Closed Bug 1614047 Opened 5 years ago Closed 5 years ago

Intermittent Last test finished | application crashed [@ mozilla::nsTerminator::StartWatchdog + 0x724]

Categories

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

defect

Tracking

()

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: crash, intermittent-failure)

Crash Data

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


[task 2020-02-07T06:03:51.068Z] 06:03:51 INFO - TEST-START | dom/tests/browser/perfmetrics/browser_test_performance_metrics.js
[task 2020-02-07T06:03:54.643Z] 06:03:54 INFO - GECKO(2076) | MEMORY STAT | vsize 2104467MB | vsizeMaxContiguous 65448214MB | residentFast 383MB | heapAllocated 120MB
[task 2020-02-07T06:03:54.643Z] 06:03:54 INFO - TEST-OK | dom/tests/browser/perfmetrics/browser_test_performance_metrics.js | took 3568ms
[task 2020-02-07T06:03:54.681Z] 06:03:54 INFO - checking window state
[task 2020-02-07T06:03:56.918Z] 06:03:56 INFO - GECKO(2076) | Completed ShutdownLeaks collections in process 7172
[task 2020-02-07T06:03:56.968Z] 06:03:56 INFO - GECKO(2076) | Completed ShutdownLeaks collections in process 5540
[task 2020-02-07T06:03:56.968Z] 06:03:56 INFO - GECKO(2076) | Completed ShutdownLeaks collections in process 6088
[task 2020-02-07T06:03:56.987Z] 06:03:56 INFO - GECKO(2076) | Completed ShutdownLeaks collections in process 3524
[task 2020-02-07T06:03:56.989Z] 06:03:56 INFO - GECKO(2076) | Completed ShutdownLeaks collections in process 8228
[task 2020-02-07T06:03:57.007Z] 06:03:57 INFO - GECKO(2076) | Completed ShutdownLeaks collections in process 6540
[task 2020-02-07T06:03:57.026Z] 06:03:57 INFO - GECKO(2076) | Completed ShutdownLeaks collections in process 7124
[task 2020-02-07T06:03:57.066Z] 06:03:57 INFO - GECKO(2076) | Completed ShutdownLeaks collections in process 3556
[task 2020-02-07T06:03:57.088Z] 06:03:57 INFO - GECKO(2076) | Completed ShutdownLeaks collections in process 8272
[task 2020-02-07T06:03:58.776Z] 06:03:58 INFO - GECKO(2076) | Completed ShutdownLeaks collections in process 2508
[task 2020-02-07T06:03:58.777Z] 06:03:58 INFO - TEST-START | Shutdown
[task 2020-02-07T06:03:58.777Z] 06:03:58 INFO - Browser Chrome Test Summary
[task 2020-02-07T06:03:58.777Z] 06:03:58 INFO - Passed: 208
[task 2020-02-07T06:03:58.777Z] 06:03:58 INFO - Failed: 0
[task 2020-02-07T06:03:58.777Z] 06:03:58 INFO - Todo: 0
[task 2020-02-07T06:03:58.777Z] 06:03:58 INFO - Mode: e10s
[task 2020-02-07T06:03:58.777Z] 06:03:58 INFO - *** End BrowserChrome Test Results ***
[task 2020-02-07T06:03:59.113Z] 06:03:59 INFO - GECKO(2076) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-02-07T06:03:59.113Z] 06:03:59 INFO - GECKO(2076) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-02-07T06:03:59.113Z] 06:03:59 INFO - GECKO(2076) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-02-07T06:03:59.183Z] 06:03:59 INFO - GECKO(2076) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-02-07T06:03:59.193Z] 06:03:59 INFO - GECKO(2076) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-02-07T06:03:59.203Z] 06:03:59 INFO - GECKO(2076) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-02-07T06:03:59.204Z] 06:03:59 INFO - GECKO(2076) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-02-07T06:03:59.204Z] 06:03:59 INFO - GECKO(2076) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-02-07T06:03:59.204Z] 06:03:59 INFO - GECKO(2076) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-02-07T06:03:59.223Z] 06:03:59 INFO - GECKO(2076) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-02-07T06:03:59.223Z] 06:03:59 INFO - GECKO(2076) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-02-07T06:03:59.224Z] 06:03:59 INFO - GECKO(2076) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-02-07T06:03:59.226Z] 06:03:59 INFO - GECKO(2076) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-02-07T06:03:59.281Z] 06:03:59 INFO - GECKO(2076) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-02-07T06:03:59.300Z] 06:03:59 INFO - GECKO(2076) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-02-07T06:03:59.300Z] 06:03:59 INFO - GECKO(2076) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-02-07T06:03:59.300Z] 06:03:59 INFO - GECKO(2076) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-02-07T06:03:59.300Z] 06:03:59 INFO - GECKO(2076) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-02-07T06:03:59.301Z] 06:03:59 INFO - GECKO(2076) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-02-07T06:03:59.301Z] 06:03:59 INFO - GECKO(2076) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-02-07T06:03:59.301Z] 06:03:59 INFO - GECKO(2076) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-02-07T06:03:59.301Z] 06:03:59 INFO - GECKO(2076) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-02-07T06:03:59.301Z] 06:03:59 INFO - GECKO(2076) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-02-07T06:03:59.668Z] 06:03:59 INFO - GECKO(2076) | 1581055439657 Marionette TRACE Received observer notification xpcom-will-shutdown
[task 2020-02-07T06:03:59.668Z] 06:03:59 INFO - GECKO(2076) | 1581055439658 Marionette INFO Stopped listening on port 2828
[task 2020-02-07T06:03:59.668Z] 06:03:59 INFO - GECKO(2076) | 1581055439658 Marionette DEBUG Marionette stopped listening
[task 2020-02-07T06:03:59.767Z] 06:03:59 INFO - GECKO(2076) | ###!!! [Child][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-02-07T06:05:28.318Z] 06:05:28 INFO - TEST-INFO | Main app process: exit 1
[task 2020-02-07T06:05:28.318Z] 06:05:28 INFO - Buffered messages finished
[task 2020-02-07T06:05:28.318Z] 06:05:28 ERROR - TEST-UNEXPECTED-FAIL | Last test finished | application terminated with exit code 1
[task 2020-02-07T06:05:28.318Z] 06:05:28 INFO - runtests.py | Application ran for: 0:01:46.074000

[task 2020-02-07T06:05:34.607Z] 06:05:34 INFO - PROCESS-CRASH | Last test finished | application crashed [@ mozilla::nsTerminator::StartWatchdog + 0x724]
[task 2020-02-07T06:05:34.607Z] 06:05:34 INFO - Mozilla crash reason: MOZ_CRASH(Shutdown too long, probably frozen, causing a crash.)
[task 2020-02-07T06:05:34.607Z] 06:05:34 INFO - Crash dump filename: c:\users\task_1581049786\appdata\local\temp\tmp4qz3sh.mozrunner\minidumps\2a70ac35-9191-48cf-9251-2da8ec92b9be.dmp
[task 2020-02-07T06:05:34.607Z] 06:05:34 INFO - Operating system: Windows NT
[task 2020-02-07T06:05:34.607Z] 06:05:34 INFO - 10.0.17134
[task 2020-02-07T06:05:34.607Z] 06:05:34 INFO - CPU: amd64
[task 2020-02-07T06:05:34.607Z] 06:05:34 INFO - family 6 model 85 stepping 4
[task 2020-02-07T06:05:34.607Z] 06:05:34 INFO - 8 CPUs
[task 2020-02-07T06:05:34.608Z] 06:05:34 INFO -
[task 2020-02-07T06:05:34.608Z] 06:05:34 INFO - GPU: UNKNOWN
[task 2020-02-07T06:05:34.608Z] 06:05:34 INFO -
[task 2020-02-07T06:05:34.608Z] 06:05:34 INFO - Crash reason: EXCEPTION_BREAKPOINT
[task 2020-02-07T06:05:34.608Z] 06:05:34 INFO - Crash address: 0x4d5bbd94
[task 2020-02-07T06:05:34.608Z] 06:05:34 INFO - Process uptime: 82 seconds
[task 2020-02-07T06:05:34.608Z] 06:05:34 INFO -
[task 2020-02-07T06:05:34.608Z] 06:05:34 INFO - Thread 12 (crashed)
[task 2020-02-07T06:05:34.608Z] 06:05:34 INFO - 0 xul.dll!void mozilla::nsTerminator::StartWatchdog + 0x724
[task 2020-02-07T06:05:34.608Z] 06:05:34 INFO - rax = 0x00007ffd8c25ded0 rdx = 0x0000000000000000
[task 2020-02-07T06:05:34.608Z] 06:05:34 INFO - rcx = 0x00007ffd5738edc0 rbx = 0x000001bdbb74b730
[task 2020-02-07T06:05:34.608Z] 06:05:34 INFO - rsi = 0x000000000000003f rdi = 0x00007ffd98373ca0
[task 2020-02-07T06:05:34.608Z] 06:05:34 INFO - rbp = 0x0000006c72b50000 rsp = 0x0000006c72b4fb60
[task 2020-02-07T06:05:34.608Z] 06:05:34 INFO - r8 = 0x0000000000000008 r9 = 0x00007ffd96bb0cec
[task 2020-02-07T06:05:34.608Z] 06:05:34 INFO - r10 = 0x00000fffb2d9abe7 r11 = 0x0022008000000002
[task 2020-02-07T06:05:34.608Z] 06:05:34 INFO - r12 = 0x00007ffd99a982c0 r13 = 0x00007ffd8185cec8
[task 2020-02-07T06:05:34.608Z] 06:05:34 INFO - r14 = 0x000001bdbb74b700 r15 = 0x000001bdbb795c50
[task 2020-02-07T06:05:34.608Z] 06:05:34 INFO - rip = 0x00007ffd4d5bbd94
[task 2020-02-07T06:05:34.608Z] 06:05:34 INFO - Found by: given as instruction pointer in context
[task 2020-02-07T06:05:34.608Z] 06:05:34 INFO - 1 nss3.dll!PR_NativeRunThread + 0x1d6
[task 2020-02-07T06:05:34.608Z] 06:05:34 INFO - rbx = 0x000001bdbb74b730 rbp = 0x0000006c72b50000
[task 2020-02-07T06:05:34.608Z] 06:05:34 INFO - rsp = 0x0000006c72b4fbd0 r12 = 0x00007ffd99a982c0
[task 2020-02-07T06:05:34.608Z] 06:05:34 INFO - r13 = 0x00007ffd8185cec8 r14 = 0x000001bdbb74b700
[task 2020-02-07T06:05:34.608Z] 06:05:34 INFO - r15 = 0x000001bdbb795c50 rip = 0x00007ffd815c4ec6
[task 2020-02-07T06:05:34.608Z] 06:05:34 INFO - Found by: call frame info
[task 2020-02-07T06:05:34.608Z] 06:05:34 INFO - 2 nss3.dll!PR_MD_CREATE_THREAD + 0x122
[task 2020-02-07T06:05:34.608Z] 06:05:34 INFO - rbx = 0x000001bdbb74b730 rbp = 0x0000006c72b50000
[task 2020-02-07T06:05:34.608Z] 06:05:34 INFO - rsp = 0x0000006c72b4fc70 r12 = 0x00007ffd99a982c0
[task 2020-02-07T06:05:34.608Z] 06:05:34 INFO - r13 = 0x00007ffd8185cec8 r14 = 0x000001bdbb74b700
[task 2020-02-07T06:05:34.608Z] 06:05:34 INFO - r15 = 0x000001bdbb795c50 rip = 0x00007ffd815a83b2
[task 2020-02-07T06:05:34.608Z] 06:05:34 INFO - Found by: call frame info
[task 2020-02-07T06:05:34.609Z] 06:05:34 INFO - 3 ucrtbase.dll!RtlpHpSegPageRangeShrink + 0xda
[task 2020-02-07T06:05:34.609Z] 06:05:34 INFO - rbx = 0x000001bdbb74b730 rbp = 0x0000006c72b50000
[task 2020-02-07T06:05:34.609Z] 06:05:34 INFO - rsp = 0x0000006c72b4fca0 r12 = 0x00007ffd99a982c0
[task 2020-02-07T06:05:34.609Z] 06:05:34 INFO - r13 = 0x00007ffd8185cec8 r14 = 0x000001bdbb74b700
[task 2020-02-07T06:05:34.609Z] 06:05:34 INFO - r15 = 0x000001bdbb795c50 rip = 0x00007ffd96b8c4be
[task 2020-02-07T06:05:34.609Z] 06:05:34 INFO - Found by: call frame info

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