Closed Bug 1691157 Opened 4 years ago Closed 4 years ago

Intermittent TEST-UNEXPECTED-TIMEOUT | dom/tests/browser/browser_bug1008941_dismissGeolocationHanger.js | application timed out after 370 seconds with no output

Categories

(Core :: DOM: Geolocation, defect, P5)

Product:
Core
Component:
DOM: Geolocation
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

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

[task 2021-02-05T22:33:34.356Z] 22:33:34     INFO - TEST-OK | dom/tests/browser/browser_bug1004814.js | took 918ms
[task 2021-02-05T22:33:34.361Z] 22:33:34     INFO - GECKO(7772) | [Child 7384: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 00000211BC147400 == 2 [pid = 7384] [id = 5]
[task 2021-02-05T22:33:34.361Z] 22:33:34     INFO - GECKO(7772) | [Child 7384: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 11 (00000211C4710040) [pid = 7384] [serial = 14] [outer = 0000000000000000]
[task 2021-02-05T22:33:34.361Z] 22:33:34     INFO - GECKO(7772) | [Child 7384: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 12 (00000211C26AD800) [pid = 7384] [serial = 15] [outer = 00000211C4710040]
[task 2021-02-05T22:33:34.379Z] 22:33:34     INFO - checking window state
[task 2021-02-05T22:33:34.398Z] 22:33:34     INFO - TEST-START | dom/tests/browser/browser_bug1008941_dismissGeolocationHanger.js
[task 2021-02-05T22:33:34.398Z] 22:33:34     INFO - GECKO(7772) | Chrome file doesn't exist: Z:\task_1612563071\build\tests\mochitest\browser\dom\tests\browser\head.js
[task 2021-02-05T22:33:34.407Z] 22:33:34     INFO - GECKO(7772) | [Child 4144: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 00000159F8247000 == 6 [pid = 4144] [id = 5]
[task 2021-02-05T22:33:34.407Z] 22:33:34     INFO - GECKO(7772) | [Child 4144: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 16 (00000159F8262740) [pid = 4144] [serial = 16] [outer = 0000000000000000]
[task 2021-02-05T22:33:34.407Z] 22:33:34     INFO - GECKO(7772) | [Child 4144: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 17 (00000159F82E9C00) [pid = 4144] [serial = 17] [outer = 00000159F8262740]
[task 2021-02-05T22:33:34.549Z] 22:33:34     INFO - GECKO(7772) | [Child 4144, Main Thread] WARNING: NS_ENSURE_TRUE(info) failed: file /builds/worker/checkouts/gecko/extensions/permissions/PermissionDelegateHandler.cpp:348
[task 2021-02-05T22:33:34.549Z] 22:33:34     INFO - GECKO(7772) | [Child 4144: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 18 (00000159FA6BA400) [pid = 4144] [serial = 18] [outer = 00000159F8262740]
<...>
[task 2021-02-05T22:33:40.353Z] 22:33:40     INFO - GECKO(7772) | [Child 4144: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (00000159F823F000) [pid = 4144] [serial = 11] [outer = 0000000000000000] [url = about:blank]
[task 2021-02-05T22:39:20.043Z] 22:39:20     INFO -  [Parent 4636, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/toolkit/components/places/Database.cpp:525
[task 2021-02-05T22:39:20.043Z] 22:39:20     INFO -  [Parent 4636, Main Thread] WARNING: Unable to get a connection to vacuum database: file /builds/worker/checkouts/gecko/storage/VacuumManager.cpp:130
[task 2021-02-05T22:39:20.062Z] 22:39:20     INFO -  [Parent 4636, IPDL Background] WARNING: '!gBasePath', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3593
[task 2021-02-05T22:39:20.062Z] 22:39:20     INFO -  [Parent 4636, IPDL Background] WARNING: profile-do-change must precede QuotaManager::GetOrCreate(): file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3594
[task 2021-02-05T22:39:20.062Z] 22:39:20     INFO -  [Parent 4636, IPDL Background] WARNING: QuotaManager failure: 'OkIf(quotaManager)', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:8059
[task 2021-02-05T22:39:50.362Z] 22:39:50     INFO - Buffered messages logged at 22:33:34
[task 2021-02-05T22:39:50.362Z] 22:39:50     INFO - Entering test bound testDismissHanger
[task 2021-02-05T22:39:50.362Z] 22:39:50     INFO - Check that location is not shared when dismissing the geolocation hanger
[task 2021-02-05T22:39:50.362Z] 22:39:50     INFO - Console message: [JavaScript Error: "The character encoding of the HTML document was not declared. The document will render with garbled text in some browser configurations if the document contains characters from outside the US-ASCII range. The character encoding of the page must be declared in the document or in the transfer protocol." {file: "https://example.com/browser/dom/tests/browser/position.html" line: 0}]
[task 2021-02-05T22:39:50.363Z] 22:39:50     INFO - Buffered messages finished
[task 2021-02-05T22:39:50.363Z] 22:39:50    ERROR - TEST-UNEXPECTED-TIMEOUT | dom/tests/browser/browser_bug1008941_dismissGeolocationHanger.js | application timed out after 370 seconds with no output
[task 2021-02-05T22:39:50.363Z] 22:39:50    ERROR - Force-terminating active process(es).
[task 2021-02-05T22:39:50.363Z] 22:39:50     INFO - Determining child pids from psutil...
[task 2021-02-05T22:39:50.368Z] 22:39:50     INFO - [8180]
[task 2021-02-05T22:39:50.368Z] 22:39:50     INFO - ==> process 8180 launched child process 5268 ("Z:\task_1612563071\build\application\firefox\firefox.exe" -contentproc --channel="8180.0.2108600988\1508161635" -parentBuildID 20210205213946 -prefsHandle 2196 -prefMapHandle 2188 -prefsLen 1 -prefMapSize 244886 -appdir "Z:\task_1612563071\build\application\firefox\browser" - 8180 "\\.\pipe\gecko-crash-server-pipe.8180" 2260 gpu)
[task 2021-02-05T22:39:50.368Z] 22:39:50     INFO - ==> process 8180 launched child process 11176 ("Z:\task_1612563071\build\application\firefox\firefox.exe" -contentproc --channel="8180.6.1624784149\1719273808" -childID 1 -isForBrowser -prefsHandle 2896 -prefMapHandle 2860 -prefsLen 1684 -prefMapSize 244886 -parentBuildID 20210205213946 -appdir "Z:\task_1612563071\build\application\firefox\browser" - 8180 "\\.\pipe\gecko-crash-server-pipe.8180" 2912 tab)
[task 2021-02-05T22:39:50.368Z] 22:39:50     INFO - ==> process 8180 launched child process 7384 ("Z:\task_1612563071\build\application\firefox\firefox.exe" -contentproc --channel="8180.13.1964487021\236591474" -childID 2 -isForBrowser -prefsHandle 3292 -prefMapHandle 3288 -prefsLen 1789 -prefMapSize 244886 -parentBuildID 20210205213946 -appdir "Z:\task_1612563071\build\application\firefox\browser" - 8180 "\\.\pipe\gecko-crash-server-pipe.8180" 3256 tab)
[task 2021-02-05T22:39:50.369Z] 22:39:50     INFO - ==> process 8180 launched child process 9892 ("Z:\task_1612563071\build\application\firefox\firefox.exe" -contentproc --channel="8180.20.2080913551\1690035284" -childID 3 -isForBrowser -prefsHandle 3492 -prefMapHandle 3488 -prefsLen 1829 -prefMapSize 244886 -parentBuildID 20210205213946 -appdir "Z:\task_1612563071\build\application\firefox\browser" - 8180 "\\.\pipe\gecko-crash-server-pipe.8180" 3480 tab)
[task 2021-02-05T22:39:50.369Z] 22:39:50     INFO - ==> process 8180 launched child process 6960 ("Z:\task_1612563071\build\application\firefox\firefox.exe" -contentproc --channel="8180.27.1718055316\2059733583" -parentBuildID 20210205213946 -prefsHandle 3900 -prefMapHandle 3892 -prefsLen 2820 -prefMapSize 244886 -appdir "Z:\task_1612563071\build\application\firefox\browser" - 8180 "\\.\pipe\gecko-crash-server-pipe.8180" 3908 rdd)
[task 2021-02-05T22:39:50.369Z] 22:39:50     INFO - ==> process 8180 launched child process 1712 ("Z:\task_1612563071\build\application\firefox\firefox.exe" -contentproc --channel="8180.31.1186741504\228060093" -childID 4 -isForBrowser -prefsHandle 4180 -prefMapHandle 4516 -prefsLen 11305 -prefMapSize 244886 -parentBuildID 20210205213946 -appdir "Z:\task_1612563071\build\application\firefox\browser" - 8180 "\\.\pipe\gecko-crash-server-pipe.8180" 4536 tab)
[task 2021-02-05T22:39:50.369Z] 22:39:50     INFO - ==> process 8180 launched child process 8568 ("Z:\task_1612563071\build\application\firefox\firefox.exe" -contentproc --channel="8180.32.1021682426\1270838310" -childID 5 -isForBrowser -prefsHandle 4124 -prefMapHandle 4032 -prefsLen 11305 -prefMapSize 244886 -parentBuildID 20210205213946 -appdir "Z:\task_1612563071\build\application\firefox\browser" - 8180 "\\.\pipe\gecko-crash-server-pipe.8180" 4592 tab)
[task 2021-02-05T22:39:50.369Z] 22:39:50     INFO - ==> process 8180 launched child process 4144 ("Z:\task_1612563071\build\application\firefox\firefox.exe" -contentproc --channel="8180.45.230875065\339733479" -childID 6 -isForBrowser -prefsHandle 5008 -prefMapHandle 4976 -prefsLen 11369 -prefMapSize 244886 -parentBuildID 20210205213946 -appdir "Z:\task_1612563071\build\application\firefox\browser" - 8180 "\\.\pipe\gecko-crash-server-pipe.8180" 4948 tab)
[task 2021-02-05T22:39:50.369Z] 22:39:50     INFO - ==> process 8180 launched child process 9672 ("Z:\task_1612563071\build\application\firefox\firefox.exe" -contentproc --channel="8180.52.391390115\1057738334" -childID 7 -isForBrowser -prefsHandle 5172 -prefMapHandle 5168 -prefsLen 11619 -prefMapSize 244886 -parentBuildID 20210205213946 -appdir "Z:\task_1612563071\build\application\firefox\browser" - 8180 "\\.\pipe\gecko-crash-server-pipe.8180" 5180 tab)
[task 2021-02-05T22:39:50.370Z] 22:39:50     INFO - Found child pids: set([1712, 9892, 4144, 11176, 6960, 8568, 5268, 7384, 8180, 9672])
[task 2021-02-05T22:39:50.370Z] 22:39:50     INFO - Failed to get child procs
[task 2021-02-05T22:39:50.370Z] 22:39:50     INFO - Killing process: 1712
[task 2021-02-05T22:39:50.372Z] 22:39:50     INFO - TEST-INFO | started process screenshot
[task 2021-02-05T22:39:50.451Z] 22:39:50     INFO - TEST-INFO | screenshot: exit 0
[task 2021-02-05T22:39:50.451Z] 22:39:50     INFO - mozcrash Writing a dump to c:\users\task_1612563071\appdata\local\temp\tmpqsvyfp.mozrunner\minidumps\33cb798d-3efe-4f2f-9877-a0f767eaeadd.dmp for [1712]
[task 2021-02-05T22:39:50.556Z] 22:39:50     INFO - Killing process: 9892
[task 2021-02-05T22:39:50.556Z] 22:39:50     INFO - Not taking screenshot here: see the one that was previously logged```

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

Status: NEW → RESOLVED
Closed: 4 years ago
Resolution: --- → INCOMPLETE

Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=333226243&repo=autoland&lineNumber=41677

Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---

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

Status: REOPENED → RESOLVED
Closed: 4 years ago → 4 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.