Intermittent TEST-UNEXPECTED-TIMEOUT | dom/security/test/csp/test_worker_src.html | application timed out after 370 seconds with no output
Categories
(Core :: DOM: Security, defect, P5)
Tracking
()
People
(Reporter: intermittent-bug-filer, Assigned: ehsan.akhgari)
References
(Regression)
Details
(Keywords: intermittent-failure, regression, Whiteboard: [domsecurity-intermittent][retriggered])
Filed by: dvarga [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=261370837&repo=mozilla-central
Full log: https://queue.taskcluster.net/v1/task/FfGI_5F_QKiQjyn9zGPfbw/runs/0/artifacts/public/logs/live_backing.log
[task 2019-08-13T17:02:48.150Z] 17:02:48 INFO - TEST-START | dom/security/test/csp/test_worker_src.html
[task 2019-08-13T17:08:59.059Z] 17:08:59 INFO - Buffered messages logged at 17:02:48
[task 2019-08-13T17:08:59.060Z] 17:08:59 INFO - TEST-PASS | dom/security/test/csp/test_worker_src.html | allowing worker from https://example.com (worker-allowed)
[task 2019-08-13T17:08:59.060Z] 17:08:59 INFO - TEST-PASS | dom/security/test/csp/test_worker_src.html | allowing worker from https://example.com (shared-worker-allowed)
[task 2019-08-13T17:08:59.060Z] 17:08:59 INFO - TEST-PASS | dom/security/test/csp/test_worker_src.html | allowing worker from https://example.com (service-worker-allowed)
[task 2019-08-13T17:08:59.061Z] 17:08:59 INFO - TEST-PASS | dom/security/test/csp/test_worker_src.html | allowing worker from https://example.com (shared-worker-allowed)
[task 2019-08-13T17:08:59.062Z] 17:08:59 INFO - TEST-PASS | dom/security/test/csp/test_worker_src.html | allowing worker from https://example.com (worker-allowed)
[task 2019-08-13T17:08:59.063Z] 17:08:59 INFO - TEST-PASS | dom/security/test/csp/test_worker_src.html | allowing worker from https://example.com (service-worker-allowed)
[task 2019-08-13T17:08:59.063Z] 17:08:59 INFO - TEST-PASS | dom/security/test/csp/test_worker_src.html | allowing worker from https://example.com (shared-worker-allowed)
[task 2019-08-13T17:08:59.063Z] 17:08:59 INFO - TEST-PASS | dom/security/test/csp/test_worker_src.html | allowing worker from https://example.com (worker-allowed)
[task 2019-08-13T17:08:59.063Z] 17:08:59 INFO - TEST-PASS | dom/security/test/csp/test_worker_src.html | allowing worker from https://example.com (service-worker-allowed)
[task 2019-08-13T17:08:59.063Z] 17:08:59 INFO - TEST-PASS | dom/security/test/csp/test_worker_src.html | blocking worker from https://test1.example.com (service-worker-blocked)
[task 2019-08-13T17:08:59.063Z] 17:08:59 INFO - TEST-PASS | dom/security/test/csp/test_worker_src.html | blocking worker from https://test1.example.com (worker-blocked)
[task 2019-08-13T17:08:59.063Z] 17:08:59 INFO - TEST-PASS | dom/security/test/csp/test_worker_src.html | blocking worker from https://test1.example.com (shared-worker-blocked)
[task 2019-08-13T17:08:59.063Z] 17:08:59 INFO - TEST-PASS | dom/security/test/csp/test_worker_src.html | blocking worker from https://test1.example.com (shared-worker-blocked)
[task 2019-08-13T17:08:59.064Z] 17:08:59 INFO - TEST-PASS | dom/security/test/csp/test_worker_src.html | blocking worker from https://test1.example.com (service-worker-blocked)
[task 2019-08-13T17:08:59.064Z] 17:08:59 INFO - TEST-PASS | dom/security/test/csp/test_worker_src.html | blocking worker from https://test1.example.com (worker-blocked)
[task 2019-08-13T17:08:59.065Z] 17:08:59 INFO - Buffered messages logged at 17:02:49
[task 2019-08-13T17:08:59.065Z] 17:08:59 INFO - TEST-PASS | dom/security/test/csp/test_worker_src.html | blocking worker from https://test1.example.com (service-worker-blocked)
[task 2019-08-13T17:08:59.065Z] 17:08:59 INFO - TEST-PASS | dom/security/test/csp/test_worker_src.html | blocking worker from https://test1.example.com (worker-blocked)
[task 2019-08-13T17:08:59.066Z] 17:08:59 INFO - Buffered messages finished
[task 2019-08-13T17:08:59.066Z] 17:08:59 ERROR - TEST-UNEXPECTED-TIMEOUT | dom/security/test/csp/test_worker_src.html | application timed out after 370 seconds with no output
[task 2019-08-13T17:08:59.067Z] 17:08:59 ERROR - Force-terminating active process(es).
[task 2019-08-13T17:08:59.067Z] 17:08:59 INFO - Determining child pids from psutil...
[task 2019-08-13T17:08:59.071Z] 17:08:59 INFO - [1579, 1561, 1455, 2098, 1533, 1419]
[task 2019-08-13T17:08:59.071Z] 17:08:59 INFO - ==> process 1382 launched child process 1403
[task 2019-08-13T17:08:59.072Z] 17:08:59 INFO - ==> process 1382 launched child process 1419
[task 2019-08-13T17:08:59.072Z] 17:08:59 INFO - ==> process 1382 launched child process 1455
[task 2019-08-13T17:08:59.073Z] 17:08:59 INFO - ==> process 1382 launched child process 1474
[task 2019-08-13T17:08:59.073Z] 17:08:59 INFO - ==> process 1382 launched child process 1533
[task 2019-08-13T17:08:59.074Z] 17:08:59 INFO - ==> process 1382 launched child process 1561
[task 2019-08-13T17:08:59.074Z] 17:08:59 INFO - ==> process 1382 launched child process 1579
[task 2019-08-13T17:08:59.074Z] 17:08:59 INFO - ==> process 1382 launched child process 1628
[task 2019-08-13T17:08:59.075Z] 17:08:59 INFO - ==> process 1382 launched child process 1657
[task 2019-08-13T17:08:59.075Z] 17:08:59 INFO - ==> process 1382 launched child process 1687
[task 2019-08-13T17:08:59.075Z] 17:08:59 INFO - ==> process 1382 launched child process 1715
[task 2019-08-13T17:08:59.076Z] 17:08:59 INFO - ==> process 1382 launched child process 1806
[task 2019-08-13T17:08:59.076Z] 17:08:59 INFO - ==> process 1382 launched child process 1836
[task 2019-08-13T17:08:59.077Z] 17:08:59 INFO - ==> process 1382 launched child process 1866
[task 2019-08-13T17:08:59.077Z] 17:08:59 INFO - ==> process 1382 launched child process 1894
[task 2019-08-13T17:08:59.077Z] 17:08:59 INFO - ==> process 1382 launched child process 1922
[task 2019-08-13T17:08:59.078Z] 17:08:59 INFO - ==> process 1382 launched child process 1950
[task 2019-08-13T17:08:59.078Z] 17:08:59 INFO - ==> process 1382 launched child process 1981
[task 2019-08-13T17:08:59.079Z] 17:08:59 INFO - ==> process 1382 launched child process 2009
[task 2019-08-13T17:08:59.079Z] 17:08:59 INFO - ==> process 1382 launched child process 2037
[task 2019-08-13T17:08:59.079Z] 17:08:59 INFO - ==> process 1382 launched child process 2066
[task 2019-08-13T17:08:59.080Z] 17:08:59 INFO - ==> process 1382 launched child process 2098
[task 2019-08-13T17:08:59.080Z] 17:08:59 INFO - Found child pids: set([1922, 1419, 1806, 2066, 1687, 1561, 1950, 1579, 1836, 1455, 2098, 1715, 1981, 1474, 1866, 2009, 1628, 1894, 2037, 1657, 1403, 1533])
[task 2019-08-13T17:08:59.080Z] 17:08:59 INFO - Failed to get child procs
[task 2019-08-13T17:08:59.081Z] 17:08:59 INFO - Killing process: 1922
[task 2019-08-13T17:08:59.081Z] 17:08:59 INFO - TEST-INFO | started process screentopng
[task 2019-08-13T17:08:59.330Z] 17:08:59 INFO - TEST-INFO | screentopng: exit 0
[task 2019-08-13T17:08:59.331Z] 17:08:59 INFO - Can't trigger Breakpad, process no longer exists
Updated•5 years ago
|
Comment hidden (Intermittent Failures Robot) |
Comment 2•5 years ago
|
||
Looks like this started permafailing once Bug 1575609 has landed: https://treeherder.mozilla.org/#/jobs?repo=autoland&searchStr=linux%2Cx64%2Cdebug%2Cmochitests%2Cwith%2Cfission%2Cenabled%2Ctest-linux64%2Fdebug-mochitest-fis-e10s-7%2Cm-fis%287%29&tochange=56e028fe22340309805ffcffd410625e560642c5&fromchange=b0d9e6296249fdfc7ad53fb69078832de77c6c56&selectedJob=263416756
Ehsan, could you please take a look? Thank you.
Updated•5 years ago
|
Comment hidden (Intermittent Failures Robot) |
Assignee | ||
Comment 4•5 years ago
|
||
My patch in bug 1576316 fixes this.
Comment hidden (Intermittent Failures Robot) |
Comment 6•5 years ago
|
||
Failure log: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=264675453&repo=mozilla-central&lineNumber=2197
Assignee | ||
Comment 7•5 years ago
|
||
Only one occurrence after that landing, so extremely rare intermittent. Unfortunately don't have time to look into it further at the moment, sorry about that.
Comment hidden (Intermittent Failures Robot) |
Updated•3 years ago
|
Description
•