New issue
Advanced search Search tips
Note: Color blocks (like or ) mean that a user may not be available. Tooltip shows the reason.

Issue 908883 link

Starred by 1 user

Issue metadata

Status: Assigned
Owner:
Cc:
Components:
EstimatedDays: ----
NextAction: ----
OS: Chrome
Pri: 2
Type: Bug



Sign in to add a comment

cheets_StartAndroid.stress failure because Chrome did not start

Project Member Reported by dlaurie@google.com, Nov 27

Issue description

https://cros-goldeneye.corp.google.com/chromeos/healthmonitoring/buildDetails?buildbucketId=8928715851182488592

11/27 03:31:13.183 DEBUG|          autotest:1283| AUTOTEST_STATUS::		FAIL	cheets_StartAndroid.stress	cheets_StartAndroid.stress	timestamp=1543318272	localtime=Nov 27 03:31:12	Unhandled TimeoutException: Timed out while waiting 30s for py_utils.WaitFor(lambda: self.oobe_exists, 30).


It looks like that on iteration 7 the attempt to restart chrome never succeeded and chrome did not start, but there are no Chrome crash dumps:

https://stainless.corp.google.com/browse/chromeos-autotest-results/261552005-chromeos-test/

11/27 03:30:35.097 INFO |cros_browser_backe:0067| Restarting Chrome (pid=28264) with remote port
11/27 03:30:35.098 INFO |cros_browser_backe:0075| dbus-send --system --type=method_call --dest=org.chromium.SessionManager /org/chromium/SessionManager org.chromium.SessionManagerInterface.EnableChromeTesting boolean:true array:string:"--disable-arc-opt-in-verification,--enable-net-benchmarking,--metrics-recording-only,--no-default-browser-check,--no-first-run,--ignore-background-tasks,--enable-gpu-benchmarking,--deny-permission-prompts,--autoplay-policy=no-user-gesture-required,--disable-component-extensions-with-background-pages,--disable-default-apps,--disable-search-geolocation-disclosure,--load-extension=/tmp/extension_fRZFP/autotest_private_ext,--enable-smooth-scrolling,--enable-threaded-compositing,--remote-debugging-port=0,--start-maximized,--ash-disable-system-sounds,--mute-audio,--oobe-skip-postlogin,--disable-logging-redirect,--vmodule=*/chromeos/net/*=2\,*/chromeos/login/*=2\,chrome_browser_main_posix=2,--allow-failed-policy-fetch-for-test,--disable-gaia-services" array:string:
11/27 03:30:35.098 DEBUG|    cros_interface:0058| sh -c dbus-send --system --type=method_call --dest=org.chromium.SessionManager /org/chromium/SessionManager org.chromium.SessionManagerInterface.EnableChromeTesting boolean:true array:string:"--disable-arc-opt-in-verification,--enable-net-benchmarking,--metrics-recording-only,--no-default-browser-check,--no-first-run,--ignore-background-tasks,--enable-gpu-benchmarking,--deny-permission-prompts,--autoplay-policy=no-user-gesture-required,--disable-component-extensions-with-background-pages,--disable-default-apps,--disable-search-geolocation-disclosure,--load-extension=/tmp/extension_fRZFP/autotest_private_ext,--enable-smooth-scrolling,--enable-threaded-compositing,--remote-debugging-port=0,--start-maximized,--ash-disable-system-sounds,--mute-audio,--oobe-skip-postlogin,--disable-logging-redirect,--vmodule=*/chromeos/net/*=2\,*/chromeos/login/*=2\,chrome_browser_main_posix=2,--allow-failed-policy-fetch-for-test,--disable-gaia-services" array:string: 
11/27 03:30:35.098 DEBUG|      global_hooks:0056| ['sh', '-c', 'dbus-send --system --type=method_call --dest=org.chromium.SessionManager /org/chromium/SessionManager org.chromium.SessionManagerInterface.EnableChromeTesting boolean:true array:string:"--disable-arc-opt-in-verification,--enable-net-benchmarking,--metrics-recording-only,--no-default-browser-check,--no-first-run,--ignore-background-tasks,--enable-gpu-benchmarking,--deny-permission-prompts,--autoplay-policy=no-user-gesture-required,--disable-component-extensions-with-background-pages,--disable-default-apps,--disable-search-geolocation-disclosure,--load-extension=/tmp/extension_fRZFP/autotest_private_ext,--enable-smooth-scrolling,--enable-threaded-compositing,--remote-debugging-port=0,--start-maximized,--ash-disable-system-sounds,--mute-audio,--oobe-skip-postlogin,--disable-logging-redirect,--vmodule=*/chromeos/net/*=2\\,*/chromeos/login/*=2\\,chrome_browser_main_posix=2,--allow-failed-policy-fetch-for-test,--disable-gaia-services" array:string:']
11/27 03:30:35.106 DEBUG|    cros_interface:0067|  > stdout=[], stderr=[]
11/27 03:30:35.107 DEBUG|      global_hooks:0056| ['sh', '-c', '/bin/ps --no-headers -A -o pid,ppid,args:4096,state']
11/27 03:30:35.130 DEBUG|    cros_interface:0378| ListProcesses(<predicate>)->[163 processes]
11/27 03:30:35.132 DEBUG|    cros_interface:0320| GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpPMudNT)
11/27 03:30:35.133 DEBUG|    cros_interface:0320| GetFile(/home/chronos/DevToolsActivePort, /tmp/tmp2snhDH)
11/27 03:30:35.233 DEBUG|    cros_interface:0320| GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpZ21MB6)
11/27 03:30:35.334 DEBUG|    cros_interface:0320| GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpV7bVCt)
11/27 03:30:35.436 DEBUG|    cros_interface:0320| GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpgrjkBQ)
11/27 03:30:35.537 DEBUG|    cros_interface:0320| GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpUkRX_s)
11/27 03:30:35.638 DEBUG|    cros_interface:0320| GetFile(/home/chronos/DevToolsActivePort, /tmp/tmp0F1r8e)
11/27 03:30:35.739 DEBUG|    cros_interface:0320| GetFile(/home/chronos/DevToolsActivePort, /tmp/tmph6Du6f)
11/27 03:30:35.840 DEBUG|    cros_interface:0320| GetFile(/home/chronos/DevToolsActivePort, /tmp/tmp8VuQM5)
11/27 03:30:35.941 DEBUG|    cros_interface:0320| GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpwjbJ1h)
11/27 03:30:36.043 DEBUG|    cros_interface:0320| GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpWcjepb)
11/27 03:30:36.144 DEBUG|    cros_interface:0320| GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpqmKF6n)
11/27 03:30:36.246 DEBUG|    cros_interface:0320| GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpWfjqpT)
11/27 03:30:36.358 DEBUG|    cros_interface:0320| GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpEFLQv5)
11/27 03:30:36.482 DEBUG|    cros_interface:0320| GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpPMYpJE)
11/27 03:30:36.483 DEBUG|    cros_interface:0350| GetFileContents(/home/chronos/DevToolsActivePort)->40078
/devtools/browser/60cff937-9f92-41b1-befb-ffebf76475a5
11/27 03:30:36.483 INFO |          __init__:0047| DoNothingForwarder started between 127.0.0.1:40078 and 40078
11/27 03:31:10.138 ERROR|           browser:0054| Failed with TimeoutException while starting the browser backend.
11/27 03:31:10.145 INFO |           browser:0348| *************** BROWSER STANDARD OUTPUT ***************
11/27 03:31:10.146 INFO |           browser:0350| Cannot get standard output on CrOS
11/27 03:31:10.146 INFO |           browser:0353| *********** END OF BROWSER STANDARD OUTPUT ************
11/27 03:31:10.147 INFO |           browser:0355| ********************* BROWSER LOG *********************
11/27 03:31:10.147 INFO |           browser:0357| No log file
11/27 03:31:10.147 INFO |           browser:0360| ***************** END OF BROWSER LOG ******************

 
It looks like both times this specific test ran on the same host chromeos4-row8-rack4-host6, but I don't see any specific signs of system level issues on this host in the logs.
Cc: gmeinke@chromium.org
Components: Platform>Apps>ARC
Labels: -Pri-3 Pri-2
This has happened again here:

https://stainless.corp.google.com/browse/chromeos-autotest-results/277164581-chromeos-test/

https://cros-goldeneye.corp.google.com/chromeos/healthmonitoring/buildDetails?buildbucketId=8924267766970539520

and it ruined a CQ run.

Owner: jhorwich@chromium.org
Status: Assigned (was: Untriaged)
Assigning to current ARC constable.
Cc: evanhernandez@chromium.org

Sign in to add a comment