Closed Bug 1684768 Opened 5 years ago Closed 5 years ago

Intermittent Assertion failure: false (MOZ_ASSERT_UNREACHABLE: leaking stream event), at /builds/worker/checkouts/gecko/xpcom/io/nsStreamUtils.cpp:70

Categories

(Core :: XPCOM, defect, P5)

defect

Tracking

()

RESOLVED DUPLICATE of bug 1477446

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: assertion, intermittent-failure)

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


[task 2021-01-03T16:13:31.518Z] 16:13:31     INFO - TEST-START | /fetch/api/basic/stream-response.any.html
[task 2021-01-03T16:13:31.521Z] 16:13:31     INFO - Closing window 200
[task 2021-01-03T16:13:31.573Z] 16:13:31     INFO - PID 1470 | [Child 1494, StreamTrans #1] WARNING: Dispatch failed: file /builds/worker/checkouts/gecko/xpcom/io/nsStreamUtils.cpp:84
[task 2021-01-03T16:13:31.573Z] 16:13:31     INFO - PID 1470 | [Child 1494, StreamTrans #1] WARNING: Dispatch failed: file /builds/worker/checkouts/gecko/xpcom/io/nsStreamUtils.cpp:84
[task 2021-01-03T16:13:31.574Z] 16:13:31     INFO - PID 1470 | Assertion failure: false (MOZ_ASSERT_UNREACHABLE: leaking stream event), at /builds/worker/checkouts/gecko/xpcom/io/nsStreamUtils.cpp:70
[task 2021-01-03T16:13:31.588Z] 16:13:31     INFO - STDOUT: Initializing stack-fixing for the first stack frame, this may take a while...
[task 2021-01-03T16:13:32.400Z] 16:13:32     INFO - IOError on command, setting status to CRASH
[task 2021-01-03T16:13:32.403Z] 16:13:32     INFO - mozcrash Copy/paste: /Users/cltbld/tasks/task_1609689548/fetches/minidump_stackwalk/minidump_stackwalk /var/folders/yb/wfn6b3715q9_l788jfqyzg58000017/T/tmp6vopqpnj/minidumps/7D9617D3-BAFC-4BC8-8550-F95E009BB4E9.dmp /Users/cltbld/tasks/task_1609689548/build/symbols
[task 2021-01-03T16:13:38.385Z] 16:13:38     INFO - mozcrash Saved minidump as /Users/cltbld/tasks/task_1609689548/build/blobber_upload_dir/7D9617D3-BAFC-4BC8-8550-F95E009BB4E9.dmp
[task 2021-01-03T16:13:38.386Z] 16:13:38     INFO - mozcrash Saved app info as /Users/cltbld/tasks/task_1609689548/build/blobber_upload_dir/7D9617D3-BAFC-4BC8-8550-F95E009BB4E9.extra
[task 2021-01-03T16:13:38.512Z] 16:13:38     INFO - PROCESS-CRASH | /fetch/api/basic/stream-response.any.html | application crashed [@ nsInputStreamReadyEvent::~nsInputStreamReadyEvent()]
[task 2021-01-03T16:13:38.512Z] 16:13:38     INFO - Mozilla crash reason: MOZ_ASSERT(false) (MOZ_ASSERT_UNREACHABLE: leaking stream event)
[task 2021-01-03T16:13:38.512Z] 16:13:38     INFO - Crash dump filename: /var/folders/yb/wfn6b3715q9_l788jfqyzg58000017/T/tmp6vopqpnj/minidumps/7D9617D3-BAFC-4BC8-8550-F95E009BB4E9.dmp
[task 2021-01-03T16:13:38.512Z] 16:13:38     INFO - Operating system: Mac OS X
[task 2021-01-03T16:13:38.512Z] 16:13:38     INFO -                   10.14.5 18F132
[task 2021-01-03T16:13:38.512Z] 16:13:38     INFO - CPU: amd64
[task 2021-01-03T16:13:38.512Z] 16:13:38     INFO -      family 6 model 69 stepping 1
[task 2021-01-03T16:13:38.512Z] 16:13:38     INFO -      4 CPUs
[task 2021-01-03T16:13:38.512Z] 16:13:38     INFO - 
[task 2021-01-03T16:13:38.512Z] 16:13:38     INFO - GPU: UNKNOWN
[task 2021-01-03T16:13:38.512Z] 16:13:38     INFO - 
[task 2021-01-03T16:13:38.512Z] 16:13:38     INFO - Crash reason:  EXC_BAD_ACCESS / KERN_INVALID_ADDRESS
[task 2021-01-03T16:13:38.512Z] 16:13:38     INFO - Crash address: 0x0
[task 2021-01-03T16:13:38.513Z] 16:13:38     INFO - Process uptime: 81 seconds
[task 2021-01-03T16:13:38.513Z] 16:13:38     INFO - 
[task 2021-01-03T16:13:38.513Z] 16:13:38     INFO - Thread 25 (crashed)
[task 2021-01-03T16:13:38.513Z] 16:13:38     INFO -  0  XUL!nsInputStreamReadyEvent::~nsInputStreamReadyEvent() [nsStreamUtils.cpp:eaa05f1555688194b8b32ef84dfb6571a539d82a : 70 + 0x29]
[task 2021-01-03T16:13:38.513Z] 16:13:38     INFO -     rax = 0x0000000122c2f3de   rdx = 0x0000000000000000
[task 2021-01-03T16:13:38.513Z] 16:13:38     INFO -     rcx = 0x000000010f0ba430   rbx = 0x0000000117b66f90
[task 2021-01-03T16:13:38.513Z] 16:13:38     INFO -     rsi = 0x00000000000120a8   rdi = 0x00007fff90594028
[task 2021-01-03T16:13:38.513Z] 16:13:38     INFO -     rbp = 0x000070000e39c620   rsp = 0x000070000e39c5e0
[task 2021-01-03T16:13:38.513Z] 16:13:38     INFO -      r8 = 0x00000000000130a8    r9 = 0x00007fff90594048
[task 2021-01-03T16:13:38.513Z] 16:13:38     INFO -     r10 = 0x0000000000000000   r11 = 0x00007fff90594040
[task 2021-01-03T16:13:38.513Z] 16:13:38     INFO -     r12 = 0x0000000117f87120   r13 = 0x000000000000000d
[task 2021-01-03T16:13:38.513Z] 16:13:38     INFO -     r14 = 0x0000000117b66fe0   r15 = 0x0000000117b3aef0
[task 2021-01-03T16:13:38.513Z] 16:13:38     INFO -     rip = 0x000000011934fe79
[task 2021-01-03T16:13:38.513Z] 16:13:38     INFO -     Found by: given as instruction pointer in context
[task 2021-01-03T16:13:38.513Z] 16:13:38     INFO -  1  XUL!nsInputStreamReadyEvent::~nsInputStreamReadyEvent() [nsStreamUtils.cpp:eaa05f1555688194b8b32ef84dfb6571a539d82a : 50 + 0xe]
[task 2021-01-03T16:13:38.513Z] 16:13:38     INFO -     rbp = 0x000070000e39c640   rsp = 0x000070000e39c630
[task 2021-01-03T16:13:38.513Z] 16:13:38     INFO -     rip = 0x000000011934c8be
[task 2021-01-03T16:13:38.513Z] 16:13:38     INFO -     Found by: previous frame's frame pointer
[task 2021-01-03T16:13:38.513Z] 16:13:38     INFO -  2  XUL!mozilla::Runnable::Release() [nsThreadUtils.cpp:eaa05f1555688194b8b32ef84dfb6571a539d82a : 68 + 0x57]
[task 2021-01-03T16:13:38.513Z] 16:13:38     INFO -     rbp = 0x000070000e39c660   rsp = 0x000070000e39c650
[task 2021-01-03T16:13:38.514Z] 16:13:38     INFO -     rip = 0x000000011938b3d7
[task 2021-01-03T16:13:38.514Z] 16:13:38     INFO -     Found by: previous frame's frame pointer
[task 2021-01-03T16:13:38.514Z] 16:13:38     INFO -  3  XUL!nsTArray_Impl<nsPipeEvents::InputEntry, nsTArrayInfallibleAllocator>::Clear() [nsTArray.h:eaa05f1555688194b8b32ef84dfb6571a539d82a : 1909 + 0x54]
[task 2021-01-03T16:13:38.514Z] 16:13:38     INFO -     rbp = 0x000070000e39c690   rsp = 0x000070000e39c670
[task 2021-01-03T16:13:38.514Z] 16:13:38     INFO -     rip = 0x0000000119341068
[task 2021-01-03T16:13:38.514Z] 16:13:38     INFO -     Found by: previous frame's frame pointer
[task 2021-01-03T16:13:38.514Z] 16:13:38     INFO -  4  XUL!nsPipeEvents::~nsPipeEvents() [nsPipe3.cpp:eaa05f1555688194b8b32ef84dfb6571a539d82a : 1133 + 0x8]
[task 2021-01-03T16:13:38.514Z] 16:13:38     INFO -     rbp = 0x000070000e39c6c0   rsp = 0x000070000e39c6a0
[task 2021-01-03T16:13:38.514Z] 16:13:38     INFO -     rip = 0x0000000119340e5a
[task 2021-01-03T16:13:38.514Z] 16:13:38     INFO -     Found by: previous frame's frame pointer
[task 2021-01-03T16:13:38.514Z] 16:13:38     INFO -  5  XUL!nsPipe::AdvanceWriteCursor(unsigned int) [nsPipe3.cpp:eaa05f1555688194b8b32ef84dfb6571a539d82a : 879 + 0x5]
[task 2021-01-03T16:13:38.514Z] 16:13:38     INFO -     rbp = 0x000070000e39c730   rsp = 0x000070000e39c6d0
[task 2021-01-03T16:13:38.514Z] 16:13:38     INFO -     rip = 0x0000000119340253
[task 2021-01-03T16:13:38.514Z] 16:13:38     INFO -     Found by: previous frame's frame pointer
[task 2021-01-03T16:13:38.514Z] 16:13:38     INFO -  6  XUL!nsPipeOutputStream::WriteSegments(nsresult (*)(nsIOutputStream*, void*, char*, unsigned int, unsigned int, unsigned int*), void*, unsigned int, unsigned int*) [nsPipe3.cpp:eaa05f1555688194b8b32ef84dfb6571a539d82a : 1704 + 0x9]
[task 2021-01-03T16:13:38.514Z] 16:13:38     INFO -     rbp = 0x000070000e39c7a0   rsp = 0x000070000e39c740
[task 2021-01-03T16:13:38.514Z] 16:13:38     INFO -     rip = 0x00000001193439d2
[task 2021-01-03T16:13:38.514Z] 16:13:38     INFO -     Found by: previous frame's frame pointer
[task 2021-01-03T16:13:38.514Z] 16:13:38     INFO -  7  XUL!NS_CopySegmentToStream(nsIInputStream*, void*, char const*, unsigned int, unsigned int, unsigned int*) [nsStreamUtils.cpp:eaa05f1555688194b8b32ef84dfb6571a539d82a : 749 + 0x13]
[task 2021-01-03T16:13:38.514Z] 16:13:38     INFO -     rbp = 0x000070000e39c7f0   rsp = 0x000070000e39c7b0
[task 2021-01-03T16:13:38.514Z] 16:13:38     INFO -     rip = 0x0000000119348eba
[task 2021-01-03T16:13:38.514Z] 16:13:38     INFO -     Found by: previous frame's frame pointer
[task 2021-01-03T16:13:38.515Z] 16:13:38     INFO -  8  XUL!nsStringInputStream::ReadSegments(nsresult (*)(nsIInputStream*, void*, char const*, unsigned int, unsigned int, unsigned int*), void*, unsigned int, unsigned int*) [nsStringStream.cpp:eaa05f1555688194b8b32ef84dfb6571a539d82a : 316 + 0x19]
[task 2021-01-03T16:13:38.515Z] 16:13:38     INFO -     rbp = 0x000070000e39c860   rsp = 0x000070000e39c800
[task 2021-01-03T16:13:38.515Z] 16:13:38     INFO -     rip = 0x000000011934b56e
[task 2021-01-03T16:13:38.515Z] 16:13:38     INFO -     Found by: previous frame's frame pointer
[task 2021-01-03T16:13:38.515Z] 16:13:38     INFO -  9  XUL!mozilla::dom::FetchDriver::OnDataAvailable(nsIRequest*, nsIInputStream*, unsigned long long, unsigned int) [FetchDriver.cpp:eaa05f1555688194b8b32ef84dfb6571a539d82a : 1304 + 0x1c]
[task 2021-01-03T16:13:38.515Z] 16:13:38     INFO -     rbp = 0x000070000e39c8d0   rsp = 0x000070000e39c870
[task 2021-01-03T16:13:38.515Z] 16:13:38     INFO -     rip = 0x000000011c2eacd4
[task 2021-01-03T16:13:38.515Z] 16:13:38     INFO -     Found by: previous frame's frame pointer
[task 2021-01-03T16:13:38.515Z] 16:13:38     INFO - 10  XUL!nsCORSListenerProxy::OnDataAvailable(nsIRequest*, nsIInputStream*, unsigned long long, unsigned int) [nsCORSListenerProxy.cpp:eaa05f1555688194b8b32ef84dfb6571a539d82a : 638 + 0x21]
[task 2021-01-03T16:13:38.515Z] 16:13:38     INFO -     rbp = 0x000070000e39c930   rsp = 0x000070000e39c8e0
[task 2021-01-03T16:13:38.515Z] 16:13:38     INFO -     rip = 0x00000001199ab4e1
[task 2021-01-03T16:13:38.515Z] 16:13:38     INFO -     Found by: previous frame's frame pointer
[task 2021-01-03T16:13:38.515Z] 16:13:38     INFO - 11  XUL!mozilla::net::HttpChannelChild::DoOnDataAvailable(nsIRequest*, nsISupports*, nsIInputStream*, unsigned long long, unsigned int) [HttpChannelChild.cpp:eaa05f1555688194b8b32ef84dfb6571a539d82a : 794 + 0x1f]
[task 2021-01-03T16:13:38.515Z] 16:13:38     INFO -     rbp = 0x000070000e39c980   rsp = 0x000070000e39c940
[task 2021-01-03T16:13:38.515Z] 16:13:38     INFO -     rip = 0x0000000119940900
[task 2021-01-03T16:13:38.515Z] 16:13:38     INFO -     Found by: previous frame's frame pointer
[task 2021-01-03T16:13:38.515Z] 16:13:38     INFO - 12  XUL!mozilla::net::HttpChannelChild::OnTransportAndData(nsresult const&, nsresult const&, unsigned long long const&, unsigned int const&, nsTString<char> const&) [HttpChannelChild.cpp:eaa05f1555688194b8b32ef84dfb6571a539d82a : 695 + 0x21]
[task 2021-01-03T16:13:38.515Z] 16:13:38     INFO -     rbp = 0x000070000e39ca30   rsp = 0x000070000e39c990
[task 2021-01-03T16:13:38.515Z] 16:13:38     INFO -     rip = 0x000000011993feaa
[task 2021-01-03T16:13:38.515Z] 16:13:38     INFO -     Found by: previous frame's frame pointer
[task 2021-01-03T16:13:38.515Z] 16:13:38     INFO - 13  XUL!mozilla::net::ChannelEventQueue::FlushQueue() [ChannelEventQueue.cpp:eaa05f1555688194b8b32ef84dfb6571a539d82a : 90 + 0x13]
[task 2021-01-03T16:13:38.515Z] 16:13:38     INFO -     rbp = 0x000070000e39caa0   rsp = 0x000070000e39ca40
[task 2021-01-03T16:13:38.515Z] 16:13:38     INFO -     rip = 0x0000000119a8576a
[task 2021-01-03T16:13:38.515Z] 16:13:38     INFO -     Found by: previous frame's frame pointer
[task 2021-01-03T16:13:38.516Z] 16:13:38     INFO - 14  XUL!mozilla::net::ChannelEventQueue::ResumeInternal()::CompleteResumeRunnable::Run() [ChannelEventQueue.cpp:eaa05f1555688194b8b32ef84dfb6571a539d82a : 148 + 0x29]
[task 2021-01-03T16:13:38.516Z] 16:13:38     INFO -     rbp = 0x000070000e39cac0   rsp = 0x000070000e39cab0
[task 2021-01-03T16:13:38.516Z] 16:13:38     INFO -     rip = 0x0000000119aa8810
[task 2021-01-03T16:13:38.516Z] 16:13:38     INFO -     Found by: previous frame's frame pointer
[task 2021-01-03T16:13:38.516Z] 16:13:38     INFO - 15  XUL!nsThreadPool::Run() [nsThreadPool.cpp:eaa05f1555688194b8b32ef84dfb6571a539d82a : 301 + 0x13]
[task 2021-01-03T16:13:38.516Z] 16:13:38     INFO -     rbp = 0x000070000e39cb70   rsp = 0x000070000e39cad0
[task 2021-01-03T16:13:38.516Z] 16:13:38     INFO -     rip = 0x00000001193a0619
[task 2021-01-03T16:13:38.516Z] 16:13:38     INFO -     Found by: previous frame's frame pointer
[task 2021-01-03T16:13:38.516Z] 16:13:38     INFO - 16  XUL!nsThread::ProcessNextEvent(bool, bool*) [nsThread.cpp:eaa05f1555688194b8b32ef84dfb6571a539d82a : 1200 + 0xf]
[task 2021-01-03T16:13:38.516Z] 16:13:38     INFO -     rbp = 0x000070000e39cc50   rsp = 0x000070000e39cb80
[task 2021-01-03T16:13:38.516Z] 16:13:38     INFO -     rip = 0x00000001193972a2
[task 2021-01-03T16:13:38.516Z] 16:13:38     INFO -     Found by: previous frame's frame pointer
[task 2021-01-03T16:13:38.516Z] 16:13:38     INFO - 17  XUL!NS_ProcessNextEvent(nsIThread*, bool) [nsThreadUtils.cpp:eaa05f1555688194b8b32ef84dfb6571a539d82a : 548 + 0xd]
[task 2021-01-03T16:13:38.516Z] 16:13:38     INFO -     rbp = 0x000070000e39cc80   rsp = 0x000070000e39cc60
[task 2021-01-03T16:13:38.516Z] 16:13:38     INFO -     rip = 0x000000011939d94c
[task 2021-01-03T16:13:38.516Z] 16:13:38     INFO -     Found by: previous frame's frame pointer
[task 2021-01-03T16:13:38.516Z] 16:13:38     INFO - 18  XUL!mozilla::ipc::MessagePumpForNonMainThreads::Run(base::MessagePump::Delegate*) [MessagePump.cpp:eaa05f1555688194b8b32ef84dfb6571a539d82a : 332 + 0xd]
[task 2021-01-03T16:13:38.516Z] 16:13:38     INFO -     rbp = 0x000070000e39ccd0   rsp = 0x000070000e39cc90
[task 2021-01-03T16:13:38.516Z] 16:13:38     INFO -     rip = 0x0000000119bdade8
[task 2021-01-03T16:13:38.516Z] 16:13:38     INFO -     Found by: previous frame's frame pointer
[task 2021-01-03T16:13:38.516Z] 16:13:38     INFO - 19  XUL!MessageLoop::Run() [message_loop.cc:eaa05f1555688194b8b32ef84dfb6571a539d82a : 309 + 0x5]
[task 2021-01-03T16:13:38.516Z] 16:13:38     INFO -     rbp = 0x000070000e39cd00   rsp = 0x000070000e39cce0
[task 2021-01-03T16:13:38.516Z] 16:13:38     INFO -     rip = 0x0000000119b670ee
[task 2021-01-03T16:13:38.516Z] 16:13:38     INFO -     Found by: previous frame's frame pointer
[task 2021-01-03T16:13:38.517Z] 16:13:38     INFO - 20  XUL!nsThread::ThreadFunc(void*) [nsThread.cpp:eaa05f1555688194b8b32ef84dfb6571a539d82a : 441 + 0x8]
[task 2021-01-03T16:13:38.517Z] 16:13:38     INFO -     rbp = 0x000070000e39ced0   rsp = 0x000070000e39cd10
[task 2021-01-03T16:13:38.517Z] 16:13:38     INFO -     rip = 0x000000011939363a
[task 2021-01-03T16:13:38.517Z] 16:13:38     INFO -     Found by: previous frame's frame pointer
[task 2021-01-03T16:13:38.517Z] 16:13:38     INFO - 21  libnss3.dylib!_pt_root [ptthread.c:eaa05f1555688194b8b32ef84dfb6571a539d82a : 201 + 0xa]
[task 2021-01-03T16:13:38.517Z] 16:13:38     INFO -     rbp = 0x000070000e39cf10   rsp = 0x000070000e39cee0
[task 2021-01-03T16:13:38.517Z] 16:13:38     INFO -     rip = 0x000000010ee63de1
[task 2021-01-03T16:13:38.517Z] 16:13:38     INFO -     Found by: previous frame's frame pointer
[task 2021-01-03T16:13:38.517Z] 16:13:38     INFO - 22  libsystem_pthread.dylib!_pthread_body + 0x7e
[task 2021-01-03T16:13:38.517Z] 16:13:38     INFO -     rbp = 0x000070000e39cf30   rsp = 0x000070000e39cf20
[task 2021-01-03T16:13:38.517Z] 16:13:38     INFO -     rip = 0x00007fff59e202eb
[task 2021-01-03T16:13:38.517Z] 16:13:38     INFO -     Found by: previous frame's frame pointer
[task 2021-01-03T16:13:38.517Z] 16:13:38     INFO - 23  libsystem_pthread.dylib!_pthread_start + 0x42
[task 2021-01-03T16:13:38.517Z] 16:13:38     INFO -     rbp = 0x000070000e39cf50   rsp = 0x000070000e39cf40
[task 2021-01-03T16:13:38.517Z] 16:13:38     INFO -     rip = 0x00007fff59e23249
[task 2021-01-03T16:13:38.517Z] 16:13:38     INFO -     Found by: previous frame's frame pointer
[task 2021-01-03T16:13:38.517Z] 16:13:38     INFO - 24  libsystem_pthread.dylib!thread_start + 0xd
[task 2021-01-03T16:13:38.517Z] 16:13:38     INFO -     rbp = 0x000070000e39cf78   rsp = 0x000070000e39cf60
[task 2021-01-03T16:13:38.517Z] 16:13:38     INFO -     rip = 0x00007fff59e1f40d
[task 2021-01-03T16:13:38.517Z] 16:13:38     INFO -     Found by: previous frame's frame pointer
[task 2021-01-03T16:13:38.517Z] 16:13:38     INFO - 25  libnss3.dylib + 0x17acb0
[task 2021-01-03T16:13:38.517Z] 16:13:38     INFO -     rsp = 0x000070000e39d090   rip = 0x000000010ee63cb0
[task 2021-01-03T16:13:38.518Z] 16:13:38     INFO -     Found by: stack scanning
[task 2021-01-03T16:13:38.518Z] 16:13:38     INFO - ```
Status: NEW → RESOLVED
Closed: 5 years ago
Resolution: --- → DUPLICATE
You need to log in before you can comment on or make changes to this bug.