Intermittent /fetch/api/abort/cache.https.any.html | single tracking bug
Categories
(Core :: DOM: Networking, defect, P5)
Tracking
()
People
(Reporter: intermittent-bug-filer, Unassigned)
References
(Blocks 1 open bug)
Details
(Keywords: intermittent-failure, intermittent-testcase, Whiteboard: [necko-triaged])
Attachments
(1 obsolete file)
Filed by: nfay [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=406825996&repo=mozilla-release
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/at3G3FZJRq-aNDImjpP9FQ/runs/0/artifacts/public/logs/live_backing.log
[task 2023-02-24T13:31:18.376Z] 13:31:18 INFO - PID 4220 | console.error: (new TypeError("this._searchProviderInfo is null", "resource:///modules/SearchSERPTelemetry.sys.mjs", 461))
[task 2023-02-24T13:31:18.445Z] 13:31:18 INFO - TEST-START | /fetch/api/abort/cache.https.any.html
[task 2023-02-24T13:31:18.497Z] 13:31:18 INFO - PID 4220 | console.error: (new TypeError("this._searchProviderInfo is null", "resource:///modules/SearchSERPTelemetry.sys.mjs", 461))
[task 2023-02-24T13:31:18.583Z] 13:31:18 INFO - PID 4220 | console.error: (new TypeError("this._searchProviderInfo is null", "resource:///modules/SearchSERPTelemetry.sys.mjs", 461))
[task 2023-02-24T13:31:23.092Z] 13:31:23 INFO - PID 4220 | console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.jsm", 407))
[task 2023-02-24T13:31:23.094Z] 13:31:23 INFO - PID 4220 | console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.jsm", 407))
[task 2023-02-24T13:31:23.094Z] 13:31:23 INFO - PID 4220 | console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.jsm", 407))
[task 2023-02-24T13:31:28.620Z] 13:31:28 INFO -
[task 2023-02-24T13:31:28.620Z] 13:31:28 INFO - TEST-PASS | /fetch/api/abort/cache.https.any.html | Signals are not stored in the cache API
[task 2023-02-24T13:31:28.620Z] 13:31:28 INFO - TEST-UNEXPECTED-TIMEOUT | /fetch/api/abort/cache.https.any.html | Signals are not stored in the cache API, even if they're already aborted - Test timed out
[task 2023-02-24T13:31:28.624Z] 13:31:28 INFO - TEST-KNOWN-INTERMITTENT-TIMEOUT | /fetch/api/abort/cache.https.any.html | took 10183ms
[task 2023-02-24T13:31:28.625Z] 13:31:28 INFO - PID 4220 | 1677245488624 Marionette INFO Stopped listening on port 53351
[task 2023-02-24T13:31:29.226Z] 13:31:29 INFO - PID 4220 | console.error: (new Error("IndexedDB: main/doh-config list() IndexedDB: execute() The application is shutting down", "resource://services-settings/IDBHelpers.jsm", 18))
[task 2023-02-24T13:31:32.010Z] 13:31:32 INFO - PID 4220 | WARNING: A blocker encountered an error while we were waiting.
[task 2023-02-24T13:31:32.018Z] 13:31:32 INFO - PID 4220 | Blocker: Waiting for ping task
[task 2023-02-24T13:31:32.018Z] 13:31:32 INFO - PID 4220 | Phase: TelemetryController: Waiting for pending ping activity
[task 2023-02-24T13:31:32.019Z] 13:31:32 INFO - PID 4220 | State: (none)
[task 2023-02-24T13:31:32.019Z] 13:31:32 INFO - PID 4220 | WARNING: Error: Phase "profile-before-change" is finished, it is too late to register completion condition "OS.File: flush I/O queued before profileBeforeChange"
[task 2023-02-24T13:31:32.020Z] 13:31:32 INFO - PID 4220 | WARNING: addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:727:15
[task 2023-02-24T13:31:32.020Z] 13:31:32 INFO - PID 4220 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:523:26
[task 2023-02-24T13:31:32.021Z] 13:31:32 INFO - PID 4220 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:458:15
[task 2023-02-24T13:31:32.021Z] 13:31:32 INFO - PID 4220 | setupShutdown@resource://gre/modules/osfile/osfile_async_front.jsm:1548:28
[task 2023-02-24T13:31:32.022Z] 13:31:32 INFO - PID 4220 | @resource://gre/modules/osfile/osfile_async_front.jsm:1568:16
[task 2023-02-24T13:31:32.022Z] 13:31:32 INFO - PID 4220 | @resource://gre/modules/osfile.jsm:12:30
[task 2023-02-24T13:31:32.023Z] 13:31:32 INFO - PID 4220 | @resource://gre/modules/TelemetryStorage.sys.mjs:10:28
[task 2023-02-24T13:31:32.023Z] 13:31:32 INFO - PID 4220 | _checkPendingPings@resource://gre/modules/TelemetrySend.sys.mjs:863:17
[task 2023-02-24T13:31:32.024Z] 13:31:32 INFO - PID 4220 | setup@resource://gre/modules/TelemetrySend.sys.mjs:803:18
[task 2023-02-24T13:31:32.025Z] 13:31:32 INFO - PID 4220 | setup@resource://gre/modules/TelemetrySend.sys.mjs:241:30
[task 2023-02-24T13:31:32.026Z] 13:31:32 INFO - PID 4220 | setupTelemetry/this._delayedInitTask<@resource://gre/modules/TelemetryControllerParent.sys.mjs:829:36
[task 2023-02-24T13:31:32.026Z] 13:31:32 INFO - PID 4220 | observe@resource://gre/modules/AsyncShutdown.sys.mjs:576:16
[task 2023-02-24T13:31:32.027Z] 13:31:32 INFO - PID 4220 | WARNING: A blocker encountered an error while we were waiting.
[task 2023-02-24T13:31:32.027Z] 13:31:32 INFO - PID 4220 | Blocker: Waiting for ping task
[task 2023-02-24T13:31:32.027Z] 13:31:32 INFO - PID 4220 | Phase: TelemetryController: Waiting for pending ping activity
[task 2023-02-24T13:31:32.028Z] 13:31:32 INFO - PID 4220 | State: (none)
[task 2023-02-24T13:31:32.029Z] 13:31:32 INFO - PID 4220 | WARNING: Error: Phase "profile-before-change" is finished, it is too late to register completion condition "OS.File: flush I/O queued before profileBeforeChange"
[task 2023-02-24T13:31:32.029Z] 13:31:32 INFO - PID 4220 | WARNING: addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:727:15
[task 2023-02-24T13:31:32.030Z] 13:31:32 INFO - PID 4220 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:523:26
[task 2023-02-24T13:31:32.030Z] 13:31:32 INFO - PID 4220 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:458:15
[task 2023-02-24T13:31:32.031Z] 13:31:32 INFO - PID 4220 | setupShutdown@resource://gre/modules/osfile/osfile_async_front.jsm:1548:28
[task 2023-02-24T13:31:32.031Z] 13:31:32 INFO - PID 4220 | @resource://gre/modules/osfile/osfile_async_front.jsm:1568:16
[task 2023-02-24T13:31:32.032Z] 13:31:32 INFO - PID 4220 | @resource://gre/modules/osfile.jsm:12:30
[task 2023-02-24T13:31:32.033Z] 13:31:32 INFO - PID 4220 | @resource://gre/modules/TelemetryStorage.sys.mjs:10:28
[task 2023-02-24T13:31:32.033Z] 13:31:32 INFO - PID 4220 | _checkPendingPings@resource://gre/modules/TelemetrySend.sys.mjs:863:17
[task 2023-02-24T13:31:32.033Z] 13:31:32 INFO - PID 4220 | setup@resource://gre/modules/TelemetrySend.sys.mjs:803:18
[task 2023-02-24T13:31:32.034Z] 13:31:32 INFO - PID 4220 | setup@resource://gre/modules/TelemetrySend.sys.mjs:241:30
[task 2023-02-24T13:31:32.034Z] 13:31:32 INFO - PID 4220 | setupTelemetry/this._delayedInitTask<@resource://gre/modules/TelemetryControllerParent.sys.mjs:829:36
[task 2023-02-24T13:31:32.035Z] 13:31:32 INFO - PID 4220 | observe@resource://gre/modules/AsyncShutdown.sys.mjs:576:16
[task 2023-02-24T13:31:32.035Z] 13:31:32 INFO - PID 4220 | WARNING: A blocker encountered an error while we were waiting.
[task 2023-02-24T13:31:32.036Z] 13:31:32 INFO - PID 4220 | Blocker: TelemetryController: shutting down
[task 2023-02-24T13:31:32.036Z] 13:31:32 INFO - PID 4220 | Phase: profile-before-change-telemetry
[task 2023-02-24T13:31:32.037Z] 13:31:32 INFO - PID 4220 | State: Error getting state: Error: Phase "profile-before-change" is finished, it is too late to register completion condition "OS.File: flush I/O queued before profileBeforeChange" at addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:727:15
[task 2023-02-24T13:31:32.038Z] 13:31:32 INFO - PID 4220 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:523:26
[task 2023-02-24T13:31:32.038Z] 13:31:32 INFO - PID 4220 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:458:15
[task 2023-02-24T13:31:32.038Z] 13:31:32 INFO - PID 4220 | setupShutdown@resource://gre/modules/osfile/osfile_async_front.jsm:1548:28
[task 2023-02-24T13:31:32.039Z] 13:31:32 INFO - PID 4220 | @resource://gre/modules/osfile/osfile_async_front.jsm:1568:16
[task 2023-02-24T13:31:32.040Z] 13:31:32 INFO - PID 4220 | @resource://gre/modules/osfile.jsm:12:30
[task 2023-02-24T13:31:32.040Z] 13:31:32 INFO - PID 4220 | @resource://gre/modules/TelemetryStorage.sys.mjs:10:28
[task 2023-02-24T13:31:32.041Z] 13:31:32 INFO - PID 4220 | _checkPendingPings@resource://gre/modules/TelemetrySend.sys.mjs:863:17
[task 2023-02-24T13:31:32.041Z] 13:31:32 INFO - PID 4220 | setup@resource://gre/modules/TelemetrySend.sys.mjs:803:18
[task 2023-02-24T13:31:32.042Z] 13:31:32 INFO - PID 4220 | setup@resource://gre/modules/TelemetrySend.sys.mjs:241:30
[task 2023-02-24T13:31:32.042Z] 13:31:32 INFO - PID 4220 | setupTelemetry/this._delayedInitTask<@resource://gre/modules/TelemetryControllerParent.sys.mjs:829:36
[task 2023-02-24T13:31:32.043Z] 13:31:32 INFO - PID 4220 | observe@resource://gre/modules/AsyncShutdown.sys.mjs:576:16
[task 2023-02-24T13:31:32.043Z] 13:31:32 INFO - PID 4220 | WARNING: Error: Phase "profile-before-change" is finished, it is too late to register completion condition "OS.File: flush I/O queued before profileBeforeChange"
[task 2023-02-24T13:31:32.044Z] 13:31:32 INFO - PID 4220 | WARNING: addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:727:15
[task 2023-02-24T13:31:32.044Z] 13:31:32 INFO - PID 4220 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:523:26
[task 2023-02-24T13:31:32.045Z] 13:31:32 INFO - PID 4220 | addBlocker@resource://gre/modules/AsyncShutdown.sys.mjs:458:15
[task 2023-02-24T13:31:32.045Z] 13:31:32 INFO - PID 4220 | setupShutdown@resource://gre/modules/osfile/osfile_async_front.jsm:1548:28
[task 2023-02-24T13:31:32.046Z] 13:31:32 INFO - PID 4220 | @resource://gre/modules/osfile/osfile_async_front.jsm:1568:16
[task 2023-02-24T13:31:32.046Z] 13:31:32 INFO - PID 4220 | @resource://gre/modules/osfile.jsm:12:30
[task 2023-02-24T13:31:32.047Z] 13:31:32 INFO - PID 4220 | @resource://gre/modules/TelemetryStorage.sys.mjs:10:28
[task 2023-02-24T13:31:32.047Z] 13:31:32 INFO - PID 4220 | _checkPendingPings@resource://gre/modules/TelemetrySend.sys.mjs:863:17
[task 2023-02-24T13:31:32.048Z] 13:31:32 INFO - PID 4220 | setup@resource://gre/modules/TelemetrySend.sys.mjs:803:18
[task 2023-02-24T13:31:32.048Z] 13:31:32 INFO - PID 4220 | setup@resource://gre/modules/TelemetrySend.sys.mjs:241:30
[task 2023-02-24T13:31:32.049Z] 13:31:32 INFO - PID 4220 | setupTelemetry/this._delayedInitTask<@resource://gre/modules/TelemetryControllerParent.sys.mjs:829:36
[task 2023-02-24T13:31:32.049Z] 13:31:32 INFO - PID 4220 | observe@resource://gre/modules/AsyncShutdown.sys.mjs:576:16
[task 2023-02-24T13:31:32.312Z] 13:31:32 INFO - PID 4220 | JavaScript error: resource://gre/modules/AsyncShutdown.sys.mjs, line 727: Error: Phase "profile-before-change" is finished, it is too late to register completion condition "OS.File: flush I/O queued before profileBeforeChange"
[task 2023-02-24T13:31:32.317Z] 13:31:32 INFO - PID 4220 | JavaScript error: resource://gre/modules/AsyncShutdown.sys.mjs, line 727: Error: Phase "profile-before-change" is finished, it is too late to register completion condition "OS.File: flush I/O queued before profileBeforeChange"
[task 2023-02-24T13:31:32.318Z] 13:31:32 INFO - PID 4220 | JavaScript error: resource://gre/modules/AsyncShutdown.sys.mjs, line 727: Error: Phase "profile-before-change" is finished, it is too late to register completion condition "OS.File: flush I/O queued before profileBeforeChange"
[task 2023-02-24T13:31:32.319Z] 13:31:32 INFO - PID 4220 | JavaScript error: resource://gre/modules/AsyncShutdown.sys.mjs, line 727: Error: Phase "profile-before-change" is finished, it is too late to register completion condition "OS.File: flush I/O queued before profileBeforeChange"
[task 2023-02-24T13:31:32.320Z] 13:31:32 INFO - PID 4220 | JavaScript error: resource://gre/modules/AsyncShutdown.sys.mjs, line 727: Error: Phase "profile-before-change" is finished, it is too late to register completion condition "OS.File: flush I/O queued before profileBeforeChange"
[task 2023-02-24T13:31:32.378Z] 13:31:32 INFO - Browser exited with return code 0
[task 2023-02-24T13:31:32.381Z] 13:31:32 INFO - Closing logging queue
[task 2023-02-24T13:31:32.382Z] 13:31:32 INFO - queue closed
[task 2023-02-24T13:31:32.409Z] 13:31:32 INFO - Application command: Z:\task_167723831379303\build\application\firefox\firefox.exe -marionette about:blank --wait-for-browser -profile C:\Users\task_167723831379303\AppData\Local\Temp\tmpz8hzj1lz
[task 2023-02-24T13:31:32.424Z] 13:31:32 INFO - PID 4436 | 1677245471775 Marionette INFO Marionette enabled
[task 2023-02-24T13:31:32.425Z] 13:31:32 INFO - PID 4436 | 1677245471777 Marionette INFO Listening on port 53366
[task 2023-02-24T13:31:32.425Z] 13:31:32 INFO - PID 4436 | JavaScript error: resource://gre/modules/XULStore.jsm, line 58: Error: Can't find profile directory.
[task 2023-02-24T13:31:32.426Z] 13:31:32 INFO - PID 4436 | console.warn: SearchSettings: "get: No settings file exists, new profile?" (new NotFoundError("Could not open the file at C:\\Users\\task_167723831379303\\AppData\\Local\\Temp\\tmpcbnjcz87\\search.json.mozlz4", (void 0)))
[task 2023-02-24T13:31:32.427Z] 13:31:32 INFO - PID 4436 | console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.jsm", 407))
[task 2023-02-24T13:31:32.428Z] 13:31:32 INFO - Starting runner
[task 2023-02-24T13:31:38.991Z] 13:31:38 INFO - PID 4436 | console.error: (new TypeError("this._searchProviderInfo is null", "resource:///modules/SearchSERPTelemetry.sys.mjs", 461))
[task 2023-02-24T13:31:39.079Z] 13:31:39 INFO - TEST-START | /fetch/api/abort/cache.https.any.serviceworker.html
Comment hidden (Intermittent Failures Robot) |
Comment 2•1 year ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.
Reporter | ||
Comment 3•1 year ago
|
||
treeherder |
New failure instance: https://treeherder.mozilla.org/logviewer?job_id=416083322&repo=mozilla-beta
Comment hidden (Intermittent Failures Robot) |
Comment 5•1 year ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit BugBot documentation.
Reporter | ||
Comment 6•1 year ago
|
||
treeherder |
New failure instance: https://treeherder.mozilla.org/logviewer?job_id=419445195&repo=autoland
Comment hidden (Intermittent Failures Robot) |
Comment 8•1 year ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit BugBot documentation.
Reporter | ||
Comment 9•10 months ago
|
||
treeherder |
New failure instance: https://treeherder.mozilla.org/logviewer?job_id=426448968&repo=mozilla-central
Comment hidden (Intermittent Failures Robot) |
Comment 11•10 months ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit BugBot documentation.
Reporter | ||
Comment 12•4 months ago
|
||
treeherder |
New failure instance: https://treeherder.mozilla.org/logviewer?job_id=447381454&repo=autoland
Comment hidden (Intermittent Failures Robot) |
Comment hidden (spam) |
Updated•4 months ago
|
Comment 15•3 months ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit BugBot documentation.
Reporter | ||
Comment 16•1 month ago
|
||
treeherder |
New failure instance: https://treeherder.mozilla.org/logviewer?job_id=458192035&repo=mozilla-central
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Description
•