1697685 - Intermittent browser/components/search/test/browser/browser_searchbar_context.js | application terminated with exit code 1

Status: RESOLVED FIXED

(Firefox :: Search, defect, P2)

Description

[Treeherder Bug Filer]

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

---

INFO - TEST-START | browser/components/search/test/browser/browser_searchbar_context.js
[task 2021-03-10T19:13:39.957Z] 19:13:39     INFO - GECKO(4540) | [2021-03-10T19:13:39Z WARN  xulstore::persist] tried to remove key that isn't in the store
[task 2021-03-10T19:13:39.957Z] 19:13:39     INFO - GECKO(4540) | [2021-03-10T19:13:39Z WARN  xulstore::persist] tried to remove key that isn't in the store
[task 2021-03-10T19:13:40.002Z] 19:13:40     INFO - GECKO(4540) | [Parent 5960: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 000002365096E800 == 12 [pid = 5960] [id = 29]
[task 2021-03-10T19:13:40.002Z] 19:13:40     INFO - GECKO(4540) | [Parent 5960: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 34 (0000023650968040) [pid = 5960] [serial = 61] [outer = 0000000000000000]
[task 2021-03-10T19:13:40.002Z] 19:13:40     INFO - GECKO(4540) | [Parent 5960: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 35 (0000023659E0AC00) [pid = 5960] [serial = 62] [outer = 0000023650968040]
[task 2021-03-10T19:13:40.012Z] 19:13:40     INFO - GECKO(4540) | [Parent 5960, Main Thread] WARNING: NS_ENSURE_TRUE(uri) failed: file /builds/worker/checkouts/gecko/caps/BasePrincipal.cpp:1327
[task 2021-03-10T19:13:40.012Z] 19:13:40     INFO - GECKO(4540) | [Parent 5960, Main Thread] WARNING: NS_ENSURE_TRUE(rootFrame) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp:4255
[task 2021-03-10T19:13:40.224Z] 19:13:40     INFO - GECKO(4540) | [Parent 5960: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 000002365E43B400 == 13 [pid = 5960] [id = 30]
[task 2021-03-10T19:13:40.224Z] 19:13:40     INFO - GECKO(4540) | [Parent 5960: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 36 (000002365F31D3C0) [pid = 5960] [serial = 63] [outer = 0000000000000000]
[task 2021-03-10T19:13:40.283Z] 19:13:40     INFO - GECKO(4540) | [Child 3464: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 000001989B675800 == 4 [pid = 3464] [id = 32]
[task 2021-03-10T19:13:40.283Z] 19:13:40     INFO - GECKO(4540) | [Child 3464: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 12 (000001989DC0C580) [pid = 3464] [serial = 95] [outer = 0000000000000000]
[task 2021-03-10T19:13:40.283Z] 19:13:40     INFO - GECKO(4540) | [Child 3464: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 13 (000001989DC1DC00) [pid = 3464] [serial = 96] [outer = 000001989DC0C580]
[task 2021-03-10T19:13:40.345Z] 19:13:40     INFO - GECKO(4540) | [Parent 5960, Main Thread] WARNING: NS_ENSURE_TRUE(presShell) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp:4253
[task 2021-03-10T19:13:40.364Z] 19:13:40     INFO - GECKO(4540) | [Parent 5960: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 37 (000002365B01D400) [pid = 5960] [serial = 64] [outer = 000002365F31D3C0]
[task 2021-03-10T19:13:40.485Z] 19:13:40     INFO - GECKO(4540) | [Parent 5960, Main Thread] WARNING: NS_ENSURE_TRUE(mPresShell) failed: file /builds/worker/checkouts/gecko/layout/generic/nsFrameSelection.cpp:1591
[task 2021-03-10T19:13:40.649Z] 19:13:40     INFO - GECKO(4540) | [Child 3464: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 14 (000001989DC27000) [pid = 3464] [serial = 97] [outer = 000001989DC0C580]
[task 2021-03-10T19:13:40.674Z] 19:13:40     INFO - GECKO(4540) | [Child 3464: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 000001989ADB3400 == 3 [pid = 3464] [id = 31] [url = about:blank]
[task 2021-03-10T19:13:40.674Z] 19:13:40     INFO - GECKO(4540) | [Child 3464: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0000019894B9F400 == 2 [pid = 3464] [id = 30] [url = https://example.com/browser/browser/components/search/test/browser/searchTelemetryAd.html?s=searchSuggestionfoo&abc=ff]
[task 2021-03-10T19:13:40.674Z] 19:13:40     INFO - GECKO(4540) | [Child 3464: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 000001989ADA9000 == 1 [pid = 3464] [id = 29] [url = about:blank]
[task 2021-03-10T19:13:40.773Z] 19:13:40     INFO - GECKO(4540) | [Child 3464: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 13 (0000019894B34C80) [pid = 3464] [serial = 84] [outer = 0000000000000000] [url = about:blank]
[task 2021-03-10T19:13:40.773Z] 19:13:40     INFO - GECKO(4540) | [Child 3464: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 12 (0000019894B34740) [pid = 3464] [serial = 93] [outer = 0000000000000000] [url = about:blank]
[task 2021-03-10T19:13:41.055Z] 19:13:41     INFO - GECKO(4540) | [Parent 5960, Main Thread] WARNING: Must complete empty transaction when compositing!: file /builds/worker/checkouts/gecko/layout/base/PresShell.cpp:6315
[task 2021-03-10T19:13:41.055Z] 19:13:41     INFO - GECKO(4540) | FATAL ERROR: Non-local network connections are disabled and a connection attempt to ac.duckduckgo.com (52.250.42.157) was made.
[task 2021-03-10T19:13:41.055Z] 19:13:41     INFO - GECKO(4540) | You should only access hostnames available via the test networking proxy (if running mochitests) or from a test-specific httpd.js server (if running xpcshell tests). Browser services should be disabled or redirected to a local server.
[task 2021-03-10T19:13:41.056Z] 19:13:41     INFO - GECKO(4540) | Hit MOZ_CRASH(Attempting to connect to non-local address!) at /builds/worker/checkouts/gecko/netwerk/base/nsSocketTransport2.cpp:1260
[task 2021-03-10T19:13:41.147Z] 19:13:41     INFO - GECKO(4540) | [Parent 5960, Main Thread] WARNING: '!presContext', file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp:3874
[task 2021-03-10T19:13:41.147Z] 19:13:41     INFO - GECKO(4540) | [GPU 4860, Compositor] WARNING: Possibly dropping task posted to updater thread: file /builds/worker/checkouts/gecko/gfx/layers/apz/src/APZUpdater.cpp:370
[task 2021-03-10T19:13:41.248Z] 19:13:41     INFO -  Initializing stack-fixing for the first stack frame, this may take a while...
[task 2021-03-10T19:13:51.021Z] 19:13:51     INFO - GECKO(4540) | #01: mozilla::net::nsSocketEvent::Run() [netwerk/base/nsSocketTransport2.cpp:95]
[task 2021-03-10T19:13:51.021Z] 19:13:51     INFO - GECKO(4540) | #02: nsThread::ProcessNextEvent(bool, bool*) [xpcom/threads/nsThread.cpp:1152]
[task 2021-03-10T19:13:51.021Z] 19:13:51     INFO - GECKO(4540) | #03: NS_ProcessNextEvent(nsIThread*, bool) [xpcom/threads/nsThreadUtils.cpp:548]
[task 2021-03-10T19:13:51.021Z] 19:13:51     INFO - GECKO(4540) | #04: mozilla::net::nsSocketTransportService::Run() [netwerk/base/nsSocketTransportService2.cpp:1201]
[task 2021-03-10T19:13:51.021Z] 19:13:51     INFO - GECKO(4540) | #05: nsThread::ProcessNextEvent(bool, bool*) [xpcom/threads/nsThread.cpp:1152]
[task 2021-03-10T19:13:51.021Z] 19:13:51     INFO - GECKO(4540) | #06: NS_ProcessNextEvent(nsIThread*, bool) [xpcom/threads/nsThreadUtils.cpp:548]
[task 2021-03-10T19:13:51.022Z] 19:13:51     INFO - GECKO(4540) | #07: mozilla::ipc::MessagePumpForNonMainThreads::Run(base::MessagePump::Delegate*) [ipc/glue/MessagePump.cpp:303]
[task 2021-03-10T19:13:51.022Z] 19:13:51     INFO - GECKO(4540) | #08: MessageLoop::RunHandler() [ipc/chromium/src/base/message_loop.cc:329]
[task 2021-03-10T19:13:51.022Z] 19:13:51     INFO - GECKO(4540) | #09: MessageLoop::Run() [ipc/chromium/src/base/message_loop.cc:311]
[task 2021-03-10T19:13:51.022Z] 19:13:51     INFO - GECKO(4540) | #10: static nsThread::ThreadFunc(void*) [xpcom/threads/nsThread.cpp:393]
[task 2021-03-10T19:13:51.209Z] 19:13:51     INFO - GECKO(4540) | #11: PR_NativeRunThread(void*) [nsprpub/pr/src/threads/combined/pruthr.c:408]
[task 2021-03-10T19:13:51.209Z] 19:13:51     INFO - GECKO(4540) | #12: pr_root(void*) [nsprpub/pr/src/md/windows/w95thred.c:140]
[task 2021-03-10T19:13:51.214Z] 19:13:51     INFO -  fix-stacks: error: failed to read debug info file `ucrtbase.pdb` for `C:\Windows\System32\ucrtbase.dll`
[task 2021-03-10T19:13:51.214Z] 19:13:51     INFO -  fix-stacks: note: this is expected and harmless for all PDB files on opt automation runs
[task 2021-03-10T19:13:51.214Z] 19:13:51     INFO -  fix-stacks: The system cannot find the file specified. (os error 2)
[task 2021-03-10T19:13:51.214Z] 19:13:51     INFO - GECKO(4540) | #13: o_ceil [C:\Windows\System32\ucrtbase.dll + 0x1c4be]
[task 2021-03-10T19:13:51.219Z] 19:13:51     INFO -  fix-stacks: error: failed to read debug info file `wkernel32.pdb` for `C:\Windows\System32\KERNEL32.DLL`
[task 2021-03-10T19:13:51.219Z] 19:13:51     INFO -  fix-stacks: note: this is expected and harmless for all PDB files on opt automation runs
[task 2021-03-10T19:13:51.219Z] 19:13:51     INFO -  fix-stacks: The system cannot find the file specified. (os error 2)
[task 2021-03-10T19:13:51.219Z] 19:13:51     INFO - GECKO(4540) | #14: BaseThreadInitThunk [C:\Windows\System32\KERNEL32.DLL + 0x13034]
[task 2021-03-10T19:13:51.223Z] 19:13:51     INFO -  fix-stacks: error: failed to read debug info file `wntdll.pdb` for `C:\Windows\SYSTEM32\ntdll.dll`
[task 2021-03-10T19:13:51.223Z] 19:13:51     INFO -  fix-stacks: note: this is expected and harmless for all PDB files on opt automation runs
[task 2021-03-10T19:13:51.223Z] 19:13:51     INFO -  fix-stacks: The system cannot find the file specified. (os error 2)
[task 2021-03-10T19:13:51.223Z] 19:13:51     INFO - GECKO(4540) | #15: RtlUserThreadStart [C:\Windows\SYSTEM32\ntdll.dll + 0x71461]
[task 2021-03-10T19:13:51.223Z] 19:13:51     INFO - GECKO(4540) | [2021-03-10T19:13:41Z WARN  xulstore::persist] tried to remove key that isn't in the store
[task 2021-03-10T19:13:51.225Z] 19:13:51     INFO - GECKO(4540) | [2021-03-10T19:13:41Z WARN  xulstore::persist] tried to remove key that isn't in the store
[task 2021-03-10T19:13:51.225Z] 19:13:51     INFO - GECKO(4540) | [GPU 4860, Compositor] WExiting due to channel error.
[task 2021-03-10T19:13:51.225Z] 19:13:51     INFO - GECKO(4540) | ARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:512
[task 2021-03-10T19:13:51.226Z] 19:13:51     INFO - GECKO(4540) | [GPU 4860, ComExiting due to channel error.
[task 2021-03-10T19:13:51.226Z] 19:13:51     INFO - GECKO(4540) | positor] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:512
[task 2021-03-10T19:13:51.226Z] 19:13:51     INFO - GECKO(4540) | [GPU 4860, Main Thread] WARNING: Shutting down GPU process early due to a crash!: file /builds/worker/checkouts/gecko/gfx/ipc/GPUParent.cpp:595
[task 2021-03-10T19:13:51.226Z] 19:13:51     INFO - GECKO(4540) | Exiting due to channel error.
[task 2021-03-10T19:13:51.257Z] 19:13:51     INFO - TEST-INFO | Main app process: exit 1
[task 2021-03-10T19:13:51.258Z] 19:13:51    ERROR - TEST-UNEXPECTED-FAIL | ShutdownLeaks | process() called before end of test suite
[task 2021-03-10T19:13:51.258Z] 19:13:51     INFO - TEST-INFO | Confirming we saw 179 DOCSHELL created and 158 destroyed log strings.
[task 2021-03-10T19:13:51.259Z] 19:13:51     INFO - TEST-INFO | Confirming we saw 508 DOMWINDOW created and 443 destroyed log strings.
[task 2021-03-10T19:13:51.259Z] 19:13:51     INFO - Buffered messages logged at 19:13:39
[task 2021-03-10T19:13:51.260Z] 19:13:51     INFO - Entering test bound setup
[task 2021-03-10T19:13:51.260Z] 19:13:51     INFO - Buffered messages logged at 19:13:40
[task 2021-03-10T19:13:51.260Z] 19:13:51     INFO - Leaving test bound setup
[task 2021-03-10T19:13:51.261Z] 19:13:51     INFO - Entering test bound test_emptybar
[task 2021-03-10T19:13:51.261Z] 19:13:51     INFO - TEST-PASS | browser/components/search/test/browser/browser_searchbar_context.js | Should have disabled the cut menuitem - true == true - 
[task 2021-03-10T19:13:51.262Z] 19:13:51     INFO - TEST-PASS | browser/components/search/test/browser/browser_searchbar_context.js | Should have disabled the copy menuitem - true == true - 
[task 2021-03-10T19:13:51.262Z] 19:13:51     INFO - TEST-PASS | browser/components/search/test/browser/browser_searchbar_context.js | Should have disabled the delete menuitem - true == true - 
[task 2021-03-10T19:13:51.262Z] 19:13:51     INFO - Leaving test bound test_emptybar
[task 2021-03-10T19:13:51.263Z] 19:13:51     INFO - Entering test bound test_text_in_bar
[task 2021-03-10T19:13:51.263Z] 19:13:51     INFO - TEST-PASS | browser/components/search/test/browser/browser_searchbar_context.js | Should have enabled the cut menuitem - true == true - 
[task 2021-03-10T19:13:51.264Z] 19:13:51     INFO - TEST-PASS | browser/components/search/test/browser/browser_searchbar_context.js | Should have enabled the copy menuitem - true == true - 
[task 2021-03-10T19:13:51.264Z] 19:13:51     INFO - TEST-PASS | browser/components/search/test/browser/browser_searchbar_context.js | Should have enabled the delete menuitem - true == true - 
[task 2021-03-10T19:13:51.264Z] 19:13:51     INFO - Leaving test bound test_text_in_bar
[task 2021-03-10T19:13:51.265Z] 19:13:51     INFO - Entering test bound test_unfocused_emptybar
[task 2021-03-10T19:13:51.265Z] 19:13:51     INFO - TEST-PASS | browser/components/search/test/browser/browser_searchbar_context.js | Should have disabled the cut menuitem - true == true - 
[task 2021-03-10T19:13:51.266Z] 19:13:51     INFO - TEST-PASS | browser/components/search/test/browser/browser_searchbar_context.js | Should have disabled the copy menuitem - true == true - 
[task 2021-03-10T19:13:51.266Z] 19:13:51     INFO - TEST-PASS | browser/components/search/test/browser/browser_searchbar_context.js | Should have disabled the delete menuitem - true == true - 
[task 2021-03-10T19:13:51.266Z] 19:13:51     INFO - Leaving test bound test_unfocused_emptybar
[task 2021-03-10T19:13:51.266Z] 19:13:51     INFO - Entering test bound test_text_in_unfocused_bar
[task 2021-03-10T19:13:51.266Z] 19:13:51     INFO - Buffered messages logged at 19:13:41
[task 2021-03-10T19:13:51.266Z] 19:13:51     INFO - TEST-PASS | browser/components/search/test/browser/browser_searchbar_context.js | Should have enabled the cut menuitem - true == true - 
[task 2021-03-10T19:13:51.266Z] 19:13:51     INFO - TEST-PASS | browser/components/search/test/browser/browser_searchbar_context.js | Should have enabled the copy menuitem - true == true - 
[task 2021-03-10T19:13:51.266Z] 19:13:51     INFO - TEST-PASS | browser/components/search/test/browser/browser_searchbar_context.js | Should have enabled the delete menuitem - true == true - 
[task 2021-03-10T19:13:51.266Z] 19:13:51     INFO - Leaving test bound test_text_in_unfocused_bar
[task 2021-03-10T19:13:51.266Z] 19:13:51     INFO - Buffered messages finished
[task 2021-03-10T19:13:51.266Z] 19:13:51    ERROR - TEST-UNEXPECTED-FAIL | browser/components/search/test/browser/browser_searchbar_context.js | application terminated with exit code 1
[task 2021-03-10T19:13:51.266Z] 19:13:51     INFO - runtests.py | Application ran for: 0:02:19.119000
[task 2021-03-10T19:13:51.266Z] 19:13:51     INFO - zombiecheck | Reading PID log: c:\users\task_1615401472\appdata\local\temp\tmpjm3m3xpidlog
[task 2021-03-10T19:13:51.266Z] 19:13:51     INFO - ==> process 5960 launched child process 4860 ("Z:\task_1615401472\build\application\firefox\firefox.exe" -contentproc --channel="5960.0.2019659172\1295263291" -parentBuildID 20210310183704 -prefsHandle 2216 -prefMapHandle 2192 -prefsLen 1 -prefMapSize 245405 -appdir "Z:\task_1615401472\build\application\firefox\browser" - 5960 "\\.\pipe\gecko-crash-server-pipe.5960" 2272 gpu)
[task 2021-03-10T19:13:51.266Z] 19:13:51     INFO - ==> process 5960 launched child process 3464 ("Z:\task_1615401472\build\application\firefox\firefox.exe" -contentproc --channel="5960.6.88798490\780327191" -childID 1 -isForBrowser -prefsHandle 2952 -prefMapHandle 2948 -prefsLen 1725 -prefMapSize 245405 -parentBuildID 20210310183704 -appdir "Z:\task_1615401472\build\application\firefox\browser" - 5960 "\\.\pipe\gecko-crash-server-pipe.5960" 2964 tab)
[task 2021-03-10T19:13:51.267Z] 19:13:51     INFO - ==> process 5960 launched child process 1700 ("Z:\task_1615401472\build\application\firefox\firefox.exe" -contentproc --channel="5960.13.321197458\1618741644" -childID 2 -isForBrowser -prefsHandle 3252 -prefMapHandle 3244 -prefsLen 1831 -prefMapSize 245405 -parentBuildID 20210310183704 -appdir "Z:\task_1615401472\build\application\firefox\browser" - 5960 "\\.\pipe\gecko-crash-server-pipe.5960" 3288 tab)
[task 2021-03-10T19:13:51.267Z] 19:13:51     INFO - ==> process 5960 launched child process 4760 ("Z:\task_1615401472\build\application\firefox\firefox.exe" -contentproc --channel="5960.20.1466322521\1523166532" -childID 3 -isForBrowser -prefsHandle 3440 -prefMapHandle 3432 -prefsLen 1871 -prefMapSize 245405 -parentBuildID 20210310183704 -appdir "Z:\task_1615401472\build\application\firefox\browser" - 5960 "\\.\pipe\gecko-crash-server-pipe.5960" 3428 tab)
[task 2021-03-10T19:13:51.267Z] 19:13:51     INFO - ==> process 5960 launched child process 6680 ("Z:\task_1615401472\build\application\firefox\firefox.exe" -contentproc --channel="5960.27.1579423005\2054537530" -childID 4 -isForBrowser -prefsHandle 4136 -prefMapHandle 2940 -prefsLen 9011 -prefMapSize 245405 -parentBuildID 20210310183704 -appdir "Z:\task_1615401472\build\application\firefox\browser" - 5960 "\\.\pipe\gecko-crash-server-pipe.5960" 4264 tab)
[task 2021-03-10T19:13:51.267Z] 19:13:51     INFO - ==> process 5960 launched child process 2364 ("Z:\task_1615401472\build\application\firefox\firefox.exe" -contentproc --channel="5960.34.30881663\1528859858" -childID 5 -isForBrowser -prefsHandle 4844 -prefMapHandle 4836 -prefsLen 10269 -prefMapSize 245405 -parentBuildID 20210310183704 -appdir "Z:\task_1615401472\build\application\firefox\browser" - 5960 "\\.\pipe\gecko-crash-server-pipe.5960" 4748 tab)
[task 2021-03-10T19:13:51.267Z] 19:13:51     INFO - ==> process 5960 launched child process 1140 ("Z:\task_1615401472\build\application\firefox\firefox.exe" -contentproc --channel="5960.41.1580350749\595976669" -childID 6 -isForBrowser -prefsHandle 5180 -prefMapHandle 5164 -prefsLen 10510 -prefMapSize 245405 -parentBuildID 20210310183704 -appdir "Z:\task_1615401472\build\application\firefox\browser" - 5960 "\\.\pipe\gecko-crash-server-pipe.5960" 5184 tab)
[task 2021-03-10T19:13:51.267Z] 19:13:51     INFO - ==> process 5960 launched child process 5588 ("Z:\task_1615401472\build\application\firefox\firefox.exe" -contentproc --channel="5960.48.378774434\452170445" -childID 7 -isForBrowser -prefsHandle 5392 -prefMapHandle 5388 -prefsLen 10510 -prefMapSize 245405 -parentBuildID 20210310183704 -appdir "Z:\task_1615401472\build\application\firefox\browser" - 5960 "\\.\pipe\gecko-crash-server-pipe.5960" 5416 tab)
[task 2021-03-10T19:13:51.267Z] 19:13:51     INFO - ==> process 5960 launched child process 6244 ("Z:\task_1615401472\build\application\firefox\firefox.exe" -contentproc --channel="5960.55.299153891\336926100" -childID 8 -isForBrowser -prefsHandle 5636 -prefMapHandle 5584 -prefsLen 10510 -prefMapSize 245405 -parentBuildID 20210310183704 -appdir "Z:\task_1615401472\build\application\firefox\browser" - 5960 "\\.\pipe\gecko-crash-server-pipe.5960" 5648 tab)
[task 2021-03-10T19:13:51.267Z] 19:13:51     INFO - zombiecheck | Checking for orphan process with PID: 6244
[task 2021-03-10T19:13:51.267Z] 19:13:51     INFO - zombiecheck | Checking for orphan process with PID: 1700
[task 2021-03-10T19:13:51.268Z] 19:13:51     INFO - zombiecheck | Checking for orphan process with PID: 3464
[task 2021-03-10T19:13:51.268Z] 19:13:51     INFO - zombiecheck | Checking for orphan process with PID: 2364
[task 2021-03-10T19:13:51.268Z] 19:13:51     INFO - zombiecheck | Checking for orphan process with PID: 6680
[task 2021-03-10T19:13:51.268Z] 19:13:51     INFO - zombiecheck | Checking for orphan process with PID: 1140
[task 2021-03-10T19:13:51.268Z] 19:13:51     INFO - zombiecheck | Checking for orphan process with PID: 4760
[task 2021-03-10T19:13:51.268Z] 19:13:51     INFO - zombiecheck | Checking for orphan process with PID: 5588
[task 2021-03-10T19:13:51.268Z] 19:13:51     INFO - zombiecheck | Checking for orphan process with PID: 4860
[task 2021-03-10T19:13:51.268Z] 19:13:51     INFO - mozcrash Copy/paste: Z:/task_1615401472/fetches\minidump_stackwalk\minidump_stackwalk.exe c:\users\task_1615401472\appdata\local\temp\tmpqefy0c.mozrunner\minidumps\b78d6550-47d3-49ad-8e9d-e8021bb80c0c.dmp Z:\task_1615401472\build\symbols
[task 2021-03-10T19:13:57.719Z] 19:13:57     INFO - mozcrash Saved minidump as Z:\task_1615401472\build\blobber_upload_dir\b78d6550-47d3-49ad-8e9d-e8021bb80c0c.dmp
[task 2021-03-10T19:13:57.719Z] 19:13:57     INFO - mozcrash Saved app info as Z:\task_1615401472\build\blobber_upload_dir\b78d6550-47d3-49ad-8e9d-e8021bb80c0c.extra
[task 2021-03-10T19:13:57.783Z] 19:13:57     INFO - PROCESS-CRASH | browser/components/search/test/browser/browser_searchbar_context.js | application crashed [@ mozilla::net::nsSocketTransport::InitiateSocket()]
[task 2021-03-10T19:13:57.783Z] 19:13:57     INFO - Mozilla crash reason: MOZ_CRASH(Attempting to connect to non-local address!)
[task 2021-03-10T19:13:57.783Z] 19:13:57     INFO - Crash dump filename: c:\users\task_1615401472\appdata\local\temp\tmpqefy0c.mozrunner\minidumps\b78d6550-47d3-49ad-8e9d-e8021bb80c0c.dmp
[task 2021-03-10T19:13:57.783Z] 19:13:57     INFO - Operating system: Windows NT
[task 2021-03-10T19:13:57.783Z] 19:13:57     INFO -                   10.0.17134 
[task 2021-03-10T19:13:57.783Z] 19:13:57     INFO - CPU: amd64
[task 2021-03-10T19:13:57.783Z] 19:13:57     INFO -      family 6 model 85 stepping 4
[task 2021-03-10T19:13:57.783Z] 19:13:57     INFO -      8 CPUs
[task 2021-03-10T19:13:57.783Z] 19:13:57     INFO - 
[task 2021-03-10T19:13:57.783Z] 19:13:57     INFO - GPU: UNKNOWN
[task 2021-03-10T19:13:57.783Z] 19:13:57     INFO - 
[task 2021-03-10T19:13:57.783Z] 19:13:57     INFO - Crash reason:  EXCEPTION_BREAKPOINT
[task 2021-03-10T19:13:57.783Z] 19:13:57     INFO - Crash address: 0x4c6ffd3d
[task 2021-03-10T19:13:57.783Z] 19:13:57     INFO - Process uptime: 129 seconds
[task 2021-03-10T19:13:57.784Z] 19:13:57     INFO - 
[task 2021-03-10T19:13:57.784Z] 19:13:57     INFO - Thread 5 (crashed)
[task 2021-03-10T19:13:57.784Z] 19:13:57     INFO -  0  xul.dll!mozilla::net::nsSocketTransport::InitiateSocket() [nsSocketTransport2.cpp:0bf029eb5afa61036d619a1ec6a5cce42995bed1 : 1260 + 0x0]
[task 2021-03-10T19:13:57.784Z] 19:13:57     INFO -     rax = 0x00007ff85540c194   rdx = 0x00007ff89235a640
[task 2021-03-10T19:13:57.784Z] 19:13:57     INFO -     rcx = 0x00007ff8872a1838   rbx = 0x0000023663545280
[task 2021-03-10T19:13:57.784Z] 19:13:57     INFO -     rsi = 0x000002365252d128   rdi = 0x0000005eb07de974
[task 2021-03-10T19:13:57.784Z] 19:13:57     INFO -     rbp = 0x000002365ea13120   rsp = 0x0000005eb07de710
[task 2021-03-10T19:13:57.784Z] 19:13:57     INFO -      r8 = 0x0000005eb07d8758    r9 = 0x0000000000000000
[task 2021-03-10T19:13:57.784Z] 19:13:57     INFO -     r10 = 0x0000000000000000   r11 = 0x0000005eb07d9da0
[task 2021-03-10T19:13:57.784Z] 19:13:57     INFO -     r12 = 0x0000000080004004   r13 = 0x0000005eb07ded4f
[task 2021-03-10T19:13:57.784Z] 19:13:57     INFO -     r14 = 0x00000000552bc100   r15 = 0xaaaaaaaaaaaaaaaa
[task 2021-03-10T19:13:57.784Z] 19:13:57     INFO -     rip = 0x00007ff84c6ffd3d
[task 2021-03-10T19:13:57.784Z] 19:13:57     INFO -     Found by: given as instruction pointer in context
[task 2021-03-10T19:13:57.784Z] 19:13:57     INFO -  1  xul.dll!mozilla::net::nsSocketTransport::OnSocketEvent(unsigned int, nsresult, nsISupports*) [nsSocketTransport2.cpp:0bf029eb5afa61036d619a1ec6a5cce42995bed1 : 2004 + 0x15]
[task 2021-03-10T19:13:57.784Z] 19:13:57     INFO -     rbx = 0x0000023663545280   rbp = 0x000002365ea13120
[task 2021-03-10T19:13:57.784Z] 19:13:57     INFO -     rsp = 0x0000005eb07deaa0   r12 = 0x0000000080004004
[task 2021-03-10T19:13:57.784Z] 19:13:57     INFO -     r13 = 0x0000005eb07ded4f   r14 = 0x00000000552bc100
[task 2021-03-10T19:13:57.784Z] 19:13:57     INFO -     r15 = 0xaaaaaaaaaaaaaaaa   rip = 0x00007ff84c701670
[task 2021-03-10T19:13:57.784Z] 19:13:57     INFO -     Found by: call frame info
[task 2021-03-10T19:13:57.784Z] 19:13:57     INFO -  2  xul.dll!mozilla::net::nsSocketEvent::Run() [nsSocketTransport2.cpp:0bf029eb5afa61036d619a1ec6a5cce42995bed1 : 94 + 0xc]
[task 2021-03-10T19:13:57.784Z] 19:13:57     INFO -     rbx = 0x0000023663545280   rbp = 0x000002365ea13120
[task 2021-03-10T19:13:57.784Z] 19:13:57     INFO -     rsp = 0x0000005eb07deb00   r12 = 0x0000000080004004
[task 2021-03-10T19:13:57.784Z] 19:13:57     INFO -     r13 = 0x0000005eb07ded4f   r14 = 0x00000000552bc100
[task 2021-03-10T19:13:57.784Z] 19:13:57     INFO -     r15 = 0xaaaaaaaaaaaaaaaa   rip = 0x00007ff84c721050
[task 2021-03-10T19:13:57.784Z] 19:13:57     INFO -     Found by: call frame info
[task 2021-03-10T19:13:57.784Z] 19:13:57     INFO -  3  xul.dll!nsThread::ProcessNextEvent(bool, bool*) [nsThread.cpp:0bf029eb5afa61036d619a1ec6a5cce42995bed1 : 1152 + 0xd]
[task 2021-03-10T19:13:57.785Z] 19:13:57     INFO -     rbx = 0x0000023663545280   rbp = 0x000002365ea13120
[task 2021-03-10T19:13:57.785Z] 19:13:57     INFO -     rsp = 0x0000005eb07deb30   r12 = 0x0000000080004004
[task 2021-03-10T19:13:57.785Z] 19:13:57     INFO -     r13 = 0x0000005eb07ded4f   r14 = 0x00000000552bc100
[task 2021-03-10T19:13:57.785Z] 19:13:57     INFO -     r15 = 0xaaaaaaaaaaaaaaaa   rip = 0x00007ff84c51dc35
[task 2021-03-10T19:13:57.785Z] 19:13:57     INFO -     Found by: call frame info
[task 2021-03-10T19:13:57.785Z] 19:13:57     INFO -  4  xul.dll!NS_ProcessNextEvent(nsIThread*, bool) [nsThreadUtils.cpp:0bf029eb5afa61036d619a1ec6a5cce42995bed1 : 548 + 0x14]
[task 2021-03-10T19:13:57.785Z] 19:13:57     INFO -     rbx = 0x0000023663545280   rbp = 0x000002365ea13120
[task 2021-03-10T19:13:57.785Z] 19:13:57     INFO -     rsp = 0x0000005eb07ded20   r12 = 0x0000000080004004
[task 2021-03-10T19:13:57.785Z] 19:13:57     INFO -     r13 = 0x0000005eb07ded4f   r14 = 0x00000000552bc100
[task 2021-03-10T19:13:57.785Z] 19:13:57     INFO -     r15 = 0xaaaaaaaaaaaaaaaa   rip = 0x00007ff84c525452
[task 2021-03-10T19:13:57.785Z] 19:13:57     INFO -     Found by: call frame info
[task 2021-03-10T19:13:57.785Z] 19:13:57     INFO -  5  xul.dll!mozilla::net::nsSocketTransportService::Run() [nsSocketTransportService2.cpp:0bf029eb5afa61036d619a1ec6a5cce42995bed1 : 1200 + 0xb]
[task 2021-03-10T19:13:57.785Z] 19:13:57     INFO -     rbx = 0x0000023663545280   rbp = 0x000002365ea13120
[task 2021-03-10T19:13:57.785Z] 19:13:57     INFO -     rsp = 0x0000005eb07ded70   r12 = 0x0000000080004004
[task 2021-03-10T19:13:57.785Z] 19:13:57     INFO -     r13 = 0x0000005eb07ded4f   r14 = 0x00000000552bc100
[task 2021-03-10T19:13:57.785Z] 19:13:57     INFO -     r15 = 0xaaaaaaaaaaaaaaaa   rip = 0x00007ff84c70a54d
[task 2021-03-10T19:13:57.785Z] 19:13:57     INFO -     Found by: call frame info
[task 2021-03-10T19:13:57.785Z] 19:13:57     INFO -  6  xul.dll!nsThread::ProcessNextEvent(bool, bool*) [nsThread.cpp:0bf029eb5afa61036d619a1ec6a5cce42995bed1 : 1152 + 0xd]
[task 2021-03-10T19:13:57.785Z] 19:13:57     INFO -     rbx = 0x0000023663545280   rbp = 0x000002365ea13120
[task 2021-03-10T19:13:57.785Z] 19:13:57     INFO -     rsp = 0x0000005eb07df160   r12 = 0x0000000080004004
[task 2021-03-10T19:13:57.785Z] 19:13:57     INFO -     r13 = 0x0000005eb07ded4f   r14 = 0x00000000552bc100
[task 2021-03-10T19:13:57.785Z] 19:13:57     INFO -     r15 = 0xaaaaaaaaaaaaaaaa   rip = 0x00007ff84c51dc35
[task 2021-03-10T19:13:57.785Z] 19:13:57     INFO -     Found by: call frame info
[task 2021-03-10T19:13:57.785Z] 19:13:57     INFO -  7  xul.dll!NS_ProcessNextEvent(nsIThread*, bool) [nsThreadUtils.cpp:0bf029eb5afa61036d619a1ec6a5cce42995bed1 : 548 + 0x14]
[task 2021-03-10T19:13:57.786Z] 19:13:57     INFO -     rbx = 0x0000023663545280   rbp = 0x000002365ea13120
[task 2021-03-10T19:13:57.786Z] 19:13:57     INFO -     rsp = 0x0000005eb07df350   r12 = 0x0000000080004004
[task 2021-03-10T19:13:57.786Z] 19:13:57     INFO -     r13 = 0x0000005eb07ded4f   r14 = 0x00000000552bc100
[task 2021-03-10T19:13:57.786Z] 19:13:57     INFO -     r15 = 0xaaaaaaaaaaaaaaaa   rip = 0x00007ff84c525452
[task 2021-03-10T19:13:57.786Z] 19:13:57     INFO -     Found by: call frame info
[task 2021-03-10T19:13:57.786Z] 19:13:57     INFO -  8  xul.dll!mozilla::ipc::MessagePumpForNonMainThreads::Run(base::MessagePump::Delegate*) [MessagePump.cpp:0bf029eb5afa61036d619a1ec6a5cce42995bed1 : 302 + 0xa]
[task 2021-03-10T19:13:57.786Z] 19:13:57     INFO -     rbx = 0x0000023663545280   rbp = 0x000002365ea13120
[task 2021-03-10T19:13:57.786Z] 19:13:57     INFO -     rsp = 0x0000005eb07df3a0   r12 = 0x0000000080004004
[task 2021-03-10T19:13:57.786Z] 19:13:57     INFO -     r13 = 0x0000005eb07ded4f   r14 = 0x00000000552bc100
[task 2021-03-10T19:13:57.786Z] 19:13:57     INFO -     r15 = 0xaaaaaaaaaaaaaaaa   rip = 0x00007ff84ce10c87
[task 2021-03-10T19:13:57.786Z] 19:13:57     INFO -     Found by: call frame info
[task 2021-03-10T19:13:57.786Z] 19:13:57     INFO -  9  xul.dll!MessageLoop::RunHandler() [message_loop.cc:0bf029eb5afa61036d619a1ec6a5cce42995bed1 : 328 + 0x8]
[task 2021-03-10T19:13:57.786Z] 19:13:57     INFO -     rbx = 0x0000023663545280   rbp = 0x000002365ea13120
[task 2021-03-10T19:13:57.786Z] 19:13:57     INFO -     rsp = 0x0000005eb07df410   r12 = 0x0000000080004004
[task 2021-03-10T19:13:57.786Z] 19:13:57     INFO -     r13 = 0x0000005eb07ded4f   r14 = 0x00000000552bc100
[task 2021-03-10T19:13:57.786Z] 19:13:57     INFO -     r15 = 0xaaaaaaaaaaaaaaaa   rip = 0x00007ff84cda8510
[task 2021-03-10T19:13:57.786Z] 19:13:57     INFO -     Found by: call frame info
[task 2021-03-10T19:13:57.786Z] 19:13:57     INFO - 10  xul.dll!MessageLoop::Run() [message_loop.cc:0bf029eb5afa61036d619a1ec6a5cce42995bed1 : 310 + 0x5]
[task 2021-03-10T19:13:57.786Z] 19:13:57     INFO -     rbx = 0x0000023663545280   rbp = 0x000002365ea13120
[task 2021-03-10T19:13:57.786Z] 19:13:57     INFO -     rsp = 0x0000005eb07df460   r12 = 0x0000000080004004
[task 2021-03-10T19:13:57.786Z] 19:13:57     INFO -     r13 = 0x0000005eb07ded4f   r14 = 0x00000000552bc100
[task 2021-03-10T19:13:57.786Z] 19:13:57     INFO -     r15 = 0xaaaaaaaaaaaaaaaa   rip = 0x00007ff84cda83d2
[task 2021-03-10T19:13:57.787Z] 19:13:57     INFO -     Found by: call frame info
[task 2021-03-10T19:13:57.787Z] 19:13:57     INFO - 11  xul.dll!static nsThread::ThreadFunc(void*) [nsThread.cpp:0bf029eb5afa61036d619a1ec6a5cce42995bed1 : 391 + 0x8]
[task 2021-03-10T19:13:57.787Z] 19:13:57     INFO -     rbx = 0x0000023663545280   rbp = 0x000002365ea13120
[task 2021-03-10T19:13:57.787Z] 19:13:57     INFO -     rsp = 0x0000005eb07df4b0   r12 = 0x0000000080004004
[task 2021-03-10T19:13:57.787Z] 19:13:57     INFO -     r13 = 0x0000005eb07ded4f   r14 = 0x00000000552bc100
[task 2021-03-10T19:13:57.787Z] 19:13:57     INFO -     r15 = 0xaaaaaaaaaaaaaaaa   rip = 0x00007ff84c51a0a4
[task 2021-03-10T19:13:57.787Z] 19:13:57     INFO -     Found by: call frame info
[task 2021-03-10T19:13:57.787Z] 19:13:57     INFO - 12  nss3.dll!PR_NativeRunThread(void*) [pruthr.c:0bf029eb5afa61036d619a1ec6a5cce42995bed1 : 399 + 0xe]
[task 2021-03-10T19:13:57.787Z] 19:13:57     INFO -     rbx = 0x0000023663545280   rbp = 0x000002365ea13120
[task 2021-03-10T19:13:57.787Z] 19:13:57     INFO -     rsp = 0x0000005eb07df690   r12 = 0x0000000080004004
[task 2021-03-10T19:13:57.787Z] 19:13:57     INFO -     r13 = 0x0000005eb07ded4f   r14 = 0x00000000552bc100
[task 2021-03-10T19:13:57.788Z] 19:13:57     INFO -     r15 = 0xaaaaaaaaaaaaaaaa   rip = 0x00007ff886d10342
[task 2021-03-10T19:13:57.788Z] 19:13:57     INFO -     Found by: call frame info
[task 2021-03-10T19:13:57.788Z] 19:13:57     INFO - 13  nss3.dll!pr_root(void*) [w95thred.c:0bf029eb5afa61036d619a1ec6a5cce42995bed1 : 139 + 0xd]
[task 2021-03-10T19:13:57.788Z] 19:13:57     INFO -     rbx = 0x0000023663545280   rbp = 0x000002365ea13120
[task 2021-03-10T19:13:57.788Z] 19:13:57     INFO -     rsp = 0x0000005eb07df710   r12 = 0x0000000080004004
[task 2021-03-10T19:13:57.788Z] 19:13:57     INFO -     r13 = 0x0000005eb07ded4f   r14 = 0x00000000552bc100
[task 2021-03-10T19:13:57.788Z] 19:13:57     INFO -     r15 = 0xaaaaaaaaaaaaaaaa   rip = 0x00007ff886d00ce1
[task 2021-03-10T19:13:57.788Z] 19:13:57     INFO -     Found by: call frame info
[task 2021-03-10T19:13:57.788Z] 19:13:57     INFO - 14  ucrtbase.dll!thread_start<unsigned int (__cdecl*)(void * __ptr64)> + 0x3e
[task 2021-03-10T19:13:57.788Z] 19:13:57     INFO -     rbx = 0x0000023663545280   rbp = 0x000002365ea13120
[task 2021-03-10T19:13:57.788Z] 19:13:57     INFO -     rsp = 0x0000005eb07df740   r12 = 0x0000000080004004
[task 2021-03-10T19:13:57.788Z] 19:13:57     INFO -     r13 = 0x0000005eb07ded4f   r14 = 0x00000000552bc100
[task 2021-03-10T19:13:57.788Z] 19:13:57     INFO -     r15 = 0xaaaaaaaaaaaaaaaa   rip = 0x00007ff89228c4be
[task 2021-03-10T19:13:57.788Z] 19:13:57     INFO -     Found by: call frame info
[task 2021-03-10T19:13:57.788Z] 19:13:57     INFO - 15  kernel32.dll!_acrt_initialize_fma3 + 0x64
[task 2021-03-10T19:13:57.788Z] 19:13:57     INFO -     rbx = 0x0000023663545280   rbp = 0x000002365ea13120
[task 2021-03-10T19:13:57.788Z] 19:13:57     INFO -     rsp = 0x0000005eb07df770   r12 = 0x0000000080004004
[task 2021-03-10T19:13:57.788Z] 19:13:57     INFO -     r13 = 0x0000005eb07ded4f   r14 = 0x00000000552bc100
[task 2021-03-10T19:13:57.788Z] 19:13:57     INFO -     r15 = 0xaaaaaaaaaaaaaaaa   rip = 0x00007ff8928a3034
[task 2021-03-10T19:13:57.788Z] 19:13:57     INFO -     Found by: call frame info
[task 2021-03-10T19:13:57.788Z] 19:13:57     INFO - 
[task 2021-03-10T19:13:57.788Z] 19:13:57     INFO - Thread 0```

Comment 1

[Intermittent Failures Robot]

18 failures in 1036 pushes (0.017 failures/push) were associated with this bug yesterday.

Repository breakdown:

• autoland: 17
• mozilla-central: 1

Platform and build breakdown:

• windows10-64-qr: 3
  • debug: 3
• macosx1014-64-qr: 14
  • debug: 14
• windows7-32: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1697685&startday=2021-03-10&endday=2021-03-10&tree=all

Comment 2

[Mark Banner (:standard8)]

I'd removed the search engine setup from this test in bug 1696027, but missed that we could hit a search engine with suggestions.

I think the simplest thing here is to turn off suggestions for this test - they're not needed.

Comment 4

[Mark Banner (:standard8)]

Attachment: Bug 1697685 - Turn off search suggestions for browser_searchbar_context.js so that the test doesn't hit the network. r?daleharvey!

Comment 5

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

Set release status flags based on info from the regressing bug 1696027

Comment 6

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/0c7809e97889
Turn off search suggestions for browser_searchbar_context.js so that the test doesn't hit the network. r=daleharvey

Comment 7

[Cristian Brindusan [:cbrindusan]]

https://hg.mozilla.org/mozilla-central/rev/0c7809e97889

Comment 8

[Intermittent Failures Robot]

42 failures in 4622 pushes (0.009 failures/push) were associated with this bug in the last 7 days.

This is the #33 most frequent failure this week.

** This failure happened more than 30 times this week! Resolving this bug is a high priority. **

** Try to resolve this bug as soon as possible. If unresolved for 2 weeks, the affected test(s) may be disabled. **

Repository breakdown:

• autoland: 40
• mozilla-central: 1
• try: 1

Platform and build breakdown:

• windows10-64-qr: 8
  • debug: 8
• macosx1014-64-qr: 26
  • debug: 25
  • opt: 1
• windows7-32: 1
  • debug: 1
• linux1804-64-tsan: 5
  • opt: 5
• linux1804-64: 1
  • debug: 1
• windows10-64: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1697685&startday=2021-03-08&endday=2021-03-14&tree=all