Perma Linux64 debug W-sw Assertion failure: (mProxy->mDelayedUpdate == this), at /builds/worker/workspace/build/src/dom/serviceworkers/ServiceWorkerRegistrationProxy.cpp:280

NEW
Unassigned

Status

()

defect
P2
normal
2 months ago
29 days ago

People

(Reporter: intermittent-bug-filer, Unassigned)

Tracking

({intermittent-failure, leave-open, regression})

Firefox Tracking Flags

(Not tracked)

Details

(Whiteboard: [stockwell disabled], crash signature)

Attachments

(3 attachments, 1 obsolete attachment)

Comment hidden (Intermittent Failures Robot)
Comment hidden (Intermittent Failures Robot)
Duplicate of this bug: 1545013
Duplicate of this bug: 1544672
Comment hidden (Intermittent Failures Robot)

The priority flag is not set for this bug.
:overholt, could you have a look please?

Flags: needinfo?(overholt)

Recent spikes here seem to have started with bug 1546407: https://treeherder.mozilla.org/#/jobs?repo=mozilla-inbound&revision=cfafd091d30107f974a22c06ef790bee7950c1cd&selectedJob=242352312&searchStr=linux%2Cx64%2Cdebug%2Cweb%2Cplatform%2Ctests%2Cwith%2Cserviceworker%2Credesign%2Ctest-linux64%2Fdebug-web-platform-tests-sw-e10s-14%2Cw-sw%28wpt14%29

Julian, can you please take a look?

There are 41 total failures in the last 3 days on linux64 debug.

Recent failure log: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=242873572&repo=mozilla-inbound&lineNumber=45736

[task 2019-04-26T14:25:41.779Z] 14:25:41 INFO - TEST-START | /service-workers/service-worker/navigate-window.https.html
[task 2019-04-26T14:25:41.783Z] 14:25:41 INFO - Closing window 214748364801
[task 2019-04-26T14:25:41.913Z] 14:25:41 INFO - PID 11416 | Assertion failure: (mProxy->mDelayedUpdate == this), at /builds/worker/workspace/build/src/dom/serviceworkers/ServiceWorkerRegistrationProxy.cpp:280
[task 2019-04-26T14:25:42.080Z] 14:25:42 INFO - IOError on command, setting status to CRASH
[task 2019-04-26T14:25:42.088Z] 14:25:42 INFO - mozcrash Copy/paste: /builds/worker/workspace/build/linux64-minidump_stackwalk /tmp/tmpoPzo_T.mozrunner/minidumps/3e992a87-4cd1-7e55-deff-6373ec94726a.dmp /builds/worker/workspace/build/symbols
[task 2019-04-26T14:25:49.644Z] 14:25:49 INFO - mozcrash Saved minidump as /builds/worker/workspace/build/blobber_upload_dir/3e992a87-4cd1-7e55-deff-6373ec94726a.dmp
[task 2019-04-26T14:25:49.645Z] 14:25:49 INFO - mozcrash Saved app info as /builds/worker/workspace/build/blobber_upload_dir/3e992a87-4cd1-7e55-deff-6373ec94726a.extra
[task 2019-04-26T14:25:49.843Z] 14:25:49 INFO - PROCESS-CRASH | /service-workers/service-worker/navigate-window.https.html | application crashed [@ mozilla::dom::ServiceWorkerRegistrationProxy::DelayedUpdate::Notify(nsITimer*)]
[task 2019-04-26T14:25:49.843Z] 14:25:49 INFO - Crash dump filename: /tmp/tmpoPzo_T.mozrunner/minidumps/3e992a87-4cd1-7e55-deff-6373ec94726a.dmp
[task 2019-04-26T14:25:49.843Z] 14:25:49 INFO - Operating system: Linux
[task 2019-04-26T14:25:49.844Z] 14:25:49 INFO - 0.0.0 Linux 4.4.0-1014-aws #14taskcluster1-Ubuntu SMP Tue Apr 3 10:27:00 UTC 2018 x86_64
[task 2019-04-26T14:25:49.844Z] 14:25:49 INFO - CPU: amd64
[task 2019-04-26T14:25:49.844Z] 14:25:49 INFO - family 6 model 62 stepping 4
[task 2019-04-26T14:25:49.845Z] 14:25:49 INFO - 4 CPUs
[task 2019-04-26T14:25:49.845Z] 14:25:49 INFO -
[task 2019-04-26T14:25:49.845Z] 14:25:49 INFO - GPU: UNKNOWN
[task 2019-04-26T14:25:49.846Z] 14:25:49 INFO -
[task 2019-04-26T14:25:49.846Z] 14:25:49 INFO - Crash reason: SIGSEGV /SEGV_MAPERR
[task 2019-04-26T14:25:49.846Z] 14:25:49 INFO - Crash address: 0x0
[task 2019-04-26T14:25:49.846Z] 14:25:49 INFO - Process uptime: not available
[task 2019-04-26T14:25:49.846Z] 14:25:49 INFO -
[task 2019-04-26T14:25:49.846Z] 14:25:49 INFO - Thread 0 (crashed)
[task 2019-04-26T14:25:49.846Z] 14:25:49 INFO - 0 libxul.so!mozilla::dom::ServiceWorkerRegistrationProxy::DelayedUpdate::Notify(nsITimer*) [ServiceWorkerRegistrationProxy.cpp:a2f7510851a4b7603cd25691f82712b2f77ec863 : 280 + 0x29]
[task 2019-04-26T14:25:49.847Z] 14:25:49 INFO - rax = 0x00007fad09453ad8 rdx = 0x0000000000000000
[task 2019-04-26T14:25:49.847Z] 14:25:49 INFO - rcx = 0x000055fa13b1c988 rbx = 0x00007ffed3effab8
[task 2019-04-26T14:25:49.847Z] 14:25:49 INFO - rsi = 0x00007fad14c81770 rdi = 0x00007fad14c80540
[task 2019-04-26T14:25:49.847Z] 14:25:49 INFO - rbp = 0x00007ffed3effa60 rsp = 0x00007ffed3effa10
[task 2019-04-26T14:25:49.847Z] 14:25:49 INFO - r8 = 0x00007fad14c81770 r9 = 0x00007fad15d4d740
[task 2019-04-26T14:25:49.847Z] 14:25:49 INFO - r10 = 0x0000000000000000 r11 = 0x0000000000000000
[task 2019-04-26T14:25:49.847Z] 14:25:49 INFO - r12 = 0x00007facf6fa62e0 r13 = 0x00007ffed3effac0
[task 2019-04-26T14:25:49.848Z] 14:25:49 INFO - r14 = 0x00007facf6fa62e8 r15 = 0x00007facf3788b68
[task 2019-04-26T14:25:49.848Z] 14:25:49 INFO - rip = 0x00007fad055f6fe8
[task 2019-04-26T14:25:49.848Z] 14:25:49 INFO - Found by: given as instruction pointer in context
[task 2019-04-26T14:25:49.848Z] 14:25:49 INFO - 1 libxul.so!nsTimerImpl::Fire(int) [nsTimerImpl.cpp:a2f7510851a4b7603cd25691f82712b2f77ec863 : 564 + 0xf]
[task 2019-04-26T14:25:49.848Z] 14:25:49 INFO - rbx = 0x00007ffed3effab8 rbp = 0x00007ffed3effb20
[task 2019-04-26T14:25:49.848Z] 14:25:49 INFO - rsp = 0x00007ffed3effa70 r12 = 0x00007facf3788b30
[task 2019-04-26T14:25:49.848Z] 14:25:49 INFO - r13 = 0x00007ffed3effac0 r14 = 0x0000000000000001
[task 2019-04-26T14:25:49.849Z] 14:25:49 INFO - r15 = 0x00007facf3788b68 rip = 0x00007fad02e997e1
[task 2019-04-26T14:25:49.849Z] 14:25:49 INFO - Found by: call frame info
[task 2019-04-26T14:25:49.849Z] 14:25:49 INFO - 2 libxul.so!nsTimerEvent::Run() [TimerThread.cpp:a2f7510851a4b7603cd25691f82712b2f77ec863 : 260 + 0x14]
[task 2019-04-26T14:25:49.849Z] 14:25:49 INFO - rbx = 0x00007facf81fd020 rbp = 0x00007ffed3effb50
[task 2019-04-26T14:25:49.849Z] 14:25:49 INFO - rsp = 0x00007ffed3effb30 r12 = 0x00007fad14651940
[task 2019-04-26T14:25:49.849Z] 14:25:49 INFO - r13 = 0x00000000ffffffff r14 = 0x0000000000000001
[task 2019-04-26T14:25:49.850Z] 14:25:49 INFO - r15 = 0x0000000000000001 rip = 0x00007fad02e993cc
[task 2019-04-26T14:25:49.850Z] 14:25:49 INFO - Found by: call frame info
[task 2019-04-26T14:25:49.850Z] 14:25:49 INFO - 3 libxul.so!nsThread::ProcessNextEvent(bool, bool*) [nsThread.cpp:a2f7510851a4b7603cd25691f82712b2f77ec863 : 1180 + 0xe]
[task 2019-04-26T14:25:49.850Z] 14:25:49 INFO - rbx = 0x00007facf81fd020 rbp = 0x00007ffed3f00060
[task 2019-04-26T14:25:49.850Z] 14:25:49 INFO - rsp = 0x00007ffed3effb60 r12 = 0x00007fad14651940
[task 2019-04-26T14:25:49.850Z] 14:25:49 INFO - r13 = 0x00000000ffffffff r14 = 0x0000000000000001
[task 2019-04-26T14:25:49.851Z] 14:25:49 INFO - r15 = 0x0000000000000001 rip = 0x00007fad02ea05a6
[task 2019-04-26T14:25:49.851Z] 14:25:49 INFO - Found by: call frame info
[task 2019-04-26T14:25:49.851Z] 14:25:49 INFO - 4 libxul.so!NS_ProcessNextEvent(nsIThread*, bool) [nsThreadUtils.cpp:a2f7510851a4b7603cd25691f82712b2f77ec863 : 486 + 0x10]
[task 2019-04-26T14:25:49.851Z] 14:25:49 INFO - rbx = 0x0000000000000000 rbp = 0x00007ffed3f00090
[task 2019-04-26T14:25:49.851Z] 14:25:49 INFO - rsp = 0x00007ffed3f00070 r12 = 0x0000000000000001
[task 2019-04-26T14:25:49.851Z] 14:25:49 INFO - r13 = 0x00007fad00606f60 r14 = 0x00007ffed3f00077
[task 2019-04-26T14:25:49.851Z] 14:25:49 INFO - r15 = 0x0000000000000001 rip = 0x00007fad02ea2ad1
[task 2019-04-26T14:25:49.852Z] 14:25:49 INFO - Found by: call frame info
[task 2019-04-26T14:25:49.852Z] 14:25:49 INFO - 5 libxul.so!mozilla::ipc::MessagePump::Run(base::MessagePump::Delegate*) [MessagePump.cpp:a2f7510851a4b7603cd25691f82712b2f77ec863 : 88 + 0x7]
[task 2019-04-26T14:25:49.852Z] 14:25:49 INFO - rbx = 0x00007fad00606f40 rbp = 0x00007ffed3f000f0
[task 2019-04-26T14:25:49.852Z] 14:25:49 INFO - rsp = 0x00007ffed3f000a0 r12 = 0x0000000000000001
[task 2019-04-26T14:25:49.852Z] 14:25:49 INFO - r13 = 0x00007fad00606f60 r14 = 0x00007fad1465e430
[task 2019-04-26T14:25:49.853Z] 14:25:49 INFO - r15 = 0x0000000000000001 rip = 0x00007fad033c6f12
[task 2019-04-26T14:25:49.853Z] 14:25:49 INFO - Found by: call frame info
[task 2019-04-26T14:25:49.853Z] 14:25:49 INFO - 6 libxul.so!MessageLoop::RunInternal() [message_loop.cc:a2f7510851a4b7603cd25691f82712b2f77ec863 : 315 + 0x17]
[task 2019-04-26T14:25:49.853Z] 14:25:49 INFO - rbx = 0x00007fad1465e430 rbp = 0x00007ffed3f00130
[task 2019-04-26T14:25:49.853Z] 14:25:49 INFO - rsp = 0x00007ffed3f00100 r12 = 0x00007ffed3f00220
[task 2019-04-26T14:25:49.853Z] 14:25:49 INFO - r13 = 0x00007ffed3f001f8 r14 = 0x00007ffed3f00140
[task 2019-04-26T14:25:49.853Z] 14:25:49 INFO - r15 = 0x00007ffed3f00220 rip = 0x00007fad03381e19
[task 2019-04-26T14:25:49.854Z] 14:25:49 INFO - Found by: call frame info
[task 2019-04-26T14:25:49.854Z] 14:25:49 INFO - 7 libxul.so!MessageLoop::Run() [message_loop.cc:a2f7510851a4b7603cd25691f82712b2f77ec863 : 290 + 0x8]
[task 2019-04-26T14:25:49.854Z] 14:25:49 INFO - rbx = 0x00007fad1465e430 rbp = 0x00007ffed3f00170
[task 2019-04-26T14:25:49.854Z] 14:25:49 INFO - rsp = 0x00007ffed3f00140 r12 = 0x00007ffed3f00220
[task 2019-04-26T14:25:49.854Z] 14:25:49 INFO - r13 = 0x00007ffed3f001f8 r14 = 0x00007ffed3f00140
[task 2019-04-26T14:25:49.854Z] 14:25:49 INFO - r15 = 0x00007ffed3f00220 rip = 0x00007fad03381d74
[task 2019-04-26T14:25:49.854Z] 14:25:49 INFO - Found by: call frame info
[task 2019-04-26T14:25:49.855Z] 14:25:49 INFO - 8 libxul.so!nsBaseAppShell::Run() [nsBaseAppShell.cpp:a2f7510851a4b7603cd25691f82712b2f77ec863 : 137 + 0xd]
[task 2019-04-26T14:25:49.855Z] 14:25:49 INFO - rbx = 0x00007fad00638f90 rbp = 0x00007ffed3f00190
[task 2019-04-26T14:25:49.855Z] 14:25:49 INFO - rsp = 0x00007ffed3f00180 r12 = 0x00007ffed3f00220
[task 2019-04-26T14:25:49.855Z] 14:25:49 INFO - r13 = 0x00007ffed3f001f8 r14 = 0x00007fad14651940
[task 2019-04-26T14:25:49.855Z] 14:25:49 INFO - r15 = 0x00007ffed3f00220 rip = 0x00007fad056a5b81
[task 2019-04-26T14:25:49.855Z] 14:25:49 INFO - Found by: call frame info
[task 2019-04-26T14:25:49.856Z] 14:25:49 INFO - 9 libxul.so!nsAppStartup::Run() [nsAppStartup.cpp:a2f7510851a4b7603cd25691f82712b2f77ec863 : 270 + 0x12]
[task 2019-04-26T14:25:49.856Z] 14:25:49 INFO - rbx = 0x00007facfb584b50 rbp = 0x00007ffed3f001b0
[task 2019-04-26T14:25:49.856Z] 14:25:49 INFO - rsp = 0x00007ffed3f001a0 r12 = 0x00007ffed3f00220
[task 2019-04-26T14:25:49.856Z] 14:25:49 INFO - r13 = 0x00007ffed3f001f8 r14 = 0x00007ffed3f003d0
[task 2019-04-26T14:25:49.856Z] 14:25:49 INFO - r15 = 0x00007ffed3f00220 rip = 0x00007fad0660a763
[task 2019-04-26T14:25:49.856Z] 14:25:49 INFO - Found by: call frame info
[task 2019-04-26T14:25:49.856Z] 14:25:49 INFO - 10 libxul.so!XREMain::XRE_mainRun() [nsAppRunner.cpp:a2f7510851a4b7603cd25691f82712b2f77ec863 : 4578 + 0xe]
[task 2019-04-26T14:25:49.857Z] 14:25:49 INFO - rbx = 0x0000000000000077 rbp = 0x00007ffed3f00300
[task 2019-04-26T14:25:49.857Z] 14:25:49 INFO - rsp = 0x00007ffed3f001c0 r12 = 0x00007ffed3f00220
[task 2019-04-26T14:25:49.857Z] 14:25:49 INFO - r13 = 0x00007ffed3f001f8 r14 = 0x00007ffed3f003d0
[task 2019-04-26T14:25:49.857Z] 14:25:49 INFO - r15 = 0x00007ffed3f00220 rip = 0x00007fad066f30f1
[task 2019-04-26T14:25:49.857Z] 14:25:49 INFO - Found by: call frame info
[task 2019-04-26T14:25:49.857Z] 14:25:49 INFO - 11 libxul.so!XREMain::XRE_main(int, char**, mozilla::BootstrapConfig const&) [nsAppRunner.cpp:a2f7510851a4b7603cd25691f82712b2f77ec863 : 4716 + 0x5]
[task 2019-04-26T14:25:49.858Z] 14:25:49 INFO - rbx = 0x00007ffed3f003c8 rbp = 0x00007ffed3f003b0
[task 2019-04-26T14:25:49.858Z] 14:25:49 INFO - rsp = 0x00007ffed3f00310 r12 = 0x0000000000000001
[task 2019-04-26T14:25:49.858Z] 14:25:49 INFO - r13 = 0x00007ffed3f00400 r14 = 0x0000000000000000
[task 2019-04-26T14:25:49.858Z] 14:25:49 INFO - r15 = 0x00007ffed3f003f8 rip = 0x00007fad066f3b48
[task 2019-04-26T14:25:49.858Z] 14:25:49 INFO - Found by: call frame info
[task 2019-04-26T14:25:49.858Z] 14:25:49 INFO - 12 libxul.so!XRE_main(int, char**, mozilla::BootstrapConfig const&) [nsAppRunner.cpp:a2f7510851a4b7603cd25691f82712b2f77ec863 : 4797 + 0x10]
[task 2019-04-26T14:25:49.858Z] 14:25:49 INFO - rbx = 0x0000000000000005 rbp = 0x00007ffed3f00510
[task 2019-04-26T14:25:49.859Z] 14:25:49 INFO - rsp = 0x00007ffed3f003c0 r12 = 0x00007ffed3f003c8
[task 2019-04-26T14:25:49.859Z] 14:25:49 INFO - r13 = 0x00007ffed3f01648 r14 = 0x00007ffed3f00530
[task 2019-04-26T14:25:49.859Z] 14:25:49 INFO - r15 = 0x00007ffed3f01648 rip = 0x00007fad066f4302
[task 2019-04-26T14:25:49.859Z] 14:25:49 INFO - Found by: call frame info
[task 2019-04-26T14:25:49.859Z] 14:25:49 INFO - 13 firefox-bin!main [nsBrowserApp.cpp:a2f7510851a4b7603cd25691f82712b2f77ec863 : 212 + 0x1e]
[task 2019-04-26T14:25:49.859Z] 14:25:49 INFO - rbx = 0x00007fad0ad2d650 rbp = 0x00007ffed3f01560
[task 2019-04-26T14:25:49.860Z] 14:25:49 INFO - rsp = 0x00007ffed3f00520 r12 = 0x000055fa13b090c4
[task 2019-04-26T14:25:49.860Z] 14:25:49 INFO - r13 = 0x00007ffed3f01648 r14 = 0x0000000000000005
[task 2019-04-26T14:25:49.860Z] 14:25:49 INFO - r15 = 0x00007ffed3f00530 rip = 0x000055fa13acabd6
[task 2019-04-26T14:25:49.860Z] 14:25:49 INFO - Found by: call frame info
[task 2019-04-26T14:25:49.860Z] 14:25:49 INFO - 14 libc-2.23.so + 0x20830
[task 2019-04-26T14:25:49.860Z] 14:25:49 INFO - rbx = 0x0000000000000000 rbp = 0x000055fa13b08720
[task 2019-04-26T14:25:49.861Z] 14:25:49 INFO - rsp = 0x00007ffed3f01570 r12 = 0x000055fa13aca868
[task 2019-04-26T14:25:49.861Z] 14:25:49 INFO - r13 = 0x00007ffed3f01640 r14 = 0x0000000000000000
[task 2019-04-26T14:25:49.861Z] 14:25:49 INFO - r15 = 0x0000000000000000 rip = 0x00007fad148db830
[task 2019-04-26T14:25:49.861Z] 14:25:49 INFO - Found by: call frame info
[task 2019-04-26T14:25:49.861Z] 14:25:49 INFO - 15 firefox-bin!<name omitted> [UniquePtr.h:a2f7510851a4b7603cd25691f82712b2f77ec863 : 274 + 0x17]
[task 2019-04-26T14:25:49.861Z] 14:25:49 INFO - rsp = 0x00007ffed3f01590 rip = 0x000055fa13acaa39
[task 2019-04-26T14:25:49.861Z] 14:25:49 INFO - Found by: stack scanning

Flags: needinfo?(jseward)

This is permafailing for weeks in the 'new serviceworker' variant oft web-platform-tests on Linux64 debug. Until recently, permafail bug 1535924 hit earlier during the execution of that test suite chunk (also a serviceworker failure). With that gone, this issue has moved to the top now.

Flags: needinfo?(jseward)
Summary: Intermittent PID 8940 | Assertion failure: (mProxy->mDelayedUpdate == this), at /builds/worker/workspace/build/src/dom/serviceworkers/ServiceWorkerRegistrationProxy.cpp:280 → Perma Linux64 debug W-sw Assertion failure: (mProxy->mDelayedUpdate == this), at /builds/worker/workspace/build/src/dom/serviceworkers/ServiceWorkerRegistrationProxy.cpp:280
Comment hidden (Intermittent Failures Robot)
Comment hidden (Intermittent Failures Robot)
Comment hidden (Intermittent Failures Robot)

Thanks. We'll get to this after we land our parent intercept work (bug 1231208).

Flags: needinfo?(overholt)
Priority: -- → P2
Comment hidden (Intermittent Failures Robot)

:overholt, I don't see work in bug 1231208 for a long time, it is unclear that that work will be completed in the next few days or even the nextweek. As this is perma failing- we really should disable this test- it doesn't meet the criteria of something we should be running in production.

:dluca, could you adjust this for linux64 serviceworkers to either be expected:fail or disabled?

Flags: needinfo?(dluca)

Updated

2 months ago
Flags: needinfo?(dluca)
Comment hidden (Intermittent Failures Robot)
Attachment #9061830 - Attachment description: Bug 1543316 - Disabled ServiceWorkerRegistrationProxy.cpp on SW Linux64 r=jmaher → Bug 1543316 - Disabled service_worker_idl.https.html on sw-e10s mode on Linux64.
Attachment #9061830 - Attachment description: Bug 1543316 - Disabled service_worker_idl.https.html on sw-e10s mode on Linux64. → Bug 1543316 - Disabled waiting.https.html.ini on sw-e10s mode on Linux64.

Updated

2 months ago
Attachment #9061830 - Attachment is obsolete: true
Keywords: leave-open
Whiteboard: [stockwell disable-recommended] → [stockwell disabled]

Comment 18

2 months ago
Pushed by apavel@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/20d75ab71902
Disabled waiting.https.html.ini on sw-e10s mode on Linux64. r=jmaher
Comment hidden (Intermittent Failures Robot)
Attachment #9061830 - Attachment is obsolete: false
Comment hidden (Intermittent Failures Robot)
Duplicate of this bug: 1548548
Crash Signature: [@ mozilla::dom::ServiceWorkerRegistrationProxy::DelayedUpdate::Notify(nsITimer*)]
Duplicate of this bug: 1549280
Comment hidden (Intermittent Failures Robot)
Comment hidden (Intermittent Failures Robot)

Comment 27

Last month
Pushed by malexandru@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/481580bf3fe8
Disable multiple-update.https.html on sw-e10s r=jmaher
Comment hidden (obsolete)
Attachment #9064435 - Attachment is obsolete: true
Comment hidden (Intermittent Failures Robot)
You need to log in before you can comment on or make changes to this bug.