Closed Bug 1711163 Opened 5 years ago Closed 3 years ago

Intermittent PROCESS-CRASH | automation.py | application crashed [@ 0xfffff954] - After application terminated with exit code 1

Categories

(Core :: Widget: Cocoa, defect, P3)

defect

Tracking

()

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: crash, intermittent-failure)

Crash Data

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


[task 2021-05-13T23:24:32.926Z] 23:24:32     INFO - TEST-START | toolkit/components/pdfjs/test/browser_pdfjs_notification_close_on_navigation.js
[task 2021-05-13T23:24:32.926Z] 23:24:32     INFO - TEST-SKIP | toolkit/components/pdfjs/test/browser_pdfjs_notification_close_on_navigation.js | took 0ms
[task 2021-05-13T23:24:32.927Z] 23:24:32     INFO - Running manifest: accessible/tests/browser/browser.ini
[task 2021-05-13T23:24:33.353Z] 23:24:33     INFO - PID 2821 | pk12util: PKCS12 IMPORT SUCCESSFUL
[task 2021-05-13T23:24:33.534Z] 23:24:33     INFO - MochitestServer : launching ['/Users/cltbld/tasks/task_1620942470/build/tests/bin/xpcshell', '-g', '/Users/cltbld/tasks/task_1620942470/build/application/Firefox Nightly.app/Contents/Resources', '-f', '/Users/cltbld/tasks/task_1620942470/build/tests/bin/components/httpd.js', '-e', "const _PROFILE_PATH = '/var/folders/cj/pjxvjcl16q9cjktt0r9pg08m000017/T/tmpnoi0dzea.mozrunner'; const _SERVER_PORT = '8888'; const _SERVER_ADDR = '127.0.0.1'; const _TEST_PREFIX = undefined; const _DISPLAY_RESULTS = false;", '-f', '/Users/cltbld/tasks/task_1620942470/build/tests/mochitest/server.js']
[task 2021-05-13T23:24:33.535Z] 23:24:33     INFO - runtests.py | Server pid: 2823
[task 2021-05-13T23:24:33.541Z] 23:24:33     INFO - runtests.py | Websocket server pid: 2824
[task 2021-05-13T23:24:33.552Z] 23:24:33     INFO - runtests.py | SSL tunnel pid: 2825
[task 2021-05-13T23:24:33.710Z] 23:24:33     INFO - runtests.py | Running with scheme: http
[task 2021-05-13T23:24:33.710Z] 23:24:33     INFO - runtests.py | Running with e10s: True
[task 2021-05-13T23:24:33.710Z] 23:24:33     INFO - runtests.py | Running with fission: False
[task 2021-05-13T23:24:33.710Z] 23:24:33     INFO - runtests.py | Running with cross-origin iframes: False
[task 2021-05-13T23:24:33.710Z] 23:24:33     INFO - runtests.py | Running with serviceworker_e10s: True
[task 2021-05-13T23:24:33.710Z] 23:24:33     INFO - runtests.py | Running with socketprocess_e10s: False
[task 2021-05-13T23:24:33.710Z] 23:24:33     INFO - runtests.py | Running tests: start.
[task 2021-05-13T23:24:33.710Z] 23:24:33     INFO - 
[task 2021-05-13T23:24:33.723Z] 23:24:33     INFO - Application command: /Users/cltbld/tasks/task_1620942470/build/application/Firefox Nightly.app/Contents/MacOS/firefox -marionette -foreground -profile /var/folders/cj/pjxvjcl16q9cjktt0r9pg08m000017/T/tmpnoi0dzea.mozrunner
[task 2021-05-13T23:24:33.733Z] 23:24:33     INFO - runtests.py | Application pid: 2826
[task 2021-05-13T23:24:33.733Z] 23:24:33     INFO - TEST-INFO | started process GECKO(2826)
[task 2021-05-13T23:27:33.848Z] 23:27:33     INFO - runtests.py | Waiting for browser...
[task 2021-05-13T23:27:33.848Z] 23:27:33     INFO - TEST-INFO | Main app process: exit 1
[task 2021-05-13T23:27:33.848Z] 23:27:33     INFO - Buffered messages finished
[task 2021-05-13T23:27:33.849Z] 23:27:33    ERROR - TEST-UNEXPECTED-FAIL | automation.py | application terminated with exit code 1
[task 2021-05-13T23:27:33.849Z] 23:27:33     INFO - runtests.py | Application ran for: 0:03:00.125557
[task 2021-05-13T23:27:33.850Z] 23:27:33     INFO - zombiecheck | Reading PID log: /var/folders/cj/pjxvjcl16q9cjktt0r9pg08m000017/T/tmpk5y7sr9qpidlog
[task 2021-05-13T23:27:33.850Z] 23:27:33     INFO - mozcrash Downloading symbols from: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/EKXdAsOVQ2KDN80R2VD0uw/artifacts/public/build/target.crashreporter-symbols.zip
[task 2021-05-13T23:27:37.785Z] 23:27:37     INFO - mozcrash Copy/paste: /Users/cltbld/tasks/task_1620942470/fetches/minidump_stackwalk/minidump_stackwalk /var/folders/cj/pjxvjcl16q9cjktt0r9pg08m000017/T/tmpnoi0dzea.mozrunner/minidumps/61EB8116-FFD0-4761-B054-5B39C4C37EDE.dmp /var/folders/cj/pjxvjcl16q9cjktt0r9pg08m000017/T/tmp1l3vltit
[task 2021-05-13T23:27:43.569Z] 23:27:43     INFO - mozcrash Saved minidump as /Users/cltbld/tasks/task_1620942470/build/blobber_upload_dir/61EB8116-FFD0-4761-B054-5B39C4C37EDE.dmp
[task 2021-05-13T23:27:43.570Z] 23:27:43     INFO - mozcrash Saved app info as /Users/cltbld/tasks/task_1620942470/build/blobber_upload_dir/61EB8116-FFD0-4761-B054-5B39C4C37EDE.extra
[task 2021-05-13T23:27:43.689Z] 23:27:43     INFO - PROCESS-CRASH | automation.py | application crashed [@ 0xfffff954]
[task 2021-05-13T23:27:43.689Z] 23:27:43     INFO - Crash dump filename: /var/folders/cj/pjxvjcl16q9cjktt0r9pg08m000017/T/tmpnoi0dzea.mozrunner/minidumps/61EB8116-FFD0-4761-B054-5B39C4C37EDE.dmp
[task 2021-05-13T23:27:43.689Z] 23:27:43     INFO - Operating system: Mac OS X
[task 2021-05-13T23:27:43.689Z] 23:27:43     INFO -                   10.14.5 18F132
[task 2021-05-13T23:27:43.689Z] 23:27:43     INFO - CPU: amd64
[task 2021-05-13T23:27:43.689Z] 23:27:43     INFO -      family 6 model 69 stepping 1
[task 2021-05-13T23:27:43.689Z] 23:27:43     INFO -      4 CPUs
[task 2021-05-13T23:27:43.689Z] 23:27:43     INFO - 
[task 2021-05-13T23:27:43.690Z] 23:27:43     INFO - GPU: UNKNOWN
[task 2021-05-13T23:27:43.690Z] 23:27:43     INFO - 
[task 2021-05-13T23:27:43.690Z] 23:27:43     INFO - Crash reason:  EXC_BAD_ACCESS / KERN_INVALID_ADDRESS
[task 2021-05-13T23:27:43.690Z] 23:27:43     INFO - Crash address: 0xfffffffffffff954
[task 2021-05-13T23:27:43.690Z] 23:27:43     INFO - Process uptime: 1 seconds
[task 2021-05-13T23:27:43.690Z] 23:27:43     INFO - 
[task 2021-05-13T23:27:43.690Z] 23:27:43     INFO - Thread 0 (crashed)
[task 2021-05-13T23:27:43.690Z] 23:27:43     INFO -  0  0xfffff954
[task 2021-05-13T23:27:43.690Z] 23:27:43     INFO -     rax = 0x0000000000000000   rdx = 0x0000000000000001
[task 2021-05-13T23:27:43.690Z] 23:27:43     INFO -     rcx = 0x000000006f617070   rbx = 0x00007fff8e799020
[task 2021-05-13T23:27:43.690Z] 23:27:43     INFO -     rsi = 0x00007ffee292cc58   rdi = 0x0000000070686162
[task 2021-05-13T23:27:43.690Z] 23:27:43     INFO -     rbp = 0x00007fff344df7f4   rsp = 0x00007ffee292cc58
[task 2021-05-13T23:27:43.690Z] 23:27:43     INFO -      r8 = 0x00007ffee292cc3c    r9 = 0x0000000000000004
[task 2021-05-13T23:27:43.690Z] 23:27:43     INFO -     r10 = 0x0000000000000000   r11 = 0x0000000119121eb8
[task 2021-05-13T23:27:43.690Z] 23:27:43     INFO -     r12 = 0x0000000000000008   r13 = 0x0000000000000000
[task 2021-05-13T23:27:43.690Z] 23:27:43     INFO -     r14 = 0x00000000fffff954   r15 = 0x0000000000000001
[task 2021-05-13T23:27:43.690Z] 23:27:43     INFO -     rip = 0x00000000fffff954
[task 2021-05-13T23:27:43.690Z] 23:27:43     INFO -     Found by: given as instruction pointer in context
[task 2021-05-13T23:27:43.691Z] 23:27:43     INFO -  1  AE!aeDispatchAppleEvent(AEDesc const*, AEDesc*, unsigned int, unsigned char*) + 0x3ec
[task 2021-05-13T23:27:43.691Z] 23:27:43     INFO -     rbp = 0x00007fff344df7f4   rsp = 0x00007ffee292cc70
[task 2021-05-13T23:27:43.691Z] 23:27:43     INFO -     rip = 0x00007fff344db06c
[task 2021-05-13T23:27:43.691Z] 23:27:43     INFO -     Found by: stack scanning
[task 2021-05-13T23:27:43.691Z] 23:27:43     INFO -  2  AE!getHighLevelEventQueue() + 0x72
[task 2021-05-13T23:27:43.691Z] 23:27:43     INFO -     rbp = 0x00007fff344df7f4   rsp = 0x00007ffee292cce0
[task 2021-05-13T23:27:43.691Z] 23:27:43     INFO -     rip = 0x00007fff344da94c
[task 2021-05-13T23:27:43.691Z] 23:27:43     INFO -     Found by: stack scanning
[task 2021-05-13T23:27:43.691Z] 23:27:43     INFO -  3  libobjc.A.dylib!NXHashMember + 0x21
[task 2021-05-13T23:27:43.691Z] 23:27:43     INFO -     rbp = 0x00007fff344df7f4   rsp = 0x00007ffee292cd70
[task 2021-05-13T23:27:43.691Z] 23:27:43     INFO -     rip = 0x00007fff5da12686
[task 2021-05-13T23:27:43.691Z] 23:27:43     INFO -     Found by: stack scanning
[task 2021-05-13T23:27:43.691Z] 23:27:43     INFO -  4  libobjc.A.dylib!cache_getImp + 0x90
[task 2021-05-13T23:27:43.691Z] 23:27:43     INFO -     rbp = 0x00007fff344df7f4   rsp = 0x00007ffee292cd88
[task 2021-05-13T23:27:43.691Z] 23:27:43     INFO -     rip = 0x00007fff5da05680
[task 2021-05-13T23:27:43.692Z] 23:27:43     INFO -     Found by: stack scanning
[task 2021-05-13T23:27:43.692Z] 23:27:43     INFO -  5  AppKit!GCC_except_table7 + 0x7f5
[task 2021-05-13T23:27:43.692Z] 23:27:43     INFO -     rbp = 0x00007fff344df7f4   rsp = 0x00007ffee292cda0
[task 2021-05-13T23:27:43.692Z] 23:27:43     INFO -     rip = 0x00007fff314bfee1
[task 2021-05-13T23:27:43.692Z] 23:27:43     INFO -     Found by: stack scanning
<...>
[task 2021-05-13T23:27:43.727Z] 23:27:43     INFO - 118  XUL!nsThreadManager::SpinEventLoopUntilInternal(nsTSubstring<char> const&, nsINestedEventLoopCondition*, mozilla::ShutdownPhase) [nsThreadManager.cpp:940a3ad12e3dc9b2809b02f6a8ac8e941a50d2a1 : 714 + 0x5f]
[task 2021-05-13T23:27:43.727Z] 23:27:43     INFO -     rbp = 0x00007fff344df7f4   rsp = 0x00007ffee292da30
[task 2021-05-13T23:27:43.727Z] 23:27:43     INFO -     rip = 0x000000010df486ef
[task 2021-05-13T23:27:43.727Z] 23:27:43     INFO -     Found by: stack scanning
[task 2021-05-13T23:27:43.727Z] 23:27:43     INFO - 119  XUL!NS_InvokeByIndex + 0x31
[task 2021-05-13T23:27:43.727Z] 23:27:43     INFO -     rbp = 0x00007fff344df7f4   rsp = 0x00007ffee292db00
[task 2021-05-13T23:27:43.727Z] 23:27:43     INFO -     rip = 0x000000010d8af031
[task 2021-05-13T23:27:43.727Z] 23:27:43     INFO -     Found by: stack scanning
[task 2021-05-13T23:27:43.727Z] 23:27:43     INFO - 120  XUL!js::FrameIter::operator++() [FrameIter.cpp:940a3ad12e3dc9b2809b02f6a8ac8e941a50d2a1 : 448 + 0x5]
[task 2021-05-13T23:27:43.727Z] 23:27:43     INFO -     rbp = 0x00007fff344df7f4   rsp = 0x00007ffee292db20
[task 2021-05-13T23:27:43.727Z] 23:27:43     INFO -     rip = 0x000000010f02e98d
[task 2021-05-13T23:27:43.727Z] 23:27:43     INFO -     Found by: stack scanning
[task 2021-05-13T23:27:43.727Z] 23:27:43     INFO - 121  XUL!NS_InvokeByIndex + 0x8e
[task 2021-05-13T23:27:43.727Z] 23:27:43     INFO -     rbp = 0x00007fff344df7f4   rsp = 0x00007ffee292db70
[task 2021-05-13T23:27:43.728Z] 23:27:43     INFO -     rip = 0x000000010d8af08e
[task 2021-05-13T23:27:43.728Z] 23:27:43     INFO -     Found by: stack scanning
[task 2021-05-13T23:27:43.728Z] 23:27:43     INFO - 122  XUL!XPCWrappedNative::CallMethod(XPCCallContext&, XPCWrappedNative::CallMode) [XPCWrappedNative.cpp:940a3ad12e3dc9b2809b02f6a8ac8e941a50d2a1 : 1143 + 0x560]
[task 2021-05-13T23:27:43.728Z] 23:27:43     INFO -     rbp = 0x00007fff344df7f4   rsp = 0x00007ffee292dba0
[task 2021-05-13T23:27:43.728Z] 23:27:43     INFO -     rip = 0x000000010e2fa273
[task 2021-05-13T23:27:43.728Z] 23:27:43     INFO -     Found by: stack scanning
[task 2021-05-13T23:27:43.728Z] 23:27:43     INFO - ```

Crash dump seems to suggest this is deep in the bowels of AppKit:

[task 2021-05-13T23:49:59.156Z] 23:49:59     INFO - Operating system: Mac OS X
[task 2021-05-13T23:49:59.156Z] 23:49:59     INFO -                   10.14.5 18F132
[task 2021-05-13T23:49:59.156Z] 23:49:59     INFO - CPU: amd64
[task 2021-05-13T23:49:59.156Z] 23:49:59     INFO -      family 6 model 69 stepping 1
[task 2021-05-13T23:49:59.156Z] 23:49:59     INFO -      4 CPUs
[task 2021-05-13T23:49:59.156Z] 23:49:59     INFO - 
[task 2021-05-13T23:49:59.156Z] 23:49:59     INFO - GPU: UNKNOWN
[task 2021-05-13T23:49:59.156Z] 23:49:59     INFO - 
[task 2021-05-13T23:49:59.156Z] 23:49:59     INFO - Crash reason:  EXC_BAD_ACCESS / KERN_INVALID_ADDRESS
[task 2021-05-13T23:49:59.156Z] 23:49:59     INFO - Crash address: 0xfffffffffffff954
[task 2021-05-13T23:49:59.156Z] 23:49:59     INFO - Process uptime: 0 seconds
[task 2021-05-13T23:49:59.156Z] 23:49:59     INFO - 
[task 2021-05-13T23:49:59.156Z] 23:49:59     INFO - Thread 0 (crashed)
[task 2021-05-13T23:49:59.156Z] 23:49:59     INFO -  0  0xfffff954
[task 2021-05-13T23:49:59.156Z] 23:49:59     INFO -     rax = 0x0000000000000000   rdx = 0x0000000000000001
[task 2021-05-13T23:49:59.156Z] 23:49:59     INFO -     rcx = 0x000000006f617070   rbx = 0x00007fff8e799020
[task 2021-05-13T23:49:59.157Z] 23:49:59     INFO -     rsi = 0x00007ffeee14ec58   rdi = 0x0000000070686162
[task 2021-05-13T23:49:59.157Z] 23:49:59     INFO -     rbp = 0x00007fff344df7f4   rsp = 0x00007ffeee14ec58
[task 2021-05-13T23:49:59.157Z] 23:49:59     INFO -      r8 = 0x00007ffeee14ec3c    r9 = 0x0000000000000004
[task 2021-05-13T23:49:59.157Z] 23:49:59     INFO -     r10 = 0x0000000000000000   r11 = 0x0000000101dc2a98
[task 2021-05-13T23:49:59.157Z] 23:49:59     INFO -     r12 = 0x0000000000000008   r13 = 0x0000000000000000
[task 2021-05-13T23:49:59.157Z] 23:49:59     INFO -     r14 = 0x00000000fffff954   r15 = 0x0000000000000001
[task 2021-05-13T23:49:59.157Z] 23:49:59     INFO -     rip = 0x00000000fffff954
[task 2021-05-13T23:49:59.157Z] 23:49:59     INFO -     Found by: given as instruction pointer in context
[task 2021-05-13T23:49:59.157Z] 23:49:59     INFO -  1  AE!aeDispatchAppleEvent(AEDesc const*, AEDesc*, unsigned int, unsigned char*) + 0x3ec
[task 2021-05-13T23:49:59.157Z] 23:49:59     INFO -     rbp = 0x00007fff344df7f4   rsp = 0x00007ffeee14ec70
[task 2021-05-13T23:49:59.157Z] 23:49:59     INFO -     rip = 0x00007fff344db06c
[task 2021-05-13T23:49:59.157Z] 23:49:59     INFO -     Found by: stack scanning
[task 2021-05-13T23:49:59.157Z] 23:49:59     INFO -  2  AE!getHighLevelEventQueue() + 0x72
[task 2021-05-13T23:49:59.157Z] 23:49:59     INFO -     rbp = 0x00007fff344df7f4   rsp = 0x00007ffeee14ece0
[task 2021-05-13T23:49:59.157Z] 23:49:59     INFO -     rip = 0x00007fff344da94c
[task 2021-05-13T23:49:59.157Z] 23:49:59     INFO -     Found by: stack scanning
[task 2021-05-13T23:49:59.158Z] 23:49:59     INFO -  3  libobjc.A.dylib!NXHashMember + 0x21
[task 2021-05-13T23:49:59.158Z] 23:49:59     INFO -     rbp = 0x00007fff344df7f4   rsp = 0x00007ffeee14ed70
[task 2021-05-13T23:49:59.158Z] 23:49:59     INFO -     rip = 0x00007fff5da12686
[task 2021-05-13T23:49:59.158Z] 23:49:59     INFO -     Found by: stack scanning
[task 2021-05-13T23:49:59.158Z] 23:49:59     INFO -  4  libobjc.A.dylib!cache_getImp + 0x90
[task 2021-05-13T23:49:59.158Z] 23:49:59     INFO -     rbp = 0x00007fff344df7f4   rsp = 0x00007ffeee14ed88
[task 2021-05-13T23:49:59.158Z] 23:49:59     INFO -     rip = 0x00007fff5da05680
[task 2021-05-13T23:49:59.158Z] 23:49:59     INFO -     Found by: stack scanning
[task 2021-05-13T23:49:59.158Z] 23:49:59     INFO -  5  AppKit!GCC_except_table7 + 0x7f5
[task 2021-05-13T23:49:59.158Z] 23:49:59     INFO -     rbp = 0x00007fff344df7f4   rsp = 0x00007ffeee14eda0
[task 2021-05-13T23:49:59.158Z] 23:49:59     INFO -     rip = 0x00007fff314bfee1
[task 2021-05-13T23:49:59.158Z] 23:49:59     INFO -     Found by: stack scanning
[task 2021-05-13T23:49:59.158Z] 23:49:59     INFO -  6  libobjc.A.dylib!isKnownClass(objc_class*) + 0x41
[task 2021-05-13T23:49:59.158Z] 23:49:59     INFO -     rbp = 0x00007fff344df7f4   rsp = 0x00007ffeee14edb0
[task 2021-05-13T23:49:59.159Z] 23:49:59     INFO -     rip = 0x00007fff5da1ca21
[task 2021-05-13T23:49:59.159Z] 23:49:59     INFO -     Found by: stack scanning
[task 2021-05-13T23:49:59.159Z] 23:49:59     INFO -  7  HIToolbox!ReleaseEvent + 0x2d
[task 2021-05-13T23:49:59.159Z] 23:49:59     INFO -     rbp = 0x00007fff344df7f4   rsp = 0x00007ffeee14ede0
[task 2021-05-13T23:49:59.159Z] 23:49:59     INFO -     rip = 0x00007fff3259e3ff
[task 2021-05-13T23:49:59.159Z] 23:49:59     INFO -     Found by: stack scanning
[task 2021-05-13T23:49:59.159Z] 23:49:59     INFO -  8  libobjc.A.dylib!cache_fill + 0x101
[task 2021-05-13T23:49:59.159Z] 23:49:59     INFO -     rbp = 0x00007fff344df7f4   rsp = 0x00007ffeee14ee10
[task 2021-05-13T23:49:59.159Z] 23:49:59     INFO -     rip = 0x00007fff5da06d49
[task 2021-05-13T23:49:59.159Z] 23:49:59     INFO -     Found by: stack scanning
[task 2021-05-13T23:49:59.159Z] 23:49:59     INFO -  9  AppKit!___DPSBlockUntilNextEventMatchingListInMode_block_invoke + 0x197
[task 2021-05-13T23:49:59.159Z] 23:49:59     INFO -     rbp = 0x00007fff344df7f4   rsp = 0x00007ffeee14ee20
[task 2021-05-13T23:49:59.160Z] 23:49:59     INFO -     rip = 0x00007fff309405db
[task 2021-05-13T23:49:59.160Z] 23:49:59     INFO -     Found by: stack scanning
[task 2021-05-13T23:49:59.160Z] 23:49:59     INFO - 10  AppKit!GCC_except_table7 + 0x7f5
[task 2021-05-13T23:49:59.160Z] 23:49:59     INFO -     rbp = 0x00007fff344df7f4   rsp = 0x00007ffeee14ee50
[task 2021-05-13T23:49:59.160Z] 23:49:59     INFO -     rip = 0x00007fff314bfee1
[task 2021-05-13T23:49:59.160Z] 23:49:59     INFO -     Found by: stack scanning

Redirecting.

Component: JavaScript Engine → Widget: Cocoa
Priority: -- → P3
Status: NEW → RESOLVED
Closed: 3 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.