Closed
Bug 1743284
Opened 3 years ago
Closed 3 years ago
Intermittent testing/firefox-ui/tests/functional/sessionstore/test_restore_windows_after_restart_and_quit.py TestSessionStoreDisabled.test_no_restore_with_quit | OSError: Process killed because the connection to Marionette server is lost. Check gecko.log
Categories
(Testing :: Firefox UI Tests, defect, P5)
Testing
Firefox UI Tests
Tracking
(Not tracked)
RESOLVED
INCOMPLETE
People
(Reporter: intermittent-bug-filer, Unassigned)
References
Details
(Keywords: intermittent-failure)
Filed by: nbeleuzu [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=359462404&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/IC-Avp-QT0C47ScRhIxbHQ/runs/0/artifacts/public/logs/live_backing.log
[task 2021-11-28T07:48:44.608Z] 07:48:44 INFO - TEST-START | testing/firefox-ui/tests/functional/sessionstore/test_restore_windows_after_restart_and_quit.py TestSessionStoreDisabled.test_no_restore_with_quit
[task 2021-11-28T07:48:44.609Z] 07:48:44 INFO - 1638085724609 Marionette DEBUG Accepted connection 3 from 127.0.0.1:49836
[task 2021-11-28T07:48:44.622Z] 07:48:44 INFO - 1638085724622 Marionette DEBUG 3 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2021-11-28T07:48:44.624Z] 07:48:44 INFO - 1638085724624 Marionette DEBUG 3 <- [1,1,null,{"sessionId":"776ee559-dd46-44a1-bed4-f651e38c59d4","capabilities":{"browserName":"firefox","browserVersion":"96.0a ... l.mozrunner","moz:shutdownTimeout":60000,"moz:useNonSpecCompliantPointerOrigin":false,"moz:webdriverClick":true,"proxy":{}}}]
[task 2021-11-28T07:48:44.625Z] 07:48:44 INFO - 1638085724625 Marionette DEBUG 3 -> [0,2,"WebDriver:SetTimeouts",{"script":30000}]
[task 2021-11-28T07:48:44.625Z] 07:48:44 INFO - 1638085724626 Marionette DEBUG 3 <- [1,2,null,{"value":null}]
[task 2021-11-28T07:48:44.626Z] 07:48:44 INFO - 1638085724626 Marionette DEBUG 3 -> [0,3,"WebDriver:SetTimeouts",{"pageLoad":300000}]
[task 2021-11-28T07:48:44.626Z] 07:48:44 INFO - 1638085724627 Marionette DEBUG 3 <- [1,3,null,{"value":null}]
[task 2021-11-28T07:48:44.627Z] 07:48:44 INFO - 1638085724627 Marionette DEBUG 3 -> [0,4,"WebDriver:SetTimeouts",{"implicit":0}]
[task 2021-11-28T07:48:44.627Z] 07:48:44 INFO - 1638085724628 Marionette DEBUG 3 <- [1,4,null,{"value":null}]
[task 2021-11-28T07:48:44.628Z] 07:48:44 INFO - 1638085724629 Marionette DEBUG 3 -> [0,5,"Marionette:GetContext",{}]
[task 2021-11-28T07:48:44.628Z] 07:48:44 INFO - 1638085724629 Marionette DEBUG 3 <- [1,5,null,{"value":"content"}]
[task 2021-11-28T07:48:44.629Z] 07:48:44 INFO - 1638085724630 Marionette DEBUG 3 -> [0,6,"Marionette:SetContext",{"value":"chrome"}]
[task 2021-11-28T07:48:44.629Z] 07:48:44 INFO - 1638085724630 Marionette DEBUG 3 <- [1,6,null,{"value":null}]
[task 2021-11-28T07:48:44.630Z] 07:48:44 INFO - 1638085724630 Marionette DEBUG 3 -> [0,7,"WebDriver:GetWindowHandle",{}]
[task 2021-11-28T07:48:44.630Z] 07:48:44 INFO - 1638085724630 Marionette DEBUG 3 <- [1,7,null,{"value":"64644f55-bc01-45fb-80c0-284aa5aa2680"}]
[task 2021-11-28T07:48:44.631Z] 07:48:44 INFO - 1638085724631 Marionette DEBUG 3 -> [0,8,"Marionette:SetContext",{"value":"content"}]
[task 2021-11-28T07:48:44.631Z] 07:48:44 INFO - 1638085724631 Marionette DEBUG 3 <- [1,8,null,{"value":null}]
[task 2021-11-28T07:48:44.632Z] 07:48:44 INFO - 1638085724632 Marionette DEBUG 3 -> [0,9,"Marionette:GetContext",{}]
[task 2021-11-28T07:48:44.632Z] 07:48:44 INFO - 1638085724633 Marionette DEBUG 3 <- [1,9,null,{"value":"content"}]
[task 2021-11-28T07:48:44.633Z] 07:48:44 INFO - 1638085724633 Marionette DEBUG 3 -> [0,10,"Marionette:SetContext",{"value":"chrome"}]
[task 2021-11-28T07:48:44.633Z] 07:48:44 INFO - 1638085724633 Marionette DEBUG 3 <- [1,10,null,{"value":null}]
[task 2021-11-28T07:48:44.634Z] 07:48:44 INFO - 1638085724634 Marionette DEBUG 3 -> [0,11,"WebDriver:GetWindowHandles",{}]
[task 2021-11-28T07:48:44.634Z] 07:48:44 INFO - 1638085724634 Marionette DEBUG 3 <- [1,11,null,["64644f55-bc01-45fb-80c0-284aa5aa2680"]]
[task 2021-11-28T07:48:44.635Z] 07:48:44 INFO - 1638085724635 Marionette DEBUG 3 -> [0,12,"Marionette:SetContext",{"value":"content"}]
[task 2021-11-28T07:48:44.635Z] 07:48:44 INFO - 1638085724635 Marionette DEBUG 3 <- [1,12,null,{"value":null}]
[task 2021-11-28T07:48:44.635Z] 07:48:44 INFO - 1638085724636 Marionette DEBUG 3 -> [0,13,"Marionette:GetContext",{}]
[task 2021-11-28T07:48:44.636Z] 07:48:44 INFO - 1638085724636 Marionette DEBUG 3 <- [1,13,null,{"value":"content"}]
[task 2021-11-28T07:48:44.636Z] 07:48:44 INFO - 1638085724637 Marionette DEBUG 3 -> [0,14,"Marionette:SetContext",{"value":"content"}]
[task 2021-11-28T07:48:44.636Z] 07:48:44 INFO - 1638085724637 Marionette DEBUG 3 <- [1,14,null,{"value":null}]
[task 2021-11-28T07:48:44.637Z] 07:48:44 INFO - 1638085724637 Marionette DEBUG 3 -> [0,15,"WebDriver:GetWindowHandle",{}]
[task 2021-11-28T07:48:44.637Z] 07:48:44 INFO - 1638085724638 Marionette DEBUG 3 <- [1,15,null,{"value":"07fb86af-d49f-437d-8c65-a3588d8322fd"}]
[task 2021-11-28T07:48:44.638Z] 07:48:44 INFO - 1638085724638 Marionette DEBUG 3 -> [0,16,"Marionette:SetContext",{"value":"content"}]
[task 2021-11-28T07:48:44.638Z] 07:48:44 INFO - 1638085724638 Marionette DEBUG 3 <- [1,16,null,{"value":null}]
[task 2021-11-28T07:48:44.639Z] 07:48:44 INFO - 1638085724639 Marionette DEBUG 3 -> [0,17,"Marionette:GetContext",{}]
[task 2021-11-28T07:48:44.639Z] 07:48:44 INFO - 1638085724639 Marionette DEBUG 3 <- [1,17,null,{"value":"content"}]
[task 2021-11-28T07:48:44.639Z] 07:48:44 INFO - 1638085724640 Marionette DEBUG 3 -> [0,18,"Marionette:SetContext",{"value":"content"}]
[task 2021-11-28T07:48:44.640Z] 07:48:44 INFO - 1638085724640 Marionette DEBUG 3 <- [1,18,null,{"value":null}]
[task 2021-11-28T07:48:44.640Z] 07:48:44 INFO - 1638085724641 Marionette DEBUG 3 -> [0,19,"WebDriver:GetWindowHandles",{}]
[task 2021-11-28T07:48:44.640Z] 07:48:44 INFO - 1638085724641 Marionette DEBUG 3 <- [1,19,null,["07fb86af-d49f-437d-8c65-a3588d8322fd"]]
[task 2021-11-28T07:48:44.641Z] 07:48:44 INFO - 1638085724641 Marionette DEBUG 3 -> [0,20,"Marionette:SetContext",{"value":"content"}]
[task 2021-11-28T07:48:44.641Z] 07:48:44 INFO - 1638085724642 Marionette DEBUG 3 <- [1,20,null,{"value":null}]
[task 2021-11-28T07:48:44.642Z] 07:48:44 INFO - 1638085724642 Marionette DEBUG 3 -> [0,21,"Marionette:SetContext",{"value":"chrome"}]
[task 2021-11-28T07:48:44.642Z] 07:48:44 INFO - 1638085724642 Marionette DEBUG 3 <- [1,21,null,{"value":null}]
[task 2021-11-28T07:48:44.642Z] 07:48:44 INFO - 1638085724643 Marionette DEBUG 3 -> [0,22,"Marionette:GetContext",{}]
[task 2021-11-28T07:48:44.643Z] 07:48:44 INFO - 1638085724643 Marionette DEBUG 3 <- [1,22,null,{"value":"chrome"}]
[task 2021-11-28T07:48:44.643Z] 07:48:44 INFO - 1638085724644 Marionette DEBUG 3 -> [0,23,"Marionette:SetContext",{"value":"chrome"}]
[task 2021-11-28T07:48:44.643Z] 07:48:44 INFO - 1638085724644 Marionette DEBUG 3 <- [1,23,null,{"value":null}]
[task 2021-11-28T07:48:44.647Z] 07:48:44 INFO - 1638085724647 Marionette DEBUG 3 -> [0,24,"WebDriver:ExecuteScript",{"script":"let prefInterface = Components.classes[\"@mozilla.org/preferences-service;1\"]\n ... efault","line":878,"filename":"Z:\\task_163808512326163\\build\\venv\\lib\\site-packages\\marionette_driver\\marionette.py"}]
[task 2021-11-28T07:48:44.649Z] 07:48:44 INFO - 1638085724649 Marionette TRACE [8] MarionetteCommands actor created for window id 2
[task 2021-11-28T07:48:44.650Z] 07:48:44 INFO - 1638085724651 Marionette DEBUG 3 <- [1,24,null,{"value":false}]
[task 2021-11-28T07:48:44.651Z] 07:48:44 INFO - 1638085724651 Marionette DEBUG 3 -> [0,25,"Marionette:SetContext",{"value":"chrome"}]
[task 2021-11-28T07:48:44.651Z] 07:48:44 INFO - 1638085724652 Marionette DEBUG 3 <- [1,25,null,{"value":null}]
[task 2021-11-28T07:48:44.652Z] 07:48:44 INFO - 1638085724652 Marionette DEBUG 3 -> [0,26,"Marionette:GetContext",{}]
[task 2021-11-28T07:48:44.652Z] 07:48:44 INFO - 1638085724652 Marionette DEBUG 3 <- [1,26,null,{"value":"chrome"}]
[task 2021-11-28T07:48:44.652Z] 07:48:44 INFO - 1638085724653 Marionette DEBUG 3 -> [0,27,"WebDriver:DeleteSession",{}]
[task 2021-11-28T07:48:44.654Z] 07:48:44 INFO - 1638085724654 Marionette DEBUG 3 <- [1,27,null,{"value":null}]
[task 2021-11-28T07:48:44.655Z] 07:48:44 INFO - 1638085724655 Marionette DEBUG Closed connection 3
[task 2021-11-28T07:48:44.850Z] 07:48:44 INFO - Application command: Z:\task_163808512326163\build\application\firefox\firefox.exe -no-remote -marionette --wait-for-browser -profile Z:\task_163808512326163\build\tmp4fvfwj17.mozrunner
[task 2021-11-28T07:48:45.216Z] 07:48:45 INFO - 1638085725227 Marionette INFO Marionette enabled
[task 2021-11-28T07:51:56.168Z] 07:51:56 INFO - TEST-UNEXPECTED-ERROR | testing/firefox-ui/tests/functional/sessionstore/test_restore_windows_after_restart_and_quit.py TestSessionStoreDisabled.test_no_restore_with_quit | OSError: Process killed because the connection to Marionette server is lost. Check gecko.log for errors (Reason: Timed out waiting for connection on 127.0.0.1:2828!)
[task 2021-11-28T07:51:56.168Z] 07:51:56 INFO - Traceback (most recent call last):
[task 2021-11-28T07:51:56.168Z] 07:51:56 INFO - File "Z:\task_163808512326163\build\venv\lib\site-packages\marionette_harness\marionette_test\testcases.py", line 183, in run
[task 2021-11-28T07:51:56.168Z] 07:51:56 INFO - self.setUp()
[task 2021-11-28T07:51:56.168Z] 07:51:56 INFO - File "Z:\task_163808512326163\build\tests\firefox-ui\tests\testing\firefox-ui\tests\functional\sessionstore\session_store_test_case.py", line 58, in setUp
[task 2021-11-28T07:51:56.173Z] 07:51:56 INFO - self.marionette.enforce_gecko_prefs(
[task 2021-11-28T07:51:56.173Z] 07:51:56 INFO - File "Z:\task_163808512326163\build\venv\lib\site-packages\marionette_driver\decorators.py", line 37, in _
[task 2021-11-28T07:51:56.173Z] 07:51:56 INFO - m._handle_socket_failure()
[task 2021-11-28T07:51:56.173Z] 07:51:56 INFO - File "Z:\task_163808512326163\build\venv\lib\site-packages\marionette_driver\marionette.py", line 716, in _handle_socket_failure
[task 2021-11-28T07:51:56.173Z] 07:51:56 INFO - reraise(
[task 2021-11-28T07:51:56.173Z] 07:51:56 INFO - File "Z:\task_163808512326163\build\venv\lib\site-packages\six.py", line 702, in reraise
[task 2021-11-28T07:51:56.173Z] 07:51:56 INFO - raise value.with_traceback(tb)
[task 2021-11-28T07:51:56.173Z] 07:51:56 INFO - File "Z:\task_163808512326163\build\venv\lib\site-packages\marionette_driver\decorators.py", line 27, in _
[task 2021-11-28T07:51:56.173Z] 07:51:56 INFO - return func(*args, **kwargs)
[task 2021-11-28T07:51:56.173Z] 07:51:56 INFO - File "Z:\task_163808512326163\build\venv\lib\site-packages\marionette_driver\marionette.py", line 906, in enforce_gecko_prefs
[task 2021-11-28T07:51:56.173Z] 07:51:56 INFO - self.raise_for_port()
[task 2021-11-28T07:51:56.173Z] 07:51:56 INFO - File "Z:\task_163808512326163\build\venv\lib\site-packages\marionette_driver\marionette.py", line 598, in raise_for_port
[task 2021-11-28T07:51:56.173Z] 07:51:56 INFO - raise socket.timeout(
[task 2021-11-28T07:51:56.173Z] 07:51:56 INFO - TEST-INFO took 191560ms
| Comment hidden (Intermittent Failures Robot) |
|
||
Comment 2•3 years ago
|
||
No toplevel-window-ready notification has been sent out by Firefox.
Depends on: 1382162
|
||
Comment 3•3 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.
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.
Description
•