Closed Bug 1761020 Opened 2 years ago Closed 2 years ago

Intermittent TV Last test finished | application crashed [@ wgpu_core::hub::Storage<T,I>::get] | After Last test finished | application terminated with exit code 1

Categories

(Core :: Graphics: WebGPU, defect)

Product:
Core
Component:
Graphics: WebGPU
Type:
defect

Tracking

()

Status:
RESOLVED DUPLICATE of bug 1761014
Tracking Flags:
Tracking Status
firefox-esr91 --- unaffected
firefox98 --- unaffected
firefox99 --- unaffected
firefox100 --- affected

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Regression)

Details

(Keywords: crash, intermittent-failure, regression)

Crash Data

Filed by: ccozmuta [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=372059949&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/LOiQLpC7Q8qUGIqZndsDBg/runs/0/artifacts/public/logs/live_backing.log
Reftest URL: https://hg.mozilla.org/mozilla-central/raw-file/tip/layout/tools/reftest/reftest-analyzer.xhtml#logurl=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/LOiQLpC7Q8qUGIqZndsDBg/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1

task 2022-03-23T13:21:51.106Z] 13:21:51     INFO - TEST-START | dom/webgpu/mochitest/test_queue_write.html
[task 2022-03-23T13:21:51.155Z] 13:21:51     INFO - GECKO(2674) | MEMORY STAT | vsize 6658MB | residentFast 111MB | heapAllocated 12MB
[task 2022-03-23T13:21:51.173Z] 13:21:51     INFO - TEST-OK | dom/webgpu/mochitest/test_queue_write.html | took 69ms
[task 2022-03-23T13:21:51.202Z] 13:21:51     INFO - TEST-START | Shutdown
[task 2022-03-23T13:21:51.202Z] 13:21:51     INFO - Passed:  22
[task 2022-03-23T13:21:51.202Z] 13:21:51     INFO - Failed:  0
[task 2022-03-23T13:21:51.203Z] 13:21:51     INFO - Todo:    0
[task 2022-03-23T13:21:51.203Z] 13:21:51     INFO - Mode:    e10s
[task 2022-03-23T13:21:51.204Z] 13:21:51     INFO - Slowest: 1274ms - /tests/dom/webgpu/mochitest/test_queue_write.html
[task 2022-03-23T13:21:51.204Z] 13:21:51     INFO - TEST-INFO | Ran 11 Loops
[task 2022-03-23T13:21:51.205Z] 13:21:51     INFO - SimpleTest FINISHED
[task 2022-03-23T13:21:51.209Z] 13:21:51     INFO - GECKO(2674) | [Child 2677, Main Thread] WARNING: DispatchEvent called on non-current inner window, dropping. Please check the window in the caller instead.: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowInner.cpp:4290
[task 2022-03-23T13:21:51.229Z] 13:21:51     INFO - GECKO(2674) | [Child 2676, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2022-03-23T13:21:51.229Z] 13:21:51     INFO - GECKO(2674) | [Child 2676, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2022-03-23T13:21:51.230Z] 13:21:51     INFO - GECKO(2674) | [Child 2676, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2022-03-23T13:21:51.234Z] 13:21:51     INFO - GECKO(2674) | [Child 2676, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2022-03-23T13:21:51.238Z] 13:21:51     INFO - GECKO(2674) | [Child 2676, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2022-03-23T13:21:51.239Z] 13:21:51     INFO - GECKO(2674) | [Child 2676, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2022-03-23T13:21:51.248Z] 13:21:51     INFO - GECKO(2674) | [Child 2676, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2022-03-23T13:21:51.317Z] 13:21:51     INFO - GECKO(2674) | 1648041711317	Marionette	TRACE	Received observer notification quit-application
[task 2022-03-23T13:21:51.318Z] 13:21:51     INFO - GECKO(2674) | 1648041711317	Marionette	INFO	Stopped listening on port 2828
[task 2022-03-23T13:21:51.318Z] 13:21:51     INFO - GECKO(2674) | 1648041711317	Marionette	DEBUG	Marionette stopped listening
[task 2022-03-23T13:21:51.359Z] 13:21:51     INFO - GECKO(2674) | [Child 2676, Main Thread] WARNING: nsAppShell::Exit() called redundantly: file /builds/worker/checkouts/gecko/widget/cocoa/nsAppShell.mm:823
[task 2022-03-23T13:21:51.362Z] 13:21:51     INFO - GECKO(2674) | [Child 2676, Main Thread] WARNING: IPC message 'PIdleScheduler::Msg_StartedGC' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:506
[task 2022-03-23T13:21:51.363Z] 13:21:51     INFO - GECKO(2674) | [Parent 2674, Compositor] WARNING: Possibly dropping task posted to updater thread: file /builds/worker/checkouts/gecko/gfx/layers/apz/src/APZUpdater.cpp:365
[task 2022-03-23T13:21:51.366Z] 13:21:51     INFO - GECKO(2674) | [Parent 2674, Socket Thread] WARNING: cannot post event if not initialized: file /builds/worker/checkouts/gecko/netwerk/protocol/http/nsHttpConnectionMgr.cpp:198
[task 2022-03-23T13:21:51.367Z] 13:21:51     INFO - GECKO(2674) | [Parent 2674, Socket Thread] WARNING: cannot post event if not initialized: file /builds/worker/checkouts/gecko/netwerk/protocol/http/nsHttpConnectionMgr.cpp:198
[task 2022-03-23T13:21:51.368Z] 13:21:51     INFO - GECKO(2674) | [Parent 2674, Socket Thread] WARNING: cannot post event if not initialized: file /builds/worker/checkouts/gecko/netwerk/protocol/http/nsHttpConnectionMgr.cpp:198
[task 2022-03-23T13:21:51.369Z] 13:21:51     INFO - GECKO(2674) | [Child 2677, Main Thread] WARNING: nsAppShell::Exit() called redundantly: file /builds/worker/checkouts/gecko/widget/cocoa/nsAppShell.mm:823
[task 2022-03-23T13:21:51.371Z] 13:21:51     INFO - GECKO(2674) | [Child 2679, Main Thread] WARNING: nsAppShell::Exit() called redundantly: file /builds/worker/checkouts/gecko/widget/cocoa/nsAppShell.mm:823
[task 2022-03-23T13:21:51.371Z] 13:21:51     INFO - GECKO(2674) | Hit MOZ_CRASH(Device[0] does not exist) at /builds/worker/checkouts/gecko/third_party/rust/wgpu-core/src/hub.rs:116
[task 2022-03-23T13:21:51.372Z] 13:21:51     INFO - GECKO(2674) | [Child 2677, Main Thread] WARNING: IPC message 'PIdleScheduler::Msg_StartedGC' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:506
[task 2022-03-23T13:21:51.375Z] 13:21:51     INFO -  Initializing stack-fixing for the first stack frame, this may take a while...
<...>
[task 2022-03-23T13:22:00.725Z] 13:22:00     INFO - GECKO(2674) | [Child 2679, Main Thread] WARNING: IPC message 'PIdleScheduler::Msg_DoneGC' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:506
[task 2022-03-23T13:22:00.726Z] 13:22:00     INFO - GECKO(2674) | [Child 2679, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3359
[task 2022-03-23T13:22:00.726Z] 13:22:00     INFO - GECKO(2674) | [Child 2679, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file /builds/worker/workspace/obj-build/dist/include/mozilla/Preferences.h:128
[task 2022-03-23T13:22:00.726Z] 13:22:00     INFO - GECKO(2674) | [Child 2679, Main Thread] WARNING: IPC message 'PIdleScheduler::Msg_StartedGC' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:506
[task 2022-03-23T13:22:00.727Z] 13:22:00     INFO - GECKO(2674) | [Child 2679, Main Thread] WARNING: IPC message 'PIdleScheduler::Msg_DoneGC' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:506
[task 2022-03-23T13:22:00.727Z] 13:22:00     INFO - GECKO(2674) | [Child 2679, Main Thread] WARNING: IPC message 'PIdleScheduler::Msg_StartedGC' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:506
[task 2022-03-23T13:22:00.728Z] 13:22:00     INFO - GECKO(2674) | [Child 2679, Main Thread] WARNING: IPC message 'PIdleScheduler::Msg_DoneGC' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:506
[task 2022-03-23T13:22:00.728Z] 13:22:00     INFO - GECKO(2674) | [Child 2679, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4465
[task 2022-03-23T13:22:00.728Z] 13:22:00     INFO - TEST-INFO | Main app process: exit 1
[task 2022-03-23T13:22:00.729Z] 13:22:00     INFO - Buffered messages finished
[task 2022-03-23T13:22:00.729Z] 13:22:00    ERROR - TEST-UNEXPECTED-FAIL | Last test finished | application terminated with exit code 1
[task 2022-03-23T13:22:00.729Z] 13:22:00     INFO - runtests.py | Application ran for: 0:00:16.217871
[task 2022-03-23T13:22:00.730Z] 13:22:00     INFO - zombiecheck | Reading PID log: /var/folders/dv/hnm8h5w55bv3mzsfk0_zk888000014/T/tmp4r_dx086pidlog
[task 2022-03-23T13:22:00.730Z] 13:22:00     INFO - ==> process 2674 launched child process 2676
[task 2022-03-23T13:22:00.730Z] 13:22:00     INFO - ==> process 2674 launched child process 2677
[task 2022-03-23T13:22:00.731Z] 13:22:00     INFO - ==> process 2674 launched child process 2678
[task 2022-03-23T13:22:00.731Z] 13:22:00     INFO - ==> process 2674 launched child process 2679
[task 2022-03-23T13:22:00.731Z] 13:22:00     INFO - ==> process 2674 launched child process 2680
[task 2022-03-23T13:22:00.732Z] 13:22:00     INFO - ==> process 2674 launched child process 2681
[task 2022-03-23T13:22:00.732Z] 13:22:00     INFO - ==> process 2674 launched child process 2682
[task 2022-03-23T13:22:00.732Z] 13:22:00     INFO - zombiecheck | Checking for orphan process with PID: 2676
[task 2022-03-23T13:22:00.732Z] 13:22:00     INFO - zombiecheck | Checking for orphan process with PID: 2677
[task 2022-03-23T13:22:00.733Z] 13:22:00     INFO - zombiecheck | Checking for orphan process with PID: 2678
[task 2022-03-23T13:22:00.733Z] 13:22:00     INFO - zombiecheck | Checking for orphan process with PID: 2679
[task 2022-03-23T13:22:00.734Z] 13:22:00     INFO - zombiecheck | Checking for orphan process with PID: 2680
[task 2022-03-23T13:22:00.734Z] 13:22:00     INFO - zombiecheck | Checking for orphan process with PID: 2681
[task 2022-03-23T13:22:00.734Z] 13:22:00     INFO - zombiecheck | Checking for orphan process with PID: 2682
[task 2022-03-23T13:22:00.735Z] 13:22:00     INFO - mozcrash Copy/paste: /opt/worker/tasks/task_164804028811417/fetches/minidump-stackwalk/minidump-stackwalk --symbols-url=https://symbols.mozilla.org/ --human /var/folders/dv/hnm8h5w55bv3mzsfk0_zk888000014/T/tmpetc0r679.mozrunner/minidumps/BE7513A7-BA22-46BF-90D7-01145F8F40D4.dmp /opt/worker/tasks/task_164804028811417/build/symbols
[task 2022-03-23T13:22:03.834Z] 13:22:03     INFO - mozcrash Saved minidump as /opt/worker/tasks/task_164804028811417/build/blobber_upload_dir/BE7513A7-BA22-46BF-90D7-01145F8F40D4.dmp
[task 2022-03-23T13:22:03.835Z] 13:22:03     INFO - mozcrash Saved app info as /opt/worker/tasks/task_164804028811417/build/blobber_upload_dir/BE7513A7-BA22-46BF-90D7-01145F8F40D4.extra
[task 2022-03-23T13:22:04.314Z] 13:22:04     INFO - PROCESS-CRASH | Last test finished | application crashed [@ wgpu_core::hub::Storage<T,I>::get]
[task 2022-03-23T13:22:04.314Z] 13:22:04     INFO - Mozilla crash reason: Device[0] does not exist
[task 2022-03-23T13:22:04.314Z] 13:22:04     INFO - Crash dump filename: /var/folders/dv/hnm8h5w55bv3mzsfk0_zk888000014/T/tmpetc0r679.mozrunner/minidumps/BE7513A7-BA22-46BF-90D7-01145F8F40D4.dmp
[task 2022-03-23T13:22:04.314Z] 13:22:04     INFO - Operating system: Mac OS X
[task 2022-03-23T13:22:04.314Z] 13:22:04     INFO -                   10.15.7 19H524
task 2022-03-23T13:22:04.314Z] 13:22:04     INFO - CPU: amd64
[task 2022-03-23T13:22:04.314Z] 13:22:04     INFO -      family 6 model 158 stepping 10
[task 2022-03-23T13:22:04.314Z] 13:22:04     INFO -      12 CPUs
[task 2022-03-23T13:22:04.314Z] 13:22:04     INFO - 
[task 2022-03-23T13:22:04.315Z] 13:22:04     INFO - Crash reason:  EXC_BAD_ACCESS / KERN_INVALID_ADDRESS
[task 2022-03-23T13:22:04.315Z] 13:22:04     INFO - Crash address: 0x0
[task 2022-03-23T13:22:04.315Z] 13:22:04     INFO - Mac Crash Info:
[task 2022-03-23T13:22:04.315Z] 13:22:04     INFO - 
[task 2022-03-23T13:22:04.315Z] 13:22:04     INFO - Process uptime: 7 seconds
[task 2022-03-23T13:22:04.315Z] 13:22:04     INFO - 
[task 2022-03-23T13:22:04.315Z] 13:22:04     INFO - Thread 45 Compositor (crashed)
[task 2022-03-23T13:22:04.315Z] 13:22:04     INFO -  0  XUL!RustMozCrash [wrappers.cpp:23d4033b2dce4009aac611d2246daab6fcd7bef2 : 18 + 0x15]
[task 2022-03-23T13:22:04.315Z] 13:22:04     INFO -     rax = 0x000000010dc4e3e8   rdx = 0x0000000000000000
[task 2022-03-23T13:22:04.315Z] 13:22:04     INFO -     rcx = 0x0000700011f1b0ac   rbx = 0x0000700011f1848a
[task 2022-03-23T13:22:04.315Z] 13:22:04     INFO -     rsi = 0x00000000000120a8   rdi = 0x00007fff9a031ca8
[task 2022-03-23T13:22:04.315Z] 13:22:04     INFO -     rbp = 0x0000700011f18270   rsp = 0x0000700011f18260
[task 2022-03-23T13:22:04.315Z] 13:22:04     INFO -      r8 = 0x00000000000130a8    r9 = 0x0000000000000000
[task 2022-03-23T13:22:04.315Z] 13:22:04     INFO -     r10 = 0x00007fff9a031cc8   r11 = 0x00007fff9a031cc0
[task 2022-03-23T13:22:04.315Z] 13:22:04     INFO -     r12 = 0x0000000000000074   r13 = 0x0000000000000044
[task 2022-03-23T13:22:04.315Z] 13:22:04     INFO -     r14 = 0x0000000000000074   r15 = 0x000000012b4fd1c0
[task 2022-03-23T13:22:04.315Z] 13:22:04     INFO -     rip = 0x000000011b68f755
[task 2022-03-23T13:22:04.315Z] 13:22:04     INFO -     Found by: given as instruction pointer in context
[task 2022-03-23T13:22:04.315Z] 13:22:04     INFO -  1  XUL!mozglue_static::panic_hook [lib.rs:23d4033b2dce4009aac611d2246daab6fcd7bef2 : 91 + 0x7]
[task 2022-03-23T13:22:04.315Z] 13:22:04     INFO -     rbx = 0x000000011e51ae60   rbp = 0x0000700011f186c0
[task 2022-03-23T13:22:04.315Z] 13:22:04     INFO -     rsp = 0x0000700011f18280   r12 = 0x0000000000000074
[task 2022-03-23T13:22:04.315Z] 13:22:04     INFO -     r13 = 0x0000000000000044   r14 = 0x000000011d40f94c
[task 2022-03-23T13:22:04.315Z] 13:22:04     INFO -     r15 = 0x000000012b4fd1c0   rip = 0x000000011b68f393
[task 2022-03-23T13:22:04.315Z] 13:22:04     INFO -     Found by: call frame info

:aosmond, since you are the author of the regressor, bug 1760810, could you take a look?
For more information, please visit auto_nag documentation.

Flags: needinfo?(aosmond)

Set release status flags based on info from the regressing bug 1760810

status-firefox100: --- → affected
status-firefox98: --- → unaffected
status-firefox99: --- → unaffected
status-firefox-esr91: --- → unaffected
Status: NEW → RESOLVED
Closed: 2 years ago
Flags: needinfo?(aosmond)
Resolution: --- → DUPLICATE
Has Regression Range: --- → yes
You need to log in before you can comment on or make changes to this bug.