1426751 - Intermittent eventsource-close.htm | application crashed [@ mozilla::net::ChannelEventQueue::FlushQueue] (Assertion failure: !mFlushing, at netwerk/ipc/ChannelEventQueue.cpp:46)

Reporter

Description

•

6 years ago

treeherder

Filed by: rvandermeulen [at] mozilla.com

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

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

Comment hidden (Intermittent Failures Robot)

1 failures in 590 pushes (0.002 failures/push) were associated with this bug in the last 7 days.    

Repository breakdown:
* mozilla-beta: 1

Platform breakdown:
* linux32-stylo-disabled: 1

For more details, see:
https://brasstacks.mozilla.com/orangefactor/?display=Bug&bugid=1426751&startday=2017-12-18&endday=2017-12-24&tree=all

Kershaw Chang [:kershaw]

Comment 2

•

6 years ago

Hi SC,

Could you perhaps take a look? The crash rate is quite low, so take your time.

Thanks.

Flags: needinfo?(schien)

Kershaw Chang [:kershaw]

Updated

•

6 years ago

Whiteboard: [necko-triaged]

Shih-Chiang Chien [:schien] (UTC+8) (use ni? plz)

Assignee

Comment 3

•

6 years ago

This assertion is complaining about there are more than one FlushQueue executed at the same time.

The crash stack shows a race condition that two MaybeFlushQueue on two threads might both enter FlushQueue.

Two issues are found:
 1) |mFlushing = true| is executed in a separate critical section which makes more than one MaybeFlushQueue pass the flushQueue check.
 2) CompleteResume might be executed while ChannelEvent::Run is executed on other thread.

[backtrace]
>Thread 11 (crashed)
> 0  libxul.so!mozilla::net::ChannelEventQueue::FlushQueue [ChannelEventQueue.cpp:f5855487cb44 : 58 + 0x0]
>    eip = 0xeff5feb7   esp = 0xe8dfeaf0   ebp = 0xe8dfeb48   ebx = 0xd7445180
>    esi = 0xf5463000   edi = 0xe8dfeb28   eax = 0x00000000   ecx = 0xf748d864
>    edx = 0x00000000   efl = 0x00210282
>    Found by: given as instruction pointer in context
> 1  libxul.so!mozilla::net::AutoEventEnqueuer::~AutoEventEnqueuer [ChannelEventQueue.h:f5855487cb44 : 324 + 0x9]
>    eip = 0xefe74827   esp = 0xe8dfeb50   ebp = 0xe8dfeb98   ebx = 0xd7445180
>    esi = 0xe8dfeb74   edi = 0x00000000
>    Found by: call frame info
> 2  libxul.so!mozilla::net::HttpChannelChild::OnTransportAndData [HttpChannelChild.cpp:f5855487cb44 : 851 + 0x8]
>    eip = 0xefef30b8   esp = 0xe8dfeba0   ebp = 0xe8dfec18   ebx = 0xe8dfebd4
>    esi = 0xd7d44000   edi = 0xe8dfebe0
>    Found by: call frame info
> 3  libxul.so!mozilla::net::TransportAndDataEvent::Run [HttpChannelChild.cpp:f5855487cb44 : 745 + 0x9]
>    eip = 0xefef30ff   esp = 0xe8dfec20   ebp = 0xe8dfec48   ebx = 0xd7445180
>    esi = 0xf5463000   edi = 0xe8dfec78
>    Found by: call frame info
> 4  libxul.so!mozilla::net::ChannelEventQueue::RunOrEnqueue [ChannelEventQueue.h:f5855487cb44 : 215 + 0x13]
>    eip = 0xefe73733   esp = 0xe8dfec50   ebp = 0xe8dfeca8   ebx = 0xd7445180
>    esi = 0xf5463000   edi = 0xe8dfec78
>    Found by: call frame info
> 5  libxul.so!mozilla::net::HttpBackgroundChannelChild::RecvOnTransportAndData [HttpBackgroundChannelChild.cpp:f5855487cb44 : 175 + 0x17]
>    eip = 0xefeaab83   esp = 0xe8dfecb0   ebp = 0xe8dfecf8   ebx = 0xf5463000
>    esi = 0xd7446bcc   edi = 0xe70d8d10
>    Found by: call frame info
> 6  libxul.so!mozilla::net::PHttpBackgroundChannelChild::OnMessageReceived [PHttpBackgroundChannelChild.cpp: : 133 + 0x32]
>    eip = 0xf0099101   esp = 0xe8dfed00   ebp = 0xe8dfee08   ebx = 0xd7445430
>    esi = 0x00000000   edi = 0xd7446bb0
>Thread 0
> 0  linux-gate.so + 0xcd9
>    eip = 0xf76e6cd9   esp = 0xffe8f2d0   ebp = 0xffe8f328   ebx = 0xd744519c
>    esi = 0x00000000   edi = 0x00000000   eax = 0xfffffe00   ecx = 0x00000080
>    edx = 0x00000002   efl = 0x00200202
>    Found by: given as instruction pointer in context
> 1  libxul.so!mozilla::OffTheBooksMutex::Lock [BlockingResourceBase.cpp:f5855487cb44 : 385 + 0x8]
>    eip = 0xefc0c8b6   esp = 0xffe8f330   ebp = 0xffe8f358
>    Found by: previous frame's frame pointer
> 2  libxul.so!mozilla::BaseAutoLock<mozilla::Mutex>::BaseAutoLock [Mutex.h:f5855487cb44 : 166 + 0xa]
>    eip = 0xefb48566   esp = 0xffe8f360   ebp = 0xffe8f378   ebx = 0xf5463000
>    esi = 0xffe8f3c8   edi = 0xffe8f3c8
>    Found by: call frame info
> 3  libxul.so!mozilla::net::ChannelEventQueue::FlushQueue [ChannelEventQueue.cpp:f5855487cb44 : 55 + 0x6]
>    eip = 0xeff5fe70   esp = 0xffe8f380   ebp = 0xffe8f3e8   ebx = 0xd7445180
>    esi = 0xf5463000   edi = 0xffe8f3c8
>    Found by: call frame info
> 4  libxul.so!mozilla::net::ChannelEventQueue::ResumeInternal()::CompleteResumeRunnable::Run() + 0xe9
>    eip = 0xeff601bf   esp = 0xffe8f3f0   ebp = 0xffe8f438   ebx = 0xffe8f418
>    esi = 0xffe8f414   edi = 0xd7445180
>    Found by: call frame info
> 5  libxul.so!nsThread::ProcessNextEvent [nsThread.cpp:f5855487cb44 : 1037 + 0x16]
>    eip = 0xefc1d239   esp = 0xffe8f440   ebp = 0xffe8f4e8   ebx = 0xf5463000
>    esi = 0xf70ed3f8   edi = 0xf7025c10
>    Found by: call frame info

Shih-Chiang Chien [:schien] (UTC+8) (use ni? plz)

Assignee

Comment 4

•

6 years ago

Attached image bug1426751 analysis.png — Details

This issue might be triggered by off-main-thread ODA listener that return error cause from OnDataAvailable callback.
A CancelEvent will be prepend to event queue and trigger race condition between CompleteResume and EndForceEnqueueing.

Assignee: nobody → schien

Flags: needinfo?(schien)

Comment hidden (mozreview-request)

Review commit: https://reviewboard.mozilla.org/r/210094/diff/#index_header
See other reviews: https://reviewboard.mozilla.org/r/210094/

Honza Bambas (:mayhemer)

Comment 6

•

6 years ago

mozreview-review

Comment on attachment 8939776 [details]
Bug 1426751 - Prevent FlushQueue to be invoked on multiple threads simultaneously.

https://reviewboard.mozilla.org/r/210094/#review216176

thanks!

::: netwerk/ipc/ChannelEventQueue.cpp
(Diff revision 1)
>  
> -  // Prevent flushed events from flushing the queue recursively
> -  {
> -    MutexAutoLock lock(mMutex);
> -    MOZ_ASSERT(!mFlushing);
> -    mFlushing = true;

I think this should be turned to:

#ifdef DEBUG
  {
    MutexAutoLock lock(mMutex);
    MOZ_ASSERT(mFlushing);
  }
#endif

Attachment #8939776 - Flags: review?(honzab.moz) → review+

Shih-Chiang Chien [:schien] (UTC+8) (use ni? plz)

Assignee

Comment 7

•

6 years ago

mozreview-review-reply

Comment on attachment 8939776 [details]
Bug 1426751 - Prevent FlushQueue to be invoked on multiple threads simultaneously.

https://reviewboard.mozilla.org/r/210094/#review216176

> I think this should be turned to:
> 
> #ifdef DEBUG
>   {
>     MutexAutoLock lock(mMutex);
>     MOZ_ASSERT(mFlushing);
>   }
> #endif

good suggestion, will be included in next revision.

Comment hidden (mozreview-request)

Comment on attachment 8939776 [details]
Bug 1426751 - Prevent FlushQueue to be invoked on multiple threads simultaneously.

Review request updated; see interdiff: https://reviewboard.mozilla.org/r/210094/diff/1-2/

Comment hidden (mozreview-request)

Comment on attachment 8939776 [details]
Bug 1426751 - Prevent FlushQueue to be invoked on multiple threads simultaneously.

Review request updated; see interdiff: https://reviewboard.mozilla.org/r/210094/diff/2-3/

Pulsebot

Comment 10

•

6 years ago

Pushed by schien@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/2698d1eb51ab
Prevent FlushQueue to be invoked on multiple threads simultaneously. r=mayhemer

Dorel Luca [:dluca]

Comment 11

•

6 years ago

bugherder

https://hg.mozilla.org/mozilla-central/rev/2698d1eb51ab

Status: NEW → RESOLVED

Closed: 6 years ago

status-firefox59: --- → fixed

Resolution: --- → FIXED

Target Milestone: --- → mozilla59

Ryan VanderMeulen [:RyanVM]

Updated

•

6 years ago

status-firefox57: --- → wontfix

status-firefox58: --- → wontfix

status-firefox-esr52: --- → unaffected

Comment hidden (Intermittent Failures Robot)

1 failures in 701 pushes (0.001 failures/push) were associated with this bug in the last 7 days.    

Repository breakdown:
* autoland: 1

Platform breakdown:
* linux64-stylo-disabled: 1

For more details, see:
https://brasstacks.mozilla.com/orangefactor/?display=Bug&bugid=1426751&startday=2018-01-22&endday=2018-01-28&tree=all

Andreea Pavel [:apavel]

Comment 13

•

6 years ago

Recent failure log: https://treeherder.mozilla.org/logviewer.html#?job_id=161397764&repo=mozilla-inbound&lineNumber=6085

[task 2018-02-09T20:18:04.704Z] 20:18:04     INFO - TEST-START | /eventsource/shared-worker/eventsource-close.htm
[task 2018-02-09T20:18:04.789Z] 20:18:04     INFO - PID 3098 | ++DOCSHELL 0x7feff4f87000 == 2 [pid = 3149] [id = {2300fbe7-3875-4409-b5bf-946871d5333f}]
[task 2018-02-09T20:18:04.789Z] 20:18:04     INFO - PID 3098 | ++DOMWINDOW == 6 (0x7feff635da40) [pid = 3149] [serial = 6] [outer = (nil)]
[task 2018-02-09T20:18:04.814Z] 20:18:04     INFO - PID 3098 | ++DOMWINDOW == 7 (0x7feff5005000) [pid = 3149] [serial = 7] [outer = 0x7feff635da40]
[task 2018-02-09T20:18:04.850Z] 20:18:04     INFO - PID 3098 | [Child 3149, Main Thread] WARNING: NS_ENSURE_TRUE(node) failed: file /builds/worker/workspace/build/src/layout/base/nsDocumentViewer.cpp, line 3713
[task 2018-02-09T20:18:04.939Z] 20:18:04     INFO - PID 3098 | ++DOMWINDOW == 8 (0x7fefef76fc00) [pid = 3149] [serial = 8] [outer = 0x7feff635da40]
[task 2018-02-09T20:18:04.968Z] 20:18:04     INFO - PID 3098 | [Child 3149, Main Thread] WARNING: NS_ENSURE_TRUE(node) failed: file /builds/worker/workspace/build/src/layout/base/nsDocumentViewer.cpp, line 3713
[task 2018-02-09T20:18:04.970Z] 20:18:04     INFO - PID 3098 | [Child 3149, Main Thread] WARNING: (debug) Error: Source()->Close() returned error (rv1) in bsBuffedInputStream::Close().: file /builds/worker/workspace/build/src/netwerk/base/nsBufferedStreams.cpp, line 335
[task 2018-02-09T20:18:04.998Z] 20:18:04     INFO - PID 3098 | ++DOCSHELL 0x7fefef208000 == 3 [pid = 3149] [id = {50b885a2-9bfe-45a3-b90c-2d38ca779443}]
[task 2018-02-09T20:18:04.999Z] 20:18:04     INFO - PID 3098 | ++DOMWINDOW == 9 (0x7feff635dc30) [pid = 3149] [serial = 9] [outer = (nil)]
[task 2018-02-09T20:18:05.035Z] 20:18:05     INFO - PID 3098 | ++DOMWINDOW == 10 (0x7feff500d400) [pid = 3149] [serial = 10] [outer = 0x7feff635dc30]
[task 2018-02-09T20:18:05.116Z] 20:18:05     INFO - PID 3098 | ++DOMWINDOW == 11 (0x7feff5011400) [pid = 3149] [serial = 11] [outer = 0x7feff635dc30]
[task 2018-02-09T20:18:05.157Z] 20:18:05     INFO - PID 3098 | [Child 3149, Main Thread] WARNING: attempt to modify an immutable nsStandardURL: file /builds/worker/workspace/build/src/netwerk/base/nsStandardURL.cpp, line 1698
[task 2018-02-09T20:18:05.952Z] 20:18:05     INFO - PID 3098 | [Child 3149, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/worker/workspace/build/src/toolkit/xre/nsXREDirProvider.cpp, line 1571
[task 2018-02-09T20:18:05.981Z] 20:18:05     INFO - PID 3098 | [Child 3149, Main Thread] WARNING: NS_ENSURE_TRUE(node) failed: file /builds/worker/workspace/build/src/layout/base/nsDocumentViewer.cpp, line 3713
[task 2018-02-09T20:18:06.018Z] 20:18:06     INFO - PID 3098 | [Parent 3098, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80070057: file /builds/worker/workspace/build/src/netwerk/base/nsChannelClassifier.cpp, line 344
[task 2018-02-09T20:18:06.079Z] 20:18:06     INFO - PID 3098 | Assertion failure: !thisObject->IsShutDown(), at /builds/worker/workspace/build/src/dom/base/EventSource.cpp:714
[task 2018-02-09T20:18:06.188Z] 20:18:06     INFO - PID 3098 | #01: nsStringInputStream::ReadSegments(nsresult (*)(nsIInputStream*, void*, char const*, unsigned int, unsigned int, unsigned int*), void*, unsigned int, unsigned int*) (/builds/worker/workspace/build/application/firefox/libxul.so)
[task 2018-02-09T20:18:06.192Z] 20:18:06     INFO - PID 3098 | #02: mozilla::dom::EventSourceImpl::OnDataAvailable(nsIRequest*, nsISupports*, nsIInputStream*, unsigned long, unsigned int) (/builds/worker/workspace/build/application/firefox/libxul.so)
[task 2018-02-09T20:18:06.201Z] 20:18:06     INFO - PID 3098 | #03: nsCORSListenerProxy::OnDataAvailable(nsIRequest*, nsISupports*, nsIInputStream*, unsigned long, unsigned int) (/builds/worker/workspace/build/application/firefox/libxul.so)
[task 2018-02-09T20:18:06.202Z] 20:18:06     INFO - PID 3098 | #04: mozilla::net::HttpChannelChild::DoOnDataAvailable(nsIRequest*, nsISupports*, nsIInputStream*, unsigned long, unsigned int) (/builds/worker/workspace/build/application/firefox/libxul.so)
[task 2018-02-09T20:18:06.210Z] 20:18:06     INFO - PID 3098 | #05: mozilla::net::HttpChannelChild::OnTransportAndData(nsresult const&, nsresult const&, unsigned long const&, unsigned int const&, nsTString<char> const&) (/builds/worker/workspace/build/application/firefox/libxul.so)
[task 2018-02-09T20:18:06.214Z] 20:18:06     INFO - PID 3098 | #06: mozilla::net::ChannelEventQueue::RunOrEnqueue(mozilla::net::ChannelEvent*, bool) (/builds/worker/workspace/build/application/firefox/libxul.so)
[task 2018-02-09T20:18:06.218Z] 20:18:06     INFO - PID 3098 | #07: mozilla::net::HttpBackgroundChannelChild::RecvOnTransportAndData(nsresult const&, nsresult const&, unsigned long const&, unsigned int const&, nsTString<char> const&) (/builds/worker/workspace/build/application/firefox/libxul.so)
[task 2018-02-09T20:18:06.224Z] 20:18:06     INFO - PID 3098 | #08: mozilla::detail::RunnableMethodImpl<mozilla::net::HttpBackgroundChannelChild*, mozilla::ipc::IPCResult (mozilla::net::HttpBackgroundChannelChild::*)(nsresult const&, nsresult const&, unsigned long const&, unsigned int const&, nsTString<char> const&), true, (mozilla::RunnableKind)0, nsresult const, nsresult const, unsigned long const, unsigned int const, nsTString<char> const>::Run() (/builds/worker/workspace/build/application/firefox/libxul.so)
[task 2018-02-09T20:18:06.232Z] 20:18:06     INFO - PID 3098 | #09: mozilla::net::HttpBackgroundChannelChild::OnStartRequestReceived() (/builds/worker/workspace/build/application/firefox/libxul.so)
[task 2018-02-09T20:18:06.233Z] 20:18:06     INFO - PID 3098 | #10: mozilla::detail::RunnableMethodImpl<RefPtr<mozilla::net::HttpBackgroundChannelChild>, void (mozilla::net::HttpBackgroundChannelChild::*)(), true, (mozilla::RunnableKind)0>::Run() (/builds/worker/workspace/build/application/firefox/libxul.so)
[task 2018-02-09T20:18:06.241Z] 20:18:06     INFO - PID 3098 | #11: nsThread::ProcessNextEvent(bool, bool*) [clone .part.288] (/builds/worker/workspace/build/application/firefox/libxul.so)
[task 2018-02-09T20:18:06.244Z] 20:18:06     INFO - PID 3098 | #12: NS_ProcessNextEvent(nsIThread*, bool) (/builds/worker/workspace/build/application/firefox/libxul.so)
[task 2018-02-09T20:18:06.248Z] 20:18:06     INFO - PID 3098 | #13: mozilla::net::nsSocketTransportService::Run() (/builds/worker/workspace/build/application/firefox/libxul.so)
[task 2018-02-09T20:18:06.250Z] 20:18:06     INFO - PID 3098 | #14: nsThread::ProcessNextEvent(bool, bool*) [clone .part.288] (/builds/worker/workspace/build/application/firefox/libxul.so)
[task 2018-02-09T20:18:06.250Z] 20:18:06     INFO - PID 3098 | #15: NS_ProcessNextEvent(nsIThread*, bool) (/builds/worker/workspace/build/application/firefox/libxul.so)
[task 2018-02-09T20:18:06.255Z] 20:18:06     INFO - PID 3098 | #16: mozilla::ipc::MessagePumpForNonMainThreads::Run(base::MessagePump::Delegate*) (/builds/worker/workspace/build/application/firefox/libxul.so)
[task 2018-02-09T20:18:06.262Z] 20:18:06     INFO - PID 3098 | #17: MessageLoop::RunInternal() (/builds/worker/workspace/build/application/firefox/libxul.so)
[task 2018-02-09T20:18:06.264Z] 20:18:06     INFO - PID 3098 | #18: MessageLoop::Run() (/builds/worker/workspace/build/application/firefox/libxul.so)
[task 2018-02-09T20:18:06.272Z] 20:18:06     INFO - PID 3098 | #19: nsThread::ThreadFunc(void*) (/builds/worker/workspace/build/application/firefox/libxul.so)
[task 2018-02-09T20:18:06.329Z] 20:18:06     INFO - PID 3098 | #20: _pt_root (/builds/worker/workspace/build/application/firefox/libnspr4.so)
[task 2018-02-09T20:18:06.377Z] 20:18:06     INFO - PID 3098 | #21: start_thread (/build/glibc-Cl5G7W/glibc-2.23/nptl/pthread_create.c:333)
[task 2018-02-09T20:18:07.015Z] 20:18:07     INFO - mozcrash Downloading symbols from: https://queue.taskcluster.net/v1/task/EYPhjnNZRFCOggqzaNhezw/artifacts/public/build/target.crashreporter-symbols.zip

[task 2018-02-09T20:18:10.315Z] 20:18:10     INFO - PID 3098 | --DOMWINDOW == 2 (0x7fbfe4f71c00) [pid = 3098] [serial = 11] [outer = (nil)] [url = about:blank]
[task 2018-02-09T20:18:10.316Z] 20:18:10     INFO - PID 3098 | --DOMWINDOW == 1 (0x7fbff60dca40) [pid = 3098] [serial = 10] [outer = (nil)] [url = about:blank]
[task 2018-02-09T20:18:10.317Z] 20:18:10     INFO - PID 3098 | [Parent 3098, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 517
[task 2018-02-09T20:18:10.318Z] 20:18:10     INFO - PID 3098 | [Parent 3098, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 517
[task 2018-02-09T20:18:10.318Z] 20:18:10     INFO - PID 3098 | [Parent 3098, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 517
[task 2018-02-09T20:18:10.319Z] 20:18:10     INFO - PID 3098 | [Parent 3098, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 517
[task 2018-02-09T20:18:10.320Z] 20:18:10     INFO - PID 3098 | [Parent 3098, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 517
[task 2018-02-09T20:18:10.321Z] 20:18:10     INFO - PID 3098 | [Parent 3098, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 517
[task 2018-02-09T20:18:10.321Z] 20:18:10     INFO - PID 3098 | [Parent 3098, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 517
[task 2018-02-09T20:18:10.322Z] 20:18:10     INFO - PID 3098 | [Parent 3098, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 517
[task 2018-02-09T20:18:10.323Z] 20:18:10     INFO - PID 3098 | --DOMWINDOW == 0 (0x7fbff9c7e400) [pid = 3098] [serial = 5] [outer = (nil)] [url = resource://gre-resources/hiddenWindow.html]
[task 2018-02-09T20:18:10.365Z] 20:18:10     INFO - PID 3098 | nsStringStats
[task 2018-02-09T20:18:10.366Z] 20:18:10     INFO - PID 3098 |  => mAllocCount:          90508
[task 2018-02-09T20:18:10.367Z] 20:18:10     INFO - PID 3098 |  => mReallocCount:         8384
[task 2018-02-09T20:18:10.368Z] 20:18:10     INFO - PID 3098 |  => mFreeCount:           90507  --  LEAKED 1 !!!
[task 2018-02-09T20:18:10.369Z] 20:18:10     INFO - PID 3098 |  => mShareCount:          94082
[task 2018-02-09T20:18:10.370Z] 20:18:10     INFO - PID 3098 |  => mAdoptCount:           3818
[task 2018-02-09T20:18:10.370Z] 20:18:10     INFO - PID 3098 |  => mAdoptFreeCount:       3818
[task 2018-02-09T20:18:10.371Z] 20:18:10     INFO - PID 3098 |  => Process ID: 3098, Thread ID: 140463188993856
[task 2018-02-09T20:18:13.818Z] 20:18:13     INFO - mozcrash Copy/paste: /usr/local/bin/linux64-minidump_stackwalk /tmp/tmpMrDmji.mozrunner/minidumps/2ff8dfdd-9f6a-ab33-0d6f-8844ce09d763.dmp /tmp/tmpABYiyb
[task 2018-02-09T20:18:21.318Z] 20:18:21     INFO - mozcrash Saved minidump as /builds/worker/workspace/build/blobber_upload_dir/2ff8dfdd-9f6a-ab33-0d6f-8844ce09d763.dmp
[task 2018-02-09T20:18:21.319Z] 20:18:21     INFO - mozcrash Saved app info as /builds/worker/workspace/build/blobber_upload_dir/2ff8dfdd-9f6a-ab33-0d6f-8844ce09d763.extra
[task 2018-02-09T20:18:21.357Z] 20:18:21     INFO - PROCESS-CRASH | /eventsource/shared-worker/eventsource-close.htm | application crashed [@ mozilla::dom::EventSourceImpl::StreamReaderFunc]
[task 2018-02-09T20:18:21.357Z] 20:18:21     INFO - Crash dump filename: /tmp/tmpMrDmji.mozrunner/minidumps/2ff8dfdd-9f6a-ab33-0d6f-8844ce09d763.dmp
[task 2018-02-09T20:18:21.358Z] 20:18:21     INFO - Operating system: Linux
[task 2018-02-09T20:18:21.358Z] 20:18:21     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-02-09T20:18:21.358Z] 20:18:21     INFO - CPU: amd64
[task 2018-02-09T20:18:21.359Z] 20:18:21     INFO -      family 6 model 62 stepping 4
[task 2018-02-09T20:18:21.359Z] 20:18:21     INFO -      4 CPUs
[task 2018-02-09T20:18:21.359Z] 20:18:21     INFO - 
[task 2018-02-09T20:18:21.360Z] 20:18:21     INFO - GPU: UNKNOWN
[task 2018-02-09T20:18:21.361Z] 20:18:21     INFO - 
[task 2018-02-09T20:18:21.361Z] 20:18:21     INFO - Crash reason:  SIGSEGV
[task 2018-02-09T20:18:21.362Z] 20:18:21     INFO - Crash address: 0x0
[task 2018-02-09T20:18:21.362Z] 20:18:21     INFO - Process uptime: not available
[task 2018-02-09T20:18:21.362Z] 20:18:21     INFO - 
[task 2018-02-09T20:18:21.363Z] 20:18:21     INFO - Thread 7 (crashed)
[task 2018-02-09T20:18:21.363Z] 20:18:21     INFO -  0  libxul.so!mozilla::dom::EventSourceImpl::StreamReaderFunc [EventSource.cpp:35b81e0007ab42a5c0e7ec037ee2295d6708607e : 714 + 0x24]
[task 2018-02-09T20:18:21.364Z] 20:18:21     INFO -     rax = 0x0000000000000000   rdx = 0x0000000000000000
[task 2018-02-09T20:18:21.364Z] 20:18:21     INFO -     rcx = 0x00007ff00fb4e2dd   rbx = 0x00007fefebd3b870
[task 2018-02-09T20:18:21.365Z] 20:18:21     INFO -     rsi = 0x00007ff00fe1d770   rdi = 0x00007ff00fe1c540
[task 2018-02-09T20:18:21.365Z] 20:18:21     INFO -     rbp = 0x00007feff71fdcc0   rsp = 0x00007feff71fdca0
[task 2018-02-09T20:18:21.365Z] 20:18:21     INFO -      r8 = 0x00007ff00fe1d770    r9 = 0x00007feff71ff700
[task 2018-02-09T20:18:21.366Z] 20:18:21     INFO -     r10 = 0x0000000000000012   r11 = 0x0000000000000000
[task 2018-02-09T20:18:21.366Z] 20:18:21     INFO -     r12 = 0x00007feff71fdd18   r13 = 0x000000000000000d
[task 2018-02-09T20:18:21.367Z] 20:18:21     INFO -     r14 = 0x00007fefea914b2c   r15 = 0x00007fefebd3b870
[task 2018-02-09T20:18:21.367Z] 20:18:21     INFO -     rip = 0x00007fefffc2cd1d
[task 2018-02-09T20:18:21.368Z] 20:18:21     INFO -     Found by: given as instruction pointer in context
[task 2018-02-09T20:18:21.368Z] 20:18:21     INFO -  1  libxul.so!nsStringInputStream::ReadSegments [nsStringStream.cpp:35b81e0007ab42a5c0e7ec037ee2295d6708607e : 257 + 0xb]
[task 2018-02-09T20:18:21.368Z] 20:18:21     INFO -     rbx = 0x00007feff638a100   rbp = 0x00007feff71fdd00
[task 2018-02-09T20:18:21.369Z] 20:18:21     INFO -     rsp = 0x00007feff71fdcd0   r12 = 0x000000000000000d
[task 2018-02-09T20:18:21.370Z] 20:18:21     INFO -     r13 = 0x00007feff71fdd18   r14 = 0x00007fefffc2ccac
[task 2018-02-09T20:18:21.371Z] 20:18:21     INFO -     r15 = 0x00007fefebd3b870   rip = 0x00007feffefd496c
[task 2018-02-09T20:18:21.371Z] 20:18:21     INFO -     Found by: call frame info
[task 2018-02-09T20:18:21.372Z] 20:18:21     INFO -  2  libxul.so!mozilla::dom::EventSourceImpl::OnDataAvailable [EventSource.cpp:35b81e0007ab42a5c0e7ec037ee2295d6708607e : 768 + 0x1a]
[task 2018-02-09T20:18:21.372Z] 20:18:21     INFO -     rbx = 0x0000000000000000   rbp = 0x00007feff71fdd50
[task 2018-02-09T20:18:21.373Z] 20:18:21     INFO -     rsp = 0x00007feff71fdd10   r12 = 0x00007fefebd3b870
[task 2018-02-09T20:18:21.373Z] 20:18:21     INFO -     r13 = 0x00007feff638a100   r14 = 0x00007feff71fdd18
[task 2018-02-09T20:18:21.373Z] 20:18:21     INFO -     r15 = 0x000000000000000d   rip = 0x00007fefffc30142
[task 2018-02-09T20:18:21.374Z] 20:18:21     INFO -     Found by: call frame info
[task 2018-02-09T20:18:21.374Z] 20:18:21     INFO -  3  libxul.so!nsCORSListenerProxy::OnDataAvailable [nsCORSListenerProxy.cpp:35b81e0007ab42a5c0e7ec037ee2295d6708607e : 665 + 0x1c]
[task 2018-02-09T20:18:21.374Z] 20:18:21     INFO -     rbx = 0x00007feff71fdd80   rbp = 0x00007feff71fddd0
[task 2018-02-09T20:18:21.374Z] 20:18:21     INFO -     rsp = 0x00007feff71fdd60   r12 = 0x00007feff71fdd88
[task 2018-02-09T20:18:21.375Z] 20:18:21     INFO -     r13 = 0x0000000000000000   r14 = 0x00007feff638a100
[task 2018-02-09T20:18:21.375Z] 20:18:21     INFO -     r15 = 0x00007feff71fdd90   rip = 0x00007fefff2bffd1
[task 2018-02-09T20:18:21.375Z] 20:18:21     INFO -     Found by: call frame info
[task 2018-02-09T20:18:21.376Z] 20:18:21     INFO -  4  libxul.so!mozilla::net::HttpChannelChild::DoOnDataAvailable [HttpChannelChild.cpp:35b81e0007ab42a5c0e7ec037ee2295d6708607e : 1028 + 0x27]
[task 2018-02-09T20:18:21.376Z] 20:18:21     INFO -     rbx = 0x00007fefebad2800   rbp = 0x00007feff71fde20
[task 2018-02-09T20:18:21.376Z] 20:18:21     INFO -     rsp = 0x00007feff71fdde0   r12 = 0x00007feff4db5e10
[task 2018-02-09T20:18:21.377Z] 20:18:21     INFO -     r13 = 0x00007feff638a100   r14 = 0x0000000000000000
[task 2018-02-09T20:18:21.377Z] 20:18:21     INFO -     r15 = 0x000000000000000d   rip = 0x00007fefff2af4e9
[task 2018-02-09T20:18:21.377Z] 20:18:21     INFO -     Found by: call frame info
[task 2018-02-09T20:18:21.377Z] 20:18:21     INFO -  5  libxul.so!mozilla::net::HttpChannelChild::OnTransportAndData [HttpChannelChild.cpp:35b81e0007ab42a5c0e7ec037ee2295d6708607e : 954 + 0x1e]
[task 2018-02-09T20:18:21.378Z] 20:18:21     INFO -     rbx = 0x00007fefebad2800   rbp = 0x00007feff71fdf00
[task 2018-02-09T20:18:21.378Z] 20:18:21     INFO -     rsp = 0x00007feff71fde30   r12 = 0x00007feff71fde98
[task 2018-02-09T20:18:21.378Z] 20:18:21     INFO -     r13 = 0x00007fefea91f2b0   r14 = 0x00007fefea91f2a8
[task 2018-02-09T20:18:21.378Z] 20:18:21     INFO -     r15 = 0x0000000000000000   rip = 0x00007fefff2afbe2
[task 2018-02-09T20:18:21.379Z] 20:18:21     INFO -     Found by: call frame info

Status: RESOLVED → REOPENED

Resolution: FIXED → ---

Comment hidden (Intermittent Failures Robot)

1 failures in 702 pushes (0.001 failures/push) were associated with this bug in the last 7 days.    

Repository breakdown:
* mozilla-inbound: 1

Platform breakdown:
* linux64: 1

For more details, see:
https://brasstacks.mozilla.com/orangefactor/?display=Bug&bugid=1426751&startday=2018-02-05&endday=2018-02-11&tree=all

Josh Matthews [:jdm]

Comment 15

•

6 years ago

That failure from comment 13 shows a different crash stack and assertion failure than the one described in this bug's summary.

Flags: needinfo?(apavel)

Andreea Pavel [:apavel]

Comment 16

•

6 years ago

:jdm hi, i looked at the failure log from comment 12, the failures match.

Andreea Pavel [:apavel]

Updated

•

6 years ago

Flags: needinfo?(apavel)

Josh Matthews [:jdm]

Comment 17

•

6 years ago

I'm pretty sure that just means that somebody mis-starred the failure from comment 12.

Firefox Bug Husbandry Bot

Comment 18

•

6 years ago

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup

Status: REOPENED → RESOLVED

Closed: 6 years ago → 6 years ago

Resolution: --- → INCOMPLETE

bug1426751 analysis.png 6 years ago Shih-Chiang Chien [:schien] (UTC+8) (use ni? plz) 54.74 KB, image/png		Details
Bug 1426751 - Prevent FlushQueue to be invoked on multiple threads simultaneously. 6 years ago Shih-Chiang Chien [:schien] (UTC+8) (use ni? plz) 59 bytes, text/x-review-board-request	mayhemer : review+	Details