Intermittent linux32-non-e10s dom/push/test/test_serviceworker_lifetime.html | application crashed [@ mozilla::dom::FetchDriver::~FetchDriver] after Assertion failure: mResponseAvailableCalled, at FetchDriver.cpp:360

NEW
Assigned to

Status

()

Core
DOM: Push Notifications
P5
critical
27 days ago
25 days ago

People

(Reporter: Treeherder Bug Filer, Assigned: catalinb)

Tracking

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

Firefox Tracking Flags

(Not tracked)

Details

(crash signature)

(Reporter)

Description

27 days ago
treeherder
Filed by: archaeopteryx [at] coole-files.de

https://treeherder.mozilla.org/logviewer.html#?job_id=158875575&repo=mozilla-inbound

https://queue.taskcluster.net/v1/task/O2C3G1WVSo231OstuQ2ZHw/runs/0/artifacts/public/logs/live_backing.log

[task 2018-01-27T19:03:44.653Z] 19:03:44     INFO - TEST-START | dom/push/test/test_serviceworker_lifetime.html
[task 2018-01-27T19:03:44.810Z] 19:03:44     INFO - GECKO(1057) | ++DOMWINDOW == 36 (0xddb4c800) [pid = 1057] [serial = 41] [outer = 0xcd197160]
[task 2018-01-27T19:03:45.159Z] 19:03:45     INFO - GECKO(1057) | ++DOCSHELL 0xddbbdc00 == 8 [pid = 1057] [id = {feab25ed-b9b6-4d7d-88d1-29599aca0f3c}]
[task 2018-01-27T19:03:45.162Z] 19:03:45     INFO - GECKO(1057) | ++DOMWINDOW == 37 (0xccad0040) [pid = 1057] [serial = 42] [outer = (nil)]
[task 2018-01-27T19:03:45.164Z] 19:03:45     INFO - GECKO(1057) | ++DOMWINDOW == 38 (0xddbbe800) [pid = 1057] [serial = 43] [outer = 0xccad0040]
[task 2018-01-27T19:03:45.368Z] 19:03:45     INFO - GECKO(1057) | [1057, DOM Worker] WARNING: A runnable was posted to a worker that is already shutting down!: file /builds/worker/workspace/build/src/dom/workers/WorkerPrivate.cpp, line 2967
[task 2018-01-27T19:03:45.369Z] 19:03:45     INFO - GECKO(1057) | [1057, DOM Worker] WARNING: A runnable was posted to a worker that is already shutting down!: file /builds/worker/workspace/build/src/dom/workers/WorkerPrivate.cpp, line 2967
[task 2018-01-27T19:03:45.568Z] 19:03:45     INFO - GECKO(1057) | [1057, DOM Worker] WARNING: A runnable was posted to a worker that is already shutting down!: file /builds/worker/workspace/build/src/dom/workers/WorkerPrivate.cpp, line 2967
[task 2018-01-27T19:03:45.569Z] 19:03:45     INFO - GECKO(1057) | [1057, DOM Worker] WARNING: A runnable was posted to a worker that is already shutting down!: file /builds/worker/workspace/build/src/dom/workers/WorkerPrivate.cpp, line 2967
[task 2018-01-27T19:03:45.595Z] 19:03:45     INFO - GECKO(1057) | Assertion failure: mResponseAvailableCalled, at /builds/worker/workspace/build/src/dom/fetch/FetchDriver.cpp:360
[task 2018-01-27T19:04:16.965Z] 19:04:16     INFO - GECKO(1057) | #01: mozilla::dom::FetchDriver::~FetchDriver [dom/fetch/FetchDriver.cpp:360]
[task 2018-01-27T19:04:16.967Z] 19:04:16     INFO - 
[task 2018-01-27T19:04:16.970Z] 19:04:16     INFO - GECKO(1057) | #02: mozilla::dom::FetchDriver::~FetchDriver [memory/mozalloc/mozalloc.h:183]
[task 2018-01-27T19:04:16.971Z] 19:04:16     INFO - 
[task 2018-01-27T19:04:16.972Z] 19:04:16     INFO - GECKO(1057) | #03: mozilla::dom::FetchDriver::Release [dom/fetch/FetchDriver.cpp:325]
[task 2018-01-27T19:04:16.974Z] 19:04:16     INFO - 
[task 2018-01-27T19:04:16.975Z] 19:04:16     INFO - GECKO(1057) | #04: nsCORSListenerProxy::Release [memory/mozalloc/mozalloc.h:183]
[task 2018-01-27T19:04:16.976Z] 19:04:16     INFO - 
[task 2018-01-27T19:04:16.977Z] 19:04:16     INFO - GECKO(1057) | #05: mozilla::net::HttpBaseChannel::~HttpBaseChannel [netwerk/protocol/http/HttpBaseChannel.cpp:239]
[task 2018-01-27T19:04:16.977Z] 19:04:16     INFO - 
[task 2018-01-27T19:04:16.978Z] 19:04:16     INFO - GECKO(1057) | #06: mozilla::net::nsHttpChannel::~nsHttpChannel [memory/mozalloc/mozalloc.h:183]
[task 2018-01-27T19:04:16.979Z] 19:04:16     INFO - 
[task 2018-01-27T19:04:16.980Z] 19:04:16     INFO - GECKO(1057) | #07: mozilla::net::HttpBaseChannel::Release [netwerk/protocol/http/HttpBaseChannel.cpp:391]
[task 2018-01-27T19:04:16.981Z] 19:04:16     INFO - 
[task 2018-01-27T19:04:16.982Z] 19:04:16     INFO - GECKO(1057) | #08: mozilla::net::nsHttpChannel::Release [netwerk/protocol/http/nsHttpChannel.cpp:5767]
[task 2018-01-27T19:04:16.983Z] 19:04:16     INFO - 
[task 2018-01-27T19:04:16.984Z] 19:04:16     INFO - GECKO(1057) | #09: mozilla::net::InterceptedHttpChannel::ReleaseListeners [xpcom/base/nsCOMPtr.h:631]
[task 2018-01-27T19:04:16.985Z] 19:04:16     INFO - 
[task 2018-01-27T19:04:16.987Z] 19:04:16     INFO - GECKO(1057) | #10: mozilla::net::InterceptedHttpChannel::OnRedirectVerifyCallback [netwerk/protocol/http/InterceptedHttpChannel.cpp:1021]
[task 2018-01-27T19:04:16.987Z] 19:04:16     INFO - 
[task 2018-01-27T19:04:16.989Z] 19:04:16     INFO - GECKO(1057) | #11: mozilla::net::nsAsyncVerifyRedirectCallbackEvent::Run [netwerk/base/nsAsyncRedirectVerifyHelper.cpp:44]
[task 2018-01-27T19:04:16.990Z] 19:04:16     INFO - 
[task 2018-01-27T19:04:16.991Z] 19:04:16     INFO - GECKO(1057) | #12: nsThread::ProcessNextEvent [mfbt/Maybe.h:100]
[task 2018-01-27T19:04:16.992Z] 19:04:16     INFO - 
[task 2018-01-27T19:04:16.993Z] 19:04:16     INFO - GECKO(1057) | #13: NS_ProcessNextEvent [xpcom/threads/nsThreadUtils.cpp:517]
[task 2018-01-27T19:04:16.994Z] 19:04:16     INFO - 
[task 2018-01-27T19:04:16.995Z] 19:04:16     INFO - GECKO(1057) | #14: mozilla::ipc::MessagePump::Run [ipc/glue/MessagePump.cpp:98]
[task 2018-01-27T19:04:16.996Z] 19:04:16     INFO - 
[task 2018-01-27T19:04:16.998Z] 19:04:16     INFO - GECKO(1057) | #15: MessageLoop::RunInternal [ipc/chromium/src/base/message_loop.cc:327]
[task 2018-01-27T19:04:16.998Z] 19:04:16     INFO - 
[task 2018-01-27T19:04:16.999Z] 19:04:16     INFO - GECKO(1057) | #16: MessageLoop::Run [ipc/chromium/src/base/message_loop.cc:298]
[task 2018-01-27T19:04:17.000Z] 19:04:17     INFO - 
[task 2018-01-27T19:04:17.001Z] 19:04:17     INFO - GECKO(1057) | #17: nsBaseAppShell::Run [widget/nsBaseAppShell.cpp:159]
[task 2018-01-27T19:04:17.002Z] 19:04:17     INFO - 
[task 2018-01-27T19:04:17.004Z] 19:04:17     INFO - GECKO(1057) | #18: nsAppStartup::Run [toolkit/components/startup/nsAppStartup.cpp:289]
[task 2018-01-27T19:04:17.005Z] 19:04:17     INFO - 
[task 2018-01-27T19:04:17.006Z] 19:04:17     INFO - GECKO(1057) | #19: XREMain::XRE_mainRun [toolkit/xre/nsAppRunner.cpp:4708]
[task 2018-01-27T19:04:17.007Z] 19:04:17     INFO - 
[task 2018-01-27T19:04:17.008Z] 19:04:17     INFO - GECKO(1057) | #20: XREMain::XRE_main [toolkit/xre/nsAppRunner.cpp:4842]
[task 2018-01-27T19:04:17.009Z] 19:04:17     INFO - 
[task 2018-01-27T19:04:17.010Z] 19:04:17     INFO - GECKO(1057) | #21: XRE_main [toolkit/xre/nsAppRunner.cpp:4935]
[task 2018-01-27T19:04:17.011Z] 19:04:17     INFO - 
[task 2018-01-27T19:04:17.088Z] 19:04:17     INFO - GECKO(1057) | #22: do_main [browser/app/nsBrowserApp.cpp:231]
[task 2018-01-27T19:04:17.089Z] 19:04:17     INFO - 
[task 2018-01-27T19:04:17.089Z] 19:04:17     INFO - GECKO(1057) | #23: main [browser/app/nsBrowserApp.cpp:306]
[task 2018-01-27T19:04:17.089Z] 19:04:17     INFO - 
[task 2018-01-27T19:04:17.090Z] 19:04:17     INFO - GECKO(1057) | ExceptionHandler::GenerateDump cloned child 1159
[task 2018-01-27T19:04:17.091Z] 19:04:17     INFO - GECKO(1057) | ExceptionHandler::SendContinueSignalToChild sent continue signal to child
[task 2018-01-27T19:04:17.091Z] 19:04:17     INFO - GECKO(1057) | ExceptionHandler::WaitForContinueSignal waiting for continue signal...
[task 2018-01-27T19:04:17.092Z] 19:04:17     INFO - TEST-INFO | Main app process: exit 11
[task 2018-01-27T19:04:17.093Z] 19:04:17     INFO - Buffered messages logged at 19:03:45
[task 2018-01-27T19:04:17.094Z] 19:04:17     INFO - TEST-PASS | dom/push/test/test_serviceworker_lifetime.html | Service Worker is active 
[task 2018-01-27T19:04:17.096Z] 19:04:17     INFO - TEST-PASS | dom/push/test/test_serviceworker_lifetime.html | successful registered for push notification 
[task 2018-01-27T19:04:17.097Z] 19:04:17     INFO - Setting shutdown observer: expectingEvent=true
[task 2018-01-27T19:04:17.098Z] 19:04:17     INFO - Setting shutdown observer: expectingEvent=false
[task 2018-01-27T19:04:17.098Z] 19:04:17     INFO - Setting shutdown observer: expectingEvent=true
[task 2018-01-27T19:04:17.100Z] 19:04:17     INFO - Setting shutdown observer: expectingEvent=false
[task 2018-01-27T19:04:17.100Z] 19:04:17     INFO - Setting shutdown observer: expectingEvent=true
[task 2018-01-27T19:04:17.107Z] 19:04:17     INFO - Setting shutdown observer: expectingEvent=false
[task 2018-01-27T19:04:17.108Z] 19:04:17     INFO - Setting shutdown observer: expectingEvent=true
[task 2018-01-27T19:04:17.109Z] 19:04:17     INFO - TEST-PASS | dom/push/test/test_serviceworker_lifetime.html | Received correct message type: fetch 
[task 2018-01-27T19:04:17.109Z] 19:04:17     INFO - TEST-PASS | dom/push/test/test_serviceworker_lifetime.html | Service worker is in the correct state: from_scope 
[task 2018-01-27T19:04:17.109Z] 19:04:17     INFO - Waiting on worker to shutdown.
[task 2018-01-27T19:04:17.110Z] 19:04:17     INFO - TEST-PASS | dom/push/test/test_serviceworker_lifetime.html | Service worker was terminated. 
[task 2018-01-27T19:04:17.111Z] 19:04:17     INFO - TEST-PASS | dom/push/test/test_serviceworker_lifetime.html | Received correct message type: fetch 
[task 2018-01-27T19:04:17.111Z] 19:04:17     INFO - TEST-PASS | dom/push/test/test_serviceworker_lifetime.html | Service worker is in the correct state: from_scope 
[task 2018-01-27T19:04:17.111Z] 19:04:17     INFO - TEST-PASS | dom/push/test/test_serviceworker_lifetime.html | Received correct message type: fetch 
[task 2018-01-27T19:04:17.112Z] 19:04:17     INFO - TEST-PASS | dom/push/test/test_serviceworker_lifetime.html | Service worker is in the correct state: wait 
[task 2018-01-27T19:04:17.113Z] 19:04:17     INFO - TEST-PASS | dom/push/test/test_serviceworker_lifetime.html | Received correct message type: fetch 
[task 2018-01-27T19:04:17.113Z] 19:04:17     INFO - TEST-PASS | dom/push/test/test_serviceworker_lifetime.html | Service worker is in the correct state: update 
[task 2018-01-27T19:04:17.113Z] 19:04:17     INFO - TEST-PASS | dom/push/test/test_serviceworker_lifetime.html | Received correct message type: fetch 
[task 2018-01-27T19:04:17.114Z] 19:04:17     INFO - TEST-PASS | dom/push/test/test_serviceworker_lifetime.html | Service worker is in the correct state: update 
[task 2018-01-27T19:04:17.115Z] 19:04:17     INFO - Waiting on worker to shutdown.
[task 2018-01-27T19:04:17.119Z] 19:04:17     INFO - TEST-PASS | dom/push/test/test_serviceworker_lifetime.html | Service worker was terminated. 
[task 2018-01-27T19:04:17.120Z] 19:04:17     INFO - Buffered messages finished
[task 2018-01-27T19:04:17.121Z] 19:04:17    ERROR - TEST-UNEXPECTED-FAIL | dom/push/test/test_serviceworker_lifetime.html | application terminated with exit code 11
[task 2018-01-27T19:04:17.122Z] 19:04:17     INFO - runtests.py | Application ran for: 0:01:23.309412
[task 2018-01-27T19:04:17.123Z] 19:04:17     INFO - zombiecheck | Reading PID log: /tmp/tmpRY44kFpidlog
[task 2018-01-27T19:04:17.124Z] 19:04:17     INFO - ==> process 1057 launched child process 1081
[task 2018-01-27T19:04:17.124Z] 19:04:17     INFO - zombiecheck | Checking for orphan process with PID: 1081
[task 2018-01-27T19:04:17.125Z] 19:04:17     INFO - mozcrash Copy/paste: /usr/local/bin/linux64-minidump_stackwalk /tmp/tmpOUjd_u.mozrunner/minidumps/66ce16a7-55a8-97ae-1e07-8a15a449d34b.dmp /builds/worker/workspace/build/symbols
[task 2018-01-27T19:04:25.674Z] 19:04:25     INFO - mozcrash Saved minidump as /builds/worker/workspace/build/blobber_upload_dir/66ce16a7-55a8-97ae-1e07-8a15a449d34b.dmp
[task 2018-01-27T19:04:25.674Z] 19:04:25     INFO - mozcrash Saved app info as /builds/worker/workspace/build/blobber_upload_dir/66ce16a7-55a8-97ae-1e07-8a15a449d34b.extra
[task 2018-01-27T19:04:25.739Z] 19:04:25     INFO - PROCESS-CRASH | dom/push/test/test_serviceworker_lifetime.html | application crashed [@ mozilla::dom::FetchDriver::~FetchDriver]
[task 2018-01-27T19:04:25.740Z] 19:04:25     INFO - Crash dump filename: /tmp/tmpOUjd_u.mozrunner/minidumps/66ce16a7-55a8-97ae-1e07-8a15a449d34b.dmp
[task 2018-01-27T19:04:25.740Z] 19:04:25     INFO - Operating system: Linux
[task 2018-01-27T19:04:25.740Z] 19:04:25     INFO -                   0.0.0 Linux 4.4.0-98-generic #121~14.04.1-Ubuntu SMP Wed Oct 11 11:54:55 UTC 2017 x86_64
[task 2018-01-27T19:04:25.740Z] 19:04:25     INFO - CPU: x86
[task 2018-01-27T19:04:25.741Z] 19:04:25     INFO -      GenuineIntel family 6 model 62 stepping 4
[task 2018-01-27T19:04:25.741Z] 19:04:25     INFO -      2 CPUs
[task 2018-01-27T19:04:25.742Z] 19:04:25     INFO - 
[task 2018-01-27T19:04:25.742Z] 19:04:25     INFO - GPU: UNKNOWN
[task 2018-01-27T19:04:25.742Z] 19:04:25     INFO - 
[task 2018-01-27T19:04:25.742Z] 19:04:25     INFO - Crash reason:  SIGSEGV
[task 2018-01-27T19:04:25.743Z] 19:04:25     INFO - Crash address: 0x0
[task 2018-01-27T19:04:25.743Z] 19:04:25     INFO - Process uptime: not available
[task 2018-01-27T19:04:25.744Z] 19:04:25     INFO - 
[task 2018-01-27T19:04:25.744Z] 19:04:25     INFO - Thread 0 (crashed)
[task 2018-01-27T19:04:25.744Z] 19:04:25     INFO -  0  libxul.so!mozilla::dom::FetchDriver::~FetchDriver [FetchDriver.cpp:1d32e08b9e14 : 360 + 0x16]
[task 2018-01-27T19:04:25.744Z] 19:04:25     INFO -     eip = 0xf0d31c87   esp = 0xffd7b9d0   ebp = 0xffd7b9e8   ebx = 0xf54a0000
[task 2018-01-27T19:04:25.745Z] 19:04:25     INFO -     esi = 0xd9e0a020   edi = 0xf54a0000   eax = 0x00000000   ecx = 0xf7518864
[task 2018-01-27T19:04:25.745Z] 19:04:25     INFO -     edx = 0x00000000   efl = 0x00010286
[task 2018-01-27T19:04:25.746Z] 19:04:25     INFO -     Found by: given as instruction pointer in context
[task 2018-01-27T19:04:25.746Z] 19:04:25     INFO -  1  libxul.so!mozilla::dom::FetchDriver::~FetchDriver [FetchDriver.cpp:1d32e08b9e14 : 361 + 0x9]
[task 2018-01-27T19:04:25.746Z] 19:04:25     INFO -     eip = 0xf0d31de2   esp = 0xffd7b9f0   ebp = 0xffd7ba08   ebx = 0xf54a0000
[task 2018-01-27T19:04:25.747Z] 19:04:25     INFO -     esi = 0xd9e0a020   edi = 0xf54a0000
[task 2018-01-27T19:04:25.747Z] 19:04:25     INFO -     Found by: call frame info
[task 2018-01-27T19:04:25.748Z] 19:04:25     INFO -  2  libxul.so!mozilla::dom::FetchDriver::Release [FetchDriver.cpp:1d32e08b9e14 : 325 + 0x13]
[task 2018-01-27T19:04:25.748Z] 19:04:25     INFO -     eip = 0xf0d31e7f   esp = 0xffd7ba10   ebp = 0xffd7ba38   ebx = 0x00000000
[task 2018-01-27T19:04:25.748Z] 19:04:25     INFO -     esi = 0xd9e0a038   edi = 0xf54a0000
[task 2018-01-27T19:04:25.750Z] 19:04:25     INFO -     Found by: call frame info
[task 2018-01-27T19:04:25.750Z] 19:04:25     INFO -  3  libxul.so!nsCORSListenerProxy::Release [nsCORSListenerProxy.cpp:1d32e08b9e14 : 378 + 0x13]
[task 2018-01-27T19:04:25.750Z] 19:04:25     INFO -     eip = 0xefa3b86f   esp = 0xffd7ba40   ebp = 0xffd7ba68   ebx = 0xf54a0000
[task 2018-01-27T19:04:25.751Z] 19:04:25     INFO -     esi = 0x00000000   edi = 0xe27fac90
[task 2018-01-27T19:04:25.751Z] 19:04:25     INFO -     Found by: call frame info
[task 2018-01-27T19:04:25.752Z] 19:04:25     INFO -  4  libxul.so!mozilla::net::HttpBaseChannel::~HttpBaseChannel [HttpBaseChannel.cpp:1d32e08b9e14 : 239 + 0x7e]
[task 2018-01-27T19:04:25.752Z] 19:04:25     INFO -     eip = 0xefa2afda   esp = 0xffd7ba70   ebp = 0xffd7ba98   ebx = 0xd9e510b0
[task 2018-01-27T19:04:25.752Z] 19:04:25     INFO -     esi = 0xd9e51000   edi = 0x00000000
[task 2018-01-27T19:04:25.752Z] 19:04:25     INFO -     Found by: call frame info
[task 2018-01-27T19:04:25.752Z] 19:04:25     INFO -  5  libxul.so!mozilla::net::nsHttpChannel::~nsHttpChannel [nsHttpChannel.cpp:1d32e08b9e14 : 356 + 0x9]
[task 2018-01-27T19:04:25.753Z] 19:04:25     INFO -     eip = 0xefa6c9b8   esp = 0xffd7baa0   ebp = 0xffd7bab8   ebx = 0xf54a0000
[task 2018-01-27T19:04:25.754Z] 19:04:25     INFO -     esi = 0xd9e51000   edi = 0xf54a0000
[task 2018-01-27T19:04:25.754Z] 19:04:25     INFO -     Found by: call frame info
[task 2018-01-27T19:04:25.754Z] 19:04:25     INFO -  6  libxul.so!mozilla::net::HttpBaseChannel::Release [HttpBaseChannel.cpp:1d32e08b9e14 : 391 + 0x16]
[task 2018-01-27T19:04:25.754Z] 19:04:25     INFO -     eip = 0xef9f7204   esp = 0xffd7bac0   ebp = 0xffd7bae8   ebx = 0xd9e51024
[task 2018-01-27T19:04:25.754Z] 19:04:25     INFO -     esi = 0x00000000   edi = 0xf54a0000
[task 2018-01-27T19:04:25.754Z] 19:04:25     INFO -     Found by: call frame info
[task 2018-01-27T19:04:25.755Z] 19:04:25     INFO -  7  libxul.so!mozilla::net::nsHttpChannel::Release [nsHttpChannel.cpp:1d32e08b9e14 : 5767 + 0x14]
[task 2018-01-27T19:04:25.755Z] 19:04:25     INFO -     eip = 0xefa5e17a   esp = 0xffd7baf0   ebp = 0xffd7bb18   ebx = 0xd9e51000
[task 2018-01-27T19:04:25.756Z] 19:04:25     INFO -     esi = 0xf54a0000   edi = 0x00000000
[task 2018-01-27T19:04:25.756Z] 19:04:25     INFO -     Found by: call frame info
[task 2018-01-27T19:04:25.756Z] 19:04:25     INFO -  8  libxul.so!mozilla::net::InterceptedHttpChannel::ReleaseListeners [nsCOMPtr.h:1d32e08b9e14 : 631 + 0xa]
[task 2018-01-27T19:04:25.757Z] 19:04:25     INFO -     eip = 0xefa6413e   esp = 0xffd7bb20   ebp = 0xffd7bb58   ebx = 0xd9e50800
[task 2018-01-27T19:04:25.757Z] 19:04:25     INFO -     esi = 0xf54a0000   edi = 0x00000000
[task 2018-01-27T19:04:25.758Z] 19:04:25     INFO -     Found by: call frame info
[task 2018-01-27T19:04:25.758Z] 19:04:25     INFO -  9  libxul.so!mozilla::net::InterceptedHttpChannel::OnRedirectVerifyCallback [InterceptedHttpChannel.cpp:1d32e08b9e14 : 1034 + 0x8]
[task 2018-01-27T19:04:25.758Z] 19:04:25     INFO -     eip = 0xefa65c2a   esp = 0xffd7bb60   ebp = 0xffd7bb98   ebx = 0xd9e50800
[task 2018-01-27T19:04:25.758Z] 19:04:25     INFO -     esi = 0xffd7bb78   edi = 0xf54a0000
[task 2018-01-27T19:04:25.759Z] 19:04:25     INFO -     Found by: call frame info
[task 2018-01-27T19:04:25.759Z] 19:04:25     INFO - 10  libxul.so!mozilla::net::nsAsyncVerifyRedirectCallbackEvent::Run [nsAsyncRedirectVerifyHelper.cpp:1d32e08b9e14 : 42 + 0xb]
[task 2018-01-27T19:04:25.760Z] 19:04:25     INFO -     eip = 0xef7e2bdd   esp = 0xffd7bba0   ebp = 0xffd7bbc8   ebx = 0xd8e2a500
[task 2018-01-27T19:04:25.760Z] 19:04:25     INFO -     esi = 0xf54a0000   edi = 0xcd1f08a0
[task 2018-01-27T19:04:25.760Z] 19:04:25     INFO -     Found by: call frame info
[task 2018-01-27T19:04:25.760Z] 19:04:25     INFO - 11  libxul.so!nsThread::ProcessNextEvent [nsThread.cpp:1d32e08b9e14 : 1040 + 0x17]
[task 2018-01-27T19:04:25.761Z] 19:04:25     INFO -     eip = 0xef78045c   esp = 0xffd7bbd0   ebp = 0xffd7c108   ebx = 0xf54a0000
[task 2018-01-27T19:04:25.761Z] 19:04:25     INFO -     esi = 0x0000002d   edi = 0xffd7c0f0
[task 2018-01-27T19:04:25.761Z] 19:04:25     INFO -     Found by: call frame info
[task 2018-01-27T19:04:25.762Z] 19:04:25     INFO - 12  libxul.so!NS_ProcessNextEvent [nsThreadUtils.cpp:1d32e08b9e14 : 517 + 0xc]
[task 2018-01-27T19:04:25.762Z] 19:04:25     INFO -     eip = 0xef7812f2   esp = 0xffd7c110   ebp = 0xffd7c148   ebx = 0x00000000
[task 2018-01-27T19:04:25.762Z] 19:04:25     INFO -     esi = 0xf71243c0   edi = 0xf54a0000
[task 2018-01-27T19:04:25.763Z] 19:04:25     INFO -     Found by: call frame info
[task 2018-01-27T19:04:25.763Z] 19:04:25     INFO - 13  libxul.so!mozilla::ipc::MessagePump::Run [MessagePump.cpp:1d32e08b9e14 : 97 + 0xc]
[task 2018-01-27T19:04:25.764Z] 19:04:25     INFO -     eip = 0xefb5ef7d   esp = 0xffd7c150   ebp = 0xffd7c198   ebx = 0xf71c1130
[task 2018-01-27T19:04:25.764Z] 19:04:25     INFO -     esi = 0xf54a0000   edi = 0xf712e110
[task 2018-01-27T19:04:25.764Z] 19:04:25     INFO -     Found by: call frame info
[task 2018-01-27T19:04:25.764Z] 19:04:25     INFO - 14  libxul.so!MessageLoop::RunInternal [message_loop.cc:1d32e08b9e14 : 326 + 0x14]
[task 2018-01-27T19:04:25.765Z] 19:04:25     INFO -     eip = 0xefb330a2   esp = 0xffd7c1a0   ebp = 0xffd7c1c8   ebx = 0xf712e110
[task 2018-01-27T19:04:25.765Z] 19:04:25     INFO -     esi = 0xf54a0000   edi = 0xffd7c2d0
[task 2018-01-27T19:04:25.765Z] 19:04:25     INFO -     Found by: call frame info
[task 2018-01-27T19:04:25.766Z] 19:04:25     INFO - 15  libxul.so!MessageLoop::Run [message_loop.cc:1d32e08b9e14 : 319 + 0x8]
[task 2018-01-27T19:04:25.766Z] 19:04:25     INFO -     eip = 0xefb330c9   esp = 0xffd7c1d0   ebp = 0xffd7c1f8   ebx = 0xffd7c1e0
[task 2018-01-27T19:04:25.766Z] 19:04:25     INFO -     esi = 0xf712e110   edi = 0xffd7c2d0
[task 2018-01-27T19:04:25.767Z] 19:04:25     INFO -     Found by: call frame info
[task 2018-01-27T19:04:25.767Z] 19:04:25     INFO - 16  libxul.so!nsBaseAppShell::Run [nsBaseAppShell.cpp:1d32e08b9e14 : 157 + 0xe]
[task 2018-01-27T19:04:25.767Z] 19:04:25     INFO -     eip = 0xf146bf70   esp = 0xffd7c200   ebp = 0xffd7c218   ebx = 0xe9177470
[task 2018-01-27T19:04:25.768Z] 19:04:25     INFO -     esi = 0xf71243c0   edi = 0xffd7c2d0
[task 2018-01-27T19:04:25.768Z] 19:04:25     INFO -     Found by: call frame info
[task 2018-01-27T19:04:25.769Z] 19:04:25     INFO - 17  libxul.so!nsAppStartup::Run [nsAppStartup.cpp:1d32e08b9e14 : 288 + 0xe]
[task 2018-01-27T19:04:25.769Z] 19:04:25     INFO -     eip = 0xf24403f3   esp = 0xffd7c220   ebp = 0xffd7c238   ebx = 0xe9186df0
[task 2018-01-27T19:04:25.773Z] 19:04:25     INFO -     esi = 0xf54a0000   edi = 0xffd7c2d0
[task 2018-01-27T19:04:25.773Z] 19:04:25     INFO -     Found by: call frame info
[task 2018-01-27T19:04:25.773Z] 19:04:25     INFO - 18  libxul.so!XREMain::XRE_mainRun [nsAppRunner.cpp:1d32e08b9e14 : 4707 + 0x14]
[task 2018-01-27T19:04:25.774Z] 19:04:25     INFO -     eip = 0xf24d86fc   esp = 0xffd7c240   ebp = 0xffd7c338   ebx = 0x00000077
[task 2018-01-27T19:04:25.774Z] 19:04:25     INFO -     esi = 0xf54a0000   edi = 0xffd7c2d0
[task 2018-01-27T19:04:25.774Z] 19:04:25     INFO -     Found by: call frame info
[task 2018-01-27T19:04:25.774Z] 19:04:25     INFO - 19  libxul.so!XREMain::XRE_main [nsAppRunner.cpp:1d32e08b9e14 : 4842 + 0xb]
[task 2018-01-27T19:04:25.774Z] 19:04:25     INFO -     eip = 0xf24d8f14   esp = 0xffd7c340   ebp = 0xffd7c3b8   ebx = 0xf54a0000
[task 2018-01-27T19:04:25.775Z] 19:04:25     INFO -     esi = 0x00000001   edi = 0xffd7c388
[task 2018-01-27T19:04:25.775Z] 19:04:25     INFO -     Found by: call frame info
[task 2018-01-27T19:04:25.783Z] 19:04:25     INFO - 20  libxul.so!XRE_main [nsAppRunner.cpp:1d32e08b9e14 : 4934 + 0x6]
[task 2018-01-27T19:04:25.783Z] 19:04:25     INFO -     eip = 0xf24d91fb   esp = 0xffd7c3c0   ebp = 0xffd7c518   ebx = 0xffd7c3fc
[task 2018-01-27T19:04:25.783Z] 19:04:25     INFO -     esi = 0x00000005   edi = 0xffd7d664
[task 2018-01-27T19:04:25.783Z] 19:04:25     INFO -     Found by: call frame info
[task 2018-01-27T19:04:25.783Z] 19:04:25     INFO - 21  firefox!do_main [nsBrowserApp.cpp:1d32e08b9e14 : 231 + 0x1e]
[task 2018-01-27T19:04:25.783Z] 19:04:25     INFO -     eip = 0x0804db4d   esp = 0xffd7c520   ebp = 0xffd7d568   ebx = 0x08087000
[task 2018-01-27T19:04:25.784Z] 19:04:25     INFO -     esi = 0x00000005   edi = 0xffd7d664
[task 2018-01-27T19:04:25.784Z] 19:04:25     INFO -     Found by: call frame info
[task 2018-01-27T19:04:25.784Z] 19:04:25     INFO - 22  firefox!main [nsBrowserApp.cpp:1d32e08b9e14 : 304 + 0xd]
[task 2018-01-27T19:04:25.784Z] 19:04:25     INFO -     eip = 0x0804d4d3   esp = 0xffd7d570   ebp = 0xffd7d5b8   ebx = 0x08087000
[task 2018-01-27T19:04:25.784Z] 19:04:25     INFO -     esi = 0xffd7d664   edi = 0x080872a4
[task 2018-01-27T19:04:25.784Z] 19:04:25     INFO -     Found by: call frame info
[task 2018-01-27T19:04:25.785Z] 19:04:25     INFO - 23  libc-2.23.so + 0x18637
[task 2018-01-27T19:04:25.785Z] 19:04:25     INFO -     eip = 0xf737d637   esp = 0xffd7d5c0   ebp = 0x00000000
[task 2018-01-27T19:04:25.785Z] 19:04:25     INFO -     Found by: previous frame's frame pointer
[task 2018-01-27T19:04:25.785Z] 19:04:25     INFO - 24  libc-2.23.so + 0x1b2000
[task 2018-01-27T19:04:25.785Z] 19:04:25     INFO -     eip = 0xf7517000   esp = 0xffd7d5c4   ebp = 0x00000000
[task 2018-01-27T19:04:25.785Z] 19:04:25     INFO -     Found by: stack scanning
[task 2018-01-27T19:04:25.785Z] 19:04:25     INFO - 25  libc-2.23.so + 0x1b2000
[task 2018-01-27T19:04:25.785Z] 19:04:25     INFO -     eip = 0xf7517000   esp = 0xffd7d5c8   ebp = 0x00000000
[task 2018-01-27T19:04:25.786Z] 19:04:25     INFO -     Found by: stack scanning
[task 2018-01-27T19:04:25.786Z] 19:04:25     INFO - 26  libc-2.23.so + 0x18637
[task 2018-01-27T19:04:25.786Z] 19:04:25     INFO -     eip = 0xf737d637   esp = 0xffd7d5d0   ebp = 0x00000000
[task 2018-01-27T19:04:25.786Z] 19:04:25     INFO -     Found by: stack scanning
[task 2018-01-27T19:04:25.786Z] 19:04:25     INFO - 27  libc-2.23.so + 0x1b2000
[task 2018-01-27T19:04:25.786Z] 19:04:25     INFO -     eip = 0xf7517000   esp = 0xffd7d5ec   ebp = 0x00000000
[task 2018-01-27T19:04:25.786Z] 19:04:25     INFO -     Found by: stack scanning
[task 2018-01-27T19:04:25.786Z] 19:04:25     INFO - 28  ld-2.23.so + 0x24c04
[task 2018-01-27T19:04:25.787Z] 19:04:25     INFO -     eip = 0xf777cc04   esp = 0xffd7d5f0   ebp = 0x00000000
[task 2018-01-27T19:04:25.787Z] 19:04:25     INFO -     Found by: stack scanning
[task 2018-01-27T19:04:25.787Z] 19:04:25     INFO - 29  ld-2.23.so + 0x24000
[task 2018-01-27T19:04:25.787Z] 19:04:25     INFO -     eip = 0xf777c000   esp = 0xffd7d5f4   ebp = 0x00000000
[task 2018-01-27T19:04:25.787Z] 19:04:25     INFO -     Found by: stack scanning
[task 2018-01-27T19:04:25.787Z] 19:04:25     INFO - 30  libc-2.23.so + 0x1b2000
[task 2018-01-27T19:04:25.787Z] 19:04:25     INFO -     eip = 0xf7517000   esp = 0xffd7d5fc   ebp = 0x00000000
[task 2018-01-27T19:04:25.788Z] 19:04:25     INFO -     Found by: stack scanning
[task 2018-01-27T19:04:25.788Z] 19:04:25     INFO - 31  libc-2.23.so + 0x1b2000
[task 2018-01-27T19:04:25.788Z] 19:04:25     INFO -     eip = 0xf7517000   esp = 0xffd7d600   ebp = 0x00000000
[task 2018-01-27T19:04:25.788Z] 19:04:25     INFO -     Found by: stack scanning
[task 2018-01-27T19:04:25.788Z] 19:04:25     INFO - 32  libxul.so!_fini + 0xd78c65
[task 2018-01-27T19:04:25.789Z] 19:04:25     INFO -     eip = 0xf4820759   esp = 0xffd7d608   ebp = 0x00000000
[task 2018-01-27T19:04:25.789Z] 19:04:25     INFO -     Found by: stack scanning
[task 2018-01-27T19:04:25.790Z] 19:04:25     INFO - 33  firefox!_GLOBAL__sub_I_TimeStamp.cpp [TimeStamp.cpp:1d32e08b9e14 : 96 + 0x8]
[task 2018-01-27T19:04:25.790Z] 19:04:25     INFO -     eip = 0x0804d77c   esp = 0xffd7d620   ebp = 0x00000000
[task 2018-01-27T19:04:25.791Z] 19:04:25     INFO -     Found by: stack scanning
[task 2018-01-27T19:04:25.792Z] 19:04:25     INFO - 34  ld-2.23.so + 0x15010
[task 2018-01-27T19:04:25.792Z] 19:04:25     INFO -     eip = 0xf776d010   esp = 0xffd7d628   ebp = 0x00000000
[task 2018-01-27T19:04:25.793Z] 19:04:25     INFO -     Found by: stack scanning
[task 2018-01-27T19:04:25.794Z] 19:04:25     INFO - 35  ld-2.23.so + 0xf880
[task 2018-01-27T19:04:25.794Z] 19:04:25     INFO -     eip = 0xf7767880   esp = 0xffd7d62c   ebp = 0x00000000
[task 2018-01-27T19:04:25.795Z] 19:04:25     INFO -     Found by: stack scanning
[task 2018-01-27T19:04:25.796Z] 19:04:25     INFO - 36  ld-2.23.so + 0x24000
[task 2018-01-27T19:04:25.796Z] 19:04:25     INFO -     eip = 0xf777c000   esp = 0xffd7d630   ebp = 0x00000000
[task 2018-01-27T19:04:25.797Z] 19:04:25     INFO -     Found by: stack scanning
[task 2018-01-27T19:04:25.798Z] 19:04:25     INFO - 37  firefox!_GLOBAL__sub_I_TimeStamp.cpp [TimeStamp.cpp:1d32e08b9e14 : 96 + 0x8]
[task 2018-01-27T19:04:25.798Z] 19:04:25     INFO -     eip = 0x0804d77c   esp = 0xffd7d638   ebp = 0x00000000
[task 2018-01-27T19:04:25.799Z] 19:04:25     INFO -     Found by: stack scanning
[task 2018-01-27T19:04:25.799Z] 19:04:25     INFO - 38  firefox!_start + 0x21
[task 2018-01-27T19:04:25.800Z] 19:04:25     INFO -     eip = 0x0804d79d   esp = 0xffd7d640   ebp = 0x00000000
[task 2018-01-27T19:04:25.801Z] 19:04:25     INFO -     Found by: stack scanning
[task 2018-01-27T19:04:25.801Z] 19:04:25     INFO - 39  firefox!SSE2Check [nsBrowserApp.cpp:1d32e08b9e14 : 87 + 0x8]
[task 2018-01-27T19:04:25.802Z] 19:04:25     INFO -     eip = 0x0804d430   esp = 0xffd7d644   ebp = 0x00000000
[task 2018-01-27T19:04:25.803Z] 19:04:25     INFO -     Found by: stack scanning
[task 2018-01-27T19:04:25.803Z] 19:04:25     INFO - 40  firefox!__libc_csu_fini + 0x10
[task 2018-01-27T19:04:25.804Z] 19:04:25     INFO -     eip = 0x08077330   esp = 0xffd7d650   ebp = 0xffd7d664
[task 2018-01-27T19:04:25.805Z] 19:04:25     INFO -     Found by: stack scanning
[task 2018-01-27T19:04:25.805Z] 19:04:25     INFO - 41  0xffd7f530
[task 2018-01-27T19:04:25.806Z] 19:04:25     INFO -     eip = 0xffd7f530   esp = 0xffd7d66c   ebp = 0xffd7f4f5
[task 2018-01-27T19:04:25.806Z] 19:04:25     INFO -     Found by: previous frame's frame pointer
[task 2018-01-27T19:04:25.807Z] 19:04:25     INFO - 42  0x2f73646c
[task 2018-01-27T19:04:25.808Z] 19:04:25     INFO -     eip = 0x2f73646c   esp = 0xffd7f4fd   ebp = 0x6975622f
[task 2018-01-27T19:04:25.808Z] 19:04:25     INFO -     Found by: previous frame's frame pointer
Also popped up after bug 1433276 landed.
Blocks: 1433276
Flags: needinfo?(jmaher)
Keywords: leave-open
Summary: Intermittent dom/push/test/test_serviceworker_lifetime.html | application crashed [@ mozilla::dom::FetchDriver::~FetchDriver] after Assertion failure: mResponseAvailableCalled, at FetchDriver.cpp:360 → Intermittent linux32-non-e10s dom/push/test/test_serviceworker_lifetime.html | application crashed [@ mozilla::dom::FetchDriver::~FetchDriver] after Assertion failure: mResponseAvailableCalled, at FetchDriver.cpp:360
:bkelly- running tests on linux32/debug instead of win7/debug yields this error as well- this test has been disabled on !e10 for now (and it wasn't running on windows prior, so we didn't have test coverage prior to this recent change).  could you help figure out the right person to look at this?
Flags: needinfo?(jmaher) → needinfo?(bkelly)

Comment 4

25 days ago
Marion can you help me find someone to look at this?  It seems in non-e10s mode this test:

dom/push/test/test_serviceworker_lifetime.html

Triggers this low frequency assertion crash.  I tested on my machine and cannot reproduce.  It probably needs the timing of the slow of automation virtual machines.

This one is relatively important to fix and get the test re-enabled.  This test_serviceworker_lifetime.html is an important test because it exercises our various service worker termination code.  This type of forced thread shutdown is not well covered by other tests because other tests are written to avoid it, by design.

We still have the test running on e10s configurations so we haven't lost all coverage, but it would be good to get it running again for non-e10s.  We still ship android in non-e10s mode.
Flags: needinfo?(bkelly) → needinfo?(mdaly)

Comment 5

25 days ago
I'll assign it to Catalin, related to the other bug I gave him earlier.
Flags: needinfo?(mdaly)

Updated

25 days ago
Assignee: nobody → catalin.badea392
You need to log in before you can comment on or make changes to this bug.