Open Bug 1934360 Opened 2 months ago Updated 6 days ago

Intermittent Max restarts exceeded

Categories

(Core :: JavaScript: WebAssembly, defect, P5)

defect

Tracking

()

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Blocks 1 open bug)

Details

(Keywords: intermittent-failure)

Filed by: nfay [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=484818646&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/Orv6GI_jSHeB9F4Zyq_-SQ/runs/0/artifacts/public/logs/live_backing.log


[task 2024-11-30T06:45:46.956Z] 06:45:46  WARNING - Protocol.setup caught an exception:
[task 2024-11-30T06:45:46.956Z] 06:45:46  WARNING - Failed to start protocol connection
[task 2024-11-30T06:45:46.956Z] 06:45:46  WARNING - Traceback (most recent call last):
[task 2024-11-30T06:45:46.956Z] 06:45:46  WARNING -   File "/opt/worker/tasks/task_173294376793584/build/tests/web-platform/tests/tools/wptrunner/wptrunner/executors/protocol.py", line 64, in setup
[task 2024-11-30T06:45:46.956Z] 06:45:46  WARNING -     self.connect()
[task 2024-11-30T06:45:46.956Z] 06:45:46  WARNING -   File "/opt/worker/tasks/task_173294376793584/build/tests/web-platform/tests/tools/wptrunner/wptrunner/executors/executormarionette.py", line 783, in connect
[task 2024-11-30T06:45:46.956Z] 06:45:46  WARNING -     self.marionette.raise_for_port()
[task 2024-11-30T06:45:46.956Z] 06:45:46  WARNING -   File "/opt/worker/tasks/task_173294376793584/build/venv/lib/python3.11/site-packages/marionette_driver/marionette.py", line 744, in raise_for_port
[task 2024-11-30T06:45:46.956Z] 06:45:46  WARNING -     raise socket.timeout(
[task 2024-11-30T06:45:46.956Z] 06:45:46  WARNING - TimeoutError: Timed out waiting for connection on 127.0.0.1:53805!
[task 2024-11-30T06:45:46.956Z] 06:45:46  WARNING - 
[task 2024-11-30T06:45:47.003Z] 06:45:47     INFO - Browser exited with return code -15
[task 2024-11-30T06:45:47.003Z] 06:45:47  WARNING - Firefox didn't exit cleanly, not processing leak logs
[task 2024-11-30T06:45:47.004Z] 06:45:47     INFO - Closing logging queue
[task 2024-11-30T06:45:47.005Z] 06:45:47     INFO - queue closed
[task 2024-11-30T06:45:47.010Z] 06:45:47     INFO - Application command: /opt/worker/tasks/task_173294376793584/build/application/Firefox NightlyDebug.app/Contents/MacOS/firefox --marionette about:blank -foreground -profile /var/folders/_j/c2dztvjj5_vgd221wb2hlkjw0000jb/T/tmp9x7bt3nf
[task 2024-11-30T06:45:47.019Z] 06:45:47     INFO - PID 3936 | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /var/folders/_j/c2dztvjj5_vgd221wb2hlkjw0000jb/T/tmp4lcpbj5n/runtests_leaks_3054.log
[task 2024-11-30T06:45:47.019Z] 06:45:47     INFO - Starting runner
[task 2024-11-30T06:49:17.143Z] 06:49:17     INFO - STDERR: Exception in thread 
[task 2024-11-30T06:49:17.143Z] 06:49:17     INFO - STDERR: Thread-6
[task 2024-11-30T06:49:17.144Z] 06:49:17     INFO - STDERR: :
[task 2024-11-30T06:49:17.144Z] 06:49:17     INFO - STDERR: Traceback (most recent call last):
[task 2024-11-30T06:49:17.144Z] 06:49:17     INFO - STDERR:   File "/Library/Frameworks/Python.framework/Versions/3.11/lib/python3.11/threading.py", line 1038, in _bootstrap_inner
[task 2024-11-30T06:49:17.145Z] 06:49:17     INFO - STDERR:     
[task 2024-11-30T06:49:17.145Z] 06:49:17     INFO - STDERR: self.run()
[task 2024-11-30T06:49:17.145Z] 06:49:17     INFO - STDERR:   File "/Library/Frameworks/Python.framework/Versions/3.11/lib/python3.11/threading.py", line 1394, in run
[task 2024-11-30T06:49:17.146Z] 06:49:17     INFO - STDERR:     
[task 2024-11-30T06:49:17.146Z] 06:49:17     INFO - STDERR: self.function(*self.args, **self.kwargs)
[task 2024-11-30T06:49:17.146Z] 06:49:17     INFO - STDERR:   File "/opt/worker/tasks/task_173294376793584/build/tests/web-platform/tests/tools/wptrunner/wptrunner/testrunner.py", line 281, in init_timeout
[task 2024-11-30T06:49:17.147Z] 06:49:17     INFO - STDERR:     
[task 2024-11-30T06:49:17.147Z] 06:49:17     INFO - STDERR: self.send_message("init_failed")
[task 2024-11-30T06:49:17.147Z] 06:49:17     INFO - STDERR:   File "/opt/worker/tasks/task_173294376793584/build/tests/web-platform/tests/tools/wptrunner/wptrunner/testrunner.py", line 275, in send_message
[task 2024-11-30T06:49:17.148Z] 06:49:17     INFO - STDERR:     
[task 2024-11-30T06:49:17.148Z] 06:49:17     INFO - STDERR: self.command_queue.put((command, args))
[task 2024-11-30T06:49:17.149Z] 06:49:17     INFO - STDERR:   File "/Library/Frameworks/Python.framework/Versions/3.11/lib/python3.11/multiprocessing/queues.py", line 88, in put
[task 2024-11-30T06:49:17.149Z] 06:49:17     INFO - STDERR:     
[task 2024-11-30T06:49:17.149Z] 06:49:17     INFO - STDERR: raise ValueError(f"Queue {self!r} is closed")
[task 2024-11-30T06:49:17.149Z] 06:49:17     INFO - STDERR: ValueError
[task 2024-11-30T06:49:17.150Z] 06:49:17     INFO - STDERR: : 
[task 2024-11-30T06:49:17.150Z] 06:49:17     INFO - STDERR: Queue <multiprocessing.queues.Queue object at 0x10fc77510> is closed
[task 2024-11-30T06:51:47.489Z] 06:51:47  WARNING - Protocol.setup caught an exception:
[task 2024-11-30T06:51:47.489Z] 06:51:47  WARNING - Failed to start protocol connection
[task 2024-11-30T06:51:47.489Z] 06:51:47  WARNING - Traceback (most recent call last):
[task 2024-11-30T06:51:47.489Z] 06:51:47  WARNING -   File "/opt/worker/tasks/task_173294376793584/build/tests/web-platform/tests/tools/wptrunner/wptrunner/executors/protocol.py", line 64, in setup
[task 2024-11-30T06:51:47.489Z] 06:51:47  WARNING -     self.connect()
[task 2024-11-30T06:51:47.489Z] 06:51:47  WARNING -   File "/opt/worker/tasks/task_173294376793584/build/tests/web-platform/tests/tools/wptrunner/wptrunner/executors/executormarionette.py", line 783, in connect
[task 2024-11-30T06:51:47.489Z] 06:51:47  WARNING -     self.marionette.raise_for_port()
[task 2024-11-30T06:51:47.489Z] 06:51:47  WARNING -   File "/opt/worker/tasks/task_173294376793584/build/venv/lib/python3.11/site-packages/marionette_driver/marionette.py", line 744, in raise_for_port
[task 2024-11-30T06:51:47.489Z] 06:51:47  WARNING -     raise socket.timeout(
[task 2024-11-30T06:51:47.489Z] 06:51:47  WARNING - TimeoutError: Timed out waiting for connection on 127.0.0.1:55502!
[task 2024-11-30T06:51:47.489Z] 06:51:47  WARNING - 
[task 2024-11-30T06:51:47.534Z] 06:51:47     INFO - Browser exited with return code -15
[task 2024-11-30T06:51:47.535Z] 06:51:47  WARNING - Firefox didn't exit cleanly, not processing leak logs
[task 2024-11-30T06:51:47.536Z] 06:51:47     INFO - Closing logging queue
[task 2024-11-30T06:51:47.536Z] 06:51:47     INFO - queue closed
[task 2024-11-30T06:51:47.537Z] 06:51:47 CRITICAL - Max restarts exceeded
[task 2024-11-30T06:51:47.539Z] 06:51:47  WARNING - Firefox didn't exit cleanly, not processing leak logs
[task 2024-11-30T06:51:47.557Z] 06:51:47     INFO - Browser exited with return code -15
[task 2024-11-30T06:51:47.559Z] 06:51:47     INFO - SUITE-END | took 2023s
[task 2024-11-30T06:51:47.561Z] 06:51:47     INFO - Got 0 unexpected results, with 0 unexpected passes
[task 2024-11-30T06:51:47.563Z] 06:51:47     INFO - wptserve Stopped WebTransport over HTTP/3 server on 127.0.0.1:11000
[task 2024-11-30T06:51:47.566Z] 06:51:47     INFO - wptserve Stopped http server on 127.0.0.1:8444
[task 2024-11-30T06:51:47.585Z] 06:51:47     INFO - wptserve Stopped http server on 127.0.0.1:9000
[task 2024-11-30T06:51:47.627Z] 06:51:47     INFO - wptserve Stopped http server on 127.0.0.1:8000
[task 2024-11-30T06:51:47.641Z] 06:51:47     INFO - wptserve Stopped http server on 127.0.0.1:8003
[task 2024-11-30T06:51:47.652Z] 06:51:47     INFO - wptserve Stopped http server on 127.0.0.1:8001
[task 2024-11-30T06:51:47.653Z] 06:51:47     INFO - wptserve Stopped http server on 127.0.0.1:8443
[task 2024-11-30T06:51:47.664Z] 06:51:47     INFO - wptserve Stopped http server on 127.0.0.1:8446
[task 2024-11-30T06:51:47.670Z] 06:51:47     INFO - wptserve Stopped http server on 127.0.0.1:8445
[task 2024-11-30T06:51:47.680Z] 06:51:47     INFO - wptserve Stopped http server on 127.0.0.1:8002
[task 2024-11-30T06:51:47.920Z] 06:51:47     INFO - wptserve Close on: (<AddressFamily.AF_INET: 2>, <SocketKind.SOCK_STREAM: 1>, 6, '', ('127.0.0.1', 8888))
[task 2024-11-30T06:51:48.020Z] 06:51:48     INFO - wptserve Close on: (<AddressFamily.AF_INET: 2>, <SocketKind.SOCK_STREAM: 1>, 6, '', ('127.0.0.1', 8889))
[task 2024-11-30T06:51:48.061Z] 06:51:48     INFO - Removed font: Ahem.ttf
[task 2024-11-30T06:51:48.118Z] 06:51:48     INFO - Closing logging queue
[task 2024-11-30T06:51:48.118Z] 06:51:48     INFO - queue closed
[task 2024-11-30T06:51:48.145Z] 06:51:48  WARNING - All requested tests were skipped
[task 2024-11-30T06:51:48.634Z] 06:51:48     INFO - Test harness output was not a valid structured log message
[task 2024-11-30T06:51:48.634Z] 06:51:48     INFO - /Library/Frameworks/Python.framework/Versions/3.11/lib/python3.11/multiprocessing/resource_tracker.py:224: UserWarning: resource_tracker: There appear to be 3 leaked semaphore objects to clean up at shutdown
[task 2024-11-30T06:51:48.634Z] 06:51:48     INFO -   warnings.warn('resource_tracker: There appear to be %d '
[task 2024-11-30T06:51:48.639Z] 06:51:48     INFO - Return code: 1

Tier 1 failure here.

Summary: Intermittent [tier 2] Max restarts exceeded → Intermittent Max restarts exceeded
You need to log in before you can comment on or make changes to this bug.