1835448 - Intermittent application crashed [None] | /webdriver/tests/classic/get_window_handles/get.py

Status: RESOLVED DUPLICATE of bug 1827125

(Remote Protocol :: Marionette, defect, P5)

Description

[Treeherder Bug Filer]

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

---

INFO - STDOUT: PASSED
[task 2023-05-27T00:24:51.496Z] 00:24:51     INFO - PID 5448 | 1685147091491	webdriver::server	DEBUG	-> POST /session/c7afcb25-e862-452c-9f11-c2467bad3c25/timeouts {"implicit": 0}
[task 2023-05-27T00:24:51.496Z] 00:24:51     INFO - PID 5448 | 1685147091492	Marionette	DEBUG	0 -> [0,95,"WebDriver:SetTimeouts",{"implicit":0}]
[task 2023-05-27T00:24:51.497Z] 00:24:51     INFO - PID 5448 | 1685147091492	Marionette	DEBUG	0 <- [1,95,null,{"value":null}]
<...>
INFO - PID 5448 | 1685147091622	webdriver::server	DEBUG	<- 200 OK {"value":{"x":100,"y":100,"width":800,"height":600}}
[task 2023-05-27T00:24:51.629Z] 00:24:51     INFO - PID 5448 | 1685147091623	webdriver::server	DEBUG	-> POST /session/c7afcb25-e862-452c-9f11-c2467bad3c25/frame {"id": null}
[task 2023-05-27T00:24:51.629Z] 00:24:51     INFO - PID 5448 | 1685147091623	Marionette	DEBUG	0 -> [0,113,"WebDriver:SwitchToFrame",{"id":null}]
[task 2023-05-27T00:24:51.632Z] 00:24:51     INFO - PID 5448 | 1685147091631	Marionette	DEBUG	0 <- [1,113,null,{"value":null}]
[task 2023-05-27T00:24:51.633Z] 00:24:51     INFO - PID 5448 | 1685147091631	webdriver::server	DEBUG	<- 200 OK {"value":null}
[task 2023-05-27T00:24:51.635Z] 00:24:51     INFO - PID 5448 | 1685147091634	webdriver::server	DEBUG	-> DELETE /session/c7afcb25-e862-452c-9f11-c2467bad3c25
[task 2023-05-27T00:24:51.636Z] 00:24:51     INFO - PID 5448 | 1685147091635	Marionette	DEBUG	0 -> [0,114,"Marionette:Quit",{"flags":["eForceQuit"]}]
[task 2023-05-27T00:24:51.637Z] 00:24:51     INFO - PID 5448 | 1685147091635	Marionette	INFO	Stopped listening on port 60571
[task 2023-05-27T00:24:51.641Z] 00:24:51     INFO - PID 5448 | 1685147091640	Marionette	TRACE	[3] MarionetteCommands actor destroyed for window id 4294967297
[task 2023-05-27T00:24:59.222Z] 00:24:59     INFO - PID 5448 | out of memory: 0x0000000000000000 bytes requested
[task 2023-05-27T00:24:59.228Z] 00:24:59     INFO - PID 5448 | out of memory: 0x0000000000000000 bytes requested
[task 2023-05-27T00:24:59.233Z] 00:24:59     INFO - PID 5448 | [Parent 2712, IPC I/O Parent] WARNING: Failed to launch tab subprocess: file Z:/task_168514020600467/build/src/ipc/glue/GeckoChildProcessHost.cpp:802
[task 2023-05-27T00:24:59.316Z] 00:24:59     INFO - PID 5448 | 1685147099317	Marionette	TRACE	Received observer notification quit-application
[task 2023-05-27T00:24:59.319Z] 00:24:59     INFO - PID 5448 | 1685147099319	Marionette	TRACE	Received observer notification quit-application
[task 2023-05-27T00:24:59.319Z] 00:24:59     INFO - PID 5448 | 1685147099321	Marionette	DEBUG	Marionette stopped listening
[task 2023-05-27T00:24:59.325Z] 00:24:59     INFO - PID 5448 | 1685147099324	Marionette	DEBUG	0 <- [1,114,null,{"cause":"shutdown","forced":false,"in_app":true}]
[task 2023-05-27T00:24:59.327Z] 00:24:59     INFO - PID 5448 | A content process crashed and MOZ_CRASHREPORTER_SHUTDOWN is set, shutting down
[task 2023-05-27T00:24:59.348Z] 00:24:59     INFO - PID 5448 | A content process crashed and MOZ_CRASHREPORTER_SHUTDOWN is set, shutting down
[task 2023-05-27T00:24:59.348Z] 00:24:59     INFO - PID 5448 | 1685147099355	webdriver::server	DEBUG	Teardown session
[task 2023-05-27T00:24:59.361Z] 00:24:59     INFO - PID 5448 | 1685147099361	Marionette	DEBUG	Closed connection 0
[task 2023-05-27T00:25:09.640Z] 00:25:09     INFO - PID 5448 | [Parent 2712, IPC I/O Parent] WARNING: ConnectNamedPipe timed out!: file Z:/task_168514020600467/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc:327
[task 2023-05-27T00:25:09.649Z] 00:25:09     INFO - PID 5448 | [Parent 2712, IPC I/O Parent] WARNING: ConnectNamedPipe timed out!: file Z:/task_168514020600467/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc:327
[task 2023-05-27T00:25:09.651Z] 00:25:09     INFO - PID 5448 | [Parent 2712, IPC I/O Parent] WARNING: ConnectNamedPipe timed out!: file Z:/task_168514020600467/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc:327
[task 2023-05-27T00:25:09.651Z] 00:25:09     INFO - PID 5448 | [Parent 2712, IPC I/O Parent] WARNING: ConnectNamedPipe timed out!: file Z:/task_168514020600467/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc:327
[task 2023-05-27T00:25:09.652Z] 00:25:09     INFO - PID 5448 | A content process crashed and MOZ_CRASHREPORTER_SHUTDOWN is set, shutting down
[task 2023-05-27T00:25:09.653Z] 00:25:09     INFO - PID 5448 | A content process crashed and MOZ_CRASHREPORTER_SHUTDOWN is set, shutting down
[task 2023-05-27T00:25:09.654Z] 00:25:09     INFO - PID 5448 | A content process crashed and MOZ_CRASHREPORTER_SHUTDOWN is set, shutting down
[task 2023-05-27T00:25:18.416Z] 00:25:18     INFO - PID 5448 | [Parent 2712, IPC I/O Parent] WARNING: Process 10076 may be hanging at shutdown; will wait for up to 80000ms: file Z:/task_168514020600467/build/src/ipc/chromium/src/chrome/common/process_watcher_win.cc:129
[task 2023-05-27T00:25:43.218Z] 00:25:43     INFO - mozcrash Downloading symbols from: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/e5gS-cG-SfOogvSiGZcUrQ/artifacts/public/build/target.crashreporter-symbols.zip
[task 2023-05-27T00:25:53.538Z] 00:25:53     INFO - mozcrash Copy/paste: Z:\task_168514530562503\fetches\minidump-stackwalk\minidump-stackwalk.exe --symbols-url=https://symbols.mozilla.org/ --cyborg=C:\Users\task_168514530562503\AppData\Local\Temp\tmpqnzvl2li\66dd8ac6-8832-4c7e-b577-928be729adf4.trace C:\Users\task_168514530562503\AppData\Local\Temp\tmpse2erl2n.mozrunner\minidumps\66dd8ac6-8832-4c7e-b577-928be729adf4.dmp C:\Users\task_168514530562503\AppData\Local\Temp\tmpekfubf1e
[task 2023-05-27T00:25:55.830Z] 00:25:55     INFO - mozcrash Saved minidump as Z:\task_168514530562503\build\blobber_upload_dir\66dd8ac6-8832-4c7e-b577-928be729adf4.dmp
[task 2023-05-27T00:25:55.830Z] 00:25:55     INFO - PROCESS-CRASH | application crashed [None] | /webdriver/tests/classic/get_window_handles/get.py 
[task 2023-05-27T00:25:55.830Z] 00:25:55     INFO - Crash dump filename: C:\Users\task_168514530562503\AppData\Local\Temp\tmpse2erl2n.mozrunner\minidumps\66dd8ac6-8832-4c7e-b577-928be729adf4.dmp
[task 2023-05-27T00:25:55.840Z] 00:25:55     INFO - stderr from minidump-stackwalk:
[task 2023-05-27T00:25:55.840Z] 00:25:55     INFO - ERROR MissingHeader - Error reading dump: Missing minidump header (empty minidump?)
INFO - mozcrash Copy/paste: Z:\task_168514530562503\fetches\minidump-stackwalk\minidump-stackwalk.exe --symbols-url=https://symbols.mozilla.org/ --cyborg=C:\Users\task_168514530562503\AppData\Local\Temp\tmpc3rc6m2l\10649176-ed31-49d6-98a7-f1fefa69d093.trace C:\Users\task_168514530562503\AppData\Local\Temp\tmpse2erl2n.mozrunner\minidumps\10649176-ed31-49d6-98a7-f1fefa69d093.dmp C:\Users\task_168514530562503\AppData\Local\Temp\tmpekfubf1e
[task 2023-05-27T00:25:57.218Z] 00:25:57     INFO - mozcrash Saved minidump as Z:\task_168514530562503\build\blobber_upload_dir\10649176-ed31-49d6-98a7-f1fefa69d093.dmp
[task 2023-05-27T00:25:57.221Z] 00:25:57     INFO - PROCESS-CRASH | application crashed [None] | /webdriver/tests/classic/get_window_handles/get.py 
[task 2023-05-27T00:25:57.221Z] 00:25:57     INFO - Crash dump filename: C:\Users\task_168514530562503\AppData\Local\Temp\tmpse2erl2n.mozrunner\minidumps\10649176-ed31-49d6-98a7-f1fefa69d093.dmp
[task 2023-05-27T00:25:57.221Z] 00:25:57     INFO - stderr from minidump-stackwalk:
[task 2023-05-27T00:25:57.221Z] 00:25:57     INFO - ERROR MissingHeader - Error reading dump: Missing minidump header (empty minidump?)
[task 2023-05-27T00:26:03.239Z] 00:26:03     INFO - Found a crash dump file; changing status to CRASH
[task 2023-05-27T00:26:03.246Z] 00:26:03     INFO - TEST-UNEXPECTED-CRASH | /webdriver/tests/classic/get_window_handles/get.py | expected OK
[task 2023-05-27T00:26:03.246Z] 00:26:03     INFO - TEST-INFO took 75032ms
[task 2023-05-27T00:26:03.318Z] 00:26:03     INFO - Closing logging queue
[task 2023-05-27T00:26:03.332Z] 00:26:03     INFO - queue closed
[task 2023-05-27T00:26:03.912Z] 00:26:03     INFO - PID 3036 | 1685147163351	geckodriver	INFO	Listening on 127.0.0.1:65077
[task 2023-05-27T00:26:03.915Z] 00:26:03     INFO - Starting runner
[task 2023-05-27T00:26:04.648Z] 00:26:04     INFO - TEST-START | /webdriver/tests/classic/get_window_handles/user_prompts.py

Comment 1

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 1

Platform and build breakdown:

• windows11-64-2009-ccov-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1835448&startday=2023-05-22&endday=2023-05-28&tree=all

Comment 2

[Henrik Skupin [:whimboo][⌚️UTC+2]]

There is no minidump due to bug 1827125 and overall it looks like an OOM crash.