Closed
Bug 1778230
Opened 3 years ago
Closed 3 years ago
Intermittent Automation Error: mozprocess timed out after 1000 seconds running ['/opt/worker/tasks/task_165705754928623/build/venv/bin/python', '-u', '/opt/worker/tasks/task_165705754928623/build/tests/mochitest/runtests.py', 'devtools/client/application/
Categories
(DevTools :: Netmonitor, defect, P5)
DevTools
Netmonitor
Tracking
(Not tracked)
RESOLVED
INCOMPLETE
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: intermittent-failure)
Filed by: nfay [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=383439147&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/FPBfG-IYQzuSI7Ob6vZjpw/runs/0/artifacts/public/logs/live_backing.log
[task 2022-07-05T22:00:47.214Z] 22:00:47 INFO - TEST-START | devtools/client/netmonitor/test/browser_net_headers-alignment.js
[task 2022-07-05T22:00:47.250Z] 22:00:47 INFO - GECKO(1626) | [Child 1938: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 10fa55400 == 0 [pid = 1938] [id = 0] [url = http://example.com/browser/devtools/client/netmonitor/test/html_post-raw-test-page.html]
[task 2022-07-05T22:00:47.277Z] 22:00:47 INFO - GECKO(1626) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /var/folders/tm/j3z1zpkj0nd_k8_zhs770g1h000014/T/tmp1n_l1wy5.mozrunner/runtests_leaks_tab_pid1939.log
[task 2022-07-05T22:00:47.278Z] 22:00:47 INFO - GECKO(1626) | [1939, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:340
[task 2022-07-05T22:00:47.290Z] 22:00:47 INFO - GECKO(1626) | [Child 1938: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 4 (107192f10) [pid = 1938] [serial = 1] [outer = 0] [url = http://example.com/browser/devtools/client/netmonitor/test/html_post-raw-test-page.html]
[task 2022-07-05T22:00:47.291Z] 22:00:47 INFO - GECKO(1626) | [Child 1938: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 3 (10fa5c800) [pid = 1938] [serial = 2] [outer = 0] [url = about:blank]
[task 2022-07-05T22:00:47.291Z] 22:00:47 INFO - GECKO(1626) | [Child 1938: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (110560000) [pid = 1938] [serial = 4] [outer = 0] [url = http://example.com/browser/devtools/client/netmonitor/test/html_post-raw-test-page.html]
[task 2022-07-05T22:00:47.292Z] 22:00:47 INFO - GECKO(1626) | [Child 1938: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (110562800) [pid = 1938] [serial = 5] [outer = 0] [url = http://example.com/browser/devtools/client/netmonitor/test/html_post-raw-test-page.html]
[task 2022-07-05T22:00:47.292Z] 22:00:47 INFO - GECKO(1626) | [Child 1938: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (10fa63800) [pid = 1938] [serial = 3] [outer = 0] [url = http://example.com/browser/devtools/client/netmonitor/test/html_post-raw-test-page.html]
[task 2022-07-05T22:00:47.293Z] 22:00:47 INFO - GECKO(1626) | [Child 1938, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3359
[task 2022-07-05T22:00:47.293Z] 22:00:47 INFO - GECKO(1626) | [Child 1632, Main Thread] WARNING: '!CanHandleWith(aPresContext)', file /builds/worker/checkouts/gecko/dom/events/IMEStateManager.cpp:498
[task 2022-07-05T22:00:47.294Z] 22:00:47 INFO - GECKO(1626) | [Child 1938, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file /builds/worker/workspace/obj-build/dist/include/mozilla/Preferences.h:129
[task 2022-07-05T22:00:47.298Z] 22:00:47 INFO - GECKO(1626) | [Child 1938, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4595
[task 2022-07-05T22:00:47.460Z] 22:00:47 INFO - GECKO(1626) | [Child 1939: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 11c088c00 == 1 [pid = 1939] [id = 0]
[task 2022-07-05T22:00:47.460Z] 22:00:47 INFO - GECKO(1626) | [Child 1939: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 1 (11b692d40) [pid = 1939] [serial = 1] [outer = 0]
[task 2022-07-05T22:00:47.461Z] 22:00:47 INFO - GECKO(1626) | [Child 1939: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 2 (11c65c800) [pid = 1939] [serial = 2] [outer = 11b692d40]
[task 2022-07-05T22:00:47.511Z] 22:00:47 INFO - GECKO(1626) | [Child 1939: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 3 (11c663800) [pid = 1939] [serial = 3] [outer = 11b692d40]
[task 2022-07-05T22:00:47.734Z] 22:00:47 INFO - GECKO(1626) | [Parent 1626: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 1279e9c00 == 10 [pid = 1626] [id = 156]
[task 2022-07-05T22:00:47.735Z] 22:00:47 INFO - GECKO(1626) | [Parent 1626: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 28 (141852180) [pid = 1626] [serial = 388] [outer = 0]
[task 2022-07-05T22:00:47.735Z] 22:00:47 INFO - GECKO(1626) | [Parent 1626: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 29 (134278c00) [pid = 1626] [serial = 389] [outer = 141852180]
[task 2022-07-05T22:00:47.766Z] 22:00:47 INFO - GECKO(1626) | [Parent 1626: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 30 (1350d2c00) [pid = 1626] [serial = 390] [outer = 141852180]
[task 2022-07-05T22:00:47.811Z] 22:00:47 INFO - GECKO(1626) | [Parent 1626, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/dom/base/nsContentUtils.cpp:4052
[task 2022-07-05T22:00:47.933Z] 22:00:47 INFO - GECKO(1626) | [Parent 1626: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 136175c00 == 11 [pid = 1626] [id = 157]
[task 2022-07-05T22:00:47.934Z] 22:00:47 INFO - GECKO(1626) | [Parent 1626: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 31 (141850f60) [pid = 1626] [serial = 391] [outer = 0]
[task 2022-07-05T22:00:47.934Z] 22:00:47 INFO - GECKO(1626) | [Parent 1626: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 32 (136675800) [pid = 1626] [serial = 392] [outer = 141850f60]
[task 2022-07-05T22:00:47.942Z] 22:00:47 INFO - GECKO(1626) | [Parent 1626, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/chrome/nsChromeRegistry.cpp:180
[task 2022-07-05T22:00:47.943Z] 22:00:47 INFO - GECKO(1626) | [Parent 1626, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/dom/security/nsCSPService.cpp:190
[task 2022-07-05T22:00:48.057Z] 22:00:48 INFO - GECKO(1626) | [Parent 1626, Main Thread] WARNING: Failed to retarget HTML data delivery to the parser thread.: file /builds/worker/checkouts/gecko/parser/html/nsHtml5StreamParser.cpp:1234
[task 2022-07-05T22:00:48.273Z] 22:00:48 INFO - GECKO(1626) | [Child 1939, Main Thread] WARNING: '!CanHandleWith(aPresContext)', file /builds/worker/checkouts/gecko/dom/events/IMEStateManager.cpp:498
[task 2022-07-05T22:00:50.577Z] 22:00:50 INFO - GECKO(1626) | [2022-07-05T22:00:50Z WARN rkv::backend::impl_safe::environment] `load_ratio()` is irrelevant for this storage backend.
[task 2022-07-05T22:00:50.617Z] 22:00:50 INFO - GECKO(1626) | [Child 1632: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 3 (107a92f10) [pid = 1632] [serial = 71] [outer = 0] [url = about:blank]
[task 2022-07-05T22:00:55.321Z] 22:00:55 INFO - GECKO(1626) | [Child 1632: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (107d1d400) [pid = 1632] [serial = 72] [outer = 0] [url = about:blank]
[task 2022-07-05T22:00:55.895Z] 22:00:55 INFO - GECKO(1626) | [Child 1634: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 114b1cc00 == 0 [pid = 1634] [id = 35] [url = about:blank]
[task 2022-07-05T22:00:57.137Z] 22:00:57 INFO - GECKO(1626) | [Parent 1626: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 31 (1279e4c00) [pid = 1626] [serial = 384] [outer = 0] [url = about:blank]
[task 2022-07-05T22:00:57.138Z] 22:00:57 INFO - GECKO(1626) | [Parent 1626: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 12dfe5800 == 10 [pid = 1626] [id = 155] [url = chrome://devtools/content/netmonitor/index.html]
[task 2022-07-05T22:00:57.138Z] 22:00:57 INFO - GECKO(1626) | [Parent 1626: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 127f8dc00 == 9 [pid = 1626] [id = 154] [url = about:devtools-toolbox]
[task 2022-07-05T22:00:57.923Z] 22:00:57 INFO - GECKO(1626) | [Parent 1626: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 127f90400 == 8 [pid = 1626] [id = 150] [url = about:devtools-toolbox]
[task 2022-07-05T22:00:57.924Z] 22:00:57 INFO - GECKO(1626) | [Parent 1626: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 1279e4400 == 7 [pid = 1626] [id = 152] [url = about:devtools-toolbox]
[task 2022-07-05T22:00:59.993Z] 22:00:59 INFO - GECKO(1626) | [Parent 1626, Main Thread] WARNING: NS_ENSURE_TRUE(!mHasOrHasHadOwnerWindow || mOwnerWindow) failed: file /builds/worker/checkouts/gecko/dom/events/DOMEventTargetHelper.cpp:306
[task 2022-07-05T22:00:59.994Z] 22:00:59 INFO - GECKO(1626) | [Parent 1626, Main Thread] WARNING: NS_ENSURE_TRUE(!mHasOrHasHadOwnerWindow || mOwnerWindow) failed: file /builds/worker/checkouts/gecko/dom/events/DOMEventTargetHelper.cpp:306
[task 2022-07-05T22:00:59.994Z] 22:00:59 INFO - GECKO(1626) | [Parent 1626, Main Thread] WARNING: NS_ENSURE_TRUE(!mHasOrHasHadOwnerWindow || mOwnerWindow) failed: file /builds/worker/checkouts/gecko/dom/events/DOMEventTargetHelper.cpp:306
[task 2022-07-05T22:00:59.995Z] 22:00:59 INFO - GECKO(1626) | [Parent 1626, Main Thread] WARNING: NS_ENSURE_TRUE(!mHasOrHasHadOwnerWindow || mOwnerWindow) failed: file /builds/worker/checkouts/gecko/dom/events/DOMEventTargetHelper.cpp:306
[task 2022-07-05T22:00:59.995Z] 22:00:59 INFO - GECKO(1626) | [Parent 1626, Main Thread] WARNING: NS_ENSURE_TRUE(!mHasOrHasHadOwnerWindow || mOwnerWindow) failed: file /builds/worker/checkouts/gecko/dom/events/DOMEventTargetHelper.cpp:306
[task 2022-07-05T22:00:59.996Z] 22:00:59 INFO - GECKO(1626) | [Parent 1626, Main Thread] WARNING: NS_ENSURE_TRUE(!mHasOrHasHadOwnerWindow || mOwnerWindow) failed: file /builds/worker/checkouts/gecko/dom/events/DOMEventTargetHelper.cpp:306
[task 2022-07-05T22:00:59.996Z] 22:00:59 INFO - GECKO(1626) | [Parent 1626, Main Thread] WARNING: NS_ENSURE_TRUE(!mHasOrHasHadOwnerWindow || mOwnerWindow) failed: file /builds/worker/checkouts/gecko/dom/events/DOMEventTargetHelper.cpp:306
[task 2022-07-05T22:00:59.997Z] 22:00:59 INFO - GECKO(1626) | [Parent 1626, Main Thread] WARNING: NS_ENSURE_TRUE(!mHasOrHasHadOwnerWindow || mOwnerWindow) failed: file /builds/worker/checkouts/gecko/dom/events/DOMEventTargetHelper.cpp:306
[task 2022-07-05T22:00:59.997Z] 22:00:59 INFO - GECKO(1626) | [Parent 1626, Main Thread] WARNING: NS_ENSURE_TRUE(!mHasOrHasHadOwnerWindow || mOwnerWindow) failed: file /builds/worker/checkouts/gecko/dom/events/DOMEventTargetHelper.cpp:306
[task 2022-07-05T22:00:59.998Z] 22:00:59 INFO - GECKO(1626) | [Parent 1626, Main Thread] WARNING: NS_ENSURE_TRUE(!mHasOrHasHadOwnerWindow || mOwnerWindow) failed: file /builds/worker/checkouts/gecko/dom/events/DOMEventTargetHelper.cpp:306
[task 2022-07-05T22:00:59.999Z] 22:00:59 INFO - GECKO(1626) | [Parent 1626, Main Thread] WARNING: NS_ENSURE_TRUE(!mHasOrHasHadOwnerWindow || mOwnerWindow) failed: file /builds/worker/checkouts/gecko/dom/events/DOMEventTargetHelper.cpp:306
[task 2022-07-05T22:00:59.999Z] 22:00:59 INFO - GECKO(1626) | [Parent 1626, Main Thread] WARNING: NS_ENSURE_TRUE(!mHasOrHasHadOwnerWindow || mOwnerWindow) failed: file /builds/worker/checkouts/gecko/dom/events/DOMEventTargetHelper.cpp:306
[task 2022-07-05T22:00:59.999Z] 22:00:59 INFO - GECKO(1626) | [Parent 1626, Main Thread] WARNING: NS_ENSURE_TRUE(!mHasOrHasHadOwnerWindow || mOwnerWindow) failed: file /builds/worker/checkouts/gecko/dom/events/DOMEventTargetHelper.cpp:306
[task 2022-07-05T22:01:00.000Z] 22:01:00 INFO - GECKO(1626) | [Parent 1626, Main Thread] WARNING: NS_ENSURE_TRUE(!mHasOrHasHadOwnerWindow || mOwnerWindow) failed: file /builds/worker/checkouts/gecko/dom/events/DOMEventTargetHelper.cpp:306
[task 2022-07-05T22:01:00.000Z] 22:01:00 INFO - GECKO(1626) | [Parent 1626, Main Thread] WARNING: NS_ENSURE_TRUE(!mHasOrHasHadOwnerWindow || mOwnerWindow) failed: file /builds/worker/checkouts/gecko/dom/events/DOMEventTargetHelper.cpp:306
[task 2022-07-05T22:01:00.001Z] 22:01:00 INFO - GECKO(1626) | [Parent 1626, Main Thread] WARNING: NS_ENSURE_TRUE(!mHasOrHasHadOwnerWindow || mOwnerWindow) failed: file /builds/worker/checkouts/gecko/dom/events/DOMEventTargetHelper.cpp:306
[task 2022-07-05T22:01:00.452Z] 22:01:00 INFO - GECKO(1626) | [Child 1939: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (11c65c800) [pid = 1939] [serial = 2] [outer = 0] [url = about:blank]
[task 2022-07-05T22:01:00.471Z] 22:01:00 INFO - GECKO(1626) | [Child 1634: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (114992f10) [pid = 1634] [serial = 72] [outer = 0] [url = about:blank]
[task 2022-07-05T22:01:01.273Z] 22:01:01 INFO - GECKO(1626) | [Parent 1626: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 30 (1361989a0) [pid = 1626] [serial = 373] [outer = 0] [url = about:devtools-toolbox]
[task 2022-07-05T22:01:01.274Z] 22:01:01 INFO - GECKO(1626) | [Parent 1626: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 29 (136199480) [pid = 1626] [serial = 371] [outer = 0] [url = chrome://devtools/content/netmonitor/index.html]
[task 2022-07-05T22:01:01.274Z] 22:01:01 INFO - GECKO(1626) | [Parent 1626: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 28 (136198f10) [pid = 1626] [serial = 368] [outer = 0] [url = about:devtools-toolbox]
[task 2022-07-05T22:01:01.275Z] 22:01:01 INFO - GECKO(1626) | [Parent 1626: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 27 (1418526f0) [pid = 1626] [serial = 376] [outer = 0] [url = chrome://devtools/content/netmonitor/index.html]
[task 2022-07-05T22:01:01.275Z] 22:01:01 INFO - GECKO(1626) | [Parent 1626: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 26 (141852520) [pid = 1626] [serial = 378] [outer = 0] [url = about:devtools-toolbox]
[task 2022-07-05T22:01:01.276Z] 22:01:01 INFO - GECKO(1626) | [Parent 1626: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 25 (14184f600) [pid = 1626] [serial = 381] [outer = 0] [url = chrome://devtools/content/netmonitor/index.html]
[task 2022-07-05T22:01:01.276Z] 22:01:01 INFO - GECKO(1626) | [Parent 1626: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 24 (141850d90) [pid = 1626] [serial = 386] [outer = 0] [url = chrome://devtools/content/netmonitor/index.html]
[task 2022-07-05T22:01:01.276Z] 22:01:01 INFO - GECKO(1626) | [Parent 1626: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 23 (141851130) [pid = 1626] [serial = 383] [outer = 0] [url = about:devtools-toolbox]
[task 2022-07-05T22:01:05.028Z] 22:01:05 INFO - GECKO(1626) | [Child 1634: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (114b28800) [pid = 1634] [serial = 73] [outer = 0] [url = about:blank]
[task 2022-07-05T22:01:06.729Z] 22:01:06 INFO - GECKO(1626) | [Parent 1626: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 22 (135ecb000) [pid = 1626] [serial = 375] [outer = 0] [url = about:devtools-toolbox]
[task 2022-07-05T22:01:06.730Z] 22:01:06 INFO - GECKO(1626) | [Parent 1626: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 21 (132756400) [pid = 1626] [serial = 372] [outer = 0] [url = about:blank]
[task 2022-07-05T22:01:06.730Z] 22:01:06 INFO - GECKO(1626) | [Parent 1626: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 20 (1279e8000) [pid = 1626] [serial = 370] [outer = 0] [url = about:devtools-toolbox]
[task 2022-07-05T22:01:06.730Z] 22:01:06 INFO - GECKO(1626) | [Parent 1626: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 19 (13617a400) [pid = 1626] [serial = 377] [outer = 0] [url = about:blank]
[task 2022-07-05T22:01:06.731Z] 22:01:06 INFO - GECKO(1626) | [Parent 1626: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 18 (1334e1000) [pid = 1626] [serial = 385] [outer = 0] [url = about:devtools-toolbox]
[task 2022-07-05T22:01:06.731Z] 22:01:06 INFO - GECKO(1626) | [Parent 1626: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 17 (127f90c00) [pid = 1626] [serial = 380] [outer = 0] [url = about:devtools-toolbox]
[task 2022-07-05T22:01:06.732Z] 22:01:06 INFO - GECKO(1626) | [Parent 1626: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 16 (12dfe1c00) [pid = 1626] [serial = 382] [outer = 0] [url = about:blank]
[task 2022-07-05T22:01:06.732Z] 22:01:06 INFO - GECKO(1626) | [Parent 1626: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 15 (13427ac00) [pid = 1626] [serial = 387] [outer = 0] [url = about:blank]
[task 2022-07-05T22:01:06.733Z] 22:01:06 INFO - GECKO(1626) | [Parent 1626: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 14 (134278c00) [pid = 1626] [serial = 389] [outer = 0] [url = about:blank]
[task 2022-07-05T22:02:51.969Z] 22:02:51 INFO - GECKO(1626) | 1657058571968 addons.xpi ERROR System addon update list error Error: got node name: html, expected: updates
[task 2022-07-05T22:19:32.123Z] 22:19:32 INFO - Automation Error: mozprocess timed out after 1000 seconds running ['/opt/worker/tasks/task_165705754928623/build/venv/bin/python', '-u', '/opt/worker/tasks/task_165705754928623/build/tests/mochitest/runtests.py', 'devtools/client/application/test/browser/browser.ini', 'devtools/client/memory/test/browser/browser.ini', 'devtools/client/netmonitor/src/har/test/browser.ini', 'devtools/client/netmonitor/test/browser.ini', 'devtools/client/styleeditor/test/browser.ini', 'devtools/shared/commands/target/tests/browser.ini', '--setpref=media.peerconnection.mtransport_process=false', '--setpref=network.process.enabled=false', '--setpref=layers.d3d11.enable-blacklist=false', '--appname=/opt/worker/tasks/task_165705754928623/build/application/Firefox NightlyDebug.app/Contents/MacOS/firefox', '--utility-path=tests/bin', '--extra-profile-file=tests/bin/plugins', '--symbols-path=/opt/worker/tasks/task_165705754928623/build/symbols', '--certificate-path=tests/certs', '--quiet', '--log-raw=/opt/worker/tasks/task_165705754928623/build/blobber_upload_dir/mochitest-devtools-chrome_raw.log', '--log-errorsummary=/opt/worker/tasks/task_165705754928623/build/blobber_upload_dir/mochitest-devtools-chrome_errorsummary.log', '--screenshot-on-fail', '--cleanup-crashes', '--marionette-startup-timeout=180', '--sandbox-read-whitelist=/opt/worker/tasks/task_165705754928623/build', '--log-raw=-', '--flavor=browser', '--subsuite=devtools', '--chunk-by-runtime']
[task 2022-07-05T22:19:32.123Z] 22:19:32 ERROR - timed out after 1000 seconds of no output
[task 2022-07-05T22:19:32.124Z] 22:19:32 ERROR - Return code: -15
[task 2022-07-05T22:19:32.124Z] 22:19:32 ERROR - No suite end message was emitted by this harness.
[task 2022-07-05T22:19:32.124Z] 22:19:32 INFO - TinderboxPrint: mochitest-mochitest-devtools-chrome<br/>125/0/0
[task 2022-07-05T22:19:32.124Z] 22:19:32 ERROR - # TBPL FAILURE #
[task 2022-07-05T22:19:32.124Z] 22:19:32 WARNING - setting return code to 2
[task 2022-07-05T22:19:32.124Z] 22:19:32 ERROR - The mochitest suite: mochitest-devtools-chrome ran with return status: FAILURE
[task 2022-07-05T22:19:32.124Z] 22:19:32 INFO - Running post-action listener: _package_coverage_data
[task 2022-07-05T22:19:32.124Z] 22:19:32 INFO - Running post-action listener: _resource_record_post_action
[task 2022-07-05T22:19:32.125Z] 22:19:32 INFO - Running post-action listener: process_java_coverage_data
[task 2022-07-05T22:19:32.125Z] 22:19:32 INFO - [mozharness: 2022-07-05 22:19:32.125063Z] Finished run-tests step (success)
[task 2022-07-05T22:19:32.125Z] 22:19:32 INFO - Running post-run listener: _resource_record_post_run
[task 2022-07-05T22:19:32.294Z] 22:19:32 INFO - instance_metadata.json not found; unable to determine instance type
[task 2022-07-05T22:19:32.302Z] 22:19:32 INFO - Validating Perfherder data against /opt/worker/tasks/task_165705754928623/mozharness/external_tools/performance-artifact-schema.json
[task 2022-07-05T22:19:32.305Z] 22:19:32 INFO - PERFHERDER_DATA: {"framework": {"name": "job_resource_usage"}, "suites": [{"name": "mochitest.mochitest-devtools-chrome.overall", "extraOptions": ["e10s", "buildbot-unknown"], "subtests": [{"name": "cpu_percent", "value": 6.169514058679706}, {"name": "io_write_bytes", "value": 720486400}, {"name": "io.read_bytes", "value": 4460498944}, {"name": "io_write_time", "value": 136486}, {"name": "io_read_time", "value": 226864}]}, {"name": "mochitest.mochitest-devtools-chrome.start-pulseaudio", "subtests": [{"name": "time", "value": 0.0006270408630371094}]}, {"name": "mochitest.mochitest-devtools-chrome.install", "subtests": [{"name": "time", "value": 24.303900003433228}, {"name": "cpu_percent", "value": 19.040909090909093}]}, {"name": "mochitest.mochitest-devtools-chrome.stage-files", "subtests": [{"name": "time", "value": 0.0003712177276611328}]}, {"name": "mochitest.mochitest-devtools-chrome.run-tests", "subtests": [{"name": "time", "value": 1703.4552257061005}, {"name": "cpu_percent", "value": 5.98902149204381}]}]}
[task 2022-07-05T22:19:32.305Z] 22:19:32 INFO - Total resource usage - Wall time: 1728s; CPU: 6%; Read bytes: 4460498944; Write bytes: 720486400; Read time: 226864; Write time: 136486
[task 2022-07-05T22:19:32.305Z] 22:19:32 INFO - TinderboxPrint: CPU usage<br/>6.0%
[task 2022-07-05T22:19:32.305Z] 22:19:32 INFO - TinderboxPrint: I/O read bytes / time<br/>4,460,498,944 / 226,864
[task 2022-07-05T22:19:32.305Z] 22:19:32 INFO - TinderboxPrint: I/O write bytes / time<br/>720,486,400 / 136,486
[task 2022-07-05T22:19:32.305Z] 22:19:32 INFO - TinderboxPrint: CPU idle<br/>18,448.4 (89.0%)
[task 2022-07-05T22:19:32.305Z] 22:19:32 INFO - TinderboxPrint: CPU system<br/>293.0 (1.4%)
[task 2022-07-05T22:19:32.305Z] 22:19:32 INFO - TinderboxPrint: CPU user<br/>1,989.8 (9.6%)
[task 2022-07-05T22:19:32.306Z] 22:19:32 INFO - TinderboxPrint: Swap in / out<br/>2,738,536,448 / 0
[task 2022-07-05T22:19:32.306Z] 22:19:32 INFO - start-pulseaudio - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2022-07-05T22:19:32.307Z] 22:19:32 INFO - install - Wall time: 24s; CPU: 19%; Read bytes: 718820864; Write bytes: 268214272; Read time: 35564; Write time: 17295
[task 2022-07-05T22:19:32.308Z] 22:19:32 INFO - stage-files - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2022-07-05T22:19:32.328Z] 22:19:32 INFO - run-tests - Wall time: 1703s; CPU: 6%; Read bytes: 3983667200; Write bytes: 402980864; Read time: 205368; Write time: 114649
[task 2022-07-05T22:19:32.717Z] 22:19:32 WARNING - returning nonzero exit status 2
[taskcluster 2022-07-05T22:19:32.756Z] Exit Code: 2
[taskcluster 2022-07-05T22:19:32.756Z] User Time: 4m22.923838s
[taskcluster 2022-07-05T22:19:32.756Z] Kernel Time: 36.569498s
[taskcluster 2022-07-05T22:19:32.756Z] Wall Time: 31m23.828207s
[taskcluster 2022-07-05T22:19:32.756Z] Result: FAILED
[taskcluster 2022-07-05T22:19:32.756Z] === Task Finished ===
[taskcluster 2022-07-05T22:19:32.756Z] Task Duration: 31m23.859274s
| Comment hidden (Intermittent Failures Robot) |
|
||
Comment 2•3 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.
Status: NEW → RESOLVED
Closed: 3 years ago
Resolution: --- → INCOMPLETE
You need to log in
before you can comment on or make changes to this bug.
Description
•