09-25 19:17:28.546 <6> [255067.774348] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 plat_1105:I]bfg_dev_pm_complete][hisi_bfgx][7464]-
09-25 19:17:28.546 <6> [255067.774540] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 [phcd][INFO][phcd_plat_complete]+
09-25 19:17:28.546 <6> [255067.774552] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 [phcd][INFO][phcd_plat_complete]-
09-25 19:17:28.546 <3> [255067.774793] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 sr_tickmark_complete
09-25 19:17:28.546 <6> [255067.774824] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 liblinux resume rollback end
09-25 19:17:28.546 <6> [255067.774915] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 [platform_pmops_resume:288] platform_pmops_resume
09-25 19:17:28.546 <6> [255067.775019] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 [hufs_resume:1419] hufs waiting for resumed
09-25 19:17:28.546 <6> [255067.775069] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 [suspend_trace:90] [PM_SR] action [thaw_system_processes] starts
09-25 19:17:28.546 <6> [255067.775093] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 [suspend_processes_dormancy:232] [PM_SR] system processes exit dormancy
09-25 19:17:28.546 <6> [255067.775166] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 [do_process_pm_dormancy_enter:568] do start pm dormancy enter at the 0 times
09-25 19:17:28.546 <6> [255067.778735] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 [do_process_pm_dormancy_enter:578] thaw thread cnt: 30
09-25 19:17:28.546 <6> [255067.778782] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 [process_pm_dormancy_enter:666] process exit dormancy success
09-25 19:17:28.546 <6> [255067.778801] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 [suspend_trace:90] [PM_SR] action [thaw_system_processes] ends
09-25 19:17:28.546 <6> [255067.778813] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 [suspend_trace:90] [PM_SR] action [thaw_system_wqs] starts
09-25 19:17:28.546 <6> [255067.778830] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 [resume_pm_action:349] [PM_SR] suspend-resume devices, action=23
09-25 19:17:28.546 <6> [255067.779158] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 [suspend_trace:90] [PM_SR] action [thaw_system_wqs] ends
09-25 19:17:28.546 <6> [255067.779177] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 [suspend_trace:90] [PM_SR] action [thaw_user_processes] starts
09-25 19:17:28.546 <6> [255067.779185] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 [suspend_processes_dormancy:232] [PM_SR] normal processes exit dormancy
09-25 19:17:28.546 <6> [255067.779206] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 [do_process_pm_dormancy_enter:568] do start pm dormancy enter at the 0 times
09-25 19:17:28.546 <6> [255067.787832] -;[2] pid=990 tid=1275 comm=OS_FFRT_2_1 [CAMERA]INFO: enter cam_sync_ioctl cmd: 0x81005305
09-25 19:17:28.546 <6> [255067.793324] -;[7] pid=1344 tid=1361 comm=xlogcat [coul_merge]coul_merge_get_capacity soc 53
09-25 19:17:28.546 <6> [255067.793560] -;[7] pid=1344 tid=1361 comm=xlogcat [coul_hardware]cc_out=0xf552aed0,cc_in=0x2f81d3ea,cout_time=17431,cin_time=1716,cc_adj=1705855uah
09-25 19:17:28.546 <3> [255067.793689] -;[5] pid=1352 tid=1942 comm=riladapter_host [mod_reset]:[modem_reset_poll] modem_reset wait before
09-25 19:17:28.546 <6> [255067.793697] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [MPXX][I][WLAN_PM]sleep request send, gpio_205 = 1[wlan_pm_sleep_request:191]
09-25 19:17:28.546 <3> [255067.793704] -;[5] pid=1352 tid=1942 comm=riladapter_host [mod_reset]:[modem_reset_poll] modem_reset wait after
09-25 19:17:28.546 <3> [255067.793711] -;[5] pid=1352 tid=1942 comm=riladapter_host [mod_reset]:[modem_reset_poll] modem_reset wait after1
09-25 19:17:28.546 <3> [255067.793934] -;[5] pid=1352 tid=1942 comm=riladapter_host rdr_audio_notify_modem audio[E]:192: dsp reset wait before
09-25 19:17:28.546 <3> [255067.793938] -;[5] pid=1352 tid=1942 comm=riladapter_host rdr_audio_notify_modem audio[E]:194: dsp reset wait after
09-25 19:17:28.547 <6> [255067.794152] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_vote] DC:current: get vote eff_client=None
09-25 19:17:28.547 <6> [255067.794163] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_vote] DC:current: get vote eff_result=-22
09-25 19:17:28.547 <6> [255067.794178] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_vote] all clients information:
09-25 19:17:28.547 <6> [255067.794178] DC:current: type=Set_Min eff_result=-22 eff_client_name=None eff_id=-22
09-25 19:17:28.547 <6> [255067.794178] client:static_cccv: enabled=0 value=0
09-25 19:17:28.547 <6> [255067.794178] client:tbat: enabled=0 value=0
09-25 19:17:28.547 <6> [255067.794178] client:adpt: enabled=0 value=0
09-25 19:17:28.547 <6> [255067.794178] client:cable: enabled=0 value=0
09-25 19:17:28.547 <6> [255067.794178] client:cur_mode: enabled=0 value=0
09-25 19:17:28.547 <6> [255067.794178] client:time: enabled=0 value=0
09-25 19:17:28.547 <6> [255067.794178] client:thermal: enabled=0 value=0
09-25 19:17:28.547 <6> [255067.794178] client:battery_care: enabled=0 value=0
09-25 19:17:28.547 <6> [255067.794178] client:dynamic_cccv: enabled=0 value=0
09-25 19:17:28.547 <6> [255067.794178] client:balance: enabled=0 value=0
09-25 19:17:28.547 <6> [255067.794178] client:multi_ic: enabled=0 value=0
09-25 19:17:28.547 <6> [255067.794178] client:
09-25 19:17:28.547 <6> [255067.794183] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_vote] DC:ibus: get vote eff_client=None
09-25 19:17:28.547 <6> [255067.794187] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_vote] DC:ibus: get vote eff_result=-22
09-25 19:17:28.547 <6> [255067.794191] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_vote] all clients information:
09-25 19:17:28.547 <6> [255067.794191] DC:ibus: type=Set_Min eff_result=-22 eff_client_name=None eff_id=-22
09-25 19:17:28.547 <6> [255067.794195] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_vote] DC:cable_curr: get vote eff_client=client:cable_1st_res
09-25 19:17:28.547 <6> [255067.794198] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_vote] DC:cable_curr: get vote eff_result=12800
09-25 19:17:28.550 <6> [255067.794203] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_vote] all clients information:
09-25 19:17:28.550 <6> [255067.794203] DC:cable_curr: type=Set_Min eff_result=12800 eff_client_name=client:cable_1st_res eff_id=1
09-25 19:17:28.550 <6> [255067.794203] client:cable_type: enabled=0 value=0
09-25 19:17:28.550 <6> [255067.794203] client:cable_1st_res: enabled=1 value=12800
09-25 19:17:28.550 <6> [255067.794203] client:cable_2nd_res: enabled=0 value=0
09-25 19:17:28.551 <6> [255067.794208] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_vote] DC:adpt_curr: get vote eff_client=client:adpt_max_curr
09-25 19:17:28.551 <6> [255067.794211] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_vote] DC:adpt_curr: get vote eff_result=6600
09-25 19:17:28.551 <6> [255067.794216] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_vote] all clients information:
09-25 19:17:28.551 <6> [255067.794216] DC:adpt_curr: type=Set_Min eff_result=6600 eff_client_name=client:adpt_max_curr eff_id=3
09-25 19:17:28.551 <6> [255067.794216] client:adpt_iwatt: enabled=0 value=0
09-25 19:17:28.551 <6> [255067.794216] client:adpt_antifake: enabled=0 value=0
09-25 19:17:28.551 <6> [255067.794216] client:adpt_time: enabled=0 value=0
09-25 19:17:28.551 <6> [255067.794216] client:adpt_max_curr: enabled=1 value=6600
09-25 19:17:28.551 <6> [255067.794220] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_vote] BATT:fcc: get vote eff_client=None
09-25 19:17:28.551 <6> [255067.794223] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_vote] BATT:fcc: get vote eff_result=-22
09-25 19:17:28.551 <6> [255067.794227] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_vote] all clients information:
09-25 19:17:28.551 <6> [255067.794227] BATT:fcc: type=Set_Min eff_result=-22 eff_client_name=None eff_id=-22
09-25 19:17:28.551 <6> [255067.794230] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_vote] BATT:usb_icl: get vote eff_client=None
09-25 19:17:28.551 <6> [255067.794233] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_vote] BATT:usb_icl: get vote eff_result=-22
09-25 19:17:28.551 <6> [255067.794238] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_vote] all clients information:
09-25 19:17:28.551 <6> [255067.794238] BATT:usb_icl: type=Set_Min eff_result=-22 eff_client_name=None eff_id=-22
09-25 19:17:28.551 <6> [255067.794241] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_vote] BATT:vterm: get vote eff_client=None
09-25 19:17:28.551 <6> [255067.794244] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_vote] BATT:vterm: get vote eff_result=-22
09-25 19:17:28.551 <6> [255067.794248] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_vote] all clients information:
09-25 19:17:28.551 <6> [255067.794248] BATT:vterm: type=Set_Min eff_result=-22 eff_client_name=None eff_id=-22
09-25 19:17:28.551 <6> [255067.794251] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_vote] BATT:iterm: get vote eff_client=None
09-25 19:17:28.551 <6> [255067.794254] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_vote] BATT:iterm: get vote eff_result=-22
09-25 19:17:28.551 <6> [255067.794258] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_vote] all clients information:
09-25 19:17:28.551 <6> [255067.794258] BATT:iterm: type=Set_Max eff_result=-22 eff_client_name=None eff_id=-22
09-25 19:17:28.551 <6> [255067.794262] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_vote] BATT:dis_chg: get vote eff_client=None
09-25 19:17:28.551 <6> [255067.794265] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_vote] BATT:dis_chg: get vote eff_result=0
09-25 19:17:28.551 <6> [255067.794283] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_vote] all clients information:
09-25 19:17:28.551 <6> [255067.794283] BATT:dis_chg: type=Set_Any eff_result=0 eff_client_name=None eff_id=-22
09-25 19:17:28.551 <6> [255067.794306] -;[7] pid=1344 tid=1361 comm=xlogcat [coul_hardware]coul_get_tbat code 1154, tbat 34
09-25 19:17:28.551 <3> [255067.794310] -;[7] pid=1344 tid=1361 comm=xlogcat [E/batt_temp_fit] g_btf_dev is null
09-25 19:17:28.551 <6> [255067.794324] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_temp] sensor:bat0_raw_temp, samples[0]:34000
09-25 19:17:28.551 <6> [255067.794337] -;[7] pid=1344 tid=1361 comm=xlogcat [coul_hardware]coul_get_tbat code 1154, tbat 34
09-25 19:17:28.551 <3> [255067.794351] -;[7] pid=1344 tid=1361 comm=xlogcat [E/batt_temp_fit] g_btf_dev is null
09-25 19:17:28.551 <6> [255067.794354] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_temp] sensor:bat0_raw_temp, samples[1]:34000
09-25 19:17:28.551 <6> [255067.794366] -;[7] pid=1344 tid=1361 comm=xlogcat [coul_hardware]coul_get_tbat code 1154, tbat 34
09-25 19:17:28.551 <3> [255067.794369] -;[7] pid=1344 tid=1361 comm=xlogcat [E/batt_temp_fit] g_btf_dev is null
09-25 19:17:28.551 <6> [255067.794371] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_temp] sensor:bat0_raw_temp, samples[2]:34000
09-25 19:17:28.551 <3> [255067.794376] -;[7] pid=1344 tid=1361 comm=xlogcat [E/batt_temp_fit] g_btf_dev is null
09-25 19:17:28.551 <6> [255067.794410] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_algo] refer:143, without_comp:34000, with_comp:34000
09-25 19:17:28.551 <6> [255067.794432] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_algo] current_comp:34000, c_comp:34000, c_raw:34000, l_comp:34000, l_raw:34000
09-25 19:17:28.551 <6> [255067.794435] -;[7] pid=1344 tid=1361 comm=xlogcat [I/btb_temp] sensor:0, raw:34000, temp:34000
09-25 19:17:28.551 <6> [255067.794439] -;[7] pid=1344 tid=1361 comm=xlogcat [I/btb_temp] temp_sync0 temp:34000
09-25 19:17:28.551 <6> [255067.794453] -;[7] pid=1344 tid=1361 comm=xlogcat [coul_hardware]coul_get_tbat code 1154, tbat 34
09-25 19:17:28.551 <3> [255067.794455] -;[7] pid=1344 tid=1361 comm=xlogcat [E/batt_temp_fit] g_btf_dev is null
09-25 19:17:28.551 <6> [255067.794459] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_temp] sensor:bat0_raw_temp, samples[0]:34000
09-25 19:17:28.551 <6> [255067.794473] -;[7] pid=1344 tid=1361 comm=xlogcat [coul_hardware]coul_get_tbat code 1154, tbat 34
09-25 19:17:28.551 <3> [255067.794476] -;[7] pid=1344 tid=1361 comm=xlogcat [E/batt_temp_fit] g_btf_dev is null
09-25 19:17:28.551 <6> [255067.794479] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_temp] sensor:bat0_raw_temp, samples[1]:34000
09-25 19:17:28.551 <6> [255067.794492] -;[7] pid=1344 tid=1361 comm=xlogcat [coul_hardware]coul_get_tbat code 1154, tbat 34
09-25 19:17:28.551 <3> [255067.794495] -;[7] pid=1344 tid=1361 comm=xlogcat [E/batt_temp_fit] g_btf_dev is null
09-25 19:17:28.551 <6> [255067.794499] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_temp] sensor:bat0_raw_temp, samples[2]:34000
09-25 19:17:28.551 <3> [255067.794502] -;[7] pid=1344 tid=1361 comm=xlogcat [E/batt_temp_fit] g_btf_dev is null
09-25 19:17:28.551 <6> [255067.794519] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_algo] refer:143, without_comp:34000, with_comp:34000
09-25 19:17:28.551 <6> [255067.794523] -;[7] pid=1344 tid=1361 comm=xlogcat [I/power_algo] current_comp:34000, c_comp:34000, c_raw:34000, l_comp:34000, l_raw:34000
09-25 19:17:28.551 <6> [255067.794526] -;[7] pid=1344 tid=1361 comm=xlogcat [I/btb_temp] sensor:0, raw:34000, temp:34000
09-25 19:17:28.551 <6> [255067.794529] -;[7] pid=1344 tid=1361 comm=xlogcat [I/btb_temp] temp_sync0 temp:34000
09-25 19:17:28.551 <6> [255067.796481] -;[5] pid=1402 tid=1431 comm=shs [iomcu_link_ipc_send] [0x8ab01] [0xabf48b] tag[0x8b],cmd[0xf4] lvl 1 resp 0 ver 0 tranid 171 shmem 0 len 8
09-25 19:17:28.551 <6> [255067.796658] -;[6] pid=1402 tid=1431 comm=shs [I/sensorhub] update_sensor_info: tag 139 cmd 244
09-25 19:17:28.551 <6> [255067.796933] -;[4] pid=89 tid=33638 comm=kworker/u25:12 [iomc_tcp_amsm_recv_handler]tag[0x8b]cmd[0xf5]len[12]
09-25 19:17:28.551 <6> [255067.797168] -;[1] pid=89 tid=33634 comm=kworker/u25:2 [MPXX][I][WLAN_PM]wifi sleep cmd send, pkt_num:[0][wlan_pm_sleep_cmd_send:2029]
09-25 19:17:28.551 <6> [255067.797919] -;[2] pid=1344 tid=1361 comm=xlogcat [I/bq25970] IBUS_ADC=0x0
09-25 19:17:28.551 <6> [255067.798067] -;[1] pid=89 tid=33634 comm=kworker/u25:2 [PCIE][INFO]pcie monitor enable value 0x0[oal_pcie_monior_enable:81]
09-25 19:17:28.551 <6> [255067.798086] -;[1] pid=89 tid=33634 comm=kworker/u25:2 [PCIE][INFO]link_state change from workup to linkup[oal_pcie_change_link_state:932]
09-25 19:17:28.551 <4> [255067.798096] -;[1] pid=89 tid=33634 comm=kworker/u25:2 [PCIE][WARN]consume 688 us[oal_pcie_sleep_request:1531]
09-25 19:17:28.551 <6> [255067.798106] -;[1] pid=89 tid=33634 comm=kworker/u25:2 plat_1105:I]board_host_wakeup_dev_set_mp]host_wakeup_wlan set low
09-25 19:17:28.551 <6> [255067.798130] -;[1] pid=89 tid=33634 comm=kworker/u25:2 [pcie_kport][INF]:pcie_kport_refclk_device_vote: 0 rc_id: 0 ep_type: 0
09-25 19:17:28.551 <6> [255067.798142] -;[1] pid=89 tid=33634 comm=kworker/u25:2 [MPXX][I][WLAN_PM]wifi not have traffic, sleep not delay, gpio_205 = 0[wlan_pm_sleep_cmd_proc:2183]
09-25 19:17:28.551 <6> [255067.798617] -;[1] pid=1344 tid=1361 comm=xlogcat [I/bq25970] VBUS_ADC=0x0
09-25 19:17:28.551 <6> [255067.800198] -;[2] pid=1344 tid=1361 comm=xlogcat [I/bq25970] IBAT_ADC=0xfddb
09-25 19:17:28.551 <6> [255067.801812] -;[2] pid=640 tid=33099 comm=OS_FFRT_2_33458 thermal ioctl cmd:0x7
09-25 19:17:28.557 <6> [255067.801951] -;[3] pid=1344 tid=1361 comm=xlogcat [I/bq25970] VAC_ADC=0x0
09-25 19:17:28.557 <6> [255067.805074] -;[1] pid=1344 tid=1361 comm=xlogcat [I/bq25970] VOUT_ADC=0xf20
09-25 19:17:28.557 <6> [255067.805761] -;[3] pid=1344 tid=1361 comm=xlogcat [I/bq25970] TDIE_ADC=0x0
09-25 19:17:28.557 <6> [255067.806595] -;[2] pid=1344 tid=1361 comm=xlogcat [I/bq25970] VBAT_ADC=0xf29
09-25 19:17:28.557 <6> [255067.807188] -;[3] pid=1344 tid=1361 comm=xlogcat [I/bq25970] VBAT_ADC=0xf29
09-25 19:17:28.557 <3> [255067.807888] -;[3] pid=1344 tid=1361 comm=xlogcat [hisi_scharger][hi6526_get_chip_temp]get chip fail,ret:-1
09-25 19:17:28.558 <6> [255067.810254] -;[4] pid=1378 tid=1973 comm=OS_IPC_1_1416 [batt_info][batt_info_get_property] batt[0] name battery_gauge, val 340
09-25 19:17:28.558 <6> [255067.839311] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 [do_process_pm_dormancy_enter:578] thaw thread cnt: 3745
09-25 19:17:28.558 <6> [255067.839346] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 [process_pm_dormancy_enter:666] process exit dormancy success
09-25 19:17:28.558 <6> [255067.839375] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 [suspend_trace:90] [PM_SR] action [thaw_user_processes] ends
09-25 19:17:28.558 <6> [255067.839501] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 [suspend_pm_action:316] [PM_SR] suspend-resume devices, action=10
09-25 19:17:28.558 <6> [255067.839555] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 plat_1105:I]board_pm_notify_handler]mode[4][1:hiber;2:restore;3:suspend;4:resume]
09-25 19:17:28.558 <6> [255067.839571] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 plat_1105:I]board_pm_notify_chain_call]resume call board_pm_nb, priority 0
09-25 19:17:28.558 <6> [255067.839581] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 plat_1105:I]board_pm_resume]+
09-25 19:17:28.558 <6> [255067.839666] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 plat_1105:I]board_pm_resume]-
09-25 19:17:28.558 <6> [255067.839696] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 plat_1105:I]board_pm_notify_chain_call]resume call wlan_pm_nb, priority 0
09-25 19:17:28.558 <6> [255067.839716] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 plat_1105:I]board_pm_notify_chain_call]resume call bfg_pm_nb_0, priority 0
09-25 19:17:28.558 <6> [255067.839736] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 plat_1105:I]board_pm_notify_chain_call]resume call bfg_pm_nb_1, priority 0
09-25 19:17:28.559 <6> [255067.839768] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 plat_1105:I]board_pm_notify_chain_call]resume call wifi_pm_node, priority 1
09-25 19:17:28.559 <6> [255067.840893] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 update_lpm3_vote_info_resume +
09-25 19:17:28.559 <3> [255067.840939] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 vote id:0 src=78312698 incre=4430 dest=78317128
09-25 19:17:28.559 <3> [255067.840964] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 vote id:1 src=10546949 incre=553 dest=10547502
09-25 19:17:28.559 <3> [255067.841006] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 vote id:2 src=124 incre=0 dest=124
09-25 19:17:28.559 <3> [255067.841026] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 vote id:3 src=2773616 incre=3055 dest=2776671
09-25 19:17:28.559 <3> [255067.841063] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 vote id:4 src=0 incre=0 dest=0
09-25 19:17:28.559 <3> [255067.841088] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 vote id:5 src=0 incre=0 dest=0
09-25 19:17:28.559 <3> [255067.841111] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 vote id:6 src=0 incre=0 dest=0
09-25 19:17:28.559 <3> [255067.841130] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 vote id:7 src=105 incre=0 dest=105
09-25 19:17:28.559 <3> [255067.841159] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 vote id:8 src=0 incre=0 dest=0
09-25 19:17:28.559 <3> [255067.841193] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 vote id:9 src=0 incre=0 dest=0
09-25 19:17:28.559 <6> [255067.841210] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 update_lpm3_vote_info_resume -
09-25 19:17:28.559 <6> [255067.841342] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 [loadmonitor&freqdump]:dpmldm only for sc
09-25 19:17:28.559 <6> [255067.841375] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 [loadmonitor&freqdump]:loadmonitor resume +:status2, action:4
09-25 19:17:28.559 <6> [255067.841726] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 [loadmonitor&freqdump]:all_peri_clk_init en_flags:0X30016, end
09-25 19:17:28.559 <6> [255067.841990] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 [loadmonitor&freqdump]:sec_loadmonitor_peri_enable peri0 enable success, en_flags:0X30016, sample time:0x9e4f580
09-25 19:17:28.559 <6> [255067.842071] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 [loadmonitor&freqdump]:sec_loadmonitor_peri_enable peri1 enable success, en_flags:0X30016, sample time:0x9e4f580
09-25 19:17:28.559 <6> [255067.842098] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 [loadmonitor&freqdump]:sec_loadmonitor_switch_enable end. en_flags:0X30016, open sr ao monitor(no disable, no enable):1
09-25 19:17:28.559 <6> [255067.842121] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 [loadmonitor&freqdump]:loadmonitor resume -:status1, action:4
09-25 19:17:28.559 <6> [255067.842140] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 pm callback null!
09-25 19:17:28.559 <6> [255067.842253] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 mspc_apm_pm_callback: resume +
09-25 19:17:28.559 <6> [255067.842284] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 mspc_apm_pm_callback: resume -
09-25 19:17:28.559 <3> [255067.842364] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 sr_tick_pm_notify ap resume end
09-25 19:17:28.559 <6> [255067.842402] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 [I/sensorhub] resume in sensorhub_pm_notify
09-25 19:17:28.559 <6> [255067.842589] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 [I/IGS]resume in igs_pm_notify
09-25 19:17:28.559 <6> [255067.842618] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 [I/IGS]get igs_mutex in igs_pm_notify
09-25 19:17:28.559 <6> [255067.842650] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 socdsp_misc [I][4062075502]:sr_event:641: resume +
09-25 19:17:28.559 <6> [255067.842670] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 socdsp_misc [I][4062075502]:sr_event:643: resume -
09-25 19:17:28.560 <6> [255067.842738] -;[2] pid=89 tid=33638 comm=kworker/u25:12 create hisysevent succeed, domain=KERNEL_XPOWER, name=WAKE_STATUS, type=4
09-25 19:17:28.560 <6> [255067.842748] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 [calculate_resume_latency:126] [PM_SR] resume latency: 174 ms
09-25 19:17:28.560 <6> [255067.842800] -;[2] pid=89 tid=33638 comm=kworker/u25:12 total block size of hisysevent data is 179
09-25 19:17:28.560 <6> [255067.842890] -;[0] pid=1378 tid=12062 comm=OS_IPC_0_1415 [do_suspend_mem_enter:483] [PM_SR] do suspend to memory end: Success
09-25 19:17:28.560 <6> [255067.842905] -;[2] pid=89 tid=33638 comm=kworker/u25:12 create hisysevent succeed, domain=KERNEL_XPOWER, name=AP_WAKE_IRQ, type=4
09-25 19:17:28.560 <6> [255067.842945] -;[2] pid=89 tid=33638 comm=kworker/u25:12 total block size of hisysevent data is 110
09-25 19:17:28.560 <6> [255067.843042] -;[2] pid=89 tid=33638 comm=kworker/u25:12 create hisysevent succeed, domain=KERNEL_XPOWER, name=KERNEL_RESUME, type=4
09-25 19:17:28.560 <6> [255067.843078] -;[2] pid=89 tid=33638 comm=kworker/u25:12 do nothing
09-25 19:17:28.560 <6> [255067.843101] -;[2] pid=89 tid=33638 comm=kworker/u25:12 total block size of hisysevent data is 98
09-25 19:17:28.560 <6> [255067.858955] -;[0] pid=89 tid=514 comm=hisi_tcpc_timer [hisi_tcpc_reset_typec_debounce_timer]
09-25 19:17:28.560 <6> [255067.859002] -;[0] pid=89 tid=514 comm=hisi_tcpc_timer [tcpc_reset_timer_range]timer_id 44 ~ 47
09-25 19:17:28.560 <6> [255067.859032] -;[0] pid=89 tid=514 comm=hisi_tcpc_timer [typec_handle_cc_changed_entry][CC_Change] 5/5
09-25 19:17:28.560 <6> [255067.859054] -;[0] pid=89 tid=514 comm=hisi_tcpc_timer [typec_is_act_as_sink_role]as_sink 1
09-25 19:17:28.560 <6> [255067.859077] -;[0] pid=89 tid=514 comm=hisi_tcpc_timer [typec_cc_change_sink_entry]typec_state 4(AttachWait.SNK)
09-25 19:17:28.560 <6> [255067.860335] -;[0] pid=89 tid=514 comm=hisi_tcpc_timer [hisi_tcpc_get_power_status]pwr_status 0xd
09-25 19:17:28.560 <6> [255067.860377] -;[0] pid=89 tid=514 comm=hisi_tcpc_timer [typec_wait_ps_change]wait state 0
09-25 19:17:28.560 <6> [255067.860399] -;[0] pid=89 tid=514 comm=hisi_tcpc_timer [typec_custom_src_attached_entry]Custom_src attached
09-25 19:17:28.560 <6> [255067.861667] -;[0] pid=89 tid=514 comm=hisi_tcpc_timer [hisi_tcpc_pd_fsm_state]pd_dbg_rdata 0x78
09-25 19:17:28.560 <6> [255067.861707] -;[0] pid=89 tid=514 comm=hisi_tcpc_timer [hisi_tcpc_pd_fsm_state]DebugAccessory.Snk
09-25 19:17:28.560 <6> [255067.861731] -;[0] pid=89 tid=514 comm=hisi_tcpc_timer [hisi_tcpc_pd_fsm_state]PD Attached
09-25 19:17:28.560 <6> [255067.861986] -;[0] pid=89 tid=514 comm=hisi_tcpc_timer [hisi_tcpc_pd_fsm_state]TypeC Attached
09-25 19:17:28.560 <6> [255067.862025] -;[0] pid=89 tid=514 comm=hisi_tcpc_timer [hisi_tcpc_pd_fsm_state]tc_cu_st Orientation.Snk
09-25 19:17:28.560 <6> [255067.862049] -;[0] pid=89 tid=514 comm=hisi_tcpc_timer [hisi_tcpc_set_cc]set role ctrl 0xa
09-25 19:17:28.560 <6> [255067.862384] -;[0] pid=89 tid=514 comm=hisi_tcpc_timer [typec_transfer_state]** Custom.SRC
09-25 19:17:28.560 <3> [255067.862422] -;[0] pid=89 tid=514 comm=hisi_tcpc_timer [E/hw_pogopin] g_pogopin_di is null
09-25 19:17:28.561 <6> [255067.862451] -;[0] pid=89 tid=514 comm=hisi_tcpc_timer [typec_alert_attach_state_change]Attached-> CUSTOM_SRC
09-25 19:17:28.561 <6> [255067.862480] -;[0] pid=89 tid=514 comm=hisi_tcpc_timer [hisi_tcpc_dual_role_instance_changed]+
09-25 19:17:28.561 <6> [255067.862535] -;[0] pid=89 tid=514 comm=hisi_tcpc_timer [hisi_tcpc_dual_role_instance_changed]-
09-25 19:17:28.561 <6> [255067.862690] -;[0] pid=89 tid=514 comm=hisi_tcpc_timer [tcpci_report_usb_port_attached]usb_port_attached
09-25 19:17:28.561 <6> [255067.862721] -;[0] pid=89 tid=514 comm=hisi_tcpc_timer [__tcpci_set_wake_lock_pd]lock attach_wake_lock
09-25 19:17:28.561 <6> [255067.862740] -;[2] pid=89 tid=33638 comm=kworker/u25:12 [usb_typec]tcpc_notify_type 12
09-25 19:17:28.561 <6> [255067.862747] -;[0] pid=89 tid=514 comm=hisi_tcpc_timer [event][__hisi_pd_put_event]event_type PD_EVT_HW_MSG, from partner 0
09-25 19:17:28.561 <6> [255067.862803] -;[2] pid=89 tid=33638 comm=kworker/u25:12 [usb_typec]typec_state: UNATTACHED --> CUSTOM_SRC / normal / OPEN
09-25 19:17:28.561 <3> [255067.862844] -;[2] pid=89 tid=33638 comm=kworker/u25:12 [E/hw_pogopin] g_pogopin_di is null
09-25 19:17:28.561 <6> [255067.862887] -;[2] pid=89 tid=33638 comm=kworker/u25:12 [I/huawei_pd] pd_dpm_set_source_sink_state 0
09-25 19:17:28.561 <6> [255067.862923] -;[2] pid=89 tid=33638 comm=kworker/u25:12 [I/charger_detection] prop = 86, val->intval = 0
09-25 19:17:28.562 <6> [255067.862949] -;[2] pid=89 tid=33638 comm=kworker/u25:12 [I/charger_detection] POWER_SUPPLY_PROP_CHG_PLUGIN
09-25 19:17:28.562 <6> [255067.862971] -;[2] pid=89 tid=33638 comm=kworker/u25:12 [I/charger_common] set_charger_online: online=1
09-25 19:17:28.562 <6> [255067.862977] -;[1] pid=89 tid=515 comm=hisi_tcpc_event [PE][hisi_pd_policy_engine_run]pd event
09-25 19:17:28.562 <6> [255067.862990] -;[2] pid=89 tid=33638 comm=kworker/u25:12 [I/charger_detection] case = START_SINK
09-25 19:17:28.562 <6> [255067.863006] -;[1] pid=89 tid=515 comm=hisi_tcpc_event [PE][pd_handle_event]pe_state_curr = pe_pd_state, 122
09-25 19:17:28.562 <6> [255067.863026] -;[1] pid=89 tid=515 comm=hisi_tcpc_event [EVT][pe_exit_idle_state]+
09-25 19:17:28.562 <6> [255067.863043] -;[1] pid=89 tid=515 comm=hisi_tcpc_event [EVT][hisi_pd_process_event]Trap in idle state, Igrone All MSG
09-25 19:17:28.562 <6> [255067.863048] -;[2] pid=89 tid=33638 comm=kworker/u25:12 [I/huawei_pd] pd_dpm_handle_pe_event ATTACHED_CUSTOM_SRC
09-25 19:17:28.562 <6> [255067.863054] -;[0] pid=89 tid=571 comm=kworker/0:2 [tcpc_dual_role_get_prop]prop 1 val 0
09-25 19:17:28.562 <6> [255067.863063] -;[1] pid=89 tid=515 comm=hisi_tcpc_event [PE][hisi_pd_policy_engine_run]no event
09-25 19:17:28.562 <6> [255067.863069] -;[2] pid=89 tid=33638 comm=kworker/u25:12 [I/huawei_usb_vbus] typec_complete ++
09-25 19:17:28.562 <6> [255067.863082] -;[0] pid=89 tid=571 comm=kworker/0:2 [tcpc_dual_role_get_prop]prop 2 val 1
09-25 19:17:28.562 <6> [255067.863089] -;[2] pid=89 tid=33638 comm=kworker/u25:12 [I/huawei_usb_vbus] typec_complete --
09-25 19:17:28.562 <6> [255067.863106] -;[0] pid=89 tid=571 comm=kworker/0:2 [tcpc_dual_role_get_prop]prop 3 val 1
09-25 19:17:28.562 <6> [255067.863110] -;[2] pid=89 tid=33638 comm=kworker/u25:12 [I/huawei_pd] pd_dpm_set_typec_state pd_dpm_set_typec_state = 2
09-25 19:17:28.562 <6> [255067.863129] -;[2] pid=89 tid=33638 comm=kworker/u25:12 [I/huawei_pd] pd_dpm_set_typec_state report attach, stop res & satrt ovp detect
09-25 19:17:28.562 <6> [255067.863131] -;[0] pid=89 tid=571 comm=kworker/0:2 [tcpc_dual_role_get_prop]prop 4 val 0
09-25 19:17:28.563 <6> [255067.863134] -;[1] pid=89 tid=33634 comm=kworker/u25:2 [I/charger_detection] charger_event_work+
09-25 19:17:28.563 <3> [255067.863145] -;[2] pid=89 tid=33638 comm=kworker/u25:12 [E/hw_pogopin] g_pogopin_di is null
09-25 19:17:28.563 <6> [255067.863164] -;[2] pid=89 tid=33638 comm=kworker/u25:12 [I/huawei_pd] pd_dpm_set_cc_orientation cc_orientation =0
09-25 19:17:28.563 <6> [255067.863167] -;[1] pid=89 tid=33634 comm=kworker/u25:2 [I/power_event] receive sysfs event attr=charger_online
09-25 19:17:28.563 <3> [255067.863225] -;[1] pid=89 tid=33634 comm=kworker/u25:2 notify path devices/platform/huawei_charger/charger_online failed with -2
09-25 19:17:28.563 <6> [255067.863271] -;[2] pid=89 tid=28840 comm=kworker/2:3 [I/huawei_pd] pd_dpm_report_device_attach
09-25 19:17:28.563 <6> [255067.863289] -;[1] pid=89 tid=33634 comm=kworker/u25:2 [I/power_event] receive blocking event type=0 event=1,usb_connect
09-25 19:17:28.563 <6> [255067.863310] -;[2] pid=89 tid=28840 comm=kworker/2:3 [I/huawei_pd] pd_dpm_get_cc_orientation cc_orientation =0
09-25 19:17:28.563 <6> [255067.863313] -;[1] pid=89 tid=33634 comm=kworker/u25:2 [I/scp_protocol] clear hwscp power curve
09-25 19:17:28.563 <6> [255067.863339] -;[2] pid=89 tid=28840 comm=kworker/2:3 [I/huawei_pd] pd_dpm_handle_combphy_event +
09-25 19:17:28.563 <6> [255067.863348] -;[1] pid=89 tid=33634 comm=kworker/u25:2 [I/power_event] receive uevent_buf 13,VBUS_CONNECT=
09-25 19:17:28.563 <6> [255067.863360] -;[2] pid=89 tid=28840 comm=kworker/2:3 [I/huawei_pd] pd_dpm_put_combphy_pd_event - input = 33, n = 1
09-25 19:17:28.563 <6> [255067.863402] -;[2] pid=89 tid=28840 comm=kworker/2:3 [I/huawei_pd] pd_dpm_handle_combphy_event -
09-25 19:17:28.563 <6> [255067.863422] -;[2] pid=89 tid=28840 comm=kworker/2:3 [I/power_event] receive blocking event type=4 event=20,wd_detect_by_usb_gpio
09-25 19:17:28.563 <6> [255067.863443] -;[2] pid=89 tid=28840 comm=kworker/2:3 [I/power_event] receive blocking event type=4 event=19,wd_detect_by_usb_id
09-25 19:17:28.563 <6> [255067.863461] -;[2] pid=89 tid=28840 comm=kworker/2:3 [I/power_event] receive blocking event type=4 event=21,wd_detect_by_audio_dp_dn
09-25 19:17:28.563 <6> [255067.863483] -;[2] pid=89 tid=28840 comm=kworker/2:3 [I/huawei_pd] pd_dpm_combphy_event_notify +
09-25 19:17:28.563 <6> [255067.863507] -;[2] pid=89 tid=28840 comm=kworker/2:3 [I/huawei_pd] pd_dpm_get_combphy_pd_event - g_iget = 33, n = 0
09-25 19:17:28.563 <6> [255067.863557] -;[2] pid=89 tid=28840 comm=kworker/2:3 [I/power_vote] hw_usb: [combphy,0] vote on of value=1 eff_result={0:1} last_eff_result={0:0}
09-25 19:17:28.563 <6> [255067.863577] -;[2] pid=89 tid=28840 comm=kworker/2:3 [I/hw_usb] result=1 client_str=combphy
09-25 19:17:28.563 <6> [255067.863611] -;[2] pid=89 tid=28840 comm=kworker/2:3 [COMBOPHY_FUNC]pd_event_notify: IRQ[TCA_IRQ_HPD_IN]MODEcur[TCPC_NC]new[TCPC_USB31_CONNECTED]DEV[TCA_CHARGER_CONNECT_EVENT]ORIEN[0]
09-25 19:17:28.563 <6> [255067.863673] -;[2] pid=89 tid=28840 comm=kworker/2:3 [COMBOPHY_FUNC]pd_event_notify: -
09-25 19:17:28.563 <6> [255067.863685] -;[3] pid=89 tid=514 comm=hisi_tcpc_timer [typec_alert_attach_state_change]set typec_attach_old 6
09-25 19:17:28.563 <3> [255067.863738] -;[2] pid=89 tid=33638 comm=kworker/u25:12 [USB3][event_work]+
09-25 19:17:28.563 <3> [255067.863766] -;[2] pid=89 tid=33638 comm=kworker/u25:12 [USB3][handle_event]type: CHARGER_CONNECT
09-25 19:17:28.563 <6> [255067.863902] -;[2] pid=89 tid=33638 comm=kworker/u25:12 [USB3][chip_usb2_phy_init]+
09-25 19:17:28.563 <3> [255067.864475] -;[3] pid=89 tid=33638 comm=kworker/u25:12 [USB2_T5][I][_usb2_phy_init]+
09-25 19:17:28.563 <6> [255067.864515] -;[3] pid=89 tid=33638 comm=kworker/u25:12 [USB_MISC_CTRL][I][multi_usb_misc_ctrl_init]+
09-25 19:17:28.563 <6> [255067.864535] -;[3] pid=89 tid=33638 comm=kworker/u25:12 [USB_MISC_CTRL][I][misc_ctrl_get]+
09-25 19:17:28.563 <6> [255067.864556] -;[3] pid=89 tid=33638 comm=kworker/u25:12 [USB_MISC_CTRL][I][multi_usb_misc_ctrl_init]init_count 0
09-25 19:17:28.563 <6> [255067.864638] -;[3] pid=89 tid=33638 comm=kworker/u25:12 [USB_MISC_CTRL][I][multi_usb_misc_ctrl_init]-
09-25 19:17:28.563 <3> [255067.864665] -;[3] pid=89 tid=33638 comm=kworker/u25:12 [USB2_T5][I][usb2_phy_open_clk]+
09-25 19:17:28.563 <3> [255067.864713] -;[3] pid=89 tid=33638 comm=kworker/u25:12 [USB2_T5][I][usb2_phy_open_clk]-
09-25 19:17:28.563 <3> [255067.864749] -;[3] pid=89 tid=33638 comm=kworker/u25:12 [USB2_T5][I][_usb2_phy_init][PHY_MODE_USB_DEVICE]: set phy-eye-diagram-param
09-25 19:17:28.563 <3> [255067.864788] -;[3] pid=89 tid=33638 comm=kworker/u25:12 [USB2_T5][I][set_usb2_eye_diagram_param]set phy diagram param: 0x14b5
09-25 19:17:28.564 <3> [255067.864804] -;[3] pid=89 tid=33638 comm=kworker/u25:12 [USB2_T5][I][set_usb2_eye_diagram_param]set phy diagram param: 0x6302
09-25 19:17:28.564 <3> [255067.864820] -;[3] pid=89 tid=33638 comm=kworker/u25:12 [USB2_T5][I][set_usb2_eye_diagram_param]set phy diagram param: 0x200
09-25 19:17:28.564 <3> [255067.864834] -;[3] pid=89 tid=33638 comm=kworker/u25:12 [USB2_T5][I][_usb2_phy_init]-
09-25 19:17:28.564 <6> [255067.864851] -;[3] pid=89 tid=33638 comm=kworker/u25:12 [USB3][chip_usb2_phy_init]-
09-25 19:17:28.564 <6> [255067.864865] -;[3] pid=89 tid=33638 comm=kworker/u25:12 [USB3][chip_usb3_phy_init]+
09-25 19:17:28.564 <6> [255067.864884] -;[3] pid=89 tid=33638 comm=kworker/u25:12 [COMBOPHY_PHY]combophy_set_mode: set mode_type 1 orien 0
09-25 19:17:28.564 <6> [255067.864913] -;[3] pid=89 tid=33638 comm=kworker/u25:12 [COMBOPHY_PHY]combophy_init: +
09-25 19:17:28.564 <6> [255067.864928] -;[3] pid=89 tid=33638 comm=kworker/u25:12 [USB_MISC_CTRL][I][multi_usb_misc_ctrl_init]+
09-25 19:17:28.564 <6> [255067.864961] -;[3] pid=89 tid=33638 comm=kworker/u25:12 [USB_MISC_CTRL][I][misc_ctrl_get]+
09-25 19:17:28.564 <6> [255067.864977] -;[3] pid=89 tid=33638 comm=kworker/u25:12 [USB_MISC_CTRL][I][multi_usb_misc_ctrl_init]init_count 1
09-25 19:17:28.564 <6> [255067.864996] -;[3] pid=89 tid=33638 comm=kworker/u25:12 [USB_MISC_CTRL][I][misc_ctrl_put]+
09-25 19:17:28.564 <6> [255067.865020] -;[3] pid=89 tid=33638 comm=kworker/u25:12 [USB_MISC_CTRL][I][misc_ctrl_put]-
09-25 19:17:28.564 <6> [255067.867275] -;[1] pid=89 tid=33638 comm=kworker/u25:12 [COMBOPHY_PHY]combophy_init: debug_flag false
09-25 19:17:28.564 <6> [255067.867327] -;[1] pid=89 tid=33638 comm=kworker/u25:12 [COMBOPHY_PHY]combophy_init: -
09-25 19:17:28.564 <6> [255067.867360] -;[1] pid=89 tid=33638 comm=kworker/u25:12 [USB3][chip_usb3_phy_init]-
09-25 19:17:28.564 <6> [255067.868456] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [I/power_vote] vbus_monitor: [usb,0] vote on of value=1 eff_result={0:1} last_eff_result={0:0}
09-25 19:17:28.564 <6> [255067.868500] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [I/vbus_monitor] result=1 client_str=usb
09-25 19:17:28.564 <6> [255067.868518] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [I/power_event] receive uevent_buf 18,VBUS_VOTE_CONNECT=
09-25 19:17:28.564 <6> [255067.868695] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [I/adapter_detect] set plugged_state=0
09-25 19:17:28.564 <6> [255067.868715] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [I/sensorhub] phone not alb
09-25 19:17:28.564 <6> [255067.868736] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [I/power_icon] notify icon_type=1
09-25 19:17:28.564 <6> [255067.868752] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [I/power_ui] receive event 8
09-25 19:17:28.564 <6> [255067.868774] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [I/power_event] receive uevent_buf 14,UI_ICON_TYPE=1
09-25 19:17:28.564 <6> [255067.869041] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [I/charger_common] set_charger_type: type=0
09-25 19:17:28.564 <6> [255067.869065] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [I/charger_common] set_charger_source: source=4
09-25 19:17:28.564 <6> [255067.869083] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [I/huawei_charger] charger_type_handler case = CHARGER_TYPE_SDP
09-25 19:17:28.564 <6> [255067.869105] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [I/power_event] receive blocking event type=14 event=101,chg_start_charging
09-25 19:17:28.564 <6> [255067.869130] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [I/wireless_charger] [wireless_charge_wired_vbus_connect_handler] wired vbus connect
09-25 19:17:28.564 <6> [255067.869151] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [I/power_event] receive blocking event type=10 event=55,wlc_wired_vbus_connect
09-25 19:17:28.564 <6> [255067.869173] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [I/huawei_charger] wireless_charger_vbus_notifier_call not in wireless charging
09-25 19:17:28.564 <6> [255067.869194] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [I/wireless_rx_status] [set_wired_channel_state] 1
09-25 19:17:28.564 <6> [255067.869215] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [I/direct_charge_eh] clean_eh_buf
09-25 19:17:28.564 <6> [255067.869231] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [I/wireless_rx_status] [dc_stage] set to STOP_CHARGING
09-25 19:17:28.564 <6> [255067.869274] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [I/wireless_mt5785_rx] [sleep_enable] gpio high now
09-25 19:17:28.564 <6> [255067.869305] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [I/wired_ch_manager] [set_buck_channel] client:WDCM_CLIENT_WIRED original_state on, voted_state on
09-25 19:17:28.564 <6> [255067.869323] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [I/wired_chsw] wired_channel_buck need set on
09-25 19:17:28.564 <6> [255067.869355] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [I/power_sw] [set_output] buck set on
09-25 19:17:28.564 <6> [255067.869397] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [I/power_sw] [set_by_gpio] gpio_345 low now
09-25 19:17:28.564 <6> [255067.869418] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [I/wired_chsw] get wired channel:wired_channel_buck is on
09-25 19:17:28.564 <6> [255067.869433] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [I/wired_chsw] wired_channel_buck is set to on
09-25 19:17:28.565 <6> [255067.869458] -;[2] pid=89 tid=33634 comm=kworker/u25:2 hisi_vbat_drop_restore_freq event: 4ld
09-25 19:17:28.565 <3> [255067.869507] -;[2] pid=89 tid=33634 comm=kworker/u25:2 notify path devices/virtual/hw_power/bq_bci/poll_charge_start_event failed with -2
09-25 19:17:28.565 <6> [255067.869535] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [batt_bci]received event = 4, charge_status = 1
09-25 19:17:28.565 <6> [255067.869558] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [batt_bci][bci_charger_event] power supply changed, soc 53
09-25 19:17:28.565 <6> [255067.869592] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [coul_merge_bigdata]receive charge event 4
09-25 19:17:28.565 <6> [255067.869618] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [I/THP] thp_charger_detect_notifier_callback, set new status: 1
09-25 19:17:28.565 <6> [255067.869702] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [I/THP] thp_set_status:type=2 value=1
09-25 19:17:28.565 <6> [255067.869720] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [scharger_cv]scharger_cv_charger_event event: 4
09-25 19:17:28.565 <6> [255067.869738] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [coul_drv]charger event = 0x4
09-25 19:17:28.565 <6> [255067.869859] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [I/power_event] receive sysfs event dir=iscd attr=iscd_process_event
09-25 19:17:28.565 <3> [255067.869895] -;[2] pid=89 tid=33634 comm=kworker/u25:2 notify path devices/platform/huawei_batt_soh/iscd/iscd_process_event failed with -2
09-25 19:17:28.565 <6> [255067.869923] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [I/huawei_charger] ---->START CHARGING
09-25 19:17:28.565 <6> [255067.869949] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [I/power_wakeup] wakeup source charge_wakelock lock
09-25 19:17:28.565 <3> [255067.869977] -;[2] pid=89 tid=33634 comm=kworker/u25:2 [hisi_scharger]hi6526_ibat_res_sel: 1000 uohm, not expected
09-25 19:17:28.565 <6> [255067.870048] -;[3] pid=1674 tid=2115 comm=DrvProc [I/THP] thp_mt_wrapper_ioctl_read_status:status = 0x109c4
09-25 19:17:28.565 <6> [255067.870446] -;[2] pid=89 tid=768 comm=kworker/2:1 [I/batt_type_identify] apply_mode cur_mode=0 mode=0
09-25 19:17:28.565 <6> [255067.870590] -;[2] pid=89 tid=185 comm=kworker/2:0 [I/wireless_mt5785_rx] [set_turbo_chg_flag] false
09-25 19:17:28.565 <6> [255067.870608] -;[2] pid=89 tid=185 comm=kworker/2:0 [I/wireless_ic_iout] [select_para] factor=0x0
09-25 19:17:28.565 <6> [255067.870632] -;[2] pid=89 tid=185 comm=kworker/2:0 [I/wireless_mt5785] [chip_enable] gpio high now
09-25 19:17:28.565 <6> [255067.870651] -;[2] pid=89 tid=185 comm=kworker/2:0 [I/wireless_rx_status] [set_wireless_channel_state] 0
09-25 19:17:28.565 <6> [255067.870683] -;[2] pid=89 tid=185 comm=kworker/2:0 [I/wireless_charger] wired_vbus_connect_work, vout:0 vrect:0
09-25 19:17:28.565 <3> [255067.870710] -;[2] pid=89 tid=185 comm=kworker/2:0 [E/wireless_dc] wldc_is_stop_charging_complete: g_wldc_di null
09-25 19:17:28.565 <6> [255067.870727] -;[2] pid=89 tid=185 comm=kworker/2:0 [I/wired_ch_manager] [set_buck_channel] client:WDCM_CLIENT_WIRED original_state on, voted_state on
09-25 19:17:28.565 <6> [255067.870742] -;[2] pid=89 tid=185 comm=kworker/2:0 [I/wired_chsw] wired_channel_buck need set on
09-25 19:17:28.565 <6> [255067.870763] -;[2] pid=89 tid=185 comm=kworker/2:0 [I/power_sw] [set_output] buck set on
09-25 19:17:28.565 <6> [255067.870787] -;[2] pid=89 tid=185 comm=kworker/2:0 [I/power_sw] [set_by_gpio] gpio_345 low now
09-25 19:17:28.565 <6> [255067.870810] -;[2] pid=89 tid=185 comm=kworker/2:0 [I/wired_chsw] get wired channel:wired_channel_buck is on
09-25 19:17:28.565 <6> [255067.870825] -;[2] pid=89 tid=185 comm=kworker/2:0 [I/wired_chsw] wired_channel_buck is set to on
09-25 19:17:28.565 <6> [255067.870839] -;[2] pid=89 tid=185 comm=kworker/2:0 [I/wireless_charger] wired vbus connect, turn off wireless channel
09-25 19:17:28.565 <6> [255067.870856] -;[2] pid=89 tid=185 comm=kworker/2:0 [I/wireless_charger] wireless_charge_stop_charging ++
09-25 19:17:28.565 <6> [255067.870874] -;[2] pid=89 tid=185 comm=kworker/2:0 [I/wireless_mt5785_rx] [sleep_enable] gpio high now
09-25 19:17:28.565 <6> [255067.870898] -;[2] pid=89 tid=185 comm=kworker/2:0 [I/wireless_rx_status] [rx_stage] set to DEFAULT
09-25 19:17:28.565 <6> [255067.870928] -;[2] pid=89 tid=185 comm=kworker/2:0 [I/wireless_buck_ictrl] [set_iin_prop] delay=0 step=0 iset=0
09-25 19:17:28.565 <6> [255067.870950] -;[2] pid=89 tid=185 comm=kworker/2:0 [I/wireless_mt5785_rx] [set_turbo_chg_flag] false
09-25 19:17:28.565 <6> [255067.870965] -;[2] pid=89 tid=185 comm=kworker/2:0 [I/wireless_ic_iout] [select_para] factor=0x0
09-25 19:17:28.565 <3> [255067.870996] -;[2] pid=89 tid=185 comm=kworker/2:0 [E/wireless_mt5785_rx] get_vmldo: mismatch
09-25 19:17:28.565 <6> [255067.871020] -;[2] pid=89 tid=185 comm=kworker/2:0 [I/power_ui] receive event 5
09-25 19:17:28.565 <6> [255067.871044] -;[2] pid=89 tid=185 comm=kworker/2:0 [I/power_event] receive uevent_buf 19,UI_ACC_DET_STATUS=0
09-25 19:17:28.565 <6> [255067.871176] -;[0] pid=89 tid=24228 comm=kworker/u25:8 [coul_merge]coul_merge_rcv_event_work +
09-25 19:17:28.565 <6> [255067.871207] -;[0] pid=89 tid=24228 comm=kworker/u25:8 [coul_merge_drv]batt_index 0, charger event = 0x4
09-25 19:17:28.565 <6> [255067.871226] -;[0] pid=89 tid=24228 comm=kworker/u25:8 [coul_core]batt 0, receive charge start event = 0x4
09-25 19:17:28.565 <6> [255067.871241] -;[0] pid=89 tid=24228 comm=kworker/u25:8 [coul_core]coul_core_charging_begin +
09-25 19:17:28.565 <6> [255067.871266] -;[0] pid=89 tid=24228 comm=kworker/u25:8 [coul_core]batt 0, pre charging state is 3
09-25 19:17:28.565 <6> [255067.871288] -;[0] pid=89 tid=24228 comm=kworker/u25:8 [coul_core]coul_board_type: batt 0 board_type = 2, batt_exist = 1
09-25 19:17:28.565 <6> [255067.871436] -;[0] pid=89 tid=24228 comm=kworker/u25:8 [coul_hardware]cc_out=0xf552aed0,cc_in=0x2f81d3ea,cout_time=17431,cin_time=1716,cc_adj=1705855uah
09-25 19:17:28.565 <6> [255067.871496] -;[2] pid=89 tid=768 comm=kworker/2:1 [I/batt_type_identify] release_mode flag=0
09-25 19:17:28.565 <6> [255067.871527] -;[2] pid=89 tid=768 comm=kworker/2:1 [coul_core]batt 0, get battery id voltage is 2785 mv
09-25 19:17:28.565 <6> [255067.871682] -;[0] pid=89 tid=24228 comm=kworker/u25:8 [coul_core]calculate_soc_params batt 0, uiSOC= 53, SOC real = 505
09-25 19:17:28.565 <6> [255067.871715] -;[3] pid=89 tid=33639 comm=kworker/u25:13 [I/huawei_charger] charge_monitor_work ++
09-25 19:17:28.565 <6> [255067.871740] -;[2] pid=89 tid=768 comm=kworker/2:1 [coul_hardware]cc_out=0xf552aed0,cc_in=0x2f81d3ea,cout_time=17431,cin_time=1716,cc_adj=1705855uah
09-25 19:17:28.565 <6> [255067.871742] -;[0] pid=89 tid=24228 comm=kworker/u25:8 [coul_core]batt 0, delta_time=0, i_ua=143084
09-25 19:17:28.565 <6> [255067.871767] -;[0] pid=89 tid=24228 comm=kworker/u25:8 [coul_core]batt 0, FCC=3894000uAh, UUC=46728uAh, RC=3672042uAh, CC=1705855uAh, delta_RC=0uAh, Rbatt=51mOhm
09-25 19:17:28.565 <6> [255067.871784] -;[0] pid=89 tid=24228 comm=kworker/u25:8 [coul_core]batt 0, FCC = 3894000uAh term flag= 0
09-25 19:17:28.565 <6> [255067.871800] -;[0] pid=89 tid=24228 comm=kworker/u25:8 [coul_core]adjust_fcc_uah, batt 0, use limit_FCC 3672558uAh
09-25 19:17:28.565 <6> [255067.871919] -;[0] pid=89 tid=24228 comm=kworker/u25:8 [coul_core]batt 0, soc_est_avg=52 delta_soc=1 n=0
09-25 19:17:28.566 <6> [255067.872042] -;[0] pid=89 tid=24228 comm=kworker/u25:8 [coul_core]limit_soc_during_running, [dischg] batt 0, current_ua 143084, output_soc 53, last_soc 53
09-25 19:17:28.566 <6> [255067.872072] -;[0] pid=89 tid=24228 comm=kworker/u25:8 [coul_core]NOT EXIT FROM ECO,SOC_NEW = 53
09-25 19:17:28.566 <6> [255067.872091] -;[0] pid=89 tid=24228 comm=kworker/u25:8 [coul_core]batt 0, SOC without UUC = 54, SOC before adjust = 53,SOC before limit = 53, SOC after limit = 53
09-25 19:17:28.566 <6> [255067.872108] -;[0] pid=89 tid=24228 comm=kworker/u25:8 [coul_core][BASP] prev_state:2, new_state:1, batt_temp:340
09-25 19:17:28.566 <6> [255067.872221] -;[0] pid=89 tid=24228 comm=kworker/u25:8 [coul_hardware]cc_out=0xf552aed0,cc_in=0x2f81d3ea,cout_time=17431,cin_time=1716,cc_adj=1705855uah
09-25 19:17:28.566 <6> [255067.872425] -;[0] pid=89 tid=24228 comm=kworker/u25:8 [coul_core]coul_core_charging_begin -
09-25 19:17:28.566 <6> [255067.872448] -;[0] pid=89 tid=24228 comm=kworker/u25:8 [coul_core]batt 0, batt_soc=53, charging_begin_soc=505,charging_begin_cc=1705855,batt_limit_fcc_begin =3672558, charging_begin_time 19147
09-25 19:17:28.566 <6> [255067.872465] -;[0] pid=89 tid=24228 comm=kworker/u25:8 [coul_merge]coul_merge_rcv_event_work -
09-25 19:17:28.566 <6> [255067.873169] -;[3] pid=1 tid=1 comm=init <6>[pid=1][PARAM][INFO][param_service.c:179]Handle set param msgId 98 pid 781 key: vendor.bms_event
09-25 19:17:28.566 <6> [255067.874130] -;[3] pid=1 tid=1 comm=init <6>[pid=1][Init][INFO][init_common_service.c:650]ServiceStart starting:usb_port
09-25 19:17:28.566 <6> [255067.876910] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [I/buck_charge_ic_manager] reset_watchdog: ret=0
09-25 19:17:28.566 <6> [255067.876940] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [I/buck_charge_ic_manager] kick watchdog timer ok
09-25 19:17:28.566 <6> [255067.876965] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [hisi_chgwdt]++charge watchdog feed, current cnt:0, timeout is:180 ++
09-25 19:17:28.566 <6> [255067.876984] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [I/direct_charge] scp_stop_charging_complete_flag is set
09-25 19:17:28.566 <3> [255067.877000] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [E/hw_pogopin] g_pogopin_di is null
09-25 19:17:28.566 <6> [255067.877014] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [I/direct_charge] scp_stop_charging_complete_flag is set
09-25 19:17:28.566 <6> [255067.877049] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [I/huawei_charger] pd_event_num=0
09-25 19:17:28.566 <3> [255067.877066] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [E/hw_pogopin] g_pogopin_di is null
09-25 19:17:28.566 <6> [255067.877082] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [I/huawei_pd] Hisi PD
09-25 19:17:28.566 <6> [255067.878095] -;[2] pid=89 tid=185 comm=kworker/2:0 [I/wireless_rx_pctrl] [count_dcdiscon] cnt=0
09-25 19:17:28.566 <6> [255067.878132] -;[2] pid=89 tid=185 comm=kworker/2:0 [I/wireless_charger] wireless_charge_stop_charging --
09-25 19:17:28.566 <6> [255067.879764] -;[3] pid=89 tid=33638 comm=kworker/u25:12 get dwc3 lock
09-25 19:17:28.566 <6> [255067.879806] -;[3] pid=89 tid=33638 comm=kworker/u25:12 set chip_dwc3_power_flag 1
09-25 19:17:28.566 <6> [255067.879823] -;[3] pid=89 tid=33638 comm=kworker/u25:12 put dwc3 lock
09-25 19:17:28.566 <6> [255067.880738] -;[0] pid=89 tid=117 comm=dh-irq-bind-0 [pcie_kport][INF]:Allow idle sleep! Ref clk will off
09-25 19:17:28.566 <6> [255067.880770] -;[0] pid=89 tid=117 comm=dh-irq-bind-0 [pcie_kport][INF]:Turn off ref_clk
09-25 19:17:28.566 <3> [255067.880789] -;[0] pid=89 tid=117 comm=dh-irq-bind-0 [pcie_kport][ERR]:100MHz refclks disable enter
09-25 19:17:28.566 <3> [255067.880823] -;[0] pid=89 tid=117 comm=dh-irq-bind-0 [pcie_kport][ERR]:pcie0 enable:0 fnpll_cnt: 0
09-25 19:17:28.566 <3> [255067.880863] -;[0] pid=89 tid=117 comm=dh-irq-bind-0 [pcie_kport][ERR]:100MHz refclks disable done
09-25 19:17:28.566 <6> [255067.881314] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [usb_typec]analog CC status: 0x33
09-25 19:17:28.566 <6> [255067.881349] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [I/hvdcp_charge] check_charger_type: type=0 ret=0
09-25 19:17:28.566 <6> [255067.881365] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [I/huawei_charger] charger type not right
09-25 19:17:28.566 <6> [255067.881499] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [coul_merge]coul_merge_get_capacity soc 53
09-25 19:17:28.566 <6> [255067.881565] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [coul_hardware]coul_get_tbat code 1154, tbat 34
09-25 19:17:28.566 <3> [255067.881582] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [E/batt_temp_fit] g_btf_dev is null
09-25 19:17:28.566 <6> [255067.881600] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [I/power_temp] sensor:bat0_raw_temp, samples[0]:34000
09-25 19:17:28.566 <6> [255067.881632] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [coul_hardware]coul_get_tbat code 1154, tbat 34
09-25 19:17:28.566 <3> [255067.881647] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [E/batt_temp_fit] g_btf_dev is null
09-25 19:17:28.566 <6> [255067.881662] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [I/power_temp] sensor:bat0_raw_temp, samples[1]:34000
09-25 19:17:28.566 <6> [255067.881691] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [coul_hardware]coul_get_tbat code 1154, tbat 34
09-25 19:17:28.566 <3> [255067.881717] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [E/batt_temp_fit] g_btf_dev is null
09-25 19:17:28.566 <6> [255067.881734] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [I/power_temp] sensor:bat0_raw_temp, samples[2]:34000
09-25 19:17:28.566 <3> [255067.881752] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [E/batt_temp_fit] g_btf_dev is null
09-25 19:17:28.566 <6> [255067.881841] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [I/power_algo] refer:143, without_comp:34000, with_comp:34000
09-25 19:17:28.566 <6> [255067.881863] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [I/power_algo] current_comp:34000, c_comp:34000, c_raw:34000, l_comp:34000, l_raw:34000
09-25 19:17:28.566 <6> [255067.881880] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [I/btb_temp] sensor:0, raw:34000, temp:34000
09-25 19:17:28.566 <6> [255067.881897] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [I/btb_temp] temp_sync0 temp:34000
09-25 19:17:28.566 <3> [255067.881911] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [E/batt_temp_fit] g_btf_dev is null
09-25 19:17:28.566 <6> [255067.882043] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [I/charging_core] charge_core_tbatt_handler: i = 3, temp = 34, data->iin = 2000, data->ichg = 3000, data->vterm = 4490
09-25 19:17:28.566 <6> [255067.882074] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [I/charging_core] overheat temp 50 vterm 4100 mV, cur temp 34 vbat 3911
09-25 19:17:28.566 <6> [255067.882089] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [I/charging_core] vdpm_first_run = 1
09-25 19:17:28.566 <6> [255067.882104] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [I/charging_core] battery voltage is 3911 mv, vindpm set to 4500 mV
09-25 19:17:28.566 <6> [255067.882120] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [I/huawei_pd] pd_dpm_get_high_power_charging_status status =0
09-25 19:17:28.566 <6> [255067.882134] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [I/huawei_pd] pd_dpm_get_high_power_charging_status status =0
09-25 19:17:28.566 <6> [255067.882152] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [I/charging_core] before, ichg:3000, vterm:4490, segment:0
09-25 19:17:28.566 <6> [255067.882169] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [I/charging_core] after, ichg:3000, vterm:4458,ichg_bsoh:0, ichg_spec:0, vterm_bsoh:4458
09-25 19:17:28.566 <3> [255067.882199] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [E/hw_pogopin] g_pogopin_di is null
09-25 19:17:28.566 <6> [255067.882214] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [I/huawei_charger] [huawei_pd_typec_current]PD_DPM_CC_VOLT_SINK_DFT
09-25 19:17:28.566 <6> [255067.885673] -;[0] pid=89 tid=33639 comm=kworker/u25:13 [hisi_scharger]hi6526_get_charge_state >>> reg0:0x0, reg1 0x0, reg2 0x0, state 0x2
09-25 19:17:28.566 <6> [255067.886237] -;[2] pid=1378 tid=2019 comm=battery_thread [coul_hardware]cc_out=0xf552fa56,cc_in=0x2f81d3ea,cout_time=17431,cin_time=1716,cc_adj=1705865uah
09-25 19:17:28.566 <6> [255067.886245] -;[3] pid=1 tid=1 comm=init <6>[pid=1][Init][INFO][init_common_service.c:676]ServiceStart started info usb_port(pid 35177 uid 6265)
09-25 19:17:28.566 <6> [255067.886296] -;[3] pid=1 tid=1 comm=init <6>[pid=1][Init][INFO][init_common_service.c:679]starttime:1758799047-308308589, prefork:1758799047-309502860, startedtime:1758799047-320410673
09-25 19:17:28.566 <6> [255067.886493] -;[2] pid=1378 tid=2019 comm=battery_thread [batt_info][batt_info_get_property] batt[0] name battery_gauge, val -482
09-25 19:17:28.566 <6> [255067.888041] -;[4] pid=35177 tid=35177 comm=init <6>[pid=35177][PLUGIN][INFO][init_context_static.c:84]Set selinux context 0 for usb_port
09-25 19:17:28.566 <6> [255067.888515] -;[3] pid=1 tid=1 comm=init <6>[pid=1][Init][INFO][init_common_service.c:650]ServiceStart starting:bms_heating
09-25 19:17:28.566 <3> [255067.889128] -;[4] pid=35177 tid=35177 comm=init [avc_audit_slow:268] avc: denied { supervsable } for pid=35177, comm="/bin/init" scontext=u:r:chipset_init:s0 tcontext=u:r:chipset_init:s0 tclass=hmcap permissive=0
09-25 19:17:28.566 <6> [255067.891228] -;[4] pid=35177 tid=35177 comm=init <6>[pid=35177][Init][INFO][init_service.c:118]ServiceExec usb_port
09-25 19:17:28.566 <3> [255067.893768] -;[5] pid=35177 tid=35177 comm=init [avc_audit_slow:268] avc: denied { supervsable } for pid=35177, comm="/bin/init" scontext=u:r:bms_host:s0 tcontext=u:r:bms_host:s0 tclass=hmcap permissive=0
09-25 19:17:28.566 <6> [255067.898728] -;[1] pid=1 tid=1 comm=init <6>[pid=1][Init][INFO][init_common_service.c:676]ServiceStart started info bms_heating(pid 35178 uid 6258)
09-25 19:17:28.566 <6> [255067.898801] -;[1] pid=1 tid=1 comm=init <6>[pid=1][Init][INFO][init_common_service.c:679]starttime:1758799047-322694006, prefork:1758799047-324820048, startedtime:1758799047-332889839
09-25 19:17:28.566 <6> [255067.901093] -;[6] pid=35178 tid=35178 comm=init <6>[pid=35178][PLUGIN][INFO][init_context_static.c:84]Set selinux context 0 for bms_heating
09-25 19:17:28.566 <6> [255067.903450] -;[3] pid=1 tid=1 comm=init <6>[pid=1][PARAM][INFO][param_service.c:179]Handle set param msgId 99 pid 781 key: vendor.bms_event_vote
09-25 19:17:28.566 <6> [255067.903645] -;[6] pid=35178 tid=35178 comm=init <6>[pid=35178][Init][INFO][init_service.c:118]ServiceExec bms_heating
09-25 19:17:28.567 <6> [255067.905535] -;[3] pid=1 tid=1 comm=init <6>[pid=1][Init][INFO][init_service_manager.c:1168]Service info bms_protocol start service bt ext parameter bms_protocol.
09-25 19:17:28.567 <6> [255067.905576] -;[3] pid=1 tid=1 comm=init <3>[pid=1][Init][ERROR][init_service_manager.c:1203]Cannot find service bms_protocol.service count 296
09-25 19:17:28.567 <6> [255067.905606] -;[3] pid=1 tid=1 comm=init <6>[pid=1][Init][INFO][init_common_service.c:650]ServiceStart starting:bms_behavior
09-25 19:17:28.567 <6> [255067.906487] -;[1] pid=31806 tid=31807 comm=OS_IPC_0_31807 [dpu_aod]dpu_aod_get_last_screen_status: +
09-25 19:17:28.567 <6> [255067.906531] -;[1] pid=31806 tid=31807 comm=OS_IPC_0_31807 [dpu_aod]aod_screen_status_receive: receive ap length = 20
09-25 19:17:28.567 <6> [255067.906561] -;[1] pid=31806 tid=31807 comm=OS_IPC_0_31807 [dpu_aod]dpu_aod_screen_status_data_req: +
09-25 19:17:28.567 <6> [255067.906600] -;[1] pid=31806 tid=31807 comm=OS_IPC_0_31807 [iomcu_link_ipc_send] [0x18ac05] [0xac0734] tag[0x34],cmd[0x7] lvl 1 resp 1 ver 0 tranid 172 shmem 0 len 24
09-25 19:17:28.567 <6> [255067.906901] -;[0] pid=89 tid=117 comm=dh-irq-bind-0 [iomc_tcp_amsm_recv_handler]tag[0x34]cmd[0x8]len[32]
09-25 19:17:28.567 <6> [255067.907025] -;[2] pid=31806 tid=31807 comm=OS_IPC_0_31807 [I/sensorhub] update_sensor_info: tag 52 cmd 7
09-25 19:17:28.567 <6> [255067.907053] -;[2] pid=31806 tid=31807 comm=OS_IPC_0_31807 [dpu_aod]dpu_aod_screen_status_data_req: -
09-25 19:17:28.567 <6> [255067.907066] -;[2] pid=31806 tid=31807 comm=OS_IPC_0_31807 [dpu_aod]dpu_aod_get_last_screen_status: result_status:0, aod_status:1, screen_status:1,
09-25 19:17:28.567 <6> [255067.907085] -;[2] pid=31806 tid=31807 comm=OS_IPC_0_31807 [dpu_aod]dpu_aod_get_last_screen_status: -
09-25 19:17:28.567 <6> [255067.908639] -;[1] pid=1342 tid=56728 comm=OS_IPC_4_56728 [I/sensorhub] shb_ioctl cmd : batch flush SHB_IOCTL_APP_SENSOR_BATCH
09-25 19:17:28.567 <6> [255067.908679] -;[1] pid=1342 tid=56728 comm=OS_IPC_4_56728 [I/sensorhub] switch_sensor ret is 1, host 0
09-25 19:17:28.567 <6> [255067.908703] -;[1] pid=1342 tid=56728 comm=OS_IPC_4_56728 [I/sensorhub] open sensor TAG_ALS (tag:4)! host:0
09-25 19:17:28.567 <6> [255067.908721] -;[1] pid=1342 tid=56728 comm=OS_IPC_4_56728 [iomcu_link_ipc_send] [0x8ad01] [0xad0104] tag[0x4],cmd[0x1] lvl 1 resp 0 ver 0 tranid 173 shmem 0 len 8
09-25 19:17:28.567 <6> [255067.908889] -;[1] pid=1342 tid=56728 comm=OS_IPC_4_56728 [I/sensorhub] update_sensor_info: tag 4 cmd 1
09-25 19:17:28.567 <6> [255067.908911] -;[1] pid=1342 tid=56728 comm=OS_IPC_4_56728 [I/sensorhub] para->period_ms is zero, set count to 1
09-25 19:17:28.567 <6> [255067.908925] -;[1] pid=1342 tid=56728 comm=OS_IPC_4_56728 [I/sensorhub] send_sensor_batch_flush_cmd batch period=0, count=1
09-25 19:17:28.567 <6> [255067.908941] -;[1] pid=1342 tid=56728 comm=OS_IPC_4_56728 [I/sensorhub] set sensor TAG_ALS (tag:4) delay 0 ms!
09-25 19:17:28.567 <6> [255067.908958] -;[1] pid=1342 tid=56728 comm=OS_IPC_4_56728 [iomcu_link_ipc_send] [0x14ae01] [0xae0504] tag[0x4],cmd[0x5] lvl 1 resp 0 ver 0 tranid 174 shmem 0 len 20
09-25 19:17:28.567 <6> [255067.910718] -;[0] pid=1342 tid=56728 comm=OS_IPC_4_56728 [I/sensorhub] update_sensor_info: tag 4 cmd 5
09-25 19:17:28.567 <6> [255067.918148] -;[3] pid=31806 tid=31807 comm=OS_IPC_0_31807 [dpu_aod]dpu_aod_get_last_backlight: +
09-25 19:17:28.567 <6> [255067.918234] -;[3] pid=31806 tid=31807 comm=OS_IPC_0_31807 [dpu_aod]aod_bl_data_receive: receive ap length = 20
09-25 19:17:28.567 <6> [255067.918262] -;[3] pid=31806 tid=31807 comm=OS_IPC_0_31807 [dpu_aod]dpu_aod_bl_data_req: +
09-25 19:17:28.567 <6> [255067.918296] -;[3] pid=31806 tid=31807 comm=OS_IPC_0_31807 [iomcu_link_ipc_send] [0x18af05] [0xaf0734] tag[0x34],cmd[0x7] lvl 1 resp 1 ver 0 tranid 175 shmem 0 len 24
09-25 19:17:28.567 <6> [255067.918583] -;[0] pid=89 tid=117 comm=dh-irq-bind-0 [iomc_tcp_amsm_recv_handler]tag[0x34]cmd[0x8]len[32]
09-25 19:17:28.567 <6> [255067.918673] -;[3] pid=31806 tid=31807 comm=OS_IPC_0_31807 [I/sensorhub] update_sensor_info: tag 52 cmd 7
09-25 19:17:28.567 <6> [255067.918705] -;[3] pid=31806 tid=31807 comm=OS_IPC_0_31807 [dpu_aod]dpu_aod_bl_data_req: -
09-25 19:17:28.567 <6> [255067.918717] -;[3] pid=31806 tid=31807 comm=OS_IPC_0_31807 [dpu_aod]dpu_aod_get_last_backlight: g_aod_bl_data->data:0
这段日志里有触发亮屏动画的日志么
最新发布