[taskcluster 2025-01-06 23:01:35.414Z] Task ID: b8j_Ey-3RpS4fikSPrhlyQ
[taskcluster 2025-01-06 23:01:35.414Z] Worker ID: 6324693990517104274
[taskcluster 2025-01-06 23:01:35.414Z] Worker Group: us-central1-c
[taskcluster 2025-01-06 23:01:35.414Z] Worker Node Type: projects/887720501152/machineTypes/n2-standard-2
[taskcluster 2025-01-06 23:01:35.414Z] Worker Pool: ci-1/decision-gcp
[taskcluster 2025-01-06 23:01:35.414Z] Worker Version: 38.0.5
[taskcluster 2025-01-06 23:01:35.414Z] Public IP: 34.31.142.75
[taskcluster 2025-01-06 23:01:35.414Z] Hostname: ci-1-decision-gcp-nfdlhx-iso6hbnhuniwtpg
[taskcluster 2025-01-06 23:01:35.414Z] using cache "ci-level-1-checkouts-sparse-v1" -> /builds/worker/checkouts

51ef4d363c0b - Started downloading
eb45b407d1cc - Started downloading
258767289e45 - Started downloading
51ef4d363c0b - Downloaded in 0.108 seconds
eb45b407d1cc - Downloaded in 0.27 seconds
2a936e0a7084 - Started downloading
2a936e0a7084 - Downloaded in 0.001 seconds
258767289e45 - Downloaded in 0.711 seconds
Digest: sha256:756d6edd4c60e1c58132a667273e3cb6113bde3d7a4a3f7b326b375caf53eb81
Status: Downloaded newer image for mozillareleases/taskgraph@sha256:756d6edd4c60e1c58132a667273e3cb6113bde3d7a4a3f7b326b375caf53eb81
[taskcluster 2025-01-06 23:01:47.025Z] === Task Starting ===
[setup 2025-01-06T23:01:48.238Z] run-task started in /
[setup 2025-01-06T23:01:48.238Z] Invoked by command: --fxci-checkout=/builds/worker/checkouts/src --task-cwd=/builds/worker/checkouts/src -- bash -cx ln -s /builds/worker/artifacts artifacts && taskgraph decision --verbose --pushlog-id='0' --pushdate='0' --project='fxci-config' --owner='pre-commit-ci[bot]@users.noreply.github.com' --level='1' --repository-type=git --tasks-for='github-pull-request-untrusted' --base-repository='https://github.com/mozilla-releng/fxci-config' --base-ref='main' --base-rev='6adf2a1fe7405c725cf215b41167d9ea0a5a2361' --head-repository='https://github.com/mozilla-releng/fxci-config' --head-ref='pre-commit-ci-update-config' --head-rev='3de40879f35c7403b1107bf2a980e31f36c5f72b' ${TRY_TASK_CONFIG_FILE+--try-task-config-file="${TRY_TASK_CONFIG_FILE}"} 

[setup 2025-01-06T23:01:48.238Z] Python version: 3.11.2
[vcs 2025-01-06T23:01:48.240Z] WARNING: vcs checkout path (/builds/worker/checkouts/src) not in cache or volume; performance will likely suffer
[setup 2025-01-06T23:01:48.240Z] running as worker:worker
[vcs 2025-01-06T23:01:48.240Z] executing ['git', 'config', '--global', '--add', 'safe.directory', '/builds/worker/checkouts/src']
[vcs 2025-01-06T23:01:48.242Z] executing ['git', 'clone', 'https://github.com/mozilla-releng/fxci-config', '/builds/worker/checkouts/src']
[vcs 2025-01-06T23:01:48.244Z] Cloning into '/builds/worker/checkouts/src'...
[vcs 2025-01-06T23:01:49.659Z] executing ['git', 'fetch', 'origin', 'main']
[vcs 2025-01-06T23:01:49.857Z] From https://github.com/mozilla-releng/fxci-config
[vcs 2025-01-06T23:01:49.857Z]  * branch            main       -> FETCH_HEAD
[vcs 2025-01-06T23:01:49.862Z] executing ['git', 'checkout', 'main']
[vcs 2025-01-06T23:01:49.872Z] Already on 'main'
[vcs 2025-01-06T23:01:49.872Z] Your branch is up to date with 'origin/main'.
[vcs 2025-01-06T23:01:49.873Z] executing ['git', 'fetch', 'origin', '6adf2a1fe7405c725cf215b41167d9ea0a5a2361']
[vcs 2025-01-06T23:01:50.053Z] From https://github.com/mozilla-releng/fxci-config
[vcs 2025-01-06T23:01:50.053Z]  * branch            6adf2a1fe7405c725cf215b41167d9ea0a5a2361 -> FETCH_HEAD
[vcs 2025-01-06T23:01:50.058Z] executing ['git', 'fetch', '--tags', '--force', 'https://github.com/mozilla-releng/fxci-config', 'pre-commit-ci-update-config']
[vcs 2025-01-06T23:01:50.237Z] From https://github.com/mozilla-releng/fxci-config
[vcs 2025-01-06T23:01:50.237Z]  * branch            pre-commit-ci-update-config -> FETCH_HEAD
[vcs 2025-01-06T23:01:50.242Z] executing ['git', 'fetch', '--no-tags', 'https://github.com/mozilla-releng/fxci-config', 'pre-commit-ci-update-config']
[vcs 2025-01-06T23:01:50.447Z] From https://github.com/mozilla-releng/fxci-config
[vcs 2025-01-06T23:01:50.447Z]  * branch            pre-commit-ci-update-config -> FETCH_HEAD
[vcs 2025-01-06T23:01:50.453Z] executing ['git', 'checkout', '-f', '-B', 'pre-commit-ci-update-config', '3de40879f35c7403b1107bf2a980e31f36c5f72b']
[vcs 2025-01-06T23:01:50.466Z] Switched to a new branch 'pre-commit-ci-update-config'
[vcs 2025-01-06T23:01:50.467Z] cleaning git checkout...
[vcs 2025-01-06T23:01:50.467Z] executing ['git', 'clean', '-nxdff']
[vcs 2025-01-06T23:01:50.469Z] removing []
[vcs 2025-01-06T23:01:50.469Z] successfully cleaned git checkout!
[vcs 2025-01-06T23:01:50.471Z] TinderboxPrint:<a href='https://github.com/mozilla-releng/fxci-config/commit/3de40879f35c7403b1107bf2a980e31f36c5f72b' title='Built from fxci-config commit 3de40879f35c7403b1107bf2a980e31f36c5f72b'>3de40879f35c7403b1107bf2a980e31f36c5f72b</a>
[pip-install 2025-01-06T23:01:50.489Z] executing ['uv', 'pip', 'install', '--python', '/usr/bin/python3', '--target', '/builds/worker/.local/lib/python3.11/site-packages', '--require-hashes', '-r', '/builds/worker/checkouts/src/taskcluster/requirements.txt']
[pip-install 2025-01-06T23:01:50.861Z] Resolved 20 packages in 320ms
[pip-install 2025-01-06T23:01:51.011Z] Prepared 20 packages in 146ms
[pip-install 2025-01-06T23:01:51.025Z] Installed 20 packages in 13ms
[pip-install 2025-01-06T23:01:51.025Z]  + aiohappyeyeballs==2.4.4
[pip-install 2025-01-06T23:01:51.026Z]  + aiohttp==3.11.11
[pip-install 2025-01-06T23:01:51.026Z]  + aiosignal==1.3.2
[pip-install 2025-01-06T23:01:51.027Z]  + async-timeout==5.0.1
[pip-install 2025-01-06T23:01:51.027Z]  + attrs==24.3.0
[pip-install 2025-01-06T23:01:51.027Z]  + certifi==2024.12.14
[pip-install 2025-01-06T23:01:51.027Z]  + charset-normalizer==3.4.0
[pip-install 2025-01-06T23:01:51.027Z]  + frozenlist==1.5.0
[pip-install 2025-01-06T23:01:51.027Z]  + idna==3.10
[pip-install 2025-01-06T23:01:51.027Z]  + mohawk==1.1.0
[pip-install 2025-01-06T23:01:51.027Z]  + multidict==6.1.0
[pip-install 2025-01-06T23:01:51.027Z]  + propcache==0.2.1
[pip-install 2025-01-06T23:01:51.027Z]  + python-dateutil==2.9.0.post0
[pip-install 2025-01-06T23:01:51.027Z]  + requests==2.32.3
[pip-install 2025-01-06T23:01:51.028Z]  + six==1.17.0
[pip-install 2025-01-06T23:01:51.028Z]  + slugid==2.0.0
[pip-install 2025-01-06T23:01:51.028Z]  + taskcluster==77.0.0
[pip-install 2025-01-06T23:01:51.028Z]  + taskcluster-urls==13.0.1
[pip-install 2025-01-06T23:01:51.028Z]  + urllib3==2.2.3
[pip-install 2025-01-06T23:01:51.028Z]  + yarl==1.18.3
[task 2025-01-06T23:01:51.035Z] executing ['bash', '-cx', 'ln -s /builds/worker/artifacts artifacts && taskgraph decision --verbose --pushlog-id=\'0\' --pushdate=\'0\' --project=\'fxci-config\' --owner=\'pre-commit-ci[bot]@users.noreply.github.com\' --level=\'1\' --repository-type=git --tasks-for=\'github-pull-request-untrusted\' --base-repository=\'https://github.com/mozilla-releng/fxci-config\' --base-ref=\'main\' --base-rev=\'6adf2a1fe7405c725cf215b41167d9ea0a5a2361\' --head-repository=\'https://github.com/mozilla-releng/fxci-config\' --head-ref=\'pre-commit-ci-update-config\' --head-rev=\'3de40879f35c7403b1107bf2a980e31f36c5f72b\' ${TRY_TASK_CONFIG_FILE+--try-task-config-file="${TRY_TASK_CONFIG_FILE}"} \n']
[task 2025-01-06T23:01:51.037Z] + ln -s /builds/worker/artifacts artifacts
[task 2025-01-06T23:01:51.038Z] + taskgraph decision --verbose --pushlog-id=0 --pushdate=0 --project=fxci-config '--owner=pre-commit-ci[bot]@users.noreply.github.com' --level=1 --repository-type=git --tasks-for=github-pull-request-untrusted --base-repository=https://github.com/mozilla-releng/fxci-config --base-ref=main --base-rev=6adf2a1fe7405c725cf215b41167d9ea0a5a2361 --head-repository=https://github.com/mozilla-releng/fxci-config --head-ref=pre-commit-ci-update-config --head-rev=3de40879f35c7403b1107bf2a980e31f36c5f72b
[task 2025-01-06T23:01:51.632Z] 2025-01-06 23:01:51,632 - INFO - Loading graph configuration.
[task 2025-01-06T23:01:51.633Z] 2025-01-06 23:01:51,632 - DEBUG - loading config from `taskcluster/config.yml`
[task 2025-01-06T23:01:51.643Z] 2025-01-06 23:01:51,643 - WARNING - using default project parameters; add fxci-config to PER_PROJECT_PARAMETERS in /usr/local/lib/python3.11/dist-packages/taskgraph/decision.py to customize behavior for this project
[task 2025-01-06T23:01:51.644Z] 2025-01-06 23:01:51,644 - INFO - Using Parameters(id=45104d081241) (from defaults)
[task 2025-01-06T23:01:51.645Z] 2025-01-06 23:01:51,645 - DEBUG - Dumping parameters:
[task 2025-01-06T23:01:51.645Z] { 'base_ref': 'main',
[task 2025-01-06T23:01:51.645Z]   'base_repository': 'https://github.com/mozilla-releng/fxci-config',
[task 2025-01-06T23:01:51.645Z]   'base_rev': '6adf2a1fe7405c725cf215b41167d9ea0a5a2361',
[task 2025-01-06T23:01:51.645Z]   'build_date': 1736204511,
[task 2025-01-06T23:01:51.645Z]   'build_number': 1,
[task 2025-01-06T23:01:51.645Z]   'do_not_optimize': [],
[task 2025-01-06T23:01:51.645Z]   'enable_always_target': True,
[task 2025-01-06T23:01:51.645Z]   'existing_tasks': {},
[task 2025-01-06T23:01:51.645Z]   'files_changed': ['.pre-commit-config.yaml'],
[task 2025-01-06T23:01:51.645Z]   'filters': ['target_tasks_method'],
[task 2025-01-06T23:01:51.645Z]   'head_ref': 'pre-commit-ci-update-config',
[task 2025-01-06T23:01:51.645Z]   'head_repository': 'https://github.com/mozilla-releng/fxci-config',
[task 2025-01-06T23:01:51.645Z]   'head_rev': '3de40879f35c7403b1107bf2a980e31f36c5f72b',
[task 2025-01-06T23:01:51.645Z]   'head_tag': '',
[task 2025-01-06T23:01:51.645Z]   'level': '1',
[task 2025-01-06T23:01:51.645Z]   'moz_build_date': '20250106230151',
[task 2025-01-06T23:01:51.645Z]   'next_version': None,
[task 2025-01-06T23:01:51.645Z]   'optimize_strategies': None,
[task 2025-01-06T23:01:51.646Z]   'optimize_target_tasks': True,
[task 2025-01-06T23:01:51.646Z]   'owner': 'pre-commit-ci[bot]@users.noreply.github.com',
[task 2025-01-06T23:01:51.646Z]   'project': 'fxci-config',
[task 2025-01-06T23:01:51.646Z]   'pushdate': 0,
[task 2025-01-06T23:01:51.646Z]   'pushlog_id': '0',
[task 2025-01-06T23:01:51.646Z]   'repository_type': 'git',
[task 2025-01-06T23:01:51.646Z]   'target_tasks_method': 'default',
[task 2025-01-06T23:01:51.646Z]   'tasks_for': 'github-pull-request-untrusted',
[task 2025-01-06T23:01:51.646Z]   'version': None}
[task 2025-01-06T23:01:51.646Z] 2025-01-06 23:01:51,646 - INFO - writing artifact file `parameters.yml`
[task 2025-01-06T23:01:51.656Z] 2025-01-06 23:01:51,656 - INFO - writing artifact file `actions.json`
[task 2025-01-06T23:01:51.657Z] 2025-01-06 23:01:51,657 - INFO - Loading kinds
[task 2025-01-06T23:01:51.658Z] 2025-01-06 23:01:51,658 - DEBUG - loading kind `tc-admin` from `taskcluster/kinds/tc-admin`
[task 2025-01-06T23:01:51.658Z] 2025-01-06 23:01:51,658 - DEBUG - loading kind `integration-test` from `taskcluster/kinds/integration-test`
[task 2025-01-06T23:01:51.659Z] 2025-01-06 23:01:51,659 - DEBUG - loading kind `firefoxci-artifact` from `taskcluster/kinds/firefoxci-artifact`
[task 2025-01-06T23:01:51.659Z] 2025-01-06 23:01:51,659 - DEBUG - loading kind `docker-image` from `taskcluster/kinds/docker-image`
[task 2025-01-06T23:01:51.660Z] 2025-01-06 23:01:51,660 - DEBUG - loading kind `tests` from `taskcluster/kinds/tests`
[task 2025-01-06T23:01:51.661Z] 2025-01-06 23:01:51,661 - INFO - Generating full task set
[task 2025-01-06T23:01:51.661Z] 2025-01-06 23:01:51,661 - DEBUG - Loading tasks for kind docker-image
[task 2025-01-06T23:01:51.682Z] 2025-01-06 23:01:51,682 - DEBUG - Generating tasks for docker-image build-decision
[task 2025-01-06T23:01:51.682Z] 2025-01-06 23:01:51,682 - INFO - Writing docker-contexts/build-decision.tar.gz for docker image build-decision
[task 2025-01-06T23:01:51.693Z] 2025-01-06 23:01:51,693 - DEBUG - Generating tasks for docker-image python3.11
[task 2025-01-06T23:01:51.693Z] 2025-01-06 23:01:51,693 - INFO - Writing docker-contexts/python3.11.tar.gz for docker image python3.11
[task 2025-01-06T23:01:51.710Z] 2025-01-06 23:01:51,710 - INFO - Generated 2 tasks for kind docker-image
[task 2025-01-06T23:01:51.710Z] 2025-01-06 23:01:51,710 - DEBUG - Loading tasks for kind firefoxci-artifact
[task 2025-01-06T23:01:51.763Z] 2025-01-06 23:01:51,763 - INFO - Generated 0 tasks for kind firefoxci-artifact
[task 2025-01-06T23:01:51.764Z] 2025-01-06 23:01:51,763 - DEBUG - Loading tasks for kind tc-admin
[task 2025-01-06T23:01:51.765Z] 2025-01-06 23:01:51,765 - DEBUG - Generating tasks for tc-admin apply-staging
[task 2025-01-06T23:01:51.766Z] 2025-01-06 23:01:51,766 - INFO - Generated 1 tasks for kind tc-admin
[task 2025-01-06T23:01:51.766Z] 2025-01-06 23:01:51,766 - DEBUG - Loading tasks for kind tests
[task 2025-01-06T23:01:51.768Z] 2025-01-06 23:01:51,768 - DEBUG - Generating tasks for tests unit-ciadmin
[task 2025-01-06T23:01:51.768Z] 2025-01-06 23:01:51,768 - DEBUG - Generating tasks for tests unit-build-decision
[task 2025-01-06T23:01:51.768Z] 2025-01-06 23:01:51,768 - DEBUG - Generating tasks for tests unit-fxci-config-taskgraph
[task 2025-01-06T23:01:51.770Z] 2025-01-06 23:01:51,769 - INFO - Generated 3 tasks for kind tests
[task 2025-01-06T23:01:51.770Z] 2025-01-06 23:01:51,770 - DEBUG - Loading tasks for kind integration-test
[task 2025-01-06T23:01:51.772Z] 2025-01-06 23:01:51,772 - INFO - Generated 0 tasks for kind integration-test
[task 2025-01-06T23:01:51.772Z] 2025-01-06 23:01:51,772 - INFO - Generating full task graph
[task 2025-01-06T23:01:51.772Z] 2025-01-06 23:01:51,772 - INFO - Full task graph contains 6 tasks and 4 dependencies
[task 2025-01-06T23:01:51.772Z] 2025-01-06 23:01:51,772 - INFO - writing artifact file `full-task-graph.json`
[task 2025-01-06T23:01:51.774Z] 2025-01-06 23:01:51,774 - INFO - writing artifact file `runnable-jobs.json`
[task 2025-01-06T23:01:51.774Z] 2025-01-06 23:01:51,774 - INFO - Generating target task set
[task 2025-01-06T23:01:51.774Z] 2025-01-06 23:01:51,774 - INFO - Filter filter_target_tasks pruned 3 tasks (3 remain)
[task 2025-01-06T23:01:51.774Z] 2025-01-06 23:01:51,774 - INFO - writing artifact file `target-tasks.json`
[task 2025-01-06T23:01:51.775Z] 2025-01-06 23:01:51,774 - INFO - Generating target task graph
[task 2025-01-06T23:01:51.775Z] 2025-01-06 23:01:51,775 - INFO - Adding 2 tasks with `always_target` attribute
[task 2025-01-06T23:01:51.775Z] 2025-01-06 23:01:51,775 - INFO - Generating optimized task graph
[task 2025-01-06T23:01:51.776Z] 2025-01-06 23:01:51,776 - DEBUG - no files found matching a pattern in `skip-unless-changed` for "tests-unit-build-decision"
[task 2025-01-06T23:01:51.776Z] 2025-01-06 23:01:51,776 - DEBUG - no files found matching a pattern in `skip-unless-changed` for "tests-unit-fxci-config-taskgraph"
[task 2025-01-06T23:01:51.776Z] 2025-01-06 23:01:51,776 - DEBUG - optimize: docker-image-build-decision kept because of index-search (index-search)
[task 2025-01-06T23:01:51.776Z] 2025-01-06 23:01:51,776 - DEBUG - optimize: tests-unit-build-decision removed because of skip-unless-changed (skip-unless-changed)
[task 2025-01-06T23:01:51.776Z] 2025-01-06 23:01:51,776 - DEBUG - optimize: tests-unit-ciadmin kept because of never
[task 2025-01-06T23:01:51.776Z] 2025-01-06 23:01:51,776 - DEBUG - optimize: tests-unit-fxci-config-taskgraph removed because of skip-unless-changed (skip-unless-changed)
[task 2025-01-06T23:01:51.776Z] 2025-01-06 23:01:51,776 - DEBUG - optimize: docker-image-python3.11 kept because of dependent tasks
[task 2025-01-06T23:01:51.777Z] 2025-01-06 23:01:51,777 - INFO - Removed 2 tasks by skip-unless-changed (skip-unless-changed) during optimization.
[task 2025-01-06T23:01:51.777Z] 2025-01-06 23:01:51,777 - DEBUG - Running in Taskcluster instance https://firefox-ci-tc.services.mozilla.com with taskcluster-proxy
[task 2025-01-06T23:01:51.779Z] 2025-01-06 23:01:51,778 - DEBUG - Starting new HTTPS connection (1): firefox-ci-tc.services.mozilla.com:443
[task 2025-01-06T23:01:51.890Z] 2025-01-06 23:01:51,890 - DEBUG - https://firefox-ci-tc.services.mozilla.com:443 "POST /api/index/v1/tasks/indexes HTTP/11" 200 None
[task 2025-01-06T23:01:51.950Z] 2025-01-06 23:01:51,950 - DEBUG - https://firefox-ci-tc.services.mozilla.com:443 "POST /api/queue/v1/tasks/status HTTP/11" 200 None
[task 2025-01-06T23:01:51.951Z] 2025-01-06 23:01:51,951 - DEBUG - replace_tasks: docker-image-build-decision
[task 2025-01-06T23:01:51.951Z] 2025-01-06 23:01:51,951 - DEBUG - replace_tasks: docker-image-build-decision replaced with Ah5aOFtZTNCXsK3JPjvLmw by optimization strategy
[task 2025-01-06T23:01:51.951Z] 2025-01-06 23:01:51,951 - DEBUG - replace_tasks: docker-image-python3.11
[task 2025-01-06T23:01:51.954Z] 2025-01-06 23:01:51,954 - DEBUG - replace_tasks: docker-image-python3.11 replaced with JpZc_MiSTheKx6_CiAAMkw by optimization strategy
[task 2025-01-06T23:01:51.954Z] 2025-01-06 23:01:51,954 - DEBUG - replace_tasks: tests-unit-build-decision
[task 2025-01-06T23:01:51.954Z] 2025-01-06 23:01:51,954 - DEBUG - replace_tasks: tests-unit-build-decision kept by optimization strategy
[task 2025-01-06T23:01:51.954Z] 2025-01-06 23:01:51,954 - DEBUG - replace_tasks: tests-unit-ciadmin
[task 2025-01-06T23:01:51.954Z] 2025-01-06 23:01:51,954 - DEBUG - replace_tasks: tests-unit-ciadmin kept by optimization strategy
[task 2025-01-06T23:01:51.954Z] 2025-01-06 23:01:51,954 - DEBUG - replace_tasks: tests-unit-fxci-config-taskgraph
[task 2025-01-06T23:01:51.954Z] 2025-01-06 23:01:51,954 - DEBUG - replace_tasks: tests-unit-fxci-config-taskgraph kept by optimization strategy
[task 2025-01-06T23:01:51.955Z] 2025-01-06 23:01:51,954 - INFO - Replaced 2 tasks by index-search (index-search) during optimization.
[task 2025-01-06T23:01:51.955Z] 2025-01-06 23:01:51,955 - DEBUG - Morphing: adding index tasks
[task 2025-01-06T23:01:51.955Z] 2025-01-06 23:01:51,955 - DEBUG - Morphing: adding code review task
[task 2025-01-06T23:01:51.955Z] 2025-01-06 23:01:51,955 - INFO - writing artifact file `task-graph.json`
[task 2025-01-06T23:01:51.956Z] 2025-01-06 23:01:51,956 - INFO - writing artifact file `label-to-taskid.json`
[task 2025-01-06T23:01:51.958Z] 2025-01-06 23:01:51,958 - INFO - Creating task with taskId H-O1j7tJS7C8oUML-yrUQA for tests-unit-ciadmin
[task 2025-01-06T23:01:51.959Z] 2025-01-06 23:01:51,959 - DEBUG - Starting new HTTP connection (1): taskcluster:80
[task 2025-01-06T23:01:52.073Z] 2025-01-06 23:01:52,073 - DEBUG - http://taskcluster:80 "PUT /queue/v1/task/H-O1j7tJS7C8oUML-yrUQA HTTP/11" 200 413
[taskcluster 2025-01-06 23:01:52.299Z] === Task Finished ===
[taskcluster 2025-01-06 23:01:54.358Z] Successful task run with exit code: 0 completed in 18.946 seconds