Ticket #1213: 3496_1406241792_Android_Runtime_Log.txt

--------- 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): <qeglDrvAPI_eglInitialize:320>: EGL 1.4 QUALCOMM Build: I0404c4692afb8623f95c43aeb6d5e13ed4b30ddbDate: 11/06/13
07-24 23:22:49.139 I/Adreno-EGL(17901): <qeglDrvAPI_eglInitialize:320>: 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: <unknown ssid>, 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.<init>(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.<init>(SourceFile:99)
07-24 23:22:51.089 E/ActivityThread(  991):     at gaz.<init>(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.<init>(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): <qeglDrvAPI_eglInitialize:320>: 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): <qeglDrvAPI_eglInitialize:320>: 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): <qeglDrvAPI_eglInitialize:320>: 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.<init>: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.<init>: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.<init>: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.<init>:157 com.android.settings.bluetooth.PbapServerProfile.<init>: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