[taskcluster 2025-09-05 19:56:48.035Z] Task ID: a2I979dvQj6l7DnOcsoYHg
[taskcluster 2025-09-05 19:56:48.035Z] Worker ID: 7141490302209392950
[taskcluster 2025-09-05 19:56:48.035Z] Worker Group: us-central1-a
[taskcluster 2025-09-05 19:56:48.035Z] Worker Node Type: projects/887720501152/machineTypes/n2-standard-2
[taskcluster 2025-09-05 19:56:48.035Z] Worker Pool: taskgraph-1/decision-gcp
[taskcluster 2025-09-05 19:56:48.035Z] Worker Version: 38.0.5
[taskcluster 2025-09-05 19:56:48.035Z] Public IP: 35.238.187.64
[taskcluster 2025-09-05 19:56:48.035Z] Hostname: taskgraph-1-decision-gcp-uljndugzt-ixd-kjcy6dea
[taskcluster 2025-09-05 19:56:48.035Z] using cache "taskgraph-level-1-checkouts-sparse-v2" -> /builds/worker/checkouts

[taskcluster 2025-09-05 19:56:48.673Z] === Task Starting ===
[setup 2025-09-05T19:56:48.966+00:00] run-task started in /
[setup 2025-09-05T19:56:48.966+00:00] Invoked by command: --taskgraph-checkout=/builds/worker/checkouts/src -- bash -cx cd /builds/worker/checkouts/src && ln -s /builds/worker/artifacts artifacts && pip3 install --user --break-system-packages . && taskgraph decision --verbose --pushlog-id='0' --pushdate='0' --project='taskgraph' --owner='ahal@users.noreply.github.com' --level='1' --repository-type=git --tasks-for='github-pull-request' --base-repository='https://github.com/taskcluster/taskgraph' --base-ref='main' --base-rev='722452874bb849e2dab4cef043cbba1061ff055a' --head-repository='https://github.com/ahal/taskgraph' --head-ref='ahal/push-pnyqlyvxwoxv' --head-rev='ffb3ed98951cc75d1c24516e80b288bfc888ffa7' 

[setup 2025-09-05T19:56:48.966+00:00] Python version: 3.11.2
[setup 2025-09-05T19:56:48.966+00:00] Subprocess python version: 
cpython-3.11.2-linux-x86_64-gnu    /usr/bin/python3.11
cpython-3.11.2-linux-x86_64-gnu    /usr/bin/python3 -> python3.11
cpython-3.11.2-linux-x86_64-gnu    /bin/python3.11
cpython-3.11.2-linux-x86_64-gnu    /bin/python3 -> python3.11

...(60 lines hidden)...

[task 2025-09-05T19:56:51.731+00:00] Requirement already satisfied: pygments<3.0.0,>=2.13.0 in /usr/local/lib/python3.11/dist-packages (from rich->cookiecutter~=2.1->taskcluster-taskgraph==15.1.3) (2.19.1)
[task 2025-09-05T19:56:51.764+00:00] Requirement already satisfied: mdurl~=0.1 in /usr/local/lib/python3.11/dist-packages (from markdown-it-py>=2.2.0->rich->cookiecutter~=2.1->taskcluster-taskgraph==15.1.3) (0.1.2)
[task 2025-09-05T19:56:51.791+00:00] Requirement already satisfied: six>=1.5 in /usr/local/lib/python3.11/dist-packages (from python-dateutil>=2.7.0->arrow->cookiecutter~=2.1->taskcluster-taskgraph==15.1.3) (1.17.0)
[task 2025-09-05T19:56:51.836+00:00] Building wheels for collected packages: taskcluster-taskgraph
[task 2025-09-05T19:56:51.837+00:00]   Building wheel for taskcluster-taskgraph (pyproject.toml): started
[task 2025-09-05T19:56:51.866+00:00]   Building wheel for taskcluster-taskgraph (pyproject.toml): finished with status 'done'
[task 2025-09-05T19:56:51.867+00:00]   Created wheel for taskcluster-taskgraph: filename=taskcluster_taskgraph-15.1.3-py3-none-any.whl size=200537 sha256=812d5bc27f8e57edbc1b993d99657ec9fe6a8f8473109ebba9ed0b74681aeb8f
[task 2025-09-05T19:56:51.868+00:00]   Stored in directory: /tmp/pip-ephem-wheel-cache-wpima2su/wheels/54/fa/b4/d3017bf051c083cc076bfd93af1693baf4c91b8f6fee74b0bc
[task 2025-09-05T19:56:51.871+00:00] Successfully built taskcluster-taskgraph
[task 2025-09-05T19:56:51.964+00:00] Installing collected packages: taskcluster-taskgraph
[task 2025-09-05T19:56:52.056+00:00]   WARNING: The script taskgraph is installed in '/builds/worker/.local/bin' which is not on PATH.
[task 2025-09-05T19:56:52.058+00:00]   Consider adding this directory to PATH or, if you prefer to suppress this warning, use --no-warn-script-location.
[task 2025-09-05T19:56:52.062+00:00] Successfully installed taskcluster-taskgraph-15.1.3
[task 2025-09-05T19:56:52.133+00:00] + taskgraph decision --verbose --pushlog-id=0 --pushdate=0 --project=taskgraph --owner=ahal@users.noreply.github.com --level=1 --repository-type=git --tasks-for=github-pull-request --base-repository=https://github.com/taskcluster/taskgraph --base-ref=main --base-rev=722452874bb849e2dab4cef043cbba1061ff055a --head-repository=https://github.com/ahal/taskgraph --head-ref=ahal/push-pnyqlyvxwoxv --head-rev=ffb3ed98951cc75d1c24516e80b288bfc888ffa7
[task 2025-09-05T19:56:52.644+00:00] 2025-09-05 19:56:52,643 - INFO - Loading graph configuration.
[task 2025-09-05T19:56:52.645+00:00] 2025-09-05 19:56:52,644 - DEBUG - loading config from `taskcluster/config.yml`
[task 2025-09-05T19:56:52.652+00:00] 2025-09-05 19:56:52,652 - WARNING - using default project parameters; add taskgraph to PER_PROJECT_PARAMETERS in /builds/worker/.local/lib/python3.11/site-packages/taskgraph/decision.py to customize behavior for this project
[task 2025-09-05T19:56:52.653+00:00] 2025-09-05 19:56:52,653 - INFO - Using Parameters(id=9835b39da6a0) (from defaults)
[task 2025-09-05T19:56:52.654+00:00] 2025-09-05 19:56:52,653 - DEBUG - Dumping parameters:
[task 2025-09-05T19:56:52.663+00:00] { 'base_ref': 'main',
[task 2025-09-05T19:56:52.663+00:00]   'base_repository': 'https://github.com/taskcluster/taskgraph',
[task 2025-09-05T19:56:52.663+00:00]   'base_rev': '722452874bb849e2dab4cef043cbba1061ff055a',
[task 2025-09-05T19:56:52.663+00:00]   'build_date': 1757102212,
[task 2025-09-05T19:56:52.663+00:00]   'build_number': 1,
[task 2025-09-05T19:56:52.663+00:00]   'do_not_optimize': [],
[task 2025-09-05T19:56:52.663+00:00]   'enable_always_target': True,
[task 2025-09-05T19:56:52.663+00:00]   'existing_tasks': {},
[task 2025-09-05T19:56:52.663+00:00]   'files_changed': [ 'src/taskgraph/docker.py',
[task 2025-09-05T19:56:52.663+00:00]                      'test/test_docker.py',
[task 2025-09-05T19:56:52.663+00:00]                      'src/taskgraph/docker.py',
[task 2025-09-05T19:56:52.663+00:00]                      'test/test_docker.py',
[task 2025-09-05T19:56:52.663+00:00]                      'src/taskgraph/docker.py'],
[task 2025-09-05T19:56:52.663+00:00]   'filters': ['target_tasks_method'],
[task 2025-09-05T19:56:52.663+00:00]   'head_ref': 'ahal/push-pnyqlyvxwoxv',
[task 2025-09-05T19:56:52.663+00:00]   'head_repository': 'https://github.com/ahal/taskgraph',
[task 2025-09-05T19:56:52.663+00:00]   'head_rev': 'ffb3ed98951cc75d1c24516e80b288bfc888ffa7',
[task 2025-09-05T19:56:52.663+00:00]   'head_tag': '',
[task 2025-09-05T19:56:52.663+00:00]   'level': '1',
[task 2025-09-05T19:56:52.663+00:00]   'moz_build_date': '20250905195652',
[task 2025-09-05T19:56:52.663+00:00]   'next_version': None,
[task 2025-09-05T19:56:52.663+00:00]   'optimize_strategies': None,
[task 2025-09-05T19:56:52.663+00:00]   'optimize_target_tasks': True,
[task 2025-09-05T19:56:52.663+00:00]   'owner': 'ahal@users.noreply.github.com',
[task 2025-09-05T19:56:52.663+00:00]   'project': 'taskgraph',
[task 2025-09-05T19:56:52.663+00:00]   'pushdate': 0,
[task 2025-09-05T19:56:52.663+00:00]   'pushlog_id': '0',
[task 2025-09-05T19:56:52.663+00:00]   'repository_type': 'git',
[task 2025-09-05T19:56:52.663+00:00]   'target_tasks_method': 'default',
[task 2025-09-05T19:56:52.663+00:00]   'tasks_for': 'github-pull-request',
[task 2025-09-05T19:56:52.663+00:00]   'version': None}
[task 2025-09-05T19:56:52.663+00:00] 2025-09-05 19:56:52,654 - INFO - writing artifact file `parameters.yml`
[task 2025-09-05T19:56:52.663+00:00] 2025-09-05 19:56:52,661 - INFO - writing artifact file `actions.json`
[task 2025-09-05T19:56:52.663+00:00] 2025-09-05 19:56:52,661 - INFO - Loading kinds
[task 2025-09-05T19:56:52.663+00:00] 2025-09-05 19:56:52,661 - DEBUG - loading kind `codecov` from `taskcluster/kinds/codecov`
[task 2025-09-05T19:56:52.663+00:00] 2025-09-05 19:56:52,662 - DEBUG - loading kind `test` from `taskcluster/kinds/test`
[task 2025-09-05T19:56:52.663+00:00] 2025-09-05 19:56:52,663 - DEBUG - loading kind `complete` from `taskcluster/kinds/complete`
[task 2025-09-05T19:56:52.663+00:00] 2025-09-05 19:56:52,663 - DEBUG - loading kind `docker-image` from `taskcluster/kinds/docker-image`
[task 2025-09-05T19:56:52.664+00:00] 2025-09-05 19:56:52,664 - DEBUG - loading kind `fetch` from `taskcluster/kinds/fetch`
[task 2025-09-05T19:56:52.664+00:00] 2025-09-05 19:56:52,664 - DEBUG - loading kind `doc` from `taskcluster/kinds/doc`
[task 2025-09-05T19:56:52.665+00:00] 2025-09-05 19:56:52,664 - DEBUG - loading kind `push-image` from `taskcluster/kinds/push-image`
[task 2025-09-05T19:56:52.665+00:00] 2025-09-05 19:56:52,665 - DEBUG - loading kind `check` from `taskcluster/kinds/check`
[task 2025-09-05T19:56:52.666+00:00] 2025-09-05 19:56:52,666 - INFO - Generating full task set
[task 2025-09-05T19:56:52.666+00:00] 2025-09-05 19:56:52,666 - DEBUG - Loading tasks for kind check
[task 2025-09-05T19:56:52.682+00:00] 2025-09-05 19:56:52,682 - DEBUG - Generating tasks for check type
[task 2025-09-05T19:56:52.683+00:00] 2025-09-05 19:56:52,683 - INFO - Generated 1 tasks for kind check
[task 2025-09-05T19:56:52.683+00:00] 2025-09-05 19:56:52,683 - DEBUG - Loading tasks for kind doc
[task 2025-09-05T19:56:52.686+00:00] 2025-09-05 19:56:52,685 - DEBUG - Generating tasks for doc generate
[task 2025-09-05T19:56:52.686+00:00] 2025-09-05 19:56:52,686 - INFO - Generated 1 tasks for kind doc
[task 2025-09-05T19:56:52.686+00:00] 2025-09-05 19:56:52,686 - DEBUG - Loading tasks for kind docker-image
[task 2025-09-05T19:56:52.687+00:00] 2025-09-05 19:56:52,687 - DEBUG - Generating tasks for docker-image decision
[task 2025-09-05T19:56:52.687+00:00] 2025-09-05 19:56:52,687 - INFO - Writing docker-contexts/decision.tar.gz for docker image decision
[task 2025-09-05T19:56:52.795+00:00] 2025-09-05 19:56:52,795 - DEBUG - Generating tasks for docker-image fetch
[task 2025-09-05T19:56:52.795+00:00] 2025-09-05 19:56:52,795 - INFO - Writing docker-contexts/fetch.tar.gz for docker image fetch
[task 2025-09-05T19:56:52.808+00:00] 2025-09-05 19:56:52,807 - DEBUG - Generating tasks for docker-image index-task
[task 2025-09-05T19:56:52.808+00:00] 2025-09-05 19:56:52,808 - INFO - Writing docker-contexts/index-task.tar.gz for docker image index-task
[task 2025-09-05T19:56:52.810+00:00] 2025-09-05 19:56:52,810 - DEBUG - Generating tasks for docker-image python
[task 2025-09-05T19:56:52.810+00:00] 2025-09-05 19:56:52,810 - INFO - Writing docker-contexts/python.tar.gz for docker image python
[task 2025-09-05T19:56:52.828+00:00] 2025-09-05 19:56:52,827 - DEBUG - Generating tasks for docker-image run-task
[task 2025-09-05T19:56:52.828+00:00] 2025-09-05 19:56:52,828 - INFO - Writing docker-contexts/run-task.tar.gz for docker image run-task
[task 2025-09-05T19:56:52.845+00:00] 2025-09-05 19:56:52,845 - DEBUG - Generating tasks for docker-image skopeo
[task 2025-09-05T19:56:52.846+00:00] 2025-09-05 19:56:52,846 - INFO - Writing docker-contexts/skopeo.tar.gz for docker image skopeo
[task 2025-09-05T19:56:52.866+00:00] 2025-09-05 19:56:52,866 - INFO - Generated 6 tasks for kind docker-image
[task 2025-09-05T19:56:52.866+00:00] 2025-09-05 19:56:52,866 - DEBUG - Loading tasks for kind fetch
[task 2025-09-05T19:56:52.869+00:00] 2025-09-05 19:56:52,869 - DEBUG - Generating tasks for fetch codecov-uploader
[task 2025-09-05T19:56:52.871+00:00] 2025-09-05 19:56:52,871 - INFO - Generated 1 tasks for kind fetch
[task 2025-09-05T19:56:52.871+00:00] 2025-09-05 19:56:52,871 - DEBUG - Loading tasks for kind push-image
[task 2025-09-05T19:56:52.873+00:00] 2025-09-05 19:56:52,873 - DEBUG - Generating tasks for push-image decision
[task 2025-09-05T19:56:52.873+00:00] 2025-09-05 19:56:52,873 - DEBUG - Generating tasks for push-image run-task
[task 2025-09-05T19:56:52.874+00:00] 2025-09-05 19:56:52,874 - INFO - Generated 2 tasks for kind push-image
[task 2025-09-05T19:56:52.874+00:00] 2025-09-05 19:56:52,874 - DEBUG - Loading tasks for kind test
[task 2025-09-05T19:56:52.876+00:00] 2025-09-05 19:56:52,876 - DEBUG - Generating tasks for test unit
[task 2025-09-05T19:56:52.879+00:00] 2025-09-05 19:56:52,879 - INFO - Generated 6 tasks for kind test
[task 2025-09-05T19:56:52.879+00:00] 2025-09-05 19:56:52,879 - DEBUG - Loading tasks for kind codecov
[task 2025-09-05T19:56:52.882+00:00] 2025-09-05 19:56:52,881 - DEBUG - Generating tasks for codecov upload
[task 2025-09-05T19:56:52.883+00:00] 2025-09-05 19:56:52,883 - INFO - Generated 1 tasks for kind codecov
[task 2025-09-05T19:56:52.883+00:00] 2025-09-05 19:56:52,883 - DEBUG - Loading tasks for kind complete
[task 2025-09-05T19:56:52.883+00:00] 2025-09-05 19:56:52,883 - DEBUG - Generating tasks for complete pr
[task 2025-09-05T19:56:52.884+00:00] 2025-09-05 19:56:52,884 - INFO - Generated 1 tasks for kind complete
[task 2025-09-05T19:56:52.884+00:00] 2025-09-05 19:56:52,884 - INFO - Generating full task graph
[task 2025-09-05T19:56:52.884+00:00] 2025-09-05 19:56:52,884 - INFO - Full task graph contains 19 tasks and 29 dependencies
[task 2025-09-05T19:56:52.884+00:00] 2025-09-05 19:56:52,884 - INFO - writing artifact file `full-task-graph.json`
[task 2025-09-05T19:56:52.885+00:00] 2025-09-05 19:56:52,885 - INFO - writing artifact file `runnable-jobs.json`
[task 2025-09-05T19:56:52.885+00:00] 2025-09-05 19:56:52,885 - INFO - Generating target task set
[task 2025-09-05T19:56:52.886+00:00] 2025-09-05 19:56:52,886 - INFO - Filter filter_target_tasks pruned 9 tasks (10 remain)
[task 2025-09-05T19:56:52.886+00:00] 2025-09-05 19:56:52,886 - INFO - writing artifact file `target-tasks.json`
[task 2025-09-05T19:56:52.886+00:00] 2025-09-05 19:56:52,886 - INFO - Generating target task graph
[task 2025-09-05T19:56:52.886+00:00] 2025-09-05 19:56:52,886 - INFO - Adding 6 tasks with `always_target` attribute
[task 2025-09-05T19:56:52.886+00:00] 2025-09-05 19:56:52,886 - INFO - Generating optimized task graph
[task 2025-09-05T19:56:52.887+00:00] 2025-09-05 19:56:52,887 - DEBUG - optimize: codecov-upload kept because of never
[task 2025-09-05T19:56:52.887+00:00] 2025-09-05 19:56:52,887 - DEBUG - optimize: complete-pr kept because of never
[task 2025-09-05T19:56:52.887+00:00] 2025-09-05 19:56:52,887 - DEBUG - optimize: doc-generate kept because of never
[task 2025-09-05T19:56:52.887+00:00] 2025-09-05 19:56:52,887 - DEBUG - optimize: docker-image-decision kept because of index-search (index-search)
[task 2025-09-05T19:56:52.887+00:00] 2025-09-05 19:56:52,887 - DEBUG - optimize: docker-image-index-task kept because of index-search (index-search)
[task 2025-09-05T19:56:52.887+00:00] 2025-09-05 19:56:52,887 - DEBUG - optimize: docker-image-run-task kept because of dependent tasks
[task 2025-09-05T19:56:52.887+00:00] 2025-09-05 19:56:52,887 - DEBUG - optimize: docker-image-skopeo kept because of index-search (index-search)
[task 2025-09-05T19:56:52.887+00:00] 2025-09-05 19:56:52,887 - DEBUG - optimize: fetch-codecov-uploader kept because of dependent tasks
[task 2025-09-05T19:56:52.887+00:00] 2025-09-05 19:56:52,887 - DEBUG - optimize: test-unit-py310 kept because of dependent tasks
[task 2025-09-05T19:56:52.887+00:00] 2025-09-05 19:56:52,887 - DEBUG - optimize: test-unit-py311 kept because of dependent tasks
[task 2025-09-05T19:56:52.888+00:00] 2025-09-05 19:56:52,887 - DEBUG - optimize: test-unit-py312 kept because of dependent tasks
[task 2025-09-05T19:56:52.888+00:00] 2025-09-05 19:56:52,888 - DEBUG - optimize: test-unit-py313 kept because of dependent tasks
[task 2025-09-05T19:56:52.888+00:00] 2025-09-05 19:56:52,888 - DEBUG - optimize: test-unit-py38 kept because of dependent tasks
[task 2025-09-05T19:56:52.888+00:00] 2025-09-05 19:56:52,888 - DEBUG - optimize: test-unit-py39 kept because of dependent tasks
[task 2025-09-05T19:56:52.888+00:00] 2025-09-05 19:56:52,888 - DEBUG - optimize: check-type kept because of dependent tasks
[task 2025-09-05T19:56:52.888+00:00] 2025-09-05 19:56:52,888 - DEBUG - optimize: docker-image-fetch kept because of dependent tasks
[task 2025-09-05T19:56:52.888+00:00] 2025-09-05 19:56:52,888 - DEBUG - optimize: docker-image-python kept because of dependent tasks
[task 2025-09-05T19:56:52.888+00:00] 2025-09-05 19:56:52,888 - INFO - No tasks removed during optimization
[task 2025-09-05T19:56:52.888+00:00] 2025-09-05 19:56:52,888 - DEBUG - Running in Taskcluster instance https://firefox-ci-tc.services.mozilla.com with taskcluster-proxy
[task 2025-09-05T19:56:52.891+00:00] 2025-09-05 19:56:52,891 - DEBUG - Starting new HTTPS connection (1): firefox-ci-tc.services.mozilla.com:443
[task 2025-09-05T19:56:52.951+00:00] 2025-09-05 19:56:52,950 - DEBUG - https://firefox-ci-tc.services.mozilla.com:443 "POST /api/index/v1/tasks/indexes HTTP/1.1" 200 None
[task 2025-09-05T19:56:53.008+00:00] 2025-09-05 19:56:53,008 - DEBUG - https://firefox-ci-tc.services.mozilla.com:443 "POST /api/queue/v1/tasks/status HTTP/1.1" 200 None
[task 2025-09-05T19:56:53.009+00:00] 2025-09-05 19:56:53,009 - DEBUG - replace_tasks: docker-image-fetch
[task 2025-09-05T19:56:53.011+00:00] 2025-09-05 19:56:53,011 - DEBUG - replace_tasks: docker-image-fetch replaced with Xw6ifnOgRmGzfcw4fHs_Pw by optimization strategy
[task 2025-09-05T19:56:53.011+00:00] 2025-09-05 19:56:53,011 - DEBUG - replace_tasks: docker-image-index-task
[task 2025-09-05T19:56:53.011+00:00] 2025-09-05 19:56:53,011 - DEBUG - replace_tasks: docker-image-index-task replaced with Fz9tliuhSN2ohsHluS3bHw by optimization strategy
[task 2025-09-05T19:56:53.011+00:00] 2025-09-05 19:56:53,011 - DEBUG - replace_tasks: docker-image-python
[task 2025-09-05T19:56:53.011+00:00] 2025-09-05 19:56:53,011 - DEBUG - replace_tasks: docker-image-python replaced with Xn9RrKSySvSngDD2ufu0fQ by optimization strategy
[task 2025-09-05T19:56:53.011+00:00] 2025-09-05 19:56:53,011 - DEBUG - replace_tasks: docker-image-run-task
[task 2025-09-05T19:56:53.011+00:00] 2025-09-05 19:56:53,011 - DEBUG - replace_tasks: docker-image-run-task replaced with TW54TrRfTFOUpB3ysHWLAw by optimization strategy
[task 2025-09-05T19:56:53.011+00:00] 2025-09-05 19:56:53,011 - DEBUG - replace_tasks: docker-image-skopeo
[task 2025-09-05T19:56:53.012+00:00] 2025-09-05 19:56:53,012 - DEBUG - replace_tasks: docker-image-skopeo replaced with cU4G2ryJQ6OQgybXAtNdag by optimization strategy
[task 2025-09-05T19:56:53.012+00:00] 2025-09-05 19:56:53,012 - DEBUG - replace_tasks: fetch-codecov-uploader
[task 2025-09-05T19:56:53.012+00:00] 2025-09-05 19:56:53,012 - DEBUG - replace_tasks: fetch-codecov-uploader replaced with WBKuszMCRl2a40l3sFZ4rA by optimization strategy
[task 2025-09-05T19:56:53.012+00:00] 2025-09-05 19:56:53,012 - DEBUG - replace_tasks: test-unit-py310
[task 2025-09-05T19:56:53.012+00:00] 2025-09-05 19:56:53,012 - DEBUG - replace_tasks: test-unit-py310 kept by optimization strategy
[task 2025-09-05T19:56:53.012+00:00] 2025-09-05 19:56:53,012 - DEBUG - replace_tasks: test-unit-py311
[task 2025-09-05T19:56:53.012+00:00] 2025-09-05 19:56:53,012 - DEBUG - replace_tasks: test-unit-py311 kept by optimization strategy
[task 2025-09-05T19:56:53.012+00:00] 2025-09-05 19:56:53,012 - DEBUG - replace_tasks: test-unit-py312
[task 2025-09-05T19:56:53.013+00:00] 2025-09-05 19:56:53,013 - DEBUG - replace_tasks: test-unit-py312 kept by optimization strategy
[task 2025-09-05T19:56:53.013+00:00] 2025-09-05 19:56:53,013 - DEBUG - replace_tasks: test-unit-py313
[task 2025-09-05T19:56:53.013+00:00] 2025-09-05 19:56:53,013 - DEBUG - replace_tasks: test-unit-py313 kept by optimization strategy
[task 2025-09-05T19:56:53.013+00:00] 2025-09-05 19:56:53,013 - DEBUG - replace_tasks: test-unit-py38
[task 2025-09-05T19:56:53.013+00:00] 2025-09-05 19:56:53,013 - DEBUG - replace_tasks: test-unit-py38 kept by optimization strategy
[task 2025-09-05T19:56:53.013+00:00] 2025-09-05 19:56:53,013 - DEBUG - replace_tasks: test-unit-py39
[task 2025-09-05T19:56:53.013+00:00] 2025-09-05 19:56:53,013 - DEBUG - replace_tasks: test-unit-py39 kept by optimization strategy
[task 2025-09-05T19:56:53.013+00:00] 2025-09-05 19:56:53,013 - DEBUG - replace_tasks: check-type
[task 2025-09-05T19:56:53.014+00:00] 2025-09-05 19:56:53,014 - DEBUG - replace_tasks: check-type kept by optimization strategy
[task 2025-09-05T19:56:53.014+00:00] 2025-09-05 19:56:53,014 - DEBUG - replace_tasks: codecov-upload
[task 2025-09-05T19:56:53.014+00:00] 2025-09-05 19:56:53,014 - DEBUG - replace_tasks: codecov-upload depends on an unreplaced or unremoved task
[task 2025-09-05T19:56:53.014+00:00] 2025-09-05 19:56:53,014 - DEBUG - replace_tasks: complete-pr
[task 2025-09-05T19:56:53.014+00:00] 2025-09-05 19:56:53,014 - DEBUG - replace_tasks: complete-pr depends on an unreplaced or unremoved task
[task 2025-09-05T19:56:53.014+00:00] 2025-09-05 19:56:53,014 - DEBUG - replace_tasks: doc-generate
[task 2025-09-05T19:56:53.014+00:00] 2025-09-05 19:56:53,014 - DEBUG - replace_tasks: doc-generate kept by optimization strategy
[task 2025-09-05T19:56:53.014+00:00] 2025-09-05 19:56:53,014 - DEBUG - replace_tasks: docker-image-decision
[task 2025-09-05T19:56:53.014+00:00] 2025-09-05 19:56:53,014 - DEBUG - replace_tasks: docker-image-decision replaced with e8gpVpoKTGStaXvLdDDQnQ by optimization strategy
[task 2025-09-05T19:56:53.015+00:00] 2025-09-05 19:56:53,014 - INFO - Replaced 7 tasks by index-search (index-search) during optimization.
[task 2025-09-05T19:56:53.016+00:00] 2025-09-05 19:56:53,016 - DEBUG - Morphing: adding index tasks
[task 2025-09-05T19:56:53.016+00:00] 2025-09-05 19:56:53,016 - DEBUG - Morphing: adding code review task
[task 2025-09-05T19:56:53.016+00:00] 2025-09-05 19:56:53,016 - INFO - writing artifact file `task-graph.json`
[task 2025-09-05T19:56:53.017+00:00] 2025-09-05 19:56:53,016 - INFO - writing artifact file `label-to-taskid.json`
[task 2025-09-05T19:56:53.018+00:00] 2025-09-05 19:56:53,018 - INFO - Creating task with taskId VH1MNGCjTm6upUlUFh0GbA for test-unit-py312
[task 2025-09-05T19:56:53.020+00:00] 2025-09-05 19:56:53,020 - DEBUG - Starting new HTTP connection (1): taskcluster:80
[task 2025-09-05T19:56:53.020+00:00] 2025-09-05 19:56:53,020 - INFO - Creating task with taskId CYQPcIT7QESGiKGUtwz47g for doc-generate
[task 2025-09-05T19:56:53.021+00:00] 2025-09-05 19:56:53,021 - DEBUG - Starting new HTTP connection (2): taskcluster:80
[task 2025-09-05T19:56:53.023+00:00] 2025-09-05 19:56:53,023 - INFO - Creating task with taskId A38OL_zRR-6iq5_PaM3-UQ for test-unit-py38
[task 2025-09-05T19:56:53.025+00:00] 2025-09-05 19:56:53,025 - DEBUG - Starting new HTTP connection (3): taskcluster:80
[task 2025-09-05T19:56:53.027+00:00] 2025-09-05 19:56:53,026 - INFO - Creating task with taskId AU53x-t-SI2-iiwonbVj9A for test-unit-py310
[task 2025-09-05T19:56:53.028+00:00] 2025-09-05 19:56:53,028 - DEBUG - Starting new HTTP connection (4): taskcluster:80
[task 2025-09-05T19:56:53.029+00:00] 2025-09-05 19:56:53,029 - INFO - Creating task with taskId HUzJYWbmTR-jyKmqus1xQg for test-unit-py311
[task 2025-09-05T19:56:53.044+00:00] 2025-09-05 19:56:53,030 - INFO - Creating task with taskId YYt4OS21THqRU4LrxQ9JKw for check-type
[task 2025-09-05T19:56:53.044+00:00] 2025-09-05 19:56:53,033 - DEBUG - Starting new HTTP connection (5): taskcluster:80
[task 2025-09-05T19:56:53.044+00:00] 2025-09-05 19:56:53,030 - INFO - Creating task with taskId XTBMA9udTLWAVhMouBDLTw for test-unit-py313
[task 2025-09-05T19:56:53.044+00:00] 2025-09-05 19:56:53,035 - DEBUG - Starting new HTTP connection (6): taskcluster:80
[task 2025-09-05T19:56:53.044+00:00] 2025-09-05 19:56:53,031 - INFO - Creating task with taskId dYiI7uoKSj-LHGDm5jcDSQ for test-unit-py39
[task 2025-09-05T19:56:53.044+00:00] 2025-09-05 19:56:53,036 - DEBUG - Starting new HTTP connection (7): taskcluster:80
[task 2025-09-05T19:56:53.044+00:00] 2025-09-05 19:56:53,037 - DEBUG - Starting new HTTP connection (8): taskcluster:80
[task 2025-09-05T19:56:53.157+00:00] 2025-09-05 19:56:53,156 - DEBUG - http://taskcluster:80 "PUT /queue/v1/task/AU53x-t-SI2-iiwonbVj9A HTTP/1.1" 200 434
[task 2025-09-05T19:56:53.159+00:00] 2025-09-05 19:56:53,158 - DEBUG - http://taskcluster:80 "PUT /queue/v1/task/dYiI7uoKSj-LHGDm5jcDSQ HTTP/1.1" 200 434
[task 2025-09-05T19:56:53.160+00:00] 2025-09-05 19:56:53,159 - DEBUG - http://taskcluster:80 "PUT /queue/v1/task/A38OL_zRR-6iq5_PaM3-UQ HTTP/1.1" 200 434
[task 2025-09-05T19:56:53.161+00:00] 2025-09-05 19:56:53,160 - DEBUG - http://taskcluster:80 "PUT /queue/v1/task/XTBMA9udTLWAVhMouBDLTw HTTP/1.1" 200 434
[task 2025-09-05T19:56:53.162+00:00] 2025-09-05 19:56:53,161 - DEBUG - http://taskcluster:80 "PUT /queue/v1/task/CYQPcIT7QESGiKGUtwz47g HTTP/1.1" 200 434
[task 2025-09-05T19:56:53.167+00:00] 2025-09-05 19:56:53,167 - DEBUG - http://taskcluster:80 "PUT /queue/v1/task/VH1MNGCjTm6upUlUFh0GbA HTTP/1.1" 200 434
[task 2025-09-05T19:56:53.168+00:00] 2025-09-05 19:56:53,168 - DEBUG - http://taskcluster:80 "PUT /queue/v1/task/HUzJYWbmTR-jyKmqus1xQg HTTP/1.1" 200 434
[task 2025-09-05T19:56:53.170+00:00] 2025-09-05 19:56:53,169 - INFO - Creating task with taskId W69vSqx1TweEIHHkPehtKQ for codecov-upload
[task 2025-09-05T19:56:53.176+00:00] 2025-09-05 19:56:53,176 - DEBUG - http://taskcluster:80 "PUT /queue/v1/task/YYt4OS21THqRU4LrxQ9JKw HTTP/1.1" 200 434
[task 2025-09-05T19:56:53.267+00:00] 2025-09-05 19:56:53,267 - DEBUG - http://taskcluster:80 "PUT /queue/v1/task/W69vSqx1TweEIHHkPehtKQ HTTP/1.1" 200 434
[task 2025-09-05T19:56:53.268+00:00] 2025-09-05 19:56:53,268 - INFO - Creating task with taskId BOT_0Yw1RXy5_5UlMHruOA for complete-pr
[task 2025-09-05T19:56:53.352+00:00] 2025-09-05 19:56:53,352 - DEBUG - http://taskcluster:80 "PUT /queue/v1/task/BOT_0Yw1RXy5_5UlMHruOA HTTP/1.1" 200 424
[taskcluster 2025-09-05 19:56:53.574Z] === Task Finished ===
[taskcluster 2025-09-05 19:56:55.612Z] Successful task run with exit code: 0 completed in 7.578 seconds