Closed Bug 1663311 Opened 5 years ago Closed 5 years ago

Intermittent TEST-UNEXPECTED-CRASH | /svg/path/interfaces/SVGAnimatedPathData-removed.svg | expected OK

Categories

(Core :: SVG, defect, P5)

defect

Tracking

()

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

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


[task 2020-09-06T10:18:55.055Z] 10:18:55     INFO - TEST-START | /svg/path/interfaces/SVGAnimatedPathData-removed.svg
[task 2020-09-06T10:18:55.084Z] 10:18:55     INFO - Setting pref javascript.options.streams (true)
[task 2020-09-06T10:18:55.161Z] 10:18:55     INFO - PID 1911 | [2361, Unnamed thread 7f5ea9a5d5e0] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-09-06T10:18:55.162Z] 10:18:55     INFO - PID 1911 | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpCSQiz8/runtests_leaks_1092.log
[task 2020-09-06T10:18:55.163Z] 10:18:55     INFO - PID 1911 | [2361, Unnamed thread 7f5ea9a5d5e0] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-09-06T10:18:55.164Z] 10:18:55     INFO - PID 1911 | [2361, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp, line 246
[task 2020-09-06T10:18:55.248Z] 10:18:55     INFO - PID 1911 | [Child 2361, Main Thread] WARNING: could not set real-time limit in CubebUtils::InitLibrary: file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp, line 626
[task 2020-09-06T10:18:55.275Z] 10:18:55     INFO - PID 1854 | [2367, Unnamed thread 7f7582b5d5e0] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-09-06T10:18:55.276Z] 10:18:55     INFO - PID 1854 | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpIaVGkx/runtests_leaks_1092.log
[task 2020-09-06T10:18:55.276Z] 10:18:55     INFO - PID 1854 | [2367, Unnamed thread 7f7582b5d5e0] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-09-06T10:18:55.276Z] 10:18:55     INFO - PID 1854 | [2367, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp, line 246
[task 2020-09-06T10:18:55.383Z] 10:18:55     INFO - Closing window 38
[task 2020-09-06T10:18:55.486Z] 10:18:55     INFO - PID 1854 | [Child 2367, Main Thread] WARNING: could not set real-time limit in CubebUtils::InitLibrary: file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp, line 626
[task 2020-09-06T10:18:55.748Z] 10:18:55     INFO - PID 1854 | 1599387535744	Marionette	ERROR	[38] No reply from Marionette:Register
[task 2020-09-06T10:18:55.748Z] 10:18:55     INFO - PID 1854 | 1599387535746	Marionette	ERROR	[38] No reply from Marionette:Register
[task 2020-09-06T10:18:55.769Z] 10:18:55     INFO - PID 1911 | [Parent 1911, Main Thread] WARNING: failed to bind socket: file /builds/worker/checkouts/gecko/netwerk/base/nsServerSocket.cpp, line 366
[task 2020-09-06T10:18:55.770Z] 10:18:55     INFO - PID 1911 | 1599387535763	Marionette	FATAL	Remote protocol server failed to start: Error: Could not bind to port 49991 (NS_ERROR_SOCKET_ADDRESS_IN_USE)(chrome://marionette/content/server.js:92:17) JS Stack trace: set acceptConnections@server.js:92:17
[task 2020-09-06T10:18:55.771Z] 10:18:55     INFO - PID 1911 | start@server.js:122:5
[task 2020-09-06T10:18:55.771Z] 10:18:55     INFO - PID 1911 | init/<@marionette.js:510:21
[task 2020-09-06T10:18:55.778Z] 10:18:55     INFO - Closing window 36
[task 2020-09-06T10:18:55.829Z] 10:18:55     INFO - NoSuchWindowException on command, setting status to CRASH
[task 2020-09-06T10:18:55.838Z] 10:18:55     INFO - TEST-UNEXPECTED-CRASH | /svg/path/interfaces/SVGAnimatedPathData-removed.svg | expected OK
[task 2020-09-06T10:18:55.838Z] 10:18:55     INFO - TEST-INFO took 778ms
[task 2020-09-06T10:18:55.841Z] 10:18:55     INFO - Restarting browser for new test group
[task 2020-09-06T10:18:55.946Z] 10:18:55     INFO - PID 1854 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-09-06T10:18:55.994Z] 10:18:55     INFO - PID 1854 | 1599387535985	Marionette	INFO	Stopped listening on port 49991
[task 2020-09-06T10:18:56.034Z] 10:18:56     INFO - PID 1911 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-09-06T10:18:56.131Z] 10:18:56     INFO - PID 1911 | [2020-09-06T10:18:56Z WARN  xulstore::persist] tried to remove key that isn't in the store
[task 2020-09-06T10:18:56.132Z] 10:18:56     INFO - PID 1911 | [2020-09-06T10:18:56Z WARN  xulstore::persist] tried to remove key that isn't in the store
[task 2020-09-06T10:18:56.252Z] 10:18:56     INFO - PID 1854 | [Child 2320, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-09-06T10:18:56.252Z] 10:18:56     INFO - PID 1854 | [Parent 1854, Main Thread] WARNING: 'aOwner->IsDiscarded()', file /builds/worker/workspace/obj-build/dist/include/mozilla/dom/SyncedContextInlines.h, line 36
[task 2020-09-06T10:18:56.260Z] 10:18:56     INFO - PID 1854 | [Parent 1854, Main Thread] WARNING: 'aOwner->IsDiscarded()', file /builds/worker/workspace/obj-build/dist/include/mozilla/dom/SyncedContextInlines.h, line 36
[task 2020-09-06T10:18:56.280Z] 10:18:56     INFO - PID 1854 | [Parent 1854, Main Thread] WARNING: 'aOwner->IsDiscarded()', file /builds/worker/workspace/obj-build/dist/include/mozilla/dom/SyncedContextInlines.h, line 36
[task 2020-09-06T10:18:56.280Z] 10:18:56     INFO - PID 1854 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-09-06T10:18:56.295Z] 10:18:56     INFO - PID 1854 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-09-06T10:18:56.296Z] 10:18:56     INFO - PID 1854 | [Child 2320, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp, line 4286
[task 2020-09-06T10:18:56.303Z] 10:18:56    ERROR - Traceback (most recent call last):
[task 2020-09-06T10:18:56.303Z] 10:18:56    ERROR -   File "/builds/worker/workspace/build/tests/web-platform/tests/tools/wptrunner/wptrunner/testrunner.py", line 126, in run_test
[task 2020-09-06T10:18:56.303Z] 10:18:56    ERROR -     return self.executor.run_test(test)
[task 2020-09-06T10:18:56.304Z] 10:18:56    ERROR -   File "/builds/worker/workspace/build/tests/web-platform/tests/tools/wptrunner/wptrunner/executors/base.py", line 285, in run_test
[task 2020-09-06T10:18:56.304Z] 10:18:56    ERROR -     self.on_environment_change(test.environment)
[task 2020-09-06T10:18:56.304Z] 10:18:56    ERROR -   File "/builds/worker/workspace/build/tests/web-platform/tests/tools/wptrunner/wptrunner/executors/executormarionette.py", line 794, in on_environment_change
[task 2020-09-06T10:18:56.304Z] 10:18:56    ERROR -     self.protocol.testharness.load_runner(new_environment["protocol"])
[task 2020-09-06T10:18:56.304Z] 10:18:56    ERROR -   File "/builds/worker/workspace/build/tests/web-platform/tests/tools/wptrunner/wptrunner/executors/executormarionette.py", line 170, in load_runner
[task 2020-09-06T10:18:56.305Z] 10:18:56    ERROR -     self.runner_handle = self.marionette.current_window_handle
[task 2020-09-06T10:18:56.306Z] 10:18:56    ERROR -   File "/builds/worker/workspace/build/venv/lib/python2.7/site-packages/marionette_driver/marionette.py", line 1184, in current_window_handle
[task 2020-09-06T10:18:56.307Z] 10:18:56    ERROR -     key="value")
[task 2020-09-06T10:18:56.308Z] 10:18:56    ERROR -   File "/builds/worker/workspace/build/venv/lib/python2.7/site-packages/marionette_driver/decorators.py", line 26, in _
[task 2020-09-06T10:18:56.309Z] 10:18:56    ERROR -     return func(*args, **kwargs)
[task 2020-09-06T10:18:56.309Z] 10:18:56    ERROR -   File "/builds/worker/workspace/build/venv/lib/python2.7/site-packages/marionette_driver/marionette.py", line 602, in _send_message
[task 2020-09-06T10:18:56.310Z] 10:18:56    ERROR -     self._handle_error(err)
[task 2020-09-06T10:18:56.311Z] 10:18:56    ERROR -   File "/builds/worker/workspace/build/venv/lib/python2.7/site-packages/marionette_driver/marionette.py", line 622, in _handle_error
[task 2020-09-06T10:18:56.311Z] 10:18:56    ERROR -     raise errors.lookup(error)(message, stacktrace=stacktrace)
[task 2020-09-06T10:18:56.312Z] 10:18:56    ERROR - NoSuchWindowException: Browsing context has been discarded
[task 2020-09-06T10:18:56.313Z] 10:18:56    ERROR - stacktrace:
[task 2020-09-06T10:18:56.314Z] 10:18:56    ERROR - 	WebDriverError@chrome://marionette/content/error.js:175:5
[task 2020-09-06T10:18:56.315Z] 10:18:56    ERROR - 	NoSuchWindowError@chrome://marionette/content/error.js:409:5
[task 2020-09-06T10:18:56.316Z] 10:18:56    ERROR - 	assert.that/<@chrome://marionette/content/assert.js:476:13
[task 2020-09-06T10:18:56.316Z] 10:18:56    ERROR - 	assert.open@chrome://marionette/content/assert.js:184:4
[task 2020-09-06T10:18:56.316Z] 10:18:56    ERROR - 	assert.open@chrome://marionette/content/assert.js:176:12
[task 2020-09-06T10:18:56.316Z] 10:18:56    ERROR - 	GeckoDriver.prototype.getWindowHandle@chrome://marionette/content/driver.js:1456:10
[task 2020-09-06T10:18:56.316Z] 10:18:56    ERROR - 	despatch@chrome://marionette/content/server.js:303:40
[task 2020-09-06T10:18:56.317Z] 10:18:56    ERROR - 	execute@chrome://marionette/content/server.js:273:16
[task 2020-09-06T10:18:56.317Z] 10:18:56    ERROR - 	onPacket/<@chrome://marionette/content/server.js:246:20
[task 2020-09-06T10:18:56.317Z] 10:18:56    ERROR - 	onPacket@chrome://marionette/content/server.js:247:9
[task 2020-09-06T10:18:56.317Z] 10:18:56    ERROR - 	_onJSONObjectReady/<@chrome://marionette/content/transport.js:501:20
[task 2020-09-06T10:18:56.318Z] 10:18:56    ERROR - 
[task 2020-09-06T10:18:56.318Z] 10:18:56    ERROR - 
[task 2020-09-06T10:18:56.318Z] 10:18:56    ERROR - Error running command run_test with arguments (<wptrunner.wpttest.TestharnessTest /service-workers/cache-storage/window/cache-abort.https.html>,):
[task 2020-09-06T10:18:56.319Z] 10:18:56    ERROR - Traceback (most recent call last):
[task 2020-09-06T10:18:56.319Z] 10:18:56    ERROR -   File "/builds/worker/workspace/build/tests/web-platform/tests/tools/wptrunner/wptrunner/testrunner.py", line 109, in run
[task 2020-09-06T10:18:56.319Z] 10:18:56    ERROR -     rv = commands[command](*args)
[task 2020-09-06T10:18:56.319Z] 10:18:56    ERROR -   File "/builds/worker/workspace/build/tests/web-platform/tests/tools/wptrunner/wptrunner/testrunner.py", line 126, in run_test
[task 2020-09-06T10:18:56.319Z] 10:18:56    ERROR -     return self.executor.run_test(test)
[task 2020-09-06T10:18:56.319Z] 10:18:56    ERROR -   File "/builds/worker/workspace/build/tests/web-platform/tests/tools/wptrunner/wptrunner/executors/base.py", line 285, in run_test
[task 2020-09-06T10:18:56.319Z] 10:18:56    ERROR -     self.on_environment_change(test.environment)
[task 2020-09-06T10:18:56.319Z] 10:18:56    ERROR -   File "/builds/worker/workspace/build/tests/web-platform/tests/tools/wptrunner/wptrunner/executors/executormarionette.py", line 794, in on_environment_change
[task 2020-09-06T10:18:56.319Z] 10:18:56    ERROR -     self.protocol.testharness.load_runner(new_environment["protocol"])
[task 2020-09-06T10:18:56.319Z] 10:18:56    ERROR -   File "/builds/worker/workspace/build/tests/web-platform/tests/tools/wptrunner/wptrunner/executors/executormarionette.py", line 170, in load_runner
[task 2020-09-06T10:18:56.319Z] 10:18:56    ERROR -     self.runner_handle = self.marionette.current_window_handle
[task 2020-09-06T10:18:56.319Z] 10:18:56    ERROR -   File "/builds/worker/workspace/build/venv/lib/python2.7/site-packages/marionette_driver/marionette.py", line 1184, in current_window_handle
[task 2020-09-06T10:18:56.319Z] 10:18:56    ERROR -     key="value")
[task 2020-09-06T10:18:56.319Z] 10:18:56    ERROR -   File "/builds/worker/workspace/build/venv/lib/python2.7/site-packages/marionette_driver/decorators.py", line 26, in _
[task 2020-09-06T10:18:56.320Z] 10:18:56    ERROR -     return func(*args, **kwargs)
[task 2020-09-06T10:18:56.320Z] 10:18:56    ERROR -   File "/builds/worker/workspace/build/venv/lib/python2.7/site-packages/marionette_driver/marionette.py", line 602, in _send_message
[task 2020-09-06T10:18:56.320Z] 10:18:56    ERROR -     self._handle_error(err)
[task 2020-09-06T10:18:56.320Z] 10:18:56    ERROR -   File "/builds/worker/workspace/build/venv/lib/python2.7/site-packages/marionette_driver/marionette.py", line 622, in _handle_error
[task 2020-09-06T10:18:56.320Z] 10:18:56    ERROR -     raise errors.lookup(error)(message, stacktrace=stacktrace)
[task 2020-09-06T10:18:56.320Z] 10:18:56    ERROR - NoSuchWindowException: Browsing context has been discarded
[task 2020-09-06T10:18:56.320Z] 10:18:56    ERROR - stacktrace:
[task 2020-09-06T10:18:56.320Z] 10:18:56    ERROR - 	WebDriverError@chrome://marionette/content/error.js:175:5
[task 2020-09-06T10:18:56.320Z] 10:18:56    ERROR - 	NoSuchWindowError@chrome://marionette/content/error.js:409:5
[task 2020-09-06T10:18:56.320Z] 10:18:56    ERROR - 	assert.that/<@chrome://marionette/content/assert.js:476:13
[task 2020-09-06T10:18:56.320Z] 10:18:56    ERROR - 	assert.open@chrome://marionette/content/assert.js:184:4
[task 2020-09-06T10:18:56.320Z] 10:18:56    ERROR - 	assert.open@chrome://marionette/content/assert.js:176:12
[task 2020-09-06T10:18:56.320Z] 10:18:56    ERROR - 	GeckoDriver.prototype.getWindowHandle@chrome://marionette/content/driver.js:1456:10
[task 2020-09-06T10:18:56.320Z] 10:18:56    ERROR - 	despatch@chrome://marionette/content/server.js:303:40
[task 2020-09-06T10:18:56.320Z] 10:18:56    ERROR - 	execute@chrome://marionette/content/server.js:273:16
[task 2020-09-06T10:18:56.321Z] 10:18:56    ERROR - 	onPacket/<@chrome://marionette/content/server.js:246:20
[task 2020-09-06T10:18:56.321Z] 10:18:56    ERROR - 	onPacket@chrome://marionette/content/server.js:247:9
[task 2020-09-06T10:18:56.321Z] 10:18:56    ERROR - 	_onJSONObjectReady/<@chrome://marionette/content/transport.js:501:20
[task 2020-09-06T10:18:56.321Z] 10:18:56    ERROR - 
[task 2020-09-06T10:18:56.321Z] 10:18:56    ERROR - 
[task 2020-09-06T10:18:56.321Z] 10:18:56    ERROR - Traceback (most recent call last):
[task 2020-09-06T10:18:56.321Z] 10:18:56    ERROR -   File "/builds/worker/workspace/build/tests/web-platform/tests/tools/wptrunner/wptrunner/testrunner.py", line 391, in run
[task 2020-09-06T10:18:56.321Z] 10:18:56    ERROR -     new_state = self.wait_event()
[task 2020-09-06T10:18:56.321Z] 10:18:56    ERROR -   File "/builds/worker/workspace/build/tests/web-platform/tests/tools/wptrunner/wptrunner/testrunner.py", line 466, in wait_event
[task 2020-09-06T10:18:56.321Z] 10:18:56    ERROR -     return f(*data)
[task 2020-09-06T10:18:56.321Z] 10:18:56    ERROR -   File "/builds/worker/workspace/build/tests/web-platform/tests/tools/wptrunner/wptrunner/testrunner.py", line 730, in error
[task 2020-09-06T10:18:56.321Z] 10:18:56    ERROR -     self.restart_runner()
[task 2020-09-06T10:18:56.321Z] 10:18:56    ERROR -   File "/builds/worker/workspace/build/tests/web-platform/tests/tools/wptrunner/wptrunner/testrunner.py", line 721, in restart_runner
[task 2020-09-06T10:18:56.321Z] 10:18:56    ERROR -     assert isinstance(self.state, RunnerManagerState.restarting)
[task 2020-09-06T10:18:56.322Z] 10:18:56    ERROR - AssertionError
[task 2020-09-06T10:18:56.322Z] 10:18:56    ERROR - 
[task 2020-09-06T10:18:56.358Z] 10:18:56     INFO - Browser exited with return code -15
[task 2020-09-06T10:18:56.358Z] 10:18:56     INFO - PROCESS LEAKS /tmp/tmpIaVGkx/runtests_leaks_1092.log
[task 2020-09-06T10:18:56.358Z] 10:18:56  WARNING - Firefox didn't exit cleanly, not processing leak logs
[task 2020-09-06T10:18:56.358Z] 10:18:56     INFO - Closing logging queue
[task 2020-09-06T10:18:56.358Z] 10:18:56     INFO - queue closed
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.