AttributeError: 'builtin_function_or_method' object has no attribute 'acquire'

本文分享了一个关于Python多线程编程中常见的错误案例。作者在使用锁机制时因忽略了一个小括号导致程序报错,错误信息提示'builtin_function_or_method'对象没有'acquire'属性。通过检查,作者发现是在声明锁机制时漏写了括号,正确的声明方式应该是使用threading.Lock()。
部署运行你感兴趣的模型镜像

今天再写写python多线程程序的时候出现了报错:

File "C:/Py/python/demo.py", line 26, in run
    gLock.acquire()
AttributeError: 'builtin_function_or_method' object has no attribute 'acquire'

经过检查发现是再申明锁机制的时候漏了括号

gMoney = 1000
gLock = threading.Lock    #此处括号漏写

正确的程序:

gMoney = 1000
gLock = threading.Lock()

您可能感兴趣的与本文相关的镜像

Python3.9

Python3.9

Conda
Python

Python 是一种高级、解释型、通用的编程语言,以其简洁易读的语法而闻名,适用于广泛的应用,包括Web开发、数据分析、人工智能和自动化脚本

07-31 15:21:10.283883 3320 4205 I AS.BtHelper: In disconnectBluetoothScoAudioHelper(), scoAudioMode: 0, bluetoothHeadset: android.bluetooth.BluetoothHeadset@7e98cca, BluetoothDevice: XX:XX:XX:XX:C3:B4 07-31 15:21:10.283900 3320 4205 I AS.BtHelper: In disconnectBluetoothScoAudioHelper(), calling stopScoUsingVirtualVoiceCall() 07-31 15:21:10.286178 11925 11939 I HeadsetService: stopScoUsingVirtualVoiceCall: uid/pid=1000/3320 07-31 15:21:10.286295 11925 11939 I HeadsetService: stopScoUsingVirtualVoiceCall: audio is active, should to deactivate 07-31 15:21:10.286593 11925 11939 D HeadsetService: numActive=0, numHeld=0, callState=6, number=, type =0, isVirtual=true 07-31 15:21:10.286983 11925 11939 D HeadsetService: send idle call state to connected device : 84:**:**:**:C3:B4 07-31 15:21:10.287345 11925 12068 D HeadsetStateMachine: handleMessage: E msg.what=9 07-31 15:21:10.287463 11925 12068 D HeadsetStateMachine: processMsg: AudioOn 07-31 15:21:10.287556 11925 12068 D HeadsetStateMachine: AudioOn: currentDevice=XX:XX:XX:XX:C3:B4, msg=processMessage:9 07-31 15:21:10.287663 11925 12068 D OplusHeadsetStateMachine: CallState.mCallState = 6 07-31 15:21:10.287887 11925 12068 D bt_device_interop: [interop_oplus.cc:613] interop_oplus_match_addr:[OplusHfpSlcScoDelta0] check 84:**:**:**:c3:b4 return 0 07-31 15:21:10.288007 11925 12068 D bt_device_interop: [interop_oplus.cc:625] interop_oplus_match_name_impl:[OplusHfpSlcScoDelta0] check realme Buds Air6 Pro return 0 07-31 15:21:10.288119 11925 12068 D bt_device_interop: [interop_oplus.cc:802] interop_oplus_match_ver:[OplusHfpSlcScoDelta0] check 84:**:**:**:c3:b4 return 0 07-31 15:21:10.288208 11925 12068 D bt_device_interop: [interop_oplus.cc:639] interop_oplus_match_both_name_and_addr_impl:[OplusHfpSlcScoDelta0] check realme Buds Air6 Pro-84:**:**:**:c3:b4 return 0 07-31 15:21:10.288296 11925 12068 D bt_device_interop: [interop_oplus.cc:665] interop_oplus_match_both_name_addr_and_ver_impl:[OplusHfpSlcScoDelta0] check realme Buds Air6 Pro-84:**:**:**:c3:b4-0c:02b0:0115 return 0 07-31 15:21:10.288495 11925 12068 D bt_device_interop: [interop_oplus.cc:613] interop_oplus_match_addr:[OplusHfpDelayOpenSco] check 84:**:**:**:c3:b4 return 0 07-31 15:21:10.288989 11925 12068 D bt_device_interop: [interop_oplus.cc:625] interop_oplus_match_name_impl:[OplusHfpDelayOpenSco] check realme Buds Air6 Pro return 0 07-31 15:21:10.289058 11925 12068 D bt_device_interop: [interop_oplus.cc:802] interop_oplus_match_ver:[OplusHfpDelayOpenSco] check 84:**:**:**:c3:b4 return 0 07-31 15:21:10.289112 11925 12068 D bt_device_interop: [interop_oplus.cc:639] interop_oplus_match_both_name_and_addr_impl:[OplusHfpDelayOpenSco] check realme Buds Air6 Pro-84:**:**:**:c3:b4 return 0 07-31 15:21:10.289165 11925 12068 D bt_device_interop: [interop_oplus.cc:665] interop_oplus_match_both_name_addr_and_ver_impl:[OplusHfpDelayOpenSco] check realme Buds Air6 Pro-84:**:**:**:c3:b4-0c:02b0:0115 return 0 07-31 15:21:10.289219 11925 12068 D bt_btif_hf: [btif_hf.cc:1608] PhoneStateChange: bd_addr:xx:xx:xx:xx:c3:b4 active_bda:xx:xx:xx:xx:c3:b4 num_active:0 prev_num_active:1 num_held:0 prev_num_held:0 call_state:BTHF_CALL_STATE_IDLE prev_call_state:BTHF_CALL_STATE_IDLE 07-31 15:21:10.289269 11925 12068 D bt_device_interop: [interop_oplus.cc:613] interop_oplus_match_addr:[OplusHfpNoReportCiev72] check 84:**:**:**:c3:b4 return 0 07-31 15:21:10.289295 11925 12068 D bt_device_interop: [interop_oplus.cc:625] interop_oplus_match_name_impl:[OplusHfpNoReportCiev72] check realme Buds Air6 Pro return 0 07-31 15:21:10.289350 11925 12068 D bt_device_interop: [interop_oplus.cc:802] interop_oplus_match_ver:[OplusHfpNoReportCiev72] check 84:**:**:**:c3:b4 return 0 07-31 15:21:10.289395 11925 12068 D bt_device_interop: [interop_oplus.cc:639] interop_oplus_match_both_name_and_addr_impl:[OplusHfpNoReportCiev72] check realme Buds Air6 Pro-84:**:**:**:c3:b4 return 0 07-31 15:21:10.289450 11925 12068 D bt_device_interop: [interop_oplus.cc:665] interop_oplus_match_both_name_addr_and_ver_impl:[OplusHfpNoReportCiev72] check realme Buds Air6 Pro-84:**:**:**:c3:b4-0c:02b0:0115 return 0 07-31 15:21:10.289473 11925 12068 D bt_btif_hf: [btif_hf.cc:1644] state change mark sco_disc_time = 539732995 07-31 15:21:10.290275 11925 12068 D HeadsetStateMachine: handleMessage: X 07-31 15:21:10.290348 11925 11954 D bluetooth: [bta_ag_main.cc:563] bta_ag_api_result: Audio gateway event for one client handle:2 scb:codec_updated=0, codec_fallback=0, nrec=0sco_codec=2, peer_codec=3, msbc_settings=0, lc3_settings=0, device=xx:xx:xx:xx:c3:b4 07-31 15:21:10.290416 11925 11954 D bluetooth: [bta_ag_main.cc:811] bta_ag_sm_execute: Execute AG event handle:0x0002 bd_addr:xx:xx:xx:xx:c3:b4 state:BTA_AG_OPEN_ST(0x2)[0x02] event:BTA_AG_API_RESULT_EVT[0x0506] result:BTA_AG_END_CALL_RES[0x12] 07-31 15:21:10.290452 11925 11954 D bta_ag_cmd: [bta_ag_cmd.cc:1909] bta_ag_hfp_result: HFP connection result:result:BTA_AG_END_CALL_RES 07-31 15:21:10.290510 11925 11954 I bluetooth: [bta_ag_sco.cc:964] bta_ag_sco_event: device:xx:xx:xx:xx:c3:b4 index:0x0000 state:BTA_AG_SCO_OPEN_ST[6] event:BTA_AG_SCO_CLOSE_E[5] p_scb:0x77e5ed2e10 curr_scb:0x77e5ed2e10 07-31 15:21:10.290550 11925 11954 D bt_bta_dm: [bta_dm_act.cc:1086] bta_dm_rm_cback: BTA Role management callback count:2 status:BTA_SYS_CONN_BUSY peer:xx:xx:xx:xx:c3:b4 07-31 15:21:10.290683 11925 11954 D bt_device_interop: [interop_oplus.cc:613] interop_oplus_match_addr:[OplusGapNotDoSniffSubrating] check 84:**:**:**:c3:b4 return 0 07-31 15:21:10.290701 11925 11954 D bt_device_interop: [interop_oplus.cc:625] interop_oplus_match_name_impl:[OplusGapNotDoSniffSubrating] check realme Buds Air6 Pro return 0 07-31 15:21:10.290725 11925 11954 D bt_device_interop: [interop_oplus.cc:802] interop_oplus_match_ver:[OplusGapNotDoSniffSubrating] check 84:**:**:**:c3:b4 return 0 07-31 15:21:10.290745 11925 11954 D bt_device_interop: [interop_oplus.cc:639] interop_oplus_match_both_name_and_addr_impl:[OplusGapNotDoSniffSubrating] check realme Buds Air6 Pro-84:**:**:**:c3:b4 return 0 07-31 15:21:10.290763 11925 11954 D bt_device_interop: [interop_oplus.cc:665] interop_oplus_match_both_name_addr_and_ver_impl:[OplusGapNotDoSniffSubrating] check realme Buds Air6 Pro-84:**:**:**:c3:b4-0c:02b0:0115 return 0 07-31 15:21:10.290802 11925 11954 D bt_btm_pm: [btm_pm.cc:258] BTM_SetPowerMode: Device is already in requested mode 0, interval: 0, max: 0, min: 0 07-31 15:21:10.290817 11925 11954 D bluetooth: [bta_dm_pm.cc:1081] bta_dm_pm_active: Active power mode already set for device:xx:xx:xx:xx:c3:b4 07-31 15:21:10.290911 11925 11954 D bt_shim_hci: [hci_layer.cc:231] transmit_command: Sending command DISCONNECT(0x0406) 07-31 15:21:10.290979 11925 11954 D btm_sco : [btm_sco.cc:1339] BTM_RemoveSco: Disconnecting link sco_handle:0x0006 peer:xx:xx:xx:xx:c3:b4 07-31 15:21:10.290997 11925 11954 D bluetooth: [bta_ag_sco.cc:409] bta_ag_remove_sco: Removed SCO index:0x0000 status:BTM_CMD_STARTED 07-31 15:21:10.291013 11925 11954 I oplus_bt_stack_hfp_event: [oplus_bt_stack_hfp_event.cc:1403] record_hfp_sco_event: index=0x0, device=xx:xx:xx:xx:c3:b4, pre_state=OPLUS_SCO_OPEN_ST[6], new_state=OPLUS_SCO_CLOSING_ST[7], event=OPLUS_SCO_CLOSE_E[5] 07-31 15:21:10.291022 11925 11954 W bluetooth: [bta_ag_sco.cc:1501] bta_ag_sco_event: SCO_state_change: [BTA_AG_SCO_OPEN_ST(0x06)]->[BTA_AG_SCO_CLOSING_ST(0x07)] after event [BTA_AG_SCO_CLOSE_E(0x05)] 07-31 15:21:10.291029 11925 11954 I bta_ag_cmd: [bta_ag_cmd.cc:2106] bta_ag_hfp_result: BTM_unblock_sniff_mode_for 07-31 15:21:10.291046 11925 11954 D btm_acl : [btm_acl.cc:962] BTM_unblock_sniff_mode_for 07-31 15:21:10.291052 11925 11954 D btm_acl : [btm_acl.cc:906] btm_set_link_policy 07-31 15:21:10.291086 11925 11954 D bt_device_interop: [interop_oplus.cc:613] interop_oplus_match_addr:[OplusRoleSwitchPolicyBlacklist] check 84:**:**:**:c3:b4 return 0 07-31 15:21:10.291099 11925 11954 D bt_device_interop: [interop_oplus.cc:625] interop_oplus_match_name_impl:[OplusRoleSwitchPolicyBlacklist] check realme Buds Air6 Pro return 0 07-31 15:21:10.291116 11925 11954 D bt_device_interop: [interop_oplus.cc:802] interop_oplus_match_ver:[OplusRoleSwitchPolicyBlacklist] check 84:**:**:**:c3:b4 return 0 07-31 15:21:10.291138 11925 11954 D bt_device_interop: [interop_oplus.cc:639] interop_oplus_match_both_name_and_addr_impl:[OplusRoleSwitchPolicyBlacklist] check realme Buds Air6 Pro-84:**:**:**:c3:b4 return 0 07-31 15:21:10.291156 11925 11954 D bt_device_interop: [interop_oplus.cc:665] interop_oplus_match_both_name_addr_and_ver_impl:[OplusRoleSwitchPolicyBlacklist] check realme Buds Air6 Pro-84:**:**:**:c3:b4-0c:02b0:0115 return 0 07-31 15:21:10.291170 11925 11954 D bt_shim_hci: [hci_layer.cc:231] transmit_command: Sending command WRITE_LINK_POLICY_SETTINGS(0x080d) 07-31 15:21:10.291431 1748 1748 D vendor.qti.bluetooth@1.1-ibs_handler: SerialClockVote: vote for UART CLK ON 07-31 15:21:10.292343 1748 1748 E vendor.qti.bluetooth@1.1-wake_lock: Acquire write to wakelock file failed -1 - Operation not permitted 07-31 15:21:10.292366 1748 1748 I vendor.qti.bluetooth@1.1-ibs_handler: DeviceWakeUp: Writing IBS_WAKE_IND 07-31 15:21:10.293075 3320 4205 D AudioDeviceBrokerExtImpl: MM_FB_Event_Ostatsd#20007# clear info MM_FB_EventID#20007#Packagename#com.tencent.mm#Device#7#Time#26663 07-31 15:21:10.294158 2046 16191 D APM_AudioPolicyManager: setForceUse() usage 7, config 0, mPhoneState 0 07-31 15:21:10.295121 2046 2615 D AudioPolicyManagerExtImpl: setParameters spatializer_enable=off 07-31 15:21:10.295158 2046 2615 D AudioPolicyManagerExtImpl: set spatializer_enable off 07-31 15:21:10.295475 1748 11969 I vendor.qti.bluetooth@1.1-ibs_handler: ProcessIbsCmd: Received IBS_WAKE_ACK: 0xFC 07-31 15:21:10.295488 1748 11969 I vendor.qti.bluetooth@1.1-ibs_handler: ProcessIbsCmd: Signal wack_cond_ 07-31 15:21:10.295591 1748 1748 D vendor.qti.bluetooth@1.1-ibs_handler: DeviceWakeUp: Unblocked from waiting for FC, pthread_cond_timedwait ret = 0 07-31 15:21:10.297283 1748 11969 I vendor.qti.bluetooth@1.1-ibs_handler: ProcessIbsCmd: Received IBS_WAKE_IND: 0xFD 07-31 15:21:10.297447 1748 11969 I vendor.qti.bluetooth@1.1-ibs_handler: ProcessIbsCmd: Writing IBS_WAKE_ACK 07-31 15:21:10.305801 11925 11959 D bt_shim_hci: [hci_layer.cc:201] OnTransmitPacketStatus: Received cmd status SUCCESS(0x00) for DISCONNECT(0x0406) 07-31 15:21:10.306044 11925 11954 E bt_btu_hcif: [btu_hcif.cc:1275] btu_hcif_hdl_command_status: Command status for opcode:0x406 should not be handled here status:HCI_SUCCESS 07-31 15:21:10.309699 11925 11959 D bt_shim_hci: [hci_layer.cc:192] OnTransmitPacketCommandComplete: Received cmd complete for WRITE_LINK_POLICY_SETTINGS(0x080d) 07-31 15:21:10.310103 11925 11954 E bt_btu_hcif: [btu_hcif.cc:1096] btu_hcif_hdl_command_complete: Command complete for opcode:0x80d should not be handled here 07-31 15:21:10.333694 11925 11959 E oplus_bt_stack_hci_monitor: [oplus_bt_stack_hci_monitor.cc:977] oplus_hcif_event_metrics p_lcb == NULL 07-31 15:21:10.333860 11925 11954 I bt_shim_hci: [hci_layer.cc:315] operator(): ISO disconnection from GD, handle: 0x06, reason: 0x16 07-31 15:21:10.333903 11925 11954 D bluetooth: [bta_ag_sco.cc:246] bta_ag_sco_disc_cback: sco_idx: 0x0 sco.state:SCO_ST_PEND_ROLECHANGE 07-31 15:21:10.333933 11925 11954 D bluetooth: [bta_ag_sco.cc:248] bta_ag_sco_disc_cback: scb[0] in_use:true sco_idx: 0xffff ag state:BTA_AG_INIT_ST(0x0) 07-31 15:21:10.333958 11925 11954 D bluetooth: [bta_ag_sco.cc:251] bta_ag_sco_disc_cback: scb[1] in_use:true sco_idx:0x0 ag state:BTA_AG_OPEN_ST(0x2) 07-31 15:21:10.334024 11925 11954 D btm_sco : [btm_sco.cc:1435] btm_sco_on_disconnected: Disconnected SCO link handle:6 reason:HCI_ERR_CONN_CAUSE_LOCAL_HOST 07-31 15:21:10.334071 11925 11954 I oplus_bt_stack_hfp_event: [oplus_bt_stack_hfp_event.cc:1364] record_hfp_sco_removed: hci_handle=0x6, reason=0x16 07-31 15:21:10.334096 11925 11954 D btm_dev : [btm_dev.cc:301] is_handle_equal: handle=6 is not found 07-31 15:21:10.334295 11925 11954 D bluetooth: [bta_ag_main.cc:844] bta_ag_sm_execute_by_handle: AG state machine event:BTA_AG_SCO_CLOSE_EVT[0x050d] handle:0x0002 07-31 15:21:10.334313 11925 11984 I oplus_bt_stack_hfp_event: [oplus_bt_stack_hfp_event.cc:996] deliver_hfp_sco_remove_event: remote_addr=xx:xx:xx:xx:c3:b4, status=0x16 07-31 15:21:10.334338 11925 11954 D bluetooth: [bta_ag_main.cc:811] bta_ag_sm_execute: Execute AG event handle:0x0002 bd_addr:xx:xx:xx:xx:c3:b4 state:BTA_AG_OPEN_ST(0x2)[0x02] event:BTA_AG_SCO_CLOSE_EVT[0x050d] result:BTA_AG_SPK_RES[0x00] 07-31 15:21:10.334342 11925 11984 I oplus_bt_dual_sync: [oplus_bt_dual_sync.cc:592] do_stack_up_sync: stack_to_apk_type = 5 07-31 15:21:10.334395 11925 11954 I bluetooth: [bta_ag_sco.cc:964] bta_ag_sco_event: device:xx:xx:xx:xx:c3:b4 index:0xffff state:BTA_AG_SCO_CLOSING_ST[7] event:BTA_AG_SCO_CONN_CLOSE_E[8] p_scb:0x77e5ed2e10 curr_scb:0x0 07-31 15:21:10.334426 11925 11954 D bluetooth: [bta_ag_sco.cc:512] bta_ag_create_sco: BEFORE codec_updated=0, codec_fallback=0, nrec=0sco_codec=2, peer_codec=3, msbc_settings=0, lc3_settings=0, device=xx:xx:xx:xx:c3:b4 07-31 15:21:10.334454 11925 11954 W bluetooth: [bta_ag_sco.cc:586] bta_ag_create_sco: esco_codec: 2 07-31 15:21:10.334495 11925 11954 D btm_sco : [btm_sco.cc:883] BTM_CreateSco: Listening for (e)SCO on ACL handle:0xffff 07-31 15:21:10.334516 11925 11954 D btm_sco : [btm_sco.cc:889] BTM_CreateSco: SCO connection successfully requested 07-31 15:21:10.334542 11925 11954 D bluetooth: [bta_ag_sco.cc:718] bta_ag_create_sco: Listening AG SCO inx 0x0000 status:BTM_CMD_STARTED pkt types 0x0388 07-31 15:21:10.334571 11925 11954 D bluetooth: [bta_ag_sco.cc:722] bta_ag_create_sco: AFTER codec_updated=0, codec_fallback=0, nrec=0sco_codec=2, peer_codec=3, msbc_settings=0, lc3_settings=0, device=xx:xx:xx:xx:c3:b4 07-31 15:21:10.334609 11925 11954 I oplus_bt_stack_hfp_event: [oplus_bt_stack_hfp_event.cc:1403] record_hfp_sco_event: index=0x0, device=xx:xx:xx:xx:c3:b4, pre_state=OPLUS_SCO_CLOSING_ST[7], new_state=OPLUS_SCO_LISTEN_ST[1], event=OPLUS_SCO_CONN_CLOSE_E[8] 07-31 15:21:10.334624 11925 11984 I oplus_bt_dual_sync: [oplus_bt_dual_sync.cc:640] operator(): up_sync done. 07-31 15:21:10.334635 11925 11954 W bluetooth: [bta_ag_sco.cc:1501] bta_ag_sco_event: SCO_state_change: [BTA_AG_SCO_CLOSING_ST(0x07)]->[BTA_AG_SCO_LISTEN_ST(0x01)] after event [BTA_AG_SCO_CONN_CLOSE_E(0x08)] 07-31 15:21:10.334824 11925 11954 D bt_device_interop: [interop_oplus.cc:613] interop_oplus_match_addr:[OplusGapNotDoSniffSubrating] check 84:**:**:**:c3:b4 return 0 07-31 15:21:10.334866 11925 11954 D bt_device_interop: [interop_oplus.cc:625] interop_oplus_match_name_impl:[OplusGapNotDoSniffSubrating] check realme Buds Air6 Pro return 0 07-31 15:21:10.334929 11925 11954 D bt_device_interop: [interop_oplus.cc:802] interop_oplus_match_ver:[OplusGapNotDoSniffSubrating] check 84:**:**:**:c3:b4 return 0 07-31 15:21:10.334990 11925 11954 D bt_device_interop: [interop_oplus.cc:639] interop_oplus_match_both_name_and_addr_impl:[OplusGapNotDoSniffSubrating] check realme Buds Air6 Pro-84:**:**:**:c3:b4 return 0 07-31 15:21:10.335049 11925 11954 D bt_device_interop: [interop_oplus.cc:665] interop_oplus_match_both_name_addr_and_ver_impl:[OplusGapNotDoSniffSubrating] check realme Buds Air6 Pro-84:**:**:**:c3:b4-0c:02b0:0115 return 0 07-31 15:21:10.335166 11925 11954 I bluetooth-a2dp: [bta_av_main.cc:1078] bta_av_sco_chg_cback: status=BTA_SYS_SCO_CLOSE, num_links=0 07-31 15:21:10.335194 11925 11954 D bluetooth-a2dp: [bta_av_main.cc:1110] bta_av_sco_chg_cback: SCO unoccupied peer:xx:xx:xx:xx:c3:b4 status:BTA_SYS_SCO_CLOSE 07-31 15:21:10.335288 11925 11954 D bt_device_interop: [interop_oplus.cc:613] interop_oplus_match_addr:[OplusHfpUpdateSecondCallstate] check 84:**:**:**:c3:b4 return 0 07-31 15:21:10.335317 11925 11954 D bt_device_interop: [interop_oplus.cc:625] interop_oplus_match_name_impl:[OplusHfpUpdateSecondCallstate] check realme Buds Air6 Pro return 0 07-31 15:21:10.335369 11925 11954 D bt_device_interop: [interop_oplus.cc:802] interop_oplus_match_ver:[OplusHfpUpdateSecondCallstate] check 84:**:**:**:c3:b4 return 0 07-31 15:21:10.335485 11925 11954 D bt_device_interop: [interop_oplus.cc:639] interop_oplus_match_both_name_and_addr_impl:[OplusHfpUpdateSecondCallstate] check realme Buds Air6 Pro-84:**:**:**:c3:b4 return 0 07-31 15:21:10.335544 11925 11954 D bt_device_interop: [interop_oplus.cc:665] interop_oplus_match_both_name_addr_and_ver_impl:[OplusHfpUpdateSecondCallstate] check realme Buds Air6 Pro-84:**:**:**:c3:b4-0c:02b0:0115 return 0 07-31 15:21:10.335621 11925 11954 D bt_device_interop: [interop_oplus.cc:613] interop_oplus_match_addr:[OplusRfcommForbidCombineRfcommData] check 84:**:**:**:c3:b4 return 0 07-31 15:21:10.335650 11925 11954 D bt_device_interop: [interop_oplus.cc:625] interop_oplus_match_name_impl:[OplusRfcommForbidCombineRfcommData] check realme Buds Air6 Pro return 0 07-31 15:21:10.335720 11925 11954 D bt_device_interop: [interop_oplus.cc:802] interop_oplus_match_ver:[OplusRfcommForbidCombineRfcommData] check 84:**:**:**:c3:b4 return 0 07-31 15:21:10.335856 11925 11954 D bt_device_interop: [interop_oplus.cc:639] interop_oplus_match_both_name_and_addr_impl:[OplusRfcommForbidCombineRfcommData] check realme Buds Air6 Pro-84:**:**:**:c3:b4 return 0 07-31 15:21:10.335960 11925 11954 D bt_device_interop: [interop_oplus.cc:665] interop_oplus_match_both_name_addr_and_ver_impl:[OplusRfcommForbidCombineRfcommData] check realme Buds Air6 Pro-84:**:**:**:c3:b4-0c:02b0:0115 return 0 07-31 15:21:10.337100 11925 11984 D bt_btif_hf: [btif_hf.cc:416] btif_hf_upstreams_evt: HF Upstream event:BTA_AG_AUDIO_CLOSE_EVT(0x6) 07-31 15:21:10.337122 11925 11984 D bt_btif_hf: [btif_hf.cc:661] btif_hf_upstreams_evt: Audio close event:BTA_AG_AUDIO_CLOSE_EVT(0x6) 07-31 15:21:10.337135 11925 11984 D bt_btif_hf: [btif_hf.cc:670] sco disc mark sco_disc_time = 539733042 07-31 15:21:10.337152 11925 11984 I BluetoothHeadsetServiceJni: [com_android_bluetooth_hfp.cpp:98] AudioStateCallback: 0 for xx:xx:xx:xx:c3:b4 07-31 15:21:10.337344 11925 11984 D oplus_btif_hf: [oplus_btif_hf.cc:124] oplus_btif_hf_ag_audio_close_evt: 07-31 15:21:10.337387 11925 11984 D oplus_btif_hf: [oplus_btif_hf.cc:128] oplus_btif_hf_ag_audio_close_evt: Close Audio: oplus_smart_bt, disable hpm 07-31 15:21:10.337400 11925 11984 D oplus_bt_hpm: [oplus_bt_hpm.cc:412] oplus_bt_enable_hpm_alllink: enable = false, sarEnable = false, SM = 0, request_feature = 00000000000000000000000000000000 07-31 15:21:10.337409 11925 11984 D oplus_bt_hpm: [oplus_bt_hpm.cc:475] oplus_bt_enable_hpm_alllink: HPM already disabled or still in use, SM = 0 07-31 15:21:10.337501 11925 12068 D HeadsetStateMachine: handleMessage: E msg.what=101 07-31 15:21:10.337560 11925 12068 D HeadsetStateMachine: processMsg: AudioOn 07-31 15:21:10.337595 11925 12068 D HeadsetStateMachine: AudioOn: currentDevice=XX:XX:XX:XX:C3:B4, msg=processMessage:101 07-31 15:21:10.337635 11925 12068 D HeadsetStateMachine: AudioOn: currentDevice=XX:XX:XX:XX:C3:B4, msg=STACK_EVENT: EVENT_TYPE_AUDIO_STATE_CHANGED[2], valInt=0, valInt2=0, valString=null, valObject=null, device=XX:XX:XX:XX:C3:B4 07-31 15:21:10.337655 11925 12068 D HeadsetStateMachine: AudioOn: currentDevice=XX:XX:XX:XX:C3:B4, msg=STACK_EVENT: EVENT_TYPE_AUDIO_STATE_CHANGED[2], valInt=0, valInt2=0, valString=null, valObject=null, device=XX:XX:XX:XX:C3:B4 07-31 15:21:10.337673 11925 12068 D HeadsetStateMachine: AudioOn: currentDevice=XX:XX:XX:XX:C3:B4, msg=processAudioEvent: audio disconnected by remote 07-31 15:21:10.337688 11925 12068 D HeadsetStateMachine: transitionTo: destState=Connected 07-31 15:21:10.337710 11925 12068 D HeadsetStateMachine: handleMessage: new destination call exit/enter 07-31 15:21:10.337720 11925 12068 D HeadsetStateMachine: setupTempStateStackWithStatesToEnter: X mTempStateStackCount=1,curStateInfo: null 07-31 15:21:10.337728 11925 12068 D HeadsetStateMachine: invokeExitMethods: AudioOn 07-31 15:21:10.337741 11925 12068 D HeadsetStateMachine: AudioOn: currentDevice=XX:XX:XX:XX:C3:B4, msg=exit... 07-31 15:21:10.337957 11925 12068 D HeadsetStateMachine: moveTempStackToStateStack: i=0,j=0 07-31 15:21:10.338003 11925 12068 D HeadsetStateMachine: moveTempStackToStateStack: X mStateStackTop=0,startingIndex=0,Top=Connected 07-31 15:21:10.338014 11925 12068 D HeadsetStateMachine: invokeEnterMethods: Connected 07-31 15:21:10.338089 11925 12068 D HeadsetStateMachine: Connected: currentDevice=XX:XX:XX:XX:C3:B4, msg=audio state changed: XX:XX:XX:XX:C3:B4: AudioOn -> Connected 07-31 15:21:10.338166 11925 12068 D HeadsetStateMachine: Connected: currentDevice=XX:XX:XX:XX:C3:B4, msg=broadcastAudioState: XX:XX:XX:XX:C3:B4: 12->10 07-31 15:21:10.338451 11925 12068 D OplusHeadsetServiceExtImpl: inActivateDevice 07-31 15:21:10.338508 11925 12068 D OplusHeadsetServiceExtImpl: check wether low priority 07-31 15:21:10.338691 3320 3411 D QosSceneRecognizer: updateAssProcRecord add: true, isProvider: true, cmpAssParams: CmpAssParams{mCallingUid=1002, mCallingPid=11925, mCalledUid=10106, mCalledPid=4818, mCalledPkgName=com.oplus.statistics.rom, mCalledProcessName=com.oplus.statistics.rom, mCmpName=6a5d11a/com.oplus.statistics.rom/.service.DcsContentProvider} 07-31 15:21:10.339347 11925 12068 D BluetoothActiveDeviceManager: isWatch deviceType is NULL 07-31 15:21:10.339543 11925 12068 D bt_device_interop: [interop_oplus.cc:613] interop_oplus_match_addr:[OplusLowPriorityDevice] check 84:**:**:**:c3:b4 return 0 07-31 15:21:10.339594 11925 12068 D bt_device_interop: [interop_oplus.cc:625] interop_oplus_match_name_impl:[OplusLowPriorityDevice] check realme Buds Air6 Pro return 0 07-31 15:21:10.339658 11925 12068 D bt_device_interop: [interop_oplus.cc:802] interop_oplus_match_ver:[OplusLowPriorityDevice] check 84:**:**:**:c3:b4 return 0 07-31 15:21:10.339718 11925 12068 D bt_device_interop: [interop_oplus.cc:639] interop_oplus_match_both_name_and_addr_impl:[OplusLowPriorityDevice] check realme Buds Air6 Pro-84:**:**:**:c3:b4 return 0 07-31 15:21:10.339777 11925 12068 D bt_device_interop: [interop_oplus.cc:665] interop_oplus_match_both_name_addr_and_ver_impl:[OplusLowPriorityDevice] check realme Buds Air6 Pro-84:**:**:**:c3:b4-0c:02b0:0115 return 0 07-31 15:21:10.340557 4818 1972 D DCS>ContentProvider[main#binder:4818_D]: DcsContentProvider insert: statSId=492ead50-754b-4240-a514-ee28af8d3f3c eventID=bt_hfp_event logMap={"devType":"3","RemoteAddress":"84:0F:2A:**:**:**:91f31071","reason":"22","scoActive_new":"true","scoCallApp":"1e34be275f0d4ffef3767a0ebddb03d50b6e669ad4ba35dcc8e90d1813302b2b","session":"sco_open","connectMs":"102","scoAirMode":"0","screenOn_new":"true","leLinkNums_new":"0","connStartTime":"2025-07-31 15:21:04","Name":"realme Buds Air6 Pro","LmpVer":"12","wifiConnected_new":"true","linkNums_new":"1","Manufacturer":"688","scoType":"2","connTotalTimeS":"6","DevClass":"2360324","DeviceIdentity":"Audio-Other","connEndTime":"2025-07-31 15:21:10","scoHasNeco":"0","scoNecoResult":"0","createSide":"dut","issueType":"stack_hfp_sco_service_trace","scoNegoCost":"0","a2dpPlaying_new":"false","isMerge":"1","LmpSubVer":"277","scoAppImpl":"100","24GwifiConnect_new":"false","wifiState_new":"3","slcConnTime":"2025-07-31 15:21:10"} logTag=bt_data_collector appName=蓝牙 appId=20131 ssoid=0 appPackage=com.android.bluetooth appIdStr=20131 appVersion=15.0.0 dataType=1006 07-31 15:21:10.342114 4818 4893 D DCS>EventRulesTableHelper[main#dcs-thread-DcsWorker]: queryEventRulesList: finish. commonBeanList size: 1 07-31 15:21:10.342359 11925 11959 I bluetooth: [hci_layer.cc:153] drop: Dropping event MAX_SLOTS_CHANGE(0x1b) 07-31 15:21:10.343245 4818 4893 D DCS>EventRulesTableHelper[main#dcs-thread-DcsWorker]: queryEventRulesList: finish. commonBeanList size: 1 07-31 15:21:10.343363 4818 4893 D DCS>StrategyManager[main#dcs-thread-DcsWorker]: getTrackType eventRule:EventRule(eventType=bt_data_collector, eventId=bt_hfp_event, eventLevel=1, isRealTime=false, acceptNetType=ALL, trackType=2, dataType=0, headSwitch=15) 07-31 15:21:10.343419 4818 4893 D DCS>StrategyManager[main#dcs-thread-DcsWorker]: isNeedUpload: cache, type: 2006, appID: 20131, logTag: bt_data_collector, eventID: bt_hfp_event 07-31 15:21:10.343446 4818 4893 D DCS>BootMemoryUtil[main#dcs-thread-DcsWorker]: checkBootMemoryTestWindow result: false 07-31 15:21:10.344486 4818 4893 D DCS>EventRulesTableHelper[main#dcs-thread-DcsWorker]: queryEventRulesList: finish. commonBeanList size: 1 07-31 15:21:10.344553 11925 12068 D OplusBluetoothLeAdapterService: isLeAudioDevice Cod : 0 07-31 15:21:10.344586 11925 12068 D HeadsetStateMachine: handleMessage: X 07-31 15:21:10.344722 11925 12068 D AudioManager: setA2dpSuspended(false) begin 07-31 15:21:10.345052 3320 4205 I AS.BtHelper: receiveBtEvent ACTION_AUDIO_STATE_CHANGED: btState=10{AudioDisconnected} 07-31 15:21:10.345093 3320 4205 I AS.BtHelper: device:XX:XX:XX:XX:C3:B4 07-31 15:21:10.345100 3320 4205 E BluetoothDevice: not support twsplus devices 07-31 15:21:10.345106 3320 4205 I AS.BtHelper: checkAndUpdatTwsPlusScoState returns true 07-31 15:21:10.345114 3320 4205 I AS.BtHelper: device:XX:XX:XX:XX:C3:B4 07-31 15:21:10.345127 11925 12068 D AudioManager: setA2dpSuspended(false) end 07-31 15:21:10.345145 3320 4205 W BluetoothDeviceSocExtImpl: qcom not support api getDeviceType 07-31 15:21:10.345151 3320 4205 I AS.BtHelper: Bluetooth device type: -1 07-31 15:21:10.345155 3320 4205 I AS.BtHelper: isGroupDevice return false 07-31 15:21:10.345167 3320 4205 I AS.BtHelper: checkAndUpdateGroupScoState returns true 07-31 15:21:10.345173 3320 4205 I AS.BtHelper: onScoAudioStateChanged state: 10, mScoAudioState: 5 07-31 15:21:10.345197 3320 4205 I AS.AudioDeviceBroker: setBluetoothScoOn: false, mBluetoothScoOn: true, btScoRequesterUId: -1, from: BtHelper.onScoAudioStateChanged, state: 10 07-31 15:21:10.345305 3320 3320 D OplusWifiBroadCastDispatcher: mHighPriorityReceiver: onReceiver action=android.bluetooth.headset.profile.action.AUDIO_STATE_CHANGED 07-31 15:21:10.345558 2046 16191 D AudioFlingerExtImpl: AudioFlingerExtImpl oplusSetParameters: keyvalue BT_SCO=off 07-31 15:21:10.345631 4818 4893 D DCS>EventRulesTableHelper[main#dcs-thread-DcsWorker]: queryEventRulesList: finish. commonBeanList size: 29 07-31 15:21:10.345673 3320 3320 D Telecom : BluetoothStateReceiver: onReceive action = android.bluetooth.headset.profile.action.AUDIO_STATE_CHANGED 07-31 15:21:10.345690 4818 4893 E DCS>CommonEventRuleListManager[main#dcs-thread-DcsWorker]: getUploadPolicy: db has 20131 bt_data_collector bt_hfp_event 07-31 15:21:10.345733 4818 4893 D DCS>AppVersionHelper[main#dcs-thread-DcsWorker]: preciseControlPackageDictionary is not include packageName=com.android.bluetooth 07-31 15:21:10.345753 4818 4893 D DCS>JsonProvider[main#dcs-thread-DcsWorker]: generateCommonHeadV3: more than 60000 ms since the last generate 07-31 15:21:10.345775 3320 4369 D OplusDumpFileObserver: audio current state:10 07-31 15:21:10.345866 4818 4893 D DCS>JsonProvider[main#dcs-thread-DcsWorker]: getCommonHeadV3 found [{"$brand":"realme","$model":"RMX3800","$platform":0,"$os_version":"V16.0.0","$rom_version":"RMX3800_16.0.0.54(CN01)","$android_version":"16","$sdk_package_name":"com.oplus.statistics.rom","$sdk_version":"5.8.88.03","$channel":"OS","$region":"CN","$region_mark":"CN","$multi_user_id":0,"$cloud_config_product_version":"2.4.3.1","$custom_head":{"os_properties":"otaVersion\u0002RMX3800_11.F.04_2040_202507221920\u0001multi_user_id\u00020\u0001my_carrier\u0002ALLNET_all"}}] in row [1] 07-31 15:21:10.345860 1747 1773 W LOG_FLOWCTRL: ==LOGS OVER PROC QUOTA(300), rows(95) bytes(5093) android.hardware.audio.service_64 u(0) l(0) t(0) c(0) DROPPED== 07-31 15:21:10.345881 3320 3320 D Telecom : WearableDeviceUtils: getDeviceRecord type = -1 07-31 15:21:10.345860 1747 1773 D AHAL: AudioDevice: SetParameters: 1932: enter: BT_SCO=off 07-31 15:21:10.345930 1747 1773 D AHAL: hfp: hfp_set_parameters: 444: enter 07-31 15:21:10.345949 1747 1773 I AHAL: AudioDevice: SetParameters: 2421: BTSCO on = 0 07-31 15:21:10.345953 3320 3320 I Telecom : BluetoothStateReceiver: Device *** transitioned to audio state 10 07-31 15:21:10.345963 1747 1773 I PAL_ResourceManager: isDeviceAvailable: 13244: Device 7, is_available = 1 07-31 15:21:10.346002 1747 1773 D AHAL: AudioDevice: SetParameters: 2757: exit 07-31 15:21:10.346038 4818 4893 D DCS>PreciseControlManager[main#dcs-thread-DcsWorker]: dealRealTimePreciseControl start sampleEventKey=20131_bt_data_collector_bt_hfp_event 07-31 15:21:10.346141 4818 4893 D DCS>PreciseControlRulesTableHelper[main#dcs-thread-DcsWorker]: queryForPreciseControlRuleBean: finish. PreciseControlRuleBean: PreciseControlRuleBean{appId=20131, type='1', proportion='0', eventKey='20131_bt_data_collector_bt_hfp_event', samplingIntervals='[1-50000]'} 07-31 15:21:10.346185 4818 4893 D DCS>PreciseControlManager[main#dcs-thread-DcsWorker]: dealRealTimePreciseControl PreciseControlRuleBean:PreciseControlRuleBean{appId=20131, type='1', proportion='0', eventKey='20131_bt_data_collector_bt_hfp_event', samplingIntervals='[1-50000]'} 07-31 15:21:10.346200 4818 4893 D DCS>PreciseControlStrategy-DeviceSamplingStrategy[main#dcs-thread-DcsWorker]: checkDeviceSampling sampleIntervals:[1-50000] 07-31 15:21:10.346227 4818 4893 D DCS>BootMemoryUtil[main#dcs-thread-DcsWorker]: checkBootMemoryTestWindow result: false 07-31 15:21:10.346237 4818 4893 D DCS>CommonTableHelper[main#dcs-thread-DcsWorker]: insertDataWithCache to db. CommonBean{AppId=20131, LogTag='bt_data_collector', EventId='bt_hfp_event', isRealtime='false', headSwitch='15', trackType='2', eventTime='0', isPreData='0', ext='null'} 07-31 15:21:10.346354 11925 12009 I oplus_bt_dual_sync: [oplus_bt_dual_sync.cc:143] stack_down_sync_action: type=5, len=54 07-31 15:21:10.346381 3320 5432 I Telecom : h: AudioOff received message: BT_AUDIO_LOST. 07-31 15:21:10.346405 3320 5432 I Telecom : h: Received BT off for device XX:XX:XX:F9:C3:B4 while BT off. 07-31 15:21:10.346672 11925 11925 W VolumeControlService: AudioStateChangedReceiver: XX:XX:XX:XX:C3:B4 doesn't in mDeviceGroupId and mGroupBrDevice 07-31 15:21:10.346739 11925 11925 I OplusCustomScanStrategy: msg.what = 4 07-31 15:21:10.347013 2046 16191 D AudioFlingerExtImpl: AudioFlingerExtImpl oplusSetParameters: keyvalue A2dpSuspended=false 07-31 15:21:10.347096 11925 11925 D LeAudioService: isBroadcastEnable() false 07-31 15:21:10.347200 3320 5432 D BluetoothAdapter: getActiveDevices(profile= HEADSET) 07-31 15:21:10.347213 1747 1773 D AHAL: AudioDevice: SetParameters: 1932: enter: A2dpSuspended=false 07-31 15:21:10.347249 1747 1773 D AHAL: hfp: hfp_set_parameters: 444: enter 07-31 15:21:10.347260 1747 1773 I AHAL: AudioDevice: SetParameters: 2378: BT A2DP Suspended = false, command received 07-31 15:21:10.347270 1747 1773 I PAL_ResourceManager: isDeviceAvailable: 13244: Device 29, is_available = 1 07-31 15:21:10.347283 1747 1773 D PAL_ResourceManager: setParameter: 11991: a2dp resumed, switch bt sco mic to handset mic 07-31 15:21:10.347291 1747 1773 D PAL_ResourceManager: getDeviceConfig: 3461: device id 0x1b channels 2 samplerate 48000, bitwidth 24 format 22 SndDev handset-mic priority 0x3 07-31 15:21:10.347302 1747 1773 D PAL_ResourceManager: findActiveStreamsNotInDisconnectList: 8384: activeStreams size = 1, device: PAL_DEVICE_IN_BLUETOOTH_SCO_HEADSET 07-31 15:21:10.347305 1747 1773 D PAL_ResourceManager: restoreDeviceConfigForUPD: 8457: UPD backend needs no update 07-31 15:21:10.347307 1747 1773 I PAL_ResourceManager: streamDevSwitch: 8664: Enter 07-31 15:21:10.347311 1747 1773 D PAL_ResourceManager: isStreamActive: 4157: Exit, ret 1 07-31 15:21:10.347313 1747 1773 D PAL_ResourceManager: isStreamActive: 4157: Exit, ret 1 07-31 15:21:10.347317 1747 1773 D PAL_ResourceManager: streamDevSwitch: 8726: uniqueStreamsList stream 0xb40000785ee68f80K lock 07-31 15:21:10.348295 11925 11925 D LeAudioService: getActiveDevices 07-31 15:21:10.348376 11925 11925 D LeAudioService: getActiveDevices 07-31 15:21:10.348526 3320 5432 D Telecom : c: mLeAudioSetAsCommunicationDevicefalse 07-31 15:21:10.348540 11925 5474 D LeAudioService: getActiveDevices 07-31 15:21:10.348549 3320 5432 I Telecom : h: Received HFP off, no bluetooth audio connected Device. 07-31 15:21:10.348572 11925 5474 D TbsService: getAudioDevices() size:0 07-31 15:21:10.348573 3320 5432 D Telecom_CALLAUDIO_ROUTE : h - Entering audio off state 07-31 15:21:10.348583 11925 5474 D TbsService: isAudioOn: uid/pid=1000/3320:false 07-31 15:21:10.349309 3320 3429 D ActivityManager: Cancel freezing 32462 com.oplus.wirelesssettings 07-31 15:21:10.349425 3320 5432 D BluetoothAdapter: getActiveDevices(profile= HEADSET) 07-31 15:21:10.349918 3320 4400 D BluetoothA2dp: isA2dpPlaying(XX:XX:XX:XX:C3:B4) 07-31 15:21:10.349957 3320 3320 D NotificationService--OplusNotificationManagerServiceExtImpl: notifyDelayRemovedLocked,reason:9 isGroup:false 07-31 15:21:10.349982 3320 3320 D NotificationService--OplusNotificationManagerServiceExtImpl: notifyDelayRemovedLocked,reason:9 isGroup:false 07-31 15:21:10.350029 3320 3320 D NotificationService--OplusNotificationManagerServiceExtImpl: notifyDelayRemovedLocked sbnList isEmpty 07-31 15:21:10.350051 3320 3320 D NotificationService--OplusNotificationManagerServiceExtImpl: notifyDelayRemovedLocked sbnList isEmpty 07-31 15:21:10.350384 11925 5474 D A2dpService: isA2dpPlaying(XX:XX:XX:XX:C3:B4) 07-31 15:21:10.350450 3320 5432 D Telecom : c: mLeAudioSetAsCommunicationDevicefalse 07-31 15:21:10.350475 3320 5432 I Telecom : AsyncRingtonePlayer: updateBtActiveState: false 07-31 15:21:10.350485 3320 5432 D Telecom : f2: sendMessageWithSessionInfo messageCodeName = BT_AUDIO_DISCONNECTED 1301 07-31 15:21:10.350670 3320 5462 I Telecom : f2: Message received: BT_AUDIO_DISCONNECTED=1301, arg1=0 07-31 15:21:10.350810 3320 5462 I Telecom : y1: Processing message BT_AUDIO_DISCONNECTED 07-31 15:21:10.350824 3320 5462 D Telecom_CALLAUDIO_ROUTE : CallAudioRouteStateMachine - Processing message BT_AUDIO_DISCONNECTED 07-31 15:21:10.350860 3320 5462 D Telecom : Logging: END_SESSION (dur: 5 ms): BSR.oR@R48 07-31 15:21:10.350893 3320 5462 I Telecom : f2: onPostHandleMessage: BT_AUDIO_DISCONNECTED=1301, arg1=0 07-31 15:21:10.351027 3320 3429 D ActivityManager: Async freezing 32462 com.oplus.wirelesssettings 07-31 15:21:10.351116 3320 3429 D ActivityManager: Cancel freezing 32462 com.oplus.wirelesssettings 07-31 15:21:10.351278 3320 4400 D BluetoothA2dp: getCodecStatus(XX:XX:XX:XX:C3:B4) 07-31 15:21:10.351373 3320 3429 D ActivityManager: Async freezing 32462 com.oplus.wirelesssettings 07-31 15:21:10.351877 11925 5474 D A2dpService: getCodecStatus(XX:XX:XX:XX:C3:B4) 07-31 15:21:10.352438 11925 5474 D HidHostService: getDevicesMatchingConnectionStates() 07-31 15:21:10.353370 11925 5474 D bt_device_interop: [interop_oplus.cc:613] interop_oplus_match_addr:[OplusDisallowFddV2Mode] check 84:**:**:**:c3:b4 return 0 07-31 15:21:10.353392 11925 5474 D bt_device_interop: [interop_oplus.cc:625] interop_oplus_match_name_impl:[OplusDisallowFddV2Mode] check realme Buds Air6 Pro return 0 07-31 15:21:10.353410 11925 5474 D bt_device_interop: [interop_oplus.cc:802] interop_oplus_match_ver:[OplusDisallowFddV2Mode] check 84:**:**:**:c3:b4 return 0 07-31 15:21:10.353425 11925 5474 D bt_device_interop: [interop_oplus.cc:639] interop_oplus_match_both_name_and_addr_impl:[OplusDisallowFddV2Mode] check realme Buds Air6 Pro-84:**:**:**:c3:b4 return 0 07-31 15:21:10.353440 11925 5474 D bt_device_interop: [interop_oplus.cc:665] interop_oplus_match_both_name_addr_and_ver_impl:[OplusDisallowFddV2Mode] check realme Buds Air6 Pro-84:**:**:**:c3:b4-0c:02b0:0115 return 0 07-31 15:21:10.353661 11925 5474 D bt_device_interop: [interop_oplus.cc:613] interop_oplus_match_addr:[OplusDisallowFddV3Mode] check 84:**:**:**:c3:b4 return 0 07-31 15:21:10.353776 11925 5474 D bt_device_interop: [interop_oplus.cc:625] interop_oplus_match_name_impl:[OplusDisallowFddV3Mode] check realme Buds Air6 Pro return 0 07-31 15:21:10.353868 11925 5474 D bt_device_interop: [interop_oplus.cc:802] interop_oplus_match_ver:[OplusDisallowFddV3Mode] check 84:**:**:**:c3:b4 return 0 07-31 15:21:10.353891 11925 5474 D bt_device_interop: [interop_oplus.cc:639] interop_oplus_match_both_name_and_addr_impl:[OplusDisallowFddV3Mode] check realme Buds Air6 Pro-84:**:**:**:c3:b4 return 0 07-31 15:21:10.353909 11925 5474 D bt_device_interop: [interop_oplus.cc:665] interop_oplus_match_both_name_addr_and_ver_impl:[OplusDisallowFddV3Mode] check realme Buds Air6 Pro-84:**:**:**:c3:b4-0c:02b0:0115 return 0 07-31 15:21:10.354437 32462 32462 D WS_BT_BluetoothEventManager: BluetoothEventManager onReceive: android.bluetooth.headset.profile.action.AUDIO_STATE_CHANGED 07-31 15:21:10.354757 32462 32462 D WS_BT_BluetoothEventManager: BluetoothEventManager onReceive: android.bluetooth.headset.profile.action.AUDIO_STATE_CHANGED 07-31 15:21:10.356662 1747 1773 D PAL_ResourceManager: streamDevDisconnect_l: 8585: Enter 07-31 15:21:10.356737 1747 1773 D PAL_ResourceManager: isStreamActive: 4157: Exit, ret 1 07-31 15:21:10.356747 1747 1773 D PAL: Stream: disconnectStreamDevice_l: 1465: device 29 name PAL_DEVICE_IN_BLUETOOTH_SCO_HEADSET, going to stop 07-31 15:21:10.356751 1747 1773 D PAL_ResourceManager: deregisterDevice: 4923: Enter. dev id: 29 07-31 15:21:10.356756 1747 1773 D PAL_ResourceManager: checkandEnableEC_l: 4816: Enter: setting to enable[OFF] for stream 2. 07-31 15:21:10.356759 1747 1773 D PAL_ResourceManager: checkandEnableECForTXStream_l: 4618: Enter: setting EC[OFF] for usecase 2 of device 29. 07-31 15:21:10.356763 1747 1773 D PAL_ResourceManager: getECEnableSetting: 4565: stream type: 2, deviceid: 29, custom key: 07-31 15:21:10.356785 1747 1773 D PAL_ResourceManager: getECEnableSetting: 4591: ec_enable_setting:1, status:0 07-31 15:21:10.356789 1747 1773 E PAL_ResourceManager: updateECDeviceMap: 6455: Cannot reset as ec ref not present 07-31 15:21:10.356793 1747 1773 D PAL: StreamPCM: setECRef_l: 1673: Enter. session handle - 0xb40000785f592000K 07-31 15:21:10.356796 1747 1773 D PAL: SessionAlsaPcm: setECRef: 3428: Enter 07-31 15:21:10.356799 1747 1773 D PAL: SessionAlsaPcm: setECRef: 3471: EC ref not enabled, skip disabling 07-31 15:21:10.356801 1747 1773 D PAL: SessionAlsaPcm: setECRef: 3591: Exit, status: 0 07-31 15:21:10.356804 1747 1773 D PAL: StreamPCM: setECRef_l: 1680: Exit, status 0 07-31 15:21:10.356807 1747 1773 D PAL_ResourceManager: checkandEnableECForTXStream_l: 4676: Exit. status: 0 07-31 15:21:10.356809 1747 1773 D PAL_ResourceManager: checkandEnableEC_l: 4847: Exit. status: 0 07-31 15:21:10.356811 1747 1773 D PAL_ResourceManager: deregisterDevice: 4941: Exit. 07-31 15:21:10.356816 1747 1773 D PAL_ResourceManager: getBackEndNames: 8270: getBackEndNames (TX): SLIM-DEV1-TX-7 07-31 15:21:10.356842 1747 1773 D PAL: SessionAlsaUtils: getFeMixerControl: 354: mixer control PCM112 control 07-31 15:21:10.356868 1747 1773 I AGM: API: agm_session_aif_connect: 625 disconnecting aifid:39 with session id=112 07-31 15:21:10.356881 1747 1773 D AGM: graph: graph_stop: 1036 entry graph_handle 0x247534c 07-31 15:21:10.356892 1747 1773 I gsl : gsl_send_spf_cmd:209 sending pkt opcode 0x1001003 token 0x07907000 07-31 15:21:10.359319 4624 4624 D SystemUi--Statusbar: OplusPhoneStatusBarPolicyEx-->updateBluetooth(), isBluetoothEnabled = true, isBluetoothConnected = true 07-31 15:21:10.359895 4624 4624 D SystemUi--Statusbar: OplusPhoneStatusBarPolicyEx-->updateBluetooth(), resourceId = 2131236965, enabled = true, slotBluetooth = bluetooth 07-31 15:21:10.361466 1747 1773 I gsl : gsl_send_spf_cmd:250 rcvd pkt token : 0x7907000 07-31 15:21:10.361539 1747 1773 I gsl : gsl_send_spf_cmd:209 sending pkt opcode 0x1001004 token 0x07908000 07-31 15:21:10.363485 1747 1773 I gsl : gsl_send_spf_cmd:250 rcvd pkt token : 0x7908000 07-31 15:21:10.363517 1747 1773 D AGM: graph: graph_stop: 1090 exit, ret 0 07-31 15:21:10.363548 1747 1773 I AGM: device: device_close: 679 PCM device 37 open refcnt: 1 07-31 15:21:10.383924 1748 11969 I vendor.qti.bluetooth@1.1-ibs_handler: ProcessIbsCmd: Received IBS_SLEEP_IND: 0xFE 07-31 15:21:10.495580 3320 3411 D QosSceneRecognizer: updateAssProcRecord add: false, isProvider: true, cmpAssParams: CmpAssParams{mCallingUid=10172, mCallingPid=24830, mCalledUid=10146, mCalledPid=22569, mCalledPkgName=com.oplus.pantanal.ums, mCalledProcessName=com.oplus.pantanal.ums, mCmpName=37bf2e5/com.oplus.pantanal.ums/.cardservice.provider.CardServiceServerProvider} 07-31 15:21:10.519369 3320 4095 I CwbClient: setCWBDisplayType set mFeatureID = CWB_RGB_VALUE 07-31 15:21:10.569463 1747 1773 I AGM: session: session_obj_set_sess_aif_metadata: 1967 Exit 07-31 15:21:10.569559 1747 1773 D PAL: SessionAlsaPcm: disconnectSessionDevice: 2526: Removed BE for dev 29 from AIF list 07-31 15:21:10.569581 1747 1773 D PAL: Device: stop_l: 696: Enter. deviceCount 1 deviceStartStopCount 1 for device id 29 (PAL_DEVICE_IN_BLUETOOTH_SCO_HEADSET) 07-31 15:21:10.569594 1747 1773 I PAL: Device: close: 575: Enter. deviceCount 1 for device id 29 (PAL_DEVICE_IN_BLUETOOTH_SCO_HEADSET) 07-31 15:21:10.569601 1747 1773 D PAL: Device: close: 580: Disabling device 29 with snd dev bt-sco-mic 07-31 15:21:10.569620 1747 1773 I PAL: Device: close: 600: Exit. deviceCount 0 for device id 29 (PAL_DEVICE_IN_BLUETOOTH_SCO_HEADSET), exit status 0 07-31 15:21:10.569637 1747 1773 D PAL_ResourceManager: checkAndSetDutyCycleParam: 7181: duty cycle for UPD not enabled 07-31 15:21:10.569646 1747 1773 D PAL_ResourceManager: streamDevDisconnect_l: 8597: disconnect stream 0xb40000785ee68f80K from device 29 07-31 15:21:10.569653 1747 1773 D PAL_ResourceManager: streamDevDisconnect_l: 8602: Exit status: 0 07-31 15:21:10.569664 1747 1773 D PAL_ResourceManager: streamDevConnect_l: 8614: Enter 07-31 15:21:10.569671 1747 1773 D PAL_ResourceManager: isStreamActive: 4157: Exit, ret 1 07-31 15:21:10.569685 1747 1773 I PAL: Device: setDeviceAttributes: 440: DeviceAttributes for Device Id 27 updated 07-31 15:21:10.569700 1747 1773 D PAL: Stream: connectStreamDevice_l: 1629: device 27 name PAL_DEVICE_IN_HANDSET_MIC, going to start 07-31 15:21:10.569710 1747 1773 D PAL_ResourceManager: getPALDeviceName: 9091: id 27 07-31 15:21:10.569721 1747 1773 I PAL: Device: open: 530: Enter. deviceCount 0 for device id 27 (PAL_DEVICE_IN_HANDSET_MIC) 07-31 15:21:10.569739 1747 1773 I PAL: SessionAlsaUtils: setDeviceMediaConfig: 1089: CODEC_DMA-LPAIF_RXTX-TX-3 rate ch fmt data_fmt 48000 2 6 1 07-31 15:21:10.569755 1747 1773 D PAL: Device: open: 554: audio_route 0xb40000785f471370K SND device name handset-mic 07-31 15:21:10.569766 1747 1773 D audio_route: Apply path: handset-mic 07-31 15:21:10.576741 1747 1773 I PAL: Device: open: 565: Exit. deviceCount 1 for device id 27 (PAL_DEVICE_IN_HANDSET_MIC), exit status: 0 07-31 15:21:10.577054 1747 1773 D PAL_ResourceManager: getBackEndNames: 8270: getBackEndNames (TX): CODEC_DMA-LPAIF_RXTX-TX-3 07-31 15:21:10.577244 1747 1773 I PAL_PayloadBuilder: populateStreamKV: 2657: stream type 2 07-31 15:21:10.577263 1747 1773 D PAL: Stream: getSoundCardId: 704: sound card id = 0x0 07-31 15:21:10.577273 1747 1773 I PAL_PayloadBuilder: populateDeviceKV: 3256: Enter device id:0 07-31 15:21:10.577280 1747 1773 I PAL_PayloadBuilder: populateDeviceKV: 3284: Exit device id:0, status 0 07-31 15:21:10.577288 1747 1773 D PAL: Stream: getSoundCardId: 704: sound card id = 0x0 07-31 15:21:10.577295 1747 1773 I PAL_PayloadBuilder: populateDeviceKV: 3256: Enter device id:27 07-31 15:21:10.577306 1747 1773 D PAL: Device: getDeviceAttributes: 399: no device attr for associated streams for dev 27 07-31 15:21:10.577335 1747 1773 I PAL_PayloadBuilder: findKVs: 2825: key: 0xa3000000 value: 0xa3000004 07-31 15:21:10.577342 1747 1773 I PAL_PayloadBuilder: populateDeviceKV: 3284: Exit device id:27, status 0 07-31 15:21:10.577349 1747 1773 D PAL: Stream: getSoundCardId: 704: sound card id = 0x0 07-31 15:21:10.577356 1747 1773 I PAL_PayloadBuilder: populateDeviceKV: 3256: Enter device id:27 07-31 15:21:10.577363 1747 1773 D PAL: Device: getDeviceAttributes: 399: no device attr for associated streams for dev 27 07-31 15:21:10.577373 1747 1773 I PAL_PayloadBuilder: findKVs: 2825: key: 0xa3000000 value: 0xa3000004 07-31 15:21:10.577378 1747 1773 I PAL_PayloadBuilder: populateDeviceKV: 3284: Exit device id:27, status 0 07-31 15:21:10.577391 1747 1773 I PAL_PayloadBuilder: populateDevicePPKV: 3416: Tx device id:27 07-31 15:21:10.577398 1747 1773 D PAL: Device: getDeviceAttributes: 399: no device attr for associated streams for dev 27 07-31 15:21:10.577420 1747 1773 I PAL_PayloadBuilder: getSelectorValues: 3022: stream type: 2 07-31 15:21:10.577613 1747 1773 I PAL_PayloadBuilder: findKVs: 2812: key: 0xa3000000 value: 0xa3000004 07-31 15:21:10.577625 1747 1773 D PAL: SessionAlsaUtils: setupSessionDevice: 2707: Speaker protection enabled 07-31 15:21:10.577651 1747 1773 D PAL: SessionAlsaUtils: setupSessionDevice: 2808: mixer control CODEC_DMA-LPAIF_RXTX-TX-3 metadata 07-31 15:21:10.577674 1747 1773 D PAL: SessionAlsaUtils: setupSessionDevice: 2818: mixer control PCM112 control 07-31 15:21:10.577682 1747 1773 D PAL: SessionAlsaUtils: setupSessionDevice: 2827: mixer control PCM112 metadata 07-31 15:21:10.577697 1747 1773 I AGM: session: session_obj_set_sess_aif_metadata: 1967 Exit 07-31 15:21:10.577706 1747 1773 D PAL: Device: start_l: 629: Enter. deviceCount 1 deviceStartStopCount 0 for device id 27 (PAL_DEVICE_IN_HANDSET_MIC) 07-31 15:21:10.577714 1747 1773 I PAL: SessionAlsaUtils: setDeviceMediaConfig: 1089: CODEC_DMA-LPAIF_RXTX-TX-3 rate ch fmt data_fmt 48000 2 6 1 07-31 15:21:10.577722 1747 1773 D PAL: Device: start_l: 676: Exit, status 0 07-31 15:21:10.577727 1747 1773 D PAL_ResourceManager: getBackEndNames: 8270: getBackEndNames (TX): CODEC_DMA-LPAIF_RXTX-TX-3 07-31 15:21:10.577741 1747 1773 D agm_server_wrapper: Aif id 6 already added to session list of 112 07-31 15:21:10.577746 1747 1773 I AGM: API: agm_session_aif_connect: 625 connecting aifid:6 with session id=112 07-31 15:21:10.578824 1747 1773 D AGM: graph: graph_change: 1741 entry graph_handle 0x247534c 07-31 15:21:10.578975 1747 1773 D AGM: metadata: metadata_print: 79 *************************Metadata************************* 07-31 15:21:10.578981 1747 1773 D AGM: metadata: metadata_print: 80 GKV size:3 07-31 15:21:10.578984 1747 1773 D AGM: metadata: metadata_print: 83 key:0xb1000000, value:0xb1000001 07-31 15:21:10.578986 1747 1773 D AGM: metadata: metadata_print: 83 key:0xab000000, value:0x1 07-31 15:21:10.578988 1747 1773 D AGM: metadata: metadata_print: 83 key:0xa3000000, value:0xa3000004 07-31 15:21:10.578990 1747 1773 D AGM: metadata: metadata_print: 89 CKV count:1 07-31 15:21:10.578992 1747 1773 D AGM: metadata: metadata_print: 95 key:0xa4000000, value:0x0 07-31 15:21:10.578995 1747 1773 D AGM: metadata: metadata_print: 102 Property ID:134217744 07-31 15:21:10.578998 1747 1773 D AGM: metadata: metadata_print: 103 property count:4 07-31 15:21:10.579000 1747 1773 D AGM: metadata: metadata_print: 106 Property Values: 07-31 15:21:10.579003 1747 1773 D AGM: metadata: metadata_print: 108 0x1 07-31 15:21:10.579005 1747 1773 D AGM: metadata: metadata_print: 108 0x3 07-31 15:21:10.579006 1747 1773 D AGM: metadata: metadata_print: 108 0x2 07-31 15:21:10.579008 1747 1773 D AGM: metadata: metadata_print: 108 0x5 07-31 15:21:10.579010 1747 1773 D AGM: metadata: metadata_print: 115 ****************Metadata Done*************************** 07-31 15:21:10.579065 1747 1773 D AGM: graph: print_graph_alias: 2482 GKV Alias 87 | DeviceTX_Handset_Mic_Instance_Instance_1_StreamTX_PCM_Record 07-31 15:21:10.579139 1747 1773 I gsl : gsl_send_spf_cmd:209 sending pkt opcode 0x1001000 token 0x07909000 07-31 15:21:10.583422 1747 1773 I gsl : gsl_send_spf_cmd:250 rcvd pkt token : 0x7909000 07-31 15:21:10.583621 1747 1773 I gsl : gsl_send_spf_cmd:209 sending pkt opcode 0x1001006 token 0x0790a000 07-31 15:21:10.585161 1747 1773 I gsl : gsl_send_spf_cmd:250 rcvd pkt token : 0x790a000 07-31 15:21:10.585310 1747 1773 E ACDB : AcdbCmdGetProcSubgraphCalDataPersist:8250 Error[19]: No calibration found 07-31 15:21:10.585326 1747 1773 E ACDB : AcdbCmdGetProcSubgraphCalDataPersist:8250 Error[19]: No calibration found 07-31 15:21:10.585336 1747 1773 D AGM: graph_module: configure_hw_ep_media_config: 705 entry mod tag c0000005 miid 43af mid 7001024 07-31 15:21:10.585340 1747 1773 D AGM: graph_module: configure_hw_ep_media_config: 735 rate 48000 bw 24 ch 2, data_fmt 1 07-31 15:21:10.585347 1747 1773 I gsl : gsl_send_spf_cmd:209 sending pkt opcode 0x1001006 token 0x0790b000 07-31 15:21:10.585921 1747 1773 I gsl : gsl_send_spf_cmd:250 rcvd pkt token : 0x790b000 07-31 15:21:10.586088 1747 1773 D AGM: graph_module: configure_hw_ep_media_config: 745 exit, ret 0 07-31 15:21:10.586160 1747 1773 D AGM: graph_module: configure_codec_dma_ep: 322 cdc_dma intf cfg lpaif 1 indx 4 ch_msk 3 07-31 15:21:10.586191 1747 1773 I gsl : gsl_send_spf_cmd:209 sending pkt opcode 0x1001006 token 0x0790c000 07-31 15:21:10.586832 1747 1773 I gsl : gsl_send_spf_cmd:250 rcvd pkt token : 0x790c000 07-31 15:21:10.586865 1747 1773 D AGM: graph_module: configure_codec_dma_ep: 337 exit, ret 0 07-31 15:21:10.586875 1747 1773 D AGM: graph: graph_change: 1874 exit, ret 0 07-31 15:21:10.586886 1747 1773 D AGM: session: session_start: 1247 configuring device early - for SLIMBUS/Connectivity Proxy EPs 07-31 15:21:10.586893 1747 1773 D AGM: graph: graph_start: 1007 entry graph_handle 0x247534c 07-31 15:21:10.586903 1747 1773 I gsl : gsl_send_spf_cmd:209 sending pkt opcode 0x1001002 token 0x0790d000 07-31 15:21:10.591911 1747 1773 I gsl : gsl_send_spf_cmd:250 rcvd pkt token : 0x790d000 07-31 15:21:10.592076 1747 1773 D AGM: graph: graph_start: 1020 exit, ret 0 07-31 15:21:10.626329 1747 1773 D PAL_ResourceManager: registerDevice: 4878: Enter. dev id: 27 07-31 15:21:10.626394 1747 1773 D PAL_ResourceManager: checkandEnableEC_l: 4816: Enter: setting to enable[ON] for stream 2. 07-31 15:21:10.626400 1747 1773 D PAL_ResourceManager: checkandEnableECForTXStream_l: 4618: Enter: setting EC[ON] for usecase 2 of device 27. 07-31 15:21:10.626409 1747 1773 D PAL: Device: getDeviceAttributes: 399: no device attr for associated streams for dev 27 07-31 15:21:10.626414 1747 1773 D PAL_ResourceManager: getECEnableSetting: 4565: stream type: 2, deviceid: 27, custom key: 07-31 15:21:10.626449 1747 1773 D PAL_ResourceManager: getECEnableSetting: 4591: ec_enable_setting:1, status:0 07-31 15:21:10.626452 1747 1773 D PAL_ResourceManager: getActiveEchoReferenceRxDevices_l: 6194: Enter 07-31 15:21:10.626459 1747 1773 D PAL_ResourceManager: getActiveEchoReferenceRxDevices_l: 6249: Exit, status 0 07-31 15:21:10.626462 1747 1773 D PAL_ResourceManager: checkandEnableECForTXStream_l: 4676: Exit. status: 0 07-31 15:21:10.626465 1747 1773 D PAL_ResourceManager: checkandEnableEC_l: 4847: Exit. status: 0 07-31 15:21:10.626468 1747 1773 D PAL_ResourceManager: registerDevice: 4899: Exit. 07-31 15:21:10.626472 1747 1773 D PAL_ResourceManager: checkAndSetDutyCycleParam: 7181: duty cycle for UPD not enabled 07-31 15:21:10.626480 1747 1773 D PAL: Device: getDeviceAttributes: 399: no device attr for associated streams for dev 27 07-31 15:21:10.626486 1747 1773 D PAL: memLoggerBuilder: palStateQueueBuilder: 77: TIME IS:1753946470626 07-31 15:21:10.626496 1747 1773 D PAL_ResourceManager: streamDevConnect_l: 8624: connected stream 0xb40000785ee68f80K from device 27 07-31 15:21:10.626725 1747 1773 D PAL_ResourceManager: streamDevConnect_l: 8637: Exit status: 0 07-31 15:21:10.626749 1747 1773 D PAL_ResourceManager: isStreamActive: 4157: Exit, ret 1 07-31 15:21:10.626753 1747 1773 I PAL_ResourceManager: streamDevSwitch: 8805: Exit status: 0 07-31 15:21:10.626758 1747 1773 D PAL_ResourceManager: isStreamActive: 4157: Exit, ret 1 07-31 15:21:10.626774 1747 1773 D PAL: Device: insertStreamDeviceAttr: 892: insert the first device attribute 07-31 15:21:10.626778 1747 1773 D PAL: Device: insertStreamDeviceAttr: 949: dev: 27 attr inserted are: priority: 0x3, stream type: 2, ch: 2, sr: 48000, bit_width: 24, fmt: 22, sndDev: handset-mic, custom_key: 07-31 15:21:10.626787 1747 1773 I PAL_ResourceManager: isDeviceAvailable: 13244: Device 7, is_available = 1 07-31 15:21:10.626802 1747 1773 I PAL_ResourceManager: getActiveStream_l: 6642: no active streams found for device 7 ret -2 07-31 15:21:10.626813 1747 1773 I btaudio_offload_aidl: clear_a2dpsuspend_flag: state = AUDIO_STATE_SUSPENDED 07-31 15:21:10.626818 1747 1773 D PAL_ResourceManager: a2dpResume: 10684: enter 07-31 15:21:10.626828 1747 1773 D PAL_ResourceManager: getDeviceConfig: 3461: device id 0x8 channels 1 samplerate 44100, bitwidth 16 format 2 SndDev bt-a2dp priority 0xffffffff 07-31 15:21:10.626866 1747 1773 I PAL_ResourceManager: getActiveStream_l: 6642: no active streams found for device 3 ret -2 07-31 15:21:10.626871 1747 1773 I PAL_ResourceManager: getActiveStream_l: 6642: no active streams found for device 2 ret -2 07-31 15:21:10.626878 1747 1773 I PAL_ResourceManager: getOrphanStream_l: 6711: no orphan streams found 07-31 15:21:10.626881 1747 1773 D PAL_ResourceManager: a2dpResume: 10717: no active streams found 07-31 15:21:10.626884 1747 1773 D PAL_ResourceManager: a2dpResume: 10894: exit status: 0 07-31 15:21:10.626960 1747 1773 D AHAL: AudioDevice: SetParameters: 2757: exit 07-31 15:21:10.629294 2046 16191 D AudioPolicyManagerExtImpl: setParameters A2dpSuspended=false 07-31 15:21:10.630138 2046 16191 D APM::AudioPolicyEngine: choose sco device 0x10 when a2dp suspend 07-31 15:21:10.630157 2046 16191 D EngineExtImpl: addRemoteSubmixDevice, currentUid:0, currentPid:0, captureUid:0, capturePid:0, castDeviceType:-1, needCapture:0, devices2:0x10 07-31 15:21:10.630293 2046 16191 D APM::AudioPolicyEngine: choose sco device 0x10 when a2dp suspend 07-31 15:21:10.630300 2046 16191 D EngineExtImpl: addRemoteSubmixDevice, currentUid:0, currentPid:0, captureUid:0, capturePid:0, castDeviceType:-1, needCapture:0, devices2:0x10 07-31 15:21:10.630521 2046 16191 D EngineExtImpl: addRemoteSubmixDevice, currentUid:0, currentPid:0, captureUid:0, capturePid:0, castDeviceType:-1, needCapture:0, devices2:0x80 07-31 15:21:10.630852 2046 16191 D EngineExtImpl: addRemoteSubmixDevice, currentUid:0, currentPid:0, captureUid:0, capturePid:0, castDeviceType:-1, needCapture:0, devices2:0x80 07-31 15:21:10.631037 2046 16191 D APM::AudioPolicyEngine: choose sco device 0x10 when a2dp suspend 07-31 15:21:10.631045 2046 16191 D EngineExtImpl: addRemoteSubmixDevice, currentUid:0, currentPid:0, captureUid:0, capturePid:0, castDeviceType:-1, needCapture:0, devices2:0x10 07-31 15:21:10.631071 2046 16191 D APM::AudioPolicyEngine: choose sco device 0x10 when a2dp suspend 07-31 15:21:10.631077 2046 16191 D EngineExtImpl: addRemoteSubmixDevice, currentUid:0, currentPid:0, captureUid:0, capturePid:0, castDeviceType:-1, needCapture:0, devices2:0x10 07-31 15:21:10.631110 2046 16191 D EngineExtImpl: addRemoteSubmixDevice, currentUid:0, currentPid:0, captureUid:0, capturePid:0, castDeviceType:-1, needCapture:0, devices2:0x80 07-31 15:21:10.631164 2046 16191 D EngineExtImpl: addRemoteSubmixDevice, currentUid:0, currentPid:0, captureUid:0, capturePid:0, castDeviceType:-1, needCapture:0, devices2:0x80 07-31 15:21:10.632209 3320 4205 I AS.BtHelper: onScoAudioStateChanged broadcasting state: 0 07-31 15:21:10.632423 3320 5299 I Quality : MonitorInfo:system_server,setLeAudioSuspended,AudioDeviceBroker.java_1747,287 07-31 15:21:10.635195 2046 16191 D AudioFlingerExtImpl: AudioFlingerExtImpl oplusSetParameters: keyvalue LeAudioSuspended=false 07-31 15:21:10.635414 1747 22166 D AHAL: AudioDevice: SetParameters: 1932: enter: LeAudioSuspended=false 07-31 15:21:10.635447 1747 22166 D AHAL: hfp: hfp_set_parameters: 444: enter 07-31 15:21:10.635470 1747 22166 I AHAL: AudioDevice: SetParameters: 2697: BT LEA Suspended = false, command received 07-31 15:21:10.635491 1747 22166 I btaudio_offload_aidl: clear_a2dpsuspend_flag: state = AUDIO_STATE_STOPPED 07-31 15:21:10.635496 1747 22166 D PAL_ResourceManager: a2dpCaptureResume: 11001: enter 07-31 15:21:10.635503 1747 22166 D PAL_ResourceManager: getDeviceConfig: 3461: device id 0x31 channels 1 samplerate 44100, bitwidth 16 format 2 SndDev bt-ble-mic priority 0xffffffff 07-31 15:21:10.635517 1747 22166 I PAL_ResourceManager: getOrphanStream_l: 6711: no orphan streams found 07-31 15:21:10.635521 1747 22166 D PAL_ResourceManager: a2dpCaptureResume: 11074: no streams to be restored 07-31 15:21:10.635525 1747 22166 D PAL_ResourceManager: a2dpCaptureResume: 11100: exit status: 0 07-31 15:21:10.635552 1747 22166 D AHAL: AudioDevice: SetParameters: 2757: exit 07-31 15:21:10.635574 2046 29602 D EngineExtImpl: addRemoteSubmixDevice, currentUid:0, currentPid:0, captureUid:0, capturePid:0, castDeviceType:-1, needCapture:0, devices2:0x80 07-31 15:21:10.637622 3320 4212 D AS.SpatializerHelper: Spatial Audio device type:8, mEnabled:true, mUserEnable:false, mUserStateOfSpeaker:0 07-31 15:21:10.638024 2046 16191 D EngineExtImpl: addRemoteSubmixDevice, currentUid:0, currentPid:0, captureUid:0, capturePid:0, castDeviceType:-1, needCapture:0, devices2:0x80 07-31 15:21:10.638396 3320 4212 I AS.SpatializerHelper: onRoutingUpdated: can spatialize media 5.1:true on device:AudioDeviceAttributes: role:output type:bt_a2dp addr:null name: profiles:[] descriptors:[] 07-31 15:21:10.638452 3320 4212 I AS.SpatializerHelper: setDispatchAvailableState(true) mState:STATE_DISABLED_AVAILABLE 07-31 15:21:10.638578 3320 4212 I AS.SpatializerHelper: Disabling Spatial Audio since disabled for media device:AudioDeviceAttributes: role:output type:bt_a2dp addr:null name: profiles:[] descriptors:[] 07-31 15:21:10.638592 3320 4212 I AS.SpatializerHelper: Setting spatialization level to: 0 07-31 15:21:10.638700 2046 29602 D APM_AudioPolicyManager: clearDevicesRoleForStrategy() strategy=0 role=1 07-31 15:21:10.638743 6351 24750 E AEC.SpatializerManager: onSpatializerAvailableChanged,available = true 07-31 15:21:10.638880 2046 16191 D AudioFlingerExtImpl: AudioFlingerExtImpl oplusSetParameters: keyvalue OPLUS_SPATIALIZER_USERSPACE_STATE=0 07-31 15:21:10.639166 2046 16191 D AudioFlingerExtImpl: oplusSetParameters, mSpatializerState 0 07-31 15:21:10.639550 3320 4212 I AS.SpatializerHelper: setDispatchFeatureEnabledState(false) no dispatch: mState:STATE_DISABLED_AVAILABLE src:onRoutingUpdated 07-31 15:21:10.639566 3320 4212 I AS.SpatializerHelper: mode:1, need set feature enabled. 07-31 15:21:10.639561 2046 29602 D EngineExtImpl: addRemoteSubmixDevice, currentUid:0, currentPid:0, captureUid:0, capturePid:0, castDeviceType:-1, needCapture:0, devices2:0x80 07-31 15:21:10.640314 2046 29602 D EngineExtImpl: addRemoteSubmixDevice, currentUid:0, currentPid:0, captureUid:0, capturePid:0, castDeviceType:-1, needCapture:0, devices2:0x80 07-31 15:21:10.640614 2046 29602 D EngineExtImpl: addRemoteSubmixDevice, currentUid:0, currentPid:0, captureUid:0, capturePid:0, castDeviceType:-1, needCapture:0, devices2:0x80 07-31 15:21:10.641088 2046 29602 D EngineExtImpl: addRemoteSubmixDevice, currentUid:0, currentPid:0, captureUid:0, capturePid:0, castDeviceType:-1, needCapture:0, devices2:0x80 07-31 15:21:10.641609 2046 29602 D EngineExtImpl: addRemoteSubmixDevice, currentUid:0, currentPid:0, captureUid:0, capturePid:0, castDeviceType:-1, needCapture:0, devices2:0x80 07-31 15:21:10.641914 2046 29602 D EngineExtImpl: addRemoteSubmixDevice, currentUid:0, currentPid:0, captureUid:0, capturePid:0, castDeviceType:-1, needCapture:0, devices2:0x80 07-31 15:21:10.641994 2046 29602 D EngineExtImpl: addRemoteSubmixDevice, currentUid:0, currentPid:0, captureUid:0, capturePid:0, castDeviceType:-1, needCapture:0, devices2:0x80 07-31 15:21:10.642044 2046 29602 D EngineExtImpl: addRemoteSubmixDevice, currentUid:0, currentPid:0, captureUid:0, capturePid:0, castDeviceType:-1, needCapture:0, devices2:0x80 07-31 15:21:10.642116 2046 29602 D EngineExtImpl: addRemoteSubmixDevice, currentUid:0, currentPid:0, captureUid:0, capturePid:0, castDeviceType:-1, needCapture:0, devices2:0x80 07-31 15:21:10.642220 2046 29602 D EngineExtImpl: addRemoteSubmixDevice, currentUid:0, currentPid:0, captureUid:0, capturePid:0, castDeviceType:-1, needCapture:0, devices2:0x80 07-31 15:21:10.642976 2046 29602 D APM::AudioPolicyEngine: getDeviceForInputSource()input source 1, device 80000004分析一下sco断开到输入设备变成内置micaudiopolicymanager和engline的流程
11-28
09-28 13:13:27.417706 1170 1230 I URCC_CORE_SERVER: [getRequestFromRunRequestMap] can not get request in runing map for handle:21159 09-28 13:13:27.417773 1170 1230 E URCC_REQUEST_QUEUE: removeNodeFromQueue is called (removeNodeFromQueue){#23:vendor/oplus/cpu/urcc/halservice/urcccore/UrccRequestQueue.cpp} 09-28 13:13:27.419470 23473 23970 I akff : (REDACTED) Provider package not found: %s 09-28 13:13:27.419779 23473 23970 I akff : (REDACTED) Provider package not found: %s 09-28 13:13:27.420866 5061 5123 I dnpp : (REDACTED) #audio# audio client(%d)'s route start remote request 09-28 13:13:27.421438 5061 5123 I dnle : (REDACTED) #audio# consulting policy for audio input params client(%s) intent(%s) 09-28 13:13:27.421982 5061 5123 I dnlw : (REDACTED) #audio# selecting audio format..., request=%s 09-28 13:13:27.422184 5061 5123 I dnlq : (REDACTED) #audio# selecting audio config, intent=%s... 09-28 13:13:27.422565 5061 5123 I dnlw : (REDACTED) #audio# selected audio format=%s 09-28 13:13:27.422824 5061 5123 I dnax : (REDACTED) #audio# starting audio session(%d) for %s 09-28 13:13:27.423010 23473 23970 I akff : (REDACTED) Provider package not found: %s 09-28 13:13:27.423351 23473 23970 I akff : (REDACTED) Provider package not found: %s 09-28 13:13:27.423890 5061 5123 I dnax : (REDACTED) #audio# enforcing concurrency state on new audio session of %s 09-28 13:13:27.424919 1895 1924 D AS.AudioService: uid 10129, callingApp = com.google.android.googlequicksearchbox 09-28 13:13:27.425989 5061 5123 I dnax : (REDACTED) #audio# audio session(%d) OK to start 09-28 13:13:27.426913 5061 5123 I dnca : (REDACTED) #audio# starting audio source session(%d) on %s for %s 09-28 13:13:27.427166 5061 5123 I dnca : (REDACTED) #audio# enforcing concurrency state on a new audio source of %s 09-28 13:13:27.427577 5061 5123 I dmhl : (REDACTED) #audio# loading processor(%s) 09-28 13:13:27.427840 5061 5123 I dmhh : (REDACTED) #audio# loading processor(%s) 09-28 13:13:27.428057 5061 5123 I dmhb : (REDACTED) #audio# loading processor(%s) 09-28 13:13:27.430332 5061 5123 I dnnt : (REDACTED) #audio# enforcing routes concurrency state on %s of %s 09-28 13:13:27.430502 23473 23970 I akff : (REDACTED) Provider package not found: %s 09-28 13:13:27.431535 5061 5145 I dmub : (REDACTED) #audio# referencing(%s) to(%s), (%s) 09-28 13:13:27.432659 23473 23970 I ajtn : ClockLookupExecutor is not enabled. 09-28 13:13:27.432774 5061 5123 I dnsc : (REDACTED) #audio# skipping session(%s) storing process, not enabled 09-28 13:13:27.432854 23473 23970 I akff : (REDACTED) Provider package not found: %s 09-28 13:13:27.433305 5061 7857 I dmzv : (REDACTED) #audio# opening audio source(%s), offset(%s) 09-28 13:13:27.433451 5061 5123 I dnnt : (REDACTED) #audio# update route state on %s of %s 09-28 13:13:27.433574 5061 7857 I dmky : (REDACTED) #audio# delegating source(%s) opening to(%s) 09-28 13:13:27.433779 5061 7857 I dmkq : (REDACTED) #audio# open audio source(%s) 09-28 13:13:27.434191 5061 5123 I dmug : (REDACTED) #audio# schedule timeout(token(%s), duration(%s)) 09-28 13:13:27.434361 5061 7857 I dmjy : #audio# createAudioRecord 09-28 13:13:27.434454 23473 23970 I akff : (REDACTED) Provider package not found: %s 09-28 13:13:27.434515 5061 7857 D AudioRecord: getMinFrameCount 640 09-28 13:13:27.435047 5061 7857 D AudioRecordExtImpl: AudioRecordExtImpl init 09-28 13:13:27.435283 5061 7857 D AudioRecordExtImpl: audiorecordTest 09-28 13:13:27.435386 5061 7857 D AudioRecord: set(): inputSource 6, sampleRate 16000, format 0x1, channelMask 0x10, frameCount 128000, notificationFrames 0, sessionId 0, transferType 0, flags 0, attributionSource AttributionSourceState{pid: 5061, uid: 10129, deviceId: 0, packageName: com.google.android.googlequicksearchbox, attributionTag: robin_android.audio, token: binder:0xb40000735bc37b80, renouncedPermissions: [], next: []}uid -1, pid -1 09-28 13:13:27.435965 23473 23970 I aesj : (REDACTED) FCF System FeatureName to check: %s 09-28 13:13:27.436174 23473 23970 I aesj : (REDACTED) FCF: Device model check status : %s 09-28 13:13:27.436496 23473 23970 I deby : (REDACTED) isAppDefaultAssistant setting: %s 09-28 13:13:27.436629 23473 23970 I deby : (REDACTED) isAppDefaultAssistant defaultComponentName: %s 09-28 13:13:27.436679 5061 7857 D AudioRecord: set(): mSessionId 0 09-28 13:13:27.436713 23473 23778 I dmru : #audio# client session ack-signal received from remote 09-28 13:13:27.437259 5061 7857 D AudioRecord: set(): 0xb40000735bc92000, Create AudioRecordThread, tid = 7858 09-28 13:13:27.437407 23473 23970 I akdd : getRequiredCapabilities: Bypassed, feature disabled. 09-28 13:13:27.437523 5061 7857 D AudioRecordExtImpl: doSchedBoost, set audioapp task boost, pid=5061, tid=7857, enable=1, ret=0 09-28 13:13:27.438321 1197 13387 D AudioFlingerExtImpl: oplusGetParametersBypassLock:only system or list app is allowed to get oplus parameters:DetectPulseEnable, uid:10129 09-28 13:13:27.438691 5061 7857 D AudioDetectPulse: setDetectPulse, mIsDetectPulse 0, 0x741ede40e0 09-28 13:13:27.439194 23473 23970 I deby : (REDACTED) isAppDefaultAssistant setting: %s 09-28 13:13:27.439285 23473 23970 I deby : (REDACTED) isAppDefaultAssistant defaultComponentName: %s 09-28 13:13:27.439429 23473 23970 I akff : (REDACTED) Provider package not found: %s 09-28 13:13:27.439560 23473 23970 I akff : (REDACTED) Provider package not found: %s 09-28 13:13:27.439700 23473 23970 I akff : (REDACTED) Provider package not found: %s 09-28 13:13:27.439788 23473 23970 I akff : (REDACTED) Provider package not found: %s 09-28 13:13:27.440246 1197 13387 D AudioBoost: audioSchedBoost, pid=1197, tid=13387, enable=1, ret=0 09-28 13:13:27.440342 1197 13387 D AudioFlingerExtImpl: addActiveAudioSession, add 2081, uid 10129, map size 1 09-28 13:13:27.440727 1197 13387 D APM_AudioPolicyManager: [MTK_APM_Input]getInputForAttr() source 6, sampling rate 16000, format 0x1, channel mask 0x10, session 2081, flags 0 attributes={ Content type: AUDIO_CONTENT_TYPE_UNKNOWN Usage: AUDIO_USAGE_UNKNOWN Source: AUDIO_SOURCE_VOICE_RECOGNITION Flags: 0x800 Tags: } requested device ID 0 09-28 13:13:27.441128 23473 23970 I deby : (REDACTED) isAppDefaultAssistant setting: %s 09-28 13:13:27.441208 23473 23970 I deby : (REDACTED) isAppDefaultAssistant defaultComponentName: %s 09-28 13:13:27.441287 1197 13387 D APM::AudioPolicyEngine: getDeviceForInputSource()input source 6, device 80000004 09-28 13:13:27.442071 1092 1840 D AudioALSAStreamManager: openInputStream(), devices = 0x80000004, format = 0x1, channels = 0x10, sampleRate = 16000, status = 110, acoustics = 0x0, input_flag 0x0 09-28 13:13:27.442178 1092 1840 D AudioALSAStreamIn: AudioALSAStreamIn() 09-28 13:13:27.442217 1092 1840 D AudioUtility: AudioThrottleTimeControl(), mIsOutput = 0, mBytesSum = 0, mThrottleControlStartTime = 0 09-28 13:13:27.442239 1092 1840 D AudioALSAHardware: InputSetScenceFromProp: mOplusInputScence = 0 09-28 13:13:27.442251 1092 1840 D AudioALSAStreamIn: AudioALSAStreamIn(), set input scence 0 09-28 13:13:27.442282 1092 1840 D WCNChipController: IsBTI2SSupport(), BTChipHWInterface() = 3, ret = 0 09-28 13:13:27.442293 1092 1840 D AudioDspStreamManager: getDspBtscoEnable(), BTSCO offload = 0 09-28 13:13:27.442312 1092 1840 D AudioSpeechEnhanceInfo: IsBesRecTuningEnable()- 0 09-28 13:13:27.442339 1092 1840 D AudioSpeechEnhanceInfo: IsAPDMNRTuningEnable(), 0 09-28 13:13:27.442355 1092 1840 D AudioALSAStreamIn: checkOpenStreamSampleRate(), origin sampleRate 16000, kDefaultInputSourceSampleRate 48000. 09-28 13:13:27.442366 1092 1840 D AudioALSAStreamIn: set() done, devices: 0x80000004, flags: 0, acoustics: 0x0, format: 0x1, sampleRate: 16000/16000, num_channels: 0x10/1, buffer_size: 640, tempDebugflag: 0 09-28 13:13:27.442384 1092 1840 D AudioALSAStreamManager: openInputStream(), add streamIn 0xb400007d61a7ce00, idenity 110 in mInputPoolInfo, size = 1 09-28 13:13:27.442391 1092 1840 D AudioALSAStreamManager: openInputStream(), SetInputMute(mAllInputMute) 09-28 13:13:27.442400 1092 1840 D AudioALSAStreamIn: SetInputMute(), 0 09-28 13:13:27.442439 1092 1840 D AudioALSAStreamIn: setParameters(), this = 0xb400007d61a7ce00, InputSource: 0 => 6, reopen 09-28 13:13:27.442491 1092 1840 D DeviceHAL: openInputStreamCore, flags: 0, open_input_stream success, mOpenedStreamsCount 6 09-28 13:13:27.442543 1092 1840 D AudioALSAStreamIn: updateSinkMetadataV7(), device:0x0 09-28 13:13:27.444178 23473 23970 I akff : (REDACTED) Provider package not found: %s 09-28 13:13:27.446640 1197 13387 D AudioBoost: audioSchedBoost, pid=1197, tid=7859, enable=1, ret=0 09-28 13:13:27.446748 1197 7859 I AudioFlinger: AudioFlinger's thread 0xb400007ab08e5ac8 tid=7859 ready to run 09-28 13:13:27.446964 1092 1840 D AudioALSAStreamIn: standby(), halRequest 0, mDestroy 0, flag 0, this 0xb400007d61a7ce00 09-28 13:13:27.447335 1197 7859 D AudioFlinger: updateWakeLockUids_l AudioIn_6E uids: 09-28 13:13:27.447772 1092 1840 D AudioALSAStreamIn: standby(), halRequest 0, mDestroy 0, flag 0, this 0xb400007d61a7ce00 09-28 13:13:27.451294 23473 23970 I deby : (REDACTED) isAppDefaultAssistant setting: %s 09-28 13:13:27.451402 23473 23970 I deby : (REDACTED) isAppDefaultAssistant defaultComponentName: %s 09-28 13:13:27.451890 23473 23970 I akff : (REDACTED) Provider package not found: %s 09-28 13:13:27.452314 23473 23970 I ajrs : DeviceStateLookUpExecutor getRequiredCapabilities 09-28 13:13:27.452311 1895 3204 I OplusHansManager : unfreeze uid: 10372 com.instagram.android pids: [1076] reason: W_AsyncBinder scene: LcdOn 09-28 13:13:27.452359 1106 1174 I OriginChannel: wise light debug, data[2].type is 65627,data[2].sensor is 91:[92.000000,,200.000000,,119.000000,595.000000,220387555073684] 09-28 13:13:27.452769 1895 4064 I OStatsManager_OplusBatteryStatsManager: updateStateTime: PkgName = com.instagram.android, uid = 10372, state to bg, mForegroundCnt = 0, isFg = false 09-28 13:13:27.452872 1895 4064 D OStatsManager_OplusBatteryStatsManager: notePkgUnFrozenInner uid = 10372, pkgName = com.instagram.android 09-28 13:13:27.453727 23473 23777 I deby : (REDACTED) isAppDefaultAssistant setting: %s 09-28 13:13:27.453904 23473 23777 I deby : (REDACTED) isAppDefaultAssistant defaultComponentName: %s 09-28 13:13:27.454142 1197 13387 D AudioFlinger: createRecordTrack_l, notificationFrameCount 320, maxNotificationFrames 320 09-28 13:13:27.454796 1197 13387 D AF_RecordTrack_ExtImpl: AudioFlinger_RecordThread_RecordTrackExtImpl init 09-28 13:13:27.455259 23473 23777 I aevl : (REDACTED) #FCF: Managed profile check status : %s 09-28 13:13:27.455325 1197 13387 I AF::RecordTrack: RecordTrack, track(0xb400007ab085b600): mId(299), mFrameCount 128000, mSampleRate 16000, mFormat 1, mChannelCount 1, thread 0xb400007ab08e5ac0, sessionId 2081, (null), primary-0 09-28 13:13:27.455392 1197 13387 D AudioFlingerExtImpl: setMagicVoiceLoopbackEnable mMagicVoiceLoopbackEnable 0 09-28 13:13:27.455406 1197 13387 D AF_RecordTrack_ExtImpl: notifyRecordTrackWiredDevice sessionId 2081, WiredDevice false 09-28 13:13:27.455506 23473 23777 I azzp : (REDACTED) getSimplifiedOobeViaDeeplinkUser: %b 09-28 13:13:27.455514 1197 13387 D AudioBoost: audioSchedBoost, pid=1197, tid=13387, enable=0, ret=0 09-28 13:13:27.455575 23473 23777 I azgw : (REDACTED) isSimplifiedOobeViaDeeplinkUser OobeStatus: %s, ZeroStateStatus: %s 09-28 13:13:27.456191 23473 23777 I aiew : Device location is not granted. 09-28 13:13:27.456181 5061 7857 I AudioRecord: openRecord_l: 0xb40000735bc92000, mCblk = 0x742d469000 09-28 13:13:27.456681 5061 7857 D AudioRecordExtImpl: doSchedBoost, set audioapp task boost, pid=5061, tid=7857, enable=0, ret=0 09-28 13:13:27.457638 1076 1076 D InputMethodDumpHelper: handleDump [log, always, 1] 09-28 13:13:27.457872 1076 1714 E MvfstCallbacks.cpp: readError: streamid=0; error=LocalError: Idle timeout, Idle timeout, num non control streams: 4 09-28 13:13:27.457995 1076 1714 E MvfstCallbacks.cpp: readError: streamid=3; error=LocalError: Idle timeout, Idle timeout, num non control streams: 4 09-28 13:13:27.458040 1076 1714 E MvfstCallbacks.cpp: readError: streamid=7; error=LocalError: Idle timeout, Idle timeout, num non control streams: 4 09-28 13:13:27.458248 5061 7857 D android.media.AudioRecord: thirdPartyPlaybackCaptureSupported = false 09-28 13:13:27.458102 1076 1714 E MvfstCallbacks.cpp: readError: streamid=11; error=LocalError: Idle timeout, Idle timeout, num non control streams: 4 09-28 13:13:27.459517 1076 1076 D OplusInputMethodUtil: update sDebug to true, update sDebugIme to true, update sAlwaysOn to true 09-28 13:13:27.459590 1076 1714 E MvfstCallbacks.cpp: onConnectionError: error=LocalError: Idle timeout, Idle timeout, num non control streams: 4 09-28 13:13:27.459659 1076 1076 D OplusInputMethodUtil: updateDebugToClass InputMethodManager.DEBUG = true 09-28 13:13:27.459913 1076 1076 D OplusInputMethodUtil: updateDebugToClass ImeFocusController.DEBUG = true 09-28 13:13:27.460156 5061 7857 I dmkq : (REDACTED) #audio# create stream of audio record source(identity(%s), recordId(%d)) 09-28 13:13:27.461702 5061 7857 D AudioRecord: start(282): sync event 0 trigger session 0 09-28 13:13:27.461988 1197 16718 D AF_RecordTrack_ExtImpl: startMagicVoice mYouMeSdk = 0 09-28 13:13:27.462047 1197 16718 D AudioFlinger: RecordThread::start event 0, triggerSession 0 09-28 13:13:27.466005 1197 16718 D AudioPolicyService: updateUidStates_l() current->uid=10129 current->pid=5061 allowCapture=1 UidState=2 apmStat=2 09-28 13:13:27.466086 1197 16718 D APM_AudioPolicyManager: BIRecord: In startInput, profile is primary input 09-28 13:13:27.466103 1197 16718 D APM_AudioPolicyManager: startInput() portId 282 input 110 session 2081 09-28 13:13:27.466971 1895 1980 D QosSceneRecognizer: notifyAudioStatusChanged uid: 10129, isOn: true 09-28 13:13:27.467145 1895 1980 D QosSceneRecognizer[AudioScene]: [10129, -1, true, audio] 09-28 13:13:27.467149 1197 16718 D APM::AudioPolicyEngine: getDeviceForInputSource()input source 6, device 80000004 09-28 13:13:27.467167 1076 1076 D OplusInputMethodUtil: updateDebugToClass OnBackInvokedDispatcher.DEBUG = true 09-28 13:13:27.467193 1895 1980 I QosSceneRecognizer[AudioScene]: onStateChanged add uid 10129 09-28 13:13:27.467241 1076 1076 D OplusInputMethodUtil: updateDebugToClass InsetsController.DEBUG = true 09-28 13:13:27.467274 1895 2736 D Osense-CleanPolicy: notifyAppStatus:IntegratedData{mResId=2, mTime=1759045407466, mInfo=Bundle[{pkgName=10129, uid=10129, isAdded=true}]} 09-28 13:13:27.467296 1895 1980 I QosSceneRecognizer[AudioScene]: onSceneChangeNotify:Bundle[{reason=audio, package=null, process=null, pid=-1, uid=10129, begin=true}] 09-28 13:13:27.467387 1895 1980 I QosSceneRecognizer: onSceneStateChange: sceneId 5 uid 10129 pid -1 type 0 reason audio 09-28 13:13:27.467423 1895 1980 D QosScheduler[QoSPolicy]: onAudioScene begin=true,pkgName=null,uid=10129,pid=-1,type=0 09-28 13:13:27.467436 1895 1980 D QosScheduler[QoSPolicy]: Audio On. 09-28 13:13:27.467463 1895 2736 V Athena : StateManager: stateValue:23, packageName:com.google.android.googlequicksearchbox, uid:10129, state:1 09-28 13:13:27.467750 1895 1980 I QosScheduler[QoSPolicy]: setSceneQoS begin:true sceneId:5 09-28 13:13:27.467802 1895 1980 W QosScheduler: executeSceneQosStrategy failed! qos feature no enable 09-28 13:13:27.467949 1895 1980 D QosSceneRecognizer[VideoScene]: [true, 10129, audio] 09-28 13:13:27.467967 1895 2736 D Osense-AppCompactPolicy: notifyAppStatus:IntegratedData{mResId=2, mTime=1759045407466, mInfo=Bundle[{pkgName=10129, uid=10129, isAdded=true}]} 09-28 13:13:27.468140 2708 2897 I SystemUi--QuickSettings: OplusSeparateQSPrivacyManager-->onPrivacyItemsChanged permGroupName android.permission-group.MICROPHONE 09-28 13:13:27.468172 2708 2708 I SystemEventCoordinator: isQsExpanded true: false, false 09-28 13:13:27.468174 1895 2736 D Osense-OfreezerPolicy: notifyAppStatus:IntegratedData{mResId=2, mTime=1759045407466, mInfo=Bundle[{pkgName=10129, uid=10129, isAdded=true}]} 09-28 13:13:27.468247 2708 2897 I SystemUi--QuickSettings: OplusSeparateQSPrivacyManager-->onPrivacyItemsChanged packageName com.google.android.googlequicksearchbox, uid 10129, size: 1 09-28 13:13:27.468252 1895 2736 D Osense-AppCpuLimitPolicy: notifyAppStatus:IntegratedData{mResId=2, mTime=1759045407466, mInfo=Bundle[{pkgName=10129, uid=10129, isAdded=true}]} 09-28 13:13:27.468351 1895 2736 D Osense-OGuardPolicy: notifyAppStatus:IntegratedData{mResId=2, mTime=1759045407466, mInfo=Bundle[{pkgName=10129, uid=10129, isAdded=true}]} 09-28 13:13:27.468567 1895 4047 D OGuardManager_WeakAwareManager: updateAppStatus uid:10129 start:true type:13 09-28 13:13:27.468699 1197 1527 D AudioSystem: +setParameters(): CamcorderSwitchMic=false 09-28 13:13:27.468834 1076 1076 D OplusInputMethodUtil: updateDebugToClass BaseInputConnection.DEBUG = true 09-28 13:13:27.469104 1197 1527 D AudioFlingerExtImpl: AudioFlingerExtImpl oplusSetParameters: keyvalue CamcorderSwitchMic=false 09-28 13:13:27.469452 1197 7859 D AudioFlinger: updateWakeLockUids_l AudioIn_6E uids:10129 09-28 13:13:27.469697 1092 1840 D OplusMicSwap: CamcorderSetParameters: output set camcorderret = 5, camcorderstrvalue = false 09-28 13:13:27.469716 1092 1840 D OplusMicSwap: CamcorderSetParameters: camera switch mic 0 09-28 13:13:27.470023 1092 1092 D AudioALSAStreamIn: updateSinkMetadataV7(), device:0x0 09-28 13:13:27.470503 1197 16718 D APM_AudioPolicyManager: [MTK_APM_Route]setInputDevice mIoHandle 110 : changing device 0x80000004 to 0x80000004, force = 1 09-28 13:13:27.470937 1895 4874 D BatteryStatsServiceExtImpl: report audio global start... 09-28 13:13:27.471329 1895 4064 I OStatsManager_Calc: noteAudio: uid = 10129, start = true 09-28 13:13:27.471628 1197 1527 V AudioFlinger::PatchPanel: createAudioPatch_l() num_sources 1 num_sinks 1 handle 0 09-28 13:13:27.472102 1092 1092 D AudioALSAHardware: +createAudioPatch() num_sources [1] , num_sinks [1], handle [0x0], current mAudioHalPatchVector size 5 09-28 13:13:27.472142 1092 1092 D AudioALSAStreamManager: +setParameters(), IOport = 110, keyValuePairs = input_source=6;routing=-2147483644 09-28 13:13:27.472169 1092 1092 D AudioALSAStreamManager: +routingInputDevice(), input_device: 0x80000004 => 0x80000004 09-28 13:13:27.472189 1092 1092 D WCNChipController: IsBTI2SSupport(), BTChipHWInterface() = 3, ret = 0 09-28 13:13:27.472194 1092 1092 D AudioDspStreamManager: getDspBtscoEnable(), BTSCO offload = 0 09-28 13:13:27.472208 1092 1092 D AudioALSAStreamManager: routingInputDevice(), haveOtherSharedDevice = 0 09-28 13:13:27.472213 1092 1092 W AudioALSAStreamManager: -routingInputDevice(), input_device(0x80000004) is AUDIO_DEVICE_NONE(0x0) or current_input_device(0x80000004), return 09-28 13:13:27.472221 1092 1092 D AudioALSAStreamIn: setParameters(), this = 0xb400007d61a7ce00, idenity = 110, mPolicyDevice = 0x80000004 09-28 13:13:27.472247 1092 1092 D AudioALSAHardware: -createAudioPatch() num_sources [1] , num_sinks [1], handle [0xa] 09-28 13:13:27.473753 1092 1841 D AudioALSAStreamIn: updateSinkMetadataV7(), device:0x0 09-28 13:13:27.474018 1197 1527 V AudioFlinger::PatchPanel: createAudioPatch_l() status 0 09-28 13:13:27.474105 1197 1527 V AudioFlinger::PatchPanel: -createAudioPatch_l() status 0 09-28 13:13:27.474248 1197 16718 D APM_AudioPolicyManager: setInputDevice() AF::createAudioPatch returned 0 patchHandle 108 num_sources 1 num_sinks 1 09-28 13:13:27.473860 1895 1924 I IPCThreadState: oneway function results for code 10007 on binder at 0xb4000073994e2320 will be dropped but finished with status UNKNOWN_TRANSACTION 09-28 13:13:27.475412 1197 16718 W AudioPolicyClientImpl: setSoundTriggerCaptureState active 1 09-28 13:13:27.475473 1895 1924 I IPCThreadState: oneway function results for code 10006 on binder at 0xb4000073994e2320 will be dropped but finished with status UNKNOWN_TRANSACTION 09-28 13:13:27.475567 1197 16718 D AudioPolicyManagerExtImpl: startinput client uid = 10129 09-28 13:13:27.476315 23473 23778 I ahve : initRequest 09-28 13:13:27.476620 1197 1527 D AudioSystem: +setParameters(): startinput_pid=10129 09-28 13:13:27.476914 1197 1527 D AudioFlingerExtImpl: AudioFlingerExtImpl oplusSetParameters: keyvalue startinput_pid=10129 09-28 13:13:27.477468 23473 23719 I ahve : (REDACTED) createInitializedStream, initialQuery: %s 09-28 13:13:27.477643 1092 1840 D AudioALSAHardware: +setParameters(): startinput_pid=10129 09-28 13:13:27.477756 1092 1840 D AudioALSAPlaybackHandlerKTVThread: setParameters: startinput_pid ktvret = 5, value = 10129 09-28 13:13:27.477774 1092 1840 D AudioALSAPlaybackHandlerKTVThread: KTV set false 09-28 13:13:27.477831 1092 1840 D AudioALSAHardware: =====>GetInstance()->MMI_Auto_Test 09-28 13:13:27.477849 1092 1840 D audio_engineer_test: do_audio_test_process Enter all_test[0]:NoneTest in_call:false 09-28 13:13:27.477928 1092 1840 D OplusAudioALSASuperVolume: parseAudioSuperVolumeParam(), not super_volume 09-28 13:13:27.478005 1092 1840 D AudioALSAHardware: -setParameters(): startinput_pid=10129 09-28 13:13:27.479535 1895 3201 I OplusHansManager : uid=10372, pkg=com.instagram.android F exit(), F stay=392, reason=W_AsyncBinder, FrozenActionKeepProxy=false 09-28 13:13:27.479603 1895 3204 I OplusHansManager : forceUnfreezeApp uid= 10372 unfreezeForKernel: W_AsyncBinder false 09-28 13:13:27.479638 1895 4884 D AudioSystem: Reset audio port generation 09-28 13:13:27.479905 1895 4921 D SoundTriggerHalConcurrentCaptureHandler: onCaptureStateChange, mCaptureState = true 09-28 13:13:27.480250 1197 16718 D AtlasEventUploadUtils: setEvent event:atlas_event_audio_record_start 09-28 13:13:27.481985 23473 23969 I akzz : (REDACTED) #retrieve id(%s) 09-28 13:13:27.482315 1895 4921 I IPCThreadState: oneway function results for code 10006 on binder at 0xb4000073994e2320 will be dropped but finished with status UNKNOWN_TRANSACTION 09-28 13:13:27.483924 1092 1092 W StreamHAL: Error from HAL stream in function set_microphone_direction: Function not implemented 09-28 13:13:27.484621 1092 1092 W StreamHAL: Error from HAL stream in function set_microphone_field_dimension: Function not implemented 09-28 13:13:27.485308 1895 3207 I OplusHansManager : up_BC uid=10372 pkg=com.instagram.android 09-28 13:13:27.485462 1092 7861 D AudioALSAStreamIn: open(), flag 0x0, this = 0xb400007d61a7ce00 09-28 13:13:27.485493 1092 7861 D WCNChipController: IsBTI2SSupport(), BTChipHWInterface() = 3, ret = 0 09-28 13:13:27.485499 1092 7861 D AudioDspStreamManager: getDspBtscoEnable(), BTSCO offload = 0 09-28 13:13:27.485528 1092 7861 D WCNChipController: IsBTI2SSupport(), BTChipHWInterface() = 3, ret = 0 09-28 13:13:27.485533 1092 7861 D AudioDspStreamManager: getDspBtscoEnable(), BTSCO offload = 0 09-28 13:13:27.485538 1092 7861 D AudioALSAStreamIn: open(),flag 0x0 current input share device 0x80000004 -> policy share device 0x80000004 09-28 13:13:27.485543 1092 7861 D AudioALSAStreamManager: +createCaptureHandler(), mAudioMode = 0, input_source = 6, input_device = 0x80000004, mBypassDualMICProcessUL=0, rate=16000, flag=0x0 09-28 13:13:27.485551 1092 7861 D WCNChipController: IsBTI2SSupport(), BTChipHWInterface() = 3, ret = 0 09-28 13:13:27.485554 1092 7861 D AudioDspStreamManager: getDspBtscoEnable(), BTSCO offload = 0 09-28 13:13:27.485559 1092 7861 D WCNChipController: IsBTI2SSupport(), BTChipHWInterface() = 3, ret = 0 09-28 13:13:27.485562 1092 7861 D AudioDspStreamManager: getDspBtscoEnable(), BTSCO offload = 0 09-28 13:13:27.485592 1092 7861 D AudioALSACaptureHandlerNormal: AudioALSACaptureHandlerNormal() 09-28 13:13:27.485597 1092 7861 D AudioALSACaptureHandlerNormal: init() 09-28 13:13:27.485600 1092 7861 D AudioALSAStreamManager: setHDRRecord(), setHDRRecord = 0, mHDRRecordEna = 0 09-28 13:13:27.485604 1092 7861 D AudioALSAHardwareResourceManager: setHDRRecord(), setHDRRecord = 0, mHDRRecordEna = 0 09-28 13:13:27.485616 1092 7861 D AudioALSACaptureHandlerBase: getCaptureHandlerType(), mCaptureHandlerType = 2 09-28 13:13:27.485620 1092 7861 D AudioALSACaptureHandlerNormal: +open(), input_device = 0x80000004, input_source = 0x6, sample_rate=16000, num_channels=1 09-28 13:13:27.485632 1092 7861 D AudioALSACaptureDataClientAurisysNormal: AudioALSACaptureDataClientAurisysNormal(+) 09-28 13:13:27.485646 1092 7861 D AudioALSACaptureDataProviderBase: configStreamAttribute(), audio_mode: 0 => 0, input_device: 0x80000004 => 0x80000004, flag: 0x0 => 0x0, input_source: 6->6, output_device: 0x2 => 0x2, sample_rate: 48000 => 16000, period_us: 0 => 0, DSP out sample_rate: 16000 => 16000 09-28 13:13:27.485650 1092 7861 D AudioALSACaptureDataProviderBase: configStreamAttribute(), mInputScence: 0 => 0, mOutputScence: 0 => 0 09-28 13:13:27.485655 1092 7861 D AudioALSACaptureDataProviderBase: attach(), 0xb400007d61a83c00, mCaptureDataClientVector.size()=0, Identity=0xb400007d4f794780, mCaptureDataProviderType = 0 09-28 13:13:27.485664 1092 7861 D AudioALSADeviceParser: compare pcm success = 10, stringpair = Capture_1 09-28 13:13:27.485670 1092 7861 D AudioALSACaptureDataProviderNormal: open(+), audiomode=0, cardindex = 0, pcmindex = 10 09-28 13:13:27.485878 1895 3207 I OplusBinderProxy: un_pb uid: 10372 pid: 1076 rst: true , Desc: android.hardware.display.IDisplayManagerCallback/1 09-28 13:13:27.486051 1895 3207 I OplusBinderProxy: proxyBinder uid: 10372 pkg: com.instagram.android proxy: false calling: OFreezer 09-28 13:13:27.486085 1895 3207 D OplusHansManager : Restore alarm is disabled. 09-28 13:13:27.486600 1092 7861 D audio_engineer_test: stop_capturing Enter onOff:1 09-28 13:13:27.486625 1092 7861 D OplusMicSwap: SetSwapMicEnable: oplus_get_config = SUPPORT isenable = 1 09-28 13:13:27.486635 1092 7861 D AudioSpeechEnhanceInfo: GetHifiRecord, mHiFiRecordEnable=0 09-28 13:13:27.486641 1092 7861 D AudioALSACaptureDataProviderNormal: buffersizemax: 262144, bHifiRecord: 0, btempDebug: 0 09-28 13:13:27.486652 1092 7861 D AudioALSAHardwareResourceManager: paramPath = InputSource,VoiceRecognition 09-28 13:13:27.486676 1092 7861 D AudioSpeechEnhanceInfo: GetHifiRecord, mHiFiRecordEnable=0 09-28 13:13:27.486685 1092 7861 D AudioALSACaptureDataProviderBase: getInputSampleRate(), input_device: 0x80000004, output_device 0x2, hifi_record = 0, phone call open = 0 09-28 13:13:27.486677 4173 5201 D OplusAtlas.OplusAudioRecordInfoUploadHelper: callback success event:atlas_event_audio_record_start eventInfo:recorderPid:5061,TrackSession:2081,inputDevice:80000004 09-28 13:13:27.486734 1092 7861 D AudioALSACaptureDataProviderNormal: mConfig format: 3, channels: 2, rate: 48000, period_size: 960, period_count: 4, latency: 20, kReadBufferSize: 7680, mCaptureDropSize: 0 09-28 13:13:27.486754 1092 7861 D AudioALSADeviceConfigManager: ApplyDeviceTurnonSequenceByName() DeviceName = ADDA_TO_CAPTURE1 descriptor->DeviceStatusCounte = 0, Ctlsize=4 09-28 13:13:27.486851 4173 5201 D OplusAtlasAudioDetectionManager: callback success event:atlas_event_audio_record_start eventInfo:recorderPid:5061,TrackSession:2081,inputDevice:80000004 09-28 13:13:27.486975 1092 7861 D AudioALSAHardwareResourceManager: +startInputDevice_l(), new_device: 0x80000004, mInputDevice: 0x0, mStartInputDeviceCount: 0, mMicInverse: 0, InputChannel: 2, mBuiltInMicSpecificTyp: 0 09-28 13:13:27.487009 1092 7861 D AudioALSAHardwareResourceManager: enableTurnOnSequence(), sequence: builtin_Mic_DualMic 09-28 13:13:27.487021 1092 7861 D AudioALSADeviceConfigManager: ApplyDeviceTurnonSequenceByName() DeviceName = builtin_Mic_DualMic descriptor->DeviceStatusCounte = 0, Ctlsize=16 09-28 13:13:27.487251 4173 5216 D OplusAtlas.OplusAudioRecordInfoUploadHelper: setRecordEvent pid:5061 session:2081 09-28 13:13:27.487289 4173 5216 D OplusAtlas.OplusAudioRecordInfoUploadHelper: new AudioRecordInfo session:2081 09-28 13:13:27.487519 1092 7861 D AudioALSAHardwareResourceManager: -startInputDevice_l(), mInputDevice = 0x80000004, mStartInputDeviceCount = 1 09-28 13:13:27.487988 1895 3204 I OplusHansManager : unfreeze uid: 99910372 com.instagram.android pids: [2114] reason: W_AsyncBinder scene: LcdOn 09-28 13:13:27.488481 1895 4064 I OStatsManager_OplusBatteryStatsManager: updateStateTime: PkgName = com.instagram.android, uid = 99910372, state to bg, mForegroundCnt = 0, isFg = false 09-28 13:13:27.488538 1895 3201 I OplusHansManager : uid=99910372, pkg=com.instagram.android F exit(), F stay=177, reason=W_AsyncBinder, FrozenActionKeepProxy=false 09-28 13:13:27.488607 1895 4064 D OStatsManager_OplusBatteryStatsManager: notePkgUnFrozenInner uid = 99910372, pkgName = com.instagram.android 09-28 13:13:27.488676 1895 3204 I OplusHansManager : forceUnfreezeApp uid= 99910372 unfreezeForKernel: W_AsyncBinder false 09-28 13:13:27.488755 1895 3207 I OplusHansManager : up_BC uid=99910372 pkg=com.instagram.android 09-28 13:13:27.488813 1895 3207 I OplusBinderProxy: proxyBinder uid: 99910372 pkg: com.instagram.android proxy: false calling: OFreezer 09-28 13:13:27.488831 1895 3207 D OplusHansManager : Restore alarm is disabled. 09-28 13:13:27.488900 1895 3204 I OplusHansManager : forceUnfreezeApp uid= 99910372 unfreezeForKernel: W_AsyncBinder false 09-28 13:13:27.489310 1895 3204 I OplusHansManager : forceUnfreezeApp uid= 99910372 unfreezeForKernel: W_AsyncBinder false 09-28 13:13:27.490051 1197 16718 D AudioBoost: audioAppKeyThreadReport() pid 5061, tid 7857, enable 1, inUid 1, eventIt -1, threadType 0, id 299 09-28 13:13:27.490120 1197 16718 D AudioBoost: appThreadInfo update:start 7857, write -1, cbk 7858 read -1 09-28 13:13:27.490130 1197 16718 D AudioBoost: audioAppKeyThreadReport(), restore boost for threadType 0, tid 7857 09-28 13:13:27.490192 1197 16718 D AudioBoost: audioAppKeyThreadReport(), restore boost for threadType 2, tid 7858 09-28 13:13:27.490524 5061 7857 I AudioRecord: start(282): return status 0 09-28 13:13:27.490618 1895 4921 D AudioService.RecordingActivityMonitor: recorderEvent, event = 0 09-28 13:13:27.491659 23473 23969 I ahue : Process query connecting 09-28 13:13:27.491769 23473 23719 I ahue : (REDACTED) Send ProcessQuery initial with query type: %s 09-28 13:13:27.491898 5061 7857 I dmls : #audio# start audio buffering 09-28 13:13:27.492429 23473 23719 I ahue : (REDACTED) Send ProcessQuery initial with s3Connection and enableManualEndpointing: %s for queryTriggerType: %s, supportedUiSource: %s 09-28 13:13:27.492786 23473 23719 I ahue : Send ProcessQuery initial with blocking session 09-28 13:13:27.495011 1197 1516 D AudioBoost: startBoostForWake mId 299, p 5061, t 7857, wp 5061, wt 7857. 09-28 13:13:27.495091 1197 1516 D AudioBoost: audioSchedBoost, pid=5061, tid=7857, enable=1, ret=0 09-28 13:13:27.496051 5061 5142 I dmwv : (REDACTED) #audio# starting listening client(%s) route(%s) took %d(ms) 09-28 13:13:27.496420 2114 2356 E MvfstCallbacks.cpp: readError: streamid=0; error=LocalError: Idle timeout, Idle timeout, num non control streams: 5 09-28 13:13:27.496622 2114 2356 E MvfstCallbacks.cpp: readError: streamid=3; error=LocalError: Idle timeout, Idle timeout, num non control streams: 5 09-28 13:13:27.497661 5061 5145 I dmwv : (REDACTED) #audio# AudioRequestListeningSession start listening status: %s 09-28 13:13:27.498074 1092 7861 D AudioALSAPlaybackHandlerKTVThread: openKTV2(), ktvapppid = 10129, ktvfgpid = 0,input_device:80000004,voip:0, reverbStatus:0 09-28 13:13:27.498101 1092 7861 D AudioALSAPlaybackHandlerKTVThread: +setinputActive(), pre_active_num = 0, start_input = 2147483652 09-28 13:13:27.498113 1092 7861 D OplusAudioALSACaptureDataProviderBase: calculateMuteSize muteTime = 120, mMuteSize = 46080 09-28 13:13:27.498122 1092 7861 D OplusAudioALSACaptureDataProviderBase: calculateFadeInSize fadeInTime = 60, mFadeInSize = 23040 mStep = 0.000174, audio_format(0x4) 09-28 13:13:27.498127 1092 7861 D AudioALSACaptureDataProviderNormal: open(-) 09-28 13:13:27.498135 1092 7861 D AudioALSACaptureDataClientAurisysNormal: mLatency 20, mRawDataPeriodBufSize 7680, mProcessedDataPeriodBufSize 640, mEchoRefDataPeriodBufSize 0, stream_attribute_target->audio_format = 1 mStreamAttributeSource->audio_format = 4 09-28 13:13:27.498142 1092 7861 D AudioMTKGainController: +SetCaptureGain(), mode=0, source=6, input device=0x80000004, output device=0x2 09-28 13:13:27.498364 1092 7861 D AudioALSACaptureDataClientAurisysNormal: CreateAurisysLibManager(), voip: 0, HDR record: 0,low_latency: 0, aec: 0, input_source: 6, flag: 0x0 => mAurisysScenario: 3 09-28 13:13:27.498402 1092 7861 D AudioALSAHardware: UpdateSceneToAurisys(), mInputScence = 0, mMultiRecordScene = 0 09-28 13:13:27.498419 1092 7861 D aurisys_utility: input dev: 0x80000004, fmt = 0x4, fs: 48000, max fs: 48000, ch: 2, max ch: 2, ch maks: 0xc, hw_info_mask: 0x0; output dev: 0x2, fmt = 0x0, fs: 0, max fs: 48000, ch: 0, max ch: 2, ch maks: 0x0, hw_info_mask: 0x4; task_scene: 3, audio_mode: 0, stream_type: 0, output_flags: 0x0, input_source: 6, input_flags: 0x0; network_info: 0, enhancement_feature_mask: 0x0 09-28 13:13:27.498434 1092 7861 D AudioUtility: setupCustomInfoStr(), custom_info = "SetAudioCustomScene=;MTK_REC_AINR=false;", (scene = , vol_level = -1, bt_codec = -1) 09-28 13:13:27.498491 1092 7861 D aurisys_utility: lib, working fs: 48000, fmt: 0x4, frame = 20, b_interleave = 0, num_ul_ref_buf_array = 0, num_dl_ref_buf_array = 0 09-28 13:13:27.498497 1092 7861 D aurisys_utility: ul in[type:0], ch: 2, ch_mask: 0xc, buf fs: 48000, buf content fs: 48000, fmt: 0x4; ul out[type:1], ch: 2, ch_mask: 0xc, buf fs: 48000, buf content fs: 48000, fmt: 0x4 09-28 13:13:27.498542 1092 7861 D android.hardware.audio.service.mediatek: App_table: 4 09-28 13:13:27.498546 1092 7861 D android.hardware.audio.service.mediatek: categoryPath = Scene,Default,Application,VR,Profile,Handset, custom_scene = Default 09-28 13:13:27.498576 1092 7861 D android.hardware.audio.service.mediatek: RECORD_PARAM_EXT IS NULL! 09-28 13:13:27.498667 1092 7861 D aurisys_lib_handler: aurisys_arsi_parsing_param_file(), gProductInfo "platform=MT6835,device=RE60AFL1,model=RMX5078", file_path "/odm/etc/audio/audio_param/Speech_AudioParam.xml", enhancement_mode 0, param_buf_size 4716, data_size 4716, custom_info SetAudioCustomScene=;MTK_REC_AINR=false; 09-28 13:13:27.499562 1197 1197 D AudioFlingerExtImpl: getRecordInfo result=6,1,10,16000 09-28 13:13:27.500826 5061 5142 I dmvu : #audio# reportMicUpdate 09-28 13:13:27.502423 1092 7861 D aurisys_lib_handler: aurisys_arsi_create_handler(), lib_name mtk_speech_enh, 0xb400007d4f01a800, memory_size 3948384, arsi_handler 0xb400007d36e00000, retval 0x0 09-28 13:13:27.502503 1092 7861 D aurisys_lib_manager: UL Lib, lib_name mtk_speech_enh, 0xb400007d4f01a800, sample_rate: 48000 => 48000, num_channels: 2 => 2, audio_format: 0x4 => 0x4, interleave: 1 => 0, frame: 0 => 20 09-28 13:13:27.502517 1092 7861 D aurisys_lib_manager: UL out, sample_rate: 48000 => 16000, num_channels: 2 => 1, audio_format: 0x4 => 0x1, interleave: 0 => 1, frame: 20 => 0 09-28 13:13:27.502716 5061 5145 I dmga : (REDACTED) #audio# registering receiver(%s), range(offset=%d, minimal=%s), buffer(%s) 09-28 13:13:27.502741 1092 7861 D MtkAudioChannelConvertInC: InitMtkAudioChannelConverterInC 09-28 13:13:27.502902 1092 7861 D aurisys_lib_handler: lib_name mtk_speech_enh, 0xb400007d4f01a800, set ul_analog_gain_ref_only 48, ul_digital_gain 48, retval 0 09-28 13:13:27.502948 1092 7861 W aurisys_controller: EXCHG not found for any <library>!! return fail!! 09-28 13:13:27.503015 2114 2332 W RealtimeClientManager: Channel state: MqttChannelState{mConnectionState=DISCONNECTED, mDisconnectionReason=null, mLastConnectionMs=220200453, mLastDisconnectMs=220387607} 09-28 13:13:27.503080 23473 23777 I dmru : #audio# start listening status received from remote 09-28 13:13:27.503209 1092 7861 D AudioALSACaptureDataClientAurisysNormal: AudioALSACaptureDataClientAurisysNormal(-), mDropMs = 60, mDropPopSize = 1920 09-28 13:13:27.503235 1092 7861 D AudioALSACaptureHandlerNormal: -open() 09-28 13:13:27.503251 1092 7861 D AudioALSAStreamIn: open(), Set RawStartFrameCount = 0 09-28 13:13:27.503294 1092 7861 D AudioALSAStreamIn: openWavDump(), mDumpFile is NULL 09-28 13:13:27.503989 1197 1516 D AudioBoost: startBoostForWake mId 299, p 5061, t 7858, wp 5061, wt 7858. 09-28 13:13:27.504084 5061 5120 I dnqr : (REDACTED) #audio# audio request client(token(%d)) session(token(%d)) start listening status(%s) 09-28 13:13:27.504169 1197 1516 D AudioBoost: audioSchedBoost, pid=5061, tid=7858, enable=1, ret=0 09-28 13:13:27.504400 2114 2356 E MvfstCallbacks.cpp: readError: streamid=7; error=LocalError: Idle timeout, Idle timeout, num non control streams: 5 09-28 13:13:27.504502 2114 2356 E MvfstCallbacks.cpp: readError: streamid=11; error=LocalError: Idle timeout, Idle timeout, num non control streams: 5 09-28 13:13:27.504511 23473 23777 I amvs : (REDACTED) Audio session opened, streaming audio with config %s... 09-28 13:13:27.504555 2114 2356 E MvfstCallbacks.cpp: readError: streamid=4; error=LocalError: Idle timeout, Idle timeout, num non control streams: 5 09-28 13:13:27.504648 2114 2356 E MvfstCallbacks.cpp: onConnectionError: error=LocalError: Idle timeout, Idle timeout, num non control streams: 5 09-28 13:13:27.504834 1092 7869 D AudioALSACaptureDataProviderNormal: +readThread(), pid: 1092, tid: 7869, kReadBufferSize=0x1e00, open_index=5, UPLINK_SET_AMICDCC_BUFFER_TIME_MS = 80, counter=1 09-28 13:13:27.504854 1092 7869 D AudioALSACaptureDataProviderBase: pcm_start 09-28 13:13:27.504868 2114 2114 D InputMethodDumpHelper: handleDump [log, always, 1] 09-28 13:13:27.505264 2114 2114 D OplusInputMethodUtil: update sDebug to true, update sDebugIme to true, update sAlwaysOn to true 09-28 13:13:27.505379 2114 2114 D OplusInputMethodUtil: updateDebugToClass InputMethodManager.DEBUG = true 09-28 13:13:27.505358 1133 3309 E PerformanceService: [WAKER_IDENTIFY] pid message 7858;1;1 is writen to proc 09-28 13:13:27.505398 2114 2356 E MvfstCallbacks.cpp: writeChain error: Connection closed 09-28 13:13:27.505429 2114 2114 D OplusInputMethodUtil: updateDebugToClass ImeFocusController.DEBUG = true 09-28 13:13:27.505461 2114 2114 D OplusInputMethodUtil: updateDebugToClass OnBackInvokedDispatcher.DEBUG = true 09-28 13:13:27.505484 2114 2114 D OplusInputMethodUtil: updateDebugToClass InsetsController.DEBUG = true 09-28 13:13:27.505510 2114 2114 D OplusInputMethodUtil: updateDebugToClass BaseInputConnection.DEBUG = true 09-28 13:13:27.505545 2114 2356 E MvfstCallbacks.cpp: writeChain error: Connection closed 09-28 13:13:27.506012 1197 1516 D AudioBoost: audioWakeTracing setWakeSeedThread end, pid 5061, tid 7858, inUid 1, id 299, isWakee 1, -> handle = 2717. 09-28 13:13:27.504909 23473 23777 I amye : Sending InitializeRequest 09-28 13:13:27.507445 23473 23775 I amvs : Start streaming main mic audio... 09-28 13:13:27.508167 23473 23969 I dmga : (REDACTED) #audio# registering receiver(%s), range(offset=%d, minimal=%s), buffer(%s) 09-28 13:13:27.508455 2114 2255 E MQTTBypassDGWStreamGroupCallbacks.cpp: onStreamGroupError TransientError domain: MNSQUICConnection code: 1 detail: Idle timeout, num non control streams: 5 09-28 13:13:27.508739 23473 23777 I amye : (REDACTED) getInitialS3Request: audioConfig=%s 09-28 13:13:27.508757 2114 2255 W MQTTBypassDGWStreamGroupConnection.cpp: Restarting due to reason: StreamError 09-28 13:13:27.508809 1243 1243 I OplusRequestedLayerState: setFlags sequence=7208, flags[0x00000000], mask[0x00000001], newFlags[0x00000001], name=Sprite#7208 09-28 13:13:27.511482 2114 2294 W LibevQuicAsyncUDPSocket.h: setTosOrTrafficClass not implemented in LibevQuicAsyncUDPSocket 09-28 13:13:27.512236 2114 2124 W FastPrintWriter: Write failure java.io.IOException: write failed: EPIPE (Broken pipe) at libcore.io.IoBridge.write(IoBridge.java:651) at java.io.FileOutputStream.write(FileOutputStream.java:436) at com.android.internal.util.FastPrintWriter.flushBytesLocked(FastPrintWriter.java:355) at com.android.internal.util.FastPrintWriter.flushLocked(FastPrintWriter.java:378) at com.android.internal.util.FastPrintWriter.flush(FastPrintWriter.java:413) at android.os.Binder.dump(Binder.java:1077) at android.os.Binder.onTransact(Binder.java:945) at com.android.internal.inputmethod.IInputMethodClient$Stub.onTransact(IInputMethodClient.java:276) at android.os.Binder.execTransactInternal(Binder.java:1444) at android.os.Binder.execTransact(Binder.java:1378) Caused by: android.system.ErrnoException: write failed: EPIPE (Broken pipe) at libcore.io.Linux.writeBytes(Native Method) at libcore.io.Linux.write(Linux.java:336) at libcore.io.ForwardingOs.write(ForwardingOs.java:948) at libcore.io.BlockGuardOs.write(BlockGuardOs.java:448) at libcore.io.ForwardingOs.write(ForwardingOs.java:948) at libcore.io.IoBridge.write(IoBridge.java:646) ... 9 more 09-28 13:13:27.514011 17128 17128 D OplusBluetoothWearCheck: receive action: android.media.ACTION_AUDIO_RECORD_START 09-28 13:13:27.515866 1895 1895 D InputMethodDumpHelper: handleDump [log, always, 1] 09-28 13:13:27.516480 1895 1895 D OplusInputMethodUtil: update sDebug to true, update sDebugIme to true, update sAlwaysOn to true 09-28 13:13:27.516555 1895 1895 D OplusInputMethodUtil: updateDebugToClass InputMethodManager.DEBUG = true 09-28 13:13:27.516581 1895 1895 D OplusInputMethodUtil: updateDebugToClass ImeFocusController.DEBUG = true 09-28 13:13:27.515759 4173 5216 D OplusAtlasService: isAppInRecording result :true 09-28 13:13:27.516605 1895 1895 D OplusInputMethodUtil: updateDebugToClass OnBackInvokedDispatcher.DEBUG = true 09-28 13:13:27.516628 1895 1895 D OplusInputMethodUtil: updateDebugToClass InsetsController.DEBUG = true 09-28 13:13:27.516648 1895 1895 D OplusInputMethodUtil: updateDebugToClass BaseInputConnection.DEBUG = true 09-28 13:13:27.518756 1895 2736 D Osense-ResourceCallback: onReceive:android.media.ACTION_AUDIO_RECORD_START 09-28 13:13:27.518919 1895 2736 D Osense-ResourceCallback: handleAudioRecordChange...uid:10129, pkgName:com.google.android.googlequicksearchbox, isAdded:true 09-28 13:13:27.519041 3170 3170 D SubsysBroadcastManager: onReceive action:android.media.ACTION_AUDIO_RECORD_START 09-28 13:13:27.519068 1895 2736 D Osense-CleanPolicy: notifyAppStatus:IntegratedData{mResId=18, mTime=1759045407519, mInfo=Bundle[{pkgName=com.google.android.googlequicksearchbox, pid=5061, uid=10129, isAdded=true}]} 09-28 13:13:27.519087 3170 3170 D OSService: onAudioRecordChange 09-28 13:13:27.519178 1895 4884 D AS.AudioService: handleRecordingConfigurationChanged: event = 2 ,sampleRate = 16000 ,uid = 10129 ,source = 6 ,device = 15 09-28 13:13:27.519221 1895 2736 D Osense-AppCompactPolicy: notifyAppStatus:IntegratedData{mResId=18, mTime=1759045407519, mInfo=Bundle[{pkgName=com.google.android.googlequicksearchbox, pid=5061, uid=10129, isAdded=true}]} 09-28 13:13:27.519270 1895 2736 D Osense-OfreezerPolicy: notifyAppStatus:IntegratedData{mResId=18, mTime=1759045407519, mInfo=Bundle[{pkgName=com.google.android.googlequicksearchbox, pid=5061, uid=10129, isAdded=true}]} 09-28 13:13:27.519335 3170 3170 D SysBroadcastReceiver: android.media.ACTION_AUDIO_RECORD_START 09-28 13:13:27.519372 1895 2736 D Osense-AppCpuLimitPolicy: notifyAppStatus:IntegratedData{mResId=18, mTime=1759045407519, mInfo=Bundle[{pkgName=com.google.android.googlequicksearchbox, pid=5061, uid=10129, isAdded=true}]} 09-28 13:13:27.519407 3170 3170 D SysBroadcastReceiver: EventId=1010001 ID_AUDIO_RECORD_START TimeStamp =1759045407519 Intent =Intent { act=android.media.ACTION_AUDIO_RECORD_START flg=0x4000010 xflg=0x4 (has extras) } Content =null Pid =0 PkgName =null 09-28 13:13:27.519500 1895 2736 D Osense-OGuardPolicy: notifyAppStatus:IntegratedData{mResId=18, mTime=1759045407519, mInfo=Bundle[{pkgName=com.google.android.googlequicksearchbox, pid=5061, uid=10129, isAdded=true}]} 09-28 13:13:27.519782 1895 4047 D OGuardManager_WeakAwareManager: updateAppStatus uid:10129 start:true type:10 09-28 13:13:27.519847 3170 17696 D SystemState: noteAudioInStart: pid = 5061, uid = 10129 09-28 13:13:27.519892 1895 1980 D QosSceneRecognizer: notifyRecordStatusChanged uid: 10129, pid: 5061, isOn: true 09-28 13:13:27.519939 1895 4047 I OGuardManager_WeakAwareManager: stop uid:10129 type:AudioRecorder mRunning:false duration:0 09-28 13:13:27.520017 1895 1980 D QosSceneRecognizer[AudioScene]: [10129, 5061, true, record] 09-28 13:13:27.520052 3170 17696 I ConferenceScene: audioRecordStateChanged 5061 10129 true 09-28 13:13:27.520152 1895 1980 I QosSceneRecognizer[AudioScene]: onSceneChangeNotify:Bundle[{reason=record, package=com.google.android.googlequicksearchbox, process=com.google.android.googlequicksearchbox:interactor, pid=5061, uid=10129, begin=true}] 09-28 13:13:27.520190 3170 17696 I VideoCallScene: isInVideoCall, mIsVoiceCall = false, mIsActivityVoiceCall = false, mActivityVoiceCallUid = -1, mVoiceCallPkg = , mVoiceCallUid = -1, cameraUid = -1, mIsVideoPlay = false 09-28 13:13:27.520273 1895 1980 I QosSceneRecognizer: onSceneStateChange: sceneId 5 uid 10129 pid 5061 type 0 reason record 09-28 13:13:27.520319 1895 1980 D QosScheduler[QoSPolicy]: onAudioScene begin=true,pkgName=com.google.android.googlequicksearchbox,uid=10129,pid=5061,type=0 09-28 13:13:27.520342 1895 1980 W QosScheduler: executeSceneQosStrategy failed! qos feature no enable 09-28 13:13:27.520482 1895 1980 I QosSceneRecognizer[VideoCallScene]: notifySceneState, audio record start = true 09-28 13:13:27.520581 3158 3497 D DataLimitControl: onRecordingConfigChanged: mRecordingsApps = [10129] 09-28 13:13:27.520653 1895 1980 I QosSceneRecognizer[VideoCallScene]: isInVideoCall, mIsInVoiceCall = false,mVoiceCallPkg =null,mVoiceCallUid=0, cameraUid = 0 09-28 13:13:27.520722 1895 1980 I QosSceneRecognizer[VideoCallScene]: isInVideoCall = false hasState = false 09-28 13:13:27.520779 1895 1980 D QosSceneRecognizer[VideoScene]: [true, 10129, record] 09-28 13:13:27.521213 1092 7869 D OplusAudioALSAThreadSched: kernelVersion 515 09-28 13:13:27.521501 1092 7869 D OplusAudioALSAThreadSched: setAudioHalSchedToUx after setUx(pid:1092, tid:7869) 日志分析,Gemini应用程序中的语音命令有时没有响应
10-12
评论 6
成就一亿技术人!
拼手气红包6.0元
还能输入1000个字符
 
红包 添加红包
表情包 插入表情
 条评论被折叠 查看
添加红包

请填写红包祝福语或标题

红包个数最小为10个

红包金额最低5元

当前余额3.43前往充值 >
需支付:10.00
成就一亿技术人!
领取后你会自动成为博主和红包主的粉丝 规则
hope_wisdom
发出的红包
实付
使用余额支付
点击重新获取
扫码支付
钱包余额 0

抵扣说明:

1.余额是钱包充值的虚拟货币,按照1:1的比例进行支付金额的抵扣。
2.余额无法直接购买下载,可以购买VIP、付费专栏及课程。

余额充值