Closed Bug 1415164 Opened 7 years ago Closed 6 years ago

Intermittent test_modal_dialogs.py TestTabModalAlerts.test_onbeforeunload_accept | TimeoutException: Timeout loading page after 300000ms

Categories

(Testing :: Marionette Client and Harness, defect, P5)

Version 3
defect

Tracking

(Not tracked)

RESOLVED WORKSFORME

People

(Reporter: intermittent-bug-filer, Unassigned)

References

Details

(Keywords: intermittent-failure)

Filed by: archaeopteryx [at] coole-files.de

https://treeherder.mozilla.org/logviewer.html#?job_id=142690771&repo=mozilla-inbound

https://queue.taskcluster.net/v1/task/NH2POgN1TCaSiGwxG1Dykw/runs/0/artifacts/public/logs/live_backing.log

[task 2017-11-07T13:02:45.427Z] 13:02:45     INFO -  1510059765419	Marionette	TRACE	20 <- [1,18,{"error":"timeout","message":"Timeout loading page after 300000ms","stacktrace":"WebDriverError@chrome://marionette/content/error.js:172:5\nTimeoutError@chrome://marionette/content/error.js:442:5\nnotify@chro ... r.js:408:13\nasync*navigate@chrome://marionette/content/listener.js:407:13\nget@chrome://marionette/content/listener.js:1150:5\n"},null]
[task 2017-11-07T13:02:45.429Z] 13:02:45     INFO -  1510059765425	Marionette	TRACE	20 -> [0,19,"getContext",{}]
[task 2017-11-07T13:02:45.434Z] 13:02:45     INFO -  1510059765430	Marionette	TRACE	20 <- [1,19,null,{"value":"content"}]
[task 2017-11-07T13:02:45.442Z] 13:02:45     INFO -  1510059765437	Marionette	TRACE	20 -> [0,20,"setContext",{"value":"chrome"}]
[task 2017-11-07T13:02:45.444Z] 13:02:45     INFO -  1510059765439	Marionette	TRACE	20 <- [1,20,null,{}]
[task 2017-11-07T13:02:45.449Z] 13:02:45     INFO -  1510059765446	Marionette	TRACE	20 -> [0,21,"takeScreenshot",{"highlights":null,"full":true,"hash":false,"id":null,"scroll":true}]
[task 2017-11-07T13:02:45.465Z] 13:02:45     INFO -  [Parent 4493, Main Thread] WARNING: Remote iframe not rendered: file /builds/worker/workspace/build/src/layout/ipc/RenderFrameParent.cpp, line 183
[task 2017-11-07T13:02:45.543Z] 13:02:45     INFO -  1510059765533	Marionette	TRACE	20 <- [1,21,null,{"value":"iVBORw0KGgoAAAANSUhEUgAABQAAAAQQCAYAAAC9RfbYAAAgAElEQVR4nOzdb6ht530f+P2y0Pd93TcNuDSQ0pIJJJCUwhSCoZ28SNpQDOOgGwpF8pAXTgqNiwU+d ... 2vD+WZLFYLBaLxWKxWCwWi8VisVjXsm49ZlHsMYvic9xiZOsjYy+MrY9sMfa52z73GNd2vMtisVgsFovFYrFYLBaLxWKxrmH9DXEWWeZ3vRtnAAAAAElFTkSuQmCC"}]
[task 2017-11-07T13:02:45.583Z] 13:02:45     INFO -  1510059765578	Marionette	TRACE	20 -> [0,22,"setContext",{"value":"content"}]
[task 2017-11-07T13:02:45.585Z] 13:02:45     INFO -  1510059765581	Marionette	TRACE	20 <- [1,22,null,{}]
[task 2017-11-07T13:02:45.593Z] 13:02:45     INFO -  1510059765586	Marionette	TRACE	20 -> [0,23,"getContext",{}]
[task 2017-11-07T13:02:45.595Z] 13:02:45     INFO -  1510059765590	Marionette	TRACE	20 <- [1,23,null,{"value":"content"}]
[task 2017-11-07T13:02:45.603Z] 13:02:45     INFO -  1510059765598	Marionette	TRACE	20 -> [0,24,"setContext",{"value":"content"}]
[task 2017-11-07T13:02:45.605Z] 13:02:45     INFO -  1510059765600	Marionette	TRACE	20 <- [1,24,null,{}]
[task 2017-11-07T13:02:45.606Z] 13:02:45     INFO -  1510059765603	Marionette	TRACE	20 -> [0,25,"getPageSource",{}]
[task 2017-11-07T13:02:45.615Z] 13:02:45     INFO -  1510059765609	Marionette	TRACE	20 <- [1,25,{"error":"unexpected alert open","message":"","stacktrace":"WebDriverError@chrome://marionette/content/error.js:172:5\nUnexpectedAlertOpenError@chrome://marionette/content/error.js:456:5 ... ync*onPacket@chrome://marionette/content/server.js:508:8\n_onJSONObjectReady/<@chrome://marionette/content/transport.js:500:9\n"},null]
[task 2017-11-07T13:02:45.616Z] 13:02:45     INFO -  1510059765612	Marionette	TRACE	20 -> [0,26,"setContext",{"value":"content"}]
[task 2017-11-07T13:02:45.618Z] 13:02:45     INFO -  1510059765615	Marionette	TRACE	20 <- [1,26,null,{}]
[task 2017-11-07T13:02:45.627Z] 13:02:45  WARNING - Failed to gather test failure debug: 
[task 2017-11-07T13:02:45.628Z] 13:02:45  WARNING - stacktrace:
[task 2017-11-07T13:02:45.629Z] 13:02:45  WARNING - 	WebDriverError@chrome://marionette/content/error.js:172:5
[task 2017-11-07T13:02:45.630Z] 13:02:45  WARNING - 	UnexpectedAlertOpenError@chrome://marionette/content/error.js:456:5
[task 2017-11-07T13:02:45.632Z] 13:02:45  WARNING - 	assert.that/<@chrome://marionette/content/assert.js:385:13
[task 2017-11-07T13:02:45.633Z] 13:02:45  WARNING - 	assert.noUserPrompt@chrome://marionette/content/assert.js:158:3
[task 2017-11-07T13:02:45.635Z] 13:02:45  WARNING - 	GeckoDriver.prototype.getPageSource@chrome://marionette/content/driver.js:1187:3
[task 2017-11-07T13:02:45.636Z] 13:02:45  WARNING - 	Async*despatch@chrome://marionette/content/server.js:560:20
[task 2017-11-07T13:02:45.638Z] 13:02:45  WARNING - 	async*execute@chrome://marionette/content/server.js:534:11
[task 2017-11-07T13:02:45.641Z] 13:02:45  WARNING - 	async*onPacket/<@chrome://marionette/content/server.js:509:15
[task 2017-11-07T13:02:45.642Z] 13:02:45  WARNING - 	async*onPacket@chrome://marionette/content/server.js:508:8
[task 2017-11-07T13:02:45.644Z] 13:02:45  WARNING - 	_onJSONObjectReady/<@chrome://marionette/content/transport.js:500:9
[task 2017-11-07T13:02:45.645Z] 13:02:45  WARNING - 
[task 2017-11-07T13:02:45.667Z] 13:02:45     INFO - TEST-UNEXPECTED-ERROR | test_modal_dialogs.py TestTabModalAlerts.test_onbeforeunload_accept | TimeoutException: Timeout loading page after 300000ms
[task 2017-11-07T13:02:45.668Z] 13:02:45     INFO - stacktrace:
[task 2017-11-07T13:02:45.668Z] 13:02:45     INFO - 	WebDriverError@chrome://marionette/content/error.js:172:5
[task 2017-11-07T13:02:45.670Z] 13:02:45     INFO - 	TimeoutError@chrome://marionette/content/error.js:442:5
[task 2017-11-07T13:02:45.671Z] 13:02:45     INFO - 	notify@chrome://marionette/content/listener.js:334:13
[task 2017-11-07T13:02:45.672Z] 13:02:45     INFO - 	openRemotePrompt@jar:file:///builds/worker/workspace/build/application/firefox/omni.ja!/components/nsPrompter.js:512:5
[task 2017-11-07T13:02:45.673Z] 13:02:45     INFO - 	openPrompt@jar:file:///builds/worker/workspace/build/application/firefox/omni.ja!/components/nsPrompter.js:546:17
[task 2017-11-07T13:02:45.674Z] 13:02:45     INFO - 	confirmEx@jar:file:///builds/worker/workspace/build/application/firefox/omni.ja!/components/nsPrompter.js:711:9
[task 2017-11-07T13:02:45.675Z] 13:02:45     INFO - 	get/<@chrome://marionette/content/listener.js:1151:7
[task 2017-11-07T13:02:45.676Z] 13:02:45     INFO - 	navigate/<@chrome://marionette/content/listener.js:408:13
[task 2017-11-07T13:02:45.678Z] 13:02:45     INFO - 	async*navigate@chrome://marionette/content/listener.js:407:13
[task 2017-11-07T13:02:45.679Z] 13:02:45     INFO - 	get@chrome://marionette/content/listener.js:1150:5
[task 2017-11-07T13:02:45.680Z] 13:02:45     INFO - Traceback (most recent call last):
[task 2017-11-07T13:02:45.683Z] 13:02:45     INFO -   File "/builds/worker/workspace/build/venv/lib/python2.7/site-packages/marionette_harness/marionette_test/testcases.py", line 156, in run
[task 2017-11-07T13:02:45.684Z] 13:02:45     INFO -     testMethod()
[task 2017-11-07T13:02:45.685Z] 13:02:45     INFO -   File "/builds/worker/workspace/build/tests/marionette/tests/testing/marionette/harness/marionette_harness/tests/unit/test_modal_dialogs.py", line 194, in test_onbeforeunload_accept
[task 2017-11-07T13:02:45.685Z] 13:02:45     INFO -     self.marionette.navigate("about:blank")
[task 2017-11-07T13:02:45.686Z] 13:02:45     INFO -   File "/builds/worker/workspace/build/venv/lib/python2.7/site-packages/marionette_driver/marionette.py", line 1651, in navigate
[task 2017-11-07T13:02:45.687Z] 13:02:45     INFO -     self._send_message("get", {"url": url})
[task 2017-11-07T13:02:45.688Z] 13:02:45     INFO -   File "/builds/worker/workspace/build/venv/lib/python2.7/site-packages/marionette_driver/decorators.py", line 23, in _
[task 2017-11-07T13:02:45.689Z] 13:02:45     INFO -     return func(*args, **kwargs)
[task 2017-11-07T13:02:45.690Z] 13:02:45     INFO -   File "/builds/worker/workspace/build/venv/lib/python2.7/site-packages/marionette_driver/marionette.py", line 759, in _send_message
[task 2017-11-07T13:02:45.691Z] 13:02:45     INFO -     self._handle_error(err)
[task 2017-11-07T13:02:45.692Z] 13:02:45     INFO -   File "/builds/worker/workspace/build/venv/lib/python2.7/site-packages/marionette_driver/marionette.py", line 783, in _handle_error
[task 2017-11-07T13:02:45.693Z] 13:02:45     INFO -     raise errors.lookup(error)(message, stacktrace=stacktrace)
Most likely caused by the changes on bug 1411393. Lets see how often this really happens.
Blocks: 1411393
Not been seen in a while so closing
Status: NEW → RESOLVED
Closed: 6 years ago
Resolution: --- → WORKSFORME
Product: Testing → Remote Protocol
Moving bug to Testing::Marionette Client and Harness component per bug 1815831.
Component: Marionette → Marionette Client and Harness
Product: Remote Protocol → Testing
You need to log in before you can comment on or make changes to this bug.