Closed Bug 1688838 Opened 3 years ago Closed 3 years ago

Intermittent Assertion failure: NS_IsMainThread() (nsXPCWrappedJS::AddRef called off main thread), at /builds/worker/checkouts/gecko/js/xpconnect/src/XPCWrappedJS.cpp:241

Categories

(Core :: Networking, defect, P2)

defect

Tracking

()

RESOLVED FIXED
87 Branch
Tracking Status
firefox-esr78 --- unaffected
firefox85 --- unaffected
firefox86 --- wontfix
firefox87 --- fixed

People

(Reporter: intermittent-bug-filer, Assigned: valentin)

References

Details

(Keywords: assertion, intermittent-failure, Whiteboard: [necko-triaged])

Attachments

(2 files)

Filed by: malexandru [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=327798729&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/ZQIPZEmeSBWbvu1l7Sho1Q/runs/0/artifacts/public/logs/live_backing.log


[task 2021-01-26T09:07:07.537Z] 09:07:07     INFO -  TEST-PASS | xpcshell.ini:browser/components/extensions/test/xpcshell/test_ext_bookmarks.js | took 6251ms
[task 2021-01-26T09:07:07.578Z] 09:07:07     INFO -  TEST-START | xpcshell.ini:browser/components/extensions/test/xpcshell/test_ext_pkcs11_management.js
[task 2021-01-26T09:07:08.530Z] 09:07:08  WARNING -  TEST-UNEXPECTED-FAIL | xpcshell.ini:browser/components/extensions/test/xpcshell/test_ext_pkcs11_management.js | xpcshell return code: 1
[task 2021-01-26T09:07:08.530Z] 09:07:08     INFO -  TEST-INFO took 947ms
[task 2021-01-26T09:07:08.530Z] 09:07:08     INFO -  >>>>>>>
[task 2021-01-26T09:07:08.531Z] 09:07:08     INFO -  PID 14380 | [Parent 14380, Main Thread] WARNING: Failed to get directory to cache.: file /builds/worker/checkouts/gecko/security/sandbox/win/src/sandboxbroker/sandboxBroker.cpp:119
[task 2021-01-26T09:07:08.531Z] 09:07:08     INFO -  PID 14380 | [Parent 14380, Main Thread] WARNING: Failed to get directory to cache.: file /builds/worker/checkouts/gecko/security/sandbox/win/src/sandboxbroker/sandboxBroker.cpp:119
[task 2021-01-26T09:07:08.531Z] 09:07:08     INFO -  PID 14380 | [Parent 14380, Main Thread] WARNING: Failed to get directory to cache.: file /builds/worker/checkouts/gecko/security/sandbox/win/src/sandboxbroker/sandboxBroker.cpp:119
[task 2021-01-26T09:07:08.531Z] 09:07:08     INFO -  PID 14380 | [Parent 14380, Main Thread] WARNING: Failed to get directory to cache.: file /builds/worker/checkouts/gecko/security/sandbox/win/src/sandboxbroker/sandboxBroker.cpp:119
[task 2021-01-26T09:07:08.531Z] 09:07:08     INFO -  PID 14380 | [Parent 14380, Main Thread] WARNING: Failed to get directory to cache.: file /builds/worker/checkouts/gecko/security/sandbox/win/src/sandboxbroker/sandboxBroker.cpp:119
[task 2021-01-26T09:07:08.531Z] 09:07:08     INFO -  PID 14380 | [Parent 14380, 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-26T09:07:08.531Z] 09:07:08     INFO -  PID 14380 | [Parent 14380, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, kKnownEsrVersion) failed with result 0x80004002 (NS_NOINTERFACE): file /builds/worker/checkouts/gecko/toolkit/components/resistfingerprinting/nsRFPService.cpp:748
[task 2021-01-26T09:07:08.531Z] 09:07:08     INFO -  (xpcshell/head.js) | test MAIN run_test pending (1)
[task 2021-01-26T09:07:08.531Z] 09:07:08     INFO -  (xpcshell/head.js) | test run_next_test 0 pending (2)
[task 2021-01-26T09:07:08.531Z] 09:07:08     INFO -  (xpcshell/head.js) | test MAIN run_test finished (2)
[task 2021-01-26T09:07:08.531Z] 09:07:08     INFO -  running event loop
[task 2021-01-26T09:07:08.531Z] 09:07:08     INFO -  xpcshell.ini:browser/components/extensions/test/xpcshell/test_ext_pkcs11_management.js | Starting test_pkcs11
[task 2021-01-26T09:07:08.531Z] 09:07:08     INFO -  (xpcshell/head.js) | test test_pkcs11 pending (2)
[task 2021-01-26T09:07:08.532Z] 09:07:08     INFO -  (xpcshell/head.js) | test run_next_test 0 finished (2)
[task 2021-01-26T09:07:08.532Z] 09:07:08     INFO -  PID 14380 | Assertion failure: NS_IsMainThread() (nsXPCWrappedJS::AddRef called off main thread), at /builds/worker/checkouts/gecko/js/xpconnect/src/XPCWrappedJS.cpp:241
[task 2021-01-26T09:07:08.532Z] 09:07:08     INFO -  Initializing stack-fixing for the first stack frame, this may take a while...
[task 2021-01-26T09:07:25.192Z] 09:07:25     INFO -  PID 14380 | #01: nsComponentManagerImpl::CreateInstanceByContractID(char const*, nsISupports*, nsID const&, void**) [xpcom/components/nsComponentManager.cpp:1145]
[task 2021-01-26T09:07:25.192Z] 09:07:25     INFO -  PID 14380 | #02: nsCreateInstanceByContractID::operator()(nsID const&, void**) const [xpcom/components/nsComponentManagerUtils.cpp:173]
[task 2021-01-26T09:07:25.192Z] 09:07:25     INFO -  PID 14380 | #03: nsCOMPtr<nsIWindowsRegKey>::nsCOMPtr(nsCOMPtr_helper const&) [xpcom/base/nsCOMPtr.h:652]
[task 2021-01-26T09:07:25.192Z] 09:07:25     INFO -  PID 14380 | #04: nsNotifyAddrListener::CheckAdaptersAddresses::<unnamed-tag>::operator()(nsTSubstring<char16_t> const&) const [netwerk/system/win32/nsNotifyAddrListener.cpp:515]
[task 2021-01-26T09:07:25.192Z] 09:07:25     INFO -  PID 14380 | #05: nsNotifyAddrListener::CheckAdaptersAddresses() [netwerk/system/win32/nsNotifyAddrListener.cpp:550]
[task 2021-01-26T09:07:25.193Z] 09:07:25     INFO -  PID 14380 | #06: nsNotifyAddrListener::CheckLinkStatus() [netwerk/system/win32/nsNotifyAddrListener.cpp:649]
[task 2021-01-26T09:07:25.193Z] 09:07:25     INFO -  fix-stacks: error: failed to read symbols file `Z:\task_1611650106\build\symbols\WINNSI.DLL\5E7052FA57A9CE26FFDE2F15EFF335C41\WINNSI.DLL.sym` for `C:\\Windows\\SYSTEM32\\WINNSI.DLL`
[task 2021-01-26T09:07:25.193Z] 09:07:25     INFO -  fix-stacks: note: this is expected and harmless for system libraries on debug automation runs
[task 2021-01-26T09:07:25.193Z] 09:07:25     INFO -  fix-stacks: The system cannot find the path specified. (os error 3)
[task 2021-01-26T09:07:25.193Z] 09:07:25     INFO -  PID 14380 | #07: NsiDisconnectFromServer [C:\\Windows\\SYSTEM32\\WINNSI.DLL + 0x25be]
[task 2021-01-26T09:07:25.194Z] 09:07:25     INFO -  PID 14380 | #08: NsiRpcRegisterChangeNotification [C:\\Windows\\SYSTEM32\\WINNSI.DLL + 0x1466]
[task 2021-01-26T09:07:25.194Z] 09:07:25     INFO -  fix-stacks: error: failed to read symbols file `Z:\task_1611650106\build\symbols\IPHLPAPI.DLL\A2B74AC589F1B50E1A26AA48F8BD256B1\IPHLPAPI.DLL.sym` for `C:\\Windows\\SYSTEM32\\IPHLPAPI.DLL`
[task 2021-01-26T09:07:25.194Z] 09:07:25     INFO -  fix-stacks: note: this is expected and harmless for system libraries on debug automation runs
[task 2021-01-26T09:07:25.194Z] 09:07:25     INFO -  fix-stacks: The system cannot find the path specified. (os error 3)
[task 2021-01-26T09:07:25.195Z] 09:07:25     INFO -  PID 14380 | #09: NotifyIpInterfaceChange [C:\\Windows\\SYSTEM32\\IPHLPAPI.DLL + 0x4f1a]
[task 2021-01-26T09:07:25.195Z] 09:07:25     INFO -  PID 14380 | #10: NotifyIpInterfaceChange [C:\\Windows\\SYSTEM32\\IPHLPAPI.DLL + 0x4e10]
[task 2021-01-26T09:07:25.195Z] 09:07:25     INFO -  PID 14380 | #11: nsNotifyAddrListener::Run() [netwerk/system/win32/nsNotifyAddrListener.cpp:294]
[task 2021-01-26T09:07:25.195Z] 09:07:25     INFO -  PID 14380 | #12: nsThreadPool::Run() [xpcom/threads/nsThreadPool.cpp:303]
[task 2021-01-26T09:07:25.195Z] 09:07:25     INFO -  PID 14380 | #13: nsThread::ProcessNextEvent(bool, bool*) [xpcom/threads/nsThread.cpp:1163]
[task 2021-01-26T09:07:25.195Z] 09:07:25     INFO -  PID 14380 | #14: NS_ProcessNextEvent(nsIThread*, bool) [xpcom/threads/nsThreadUtils.cpp:548]
[task 2021-01-26T09:07:25.196Z] 09:07:25     INFO -  PID 14380 | #15: mozilla::ipc::MessagePumpForNonMainThreads::Run(base::MessagePump::Delegate*) [ipc/glue/MessagePump.cpp:303]
[task 2021-01-26T09:07:25.196Z] 09:07:25     INFO -  PID 14380 | #16: MessageLoop::RunHandler() [ipc/chromium/src/base/message_loop.cc:328]
[task 2021-01-26T09:07:25.196Z] 09:07:25     INFO -  PID 14380 | #17: MessageLoop::Run() [ipc/chromium/src/base/message_loop.cc:310]
[task 2021-01-26T09:07:25.196Z] 09:07:25     INFO -  PID 14380 | #18: static nsThread::ThreadFunc(void*) [xpcom/threads/nsThread.cpp:406]
[task 2021-01-26T09:07:25.519Z] 09:07:25     INFO -  PID 14380 | #19: PR_NativeRunThread(void*) [nsprpub/pr/src/threads/combined/pruthr.c:408]
[task 2021-01-26T09:07:25.519Z] 09:07:25     INFO -  PID 14380 | #20: pr_root(void*) [nsprpub/pr/src/md/windows/w95thred.c:140]
[task 2021-01-26T09:07:25.519Z] 09:07:25     INFO -  fix-stacks: error: failed to read symbols file `Z:\task_1611650106\build\symbols\ucrtbase.pdb\08A2EF04ED46F71846F69333018A073A1\ucrtbase.sym` for `C:\\Windows\\System32\\ucrtbase.dll`
[task 2021-01-26T09:07:25.519Z] 09:07:25     INFO -  fix-stacks: note: this is expected and harmless for system libraries on debug automation runs
[task 2021-01-26T09:07:25.519Z] 09:07:25     INFO -  fix-stacks: The system cannot find the path specified. (os error 3)
[task 2021-01-26T09:07:25.519Z] 09:07:25     INFO -  PID 14380 | #21: o_ceil [C:\\Windows\\System32\\ucrtbase.dll + 0x1c4be]
[task 2021-01-26T09:07:25.524Z] 09:07:25     INFO -  fix-stacks: error: failed to read symbols file `Z:\task_1611650106\build\symbols\KERNEL32.DLL\CC28E59125064F9516DBA8AD3D6420A51\KERNEL32.DLL.sym` for `C:\\Windows\\System32\\KERNEL32.DLL`
[task 2021-01-26T09:07:25.524Z] 09:07:25     INFO -  fix-stacks: note: this is expected and harmless for system libraries on debug automation runs
[task 2021-01-26T09:07:25.524Z] 09:07:25     INFO -  fix-stacks: The system cannot find the path specified. (os error 3)
[task 2021-01-26T09:07:25.524Z] 09:07:25     INFO -  PID 14380 | #22: BaseThreadInitThunk [C:\\Windows\\System32\\KERNEL32.DLL + 0x13034]
[task 2021-01-26T09:07:25.624Z] 09:07:25     INFO -  PID 14380 | #23: patched_BaseThreadInitThunk(int, void*, void*) [mozglue/dllservices/WindowsDllBlocklist.cpp:587]
[task 2021-01-26T09:07:25.624Z] 09:07:25     INFO -  fix-stacks: error: failed to read symbols file `Z:\task_1611650106\build\symbols\ntdll.pdb\D3AE91CEDD9309EF777F2FD5120010BE1\ntdll.sym` for `C:\\Windows\\SYSTEM32\\ntdll.dll`
[task 2021-01-26T09:07:25.625Z] 09:07:25     INFO -  fix-stacks: note: this is expected and harmless for system libraries on debug automation runs
[task 2021-01-26T09:07:25.625Z] 09:07:25     INFO -  fix-stacks: The system cannot find the path specified. (os error 3)
[task 2021-01-26T09:07:25.625Z] 09:07:25     INFO -  PID 14380 | #24: RtlUserThreadStart [C:\\Windows\\SYSTEM32\\ntdll.dll + 0x71461]
[task 2021-01-26T09:07:25.625Z] 09:07:25     INFO -  <<<<<<<
[task 2021-01-26T09:07:36.692Z] 09:07:36  WARNING -  PROCESS-CRASH | xpcshell.ini:browser/components/extensions/test/xpcshell/test_ext_pkcs11_management.js | application crashed [@ nsXPCWrappedJS::AddRef()]
[task 2021-01-26T09:07:36.692Z] 09:07:36     INFO -  Mozilla crash reason: MOZ_RELEASE_ASSERT(NS_IsMainThread()) (nsXPCWrappedJS::AddRef called off main thread)
[task 2021-01-26T09:07:36.693Z] 09:07:36     INFO -  Crash dump filename: c:\users\task_1611650106\appdata\local\temp\xpc-other-ueaytt\068b930d-d359-4827-b83a-7536c729f485.dmp
[task 2021-01-26T09:07:36.693Z] 09:07:36     INFO -  Operating system: Windows NT
[task 2021-01-26T09:07:36.693Z] 09:07:36     INFO -                    10.0.17134
[task 2021-01-26T09:07:36.694Z] 09:07:36     INFO -  CPU: amd64
[task 2021-01-26T09:07:36.694Z] 09:07:36     INFO -       family 6 model 85 stepping 4
[task 2021-01-26T09:07:36.694Z] 09:07:36     INFO -       8 CPUs
[task 2021-01-26T09:07:36.694Z] 09:07:36     INFO -  GPU: UNKNOWN
[task 2021-01-26T09:07:36.695Z] 09:07:36     INFO -  Crash reason:  EXCEPTION_BREAKPOINT
[task 2021-01-26T09:07:36.695Z] 09:07:36     INFO -  Crash address: 0x9731782d
[task 2021-01-26T09:07:36.695Z] 09:07:36     INFO -  Process uptime: 1 seconds
[task 2021-01-26T09:07:36.695Z] 09:07:36     INFO -  Thread 6 (crashed)
[task 2021-01-26T09:07:36.696Z] 09:07:36     INFO -   0  xul.dll!nsXPCWrappedJS::AddRef() [XPCWrappedJS.cpp:afb6bcdbdf4f7345d8b683ca7d3337fcebf27d81 : 240 + 0x0]
[task 2021-01-26T09:07:36.696Z] 09:07:36     INFO -      rax = 0x00007ffc9f10f3fa   rdx = 0x00007ffcd78ba640
[task 2021-01-26T09:07:36.696Z] 09:07:36     INFO -      rcx = 0x00007ffcc338f830   rbx = 0x0000000080040154
[task 2021-01-26T09:07:36.697Z] 09:07:36     INFO -      rsi = 0x0000014f7f875b30   rdi = 0x0000014f02d90f70
[task 2021-01-26T09:07:36.697Z] 09:07:36     INFO -      rbp = 0x0000000000000000   rsp = 0x000000316f57e780
[task 2021-01-26T09:07:36.697Z] 09:07:36     INFO -       r8 = 0x000000316f5787c8    r9 = 0x0000000000000000
[task 2021-01-26T09:07:36.697Z] 09:07:36     INFO -      r10 = 0x0000000000000000   r11 = 0x000000316f579e10
[task 2021-01-26T09:07:36.698Z] 09:07:36     INFO -      r12 = 0x0000010000000000   r13 = 0x00007ffc9f046b02
[task 2021-01-26T09:07:36.698Z] 09:07:36     INFO -      r14 = 0x0000000000d90000   r15 = 0x0000004f00000000
[task 2021-01-26T09:07:36.698Z] 09:07:36     INFO -      rip = 0x00007ffc9731782d
[task 2021-01-26T09:07:36.698Z] 09:07:36     INFO -      Found by: given as instruction pointer in context
[task 2021-01-26T09:07:36.699Z] 09:07:36     INFO -   1  xul.dll!nsFactoryEntry::GetFactory() [nsComponentManager.cpp:afb6bcdbdf4f7345d8b683ca7d3337fcebf27d81 : 1756 + 0x1a]
[task 2021-01-26T09:07:36.699Z] 09:07:36     INFO -      rbx = 0x0000000080040154   rbp = 0x0000000000000000
[task 2021-01-26T09:07:36.699Z] 09:07:36     INFO -      rsp = 0x000000316f57e7c0   r12 = 0x0000010000000000
[task 2021-01-26T09:07:36.699Z] 09:07:36     INFO -      r13 = 0x00007ffc9f046b02   r14 = 0x0000000000d90000
[task 2021-01-26T09:07:36.700Z] 09:07:36     INFO -      r15 = 0x0000004f00000000   rip = 0x00007ffc962c72d2
[task 2021-01-26T09:07:36.700Z] 09:07:36     INFO -      Found by: call frame info
[task 2021-01-26T09:07:36.700Z] 09:07:36     INFO -   2  xul.dll!nsComponentManagerImpl::CreateInstanceByContractID(char const*, nsISupports*, nsID const&, void**) [nsComponentManager.cpp:afb6bcdbdf4f7345d8b683ca7d3337fcebf27d81 : 1145 + 0x79]
[task 2021-01-26T09:07:36.700Z] 09:07:36     INFO -      rbx = 0x0000000080040154   rbp = 0x0000000000000000
[task 2021-01-26T09:07:36.701Z] 09:07:36     INFO -      rsp = 0x000000316f57e830   r12 = 0x0000010000000000
[task 2021-01-26T09:07:36.701Z] 09:07:36     INFO -      r13 = 0x00007ffc9f046b02   r14 = 0x0000000000d90000
[task 2021-01-26T09:07:36.701Z] 09:07:36     INFO -      r15 = 0x0000004f00000000   rip = 0x00007ffc962c4697
[task 2021-01-26T09:07:36.701Z] 09:07:36     INFO -      Found by: call frame info
[task 2021-01-26T09:07:36.702Z] 09:07:36     INFO -   3  xul.dll!nsCreateInstanceByContractID::operator()(nsID const&, void**) const [nsComponentManagerUtils.cpp:afb6bcdbdf4f7345d8b683ca7d3337fcebf27d81 : 171 + 0x14]
[task 2021-01-26T09:07:36.702Z] 09:07:36     INFO -      rbx = 0x0000000080040154   rbp = 0x0000000000000000
[task 2021-01-26T09:07:36.702Z] 09:07:36     INFO -      rsp = 0x000000316f57e900   r12 = 0x0000010000000000
[task 2021-01-26T09:07:36.702Z] 09:07:36     INFO -      r13 = 0x00007ffc9f046b02   r14 = 0x0000000000d90000
[task 2021-01-26T09:07:36.703Z] 09:07:36     INFO -      r15 = 0x0000004f00000000   rip = 0x00007ffc962c88dc
[task 2021-01-26T09:07:36.703Z] 09:07:36     INFO -      Found by: call frame info
[task 2021-01-26T09:07:36.703Z] 09:07:36     INFO -   4  xul.dll!nsCOMPtr<nsIWindowsRegKey>::nsCOMPtr(nsCOMPtr_helper const&) [nsCOMPtr.h:afb6bcdbdf4f7345d8b683ca7d3337fcebf27d81 : 652 + 0x20]
[task 2021-01-26T09:07:36.704Z] 09:07:36     INFO -      rbx = 0x0000000080040154   rbp = 0x0000000000000000
[task 2021-01-26T09:07:36.704Z] 09:07:36     INFO -      rsp = 0x000000316f57e940   r12 = 0x0000010000000000
[task 2021-01-26T09:07:36.704Z] 09:07:36     INFO -      r13 = 0x00007ffc9f046b02   r14 = 0x0000000000d90000
[task 2021-01-26T09:07:36.704Z] 09:07:36     INFO -      r15 = 0x0000004f00000000   rip = 0x00007ffc96a7986c
[task 2021-01-26T09:07:36.705Z] 09:07:36     INFO -      Found by: call frame info
[task 2021-01-26T09:07:36.705Z] 09:07:36     INFO -   5  xul.dll!nsNotifyAddrListener::CheckAdaptersAddresses::<unnamed-tag>::operator()(nsTSubstring<char16_t> const&) const [nsNotifyAddrListener.cpp:afb6bcdbdf4f7345d8b683ca7d3337fcebf27d81 : 513 + 0x5]
[task 2021-01-26T09:07:36.705Z] 09:07:36     INFO -      rbx = 0x0000000080040154   rbp = 0x0000000000000000
[task 2021-01-26T09:07:36.705Z] 09:07:36     INFO -      rsp = 0x000000316f57e990   r12 = 0x0000010000000000
[task 2021-01-26T09:07:36.706Z] 09:07:36     INFO -      r13 = 0x00007ffc9f046b02   r14 = 0x0000000000d90000
[task 2021-01-26T09:07:36.706Z] 09:07:36     INFO -      r15 = 0x0000004f00000000   rip = 0x00007ffc96a790f7
[task 2021-01-26T09:07:36.706Z] 09:07:36     INFO -      Found by: call frame info
[task 2021-01-26T09:07:36.706Z] 09:07:36     INFO -   6  xul.dll!nsNotifyAddrListener::CheckAdaptersAddresses() [nsNotifyAddrListener.cpp:afb6bcdbdf4f7345d8b683ca7d3337fcebf27d81 : 550 + 0x5]
[task 2021-01-26T09:07:36.707Z] 09:07:36     INFO -      rbx = 0x0000000080040154   rbp = 0x0000000000000000
[task 2021-01-26T09:07:36.707Z] 09:07:36     INFO -      rsp = 0x000000316f57ebd0   r12 = 0x0000010000000000
[task 2021-01-26T09:07:36.707Z] 09:07:36     INFO -      r13 = 0x00007ffc9f046b02   r14 = 0x0000000000d90000
[task 2021-01-26T09:07:36.707Z] 09:07:36     INFO -      r15 = 0x0000004f00000000   rip = 0x00007ffc96a78e34
[task 2021-01-26T09:07:36.708Z] 09:07:36     INFO -      Found by: call frame info
[task 2021-01-26T09:07:36.708Z] 09:07:36     INFO -   7  xul.dll!nsNotifyAddrListener::CheckLinkStatus() [nsNotifyAddrListener.cpp:afb6bcdbdf4f7345d8b683ca7d3337fcebf27d81 : 648 + 0x8]
[task 2021-01-26T09:07:36.708Z] 09:07:36     INFO -      rbx = 0x0000000080040154   rbp = 0x0000000000000000
[task 2021-01-26T09:07:36.708Z] 09:07:36     INFO -      rsp = 0x000000316f57ed00   r12 = 0x0000010000000000
[task 2021-01-26T09:07:36.709Z] 09:07:36     INFO -      r13 = 0x00007ffc9f046b02   r14 = 0x0000000000d90000
[task 2021-01-26T09:07:36.709Z] 09:07:36     INFO -      r15 = 0x0000004f00000000   rip = 0x00007ffc96a770f8
[task 2021-01-26T09:07:36.709Z] 09:07:36     INFO -      Found by: call frame info
[task 2021-01-26T09:07:36.709Z] 09:07:36     INFO -   8  winnsi.dll!EtwpDisableTraceProviders + 0x9a
[task 2021-01-26T09:07:36.710Z] 09:07:36     INFO -      rbx = 0x0000000080040154   rbp = 0x0000000000000000
[task 2021-01-26T09:07:36.710Z] 09:07:36     INFO -      rsp = 0x000000316f57ed70   r12 = 0x0000010000000000
[task 2021-01-26T09:07:36.710Z] 09:07:36     INFO -      r13 = 0x00007ffc9f046b02   r14 = 0x0000000000d90000
[task 2021-01-26T09:07:36.710Z] 09:07:36     INFO -      r15 = 0x0000004f00000000   rip = 0x00007ffcd17e25be
[task 2021-01-26T09:07:36.711Z] 09:07:36     INFO -      Found by: call frame info
[task 2021-01-26T09:07:36.711Z] 09:07:36     INFO -   9  IPHLPAPI.DLL!RtlpNewSecurityObject + 0x82c
[task 2021-01-26T09:07:36.711Z] 09:07:36     INFO -      rbx = 0x0000000080040154   rbp = 0x0000000000000000
[task 2021-01-26T09:07:36.712Z] 09:07:36     INFO -      rsp = 0x000000316f57ee20   r12 = 0x0000010000000000
[task 2021-01-26T09:07:36.712Z] 09:07:36     INFO -      r13 = 0x00007ffc9f046b02   r14 = 0x0000000000d90000
[task 2021-01-26T09:07:36.712Z] 09:07:36     INFO -      r15 = 0x0000004f00000000   rip = 0x00007ffcd6948048
[task 2021-01-26T09:07:36.712Z] 09:07:36     INFO -      Found by: call frame info
[task 2021-01-26T09:07:36.713Z] 09:07:36     INFO -  Thread 0
[task 2021-01-26T09:07:36.713Z] 09:07:36     INFO -   0  xul.dll!js::frontend::SourceCoords::indexFromOffset(unsigned int) const [TokenStream.cpp:afb6bcdbdf4f7345d8b683ca7d3337fcebf27d81 : 487 + 0x0]```

Looks like nsNotifyAddrListener::CheckAdaptersAddresses is calling do_createInstance on a contractID that, at least in this test, is JS-implemented:

https://searchfox.org/mozilla-central/rev/0b2870194375d80b54608c39060884acb758c206/netwerk/system/win32/nsNotifyAddrListener.cpp#560

Flags: needinfo?(valentin.gosu)
Component: XPConnect → Networking

It looks like there's a JS implementation of it here: testing/modules/MockRegistry.jsm. There's nothing obvious to me that's changed recently in either the JS implementation or the top few frames in the crash.

There was a recent change in toolkit/mozapps/extensions/test/xpcshell/head_addons.js: https://hg.mozilla.org/mozilla-central/rev/c36493fb059953120538587cd308928cffd57b82

but I can't see how that would cause this...

Depends on: 1644858
No longer depends on: 1644858

Indeed, it seems test_ext_pkcs11_management.js is instantiating a MockRegistry and for some reason OnInterfaceChange gets called during that time (it may be that something in the test is triggering a network change event).
In any case, I think the easiest thing is to disable checking the registry while a MockRegistry is active by setting the network.notify.dnsSuffixList pref to false.

Assignee: nobody → valentin.gosu
Flags: needinfo?(valentin.gosu)
Priority: P5 → P2
Whiteboard: [necko-triaged]
Pushed by valentin.gosu@gmail.com:
https://hg.mozilla.org/integration/autoland/rev/7d8e8f586ad8
Don't use the Windows Registry off main thread in nsNotifyAddrListener while a MockRegistry is active r=necko-reviewers,kershaw
Status: NEW → RESOLVED
Closed: 3 years ago
Resolution: --- → FIXED
Target Milestone: --- → 87 Branch
Pushed by valentin.gosu@gmail.com:
https://hg.mozilla.org/integration/autoland/rev/a00c9b70eca3
Also disable other prefs that may trigger OMT use of MockRegistry.jsm r=necko-reviewers,kershaw
Status: REOPENED → RESOLVED
Closed: 3 years ago3 years ago
Resolution: --- → FIXED
Target Milestone: --- → 87 Branch
See Also: → 1692411

Valentin, this assertion failure has appeared again:
https://treeherder.mozilla.org/logviewer?job_id=330781351&repo=mozilla-central&lineNumber=6813

Should we file a new bug or continue to keep track of it here?

Flags: needinfo?(valentin.gosu)
Blocks: 1694345

I filed bug 1694345.

Flags: needinfo?(valentin.gosu)
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Created:
Updated:
Size: