Closed Bug 1884739 Opened 2 years ago Closed 2 years ago

Intermittent taskcluster/test/test_generate_params.py::test_generate_graphs[try] TEST-UNEXPECTED-FAIL

Categories

(Firefox Build System :: Task Configuration, defect, P5)

Product:
Firefox Build System
Component:
Task Configuration
Type:
defect

Tracking

(Not tracked)

Status:
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=450340408&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/OGUa5FqyQue-5Poz60VAQQ/runs/0/artifacts/public/logs/live_backing.log

 taskcluster/test/test_generate_params.py::test_generate_graphs[mb-ship-devedition] PASSED
[task 2024-03-11T17:12:10.518Z] taskcluster/test/test_generate_params.py::test_generate_graphs[try] TEST-UNEXPECTED-FAIL
[task 2024-03-11T17:12:10.518Z] taskcluster/test/test_generate_params.py::test_generate_graphs[mb-ship-firefox-partials] PASSED
<...>
taskcluster/test/test_generate_params.py::test_generate_graphs[mb-ship-firefox] PASSED
[task 2024-03-11T17:12:10.518Z] 
[task 2024-03-11T17:12:10.518Z] =================================== FAILURES ===================================
[task 2024-03-11T17:12:10.518Z] __________________________ test_generate_graphs[try] ___________________________
[task 2024-03-11T17:12:10.518Z] taskcluster/test/test_generate_params.py:55: in test_generate_graphs
[task 2024-03-11T17:12:10.518Z]     pytest.fail("An exception was raised during graph generation!")
[task 2024-03-11T17:12:10.518Z] E   Failed: An exception was raised during graph generation!
[task 2024-03-11T17:12:10.518Z] ----------------------------- Captured stdout call -----------------------------
[task 2024-03-11T17:12:10.518Z] concurrent.futures.process._RemoteTraceback:
[task 2024-03-11T17:12:10.518Z] """
[task 2024-03-11T17:12:10.518Z] Traceback (most recent call last):
[task 2024-03-11T17:12:10.518Z]   File "/builds/worker/checkouts/gecko/third_party/python/urllib3/urllib3/connectionpool.py", line 466, in _make_request
[task 2024-03-11T17:12:10.518Z]     six.raise_from(e, None)
[task 2024-03-11T17:12:10.518Z]   File "<string>", line 3, in raise_from
[task 2024-03-11T17:12:10.518Z]   File "/builds/worker/checkouts/gecko/third_party/python/urllib3/urllib3/connectionpool.py", line 461, in _make_request
[task 2024-03-11T17:12:10.518Z]     httplib_response = conn.getresponse()
[task 2024-03-11T17:12:10.518Z]   File "/builds/worker/fetches/python/lib/python3.8/http/client.py", line 1344, in getresponse
[task 2024-03-11T17:12:10.518Z]     response.begin()
[task 2024-03-11T17:12:10.518Z]   File "/builds/worker/fetches/python/lib/python3.8/http/client.py", line 307, in begin
[task 2024-03-11T17:12:10.518Z]     version, status, reason = self._read_status()
[task 2024-03-11T17:12:10.518Z]   File "/builds/worker/fetches/python/lib/python3.8/http/client.py", line 268, in _read_status
[task 2024-03-11T17:12:10.518Z]     line = str(self.fp.readline(_MAXLINE + 1), "iso-8859-1")
[task 2024-03-11T17:12:10.518Z]   File "/builds/worker/fetches/python/lib/python3.8/socket.py", line 669, in readinto
[task 2024-03-11T17:12:10.518Z]     return self._sock.recv_into(b)
[task 2024-03-11T17:12:10.518Z]   File "/builds/worker/fetches/python/lib/python3.8/ssl.py", line 1241, in recv_into
[task 2024-03-11T17:12:10.518Z]     return self.read(nbytes, buffer)
[task 2024-03-11T17:12:10.518Z]   File "/builds/worker/fetches/python/lib/python3.8/ssl.py", line 1099, in read
[task 2024-03-11T17:12:10.518Z]     return self._sslobj.read(len, buffer)
[task 2024-03-11T17:12:10.518Z] socket.timeout: The read operation timed out
[task 2024-03-11T17:12:10.518Z] 
[task 2024-03-11T17:12:10.518Z] During handling of the above exception, another exception occurred:
[task 2024-03-11T17:12:10.518Z] 
[task 2024-03-11T17:12:10.518Z] Traceback (most recent call last):
[task 2024-03-11T17:12:10.518Z]   File "/builds/worker/checkouts/gecko/third_party/python/requests/requests/adapters.py", line 486, in send
[task 2024-03-11T17:12:10.518Z]     resp = conn.urlopen(
[task 2024-03-11T17:12:10.518Z]   File "/builds/worker/checkouts/gecko/third_party/python/urllib3/urllib3/connectionpool.py", line 798, in urlopen
[task 2024-03-11T17:12:10.518Z]     retries = retries.increment(
[task 2024-03-11T17:12:10.518Z]   File "/builds/worker/checkouts/gecko/third_party/python/urllib3/urllib3/util/retry.py", line 550, in increment
[task 2024-03-11T17:12:10.518Z]     raise six.reraise(type(error), error, _stacktrace)
[task 2024-03-11T17:12:10.518Z]   File "/builds/worker/checkouts/gecko/third_party/python/urllib3/urllib3/packages/six.py", line 770, in reraise
[task 2024-03-11T17:12:10.518Z]     raise value
[task 2024-03-11T17:12:10.518Z]   File "/builds/worker/checkouts/gecko/third_party/python/urllib3/urllib3/connectionpool.py", line 714, in urlopen
httplib_response = self._make_request(
[task 2024-03-11T17:12:10.518Z]   File "/builds/worker/checkouts/gecko/third_party/python/urllib3/urllib3/connectionpool.py", line 468, in _make_request
[task 2024-03-11T17:12:10.518Z]     self._raise_timeout(err=e, url=url, timeout_value=read_timeout)
[task 2024-03-11T17:12:10.518Z]   File "/builds/worker/checkouts/gecko/third_party/python/urllib3/urllib3/connectionpool.py", line 357, in _raise_timeout
[task 2024-03-11T17:12:10.518Z]     raise ReadTimeoutError(
[task 2024-03-11T17:12:10.518Z] urllib3.exceptions.ReadTimeoutError: HTTPSConnectionPool(host='hg.mozilla.org', port=443): Read timed out. (read timeout=30)
[task 2024-03-11T17:12:10.518Z] 
[task 2024-03-11T17:12:10.518Z] During handling of the above exception, another exception occurred:
[task 2024-03-11T17:12:10.518Z] 
[task 2024-03-11T17:12:10.518Z] Traceback (most recent call last):
[task 2024-03-11T17:12:10.518Z]   File "/builds/worker/fetches/python/lib/python3.8/concurrent/futures/process.py", line 239, in _process_worker
[task 2024-03-11T17:12:10.518Z]     r = call_item.fn(*call_item.args, **call_item.kwargs)
[task 2024-03-11T17:12:10.518Z]   File "/builds/worker/checkouts/gecko/taskcluster/gecko_taskgraph/main.py", line 157, in format_taskgraph
[task 2024-03-11T17:12:10.518Z]     tg = getattr(tgg, options["graph_attr"])
[task 2024-03-11T17:12:10.518Z]   File "/builds/worker/checkouts/gecko/third_party/python/taskcluster_taskgraph/taskgraph/generator.py", line 220, in morphed_task_graph
[task 2024-03-11T17:12:10.518Z]     return self._run_until("morphed_task_graph")
[task 2024-03-11T17:12:10.518Z]   File "/builds/worker/checkouts/gecko/third_party/python/taskcluster_taskgraph/taskgraph/generator.py", line 425, in _run_until
[task 2024-03-11T17:12:10.518Z]     k, v = next(self._run)
[task 2024-03-11T17:12:10.518Z]   File "/builds/worker/checkouts/gecko/third_party/python/taskcluster_taskgraph/taskgraph/generator.py", line 399, in _run
[task 2024-03-11T17:12:10.518Z]     optimized_task_graph, label_to_taskid = optimize_task_graph(
[task 2024-03-11T17:12:10.518Z]   File "/builds/worker/checkouts/gecko/third_party/python/taskcluster_taskgraph/taskgraph/optimize/base.py", line 65, in optimize_task_graph
[task 2024-03-11T17:12:10.518Z]     removed_tasks = remove_tasks(
[task 2024-03-11T17:12:10.518Z]   File "/builds/worker/checkouts/gecko/third_party/python/taskcluster_taskgraph/taskgraph/optimize/base.py", line 217, in remove_tasks
[task 2024-03-11T17:12:10.518Z]     if opt.should_remove_task(task, params, arg):
[task 2024-03-11T17:12:10.518Z]   File "/builds/worker/checkouts/gecko/third_party/python/taskcluster_taskgraph/taskgraph/optimize/strategies.py", line 56, in should_remove_task
[task 2024-03-11T17:12:10.518Z]     changed = files_changed.check(params, file_patterns)
[task 2024-03-11T17:12:10.518Z]   File "/builds/worker/checkouts/gecko/third_party/python/taskcluster_taskgraph/taskgraph/files_changed.py", line 84, in check
[task 2024-03-11T17:12:10.518Z]     changed_files = get_changed_files(head_repository_url, head_rev, base_rev)
[task 2024-03-11T17:12:10.518Z]   File "/builds/worker/checkouts/gecko/third_party/python/taskcluster_taskgraph/taskgraph/util/memoize.py", line 25, in __call__
[task 2024-03-11T17:12:10.518Z]     self[args] = self.func(*args)
[task 2024-03-11T17:12:10.518Z]   File "/builds/worker/checkouts/gecko/third_party/python/taskcluster_taskgraph/taskgraph/files_changed.py", line 34, in get_changed_files
[task 2024-03-11T17:12:10.518Z]     return _get_changed_files_json_automationrelevance(
[task 2024-03-11T17:12:10.518Z]   File "/builds/worker/checkouts/gecko/third_party/python/taskcluster_taskgraph/taskgraph/files_changed.py", line 54, in _get_changed_files_json_automationrelevance
[task 2024-03-11T17:12:10.518Z]     contents = retry(get_automationrelevance, attempts=10, sleeptime=10)
[task 2024-03-11T17:12:10.518Z]   File "/builds/worker/checkouts/gecko/third_party/python/redo/redo/__init__.py", line 185, in retry
[task 2024-03-11T17:12:10.518Z]     return action(*args, **kwargs)
[task 2024-03-11T17:12:10.518Z]   File "/builds/worker/checkouts/gecko/third_party/python/taskcluster_taskgraph/taskgraph/files_changed.py", line 51, in get_automationrelevance
[task 2024-03-11T17:12:10.518Z]     response = requests.get(url, timeout=30)
[task 2024-03-11T17:12:10.518Z]   File "/builds/worker/checkouts/gecko/third_party/python/requests/requests/api.py", line 73, in get
return request("get", url, params=params, **kwargs)
[task 2024-03-11T17:12:10.518Z]   File "/builds/worker/checkouts/gecko/third_party/python/requests/requests/api.py", line 59, in request
[task 2024-03-11T17:12:10.518Z]     return session.request(method=method, url=url, **kwargs)
[task 2024-03-11T17:12:10.518Z]   File "/builds/worker/checkouts/gecko/third_party/python/requests/requests/sessions.py", line 589, in request
[task 2024-03-11T17:12:10.518Z]     resp = self.send(prep, **send_kwargs)
[task 2024-03-11T17:12:10.518Z]   File "/builds/worker/checkouts/gecko/third_party/python/requests/requests/sessions.py", line 703, in send
[task 2024-03-11T17:12:10.518Z]     r = adapter.send(request, **kwargs)
[task 2024-03-11T17:12:10.518Z]   File "/builds/worker/checkouts/gecko/third_party/python/requests/requests/adapters.py", line 532, in send
[task 2024-03-11T17:12:10.518Z]     raise ReadTimeout(e, request=request)
[task 2024-03-11T17:12:10.518Z] requests.exceptions.ReadTimeout: HTTPSConnectionPool(host='hg.mozilla.org', port=443): Read timed out. (read timeout=30)
[task 2024-03-11T17:12:10.518Z] """
[task 2024-03-11T17:12:10.518Z] 
[task 2024-03-11T17:12:10.518Z] The above exception was the direct cause of the following exception:
[task 2024-03-11T17:12:10.518Z] 
[task 2024-03-11T17:12:10.518Z] requests.exceptions.ReadTimeout: None: None
[task 2024-03-11T17:12:10.518Z] 
[task 2024-03-11T17:12:10.518Z] 
[task 2024-03-11T17:12:10.518Z] 
[task 2024-03-11T17:12:10.518Z] ================== 1 failed, 28 passed in 2538.00s (0:42:17) ===================
[task 2024-03-11T17:12:10.518Z] 
[task 2024-03-11T17:12:10.518Z] 
[task 2024-03-11T17:12:10.518Z] Tests Completed: 100%|██████████| 6/6 [42:19<00:00, 423.18s/Test]Return code from mach python-test: 1
[task 2024-03-11T17:12:10.553Z] 
[taskcluster 2024-03-11 17:12:11.050Z] === Task Finished ===
[taskcluster 2024-03-11 17:12:11.050Z] Unsuccessful task run with exit code: 1 completed in 2563.991 seconds

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit BugBot documentation.

Status: NEW → RESOLVED
Closed: 2 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.