[taskcluster 2024-05-24 17:53:11.201Z] using cache "taskgraph-level-1-checkouts-sparse-v2" -> /builds/worker/checkouts

a8ab88d51ba5 - Started downloading
e67bee4813b9 - Started downloading
25d693efad98 - Started downloading
a8ab88d51ba5 - Downloaded in 0.199 seconds
64d8035e67a0 - Started downloading
64d8035e67a0 - Downloaded in 0 seconds
25d693efad98 - Downloaded in 0.51 seconds
e67bee4813b9 - Downloaded in 0.885 seconds
Digest: sha256:86c8f0d2e9558707b393edc0b9feb9869e6d41659c1592e94192d24856c97949
Status: Downloaded newer image for mozillareleases/taskgraph:decision-latest
[taskcluster 2024-05-24 17:53:23.746Z] === Task Starting ===
[setup 2024-05-24T17:53:24.550Z] run-task started in /
[setup 2024-05-24T17:53:24.550Z] 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='[email protected]' --level='1' --repository-type=git --tasks-for='github-pull-request-untrusted' --base-repository='https://github.com/taskcluster/taskgraph' --base-ref='main' --base-rev='07452607791c48e6ea213ef820cab80a83130dc8' --head-repository='https://github.com/oskirby/taskgraph' --head-ref='run-task-optional-submodules' --head-rev='3612b26467ee222651d430e4bae8ab8ea3709def' 

[setup 2024-05-24T17:53:24.550Z] Python version: 3.11.2
[vcs 2024-05-24T17:53:24.551Z] WARNING: vcs checkout path (/builds/worker/checkouts/src) not in cache or volume; performance will likely suffer
[setup 2024-05-24T17:53:24.551Z] running as worker:worker
[vcs 2024-05-24T17:53:24.552Z] executing ['git', 'config', '--global', '--add', 'safe.directory', '/builds/worker/checkouts/src']
[vcs 2024-05-24T17:53:24.555Z] executing ['git', 'clone', 'https://github.com/taskcluster/taskgraph', '/builds/worker/checkouts/src']
[vcs 2024-05-24T17:53:24.557Z] Cloning into '/builds/worker/checkouts/src'...
[vcs 2024-05-24T17:53:25.687Z] executing ['git', 'fetch', 'origin', 'main']
[vcs 2024-05-24T17:53:25.968Z] From https://github.com/taskcluster/taskgraph
[vcs 2024-05-24T17:53:25.969Z]  * branch              main       -> FETCH_HEAD
[vcs 2024-05-24T17:53:25.973Z] executing ['git', 'checkout', 'main']
[vcs 2024-05-24T17:53:25.984Z] Already on 'main'
[vcs 2024-05-24T17:53:25.985Z] Your branch is up to date with 'origin/main'.
[vcs 2024-05-24T17:53:25.985Z] executing ['git', 'fetch', 'origin', '07452607791c48e6ea213ef820cab80a83130dc8']
[vcs 2024-05-24T17:53:26.280Z] From https://github.com/taskcluster/taskgraph
[vcs 2024-05-24T17:53:26.281Z]  * branch              07452607791c48e6ea213ef820cab80a83130dc8 -> FETCH_HEAD
[vcs 2024-05-24T17:53:26.287Z] executing ['git', 'fetch', '--no-tags', 'https://github.com/oskirby/taskgraph', 'run-task-optional-submodules']
[vcs 2024-05-24T17:53:26.698Z] From https://github.com/oskirby/taskgraph
[vcs 2024-05-24T17:53:26.700Z]  * branch              run-task-optional-submodules -> FETCH_HEAD
[vcs 2024-05-24T17:53:26.701Z] executing ['git', 'checkout', '-f', '-B', 'run-task-optional-submodules', '3612b26467ee222651d430e4bae8ab8ea3709def']
[vcs 2024-05-24T17:53:26.719Z] Switched to a new branch 'run-task-optional-submodules'
[vcs 2024-05-24T17:53:26.719Z] cleaning git checkout...
[vcs 2024-05-24T17:53:26.719Z] executing ['git', 'clean', '-nxdff']
[vcs 2024-05-24T17:53:26.723Z] removing []
[vcs 2024-05-24T17:53:26.723Z] successfully cleaned git checkout!
[vcs 2024-05-24T17:53:26.725Z] TinderboxPrint:<a href='https://github.com/oskirby/taskgraph/commit/3612b26467ee222651d430e4bae8ab8ea3709def' title='Built from taskgraph commit 3612b26467ee222651d430e4bae8ab8ea3709def'>3612b26467ee222651d430e4bae8ab8ea3709def</a>
[task 2024-05-24T17:53:26.726Z] executing ['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='[email protected]' --level='1' --repository-type=git --tasks-for='github-pull-request-untrusted' --base-repository='https://github.com/taskcluster/taskgraph' --base-ref='main' --base-rev='07452607791c48e6ea213ef820cab80a83130dc8' --head-repository='https://github.com/oskirby/taskgraph' --head-ref='run-task-optional-submodules' --head-rev='3612b26467ee222651d430e4bae8ab8ea3709def' \n"]
[task 2024-05-24T17:53:26.728Z] + cd /builds/worker/checkouts/src
[task 2024-05-24T17:53:26.728Z] + ln -s /builds/worker/artifacts artifacts
[task 2024-05-24T17:53:26.729Z] + pip3 install --user --break-system-packages .
[task 2024-05-24T17:53:27.115Z] Processing /builds/worker/checkouts/src
[task 2024-05-24T17:53:27.119Z]   Installing build dependencies: started
[task 2024-05-24T17:53:28.824Z]   Installing build dependencies: finished with status 'done'
[task 2024-05-24T17:53:28.826Z]   Getting requirements to build wheel: started
[task 2024-05-24T17:53:29.007Z]   Getting requirements to build wheel: finished with status 'done'
[task 2024-05-24T17:53:29.011Z]   Preparing metadata (pyproject.toml): started
[task 2024-05-24T17:53:29.217Z]   Preparing metadata (pyproject.toml): finished with status 'done'
[task 2024-05-24T17:53:29.233Z] Requirement already satisfied: appdirs>=1.4 in /usr/local/lib/python3.11/dist-packages (from taskcluster-taskgraph==8.2.0) (1.4.4)
[task 2024-05-24T17:53:29.235Z] Requirement already satisfied: cookiecutter~=2.1 in /usr/local/lib/python3.11/dist-packages (from taskcluster-taskgraph==8.2.0) (2.5.0)
[task 2024-05-24T17:53:29.236Z] Requirement already satisfied: json-e>=2.7 in /usr/local/lib/python3.11/dist-packages (from taskcluster-taskgraph==8.2.0) (4.6.0)
[task 2024-05-24T17:53:29.237Z] Requirement already satisfied: mozilla-repo-urls in /usr/local/lib/python3.11/dist-packages (from taskcluster-taskgraph==8.2.0) (0.1.1)
[task 2024-05-24T17:53:29.239Z] Requirement already satisfied: PyYAML>=5.3.1 in /usr/local/lib/python3.11/dist-packages (from taskcluster-taskgraph==8.2.0) (6.0.1)
[task 2024-05-24T17:53:29.240Z] Requirement already satisfied: redo>=2.0 in /usr/local/lib/python3.11/dist-packages (from taskcluster-taskgraph==8.2.0) (2.0.4)
[task 2024-05-24T17:53:29.242Z] Requirement already satisfied: requests>=2.25 in /usr/local/lib/python3.11/dist-packages (from taskcluster-taskgraph==8.2.0) (2.31.0)
[task 2024-05-24T17:53:29.243Z] Requirement already satisfied: slugid>=2.0 in /usr/local/lib/python3.11/dist-packages (from taskcluster-taskgraph==8.2.0) (2.0.0)
[task 2024-05-24T17:53:29.245Z] Requirement already satisfied: taskcluster-urls>=11.0 in /usr/local/lib/python3.11/dist-packages (from taskcluster-taskgraph==8.2.0) (13.0.1)
[task 2024-05-24T17:53:29.247Z] Requirement already satisfied: voluptuous>=0.12.1 in /usr/local/lib/python3.11/dist-packages (from taskcluster-taskgraph==8.2.0) (0.14.1)
[task 2024-05-24T17:53:29.256Z] Requirement already satisfied: binaryornot>=0.4.4 in /usr/local/lib/python3.11/dist-packages (from cookiecutter~=2.1->taskcluster-taskgraph==8.2.0) (0.4.4)
[task 2024-05-24T17:53:29.258Z] Requirement already satisfied: Jinja2<4.0.0,>=2.7 in /usr/local/lib/python3.11/dist-packages (from cookiecutter~=2.1->taskcluster-taskgraph==8.2.0) (3.1.2)
[task 2024-05-24T17:53:29.260Z] Requirement already satisfied: click<9.0.0,>=7.0 in /usr/local/lib/python3.11/dist-packages (from cookiecutter~=2.1->taskcluster-taskgraph==8.2.0) (8.1.7)
[task 2024-05-24T17:53:29.262Z] Requirement already satisfied: python-slugify>=4.0.0 in /usr/local/lib/python3.11/dist-packages (from cookiecutter~=2.1->taskcluster-taskgraph==8.2.0) (8.0.1)
[task 2024-05-24T17:53:29.264Z] Requirement already satisfied: arrow in /usr/local/lib/python3.11/dist-packages (from cookiecutter~=2.1->taskcluster-taskgraph==8.2.0) (1.3.0)
[task 2024-05-24T17:53:29.265Z] Requirement already satisfied: rich in /usr/local/lib/python3.11/dist-packages (from cookiecutter~=2.1->taskcluster-taskgraph==8.2.0) (13.7.0)
[task 2024-05-24T17:53:29.283Z] Requirement already satisfied: charset-normalizer<4,>=2 in /usr/local/lib/python3.11/dist-packages (from requests>=2.25->taskcluster-taskgraph==8.2.0) (3.3.2)
[task 2024-05-24T17:53:29.285Z] Requirement already satisfied: idna<4,>=2.5 in /usr/local/lib/python3.11/dist-packages (from requests>=2.25->taskcluster-taskgraph==8.2.0) (3.6)
[task 2024-05-24T17:53:29.286Z] Requirement already satisfied: urllib3<3,>=1.21.1 in /usr/local/lib/python3.11/dist-packages (from requests>=2.25->taskcluster-taskgraph==8.2.0) (2.1.0)
[task 2024-05-24T17:53:29.288Z] Requirement already satisfied: certifi>=2017.4.17 in /usr/local/lib/python3.11/dist-packages (from requests>=2.25->taskcluster-taskgraph==8.2.0) (2023.11.17)
[task 2024-05-24T17:53:29.305Z] Requirement already satisfied: giturlparse in /usr/local/lib/python3.11/dist-packages (from mozilla-repo-urls->taskcluster-taskgraph==8.2.0) (0.12.0)
[task 2024-05-24T17:53:29.312Z] 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==8.2.0) (5.2.0)
[task 2024-05-24T17:53:29.346Z] 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==8.2.0) (2.1.3)
[task 2024-05-24T17:53:29.357Z] 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==8.2.0) (1.3)
[task 2024-05-24T17:53:29.390Z] Requirement already satisfied: python-dateutil>=2.7.0 in /usr/local/lib/python3.11/dist-packages (from arrow->cookiecutter~=2.1->taskcluster-taskgraph==8.2.0) (2.8.2)
[task 2024-05-24T17:53:29.392Z] Requirement already satisfied: types-python-dateutil>=2.8.10 in /usr/local/lib/python3.11/dist-packages (from arrow->cookiecutter~=2.1->taskcluster-taskgraph==8.2.0) (2.8.19.14)
[task 2024-05-24T17:53:29.414Z] Requirement already satisfied: markdown-it-py>=2.2.0 in /usr/local/lib/python3.11/dist-packages (from rich->cookiecutter~=2.1->taskcluster-taskgraph==8.2.0) (3.0.0)
[task 2024-05-24T17:53:29.416Z] 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==8.2.0) (2.17.2)
[task 2024-05-24T17:53:29.457Z] 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==8.2.0) (0.1.2)
[task 2024-05-24T17:53:29.491Z] 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==8.2.0) (1.16.0)
[task 2024-05-24T17:53:29.544Z] Building wheels for collected packages: taskcluster-taskgraph
[task 2024-05-24T17:53:29.545Z]   Building wheel for taskcluster-taskgraph (pyproject.toml): started
[task 2024-05-24T17:53:29.837Z]   Building wheel for taskcluster-taskgraph (pyproject.toml): finished with status 'done'
[task 2024-05-24T17:53:29.839Z]   Created wheel for taskcluster-taskgraph: filename=taskcluster_taskgraph-8.2.0-py3-none-any.whl size=189582 sha256=2e04a8160ec2e1ad212aab960560b33c194e81bf6b49eab994f707f5799a0404
[task 2024-05-24T17:53:29.840Z]   Stored in directory: /tmp/pip-ephem-wheel-cache-w610_xlu/wheels/54/fa/b4/d3017bf051c083cc076bfd93af1693baf4c91b8f6fee74b0bc
[task 2024-05-24T17:53:29.844Z] Successfully built taskcluster-taskgraph
[task 2024-05-24T17:53:29.945Z] Installing collected packages: taskcluster-taskgraph
[task 2024-05-24T17:53:30.044Z]   WARNING: The script taskgraph is installed in '/builds/worker/.local/bin' which is not on PATH.
[task 2024-05-24T17:53:30.045Z]   Consider adding this directory to PATH or, if you prefer to suppress this warning, use --no-warn-script-location.
[task 2024-05-24T17:53:30.050Z] Successfully installed taskcluster-taskgraph-8.2.0
[task 2024-05-24T17:53:30.143Z] + taskgraph decision --verbose --pushlog-id=0 --pushdate=0 --project=taskgraph [email protected] --level=1 --repository-type=git --tasks-for=github-pull-request-untrusted --base-repository=https://github.com/taskcluster/taskgraph --base-ref=main --base-rev=07452607791c48e6ea213ef820cab80a83130dc8 --head-repository=https://github.com/oskirby/taskgraph --head-ref=run-task-optional-submodules --head-rev=3612b26467ee222651d430e4bae8ab8ea3709def
[task 2024-05-24T17:53:30.628Z] 2024-05-24 17:53:30,628 - INFO - Loading graph configuration.
[task 2024-05-24T17:53:30.628Z] 2024-05-24 17:53:30,628 - DEBUG - loading config from `taskcluster/config.yml`
[task 2024-05-24T17:53:30.640Z] 2024-05-24 17:53:30,640 - 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-05-24T17:53:30.641Z] 2024-05-24 17:53:30,641 - INFO - Using Parameters(id=552bf79d991d) (from defaults)
[task 2024-05-24T17:53:30.641Z] 2024-05-24 17:53:30,641 - DEBUG - Dumping parameters:
[task 2024-05-24T17:53:30.643Z] { 'base_ref': 'main',
[task 2024-05-24T17:53:30.643Z]   'base_repository': 'https://github.com/taskcluster/taskgraph',
[task 2024-05-24T17:53:30.643Z]   'base_rev': '07452607791c48e6ea213ef820cab80a83130dc8',
[task 2024-05-24T17:53:30.645Z]   'build_date': 1716573210,
[task 2024-05-24T17:53:30.645Z]   'build_number': 1,
[task 2024-05-24T17:53:30.645Z]   'do_not_optimize': [],
[task 2024-05-24T17:53:30.645Z]   'enable_always_target': True,
[task 2024-05-24T17:53:30.645Z]   'existing_tasks': {},
[task 2024-05-24T17:53:30.645Z]   'files_changed': [ 'src/taskgraph/run-task/run-task',
[task 2024-05-24T17:53:30.645Z]                      'src/taskgraph/transforms/run/common.py',
[task 2024-05-24T17:53:30.645Z]                      'src/taskgraph/transforms/base.py',
[task 2024-05-24T17:53:30.645Z]                      'src/taskgraph/transforms/run/common.py',
[task 2024-05-24T17:53:30.645Z]                      'test/test_transforms_run_run_task.py',
[task 2024-05-24T17:53:30.645Z]                      'src/taskgraph/transforms/run/common.py',
[task 2024-05-24T17:53:30.645Z]                      'test/test_scripts_run_task.py',
[task 2024-05-24T17:53:30.645Z]                      'src/taskgraph/transforms/base.py',
[task 2024-05-24T17:53:30.645Z]                      'src/taskgraph/transforms/run/common.py',
[task 2024-05-24T17:53:30.645Z]                      'test/test_transforms_run_run_task.py',
[task 2024-05-24T17:53:30.645Z]                      'test/test_transforms_run_run_task.py',
[task 2024-05-24T17:53:30.645Z]                      'test/test_scripts_run_task.py',
[task 2024-05-24T17:53:30.645Z]                      'src/taskgraph/run-task/run-task',
[task 2024-05-24T17:53:30.645Z]                      'test/test_scripts_run_task.py',
[task 2024-05-24T17:53:30.645Z]                      'test/test_scripts_run_task.py'],
[task 2024-05-24T17:53:30.645Z]   'filters': ['target_tasks_method'],
[task 2024-05-24T17:53:30.645Z]   'head_ref': 'run-task-optional-submodules',
[task 2024-05-24T17:53:30.645Z]   'head_repository': 'https://github.com/oskirby/taskgraph',
[task 2024-05-24T17:53:30.645Z]   'head_rev': '3612b26467ee222651d430e4bae8ab8ea3709def',
[task 2024-05-24T17:53:30.645Z]   'head_tag': '',
[task 2024-05-24T17:53:30.645Z]   'level': '1',
[task 2024-05-24T17:53:30.645Z]   'moz_build_date': '20240524175330',
[task 2024-05-24T17:53:30.645Z]   'next_version': None,
[task 2024-05-24T17:53:30.645Z]   'optimize_strategies': None,
[task 2024-05-24T17:53:30.645Z]   'optimize_target_tasks': True,
[task 2024-05-24T17:53:30.645Z]   'owner': '[email protected]',
[task 2024-05-24T17:53:30.645Z]   'project': 'taskgraph',
[task 2024-05-24T17:53:30.645Z]   'pushdate': 0,
[task 2024-05-24T17:53:30.645Z]   'pushlog_id': '0',
[task 2024-05-24T17:53:30.645Z]   'repository_type': 'git',
[task 2024-05-24T17:53:30.645Z]   'target_tasks_method': 'default',
[task 2024-05-24T17:53:30.645Z]   'tasks_for': 'github-pull-request-untrusted',
[task 2024-05-24T17:53:30.645Z]   'version': None}
[task 2024-05-24T17:53:30.645Z] 2024-05-24 17:53:30,641 - INFO - writing artifact file `parameters.yml`
[task 2024-05-24T17:53:30.649Z] 2024-05-24 17:53:30,649 - INFO - writing artifact file `actions.json`
[task 2024-05-24T17:53:30.651Z] 2024-05-24 17:53:30,650 - INFO - Loading kinds
[task 2024-05-24T17:53:30.651Z] 2024-05-24 17:53:30,651 - DEBUG - loading kind `fetch` from `taskcluster/kinds/fetch`
[task 2024-05-24T17:53:30.651Z] 2024-05-24 17:53:30,651 - DEBUG - loading kind `tests` from `taskcluster/kinds/tests`
[task 2024-05-24T17:53:30.652Z] 2024-05-24 17:53:30,652 - DEBUG - loading kind `codecov` from `taskcluster/kinds/codecov`
[task 2024-05-24T17:53:30.653Z] 2024-05-24 17:53:30,653 - DEBUG - loading kind `docker-image` from `taskcluster/kinds/docker-image`
[task 2024-05-24T17:53:30.653Z] 2024-05-24 17:53:30,653 - DEBUG - loading kind `push-image` from `taskcluster/kinds/push-image`
[task 2024-05-24T17:53:30.654Z] 2024-05-24 17:53:30,654 - DEBUG - loading kind `doc` from `taskcluster/kinds/doc`
[task 2024-05-24T17:53:30.655Z] 2024-05-24 17:53:30,655 - INFO - Generating full task set
[task 2024-05-24T17:53:30.655Z] 2024-05-24 17:53:30,655 - DEBUG - Loading tasks for kind doc
[task 2024-05-24T17:53:30.670Z] 2024-05-24 17:53:30,669 - DEBUG - Generating tasks for doc generate
[task 2024-05-24T17:53:30.671Z] 2024-05-24 17:53:30,671 - INFO - Generated 1 tasks for kind doc
[task 2024-05-24T17:53:30.671Z] 2024-05-24 17:53:30,671 - DEBUG - Loading tasks for kind docker-image
[task 2024-05-24T17:53:30.672Z] 2024-05-24 17:53:30,672 - DEBUG - Generating tasks for docker-image decision
[task 2024-05-24T17:53:30.672Z] 2024-05-24 17:53:30,672 - DEBUG - Generating tasks for docker-image fetch
[task 2024-05-24T17:53:30.672Z] 2024-05-24 17:53:30,672 - DEBUG - Generating tasks for docker-image index-task
[task 2024-05-24T17:53:30.672Z] 2024-05-24 17:53:30,672 - DEBUG - Generating tasks for docker-image python
[task 2024-05-24T17:53:30.673Z] 2024-05-24 17:53:30,673 - DEBUG - Generating tasks for docker-image run-task
[task 2024-05-24T17:53:30.673Z] 2024-05-24 17:53:30,673 - DEBUG - Generating tasks for docker-image skopeo
[task 2024-05-24T17:53:30.673Z] 2024-05-24 17:53:30,673 - INFO - Writing docker-contexts/decision.tar.gz for docker image decision
[task 2024-05-24T17:53:30.761Z] 2024-05-24 17:53:30,761 - INFO - Writing docker-contexts/fetch.tar.gz for docker image fetch
[task 2024-05-24T17:53:30.772Z] 2024-05-24 17:53:30,772 - INFO - Writing docker-contexts/index-task.tar.gz for docker image index-task
[task 2024-05-24T17:53:30.774Z] 2024-05-24 17:53:30,774 - INFO - Writing docker-contexts/python.tar.gz for docker image python
[task 2024-05-24T17:53:30.791Z] 2024-05-24 17:53:30,791 - INFO - Writing docker-contexts/run-task.tar.gz for docker image run-task
[task 2024-05-24T17:53:30.808Z] 2024-05-24 17:53:30,808 - INFO - Writing docker-contexts/skopeo.tar.gz for docker image skopeo
[task 2024-05-24T17:53:30.827Z] 2024-05-24 17:53:30,827 - INFO - Generated 6 tasks for kind docker-image
[task 2024-05-24T17:53:30.827Z] 2024-05-24 17:53:30,827 - DEBUG - Loading tasks for kind fetch
[task 2024-05-24T17:53:30.831Z] 2024-05-24 17:53:30,831 - DEBUG - Generating tasks for fetch codecov-uploader
[task 2024-05-24T17:53:30.832Z] 2024-05-24 17:53:30,832 - INFO - Generated 1 tasks for kind fetch
[task 2024-05-24T17:53:30.832Z] 2024-05-24 17:53:30,832 - DEBUG - Loading tasks for kind push-image
[task 2024-05-24T17:53:30.835Z] 2024-05-24 17:53:30,835 - DEBUG - Generating tasks for push-image decision
[task 2024-05-24T17:53:30.835Z] 2024-05-24 17:53:30,835 - DEBUG - Generating tasks for push-image run-task
[task 2024-05-24T17:53:30.836Z] 2024-05-24 17:53:30,836 - INFO - Generated 2 tasks for kind push-image
[task 2024-05-24T17:53:30.836Z] 2024-05-24 17:53:30,836 - DEBUG - Loading tasks for kind tests
[task 2024-05-24T17:53:30.838Z] 2024-05-24 17:53:30,838 - DEBUG - Generating tasks for tests unit
[task 2024-05-24T17:53:30.839Z] 2024-05-24 17:53:30,838 - DEBUG - Generating tasks for tests type-check
[task 2024-05-24T17:53:30.840Z] 2024-05-24 17:53:30,840 - INFO - Generated 2 tasks for kind tests
[task 2024-05-24T17:53:30.840Z] 2024-05-24 17:53:30,840 - DEBUG - Loading tasks for kind codecov
[task 2024-05-24T17:53:30.841Z] 2024-05-24 17:53:30,841 - DEBUG - Generating tasks for codecov upload
[task 2024-05-24T17:53:30.842Z] 2024-05-24 17:53:30,842 - INFO - Generated 1 tasks for kind codecov
[task 2024-05-24T17:53:30.842Z] 2024-05-24 17:53:30,842 - INFO - Generating full task graph
[task 2024-05-24T17:53:30.842Z] 2024-05-24 17:53:30,842 - INFO - Full task graph contains 13 tasks and 12 dependencies
[task 2024-05-24T17:53:30.843Z] 2024-05-24 17:53:30,843 - INFO - writing artifact file `full-task-graph.json`
[task 2024-05-24T17:53:30.846Z] 2024-05-24 17:53:30,846 - INFO - writing artifact file `runnable-jobs.json`
[task 2024-05-24T17:53:30.847Z] 2024-05-24 17:53:30,847 - INFO - Generating target task set
[task 2024-05-24T17:53:30.847Z] 2024-05-24 17:53:30,847 - INFO - Filter filter_target_tasks pruned 10 tasks (3 remain)
[task 2024-05-24T17:53:30.847Z] 2024-05-24 17:53:30,847 - INFO - writing artifact file `target-tasks.json`
[task 2024-05-24T17:53:30.848Z] 2024-05-24 17:53:30,847 - INFO - Generating target task graph
[task 2024-05-24T17:53:30.848Z] 2024-05-24 17:53:30,847 - INFO - Adding 6 tasks with `always_target` attribute
[task 2024-05-24T17:53:30.848Z] 2024-05-24 17:53:30,847 - INFO - Generating optimized task graph
[task 2024-05-24T17:53:30.848Z] 2024-05-24 17:53:30,848 - DEBUG - optimize: build-docker-image-decision kept because of index-search (index-search)
[task 2024-05-24T17:53:30.848Z] 2024-05-24 17:53:30,848 - DEBUG - optimize: build-docker-image-fetch kept because of index-search (index-search)
[task 2024-05-24T17:53:30.848Z] 2024-05-24 17:53:30,848 - DEBUG - optimize: build-docker-image-index-task kept because of index-search (index-search)
[task 2024-05-24T17:53:30.848Z] 2024-05-24 17:53:30,848 - DEBUG - optimize: build-docker-image-run-task kept because of dependent tasks
[task 2024-05-24T17:53:30.848Z] 2024-05-24 17:53:30,848 - DEBUG - optimize: build-docker-image-skopeo kept because of index-search (index-search)
[task 2024-05-24T17:53:30.848Z] 2024-05-24 17:53:30,848 - DEBUG - optimize: doc-generate kept because of never
[task 2024-05-24T17:53:30.848Z] 2024-05-24 17:53:30,848 - DEBUG - optimize: tests-type-check kept because of never
[task 2024-05-24T17:53:30.848Z] 2024-05-24 17:53:30,848 - DEBUG - optimize: tests-unit kept because of never
[task 2024-05-24T17:53:30.848Z] 2024-05-24 17:53:30,848 - DEBUG - optimize: build-docker-image-python kept because of dependent tasks
[task 2024-05-24T17:53:30.848Z] 2024-05-24 17:53:30,848 - INFO - No tasks removed during optimization
[task 2024-05-24T17:53:30.849Z] 2024-05-24 17:53:30,848 - DEBUG - Running in Taskcluster instance https://firefox-ci-tc.services.mozilla.com with taskcluster-proxy
[task 2024-05-24T17:53:30.851Z] 2024-05-24 17:53:30,851 - DEBUG - Starting new HTTPS connection (1): firefox-ci-tc.services.mozilla.com:443
[task 2024-05-24T17:53:30.912Z] 2024-05-24 17:53:30,912 - DEBUG - https://firefox-ci-tc.services.mozilla.com:443 "POST /api/index/v1/tasks/indexes HTTP/1.1" 200 588
[task 2024-05-24T17:53:30.942Z] 2024-05-24 17:53:30,942 - DEBUG - https://firefox-ci-tc.services.mozilla.com:443 "POST /api/queue/v1/tasks/status HTTP/1.1" 200 None
[task 2024-05-24T17:53:30.943Z] 2024-05-24 17:53:30,943 - DEBUG - replace_tasks: build-docker-image-fetch
[task 2024-05-24T17:53:30.943Z] 2024-05-24 17:53:30,943 - DEBUG - replace_tasks: build-docker-image-fetch kept by optimization strategy
[task 2024-05-24T17:53:30.943Z] 2024-05-24 17:53:30,943 - DEBUG - replace_tasks: build-docker-image-index-task
[task 2024-05-24T17:53:30.944Z] 2024-05-24 17:53:30,943 - DEBUG - replace_tasks: build-docker-image-index-task replaced with PebYGdYSQgu0_iTKTCg_fQ by optimization strategy
[task 2024-05-24T17:53:30.944Z] 2024-05-24 17:53:30,944 - DEBUG - replace_tasks: build-docker-image-python
[task 2024-05-24T17:53:30.944Z] 2024-05-24 17:53:30,944 - DEBUG - replace_tasks: build-docker-image-python kept by optimization strategy
[task 2024-05-24T17:53:30.944Z] 2024-05-24 17:53:30,944 - DEBUG - replace_tasks: build-docker-image-run-task
[task 2024-05-24T17:53:30.944Z] 2024-05-24 17:53:30,944 - DEBUG - replace_tasks: build-docker-image-run-task kept by optimization strategy
[task 2024-05-24T17:53:30.944Z] 2024-05-24 17:53:30,944 - DEBUG - replace_tasks: build-docker-image-skopeo
[task 2024-05-24T17:53:30.944Z] 2024-05-24 17:53:30,944 - DEBUG - replace_tasks: build-docker-image-skopeo kept by optimization strategy
[task 2024-05-24T17:53:30.944Z] 2024-05-24 17:53:30,944 - DEBUG - replace_tasks: doc-generate
[task 2024-05-24T17:53:30.944Z] 2024-05-24 17:53:30,944 - DEBUG - replace_tasks: doc-generate depends on an unreplaced or unremoved task
[task 2024-05-24T17:53:30.944Z] 2024-05-24 17:53:30,944 - DEBUG - replace_tasks: tests-type-check
[task 2024-05-24T17:53:30.944Z] 2024-05-24 17:53:30,944 - DEBUG - replace_tasks: tests-type-check depends on an unreplaced or unremoved task
[task 2024-05-24T17:53:30.944Z] 2024-05-24 17:53:30,944 - DEBUG - replace_tasks: tests-unit
[task 2024-05-24T17:53:30.944Z] 2024-05-24 17:53:30,944 - DEBUG - replace_tasks: tests-unit depends on an unreplaced or unremoved task
[task 2024-05-24T17:53:30.944Z] 2024-05-24 17:53:30,944 - DEBUG - replace_tasks: build-docker-image-decision
[task 2024-05-24T17:53:30.944Z] 2024-05-24 17:53:30,944 - DEBUG - replace_tasks: build-docker-image-decision depends on an unreplaced or unremoved task
[task 2024-05-24T17:53:30.944Z] 2024-05-24 17:53:30,944 - INFO - Replaced 1 tasks by index-search (index-search) during optimization.
[task 2024-05-24T17:53:30.945Z] 2024-05-24 17:53:30,945 - DEBUG - Morphing: adding index tasks
[task 2024-05-24T17:53:30.945Z] 2024-05-24 17:53:30,945 - DEBUG - Morphing: adding code review task
[task 2024-05-24T17:53:30.946Z] 2024-05-24 17:53:30,946 - INFO - writing artifact file `task-graph.json`
[task 2024-05-24T17:53:30.948Z] 2024-05-24 17:53:30,948 - INFO - writing artifact file `label-to-taskid.json`
[task 2024-05-24T17:53:30.950Z] 2024-05-24 17:53:30,950 - INFO - Creating task with taskId MmkvztigQYm_dM7Qo3xwjg for build-docker-image-skopeo
[task 2024-05-24T17:53:30.952Z] 2024-05-24 17:53:30,952 - DEBUG - Starting new HTTP connection (1): taskcluster:80
[task 2024-05-24T17:53:30.952Z] 2024-05-24 17:53:30,952 - INFO - Creating task with taskId TpUYi56fRfCGALIuqH_7Iw for build-docker-image-python
[task 2024-05-24T17:53:30.954Z] 2024-05-24 17:53:30,954 - DEBUG - Starting new HTTP connection (2): taskcluster:80
[task 2024-05-24T17:53:30.957Z] 2024-05-24 17:53:30,957 - INFO - Creating task with taskId KvQkKqSXSmWI_GG25sYHkg for build-docker-image-run-task
[task 2024-05-24T17:53:30.959Z] 2024-05-24 17:53:30,958 - DEBUG - Starting new HTTP connection (3): taskcluster:80
[task 2024-05-24T17:53:30.961Z] 2024-05-24 17:53:30,961 - INFO - Creating task with taskId DdGl_YPlRTmYNEo0lTOKYA for build-docker-image-fetch
[task 2024-05-24T17:53:30.965Z] 2024-05-24 17:53:30,965 - DEBUG - Starting new HTTP connection (4): taskcluster:80
[task 2024-05-24T17:53:31.026Z] 2024-05-24 17:53:31,026 - DEBUG - http://taskcluster:80 "PUT /queue/v1/task/KvQkKqSXSmWI_GG25sYHkg HTTP/1.1" 200 436
[task 2024-05-24T17:53:31.027Z] 2024-05-24 17:53:31,027 - INFO - Creating task with taskId JaSrf6TnRDiBwZAZEk_SDA for build-docker-image-decision
[task 2024-05-24T17:53:31.031Z] 2024-05-24 17:53:31,031 - DEBUG - http://taskcluster:80 "PUT /queue/v1/task/DdGl_YPlRTmYNEo0lTOKYA HTTP/1.1" 200 436
[task 2024-05-24T17:53:31.032Z] 2024-05-24 17:53:31,032 - DEBUG - http://taskcluster:80 "PUT /queue/v1/task/TpUYi56fRfCGALIuqH_7Iw HTTP/1.1" 200 436
[task 2024-05-24T17:53:31.049Z] 2024-05-24 17:53:31,049 - DEBUG - http://taskcluster:80 "PUT /queue/v1/task/MmkvztigQYm_dM7Qo3xwjg HTTP/1.1" 200 436
[task 2024-05-24T17:53:31.099Z] 2024-05-24 17:53:31,099 - DEBUG - http://taskcluster:80 "PUT /queue/v1/task/JaSrf6TnRDiBwZAZEk_SDA HTTP/1.1" 200 436
[task 2024-05-24T17:53:31.101Z] 2024-05-24 17:53:31,100 - INFO - Creating task with taskId W_hQrN0nQ76TIbQI3djNrg for doc-generate
[task 2024-05-24T17:53:31.102Z] 2024-05-24 17:53:31,101 - INFO - Creating task with taskId F7b3fx6XQXSg4F-h5SikDg for tests-unit
[task 2024-05-24T17:53:31.104Z] 2024-05-24 17:53:31,102 - INFO - Creating task with taskId IB30VchBTTi2iFahwqbMSw for tests-type-check
[task 2024-05-24T17:53:31.145Z] 2024-05-24 17:53:31,145 - DEBUG - http://taskcluster:80 "PUT /queue/v1/task/W_hQrN0nQ76TIbQI3djNrg HTTP/1.1" 200 434
[task 2024-05-24T17:53:31.173Z] 2024-05-24 17:53:31,173 - DEBUG - http://taskcluster:80 "PUT /queue/v1/task/IB30VchBTTi2iFahwqbMSw HTTP/1.1" 200 434
[task 2024-05-24T17:53:31.176Z] 2024-05-24 17:53:31,176 - DEBUG - http://taskcluster:80 "PUT /queue/v1/task/F7b3fx6XQXSg4F-h5SikDg HTTP/1.1" 200 434
[taskcluster 2024-05-24 17:53:31.426Z] === Task Finished ===
[taskcluster 2024-05-24 17:53:33.231Z] Successful task run with exit code: 0 completed in 22.031 seconds