1699429 - Intermittent <random_test> | application crashed [@ mozilla::dom::ServiceWorkerManager::Init(mozilla::dom::ServiceWorkerRegistrar*)]

Status: RESOLVED WORKSFORME

(Core :: DOM: Service Workers, defect)

Description

[Treeherder Bug Filer]

Filed by: smolnar [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=333609859&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/To-_kncQRZq93-ha8g-qtA/runs/0/artifacts/public/logs/live_backing.log
Reftest URL: https://hg.mozilla.org/mozilla-central/raw-file/tip/layout/tools/reftest/reftest-analyzer.xhtml#logurl=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/To-_kncQRZq93-ha8g-qtA/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1

---

INFO -  TEST-PASS | toolkit/components/glean/xpcshell/test_GleanIPC.js | test_child_metrics - [test_child_metrics : 182] 7 == 7
[task 2021-03-18T10:44:03.808Z] 10:44:03     INFO -  (xpcshell/head.js) | test run_next_test 3 pending (2)
[task 2021-03-18T10:44:03.809Z] 10:44:03     INFO -  (xpcshell/head.js) | test test_child_metrics finished (2)
[task 2021-03-18T10:44:03.809Z] 10:44:03     INFO -  (xpcshell/head.js) | test run_next_test 3 finished (1)
[task 2021-03-18T10:44:03.809Z] 10:44:03     INFO -  exiting test
[task 2021-03-18T10:44:03.809Z] 10:44:03     INFO -  PID 10080 | [Parent 10080, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:512
[task 2021-03-18T10:44:03.809Z] 10:44:03     INFO -  PID 10080 | ###!!! [Child][MessageChannel] Error: (msgtype=0xB80014,name=PWindowGlobal::Msg_UpdateDocumentHasLoaded) Channel closing: too late to send/recv, messages will be lost
[task 2021-03-18T10:44:03.809Z] 10:44:03     INFO -  PID 10080 | ###!!! [Child][MessageChannel] Error: (msgtype=0xB80026,name=PWindowGlobal::Msg_Destroy) Channel closing: too late to send/recv, messages will be lost
[task 2021-03-18T10:44:03.809Z] 10:44:03     INFO -  PID 10080 | [Child 10504, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3365
[task 2021-03-18T10:44:03.809Z] 10:44:03     INFO -  PID 10080 | ###!!! [Child][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-03-18T10:44:03.809Z] 10:44:03     INFO -  PID 10080 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 718: Error: Phase "profile-change-teardown" is finished, it is too late to register completion condition "ServiceWorkerShutdownBlocker: shutting down Service Workers"
[task 2021-03-18T10:44:03.809Z] 10:44:03     INFO -  PID 10080 | [Parent 10080, Main Thread] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/dom/serviceworkers/ServiceWorkerShutdownBlocker.cpp:107
[task 2021-03-18T10:44:03.809Z] 10:44:03     INFO -  PID 10080 | Assertion failure: mShutdownBlocker, at /builds/worker/checkouts/gecko/dom/serviceworkDestroying context 0000016B1F178000 surface 0000016B1D67C2E0 on display 0000016B1D69D800
[task 2021-03-18T10:44:03.809Z] 10:44:03     INFO -  PID 10080 | ers/ServiceWorkerManager.cpp:461
[task 2021-03-18T10:44:03.809Z] 10:44:03     INFO -  PID 10080 | [Child 10504, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4442
[task 2021-03-18T10:44:03.809Z] 10:44:03     INFO -  PID 10080 | [GPU 10072, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4442
[task 2021-03-18T10:44:03.809Z] 10:44:03     INFO -  Initializing stack-fixing for the first stack frame, this may take a while...
[task 2021-03-18T10:44:13.233Z] 10:44:13     INFO -  PID 10080 | #01: mozilla::dom::Document::DispatchContentLoadedEvents() [dom/base/Document.cpp:7562]
[task 2021-03-18T10:44:13.233Z] 10:44:13     INFO -  PID 10080 | #02: mozilla::detail::RunnableMethodImpl<mozilla::dom::Document *,void (mozilla::dom::Document::*)(),1,mozilla::RunnableKind::Standard>::Run() [xpcom/threads/nsThreadUtils.h:1204]
[task 2021-03-18T10:44:13.234Z] 10:44:13     INFO -  PID 10080 | #03: mozilla::RunnableTask::Run() [xpcom/threads/TaskController.cpp:473]
[task 2021-03-18T10:44:13.234Z] 10:44:13     INFO -  PID 10080 | #04: mozilla::TaskController::DoExecuteNextTaskOnlyMainThreadInternal(mozilla::detail::BaseAutoLock<mozilla::Mutex &> const&) [xpcom/threads/TaskController.cpp:760]
[task 2021-03-18T10:44:13.234Z] 10:44:13     INFO -  PID 10080 | #05: mozilla::TaskController::ExecuteNextTaskOnlyMainThreadInternal(mozilla::detail::BaseAutoLock<mozilla::Mutex &> const&) [xpcom/threads/TaskController.cpp:611]
[task 2021-03-18T10:44:13.235Z] 10:44:13     INFO -  PID 10080 | #06: mozilla::TaskController::ProcessPendingMTTask(bool) [xpcom/threads/TaskController.cpp:395]
[task 2021-03-18T10:44:13.235Z] 10:44:13     INFO -  PID 10080 | #07: mozilla::detail::RunnableFunction<`lambda at /builds/worker/checkouts/gecko/xpcom/threads/TaskController.cpp:133:7'>::Run() [xpcom/threads/nsThreadUtils.h:535]
[task 2021-03-18T10:44:13.235Z] 10:44:13     INFO -  PID 10080 | #08: nsThread::ProcessNextEvent(bool, bool*) [xpcom/threads/nsThread.cpp:1162]
[task 2021-03-18T10:44:13.235Z] 10:44:13     INFO -  PID 10080 | #09: NS_ProcessPendingEvents(nsIThread*, unsigned int) [xpcom/threads/nsThreadUtils.cpp:496]
[task 2021-03-18T10:44:13.235Z] 10:44:13     INFO -  PID 10080 | #10: mozilla::ShutdownXPCOM(nsIServiceManager*) [xpcom/build/XPCOMInit.cpp:620]
[task 2021-03-18T10:44:13.235Z] 10:44:13     INFO -  PID 10080 | #11: XRE_XPCShellMain(int, char**, char**, XREShellData const*) [js/xpconnect/src/XPCShellImpl.cpp:1384]
[task 2021-03-18T10:44:13.286Z] 10:44:13     INFO -  PID 10080 | #12: NS_internal_main(int, char**, char**) [js/xpconnect/shell/xpcshell.cpp:78]
[task 2021-03-18T10:44:13.286Z] 10:44:13     INFO -  PID 10080 | #13: wmain(int, wchar_t**) [toolkit/xre/nsWindowsWMain.cpp:131]
[task 2021-03-18T10:44:13.286Z] 10:44:13     INFO -  PID 10080 | #14: __scrt_common_main_seh() [/builds/worker/workspace/obj-build/js/xpconnect/shell/f:/dd/vctools/crt/vcstartup/src/startup/exe_common.inl:288]
[task 2021-03-18T10:44:13.296Z] 10:44:13     INFO -  fix-stacks: error: failed to read debug info file `wkernel32.pdb` for `C:\\Windows\\System32\\KERNEL32.DLL`
[task 2021-03-18T10:44:13.296Z] 10:44:13     INFO -  fix-stacks: note: this is expected and harmless for all PDB files on opt automation runs
[task 2021-03-18T10:44:13.296Z] 10:44:13     INFO -  fix-stacks: The system cannot find the file specified. (os error 2)
INFO -  PID 10080 | #15: BaseThreadInitThunk [C:\\Windows\\System32\\KERNEL32.DLL + 0x13034]
[task 2021-03-18T10:44:13.305Z] 10:44:13     INFO -  fix-stacks: error: failed to read debug info file `wntdll.pdb` for `C:\\Windows\\SYSTEM32\\ntdll.dll`
[task 2021-03-18T10:44:13.305Z] 10:44:13     INFO -  fix-stacks: note: this is expected and harmless for all PDB files on opt automation runs
[task 2021-03-18T10:44:13.305Z] 10:44:13     INFO -  fix-stacks: The system cannot find the file specified. (os error 2)
[task 2021-03-18T10:44:13.305Z] 10:44:13     INFO -  PID 10080 | #16: RtlUserThreadStart [C:\\Windows\\SYSTEM32\\ntdll.dll + 0x71461]
[task 2021-03-18T10:44:13.305Z] 10:44:13     INFO -  <<<<<<<
[task 2021-03-18T10:44:20.066Z] 10:44:20  WARNING -  PROCESS-CRASH | toolkit/components/glean/xpcshell/test_GleanIPC.js | application crashed [@ mozilla::dom::ServiceWorkerManager::Init(mozilla::dom::ServiceWorkerRegistrar*)]
[task 2021-03-18T10:44:20.067Z] 10:44:20     INFO -  Mozilla crash reason: MOZ_ASSERT(mShutdownBlocker)
[task 2021-03-18T10:44:20.067Z] 10:44:20     INFO -  Crash dump filename: c:\users\task_1616062650\appdata\local\temp\xpc-other-viovhp\30d5a53e-8d5c-4fe2-a0cc-ebc972f851d1.dmp
[task 2021-03-18T10:44:20.068Z] 10:44:20     INFO -  Operating system: Windows NT
[task 2021-03-18T10:44:20.068Z] 10:44:20     INFO -                    10.0.17134
[task 2021-03-18T10:44:20.069Z] 10:44:20     INFO -  CPU: amd64
[task 2021-03-18T10:44:20.069Z] 10:44:20     INFO -       family 6 model 85 stepping 4
[task 2021-03-18T10:44:20.070Z] 10:44:20     INFO -       8 CPUs
[task 2021-03-18T10:44:20.071Z] 10:44:20     INFO -  GPU: UNKNOWN
[task 2021-03-18T10:44:20.071Z] 10:44:20     INFO -  Crash reason:  EXCEPTION_BREAKPOINT
[task 2021-03-18T10:44:20.072Z] 10:44:20     INFO -  Crash address: 0xabe7cfa3
[task 2021-03-18T10:44:20.072Z] 10:44:20     INFO -  Process uptime: 0 seconds
[task 2021-03-18T10:44:20.073Z] 10:44:20     INFO -  Thread 0 (crashed)
[task 2021-03-18T10:44:20.074Z] 10:44:20     INFO -   0  xul.dll!mozilla::dom::ServiceWorkerManager::Init(mozilla::dom::ServiceWorkerRegistrar*) [ServiceWorkerManager.cpp:b270383193eac21101a9696f1ec1a7c82f0b5779 : 461 + 0x0]
[task 2021-03-18T10:44:20.074Z] 10:44:20     INFO -      rax = 0x00007ff8b1400081   rdx = 0x00007ff8e90ea640
[task 2021-03-18T10:44:20.075Z] 10:44:20     INFO -      rcx = 0x00007ff8d47f1838   rbx = 0x0000028f0fec51c0
[task 2021-03-18T10:44:20.075Z] 10:44:20     INFO -      rsi = 0x0000028f0fe19100   rdi = 0x0000028f0fe11f20
[task 2021-03-18T10:44:20.076Z] 10:44:20     INFO -      rbp = 0x0000000000000000   rsp = 0x000000ed317fe470
[task 2021-03-18T10:44:20.076Z] 10:44:20     INFO -       r8 = 0x000000ed317f84b8    r9 = 0x0000000000000000
[task 2021-03-18T10:44:20.077Z] 10:44:20     INFO -      r10 = 0x0000000000000000   r11 = 0x000000ed317f9b00
[task 2021-03-18T10:44:20.077Z] 10:44:20     INFO -      r12 = 0xaaaaaaaaaaaaaaaa   r13 = 0xaaaaaaaaaaaaaaaa
[task 2021-03-18T10:44:20.078Z] 10:44:20     INFO -      r14 = 0x00007ff8b274a420   r15 = 0x00007ff8b098d200
[task 2021-03-18T10:44:20.079Z] 10:44:20     INFO -      rip = 0x00007ff8abe7cfa3
[task 2021-03-18T10:44:20.079Z] 10:44:20     INFO -      Found by: given as instruction pointer in context```

Comment 1

[Chris H-C :chutten]

The test does nothing with serviceworkers and has no special consideration for them in its head.js (it doesn't even have one). Passing over to DOM:ServiceWorkers for ideas.

Comment 2

[Intermittent Failures Robot]

1 failures in 4257 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• windows10-64-qr: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1699429&startday=2021-03-15&endday=2021-03-21&tree=all

Comment 3

[Intermittent Failures Robot]

1 failures in 3967 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• comm-central: 1

Platform and build breakdown:

• windows10-64: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1699429&startday=2021-03-22&endday=2021-03-28&tree=all

Comment 4

[Intermittent Failures Robot]

2 failures in 3125 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• comm-central: 1
• try: 1

Platform and build breakdown:

• windows10-64: 2
  • debug: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1699429&startday=2021-03-29&endday=2021-04-04&tree=all

Comment 6

[Intermittent Failures Robot]

1 failures in 3706 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 1

Platform and build breakdown:

• windows10-64: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1699429&startday=2021-04-26&endday=2021-05-02&tree=all

Comment 7

[Intermittent Failures Robot]

4 failures in 3115 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 4

Platform and build breakdown:

• windows10-32-qr: 4
  • debug: 4

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1699429&startday=2021-06-21&endday=2021-06-27&tree=all

Comment 8

[Intermittent Failures Robot]

2 failures in 2387 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 2

Platform and build breakdown:

• windows10-64: 1
  • debug: 1
• windows10-32-qr: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1699429&startday=2021-07-05&endday=2021-07-11&tree=all

Comment 9

[Intermittent Failures Robot]

1 failures in 3025 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• windows10-32-qr: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1699429&startday=2021-08-09&endday=2021-08-15&tree=all