Filed by: nfay [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=390645072&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/aBkLeL7_SPaQaoXRDYIiIw/runs/0/artifacts/public/logs/live_backing.log
[task 2022-09-16T04:20:19.048Z] 04:20:19 INFO - TEST-START | /streams/writable-streams/aborting.any.serviceworker.html
[task 2022-09-16T04:20:19.049Z] 04:20:19 INFO - Setting pref dom.streams.transform_streams.enabled to true
[task 2022-09-16T04:20:19.051Z] 04:20:19 INFO - Setting pref dom.streams.pipeTo.enabled to true
[task 2022-09-16T04:20:19.063Z] 04:20:19 INFO - Setting pref dom.streams.transform_streams.enabled to true
[task 2022-09-16T04:20:19.074Z] 04:20:19 INFO - Setting pref dom.streams.pipeTo.enabled to true
[task 2022-09-16T04:20:19.081Z] 04:20:19 INFO - Closing window 949f559f-c4f5-4d09-b9b8-b6e177e49f0c
[task 2022-09-16T04:20:29.312Z] 04:20:29 INFO -
[task 2022-09-16T04:20:29.312Z] 04:20:29 INFO - TEST-PASS | /streams/writable-streams/aborting.any.serviceworker.html | underlying abort() should not be called until underlying write() completes
[task 2022-09-16T04:20:29.312Z] 04:20:29 INFO - TEST-PASS | /streams/writable-streams/aborting.any.serviceworker.html | underlying abort() should not be called if underlying close() has started
[task 2022-09-16T04:20:29.312Z] 04:20:29 INFO - TEST-PASS | /streams/writable-streams/aborting.any.serviceworker.html | if underlying close() has started and then rejects, the abort() and close() promises should reject with the underlying close rejection reason
[task 2022-09-16T04:20:29.312Z] 04:20:29 INFO - TEST-PASS | /streams/writable-streams/aborting.any.serviceworker.html | an abort() that happens during a write() should trigger the underlying abort() even with a close() queued
[task 2022-09-16T04:20:29.312Z] 04:20:29 INFO - TEST-PASS | /streams/writable-streams/aborting.any.serviceworker.html | if a writer is created for a stream with a pending abort, its ready should be rejected with the abort error
[task 2022-09-16T04:20:29.312Z] 04:20:29 INFO - TEST-PASS | /streams/writable-streams/aborting.any.serviceworker.html | writer close() promise should resolve before abort() promise
[task 2022-09-16T04:20:29.312Z] 04:20:29 INFO - TEST-PASS | /streams/writable-streams/aborting.any.serviceworker.html | writer.ready should reject on controller error without waiting for underlying write
[task 2022-09-16T04:20:29.312Z] 04:20:29 INFO - TEST-PASS | /streams/writable-streams/aborting.any.serviceworker.html | writer.abort() while there is an in-flight write, and then finish the write with rejection
[task 2022-09-16T04:20:29.312Z] 04:20:29 INFO - TEST-PASS | /streams/writable-streams/aborting.any.serviceworker.html | writer.abort(), controller.error() while there is an in-flight write, and then finish the write
[task 2022-09-16T04:20:29.312Z] 04:20:29 INFO - TEST-PASS | /streams/writable-streams/aborting.any.serviceworker.html | writer.abort(), controller.error() while there is an in-flight close, and then finish the close
[task 2022-09-16T04:20:29.312Z] 04:20:29 INFO - TEST-UNEXPECTED-TIMEOUT | /streams/writable-streams/aborting.any.serviceworker.html | controller.error(), writer.abort() while there is an in-flight write, and then finish the write - Test timed out
[task 2022-09-16T04:20:29.313Z] 04:20:29 INFO -
[task 2022-09-16T04:20:29.314Z] 04:20:29 INFO - TEST-UNEXPECTED-NOTRUN | /streams/writable-streams/aborting.any.serviceworker.html | controller.error(), writer.abort() while there is an in-flight close, and then finish the close - expected PASS
[task 2022-09-16T04:20:29.314Z] 04:20:29 INFO -
[task 2022-09-16T04:20:29.315Z] 04:20:29 INFO - TEST-UNEXPECTED-NOTRUN | /streams/writable-streams/aborting.any.serviceworker.html | releaseLock() while aborting should reject the original closed promise - expected PASS
[task 2022-09-16T04:20:29.315Z] 04:20:29 INFO -
[task 2022-09-16T04:20:29.315Z] 04:20:29 INFO - TEST-UNEXPECTED-NOTRUN | /streams/writable-streams/aborting.any.serviceworker.html | releaseLock() during delayed async abort() should reject the writer.closed promise - expected PASS
[task 2022-09-16T04:20:29.317Z] 04:20:29 INFO -
[task 2022-09-16T04:20:29.317Z] 04:20:29 INFO - TEST-UNEXPECTED-NOTRUN | /streams/writable-streams/aborting.any.serviceworker.html | sink abort() should not be called until sink start() is done - expected PASS
[task 2022-09-16T04:20:29.318Z] 04:20:29 INFO -
[task 2022-09-16T04:20:29.318Z] 04:20:29 INFO - TEST-UNEXPECTED-NOTRUN | /streams/writable-streams/aborting.any.serviceworker.html | if start attempts to error the controller after abort() has been called, then it should lose - expected PASS
[task 2022-09-16T04:20:29.319Z] 04:20:29 INFO -
[task 2022-09-16T04:20:29.319Z] 04:20:29 INFO - TEST-UNEXPECTED-NOTRUN | /streams/writable-streams/aborting.any.serviceworker.html | stream abort() promise should still resolve if sink start() rejects - expected PASS
[task 2022-09-16T04:20:29.320Z] 04:20:29 INFO -
[task 2022-09-16T04:20:29.320Z] 04:20:29 INFO - TEST-UNEXPECTED-NOTRUN | /streams/writable-streams/aborting.any.serviceworker.html | writer abort() during sink start() should replace the writer.ready promise synchronously - expected PASS
[task 2022-09-16T04:20:29.321Z] 04:20:29 INFO -
[task 2022-09-16T04:20:29.321Z] 04:20:29 INFO - TEST-UNEXPECTED-NOTRUN | /streams/writable-streams/aborting.any.serviceworker.html | promises returned from other writer methods should be rejected when writer abort() happens during sink start() - expected PASS
[task 2022-09-16T04:20:29.321Z] 04:20:29 INFO -
[task 2022-09-16T04:20:29.321Z] 04:20:29 INFO - TEST-UNEXPECTED-NOTRUN | /streams/writable-streams/aborting.any.serviceworker.html | abort() should succeed despite rejection from write - expected PASS
[task 2022-09-16T04:20:29.322Z] 04:20:29 INFO -
[task 2022-09-16T04:20:29.322Z] 04:20:29 INFO - TEST-UNEXPECTED-NOTRUN | /streams/writable-streams/aborting.any.serviceworker.html | abort() should be rejected with the rejection returned from close() - expected PASS
[task 2022-09-16T04:20:29.323Z] 04:20:29 INFO -
[task 2022-09-16T04:20:29.323Z] 04:20:29 INFO - TEST-UNEXPECTED-NOTRUN | /streams/writable-streams/aborting.any.serviceworker.html | a rejecting sink.write() should not prevent sink.abort() from being called - expected PASS
[task 2022-09-16T04:20:29.325Z] 04:20:29 INFO -
[task 2022-09-16T04:20:29.325Z] 04:20:29 INFO - TEST-UNEXPECTED-NOTRUN | /streams/writable-streams/aborting.any.serviceworker.html | when start errors after stream abort(), underlying sink abort() should be called anyway - expected PASS
[task 2022-09-16T04:20:29.325Z] 04:20:29 INFO -
[task 2022-09-16T04:20:29.326Z] 04:20:29 INFO - TEST-UNEXPECTED-NOTRUN | /streams/writable-streams/aborting.any.serviceworker.html | when calling abort() twice on the same stream, both should give the same promise that fulfills with undefined - expected PASS
[task 2022-09-16T04:20:29.326Z] 04:20:29 INFO -
[task 2022-09-16T04:20:29.327Z] 04:20:29 INFO - TEST-UNEXPECTED-NOTRUN | /streams/writable-streams/aborting.any.serviceworker.html | when calling abort() twice on the same stream, but sequentially so so there's no pending abort the second time, both should fulfill with undefined - expected PASS
[task 2022-09-16T04:20:29.327Z] 04:20:29 INFO -
[task 2022-09-16T04:20:29.327Z] 04:20:29 INFO - TEST-UNEXPECTED-NOTRUN | /streams/writable-streams/aborting.any.serviceworker.html | calling abort() on an errored stream should fulfill with undefined - expected PASS
[task 2022-09-16T04:20:29.328Z] 04:20:29 INFO -
[task 2022-09-16T04:20:29.328Z] 04:20:29 INFO - TEST-UNEXPECTED-NOTRUN | /streams/writable-streams/aborting.any.serviceworker.html | sink abort() should not be called if stream was erroring due to controller.error() before abort() was called - expected PASS
[task 2022-09-16T04:20:29.329Z] 04:20:29 INFO -
[task 2022-09-16T04:20:29.329Z] 04:20:29 INFO - TEST-UNEXPECTED-NOTRUN | /streams/writable-streams/aborting.any.serviceworker.html | sink abort() should not be called if stream was erroring due to bad strategy before abort() was called - expected PASS
[task 2022-09-16T04:20:29.330Z] 04:20:29 INFO -
[task 2022-09-16T04:20:29.330Z] 04:20:29 INFO - TEST-UNEXPECTED-NOTRUN | /streams/writable-streams/aborting.any.serviceworker.html | abort with no arguments should set the stored error to undefined - expected PASS
[task 2022-09-16T04:20:29.332Z] 04:20:29 INFO -
[task 2022-09-16T04:20:29.332Z] 04:20:29 INFO - TEST-UNEXPECTED-NOTRUN | /streams/writable-streams/aborting.any.serviceworker.html | abort with an undefined argument should set the stored error to undefined - expected PASS
[task 2022-09-16T04:20:29.333Z] 04:20:29 INFO -
[task 2022-09-16T04:20:29.333Z] 04:20:29 INFO - TEST-UNEXPECTED-NOTRUN | /streams/writable-streams/aborting.any.serviceworker.html | abort with a string argument should set the stored error to that argument - expected PASS
[task 2022-09-16T04:20:29.334Z] 04:20:29 INFO -
[task 2022-09-16T04:20:29.334Z] 04:20:29 INFO - TEST-UNEXPECTED-NOTRUN | /streams/writable-streams/aborting.any.serviceworker.html | abort on a locked stream should reject - expected PASS
[task 2022-09-16T04:20:29.335Z] 04:20:29 INFO -
[task 2022-09-16T04:20:29.335Z] 04:20:29 INFO - TEST-PASS | /streams/writable-streams/aborting.any.serviceworker.html | WritableStreamDefaultController.signal
[task 2022-09-16T04:20:29.335Z] 04:20:29 INFO - TEST-UNEXPECTED-NOTRUN | /streams/writable-streams/aborting.any.serviceworker.html | the abort signal is signalled synchronously - write - expected PASS
[task 2022-09-16T04:20:29.336Z] 04:20:29 INFO -
[task 2022-09-16T04:20:29.336Z] 04:20:29 INFO - TEST-UNEXPECTED-NOTRUN | /streams/writable-streams/aborting.any.serviceworker.html | the abort signal is signalled synchronously - close - expected PASS
[task 2022-09-16T04:20:29.337Z] 04:20:29 INFO -
[task 2022-09-16T04:20:29.337Z] 04:20:29 INFO - TEST-UNEXPECTED-NOTRUN | /streams/writable-streams/aborting.any.serviceworker.html | the abort signal is not signalled on error - expected PASS
[task 2022-09-16T04:20:29.339Z] 04:20:29 INFO -
[task 2022-09-16T04:20:29.339Z] 04:20:29 INFO - TEST-UNEXPECTED-NOTRUN | /streams/writable-streams/aborting.any.serviceworker.html | the abort signal is not signalled on write failure - expected PASS
[task 2022-09-16T04:20:29.339Z] 04:20:29 INFO -
[task 2022-09-16T04:20:29.339Z] 04:20:29 INFO - TEST-UNEXPECTED-NOTRUN | /streams/writable-streams/aborting.any.serviceworker.html | the abort signal is not signalled on close failure - expected PASS
[task 2022-09-16T04:20:29.340Z] 04:20:29 INFO -
[task 2022-09-16T04:20:29.341Z] 04:20:29 INFO - TEST-UNEXPECTED-NOTRUN | /streams/writable-streams/aborting.any.serviceworker.html | recursive abort() call - expected PASS
[task 2022-09-16T04:20:29.342Z] 04:20:29 INFO - TEST-UNEXPECTED-TIMEOUT | /streams/writable-streams/aborting.any.serviceworker.html | expected OK
[task 2022-09-16T04:20:29.342Z] 04:20:29 INFO - TEST-INFO took 10295ms
[task 2022-09-16T04:20:29.344Z] 04:20:29 INFO - PID 2380 | 1663302029336 Marionette INFO Stopped listening on port 58476
[task 2022-09-16T04:20:29.346Z] 04:20:29 INFO - PID 2380 | [Parent 7052, Main Thread] WARNING: ContentParent: id=19c3ec00 - BlockShutdown: NotifyImpendingShutdown.: file /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:3635
[task 2022-09-16T04:20:29.347Z] 04:20:29 INFO - PID 2380 | [Parent 7052, Main Thread] WARNING: ContentParent: id=19c3ec00 - BlockShutdown: RequestContentJSInterrupt.: file /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:3641
[task 2022-09-16T04:20:29.348Z] 04:20:29 INFO - PID 2380 | [Parent 7052, Main Thread] WARNING: ContentParent: id=1b57d700 - BlockShutdown: NotifyImpendingShutdown.: file /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:3635
[task 2022-09-16T04:20:29.349Z] 04:20:29 INFO - PID 2380 | [Parent 7052, Main Thread] WARNING: ContentParent: id=1b57d700 - BlockShutdown: RequestContentJSInterrupt.: file /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:3641
[task 2022-09-16T04:20:29.349Z] 04:20:29 INFO - PID 2380 | [Parent 7052, Main Thread] WARNING: ContentParent: id=1c528800 - BlockShutdown: NotifyImpendingShutdown.: file /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:3635
[task 2022-09-16T04:20:29.350Z] 04:20:29 INFO - PID 2380 | [Parent 7052, Main Thread] WARNING: ContentParent: id=1c528800 - BlockShutdown: RequestContentJSInterrupt.: file /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:3641
[task 2022-09-16T04:20:29.352Z] 04:20:29 INFO - PID 2380 | [Parent 7052, Main Thread] WARNING: ContentParent: id=1c527c00 - BlockShutdown: NotifyImpendingShutdown.: file /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:3635
[task 2022-09-16T04:20:29.353Z] 04:20:29 INFO - PID 2380 | [Parent 7052, Main Thread] WARNING: ContentParent: id=1c527c00 - BlockShutdown: RequestContentJSInterrupt.: file /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:3641
[task 2022-09-16T04:20:29.354Z] 04:20:29 INFO - PID 2380 | [Parent 7052, Main Thread] WARNING: ContentParent: id=1faa3400 - BlockShutdown: NotifyImpendingShutdown.: file /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:3635
[task 2022-09-16T04:20:29.354Z] 04:20:29 INFO - PID 2380 | [Parent 7052, Main Thread] WARNING: ContentParent: id=1faa3400 - BlockShutdown: RequestContentJSInterrupt.: file /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:3641
[task 2022-09-16T04:20:29.357Z] 04:20:29 INFO - PID 2380 | [Parent 7052, Main Thread] WARNING: ContentParent: id=1a307600 - BlockShutdown: NotifyImpendingShutdown.: file /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:3635
[task 2022-09-16T04:20:29.357Z] 04:20:29 INFO - PID 2380 | [Parent 7052, Main Thread] WARNING: ContentParent: id=1a307600 - BlockShutdown: RequestContentJSInterrupt.: file /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:3641
[task 2022-09-16T04:20:29.358Z] 04:20:29 INFO - PID 2380 | [Parent 7052, Main Thread] WARNING: ContentParent: id=19caef00 - BlockShutdown: NotifyImpendingShutdown.: file /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:3635
[task 2022-09-16T04:20:29.359Z] 04:20:29 INFO - PID 2380 | [Parent 7052, Main Thread] WARNING: ContentParent: id=19caef00 - BlockShutdown: RequestContentJSInterrupt.: file /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:3641
[task 2022-09-16T04:20:30.037Z] 04:20:30 INFO - PID 2380 | [Parent 7052, Main Thread] WARNING: ContentParent: id=1faa3400 - BlockShutdown: CanSend.: file /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:3680
[task 2022-09-16T04:20:30.039Z] 04:20:30 INFO - PID 2380 | [Parent 7052, Main Thread] WARNING: ContentParent: id=1faa3400 - ShutDownProcess: Sent shutdown message.: file /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:1803
[task 2022-09-16T04:20:30.040Z] 04:20:30 INFO - PID 2380 | [Parent 7052, Main Thread] WARNING: ContentParent: id=1a307600 - BlockShutdown: CanSend.: file /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:3680
[task 2022-09-16T04:20:30.040Z] 04:20:30 INFO - PID 2380 | [Parent 7052, Main Thread] WARNING: ContentParent: id=1a307600 - ShutDownProcess: Sent shutdown message.: file /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:1803
[task 2022-09-16T04:20:30.041Z] 04:20:30 INFO - PID 2380 | [Parent 7052, Main Thread] WARNING: ContentParent: id=19caef00 - BlockShutdown: CanSend.: file /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:3680
[task 2022-09-16T04:20:30.042Z] 04:20:30 INFO - PID 2380 | [Parent 7052, Main Thread] WARNING: ContentParent: id=19caef00 - ShutDownProcess: Sent shutdown message.: file /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:1803
[task 2022-09-16T04:20:30.043Z] 04:20:30 INFO - PID 2380 | [Parent 7052, IPC I/O Parent] WARNING: file /builds/worker/checkouts/gecko/ipc/chromium/src/base/process_util_win.cc:167
[task 2022-09-16T04:20:30.045Z] 04:20:30 INFO - PID 2380 | [Parent 7052, Main Thread] WARNING: ContentParent: id=1faa3400 - ShutDownProcess: Closing channel.: file /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:1843
[task 2022-09-16T04:20:30.046Z] 04:20:30 INFO - PID 2380 | [Parent 7052, Main Thread] WARNING: ContentParent: id=1faa3400 - RemoveShutdownBlockers: file /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:3795
[task 2022-09-16T04:20:30.047Z] 04:20:30 INFO - PID 2380 | [Parent 7052, Main Thread] WARNING: ContentParent: id=1a307600 - ShutDownProcess: Closing channel.: file /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:1843
[task 2022-09-16T04:20:30.048Z] 04:20:30 INFO - PID 2380 | [Parent 7052, Main Thread] WARNING: ContentParent: id=1a307600 - RemoveShutdownBlockers: file /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:3795
[task 2022-09-16T04:20:30.049Z] 04:20:30 INFO - PID 2380 | [Parent 7052, Main Thread] WARNING: ContentParent: id=19caef00 - ShutDownProcess: Closing channel.: file /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:1843
[task 2022-09-16T04:20:30.050Z] 04:20:30 INFO - PID 2380 | [Parent 7052, Main Thread] WARNING: ContentParent: id=19caef00 - RemoveShutdownBlockers: file /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:3795
[task 2022-09-16T04:20:34.851Z] 04:20:34 INFO - Browser exited with return code 0
[task 2022-09-16T04:20:34.855Z] 04:20:34 INFO - Closing logging queue
[task 2022-09-16T04:20:34.855Z] 04:20:34 INFO - queue closed
[task 2022-09-16T04:20:34.889Z] 04:20:34 INFO - Application command: Z:\task_166330054095886\build\application\firefox\firefox.exe -marionette about:blank --wait-for-browser -profile C:\Users\task_166330054095886\AppData\Local\Temp\tmpevpbrd7c
[task 2022-09-16T04:20:34.905Z] 04:20:34 INFO - PID 3680 | 1663302009748 Marionette INFO Marionette enabled
[task 2022-09-16T04:20:34.906Z] 04:20:34 INFO - PID 3680 | 1663302009751 Marionette INFO Listening on port 58489
[task 2022-09-16T04:20:34.907Z] 04:20:34 INFO - PID 3680 | console.warn: SearchSettings: "get: No settings file exists, new profile?" (new NotFoundError("Could not open the file at C:\\Users\\task_166330054095886\\AppData\\Local\\Temp\\tmpcxswo9tr\\search.json.mozlz4", (void 0)))
[task 2022-09-16T04:20:34.907Z] 04:20:34 INFO - PID 3680 | *** You are running in background task mode. ***
[task 2022-09-16T04:20:34.908Z] 04:20:34 INFO - PID 3680 | *** You are running in headless mode.
[task 2022-09-16T04:20:34.909Z] 04:20:34 INFO - PID 3680 | console.error: "C:\\Users\\task_166330054095886\\AppData\\Local\\Temp\\tmpcxswo9tr" "" 0 ".purge.bg_rm"
[task 2022-09-16T04:20:34.909Z] 04:20:34 INFO - Starting runner
[task 2022-09-16T04:20:35.919Z] 04:20:35 INFO - TEST-START | /streams/writable-streams/aborting.any.sharedworker.html
Description
•