Closed Bug 1478864 Opened 7 years ago Closed 7 years ago

Intermittent toolkit/components/extensions/test/browser/browser_ext_themes_ntp_colors_perwindow.js with Automation Error: mozprocess timed out after 1000 seconds running ['/builds/worker/workspace/build/venv/bin/python', '-u',

Categories

(WebExtensions :: General, defect, P5)

defect

Tracking

(Not tracked)

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

Filed by: ncsoregi [at] mozilla.com https://treeherder.mozilla.org/logviewer.html#?job_id=190420495&repo=mozilla-central https://queue.taskcluster.net/v1/task/adzvzpInQ6-WgiDsB3tLmQ/runs/0/artifacts/public/logs/live_backing.log [task 2018-07-27T00:09:37.221Z] 00:09:37 INFO - TEST-START | toolkit/components/extensions/test/browser/browser_ext_themes_ntp_colors_perwindow.js [task 2018-07-27T00:26:17.247Z] 00:26:17 INFO - Automation Error: mozprocess timed out after 1000 seconds running ['/builds/worker/workspace/build/venv/bin/python', '-u', '/builds/worker/workspace/build/tests/mochitest/runtests.py', '--total-chunks', '7', '--this-chunk', '5', '--jscov-dir-prefix=/builds/worker/workspace/build/blobber_upload_dir', '--appname=/builds/worker/workspace/build/application/firefox/firefox', '--utility-path=tests/bin', '--extra-profile-file=tests/bin/plugins', '--symbols-path=https://queue.taskcluster.net/v1/task/L4Bi87DVRzWrtFOZzEVljQ/artifacts/public/build/target.crashreporter-symbols.zip', '--certificate-path=tests/certs', '--setpref=webgl.force-enabled=true', '--quiet', '--log-raw=/builds/worker/workspace/build/blobber_upload_dir/browser-chrome-coverage_raw.log', '--log-errorsummary=/builds/worker/workspace/build/blobber_upload_dir/browser-chrome-coverage_errorsummary.log', '--use-test-media-devices', '--screenshot-on-fail', '--cleanup-crashes', '--marionette-startup-timeout=180', '--sandbox-read-whitelist=/builds/worker/workspace/build', '--log-raw=-', '--flavor=browser', '--chunk-by-runtime', '--timeout=1200'] [task 2018-07-27T00:26:17.261Z] 00:26:17 ERROR - timed out after 1000 seconds of no output [task 2018-07-27T00:26:17.261Z] 00:26:17 ERROR - Return code: -15 [task 2018-07-27T00:26:17.262Z] 00:26:17 ERROR - No suite end message was emitted by this harness. [task 2018-07-27T00:26:17.264Z] 00:26:17 INFO - TinderboxPrint: mochitest-browser-chrome-coverage<br/>309/0/0 [task 2018-07-27T00:26:17.264Z] 00:26:17 ERROR - # TBPL FAILURE # [task 2018-07-27T00:26:17.264Z] 00:26:17 WARNING - setting return code to 2 [task 2018-07-27T00:26:17.264Z] 00:26:17 ERROR - The mochitest suite: browser-chrome-coverage ran with return status: FAILURE [task 2018-07-27T00:26:17.264Z] 00:26:17 INFO - Running post-action listener: _package_coverage_data [task 2018-07-27T00:26:17.264Z] 00:26:17 INFO - Beginning compression of JSDCov artifacts... [task 2018-07-27T00:26:22.437Z] 00:26:22 INFO - Completed compression of JSDCov artifacts! [task 2018-07-27T00:26:22.438Z] 00:26:22 INFO - Path to JSDCov compressed artifacts: /builds/worker/workspace/build/blobber_upload_dir/jsdcov_artifacts.zip [task 2018-07-27T00:26:22.438Z] 00:26:22 INFO - Running post-action listener: _resource_record_post_action [task 2018-07-27T00:26:22.438Z] 00:26:22 INFO - [mozharness: 2018-07-27 00:26:22.438504Z] Finished run-tests step (success) [task 2018-07-27T00:26:22.438Z] 00:26:22 INFO - Running post-run listener: _resource_record_post_run [task 2018-07-27T00:26:22.578Z] 00:26:22 INFO - Validating Perfherder data against /builds/worker/workspace/mozharness/external_tools/performance-artifact-schema.json [task 2018-07-27T00:26:22.582Z] 00:26:22 INFO - PERFHERDER_DATA: {"framework": {"name": "job_resource_usage"}, "suites": [{"subtests": [{"name": "cpu_percent", "value": 14.520612191276916}, {"name": "io_write_bytes", "value": 2685337600}, {"name": "io.read_bytes", "value": 16826368}, {"name": "io_write_time", "value": 144644}, {"name": "io_read_time", "value": 1432}], "extraOptions": ["e10s", "taskcluster-c3.xlarge"], "name": "mochitest.browser-chrome-coverage.5.overall"}, {"subtests": [{"name": "time", "value": 15.137241125106812}, {"name": "cpu_percent", "value": 25.13}], "name": "mochitest.browser-chrome-coverage.5.install"}, {"subtests": [{"name": "time", "value": 0.0006821155548095703}], "name": "mochitest.browser-chrome-coverage.5.stage-files"}, {"subtests": [{"name": "time", "value": 1891.217966079712}, {"name": "cpu_percent", "value": 14.43224695283517}], "name": "mochitest.browser-chrome-coverage.5.run-tests"}]} [task 2018-07-27T00:26:22.582Z] 00:26:22 INFO - Total resource usage - Wall time: 1906s; CPU: 14.0%; Read bytes: 16826368; Write bytes: 2685337600; Read time: 1432; Write time: 144644 [task 2018-07-27T00:26:22.582Z] 00:26:22 INFO - TinderboxPrint: CPU usage<br/>14.4% [task 2018-07-27T00:26:22.583Z] 00:26:22 INFO - TinderboxPrint: I/O read bytes / time<br/>16,826,368 / 1,432 [task 2018-07-27T00:26:22.583Z] 00:26:22 INFO - TinderboxPrint: I/O write bytes / time<br/>2,685,337,600 / 144,644 [task 2018-07-27T00:26:22.583Z] 00:26:22 INFO - TinderboxPrint: CPU idle<br/>6,396.2 (85.5%) [task 2018-07-27T00:26:22.584Z] 00:26:22 INFO - TinderboxPrint: CPU system<br/>137.0 (1.8%) [task 2018-07-27T00:26:22.584Z] 00:26:22 INFO - TinderboxPrint: CPU user<br/>934.1 (12.5%) [task 2018-07-27T00:26:22.584Z] 00:26:22 INFO - TinderboxPrint: Swap in / out<br/>0 / 0 [task 2018-07-27T00:26:22.586Z] 00:26:22 INFO - install - Wall time: 15s; CPU: 25.0%; Read bytes: 0; Write bytes: 48963584; Read time: 0; Write time: 32668 [task 2018-07-27T00:26:22.587Z] 00:26:22 INFO - stage-files - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 [task 2018-07-27T00:26:22.605Z] 00:26:22 INFO - run-tests - Wall time: 1891s; CPU: 14.0%; Read bytes: 16285696; Write bytes: 2636357632; Read time: 1416; Write time: 111976 [task 2018-07-27T00:26:23.146Z] 00:26:23 INFO - Running post-run listener: copy_logs_to_upload_dir [task 2018-07-27T00:26:23.146Z] 00:26:23 INFO - Copying logs to upload dir... [task 2018-07-27T00:26:23.147Z] 00:26:23 INFO - mkdir: /builds/worker/workspace/build/upload/logs [task 2018-07-27T00:26:23.150Z] 00:26:23 INFO - Copying logs to upload dir... [task 2018-07-27T00:26:23.152Z] 00:26:23 WARNING - returning nonzero exit status 2 [task 2018-07-27T00:26:23.171Z] cleanup [task 2018-07-27T00:26:23.172Z] + cleanup [task 2018-07-27T00:26:23.172Z] + local rv=2 [task 2018-07-27T00:26:23.172Z] + [[ -s /builds/worker/.xsession-errors ]] [task 2018-07-27T00:26:23.172Z] + cp /builds/worker/.xsession-errors /builds/worker/artifacts/public/xsession-errors.log [task 2018-07-27T00:26:23.176Z] + true [task 2018-07-27T00:26:23.176Z] + cleanup_xvfb [task 2018-07-27T00:26:23.177Z] pidof Xvfb [task 2018-07-27T00:26:23.177Z] ++ pidof Xvfb [task 2018-07-27T00:26:23.181Z] + local xvfb_pid=25 [task 2018-07-27T00:26:23.181Z] + local vnc=false [task 2018-07-27T00:26:23.181Z] + local interactive=false [task 2018-07-27T00:26:23.181Z] + '[' -n 25 ']' [task 2018-07-27T00:26:23.181Z] + [[ false == false ]] [task 2018-07-27T00:26:23.181Z] + [[ false == false ]] [task 2018-07-27T00:26:23.181Z] + kill 25 [task 2018-07-27T00:26:23.189Z] + screen -XS xvfb quit [task 2018-07-27T00:26:23.189Z] XIO: fatal IO error 11 (Resource temporarily unavailable) on X server ":0" [task 2018-07-27T00:26:23.189Z] after 58719 requests (58719 known processed) with 1 events remaining. [task 2018-07-27T00:26:23.189Z] compizconfig - Info: Backend : ini [task 2018-07-27T00:26:23.189Z] compizconfig - Info: Integration : true [task 2018-07-27T00:26:23.189Z] compizconfig - Info: Profile : default [task 2018-07-27T00:26:23.344Z] No screen session found. [task 2018-07-27T00:26:23.344Z] + true [task 2018-07-27T00:26:23.345Z] + exit 2 [taskcluster 2018-07-27 00:26:23.927Z] === Task Finished === [taskcluster 2018-07-27 00:26:33.438Z] Unsuccessful task run with exit code: 2 completed in 2243.679 seconds
Status: NEW → RESOLVED
Closed: 7 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.