[taskcluster 2024-02-02 20:05:27.524Z] Task ID: Jll4LC9aSDeCkDQw95frHA
[taskcluster 2024-02-02 20:05:27.524Z] Worker ID: 678016433976834426
[taskcluster 2024-02-02 20:05:27.525Z] Worker Group: us-central1
[taskcluster 2024-02-02 20:05:27.525Z] Worker Node Type: projects/887720501152/machineTypes/n2-standard-2
[taskcluster 2024-02-02 20:05:27.525Z] Worker Pool: mozilla-1/decision-gcp
[taskcluster 2024-02-02 20:05:27.525Z] Worker Version: 38.0.5
[taskcluster 2024-02-02 20:05:27.525Z] Public IP: 35.226.225.223
[taskcluster 2024-02-02 20:05:27.525Z] Hostname: mozilla-1-decision-gcp-fs7db1dcstgm5r9cxuayma
[taskcluster 2024-02-02 20:05:27.525Z] using cache "mozilla-project-reps-level-1-checkouts-sparse-v2" -> /builds/worker/checkouts

90e5e7d8b87a - Started downloading
2e4b65595e5e - Started downloading
90e5e7d8b87a - Downloaded in 0.373 seconds
2e4b65595e5e - Downloaded in 0.675 seconds
Digest: sha256:2dd667994aa13fccdcdcede85c570a5eb4a5247e42875a9e95a135ef774ee469
Status: Downloaded newer image for mozillareleases/taskgraph@sha256:2dd667994aa13fccdcdcede85c570a5eb4a5247e42875a9e95a135ef774ee469
[taskcluster 2024-02-02 20:05:36.832Z] === Task Starting ===
[setup 2024-02-02T20:05:38.047Z] run-task started in /
[setup 2024-02-02T20:05:38.047Z] Invoked by command: --reps-checkout=/builds/worker/checkouts/src -- bash -cx cd /builds/worker/checkouts/src && ln -s /builds/worker/artifacts artifacts && ~/.local/bin/taskgraph decision --pushlog-id='0' --pushdate='0' --project='reps' --owner='[email protected]' --level='1' --repository-type=git --tasks-for='github-pull-request' --base-repository='https://github.com/mozilla-releng/reps' --base-ref='main' --base-rev='9656dad49e7d419a77e15bb9166f77792db97422' --head-repository='https://github.com/ahal/reps' --head-ref='bump' --head-rev='83908e79ac5abaa673fbf0e7de76ea2831ea1a61' 

[setup 2024-02-02T20:05:38.047Z] Python version: 3.11.2
[vcs 2024-02-02T20:05:38.048Z] WARNING: vcs checkout path (/builds/worker/checkouts/src) not in cache or volume; performance will likely suffer
[setup 2024-02-02T20:05:38.049Z] running as worker:worker
[vcs 2024-02-02T20:05:38.049Z] executing ['git', 'config', '--global', '--add', 'safe.directory', '/builds/worker/checkouts/src']
[vcs 2024-02-02T20:05:38.050Z] executing ['git', 'clone', 'https://github.com/mozilla-releng/reps', '/builds/worker/checkouts/src']
[vcs 2024-02-02T20:05:38.052Z] Cloning into '/builds/worker/checkouts/src'...
[vcs 2024-02-02T20:05:38.450Z] executing ['git', 'fetch', 'origin', 'main']
[vcs 2024-02-02T20:05:38.671Z] From https://github.com/mozilla-releng/reps
[vcs 2024-02-02T20:05:38.671Z]  * branch            main       -> FETCH_HEAD
[vcs 2024-02-02T20:05:38.675Z] executing ['git', 'checkout', 'main']
[vcs 2024-02-02T20:05:38.679Z] Already on 'main'
[vcs 2024-02-02T20:05:38.680Z] Your branch is up to date with 'origin/main'.
[vcs 2024-02-02T20:05:38.680Z] executing ['git', 'fetch', 'origin', '9656dad49e7d419a77e15bb9166f77792db97422']
[vcs 2024-02-02T20:05:38.888Z] From https://github.com/mozilla-releng/reps
[vcs 2024-02-02T20:05:38.888Z]  * branch            9656dad49e7d419a77e15bb9166f77792db97422 -> FETCH_HEAD
[vcs 2024-02-02T20:05:38.892Z] executing ['git', 'fetch', '--no-tags', 'https://github.com/ahal/reps', 'bump']
[vcs 2024-02-02T20:05:39.188Z] From https://github.com/ahal/reps
[vcs 2024-02-02T20:05:39.188Z]  * branch            bump       -> FETCH_HEAD
[vcs 2024-02-02T20:05:39.190Z] executing ['git', 'checkout', '-f', '-B', 'bump', '83908e79ac5abaa673fbf0e7de76ea2831ea1a61']
[vcs 2024-02-02T20:05:39.196Z] Switched to a new branch 'bump'
[vcs 2024-02-02T20:05:39.197Z] cleaning git checkout...
[vcs 2024-02-02T20:05:39.197Z] executing ['git', 'clean', '-nxdff']
[vcs 2024-02-02T20:05:39.199Z] removing []
[vcs 2024-02-02T20:05:39.199Z] successfully cleaned git checkout!
[vcs 2024-02-02T20:05:39.201Z] TinderboxPrint:<a href='https://github.com/ahal/reps/commit/83908e79ac5abaa673fbf0e7de76ea2831ea1a61' title='Built from reps commit 83908e79ac5abaa673fbf0e7de76ea2831ea1a61'>83908e79ac5abaa673fbf0e7de76ea2831ea1a61</a>
[pip-install 2024-02-02T20:05:39.202Z] executing ['/usr/bin/python3', '-mpip', 'install', '--break-system-packages', '--require-hashes', '-r', '/builds/worker/checkouts/src/taskcluster/requirements.txt']
[pip-install 2024-02-02T20:05:39.463Z] Defaulting to user installation because normal site-packages is not writeable
[pip-install 2024-02-02T20:05:39.545Z] Requirement already satisfied: appdirs==1.4.4 in /usr/local/lib/python3.11/dist-packages (from -r /builds/worker/checkouts/src/taskcluster/requirements.txt (line 7)) (1.4.4)
[pip-install 2024-02-02T20:05:39.547Z] Requirement already satisfied: arrow==1.2.3 in /usr/local/lib/python3.11/dist-packages (from -r /builds/worker/checkouts/src/taskcluster/requirements.txt (line 11)) (1.2.3)
[pip-install 2024-02-02T20:05:39.549Z] Requirement already satisfied: binaryornot==0.4.4 in /usr/local/lib/python3.11/dist-packages (from -r /builds/worker/checkouts/src/taskcluster/requirements.txt (line 15)) (0.4.4)
[pip-install 2024-02-02T20:05:39.640Z] Collecting certifi==2023.7.22
[pip-install 2024-02-02T20:05:39.791Z]   Downloading certifi-2023.7.22-py3-none-any.whl (158 kB)
[pip-install 2024-02-02T20:05:39.883Z]      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 158.3/158.3 kB 1.7 MB/s eta 0:00:00
[pip-install 2024-02-02T20:05:39.887Z] Requirement already satisfied: chardet==5.1.0 in /usr/local/lib/python3.11/dist-packages (from -r /builds/worker/checkouts/src/taskcluster/requirements.txt (line 23)) (5.1.0)
[pip-install 2024-02-02T20:05:39.889Z] Requirement already satisfied: charset-normalizer==3.1.0 in /usr/local/lib/python3.11/dist-packages (from -r /builds/worker/checkouts/src/taskcluster/requirements.txt (line 27)) (3.1.0)
[pip-install 2024-02-02T20:05:39.921Z] Collecting click==8.1.4
[pip-install 2024-02-02T20:05:39.964Z]   Downloading click-8.1.4-py3-none-any.whl (98 kB)
[pip-install 2024-02-02T20:05:39.976Z]      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.2/98.2 kB 10.0 MB/s eta 0:00:00
[pip-install 2024-02-02T20:05:40.005Z] Collecting cookiecutter==2.2.0
[pip-install 2024-02-02T20:05:40.047Z]   Downloading cookiecutter-2.2.0-py3-none-any.whl (38 kB)
[pip-install 2024-02-02T20:05:40.054Z] Requirement already satisfied: giturlparse==0.10.0 in /usr/local/lib/python3.11/dist-packages (from -r /builds/worker/checkouts/src/taskcluster/requirements.txt (line 112)) (0.10.0)
[pip-install 2024-02-02T20:05:40.056Z] Requirement already satisfied: idna==3.4 in /usr/local/lib/python3.11/dist-packages (from -r /builds/worker/checkouts/src/taskcluster/requirements.txt (line 116)) (3.4)
[pip-install 2024-02-02T20:05:40.057Z] Requirement already satisfied: jinja2==3.1.2 in /usr/local/lib/python3.11/dist-packages (from -r /builds/worker/checkouts/src/taskcluster/requirements.txt (line 120)) (3.1.2)
[pip-install 2024-02-02T20:05:40.058Z] Requirement already satisfied: json-e==4.5.2 in /usr/local/lib/python3.11/dist-packages (from -r /builds/worker/checkouts/src/taskcluster/requirements.txt (line 124)) (4.5.2)
[pip-install 2024-02-02T20:05:40.060Z] Requirement already satisfied: markupsafe==2.1.3 in /usr/local/lib/python3.11/dist-packages (from -r /builds/worker/checkouts/src/taskcluster/requirements.txt (line 128)) (2.1.3)
[pip-install 2024-02-02T20:05:40.061Z] Requirement already satisfied: mozilla-repo-urls==0.1.1 in /usr/local/lib/python3.11/dist-packages (from -r /builds/worker/checkouts/src/taskcluster/requirements.txt (line 180)) (0.1.1)
[pip-install 2024-02-02T20:05:40.063Z] Requirement already satisfied: python-dateutil==2.8.2 in /usr/local/lib/python3.11/dist-packages (from -r /builds/worker/checkouts/src/taskcluster/requirements.txt (line 184)) (2.8.2)
[pip-install 2024-02-02T20:05:40.064Z] Requirement already satisfied: python-slugify==8.0.1 in /usr/local/lib/python3.11/dist-packages (from -r /builds/worker/checkouts/src/taskcluster/requirements.txt (line 188)) (8.0.1)
[pip-install 2024-02-02T20:05:40.065Z] Requirement already satisfied: pyyaml==6.0 in /usr/local/lib/python3.11/dist-packages (from -r /builds/worker/checkouts/src/taskcluster/requirements.txt (line 192)) (6.0)
[pip-install 2024-02-02T20:05:40.067Z] Requirement already satisfied: redo==2.0.4 in /usr/local/lib/python3.11/dist-packages (from -r /builds/worker/checkouts/src/taskcluster/requirements.txt (line 236)) (2.0.4)
[pip-install 2024-02-02T20:05:40.068Z] Requirement already satisfied: requests==2.31.0 in /usr/local/lib/python3.11/dist-packages (from -r /builds/worker/checkouts/src/taskcluster/requirements.txt (line 240)) (2.31.0)
[pip-install 2024-02-02T20:05:40.069Z] Requirement already satisfied: six==1.16.0 in /usr/local/lib/python3.11/dist-packages (from -r /builds/worker/checkouts/src/taskcluster/requirements.txt (line 246)) (1.16.0)
[pip-install 2024-02-02T20:05:40.070Z] Requirement already satisfied: slugid==2.0.0 in /usr/local/lib/python3.11/dist-packages (from -r /builds/worker/checkouts/src/taskcluster/requirements.txt (line 250)) (2.0.0)
[pip-install 2024-02-02T20:05:40.103Z] Collecting taskcluster-taskgraph==7.0.0
[pip-install 2024-02-02T20:05:40.147Z]   Downloading taskcluster_taskgraph-7.0.0-py3-none-any.whl (185 kB)
[pip-install 2024-02-02T20:05:40.167Z]      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 185.7/185.7 kB 10.7 MB/s eta 0:00:00
[pip-install 2024-02-02T20:05:40.170Z] Requirement already satisfied: taskcluster-urls==13.0.1 in /usr/local/lib/python3.11/dist-packages (from -r /builds/worker/checkouts/src/taskcluster/requirements.txt (line 258)) (13.0.1)
[pip-install 2024-02-02T20:05:40.172Z] Requirement already satisfied: text-unidecode==1.3 in /usr/local/lib/python3.11/dist-packages (from -r /builds/worker/checkouts/src/taskcluster/requirements.txt (line 263)) (1.3)
[pip-install 2024-02-02T20:05:40.221Z] Collecting urllib3==2.0.7
[pip-install 2024-02-02T20:05:40.264Z]   Downloading urllib3-2.0.7-py3-none-any.whl (124 kB)
[pip-install 2024-02-02T20:05:40.272Z]      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 124.2/124.2 kB 20.9 MB/s eta 0:00:00
[pip-install 2024-02-02T20:05:40.277Z] Requirement already satisfied: voluptuous==0.13.1 in /usr/local/lib/python3.11/dist-packages (from -r /builds/worker/checkouts/src/taskcluster/requirements.txt (line 271)) (0.13.1)
[pip-install 2024-02-02T20:05:40.544Z] Installing collected packages: urllib3, click, certifi, cookiecutter, taskcluster-taskgraph
[pip-install 2024-02-02T20:05:40.673Z]   WARNING: The script cookiecutter is installed in '/builds/worker/.local/bin' which is not on PATH.
[pip-install 2024-02-02T20:05:40.673Z]   Consider adding this directory to PATH or, if you prefer to suppress this warning, use --no-warn-script-location.
[pip-install 2024-02-02T20:05:40.754Z]   WARNING: The script taskgraph is installed in '/builds/worker/.local/bin' which is not on PATH.
[pip-install 2024-02-02T20:05:40.754Z]   Consider adding this directory to PATH or, if you prefer to suppress this warning, use --no-warn-script-location.
[pip-install 2024-02-02T20:05:40.762Z] Successfully installed certifi-2023.7.22 click-8.1.4 cookiecutter-2.2.0 taskcluster-taskgraph-7.0.0 urllib3-2.0.7
[task 2024-02-02T20:05:40.824Z] executing ['bash', '-cx', "cd /builds/worker/checkouts/src && ln -s /builds/worker/artifacts artifacts && ~/.local/bin/taskgraph decision --pushlog-id='0' --pushdate='0' --project='reps' --owner='[email protected]' --level='1' --repository-type=git --tasks-for='github-pull-request' --base-repository='https://github.com/mozilla-releng/reps' --base-ref='main' --base-rev='9656dad49e7d419a77e15bb9166f77792db97422' --head-repository='https://github.com/ahal/reps' --head-ref='bump' --head-rev='83908e79ac5abaa673fbf0e7de76ea2831ea1a61' \n"]
[task 2024-02-02T20:05:40.826Z] + cd /builds/worker/checkouts/src
[task 2024-02-02T20:05:40.826Z] + ln -s /builds/worker/artifacts artifacts
[task 2024-02-02T20:05:40.827Z] + /builds/worker/.local/bin/taskgraph decision --pushlog-id=0 --pushdate=0 --project=reps [email protected] --level=1 --repository-type=git --tasks-for=github-pull-request --base-repository=https://github.com/mozilla-releng/reps --base-ref=main --base-rev=9656dad49e7d419a77e15bb9166f77792db97422 --head-repository=https://github.com/ahal/reps --head-ref=bump --head-rev=83908e79ac5abaa673fbf0e7de76ea2831ea1a61
[task 2024-02-02T20:05:41.219Z] 2024-02-02 20:05:41,218 - INFO - Loading graph configuration.
[task 2024-02-02T20:05:41.226Z] 2024-02-02 20:05:41,226 - WARNING - using default project parameters; add reps to PER_PROJECT_PARAMETERS in /builds/worker/.local/lib/python3.11/site-packages/taskgraph/decision.py to customize behavior for this project
[task 2024-02-02T20:05:41.226Z] 2024-02-02 20:05:41,226 - INFO - Using Parameters(id=6fe161f3f698) (from defaults)
[task 2024-02-02T20:05:41.227Z] 2024-02-02 20:05:41,227 - INFO - writing artifact file `parameters.yml`
[task 2024-02-02T20:05:41.231Z] 2024-02-02 20:05:41,231 - INFO - writing artifact file `actions.json`
[task 2024-02-02T20:05:41.232Z] 2024-02-02 20:05:41,232 - INFO - Loading kinds
[task 2024-02-02T20:05:41.241Z] 2024-02-02 20:05:41,241 - INFO - Generating full task set
[task 2024-02-02T20:05:41.248Z] 2024-02-02 20:05:41,248 - INFO - Writing docker-contexts/fetch.tar.gz for docker image fetch
[task 2024-02-02T20:05:41.264Z] 2024-02-02 20:05:41,264 - INFO - Writing docker-contexts/python.tar.gz for docker image python
[task 2024-02-02T20:05:41.281Z] 2024-02-02 20:05:41,281 - INFO - Generated 2 tasks for kind docker-image
[task 2024-02-02T20:05:41.291Z] 2024-02-02 20:05:41,291 - INFO - Generated 1 tasks for kind fetch
[task 2024-02-02T20:05:41.293Z] 2024-02-02 20:05:41,293 - INFO - Generated 2 tasks for kind test
[task 2024-02-02T20:05:41.295Z] 2024-02-02 20:05:41,295 - INFO - Generated 1 tasks for kind codecov
[task 2024-02-02T20:05:41.296Z] 2024-02-02 20:05:41,295 - INFO - Generating full task graph
[task 2024-02-02T20:05:41.297Z] 2024-02-02 20:05:41,295 - INFO - Full task graph contains 6 tasks and 6 dependencies
[task 2024-02-02T20:05:41.297Z] 2024-02-02 20:05:41,296 - INFO - writing artifact file `full-task-graph.json`
[task 2024-02-02T20:05:41.298Z] 2024-02-02 20:05:41,298 - INFO - writing artifact file `runnable-jobs.json`
[task 2024-02-02T20:05:41.298Z] 2024-02-02 20:05:41,298 - INFO - Generating target task set
[task 2024-02-02T20:05:41.299Z] 2024-02-02 20:05:41,298 - INFO - Filter filter_target_tasks pruned 3 tasks (3 remain)
[task 2024-02-02T20:05:41.299Z] 2024-02-02 20:05:41,298 - INFO - writing artifact file `target-tasks.json`
[task 2024-02-02T20:05:41.299Z] 2024-02-02 20:05:41,299 - INFO - Generating target task graph
[task 2024-02-02T20:05:41.299Z] 2024-02-02 20:05:41,299 - INFO - Adding 2 tasks with `always_target` attribute
[task 2024-02-02T20:05:41.299Z] 2024-02-02 20:05:41,299 - INFO - Generating optimized task graph
[task 2024-02-02T20:05:41.299Z] 2024-02-02 20:05:41,299 - INFO - No tasks removed during optimization
[task 2024-02-02T20:05:41.390Z] 2024-02-02 20:05:41,389 - WARNING - response body: {
[task 2024-02-02T20:05:41.390Z]   "code": "ResourceNotFound",
[task 2024-02-02T20:05:41.390Z]   "message": "Indexed task not found\n\n---\n\n* method:     findTask\n* errorCode:  ResourceNotFound\n* statusCode: 404\n* time:       2024-02-02T20:05:41.371Z",
[task 2024-02-02T20:05:41.390Z]   "requestInfo": {
[task 2024-02-02T20:05:41.390Z]     "method": "findTask",
[task 2024-02-02T20:05:41.390Z]     "params": {
[task 2024-02-02T20:05:41.390Z]       "indexPath": "mozilla.v2.reps.cache.level-3.docker-images.v2.fetch.hash.9647b12f43b0d01a126b8a8adabd5ebd2f1ce2d37b7a10c53964dd1357f13e7c"
[task 2024-02-02T20:05:41.390Z]     },
[task 2024-02-02T20:05:41.390Z]     "payload": {},
[task 2024-02-02T20:05:41.390Z]     "time": "2024-02-02T20:05:41.371Z"
[task 2024-02-02T20:05:41.390Z]   }
[task 2024-02-02T20:05:41.390Z] }
[task 2024-02-02T20:05:41.436Z] 2024-02-02 20:05:41,436 - WARNING - response body: {
[task 2024-02-02T20:05:41.436Z]   "code": "ResourceNotFound",
[task 2024-02-02T20:05:41.436Z]   "message": "Indexed task not found\n\n---\n\n* method:     findTask\n* errorCode:  ResourceNotFound\n* statusCode: 404\n* time:       2024-02-02T20:05:41.418Z",
[task 2024-02-02T20:05:41.436Z]   "requestInfo": {
[task 2024-02-02T20:05:41.436Z]     "method": "findTask",
[task 2024-02-02T20:05:41.436Z]     "params": {
[task 2024-02-02T20:05:41.436Z]       "indexPath": "mozilla.v2.reps.cache.level-3.docker-images.v2.python.hash.ed63992f82633b679b6503e3674b5b0062f7138370ea3c691cf04e5a77cb7e46"
[task 2024-02-02T20:05:41.436Z]     },
[task 2024-02-02T20:05:41.436Z]     "payload": {},
[task 2024-02-02T20:05:41.436Z]     "time": "2024-02-02T20:05:41.418Z"
[task 2024-02-02T20:05:41.436Z]   }
[task 2024-02-02T20:05:41.436Z] }
[task 2024-02-02T20:05:41.436Z] 2024-02-02 20:05:41,436 - INFO - No tasks replaced during optimization
[task 2024-02-02T20:05:41.437Z] 2024-02-02 20:05:41,437 - INFO - writing artifact file `task-graph.json`
[task 2024-02-02T20:05:41.438Z] 2024-02-02 20:05:41,438 - INFO - writing artifact file `label-to-taskid.json`
[task 2024-02-02T20:05:41.440Z] 2024-02-02 20:05:41,440 - INFO - Creating task with taskId OrjGF6y8RC2GSlji7ILODQ for build-docker-image-fetch
[task 2024-02-02T20:05:41.441Z] 2024-02-02 20:05:41,441 - INFO - Creating task with taskId R9dpYpTPTs-e6nWRb6dgxg for build-docker-image-python
[task 2024-02-02T20:05:41.553Z] 2024-02-02 20:05:41,553 - INFO - Creating task with taskId PNyWLm5CRZGGW-3wlsTWYg for test-type-check
[task 2024-02-02T20:05:41.555Z] 2024-02-02 20:05:41,554 - INFO - Creating task with taskId IBxNkBCgRnOFjNhI5J68Dw for test-unit
[task 2024-02-02T20:05:41.629Z] 2024-02-02 20:05:41,629 - INFO - Creating task with taskId LAMM5rlVRA2nxg58YAzRoA for fetch-codecov-uploader
[task 2024-02-02T20:05:41.731Z] 2024-02-02 20:05:41,731 - INFO - Creating task with taskId bQy-aFsYQ5yRhq4CzifyEg for codecov-upload
[taskcluster 2024-02-02 20:05:42.012Z] === Task Finished ===
[taskcluster 2024-02-02 20:05:43.996Z] Successful task run with exit code: 0 completed in 16.474 seconds