Closed Bug 1459602 Opened 7 years ago Closed 6 years ago

Intermittent SUMMARY: AddressSanitizer: SEGV /builds/worker/workspace/build/src/ipc/glue/MessageChannel.cpp:2555:13 in mozilla::ipc::MessageChannel::OnChannelErrorFromLink()

Categories

(Core :: IPC, defect)

Product:
Core
Component:
IPC
Type:
defect
Priority:
Not set
Severity:
normal

Tracking

()

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

References

Details

(Keywords: intermittent-failure, Whiteboard: [stockwell needswork:owner][retriggered])

Attachments

(1 file)

Marionette test
456 bytes, text/plain
Details
Filed by: archaeopteryx [at] coole-files.de https://treeherder.mozilla.org/logviewer.html#?job_id=177000744&repo=mozilla-inbound https://queue.taskcluster.net/v1/task/UZovVe6_QHO_4I7G8zkzPQ/runs/0/artifacts/public/logs/live_backing.log [task 2018-05-04T17:40:04.323Z] 17:40:04 INFO - TEST-START | testing/marionette/harness/marionette_harness/tests/unit/test_timeouts.py TestTimeouts.test_reset_timeout [task 2018-05-04T17:40:04.324Z] 17:40:04 INFO - 1525455604315 Marionette TRACE 523 <- [1,10,null,{}] [task 2018-05-04T17:40:04.326Z] 17:40:04 INFO - 1525455604321 Marionette DEBUG Closed connection 523 [task 2018-05-04T17:40:04.327Z] 17:40:04 INFO - 1525455604324 Marionette DEBUG Accepted connection 524 from 127.0.0.1:36502 [task 2018-05-04T17:40:04.331Z] 17:40:04 INFO - 1525455604329 Marionette TRACE 524 -> [0,1,"WebDriver:NewSession",{}] [task 2018-05-04T17:40:04.347Z] 17:40:04 INFO - 1525455604337 Marionette DEBUG Register listener.js for window 2147483691 [task 2018-05-04T17:40:04.349Z] 17:40:04 INFO - 1525455604338 Marionette DEBUG Register listener.js for window 8589935139 [task 2018-05-04T17:40:04.357Z] 17:40:04 INFO - 1525455604347 Marionette TRACE 524 <- [1,1,null,{"sessionId":"25488eec-0d3a-48ac-8187-54dd8f2676ba","capabilities":{"browserName":"firefox","browserVersion":"61.0a ... ssID":1154,"moz:profile":"/tmp/tmpjVSAuE.mozrunner","moz:useNonSpecCompliantPointerOrigin":false,"moz:webdriverClick":true}}] [task 2018-05-04T17:40:04.357Z] 17:40:04 INFO - 1525455604352 Marionette TRACE 524 -> [0,2,"WebDriver:SetTimeouts",{"script":30000}] [task 2018-05-04T17:40:04.359Z] 17:40:04 INFO - 1525455604353 Marionette TRACE 524 <- [1,2,null,{}] [task 2018-05-04T17:40:04.360Z] 17:40:04 INFO - 1525455604355 Marionette TRACE 524 -> [0,3,"WebDriver:SetTimeouts",{"pageLoad":300000}] [task 2018-05-04T17:40:04.361Z] 17:40:04 INFO - 1525455604356 Marionette TRACE 524 <- [1,3,null,{}] [task 2018-05-04T17:40:04.363Z] 17:40:04 INFO - 1525455604361 Marionette TRACE 524 -> [0,4,"WebDriver:SetTimeouts",{"implicit":0}] [task 2018-05-04T17:40:04.367Z] 17:40:04 INFO - 1525455604364 Marionette TRACE 524 <- [1,4,null,{}] [task 2018-05-04T17:40:04.368Z] 17:40:04 INFO - 1525455604366 Marionette TRACE 524 -> [0,5,"WebDriver:GetTimeouts",{}] [task 2018-05-04T17:40:04.372Z] 17:40:04 INFO - 1525455604368 Marionette TRACE 524 <- [1,5,null,{"implicit":0,"pageLoad":300000,"script":30000}] [task 2018-05-04T17:40:04.373Z] 17:40:04 INFO - 1525455604371 Marionette TRACE 524 -> [0,6,"WebDriver:GetTimeouts",{}] [task 2018-05-04T17:40:04.374Z] 17:40:04 INFO - 1525455604371 Marionette TRACE 524 <- [1,6,null,{"implicit":0,"pageLoad":300000,"script":30000}] [task 2018-05-04T17:40:04.378Z] 17:40:04 INFO - 1525455604375 Marionette TRACE 524 -> [0,7,"WebDriver:GetTimeouts",{}] [task 2018-05-04T17:40:04.378Z] 17:40:04 INFO - 1525455604376 Marionette TRACE 524 <- [1,7,null,{"implicit":0,"pageLoad":300000,"script":30000}] [task 2018-05-04T17:40:04.384Z] 17:40:04 INFO - 1525455604380 Marionette TRACE 524 -> [0,8,"Marionette:GetContext",{}] [task 2018-05-04T17:40:04.385Z] 17:40:04 INFO - 1525455604381 Marionette TRACE 524 <- [1,8,null,{"value":"content"}] [task 2018-05-04T17:40:04.389Z] 17:40:04 INFO - 1525455604383 Marionette TRACE 524 -> [0,9,"WebDriver:DeleteSession",{}] [task 2018-05-04T17:40:04.421Z] 17:40:04 INFO - 1525455604389 Marionette TRACE 524 <- [1,9,null,{}] [task 2018-05-04T17:40:04.565Z] 17:40:04 INFO - Application command: /builds/worker/workspace/build/application/firefox/firefox -no-remote -marionette -profile /tmp/tmpjVSAuE.mozrunner [task 2018-05-04T17:40:05.681Z] 17:40:05 INFO - 1525455605668 Marionette DEBUG Received observer notification profile-after-change [task 2018-05-04T17:40:05.758Z] 17:40:05 INFO - 1525455605749 Marionette DEBUG Received observer notification command-line-startup [task 2018-05-04T17:40:05.759Z] 17:40:05 INFO - 1525455605750 Marionette DEBUG Received observer notification nsPref:changed [task 2018-05-04T17:40:07.497Z] 17:40:07 INFO - 1525455607492 Marionette DEBUG Received observer notification sessionstore-windows-restored [task 2018-05-04T17:40:09.345Z] 17:40:09 INFO - 1525455609334 Marionette DEBUG New connections are accepted [task 2018-05-04T17:40:09.345Z] 17:40:09 INFO - 1525455609335 Marionette INFO Listening on port 2828 [task 2018-05-04T17:40:09.422Z] 17:40:09 INFO - 1525455609418 Marionette DEBUG Accepted connection 0 from 127.0.0.1:36612 [task 2018-05-04T17:40:09.430Z] 17:40:09 INFO - 1525455609426 Marionette DEBUG Accepted connection 1 from 127.0.0.1:36614 [task 2018-05-04T17:40:09.432Z] 17:40:09 INFO - 1525455609428 Marionette DEBUG Closed connection 0 [task 2018-05-04T17:40:09.452Z] 17:40:09 INFO - 1525455609437 Marionette TRACE 1 -> [0,1,"WebDriver:NewSession",{}] [task 2018-05-04T17:40:09.711Z] 17:40:09 INFO - 1525455609700 Marionette DEBUG Register listener.js for window 2147483649 [task 2018-05-04T17:40:09.748Z] 17:40:09 INFO - 1525455609735 Marionette TRACE 1 <- [1,1,null,{"sessionId":"9cf0dbcf-09a8-4c3a-9e21-ceebdc6d240e","capabilities":{"browserName":"firefox","browserVersion":"61.0a ... ssID":1812,"moz:profile":"/tmp/tmpjVSAuE.mozrunner","moz:useNonSpecCompliantPointerOrigin":false,"moz:webdriverClick":true}}] [task 2018-05-04T17:40:09.765Z] 17:40:09 INFO - 1525455609754 Marionette TRACE 1 -> [0,2,"Marionette:SetContext",{"value":"content"}] [task 2018-05-04T17:40:09.765Z] 17:40:09 INFO - 1525455609756 Marionette TRACE 1 <- [1,2,null,{}] [task 2018-05-04T17:40:09.787Z] 17:40:09 INFO - 1525455609781 Marionette TRACE 1 -> [0,3,"WebDriver:DeleteSession",{}] [task 2018-05-04T17:40:09.789Z] 17:40:09 INFO - 1525455609785 Marionette TRACE 1 <- [1,3,null,{}] [task 2018-05-04T17:40:09.952Z] 17:40:09 INFO - [Child 1911, Chrome_ChildThread] WARNING: pipe error: Broken pipe: file /builds/worker/workspace/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 709 [task 2018-05-04T17:40:09.954Z] 17:40:09 INFO - [Child 1911, Chrome_ChildThread] WARNING: pipe error: Broken pipe: file /builds/worker/workspace/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 709 [task 2018-05-04T17:40:09.955Z] 17:40:09 INFO - [Child 1911, Chrome_ChildThread] WARNING: pipe error: Broken pipe: file /builds/worker/workspace/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 709 [task 2018-05-04T17:40:09.957Z] 17:40:09 INFO - [Child 1911, Chrome_ChildThread] WARNING: pipe error: Broken pipe: file /builds/worker/workspace/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 709 [task 2018-05-04T17:40:09.958Z] 17:40:09 INFO - [Child 1911, Chrome_ChildThread] WARNING: pipe error: Broken pipe: file /builds/worker/workspace/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 709 [task 2018-05-04T17:40:09.960Z] 17:40:09 INFO - [Child 1911, Chrome_ChildThread] WARNING: pipe error: Broken pipe: file /builds/worker/workspace/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 709 [task 2018-05-04T17:40:09.962Z] 17:40:09 INFO - [Child 1911, Chrome_ChildThread] WARNING: FileDescriptorSet destroyed with unconsumed descriptors: file /builds/worker/workspace/build/src/ipc/chromium/src/chrome/common/file_descriptor_set_posix.cc, line 22 [task 2018-05-04T17:40:09.963Z] 17:40:09 INFO - [Child 1911, Chrome_ChildThread] WARNING: FileDescriptorSet destroyed with unconsumed descriptors: file /builds/worker/workspace/build/src/ipc/chromium/src/chrome/common/file_descriptor_set_posix.cc, line 22 [task 2018-05-04T17:40:09.964Z] 17:40:09 INFO - AddressSanitizer:DEADLYSIGNAL [task 2018-05-04T17:40:09.966Z] 17:40:09 INFO - ================================================================= [task 2018-05-04T17:40:09.966Z] 17:40:09 ERROR - ==1911==ERROR: AddressSanitizer: SEGV on unknown address 0x000000000000 (pc 0x7f70244eea33 bp 0x7f7020638300 sp 0x7f70206382e0 T2) [task 2018-05-04T17:40:09.971Z] 17:40:09 INFO - ==1911==The signal is caused by a WRITE memory access. [task 2018-05-04T17:40:09.972Z] 17:40:09 INFO - ==1911==Hint: address points to the zero page. [task 2018-05-04T17:40:10.998Z] 17:40:10 INFO - #0 0x7f70244eea32 in mozilla::ipc::MessageChannel::OnChannelErrorFromLink() /builds/worker/workspace/build/src/ipc/glue/MessageChannel.cpp:2555:13 [task 2018-05-04T17:40:10.999Z] 17:40:10 INFO - #1 0x7f70244f3947 in OnChannelError /builds/worker/workspace/build/src/ipc/glue/MessageLink.cpp:393:12 [task 2018-05-04T17:40:11.001Z] 17:40:11 INFO - #2 0x7f70244f3947 in non-virtual thunk to mozilla::ipc::ProcessLink::OnChannelError() /builds/worker/workspace/build/src/ipc/glue/MessageLink.cpp [task 2018-05-04T17:40:11.001Z] 17:40:11 INFO - #3 0x7f7024496fe7 in event_persist_closure /builds/worker/workspace/build/src/ipc/chromium/src/third_party/libevent/event.c:1580:9 [task 2018-05-04T17:40:11.003Z] 17:40:11 INFO - #4 0x7f7024496fe7 in event_process_active_single_queue /builds/worker/workspace/build/src/ipc/chromium/src/third_party/libevent/event.c:1639 [task 2018-05-04T17:40:11.004Z] 17:40:11 INFO - #5 0x7f702448eee5 in event_process_active /builds/worker/workspace/build/src/ipc/chromium/src/third_party/libevent/event.c [task 2018-05-04T17:40:11.004Z] 17:40:11 INFO - #6 0x7f702448eee5 in event_base_loop /builds/worker/workspace/build/src/ipc/chromium/src/third_party/libevent/event.c:1961 [task 2018-05-04T17:40:11.014Z] 17:40:11 INFO - #7 0x7f702444e443 in base::MessagePumpLibevent::Run(base::MessagePump::Delegate*) /builds/worker/workspace/build/src/ipc/chromium/src/base/message_pump_libevent.cc:373:7 [task 2018-05-04T17:40:11.014Z] 17:40:11 INFO - #8 0x7f70244487e9 in RunInternal /builds/worker/workspace/build/src/ipc/chromium/src/base/message_loop.cc:326:10 [task 2018-05-04T17:40:11.015Z] 17:40:11 INFO - #9 0x7f70244487e9 in RunHandler /builds/worker/workspace/build/src/ipc/chromium/src/base/message_loop.cc:319 [task 2018-05-04T17:40:11.015Z] 17:40:11 INFO - #10 0x7f70244487e9 in MessageLoop::Run() /builds/worker/workspace/build/src/ipc/chromium/src/base/message_loop.cc:299 [task 2018-05-04T17:40:11.023Z] 17:40:11 INFO - #11 0x7f702446667f in base::Thread::ThreadMain() /builds/worker/workspace/build/src/ipc/chromium/src/base/thread.cc:181:16 [task 2018-05-04T17:40:11.023Z] 17:40:11 INFO - #12 0x7f702445935c in ThreadFunc(void*) /builds/worker/workspace/build/src/ipc/chromium/src/base/platform_thread_posix.cc:38:13 [task 2018-05-04T17:40:11.025Z] 17:40:11 INFO - #13 0x7f70441566b9 in start_thread (/lib/x86_64-linux-gnu/libpthread.so.0+0x76b9) [task 2018-05-04T17:40:11.089Z] 17:40:11 INFO - #14 0x7f70431df41c in clone /build/glibc-Cl5G7W/glibc-2.23/misc/../sysdeps/unix/sysv/linux/x86_64/clone.S:109 [task 2018-05-04T17:40:11.089Z] 17:40:11 INFO - AddressSanitizer can not provide additional info. [task 2018-05-04T17:40:11.091Z] 17:40:11 INFO - SUMMARY: AddressSanitizer: SEGV /builds/worker/workspace/build/src/ipc/glue/MessageChannel.cpp:2555:13 in mozilla::ipc::MessageChannel::OnChannelErrorFromLink() [task 2018-05-04T17:40:11.091Z] 17:40:11 INFO - Thread T2 (Chrome_~dThread) created by T0 (Web Content) here: [task 2018-05-04T17:40:11.117Z] 17:40:11 INFO - #0 0x4aafed in __interceptor_pthread_create /builds/worker/workspace/moz-toolchain/src/llvm/projects/compiler-rt/lib/asan/asan_interceptors.cc:204:3 [task 2018-05-04T17:40:11.119Z] 17:40:11 INFO - #1 0x7f7024456d8f in CreateThread /builds/worker/workspace/build/src/ipc/chromium/src/base/platform_thread_posix.cc:135:14 [task 2018-05-04T17:40:11.119Z] 17:40:11 INFO - #2 0x7f7024456d8f in PlatformThread::Create(unsigned long, PlatformThread::Delegate*, unsigned long*) /builds/worker/workspace/build/src/ipc/chromium/src/base/platform_thread_posix.cc:146 [task 2018-05-04T17:40:11.121Z] 17:40:11 INFO - #3 0x7f702446601f in base::Thread::StartWithOptions(base::Thread::Options const&) /builds/worker/workspace/build/src/ipc/chromium/src/base/thread.cc:99:8 [task 2018-05-04T17:40:11.121Z] 17:40:11 INFO - #4 0x7f7024467dae in Run /builds/worker/workspace/build/src/ipc/chromium/src/chrome/common/child_thread.cc:27:12 [task 2018-05-04T17:40:11.123Z] 17:40:11 INFO - #5 0x7f7024467dae in ChildProcess::ChildProcess(ChildThread*) /builds/worker/workspace/build/src/ipc/chromium/src/chrome/common/child_process.cc:20 [task 2018-05-04T17:40:11.123Z] 17:40:11 INFO - #6 0x7f70244f5493 in mozilla::ipc::ProcessChild::ProcessChild(int) /builds/worker/workspace/build/src/ipc/glue/ProcessChild.cpp:24:5 [task 2018-05-04T17:40:11.125Z] 17:40:11 INFO - #7 0x7f702f16044e in ContentProcess /builds/worker/workspace/build/src/obj-firefox/dist/include/mozilla/dom/ContentProcess.h:31:7 [task 2018-05-04T17:40:11.126Z] 17:40:11 INFO - #8 0x7f702f16044e in XRE_InitChildProcess(int, char**, XREChildData const*) /builds/worker/workspace/build/src/toolkit/xre/nsEmbedFunctions.cpp:667 [task 2018-05-04T17:40:11.128Z] 17:40:11 INFO - #9 0x4f1875 in content_process_main /builds/worker/workspace/build/src/browser/app/../../ipc/contentproc/plugin-container.cpp:50:30 [task 2018-05-04T17:40:11.129Z] 17:40:11 INFO - #10 0x4f1875 in main /builds/worker/workspace/build/src/browser/app/nsBrowserApp.cpp:280 [task 2018-05-04T17:40:11.129Z] 17:40:11 INFO - #11 0x7f70430f882f in __libc_start_main /build/glibc-Cl5G7W/glibc-2.23/csu/../csu/libc-start.c:291 [task 2018-05-04T17:40:11.131Z] 17:40:11 INFO - ==1911==ABORTING
Component: Marionette → IPC
Product: Testing → Core
Version: Version 3 → unspecified
I think I'm seeing the same thing; both my main and work machines (Fedora 28 on both) are failing a couple of times a day, the backtrace is: (gdb) where #0 0x00007f429b7870d8 in mozilla::ipc::MessageChannel::OnChannelErrorFromLink() (this=0x7f42aa2c6128) at /usr/src/debug/firefox-59.0.2-1.fc28.x86_64/ipc/glue/MessageChannel.cpp:2534 2534 MOZ_CRASH("Aborting on channel error."); #1 0x00007f429bcc4eb3 in mozilla::ipc::ProcessLink::OnChannelError() (this=0x7f428db4fd30) at /usr/src/debug/firefox-59.0.2-1.fc28.x86_64/ipc/glue/MessageLink.cpp:393 #2 0x00007f429bcae77a in event_persist_closure (ev=<optimized out>, base=0x7f42aa2c1400) at /usr/src/debug/firefox-59.0.2-1.fc28.x86_64/ipc/chromium/src/third_party/libevent/event.c:1580 #3 0x00007f429bcae77a in event_process_active_single_queue (base=base@entry=0x7f42aa2c1400, max_to_process=max_to_process@entry=2147483647, endtime=endtime@entry=0x0, activeq=<optimized out>) at /usr/src/debug/firefox-59.0.2-1.fc28.x86_64/ipc/chromium/src/third_party/libevent/event.c:1639 #4 0x00007f429bcaed8f in event_process_active (base=0x7f42aa2c1400) at /usr/src/debug/firefox-59.0.2-1.fc28.x86_64/ipc/chromium/src/third_party/libevent/event.c:1738 #5 0x00007f429bcaed8f in event_base_loop (base=0x7f42aa2c1400, flags=flags@entry=1) at /usr/src/debug/firefox-59.0.2-1.fc28.x86_64/ipc/chromium/src/third_party/libevent/event.c:1961 #6 0x00007f429bc943ce in base::MessagePumpLibevent::Run(base::MessagePump::Delegate*) (this=0x7f42aa251a40, delegate=0x7f429811cd00) at /usr/src/debug/firefox-59.0.2-1.fc28.x86_64/ipc/chromium/src/base/message_pump_libevent.cc:381 #7 0x00007f429bc96849 in MessageLoop::RunInternal() (this=0x7f429811cd00) at /usr/src/debug/firefox-59.0.2-1.fc28.x86_64/ipc/chromium/src/base/message_loop.cc:326 #8 0x00007f429bc96849 in MessageLoop::RunHandler() (this=0x7f429811cd00) at /usr/src/debug/firefox-59.0.2-1.fc28.x86_64/ipc/chromium/src/base/message_loop.cc:319 #9 0x00007f429bc96849 in MessageLoop::Run() (this=this@entry=0x7f429811cd00) at /usr/src/debug/firefox-59.0.2-1.fc28.x86_64/ipc/chromium/src/base/message_loop.cc:299 #10 0x00007f429bca4785 in base::Thread::ThreadMain() (this=0x7f42aa2263e8) at /usr/src/debug/firefox-59.0.2-1.fc28.x86_64/ipc/chromium/src/base/thread.cc:181 #11 0x00007f429bc93eee in ThreadFunc(void*) (closure=<optimized out>) at /usr/src/debug/firefox-59.0.2-1.fc28.x86_64/ipc/chromium/src/base/platform_thread_posix.cc:38 #12 0x00007f42ab572564 in start_thread () at /lib64/libpthread.so.0 #13 0x00007f42aa76431f in clone () at /lib64/libc.so.6 Note the 'mChannelState is mozilla::ipc::ChannelConnected. I've had it fail at quite a few different activities; scrolling through videos, clicking on the 'tick' in google photos; and a bunch of others - can't nail down a single cause. My work machine has no extra codecs, my home machine has a load of ffmpeg - so there's nothing common between them. I don't think I'd seen it before fedora28 though - it's currently Firefox 59.0.2. I'd filed it as Fedora bug: https://bugzilla.redhat.com/show_bug.cgi?id=1568097
Attached file Marionette test —
I can replicate that failure all the time on MacOS when running the above Marionette test in headless mode: `mach marionette-test --headless -vv --gecko-log - %path_to_py_file%` It always results in a: > Hit MOZ_CRASH(Aborting on channel error.) at /builds/worker/workspace/build/src/ipc/glue/MessageChannel.cpp:2555 > [GFX1-]: Receive IPC close with reason=AbnormalShutdown I will see if I can narrow down the regression range (if there is one) a bit further.
It looks like I cannot really do a regression test with artifact builds which I'm using locally. So if a developer could have a look at this and run the test it might be faster.
Could this bug be related to https://bugzilla.mozilla.org/show_bug.cgi?id=1461041 ? FF 60 ESR was crashing on my AArch64 box with the exact same results. But removing the "-fno-delete-null-pointer-checks" compiler flag fixes this for me.
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
Status: NEW → RESOLVED
Closed: 7 years ago
Resolution: --- → INCOMPLETE
Recent log failure: https://treeherder.mozilla.org/logviewer.html#?job_id=206850667&repo=try&lineNumber=53570 [task 2018-10-21T11:50:07.915Z] 11:50:07 INFO - 1540122607903 Marionette DEBUG [30] Frame script loaded [task 2018-10-21T11:50:07.920Z] 11:50:07 INFO - 1540122607906 Marionette DEBUG [30] Frame script registered [task 2018-10-21T11:50:07.952Z] 11:50:07 INFO - console.log: "[bug 1345098] Lazy browser prematurely inserted via 'messageManager' property access:\ngetter@chrome://browser/content/tabbrowser.js:2020:37\nflush@resource:///modules/sessionstore/TabStateFlusher.jsm:84:9\nflush@resource:///modules/sessionstore/TabStateFlusher.jsm:23:12\ntestSSPostReset/<@tests/browser/components/migration/tests/marionette/test_refresh_firefox.py:473:52\ntestSSPostReset@tests/browser/components/migration/tests/marionette/test_refresh_firefox.py:473:25\nssi_sendWindowStateEvent@resource:///modules/sessionstore/SessionStore.jsm:4762:5\nssi_setWindowStateReady@resource:///modules/sessionstore/SessionStore.jsm:4736:7\nssi_restoreWindow@resource:///modules/sessionstore/SessionStore.jsm:3579:5\n_restoreWindowsFeaturesAndTabs@resource:///modules/sessionstore/SessionStore.jsm:3651:7\n_restoreWindowsInReversedZOrder@resource:///modules/sessionstore/SessionStore.jsm:3668:5\nssi_restoreWindows/<@resource:///modules/sessionstore/SessionStore.jsm:3723:7\n" [task 2018-10-21T11:50:08.174Z] 11:50:08 INFO - 1540122608167 Marionette DEBUG [8589934593] Frame script loaded [task 2018-10-21T11:50:08.210Z] 11:50:08 INFO - 1540122608198 Marionette ERROR [8589934593] No reply from Marionette:Register [task 2018-10-21T11:50:08.212Z] 11:50:08 INFO - JavaScript error: chrome://marionette/content/listener.js, line 456: TypeError: reply[0] is undefined; can't access its "outerWindowID" property [task 2018-10-21T11:50:08.351Z] 11:50:08 INFO - 1540122608344 Marionette DEBUG [8589934595] Frame script loaded [task 2018-10-21T11:50:08.387Z] 11:50:08 INFO - 1540122608375 Marionette DEBUG [8589934595] Frame script registered [task 2018-10-21T11:50:08.488Z] 11:50:08 INFO - 1540122608479 Marionette TRACE 1 <- [1,20,null,{"value":["about:robots","about:mozilla"]}] [task 2018-10-21T11:50:08.553Z] 11:50:08 INFO - 1540122608551 Marionette TRACE 1 -> [0,21,"Marionette:GetContext",{}] [task 2018-10-21T11:50:08.557Z] 11:50:08 INFO - 1540122608554 Marionette TRACE 1 <- [1,21,null,{"value":"chrome"}] [task 2018-10-21T11:50:08.607Z] 11:50:08 INFO - 1540122608601 Marionette TRACE 1 -> [0,22,"WebDriver:DeleteSession",{}] [task 2018-10-21T11:50:08.623Z] 11:50:08 INFO - 1540122608609 Marionette TRACE 1 <- [1,22,null,{"value":null}] [task 2018-10-21T11:50:08.807Z] 11:50:08 INFO - [Child 10868, Chrome_ChildThread] WARNING: pipe error: Broken pipe: file /builds/worker/workspace/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 736 [task 2018-10-21T11:50:08.809Z] 11:50:08 INFO - [Child 10868, Chrome_ChildThread] WARNING: pipe error: Broken pipe: file /builds/worker/workspace/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 736 [task 2018-10-21T11:50:08.809Z] 11:50:08 INFO - AddressSanitizer:DEADLYSIGNAL [task 2018-10-21T11:50:08.809Z] 11:50:08 INFO - ================================================================= [task 2018-10-21T11:50:08.810Z] 11:50:08 ERROR - ==10868==ERROR: AddressSanitizer: SEGV on unknown address 0x000000000001 (pc 0x7f281b055e8f bp 0x7f28133922c0 sp 0x7f28133922a0 T1) [task 2018-10-21T11:50:08.811Z] 11:50:08 INFO - ==10868==The signal is caused by a WRITE memory access. [task 2018-10-21T11:50:08.811Z] 11:50:08 INFO - ==10868==Hint: address points to the zero page. [task 2018-10-21T11:50:09.630Z] 11:50:09 INFO - #0 0x7f281b055e8e in mozilla::ipc::MessageChannel::OnChannelErrorFromLink() /builds/worker/workspace/build/src/ipc/glue/MessageChannel.cpp:2669:13 [task 2018-10-21T11:50:09.632Z] 11:50:09 INFO - #1 0x7f281b05a247 in non-virtual thunk to mozilla::ipc::ProcessLink::OnChannelError() /builds/worker/workspace/build/src/ipc/glue/MessageLink.cpp:397:12 [task 2018-10-21T11:50:09.634Z] 11:50:09 INFO - #2 0x7f281affc7e7 in event_persist_closure /builds/worker/workspace/build/src/ipc/chromium/src/third_party/libevent/event.c:1580:9 [task 2018-10-21T11:50:09.636Z] 11:50:09 INFO - #3 0x7f281affc7e7 in event_process_active_single_queue /builds/worker/workspace/build/src/ipc/chromium/src/third_party/libevent/event.c:1639 [task 2018-10-21T11:50:09.637Z] 11:50:09 INFO - #4 0x7f281aff4685 in event_process_active /builds/worker/workspace/build/src/ipc/chromium/src/third_party/libevent/event.c [task 2018-10-21T11:50:09.640Z] 11:50:09 INFO - #5 0x7f281aff4685 in event_base_loop /builds/worker/workspace/build/src/ipc/chromium/src/third_party/libevent/event.c:1961 [task 2018-10-21T11:50:09.641Z] 11:50:09 INFO - #6 0x7f281afb3dd0 in base::MessagePumpLibevent::Run(base::MessagePump::Delegate*) /builds/worker/workspace/build/src/ipc/chromium/src/base/message_pump_libevent.cc:373:7 [task 2018-10-21T11:50:09.641Z] 11:50:09 INFO - #7 0x7f281afae41c in RunInternal /builds/worker/workspace/build/src/ipc/chromium/src/base/message_loop.cc:325:10 [task 2018-10-21T11:50:09.643Z] 11:50:09 INFO - #8 0x7f281afae41c in RunHandler /builds/worker/workspace/build/src/ipc/chromium/src/base/message_loop.cc:318 [task 2018-10-21T11:50:09.643Z] 11:50:09 INFO - #9 0x7f281afae41c in MessageLoop::Run() /builds/worker/workspace/build/src/ipc/chromium/src/base/message_loop.cc:298 [task 2018-10-21T11:50:09.643Z] 11:50:09 INFO - #10 0x7f281afcb376 in base::Thread::ThreadMain() /builds/worker/workspace/build/src/ipc/chromium/src/base/thread.cc:198:16 [task 2018-10-21T11:50:09.643Z] 11:50:09 INFO - #11 0x7f281afbf86c in ThreadFunc(void*) /builds/worker/workspace/build/src/ipc/chromium/src/base/platform_thread_posix.cc:40:13 [task 2018-10-21T11:50:09.644Z] 11:50:09 INFO - #12 0x7f283977c6b9 in start_thread (/lib/x86_64-linux-gnu/libpthread.so.0+0x76b9) [task 2018-10-21T11:50:09.696Z] 11:50:09 INFO - #13 0x7f283880541c in clone /build/glibc-Cl5G7W/glibc-2.23/misc/../sysdeps/unix/sysv/linux/x86_64/clone.S:109 [task 2018-10-21T11:50:09.697Z] 11:50:09 INFO - AddressSanitizer can not provide additional info. [task 2018-10-21T11:50:09.698Z] 11:50:09 INFO - SUMMARY: AddressSanitizer: SEGV /builds/worker/workspace/build/src/ipc/glue/MessageChannel.cpp:2669:13 in mozilla::ipc::MessageChannel::OnChannelErrorFromLink() [task 2018-10-21T11:50:09.699Z] 11:50:09 INFO - Thread T1 (Chrome_~dThread) created by T0 here: [task 2018-10-21T11:50:09.700Z] 11:50:09 INFO - #0 0x55942aa572ed in __interceptor_pthread_create /builds/worker/workspace/moz-toolchain/src/llvm/projects/compiler-rt/lib/asan/asan_interceptors.cc:204:3 [task 2018-10-21T11:50:09.701Z] 11:50:09 INFO - #1 0x7f281afbd2ec in CreateThread /builds/worker/workspace/build/src/ipc/chromium/src/base/platform_thread_posix.cc:127:14 [task 2018-10-21T11:50:09.702Z] 11:50:09 INFO - #2 0x7f281afbd2ec in PlatformThread::Create(unsigned long, PlatformThread::Delegate*, unsigned long*) /builds/worker/workspace/build/src/ipc/chromium/src/base/platform_thread_posix.cc:138 [task 2018-10-21T11:50:09.708Z] 11:50:09 INFO - #3 0x7f281afcaa93 in base::Thread::StartWithOptions(base::Thread::Options const&) /builds/worker/workspace/build/src/ipc/chromium/src/base/thread.cc:102:8 [task 2018-10-21T11:50:09.708Z] 11:50:09 INFO - #4 0x7f281afcccde in Run /builds/worker/workspace/build/src/ipc/chromium/src/chrome/common/child_thread.cc:27:12 [task 2018-10-21T11:50:09.715Z] 11:50:09 INFO - #5 0x7f281afcccde in ChildProcess::ChildProcess(ChildThread*) /builds/worker/workspace/build/src/ipc/chromium/src/chrome/common/child_process.cc:20 [task 2018-10-21T11:50:09.715Z] 11:50:09 INFO - #6 0x7f281b05be97 in mozilla::ipc::ProcessChild::ProcessChild(int) /builds/worker/workspace/build/src/ipc/glue/ProcessChild.cpp:24:5 [task 2018-10-21T11:50:09.716Z] 11:50:09 INFO - #7 0x7f2825d161d9 in ContentProcess /builds/worker/workspace/build/src/obj-firefox/dist/include/mozilla/dom/ContentProcess.h:31:7 [task 2018-10-21T11:50:09.718Z] 11:50:09 INFO - #8 0x7f2825d161d9 in XRE_InitChildProcess(int, char**, XREChildData const*) /builds/worker/workspace/build/src/toolkit/xre/nsEmbedFunctions.cpp:707 [task 2018-10-21T11:50:09.718Z] 11:50:09 INFO - #9 0x55942aa9e6f4 in content_process_main /builds/worker/workspace/build/src/browser/app/../../ipc/contentproc/plugin-container.cpp:50:30 [task 2018-10-21T11:50:09.719Z] 11:50:09 INFO - #10 0x55942aa9e6f4 in main /builds/worker/workspace/build/src/browser/app/nsBrowserApp.cpp:287 [task 2018-10-21T11:50:09.720Z] 11:50:09 INFO - #11 0x7f283871e82f in __libc_start_main /build/glibc-Cl5G7W/glibc-2.23/csu/../csu/libc-start.c:291 [task 2018-10-21T11:50:09.720Z] 11:50:09 INFO - ==10868==ABORTING
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---

Since this was landed, this bug started to perma fail. It might me from bug 1519862 https://bugzilla.mozilla.org/show_bug.cgi?id=1519862

James, could you please take a look?

Flags: needinfo?(james)
Whiteboard: [stockwell needswork:owner] → [stockwell needswork:owner][retriggered]

Issue is being tracked here https://bugzilla.mozilla.org/show_bug.cgi?id=1522213 I think we can close this. Aryx?

There are no other occurrences since the 24th of January: https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?startday=2019-01-19&endday=2019-01-26&tree=trunk&bug=1459602

Flags: needinfo?(aryx.bugmail)
Status: REOPENED → RESOLVED
Closed: 7 years ago → 6 years ago
Flags: needinfo?(aryx.bugmail)
Resolution: --- → INCOMPLETE
Flags: needinfo?(james)
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Creator:
Created:
Updated:
Size: