1649605 - SessionWorker.jsm imports OS.File during startup

Reporter

Description

•

4 years ago

According to this startup profile, SessionWorker.jsm runs during startup and imports osfile.jsm. We should migrate this to the new IOUtils replacement for osfile.jsm when possible.

Stack:

(root) []
XREMain::XRE_main []
XREMain::XRE_main(int, char**, mozilla::BootstrapConfig const&) [libxul.so]
XREMain::XRE_mainRun() [libxul.so]
nsAppStartup::Run() [libxul.so]
nsBaseAppShell::Run() [libxul.so]
MessageLoop::Run() [libxul.so]
mozilla::ipc::MessagePump::Run(base::MessagePump::Delegate*) [libxul.so]
nsThread::ProcessNextEvent(bool, bool*) [libxul.so]
mozilla::ThrottledEventQueue::Inner::Executor::Run() [libxul.so]
mozilla::ThrottledEventQueue::Inner::ExecuteRunnable() [libxul.so]
mozilla::dom::WorkerRunnable::Run() [libxul.so]
mozilla::dom::MessageEventRunnable::DispatchDOMEvent(JSContext*, mozilla::dom::WorkerPrivate*, mozilla::DOMEventTargetHelper*, bool) [libxul.so]
mozilla::dom::EventTarget::DispatchEvent(mozilla::dom::Event&) [libxul.so]
mozilla::DOMEventTargetHelper::DispatchEvent(mozilla::dom::Event&, mozilla::dom::CallerType, mozilla::ErrorResult&) [libxul.so]
mozilla::EventDispatcher::DispatchDOMEvent(nsISupports*, mozilla::WidgetEvent*, mozilla::dom::Event*, nsPresContext*, nsEventStatus*) [libxul.so]
EventDispatcher::Dispatch []
EventDispatcher::Dispatch message []
mozilla::EventDispatcher::Dispatch(nsISupports*, nsPresContext*, mozilla::WidgetEvent*, mozilla::dom::Event*, nsEventStatus*, mozilla::EventDispatchingCallback*, nsTArray<mozilla::dom::EventTarget*>*) [libxul.so]
mozilla::EventTargetChainItem::HandleEventTargetChain(nsTArray<mozilla::EventTargetChainItem>&, mozilla::EventChainPostVisitor&, mozilla::EventDispatchingCallback*, mozilla::ELMCreationDetector&) [libxul.so]
mozilla::EventListenerManager::HandleEventInternal(nsPresContext*, mozilla::WidgetEvent*, mozilla::dom::Event**, mozilla::dom::EventTarget*, nsEventStatus*, bool) [libxul.so]
<name omitted> [libxul.so]
promise callback []
mozilla::PromiseJobRunnable::Run(mozilla::AutoSlowOperation&) [libxul.so]
mozilla::dom::PromiseJobCallback::Call(mozilla::dom::BindingCallContext&, JS::Handle<JS::Value>, mozilla::ErrorResult&) [libxul.so]
JS::Call(JSContext*, JS::Handle<JS::Value>, JS::Handle<JS::Value>, JS::HandleValueArray const&, JS::MutableHandle<JS::Value>) [libxul.so]
js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) [libxul.so]
PromiseReactionJob(JSContext*, unsigned int, JS::Value*) [libxul.so]
AsyncFunctionResume(JSContext*, JS::Handle<js::AsyncFunctionGeneratorObject*>, ResumeKind, JS::Handle<JS::Value>) [libxul.so]
js::CallSelfHostedFunction(JSContext*, JS::Handle<js::PropertyName*>, JS::Handle<JS::Value>, js::AnyInvokeArgs const&, JS::MutableHandle<JS::Value>) [libxul.so]
js::Call(JSContext*, JS::Handle<JS::Value>, JS::Handle<JS::Value>, js::AnyInvokeArgs const&, JS::MutableHandle<JS::Value>, js::CallReason) [libxul.so]
js::RunScript []
js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) [libxul.so]
AsyncFunctionNext [self-hosted:688:26]
0xff4eaa5ea9f []
js::jit::InterpretResume(JSContext*, JS::Handle<JSObject*>, JS::Value*, JS::MutableHandle<JS::Value>) [libxul.so]
js::CallSelfHostedFunction(JSContext*, JS::Handle<js::PropertyName*>, JS::Handle<JS::Value>, js::AnyInvokeArgs const&, JS::MutableHandle<JS::Value>) [libxul.so]
js::Call(JSContext*, JS::Handle<JS::Value>, JS::Handle<JS::Value>, js::AnyInvokeArgs const&, JS::MutableHandle<JS::Value>, js::CallReason) [libxul.so]
js::RunScript []
InterpretGeneratorResume [self-hosted:1146:33]
_initWorker [resource:///modules/sessionstore/SessionFile.jsm:367:13]
js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) [libxul.so]
Interpret(JSContext*, js::RunState&) [libxul.so]
PromiseConstructor(JSContext*, unsigned int, JS::Value*) [libxul.so]
js::PromiseObject::create(JSContext*, JS::Handle<JSObject*>, JS::Handle<JSObject*>, bool) [libxul.so]
js::Call(JSContext*, JS::Handle<JS::Value>, JS::Handle<JS::Value>, js::AnyInvokeArgs const&, JS::MutableHandle<JS::Value>, js::CallReason) [libxul.so]
js::RunScript []
_initWorker/< [resource:///modules/sessionstore/SessionFile.jsm:368:23]
js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) [libxul.so]
Interpret(JSContext*, js::RunState&) [libxul.so]
js::NativeGetExistingProperty(JSContext*, JS::Handle<JSObject*>, JS::Handle<js::NativeObject*>, JS::Handle<js::Shape*>, JS::MutableHandle<JS::Value>) [libxul.so]
js::CallGetter(JSContext*, JS::Handle<JS::Value>, JS::Handle<JS::Value>, JS::MutableHandle<JS::Value>) [libxul.so]
js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) [libxul.so]
mozilla::dom::module_getter::ModuleGetter(JSContext*, unsigned int, JS::Value*) [libxul.so]
mozJSComponentLoader::Import(JSContext*, nsTSubstring<char> const&, JS::MutableHandle<JSObject*>, JS::MutableHandle<JSObject*>, bool) [libxul.so]
component loader load module []
mozJSComponentLoader::ObjectForLocation(ComponentLoaderInfo&, nsIFile*, JS::MutableHandle<JSObject*>, JS::MutableHandle<JSScript*>, char**, bool, JS::MutableHandle<JS::Value>) [libxul.so]
js::ExecuteInJSMEnvironment(JSContext*, JS::Handle<JSScript*>, JS::Handle<JSObject*>) [libxul.so]
js::ExecuteInJSMEnvironment(JSContext*, JS::Handle<JSScript*>, JS::Handle<JSObject*>, JS::Handle<JS::StackGCVector<JSObject*, js::TempAllocPolicy> >) [libxul.so]
ExecuteInExtensibleLexicalEnvironment(JSContext*, JS::Handle<JSScript*>, JS::Handle<JSObject*>) [libxul.so]
js::RunScript []
> resource:///modules/sessionstore/SessionWorker.jsm []
js::ExecuteKernel(JSContext*, JS::Handle<JSScript*>, JS::Handle<JSObject*>, JS::Handle<JS::Value>, js::AbstractFramePtr, JS::MutableHandle<JS::Value>) [libxul.so]
Interpret(JSContext*, js::RunState&) [libxul.so]
js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) [libxul.so]
ChromeUtils.import []
mozilla::dom::ChromeUtils_Binding::import(JSContext*, unsigned int, JS::Value*) [libxul.so]
> ChromeUtils::Import resource://gre/modules/osfile.jsm []
mozilla::dom::ChromeUtils::Import(mozilla::dom::GlobalObject const&, nsTSubstring<char16_t> const&, mozilla::dom::Optional<JS::Handle<JSObject*> > const&, JS::MutableHandle<JSObject*>, mozilla::ErrorResult&) [libxul.so]
mozJSComponentLoader::Import(JSContext*, nsTSubstring<char> const&, JS::MutableHandle<JSObject*>, JS::MutableHandle<JSObject*>, bool) [libxul.so]
profiler_get_backtrace() [libxul.so]
Registers::SyncPopulate() [libxul.so]

Emma Malysz

Comment 1

•

4 years ago

Attached file Bug 1649605, remove OS.File usage from SessionWorker.jsm (obsolete) — Details

Emma Malysz

Comment 2

•

4 years ago

Attached file WIP: Bug 1649605: remove OS.File import from SessionWorker.jsm and replace OS.File usage in SessionWorker.js (obsolete) — Details

Phabricator Automation

Updated

•

4 years ago

Assignee: nobody → emalysz

Status: NEW → ASSIGNED

Phabricator Automation

Updated

•

4 years ago

Attachment #9191359 - Attachment is obsolete: true

Pulsebot

Comment 3

•

4 years ago

Pushed by emalysz@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/35518cae413a
remove OS.File import from SessionWorker.jsm and replace OS.File usage in SessionWorker.js r=Gijs

Bogdan Tara[:bogdan_tara | bogdant]

Comment 4

•

4 years ago

Backed out changeset 35518cae413a (bug 1649605) for test_Promise.js & test_compression.js xpc failures.

Push with failures: https://treeherder.mozilla.org/jobs?repo=autoland&group_state=expanded&fromchange=9ca5ca297508f4240fd47aad0838d90512e082e1&searchStr=linux%2C18.04%2Cx64%2Casan%2Copt%2Cxpcshell%2Ctests%2Ctest-linux1804-64-asan%2Fopt-xpcshell-e10s%2Cx1&tochange=ef9b83d0ef1a36996b1ac664290636de6aa47058

Backout link: https://hg.mozilla.org/integration/autoland/rev/ef9b83d0ef1a36996b1ac664290636de6aa47058

Failure log: https://treeherder.mozilla.org/logviewer?job_id=326032887&repo=autoland&lineNumber=5550

[task 2021-01-07T03:24:10.892Z] 03:24:10     INFO -  TEST-START | toolkit/components/osfile/tests/xpcshell/test_compression.js
[task 2021-01-07T03:29:10.961Z] 03:29:10  WARNING -  TEST-UNEXPECTED-TIMEOUT | toolkit/components/osfile/tests/xpcshell/test_compression.js | Test timed out
[task 2021-01-07T03:29:10.961Z] 03:29:10     INFO -  TEST-INFO took 300067ms
[task 2021-01-07T03:29:10.961Z] 03:29:10     INFO -  >>>>>>>
[task 2021-01-07T03:29:10.961Z] 03:29:10     INFO -  PID 7404 | [Parent 7404, 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:2916
[task 2021-01-07T03:29:10.962Z] 03:29:10     INFO -  (xpcshell/head.js) | test MAIN run_test pending (1)
[task 2021-01-07T03:29:10.962Z] 03:29:10     INFO -  (xpcshell/head.js) | test pending (2)
[task 2021-01-07T03:29:10.962Z] 03:29:10     INFO -  (xpcshell/head.js) | test run_next_test 0 pending (3)
[task 2021-01-07T03:29:10.962Z] 03:29:10     INFO -  (xpcshell/head.js) | test MAIN run_test finished (3)
[task 2021-01-07T03:29:10.962Z] 03:29:10     INFO -  running event loop
[task 2021-01-07T03:29:10.962Z] 03:29:10     INFO -  PID 7404 | Couldn't convert chrome URL: chrome://branding/locale/brand.properties
[task 2021-01-07T03:29:10.962Z] 03:29:10     INFO -  PID 7404 | [Parent 7404, Main Thread] WARNING: Could not get the program name for a cubeb stream.: 'NS_SUCCEEDED(rv)', file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp:387
[task 2021-01-07T03:29:10.962Z] 03:29:10     INFO -  toolkit/components/osfile/tests/xpcshell/test_compression.js | Starting test_compress_lz4
[task 2021-01-07T03:29:10.962Z] 03:29:10     INFO -  (xpcshell/head.js) | test test_compress_lz4 pending (3)
[task 2021-01-07T03:29:10.962Z] 03:29:10     INFO -  "Writing data with lz4 compression"
[task 2021-01-07T03:29:10.962Z] 03:29:10     INFO -  (xpcshell/head.js) | test run_next_test 0 finished (3)
[task 2021-01-07T03:29:10.963Z] 03:29:10     INFO -  PID 7404 | OS Controller Posting message {"fun":"SET_DEBUG","args":[true],"id":1}
[task 2021-01-07T03:29:10.963Z] 03:29:10     INFO -  PID 7404 | [Parent 7404, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, kKnownEsrVersion) failed with result 0x80004002 (NS_NOINTERFACE): file /builds/worker/checkouts/gecko/toolkit/components/resistfingerprinting/nsRFPService.cpp:744
[task 2021-01-07T03:29:10.963Z] 03:29:10     INFO -  PID 7404 | OS Controller Message posted
[task 2021-01-07T03:29:10.963Z] 03:29:10     INFO -  PID 7404 | OS Controller Expecting reply
[task 2021-01-07T03:29:10.963Z] 03:29:10     INFO -  PID 7404 | OS Controller Posting message {"fun":"writeAtomic","args":[{"string":"/var/folders/dz/nmd20w0x70d8whltfm6tpd3r000017/T/compression.lz"},{"data":"[Uint8Array 0 1024]"},{"compression":"lz4","bytes":1024}],"id":2}
[task 2021-01-07T03:29:10.963Z] 03:29:10     INFO -  PID 7404 | OS Controller Message posted
[task 2021-01-07T03:29:10.963Z] 03:29:10     INFO -  PID 7404 | OS Controller Expecting reply
[task 2021-01-07T03:29:10.963Z] 03:29:10     INFO -  "CONSOLE_MESSAGE: (info) No chrome package registered for chrome://branding/locale/brand.properties"
[task 2021-01-07T03:29:10.963Z] 03:29:10     INFO -  PID 7404 | OS Agent Method SET_DEBUG succeeded
[task 2021-01-07T03:29:10.964Z] 03:29:10     INFO -  PID 7404 | OS Agent Sending positive reply  id is 1
[task 2021-01-07T03:29:10.964Z] 03:29:10     INFO -  PID 7404 | OS Agent Received message {"fun":"writeAtomic","args":[{"string":"/var/folders/dz/nmd20w0x70d8whltfm6tpd3r000017/T/compression.lz"},{"data":"[Uint8Array 0 1024]"},{"compression":"lz4","bytes":1024}],"id":2}
[task 2021-01-07T03:29:10.964Z] 03:29:10     INFO -  PID 7404 | OS Agent Calling method writeAtomic
[task 2021-01-07T03:29:10.964Z] 03:29:10     INFO -  PID 7404 | OS Controller Received message from worker {"id":1,"timeStamps":{"entered":1609989851180,"loaded":1609989851223}}
[task 2021-01-07T03:29:10.964Z] 03:29:10     INFO -  PID 7404 | OS Attempting to declare FFI  workerlz4_maxCompressedSize
[task 2021-01-07T03:29:10.964Z] 03:29:10     INFO -  PID 7404 | OS Function workerlz4_maxCompressedSize declared
[task 2021-01-07T03:29:10.965Z] 03:29:10     INFO -  PID 7404 | OS Attempting to declare FFI  workerlz4_compress
[task 2021-01-07T03:29:10.966Z] 03:29:10     INFO -  PID 7404 | OS Function workerlz4_compress declared
[task 2021-01-07T03:29:10.966Z] 03:29:10     INFO -  PID 7404 | OS Attempting to declare FFI  open
[task 2021-01-07T03:29:10.966Z] 03:29:10     INFO -  PID 7404 | OS Function open declared
[task 2021-01-07T03:29:10.966Z] 03:29:10     INFO -  PID 7404 | OS Attempting to declare FFI  write
[task 2021-01-07T03:29:10.966Z] 03:29:10     INFO -  PID 7404 | OS Function write declared
[task 2021-01-07T03:29:10.966Z] 03:29:10     INFO -  PID 7404 | OS Agent Method writeAtomic succeeded
[task 2021-01-07T03:29:10.966Z] 03:29:10     INFO -  PID 7404 | OS Agent Sending positive reply 281 id is 2
[task 2021-01-07T03:29:10.966Z] 03:29:10     INFO -  PID 7404 | OS Controller Received message from worker {"ok":281,"id":2}
[task 2021-01-07T03:29:10.966Z] 03:29:10     INFO -  "Compressed 1024 bytes into 281"
[task 2021-01-07T03:29:10.966Z] 03:29:10     INFO -  "Reading back with lz4 decompression"
[task 2021-01-07T03:29:10.966Z] 03:29:10     INFO -  PID 7404 | OS Controller Posting message {"fun":"read","args":[{"string":"/var/folders/dz/nmd20w0x70d8whltfm6tpd3r000017/T/compression.lz"},{"compression":"lz4"},{"compression":"lz4"}],"id":3}
[task 2021-01-07T03:29:10.966Z] 03:29:10     INFO -  PID 7404 | OS Controller Message posted
[task 2021-01-07T03:29:10.966Z] 03:29:10     INFO -  PID 7404 | OS Controller Expecting reply
[task 2021-01-07T03:29:10.966Z] 03:29:10     INFO -  PID 7404 | OS Agent Received message {"fun":"read","args":[{"string":"/var/folders/dz/nmd20w0x70d8whltfm6tpd3r000017/T/compression.lz"},{"compression":"lz4"},{"compression":"lz4"}],"id":3}
[task 2021-01-07T03:29:10.966Z] 03:29:10     INFO -  PID 7404 | OS Agent Calling method read
[task 2021-01-07T03:29:10.966Z] 03:29:10     INFO -  PID 7404 | OS Attempting to declare FFI  fstat$INODE64
[task 2021-01-07T03:29:10.967Z] 03:29:10     INFO -  PID 7404 | OS Function fstat$INODE64 declared
[task 2021-01-07T03:29:10.967Z] 03:29:10     INFO -  PID 7404 | OS Attempting to declare FFI  posix_fadvise
[task 2021-01-07T03:29:10.967Z] 03:29:10     INFO -  PID 7404 | OS Could not declare function  posix_fadvise Error: couldn't find function symbol in library
[task 2021-01-07T03:29:10.967Z] 03:29:10     INFO -  PID 7404 | OS Attempting to declare FFI  read
[task 2021-01-07T03:29:10.967Z] 03:29:10     INFO -  PID 7404 | OS Function read declared
[task 2021-01-07T03:29:10.967Z] 03:29:10     INFO -  PID 7404 | OS Attempting to declare FFI  workerlz4_decompress
[task 2021-01-07T03:29:10.968Z] 03:29:10     INFO -  PID 7404 | OS Function workerlz4_decompress declared
[task 2021-01-07T03:29:10.968Z] 03:29:10     INFO -  PID 7404 | OS Agent Method read succeeded
[task 2021-01-07T03:29:10.968Z] 03:29:10     INFO -  PID 7404 | OS Agent Sending positive reply {"data":"[Object 0 1024]","meta":{"transfers":[{}]}} id is 3
[task 2021-01-07T03:29:10.968Z] 03:29:10     INFO -  PID 7404 | OS Controller Received message from worker {"ok":"[Object 0 1024]","id":3}
[task 2021-01-07T03:29:10.968Z] 03:29:10     INFO -  "Decompressed into 1024 bytes"
[task 2021-01-07T03:29:10.969Z] 03:29:10     INFO -  TEST-PASS | toolkit/components/osfile/tests/xpcshell/test_compression.js | test_compress_lz4 - [test_compress_lz4 : 29] "0,1,2,3,4,5,6,7,8,9,10,11,12,13,14,15,16,17,18,19,20,21,22,23,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,48,49,50,51,52,53,54,55,56,57,58,59,60,61,62,63,64,65,66,67,68,69,70,71,72,73,74,75,76,77,78,79,80,81,82,83,84,85,86,87,88,89,90,91,92,93,94,95,96,97,98,99,100,101,102,103,104,105,106,107,108,109,110,111,112,113,114,115,116,117,118,119,120,121,122,123,124,125,126,127,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143,144,145,146,147,148,149,150,151,152,153,154,155,156,157,158,159,160,161,162,163,164,165,166,167,168,169,170,171,172,173,174,175,176,177,178,179,180,181,182,183,184,185,186,187,188,189,190,191,192,193,194,195,196,197,198,199,200,201,202,203,204,205,206,207,208,209,210,211,212,213,214,215,216,217,218,219,220,221,222,223,224,225,226,227,228,229,230,231,232,233,234,235,236,237,238,239,240,241,242,243,244,245,246,247,248,249,250,251,252,253,254,255,0,1,2,3,4,5,6,7,8,9,10,11,12,13,14,15,16,17,18,19,20,21,22,23,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,48,49,50,51,52,53,54,55,56,57,58,59,60,61,62,63,64,65,66,67,68,69,70,71,72,73,74,75,76,77,78,79,80,81,82,83,84,85,86,87,88,89,90,91,92,93,94,95,96,97,98,99,100,101,102,103,104,105,106,107,108,109,110,111,112,113,114,115,116,117,118,119,120,121,122,123,124,125,126,127,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143,144,145,146,147,148,149,150,151,152,153,154,155,156,157,158,159,160,161,162,163,164,165,166,167,168,169,170,171,172,173,174,175,176,177,178,179,180,181,182,183,184,185,186,187,188,189,190,191,192,193,194,195,196,197,198,199,200,201,202,203,204,205,206,207,208,209,210,211,212,213,214,215,216,217,218,219,220,221,222,223,224,225,226,227,228,229,230,231,232,233,234,235,236,237,238,239,240,241,242,243,244,245,246,247,248,249,250,251,252,253,254,255,0,1,2,3,4,5,6,7,8,9,10,11,12,13,14,15,16,17,18,19,20,21,22,23,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,48,49,50,51,52,53,54,55,56,57,58,59,60,61,62,63,64,65,66,67,68,69,70,71,72,73,74,75,76,77,78,79,80,81,82,83,84,85,86,87,88,89,90,91,92,93,94,95,96,97,98,99,100,101,102,103,104,105,106,107,108,109,110,111,112,113,114,115,116,117,118,119,120,121,122,123,124,125,126,127,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143,144,145,146,147,148,149,150,151,152,153,154,155,156,157,158,159,160,161,162,163,164,165,166,167,168,169,170,171,172,173,174,175,176,177,178,179,180,181,182,183,184,185,186,187,188,189,190,191,192,193,194,195,196,197,198,199,200,201,202,203,204,205,206,207,208,209,210,211,212,213,214,215,216,217,218,219,220,221,222,223,224,225,226,227,228,229,230,231,232,233,234,235,236,237,238,239,240,241,242,243,244,245,246,247,248,249,250,251,252,253,254,255,0,1,2,3,4,5,6,7,8,9,10,11,12,13,14,15,16,17,18,19,20,21,22,23,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,48,49,50,51,52,53,54,55,56,57,58,59,60,61,62,63,64,65,66,67,68,69,70,71,72,73,74,75,76,77,78,79,80,81,82,83,84,85,86,87,88,89,90,91,92,93,94,95,96,97,98,99,100,101,102,103,104,105,106,107,108,109,110,111,112,113,114,115,116,117,118,119,120,121,122,123,124,125,126,127,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143,144,145,146,147,148,149,150,151,152,153,154,155,156,157,158,159,160,161,162,163,164,165,166,167,168,169,170,171,172,173,174,175,176,177,178,179,180,181,182,183,184,185,186,187,188,189,190,191,192,193,194,195,196,197,198,199,200,201,202,203,204,205,206,207,208,209,210,211,212,213,214,215,216,217,218,219,220,221,222,223,224,225,226,227,228,229,230,231,232,233,234,235,236,237,238,239,240,241,242,243,244,245,246,247,248,249,250,251,252,253,254,255" == "0,1,2,3,4,5,6,7,8,9,10,11,12,13,14,15,16,17,18,19,20,21,22,23,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,48,49,50,51,52,53,54,55,56,57,58,59,60,61,62,63,64,65,66,67,68,69,70,71,72,73,74,75,76,77,78,79,80,81,82,83,84,85,86,87,88,89,90,91,92,93,94,95,96,97,98,99,100,101,102,103,104,105,106,107,108,109,110,111,112,113,114,115,116,117,118,119,120,121,122,123,124,125,126,127,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143,144,145,146,147,148,149,150,151,152,153,154,155,156,157,158,159,160,161,162,163,164,165,166,167,168,169,170,171,172,173,174,175,176,177,178,179,180,181,182,183,184,185,186,187,188,189,190,191,192,193,194,195,196,197,198,199,200,201,202,203,204,205,206,207,208,209,210,211,212,213,214,215,216,217,218,219,220,221,222,223,224,225,226,227,228,229,230,231,232,233,234,235,236,237,238,239,240,241,242,243,244,245,246,247,248,249,250,251,252,253,254,255,0,1,2,3,4,5,6,7,8,9,10,11,12,13,14,15,16,17,18,19,20,21,22,23,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,48,49,50,51,52,53,54,55,56,57,58,59,60,61,62,63,64,65,66,67,68,69,70,71,72,73,74,75,76,77,78,79,80,81,82,83,84,85,86,87,88,89,90,91,92,93,94,95,96,97,98,99,100,101,102,103,104,105,106,107,108,109,110,111,112,113,114,115,116,117,118,119,120,121,122,123,124,125,126,127,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143,144,145,146,147,148,149,150,151,152,153,154,155,156,157,158,159,160,161,162,163,164,165,166,167,168,169,170,171,172,173,174,175,176,177,178,179,180,181,182,183,184,185,186,187,188,189,190,191,192,193,194,195,196,197,198,199,200,201,202,203,204,205,206,207,208,209,210,211,212,213,214,215,216,217,218,219,220,221,222,223,224,225,226,227,228,229,230,231,232,233,234,235,236,237,238,239,240,241,242,243,244,245,246,247,248,249,250,251,252,253,254,255,0,1,2,3,4,5,6,7,8,9,10,11,12,13,14,15,16,17,18,19,20,21,22,23,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,48,49,50,51,52,53,54,55,56,57,58,59,60,61,62,63,64,65,66,67,68,69,70,71,72,73,74,75,76,77,78,79,80,81,82,83,84,85,86,87,88,89,90,91,92,93,94,95,96,97,98,99,100,101,102,103,104,105,106,107,108,109,110,111,112,113,114,115,116,117,118,119,120,121,122,123,124,125,126,127,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143,144,145,146,147,148,149,150,151,152,153,154,155,156,157,158,159,160,161,162,163,164,165,166,167,168,169,170,171,172,173,174,175,176,177,178,179,180,181,182,183,184,185,186,187,188,189,190,191,192,193,194,195,196,197,198,199,200,201,202,203,204,205,206,207,208,209,210,211,212,213,214,215,216,217,218,219,220,221,222,223,224,225,226,227,228,229,230,231,232,233,234,235,236,237,238,239,240,241,242,243,244,245,246,247,248,249,250,251,252,253,254,255,0,1,2,3,4,5,6,7,8,9,10,11,12,13,14,15,16,17,18,19,20,21,22,23,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,48,49,50,51,52,53,54,55,56,57,58,59,60,61,62,63,64,65,66,67,68,69,70,71,72,73,74,75,76,77,78,79,80,81,82,83,84,85,86,87,88,89,90,91,92,93,94,95,96,97,98,99,100,101,102,103,104,105,106,107,108,109,110,111,112,113,114,115,116,117,118,119,120,121,122,123,124,125,126,127,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143,144,145,146,147,148,149,150,151,152,153,154,155,156,157,158,159,160,161,162,163,164,165,166,167,168,169,170,171,172,173,174,175,176,177,178,179,180,181,182,183,184,185,186,187,188,189,190,191,192,193,194,195,196,197,198,199,200,201,202,203,204,205,206,207,208,209,210,211,212,213,214,215,216,217,218,219,220,221,222,223,224,225,226,227,228,229,230,231,232,233,234,235,236,237,238,239,240,241,242,243,244,245,246,247,248,249,250,251,252,253,254,255"
[task 2021-01-07T03:29:10.970Z] 03:29:10     INFO -  (xpcshell/head.js) | test run_next_test 1 pending (3)
[task 2021-01-07T03:29:10.970Z] 03:29:10     INFO -  (xpcshell/head.js) | test test_compress_lz4 finished (3)
[task 2021-01-07T03:29:10.970Z] 03:29:10     INFO -  toolkit/components/osfile/tests/xpcshell/test_compression.js | Starting test_uncompressed
[task 2021-01-07T03:29:10.970Z] 03:29:10     INFO -  (xpcshell/head.js) | test test_uncompressed pending (3)
[task 2021-01-07T03:29:10.970Z] 03:29:10     INFO -  "Writing data without compression"
[task 2021-01-07T03:29:10.970Z] 03:29:10     INFO -  (xpcshell/head.js) | test run_next_test 1 finished (3)
[task 2021-01-07T03:29:10.970Z] 03:29:10     INFO -  PID 7404 | OS Controller Posting message {"fun":"read","args":[{"string":"/var/folders/dz/nmd20w0x70d8whltfm6tpd3r000017/T/no_compression.tmp"},{"compression":"lz4"},{"compression":"lz4"}],"id":4}
[task 2021-01-07T03:29:10.970Z] 03:29:10     INFO -  PID 7404 | OS Controller Message posted
[task 2021-01-07T03:29:10.971Z] 03:29:10     INFO -  PID 7404 | OS Controller Expecting reply
[task 2021-01-07T03:29:10.971Z] 03:29:10     INFO -  PID 7404 | OS Agent Received message {"fun":"read","args":[{"string":"/var/folders/dz/nmd20w0x70d8whltfm6tpd3r000017/T/no_compression.tmp"},{"compression":"lz4"},{"compression":"lz4"}],"id":4}
[task 2021-01-07T03:29:10.971Z] 03:29:10     INFO -  PID 7404 | OS Agent Calling method read
[task 2021-01-07T03:29:10.971Z] 03:29:10     INFO -  PID 7404 | OS Agent Error while calling agent method read Invalid header (no magic number) - Data: /var/folders/dz/nmd20w0x70d8whltfm6tpd3r000017/T/no_compression.tmp
[task 2021-01-07T03:29:10.971Z] 03:29:10     INFO -  PID 7404 | OS Agent Sending back regular error Invalid header (no magic number) - Data: /var/folders/dz/nmd20w0x70d8whltfm6tpd3r000017/T/no_compression.tmp  id is 4
[task 2021-01-07T03:29:10.971Z] 03:29:10     INFO -  PID 7404 | JavaScript error: , line 0: uncaught exception: Object
[task 2021-01-07T03:29:10.971Z] 03:29:10     INFO -  "CONSOLE_MESSAGE: (error) [JavaScript Error: "uncaught exception: Object"]"
[task 2021-01-07T03:29:10.971Z] 03:29:10     INFO -  <<<<<<<
[task 2021-01-07T03:29:10.971Z] 03:29:10     INFO -  xpcshell return code: None
[task 2021-01-07T03:29:10.971Z] 03:29:10     INFO -  toolkit/components/osfile/tests/xpcshell/test_compression.js | Process still running after test!
[task 2021-01-07T03:29:10.982Z] 03:29:10     INFO -  TEST-START | toolkit/components/promiseworker/tests/xpcshell/test_Promise.js
[task 2021-01-07T03:34:11.102Z] 03:34:11  WARNING -  TEST-UNEXPECTED-TIMEOUT | toolkit/components/promiseworker/tests/xpcshell/test_Promise.js | Test timed out
[task 2021-01-07T03:34:11.103Z] 03:34:11     INFO -  TEST-INFO took 300111ms
[task 2021-01-07T03:34:11.103Z] 03:34:11     INFO -  >>>>>>>
[task 2021-01-07T03:34:11.103Z] 03:34:11     INFO -  PID 7451 | [Parent 7451, 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:2916
[task 2021-01-07T03:34:11.103Z] 03:34:11     INFO -  TEST-PASS | toolkit/components/promiseworker/tests/xpcshell/test_Promise.js | undefined assertion name - true == true
[task 2021-01-07T03:34:11.103Z] 03:34:11     INFO -  (xpcshell/head.js) | test MAIN run_test pending (1)
[task 2021-01-07T03:34:11.103Z] 03:34:11     INFO -  (xpcshell/head.js) | test run_next_test 0 pending (2)
[task 2021-01-07T03:34:11.103Z] 03:34:11     INFO -  (xpcshell/head.js) | test MAIN run_test finished (2)
[task 2021-01-07T03:34:11.103Z] 03:34:11     INFO -  running event loop
[task 2021-01-07T03:34:11.103Z] 03:34:11     INFO -  PID 7451 | Couldn't convert chrome URL: chrome://branding/locale/brand.properties
[task 2021-01-07T03:34:11.103Z] 03:34:11     INFO -  PID 7451 | [Parent 7451, Main Thread] WARNING: Could not get the program name for a cubeb stream.: 'NS_SUCCEEDED(rv)', file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp:387
[task 2021-01-07T03:34:11.103Z] 03:34:11     INFO -  toolkit/components/promiseworker/tests/xpcshell/test_Promise.js | Starting test_simple_args
[task 2021-01-07T03:34:11.103Z] 03:34:11     INFO -  (xpcshell/head.js) | test test_simple_args pending (2)
[task 2021-01-07T03:34:11.103Z] 03:34:11     INFO -  (xpcshell/head.js) | test run_next_test 0 finished (2)
[task 2021-01-07T03:34:11.103Z] 03:34:11     INFO -  "Controller: Posting message [object Object]"
[task 2021-01-07T03:34:11.103Z] 03:34:11     INFO -  PID 7451 | [Parent 7451, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, kKnownEsrVersion) failed with result 0x80004002 (NS_NOINTERFACE): file /builds/worker/checkouts/gecko/toolkit/components/resistfingerprinting/nsRFPService.cpp:744
[task 2021-01-07T03:34:11.103Z] 03:34:11     INFO -  "Controller: Message posted"
[task 2021-01-07T03:34:11.103Z] 03:34:11     INFO -  "Controller: Expecting reply"
[task 2021-01-07T03:34:11.103Z] 03:34:11     INFO -  "CONSOLE_MESSAGE: (info) No chrome package registered for chrome://branding/locale/brand.properties"
[task 2021-01-07T03:34:11.103Z] 03:34:11     INFO -  PID 7451 | Worker: Received message [object Object]
[task 2021-01-07T03:34:11.104Z] 03:34:11     INFO -  PID 7451 | Worker: Calling method bounce
[task 2021-01-07T03:34:11.104Z] 03:34:11     INFO -  PID 7451 | Worker: Method bounce succeeded
[task 2021-01-07T03:34:11.104Z] 03:34:11     INFO -  PID 7451 | Worker: Sending positive reply test_simple_args,0.4922480305999374 id is 1
[task 2021-01-07T03:34:11.104Z] 03:34:11     INFO -  "Controller: Received message from worker [object Object]"
[task 2021-01-07T03:34:11.104Z] 03:34:11     INFO -  TEST-PASS | toolkit/components/promiseworker/tests/xpcshell/test_Promise.js | test_simple_args - [test_simple_args : 24] "[\\"test_simple_args\\",0.4922480305999374]" == "[\\"test_simple_args\\",0.4922480305999374]"
[task 2021-01-07T03:34:11.104Z] 03:34:11     INFO -  (xpcshell/head.js) | test run_next_test 1 pending (2)
[task 2021-01-07T03:34:11.104Z] 03:34:11     INFO -  (xpcshell/head.js) | test test_simple_args finished (2)
[task 2021-01-07T03:34:11.104Z] 03:34:11     INFO -  toolkit/components/promiseworker/tests/xpcshell/test_Promise.js | Starting test_no_args
[task 2021-01-07T03:34:11.105Z] 03:34:11     INFO -  (xpcshell/head.js) | test test_no_args pending (2)
[task 2021-01-07T03:34:11.105Z] 03:34:11     INFO -  "Controller: Posting message [object Object]"
[task 2021-01-07T03:34:11.105Z] 03:34:11     INFO -  PID 7451 | Worker: Received message [object Object]
[task 2021-01-07T03:34:11.105Z] 03:34:11     INFO -  "Controller: Message posted"
[task 2021-01-07T03:34:11.105Z] 03:34:11     INFO -  PID 7451 | Worker: Calling method bounce
[task 2021-01-07T03:34:11.105Z] 03:34:11     INFO -  PID 7451 | Worker: Method bounce succeeded
[task 2021-01-07T03:34:11.105Z] 03:34:11     INFO -  "Controller: Expecting reply"
[task 2021-01-07T03:34:11.105Z] 03:34:11     INFO -  PID 7451 | Worker: Sending positive reply  id is 2
[task 2021-01-07T03:34:11.106Z] 03:34:11     INFO -  (xpcshell/head.js) | test run_next_test 1 finished (2)
[task 2021-01-07T03:34:11.106Z] 03:34:11     INFO -  "Controller: Received message from worker [object Object]"
[task 2021-01-07T03:34:11.106Z] 03:34:11     INFO -  TEST-PASS | toolkit/components/promiseworker/tests/xpcshell/test_Promise.js | test_no_args - [test_no_args : 30] "[]" == "[]"
[task 2021-01-07T03:34:11.106Z] 03:34:11     INFO -  (xpcshell/head.js) | test run_next_test 2 pending (2)
[task 2021-01-07T03:34:11.106Z] 03:34:11     INFO -  (xpcshell/head.js) | test test_no_args finished (2)
[task 2021-01-07T03:34:11.106Z] 03:34:11     INFO -  toolkit/components/promiseworker/tests/xpcshell/test_Promise.js | Starting test_promise_args
[task 2021-01-07T03:34:11.106Z] 03:34:11     INFO -  (xpcshell/head.js) | test test_promise_args pending (2)
[task 2021-01-07T03:34:11.106Z] 03:34:11     INFO -  (xpcshell/head.js) | test run_next_test 2 finished (2)
[task 2021-01-07T03:34:11.106Z] 03:34:11     INFO -  "Controller: Posting message [object Object]"
[task 2021-01-07T03:34:11.106Z] 03:34:11     INFO -  PID 7451 | Worker: Received message [object Object]
[task 2021-01-07T03:34:11.106Z] 03:34:11     INFO -  PID 7451 | Worker: Calling method bounce
[task 2021-01-07T03:34:11.106Z] 03:34:11     INFO -  "Controller: Message posted"
[task 2021-01-07T03:34:11.106Z] 03:34:11     INFO -  PID 7451 | Worker: Method bounce succeeded
[task 2021-01-07T03:34:11.107Z] 03:34:11     INFO -  PID 7451 | Worker: Sending positive reply test_promise_args,0.17715510396266865 id is 3
[task 2021-01-07T03:34:11.107Z] 03:34:11     INFO -  "Controller: Expecting reply"
[task 2021-01-07T03:34:11.107Z] 03:34:11     INFO -  "Controller: Received message from worker [object Object]"
[task 2021-01-07T03:34:11.107Z] 03:34:11     INFO -  TEST-PASS | toolkit/components/promiseworker/tests/xpcshell/test_Promise.js | test_promise_args - [test_promise_args : 38] "[\\"test_promise_args\\",0.17715510396266865]" == "[\\"test_promise_args\\",0.17715510396266865]"
[task 2021-01-07T03:34:11.107Z] 03:34:11     INFO -  (xpcshell/head.js) | test run_next_test 3 pending (2)
[task 2021-01-07T03:34:11.107Z] 03:34:11     INFO -  (xpcshell/head.js) | test test_promise_args finished (2)
[task 2021-01-07T03:34:11.108Z] 03:34:11     INFO -  toolkit/components/promiseworker/tests/xpcshell/test_Promise.js | Starting test_delayed_promise_args
[task 2021-01-07T03:34:11.108Z] 03:34:11     INFO -  (xpcshell/head.js) | test test_delayed_promise_args pending (2)
[task 2021-01-07T03:34:11.108Z] 03:34:11     INFO -  (xpcshell/head.js) | test run_next_test 3 finished (2)
[task 2021-01-07T03:34:11.108Z] 03:34:11     INFO -  "Controller: Posting message [object Object]"
[task 2021-01-07T03:34:11.108Z] 03:34:11     INFO -  PID 7451 | Worker: Received message [object Object]
[task 2021-01-07T03:34:11.108Z] 03:34:11     INFO -  "Controller: Message posted"
[task 2021-01-07T03:34:11.108Z] 03:34:11     INFO -  PID 7451 | Worker: Calling method bounce
[task 2021-01-07T03:34:11.108Z] 03:34:11     INFO -  "Controller: Expecting reply"
[task 2021-01-07T03:34:11.109Z] 03:34:11     INFO -  PID 7451 | Worker: Method bounce succeeded
[task 2021-01-07T03:34:11.109Z] 03:34:11     INFO -  PID 7451 | Worker: Sending positive reply test_delayed_promise_args,0.5288102172825481 id is 4
[task 2021-01-07T03:34:11.109Z] 03:34:11     INFO -  "Controller: Received message from worker [object Object]"
[task 2021-01-07T03:34:11.109Z] 03:34:11     INFO -  TEST-PASS | toolkit/components/promiseworker/tests/xpcshell/test_Promise.js | test_delayed_promise_args - [test_delayed_promise_args : 49] "[\\"test_delayed_promise_args\\",0.5288102172825481]" == "[\\"test_delayed_promise_args\\",0.5288102172825481]"
[task 2021-01-07T03:34:11.109Z] 03:34:11     INFO -  (xpcshell/head.js) | test run_next_test 4 pending (2)
[task 2021-01-07T03:34:11.109Z] 03:34:11     INFO -  (xpcshell/head.js) | test test_delayed_promise_args finished (2)
[task 2021-01-07T03:34:11.109Z] 03:34:11     INFO -  toolkit/components/promiseworker/tests/xpcshell/test_Promise.js | Starting test_rejected_promise_args
[task 2021-01-07T03:34:11.109Z] 03:34:11     INFO -  (xpcshell/head.js) | test test_rejected_promise_args pending (2)
[task 2021-01-07T03:34:11.110Z] 03:34:11     INFO -  (xpcshell/head.js) | test run_next_test 4 finished (2)
[task 2021-01-07T03:34:11.110Z] 03:34:11     INFO -  "I threw the right error"
[task 2021-01-07T03:34:11.110Z] 03:34:11     INFO -  (xpcshell/head.js) | test run_next_test 5 pending (2)
[task 2021-01-07T03:34:11.110Z] 03:34:11     INFO -  (xpcshell/head.js) | test test_rejected_promise_args finished (2)
[task 2021-01-07T03:34:11.110Z] 03:34:11     INFO -  toolkit/components/promiseworker/tests/xpcshell/test_Promise.js | Starting test_transfer_args
[task 2021-01-07T03:34:11.110Z] 03:34:11     INFO -  (xpcshell/head.js) | test test_transfer_args pending (2)
[task 2021-01-07T03:34:11.110Z] 03:34:11     INFO -  TEST-PASS | toolkit/components/promiseworker/tests/xpcshell/test_Promise.js | test_transfer_args - [test_transfer_args : 73] The buffer is not detached yet - 4 == 4
[task 2021-01-07T03:34:11.110Z] 03:34:11     INFO -  (xpcshell/head.js) | test run_next_test 5 finished (2)
[task 2021-01-07T03:34:11.110Z] 03:34:11     INFO -  "Controller: Posting message [object Object]"
[task 2021-01-07T03:34:11.110Z] 03:34:11     INFO -  "Controller: Message posted"
[task 2021-01-07T03:34:11.111Z] 03:34:11     INFO -  PID 7451 | Worker: Received message [object Object]
[task 2021-01-07T03:34:11.111Z] 03:34:11     INFO -  "Controller: Expecting reply"
[task 2021-01-07T03:34:11.112Z] 03:34:11     INFO -  PID 7451 | Worker: Calling method bounce
[task 2021-01-07T03:34:11.112Z] 03:34:11     INFO -  PID 7451 | Worker: Method bounce succeeded
[task 2021-01-07T03:34:11.112Z] 03:34:11     INFO -  PID 7451 | Worker: Sending positive reply [object ArrayBuffer] id is 5
[task 2021-01-07T03:34:11.112Z] 03:34:11     INFO -  "Controller: Received message from worker [object Object]"
[task 2021-01-07T03:34:11.112Z] 03:34:11     INFO -  TEST-PASS | toolkit/components/promiseworker/tests/xpcshell/test_Promise.js | test_transfer_args - [test_transfer_args : 80] The buffer has been detached - 0 == 0
[task 2021-01-07T03:34:11.112Z] 03:34:11     INFO -  TEST-PASS | toolkit/components/promiseworker/tests/xpcshell/test_Promise.js | test_transfer_args - [test_transfer_args : 83] The result has the right size - 4 == 4
[task 2021-01-07T03:34:11.112Z] 03:34:11     INFO -  TEST-PASS | toolkit/components/promiseworker/tests/xpcshell/test_Promise.js | test_transfer_args - [test_transfer_args : 86] 0 == 0
[task 2021-01-07T03:34:11.112Z] 03:34:11     INFO -  TEST-PASS | toolkit/components/promiseworker/tests/xpcshell/test_Promise.js | test_transfer_args - [test_transfer_args : 86] 1 == 1
[task 2021-01-07T03:34:11.112Z] 03:34:11     INFO -  TEST-PASS | toolkit/components/promiseworker/tests/xpcshell/test_Promise.js | test_transfer_args - [test_transfer_args : 86] 2 == 2
[task 2021-01-07T03:34:11.112Z] 03:34:11     INFO -  TEST-PASS | toolkit/components/promiseworker/tests/xpcshell/test_Promise.js | test_transfer_args - [test_transfer_args : 86] 3 == 3
[task 2021-01-07T03:34:11.112Z] 03:34:11     INFO -  (xpcshell/head.js) | test run_next_test 6 pending (2)
[task 2021-01-07T03:34:11.112Z] 03:34:11     INFO -  (xpcshell/head.js) | test test_transfer_args finished (2)
[task 2021-01-07T03:34:11.112Z] 03:34:11     INFO -  toolkit/components/promiseworker/tests/xpcshell/test_Promise.js | Starting test_transfer_with_meta
[task 2021-01-07T03:34:11.112Z] 03:34:11     INFO -  (xpcshell/head.js) | test test_transfer_with_meta pending (2)
[task 2021-01-07T03:34:11.112Z] 03:34:11     INFO -  TEST-PASS | toolkit/components/promiseworker/tests/xpcshell/test_Promise.js | test_transfer_with_meta - [test_transfer_with_meta : 96] The buffer is not detached yet - 4 == 4
[task 2021-01-07T03:34:11.113Z] 03:34:11     INFO -  (xpcshell/head.js) | test run_next_test 6 finished (2)
[task 2021-01-07T03:34:11.113Z] 03:34:11     INFO -  "Controller: Posting message [object Object]"
[task 2021-01-07T03:34:11.113Z] 03:34:11     INFO -  PID 7451 | Worker: Received message [object Object]
[task 2021-01-07T03:34:11.114Z] 03:34:11     INFO -  "Controller: Message posted"
[task 2021-01-07T03:34:11.114Z] 03:34:11     INFO -  PID 7451 | Worker: Calling method bounce
[task 2021-01-07T03:34:11.114Z] 03:34:11     INFO -  "Controller: Expecting reply"
[task 2021-01-07T03:34:11.114Z] 03:34:11     INFO -  PID 7451 | Worker: Method bounce succeeded
[task 2021-01-07T03:34:11.114Z] 03:34:11     INFO -  PID 7451 | Worker: Sending positive reply 0,1,2,3 id is 6
[task 2021-01-07T03:34:11.114Z] 03:34:11     INFO -  "Controller: Received message from worker [object Object]"
[task 2021-01-07T03:34:11.114Z] 03:34:11     INFO -  TEST-PASS | toolkit/components/promiseworker/tests/xpcshell/test_Promise.js | test_transfer_with_meta - [test_transfer_with_meta : 104] The buffer has been detached - 0 == 0
[task 2021-01-07T03:34:11.114Z] 03:34:11     INFO -  TEST-PASS | toolkit/components/promiseworker/tests/xpcshell/test_Promise.js | test_transfer_with_meta - [test_transfer_with_meta : 107] The result appears to be a Typed Array - "[object Uint8Array]" == "[object Uint8Array]"
[task 2021-01-07T03:34:11.114Z] 03:34:11     INFO -  TEST-PASS | toolkit/components/promiseworker/tests/xpcshell/test_Promise.js | test_transfer_with_meta - [test_transfer_with_meta : 112] The result has the right size - 4 == 4
[task 2021-01-07T03:34:11.114Z] 03:34:11     INFO -  TEST-PASS | toolkit/components/promiseworker/tests/xpcshell/test_Promise.js | test_transfer_with_meta - [test_transfer_with_meta : 115] 0 == 0
[task 2021-01-07T03:34:11.114Z] 03:34:11     INFO -  TEST-PASS | toolkit/components/promiseworker/tests/xpcshell/test_Promise.js | test_transfer_with_meta - [test_transfer_with_meta : 115] 1 == 1
[task 2021-01-07T03:34:11.119Z] 03:34:11     INFO -  TEST-PASS | toolkit/components/promiseworker/tests/xpcshell/test_Promise.js | test_transfer_with_meta - [test_transfer_with_meta : 115] 2 == 2
[task 2021-01-07T03:34:11.119Z] 03:34:11     INFO -  TEST-PASS | toolkit/components/promiseworker/tests/xpcshell/test_Promise.js | test_transfer_with_meta - [test_transfer_with_meta : 115] 3 == 3
[task 2021-01-07T03:34:11.119Z] 03:34:11     INFO -  (xpcshell/head.js) | test run_next_test 7 pending (2)
[task 2021-01-07T03:34:11.119Z] 03:34:11     INFO -  (xpcshell/head.js) | test test_transfer_with_meta finished (2)
[task 2021-01-07T03:34:11.119Z] 03:34:11     INFO -  toolkit/components/promiseworker/tests/xpcshell/test_Promise.js | Starting test_throw_error
[task 2021-01-07T03:34:11.119Z] 03:34:11     INFO -  (xpcshell/head.js) | test test_throw_error pending (2)
[task 2021-01-07T03:34:11.119Z] 03:34:11     INFO -  (xpcshell/head.js) | test run_next_test 7 finished (2)
[task 2021-01-07T03:34:11.119Z] 03:34:11     INFO -  "Controller: Posting message [object Object]"
[task 2021-01-07T03:34:11.119Z] 03:34:11     INFO -  "Controller: Message posted"
[task 2021-01-07T03:34:11.119Z] 03:34:11     INFO -  PID 7451 | Worker: Received message [object Object]
[task 2021-01-07T03:34:11.119Z] 03:34:11     INFO -  PID 7451 | Worker: Calling method throwError
[task 2021-01-07T03:34:11.119Z] 03:34:11     INFO -  "Controller: Expecting reply"
[task 2021-01-07T03:34:11.119Z] 03:34:11     INFO -  PID 7451 | Worker: Error while calling agent method throwError Error: error message throwError@chrome://promiseworker/content/worker.js:34:11
[task 2021-01-07T03:34:11.120Z] 03:34:11     INFO -  PID 7451 | worker.dispatch@chrome://promiseworker/content/worker.js:15:23
[task 2021-01-07T03:34:11.120Z] 03:34:11     INFO -  PID 7451 | handleMessage@resource://gre/modules/workers/PromiseWorker.js:130:27
[task 2021-01-07T03:34:11.120Z] 03:34:11     INFO -  PID 7451 | @chrome://promiseworker/content/worker.js:26:48
[task 2021-01-07T03:34:11.120Z] 03:34:11     INFO -  PID 7451 | Worker: Sending back regular error Error: error message throwError@chrome://promiseworker/content/worker.js:34:11
[task 2021-01-07T03:34:11.120Z] 03:34:11     INFO -  PID 7451 | worker.dispatch@chrome://promiseworker/content/worker.js:15:23
[task 2021-01-07T03:34:11.120Z] 03:34:11     INFO -  PID 7451 | handleMessage@resource://gre/modules/workers/PromiseWorker.js:130:27
[task 2021-01-07T03:34:11.120Z] 03:34:11     INFO -  PID 7451 | @chrome://promiseworker/content/worker.js:26:48
[task 2021-01-07T03:34:11.120Z] 03:34:11     INFO -  PID 7451 |  id is 7
[task 2021-01-07T03:34:11.120Z] 03:34:11     INFO -  PID 7451 | JavaScript error: chrome://promiseworker/content/worker.js, line 34: Error: error message
[task 2021-01-07T03:34:11.120Z] 03:34:11     INFO -  "CONSOLE_MESSAGE: (error) [JavaScript Error: "Error: error message" {file: "chrome://promiseworker/content/worker.js" line: 34}]"
[task 2021-01-07T03:34:11.120Z] 03:34:11     INFO -  <<<<<<<
[task 2021-01-07T03:34:11.121Z] 03:34:11     INFO -  xpcshell return code: None
[task 2021-01-07T03:34:11.121Z] 03:34:11     INFO -  toolkit/components/promiseworker/tests/xpcshell/test_Promise.js | Process still running after test!
...

Flags: needinfo?(emalysz)

Bogdan Tara[:bogdan_tara | bogdant]

Comment 5

•

4 years ago

Also seeing the following starting with the backed out changes: https://treeherder.mozilla.org/logviewer?job_id=326032543&repo=autoland&lineNumber=49084

BugBot [:suhaib / :marco/ :calixte]

Comment 6

•

3 years ago

There's a r+ patch which didn't land and no activity in this bug for 2 weeks.
:emalysz, could you have a look please?
For more information, please visit auto_nag documentation.

Flags: needinfo?(emalysz)

Emma Malysz

Comment 7

•

3 years ago

Attached file Bug 1649605, part 1: provide async support for promise workers — Details

Phabricator Automation

Updated

•

3 years ago

Attachment #9194450 - Attachment description: Bug 1649605: remove OS.File import from SessionWorker.jsm and replace OS.File usage in SessionWorker.js → WIP: Bug 1649605: remove OS.File import from SessionWorker.jsm and replace OS.File usage in SessionWorker.js

Emma Malysz

Updated

•

3 years ago

Flags: needinfo?(emalysz)

Keywords: leave-open

Pulsebot

Comment 8

•

3 years ago

Pushed by emalysz@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/0d0287d563b9
part 1: provide async support for promise workers r=barret,asuth

Narcis Beleuzu [:NarcisB]

Comment 9

•

3 years ago

bugherder

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

Emma Malysz

Comment 10

•

3 years ago

This bug is now up for grabs. The WIP patch attached was failing due to a linux mochitest suite timeout

Assignee: emalysz → nobody

Status: ASSIGNED → NEW

Mathew Hodson

Assignee

Comment 11

•

3 years ago

Attached file Bug 1649605 - Replace osfile.jsm usage in SessionWorker.jsm. r?Gijs — Details

Co-authored-by: Mathew Hodson <mathew.hodson@gmail.com>

Phabricator Automation

Updated

•

3 years ago

Assignee: nobody → mathew.hodson

Status: NEW → ASSIGNED

Mathew Hodson

Assignee

Updated

•

3 years ago

Component: OS.File → Session Restore

Keywords: leave-open

Product: Toolkit → Firefox

Phabricator Automation

Updated

•

3 years ago

Attachment #9194450 - Attachment is obsolete: true

Pulsebot

Comment 12

•

3 years ago

Pushed by mbanner@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/f54285c09367
Replace osfile.jsm usage in SessionWorker.jsm. r=Gijs

Marian-Vasile Laza

Comment 13

•

3 years ago

bugherder

https://hg.mozilla.org/mozilla-central/rev/f54285c09367

Status: ASSIGNED → RESOLVED

Closed: 3 years ago

status-firefox96: --- → fixed

Resolution: --- → FIXED

Target Milestone: --- → 96 Branch

:Gijs (he/him)

Updated

•

2 years ago

Blocks: 1752853

Marco Castelluccio [:marco]

Updated

•

2 years ago

Regressions: 1749996

Bug 1649605, remove OS.File usage from SessionWorker.jsm 4 years ago Emma Malysz 47 bytes, text/x-phabricator-request		Details \| Review
WIP: Bug 1649605: remove OS.File import from SessionWorker.jsm and replace OS.File usage in SessionWorker.js 4 years ago Emma Malysz 48 bytes, text/x-phabricator-request		Details \| Review
Bug 1649605, part 1: provide async support for promise workers 3 years ago Emma Malysz 48 bytes, text/x-phabricator-request		Details \| Review
Bug 1649605 - Replace osfile.jsm usage in SessionWorker.jsm. r?Gijs 3 years ago Mathew Hodson 48 bytes, text/x-phabricator-request		Details \| Review