Closed Bug 1603613 Opened 6 years ago Closed 6 years ago

Intermittent PID 907 | SUMMARY: AddressSanitizer: SEGV /builds/worker/workspace/build/src/xpcom/threads/ThreadEventTarget.cpp:189:3 in mozilla::ThreadEventTarget::IsOnCurrentThreadInfallible()

Categories

(Core :: DOM: Core & HTML, defect, P5)

Product:
Core
Component:
DOM: Core & HTML
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

Filed by: aiakab [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=280922501&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/CpQQZhVKQF-i0W3LUwvuuQ/runs/0/artifacts/public/logs/live_backing.log

[task 2019-12-12T19:23:54.187Z] 19:23:54 INFO - TEST-OK | /html/dom/usvstring-reflection.https.html | took 2956ms
[task 2019-12-12T19:23:54.217Z] 19:23:54 INFO - PID 907 | 1576178634208 Marionette INFO Stopped listening on port 41848
[task 2019-12-12T19:23:54.281Z] 19:23:54 INFO - PID 907 | [Child 1750: Socket Thread]: D/DataChannel SendDeferredMessages called, pending type: 0
[task 2019-12-12T19:23:54.627Z] 19:23:54 INFO - PID 907 | [Child 1750: Main Thread]: E/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2812: GetStats: Found no pipelines matching selector.
[task 2019-12-12T19:23:54.628Z] 19:23:54 INFO - PID 907 | [Child 1750: Main Thread]: E/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2825: GetStats: Found no pipelines matching selector.
[task 2019-12-12T19:23:54.629Z] 19:23:54 INFO - PID 907 | [Child 1750: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2183: CloseInt: Closing PeerConnectionImpl 19ac645f39ec968f; ending call
[task 2019-12-12T19:23:54.629Z] 19:23:54 INFO - PID 907 | [Child 1750: Main Thread]: I/jsep [1576178633674778 (id=42949672962 url=https://web-platform.test:8443/html/dom/usvstring-reflection.https.html#%EF%BF%BD)]: stable -> closed
[task 2019-12-12T19:23:54.630Z] 19:23:54 INFO - PID 907 | [Child 1750: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2189: CloseInt: Destroying DataChannelConnection 0x617000095700 for 19ac645f39ec968f
[task 2019-12-12T19:23:54.630Z] 19:23:54 INFO - PID 907 | [Child 1750: Main Thread]: D/DataChannel Destroying DataChannelConnection 0x617000095700
[task 2019-12-12T19:23:54.631Z] 19:23:54 INFO - PID 907 | [Child 1750: Main Thread]: D/DataChannel Closing all channels (connection 0x617000095700)
[task 2019-12-12T19:23:54.632Z] 19:23:54 INFO - PID 907 | [Child 1750: Main Thread]: D/DataChannel DataChannelConnection labeled transport_0 (0x617000095700) switching connection state OPEN -> CLOSED
[task 2019-12-12T19:23:54.632Z] 19:23:54 INFO - PID 907 | [Child 1750: Main Thread]: D/DataChannel Connection 0x617000095700/Channel 0x60d0000b2b70: Closing stream 1
[task 2019-12-12T19:23:54.632Z] 19:23:54 INFO - PID 907 | [Child 1750: Main Thread]: D/DataChannel Removing channel 1 : 0x60d0000b2b70
[task 2019-12-12T19:23:54.632Z] 19:23:54 INFO - PID 907 | [Child 1750: Main Thread]: D/DataChannel Connection 0x617000095700: Resetting outgoing stream 1
[task 2019-12-12T19:23:54.633Z] 19:23:54 INFO - PID 907 | [Child 1750: Main Thread]: D/DataChannel DataChannelConnection labeled (0x60d0000b2b70) (stream 1) changing ready state OPEN -> CLOSING
[task 2019-12-12T19:23:54.633Z] 19:23:54 INFO - PID 907 | [Child 1750: Main Thread]: D/DataChannel Destroying Data channel 1
[task 2019-12-12T19:23:54.633Z] 19:23:54 INFO - PID 907 | [Child 1750: Main Thread]: D/DataChannel Connection 0x617000095700: Sending outgoing stream reset for 1 streams
[task 2019-12-12T19:23:54.634Z] 19:23:54 INFO - PID 907 | [Child 1750: Socket Thread]: D/DataChannel Deregistered 0x617000095700 from the SCTP stack.
[task 2019-12-12T19:23:54.634Z] 19:23:54 INFO - PID 907 | [Child 1750: Main Thread]: E/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2812: GetStats: Found no pipelines matching selector.
[task 2019-12-12T19:23:54.635Z] 19:23:54 INFO - PID 907 | [Child 1750: Main Thread]: E/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2825: GetStats: Found no pipelines matching selector.
[task 2019-12-12T19:23:54.635Z] 19:23:54 INFO - PID 907 | [Child 1750: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2183: CloseInt: Closing PeerConnectionImpl 33bb49446ce30f79; ending call
[task 2019-12-12T19:23:54.635Z] 19:23:54 INFO - PID 907 | [Child 1750: Main Thread]: I/jsep [1576178633690370 (id=42949672962 url=https://web-platform.test:8443/html/dom/usvstring-reflection.https.html#%EF%BF%BD)]: stable -> closed
[task 2019-12-12T19:23:54.636Z] 19:23:54 INFO - PID 907 | [Child 1750: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2189: CloseInt: Destroying DataChannelConnection 0x617000097680 for 33bb49446ce30f79
[task 2019-12-12T19:23:54.636Z] 19:23:54 INFO - PID 907 | [Child 1750: Main Thread]: D/DataChannel Destroying DataChannelConnection 0x617000097680
[task 2019-12-12T19:23:54.636Z] 19:23:54 INFO - PID 907 | [Child 1750: Main Thread]: D/DataChannel Closing all channels (connection 0x617000097680)
[task 2019-12-12T19:23:54.636Z] 19:23:54 INFO - PID 907 | [Child 1750: Main Thread]: D/DataChannel DataChannelConnection labeled transport_0 (0x617000097680) switching connection state OPEN -> CLOSED
[task 2019-12-12T19:23:54.637Z] 19:23:54 INFO - PID 907 | [Child 1750: Main Thread]: D/DataChannel Connection 0x617000097680/Channel 0x60d00011d4e0: Closing stream 1
[task 2019-12-12T19:23:54.637Z] 19:23:54 INFO - PID 907 | [Child 1750: Main Thread]: D/DataChannel Removing channel 1 : 0x60d00011d4e0
[task 2019-12-12T19:23:54.638Z] 19:23:54 INFO - PID 907 | [Child 1750: Main Thread]: D/DataChannel Connection 0x617000097680: Resetting outgoing stream 1
[task 2019-12-12T19:23:54.639Z] 19:23:54 INFO - PID 907 | [Child 1750: Main Thread]: D/DataChannel DataChannelConnection labeled (0x60d00011d4e0) (stream 1) changing ready state OPEN -> CLOSING
[task 2019-12-12T19:23:54.639Z] 19:23:54 INFO - PID 907 | [Child 1750: Main Thread]: D/DataChannel Destroying Data channel 1
[task 2019-12-12T19:23:54.640Z] 19:23:54 INFO - PID 907 | [Child 1750: Main Thread]: D/DataChannel Connection 0x617000097680: Sending outgoing stream reset for 1 streams
[task 2019-12-12T19:23:54.641Z] 19:23:54 INFO - PID 907 | [Child 1750: Socket Thread]: D/DataChannel Deregistered 0x617000097680 from the SCTP stack.
[task 2019-12-12T19:23:54.641Z] 19:23:54 INFO - PID 907 | AddressSanitizer:DEADLYSIGNAL
[task 2019-12-12T19:23:54.641Z] 19:23:54 INFO - PID 907 | =================================================================
[task 2019-12-12T19:23:54.642Z] 19:23:54 ERROR - PID 907 | ==907==ERROR: AddressSanitizer: SEGV on unknown address 0x000000000001 (pc 0x7fd82723322a bp 0x7fd7996f0030 sp 0x7fd7996f0030 T19)
[task 2019-12-12T19:23:54.642Z] 19:23:54 INFO - PID 907 | ==907==The signal is caused by a WRITE memory access.
[task 2019-12-12T19:23:54.643Z] 19:23:54 INFO - PID 907 | ==907==Hint: address points to the zero page.
[task 2019-12-12T19:23:54.643Z] 19:23:54 INFO - PID 907 | [Child 1750: Main Thread]: D/DataChannel DataChannelConnection labeled (0x60d0000b2b70) (stream 1) changing ready state CLOSING -> CLOSED
[task 2019-12-12T19:23:54.645Z] 19:23:54 INFO - PID 907 | [Child 1750: Main Thread]: D/DataChannel operator(): sending ON_CHANNEL_CLOSED for /: 1
[task 2019-12-12T19:23:54.645Z] 19:23:54 INFO - PID 907 | [Child 1750: Main Thread]: D/DataChannel 0x60f00005ea50(0x60d0000b2b70): OnChannelClosed - Dispatching
[task 2019-12-12T19:23:54.646Z] 19:23:54 INFO - PID 907 | [Child 1750: Main Thread]: D/DataChannel DataChannelConnection labeled (0x60d00011d4e0) (stream 1) changing ready state CLOSING -> CLOSED
[task 2019-12-12T19:23:54.646Z] 19:23:54 INFO - PID 907 | [Child 1750: Main Thread]: D/DataChannel operator(): sending ON_CHANNEL_CLOSED for /: 1
[task 2019-12-12T19:23:54.647Z] 19:23:54 INFO - PID 907 | [Child 1750: Main Thread]: D/DataChannel 0x60f00007b100(0x60d00011d4e0): OnChannelClosed - Dispatching
[task 2019-12-12T19:23:54.647Z] 19:23:54 INFO - PID 907 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2019-12-12T19:23:55.274Z] 19:23:55 INFO - PID 907 | #0 0x7fd827233229 in mozilla::ThreadEventTarget::IsOnCurrentThreadInfallible() /builds/worker/workspace/build/src/xpcom/threads/ThreadEventTarget.cpp:189:3
[task 2019-12-12T19:23:55.274Z] 19:23:55 INFO - PID 907 | #1 0x7fd827245fe3 in IsOnCurrentThread /builds/worker/workspace/build/src/xpcom/threads/nsThreadUtils.cpp:632:10
[task 2019-12-12T19:23:55.275Z] 19:23:55 INFO - PID 907 | #2 0x7fd827245fe3 in IsOnCurrentThread /builds/worker/workspace/build/src/xpcom/threads/ThreadEventTarget.cpp:182:25
[task 2019-12-12T19:23:55.275Z] 19:23:55 INFO - PID 907 | #3 0x7fd827245fe3 in nsThread::IsOnCurrentThread(bool*) /builds/worker/workspace/build/src/xpcom/threads/nsThread.cpp:760:26
[task 2019-12-12T19:23:55.312Z] 19:23:55 INFO - PID 907 | #4 0x7fd827536171 in mozilla::net::nsSocketTransportService::IsOnCurrentThread(bool*) /builds/worker/workspace/build/src/netwerk/base/nsSocketTransportService2.cpp:224:18
[task 2019-12-12T19:23:55.312Z] 19:23:55 INFO - PID 907 | #5 0x7fd827586aff in mozilla::net::nsUDPSocket::SendWithAddress(mozilla::net::NetAddr const*, nsTArray<unsigned char> const&, unsigned int*) /builds/worker/workspace/build/src/netwerk/base/nsUDPSocket.cpp:1132:9
[task 2019-12-12T19:23:55.320Z] 19:23:55 INFO - PID 907 | #6 0x7fd82d3f6aba in mozilla::dom::UDPSocketParent::Send(nsTArray<unsigned char> const&, UDPSocketAddr const&) /builds/worker/workspace/build/src/dom/network/UDPSocketParent.cpp:379:21
[task 2019-12-12T19:23:55.320Z] 19:23:55 INFO - PID 907 | #7 0x7fd82d3f653e in mozilla::dom::UDPSocketParent::RecvOutgoingData(UDPData const&, UDPSocketAddr const&) /builds/worker/workspace/build/src/dom/network/UDPSocketParent.cpp:354:7
[task 2019-12-12T19:23:55.321Z] 19:23:55 INFO - PID 907 | #8 0x7fd828842d08 in mozilla::net::PUDPSocketParent::OnMessageReceived(IPC::Message const&) /builds/worker/workspace/build/src/obj-firefox/ipc/ipdl/PUDPSocketParent.cpp:372:73
[task 2019-12-12T19:23:55.337Z] 19:23:55 INFO - PID 907 | #9 0x7fd8289364e9 in mozilla::ipc::PBackgroundParent::OnMessageReceived(IPC::Message const&) /builds/worker/workspace/build/src/obj-firefox/ipc/ipdl/PBackgroundParent.cpp:3653:32
[task 2019-12-12T19:23:55.355Z] 19:23:55 INFO - PID 907 | #10 0x7fd8282498dc in mozilla::ipc::MessageChannel::DispatchAsyncMessage(mozilla::ipc::ActorLifecycleProxy*, IPC::Message const&) /builds/worker/workspace/build/src/ipc/glue/MessageChannel.cpp:2209:25
[task 2019-12-12T19:23:55.356Z] 19:23:55 INFO - PID 907 | #11 0x7fd828246612 in mozilla::ipc::MessageChannel::DispatchMessage(IPC::Message&&) /builds/worker/workspace/build/src/ipc/glue/MessageChannel.cpp:2131:9
[task 2019-12-12T19:23:55.357Z] 19:23:55 INFO - PID 907 | #12 0x7fd8282478a3 in mozilla::ipc::MessageChannel::RunMessage(mozilla::ipc::MessageChannel::MessageTask&) /builds/worker/workspace/build/src/ipc/glue/MessageChannel.cpp:1973:3
[task 2019-12-12T19:23:55.360Z] 19:23:55 INFO - PID 907 | #13 0x7fd8282480be in mozilla::ipc::MessageChannel::MessageTask::Run() /builds/worker/workspace/build/src/ipc/glue/MessageChannel.cpp:2004:13
[task 2019-12-12T19:23:55.360Z] 19:23:55 INFO - PID 907 | #14 0x7fd827249737 in nsThread::ProcessNextEvent(bool, bool*) /builds/worker/workspace/build/src/xpcom/threads/nsThread.cpp:1240:14
[task 2019-12-12T19:23:55.361Z] 19:23:55 INFO - PID 907 | #15 0x7fd82725393c in NS_ProcessNextEvent(nsIThread*, bool) /builds/worker/workspace/build/src/xpcom/threads/nsThreadUtils.cpp:486:10
[task 2019-12-12T19:23:55.361Z] 19:23:55 INFO - PID 907 | #16 0x7fd828252189 in mozilla::ipc::MessagePumpForNonMainThreads::Run(base::MessagePump::Delegate*) /builds/worker/workspace/build/src/ipc/glue/MessagePump.cpp:302:20
[task 2019-12-12T19:23:55.362Z] 19:23:55 INFO - PID 907 | #17 0x7fd828186607 in RunInternal /builds/worker/workspace/build/src/ipc/chromium/src/base/message_loop.cc:315:10
[task 2019-12-12T19:23:55.363Z] 19:23:55 INFO - PID 907 | #18 0x7fd828186607 in RunHandler /builds/worker/workspace/build/src/ipc/chromium/src/base/message_loop.cc:308:3
[task 2019-12-12T19:23:55.363Z] 19:23:55 INFO - PID 907 | #19 0x7fd828186607 in MessageLoop::Run() /builds/worker/workspace/build/src/ipc/chromium/src/base/message_loop.cc:290:3
[task 2019-12-12T19:23:55.364Z] 19:23:55 INFO - PID 907 | #20 0x7fd82724286a in nsThread::ThreadFunc(void*) /builds/worker/workspace/build/src/xpcom/threads/nsThread.cpp:459:11
[task 2019-12-12T19:23:55.366Z] 19:23:55 INFO - PID 907 | #21 0x7fd843ad1d0e in _pt_root /builds/worker/workspace/build/src/nsprpub/pr/src/pthreads/ptthread.c:201:5
[task 2019-12-12T19:23:55.367Z] 19:23:55 INFO - PID 907 | #22 0x7fd8478776b9 in start_thread (/lib/x86_64-linux-gnu/libpthread.so.0+0x76b9)
[task 2019-12-12T19:23:55.404Z] 19:23:55 INFO - PID 907 | #23 0x7fd84690041c in clone /build/glibc-LK5gWL/glibc-2.23/misc/../sysdeps/unix/sysv/linux/x86_64/clone.S:109
[task 2019-12-12T19:23:55.405Z] 19:23:55 INFO - PID 907 | AddressSanitizer can not provide additional info.
[task 2019-12-12T19:23:55.405Z] 19:23:55 INFO - PID 907 | SUMMARY: AddressSanitizer: SEGV /builds/worker/workspace/build/src/xpcom/threads/ThreadEventTarget.cpp:189:3 in mozilla::ThreadEventTarget::IsOnCurrentThreadInfallible()
[task 2019-12-12T19:23:55.406Z] 19:23:55 INFO - PID 907 | Thread T19 (IPDL Background) created by T0 here:
[task 2019-12-12T19:23:55.423Z] 19:23:55 INFO - PID 907 | #0 0x557cde0f532a in pthread_create /builds/worker/fetches/llvm-project/llvm/projects/compiler-rt/lib/asan/asan_interceptors.cc:209:3
[task 2019-12-12T19:23:55.424Z] 19:23:55 INFO - PID 907 | #1 0x7fd843ac4625 in _PR_CreateThread /builds/worker/workspace/build/src/nsprpub/pr/src/pthreads/ptthread.c:458:14
[task 2019-12-12T19:23:55.425Z] 19:23:55 INFO - PID 907 | #2 0x7fd843ab238e in PR_CreateThread /builds/worker/workspace/build/src/nsprpub/pr/src/pthreads/ptthread.c:533:12
[task 2019-12-12T19:23:55.426Z] 19:23:55 INFO - PID 907 | #3 0x7fd8272452d7 in nsThread::Init(nsTSubstring<char> const&) /builds/worker/workspace/build/src/xpcom/threads/nsThread.cpp:675:8
[task 2019-12-12T19:23:55.427Z] 19:23:55 INFO - PID 907 | #4 0x7fd827252495 in nsThreadManager::NewNamedThread(nsTSubstring<char> const&, unsigned int, nsIThread**) /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp:618:12
[task 2019-12-12T19:23:55.428Z] 19:23:55 INFO - PID 907 | #5 0x7fd827256933 in NS_NewNamedThread(nsTSubstring<char> const&, nsIThread**, nsIRunnable*, unsigned int) /builds/worker/workspace/build/src/xpcom/threads/nsThreadUtils.cpp:139:57
[task 2019-12-12T19:23:55.434Z] 19:23:55 INFO - PID 907 | #6 0x7fd82820e90e in NS_NewNamedThread<16> /builds/worker/workspace/build/src/obj-firefox/dist/include/nsThreadUtils.h:71:10
[task 2019-12-12T19:23:55.435Z] 19:23:55 INFO - PID 907 | #7 0x7fd82820e90e in (anonymous namespace)::ParentImpl::CreateBackgroundThread() /builds/worker/workspace/build/src/ipc/glue/BackgroundImpl.cpp:943:7
[task 2019-12-12T19:23:55.436Z] 19:23:55 INFO - PID 907 | #8 0x7fd828213fb9 in RunOnMainThread /builds/worker/workspace/build/src/ipc/glue/BackgroundImpl.cpp:1243:30
[task 2019-12-12T19:23:55.437Z] 19:23:55 INFO - PID 907 | #9 0x7fd828213fb9 in (anonymous namespace)::ParentImpl::CreateActorHelper::Run() /builds/worker/workspace/build/src/ipc/glue/BackgroundImpl.cpp:1262:17
[task 2019-12-12T19:23:55.438Z] 19:23:55 INFO - PID 907 | #10 0x7fd827249737 in nsThread::ProcessNextEvent(bool, bool*) /builds/worker/workspace/build/src/xpcom/threads/nsThread.cpp:1240:14
[task 2019-12-12T19:23:55.439Z] 19:23:55 INFO - PID 907 | #11 0x7fd827252fce in NS_ProcessNextEvent /builds/worker/workspace/build/src/xpcom/threads/nsThreadUtils.cpp:486:10
[task 2019-12-12T19:23:55.440Z] 19:23:55 INFO - PID 907 | #12 0x7fd827252fce in SpinEventLoopUntil<mozilla::ProcessFailureBehavior::ReportToCaller, (lambda at /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp:691:36)> /builds/worker/workspace/build/src/obj-firefox/dist/include/nsThreadUtils.h:348:25

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.

Status: NEW → RESOLVED
Closed: 6 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.