Closed Bug 1577893 Opened 5 years ago Closed 5 years ago

Intermittent testing\marionette\harness\marionette_harness\tests\unit\test_timeouts.py TestTimeouts.test_reset_timeout | IOError: Process killed because the connection to Marionette server is lost. Check gecko.log for errors (Reason: Timed out waiting for

Categories

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

Product:
Testing
Component:
Marionette Client and Harness
Version:
Version 3
Type:
defect

Tracking

(Not tracked)

Status:
RESOLVED DUPLICATE of bug 1382162

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure, regression)

Filed by: malexandru [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=264314055&repo=mozilla-central
Full log: https://queue.taskcluster.net/v1/task/ObIqAhezTO66dK03nPN6Ww/runs/0/artifacts/public/logs/live_backing.log

20:40:07 INFO - TEST-PASS | testing\marionette\harness\marionette_harness\tests\unit\test_timeouts.py TestTimeouts.test_page_timeout_pass | took 94ms
20:40:07 INFO - TEST-START | testing\marionette\harness\marionette_harness\tests\unit\test_timeouts.py TestTimeouts.test_reset_timeout
20:40:07 INFO - 1567197607986 Marionette DEBUG Accepted connection 58 from 127.0.0.1:50923
20:40:07 INFO - 1567197607988 Marionette DEBUG 58 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
20:40:07 INFO - 1567197607990 Marionette TRACE [69] Frame script loaded
20:40:07 INFO - 1567197607991 Marionette TRACE [69] Frame script registered
20:40:08 INFO - 1567197607992 Marionette DEBUG 58 <- [1,1,null,{"sessionId":"c5fcc730-87c4-4378-adfe-954b49cdd853","capabilities":{"browserName":"firefox","browserVersion":"70.0a ... p\tmpuiopto.mozrunner","moz:shutdownTimeout":60000,"moz:useNonSpecCompliantPointerOrigin":false,"moz:webdriverClick":true}}]
20:40:08 INFO - 1567197607996 Marionette DEBUG 58 -> [0,2,"WebDriver:SetTimeouts",{"script":30000}]
20:40:08 INFO - 1567197607997 Marionette DEBUG 58 <- [1,2,null,{"value":null}]
20:40:08 INFO - 1567197608000 Marionette DEBUG 58 -> [0,3,"WebDriver:SetTimeouts",{"pageLoad":300000}]
20:40:08 INFO - 1567197608000 Marionette DEBUG 58 <- [1,3,null,{"value":null}]
20:40:08 INFO - 1567197608003 Marionette DEBUG 58 -> [0,4,"WebDriver:SetTimeouts",{"implicit":0}]
20:40:08 INFO - 1567197608003 Marionette DEBUG 58 <- [1,4,null,{"value":null}]
20:40:08 INFO - 1567197608008 Marionette DEBUG 58 -> [0,5,"WebDriver:GetTimeouts",{}]
20:40:08 INFO - 1567197608008 Marionette DEBUG 58 <- [1,5,null,{"implicit":0,"pageLoad":300000,"script":30000}]
20:40:08 INFO - 1567197608010 Marionette DEBUG 58 -> [0,6,"WebDriver:GetTimeouts",{}]
20:40:08 INFO - 1567197608011 Marionette DEBUG 58 <- [1,6,null,{"implicit":0,"pageLoad":300000,"script":30000}]
20:40:08 INFO - 1567197608013 Marionette DEBUG 58 -> [0,7,"WebDriver:GetTimeouts",{}]
20:40:08 INFO - 1567197608013 Marionette DEBUG 58 <- [1,7,null,{"implicit":0,"pageLoad":300000,"script":30000}]
20:40:08 INFO - 1567197608015 Marionette DEBUG 58 -> [0,8,"Marionette:GetContext",{}]
20:40:08 INFO - 1567197608015 Marionette DEBUG 58 <- [1,8,null,{"value":"content"}]
20:40:08 INFO - 1567197608018 Marionette DEBUG 58 -> [0,9,"WebDriver:DeleteSession",{}]
20:40:08 INFO - 1567197608019 Marionette DEBUG 58 <- [1,9,null,{"value":null}]
20:40:08 INFO - 1567197608021 Marionette DEBUG Closed connection 58
20:40:08 INFO - Application command: C:\tasks\task_1567196360\build\application\firefox\firefox.exe -no-remote -marionette --wait-for-browser -profile c:\users\testdr~1\appdata\local\temp\tmpuiopto.mozrunner
20:40:08 INFO - 1567197608529 Marionette TRACE Received observer notification profile-after-change
20:40:08 INFO - 1567197608560 Marionette TRACE Received observer notification command-line-startup
20:40:08 INFO - 1567197608560 Marionette TRACE Received observer notification nsPref:changed
20:40:08 INFO - 1567197608561 Marionette DEBUG Init aborted (running=false, enabled=true, finalUIStartup=false)
20:43:19 ERROR - TEST-UNEXPECTED-ERROR | testing\marionette\harness\marionette_harness\tests\unit\test_timeouts.py TestTimeouts.test_reset_timeout | IOError: 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!)
20:43:19 INFO - Traceback (most recent call last):
20:43:19 INFO - File "C:\tasks\task_1567196360\build\venv\lib\site-packages\marionette_harness\marionette_test\testcases.py", line 159, in run
20:43:19 INFO - testMethod()
20:43:19 INFO - File "C:\tasks\task_1567196360\build\venv\lib\site-packages\marionette_harness\marionette_test\decorators.py", line 84, in skip_wrapper
20:43:19 INFO - return test_item(self, *args, **kwargs)
20:43:19 INFO - File "C:\tasks\task_1567196360\build\venv\lib\site-packages\marionette_harness\marionette_test\decorators.py", line 152, in skip_wrapper
20:43:19 INFO - return test_item(self, *args, **kwargs)
20:43:19 INFO - File "C:\tasks\task_1567196360\build\tests\marionette\tests\testing\marionette\harness\marionette_harness\tests\unit\test_timeouts.py", line 85, in test_reset_timeout
20:43:19 INFO - do_check(self.marionette.restart)
20:43:19 INFO - File "C:\tasks\task_1567196360\build\tests\marionette\tests\testing\marionette\harness\marionette_harness\tests\unit\test_timeouts.py", line 77, in do_check
20:43:19 INFO - callback()
20:43:19 INFO - File "C:\tasks\task_1567196360\build\venv\lib\site-packages\marionette_driver\decorators.py", line 36, in _
20:43:19 INFO - m._handle_socket_failure()
20:43:19 INFO - File "C:\tasks\task_1567196360\build\venv\lib\site-packages\marionette_driver\marionette.py", line 678, in _handle_socket_failure
20:43:19 INFO - reraise(IOError, message.format(returncode=returncode, reason=val), tb)
20:43:19 INFO - File "C:\tasks\task_1567196360\build\venv\lib\site-packages\marionette_driver\decorators.py", line 26, in _
20:43:19 INFO - return func(*args, **kwargs)
20:43:19 INFO - File "C:\tasks\task_1567196360\build\venv\lib\site-packages\marionette_driver\marionette.py", line 1052, in restart
20:43:19 INFO - self.raise_for_port(timeout=self.DEFAULT_STARTUP_TIMEOUT)
20:43:19 INFO - File "C:\tasks\task_1567196360\build\venv\lib\site-packages\marionette_driver\marionette.py", line 569, in raise_for_port
20:43:19 INFO - self.host, self.port))
20:43:19 INFO - TEST-INFO took 191494ms

Missing marionette-startup-requested notification.

Status: NEW → RESOLVED
Closed: 5 years ago
Resolution: --- → DUPLICATE
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.