1649610 - SharedDataMap.jsm imports OS.File during startup

Reporter

Description

•

4 years ago

•

According to this startup profile, SharedDataMap.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::CycleCollectedJSContext::AfterProcessTask(unsigned int) [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]
onStartup [resource://messaging-system/experiments/ExperimentManager.jsm:82:17]
init [resource://messaging-system/lib/SharedDataMap.jsm:57:12]
js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) [libxul.so]
Interpret(JSContext*, js::RunState&) [libxul.so]
<name omitted> [libxul.so]
js::CallGetter(JSContext*, JS::Handle<JS::Value>, JS::Handle<JS::Value>, JS::MutableHandle<JS::Value>) [libxul.so]
js::RunScript []
js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) [libxul.so]
get [resource://gre/modules/XPCOMUtils.jsm:124:20]
0xff4eaa5dbc7 []
js::jit::DoCallFallback(JSContext*, js::jit::BaselineFrame*, js::jit::ICCall_Fallback*, unsigned int, JS::Value*, JS::MutableHandle<JS::Value>) [libxul.so]
js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) [libxul.so]
js::fun_apply(JSContext*, unsigned int, JS::Value*) [libxul.so]
js::fun_call(JSContext*, unsigned int, JS::Value*) [libxul.so]
js::RunScript []
> SharedDataMap/< [resource://messaging-system/lib/SharedDataMap.jsm:44:50]
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]
profiler_get_backtrace() [libxul.so]
Registers::SyncPopulate() [libxul.so]

Barret Rennie [:barret] (they/them)

Reporter

Updated

•

4 years ago

Blocks: 1649611

Barret Rennie [:barret] (they/them)

Reporter

Updated

•

4 years ago

No longer blocks: 1649611

Emma Malysz

Updated

•

4 years ago

Depends on: 1671035

Barret Rennie [:barret] (they/them)

Reporter

Updated

•

4 years ago

Depends on: 1674311

Bernard Igiri

Assignee

Updated

•

4 years ago

Assignee: nobody → bigiri

Bernard Igiri

Assignee

Comment 1

•

4 years ago

Attached file Bug 1649610 - Remove OS.File from SharedDataMap.jsm -r=emalysz,gijs,k88hudson,andreio — Details

The OS.File code here doesn't seem to be necessary so I removed it.

Phabricator Automation

Updated

•

3 years ago

Attachment #9188962 - Attachment description: Bug 1649610 - Remove OS.File from SharedDataMap.jsm (WIP) → Bug 1649610 - Remove OS.File from SharedDataMap.jsm -r=emalysz

Andrei Oprea [:andreio]

Comment 2

•

3 years ago

We're using file access so early because we want to load any existing user experiments at startup.
In bug 1680371 we're migrating "early startup" experiments to prefs. It might be an alternative to delay disk access until later (do something with idleDispatchToMainThread) and rely on prefs for anything that is needed early on.

Phabricator Automation

Updated

•

3 years ago

Attachment #9188962 - Attachment description: Bug 1649610 - Remove OS.File from SharedDataMap.jsm -r=emalysz → Bug 1649610 - Remove OS.File from SharedDataMap.jsm -r=emalysz,gijs,andreio

Phabricator Automation

Updated

•

3 years ago

Attachment #9188962 - Attachment description: Bug 1649610 - Remove OS.File from SharedDataMap.jsm -r=emalysz,gijs,andreio → Bug 1649610 - Remove OS.File from SharedDataMap.jsm -r=emalysz,gijs,k88hudson,andreio

BugBot [:suhaib / :marco/ :calixte]

Comment 3

•

3 years ago

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

Flags: needinfo?(bigiri)

Pulsebot

Comment 4

•

3 years ago

Pushed by gijskruitbosch@gmail.com:
https://hg.mozilla.org/integration/autoland/rev/4f5d08880ea8
Remove OS.File from SharedDataMap.jsm -r=emalysz,gijs,k88hudson,andreio

Bogdan Tara[:bogdan_tara | bogdant]

Comment 5

•

3 years ago

Backed out changeset 4f5d08880ea8 (bug 1649610) for browser/components/* and toolkit/components/* failures.

Push with failures: https://treeherder.mozilla.org/jobs?repo=autoland&group_state=expanded&searchStr=linux%2C18.04%2Cx64%2Casan%2Copt%2Cxpcshell%2Ctests%2Ctest-linux1804-64-asan%2Fopt-xpcshell-e10s%2Cx2&fromchange=057a059129e3e9221baf6711645484dcadf19378&tochange=1a97194d80a068dc098183b36deea6a9e236d76f&selectedTaskRun=GRVKMUfMTqmLYpWViTkbFg.0

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

Failures logs:
https://treeherder.mozilla.org/logviewer?job_id=326396245&repo=autoland&lineNumber=3066

[task 2021-01-11T22:43:33.500Z] 22:43:33     INFO -  TEST-START | toolkit/components/cleardata/tests/unit/test_basic.js
[task 2021-01-11T22:43:34.644Z] 22:43:34  WARNING -  TEST-UNEXPECTED-FAIL | toolkit/components/cleardata/tests/unit/test_basic.js | xpcshell return code: 1
[task 2021-01-11T22:43:34.645Z] 22:43:34     INFO -  TEST-INFO took 1140ms
[task 2021-01-11T22:43:34.645Z] 22:43:34     INFO -  >>>>>>>
[task 2021-01-11T22:43:34.645Z] 22:43:34     INFO -  (xpcshell/head.js) | test MAIN run_test pending (1)
[task 2021-01-11T22:43:34.646Z] 22:43:34     INFO -  (xpcshell/head.js) | test run_next_test 0 pending (2)
[task 2021-01-11T22:43:34.646Z] 22:43:34     INFO -  (xpcshell/head.js) | test MAIN run_test finished (2)
[task 2021-01-11T22:43:34.646Z] 22:43:34     INFO -  running event loop
[task 2021-01-11T22:43:34.647Z] 22:43:34     INFO -  toolkit/components/cleardata/tests/unit/test_basic.js | Starting test_basic
[task 2021-01-11T22:43:34.647Z] 22:43:34     INFO -  (xpcshell/head.js) | test test_basic pending (2)
[task 2021-01-11T22:43:34.647Z] 22:43:34     INFO -  TEST-PASS | toolkit/components/cleardata/tests/unit/test_basic.js | test_basic - [test_basic : 11] true == true
[task 2021-01-11T22:43:34.647Z] 22:43:34     INFO -  PID 28494 | AddressSanitizer:DEADLYSIGNAL
[task 2021-01-11T22:43:34.648Z] 22:43:34     INFO -  PID 28494 | =================================================================
[task 2021-01-11T22:43:34.648Z] 22:43:34    ERROR -  PID 28494 | ==28494==ERROR: AddressSanitizer: SEGV on unknown address 0x000000000040 (pc 0x7f71aea1b7b6 bp 0x7ffd8de77470 sp 0x7ffd8de77450 T0)
[task 2021-01-11T22:43:34.648Z] 22:43:34     INFO -  PID 28494 | ==28494==The signal is caused by a READ memory access.
...

https://treeherder.mozilla.org/logviewer?job_id=326396130&repo=autoland&lineNumber=3084

[task 2021-01-11T22:30:37.180Z] 22:30:37     INFO -  TEST-START | browser/components/migration/tests/unit/test_Chrome_bookmarks.js
[task 2021-01-11T22:30:37.288Z] 22:30:37  WARNING -  TEST-UNEXPECTED-FAIL | browser/components/migration/tests/unit/test_Chrome_bookmarks.js | xpcshell return code: -11
[task 2021-01-11T22:30:37.289Z] 22:30:37     INFO -  TEST-INFO took 109ms
[task 2021-01-11T22:30:37.289Z] 22:30:37     INFO -  >>>>>>>
[task 2021-01-11T22:30:37.289Z] 22:30:37     INFO -  PID 26263 | ExceptionHandler::GenerateDump cloned child 26275
[task 2021-01-11T22:30:37.289Z] 22:30:37     INFO -  PID 26263 | ExceptionHandler::SendContinueSignalToChild sent continue signal to child
[task 2021-01-11T22:30:37.289Z] 22:30:37     INFO -  PID 26263 | ExceptionHandler::WaitForContinueSignal waiting for continue signal...
[task 2021-01-11T22:30:37.289Z] 22:30:37     INFO -  <<<<<<<
[task 2021-01-11T22:30:43.208Z] 22:30:43  WARNING -  PROCESS-CRASH | browser/components/migration/tests/unit/test_Chrome_bookmarks.js | application crashed [@ nsFrameMessageManager::SharedData()]
[task 2021-01-11T22:30:43.209Z] 22:30:43     INFO -  Crash dump filename: /tmp/xpc-other-euBGcz/14d5643c-5440-5473-369f-1f5548ee6408.dmp
[task 2021-01-11T22:30:43.209Z] 22:30:43     INFO -  Operating system: Linux
[task 2021-01-11T22:30:43.210Z] 22:30:43     INFO -                    0.0.0 Linux 4.4.0-1014-aws #14taskcluster1-Ubuntu SMP Tue Apr 3 10:27:00 UTC 2018 x86_64
[task 2021-01-11T22:30:43.210Z] 22:30:43     INFO -  CPU: amd64
[task 2021-01-11T22:30:43.210Z] 22:30:43     INFO -       family 6 model 85 stepping 7
[task 2021-01-11T22:30:43.210Z] 22:30:43     INFO -       2 CPUs
[task 2021-01-11T22:30:43.211Z] 22:30:43     INFO -  GPU: UNKNOWN
[task 2021-01-11T22:30:43.211Z] 22:30:43     INFO -  Crash reason:  SIGSEGV /SEGV_MAPERR
[task 2021-01-11T22:30:43.211Z] 22:30:43     INFO -  Crash address: 0x38
[task 2021-01-11T22:30:43.211Z] 22:30:43     INFO -  Process uptime: not available
[task 2021-01-11T22:30:43.212Z] 22:30:43     INFO -  Thread 0 (crashed)
[task 2021-01-11T22:30:43.212Z] 22:30:43     INFO -   0  libxul.so!nsFrameMessageManager::SharedData() [nsFrameMessageManager.cpp:4f5d08880ea8c7a6bd59c45c5cfd1fd74c524818 : 943 + 0x0]
[task 2021-01-11T22:30:43.212Z] 22:30:43     INFO -      rax = 0x0000000000000000   rdx = 0x00007fa55fde5980
[task 2021-01-11T22:30:43.213Z] 22:30:43     INFO -      rcx = 0x00007ffcfd48e7a0   rbx = 0x0000000000000000
[task 2021-01-11T22:30:43.213Z] 22:30:43     INFO -      rsi = 0x00007ffcfd48e678   rdi = 0x0000000000000000
[task 2021-01-11T22:30:43.213Z] 22:30:43     INFO -      rbp = 0x00007ffcfd48e5d0   rsp = 0x00007ffcfd48e5c0
[task 2021-01-11T22:30:43.213Z] 22:30:43     INFO -       r8 = 0x00007fa55f6f7ae0    r9 = 0x00007fa55f6f7a60
[task 2021-01-11T22:30:43.214Z] 22:30:43     INFO -      r10 = 0xffff800000000000   r11 = 0xfffe000000000000
[task 2021-01-11T22:30:43.214Z] 22:30:43     INFO -      r12 = 0x00007fa55fde5980   r13 = 0x0000000000000000
[task 2021-01-11T22:30:43.214Z] 22:30:43     INFO -      r14 = 0x00007ffcfd48e7a0   r15 = 0x00007fa55ff1a000
[task 2021-01-11T22:30:43.214Z] 22:30:43     INFO -      rip = 0x00007fa573d499f7
[task 2021-01-11T22:30:43.215Z] 22:30:43     INFO -      Found by: given as instruction pointer in context
[task 2021-01-11T22:30:43.215Z] 22:30:43     INFO -   1  libxul.so!mozilla::dom::ContentProcessMessageManager::GetSharedData() [ContentProcessMessageManager.cpp:4f5d08880ea8c7a6bd59c45c5cfd1fd74c524818 : 49 + 0x5]
[task 2021-01-11T22:30:43.215Z] 22:30:43     INFO -      rbx = 0x0000000000000000   rbp = 0x00007ffcfd48e5f0
[task 2021-01-11T22:30:43.215Z] 22:30:43     INFO -      rsp = 0x00007ffcfd48e5e0   r12 = 0x00007fa55fde5980
[task 2021-01-11T22:30:43.215Z] 22:30:43     INFO -      r13 = 0x0000000000000000   r14 = 0x00007ffcfd48e7a0
[task 2021-01-11T22:30:43.216Z] 22:30:43     INFO -      r15 = 0x00007fa55ff1a000   rip = 0x00007fa573dad8bf
[task 2021-01-11T22:30:43.216Z] 22:30:43     INFO -      Found by: call frame info
[task 2021-01-11T22:30:43.216Z] 22:30:43     INFO -   2  libxul.so!mozilla::dom::ContentProcessMessageManager_Binding::get_sharedData(JSContext*, JS::Handle<JSObject*>, void*, JSJitGetterCallArgs) [MessageManagerBinding.cpp: : 2784 + 0x8]
[task 2021-01-11T22:30:43.216Z] 22:30:43     INFO -      rbx = 0x0000000000000000   rbp = 0x00007ffcfd48e640
[task 2021-01-11T22:30:43.216Z] 22:30:43     INFO -      rsp = 0x00007ffcfd48e600   r12 = 0x00007fa55fde5980
[task 2021-01-11T22:30:43.217Z] 22:30:43     INFO -      r13 = 0x0000000000000000   r14 = 0x00007ffcfd48e7a0
[task 2021-01-11T22:30:43.217Z] 22:30:43     INFO -      r15 = 0x00007fa55ff1a000   rip = 0x00007fa574114a2a
[task 2021-01-11T22:30:43.217Z] 22:30:43     INFO -      Found by: call frame info
[task 2021-01-11T22:30:43.217Z] 22:30:43     INFO -   3  libxul.so!bool mozilla::dom::binding_detail::GenericGetter<mozilla::dom::binding_detail::NormalThisPolicy, mozilla::dom::binding_detail::ThrowExceptions>(JSContext*, unsigned int, JS::Value*) [BindingUtils.cpp:4f5d08880ea8c7a6bd59c45c5cfd1fd74c524818 : 3113 + 0x9]
[task 2021-01-11T22:30:43.218Z] 22:30:43     INFO -      rbx = 0x00007ffcfd48e7a0   rbp = 0x00007ffcfd48e6c0
[task 2021-01-11T22:30:43.218Z] 22:30:43     INFO -      rsp = 0x00007ffcfd48e650   r12 = 0x0000000000000066
[task 2021-01-11T22:30:43.219Z] 22:30:43     INFO -      r13 = 0x0000000000000000   r14 = 0x00007fa55ff1a000
[task 2021-01-11T22:30:43.219Z] 22:30:43     INFO -      r15 = 0x00007fa5783cafa0   rip = 0x00007fa57483ec5a
[task 2021-01-11T22:30:43.219Z] 22:30:43     INFO -      Found by: call frame info
...

https://treeherder.mozilla.org/logviewer?job_id=326395853&repo=autoland&lineNumber=4489

[task 2021-01-11T22:33:41.697Z] 22:33:41     INFO - TEST-START | browser/components/newtab/test/browser/browser_aboutwelcome_multistage.js
[task 2021-01-11T22:33:41.745Z] 22:33:41     INFO - TEST-INFO | started process screentopng
[task 2021-01-11T22:33:42.150Z] 22:33:42     INFO - TEST-INFO | screentopng: exit 0
[task 2021-01-11T22:33:42.151Z] 22:33:42     INFO - Buffered messages logged at 22:33:41
[task 2021-01-11T22:33:42.154Z] 22:33:42     INFO - TEST-PASS | browser/components/newtab/test/browser/browser_aboutwelcome_multistage.js | Sanity check the temporary file doesn't exist. - true == true - 
[task 2021-01-11T22:33:42.154Z] 22:33:42     INFO - Entering test bound test_multistage_zeroOnboarding_experimentAPI
[task 2021-01-11T22:33:42.154Z] 22:33:42     INFO - Buffered messages finished
[task 2021-01-11T22:33:42.154Z] 22:33:42     INFO - TEST-UNEXPECTED-FAIL | browser/components/newtab/test/browser/browser_aboutwelcome_multistage.js | Uncaught exception - at resource://messaging-system/lib/SharedDataMap.jsm:84 - Error: Setting values from within a content process is not allowed
[task 2021-01-11T22:33:42.155Z] 22:33:42     INFO - Stack trace:
[task 2021-01-11T22:33:42.155Z] 22:33:42     INFO - set@resource://messaging-system/lib/SharedDataMap.jsm:84:13
[task 2021-01-11T22:33:42.155Z] 22:33:42     INFO - addExperiment@resource://messaging-system/experiments/ExperimentStore.jsm:185:10
[task 2021-01-11T22:33:42.155Z] 22:33:42     INFO - test_multistage_zeroOnboarding_experimentAPI@chrome://mochitests/content/browser/browser/components/newtab/test/browser/browser_aboutwelcome_multistage.js:202:24
[task 2021-01-11T22:33:42.156Z] 22:33:42     INFO - Leaving test bound test_multistage_zeroOnboarding_experimentAPI
[task 2021-01-11T22:33:42.156Z] 22:33:42     INFO - Entering test bound test_multistage_aboutwelcome_experimentAPI
[task 2021-01-11T22:33:42.156Z] 22:33:42     INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-01-11T22:33:42.156Z] 22:33:42     INFO - TEST-UNEXPECTED-FAIL | browser/components/newtab/test/browser/browser_aboutwelcome_multistage.js | Uncaught exception - at resource://messaging-system/lib/SharedDataMap.jsm:84 - Error: Setting values from within a content process is not allowed
[task 2021-01-11T22:33:42.157Z] 22:33:42     INFO - Stack trace:
[task 2021-01-11T22:33:42.157Z] 22:33:42     INFO - set@resource://messaging-system/lib/SharedDataMap.jsm:84:13
[task 2021-01-11T22:33:42.158Z] 22:33:42     INFO - addExperiment@resource://messaging-system/experiments/ExperimentStore.jsm:185:10
[task 2021-01-11T22:33:42.158Z] 22:33:42     INFO - test_multistage_aboutwelcome_experimentAPI@chrome://mochitests/content/browser/browser/components/newtab/test/browser/browser_aboutwelcome_multistage.js:251:24
[task 2021-01-11T22:33:42.158Z] 22:33:42     INFO - Leaving test bound test_multistage_aboutwelcome_experimentAPI
...

https://treeherder.mozilla.org/logviewer?job_id=326397682&repo=autoland&lineNumber=4632

...
[task 2021-01-11T22:52:33.416Z] 22:52:33     INFO - Entering test bound test_messaging_system_about_studies
[task 2021-01-11T22:52:33.416Z] 22:52:33     INFO - Buffered messages finished
[task 2021-01-11T22:52:33.420Z] 22:52:33     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/normandy/test/browser/browser_about_studies.js | Uncaught exception - at resource://messaging-system/lib/SharedDataMap.jsm:84 - Error: Setting values from within a content process is not allowed
[task 2021-01-11T22:52:33.420Z] 22:52:33     INFO - Stack trace:
[task 2021-01-11T22:52:33.420Z] 22:52:33     INFO - set@resource://messaging-system/lib/SharedDataMap.jsm:84:13
[task 2021-01-11T22:52:33.420Z] 22:52:33     INFO - addExperiment@resource://messaging-system/experiments/ExperimentStore.jsm:185:10
[task 2021-01-11T22:52:33.420Z] 22:52:33     INFO - enroll@resource://messaging-system/experiments/ExperimentManager.jsm:241:16
[task 2021-01-11T22:52:33.420Z] 22:52:33     INFO - Leaving test bound test_messaging_system_about_studies
[task 2021-01-11T22:52:33.420Z] 22:52:33     INFO - GECKO(5205) | MEMORY STAT | vsize 20975331MB | residentFast 1167MB
[task 2021-01-11T22:52:33.420Z] 22:52:33     INFO - TEST-OK | toolkit/components/normandy/test/browser/browser_about_studies.js | took 7748ms

https://treeherder.mozilla.org/logviewer?job_id=326395923&repo=autoland&lineNumber=6003

[task 2021-01-11T22:38:45.698Z] 22:38:45     INFO - TEST-START | toolkit/components/messaging-system/test/browser/browser_remotesettings_experiment_enroll.js
[task 2021-01-11T22:38:45.740Z] 22:38:45     INFO - GECKO(5863) | console.debug: RSLoader:
[task 2021-01-11T22:38:45.741Z] 22:38:45     INFO - GECKO(5863) |   Registered update timer
[task 2021-01-11T22:38:45.741Z] 22:38:45     INFO - GECKO(5863) | console.debug: RSLoader:
[task 2021-01-11T22:38:45.742Z] 22:38:45     INFO - GECKO(5863) |   Updating recipes
[task 2021-01-11T22:38:45.830Z] 22:38:45     INFO - GECKO(5863) | console.debug: RSLoader:
[task 2021-01-11T22:38:45.830Z] 22:38:45     INFO - GECKO(5863) |   Got 1 recipes from Remote Settings
[task 2021-01-11T22:38:45.839Z] 22:38:45     INFO - GECKO(5863) | console.debug: RSLoader:
[task 2021-01-11T22:38:45.839Z] 22:38:45     INFO - GECKO(5863) |   No targeting for recipe, so it matches automatically
[task 2021-01-11T22:38:45.839Z] 22:38:45     INFO - GECKO(5863) | console.debug: RSLoader:
[task 2021-01-11T22:38:45.839Z] 22:38:45     INFO - GECKO(5863) |   f91cf6f8-acfe-4956-9d36-81f946e623db matched
[task 2021-01-11T22:38:45.875Z] 22:38:45     INFO - GECKO(5863) | JavaScript error: resource://messaging-system/lib/SharedDataMap.jsm, line 84: Error: Setting values from within a content process is not allowed
[task 2021-01-11T22:40:15.724Z] 22:40:15     INFO - TEST-INFO | started process screentopng
[task 2021-01-11T22:40:16.118Z] 22:40:16     INFO - TEST-INFO | screentopng: exit 0
[task 2021-01-11T22:40:16.118Z] 22:40:16     INFO - Buffered messages logged at 22:38:45
[task 2021-01-11T22:40:16.118Z] 22:40:16     INFO - TEST-PASS | toolkit/components/messaging-system/test/browser/browser_remotesettings_experiment_enroll.js | Sanity check the temporary file doesn't exist. - true == true - 
[task 2021-01-11T22:40:16.118Z] 22:40:16     INFO - Entering test bound setup
[task 2021-01-11T22:40:16.118Z] 22:40:16     INFO - Leaving test bound setup
[task 2021-01-11T22:40:16.118Z] 22:40:16     INFO - Entering test bound test_experimentEnrollment
[task 2021-01-11T22:40:16.118Z] 22:40:16     INFO - Console message: [JavaScript Error: "Unknown Collection "main/nimbus-desktop-experiments"" {file: "resource://services-settings/RemoteSettingsClient.jsm" line: 160}]
[task 2021-01-11T22:40:16.118Z] 22:40:16     INFO - UnknownCollectionError@resource://services-settings/RemoteSettingsClient.jsm:160:5
[task 2021-01-11T22:40:16.118Z] 22:40:16     INFO - sync@resource://services-settings/RemoteSettingsClient.jsm:470:13
[task 2021-01-11T22:40:16.118Z] 22:40:16     INFO - 
[task 2021-01-11T22:40:16.118Z] 22:40:16     INFO - Console message: [JavaScript Error: "Error: Setting values from within a content process is not allowed" {file: "resource://messaging-system/lib/SharedDataMap.jsm" line: 84}]
[task 2021-01-11T22:40:16.118Z] 22:40:16     INFO - Buffered messages finished
[task 2021-01-11T22:40:16.118Z] 22:40:16     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/messaging-system/test/browser/browser_remotesettings_experiment_enroll.js | Test timed out - 
[task 2021-01-11T22:40:16.118Z] 22:40:16     INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-01-11T22:40:16.118Z] 22:40:16     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/messaging-system/test/browser/browser_remotesettings_experiment_enroll.js | A promise chain failed to handle a rejection: Setting values from within a content process is not allowed - stack: set@resource://messaging-system/lib/SharedDataMap.jsm:84:13
[task 2021-01-11T22:40:16.118Z] 22:40:16     INFO - addExperiment@resource://messaging-system/experiments/ExperimentStore.jsm:185:10
[task 2021-01-11T22:40:16.118Z] 22:40:16     INFO - enroll@resource://messaging-system/experiments/ExperimentManager.jsm:241:16
[task 2021-01-11T22:40:16.118Z] 22:40:16     INFO - Rejection date: Mon Jan 11 2021 22:38:45 GMT+0000 (Coordinated Universal Time) - false == true - JS frame :: resource://testing-common/PromiseTestUtils.jsm :: assertNoUncaughtRejections :: line 282
[task 2021-01-11T22:40:16.118Z] 22:40:16     INFO - Stack trace:
[task 2021-01-11T22:40:16.118Z] 22:40:16     INFO - resource://testing-common/PromiseTestUtils.jsm:assertNoUncaughtRejections:282
[task 2021-01-11T22:40:16.118Z] 22:40:16     INFO - chrome://mochikit/content/browser-test.js:nextTest:615
[task 2021-01-11T22:40:16.118Z] 22:40:16     INFO - GECKO(5863) | MEMORY STAT vsizeMaxContiguous not supported in this build configuration.
[task 2021-01-11T22:40:16.118Z] 22:40:16     INFO - GECKO(5863) | MEMORY STAT heapAllocated not supported in this build configuration.
[task 2021-01-11T22:40:16.118Z] 22:40:16     INFO - GECKO(5863) | MEMORY STAT | vsize 20975170MB | residentFast 1155MB
[task 2021-01-11T22:40:16.118Z] 22:40:16     INFO - TEST-OK | toolkit/components/messaging-system/test/browser/browser_remotesettings_experiment_enroll.js | took 90078ms

Pulsebot

Comment 6

•

3 years ago

Pushed by rmaries@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/a673fcbd7a06
Remove OS.File from SharedDataMap.jsm -r=emalysz,gijs,k88hudson,andreio

Natalia Csoregi [:nataliaCs]

Comment 7

•

3 years ago

bugherder

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

Status: NEW → RESOLVED

Closed: 3 years ago

status-firefox86: --- → fixed

Resolution: --- → FIXED

Target Milestone: --- → 86 Branch

Bernard Igiri

Assignee

Updated

•

3 years ago

Flags: needinfo?(bigiri)

Kate Hudson :k88hudson

Updated

•

3 years ago

Regressions: 1692099

BMO Automation

Updated

•

11 months ago

Product: Toolkit → Toolkit Graveyard