02-24 21:45:04.110 V/PhoneStatusBar(10097): setLightsOn(true) 02-24 21:45:04.126 V/PhoneStatusBar(10097): setLightsOn(true) 02-24 21:45:04.165 V/PhoneStatusBar(10097): setLightsOn(true) 02-24 21:45:04.181 V/PhoneStatusBar(10097): setLightsOn(true) 02-24 21:45:04.468 V/PhoneStatusBar(10097): setLightsOn(true) 02-24 21:45:05.184 D/ZWSleepReceiver(14659): Received: org.zooper.zw.action.UPDATEALL 02-24 21:45:05.221 V/ZWUpdateService(14659): Update not necessary 02-24 21:45:05.447 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:05.483 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:05.491 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:05.497 W/System.err(20195): javax.net.ssl.SSLPeerUnverifiedException: Hostname api.iterable.com not verified: 02-24 21:45:05.497 W/System.err(20195): certificate: sha1/LbxV7EzqJmu+j6fCYa5dhI8pByc= 02-24 21:45:05.498 W/System.err(20195): DN: CN=*.paynode.com,OU=Domain Control Validated 02-24 21:45:05.498 W/System.err(20195): subjectAltNames: [*.paynode.com, paynode.com] 02-24 21:45:05.499 W/System.err(20195): at com.android.okhttp.Connection.connectTls(Connection.java:241) 02-24 21:45:05.499 W/System.err(20195): at com.android.okhttp.Connection.connectSocket(Connection.java:199) 02-24 21:45:05.499 W/System.err(20195): at com.android.okhttp.Connection.connect(Connection.java:172) 02-24 21:45:05.499 W/System.err(20195): at com.android.okhttp.Connection.connectAndSetOwner(Connection.java:367) 02-24 21:45:05.499 W/System.err(20195): at com.android.okhttp.OkHttpClient$1.connectAndSetOwner(OkHttpClient.java:130) 02-24 21:45:05.499 W/System.err(20195): at com.android.okhttp.internal.http.HttpEngine.connect(HttpEngine.java:330) 02-24 21:45:05.499 W/System.err(20195): at com.android.okhttp.internal.http.HttpEngine.sendRequest(HttpEngine.java:247) 02-24 21:45:05.499 W/System.err(20195): at com.android.okhttp.internal.huc.HttpURLConnectionImpl.execute(HttpURLConnectionImpl.java:457) 02-24 21:45:05.499 W/System.err(20195): at com.android.okhttp.internal.huc.HttpURLConnectionImpl.connect(HttpURLConnectionImpl.java:126) 02-24 21:45:05.499 W/System.err(20195): at com.android.okhttp.internal.huc.HttpURLConnectionImpl.getOutputStream(HttpURLConnectionImpl.java:257) 02-24 21:45:05.499 W/System.err(20195): at com.android.okhttp.internal.huc.DelegatingHttpsURLConnection.getOutputStream(DelegatingHttpsURLConnection.java:218) 02-24 21:45:05.499 W/System.err(20195): at com.android.okhttp.internal.huc.HttpsURLConnectionImpl.getOutputStream(HttpsURLConnectionImpl.java) 02-24 21:45:05.499 W/System.err(20195): at dvw.a(SourceFile:104) 02-24 21:45:05.499 W/System.err(20195): at dvw.doInBackground(SourceFile:24) 02-24 21:45:05.499 W/System.err(20195): at android.os.AsyncTask$2.call(AsyncTask.java:305) 02-24 21:45:05.500 W/System.err(20195): at java.util.concurrent.FutureTask.run(FutureTask.java:237) 02-24 21:45:05.500 W/System.err(20195): at android.os.AsyncTask$SerialExecutor$1.run(AsyncTask.java:243) 02-24 21:45:05.500 W/System.err(20195): at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1133) 02-24 21:45:05.500 W/System.err(20195): at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:607) 02-24 21:45:05.500 W/System.err(20195): at java.lang.Thread.run(Thread.java:761) 02-24 21:45:05.512 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:05.525 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:05.543 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:05.559 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:05.562 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:05.564 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:05.580 I/ActivityManager(9816): START u0 {flg=0x10804000 cmp=com.android.systemui/.recents.RecentsActivity} from uid 10029 on display 0 02-24 21:45:05.652 V/PhoneStatusBar(10097): setLightsOn(true) 02-24 21:45:05.803 I/art (9816): Background partial concurrent mark sweep GC freed 7711(348KB) AllocSpace objects, 1(32KB) LOS objects, 33% free, 27MB/40MB, paused 2.083ms total 175.602ms 02-24 21:45:07.543 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:07.571 W/WindowManager(9816): Attempted to remove non-existing token: android.os.Binder@9b5cc42 02-24 21:45:07.665 D/sensors_hal_Ctx(9816): poll:polldata:1, sensor:0, type:1, x:-0.316193 y:5.061325 z:8.152817 02-24 21:45:07.708 V/sensors_hal_Light(9816): processReportInd: e0000 14.000000 02-24 21:45:07.726 D/sensors_hal_Ctx(9816): poll:polldata:1, sensor:0, type:1, x:-0.165451 y:4.998459 z:8.343643 02-24 21:45:07.784 D/sensors_hal_Ctx(9816): poll:polldata:1, sensor:0, type:1, x:0.412323 y:4.470291 z:9.219055 02-24 21:45:07.794 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:07.795 V/sensors_hal_Light(9816): processReportInd: f0000 15.000000 02-24 21:45:07.795 D/sensors_hal_Ctx(9816): poll:polldata:1, sensor:1, type:5, x:15.000000 y:0.000000 z:0.000000 02-24 21:45:08.352 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:08.407 E/ActivityManager(9816): applyOptionsLocked: Unknown animationType=0 02-24 21:45:08.600 D/KeepAlive(20195): cancel() 02-24 21:45:08.600 D/KeepAlive(20195): start(3000) 02-24 21:45:09.335 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:09.437 I/bt_a2dp_hw(9544): out_set_parameters: out_set_parameters: state 5 02-24 21:45:09.438 I/hash_map_utils(9544): key: 'a2dp_sink_address' value: 'CC:90:93:05:E5:0C' 02-24 21:45:09.438 I/hash_map_utils(9544): key: 'routing' value: '128' 02-24 21:45:09.454 I/bt_a2dp_hw(9544): start_audio_datapath: state 5 02-24 21:45:09.454 I/bt_a2dp_hw(9544): start_audio_datapath: state AUDIO_A2DP_STATE_STANDBY 02-24 21:45:09.454 I/bt_a2dp_hw(9544): a2dp_command: A2DP COMMAND A2DP_CTRL_CMD_START 02-24 21:45:09.454 D/bt_btif (7322): A2DP-CTRL-CHANNEL EVENT UIPC_RX_DATA_READY_EVT 02-24 21:45:09.454 D/bt_btif (7322): a2dp-ctrl-cmd : A2DP_CTRL_CMD_START 02-24 21:45:09.454 D/bt_btif (7322): btif_dispatch_sm_event: event: 27, len: 0 02-24 21:45:09.454 D/bt_btif (7322): btif_dispatch_sm_event: event 27 sent 02-24 21:45:09.454 D/bt_btif (7322): a2dp-ctrl-cmd : A2DP_CTRL_CMD_START DONE 02-24 21:45:09.454 D/bt_btif (7322): btif_av_state_opened_handler event:BTIF_AV_START_STREAM_REQ_EVT flags 0 and index = 0 02-24 21:45:09.454 I/bt_btif_media(7322): btif_a2dp_encoder_init SCMS_T DISABLED 02-24 21:45:09.454 E/bt_btif (7322): bta_av_select_codec hdl = 65 02-24 21:45:09.454 I/bt_btif_media(7322): btif_a2dp_encoder_init Selected Codec SBC 02-24 21:45:09.454 D/bt_btif (7322): btif_media_thread_handle_cmd : 5 BTIF_MEDIA_SBC_ENC_INIT 02-24 21:45:09.455 D/bt_btif (7322): btif_media_thread_handle_cmd: BTIF_MEDIA_SBC_ENC_INIT DONE 02-24 21:45:09.455 D/bt_btif (7322): btif_media_thread_handle_cmd : 11 BTIF_MEDIA_AUDIO_FEEDING_INIT 02-24 21:45:09.455 D/bt_btif (7322): btif_media_thread_handle_cmd: BTIF_MEDIA_AUDIO_FEEDING_INIT DONE 02-24 21:45:09.455 D/bt_btif (7322): AV Sevent(0x41)=0x120b(AP_START) state=3(OPEN) 02-24 21:45:09.455 W/bt_btm (7322): BTM: Local device role : 0x00 02-24 21:45:09.455 W/bt_btm (7322): BTM: RemBdAddr: cc909305e50c 02-24 21:45:09.455 W/bt_btif (7322): bta_dm_rm_cback:1, status:7 02-24 21:45:09.477 V/Avrcp (7322): MediaController metadata changed 02-24 21:45:09.478 V/Avrcp (7322): Metadata updated but no change! 02-24 21:45:09.478 V/Avrcp (7322): updatePlayPauseState, state: PlaybackState {state=3, position=106678, buffered position=0, speed=1.0, updated=1253142104, actions=560, custom actions=[], active item id=-1, error=null} device: null 02-24 21:45:09.480 V/Avrcp (7322): Device: musicbox XS E50C : old state: PlaybackState {state=2, position=-1, buffered position=0, speed=0.0, updated=1253108128, actions=0, custom actions=[], active item id=-1, error=null} 02-24 21:45:09.480 V/Avrcp (7322): isPlayStateTobeUpdated: device: CC:90:93:05:E5:0C 02-24 21:45:09.480 V/Avrcp (7322): maxAvrcpConnections: 1 02-24 21:45:09.480 I/Avrcp (7322): updatePlayStatusForDevice: device: CC:90:93:05:E5:0C 02-24 21:45:09.480 D/bt_btif (7322): ## register_notification_rsp ## event_id:AVRC_EVT_PLAY_STATUS_CHANGE 02-24 21:45:09.480 I/Avrcp (7322): device found at index 0 02-24 21:45:09.480 D/bt_btif (7322): LCB lcb=1 event=2 state=2 02-24 21:45:09.480 D/bt_btif (7322): ## register_notification_rsp ## event_id:AVRC_EVT_PLAY_POS_CHANGED 02-24 21:45:09.480 D/Avrcp (7322): Exit onMetadataChanged() 02-24 21:45:09.480 D/bt_btif (7322): LCB lcb=1 event=2 state=2 02-24 21:45:09.480 V/Avrcp (7322): MediaController playback changed: PlaybackState {state=3, position=106665, buffered position=0, speed=1.0, updated=1253142091, actions=560, custom actions=[], active item id=-1, error=null} 02-24 21:45:09.480 V/Avrcp (7322): updatePlayPauseState, state: PlaybackState {state=3, position=106665, buffered position=0, speed=1.0, updated=1253142091, actions=560, custom actions=[], active item id=-1, error=null} device: null 02-24 21:45:09.483 V/Avrcp (7322): Device: musicbox XS E50C : old state: PlaybackState {state=3, position=106678, buffered position=0, speed=1.0, updated=1253142104, actions=560, custom actions=[], active item id=-1, error=null} 02-24 21:45:09.483 V/Avrcp (7322): isPlayStateTobeUpdated: device: CC:90:93:05:E5:0C 02-24 21:45:09.483 V/Avrcp (7322): maxAvrcpConnections: 1 02-24 21:45:09.483 I/Avrcp (7322): updatePlayStatusForDevice: device: CC:90:93:05:E5:0C 02-24 21:45:09.483 D/Avrcp (7322): Exit onPlaybackStateChanged() 02-24 21:45:09.483 V/Avrcp (7322): Active sessions changed, 1 sessions 02-24 21:45:09.483 V/Avrcp (7322): Updating media controller to android.media.session.MediaController@cd1f8d9 02-24 21:45:09.484 V/Avrcp (7322): Metadata updated but no change! 02-24 21:45:09.485 V/Avrcp (7322): updatePlayPauseState, state: PlaybackState {state=3, position=106684, buffered position=0, speed=1.0, updated=1253142110, actions=560, custom actions=[], active item id=-1, error=null} device: null 02-24 21:45:09.486 V/Avrcp (7322): Device: musicbox XS E50C : old state: PlaybackState {state=3, position=106665, buffered position=0, speed=1.0, updated=1253142091, actions=560, custom actions=[], active item id=-1, error=null} 02-24 21:45:09.486 V/Avrcp (7322): isPlayStateTobeUpdated: device: CC:90:93:05:E5:0C 02-24 21:45:09.486 V/Avrcp (7322): maxAvrcpConnections: 1 02-24 21:45:09.486 I/Avrcp (7322): updatePlayStatusForDevice: device: CC:90:93:05:E5:0C 02-24 21:45:09.487 V/Avrcp (7322): Focus gained for player: com.spotify.music 02-24 21:45:09.487 D/Avrcp (7322): Exit updateCurrentMediaController() 02-24 21:45:09.487 D/Avrcp (7322): Exit onActiveSessionsChanged() 02-24 21:45:09.487 V/Avrcp (7322): MSG_UPDATE_RCC_CHANGE 02-24 21:45:09.487 V/Avrcp (7322): processRCCStateChange: com.spotify.music 02-24 21:45:09.487 V/Avrcp (7322): updateAddressedMediaPlayer 02-24 21:45:09.487 V/Avrcp (7322): current Player: 0 02-24 21:45:09.487 V/Avrcp (7322): Requested Player: 0 02-24 21:45:09.579 W/art (11200): Suspending all threads took: 6.764ms 02-24 21:45:09.583 I/art (11200): Background partial concurrent mark sweep GC freed 341(14KB) AllocSpace objects, 0(0B) LOS objects, 41% free, 5MB/9MB, paused 7.004ms total 13.972ms 02-24 21:45:09.654 W/art (21795): Long monitor contention with owner AsyncTask #2 (21942) at boolean android.os.MessageQueue.enqueueMessage(android.os.Message, long)(MessageQueue.java:541) waiters=0 in android.os.Message android.os.MessageQueue.next() for 116ms 02-24 21:45:09.728 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:09.728 E/Thermal-Lib(3427): Thermal-Lib-Client: Unable to create pthread to send client request from override 02-24 21:45:09.757 D/bt_btif (7322): AV Sevent(0x41)=0x121c(STR_START_OK) state=3(OPEN) 02-24 21:45:09.757 W/bt_btm (7322): BTM: Local device role : 0x00 02-24 21:45:09.757 W/bt_btm (7322): BTM: RemBdAddr: cc909305e50c 02-24 21:45:09.757 I/%s hndl:x%x role:%d conn_audio:x%x bits:%d features:x%x(7322): bta_av_link_role_ok 02-24 21:45:09.757 W/bt_btif (7322): bta_dm_rm_cback:1, status:0 02-24 21:45:09.757 W/bt_l2cap(7322): L2CA_SetDesireRole() new:x0, disallow_switch:0 02-24 21:45:09.757 W/bt_btif (7322): bta_dm_pm_ssr conn_srvc id:18, app_id:0 02-24 21:45:09.757 W/bt_btif (7322): bta_dm_pm_ssr ssr:2, lat:1200 02-24 21:45:09.758 W/bt_btif (7322): bta_dm_rm_cback:1, status:7 02-24 21:45:09.758 W/bt_btm (7322): BTM: Local device role : 0x00 02-24 21:45:09.758 W/bt_btm (7322): BTM: RemBdAddr: cc909305e50c 02-24 21:45:09.758 D/bt_btif (7322): btif_av_state_opened_handler event:BTA_AV_START_EVT flags 4 and index = 0 02-24 21:45:09.758 D/bt_btif (7322): ## ON A2DP STARTED ## 02-24 21:45:09.758 D/bt_btif (7322): ## a2dp ack : A2DP_CTRL_CMD_START, status 0 ## 02-24 21:45:09.758 D/bt_btif (7322): btif_av_state_opened_handler event:BTIF_SM_EXIT_EVT flags 0 and index = 0 02-24 21:45:09.758 D/bt_btif (7322): btif_av_state_started_handler event:BTIF_SM_ENTER_EVT flags 0 index =0 02-24 21:45:09.758 I/bt_a2dp_hw(9544): a2dp_command: A2DP COMMAND A2DP_CTRL_CMD_START DONE STATUS 0 02-24 21:45:09.758 I/BluetoothA2dpServiceJni(7322): bta2dp_audio_state_callback 02-24 21:45:09.758 I/bt_a2dp_hw(9544): skt_connect: connect to /data/misc/bluedroid/.a2dp_data (sz 14336) 02-24 21:45:09.758 D/A2dpStateMachine(7322): Enter onAudioStateChanged() 02-24 21:45:09.758 I/bt_a2dp_hw(9544): skt_connect: connected to stack fd = 22 02-24 21:45:09.758 D/bt_btif (7322): btif_dispatch_sm_event: event: 34, len: 0 02-24 21:45:09.758 D/bt_btif (7322): btif_dispatch_sm_event: event 34 sent 02-24 21:45:09.759 D/A2dpStateMachine(7322): Exit onAudioStateChanged() 02-24 21:45:09.759 D/bt_btif (7322): btif_av_state_started_handler event:BTIF_AV_UPDATE_ENCODER_REQ_EVT flags 0 index =0 02-24 21:45:09.759 D/bt_btif (7322): btif_media_thread_handle_cmd : 1 BTIF_MEDIA_START_AA_TX 02-24 21:45:09.759 D/bt_btif (7322): btif_media_task_aa_start_tx media_alarm not running, feeding mode 0 02-24 21:45:09.759 W/bt_btif (7322): pcm bytes per tick 7056 02-24 21:45:09.760 D/A2dpStateMachine(7322): Connected process message: 101, size: 1 02-24 21:45:09.760 D/A2dpStateMachine(7322): Enter Connected processAudioStateEvent() 02-24 21:45:09.760 D/A2dpStateMachine(7322): connectedState: processAudioStateEvent state: 2 device CC:90:93:05:E5:0C 02-24 21:45:09.760 D/A2dpStateMachine(7322): mPlayingA2dpDevice size is 0 02-24 21:45:09.760 D/A2dpStateMachine(7322): mConnectedDevicesList size is true 02-24 21:45:09.760 D/bt_btif (7322): btif_media_thread_handle_cmd: BTIF_MEDIA_START_AA_TX DONE 02-24 21:45:09.760 D/bt_btif (7322): btif_media_thread_handle_cmd : 6 BTIF_MEDIA_SBC_ENC_UPDATE 02-24 21:45:09.760 D/bt_btif (7322): btif_media_thread_handle_cmd: BTIF_MEDIA_SBC_ENC_UPDATE DONE 02-24 21:45:09.760 D/A2dpStateMachine(7322): Enter broadcastAudioState() 02-24 21:45:09.760 V/Avrcp (7322): event for device address CC:90:93:05:E5:0C 02-24 21:45:09.760 I/Avrcp (7322): device found at index 0 02-24 21:45:09.760 V/Avrcp (7322): updateA2dpAudioState 02-24 21:45:09.762 D/A2dpStateMachine(7322): A2DP Playing state : device: CC:90:93:05:E5:0C State:11->10 02-24 21:45:09.762 D/A2dpStateMachine(7322): Exit broadcastAudioState() 02-24 21:45:09.762 D/A2dpStateMachine(7322): Exit Connected processAudioStateEvent() 02-24 21:45:09.762 D/A2dpStateMachine(7322): Exit Connected processMessage() 02-24 21:45:09.762 V/HeadsetService(7322): HeadsetService - Received BluetoothA2dp Play State changed 02-24 21:45:09.774 I/art (9816): Background partial concurrent mark sweep GC freed 10701(578KB) AllocSpace objects, 1(20KB) LOS objects, 33% free, 27MB/40MB, paused 1.321ms total 236.846ms 02-24 21:45:09.779 W/AudioFlinger(9544): write blocked for 325 msecs, 2 delayed writes, thread 0xb4d83780 02-24 21:45:09.779 E/bt_btif (7322): [media task tx timer] ts 1253142408128, diff : 34287168, queue sz 0 02-24 21:45:09.788 D/bt_btif (7322): LCB lcb=1 event=6 state=2 02-24 21:45:09.788 D/bt_btif (7322): bta_av_rc_msg_cback handle: 0 opcode=0x0 02-24 21:45:09.788 D/bt_btif (7322): btif_av_state_started_handler event:BTA_AV_META_MSG_EVT flags 0 index =0 02-24 21:45:09.788 D/bt_btif (7322): btif_rc_handler event:BTA_AV_META_MSG_EVT 02-24 21:45:09.788 D/bt_btif (7322): AVRC_ParsCommand() return status:0x4 02-24 21:45:09.788 D/bt_btif (7322): btif_rc_upstreams_evt pdu: AVRC_PDU_REGISTER_NOTIFICATION handle: 0x0 ctype:3 label:d 02-24 21:45:09.791 I/Avrcp (7322): device found at index 0 02-24 21:45:09.791 V/Avrcp (7322): processRegisterNotification: eventId1 02-24 21:45:09.791 D/bt_btif (7322): ## register_notification_rsp ## event_id:AVRC_EVT_PLAY_STATUS_CHANGE 02-24 21:45:09.792 D/bt_btif (7322): LCB lcb=1 event=2 state=2 02-24 21:45:09.824 D/bt_btif (7322): LCB lcb=1 event=6 state=2 02-24 21:45:09.824 D/bt_btif (7322): bta_av_rc_msg_cback handle: 0 opcode=0x0 02-24 21:45:09.824 D/bt_btif (7322): btif_av_state_started_handler event:BTA_AV_META_MSG_EVT flags 0 index =0 02-24 21:45:09.824 D/bt_btif (7322): btif_rc_handler event:BTA_AV_META_MSG_EVT 02-24 21:45:09.824 D/bt_btif (7322): AVRC_ParsCommand() return status:0x4 02-24 21:45:09.824 D/bt_btif (7322): btif_rc_upstreams_evt pdu: AVRC_PDU_REGISTER_NOTIFICATION handle: 0x0 ctype:3 label:e 02-24 21:45:09.825 I/Avrcp (7322): device found at index 0 02-24 21:45:09.825 V/Avrcp (7322): processRegisterNotification: eventId5 02-24 21:45:09.825 I/Avrcp (7322): device found at index 0 02-24 21:45:09.825 D/bt_btif (7322): ## register_notification_rsp ## event_id:AVRC_EVT_PLAY_POS_CHANGED 02-24 21:45:09.825 D/bt_btif (7322): LCB lcb=1 event=2 state=2 02-24 21:45:10.714 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:10.715 E/Thermal-Lib(3427): Thermal-Lib-Client: Unable to create pthread to send client request from override 02-24 21:45:10.826 V/Avrcp (7322): event for device address CC:90:93:05:E5:0C 02-24 21:45:10.826 I/Avrcp (7322): device found at index 0 02-24 21:45:10.826 I/Avrcp (7322): device found at index 0 02-24 21:45:10.826 D/bt_btif (7322): ## register_notification_rsp ## event_id:AVRC_EVT_PLAY_POS_CHANGED 02-24 21:45:10.826 D/bt_btif (7322): LCB lcb=1 event=2 state=2 02-24 21:45:10.849 D/bt_btif (7322): LCB lcb=1 event=6 state=2 02-24 21:45:10.849 D/bt_btif (7322): bta_av_rc_msg_cback handle: 0 opcode=0x0 02-24 21:45:10.849 D/bt_btif (7322): btif_av_state_started_handler event:BTA_AV_META_MSG_EVT flags 0 index =0 02-24 21:45:10.849 D/bt_btif (7322): btif_rc_handler event:BTA_AV_META_MSG_EVT 02-24 21:45:10.849 D/bt_btif (7322): AVRC_ParsCommand() return status:0x4 02-24 21:45:10.849 D/bt_btif (7322): btif_rc_upstreams_evt pdu: AVRC_PDU_REGISTER_NOTIFICATION handle: 0x0 ctype:3 label:f 02-24 21:45:10.850 I/Avrcp (7322): device found at index 0 02-24 21:45:10.850 V/Avrcp (7322): processRegisterNotification: eventId5 02-24 21:45:10.850 I/Avrcp (7322): device found at index 0 02-24 21:45:10.850 D/bt_btif (7322): ## register_notification_rsp ## event_id:AVRC_EVT_PLAY_POS_CHANGED 02-24 21:45:10.850 D/bt_btif (7322): LCB lcb=1 event=2 state=2 02-24 21:45:11.600 D/KeepAlive(20195): run() 02-24 21:45:11.600 D/KeepAlive(20195): processKeepAlive(false) timeSinceLastTransmission=1487968972601 currentTimeout=86400000 02-24 21:45:11.772 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:11.816 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:11.831 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:11.852 V/Avrcp (7322): event for device address CC:90:93:05:E5:0C 02-24 21:45:11.852 I/Avrcp (7322): device found at index 0 02-24 21:45:11.852 I/Avrcp (7322): device found at index 0 02-24 21:45:11.852 D/bt_btif (7322): ## register_notification_rsp ## event_id:AVRC_EVT_PLAY_POS_CHANGED 02-24 21:45:11.852 D/bt_btif (7322): LCB lcb=1 event=2 state=2 02-24 21:45:11.852 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:11.859 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:11.863 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:11.869 D/bt_btif (7322): LCB lcb=1 event=6 state=2 02-24 21:45:11.869 D/bt_btif (7322): bta_av_rc_msg_cback handle: 0 opcode=0x0 02-24 21:45:11.869 D/bt_btif (7322): btif_av_state_started_handler event:BTA_AV_META_MSG_EVT flags 0 index =0 02-24 21:45:11.869 D/bt_btif (7322): btif_rc_handler event:BTA_AV_META_MSG_EVT 02-24 21:45:11.869 D/bt_btif (7322): AVRC_ParsCommand() return status:0x4 02-24 21:45:11.869 D/bt_btif (7322): btif_rc_upstreams_evt pdu: AVRC_PDU_REGISTER_NOTIFICATION handle: 0x0 ctype:3 label:1 02-24 21:45:11.870 I/Avrcp (7322): device found at index 0 02-24 21:45:11.870 V/Avrcp (7322): processRegisterNotification: eventId5 02-24 21:45:11.870 I/Avrcp (7322): device found at index 0 02-24 21:45:11.870 D/bt_btif (7322): ## register_notification_rsp ## event_id:AVRC_EVT_PLAY_POS_CHANGED 02-24 21:45:11.870 D/bt_btif (7322): LCB lcb=1 event=2 state=2 02-24 21:45:11.887 I/ActivityManager(9816): START u0 {flg=0x10804000 cmp=com.android.systemui/.recents.RecentsActivity} from uid 10029 on display 0 02-24 21:45:12.102 I/art (9816): Background partial concurrent mark sweep GC freed 5356(271KB) AllocSpace objects, 1(20KB) LOS objects, 33% free, 27MB/40MB, paused 1.243ms total 147.988ms 02-24 21:45:12.853 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:12.872 V/Avrcp (7322): event for device address CC:90:93:05:E5:0C 02-24 21:45:12.875 I/Avrcp (7322): device found at index 0 02-24 21:45:12.875 I/Avrcp (7322): device found at index 0 02-24 21:45:12.875 D/bt_btif (7322): ## register_notification_rsp ## event_id:AVRC_EVT_PLAY_POS_CHANGED 02-24 21:45:12.879 D/bt_btif (7322): LCB lcb=1 event=2 state=2 02-24 21:45:12.889 D/bt_btif (7322): LCB lcb=1 event=6 state=2 02-24 21:45:12.889 D/bt_btif (7322): bta_av_rc_msg_cback handle: 0 opcode=0x0 02-24 21:45:12.889 D/bt_btif (7322): btif_av_state_started_handler event:BTA_AV_META_MSG_EVT flags 0 index =0 02-24 21:45:12.889 D/bt_btif (7322): btif_rc_handler event:BTA_AV_META_MSG_EVT 02-24 21:45:12.889 D/bt_btif (7322): AVRC_ParsCommand() return status:0x4 02-24 21:45:12.889 D/bt_btif (7322): btif_rc_upstreams_evt pdu: AVRC_PDU_REGISTER_NOTIFICATION handle: 0x0 ctype:3 label:2 02-24 21:45:12.890 I/Avrcp (7322): device found at index 0 02-24 21:45:12.891 V/Avrcp (7322): processRegisterNotification: eventId5 02-24 21:45:12.891 I/Avrcp (7322): device found at index 0 02-24 21:45:12.893 D/bt_btif (7322): ## register_notification_rsp ## event_id:AVRC_EVT_PLAY_POS_CHANGED 02-24 21:45:12.894 D/bt_btif (7322): LCB lcb=1 event=2 state=2 02-24 21:45:13.107 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:13.435 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:13.522 E/ActivityManager(9816): applyOptionsLocked: Unknown animationType=0 02-24 21:45:13.550 I/MediaFocusControl(9816): AudioFocus requestAudioFocus() from uid/pid 10164/17805 clientId=android.media.AudioManager@3441355 req=2 flags=0x0 02-24 21:45:13.551 D/AudioManager(20195): AudioManager dispatching onAudioFocusChange(-2) for android.media.AudioManager@9a3c97bfzb$2@2427398 02-24 21:45:13.569 I/MediaFocusControl(9816): AudioFocus requestAudioFocus() from uid/pid 10164/17805 clientId=android.media.AudioManager@3441355 req=1 flags=0x0 02-24 21:45:13.569 D/AudioManager(20195): AudioManager dispatching onAudioFocusChange(-1) for android.media.AudioManager@9a3c97bfzb$2@2427398 02-24 21:45:13.573 E/MediaPlayer-JNI(17805): JNIMediaPlayerFactory: bIsQCMediaPlayerPresent 0 02-24 21:45:13.573 E/MediaPlayer-JNI(17805): JNIMediaPlayerFactory: bIsQCMediaPlayerPresent 0 02-24 21:45:13.598 D/NuPlayer(9545): onSetVideoSurface(0xacfb0000, no video decoder) 02-24 21:45:13.603 V/Avrcp (7322): MediaController metadata changed 02-24 21:45:13.603 V/Avrcp (7322): Metadata updated but no change! 02-24 21:45:13.603 V/Avrcp (7322): updatePlayPauseState, state: PlaybackState {state=3, position=110803, buffered position=0, speed=1.0, updated=1253146229, actions=560, custom actions=[], active item id=-1, error=null} device: null 02-24 21:45:13.605 V/Avrcp (7322): Device: musicbox XS E50C : old state: PlaybackState {state=3, position=106684, buffered position=0, speed=1.0, updated=1253142110, actions=560, custom actions=[], active item id=-1, error=null} 02-24 21:45:13.605 V/Avrcp (7322): isPlayStateTobeUpdated: device: CC:90:93:05:E5:0C 02-24 21:45:13.605 V/Avrcp (7322): maxAvrcpConnections: 1 02-24 21:45:13.605 I/Avrcp (7322): updatePlayStatusForDevice: device: CC:90:93:05:E5:0C 02-24 21:45:13.605 I/Avrcp (7322): device found at index 0 02-24 21:45:13.605 D/Avrcp (7322): Exit onMetadataChanged() 02-24 21:45:13.605 V/Avrcp (7322): MediaController playback changed: PlaybackState {state=2, position=109639, buffered position=0, speed=1.0, updated=1253146229, actions=560, custom actions=[], active item id=-1, error=null} 02-24 21:45:13.605 V/Avrcp (7322): updatePlayPauseState, state: PlaybackState {state=2, position=109639, buffered position=0, speed=1.0, updated=1253146229, actions=560, custom actions=[], active item id=-1, error=null} device: null 02-24 21:45:13.607 V/Avrcp (7322): Device: musicbox XS E50C : old state: PlaybackState {state=3, position=110803, buffered position=0, speed=1.0, updated=1253146229, actions=560, custom actions=[], active item id=-1, error=null} 02-24 21:45:13.607 I/Avrcp (7322): updatePlayStatusForDevice: device: CC:90:93:05:E5:0C 02-24 21:45:13.607 D/bt_btif (7322): ## register_notification_rsp ## event_id:AVRC_EVT_PLAY_STATUS_CHANGE 02-24 21:45:13.607 I/Avrcp (7322): device found at index 0 02-24 21:45:13.607 D/bt_btif (7322): LCB lcb=1 event=2 state=2 02-24 21:45:13.607 D/Avrcp (7322): Exit onPlaybackStateChanged() 02-24 21:45:13.638 D/bt_btif (7322): LCB lcb=1 event=6 state=2 02-24 21:45:13.638 D/bt_btif (7322): bta_av_rc_msg_cback handle: 0 opcode=0x0 02-24 21:45:13.638 D/bt_btif (7322): btif_av_state_started_handler event:BTA_AV_META_MSG_EVT flags 0 index =0 02-24 21:45:13.638 D/bt_btif (7322): btif_rc_handler event:BTA_AV_META_MSG_EVT 02-24 21:45:13.638 D/bt_btif (7322): AVRC_ParsCommand() return status:0x4 02-24 21:45:13.638 D/bt_btif (7322): btif_rc_upstreams_evt pdu: AVRC_PDU_REGISTER_NOTIFICATION handle: 0x0 ctype:3 label:3 02-24 21:45:13.639 I/Avrcp (7322): device found at index 0 02-24 21:45:13.639 V/Avrcp (7322): processRegisterNotification: eventId1 02-24 21:45:13.639 D/bt_btif (7322): ## register_notification_rsp ## event_id:AVRC_EVT_PLAY_STATUS_CHANGE 02-24 21:45:13.639 D/bt_btif (7322): LCB lcb=1 event=2 state=2 02-24 21:45:13.701 I/FFmpegExtractor(359): android-source:0xb5ff8000 02-24 21:45:13.712 D/FFmpegExtractor(359): suppoted codec(h264) by official Stagefright 02-24 21:45:13.712 D/FFmpegExtractor(359): suppoted codec(aac) by official Stagefright 02-24 21:45:13.712 D/FFmpegExtractor(359): ffmpeg detected media content as 'video/mp4' with confidence 0.08 02-24 21:45:13.713 I/SampleTable(359): There are reordered frames present. 02-24 21:45:13.716 D/NuPlayerDriver(9545): notifyListener_l(0xb5daad20), (5, 640, 368), loop setting(0, 0) 02-24 21:45:13.716 D/MediaBufferGroup(359): creating MemoryDealer 02-24 21:45:13.717 D/NuPlayerDriver(9545): notifyListener_l(0xb5daad20), (1, 0, 0), loop setting(0, 0) 02-24 21:45:13.726 I/art (10097): Background partial concurrent mark sweep GC freed 12973(578KB) AllocSpace objects, 2(4MB) LOS objects, 23% free, 52MB/68MB, paused 11.956ms total 139.038ms 02-24 21:45:13.732 D/MediaPlayer(17805): getMetadata 02-24 21:45:13.815 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:13.815 E/Thermal-Lib(3427): Thermal-Lib-Client: Unable to create pthread to send client request from override 02-24 21:45:13.921 D/KeepAlive(20195): stop 02-24 21:45:13.921 D/KeepAlive(20195): cancel() 02-24 21:45:13.921 D/KeepAlive(20195): processKeepAlive(true) timeSinceLastTransmission=1487968972601 currentTimeout=86400000 02-24 21:45:13.932 I/art (9816): Background partial concurrent mark sweep GC freed 5816(294KB) AllocSpace objects, 0(0B) LOS objects, 33% free, 27MB/40MB, paused 2.411ms total 121.404ms 02-24 21:45:14.161 E/ThermalEngine(346): [GPU_MON] 11 percent. Current Sampling Time is 1 sec 02-24 21:45:14.486 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:14.487 E/Thermal-Lib(3427): Thermal-Lib-Client: Unable to create pthread to send client request from override 02-24 21:45:14.961 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:15.033 D/NuPlayerDriver(9545): start(0xb5daad20), state is 4, eos is 0 02-24 21:45:15.033 I/GenericSource(9545): start 02-24 21:45:15.047 W/Utils (9545): track of type 'audio/mp4a-latm' does not publish channel mask, channel count 2 02-24 21:45:15.051 W/Utils (9545): track of type 'audio/mp4a-latm' does not publish channel mask, channel count 2 02-24 21:45:15.053 I/MediaPlayerService(9545): MediaPlayerService::getOMX 02-24 21:45:15.053 I/OMXClient(9545): MuxOMX ctor 02-24 21:45:15.053 I/MediaPlayerService(9545): MediaPlayerService::getOMX 02-24 21:45:15.054 I/OMXMaster(356): makeComponentInstance(OMX.qcom.video.decoder.avc) in mediacodec process 02-24 21:45:15.057 I/OMXClient(9545): MuxOMX ctor 02-24 21:45:15.148 I/OMXMaster(356): makeComponentInstance(OMX.google.aac.decoder) in mediacodec process 02-24 21:45:15.149 I/MediaCodec(9545): [OMX.qcom.video.decoder.avc] setting surface generation to 9774100 02-24 21:45:15.153 I/FFMPEGSoftCodec(9545): Decoder will be in frame by frame mode 02-24 21:45:15.160 E/OMXNodeInstance(356): setConfig(1640a2e:google.aac.decoder, ConfigPriority(0x6f800002)) ERROR: Undefined(0x80001001) 02-24 21:45:15.161 I/ACodec (9545): codec does not support config priority (err -2147483648) 02-24 21:45:15.162 I/MediaCodec(9545): MediaCodec will operate in async mode 02-24 21:45:15.163 I/MediaCodec(9545): MediaCodec will operate in async mode 02-24 21:45:15.171 I/SoftAAC2(356): Reconfiguring decoder: 0->44100 Hz, 0->2 channels 02-24 21:45:15.174 D/SurfaceUtils(9545): set up nativeWindow 0xacfb0008 for 640x368, color 0x7fa30c04, rotation 0, usage 0x42002900 02-24 21:45:15.184 D/AudioTrack(9545): Client defaulted notificationFrames to 11200 for frameCount 22400 02-24 21:45:15.194 I/bt_a2dp_hw(9544): out_set_parameters: out_set_parameters: state 1 02-24 21:45:15.194 I/hash_map_utils(9544): key: 'a2dp_sink_address' value: 'CC:90:93:05:E5:0C' 02-24 21:45:15.194 I/hash_map_utils(9544): key: 'routing' value: '128' 02-24 21:45:15.209 D/SurfaceUtils(9545): set up nativeWindow 0xacfb0008 for 640x368, color 0x7fa30c04, rotation 0, usage 0x42002900 02-24 21:45:15.211 D/NuPlayerDriver(9545): notifyListener_l(0xb5daad20), (6, 0, 0), loop setting(0, 0) 02-24 21:45:15.243 D/NuPlayerDriver(9545): notifyListener_l(0xb5daad20), (5, 640, 368), loop setting(0, 0) 02-24 21:45:15.243 D/NuPlayerDriver(9545): notifyListener_l(0xb5daad20), (200, 3, 0), loop setting(0, 0) 02-24 21:45:15.243 W/MediaPlayer(17805): info/warning (3, 0) 02-24 21:45:19.102 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:19.509 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:19.573 D/NuPlayerDriver(9545): pause(0xb5daad20) 02-24 21:45:19.573 D/NuPlayerDriver(9545): notifyListener_l(0xb5daad20), (7, 0, 0), loop setting(0, 0) 02-24 21:45:20.132 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:20.160 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:20.175 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:20.191 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:20.196 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:20.198 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:20.225 I/ActivityManager(9816): START u0 {flg=0x10804000 cmp=com.android.systemui/.recents.RecentsActivity} from uid 10029 on display 0 02-24 21:45:20.234 D/NuPlayerDriver(9545): reset(0xb5daad20) at state 6 02-24 21:45:20.234 D/NuPlayerDriver(9545): notifyListener_l(0xb5daad20), (8, 0, 0), loop setting(0, 0) 02-24 21:45:20.246 W/AMessage(9545): failed to post message as target looper for handler 0 is gone. 02-24 21:45:20.262 W/AMessage(9545): failed to post message as target looper for handler 0 is gone. 02-24 21:45:20.265 D/NuPlayerDriver(9545): notifyResetComplete(0xb5daad20) 02-24 21:45:20.265 D/NuPlayerDriver(9545): reset(0xb5daad20) at state 0 02-24 21:45:20.267 I/MediaFocusControl(9816): AudioFocus abandonAudioFocus() from uid/pid 10164/17805 clientId=android.media.AudioManager@3441355 02-24 21:45:20.268 D/AudioManager(20195): AudioManager dispatching onAudioFocusChange(1) for android.media.AudioManager@9a3c97bfzb$2@2427398 02-24 21:45:20.302 I/MediaFocusControl(9816): AudioFocus abandonAudioFocus() from uid/pid 10164/17805 clientId=android.media.AudioManager@3441355 02-24 21:45:20.414 I/art (9816): Background partial concurrent mark sweep GC freed 9342(472KB) AllocSpace objects, 2(40KB) LOS objects, 33% free, 27MB/40MB, paused 1.749ms total 139.689ms 02-24 21:45:20.423 E/qdoverlay(343): Bad ov dump: mdp_overlay z=1 fg=0 alpha=255 mask=-1 flags=0x20300 id=2 02-24 21:45:20.423 E/qdoverlay(343): src msmfb_img w=1664 h=2560 format=13 MDP_RGBA_8888 02-24 21:45:20.423 E/qdoverlay(343): src_rect mdp_rect x=720 y=0 w=720 h=2560 02-24 21:45:20.423 E/qdoverlay(343): dst_rect mdp_rect x=0 y=0 w=720 h=2560 02-24 21:45:20.423 E/qdoverlay(343): Bad ov dump: mdp_overlay z=1 fg=0 alpha=255 mask=-1 flags=0x20300 id=2 02-24 21:45:20.423 E/qdoverlay(343): src msmfb_img w=1664 h=2560 format=13 MDP_RGBA_8888 02-24 21:45:20.423 E/qdoverlay(343): src_rect mdp_rect x=720 y=0 w=720 h=2560 02-24 21:45:20.423 E/qdoverlay(343): dst_rect mdp_rect x=0 y=0 w=720 h=2560 02-24 21:45:20.687 D/sensors_hal_Ctx(9816): poll:polldata:1, sensor:0, type:1, x:-0.026169 y:4.563751 z:8.759109 02-24 21:45:20.734 V/sensors_hal_Light(9816): processReportInd: f0000 15.000000 02-24 21:45:20.747 D/sensors_hal_Ctx(9816): poll:polldata:1, sensor:0, type:1, x:-0.097717 y:4.535767 z:8.702713 02-24 21:45:20.806 D/sensors_hal_Ctx(9816): poll:polldata:1, sensor:0, type:1, x:0.155731 y:4.495941 z:8.455261 02-24 21:45:20.821 V/sensors_hal_Light(9816): processReportInd: e0000 14.000000 02-24 21:45:20.821 D/sensors_hal_Ctx(9816): poll:polldata:1, sensor:1, type:5, x:14.000000 y:0.000000 z:0.000000 02-24 21:45:21.048 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:21.302 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:21.649 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory 02-24 21:45:21.719 E/ActivityManager(9816): applyOptionsLocked: Unknown animationType=0 02-24 21:45:21.816 V/PhoneStatusBar(10097): setLightsOn(true) 02-24 21:45:21.930 V/PhoneStatusBar(10097): setLightsOn(true) 02-24 21:45:21.987 V/PhoneStatusBar(10097): setLightsOn(true) 02-24 21:45:22.087 V/PhoneStatusBar(10097): setLightsOn(true) 02-24 21:45:22.165 E/ThermalEngine(346): [GPU_MON] 25 percent. Current Sampling Time is 1 sec 02-24 21:45:22.165 E/ThermalEngine(346): [GPU_MON] ACTION: GPU - [GPU_MON] Setting GPU[0] to 462400000 02-24 21:45:22.167 E/ThermalEngine(346): [GPU_MON] GPU Initial setting Addaped 462400000 Mhz 02-24 21:45:22.611 I/bt_a2dp_hw(9544): suspend_audio_datapath: state AUDIO_A2DP_STATE_STARTED 02-24 21:45:22.611 I/bt_a2dp_hw(9544): a2dp_command: A2DP COMMAND A2DP_CTRL_CMD_SUSPEND 02-24 21:45:22.612 D/bt_btif (7322): A2DP-CTRL-CHANNEL EVENT UIPC_RX_DATA_READY_EVT 02-24 21:45:22.612 D/bt_btif (7322): a2dp-ctrl-cmd : A2DP_CTRL_CMD_SUSPEND 02-24 21:45:22.612 D/bt_btif (7322): btif_dispatch_sm_event: event: 29, len: 0 02-24 21:45:22.613 D/bt_btif (7322): btif_dispatch_sm_event: event 29 sent 02-24 21:45:22.613 D/bt_btif (7322): a2dp-ctrl-cmd : A2DP_CTRL_CMD_SUSPEND DONE 02-24 21:45:22.613 D/bt_btif (7322): a2dp-ctrl-cmd : A2DP_CTRL_CMD_SUSPEND DONE 02-24 21:45:22.613 D/bt_btif (7322): AV Sevent(0x41)=0x120c(AP_STOP) state=3(OPEN) 02-24 21:45:22.613 E/bt_btif (7322): bta_av_str_stopped:audio_open_cnt=1, p_data 6e5fb780 02-24 21:45:22.613 W/bt_btif (7322): bta_dm_rm_cback:1, status:6 02-24 21:45:22.656 D/bt_btif (7322): AV Sevent(0x41)=0x1223(STR_SUSPEND_CFM) state=3(OPEN) 02-24 21:45:22.656 W/bt_btif (7322): bta_dm_rm_cback:1, status:6 02-24 21:45:22.657 D/bt_btif (7322): btif_av_state_started_handler event:BTA_AV_SUSPEND_EVT flags 1 index =0 02-24 21:45:22.657 D/bt_btif (7322): ## ON A2DP SUSPENDED ## 02-24 21:45:22.657 D/bt_btif (7322): btif_media_thread_handle_cmd : 2 BTIF_MEDIA_STOP_AA_TX 02-24 21:45:22.657 D/bt_btif (7322): btif_media_task_aa_stop_tx media_alarm is running 02-24 21:45:22.661 I/BluetoothA2dpServiceJni(7322): bta2dp_audio_state_callback 02-24 21:45:22.661 D/A2dpStateMachine(7322): Enter onAudioStateChanged() 02-24 21:45:22.662 D/bt_btif (7322): ## a2dp ack : A2DP_CTRL_CMD_SUSPEND, status 0 ## 02-24 21:45:22.662 D/bt_btif (7322): ## a2dp ack : A2DP_CTRL_CMD_NONE, status 0 ## 02-24 21:45:22.662 E/bt_btif (7322): warning : no command pending, ignore ack 02-24 21:45:22.662 D/bt_btif (7322): ## AUDIO PATH DETACHED ## 02-24 21:45:22.663 W/bt_btif (7322): pcm bytes per tick 7056 02-24 21:45:22.663 I/bt_a2dp_hw(9544): a2dp_command: A2DP COMMAND A2DP_CTRL_CMD_SUSPEND DONE STATUS 0 02-24 21:45:22.664 D/bt_btif (7322): btif_media_thread_handle_cmd: BTIF_MEDIA_STOP_AA_TX DONE 02-24 21:45:22.664 I/bt_a2dp_hw(9544): skt_disconnect: fd 22 02-24 21:45:22.668 D/A2dpStateMachine(7322): Connected process message: 101, size: 1 02-24 21:45:22.668 D/A2dpStateMachine(7322): Enter Connected processAudioStateEvent() 02-24 21:45:22.668 D/A2dpStateMachine(7322): connectedState: processAudioStateEvent state: 0 device CC:90:93:05:E5:0C 02-24 21:45:22.668 D/A2dpStateMachine(7322): mPlayingA2dpDevice size is 1 02-24 21:45:22.668 D/A2dpStateMachine(7322): mConnectedDevicesList size is true 02-24 21:45:22.669 D/A2dpStateMachine(7322): Enter broadcastAudioState() 02-24 21:45:22.670 V/Avrcp (7322): event for device address CC:90:93:05:E5:0C 02-24 21:45:22.670 I/Avrcp (7322): device found at index 0 02-24 21:45:22.670 V/Avrcp (7322): updateA2dpAudioState 02-24 21:45:22.676 V/HeadsetService(7322): HeadsetService - Received BluetoothA2dp Play State changed 02-24 21:45:22.677 D/A2dpStateMachine(7322): A2DP Playing state : device: CC:90:93:05:E5:0C State:10->11 02-24 21:45:22.677 D/A2dpStateMachine(7322): Exit broadcastAudioState() 02-24 21:45:22.678 D/A2dpStateMachine(7322): Exit onAudioStateChanged() 02-24 21:45:22.679 D/bt_btif (7322): btif_av_state_started_handler event:BTIF_SM_EXIT_EVT flags 1 index =0 02-24 21:45:22.679 D/bt_btif (7322): btif_av_state_opened_handler event:BTIF_SM_ENTER_EVT flags 1 and index = 0 02-24 21:45:22.683 I/A2dpStateMachine(7322): getScanMode: 21 isScanDisabled: false 02-24 21:45:22.687 D/A2dpStateMachine(7322): Exit Connected processAudioStateEvent() 02-24 21:45:22.687 D/A2dpStateMachine(7322): Exit Connected processMessage() 02-24 21:45:22.862 W/libc (3427): pthread_create failed: couldn't allocate 1044480-bytes mapped space: Out of memory