Closed
Bug 1495158
Opened 6 years ago
Closed 6 years ago
Intermittent testing/marionette/harness/marionette_harness/tests/unit/test_quit_restart.py TestQuitRestart.test_in_app_restart | application crashed [@ MOZ_CrashOOL]
Categories
(Testing :: Marionette Client and Harness, defect, P5)
Tracking
(firefox-esr60 unaffected, firefox62 unaffected, firefox63 unaffected, firefox64 fixed)
RESOLVED
FIXED
mozilla64
| Tracking | Status | |
|---|---|---|
| firefox-esr60 | --- | unaffected |
| firefox62 | --- | unaffected |
| firefox63 | --- | unaffected |
| firefox64 | --- | fixed |
People
(Reporter: intermittent-bug-filer, Assigned: kip)
References
(Depends on 1 open bug)
Details
(Keywords: crash, intermittent-failure)
Crash Data
Filed by: nerli [at] mozilla.com https://treeherder.mozilla.org/logviewer.html#?job_id=202320701&repo=mozilla-inbound https://queue.taskcluster.net/v1/task/eYUPJRe1T8aMY2PZnCAqyQ/runs/0/artifacts/public/logs/live_backing.log [task 2018-09-28T23:48:56.737Z] 23:48:56 INFO - TEST-START | testing/marionette/harness/marionette_harness/tests/unit/test_quit_restart.py TestQuitRestart.test_in_app_restart [task 2018-09-28T23:48:56.752Z] 23:48:56 INFO - 1538178536744 Marionette DEBUG Closed connection 1 [task 2018-09-28T23:48:56.753Z] 23:48:56 INFO - 1538178536745 Marionette DEBUG Accepted connection 2 from 127.0.0.1:49048 [task 2018-09-28T23:48:56.757Z] 23:48:56 INFO - 1538178536750 Marionette TRACE 2 -> [0,1,"WebDriver:NewSession",{}] [task 2018-09-28T23:48:56.758Z] 23:48:56 INFO - 1538178536752 Marionette DEBUG [2147483649] Frame script loaded [task 2018-09-28T23:48:56.766Z] 23:48:56 INFO - 1538178536760 Marionette DEBUG [2147483649] Frame script registered [task 2018-09-28T23:48:56.767Z] 23:48:56 INFO - 1538178536763 Marionette TRACE 2 <- [1,1,null,{"sessionId":"2797aa15-b396-4ee2-9cec-cdb910733100","capabilities":{"browserName":"firefox","browserVersion":"64.0a ... ssID":7425,"moz:profile":"/tmp/tmpAGlGfP.mozrunner","moz:useNonSpecCompliantPointerOrigin":false,"moz:webdriverClick":true}}] [task 2018-09-28T23:48:56.844Z] 23:48:56 INFO - 1538178536836 Marionette TRACE 2 -> [0,2,"WebDriver:SetTimeouts",{"script":30000}] [task 2018-09-28T23:48:56.845Z] 23:48:56 INFO - 1538178536838 Marionette TRACE 2 <- [1,2,null,{"value":null}] [task 2018-09-28T23:48:56.845Z] 23:48:56 INFO - 1538178536840 Marionette TRACE 2 -> [0,3,"WebDriver:SetTimeouts",{"pageLoad":300000}] [task 2018-09-28T23:48:56.845Z] 23:48:56 INFO - 1538178536841 Marionette TRACE 2 <- [1,3,null,{"value":null}] [task 2018-09-28T23:48:56.848Z] 23:48:56 INFO - 1538178536843 Marionette TRACE 2 -> [0,4,"WebDriver:SetTimeouts",{"implicit":0}] [task 2018-09-28T23:48:56.849Z] 23:48:56 INFO - 1538178536844 Marionette TRACE 2 <- [1,4,null,{"value":null}] [task 2018-09-28T23:48:56.857Z] 23:48:56 INFO - 1538178536852 Marionette TRACE 2 -> [0,5,"Marionette:GetContext",{}] [task 2018-09-28T23:48:56.857Z] 23:48:56 INFO - 1538178536854 Marionette TRACE 2 <- [1,5,null,{"value":"content"}] [task 2018-09-28T23:48:56.858Z] 23:48:56 INFO - 1538178536855 Marionette TRACE 2 -> [0,6,"Marionette:SetContext",{"value":"chrome"}] [task 2018-09-28T23:48:56.858Z] 23:48:56 INFO - 1538178536855 Marionette TRACE 2 <- [1,6,null,{"value":null}] [task 2018-09-28T23:48:56.867Z] 23:48:56 INFO - 1538178536860 Marionette TRACE 2 -> [0,7,"WebDriver:ExecuteScript",{"scriptTimeout":null,"newSandbox":true,"args":["startup.homepage_welcome_url",false,"unspecif ... tBranch});\n return prefs.get(pref, null, Components.interfaces[valueType]);","sandbox":"default","line":893}] [task 2018-09-28T23:48:56.867Z] 23:48:56 INFO - 1538178536865 Marionette TRACE 2 <- [1,7,null,{"value":"https://www.mozilla.org/projects/firefox/%VERSION%/firstrun/"}] [task 2018-09-28T23:48:56.873Z] 23:48:56 INFO - 1538178536866 Marionette TRACE 2 -> [0,8,"Marionette:SetContext",{"value":"content"}] [task 2018-09-28T23:48:56.882Z] 23:48:56 INFO - 1538178536869 Marionette TRACE 2 <- [1,8,null,{"value":null}] [task 2018-09-28T23:48:56.882Z] 23:48:56 INFO - 1538178536870 Marionette TRACE 2 -> [0,9,"Marionette:GetContext",{}] [task 2018-09-28T23:48:56.882Z] 23:48:56 INFO - 1538178536870 Marionette TRACE 2 <- [1,9,null,{"value":"content"}] [task 2018-09-28T23:48:56.882Z] 23:48:56 INFO - 1538178536871 Marionette TRACE 2 -> [0,10,"Marionette:SetContext",{"value":"chrome"}] [task 2018-09-28T23:48:56.883Z] 23:48:56 INFO - 1538178536872 Marionette TRACE 2 <- [1,10,null,{"value":null}] [task 2018-09-28T23:48:56.883Z] 23:48:56 INFO - 1538178536874 Marionette TRACE 2 -> [0,11,"WebDriver:ExecuteScript",{"scriptTimeout":null,"newSandbox":true,"args":["startup.homepage_welcome_url","about:about", ... = new Preferences({defaultBranch: defaultBranch});\n prefs.set(pref, value);","sandbox":"default","line":927}] [task 2018-09-28T23:48:56.883Z] 23:48:56 INFO - 1538178536876 Marionette TRACE 2 <- [1,11,null,{"value":null}] [task 2018-09-28T23:48:56.883Z] 23:48:56 INFO - 1538178536877 Marionette TRACE 2 -> [0,12,"Marionette:SetContext",{"value":"content"}] [task 2018-09-28T23:48:56.884Z] 23:48:56 INFO - 1538178536878 Marionette TRACE 2 <- [1,12,null,{"value":null}] [task 2018-09-28T23:48:56.884Z] 23:48:56 INFO - 1538178536879 Marionette TRACE 2 -> [0,13,"Marionette:GetContext",{}] [task 2018-09-28T23:48:56.888Z] 23:48:56 INFO - 1538178536880 Marionette TRACE 2 <- [1,13,null,{"value":"content"}] [task 2018-09-28T23:48:56.889Z] 23:48:56 INFO - 1538178536885 Marionette TRACE 2 -> [0,14,"Marionette:GetContext",{}] [task 2018-09-28T23:48:56.889Z] 23:48:56 INFO - 1538178536886 Marionette TRACE 2 <- [1,14,null,{"value":"content"}] [task 2018-09-28T23:48:56.892Z] 23:48:56 INFO - 1538178536887 Marionette TRACE 2 -> [0,15,"Marionette:SetContext",{"value":"chrome"}] [task 2018-09-28T23:48:56.893Z] 23:48:56 INFO - 1538178536890 Marionette TRACE 2 <- [1,15,null,{"value":null}] [task 2018-09-28T23:48:56.897Z] 23:48:56 INFO - 1538178536894 Marionette TRACE 2 -> [0,16,"WebDriver:ExecuteScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"../../venv/lib/python2.7/site-p ... ancelQuit, \"quit-application-requested\", null);\n return cancelQuit.data;","sandbox":"default","line":1062}] [task 2018-09-28T23:48:56.914Z] 23:48:56 INFO - 1538178536906 Marionette TRACE 2 <- [1,16,null,{"value":false}] [task 2018-09-28T23:48:56.914Z] 23:48:56 INFO - 1538178536908 Marionette TRACE 2 -> [0,17,"Marionette:SetContext",{"value":"content"}] [task 2018-09-28T23:48:56.915Z] 23:48:56 INFO - 1538178536908 Marionette TRACE 2 <- [1,17,null,{"value":null}] [task 2018-09-28T23:48:56.916Z] 23:48:56 INFO - 1538178536909 Marionette TRACE 2 -> [0,18,"Marionette:Quit",{"flags":["eForceQuit","eRestart"]}] [task 2018-09-28T23:48:56.917Z] 23:48:56 INFO - 1538178536910 Marionette INFO Stopped listening on port 2828 [task 2018-09-28T23:48:57.017Z] 23:48:57 INFO - 1538178537012 Marionette TRACE 2 <- [1,18,null,{"cause":"restart"}] [task 2018-09-28T23:48:57.075Z] 23:48:57 INFO - 1538178537065 Marionette DEBUG Closed connection 2 [task 2018-09-28T23:48:57.110Z] 23:48:57 INFO - [Parent 7425, Gecko_IOThread] WARNING: pipe error (106): Connection reset by peer: file /builds/worker/workspace/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 356 [task 2018-09-28T23:48:57.333Z] 23:48:57 INFO - 1538178537326 Marionette DEBUG Received observer notification xpcom-will-shutdown [task 2018-09-28T23:48:57.334Z] 23:48:57 INFO - 1538178537327 Marionette DEBUG Remote service is inactive [task 2018-09-28T23:50:01.028Z] 23:50:01 INFO - ExceptionHandler::WaitForContinueSignal waiting for continue signal... [task 2018-09-28T23:50:01.029Z] 23:50:01 INFO - ExceptionHandler::GenerateDump cloned child 7613 [task 2018-09-28T23:50:01.030Z] 23:50:01 INFO - ExceptionHandler::SendContinueSignalToChild sent continue signal to child [task 2018-09-28T23:52:57.141Z] 23:52:57 INFO - mozcrash Downloading symbols from: https://queue.taskcluster.net/v1/task/N9nPrfOZR5OjR9uSc2V6rg/artifacts/public/build/target.crashreporter-symbols.zip [task 2018-09-28T23:53:03.797Z] 23:53:03 INFO - mozcrash Copy/paste: /usr/local/bin/linux64-minidump_stackwalk /tmp/tmpAGlGfP.mozrunner/minidumps/21db36a3-44bc-df0c-885e-c6226a15b511.dmp /tmp/tmpCVGsXe [task 2018-09-28T23:53:14.846Z] 23:53:14 INFO - mozcrash Saved minidump as /builds/worker/workspace/build/blobber_upload_dir/21db36a3-44bc-df0c-885e-c6226a15b511.dmp [task 2018-09-28T23:53:14.847Z] 23:53:14 INFO - mozcrash Saved app info as /builds/worker/workspace/build/blobber_upload_dir/21db36a3-44bc-df0c-885e-c6226a15b511.extra [task 2018-09-28T23:53:14.918Z] 23:53:14 INFO - PROCESS-CRASH | testing/marionette/harness/marionette_harness/tests/unit/test_quit_restart.py TestQuitRestart.test_in_app_restart | application crashed [@ MOZ_CrashOOL] [task 2018-09-28T23:53:14.919Z] 23:53:14 INFO - Crash dump filename: /tmp/tmpAGlGfP.mozrunner/minidumps/21db36a3-44bc-df0c-885e-c6226a15b511.dmp [task 2018-09-28T23:53:14.919Z] 23:53:14 INFO - Operating system: Linux [task 2018-09-28T23:53:14.920Z] 23:53:14 INFO - 0.0.0 Linux 4.4.0-1014-aws #14taskcluster1-Ubuntu SMP Tue Apr 3 10:27:00 UTC 2018 x86_64 [task 2018-09-28T23:53:14.920Z] 23:53:14 INFO - CPU: amd64 [task 2018-09-28T23:53:14.920Z] 23:53:14 INFO - family 6 model 62 stepping 4 [task 2018-09-28T23:53:14.921Z] 23:53:14 INFO - 2 CPUs [task 2018-09-28T23:53:14.921Z] 23:53:14 INFO - [task 2018-09-28T23:53:14.921Z] 23:53:14 INFO - GPU: UNKNOWN [task 2018-09-28T23:53:14.922Z] 23:53:14 INFO - [task 2018-09-28T23:53:14.922Z] 23:53:14 INFO - Crash reason: SIGSEGV [task 2018-09-28T23:53:14.923Z] 23:53:14 INFO - Crash address: 0x0 [task 2018-09-28T23:53:14.923Z] 23:53:14 INFO - Process uptime: not available
|
||
Comment 1•6 years ago
|
||
Nerli, this is a crash and as such the comment 0 should contain the information about the crashing thread. But exactly this is missing here. Please make sure to add it in the future. Here the crash information of the shutdown hang: [task 2018-09-28T23:53:14.924Z] 23:53:14 INFO - Thread 31 (crashed) [task 2018-09-28T23:53:14.924Z] 23:53:14 INFO - 0 firefox-bin!MOZ_CrashOOL [Assertions.cpp:b8d8c53289150332f491df758566cf6832f2f400 : 33 + 0x0] [task 2018-09-28T23:53:14.924Z] 23:53:14 INFO - rax = 0x00007f2c6321af10 rdx = 0x0000000000000072 [task 2018-09-28T23:53:14.925Z] 23:53:14 INFO - rcx = 0x00007f2c85716a00 rbx = 0x00007f2c632330c0 [task 2018-09-28T23:53:14.925Z] 23:53:14 INFO - rsi = 0x00007f2c6321af10 rdi = 0x00000000000007e3 [task 2018-09-28T23:53:14.926Z] 23:53:14 INFO - rbp = 0x00007f2c625fee10 rsp = 0x00007f2c625fee10 [task 2018-09-28T23:53:14.926Z] 23:53:14 INFO - r8 = 0x0000000000000001 r9 = 0x0000000000000000 [task 2018-09-28T23:53:14.926Z] 23:53:14 INFO - r10 = 0x0000000000000080 r11 = 0x000055d194f649f6 [task 2018-09-28T23:53:14.927Z] 23:53:14 INFO - r12 = 0x00007f2c625fee40 r13 = 0x0000000000000002 [task 2018-09-28T23:53:14.927Z] 23:53:14 INFO - r14 = 0x00007f2c6793e000 r15 = 0x00007f2c8608f305 [task 2018-09-28T23:53:14.927Z] 23:53:14 INFO - rip = 0x000055d194f64a01 [task 2018-09-28T23:53:14.928Z] 23:53:14 INFO - Found by: given as instruction pointer in context [task 2018-09-28T23:53:14.928Z] 23:53:14 INFO - 1 libxul.so!mozilla::dom::workerinternals::RuntimeService::CrashIfHanging() [RuntimeService.cpp:b8d8c53289150332f491df758566cf6832f2f400 : 2019 + 0x12] [task 2018-09-28T23:53:14.928Z] 23:53:14 INFO - rbx = 0x00007f2c632330c0 rbp = 0x00007f2c625feea0 [task 2018-09-28T23:53:14.929Z] 23:53:14 INFO - rsp = 0x00007f2c625fee20 r12 = 0x00007f2c625fee40 [task 2018-09-28T23:53:14.929Z] 23:53:14 INFO - r13 = 0x0000000000000002 r14 = 0x00007f2c6793e000 [task 2018-09-28T23:53:14.929Z] 23:53:14 INFO - r15 = 0x00007f2c8608f305 rip = 0x00007f2c76fc4d68 [task 2018-09-28T23:53:14.930Z] 23:53:14 INFO - Found by: call frame info [task 2018-09-28T23:53:14.930Z] 23:53:14 INFO - 2 libxul.so!mozilla::(anonymous namespace)::RunWatchdog(void*) [nsTerminator.cpp:b8d8c53289150332f491df758566cf6832f2f400 : 213 + 0x8] [task 2018-09-28T23:53:14.931Z] 23:53:14 INFO - rbx = 0x000000000000003f rbp = 0x00007f2c625feed0 [task 2018-09-28T23:53:14.931Z] 23:53:14 INFO - rsp = 0x00007f2c625feeb0 r12 = 0x00007f2c854159d0 [task 2018-09-28T23:53:14.932Z] 23:53:14 INFO - r13 = 0x00007f2c64ffca60 r14 = 0x00007f2c649a7c88 [task 2018-09-28T23:53:14.932Z] 23:53:14 INFO - r15 = 0x0000000000001dac rip = 0x00007f2c783dff41 [task 2018-09-28T23:53:14.933Z] 23:53:14 INFO - Found by: call frame info [task 2018-09-28T23:53:14.933Z] 23:53:14 INFO - 3 libnspr4.so!_pt_root [ptthread.c:b8d8c53289150332f491df758566cf6832f2f400 : 201 + 0x4] [task 2018-09-28T23:53:14.934Z] 23:53:14 INFO - rbx = 0x0000000000000007 rbp = 0x00007f2c625fef10 [task 2018-09-28T23:53:14.934Z] 23:53:14 INFO - rsp = 0x00007f2c625feee0 r12 = 0x00007f2c854159d0 [task 2018-09-28T23:53:14.935Z] 23:53:14 INFO - r13 = 0x00007f2c64ffca60 r14 = 0x00007f2c625ff700 [task 2018-09-28T23:53:14.935Z] 23:53:14 INFO - r15 = 0x0000000000001dac rip = 0x00007f2c86aee10d [task 2018-09-28T23:53:14.936Z] 23:53:14 INFO - Found by: call frame info [task 2018-09-28T23:53:14.936Z] 23:53:14 INFO - 4 libpthread-2.23.so + 0x76ba [task 2018-09-28T23:53:14.937Z] 23:53:14 INFO - rbx = 0x0000000000000000 rbp = 0x0000000000000000 [task 2018-09-28T23:53:14.937Z] 23:53:14 INFO - rsp = 0x00007f2c625fef20 r12 = 0x0000000000000000 [task 2018-09-28T23:53:14.938Z] 23:53:14 INFO - r13 = 0x00007ffe3624272f r14 = 0x00007f2c625ff9c0 [task 2018-09-28T23:53:14.938Z] 23:53:14 INFO - r15 = 0x00007f2c64ffca60 rip = 0x00007f2c866ee6ba [task 2018-09-28T23:53:14.938Z] 23:53:14 INFO - Found by: call frame info [task 2018-09-28T23:53:14.939Z] 23:53:14 INFO - 5 libc-2.23.so + 0x10741d [task 2018-09-28T23:53:14.939Z] 23:53:14 INFO - rsp = 0x00007f2c625fefc0 rip = 0x00007f2c8577741d [task 2018-09-28T23:53:14.939Z] 23:53:14 INFO - Found by: stack scanning The main thread seem to be stuck in canceling a timer for `VRManager::StopVRListenerThreadTasks()`: [task 2018-09-28T23:53:14.940Z] 23:53:14 INFO - Thread 0 [task 2018-09-28T23:53:14.940Z] 23:53:14 INFO - 0 libpthread-2.23.so + 0x1026d [task 2018-09-28T23:53:14.941Z] 23:53:14 INFO - rax = 0xfffffffffffffe00 rdx = 0x0000000000000002 [task 2018-09-28T23:53:14.941Z] 23:53:14 INFO - rcx = 0x00007f2c866f726d rbx = 0x00007f2c693b2d40 [task 2018-09-28T23:53:14.942Z] 23:53:14 INFO - rsi = 0x0000000000000080 rdi = 0x00007f2c693b2d78 [task 2018-09-28T23:53:14.943Z] 23:53:14 INFO - rbp = 0x00007ffe36247db0 rsp = 0x00007ffe36247cf8 [task 2018-09-28T23:53:14.944Z] 23:53:14 INFO - r8 = 0x00007f2c693b2d78 r9 = 0x00007f2c857cef90 [task 2018-09-28T23:53:14.944Z] 23:53:14 INFO - r10 = 0x0000000000000000 r11 = 0x0000000000000282 [task 2018-09-28T23:53:14.945Z] 23:53:14 INFO - r12 = 0x00007ffe36247dd8 r13 = 0x00007ffe36248180 [task 2018-09-28T23:53:14.946Z] 23:53:14 INFO - r14 = 0x00007f2c693b2d78 r15 = 0x0000000000000000 [task 2018-09-28T23:53:14.947Z] 23:53:14 INFO - rip = 0x00007f2c866f726d [task 2018-09-28T23:53:14.947Z] 23:53:14 INFO - Found by: given as instruction pointer in context [task 2018-09-28T23:53:14.948Z] 23:53:14 INFO - 1 libxul.so!nsTimerImpl::CancelImpl(bool) [Mutex.h:b8d8c53289150332f491df758566cf6832f2f400 : 66 + 0xc] [task 2018-09-28T23:53:14.949Z] 23:53:14 INFO - rbp = 0x00007ffe36247e10 rsp = 0x00007ffe36247dc0 [task 2018-09-28T23:53:14.950Z] 23:53:14 INFO - rip = 0x00007f2c7868b024 [task 2018-09-28T23:53:14.951Z] 23:53:14 INFO - Found by: previous frame's frame pointer [task 2018-09-28T23:53:14.951Z] 23:53:14 INFO - 2 libxul.so!nsTimer::Cancel() [nsTimerImpl.cpp:b8d8c53289150332f491df758566cf6832f2f400 : 509 + 0x7] [task 2018-09-28T23:53:14.952Z] 23:53:14 INFO - rbx = 0x0000000000000000 rbp = 0x00007ffe36247e30 [task 2018-09-28T23:53:14.953Z] 23:53:14 INFO - rsp = 0x00007ffe36247e20 r12 = 0x00007f2c854b82f0 [task 2018-09-28T23:53:14.954Z] 23:53:14 INFO - r14 = 0x00007f2c854f3088 r15 = 0x00007ffe36247fa8 [task 2018-09-28T23:53:14.955Z] 23:53:14 INFO - rip = 0x00007f2c7868c238 [task 2018-09-28T23:53:14.955Z] 23:53:14 INFO - Found by: call frame info [task 2018-09-28T23:53:14.956Z] 23:53:14 INFO - 3 libxul.so!mozilla::gfx::VRManager::StopVRListenerThreadTasks() [VRManager.cpp:b8d8c53289150332f491df758566cf6832f2f400 : 302 + 0x6] [task 2018-09-28T23:53:14.957Z] 23:53:14 INFO - rbx = 0x00007f2c6c6346d0 rbp = 0x00007ffe36247e50 [task 2018-09-28T23:53:14.958Z] 23:53:14 INFO - rsp = 0x00007ffe36247e40 r12 = 0x00007f2c854b82f0 [task 2018-09-28T23:53:14.959Z] 23:53:14 INFO - r14 = 0x00007f2c854f3088 r15 = 0x00007ffe36247fa8 [task 2018-09-28T23:53:14.959Z] 23:53:14 INFO - rip = 0x00007f2c75d31f24 [task 2018-09-28T23:53:14.960Z] 23:53:14 INFO - Found by: call frame info [task 2018-09-28T23:53:14.961Z] 23:53:14 INFO - 4 libxul.so!mozilla::gfx::VRListenerThreadHolder::Shutdown() [VRThread.cpp:b8d8c53289150332f491df758566cf6832f2f400 : 108 + 0x7] [task 2018-09-28T23:53:14.962Z] 23:53:14 INFO - rbx = 0x00007ffe36247eb8 rbp = 0x00007ffe36247e70 [task 2018-09-28T23:53:14.962Z] 23:53:14 INFO - rsp = 0x00007ffe36247e60 r12 = 0x00007f2c854b82f0 [task 2018-09-28T23:53:14.963Z] 23:53:14 INFO - r14 = 0x00007f2c854f3088 r15 = 0x00007ffe36247fa8 [task 2018-09-28T23:53:14.964Z] 23:53:14 INFO - rip = 0x00007f2c75d3302b [task 2018-09-28T23:53:14.964Z] 23:53:14 INFO - Found by: call frame info Kip, is that an already known problem for VR? If not I can file a new bug.
| Comment hidden (Intermittent Failures Robot) |
|
||
Comment 3•6 years ago
|
||
:whimboo will do, sorry about that
|
|
||
Updated•6 years ago
|
Flags: needinfo?(nerli)
|
Assignee | |
Comment 4•6 years ago
|
||
I suspect this crash is the same as Bug 1491868 (Avoid shutdown hang by checking if VRListenerThread is null) (In reply to Henrik Skupin (:whimboo) from comment #1) > Nerli, this is a crash and as such the comment 0 should contain the > information about the crashing thread. But exactly this is missing here. > Please make sure to add it in the future. > > Here the crash information of the shutdown hang: > > [task 2018-09-28T23:53:14.924Z] 23:53:14 INFO - Thread 31 (crashed) > [task 2018-09-28T23:53:14.924Z] 23:53:14 INFO - 0 > firefox-bin!MOZ_CrashOOL > [Assertions.cpp:b8d8c53289150332f491df758566cf6832f2f400 : 33 + 0x0] > [task 2018-09-28T23:53:14.924Z] 23:53:14 INFO - rax = > 0x00007f2c6321af10 rdx = 0x0000000000000072 > [task 2018-09-28T23:53:14.925Z] 23:53:14 INFO - rcx = > 0x00007f2c85716a00 rbx = 0x00007f2c632330c0 > [task 2018-09-28T23:53:14.925Z] 23:53:14 INFO - rsi = > 0x00007f2c6321af10 rdi = 0x00000000000007e3 > [task 2018-09-28T23:53:14.926Z] 23:53:14 INFO - rbp = > 0x00007f2c625fee10 rsp = 0x00007f2c625fee10 > [task 2018-09-28T23:53:14.926Z] 23:53:14 INFO - r8 = > 0x0000000000000001 r9 = 0x0000000000000000 > [task 2018-09-28T23:53:14.926Z] 23:53:14 INFO - r10 = > 0x0000000000000080 r11 = 0x000055d194f649f6 > [task 2018-09-28T23:53:14.927Z] 23:53:14 INFO - r12 = > 0x00007f2c625fee40 r13 = 0x0000000000000002 > [task 2018-09-28T23:53:14.927Z] 23:53:14 INFO - r14 = > 0x00007f2c6793e000 r15 = 0x00007f2c8608f305 > [task 2018-09-28T23:53:14.927Z] 23:53:14 INFO - rip = > 0x000055d194f64a01 > [task 2018-09-28T23:53:14.928Z] 23:53:14 INFO - Found by: given as > instruction pointer in context > [task 2018-09-28T23:53:14.928Z] 23:53:14 INFO - 1 > libxul.so!mozilla::dom::workerinternals::RuntimeService::CrashIfHanging() > [RuntimeService.cpp:b8d8c53289150332f491df758566cf6832f2f400 : 2019 + 0x12] > [task 2018-09-28T23:53:14.928Z] 23:53:14 INFO - rbx = > 0x00007f2c632330c0 rbp = 0x00007f2c625feea0 > [task 2018-09-28T23:53:14.929Z] 23:53:14 INFO - rsp = > 0x00007f2c625fee20 r12 = 0x00007f2c625fee40 > [task 2018-09-28T23:53:14.929Z] 23:53:14 INFO - r13 = > 0x0000000000000002 r14 = 0x00007f2c6793e000 > [task 2018-09-28T23:53:14.929Z] 23:53:14 INFO - r15 = > 0x00007f2c8608f305 rip = 0x00007f2c76fc4d68 > [task 2018-09-28T23:53:14.930Z] 23:53:14 INFO - Found by: call frame > info > [task 2018-09-28T23:53:14.930Z] 23:53:14 INFO - 2 > libxul.so!mozilla::(anonymous namespace)::RunWatchdog(void*) > [nsTerminator.cpp:b8d8c53289150332f491df758566cf6832f2f400 : 213 + 0x8] > [task 2018-09-28T23:53:14.931Z] 23:53:14 INFO - rbx = > 0x000000000000003f rbp = 0x00007f2c625feed0 > [task 2018-09-28T23:53:14.931Z] 23:53:14 INFO - rsp = > 0x00007f2c625feeb0 r12 = 0x00007f2c854159d0 > [task 2018-09-28T23:53:14.932Z] 23:53:14 INFO - r13 = > 0x00007f2c64ffca60 r14 = 0x00007f2c649a7c88 > [task 2018-09-28T23:53:14.932Z] 23:53:14 INFO - r15 = > 0x0000000000001dac rip = 0x00007f2c783dff41 > [task 2018-09-28T23:53:14.933Z] 23:53:14 INFO - Found by: call frame > info > [task 2018-09-28T23:53:14.933Z] 23:53:14 INFO - 3 libnspr4.so!_pt_root > [ptthread.c:b8d8c53289150332f491df758566cf6832f2f400 : 201 + 0x4] > [task 2018-09-28T23:53:14.934Z] 23:53:14 INFO - rbx = > 0x0000000000000007 rbp = 0x00007f2c625fef10 > [task 2018-09-28T23:53:14.934Z] 23:53:14 INFO - rsp = > 0x00007f2c625feee0 r12 = 0x00007f2c854159d0 > [task 2018-09-28T23:53:14.935Z] 23:53:14 INFO - r13 = > 0x00007f2c64ffca60 r14 = 0x00007f2c625ff700 > [task 2018-09-28T23:53:14.935Z] 23:53:14 INFO - r15 = > 0x0000000000001dac rip = 0x00007f2c86aee10d > [task 2018-09-28T23:53:14.936Z] 23:53:14 INFO - Found by: call frame > info > [task 2018-09-28T23:53:14.936Z] 23:53:14 INFO - 4 libpthread-2.23.so + > 0x76ba > [task 2018-09-28T23:53:14.937Z] 23:53:14 INFO - rbx = > 0x0000000000000000 rbp = 0x0000000000000000 > [task 2018-09-28T23:53:14.937Z] 23:53:14 INFO - rsp = > 0x00007f2c625fef20 r12 = 0x0000000000000000 > [task 2018-09-28T23:53:14.938Z] 23:53:14 INFO - r13 = > 0x00007ffe3624272f r14 = 0x00007f2c625ff9c0 > [task 2018-09-28T23:53:14.938Z] 23:53:14 INFO - r15 = > 0x00007f2c64ffca60 rip = 0x00007f2c866ee6ba > [task 2018-09-28T23:53:14.938Z] 23:53:14 INFO - Found by: call frame > info > [task 2018-09-28T23:53:14.939Z] 23:53:14 INFO - 5 libc-2.23.so + > 0x10741d > [task 2018-09-28T23:53:14.939Z] 23:53:14 INFO - rsp = > 0x00007f2c625fefc0 rip = 0x00007f2c8577741d > [task 2018-09-28T23:53:14.939Z] 23:53:14 INFO - Found by: stack > scanning > > The main thread seem to be stuck in canceling a timer for > `VRManager::StopVRListenerThreadTasks()`: > > [task 2018-09-28T23:53:14.940Z] 23:53:14 INFO - Thread 0 > [task 2018-09-28T23:53:14.940Z] 23:53:14 INFO - 0 libpthread-2.23.so + > 0x1026d > [task 2018-09-28T23:53:14.941Z] 23:53:14 INFO - rax = > 0xfffffffffffffe00 rdx = 0x0000000000000002 > [task 2018-09-28T23:53:14.941Z] 23:53:14 INFO - rcx = > 0x00007f2c866f726d rbx = 0x00007f2c693b2d40 > [task 2018-09-28T23:53:14.942Z] 23:53:14 INFO - rsi = > 0x0000000000000080 rdi = 0x00007f2c693b2d78 > [task 2018-09-28T23:53:14.943Z] 23:53:14 INFO - rbp = > 0x00007ffe36247db0 rsp = 0x00007ffe36247cf8 > [task 2018-09-28T23:53:14.944Z] 23:53:14 INFO - r8 = > 0x00007f2c693b2d78 r9 = 0x00007f2c857cef90 > [task 2018-09-28T23:53:14.944Z] 23:53:14 INFO - r10 = > 0x0000000000000000 r11 = 0x0000000000000282 > [task 2018-09-28T23:53:14.945Z] 23:53:14 INFO - r12 = > 0x00007ffe36247dd8 r13 = 0x00007ffe36248180 > [task 2018-09-28T23:53:14.946Z] 23:53:14 INFO - r14 = > 0x00007f2c693b2d78 r15 = 0x0000000000000000 > [task 2018-09-28T23:53:14.947Z] 23:53:14 INFO - rip = > 0x00007f2c866f726d > [task 2018-09-28T23:53:14.947Z] 23:53:14 INFO - Found by: given as > instruction pointer in context > [task 2018-09-28T23:53:14.948Z] 23:53:14 INFO - 1 > libxul.so!nsTimerImpl::CancelImpl(bool) > [Mutex.h:b8d8c53289150332f491df758566cf6832f2f400 : 66 + 0xc] > [task 2018-09-28T23:53:14.949Z] 23:53:14 INFO - rbp = > 0x00007ffe36247e10 rsp = 0x00007ffe36247dc0 > [task 2018-09-28T23:53:14.950Z] 23:53:14 INFO - rip = > 0x00007f2c7868b024 > [task 2018-09-28T23:53:14.951Z] 23:53:14 INFO - Found by: previous > frame's frame pointer > [task 2018-09-28T23:53:14.951Z] 23:53:14 INFO - 2 > libxul.so!nsTimer::Cancel() > [nsTimerImpl.cpp:b8d8c53289150332f491df758566cf6832f2f400 : 509 + 0x7] > [task 2018-09-28T23:53:14.952Z] 23:53:14 INFO - rbx = > 0x0000000000000000 rbp = 0x00007ffe36247e30 > [task 2018-09-28T23:53:14.953Z] 23:53:14 INFO - rsp = > 0x00007ffe36247e20 r12 = 0x00007f2c854b82f0 > [task 2018-09-28T23:53:14.954Z] 23:53:14 INFO - r14 = > 0x00007f2c854f3088 r15 = 0x00007ffe36247fa8 > [task 2018-09-28T23:53:14.955Z] 23:53:14 INFO - rip = > 0x00007f2c7868c238 > [task 2018-09-28T23:53:14.955Z] 23:53:14 INFO - Found by: call frame > info > [task 2018-09-28T23:53:14.956Z] 23:53:14 INFO - 3 > libxul.so!mozilla::gfx::VRManager::StopVRListenerThreadTasks() > [VRManager.cpp:b8d8c53289150332f491df758566cf6832f2f400 : 302 + 0x6] > [task 2018-09-28T23:53:14.957Z] 23:53:14 INFO - rbx = > 0x00007f2c6c6346d0 rbp = 0x00007ffe36247e50 > [task 2018-09-28T23:53:14.958Z] 23:53:14 INFO - rsp = > 0x00007ffe36247e40 r12 = 0x00007f2c854b82f0 > [task 2018-09-28T23:53:14.959Z] 23:53:14 INFO - r14 = > 0x00007f2c854f3088 r15 = 0x00007ffe36247fa8 > [task 2018-09-28T23:53:14.959Z] 23:53:14 INFO - rip = > 0x00007f2c75d31f24 > [task 2018-09-28T23:53:14.960Z] 23:53:14 INFO - Found by: call frame > info > [task 2018-09-28T23:53:14.961Z] 23:53:14 INFO - 4 > libxul.so!mozilla::gfx::VRListenerThreadHolder::Shutdown() > [VRThread.cpp:b8d8c53289150332f491df758566cf6832f2f400 : 108 + 0x7] > [task 2018-09-28T23:53:14.962Z] 23:53:14 INFO - rbx = > 0x00007ffe36247eb8 rbp = 0x00007ffe36247e70 > [task 2018-09-28T23:53:14.962Z] 23:53:14 INFO - rsp = > 0x00007ffe36247e60 r12 = 0x00007f2c854b82f0 > [task 2018-09-28T23:53:14.963Z] 23:53:14 INFO - r14 = > 0x00007f2c854f3088 r15 = 0x00007ffe36247fa8 > [task 2018-09-28T23:53:14.964Z] 23:53:14 INFO - rip = > 0x00007f2c75d3302b > [task 2018-09-28T23:53:14.964Z] 23:53:14 INFO - Found by: call frame > info > > Kip, is that an already known problem for VR? If not I can file a new bug.
Flags: needinfo?(kgilbert)
|
|
||
Comment 5•6 years ago
|
||
(In reply to :kip (Kearwood Gilbert) from comment #4) > I suspect this crash is the same as Bug 1491868 (Avoid shutdown hang by > checking if VRListenerThread is null) Thanks. That could indeed have fixed it. Let me check back on this bug by next Monday when we get the 7day overview intermittent rate from OF.
| Comment hidden (Intermittent Failures Robot) |
|
|
||
Comment 7•6 years ago
|
||
This was indeed fixed by the patch on bug 1491868.
Assignee: nobody → kgilbert
Status: NEW → RESOLVED
Closed: 6 years ago
status-firefox64:
--- → fixed
Resolution: --- → FIXED
Target Milestone: --- → mozilla64
|
||
Updated•6 years ago
|
status-firefox62:
--- → unaffected
status-firefox63:
--- → unaffected
status-firefox-esr60:
--- → unaffected
|
||
Updated•1 year ago
|
Product: Testing → Remote Protocol
|
|
||
Comment 8•1 year ago
|
||
Moving bug to Testing::Marionette Client and Harness component per bug 1815831.
Component: Marionette → Marionette Client and Harness
Product: Remote Protocol → Testing
You need to log in
before you can comment on or make changes to this bug.
Description
•