[task 2024-09-06T20:32:42.388Z] + ln -s /builds/worker/artifacts artifacts
[task 2024-09-06T20:32:42.390Z] + pip3 install --user --break-system-packages .
[task 2024-09-06T20:32:42.794Z] Processing /builds/worker/checkouts/src
[task 2024-09-06T20:32:42.797Z]   Installing build dependencies: started
[task 2024-09-06T20:32:44.974Z]   Installing build dependencies: finished with status 'done'
[task 2024-09-06T20:32:44.977Z]   Getting requirements to build wheel: started
[task 2024-09-06T20:32:45.175Z]   Getting requirements to build wheel: finished with status 'done'
[task 2024-09-06T20:32:45.177Z]   Preparing metadata (pyproject.toml): started
[task 2024-09-06T20:32:45.396Z]   Preparing metadata (pyproject.toml): finished with status 'done'
[task 2024-09-06T20:32:45.411Z] Requirement already satisfied: appdirs>=1.4 in /usr/local/lib/python3.11/dist-packages (from taskcluster-taskgraph==11.0.0) (1.4.4)
[task 2024-09-06T20:32:45.413Z] Requirement already satisfied: cookiecutter~=2.1 in /usr/local/lib/python3.11/dist-packages (from taskcluster-taskgraph==11.0.0) (2.6.0)
[task 2024-09-06T20:32:45.416Z] Requirement already satisfied: json-e>=2.7 in /usr/local/lib/python3.11/dist-packages (from taskcluster-taskgraph==11.0.0) (4.7.1)
[task 2024-09-06T20:32:45.417Z] Requirement already satisfied: mozilla-repo-urls in /usr/local/lib/python3.11/dist-packages (from taskcluster-taskgraph==11.0.0) (0.1.1)
[task 2024-09-06T20:32:45.419Z] Requirement already satisfied: PyYAML>=5.3.1 in /usr/local/lib/python3.11/dist-packages (from taskcluster-taskgraph==11.0.0) (6.0.1)
[task 2024-09-06T20:32:45.421Z] Requirement already satisfied: redo>=2.0 in /usr/local/lib/python3.11/dist-packages (from taskcluster-taskgraph==11.0.0) (3.0.0)
[task 2024-09-06T20:32:45.423Z] Requirement already satisfied: requests>=2.25 in /usr/local/lib/python3.11/dist-packages (from taskcluster-taskgraph==11.0.0) (2.32.3)
[task 2024-09-06T20:32:45.425Z] Requirement already satisfied: slugid>=2.0 in /usr/local/lib/python3.11/dist-packages (from taskcluster-taskgraph==11.0.0) (2.0.0)
[task 2024-09-06T20:32:45.427Z] Requirement already satisfied: taskcluster-urls>=11.0 in /usr/local/lib/python3.11/dist-packages (from taskcluster-taskgraph==11.0.0) (13.0.1)
[task 2024-09-06T20:32:45.430Z] Requirement already satisfied: voluptuous>=0.12.1 in /usr/local/lib/python3.11/dist-packages (from taskcluster-taskgraph==11.0.0) (0.14.2)
[task 2024-09-06T20:32:45.440Z] Requirement already satisfied: binaryornot>=0.4.4 in /usr/local/lib/python3.11/dist-packages (from cookiecutter~=2.1->taskcluster-taskgraph==11.0.0) (0.4.4)
[task 2024-09-06T20:32:45.442Z] Requirement already satisfied: Jinja2<4.0.0,>=2.7 in /usr/local/lib/python3.11/dist-packages (from cookiecutter~=2.1->taskcluster-taskgraph==11.0.0) (3.1.4)
[task 2024-09-06T20:32:45.443Z] Requirement already satisfied: click<9.0.0,>=7.0 in /usr/local/lib/python3.11/dist-packages (from cookiecutter~=2.1->taskcluster-taskgraph==11.0.0) (8.1.7)
[task 2024-09-06T20:32:45.445Z] Requirement already satisfied: python-slugify>=4.0.0 in /usr/local/lib/python3.11/dist-packages (from cookiecutter~=2.1->taskcluster-taskgraph==11.0.0) (8.0.4)
[task 2024-09-06T20:32:45.447Z] Requirement already satisfied: arrow in /usr/local/lib/python3.11/dist-packages (from cookiecutter~=2.1->taskcluster-taskgraph==11.0.0) (1.3.0)
[task 2024-09-06T20:32:45.449Z] Requirement already satisfied: rich in /usr/local/lib/python3.11/dist-packages (from cookiecutter~=2.1->taskcluster-taskgraph==11.0.0) (13.7.1)
[task 2024-09-06T20:32:45.467Z] Requirement already satisfied: charset-normalizer<4,>=2 in /usr/local/lib/python3.11/dist-packages (from requests>=2.25->taskcluster-taskgraph==11.0.0) (3.3.2)
[task 2024-09-06T20:32:45.469Z] Requirement already satisfied: idna<4,>=2.5 in /usr/local/lib/python3.11/dist-packages (from requests>=2.25->taskcluster-taskgraph==11.0.0) (3.7)
[task 2024-09-06T20:32:45.471Z] Requirement already satisfied: urllib3<3,>=1.21.1 in /usr/local/lib/python3.11/dist-packages (from requests>=2.25->taskcluster-taskgraph==11.0.0) (2.2.2)
[task 2024-09-06T20:32:45.473Z] Requirement already satisfied: certifi>=2017.4.17 in /usr/local/lib/python3.11/dist-packages (from requests>=2.25->taskcluster-taskgraph==11.0.0) (2024.7.4)
[task 2024-09-06T20:32:45.491Z] Requirement already satisfied: giturlparse in /usr/local/lib/python3.11/dist-packages (from mozilla-repo-urls->taskcluster-taskgraph==11.0.0) (0.12.0)
[task 2024-09-06T20:32:45.499Z] Requirement already satisfied: chardet>=3.0.2 in /usr/local/lib/python3.11/dist-packages (from binaryornot>=0.4.4->cookiecutter~=2.1->taskcluster-taskgraph==11.0.0) (5.2.0)
[task 2024-09-06T20:32:45.536Z] Requirement already satisfied: MarkupSafe>=2.0 in /usr/local/lib/python3.11/dist-packages (from Jinja2<4.0.0,>=2.7->cookiecutter~=2.1->taskcluster-taskgraph==11.0.0) (2.1.5)
[task 2024-09-06T20:32:45.548Z] Requirement already satisfied: text-unidecode>=1.3 in /usr/local/lib/python3.11/dist-packages (from python-slugify>=4.0.0->cookiecutter~=2.1->taskcluster-taskgraph==11.0.0) (1.3)
[task 2024-09-06T20:32:45.585Z] Requirement already satisfied: python-dateutil>=2.7.0 in /usr/local/lib/python3.11/dist-packages (from arrow->cookiecutter~=2.1->taskcluster-taskgraph==11.0.0) (2.9.0.post0)
[task 2024-09-06T20:32:45.587Z] Requirement already satisfied: types-python-dateutil>=2.8.10 in /usr/local/lib/python3.11/dist-packages (from arrow->cookiecutter~=2.1->taskcluster-taskgraph==11.0.0) (2.9.0.20240316)
[task 2024-09-06T20:32:45.610Z] Requirement already satisfied: markdown-it-py>=2.2.0 in /usr/local/lib/python3.11/dist-packages (from rich->cookiecutter~=2.1->taskcluster-taskgraph==11.0.0) (3.0.0)
[task 2024-09-06T20:32:45.612Z] 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==11.0.0) (2.18.0)
[task 2024-09-06T20:32:45.654Z] 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==11.0.0) (0.1.2)
[task 2024-09-06T20:32:45.687Z] 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==11.0.0) (1.16.0)
[task 2024-09-06T20:32:45.742Z] Building wheels for collected packages: taskcluster-taskgraph
[task 2024-09-06T20:32:45.743Z]   Building wheel for taskcluster-taskgraph (pyproject.toml): started
[task 2024-09-06T20:32:46.057Z]   Building wheel for taskcluster-taskgraph (pyproject.toml): finished with status 'done'
[task 2024-09-06T20:32:46.059Z]   Created wheel for taskcluster-taskgraph: filename=taskcluster_taskgraph-11.0.0-py3-none-any.whl size=191660 sha256=23673b6801146c5176eeb88e4b87f47257d37bc3c0266e0c03d1add2353197ab
[task 2024-09-06T20:32:46.060Z]   Stored in directory: /tmp/pip-ephem-wheel-cache-qto6os3d/wheels/54/fa/b4/d3017bf051c083cc076bfd93af1693baf4c91b8f6fee74b0bc
[task 2024-09-06T20:32:46.063Z] Successfully built taskcluster-taskgraph
[task 2024-09-06T20:32:46.162Z] Installing collected packages: taskcluster-taskgraph
[task 2024-09-06T20:32:46.259Z]   WARNING: The script taskgraph is installed in '/builds/worker/.local/bin' which is not on PATH.
[task 2024-09-06T20:32:46.259Z]   Consider adding this directory to PATH or, if you prefer to suppress this warning, use --no-warn-script-location.
[task 2024-09-06T20:32:46.268Z] Successfully installed taskcluster-taskgraph-11.0.0
[task 2024-09-06T20:32:46.380Z] + 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=c42867951e5010c9d128f673fd91f42a2e681a8d --head-repository=https://github.com/ahal/taskgraph --head-ref=fix_init --head-rev=3c9c39c8280f752c40edc9a3f5813eda1c7b6b28
[task 2024-09-06T20:32:46.668Z] 2024-09-06 20:32:46,667 - INFO - Loading graph configuration.
[task 2024-09-06T20:32:46.669Z] 2024-09-06 20:32:46,668 - DEBUG - loading config from `taskcluster/config.yml`
[task 2024-09-06T20:32:46.678Z] 2024-09-06 20:32:46,678 - 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 2024-09-06T20:32:46.679Z] 2024-09-06 20:32:46,678 - INFO - Using Parameters(id=8f874641363f) (from defaults)
[task 2024-09-06T20:32:46.680Z] 2024-09-06 20:32:46,679 - DEBUG - Dumping parameters:
[task 2024-09-06T20:32:46.681Z] { 'base_ref': 'main',
[task 2024-09-06T20:32:46.682Z]   'base_repository': 'https://github.com/taskcluster/taskgraph',
[task 2024-09-06T20:32:46.683Z]   'base_rev': 'c42867951e5010c9d128f673fd91f42a2e681a8d',
[task 2024-09-06T20:32:46.684Z]   'build_date': 1725654766,
[task 2024-09-06T20:32:46.685Z]   'build_number': 1,
[task 2024-09-06T20:32:46.686Z]   'do_not_optimize': [],
[task 2024-09-06T20:32:46.686Z]   'enable_always_target': True,
[task 2024-09-06T20:32:46.686Z]   'existing_tasks': {},
[task 2024-09-06T20:32:46.686Z]   'files_changed': [ 'template/{{cookiecutter.project_name}}/taskcluster/docker/linux/Dockerfile',
[task 2024-09-06T20:32:46.686Z]                      'taskcluster/docker/fetch/Dockerfile',
[task 2024-09-06T20:32:46.686Z]                      'taskcluster/docker/run-task/Dockerfile',
[task 2024-09-06T20:32:46.686Z]                      'template/{{cookiecutter.project_name}}/taskcluster/docker/linux/Dockerfile'],
[task 2024-09-06T20:32:46.686Z]   'filters': ['target_tasks_method'],
[task 2024-09-06T20:32:46.686Z]   'head_ref': 'fix_init',
[task 2024-09-06T20:32:46.686Z]   'head_repository': 'https://github.com/ahal/taskgraph',
[task 2024-09-06T20:32:46.686Z]   'head_rev': '3c9c39c8280f752c40edc9a3f5813eda1c7b6b28',
[task 2024-09-06T20:32:46.686Z]   'head_tag': '',
[task 2024-09-06T20:32:46.686Z]   'level': '1',
[task 2024-09-06T20:32:46.686Z]   'moz_build_date': '20240906203246',
[task 2024-09-06T20:32:46.686Z]   'next_version': None,
[task 2024-09-06T20:32:46.686Z]   'optimize_strategies': None,
[task 2024-09-06T20:32:46.686Z]   'optimize_target_tasks': True,
[task 2024-09-06T20:32:46.686Z]   'owner': 'ahal@users.noreply.github.com',
[task 2024-09-06T20:32:46.686Z]   'project': 'taskgraph',
[task 2024-09-06T20:32:46.686Z]   'pushdate': 0,
[task 2024-09-06T20:32:46.687Z]   'pushlog_id': '0',
[task 2024-09-06T20:32:46.687Z]   'repository_type': 'git',
[task 2024-09-06T20:32:46.687Z]   'target_tasks_method': 'default',
[task 2024-09-06T20:32:46.687Z]   'tasks_for': 'github-pull-request',
[task 2024-09-06T20:32:46.687Z]   'version': None}
[task 2024-09-06T20:32:46.687Z] 2024-09-06 20:32:46,679 - INFO - writing artifact file `parameters.yml`
[task 2024-09-06T20:32:46.689Z] 2024-09-06 20:32:46,689 - INFO - writing artifact file `actions.json`
[task 2024-09-06T20:32:46.690Z] 2024-09-06 20:32:46,690 - INFO - Loading kinds
[task 2024-09-06T20:32:46.691Z] 2024-09-06 20:32:46,690 - DEBUG - loading kind `test` from `taskcluster/kinds/test`
[task 2024-09-06T20:32:46.691Z] 2024-09-06 20:32:46,691 - DEBUG - loading kind `codecov` from `taskcluster/kinds/codecov`
[task 2024-09-06T20:32:46.692Z] 2024-09-06 20:32:46,692 - DEBUG - loading kind `push-image` from `taskcluster/kinds/push-image`
[task 2024-09-06T20:32:46.693Z] 2024-09-06 20:32:46,693 - DEBUG - loading kind `fetch` from `taskcluster/kinds/fetch`
[task 2024-09-06T20:32:46.693Z] 2024-09-06 20:32:46,693 - DEBUG - loading kind `docker-image` from `taskcluster/kinds/docker-image`
[task 2024-09-06T20:32:46.694Z] 2024-09-06 20:32:46,694 - DEBUG - loading kind `doc` from `taskcluster/kinds/doc`
[task 2024-09-06T20:32:46.695Z] 2024-09-06 20:32:46,695 - DEBUG - loading kind `check` from `taskcluster/kinds/check`
[task 2024-09-06T20:32:46.696Z] 2024-09-06 20:32:46,696 - INFO - Generating full task set
[task 2024-09-06T20:32:46.696Z] 2024-09-06 20:32:46,696 - DEBUG - Loading tasks for kind check
[task 2024-09-06T20:32:46.712Z] 2024-09-06 20:32:46,712 - DEBUG - Generating tasks for check type
[task 2024-09-06T20:32:46.714Z] 2024-09-06 20:32:46,714 - INFO - Generated 1 tasks for kind check
[task 2024-09-06T20:32:46.714Z] 2024-09-06 20:32:46,714 - DEBUG - Loading tasks for kind doc
[task 2024-09-06T20:32:46.715Z] 2024-09-06 20:32:46,715 - DEBUG - Generating tasks for doc generate
[task 2024-09-06T20:32:46.717Z] 2024-09-06 20:32:46,716 - INFO - Generated 1 tasks for kind doc
[task 2024-09-06T20:32:46.717Z] 2024-09-06 20:32:46,716 - DEBUG - Loading tasks for kind docker-image
[task 2024-09-06T20:32:46.718Z] 2024-09-06 20:32:46,718 - DEBUG - Generating tasks for docker-image decision
[task 2024-09-06T20:32:46.718Z] 2024-09-06 20:32:46,718 - INFO - Writing docker-contexts/decision.tar.gz for docker image decision
[task 2024-09-06T20:32:46.810Z] 2024-09-06 20:32:46,809 - DEBUG - Generating tasks for docker-image fetch
[task 2024-09-06T20:32:46.810Z] 2024-09-06 20:32:46,810 - INFO - Writing docker-contexts/fetch.tar.gz for docker image fetch
[task 2024-09-06T20:32:46.822Z] 2024-09-06 20:32:46,822 - DEBUG - Generating tasks for docker-image index-task
[task 2024-09-06T20:32:46.822Z] 2024-09-06 20:32:46,822 - INFO - Writing docker-contexts/index-task.tar.gz for docker image index-task
[task 2024-09-06T20:32:46.824Z] 2024-09-06 20:32:46,824 - DEBUG - Generating tasks for docker-image py38
[task 2024-09-06T20:32:46.824Z] 2024-09-06 20:32:46,824 - INFO - Writing docker-contexts/py38.tar.gz for docker image py38
[task 2024-09-06T20:32:46.842Z] 2024-09-06 20:32:46,841 - DEBUG - Generating tasks for docker-image py39
[task 2024-09-06T20:32:46.842Z] 2024-09-06 20:32:46,842 - INFO - Writing docker-contexts/py39.tar.gz for docker image py39
[task 2024-09-06T20:32:46.859Z] 2024-09-06 20:32:46,859 - DEBUG - Generating tasks for docker-image py310
[task 2024-09-06T20:32:46.859Z] 2024-09-06 20:32:46,859 - INFO - Writing docker-contexts/py310.tar.gz for docker image py310
[task 2024-09-06T20:32:46.877Z] 2024-09-06 20:32:46,877 - DEBUG - Generating tasks for docker-image py311
[task 2024-09-06T20:32:46.877Z] 2024-09-06 20:32:46,877 - INFO - Writing docker-contexts/py311.tar.gz for docker image py311
[task 2024-09-06T20:32:46.894Z] 2024-09-06 20:32:46,894 - DEBUG - Generating tasks for docker-image py312
[task 2024-09-06T20:32:46.895Z] 2024-09-06 20:32:46,894 - INFO - Writing docker-contexts/py312.tar.gz for docker image py312
[task 2024-09-06T20:32:46.912Z] 2024-09-06 20:32:46,912 - DEBUG - Generating tasks for docker-image run-task
[task 2024-09-06T20:32:46.912Z] 2024-09-06 20:32:46,912 - INFO - Writing docker-contexts/run-task.tar.gz for docker image run-task
[task 2024-09-06T20:32:46.930Z] 2024-09-06 20:32:46,930 - DEBUG - Generating tasks for docker-image skopeo
[task 2024-09-06T20:32:46.930Z] 2024-09-06 20:32:46,930 - INFO - Writing docker-contexts/skopeo.tar.gz for docker image skopeo
[task 2024-09-06T20:32:46.951Z] 2024-09-06 20:32:46,951 - INFO - Generated 10 tasks for kind docker-image
[task 2024-09-06T20:32:46.951Z] 2024-09-06 20:32:46,951 - DEBUG - Loading tasks for kind fetch
[task 2024-09-06T20:32:46.955Z] 2024-09-06 20:32:46,955 - DEBUG - Generating tasks for fetch codecov-uploader
[task 2024-09-06T20:32:46.956Z] 2024-09-06 20:32:46,956 - INFO - Generated 1 tasks for kind fetch
[task 2024-09-06T20:32:46.956Z] 2024-09-06 20:32:46,956 - DEBUG - Loading tasks for kind push-image
[task 2024-09-06T20:32:46.959Z] 2024-09-06 20:32:46,959 - DEBUG - Generating tasks for push-image decision
[task 2024-09-06T20:32:46.959Z] 2024-09-06 20:32:46,959 - DEBUG - Generating tasks for push-image run-task
[task 2024-09-06T20:32:46.961Z] 2024-09-06 20:32:46,961 - INFO - Generated 2 tasks for kind push-image
[task 2024-09-06T20:32:46.961Z] 2024-09-06 20:32:46,961 - DEBUG - Loading tasks for kind test
[task 2024-09-06T20:32:46.963Z] 2024-09-06 20:32:46,963 - DEBUG - Generating tasks for test unit
[task 2024-09-06T20:32:46.966Z] 2024-09-06 20:32:46,966 - INFO - Generated 5 tasks for kind test
[task 2024-09-06T20:32:46.966Z] 2024-09-06 20:32:46,966 - DEBUG - Loading tasks for kind codecov
[task 2024-09-06T20:32:46.969Z] 2024-09-06 20:32:46,969 - DEBUG - Generating tasks for codecov upload
[task 2024-09-06T20:32:46.971Z] 2024-09-06 20:32:46,971 - INFO - Generated 1 tasks for kind codecov
[task 2024-09-06T20:32:46.971Z] 2024-09-06 20:32:46,971 - INFO - Generating full task graph
[task 2024-09-06T20:32:46.971Z] 2024-09-06 20:32:46,971 - INFO - Full task graph contains 21 tasks and 20 dependencies
[task 2024-09-06T20:32:46.972Z] 2024-09-06 20:32:46,972 - INFO - writing artifact file `full-task-graph.json`
[task 2024-09-06T20:32:46.976Z] 2024-09-06 20:32:46,976 - INFO - writing artifact file `runnable-jobs.json`
[task 2024-09-06T20:32:46.977Z] 2024-09-06 20:32:46,977 - INFO - Generating target task set
[task 2024-09-06T20:32:46.978Z] 2024-09-06 20:32:46,977 - INFO - Filter filter_target_tasks pruned 13 tasks (8 remain)
[task 2024-09-06T20:32:46.978Z] 2024-09-06 20:32:46,978 - INFO - writing artifact file `target-tasks.json`
[task 2024-09-06T20:32:46.978Z] 2024-09-06 20:32:46,978 - INFO - Generating target task graph
[task 2024-09-06T20:32:46.978Z] 2024-09-06 20:32:46,978 - INFO - Adding 10 tasks with `always_target` attribute
[task 2024-09-06T20:32:46.978Z] 2024-09-06 20:32:46,978 - INFO - Generating optimized task graph
[task 2024-09-06T20:32:46.979Z] 2024-09-06 20:32:46,979 - DEBUG - optimize: build-docker-image-decision kept because of index-search (index-search)
[task 2024-09-06T20:32:46.979Z] 2024-09-06 20:32:46,979 - DEBUG - optimize: build-docker-image-index-task kept because of index-search (index-search)
[task 2024-09-06T20:32:46.979Z] 2024-09-06 20:32:46,979 - DEBUG - optimize: build-docker-image-run-task kept because of dependent tasks
[task 2024-09-06T20:32:46.979Z] 2024-09-06 20:32:46,979 - DEBUG - optimize: build-docker-image-skopeo kept because of index-search (index-search)
[task 2024-09-06T20:32:46.979Z] 2024-09-06 20:32:46,979 - DEBUG - optimize: check-type kept because of never
[task 2024-09-06T20:32:46.979Z] 2024-09-06 20:32:46,979 - DEBUG - optimize: codecov-upload kept because of never
[task 2024-09-06T20:32:46.979Z] 2024-09-06 20:32:46,979 - DEBUG - optimize: doc-generate kept because of never
[task 2024-09-06T20:32:46.979Z] 2024-09-06 20:32:46,979 - DEBUG - optimize: fetch-codecov-uploader kept because of dependent tasks
[task 2024-09-06T20:32:46.980Z] 2024-09-06 20:32:46,979 - DEBUG - optimize: test-unit-py310 kept because of dependent tasks
[task 2024-09-06T20:32:46.980Z] 2024-09-06 20:32:46,979 - DEBUG - optimize: test-unit-py311 kept because of dependent tasks
[task 2024-09-06T20:32:46.980Z] 2024-09-06 20:32:46,979 - DEBUG - optimize: test-unit-py312 kept because of dependent tasks
[task 2024-09-06T20:32:46.980Z] 2024-09-06 20:32:46,980 - DEBUG - optimize: test-unit-py38 kept because of dependent tasks
[task 2024-09-06T20:32:46.980Z] 2024-09-06 20:32:46,980 - DEBUG - optimize: test-unit-py39 kept because of dependent tasks
[task 2024-09-06T20:32:46.980Z] 2024-09-06 20:32:46,980 - DEBUG - optimize: build-docker-image-fetch kept because of dependent tasks
[task 2024-09-06T20:32:46.980Z] 2024-09-06 20:32:46,980 - DEBUG - optimize: build-docker-image-py310 kept because of dependent tasks
[task 2024-09-06T20:32:46.980Z] 2024-09-06 20:32:46,980 - DEBUG - optimize: build-docker-image-py311 kept because of dependent tasks
[task 2024-09-06T20:32:46.980Z] 2024-09-06 20:32:46,980 - DEBUG - optimize: build-docker-image-py312 kept because of dependent tasks
[task 2024-09-06T20:32:46.980Z] 2024-09-06 20:32:46,980 - DEBUG - optimize: build-docker-image-py38 kept because of dependent tasks
[task 2024-09-06T20:32:46.980Z] 2024-09-06 20:32:46,980 - DEBUG - optimize: build-docker-image-py39 kept because of dependent tasks
[task 2024-09-06T20:32:46.980Z] 2024-09-06 20:32:46,980 - INFO - No tasks removed during optimization
[task 2024-09-06T20:32:46.980Z] 2024-09-06 20:32:46,980 - DEBUG - Running in Taskcluster instance https://firefox-ci-tc.services.mozilla.com with taskcluster-proxy
[task 2024-09-06T20:32:46.983Z] 2024-09-06 20:32:46,983 - DEBUG - Starting new HTTPS connection (1): firefox-ci-tc.services.mozilla.com:443
[task 2024-09-06T20:32:47.057Z] 2024-09-06 20:32:47,057 - DEBUG - https://firefox-ci-tc.services.mozilla.com:443 "POST /api/index/v1/tasks/indexes HTTP/11" 200 None
[task 2024-09-06T20:32:47.107Z] 2024-09-06 20:32:47,107 - DEBUG - https://firefox-ci-tc.services.mozilla.com:443 "POST /api/queue/v1/tasks/status HTTP/11" 200 None
[task 2024-09-06T20:32:47.108Z] 2024-09-06 20:32:47,108 - DEBUG - replace_tasks: build-docker-image-fetch
[task 2024-09-06T20:32:47.108Z] 2024-09-06 20:32:47,108 - DEBUG - replace_tasks: build-docker-image-fetch kept by optimization strategy
[task 2024-09-06T20:32:47.108Z] 2024-09-06 20:32:47,108 - DEBUG - replace_tasks: build-docker-image-index-task
[task 2024-09-06T20:32:47.109Z] 2024-09-06 20:32:47,108 - DEBUG - replace_tasks: build-docker-image-index-task replaced with AeoSQIL9QhCfYYsPaMheLw by optimization strategy
[task 2024-09-06T20:32:47.109Z] 2024-09-06 20:32:47,109 - DEBUG - replace_tasks: build-docker-image-py310
[task 2024-09-06T20:32:47.111Z] 2024-09-06 20:32:47,111 - DEBUG - replace_tasks: build-docker-image-py310 replaced with UdZcoUP6SAe0Zb83vhAOpg by optimization strategy
[task 2024-09-06T20:32:47.111Z] 2024-09-06 20:32:47,111 - DEBUG - replace_tasks: build-docker-image-py311
[task 2024-09-06T20:32:47.111Z] 2024-09-06 20:32:47,111 - DEBUG - replace_tasks: build-docker-image-py311 replaced with HckjWDWWQ_m57QFAgmwuPg by optimization strategy
[task 2024-09-06T20:32:47.111Z] 2024-09-06 20:32:47,111 - DEBUG - replace_tasks: build-docker-image-py312
[task 2024-09-06T20:32:47.111Z] 2024-09-06 20:32:47,111 - DEBUG - replace_tasks: build-docker-image-py312 replaced with P570Kk0ARmW377MF087XHQ by optimization strategy
[task 2024-09-06T20:32:47.111Z] 2024-09-06 20:32:47,111 - DEBUG - replace_tasks: build-docker-image-py38
[task 2024-09-06T20:32:47.112Z] 2024-09-06 20:32:47,112 - DEBUG - replace_tasks: build-docker-image-py38 replaced with I4ZXj-A0S4e3MgeXXn-QwQ by optimization strategy
[task 2024-09-06T20:32:47.112Z] 2024-09-06 20:32:47,112 - DEBUG - replace_tasks: build-docker-image-py39
[task 2024-09-06T20:32:47.112Z] 2024-09-06 20:32:47,112 - DEBUG - replace_tasks: build-docker-image-py39 replaced with H7tNtCKHRYaUND_Zq2vbMg by optimization strategy
[task 2024-09-06T20:32:47.112Z] 2024-09-06 20:32:47,112 - DEBUG - replace_tasks: build-docker-image-run-task
[task 2024-09-06T20:32:47.112Z] 2024-09-06 20:32:47,112 - DEBUG - replace_tasks: build-docker-image-run-task kept by optimization strategy
[task 2024-09-06T20:32:47.112Z] 2024-09-06 20:32:47,112 - DEBUG - replace_tasks: build-docker-image-skopeo
[task 2024-09-06T20:32:47.112Z] 2024-09-06 20:32:47,112 - DEBUG - replace_tasks: build-docker-image-skopeo replaced with FhNvXF3JTg6dNLh2OkYzQw by optimization strategy
[task 2024-09-06T20:32:47.112Z] 2024-09-06 20:32:47,112 - DEBUG - replace_tasks: check-type
[task 2024-09-06T20:32:47.112Z] 2024-09-06 20:32:47,112 - DEBUG - replace_tasks: check-type kept by optimization strategy
[task 2024-09-06T20:32:47.113Z] 2024-09-06 20:32:47,112 - DEBUG - replace_tasks: doc-generate
[task 2024-09-06T20:32:47.113Z] 2024-09-06 20:32:47,113 - DEBUG - replace_tasks: doc-generate kept by optimization strategy
[task 2024-09-06T20:32:47.113Z] 2024-09-06 20:32:47,113 - DEBUG - replace_tasks: fetch-codecov-uploader
[task 2024-09-06T20:32:47.113Z] 2024-09-06 20:32:47,113 - DEBUG - replace_tasks: fetch-codecov-uploader depends on an unreplaced or unremoved task
[task 2024-09-06T20:32:47.113Z] 2024-09-06 20:32:47,113 - DEBUG - replace_tasks: test-unit-py310
[task 2024-09-06T20:32:47.113Z] 2024-09-06 20:32:47,113 - DEBUG - replace_tasks: test-unit-py310 kept by optimization strategy
[task 2024-09-06T20:32:47.113Z] 2024-09-06 20:32:47,113 - DEBUG - replace_tasks: test-unit-py311
[task 2024-09-06T20:32:47.113Z] 2024-09-06 20:32:47,113 - DEBUG - replace_tasks: test-unit-py311 kept by optimization strategy
[task 2024-09-06T20:32:47.113Z] 2024-09-06 20:32:47,113 - DEBUG - replace_tasks: test-unit-py312
[task 2024-09-06T20:32:47.113Z] 2024-09-06 20:32:47,113 - DEBUG - replace_tasks: test-unit-py312 kept by optimization strategy
[task 2024-09-06T20:32:47.113Z] 2024-09-06 20:32:47,113 - DEBUG - replace_tasks: test-unit-py38
[task 2024-09-06T20:32:47.114Z] 2024-09-06 20:32:47,114 - DEBUG - replace_tasks: test-unit-py38 kept by optimization strategy
[task 2024-09-06T20:32:47.114Z] 2024-09-06 20:32:47,114 - DEBUG - replace_tasks: test-unit-py39
[task 2024-09-06T20:32:47.114Z] 2024-09-06 20:32:47,114 - DEBUG - replace_tasks: test-unit-py39 kept by optimization strategy
[task 2024-09-06T20:32:47.114Z] 2024-09-06 20:32:47,114 - DEBUG - replace_tasks: build-docker-image-decision
[task 2024-09-06T20:32:47.114Z] 2024-09-06 20:32:47,114 - DEBUG - replace_tasks: build-docker-image-decision depends on an unreplaced or unremoved task
[task 2024-09-06T20:32:47.114Z] 2024-09-06 20:32:47,114 - DEBUG - replace_tasks: codecov-upload
[task 2024-09-06T20:32:47.114Z] 2024-09-06 20:32:47,114 - DEBUG - replace_tasks: codecov-upload depends on an unreplaced or unremoved task
[task 2024-09-06T20:32:47.114Z] 2024-09-06 20:32:47,114 - INFO - Replaced 7 tasks by index-search (index-search) during optimization.
[task 2024-09-06T20:32:47.117Z] 2024-09-06 20:32:47,117 - DEBUG - Morphing: adding index tasks
[task 2024-09-06T20:32:47.117Z] 2024-09-06 20:32:47,117 - DEBUG - Morphing: adding code review task
[task 2024-09-06T20:32:47.117Z] 2024-09-06 20:32:47,117 - INFO - writing artifact file `task-graph.json`
[task 2024-09-06T20:32:47.121Z] 2024-09-06 20:32:47,121 - INFO - writing artifact file `label-to-taskid.json`
[task 2024-09-06T20:32:47.124Z] 2024-09-06 20:32:47,124 - INFO - Creating task with taskId MivNYUPyT4aoLuo5xOIFfw for test-unit-py312
[task 2024-09-06T20:32:47.126Z] 2024-09-06 20:32:47,126 - DEBUG - Starting new HTTP connection (1): taskcluster:80
[task 2024-09-06T20:32:47.127Z] 2024-09-06 20:32:47,127 - INFO - Creating task with taskId OclSvbZzT-SISt5b1VOR3g for check-type
[task 2024-09-06T20:32:47.129Z] 2024-09-06 20:32:47,128 - DEBUG - Starting new HTTP connection (2): taskcluster:80
[task 2024-09-06T20:32:47.130Z] 2024-09-06 20:32:47,130 - INFO - Creating task with taskId WSF0rK6wQwy89S4kQvJ5nQ for test-unit-py38
[task 2024-09-06T20:32:47.133Z] 2024-09-06 20:32:47,133 - DEBUG - Starting new HTTP connection (3): taskcluster:80
[task 2024-09-06T20:32:47.136Z] 2024-09-06 20:32:47,136 - INFO - Creating task with taskId f_gMV9TNRH6495-PUbX-Sw for test-unit-py310
[task 2024-09-06T20:32:47.138Z] 2024-09-06 20:32:47,138 - DEBUG - Starting new HTTP connection (4): taskcluster:80
[task 2024-09-06T20:32:47.140Z] 2024-09-06 20:32:47,139 - INFO - Creating task with taskId f7PD8TtkR_Ocsulw3TZhVg for build-docker-image-fetch
[task 2024-09-06T20:32:47.142Z] 2024-09-06 20:32:47,142 - DEBUG - Starting new HTTP connection (5): taskcluster:80
[task 2024-09-06T20:32:47.146Z] 2024-09-06 20:32:47,146 - INFO - Creating task with taskId XHeT_IJSTAaYZZLPaBan3g for doc-generate
[task 2024-09-06T20:32:47.148Z] 2024-09-06 20:32:47,148 - DEBUG - Starting new HTTP connection (6): taskcluster:80
[task 2024-09-06T20:32:47.151Z] 2024-09-06 20:32:47,150 - INFO - Creating task with taskId GoOJmFNAQeeZU7wP9sM45A for test-unit-py311
[task 2024-09-06T20:32:47.153Z] 2024-09-06 20:32:47,153 - DEBUG - Starting new HTTP connection (7): taskcluster:80
[task 2024-09-06T20:32:47.157Z] 2024-09-06 20:32:47,157 - INFO - Creating task with taskId EeS3Jq1zTUOFuAfUemqPoQ for test-unit-py39
[task 2024-09-06T20:32:47.162Z] 2024-09-06 20:32:47,162 - DEBUG - Starting new HTTP connection (8): taskcluster:80
[task 2024-09-06T20:32:47.164Z] 2024-09-06 20:32:47,162 - INFO - Creating task with taskId A1Uvou2sRXG8-8Ige2ZLZQ for build-docker-image-run-task
[task 2024-09-06T20:32:47.165Z] 2024-09-06 20:32:47,163 - DEBUG - Starting new HTTP connection (9): taskcluster:80
[task 2024-09-06T20:32:47.223Z] 2024-09-06 20:32:47,223 - DEBUG - http://taskcluster:80 "PUT /queue/v1/task/A1Uvou2sRXG8-8Ige2ZLZQ HTTP/11" 200 436
[task 2024-09-06T20:32:47.224Z] 2024-09-06 20:32:47,224 - INFO - Creating task with taskId U0wjIE9XQIGPjpqaa1b-ew for build-docker-image-decision
[task 2024-09-06T20:32:47.232Z] 2024-09-06 20:32:47,232 - DEBUG - http://taskcluster:80 "PUT /queue/v1/task/MivNYUPyT4aoLuo5xOIFfw HTTP/11" 200 434
[task 2024-09-06T20:32:47.235Z] 2024-09-06 20:32:47,235 - DEBUG - http://taskcluster:80 "PUT /queue/v1/task/WSF0rK6wQwy89S4kQvJ5nQ HTTP/11" 200 434
[task 2024-09-06T20:32:47.241Z] 2024-09-06 20:32:47,240 - DEBUG - http://taskcluster:80 "PUT /queue/v1/task/f_gMV9TNRH6495-PUbX-Sw HTTP/11" 200 434
[task 2024-09-06T20:32:47.242Z] 2024-09-06 20:32:47,242 - DEBUG - http://taskcluster:80 "PUT /queue/v1/task/f7PD8TtkR_Ocsulw3TZhVg HTTP/11" 200 436
[task 2024-09-06T20:32:47.250Z] 2024-09-06 20:32:47,250 - DEBUG - http://taskcluster:80 "PUT /queue/v1/task/EeS3Jq1zTUOFuAfUemqPoQ HTTP/11" 200 434
[task 2024-09-06T20:32:47.255Z] 2024-09-06 20:32:47,255 - DEBUG - http://taskcluster:80 "PUT /queue/v1/task/XHeT_IJSTAaYZZLPaBan3g HTTP/11" 200 434
[task 2024-09-06T20:32:47.259Z] 2024-09-06 20:32:47,259 - DEBUG - http://taskcluster:80 "PUT /queue/v1/task/GoOJmFNAQeeZU7wP9sM45A HTTP/11" 200 434
[task 2024-09-06T20:32:47.280Z] 2024-09-06 20:32:47,280 - DEBUG - http://taskcluster:80 "PUT /queue/v1/task/U0wjIE9XQIGPjpqaa1b-ew HTTP/11" 200 436
[task 2024-09-06T20:32:47.282Z] 2024-09-06 20:32:47,281 - INFO - Creating task with taskId CSKLcXCKQ0-IdAETcRn9AA for fetch-codecov-uploader
[task 2024-09-06T20:32:47.288Z] 2024-09-06 20:32:47,288 - DEBUG - http://taskcluster:80 "PUT /queue/v1/task/OclSvbZzT-SISt5b1VOR3g HTTP/11" 200 434
[task 2024-09-06T20:32:47.329Z] 2024-09-06 20:32:47,329 - DEBUG - http://taskcluster:80 "PUT /queue/v1/task/CSKLcXCKQ0-IdAETcRn9AA HTTP/11" 200 436
[task 2024-09-06T20:32:47.332Z] 2024-09-06 20:32:47,331 - INFO - Creating task with taskId W_7h_n8TRuW3KGKx37yz0w for codecov-upload
[task 2024-09-06T20:32:47.448Z] 2024-09-06 20:32:47,448 - DEBUG - http://taskcluster:80 "PUT /queue/v1/task/W_7h_n8TRuW3KGKx37yz0w HTTP/11" 200 434
[taskcluster 2024-09-06 20:32:47.679Z] === Task Finished ===
[taskcluster 2024-09-06 20:32:50.052Z] Successful task run with exit code: 0 completed in 24.635 seconds