1752711 - Intermittent Automation Error: mozprocess timed out after 1000 seconds running ['Z:\\task_1643490084\\build\\venv\\Scripts\\python', '-u', 'Z:\\task_1643490084\\build\\tests\\xpcshell\\runxpcshelltests.py', 'browser/components/newtab/test/xpcshell/xpcshel

Status: RESOLVED INCOMPLETE

(Testing :: web-platform-tests, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: mlaza [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=366065492&repo=mozilla-beta
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/TLLRaDSWRpakcoSXkRRuDw/runs/0/artifacts/public/logs/live_backing.log

---

[task 2022-01-29T21:19:51.158Z] 21:19:51     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-artweojo',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:51.281Z] 21:19:51     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-oviskf44',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:51.612Z] 21:19:51     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-kbh7icqw',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:51.613Z] 21:19:51     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-_k9ts9yb',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:52.103Z] 21:19:52     INFO -  Failed to remove directory: C:\Users\task_1643490084\AppData\Local\Temp\xpc-other-e1_kbk4h. Waiting.
[task 2022-01-29T21:19:52.109Z] 21:19:52     INFO -  Failed to remove directory: C:\Users\task_1643490084\AppData\Local\Temp\xpc-other-nubovh4l. Waiting.
[task 2022-01-29T21:19:52.110Z] 21:19:52     INFO -  Failed to remove directory: C:\Users\task_1643490084\AppData\Local\Temp\xpc-other-gmuxfv1_. Waiting.
[task 2022-01-29T21:19:52.111Z] 21:19:52     INFO -  Failed to remove directory: C:\Users\task_1643490084\AppData\Local\Temp\xpc-other-trka26ba. Waiting.
[task 2022-01-29T21:19:52.112Z] 21:19:52     INFO -  Failed to remove directory: C:\Users\task_1643490084\AppData\Local\Temp\xpc-other-0fwo_sfw. Waiting.
[task 2022-01-29T21:19:52.112Z] 21:19:52     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-kbh7icqw',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:52.113Z] 21:19:52     INFO -  Failed to remove directory: C:\Users\task_1643490084\AppData\Local\Temp\xpc-other-bp2w8x59. Waiting.
[task 2022-01-29T21:19:52.113Z] 21:19:52     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-_k9ts9yb',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:52.659Z] 21:19:52     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-artweojo',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:52.782Z] 21:19:52     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-oviskf44',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:53.106Z] 21:19:53     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-e1_kbk4h',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:53.111Z] 21:19:53     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-nubovh4l',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:53.114Z] 21:19:53     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-kbh7icqw',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:53.115Z] 21:19:53     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-gmuxfv1_',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:53.115Z] 21:19:53     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-0fwo_sfw',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:53.116Z] 21:19:53     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-trka26ba',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:53.116Z] 21:19:53     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-_k9ts9yb',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:53.116Z] 21:19:53     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-bp2w8x59',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:53.485Z] 21:19:53     INFO -  Failed to remove directory: C:\Users\task_1643490084\AppData\Local\Temp\xpc-other-4yf5yvzy. Waiting.
[task 2022-01-29T21:19:53.606Z] 21:19:53     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-e1_kbk4h',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:53.611Z] 21:19:53     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-nubovh4l',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:53.615Z] 21:19:53     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-trka26ba',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:53.615Z] 21:19:53     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-gmuxfv1_',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-0fwo_sfw',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:53.616Z] 21:19:53     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-bp2w8x59',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:54.486Z] 21:19:54     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-4yf5yvzy',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:54.605Z] 21:19:54     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-e1_kbk4h',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:54.611Z] 21:19:54     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-nubovh4l',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:54.614Z] 21:19:54     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-gmuxfv1_',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:54.615Z] 21:19:54     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-0fwo_sfw',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:54.616Z] 21:19:54     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-trka26ba',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:54.616Z] 21:19:54     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-kbh7icqw',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:54.617Z] 21:19:54     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-_k9ts9yb',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:54.617Z] 21:19:54     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-bp2w8x59',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:54.659Z] 21:19:54     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-artweojo',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:54.782Z] 21:19:54     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-oviskf44',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:54.986Z] 21:19:54     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-4yf5yvzy',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:55.262Z] 21:19:55     INFO -  TEST-PASS | toolkit/components/antitracking/test/xpcshell/test_purge_trackers.js | took 15820ms
[task 2022-01-29T21:19:55.313Z] 21:19:55     INFO -  TEST-START | xpcshell.ini:toolkit/mozapps/extensions/test/xpcshell/test_signed_verify.js
[task 2022-01-29T21:19:55.922Z] 21:19:55     INFO -  TEST-PASS | xpcshell.ini:toolkit/mozapps/extensions/test/xpcshell/test_signed_verify.js | took 609ms
[task 2022-01-29T21:19:55.957Z] 21:19:55     INFO -  TEST-START | netwerk/test/unit_ipc/test_trr_httpssvc_wrap.js
[task 2022-01-29T21:19:55.987Z] 21:19:55     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-4yf5yvzy',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:56.107Z] 21:19:56     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-e1_kbk4h',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:56.114Z] 21:19:56     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-nubovh4l',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:56.120Z] 21:19:56     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-gmuxfv1_',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:56.120Z] 21:19:56     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-trka26ba',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:56.121Z] 21:19:56     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-0fwo_sfw',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:56.122Z] 21:19:56     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-bp2w8x59',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:56.615Z] 21:19:56     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-kbh7icqw',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:56.616Z] 21:19:56     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-_k9ts9yb',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:57.160Z] 21:19:57     INFO -  Failed to remove directory: C:\Users\task_1643490084\AppData\Local\Temp\xpc-other-artweojo. Waiting.
[task 2022-01-29T21:19:57.284Z] 21:19:57     INFO -  Failed to remove directory: C:\Users\task_1643490084\AppData\Local\Temp\xpc-other-oviskf44. Waiting.
[task 2022-01-29T21:19:57.488Z] 21:19:57     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-4yf5yvzy',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:58.107Z] 21:19:58     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-e1_kbk4h',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:58.112Z] 21:19:58     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-nubovh4l',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:58.115Z] 21:19:58     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-gmuxfv1_',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:58.116Z] 21:19:58     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-trka26ba',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:58.119Z] 21:19:58     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-0fwo_sfw',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:58.122Z] 21:19:58     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-bp2w8x59',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:58.163Z] 21:19:58     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-artweojo',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:58.285Z] 21:19:58     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-oviskf44',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:58.353Z] 21:19:58     INFO -  TEST-PASS | netwerk/test/unit_ipc/test_trr_httpssvc_wrap.js | took 2395ms
[task 2022-01-29T21:19:58.376Z] 21:19:58     INFO -  TEST-START | toolkit/crashreporter/test/unit/test_oom_annotation.js
[task 2022-01-29T21:19:58.662Z] 21:19:58     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-artweojo',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:58.785Z] 21:19:58     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-oviskf44',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:59.116Z] 21:19:59     INFO -  Failed to remove directory: C:\Users\task_1643490084\AppData\Local\Temp\xpc-other-kbh7icqw. Waiting.
[task 2022-01-29T21:19:59.117Z] 21:19:59     INFO -  Failed to remove directory: C:\Users\task_1643490084\AppData\Local\Temp\xpc-other-_k9ts9yb. Waiting.
[task 2022-01-29T21:19:59.489Z] 21:19:59     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-4yf5yvzy',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:59.664Z] 21:19:59     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-artweojo',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:19:59.786Z] 21:19:59     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-oviskf44',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:20:00.119Z] 21:20:00     INFO -  rmtree() failed for "('\\\\?\\C:\\Users\\task_1643490084\\AppData\\Local\\Temp\\xpc-other-kbh7icqw',)". Reason: The process cannot access the file because it is being used by another process (13). Retrying...
[task 2022-01-29T21:20:00.142Z] 21:20:00     INFO -  toolkit/crashreporter/test/unit_ipc/test_content_exception_time_annotation.js failed or timed out, will retry.
[task 2022-01-29T21:20:00.225Z] 21:20:00     INFO -  toolkit/crashreporter/test/unit_ipc/test_content_rust_panic_multiline.js failed or timed out, will retry.
[task 2022-01-29T21:20:00.342Z] 21:20:00     INFO -  toolkit/crashreporter/test/unit/test_crash_heap_corruption.js failed or timed out, will retry.
[task 2022-01-29T21:20:00.535Z] 21:20:00     INFO -  toolkit/crashreporter/test/unit/test_crash_modules.js failed or timed out, will retry.
[task 2022-01-29T21:20:00.607Z] 21:20:00     INFO -  toolkit/crashreporter/test/unit_ipc/test_content_rust_panic.js failed or timed out, will retry.
[task 2022-01-29T21:20:00.619Z] 21:20:00     INFO -  Failed to remove directory: C:\Users\task_1643490084\AppData\Local\Temp\xpc-other-gmuxfv1_. Waiting.
[task 2022-01-29T21:20:00.677Z] 21:20:00     INFO -  TEST-PASS | toolkit/crashreporter/test/unit/test_oom_annotation.js | took 2302ms
[task 2022-01-29T21:20:00.703Z] 21:20:00     INFO -  TEST-START | toolkit/crashreporter/test/unit/test_crashreporter_crash.js
[task 2022-01-29T21:20:00.760Z] 21:20:00     INFO -  toolkit/crashreporter/test/unit_ipc/test_content_memory_list.js failed or timed out, will retry.
[task 2022-01-29T21:20:00.765Z] 21:20:00     INFO -  toolkit/crashreporter/test/unit_ipc/test_content_large_annotation.js failed or timed out, will retry.
[task 2022-01-29T21:20:00.803Z] 21:20:00     INFO -  toolkit/crashreporter/test/unit_ipc/test_content_oom_annotation.js failed or timed out, will retry.
[task 2022-01-29T21:20:00.877Z] 21:20:00     INFO -  toolkit/crashreporter/test/unit_ipc/test_content_annotation.js failed or timed out, will retry.
[task 2022-01-29T21:20:00.948Z] 21:20:00     INFO -  toolkit/crashreporter/test/unit/test_crashreporter_crash.js failed or timed out, will retry.
[task 2022-01-29T21:20:01.061Z] 21:20:01     INFO -  toolkit/crashreporter/test/unit/test_oom_annotation.js failed or timed out, will retry.
[task 2022-01-29T21:20:03.255Z] 21:20:03     INFO -  TEST-PASS | toolkit/crashreporter/test/unit/test_crashreporter_crash.js | took 2552ms
[task 2022-01-29T21:20:03.283Z] 21:20:03     INFO -  TEST-START | toolkit/crashreporter/test/unit/test_crash_heap_corruption.js
[task 2022-01-29T21:20:05.328Z] 21:20:05     INFO -  TEST-PASS | toolkit/crashreporter/test/unit/test_crash_heap_corruption.js | took 2045ms
[task 2022-01-29T21:20:05.344Z] 21:20:05     INFO -  TEST-START | toolkit/crashreporter/test/unit_ipc/test_content_annotation.js
[task 2022-01-29T21:20:07.163Z] 21:20:07     INFO -  TEST-PASS | toolkit/crashreporter/test/unit_ipc/test_content_annotation.js | took 1820ms
[task 2022-01-29T21:20:07.188Z] 21:20:07     INFO -  TEST-START | toolkit/crashreporter/test/unit_ipc/test_content_large_annotation.js
[task 2022-01-29T21:20:09.164Z] 21:20:09     INFO -  TEST-PASS | toolkit/crashreporter/test/unit_ipc/test_content_large_annotation.js | took 1976ms
[task 2022-01-29T21:20:09.186Z] 21:20:09     INFO -  TEST-START | toolkit/crashreporter/test/unit_ipc/test_content_exception_time_annotation.js
[task 2022-01-29T21:20:10.998Z] 21:20:10     INFO -  TEST-PASS | toolkit/crashreporter/test/unit_ipc/test_content_exception_time_annotation.js | took 1811ms
[task 2022-01-29T21:20:11.021Z] 21:20:11     INFO -  TEST-START | toolkit/crashreporter/test/unit_ipc/test_content_oom_annotation.js
[task 2022-01-29T21:20:12.878Z] 21:20:12     INFO -  TEST-PASS | toolkit/crashreporter/test/unit_ipc/test_content_oom_annotation.js | took 1857ms
[task 2022-01-29T21:20:12.902Z] 21:20:12     INFO -  TEST-START | toolkit/crashreporter/test/unit_ipc/test_content_memory_list.js
[task 2022-01-29T21:20:14.741Z] 21:20:14     INFO -  TEST-PASS | toolkit/crashreporter/test/unit_ipc/test_content_memory_list.js | took 1838ms
[task 2022-01-29T21:20:14.764Z] 21:20:14     INFO -  TEST-START | toolkit/crashreporter/test/unit_ipc/test_content_rust_panic.js
[task 2022-01-29T21:20:16.652Z] 21:20:16     INFO -  TEST-PASS | toolkit/crashreporter/test/unit_ipc/test_content_rust_panic.js | took 1888ms
[task 2022-01-29T21:20:16.675Z] 21:20:16     INFO -  TEST-START | toolkit/crashreporter/test/unit_ipc/test_content_rust_panic_multiline.js
[task 2022-01-29T21:20:18.492Z] 21:20:18     INFO -  TEST-PASS | toolkit/crashreporter/test/unit_ipc/test_content_rust_panic_multiline.js | took 1816ms
[task 2022-01-29T21:20:18.516Z] 21:20:18     INFO -  TEST-START | toolkit/crashreporter/test/unit/test_crash_modules.js
[task 2022-01-29T21:20:20.420Z] 21:20:20     INFO -  TEST-PASS | toolkit/crashreporter/test/unit/test_crash_modules.js | took 1904ms
[task 2022-01-29T21:20:20.427Z] 21:20:20     INFO -  INFO | Result summary:
[task 2022-01-29T21:20:20.428Z] 21:20:20     INFO -  INFO | Passed: 897
[task 2022-01-29T21:20:20.428Z] 21:20:20     INFO -  INFO | Failed: 0
[task 2022-01-29T21:20:20.428Z] 21:20:20     INFO -  INFO | Todo: 0
[task 2022-01-29T21:20:20.429Z] 21:20:20     INFO -  INFO | Retried: 14
[task 2022-01-29T21:20:20.430Z] 21:20:20     INFO -  SUITE-END | took 577s
[task 2022-01-29T21:20:20.435Z] 21:20:20     INFO -  Node moz-http2 server shutting down ...
[task 2022-01-29T21:37:00.444Z] 21:37:00     INFO - Automation Error: mozprocess timed out after 1000 seconds running ['Z:\\task_1643490084\\build\\venv\\Scripts\\python', '-u', 'Z:\\task_1643490084\\build\\tests\\xpcshell\\runxpcshelltests.py', 'browser/components/newtab/test/xpcshell/xpcshell.ini', 'browser/components/places/tests/unit/interactions/xpcshell.ini', 'browser/components/search/test/unit/xpcshell.ini', 'browser/components/urlbar/tests/unit/xpcshell.ini', 'browser/tools/mozscreenshots/tests/xpcshell/xpcshell.ini', 'devtools/client/application/test/xpcshell/xpcshell.ini', 'devtools/client/debugger/test/xpcshell/xpcshell.ini', 'devtools/client/framework/test/xpcshell/xpcshell.ini', 'devtools/client/inspector/compatibility/test/xpcshell/xpcshell.ini', 'devtools/client/performance-new/test/xpcshell/xpcshell.ini', 'devtools/client/shared/test/xpcshell/xpcshell.ini', 'devtools/client/webconsole/test/xpcshell/xpcshell.ini', 'devtools/shared/discovery/tests/xpcshell/xpcshell.ini', 'devtools/shared/storage/vendor/stringvalidator/tests/xpcshell/xpcshell.ini', 'devtools/shared/webconsole/test/xpcshell/xpcshell.ini', 'devtools/startup/tests/xpcshell/xpcshell.ini', 'dom/encoding/test/unit/xpcshell.ini', 'dom/indexedDB/test/unit/xpcshell-child-process.ini', 'dom/promise/tests/unit/xpcshell.ini', 'dom/quota/test/xpcshell/telemetry/xpcshell.ini', 'dom/quota/test/xpcshell/upgrades/xpcshell.ini', 'dom/streams/test/xpcshell/xpcshell.ini', 'js/xpconnect/tests/unit/xpcshell.ini', 'layout/tools/layout-debug/tests/unit/xpcshell.ini', 'modules/libjar/zipwriter/test/unit/xpcshell.ini', 'modules/libmar/tests/unit/xpcshell.ini', 'netwerk/cookie/test/unit/xpcshell.ini', 'netwerk/dns/tests/unit/xpcshell.ini', 'netwerk/test/httpserver/test/xpcshell.ini', 'netwerk/test/unit_ipc/xpcshell.ini', 'remote/shared/test/xpcshell/xpcshell.ini', 'security/manager/ssl/tests/unit/xpcshell-smartcards.ini', 'toolkit/components/aboutthirdparty/tests/xpcshell/xpcshell.ini', 'toolkit/components/antitracking/test/xpcshell/xpcshell.ini', 'toolkit/components/captivedetect/test/unit/xpcshell.ini', 'toolkit/components/crashmonitor/test/unit/xpcshell.ini', 'toolkit/components/ctypes/tests/unit/xpcshell.ini', 'toolkit/components/forgetaboutsite/test/unit/xpcshell.ini', 'toolkit/components/glean/tests/xpcshell/xpcshell.ini', 'toolkit/components/kvstore/test/xpcshell/xpcshell.ini', 'toolkit/components/osfile/tests/xpcshell/xpcshell.ini', 'toolkit/components/places/tests/bookmarks/xpcshell.ini', 'toolkit/components/places/tests/expiration/xpcshell.ini', 'toolkit/components/promiseworker/tests/xpcshell/xpcshell.ini', 'toolkit/components/search/tests/xpcshell/searchconfigs/xpcshell.ini', 'toolkit/components/timermanager/tests/unit/xpcshell.ini', 'toolkit/content/tests/unit/xpcshell.ini', 'toolkit/crashreporter/test/unit/xpcshell.ini', 'toolkit/crashreporter/test/unit_ipc/xpcshell.ini', 'toolkit/mozapps/downloads/tests/unit/xpcshell.ini', 'toolkit/mozapps/extensions/test/xpcshell/xpcshell.ini', 'toolkit/mozapps/update/tests/unit_base_updater/xpcshell.ini', 'tools/code-coverage/tests/xpcshell/xpcshell.ini', 'xpcom/tests/unit/xpcshell.ini', '--setpref=media.peerconnection.mtransport_process=false', '--setpref=network.process.enabled=false', '--setpref=layers.d3d11.enable-blacklist=false', '--setpref=fission.autostart=false', '--self-test', '--symbols-path=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/fDDmgo1jTvSImeafSXBrdw/artifacts/public/build/target.crashreporter-symbols.zip', '--test-plugin-path=Z:\\task_1643490084\\build\\application\\firefox\\plugins', '--log-raw=Z:\\task_1643490084\\build\\blobber_upload_dir\\xpcshell_raw.log', '--log-errorsummary=Z:\\task_1643490084\\build\\blobber_upload_dir\\xpcshell_errorsummary.log', '--utility-path=tests/bin', '--xpcshell=Z:\\task_1643490084\\build\\application\\firefox/xpcshell.exe', '--manifest=tests/xpcshell/tests/xpcshell.ini']
[task 2022-01-29T21:37:00.470Z] 21:37:00    ERROR - timed out after 1000 seconds of no output
[task 2022-01-29T21:37:00.471Z] 21:37:00    ERROR - Return code: 572
[task 2022-01-29T21:37:00.471Z] 21:37:00     INFO - TinderboxPrint: xpcshell-xpcshell<br/>897/0/0
[task 2022-01-29T21:37:00.471Z] 21:37:00     INFO - # TBPL FAILURE #
[task 2022-01-29T21:37:00.471Z] 21:37:00  WARNING - setting return code to 2
[task 2022-01-29T21:37:00.471Z] 21:37:00     INFO - The xpcshell suite: xpcshell ran with return status: FAILURE
[task 2022-01-29T21:37:00.471Z] 21:37:00     INFO - Running post-action listener: _package_coverage_data
[task 2022-01-29T21:37:00.471Z] 21:37:00     INFO - Running post-action listener: _resource_record_post_action
[task 2022-01-29T21:37:00.472Z] 21:37:00     INFO - Running post-action listener: process_java_coverage_data
[task 2022-01-29T21:37:00.472Z] 21:37:00     INFO - [mozharness: 2022-01-29 21:37:00.472006Z] Finished run-tests step (success)
[task 2022-01-29T21:37:00.472Z] 21:37:00     INFO - Running post-run listener: _resource_record_post_run
[task 2022-01-29T21:37:00.942Z] 21:37:00     INFO - Validating Perfherder data against Z:\task_1643490084\mozharness\external_tools\performance-artifact-schema.json
[task 2022-01-29T21:37:00.946Z] 21:37:00     INFO - PERFHERDER_DATA: {"framework": {"name": "job_resource_usage"}, "suites": [{"name": "xpcshell.xpcshell.overall", "extraOptions": ["e10s", "taskcluster-c4.2xlarge"], "subtests": [{"name": "cpu_percent", "value": 16.56753536285357}, {"name": "io_write_bytes", "value": 27165523968}, {"name": "io.read_bytes", "value": 47025022464}, {"name": "io_write_time", "value": 696}, {"name": "io_read_time", "value": 12244}]}, {"name": "xpcshell.xpcshell.start-pulseaudio", "subtests": [{"name": "time", "value": 0.0}]}, {"name": "xpcshell.xpcshell.install", "subtests": [{"name": "time", "value": 4.053215503692627}, {"name": "cpu_percent", "value": 11.454166666666666}]}, {"name": "xpcshell.xpcshell.stage-files", "subtests": [{"name": "time", "value": 0.07002115249633789}]}, {"name": "xpcshell.xpcshell.run-tests", "subtests": [{"name": "time", "value": 1627.530725479126}, {"name": "cpu_percent", "value": 16.58407829839698}]}]}
[task 2022-01-29T21:37:00.946Z] 21:37:00     INFO - Total resource usage - Wall time: 1630s; CPU: 17%; Read bytes: 47025022464; Write bytes: 27165523968; Read time: 12244; Write time: 696
[task 2022-01-29T21:37:00.946Z] 21:37:00     INFO - TinderboxPrint: CPU usage<br/>16.6%
[task 2022-01-29T21:37:00.947Z] 21:37:00     INFO - TinderboxPrint: I/O read bytes / time<br/>47,025,022,464 / 12,244
[task 2022-01-29T21:37:00.947Z] 21:37:00     INFO - TinderboxPrint: I/O write bytes / time<br/>27,165,523,968 / 696
[task 2022-01-29T21:37:00.947Z] 21:37:00     INFO - TinderboxPrint: CPU idle<br/>10,866.7 (82.9%)
[task 2022-01-29T21:37:00.947Z] 21:37:00     INFO - TinderboxPrint: CPU system<br/>647.4 (4.9%)
[task 2022-01-29T21:37:00.947Z] 21:37:00     INFO - TinderboxPrint: CPU user<br/>1,522.1 (11.6%)
[task 2022-01-29T21:37:00.948Z] 21:37:00     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-01-29T21:37:00.949Z] 21:37:00     INFO - install - Wall time: 4s; CPU: 11%; Read bytes: 84290560; Write bytes: 88486400; Read time: 1; Write time: 0
[task 2022-01-29T21:37:00.950Z] 21:37:00     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-01-29T21:37:00.972Z] 21:37:00     INFO - run-tests - Wall time: 1628s; CPU: 17%; Read bytes: 46940731904; Write bytes: 26955454464; Read time: 12243; Write time: 695
[task 2022-01-29T21:37:01.680Z] 21:37:01  WARNING - returning nonzero exit status 2
[taskcluster 2022-01-29T21:37:01.743Z]    Exit Code: 2
[taskcluster 2022-01-29T21:37:01.743Z]    User Time: 15.6001ms
[taskcluster 2022-01-29T21:37:01.743Z]  Kernel Time: 0s
[taskcluster 2022-01-29T21:37:01.743Z]    Wall Time: 31m0.261397s
[taskcluster 2022-01-29T21:37:01.743Z]       Result: FAILED
[taskcluster 2022-01-29T21:37:01.744Z] === Task Finished ===
[taskcluster 2022-01-29T21:37:01.744Z] Task Duration: 31m0.2683989s
[taskcluster 2022-01-29T21:37:01.961Z] Uploading artifact public/logs/localconfig.json from file logs\localconfig.json with content encoding "gzip", mime type "application/octet-stream" and expiry 2023-01-29T19:06:07.222Z
[taskcluster 2022-01-29T21:37:02.081Z] Uploading artifact public/test_info/36bf2695-b044-4902-8110-a1085b968c93.dmp from file build\blobber_upload_dir\36bf2695-b044-4902-8110-a1085b968c93.dmp with content encoding "gzip", mime type "application/octet-stream" and expiry 2023-01-29T19:06:07.222Z
[taskcluster 2022-01-29T21:37:02.167Z] Uploading artifact public/test_info/36bf2695-b044-4902-8110-a1085b968c93.extra from file build\blobber_upload_dir\36bf2695-b044-4902-8110-a1085b968c93.extra with content encoding "gzip", mime type "application/octet-stream" and expiry 2023-01-29T19:06:07.222Z
[taskcluster 2022-01-29T21:37:02.227Z] Uploading artifact public/test_info/resource-usage.json from file build\blobber_upload_dir\resource-usage.json with content encoding "gzip", mime type "application/octet-stream" and expiry 2023-01-29T19:06:07.222Z
[taskcluster 2022-01-29T21:37:02.435Z] 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 2023-01-29T19:06:07.222Z
[taskcluster 2022-01-29T21:37:02.497Z] Uploading artifact public/test_info/xpcshell_errorsummary.log from file build\blobber_upload_dir\xpcshell_errorsummary.log with content encoding "gzip", mime type "text/plain" and expiry 2023-01-29T19:06:07.222Z
[taskcluster 2022-01-29T21:37:02.575Z] Uploading artifact public/test_info/xpcshell_raw.log from file build\blobber_upload_dir\xpcshell_raw.log with content encoding "gzip", mime type "text/plain" and expiry 2023-01-29T19:06:07.222Z
[taskcluster 2022-01-29T21:37:02.669Z] Uploading redirect artifact public/logs/live.log to URL https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/TLLRaDSWRpakcoSXkRRuDw/runs/0/artifacts/public/logs/live_backing.log with mime type "text/plain; charset=utf-8" and expiry 2023-01-29T19:06:07.222Z

Comment 1

[Intermittent Failures Robot]

1 failures in 3445 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-beta: 1

Platform and build breakdown:

• windows7-32-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1752711&startday=2022-01-24&endday=2022-01-30&tree=all

Comment 2

[BugBot [:suhaib / :marco/ :calixte]]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.