[taskcluster 2025-10-16 18:01:56.169Z] Task ID: bPkGlDclR9eLgLqxqWeedA
[taskcluster 2025-10-16 18:01:56.169Z] Worker ID: 5258743847019383849
[taskcluster 2025-10-16 18:01:56.169Z] Worker Group: us-west1-a
[taskcluster 2025-10-16 18:01:56.169Z] Worker Node Type: projects/887720501152/machineTypes/n2-standard-2
[taskcluster 2025-10-16 18:01:56.169Z] Worker Pool: taskgraph-1/decision-gcp
[taskcluster 2025-10-16 18:01:56.169Z] Worker Version: 38.0.5
[taskcluster 2025-10-16 18:01:56.169Z] Public IP: 34.83.200.48
[taskcluster 2025-10-16 18:01:56.169Z] Hostname: taskgraph-1-decision-gcp-yhlukrmxsm6xof72w8c9ia
[taskcluster 2025-10-16 18:01:56.169Z] using cache "taskgraph-level-1-checkouts-sparse-v2" -> /builds/worker/checkouts

7d921eadec7b - Started downloading
b6a7b67a3f4c - Started downloading
7d921eadec7b - Downloaded in 0.077 seconds
3d0eb16c9df1 - Started downloading
b6a7b67a3f4c - Downloaded in 0.332 seconds
1bb072c57b89 - Started downloading
1bb072c57b89 - Downloaded in 0 seconds
3d0eb16c9df1 - Downloaded in 1.596 seconds
Digest: sha256:cd82d92f7f2be8b4fe772335eb3f370854789cc2415d61e2e322fee7f9a47c19
Status: Downloaded newer image for mozillareleases/taskgraph:decision-latest

...(269 lines hidden)...

[task 2025-10-16T18:02:18.683+00:00] 2025-10-16 18:02:18,683 - DEBUG - replace_tasks: docker-image-python kept by optimization strategy
[task 2025-10-16T18:02:18.683+00:00] 2025-10-16 18:02:18,683 - DEBUG - replace_tasks: docker-image-run-task
[task 2025-10-16T18:02:18.683+00:00] 2025-10-16 18:02:18,683 - DEBUG - replace_tasks: docker-image-run-task replaced with Wug6clNET7Sb6qdNIrF_JA by optimization strategy
[task 2025-10-16T18:02:18.683+00:00] 2025-10-16 18:02:18,683 - DEBUG - replace_tasks: docker-image-skopeo
[task 2025-10-16T18:02:18.684+00:00] 2025-10-16 18:02:18,684 - DEBUG - replace_tasks: docker-image-skopeo replaced with Pt_c0cp3SA-dGWvuUiqMsw by optimization strategy
[task 2025-10-16T18:02:18.684+00:00] 2025-10-16 18:02:18,684 - DEBUG - replace_tasks: fetch-codecov-uploader
[task 2025-10-16T18:02:18.684+00:00] 2025-10-16 18:02:18,684 - DEBUG - replace_tasks: fetch-codecov-uploader replaced with LnvkOPXFTyWWUX9mA1UwRQ by optimization strategy
[task 2025-10-16T18:02:18.684+00:00] 2025-10-16 18:02:18,684 - DEBUG - replace_tasks: test-unit-py310
[task 2025-10-16T18:02:18.684+00:00] 2025-10-16 18:02:18,684 - DEBUG - replace_tasks: test-unit-py310 depends on an unreplaced or unremoved task
[task 2025-10-16T18:02:18.684+00:00] 2025-10-16 18:02:18,684 - DEBUG - replace_tasks: test-unit-py311
[task 2025-10-16T18:02:18.684+00:00] 2025-10-16 18:02:18,684 - DEBUG - replace_tasks: test-unit-py311 depends on an unreplaced or unremoved task
[task 2025-10-16T18:02:18.684+00:00] 2025-10-16 18:02:18,684 - DEBUG - replace_tasks: test-unit-py312
[task 2025-10-16T18:02:18.684+00:00] 2025-10-16 18:02:18,684 - DEBUG - replace_tasks: test-unit-py312 depends on an unreplaced or unremoved task
[task 2025-10-16T18:02:18.684+00:00] 2025-10-16 18:02:18,684 - DEBUG - replace_tasks: test-unit-py313
[task 2025-10-16T18:02:18.685+00:00] 2025-10-16 18:02:18,685 - DEBUG - replace_tasks: test-unit-py313 depends on an unreplaced or unremoved task
[task 2025-10-16T18:02:18.685+00:00] 2025-10-16 18:02:18,685 - DEBUG - replace_tasks: test-unit-py39
[task 2025-10-16T18:02:18.685+00:00] 2025-10-16 18:02:18,685 - DEBUG - replace_tasks: test-unit-py39 depends on an unreplaced or unremoved task
[task 2025-10-16T18:02:18.685+00:00] 2025-10-16 18:02:18,685 - DEBUG - replace_tasks: check-type
[task 2025-10-16T18:02:18.685+00:00] 2025-10-16 18:02:18,685 - DEBUG - replace_tasks: check-type depends on an unreplaced or unremoved task
[task 2025-10-16T18:02:18.685+00:00] 2025-10-16 18:02:18,685 - DEBUG - replace_tasks: codecov-upload
[task 2025-10-16T18:02:18.685+00:00] 2025-10-16 18:02:18,685 - DEBUG - replace_tasks: codecov-upload depends on an unreplaced or unremoved task
[task 2025-10-16T18:02:18.685+00:00] 2025-10-16 18:02:18,685 - DEBUG - replace_tasks: complete-pr
[task 2025-10-16T18:02:18.685+00:00] 2025-10-16 18:02:18,685 - DEBUG - replace_tasks: complete-pr depends on an unreplaced or unremoved task
[task 2025-10-16T18:02:18.685+00:00] 2025-10-16 18:02:18,685 - DEBUG - replace_tasks: doc-generate
[task 2025-10-16T18:02:18.685+00:00] 2025-10-16 18:02:18,685 - DEBUG - replace_tasks: doc-generate depends on an unreplaced or unremoved task
[task 2025-10-16T18:02:18.686+00:00] 2025-10-16 18:02:18,685 - DEBUG - replace_tasks: docker-image-decision
[task 2025-10-16T18:02:18.686+00:00] 2025-10-16 18:02:18,686 - DEBUG - replace_tasks: docker-image-decision kept by optimization strategy
[task 2025-10-16T18:02:18.686+00:00] 2025-10-16 18:02:18,686 - INFO - Replaced 5 tasks by index-search (index-search) during optimization.
[task 2025-10-16T18:02:18.687+00:00] 2025-10-16 18:02:18,687 - DEBUG - Morphing: adding index tasks
[task 2025-10-16T18:02:18.687+00:00] 2025-10-16 18:02:18,687 - DEBUG - Morphing: adding code review task
[task 2025-10-16T18:02:18.688+00:00] 2025-10-16 18:02:18,687 - INFO - writing artifact file `task-graph.json`
[task 2025-10-16T18:02:18.688+00:00] 2025-10-16 18:02:18,688 - INFO - writing artifact file `label-to-taskid.json`
[task 2025-10-16T18:02:18.690+00:00] 2025-10-16 18:02:18,690 - INFO - Creating task with taskId NsMUVwKsQRue5yu4zXGXsw for docker-image-python
[task 2025-10-16T18:02:18.690+00:00] 2025-10-16 18:02:18,690 - INFO - Creating task with taskId ZcfbPbzGQ_e7QVSfuLFibQ for docker-image-decision
[task 2025-10-16T18:02:18.691+00:00] 2025-10-16 18:02:18,690 - DEBUG - Using method(v1, v2, payload) calling convention
[task 2025-10-16T18:02:18.691+00:00] 2025-10-16 18:02:18,691 - DEBUG - Found a positional argument: ZcfbPbzGQ_e7QVSfuLFibQ
[task 2025-10-16T18:02:18.691+00:00] 2025-10-16 18:02:18,691 - DEBUG - After processing positional arguments, we have: {'taskId': 'ZcfbPbzGQ_e7QVSfuLFibQ'}
[task 2025-10-16T18:02:18.691+00:00] 2025-10-16 18:02:18,691 - DEBUG - After keyword arguments, we have: {'taskId': 'ZcfbPbzGQ_e7QVSfuLFibQ'}
[task 2025-10-16T18:02:18.691+00:00] 2025-10-16 18:02:18,691 - DEBUG - Full URL used is: http://taskcluster/api/queue/v1/task/ZcfbPbzGQ_e7QVSfuLFibQ
[task 2025-10-16T18:02:18.691+00:00] 2025-10-16 18:02:18,691 - DEBUG - Not using hawk!
[task 2025-10-16T18:02:18.691+00:00] 2025-10-16 18:02:18,691 - DEBUG - Making attempt 0
[task 2025-10-16T18:02:18.691+00:00] 2025-10-16 18:02:18,691 - DEBUG - Making a PUT request to http://taskcluster/api/queue/v1/task/ZcfbPbzGQ_e7QVSfuLFibQ
[task 2025-10-16T18:02:18.691+00:00] 2025-10-16 18:02:18,691 - DEBUG - HTTP Headers: {'Content-Type': 'application/json'}
[task 2025-10-16T18:02:18.691+00:00] 2025-10-16 18:02:18,691 - DEBUG - HTTP Payload: {"provisionerId":"taskgraph-1","workerType":"images-gcp","routes":["index.taskgraph.cache.pr.docker- (limit 100 char)
[task 2025-10-16T18:02:18.692+00:00] 2025-10-16 18:02:18,692 - DEBUG - Starting new HTTP connection (1): taskcluster:80
[task 2025-10-16T18:02:18.693+00:00] 2025-10-16 18:02:18,690 - DEBUG - Using method(v1, v2, payload) calling convention
[task 2025-10-16T18:02:18.693+00:00] 2025-10-16 18:02:18,692 - DEBUG - Found a positional argument: NsMUVwKsQRue5yu4zXGXsw
[task 2025-10-16T18:02:18.693+00:00] 2025-10-16 18:02:18,692 - DEBUG - After processing positional arguments, we have: {'taskId': 'NsMUVwKsQRue5yu4zXGXsw'}
[task 2025-10-16T18:02:18.693+00:00] 2025-10-16 18:02:18,692 - DEBUG - After keyword arguments, we have: {'taskId': 'NsMUVwKsQRue5yu4zXGXsw'}
[task 2025-10-16T18:02:18.693+00:00] 2025-10-16 18:02:18,693 - DEBUG - Full URL used is: http://taskcluster/api/queue/v1/task/NsMUVwKsQRue5yu4zXGXsw
[task 2025-10-16T18:02:18.693+00:00] 2025-10-16 18:02:18,693 - DEBUG - Not using hawk!
[task 2025-10-16T18:02:18.693+00:00] 2025-10-16 18:02:18,693 - DEBUG - Making attempt 0
[task 2025-10-16T18:02:18.693+00:00] 2025-10-16 18:02:18,693 - DEBUG - Making a PUT request to http://taskcluster/api/queue/v1/task/NsMUVwKsQRue5yu4zXGXsw
[task 2025-10-16T18:02:18.693+00:00] 2025-10-16 18:02:18,693 - DEBUG - HTTP Headers: {'Content-Type': 'application/json'}
[task 2025-10-16T18:02:18.693+00:00] 2025-10-16 18:02:18,693 - DEBUG - HTTP Payload: {"provisionerId":"taskgraph-1","workerType":"images-gcp","routes":["index.taskgraph.cache.pr.docker- (limit 100 char)
[task 2025-10-16T18:02:18.694+00:00] 2025-10-16 18:02:18,694 - DEBUG - Starting new HTTP connection (1): taskcluster:80
[task 2025-10-16T18:02:18.808+00:00] 2025-10-16 18:02:18,808 - DEBUG - http://taskcluster:80 "PUT /api/queue/v1/task/NsMUVwKsQRue5yu4zXGXsw HTTP/1.1" 200 436
[task 2025-10-16T18:02:18.809+00:00] 2025-10-16 18:02:18,809 - DEBUG - Received HTTP Status:    200
[task 2025-10-16T18:02:18.809+00:00] 2025-10-16 18:02:18,809 - DEBUG - Received HTTP Headers: {'Accept-Ranges': 'bytes', 'Access-Control-Allow-Headers': 'X-Requested-With,Content-Type,Authorization,Accept,Origin,Cache-Control', 'Access-Control-Allow-Methods': 'OPTIONS,GET,HEAD,POST,PUT,DELETE,TRACE,CONNECT', 'Access-Control-Allow-Origin': '*', 'Access-Control-Max-Age': '900', 'Access-Control-Request-Method': '*', 'Cache-Control': 'no-store no-cache must-revalidate', 'Content-Length': '436', 'Content-Security-Policy': "report-uri /__cspreport__;default-src 'none';frame-ancestors 'none';", 'Content-Type': 'application/json; charset=utf-8', 'Date': 'Thu, 16 Oct 2025 18:02:18 GMT', 'Etag': 'W/"1b4-V7Alflh/xibHJ+rdWTxFVAu9NeA"', 'Server': 'openresty', 'Strict-Transport-Security': 'max-age=31536000', 'Vary': 'Accept-Encoding', 'Via': '1.1 google, 1.1 varnish, 1.1 varnish', 'X-Cache': 'MISS, MISS', 'X-Cache-Hits': '0, 0', 'X-Content-Type-Options': 'nosniff', 'X-For-Request-Id': '84636ab9-6bd4-48f3-b587-e439609cf5c0', 'X-For-Trace-Id': '22bf1604a36435e059437a1faca157d2', 'X-Served-By': 'cache-bfi-kbfi7400088-BFI, cache-bfi-kbfi7400088-BFI', 'X-Taskcluster-Authorized-Scopes': '["assume:repo:github.com/taskcluster/taskgraph:pull-request","queue:create-artifact:bPkGlDclR9eLgLqxqWeedA/0"]', 'X-Taskcluster-Endpoint': 'https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/NsMUVwKsQRue5yu4zXGXsw', 'X-Taskcluster-Proxy-Revision': '', 'X-Taskcluster-Proxy-Temp-Clientid': 'task-client/bPkGlDclR9eLgLqxqWeedA/0/on/us-west1-a/5258743847019383849/until/1760638916.099', 'X-Taskcluster-Proxy-Temp-Scopes': '["queue:reclaim-task:bPkGlDclR9eLgLqxqWeedA/0","queue:resolve-task:bPkGlDclR9eLgLqxqWeedA/0","queue:create-artifact:bPkGlDclR9eLgLqxqWeedA/0","assume:repo:github.com/taskcluster/taskgraph:pull-request"]', 'X-Taskcluster-Proxy-Version': '38.0.5', 'X-Timer': 'S1760637739.698357,VS0,VE105'}
[task 2025-10-16T18:02:18.810+00:00] 2025-10-16 18:02:18,810 - INFO - Creating task with taskId eaXreDsASfKS2Komvrh8pA for test-unit-py310
[task 2025-10-16T18:02:18.811+00:00] 2025-10-16 18:02:18,811 - INFO - Creating task with taskId R6mkstoCQ1m6qP_8VmCwTQ for doc-generate
[task 2025-10-16T18:02:18.812+00:00] 2025-10-16 18:02:18,812 - DEBUG - Using method(v1, v2, payload) calling convention
[task 2025-10-16T18:02:18.813+00:00] 2025-10-16 18:02:18,811 - DEBUG - Using method(v1, v2, payload) calling convention
[task 2025-10-16T18:02:18.814+00:00] 2025-10-16 18:02:18,812 - INFO - Creating task with taskId dVX6YN-rS16w9lwl-n68JQ for test-unit-py311
[task 2025-10-16T18:02:18.815+00:00] 2025-10-16 18:02:18,811 - INFO - Creating task with taskId Vx-MI97PScaeU8IS9zjYfQ for test-unit-py313
[task 2025-10-16T18:02:18.815+00:00] 2025-10-16 18:02:18,813 - INFO - Creating task with taskId f3wy6JiNQ0Wj9VLWN9lz4A for check-type
[task 2025-10-16T18:02:18.815+00:00] 2025-10-16 18:02:18,813 - DEBUG - Found a positional argument: R6mkstoCQ1m6qP_8VmCwTQ
[task 2025-10-16T18:02:18.816+00:00] 2025-10-16 18:02:18,815 - DEBUG - After processing positional arguments, we have: {'taskId': 'R6mkstoCQ1m6qP_8VmCwTQ'}
[task 2025-10-16T18:02:18.816+00:00] 2025-10-16 18:02:18,815 - DEBUG - After keyword arguments, we have: {'taskId': 'R6mkstoCQ1m6qP_8VmCwTQ'}
[task 2025-10-16T18:02:18.816+00:00] 2025-10-16 18:02:18,816 - DEBUG - Full URL used is: http://taskcluster/api/queue/v1/task/R6mkstoCQ1m6qP_8VmCwTQ
[task 2025-10-16T18:02:18.816+00:00] 2025-10-16 18:02:18,814 - DEBUG - Using method(v1, v2, payload) calling convention
[task 2025-10-16T18:02:18.817+00:00] 2025-10-16 18:02:18,816 - DEBUG - Found a positional argument: dVX6YN-rS16w9lwl-n68JQ
[task 2025-10-16T18:02:18.818+00:00] 2025-10-16 18:02:18,816 - DEBUG - After processing positional arguments, we have: {'taskId': 'dVX6YN-rS16w9lwl-n68JQ'}
[task 2025-10-16T18:02:18.818+00:00] 2025-10-16 18:02:18,816 - DEBUG - After keyword arguments, we have: {'taskId': 'dVX6YN-rS16w9lwl-n68JQ'}
[task 2025-10-16T18:02:18.818+00:00] 2025-10-16 18:02:18,817 - DEBUG - Full URL used is: http://taskcluster/api/queue/v1/task/dVX6YN-rS16w9lwl-n68JQ
[task 2025-10-16T18:02:18.818+00:00] 2025-10-16 18:02:18,814 - DEBUG - Found a positional argument: eaXreDsASfKS2Komvrh8pA
[task 2025-10-16T18:02:18.818+00:00] 2025-10-16 18:02:18,817 - DEBUG - After processing positional arguments, we have: {'taskId': 'eaXreDsASfKS2Komvrh8pA'}
[task 2025-10-16T18:02:18.818+00:00] 2025-10-16 18:02:18,817 - DEBUG - After keyword arguments, we have: {'taskId': 'eaXreDsASfKS2Komvrh8pA'}
[task 2025-10-16T18:02:18.818+00:00] 2025-10-16 18:02:18,817 - DEBUG - Full URL used is: http://taskcluster/api/queue/v1/task/eaXreDsASfKS2Komvrh8pA
[task 2025-10-16T18:02:18.818+00:00] 2025-10-16 18:02:18,816 - DEBUG - Not using hawk!
[task 2025-10-16T18:02:18.819+00:00] 2025-10-16 18:02:18,818 - DEBUG - Making attempt 0
[task 2025-10-16T18:02:18.819+00:00] 2025-10-16 18:02:18,818 - DEBUG - Not using hawk!
[task 2025-10-16T18:02:18.819+00:00] 2025-10-16 18:02:18,815 - DEBUG - Using method(v1, v2, payload) calling convention
[task 2025-10-16T18:02:18.819+00:00] 2025-10-16 18:02:18,819 - DEBUG - Found a positional argument: f3wy6JiNQ0Wj9VLWN9lz4A
[task 2025-10-16T18:02:18.819+00:00] 2025-10-16 18:02:18,819 - DEBUG - After processing positional arguments, we have: {'taskId': 'f3wy6JiNQ0Wj9VLWN9lz4A'}
[task 2025-10-16T18:02:18.819+00:00] 2025-10-16 18:02:18,814 - INFO - Creating task with taskId NFbsUhocREO13vDauQF8Hg for test-unit-py312
[task 2025-10-16T18:02:18.820+00:00] 2025-10-16 18:02:18,817 - DEBUG - Not using hawk!
[task 2025-10-16T18:02:18.821+00:00] 2025-10-16 18:02:18,818 - DEBUG - Making a PUT request to http://taskcluster/api/queue/v1/task/R6mkstoCQ1m6qP_8VmCwTQ
[task 2025-10-16T18:02:18.821+00:00] 2025-10-16 18:02:18,820 - DEBUG - HTTP Headers: {'Content-Type': 'application/json'}
[task 2025-10-16T18:02:18.821+00:00] 2025-10-16 18:02:18,820 - DEBUG - HTTP Payload: {"provisionerId":"taskgraph-t","workerType":"linux-gcp","routes":["tc-treeherder.v2.taskgraph-pr.003 (limit 100 char)
[task 2025-10-16T18:02:18.821+00:00] 2025-10-16 18:02:18,819 - DEBUG - After keyword arguments, we have: {'taskId': 'f3wy6JiNQ0Wj9VLWN9lz4A'}
[task 2025-10-16T18:02:18.822+00:00] 2025-10-16 18:02:18,819 - DEBUG - Making attempt 0
[task 2025-10-16T18:02:18.822+00:00] 2025-10-16 18:02:18,822 - DEBUG - Making a PUT request to http://taskcluster/api/queue/v1/task/eaXreDsASfKS2Komvrh8pA
[task 2025-10-16T18:02:18.823+00:00] 2025-10-16 18:02:18,820 - DEBUG - Making attempt 0
[task 2025-10-16T18:02:18.823+00:00] 2025-10-16 18:02:18,815 - DEBUG - Using method(v1, v2, payload) calling convention
[task 2025-10-16T18:02:18.824+00:00] 2025-10-16 18:02:18,822 - DEBUG - Found a positional argument: Vx-MI97PScaeU8IS9zjYfQ
[task 2025-10-16T18:02:18.825+00:00] 2025-10-16 18:02:18,822 - DEBUG - After processing positional arguments, we have: {'taskId': 'Vx-MI97PScaeU8IS9zjYfQ'}
[task 2025-10-16T18:02:18.826+00:00] 2025-10-16 18:02:18,822 - DEBUG - After keyword arguments, we have: {'taskId': 'Vx-MI97PScaeU8IS9zjYfQ'}
[task 2025-10-16T18:02:18.827+00:00] 2025-10-16 18:02:18,822 - DEBUG - HTTP Headers: {'Content-Type': 'application/json'}
[task 2025-10-16T18:02:18.827+00:00] 2025-10-16 18:02:18,822 - DEBUG - HTTP Payload: {"provisionerId":"taskgraph-t","workerType":"linux-gcp","routes":["tc-treeherder.v2.taskgraph-pr.003 (limit 100 char)
[task 2025-10-16T18:02:18.828+00:00] 2025-10-16 18:02:18,822 - DEBUG - Making a PUT request to http://taskcluster/api/queue/v1/task/dVX6YN-rS16w9lwl-n68JQ
[task 2025-10-16T18:02:18.829+00:00] 2025-10-16 18:02:18,821 - DEBUG - Full URL used is: http://taskcluster/api/queue/v1/task/f3wy6JiNQ0Wj9VLWN9lz4A
[task 2025-10-16T18:02:18.829+00:00] 2025-10-16 18:02:18,825 - DEBUG - Not using hawk!
[task 2025-10-16T18:02:18.830+00:00] 2025-10-16 18:02:18,825 - DEBUG - Making attempt 0
[task 2025-10-16T18:02:18.831+00:00] 2025-10-16 18:02:18,825 - DEBUG - Making a PUT request to http://taskcluster/api/queue/v1/task/f3wy6JiNQ0Wj9VLWN9lz4A
[task 2025-10-16T18:02:18.834+00:00] 2025-10-16 18:02:18,825 - DEBUG - HTTP Headers: {'Content-Type': 'application/json'}
[task 2025-10-16T18:02:18.835+00:00] 2025-10-16 18:02:18,825 - DEBUG - HTTP Payload: {"provisionerId":"taskgraph-t","workerType":"linux-gcp","routes":["tc-treeherder.v2.taskgraph-pr.003 (limit 100 char)
[task 2025-10-16T18:02:18.836+00:00] 2025-10-16 18:02:18,824 - DEBUG - HTTP Headers: {'Content-Type': 'application/json'}
[task 2025-10-16T18:02:18.837+00:00] 2025-10-16 18:02:18,827 - DEBUG - HTTP Payload: {"provisionerId":"taskgraph-t","workerType":"linux-gcp","routes":["tc-treeherder.v2.taskgraph-pr.003 (limit 100 char)
[task 2025-10-16T18:02:18.840+00:00] 2025-10-16 18:02:18,828 - DEBUG - Starting new HTTP connection (1): taskcluster:80
[task 2025-10-16T18:02:18.840+00:00] 2025-10-16 18:02:18,824 - DEBUG - Starting new HTTP connection (1): taskcluster:80
[task 2025-10-16T18:02:18.841+00:00] 2025-10-16 18:02:18,821 - DEBUG - Starting new HTTP connection (1): taskcluster:80
[task 2025-10-16T18:02:18.842+00:00] 2025-10-16 18:02:18,814 - INFO - Creating task with taskId VJqdjIDYSC62kED3R9qa-g for test-unit-py39
[task 2025-10-16T18:02:18.844+00:00] 2025-10-16 18:02:18,833 - DEBUG - Using method(v1, v2, payload) calling convention
[task 2025-10-16T18:02:18.844+00:00] 2025-10-16 18:02:18,820 - DEBUG - Using method(v1, v2, payload) calling convention
[task 2025-10-16T18:02:18.844+00:00] 2025-10-16 18:02:18,826 - DEBUG - Starting new HTTP connection (1): taskcluster:80
[task 2025-10-16T18:02:18.844+00:00] 2025-10-16 18:02:18,822 - DEBUG - Full URL used is: http://taskcluster/api/queue/v1/task/Vx-MI97PScaeU8IS9zjYfQ
[task 2025-10-16T18:02:18.844+00:00] 2025-10-16 18:02:18,834 - DEBUG - Not using hawk!
[task 2025-10-16T18:02:18.844+00:00] 2025-10-16 18:02:18,834 - DEBUG - Making attempt 0
[task 2025-10-16T18:02:18.844+00:00] 2025-10-16 18:02:18,834 - DEBUG - Making a PUT request to http://taskcluster/api/queue/v1/task/Vx-MI97PScaeU8IS9zjYfQ
[task 2025-10-16T18:02:18.845+00:00] 2025-10-16 18:02:18,834 - DEBUG - HTTP Headers: {'Content-Type': 'application/json'}
[task 2025-10-16T18:02:18.845+00:00] 2025-10-16 18:02:18,834 - DEBUG - HTTP Payload: {"provisionerId":"taskgraph-t","workerType":"linux-gcp","routes":["tc-treeherder.v2.taskgraph-pr.003 (limit 100 char)
[task 2025-10-16T18:02:18.845+00:00] 2025-10-16 18:02:18,827 - DEBUG - http://taskcluster:80 "PUT /api/queue/v1/task/ZcfbPbzGQ_e7QVSfuLFibQ HTTP/1.1" 200 436
[task 2025-10-16T18:02:18.845+00:00] 2025-10-16 18:02:18,836 - DEBUG - Starting new HTTP connection (1): taskcluster:80
[task 2025-10-16T18:02:18.846+00:00] 2025-10-16 18:02:18,833 - DEBUG - Found a positional argument: VJqdjIDYSC62kED3R9qa-g
[task 2025-10-16T18:02:18.846+00:00] 2025-10-16 18:02:18,838 - DEBUG - After processing positional arguments, we have: {'taskId': 'VJqdjIDYSC62kED3R9qa-g'}
[task 2025-10-16T18:02:18.846+00:00] 2025-10-16 18:02:18,837 - DEBUG - Received HTTP Status:    200
[task 2025-10-16T18:02:18.846+00:00] 2025-10-16 18:02:18,838 - DEBUG - Received HTTP Headers: {'Accept-Ranges': 'bytes', 'Access-Control-Allow-Headers': 'X-Requested-With,Content-Type,Authorization,Accept,Origin,Cache-Control', 'Access-Control-Allow-Methods': 'OPTIONS,GET,HEAD,POST,PUT,DELETE,TRACE,CONNECT', 'Access-Control-Allow-Origin': '*', 'Access-Control-Max-Age': '900', 'Access-Control-Request-Method': '*', 'Cache-Control': 'no-store no-cache must-revalidate', 'Content-Length': '436', 'Content-Security-Policy': "report-uri /__cspreport__;default-src 'none';frame-ancestors 'none';", 'Content-Type': 'application/json; charset=utf-8', 'Date': 'Thu, 16 Oct 2025 18:02:18 GMT', 'Etag': 'W/"1b4-7In27rtxG1Z9nwDIlg56ETyXPP8"', 'Server': 'openresty', 'Strict-Transport-Security': 'max-age=31536000', 'Vary': 'Accept-Encoding', 'Via': '1.1 google, 1.1 varnish, 1.1 varnish', 'X-Cache': 'MISS, MISS', 'X-Cache-Hits': '0, 0', 'X-Content-Type-Options': 'nosniff', 'X-For-Request-Id': '076670e1-a7c8-4436-abbc-787f3d3c6dba', 'X-For-Trace-Id': 'c34729adbd209dd3989b1f8534603f8e', 'X-Served-By': 'cache-bfi-kbfi7400088-BFI, cache-bfi-kbfi7400088-BFI', 'X-Taskcluster-Authorized-Scopes': '["assume:repo:github.com/taskcluster/taskgraph:pull-request","queue:create-artifact:bPkGlDclR9eLgLqxqWeedA/0"]', 'X-Taskcluster-Endpoint': 'https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/ZcfbPbzGQ_e7QVSfuLFibQ', 'X-Taskcluster-Proxy-Revision': '', 'X-Taskcluster-Proxy-Temp-Clientid': 'task-client/bPkGlDclR9eLgLqxqWeedA/0/on/us-west1-a/5258743847019383849/until/1760638916.099', 'X-Taskcluster-Proxy-Temp-Scopes': '["queue:reclaim-task:bPkGlDclR9eLgLqxqWeedA/0","queue:resolve-task:bPkGlDclR9eLgLqxqWeedA/0","queue:create-artifact:bPkGlDclR9eLgLqxqWeedA/0","assume:repo:github.com/taskcluster/taskgraph:pull-request"]', 'X-Taskcluster-Proxy-Version': '38.0.5', 'X-Timer': 'S1760637739.695937,VS0,VE125'}
[task 2025-10-16T18:02:18.846+00:00] 2025-10-16 18:02:18,833 - DEBUG - Found a positional argument: NFbsUhocREO13vDauQF8Hg
[task 2025-10-16T18:02:18.846+00:00] 2025-10-16 18:02:18,838 - DEBUG - After processing positional arguments, we have: {'taskId': 'NFbsUhocREO13vDauQF8Hg'}
[task 2025-10-16T18:02:18.847+00:00] 2025-10-16 18:02:18,838 - DEBUG - After keyword arguments, we have: {'taskId': 'NFbsUhocREO13vDauQF8Hg'}
[task 2025-10-16T18:02:18.847+00:00] 2025-10-16 18:02:18,838 - DEBUG - Full URL used is: http://taskcluster/api/queue/v1/task/NFbsUhocREO13vDauQF8Hg
[task 2025-10-16T18:02:18.847+00:00] 2025-10-16 18:02:18,838 - DEBUG - Not using hawk!
[task 2025-10-16T18:02:18.847+00:00] 2025-10-16 18:02:18,838 - DEBUG - Making attempt 0
[task 2025-10-16T18:02:18.847+00:00] 2025-10-16 18:02:18,838 - DEBUG - After keyword arguments, we have: {'taskId': 'VJqdjIDYSC62kED3R9qa-g'}
[task 2025-10-16T18:02:18.847+00:00] 2025-10-16 18:02:18,838 - DEBUG - Full URL used is: http://taskcluster/api/queue/v1/task/VJqdjIDYSC62kED3R9qa-g
[task 2025-10-16T18:02:18.848+00:00] 2025-10-16 18:02:18,839 - DEBUG - Not using hawk!
[task 2025-10-16T18:02:18.848+00:00] 2025-10-16 18:02:18,839 - DEBUG - Making attempt 0
[task 2025-10-16T18:02:18.849+00:00] 2025-10-16 18:02:18,839 - DEBUG - Making a PUT request to http://taskcluster/api/queue/v1/task/VJqdjIDYSC62kED3R9qa-g
[task 2025-10-16T18:02:18.849+00:00] 2025-10-16 18:02:18,839 - DEBUG - HTTP Headers: {'Content-Type': 'application/json'}
[task 2025-10-16T18:02:18.849+00:00] 2025-10-16 18:02:18,839 - DEBUG - HTTP Payload: {"provisionerId":"taskgraph-t","workerType":"linux-gcp","routes":["tc-treeherder.v2.taskgraph-pr.003 (limit 100 char)
[task 2025-10-16T18:02:18.849+00:00] 2025-10-16 18:02:18,838 - DEBUG - Making a PUT request to http://taskcluster/api/queue/v1/task/NFbsUhocREO13vDauQF8Hg
[task 2025-10-16T18:02:18.849+00:00] 2025-10-16 18:02:18,840 - DEBUG - HTTP Headers: {'Content-Type': 'application/json'}
[task 2025-10-16T18:02:18.849+00:00] 2025-10-16 18:02:18,840 - DEBUG - HTTP Payload: {"provisionerId":"taskgraph-t","workerType":"linux-gcp","routes":["tc-treeherder.v2.taskgraph-pr.003 (limit 100 char)
[task 2025-10-16T18:02:18.849+00:00] 2025-10-16 18:02:18,840 - DEBUG - Starting new HTTP connection (1): taskcluster:80
[task 2025-10-16T18:02:18.849+00:00] 2025-10-16 18:02:18,842 - DEBUG - Starting new HTTP connection (1): taskcluster:80
[task 2025-10-16T18:02:18.923+00:00] 2025-10-16 18:02:18,923 - DEBUG - http://taskcluster:80 "PUT /api/queue/v1/task/dVX6YN-rS16w9lwl-n68JQ HTTP/1.1" 200 434
[task 2025-10-16T18:02:18.924+00:00] 2025-10-16 18:02:18,924 - DEBUG - Received HTTP Status:    200
[task 2025-10-16T18:02:18.925+00:00] 2025-10-16 18:02:18,924 - DEBUG - Received HTTP Headers: {'Accept-Ranges': 'bytes', 'Access-Control-Allow-Headers': 'X-Requested-With,Content-Type,Authorization,Accept,Origin,Cache-Control', 'Access-Control-Allow-Methods': 'OPTIONS,GET,HEAD,POST,PUT,DELETE,TRACE,CONNECT', 'Access-Control-Allow-Origin': '*', 'Access-Control-Max-Age': '900', 'Access-Control-Request-Method': '*', 'Cache-Control': 'no-store no-cache must-revalidate', 'Content-Length': '434', 'Content-Security-Policy': "report-uri /__cspreport__;default-src 'none';frame-ancestors 'none';", 'Content-Type': 'application/json; charset=utf-8', 'Date': 'Thu, 16 Oct 2025 18:02:18 GMT', 'Etag': 'W/"1b2-+pDygxH3iiuEoAgT0f06H7vS9ww"', 'Server': 'openresty', 'Strict-Transport-Security': 'max-age=31536000', 'Vary': 'Accept-Encoding', 'Via': '1.1 google, 1.1 varnish, 1.1 varnish', 'X-Cache': 'MISS, MISS', 'X-Cache-Hits': '0, 0', 'X-Content-Type-Options': 'nosniff', 'X-For-Request-Id': 'ab514a20-4332-4d3b-91e3-d1bd996ddb34', 'X-For-Trace-Id': 'ff61e424962822e495d6a4a96b7147b0', 'X-Served-By': 'cache-bfi-kbfi7400088-BFI, cache-bfi-kbfi7400088-BFI', 'X-Taskcluster-Authorized-Scopes': '["assume:repo:github.com/taskcluster/taskgraph:pull-request","queue:create-artifact:bPkGlDclR9eLgLqxqWeedA/0"]', 'X-Taskcluster-Endpoint': 'https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/dVX6YN-rS16w9lwl-n68JQ', 'X-Taskcluster-Proxy-Revision': '', 'X-Taskcluster-Proxy-Temp-Clientid': 'task-client/bPkGlDclR9eLgLqxqWeedA/0/on/us-west1-a/5258743847019383849/until/1760638916.099', 'X-Taskcluster-Proxy-Temp-Scopes': '["queue:reclaim-task:bPkGlDclR9eLgLqxqWeedA/0","queue:resolve-task:bPkGlDclR9eLgLqxqWeedA/0","queue:create-artifact:bPkGlDclR9eLgLqxqWeedA/0","assume:repo:github.com/taskcluster/taskgraph:pull-request"]', 'X-Taskcluster-Proxy-Version': '38.0.5', 'X-Timer': 'S1760637739.835565,VS0,VE83'}
[task 2025-10-16T18:02:18.925+00:00] 2025-10-16 18:02:18,924 - DEBUG - http://taskcluster:80 "PUT /api/queue/v1/task/R6mkstoCQ1m6qP_8VmCwTQ HTTP/1.1" 200 434
[task 2025-10-16T18:02:18.927+00:00] 2025-10-16 18:02:18,926 - DEBUG - Received HTTP Status:    200
[task 2025-10-16T18:02:18.927+00:00] 2025-10-16 18:02:18,926 - DEBUG - Received HTTP Headers: {'Accept-Ranges': 'bytes', 'Access-Control-Allow-Headers': 'X-Requested-With,Content-Type,Authorization,Accept,Origin,Cache-Control', 'Access-Control-Allow-Methods': 'OPTIONS,GET,HEAD,POST,PUT,DELETE,TRACE,CONNECT', 'Access-Control-Allow-Origin': '*', 'Access-Control-Max-Age': '900', 'Access-Control-Request-Method': '*', 'Cache-Control': 'no-store no-cache must-revalidate', 'Content-Length': '434', 'Content-Security-Policy': "report-uri /__cspreport__;default-src 'none';frame-ancestors 'none';", 'Content-Type': 'application/json; charset=utf-8', 'Date': 'Thu, 16 Oct 2025 18:02:18 GMT', 'Etag': 'W/"1b2-2CpDVu1tYzMwAimA1S7th8n9f6c"', 'Server': 'openresty', 'Strict-Transport-Security': 'max-age=31536000', 'Vary': 'Accept-Encoding', 'Via': '1.1 google, 1.1 varnish, 1.1 varnish', 'X-Cache': 'MISS, MISS', 'X-Cache-Hits': '0, 0', 'X-Content-Type-Options': 'nosniff', 'X-For-Request-Id': 'c62205f3-e7ee-4fbf-a694-815ce2ac3788', 'X-For-Trace-Id': 'eefb6895f6232b2c255374b86e9ced5d', 'X-Served-By': 'cache-bfi-kbfi7400088-BFI, cache-bfi-kbfi7400088-BFI', 'X-Taskcluster-Authorized-Scopes': '["assume:repo:github.com/taskcluster/taskgraph:pull-request","queue:create-artifact:bPkGlDclR9eLgLqxqWeedA/0"]', 'X-Taskcluster-Endpoint': 'https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/R6mkstoCQ1m6qP_8VmCwTQ', 'X-Taskcluster-Proxy-Revision': '', 'X-Taskcluster-Proxy-Temp-Clientid': 'task-client/bPkGlDclR9eLgLqxqWeedA/0/on/us-west1-a/5258743847019383849/until/1760638916.099', 'X-Taskcluster-Proxy-Temp-Scopes': '["queue:reclaim-task:bPkGlDclR9eLgLqxqWeedA/0","queue:resolve-task:bPkGlDclR9eLgLqxqWeedA/0","queue:create-artifact:bPkGlDclR9eLgLqxqWeedA/0","assume:repo:github.com/taskcluster/taskgraph:pull-request"]', 'X-Taskcluster-Proxy-Version': '38.0.5', 'X-Timer': 'S1760637739.836768,VS0,VE81'}
[task 2025-10-16T18:02:18.953+00:00] 2025-10-16 18:02:18,953 - DEBUG - http://taskcluster:80 "PUT /api/queue/v1/task/Vx-MI97PScaeU8IS9zjYfQ HTTP/1.1" 200 434
[task 2025-10-16T18:02:18.954+00:00] 2025-10-16 18:02:18,954 - DEBUG - Received HTTP Status:    200
[task 2025-10-16T18:02:18.954+00:00] 2025-10-16 18:02:18,954 - DEBUG - Received HTTP Headers: {'Accept-Ranges': 'bytes', 'Access-Control-Allow-Headers': 'X-Requested-With,Content-Type,Authorization,Accept,Origin,Cache-Control', 'Access-Control-Allow-Methods': 'OPTIONS,GET,HEAD,POST,PUT,DELETE,TRACE,CONNECT', 'Access-Control-Allow-Origin': '*', 'Access-Control-Max-Age': '900', 'Access-Control-Request-Method': '*', 'Cache-Control': 'no-store no-cache must-revalidate', 'Content-Length': '434', 'Content-Security-Policy': "report-uri /__cspreport__;default-src 'none';frame-ancestors 'none';", 'Content-Type': 'application/json; charset=utf-8', 'Date': 'Thu, 16 Oct 2025 18:02:18 GMT', 'Etag': 'W/"1b2-+io1oropDW6jBGOujlB3GOgRDJY"', 'Server': 'openresty', 'Strict-Transport-Security': 'max-age=31536000', 'Vary': 'Accept-Encoding', 'Via': '1.1 google, 1.1 varnish, 1.1 varnish', 'X-Cache': 'MISS, MISS', 'X-Cache-Hits': '0, 0', 'X-Content-Type-Options': 'nosniff', 'X-For-Request-Id': '9c99db52-c89d-4a64-8d3b-9fc8aad35885', 'X-For-Trace-Id': '0a940e1d4efefa2ae52071ad19752003', 'X-Served-By': 'cache-bfi-kbfi7400088-BFI, cache-bfi-kbfi7400088-BFI', 'X-Taskcluster-Authorized-Scopes': '["assume:repo:github.com/taskcluster/taskgraph:pull-request","queue:create-artifact:bPkGlDclR9eLgLqxqWeedA/0"]', 'X-Taskcluster-Endpoint': 'https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/Vx-MI97PScaeU8IS9zjYfQ', 'X-Taskcluster-Proxy-Revision': '', 'X-Taskcluster-Proxy-Temp-Clientid': 'task-client/bPkGlDclR9eLgLqxqWeedA/0/on/us-west1-a/5258743847019383849/until/1760638916.099', 'X-Taskcluster-Proxy-Temp-Scopes': '["queue:reclaim-task:bPkGlDclR9eLgLqxqWeedA/0","queue:resolve-task:bPkGlDclR9eLgLqxqWeedA/0","queue:create-artifact:bPkGlDclR9eLgLqxqWeedA/0","assume:repo:github.com/taskcluster/taskgraph:pull-request"]', 'X-Taskcluster-Proxy-Version': '38.0.5', 'X-Timer': 'S1760637739.841987,VS0,VE106'}
[task 2025-10-16T18:02:18.955+00:00] 2025-10-16 18:02:18,955 - DEBUG - http://taskcluster:80 "PUT /api/queue/v1/task/VJqdjIDYSC62kED3R9qa-g HTTP/1.1" 200 434
[task 2025-10-16T18:02:18.956+00:00] 2025-10-16 18:02:18,956 - DEBUG - Received HTTP Status:    200
[task 2025-10-16T18:02:18.957+00:00] 2025-10-16 18:02:18,956 - DEBUG - Received HTTP Headers: {'Accept-Ranges': 'bytes', 'Access-Control-Allow-Headers': 'X-Requested-With,Content-Type,Authorization,Accept,Origin,Cache-Control', 'Access-Control-Allow-Methods': 'OPTIONS,GET,HEAD,POST,PUT,DELETE,TRACE,CONNECT', 'Access-Control-Allow-Origin': '*', 'Access-Control-Max-Age': '900', 'Access-Control-Request-Method': '*', 'Cache-Control': 'no-store no-cache must-revalidate', 'Content-Length': '434', 'Content-Security-Policy': "report-uri /__cspreport__;default-src 'none';frame-ancestors 'none';", 'Content-Type': 'application/json; charset=utf-8', 'Date': 'Thu, 16 Oct 2025 18:02:18 GMT', 'Etag': 'W/"1b2-jSkYw18layTnTcp0AKeYxNIWWAY"', 'Server': 'openresty', 'Strict-Transport-Security': 'max-age=31536000', 'Vary': 'Accept-Encoding', 'Via': '1.1 google, 1.1 varnish, 1.1 varnish', 'X-Cache': 'MISS, MISS', 'X-Cache-Hits': '0, 0', 'X-Content-Type-Options': 'nosniff', 'X-For-Request-Id': '8d247643-ae9c-4f3c-b7c2-da1e7626bc29', 'X-For-Trace-Id': 'a6b50eeb4075a14ea2c4b03322cf76fc', 'X-Served-By': 'cache-bfi-kbfi7400088-BFI, cache-bfi-kbfi7400088-BFI', 'X-Taskcluster-Authorized-Scopes': '["assume:repo:github.com/taskcluster/taskgraph:pull-request","queue:create-artifact:bPkGlDclR9eLgLqxqWeedA/0"]', 'X-Taskcluster-Endpoint': 'https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/VJqdjIDYSC62kED3R9qa-g', 'X-Taskcluster-Proxy-Revision': '', 'X-Taskcluster-Proxy-Temp-Clientid': 'task-client/bPkGlDclR9eLgLqxqWeedA/0/on/us-west1-a/5258743847019383849/until/1760638916.099', 'X-Taskcluster-Proxy-Temp-Scopes': '["queue:reclaim-task:bPkGlDclR9eLgLqxqWeedA/0","queue:resolve-task:bPkGlDclR9eLgLqxqWeedA/0","queue:create-artifact:bPkGlDclR9eLgLqxqWeedA/0","assume:repo:github.com/taskcluster/taskgraph:pull-request"]', 'X-Taskcluster-Proxy-Version': '38.0.5', 'X-Timer': 'S1760637739.846336,VS0,VE105'}
[task 2025-10-16T18:02:18.977+00:00] 2025-10-16 18:02:18,977 - DEBUG - http://taskcluster:80 "PUT /api/queue/v1/task/NFbsUhocREO13vDauQF8Hg HTTP/1.1" 200 434
[task 2025-10-16T18:02:18.977+00:00] 2025-10-16 18:02:18,977 - DEBUG - Received HTTP Status:    200
[task 2025-10-16T18:02:18.978+00:00] 2025-10-16 18:02:18,978 - DEBUG - Received HTTP Headers: {'Accept-Ranges': 'bytes', 'Access-Control-Allow-Headers': 'X-Requested-With,Content-Type,Authorization,Accept,Origin,Cache-Control', 'Access-Control-Allow-Methods': 'OPTIONS,GET,HEAD,POST,PUT,DELETE,TRACE,CONNECT', 'Access-Control-Allow-Origin': '*', 'Access-Control-Max-Age': '900', 'Access-Control-Request-Method': '*', 'Cache-Control': 'no-store no-cache must-revalidate', 'Content-Length': '434', 'Content-Security-Policy': "report-uri /__cspreport__;default-src 'none';frame-ancestors 'none';", 'Content-Type': 'application/json; charset=utf-8', 'Date': 'Thu, 16 Oct 2025 18:02:18 GMT', 'Etag': 'W/"1b2-TU8wHEUzHbOUkFwlbksTy4lowFE"', 'Server': 'openresty', 'Strict-Transport-Security': 'max-age=31536000', 'Vary': 'Accept-Encoding', 'Via': '1.1 google, 1.1 varnish, 1.1 varnish', 'X-Cache': 'MISS, MISS', 'X-Cache-Hits': '0, 0', 'X-Content-Type-Options': 'nosniff', 'X-For-Request-Id': '3ca1ba7e-da21-42d5-a247-e5aef031038b', 'X-For-Trace-Id': '75a3264a590766e06676b209f4519ec4', 'X-Served-By': 'cache-bfi-kbfi7400088-BFI, cache-bfi-kbfi7400088-BFI', 'X-Taskcluster-Authorized-Scopes': '["assume:repo:github.com/taskcluster/taskgraph:pull-request","queue:create-artifact:bPkGlDclR9eLgLqxqWeedA/0"]', 'X-Taskcluster-Endpoint': 'https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/NFbsUhocREO13vDauQF8Hg', 'X-Taskcluster-Proxy-Revision': '', 'X-Taskcluster-Proxy-Temp-Clientid': 'task-client/bPkGlDclR9eLgLqxqWeedA/0/on/us-west1-a/5258743847019383849/until/1760638916.099', 'X-Taskcluster-Proxy-Temp-Scopes': '["queue:reclaim-task:bPkGlDclR9eLgLqxqWeedA/0","queue:resolve-task:bPkGlDclR9eLgLqxqWeedA/0","queue:create-artifact:bPkGlDclR9eLgLqxqWeedA/0","assume:repo:github.com/taskcluster/taskgraph:pull-request"]', 'X-Taskcluster-Proxy-Version': '38.0.5', 'X-Timer': 'S1760637739.846965,VS0,VE126'}
[task 2025-10-16T18:02:18.986+00:00] 2025-10-16 18:02:18,986 - DEBUG - http://taskcluster:80 "PUT /api/queue/v1/task/eaXreDsASfKS2Komvrh8pA HTTP/1.1" 200 434
[task 2025-10-16T18:02:18.986+00:00] 2025-10-16 18:02:18,986 - DEBUG - Received HTTP Status:    200
[task 2025-10-16T18:02:18.987+00:00] 2025-10-16 18:02:18,986 - DEBUG - Received HTTP Headers: {'Accept-Ranges': 'bytes', 'Access-Control-Allow-Headers': 'X-Requested-With,Content-Type,Authorization,Accept,Origin,Cache-Control', 'Access-Control-Allow-Methods': 'OPTIONS,GET,HEAD,POST,PUT,DELETE,TRACE,CONNECT', 'Access-Control-Allow-Origin': '*', 'Access-Control-Max-Age': '900', 'Access-Control-Request-Method': '*', 'Cache-Control': 'no-store no-cache must-revalidate', 'Content-Length': '434', 'Content-Security-Policy': "report-uri /__cspreport__;default-src 'none';frame-ancestors 'none';", 'Content-Type': 'application/json; charset=utf-8', 'Date': 'Thu, 16 Oct 2025 18:02:18 GMT', 'Etag': 'W/"1b2-en7nBaIbyZzb1W4+NRUlXlU/qdY"', 'Server': 'openresty', 'Strict-Transport-Security': 'max-age=31536000', 'Vary': 'Accept-Encoding', 'Via': '1.1 google, 1.1 varnish, 1.1 varnish', 'X-Cache': 'MISS, MISS', 'X-Cache-Hits': '0, 0', 'X-Content-Type-Options': 'nosniff', 'X-For-Request-Id': 'e13518cb-2eee-4be8-927f-b23b14866243', 'X-For-Trace-Id': 'a70ce644395e43d89b84f45331f5b010', 'X-Served-By': 'cache-bfi-kbfi7400088-BFI, cache-bfi-kbfi7400088-BFI', 'X-Taskcluster-Authorized-Scopes': '["assume:repo:github.com/taskcluster/taskgraph:pull-request","queue:create-artifact:bPkGlDclR9eLgLqxqWeedA/0"]', 'X-Taskcluster-Endpoint': 'https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/eaXreDsASfKS2Komvrh8pA', 'X-Taskcluster-Proxy-Revision': '', 'X-Taskcluster-Proxy-Temp-Clientid': 'task-client/bPkGlDclR9eLgLqxqWeedA/0/on/us-west1-a/5258743847019383849/until/1760638916.099', 'X-Taskcluster-Proxy-Temp-Scopes': '["queue:reclaim-task:bPkGlDclR9eLgLqxqWeedA/0","queue:resolve-task:bPkGlDclR9eLgLqxqWeedA/0","queue:create-artifact:bPkGlDclR9eLgLqxqWeedA/0","assume:repo:github.com/taskcluster/taskgraph:pull-request"]', 'X-Taskcluster-Proxy-Version': '38.0.5', 'X-Timer': 'S1760637739.836444,VS0,VE145'}
[task 2025-10-16T18:02:18.987+00:00] 2025-10-16 18:02:18,987 - INFO - Creating task with taskId Xj7soWpqR02r1Yy1IZxJmA for codecov-upload
[task 2025-10-16T18:02:18.988+00:00] 2025-10-16 18:02:18,987 - DEBUG - Using method(v1, v2, payload) calling convention
[task 2025-10-16T18:02:18.988+00:00] 2025-10-16 18:02:18,987 - DEBUG - Found a positional argument: Xj7soWpqR02r1Yy1IZxJmA
[task 2025-10-16T18:02:18.989+00:00] 2025-10-16 18:02:18,988 - DEBUG - After processing positional arguments, we have: {'taskId': 'Xj7soWpqR02r1Yy1IZxJmA'}
[task 2025-10-16T18:02:18.989+00:00] 2025-10-16 18:02:18,988 - DEBUG - After keyword arguments, we have: {'taskId': 'Xj7soWpqR02r1Yy1IZxJmA'}
[task 2025-10-16T18:02:18.989+00:00] 2025-10-16 18:02:18,988 - DEBUG - Full URL used is: http://taskcluster/api/queue/v1/task/Xj7soWpqR02r1Yy1IZxJmA
[task 2025-10-16T18:02:18.990+00:00] 2025-10-16 18:02:18,988 - DEBUG - Not using hawk!
[task 2025-10-16T18:02:18.990+00:00] 2025-10-16 18:02:18,988 - DEBUG - Making attempt 0
[task 2025-10-16T18:02:18.990+00:00] 2025-10-16 18:02:18,989 - DEBUG - Making a PUT request to http://taskcluster/api/queue/v1/task/Xj7soWpqR02r1Yy1IZxJmA
[task 2025-10-16T18:02:18.991+00:00] 2025-10-16 18:02:18,989 - DEBUG - HTTP Headers: {'Content-Type': 'application/json'}
[task 2025-10-16T18:02:18.991+00:00] 2025-10-16 18:02:18,989 - DEBUG - HTTP Payload: {"provisionerId":"taskgraph-t","workerType":"linux-gcp","routes":["tc-treeherder.v2.taskgraph-pr.003 (limit 100 char)
[task 2025-10-16T18:02:18.993+00:00] 2025-10-16 18:02:18,992 - DEBUG - Starting new HTTP connection (1): taskcluster:80
[task 2025-10-16T18:02:18.993+00:00] 2025-10-16 18:02:18,993 - DEBUG - http://taskcluster:80 "PUT /api/queue/v1/task/f3wy6JiNQ0Wj9VLWN9lz4A HTTP/1.1" 200 434
[task 2025-10-16T18:02:18.993+00:00] 2025-10-16 18:02:18,993 - DEBUG - Received HTTP Status:    200
[task 2025-10-16T18:02:18.994+00:00] 2025-10-16 18:02:18,993 - DEBUG - Received HTTP Headers: {'Accept-Ranges': 'bytes', 'Access-Control-Allow-Headers': 'X-Requested-With,Content-Type,Authorization,Accept,Origin,Cache-Control', 'Access-Control-Allow-Methods': 'OPTIONS,GET,HEAD,POST,PUT,DELETE,TRACE,CONNECT', 'Access-Control-Allow-Origin': '*', 'Access-Control-Max-Age': '900', 'Access-Control-Request-Method': '*', 'Cache-Control': 'no-store no-cache must-revalidate', 'Content-Length': '434', 'Content-Security-Policy': "report-uri /__cspreport__;default-src 'none';frame-ancestors 'none';", 'Content-Type': 'application/json; charset=utf-8', 'Date': 'Thu, 16 Oct 2025 18:02:18 GMT', 'Etag': 'W/"1b2-Ukqgdt3g2GIviHSkrYrAeHaBbWQ"', 'Server': 'openresty', 'Strict-Transport-Security': 'max-age=31536000', 'Vary': 'Accept-Encoding', 'Via': '1.1 google, 1.1 varnish, 1.1 varnish', 'X-Cache': 'MISS, MISS', 'X-Cache-Hits': '0, 0', 'X-Content-Type-Options': 'nosniff', 'X-For-Request-Id': '048a8c03-786c-493a-89cd-ec92d047b800', 'X-For-Trace-Id': '7acfa8671443c452cb26c9f52a9881a4', 'X-Served-By': 'cache-bfi-kbfi7400088-BFI, cache-bfi-kbfi7400088-BFI', 'X-Taskcluster-Authorized-Scopes': '["assume:repo:github.com/taskcluster/taskgraph:pull-request","queue:create-artifact:bPkGlDclR9eLgLqxqWeedA/0"]', 'X-Taskcluster-Endpoint': 'https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/f3wy6JiNQ0Wj9VLWN9lz4A', 'X-Taskcluster-Proxy-Revision': '', 'X-Taskcluster-Proxy-Temp-Clientid': 'task-client/bPkGlDclR9eLgLqxqWeedA/0/on/us-west1-a/5258743847019383849/until/1760638916.099', 'X-Taskcluster-Proxy-Temp-Scopes': '["queue:reclaim-task:bPkGlDclR9eLgLqxqWeedA/0","queue:resolve-task:bPkGlDclR9eLgLqxqWeedA/0","queue:create-artifact:bPkGlDclR9eLgLqxqWeedA/0","assume:repo:github.com/taskcluster/taskgraph:pull-request"]', 'X-Taskcluster-Proxy-Version': '38.0.5', 'X-Timer': 'S1760637739.841652,VS0,VE144'}
[task 2025-10-16T18:02:19.108+00:00] 2025-10-16 18:02:19,108 - DEBUG - http://taskcluster:80 "PUT /api/queue/v1/task/Xj7soWpqR02r1Yy1IZxJmA HTTP/1.1" 200 434
[task 2025-10-16T18:02:19.109+00:00] 2025-10-16 18:02:19,109 - DEBUG - Received HTTP Status:    200
[task 2025-10-16T18:02:19.109+00:00] 2025-10-16 18:02:19,109 - DEBUG - Received HTTP Headers: {'Accept-Ranges': 'bytes', 'Access-Control-Allow-Headers': 'X-Requested-With,Content-Type,Authorization,Accept,Origin,Cache-Control', 'Access-Control-Allow-Methods': 'OPTIONS,GET,HEAD,POST,PUT,DELETE,TRACE,CONNECT', 'Access-Control-Allow-Origin': '*', 'Access-Control-Max-Age': '900', 'Access-Control-Request-Method': '*', 'Cache-Control': 'no-store no-cache must-revalidate', 'Content-Length': '434', 'Content-Security-Policy': "report-uri /__cspreport__;default-src 'none';frame-ancestors 'none';", 'Content-Type': 'application/json; charset=utf-8', 'Date': 'Thu, 16 Oct 2025 18:02:19 GMT', 'Etag': 'W/"1b2-ot0vLJ+juD5efYVlh4cCfVAseq4"', 'Server': 'openresty', 'Strict-Transport-Security': 'max-age=31536000', 'Vary': 'Accept-Encoding', 'Via': '1.1 google, 1.1 varnish, 1.1 varnish', 'X-Cache': 'MISS, MISS', 'X-Cache-Hits': '0, 0', 'X-Content-Type-Options': 'nosniff', 'X-For-Request-Id': 'eeb02113-c01e-4a83-b36d-5cb41d3223a4', 'X-For-Trace-Id': '8ad79522bc199c2ba1354305998afd3a', 'X-Served-By': 'cache-bfi-kbfi7400088-BFI, cache-bfi-kbfi7400088-BFI', 'X-Taskcluster-Authorized-Scopes': '["assume:repo:github.com/taskcluster/taskgraph:pull-request","queue:create-artifact:bPkGlDclR9eLgLqxqWeedA/0"]', 'X-Taskcluster-Endpoint': 'https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/Xj7soWpqR02r1Yy1IZxJmA', 'X-Taskcluster-Proxy-Revision': '', 'X-Taskcluster-Proxy-Temp-Clientid': 'task-client/bPkGlDclR9eLgLqxqWeedA/0/on/us-west1-a/5258743847019383849/until/1760638916.099', 'X-Taskcluster-Proxy-Temp-Scopes': '["queue:reclaim-task:bPkGlDclR9eLgLqxqWeedA/0","queue:resolve-task:bPkGlDclR9eLgLqxqWeedA/0","queue:create-artifact:bPkGlDclR9eLgLqxqWeedA/0","assume:repo:github.com/taskcluster/taskgraph:pull-request"]', 'X-Taskcluster-Proxy-Version': '38.0.5', 'X-Timer': 'S1760637739.998422,VS0,VE105'}
[task 2025-10-16T18:02:19.112+00:00] 2025-10-16 18:02:19,110 - INFO - Creating task with taskId MTQGc1M8T_aHlhyH6E9UKA for complete-pr
[task 2025-10-16T18:02:19.112+00:00] 2025-10-16 18:02:19,110 - DEBUG - Using method(v1, v2, payload) calling convention
[task 2025-10-16T18:02:19.112+00:00] 2025-10-16 18:02:19,110 - DEBUG - Found a positional argument: MTQGc1M8T_aHlhyH6E9UKA
[task 2025-10-16T18:02:19.112+00:00] 2025-10-16 18:02:19,110 - DEBUG - After processing positional arguments, we have: {'taskId': 'MTQGc1M8T_aHlhyH6E9UKA'}
[task 2025-10-16T18:02:19.112+00:00] 2025-10-16 18:02:19,111 - DEBUG - After keyword arguments, we have: {'taskId': 'MTQGc1M8T_aHlhyH6E9UKA'}
[task 2025-10-16T18:02:19.112+00:00] 2025-10-16 18:02:19,111 - DEBUG - Full URL used is: http://taskcluster/api/queue/v1/task/MTQGc1M8T_aHlhyH6E9UKA
[task 2025-10-16T18:02:19.112+00:00] 2025-10-16 18:02:19,111 - DEBUG - Not using hawk!
[task 2025-10-16T18:02:19.112+00:00] 2025-10-16 18:02:19,111 - DEBUG - Making attempt 0
[task 2025-10-16T18:02:19.112+00:00] 2025-10-16 18:02:19,111 - DEBUG - Making a PUT request to http://taskcluster/api/queue/v1/task/MTQGc1M8T_aHlhyH6E9UKA
[task 2025-10-16T18:02:19.112+00:00] 2025-10-16 18:02:19,111 - DEBUG - HTTP Headers: {'Content-Type': 'application/json'}
[task 2025-10-16T18:02:19.112+00:00] 2025-10-16 18:02:19,111 - DEBUG - HTTP Payload: {"provisionerId":"built-in","workerType":"succeed","routes":["checks"],"created":"2025-10-16T18:02:1 (limit 100 char)
[task 2025-10-16T18:02:19.112+00:00] 2025-10-16 18:02:19,112 - DEBUG - Starting new HTTP connection (1): taskcluster:80
[task 2025-10-16T18:02:19.223+00:00] 2025-10-16 18:02:19,223 - DEBUG - http://taskcluster:80 "PUT /api/queue/v1/task/MTQGc1M8T_aHlhyH6E9UKA HTTP/1.1" 200 424
[task 2025-10-16T18:02:19.224+00:00] 2025-10-16 18:02:19,223 - DEBUG - Received HTTP Status:    200
[task 2025-10-16T18:02:19.224+00:00] 2025-10-16 18:02:19,224 - DEBUG - Received HTTP Headers: {'Accept-Ranges': 'bytes', 'Access-Control-Allow-Headers': 'X-Requested-With,Content-Type,Authorization,Accept,Origin,Cache-Control', 'Access-Control-Allow-Methods': 'OPTIONS,GET,HEAD,POST,PUT,DELETE,TRACE,CONNECT', 'Access-Control-Allow-Origin': '*', 'Access-Control-Max-Age': '900', 'Access-Control-Request-Method': '*', 'Cache-Control': 'no-store no-cache must-revalidate', 'Content-Length': '424', 'Content-Security-Policy': "report-uri /__cspreport__;default-src 'none';frame-ancestors 'none';", 'Content-Type': 'application/json; charset=utf-8', 'Date': 'Thu, 16 Oct 2025 18:02:19 GMT', 'Etag': 'W/"1a8-5WxJqgg51j77tWNccZjdUHySAIA"', 'Server': 'openresty', 'Strict-Transport-Security': 'max-age=31536000', 'Vary': 'Accept-Encoding', 'Via': '1.1 google, 1.1 varnish, 1.1 varnish', 'X-Cache': 'MISS, MISS', 'X-Cache-Hits': '0, 0', 'X-Content-Type-Options': 'nosniff', 'X-For-Request-Id': 'a478359e-324a-4594-8654-c10bafb2f4a5', 'X-For-Trace-Id': '364fc15d58702d90f627e96b821a48c1', 'X-Served-By': 'cache-bfi-kbfi7400088-BFI, cache-bfi-kbfi7400088-BFI', 'X-Taskcluster-Authorized-Scopes': '["assume:repo:github.com/taskcluster/taskgraph:pull-request","queue:create-artifact:bPkGlDclR9eLgLqxqWeedA/0"]', 'X-Taskcluster-Endpoint': 'https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/MTQGc1M8T_aHlhyH6E9UKA', 'X-Taskcluster-Proxy-Revision': '', 'X-Taskcluster-Proxy-Temp-Clientid': 'task-client/bPkGlDclR9eLgLqxqWeedA/0/on/us-west1-a/5258743847019383849/until/1760638916.099', 'X-Taskcluster-Proxy-Temp-Scopes': '["queue:reclaim-task:bPkGlDclR9eLgLqxqWeedA/0","queue:resolve-task:bPkGlDclR9eLgLqxqWeedA/0","queue:create-artifact:bPkGlDclR9eLgLqxqWeedA/0","assume:repo:github.com/taskcluster/taskgraph:pull-request"]', 'X-Taskcluster-Proxy-Version': '38.0.5', 'X-Timer': 'S1760637739.116762,VS0,VE102'}
[taskcluster 2025-10-16 18:02:19.492Z] === Task Finished ===
[taskcluster 2025-10-16 18:02:21.889Z] Successful task run with exit code: 0 completed in 25.721 seconds