1647954 - Intermittent toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | test_alternate_cached_data - [test_alternate_cached_data : 392] message queue is empty - "[\\"onHeadersReceived\\"]" == "[]" After xpcshell return code: 0

Status: RESOLVED FIXED

(WebExtensions :: General, defect, P5)

Description

[Treeherder Bug Filer]

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

---

INFO -  TEST-START | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js
[task 2020-06-24T01:39:12.070Z] 01:39:12  WARNING -  TEST-UNEXPECTED-FAIL | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | xpcshell return code: 0
[task 2020-06-24T01:39:12.070Z] 01:39:12     INFO -  TEST-INFO took 3954ms
[task 2020-06-24T01:39:12.071Z] 01:39:12     INFO -  >>>>>>>
[task 2020-06-24T01:39:12.071Z] 01:39:12     INFO -  PID 3204 | [3204, Main Thread] WARNING: Failed to get directory to cache.: file /builds/worker/checkouts/gecko/security/sandbox/win/src/sandboxbroker/sandboxBroker.cpp, line 84
[task 2020-06-24T01:39:12.071Z] 01:39:12     INFO -  PID 3204 | [3204, Main Thread] WARNING: Failed to get directory to cache.: file /builds/worker/checkouts/gecko/security/sandbox/win/src/sandboxbroker/sandboxBroker.cpp, line 84
[task 2020-06-24T01:39:12.072Z] 01:39:12     INFO -  PID 3204 | [3204, Main Thread] WARNING: Failed to get directory to cache.: file /builds/worker/checkouts/gecko/security/sandbox/win/src/sandboxbroker/sandboxBroker.cpp, line 84
[task 2020-06-24T01:39:12.072Z] 01:39:12     INFO -  PID 3204 | [3204, Main Thread] WARNING: Failed to get directory to cache.: file /builds/worker/checkouts/gecko/security/sandbox/win/src/sandboxbroker/sandboxBroker.cpp, line 84
[task 2020-06-24T01:39:12.072Z] 01:39:12     INFO -  PID 3204 | [3204, Main Thread] WARNING: Failed to get directory to cache.: file /builds/worker/checkouts/gecko/security/sandbox/win/src/sandboxbroker/sandboxBroker.cpp, line 84
[task 2020-06-24T01:39:12.073Z] 01:39:12     INFO -  PID 3204 | [3204, Main Thread] WARNING: Couldn't get the user appdata directory. Crash events may not be produced.: file /builds/worker/checkouts/gecko/toolkit/crashreporter/nsExceptionHandler.cpp, line 2924
[task 2020-06-24T01:39:12.073Z] 01:39:12     INFO -  PID 3204 | [3204, Main Thread] WARNING: '!mProxySettingTarget', file /builds/worker/checkouts/gecko/netwerk/base/nsProtocolProxyService.cpp, line 874
[task 2020-06-24T01:39:12.073Z] 01:39:12     INFO -  (xpcshell/head.js) | test MAIN run_test pending (1)
[task 2020-06-24T01:39:12.074Z] 01:39:12     INFO -  (xpcshell/head.js) | test run_next_test 0 pending (2)
[task 2020-06-24T01:39:12.074Z] 01:39:12     INFO -  (xpcshell/head.js) | test MAIN run_test finished (2)
[task 2020-06-24T01:39:12.074Z] 01:39:12     INFO -  running event loop
[task 2020-06-24T01:39:12.074Z] 01:39:12     INFO -  PID 3204 | [3204, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, kKnownEsrVersion) failed with result 0x80004002 (NS_NOINTERFACE): file /builds/worker/checkouts/gecko/toolkit/components/resistfingerprinting/nsRFPService.cpp, line 673
[task 2020-06-24T01:39:12.074Z] 01:39:12     INFO -  xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | Starting check_remote
[task 2020-06-24T01:39:12.075Z] 01:39:12     INFO -  (xpcshell/head.js) | test check_remote pending (2)
[task 2020-06-24T01:39:12.075Z] 01:39:12     INFO -  TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | check_remote - [check_remote : 1] useRemoteWebExtensions matches - true == true
[task 2020-06-24T01:39:12.075Z] 01:39:12     INFO -  TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | check_remote - [check_remote : 1] testing from extension process - false == false
[task 2020-06-24T01:39:12.075Z] 01:39:12     INFO -  (xpcshell/head.js) | test run_next_test 0 finished (2)
[task 2020-06-24T01:39:12.076Z] 01:39:12     INFO -  (xpcshell/head.js) | test run_next_test 1 pending (2)
[task 2020-06-24T01:39:12.076Z] 01:39:12     INFO -  (xpcshell/head.js) | test check_remote finished (2)
[task 2020-06-24T01:39:12.076Z] 01:39:12     INFO -  xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | Starting test_stream_encoding_data
[task 2020-06-24T01:39:12.076Z] 01:39:12     INFO -  (xpcshell/head.js) | test test_stream_encoding_data pending (2)
[task 2020-06-24T01:39:12.076Z] 01:39:12     INFO -  "Extension attached"
[task 2020-06-24T01:39:12.076Z] 01:39:12     INFO -  (xpcshell/head.js) | test run_next_test 1 finished (2)
[task 2020-06-24T01:39:12.077Z] 01:39:12     INFO -  PID 3204 | [3204, Main Thread] WARNING: Failed to acquire a DXGI adapter for enumerating outputs.: file /builds/worker/checkouts/gecko/gfx/thebes/DeviceManagerDx.cpp, line 146
[task 2020-06-24T01:39:12.077Z] 01:39:12     INFO -  PID 3204 | [3204, Main Thread] WARNING: Failed to acquire a DXGI adapter for checking hardware stretching support.: file /builds/worker/checkouts/gecko/gfx/thebes/DeviceManagerDx.cpp, line 207
[task 2020-06-24T01:39:12.077Z] 01:39:12     INFO -  PID 3204 | [3204, Main Thread] WARNING: DWM not enabled, falling back to software vsync: file /builds/worker/checkouts/gecko/gfx/thebes/gfxWindowsPlatform.cpp, line 1941
[task 2020-06-24T01:39:12.077Z] 01:39:12     INFO -  PID 3204 | [3204, Main Thread] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/widget/windows/nsLookAndFeel.cpp, line 861
[task 2020-06-24T01:39:12.078Z] 01:39:12     INFO -  PID 3204 | [3204, Main Thread] WARNING: NS_ENSURE_TRUE(presShell) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp, line 4279
[task 2020-06-24T01:39:12.078Z] 01:39:12     INFO -  PID 3204 | [3204, Main Thread] WARNING: 'NS_FAILED(GetAccentColor(unused))', file /builds/worker/checkouts/gecko/widget/windows/nsLookAndFeel.cpp, line 485
[task 2020-06-24T01:39:12.078Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: Couldn't get the user appdata directory, crash dumps will go in an unusual location: file /builds/worker/checkouts/gecko/toolkit/crashreporter/nsExceptionHandler.cpp, line 2984
[task 2020-06-24T01:39:12.078Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, GMPThread] WARNING: Failed to delete GMP storage directory: file /builds/worker/checkouts/gecko/dom/media/gmp/GMPServiceParent.cpp, line 1568
[task 2020-06-24T01:39:12.079Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: Need BrowserChild to get the nativeWindow from!: file /builds/worker/checkouts/gecko/widget/PuppetWidget.cpp, line 1086
[task 2020-06-24T01:39:12.079Z] 01:39:12     INFO -  PID 3204 | DLL blocklist was unable to intercept AppInit DLLs.
[task 2020-06-24T01:39:12.079Z] 01:39:12     INFO -  PID 3204 | [11136, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-06-24T01:39:12.079Z] 01:39:12     INFO -  PID 3204 | [11136, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-06-24T01:39:12.080Z] 01:39:12     INFO -  PID 3204 | [Child 11136, Main Thread] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/widget/windows/nsLookAndFeel.cpp, line 861
[task 2020-06-24T01:39:12.080Z] 01:39:12     INFO -  PID 3204 | [Child 11136, Main Thread] WARNING: Fallback to BasicLayerManager: file /builds/worker/checkouts/gecko/dom/ipc/BrowserChild.cpp, line 2673
[task 2020-06-24T01:39:12.080Z] 01:39:12     INFO -  PID 3204 | [Child 11136, Main Thread] WARNING: 'NS_FAILED(GetAccentColor(unused))', file /builds/worker/checkouts/gecko/widget/windows/nsLookAndFeel.cpp, line 485
[task 2020-06-24T01:39:12.080Z] 01:39:12     INFO -  PID 3204 | [Child 11136, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, kKnownEsrVersion) failed with result 0x80070057 (NS_ERROR_ILLEGAL_VALUE): file /builds/worker/checkouts/gecko/toolkit/components/resistfingerprinting/nsRFPService.cpp, line 683
[task 2020-06-24T01:39:12.081Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: NS_ENSURE_TRUE(rootFrame) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp, line 4281
[task 2020-06-24T01:39:12.081Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: Need BrowserChild to get the nativeWindow from!: file /builds/worker/checkouts/gecko/widget/PuppetWidget.cpp, line 1086
[task 2020-06-24T01:39:12.081Z] 01:39:12     INFO -  PID 3204 | DLL blocklist was unable to intercept AppInit DLLs.
[task 2020-06-24T01:39:12.081Z] 01:39:12     INFO -  PID 3204 | [10532, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-06-24T01:39:12.081Z] 01:39:12     INFO -  PID 3204 | [10532, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-06-24T01:39:12.082Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: This method is lossy. Use GetCanonicalPath !: file /builds/worker/checkouts/gecko/xpcom/io/nsLocalFileWin.cpp, line 3149
[task 2020-06-24T01:39:12.082Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: This method is lossy. Use GetCanonicalPath !: file /builds/worker/checkouts/gecko/xpcom/io/nsLocalFileWin.cpp, line 3149
[task 2020-06-24T01:39:12.082Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: This method is lossy. Use GetCanonicalPath !: file /builds/worker/checkouts/gecko/xpcom/io/nsLocalFileWin.cpp, line 3149
[task 2020-06-24T01:39:12.082Z] 01:39:12     INFO -  PID 3204 | [Child 10532, Main Thread] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/widget/windows/nsLookAndFeel.cpp, line 861
[task 2020-06-24T01:39:12.082Z] 01:39:12     INFO -  PID 3204 | [Child 10532, Main Thread] WARNING: Fallback to BasicLayerManager: file /builds/worker/checkouts/gecko/dom/ipc/BrowserChild.cpp, line 2673
[task 2020-06-24T01:39:12.083Z] 01:39:12     INFO -  PID 3204 | [Child 10532, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, kKnownEsrVersion) failed with result 0x80070057 (NS_ERROR_ILLEGAL_VALUE): file /builds/worker/checkouts/gecko/toolkit/components/resistfingerprinting/nsRFPService.cpp, line 683
[task 2020-06-24T01:39:12.083Z] 01:39:12     INFO -  PID 3204 | [Child 10532, Main Thread] WARNING: 'NS_FAILED(GetAccentColor(unused))', file /builds/worker/checkouts/gecko/widget/windows/nsLookAndFeel.cpp, line 485
[task 2020-06-24T01:39:12.083Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: NS_ENSURE_TRUE(mIsPending) failed: file /builds/worker/checkouts/gecko/netwerk/protocol/http/nsHttpChannel.cpp, line 9394
[task 2020-06-24T01:39:12.083Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: NS_ENSURE_TRUE(mSuspendCount > 0) failed: file /builds/worker/checkouts/gecko/netwerk/protocol/http/nsHttpChannel.cpp, line 9435
[task 2020-06-24T01:39:12.083Z] 01:39:12     INFO -  PID 3204 | [Child 11136, Main Thread][Chi WARNIld 10NG: NS_ENSURE_SUCCESS(rv, rv) 532, Main Thread] WARNING: NS_ENfailed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/stSURE_SUCCESS(rv, rv) failed with resaultr t0upcache/StartupCacheUtils.cpp, line 197
[task 2020-06-24T01:39:12.083Z] 01:39:12     INFO -  PID 3204 | x80004005 C(NS_EouRlRdOn't cR_FAILURE): file /builds/worker/checkouts/gecko/startupcache/StartupCachoeUtils.ncpp,vert  chrlome Uine 197
[task 2020-06-24T01:39:12.084Z] 01:39:12     INFO -  PID 3204 | RL: chrome:/Cou/mochikit/content/tests/SimpleTest/EventUtils.js
[task 2020-06-24T01:39:12.084Z] 01:39:12     INFO -  PID 3204 | ldn't convert chrome URL: chrome://mochikit/content/tests/SimpleTest/EventUtils.js
[task 2020-06-24T01:39:12.084Z] 01:39:12     INFO -  TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | test_stream_encoding_data - [test_stream_encoding_data : 118] expected content received - true == true
[task 2020-06-24T01:39:12.084Z] 01:39:12     INFO -  (xpcshell/head.js) | test run_next_test 2 pending (2)
[task 2020-06-24T01:39:12.084Z] 01:39:12     INFO -  (xpcshell/head.js) | test test_stream_encoding_data finished (2)
[task 2020-06-24T01:39:12.084Z] 01:39:12     INFO -  xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | Starting test_xml_document_loadgroup_blocking
[task 2020-06-24T01:39:12.085Z] 01:39:12     INFO -  (xpcshell/head.js) | test test_xml_document_loadgroup_blocking pending (2)
[task 2020-06-24T01:39:12.085Z] 01:39:12     INFO -  "Extension attached"
[task 2020-06-24T01:39:12.085Z] 01:39:12     INFO -  (xpcshell/head.js) | test run_next_test 2 finished (2)
[task 2020-06-24T01:39:12.085Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: NS_ENSURE_TRUE(presShell) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp, line 4279
[task 2020-06-24T01:39:12.086Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: Need BrowserChild to get the nativeWindow from!: file /builds/worker/checkouts/gecko/widget/PuppetWidget.cpp, line 1086
[task 2020-06-24T01:39:12.086Z] 01:39:12     INFO -  PID 3204 | [Child 11136, Main Thread] WARNING: Fallback to BasicLayerManager: file /builds/worker/checkouts/gecko/dom/ipc/BrowserChild.cpp, line 2673
[task 2020-06-24T01:39:12.086Z] 01:39:12     INFO -  PID 3204 | [Child 11136, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/startupcache/StartupCacheUtils.cpp, line 197
[task 2020-06-24T01:39:12.087Z] 01:39:12     INFO -  PID 3204 | Couldn't convert chrome URL: chrome://mochikit/content/tests/SimpleTest/EventUtils.js
[task 2020-06-24T01:39:12.087Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: NS_ENSURE_TRUE(rootFrame) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp, line 4281
[task 2020-06-24T01:39:12.087Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: Need BrowserChild to get the nativeWindow from!: file /builds/worker/checkouts/gecko/widget/PuppetWidget.cpp, line 1086
[task 2020-06-24T01:39:12.087Z] 01:39:12     INFO -  PID 3204 | [Child 10532, Main Thread] WARNING: Fallback to BasicLayerManager: file /builds/worker/checkouts/gecko/dom/ipc/BrowserChild.cpp, line 2673
[task 2020-06-24T01:39:12.087Z] 01:39:12     INFO -  PID 3204 | [Child 10532, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/startupcache/StartupCacheUtils.cpp, line 197
[task 2020-06-24T01:39:12.088Z] 01:39:12     INFO -  PID 3204 | Couldn't convert chrome URL: chrome://mochikit/content/tests/SimpleTest/EventUtils.js
[task 2020-06-24T01:39:12.088Z] 01:39:12     INFO -  PID 3204 | DLL blocklist was unable to intercept AppInit DLLs.
[task 2020-06-24T01:39:12.088Z] 01:39:12     INFO -  PID 3204 | [10140, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-06-24T01:39:12.088Z] 01:39:12     INFO -  PID 3204 | [10140, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.c
[task 2020-06-24T01:39:12.089Z] 01:39:12     INFO -  TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | test_xml_document_loadgroup_blocking - [test_xml_document_loadgroup_blocking : 220] Things happened, and in the right order - ["original-onstop","filter-onstop","content-script-start","content-script-domload","content-script-load"] deepEqual ["original-onstop","filter-onstop","content-script-start","content-script-domload","content-script-load"]
[task 2020-06-24T01:39:12.089Z] 01:39:12     INFO -  PID 3204 | pp, line 202
[task 2020-06-24T01:39:12.089Z] 01:39:12     INFO -  (xpcshell/head.js) | test run_next_test 3 pending (2)
[task 2020-06-24T01:39:12.089Z] 01:39:12     INFO -  (xpcshell/head.js) | test test_xml_document_loadgroup_blocking finished (2)
[task 2020-06-24T01:39:12.090Z] 01:39:12     INFO -  xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | Starting test_filter_content_fetch
[task 2020-06-24T01:39:12.090Z] 01:39:12     INFO -  (xpcshell/head.js) | test test_filter_content_fetch pending (2)
[task 2020-06-24T01:39:12.090Z] 01:39:12     INFO -  "Extension attached"
[task 2020-06-24T01:39:12.090Z] 01:39:12     INFO -  (xpcshell/head.js) | test run_next_test 3 finished (2)
[task 2020-06-24T01:39:12.091Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: NS_ENSURE_TRUE(presShell) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp, line 4279
[task 2020-06-24T01:39:12.091Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: Need BrowserChild to get the nativeWindow from!: file /builds/worker/checkouts/gecko/widget/PuppetWidget.cpp, line 1086
[task 2020-06-24T01:39:12.091Z] 01:39:12     INFO -  PID 3204 | [Child 11136, Main Thread] WARNING: Fallback to BasicLayerManager: file /builds/worker/checkouts/gecko/dom/ipc/BrowserChild.cpp, line 2673
[task 2020-06-24T01:39:12.091Z] 01:39:12     INFO -  PID 3204 | [Child 11136, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/startupcache/StartupCacheUtils.cpp, line 197
[task 2020-06-24T01:39:12.091Z] 01:39:12     INFO -  PID 3204 | Couldn't convert chrome URL: chrome://mochikit/content/tests/SimpleTest/EventUtils.js
[task 2020-06-24T01:39:12.092Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: NS_ENSURE_TRUE(rootFrame) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp, line 4281
[task 2020-06-24T01:39:12.092Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: Need BrowserChild to get the nativeWindow from!: file /builds/worker/checkouts/gecko/widget/PuppetWidget.cpp, line 1086
[task 2020-06-24T01:39:12.092Z] 01:39:12     INFO -  PID 3204 | [Child 10532, Main Thread] WARNING: Fallback to BasicLayerManager: file /builds/worker/checkouts/gecko/dom/ipc/BrowserChild.cpp, line 2673
[task 2020-06-24T01:39:12.093Z] 01:39:12     INFO -  PID 3204 | [Child 10532, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/startupcache/StartupCacheUtils.cpp, line 197
[task 2020-06-24T01:39:12.093Z] 01:39:12     INFO -  PID 3204 | Couldn't convert chrome URL: chrome://mochikit/content/tests/SimpleTest/EventUtils.js
[task 2020-06-24T01:39:12.093Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: NS_ENSURE_TRUE(mIsPending) failed: file /builds/worker/checkouts/gecko/netwerk/protocol/http/nsHttpChannel.cpp, line 9394
[task 2020-06-24T01:39:12.094Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: NS_ENSURE_TRUE(mSuspendCount > 0) failed: file /builds/worker/checkouts/gecko/netwerk/protocol/http/nsHttpChannel.cpp, line 9435
[task 2020-06-24T01:39:12.094Z] 01:39:12     INFO -  TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | test_filter_content_fetch - [test_filter_content_fetch : 416] Got unfiltered data for http://example.com/dummy - Expected: ok, Actual: ok - true == true
[task 2020-06-24T01:39:12.094Z] 01:39:12     INFO -  "CONSOLE_MESSAGE: (error) [JavaScript Error: "The character encoding of the plain text 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 file needs to be declared in the transfer protocol or file needs to use a byte order mark as an encoding signature." {file: "http://example.com/dummy" line: 0}]"
[task 2020-06-24T01:39:12.094Z] 01:39:12     INFO -  TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | test_filter_content_fetch - [test_filter_content_fetch : 311] Expected response for http://example.net/dummy - "ok" == "ok"
[task 2020-06-24T01:39:12.095Z] 01:39:12     INFO -  PID 3204 | ###!!! [Child][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-06-24T01:39:12.095Z] 01:39:12     INFO -  TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | test_filter_content_fetch - [test_filter_content_fetch : 416] Got unfiltered data for http://example.com/dummy - Expected: ok, Actual: ok - true == true
[task 2020-06-24T01:39:12.095Z] 01:39:12     INFO -  PID 3204 | ###!!! [Child][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-06-24T01:39:12.095Z] 01:39:12     INFO -  TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | test_filter_content_fetch - [test_filter_content_fetch : 311] Expected response for http://example.com/dummy - "http://example.com/dummy" == "http://example.com/dummy"
[task 2020-06-24T01:39:12.096Z] 01:39:12     INFO -  PID 3204 | ###!!! [Child][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-06-24T01:39:12.096Z] 01:39:12     INFO -  TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | test_filter_content_fetch - [test_filter_content_fetch : 416] Got unfiltered data for http://example.org/dummy - Expected: ok, Actual: ok - true == true
[task 2020-06-24T01:39:12.096Z] 01:39:12     INFO -  TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | test_filter_content_fetch - [test_filter_content_fetch : 311] Expected response for http://example.org/dummy - "http://example.org/dummy" == "http://example.org/dummy"
[task 2020-06-24T01:39:12.096Z] 01:39:12     INFO -  TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | test_filter_content_fetch - [test_filter_content_fetch : 416] Got unfiltered data for http://example.com/dummy - Expected: ok, Actual: ok - true == true
[task 2020-06-24T01:39:12.097Z] 01:39:12     INFO -  TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | test_filter_content_fetch - [test_filter_content_fetch : 311] Expected response for http://example.net/redirect?redirect_uri=http://example.com/dummy - "http://example.com/dummy" == "http://example.com/dummy"
[task 2020-06-24T01:39:12.097Z] 01:39:12     INFO -  TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | test_filter_content_fetch - [test_filter_content_fetch : 311] Expected response for http://example.com/redirect?redirect_uri=http://example.net/dummy - "ok" == "ok"
[task 2020-06-24T01:39:12.097Z] 01:39:12     INFO -  TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | test_filter_content_fetch - [test_filter_content_fetch : 416] Got correct error for redirected filter - Expected: Channel redirected, Actual: Channel redirected - true == true
[task 2020-06-24T01:39:12.098Z] 01:39:12     INFO -  TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | test_filter_content_fetch - [test_filter_content_fetch : 416] Got correct error for redirected filter - Expected: Channel redirected, Actual: Channel redirected - true == true
[task 2020-06-24T01:39:12.098Z] 01:39:12     INFO -  TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | test_filter_content_fetch - [test_filter_content_fetch : 416] Got correct error for redirected filter - Expected: Channel redirected, Actual: Channel redirected - true == true
[task 2020-06-24T01:39:12.099Z] 01:39:12     INFO -  TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | test_filter_content_fetch - [test_filter_content_fetch : 416] Got unfiltered data for http://example.com/dummy - Expected: ok, Actual: ok - true == true
[task 2020-06-24T01:39:12.099Z] 01:39:12     INFO -  TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | test_filter_content_fetch - [test_filter_content_fetch : 416] Got unfiltered data for http://example.org/dummy - Expected: ok, Actual: ok - true == true
[task 2020-06-24T01:39:12.099Z] 01:39:12     INFO -  TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | test_filter_content_fetch - [test_filter_content_fetch : 311] Expected response for http://example.com/redirect?redirect_uri=http://example.com/dummy - "http://example.com/dummy" == "http://example.com/dummy"
[task 2020-06-24T01:39:12.100Z] 01:39:12     INFO -  TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | test_filter_content_fetch - [test_filter_content_fetch : 311] Expected response for http://example.com/redirect?redirect_uri=http://example.org/dummy - "http://example.org/dummy" == "http://example.org/dummy"
[task 2020-06-24T01:39:12.100Z] 01:39:12     INFO -  TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | test_filter_content_fetch - [test_filter_content_fetch : 431] stream-filter - true == true
[task 2020-06-24T01:39:12.100Z] 01:39:12     INFO -  TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | test_filter_content_fetch - [test_filter_content_fetch : 530] test result correct - "stream-filter" == "stream-filter"
[task 2020-06-24T01:39:12.101Z] 01:39:12     INFO -  (xpcshell/head.js) | test run_next_test 4 pending (2)
[task 2020-06-24T01:39:12.101Z] 01:39:12     INFO -  (xpcshell/head.js) | test test_filter_content_fetch finished (2)
[task 2020-06-24T01:39:12.101Z] 01:39:12     INFO -  xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | Starting test_filter_301
[task 2020-06-24T01:39:12.102Z] 01:39:12     INFO -  (xpcshell/head.js) | test test_filter_301 pending (2)
[task 2020-06-24T01:39:12.102Z] 01:39:12     INFO -  "Extension attached"
[task 2020-06-24T01:39:12.102Z] 01:39:12     INFO -  (xpcshell/head.js) | test run_next_test 4 finished (2)
[task 2020-06-24T01:39:12.102Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: NS_ENSURE_TRUE(presShell) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp, line 4279
[task 2020-06-24T01:39:12.103Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: Need BrowserChild to get the nativeWindow from!: file /builds/worker/checkouts/gecko/widget/PuppetWidget.cpp, line 1086
[task 2020-06-24T01:39:12.103Z] 01:39:12     INFO -  PID 3204 | [Child 11136, Main Thread] WARNING: Fallback to BasicLayerManager: file /builds/worker/checkouts/gecko/dom/ipc/BrowserChild.cpp, line 2673
[task 2020-06-24T01:39:12.103Z] 01:39:12     INFO -  PID 3204 | [Child 11136, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/startupcache/StartupCacheUtils.cpp, line 197
[task 2020-06-24T01:39:12.103Z] 01:39:12     INFO -  PID 3204 | Couldn't convert chrome URL: chrome://mochikit/content/tests/SimpleTest/EventUtils.js
[task 2020-06-24T01:39:12.103Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: NS_ENSURE_TRUE(rootFrame) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp, line 4281
[task 2020-06-24T01:39:12.104Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: Need BrowserChild to get the nativeWindow from!: file /builds/worker/checkouts/gecko/widget/PuppetWidget.cpp, line 1086
[task 2020-06-24T01:39:12.104Z] 01:39:12     INFO -  PID 3204 | [Child 10140, Main Thread] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/widget/windows/nsLookAndFeel.cpp, line 861
[task 2020-06-24T01:39:12.104Z] 01:39:12     INFO -  PID 3204 | [Child 10140, Main Thread] WARNING: Fallback to BasicLayerManager: file /builds/worker/checkouts/gecko/dom/ipc/BrowserChild.cpp, line 2673
[task 2020-06-24T01:39:12.104Z] 01:39:12     INFO -  PID 3204 | [Child 10140, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/startupcache/StartupCacheUtils.cpp, line 197
[task 2020-06-24T01:39:12.105Z] 01:39:12     INFO -  PID 3204 | Couldn't convert chrome URL: chrome://mochikit/content/tests/SimpleTest/EventUtils.js
[task 2020-06-24T01:39:12.105Z] 01:39:12     INFO -  PID 3204 | [Child 10140, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, kKnownEsrVersion) failed with result 0x80070057 (NS_ERROR_ILLEGAL_VALUE): file /builds/worker/checkouts/gecko/toolkit/components/resistfingerprinting/nsRFPService.cpp, line 683
[task 2020-06-24T01:39:12.105Z] 01:39:12     INFO -  PID 3204 | DLL blocklist was unable to intercept AppInit DLLs.
[task 2020-06-24T01:39:12.106Z] 01:39:12     INFO -  PID 3204 | [3776, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-06-24T01:39:12.106Z] 01:39:12     INFO -  PID 3204 | [3776, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-06-24T01:39:12.106Z] 01:39:12     INFO -  PID 3204 | DLL blocklist was unable to intercept AppInit DLLs.
[task 2020-06-24T01:39:12.107Z] 01:39:12     INFO -  PID 3204 | [7876, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-06-24T01:39:12.107Z] 01:39:12     INFO -  PID 3204 | [7876, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-06-24T01:39:12.108Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: NS_ENSURE_TRUE(mIsPending) failed: file /builds/worker/checkouts/gecko/netwerk/protocol/http/nsHttpChannel.cpp, line 9394
[task 2020-06-24T01:39:12.108Z] 01:39:12     INFO -  PID 3204 | [Child 10140, Main Thread] WARNING: 'NS_FAILED(GetAccentColor(unused))', file /builds/worker/checkouts/gecko/widget/windows/nsLookAndFeel.cpp, line 485
[task 2020-06-24T01:39:12.108Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: NS_ENSURE_TRUE(mSuspendCount > 0) failed: file /builds/worker/checkouts/gecko/netwerk/protocol/http/nsHttpChannel.cpp, line 9435
[task 2020-06-24T01:39:12.108Z] 01:39:12     INFO -  PID 3204 | ###!!! [Child][RunMessage] Error: Channel error: cannot send/recv
[task 2020-06-24T01:39:12.109Z] 01:39:12     INFO -  "CONSOLE_MESSAGE: (error) [JavaScript Error: "The character encoding of the plain text 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 file needs to be declared in the transfer protocol or file needs to use a byte order mark as an encoding signature." {file: "http://example.org/dummy" line: 0}]"
[task 2020-06-24T01:39:12.109Z] 01:39:12     INFO -  TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | test_filter_301 - [test_filter_301 : 431] stream-filter - true == true
[task 2020-06-24T01:39:12.109Z] 01:39:12     INFO -  TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | test_filter_301 - [test_filter_301 : 530] test result correct - "stream-filter" == "stream-filter"
[task 2020-06-24T01:39:12.109Z] 01:39:12     INFO -  (xpcshell/head.js) | test run_next_test 5 pending (2)
[task 2020-06-24T01:39:12.110Z] 01:39:12     INFO -  (xpcshell/head.js) | test test_filter_301 finished (2)
[task 2020-06-24T01:39:12.110Z] 01:39:12     INFO -  xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | Starting test_filter_302
[task 2020-06-24T01:39:12.110Z] 01:39:12     INFO -  (xpcshell/head.js) | test test_filter_302 pending (2)
[task 2020-06-24T01:39:12.110Z] 01:39:12     INFO -  PID 3204 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-06-24T01:39:12.110Z] 01:39:12     INFO -  "Extension attached"
[task 2020-06-24T01:39:12.110Z] 01:39:12     INFO -  (xpcshell/head.js) | test run_next_test 5 finished (2)
[task 2020-06-24T01:39:12.111Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: NS_ENSURE_TRUE(presShell) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp, line 4279
[task 2020-06-24T01:39:12.111Z] 01:39:12     INFO -  PID 3204 | [Child 3776, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-06-24T01:39:12.111Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: Need BrowserChild to get the nativeWindow from!: file /builds/worker/checkouts/gecko/widget/PuppetWidget.cpp, line 1086
[task 2020-06-24T01:39:12.111Z] 01:39:12     INFO -  PID 3204 | [Child 11136, Main Thread] WARNING: Fallback to BasicLayerManager: file /builds/worker/checkouts/gecko/dom/ipc/BrowserChild.cpp, line 2673
[task 2020-06-24T01:39:12.111Z] 01:39:12     INFO -  PID 3204 | [Child 11136, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/startupcache/StartupCacheUtils.cpp, line 197
[task 2020-06-24T01:39:12.111Z] 01:39:12     INFO -  PID 3204 | Couldn't convert chrome URL: chrome://mochikit/content/tests/SimpleTest/EventUtils.js
[task 2020-06-24T01:39:12.111Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: NS_ENSURE_TRUE(rootFrame) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp, line 4281
[task 2020-06-24T01:39:12.111Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: Need BrowserChild to get the nativeWindow from!: file /builds/worker/checkouts/gecko/widget/PuppetWidget.cpp, line 1086
[task 2020-06-24T01:39:12.111Z] 01:39:12     INFO -  PID 3204 | [Child 10140, Main Thread] WARNING: Fallback to BasicLayerManager: file /builds/worker/checkouts/gecko/dom/ipc/BrowserChild.cpp, line 2673
[task 2020-06-24T01:39:12.111Z] 01:39:12     INFO -  PID 3204 | [Child 10140, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/startupcache/StartupCacheUtils.cpp, line 197
[task 2020-06-24T01:39:12.111Z] 01:39:12     INFO -  PID 3204 | Couldn't convert chrome URL: chrome://mochikit/content/tests/SimpleTest/EventUtils.js
[task 2020-06-24T01:39:12.112Z] 01:39:12     INFO -  TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | test_filter_302 - [test_filter_302 : 416] undefined - Expected: Channel redirected, Actual: Channel redirected - true == true
[task 2020-06-24T01:39:12.112Z] 01:39:12     INFO -  PID 3204 | ###!!! [Child][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-06-24T01:39:12.112Z] 01:39:12     INFO -  PID 3204 | JavaScript error: http://example.com/script302.js, line 1: ReferenceError: forceError is not defined
[task 2020-06-24T01:39:12.112Z] 01:39:12     INFO -  "CONSOLE_MESSAGE: (error) [JavaScript Error: "ReferenceError: forceError is not defined" {file: "http://example.com/script302.js" line: 1}]
[task 2020-06-24T01:39:12.112Z] 01:39:12     INFO -  @http://example.com/script302.js:1:1
[task 2020-06-24T01:39:12.112Z] 01:39:12     INFO -  "
[task 2020-06-24T01:39:12.112Z] 01:39:12     INFO -  "CONSOLE_MESSAGE: (error) [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: "http://example.com/302.html" line: 0}]"
[task 2020-06-24T01:39:12.112Z] 01:39:12     INFO -  "CONSOLE_MESSAGE: (info) === console listener 0.5414265033430777 done ==="
[task 2020-06-24T01:39:12.112Z] 01:39:12     INFO -  "Matched expected console message: [JavaScript Error: "ReferenceError: forceError is not defined" {file: "http://example.com/script302.js" line: 1}]
[task 2020-06-24T01:39:12.112Z] 01:39:12     INFO -  @http://example.com/script302.js:1:1
[task 2020-06-24T01:39:12.112Z] 01:39:12     INFO -  "
[task 2020-06-24T01:39:12.112Z] 01:39:12     INFO -  (xpcshell/head.js) | test run_next_test 6 pending (2)
[task 2020-06-24T01:39:12.113Z] 01:39:12     INFO -  (xpcshell/head.js) | test test_filter_302 finished (2)
[task 2020-06-24T01:39:12.113Z] 01:39:12     INFO -  xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | Starting test_alternate_cached_data
[task 2020-06-24T01:39:12.113Z] 01:39:12     INFO -  (xpcshell/head.js) | test test_alternate_cached_data pending (2)
[task 2020-06-24T01:39:12.113Z] 01:39:12     INFO -  "Extension attached"
[task 2020-06-24T01:39:12.113Z] 01:39:12     INFO -  (xpcshell/head.js) | test run_next_test 6 finished (2)
[task 2020-06-24T01:39:12.113Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: NS_ENSURE_TRUE(rootFrame) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp, line 4281
[task 2020-06-24T01:39:12.113Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: Need BrowserChild to get the nativeWindow from!: file /builds/worker/checkouts/gecko/widget/PuppetWidget.cpp, line 1086
[task 2020-06-24T01:39:12.113Z] 01:39:12     INFO -  PID 3204 | [Child 10140, Main Thread] WARNING: Fallback to BasicLayerManager: file /builds/worker/checkouts/gecko/dom/ipc/BrowserChild.cpp, line 2673
[task 2020-06-24T01:39:12.113Z] 01:39:12     INFO -  PID 3204 | [Child 10140, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/startupcache/StartupCacheUtils.cpp, line 197
[task 2020-06-24T01:39:12.113Z] 01:39:12     INFO -  PID 3204 | Couldn't convert chrome URL: chrome://mochikit/content/tests/SimpleTest/EventUtils.js
[task 2020-06-24T01:39:12.114Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: NS_ENSURE_TRUE(presShell) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp, line 4279
[task 2020-06-24T01:39:12.114Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: Need BrowserChild to get the nativeWindow from!: file /builds/worker/checkouts/gecko/widget/PuppetWidget.cpp, line 1086
[task 2020-06-24T01:39:12.114Z] 01:39:12     INFO -  PID 3204 | [Child 11136, Main Thread] WARNING: Fallback to BasicLayerManager: file /builds/worker/checkouts/gecko/dom/ipc/BrowserChild.cpp, line 2673
[task 2020-06-24T01:39:12.114Z] 01:39:12     INFO -  PID 3204 | [Child 11136, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/startupcache/StartupCacheUtils.cpp, line 197
[task 2020-06-24T01:39:12.114Z] 01:39:12     INFO -  PID 3204 | Couldn't convert chrome URL: chrome://mochikit/content/tests/SimpleTest/EventUtils.js
[task 2020-06-24T01:39:12.114Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: NS_ENSURE_TRUE(rootFrame) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp, line 4281
[task 2020-06-24T01:39:12.114Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: Need BrowserChild to get the nativeWindow from!: file /builds/worker/checkouts/gecko/widget/PuppetWidget.cpp, line 1086
[task 2020-06-24T01:39:12.114Z] 01:39:12     INFO -  PID 3204 | [Child 10140, Main Thread] WARNING: Fallback to BasicLayerManager: file /builds/worker/checkouts/gecko/dom/ipc/BrowserChild.cpp, line 2673
[task 2020-06-24T01:39:12.114Z] 01:39:12     INFO -  PID 3204 | [Child 10140, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/startupcache/StartupCacheUtils.cpp, line 197
[task 2020-06-24T01:39:12.114Z] 01:39:12     INFO -  PID 3204 | Couldn't convert chrome URL: chrome://mochikit/content/tests/SimpleTest/EventUtils.js
[task 2020-06-24T01:39:12.115Z] 01:39:12     INFO -  TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | test_alternate_cached_data - [test_alternate_cached_data : 427] cache won the race - true == true
[task 2020-06-24T01:39:12.115Z] 01:39:12     INFO -  TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | test_alternate_cached_data - [test_alternate_cached_data : 416] undefined - Expected: Channel is delivering cached alt-data, Actual: Channel is delivering cached alt-data - true == true
[task 2020-06-24T01:39:12.115Z] 01:39:12     INFO -  TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | test_alternate_cached_data - [test_alternate_cached_data : 427] ondata received decoded data - true == true
[task 2020-06-24T01:39:12.115Z] 01:39:12     INFO -  TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | test_alternate_cached_data - [test_alternate_cached_data : 427] cache lost the race - true == true
[task 2020-06-24T01:39:12.115Z] 01:39:12     INFO -  TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | test_alternate_cached_data - [test_alternate_cached_data : 427] ondata received decoded data - true == true
[task 2020-06-24T01:39:12.115Z] 01:39:12     INFO -  (xpcshell/head.js) | test run_next_test 7 pending (2)
[task 2020-06-24T01:39:12.115Z] 01:39:12     INFO -  (xpcshell/head.js) | test test_alternate_cached_data finished (2)
[task 2020-06-24T01:39:12.115Z] 01:39:12     INFO -  (xpcshell/head.js) | test run_next_test 7 finished (1)
[task 2020-06-24T01:39:12.115Z] 01:39:12     INFO -  exiting test
[task 2020-06-24T01:39:12.115Z] 01:39:12  WARNING -  TEST-UNEXPECTED-FAIL | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_filterResponseData.js | test_alternate_cached_data - [test_alternate_cached_data : 392] message queue is empty - "[\\"onHeadersReceived\\"]" == "[]"
[task 2020-06-24T01:39:12.115Z] 01:39:12     INFO -  resource://testing-common/ExtensionXPCShellUtils.jsm:clearMessageQueues:392
[task 2020-06-24T01:39:12.116Z] 01:39:12     INFO -  resource://testing-common/ExtensionXPCShellUtils.jsm:ExtensionWrapper/<:334
[task 2020-06-24T01:39:12.116Z] 01:39:12     INFO -  Z:\task_1592960203\build\tests\xpcshell\head.js:_execute_test/<:641
[task 2020-06-24T01:39:12.116Z] 01:39:12     INFO -  Z:\task_1592960203\build\tests\xpcshell\head.js:_execute_test:650
[task 2020-06-24T01:39:12.116Z] 01:39:12     INFO -  -e:null:1
[task 2020-06-24T01:39:12.116Z] 01:39:12     INFO -  exiting test
[task 2020-06-24T01:39:12.116Z] 01:39:12     INFO -  NS_ERROR_ABORT:
[task 2020-06-24T01:39:12.116Z] 01:39:12     INFO -  _abort_failed_test@Z:\task_1592960203\build\tests\xpcshell\head.js:833:20
[task 2020-06-24T01:39:12.116Z] 01:39:12     INFO -  do_report_result@Z:\task_1592960203\build\tests\xpcshell\head.js:934:5
[task 2020-06-24T01:39:12.116Z] 01:39:12     INFO -  Assert<@Z:\task_1592960203\build\tests\xpcshell\head.js:73:21
[task 2020-06-24T01:39:12.116Z] 01:39:12     INFO -  proto.report@resource://testing-common/Assert.jsm:233:10
[task 2020-06-24T01:39:12.116Z] 01:39:12     INFO -  equal@resource://testing-common/Assert.jsm:275:8
[task 2020-06-24T01:39:12.117Z] 01:39:12     INFO -  clearMessageQueues@resource://testing-common/ExtensionXPCShellUtils.jsm:392:22
[task 2020-06-24T01:39:12.117Z] 01:39:12     INFO -  ExtensionWrapper/<@resource://testing-common/ExtensionXPCShellUtils.jsm:334:12
[task 2020-06-24T01:39:12.117Z] 01:39:12     INFO -  _execute_test/<@Z:\task_1592960203\build\tests\xpcshell\head.js:641:28
[task 2020-06-24T01:39:12.117Z] 01:39:12     INFO -  _execute_test@Z:\task_1592960203\build\tests\xpcshell\head.js:650:5
[task 2020-06-24T01:39:12.117Z] 01:39:12     INFO -  @-e:1:1
[task 2020-06-24T01:39:12.117Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Socket Thread] WARNING: cannot post event if not initialized: file /builds/worker/checkouts/gecko/netwerk/protocol/http/nsHttpConnectionMgr.cpp, line 282
[task 2020-06-24T01:39:12.117Z] 01:39:12     INFO -  "CONSOLE_MESSAGE: (error) [JavaScript Error: "NetworkError when attempting to fetch resource." {file: "Z:\\task_1592960203\\build\\tests\\xpcshell\\head.js" line: 671}]
[task 2020-06-24T01:39:12.117Z] 01:39:12     INFO -  _execute_test@Z:\\task_1592960203\\build\\tests\\xpcshell\\head.js:671:19
[task 2020-06-24T01:39:12.117Z] 01:39:12     INFO -  @-e:1:1
[task 2020-06-24T01:39:12.117Z] 01:39:12     INFO -  "
[task 2020-06-24T01:39:12.117Z] 01:39:12     INFO -  PID 3204 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-06-24T01:39:12.118Z] 01:39:12     INFO -  PID 3204 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-06-24T01:39:12.118Z] 01:39:12     INFO -  PID 3204 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-06-24T01:39:12.118Z] 01:39:12     INFO -  PID 3204 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-06-24T01:39:12.118Z] 01:39:12     INFO -  PID 3204 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-06-24T01:39:12.118Z] 01:39:12     INFO -  PID 3204 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-06-24T01:39:12.118Z] 01:39:12     INFO -  PID 3204 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-06-24T01:39:12.118Z] 01:39:12     INFO -  PID 3204 | [Child 7876, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-06-24T01:39:12.118Z] 01:39:12     INFO -  PID 3204 | [Child 10140, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-06-24T01:39:12.118Z] 01:39:12     INFO -  PID 3204 | [Child 10532, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-06-24T01:39:12.119Z] 01:39:12     INFO -  PID 3204 | [Child 11136, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-06-24T01:39:12.119Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-06-24T01:39:12.119Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-06-24T01:39:12.119Z] 01:39:12     INFO -  PID 3204 | [Parent 3204, Main Thread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-06-24T01:39:12.119Z] 01:39:12     INFO -  <<<<<<<
[task 2020-06-24T01:39:12.154Z] 01:39:12     INFO -  TEST-START | toolkit/components/url-classifier/tests/unit/test_bug1274685_unowned_list.js

Comment 1

[Intermittent Failures Robot]

25 failures in 1046 pushes (0.024 failures/push) were associated with this bug yesterday.

Repository breakdown:

• autoland: 17
• mozilla-central: 6
• try: 2

Platform breakdown:

• windows7-32: 12
• windows7-32-devedition: 1
• windows7-32-shippable: 7
• windows10-64: 4
• macosx1014-64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1647954&startday=2020-06-24&endday=2020-06-24&tree=all

Comment 2

[Intermittent Failures Robot]

24 failures in 1151 pushes (0.021 failures/push) were associated with this bug yesterday.

Repository breakdown:

• autoland: 18
• mozilla-central: 6

Platform breakdown:

• windows7-32: 9
• windows7-32-shippable: 5
• windows10-64: 6
• linux1804-64: 1
• windows10-64-shippable: 3

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1647954&startday=2020-06-25&endday=2020-06-25&tree=all

Comment 3

[Intermittent Failures Robot]

54 failures in 5252 pushes (0.01 failures/push) were associated with this bug in the last 7 days.

This is the #28 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: 12
• try: 2

Platform breakdown:

• linux1804-64-asan: 1
• windows10-64: 14
• windows7-32: 21
• windows7-32-devedition: 1
• windows7-32-shippable: 12
• macosx1014-64: 1
• linux1804-64: 1
• windows10-64-shippable: 3

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1647954&startday=2020-06-22&endday=2020-06-28&tree=all

Comment 4

[Intermittent Failures Robot]

35 failures in 954 pushes (0.037 failures/push) were associated with this bug yesterday.

Repository breakdown:

• autoland: 31
• mozilla-central: 4

Platform breakdown:

• windows7-32-shippable: 10
• windows7-32: 12
• windows10-64: 7
• windows10-64-shippable: 2
• macosx1014-64: 1
• windows10-64-ccov: 2
• linux1804-64-shippable: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1647954&startday=2020-06-30&endday=2020-06-30&tree=all

Comment 5

[Junior [inactive]]

Bug 1633935 is the regressor, could be the same reason with https://bugzilla.mozilla.org/show_bug.cgi?id=1647978#c5

Comment 6

[Intermittent Failures Robot]

18 failures in 834 pushes (0.022 failures/push) were associated with this bug yesterday.

Repository breakdown:

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

Platform breakdown:

• windows10-64: 3
• windows7-32: 4
• windows7-32-shippable: 9
• windows10-64-shippable: 1
• windows10-64-ccov: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1647954&startday=2020-07-01&endday=2020-07-01&tree=all

Comment 7

[Intermittent Failures Robot]

26 failures in 992 pushes (0.026 failures/push) were associated with this bug yesterday.

Repository breakdown:

• autoland: 19
• mozilla-central: 7

Platform breakdown:

• windows7-32-shippable: 12
• windows7-32: 5
• windows10-64: 5
• linux1804-64-shippable-qr: 1
• windows10-64-shippable: 1
• macosx1014-64: 1
• windows10-64-ccov: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1647954&startday=2020-07-02&endday=2020-07-02&tree=all

Comment 8

[Intermittent Failures Robot]

31 failures in 692 pushes (0.045 failures/push) were associated with this bug yesterday.

** This test has failed more than 150 times in the last 21 days. It should be disabled until it can be fixed. **

Repository breakdown:

• autoland: 27
• mozilla-central: 3
• try: 1

Platform breakdown:

• windows10-64: 7
• linux1804-64: 3
• windows10-64-ccov: 2
• windows7-32-shippable: 17
• windows7-32: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1647954&startday=2020-07-03&endday=2020-07-03&tree=all

Comment 9

[Andreea Pavel [:apavel]]

Attachment: Bug 1647954 - disable test_ext_webRequest_filterResponseData.js on windows r?#intermittent-reviewers

Comment 10

[Intermittent Failures Robot]

132 failures in 4516 pushes (0.029 failures/push) were associated with this bug in the last 7 days.

This is the #8 most frequent failure this week.

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

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

Repository breakdown:

• autoland: 103
• mozilla-central: 25
• try: 4

Platform breakdown:

• windows7-32: 27
• windows10-64: 25
• windows7-32-shippable: 59
• macosx1014-64: 2
• windows10-64-shippable: 4
• windows10-64-ccov: 8
• linux1804-64-shippable: 1
• linux1804-64-shippable-qr: 1
• linux1804-64: 4
• linux1804-64-tsan: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1647954&startday=2020-06-29&endday=2020-07-05&tree=all

Comment 11

[Intermittent Failures Robot]

21 failures in 849 pushes (0.025 failures/push) were associated with this bug yesterday.

Repository breakdown:

• mozilla-central: 5
• autoland: 14
• try: 2

Platform breakdown:

• windows7-32-shippable: 7
• windows7-32: 7
• windows10-64: 7

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1647954&startday=2020-07-06&endday=2020-07-06&tree=all

Comment 12

[Intermittent Failures Robot]

32 failures in 928 pushes (0.034 failures/push) were associated with this bug yesterday.

Repository breakdown:

• autoland: 22
• mozilla-central: 6
• try: 4

Platform breakdown:

• windows7-32: 10
• windows7-32-shippable: 10
• macosx1014-64: 1
• linux1804-64-asan: 1
• windows10-64-ccov: 1
• windows10-64: 8
• windows10-64-shippable: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1647954&startday=2020-07-07&endday=2020-07-07&tree=all

Comment 13

[Intermittent Failures Robot]

38 failures in 1037 pushes (0.037 failures/push) were associated with this bug yesterday.

Repository breakdown:

• autoland: 34
• try: 3
• mozilla-central: 1

Platform breakdown:

• windows7-32-shippable: 10
• windows7-32: 17
• windows10-64: 8
• macosx1014-64: 1
• windows10-64-shippable: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1647954&startday=2020-07-08&endday=2020-07-08&tree=all

Comment 14

[Junior [inactive]]

I take another look and as Orange Factor said, Bug 1647978 just covers alternative data cases.
I'd like to use this bug to address this and do some optimization.

Comment 15

[Junior [inactive]]

Attachment: Bug 1647954 - not touching Atomic for redirection/alt-data disconnection, r=mixedpuppy

Also address alt-data in comment

Comment 16

[Andreea Pavel [:apavel]]

No failures since the 9th of July.

Comment 17

[Intermittent Failures Robot]

92 failures in 5265 pushes (0.017 failures/push) were associated with this bug in the last 7 days.

This is the #10 most frequent failure this week.

** This test has failed more than 150 times in the last 21 days. It should be disabled until it can be fixed. **

Repository breakdown:

• autoland: 70
• mozilla-central: 12
• try: 10

Platform breakdown:

• windows7-32: 35
• windows10-64: 23
• windows7-32-shippable: 27
• macosx1014-64: 2
• linux1804-64-asan: 1
• windows10-64-ccov: 1
• windows10-64-shippable: 3

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1647954&startday=2020-07-06&endday=2020-07-12&tree=all

Comment 18

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/475ab29538a3
not touching Atomic for redirection/alt-data disconnection, r=mixedpuppy

Comment 19

[Bogdan Tara[:bogdan_tara | bogdant]]

https://hg.mozilla.org/mozilla-central/rev/475ab29538a3