--------- beginning of /dev/log/main 07-24 23:22:40.529 V/KeyguardServiceDelegate( 749): onScreenTurnedOn(showListener = com.android.internal.policy.impl.PhoneWindowManager$17@4372dba8) --------- beginning of /dev/log/system 07-24 23:22:40.529 I/PowerManagerService( 749): Waking up from sleep... 07-24 23:22:40.549 D/SurfaceFlinger( 182): Screen acquired, type=0 flinger=0xb7f91450 07-24 23:22:40.549 D/qdhwcomposer( 182): hwc_blank: Unblanking display: 0 07-24 23:22:40.579 V/KeyguardServiceDelegate( 749): **** SHOWN CALLED **** 07-24 23:22:40.579 I/WindowManager( 749): Lock screen displayed! 07-24 23:22:40.579 D/DisplayPowerController( 749): Unblocked screen on after 87766491 ms 07-24 23:22:40.799 D/qdhwcomposer( 182): hwc_blank: Done unblanking display: 0 07-24 23:22:40.799 D/SurfaceControl( 749): Excessive delay in unblankDisplay() while turning screen on: 243ms 07-24 23:22:40.869 I/PedometerServiceScheduler(1)(17709): Removing PedometerService from schedule... 07-24 23:22:41.649 D/PhoneStatusBar( 861): disable: < expand icons alerts ticker system_info back* home* recent* clock* search > 07-24 23:22:41.839 W/InputMethodManagerService( 749): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@4323eb68 attribute=android.view.inputmethod.EditorInfo@43a7de30, token = android.os.BinderProxy@43e35068 07-24 23:22:41.909 D/dalvikvm(20973): GC_CONCURRENT freed 835K, 5% free 19232K/20176K, paused 2ms+2ms, total 23ms 07-24 23:22:42.909 V/PanelView( 861): animationTick called with dtms=0; nothing to do (h=345.0 v=3105.92) 07-24 23:22:43.469 D/dalvikvm( 991): GC_CONCURRENT freed 692K, 8% free 18712K/20308K, paused 2ms+3ms, total 28ms 07-24 23:22:43.469 D/dalvikvm( 991): WAIT_FOR_CONCURRENT_GC blocked 16ms 07-24 23:22:43.469 D/dalvikvm( 991): WAIT_FOR_CONCURRENT_GC blocked 12ms 07-24 23:22:43.509 D/dalvikvm( 991): GC_FOR_ALLOC freed 444K, 8% free 18819K/20308K, paused 24ms, total 24ms 07-24 23:22:43.509 I/dalvikvm-heap( 991): Grow heap (frag case) to 18.718MB for 262160-byte allocation 07-24 23:22:43.529 D/dalvikvm( 991): GC_FOR_ALLOC freed <1K, 8% free 19074K/20568K, paused 16ms, total 16ms 07-24 23:22:43.549 D/dalvikvm( 991): GC_FOR_ALLOC freed 294K, 9% free 18819K/20568K, paused 16ms, total 17ms 07-24 23:22:43.569 D/dalvikvm( 991): GC_FOR_ALLOC freed <1K, 8% free 19074K/20568K, paused 17ms, total 17ms 07-24 23:22:43.569 I/dalvikvm-heap( 991): Grow heap (frag case) to 18.968MB for 262160-byte allocation 07-24 23:22:43.579 D/dalvikvm( 991): GC_FOR_ALLOC freed <1K, 8% free 19330K/20828K, paused 17ms, total 17ms 07-24 23:22:43.609 D/dalvikvm( 991): GC_FOR_ALLOC freed 556K, 10% free 18818K/20828K, paused 24ms, total 24ms 07-24 23:22:44.529 D/dalvikvm( 991): GC_FOR_ALLOC freed 296K, 9% free 19073K/20828K, paused 21ms, total 21ms 07-24 23:22:44.559 D/dalvikvm( 991): GC_FOR_ALLOC freed 309K, 9% free 19073K/20828K, paused 18ms, total 19ms 07-24 23:22:44.569 D/dalvikvm( 991): GC_FOR_ALLOC freed 264K, 9% free 19073K/20828K, paused 17ms, total 17ms 07-24 23:22:45.139 V/PanelView( 861): animationTick called with dtms=0; nothing to do (h=1776.0 v=-6000.0) 07-24 23:22:45.159 D/dalvikvm(20973): GC_FOR_ALLOC freed 201K, 5% free 19223K/20176K, paused 21ms, total 21ms 07-24 23:22:45.159 I/dalvikvm-heap(20973): Grow heap (frag case) to 18.835MB for 36880-byte allocation 07-24 23:22:45.189 D/dalvikvm(20973): GC_FOR_ALLOC freed 3K, 5% free 19255K/20216K, paused 23ms, total 23ms 07-24 23:22:45.209 D/dalvikvm(20973): GC_FOR_ALLOC freed 7K, 5% free 19248K/20216K, paused 18ms, total 18ms 07-24 23:22:45.209 I/dalvikvm-heap(20973): Grow heap (frag case) to 18.861MB for 36880-byte allocation 07-24 23:22:45.219 D/dalvikvm(20973): GC_FOR_ALLOC freed <1K, 5% free 19284K/20256K, paused 12ms, total 12ms 07-24 23:22:45.229 D/dalvikvm(20973): GC_FOR_ALLOC freed <1K, 5% free 19285K/20256K, paused 13ms, total 13ms 07-24 23:22:45.229 I/dalvikvm-heap(20973): Grow heap (frag case) to 18.896MB for 36880-byte allocation 07-24 23:22:45.249 D/dalvikvm(20973): GC_FOR_ALLOC freed <1K, 5% free 19321K/20296K, paused 14ms, total 14ms 07-24 23:22:45.319 D/dalvikvm(20973): GC_FOR_ALLOC freed 271K, 6% free 19277K/20296K, paused 13ms, total 15ms 07-24 23:22:45.319 I/dalvikvm-heap(20973): Grow heap (frag case) to 18.932MB for 82960-byte allocation 07-24 23:22:45.339 D/dalvikvm(20973): GC_FOR_ALLOC freed 20K, 6% free 19338K/20380K, paused 14ms, total 14ms 07-24 23:22:45.429 D/dalvikvm(20973): GC_FOR_ALLOC freed 155K, 5% free 19366K/20380K, paused 11ms, total 11ms 07-24 23:22:45.449 D/dalvikvm(20973): GC_FOR_ALLOC freed 13K, 5% free 19444K/20380K, paused 11ms, total 12ms 07-24 23:22:45.449 I/dalvikvm-heap(20973): Grow heap (frag case) to 19.095MB for 82960-byte allocation 07-24 23:22:45.459 D/dalvikvm(20973): GC_FOR_ALLOC freed 0K, 5% free 19525K/20464K, paused 12ms, total 12ms 07-24 23:22:45.469 D/dalvikvm(20973): GC_FOR_ALLOC freed 6K, 5% free 19523K/20464K, paused 13ms, total 13ms 07-24 23:22:45.469 I/dalvikvm-heap(20973): Grow heap (frag case) to 19.172MB for 82960-byte allocation 07-24 23:22:45.489 D/dalvikvm(20973): GC_FOR_ALLOC freed 0K, 5% free 19604K/20548K, paused 12ms, total 12ms 07-24 23:22:45.499 D/dalvikvm(20973): GC_FOR_ALLOC freed 4K, 5% free 19601K/20548K, paused 14ms, total 16ms 07-24 23:22:45.499 I/dalvikvm-heap(20973): Grow heap (frag case) to 19.249MB for 82960-byte allocation 07-24 23:22:45.519 D/dalvikvm(20973): GC_FOR_ALLOC freed <1K, 5% free 19682K/20632K, paused 12ms, total 12ms 07-24 23:22:45.529 D/dalvikvm(20973): GC_FOR_ALLOC freed 7K, 5% free 19688K/20632K, paused 13ms, total 15ms 07-24 23:22:45.539 I/dalvikvm-heap(20973): Grow heap (frag case) to 19.334MB for 82960-byte allocation 07-24 23:22:45.549 D/dalvikvm(20973): GC_FOR_ALLOC freed 1K, 5% free 19768K/20716K, paused 11ms, total 11ms 07-24 23:22:45.589 D/dalvikvm(20973): GC_FOR_ALLOC freed 61K, 4% free 20024K/20800K, paused 11ms, total 11ms 07-24 23:22:45.789 D/dalvikvm(20973): GC_FOR_ALLOC freed 945K, 7% free 19796K/21092K, paused 12ms, total 12ms 07-24 23:22:47.079 D/WifiService( 749): setWifiEnabled: false pid=20973, uid=1000 07-24 23:22:47.109 I/wpa_supplicant(17509): wlan0: CTRL-EVENT-DISCONNECTED bssid=2c:39:96:d5:ea:d2 reason=3 locally_generated=1 07-24 23:22:47.119 D/CommandListener( 179): Clearing all IP addresses on wlan0 07-24 23:22:47.119 D/ConnectivityService( 749): ConnectivityChange for WIFI: DISCONNECTED/DISCONNECTED 07-24 23:22:47.119 D/ConnectivityService( 749): tryFailover: set mActiveDefaultNetwork=-1, prevNetType=1 07-24 23:22:47.119 D/ConnectivityService( 749): Attempting to switch to mobile 07-24 23:22:47.119 D/ConnectivityService( 749): Attempting to switch to BLUETOOTH_TETHER 07-24 23:22:47.139 D/NetUtils( 749): android_net_utils_resetConnections in env=0x77bc39b0 clazz=0xbd500001 iface=wlan0 mask=0x3 07-24 23:22:47.139 D/MobileDataStateTracker( 749): default: Broadcast received: android.intent.action.ANY_DATA_STATE apnType=default 07-24 23:22:47.139 D/MobileDataStateTracker( 749): default: Received state=CONNECTING, old=DISCONNECTED, reason=dataEnabled 07-24 23:22:47.139 D/MobileDataStateTracker( 749): default: setDetailed state, old =IDLE and new state=CONNECTING 07-24 23:22:47.139 D/MobileDataStateTracker( 749): fota: Broadcast received: android.intent.action.ANY_DATA_STATE apnType=fota 07-24 23:22:47.139 D/ConnectivityService( 749): resetConnections(wlan0, 3) 07-24 23:22:47.149 D/MobileDataStateTracker( 749): fota: Received state=DISCONNECTED, old=DISCONNECTED, reason=dataEnabled 07-24 23:22:47.149 D/MobileDataStateTracker( 749): dun: Broadcast received: android.intent.action.ANY_DATA_STATE apnType=dun 07-24 23:22:47.149 D/MobileDataStateTracker( 749): dun: Received state=DISCONNECTED, old=DISCONNECTED, reason=dataEnabled 07-24 23:22:47.149 D/MobileDataStateTracker( 749): ia: Broadcast received: android.intent.action.ANY_DATA_STATE apnType=ia 07-24 23:22:47.149 D/MobileDataStateTracker( 749): ia: Received state=DISCONNECTED, old=DISCONNECTED, reason=dataEnabled 07-24 23:22:47.159 D/MobileDataStateTracker( 749): supl: Broadcast received: android.intent.action.ANY_DATA_STATE apnType=supl 07-24 23:22:47.159 D/MobileDataStateTracker( 749): supl: Received state=DISCONNECTED, old=DISCONNECTED, reason=dataEnabled 07-24 23:22:47.159 D/MobileDataStateTracker( 749): hipri: Broadcast received: android.intent.action.ANY_DATA_STATE apnType=hipri 07-24 23:22:47.159 D/MobileDataStateTracker( 749): hipri: Received state=DISCONNECTED, old=DISCONNECTED, reason=dataEnabled 07-24 23:22:47.159 D/MobileDataStateTracker( 749): ims: Broadcast received: android.intent.action.ANY_DATA_STATE apnType=ims 07-24 23:22:47.159 D/MobileDataStateTracker( 749): ims: Received state=DISCONNECTED, old=DISCONNECTED, reason=dataEnabled 07-24 23:22:47.159 D/MobileDataStateTracker( 749): mms: Broadcast received: android.intent.action.ANY_DATA_STATE apnType=mms 07-24 23:22:47.159 D/MobileDataStateTracker( 749): mms: Received state=DISCONNECTED, old=DISCONNECTED, reason=dataEnabled 07-24 23:22:47.159 D/MobileDataStateTracker( 749): cbs: Broadcast received: android.intent.action.ANY_DATA_STATE apnType=cbs 07-24 23:22:47.169 D/MobileDataStateTracker( 749): cbs: Received state=DISCONNECTED, old=DISCONNECTED, reason=dataEnabled 07-24 23:22:47.179 W/ContextImpl(19101): Implicit intents with startService are not safe: Intent { act=com.viber.voip.action.VIBER_SERVICE_BACKGROUND } android.content.ContextWrapper.startService:494 com.viber.voip.e.s.a:273 com.viber.voip.e.s.onServiceStateChanged:237 07-24 23:22:47.189 W/ContextImpl(19101): Implicit intents with startService are not safe: Intent { act=com.viber.voip.action.VIBER_SERVICE_BACKGROUND } android.content.ContextWrapper.startService:494 com.viber.voip.e.s.a:273 com.viber.voip.e.s.onServiceStateChanged:237 07-24 23:22:47.189 W/ContextImpl(19101): Implicit intents with startService are not safe: Intent { act=com.viber.voip.action.VIBER_SERVICE_BACKGROUND } android.content.ContextWrapper.startService:494 com.viber.voip.e.s.a:273 com.viber.voip.e.s.onServiceStateChanged:237 07-24 23:22:47.199 W/ContextImpl(19101): Implicit intents with startService are not safe: Intent { act=com.viber.voip.action.VIBER_SERVICE_BACKGROUND } android.content.ContextWrapper.startService:494 com.viber.voip.e.s.a:273 com.viber.voip.e.s.onServiceStateChanged:237 07-24 23:22:47.199 D/CommandListener( 179): Clearing all IP addresses on wlan0 07-24 23:22:47.209 W/BackupManagerService( 749): dataChanged but no participant pkg='com.android.providers.settings' uid=10059 07-24 23:22:47.219 W/Settings( 1156): Setting airplane_mode_on has moved from android.provider.Settings.System to android.provider.Settings.Global, returning read-only value. 07-24 23:22:47.219 W/ContextImpl(19101): Implicit intents with startService are not safe: Intent { act=com.viber.voip.action.VIBER_SERVICE_BACKGROUND } android.content.ContextWrapper.startService:494 com.viber.voip.e.s.a:273 com.viber.voip.e.s.onServiceStateChanged:237 07-24 23:22:47.229 W/ContextImpl(19101): Implicit intents with startService are not safe: Intent { act=com.viber.voip.action.VIBER_SERVICE_BACKGROUND } android.content.ContextWrapper.startService:494 com.viber.voip.e.s.a:273 com.viber.voip.e.s.onServiceStateChanged:237 07-24 23:22:47.229 D/Nat464Xlat( 749): requiresClat: netType=1, hasIPv4Address=false 07-24 23:22:47.229 D/ConnectivityService( 749): handleInetConditionChange: no active default network - ignore 07-24 23:22:47.239 D/BluetoothAdapter(20973): 1114544152: getState() : mService = null. Returning STATE_OFF 07-24 23:22:47.239 D/MobileDataStateTracker( 749): default: setPolicyDataEnable(enabled=true) 07-24 23:22:47.289 D/MobileDataStateTracker( 749): default: setPolicyDataEnable(enabled=true) 07-24 23:22:47.729 W/ContextImpl(19101): Implicit intents with startService are not safe: Intent { act=com.viber.voip.action.VIBER_SERVICE_BACKGROUND } android.content.ContextWrapper.startService:494 com.viber.voip.e.s.a:273 com.viber.voip.e.s.onServiceStateChanged:237 07-24 23:22:47.729 W/ContextImpl(19101): Implicit intents with startService are not safe: Intent { act=com.viber.voip.action.VIBER_SERVICE_BACKGROUND } android.content.ContextWrapper.startService:494 com.viber.voip.e.s.a:273 com.viber.voip.e.s.onServiceStateChanged:237 07-24 23:22:48.129 V/QcrilMsgTunnelSocket(30567): After reading offset = 0 remaining = 4 countRead = 4 07-24 23:22:48.129 D/QcrilMsgTunnelSocket(30567): messageLength extracted from first 4 inputStream reads = 29 07-24 23:22:48.129 V/QcrilMsgTunnelSocket(30567): offset = 0 remaining = 29 countRead = 0 07-24 23:22:48.129 V/QcrilMsgTunnelSocket(30567): offset = 0 remaining = 29 countRead = 29 07-24 23:22:48.129 D/QcrilMsgTunnelSocket(30567): readRilMessage: Buffer = [B@42603a38 HexData = [0100000004040000110000005155414c434f4d4def0308000100000001] 07-24 23:22:48.129 V/QcrilMsgTunnelSocket(30567): Read packet: 29 bytes. Data Available = 32 Position = 0 07-24 23:22:48.129 D/QcrilMsgTunnelSocket(30567): processResponse. message type = 1. Data Available = 28 07-24 23:22:48.129 D/QcrilMsgTunnelSocket(30567): ByteArray from parcel = 5155414c434f4d4def0308000100000001 07-24 23:22:48.129 D/QcrilMsgTunnelSocket(30567): Received RIL_UNSOL_OEM_HOOK_RAW message 07-24 23:22:48.129 D/QcrilMsgTunnelSocket(30567): Oem ID in RIL_UNSOL_OEM_HOOK_RAW is QUALCOMM 07-24 23:22:48.129 D/QcrilMsgTunnelSocket(30567): OEM ID check Passed 07-24 23:22:48.129 D/QcrilMsgTunnelSocket(30567): Response ID in RIL_UNSOL_OEM_HOOK_RAW is 525295 07-24 23:22:48.129 D/QcrilMsgTunnelSocket(30567): Response ID 525295is not served in this process. 07-24 23:22:48.129 D/QcrilMsgTunnelSocket(30567): To broadcast an Intent via the notifier to external apps 07-24 23:22:48.129 V/QcrilMsgTunnelSocket(30567): Before reading offset = 0 remaining = 4 countRead = 0 07-24 23:22:48.129 D/QcrilMsgTunnelIfaceManager(30567): handleMessage what=0 07-24 23:22:48.129 D/QcrilMsgTunnelIfaceManager(30567): Broadcasting intent ACTION_UNSOL_RESPONSE_OEM_HOOK_RAW 07-24 23:22:48.729 W/ContextImpl(19101): Implicit intents with startService are not safe: Intent { act=com.viber.voip.action.VIBER_SERVICE_BACKGROUND } android.content.ContextWrapper.startService:494 com.viber.voip.e.s.a:273 com.viber.voip.e.s.onServiceStateChanged:237 07-24 23:22:48.729 W/ContextImpl(19101): Implicit intents with startService are not safe: Intent { act=com.viber.voip.action.VIBER_SERVICE_BACKGROUND } android.content.ContextWrapper.startService:494 com.viber.voip.e.s.a:273 com.viber.voip.e.s.onServiceStateChanged:237 07-24 23:22:48.809 D/MobileDataStateTracker( 749): default: Broadcast received: android.intent.action.ANY_DATA_STATE apnType=default 07-24 23:22:48.809 D/MobileDataStateTracker( 749): default: Received state=CONNECTED, old=CONNECTING, reason=connected 07-24 23:22:48.809 D/MobileDataStateTracker( 749): default: setDetailed state, old =CONNECTING and new state=CONNECTED 07-24 23:22:48.809 D/ConnectivityService( 749): ConnectivityChange for mobile: CONNECTED/CONNECTED 07-24 23:22:48.809 D/ConnectivityService( 749): ConnectivityChange checkMobileProvisioning for TYPE_MOBILE or ProvisioningNetwork 07-24 23:22:48.809 D/ConnectivityService( 749): checkMobileProvisioning: E suggestedTimeOutMs=60000 07-24 23:22:48.809 D/ConnectivityService( 749): setProvNotificationVisible: E visible=false networkType=5 extraInfo=null url=null 07-24 23:22:48.809 D/ConnectivityService( 749): checkMobileProvisioning: params={ url=http://clients3.google.com/generate_204 mTimeOutMs=60000 mCb=com.android.server.ConnectivityService$5@42effc98} 07-24 23:22:48.809 D/ConnectivityService( 749): checkMobileProvisioning: X 07-24 23:22:48.819 D/dalvikvm( 1009): GC_CONCURRENT freed 479K, 4% free 18043K/18696K, paused 2ms+3ms, total 27ms 07-24 23:22:48.819 D/dalvikvm( 1009): WAIT_FOR_CONCURRENT_GC blocked 13ms 07-24 23:22:48.819 D/dalvikvm( 1009): WAIT_FOR_CONCURRENT_GC blocked 12ms 07-24 23:22:48.819 D/dalvikvm( 1009): WAIT_FOR_CONCURRENT_GC blocked 14ms 07-24 23:22:48.839 D/Nat464Xlat( 749): requiresClat: netType=0, hasIPv4Address=true 07-24 23:22:48.839 D/MobileDataStateTracker( 749): default: setPolicyDataEnable(enabled=true) 07-24 23:22:48.849 D/MobileDataStateTracker( 749): default: isProvisioningNetwork: retVal=false 07-24 23:22:48.849 D/ConnectivityService( 749): [CheckMp] isMobileOk: isDefaultProvisioning=false 07-24 23:22:48.869 D/MobileDataStateTracker( 749): hipri: isProvisioningNetwork: retVal=false 07-24 23:22:48.869 D/ConnectivityService( 749): [CheckMp] isMobileOk: isHipriProvisioning=false 07-24 23:22:48.869 D/ConnectivityService( 749): [CheckMp] isMobileOk: start hipri url=http://clients3.google.com/generate_204 07-24 23:22:48.879 I/CheckinService( 991): Preparing to send checkin request 07-24 23:22:48.879 I/EventLogService( 991): Accumulating logs since 1406240244726 07-24 23:22:48.919 I/GoogleHttpClient( 991): Falling back to old SSLCertificateSocketFactory 07-24 23:22:48.919 I/GoogleHttpClient( 991): Using GMS GoogleHttpClient 07-24 23:22:48.929 D/MobileDataStateTracker( 749): default: setPolicyDataEnable(enabled=true) 07-24 23:22:48.939 D/ConnectivityService( 749): startUsingNetworkFeature reconnecting to 0: enableHIPRI 07-24 23:22:48.939 D/ConnectivityService( 749): startUsingNetworkFeature X: return APN_REQUEST_STARTED 07-24 23:22:48.939 D/ConnectivityService( 749): [CheckMp] isMobileOk: hipri started 07-24 23:22:48.939 D/ConnectivityService( 749): [CheckMp] isMobileOk: not connected ni=NetworkInfo: type: mobile_hipri[HSPA], state: DISCONNECTED/IDLE, reason: (unspecified), extra: (none), roaming: false, failover: false, isAvailable: true, isConnectedToProvisioningNetwork: false 07-24 23:22:48.939 D/MobileDataStateTracker( 749): hipri: Broadcast received: android.intent.action.ANY_DATA_STATE apnType=hipri 07-24 23:22:48.939 D/MobileDataStateTracker( 749): hipri: Received state=CONNECTING, old=DISCONNECTED, reason=dataEnabled 07-24 23:22:48.939 D/MobileDataStateTracker( 749): hipri: setDetailed state, old =IDLE and new state=CONNECTING 07-24 23:22:48.939 D/MobileDataStateTracker( 749): fota: Broadcast received: android.intent.action.ANY_DATA_STATE apnType=fota 07-24 23:22:48.939 D/MobileDataStateTracker( 749): fota: Received state=DISCONNECTED, old=DISCONNECTED, reason=dataEnabled 07-24 23:22:48.939 D/MobileDataStateTracker( 749): dun: Broadcast received: android.intent.action.ANY_DATA_STATE apnType=dun 07-24 23:22:48.949 D/MobileDataStateTracker( 749): dun: Received state=DISCONNECTED, old=DISCONNECTED, reason=dataEnabled 07-24 23:22:48.949 D/MobileDataStateTracker( 749): ia: Broadcast received: android.intent.action.ANY_DATA_STATE apnType=ia 07-24 23:22:48.949 D/MobileDataStateTracker( 749): ia: Received state=DISCONNECTED, old=DISCONNECTED, reason=dataEnabled 07-24 23:22:48.949 D/MobileDataStateTracker( 749): supl: Broadcast received: android.intent.action.ANY_DATA_STATE apnType=supl 07-24 23:22:48.949 D/MobileDataStateTracker( 749): supl: Received state=DISCONNECTED, old=DISCONNECTED, reason=dataEnabled 07-24 23:22:48.949 D/MobileDataStateTracker( 749): ims: Broadcast received: android.intent.action.ANY_DATA_STATE apnType=ims 07-24 23:22:48.959 D/MobileDataStateTracker( 749): ims: Received state=DISCONNECTED, old=DISCONNECTED, reason=dataEnabled 07-24 23:22:48.959 D/MobileDataStateTracker( 749): mms: Broadcast received: android.intent.action.ANY_DATA_STATE apnType=mms 07-24 23:22:48.959 D/MobileDataStateTracker( 749): mms: Received state=DISCONNECTED, old=DISCONNECTED, reason=dataEnabled 07-24 23:22:48.959 D/MobileDataStateTracker( 749): cbs: Broadcast received: android.intent.action.ANY_DATA_STATE apnType=cbs 07-24 23:22:48.959 D/MobileDataStateTracker( 749): cbs: Received state=DISCONNECTED, old=DISCONNECTED, reason=dataEnabled 07-24 23:22:48.959 D/MobileDataStateTracker( 749): hipri: Broadcast received: android.intent.action.ANY_DATA_STATE apnType=hipri 07-24 23:22:48.959 D/MobileDataStateTracker( 749): hipri: Received state=CONNECTED, old=CONNECTING, reason=dataEnabled 07-24 23:22:48.959 D/MobileDataStateTracker( 749): hipri: setDetailed state, old =CONNECTING and new state=CONNECTED 07-24 23:22:48.959 D/ConnectivityService( 749): ConnectivityChange for mobile_hipri: CONNECTED/CONNECTED 07-24 23:22:48.989 V/PanelView( 861): animationTick called with dtms=0; nothing to do (h=2.7278209 v=2874.1357) 07-24 23:22:48.989 V/PanelView( 861): animationTick called with dtms=-6; nothing to do (h=2.7278209 v=2874.1357) 07-24 23:22:48.989 W/GLSUser ( 1124): GoogleAccountDataService.getToken() 07-24 23:22:49.019 D/Nat464Xlat( 749): requiresClat: netType=5, hasIPv4Address=true 07-24 23:22:49.019 D/MobileDataStateTracker( 749): default: setPolicyDataEnable(enabled=true) 07-24 23:22:49.029 W/NetworkPolicy( 749): shared quota unsupported; generating rule for each iface 07-24 23:22:49.109 I/Adreno-EGL(17901): : EGL 1.4 QUALCOMM Build: I0404c4692afb8623f95c43aeb6d5e13ed4b30ddbDate: 11/06/13 07-24 23:22:49.139 I/Adreno-EGL(17901): : EGL 1.4 QUALCOMM Build: I0404c4692afb8623f95c43aeb6d5e13ed4b30ddbDate: 11/06/13 07-24 23:22:49.189 I/CheckinTask( 991): Sending checkin request (4284 bytes) 07-24 23:22:49.229 D/MobileDataStateTracker( 749): default: setPolicyDataEnable(enabled=true) 07-24 23:22:49.529 D/dalvikvm( 749): GC_FOR_ALLOC freed 4374K, 23% free 42282K/54876K, paused 76ms, total 76ms 07-24 23:22:49.619 D/dalvikvm( 749): GC_FOR_ALLOC freed 1906K, 24% free 42052K/54876K, paused 61ms, total 61ms 07-24 23:22:49.689 D/dalvikvm( 749): GC_FOR_ALLOC freed 838K, 22% free 42888K/54876K, paused 59ms, total 59ms 07-24 23:22:49.709 D/dalvikvm( 861): GC_FOR_ALLOC freed 4614K, 54% free 23588K/50320K, paused 22ms, total 22ms 07-24 23:22:49.759 D/dalvikvm( 749): GC_FOR_ALLOC freed 1672K, 24% free 42051K/54876K, paused 62ms, total 62ms 07-24 23:22:49.769 D/dalvikvm( 861): GC_FOR_ALLOC freed 973K, 52% free 24371K/50320K, paused 15ms, total 15ms 07-24 23:22:49.849 D/dalvikvm( 749): GC_FOR_ALLOC freed 838K, 22% free 42890K/54876K, paused 60ms, total 60ms 07-24 23:22:49.849 D/ConnectivityService( 749): NetTransition Wakelock for ConnectedState released by timeout 07-24 23:22:49.879 V/PanelView( 861): animationTick called with dtms=0; nothing to do (h=1776.0 v=-6000.0) 07-24 23:22:49.879 V/PanelView( 861): animationTick called with dtms=0; nothing to do (h=1776.0 v=-6000.0) 07-24 23:22:49.939 D/MobileDataStateTracker( 749): hipri: isProvisioningNetwork: retVal=false 07-24 23:22:49.939 D/ConnectivityService( 749): [CheckMp] isMobileOk: isProvisioningNetwork is false, continue 07-24 23:22:50.029 V/QcrilMsgTunnelSocket(30567): After reading offset = 0 remaining = 4 countRead = 4 07-24 23:22:50.029 D/QcrilMsgTunnelSocket(30567): messageLength extracted from first 4 inputStream reads = 29 07-24 23:22:50.029 V/QcrilMsgTunnelSocket(30567): offset = 0 remaining = 29 countRead = 0 07-24 23:22:50.049 V/QcrilMsgTunnelSocket(30567): offset = 0 remaining = 29 countRead = 29 07-24 23:22:50.049 D/QcrilMsgTunnelSocket(30567): readRilMessage: Buffer = [B@42603a38 HexData = [0100000004040000110000005155414c434f4d4def0308000100000002] 07-24 23:22:50.049 V/QcrilMsgTunnelSocket(30567): Read packet: 29 bytes. Data Available = 32 Position = 0 07-24 23:22:50.049 D/QcrilMsgTunnelSocket(30567): processResponse. message type = 1. Data Available = 28 07-24 23:22:50.049 D/QcrilMsgTunnelSocket(30567): ByteArray from parcel = 5155414c434f4d4def0308000100000002 07-24 23:22:50.049 D/QcrilMsgTunnelSocket(30567): Received RIL_UNSOL_OEM_HOOK_RAW message 07-24 23:22:50.049 D/QcrilMsgTunnelSocket(30567): Oem ID in RIL_UNSOL_OEM_HOOK_RAW is QUALCOMM 07-24 23:22:50.049 D/QcrilMsgTunnelSocket(30567): OEM ID check Passed 07-24 23:22:50.069 D/AlarmManagerService( 749): Kernel timezone updated to -60 minutes west of GMT 07-24 23:22:50.079 D/MobileDataStateTracker( 749): hipri: Broadcast received: android.intent.action.ANY_DATA_STATE apnType=hipri 07-24 23:22:50.079 D/MobileDataStateTracker( 749): hipri: Received state=CONNECTED, old=CONNECTED, reason=(unspecified) 07-24 23:22:50.089 D/MobileDataStateTracker( 749): default: Broadcast received: android.intent.action.ANY_DATA_STATE apnType=default 07-24 23:22:50.089 D/MobileDataStateTracker( 749): default: Received state=CONNECTED, old=CONNECTED, reason=(unspecified) 07-24 23:22:50.099 D/dalvikvm( 1009): GC_CONCURRENT freed 461K, 4% free 18011K/18696K, paused 2ms+1ms, total 29ms 07-24 23:22:50.109 D/QcrilMsgTunnelSocket(30567): Response ID in RIL_UNSOL_OEM_HOOK_RAW is 525295 07-24 23:22:50.109 D/QcrilMsgTunnelSocket(30567): Response ID 525295is not served in this process. 07-24 23:22:50.109 D/QcrilMsgTunnelSocket(30567): To broadcast an Intent via the notifier to external apps 07-24 23:22:50.109 V/QcrilMsgTunnelSocket(30567): Before reading offset = 0 remaining = 4 countRead = 0 07-24 23:22:50.109 D/QcrilMsgTunnelIfaceManager(30567): handleMessage what=0 07-24 23:22:50.109 D/QcrilMsgTunnelIfaceManager(30567): Broadcasting intent ACTION_UNSOL_RESPONSE_OEM_HOOK_RAW 07-24 23:22:50.169 D/ConnectivityService( 749): [CheckMp] isMobileOk: addresses=clients3.google.com/173.194.35.97,clients3.google.com/173.194.35.102,clients3.google.com/173.194.35.99,clients3.google.com/173.194.35.105,clients3.google.com/173.194.35.96,clients3.google.com/173.194.35.98,clients3.google.com/173.194.35.104,clients3.google.com/173.194.35.103,clients3.google.com/173.194.35.100,clients3.google.com/173.194.35.101,clients3.google.com/173.194.35.110 07-24 23:22:50.169 D/ConnectivityService( 749): [CheckMp] isMobileOk: linkHasIpv4=true linkHasIpv6=false 07-24 23:22:50.179 D/ConnectivityService( 749): requestRouteToHostAddress ok=true 07-24 23:22:50.179 D/ConnectivityService( 749): [CheckMp] isMobileOk: wait to establish route to hostAddr=clients3.google.com/173.194.35.98 07-24 23:22:50.229 D/Tethering( 749): MasterInitialState.processMessage what=3 07-24 23:22:50.229 D/CaptivePortalTracker( 749): Disconnected from active network NetworkInfo: type: WIFI[], state: DISCONNECTED/DISCONNECTED, reason: (unspecified), extra: , roaming: false, failover: false, isAvailable: true, isConnectedToProvisioningNetwork: false 07-24 23:22:50.229 D/ConnectivityService( 749): setProvNotificationVisible: E visible=false networkType=1 extraInfo=null url=null 07-24 23:22:50.239 I/ProxyService(21922): Action: android.net.conn.CONNECTIVITY_CHANGE 07-24 23:22:50.239 I/ProxyService(21922): Network Type: mobile, subtype: HSPA+, available: true 07-24 23:22:50.239 W/ContextImpl(19101): Implicit intents with startService are not safe: Intent { act=com.viber.voip.action.VIBER_SERVICE_BACKGROUND } android.content.ContextWrapper.startService:494 com.viber.voip.e.s.a:273 com.viber.voip.e.s.onServiceStateChanged:237 07-24 23:22:50.249 D/MobileConnectivityChangeReceiver(17578): onReceive Intent { act=android.net.conn.CONNECTIVITY_CHANGE flg=0x4000010 cmp=com.google.android.setupwizard/.MobileConnectivityChangeReceiver (has extras) } 07-24 23:22:50.249 D/MobileConnectivityChangeReceiver(17578): onReceive CONNECTIVITY_CHANGE networkType=1 07-24 23:22:50.259 D/GCM ( 1124): GcmService start Intent { act=android.net.conn.CONNECTIVITY_CHANGE flg=0x4000010 cmp=com.google.android.gms/.gcm.GcmService (has extras) } android.net.conn.CONNECTIVITY_CHANGE 07-24 23:22:50.289 D/dalvikvm( 8348): GC_CONCURRENT freed 462K, 4% free 18318K/18956K, paused 4ms+4ms, total 40ms 07-24 23:22:50.329 I/PushServiceReceiver(18059): start PushSerevice for ACTION_BOOT_COMPLETED or CONNECTIVITY_ACTION 07-24 23:22:50.329 D/DownloadQueueService(17691): service created : co.uk.mediaat.downloader.queue.DownloadQueueService@42666260 07-24 23:22:50.339 D/DownloadQueue(17691): BBCDownloadAgent: querying downloads: queue id: BBCDownloadAgent 07-24 23:22:50.339 D/DownloadQueue(17691): BBCDownloadAgent: received 0 downloads 07-24 23:22:50.339 D/DownloadQueueController(17691): network available: false 07-24 23:22:50.339 D/DownloadQueueController(17691): storage available: true 07-24 23:22:50.339 D/DownloadQueueController(17691): environment valid: true 07-24 23:22:50.339 D/DownloadQueue(17691): download queue suspended 07-24 23:22:50.339 D/DownloadQueueService(17691): no active queues, stopping service 07-24 23:22:50.339 D/DownloadQueueService(17691): service stopped 07-24 23:22:50.339 D/DownloadQueueService(17691): service destroyed 07-24 23:22:50.379 D/dalvikvm( 8746): GC_CONCURRENT freed 254K, 8% free 17663K/19032K, paused 1ms+3ms, total 13ms 07-24 23:22:50.469 D/dalvikvm( 991): GC_CONCURRENT freed 1083K, 10% free 18738K/20820K, paused 3ms+3ms, total 24ms 07-24 23:22:50.559 W/BackupManagerService( 749): dataChanged but no participant pkg='com.android.providers.settings' uid=10059 07-24 23:22:50.709 D/GCM ( 1124): Connected 07-24 23:22:50.729 I/GCM ( 1124): GCM message com.google.android.gsf.gtalkservice 07-24 23:22:50.749 D/GCM ( 1124): Message class mpg 07-24 23:22:50.929 I/socket (18059): msgid:1 07-24 23:22:51.039 W/GLSUser ( 1124): GoogleAccountDataService.getToken() 07-24 23:22:51.059 I/CheckinTask( 991): Checkin success: https://android.clients.google.com/checkin (1 requests sent) 07-24 23:22:51.059 W/GoogleHttpClient( 991): Unable to close GMS GoogleHttpClient 07-24 23:22:51.089 D/GCM ( 1124): GcmService start Intent { act=com.google.android.checkin.CHECKIN_COMPLETE flg=0x10 cmp=com.google.android.gms/.gcm.GcmService (has extras) } com.google.android.checkin.CHECKIN_COMPLETE 07-24 23:22:51.089 E/ActivityThread( 991): Service com.google.android.gms.checkin.CheckinService has leaked ServiceConnection gbe@427bebf8 that was originally bound here 07-24 23:22:51.089 E/ActivityThread( 991): android.app.ServiceConnectionLeaked: Service com.google.android.gms.checkin.CheckinService has leaked ServiceConnection gbe@427bebf8 that was originally bound here 07-24 23:22:51.089 E/ActivityThread( 991): at android.app.LoadedApk$ServiceDispatcher.(LoadedApk.java:970) 07-24 23:22:51.089 E/ActivityThread( 991): at android.app.LoadedApk.getServiceDispatcher(LoadedApk.java:864) 07-24 23:22:51.089 E/ActivityThread( 991): at android.app.ContextImpl.bindServiceCommon(ContextImpl.java:1569) 07-24 23:22:51.089 E/ActivityThread( 991): at android.app.ContextImpl.bindService(ContextImpl.java:1552) 07-24 23:22:51.089 E/ActivityThread( 991): at android.content.ContextWrapper.bindService(ContextWrapper.java:517) 07-24 23:22:51.089 E/ActivityThread( 991): at gbd.(SourceFile:99) 07-24 23:22:51.089 E/ActivityThread( 991): at gaz.(SourceFile:226) 07-24 23:22:51.089 E/ActivityThread( 991): at java.lang.reflect.Constructor.constructNative(Native Method) 07-24 23:22:51.089 E/ActivityThread( 991): at java.lang.reflect.Constructor.newInstance(Constructor.java:423) 07-24 23:22:51.089 E/ActivityThread( 991): at xt.(SourceFile:175) 07-24 23:22:51.089 E/ActivityThread( 991): at bku.a(SourceFile:226) 07-24 23:22:51.089 E/ActivityThread( 991): at bkt.a(SourceFile:298) 07-24 23:22:51.089 E/ActivityThread( 991): at bkt.doInBackground(SourceFile:288) 07-24 23:22:51.089 E/ActivityThread( 991): at android.os.AsyncTask$2.call(AsyncTask.java:288) 07-24 23:22:51.089 E/ActivityThread( 991): at java.util.concurrent.FutureTask.run(FutureTask.java:237) 07-24 23:22:51.089 E/ActivityThread( 991): at java.lang.Thread.run(Thread.java:841) 07-24 23:22:51.099 I/GCM ( 1124): GCM config loaded 07-24 23:22:51.109 D/dalvikvm( 1124): GC_CONCURRENT freed 567K, 4% free 17780K/18452K, paused 2ms+2ms, total 22ms 07-24 23:22:51.219 D/ConnectivityService( 749): handleInetConditionHoldEnd: net=0, condition=100, published condition=0 07-24 23:22:51.849 D/Tethering( 749): MasterInitialState.processMessage what=3 07-24 23:22:51.849 D/CaptivePortalTracker( 749): NoActiveNetworkState{ when=-1ms what=1 obj=NetworkInfo: type: mobile[HSPA], state: CONNECTED/CONNECTED, reason: connected, extra: everywhere, roaming: false, failover: false, isAvailable: true, isConnectedToProvisioningNetwork: false target=com.android.internal.util.StateMachine$SmHandler } 07-24 23:22:51.849 D/CaptivePortalTracker( 749): NoActiveNetworkState not a wifi connectivity change, ignore 07-24 23:22:51.849 I/ProxyService(21922): Action: android.net.conn.CONNECTIVITY_CHANGE 07-24 23:22:51.849 I/ProxyService(21922): Network Type: mobile, subtype: HSPA+, available: true 07-24 23:22:51.859 D/MobileConnectivityChangeReceiver(17578): onReceive Intent { act=android.net.conn.CONNECTIVITY_CHANGE flg=0x4000010 cmp=com.google.android.setupwizard/.MobileConnectivityChangeReceiver (has extras) } 07-24 23:22:51.869 D/MobileConnectivityChangeReceiver(17578): onReceive CONNECTIVITY_CHANGE networkType=0 07-24 23:22:51.869 D/MobileConnectivityChangeReceiver(17578): onReceive CONNECTIVITY_CHANGE: checkConnection 07-24 23:22:51.879 D/CheckConnectionTask(17578): doInBackground: url=http://clients3.google.com/generate_204 07-24 23:22:51.889 D/GCM ( 1124): GcmService start Intent { act=android.net.conn.CONNECTIVITY_CHANGE flg=0x4000010 cmp=com.google.android.gms/.gcm.GcmService (has extras) } android.net.conn.CONNECTIVITY_CHANGE 07-24 23:22:51.929 D/dalvikvm( 8746): GC_CONCURRENT freed 522K, 8% free 17532K/19032K, paused 4ms+3ms, total 29ms 07-24 23:22:51.939 I/PushServiceReceiver(18059): start PushSerevice for ACTION_BOOT_COMPLETED or CONNECTIVITY_ACTION 07-24 23:22:51.949 D/DownloadQueueService(17691): service created : co.uk.mediaat.downloader.queue.DownloadQueueService@4266ba08 07-24 23:22:51.959 D/DownloadQueue(17691): BBCDownloadAgent: querying downloads: queue id: BBCDownloadAgent 07-24 23:22:51.959 D/GCM ( 1124): GcmService start Intent { act=com.google.android.checkin.CHECKIN_COMPLETE flg=0x10 cmp=com.google.android.gms/.gcm.GcmService (has extras) } com.google.android.checkin.CHECKIN_COMPLETE 07-24 23:22:51.959 D/DownloadQueue(17691): BBCDownloadAgent: received 0 downloads 07-24 23:22:51.959 D/DownloadQueueController(17691): network available: false 07-24 23:22:51.959 D/DownloadQueueController(17691): storage available: true 07-24 23:22:51.959 D/DownloadQueueController(17691): environment valid: true 07-24 23:22:51.959 D/DownloadQueue(17691): download queue suspended 07-24 23:22:51.959 D/DownloadQueueService(17691): no active queues, stopping service 07-24 23:22:51.959 D/DownloadQueueService(17691): service stopped 07-24 23:22:51.969 D/DownloadQueueService(17691): service destroyed 07-24 23:22:51.999 D/dalvikvm(17578): GC_CONCURRENT freed 488K, 4% free 16982K/17508K, paused 1ms+2ms, total 10ms 07-24 23:22:52.009 D/dalvikvm( 3210): GC_CONCURRENT freed 434K, 3% free 17090K/17608K, paused 1ms+1ms, total 11ms 07-24 23:22:52.029 D/Tethering( 749): MasterInitialState.processMessage what=3 07-24 23:22:52.029 D/dalvikvm( 8746): GC_CONCURRENT freed 498K, 9% free 17457K/19032K, paused 2ms+4ms, total 15ms 07-24 23:22:52.029 D/CaptivePortalTracker( 749): NoActiveNetworkState{ when=-1ms what=1 obj=NetworkInfo: type: mobile_hipri[HSPA], state: CONNECTED/CONNECTED, reason: dataEnabled, extra: everywhere, roaming: false, failover: false, isAvailable: true, isConnectedToProvisioningNetwork: false target=com.android.internal.util.StateMachine$SmHandler } 07-24 23:22:52.029 D/CaptivePortalTracker( 749): NoActiveNetworkState not a wifi connectivity change, ignore 07-24 23:22:52.029 I/goggles ( 3210): k: Checking for images newer than 1406141576633 07-24 23:22:52.029 I/ProxyService(21922): Action: android.net.conn.CONNECTIVITY_CHANGE 07-24 23:22:52.029 I/ProxyService(21922): Network Type: mobile, subtype: HSPA+, available: true 07-24 23:22:52.039 D/MobileConnectivityChangeReceiver(17578): onReceive Intent { act=android.net.conn.CONNECTIVITY_CHANGE flg=0x4000010 cmp=com.google.android.setupwizard/.MobileConnectivityChangeReceiver (has extras) } 07-24 23:22:52.039 D/MobileConnectivityChangeReceiver(17578): onReceive CONNECTIVITY_CHANGE networkType=5 07-24 23:22:52.059 D/GCM ( 1124): GcmService start Intent { act=android.net.conn.CONNECTIVITY_CHANGE flg=0x4000010 cmp=com.google.android.gms/.gcm.GcmService (has extras) } android.net.conn.CONNECTIVITY_CHANGE 07-24 23:22:52.059 D/ConnectivityService( 749): requestRouteToHostAddress ok=true 07-24 23:22:52.079 W/InputMethodManagerService( 749): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@4478f990 attribute=null, token = android.os.BinderProxy@430098d8 07-24 23:22:52.119 D/dalvikvm(18874): GC_CONCURRENT freed 2871K, 11% free 25257K/28168K, paused 3ms+4ms, total 72ms 07-24 23:22:52.119 D/dalvikvm(18874): WAIT_FOR_CONCURRENT_GC blocked 55ms 07-24 23:22:52.119 D/dalvikvm(18874): WAIT_FOR_CONCURRENT_GC blocked 42ms 07-24 23:22:52.149 I/PushServiceReceiver(18059): start PushSerevice for ACTION_BOOT_COMPLETED or CONNECTIVITY_ACTION 07-24 23:22:52.159 D/DownloadQueueService(17691): service created : co.uk.mediaat.downloader.queue.DownloadQueueService@42670fd8 07-24 23:22:52.169 D/DownloadQueue(17691): BBCDownloadAgent: querying downloads: queue id: BBCDownloadAgent 07-24 23:22:52.169 D/GCM ( 1124): GcmService start Intent { act=com.google.android.checkin.CHECKIN_COMPLETE flg=0x10 cmp=com.google.android.gms/.gcm.GcmService (has extras) } com.google.android.checkin.CHECKIN_COMPLETE 07-24 23:22:52.169 D/DownloadQueue(17691): BBCDownloadAgent: received 0 downloads 07-24 23:22:52.169 D/DownloadQueueController(17691): network available: false 07-24 23:22:52.169 D/DownloadQueueController(17691): storage available: true 07-24 23:22:52.169 D/DownloadQueueController(17691): environment valid: true 07-24 23:22:52.169 D/DownloadQueue(17691): download queue suspended 07-24 23:22:52.169 D/DownloadQueueService(17691): no active queues, stopping service 07-24 23:22:52.169 D/DownloadQueueService(17691): service stopped 07-24 23:22:52.169 D/DownloadQueueService(17691): service destroyed 07-24 23:22:52.179 D/dalvikvm(17691): GC_CONCURRENT freed 343K, 3% free 16915K/17292K, paused 2ms+2ms, total 19ms 07-24 23:22:52.189 D/CheckConnectionTask(17578): doInBackground: resultCode=204 retVal=true 07-24 23:22:52.189 D/CheckConnectionTask(17578): onPostExecute connected=true 07-24 23:22:52.189 D/CheckConnectionTask(17578): onPostExecute set preference connected=true 07-24 23:22:52.209 W/ContextImpl(19101): Implicit intents with startService are not safe: Intent { act=com.viber.voip.action.VIBER_SERVICE_BACKGROUND } android.content.ContextWrapper.startService:494 com.viber.voip.e.s.a:273 com.viber.voip.e.s.onServiceStateChanged:237 07-24 23:22:52.209 D/dalvikvm( 3210): GC_CONCURRENT freed 454K, 3% free 17105K/17608K, paused 2ms+4ms, total 17ms 07-24 23:22:52.219 I/goggles ( 3210): k: Checking for images newer than 1406141576633 07-24 23:22:52.389 D/ConnectivityService( 749): handleInetConditionHoldEnd: net=0, condition=100, published condition=100 07-24 23:22:53.189 D/ConnectivityService( 749): [CheckMp] isMobileOk: newUrl=https://173.194.35.98/generate_204 07-24 23:22:53.519 D/ConnectivityService( 749): [CheckMp] isMobileOk: hostnameVerify retVal=true hostname=173.194.35.98 orgUriHost=clients3.google.com 07-24 23:22:53.619 D/ConnectivityService( 749): [CheckMp] isMobileOk: headers={null=[HTTP/1.1 204 No Content], Connection=[close], Content-Length=[0], Content-Type=[text/html; charset=UTF-8], Date=[Thu, 24 Jul 2014 22:22:54 GMT], Server=[GFE/2.0], X-Android-Received-Millis=[1406240573628], X-Android-Response-Source=[NETWORK 204], X-Android-Selected-Transport=[http/1.1], X-Android-Sent-Millis=[1406240573536]} 07-24 23:22:53.619 D/ConnectivityService( 749): [CheckMp] isMobileOk: X got expected responseCode=204 result=1 07-24 23:22:53.619 D/ConnectivityService( 749): [CheckMp] isMobileOk: F stop hipri 07-24 23:22:53.619 D/MobileDataStateTracker( 749): default: setEnableFailFastMobileData(enabled=0) 07-24 23:22:53.619 D/ConnectivityService( 749): stopUsingNetworkFeature: teardown net 0: enableHIPRI 07-24 23:22:53.629 D/MobileDataStateTracker( 749): hipri: Broadcast received: android.intent.action.ANY_DATA_STATE apnType=hipri 07-24 23:22:53.629 D/MobileDataStateTracker( 749): hipri: Received state=DISCONNECTED, old=CONNECTED, reason=dataDisabled 07-24 23:22:53.629 D/MobileDataStateTracker( 749): hipri: setDetailed state, old =CONNECTED and new state=DISCONNECTED 07-24 23:22:53.629 D/ConnectivityService( 749): ConnectivityChange for mobile_hipri: DISCONNECTED/DISCONNECTED 07-24 23:22:53.679 D/Nat464Xlat( 749): requiresClat: netType=5, hasIPv4Address=true 07-24 23:22:53.689 D/MobileDataStateTracker( 749): default: setPolicyDataEnable(enabled=true) 07-24 23:22:53.879 D/MobileDataStateTracker( 749): default: setPolicyDataEnable(enabled=true) 07-24 23:22:53.899 V/PanelView( 861): animationTick called with dtms=0; nothing to do (h=278.0 v=3788.3794) 07-24 23:22:54.059 D/MobileDataStateTracker( 749): default: setPolicyDataEnable(enabled=true) 07-24 23:22:54.059 D/MobileDataStateTracker( 749): default: setPolicyDataEnable(enabled=true) 07-24 23:22:54.389 D/dalvikvm( 749): GC_FOR_ALLOC freed 4987K, 27% free 40470K/54876K, paused 64ms, total 64ms 07-24 23:22:54.399 V/PanelView( 861): animationTick called with dtms=0; nothing to do (h=1776.0 v=-6000.0) 07-24 23:22:54.469 V/PanelView( 861): animationTick called with dtms=0; nothing to do (h=1478.778 v=-6000.0) 07-24 23:22:54.489 W/Resources(21922): Converting to string: TypedValue{t=0x10/d=0x2 a=2 r=0x7f0c0001} 07-24 23:22:54.489 W/Resources(21922): Converting to string: TypedValue{t=0x10/d=0x2 a=2 r=0x7f0c0001} 07-24 23:22:54.499 D/dalvikvm(21922): GC_CONCURRENT freed 280K, 2% free 16997K/17312K, paused 2ms+1ms, total 20ms 07-24 23:22:54.509 D/dalvikvm(21922): Trying to load lib /data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so 0x425fac80 07-24 23:22:54.509 W/linker (21922): libadblockplus-jni.so has text relocations. This is wasting memory and is a security risk. Please fix. 07-24 23:22:54.519 D/dalvikvm(21922): Added shared lib /data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so 0x425fac80 07-24 23:22:54.519 D/dalvikvm(21922): No JNI_OnLoad found in /data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so 0x425fac80, skipping init 07-24 23:22:54.539 D/dalvikvm(21922): Trying to load lib /data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so 0x425fac80 07-24 23:22:54.539 D/dalvikvm(21922): Shared lib '/data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so' already loaded in same CL 0x425fac80 07-24 23:22:54.539 D/dalvikvm(21922): Trying to load lib /data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so 0x425fac80 07-24 23:22:54.539 D/dalvikvm(21922): Shared lib '/data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so' already loaded in same CL 0x425fac80 07-24 23:22:54.539 D/dalvikvm(21922): Trying to load lib /data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so 0x425fac80 07-24 23:22:54.539 D/dalvikvm(21922): Shared lib '/data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so' already loaded in same CL 0x425fac80 07-24 23:22:54.539 D/dalvikvm(21922): Trying to load lib /data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so 0x425fac80 07-24 23:22:54.539 D/dalvikvm(21922): Shared lib '/data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so' already loaded in same CL 0x425fac80 07-24 23:22:55.069 D/dalvikvm( 749): GC_CONCURRENT freed 5086K, 25% free 41329K/54876K, paused 3ms+4ms, total 98ms 07-24 23:22:55.069 D/dalvikvm( 749): WAIT_FOR_CONCURRENT_GC blocked 86ms 07-24 23:22:55.179 W/ProcessCpuTracker( 749): Skipping unknown process pid 22357 07-24 23:22:55.179 W/ProcessCpuTracker( 749): Skipping unknown process pid 22358 07-24 23:22:55.179 W/ProcessCpuTracker( 749): Skipping unknown process pid 22360 07-24 23:22:55.179 W/ProcessCpuTracker( 749): Skipping unknown process pid 22361 07-24 23:22:55.179 W/ProcessCpuTracker( 749): Skipping unknown process pid 22366 07-24 23:22:55.399 I/InputDispatcher( 749): Dropping event because there is no touchable window at (689, 671). 07-24 23:22:55.609 D/dalvikvm( 749): GC_CONCURRENT freed 6136K, 25% free 41312K/54876K, paused 4ms+5ms, total 92ms 07-24 23:22:55.689 D/dalvikvm(21922): Trying to load lib /data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so 0x425fac80 07-24 23:22:55.689 D/dalvikvm(21922): Shared lib '/data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so' already loaded in same CL 0x425fac80 07-24 23:22:55.689 D/dalvikvm(21922): Trying to load lib /data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so 0x425fac80 07-24 23:22:55.689 D/dalvikvm(21922): Shared lib '/data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so' already loaded in same CL 0x425fac80 07-24 23:22:56.159 D/dalvikvm( 749): GC_CONCURRENT freed 6066K, 25% free 41312K/54876K, paused 3ms+6ms, total 92ms 07-24 23:22:56.669 D/dalvikvm( 749): GC_CONCURRENT freed 6157K, 25% free 41311K/54876K, paused 4ms+4ms, total 84ms 07-24 23:22:56.669 D/dalvikvm( 749): WAIT_FOR_CONCURRENT_GC blocked 70ms 07-24 23:22:56.689 D/Tethering( 749): MasterInitialState.processMessage what=3 07-24 23:22:56.689 D/CaptivePortalTracker( 749): NoActiveNetworkState{ when=-1ms what=1 obj=NetworkInfo: type: mobile_hipri[HSPA+], state: DISCONNECTED/DISCONNECTED, reason: dataDisabled, extra: everywhere, roaming: false, failover: false, isAvailable: true, isConnectedToProvisioningNetwork: false target=com.android.internal.util.StateMachine$SmHandler } 07-24 23:22:56.689 D/CaptivePortalTracker( 749): NoActiveNetworkState not a wifi connectivity change, ignore 07-24 23:22:56.689 D/Tethering( 749): MasterInitialState.processMessage what=3 07-24 23:22:56.699 D/CaptivePortalTracker( 749): NoActiveNetworkState{ when=0 what=1 obj=NetworkInfo: type: mobile[HSPA+], state: CONNECTED/CONNECTED, reason: connected, extra: everywhere, roaming: false, failover: false, isAvailable: true, isConnectedToProvisioningNetwork: false target=com.android.internal.util.StateMachine$SmHandler } 07-24 23:22:56.699 D/CaptivePortalTracker( 749): NoActiveNetworkState not a wifi connectivity change, ignore 07-24 23:22:56.709 D/MobileConnectivityChangeReceiver(17578): onReceive Intent { act=android.net.conn.CONNECTIVITY_CHANGE flg=0x4000010 cmp=com.google.android.setupwizard/.MobileConnectivityChangeReceiver (has extras) } 07-24 23:22:56.709 D/MobileConnectivityChangeReceiver(17578): onReceive CONNECTIVITY_CHANGE networkType=5 07-24 23:22:56.719 D/GCM ( 1124): GcmService start Intent { act=android.net.conn.CONNECTIVITY_CHANGE flg=0x4000010 cmp=com.google.android.gms/.gcm.GcmService (has extras) } android.net.conn.CONNECTIVITY_CHANGE 07-24 23:22:56.729 D/dalvikvm(21922): Trying to load lib /data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so 0x425fac80 07-24 23:22:56.729 D/dalvikvm(21922): Shared lib '/data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so' already loaded in same CL 0x425fac80 07-24 23:22:56.739 D/dalvikvm(21922): Trying to load lib /data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so 0x425fac80 07-24 23:22:56.739 D/dalvikvm(21922): Shared lib '/data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so' already loaded in same CL 0x425fac80 07-24 23:22:56.779 D/dalvikvm( 8746): GC_CONCURRENT freed 334K, 9% free 17509K/19032K, paused 1ms+1ms, total 23ms 07-24 23:22:56.819 I/PushServiceReceiver(18059): start PushSerevice for ACTION_BOOT_COMPLETED or CONNECTIVITY_ACTION 07-24 23:22:56.829 D/DownloadQueueService(17691): service created : co.uk.mediaat.downloader.queue.DownloadQueueService@4266c9f0 07-24 23:22:56.839 D/DownloadQueue(17691): BBCDownloadAgent: querying downloads: queue id: BBCDownloadAgent 07-24 23:22:56.839 D/DownloadQueue(17691): BBCDownloadAgent: received 0 downloads 07-24 23:22:56.849 D/MobileConnectivityChangeReceiver(17578): onReceive Intent { act=android.net.conn.CONNECTIVITY_CHANGE flg=0x4000010 cmp=com.google.android.setupwizard/.MobileConnectivityChangeReceiver (has extras) } 07-24 23:22:56.849 D/MobileConnectivityChangeReceiver(17578): onReceive CONNECTIVITY_CHANGE networkType=0 07-24 23:22:56.849 D/MobileConnectivityChangeReceiver(17578): onReceive CONNECTIVITY_CHANGE: checkConnection 07-24 23:22:56.849 D/CheckConnectionTask(17578): doInBackground: url=http://clients3.google.com/generate_204 07-24 23:22:56.859 D/DownloadQueueController(17691): network available: false 07-24 23:22:56.859 D/DownloadQueueController(17691): storage available: true 07-24 23:22:56.859 D/DownloadQueueController(17691): environment valid: true 07-24 23:22:56.859 D/DownloadQueue(17691): download queue suspended 07-24 23:22:56.859 D/DownloadQueueService(17691): no active queues, stopping service 07-24 23:22:56.859 D/DownloadQueueService(17691): service stopped 07-24 23:22:56.859 D/DownloadQueueService(17691): service destroyed 07-24 23:22:56.869 D/GCM ( 1124): GcmService start Intent { act=android.net.conn.CONNECTIVITY_CHANGE flg=0x4000010 cmp=com.google.android.gms/.gcm.GcmService (has extras) } android.net.conn.CONNECTIVITY_CHANGE 07-24 23:22:56.879 D/dalvikvm( 3210): GC_CONCURRENT freed 399K, 3% free 17090K/17608K, paused 3ms+1ms, total 16ms 07-24 23:22:56.889 D/dalvikvm( 991): GC_CONCURRENT freed 609K, 8% free 18702K/20308K, paused 3ms+1ms, total 17ms 07-24 23:22:56.889 I/goggles ( 3210): k: Checking for images newer than 1406141576633 07-24 23:22:56.909 I/PushServiceReceiver(18059): start PushSerevice for ACTION_BOOT_COMPLETED or CONNECTIVITY_ACTION 07-24 23:22:56.909 D/DownloadQueueService(17691): service created : co.uk.mediaat.downloader.queue.DownloadQueueService@4261c230 07-24 23:22:56.919 D/DownloadQueue(17691): BBCDownloadAgent: querying downloads: queue id: BBCDownloadAgent 07-24 23:22:56.919 D/DownloadQueue(17691): BBCDownloadAgent: received 0 downloads 07-24 23:22:56.919 D/GCM ( 1124): GcmService start Intent { act=com.google.android.checkin.CHECKIN_COMPLETE flg=0x10 cmp=com.google.android.gms/.gcm.GcmService (has extras) } com.google.android.checkin.CHECKIN_COMPLETE 07-24 23:22:56.929 D/DownloadQueueController(17691): network available: false 07-24 23:22:56.929 D/DownloadQueueController(17691): storage available: true 07-24 23:22:56.929 D/DownloadQueueController(17691): environment valid: true 07-24 23:22:56.929 D/DownloadQueue(17691): download queue suspended 07-24 23:22:56.929 D/DownloadQueueService(17691): no active queues, stopping service 07-24 23:22:56.929 D/DownloadQueueService(17691): service stopped 07-24 23:22:56.929 D/DownloadQueueService(17691): service destroyed 07-24 23:22:56.939 D/GCM ( 1124): GcmService start Intent { act=com.google.android.checkin.CHECKIN_COMPLETE flg=0x10 cmp=com.google.android.gms/.gcm.GcmService (has extras) } com.google.android.checkin.CHECKIN_COMPLETE 07-24 23:22:56.949 D/dalvikvm( 8746): GC_CONCURRENT freed 472K, 9% free 17420K/19032K, paused 2ms+1ms, total 13ms 07-24 23:22:56.959 D/dalvikvm( 3210): GC_CONCURRENT freed 433K, 3% free 17096K/17608K, paused 2ms+1ms, total 12ms 07-24 23:22:56.969 I/goggles ( 3210): k: Checking for images newer than 1406141576633 07-24 23:22:56.999 I/ProxyService(21922): Action: android.net.conn.CONNECTIVITY_CHANGE 07-24 23:22:56.999 I/ProxyService(21922): Network Type: mobile, subtype: HSPA+, available: true 07-24 23:22:56.999 I/ProxyService(21922): Action: android.net.conn.CONNECTIVITY_CHANGE 07-24 23:22:56.999 I/ProxyService(21922): Network Type: mobile, subtype: HSPA+, available: true 07-24 23:22:57.029 I/Adreno-EGL(21922): : EGL 1.4 QUALCOMM Build: I0404c4692afb8623f95c43aeb6d5e13ed4b30ddbDate: 11/06/13 07-24 23:22:57.049 D/OpenGLRenderer(21922): Enabling debug mode 0 07-24 23:22:57.079 D/dalvikvm(21922): GC_CONCURRENT freed 125K, 1% free 17333K/17508K, paused 1ms+1ms, total 11ms 07-24 23:22:57.089 D/Preferences(21922): Proxy service connected 07-24 23:22:57.219 D/ConnectivityService( 749): handleInetConditionHoldEnd: net=0, condition=100, published condition=100 07-24 23:22:57.299 V/QcrilMsgTunnelSocket(30567): After reading offset = 0 remaining = 4 countRead = 4 07-24 23:22:57.299 D/QcrilMsgTunnelSocket(30567): messageLength extracted from first 4 inputStream reads = 29 07-24 23:22:57.299 V/QcrilMsgTunnelSocket(30567): offset = 0 remaining = 29 countRead = 0 07-24 23:22:57.299 V/QcrilMsgTunnelSocket(30567): offset = 0 remaining = 29 countRead = 29 07-24 23:22:57.299 D/QcrilMsgTunnelSocket(30567): readRilMessage: Buffer = [B@42603a38 HexData = [0100000004040000110000005155414c434f4d4def0308000100000002] 07-24 23:22:57.299 V/QcrilMsgTunnelSocket(30567): Read packet: 29 bytes. Data Available = 32 Position = 0 07-24 23:22:57.299 D/QcrilMsgTunnelSocket(30567): processResponse. message type = 1. Data Available = 28 07-24 23:22:57.299 D/QcrilMsgTunnelSocket(30567): ByteArray from parcel = 5155414c434f4d4def0308000100000002 07-24 23:22:57.299 D/QcrilMsgTunnelSocket(30567): Received RIL_UNSOL_OEM_HOOK_RAW message 07-24 23:22:57.299 D/QcrilMsgTunnelSocket(30567): Oem ID in RIL_UNSOL_OEM_HOOK_RAW is QUALCOMM 07-24 23:22:57.299 D/QcrilMsgTunnelSocket(30567): OEM ID check Passed 07-24 23:22:57.299 D/QcrilMsgTunnelSocket(30567): Response ID in RIL_UNSOL_OEM_HOOK_RAW is 525295 07-24 23:22:57.299 D/QcrilMsgTunnelSocket(30567): Response ID 525295is not served in this process. 07-24 23:22:57.299 D/QcrilMsgTunnelSocket(30567): To broadcast an Intent via the notifier to external apps 07-24 23:22:57.299 V/QcrilMsgTunnelSocket(30567): Before reading offset = 0 remaining = 4 countRead = 0 07-24 23:22:57.299 D/QcrilMsgTunnelIfaceManager(30567): handleMessage what=0 07-24 23:22:57.299 D/QcrilMsgTunnelIfaceManager(30567): Broadcasting intent ACTION_UNSOL_RESPONSE_OEM_HOOK_RAW 07-24 23:22:57.369 D/dalvikvm( 749): GC_CONCURRENT freed 6117K, 25% free 41349K/54876K, paused 3ms+6ms, total 90ms 07-24 23:22:57.369 D/dalvikvm( 749): WAIT_FOR_CONCURRENT_GC blocked 77ms 07-24 23:22:57.369 D/dalvikvm( 749): WAIT_FOR_CONCURRENT_GC blocked 72ms 07-24 23:22:57.389 D/AlarmManagerService( 749): Kernel timezone updated to -60 minutes west of GMT 07-24 23:22:57.389 D/MobileDataStateTracker( 749): default: Broadcast received: android.intent.action.ANY_DATA_STATE apnType=default 07-24 23:22:57.389 D/MobileDataStateTracker( 749): default: Received state=CONNECTED, old=CONNECTED, reason=(unspecified) 07-24 23:22:57.899 D/dalvikvm( 749): GC_CONCURRENT freed 6306K, 25% free 41208K/54876K, paused 3ms+4ms, total 81ms 07-24 23:22:57.899 D/dalvikvm( 749): WAIT_FOR_CONCURRENT_GC blocked 64ms 07-24 23:22:58.279 D/CheckConnectionTask(17578): doInBackground: resultCode=204 retVal=true 07-24 23:22:58.279 D/CheckConnectionTask(17578): onPostExecute connected=true 07-24 23:22:58.279 D/CheckConnectionTask(17578): onPostExecute set preference connected=true 07-24 23:22:58.429 D/dalvikvm( 749): GC_CONCURRENT freed 6137K, 25% free 41200K/54876K, paused 3ms+4ms, total 85ms 07-24 23:22:58.429 D/dalvikvm( 749): WAIT_FOR_CONCURRENT_GC blocked 30ms 07-24 23:22:58.429 D/dalvikvm( 749): WAIT_FOR_CONCURRENT_GC blocked 72ms 07-24 23:22:58.619 D/ConnectivityService( 749): [CheckMp] isMobileOk: X result=1 07-24 23:22:58.629 D/ConnectivityService( 749): [CheckMp] onPostExecute: result=1 07-24 23:22:58.629 D/ConnectivityService( 749): CheckMp.onComplete: result=1 07-24 23:22:58.629 D/ConnectivityService( 749): CheckMp.onComplete: ignore, connected or no connection 07-24 23:22:59.349 D/dalvikvm( 749): GC_FOR_ALLOC freed 4606K, 25% free 41202K/54876K, paused 72ms, total 72ms 07-24 23:22:59.369 D/dalvikvm( 861): GC_FOR_ALLOC freed 2166K, 52% free 24415K/50320K, paused 15ms, total 15ms 07-24 23:22:59.459 D/dalvikvm( 749): GC_FOR_ALLOC freed 2516K, 25% free 41200K/54876K, paused 76ms, total 76ms 07-24 23:22:59.519 D/dalvikvm(21922): GC_CONCURRENT freed 118K, 1% free 17603K/17756K, paused 2ms+2ms, total 17ms 07-24 23:23:02.009 D/dalvikvm(20973): GC_CONCURRENT freed 696K, 5% free 20098K/21048K, paused 1ms+7ms, total 35ms 07-24 23:23:02.079 W/ResourceType(20973): getEntry failing because entryIndex 129 is beyond type entryCount 4 07-24 23:23:02.219 D/android.widget.GridLayout(20973): vertical constraints: y1-y0>=79, y2-y1>=841, y2-y0<=144 are inconsistent; permanently removing: y2-y0<=144. 07-24 23:23:02.419 D/dalvikvm(20973): GC_CONCURRENT freed 1629K, 8% free 19486K/21172K, paused 1ms+2ms, total 15ms 07-24 23:23:02.419 D/dalvikvm(20973): WAIT_FOR_CONCURRENT_GC blocked 11ms 07-24 23:23:02.469 D/dalvikvm(20973): GC_FOR_ALLOC freed 88K, 5% free 20133K/21172K, paused 11ms, total 12ms 07-24 23:23:02.489 D/dalvikvm(20973): GC_FOR_ALLOC freed 7K, 5% free 20209K/21256K, paused 11ms, total 11ms 07-24 23:23:02.509 D/dalvikvm(20973): GC_FOR_ALLOC freed 2K, 5% free 20290K/21340K, paused 14ms, total 14ms 07-24 23:23:02.519 D/dalvikvm(20973): GC_FOR_ALLOC freed 3K, 5% free 20454K/21508K, paused 10ms, total 10ms 07-24 23:23:02.539 D/dalvikvm(20973): GC_FOR_ALLOC freed 4K, 5% free 20617K/21676K, paused 11ms, total 11ms 07-24 23:23:02.569 D/dalvikvm(20973): GC_FOR_ALLOC freed 5K, 5% free 20862K/21928K, paused 12ms, total 13ms 07-24 23:23:02.599 D/dalvikvm(20973): GC_FOR_ALLOC freed 8K, 5% free 21190K/22264K, paused 12ms, total 12ms 07-24 23:23:02.619 D/dalvikvm(20973): GC_FOR_ALLOC freed 6K, 5% free 21622K/22700K, paused 11ms, total 11ms 07-24 23:23:02.639 I/Metrics:BatchTransmitte(12411): QueuePusher.sendBatches - Drained batch queue.; Number of batches sent: 0 07-24 23:23:02.659 D/dalvikvm(20973): GC_FOR_ALLOC freed 11K, 5% free 22196K/23288K, paused 10ms, total 10ms 07-24 23:23:02.729 D/dalvikvm(20973): GC_FOR_ALLOC freed 17K, 5% free 22994K/24024K, paused 11ms, total 11ms 07-24 23:23:02.799 D/dalvikvm(20973): GC_FOR_ALLOC freed 23K, 5% free 24049K/25108K, paused 11ms, total 11ms 07-24 23:23:02.879 D/dalvikvm(20973): GC_FOR_ALLOC freed 27K, 4% free 25516K/26524K, paused 11ms, total 11ms 07-24 23:23:02.999 D/dalvikvm(20973): GC_FOR_ALLOC freed 43K, 4% free 27420K/28456K, paused 10ms, total 10ms 07-24 23:23:03.049 D/dalvikvm(20973): GC_FOR_ALLOC freed 27K, 4% free 30025K/31008K, paused 11ms, total 11ms 07-24 23:23:03.179 D/dalvikvm(16404): GC_CONCURRENT freed 385K, 3% free 16757K/17176K, paused 1ms+1ms, total 8ms 07-24 23:23:03.629 D/dalvikvm(16404): GC_CONCURRENT freed 387K, 3% free 16755K/17176K, paused 2ms+1ms, total 11ms 07-24 23:23:03.819 W/ActivityManager( 749): Scheduling restart of crashed service org.adblockplus.android/.ProxyService in 1000ms 07-24 23:23:03.849 I/WindowState( 749): WIN DEATH: Window{43a47a38 u0 org.adblockplus.android/org.adblockplus.android.Preferences} 07-24 23:23:03.879 W/InputMethodManagerService( 749): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@4372fc70 attribute=null, token = android.os.BinderProxy@430f31e8 07-24 23:23:06.969 W/ProcessCpuTracker( 749): Skipping unknown process pid 22481 07-24 23:23:08.189 E/ThermalEngine( 195): TM Id 'SKIN_THERMAL_management_1' Sensor 'xo_therm_pu2' - alarm raised 1 at 40.0 degC 07-24 23:23:08.189 E/ThermalEngine( 195): ACTION: LCD - Setting max LCD brightness to 229 07-24 23:23:11.959 E/WindowManager( 749): Starting window AppWindowToken{447cd230 token=Token{431b0a00 ActivityRecord{4268c6d8 u0 com.android.settings/.Settings$ManageApplicationsActivity t49}}} timed out 07-24 23:23:12.239 D/ConnectivityService( 749): Sampling interval elapsed, updating statistics .. 07-24 23:23:12.239 D/ConnectivityService( 749): Done. 07-24 23:23:12.239 D/ConnectivityService( 749): Setting timer for 720seconds 07-24 23:23:12.249 D/dalvikvm( 1009): GC_CONCURRENT freed 416K, 4% free 18027K/18696K, paused 1ms+1ms, total 21ms 07-24 23:23:12.279 W/BackupManagerService( 749): dataChanged but no participant pkg='com.android.providers.settings' uid=10059 07-24 23:23:12.299 D/dalvikvm(18059): GC_CONCURRENT freed 410K, 3% free 17545K/17988K, paused 1ms+1ms, total 11ms 07-24 23:23:12.299 D/dalvikvm(18059): WAIT_FOR_CONCURRENT_GC blocked 2ms 07-24 23:23:13.069 I/IcingCorporaProvider( 1343): Updating corpora: APPS=NONE, CONTACTS=DELTA 07-24 23:23:13.129 I/ContactLoggerTask( 1343): canRun() : Disabled 07-24 23:23:13.129 I/IcingCorporaProvider( 1343): UpdateCorporaTask done [took 65 ms] updated contacts [took 65 ms] 07-24 23:23:13.199 I/socket (18059): msgid:5 07-24 23:23:15.329 D/dalvikvm( 749): GC_FOR_ALLOC freed 4343K, 25% free 41362K/54876K, paused 78ms, total 78ms 07-24 23:23:15.369 D/dalvikvm( 861): GC_FOR_ALLOC freed 2839K, 54% free 23441K/50320K, paused 20ms, total 21ms 07-24 23:23:15.419 D/dalvikvm( 749): GC_FOR_ALLOC freed 2698K, 25% free 41178K/54876K, paused 68ms, total 68ms 07-24 23:23:15.449 D/dalvikvm( 861): GC_FOR_ALLOC freed 1725K, 54% free 23481K/50320K, paused 14ms, total 14ms 07-24 23:23:15.529 D/dalvikvm( 749): GC_FOR_ALLOC freed 2514K, 25% free 41179K/54876K, paused 65ms, total 65ms 07-24 23:23:15.559 W/InputMethodManagerService( 749): Starting input on non-focused client com.android.internal.view.IInputMethodClient$Stub$Proxy@428f03a0 (uid=1000 pid=20973) 07-24 23:23:16.349 I/WindowState( 749): WIN DEATH: Window{44269140 u0 com.android.settings/com.android.settings.Settings$WifiSettingsActivity} 07-24 23:23:16.359 W/InputDispatcher( 749): channel '42f5b9b8 com.android.settings/com.android.settings.applications.InstalledAppDetails (server)' ~ Consumer closed input channel or an error occurred. events=0x9 07-24 23:23:16.359 E/InputDispatcher( 749): channel '42f5b9b8 com.android.settings/com.android.settings.applications.InstalledAppDetails (server)' ~ Channel is unrecoverably broken and will be disposed! 07-24 23:23:16.359 W/InputDispatcher( 749): Attempted to unregister already unregistered input channel '42f5b9b8 com.android.settings/com.android.settings.applications.InstalledAppDetails (server)' 07-24 23:23:16.359 I/WindowState( 749): WIN DEATH: Window{42f5b9b8 u0 com.android.settings/com.android.settings.applications.InstalledAppDetails} 07-24 23:23:17.009 D/dalvikvm( 1343): GC_FOR_ALLOC freed 3768K, 18% free 29097K/35240K, paused 43ms, total 44ms 07-24 23:23:17.019 I/MicrophoneInputStream( 1343): mic_starting eze@429edb10 07-24 23:23:17.029 I/HotwordRecognitionRnr( 1343): Starting hotword detection. 07-24 23:23:17.029 D/audio_hw_primary( 185): select_devices: out_snd_device(0: ) in_snd_device(35: voice-rec-mic) 07-24 23:23:17.029 D/ ( 185): Failed to fetch the lookup information of the device 0000003E 07-24 23:23:17.029 E/ACDB-LOADER( 185): Error: ACDB AudProc vol returned = -19 07-24 23:23:17.059 I/Icing ( 991): Usage reports 1 indexed 0 rejected 0 denied 0 07-24 23:23:17.119 I/HotwordWorker( 1343): onReady 07-24 23:23:17.279 I/GEL ( 1049): handleIntent(Intent { act=android.intent.action.MAIN cat=[android.intent.category.HOME] flg=0x10200000 cmp=com.google.android.googlequicksearchbox/com.google.android.launcher.GEL }) 07-24 23:23:17.939 W/ContextImpl(19101): Implicit intents with startService are not safe: Intent { act=com.viber.voip.action.ACTION_SYNC_ACCOUNT } android.content.ContextWrapper.startService:494 com.viber.service.contacts.sync.c.run:58 android.os.Handler.handleCallback:733 07-24 23:23:18.039 I/MicrophoneInputStream( 1343): mic_close eze@429edb10 07-24 23:23:18.089 D/dalvikvm(11362): GC_FOR_ALLOC freed 450K, 4% free 17817K/18448K, paused 18ms, total 20ms 07-24 23:23:18.109 I/HotwordRecognitionRnr( 1343): Stopping hotword detection. 07-24 23:23:18.109 I/HotwordRecognitionRnr( 1343): Hotword detection finished 07-24 23:23:18.119 D/dalvikvm(11362): GC_CONCURRENT freed 88K, 4% free 17839K/18448K, paused 3ms+3ms, total 28ms 07-24 23:23:18.119 V/PanelView( 861): animationTick called with dtms=0; nothing to do (h=84.35503 v=1597.2356) 07-24 23:23:18.119 D/dalvikvm(11362): WAIT_FOR_CONCURRENT_GC blocked 12ms 07-24 23:23:18.119 I/dalvikvm-heap(11362): Grow heap (frag case) to 17.493MB for 46270-byte allocation 07-24 23:23:18.119 V/PanelView( 861): animationTick called with dtms=-17; nothing to do (h=84.35503 v=1597.2356) 07-24 23:23:18.129 D/dalvikvm(11362): GC_FOR_ALLOC freed 39K, 4% free 17844K/18496K, paused 12ms, total 12ms 07-24 23:23:18.229 D/dalvikvm(11362): GC_FOR_ALLOC freed 210K, 4% free 17790K/18496K, paused 13ms, total 13ms 07-24 23:23:18.249 D/dalvikvm(11362): GC_FOR_ALLOC freed 75K, 4% free 17866K/18496K, paused 13ms, total 13ms 07-24 23:23:18.439 D/dalvikvm(19101): GC_CONCURRENT freed 2628K, 10% free 24832K/27508K, paused 2ms+2ms, total 37ms 07-24 23:23:18.439 D/dalvikvm(19101): WAIT_FOR_CONCURRENT_GC blocked 14ms 07-24 23:23:18.439 D/dalvikvm(19101): WAIT_FOR_CONCURRENT_GC blocked 13ms 07-24 23:23:18.529 D/dalvikvm( 8348): GC_CONCURRENT freed 407K, 3% free 18408K/18956K, paused 2ms+2ms, total 22ms 07-24 23:23:18.609 W/MdnsDeviceScanner( 991): No network interfaces to scan on! 07-24 23:23:18.619 D/dalvikvm( 991): GC_CONCURRENT freed 674K, 8% free 18708K/20308K, paused 4ms+2ms, total 24ms 07-24 23:23:18.619 D/dalvikvm( 991): WAIT_FOR_CONCURRENT_GC blocked 15ms 07-24 23:23:18.629 W/MdnsDeviceScanner( 991): No network interfaces to scan on! 07-24 23:23:21.939 I/GEL ( 1049): handleIntent(Intent { act=android.intent.action.MAIN cat=[android.intent.category.HOME] flg=0x10200000 cmp=com.google.android.googlequicksearchbox/com.google.android.launcher.GEL }) 07-24 23:23:21.939 V/PanelView( 861): animationTick called with dtms=0; nothing to do (h=1776.0 v=-6000.0) 07-24 23:23:21.969 W/InputMethodManagerService( 749): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@43125908 attribute=null, token = android.os.BinderProxy@4314bc48 07-24 23:23:21.989 I/MicrophoneInputStream( 1343): mic_starting eze@428d6cc8 07-24 23:23:21.999 I/HotwordRecognitionRnr( 1343): Starting hotword detection. 07-24 23:23:21.999 D/audio_hw_primary( 185): select_devices: out_snd_device(0: ) in_snd_device(35: voice-rec-mic) 07-24 23:23:21.999 D/ ( 185): Failed to fetch the lookup information of the device 0000003E 07-24 23:23:21.999 E/ACDB-LOADER( 185): Error: ACDB AudProc vol returned = -19 07-24 23:23:22.089 I/HotwordWorker( 1343): onReady 07-24 23:23:22.519 D/dalvikvm(11362): GC_CONCURRENT freed 489K, 4% free 17788K/18496K, paused 2ms+2ms, total 25ms 07-24 23:23:22.619 D/dalvikvm(11362): GC_CONCURRENT freed 421K, 4% free 17878K/18496K, paused 1ms+1ms, total 13ms 07-24 23:23:22.619 D/dalvikvm(11362): WAIT_FOR_CONCURRENT_GC blocked 12ms 07-24 23:23:22.629 D/dalvikvm(11362): GC_FOR_ALLOC freed 51K, 4% free 17889K/18496K, paused 11ms, total 11ms 07-24 23:23:22.629 I/dalvikvm-heap(11362): Grow heap (frag case) to 17.541MB for 46162-byte allocation 07-24 23:23:22.649 D/dalvikvm(11362): GC_FOR_ALLOC freed 0K, 4% free 17934K/18544K, paused 12ms, total 12ms 07-24 23:23:22.739 D/dalvikvm(11362): GC_FOR_ALLOC freed 316K, 5% free 17756K/18544K, paused 13ms, total 13ms 07-24 23:23:22.749 D/dalvikvm(11362): GC_FOR_ALLOC freed 63K, 4% free 17873K/18544K, paused 12ms, total 12ms 07-24 23:23:23.999 D/dalvikvm(11362): GC_FOR_ALLOC freed 411K, 5% free 17746K/18544K, paused 16ms, total 16ms 07-24 23:23:24.019 D/dalvikvm(11362): GC_FOR_ALLOC freed 102K, 4% free 17819K/18544K, paused 16ms, total 16ms 07-24 23:23:24.039 D/dalvikvm(11362): GC_FOR_ALLOC freed 36K, 4% free 17890K/18544K, paused 16ms, total 16ms 07-24 23:23:24.049 D/dalvikvm(11362): GC_FOR_ALLOC freed 180K, 5% free 17740K/18544K, paused 11ms, total 11ms 07-24 23:23:24.059 D/dalvikvm(11362): GC_FOR_ALLOC freed 32K, 4% free 17843K/18544K, paused 11ms, total 11ms 07-24 23:23:24.079 D/dalvikvm(11362): GC_FOR_ALLOC freed 30K, 4% free 17859K/18544K, paused 12ms, total 12ms 07-24 23:23:24.459 E/DatabaseUtils(11362): Writing exception to parcel 07-24 23:23:24.459 E/DatabaseUtils(11362): java.lang.IllegalArgumentException: URI: content://com.android.contacts/phone_lookup/, calling user: com.mrnumber.blocker, calling package:com.mrnumber.blocker 07-24 23:23:24.459 E/DatabaseUtils(11362): at com.android.providers.contacts.LegacyApiSupport.query(LegacyApiSupport.java:1914) 07-24 23:23:24.459 E/DatabaseUtils(11362): at com.android.providers.contacts.ContactsProvider2.queryLocal(ContactsProvider2.java:6380) 07-24 23:23:24.459 E/DatabaseUtils(11362): at com.android.providers.contacts.ContactsProvider2.query(ContactsProvider2.java:4996) 07-24 23:23:24.459 E/DatabaseUtils(11362): at android.content.ContentProvider$Transport.query(ContentProvider.java:200) 07-24 23:23:24.459 E/DatabaseUtils(11362): at android.content.ContentProviderNative.onTransact(ContentProviderNative.java:112) 07-24 23:23:24.459 E/DatabaseUtils(11362): at android.os.Binder.execTransact(Binder.java:404) 07-24 23:23:24.459 E/DatabaseUtils(11362): at dalvik.system.NativeStart.run(Native Method) 07-24 23:23:24.459 D/dalvikvm(26403): GC_CONCURRENT freed 1224K, 7% free 20645K/22080K, paused 2ms+2ms, total 28ms 07-24 23:23:24.569 D/dalvikvm(11362): GC_CONCURRENT freed 430K, 4% free 17821K/18544K, paused 2ms+2ms, total 16ms 07-24 23:23:24.699 D/dalvikvm( 749): GC_EXPLICIT freed 4659K, 28% free 39547K/54876K, paused 3ms+6ms, total 95ms 07-24 23:23:24.959 D/dalvikvm(11362): GC_CONCURRENT freed 438K, 5% free 17777K/18544K, paused 3ms+3ms, total 22ms 07-24 23:23:27.789 D/dalvikvm( 861): GC_CONCURRENT freed 440K, 50% free 25166K/50320K, paused 1ms+2ms, total 19ms 07-24 23:23:28.789 I/MicrophoneInputStream( 1343): mic_close eze@428d6cc8 07-24 23:23:28.849 I/HotwordRecognitionRnr( 1343): Hotword detection finished 07-24 23:23:28.849 I/HotwordRecognitionRnr( 1343): Stopping hotword detection. 07-24 23:23:29.929 W/Resources(22601): Converting to string: TypedValue{t=0x10/d=0x2 a=2 r=0x7f0c0001} 07-24 23:23:29.929 W/Resources(22601): Converting to string: TypedValue{t=0x10/d=0x2 a=2 r=0x7f0c0001} 07-24 23:23:29.929 D/dalvikvm(22601): GC_CONCURRENT freed 269K, 2% free 16976K/17276K, paused 2ms+2ms, total 22ms 07-24 23:23:29.929 D/dalvikvm(22601): WAIT_FOR_CONCURRENT_GC blocked 1ms 07-24 23:23:29.939 D/dalvikvm(22601): Trying to load lib /data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so 0x425fc4f0 07-24 23:23:29.939 W/linker (22601): libadblockplus-jni.so has text relocations. This is wasting memory and is a security risk. Please fix. 07-24 23:23:29.949 D/dalvikvm(22601): Added shared lib /data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so 0x425fc4f0 07-24 23:23:29.949 D/dalvikvm(22601): No JNI_OnLoad found in /data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so 0x425fc4f0, skipping init 07-24 23:23:29.959 D/dalvikvm(22601): Trying to load lib /data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so 0x425fc4f0 07-24 23:23:29.959 D/dalvikvm(22601): Shared lib '/data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so' already loaded in same CL 0x425fc4f0 07-24 23:23:29.959 D/dalvikvm(22601): Trying to load lib /data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so 0x425fc4f0 07-24 23:23:29.959 D/dalvikvm(22601): Shared lib '/data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so' already loaded in same CL 0x425fc4f0 07-24 23:23:29.959 D/dalvikvm(22601): Trying to load lib /data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so 0x425fc4f0 07-24 23:23:29.959 D/dalvikvm(22601): Shared lib '/data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so' already loaded in same CL 0x425fc4f0 07-24 23:23:29.959 D/dalvikvm(22601): Trying to load lib /data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so 0x425fc4f0 07-24 23:23:29.959 D/dalvikvm(22601): Shared lib '/data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so' already loaded in same CL 0x425fc4f0 07-24 23:23:31.169 D/dalvikvm(22601): Trying to load lib /data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so 0x425fc4f0 07-24 23:23:31.169 D/dalvikvm(22601): Shared lib '/data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so' already loaded in same CL 0x425fc4f0 07-24 23:23:31.169 D/dalvikvm(22601): Trying to load lib /data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so 0x425fc4f0 07-24 23:23:31.169 D/dalvikvm(22601): Shared lib '/data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so' already loaded in same CL 0x425fc4f0 07-24 23:23:32.239 D/dalvikvm(22601): Trying to load lib /data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so 0x425fc4f0 07-24 23:23:32.239 D/dalvikvm(22601): Shared lib '/data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so' already loaded in same CL 0x425fc4f0 07-24 23:23:32.249 D/dalvikvm(22601): Trying to load lib /data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so 0x425fc4f0 07-24 23:23:32.249 D/dalvikvm(22601): Shared lib '/data/app-lib/org.adblockplus.android-1/libadblockplus-jni.so' already loaded in same CL 0x425fc4f0 07-24 23:23:32.529 D/ProxyService(22601): PRX: null:null(null) 07-24 23:23:32.549 D/dalvikvm(22601): GC_EXPLICIT freed 135K, 2% free 17019K/17276K, paused 1ms+1ms, total 15ms 07-24 23:23:33.069 W/System.err(22601): java.util.concurrent.TimeoutException 07-24 23:23:33.069 W/System.err(22601): at com.stericson.RootTools.Executer.sendShell(Executer.java:95) 07-24 23:23:33.069 W/System.err(22601): at com.stericson.RootTools.RootTools.sendShell(RootTools.java:1112) 07-24 23:23:33.069 W/System.err(22601): at com.stericson.RootTools.RootTools.sendShell(RootTools.java:1079) 07-24 23:23:33.069 W/System.err(22601): at com.stericson.RootTools.RootTools.sendShell(RootTools.java:1141) 07-24 23:23:33.069 W/System.err(22601): at com.stericson.RootTools.RootTools.isAccessGiven(RootTools.java:762) 07-24 23:23:33.069 W/System.err(22601): at org.adblockplus.android.ProxyService.onCreate(ProxyService.java:169) 07-24 23:23:33.069 W/System.err(22601): at android.app.ActivityThread.handleCreateService(ActivityThread.java:2558) 07-24 23:23:33.069 W/System.err(22601): at android.app.ActivityThread.access$1800(ActivityThread.java:135) 07-24 23:23:33.069 W/System.err(22601): at android.app.ActivityThread$H.handleMessage(ActivityThread.java:1278) 07-24 23:23:33.069 W/System.err(22601): at android.os.Handler.dispatchMessage(Handler.java:102) 07-24 23:23:33.069 W/System.err(22601): at android.os.Looper.loop(Looper.java:136) 07-24 23:23:33.069 W/System.err(22601): at android.app.ActivityThread.main(ActivityThread.java:5001) 07-24 23:23:33.069 W/System.err(22601): at java.lang.reflect.Method.invokeNative(Native Method) 07-24 23:23:33.069 W/System.err(22601): at java.lang.reflect.Method.invoke(Method.java:515) 07-24 23:23:33.069 W/System.err(22601): at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:785) 07-24 23:23:33.069 W/System.err(22601): at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:601) 07-24 23:23:33.069 W/System.err(22601): at dalvik.system.NativeStart.main(Native Method) 07-24 23:23:33.079 E/DCR (22601): Saving proxy null:null/null 07-24 23:23:33.089 V/main. (22601): starting handler: https 07-24 23:23:33.089 V/main. (22601): starting handler: adblock 07-24 23:23:33.089 I/ProxyService(22601): Broadcasting org.adblockplus.android.service.state 07-24 23:23:33.089 I/ProxyService(22601): Service started 07-24 23:23:33.089 I/Choreographer(22601): Skipped 33 frames! The application may be doing too much work on its main thread. 07-24 23:23:33.119 I/Adreno-EGL(22601): : EGL 1.4 QUALCOMM Build: I0404c4692afb8623f95c43aeb6d5e13ed4b30ddbDate: 11/06/13 07-24 23:23:33.139 D/OpenGLRenderer(22601): Enabling debug mode 0 07-24 23:23:33.169 D/dalvikvm(22601): GC_CONCURRENT freed 90K, 1% free 17365K/17532K, paused 3ms+2ms, total 12ms 07-24 23:23:33.189 I/ProxyService(22601): Action: android.net.conn.CONNECTIVITY_CHANGE 07-24 23:23:33.189 I/ProxyService(22601): Network Type: mobile, subtype: HSPA, available: true 07-24 23:23:33.189 D/Preferences(22601): Proxy service connected 07-24 23:23:33.809 W/ProcessCpuTracker( 749): Skipping unknown process pid 22590 07-24 23:23:33.809 W/ProcessCpuTracker( 749): Skipping unknown process pid 22594 07-24 23:23:34.239 V/PanelView( 861): animationTick called with dtms=0; nothing to do (h=344.0 v=2971.6191) 07-24 23:23:34.729 W/MdnsDeviceScanner( 991): No network interfaces to scan on! 07-24 23:23:34.759 D/dalvikvm( 991): GC_CONCURRENT freed 692K, 8% free 18696K/20308K, paused 3ms+2ms, total 26ms 07-24 23:23:34.759 D/dalvikvm( 991): WAIT_FOR_CONCURRENT_GC blocked 13ms 07-24 23:23:34.759 W/MdnsDeviceScanner( 991): No network interfaces to scan on! 07-24 23:23:35.949 V/PanelView( 861): animationTick called with dtms=0; nothing to do (h=1776.0 v=-6000.0) 07-24 23:23:36.099 D/dalvikvm(22672): GC_CONCURRENT freed 228K, 2% free 16948K/17208K, paused 2ms+5ms, total 27ms 07-24 23:23:36.189 I/Adreno-EGL(22672): : EGL 1.4 QUALCOMM Build: I0404c4692afb8623f95c43aeb6d5e13ed4b30ddbDate: 11/06/13 07-24 23:23:36.209 D/OpenGLRenderer(22672): Enabling debug mode 0 07-24 23:23:36.279 D/dalvikvm(22672): GC_CONCURRENT freed 38K, 1% free 17355K/17448K, paused 2ms+1ms, total 11ms 07-24 23:23:36.339 D/dalvikvm(22672): GC_CONCURRENT freed 34K, 1% free 17777K/17868K, paused 2ms+2ms, total 16ms 07-24 23:23:36.339 D/dalvikvm(22672): WAIT_FOR_CONCURRENT_GC blocked 12ms 07-24 23:23:36.499 D/dalvikvm(22672): GC_CONCURRENT freed 452K, 3% free 17802K/18288K, paused 1ms+1ms, total 12ms 07-24 23:23:36.499 D/dalvikvm(22672): WAIT_FOR_CONCURRENT_GC blocked 9ms 07-24 23:23:36.499 D/dalvikvm(22672): WAIT_FOR_CONCURRENT_GC blocked 4ms 07-24 23:23:37.099 D/WifiService( 749): setWifiEnabled: true pid=22672, uid=1000 07-24 23:23:37.119 D/WifiConfigStore( 749): Loading config and enabling all networks 07-24 23:23:37.139 D/BluetoothManagerService( 749): Message: 20 07-24 23:23:37.139 D/BluetoothManagerService( 749): Added callback: android.bluetooth.IBluetoothManagerCallback$Stub$Proxy@4320b968:true 07-24 23:23:37.139 D/BluetoothAdapter(22672): 1113849256: getState() : mService = null. Returning STATE_OFF 07-24 23:23:37.139 D/BluetoothManagerService( 749): Message: 30 07-24 23:23:37.149 D/LocalBluetoothProfileManager(22672): Adding local MAP profile 07-24 23:23:37.149 D/BluetoothMap(22672): Create BluetoothMap proxy object 07-24 23:23:37.149 W/ContextImpl(22672): Calling a method in the system process without a qualified user: android.app.ContextImpl.bindService:1551 android.content.ContextWrapper.bindService:517 android.bluetooth.BluetoothInputDevice.doBind:245 android.bluetooth.BluetoothInputDevice.:238 android.bluetooth.BluetoothAdapter.getProfileProxy:1367 07-24 23:23:37.149 W/ContextImpl(22672): Calling a method in the system process without a qualified user: android.app.ContextImpl.bindService:1551 android.content.ContextWrapper.bindService:517 android.bluetooth.BluetoothPan.doBind:149 android.bluetooth.BluetoothPan.:141 android.bluetooth.BluetoothAdapter.getProfileProxy:1370 07-24 23:23:37.159 W/ContextImpl(22672): Calling a method in the system process without a qualified user: android.app.ContextImpl.bindService:1551 android.content.ContextWrapper.bindService:517 android.bluetooth.BluetoothMap.doBind:109 android.bluetooth.BluetoothMap.:102 android.bluetooth.BluetoothAdapter.getProfileProxy:1376 07-24 23:23:37.159 D/LocalBluetoothProfileManager(22672): LocalBluetoothProfileManager construction complete 07-24 23:23:37.159 D/BluetoothAdapter(22672): 1113849256: getState() : mService = null. Returning STATE_OFF 07-24 23:23:37.159 D/BluetoothAdapter(22672): 1113849256: getState() : mService = null. Returning STATE_OFF 07-24 23:23:37.159 W/ContextImpl(22672): Calling a method in the system process without a qualified user: android.app.ContextImpl.bindService:1551 android.content.ContextWrapper.bindService:517 android.bluetooth.BluetoothPbap.doBind:164 android.bluetooth.BluetoothPbap.:157 com.android.settings.bluetooth.PbapServerProfile.:68 07-24 23:23:37.259 D/dalvikvm( 749): GC_EXPLICIT freed 3299K, 26% free 40656K/54876K, paused 2ms+8ms, total 120ms 07-24 23:23:37.259 D/BluetoothManagerService( 749): Message: 30 07-24 23:23:37.259 D/BluetoothManagerService( 749): Message: 30 07-24 23:23:37.259 D/BluetoothManagerService( 749): Message: 30 07-24 23:23:37.269 D/CommandListener( 179): Setting iface cfg 07-24 23:23:37.269 D/CommandListener( 179): Trying to bring up p2p0 07-24 23:23:37.269 D/WifiMonitor( 749): startMonitoring(p2p0) with mConnected = true 07-24 23:23:37.299 D/dalvikvm(22672): GC_CONCURRENT freed 161K, 2% free 18047K/18288K, paused 3ms+2ms, total 18ms 07-24 23:23:37.339 D/dalvikvm(22672): GC_FOR_ALLOC freed 91K, 2% free 18310K/18568K, paused 9ms, total 9ms 07-24 23:23:38.829 W/GLSUser ( 1124): GoogleAccountDataService.getToken() 07-24 23:23:38.839 D/dalvikvm( 1009): GC_CONCURRENT freed 432K, 4% free 18019K/18696K, paused 1ms+1ms, total 24ms 07-24 23:23:39.809 I/wpa_supplicant(17509): wlan0: Trying to associate with 2c:39:96:d5:ea:d3 (SSID='BTHub4-PXNQ' freq=5240 MHz) 07-24 23:23:39.899 I/wpa_supplicant(17509): wlan0: Associated with 2c:39:96:d5:ea:d3 07-24 23:23:39.909 I/wpa_supplicant(17509): wlan0: WPA: Key negotiation completed with 2c:39:96:d5:ea:d3 [PTK=CCMP GTK=TKIP] 07-24 23:23:39.909 I/wpa_supplicant(17509): wlan0: CTRL-EVENT-CONNECTED - Connection to 2c:39:96:d5:ea:d3 completed (auth) [id=0 id_str=] 07-24 23:23:39.949 D/dalvikvm(22672): GC_CONCURRENT freed 279K, 2% free 18485K/18796K, paused 3ms+3ms, total 18ms 07-24 23:23:39.999 E/WifiStateMachine( 749): scanCount==0 - aborting 07-24 23:23:40.089 D/dalvikvm(22672): GC_CONCURRENT freed 472K, 3% free 18516K/19020K, paused 2ms+3ms, total 19ms 07-24 23:23:40.099 D/dalvikvm(22672): GC_FOR_ALLOC freed 59K, 3% free 18658K/19140K, paused 9ms, total 9ms 07-24 23:23:40.609 D/WifiStateMachine( 749): VerifyingLinkState enter 07-24 23:23:40.639 D/WifiStateMachine( 749): VerifyingLinkState GOOD_LINK_DETECTED: transition to captive portal check 07-24 23:23:40.639 D/WifiStateMachine( 749): CaptivePortalCheckState enter 07-24 23:23:40.649 D/ConnectivityService( 749): Captive portal check NetworkInfo: type: WIFI[], state: CONNECTING/CAPTIVE_PORTAL_CHECK, reason: (unspecified), extra: "BTHub4-PXNQ", roaming: false, failover: false, isAvailable: true, isConnectedToProvisioningNetwork: false 07-24 23:23:40.649 D/CaptivePortalTracker( 749): NoActiveNetworkState{ when=0 what=0 obj=NetworkInfo: type: WIFI[], state: CONNECTING/CAPTIVE_PORTAL_CHECK, reason: (unspecified), extra: "BTHub4-PXNQ", roaming: false, failover: false, isAvailable: true, isConnectedToProvisioningNetwork: false target=com.android.internal.util.StateMachine$SmHandler } 07-24 23:23:40.649 D/CaptivePortalTracker( 749): DefaultState{ when=-1ms what=0 obj=NetworkInfo: type: WIFI[], state: CONNECTING/CAPTIVE_PORTAL_CHECK, reason: (unspecified), extra: "BTHub4-PXNQ", roaming: false, failover: false, isAvailable: true, isConnectedToProvisioningNetwork: false target=com.android.internal.util.StateMachine$SmHandler } 07-24 23:23:40.649 D/CaptivePortalTracker( 749): notifyPortalCheckComplete: ni=NetworkInfo: type: WIFI[], state: CONNECTING/CAPTIVE_PORTAL_CHECK, reason: (unspecified), extra: "BTHub4-PXNQ", roaming: false, failover: false, isAvailable: true, isConnectedToProvisioningNetwork: false 07-24 23:23:40.649 D/ConnectivityService( 749): Captive check on WIFI 07-24 23:23:40.649 D/ConnectivityService( 749): captivePortalCheckComplete: ni=NetworkInfo: type: WIFI[], state: CONNECTING/CAPTIVE_PORTAL_CHECK, reason: (unspecified), extra: "BTHub4-PXNQ", roaming: false, failover: false, isAvailable: true, isConnectedToProvisioningNetwork: false 07-24 23:23:40.659 D/WifiStateMachine( 749): CaptivePortalCheckState CMD_CAPTIVE_CHECK_COMPLETE 07-24 23:23:40.679 D/ConnectivityService( 749): ConnectivityChange for WIFI: CONNECTED/CONNECTED 07-24 23:23:40.679 D/ConnectivityService( 749): Policy requires mobile teardown 07-24 23:23:40.699 E/ConnectivityService( 749): Unexpected mtu value: android.net.wifi.WifiStateTracker@42f3a778 07-24 23:23:40.709 D/Nat464Xlat( 749): requiresClat: netType=1, hasIPv4Address=true 07-24 23:23:40.719 D/MobileDataStateTracker( 749): default: setPolicyDataEnable(enabled=true) 07-24 23:23:40.819 D/dalvikvm(22672): GC_CONCURRENT freed 514K, 3% free 18693K/19240K, paused 2ms+2ms, total 13ms 07-24 23:23:40.839 D/dalvikvm(22672): GC_FOR_ALLOC freed 40K, 3% free 18841K/19360K, paused 10ms, total 10ms 07-24 23:23:40.859 D/MobileDataStateTracker( 749): default: setPolicyDataEnable(enabled=true) 07-24 23:23:42.089 V/QcrilMsgTunnelSocket(30567): After reading offset = 0 remaining = 4 countRead = 4 07-24 23:23:42.129 D/QcrilMsgTunnelSocket(30567): messageLength extracted from first 4 inputStream reads = 29 07-24 23:23:42.129 V/QcrilMsgTunnelSocket(30567): offset = 0 remaining = 29 countRead = 0 07-24 23:23:42.129 D/MobileDataStateTracker( 749): default: Broadcast received: android.intent.action.ANY_DATA_STATE apnType=default 07-24 23:23:42.139 D/MobileDataStateTracker( 749): default: Received state=DISCONNECTED, old=CONNECTED, reason=dataDisabled 07-24 23:23:42.139 D/MobileDataStateTracker( 749): default: setDetailed state, old =CONNECTED and new state=DISCONNECTED 07-24 23:23:42.139 D/ConnectivityService( 749): ConnectivityChange for mobile: DISCONNECTED/DISCONNECTED 07-24 23:23:42.139 D/ConnectivityService( 749): Attempting to switch to WIFI 07-24 23:23:42.139 D/ConnectivityService( 749): Attempting to switch to BLUETOOTH_TETHER 07-24 23:23:42.149 D/NetUtils( 749): android_net_utils_resetConnections in env=0x77bc39b0 clazz=0x48000001 iface=rmnet0 mask=0x3 07-24 23:23:42.149 V/QcrilMsgTunnelSocket(30567): offset = 0 remaining = 29 countRead = 29 07-24 23:23:42.149 D/QcrilMsgTunnelSocket(30567): readRilMessage: Buffer = [B@42603a38 HexData = [0100000004040000110000005155414c434f4d4def0308000100000001] 07-24 23:23:42.149 W/ContextImpl(19101): Implicit intents with startService are not safe: Intent { act=com.viber.voip.action.VIBER_SERVICE_BACKGROUND } android.content.ContextWrapper.startService:494 com.viber.voip.e.s.a:273 com.viber.voip.e.s.onServiceStateChanged:237 07-24 23:23:42.149 V/QcrilMsgTunnelSocket(30567): Read packet: 29 bytes. Data Available = 32 Position = 0 07-24 23:23:42.149 D/QcrilMsgTunnelSocket(30567): processResponse. message type = 1. Data Available = 28 07-24 23:23:42.149 D/ConnectivityService( 749): resetConnections(rmnet0, 3) 07-24 23:23:42.159 D/QcrilMsgTunnelSocket(30567): ByteArray from parcel = 5155414c434f4d4def0308000100000001 07-24 23:23:42.159 D/QcrilMsgTunnelSocket(30567): Received RIL_UNSOL_OEM_HOOK_RAW message 07-24 23:23:42.159 D/QcrilMsgTunnelSocket(30567): Oem ID in RIL_UNSOL_OEM_HOOK_RAW is QUALCOMM 07-24 23:23:42.159 D/QcrilMsgTunnelSocket(30567): OEM ID check Passed 07-24 23:23:42.159 D/QcrilMsgTunnelSocket(30567): Response ID in RIL_UNSOL_OEM_HOOK_RAW is 525295 07-24 23:23:42.159 D/QcrilMsgTunnelSocket(30567): Response ID 525295is not served in this process. 07-24 23:23:42.159 D/QcrilMsgTunnelSocket(30567): To broadcast an Intent via the notifier to external apps 07-24 23:23:42.159 V/QcrilMsgTunnelSocket(30567): Before reading offset = 0 remaining = 4 countRead = 0 07-24 23:23:42.159 D/QcrilMsgTunnelIfaceManager(30567): handleMessage what=0 07-24 23:23:42.159 D/QcrilMsgTunnelIfaceManager(30567): Broadcasting intent ACTION_UNSOL_RESPONSE_OEM_HOOK_RAW 07-24 23:23:42.159 W/FileUtils(18059): Failed to chmod(/storage/emulated/0/baidu/pushservice/database/pushstat_3.4.db): libcore.io.ErrnoException: chmod failed: EPERM (Operation not permitted) 07-24 23:23:42.189 W/BackupManagerService( 749): dataChanged but no participant pkg='com.android.providers.settings' uid=10059 07-24 23:23:42.209 D/Nat464Xlat( 749): requiresClat: netType=0, hasIPv4Address=true 07-24 23:23:42.219 D/MobileDataStateTracker( 749): default: setPolicyDataEnable(enabled=true) 07-24 23:23:42.249 D/MobileDataStateTracker( 749): default: setPolicyDataEnable(enabled=true) 07-24 23:23:42.279 D/MobileDataStateTracker( 749): default: setPolicyDataEnable(enabled=true) 07-24 23:23:42.289 D/MobileDataStateTracker( 749): default: setPolicyDataEnable(enabled=true) 07-24 23:23:42.549 D/ConnectivityService( 749): handleConnectivityChange: addresses changed linkProperty[1]: resetMask=0 07-24 23:23:42.549 D/ConnectivityService( 749): car=removed=[] added=[fe80::c643:8fff:fef6:676/64,] 07-24 23:23:42.559 D/Nat464Xlat( 749): requiresClat: netType=1, hasIPv4Address=true 07-24 23:23:42.609 W/ContextImpl(19101): Implicit intents with startService are not safe: Intent { act=com.viber.voip.action.VIBER_SERVICE_BACKGROUND } android.content.ContextWrapper.startService:494 com.viber.voip.e.s.a:273 com.viber.voip.e.s.onServiceStateChanged:237 07-24 23:23:43.729 D/CaptivePortalTracker( 749): NoActiveNetworkState{ when=-1ms what=1 obj=NetworkInfo: type: WIFI[], state: CONNECTED/CONNECTED, reason: (unspecified), extra: "BTHub4-PXNQ", roaming: false, failover: false, isAvailable: true, isConnectedToProvisioningNetwork: false target=com.android.internal.util.StateMachine$SmHandler } 07-24 23:23:43.739 D/Tethering( 749): MasterInitialState.processMessage what=3 07-24 23:23:43.759 I/ProxyService(22601): Action: android.net.conn.CONNECTIVITY_CHANGE 07-24 23:23:43.769 I/ProxyService(22601): Network Type: WIFI, subtype: , available: true 07-24 23:23:43.769 W/ActivityManager( 749): Permission Denial: not allowed to send broadcast android.net.wifi.LINK_CONFIGURATION_CHANGED from pid=22601, uid=10091 07-24 23:23:43.789 D/MobileConnectivityChangeReceiver(17578): onReceive Intent { act=android.net.conn.CONNECTIVITY_CHANGE flg=0x4000010 cmp=com.google.android.setupwizard/.MobileConnectivityChangeReceiver (has extras) } 07-24 23:23:43.789 D/MobileConnectivityChangeReceiver(17578): onReceive CONNECTIVITY_CHANGE networkType=1 07-24 23:23:43.819 D/GCM ( 1124): GcmService start Intent { act=android.net.conn.CONNECTIVITY_CHANGE flg=0x4000010 cmp=com.google.android.gms/.gcm.GcmService (has extras) } android.net.conn.CONNECTIVITY_CHANGE 07-24 23:23:43.849 D/dalvikvm( 8746): GC_CONCURRENT freed 326K, 9% free 17496K/19032K, paused 3ms+1ms, total 19ms 07-24 23:23:43.879 I/PushServiceReceiver(18059): start PushSerevice for ACTION_BOOT_COMPLETED or CONNECTIVITY_ACTION 07-24 23:23:43.889 D/DownloadQueueService(17691): service created : co.uk.mediaat.downloader.queue.DownloadQueueService@42657bf8 07-24 23:23:43.889 D/DownloadQueue(17691): BBCDownloadAgent: querying downloads: queue id: BBCDownloadAgent 07-24 23:23:43.889 D/DownloadQueue(17691): BBCDownloadAgent: received 0 downloads 07-24 23:23:43.899 D/DownloadQueueController(17691): network available: true 07-24 23:23:43.899 D/DownloadQueueController(17691): storage available: true 07-24 23:23:43.899 D/DownloadQueueController(17691): environment valid: true 07-24 23:23:43.899 D/DownloadQueueService(17691): no active queues, stopping service 07-24 23:23:43.899 D/DownloadQueueService(17691): service stopped 07-24 23:23:43.899 D/DownloadQueueService(17691): service destroyed 07-24 23:23:43.909 D/GCM ( 1124): GcmService start Intent { act=com.google.android.checkin.CHECKIN_COMPLETE flg=0x10 cmp=com.google.android.gms/.gcm.GcmService (has extras) } com.google.android.checkin.CHECKIN_COMPLETE 07-24 23:23:43.919 D/dalvikvm(22672): GC_CONCURRENT freed 817K, 5% free 18653K/19504K, paused 1ms+3ms, total 17ms 07-24 23:23:43.969 D/dalvikvm( 3210): GC_CONCURRENT freed 422K, 3% free 17094K/17600K, paused 2ms+3ms, total 16ms 07-24 23:23:43.979 I/goggles ( 3210): k: Checking for images newer than 1406141576633 07-24 23:23:44.009 D/dalvikvm( 8746): GC_CONCURRENT freed 475K, 9% free 17421K/19032K, paused 2ms+1ms, total 14ms 07-24 23:23:44.249 V/PanelView( 861): animationTick called with dtms=0; nothing to do (h=406.0 v=3573.7253) 07-24 23:23:44.249 V/PanelView( 861): animationTick called with dtms=0; nothing to do (h=406.0 v=3573.7253) 07-24 23:23:44.759 V/PanelView( 861): animationTick called with dtms=0; nothing to do (h=1776.0 v=-6000.0) 07-24 23:23:44.789 W/Resources(22601): Converting to string: TypedValue{t=0x10/d=0x2 a=2 r=0x7f0c0001} 07-24 23:23:44.789 W/Resources(22601): Converting to string: TypedValue{t=0x10/d=0x2 a=2 r=0x7f0c0001} 07-24 23:23:44.839 D/dalvikvm(22601): GC_CONCURRENT freed 205K, 2% free 17578K/17816K, paused 1ms+2ms, total 20ms 07-24 23:23:44.839 D/Preferences(22601): Proxy service connected 07-24 23:23:44.899 D/dalvikvm(22601): GC_CONCURRENT freed 535K, 4% free 17449K/18072K, paused 2ms+7ms, total 26ms 07-24 23:23:45.089 D/ConnectivityService( 749): handleInetConditionHoldEnd: net=1, condition=0, published condition=0 07-24 23:23:45.219 D/Tethering( 749): MasterInitialState.processMessage what=3 07-24 23:23:45.219 D/CaptivePortalTracker( 749): DelayedCaptiveCheckState{ when=0 what=1 obj=NetworkInfo: type: mobile[HSPA], state: DISCONNECTED/DISCONNECTED, reason: dataDisabled, extra: everywhere, roaming: false, failover: false, isAvailable: true, isConnectedToProvisioningNetwork: false target=com.android.internal.util.StateMachine$SmHandler } 07-24 23:23:45.229 I/ProxyService(22601): Action: android.net.conn.CONNECTIVITY_CHANGE 07-24 23:23:45.229 I/ProxyService(22601): Network Type: WIFI, subtype: , available: true 07-24 23:23:45.239 D/Tethering( 749): MasterInitialState.processMessage what=3 07-24 23:23:45.239 I/ProxyService(22601): Action: android.net.conn.CONNECTIVITY_CHANGE 07-24 23:23:45.239 D/CaptivePortalTracker( 749): DelayedCaptiveCheckState{ when=-1ms what=1 obj=NetworkInfo: type: WIFI[], state: CONNECTED/CONNECTED, reason: (unspecified), extra: "BTHub4-PXNQ", roaming: false, failover: false, isAvailable: true, isConnectedToProvisioningNetwork: false target=com.android.internal.util.StateMachine$SmHandler } 07-24 23:23:45.239 W/ActivityManager( 749): Permission Denial: not allowed to send broadcast android.net.wifi.LINK_CONFIGURATION_CHANGED from pid=22601, uid=10091 07-24 23:23:45.249 I/ProxyService(22601): Network Type: WIFI, subtype: , available: true 07-24 23:23:45.259 D/MobileConnectivityChangeReceiver(17578): onReceive Intent { act=android.net.conn.CONNECTIVITY_CHANGE flg=0x4000010 cmp=com.google.android.setupwizard/.MobileConnectivityChangeReceiver (has extras) } 07-24 23:23:45.259 D/MobileConnectivityChangeReceiver(17578): onReceive CONNECTIVITY_CHANGE networkType=0 07-24 23:23:45.259 D/MobileConnectivityChangeReceiver(17578): onReceive CONNECTIVITY_CHANGE: not connected|connecting, ignore 07-24 23:23:45.259 W/ActivityManager( 749): Permission Denial: not allowed to send broadcast android.net.wifi.LINK_CONFIGURATION_CHANGED from pid=22601, uid=10091 07-24 23:23:45.289 D/GCM ( 1124): GcmService start Intent { act=android.net.conn.CONNECTIVITY_CHANGE flg=0x4000010 cmp=com.google.android.gms/.gcm.GcmService (has extras) } android.net.conn.CONNECTIVITY_CHANGE 07-24 23:23:45.299 W/BackupManagerService( 749): dataChanged but no participant pkg='com.android.providers.settings' uid=10059 07-24 23:23:45.359 D/dalvikvm( 8746): GC_CONCURRENT freed 259K, 8% free 17586K/19032K, paused 2ms+3ms, total 16ms 07-24 23:23:45.379 D/dalvikvm(18874): GC_FOR_ALLOC freed 2497K, 11% free 25230K/28164K, paused 77ms, total 77ms 07-24 23:23:45.459 I/PushServiceReceiver(18059): start PushSerevice for ACTION_BOOT_COMPLETED or CONNECTIVITY_ACTION 07-24 23:23:45.469 D/dalvikvm( 8746): GC_CONCURRENT freed 499K, 9% free 17496K/19032K, paused 2ms+2ms, total 20ms 07-24 23:23:45.469 D/DownloadQueueService(17691): service created : co.uk.mediaat.downloader.queue.DownloadQueueService@4260b678 07-24 23:23:45.479 D/DownloadQueue(17691): BBCDownloadAgent: querying downloads: queue id: BBCDownloadAgent 07-24 23:23:45.479 D/DownloadQueue(17691): BBCDownloadAgent: received 0 downloads 07-24 23:23:45.479 D/DownloadQueueController(17691): network available: true 07-24 23:23:45.479 D/DownloadQueueController(17691): storage available: true 07-24 23:23:45.479 D/DownloadQueueController(17691): environment valid: true 07-24 23:23:45.479 D/DownloadQueueService(17691): no active queues, stopping service 07-24 23:23:45.479 D/DownloadQueueService(17691): service stopped 07-24 23:23:45.479 D/DownloadQueueService(17691): service destroyed 07-24 23:23:45.489 D/MobileConnectivityChangeReceiver(17578): onReceive Intent { act=android.net.conn.CONNECTIVITY_CHANGE flg=0x4000010 cmp=com.google.android.setupwizard/.MobileConnectivityChangeReceiver (has extras) } 07-24 23:23:45.489 D/MobileConnectivityChangeReceiver(17578): onReceive CONNECTIVITY_CHANGE networkType=1 07-24 23:23:45.499 D/GCM ( 1124): GcmService start Intent { act=android.net.conn.CONNECTIVITY_CHANGE flg=0x4000010 cmp=com.google.android.gms/.gcm.GcmService (has extras) } android.net.conn.CONNECTIVITY_CHANGE 07-24 23:23:45.529 D/dalvikvm( 3210): GC_CONCURRENT freed 452K, 3% free 17114K/17600K, paused 2ms+1ms, total 17ms 07-24 23:23:45.529 I/goggles ( 3210): k: Checking for images newer than 1406141576633 07-24 23:23:45.529 D/GCM ( 1124): Connected 07-24 23:23:45.549 I/PushServiceReceiver(18059): start PushSerevice for ACTION_BOOT_COMPLETED or CONNECTIVITY_ACTION 07-24 23:23:45.559 D/DownloadQueueService(17691): service created : co.uk.mediaat.downloader.queue.DownloadQueueService@426537c0 07-24 23:23:45.559 I/GCM ( 1124): GCM message com.google.android.gsf.gtalkservice 07-24 23:23:45.559 D/DownloadQueue(17691): BBCDownloadAgent: querying downloads: queue id: BBCDownloadAgent 07-24 23:23:45.559 D/DownloadQueue(17691): BBCDownloadAgent: received 0 downloads 07-24 23:23:45.569 D/GCM ( 1124): GcmService start Intent { act=com.google.android.checkin.CHECKIN_COMPLETE flg=0x10 cmp=com.google.android.gms/.gcm.GcmService (has extras) } com.google.android.checkin.CHECKIN_COMPLETE 07-24 23:23:45.569 D/DownloadQueueController(17691): network available: true 07-24 23:23:45.569 D/DownloadQueueController(17691): storage available: true 07-24 23:23:45.569 D/DownloadQueueController(17691): environment valid: true 07-24 23:23:45.569 D/DownloadQueueService(17691): no active queues, stopping service 07-24 23:23:45.569 D/DownloadQueueService(17691): service stopped 07-24 23:23:45.569 D/GCM ( 1124): GcmService start Intent { act=com.google.android.checkin.CHECKIN_COMPLETE flg=0x10 cmp=com.google.android.gms/.gcm.GcmService (has extras) } com.google.android.checkin.CHECKIN_COMPLETE 07-24 23:23:45.569 D/DownloadQueueService(17691): service destroyed 07-24 23:23:45.579 D/GCM ( 1124): Message class mpg 07-24 23:23:45.609 I/goggles ( 3210): k: Checking for images newer than 1406141576633 07-24 23:23:45.619 D/dalvikvm( 3210): GC_CONCURRENT freed 428K, 3% free 17109K/17600K, paused 1ms+2ms, total 15ms 07-24 23:23:45.659 I/socket (18059): msgid:1 07-24 23:23:46.039 D/ConnectivityService( 749): handleInetConditionHoldEnd: net=1, condition=100, published condition=0 07-24 23:23:46.179 D/Preferences(22601): Proxy service disconnected 07-24 23:23:46.189 W/System.err(22601): Server failed to start: java.net.SocketException: Socket closed 07-24 23:23:46.189 W/ProxyService(22601): server stopped 07-24 23:23:46.189 I/ProxyService(22601): Service stopped 07-24 23:23:46.189 W/ActivityManager( 749): Permission Denial: not allowed to send broadcast android.net.wifi.LINK_CONFIGURATION_CHANGED from pid=22601, uid=10091 07-24 23:23:49.519 D/AbstractMetricsFactoryImpl(12411): record : No data points in metrics event 07-24 23:23:49.589 D/ProxyService(22601): PRX: null:null(null) 07-24 23:23:49.609 D/dalvikvm(22601): GC_EXPLICIT freed 228K, 4% free 17529K/18072K, paused 1ms+2ms, total 20ms 07-24 23:23:50.149 W/System.err(22601): java.util.concurrent.TimeoutException 07-24 23:23:50.149 W/System.err(22601): at com.stericson.RootTools.Executer.sendShell(Executer.java:95) 07-24 23:23:50.149 W/System.err(22601): at com.stericson.RootTools.RootTools.sendShell(RootTools.java:1112) 07-24 23:23:50.149 W/System.err(22601): at com.stericson.RootTools.RootTools.sendShell(RootTools.java:1079) 07-24 23:23:50.149 W/System.err(22601): at com.stericson.RootTools.RootTools.sendShell(RootTools.java:1141) 07-24 23:23:50.149 W/System.err(22601): at com.stericson.RootTools.RootTools.isAccessGiven(RootTools.java:762) 07-24 23:23:50.149 W/System.err(22601): at org.adblockplus.android.ProxyService.onCreate(ProxyService.java:169) 07-24 23:23:50.149 W/System.err(22601): at android.app.ActivityThread.handleCreateService(ActivityThread.java:2558) 07-24 23:23:50.149 W/System.err(22601): at android.app.ActivityThread.access$1800(ActivityThread.java:135) 07-24 23:23:50.149 W/System.err(22601): at android.app.ActivityThread$H.handleMessage(ActivityThread.java:1278) 07-24 23:23:50.149 W/System.err(22601): at android.os.Handler.dispatchMessage(Handler.java:102) 07-24 23:23:50.149 W/System.err(22601): at android.os.Looper.loop(Looper.java:136) 07-24 23:23:50.149 W/System.err(22601): at android.app.ActivityThread.main(ActivityThread.java:5001) 07-24 23:23:50.149 W/System.err(22601): at java.lang.reflect.Method.invokeNative(Native Method) 07-24 23:23:50.149 W/System.err(22601): at java.lang.reflect.Method.invoke(Method.java:515) 07-24 23:23:50.149 W/System.err(22601): at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:785) 07-24 23:23:50.149 W/System.err(22601): at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:601) 07-24 23:23:50.149 W/System.err(22601): at dalvik.system.NativeStart.main(Native Method) 07-24 23:23:50.149 W/ActivityManager( 749): Permission Denial: not allowed to send broadcast android.net.wifi.LINK_CONFIGURATION_CHANGED from pid=22601, uid=10091 07-24 23:23:50.169 I/ProxyService(22601): Broadcasting org.adblockplus.android.service.state 07-24 23:23:50.169 I/ProxyService(22601): Service started 07-24 23:23:50.169 I/ProxyService(22601): Action: android.net.conn.CONNECTIVITY_CHANGE 07-24 23:23:50.169 I/ProxyService(22601): Network Type: WIFI, subtype: , available: true 07-24 23:23:50.179 V/main. (22601): starting handler: https 07-24 23:23:50.179 V/main. (22601): starting handler: adblock 07-24 23:23:52.549 D/AndroidRuntime(22601): Shutting down VM 07-24 23:23:52.549 W/dalvikvm(22601): threadid=1: thread exiting with uncaught exception (group=0x415a2ba8) 07-24 23:23:52.549 E/DCR (22601): Clearing proxy 07-24 23:23:52.549 W/ActivityManager( 749): Permission Denial: not allowed to send broadcast android.net.wifi.LINK_CONFIGURATION_CHANGED from pid=22601, uid=10091 07-24 23:23:52.549 E/AndroidRuntime(22601): FATAL EXCEPTION: main 07-24 23:23:52.549 E/AndroidRuntime(22601): Process: org.adblockplus.android, PID: 22601 07-24 23:23:52.549 E/AndroidRuntime(22601): java.lang.IllegalStateException: Could not execute method of the activity 07-24 23:23:52.549 E/AndroidRuntime(22601): at android.view.View$1.onClick(View.java:3823) 07-24 23:23:52.549 E/AndroidRuntime(22601): at android.view.View.performClick(View.java:4438) 07-24 23:23:52.549 E/AndroidRuntime(22601): at android.view.View$PerformClick.run(View.java:18422) 07-24 23:23:52.549 E/AndroidRuntime(22601): at android.os.Handler.handleCallback(Handler.java:733) 07-24 23:23:52.549 E/AndroidRuntime(22601): at android.os.Handler.dispatchMessage(Handler.java:95) 07-24 23:23:52.549 E/AndroidRuntime(22601): at android.os.Looper.loop(Looper.java:136) 07-24 23:23:52.549 E/AndroidRuntime(22601): at android.app.ActivityThread.main(ActivityThread.java:5001) 07-24 23:23:52.549 E/AndroidRuntime(22601): at java.lang.reflect.Method.invokeNative(Native Method) 07-24 23:23:52.549 E/AndroidRuntime(22601): at java.lang.reflect.Method.invoke(Method.java:515) 07-24 23:23:52.549 E/AndroidRuntime(22601): at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:785) 07-24 23:23:52.549 E/AndroidRuntime(22601): at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:601) 07-24 23:23:52.549 E/AndroidRuntime(22601): at dalvik.system.NativeStart.main(Native Method) 07-24 23:23:52.549 E/AndroidRuntime(22601): Caused by: java.lang.reflect.InvocationTargetException 07-24 23:23:52.549 E/AndroidRuntime(22601): at java.lang.reflect.Method.invokeNative(Native Method) 07-24 23:23:52.549 E/AndroidRuntime(22601): at java.lang.reflect.Method.invoke(Method.java:515) 07-24 23:23:52.549 E/AndroidRuntime(22601): at android.view.View$1.onClick(View.java:3818) 07-24 23:23:52.549 E/AndroidRuntime(22601): ... 11 more 07-24 23:23:52.549 E/AndroidRuntime(22601): Caused by: java.lang.NullPointerException 07-24 23:23:52.549 E/AndroidRuntime(22601): at org.adblockplus.android.Preferences.showProxySettings(Preferences.java:353) 07-24 23:23:52.549 E/AndroidRuntime(22601): ... 14 more 07-24 23:23:52.559 W/ActivityManager( 749): Force finishing activity org.adblockplus.android/.Preferences 07-24 23:23:52.579 D/dalvikvm(22601): GC_CONCURRENT freed 186K, 2% free 17734K/18064K, paused 1ms+5ms, total 29ms 07-24 23:23:52.659 D/dalvikvm( 749): GC_CONCURRENT freed 5244K, 25% free 41365K/54876K, paused 3ms+6ms, total 92ms 07-24 23:23:53.079 W/ActivityManager( 749): Activity pause timeout for ActivityRecord{432f0990 u0 org.adblockplus.android/.Preferences t83 f} 07-24 23:23:53.299 D/dalvikvm(22672): GC_CONCURRENT freed 615K, 5% free 18620K/19504K, paused 2ms+2ms, total 22ms 07-24 23:23:53.739 D/CaptivePortalTracker( 749): DelayedCaptiveCheckState{ when=-9ms what=2 arg1=19 target=com.android.internal.util.StateMachine$SmHandler } 07-24 23:23:53.749 D/CaptivePortalTracker( 749): Checking http://173.194.41.142/generate_204 07-24 23:23:53.749 D/ConnectivityService( 749): setProvNotificationVisible: E visible=false networkType=1 extraInfo=null url=null 07-24 23:23:53.989 D/CaptivePortalTracker( 749): isCaptivePortal: ret=false rspCode=204 07-24 23:23:53.989 D/CaptivePortalTracker( 749): Not captive network NetworkInfo: type: WIFI[], state: CONNECTED/CONNECTED, reason: (unspecified), extra: "BTHub4-PXNQ", roaming: false, failover: false, isAvailable: true, isConnectedToProvisioningNetwork: false 07-24 23:23:53.989 D/CaptivePortalTracker( 749): notifyPortalCheckCompleted: captive=false ni=NetworkInfo: type: WIFI[], state: CONNECTED/CONNECTED, reason: (unspecified), extra: "BTHub4-PXNQ", roaming: false, failover: false, isAvailable: true, isConnectedToProvisioningNetwork: false 07-24 23:23:53.989 W/ContextImpl( 749): Calling a method in the system process without a qualified user: android.app.ContextImpl.sendBroadcast:1145 android.net.CaptivePortalTracker.sendNetworkConditionsBroadcast:507 android.net.CaptivePortalTracker.isCaptivePortal:399 android.net.CaptivePortalTracker.access$2600:60 android.net.CaptivePortalTracker$DelayedCaptiveCheckState.processMessage:283 07-24 23:23:53.989 D/ConnectivityService( 749): captivePortalCheckCompleted: ni=NetworkInfo: type: WIFI[], state: CONNECTED/CONNECTED, reason: (unspecified), extra: "BTHub4-PXNQ", roaming: false, failover: false, isAvailable: true, isConnectedToProvisioningNetwork: false captive=false