1517106 - Intermittent testing\firefox-ui\tests\functional\sessionstore\test_restore_windows_after_windows_shutdown.py TestWindowsShutdown.test_with_variety | IOError: Process still running 70s after quit request

Status: RESOLVED FIXED

(Testing :: Firefox UI Tests, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: rmaries [at] mozilla.com

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

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

11:47:24     INFO -  ERROR: GC found live SharedScriptData 000001EFDAD87880 with ref count 2 at shutdown
11:47:24     INFO -  ERROR: GC found live SharedScriptData 000001EFDAD34340 with ref count 2 at shutdown
11:47:24     INFO -  ERROR: GC found live SharedScriptData 000001EFDAD8EEE0 with ref count 2 at shutdown
11:47:24     INFO -  ERROR: GC found live SharedScriptData 000001EFDE023580 with ref count 2 at shutdown
11:47:24     INFO -  Assertion failure: m_refCount == 1, at z:/build/build/src/js/src/jit/ExecutableAllocator.cpp:49
11:48:31     INFO - TEST-UNEXPECTED-ERROR | testing\firefox-ui\tests\functional\sessionstore\test_restore_windows_after_windows_shutdown.py TestWindowsShutdown.test_with_variety | IOError: Process still running 70s after quit request
11:48:31     INFO - Traceback (most recent call last):
11:48:31     INFO -   File "Z:\task_1546341251\build\venv\lib\site-packages\marionette_harness\marionette_test\testcases.py", line 159, in run
11:48:31     INFO -     testMethod()
11:48:31     INFO -   File "Z:\task_1546341251\build\tests\firefox-ui\tests\testing\firefox-ui\tests\functional\sessionstore\test_restore_windows_after_windows_shutdown.py", line 32, in test_with_variety
11:48:31     INFO -     self.windows_shutdown_with_variety(restart_by_os=False, expect_restore=True)
11:48:31     INFO -   File "Z:\task_1546341251\build\tests\firefox-ui\tests\testing\firefox-ui\tests\functional\sessionstore\session_store_test_case.py", line 310, in windows_shutdown_with_variety
11:48:31     INFO -     self.marionette.quit(in_app=True, callback=lambda: self.simulate_os_shutdown())
11:48:31     INFO -   File "Z:\task_1546341251\build\venv\lib\site-packages\marionette_driver\decorators.py", line 26, in _
11:48:31     INFO -     return func(*args, **kwargs)
11:48:31     INFO -   File "Z:\task_1546341251\build\venv\lib\site-packages\marionette_driver\marionette.py", line 1128, in quit
11:48:31     INFO -     raise IOError(message.format(self.shutdown_timeout))
11:48:31     INFO - TEST-INFO took 126471ms
11:48:31    ERROR - test_end for testing\firefox-ui\tests\functional\sessionstore\test_restore_windows_after_windows_shutdown.py TestWindowsShutdown.test_with_variety logged while not in progress. Logged with data: {"status": "ERROR", "extra": {"class_name": "test_restore_windows_after_windows_shutdown.TestWindowsShutdown", "method_name": "test_with_variety"}, "expected": "PASS", "test": "testing\\firefox-ui\\tests\\functional\\sessionstore\\test_restore_windows_after_windows_shutdown.py TestWindowsShutdown.test_with_variety", "message": "InvalidSessionIdException: Please start a session", "stack": "Traceback (most recent call last):\n  File \"Z:\\task_1546341251\\build\\venv\\lib\\site-packages\\marionette_harness\\marionette_test\\testcases.py\", line 190, in run\n    self.tearDown()\n  File \"Z:\\task_1546341251\\build\\tests\\firefox-ui\\tests\\testing\\firefox-ui\\tests\\functional\\sessionstore\\session_store_test_case.py\", line 65, in tearDown\n    super(SessionStoreTestCase, self).tearDown()\n  File \"Z:\\task_1546341251\\build\\venv\\lib\\site-packages\\firefox_puppeteer\\mixins.py\", line 97, in tearDown\n    self.marionette.set_context('chrome')\n  File \"Z:\\task_1546341251\\build\\venv\\lib\\site-packages\\marionette_driver\\marionette.py\", line 1461, in set_context\n    {\"value\": context})\n  File \"Z:\\task_1546341251\\build\\venv\\lib\\site-packages\\marionette_driver\\decorators.py\", line 26, in _\n    return func(*args, **kwargs)\n  File \"Z:\\task_1546341251\\build\\venv\\lib\\site-packages\\marionette_driver\\marionette.py\", line 753, in _send_message\n    raise errors.InvalidSessionIdException(\"Please start a session\")\n"}

Comment 1

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

This is clearly a shutdown hang of Firefox. I can see the assertion as covered on bug 1486101 during the shutdown process, which might actually be causing this hang.

Comment 2

[Intermittent Failures Robot]

5 failures in 1668 pushes (0.003 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-central: 5

Platform breakdown:
* windows10-64-ccov: 5

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1517106&startday=2018-12-31&endday=2019-01-06&tree=all

Comment 3

[Intermittent Failures Robot]

4 failures in 2627 pushes (0.002 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 4

Platform breakdown:

• windows10-64-ccov: 4

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1517106&startday=2019-01-07&endday=2019-01-13&tree=all

Comment 4

[Intermittent Failures Robot]

2 failures in 2378 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 2

Platform breakdown:

• windows10-64-ccov: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1517106&startday=2019-01-14&endday=2019-01-20&tree=all

Comment 5

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 1

Platform breakdown:

• windows10-64-ccov: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1517106&startday=2019-01-21&endday=2019-01-27&tree=all

Comment 6

[Intermittent Failures Robot]

2 failures in 2628 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 2

Platform breakdown:

• windows10-64-ccov: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1517106&startday=2019-01-28&endday=2019-02-03&tree=all

Comment 7

[Intermittent Failures Robot]

3 failures in 2658 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 3

Platform breakdown:

• windows10-64-ccov: 3

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1517106&startday=2019-02-04&endday=2019-02-10&tree=all

Comment 8

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

No more failures since 20 days. I'm going to mark it as WFM.

Comment 9

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

Most likely fixed by the upgrade of Windows workers to 1803 by bug 1522896.