HI,
Since January I've been experiencing periodic network discnnections on my AT&T GS3. I use the Cyanogenmod nighties. I use the MG2 bootloader. The disconnection problem doesn't always happen, but when it does, it repeats approximately every five minutes, like something is timing out... I have tried various radio firmware, and also wiping my system and reinstalling cyanogenmod.
See the attached image and note the periodicity.
Ideas?
-Nathan
pigrew said:
HI,
Since January I've been experiencing periodic network discnnections on my AT&T GS3. I use the Cyanogenmod nighties. I use the MG2 bootloader. The disconnection problem doesn't always happen, but when it does, it repeats approximately every five minutes, like something is timing out... I have tried various radio firmware, and also wiping my system and reinstalling cyanogenmod.
See the attached image and note the periodicity.
Ideas?
-Nathan
Click to expand...
Click to collapse
Hey same here, but not since Jan. This happened to me this month and Im on cm 10.2.1. Maybe ATT towers.
I just installed CM 10.2 and 10.2.1 and the issue still happens. I guess it has to do with a change that at&t made. I assume that the RIL is a little bit different in CyanogenMod than the radio firmware expects.
I third this issue. I've been frantically searching for weeks and finally opted to just post. Turns out somebody beat me to it. I'm running the i747 with CM nightlies (04/13). My wife has the same phone, same CM build, and SIMILAR issues. Her signal will drop completely and won't come back until the battery is pulled! Also, we're both using straight talk with the AT&T LTE SIMs. I have made a few other observations though. I've noticed that mine will start randomly or particularly right after a random reboot. When the phone comes back up, wifi connects, signal appears, then drops every 5 minutes after that. If I disconnect wifi, H+ appears, then the signal drops at the 5 minute interval BUT LTE will appear quickly instead of it just staying off signal. (See the screen shot) Finally, if I turn wifi back on AFTER the phone connects to LTE, the signal seems to stay.
Sent from my SAMSUNG-SGH-I747 using xda app-developers app
radio log
A while ago, I noticed that there were some unknown calls happening coming from the RIL. I need to reinstall adb on this laptop, and grab a copy of the radio log.... Though, I don't know enough about the RIL and Samsung's proprietary interface to fix it (not that it's documented AFAIK....).
Radio log
pigrew said:
A while ago, I noticed that there were some unknown calls happening coming from the RIL. I need to reinstall adb on this laptop, and grab a copy of the radio log.... Though, I don't know enough about the RIL and Samsung's proprietary interface to fix it (not that it's documented AFAIK....).
Click to expand...
Click to collapse
The below did not cause a disconnect, but I remember that a very very similar error happened when the radio disconnects. I'm going to need to wait for the error to happen again. It's so full of errors.... something's wrong.
lastlong -db radio
Code:
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_util_convert_qmi_response_codes_to_ril_result_ex: ctx check 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_fetch_signal_strength_observations: ..sign info fetch res 0, 0, 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_propagate_known_signal_strength_ind: .. subfetch sig strength info 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_propagate_known_signal_strength_ind: .. conf res 0
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_send_unsol_response: [DEADLOCK-DEBUG] >> get the peding LOCK - qcril_send_unsol_response
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qmi_ril_android_pending_unsol_resp_lock: [DEADLOCK-DEBUG] qmi_ril_android_pending_unsol_resp_lock - Before Count : 0
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_send_unsol_response_epilog: UI <--- RIL_UNSOL_SIGNAL_STRENGTH (1009) --- RIL [RID 0, Len 52, (null)]
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_send_unsol_response: [DEADLOCK-DEBUG] << get the peding UNLOCK - qcril_send_unsol_response
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qmi_ril_android_pending_unsol_resp_unlock: [DEADLOCK-DEBUG] qmi_ril_android_pending_unsol_resp_unlock - Before Count : 1
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_process_event: Exit QCRIL_EVT_QMI_NAS_SIG_STRENGTH_UPDATE, err_no 0
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_event_main: Waiting...
E/use-Rlog/RLOG-RIL-RAWDATA( 401): service_ID = 3, message_ID = 51
E/use-Rlog/RLOG-RIL-RAWDATA( 401): 01 15 00 80 03 01 04 00 00 51 00 ..
D/use-Rlog/RLOG-RIL-QMI( 401): qmuxd: TX message on fd=22, to clientID = 0, len=56
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_qmi_nas_unsolicited_indication_cb: invoked msg 0x51
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_qmi_nas_is_considered_registered: .. cache valid 1
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_qmi_nas_is_considered_registered: .. cache valid 1
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_event_queue: Event [QCRIL_EVT_QMI_NAS_SIG_STRENGTH_UPDATE, a000a] data was NULL
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_event_queue: RID 0 MID 0 Queued event QCRIL_EVT_QMI_NAS_SIG_STRENGTH_UPDATE (0 bytes)
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_qmi_nas_unsolicited_indication_cb: .. operational state 3
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_event_main: 1 items on queue
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_event_main: RID 0 MID 0 De-queued event QCRIL_EVT_QMI_NAS_SIG_STRENGTH_UPDATE (655370)
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_process_event: RIL <--- QCRIL_EVT_QMI_NAS_SIG_STRENGTH_UPDATE(655370), RID 0, MID 0 --- AMSS
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_fetch_signal_strength_observations: validity sign info GSM 0, WCDMA 0, TDSCDMA 0, 1x 0, HRPD 0, LTE 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_fetch_signal_strength_observations: validity err rate GSM 0, WCDMA 0, TDSCDMA 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_fetch_signal_strength_observations: ..qmi_request_need_sig_info-1, qmi_request_need_err_rate-0
D/use-Rlog/RLOG-RIL-QMI( 401): qmuxd: RX 47 bytes on fd=22 from qmux_client_id=0
E/use-Rlog/RLOG-RIL-RAWDATA( 401): service_ID = 3, message_ID = 4f
E/use-Rlog/RLOG-RIL-RAWDATA( 401): 01 0C 00 00 03 01 00 21 14 4F 00 ..
E/use-Rlog/RLOG-RIL-QMI( 401): [SMDPORT] >> BEFORE, Write SMD Port [fd = 10] [msg_len = 13]
E/use-Rlog/RLOG-RIL-QMI( 401): [SMDPORT] << AFTER, Write SMD Port [rc = 0]
E/use-Rlog/RLOG-RIL-RAWDATA( 401): service_ID = 3, message_ID = 4f
E/use-Rlog/RLOG-RIL-RAWDATA( 401): 01 21 00 80 03 01 02 21 14 4F 00 ..
D/use-Rlog/RLOG-RIL-QMI( 401): qmuxd: TX message on fd=22, to clientID = 0, len=68
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_util_convert_qmi_response_codes_to_ril_result_ex: ctx check 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_fetch_signal_strength_observations: ..sign info fetch res 0, 0, 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_propagate_known_signal_strength_ind: .. subfetch sig strength info 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_propagate_known_signal_strength_ind: .. conf res 0
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_send_unsol_response: [DEADLOCK-DEBUG] >> get the peding LOCK - qcril_send_unsol_response
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qmi_ril_android_pending_unsol_resp_lock: [DEADLOCK-DEBUG] qmi_ril_android_pending_unsol_resp_lock - Before Count : 0
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_send_unsol_response_epilog: UI <--- RIL_UNSOL_SIGNAL_STRENGTH (1009) --- RIL [RID 0, Len 52, (null)]
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_send_unsol_response: [DEADLOCK-DEBUG] << get the peding UNLOCK - qcril_send_unsol_response
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qmi_ril_android_pending_unsol_resp_unlock: [DEADLOCK-DEBUG] qmi_ril_android_pending_unsol_resp_unlock - Before Count : 1
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_process_event: Exit QCRIL_EVT_QMI_NAS_SIG_STRENGTH_UPDATE, err_no 0
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_event_main: Waiting...
E/use-Rlog/RLOG-RIL-RAWDATA( 401): service_ID = 3, message_ID = 51
E/use-Rlog/RLOG-RIL-RAWDATA( 401): 01 15 00 80 03 01 04 00 00 51 00 ..
D/use-Rlog/RLOG-RIL-QMI( 401): qmuxd: TX message on fd=22, to clientID = 0, len=56
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_qmi_nas_unsolicited_indication_cb: invoked msg 0x51
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_qmi_nas_is_considered_registered: .. cache valid 1
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_qmi_nas_is_considered_registered: .. cache valid 1
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_event_queue: Event [QCRIL_EVT_QMI_NAS_SIG_STRENGTH_UPDATE, a000a] data was NULL
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_event_queue: RID 0 MID 0 Queued event QCRIL_EVT_QMI_NAS_SIG_STRENGTH_UPDATE (0 bytes)
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_qmi_nas_unsolicited_indication_cb: .. operational state 3
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_event_main: 1 items on queue
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_event_main: RID 0 MID 0 De-queued event QCRIL_EVT_QMI_NAS_SIG_STRENGTH_UPDATE (655370)
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_process_event: RIL <--- QCRIL_EVT_QMI_NAS_SIG_STRENGTH_UPDATE(655370), RID 0, MID 0 --- AMSS
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_fetch_signal_strength_observations: validity sign info GSM 0, WCDMA 0, TDSCDMA 0, 1x 0, HRPD 0, LTE 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_fetch_signal_strength_observations: validity err rate GSM 0, WCDMA 0, TDSCDMA 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_fetch_signal_strength_observations: ..qmi_request_need_sig_info-1, qmi_request_need_err_rate-0
D/use-Rlog/RLOG-RIL-QMI( 401): qmuxd: RX 47 bytes on fd=22 from qmux_client_id=0
E/use-Rlog/RLOG-RIL-RAWDATA( 401): service_ID = 3, message_ID = 4f
E/use-Rlog/RLOG-RIL-RAWDATA( 401): 01 0C 00 00 03 01 00 22 14 4F 00 ..
E/use-Rlog/RLOG-RIL-QMI( 401): [SMDPORT] >> BEFORE, Write SMD Port [fd = 10] [msg_len = 13]
E/use-Rlog/RLOG-RIL-QMI( 401): [SMDPORT] << AFTER, Write SMD Port [rc = 0]
E/use-Rlog/RLOG-RIL-RAWDATA( 401): service_ID = 3, message_ID = 4f
E/use-Rlog/RLOG-RIL-RAWDATA( 401): 01 21 00 80 03 01 02 22 14 4F 00 ..
D/use-Rlog/RLOG-RIL-QMI( 401): qmuxd: TX message on fd=22, to clientID = 0, len=68
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_util_convert_qmi_response_codes_to_ril_result_ex: ctx check 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_fetch_signal_strength_observations: ..sign info fetch res 0, 0, 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_propagate_known_signal_strength_ind: .. subfetch sig strength info 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_propagate_known_signal_strength_ind: .. conf res 0
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_send_unsol_response: [DEADLOCK-DEBUG] >> get the peding LOCK - qcril_send_unsol_response
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qmi_ril_android_pending_unsol_resp_lock: [DEADLOCK-DEBUG] qmi_ril_android_pending_unsol_resp_lock - Before Count : 0
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_send_unsol_response_epilog: UI <--- RIL_UNSOL_SIGNAL_STRENGTH (1009) --- RIL [RID 0, Len 52, (null)]
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_send_unsol_response: [DEADLOCK-DEBUG] << get the peding UNLOCK - qcril_send_unsol_response
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qmi_ril_android_pending_unsol_resp_unlock: [DEADLOCK-DEBUG] qmi_ril_android_pending_unsol_resp_unlock - Before Count : 1
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_process_event: Exit QCRIL_EVT_QMI_NAS_SIG_STRENGTH_UPDATE, err_no 0
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_event_main: Waiting...
E/use-Rlog/RLOG-RIL-RAWDATA( 401): service_ID = 3, message_ID = 51
E/use-Rlog/RLOG-RIL-RAWDATA( 401): 01 15 00 80 03 01 04 00 00 51 00 ..
D/use-Rlog/RLOG-RIL-QMI( 401): qmuxd: TX message on fd=22, to clientID = 0, len=56
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_qmi_nas_unsolicited_indication_cb: invoked msg 0x51
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_qmi_nas_is_considered_registered: .. cache valid 1
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_qmi_nas_is_considered_registered: .. cache valid 1
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_event_queue: Event [QCRIL_EVT_QMI_NAS_SIG_STRENGTH_UPDATE, a000a] data was NULL
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_event_queue: RID 0 MID 0 Queued event QCRIL_EVT_QMI_NAS_SIG_STRENGTH_UPDATE (0 bytes)
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_qmi_nas_unsolicited_indication_cb: .. operational state 3
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_event_main: 1 items on queue
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_event_main: RID 0 MID 0 De-queued event QCRIL_EVT_QMI_NAS_SIG_STRENGTH_UPDATE (655370)
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_process_event: RIL <--- QCRIL_EVT_QMI_NAS_SIG_STRENGTH_UPDATE(655370), RID 0, MID 0 --- AMSS
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_fetch_signal_strength_observations: validity sign info GSM 0, WCDMA 0, TDSCDMA 0, 1x 0, HRPD 0, LTE 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_fetch_signal_strength_observations: validity err rate GSM 0, WCDMA 0, TDSCDMA 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_fetch_signal_strength_observations: ..qmi_request_need_sig_info-1, qmi_request_need_err_rate-0
D/use-Rlog/RLOG-RIL-QMI( 401): qmuxd: RX 47 bytes on fd=22 from qmux_client_id=0
E/use-Rlog/RLOG-RIL-RAWDATA( 401): service_ID = 3, message_ID = 4f
E/use-Rlog/RLOG-RIL-RAWDATA( 401): 01 0C 00 00 03 01 00 23 14 4F 00 ..
E/use-Rlog/RLOG-RIL-QMI( 401): [SMDPORT] >> BEFORE, Write SMD Port [fd = 10] [msg_len = 13]
E/use-Rlog/RLOG-RIL-QMI( 401): [SMDPORT] << AFTER, Write SMD Port [rc = 0]
E/use-Rlog/RLOG-RIL-RAWDATA( 401): service_ID = 3, message_ID = 4f
E/use-Rlog/RLOG-RIL-RAWDATA( 401): 01 21 00 80 03 01 02 23 14 4F 00 ..
D/use-Rlog/RLOG-RIL-QMI( 401): qmuxd: TX message on fd=22, to clientID = 0, len=68
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_util_convert_qmi_response_codes_to_ril_result_ex: ctx check 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_fetch_signal_strength_observations: ..sign info fetch res 0, 0, 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_propagate_known_signal_strength_ind: .. subfetch sig strength info 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_propagate_known_signal_strength_ind: .. conf res 0
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_send_unsol_response: [DEADLOCK-DEBUG] >> get the peding LOCK - qcril_send_unsol_response
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qmi_ril_android_pending_unsol_resp_lock: [DEADLOCK-DEBUG] qmi_ril_android_pending_unsol_resp_lock - Before Count : 0
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_send_unsol_response_epilog: UI <--- RIL_UNSOL_SIGNAL_STRENGTH (1009) --- RIL [RID 0, Len 52, (null)]
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_send_unsol_response: [DEADLOCK-DEBUG] << get the peding UNLOCK - qcril_send_unsol_response
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qmi_ril_android_pending_unsol_resp_unlock: [DEADLOCK-DEBUG] qmi_ril_android_pending_unsol_resp_unlock - Before Count : 1
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_process_event: Exit QCRIL_EVT_QMI_NAS_SIG_STRENGTH_UPDATE, err_no 0
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_event_main: Waiting...
E/use-Rlog/RLOG-RIL-RAWDATA( 401): service_ID = 3, message_ID = 51
E/use-Rlog/RLOG-RIL-RAWDATA( 401): 01 15 00 80 03 01 04 00 00 51 00 ..
D/use-Rlog/RLOG-RIL-QMI( 401): qmuxd: TX message on fd=22, to clientID = 0, len=56
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_qmi_nas_unsolicited_indication_cb: invoked msg 0x51
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_qmi_nas_is_considered_registered: .. cache valid 1
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_qmi_nas_is_considered_registered: .. cache valid 1
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_event_queue: Event [QCRIL_EVT_QMI_NAS_SIG_STRENGTH_UPDATE, a000a] data was NULL
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_event_queue: RID 0 MID 0 Queued event QCRIL_EVT_QMI_NAS_SIG_STRENGTH_UPDATE (0 bytes)
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_qmi_nas_unsolicited_indication_cb: .. operational state 3
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_event_main: 1 items on queue
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_event_main: RID 0 MID 0 De-queued event QCRIL_EVT_QMI_NAS_SIG_STRENGTH_UPDATE (655370)
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_process_event: RIL <--- QCRIL_EVT_QMI_NAS_SIG_STRENGTH_UPDATE(655370), RID 0, MID 0 --- AMSS
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_fetch_signal_strength_observations: validity sign info GSM 0, WCDMA 0, TDSCDMA 0, 1x 0, HRPD 0, LTE 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_fetch_signal_strength_observations: validity err rate GSM 0, WCDMA 0, TDSCDMA 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_fetch_signal_strength_observations: ..qmi_request_need_sig_info-1, qmi_request_need_err_rate-0
D/use-Rlog/RLOG-RIL-QMI( 401): qmuxd: RX 47 bytes on fd=22 from qmux_client_id=0
E/use-Rlog/RLOG-RIL-RAWDATA( 401): service_ID = 3, message_ID = 4f
E/use-Rlog/RLOG-RIL-RAWDATA( 401): 01 0C 00 00 03 01 00 24 14 4F 00 ..
E/use-Rlog/RLOG-RIL-QMI( 401): [SMDPORT] >> BEFORE, Write SMD Port [fd = 10] [msg_len = 13]
E/use-Rlog/RLOG-RIL-QMI( 401): [SMDPORT] << AFTER, Write SMD Port [rc = 0]
E/use-Rlog/RLOG-RIL-RAWDATA( 401): service_ID = 3, message_ID = 4f
E/use-Rlog/RLOG-RIL-RAWDATA( 401): 01 21 00 80 03 01 02 24 14 4F 00 ..
D/use-Rlog/RLOG-RIL-QMI( 401): qmuxd: TX message on fd=22, to clientID = 0, len=68
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_util_convert_qmi_response_codes_to_ril_result_ex: ctx check 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_fetch_signal_strength_observations: ..sign info fetch res 0, 0, 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_propagate_known_signal_strength_ind: .. subfetch sig strength info 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_propagate_known_signal_strength_ind: .. conf res 0
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_send_unsol_response: [DEADLOCK-DEBUG] >> get the peding LOCK - qcril_send_unsol_response
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qmi_ril_android_pending_unsol_resp_lock: [DEADLOCK-DEBUG] qmi_ril_android_pending_unsol_resp_lock - Before Count : 0
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_send_unsol_response_epilog: UI <--- RIL_UNSOL_SIGNAL_STRENGTH (1009) --- RIL [RID 0, Len 52, (null)]
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_send_unsol_response: [DEADLOCK-DEBUG] << get the peding UNLOCK - qcril_send_unsol_response
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qmi_ril_android_pending_unsol_resp_unlock: [DEADLOCK-DEBUG] qmi_ril_android_pending_unsol_resp_unlock - Before Count : 1
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_process_event: Exit QCRIL_EVT_QMI_NAS_SIG_STRENGTH_UPDATE, err_no 0
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_event_main: Waiting...
E/use-Rlog/RLOG-RIL-RAWDATA( 401): service_ID = 3, message_ID = 51
E/use-Rlog/RLOG-RIL-RAWDATA( 401): 01 15 00 80 03 01 04 00 00 51 00 ..
D/use-Rlog/RLOG-RIL-QMI( 401): qmuxd: TX message on fd=22, to clientID = 0, len=56
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_qmi_nas_unsolicited_indication_cb: invoked msg 0x51
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_qmi_nas_is_considered_registered: .. cache valid 1
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_qmi_nas_is_considered_registered: .. cache valid 1
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_event_queue: Event [QCRIL_EVT_QMI_NAS_SIG_STRENGTH_UPDATE, a000a] data was NULL
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_event_queue: RID 0 MID 0 Queued event QCRIL_EVT_QMI_NAS_SIG_STRENGTH_UPDATE (0 bytes)
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_qmi_nas_unsolicited_indication_cb: .. operational state 3
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_event_main: 1 items on queue
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_event_main: RID 0 MID 0 De-queued event QCRIL_EVT_QMI_NAS_SIG_STRENGTH_UPDATE (655370)
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_process_event: RIL <--- QCRIL_EVT_QMI_NAS_SIG_STRENGTH_UPDATE(655370), RID 0, MID 0 --- AMSS
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_fetch_signal_strength_observations: validity sign info GSM 0, WCDMA 0, TDSCDMA 0, 1x 0, HRPD 0, LTE 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_fetch_signal_strength_observations: validity err rate GSM 0, WCDMA 0, TDSCDMA 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_fetch_signal_strength_observations: ..qmi_request_need_sig_info-1, qmi_request_need_err_rate-0
D/use-Rlog/RLOG-RIL-QMI( 401): qmuxd: RX 47 bytes on fd=22 from qmux_client_id=0
E/use-Rlog/RLOG-RIL-RAWDATA( 401): service_ID = 3, message_ID = 4f
E/use-Rlog/RLOG-RIL-RAWDATA( 401): 01 0C 00 00 03 01 00 25 14 4F 00 ..
E/use-Rlog/RLOG-RIL-QMI( 401): [SMDPORT] >> BEFORE, Write SMD Port [fd = 10] [msg_len = 13]
E/use-Rlog/RLOG-RIL-QMI( 401): [SMDPORT] << AFTER, Write SMD Port [rc = 0]
E/use-Rlog/RLOG-RIL-RAWDATA( 401): service_ID = 3, message_ID = 4f
E/use-Rlog/RLOG-RIL-RAWDATA( 401): 01 21 00 80 03 01 02 25 14 4F 00 ..
D/use-Rlog/RLOG-RIL-QMI( 401): qmuxd: TX message on fd=22, to clientID = 0, len=68
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_util_convert_qmi_response_codes_to_ril_result_ex: ctx check 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_fetch_signal_strength_observations: ..sign info fetch res 0, 0, 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_propagate_known_signal_strength_ind: .. subfetch sig strength info 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_propagate_known_signal_strength_ind: .. conf res 0
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_send_unsol_response: [DEADLOCK-DEBUG] >> get the peding LOCK - qcril_send_unsol_response
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qmi_ril_android_pending_unsol_resp_lock: [DEADLOCK-DEBUG] qmi_ril_android_pending_unsol_resp_lock - Before Count : 0
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_send_unsol_response_epilog: UI <--- RIL_UNSOL_SIGNAL_STRENGTH (1009) --- RIL [RID 0, Len 52, (null)]
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_send_unsol_response: [DEADLOCK-DEBUG] << get the peding UNLOCK - qcril_send_unsol_response
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qmi_ril_android_pending_unsol_resp_unlock: [DEADLOCK-DEBUG] qmi_ril_android_pending_unsol_resp_unlock - Before Count : 1
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_process_event: Exit QCRIL_EVT_QMI_NAS_SIG_STRENGTH_UPDATE, err_no 0
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_event_main: Waiting...
E/use-Rlog/RLOG-RIL-RAWDATA( 401): service_ID = 3, message_ID = 51
E/use-Rlog/RLOG-RIL-RAWDATA( 401): 01 15 00 80 03 01 04 00 00 51 00 ..
D/use-Rlog/RLOG-RIL-QMI( 401): qmuxd: TX message on fd=22, to clientID = 0, len=56
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_qmi_nas_unsolicited_indication_cb: invoked msg 0x51
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_qmi_nas_is_considered_registered: .. cache valid 1
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_qmi_nas_is_considered_registered: .. cache valid 1
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_event_queue: Event [QCRIL_EVT_QMI_NAS_SIG_STRENGTH_UPDATE, a000a] data was NULL
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_event_queue: RID 0 MID 0 Queued event QCRIL_EVT_QMI_NAS_SIG_STRENGTH_UPDATE (0 bytes)
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_qmi_nas_unsolicited_indication_cb: .. operational state 3
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_event_main: 1 items on queue
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_event_main: RID 0 MID 0 De-queued event QCRIL_EVT_QMI_NAS_SIG_STRENGTH_UPDATE (655370)
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_process_event: RIL <--- QCRIL_EVT_QMI_NAS_SIG_STRENGTH_UPDATE(655370), RID 0, MID 0 --- AMSS
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_fetch_signal_strength_observations: validity sign info GSM 0, WCDMA 0, TDSCDMA 0, 1x 0, HRPD 0, LTE 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_fetch_signal_strength_observations: validity err rate GSM 0, WCDMA 0, TDSCDMA 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_fetch_signal_strength_observations: ..qmi_request_need_sig_info-1, qmi_request_need_err_rate-0
D/use-Rlog/RLOG-RIL-QMI( 401): qmuxd: RX 47 bytes on fd=22 from qmux_client_id=0
E/use-Rlog/RLOG-RIL-RAWDATA( 401): service_ID = 3, message_ID = 4f
E/use-Rlog/RLOG-RIL-RAWDATA( 401): 01 0C 00 00 03 01 00 26 14 4F 00 ..
E/use-Rlog/RLOG-RIL-QMI( 401): [SMDPORT] >> BEFORE, Write SMD Port [fd = 10] [msg_len = 13]
E/use-Rlog/RLOG-RIL-QMI( 401): [SMDPORT] << AFTER, Write SMD Port [rc = 0]
E/use-Rlog/RLOG-RIL-RAWDATA( 401): service_ID = 3, message_ID = 4f
E/use-Rlog/RLOG-RIL-RAWDATA( 401): 01 21 00 80 03 01 02 26 14 4F 00 ..
D/use-Rlog/RLOG-RIL-QMI( 401): qmuxd: TX message on fd=22, to clientID = 0, len=68
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_util_convert_qmi_response_codes_to_ril_result_ex: ctx check 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_fetch_signal_strength_observations: ..sign info fetch res 0, 0, 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_propagate_known_signal_strength_ind: .. subfetch sig strength info 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_propagate_known_signal_strength_ind: .. conf res 0
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_send_unsol_response: [DEADLOCK-DEBUG] >> get the peding LOCK - qcril_send_unsol_response
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qmi_ril_android_pending_unsol_resp_lock: [DEADLOCK-DEBUG] qmi_ril_android_pending_unsol_resp_lock - Before Count : 0
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_send_unsol_response_epilog: UI <--- RIL_UNSOL_SIGNAL_STRENGTH (1009) --- RIL [RID 0, Len 52, (null)]
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_send_unsol_response: [DEADLOCK-DEBUG] << get the peding UNLOCK - qcril_send_unsol_response
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qmi_ril_android_pending_unsol_resp_unlock: [DEADLOCK-DEBUG] qmi_ril_android_pending_unsol_resp_unlock - Before Count : 1
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_process_event: Exit QCRIL_EVT_QMI_NAS_SIG_STRENGTH_UPDATE, err_no 0
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_event_main: Waiting...
E/use-Rlog/RLOG-RIL-RAWDATA( 401): service_ID = 3, message_ID = 51
E/use-Rlog/RLOG-RIL-RAWDATA( 401): 01 15 00 80 03 01 04 00 00 51 00 ..
D/use-Rlog/RLOG-RIL-QMI( 401): qmuxd: TX message on fd=22, to clientID = 0, len=56
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_qmi_nas_unsolicited_indication_cb: invoked msg 0x51
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_qmi_nas_is_considered_registered: .. cache valid 1
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_qmi_nas_is_considered_registered: .. cache valid 1
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_event_queue: Event [QCRIL_EVT_QMI_NAS_SIG_STRENGTH_UPDATE, a000a] data was NULL
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_event_queue: RID 0 MID 0 Queued event QCRIL_EVT_QMI_NAS_SIG_STRENGTH_UPDATE (0 bytes)
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [qmi_cb] qcril_qmi_nas_unsolicited_indication_cb: .. operational state 3
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_event_main: 1 items on queue
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_event_main: RID 0 MID 0 De-queued event QCRIL_EVT_QMI_NAS_SIG_STRENGTH_UPDATE (655370)
D/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_process_event: RIL <--- QCRIL_EVT_QMI_NAS_SIG_STRENGTH_UPDATE(655370), RID 0, MID 0 --- AMSS
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_fetch_signal_strength_observations: validity sign info GSM 0, WCDMA 0, TDSCDMA 0, 1x 0, HRPD 0, LTE 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_fetch_signal_strength_observations: validity err rate GSM 0, WCDMA 0, TDSCDMA 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_fetch_signal_strength_observations: ..qmi_request_need_sig_info-1, qmi_request_need_err_rate-0
D/use-Rlog/RLOG-RIL-QMI( 401): qmuxd: RX 47 bytes on fd=22 from qmux_client_id=0
E/use-Rlog/RLOG-RIL-RAWDATA( 401): service_ID = 3, message_ID = 4f
E/use-Rlog/RLOG-RIL-RAWDATA( 401): 01 0C 00 00 03 01 00 27 14 4F 00 ..
E/use-Rlog/RLOG-RIL-QMI( 401): [SMDPORT] >> BEFORE, Write SMD Port [fd = 10] [msg_len = 13]
E/use-Rlog/RLOG-RIL-QMI( 401): [SMDPORT] << AFTER, Write SMD Port [rc = 0]
E/use-Rlog/RLOG-RIL-RAWDATA( 401): service_ID = 3, message_ID = 4f
E/use-Rlog/RLOG-RIL-RAWDATA( 401): 01 21 00 80 03 01 02 27 14 4F 00 ..
D/use-Rlog/RLOG-RIL-QMI( 401): qmuxd: TX message on fd=22, to clientID = 0, len=68
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_util_convert_qmi_response_codes_to_ril_result_ex: ctx check 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_fetch_signal_strength_observations: ..sign info fetch res 0, 0, 0
I/use-Rlog/RLOG-RILC( 340): qmi_ril(0/340): [event] qcril_qmi_nas_propagate_known_signal_strength_ind: .. subfetch sig strength info 0
pigrew said:
The below did not cause a disconnect, but I remember that a very very similar error happened when the radio disconnects. I'm going to need to wait for the error to happen again. It's so full of errors.... something's wrong.
lastlong -db radio
Click to expand...
Click to collapse
I'm getting the exact same log on my S4 mini running cm10.2, on AT&T.
Now I build roms, so I was thinking it was due to my latest tweaks.
Then I tried stable cm10.2 and stock kernel. Even reverted to old basebands.
I'm still getting thousands of wakeup triggers from rilj during the day.
I definitely think AT&T made a change in their network and cm10.2 somehow isn't compatible.
jamus28 said:
I'm getting the exact same log on my S4 mini running cm10.2, on AT&T.
Now I build roms, so I was thinking it was due to my latest tweaks.
Then I tried stable cm10.2 and stock kernel. Even reverted to old basebands.
I'm still getting thousands of wakeup triggers from rilj during the day.
I definitely think AT&T made a change in their network and cm10.2 somehow isn't compatible.
Click to expand...
Click to collapse
Yes, it very well could be that AT&T changed their basestations. My reading of the persistant error messages is that there's some API incompatibility between the Android RIL and the Samsung RIL. I've not tried looking for it, but is the source code available for the Samsung RIL? How does it differ from CM? Are they radically different, or mostly the same?
Though, the disconnect issue may be separate from the many error messages... so much noise and so little signal.
(I probably should try to look at this myself, but I'm not too familiar with the Android codebase....)
So my data connection and telephone signal are about the same theyve always been.
What's changed is the thousands of RIL wakeups and resulting battery drain. It's almost constantly querying the network and erroring back.
Reported at cyanogenmod
I just reported the bug to Cyanogenmod's bug tracker against the M7 build.
https://jira.cyanogenmod.org/browse/CYAN-4490
Just wanted to +1 this thread. Happening to me on a regular basis. On task's rom. Haven't been able to find anything on it. It's quite frustrating
You can add me as another experiencing this problem. It's been happening the past couple months. It randomly (but fairly regularly) loses signal, will stay lost for about 5 mins, and then find signal again. This drains the battery a TON and I have to charge it 2-3 times a day. Very frustrating, to the point I'm trying to sell it and get a different phone...
This happened to me with my S3 on every single AOSP-based ROM I tried. If I'd revert to the stock image that ships with the phone (complete with all of the AT&T bloatware, etc, sigh) it would disappear.
I submitted bug reports on it for both CM and AOKP, but never got anywhere. Considering the phone's age and the fact that this bug seems to affect people intermittently and selectively, I had my doubts that it would ever be fixed. I chugged along for a while by disabling LTE (though I'd have to force the phone to WCDMA/GSM again after every single reboot and it would often take many tries), which minimized it, but eventually I gave up and bought an S4 GPE. My phone, first and foremost, needs to work as a phone. Just couldn't make that happen with CM or AOKP on the S3, I'm sad to say. A real shame, because I loved the device itself.
If anyone ever finds a fix, maybe I can revive mine!
Hi,
When I am in update center and click "app updates" it force closes. Clicking software update works though.
Just wondering why this is happening and if I can fix it. I have removed some of the bloatware from the stock rom, but the update center apk is still where it should be. Thought it might have been xposed causing it but turned it off and still no go.
Here is my logcat. Running stock, rooted. Thanks a lot!!!
09-11 20:59:00.002 D/PowerManagerServiceEx(991): acquireWakeLockInternal: lock=480311568, flags=0x40000001, tag="*alarm*", ws=WorkSource{1000}, historyTag=*alarm*:android.intent.action.TIME_TICK, uid=1000, pid=991
09-11 20:59:00.031 D/PowerManagerServiceEx(991): releaseWakeLockInternal: lock=480311568 [*alarm*], flags=0x0
09-11 20:59:00.035 I/[SystemUI]TimeTickManager(2025): setTimeTickHandler, called onTimeChanged()
09-11 20:59:00.035 I/KeyguardUpdateMonitor(2025): called onTimeUpdated()
09-11 20:59:00.035 I/[SystemUI]KeyguardIndicationController(2025): called onTimeUpdated()
09-11 20:59:00.035 I/[SystemUI]Clock(2025): called onTimeUpdated()
09-11 20:59:00.039 I/LgeClockWidgetControlView(2025): called onTimeUpdated()
09-11 20:59:00.039 I/[SystemUI]DateView(2025): called onTimeUpdated()
09-11 20:59:00.040 I/[SystemUI]DateView(2025): called onTimeUpdated()
09-11 20:59:00.040 D/KeyguardUpdateMonitor(2025): handleTimeUpdate
09-11 20:59:01.232 D/InputDispatcher(991): notifyMotion - action=ACTION_DOWN, eventTime=586158702000, downTime=586158702000
09-11 20:59:01.235 D/InputTransport(991): channel '1064ef63 com.lge.updatecenter/com.lge.updatecenter.UpdateCenterPrfActivity (server)' : action=ACTION_DOWN, downTime=586158702000, eventTime=586158702000, pointerCount=1
09-11 20:59:01.235 I/ViewRootImpl(8765): ViewRoot's Touch Event : ACTION_DOWN
09-11 20:59:01.236 D/InputTransport(991): channel 'WindowManager (server)' : action=ACTION_DOWN, downTime=586158702000, eventTime=586158702000, pointerCount=1
09-11 20:59:01.237 E/GBMv2 (357): Set value is all cleared set the max
09-11 20:59:01.237 I/GBMv2 (357): VFP is [12]
09-11 20:59:01.237 D/PowerManagerServiceEx(991): updateUserActivitySummaryLocked: mWakefulness=Awake, mUserActivitySummary=0x1, nextTimeout=613911 (in 27747 ms)
09-11 20:59:01.310 D/InputDispatcher(991): notifyMotion - action=ACTION_UP, eventTime=586237001000, downTime=586158702000
09-11 20:59:01.310 D/InputTransport(991): channel '1064ef63 com.lge.updatecenter/com.lge.updatecenter.UpdateCenterPrfActivity (server)' : action=ACTION_UP, downTime=586158702000, eventTime=586237001000, pointerCount=1
09-11 20:59:01.310 D/InputTransport(991): channel 'WindowManager (server)' : action=ACTION_UP, downTime=586158702000, eventTime=586237001000, pointerCount=1
09-11 20:59:01.311 I/ViewRootImpl(8765): ViewRoot's Touch Event : ACTION_UP
09-11 20:59:01.376 D/UpdateCenter:UpdateCenterListFragment(8765): ****onListItemClick****
09-11 20:59:01.377 D/UpdateCenter:UpdateCenterListFragment(8765): ****isSystemPackageInfo****
09-11 20:59:01.378 I/Timeline(8765): Timeline: Activity_launch_request id:com.lge.appbox.client time:586304
09-11 20:59:01.378 I/ActivityManager(991): START u0 {act=android.intent.action.MAIN cmp=com.lge.appbox.client/.AppBoxClient} from uid 10040 on display 0
09-11 20:59:01.383 V/SplitWindowPolicy(2528): checkScreen => return. sourceIntent is null or not support SplitWindow component: ComponentInfo{co.....client/co.....client.AppBoxClient}
09-11 20:59:01.383 D/SplitInfo(991): new ActivitySplitInfo : ActivitySplitInfo [screenZone=0/ flag=0x0/ state=NATIVE]
09-11 20:59:01.384 D/ActivityManager(991): setTaskToReturnTo : TaskRecord{13ba98d5 #4527 A=com.lge.appbox.client U=0 sz=0} / mTaskToReturnTo = 0
09-11 20:59:01.385 D/WindowStateEx(991): AppWindowTokenEx init..
09-11 20:59:01.386 D/ContextHelper(991): convertTheme. context->name=com.lge.appbox.client themeResourceId=34210242
09-11 20:59:01.388 I/PhoneWindow(991): [generateLayout] setColorNavigationBar => color=0x ff000001
09-11 20:59:01.397 D/PhoneWindowEx(991): [PWEx][generateLayout] setNavigationBarColor2 : colors=0xff000000
09-11 20:59:01.397 I/PhoneWindow(991): [setNavigationBarColor2] color=0x ff000000
09-11 20:59:01.406 D/SplitWindow(991): check instance of lgWin Window{2111e9b6 u0 Starting com.lge.appbox.client}
09-11 20:59:01.425 D/SplitWindowPolicy(2528): updateActivityStateChanged: resumed=false, screenId=1, isScreenFull=true
09-11 20:59:01.425 D/SplitWindowPolicy(2528): topRunningActivity=ActivityInfo{37a1d43e co.....UpdateCenterPrfActivity}, taskId=4520, activityType=0, bIsSplit=false
09-11 20:59:01.472 D/InputDispatcher(991): Focus left window: Window{1064ef63 u0 com.lge.updatecenter/com.lge.updatecenter.UpdateCenterPrfActivity}
09-11 20:59:01.476 D/UpdateCenter:UpdateCenterListFragment(8765): ****prfListAdapter : getView****
09-11 20:59:01.476 D/UpdateCenter:UpdateCenterListFragment(8765): 0:App Updates
09-11 20:59:01.477 D/UpdateCenter:UpdateCenterListFragment(8765): ****prfListAdapter : getView****
09-11 20:59:01.477 D/UpdateCenter:UpdateCenterListFragment(8765): 1:Software Update
09-11 20:59:01.534 I/ActivityManager(991): Start proc com.lge.appbox.client for activity com.lge.appbox.client/.AppBoxClient: pid=8868 uid=10011 gids={50011, 9997, 3003, 1028, 1015, 2001} abi=armeabi
09-11 20:59:01.604 I/WindowStateAnimator(991): Starting window displayed
09-11 20:59:01.624 I/SystemUI[Framework](991): PhoneWindowManager.updateSystemUiVisibilityLw() :visibility=0x8600, pkg=com.lge.appbox.client
09-11 20:59:01.625 W/PhoneWindowManagerEx(991): Call!!!getLGSystemUiVisibility. =0x0
09-11 20:59:01.625 D/StatusBarManagerServiceEx(991): setLGSystemUiVisibility(0x0)
09-11 20:59:01.625 D/StatusBarManagerServiceEx(991): manageNaviBtnDisableList userId=0 what=0x0 pkg=WindowManager.LayoutParams
09-11 20:59:01.625 I/SystemUI[Framework](991): ==>disabledNaviBtn() what=0x0, [email protected], pkg=WindowManager.LayoutParams
09-11 20:59:01.625 I/SystemUI[Framework](991): disableNaviBtn: mDisabledNaviBtn=0x0, mDisableRecords.size=0
09-11 20:59:01.634 D/OpenGLRenderer(8765): endAllStagingAnimators on 0x9c8f9b00 (ListView) with handle 0xa9bf7ab0
09-11 20:59:01.651 D/SplitWindowPolicy(2528): updateActivityStateChanged: resumed=true, screenId=1, isScreenFull=true
09-11 20:59:01.651 D/SplitWindowPolicy(2528): topRunningActivity=ActivityInfo{2486729f co.....client.AppBoxClient}, taskId=4527, activityType=0, bIsSplit=false
09-11 20:59:01.718 I/AppUp4:AppBoxCP(8868): onCreate
09-11 20:59:01.719 W/AppUp4B(8868): [AppBoxDatabaseHelper] construct
09-11 20:59:01.732 I/AppUp4B(8868): setFingerPrint start
09-11 20:59:01.733 I/AppUp4B(8868): newfinger = lge/g3_bell_ca/g3:5.0.1/LRX21Y/150351852d88d:user/release-keys SDK version = 21
09-11 20:59:01.741 I/AppUp4B(8868): beforefinger = lge/g3_bell_ca/g3:5.0.1/LRX21Y/150351852d88d:user/release-keys
09-11 20:59:01.741 I/AppUp4B(8868): SDK version = 21
09-11 20:59:01.741 I/AppUp4B(8868): beforefinger == newfinger no write in DB
09-11 20:59:01.743 D/AppUp4:AppBoxApplication(8868): AppBoxApplication onCreate()
09-11 20:59:01.751 D/ContextHelper(8868): convertTheme. context->name=com.lge.appbox.client themeResourceId=34210242
09-11 20:59:01.753 V/AppUp4:AppBoxClient (8868): onCreate
09-11 20:59:01.757 I/AppUp4 (8868): +isLinkedUser : false
09-11 20:59:01.761 I/PhoneWindow(8868): [generateLayout] setColorNavigationBar => color=0x ff000001
09-11 20:59:01.771 D/PhoneWindowEx(8868): [PWEx][generateLayout] setNavigationBarColor2 : colors=0xff000000
09-11 20:59:01.771 I/PhoneWindow(8868): [setNavigationBarColor2] color=0x ff000000
09-11 20:59:01.771 I/ToolbarWidgetWrapper(8868): Progress display unsupported
09-11 20:59:01.788 E/PhoneWindow(8868): Circular progress bar not located in current window decor
09-11 20:59:01.789 I/AppUp4:MemoryCache(8868): MemoryCache will use up to 89.59999942779541MB
09-11 20:59:01.789 D/AppUp4:ImageLoader(8868): [ImageLoader] init with scale : 192 / context : [email protected]
09-11 20:59:01.795 E/AppUp4:EulaManager(8868): NameNotFoundException in isEulaForKitkat...
09-11 20:59:01.795 E/AppUp4:EulaManager(8868): android.content.pm.PackageManager$NameNotFoundException: com.lge.eula
09-11 20:59:01.795 E/AppUp4:EulaManager(8868): at android.app.ApplicationPackageManager.getPackageInfo(ApplicationPackageManager.java:114)
09-11 20:59:01.795 E/AppUp4:EulaManager(8868): at com.lge.appbox.manager.EulaManager.compareEulaVersion(EulaManager.java:86)
09-11 20:59:01.795 E/AppUp4:EulaManager(8868): at com.lge.appbox.manager.EulaManager.isEulaUI4_2Version(EulaManager.java:50)
09-11 20:59:01.795 E/AppUp4:EulaManager(8868): at com.lge.appbox.manager.EulaManager.getEulaAgreement(EulaManager.java:66)
09-11 20:59:01.795 E/AppUp4:EulaManager(8868): at com.lge.appbox.manager.EulaManager.initWithDeviceEulaInfo(EulaManager.java:54)
09-11 20:59:01.795 E/AppUp4:EulaManager(8868): at com.lge.appbox.client.AppBoxClient.onCreate(AppBoxClient.java:302)
09-11 20:59:01.795 E/AppUp4:EulaManager(8868): at android.app.Activity.performCreate(Activity.java:6020)
09-11 20:59:01.795 E/AppUp4:EulaManager(8868): at android.app.Instrumentation.callActivityOnCreate(Instrumentation.java:1105)
09-11 20:59:01.795 E/AppUp4:EulaManager(8868): at android.app.ActivityThread.performLaunchActivity(ActivityThread.java:2259)
09-11 20:59:01.795 E/AppUp4:EulaManager(8868): at android.app.ActivityThread.handleLaunchActivity(ActivityThread.java:2368)
09-11 20:59:01.795 E/AppUp4:EulaManager(8868): at android.app.ActivityThread.access$800(ActivityThread.java:149)
09-11 20:59:01.795 E/AppUp4:EulaManager(8868): at android.app.ActivityThread$H.handleMessage(ActivityThread.java:1284)
09-11 20:59:01.795 E/AppUp4:EulaManager(8868): at android.os.Handler.dispatchMessage(Handler.java:102)
09-11 20:59:01.795 E/AppUp4:EulaManager(8868): at android.os.Looper.loop(Looper.java:135)
09-11 20:59:01.795 E/AppUp4:EulaManager(8868): at android.app.ActivityThread.main(ActivityThread.java:5299)
09-11 20:59:01.795 E/AppUp4:EulaManager(8868): at java.lang.reflect.Method.invoke(Native Method)
09-11 20:59:01.795 E/AppUp4:EulaManager(8868): at java.lang.reflect.Method.invoke(Method.java:372)
09-11 20:59:01.795 E/AppUp4:EulaManager(8868): at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:908)
09-11 20:59:01.795 E/AppUp4:EulaManager(8868): at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:703)
09-11 20:59:01.796 E/ActivityThread(8868): Failed to find provider info for com.lge.eula.contentprovider
09-11 20:59:01.796 I/AppUp4:EulaManager(8868): getAgreementForKK : Eula agreement is false
09-11 20:59:01.799 V/AppUp4:AppBoxClient (8868): [clearFrgmentBackStack]***** onCreate back stack entryCount before : 0
09-11 20:59:01.800 V/AppUp4:AppBoxClient (8868): onStart with entryCount : 0
09-11 20:59:01.800 V/AppUp4:AppBoxClient (8868): onStart with mCurrentFragment : null
09-11 20:59:01.800 V/AppUp4:AppBoxClient (8868): onStart without mSelectedPackageName
09-11 20:59:01.803 V/AppUp4:AppBoxClient (8868): [onCreate] EULA not accepted and request EULA page
09-11 20:59:01.803 I/AppUp4:EulaManager(8868): [Activity] requestEulaPage.
09-11 20:59:01.804 E/AppUp4:EulaManager(8868): NameNotFoundException in isEulaForKitkat...
09-11 20:59:01.804 E/AppUp4:EulaManager(8868): android.content.pm.PackageManager$NameNotFoundException: com.lge.eula
09-11 20:59:01.804 E/AppUp4:EulaManager(8868): at android.app.ApplicationPackageManager.getPackageInfo(ApplicationPackageManager.java:114)
09-11 20:59:01.804 E/AppUp4:EulaManager(8868): at com.lge.appbox.manager.EulaManager.compareEulaVersion(EulaManager.java:86)
09-11 20:59:01.804 E/AppUp4:EulaManager(8868): at com.lge.appbox.manager.EulaManager.isEulaUI4_2Version(EulaManager.java:50)
09-11 20:59:01.804 E/AppUp4:EulaManager(8868): at com.lge.appbox.manager.EulaManager.showEULA(EulaManager.java:189)
09-11 20:59:01.804 E/AppUp4:EulaManager(8868): at com.lge.appbox.client.AppBoxClient.onCreate(AppBoxClient.java:317)
09-11 20:59:01.804 E/AppUp4:EulaManager(8868): at android.app.Activity.performCreate(Activity.java:6020)
09-11 20:59:01.804 E/AppUp4:EulaManager(8868): at android.app.Instrumentation.callActivityOnCreate(Instrumentation.java:1105)
09-11 20:59:01.804 E/AppUp4:EulaManager(8868): at android.app.ActivityThread.performLaunchActivity(ActivityThread.java:2259)
09-11 20:59:01.804 E/AppUp4:EulaManager(8868): at android.app.ActivityThread.handleLaunchActivity(ActivityThread.java:2368)
09-11 20:59:01.804 E/AppUp4:EulaManager(8868): at android.app.ActivityThread.access$800(ActivityThread.java:149)
09-11 20:59:01.804 E/AppUp4:EulaManager(8868): at android.app.ActivityThread$H.handleMessage(ActivityThread.java:1284)
09-11 20:59:01.804 E/AppUp4:EulaManager(8868): at android.os.Handler.dispatchMessage(Handler.java:102)
09-11 20:59:01.804 E/AppUp4:EulaManager(8868): at android.os.Looper.loop(Looper.java:135)
09-11 20:59:01.804 E/AppUp4:EulaManager(8868): at android.app.ActivityThread.main(ActivityThread.java:5299)
09-11 20:59:01.804 E/AppUp4:EulaManager(8868): at java.lang.reflect.Method.invoke(Native Method)
09-11 20:59:01.804 E/AppUp4:EulaManager(8868): at java.lang.reflect.Method.invoke(Method.java:372)
09-11 20:59:01.804 E/AppUp4:EulaManager(8868): at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:908)
09-11 20:59:01.804 E/AppUp4:EulaManager(8868): at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:703)
09-11 20:59:01.805 I/Timeline(8868): Timeline: Activity_launch_request id:com.lge.eula time:586731
09-11 20:59:01.805 I/ActivityManager(991): START u0 {cmp=com.lge.eula/.UnifiedEula (has extras)} from uid 10011 on display 0
09-11 20:59:01.806 D/AndroidRuntime(8868): Shutting down VM
09-11 20:59:01.806 E/AndroidRuntime(8868): FATAL EXCEPTION: main
09-11 20:59:01.806 E/AndroidRuntime(8868): Process: com.lge.appbox.client, PID: 8868
09-11 20:59:01.806 E/AndroidRuntime(8868): java.lang.RuntimeException: Unable to start activity ComponentInfo{com.lge.appbox.client/com.lge.appbox.client.AppBoxClient}: android.content.ActivityNotFoundException: Unable to find explicit activity class {com.lge.eula/com.lge.eula.UnifiedEula}; have you declared this activity in your AndroidManifest.xml?
09-11 20:59:01.806 E/AndroidRuntime(8868): at android.app.ActivityThread.performLaunchActivity(ActivityThread.java:2306)
09-11 20:59:01.806 E/AndroidRuntime(8868): at android.app.ActivityThread.handleLaunchActivity(ActivityThread.java:2368)
09-11 20:59:01.806 E/AndroidRuntime(8868): at android.app.ActivityThread.access$800(ActivityThread.java:149)
09-11 20:59:01.806 E/AndroidRuntime(8868): at android.app.ActivityThread$H.handleMessage(ActivityThread.java:1284)
09-11 20:59:01.806 E/AndroidRuntime(8868): at android.os.Handler.dispatchMessage(Handler.java:102)
09-11 20:59:01.806 E/AndroidRuntime(8868): at android.os.Looper.loop(Looper.java:135)
09-11 20:59:01.806 E/AndroidRuntime(8868): at android.app.ActivityThread.main(ActivityThread.java:5299)
09-11 20:59:01.806 E/AndroidRuntime(8868): at java.lang.reflect.Method.invoke(Native Method)
09-11 20:59:01.806 E/AndroidRuntime(8868): at java.lang.reflect.Method.invoke(Method.java:372)
09-11 20:59:01.806 E/AndroidRuntime(8868): at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:908)
09-11 20:59:01.806 E/AndroidRuntime(8868): at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:703)
09-11 20:59:01.806 E/AndroidRuntime(8868): Caused by: android.content.ActivityNotFoundException: Unable to find explicit activity class {com.lge.eula/com.lge.eula.UnifiedEula}; have you declared this activity in your AndroidManifest.xml?
09-11 20:59:01.806 E/AndroidRuntime(8868): at android.app.Instrumentation.checkStartActivityResult(Instrumentation.java:1761)
09-11 20:59:01.806 E/AndroidRuntime(8868): at android.app.Instrumentation.execStartActivity(Instrumentation.java:1485)
09-11 20:59:01.806 E/AndroidRuntime(8868): at android.app.Activity.startActivityForResult(Activity.java:3823)
09-11 20:59:01.806 E/AndroidRuntime(8868): at android.app.Activity.startActivityForResult(Activity.java:3784)
09-11 20:59:01.806 E/AndroidRuntime(8868): at com.lge.appbox.manager.EulaManager.showEULA(EulaManager.java:196)
09-11 20:59:01.806 E/AndroidRuntime(8868): at com.lge.appbox.client.AppBoxClient.onCreate(AppBoxClient.java:317)
09-11 20:59:01.806 E/AndroidRuntime(8868): at android.app.Activity.performCreate(Activity.java:6020)
09-11 20:59:01.806 E/AndroidRuntime(8868): at android.app.Instrumentation.callActivityOnCreate(Instrumentation.java:1105)
09-11 20:59:01.806 E/AndroidRuntime(8868): at android.app.ActivityThread.performLaunchActivity(ActivityThread.java:2259)
09-11 20:59:01.806 E/AndroidRuntime(8868): ... 10 more
09-11 20:59:01.808 W/ActivityManager(991): Force finishing activity com.lge.appbox.client/.AppBoxClient
09-11 20:59:02.113 I/WindowManager(991): Screenshot max retries 4 of Token{c1ee7db ActivityRecord{ac228ea u0 com.lge.appbox.client/.AppBoxClient t4527 f}} appWin=Window{2111e9b6 u0 Starting com.lge.appbox.client} drawState=4
09-11 20:59:02.114 E/ActivityManager(991): Invalid thumbnail dimensions: 768x768
09-11 20:59:02.116 W/ActivityManager(991): Force finishing activity com.lge.updatecenter/.UpdateCenterPrfActivity
09-11 20:59:02.123 D/SplitWindowPolicy(2528): updateActivityStateChanged: resumed=false, screenId=1, isScreenFull=true
09-11 20:59:02.124 D/SplitWindowPolicy(2528): topRunningActivity=ActivityInfo{a256fec co.....client.AppBoxClient}, taskId=4527, activityType=0, bIsSplit=false
09-11 20:59:02.140 I/PhoneWindow(991): [generateLayout] setColorNavigationBar => color=0x ff000001
09-11 20:59:02.142 D/PhoneWindowEx(991): [PWEx][generateLayout] setNavigationBarColor2 : colors=0xff000000
09-11 20:59:02.142 I/PhoneWindow(991): [setNavigationBarColor2] color=0x ff000000
09-11 20:59:02.154 I/Adreno-EGL(991): <qeglDrvAPI_eglInitialize:410>: EGL 1.4 QUALCOMM build: ()
09-11 20:59:02.154 I/Adreno-EGL(991): OpenGL ES Shader Compiler Version: E031.25.03.00
09-11 20:59:02.154 I/Adreno-EGL(991): Build Date: 12/24/14 Wed
09-11 20:59:02.154 I/Adreno-EGL(991): Local Branch: LA.BF.1.1.1_RB1_AU001_20141224_1077123
09-11 20:59:02.154 I/Adreno-EGL(991): Remote Branch:
09-11 20:59:02.154 I/Adreno-EGL(991): Local Patches:
09-11 20:59:02.154 I/Adreno-EGL(991): Reconstruct Branch:
09-11 20:59:02.154 I/OpenGLRenderer(991): Initialized EGL, version 1.4
09-11 20:59:02.161 D/SplitWindow(991): check instance of lgWin Window{188a73fd u0 Application Error: com.lge.appbox.client}
09-11 20:59:02.162 D/WindowManager(991): [PWM]2.notifyNavigationBarColor => Color.TRANSPARENT
09-11 20:59:02.163 I/[SystemUI]NavigationThemeResource(2025): notify navigation bar color(0x0)
09-11 20:59:02.163 I/[SystemUI]NavigationThemeResource(2025): NavigationKey Color is changed(WHITE -> WHITE_WITH_SHADOW)
09-11 20:59:02.163 I/[SystemUI]NavigationThemeResource(2025): BarMode=4, Theme=BLACK, LightBackground=false (Transparent)
09-11 20:59:02.163 I/[SystemUI]NavigationThemeResource(2025): , Keyguard show=false, IME shown=false, Panel expanded=false
09-11 20:59:02.165 I/SystemUI[Framework](991): PhoneWindowManager.updateSystemUiVisibilityLw() :visibility=0x8000, pkg=android
09-11 20:59:02.166 D/PhoneStatusBar(2025): setSystemUiVisibility vis=8000 mask=ffffffff oldVal=8600 newVal=8000 diff=600
09-11 20:59:02.166 W/PhoneWindowManagerEx(991): Call!!!getLGSystemUiVisibility. =0x0
09-11 20:59:02.166 D/StatusBarManagerServiceEx(991): setLGSystemUiVisibility(0x0)
09-11 20:59:02.168 D/StatusBarManagerServiceEx(991): manageNaviBtnDisableList userId=0 what=0x0 pkg=WindowManager.LayoutParams
09-11 20:59:02.168 I/SystemUI[Framework](991): ==>disabledNaviBtn() what=0x0, [email protected], pkg=WindowManager.LayoutParams
09-11 20:59:02.168 I/SystemUI[Framework](991): disableNaviBtn: mDisabledNaviBtn=0x0, mDisableRecords.size=0
09-11 20:59:02.173 D/InputDispatcher(991): Focus entered window: Window{188a73fd u0 Application Error: com.lge.appbox.client}
09-11 20:59:02.617 W/ActivityManager(991): Activity pause timeout for ActivityRecord{ac228ea u0 com.lge.appbox.client/.AppBoxClient t4527 f}
09-11 20:59:02.665 I/NotificationManager(991): android: cancel(1000) by android
09-11 20:59:02.685 D/SplitWindowPolicy(2528): updateActivityStateChanged: resumed=true, screenId=1, isScreenFull=true
09-11 20:59:02.686 D/SplitWindowPolicy(2528): topRunningActivity=ActivityInfo{3692bfb5 co.....SubSettings}, taskId=4520, activityType=0, bIsSplit=false
09-11 20:59:02.709 D/kjo (5897): registerReceiver
09-11 20:59:02.709 D/aboutphone # DeviceInfoLge(5897): onResume()
09-11 20:59:02.710 D/Utils (5897): value : 1435420529135, N
09-11 20:59:02.710 D/aboutphone # DeviceInfoLge(5897): isLogInfomationOn -> unchecked
09-11 20:59:02.765 W/Utils (5897): checkPackage() : package is not found(com.kddi.android.au_setting_menu)
09-11 20:59:02.765 I/Settings(5897): Remove au settings category
09-11 20:59:02.766 W/Utils (5897): checkPackage() : package is not found(com.kddi.android.au_setting_menu)
09-11 20:59:02.766 I/Settings(5897): Remove au settings menj
09-11 20:59:02.774 I/Settings : (5897): Settings.java[1464] : not supported the use 4g network
09-11 20:59:02.776 D/hkk (5897): [checkRcsDB] operator : BELL
09-11 20:59:02.776 D/hkk (5897): [checkRcsDB] country : CA
09-11 20:59:02.776 D/hkk (5897): [checkRcsDB] rcs_working : null
09-11 20:59:02.777 E/ActivityThread(5897): Failed to find provider info for com.lge.ims.provisioning
09-11 20:59:02.777 D/kimyow (5897): CONTENT_URIcontent://com.lge.ims.provisioning/workings
09-11 20:59:02.778 E/ActivityThread(5897): Failed to find provider info for com.lge.ims.rcs
09-11 20:59:02.778 D/kimyow (5897): CONTENT_URI_BBcontent://com.lge.ims.rcs/device
09-11 20:59:02.778 D/kimyow (5897): R.id.rcs_setting : objCursor==null
09-11 20:59:02.781 W/System.err(5897): Removed 2131691063
09-11 20:59:02.789 W/Utils (5897): checkPackage() : package is not found(com.skt.taction)
09-11 20:59:02.795 I/displaysizeinfo(5897): width :2.677167
09-11 20:59:02.795 I/displaysizeinfo(5897): height :4.724415
09-11 20:59:02.796 I/displaysizeinfo(5897): displaysize :29.487318
09-11 20:59:02.796 I/displaysizeinfo(5897): lcdsize :5.430222650954603
09-11 20:59:02.797 W/Utils (5897): checkPackage() : package is not found(com.skt.t_smart_charge)
09-11 20:59:02.798 W/Utils (5897): checkPackage() : package is not found(com.lge.springcleaning)
09-11 20:59:02.805 D/Settings(5897): mPhone.getPhoneType() = 1
09-11 20:59:02.805 D/Settings(5897): mPhone.isSmsCapable() = true
09-11 20:59:02.805 D/Settings(5897): isSMSsupported = true
09-11 20:59:02.810 D/Utils (5897): FEATURE_NFC_HOST_CARD_EMULATION = true
09-11 20:59:02.811 D/Utils (5897): else remove tap&pay
09-11 20:59:02.811 I/Settings(5897): Remove tap&pay
09-11 20:59:02.812 W/System.err(5897): Removed 2131691088
09-11 20:59:02.813 W/Utils (5897): checkPackage() : package is not found(jp.co.yahoo.android.ybox)
09-11 20:59:02.815 W/System.err(5897): java.lang.NoSuchFieldException: CAPP_MYFOLDER
09-11 20:59:02.816 W/System.err(5897): at java.lang.Class.getField(Class.java:1048)
09-11 20:59:02.816 W/System.err(5897): at com.android.settings.Utils.isSupportMyRoom(Utils.java:2966)
09-11 20:59:02.816 W/System.err(5897): at com.android.settings.Settings.updateHeaderList(Settings.java:1683)
09-11 20:59:02.816 W/System.err(5897): at com.android.settings.Settings.onBuildHeaders(Settings.java:1364)
09-11 20:59:02.816 W/System.err(5897): at android.preference.PreferenceActivity$1.handleMessage(PreferenceActivity.java:235)
09-11 20:59:02.816 W/System.err(5897): at android.os.Handler.dispatchMessage(Handler.java:102)
09-11 20:59:02.816 W/System.err(5897): at android.os.Looper.loop(Looper.java:135)
09-11 20:59:02.816 W/System.err(5897): at android.app.ActivityThread.main(ActivityThread.java:5299)
09-11 20:59:02.816 W/System.err(5897): at java.lang.reflect.Method.invoke(Native Method)
09-11 20:59:02.816 W/System.err(5897): at java.lang.reflect.Method.invoke(Method.java:372)
09-11 20:59:02.816 W/System.err(5897): at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:908)
09-11 20:59:02.816 W/System.err(5897): at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:703)
09-11 20:59:02.827 D/Utils (5897): guestModeEnable: true
09-11 20:59:02.831 I/Settings(5897): Remove native accessibility
09-11 20:59:02.835 W/Utils (5897): checkPackage() : package is not found(com.lge.carhome)
09-11 20:59:02.835 W/Utils (5897): checkPackage() : package is not found(com.lge.tangible)
09-11 20:59:02.838 W/Utils (5897): checkPackage() : package is not found(com.lge.tangible)
09-11 20:59:02.840 W/Utils (5897): checkPackage() : package is not found(com.lge.carhome)
09-11 20:59:02.841 D/YSY (5897): QuickCircle case
09-11 20:59:02.841 D/development(5897): mHideDev = false
09-11 20:59:02.841 D/development(5897): showDev = true
09-11 20:59:02.844 D/aboutphone(5897): about_settings, removed !
09-11 20:59:02.845 D/aboutphone(5897): system_update_settings, removed !
09-11 20:59:02.845 W/Utils (5897): checkPackage() : package is not found(com.innopath.activecare)
09-11 20:59:02.845 D/aboutphone(5897): com.innopath.activecare checkPackage = false, removed !
09-11 20:59:02.846 D/aboutphone(5897): isUI_4_1_model = true, removed !
09-11 20:59:02.846 D/aboutphone(5897): system_update_settings, removed !
09-11 20:59:02.868 I/Timeline(5897): Timeline: Activity_idle id: [email protected] time:587795
09-11 20:59:02.941 D/InputDispatcher(991): Window went away: Window{1064ef63 u0 com.lge.updatecenter/com.lge.updatecenter.UpdateCenterPrfActivity}
09-11 20:59:02.996 I/Timeline(991): Timeline: Activity_windows_visible id: ActivityRecord{2ed7eeb1 u0 com.android.settings/.SubSettings t4520} time:587923
09-11 20:59:04.102 E/GBMv2 (357): DFP En is all cleared set to be enabled
09-11 20:59:04.102 E/GBMv2 (357): Set value is all cleared set the max
09-11 20:59:04.102 I/GBMv2 (357): DFP Enabled. Ignore VFP set
09-11 20:59:06.396 V/sensors_hal_Light(991): processReportInd: e0000 14.000000
09-11 20:59:12.882 W/ActivityManager(991): Activity destroy timeout for ActivityRecord{ac228ea u0 com.lge.appbox.client/.AppBoxClient t4527 f}
09-11 20:59:16.384 D/TaskPersister(991): removeObsoleteFile: deleting file=4527_task.xml
Click to expand...
Click to collapse
I updated my htc 10 firmware via one of the NoWipe firmware files from a nougat fw to the Oreo one (3.401.2) a few months ago and flashed the Pyrana Rom shortly afterwards. I had issues playing back m4a (aac) files trough various music players and playing offline tidal songs. Usually there is no sound whatsoever with these files while offline mp3s and FLACs work flawlessly, but if I try often enough by closing and reopening the app it plays the file back after a few tries.
At first I thought it was an issue with the ROM but I switched to LeeDroid recently and the issue is still persisting.
According to logcat it seems the device has issues with something called hph-highquality-mode,it "can't find backend to snd device" and then ACBD dies. I've no idea how audio processing works on android, but this should should be the interesting part from logcat:
Code:
06-06 21:26:16.378 944 3995 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.379 824 1336 E audio_hw_primary: out_set_volume: compress mute 0
06-06 21:26:16.379 824 1336 E audio_hw_primary: out_set_compr_volume:ctl for mixer cmd - Compress Playback 9 Volume, left 0.006310, right 0.006310
06-06 21:26:16.380 944 26907 D AudioFlinger: Set Offload Audio Balance L(0.006310) R(0.006310)
06-06 21:26:16.384 944 18976 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.385 944 3895 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.394 824 26917 D audio_hw_primary: start_output_stream: enter: stream(0xe980f500)usecase(3: compress-offload-playback) devices(0x4)
[trash-data]
06-06 21:26:16.397 944 18976 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.410 824 26917 D audio_hw_primary: select_devices for use case (compress-offload-playback)
06-06 21:26:16.410 824 26917 D audio_hw_extn: audio_extn_get_anc_enabled: anc_enabled:0
06-06 21:26:16.410 824 26917 D audio_hw_primary: select_devices: out_snd_device(8: headphones) in_snd_device(0: )
06-06 21:26:16.411 824 26917 I msm8974_platform: platform_check_and_set_codec_backend_cfg:becf: afe: bitwidth 24, samplerate 44100 channels 2, backend_idx 3 usecase = 3 device (headphones)
06-06 21:26:16.411 824 26917 D msm8974_platform: platform_split_snd_device: snd_device(8) num devices(1) new_snd_devices(0)
06-06 21:26:16.411 824 26917 I msm8974_platform: platform_check_and_set_codec_backend_cfg: new_snd_devices[0] is 8
06-06 21:26:16.411 824 26917 I msm8974_platform: platform_check_codec_backend_cfg:becf: afe: bitwidth 24, samplerate 44100 channels 2, backend_idx 3 usecase = 3 device (headphones)
06-06 21:26:16.411 824 26917 D msm8974_platform: platform_check_codec_backend_cfg:becf: afe: napb not active - set non fractional rate
06-06 21:26:16.411 824 26917 I msm8974_platform: platform_check_codec_backend_cfg:becf: afe: Codec selected backend: 3 updated bit width: 24 and sample rate: 48000
06-06 21:26:16.411 824 26917 I msm8974_platform: platform_check_codec_backend_cfg: apply HPH HQ mode
06-06 21:26:16.411 824 26917 E audio_route: unable to find path 'hph-highquality-mode'
06-06 21:26:16.411 824 26917 D audio_hw_primary: check_usecases_codec_backend:becf: force routing 0
06-06 21:26:16.411 824 26917 E msm8974_platform: platform_check_backends_match: Invalid snd_device =
06-06 21:26:16.411 824 26917 D audio_hw_primary: check_usecases_codec_backend:becf: (47) check_usecases curr device: headphones, usecase device: backends match 0
06-06 21:26:16.411 824 26917 E msm8974_platform: platform_check_backends_match: Invalid snd_device =
06-06 21:26:16.411 824 26917 D audio_hw_primary: check_usecases_codec_backend:becf: (47) check_usecases curr device: headphones, usecase device: backends match 0
06-06 21:26:16.411 824 26917 D audio_hw_primary: check_usecases_codec_backend:becf: check_usecases num.of Usecases to switch 0
06-06 21:26:16.411 824 26917 D hardware_info: hw_info_append_hw_type : device_name = headphones
06-06 21:26:16.411 824 26917 D msm8974_platform: platform_split_snd_device: snd_device(8) num devices(0) new_snd_devices(0)
06-06 21:26:16.411 824 26917 D audio_hw_primary: enable_snd_device: snd_device(8: headphones)
06-06 21:26:16.411 824 26917 I soundtrigger: audio_extn_sound_trigger_update_device_status: device 0x8 of type 0 for Event 1, with Raise=0
06-06 21:26:16.412 3028 3087 I zygote : NativeAllocBackground concurrent copying GC freed 14838(616KB) AllocSpace objects, 0(0B) LOS objects, 67% free, 2MB/8MB, paused 11.885ms total 176.926ms
06-06 21:26:16.428 1930 1930 I StatusBar: updateEmptyShade(true,true)
06-06 21:26:16.428 1930 1930 I StackScroller: setBlockTouch:false
06-06 21:26:16.430 824 26917 D audio_route: set ctl: SLIM RX1 MUX enum[0]: 6
06-06 21:26:16.431 824 26917 D audio_route: set ctl: SLIM_0_RX Channels enum[0]: 1
06-06 21:26:16.435 3020 3059 I zygote : NativeAllocBackground concurrent copying GC freed 23044(1676KB) AllocSpace objects, 0(0B) LOS objects, 71% free, 2MB/8MB, paused 8.924ms total 145.389ms
06-06 21:26:16.442 824 26917 D audio_route: set ctl: RX INT1_2 MUX enum[0]: 1
06-06 21:26:16.444 824 26917 D audio_route: set ctl: RX INT2_2 MUX enum[0]: 2
06-06 21:26:16.445 824 26917 D audio_route: set ctl COMP1 Switch, integer[0]
06-06 21:26:16.445 824 26917 D audio_route: set ctl COMP2 Switch, integer[0]
06-06 21:26:16.445 824 26917 D audio_hw_primary: enable_audio_route: enter: usecase(3)
06-06 21:26:16.445 824 26917 E audio_hw_dolby: audio_extn_dolby_ds2_set_endpoint: Dolby set endpint :0x4
06-06 21:26:16.445 824 26917 D soundtrigger: audio_extn_sound_trigger_update_stream_status: uc_id 3 of type 0 for Event 3, with Raise=1
06-06 21:26:16.445 824 26917 D sound_trigger_platform: platform_stdev_check_and_update_concurrency: concurrency active 0, tx 1, rx 1, concurrency session_allowed 0
06-06 21:26:16.445 824 26917 D audio_hw_utils: audio_extn_utils_send_app_type_cfg: usecase->out_snd_device headphones
06-06 21:26:16.445 824 26917 D msm8974_platform: platform_split_snd_device: snd_device(8) num devices(0) new_snd_devices(0)
06-06 21:26:16.445 824 26917 E msm8974_platform: platform_get_snd_device_backend_index: BE DAI Name Table is not present
06-06 21:26:16.445 824 26917 E audio_hw_utils: send_app_type_cfg_for_device: Couldn't get the backend index for snd device headphones ret=-14
06-06 21:26:16.445 824 26917 I audio_hw_utils: send_app_type_cfg_for_device PLAYBACK app_type 69936, acdb_dev_id 10, sample_rate 48000, snd_device_be_idx -14
06-06 21:26:16.446 824 26917 D msm8974_platform: platform_split_snd_device: snd_device(8) num devices(1) new_snd_devices(0)
06-06 21:26:16.446 824 26917 D ACDB-LOADER: ACDB -> send_audio_cal, acdb_id = 10, path = 0, app id = 0x11130, sample rate = 48000
06-06 21:26:16.446 824 26917 D ACDB-LOADER: ACDB -> send_asm_topology
06-06 21:26:16.446 824 26917 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_STREAM_TOPOLOGY_ID
06-06 21:26:16.446 824 26917 D ACDB-LOADER: ACDB -> send_adm_topology
06-06 21:26:16.446 824 26917 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_COMMON_TOPOLOGY_ID
06-06 21:26:16.446 824 26917 D ACDB-LOADER: ACDB -> send_audtable
06-06 21:26:16.446 824 26917 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_COMMON_TABLE_SIZE
06-06 21:26:16.446 824 26917 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_COMMON_TABLE
06-06 21:26:16.446 824 26917 D ACDB-LOADER: ACDB -> AUDIO_SET_AUDPROC_CAL
06-06 21:26:16.446 824 26917 D ACDB-LOADER: ACDB -> send_audvoltable
06-06 21:26:16.446 824 26917 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_VOL_STEP_TABLE_SIZE
06-06 21:26:16.447 824 26917 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_GAIN_DEP_STEP_TABLE, vol index 0
06-06 21:26:16.447 824 26917 D : Failed to fetch the lookup information of the device 0000000A
06-06 21:26:16.447 824 26917 E ACDB-LOADER: Error: ACDB AudProc vol returned = -19
06-06 21:26:16.447 824 26917 D ACDB-LOADER: ACDB -> AUDIO_SET_VOL_CAL cal type = 12
06-06 21:26:16.447 824 26917 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_STREAM_TABLE_SIZE
06-06 21:26:16.447 824 26917 D ACDB-LOADER: ACDB -> send_audstrmtable
06-06 21:26:16.447 824 26917 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_STREAM_TABLE_V2
06-06 21:26:16.447 824 26917 D ACDB-LOADER: ACDB -> audstrm_cal->cal_type.cal_data.cal_size = 456
06-06 21:26:16.447 824 26917 D ACDB-LOADER: ACDB -> send_afe_topology
06-06 21:26:16.447 824 26917 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_TOPOLOGY_ID
06-06 21:26:16.447 824 26917 D ACDB-LOADER: ACDB -> GET_AFE_TOPOLOGY_ID for adcd_id 10, Topology Id 112fc
06-06 21:26:16.447 824 26917 D ACDB-LOADER: ACDB -> send_afe_cal
06-06 21:26:16.447 824 26917 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_COMMON_TABLE_SIZE
06-06 21:26:16.447 824 26917 D : Failed to fetch the lookup information of the device 0000000A
06-06 21:26:16.447 824 26917 E ACDB-LOADER: Error: ACDB_CMD_GET_AFE_COMMON_TABLE_SIZE Returned = -19
06-06 21:26:16.447 824 26917 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_COMMON_TABLE
06-06 21:26:16.447 824 26917 D : Failed to fetch the lookup information of the device 0000000A
06-06 21:26:16.447 824 26917 E ACDB-LOADER: Error: ACDB AFE returned = -19
06-06 21:26:16.447 824 26917 D ACDB-LOADER: ACDB -> AUDIO_SET_AFE_CAL
06-06 21:26:16.447 824 26917 D ACDB-LOADER: ACDB -> send_hw_delay : acdb_id = 10 path = 0
06-06 21:26:16.447 824 26917 D ACDB-LOADER: ACDB -> ACDB_AVSYNC_INFO: ACDB_CMD_GET_DEVICE_PROPERTY
06-06 21:26:16.447 824 26917 D audio_hw_primary: enable_audio_route: apply mixer and update path: compress-offload-playback headphones
06-06 21:26:16.450 824 26917 D audio_route: set ctl SLIMBUS_0_RX Audio Mixer MultiMedia4, integer[0]
06-06 21:26:16.450 824 26917 D audio_hw_primary: enable_audio_route: exit
06-06 21:26:16.450 824 26917 D audio_hw_primary: select_devices: done
06-06 21:26:16.450 824 26917 D audio_hw_primary: start_output_stream: Opening PCM device card_id(0) device_id(9) format(0)
06-06 21:26:16.450 824 26917 D msm8974_platform: platform_set_channel_map mixer_ctl_name:Playback Channel Map9
06-06 21:26:16.450 824 26917 D msm8974_platform: platform_set_channel_map: set mapping(1 2 0 0 0 0 0 0) for channel:2
06-06 21:26:16.452 26850 26850 V MediaPlayerNative: isPlaying: 1
06-06 21:26:16.493 939 964 V /system/vendor/bin/adsprpcd: vendor/qcom/proprietary/adsprpc/src/apps_std_imp.c:194: fopen success: /dsp/HeaacDecoderModule.so.1
06-06 21:26:16.521 1234 1244 I zygote64: Background concurrent copying GC freed 17846(1094KB) AllocSpace objects, 1(20KB) LOS objects, 42% free, 26MB/47MB, paused 1.269ms total 624.204ms
06-06 21:26:16.550 837 1749 I CwMcuSensor: offset changed, id = 0, offset = -20688488974
06-06 21:26:16.565 824 26917 E audio_hw_primary: start_output_stream: cannot set device: Out of memory
06-06 21:26:16.565 845 1184 I ANDR-PERF-MPCTL: perfRel: handle = 2470
06-06 21:26:16.565 845 1184 I ANDR-PERF-PNPUTIL: (Basic) Recv '/sys/devices/system/cpu/cpu0/cpufreq/scaling_min_freq' = '307200'
06-06 21:26:16.565 824 26917 W offload_visualizer: visualizer_hal_stop_output output not started
06-06 21:26:16.565 824 26917 W offload_effect_bundle: offload_effects_bundle_hal_stop_output output not started
06-06 21:26:16.565 824 26917 D audio_hw_primary: disable_audio_route: enter: usecase(3)
06-06 21:26:16.565 824 26917 D audio_hw_primary: disable_audio_route: reset and update mixer path: compress-offload-playback headphones
[trash]
06-06 21:26:16.566 824 26917 D audio_route: set ctl SLIMBUS_0_RX Audio Mixer MultiMedia4, integer[0]
06-06 21:26:16.566 824 26917 D soundtrigger: audio_extn_sound_trigger_update_stream_status: uc_id 3 of type 0 for Event 2, with Raise=1
06-06 21:26:16.566 824 26917 D sound_trigger_platform: platform_stdev_check_and_update_concurrency: concurrency active 0, tx 1, rx 0, concurrency session_allowed 0
06-06 21:26:16.566 845 1184 I ANDR-PERF-PNPUTIL: Write '/sys/devices/system/cpu/cpu0/cpufreq/scaling_min_freq' = '960000' <Rule: long duration input boost>
06-06 21:26:16.566 824 26917 D audio_hw_primary: disable_audio_route: exit
06-06 21:26:16.567 824 26917 D hardware_info: hw_info_append_hw_type : device_name = headphones
06-06 21:26:16.567 824 26917 D audio_hw_primary: disable_snd_device: snd_device(8: headphones)
06-06 21:26:16.567 824 26917 D msm8974_platform: platform_split_snd_device: snd_device(8) num devices(0) new_snd_devices(0)
06-06 21:26:16.567 845 1184 I ANDR-PERF-PNPUTIL: Write '/sys/devices/system/cpu/cpu1/cpufreq/scaling_min_freq' = '960000' <Rule: long duration input boost>
06-06 21:26:16.567 824 26917 D audio_route: set ctl COMP2 Switch, integer[0]
06-06 21:26:16.567 845 1184 W ANDR-PERF-PNPUTIL: Unable to open '/sys/block/dm-0/bdi/read_ahead_kb' (No such file or directory)
06-06 21:26:16.567 845 1184 W ANDR-PERF-PNPUTIL: Unable to open '/sys/block/dm-1/bdi/read_ahead_kb' (No such file or directory)
06-06 21:26:16.567 824 26917 D audio_route: set ctl COMP1 Switch, integer[0]
06-06 21:26:16.571 824 26917 D audio_route: set ctl: RX INT2_2 MUX enum[0]: 0
06-06 21:26:16.574 824 26917 D audio_route: set ctl: RX INT1_2 MUX enum[0]: 0
06-06 21:26:16.575 824 26917 D audio_route: set ctl: SLIM_0_RX Channels enum[0]: 0
06-06 21:26:16.577 824 26917 D audio_route: set ctl: SLIM RX1 MUX enum[0]: 0
06-06 21:26:16.577 824 26917 I soundtrigger: audio_extn_sound_trigger_update_device_status: device 0x8 of type 0 for Event 0, with Raise=0
06-06 21:26:16.595 26850 26850 V MediaPlayerNative: isPlaying: 1
06-06 21:26:16.618 837 837 I CwMcuSensor: offset changed, id = 8, offset = -20688488974
06-06 21:26:16.624 1930 1930 I StatusBar: updateEmptyShade(true,true)
06-06 21:26:16.625 1930 1930 I StackScroller: setBlockTouch:false
06-06 21:26:16.628 944 3995 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.639 944 944 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.639 1930 1930 I StatusBar: updateEmptyShade(true,true)
06-06 21:26:16.640 1930 1930 I StackScroller: setBlockTouch:false
06-06 21:26:16.640 944 3995 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.644 1930 1930 W StaticLayout: maxLineHeight should not be -1. maxLines:1 lineCount:1
06-06 21:26:16.645 1930 1930 I chatty : uid=10021(u0_a21) com.android.systemui identical 2 lines
06-06 21:26:16.646 1930 1930 W StaticLayout: maxLineHeight should not be -1. maxLines:1 lineCount:1
06-06 21:26:16.648 824 1810 E audio_hw_primary: out_set_volume: compress mute 0
06-06 21:26:16.648 824 1810 E audio_hw_primary: out_set_compr_volume:ctl for mixer cmd - Compress Playback 9 Volume, left 0.006310, right 0.006310
06-06 21:26:16.649 944 26907 D AudioFlinger: Set Offload Audio Balance L(0.006310) R(0.006310)
06-06 21:26:16.651 944 944 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.652 944 3895 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.661 1930 1940 I zygote64: JIT added (osr=false) void com.android.systemui.statusbar.stack.NotificationStackScrollLayout.updateScrollPositionOnExpandInBottom(com.android.systemui.statusbar.ExpandableView)@0x776474e1e8 ccache_size=1628KB: dcache_size=998KB: 0x99e137b0,0x99e141b4
06-06 21:26:16.663 944 944 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.664 944 3895 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.675 944 944 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.685 837 1749 I CwMcuSensor: processEvent: Reporting mPendingEvent.light = 1.000 18.000
06-06 21:26:16.685 837 1749 I CwMcuSensor: offset changed, id = 3, offset = -20688488974
06-06 21:26:16.686 944 944 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.687 944 944 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.698 944 3895 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.699 944 944 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.700 1234 1775 V NetworkPolicy: updateRuleForRestrictBackgroundUL(10019): isForeground=false, isBlacklisted=false, isWhitelisted=true, oldRule=2 (TEMPORARY_ALLOW_METERED), newRule=0 (NONE), newUidRules=0 (NONE), oldUidRules=2 (TEMPORARY_ALLOW_METERED)
06-06 21:26:16.700 1234 1775 V NetworkPolicy: setMeteredNetworkWhitelist 10019: false
06-06 21:26:16.701 641 715 V CommandListener: bwctrlcmd: argc=3 bandwidth removeniceapps ...
06-06 21:26:16.705 1234 1775 V NetworkPolicy: setMeteredNetworkBlacklist 10019: false
06-06 21:26:16.706 1234 1775 V NetworkPolicy: updateRulesForPowerRestrictionsUL(10019), isIdle: false, mRestrictPower: false, mDeviceIdleMode: false, isForeground=false, isWhitelisted=true, oldRule=0 (NONE), newRule=0 (NONE), newUidRules=0 (NONE), oldUidRules=0 (NONE)
06-06 21:26:16.710 944 3895 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.711 944 3995 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.722 944 3995 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.723 944 3895 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.734 944 3995 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.735 944 3895 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.747 944 3995 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.753 26850 26850 V MediaPlayerNative: isPlaying: 1
06-06 21:26:16.756 26850 26850 V MediaPlayerNative: isPlaying: 1
06-06 21:26:16.758 944 3995 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.758 944 3895 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.769 944 3995 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.770 944 3895 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.781 944 3995 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.782 944 3895 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.793 944 3895 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.793 944 3995 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.805 944 3895 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.806 944 944 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.818 944 944 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.818 944 3895 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.829 944 944 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.830 944 3895 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.842 944 944 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.843 944 3895 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.856 944 3895 I chatty : uid=1041(audioserver) Binder:944_4 identical 2 lines
06-06 21:26:16.868 944 3895 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.869 944 944 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.881 944 944 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.882 944 3895 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.893 944 944 D IAudioTrack: onTransact(), code=9
06-06 21:26:16.905 824 26917 D audio_hw_primary: start_output_stream: enter: stream(0xe980f500)usecase(3: compress-offload-playback) devices(0x4)
06-06 21:26:16.905 944 3895 D IAudioTrack: onTransact(), code=9
The DSP also returns error messages in dmesg. Here is the output of dmesg | grep AUD:
Code:
htc_pmeuhl:/ # dmesg | grep AUD
[ 4242.131633] [AUD] q6asm: q6asm_callback: cmd = 0x10db3 returned error = 0x1
[ 4242.131702] [AUD] q6asm: __q6asm_open_write: DSP returned error[ADSP_EFAILED]
[ 4242.131720] [AUD] snd_soc_qdsp6v2: msm_compr_configure_dsp_for_playback:ASM open write err[-131] for compr type[0]
[ 4242.570646] [AUD] q6asm: q6asm_callback: cmd = 0x10db3 returned error = 0x1
[ 4242.570717] [AUD] q6asm: __q6asm_open_write: DSP returned error[ADSP_EFAILED]
[ 4242.570734] [AUD] snd_soc_qdsp6v2: msm_compr_configure_dsp_for_playback:ASM open write err[-131] for compr type[0]
[ 4243.028382] [AUD] q6asm: q6asm_callback: cmd = 0x10db3 returned error = 0x1
[ 4243.028434] [AUD] q6asm: __q6asm_open_write: DSP returned error[ADSP_EFAILED]
[ 4243.028456] [AUD] snd_soc_qdsp6v2: msm_compr_configure_dsp_for_playback:ASM open write err[-131] for compr type[0]
[ 4268.152812] [AUD] q6asm: q6asm_callback: cmd = 0x10db3 returned error = 0x1
[ 4268.152868] [AUD] q6asm: __q6asm_open_write: DSP returned error[ADSP_EFAILED]
[ 4268.152884] [AUD] snd_soc_qdsp6v2: msm_compr_configure_dsp_for_playback:ASM open write err[-131] for compr type[0]
[ 4268.984529] [AUD] q6asm: q6asm_callback: cmd = 0x10db3 returned error = 0x1
[ 4268.984581] [AUD] q6asm: __q6asm_open_write: DSP returned error[ADSP_EFAILED]
[ 4268.984599] [AUD] snd_soc_qdsp6v2: msm_compr_configure_dsp_for_playback:ASM open write err[-131] for compr type[0]
[ 4269.837727] [AUD] q6asm: q6asm_callback: cmd = 0x10db3 returned error = 0x1
[ 4269.837793] [AUD] q6asm: __q6asm_open_write: DSP returned error[ADSP_EFAILED]
[ 4269.837812] [AUD] snd_soc_qdsp6v2: msm_compr_configure_dsp_for_playback:ASM open write err[-131] for compr type[0]
[ 4456.475784] [AUD] q6asm: q6asm_callback: cmd = 0x10db3 returned error = 0x1
[ 4456.475872] [AUD] q6asm: __q6asm_open_write: DSP returned error[ADSP_EFAILED]
[ 4456.475892] [AUD] snd_soc_qdsp6v2: msm_compr_configure_dsp_for_playback:ASM open write err[-131] for compr type[0]
[ 4457.913943] [AUD] q6asm: q6asm_callback: cmd = 0x10db3 returned error = 0x1
[ 4457.914010] [AUD] q6asm: __q6asm_open_write: DSP returned error[ADSP_EFAILED]
[ 4457.914035] [AUD] snd_soc_qdsp6v2: msm_compr_configure_dsp_for_playback:ASM open write err[-131] for compr type[0]
[ 4462.793998] [AUD] q6asm: q6asm_callback: cmd = 0x10db3 returned error = 0x1
[ 4462.794051] [AUD] q6asm: __q6asm_open_write: DSP returned error[ADSP_EFAILED]
[ 4462.794068] [AUD] snd_soc_qdsp6v2: msm_compr_configure_dsp_for_playback:ASM open write err[-131] for compr type[0]
[ 4476.162351] [AUD] q6asm: q6asm_callback: cmd = 0x10db3 returned error = 0x1
[ 4476.162419] [AUD] q6asm: __q6asm_open_write: DSP returned error[ADSP_EFAILED]
[ 4476.162438] [AUD] snd_soc_qdsp6v2: msm_compr_configure_dsp_for_playback:ASM open write err[-131] for compr type[0]
[ 4477.467307] [AUD] q6asm: q6asm_callback: cmd = 0x10db3 returned error = 0x1
[ 4477.467362] [AUD] q6asm: __q6asm_open_write: DSP returned error[ADSP_EFAILED]
[ 4477.467381] [AUD] snd_soc_qdsp6v2: msm_compr_configure_dsp_for_playback:ASM open write err[-131] for compr type[0]
[ 4478.415672] [AUD] q6asm: q6asm_callback: cmd = 0x10db3 returned error = 0x1
[ 4478.415737] [AUD] q6asm: __q6asm_open_write: DSP returned error[ADSP_EFAILED]
[ 4478.415757] [AUD] snd_soc_qdsp6v2: msm_compr_configure_dsp_for_playback:ASM open write err[-131] for compr type[0]
[ 4484.841688] [AUD] q6asm: __q6asm_cmd_nowait: CMD_PAUSE
[ 4484.841773] [AUD] q6asm: __q6asm_cmd:q6asm close session 1
[ 4484.848904] [AUD] q6adm: adm_close: port_id=0x4001 perf_mode: 0 copp_idx: 0
[ 4603.777375] [AUD] snd_soc_wcd_mbhc: wcd_mbhc_mech_plug_detect_irq: enter
[ 4603.778279] [AUD] snd_soc_wcd_mbhc: wcd_mbhc_swch_irq_handler: mbhc->current_plug: 1 detection_type: 0
[ 4603.779931] [AUD] snd_soc_wcd_mbhc: wcd_mbhc_report_plug: Reporting removal 3(0)
[ 4603.802299] [AUD] snd_soc_wcd_mbhc: wcd_mbhc_mech_plug_detect_irq: leave 1
[ 5223.260643] [AUD] q6adm: adm_open:port 0x4001 path:2 rate:16000 mode:1 perf_mode:0,topo_id 66325
Anyone knows what's wrong? Since this happend after I've flashed from nougat -> noWipe noBootimg 3.16.401.2 FW -> LeeDroid Oreo 3.16.401.2 I guess it's something related to mismatched software parts. I don't want to run a RUU if it's avoidable, making backups over the really bad mtp implementation is nearly impossible...