[G2 and Desire Z Q&A, Help & Troubleshooting] IntuitiveNipple:
I wonder if the experts in the community might be able to help me diagnose (and fix) lost in-call audio via the front speaker.

Although I was part of the original team that worked on unlocking the eMMC when the Vision was first released (I bought it for that reason) I handed the phone on to my partner afterwards and have not had much to do with it since so I'm rusty on Vision specific issues now.

Last week, with no recent changes to hardware or software, the in-call audio via the front speaker stopped working. Audio is available via headset and rear speaker. There is no noise whatever from the front speaker.

Having read these and other forums and seen a few other reports of the same or similar issues I was hopeful someone would might have diagnosed the problem and provided a solution but I've been unable to find anything.

I specifically looked at the thread "Fix for no in-call audio/T-Mobile US/4.2.2/.33 radio or lower" in the "Nexus 4 Original Android Development" forum but it doesn't seem to match the files/setup of the Vision's OS.

I decided to test the hardware first, so we stripped the phone down today and tested the speaker. It works. We cleaned the contacts with Isopropyl alcohol and inspected the flex strip for damage but couldn't find any that might affect the speaker.

We decided to do a complete software update since it had an old version of Andromadus which was being quite laggy. The upgrade is to:

Slim-vision-4.2.2.build.6.2-UNOFFICIAL-20130608-0927
AIO_Addons.4.2.2.build.6.x.zip
VISION_RADIO_RCDATA_12.62.60.27_26.13.04.19
CM9_Andromadus_AOKP_26.13.04.19radio_ril_gps_so_updater_v3.1
vision_wipe_efs-signed

Unfortunately the software upgrade hasn't improved the issue.

I was wondering if there are any audio diagnostic tools we can use to test/manipulate the audio path - I was hoping we could try routing media audio to the front speaker to prove that it is possible to get sound via Android. That would help narrow down the issue.

Right now I'm at a loss as to what else to test.

Here's a log snippet during a specimen test call (apologies for its length; its been cut as much as possible). I wonder if someone else with the same or similar configuration could capture the same log so I could compare a known-good with this known-faulty log:

$ adb logcat -b radio -b main -b system -v time V*
...
07-19 21:09:14.531 D/use-Rlog/RLOG-PHONE( 2013): Event EVENT_CALL_RING Received state=RINGING
07-19 21:09:14.541 D/use-Rlog/RLOG-HTC_RIL( 1461): (t=1374264554)<< +CLCC: 1,1,4,0,0,"1234567890",129\r\n0\r
07-19 21:09:14.541 D/use-Rlog/RLOG-HTC_RIL( 1461): ril_func_chk_call_state_until_none():called
07-19 21:09:14.541 D/use-Rlog/RLOG-HTC_RIL( 1461): ril_func_chk_call_state_until_none():clcc already keeping polling (1)
07-19 21:09:14.541 E/use-Rlog/RLOG-HTC_RIL( 1461): write_attr_file():failed to open attributed file: /sys/module/gpio_event/parameters/phone_call_status(errno=2)
07-19 21:09:14.541 D/use-Rlog/RLOG-RILSWITCH( 1461): RILD <-- RIL (token 0x41488140)
07-19 21:09:14.541 D/use-Rlog/RLOG-RILSWITCH( 1461): atdToken : 0x41488140, bEMCRedirected 0
07-19 21:09:14.541 V/use-Rlog/RLOG-RILJ( 2013): Incoming UUS : NOT present!
07-19 21:09:14.541 D/use-Rlog/RLOG-RILJ( 2013): InCall VoicePrivacy is disabled
07-19 21:09:14.541 D/use-Rlog/RLOG-RILJ( 2013): [0210]< GET_CURRENT_CALLS [id=1,INCOMING,toa=129,norm,mt,0,voc,noevp,,cli=1,,0]
07-19 21:09:14.571 D/use-Rlog/RLOG-GSM( 2013): [GSMConn] --dssds----null
07-19 21:09:14.571 D/use-Rlog/RLOG-GSM( 2013): [GSMConn] update: parent=INCOMING, hasNewParent=false, wasConnectingInOrOut=true, wasHolding=false, isConnectingInOrOut=true, changed=false
07-19 21:09:15.032 D/PhoneUtils( 2013): answerCall(INCOMING)...
07-19 21:09:15.042 D/use-Rlog/RLOG-RILJ( 2013): [0211]> SET_MUTE false
07-19 21:09:15.042 W/use-Rlog/RLOG-RILSWITCH( 1461): RIL REQUEST: SET_MUTE received. Switch state is Vendor
07-19 21:09:15.042 W/use-Rlog/RLOG-RILSWITCH( 1461): RIL REQUEST: Set Mute. OnRequest for vendor called
07-19 21:09:15.042 D/use-Rlog/RLOG-HTC_RIL( 1461): ril_func_set_uplink_mute():called
07-19 21:09:15.042 D/use-Rlog/RLOG-HTC_RIL( 1461): (t=1374264555)>> AT+CMUT=0\r
07-19 21:09:15.042 D/use-Rlog/RLOG-HTC_RIL( 1461): (t=1374264555)<< 0\r
07-19 21:09:15.042 D/use-Rlog/RLOG-RILSWITCH( 1461): RILD <-- RIL (token 0x4148ae38)
07-19 21:09:15.042 D/use-Rlog/RLOG-RILSWITCH( 1461): atdToken : 0x4148ae38, bEMCRedirected 0
07-19 21:09:15.042 I/phone ( 2013): acceptCall: incoming...
07-19 21:09:15.052 D/use-Rlog/RLOG-RILJ( 2013): [0211]< SET_MUTE
07-19 21:09:15.052 D/use-Rlog/RLOG-RILJ( 2013): [0212]> ANSWER
07-19 21:09:15.052 W/use-Rlog/RLOG-RILSWITCH( 1461): RIL REQUEST: ANSWER received. Switch state is Vendor
07-19 21:09:15.052 W/use-Rlog/RLOG-RILSWITCH( 1461): RIL REQUEST: ANSWER --> Vendor RIL
07-19 21:09:15.052 D/use-Rlog/RLOG-HTC_RIL( 1461): ril_func_answer_call():called
07-19 21:09:15.052 D/use-Rlog/RLOG-HTC_RIL( 1461): ril_func_chk_call_state_until_none():called
07-19 21:09:15.052 D/use-Rlog/RLOG-HTC_RIL( 1461): ril_func_chk_call_state_until_none():clcc already keeping polling (1)
07-19 21:09:15.052 D/use-Rlog/RLOG-HTC_RIL( 1461): (t=1374264555)>> ATA\r
07-19 21:09:15.302 D/use-Rlog/RLOG-HTC_RIL( 1461): (t=1374264555)<< 0\r
07-19 21:09:15.302 D/use-Rlog/RLOG-HTC_RIL( 1461): (t=1374264555)>> AT+CLCC\r
07-19 21:09:15.302 D/use-Rlog/RLOG-RILSWITCH( 1461): RILD <-- RIL (token 0x4148ae20)
07-19 21:09:15.302 D/use-Rlog/RLOG-RILSWITCH( 1461): atdToken : 0x4148ae20, bEMCRedirected 0
07-19 21:09:15.302 D/use-Rlog/RLOG-RILJ( 2013): [0212]< ANSWER
07-19 21:09:15.302 D/use-Rlog/RLOG-HTC_RIL( 1461): (t=1374264555)<< +CLCC: 1,1,0,0,0,"1234567890",129\r\n0\r
07-19 21:09:15.302 D/use-Rlog/RLOG-HTC_RIL( 1461): ril_func_chk_call_state_until_none():called
07-19 21:09:15.302 D/use-Rlog/RLOG-HTC_RIL( 1461): ril_func_chk_call_state_until_none():clcc already keeping polling (1)
07-19 21:09:15.302 E/use-Rlog/RLOG-HTC_RIL( 1461): write_attr_file():failed to open attributed file: /sys/module/gpio_event/parameters/phone_call_status(errno=2)
07-19 21:09:15.302 D/use-Rlog/RLOG-RILSWITCH( 1461): Vendor RIL ----> UNSOLICITED: 1001
07-19 21:09:15.302 D/use-Rlog/RLOG-RILSWITCH( 1461): Sending vendor RIL unsolicited message to rild
07-19 21:09:15.302 D/use-Rlog/RLOG-RILJ( 2013): [UNSL]< UNSOL_RESPONSE_CALL_STATE_CHANGED
07-19 21:09:15.302 I/use-Rlog/RLOG-HTC_RIL( 1461): chk_call_state_rsp_handler():stop clcc polling because all calls are activated
07-19 21:09:15.392 D/use-Rlog/RLOG-RILJ( 2013): [0213]> GET_CURRENT_CALLS
07-19 21:09:15.392 W/use-Rlog/RLOG-RILSWITCH( 1461): RIL REQUEST: GET_CURRENT_CALLS received. Switch state is Vendor
07-19 21:09:15.392 W/use-Rlog/RLOG-RILSWITCH( 1461): RIL REQUEST: GET_CURRENT_CALLS --> Vendor RIL
07-19 21:09:15.392 D/use-Rlog/RLOG-HTC_RIL( 1461): ril_func_get_call_list():called
07-19 21:09:15.392 D/use-Rlog/RLOG-HTC_RIL( 1461): (t=1374264555)>> AT+CLCC\r
07-19 21:09:15.392 D/use-Rlog/RLOG-RILJ( 2013): [0214]> GET_CURRENT_CALLS
07-19 21:09:15.392 D/use-Rlog/RLOG-HTC_RIL( 1461): (t=1374264555)<< +CLCC: 1,1,0,0,0,"1234567890",129\r\n0\r
07-19 21:09:15.392 D/use-Rlog/RLOG-HTC_RIL( 1461): ril_func_chk_call_state_until_none():called
07-19 21:09:15.392 W/use-Rlog/RLOG-RILSWITCH( 1461): RIL REQUEST: GET_CURRENT_CALLS received. Switch state is Vendor
07-19 21:09:15.392 W/use-Rlog/RLOG-RILSWITCH( 1461): RIL REQUEST: GET_CURRENT_CALLS --> Vendor RIL
07-19 21:09:15.392 D/use-Rlog/RLOG-HTC_RIL( 1461): ril_func_get_call_list():called
07-19 21:09:15.892 I/use-Rlog/RLOG-HTC_RIL( 1461): ril_func_chk_call_state_until_none():start clcc polling (1)
07-19 21:09:15.892 E/use-Rlog/RLOG-HTC_RIL( 1461): write_attr_file():failed to open attributed file: /sys/module/gpio_event/parameters/phone_call_status(errno=2)
07-19 21:09:15.892 D/use-Rlog/RLOG-HTC_RIL( 1461): (t=1374264555)>> AT+CLCC\r
07-19 21:09:15.892 D/use-Rlog/RLOG-RILSWITCH( 1461): RILD <-- RIL (token 0x414899f0)
07-19 21:09:15.892 D/use-Rlog/RLOG-RILSWITCH( 1461): atdToken : 0x414899f0, bEMCRedirected 0
07-19 21:09:15.902 D/use-Rlog/RLOG-HTC_RIL( 1461): (t=1374264555)<< +CLCC: 1,1,0,0,0,"1234567890",129\r\n0\r
07-19 21:09:15.902 D/use-Rlog/RLOG-HTC_RIL( 1461): ril_func_chk_call_state_until_none():called
07-19 21:09:15.902 D/use-Rlog/RLOG-HTC_RIL( 1461): ril_func_chk_call_state_until_none():clcc already keeping polling (1)
07-19 21:09:15.902 E/use-Rlog/RLOG-HTC_RIL( 1461): write_attr_file():failed to open attributed file: /sys/module/gpio_event/parameters/phone_call_status(errno=2)
07-19 21:09:15.902 D/use-Rlog/RLOG-RILSWITCH( 1461): RILD <-- RIL (token 0x41489d60)
07-19 21:09:15.902 D/use-Rlog/RLOG-RILSWITCH( 1461): atdToken : 0x41489d60, bEMCRedirected 0
07-19 21:09:15.902 D/use-Rlog/RLOG-HTC_RIL( 1461): (t=1374264555)>> AT+CLCC\r
07-19 21:09:15.902 D/use-Rlog/RLOG-HTC_RIL( 1461): (t=1374264555)<< +CLCC: 1,1,0,0,0,"1234567890",129\r\n0\r
07-19 21:09:15.902 D/use-Rlog/RLOG-HTC_RIL( 1461): ril_func_chk_call_state_until_none():called
07-19 21:09:15.902 D/use-Rlog/RLOG-HTC_RIL( 1461): ril_func_chk_call_state_until_none():clcc already keeping polling (1)
07-19 21:09:15.902 E/use-Rlog/RLOG-HTC_RIL( 1461): write_attr_file():failed to open attributed file: /sys/module/gpio_event/parameters/phone_call_status(errno=2)
07-19 21:09:15.912 I/use-Rlog/RLOG-HTC_RIL( 1461): chk_call_state_rsp_handler():stop clcc polling because all calls are activated
07-19 21:09:15.912 D/use-Rlog/RLOG-HTC_RIL( 1461): (t=1374264555)>> AT@SYSTEMTIME=21,9,15,2013,7,19\r
07-19 21:09:15.912 D/use-Rlog/RLOG-HTC_RIL( 1461): (t=1374264555)<< 4\r
07-19 21:09:15.912 V/use-Rlog/RLOG-RILJ( 2013): Incoming UUS : NOT present!
07-19 21:09:15.912 D/use-Rlog/RLOG-RILJ( 2013): InCall VoicePrivacy is disabled
07-19 21:09:15.912 D/use-Rlog/RLOG-RILJ( 2013): [0213]< GET_CURRENT_CALLS [id=1,ACTIVE,toa=129,norm,mt,0,voc,noevp,,cli=1,,0]
07-19 21:09:15.912 V/use-Rlog/RLOG-RILJ( 2013): Incoming UUS : NOT present!
07-19 21:09:15.912 D/use-Rlog/RLOG-RILJ( 2013): InCall VoicePrivacy is disabled
07-19 21:09:15.922 D/use-Rlog/RLOG-RILJ( 2013): [0214]< GET_CURRENT_CALLS [id=1,ACTIVE,toa=129,norm,mt,0,voc,noevp,,cli=1,,0]
07-19 21:09:15.932 D/use-Rlog/RLOG-GSM( 2013): [GSMConn] --dssds----null
07-19 21:09:15.932 D/use-Rlog/RLOG-GSM( 2013): [GSMConn] update: parent=ACTIVE, hasNewParent=false, wasConnectingInOrOut=true, wasHolding=false, isConnectingInOrOut=false, changed=true
07-19 21:09:15.932 D/use-Rlog/RLOG-GSM( 2013): [GSMConn] onConnectedInOrOut: connectTime=1374264555936
07-19 21:09:15.932 D/use-Rlog/RLOG-GSM( 2013): [GSMConn] releaseWakeLock
07-19 21:09:15.952 D/AccelerometerListener( 2013): enable(true)
07-19 21:09:16.183 I/AudioService( 1808): AudioFocus requestAudioFocus() from AudioFocus_For_Phone_Ring_And_Calls
07-19 21:09:16.183 D/AudioHardwareInterface( 1465): setMode(IN_CALL)
07-19 21:09:16.203 E/BluetoothPhoneService( 2013): Could not get a handle on Connection object for the call
07-19 21:09:16.203 D/PhoneStatusBar( 1903): disable: < expand* icons ALERTS ticker system_info BACK HOME RECENT clock search >
07-19 21:09:16.213 I/keystore( 1467): uid: 1000 action: z -> 7 state: 3 -> 3 retry: 4
07-19 21:09:16.233 D/PhoneStatusBar( 1903): disable: < expand icons ALERTS ticker system_info back* home* recent* clock search >
07-19 21:09:16.253 I/keystore( 1467): uid: 1000 action: z -> 7 state: 3 -> 3 retry: 4
07-19 21:09:16.323 I/AudioHardware7x30( 1465): Routing audio to Handset
07-19 21:09:16.323 D/AudioHardware7x30( 1465): new_rx = 0
07-19 21:09:16.323 D/AudioHardware7x30( 1465): new_tx = 1
07-19 21:09:16.323 D/AudioHardware7x30( 1465): Starting voice on Rx 0 and Tx 1 device
07-19 21:09:16.323 D/AudioHardware7x30( 1465): updateACDB: (1, 0, 105, 205)
07-19 21:09:16.323 I/HTC Acoustic( 1465): update ACDB id: (tx, rx, tx_acdb, rx_acdb) = (1, 0, 105, 205)
07-19 21:09:16.323 D/AudioHardware7x30( 1465): value of device and enable is 2 0 ALSA dev id:6
07-19 21:09:16.323 D/AudioHardware7x30( 1465): value of device and enable is 0 1 ALSA dev id:0
07-19 21:09:16.363 D/AudioHardware7x30( 1465): value of device and enable is 3 0 ALSA dev id:11
07-19 21:09:16.363 D/AudioHardware7x30( 1465): value of device and enable is 1 1 ALSA dev id:1
07-19 21:09:16.393 D/AudioHardware7x30( 1465): Starting voice call and UnMuting the call
07-19 21:09:16.393 D/AudioHardware7x30( 1465): case VOICE_CALL
07-19 21:09:16.393 D/AudioHardware7x30( 1465): The node type is 1 and cur device 2 new device 0
07-19 21:09:16.393 D/AudioHardware7x30( 1465): value of device and enable is 2 0 ALSA dev id:6
07-19 21:09:16.393 D/AudioHardware7x30( 1465): value of device and enable is 0 1 ALSA dev id:0
07-19 21:09:16.393 D/AudioHardware7x30( 1465): setVoiceVolume(0.800000)
07-19 21:09:16.393 I/AudioHardware7x30( 1465): Setting in-call volume to 80 (available range is 0 to 100)
07-19 21:09:16.393 I/HTC Acoustic( 1465): update voice ACDB id: (tx_acdb, rx_acdb) = (0, 0)
07-19 21:09:16.393 I/HTC Acoustic( 1465): update voice ACDB id (0, 0) success
07-19 21:09:16.393 I/AudioHardware7x30( 1465): update_voice_acdb(0, 0) succeeded
07-19 21:09:16.393 D/AudioHardware7x30( 1465): setVoiceVolume(1.000000)
07-19 21:09:16.393 I/AudioHardware7x30( 1465): Setting in-call volume to 100 (available range is 0 to 100)
07-19 21:09:16.403 I/HTC Acoustic( 1465): update voice ACDB id: (tx_acdb, rx_acdb) = (106, 206)
07-19 21:09:16.403 I/HTC Acoustic( 1465): update voice ACDB id (106, 206) success
07-19 21:09:16.403 I/AudioHardware7x30( 1465): update_voice_acdb(106, 206) succeeded
07-19 21:09:16.493 W/BackupManagerService( 1808): dataChanged but no participant pkg='com.android.providers.settings' uid=10031
07-19 21:09:16.723 D/AccelerometerListener( 2013): orientation: horizontal
07-19 21:09:16.743 I/keystore( 1467): uid: 1000 action: z -> 7 state: 3 -> 3 retry: 4
07-19 21:09:16.753 V/TAG ( 1808): bug 7643792: fitSystemWindows([0,28][0,0])
07-19 21:09:19.446 D/AudioHardware7x30( 1465): AudioStreamOutMSM7x30::standby()
07-19 21:09:19.446 D/AudioHardware7x30( 1465): Deroute pcm out stream
07-19 21:09:19.446 D/AudioHardware7x30( 1465): case VOICE_CALL
07-19 21:09:19.666 D/use-Rlog/RLOG-HTC_RIL( 1461): (t=1374264559)%% +HTCUCSQ: 7\r\n
07-19 21:09:22.659 D/use-Rlog/RLOG-HTC_RIL( 1461): (t=1374264562)%% +HTCUCSQ: 8\r\n
07-19 21:09:22.659 D/use-Rlog/RLOG-RILSWITCH( 1461): Vendor RIL ----> UNSOLICITED: 1009
07-19 21:09:22.659 D/use-Rlog/RLOG-RILSWITCH( 1461): Sending vendor RIL unsolicited message to rild
07-19 21:09:24.581 D/SurfaceFlinger( 1462): Screen released, type=0 flinger=0x4053e3a8
07-19 21:09:24.581 D/qdhwcomposer( 1462): hwc_blank: Blanking display: 0
07-19 21:09:24.831 I/keystore( 1467): uid: 1000 action: z -> 7 state: 3 -> 3 retry: 4
07-19 21:09:24.971 D/qdhwcomposer( 1462): hwc_blank: Done blanking display: 0
07-19 21:09:24.971 D/Surface ( 1808): Excessive delay in blankDisplay() while turning screen off: 394ms
07-19 21:09:25.001 I/keystore( 1467): uid: 1000 action: z -> 7 state: 3 -> 3 retry: 4
07-19 21:09:25.081 D/AccelerometerListener( 2013): orientation: vertical
07-19 21:09:25.662 D/use-Rlog/RLOG-HTC_RIL( 1461): (t=1374264565)%% +HTCUCSQ: 9\r\n
07-19 21:09:25.662 D/use-Rlog/RLOG-RILSWITCH( 1461): Vendor RIL ----> UNSOLICITED: 1009
07-19 21:09:25.662 D/use-Rlog/RLOG-RILSWITCH( 1461): Sending vendor RIL unsolicited message to rild
07-19 21:09:26.122 D/SurfaceFlinger( 1462): Screen acquired, type=0 flinger=0x4053e3a8
07-19 21:09:26.122 D/qdhwcomposer( 1462): hwc_blank: Unblanking display: 0
07-19 21:09:26.313 I/keystore( 1467): uid: 1000 action: z -> 7 state: 3 -> 3 retry: 4
07-19 21:09:26.483 D/qdhwcomposer( 1462): hwc_blank: Done unblanking display: 0
07-19 21:09:26.483 D/Surface ( 1808): Excessive delay in unblankDisplay() while turning screen on: 358ms
07-19 21:09:26.493 D/SurfaceFlinger( 1462): Screen released, type=0 flinger=0x4053e3a8
07-19 21:09:26.493 D/qdhwcomposer( 1462): hwc_blank: Blanking display: 0
07-19 21:09:26.873 D/qdhwcomposer( 1462): hwc_blank: Done blanking display: 0
07-19 21:09:26.873 D/Surface ( 1808): Excessive delay in blankDisplay() while turning screen off: 390ms
07-19 21:09:26.913 I/keystore( 1467): uid: 1000 action: z -> 7 state: 3 -> 3 retry: 4
07-19 21:09:26.993 D/dalvikvm( 1808): JIT code cache reset in 3 ms (1048572 bytes 1/0)
07-19 21:09:27.013 D/dalvikvm( 1808): GC_CONCURRENT freed 1722K, 22% free 9146K/11584K, paused 23ms+14ms, total 114ms
07-19 21:09:28.655 D/use-Rlog/RLOG-HTC_RIL( 1461): (t=1374264568)%% +HTCUCSQ: 8\r\n
07-19 21:09:28.655 D/use-Rlog/RLOG-RILSWITCH( 1461): Vendor RIL ----> UNSOLICITED: 1009
07-19 21:09:28.655 D/use-Rlog/RLOG-RILSWITCH( 1461): Sending vendor RIL unsolicited message to rild
07-19 21:09:31.658 D/use-Rlog/RLOG-HTC_RIL( 1461): (t=1374264571)%% +HTCUCSQ: 7\r\n
07-19 21:09:32.579 D/use-Rlog/RLOG-HTC_RIL( 1461): (t=1374264572)%% 3\r
07-19 21:09:32.579 D/use-Rlog/RLOG-RILSWITCH( 1461): Vendor RIL ----> UNSOLICITED: 1001
07-19 21:09:32.579 D/use-Rlog/RLOG-RILSWITCH( 1461): Sending vendor RIL unsolicited message to rild
07-19 21:09:32.579 D/use-Rlog/RLOG-RILSWITCH( 1461): Vendor RIL requests timed callback
07-19 21:09:32.579 D/use-Rlog/RLOG-HTC_RIL( 1461): (t=1374264572)%% [MENTION=2394267]htcdi[/MENTION]S: 0010\r\n
07-19 21:09:32.589 D/use-Rlog/RLOG-RILJ( 2013): [UNSL]< UNSOL_RESPONSE_CALL_STATE_CHANGED
07-19 21:09:32.589 D/use-Rlog/RLOG-RILJ( 2013): [0215]> GET_CURRENT_CALLS
07-19 21:09:32.599 W/use-Rlog/RLOG-RILSWITCH( 1461): RIL REQUEST: GET_CURRENT_CALLS received. Switch state is Vendor
07-19 21:09:32.599 W/use-Rlog/RLOG-RILSWITCH( 1461): RIL REQUEST: GET_CURRENT_CALLS --> Vendor RIL
07-19 21:09:32.599 D/use-Rlog/RLOG-HTC_RIL( 1461): ril_func_get_call_list():called
07-19 21:09:32.599 D/use-Rlog/RLOG-HTC_RIL( 1461): (t=1374264572)>> AT+CLCC\r
07-19 21:09:32.609 D/use-Rlog/RLOG-HTC_RIL( 1461): (t=1374264572)<< 0\r
07-19 21:09:32.609 E/use-Rlog/RLOG-HTC_RIL( 1461): write_attr_file():failed to open attributed file: /sys/module/gpio_event/parameters/phone_call_status(errno=2)
07-19 21:09:32.609 E/use-Rlog/RLOG-HTC_RIL( 1461): write_attr_file():failed to open attributed file: /sys/module/gpio_event/parameters/phone_call_status(errno=2)
07-19 21:09:32.609 E/use-Rlog/RLOG-HTC_RIL( 1461): write_attr_file():failed to open attributed file: /sys/class/htc_accessory/phonein/flag(errno=2)
07-19 21:09:32.609 D/use-Rlog/RLOG-RILSWITCH( 1461): Vendor RIL ----> UNSOLICITED: 1001
07-19 21:09:32.609 D/use-Rlog/RLOG-RILSWITCH( 1461): Sending vendor RIL unsolicited message to rild
07-19 21:09:32.609 D/use-Rlog/RLOG-RILJ( 2013): [UNSL]< UNSOL_RESPONSE_CALL_STATE_CHANGED
07-19 21:09:32.609 D/use-Rlog/RLOG-RILSWITCH( 1461): RILD <-- RIL (token 0x41489b20)
07-19 21:09:32.609 D/use-Rlog/RLOG-RILSWITCH( 1461): atdToken : 0x41489b20, bEMCRedirected 0
07-19 21:09:32.609 D/use-Rlog/RLOG-RILJ( 2013): [0215]< GET_CURRENT_CALLS
07-19 21:09:32.609 D/use-Rlog/RLOG-RILJ( 2013): [0216]> GET_CURRENT_CALLS
07-19 21:09:32.629 W/use-Rlog/RLOG-RILSWITCH( 1461): RIL REQUEST: GET_CURRENT_CALLS received. Switch state is Vendor
07-19 21:09:32.629 W/use-Rlog/RLOG-RILSWITCH( 1461): RIL REQUEST: GET_CURRENT_CALLS --> Vendor RIL
07-19 21:09:32.629 D/use-Rlog/RLOG-HTC_RIL( 1461): ril_func_get_call_list():called
07-19 21:09:32.629 D/use-Rlog/RLOG-HTC_RIL( 1461): (t=1374264572)>> AT+CLCC\r
07-19 21:09:32.629 D/use-Rlog/RLOG-HTC_RIL( 1461): (t=1374264572)<< 0\r
07-19 21:09:32.629 E/use-Rlog/RLOG-HTC_RIL( 1461): write_attr_file():failed to open attributed file: /sys/module/gpio_event/parameters/phone_call_status(errno=2)
07-19 21:09:32.629 E/use-Rlog/RLOG-HTC_RIL( 1461): write_attr_file():failed to open attributed file: /sys/module/gpio_event/parameters/phone_call_status(errno=2)
07-19 21:09:32.629 D/use-Rlog/RLOG-RILSWITCH( 1461): RILD <-- RIL (token 0x41489da8)
07-19 21:09:32.629 D/use-Rlog/RLOG-RILSWITCH( 1461): atdToken : 0x41489da8, bEMCRedirected 0
07-19 21:09:32.629 D/use-Rlog/RLOG-RILJ( 2013): [0216]< GET_CURRENT_CALLS
07-19 21:09:32.629 D/use-Rlog/RLOG-RILJ( 2013): [0217]> LAST_CALL_FAIL_CAUSE
07-19 21:09:32.639 W/use-Rlog/RLOG-RILSWITCH( 1461): RIL REQUEST: LAST_CALL_FAIL_CAUSE received. Switch state is Vendor
07-19 21:09:32.639 W/use-Rlog/RLOG-RILSWITCH( 1461): RIL REQUEST: LAST_CALL_FAIL_CAUSE --> Vendor RIL
07-19 21:09:32.639 D/use-Rlog/RLOG-HTC_RIL( 1461): ril_func_get_last_call_fail_cause():called
07-19 21:09:32.639 D/use-Rlog/RLOG-HTC_RIL( 1461): (t=1374264572)>> AT\r
07-19 21:09:32.639 D/use-Rlog/RLOG-HTC_RIL( 1461): (t=1374264572)<< 0\r
07-19 21:09:32.639 D/use-Rlog/RLOG-RILSWITCH( 1461): RILD <-- RIL (token 0x41489da8)
07-19 21:09:32.639 D/use-Rlog/RLOG-RILSWITCH( 1461): atdToken : 0x41489da8, bEMCRedirected 0
07-19 21:09:32.639 D/use-Rlog/RLOG-RILJ( 2013): [0217]< LAST_CALL_FAIL_CAUSE {16}
07-19 21:09:32.659 D/use-Rlog/RLOG-GSM( 2013): [GsmDCT] handleMessage msg={ what=270344 when=-11ms obj=android.os.AsyncResult@41547e20 }
07-19 21:09:32.659 D/use-Rlog/RLOG-GSM( 2013): [GsmDCT] onVoiceCallEnded
07-19 21:09:32.659 D/use-Rlog/RLOG-GSM( 2013): [GsmDCT] configureRetry: forDefault=false retryCount=0 dc={GsmDC-1: State=DcInactiveState apnSetting=null apnList= [] RefCount=0 cid=-1 create=-1 lastFail=-1 lastFailCause=NONE}
07-19 21:09:32.659 D/use-Rlog/RLOG-GSM( 2013): [RM] resetRetryCount: 0
07-19 21:09:32.659 D/use-Rlog/RLOG-GSM( 2013): [GsmDC-1] setRetryCount: 0
07-19 21:09:32.659 D/use-Rlog/RLOG-GSM( 2013): [RM] setRetryCount: 0
07-19 21:09:32.659 D/use-Rlog/RLOG-GSM( 2013): [ApnContext:dun] setRetryCount: 0
07-19 21:09:32.659 D/use-Rlog/RLOG-GSM( 2013): [ApnContext:supl] setRetryCount: 0
07-19 21:09:32.659 D/use-Rlog/RLOG-GSM( 2013): [ApnContext:hipri] setRetryCount: 0
07-19 21:09:32.659 D/use-Rlog/RLOG-GSM( 2013): [ApnContext:default] setRetryCount: 0
07-19 21:09:32.659 D/use-Rlog/RLOG-GSM( 2013): [ApnContext:mms] setRetryCount: 0
07-19 21:09:32.669 D/use-Rlog/RLOG-GSM( 2013): [RM] resetRetryCount: 0
07-19 21:09:32.669 D/CallNotifier( 2013): onDisconnect: cause = NORMAL, incoming = true, date = 1374264546057
07-19 21:09:32.669 D/AudioHardwareInterface( 1465): setMode(NORMAL)
07-19 21:09:32.669 I/AudioHardware7x30( 1465): Routing audio to Handset
07-19 21:09:32.669 D/AudioHardware7x30( 1465): new_rx = 0
07-19 21:09:32.669 D/AudioHardware7x30( 1465): new_tx = 1
07-19 21:09:32.669 D/AudioHardware7x30( 1465): Ending Voice call
07-19 21:09:32.669 D/AudioHardware7x30( 1465): No active voicecall/playback, disabling cur_rx 0
07-19 21:09:32.669 D/AudioHardware7x30( 1465): value of device and enable is 0 0 ALSA dev id:0
07-19 21:09:32.679 D/CallNotifier( 2013): SignalInfoTonePlayer.run(toneId = 98)...
07-19 21:09:32.679 D/AudioHardware7x30( 1465): No active voicecall/recording, disabling cur_tx 1
07-19 21:09:32.679 D/AudioHardware7x30( 1465): value of device and enable is 1 0 ALSA dev id:1
07-19 21:09:32.689 I/AudioService( 1808): AudioFocus abandonAudioFocus() from AudioFocus_For_Phone_Ring_And_Calls