Closed
Bug 1720167
Opened 5 years ago
Closed 5 years ago
Intermittent TEST-UNEXPECTED-TIMEOUT | browser/components/places/tests/browser/interactions/browser_interactions_view_time.js | application timed out after 370 seconds with no output
Categories
(Firefox :: Bookmarks & History, defect, P5)
Firefox
Bookmarks & History
Tracking
()
RESOLVED
INCOMPLETE
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: intermittent-failure)
Filed by: mlaza [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=344968634&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/Dk8sB1VsRa6vu_MkXaQLpA/runs/0/artifacts/public/logs/live_backing.log
[task 2021-07-12T14:37:59.146Z] 14:37:59 INFO - TEST-START | browser/components/places/tests/browser/interactions/browser_interactions_view_time.js
[task 2021-07-12T14:37:59.147Z] 14:37:59 INFO - GECKO(3808) | console.debug: InteractionsManager: "Reset"
[task 2021-07-12T14:37:59.162Z] 14:37:59 INFO - GECKO(3808) | console.debug: InteractionsManager: "Tab switch notified"
[task 2021-07-12T14:37:59.163Z] 14:37:59 INFO - GECKO(3808) | console.debug: InteractionsManager: "No interaction to update"
[task 2021-07-12T14:37:59.205Z] 14:37:59 INFO - GECKO(3808) | console.debug: InteractionsManager: "New interaction" ({isActive:true, url:"https://example.com/"})
[task 2021-07-12T14:37:59.487Z] 14:37:59 INFO - GECKO(3808) | console.debug: InteractionsManager: "End of interaction"
[task 2021-07-12T14:37:59.487Z] 14:37:59 INFO - GECKO(3808) | console.debug: InteractionsManager: "Add to store: " ({url:"https://example.com/", totalViewTime:10025.107088, typingTime:0, keypresses:0, scrollingTime:0, scrollingDistance:0, created_at:1626100679205, updated_at:1626100679486})
[task 2021-07-12T14:37:59.500Z] 14:37:59 INFO - GECKO(3808) | console.debug: InteractionsManager: "New interaction" ({isActive:true, url:"https://example.com/browser"})
[task 2021-07-12T14:37:59.502Z] 14:37:59 INFO - GECKO(3808) | console.debug: InteractionsManager: "Storing 1 entries in the database"
[task 2021-07-12T14:37:59.517Z] 14:37:59 INFO - GECKO(3808) | console.debug: InteractionsManager: "End of interaction"
[task 2021-07-12T14:37:59.518Z] 14:37:59 INFO - GECKO(3808) | console.debug: InteractionsManager: "Add to store: " ({url:"https://example.com/browser", totalViewTime:20009.160048, typingTime:0, keypresses:0, scrollingTime:0, scrollingDistance:0, created_at:1626100679500, updated_at:1626100679517})
[task 2021-07-12T14:37:59.524Z] 14:37:59 INFO - GECKO(3808) | console.debug: InteractionsManager: "End of interaction"
[task 2021-07-12T14:37:59.524Z] 14:37:59 INFO - GECKO(3808) | console.debug: InteractionsManager: "No interaction to update"
[task 2021-07-12T14:37:59.525Z] 14:37:59 INFO - GECKO(3808) | console.debug: InteractionsManager: "Storing 1 entries in the database"
[task 2021-07-12T14:37:59.538Z] 14:37:59 INFO - GECKO(3808) | console.debug: InteractionsManager: "Tab switch notified"
[task 2021-07-12T14:37:59.538Z] 14:37:59 INFO - GECKO(3808) | console.debug: InteractionsManager: "No interaction to update"
[task 2021-07-12T14:37:59.542Z] 14:37:59 INFO - GECKO(3808) | console.debug: InteractionsManager: "Reset"
[task 2021-07-12T14:37:59.556Z] 14:37:59 INFO - GECKO(3808) | console.debug: InteractionsManager: "Tab switch notified"
[task 2021-07-12T14:37:59.556Z] 14:37:59 INFO - GECKO(3808) | console.debug: InteractionsManager: "No interaction to update"
[task 2021-07-12T14:37:59.607Z] 14:37:59 INFO - GECKO(3808) | console.debug: InteractionsManager: "New interaction" ({isActive:true, url:"https://example.com/"})
[task 2021-07-12T14:38:00.022Z] 14:38:00 INFO - GECKO(3808) | JavaScript warning: resource://gre/modules/Troubleshoot.jsm, line 691: WebGL context was lost.
[task 2021-07-12T14:44:10.051Z] 14:44:10 INFO - Buffered messages logged at 14:37:59
[task 2021-07-12T14:44:10.051Z] 14:44:10 INFO - Entering test bound global_setup
[task 2021-07-12T14:44:10.052Z] 14:44:10 INFO - Leaving test bound global_setup
[task 2021-07-12T14:44:10.052Z] 14:44:10 INFO - Entering test bound test_interactions_simple_load_and_navigate_away
[task 2021-07-12T14:44:10.052Z] 14:44:10 INFO - Console message: [JavaScript Error: "InvalidStateError: JSWindowActorChild.sendAsyncMessage: JSWindowActorChild cannot send at the moment" {file: "resource://autofill/FormAutofillChild.jsm" line: 108}]
[task 2021-07-12T14:44:10.053Z] 14:44:10 INFO - _doIdentifyAutofillFields/<@resource://autofill/FormAutofillChild.jsm:108:12
[task 2021-07-12T14:44:10.053Z] 14:44:10 INFO - notify@resource://gre/modules/Timer.jsm:62:17
[task 2021-07-12T14:44:10.053Z] 14:44:10 INFO -
[task 2021-07-12T14:44:10.053Z] 14:44:10 INFO - Found 1 interactions:
[task 2021-07-12T14:44:10.053Z] 14:44:10 INFO - [{"url":"https://example.com/","keypresses":0,"typingTime":0,"totalViewTime":10025}]
[task 2021-07-12T14:44:10.054Z] 14:44:10 INFO - TEST-PASS | browser/components/places/tests/browser/interactions/browser_interactions_view_time.js | Found the expected number of entries - 1 == 1 -
[task 2021-07-12T14:44:10.054Z] 14:44:10 INFO - TEST-PASS | browser/components/places/tests/browser/interactions/browser_interactions_view_time.js | Should have saved the page into the database - "https://example.com/" == "https://example.com/" -
[task 2021-07-12T14:44:10.054Z] 14:44:10 INFO - TEST-PASS | browser/components/places/tests/browser/interactions/browser_interactions_view_time.js | Should have stored the interaction time - 10025 >= 10000 -
[task 2021-07-12T14:44:10.055Z] 14:44:10 INFO - Found 2 interactions:
[task 2021-07-12T14:44:10.055Z] 14:44:10 INFO - [{"url":"https://example.com/","keypresses":0,"typingTime":0,"totalViewTime":10025},{"url":"https://example.com/browser","keypresses":0,"typingTime":0,"totalViewTime":20009}]
[task 2021-07-12T14:44:10.055Z] 14:44:10 INFO - TEST-PASS | browser/components/places/tests/browser/interactions/browser_interactions_view_time.js | Found the expected number of entries - 2 == 2 -
[task 2021-07-12T14:44:10.056Z] 14:44:10 INFO - TEST-PASS | browser/components/places/tests/browser/interactions/browser_interactions_view_time.js | Should have saved the page into the database - "https://example.com/" == "https://example.com/" -
[task 2021-07-12T14:44:10.056Z] 14:44:10 INFO - TEST-PASS | browser/components/places/tests/browser/interactions/browser_interactions_view_time.js | Should have stored the interaction time - 10025 >= 10000 -
[task 2021-07-12T14:44:10.057Z] 14:44:10 INFO - TEST-PASS | browser/components/places/tests/browser/interactions/browser_interactions_view_time.js | Should have saved the page into the database - "https://example.com/browser" == "https://example.com/browser" -
[task 2021-07-12T14:44:10.057Z] 14:44:10 INFO - TEST-PASS | browser/components/places/tests/browser/interactions/browser_interactions_view_time.js | Should have stored the interaction time - 20009 >= 20000 -
[task 2021-07-12T14:44:10.057Z] 14:44:10 INFO - Leaving test bound test_interactions_simple_load_and_navigate_away
[task 2021-07-12T14:44:10.058Z] 14:44:10 INFO - Entering test bound test_interactions_simple_load_and_change_to_non_http
[task 2021-07-12T14:44:10.058Z] 14:44:10 INFO - Buffered messages finished
[task 2021-07-12T14:44:10.058Z] 14:44:10 ERROR - TEST-UNEXPECTED-TIMEOUT | browser/components/places/tests/browser/interactions/browser_interactions_view_time.js | application timed out after 370 seconds with no output
[task 2021-07-12T14:44:10.059Z] 14:44:10 ERROR - Force-terminating active process(es).
[task 2021-07-12T14:44:10.059Z] 14:44:10 INFO - Determining child pids from psutil...
[task 2021-07-12T14:44:10.059Z] 14:44:10 INFO - [3516]
[task 2021-07-12T14:44:10.060Z] 14:44:10 INFO - ==> process 3516 launched child process 740 ("Z:\task_1626098996\build\application\firefox\firefox.exe" -contentproc --channel="3516.0.1911453063\1708708182" -parentBuildID 20210712124850 -prefsHandle 2220 -prefMapHandle 2208 -prefsLen 1 -prefMapSize 250035 -appdir "Z:\task_1626098996\build\application\firefox\browser" - 3516 "\\.\pipe\gecko-crash-server-pipe.3516" 2260 1f6f1152538 gpu)
[task 2021-07-12T14:44:10.060Z] 14:44:10 INFO - ==> process 3516 launched child process 4860 ("Z:\task_1626098996\build\application\firefox\firefox.exe" -contentproc --channel="3516.1.816125948\1871476849" -childID 1 -isForBrowser -prefsHandle 2812 -prefMapHandle 2572 -prefsLen 1790 -prefMapSize 250035 -jsInit 1288 285716 -parentBuildID 20210712124850 -appdir "Z:\task_1626098996\build\application\firefox\browser" - 3516 "\\.\pipe\gecko-crash-server-pipe.3516" 2844 1f6f3198b38 tab)
[task 2021-07-12T14:44:10.061Z] 14:44:10 INFO - ==> process 3516 launched child process 7360 ("Z:\task_1626098996\build\application\firefox\firefox.exe" -contentproc --channel="3516.3.1410116717\1096539786" -childID 2 -isForBrowser -prefsHandle 3176 -prefMapHandle 3172 -prefsLen 1933 -prefMapSize 250035 -jsInit 1288 285716 -parentBuildID 20210712124850 -appdir "Z:\task_1626098996\build\application\firefox\browser" - 3516 "\\.\pipe\gecko-crash-server-pipe.3516" 3188 1f6f6963d38 tab)
[task 2021-07-12T14:44:10.062Z] 14:44:10 INFO - ==> process 3516 launched child process 1148 ("Z:\task_1626098996\build\application\firefox\firefox.exe" -contentproc --channel="3516.5.1663561378\1697757470" -childID 3 -isForBrowser -prefsHandle 3324 -prefMapHandle 3328 -prefsLen 1973 -prefMapSize 250035 -jsInit 1288 285716 -parentBuildID 20210712124850 -appdir "Z:\task_1626098996\build\application\firefox\browser" - 3516 "\\.\pipe\gecko-crash-server-pipe.3516" 3364 1f6f6965738 tab)
[task 2021-07-12T14:44:10.062Z] 14:44:10 INFO - ==> process 3516 launched child process 10024 ("Z:\task_1626098996\build\application\firefox\firefox.exe" -contentproc --channel="3516.7.923798933\639284729" -childID 4 -isForBrowser -prefsHandle 4080 -prefMapHandle 4072 -prefsLen 9905 -prefMapSize 250035 -jsInit 1288 285716 -parentBuildID 20210712124850 -appdir "Z:\task_1626098996\build\application\firefox\browser" - 3516 "\\.\pipe\gecko-crash-server-pipe.3516" 4100 1f6f8e99938 tab)
[task 2021-07-12T14:44:10.063Z] 14:44:10 INFO - ==> process 3516 launched child process 6904 ("Z:\task_1626098996\build\application\firefox\firefox.exe" -contentproc --channel="3516.8.1217167678\1231772126" -childID 5 -isForBrowser -prefsHandle 4124 -prefMapHandle 4120 -prefsLen 9905 -prefMapSize 250035 -jsInit 1288 285716 -parentBuildID 20210712124850 -appdir "Z:\task_1626098996\build\application\firefox\browser" - 3516 "\\.\pipe\gecko-crash-server-pipe.3516" 4240 1f6f8e9a138 tab)
[task 2021-07-12T14:44:10.064Z] 14:44:10 INFO - ==> process 3516 launched child process 1916 ("Z:\task_1626098996\build\application\firefox\firefox.exe" -contentproc --channel="3516.12.23628892\2088215332" -childID 6 -isForBrowser -prefsHandle 4724 -prefMapHandle 4720 -prefsLen 10368 -prefMapSize 250035 -jsInit 1288 285716 -parentBuildID 20210712124850 -appdir "Z:\task_1626098996\build\application\firefox\browser" - 3516 "\\.\pipe\gecko-crash-server-pipe.3516" 4384 1f6f6687738 tab)
[task 2021-07-12T14:44:10.064Z] 14:44:10 INFO - ==> process 3516 launched child process 2092 ("Z:\task_1626098996\build\application\firefox\firefox.exe" -contentproc --channel="3516.14.1903635055\1269436304" -childID 7 -isForBrowser -prefsHandle 4644 -prefMapHandle 4876 -prefsLen 10368 -prefMapSize 250035 -jsInit 1288 285716 -parentBuildID 20210712124850 -appdir "Z:\task_1626098996\build\application\firefox\browser" - 3516 "\\.\pipe\gecko-crash-server-pipe.3516" 4732 1f6f6969538 tab)
[task 2021-07-12T14:44:10.065Z] 14:44:10 INFO - Found child pids: {7360, 740, 10024, 1916, 2092, 1148, 6904, 3516, 4860}
[task 2021-07-12T14:44:10.065Z] 14:44:10 INFO - Failed to get child procs
[task 2021-07-12T14:44:10.065Z] 14:44:10 INFO - Killing process: 7360
[task 2021-07-12T14:44:10.065Z] 14:44:10 INFO - TEST-INFO | started process screenshot
[task 2021-07-12T14:44:10.128Z] 14:44:10 INFO - TEST-INFO | screenshot: exit 0
[task 2021-07-12T14:44:10.128Z] 14:44:10 INFO - mozcrash Writing a dump to C:\Users\task_1626098996\AppData\Local\Temp\tmpobo_ns7j.mozrunner\minidumps\79b2374f-25cc-4f53-94ad-961bec15978d.dmp for [7360]
[task 2021-07-12T14:44:10.204Z] 14:44:10 INFO - Killing process: 740
[task 2021-07-12T14:44:10.205Z] 14:44:10 INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-07-12T14:44:10.205Z] 14:44:10 INFO - mozcrash Writing a dump to C:\Users\task_1626098996\AppData\Local\Temp\tmpobo_ns7j.mozrunner\minidumps\43796592-43a5-4d0d-926f-fa5d4925329c.dmp for [740]
[task 2021-07-12T14:44:10.317Z] 14:44:10 INFO - Killing process: 10024
[task 2021-07-12T14:44:10.318Z] 14:44:10 INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-07-12T14:44:10.318Z] 14:44:10 INFO - mozcrash Writing a dump to C:\Users\task_1626098996\AppData\Local\Temp\tmpobo_ns7j.mozrunner\minidumps\1dd559e8-5b90-4500-8fa0-81bafbef604d.dmp for [10024]
[task 2021-07-12T14:44:10.372Z] 14:44:10 INFO - Killing process: 1916
[task 2021-07-12T14:44:10.372Z] 14:44:10 INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-07-12T14:44:10.373Z] 14:44:10 INFO - mozcrash Writing a dump to C:\Users\task_1626098996\AppData\Local\Temp\tmpobo_ns7j.mozrunner\minidumps\dce96029-946d-426b-accf-dfd25c7279a0.dmp for [1916]
[task 2021-07-12T14:44:10.423Z] 14:44:10 INFO - Killing process: 2092
[task 2021-07-12T14:44:10.424Z] 14:44:10 INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-07-12T14:44:10.424Z] 14:44:10 INFO - mozcrash Writing a dump to C:\Users\task_1626098996\AppData\Local\Temp\tmpobo_ns7j.mozrunner\minidumps\082bb21a-2339-41ec-897e-f03d6bbfc317.dmp for [2092]
[task 2021-07-12T14:44:10.473Z] 14:44:10 INFO - Killing process: 1148
[task 2021-07-12T14:44:10.473Z] 14:44:10 INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-07-12T14:44:10.474Z] 14:44:10 INFO - mozcrash Writing a dump to C:\Users\task_1626098996\AppData\Local\Temp\tmpobo_ns7j.mozrunner\minidumps\b1b37f16-0158-418c-bb3b-becb24005edc.dmp for [1148]
[task 2021-07-12T14:44:10.525Z] 14:44:10 INFO - Killing process: 6904
[task 2021-07-12T14:44:10.525Z] 14:44:10 INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-07-12T14:44:10.526Z] 14:44:10 INFO - mozcrash Writing a dump to C:\Users\task_1626098996\AppData\Local\Temp\tmpobo_ns7j.mozrunner\minidumps\14744818-e0a5-460a-8d2d-ebfd77e0a4f2.dmp for [6904]
[task 2021-07-12T14:44:10.528Z] 14:44:10 WARNING - mozcrash unable to dump minidump file for pid 6904: -2147024597
[task 2021-07-12T14:44:10.528Z] 14:44:10 WARNING - mozcrash kill_pid(): unable to terminate pid 6904: 5
[task 2021-07-12T14:44:10.528Z] 14:44:10 INFO - Killing process: 3516
[task 2021-07-12T14:44:10.528Z] 14:44:10 INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-07-12T14:44:10.529Z] 14:44:10 INFO - mozcrash Writing a dump to C:\Users\task_1626098996\AppData\Local\Temp\tmpobo_ns7j.mozrunner\minidumps\4cb6b969-8c15-47a1-b95d-0a1d96677342.dmp for [3516]
[task 2021-07-12T14:44:10.666Z] 14:44:10 INFO - Killing process: 4860
[task 2021-07-12T14:44:10.667Z] 14:44:10 INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-07-12T14:44:10.667Z] 14:44:10 INFO - mozcrash Writing a dump to C:\Users\task_1626098996\AppData\Local\Temp\tmpobo_ns7j.mozrunner\minidumps\772c9ed0-9df1-49da-baca-0a45298ae123.dmp for [4860]
[task 2021-07-12T14:44:10.670Z] 14:44:10 WARNING - mozcrash unable to dump minidump file for pid 4860: -2147024597
[task 2021-07-12T14:44:10.670Z] 14:44:10 WARNING - mozcrash kill_pid(): unable to get handle for pid 4860: 87
[task 2021-07-12T14:44:10.670Z] 14:44:10 INFO - Killing process: 3808
[task 2021-07-12T14:44:10.671Z] 14:44:10 INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-07-12T14:44:10.671Z] 14:44:10 INFO - mozcrash Writing a dump to C:\Users\task_1626098996\AppData\Local\Temp\tmpobo_ns7j.mozrunner\minidumps\d4129996-aa0b-48ec-8c8d-ab264d92292d.dmp for [3808]
[task 2021-07-12T14:44:10.675Z] 14:44:10 WARNING - mozcrash unable to dump minidump file for pid 3808: -2147024597
[task 2021-07-12T14:44:10.676Z] 14:44:10 WARNING - mozcrash kill_pid(): unable to terminate pid 3808: 5
[task 2021-07-12T14:44:10.679Z] 14:44:10 INFO - psutil found pid 3808 dead
[task 2021-07-12T14:44:10.679Z] 14:44:10 INFO - TEST-INFO | Main app process: exit 1
[task 2021-07-12T14:44:10.680Z] 14:44:10 INFO - Buffered messages finished
[task 2021-07-12T14:44:10.680Z] 14:44:10 ERROR - TEST-UNEXPECTED-FAIL | browser/components/places/tests/browser/interactions/browser_interactions_view_time.js | application terminated with exit code 1
[task 2021-07-12T14:44:10.680Z] 14:44:10 INFO - runtests.py | Application ran for: 0:06:23.451376
[task 2021-07-12T14:44:10.681Z] 14:44:10 INFO - zombiecheck | Reading PID log: C:\Users\task_1626098996\AppData\Local\Temp\tmpeg5da5ejpidlog
[task 2021-07-12T14:44:10.681Z] 14:44:10 INFO - ==> process 3516 launched child process 740 ("Z:\task_1626098996\build\application\firefox\firefox.exe" -contentproc --channel="3516.0.1911453063\1708708182" -parentBuildID 20210712124850 -prefsHandle 2220 -prefMapHandle 2208 -prefsLen 1 -prefMapSize 250035 -appdir "Z:\task_1626098996\build\application\firefox\browser" - 3516 "\\.\pipe\gecko-crash-server-pipe.3516" 2260 1f6f1152538 gpu)
[task 2021-07-12T14:44:10.682Z] 14:44:10 INFO - ==> process 3516 launched child process 4860 ("Z:\task_1626098996\build\application\firefox\firefox.exe" -contentproc --channel="3516.1.816125948\1871476849" -childID 1 -isForBrowser -prefsHandle 2812 -prefMapHandle 2572 -prefsLen 1790 -prefMapSize 250035 -jsInit 1288 285716 -parentBuildID 20210712124850 -appdir "Z:\task_1626098996\build\application\firefox\browser" - 3516 "\\.\pipe\gecko-crash-server-pipe.3516" 2844 1f6f3198b38 tab)
[task 2021-07-12T14:44:10.683Z] 14:44:10 INFO - ==> process 3516 launched child process 7360 ("Z:\task_1626098996\build\application\firefox\firefox.exe" -contentproc --channel="3516.3.1410116717\1096539786" -childID 2 -isForBrowser -prefsHandle 3176 -prefMapHandle 3172 -prefsLen 1933 -prefMapSize 250035 -jsInit 1288 285716 -parentBuildID 20210712124850 -appdir "Z:\task_1626098996\build\application\firefox\browser" - 3516 "\\.\pipe\gecko-crash-server-pipe.3516" 3188 1f6f6963d38 tab)
[task 2021-07-12T14:44:10.683Z] 14:44:10 INFO - ==> process 3516 launched child process 1148 ("Z:\task_1626098996\build\application\firefox\firefox.exe" -contentproc --channel="3516.5.1663561378\1697757470" -childID 3 -isForBrowser -prefsHandle 3324 -prefMapHandle 3328 -prefsLen 1973 -prefMapSize 250035 -jsInit 1288 285716 -parentBuildID 20210712124850 -appdir "Z:\task_1626098996\build\application\firefox\browser" - 3516 "\\.\pipe\gecko-crash-server-pipe.3516" 3364 1f6f6965738 tab)
[task 2021-07-12T14:44:10.684Z] 14:44:10 INFO - ==> process 3516 launched child process 10024 ("Z:\task_1626098996\build\application\firefox\firefox.exe" -contentproc --channel="3516.7.923798933\639284729" -childID 4 -isForBrowser -prefsHandle 4080 -prefMapHandle 4072 -prefsLen 9905 -prefMapSize 250035 -jsInit 1288 285716 -parentBuildID 20210712124850 -appdir "Z:\task_1626098996\build\application\firefox\browser" - 3516 "\\.\pipe\gecko-crash-server-pipe.3516" 4100 1f6f8e99938 tab)
[task 2021-07-12T14:44:10.685Z] 14:44:10 INFO - ==> process 3516 launched child process 6904 ("Z:\task_1626098996\build\application\firefox\firefox.exe" -contentproc --channel="3516.8.1217167678\1231772126" -childID 5 -isForBrowser -prefsHandle 4124 -prefMapHandle 4120 -prefsLen 9905 -prefMapSize 250035 -jsInit 1288 285716 -parentBuildID 20210712124850 -appdir "Z:\task_1626098996\build\application\firefox\browser" - 3516 "\\.\pipe\gecko-crash-server-pipe.3516" 4240 1f6f8e9a138 tab)
[task 2021-07-12T14:44:10.685Z] 14:44:10 INFO - ==> process 3516 launched child process 1916 ("Z:\task_1626098996\build\application\firefox\firefox.exe" -contentproc --channel="3516.12.23628892\2088215332" -childID 6 -isForBrowser -prefsHandle 4724 -prefMapHandle 4720 -prefsLen 10368 -prefMapSize 250035 -jsInit 1288 285716 -parentBuildID 20210712124850 -appdir "Z:\task_1626098996\build\application\firefox\browser" - 3516 "\\.\pipe\gecko-crash-server-pipe.3516" 4384 1f6f6687738 tab)
[task 2021-07-12T14:44:10.686Z] 14:44:10 INFO - ==> process 3516 launched child process 2092 ("Z:\task_1626098996\build\application\firefox\firefox.exe" -contentproc --channel="3516.14.1903635055\1269436304" -childID 7 -isForBrowser -prefsHandle 4644 -prefMapHandle 4876 -prefsLen 10368 -prefMapSize 250035 -jsInit 1288 285716 -parentBuildID 20210712124850 -appdir "Z:\task_1626098996\build\application\firefox\browser" - 3516 "\\.\pipe\gecko-crash-server-pipe.3516" 4732 1f6f6969538 tab)
[task 2021-07-12T14:44:10.686Z] 14:44:10 INFO - zombiecheck | Checking for orphan process with PID: 7360
[task 2021-07-12T14:44:10.687Z] 14:44:10 INFO - zombiecheck | Checking for orphan process with PID: 740
[task 2021-07-12T14:44:10.687Z] 14:44:10 INFO - zombiecheck | Checking for orphan process with PID: 10024
[task 2021-07-12T14:44:10.687Z] 14:44:10 INFO - zombiecheck | Checking for orphan process with PID: 1916
[task 2021-07-12T14:44:10.688Z] 14:44:10 INFO - zombiecheck | Checking for orphan process with PID: 2092
[task 2021-07-12T14:44:10.688Z] 14:44:10 INFO - zombiecheck | Checking for orphan process with PID: 1148
[task 2021-07-12T14:44:10.688Z] 14:44:10 INFO - zombiecheck | Checking for orphan process with PID: 6904
[task 2021-07-12T14:44:10.688Z] 14:44:10 INFO - zombiecheck | Checking for orphan process with PID: 4860
[task 2021-07-12T14:44:10.689Z] 14:44:10 INFO - mozcrash Downloading symbols from: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/TUeHPpuWQAGDZZzBmvQ67A/artifacts/public/build/target.crashreporter-symbols.zip
[task 2021-07-12T14:44:14.538Z] 14:44:14 INFO - mozcrash Copy/paste: Z:/task_1626098996/fetches\minidump_stackwalk\minidump_stackwalk.exe C:\Users\task_1626098996\AppData\Local\Temp\tmpobo_ns7j.mozrunner\minidumps\dce96029-946d-426b-accf-dfd25c7279a0.dmp C:\Users\task_1626098996\AppData\Local\Temp\tmp7gam_nrn
[task 2021-07-12T14:44:18.608Z] 14:44:18 INFO - mozcrash Saved minidump as Z:\task_1626098996\build\blobber_upload_dir\dce96029-946d-426b-accf-dfd25c7279a0.dmp
[task 2021-07-12T14:44:18.652Z] 14:44:18 INFO - PROCESS-CRASH | browser/components/places/tests/browser/interactions/browser_interactions_view_time.js | application crashed [None]
[task 2021-07-12T14:44:18.652Z] 14:44:18 INFO - Crash dump filename: C:\Users\task_1626098996\AppData\Local\Temp\tmpobo_ns7j.mozrunner\minidumps\dce96029-946d-426b-accf-dfd25c7279a0.dmp
[task 2021-07-12T14:44:18.652Z] 14:44:18 INFO - Operating system: Windows NT
[task 2021-07-12T14:44:18.652Z] 14:44:18 INFO - 10.0.17134
[task 2021-07-12T14:44:18.652Z] 14:44:18 INFO - CPU: amd64
[task 2021-07-12T14:44:18.652Z] 14:44:18 INFO - family 6 model 85 stepping 7
[task 2021-07-12T14:44:18.652Z] 14:44:18 INFO - 8 CPUs
[task 2021-07-12T14:44:18.652Z] 14:44:18 INFO -
[task 2021-07-12T14:44:18.652Z] 14:44:18 INFO - GPU: UNKNOWN
[task 2021-07-12T14:44:18.652Z] 14:44:18 INFO -
[task 2021-07-12T14:44:18.652Z] 14:44:18 INFO - No crash
[task 2021-07-12T14:44:18.652Z] 14:44:18 INFO - Process uptime: 380 seconds
[task 2021-07-12T14:44:18.652Z] 14:44:18 INFO -
[task 2021-07-12T14:44:18.652Z] 14:44:18 INFO - Thread 0 - MainThread
[task 2021-07-12T14:44:18.652Z] 14:44:18 INFO - 0 ntdll.dll!NtWaitForAlertByThreadId + 0x14
[task 2021-07-12T14:44:18.652Z] 14:44:18 INFO - rax = 0x00000000000001c8 rdx = 0x0000000000000000
[task 2021-07-12T14:44:18.652Z] 14:44:18 INFO - rcx = 0x000001ac05277060 rbx = 0x0000000000000000
[task 2021-07-12T14:44:18.652Z] 14:44:18 INFO - rsi = 0x0000000000000000 rdi = 0x00000082c09ff401
[task 2021-07-12T14:44:18.652Z] 14:44:18 INFO - rbp = 0x000001ac05277060 rsp = 0x00000082c09feb08
[task 2021-07-12T14:44:18.652Z] 14:44:18 INFO - r8 = 0x0000000000000000 r9 = 0x0000000000000000
[task 2021-07-12T14:44:18.652Z] 14:44:18 INFO - r10 = 0x00000fff8ca6b7fe r11 = 0x4100000000000000
[task 2021-07-12T14:44:18.653Z] 14:44:18 INFO - r12 = 0x0000000000000001 r13 = 0x000001ac0527c0a0
[task 2021-07-12T14:44:18.653Z] 14:44:18 INFO - r14 = 0x000001ac052770f0 r15 = 0x0000000000000000
[task 2021-07-12T14:44:18.653Z] 14:44:18 INFO - rip = 0x00007ffca949d7e4
[task 2021-07-12T14:44:18.653Z] 14:44:18 INFO - Found by: given as instruction pointer in context
[task 2021-07-12T14:44:18.653Z] 14:44:18 INFO - 1 ntdll.dll!RtlSleepConditionVariableSRW + 0x109
[task 2021-07-12T14:44:18.653Z] 14:44:18 INFO - rbx = 0x0000000000000000 rbp = 0x000001ac05277060
[task 2021-07-12T14:44:18.653Z] 14:44:18 INFO - rsp = 0x00000082c09feb10 r12 = 0x0000000000000001
[task 2021-07-12T14:44:18.653Z] 14:44:18 INFO - r13 = 0x000001ac0527c0a0 r14 = 0x000001ac052770f0
[task 2021-07-12T14:44:18.653Z] 14:44:18 INFO - r15 = 0x0000000000000000 rip = 0x00007ffca941ef19
[task 2021-07-12T14:44:18.653Z] 14:44:18 INFO - Found by: call frame info
[task 2021-07-12T14:44:18.653Z] 14:44:18 INFO - 2 KERNELBASE.dll!LdrpLoadDependentModule + 0xe32
[task 2021-07-12T14:44:18.653Z] 14:44:18 INFO - rbx = 0x0000000000000000 rbp = 0x000001ac05277060
[task 2021-07-12T14:44:18.653Z] 14:44:18 INFO - rsp = 0x00000082c09feb80 r12 = 0x0000000000000001
[task 2021-07-12T14:44:18.653Z] 14:44:18 INFO - r13 = 0x000001ac0527c0a0 r14 = 0x000001ac052770f0
[task 2021-07-12T14:44:18.653Z] 14:44:18 INFO - r15 = 0x0000000000000000 rip = 0x00007ffca6642c72
[task 2021-07-12T14:44:18.653Z] 14:44:18 INFO - Found by: call frame info
[task 2021-07-12T14:44:18.653Z] 14:44:18 INFO - 3 0x82c09ff440
[task 2021-07-12T14:44:18.653Z] 14:44:18 INFO - rbx = 0x0000000000000000 rbp = 0x000001ac05277060
[task 2021-07-12T14:44:18.653Z] 14:44:18 INFO - rsp = 0x00000082c09ff130 r12 = 0x0000000000000001
[task 2021-07-12T14:44:18.654Z] 14:44:18 INFO - r13 = 0x000001ac0527c0a0 r14 = 0x000001ac052770f0
[task 2021-07-12T14:44:18.654Z] 14:44:18 INFO - r15 = 0x0000000000000000 rip = 0x00000082c09ff440
[task 2021-07-12T14:44:18.654Z] 14:44:18 INFO - Found by: call frame info
[task 2021-07-12T14:44:18.654Z] 14:44:18 INFO - 4 xul.dll!nsBaseAppShell::Run() [nsBaseAppShell.cpp:5f345b9749ed2ce119eff74d958576486ae7db6c : 137 + 0xd]
[task 2021-07-12T14:44:18.654Z] 14:44:18 INFO - rbp = 0x000001ac05277060 rsp = 0x00000082c09ff150
[task 2021-07-12T14:44:18.654Z] 14:44:18 INFO - rip = 0x00007ffc648fd6f8
[task 2021-07-12T14:44:18.654Z] 14:44:18 INFO - Found by: stack scanning
[task 2021-07-12T14:44:18.654Z] 14:44:18 INFO - 5 xul.dll!nsAppShell::Run() [nsAppShell.cpp:5f345b9749ed2ce119eff74d958576486ae7db6c : 603 + 0x8]
[task 2021-07-12T14:44:18.654Z] 14:44:18 INFO - rbp = 0x000001ac05277060 rsp = 0x00000082c09ff190
[task 2021-07-12T14:44:18.654Z] 14:44:18 INFO - rip = 0x00007ffc648fc53f
[task 2021-07-12T14:44:18.654Z] 14:44:18 INFO - Found by: call frame info
[task 2021-07-12T14:44:18.654Z] 14:44:18 INFO - 6 xul.dll!XRE_RunAppShell() [nsEmbedFunctions.cpp:5f345b9749ed2ce119eff74d958576486ae7db6c : 910 + 0xd]
[task 2021-07-12T14:44:18.654Z] 14:44:18 INFO - rbp = 0x000001ac05277060 rsp = 0x00000082c09ff300
[task 2021-07-12T14:44:18.654Z] 14:44:18 INFO - rip = 0x00007ffc659ed7ab
[task 2021-07-12T14:44:18.654Z] 14:44:18 INFO - Found by: call frame info
[task 2021-07-12T14:44:18.654Z] 14:44:18 INFO - 7 xul.dll!MessageLoop::RunHandler() [message_loop.cc:5f345b9749ed2ce119eff74d958576486ae7db6c : 324 + 0x16]
[task 2021-07-12T14:44:18.654Z] 14:44:18 INFO - rbp = 0x000001ac05277060 rsp = 0x00000082c09ff340
[task 2021-07-12T14:44:18.654Z] 14:44:18 INFO - rip = 0x00007ffc65177d9f
[task 2021-07-12T14:44:18.654Z] 14:44:18 INFO - Found by: call frame info
[task 2021-07-12T14:44:18.654Z] 14:44:18 INFO - 8 xul.dll!MessageLoop::Run() [message_loop.cc:5f345b9749ed2ce119eff74d958576486ae7db6c : 306 + 0x5]
[task 2021-07-12T14:44:18.655Z] 14:44:18 INFO - rbp = 0x000001ac05277060 rsp = 0x00000082c09ff390
[task 2021-07-12T14:44:18.655Z] 14:44:18 INFO - rip = 0x00007ffc64777f6e
[task 2021-07-12T14:44:18.655Z] 14:44:18 INFO - Found by: call frame info
[task 2021-07-12T14:44:18.655Z] 14:44:18 INFO - 9 xul.dll!XRE_InitChildProcess(int, char**, XREChildData const*) [nsEmbedFunctions.cpp:5f345b9749ed2ce119eff74d958576486ae7db6c : 742 + 0xa]
[task 2021-07-12T14:44:18.655Z] 14:44:18 INFO - rbp = 0x000001ac05277060 rsp = 0x00000082c09ff3f0
[task 2021-07-12T14:44:18.655Z] 14:44:18 INFO - rip = 0x00007ffc659ed291
[task 2021-07-12T14:44:18.655Z] 14:44:18 INFO - Found by: call frame info
[task 2021-07-12T14:44:18.655Z] 14:44:18 INFO - 10 firefox.exe!wmain(int, wchar_t**) [nsWindowsWMain.cpp:5f345b9749ed2ce119eff74d958576486ae7db6c : 131 + 0x16f]
[task 2021-07-12T14:44:18.655Z] 14:44:18 INFO - rbp = 0x000001ac05277060 rsp = 0x00000082c09ff640
[task 2021-07-12T14:44:18.655Z] 14:44:18 INFO - rip = 0x00007ff6fe2aa345
[task 2021-07-12T14:44:18.655Z] 14:44:18 INFO - Found by: call frame info
[task 2021-07-12T14:44:18.655Z] 14:44:18 INFO - 11 firefox.exe!__scrt_common_main_seh() [exe_common.inl : 288 + 0x22]
[task 2021-07-12T14:44:18.655Z] 14:44:18 INFO - rbp = 0x000001ac05277060 rsp = 0x00000082c09ff860
[task 2021-07-12T14:44:18.655Z] 14:44:18 INFO - rip = 0x00007ff6fe2bd688
[task 2021-07-12T14:44:18.655Z] 14:44:18 INFO - Found by: call frame info
[task 2021-07-12T14:44:18.655Z] 14:44:18 INFO - 12 kernel32.dll!RtlpLowFragHeapAllocFromContext + 0x204
[task 2021-07-12T14:44:18.655Z] 14:44:18 INFO - rbp = 0x000001ac05277060 rsp = 0x00000082c09ff8a0
[task 2021-07-12T14:44:18.655Z] 14:44:18 INFO - rip = 0x00007ffca9183034
[task 2021-07-12T14:44:18.655Z] 14:44:18 INFO - Found by: call frame info
| Comment hidden (Intermittent Failures Robot) |
|
||
Comment 2•5 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.
Status: NEW → RESOLVED
Closed: 5 years ago
Resolution: --- → INCOMPLETE
You need to log in
before you can comment on or make changes to this bug.
Description
•