HP Chromebook 13 sometimes does not go to sleep due to active audio stream
Reported by
chriswil...@gmail.com,
Jun 17 2017
|
||||||||||
Issue descriptionUserAgent: Mozilla/5.0 (X11; CrOS x86_64 9334.72.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/58.0.3029.140 Safari/537.36 Platform: 9334.72.0 (Official Build) stable-channel chell Steps to reproduce the problem: 1. step away from the laptop 2. wait the appropriate amount of time so the laptop should suspend 3. note that it does not suspend (sometimes) What is the expected behavior? The laptop suspends. What went wrong? The laptop does not suspend. The issue doesn't happen every time but I *think* that, once the issue occurs, it occurs reliably until a machine restart, or possibly a logout. Did this work before? N/A Chrome version: 58.0.3029.140 Channel: stable OS Version: 9334.72.0 Flash Version: 25.0.0.171
,
Jun 17 2017
,
Jun 21 2017
note: this only happens for the secondary account. ie. I log in with account X and then log in w/ account Y while account X is already logged in. The issue only occurs for Y.
,
Jul 18 2017
doesn't seem like a privacy issue
,
Jul 18 2017
chriswillmorris@, can you send feedback (Shift+Alt+i), after reproducing the issue. Thanks.
,
Jul 18 2017
Tested on M59 Stable and M61 (ToT) using 'set_short_powerd_timeouts' command to faster repro. Able to repro on M59, please see stack trace below: M59: Suspending is missing: Google Chrome 59.0.3071.134 (Official Build) (64-bit) Revision 0 Platform 9460.73.0 (Official Build) stable-channel chell Firmware Version Google_Chell.7820.253.0 [0718/151836:INFO:state_controller.cc(89)] Dimming screen after 10s [0718/151836:INFO:internal_backlight_controller.cc(682)] Setting brightness to 19 (35.4143%) over 200 ms [0718/151838:INFO:daemon.cc(777)] On battery at 55%, 2.154/3.901Ah at 0.241A, 12h45m45s until empty (11h50m17s until shutdown)[0718/151841:INFO:state_controller.cc(89)] Turning screen off after 15s [0718/151841:INFO:internal_backlight_controller.cc(682)] Setting brightness to 0 (0%) over 200 ms [0718/151841:INFO:display_power_setter.cc(82)] Asking Chrome to turn all displays off [0718/151841:INFO:daemon.cc(1394)] Chrome is using normal display mode [0718/151846:INFO:activity_logger.cc(20)] User activity stopped; last reported 20 sec ago [0718/151848:INFO:activity_logger.cc(20)] Audio activity ongoing [0718/151856:INFO:keyboard_backlight_controller.cc(492)] Setting brightness to 0 (0%) over 2000 ms [0718/151908:INFO:daemon.cc(777)] On battery at 55%, 2.153/3.901Ah at 0.064A, 16h30m24s until empty (15h18m37s until shutdown) [0718/151908:INFO:activity_logger.cc(20)] User activity reported [0718/151908:INFO:state_controller.cc(96)] Undimming screen [0718/151908:INFO:state_controller.cc(96)] Turning screen on [0718/151908:INFO:display_power_setter.cc(82)] Asking Chrome to turn all displays on [0718/151909:INFO:internal_backlight_controller.cc(682)] Setting brightness to 53 (55.8%) over 0 ms [0718/151909:INFO:keyboard_backlight_controller.cc(492)] Setting brightness to 10 (10%) over 200 ms [0718/151909:INFO:daemon.cc(1394)] Chrome is using normal display mode M61 (ToT) Successful suspend: Google Chrome 61.0.3159.0 (Official Build) dev (64-bit) Revision 0 Platform 9756.0.0 (Official Build) dev-channel chell Firmware Version Google_Chell.7820.253.0 [0718/154840:INFO:daemon.cc(777)] On battery at 51% (displayed as 50%), 1.968/3.866Ah at 0.290A, 6h12m10s until empty (5h42m56s until shutdown) [0718/154846:INFO:state_controller.cc(89)] Dimming screen after 10s [0718/154846:INFO:internal_backlight_controller.cc(682)] Setting brightness to 19 (35.4143%) over 200 ms [0718/154851:INFO:state_controller.cc(89)] Turning screen off after 15s [0718/154851:INFO:internal_backlight_controller.cc(682)] Setting brightness to 0 (0%) over 200 ms [0718/154851:INFO:display_power_setter.cc(82)] Asking Chrome to turn all displays off [0718/154852:INFO:daemon.cc(1396)] Chrome is using normal display mode [0718/154856:INFO:activity_logger.cc(20)] User activity stopped; last reported 20 sec ago [0718/154859:INFO:state_controller.cc(914)] Ready to perform idle action (suspend) after 20s [0718/154859:INFO:suspender.cc(402)] Starting request 600506370 [0718/154859:INFO:daemon.cc(602)] Reading wakeup count from /sys/power/wakeup_count [0718/154859:INFO:daemon.cc(606)] Read wakeup count 961 [0718/154859:INFO:internal_backlight_controller.cc(699)] Setting resume brightness to 53 (55.8%) [0718/154859:INFO:keyboard_backlight_controller.cc(492)] Setting brightness to 0 (0%) over 0 ms [0718/154859:INFO:suspend_delay_controller.cc(140)] Announcing suspend request 600506370 with 2 pending delay(s) and 0 outstanding delay(s) from previous request [0718/154859:INFO:suspend_delay_controller.cc(86)] Got notification that delay 600506369 (shill) is ready for suspend request 600506370 from :1.10 [0718/154859:INFO:suspend_delay_controller.cc(86)] Got notification that delay 600506370 (chrome) is ready for suspend request 600506370 from :1.66 [0718/154859:INFO:suspend_delay_controller.cc(232)] Notifying observers that suspend is ready [0718/154859:INFO:suspender.cc(473)] Starting suspend [0718/154859:INFO:main.cc(233)] Running "/usr/bin/powerd_setuid_helper --action=suspend --suspend_wakeup_count_valid --suspend_wakeup_count=961" [0718/154936:INFO:daemon.cc(698)] powerd_suspend returned 0 [0718/154936:INFO:suspender.cc(429)] Finishing request 600506370 successfully [0718/154936:INFO:state_controller.cc(96)] Undimming screen [0718/154936:INFO:internal_backlight_controller.cc(699)] Setting resume brightness to 53 (55.8%) [0718/154936:INFO:state_controller.cc(96)] Turning screen on [0718/154936:INFO:internal_backlight_controller.cc(699)] Setting resume brightness to 53 (55.8%) [0718/154936:INFO:display_power_setter.cc(82)] Asking Chrome to turn all displays on [0718/154936:INFO:internal_backlight_controller.cc(682)] Setting brightness to 53 (55.8%) over 0 ms [0718/154936:INFO:keyboard_backlight_controller.cc(492)] Setting brightness to 10 (10%) over 200 ms [0718/154936:INFO:daemon.cc(1396)] Chrome is using normal display mode [0718/154936:INFO:daemon.cc(777)] On battery at 51% (displayed as 50%), 1.967/3.866Ah at 0.088A, 0s until empty (calculating) [0718/154937:INFO:daemon.cc(1396)] Chrome is using normal display mode
,
Jul 18 2017
'Audio activity ongoing' log present at the M59 build. I do not remember having audio going on during the test. pgangishetty@, can you confirm there was no audio playing while leaving device to suspend?
,
Jul 19 2017
Go to chrome://media-internals/ to look for the open audio stream(s).
,
Jul 19 2017
Stack trace from today's test on M59: [0719/103511:INFO:state_controller.cc(89)] Dimming screen after 10s [0719/103511:INFO:internal_backlight_controller.cc(682)] Setting brightness to 19 (35.4143%) over 200 ms [0719/103516:INFO:state_controller.cc(89)] Turning screen off after 15s [0719/103516:INFO:internal_backlight_controller.cc(682)] Setting brightness to 0 (0%) over 200 ms [0719/103516:INFO:display_power_setter.cc(82)] Asking Chrome to turn all displays off [0719/103516:INFO:daemon.cc(1394)] Chrome is using normal display mode [0719/103521:INFO:activity_logger.cc(20)] User activity stopped; last reported 20 sec ago [0719/103531:INFO:keyboard_backlight_controller.cc(492)] Setting brightness to 0 (0%) over 2000 ms [0719/103533:INFO:activity_logger.cc(20)] Audio activity ongoing [0719/103538:INFO:daemon.cc(777)] On battery at 52%, 2.021/3.870Ah at 0.065A, 11h4m46s until empty (10h13m51s until shutdown) [0719/103604:INFO:activity_logger.cc(20)] User activity reported [0719/103604:INFO:state_controller.cc(96)] Undimming screen [0719/103604:INFO:state_controller.cc(96)] Turning screen on [0719/103604:INFO:display_power_setter.cc(82)] Asking Chrome to turn all displays on [0719/103605:INFO:internal_backlight_controller.cc(682)] Setting brightness to 53 (55.8%) over 0 ms [0719/103605:INFO:keyboard_backlight_controller.cc(492)] Setting brightness to 10 (10%) over 200 ms [0719/103605:INFO:daemon.cc(1394)] Chrome is using normal display mode [0719/103608:INFO:daemon.cc(777)] On battery at 52%, 2.020/3.870Ah at 0.265A, 11h24m37s until empty (10h32m9s until shutdown) [0719/103624:INFO:state_controller.cc(443)] Reloading prefs for disable_idle_suspend change Media-internals log & Screenshot here: https://pantheon.corp.google.com/storage/browser/chromiumos-test-logs/bugfiles/cr/734331/
,
Jul 19 2017
Update on #9 : I did not initiate any audio on any of the 2 user accounts logged in.
,
Jul 19 2017
Over to the audio team to help figure out what's holding the stream open.
,
Jul 19 2017
,
Jul 20 2017
In screenshot in the log #9, 1~4 were bell sound of crosh. 5 were incoming message notification sound. 6 and 7 were incoming hangout call sound. The media-internal logs show that all the streams are not playing. Their pipeline state are either kSuspended or kStopped. I am not sure why there is still a output controller 0:2 holding stream 0:0. Dale probably has better idea what is going on.
,
Jul 20 2017
Probably a stale audio context. See issue 707462 or issue 732450 . I just enabled silent audio suspension in https://chromium-review.googlesource.com/c/568817/ so you might see if dev channel fixes this issue.
,
Jul 28 2017
chriswillmorris@gmail.com, can you upgrade to the latest dev build to see if this issue is fixed?
,
Jul 29 2017
Hello. I don't use the 'dev' channel and, to be honest, am pretty burnt out on helping to debug Chrome issues. I've spent numerous hours helping people identify Bluetooth and audio issues in the past and am just burnt out. So I won't be helping to confirm this is fixed if it requires switching channels or taking other steps. I know that makes it harder for you all, but it sounds like others have been able to reproduce the problem. And for what it's worth, I stopped using the HP Chromebook 13 and am using a Pixel 2 2015 (Samus), and the issue exists on this device, as well.
,
Aug 3 2017
give to Chromebook team. This is is not observed on my LINK and Nyan device.
,
Aug 4 2017
assign to jimmy to track, but it looks like dale's fix will take care of this once it hits stable.
,
Aug 4 2017
I verified on my chell using latest dev channel image R62 9806.0. |
||||||||||
►
Sign in to add a comment |
||||||||||
Comment 1 by est...@chromium.org
, Jun 17 2017Components: Privacy
Labels: -Restrict-View-SecurityTeam Restrict-View-ChromePrivacy