Closed Bug 1757709 Opened 4 years ago Closed 4 years ago

Intermittent [tier 2] TEST-UNEXPECTED-TIMEOUT | toolkit/components/extensions/test/xpcshell/test_ext_webRequest_style_cache.js | Test timed out

Categories

(WebExtensions :: General, defect, P5)

defect

Tracking

(Not tracked)

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

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


[task 2022-03-02T07:43:00.563Z] 07:43:00     INFO -  TEST-START | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_style_cache.js
[task 2022-03-02T07:48:00.571Z] 07:48:00  WARNING -  TEST-UNEXPECTED-TIMEOUT | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_style_cache.js | Test timed out
[task 2022-03-02T07:48:00.571Z] 07:48:00     INFO -  TEST-INFO took 300008ms
[task 2022-03-02T07:48:00.573Z] 07:48:00     INFO -  >>>>>>>
[task 2022-03-02T07:48:00.573Z] 07:48:00     INFO -  (xpcshell/head.js) | test MAIN run_test pending (1)
[task 2022-03-02T07:48:00.573Z] 07:48:00     INFO -  (xpcshell/head.js) | test run_next_test 0 pending (2)
[task 2022-03-02T07:48:00.573Z] 07:48:00     INFO -  (xpcshell/head.js) | test MAIN run_test finished (2)
[task 2022-03-02T07:48:00.574Z] 07:48:00     INFO -  running event loop
[task 2022-03-02T07:48:00.574Z] 07:48:00     INFO -  xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_style_cache.js | Starting check_remote
[task 2022-03-02T07:48:00.574Z] 07:48:00     INFO -  (xpcshell/head.js) | test check_remote pending (2)
[task 2022-03-02T07:48:00.575Z] 07:48:00     INFO -  TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_style_cache.js | check_remote - [check_remote : 1] useRemoteWebExtensions matches - true == true
[task 2022-03-02T07:48:00.575Z] 07:48:00     INFO -  TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_style_cache.js | check_remote - [check_remote : 1] testing from extension process - false == false
[task 2022-03-02T07:48:00.575Z] 07:48:00     INFO -  (xpcshell/head.js) | test run_next_test 0 finished (2)
[task 2022-03-02T07:48:00.576Z] 07:48:00     INFO -  (xpcshell/head.js) | test run_next_test 1 pending (2)
[task 2022-03-02T07:48:00.576Z] 07:48:00     INFO -  (xpcshell/head.js) | test check_remote finished (2)
[task 2022-03-02T07:48:00.576Z] 07:48:00     INFO -  xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_style_cache.js | Starting test_stylesheet_cache
[task 2022-03-02T07:48:00.576Z] 07:48:00     INFO -  (xpcshell/head.js) | test test_stylesheet_cache pending (2)
[task 2022-03-02T07:48:00.576Z] 07:48:00     INFO -  "Extension attached"
[task 2022-03-02T07:48:00.577Z] 07:48:00     INFO -  (xpcshell/head.js) | test run_next_test 1 finished (2)
[task 2022-03-02T07:48:00.577Z] 07:48:00     INFO -  PID 1076 | JavaScript error: Z:\task_164620408301571\build\tests\xpcshell\head.js, line 333: NS_NOINTERFACE:
[task 2022-03-02T07:48:00.577Z] 07:48:00     INFO -  "CONSOLE_MESSAGE: (error) [JavaScript Error: "NS_NOINTERFACE: " {file: "Z:\\task_164620408301571\\build\\tests\\xpcshell\\head.js" line: 333}]
[task 2022-03-02T07:48:00.577Z] 07:48:00     INFO -  QueryInterface@Z:\\task_164620408301571\\build\\tests\\xpcshell\\head.js:333:22
[task 2022-03-02T07:48:00.578Z] 07:48:00     INFO -  createInstance@Z:\\task_164620408301571\\build\\tests\\xpcshell\\head.js:309:31
[task 2022-03-02T07:48:00.578Z] 07:48:00     INFO -  createBrowserElement@resource://gre/modules/ExtensionParent.jsm:1249:31
[task 2022-03-02T07:48:00.578Z] 07:48:00     INFO -  _do_main@Z:\\task_164620408301571\\build\\tests\\xpcshell\\head.js:240:6
[task 2022-03-02T07:48:00.578Z] 07:48:00     INFO -  _execute_test@Z:\\task_164620408301571\\build\\tests\\xpcshell\\head.js:604:5
[task 2022-03-02T07:48:00.579Z] 07:48:00     INFO -  @-e:1:1
[task 2022-03-02T07:48:00.579Z] 07:48:00     INFO -  "
[task 2022-03-02T07:48:00.579Z] 07:48:00     INFO -  "CONSOLE_MESSAGE: (warn) [JavaScript Warning: "This page is in Quirks Mode. Page layout may be impacted. For Standards Mode use \ufffd<!DOCTYPE html>\ufffd." {file: "resource://gre-resources/hiddenWindow.html" line: 0}]"
[task 2022-03-02T07:48:00.580Z] 07:48:00     INFO -  TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_style_cache.js | test_stylesheet_cache - [test_stylesheet_cache : 170] undefined - Expected: http://example.com/data/file_stylesheet_cache.css, Actual: http://example.com/data/file_stylesheet_cache.css - true == true
[task 2022-03-02T07:48:00.580Z] 07:48:00     INFO -  TEST-PASS | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_webRequest_style_cache.js | test_stylesheet_cache - [test_stylesheet_cache : 170] undefined - Expected: http://example.com/data/file_stylesheet_cache.css?2, Actual: http://example.com/data/file_stylesheet_cache.css?2 - true == true
[task 2022-03-02T07:48:00.580Z] 07:48:00     INFO -  (xpcshell/head.js) | test run_next_test 2 pending (2)
[task 2022-03-02T07:48:00.581Z] 07:48:00     INFO -  (xpcshell/head.js) | test test_stylesheet_cache finished (2)
[task 2022-03-02T07:48:00.581Z] 07:48:00     INFO -  (xpcshell/head.js) | test run_next_test 2 finished (1)
[task 2022-03-02T07:48:00.581Z] 07:48:00     INFO -  exiting test
[task 2022-03-02T07:48:00.581Z] 07:48:00     INFO -  PID 1076 | JavaScript error: resource://gre/modules/URLQueryStrippingListService.jsm, line 90: TypeError: can't access property "removeEventListener", Services.cpmm.sharedData is null
[task 2022-03-02T07:48:00.582Z] 07:48:00     INFO -  PID 1076 | ###!!! [Parent][PCompositorManagerParent] Error: RunMessage(msgname=PCompositorBridge::Msg___delete__) Channel closing: too late to send/recv, messages will be lost
[task 2022-03-02T07:48:00.582Z] 07:48:00     INFO -  PID 1076 | ###!!! [Parent][PImageBridgeParent] Error: RunMessage(msgname=PImageBridge::Msg_WillClose) Channel closing: too late to send/recv, messages will be lost
[task 2022-03-02T07:48:00.582Z] 07:48:00     INFO -  "CONSOLE_MESSAGE: (error) [JavaScript Error: "IndexedDB UnknownErr: ActorsParent.cpp:16540"]"
[task 2022-03-02T07:48:00.583Z] 07:48:00     INFO -  "CONSOLE_MESSAGE: (error) [JavaScript Error: "IndexedDB: nonexistent-bucket-foo/query-stripping getLastModified() IndexedDB:   The operation failed for reasons unrelated to the database itself and not covered by any other error code." {file: "resource://services-settings/IDBHelpers.jsm" line: 24}]
[task 2022-03-02T07:48:00.583Z] 07:48:00     INFO -  IndexedDBError@resource://services-settings/IDBHelpers.jsm:24:5
[task 2022-03-02T07:48:00.583Z] 07:48:00     INFO -  getLastModified@resource://services-settings/Database.jsm:174:13
[task 2022-03-02T07:48:00.583Z] 07:48:00     INFO -  _execute_test@Z:\\task_164620408301571\\build\\tests\\xpcshell\\head.js:714:23
[task 2022-03-02T07:48:00.583Z] 07:48:00     INFO -  @-e:1:1
[task 2022-03-02T07:48:00.584Z] 07:48:00     INFO -  "
[task 2022-03-02T07:48:00.584Z] 07:48:00     INFO -  "CONSOLE_MESSAGE: (error) [JavaScript Error: "IndexedDB: nonexistent-bucket-foo/url-classifier-skip-urls getLastModified() IndexedDB:   The operation failed for reasons unrelated to the database itself and not covered by any other error code." {file: "resource://services-settings/IDBHelpers.jsm" line: 24}]
[task 2022-03-02T07:48:00.584Z] 07:48:00     INFO -  IndexedDBError@resource://services-settings/IDBHelpers.jsm:24:5
[task 2022-03-02T07:48:00.585Z] 07:48:00     INFO -  getLastModified@resource://services-settings/Database.jsm:174:13
[task 2022-03-02T07:48:00.585Z] 07:48:00     INFO -  _execute_test@Z:\\task_164620408301571\\build\\tests\\xpcshell\\head.js:714:23
[task 2022-03-02T07:48:00.585Z] 07:48:00     INFO -  @-e:1:1
[task 2022-03-02T07:48:00.585Z] 07:48:00     INFO -  "
[task 2022-03-02T07:48:00.585Z] 07:48:00     INFO -  PID 1076 | ###!!! [Parent][PGPUParent] Error: RunMessage(msgname=PGPU::Msg_ShutdownVR) Channel closing: too late to send/recv, messages will be lost
[task 2022-03-02T07:48:00.586Z] 07:48:00     INFO -  PID 1076 | ###!!! [Child][PInProcessChild] Error: Send(msgname=PWindowGlobal::Msg_UpdateDocumentHasLoaded) Channel closing: too late to send/recv, messages will be lost
[task 2022-03-02T07:48:00.586Z] 07:48:00     INFO -  PID 1076 | ###!!! [Child][PInProcessChild] Error: Send(msgname=PWindowGlobal::Msg_Destroy) Channel closing: too late to send/recv, messages will be lost
[task 2022-03-02T07:48:00.586Z] 07:48:00     INFO -  PID 1076 | ###!!! [Child][PCompositorManagerChild] Error: RunMessage(msgname=PCompositorWidget::Msg_UnobserveVsync) Channel closing: too late to send/recv, messages will be lost
[task 2022-03-02T07:48:00.587Z] 07:48:00     INFO -  PID 1076 | ###!!! [Child][PCompositorManagerChild] Error: RunMessage(msgname=PWebRenderBridge::Msg___delete__) Channel closing: too late to send/recv, messages will be lost
[task 2022-03-02T07:48:00.587Z] 07:48:00     INFO -  PID 1076 | ###!!! [Child][PCompositorManagerChild] Error: Send(msgname=PCompositorBridge::Msg___delete__) Channel closing: too late to send/recv, messages will be lost
[task 2022-03-02T07:48:00.587Z] 07:48:00     INFO -  <<<<<<<
[task 2022-03-02T07:48:00.662Z] 07:48:00     INFO -  xpcshell return code: None
[task 2022-03-02T07:48:00.683Z] 07:48:00     INFO -  Failed to remove directory: C:\Users\task_164620408301571\AppData\Local\Temp\xpc-plugins-9tpwyj4p. Waiting.
[task 2022-03-02T07:48:00.687Z] 07:48:00     INFO -  INFO | Result summary:
[task 2022-03-02T07:48:00.687Z] 07:48:00     INFO -  INFO | Passed: 545
[task 2022-03-02T07:48:00.687Z] 07:48:00  WARNING -  INFO | Failed: 1
Status: NEW → RESOLVED
Closed: 4 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.