frieza

M10 Tablet - [battery_pm_event] issue

Bug #1574353 reported by Will Atwood on 2016-04-24

This bug affects 5 people

Affects		Status	Importance	Assigned to	Milestone
	Canonical System Image	Confirmed	High	Alfonso Sanchez-Beato
	frieza	Confirmed	High	Unassigned

Bug Description

While tablet is in sleep mode, dmesg is constantly recording the following logs in un-ending loop:

(0)[5951:kworker/u8:1]Freezing of tasks aborted after 0.000 seconds
[ 6609.517243] (0)[5951:kworker/u8:1]Restarting tasks ... done.
[ 6609.518665] (0)[5951:kworker/u8:1]msdc: 0,mmc_schedule_delayed_work ret= 1
[ 6609.518677] (0)[5951:kworker/u8:1]msdc: 1,mmc_schedule_delayed_work ret= 1
[ 6609.518685] (0)[5951:kworker/u8:1][battery_pm_event] pm_event 4
[ 6609.518693] (0)[5951:kworker/u8:1]battery resume NOT by pcm timer!!
[ 6609.518704] (0)[5951:kworker/u8:1]@bs=0@
[ 6609.518785] (0)[5951:kworker/u8:1]PM: suspend exit 2016-04-24 18:05:28.014388308 UTC
[ 6609.518822] (0)[5951:kworker/u8:1]active wakeup source: mmc1_detect
[ 6609.518888] -(0)[8448:kworker/u8:4]INIT: KN@MSDC Card insert<1> Block bad card<0> <- L<9729> PID<kworker/u8:4><0x2100>
[ 6609.518935] (0)[5951:kworker/u8:1][HIB/AUTOSLEEP][try_to_suspend]pm_suspend: state(3)
[ 6609.518945] (0)[5951:kworker/u8:1][HIB/AUTOSLEEP][try_to_suspend]calling pm_suspend() state(3)
[ 6609.518958] (0)[5951:kworker/u8:1]PM: suspend entry 2016-04-24 18:05:28.014563847 UTC
[ 6609.519000] (0)[8448:kworker/u8:4]++
[ 6609.525066] (0)[8448:kworker/u8:4]--
[ 6609.532233] (1)[1129:systemd-logind]systemd-logind[1129]: Failed to apply ACLs: Operation not supported
[ 6609.542941] (1)[1129:systemd-logind]systemd-logind[1129]: Failed to apply ACLs: Operation not supported
[ 6609.518964] (0)[5951:kworker/u8:1]PM: Syncing filesystems ... done.
[ 6609.626699] (0)[5951:kworker/u8:1][battery_pm_event] pm_event 3
[ 6609.626710] (0)[5951:kworker/u8:1]@bs=1@
[ 6609.626718] (0)[5951:kworker/u8:1]Freezing user space processes ...
[ 6609.627173] (0)[5951:kworker/u8:1]active wakeup source: WLAN AHB ISR
[ 6609.627190] (0)[5951:kworker/u8:1]
[ 6609.627197] (0)[5951:kworker/u8:1]Freezing of tasks aborted after 0.000 seconds
[ 6609.627223] (0)[5951:kworker/u8:1]Restarting tasks ... done.
[ 6609.628612] (0)[5951:kworker/u8:1]msdc: 0,mmc_schedule_delayed_work ret= 1
[ 6609.628625] (0)[5951:kworker/u8:1]msdc: 1,mmc_schedule_delayed_work ret= 1
[ 6609.628633] (0)[5951:kworker/u8:1][battery_pm_event] pm_event 4
[ 6609.628642] (0)[5951:kworker/u8:1]battery resume NOT by pcm timer!!
[ 6609.628653] (0)[5951:kworker/u8:1]@bs=0@
[ 6609.628736] (0)[5951:kworker/u8:1]PM: suspend exit 2016-04-24 18:05:28.124339924 UTC
[ 6609.628770] (0)[5951:kworker/u8:1]active wakeup source: WLAN AHB ISR
[ 6609.628779] (0)[5951:kworker/u8:1]active wakeup source: mmc1_detect
[ 6609.631555] -(0)[8448:kworker/u8:4]INIT: KN@MSDC Card insert<1> Block bad card<0> <- L<9729> PID<kworker/u8:4><0x2100>
[ 6609.639200] (0)[1129:systemd-logind]systemd-logind[1129]: Failed to apply ACLs: Operation not supported
[ 6609.650126] (0)[1129:systemd-logind]systemd-logind[1129]: Failed to apply ACLs: Operation not supported
[ 6609.756265] (1)[5951:kworker/u8:1][HIB/AUTOSLEEP][try_to_suspend]pm_suspend: state(3)
[ 6609.756279] (1)[5951:kworker/u8:1][HIB/AUTOSLEEP][try_to_suspend]calling pm_suspend() state(3)
[ 6609.756294] (1)[5951:kworker/u8:1]PM: suspend entry 2016-04-24 18:05:28.251898155 UTC
[ 6609.756328] (0)[8448:kworker/u8:4]++
[ 6609.762126] (0)[8448:kworker/u8:4]--
[ 6609.776259] (0)[82:display_idle_de][DISPCHECK][ddp_idle]primary display path is sleeped?? -- skip ddp_idle
[ 6609.756301] (1)[5951:kworker/u8:1]PM: Syncing filesystems ... done.
[ 6609.866704] (1)[5951:kworker/u8:1][battery_pm_event] pm_event 3
[ 6609.866715] (1)[5951:kworker/u8:1]@bs=1@
[ 6609.866724] (1)[5951:kworker/u8:1]Freezing user space processes ...
[ 6609.867172] (1)[5951:kworker/u8:1]active wakeup source: WLAN AHB ISR
[ 6609.867189] (1)[5951:kworker/u8:1]
[ 6609.867196] (1)[5951:kworker/u8:1]Freezing of tasks aborted after 0.000 seconds
[ 6609.867219] (1)[5951:kworker/u8:1]Restarting tasks ... done.
[ 6609.868604] (1)[5951:kworker/u8:1]msdc: 0,mmc_schedule_delayed_work ret= 1
[ 6609.868617] (1)[5951:kworker/u8:1]msdc: 1,mmc_schedule_delayed_work ret= 1
[ 6609.868625] (1)[5951:kworker/u8:1][battery_pm_event] pm_event 4
[ 6609.868634] (1)[5951:kworker/u8:1]battery resume NOT by pcm timer!!
[ 6609.868645] (1)[5951:kworker/u8:1]@bs=0@
[ 6609.868732] (1)[5951:kworker/u8:1]PM: suspend exit 2016-04-24 18:05:28.364335232 UTC
[ 6609.868765] (1)[5951:kworker/u8:1]active wakeup source: WLAN AHB ISR
[ 6609.868776] (1)[5951:kworker/u8:1]active wakeup source: mmc1_detect
[ 6609.868843] -(1)[8448:kworker/u8:4]INIT: KN@MSDC Card insert<1> Block bad card<0> <- L<9729> PID<kworker/u8:4><0x2100>
[ 6609.877457] (1)[1129:systemd-logind]systemd-logind[1129]: Failed to apply ACLs: Operation not supported
[ 6609.888378] (1)[1129:systemd-logind]systemd-logind[1129]: Failed to apply ACLs: Operation not supported
[ 6609.996304] (0)[5951:kworker/u8:1][HIB/AUTOSLEEP][try_to_suspend]pm_suspend: state(3)
[ 6609.996319] (0)[5951:kworker/u8:1][HIB/AUTOSLEEP][try_to_suspend]calling pm_suspend() state(3)
[ 6609.996335] (0)[5951:kworker/u8:1]PM: suspend entry 2016-04-24 18:05:28.491938462 UTC
[ 6609.996375] (1)[8448:kworker/u8:4]++
[ 6609.996501] (1)[104:mmcqd/0][BLOCK_TAG] mmcqd:104 Workload < 1%, duty 0, period 587114769, req_cnt=0
[ 6609.996514] (1)[104:mmcqd/0][BLOCK_TAG] vmstat (FP:108160)(FD:20)(ND:611648)(WB:0)(NW:596808)
[ 6610.002793] (0)[8448:kworker/u8:4]--
[ 6609.996341] (1)[5951:kworker/u8:1]PM: Syncing filesystems ... done.
[ 6610.106706] (1)[5951:kworker/u8:1][battery_pm_event] pm_event 3
[ 6610.106717] (1)[5951:kworker/u8:1]@bs=1@
[ 6610.106725] (1)[5951:kworker/u8:1]Freezing user space processes ...
[ 6610.107173] (1)[5951:kworker/u8:1]last active wakeup source: WLAN AHB ISR
[ 6610.107184] (1)[5951:kworker/u8:1]
[ 6610.107191] (1)[5951:kworker/u8:1]Freezing of tasks aborted after 0.000 seconds
[ 6610.107215] (1)[5951:kworker/u8:1]Restarting tasks ... done.
[ 6610.107849] (1)[5951:kworker/u8:1]msdc: 0,mmc_schedule_delayed_work ret= 1
[ 6610.107860] (1)[5951:kworker/u8:1]msdc: 1,mmc_schedule_delayed_work ret= 1
[ 6610.107869] (1)[5951:kworker/u8:1][battery_pm_event] pm_event 4
[ 6610.107877] (1)[5951:kworker/u8:1]battery resume NOT by pcm timer!!
[ 6610.107887] (1)[5951:kworker/u8:1]@bs=0@
[ 6610.107974] (1)[5951:kworker/u8:1]PM: suspend exit 2016-04-24 18:05:28.603578001 UTC
[ 6610.108008] (1)[5951:kworker/u8:1]active wakeup source: mmc1_detect
[ 6610.108099] -(1)[8448:kworker/u8:4]INIT: KN@MSDC Card insert<1> Block bad card<0> <- L<9729> PID<kworker/u8:4><0x2100>
[ 6610.108145] (1)[5951:kworker/u8:1][HIB/AUTOSLEEP][try_to_suspend]pm_suspend: state(3)
[ 6610.108155] (1)[5951:kworker/u8:1][HIB/AUTOSLEEP][try_to_suspend]calling pm_suspend() state(3)
[ 6610.108168] (1)[5951:kworker/u8:1]PM: suspend entry 2016-04-24 18:05:28.603773616 UTC
[ 6610.112080] (1)[8448:kworker/u8:4]++
[ 6610.120269] (1)[8448:kworker/u8:4]--

Matthias Apitz (gubu) on 2016-04-24

Changed in canonical-devices-system-image:
status:	New → Confirmed

Pat McGowan (pat-mcgowan) on 2016-04-25

Changed in canonical-devices-system-image:
assignee:	nobody → Alfonso Sanchez-Beato (alfonsosanchezbeato)

Revision history for this message

Will Atwood (skyflyer) wrote on 2016-06-07:

Download full text (5.8 KiB)

OTA-11 update and issue is still a problem. Syslog is flooded with the following messages. Current fix is to attach bt keyboard. Once connected, syslog stops being flooded by battery-pm-event.

OTA-11 update and issue is still a problem.   Syslog is flooded with the following messages.  Current fix is to attach bt keyboard.  Once connected, syslog stops being flooded by battery-pm-event.

+
> Jun  6 09:05:02 ubuntu-phablet kernel: [  424.269572]
> (0)[77:kworker/u8:1]--
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.262366]
> (0)[4571:kworker/u8:0]PM: Syncing filesystems ... done.
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.380058]
> (0)[4571:kworker/u8:0][battery_pm_event] pm_event 3
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.380074]
> (0)[4571:kworker/u8:0]Freezing user space processes ...
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.380432]
> (0)[4571:kworker/u8:0]active wakeup source: WLAN AHB ISR
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.380448]
> (0)[4571:kworker/u8:0]
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.380455]
> (0)[4571:kworker/u8:0]Freezing of tasks aborted after 0.000 seconds
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.380479]
> (0)[4571:kworker/u8:0]Restarting tasks ... done.
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.381303]
> (0)[4571:kworker/u8:0]msdc: 0,mmc_schedule_delayed_work ret= 1
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.381315]
> (0)[4571:kworker/u8:0]msdc: 1,mmc_schedule_delayed_work ret= 1
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.381323]
> (0)[4571:kworker/u8:0][battery_pm_event] pm_event 4
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.381409]
> (0)[4571:kworker/u8:0]PM: suspend exit 2016-06-06 13:05:03.027101024 UTC
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.381423]
> (0)[4571:kworker/u8:0]WQ warning! work (try_to_suspend,
> ffffffc000da6a60) execute more than 1 sec, time: 4853026077 ns
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.381452]
> (0)[4571:kworker/u8:0]active wakeup source: WLAN AHB ISR
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.381461]
> (0)[4571:kworker/u8:0]active wakeup source: mmc1_detect
> Jun  6 09:05:03 ubuntu-phablet kernel: [ 
> 424.381780]-(0)[77:kworker/u8:1]INIT: KN@MSDC Card insert<0> Block bad
> card<0> <- L<9729> PID<kworker/u8:1><0x4d>
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.382080]
> (0)[77:kworker/u8:1]INFO: KN@MSDC [MSDC1] MCLK (260KHz), HCLK(200MHz),
> SCLK(259kHz) MODE(0) DIV(193) buswidth(1-bits)
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.382080] <- L<9359>
> PID<kworker/u8:1><0x4d>
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.382398]
> (0)[77:kworker/u8:1]INFO: KN@MSDC msdc1 -> !!! Set<260KHz>
> Source<200000KHz> -> sclk<259KHz> state<0> mode<0> div<193>
> hs400_src<0> buswidth<1-bit> <- L<3289> PID<kworker/u8:1><0x4d>
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.472375]
> (0)[4571:kworker/u8:0][HIB/AUTOSLEEP][try_to_suspend]pm_suspend: state(3)
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.472390]
> (0)[4571:kworker/u8:0][HIB/AUTOSLEEP][try_to_suspend]calling
> pm_suspend() state(3)
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.472405]
> (0)[4571:kworker/u8:0]PM: suspend entry 2016-06-06 13:05:03.118097485 UTC
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.472447]
> (0)[77:kworker/u8:1]++
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.481024]
> (0)[77:kworker/u8:1]--
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.472411]
> (0)[4571:kworker/u8:0]PM: Syncing filesystems ... done.
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.588848]
> (0)[4571:kworker/u8:0][battery_pm_event] pm_event 3
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.588865]
> (0)[4571:kworker/u8:0]Freezing user space processes ...
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.589215]
> (0)[4571:kworker/u8:0]active wakeup source: WLAN AHB ISR
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.589230]
> (0)[4571:kworker/u8:0]
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.589237]
> (0)[4571:kworker/u8:0]Freezing of tasks aborted after 0.000 seconds
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.589262]
> (0)[4571:kworker/u8:0]Restarting tasks ... done.
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.590092]
> (0)[4571:kworker/u8:0]msdc: 0,mmc_schedule_delayed_work ret= 1
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.590103]
> (0)[4571:kworker/u8:0]msdc: 1,mmc_schedule_delayed_work ret= 1
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.590111]
> (0)[4571:kworker/u8:0][battery_pm_event] pm_event 4
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.590194]
> (0)[4571:kworker/u8:0]PM: suspend exit 2016-06-06 13:05:03.235885947 UTC
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.590226]
> (0)[4571:kworker/u8:0]active wakeup source: WLAN AHB ISR
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.590235]
> (0)[4571:kworker/u8:0]active wakeup source: mmc1_detect
> Jun  6 09:05:03 ubuntu-phablet kernel: [ 
> 424.590260]-(0)[77:kworker/u8:1]INIT: KN@MSDC Card insert<0> Block bad
> card<0> <- L<9729> PID<kworker/u8:1><0x4d>
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.590300]
> (0)[77:kworker/u8:1]INFO: KN@MSDC [MSDC1] MCLK (260KHz), HCLK(200MHz),
> SCLK(259kHz) MODE(0) DIV(193) buswidth(1-bits)
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.590300] <- L<9359>
> PID<kworker/u8:1><0x4d>
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.590614]
> (0)[77:kworker/u8:1]INFO: KN@MSDC msdc1 -> !!! Set<260KHz>
> Source<200000KHz> -> sclk<259KHz> state<0> mode<0> div<193>
> hs400_src<0> buswidth<1-bit> <- L<3289> PID<kworker/u8:1><0x4d>
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.682330]
> (0)[4571:kworker/u8:0][HIB/AUTOSLEEP][try_to_suspend]pm_suspend: state(3)
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.682344]
> (0)[4571:kworker/u8:0][HIB/AUTOSLEEP][try_to_suspend]calling
> pm_suspend() state(3)
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.682359]
> (0)[4571:kworker/u8:0]PM: suspend entry 2016-06-06 13:05:03.328052024 UTC
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.682405]
> (0)[77:kworker/u8:1]++
> Jun  6 09:05:03 ubuntu-phablet kernel: [  424.689286]
> (0)[77:kworker/u8:1]--
>
>
>

Revision history for this message

Pat McGowan (pat-mcgowan) wrote on 2016-07-08:

I wonder if this is related to bug #1577757 where our battery life is poor, we resolved a similar issue with one of the other device kernels.

Changed in frieza:
status:	New → Confirmed
importance:	Undecided → High
Changed in canonical-devices-system-image:
importance:	Undecided → High

Revision history for this message

Will Atwood (skyflyer) wrote on 2016-07-08:

Possibly. My current fix is to leave tablet plugged in which is a problem. I'd love to see a proper fix for this. Thanks Pat for escalating.

Report a bug

This report contains Public information

Everyone can see this information.

You are

Subscribing...

Edit bug mail

Other bug subscribers

Remote bug watches

Bug watches keep track of this bug in other bug trackers.