Closed Bug 1845393 Opened 2 years ago Closed 1 year ago

Intermittent position-dynamic-changes/mixed/reftest_margin_abspos.list | application timed out after 370 seconds with no output | application terminated with exit code 3221225477

Categories

(Core :: Layout: Positioned, defect, P5)

defect

Tracking

()

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

Filed by: smolnar [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=423835218&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/ebBZnVlgSuqChVUVxWwZEA/runs/0/artifacts/public/logs/live_backing.log
Reftest URL: https://hg.mozilla.org/mozilla-central/raw-file/tip/layout/tools/reftest/reftest-analyzer.xhtml#logurl=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/ebBZnVlgSuqChVUVxWwZEA/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1


REFTEST TEST-PASS | layout/reftests/position-dynamic-changes/mixed/mixed-dimentionA.html?margin_abspos == layout/reftests/position-dynamic-changes/mixed/mixed-dimentionA-ref.html?margin_abspos | image comparison, max difference: 0, number of differing pixels: 0
[task 2023-07-25T18:36:58.580Z] 18:36:58     INFO - REFTEST TEST-END | layout/reftests/position-dynamic-changes/mixed/mixed-dimentionA.html?margin_abspos == layout/reftests/position-dynamic-changes/mixed/mixed-dimentionA-ref.html?margin_abspos
[task 2023-07-25T18:36:58.587Z] 18:36:58     INFO - REFTEST INFO | Slowest test took 870ms (file:///Z:/task_169030344790580/build/tests/reftest/tests/layout/reftests/position-dynamic-changes/mixed/mixed-dimentionA.html?margin_abspos)
[task 2023-07-25T18:36:58.587Z] 18:36:58     INFO - REFTEST INFO | Total canvas count = 2
[task 2023-07-25T18:36:59.192Z] 18:36:59     INFO - 1690310219191	Marionette	TRACE	Received observer notification quit-application
[task 2023-07-25T18:36:59.193Z] 18:36:59     INFO - 1690310219191	Marionette	INFO	Stopped listening on port 2828
[task 2023-07-25T18:36:59.193Z] 18:36:59     INFO - 1690310219192	Marionette	DEBUG	Marionette stopped listening
[task 2023-07-25T18:36:59.274Z] 18:36:59     INFO - console.error: ({})
[task 2023-07-25T18:36:59.299Z] 18:36:59     INFO - console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.sys.mjs", 399))
[task 2023-07-25T18:36:59.993Z] 18:36:59     INFO - REFTEST INFO | Process mode: e10s
[task 2023-07-25T18:36:59.994Z] 18:36:59  WARNING - leakcheck | refcount logging is off, so leaks can't be detected!
[task 2023-07-25T18:36:59.995Z] 18:36:59     INFO - REFTEST INFO | Running tests in file:///Z:/task_169030344790580/build/tests/reftest/tests/layout/reftests/position-dynamic-changes/mixed-abspos-root/reftest_plain.list
[task 2023-07-25T18:37:00.016Z] 18:37:00     INFO - REFTEST INFO | Running with e10s: True
[task 2023-07-25T18:37:00.016Z] 18:37:00     INFO - REFTEST INFO | Running with fission: True
[task 2023-07-25T18:37:00.017Z] 18:37:00     INFO - REFTEST INFO | Application command: Z:\task_169030344790580\build\application\firefox\firefox.exe -marionette --wait-for-browser -profile C:\Users\task_169030344790580\AppData\Local\Temp\tmp12bmzwkd.mozrunner
[task 2023-07-25T18:37:00.481Z] 18:37:00     INFO - 1690310220481	Marionette	INFO	Marionette enabled
[task 2023-07-25T18:37:00.484Z] 18:37:00     INFO - 1690310220483	Marionette	TRACE	Received observer notification final-ui-startup
[task 2023-07-25T18:37:00.547Z] 18:37:00     INFO - 1690310220547	Marionette	INFO	Listening on port 2828
[task 2023-07-25T18:37:00.549Z] 18:37:00     INFO - 1690310220549	Marionette	DEBUG	Marionette is listening
[task 2023-07-25T18:37:00.562Z] 18:37:00     INFO - 1690310220561	Marionette	DEBUG	Accepted connection 0 from 127.0.0.1:57209
[task 2023-07-25T18:37:00.571Z] 18:37:00     INFO - 1690310220570	Marionette	DEBUG	Closed connection 0
[task 2023-07-25T18:37:00.754Z] 18:37:00     INFO - 1690310220753	Marionette	DEBUG	Accepted connection 1 from 127.0.0.1:57212
[task 2023-07-25T18:37:01.560Z] 18:37:01     INFO - 1690310221559	Marionette	DEBUG	Closed connection 1
[task 2023-07-25T18:37:01.595Z] 18:37:01     INFO - JavaScript error: resource://gre/modules/XULStore.sys.mjs, line 60: Error: Can't find profile directory.
[task 2023-07-25T18:37:01.988Z] 18:37:01     INFO - 1690310221987	Marionette	DEBUG	Accepted connection 2 from 127.0.0.1:57213
[task 2023-07-25T18:37:02.047Z] 18:37:02     INFO - 1690310222046	Marionette	DEBUG	Closed connection 2
[task 2023-07-25T18:37:02.048Z] 18:37:02     INFO - 1690310222047	Marionette	DEBUG	Accepted connection 3 from 127.0.0.1:57214
[task 2023-07-25T18:37:02.709Z] 18:37:02     INFO - 1690310222709	Marionette	DEBUG	3 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2023-07-25T18:37:02.714Z] 18:37:02     INFO - 1690310222713	Marionette	DEBUG	Waiting for initial application window
[task 2023-07-25T18:37:02.727Z] 18:37:02     INFO - console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.sys.mjs", 399))
[task 2023-07-25T18:37:02.728Z] 18:37:02     INFO - console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.sys.mjs", 399))
[task 2023-07-25T18:37:13.678Z] 18:37:13     INFO - console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.sys.mjs", 399))
[task 2023-07-25T18:43:23.684Z] 18:43:23    ERROR - REFTEST ERROR | file:///Z:/task_169030344790580/build/tests/reftest/tests/layout/reftests/position-dynamic-changes/mixed/reftest_margin_abspos.list | application timed out after 370 seconds with no output
[task 2023-07-25T18:43:23.685Z] 18:43:23  WARNING - REFTEST WARNING | Force-terminating active process(es).
[task 2023-07-25T18:43:23.685Z] 18:43:23     INFO - REFTEST TEST-INFO | started process screenshot
[task 2023-07-25T18:43:23.913Z] 18:43:23     INFO - REFTEST TEST-INFO | screenshot: exit 0
[task 2023-07-25T18:43:23.955Z] 18:43:23     INFO -  TEST-INFO | crashinject: exit 0
[task 2023-07-25T18:43:24.334Z] 18:43:24    ERROR - TEST-UNEXPECTED-FAIL | file:///Z:/task_169030344790580/build/tests/reftest/tests/layout/reftests/position-dynamic-changes/mixed/reftest_margin_abspos.list | application terminated with exit code 3221225477
[task 2023-07-25T18:43:24.379Z] 18:43:24     INFO -  Traceback (most recent call last):
[task 2023-07-25T18:43:24.380Z] 18:43:24     INFO -    File "Z:\task_169030344790580\build\tests\reftest\runreftest.py", line 1194, in <module>
[task 2023-07-25T18:43:24.380Z] 18:43:24     INFO -      sys.exit(run_test_harness(parser, options))
[task 2023-07-25T18:43:24.381Z] 18:43:24     INFO -    File "Z:\task_169030344790580\build\tests\reftest\runreftest.py", line 1186, in run_test_harness
INFO -      result = reftest.runTests(options.tests, options)
[task 2023-07-25T18:43:24.381Z] 18:43:24     INFO -    File "Z:\task_169030344790580\build\tests\reftest\runreftest.py", line 707, in runTests
[task 2023-07-25T18:43:24.381Z] 18:43:24     INFO -      return self.runSerialTests(manifests, options, cmdargs)
[task 2023-07-25T18:43:24.381Z] 18:43:24     INFO -    File "Z:\task_169030344790580\build\tests\reftest\runreftest.py", line 1128, in runSerialTests
[task 2023-07-25T18:43:24.381Z] 18:43:24     INFO -      status = run(tests=tests)
[task 2023-07-25T18:43:24.382Z] 18:43:24     INFO -    File "Z:\task_169030344790580\build\tests\reftest\runreftest.py", line 1077, in run
[task 2023-07-25T18:43:24.382Z] 18:43:24     INFO -      status = self.runApp(
[task 2023-07-25T18:43:24.382Z] 18:43:24     INFO -    File "Z:\task_169030344790580\build\tests\reftest\runreftest.py", line 1023, in runApp
[task 2023-07-25T18:43:24.382Z] 18:43:24     INFO -      raise reraise(exc, value, tb)
[task 2023-07-25T18:43:24.382Z] 18:43:24     INFO -    File "Z:\task_169030344790580\build\venv\lib\site-packages\six.py", line 696, in reraise
[task 2023-07-25T18:43:24.382Z] 18:43:24     INFO -      raise value
[task 2023-07-25T18:43:24.382Z] 18:43:24     INFO -    File "Z:\task_169030344790580\build\tests\reftest\runreftest.py", line 958, in runApp
[task 2023-07-25T18:43:24.382Z] 18:43:24     INFO -      marionette.start_session()
[task 2023-07-25T18:43:24.383Z] 18:43:24     INFO -    File "Z:\task_169030344790580\build\venv\lib\site-packages\marionette_driver\decorators.py", line 34, in _
[task 2023-07-25T18:43:24.383Z] 18:43:24     INFO -      m._handle_socket_failure()
[task 2023-07-25T18:43:24.384Z] 18:43:24     INFO -    File "Z:\task_169030344790580\build\venv\lib\site-packages\marionette_driver\marionette.py", line 736, in _handle_socket_failure
[task 2023-07-25T18:43:24.384Z] 18:43:24     INFO -      reraise(exc_cls, exc, tb)
[task 2023-07-25T18:43:24.384Z] 18:43:24     INFO -    File "Z:\task_169030344790580\build\venv\lib\site-packages\six.py", line 696, in reraise
[task 2023-07-25T18:43:24.384Z] 18:43:24     INFO -      raise value
[task 2023-07-25T18:43:24.384Z] 18:43:24     INFO -    File "Z:\task_169030344790580\build\venv\lib\site-packages\marionette_driver\decorators.py", line 24, in _
[task 2023-07-25T18:43:24.384Z] 18:43:24     INFO -      return func(*args, **kwargs)
[task 2023-07-25T18:43:24.384Z] 18:43:24     INFO -    File "Z:\task_169030344790580\build\venv\lib\site-packages\marionette_driver\marionette.py", line 1287, in start_session
[task 2023-07-25T18:43:24.385Z] 18:43:24     INFO -      resp = self._send_message("WebDriver:NewSession", capabilities)
[task 2023-07-25T18:43:24.385Z] 18:43:24     INFO -    File "Z:\task_169030344790580\build\venv\lib\site-packages\marionette_driver\decorators.py", line 34, in _
[task 2023-07-25T18:43:24.385Z] 18:43:24     INFO -      m._handle_socket_failure()
[task 2023-07-25T18:43:24.385Z] 18:43:24     INFO -    File "Z:\task_169030344790580\build\venv\lib\site-packages\marionette_driver\marionette.py", line 736, in _handle_socket_failure
[task 2023-07-25T18:43:24.385Z] 18:43:24     INFO -      reraise(exc_cls, exc, tb)
[task 2023-07-25T18:43:24.385Z] 18:43:24     INFO -    File "Z:\task_169030344790580\build\venv\lib\site-packages\six.py", line 696, in reraise
[task 2023-07-25T18:43:24.386Z] 18:43:24     INFO -      raise value
[task 2023-07-25T18:43:24.386Z] 18:43:24     INFO -    File "Z:\task_169030344790580\build\venv\lib\site-packages\marionette_driver\decorators.py", line 24, in _
[task 2023-07-25T18:43:24.386Z] 18:43:24     INFO -      return func(*args, **kwargs)
[task 2023-07-25T18:43:24.386Z] 18:43:24     INFO -    File "Z:\task_169030344790580\build\venv\lib\site-packages\marionette_driver\marionette.py", line 685, in _send_message
[task 2023-07-25T18:43:24.386Z] 18:43:24     INFO -      msg = self.client.request(name, params)
[task 2023-07-25T18:43:24.386Z] 18:43:24     INFO -    File "Z:\task_169030344790580\build\venv\lib\site-packages\marionette_driver\transport.py", line 382, in request
[task 2023-07-25T18:43:24.386Z] 18:43:24     INFO -      return self.receive()
[task 2023-07-25T18:43:24.387Z] 18:43:24     INFO -    File "Z:\task_169030344790580\build\venv\lib\site-packages\marionette_driver\transport.py", line 223, in receive
[task 2023-07-25T18:43:24.387Z] 18:43:24     INFO -      chunk = sock.recv(recv_bytes)
[task 2023-07-25T18:43:24.387Z] 18:43:24     INFO -  ConnectionResetError: [WinError 10054] An existing connection was forcibly closed by the remote host
[task 2023-07-25T18:43:24.413Z] 18:43:24     INFO -  Exception ignored in: <function BaseProfile.__del__ at 0x000001F70B8E0790>
INFO -  Traceback (most recent call last):
[task 2023-07-25T18:43:24.414Z] 18:43:24     INFO -    File "Z:\task_169030344790580\build\venv\lib\site-packages\mozprofile\profile.py", line 84, in __del__
[task 2023-07-25T18:43:24.414Z] 18:43:24     INFO -    File "Z:\task_169030344790580\build\venv\lib\site-packages\mozprofile\profile.py", line 294, in cleanup
[task 2023-07-25T18:43:24.414Z] 18:43:24     INFO -    File "Z:\task_169030344790580\build\venv\lib\site-packages\mozprofile\profile.py", line 92, in cleanup
[task 2023-07-25T18:43:24.414Z] 18:43:24     INFO -    File "Z:\task_169030344790580\build\venv\lib\site-packages\mozfile\mozfile.py", line 247, in remove
[task 2023-07-25T18:43:24.414Z] 18:43:24     INFO -  ImportError: sys.meta_path is None, Python is likely shutting down
[task 2023-07-25T18:43:24.447Z] 18:43:24     INFO - Return code: 1
[task 2023-07-25T18:43:24.448Z] 18:43:24    ERROR - No suite end message was emitted by this harness.
[task 2023-07-25T18:43:24.448Z] 18:43:24     INFO - TinderboxPrint: reftest-reftest<br/>9255/0/0
[task 2023-07-25T18:43:24.448Z] 18:43:24  WARNING - setting return code to 2
Status: NEW → RESOLVED
Closed: 1 year ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.