Closed Bug 1834137 Opened 3 years ago Closed 2 years ago

Intermittent layout/generic/crashtests/473894-1.html | single tracking bug

Categories

(Core :: Layout, defect, P5)

defect

Tracking

()

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure, intermittent-testcase)

Filed by: sstanca [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=416414478&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/GCdIUvPQRcyT6TXX9HKUhg/runs/0/artifacts/public/logs/live_backing.log
Reftest URL: https://hg.mozilla.org/mozilla-central/raw-file/tip/layout/tools/reftest/reftest-analyzer.xhtml#logurl=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/GCdIUvPQRcyT6TXX9HKUhg/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1


[task 2023-05-19T22:00:50.019Z] 22:00:50     INFO - REFTEST TEST-START | layout/generic/crashtests/473894-1.html
[task 2023-05-19T22:00:50.019Z] 22:00:50     INFO - REFTEST TEST-LOAD | file:///Z:/task_168452774123176/build/tests/reftest/tests/layout/generic/crashtests/473894-1.html | 2496 / 3976 (62%)
[task 2023-05-19T22:00:50.192Z] 22:00:50     INFO - 1684533650194	Marionette	TRACE	Received observer notification quit-application
[task 2023-05-19T22:00:50.195Z] 22:00:50     INFO - 1684533650194	Marionette	INFO	Stopped listening on port 2828
[task 2023-05-19T22:00:50.198Z] 22:00:50     INFO - 1684533650198	Marionette	DEBUG	Marionette stopped listening
[task 2023-05-19T22:00:50.820Z] 22:00:50     INFO - [5680, IPC I/O Child] WARNING: failed to create pipe: 2: file /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/ipc_channel_win.cc:237
[task 2023-05-19T22:00:50.834Z] 22:00:50     INFO - [5680, IPC I/O Child] WARNING: Unable to create pipe named "8132.90.258552609\302172517" in client mode.: file /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/ipc_channel_win.cc:55
[task 2023-05-19T22:00:50.851Z] 22:00:50     INFO - Exiting due to channel error.
[task 2023-05-19T22:00:51.118Z] 22:00:51     INFO - [9248, IPC I/O Child] WARNING: failed to create pipe: 2: file /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/ipc_channel_win.cc:237
[task 2023-05-19T22:00:51.124Z] 22:00:51     INFO - [9248, IPC I/O Child] WARNING: Unable to create pipe named "8132.105.547123487\1188161977" in client mode.: file /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/ipc_channel_win.cc:55
[task 2023-05-19T22:00:51.150Z] 22:00:51     INFO - Exiting due to channel error.
[task 2023-05-19T22:00:51.291Z] 22:00:51     INFO - [9020, IPC I/O Child] WARNING: failed to create pipe: 2: file /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/ipc_channel_win.cc:237
[task 2023-05-19T22:00:51.298Z] 22:00:51     INFO - [9020, IPC I/O Child] WARNING: Unable to create pipe named "8132.101.1795721754\213506655" in client mode.: file /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/ipc_channel_win.cc:55
[task 2023-05-19T22:00:51.309Z] 22:00:51     INFO - Exiting due to channel error.
[task 2023-05-19T22:00:51.369Z] 22:00:51     INFO - !!! error running onStopped callback: TypeError: callback is not a function
[task 2023-05-19T22:00:52.327Z] 22:00:52     INFO - [5852, IPC I/O Child] WARNING: failed to create pipe: 2: file /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/ipc_channel_win.cc:237
[task 2023-05-19T22:00:52.333Z] 22:00:52     INFO - [5852, IPC I/O Child] WARNING: Unable to create pipe named "8132.98.345257738\1220207192" in client mode.: file /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/ipc_channel_win.cc:55
[task 2023-05-19T22:00:52.359Z] 22:00:52     INFO - Exiting due to channel error.
[task 2023-05-19T22:00:52.421Z] 22:00:52     INFO - [7696, IPC I/O Child] WARNING: failed to create pipe: 2: file /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/ipc_channel_win.cc:237
[task 2023-05-19T22:00:52.428Z] 22:00:52     INFO - [7696, IPC I/O Child] WARNING: Unable to create pipe named "8132.100.335764361\668166923" in client mode.: file /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/ipc_channel_win.cc:55
[task 2023-05-19T22:00:52.453Z] 22:00:52     INFO - Exiting due to channel error.
[task 2023-05-19T22:00:52.594Z] 22:00:52     INFO - [6588, IPC I/O Child] WARNING: failed to create pipe: 2: file /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/ipc_channel_win.cc:237
[task 2023-05-19T22:00:52.597Z] 22:00:52     INFO - [6588, IPC I/O Child] WARNING: Unable to create pipe named "8132.97.1456716993\793358307" in client mode.: file /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/ipc_channel_win.cc:55
[task 2023-05-19T22:00:52.610Z] 22:00:52     INFO - Exiting due to channel error.
[task 2023-05-19T22:00:52.830Z] 22:00:52     INFO - [4132, IPC I/O Child] WARNING: failed to create pipe: 2: file /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/ipc_channel_win.cc:237
[task 2023-05-19T22:00:52.837Z] 22:00:52     INFO - [4132, IPC I/O Child] WARNING: Unable to create pipe named "8132.99.840120634\1076545135" in client mode.: file /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/ipc_channel_win.cc:55
[task 2023-05-19T22:00:52.848Z] 22:00:52     INFO - Exiting due to channel error.
[task 2023-05-19T22:00:53.394Z] 22:00:53     INFO - [6992, IPC I/O Child] WARNING: failed to create pipe: 2: file /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/ipc_channel_win.cc:237
[task 2023-05-19T22:00:53.396Z] 22:00:53     INFO - [6992, IPC I/O Child] WARNING: Unable to create pipe named "8132.96.743753818\204869210" in client mode.: file /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/ipc_channel_win.cc:55
[task 2023-05-19T22:00:53.404Z] 22:00:53     INFO - Exiting due to channel error.
[task 2023-05-19T22:00:55.637Z] 22:00:55     INFO - [Parent 8132, IPC I/O Parent] WARNING: Process 4864 may be hanging at shutdown; will wait for up to 40000ms: file /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/process_watcher_win.cc:129
[task 2023-05-19T22:01:08.156Z] 22:01:08    ERROR - TEST-UNEXPECTED-FAIL | layout/generic/crashtests/473894-1.html | application terminated with exit code 245
[task 2023-05-19T22:01:08.282Z] 22:01:08     INFO - REFTEST INFO | Process mode: e10s
[task 2023-05-19T22:01:08.286Z] 22:01:08  WARNING - leakcheck | refcount logging is off, so leaks can't be detected!
[task 2023-05-19T22:01:08.344Z] 22:01:08     INFO - Return code: 245
[task 2023-05-19T22:01:08.345Z] 22:01:08    ERROR - No suite end message was emitted by this harness.
[task 2023-05-19T22:01:08.345Z] 22:01:08     INFO - TinderboxPrint: reftest-crashtest<br/>4978/0/0
[task 2023-05-19T22:01:08.345Z] 22:01:08  WARNING - setting return code to 2
[task 2023-05-19T22:01:08.346Z] 22:01:08     INFO - The reftest suite: crashtest ran with return status: FAILURE
[task 2023-05-19T22:01:08.346Z] 22:01:08     INFO - Running post-action listener: _package_coverage_data
[task 2023-05-19T22:01:08.346Z] 22:01:08     INFO - Running post-action listener: _resource_record_post_action
[task 2023-05-19T22:01:08.346Z] 22:01:08     INFO - Running post-action listener: process_java_coverage_data
[task 2023-05-19T22:01:08.346Z] 22:01:08     INFO - [mozharness: 2023-05-19 22:01:08.346049Z] Finished run-tests step (success)
[task 2023-05-19T22:01:08.346Z] 22:01:08     INFO - [mozharness: 2023-05-19 22:01:08.346049Z] Running uninstall step.
[task 2023-05-19T22:01:08.346Z] 22:01:08     INFO - Running pre-action listener: _resource_record_pre_action
[task 2023-05-19T22:01:08.346Z] 22:01:08     INFO - Running main action method: uninstall
[task 2023-05-19T22:01:08.346Z] 22:01:08     INFO - Skipping uninstall for non-MSIX test
[task 2023-05-19T22:01:08.346Z] 22:01:08     INFO - Running post-action listener: _resource_record_post_action
[task 2023-05-19T22:01:08.346Z] 22:01:08     INFO - [mozharness: 2023-05-19 22:01:08.346570Z] Finished uninstall step (success)
[task 2023-05-19T22:01:08.346Z] 22:01:08     INFO - Running post-run listener: _resource_record_post_run
[task 2023-05-19T22:01:09.048Z] 22:01:09     INFO - instance_metadata.json not found; unable to determine instance type
[task 2023-05-19T22:01:09.066Z] 22:01:09     INFO - Validating Perfherder data against Z:\task_168452774123176\mozharness\external_tools\performance-artifact-schema.json
[task 2023-05-19T22:01:09.068Z] 22:01:09     INFO - PERFHERDER_DATA: {"framework": {"name": "job_resource_usage"}, "suites": [{"name": "reftest.crashtest.overall", "extraOptions": ["e10s", "buildbot-unknown"], "subtests": [{"name": "cpu_percent", "value": 43.10108695652173}, {"name": "io_write_bytes", "value": 2411164672}, {"name": "io.read_bytes", "value": 987534848}, {"name": "io_write_time", "value": 77}, {"name": "io_read_time", "value": 451}]}, {"name": "reftest.crashtest.start-pulseaudio", "subtests": [{"name": "time", "value": 0.0005412101745605469}, {"name": "cpu_percent", "value": 0}]}, {"name": "reftest.crashtest.install", "subtests": [{"name": "time", "value": 11.068346500396729}, {"name": "cpu_percent", "value": 38.919999999999995}]}, {"name": "reftest.crashtest.stage-files", "subtests": [{"name": "time", "value": 0.0}, {"name": "cpu_percent", "value": 0}]}, {"name": "reftest.crashtest.run-tests", "subtests": [{"name": "time", "value": 728.51322722435}, {"name": "cpu_percent", "value": 43.14710344827586}]}, {"name": "reftest.crashtest.uninstall", "subtests": [{"name": "time", "value": 0.0005207061767578125}, {"name": "cpu_percent", "value": 0}]}]}
[task 2023-05-19T22:01:09.068Z] 22:01:09     INFO - Total resource usage - Wall time: 739s; CPU: Can't collect data; Read bytes: 987534848; Write bytes: 2411164672; Read time: 451; Write time: 77
[task 2023-05-19T22:01:09.068Z] 22:01:09     INFO - TinderboxPrint: I/O read bytes / time<br/>987,534,848 / 451
[task 2023-05-19T22:01:09.068Z] 22:01:09     INFO - TinderboxPrint: I/O write bytes / time<br/>2,411,164,672 / 77
[task 2023-05-19T22:01:09.068Z] 22:01:09     INFO - TinderboxPrint: CPU idle<br/>3,369.1 (56.9%)
[task 2023-05-19T22:01:09.068Z] 22:01:09     INFO - TinderboxPrint: CPU system<br/>865.6 (14.6%)
[task 2023-05-19T22:01:09.068Z] 22:01:09     INFO - TinderboxPrint: CPU user<br/>1,677.2 (28.3%)
[task 2023-05-19T22:01:09.069Z] 22:01:09     INFO - start-pulseaudio - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2023-05-19T22:01:09.069Z] 22:01:09     INFO - install - Wall time: 11s; CPU: 39%; Read bytes: 156793856; Write bytes: 876633088; Read time: 0; Write time: 20
[task 2023-05-19T22:01:09.069Z] 22:01:09     INFO - stage-files - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2023-05-19T22:01:09.074Z] 22:01:09     INFO - run-tests - Wall time: 729s; CPU: 43%; Read bytes: 748503040; Write bytes: 1446115328; Read time: 451; Write time: 55
[task 2023-05-19T22:01:09.074Z] 22:01:09     INFO - uninstall - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2023-05-19T22:01:09.219Z] 22:01:09  WARNING - returning nonzero exit status 2
[taskcluster 2023-05-19T22:01:09.345Z]    Exit Code: 2
[taskcluster 2023-05-19T22:01:09.345Z]    User Time: 0s
[taskcluster 2023-05-19T22:01:09.345Z]  Kernel Time: 15.625ms
[taskcluster 2023-05-19T22:01:09.345Z]    Wall Time: 16m11.9384023s
[taskcluster 2023-05-19T22:01:09.345Z]       Result: FAILED
[taskcluster 2023-05-19T22:01:09.345Z] === Task Finished ===
[taskcluster 2023-05-19T22:01:09.345Z] Task Duration: 16m11.9427116s
[taskcluster 2023-05-19T22:01:09.532Z] Uploading artifact public/logs/localconfig.json from file logs\localconfig.json with content encoding "gzip", mime type "application/json" and expiry 2024-05-18T21:10:14.147Z
[taskcluster 2023-05-19T22:01:10.022Z] Uploading artifact public/test_info/crashtest_errorsummary.log from file build\blobber_upload_dir\crashtest_errorsummary.log with content encoding "gzip", mime type "text/plain" and expiry 2024-05-18T21:10:14.147Z
[taskcluster 2023-05-19T22:01:10.221Z] Uploading artifact public/test_info/resource-usage.json from file build\blobber_upload_dir\resource-usage.json with content encoding "gzip", mime type "application/json" and expiry 2024-05-18T21:10:14.147Z
[taskcluster 2023-05-19T22:01:10.917Z] Uploading artifact public/test_info/system-info.log from file build\blobber_upload_dir\system-info.log with content encoding "gzip", mime type "text/plain" and expiry 2024-05-18T21:10:14.147Z
[taskcluster 2023-05-19T22:01:11.186Z] Uploading link artifact public/logs/live.log to artifact public/logs/live_backing.log with expiry 2024-05-18T21:10:14.147Z
[taskcluster:error] exit status 2
Status: NEW → RESOLVED
Closed: 2 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.