Cannot hear voice during calls
- /e/ version: e-1.6-s-20221201239247-dev-miatoll
- Device model(s): Xiamo Redmi Note 9 Pro (joyeuse) - m2003j6b2g
- Device rooted: no
Summary
When I make a call I cannot hear nothing from the ear speaker. if I active the main speaker I can hear the voice
The problem
Steps to reproduce make a call
make a callWhat is the current behavior? no voice from the ear speaker. voice from main speaker is ok
no voice from the ear speakerWhat is the expected correct behavior?
I should hear from the ear speaker the voice
Technical informations
Relevant logs (adb logcat
)
12-22 06:47:21.670 969 969 D vendor.qti.vibrator: Vibrator perform effect 0
12-22 06:47:21.671 969 7179 D vendor.qti.vibrator: Starting perform on another thread
12-22 06:47:21.672 923 4098 D audio_hw_primary: start_output_stream: enter: stream(0xf0fc0010)usecase(1: low-latency-playback) devices(0x2) is_haptic_usecase(0)
12-22 06:47:21.673 923 4098 D audio_hw_primary: select_devices for use case (low-latency-playback)
12-22 06:47:21.673 672 672 I libperfmgr: Hint type not present in actions: AUDIO_LAUNCH
12-22 06:47:21.673 923 4098 I msm8974_platform: platform_check_and_set_codec_backend_cfg:becf: afe: bitwidth 16, samplerate 48000 channels 2, backend_idx 0 usecase = 1 device (speaker)
12-22 06:47:21.674 5234 5234 I Dialer : PreCallImpl.buildIntent - No UI requested, running pre-call directly
12-22 06:47:21.674 923 4098 D msm8974_platform: platform_split_snd_device: snd_device(2) num devices(1) new_snd_devices(0)
12-22 06:47:21.675 923 4098 I msm8974_platform: platform_check_and_set_codec_backend_cfg: new_snd_devices[0] is 2
12-22 06:47:21.675 923 4098 I msm8974_platform: platform_check_codec_backend_cfg:becf: afe: bitwidth 16, samplerate 48000 channels 2, backend_idx 0 usecase = 1 device (speaker)
12-22 06:47:21.677 923 4098 D audio_hw_extn: audio_extn_enable_hifi_filter: mixer_value set 0
12-22 06:47:21.677 923 4098 D msm8974_platform: platform_check_codec_backend_cfg:becf: updated afe: bitwidth 16, samplerate 48000 channels 2,backend_idx 0 usecase = 1 device (speaker)
12-22 06:47:21.677 923 4098 D msm8974_platform: platform_check_codec_backend_cfg:becf: afe: playback on codec device not supporting native playback set default Sample Rate(48k)
12-22 06:47:21.678 923 4098 I msm8974_platform: platform_check_codec_backend_cfg:becf: afe: Codec selected backend: 0 updated bit width: 16 and sample rate: 48000
12-22 06:47:21.678 923 4098 D audio_hw_primary: check_usecases_codec_backend:becf: force routing 0
12-22 06:47:21.679 923 4098 E msm8974_platform: platform_check_backends_match: Invalid snd_device =
12-22 06:47:21.679 1457 5763 I Telecom : UserCallIntentProcessor: sendIntentToDestination: send intent to Telecom directly.: TSI.pC@Cko
12-22 06:47:21.679 923 4098 D audio_hw_primary: check_usecases_codec_backend:becf: (78) check_usecases curr device: speaker, usecase device: backends match 0
12-22 06:47:21.679 1457 5763 I Telecom : CallIntentProcessor: onReceive - isUnknownCall: false: TSI.pC@Cko
12-22 06:47:21.680 923 4098 D audio_hw_primary: check_usecases_codec_backend:becf: check_usecases num.of Usecases to switch 0
12-22 06:47:21.680 923 4098 D hardware_info: hw_info_append_hw_type : device_name = speaker
12-22 06:47:21.681 923 4098 D msm8974_platform: platform_split_snd_device: snd_device(2) num devices(0) new_snd_devices(0)
12-22 06:47:21.681 923 4098 D audio_hw_primary: enable_snd_device: snd_device(2: speaker)
12-22 06:47:21.681 923 4098 D msm8974_platform: platform_get_island_cfg_on_device:island cfg status on snd_device = (speaker 0)
12-22 06:47:21.682 923 4098 I soundtrigger: audio_extn_sound_trigger_update_device_status: device 0x2 of type 0 for Event 1, with Raise=0
12-22 06:47:21.682 923 4098 D audio_route: Apply path: speaker
12-22 06:47:21.683 923 4098 I audio_hw_utils: audio_extn_utils_update_stream_output_app_type_cfg Allowing 24 and above bits playback on speaker ONLY at default sampling rate
12-22 06:47:21.683 1457 5763 I Telecom : TelecomAnalytics: Starting analytics for call TC@5: TSI.pC@Cko
12-22 06:47:21.683 923 4098 E soundtrigger: audio_extn_sound_trigger_update_stream_status: invalid input device 0x0, for event 3
12-22 06:47:21.683 1457 1457 I Telecom : TelecomSystem: CallerInfoAsyncQuery.startQuery number=*** cookie=TSI.pC->CILH.sL->CILH.sL@Cko: TSI.pC->CILH.sL@Cko
12-22 06:47:21.684 923 4098 D soundtrigger: audio_extn_sound_trigger_update_stream_status: uc_info->id 1 of type 0 for Event 3, with Raise=0
12-22 06:47:21.684 1457 5763 I Telecom : LogUtils: EventRecord added as Call: [Call id=TC@5, state=NEW, tpac=null, cmgr=null, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[], prop=[]]: TSI.pC@Cko
12-22 06:47:21.684 923 4098 D audio_hw_utils: audio_extn_utils_send_app_type_cfg: usecase->out_snd_device speaker
12-22 06:47:21.685 923 4098 D msm8974_platform: platform_split_snd_device: snd_device(2) num devices(0) new_snd_devices(0)
12-22 06:47:21.685 1457 5763 I Telecom : Event: RecordEntry TC@5: CREATED, com.android.dialer: TSI.pC@Cko
12-22 06:47:21.686 923 4098 D audio_hw_utils: audio_extn_btsco_get_sample_rate:Not a BT SCO device, need not update sampling rate
12-22 06:47:21.686 923 4098 I audio_hw_utils: send_app_type_cfg_for_device PLAYBACK app_type 69937, acdb_dev_id 10011, sample_rate 48000, snd_device_be_idx 45
12-22 06:47:21.686 1457 5763 I Telecom : CallerInfoLookupHelper: There is a previously incomplete query for handle tel:*90. Adding to listeners for this query.: TSI.pC@Cko
12-22 06:47:21.688 923 4098 D msm8974_platform: platform_split_snd_device: snd_device(2) num devices(1) new_snd_devices(0)
12-22 06:47:21.688 923 4098 D audio_hw_utils: audio_extn_btsco_get_sample_rate:Not a BT SCO device, need not update sampling rate
12-22 06:47:21.688 923 4098 D ACDB-LOADER: ACDB -> send_audio_cal, acdb_id = 10011, path = 0, app id = 0x11131, sample rate = 48000, afe_sample_rate = 48000
12-22 06:47:21.688 5234 5234 I Dialer : DialpadFragment.hideAndClearDialpad - enter
12-22 06:47:21.689 923 4098 D ACDB-LOADER: ACDB -> send_asm_topology
12-22 06:47:21.689 923 4098 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_STREAM_TOPOLOGY_ID
12-22 06:47:21.690 923 4098 D ACDB-LOADER: ACDB -> send_adm_topology
12-22 06:47:21.690 923 4098 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_COMMON_TOPOLOGY_ID
12-22 06:47:21.690 923 4098 D ACDB-LOADER: ACDB -> send_audtable
12-22 06:47:21.691 923 4098 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_INSTANCE_COMMON_TABLE_SIZE
12-22 06:47:21.691 923 4098 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_INSTANCE_COMMON_TABLE
12-22 06:47:21.691 923 4098 D ACDB-LOADER: ACDB -> AUDIO_SET_AUDPROC_CAL cal_type[11] acdb_id[10011] app_type[69937]
12-22 06:47:21.692 923 4098 D ACDB-LOADER: ACDB -> send_audvoltable
12-22 06:47:21.692 923 4098 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_INSTANCE_GAIN_DEP_STEP_TABLE_SIZE
12-22 06:47:21.692 923 4098 D android.hardware.audio.service: Failed to fetch the lookup information of the device 0000271B
12-22 06:47:21.693 923 4098 D ACDB-LOADER: Error: ACDB_CMD_GET_AUDPROC_INSTANCE_GAIN_DEP_STEP_TABLE_SIZE Returned = -19
12-22 06:47:21.693 923 4098 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_INSTANCE_GAIN_DEP_STEP_TABLE, vol index 0
12-22 06:47:21.693 923 4098 D android.hardware.audio.service: Failed to fetch the lookup information of the device 0000271B
12-22 06:47:21.694 923 4098 D ACDB-LOADER: Error: ACDB AudProc vol returned = -19
12-22 06:47:21.694 923 4098 D ACDB-LOADER: ACDB -> AUDIO_SET_VOL_CAL cal type = 12
12-22 06:47:21.694 923 4098 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_INSTANCE_STREAM_TABLE_SIZE
12-22 06:47:21.695 923 4098 D ACDB-LOADER: ACDB -> send_audstrmtable
12-22 06:47:21.695 923 4098 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_INSTANCE_STREAM_TABLE
12-22 06:47:21.695 923 4098 D ACDB-LOADER: ACDB -> audstrm_cal->cal_type.cal_data.cal_size = 20
12-22 06:47:21.696 923 4098 D ACDB-LOADER: ACDB -> send_afe_topology
12-22 06:47:21.696 923 4098 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_TOPOLOGY_ID
12-22 06:47:21.697 923 4098 D ACDB-LOADER: ACDB -> GET_AFE_TOPOLOGY_ID for adcd_id 10011, Topology Id 112fc
12-22 06:47:21.697 923 4098 D ACDB-LOADER: ACDB -> send_afe_cal
12-22 06:47:21.697 923 4098 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_INSTANCE_COMMON_TABLE_SIZE
12-22 06:47:21.698 923 4098 D android.hardware.audio.service: Failed to fetch the lookup information of the device 0000271B
12-22 06:47:21.698 1457 1457 I Telecom : CallsManager: call outgoing call suggestion service stage: TSI.pC->CM.fOCP->CM.cOCSS@Cko
12-22 06:47:21.698 923 4098 D ACDB-LOADER: Error: ACDB_CMD_GET_AFE_INSTANCE_COMMON_TABLE_SIZE Returned = -19
12-22 06:47:21.698 1457 1457 I Telecom : CallsManager: set outgoing call phone acct stage: TSI.pC->CM.fOCP->CM.sOCPA@Cko
12-22 06:47:21.699 923 4098 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_INSTANCE_COMMON_TABLE
12-22 06:47:21.699 923 4098 D android.hardware.audio.service: Failed to fetch the lookup information of the device 0000271B
12-22 06:47:21.699 1457 1457 I Telecom : CallsManager: make room for outgoing call stage: TSI.pC->CM.fOCP->CM.sOCPA->CM.dSMCP@Cko
12-22 06:47:21.699 923 4098 D ACDB-LOADER: Error: ACDB AFE returned = -19
12-22 06:47:21.700 923 4098 D ACDB-LOADER: ACDB -> AUDIO_SET_AFE_CAL cal_type[16] acdb_id[10011]
12-22 06:47:21.700 1457 1457 I Telecom : CallsManager: dialer phone acct select stage: TSI.pC->CM.fOCP->CM.sOCPA->CM.dSMCP->CM.dSPA@Cko
12-22 06:47:21.700 923 4098 D ACDB-LOADER: ACDB -> send_hw_delay : acdb_id = 10011 path = 0
12-22 06:47:21.701 1457 1457 I Telecom : CallsManager: post acct selection stage: TSI.pC->CM.fOCP->CM.sOCPA->CM.dSMCP->CM.dSPA->CM.pASP@Cko
12-22 06:47:21.701 923 4098 D ACDB-LOADER: ACDB -> ACDB_AVSYNC_INFO: ACDB_CMD_GET_DEVICE_PROPERTY
12-22 06:47:21.702 923 4098 D msm8974_platform: platform_split_snd_device: snd_device(2) num devices(0) new_snd_devices(0)
12-22 06:47:21.702 1457 1457 I Telecom : Event: RecordEntry TC@5: SET_CONNECTING, ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}: TSI.pC->CM.fOCP->CM.sOCPA->CM.dSMCP->CM.dSPA->CM.pASP@Cko
12-22 06:47:21.702 923 4098 I msm8974_platform: platform_get_custom_mtmx_params: no matching param with id 0 ip_ch 2 op_ch 2 uc_id 1 snd_dev 2
12-22 06:47:21.703 923 4098 D audio_hw_primary: enable_audio_route: apply mixer and update path: low-latency-playback
12-22 06:47:21.703 923 4098 D audio_route: Apply path: low-latency-playback
12-22 06:47:21.705 923 4098 D audio_hw_primary: select_devices: done
12-22 06:47:21.712 969 7179 D vendor.qti.vibrator: Notifying perform complete
12-22 06:47:21.712 969 969 D vendor.qti.vibrator: QTI Vibrator off
12-22 06:47:20.837 0 0 E : ibat_ua =-1245423
12-22 06:47:21.709 0 0 I : tas2562 tas2562: tas2562_set_bitwidth 2
12-22 06:47:21.711 0 0 I : tas2562 tas2562: tas2562_iv_slot_config, 16
12-22 06:47:21.716 0 0 I : tas2562 tas2562: SND_SOC_DAPM_POST_PMU
12-22 06:47:21.716 0 0 I __afe_port_start: port id: 0x1004
12-22 06:47:21.716 0 0 I afe_find_cal_topo_id_by_port: port id: 0x1004, dev_acdb_id: 10011
12-22 06:47:21.716 0 0 I afe_find_cal_topo_id_by_port: top_id:112fc acdb_id:10011 afe_port_id:0x1004
12-22 06:47:21.716 0 0 I afe_get_cal_topology_id: port_id = 0x1004 acdb_id = 10011 topology_id = 0x112fc cal_type_index=8 ret=0
12-22 06:47:21.716 0 0 I afe_send_port_topology_id: AFE set topology id 0x112fc enable for port 0x1004 ret 0
12-22 06:47:21.716 0 0 I send_afe_cal_type: cal_index is 0
12-22 06:47:21.716 0 0 I send_afe_cal_type: dev_acdb_id[38] is 10011
12-22 06:47:21.716 0 0 I afe_find_cal: cal_index 0 port_id 0x1004 port_index 38
12-22 06:47:21.716 0 0 I afe_find_cal: acdb_id 10011 dev_acdb_id 10011 sample_rate 48000 afe_sample_rates 48000
12-22 06:47:21.716 0 0 I afe_find_cal: cal block is a match, size is 0
12-22 06:47:21.716 0 0 I send_afe_cal_type: Sending cal_index cal 0
12-22 06:47:21.716 0 0 E send_afe_cal_type: No cal sent for cal_index 0, port_id = 0x1004! ret -22
12-22 06:47:21.717 0 0 I afe_send_hw_delay: port_id 0x1004 rate 48000 delay_usec 0 status 0
12-22 06:47:21.721 1457 1457 I Telecom : CallsManager: addCall([Call id=TC@5, state=CONNECTING, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=null, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[], prop=[]]): TSI.pC->CM.fOCP->CM.sOCPA->CM.dSMCP->CM.dSPA->CM.pASP@Cko
12-22 06:47:21.722 1457 3300 I Telecom : CallAudioRouteStateMachine: Message received: UPDATE_SYSTEM_AUDIO_ROUTE=1201, arg1=0: TSI.pC->CM.fOCP->CM.sOCPA->CM.dSMCP->CM.dSPA->CM.pASP->CARSM.pM_UPDATE_SYSTEM_AUDIO_ROUTE@Cko
12-22 06:47:21.722 1457 3301 I Telecom : CallAudioModeStateMachine: Message received: NEW_ACTIVE_OR_DIALING_CALL.: TSI.pC->CM.fOCP->CM.sOCPA->CM.dSMCP->CM.dSPA->CM.pASP->CAMSM.pM_2001@Cko
12-22 06:47:21.722 1457 1457 I Telecom : IncomingCallNotifier: updateIncomingCall: foundIncomingcall = null: TSI.pC->CM.fOCP->CM.sOCPA->CM.dSMCP->CM.dSPA->CM.pASP@Cko
12-22 06:47:21.723 1457 3300 I Telecom : QuiescentEarpieceRoute: Processing message UPDATE_SYSTEM_AUDIO_ROUTE: TSI.pC->CM.fOCP->CM.sOCPA->CM.dSMCP->CM.dSPA->CM.pASP->CARSM.pM_UPDATE_SYSTEM_AUDIO_ROUTE@Cko
12-22 06:47:21.723 1457 3301 I Telecom : CallAudioModeStateMachine: Audio focus entering SIM CALL state: TSI.pC->CM.fOCP->CM.sOCPA->CM.dSMCP->CM.dSPA->CM.pASP->CAMSM.pM_2001@Cko
12-22 06:47:21.723 1457 1457 I Telecom : CallDiagnosticServiceController: bindCallDiagnosticService: no package; skip binding.: TSI.pC->CM.fOCP->CM.sOCPA->CM.dSMCP->CM.dSPA->CM.pASP@Cko
12-22 06:47:21.724 1457 1457 I Telecom : TelecomWakeLock: WakeLock already released with id: 26: TSI.pC->CM.fOCP->CM.sOCPA->CM.dSMCP->CM.dSPA->CM.pASP@Cko
12-22 06:47:21.724 1457 3301 I MediaFocusControl: requestAudioFocus() from uid/pid 1000/1457 AA=USAGE_VOICE_COMMUNICATION/CONTENT_TYPE_SPEECH clientId=AudioFocus_For_Phone_Ring_And_Calls callingPack=com.android.server.telecom req=2 flags=0x4 sdk=0
12-22 06:47:21.724 1457 1457 I Telecom : InCallWakeLockController: Releasing full wake lock: TSI.pC->CM.fOCP->CM.sOCPA->CM.dSMCP->CM.dSPA->CM.pASP@Cko
12-22 06:47:21.725 1457 1457 I Telecom : InCallController: onCallAdded: [Call id=TC@5, state=CONNECTING, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=null, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[], prop=[]]; not bound or connected.: TSI.pC->CM.fOCP->CM.sOCPA->CM.dSMCP->CM.dSPA->CM.pASP@Cko
12-22 06:47:21.725 1457 3301 I AudioService.FadeOutManager: unfadeOutUid() uid:1000
12-22 06:47:21.725 1457 1457 I Telecom : InCallController: defaultDialer: [ComponentInfo{com.android.dialer/com.android.incallui.InCallServiceImpl} supportsExternal? true supportsSelfMg?false]: TSI.pC->CM.fOCP->CM.sOCPA->CM.dSMCP->CM.dSPA->CM.pASP@Cko
12-22 06:47:21.726 1001 3151 D AudioFlinger: Client defaulted notificationFrames to 192 for frameCount 960
12-22 06:47:21.726 1457 1457 I Telecom : InCallController: defaultDialer: null: TSI.pC->CM.fOCP->CM.sOCPA->CM.dSMCP->CM.dSPA->CM.pASP@Cko
12-22 06:47:21.724 0 0 I : tas2562 tas2562: set power state: 0
12-22 06:47:21.728 1457 1457 I Telecom : CarSwappingInCallServiceConnection: chooseInitialInCallService: false => false: TSI.pC->CM.fOCP->CM.sOCPA->CM.dSMCP->CM.dSPA->CM.pASP@Cko
12-22 06:47:21.728 1457 1457 I Telecom : EmergencyCallHelper: ShouldGrantTemporaryLocationPermission, disabled by config: TSI.pC->CM.fOCP->CM.sOCPA->CM.dSMCP->CM.dSPA->CM.pASP@Cko
12-22 06:47:21.728 1457 1457 I Telecom : EmergencyInCallServiceConnection: Attempting to bind to InCall [ComponentInfo{com.android.dialer/com.android.incallui.InCallServiceImpl} supportsExternal? true supportsSelfMg?false], with Intent { act=android.telecom.InCallService cmp=com.android.dialer/com.android.incallui.InCallServiceImpl (has extras) }: TSI.pC->CM.fOCP->CM.sOCPA->CM.dSMCP->CM.dSPA->CM.pASP@Cko
12-22 06:47:21.729 1001 3151 D AF::TrackHandle: OpPlayAudio: track:80 usage:3 not muted
12-22 06:47:21.732 1457 1457 I Telecom : EmergencyInCallServiceConnection: mCall: [Call id=TC@5, state=CONNECTING, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=null, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[], prop=[]], mIsConnected: true: TSI.pC->CM.fOCP->CM.sOCPA->CM.dSMCP->CM.dSPA->CM.pASP@Cko
12-22 06:47:21.732 1457 6028 I AudioTrack: createTrack_l(8): AUDIO_OUTPUT_FLAG_FAST successful; frameCount 960 -> 960
12-22 06:47:21.733 1457 1457 I Telecom : InCallServiceBindingConnection: Attempting to bind to InCall [ComponentInfo{com.android.bluetooth/com.android.bluetooth.telephony.BluetoothInCallService} supportsExternal? false supportsSelfMg?true], with Intent { act=android.telecom.InCallService cmp=com.android.bluetooth/.telephony.BluetoothInCallService (has extras) }: TSI.pC->CM.fOCP->CM.sOCPA->CM.dSMCP->CM.dSPA->CM.pASP@Cko
12-22 06:47:21.736 2620 2620 I BluetoothInCallService: BluetoothInCallService is created
12-22 06:47:21.737 1457 1457 I Telecom : InCallServiceBindingConnection: mCall: [Call id=TC@5, state=CONNECTING, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=null, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[], prop=[]], mIsConnected: true: TSI.pC->CM.fOCP->CM.sOCPA->CM.dSMCP->CM.dSPA->CM.pASP@Cko
12-22 06:47:21.737 2620 2620 D BluetoothInCallService: onCreate
12-22 06:47:21.738 1457 1457 I Telecom : CallRedirectionProcessorHelper: formatNumberToE164, original number: ***: TSI.pC->CIP.sNOCI@Cko
12-22 06:47:21.739 2620 2620 I BluetoothInCallService: onBind. Intent: Intent { act=android.telecom.InCallService cmp=com.android.bluetooth/.telephony.BluetoothInCallService (has extras) }
12-22 06:47:21.739 1457 1457 I Telecom : CallRedirectionProcessorHelper: formatNumberToE164, formatted E164 number: null: TSI.pC->CIP.sNOCI@Cko
12-22 06:47:21.740 1457 1457 I Telecom : CallRedirectionProcessorHelper: removePostDialDigits, number after being extracted post dial digits: ***: TSI.pC->CIP.sNOCI@Cko
12-22 06:47:21.740 1457 1457 I Telecom : CallRedirectionProcessorHelper: PackageName is empty. Not performing user-defined call redirection.: TSI.pC->CIP.sNOCI@Cko
12-22 06:47:21.745 0 0 E : aw8624_haptic_stop_delay do not enter standby automatically
12-22 06:47:21.744 923 4098 D msm8974_platform: platform_set_channel_map mixer_ctl_name:Playback Channel Map9
12-22 06:47:21.744 1457 1457 I Telecom : CallRedirectionProcessorHelper: Cannot get carrier componentNameString.: TSI.pC->CIP.sNOCI@Cko
12-22 06:47:21.744 923 4098 D msm8974_platform: platform_set_channel_map: set mapping(1 2 0 0 0 0 0 0) for channel:2
12-22 06:47:21.744 1457 1457 I Telecom : CallRedirectionProcessor: Can make call redirection with any available service: false: TSI.pC->CIP.sNOCI@Cko
12-22 06:47:21.745 1457 1457 I Telecom : NewOutgoingCallIntentBroadcaster: Sending NewOutgoingCallBroadcast for [Call id=TC@5, state=CONNECTING, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=null, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[], prop=[]] to UserHandle{0}: TSI.pC->CIP.sNOCI@Cko
12-22 06:47:21.746 923 4098 D audio_hw_primary: start_output_stream: exit
12-22 06:47:21.746 672 672 I libperfmgr: Hint type not present in actions: AUDIO_LAUNCH
12-22 06:47:21.746 923 2025 D audio_hw_primary: adev_set_mode: mode 2 , prev_mode 0
12-22 06:47:21.746 1457 1457 W Telecom : Logging: Log.endSession was called with no session active.
12-22 06:47:21.748 1457 3300 I Telecom : CallAudioRouteStateMachine: setSystemAudioState: changing from [AudioState isMuted: false, route: EARPIECE, supportedRouteMask: EARPIECE, SPEAKER, activeBluetoothDevice: [null], supportedBluetoothDevices: []] to [AudioState isMuted: false, route: EARPIECE, supportedRouteMask: EARPIECE, SPEAKER, activeBluetoothDevice: [null], supportedBluetoothDevices: []]: TSI.pC->CM.fOCP->CM.sOCPA->CM.dSMCP->CM.dSPA->CM.pASP->CARSM.pM_UPDATE_SYSTEM_AUDIO_ROUTE@Cko
12-22 06:47:21.748 1457 3300 I Telecom : CallAudioRouteStateMachine: Message received: SWITCH_FOCUS=4001, arg1=2: TSI.pC->CM.fOCP->CM.sOCPA->CM.dSMCP->CM.dSPA->CM.pASP->CAMSM.pM_2001->CARSM.pM_SWITCH_FOCUS@Cko
12-22 06:47:21.749 1457 3300 I Telecom : QuiescentEarpieceRoute: Processing message SWITCH_FOCUS: TSI.pC->CM.fOCP->CM.sOCPA->CM.dSMCP->CM.dSPA->CM.pASP->CAMSM.pM_2001->CARSM.pM_SWITCH_FOCUS@Cko
12-22 06:47:21.750 1457 3300 I Telecom : Event: RecordEntry TC@5: AUDIO_ROUTE, Leaving state QuiescentEarpieceRoute: TSI.pC->CM.fOCP->CM.sOCPA->CM.dSMCP->CM.dSPA->CM.pASP->CAMSM.pM_2001->CARSM.pM_SWITCH_FOCUS@Cko
12-22 06:47:21.750 1457 1457 D MediaSessionService: Global priority session is updated, active=true
12-22 06:47:21.750 1457 3300 I Telecom : Event: RecordEntry TC@5: AUDIO_ROUTE, Entering state ActiveEarpieceRoute: TSI.pC->CM.fOCP->CM.sOCPA->CM.dSMCP->CM.dSPA->CM.pASP->CAMSM.pM_2001->CARSM.pM_SWITCH_FOCUS@Cko
12-22 06:47:21.751 1457 1457 I Telecom : InCallController: onConnected to ComponentInfo{com.android.bluetooth/com.android.bluetooth.telephony.BluetoothInCallService}: ICSBC.oSC(cab)@Cks
12-22 06:47:21.751 2620 2620 I MediaPlayerList: onMediaKeyEventSessionChanged: token=com.android.server.telecom
12-22 06:47:21.751 1457 3300 I Telecom : Event: RecordEntry TC@5: AUDIO_ROUTE_EARPIECE, null: TSI.pC->CM.fOCP->CM.sOCPA->CM.dSMCP->CM.dSPA->CM.pASP->CAMSM.pM_2001->CARSM.pM_SWITCH_FOCUS@Cko
12-22 06:47:21.751 2620 2620 W MediaPlayerList: com.android.server.telecom is already the active player
12-22 06:47:21.751 1457 1457 I Telecom : InCallController: Adding 1 calls to InCallService after onConnected: ComponentInfo{com.android.bluetooth/com.android.bluetooth.telephony.BluetoothInCallService}, including external calls: ICSBC.oSC(cab)@Cks
12-22 06:47:21.752 1457 3300 I Telecom : CallAudioRouteStateMachine: turning speaker phone false: TSI.pC->CM.fOCP->CM.sOCPA->CM.dSMCP->CM.dSPA->CM.pASP->CAMSM.pM_2001->CARSM.pM_SWITCH_FOCUS@Cko
12-22 06:47:21.753 1457 1457 W Telecom : Call: maybeOnInCallServiceTrackingChanged() request on a call without a connection service.: ICSBC.oSC(cab)@Cks
12-22 06:47:21.753 2620 2620 D BluetoothInCallService: onCallAdded
12-22 06:47:21.754 1457 1457 I Telecom : InCallController: 1 calls sent to InCallService.: ICSBC.oSC(cab)@Cks
12-22 06:47:21.754 2620 2620 D BluetoothInCallService: onCallAudioStateChanged, audioState == [AudioState isMuted: false, route: EARPIECE, supportedRouteMask: EARPIECE, SPEAKER, activeBluetoothDevice: [null], supportedBluetoothDevices: []]
12-22 06:47:21.756 2620 2620 V MediaPlayerList: onActiveSessionsChanged: number of controllers: 1
12-22 06:47:21.757 2620 2620 D MediaPlayerList: onActiveSessionsChanged: controller: com.android.server.telecom
12-22 06:47:21.757 2620 2620 D MediaPlayerList: Already have a controller for the player: com.android.server.telecom, updating instead
12-22 06:47:21.759 1457 1457 I Telecom : CallerInfoLookupHelper: CI query for handle tel:*90 has completed; notifying all listeners.: TSI.pC->CILH.sL->CILH.oQC@Cko
12-22 06:47:21.759 2620 2620 D MediaPlayerList: sendMediaUpdate
12-22 06:47:21.759 1457 1457 I Telecom : Call: CallerInfo received for tel:*90: android.telecom.CallerInfo@849381a { name null, phoneNumber non-null }: TSI.pC->CILH.sL->CILH.oQC@Cko
12-22 06:47:21.759 2620 2620 I MediaPlayerList: sendMediaUpdate: Creating a one item queue for a player with no queue
12-22 06:47:21.760 1457 1457 I Telecom : CallerInfoLookupHelper: There is no photo for this contact, skipping photo query: TSI.pC->CILH.sL->CILH.oQC@Cko
12-22 06:47:21.760 2620 2620 D MediaPlayerList: sendMediaUpdate state=null
12-22 06:47:21.760 2620 2620 D AvrcpNativeInterface: sendMediaUpdate: metadata=false playStatus=false queue=false
12-22 06:47:21.760 1457 1457 I Telecom : CallsManager: Outgoing caller ID complete: TSI.pC->CILH.sL->CILH.oQC->CM.pCSB@Cko
12-22 06:47:21.760 2620 2620 D AvrcpTargetJni: sendMediaUpdateNative
12-22 06:47:21.761 2620 2620 I bt_stack: [INFO:avrcp_service.cc(412)] virtual void bluetooth::avrcp::AvrcpService::SendMediaUpdate(bool, bool, bool) track_changed=0 : play_state=0 : queue=0
12-22 06:47:21.762 1001 4907 W APM_AudioPolicyManager: stopAudioSource unknown source for port ID 0
12-22 06:47:21.766 0 0 I : tas2562 tas2562: irq_work_routine
12-22 06:47:21.769 0 0 I : tas2562 tas2562: IRQ status : 0x0, 0x0, 0x0, 0x0
12-22 06:47:21.839 2620 6470 D BluetoothHeadset: Proxy object connected
12-22 06:47:21.840 2620 2620 I BluetoothInCallService: updateHeadsetWithCallState numActive 0, numHeld 0, callState 2, ringing type 128
12-22 06:47:21.841 2620 2620 I BluetoothInCallService: updateHeadsetWithCallState numActive 0, numHeld 0, callState 3, ringing type 128
12-22 06:47:21.888 923 2581 D audio_hw_primary: adev_create_audio_patch: enter: num sources 1, num_sinks 1, handle 1
12-22 06:47:21.888 923 2581 D audio_hw_primary: adev_create_audio_patch: Playback patch from mix handle 13 to device 1
12-22 06:47:21.889 923 2581 D audio_hw_primary: update_patch: enter
12-22 06:47:21.889 923 2581 D audio_hw_primary: route_output_stream: enter: usecase(1: low-latency-playback) devices 1
12-22 06:47:21.893 923 2581 D voice_extn: update_calls: enter:
12-22 06:47:21.894 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10c01000
12-22 06:47:21.894 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10dc1000
12-22 06:47:21.895 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10c02000
12-22 06:47:21.895 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10803000
12-22 06:47:21.895 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10002000
12-22 06:47:21.896 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=11c05000
12-22 06:47:21.896 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=11dc5000
12-22 06:47:21.896 923 2581 D audio_hw_primary: select_devices for use case (low-latency-playback)
12-22 06:47:21.897 923 2581 D msm8974_platform: is_operator_tmus: tmus mccmnc 22210
12-22 06:47:21.897 923 2581 D audio_hw_primary: select_devices: changing use case low-latency-playback output device from(2: speaker, acdb 10011) to (25: voice-handset, acdb 7)
12-22 06:47:21.898 923 2581 D audio_hw_primary: disable_audio_route: reset and update mixer path: low-latency-playback
12-22 06:47:21.903 0 0 I : tas2562 tas2562: set power state: 2
12-22 06:47:21.927 0 0 I : tas2562 tas2562: SND_SOC_DAPM_PRE_PMD
12-22 06:47:21.936 923 2581 E soundtrigger: audio_extn_sound_trigger_update_stream_status: invalid input device 0x0, for event 2
12-22 06:47:21.928 0 0 I afe_close: port_id = 0x1004
12-22 06:47:21.937 923 2581 D soundtrigger: audio_extn_sound_trigger_update_stream_status: uc_info->id 1 of type 0 for Event 2, with Raise=0
12-22 06:47:21.937 923 2581 D msm8974_platform: platform_split_snd_device: snd_device(2) num devices(0) new_snd_devices(0)
12-22 06:47:21.938 923 2581 I msm8974_platform: platform_get_custom_mtmx_params: no matching param with id 0 ip_ch 2 op_ch 2 uc_id 1 snd_dev 2
12-22 06:47:21.938 923 2581 D hardware_info: hw_info_append_hw_type : device_name = speaker
12-22 06:47:21.938 923 2581 D audio_hw_primary: disable_snd_device: snd_device(2: speaker)
12-22 06:47:21.939 923 2581 D msm8974_platform: platform_split_snd_device: snd_device(2) num devices(0) new_snd_devices(0)
12-22 06:47:21.939 923 2581 I soundtrigger: audio_extn_sound_trigger_update_device_status: device 0x2 of type 0 for Event 0, with Raise=0
12-22 06:47:21.940 923 2581 I msm8974_platform: platform_check_and_set_codec_backend_cfg:becf: afe: bitwidth 16, samplerate 48000 channels 2, backend_idx 0 usecase = 1 device (voice-handset)
12-22 06:47:21.941 923 2581 D msm8974_platform: platform_split_snd_device: snd_device(25) num devices(1) new_snd_devices(0)
12-22 06:47:21.941 923 2581 I msm8974_platform: platform_check_and_set_codec_backend_cfg: new_snd_devices[0] is 25
12-22 06:47:21.942 923 2581 I msm8974_platform: platform_check_codec_backend_cfg:becf: afe: bitwidth 16, samplerate 48000 channels 2, backend_idx 0 usecase = 1 device (voice-handset)
12-22 06:47:21.943 923 2581 D audio_hw_extn: audio_extn_enable_hifi_filter: mixer_value set 0
12-22 06:47:21.944 923 2581 D msm8974_platform: platform_check_codec_backend_cfg:becf: updated afe: bitwidth 16, samplerate 48000 channels 2,backend_idx 0 usecase = 1 device (voice-handset)
12-22 06:47:21.944 923 2581 D msm8974_platform: platform_check_codec_backend_cfg:becf: afe: playback on codec device not supporting native playback set default Sample Rate(48k)
12-22 06:47:21.944 923 2581 I msm8974_platform: platform_check_codec_backend_cfg:becf: afe: Codec selected backend: 0 updated bit width: 16 and sample rate: 48000
12-22 06:47:21.945 923 2581 D audio_hw_primary: check_usecases_codec_backend:becf: force routing 0
12-22 06:47:21.945 923 2581 D audio_hw_primary: check_usecases_codec_backend:becf: (78) check_usecases curr device: voice-handset, usecase device:speaker backends match 0
12-22 06:47:21.946 923 2581 D audio_hw_primary: check_usecases_codec_backend:becf: check_usecases num.of Usecases to switch 0
12-22 06:47:21.946 923 2581 D hardware_info: hw_info_append_hw_type : device_name = voice-handset
12-22 06:47:21.947 923 2581 D msm8974_platform: platform_split_snd_device: snd_device(25) num devices(0) new_snd_devices(0)
12-22 06:47:21.947 923 2581 D audio_hw_primary: enable_snd_device: snd_device(25: voice-handset)
12-22 06:47:21.948 923 2581 D msm8974_platform: platform_get_island_cfg_on_device:island cfg status on snd_device = (voice-handset 0)
12-22 06:47:21.948 923 2581 I soundtrigger: audio_extn_sound_trigger_update_device_status: device 0x19 of type 0 for Event 1, with Raise=0
12-22 06:47:21.949 923 2581 D audio_route: Apply path: voice-handset
12-22 06:47:21.963 923 2581 E soundtrigger: audio_extn_sound_trigger_update_stream_status: invalid input device 0x0, for event 3
12-22 06:47:21.963 923 2581 D soundtrigger: audio_extn_sound_trigger_update_stream_status: uc_info->id 1 of type 0 for Event 3, with Raise=0
12-22 06:47:21.963 923 2581 D audio_hw_utils: audio_extn_utils_send_app_type_cfg: usecase->out_snd_device voice-handset
12-22 06:47:21.964 923 2581 D msm8974_platform: platform_split_snd_device: snd_device(25) num devices(0) new_snd_devices(0)
12-22 06:47:21.965 923 2581 D audio_hw_utils: audio_extn_btsco_get_sample_rate:Not a BT SCO device, need not update sampling rate
12-22 06:47:21.965 923 2581 I audio_hw_utils: send_app_type_cfg_for_device PLAYBACK app_type 69937, acdb_dev_id 7, sample_rate 48000, snd_device_be_idx 187
12-22 06:47:21.967 923 2581 D msm8974_platform: platform_split_snd_device: snd_device(25) num devices(1) new_snd_devices(0)
12-22 06:47:21.967 923 2581 D audio_hw_utils: audio_extn_btsco_get_sample_rate:Not a BT SCO device, need not update sampling rate
12-22 06:47:21.968 923 2581 D ACDB-LOADER: ACDB -> send_audio_cal, acdb_id = 7, path = 0, app id = 0x11131, sample rate = 48000, afe_sample_rate = 48000
12-22 06:47:21.968 923 2581 D ACDB-LOADER: ACDB -> send_asm_topology
12-22 06:47:21.969 923 2581 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_STREAM_TOPOLOGY_ID
12-22 06:47:21.969 923 2581 D ACDB-LOADER: ACDB -> send_adm_topology
12-22 06:47:21.970 923 2581 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_COMMON_TOPOLOGY_ID
12-22 06:47:21.970 923 2581 D ACDB-LOADER: ACDB -> send_audtable
12-22 06:47:21.971 923 2581 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_INSTANCE_COMMON_TABLE_SIZE
12-22 06:47:21.971 923 2581 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_INSTANCE_COMMON_TABLE
12-22 06:47:21.971 923 2581 D ACDB-LOADER: ACDB -> AUDIO_SET_AUDPROC_CAL cal_type[11] acdb_id[7] app_type[69937]
12-22 06:47:21.972 923 2581 D ACDB-LOADER: ACDB -> send_audvoltable
12-22 06:47:21.972 923 2581 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_INSTANCE_GAIN_DEP_STEP_TABLE_SIZE
12-22 06:47:21.973 923 2581 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_INSTANCE_GAIN_DEP_STEP_TABLE, vol index 0
12-22 06:47:21.973 923 2581 D ACDB-LOADER: ACDB -> AUDIO_SET_VOL_CAL cal type = 12
12-22 06:47:21.974 923 2581 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_INSTANCE_STREAM_TABLE_SIZE
12-22 06:47:21.974 923 2581 D ACDB-LOADER: ACDB -> send_audstrmtable
12-22 06:47:21.975 923 2581 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_INSTANCE_STREAM_TABLE
12-22 06:47:21.975 923 2581 D ACDB-LOADER: ACDB -> audstrm_cal->cal_type.cal_data.cal_size = 20
12-22 06:47:21.976 923 2581 D ACDB-LOADER: ACDB -> send_afe_topology
12-22 06:47:21.976 923 2581 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_TOPOLOGY_ID
12-22 06:47:21.976 923 2581 D ACDB-LOADER: ACDB -> GET_AFE_TOPOLOGY_ID for adcd_id 7, Topology Id 112fc
12-22 06:47:21.977 923 2581 D ACDB-LOADER: ACDB -> send_afe_cal
12-22 06:47:21.977 923 2581 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_INSTANCE_COMMON_TABLE_SIZE
12-22 06:47:21.978 923 2581 D android.hardware.audio.service: Failed to fetch the lookup information of the device 00000007
12-22 06:47:21.978 923 2581 D ACDB-LOADER: Error: ACDB_CMD_GET_AFE_INSTANCE_COMMON_TABLE_SIZE Returned = -19
12-22 06:47:21.978 923 2581 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_INSTANCE_COMMON_TABLE
12-22 06:47:21.979 923 2581 D android.hardware.audio.service: Failed to fetch the lookup information of the device 00000007
12-22 06:47:21.979 923 2581 D ACDB-LOADER: Error: ACDB AFE returned = -19
12-22 06:47:21.980 923 2581 D ACDB-LOADER: ACDB -> AUDIO_SET_AFE_CAL cal_type[16] acdb_id[7]
12-22 06:47:21.980 923 2581 D ACDB-LOADER: ACDB -> send_hw_delay : acdb_id = 7 path = 0
12-22 06:47:21.981 923 2581 D ACDB-LOADER: ACDB -> ACDB_AVSYNC_INFO: ACDB_CMD_GET_DEVICE_PROPERTY
12-22 06:47:21.981 923 2581 D msm8974_platform: platform_split_snd_device: snd_device(25) num devices(0) new_snd_devices(0)
12-22 06:47:21.981 923 2581 I msm8974_platform: platform_get_custom_mtmx_params: no matching param with id 0 ip_ch 2 op_ch 2 uc_id 1 snd_dev 25
12-22 06:47:21.982 923 2581 D audio_hw_primary: enable_audio_route: apply mixer and update path: low-latency-playback handset
12-22 06:47:21.982 923 2581 D audio_route: Apply path: low-latency-playback handset
12-22 06:47:22.019 0 0 I __afe_port_start: port id: 0xb030
12-22 06:47:22.019 0 0 I afe_find_cal_topo_id_by_port: port id: 0xb030, dev_acdb_id: 7
12-22 06:47:22.019 0 0 I afe_find_cal_topo_id_by_port: top_id:112fc acdb_id:7 afe_port_id:0xb030
12-22 06:47:22.019 0 0 I afe_get_cal_topology_id: port_id = 0xb030 acdb_id = 7 topology_id = 0x112fc cal_type_index=8 ret=0
12-22 06:47:22.019 0 0 I afe_send_port_topology_id: AFE set topology id 0x112fc enable for port 0xb030 ret 0
12-22 06:47:22.019 0 0 I send_afe_cal_type: cal_index is 0
12-22 06:47:22.019 0 0 I send_afe_cal_type: dev_acdb_id[170] is 7
12-22 06:47:22.019 0 0 I afe_find_cal: cal_index 0 port_id 0xb030 port_index 170
12-22 06:47:22.019 0 0 I afe_find_cal: acdb_id 7 dev_acdb_id 7 sample_rate 48000 afe_sample_rates 48000
12-22 06:47:22.019 0 0 I afe_find_cal: cal block is a match, size is 0
12-22 06:47:22.019 0 0 I send_afe_cal_type: Sending cal_index cal 0
12-22 06:47:22.019 0 0 E send_afe_cal_type: No cal sent for cal_index 0, port_id = 0xb030! ret -22
12-22 06:47:22.019 0 0 I afe_send_hw_delay: port_id 0xb030 rate 48000 delay_usec 474 status 0
12-22 06:47:22.030 923 2581 D audio_hw_primary: select_devices: done
12-22 06:47:22.031 923 4098 W audio_hw_primary: out_get_presentation_position: avail:384 > kernel_buffer_size:384 clamping!
12-22 06:47:22.031 923 4098 W audio_hw_primary: out_write: underrun(30) frames_by_time(88) > out->last_fifo_frames_remaining(0)
12-22 06:47:22.035 923 4098 W audio_hw_primary: out_write: underrun(31) frames_by_time(274) > out->last_fifo_frames_remaining(192)
12-22 06:47:22.060 1457 3300 W system_server: Long monitor contention with owner AudioService (2579) at void com.android.server.audio.AudioService$AudioHandler.handleMessage(android.os.Message)(AudioService.java:7752) waiters=0 in void com.android.server.audio.AudioDeviceBroker.setSpeakerphoneOn(android.os.IBinder, int, boolean, java.lang.String) for 307ms
12-22 06:47:22.060 5234 5234 I Dialer : AudioModeProvider.getApproximatedAudioRoute - Routing to earpiece
12-22 06:47:22.062 5234 5234 I Dialer : ProximitySensor.updateProximitySensorMode - screenOnImmediately: false, dialPadVisible: false, offHook: false, horizontal: false, uiShowing: false, audioRoute: EARPIECE
12-22 06:47:22.062 1457 3300 I Telecom : CallAudioRouteStateMachine: setSystemAudioState: changing from [AudioState isMuted: false, route: EARPIECE, supportedRouteMask: EARPIECE, SPEAKER, activeBluetoothDevice: [null], supportedBluetoothDevices: []] to [AudioState isMuted: false, route: EARPIECE, supportedRouteMask: EARPIECE, SPEAKER, activeBluetoothDevice: [null], supportedBluetoothDevices: []]: TSI.pC->CM.fOCP->CM.sOCPA->CM.dSMCP->CM.dSPA->CM.pASP->CAMSM.pM_2001->CARSM.pM_SWITCH_FOCUS@Cko
12-22 06:47:22.062 923 2581 D audio_hw_primary: adev_set_parameters: enter: BT_SCO=off
12-22 06:47:22.062 5234 5234 I Dialer : ProximitySensor.turnOffProximitySensor - wake lock already released
12-22 06:47:22.063 923 2581 D audio_hw_hfp: hfp_set_parameters: enter
12-22 06:47:22.063 923 2581 D audio_hw_extn: audio_extn_fm_set_parameters: Enter
12-22 06:47:22.063 5234 5234 I Dialer : InCallPresenter.onCallListChange - Phone switching state: NO_CALLS -> NO_CALLS
12-22 06:47:22.064 5234 5234 I Dialer : VideoPauseController.setUp - enter
12-22 06:47:22.068 1457 2580 I AS.AudioDeviceInventory: removePreferredDevicesForStrategySync, strategy: 15
12-22 06:47:22.068 1457 3300 I Telecom : InCallController: Calling onAudioStateChanged, audioState: [AudioState isMuted: false, route: EARPIECE, supportedRouteMask: EARPIECE, SPEAKER, activeBluetoothDevice: [null], supportedBluetoothDevices: []] -> [AudioState isMuted: false, route: EARPIECE, supportedRouteMask: EARPIECE, SPEAKER, activeBluetoothDevice: [null], supportedBluetoothDevices: []]: TSI.pC->CM.fOCP->CM.sOCPA->CM.dSMCP->CM.dSPA->CM.pASP->CAMSM.pM_2001->CARSM.pM_SWITCH_FOCUS@Cko
12-22 06:47:22.071 5234 5234 I Dialer : InCallPresenter.setBoundAndWaitingForOutgoingCall - setBoundAndWaitingForOutgoingCall: true
12-22 06:47:22.073 1457 5763 I ActivityTaskManager: START u0 {act=android.intent.action.MAIN flg=0x10040000 cmp=com.android.dialer/com.android.incallui.InCallActivity (has extras)} from uid 10121
12-22 06:47:22.074 1457 5763 W ActivityTaskManager: Can't find TaskDisplayArea to determine support for multi window. Task id=29 attached=false
12-22 06:47:22.082 1457 5763 V SplashScreenExceptionList: SplashScreen checking exception for package com.android.dialer (target sdk:29) -> false
12-22 06:47:22.087 3079 3119 D SplashScreenView: Build android.window.SplashScreenView{9adc577 V.E...... ......ID 0,0-0,0}
12-22 06:47:22.087 3079 3119 D SplashScreenView: Icon: view: null drawable: null size: 0
12-22 06:47:22.087 3079 3119 D SplashScreenView: Branding: view: android.view.View{23185e4 G.ED..... ......I. 0,0-0,0 #10204a9 android:id/splashscreen_branding_view} drawable: null size w: 0 h: 0
12-22 06:47:22.091 5234 5234 I Dialer : ReturnToCallController.hide - hide() called without calling show()
12-22 06:47:22.092 5234 5234 I Dialer : ReturnToCallController.hide - hide() called without calling show()
12-22 06:47:22.092 5234 5234 I Dialer : StubFeedbackModule.provideCallFeedbackListener - returning stub
12-22 06:47:22.093 1457 1457 I Telecom : InCallController: onConnected to ComponentInfo{com.android.dialer/com.android.incallui.InCallServiceImpl}: ICSBC.oSC(cad)@Ck4
12-22 06:47:22.093 1457 1457 I Telecom : InCallController: trackCallingUserInterfaceStarted: com.android.dialer is now calling UX.: ICSBC.oSC(cad)@Ck4
12-22 06:47:22.094 1457 1457 I Telecom : InCallController: Adding 1 calls to InCallService after onConnected: ComponentInfo{com.android.dialer/com.android.incallui.InCallServiceImpl}, including external calls: ICSBC.oSC(cad)@Ck4
12-22 06:47:22.095 1457 1457 W Telecom : Call: maybeOnInCallServiceTrackingChanged() request on a call without a connection service.: ICSBC.oSC(cad)@Ck4
12-22 06:47:22.095 1457 1457 I Telecom : InCallController: 1 calls sent to InCallService.: ICSBC.oSC(cad)@Ck4
12-22 06:47:22.096 1457 1457 I Telecom : NewOutgoingCallBroadcastIntentReceiver: Received new-outgoing-call-broadcast for [Call id=TC@5, state=CONNECTING, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=null, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[], prop=[]] with data ***: NOCBIR.oR@Ck8
12-22 06:47:22.096 5234 5234 I Dialer : MainSearchController.onActivityPause - enter
12-22 06:47:22.097 1457 1457 I Telecom : NewOutgoingCallIntentBroadcaster: Placing call immediately instead of waiting for OutgoingCallBroadcastReceiver: NOCBIR.oR@Ck8
12-22 06:47:22.097 5234 5234 I Dialer : MainSearchController.closeSearch - enter
12-22 06:47:22.098 1457 1457 I Telecom : CallsManager: Creating a new outgoing call with handle: tel:*90: NOCBIR.oR@Ck8
12-22 06:47:22.098 5234 5234 I Dialer : MainSearchController.hideDialpad - enter
12-22 06:47:22.104 1457 1457 I Telecom : PhoneAccountRegistrar: getSimCallManager: SimCallManager for subId 1 queried, returning: null: NOCBIR.oR@Ck8
12-22 06:47:22.105 1457 1457 I Telecom : CreateConnectionProcessor: Trying attempt CallAttemptRecord(ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0},ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}): NOCBIR.oR@Ck8
12-22 06:47:22.107 1457 3302 I Telecom : ConnectionServiceFocusManager: handleRequestFocus req = com.android.server.telecom.ConnectionServiceFocusManager$FocusRequest@76361be: NOCBIR.oR->CSFM.rF@Ck8
12-22 06:47:22.108 1457 3302 I Telecom : Logging.Events: Non-call EVENT: BIND_CS, ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}: NOCBIR.oR->CSFM.rF@Ck8
12-22 06:47:22.113 1457 3302 I Telecom : ConnectionServiceWrapper: createConnection([Call id=TC@5, state=CONNECTING, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[], prop=[]]) via ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}.: NOCBIR.oR->CSFM.rF@Ck8
12-22 06:47:22.115 1457 1457 I Telecom : ServiceBinderConnection: Service bound ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}: SBC.oSC(cap)@ClA
12-22 06:47:22.115 1457 1457 I Telecom : Logging.Events: Non-call EVENT: CS_BOUND, ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}: SBC.oSC(cap)@ClA
12-22 06:47:22.118 1457 1457 I Telecom : Event: RecordEntry TC@5: START_CONNECTION, tel:*90 via:com.android.phone: SBC.oSC(cap)@ClA
12-22 06:47:22.123 1457 5763 I Telecom : PhoneAccountRegistrar: getSimCallManager: SimCallManager for subId 1 queried, returning: null: (...->CS.aCSA->H.CS.aCSA)->CSW.qRCS(cap)@E-E-ClA
12-22 06:47:22.123 1457 5763 W Telecom : ConnectionServiceWrapper: call provider also detected as SIM call manager: [ConnectionServiceWrapper componentName=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}]: (...->CS.aCSA->H.CS.aCSA)->CSW.qRCS(cap)@E-E-ClA
12-22 06:47:22.123 5234 5234 E SpannableStringBuilder: SPAN_EXCLUSIVE_EXCLUSIVE spans cannot have a zero length
12-22 06:47:22.124 3197 3197 I TelecomFramework: TelephonyConnectionService: createConnection, callManagerAccount: ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, callId: TC@5_1, request: ConnectionRequest xxxxxxx Bundle[android.telecom.extra.START_CALL_WITH_VIDEO_STATE=0, android.telecom.extra.CALL_TELECOM_ROUTING_END_TIME_MILLIS=792665, android.telecom.extra.CALL_CREATED_TIME_MILLIS=792618, android.telecom.extra.CALL_TELECOM_ROUTING_START_TIME_MILLIS=792664, com.android.dialer.callintent.CALL_SPECIFIC_APP_DATA=[B@56a6367, ] isAdhocConf: N, isIncoming: false, isUnknown: false, isLegacyHandover: false, isHandover: false, addSelfManaged: true: (SBC.oSC)->CS.crCo->H.CS.crCo->H.CS.crCo.pICR(cap/cast)@E-ClA
12-22 06:47:22.125 3197 3197 I Telephony: onCreateOutgoingConnection, request: ConnectionRequest xxxxxxx Bundle[android.telecom.extra.START_CALL_WITH_VIDEO_STATE=0, android.telecom.extra.CALL_TELECOM_ROUTING_END_TIME_MILLIS=792665, android.telecom.extra.CALL_CREATED_TIME_MILLIS=792618, android.telecom.extra.CALL_TELECOM_ROUTING_START_TIME_MILLIS=792664, com.android.dialer.callintent.CALL_SPECIFIC_APP_DATA=[B@56a6367, ] isAdhocConf: N
12-22 06:47:22.126 1457 5763 W ActivityTaskManager: Tried to set launchTime (0) < mLastActivityLaunchTime (606151)
12-22 06:47:22.128 3197 3197 V Telephony: onStateChanged, state: INITIALIZING
12-22 06:47:22.129 3197 3197 D Telephony: buildConnectionCapabilities: isHoldable = false State = 0 capabilities = 0
12-22 06:47:22.134 3197 3197 D TelephonyProvider: Using old permission behavior for telephony provider compat
12-22 06:47:22.147 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.153 3197 3197 D TelephonyProvider: Using old permission behavior for telephony provider compat
12-22 06:47:22.157 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.158 5234 5234 I Dialer : CallList.onUpdateCall - [DialerCall_4, CONNECTING, [Capabilities:], [Properties:], children:[], parent:null, conferenceable:[], videoState:Audio Only, mSessionModificationState:0, CameraDir:-1]
12-22 06:47:22.158 5234 5234 I Dialer : ReturnToCallController.hide - hide() called without calling show()
12-22 06:47:22.158 5234 5234 I Dialer : InCallPresenter.onCallListChange - Phone switching state: PENDING_OUTGOING -> PENDING_OUTGOING
12-22 06:47:22.160 1457 5907 W ServiceManager: Permission failure: android.permission.HIGH_SAMPLING_RATE_SENSORS from uid=10121 pid=5234
12-22 06:47:22.161 1457 5763 W ServiceManager: Permission failure: android.permission.HIGH_SAMPLING_RATE_SENSORS from uid=10121 pid=5234
12-22 06:47:22.162 942 942 I sensors-hal: batch:242, android.sensor.accelerometer/11, period=200000000, max_latency=0
12-22 06:47:22.162 942 942 I sensors-hal: set_config:63, sample_period_ns is adjusted to 200000000 based on min/max delay_ns
12-22 06:47:22.163 942 942 I sensors-hal: batch:251, android.sensor.accelerometer/11, period=200000000, max_latency=0 request completed
12-22 06:47:22.163 942 942 I sensors-hal: flush:271, android.sensor.accelerometer/11
12-22 06:47:22.164 942 942 I sensors-hal: flush:277, android.sensor.accelerometer/11 completed
12-22 06:47:22.164 942 7068 I sensors-hal: ssc_conn_resp_cb:663, resp_value = 0
12-22 06:47:22.165 5234 5234 I Dialer : ProximitySensor.updateProximitySensorMode - screenOnImmediately: false, dialPadVisible: false, offHook: true, horizontal: false, uiShowing: false, audioRoute: EARPIECE
12-22 06:47:22.165 5234 5234 I Dialer : ProximitySensor.turnOnProximitySensor - acquiring wake lock
12-22 06:47:22.165 3197 3197 D TelephonyProvider: Using old permission behavior for telephony provider compat
12-22 06:47:22.167 942 942 I sensors-hal: batch:242, android.sensor.proximity/82, period=200000000, max_latency=0
12-22 06:47:22.167 5234 5234 I Dialer : VideoPauseController.onStateChange - hasPrimaryCallChanged: true, videoCanPause: false, isInBackground: false
12-22 06:47:22.167 5234 5234 I Dialer : VideoPauseController.onPrimaryCallChanged - new call: [DialerCall_4, CONNECTING, [Capabilities:], [Properties:], children:[], parent:null, conferenceable:[], videoState:Audio Only, mSessionModificationState:0, CameraDir:-1], old call: null, mIsInBackground: false
12-22 06:47:22.167 942 7068 I sensors-hal: ssc_conn_resp_cb:663, resp_value = 0
12-22 06:47:22.168 5234 5234 I Dialer : InCallPresenter.setBoundAndWaitingForOutgoingCall - setBoundAndWaitingForOutgoingCall: false
12-22 06:47:22.168 942 942 I sensors-hal: set_config:63, sample_period_ns is adjusted to 0 based on min/max delay_ns
12-22 06:47:22.168 942 942 I sensors-hal: batch:251, android.sensor.proximity/82, period=200000000, max_latency=0 request completed
12-22 06:47:22.168 5234 5234 I Dialer : ProximitySensor.updateProximitySensorMode - screenOnImmediately: false, dialPadVisible: false, offHook: true, horizontal: false, uiShowing: false, audioRoute: EARPIECE
12-22 06:47:22.169 942 942 I sensors-hal: activate:209, android.sensor.proximity/82 en=1
12-22 06:47:22.169 5234 5234 I Dialer : ProximitySensor.turnOnProximitySensor - wake lock already acquired
12-22 06:47:22.169 942 942 I sensors-hal: get_qmi_debug_flag:241, support_qmi_debug : false
12-22 06:47:22.169 5234 5234 I Dialer : ReturnToCallController.hide - hide() called without calling show()
12-22 06:47:22.173 942 942 I sensors-hal: activate:220, android.sensor.proximity/82 en=1 completed
12-22 06:47:22.176 942 7186 I sensors-hal: ssc_conn_resp_cb:663, resp_value = 0
12-22 06:47:22.179 5234 5993 W OpenGLRenderer: Incorrectly called buildLayer on View: RelativeLayout, destroying layer...
12-22 06:47:22.179 5234 5993 W OpenGLRenderer: Incorrectly called buildLayer on View: RelativeLayout, destroying layer...
12-22 06:47:22.180 3197 3197 I Telephony: GsmConnection: registerForCallEvents; phone=Handler (com.android.internal.telephony.imsphone.ImsPhone) {d8f4886}
12-22 06:47:22.183 5234 5234 I Dialer : UiListener.create - creating new UiListener for preferredAccountWorkerResultListener
12-22 06:47:22.193 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: false, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.193 5234 5234 I Dialer : InCallFragment.onCreateView
12-22 06:47:22.194 942 7186 I sensors-hal: handle_indication_realtime:471, SCHED_FIFO(10) for qmi_cbk
12-22 06:47:22.204 5234 5234 I Dialer : InCallFragment.onViewCreated
12-22 06:47:22.204 5234 5234 I Dialer : CallCardPresenter.constructor
12-22 06:47:22.207 3174 3211 I QImsService: ImsCallSessionCallbackHandler : Constructor: start handler thread for callbacks.
12-22 06:47:22.208 3174 3211 I QImsService: ImsCallSessionImpl : updateFeatureCapabilities video false voice true
12-22 06:47:22.209 3174 3211 D VideoCall_MediaController: onSessionAdded callSession= callid= -1 mediaId=-1 mState= 0 mDc=null mCallProfile={ serviceType=1, callType=2, restrictCause=0, mediaProfile={ audioQuality=0, audioDirection=3, audioCodecAttribute=null, videoQuality=0, videoDirection=-1, rttMode=0, hasRttAudioSpeech=false }, emergencyServiceCategories=0, emergencyUrns=[], emergencyCallRouting=0, emergencyCallTesting=false, hasKnownUserIntentEmergency=false, mRestrictCause=0, mCallerNumberVerstat= 0, mAcceptedRtpHeaderExtensions= {} } mLocalCallProfile={ serviceType=1, callType=7, restrictCause=0, mediaProfile={ audioQuality=0, audioDirection=3, audioCodecAttribute=null, videoQuality=0, videoDirection=-1, rttMode=0, hasRttAudioSpeech=false }, emergencyServiceCategories=0, emergencyUrns=[], emergencyCallRouting=0, emergencyCallTesting=false, hasKnownUserIntentEmergency=false, mRestrictCause=0, mCallerNumberVerstat= 0, mAcceptedRtpHeaderExtensions= {} } mRemoteCallProfile={ serviceType=1, callType=7, restrictCause=0, mediaProfile={ audioQuality=0, audioDirection=3, audioCodecAttribute=null, videoQuality=0, videoDirection=-1, rttMode=0, hasRttAudioSpeech=false }, emergencyServiceCategories=0, emergencyUrns=[], emergencyCallRouting=0, emergencyCallTesting=false, hasKnownUserIntentEmergency=false, mRestrictCause=0, mCallerNumberVerstat= 0, mAcceptedRtpHeaderExtensions= {} } no:of call sessions = 0
12-22 06:47:22.210 3174 3211 D VideoCall_LowBattery: onSessionAdded callSession = callid= -1 mediaId=-1 mState= 0 mDc=null mCallProfile={ serviceType=1, callType=2, restrictCause=0, mediaProfile={ audioQuality=0, audioDirection=3, audioCodecAttribute=null, videoQuality=0, videoDirection=-1, rttMode=0, hasRttAudioSpeech=false }, emergencyServiceCategories=0, emergencyUrns=[], emergencyCallRouting=0, emergencyCallTesting=false, hasKnownUserIntentEmergency=false, mRestrictCause=0, mCallerNumberVerstat= 0, mAcceptedRtpHeaderExtensions= {} } mLocalCallProfile={ serviceType=1, callType=7, restrictCause=0, mediaProfile={ audioQuality=0, audioDirection=3, audioCodecAttribute=null, videoQuality=0, videoDirection=-1, rttMode=0, hasRttAudioSpeech=false }, emergencyServiceCategories=0, emergencyUrns=[], emergencyCallRouting=0, emergencyCallTesting=false, hasKnownUserIntentEmergency=false, mRestrictCause=0, mCallerNumberVerstat= 0, mAcceptedRtpHeaderExtensions= {} } mRemoteCallProfile={ serviceType=1, callType=7, restrictCause=0, mediaProfile={ audioQuality=0, audioDirection=3, audioCodecAttribute=null, videoQuality=0, videoDirection=-1, rttMode=0, hasRttAudioSpeech=false }, emergencyServiceCategories=0, emergencyUrns=[], emergencyCallRouting=0, emergencyCallTesting=false, hasKnownUserIntentEmergency=false, mRestrictCause=0, mCallerNumberVerstat= 0, mAcceptedRtpHeaderExtensions= {} }
12-22 06:47:22.211 5234 5234 I Dialer : CallCardPresenter.getLocationFragment - shouldn't show location
12-22 06:47:22.211 5234 5234 I Dialer : InCallFragment.setPrimary - PrimaryInfo, number: ***, name: Redacted-3-chars, location: null, label: null, photo: null, photoType: 0, isPhotoVisible: true, MultimediaData: null
12-22 06:47:22.212 5234 5234 I Dialer : CallCardPresenter.updatePrimaryDisplayInfo - UI not ready, not showing location
12-22 06:47:22.212 3197 3197 I ImsCall : start(1) :: session=[ImsCallSession objId:207185674 state:IDLE callId:-1] ImsCall=[ImsCall objId:187833211 onHold:N mute:N mCallProfile:{ serviceType=1, callType=2, restrictCause=0, mediaProfile={ audioQuality=0, audioDirection=3, audioCodecAttribute=null, videoQuality=0, videoDirection=-1, rttMode=0, hasRttAudioSpeech=false }, emergencyServiceCategories=0, emergencyUrns=[], emergencyCallRouting=0, emergencyCallTesting=false, hasKnownUserIntentEmergency=false, mRestrictCause=0, mCallerNumberVerstat= 0, mAcceptedRtpHeaderExtensions= [] } networkType:0 updateRequest:NONE merging:N merge action pending:N merged:N multiParty:N confHost:N buried term:N isVideo: N wasVideo: N isWifi: N session:null transientSession:null]
12-22 06:47:22.214 3174 3211 I QImsService: ImsCallSessionCallbackHandler : posting to handler
12-22 06:47:22.214 3174 7190 I QImsService: ImsCallSessionCallbackHandler : callSessionUpdated :: profile={ serviceType=1, callType=2, restrictCause=0, mediaProfile={ audioQuality=0, audioDirection=3, audioCodecAttribute=null, videoQuality=0, videoDirection=-1, rttMode=0, hasRttAudioSpeech=false }, emergencyServiceCategories=0, emergencyUrns=[], emergencyCallRouting=0, emergencyCallTesting=false, hasKnownUserIntentEmergency=false, mRestrictCause=0, mCallerNumberVerstat= 0, mAcceptedRtpHeaderExtensions= {} }
12-22 06:47:22.215 3174 3211 I QImsService: ImsSenderRxr : Dial Request - address= [3a2dc677d8e85ac856541744e288d504882feb36]clirMode= 0 callDetails= 0 3 callSubState 0 videoPauseState2 mediaId-1 Rtt mode 0 Local Ability Peer Ability Cause code 0 sipAlternateUri null, {MultiIdentity Line Info : msisdn = , line type = 1 , line status = 0} isEncrypted= false redialInfo RedialInfo: retryCallFailCause = 0 retryCallFailRadioTech = 0[SUB0]
12-22 06:47:22.216 5234 5234 I Dialer : CallCardPresenter.getLocationFragment - shouldn't show location
12-22 06:47:22.216 5234 5234 I Dialer : InCallFragment.setPrimary - PrimaryInfo, number: ***, name: Redacted-3-chars, location: null, label: null, photo: null, photoType: 0, isPhotoVisible: true, MultimediaData: null
12-22 06:47:22.217 3174 3211 I QImsService: ImsSenderRxr : [0043]> DIAL [SUB0]
12-22 06:47:22.217 5234 5234 I Dialer : CallCardPresenter.updatePrimaryDisplayInfo - UI not ready, not showing location
12-22 06:47:22.217 3174 3211 I QImsService: Class : Unsupported imsReason for ending call. Passing end cause as 'misc'.
12-22 06:47:22.218 5234 5234 I Dialer : CallCardPresenter.getLocationFragment - shouldn't show location
12-22 06:47:22.218 3174 3211 I QImsService: ImsRadioHidl : dial v1.6[SUB0]
12-22 06:47:22.218 5234 5234 I Dialer : InCallFragment.setPrimary - PrimaryInfo, number: ***, name: Redacted-3-chars, location: null, label: null, photo: null, photoType: 0, isPhotoVisible: true, MultimediaData: null
12-22 06:47:22.219 5234 5234 I Dialer : CallCardPresenter.updatePrimaryDisplayInfo - UI not ready, not showing location
12-22 06:47:22.221 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 13, connectionLabel:
12-22 06:47:22.221 3174 3211 I QImsService: ImsCallSessionImpl : getImsVideoCallProvider: Video call provider is null
12-22 06:47:22.221 3197 3552 I ImsCall : callSessionUpdated :: session=[ImsCallSession objId:207185674 state:INITIATED callId:-1] profile={ serviceType=1, callType=2, restrictCause=0, mediaProfile={ audioQuality=0, audioDirection=3, audioCodecAttribute=null, videoQuality=0, videoDirection=-1, rttMode=0, hasRttAudioSpeech=false }, emergencyServiceCategories=0, emergencyUrns=[], emergencyCallRouting=0, emergencyCallTesting=false, hasKnownUserIntentEmergency=false, mRestrictCause=0, mCallerNumberVerstat= 0, mAcceptedRtpHeaderExtensions= [] } ImsCall=[ImsCall objId:187833211 onHold:N mute:N mCallProfile:{ serviceType=1, callType=2, restrictCause=0, mediaProfile={ audioQuality=0, audioDirection=3, audioCodecAttribute=null, videoQuality=0, videoDirection=-1, rttMode=0, hasRttAudioSpeech=false }, emergencyServiceCategories=0, emergencyUrns=[], emergencyCallRouting=0, emergencyCallTesting=false, hasKnownUserIntentEmergency=false, mRestrictCause=0, mCallerNumberVerstat= 0, mAcceptedRtpHeaderExtensions= [] } networkType:0 updateRequest:NONE merging:N merge action pending:N merged:N multiParty:N confHost:N buried term:N isVideo: N wasVideo: N isWifi: N session:[ImsCallSession objId:207185674 state:INITIATED callId:-1] transientSession:null]
12-22 06:47:22.222 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - already in method, bailing
12-22 06:47:22.223 5234 5234 I Dialer : CallCardPresenter.onInCallScreenReady
12-22 06:47:22.223 5234 5234 I Dialer : CallCardPresenter.getLocationFragment - shouldn't show location
12-22 06:47:22.224 5234 5234 I Dialer : InCallFragment.setPrimary - PrimaryInfo, number: ***, name: Redacted-3-chars, location: null, label: null, photo: null, photoType: 0, isPhotoVisible: true, MultimediaData: null
12-22 06:47:22.225 5234 5234 I Dialer : CallCardPresenter.updatePrimaryDisplayInfo - UI not ready, not showing location
12-22 06:47:22.225 3174 3704 I QImsService: ImsRadioIndicationHidl : onCallStateChanged_1_7()
12-22 06:47:22.225 5234 5234 I Dialer : CallCardPresenter.getLocationFragment - shouldn't show location
12-22 06:47:22.226 3174 3704 I QImsService: ImsRadioIndicationHidl : onCallStateChanged_1_8()
12-22 06:47:22.226 3157 3784 D QcRilAudio: setParameters with: vsid=297816064;call_state=1[slot1]
12-22 06:47:22.226 5234 5234 I Dialer : InCallPresenter.updateActivity - UI Initialized
12-22 06:47:22.226 3174 3704 I QImsService: Class : Num of SrvUpdates = 1
12-22 06:47:22.226 3197 3197 I ImsExternalCallTracker: onPhoneStateChanged : hasActiveCalls = true
12-22 06:47:22.227 3174 3704 I QImsService: Class : networkMode = 0 status = 2 restrictCause = 0 registered = 0
12-22 06:47:22.227 923 2581 D audio_hw_primary: adev_set_parameters: enter: call_state=1;vsid=297816064
12-22 06:47:22.227 3197 3197 D ImsExternalCallTracker: refreshCallPullState
12-22 06:47:22.227 3174 3704 I QImsService: Class : Partially Enabled Status due to Restrict Cause
12-22 06:47:22.227 923 2581 D voice_extn: update_call_states is_call_active:0 in_call:1, mode:2
12-22 06:47:22.228 3174 3704 I QImsService: Class : RTT: copySrvStatusList rtt mode = 2
12-22 06:47:22.228 923 2581 D voice_extn: update_calls: enter:
12-22 06:47:22.228 3174 3704 I QImsService: Class : Num of SrvUpdates = 0
12-22 06:47:22.228 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10c01000
12-22 06:47:22.229 3174 3704 I QImsService: Class : Call Details = 0 3 callSubState 0 videoPauseState2 mediaId17 Rtt mode 0 Local Ability isValid = true type = 0 status = 1 rttMode = 0 accTechStatus mode = 0 Status = 2 restrictCause = 0 registered = 0 Peer Ability Cause code 0 sipAlternateUri null, null
12-22 06:47:22.229 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10dc1000
12-22 06:47:22.230 3174 3704 I QImsService: Class : Call fail cause= 1
12-22 06:47:22.230 3197 3197 I Telephony: setOriginalConnection: TelephonyConnection, originalConnection: [ImsPhoneConnection objId: 81223064 telecomCallID: null address: [Oi3Gd9joWshWVBdE4ojVBIgv6zY] isAdhocConf: N ImsCall: [ImsCall objId:187833211 onHold:N mute:N mCallProfile:{ serviceType=1, callType=2, restrictCause=0, mediaProfile={ audioQuality=0, audioDirection=3, audioCodecAttribute=null, videoQuality=0, videoDirection=-1, rttMode=0, hasRttAudioSpeech=false }, emergencyServiceCategories=0, emergencyUrns=[], emergencyCallRouting=0, emergencyCallTesting=false, hasKnownUserIntentEmergency=false, mRestrictCause=0, mCallerNumberVerstat= 0, mAcceptedRtpHeaderExtensions= [] } networkType:0 updateRequest:NONE merging:N merge action pending:N merged:N multiParty:N confHost:N buried term:N isVideo: N wasVideo: N isWifi: N session:[ImsCallSession objId:207185674 state:INITIATED callId:-1] transientSession:null]]
12-22 06:47:22.230 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10c02000
12-22 06:47:22.230 3174 3704 I QImsService: Class : CallFailCauseResponse has no int error code!
12-22 06:47:22.231 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10803000
12-22 06:47:22.232 5234 5234 I Dialer : InCallPresenter.onCallListChange - Phone switching state: PENDING_OUTGOING -> PENDING_OUTGOING
12-22 06:47:22.232 3174 3704 I QImsService: ImsSenderRxr : [UNSL]< UNSOL_RESPONSE_CALL_STATE_CHANGED [id=1,DIALING,toa=129,norm,mo,0,voc,noevp,,cli=1,,3Call Details = 0 3 callSubState 0 videoPauseState2 mediaId17 Rtt mode 0 Local Ability isValid = true type = 0 status = 1 rttMode = 0 accTechStatus mode = 0 Status = 2 restrictCause = 0 registered = 0 Peer Ability Cause code 0 sipAlternateUri null, null,CallFailCause Code= 501,CallFailCause String= null, isEncrypted=false, historyInfo=, Conf. Support=0, {MultiIdentity Line Info : msisdn = , line type = 0 , line status = 0}, isTirOverwriteAllowed=false, isPreparatory=false, CRS data=CrsData crsType: 0 originalCallType: 10, Call progress Info = CallProgressInfo Type: -1 Reason code: 0 Reason Text: null, diversionInfo =, additional call info =MsimAdditionalCallInfo additional code : -1] [SUB0]
12-22 06:47:22.232 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10002000
12-22 06:47:22.234 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=11c05000
12-22 06:47:22.235 3197 3197 I Telephony: registerForCallEvents - same phone requested forregistration, ignoring.
12-22 06:47:22.235 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=11dc5000
12-22 06:47:22.236 3174 3704 I QImsService: ImsSenderRxr : InCall VoicePrivacy is disabled[SUB0]
12-22 06:47:22.236 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 13, connectionLabel:
12-22 06:47:22.237 923 2581 D audio_hw_hfp: hfp_set_parameters: enter
12-22 06:47:22.238 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.238 923 2581 D audio_hw_extn: audio_extn_fm_set_parameters: Enter
12-22 06:47:22.239 3174 3174 I QImsService: ImsServiceSubHandler : Message received: what = 1
12-22 06:47:22.239 5234 5234 I Dialer : VideoPauseController.onStateChange - hasPrimaryCallChanged: false, videoCanPause: false, isInBackground: false
12-22 06:47:22.239 3174 3174 I QImsService: ImsServiceSub : [0] >handleCalls
12-22 06:47:22.240 5234 5234 I Dialer : ProximitySensor.updateProximitySensorMode - screenOnImmediately: false, dialPadVisible: false, offHook: true, horizontal: false, uiShowing: true, audioRoute: EARPIECE
12-22 06:47:22.240 3174 3211 I QImsService: ImsCallSessionImpl : getImsVideoCallProvider: Video call provider is null
12-22 06:47:22.240 5234 5234 I Dialer : ProximitySensor.turnOnProximitySensor - wake lock already acquired
12-22 06:47:22.241 3174 3174 I QImsService: ImsServiceSub : [0] handleCalls: dc = id=1,DIALING,toa=129,norm,mo,0,voc,noevp,,cli=1,,3Call Details = 0 3 callSubState 0 videoPauseState2 mediaId17 Rtt mode 0 Local Ability isValid = true type = 0 status = 1 rttMode = 0 accTechStatus mode = 0 Status = 2 restrictCause = 0 registered = 0 Peer Ability Cause code 0 sipAlternateUri null, null,CallFailCause Code= 501,CallFailCause String= null, isEncrypted=false, historyInfo=, Conf. Support=0, {MultiIdentity Line Info : msisdn = , line type = 0 , line status = 0}, isTirOverwriteAllowed=false, isPreparatory=false, CRS data=CrsData crsType: 0 originalCallType: 10, Call progress Info = CallProgressInfo Type: -1 Reason code: 0 Reason Text: null, diversionInfo =, additional call info =MsimAdditionalCallInfo additional code : -1
12-22 06:47:22.241 5234 5234 I Dialer : InCallPresenter.refreshMuteState - refreshMuteStateAfterAddCall: false addCallClicked: false
12-22 06:47:22.241 3157 3784 I QcrilOemhookMsgTunnel: [0]processOemHookIndication length=47
12-22 06:47:22.241 5234 5234 I Dialer : ReturnToCallController.hide - hide() called without calling show()
12-22 06:47:22.242 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.242 3174 3174 I QImsService: ImsServiceClassTracker : Found match call session in temp list, s = callid= -1 mediaId=-1 mState= 1 mDc=null mCallProfile={ serviceType=1, callType=2, restrictCause=0, mediaProfile={ audioQuality=0, audioDirection=3, audioCodecAttribute=null, videoQuality=0, videoDirection=-1, rttMode=0, hasRttAudioSpeech=false }, emergencyServiceCategories=0, emergencyUrns=[], emergencyCallRouting=0, emergencyCallTesting=false, hasKnownUserIntentEmergency=false, mRestrictCause=0, mCallerNumberVerstat= 0, mAcceptedRtpHeaderExtensions= {} } mLocalCallProfile={ serviceType=1, callType=7, restrictCause=0, mediaProfile={ audioQuality=0, audioDirection=3, audioCodecAttribute=null, videoQuality=0, videoDirection=-1, rttMode=0, hasRttAudioSpeech=false }, emergencyServiceCategories=0, emergencyUrns=[], emergencyCallRouting=0, emergencyCallTesting=false, hasKnownUserIntentEmergency=false, mRestrictCause=0, mCallerNumberVerstat= 0, mAcceptedRtpHeaderExtensions= {} } mRemoteCallProfile={ serviceType=1, callType=7, restrictCause=0, mediaProfile={ audioQuality=0, audioDirection=3, audioCodecAttribute=null, videoQuality=0, videoDirection=-1, rttMode=0, hasRttAudioSpeech=false }, emergencyServiceCategories=0, emergencyUrns=[], emergencyCallRouting=0, emergencyCallTesting=false, hasKnownUserIntentEmergency=false, mRestrictCause=0, mCallerNumberVerstat= 0, mAcceptedRtpHeaderExtensions= {} }
12-22 06:47:22.243 3157 3784 D QcRilAudio: setParameters with: vsid=297816064;call_state=1[slot1]
12-22 06:47:22.244 3174 3174 I QImsService: ImsServiceClassTracker : Index in call list is 1
12-22 06:47:22.244 923 2581 D audio_hw_primary: adev_set_parameters: enter: call_state=1;vsid=297816064
12-22 06:47:22.244 3197 3197 D Telephony: buildConnectionCapabilities: isHoldable = false State = 0 capabilities = 2
12-22 06:47:22.244 3174 3174 I QImsService: ImsCallSessionImpl : updateCall for id=1,DIALING,toa=129,norm,mo,0,voc,noevp,,cli=1,,3Call Details = 0 3 callSubState 0 videoPauseState2 mediaId17 Rtt mode 0 Local Ability isValid = true type = 0 status = 1 rttMode = 0 accTechStatus mode = 0 Status = 2 restrictCause = 0 registered = 0 Peer Ability Cause code 0 sipAlternateUri null, null,CallFailCause Code= 501,CallFailCause String= null, isEncrypted=false, historyInfo=, Conf. Support=0, {MultiIdentity Line Info : msisdn = , line type = 0 , line status = 0}, isTirOverwriteAllowed=false, isPreparatory=false, CRS data=CrsData crsType: 0 originalCallType: 10, Call progress Info = CallProgressInfo Type: -1 Reason code: 0 Reason Text: null, diversionInfo =, additional call info =MsimAdditionalCallInfo additional code : -1
12-22 06:47:22.245 923 2581 D voice_extn: update_call_states is_call_active:0 in_call:1, mode:2
12-22 06:47:22.245 5234 5234 I Dialer : InCallActivity.onPseudoScreenStateChanged - isOn: true
12-22 06:47:22.245 3174 3174 I QImsService: ImsCallSessionImpl : updateImsCallProfile :: Packing encryption=false in mCallProfile's extras.
12-22 06:47:22.246 923 2581 D voice_extn: update_calls: enter:
12-22 06:47:22.246 3174 3174 I QImsService: ImsCallSessionImpl : updateImsCallProfile :: VerstatInfo : canMarkUnwantedCall = false , verstatVerificationStatus = 0
12-22 06:47:22.246 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10c01000
12-22 06:47:22.247 5234 5234 I Dialer : CallCardPresenter.getLocationFragment - shouldn't show location
12-22 06:47:22.247 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10dc1000
12-22 06:47:22.247 3174 3174 I QImsService: ImsCallSessionImpl : MO Dialing call!
12-22 06:47:22.247 5234 5234 I Dialer : InCallFragment.setPrimary - PrimaryInfo, number: ***, name: Redacted-3-chars, location: null, label: null, photo: null, photoType: 0, isPhotoVisible: true, MultimediaData: null
12-22 06:47:22.248 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10c02000
12-22 06:47:22.248 3174 3174 I QImsService: ImsCallSessionCallbackHandler : posting to handler
12-22 06:47:22.248 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10803000
12-22 06:47:22.248 5234 5234 I Dialer : CallCardPresenter.getLocationFragment - shouldn't show location
12-22 06:47:22.249 3174 3174 I QImsService: ImsCallSessionImpl : updateLocalDc is true
12-22 06:47:22.249 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10002000
12-22 06:47:22.249 3174 7190 I QImsService: ImsCallSessionCallbackHandler : callSessionInitiating :: profile={ serviceType=1, callType=2, restrictCause=0, mediaProfile={ audioQuality=0, audioDirection=3, audioCodecAttribute=null, videoQuality=0, videoDirection=-1, rttMode=0, hasRttAudioSpeech=false }, emergencyServiceCategories=0, emergencyUrns=[], emergencyCallRouting=0, emergencyCallTesting=false, hasKnownUserIntentEmergency=false, mRestrictCause=0, mCallerNumberVerstat= 0, mAcceptedRtpHeaderExtensions= {} }
12-22 06:47:22.250 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=11c05000
12-22 06:47:22.250 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=11dc5000
12-22 06:47:22.251 923 2581 D audio_hw_hfp: hfp_set_parameters: enter
12-22 06:47:22.251 923 2581 D audio_hw_extn: audio_extn_fm_set_parameters: Enter
12-22 06:47:22.251 3197 3552 I ImsCall : callSessionInitiating :: session=[ImsCallSession objId:207185674 state:INITIATED callId:1] profile={ serviceType=1, callType=2, restrictCause=0, mediaProfile={ audioQuality=0, audioDirection=3, audioCodecAttribute=null, videoQuality=0, videoDirection=-1, rttMode=0, hasRttAudioSpeech=false }, emergencyServiceCategories=0, emergencyUrns=[], emergencyCallRouting=0, emergencyCallTesting=false, hasKnownUserIntentEmergency=false, mRestrictCause=0, mCallerNumberVerstat= 0, mAcceptedRtpHeaderExtensions= [] } ImsCall=[ImsCall objId:187833211 onHold:N mute:N mCallProfile:{ serviceType=1, callType=2, restrictCause=0, mediaProfile={ audioQuality=0, audioDirection=3, audioCodecAttribute=null, videoQuality=0, videoDirection=-1, rttMode=0, hasRttAudioSpeech=false }, emergencyServiceCategories=0, emergencyUrns=[], emergencyCallRouting=0, emergencyCallTesting=false, hasKnownUserIntentEmergency=false, mRestrictCause=0, mCallerNumberVerstat= 0, mAcceptedRtpHeaderExtensions= [] } networkType:0 updateRequest:NONE merging:N merge action pending:N merged:N multiParty:N confHost:N buried term:N isVideo: N wasVideo: N isWifi: N session:[ImsCallSession objId:207185674 state:INITIATED callId:1] transientSession:null]
12-22 06:47:22.253 3157 3784 I QcrilOemhookMsgTunnel: [0]processOemHookIndication length=47
12-22 06:47:22.254 3197 3197 D Telephony: GsmConnection: setIsNetworkIdentifiedEmergencyCall; callId=TC@5_1, isNetworkIdentifiedEmergencyCall=false
12-22 06:47:22.255 3157 3784 D QcRilAudio: setParameters with: vsid=297816064;call_state=1[slot1]
12-22 06:47:22.256 923 2581 D audio_hw_primary: adev_set_parameters: enter: call_state=1;vsid=297816064
12-22 06:47:22.256 3174 3234 I QImsService: ImsCallSessionImpl : getImsVideoCallProvider: Video call provider is null
12-22 06:47:22.256 923 2581 D voice_extn: update_call_states is_call_active:0 in_call:1, mode:2
12-22 06:47:22.257 923 2581 D voice_extn: update_calls: enter:
12-22 06:47:22.257 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10c01000
12-22 06:47:22.257 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10dc1000
12-22 06:47:22.258 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10c02000
12-22 06:47:22.258 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10803000
12-22 06:47:22.258 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10002000
12-22 06:47:22.259 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=11c05000
12-22 06:47:22.259 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=11dc5000
12-22 06:47:22.259 923 2581 D audio_hw_hfp: hfp_set_parameters: enter
12-22 06:47:22.260 923 2581 D audio_hw_extn: audio_extn_fm_set_parameters: Enter
12-22 06:47:22.260 5234 5234 I Dialer : DialpadFragment.onStop - enter
12-22 06:47:22.262 3157 3784 I QcrilOemhookMsgTunnel: [0]processOemHookIndication length=47
12-22 06:47:22.264 3174 3704 I QImsService: ImsRadioResponseHidl : Dial response received
12-22 06:47:22.264 3174 3704 I QImsService: ImsSenderRxr : [0043]< DIAL [SUB0]
12-22 06:47:22.265 3174 3174 I QImsService: ImsCallSessionImplHandler : Message received: what = 1
12-22 06:47:22.266 3157 3784 D QcRilAudio: setParameters with: vsid=297816064;call_state=2;call_type=LTE[slot1]
12-22 06:47:22.266 3197 3197 I Telephony: maybeConfigureDeviceToDeviceCommunication: not using D2D.
12-22 06:47:22.266 3174 3704 I QImsService: ImsRadioIndicationHidl : onCallStateChanged_1_7()
12-22 06:47:22.267 923 2581 D audio_hw_primary: adev_set_parameters: enter: call_state=2;call_type=LTE;vsid=297816064
12-22 06:47:22.267 3174 3704 I QImsService: ImsRadioIndicationHidl : onCallStateChanged_1_8()
12-22 06:47:22.267 3197 3197 V Telephony: GsmConnection: Update state from IDLE to DIALING for TC@5_1
12-22 06:47:22.267 923 2581 D voice_extn: update_call_states is_call_active:0 in_call:1, mode:2
12-22 06:47:22.268 3174 3704 I QImsService: Class : Num of SrvUpdates = 1
12-22 06:47:22.268 5234 5993 D OpenGLRenderer: endAllActiveAnimators on 0x7c8cc4e020 (RippleDrawable) with handle 0x7b9cc5a1b0
12-22 06:47:22.268 923 2581 D voice_extn: update_calls: enter:
12-22 06:47:22.269 3174 3704 I QImsService: Class : networkMode = 14 status = 2 restrictCause = 0 registered = 0
12-22 06:47:22.269 3197 3197 V Telephony: onStateChanged, state: DIALING
12-22 06:47:22.270 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10c01000
12-22 06:47:22.271 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10dc1000
12-22 06:47:22.271 3174 3704 I QImsService: Class : Partially Enabled Status due to Restrict Cause
12-22 06:47:22.271 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10c02000
12-22 06:47:22.272 3174 3704 I QImsService: Class : RTT: copySrvStatusList rtt mode = 2
12-22 06:47:22.272 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10803000
12-22 06:47:22.272 3174 3704 I QImsService: Class : Num of SrvUpdates = 0
12-22 06:47:22.272 3174 3704 I QImsService: Class : Call Details = 0 3 callSubState 0 videoPauseState2 mediaId17 Rtt mode 0 Local Ability isValid = true type = 0 status = 1 rttMode = 0 accTechStatus mode = 14 Status = 2 restrictCause = 0 registered = 0 Peer Ability Cause code 0 sipAlternateUri null, null
12-22 06:47:22.273 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10002000
12-22 06:47:22.273 3174 3704 I QImsService: Class : Call fail cause= 548
12-22 06:47:22.273 923 2581 D voice_extn: update_calls: cur_state=1 new_state=2 vsid=11c05000
12-22 06:47:22.273 3174 3704 I QImsService: Class : CallFailCauseResponse has no int error code!
12-22 06:47:22.274 3197 3197 D Telephony: buildConnectionCapabilities: isHoldable = false State = 3 capabilities = 2
12-22 06:47:22.274 923 2581 D voice_extn: update_calls: INACTIVE -> ACTIVE vsid:11c05000
12-22 06:47:22.274 3174 3704 I QImsService: ImsSenderRxr : [UNSL]< UNSOL_RESPONSE_CALL_STATE_CHANGED [id=1,DIALING,toa=129,norm,mo,0,voc,noevp,,cli=1,,3Call Details = 0 3 callSubState 0 videoPauseState2 mediaId17 Rtt mode 0 Local Ability isValid = true type = 0 status = 1 rttMode = 0 accTechStatus mode = 14 Status = 2 restrictCause = 0 registered = 0 Peer Ability Cause code 0 sipAlternateUri null, null,CallFailCause Code= 0,CallFailCause String= null, isEncrypted=false, historyInfo=, Conf. Support=0, {MultiIdentity Line Info : msisdn = , line type = 0 , line status = 0}, isTirOverwriteAllowed=false, isPreparatory=false, CRS data=CrsData crsType: 0 originalCallType: 10, Call progress Info = CallProgressInfo Type: -1 Reason code: 0 Reason Text: null, diversionInfo =, additional call info =MsimAdditionalCallInfo additional code : -1] [SUB0]
12-22 06:47:22.274 923 2581 D voice : voice_start_usecase: enter usecase:voicemmode1-call
12-22 06:47:22.275 923 2581 D audio_hw_primary: select_devices for use case (voicemmode1-call)
12-22 06:47:22.275 923 2581 D msm8974_platform: is_operator_tmus: tmus mccmnc 22210
12-22 06:47:22.276 3174 3704 I QImsService: ImsSenderRxr : InCall VoicePrivacy is disabled[SUB0]
12-22 06:47:22.276 923 2581 D msm8974_platform: is_operator_tmus: tmus mccmnc 22210
12-22 06:47:22.277 923 2581 I msm8974_platform: platform_check_and_set_codec_backend_cfg:becf: afe: bitwidth 16, samplerate 48000 channels 2, backend_idx 0 usecase = 41 device (voice-handset)
12-22 06:47:22.277 3174 3174 I QImsService: ImsServiceSubHandler : Message received: what = 1
12-22 06:47:22.277 923 2581 D msm8974_platform: platform_split_snd_device: snd_device(25) num devices(1) new_snd_devices(0)
12-22 06:47:22.278 3174 3174 I QImsService: ImsServiceSub : [0] >handleCalls
12-22 06:47:22.278 923 2581 I msm8974_platform: platform_check_and_set_codec_backend_cfg: new_snd_devices[0] is 25
12-22 06:47:22.278 3174 3174 I QImsService: ImsServiceSub : [0] handleCalls: dc = id=1,DIALING,toa=129,norm,mo,0,voc,noevp,,cli=1,,3Call Details = 0 3 callSubState 0 videoPauseState2 mediaId17 Rtt mode 0 Local Ability isValid = true type = 0 status = 1 rttMode = 0 accTechStatus mode = 14 Status = 2 restrictCause = 0 registered = 0 Peer Ability Cause code 0 sipAlternateUri null, null,CallFailCause Code= 0,CallFailCause String= null, isEncrypted=false, historyInfo=, Conf. Support=0, {MultiIdentity Line Info : msisdn = , line type = 0 , line status = 0}, isTirOverwriteAllowed=false, isPreparatory=false, CRS data=CrsData crsType: 0 originalCallType: 10, Call progress Info = CallProgressInfo Type: -1 Reason code: 0 Reason Text: null, diversionInfo =, additional call info =MsimAdditionalCallInfo additional code : -1
12-22 06:47:22.279 923 2581 I msm8974_platform: platform_check_codec_backend_cfg:becf: afe: bitwidth 16, samplerate 48000 channels 2, backend_idx 0 usecase = 41 device (voice-handset)
12-22 06:47:22.279 3174 3174 I QImsService: ImsCallSessionImpl : updateCall for id=1,DIALING,toa=129,norm,mo,0,voc,noevp,,cli=1,,3Call Details = 0 3 callSubState 0 videoPauseState2 mediaId17 Rtt mode 0 Local Ability isValid = true type = 0 status = 1 rttMode = 0 accTechStatus mode = 14 Status = 2 restrictCause = 0 registered = 0 Peer Ability Cause code 0 sipAlternateUri null, null,CallFailCause Code= 0,CallFailCause String= null, isEncrypted=false, historyInfo=, Conf. Support=0, {MultiIdentity Line Info : msisdn = , line type = 0 , line status = 0}, isTirOverwriteAllowed=false, isPreparatory=false, CRS data=CrsData crsType: 0 originalCallType: 10, Call progress Info = CallProgressInfo Type: -1 Reason code: 0 Reason Text: null, diversionInfo =, additional call info =MsimAdditionalCallInfo additional code : -1
12-22 06:47:22.279 923 2581 D msm8974_platform: is_operator_tmus: tmus mccmnc 22210
12-22 06:47:22.279 5234 5234 I Dialer : InCallFragment.onButtonGridCreated - InCallUiReady
12-22 06:47:22.280 3174 3174 I QImsService: ImsCallSessionImpl : updateImsCallProfile :: Packing encryption=false in mCallProfile's extras.
12-22 06:47:22.280 923 2581 W msm8974_platform: platform_check_codec_backend_cfg:becf: afe:Use default bw and sr for voice/voip calls
12-22 06:47:22.280 5234 5234 I Dialer : InCallFragment.setAudioState - audioState: [AudioState isMuted: false, route: EARPIECE, supportedRouteMask: EARPIECE, SPEAKER, activeBluetoothDevice: [null], supportedBluetoothDevices: []]
12-22 06:47:22.281 3174 3174 I QImsService: ImsCallSessionImpl : updateImsCallProfile :: VerstatInfo : canMarkUnwantedCall = false , verstatVerificationStatus = 0
12-22 06:47:22.281 923 2581 D msm8974_platform: is_operator_tmus: tmus mccmnc 22210
12-22 06:47:22.281 3174 3174 I QImsService: ImsCallSessionImpl : updateLocalDc is true
12-22 06:47:22.281 923 2581 D msm8974_platform: platform_check_codec_backend_cfg:becf: afe: playback on codec device not supporting native playback set default Sample Rate(48k)
12-22 06:47:22.282 3174 3174 I QImsService: ImsCallSessionCallbackHandler : posting to handler
12-22 06:47:22.282 923 2581 I msm8974_platform: platform_check_codec_backend_cfg:becf: afe: Codec selected backend: 0 updated bit width: 16 and sample rate: 48000
12-22 06:47:22.283 923 2581 D audio_hw_primary: check_usecases_codec_backend:becf: force routing 0
12-22 06:47:22.283 923 2581 D audio_hw_primary: check_usecases_codec_backend:becf: (78) check_usecases curr device: voice-handset, usecase device:voice-handset backends match 1
12-22 06:47:22.284 923 2581 E msm8974_platform: platform_check_backends_match: Invalid snd_device =
12-22 06:47:22.284 923 2581 D audio_hw_primary: check_usecases_codec_backend:becf: (78) check_usecases curr device: voice-handset, usecase device: backends match 0
12-22 06:47:22.284 923 2581 D audio_hw_primary: check_usecases_codec_backend:becf: check_usecases num.of Usecases to switch 0
12-22 06:47:22.284 923 2581 D hardware_info: hw_info_append_hw_type : device_name = voice-handset
12-22 06:47:22.285 3174 7190 I QImsService: ImsCallSessionCallbackHandler : callSessionUpdated :: profile={ serviceType=1, callType=2, restrictCause=0, mediaProfile={ audioQuality=0, audioDirection=3, audioCodecAttribute=null, videoQuality=0, videoDirection=-1, rttMode=0, hasRttAudioSpeech=false }, emergencyServiceCategories=0, emergencyUrns=[], emergencyCallRouting=0, emergencyCallTesting=false, hasKnownUserIntentEmergency=false, mRestrictCause=0, mCallerNumberVerstat= 0, mAcceptedRtpHeaderExtensions= {} }
12-22 06:47:22.285 923 2581 D msm8974_platform: platform_split_snd_device: snd_device(25) num devices(0) new_snd_devices(0)
12-22 06:47:22.285 3197 3197 D Telephony: buildConnectionCapabilities: isHoldable = false State = 3 capabilities = 2
12-22 06:47:22.289 3197 3552 I ImsCall : callSessionUpdated :: session=[ImsCallSession objId:207185674 state:INITIATED callId:1] profile={ serviceType=1, callType=2, restrictCause=0, mediaProfile={ audioQuality=0, audioDirection=3, audioCodecAttribute=null, videoQuality=0, videoDirection=-1, rttMode=0, hasRttAudioSpeech=false }, emergencyServiceCategories=0, emergencyUrns=[], emergencyCallRouting=0, emergencyCallTesting=false, hasKnownUserIntentEmergency=false, mRestrictCause=0, mCallerNumberVerstat= 0, mAcceptedRtpHeaderExtensions= [] } ImsCall=[ImsCall objId:187833211 onHold:N mute:N mCallProfile:{ serviceType=1, callType=2, restrictCause=0, mediaProfile={ audioQuality=0, audioDirection=3, audioCodecAttribute=null, videoQuality=0, videoDirection=-1, rttMode=0, hasRttAudioSpeech=false }, emergencyServiceCategories=0, emergencyUrns=[], emergencyCallRouting=0, emergencyCallTesting=false, hasKnownUserIntentEmergency=false, mRestrictCause=0, mCallerNumberVerstat= 0, mAcceptedRtpHeaderExtensions= [] } networkType:13 updateRequest:NONE merging:N merge action pending:N merged:N multiParty:N confHost:N buried term:N isVideo: N wasVideo: N isWifi: N session:[ImsCallSession objId:207185674 state:INITIATED callId:1] transientSession:null]
12-22 06:47:22.289 923 2581 I msm8974_platform: platform_check_and_set_capture_codec_backend_cfg:txbecf: afe: bitwidth 16, samplerate 48000, channel 1 format 1, backend_idx 8 usecase = 41 device (voice-dmic-ef)
12-22 06:47:22.290 923 2581 I msm8974_platform: platform_check_capture_codec_backend_cfg:txbecf: afe: Codec selected backend: 8 current bit width: 16 and sample rate: 48000, channels 1 format 1
12-22 06:47:22.290 923 2581 W msm8974_platform: platform_check_capture_codec_backend_cfg:txbecf: afe: Use default bw and sr for voice/voip calls and for unprocessed/camera source
12-22 06:47:22.292 923 2581 I msm8974_platform: platform_check_capture_codec_backend_cfg:txbecf: afe: current backend bit_width 16 sample_rate 48000 channels 1, format 0
12-22 06:47:22.293 923 2581 I msm8974_platform: platform_check_capture_codec_backend_cfg:txbecf: afe: Codec backend needs to be updated. new bit width: 16 new sample rate: 48000 new channel: 1 new format: 1
12-22 06:47:22.293 923 2581 I msm8974_platform: platform_set_codec_backend_cfg:becf: afe: bitwidth 16, samplerate 48000 channels 1 format 1, backend_idx 8 device (voice-dmic-ef)
12-22 06:47:22.294 923 2581 D audio_hw_primary: check_usecases_capture_codec_backend:becf: force routing 0
12-22 06:47:22.294 923 2581 D hardware_info: hw_info_append_hw_type : device_name = voice-dmic-ef
12-22 06:47:22.294 923 2581 D msm8974_platform: platform_split_snd_device: snd_device(183) num devices(0) new_snd_devices(0)
12-22 06:47:22.295 923 2581 D audio_hw_primary: enable_snd_device: snd_device(183: voice-dmic-ef)
12-22 06:47:22.296 923 2581 D msm8974_platform: platform_get_island_cfg_on_device:island cfg status on snd_device = (voice-dmic-ef 0)
12-22 06:47:22.296 923 2581 D soundtrigger: audio HAL using same device 183 as ST
12-22 06:47:22.297 3197 3197 V Telephony: updateAddress, caller display name changed
12-22 06:47:22.297 923 2581 I soundtrigger: audio_extn_sound_trigger_update_device_status: device 0xb7 of type 1 for Event 1, with Raise=1
12-22 06:47:22.298 923 2581 I sound_trigger_platform: platform_stdev_check_and_update_concurrency: Received DEVICE event, event type 1, usecase type 2
12-22 06:47:22.298 923 2581 D sound_trigger_platform: platform_stdev_get_capture_device: Device = 0x80000004
12-22 06:47:22.299 923 2581 D sound_trigger_platform: platform_stdev_get_capture_device: Available device = 0x80000004
12-22 06:47:22.299 923 2581 D sound_trigger_platform: platform_stdev_check_and_update_concurrency: dedicated path 0, reset backend 1, tx 1, rx 0, concurrency session not allowed
12-22 06:47:22.300 923 2581 D audio_route: Apply path: voice-dmic-ef
12-22 06:47:22.300 3174 3234 I QImsService: ImsCallSessionImpl : getImsVideoCallProvider: Video call provider is null
12-22 06:47:22.300 3197 3197 D TelephonyProvider: Using old permission behavior for telephony provider compat
12-22 06:47:22.305 1457 1873 I ActivityTaskManager: Displayed com.android.dialer/com.android.incallui.InCallActivity: +232ms
12-22 06:47:22.308 5234 5234 V LookupCache: Lookup cache directory does not exist. Not clearing it.
12-22 06:47:22.309 5234 5234 I Dialer : CallCardPresenter.getLocationFragment - shouldn't show location
12-22 06:47:22.309 5234 5234 I Dialer : InCallFragment.setPrimary - PrimaryInfo, number: ***, name: Redacted-3-chars, location: Redacted-0-chars, label: null, photo: null, photoType: 0, isPhotoVisible: true, MultimediaData: null
12-22 06:47:22.310 5234 5234 I Dialer : CallCardPresenter.getLocationFragment - shouldn't show location
12-22 06:47:22.310 5234 5234 I Dialer : CallCardPresenter.getLocationFragment - shouldn't show location
12-22 06:47:22.311 5234 5234 I Dialer : InCallFragment.setPrimary - PrimaryInfo, number: ***, name: Redacted-3-chars, location: Redacted-0-chars, label: null, photo: null, photoType: 0, isPhotoVisible: true, MultimediaData: null
12-22 06:47:22.311 5234 5234 I Dialer : CallCardPresenter.getLocationFragment - shouldn't show location
12-22 06:47:22.325 3197 3197 V Telephony: GsmConnection: refreshConferenceSupported : isConfSupp=true, isImsConfSupp=true, isVidConfSupp=true, isMergeOfWifiAllowed=true, isWifi=false, isVoWifiEnabled=false
12-22 06:47:22.325 3197 3197 D Telephony: refreshConferenceSupported = true.
12-22 06:47:22.327 923 2581 D ACDB-LOADER: ACDB -> send_voice_cal, acdb_rx = 7, acdb_tx = 41, feature_set = 0
12-22 06:47:22.327 923 2581 D ACDB-LOADER: ACDB -> send_voice_rx_topology
12-22 06:47:22.327 923 2581 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_VOCPROC_COMMON_TOPOLOGY_ID
12-22 06:47:22.327 923 2581 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_TARGET_SPECIFIC_DEVICE_INFO
12-22 06:47:22.328 923 2581 D ACDB-LOADER: ACDB -> ACDB_CHANNEL_MAPPING_CONFIG_V2: GET_DEVICE_PROPERTY
12-22 06:47:22.328 923 2581 D ACDB-LOADER: ACDB -> send_voice_tx_topology
12-22 06:47:22.328 923 2581 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_VOCPROC_COMMON_TOPOLOGY_ID
12-22 06:47:22.328 3197 3197 D Telephony: Adding IMS connection to conference controller: [TelephonyConnection objId:28359492 telecomCallID:TC@5_1 type:ims state:DIALING capabilities:[Capabilities: CAPABILITY_SUPPORT_HOLD CAPABILITY_MUTE CAPABILITY_CANNOT_DOWNGRADE_VIDEO_TO_AUDIO] properties:[Properties:] address:[ldYnOm-r6PZl1i9O7AumfsNKyp4] originalConnection:[ImsPhoneConnection objId: 81223064 telecomCallID: TC@5_1 address: [Oi3Gd9joWshWVBdE4ojVBIgv6zY] isAdhocConf: N ImsCall: [ImsCall objId:187833211 onHold:N mute:N mCallProfile:{ serviceType=1, callType=2, restrictCause=0, mediaProfile={ audioQuality=0, audioDirection=3, audioCodecAttribute=null, videoQuality=0, videoDirection=-1, rttMode=0, hasRttAudioSpeech=false }, emergencyServiceCategories=0, emergencyUrns=[], emergencyCallRouting=0, emergencyCallTesting=false, hasKnownUserIntentEmergency=false, mRestrictCause=0, mCallerNumberVerstat= 0, mAcceptedRtpHeaderExtensions= [] } networkType:13 updateRequest:NONE merging:N merge action pending:N merged:N multiParty:N confHost:N buried term:N isVideo: N wasVideo: N isWifi: N session:[ImsCallSession objId:207185674 state:INITIATED callId:1] transientSession:null]] partOfConf:N confSupported:Y isAdhocConf:N]
12-22 06:47:22.328 923 2581 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_TARGET_SPECIFIC_DEVICE_INFO
12-22 06:47:22.329 923 2581 D ACDB-LOADER: ACDB -> ACDB_CHANNEL_MAPPING_CONFIG_V2: GET_DEVICE_PROPERTY
12-22 06:47:22.329 923 2581 D ACDB-LOADER: ACDB -> AUDIO_SET_SIDETONE_IIR_CAL
12-22 06:47:22.330 923 2581 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_DATA
12-22 06:47:22.330 923 2581 D ACDB-LOADER: ACDB -> AUDIO_SET_SIDETONE_CAL
12-22 06:47:22.330 923 2581 D ACDB-LOADER: ACDB -> send_voice_columns, rxacdb_id 7, txacdb_id 41, table 8
12-22 06:47:22.330 923 2581 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_VOC_COLUMNS_INFO_V2
12-22 06:47:22.330 3197 3197 D Telephony: Adding IMS connection to conference controller: [TelephonyConnection objId:28359492 telecomCallID:TC@5_1 type:ims state:DIALING capabilities:[Capabilities: CAPABILITY_SUPPORT_HOLD CAPABILITY_MUTE CAPABILITY_CANNOT_DOWNGRADE_VIDEO_TO_AUDIO] properties:[Properties:] address:[ldYnOm-r6PZl1i9O7AumfsNKyp4] originalConnection:[ImsPhoneConnection objId: 81223064 telecomCallID: TC@5_1 address: [Oi3Gd9joWshWVBdE4ojVBIgv6zY] isAdhocConf: N ImsCall: [ImsCall objId:187833211 onHold:N mute:N mCallProfile:{ serviceType=1, callType=2, restrictCause=0, mediaProfile={ audioQuality=0, audioDirection=3, audioCodecAttribute=null, videoQuality=0, videoDirection=-1, rttMode=0, hasRttAudioSpeech=false }, emergencyServiceCategories=0, emergencyUrns=[], emergencyCallRouting=0, emergencyCallTesting=false, hasKnownUserIntentEmergency=false, mRestrictCause=0, mCallerNumberVerstat= 0, mAcceptedRtpHeaderExtensions= [] } networkType:13 updateRequest:NONE merging:N merge action pending:N merged:N multiParty:N confHost:N buried term:N isVideo: N wasVideo: N isWifi: N session:[ImsCallSession objId:207185674 state:INITIATED callId:1] transientSession:null]] partOfConf:N confSupported:Y isAdhocConf:N]
12-22 06:47:22.330 923 2581 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_VOC_PROC_STATIC_TABLE_SIZE
12-22 06:47:22.331 923 2581 D android.hardware.audio.service: ACDBFILE_MGR: Property for the pid 000133B7 not found
12-22 06:47:22.332 923 2581 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_VOC_PROC_STATIC_TABLE
12-22 06:47:22.332 923 2581 D android.hardware.audio.service: ACDBFILE_MGR: Property for the pid 000133B7 not found
12-22 06:47:22.332 923 2581 D ACDB-LOADER: ACDB -> AUDIO_SET_VOCPROC_CAL
12-22 06:47:22.333 3197 3197 W Telephony: ImsConferenceController: add - connection already tracked; connection=[TelephonyConnection objId:28359492 telecomCallID:TC@5_1 type:ims state:DIALING capabilities:[Capabilities: CAPABILITY_SUPPORT_HOLD CAPABILITY_MUTE CAPABILITY_CANNOT_DOWNGRADE_VIDEO_TO_AUDIO] properties:[Properties:] address:[ldYnOm-r6PZl1i9O7AumfsNKyp4] originalConnection:[ImsPhoneConnection objId: 81223064 telecomCallID: TC@5_1 address: [Oi3Gd9joWshWVBdE4ojVBIgv6zY] isAdhocConf: N ImsCall: [ImsCall objId:187833211 onHold:N mute:N mCallProfile:{ serviceType=1, callType=2, restrictCause=0, mediaProfile={ audioQuality=0, audioDirection=3, audioCodecAttribute=null, videoQuality=0, videoDirection=-1, rttMode=0, hasRttAudioSpeech=false }, emergencyServiceCategories=0, emergencyUrns=[], emergencyCallRouting=0, emergencyCallTesting=false, hasKnownUserIntentEmergency=false, mRestrictCause=0, mCallerNumberVerstat= 0, mAcceptedRtpHeaderExtensions= [] } networkType:13 updateRequest:NONE merging:N merge action pending:N merged:N multiParty:N confHost:N buried term:N isVideo: N wasVideo: N isWifi: N session:[ImsCallSession objId:207185674 state:INITIATED callId:1] transientSession:null]] partOfConf:N confSupported:Y isAdhocConf:N]
12-22 06:47:22.333 923 2581 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_VOC_PROC_DEVICE_CFG
12-22 06:47:22.334 923 2581 D ACDB-LOADER: ACDB -> AUDIO_SET_VOCPROC_DEV_CFG_CAL
12-22 06:47:22.334 923 2581 D ACDB-LOADER: ACDB -> send_voice_columns, rxacdb_id 7, txacdb_id 41, table 7
12-22 06:47:22.335 923 2581 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_VOC_COLUMNS_INFO_V2
12-22 06:47:22.335 923 2581 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_VOC_PROC_DYNAMIC_TABLE_SIZE
12-22 06:47:22.337 3197 3197 D Telephony: TelephonyConferenceController: remove - connection not tracked; connection=[TelephonyConnection objId:28359492 telecomCallID:TC@5_1 type:ims state:DIALING capabilities:[Capabilities: CAPABILITY_SUPPORT_HOLD CAPABILITY_MUTE CAPABILITY_CANNOT_DOWNGRADE_VIDEO_TO_AUDIO] properties:[Properties:] address:[ldYnOm-r6PZl1i9O7AumfsNKyp4] originalConnection:[ImsPhoneConnection objId: 81223064 telecomCallID: TC@5_1 address: [Oi3Gd9joWshWVBdE4ojVBIgv6zY] isAdhocConf: N ImsCall: [ImsCall objId:187833211 onHold:N mute:N mCallProfile:{ serviceType=1, callType=2, restrictCause=0, mediaProfile={ audioQuality=0, audioDirection=3, audioCodecAttribute=null, videoQuality=0, videoDirection=-1, rttMode=0, hasRttAudioSpeech=false }, emergencyServiceCategories=0, emergencyUrns=[], emergencyCallRouting=0, emergencyCallTesting=false, hasKnownUserIntentEmergency=false, mRestrictCause=0, mCallerNumberVerstat= 0, mAcceptedRtpHeaderExtensions= [] } networkType:13 updateRequest:NONE merging:N merge action pending:N merged:N multiParty:N confHost:N buried term:N isVideo: N wasVideo: N isWifi: N session:[ImsCallSession objId:207185674 state:INITIATED callId:1] transientSession:null]] partOfConf:N confSupported:Y isAdhocConf:N]
12-22 06:47:22.337 3197 3197 V Telephony: recalculateConference
12-22 06:47:22.339 923 2581 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_VOC_PROC_DYNAMIC_TABLE
12-22 06:47:22.339 3197 3197 V Telephony: ImsConferenceController: recalculateConferenceable : 1
12-22 06:47:22.340 3197 3197 V Telephony: conferenceableSet size: 0
12-22 06:47:22.342 3197 3197 D Telephony: TelephonyConferenceController: remove - connection not tracked; connection=[TelephonyConnection objId:28359492 telecomCallID:TC@5_1 type:ims state:DIALING capabilities:[Capabilities: CAPABILITY_SUPPORT_HOLD CAPABILITY_MUTE CAPABILITY_CANNOT_DOWNGRADE_VIDEO_TO_AUDIO] properties:[Properties:] address:[ldYnOm-r6PZl1i9O7AumfsNKyp4] originalConnection:[ImsPhoneConnection objId: 81223064 telecomCallID: TC@5_1 address: [Oi3Gd9joWshWVBdE4ojVBIgv6zY] isAdhocConf: N ImsCall: [ImsCall objId:187833211 onHold:N mute:N mCallProfile:{ serviceType=1, callType=2, restrictCause=0, mediaProfile={ audioQuality=0, audioDirection=3, audioCodecAttribute=null, videoQuality=0, videoDirection=-1, rttMode=0, hasRttAudioSpeech=false }, emergencyServiceCategories=0, emergencyUrns=[], emergencyCallRouting=0, emergencyCallTesting=false, hasKnownUserIntentEmergency=false, mRestrictCause=0, mCallerNumberVerstat= 0, mAcceptedRtpHeaderExtensions= [] } networkType:13 updateRequest:NONE merging:N merge action pending:N merged:N multiParty:N confHost:N buried term:N isVideo: N wasVideo: N isWifi: N session:[ImsCallSession objId:207185674 state:INITIATED callId:1] transientSession:null]] partOfConf:N confSupported:Y isAdhocConf:N]
12-22 06:47:22.343 3197 3197 D Telephony: topHoldableCount = 1
12-22 06:47:22.345 3197 3197 D Telephony: buildConnectionCapabilities: isHoldable = true State = 3 capabilities = 2
12-22 06:47:22.348 923 2581 D ACDB-LOADER: ACDB -> AUDIO_SET_VOCPROC_VOL_CAL
12-22 06:47:22.348 923 2581 D ACDB-LOADER: ACDB -> send_voice_columns, rxacdb_id 7, txacdb_id 41, table 9
12-22 06:47:22.348 923 2581 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_VOC_COLUMNS_INFO_V2
12-22 06:47:22.349 923 2581 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_VOC_STREAM_STATIC_TABLE_SIZE
12-22 06:47:22.349 923 2581 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_VOC_STREAM_STATIC_TABLE
12-22 06:47:22.349 923 2581 D ACDB-LOADER: ACDB -> AUDIO_SET_VOCPROC_STREAM_CAL
12-22 06:47:22.349 923 2581 D ACDB-LOADER: ACDB -> send_afe_topology
12-22 06:47:22.349 923 2581 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_TOPOLOGY_ID
12-22 06:47:22.350 923 2581 D ACDB-LOADER: ACDB -> GET_AFE_TOPOLOGY_ID for adcd_id 41, Topology Id 112fb
12-22 06:47:22.350 923 2581 D ACDB-LOADER: ACDB -> send_afe_cal
12-22 06:47:22.350 923 2581 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_INSTANCE_COMMON_TABLE_SIZE
12-22 06:47:22.350 923 2581 D android.hardware.audio.service: Failed to fetch the lookup information of the device 00000029
12-22 06:47:22.351 923 2581 D ACDB-LOADER: Error: ACDB_CMD_GET_AFE_INSTANCE_COMMON_TABLE_SIZE Returned = -19
12-22 06:47:22.351 923 2581 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_INSTANCE_COMMON_TABLE
12-22 06:47:22.351 923 2581 D android.hardware.audio.service: Failed to fetch the lookup information of the device 00000029
12-22 06:47:22.351 923 2581 D ACDB-LOADER: Error: ACDB AFE returned = -19
12-22 06:47:22.351 923 2581 D ACDB-LOADER: ACDB -> AUDIO_SET_AFE_CAL cal_type[17] acdb_id[41]
12-22 06:47:22.352 923 2581 D ACDB-LOADER: ACDB -> send_afe_topology
12-22 06:47:22.352 923 2581 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_TOPOLOGY_ID
12-22 06:47:22.352 923 2581 D ACDB-LOADER: ACDB -> GET_AFE_TOPOLOGY_ID for adcd_id 7, Topology Id 112fc
12-22 06:47:22.352 923 2581 D ACDB-LOADER: ACDB -> send_afe_cal
12-22 06:47:22.352 923 2581 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_INSTANCE_COMMON_TABLE_SIZE
12-22 06:47:22.353 923 2581 D android.hardware.audio.service: Failed to fetch the lookup information of the device 00000007
12-22 06:47:22.353 923 2581 D ACDB-LOADER: Error: ACDB_CMD_GET_AFE_INSTANCE_COMMON_TABLE_SIZE Returned = -19
12-22 06:47:22.353 923 2581 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_INSTANCE_COMMON_TABLE
12-22 06:47:22.353 923 2581 D android.hardware.audio.service: Failed to fetch the lookup information of the device 00000007
12-22 06:47:22.353 923 2581 D ACDB-LOADER: Error: ACDB AFE returned = -19
12-22 06:47:22.354 923 2581 D ACDB-LOADER: ACDB -> AUDIO_SET_AFE_CAL cal_type[16] acdb_id[7]
12-22 06:47:22.354 923 2581 D ACDB-LOADER: ACDB -> send_hw_delay : acdb_id = 41 path = 1
12-22 06:47:22.354 923 2581 D ACDB-LOADER: ACDB -> ACDB_AVSYNC_INFO: ACDB_CMD_GET_DEVICE_PROPERTY
12-22 06:47:22.354 923 2581 D ACDB-LOADER: ACDB -> send_hw_delay : acdb_id = 7 path = 0
12-22 06:47:22.354 923 2581 D ACDB-LOADER: ACDB -> ACDB_AVSYNC_INFO: ACDB_CMD_GET_DEVICE_PROPERTY
12-22 06:47:22.355 923 2581 D ACDB-LOADER: ACDB -> Sent VocProc Cal!
12-22 06:47:22.355 923 2581 E audio_hw_utils: audio_extn_utils_update_stream_app_type_cfg_for_usecase: app type cfg not supported for usecase type (2)
12-22 06:47:22.355 923 2581 D soundtrigger: audio HAL using same device 183 as ST
12-22 06:47:22.355 923 2581 D soundtrigger: audio_extn_sound_trigger_update_stream_status: uc_info->id 41 of type 2 for Event 3, with Raise=1
12-22 06:47:22.355 923 2581 D soundtrigger: audio_extn_sound_trigger_update_stream_status: send event 13: usecase id 41, type 2
12-22 06:47:22.356 923 2581 I sound_trigger_platform: platform_stdev_check_and_update_concurrency: Received CAPTURE_STREAM event, event type 13, usecase type 2
12-22 06:47:22.356 923 2581 D sound_trigger_platform: platform_stdev_get_capture_device: Device = 0x80000004
12-22 06:47:22.356 923 2581 D sound_trigger_platform: platform_stdev_get_capture_device: Available device = 0x80000004
12-22 06:47:22.356 923 2581 D sound_trigger_platform: platform_stdev_check_and_update_concurrency: dedicated path 0, reset backend 1, tx 1, rx 0, concurrency session not allowed
12-22 06:47:22.357 923 2581 I audio_hw_utils: audio_extn_utils_send_app_type_cfg: not a playback/capture path, no need to cfg app type
12-22 06:47:22.357 923 2581 D audio_hw_primary: enable_audio_route: apply mixer and update path: voicemmode1-call handset
12-22 06:47:22.357 923 2581 D audio_route: Apply path: voicemmode1-call handset
12-22 06:47:22.360 923 2581 D audio_hw_primary: select_devices: done
12-22 06:47:22.360 923 2581 D voice : voice_config.rate 8000
12-22 06:47:22.364 3197 3197 V Telephony: MSG_PRECISE_CALL_STATE_CHANGED
12-22 06:47:22.365 1457 2902 I Telecom : InCallController: Sending updateCall [Call id=TC@5, state=CONNECTING, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[], prop=[]]: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC(cap/cast)@E-E-ClA
12-22 06:47:22.361 0 0 D cma : cma_alloc(cma 00000000f1510374, count 1, align 0)
12-22 06:47:22.362 0 0 D cma : cma_alloc(): returned 0000000016f201ac
12-22 06:47:22.362 0 0 D cma : cma_alloc(cma 00000000f1510374, count 1, align 0)
12-22 06:47:22.363 0 0 D cma : cma_alloc(): returned 0000000066d5e7d1
12-22 06:47:22.363 0 0 I __afe_port_start: port id: 0xb037
12-22 06:47:22.363 0 0 I afe_find_cal_topo_id_by_port: port id: 0xb037, dev_acdb_id: 0
12-22 06:47:22.363 0 0 I afe_find_cal_topo_id_by_port: port id: 0xb037, dev_acdb_id: 0
12-22 06:47:22.363 0 0 I afe_find_cal_topo_id_by_port: top_id:112fb acdb_id:41 afe_port:0xb037
12-22 06:47:22.363 0 0 I afe_get_cal_topology_id: port_id = 0xb037 acdb_id = 41 topology_id = 0x112fb cal_type_index=8 ret=0
12-22 06:47:22.363 0 0 I afe_send_port_topology_id: AFE set topology id 0x112fb enable for port 0xb037 ret 0
12-22 06:47:22.363 0 0 I send_afe_cal_type: cal_index is 1
12-22 06:47:22.363 0 0 I send_afe_cal_type: dev_acdb_id[177] is 0
12-22 06:47:22.363 0 0 I send_afe_cal_type: Sending cal_index cal 1
12-22 06:47:22.363 0 0 E send_afe_cal_type: No cal sent for cal_index 1, port_id = 0xb037! ret -22
12-22 06:47:22.363 0 0 I send_afe_cal_type: cal_index is 2
12-22 06:47:22.363 0 0 I send_afe_cal_type: dev_acdb_id[177] is 0
12-22 06:47:22.363 0 0 E : send_afe_cal_type cal_block not found!!
12-22 06:47:22.363 0 0 I afe_send_hw_delay: port_id 0xb037 rate 48000 delay_usec 578 status 0
12-22 06:47:22.366 3197 3197 V Telephony: GsmConnection: Update state from DIALING to DIALING for TC@5_1
12-22 06:47:22.370 3197 3197 D Telephony: buildConnectionCapabilities: isHoldable = true State = 3 capabilities = 2
12-22 06:47:22.372 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.373 1457 2902 I Telecom : InCallController: Components updated: [ComponentInfo{com.android.dialer/com.android.incallui.InCallServiceImpl}, ComponentInfo{com.android.bluetooth/com.android.bluetooth.telephony.BluetoothInCallService}]: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC(cap/cast)@E-E-ClA
12-22 06:47:22.373 1457 2902 I Telecom : InCallController: Sending updateCall [Call id=TC@5, state=CONNECTING, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[ sup_hld mut !v2a], prop=[]]: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC(cap/cast)@E-E-ClA
12-22 06:47:22.375 1457 2902 I Telecom : InCallController: Components updated: [ComponentInfo{com.android.dialer/com.android.incallui.InCallServiceImpl}, ComponentInfo{com.android.bluetooth/com.android.bluetooth.telephony.BluetoothInCallService}]: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC(cap/cast)@E-E-ClA
12-22 06:47:22.376 1457 2902 I Telecom : Event: RecordEntry TC@5: CAPABILITY_CHANGE, Current: [[ sup_hld mut !v2a]], Removed [[]], Added [[ sup_hld mut !v2a]]: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC(cap/cast)@E-E-ClA
12-22 06:47:22.377 1457 3301 I Telecom : CallAudioModeStateMachine: Message received: FOREGROUND_VOIP_MODE_CHANGE.: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC->CAMSM.pM_4001(cap/cast)@E-E-ClA
12-22 06:47:22.378 1457 2902 I Telecom : InCallController: Sending updateCall [Call id=TC@5, state=CONNECTING, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[ sup_hld mut !v2a], prop=[]]: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC(cap/cast)@E-E-ClA
12-22 06:47:22.380 1457 2902 I Telecom : InCallController: Components updated: [ComponentInfo{com.android.dialer/com.android.incallui.InCallServiceImpl}, ComponentInfo{com.android.bluetooth/com.android.bluetooth.telephony.BluetoothInCallService}]: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC(cap/cast)@E-E-ClA
12-22 06:47:22.380 3197 3197 D Telephony: buildConnectionCapabilities: isHoldable = true State = 3 capabilities = 2
12-22 06:47:22.381 1457 2902 I Telecom : InCallController: Sending updateCall [Call id=TC@5, state=CONNECTING, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[ sup_hld mut !v2a], prop=[]]: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC(cap/cast)@E-E-ClA
12-22 06:47:22.383 1457 2902 I Telecom : InCallController: Components updated: [ComponentInfo{com.android.dialer/com.android.incallui.InCallServiceImpl}, ComponentInfo{com.android.bluetooth/com.android.bluetooth.telephony.BluetoothInCallService}]: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC(cap/cast)@E-E-ClA
12-22 06:47:22.384 1457 2902 I Telecom : InCallController: Sending updateCall [Call id=TC@5, state=CONNECTING, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[ sup_hld mut !v2a], prop=[]]: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC(cap/cast)@E-E-ClA
12-22 06:47:22.389 1457 2902 I Telecom : InCallController: Components updated: [ComponentInfo{com.android.dialer/com.android.incallui.InCallServiceImpl}, ComponentInfo{com.android.bluetooth/com.android.bluetooth.telephony.BluetoothInCallService}]: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC(cap/cast)@E-E-ClA
12-22 06:47:22.389 1457 2902 I Telecom : InCallController: Sending updateCall [Call id=TC@5, state=CONNECTING, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[ sup_hld mut !v2a], prop=[]]: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC(cap/cast)@E-E-ClA
12-22 06:47:22.391 3197 3197 D TelephonyProvider: Using old permission behavior for telephony provider compat
12-22 06:47:22.392 1457 2902 I Telecom : InCallController: Components updated: [ComponentInfo{com.android.dialer/com.android.incallui.InCallServiceImpl}, ComponentInfo{com.android.bluetooth/com.android.bluetooth.telephony.BluetoothInCallService}]: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC(cap/cast)@E-E-ClA
12-22 06:47:22.393 1457 2902 I Telecom : CallsManager: setCallState CONNECTING -> DIALING, call: [Call id=TC@5, state=CONNECTING, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[ sup_hld mut !v2a], prop=[]]: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC(cap/cast)@E-E-ClA
12-22 06:47:22.394 1457 2902 I Telecom : Event: RecordEntry TC@5: SET_DIALING, successful outgoing call: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC(cap/cast)@E-E-ClA
12-22 06:47:22.392 0 0 W HTB : quantum of class 10010 is big. Consider r2q change.
12-22 06:47:22.396 1457 2902 I Telecom : IncomingCallNotifier: updateIncomingCall: foundIncomingcall = null: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC(cap/cast)@E-E-ClA
12-22 06:47:22.397 1457 3301 I Telecom : CallAudioModeStateMachine: Message received: NEW_ACTIVE_OR_DIALING_CALL.: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC->CAMSM.pM_2001(cap/cast)@E-E-ClA
12-22 06:47:22.398 1457 2902 I Telecom : TelecomWakeLock: WakeLock already released with id: 26: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC(cap/cast)@E-E-ClA
12-22 06:47:22.398 1457 2902 I Telecom : InCallWakeLockController: Releasing full wake lock: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC(cap/cast)@E-E-ClA
12-22 06:47:22.399 1457 2902 I Telecom : InCallController: Sending updateCall [Call id=TC@5, state=DIALING, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[ sup_hld mut !v2a], prop=[]]: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC(cap/cast)@E-E-ClA
12-22 06:47:22.405 1457 2902 I Telecom : InCallController: Components updated: [ComponentInfo{com.android.dialer/com.android.incallui.InCallServiceImpl}, ComponentInfo{com.android.bluetooth/com.android.bluetooth.telephony.BluetoothInCallService}]: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC(cap/cast)@E-E-ClA
12-22 06:47:22.407 1457 2902 I Telecom : PhoneStateBroadcaster: Broadcasted state change: 2: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC(cap/cast)@E-E-ClA
12-22 06:47:22.407 1457 2902 I Telecom : InCallController: Sending updateCall [Call id=TC@5, state=DIALING, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[ sup_hld mut !v2a], prop=[]]: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC(cap/cast)@E-E-ClA
12-22 06:47:22.408 1457 3300 I Telecom : CallAudioRouteStateMachine: Message received: UPDATE_SYSTEM_AUDIO_ROUTE=1201, arg1=0: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC->CARSM.pM_UPDATE_SYSTEM_AUDIO_ROUTE(cap/cast)@E-E-ClA
12-22 06:47:22.408 1457 3300 I Telecom : ActiveEarpieceRoute: Processing message UPDATE_SYSTEM_AUDIO_ROUTE: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC->CARSM.pM_UPDATE_SYSTEM_AUDIO_ROUTE(cap/cast)@E-E-ClA
12-22 06:47:22.409 1457 1918 W BroadcastQueue: Permission Denial: receiving Intent { act=android.intent.action.PHONE_STATE flg=0x1000010 (has extras) } to ProcessRecord{e4da818 3079:com.android.systemui/u0a142} (pid=3079, uid=10142) requires android.permission.READ_CALL_LOG due to sender android (uid 1000)
12-22 06:47:22.410 1457 1918 W BroadcastQueue: Permission Denial: receiving Intent { act=android.intent.action.PHONE_STATE flg=0x1000010 (has extras) } to ProcessRecord{e4da818 3079:com.android.systemui/u0a142} (pid=3079, uid=10142) requires android.permission.READ_CALL_LOG due to sender android (uid 1000)
12-22 06:47:22.411 3197 3197 V Telephony: GsmConnection: refreshConferenceSupported : isConfSupp=true, isImsConfSupp=true, isVidConfSupp=true, isMergeOfWifiAllowed=true, isWifi=false, isVoWifiEnabled=false
12-22 06:47:22.411 3197 3197 D Telephony: refreshConferenceSupported = true.
12-22 06:47:22.412 1457 2902 I Telecom : InCallController: Components updated: [ComponentInfo{com.android.dialer/com.android.incallui.InCallServiceImpl}, ComponentInfo{com.android.bluetooth/com.android.bluetooth.telephony.BluetoothInCallService}]: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC(cap/cast)@E-E-ClA
12-22 06:47:22.412 1457 2902 I Telecom : CallsManager: setCallState DIALING -> DIALING, call: [Call id=TC@5, state=DIALING, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[ sup_hld mut !v2a], prop=[]]: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC(cap/cast)@E-E-ClA
12-22 06:47:22.414 1457 3300 I Telecom : CallAudioRouteStateMachine: setSystemAudioState: changing from [AudioState isMuted: false, route: EARPIECE, supportedRouteMask: EARPIECE, SPEAKER, activeBluetoothDevice: [null], supportedBluetoothDevices: []] to [AudioState isMuted: false, route: EARPIECE, supportedRouteMask: EARPIECE, SPEAKER, activeBluetoothDevice: [null], supportedBluetoothDevices: []]: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC->CARSM.pM_UPDATE_SYSTEM_AUDIO_ROUTE(cap/cast)@E-E-ClA
12-22 06:47:22.414 3197 3197 V Telephony: MSG_PRECISE_CALL_STATE_CHANGED
12-22 06:47:22.414 1457 3300 I Telecom : InCallController: Calling onAudioStateChanged, audioState: [AudioState isMuted: false, route: EARPIECE, supportedRouteMask: EARPIECE, SPEAKER, activeBluetoothDevice: [null], supportedBluetoothDevices: []] -> [AudioState isMuted: false, route: EARPIECE, supportedRouteMask: EARPIECE, SPEAKER, activeBluetoothDevice: [null], supportedBluetoothDevices: []]: (...->CS.crCo->H.CS.crCo->H.CS.crCo.pICR)->CSW.hCCC->CARSM.pM_UPDATE_SYSTEM_AUDIO_ROUTE(cap/cast)@E-E-ClA
12-22 06:47:22.415 3197 3197 V Telephony: GsmConnection: Update state from DIALING to DIALING for TC@5_1
12-22 06:47:22.416 1457 2902 I Telecom : InCallController: Sending updateCall [Call id=TC@5, state=DIALING, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[ sup_hld mut !v2a], prop=[]]: CSW.sSH(cap)@Clw
12-22 06:47:22.416 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.417 5234 5234 I Dialer : CallList.onUpdateCall - [DialerCall_4, CONNECTING, [Capabilities:], [Properties:], children:[], parent:null, conferenceable:[], videoState:Audio Only, mSessionModificationState:0, CameraDir:-1]
12-22 06:47:22.418 5234 5234 I Dialer : ReturnToCallController.hide - hide() called without calling show()
12-22 06:47:22.418 5234 5234 I Dialer : InCallPresenter.onCallListChange - Phone switching state: PENDING_OUTGOING -> PENDING_OUTGOING
12-22 06:47:22.419 1457 2902 I Telecom : InCallController: Components updated: [ComponentInfo{com.android.dialer/com.android.incallui.InCallServiceImpl}, ComponentInfo{com.android.bluetooth/com.android.bluetooth.telephony.BluetoothInCallService}]: CSW.sSH(cap)@Clw
12-22 06:47:22.419 1457 2902 I Telecom : InCallController: Sending updateCall [Call id=TC@5, state=DIALING, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[ sup_hld mut !v2a], prop=[]]: CSW.rE(cap)@Cl0
12-22 06:47:22.421 3197 3197 D Telephony: buildConnectionCapabilities: isHoldable = true State = 3 capabilities = 2
12-22 06:47:22.423 1457 2902 I Telecom : InCallController: Components updated: [ComponentInfo{com.android.dialer/com.android.incallui.InCallServiceImpl}, ComponentInfo{com.android.bluetooth/com.android.bluetooth.telephony.BluetoothInCallService}]: CSW.rE(cap)@Cl0
12-22 06:47:22.425 1457 2902 I Telecom : InCallController: Sending updateCall [Call id=TC@5, state=DIALING, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[ sup_hld mut !v2a], prop=[]]: CSW.sSH(cap)@Cl8
12-22 06:47:22.426 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 13, connectionLabel:
12-22 06:47:22.427 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.428 5234 5234 I Dialer : VideoPauseController.onStateChange - hasPrimaryCallChanged: false, videoCanPause: false, isInBackground: false
12-22 06:47:22.428 1457 2902 I Telecom : InCallController: Components updated: [ComponentInfo{com.android.dialer/com.android.incallui.InCallServiceImpl}, ComponentInfo{com.android.bluetooth/com.android.bluetooth.telephony.BluetoothInCallService}]: CSW.sSH(cap)@Cl8
12-22 06:47:22.429 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 13, connectionLabel:
12-22 06:47:22.430 3197 3197 D Telephony: buildConnectionCapabilities: isHoldable = true State = 3 capabilities = 2
12-22 06:47:22.430 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.432 923 2581 D voice : voice_set_sidetone: enable, out_snd_device: 25
12-22 06:47:22.432 923 2581 D audio_route: Apply path: sidetone-handset
12-22 06:47:22.434 0 0 E qdsp_cvp_callback: cmd = 0x112c2 returned error = 0x9
12-22 06:47:22.434 0 0 E voice_send_vol_step_cmd: DSP returned error[ADSP_EALREADY]
12-22 06:47:22.435 923 2581 D voice : voice_start_usecase: exit: status(0)
12-22 06:47:22.435 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=11dc5000
12-22 06:47:22.435 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.435 923 2581 D voice_extn: voice_extn_set_parameters: call type is LTE
12-22 06:47:22.436 923 2581 D audio_hw_hfp: hfp_set_parameters: enter
12-22 06:47:22.436 923 2581 D audio_hw_extn: audio_extn_fm_set_parameters: Enter
12-22 06:47:22.439 3157 3784 I QcrilOemhookMsgTunnel: [0]processOemHookIndication length=61
12-22 06:47:22.440 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.440 3197 3197 D TelephonyProvider: Using old permission behavior for telephony provider compat
12-22 06:47:22.443 5234 5234 I Dialer : CallList.onUpdateCall - [DialerCall_4, DIALING, [Capabilities: CAPABILITY_SUPPORT_HOLD CAPABILITY_MUTE CAPABILITY_CANNOT_DOWNGRADE_VIDEO_TO_AUDIO], [Properties:], children:[], parent:null, conferenceable:[], videoState:Audio Only, mSessionModificationState:0, CameraDir:-1]
12-22 06:47:22.444 5234 5234 I Dialer : ReturnToCallController.hide - hide() called without calling show()
12-22 06:47:22.445 5234 5234 I Dialer : InCallPresenter.onCallListChange - Phone switching state: PENDING_OUTGOING -> OUTGOING
12-22 06:47:22.452 5234 5234 I Dialer : StatusBarNotifier.buildAndSendNotification - notificationType=1
12-22 06:47:22.453 5234 5234 I Dialer : StatusBarNotifier.buildAndSendNotification - displaying notification for 1
12-22 06:47:22.456 5234 5234 I Dialer : DialerCall.isVoipCallNotSupportedBySpeakeasy - callid was empty
12-22 06:47:22.462 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 6, connectionLabel:
12-22 06:47:22.463 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.463 5234 5234 I Dialer : VideoPauseController.onStateChange - hasPrimaryCallChanged: false, videoCanPause: false, isInBackground: false
12-22 06:47:22.465 5234 5234 I Dialer : DialerCall.isVoipCallNotSupportedBySpeakeasy - callid was empty
12-22 06:47:22.466 3197 3197 V Telephony: GsmConnection: refreshConferenceSupported : isConfSupp=true, isImsConfSupp=true, isVidConfSupp=true, isMergeOfWifiAllowed=true, isWifi=false, isVoWifiEnabled=false
12-22 06:47:22.466 3197 3197 D Telephony: refreshConferenceSupported = true.
12-22 06:47:22.468 1457 2859 I Telecom : InCallController: Sending updateCall [Call id=TC@5, state=DIALING, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[ sup_hld mut !v2a], prop=[]]: CSW.rE(cap)@Cmo
12-22 06:47:22.469 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 6, connectionLabel:
12-22 06:47:22.472 3197 3197 D Telephony: buildConnectionCapabilities: isHoldable = true State = 3 capabilities = 2
12-22 06:47:22.472 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.473 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.474 1457 2859 I Telecom : InCallController: Components updated: [ComponentInfo{com.android.dialer/com.android.incallui.InCallServiceImpl}, ComponentInfo{com.android.bluetooth/com.android.bluetooth.telephony.BluetoothInCallService}]: CSW.rE(cap)@Cmo
12-22 06:47:22.476 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.471 0 0 W HTB : quantum of class 10010 is big. Consider r2q change.
12-22 06:47:22.477 5234 5234 I Dialer : CallList.onUpdateCall - [DialerCall_4, DIALING, [Capabilities: CAPABILITY_SUPPORT_HOLD CAPABILITY_MUTE CAPABILITY_CANNOT_DOWNGRADE_VIDEO_TO_AUDIO], [Properties:], children:[], parent:null, conferenceable:[], videoState:Audio Only, mSessionModificationState:0, CameraDir:-1]
12-22 06:47:22.478 5234 5234 I Dialer : ReturnToCallController.hide - hide() called without calling show()
12-22 06:47:22.479 5234 5234 I Dialer : InCallPresenter.onCallListChange - Phone switching state: OUTGOING -> OUTGOING
12-22 06:47:22.482 1457 5763 I Telecom : InCallController: Sending updateCall [Call id=TC@5, state=DIALING, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[ sup_hld mut], prop=[]]: CSW.sCC(cap)@Cm0
12-22 06:47:22.483 3197 3197 D Telephony: Extras update not required
12-22 06:47:22.486 1457 5763 I Telecom : InCallController: Components updated: [ComponentInfo{com.android.dialer/com.android.incallui.InCallServiceImpl}, ComponentInfo{com.android.bluetooth/com.android.bluetooth.telephony.BluetoothInCallService}]: CSW.sCC(cap)@Cm0
12-22 06:47:22.486 3197 3197 I TelecomFramework: TelephonyConnectionService: notifyCreateConnectionComplete TC@5_1: (...->CSW.hCCC)->CS.crCoC->H.CS.crCoC(cap/cast)@E-E-E-ClA
12-22 06:47:22.486 1457 5763 I Telecom : Event: RecordEntry TC@5: CAPABILITY_CHANGE, Current: [[ sup_hld mut]], Removed [[ !v2a]], Added [[]]: CSW.sCC(cap)@Cm0
12-22 06:47:22.487 5234 5234 I Dialer : DialerCall.isVoipCallNotSupportedBySpeakeasy - callid was empty
12-22 06:47:22.492 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 6, connectionLabel:
12-22 06:47:22.493 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.493 5234 5234 I Dialer : VideoPauseController.onStateChange - hasPrimaryCallChanged: false, videoCanPause: false, isInBackground: false
12-22 06:47:22.494 1457 5763 I Telecom : InCallController: Sending updateCall [Call id=TC@5, state=DIALING, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[ sup_hld mut], prop=[]]: CSW.pE(cap)@CnI
12-22 06:47:22.497 3197 3197 I TelecomFramework: TelephonyConnectionService: onAudioStateChanged TC@5_1 [AudioState isMuted: false, route: EARPIECE, supportedRouteMask: EARPIECE, SPEAKER, activeBluetoothDevice: [null], supportedBluetoothDevices: []]: (...->CSW.hCCC->CARSM.pM_UPDATE_SYSTEM_AUDIO_ROUTE)->CS.cASC->H.CS.cASC(cap/cast/cast)@E-E-E-ClA
12-22 06:47:22.498 1457 5763 I Telecom : InCallController: Components updated: [ComponentInfo{com.android.dialer/com.android.incallui.InCallServiceImpl}, ComponentInfo{com.android.bluetooth/com.android.bluetooth.telephony.BluetoothInCallService}]: CSW.pE(cap)@CnI
12-22 06:47:22.499 1457 5763 I Telecom : InCallController: Sending updateCall [Call id=TC@5, state=DIALING, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[ sup_hld mut], prop=[]]: CSW.pE(cap)@CnM
12-22 06:47:22.500 5234 5234 I Dialer : DialerCall.isVoipCallNotSupportedBySpeakeasy - callid was empty
12-22 06:47:22.503 1457 5763 I Telecom : InCallController: Components updated: [ComponentInfo{com.android.dialer/com.android.incallui.InCallServiceImpl}, ComponentInfo{com.android.bluetooth/com.android.bluetooth.telephony.BluetoothInCallService}]: CSW.pE(cap)@CnM
12-22 06:47:22.506 1457 5763 I Telecom : InCallController: Sending updateCall [Call id=TC@5, state=DIALING, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[ sup_hld mut], prop=[]]: CSW.pE(cap)@Cng
12-22 06:47:22.507 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 6, connectionLabel:
12-22 06:47:22.508 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.508 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.509 1457 5763 I Telecom : InCallController: Components updated: [ComponentInfo{com.android.dialer/com.android.incallui.InCallServiceImpl}, ComponentInfo{com.android.bluetooth/com.android.bluetooth.telephony.BluetoothInCallService}]: CSW.pE(cap)@Cng
12-22 06:47:22.510 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.510 3197 3552 D TelephonyProvider: Using old permission behavior for telephony provider compat
12-22 06:47:22.510 1457 5763 I Telecom : InCallController: Sending updateCall [Call id=TC@5, state=DIALING, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[ sup_hld mut], prop=[]]: CSW.pE(cap)@Cno
12-22 06:47:22.510 5234 5234 I Dialer : CallList.onUpdateCall - [DialerCall_4, DIALING, [Capabilities: CAPABILITY_SUPPORT_HOLD CAPABILITY_MUTE CAPABILITY_CANNOT_DOWNGRADE_VIDEO_TO_AUDIO], [Properties:], children:[], parent:null, conferenceable:[], videoState:Audio Only, mSessionModificationState:0, CameraDir:-1]
12-22 06:47:22.511 5234 5234 I Dialer : ReturnToCallController.hide - hide() called without calling show()
12-22 06:47:22.512 5234 5234 I Dialer : InCallPresenter.onCallListChange - Phone switching state: OUTGOING -> OUTGOING
12-22 06:47:22.512 1457 5763 I Telecom : InCallController: Components updated: [ComponentInfo{com.android.dialer/com.android.incallui.InCallServiceImpl}, ComponentInfo{com.android.bluetooth/com.android.bluetooth.telephony.BluetoothInCallService}]: CSW.pE(cap)@Cno
12-22 06:47:22.513 3197 3552 W SQLiteLog: (28) double-quoted string literal: "8939109610006623927"
12-22 06:47:22.517 5234 5234 I Dialer : DialerCall.isVoipCallNotSupportedBySpeakeasy - callid was empty
12-22 06:47:22.517 3197 3552 W SQLiteLog: (28) double-quoted string literal: "8939109610006623927"
12-22 06:47:22.521 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 6, connectionLabel:
12-22 06:47:22.522 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.522 3197 3552 W SQLiteLog: (28) double-quoted string literal: "8939109610006623927"
12-22 06:47:22.523 5234 5234 I Dialer : VideoPauseController.onStateChange - hasPrimaryCallChanged: false, videoCanPause: false, isInBackground: false
12-22 06:47:22.524 5234 5234 I Dialer : DialerCall.isVoipCallNotSupportedBySpeakeasy - callid was empty
12-22 06:47:22.527 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 6, connectionLabel:
12-22 06:47:22.528 3197 3548 D TelephonyProvider: Using old permission behavior for telephony provider compat
12-22 06:47:22.528 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.529 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.530 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.530 5234 5234 I Dialer : CallList.onUpdateCall - [DialerCall_4, DIALING, [Capabilities: CAPABILITY_SUPPORT_HOLD CAPABILITY_MUTE CAPABILITY_CANNOT_DOWNGRADE_VIDEO_TO_AUDIO], [Properties:], children:[], parent:null, conferenceable:[], videoState:Audio Only, mSessionModificationState:0, CameraDir:-1]
12-22 06:47:22.530 3197 3548 W SQLiteLog: (28) double-quoted string literal: "8939109610006623927"
12-22 06:47:22.531 5234 5234 I Dialer : ReturnToCallController.hide - hide() called without calling show()
12-22 06:47:22.531 5234 5234 I Dialer : InCallPresenter.onCallListChange - Phone switching state: OUTGOING -> OUTGOING
12-22 06:47:22.534 3197 3548 W SQLiteLog: (28) double-quoted string literal: "8939109610006623927"
12-22 06:47:22.535 5234 5234 I Dialer : DialerCall.isVoipCallNotSupportedBySpeakeasy - callid was empty
12-22 06:47:22.539 3197 3548 W SQLiteLog: (28) double-quoted string literal: "8939109610006623927"
12-22 06:47:22.539 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 6, connectionLabel:
12-22 06:47:22.540 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.541 5234 5234 I Dialer : VideoPauseController.onStateChange - hasPrimaryCallChanged: false, videoCanPause: false, isInBackground: false
12-22 06:47:22.542 5234 5234 I Dialer : DialerCall.isVoipCallNotSupportedBySpeakeasy - callid was empty
12-22 06:47:22.544 3197 3552 D TelephonyProvider: Using old permission behavior for telephony provider compat
12-22 06:47:22.545 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 6, connectionLabel:
12-22 06:47:22.546 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.547 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.547 3197 3552 W SQLiteLog: (28) double-quoted string literal: "8939109610006623927"
12-22 06:47:22.548 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.548 5234 5234 I Dialer : CallList.onUpdateCall - [DialerCall_4, DIALING, [Capabilities: CAPABILITY_SUPPORT_HOLD CAPABILITY_MUTE CAPABILITY_CANNOT_DOWNGRADE_VIDEO_TO_AUDIO], [Properties:], children:[], parent:null, conferenceable:[], videoState:Audio Only, mSessionModificationState:0, CameraDir:-1]
12-22 06:47:22.549 5234 5234 I Dialer : ReturnToCallController.hide - hide() called without calling show()
12-22 06:47:22.549 5234 5234 I Dialer : InCallPresenter.onCallListChange - Phone switching state: OUTGOING -> OUTGOING
12-22 06:47:22.550 3197 3552 W SQLiteLog: (28) double-quoted string literal: "8939109610006623927"
12-22 06:47:22.554 5234 5234 I Dialer : DialerCall.isVoipCallNotSupportedBySpeakeasy - callid was empty
12-22 06:47:22.555 3197 3552 W SQLiteLog: (28) double-quoted string literal: "8939109610006623927"
12-22 06:47:22.557 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 6, connectionLabel:
12-22 06:47:22.559 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.559 5234 5234 I Dialer : VideoPauseController.onStateChange - hasPrimaryCallChanged: false, videoCanPause: false, isInBackground: false
12-22 06:47:22.560 5234 5234 I Dialer : DialerCall.isVoipCallNotSupportedBySpeakeasy - callid was empty
12-22 06:47:22.564 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 6, connectionLabel:
12-22 06:47:22.565 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.565 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.566 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.567 5234 5234 I Dialer : CallList.onUpdateCall - [DialerCall_4, DIALING, [Capabilities: CAPABILITY_SUPPORT_HOLD CAPABILITY_MUTE CAPABILITY_CANNOT_DOWNGRADE_VIDEO_TO_AUDIO], [Properties:], children:[], parent:null, conferenceable:[], videoState:Audio Only, mSessionModificationState:0, CameraDir:-1]
12-22 06:47:22.567 5234 5234 I Dialer : ReturnToCallController.hide - hide() called without calling show()
12-22 06:47:22.567 5234 5234 I Dialer : InCallPresenter.onCallListChange - Phone switching state: OUTGOING -> OUTGOING
12-22 06:47:22.573 5234 5234 I Dialer : DialerCall.isVoipCallNotSupportedBySpeakeasy - callid was empty
12-22 06:47:22.576 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 6, connectionLabel:
12-22 06:47:22.577 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.578 5234 5234 I Dialer : VideoPauseController.onStateChange - hasPrimaryCallChanged: false, videoCanPause: false, isInBackground: false
12-22 06:47:22.578 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.580 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.580 5234 5234 I Dialer : CallList.onUpdateCall - [DialerCall_4, DIALING, [Capabilities: CAPABILITY_SUPPORT_HOLD CAPABILITY_MUTE CAPABILITY_CANNOT_DOWNGRADE_VIDEO_TO_AUDIO], [Properties:], children:[], parent:null, conferenceable:[], videoState:Audio Only, mSessionModificationState:0, CameraDir:-1]
12-22 06:47:22.581 5234 5234 I Dialer : ReturnToCallController.hide - hide() called without calling show()
12-22 06:47:22.581 5234 5234 I Dialer : InCallPresenter.onCallListChange - Phone switching state: OUTGOING -> OUTGOING
12-22 06:47:22.587 5234 5234 I Dialer : DialerCall.isVoipCallNotSupportedBySpeakeasy - callid was empty
12-22 06:47:22.592 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 6, connectionLabel:
12-22 06:47:22.593 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.593 5234 5234 I Dialer : VideoPauseController.onStateChange - hasPrimaryCallChanged: false, videoCanPause: false, isInBackground: false
12-22 06:47:22.594 1457 2902 W InputManager-JNI: Input channel object '53e4527 Splash Screen com.android.dialer (client)' was disposed without first being removed with the input manager!
12-22 06:47:22.595 5234 5234 I Dialer : DialerCall.isVoipCallNotSupportedBySpeakeasy - callid was empty
12-22 06:47:22.599 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 6, connectionLabel:
12-22 06:47:22.600 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.608 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.609 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.610 5234 5234 I Dialer : CallList.onUpdateCall - [DialerCall_4, DIALING, [Capabilities: CAPABILITY_SUPPORT_HOLD CAPABILITY_MUTE CAPABILITY_CANNOT_DOWNGRADE_VIDEO_TO_AUDIO], [Properties:], children:[], parent:null, conferenceable:[], videoState:Audio Only, mSessionModificationState:0, CameraDir:-1]
12-22 06:47:22.611 5234 5234 I Dialer : ReturnToCallController.hide - hide() called without calling show()
12-22 06:47:22.611 5234 5234 I Dialer : InCallPresenter.onCallListChange - Phone switching state: OUTGOING -> OUTGOING
12-22 06:47:22.615 5234 5234 I Dialer : DialerCall.isVoipCallNotSupportedBySpeakeasy - callid was empty
12-22 06:47:22.619 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 6, connectionLabel:
12-22 06:47:22.620 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.620 5234 5234 I Dialer : VideoPauseController.onStateChange - hasPrimaryCallChanged: false, videoCanPause: false, isInBackground: false
12-22 06:47:22.622 5234 5234 I Dialer : DialerCall.isVoipCallNotSupportedBySpeakeasy - callid was empty
12-22 06:47:22.625 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 6, connectionLabel:
12-22 06:47:22.626 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.626 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.627 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.628 5234 5234 I Dialer : CallList.onUpdateCall - [DialerCall_4, DIALING, [Capabilities: CAPABILITY_SUPPORT_HOLD CAPABILITY_MUTE CAPABILITY_CANNOT_DOWNGRADE_VIDEO_TO_AUDIO], [Properties:], children:[], parent:null, conferenceable:[], videoState:Audio Only, mSessionModificationState:0, CameraDir:-1]
12-22 06:47:22.628 5234 5234 I Dialer : ReturnToCallController.hide - hide() called without calling show()
12-22 06:47:22.629 5234 5234 I Dialer : InCallPresenter.onCallListChange - Phone switching state: OUTGOING -> OUTGOING
12-22 06:47:22.633 5234 5234 I Dialer : DialerCall.isVoipCallNotSupportedBySpeakeasy - callid was empty
12-22 06:47:22.637 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 6, connectionLabel:
12-22 06:47:22.638 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.638 5234 5234 I Dialer : VideoPauseController.onStateChange - hasPrimaryCallChanged: false, videoCanPause: false, isInBackground: false
12-22 06:47:22.640 5234 5234 I Dialer : DialerCall.isVoipCallNotSupportedBySpeakeasy - callid was empty
12-22 06:47:22.643 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 6, connectionLabel:
12-22 06:47:22.644 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.645 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.646 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.647 5234 5234 I Dialer : CallList.onUpdateCall - [DialerCall_4, DIALING, [Capabilities: CAPABILITY_SUPPORT_HOLD CAPABILITY_MUTE CAPABILITY_CANNOT_DOWNGRADE_VIDEO_TO_AUDIO], [Properties:], children:[], parent:null, conferenceable:[], videoState:Audio Only, mSessionModificationState:0, CameraDir:-1]
12-22 06:47:22.648 5234 5234 I Dialer : ReturnToCallController.hide - hide() called without calling show()
12-22 06:47:22.648 5234 5234 I Dialer : InCallPresenter.onCallListChange - Phone switching state: OUTGOING -> OUTGOING
12-22 06:47:22.653 5234 5234 I Dialer : DialerCall.isVoipCallNotSupportedBySpeakeasy - callid was empty
12-22 06:47:22.657 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 6, connectionLabel:
12-22 06:47:22.658 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.659 5234 5234 I Dialer : VideoPauseController.onStateChange - hasPrimaryCallChanged: false, videoCanPause: false, isInBackground: false
12-22 06:47:22.660 5234 5234 I Dialer : DialerCall.isVoipCallNotSupportedBySpeakeasy - callid was empty
12-22 06:47:22.662 1457 1457 W NotificationHistory: Attempted to add notif for locked/gone/disabled user 0
12-22 06:47:22.665 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 6, connectionLabel:
12-22 06:47:22.666 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.667 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.668 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.668 5234 5234 I Dialer : CallList.onUpdateCall - [DialerCall_4, DIALING, [Capabilities: CAPABILITY_SUPPORT_HOLD CAPABILITY_MUTE CAPABILITY_CANNOT_DOWNGRADE_VIDEO_TO_AUDIO], [Properties:], children:[], parent:null, conferenceable:[], videoState:Audio Only, mSessionModificationState:0, CameraDir:-1]
12-22 06:47:22.669 4040 4040 D NotificationRepository: updateNotification() called with: list = [6]
12-22 06:47:22.669 5234 5234 I Dialer : ReturnToCallController.hide - hide() called without calling show()
12-22 06:47:22.669 5234 5234 I Dialer : InCallPresenter.onCallListChange - Phone switching state: OUTGOING -> OUTGOING
12-22 06:47:22.674 5234 5234 I Dialer : DialerCall.isVoipCallNotSupportedBySpeakeasy - callid was empty
12-22 06:47:22.678 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 6, connectionLabel:
12-22 06:47:22.679 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.680 5234 5234 I Dialer : VideoPauseController.onStateChange - hasPrimaryCallChanged: false, videoCanPause: false, isInBackground: false
12-22 06:47:22.682 5234 5234 I Dialer : DialerCall.isVoipCallNotSupportedBySpeakeasy - callid was empty
12-22 06:47:22.677 0 0 W HTB : quantum of class 10060 is small. Consider r2q change.
12-22 06:47:22.686 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 6, connectionLabel:
12-22 06:47:22.687 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.688 5234 5234 I Dialer : NewSearchFragment.onCreateLoader - loading cursor: 0
12-22 06:47:22.688 5234 5234 I Dialer : NewSearchFragment.onCreateLoader - loading cursor: 3
12-22 06:47:22.689 3079 3127 D PeopleSpaceWidgetMgr: Sbn doesn't contain valid PeopleTileKey: null/0/com.android.dialer
12-22 06:47:22.691 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.692 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.693 5234 5234 I Dialer : CallList.onUpdateCall - [DialerCall_4, DIALING, [Capabilities: CAPABILITY_SUPPORT_HOLD CAPABILITY_MUTE], [Properties:], children:[], parent:null, conferenceable:[], videoState:Audio Only, mSessionModificationState:0, CameraDir:-1]
12-22 06:47:22.693 5234 5234 I Dialer : ReturnToCallController.hide - hide() called without calling show()
12-22 06:47:22.693 5234 5234 I Dialer : InCallPresenter.onCallListChange - Phone switching state: OUTGOING -> OUTGOING
12-22 06:47:22.698 5234 5234 I Dialer : DialerCall.isVoipCallNotSupportedBySpeakeasy - callid was empty
12-22 06:47:22.701 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 6, connectionLabel:
12-22 06:47:22.703 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.703 5234 5234 I Dialer : VideoPauseController.onStateChange - hasPrimaryCallChanged: false, videoCanPause: false, isInBackground: false
12-22 06:47:22.705 5234 5234 I Dialer : DialerCall.isVoipCallNotSupportedBySpeakeasy - callid was empty
12-22 06:47:22.709 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 6, connectionLabel:
12-22 06:47:22.710 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.710 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.711 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.712 5234 5234 I Dialer : CallList.onUpdateCall - [DialerCall_4, DIALING, [Capabilities: CAPABILITY_SUPPORT_HOLD CAPABILITY_MUTE], [Properties:], children:[], parent:null, conferenceable:[], videoState:Audio Only, mSessionModificationState:0, CameraDir:-1]
12-22 06:47:22.712 5234 5234 I Dialer : ReturnToCallController.hide - hide() called without calling show()
12-22 06:47:22.712 5234 5234 I Dialer : InCallPresenter.onCallListChange - Phone switching state: OUTGOING -> OUTGOING
12-22 06:47:22.717 5234 5234 I Dialer : DialerCall.isVoipCallNotSupportedBySpeakeasy - callid was empty
12-22 06:47:22.721 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 6, connectionLabel:
12-22 06:47:22.722 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.722 5234 5234 I Dialer : VideoPauseController.onStateChange - hasPrimaryCallChanged: false, videoCanPause: false, isInBackground: false
12-22 06:47:22.724 5234 5234 I Dialer : DialerCall.isVoipCallNotSupportedBySpeakeasy - callid was empty
12-22 06:47:22.728 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 6, connectionLabel:
12-22 06:47:22.729 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.729 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.730 1457 1949 I DisplayPowerController[0]: No longer ignoring proximity [0]
12-22 06:47:22.731 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.731 5234 5234 I Dialer : CallList.onUpdateCall - [DialerCall_4, DIALING, [Capabilities: CAPABILITY_SUPPORT_HOLD CAPABILITY_MUTE], [Properties:], children:[], parent:null, conferenceable:[], videoState:Audio Only, mSessionModificationState:0, CameraDir:-1]
12-22 06:47:22.732 5234 5234 I Dialer : ReturnToCallController.hide - hide() called without calling show()
12-22 06:47:22.732 5234 5234 I Dialer : InCallPresenter.onCallListChange - Phone switching state: OUTGOING -> OUTGOING
12-22 06:47:22.736 5234 5234 I Dialer : DialerCall.isVoipCallNotSupportedBySpeakeasy - callid was empty
12-22 06:47:22.740 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 6, connectionLabel:
12-22 06:47:22.741 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.741 5234 5234 I Dialer : VideoPauseController.onStateChange - hasPrimaryCallChanged: false, videoCanPause: false, isInBackground: false
12-22 06:47:22.743 5234 5234 I Dialer : DialerCall.isVoipCallNotSupportedBySpeakeasy - callid was empty
12-22 06:47:22.746 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 6, connectionLabel:
12-22 06:47:22.747 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.748 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.749 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.749 5234 5234 I Dialer : CallList.onUpdateCall - [DialerCall_4, DIALING, [Capabilities: CAPABILITY_SUPPORT_HOLD CAPABILITY_MUTE], [Properties:], children:[], parent:null, conferenceable:[], videoState:Audio Only, mSessionModificationState:0, CameraDir:-1]
12-22 06:47:22.750 5234 5234 I Dialer : ReturnToCallController.hide - hide() called without calling show()
12-22 06:47:22.751 5234 5234 I Dialer : InCallPresenter.onCallListChange - Phone switching state: OUTGOING -> OUTGOING
12-22 06:47:22.757 5234 5234 I Dialer : DialerCall.isVoipCallNotSupportedBySpeakeasy - callid was empty
12-22 06:47:22.766 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 6, connectionLabel:
12-22 06:47:22.767 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.768 5234 5234 I Dialer : VideoPauseController.onStateChange - hasPrimaryCallChanged: false, videoCanPause: false, isInBackground: false
12-22 06:47:22.769 5234 5234 I Dialer : DialerCall.isVoipCallNotSupportedBySpeakeasy - callid was empty
12-22 06:47:22.773 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 6, connectionLabel:
12-22 06:47:22.774 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.775 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.776 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.777 5234 5234 I Dialer : CallList.onUpdateCall - [DialerCall_4, DIALING, [Capabilities: CAPABILITY_SUPPORT_HOLD CAPABILITY_MUTE], [Properties:], children:[], parent:null, conferenceable:[], videoState:Audio Only, mSessionModificationState:0, CameraDir:-1]
12-22 06:47:22.777 5234 5234 I Dialer : ReturnToCallController.hide - hide() called without calling show()
12-22 06:47:22.778 5234 5234 I Dialer : InCallPresenter.onCallListChange - Phone switching state: OUTGOING -> OUTGOING
12-22 06:47:22.785 5234 5234 I Dialer : DialerCall.isVoipCallNotSupportedBySpeakeasy - callid was empty
12-22 06:47:22.790 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 6, connectionLabel:
12-22 06:47:22.791 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.792 5234 5234 I Dialer : VideoPauseController.onStateChange - hasPrimaryCallChanged: false, videoCanPause: false, isInBackground: false
12-22 06:47:22.794 5234 5234 I Dialer : DialerCall.isVoipCallNotSupportedBySpeakeasy - callid was empty
12-22 06:47:22.798 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 6, connectionLabel:
12-22 06:47:22.799 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.800 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.802 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:22.802 5234 5234 I Dialer : CallList.onUpdateCall - [DialerCall_4, DIALING, [Capabilities: CAPABILITY_SUPPORT_HOLD CAPABILITY_MUTE], [Properties:], children:[], parent:null, conferenceable:[], videoState:Audio Only, mSessionModificationState:0, CameraDir:-1]
12-22 06:47:22.803 5234 5234 I Dialer : ReturnToCallController.hide - hide() called without calling show()
12-22 06:47:22.803 5234 5234 I Dialer : InCallPresenter.onCallListChange - Phone switching state: OUTGOING -> OUTGOING
12-22 06:47:22.807 5234 5234 I Dialer : DialerCall.isVoipCallNotSupportedBySpeakeasy - callid was empty
12-22 06:47:22.811 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 6, connectionLabel:
12-22 06:47:22.812 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.813 5234 5234 I Dialer : VideoPauseController.onStateChange - hasPrimaryCallChanged: false, videoCanPause: false, isInBackground: false
12-22 06:47:22.814 5234 5234 I Dialer : DialerCall.isVoipCallNotSupportedBySpeakeasy - callid was empty
12-22 06:47:22.817 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 6, connectionLabel:
12-22 06:47:22.819 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:22.821 5234 5234 I Dialer : ProximitySensor.updateProximitySensorMode - screenOnImmediately: false, dialPadVisible: false, offHook: true, horizontal: true, uiShowing: true, audioRoute: EARPIECE
12-22 06:47:22.821 5234 5234 I Dialer : ProximitySensor.turnOnProximitySensor - wake lock already acquired
12-22 06:47:39.637 5234 5234 I Dialer : InCallFragment.onClick - end call button clicked
12-22 06:47:39.638 5234 5234 I Dialer : CallCardPresenter.onEndCallClicked - disconnecting call: [DialerCall_4, ACTIVE, [Capabilities: CAPABILITY_HOLD CAPABILITY_SUPPORT_HOLD CAPABILITY_MUTE CAPABILITY_TRANSFER], [Properties:], children:[], parent:null, conferenceable:[], videoState:Audio Only, mSessionModificationState:0, CameraDir:-1]
12-22 06:47:39.638 5234 5234 I Dialer : DialerCall.disconnect
12-22 06:47:39.639 5234 5234 I Dialer : CallList.onUpdateCall - [DialerCall_4, DISCONNECTING, [Capabilities: CAPABILITY_HOLD CAPABILITY_SUPPORT_HOLD CAPABILITY_MUTE CAPABILITY_TRANSFER], [Properties:], children:[], parent:null, conferenceable:[], videoState:Audio Only, mSessionModificationState:0, CameraDir:-1]
12-22 06:47:39.640 5234 5234 I Dialer : ReturnToCallController.hide - hide() called without calling show()
12-22 06:47:39.640 5234 5234 I Dialer : InCallPresenter.onCallListChange - Phone switching state: INCALL -> INCALL
12-22 06:47:39.647 942 942 I sensors-hal: batch:242, android.sensor.accelerometer/11, period=200000000, max_latency=2000000000
12-22 06:47:39.648 942 942 I sensors-hal: set_config:63, sample_period_ns is adjusted to 200000000 based on min/max delay_ns
12-22 06:47:39.648 942 942 I sensors-hal: batch:251, android.sensor.accelerometer/11, period=200000000, max_latency=2000000000 request completed
12-22 06:47:39.650 942 7068 I sensors-hal: ssc_conn_resp_cb:663, resp_value = 0
12-22 06:47:39.650 5234 5234 I Dialer : ProximitySensor.updateProximitySensorMode - screenOnImmediately: true, dialPadVisible: false, offHook: false, horizontal: false, uiShowing: true, audioRoute: SPEAKER
12-22 06:47:39.651 5234 5234 I Dialer : ProximitySensor.turnOffProximitySensor - wake lock already released
12-22 06:47:39.652 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 9, connectionLabel:
12-22 06:47:39.654 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:39.655 5234 5234 I Dialer : VideoPauseController.onStateChange - hasPrimaryCallChanged: true, videoCanPause: false, isInBackground: false
12-22 06:47:39.656 5234 5234 I Dialer : VideoPauseController.onPrimaryCallChanged - new call: null, old call: [DialerCall_4, DISCONNECTING, [Capabilities: CAPABILITY_HOLD CAPABILITY_SUPPORT_HOLD CAPABILITY_MUTE CAPABILITY_TRANSFER], [Properties:], children:[], parent:null, conferenceable:[], videoState:Audio Only, mSessionModificationState:0, CameraDir:-1], mIsInBackground: false
12-22 06:47:39.657 3079 3127 D PeopleSpaceWidgetMgr: Sbn doesn't contain valid PeopleTileKey: null/0/com.android.dialer
12-22 06:47:39.657 1457 2901 I Telecom : Event: RecordEntry TC@5: REQUEST_DISCONNECT, internal: ICA.dC(cad)@DDs
12-22 06:47:39.658 1457 2901 I Telecom : Call: Send disconnect to connection service for call: [Call id=TC@5, state=DISCONNECTING, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[ hld sup_hld mut sup_trans], prop=[]]: ICA.dC(cad)@DDs
12-22 06:47:39.659 1457 3301 I Telecom : CallAudioModeStateMachine: Message received: NEW_ACTIVE_OR_DIALING_CALL.: ICA.dC->CAMSM.pM_2001(cad)@DDs
12-22 06:47:39.659 3197 3197 I TelecomFramework: TelephonyConnectionService: disconnect TC@5_1: (ICA.dC)->CS.d->H.CS.d(cad/cast)@E-DDs
12-22 06:47:39.660 1457 2901 I Telecom : IncomingCallNotifier: updateIncomingCall: foundIncomingcall = null: ICA.dC(cad)@DDs
12-22 06:47:39.660 3197 3197 V Telephony: onDisconnect
12-22 06:47:39.661 4040 4040 D NotificationRepository: updateNotification() called with: list = [5]
12-22 06:47:39.661 3197 3197 V Telephony: isValidRingingCall, ringing call is not in ringing state
12-22 06:47:39.661 1457 2901 I Telecom : TelecomWakeLock: WakeLock already released with id: 26: ICA.dC(cad)@DDs
12-22 06:47:39.662 1457 2901 I Telecom : InCallWakeLockController: Releasing full wake lock: ICA.dC(cad)@DDs
12-22 06:47:39.663 1457 2901 I Telecom : InCallController: Sending updateCall [Call id=TC@5, state=DISCONNECTING, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[ hld sup_hld mut sup_trans], prop=[]]: ICA.dC(cad)@DDs
12-22 06:47:39.665 3197 3197 I ImsCall : terminate :: reason=501 ImsCall=[ImsCall objId:187833211 onHold:N mute:N mCallProfile:{ serviceType=1, callType=2, restrictCause=0, mediaProfile={ audioQuality=0, audioDirection=3, audioCodecAttribute=null, videoQuality=0, videoDirection=-1, rttMode=0, hasRttAudioSpeech=false }, emergencyServiceCategories=0, emergencyUrns=[], emergencyCallRouting=0, emergencyCallTesting=false, hasKnownUserIntentEmergency=false, mRestrictCause=0, mCallerNumberVerstat= 0, mAcceptedRtpHeaderExtensions= [] } networkType:13 updateRequest:NONE merging:N merge action pending:N merged:N multiParty:N confHost:N buried term:N isVideo: N wasVideo: N isWifi: N session:[ImsCallSession objId:207185674 state:ESTABLISHED callId:1] transientSession:null]
12-22 06:47:39.665 1457 2901 I Telecom : InCallController: Components updated: [ComponentInfo{com.android.dialer/com.android.incallui.InCallServiceImpl}, ComponentInfo{com.android.bluetooth/com.android.bluetooth.telephony.BluetoothInCallService}]: ICA.dC(cad)@DDs
12-22 06:47:39.666 3174 3234 I QImsService: ImsCallSessionImpl : terminate 501
12-22 06:47:39.667 3174 3234 I QImsService: ImsSenderRxr : [0044]> HANGUP [SUB0]
12-22 06:47:39.668 3174 3234 I QImsService: ImsRadioUtils : imsReason= 501
12-22 06:47:39.672 3197 3197 V Telephony: MSG_PRECISE_CALL_STATE_CHANGED
12-22 06:47:39.673 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:39.673 3197 3197 V Telephony: GsmConnection: Update state from ACTIVE to DISCONNECTING for TC@5_1
12-22 06:47:39.674 1457 5907 I Telecom : InCallController: Sending updateCall [Call id=TC@5, state=DISCONNECTING, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[ hld sup_hld mut sup_trans], prop=[]]: CSW.sSH(cap)@DD0
12-22 06:47:39.675 3157 3784 D QcRilAudio: setParameters with: vsid=297816064;call_state=2;call_type=LTE[slot1]
12-22 06:47:39.676 1457 5907 I Telecom : InCallController: Components updated: [ComponentInfo{com.android.dialer/com.android.incallui.InCallServiceImpl}, ComponentInfo{com.android.bluetooth/com.android.bluetooth.telephony.BluetoothInCallService}]: CSW.sSH(cap)@DD0
12-22 06:47:39.676 923 2581 D audio_hw_primary: adev_set_parameters: enter: call_state=2;call_type=LTE;vsid=297816064
12-22 06:47:39.676 3197 3197 D Telephony: buildConnectionCapabilities: isHoldable = true State = 4 capabilities = 3
12-22 06:47:39.676 923 2581 D voice_extn: update_call_states is_call_active:1 in_call:1, mode:2
12-22 06:47:39.677 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:39.677 923 2581 D voice_extn: update_calls: enter:
12-22 06:47:39.677 5234 5234 I Dialer : CallList.onUpdateCall - [DialerCall_4, DISCONNECTING, [Capabilities: CAPABILITY_HOLD CAPABILITY_SUPPORT_HOLD CAPABILITY_MUTE CAPABILITY_TRANSFER], [Properties:], children:[], parent:null, conferenceable:[], videoState:Audio Only, mSessionModificationState:0, CameraDir:-1]
12-22 06:47:39.679 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10c01000
12-22 06:47:39.679 5234 5234 I Dialer : ReturnToCallController.hide - hide() called without calling show()
12-22 06:47:39.680 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10dc1000
12-22 06:47:39.680 5234 5234 I Dialer : InCallPresenter.onCallListChange - Phone switching state: INCALL -> INCALL
12-22 06:47:39.680 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10c02000
12-22 06:47:39.681 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10803000
12-22 06:47:39.681 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10002000
12-22 06:47:39.682 923 2581 D voice_extn: update_calls: cur_state=2 new_state=2 vsid=11c05000
12-22 06:47:39.683 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=11dc5000
12-22 06:47:39.683 923 2581 D voice_extn: voice_extn_set_parameters: call type is LTE
12-22 06:47:39.683 923 2581 D audio_hw_hfp: hfp_set_parameters: enter
12-22 06:47:39.684 923 2581 D audio_hw_extn: audio_extn_fm_set_parameters: Enter
12-22 06:47:39.686 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 9, connectionLabel:
12-22 06:47:39.686 3157 3784 I QcrilOemhookMsgTunnel: [0]processOemHookIndication length=61
12-22 06:47:39.687 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:39.688 5234 5234 I Dialer : VideoPauseController.onStateChange - hasPrimaryCallChanged: false, videoCanPause: false, isInBackground: false
12-22 06:47:39.688 3174 3704 I QImsService: ImsRadioResponseHidl : Got hangup response from ImsRadio.
12-22 06:47:39.688 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:39.689 3174 3704 I QImsService: ImsSenderRxr : [0044]< HANGUP [SUB0]
12-22 06:47:39.689 3197 3197 D Telephony: buildConnectionCapabilities: isHoldable = true State = 4 capabilities = 3
12-22 06:47:39.689 3174 3174 I QImsService: ImsCallSessionImplHandler : Message received: what = 3
12-22 06:47:39.690 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:39.690 5234 5234 I Dialer : CallList.onUpdateCall - [DialerCall_4, DISCONNECTING, [Capabilities: CAPABILITY_HOLD CAPABILITY_SUPPORT_HOLD CAPABILITY_MUTE CAPABILITY_TRANSFER], [Properties:], children:[], parent:null, conferenceable:[], videoState:Audio Only, mSessionModificationState:0, CameraDir:-1]
12-22 06:47:39.691 5234 5234 I Dialer : ReturnToCallController.hide - hide() called without calling show()
12-22 06:47:39.691 5234 5234 I Dialer : InCallPresenter.onCallListChange - Phone switching state: INCALL -> INCALL
12-22 06:47:39.693 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 9, connectionLabel:
12-22 06:47:39.695 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:39.696 5234 5234 I Dialer : VideoPauseController.onStateChange - hasPrimaryCallChanged: false, videoCanPause: false, isInBackground: false
12-22 06:47:39.697 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 9, connectionLabel:
12-22 06:47:39.698 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:39.699 3197 3197 D TelephonyProvider: Using old permission behavior for telephony provider compat
12-22 06:47:39.700 3157 3784 D QcRilAudio: setParameters with: vsid=297816064;call_state=1[slot1]
12-22 06:47:39.700 3174 3704 I QImsService: ImsRadioIndicationHidl : onCallStateChanged_1_7()
12-22 06:47:39.700 923 2581 D audio_hw_primary: adev_set_parameters: enter: call_state=1;vsid=297816064
12-22 06:47:39.701 3174 3704 I QImsService: ImsRadioIndicationHidl : onCallStateChanged_1_8()
12-22 06:47:39.701 923 2581 D voice_extn: update_call_states is_call_active:1 in_call:1, mode:2
12-22 06:47:39.701 3174 3704 I QImsService: Class : Num of SrvUpdates = 2
12-22 06:47:39.701 923 2581 D voice_extn: update_calls: enter:
12-22 06:47:39.702 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:39.702 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10c01000
12-22 06:47:39.703 3174 3704 I QImsService: Class : networkMode = 14 status = 2 restrictCause = 0 registered = 0
12-22 06:47:39.703 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10dc1000
12-22 06:47:39.703 3174 3704 I QImsService: Class : RTT: copySrvStatusList rtt mode = 0
12-22 06:47:39.703 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:39.703 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10c02000
12-22 06:47:39.704 3174 3704 I QImsService: Class : RTT: copySrvStatusList rtt mode = 0
12-22 06:47:39.704 5234 5234 I Dialer : CallList.onUpdateCall - [DialerCall_4, DISCONNECTING, [Capabilities: CAPABILITY_HOLD CAPABILITY_SUPPORT_HOLD CAPABILITY_MUTE CAPABILITY_TRANSFER], [Properties:], children:[], parent:null, conferenceable:[], videoState:Audio Only, mSessionModificationState:0, CameraDir:-1]
12-22 06:47:39.704 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10803000
12-22 06:47:39.704 3174 3704 I QImsService: Class : Num of SrvUpdates = 2
12-22 06:47:39.705 5234 5234 I Dialer : ReturnToCallController.hide - hide() called without calling show()
12-22 06:47:39.705 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10002000
12-22 06:47:39.705 3174 3704 I QImsService: Class : RTT: copySrvStatusList rtt mode = 0
12-22 06:47:39.705 5234 5234 I Dialer : InCallPresenter.onCallListChange - Phone switching state: INCALL -> INCALL
12-22 06:47:39.706 923 2581 D voice_extn: update_calls: cur_state=2 new_state=1 vsid=11c05000
12-22 06:47:39.706 3174 3704 I QImsService: Class : RTT: copySrvStatusList rtt mode = 0
12-22 06:47:39.707 923 2581 D voice_extn: update_calls: ACTIVE/HOLD/LOCAL_HOLD -> INACTIVE vsid:11c05000
12-22 06:47:39.707 3174 3704 I QImsService: Class : Call Details = 0 2 callSubState 0 videoPauseState2 mediaId17 Rtt mode 0 Local Ability isValid = true type = 0 status = 2 rttMode = 0 accTechStatus mode = 14 Status = 2 restrictCause = 0 registered = 0isValid = true type = 3 status = 0 rttMode = 0 accTechStatus mode = 14 Status = 0 restrictCause = 1 registered = 0 Peer Ability isValid = true type = 0 status = 2 rttMode = 0 accTechStatus mode = 14 Status = 2 restrictCause = 0 registered = 0isValid = true type = 3 status = 0 rttMode = 0 accTechStatus mode = 14 Status = 0 restrictCause = 1 registered = 0 Cause code 0 sipAlternateUri null, null
12-22 06:47:39.707 923 2581 D voice : voice_stop_usecase: enter usecase:voicemmode1-call
12-22 06:47:39.708 3174 3704 I QImsService: Class : Call fail cause= 1
12-22 06:47:39.708 923 2581 D voice : voice_set_sidetone: disable, out_snd_device: 26
12-22 06:47:39.709 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 9, connectionLabel:
12-22 06:47:39.710 3174 3704 I QImsService: Class : CallFailCauseResponse has no int error code!
12-22 06:47:39.710 923 2581 W voice : voice_is_sidetone_device: 26 is not a sidetone device
12-22 06:47:39.710 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:39.711 3174 3704 I QImsService: ImsSenderRxr : [UNSL]< UNSOL_RESPONSE_CALL_STATE_CHANGED [id=1,END,toa=129,norm,mo,0,voc,noevp,,cli=1,,3Call Details = 0 2 callSubState 0 videoPauseState2 mediaId17 Rtt mode 0 Local Ability isValid = true type = 0 status = 2 rttMode = 0 accTechStatus mode = 14 Status = 2 restrictCause = 0 registered = 0isValid = true type = 3 status = 0 rttMode = 0 accTechStatus mode = 14 Status = 0 restrictCause = 1 registered = 0 Peer Ability isValid = true type = 0 status = 2 rttMode = 0 accTechStatus mode = 14 Status = 2 restrictCause = 0 registered = 0isValid = true type = 3 status = 0 rttMode = 0 accTechStatus mode = 14 Status = 0 restrictCause = 1 registered = 0 Cause code 0 sipAlternateUri null, null,CallFailCause Code= 501,CallFailCause String= null, isEncrypted=false, historyInfo=, Conf. Support=3, {MultiIdentity Line Info : msisdn = , line type = 0 , line status = 0}, isTirOverwriteAllowed=false, isPreparatory=false, CRS data=CrsData crsType: 0 originalCallType: 10, Call progress Info = CallProgressInfo Type: -1 Reason code: 0 Reason Text: null, diversionInfo =, additional call info =MsimAdditionalCallInfo additional code : -1] [SUB0]
12-22 06:47:39.712 5234 5234 I Dialer : VideoPauseController.onStateChange - hasPrimaryCallChanged: false, videoCanPause: false, isInBackground: false
12-22 06:47:39.713 3174 3704 I QImsService: ImsSenderRxr : InCall VoicePrivacy is disabled[SUB0]
12-22 06:47:39.714 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 9, connectionLabel:
12-22 06:47:39.714 3174 3174 I QImsService: ImsServiceSubHandler : Message received: what = 1
12-22 06:47:39.711 0 0 D cma : cma_release(page 0000000066d5e7d1)
12-22 06:47:39.714 0 0 D cma : cma_release(page 0000000016f201ac)
12-22 06:47:39.715 3174 3174 I QImsService: ImsServiceSub : [0] >handleCalls
12-22 06:47:39.715 3174 3174 I QImsService: ImsServiceSub : [0] handleCalls: dc = id=1,END,toa=129,norm,mo,0,voc,noevp,,cli=1,,3Call Details = 0 2 callSubState 0 videoPauseState2 mediaId17 Rtt mode 0 Local Ability isValid = true type = 0 status = 2 rttMode = 0 accTechStatus mode = 14 Status = 2 restrictCause = 0 registered = 0isValid = true type = 3 status = 0 rttMode = 0 accTechStatus mode = 14 Status = 0 restrictCause = 1 registered = 0 Peer Ability isValid = true type = 0 status = 2 rttMode = 0 accTechStatus mode = 14 Status = 2 restrictCause = 0 registered = 0isValid = true type = 3 status = 0 rttMode = 0 accTechStatus mode = 14 Status = 0 restrictCause = 1 registered = 0 Cause code 0 sipAlternateUri null, null,CallFailCause Code= 501,CallFailCause String= null, isEncrypted=false, historyInfo=, Conf. Support=3, {MultiIdentity Line Info : msisdn = , line type = 0 , line status = 0}, isTirOverwriteAllowed=false, isPreparatory=false, CRS data=CrsData crsType: 0 originalCallType: 10, Call progress Info = CallProgressInfo Type: -1 Reason code: 0 Reason Text: null, diversionInfo =, additional call info =MsimAdditionalCallInfo additional code : -1
12-22 06:47:39.715 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:39.717 3174 3174 I QImsService: ImsCallSessionImpl : updateCall for id=1,END,toa=129,norm,mo,0,voc,noevp,,cli=1,,3Call Details = 0 2 callSubState 0 videoPauseState2 mediaId17 Rtt mode 0 Local Ability isValid = true type = 0 status = 2 rttMode = 0 accTechStatus mode = 14 Status = 2 restrictCause = 0 registered = 0isValid = true type = 3 status = 0 rttMode = 0 accTechStatus mode = 14 Status = 0 restrictCause = 1 registered = 0 Peer Ability isValid = true type = 0 status = 2 rttMode = 0 accTechStatus mode = 14 Status = 2 restrictCause = 0 registered = 0isValid = true type = 3 status = 0 rttMode = 0 accTechStatus mode = 14 Status = 0 restrictCause = 1 registered = 0 Cause code 0 sipAlternateUri null, null,CallFailCause Code= 501,CallFailCause String= null, isEncrypted=false, historyInfo=, Conf. Support=3, {MultiIdentity Line Info : msisdn = , line type = 0 , line status = 0}, isTirOverwriteAllowed=false, isPreparatory=false, CRS data=CrsData crsType: 0 originalCallType: 10, Call progress Info = CallProgressInfo Type: -1 Reason code: 0 Reason Text: null, diversionInfo =, additional call info =MsimAdditionalCallInfo additional code : -1
12-22 06:47:39.717 3197 3197 V Telephony: GsmConnection: refreshConferenceSupported : isConfSupp=true, isImsConfSupp=true, isVidConfSupp=true, isMergeOfWifiAllowed=true, isWifi=false, isVoWifiEnabled=false
12-22 06:47:39.718 3174 3174 I QImsService: ImsCallSessionImpl : updateImsCallProfile :: Packing encryption=false in mCallProfile's extras.
12-22 06:47:39.718 3197 3197 D Telephony: refreshConferenceSupported = true.
12-22 06:47:39.718 3174 3174 I QImsService: ImsCallSessionImpl : updateImsCallProfile :: VerstatInfo : canMarkUnwantedCall = false , verstatVerificationStatus = 0
12-22 06:47:39.719 3174 3174 I QImsService: ImsCallSessionImpl : AudioQuality is 1
12-22 06:47:39.719 3174 3174 I QImsService: ImsCallSessionImpl : Sip callFailCause:ImsReasonInfo :: {501 : CODE_USER_TERMINATED, 0, null}
12-22 06:47:39.719 1457 5763 I Telecom : InCallController: Sending updateCall [Call id=TC@5, state=DISCONNECTING, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[ hld sup_hld mut sup_trans], prop=[]]: CSW.rE(cap)@DEM
12-22 06:47:39.719 3174 3174 I QImsService: ImsCallSessionCallbackHandler : posting to handler
12-22 06:47:39.720 3174 3174 I QImsService: ImsCallSessionImpl : updateLocalDc is true
12-22 06:47:39.721 3174 3174 I QImsService: ImsServiceClassTracker : handleCalls: removing dropped/ended call id:1
12-22 06:47:39.721 3174 7190 I QImsService: ImsCallSessionCallbackHandler : callSessionTerminated :: reason=ImsReasonInfo :: {501 : CODE_USER_TERMINATED, 0, null}
12-22 06:47:39.721 3174 3174 D VideoCall_MediaController: onSessionRemoved callSession= callid= 1 mediaId=17 mState= 8 mDc=id=1,END,toa=129,norm,mo,0,voc,noevp,,cli=1,,3Call Details = 0 2 callSubState 0 videoPauseState2 mediaId17 Rtt mode 0 Local Ability isValid = true type = 0 status = 2 rttMode = 0 accTechStatus mode = 14 Status = 2 restrictCause = 0 registered = 0isValid = true type = 3 status = 0 rttMode = 0 accTechStatus mode = 14 Status = 0 restrictCause = 1 registered = 0 Peer Ability isValid = true type = 0 status = 2 rttMode = 0 accTechStatus mode = 14 Status = 2 restrictCause = 0 registered = 0isValid = true type = 3 status = 0 rttMode = 0 accTechStatus mode = 14 Status = 0 restrictCause = 1 registered = 0 Cause code 0 sipAlternateUri null, null,CallFailCause Code= 501,CallFailCause String= null, isEncrypted=false, historyInfo=, Conf. Support=3, {MultiIdentity Line Info : msisdn = , line type = 0 , line status = 0}, isTirOverwriteAllowed=false, isPreparatory=false, CRS data=CrsData crsType: 0 originalCallType: 10, Call progress Info = CallProgressInfo Type: -1 Reason code: 0 Reason Text: null, diversionInfo =, additional call info =MsimAdditionalCallInfo additional code : -1 mCallProfile={ serviceType=1, callType=2, restrictCause=0, mediaProfile={ audioQuality=0, audioDirection=3, audioCodecAttribute=null, videoQuality=0, videoDirection=-1, rttMode=0, hasRttAudioSpeech=false }, emergencyServiceCategories=0, emergencyUrns=[], emergencyCallRouting=0, emergencyCallTesting=false, hasKnownUserIntentEmergency=false, mRestrictCause=0, mCallerNumberVerstat= 0, mAcceptedRtpHeaderExtensions= {} } mLocalCallProfile={ serviceType=1, callType=2, restrictCause=0, mediaProfile={ audioQuality=1, audioDirection=3, audioCodecAttribute=null, videoQuality=0, videoDirection=-1, rttMode=0, hasRttAudioSpeech=false }, emergencyServiceCategories=0, emergencyUrns=[], emergencyCallRouting=0, emergencyCallTesting=false, hasKnownUserIntentEmergency=false, mRestrictCause=0, mCallerNumberVerstat= 0, mAcceptedRtpHeaderExtensions= {} } mRemoteCallProfile={ serviceType=1, callType=2, restrictCause=0, mediaProfile={ audioQuality=0, audioDirection=3, audioCodecAttribute=null, videoQuality=0, videoDirection=-1, rttMode=0, hasRttAudioSpeech=false }, emergencyServiceCategories=0, emergencyUrns=[], emergencyCallRouting=0, emergencyCallTesting=false, hasKnownUserIntentEmergency=false, mRestrictCause=0, mCallerNumberVerstat= 0, mAcceptedRtpHeaderExtensions= {} } no:of call sessions = 1
12-22 06:47:39.721 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:39.722 1457 5763 I Telecom : InCallController: Components updated: [ComponentInfo{com.android.dialer/com.android.incallui.InCallServiceImpl}, ComponentInfo{com.android.bluetooth/com.android.bluetooth.telephony.BluetoothInCallService}]: CSW.rE(cap)@DEM
12-22 06:47:39.723 3197 3499 I ImsCall : callSessionTerminated :: session=[ImsCallSession objId:207185674 state:TERMINATED callId:1] reasonInfo=ImsReasonInfo :: {501 : CODE_USER_TERMINATED, 0, null} ImsCall=[ImsCall objId:187833211 onHold:N mute:N mCallProfile:{ serviceType=1, callType=2, restrictCause=0, mediaProfile={ audioQuality=0, audioDirection=3, audioCodecAttribute=null, videoQuality=0, videoDirection=-1, rttMode=0, hasRttAudioSpeech=false }, emergencyServiceCategories=0, emergencyUrns=[], emergencyCallRouting=0, emergencyCallTesting=false, hasKnownUserIntentEmergency=false, mRestrictCause=0, mCallerNumberVerstat= 0, mAcceptedRtpHeaderExtensions= [] } networkType:13 updateRequest:NONE merging:N merge action pending:N merged:N multiParty:N confHost:N buried term:N isVideo: N wasVideo: N isWifi: N session:[ImsCallSession objId:207185674 state:TERMINATED callId:1] transientSession:null]
12-22 06:47:39.724 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:39.724 3197 3499 I ImsCall : processCallTerminated :: reason=ImsReasonInfo :: {501 : CODE_USER_TERMINATED, 0, null} userInitiated = true ImsCall=[ImsCall objId:187833211 onHold:N mute:N mCallProfile:{ serviceType=1, callType=2, restrictCause=0, mediaProfile={ audioQuality=0, audioDirection=3, audioCodecAttribute=null, videoQuality=0, videoDirection=-1, rttMode=0, hasRttAudioSpeech=false }, emergencyServiceCategories=0, emergencyUrns=[], emergencyCallRouting=0, emergencyCallTesting=false, hasKnownUserIntentEmergency=false, mRestrictCause=0, mCallerNumberVerstat= 0, mAcceptedRtpHeaderExtensions= [] } networkType:13 updateRequest:NONE merging:N merge action pending:N merged:N multiParty:N confHost:N buried term:N isVideo: N wasVideo: N isWifi: N session:[ImsCallSession objId:207185674 state:TERMINATED callId:1] transientSession:null]
12-22 06:47:39.724 5234 5234 I Dialer : CallList.onUpdateCall - [DialerCall_4, DISCONNECTING, [Capabilities: CAPABILITY_HOLD CAPABILITY_SUPPORT_HOLD CAPABILITY_MUTE CAPABILITY_TRANSFER], [Properties:], children:[], parent:null, conferenceable:[], videoState:Audio Only, mSessionModificationState:0, CameraDir:-1]
12-22 06:47:39.725 5234 5234 I Dialer : ReturnToCallController.hide - hide() called without calling show()
12-22 06:47:39.726 5234 5234 I Dialer : InCallPresenter.onCallListChange - Phone switching state: INCALL -> INCALL
12-22 06:47:39.729 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 9, connectionLabel:
12-22 06:47:39.730 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:39.731 5234 5234 I Dialer : VideoPauseController.onStateChange - hasPrimaryCallChanged: false, videoCanPause: false, isInBackground: false
12-22 06:47:39.732 1457 2901 E AppOps : noteOperation
12-22 06:47:39.732 1457 2901 E AppOps : java.lang.SecurityException: Specified package com.android.phone under uid 10146 but it is not
12-22 06:47:39.732 1457 2901 E AppOps : at com.android.server.appop.AppOpsService.verifyAndGetBypass(AppOpsService.java:4625)
12-22 06:47:39.732 1457 2901 E AppOps : at com.android.server.appop.AppOpsService.noteOperationUnchecked(AppOpsService.java:3429)
12-22 06:47:39.732 1457 2901 E AppOps : at com.android.server.appop.AppOpsService.noteOperationImpl(AppOpsService.java:3417)
12-22 06:47:39.732 1457 2901 E AppOps : at com.android.server.appop.AppOpsService.access$3900(AppOpsService.java:215)
12-22 06:47:39.732 1457 2901 E AppOps : at com.android.server.appop.AppOpsService$CheckOpsDelegateDispatcher.lambda$noteOperation$4(AppOpsService.java:7558)
12-22 06:47:39.732 1457 2901 E AppOps : at com.android.server.appop.AppOpsService$CheckOpsDelegateDispatcher$$ExternalSyntheticLambda5.apply(Unknown Source:33)
12-22 06:47:39.732 1457 2901 E AppOps : at com.android.server.policy.AppOpsPolicy.noteOperation(AppOpsPolicy.java:226)
12-22 06:47:39.732 1457 2901 E AppOps : at com.android.server.appop.AppOpsService$CheckOpsDelegateDispatcher.noteOperation(AppOpsService.java:7556)
12-22 06:47:39.732 1457 2901 E AppOps : at com.android.server.appop.AppOpsService.noteOperation(AppOpsService.java:3401)
12-22 06:47:39.732 1457 2901 E AppOps : at com.android.internal.app.IAppOpsService$Stub.onTransact(IAppOpsService.java:476)
12-22 06:47:39.732 1457 2901 E AppOps : at android.os.Binder.execTransactInternal(Binder.java:1184)
12-22 06:47:39.732 1457 2901 E AppOps : at android.os.Binder.execTransact(Binder.java:1143)
12-22 06:47:39.732 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 9, connectionLabel:
12-22 06:47:39.733 1457 2901 W PackageManager: Calling uid 1001, pid 3197 cannot access for package com.android.phone (uid=10146, pid=0): getSubscriptionInfoList
12-22 06:47:39.734 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:39.735 1457 2901 W PackageManager: Calling uid 1001, pid 3197 cannot access for package com.android.phone (uid=10146, pid=0): getSubscriptionInfoList
12-22 06:47:39.729 0 0 I afe_close: port_id = 0xb037
12-22 06:47:39.740 923 2581 D msm8974_platform: platform_get_island_cfg_on_device:island cfg status on snd_device = (voice-speaker-dmic-ef 0)
12-22 06:47:39.740 923 2581 D msm8974_platform: platform_get_island_cfg_on_device:island cfg status on snd_device = (voice-speaker 0)
12-22 06:47:39.741 923 2581 D audio_hw_primary: disable_audio_route: reset and update mixer path: voicemmode1-call
12-22 06:47:39.744 923 2581 D soundtrigger: audio HAL using same device 186 as ST
12-22 06:47:39.745 923 2581 D soundtrigger: audio_extn_sound_trigger_update_stream_status: uc_info->id 41 of type 2 for Event 2, with Raise=1
12-22 06:47:39.745 923 2581 D soundtrigger: audio_extn_sound_trigger_update_stream_status: send event 12: usecase id 41, type 2
12-22 06:47:39.745 923 2581 I sound_trigger_platform: platform_stdev_check_and_update_concurrency: Received CAPTURE_STREAM event, event type 12, usecase type 2
12-22 06:47:39.746 923 2581 D sound_trigger_platform: platform_stdev_get_capture_device: Device = 0x80000004
12-22 06:47:39.747 923 2581 D sound_trigger_platform: platform_stdev_get_capture_device: Available device = 0x80000004
12-22 06:47:39.747 923 2581 D sound_trigger_platform: platform_stdev_check_and_update_concurrency: dedicated path 0, reset backend 1, tx 1, rx 0, concurrency session not allowed
12-22 06:47:39.748 923 2581 D hardware_info: hw_info_append_hw_type : device_name = voice-speaker
12-22 06:47:39.749 923 2581 D msm8974_platform: platform_split_snd_device: snd_device(26) num devices(0) new_snd_devices(0)
12-22 06:47:39.749 923 2581 D hardware_info: hw_info_append_hw_type : device_name = voice-speaker-dmic-ef
12-22 06:47:39.749 923 2581 D audio_hw_primary: disable_snd_device: snd_device(186: voice-speaker-dmic-ef)
12-22 06:47:39.750 923 2581 D msm8974_platform: platform_split_snd_device: snd_device(186) num devices(0) new_snd_devices(0)
12-22 06:47:39.753 3197 7211 D CallNotifier: SignalInfoTonePlayer.run(toneId = 98)...
12-22 06:47:39.753 3197 3499 I Telephony: : onDisconnect: callId=TC@5_1, cause=LOCAL
12-22 06:47:39.753 3197 7211 D CallNotifier: mSignalInfoToneGenerator created already, hence skipping
12-22 06:47:39.754 3174 3234 I QImsService: ImsCallSessionImpl : Close!
12-22 06:47:39.754 3174 3174 I QImsService: ImsCallSessionImplHandler : Message received: what = 11
12-22 06:47:39.754 3197 3499 I ImsCall : getConferenceParticipants :: mConferenceParticipantsnull ImsCall=[ImsCall objId:187833211 onHold:N mute:N updateRequest:NONE merging:N merge action pending:N merged:N multiParty:N confHost:N buried term:N isVideo: N wasVideo: N isWifi: N session:null transientSession:null]
12-22 06:47:39.755 3174 3174 I QImsService: ImsCallSessionImpl : doClose!
12-22 06:47:39.755 3197 3197 V Telephony: GsmConnection: Update state from DISCONNECTING to DISCONNECTED for TC@5_1
12-22 06:47:39.755 3174 3174 I QImsService: ImsCallSessionCallbackHandler : posting to handler
12-22 06:47:39.756 3174 7190 I QImsService: ImsCallSessionCallbackHandler : dispose
12-22 06:47:39.757 3174 7190 I QImsService: ImsCallSessionCallbackHandler : cleanup
12-22 06:47:39.759 3197 3197 V Telephony: onStateChanged, state: DISCONNECTED
12-22 06:47:39.759 3197 3499 I ImsExternalCallTracker: onPhoneStateChanged : hasActiveCalls = false
12-22 06:47:39.759 3197 3499 D ImsExternalCallTracker: refreshCallPullState
12-22 06:47:39.760 3197 3197 V Telephony: : onDisconnected: [ldYnOm-r6PZl1i9O7AumfsNKyp4]
12-22 06:47:39.760 3197 3197 V Telephony: ImsConferenceController: recalculateConferenceable : 1
12-22 06:47:39.761 3197 3197 V Telephony: conferenceableSet size: 0
12-22 06:47:39.761 1457 5763 I Telecom : InCallController: Sending updateCall [Call id=TC@5, state=DISCONNECTING, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[ hld sup_hld mut sup_trans], prop=[]]: CSW.sSH(cap)@DEY
12-22 06:47:39.761 3197 3197 V Telephony: recalculateConference
12-22 06:47:39.762 3197 3197 V Telephony: : onStateChanged: [ldYnOm-r6PZl1i9O7AumfsNKyp4]
12-22 06:47:39.763 3197 3197 V Telephony: ImsConferenceController: recalculateConferenceable : 1
12-22 06:47:39.763 3197 3197 V Telephony: conferenceableSet size: 0
12-22 06:47:39.763 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:39.763 3197 3197 V Telephony: recalculateConference
12-22 06:47:39.764 1457 5763 I Telecom : InCallController: Components updated: [ComponentInfo{com.android.dialer/com.android.incallui.InCallServiceImpl}, ComponentInfo{com.android.bluetooth/com.android.bluetooth.telephony.BluetoothInCallService}]: CSW.sSH(cap)@DEY
12-22 06:47:39.764 3197 3197 V Telephony: close
12-22 06:47:39.765 1457 5763 I Telecom : CallsManager: setCallState DISCONNECTING -> DISCONNECTED, call: [Call id=TC@5, state=DISCONNECTING, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[ hld sup_hld mut sup_trans], prop=[]]: CSW.sDc(cap)@DEg
12-22 06:47:39.765 3197 3197 I Telephony: GsmConnection: clearOriginalConnection; clearing=[ImsPhoneConnection objId: 81223064 telecomCallID: TC@5_1 address: [Oi3Gd9joWshWVBdE4ojVBIgv6zY] isAdhocConf: N ImsCall: null]
12-22 06:47:39.765 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:39.766 1457 5763 I Telecom : Event: RecordEntry TC@5: SET_DISCONNECTED, disconnected set explicitly> DisconnectCause [ Code: (LOCAL) Label: () Description: () Reason: (LOCAL) Tone: (27) TelephonyCause: 3/-1 ImsReasonInfo: ImsReasonInfo :: {501 : CODE_USER_TERMINATED, 0, null}]: CSW.sDc(cap)@DEg
12-22 06:47:39.766 5234 5234 I Dialer : CallList.onUpdateCall - [DialerCall_4, DISCONNECTING, [Capabilities: CAPABILITY_HOLD CAPABILITY_SUPPORT_HOLD CAPABILITY_MUTE CAPABILITY_TRANSFER], [Properties:], children:[], parent:null, conferenceable:[], videoState:Audio Only, mSessionModificationState:0, CameraDir:-1]
12-22 06:47:39.766 3197 3197 D Telephony: topHoldableCount = 0
12-22 06:47:39.767 5234 5234 I Dialer : ReturnToCallController.hide - hide() called without calling show()
12-22 06:47:39.767 1457 3300 I Telecom : CallAudioRouteStateMachine: Message received: UPDATE_SYSTEM_AUDIO_ROUTE=1201, arg1=0: CSW.sDc->CARSM.pM_UPDATE_SYSTEM_AUDIO_ROUTE(cap)@DEg
12-22 06:47:39.767 3197 3197 V Telephony: ImsConferenceController: recalculateConferenceable : 0
12-22 06:47:39.767 5234 5234 I Dialer : InCallPresenter.onCallListChange - Phone switching state: INCALL -> INCALL
12-22 06:47:39.767 1457 3300 I Telecom : ActiveSpeakerRoute: Processing message UPDATE_SYSTEM_AUDIO_ROUTE: CSW.sDc->CARSM.pM_UPDATE_SYSTEM_AUDIO_ROUTE(cap)@DEg
12-22 06:47:39.769 3197 3197 V Telephony: conferenceableSet size: 0
12-22 06:47:39.769 3197 3197 D Telephony: buildConnectionCapabilities: isHoldable = true State = 6 capabilities = 0
12-22 06:47:39.770 923 2581 D soundtrigger: audio HAL using same device 186 as ST
12-22 06:47:39.770 3197 3197 D Telephony: buildConnectionCapabilities: isHoldable = true State = 6 capabilities = 0
12-22 06:47:39.770 1457 5763 I Telecom : IncomingCallNotifier: updateIncomingCall: foundIncomingcall = null: CSW.sDc(cap)@DEg
12-22 06:47:39.770 923 2581 I soundtrigger: audio_extn_sound_trigger_update_device_status: device 0xba of type 1 for Event 0, with Raise=1
12-22 06:47:39.771 923 2581 I sound_trigger_platform: platform_stdev_check_and_update_concurrency: Received DEVICE event, event type 0, usecase type 2
12-22 06:47:39.771 1457 3301 I Telecom : CallAudioModeStateMachine: Message received: TONE_STARTED_PLAYING.: CSW.sDc->CAMSM.pM_3001(cap)@DEg
12-22 06:47:39.772 3197 3197 I Telephony: GsmConnection: refreshCodec: codec changed; old=1, new=0
12-22 06:47:39.772 923 2581 D sound_trigger_platform: platform_stdev_get_capture_device: Device = 0x80000004
12-22 06:47:39.772 1457 3299 I Telecom : BluetoothRouteManager: Message received: GET_CURRENT_STATE.: CSW.sDc->ICTP.r->BRM.pM_400(cap)@DEg
12-22 06:47:39.773 923 2581 D sound_trigger_platform: platform_stdev_get_capture_device: Available device = 0x80000004
12-22 06:47:39.773 3197 3197 I Telephony: refreshCodec: Codec:0, Bitrate:0.0, Bandwidth:0.0
12-22 06:47:39.773 1457 5763 I Telecom : TelecomWakeLock: WakeLock already released with id: 26: CSW.sDc(cap)@DEg
12-22 06:47:39.773 923 2581 D sound_trigger_platform: platform_stdev_check_and_update_concurrency: dedicated path 0, reset backend 1, tx 0, rx 0, concurrency session allowed
12-22 06:47:39.774 1457 3301 I Telecom : CallAudioModeStateMachine: Message received: NO_MORE_ACTIVE_OR_DIALING_CALLS.: CSW.sDc->CAMSM.pM_1001(cap)@DEg
12-22 06:47:39.774 923 2581 D sound_trigger_platform: platform_stdev_get_capture_device: Device = 0x80000004
12-22 06:47:39.775 1457 7212 I Telecom : InCallTonePlayer: playMediaTone: toneResourceId=2131755009: CSW.sDc->ICTP.r(cap)@DEg
12-22 06:47:39.775 923 2581 D sound_trigger_platform: platform_stdev_get_capture_device: Available device = 0x80000004
12-22 06:47:39.775 1457 5763 I Telecom : InCallWakeLockController: Releasing full wake lock: CSW.sDc(cap)@DEg
12-22 06:47:39.775 3197 3197 V Telephony: MSG_PRECISE_CALL_STATE_CHANGED
12-22 06:47:39.776 923 2581 D voice : voice_stop_usecase: exit: status(0)
12-22 06:47:39.776 1457 3301 I Telecom : CallAudioModeStateMachine: Audio focus entering TONE/HOLDING state: CSW.sDc->CAMSM.pM_1001(cap)@DEg
12-22 06:47:39.777 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=11dc5000
12-22 06:47:39.777 1457 5763 I Telecom : InCallController: Sending updateCall [Call id=TC@5, state=DISCONNECTED, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[ hld sup_hld mut sup_trans], prop=[]]: CSW.sDc(cap)@DEg
12-22 06:47:39.777 923 2581 D audio_hw_hfp: hfp_set_parameters: enter
12-22 06:47:39.778 1457 3301 I MediaFocusControl: requestAudioFocus() from uid/pid 1000/1457 AA=USAGE_VOICE_COMMUNICATION/CONTENT_TYPE_SPEECH clientId=AudioFocus_For_Phone_Ring_And_Calls callingPack=com.android.server.telecom req=2 flags=0x4 sdk=0
12-22 06:47:39.778 923 2581 D audio_hw_extn: audio_extn_fm_set_parameters: Enter
12-22 06:47:39.778 1457 5763 I Telecom : InCallController: Components updated: [ComponentInfo{com.android.dialer/com.android.incallui.InCallServiceImpl}, ComponentInfo{com.android.bluetooth/com.android.bluetooth.telephony.BluetoothInCallService}]: CSW.sDc(cap)@DEg
12-22 06:47:39.779 2620 2620 I BluetoothInCallService: updateHeadsetWithCallState numActive 0, numHeld 0, callState 7, ringing type 128
12-22 06:47:39.781 2620 2620 D BluetoothInCallService: onCallRemoved
12-22 06:47:39.781 3157 3784 I QcrilOemhookMsgTunnel: [0]processOemHookIndication length=47
12-22 06:47:39.781 2620 2620 I BluetoothInCallService: updateHeadsetWithCallState numActive 0, numHeld 0, callState 6, ringing type 128
12-22 06:47:39.781 3846 4433 W MediaProvider: Failed to fetch original file descriptor
12-22 06:47:39.781 3846 4433 W MediaProvider: java.io.FileNotFoundException: Input file descriptor is already original
12-22 06:47:39.781 3846 4433 W MediaProvider: at com.android.providers.media.MediaProvider.getOriginalMediaFormatFileDescriptor(MediaProvider.java:5746)
12-22 06:47:39.781 3846 4433 W MediaProvider: at com.android.providers.media.MediaProvider.openTypedAssetFileCommon(MediaProvider.java:7162)
12-22 06:47:39.781 3846 4433 W MediaProvider: at com.android.providers.media.MediaProvider.openTypedAssetFile(MediaProvider.java:7143)
12-22 06:47:39.781 3846 4433 W MediaProvider: at android.content.ContentProvider$Transport.openTypedAssetFile(ContentProvider.java:548)
12-22 06:47:39.781 3846 4433 W MediaProvider: at android.content.ContentProviderNative.onTransact(ContentProviderNative.java:327)
12-22 06:47:39.781 3846 4433 W MediaProvider: at android.os.Binder.execTransactInternal(Binder.java:1184)
12-22 06:47:39.781 3846 4433 W MediaProvider: at android.os.Binder.execTransact(Binder.java:1143)
12-22 06:47:39.783 1254 4476 D NuPlayerDriver: NuPlayerDriver(0xed040dd0) created, clientPid(1457)
12-22 06:47:39.783 923 2025 D audio_hw_primary: adev_set_parameters: enter: A2dpSuspended=false
12-22 06:47:39.783 923 2025 D audio_hw_hfp: hfp_set_parameters: enter
12-22 06:47:39.783 1457 5763 I Telecom : PhoneStateBroadcaster: Broadcasted state change: 0: CSW.sDc(cap)@DEg
12-22 06:47:39.783 923 2025 D audio_hw_extn: audio_extn_fm_set_parameters: Enter
12-22 06:47:39.783 3157 3784 D QcRilAudio: setParameters with: vsid=297816064;call_state=1[slot1]
12-22 06:47:39.785 1457 1918 W BroadcastQueue: Permission Denial: receiving Intent { act=android.intent.action.PHONE_STATE flg=0x1000010 (has extras) } to ProcessRecord{e4da818 3079:com.android.systemui/u0a142} (pid=3079, uid=10142) requires android.permission.READ_CALL_LOG due to sender android (uid 1000)
12-22 06:47:39.785 923 2025 D audio_hw_primary: adev_set_parameters: enter: call_state=1;vsid=297816064
12-22 06:47:39.785 1457 1918 W BroadcastQueue: Permission Denial: receiving Intent { act=android.intent.action.PHONE_STATE flg=0x1000010 (has extras) } to ProcessRecord{e4da818 3079:com.android.systemui/u0a142} (pid=3079, uid=10142) requires android.permission.READ_CALL_LOG due to sender android (uid 1000)
12-22 06:47:39.785 923 2025 D voice_extn: update_call_states is_call_active:0 in_call:1, mode:2
12-22 06:47:39.786 923 2025 D voice_extn: update_calls: enter:
12-22 06:47:39.786 923 2025 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10c01000
12-22 06:47:39.787 923 2025 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10dc1000
12-22 06:47:39.787 923 2025 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10c02000
12-22 06:47:39.787 923 2025 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10803000
12-22 06:47:39.788 923 2025 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10002000
12-22 06:47:39.788 923 2025 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=11c05000
12-22 06:47:39.788 923 2025 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=11dc5000
12-22 06:47:39.789 923 2025 D audio_hw_hfp: hfp_set_parameters: enter
12-22 06:47:39.789 923 2025 D audio_hw_extn: audio_extn_fm_set_parameters: Enter
12-22 06:47:39.791 1254 7215 D GenericSource: FileSource remote
12-22 06:47:39.794 1457 5763 I Telecom : Event: RecordEntry TC@5: CONF_CALLS_CHANGED, : CSW.sCC(cap)@DEo
12-22 06:47:39.794 1457 5763 I Telecom : InCallController: Sending updateCall [Call id=TC@5, state=DISCONNECTED, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[ hld sup_hld mut sup_trans], prop=[]]: CSW.sCC(cap)@DEo
12-22 06:47:39.795 3157 3784 I QcrilOemhookMsgTunnel: [0]processOemHookIndication length=47
12-22 06:47:39.796 3157 3784 D QcRilAudio: setParameters with: vsid=297816064;call_state=1[slot1]
12-22 06:47:39.796 923 2581 D audio_hw_primary: adev_set_parameters: enter: call_state=1;vsid=297816064
12-22 06:47:39.797 923 2581 D voice_extn: update_call_states is_call_active:0 in_call:1, mode:2
12-22 06:47:39.797 923 2581 D voice_extn: update_calls: enter:
12-22 06:47:39.797 1457 5763 I Telecom : InCallController: Components updated: [ComponentInfo{com.android.dialer/com.android.incallui.InCallServiceImpl}, ComponentInfo{com.android.bluetooth/com.android.bluetooth.telephony.BluetoothInCallService}]: CSW.sCC(cap)@DEo
12-22 06:47:39.797 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10c01000
12-22 06:47:39.797 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10dc1000
12-22 06:47:39.800 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10c02000
12-22 06:47:39.800 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10803000
12-22 06:47:39.800 1457 3300 I Telecom : CallAudioRouteStateMachine: setSystemAudioState: changing from [AudioState isMuted: false, route: SPEAKER, supportedRouteMask: EARPIECE, SPEAKER, activeBluetoothDevice: [null], supportedBluetoothDevices: []] to [AudioState isMuted: false, route: SPEAKER, supportedRouteMask: EARPIECE, SPEAKER, activeBluetoothDevice: [null], supportedBluetoothDevices: []]: CSW.sDc->CARSM.pM_UPDATE_SYSTEM_AUDIO_ROUTE(cap)@DEg
12-22 06:47:39.801 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=10002000
12-22 06:47:39.801 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=11c05000
12-22 06:47:39.802 923 2581 D voice_extn: update_calls: cur_state=1 new_state=1 vsid=11dc5000
12-22 06:47:39.802 923 2581 D audio_hw_hfp: hfp_set_parameters: enter
12-22 06:47:39.803 1457 3300 I Telecom : InCallController: Calling onAudioStateChanged, audioState: [AudioState isMuted: false, route: SPEAKER, supportedRouteMask: EARPIECE, SPEAKER, activeBluetoothDevice: [null], supportedBluetoothDevices: []] -> [AudioState isMuted: false, route: SPEAKER, supportedRouteMask: EARPIECE, SPEAKER, activeBluetoothDevice: [null], supportedBluetoothDevices: []]: CSW.sDc->CARSM.pM_UPDATE_SYSTEM_AUDIO_ROUTE(cap)@DEg
12-22 06:47:39.803 923 2581 D audio_hw_extn: audio_extn_fm_set_parameters: Enter
12-22 06:47:39.804 1457 3300 I Telecom : CallAudioRouteStateMachine: Message received: SWITCH_FOCUS=4001, arg1=2: CSW.sDc->CAMSM.pM_1001->CARSM.pM_SWITCH_FOCUS(cap)@DEg
12-22 06:47:39.805 1457 3300 I Telecom : ActiveSpeakerRoute: Processing message SWITCH_FOCUS: CSW.sDc->CAMSM.pM_1001->CARSM.pM_SWITCH_FOCUS(cap)@DEg
12-22 06:47:39.805 3157 3784 I QcrilOemhookMsgTunnel: [0]processOemHookIndication length=47
12-22 06:47:39.807 1254 7214 I GenericSource: start
12-22 06:47:39.807 1457 1457 D MediaRouter: onRestoreRoute() : route=RouteInfo{ name=Telefono, description=null, status=null, category=RouteCategory{ name=Sistema types=ROUTE_TYPE_LIVE_AUDIO ROUTE_TYPE_LIVE_VIDEO groupable=false }, supportedTypes=ROUTE_TYPE_LIVE_AUDIO ROUTE_TYPE_LIVE_VIDEO , presentationDisplay=null }
12-22 06:47:39.807 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 9, connectionLabel:
12-22 06:47:39.807 1457 1457 V MediaRouter: Selecting route: RouteInfo{ name=Telefono, description=null, status=null, category=RouteCategory{ name=Sistema types=ROUTE_TYPE_LIVE_AUDIO ROUTE_TYPE_LIVE_VIDEO groupable=false }, supportedTypes=ROUTE_TYPE_LIVE_AUDIO ROUTE_TYPE_LIVE_VIDEO , presentationDisplay=null }
12-22 06:47:39.809 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:39.809 5234 5234 I Dialer : VideoPauseController.onStateChange - hasPrimaryCallChanged: false, videoCanPause: false, isInBackground: false
12-22 06:47:39.809 1457 3823 I Telecom : PhoneAccountRegistrar: getSimCallManager: SimCallManager for subId 1 queried, returning: null
12-22 06:47:39.811 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 9, connectionLabel:
12-22 06:47:39.812 1457 5763 I Telecom : Event: RecordEntry TC@5: CONF_CALLS_CHANGED, : CSW.sCC(cap)@DEs
12-22 06:47:39.812 1457 5763 I Telecom : InCallController: Sending updateCall [Call id=TC@5, state=DISCONNECTED, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[ hld sup_hld mut sup_trans], prop=[]]: CSW.sCC(cap)@DEs
12-22 06:47:39.813 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:39.813 1254 7219 D CCodec : allocate(c2.android.vorbis.decoder)
12-22 06:47:39.814 1457 5763 I Telecom : InCallController: Components updated: [ComponentInfo{com.android.dialer/com.android.incallui.InCallServiceImpl}, ComponentInfo{com.android.bluetooth/com.android.bluetooth.telephony.BluetoothInCallService}]: CSW.sCC(cap)@DEs
12-22 06:47:39.814 1325 2808 V C2Store : in init
12-22 06:47:39.814 1457 5763 I Telecom : CallsManager: markCallAsRemoved; callid=TC@5, immediate.: CSW.rC(cap)@DE4
12-22 06:47:39.814 1325 2808 V C2Store : loading dll
12-22 06:47:39.815 1457 1457 I Telecom : ConnectionServiceWrapper: Service unbound ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, from unbind.: CSW.rC->CM.pR(cap)@DE4
12-22 06:47:39.817 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:39.817 1457 1457 I Telecom : CallsManager: handleConnectionServiceDeath: service [ConnectionServiceWrapper componentName=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}] died: CSW.rC->CM.pR(cap)@DE4
12-22 06:47:39.818 1457 1457 I Telecom : Event: RecordEntry TC@5: DESTROYED, null: CSW.rC->CM.pR(cap)@DE4
12-22 06:47:39.819 1457 1457 I Telecom : ProximitySensorManager: All calls removed, resetting proximity sensor to default state: CSW.rC->CM.pR(cap)@DE4
12-22 06:47:39.819 1457 1457 I Telecom : TelecomWakeLock: WakeLock already released with id: 32: CSW.rC->CM.pR(cap)@DE4
12-22 06:47:39.819 1254 7219 I CCodec : Created component [c2.android.vorbis.decoder]
12-22 06:47:39.820 1457 1457 I Telecom : IncomingCallNotifier: updateIncomingCall: foundIncomingcall = null: CSW.rC->CM.pR(cap)@DE4
12-22 06:47:39.820 1254 7219 D CCodecConfig: read media type: audio/vorbis
12-22 06:47:39.821 1457 1457 W Telecom : CallDiagnosticServiceController: maybeUnbindCallScreeningService - already unbound: CSW.rC->CM.pR(cap)@DE4
12-22 06:47:39.822 1457 1457 I Telecom : TelecomWakeLock: WakeLock already released with id: 26: CSW.rC->CM.pR(cap)@DE4
12-22 06:47:39.823 1457 1457 I Telecom : InCallWakeLockController: Releasing full wake lock: CSW.rC->CM.pR(cap)@DE4
12-22 06:47:39.824 1457 1457 I Telecom : InCallController: onCallRemoved: [Call id=TC@5, state=DISCONNECTED, tpac=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, cmgr=ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, ***, UserHandle{0}, handle=tel:*90, vidst=A, childs(0), has_parent(false), cap=[ hld sup_hld mut sup_trans], prop=[]]: CSW.rC->CM.pR(cap)@DE4
12-22 06:47:39.824 1254 7219 D ReflectedParamUpdater: extent() != 1 for single value type: algo.buffers.max-count.values
12-22 06:47:39.825 1457 1457 I Telecom : InCallController: onSetCamera callId=TC@5, cameraId=null: CSW.rC->CM.pR(cap)@DE4
12-22 06:47:39.825 1254 7219 D ReflectedParamUpdater: extent() != 1 for single value type: output.subscribed-indices.values
12-22 06:47:39.825 1457 1457 D MediaSessionService: Global priority session is updated, active=false
12-22 06:47:39.826 1254 7219 D ReflectedParamUpdater: extent() != 1 for single value type: input.buffers.allocator-ids.values
12-22 06:47:39.826 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:39.826 5234 5234 I Dialer : DialerCallListenerImpl.onDialerCallDisconnect - [DialerCall_4, DISCONNECTED, [Capabilities: CAPABILITY_HOLD CAPABILITY_SUPPORT_HOLD CAPABILITY_MUTE CAPABILITY_TRANSFER], [Properties:], children:[], parent:null, conferenceable:[], videoState:Audio Only, mSessionModificationState:0, CameraDir:-1]
12-22 06:47:39.827 1254 7219 D ReflectedParamUpdater: extent() != 1 for single value type: output.buffers.allocator-ids.values
12-22 06:47:39.828 2620 2620 V MediaPlayerList: onActiveSessionsChanged: number of controllers: 0
12-22 06:47:39.829 1254 7219 D ReflectedParamUpdater: extent() != 1 for single value type: algo.buffers.allocator-ids.values
12-22 06:47:39.829 5234 5234 I Dialer : ReturnToCallController.hide - hide() called without calling show()
12-22 06:47:39.830 1254 7219 D ReflectedParamUpdater: extent() != 1 for single value type: output.buffers.pool-ids.values
12-22 06:47:39.830 1254 7219 D ReflectedParamUpdater: extent() != 1 for single value type: algo.buffers.pool-ids.values
12-22 06:47:39.833 1254 7219 I CCodecConfig: query failed after returning 7 values (BAD_INDEX)
12-22 06:47:39.834 1254 7219 D CCodecConfig: c2 config diff is Dict {
12-22 06:47:39.834 1254 7219 D CCodecConfig: c2::u32 coded.bitrate.value = 64000
12-22 06:47:39.834 1254 7219 D CCodecConfig: c2::u32 input.buffers.max-size.value = 32768
12-22 06:47:39.834 1254 7219 D CCodecConfig: c2::u32 input.delay.value = 0
12-22 06:47:39.834 1254 7219 D CCodecConfig: string input.media-type.value = "audio/vorbis"
12-22 06:47:39.834 1254 7219 D CCodecConfig: string output.media-type.value = "audio/raw"
12-22 06:47:39.834 1254 7219 D CCodecConfig: c2::u32 raw.channel-count.value = 1
12-22 06:47:39.834 1254 7219 D CCodecConfig: c2::u32 raw.sample-rate.value = 48000
12-22 06:47:39.834 1254 7219 D CCodecConfig: }
12-22 06:47:39.835 1254 7219 D CCodec : [c2.android.vorbis.decoder] buffers are bound to CCodec for this session
12-22 06:47:39.836 1254 7219 D CCodecConfig: no c2 equivalents for durationUs
12-22 06:47:39.836 5234 5234 I Dialer : InCallActivity.showDialogOrToastForDisconnectedCall - disconnect cause: DisconnectMessage {code: 2, description: , reason: LOCAL, message: null}
12-22 06:47:39.836 1254 7219 D CCodecConfig: no c2 equivalents for csd-1
12-22 06:47:39.836 5234 5234 I Dialer : InCallPresenter.onCallListChange - Phone switching state: INCALL -> INCALL
12-22 06:47:39.837 1254 7219 D CCodecConfig: no c2 equivalents for channel-mask
12-22 06:47:39.837 1254 7219 D CCodecConfig: no c2 equivalents for flags
12-22 06:47:39.841 1254 7219 D CCodecConfig: c2 config diff is c2::u32 coded.bitrate.value = 224000
12-22 06:47:39.841 1254 7219 D CCodecConfig: c2::u32 raw.channel-count.value = 2
12-22 06:47:39.843 1254 7219 W Codec2Client: query -- param skipped: index = 1107298332.
12-22 06:47:39.844 1254 7219 D CCodec : setup formats input: AMessage(what = 0x00000000) = {
12-22 06:47:39.844 1254 7219 D CCodec : int32_t bitrate = 224000
12-22 06:47:39.844 1254 7219 D CCodec : int32_t channel-count = 2
12-22 06:47:39.844 1254 7219 D CCodec : int32_t max-input-size = 32768
12-22 06:47:39.844 1254 7219 D CCodec : string mime = "audio/vorbis"
12-22 06:47:39.844 1254 7219 D CCodec : int32_t sample-rate = 48000
12-22 06:47:39.844 1254 7219 D CCodec : }
12-22 06:47:39.844 1254 7219 D CCodec : setup formats output: AMessage(what = 0x00000000) = {
12-22 06:47:39.844 1254 7219 D CCodec : int32_t channel-count = 2
12-22 06:47:39.844 1254 7219 D CCodec : string mime = "audio/raw"
12-22 06:47:39.844 1254 7219 D CCodec : int32_t sample-rate = 48000
12-22 06:47:39.844 1254 7219 D CCodec : int32_t channel-mask = 3
12-22 06:47:39.844 1254 7219 D CCodec : }
12-22 06:47:39.844 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 10, connectionLabel:
12-22 06:47:39.845 1254 7219 I CCodecConfig: query failed after returning 7 values (BAD_INDEX)
12-22 06:47:39.845 1254 7219 I MediaCodec: MediaCodec will operate in async mode
12-22 06:47:39.846 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:39.846 1254 7218 D MediaCodec: keep callback message for reclaim
12-22 06:47:39.846 5234 5234 I Dialer : VideoPauseController.onStateChange - hasPrimaryCallChanged: false, videoCanPause: false, isInBackground: false
12-22 06:47:39.847 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:39.847 1254 7219 W Codec2Client: query -- param skipped: index = 1342179345.
12-22 06:47:39.847 1254 7219 W Codec2Client: query -- param skipped: index = 2415921170.
12-22 06:47:39.848 5234 5234 I Dialer : DialerCall.setState - ignoring state transition from DISCONNECTED to DISCONNECTED. Duration would have changed from 14680 to 14710
12-22 06:47:39.849 1254 7219 D CCodecBufferChannel: [c2.android.vorbis.decoder#487] Created input block pool with allocatorID 16 => poolID 22 - OK (0)
12-22 06:47:39.849 1325 1412 D BufferPoolAccessor2.0: bufferpool2 0xb4000076b362f568 : 0(0 size) total buffers - 0(0 size) used buffers - 38/41 (recycle/alloc) - 3/40 (fetch/transfer)
12-22 06:47:39.850 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:39.850 1325 1412 D BufferPoolAccessor2.0: Destruction - bufferpool2 0xb4000076b362f568 cached: 0/0M, 0/0% in use; allocs: 41, 93% recycled; transfers: 40, 93% unfetched
12-22 06:47:39.850 5234 5234 I Dialer : CallList.onUpdateCall - [DialerCall_4, DISCONNECTED, [Capabilities: CAPABILITY_HOLD CAPABILITY_SUPPORT_HOLD CAPABILITY_MUTE CAPABILITY_TRANSFER], [Properties:], children:[], parent:null, conferenceable:[], videoState:Audio Only, mSessionModificationState:0, CameraDir:-1]
12-22 06:47:39.850 1254 2660 D BufferPoolAccessor2.0: bufferpool2 0xe90c3aa8 : 0(0 size) total buffers - 0(0 size) used buffers - 37/45 (recycle/alloc) - 8/86 (fetch/transfer)
12-22 06:47:39.850 1254 7219 I CCodecBufferChannel: [c2.android.vorbis.decoder#487] Created output block pool with allocatorID 16 => poolID 40 - OK
12-22 06:47:39.851 1254 2660 D BufferPoolAccessor2.0: Destruction - bufferpool2 0xe90c3aa8 cached: 0/0M, 0/0% in use; allocs: 45, 82% recycled; transfers: 86, 91% unfetched
12-22 06:47:39.851 5234 5234 I Dialer : ReturnToCallController.hide - hide() called without calling show()
12-22 06:47:39.851 1254 7219 D CCodecBufferChannel: [c2.android.vorbis.decoder#487] Configured output block pool ids 40 => OK
12-22 06:47:39.851 5234 5234 I Dialer : InCallPresenter.onCallListChange - Phone switching state: INCALL -> INCALL
12-22 06:47:39.853 1325 7221 D SimpleC2Component: Using output block pool with poolID 40 => got 40 - 0
12-22 06:47:39.855 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 10, connectionLabel:
12-22 06:47:39.856 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:39.857 5234 5234 I Dialer : VideoPauseController.onStateChange - hasPrimaryCallChanged: false, videoCanPause: false, isInBackground: false
12-22 06:47:39.858 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 10, connectionLabel:
12-22 06:47:39.859 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:39.860 5234 5234 W Dialer : CallList.onCallRemoved - Removing call not previously disconnected DialerCall_4
12-22 06:47:39.860 5234 5234 I Dialer : DialerCall.onRemovedFromCallList - enter
12-22 06:47:39.860 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:39.861 5234 5234 I Dialer : DialerCall.setState - ignoring state transition from DISCONNECTED to DISCONNECTED. Duration would have changed from 14680 to 14723
12-22 06:47:39.862 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:39.862 5234 5234 I Dialer : CallList.onUpdateCall - [DialerCall_4, DISCONNECTED, [Capabilities: CAPABILITY_HOLD CAPABILITY_SUPPORT_HOLD CAPABILITY_MUTE CAPABILITY_TRANSFER], [Properties:], children:[], parent:null, conferenceable:[], videoState:Audio Only, mSessionModificationState:0, CameraDir:-1]
12-22 06:47:39.863 5234 5234 I Dialer : ReturnToCallController.hide - hide() called without calling show()
12-22 06:47:39.864 5234 5234 I Dialer : InCallPresenter.onCallListChange - Phone switching state: INCALL -> INCALL
12-22 06:47:39.867 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 10, connectionLabel:
12-22 06:47:39.869 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:39.870 5234 5234 I Dialer : VideoPauseController.onStateChange - hasPrimaryCallChanged: false, videoCanPause: false, isInBackground: false
12-22 06:47:39.871 1001 3151 I AudioFlinger: openOutput() this 0xb40000728b7930a0, module 10 Device type:0x2,@:, SamplingRate 48000, Format 0x000001, Channels 0x3, flags 0x8001
12-22 06:47:39.872 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 10, connectionLabel:
12-22 06:47:39.872 923 2581 D audio_hw_primary: adev_open_output_stream: enter: format(0x1) sample_rate(48000) channel_mask(0x3) devices(0x2) flags(0x8001) stream_handle(0xf0fd7140) address()
12-22 06:47:39.872 923 2581 I audio_hw_utils: audio_extn_utils_update_stream_output_app_type_cfg Allowing 24 and above bits playback on speaker ONLY at default sampling rate
12-22 06:47:39.873 923 2581 D audio_hw_primary: adev_open_output_stream: Stream (0xf0fd7140) picks up usecase (audio-playback-voip)
12-22 06:47:39.873 923 2581 D audio_hw_primary: io_streams_map_insert: Added stream in io_streams_map with handle 109
12-22 06:47:39.874 1001 3151 I AudioFlinger: HAL output buffer size 960 frames, normal sink buffer size 960 frames
12-22 06:47:39.874 1001 3151 D AudioFlinger: Failed to add event callback
12-22 06:47:39.874 1001 7224 I AudioFlinger: AudioFlinger's thread 0xb40000733b79e030 tid=7224 ready to run
12-22 06:47:39.875 1001 7224 D AudioFlinger: ro.audio.silent is ignored since no output device is set
12-22 06:47:39.876 923 2581 D audio_hw_primary: out_standby: enter: stream (0xf0fd7140) usecase(33: audio-playback-voip)
12-22 06:47:39.876 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:39.876 923 2581 D audio_hw_primary: out_standby: exit
12-22 06:47:39.877 5234 5234 W Dialer : CallList.onCallRemoved - Removing call not previously disconnected DialerCall_4
12-22 06:47:39.877 5234 5234 I Dialer : DialerCall.onRemovedFromCallList - enter
12-22 06:47:39.878 5234 5234 W Dialer : CallList.onCallRemoved - Removing call not previously disconnected DialerCall_4
12-22 06:47:39.878 5234 5234 I Dialer : DialerCall.onRemovedFromCallList - enter
12-22 06:47:39.878 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:39.878 1001 7224 D AudioFlinger: ro.audio.silent is ignored since no output device is set
12-22 06:47:39.879 5234 5234 I Dialer : DialerCall.setState - ignoring state transition from DISCONNECTED to DISCONNECTED. Duration would have changed from 14680 to 14741
12-22 06:47:39.880 5234 5234 I Dialer : ImsVideoCall.isAvailable - null video call
12-22 06:47:39.880 5234 5234 I Dialer : CallList.onUpdateCall - [DialerCall_4, DISCONNECTED, [Capabilities: CAPABILITY_HOLD CAPABILITY_SUPPORT_HOLD CAPABILITY_MUTE CAPABILITY_TRANSFER], [Properties:], children:[], parent:null, conferenceable:[], videoState:Audio Only, mSessionModificationState:0, CameraDir:-1]
12-22 06:47:39.881 5234 5234 I Dialer : ReturnToCallController.hide - hide() called without calling show()
12-22 06:47:39.881 5234 5234 I Dialer : InCallPresenter.onCallListChange - Phone switching state: INCALL -> INCALL
12-22 06:47:39.884 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 10, connectionLabel:
12-22 06:47:39.885 1001 3151 D AudioFlinger: Client defaulted notificationFrames to 12000 for frameCount 24000
12-22 06:47:39.886 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:39.887 5234 5234 I Dialer : VideoPauseController.onStateChange - hasPrimaryCallChanged: false, videoCanPause: false, isInBackground: false
12-22 06:47:39.887 1001 3151 D AF::TrackHandle: OpPlayAudio: track:82 usage:2 not muted
12-22 06:47:39.889 5234 5234 I Dialer : InCallFragment.setCallState - PrimaryCallState, state: 10, connectionLabel:
12-22 06:47:39.890 5234 5234 I Dialer : InCallActivity.showMainInCallFragment - shouldShowAnswerUi: false, shouldShowRttUi: false, shouldShowVideoUi: false, shouldShowSpeakEasyUi: false, didShowAnswerScreen: false, didShowInCallScreen: true, didShowRttCallScreen: false, didShowVideoCallScreen: false, didShowSpeakEasyScreen: false
12-22 06:47:39.890 5234 5234 W Dialer : CallList.onCallRemoved - Removing call not previously disconnected DialerCall_4
12-22 06:47:39.890 5234 5234 I Dialer : DialerCall.onRemovedFromCallList - enter
12-22 06:47:39.891 5234 5234 W Dialer : CallList.onCallRemoved - Removing call not previously disconnected DialerCall_4
12-22 06:47:39.891 5234 5234 I Dialer : DialerCall.onRemovedFromCallList - enter
12-22 06:47:39.894 923 954 I EffectsFactory: EffectCreate() create_effect
12-22 06:47:39.918 923 954 W msm8974_platform: platform_send_gain_dep_cal: Voice call in progress .. ignore setting new cal
12-22 06:47:39.919 923 954 E volume_listener: check_and_set_gain_dep_cal: Failed to set gain dep cal level
12-22 06:47:39.919 923 954 D audio_hw_primary: adev_create_audio_patch: enter: num sources 1, num_sinks 1, handle 0
12-22 06:47:39.920 923 954 D audio_hw_primary: adev_create_audio_patch: Playback patch from mix handle 109 to device 2
12-22 06:47:39.920 923 954 D audio_hw_primary: update_patch: enter
12-22 06:47:39.920 923 954 D audio_hw_primary: route_output_stream: enter: usecase(33: audio-playback-voip) devices 2
12-22 06:47:39.920 923 954 D audio_hw_primary: adev_create_audio_patch: Added a new patch with handle 9
12-22 06:47:39.935 5234 5250 W System : A resource failed to call close.
12-22 06:47:39.937 5234 5250 W System : A resource failed to call close.
12-22 06:47:39.938 5234 5250 W System : A resource failed to call close.
12-22 06:47:39.940 5234 5250 W System : A resource failed to call close.
12-22 06:47:39.965 923 954 D audio_hw_primary: out_set_volume: called with left_vol=0.409040, right_vol=0.409040
12-22 06:47:39.966 923 954 W msm8974_platform: platform_send_gain_dep_cal: Voice call in progress .. ignore setting new cal
12-22 06:47:39.967 923 954 E volume_listener: check_and_set_gain_dep_cal: Failed to set gain dep cal level
12-22 06:47:39.967 923 954 D audio_hw_primary: out_set_volume: called with left_vol=0.409040, right_vol=0.409040
12-22 06:47:39.969 923 7227 D audio_hw_primary: start_output_stream: enter: stream(0xf0fd7140)usecase(33: audio-playback-voip) devices(0x2) is_haptic_usecase(0)
12-22 06:47:39.969 672 672 I libperfmgr: Hint type not present in actions: AUDIO_LAUNCH
12-22 06:47:39.970 923 7227 D audio_hw_primary: select_devices for use case (audio-playback-voip)
12-22 06:47:39.970 923 7227 D audio_hw_primary: select_devices: changing use case audio-playback-voip output device from(25: voice-handset, acdb 7) to (26: voice-speaker, acdb 14)
12-22 06:47:39.970 923 7227 I msm8974_platform: platform_check_and_set_codec_backend_cfg:becf: afe: bitwidth 16, samplerate 48000 channels 2, backend_idx 0 usecase = 33 device (voice-speaker)
12-22 06:47:39.971 923 7227 D msm8974_platform: platform_split_snd_device: snd_device(26) num devices(1) new_snd_devices(0)
12-22 06:47:39.971 923 7227 I msm8974_platform: platform_check_and_set_codec_backend_cfg: new_snd_devices[0] is 26
12-22 06:47:39.971 923 7227 I msm8974_platform: platform_check_codec_backend_cfg:becf: afe: bitwidth 16, samplerate 48000 channels 2, backend_idx 0 usecase = 33 device (voice-speaker)
12-22 06:47:39.972 923 7227 W msm8974_platform: platform_check_codec_backend_cfg:becf: afe:Use default bw and sr for voice/voip calls
12-22 06:47:39.972 923 7227 D msm8974_platform: platform_check_codec_backend_cfg:becf: afe: playback on codec device not supporting native playback set default Sample Rate(48k)
12-22 06:47:39.972 923 7227 I msm8974_platform: platform_check_codec_backend_cfg:becf: afe: Codec selected backend: 0 updated bit width: 16 and sample rate: 48000
12-22 06:47:39.972 923 7227 D audio_hw_primary: check_usecases_codec_backend:becf: force routing 0
12-22 06:47:39.973 923 7227 D audio_hw_primary: check_usecases_codec_backend:becf: (78) check_usecases curr device: voice-speaker, usecase device:voice-speaker backends match 1
12-22 06:47:39.973 923 7227 E msm8974_platform: platform_check_backends_match: Invalid snd_device =
12-22 06:47:39.973 923 7227 D audio_hw_primary: check_usecases_codec_backend:becf: (78) check_usecases curr device: voice-speaker, usecase device: backends match 0
12-22 06:47:39.974 923 7227 D audio_hw_primary: check_usecases_codec_backend:becf: check_usecases num.of Usecases to switch 0
12-22 06:47:39.974 923 7227 D hardware_info: hw_info_append_hw_type : device_name = voice-speaker
12-22 06:47:39.974 923 7227 D msm8974_platform: platform_split_snd_device: snd_device(26) num devices(0) new_snd_devices(0)
12-22 06:47:39.974 923 7227 I audio_hw_utils: audio_extn_utils_update_stream_output_app_type_cfg Allowing 24 and above bits playback on speaker ONLY at default sampling rate
12-22 06:47:39.975 923 7227 E soundtrigger: audio_extn_sound_trigger_update_stream_status: invalid input device 0x0, for event 3
12-22 06:47:39.976 923 7227 D soundtrigger: audio_extn_sound_trigger_update_stream_status: uc_info->id 33 of type 0 for Event 3, with Raise=0
12-22 06:47:39.976 923 7227 D audio_hw_utils: audio_extn_utils_send_app_type_cfg: usecase->out_snd_device voice-speaker
12-22 06:47:39.977 923 7227 D msm8974_platform: platform_split_snd_device: snd_device(26) num devices(0) new_snd_devices(0)
12-22 06:47:39.978 923 7227 D audio_hw_utils: audio_extn_btsco_get_sample_rate:Not a BT SCO device, need not update sampling rate
12-22 06:47:39.978 923 7227 I audio_hw_utils: send_app_type_cfg_for_device PLAYBACK app_type 69946, acdb_dev_id 14, sample_rate 48000, snd_device_be_idx 45
12-22 06:47:39.982 923 7227 D msm8974_platform: platform_split_snd_device: snd_device(26) num devices(1) new_snd_devices(0)
12-22 06:47:39.982 923 7227 D audio_hw_utils: audio_extn_btsco_get_sample_rate:Not a BT SCO device, need not update sampling rate
12-22 06:47:39.983 923 7227 D ACDB-LOADER: ACDB -> send_audio_cal, acdb_id = 14, path = 0, app id = 0x1113a, sample rate = 48000, afe_sample_rate = 48000
12-22 06:47:39.983 923 7227 D ACDB-LOADER: ACDB -> send_asm_topology
12-22 06:47:39.983 923 7227 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_STREAM_TOPOLOGY_ID
12-22 06:47:39.984 923 7227 D ACDB-LOADER: ACDB -> send_adm_topology
12-22 06:47:39.984 923 7227 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_COMMON_TOPOLOGY_ID
12-22 06:47:39.984 923 7227 D ACDB-LOADER: ACDB -> send_audtable
12-22 06:47:39.984 923 7227 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_INSTANCE_COMMON_TABLE_SIZE
12-22 06:47:39.985 923 7227 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_INSTANCE_COMMON_TABLE
12-22 06:47:39.985 923 7227 D ACDB-LOADER: ACDB -> AUDIO_SET_AUDPROC_CAL cal_type[11] acdb_id[14] app_type[69946]
12-22 06:47:39.985 923 7227 D ACDB-LOADER: ACDB -> send_audvoltable
12-22 06:47:39.986 923 7227 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_INSTANCE_GAIN_DEP_STEP_TABLE_SIZE
12-22 06:47:39.986 923 7227 D android.hardware.audio.service: Failed to fetch the lookup information of the device 0000000E
12-22 06:47:39.986 923 7227 D ACDB-LOADER: Error: ACDB_CMD_GET_AUDPROC_INSTANCE_GAIN_DEP_STEP_TABLE_SIZE Returned = -19
12-22 06:47:39.987 923 7227 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_INSTANCE_GAIN_DEP_STEP_TABLE, vol index 0
12-22 06:47:39.987 923 7227 D android.hardware.audio.service: Failed to fetch the lookup information of the device 0000000E
12-22 06:47:39.987 923 7227 D ACDB-LOADER: Error: ACDB AudProc vol returned = -19
12-22 06:47:39.987 923 7227 D ACDB-LOADER: ACDB -> AUDIO_SET_VOL_CAL cal type = 12
12-22 06:47:39.988 923 7227 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_INSTANCE_STREAM_TABLE_SIZE
12-22 06:47:39.988 923 7227 D ACDB-LOADER: ACDB -> send_audstrmtable
12-22 06:47:39.988 923 7227 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_INSTANCE_STREAM_TABLE
12-22 06:47:39.989 923 7227 D ACDB-LOADER: ACDB -> audstrm_cal->cal_type.cal_data.cal_size = 20
12-22 06:47:39.989 923 7227 D ACDB-LOADER: ACDB -> send_afe_topology
12-22 06:47:39.989 923 7227 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_TOPOLOGY_ID
12-22 06:47:39.989 923 7227 D ACDB-LOADER: ACDB -> GET_AFE_TOPOLOGY_ID for adcd_id 14, Topology Id 112fc
12-22 06:47:39.990 923 7227 D ACDB-LOADER: ACDB -> send_afe_cal
12-22 06:47:39.990 923 7227 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_INSTANCE_COMMON_TABLE_SIZE
12-22 06:47:39.990 923 7227 D android.hardware.audio.service: Failed to fetch the lookup information of the device 0000000E
12-22 06:47:39.991 923 7227 D ACDB-LOADER: Error: ACDB_CMD_GET_AFE_INSTANCE_COMMON_TABLE_SIZE Returned = -19
12-22 06:47:39.991 923 7227 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_INSTANCE_COMMON_TABLE
12-22 06:47:39.991 923 7227 D android.hardware.audio.service: Failed to fetch the lookup information of the device 0000000E
12-22 06:47:39.992 923 7227 D ACDB-LOADER: Error: ACDB AFE returned = -19
12-22 06:47:39.992 923 7227 D ACDB-LOADER: ACDB -> AUDIO_SET_AFE_CAL cal_type[16] acdb_id[14]
12-22 06:47:39.992 923 7227 D ACDB-LOADER: ACDB -> send_hw_delay : acdb_id = 14 path = 0
12-22 06:47:39.992 923 7227 D ACDB-LOADER: ACDB -> ACDB_AVSYNC_INFO: ACDB_CMD_GET_DEVICE_PROPERTY
12-22 06:47:39.993 923 7227 D msm8974_platform: platform_split_snd_device: snd_device(26) num devices(0) new_snd_devices(0)
12-22 06:47:39.993 923 7227 I msm8974_platform: platform_get_custom_mtmx_params: no matching param with id 0 ip_ch 2 op_ch 2 uc_id 33 snd_dev 26
12-22 06:47:39.993 923 7227 D audio_hw_primary: enable_audio_route: apply mixer and update path: audio-playback-voip
12-22 06:47:39.994 923 7227 D audio_route: Apply path: audio-playback-voip
12-22 06:47:39.996 923 7227 D audio_hw_primary: select_devices: done
Relevant screenshots
Solutions
Workaround
use main speaker
Possible fixes
nothing
Edited by Claudio Melis