[taskcluster 2026-05-19T13:44:54.889Z] Worker Type (releng-1/decision) settings:
[taskcluster 2026-05-19T13:44:54.889Z]   {
[taskcluster 2026-05-19T13:44:54.889Z]     "generic-worker": {
[taskcluster 2026-05-19T13:44:54.889Z]       "config": {
[taskcluster 2026-05-19T13:44:54.889Z]         "headlessTasks": true
[taskcluster 2026-05-19T13:44:54.889Z]       },
[taskcluster 2026-05-19T13:44:54.889Z]       "engine": "multiuser",
[taskcluster 2026-05-19T13:44:54.889Z]       "go-arch": "amd64",
[taskcluster 2026-05-19T13:44:54.889Z]       "go-os": "linux",
[taskcluster 2026-05-19T13:44:54.889Z]       "go-version": "go1.26.2",
[taskcluster 2026-05-19T13:44:54.889Z]       "release": "https://github.com/taskcluster/taskcluster/releases/tag/v99.2.1",
[taskcluster 2026-05-19T13:44:54.889Z]       "revision": "ddb9ce7efdb98ae2d0917b69778e9f3cd125e07f",
[taskcluster 2026-05-19T13:44:54.889Z]       "source": "https://github.com/taskcluster/taskcluster/commits/ddb9ce7efdb98ae2d0917b69778e9f3cd125e07f",
[taskcluster 2026-05-19T13:44:54.889Z]       "version": "99.2.1"
[taskcluster 2026-05-19T13:44:54.889Z]     },
[taskcluster 2026-05-19T13:44:54.889Z]     "image": "projects/taskcluster-imaging/global/images/gw-fxci-gcp-l1-2404-amd64-headless-googlecompute-2026-05-04",
[taskcluster 2026-05-19T13:44:54.889Z]     "instance-id": "3215052571939035115",
[taskcluster 2026-05-19T13:44:54.889Z]     "instance-type": "projects/887720501152/machineTypes/n2-standard-2",
[taskcluster 2026-05-19T13:44:54.889Z]     "local-ipv4": "10.128.0.9",
[taskcluster 2026-05-19T13:44:54.889Z]     "project-id": "fxci-production-level1-workers",
[taskcluster 2026-05-19T13:44:54.889Z]     "public-hostname": "releng-1-decision-neac9c6vsvqh3xkgefvteg.c.fxci-production-level1-workers.internal",
[taskcluster 2026-05-19T13:44:54.889Z]     "public-ipv4": "136.119.150.140",
[taskcluster 2026-05-19T13:44:54.889Z]     "region": "us-central1",
[taskcluster 2026-05-19T13:44:54.889Z]     "zone": "us-central1-a"
[taskcluster 2026-05-19T13:44:54.889Z]   }
[taskcluster 2026-05-19T13:44:54.889Z] Task ID: Dn1qVe8wQoqbM7mR2EJbgw
[taskcluster 2026-05-19T13:44:54.889Z] === Task Starting ===
[taskcluster 2026-05-19T13:44:57.773Z] [mounts] No existing writable directory cache 'releng-level-1-checkouts-sparse-v1' - creating /home/generic-worker/caches/LVf-KP1XQN-95Xk1xRj5cQ
[taskcluster 2026-05-19T13:44:57.773Z] [mounts] Creating directory /home/task_177919829357869/cache0
[taskcluster 2026-05-19T13:44:57.795Z] [mounts] Successfully mounted writable directory cache '/home/task_177919829357869/cache0'
[taskcluster 2026-05-19T13:44:57.799Z] [d2g] Loading docker image
[taskcluster 2026-05-19T13:45:06.683Z] [d2g] Loaded docker image "docker.io/mozillareleases/taskgraph:decision-v23.0.0@sha256:3654f72ea7df1e0b9cb1c2a30dd9f4365138e3e86c4fc4948dc463c69f134aee"
[taskcluster 2026-05-19T13:45:06.703Z] Executing command 0: docker run -t --name taskcontainer_JdOfF4BeQ8yliO9WqX4EEg --memory-swap -1 --pids-limit -1 --pull=never --log-driver=none '--add-host=localhost.localdomain:127.0.0.1' -v /home/task_177919829357869/cache0:/builds/worker/checkouts --add-host=taskcluster:host-gateway --env-file 'env.list' 'mozillareleases/taskgraph:decision-v23.0.0@sha256:3654f72ea7df1e0b9cb1c2a30dd9f4365138e3e86c4fc4948dc463c69f134aee' run-task --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='\''jcristau@users.noreply.github.com'\'' --level='\''1'\'' --repository-type=git --tasks-for='\''github-pull-request'\'' --base-repository='\''https://github.com/mozilla-releng/fxci-config'\'' --base-ref='\''main'\'' --base-rev='\''7824c177b59b7f4bc422555bc4d2691e76a04469'\'' --head-repository='\''https://github.com/jcristau/fxci-config'\'' --head-ref='\''builddecision'\'' --head-rev='\''1b3e34f489292c71c819ef3ffaf15d1a8070a9f7'\'' ${TRY_TASK_CONFIG_FILE+--try-task-config-file="${TRY_TASK_CONFIG_FILE}"} 
[taskcluster 2026-05-19T13:45:06.703Z] '
[setup 2026-05-19T13:45:08.387+00:00] run-task started in /
[setup 2026-05-19T13:45:08.387+00:00] 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='jcristau@users.noreply.github.com' --level='1' --repository-type=git --tasks-for='github-pull-request' --base-repository='https://github.com/mozilla-releng/fxci-config' --base-ref='main' --base-rev='7824c177b59b7f4bc422555bc4d2691e76a04469' --head-repository='https://github.com/jcristau/fxci-config' --head-ref='builddecision' --head-rev='1b3e34f489292c71c819ef3ffaf15d1a8070a9f7' ${TRY_TASK_CONFIG_FILE+--try-task-config-file="${TRY_TASK_CONFIG_FILE}"} 

[setup 2026-05-19T13:45:08.388+00:00] Python version: 3.13.5
[setup 2026-05-19T13:45:08.388+00:00] Subprocess python version: 
cpython-3.13.5-linux-x86_64-gnu    /usr/bin/python3.13
cpython-3.13.5-linux-x86_64-gnu    /usr/bin/python3 -> python3.13
[vcs 2026-05-19T13:45:08.511+00:00] WARNING: vcs checkout path (/builds/worker/checkouts/src) not in cache or volume; performance will likely suffer
[setup 2026-05-19T13:45:08.511+00:00] running as worker:worker
[vcs 2026-05-19T13:45:08.512+00:00] executing ['git', 'config', '--global', '--add', 'safe.directory', '/builds/worker/checkouts/src']
[vcs 2026-05-19T13:45:08.514+00:00] executing ['git', 'clone', 'https://github.com/jcristau/fxci-config', '/builds/worker/checkouts/src']
[vcs 2026-05-19T13:45:08.516+00:00] Cloning into '/builds/worker/checkouts/src'...
[vcs 2026-05-19T13:45:11.088+00:00] executing ['git', 'fetch', 'origin', '7824c177b59b7f4bc422555bc4d2691e76a04469']
[vcs 2026-05-19T13:45:11.453+00:00] From https://github.com/jcristau/fxci-config
[vcs 2026-05-19T13:45:11.453+00:00]  * branch            7824c177b59b7f4bc422555bc4d2691e76a04469 -> FETCH_HEAD
[vcs 2026-05-19T13:45:11.456+00:00] executing ['git', 'fetch', '--tags', '--force', 'https://github.com/jcristau/fxci-config', 'builddecision']
[vcs 2026-05-19T13:45:11.660+00:00] From https://github.com/jcristau/fxci-config
[vcs 2026-05-19T13:45:11.660+00:00]  * branch            builddecision -> FETCH_HEAD
[vcs 2026-05-19T13:45:11.666+00:00] executing ['git', 'checkout', '-f', '-B', 'builddecision', '1b3e34f489292c71c819ef3ffaf15d1a8070a9f7']
[vcs 2026-05-19T13:45:11.686+00:00] Switched to a new branch 'builddecision'
[vcs 2026-05-19T13:45:11.687+00:00] cleaning git checkout...
[vcs 2026-05-19T13:45:11.687+00:00] executing ['git', 'clean', '-nxdff']
[vcs 2026-05-19T13:45:11.689+00:00] removing []
[vcs 2026-05-19T13:45:11.690+00:00] successfully cleaned git checkout!
[vcs 2026-05-19T13:45:11.692+00:00] TinderboxPrint:<a href='https://github.com/jcristau/fxci-config/commit/1b3e34f489292c71c819ef3ffaf15d1a8070a9f7' title='Built from fxci-config commit 1b3e34f489292c71c819ef3ffaf15d1a8070a9f7'>1b3e34f489292c71c819ef3ffaf15d1a8070a9f7</a>
[task 2026-05-19T13:45:11.692+00:00] executing ['bash', '-cx', 'ln -s /builds/worker/artifacts artifacts && taskgraph decision --verbose --pushlog-id=\'0\' --pushdate=\'0\' --project=\'fxci-config\' --owner=\'jcristau@users.noreply.github.com\' --level=\'1\' --repository-type=git --tasks-for=\'github-pull-request\' --base-repository=\'https://github.com/mozilla-releng/fxci-config\' --base-ref=\'main\' --base-rev=\'7824c177b59b7f4bc422555bc4d2691e76a04469\' --head-repository=\'https://github.com/jcristau/fxci-config\' --head-ref=\'builddecision\' --head-rev=\'1b3e34f489292c71c819ef3ffaf15d1a8070a9f7\' ${TRY_TASK_CONFIG_FILE+--try-task-config-file="${TRY_TASK_CONFIG_FILE}"} \n']
[task 2026-05-19T13:45:11.694+00:00] + ln -s /builds/worker/artifacts artifacts
[task 2026-05-19T13:45:11.695+00:00] + taskgraph decision --verbose --pushlog-id=0 --pushdate=0 --project=fxci-config --owner=jcristau@users.noreply.github.com --level=1 --repository-type=git --tasks-for=github-pull-request --base-repository=https://github.com/mozilla-releng/fxci-config --base-ref=main --base-rev=7824c177b59b7f4bc422555bc4d2691e76a04469 --head-repository=https://github.com/jcristau/fxci-config --head-ref=builddecision --head-rev=1b3e34f489292c71c819ef3ffaf15d1a8070a9f7
[task 2026-05-19T13:45:12.379+00:00] 2026-05-19 13:45:12,379 - INFO - Loading graph configuration.
[task 2026-05-19T13:45:12.379+00:00] 2026-05-19 13:45:12,379 - DEBUG - loading config from `taskcluster/config.yml`
[task 2026-05-19T13:45:12.388+00:00] 2026-05-19 13:45:12,388 - WARNING - using default project parameters; add fxci-config to PER_PROJECT_PARAMETERS in /usr/local/lib/python3.13/dist-packages/taskgraph/decision.py to customize behavior for this project
[task 2026-05-19T13:45:12.389+00:00] 2026-05-19 13:45:12,389 - INFO - Using Parameters(id=89c86a26dce2) (from defaults)
[task 2026-05-19T13:45:12.390+00:00] 2026-05-19 13:45:12,389 - DEBUG - Dumping parameters:
[task 2026-05-19T13:45:12.390+00:00] { 'base_ref': 'main',
[task 2026-05-19T13:45:12.390+00:00]   'base_repository': 'https://github.com/mozilla-releng/fxci-config',
[task 2026-05-19T13:45:12.390+00:00]   'base_rev': '7824c177b59b7f4bc422555bc4d2691e76a04469',
[task 2026-05-19T13:45:12.390+00:00]   'build_date': 1779198312,
[task 2026-05-19T13:45:12.390+00:00]   'build_number': 1,
[task 2026-05-19T13:45:12.390+00:00]   'do_not_optimize': [],
[task 2026-05-19T13:45:12.390+00:00]   'enable_always_target': True,
[task 2026-05-19T13:45:12.390+00:00]   'existing_tasks': {},
[task 2026-05-19T13:45:12.390+00:00]   'files_changed': ['clients.yml'],
[task 2026-05-19T13:45:12.390+00:00]   'filters': ['target_tasks_method'],
[task 2026-05-19T13:45:12.390+00:00]   'head_ref': 'builddecision',
[task 2026-05-19T13:45:12.390+00:00]   'head_repository': 'https://github.com/jcristau/fxci-config',
[task 2026-05-19T13:45:12.390+00:00]   'head_rev': '1b3e34f489292c71c819ef3ffaf15d1a8070a9f7',
[task 2026-05-19T13:45:12.390+00:00]   'head_tag': '',
[task 2026-05-19T13:45:12.390+00:00]   'level': '1',
[task 2026-05-19T13:45:12.390+00:00]   'moz_build_date': '20260519134512',
[task 2026-05-19T13:45:12.390+00:00]   'next_version': None,
[task 2026-05-19T13:45:12.390+00:00]   'optimize_strategies': None,
[task 2026-05-19T13:45:12.390+00:00]   'optimize_target_tasks': True,
[task 2026-05-19T13:45:12.390+00:00]   'owner': 'jcristau@users.noreply.github.com',
[task 2026-05-19T13:45:12.390+00:00]   'project': 'fxci-config',
[task 2026-05-19T13:45:12.390+00:00]   'pushdate': 0,
[task 2026-05-19T13:45:12.390+00:00]   'pushlog_id': '0',
[task 2026-05-19T13:45:12.390+00:00]   'repository_type': 'git',
[task 2026-05-19T13:45:12.390+00:00]   'target_tasks_method': 'default',
[task 2026-05-19T13:45:12.390+00:00]   'tasks_for': 'github-pull-request',
[task 2026-05-19T13:45:12.390+00:00]   'version': None}
[task 2026-05-19T13:45:12.390+00:00] 2026-05-19 13:45:12,390 - INFO - writing artifact file `parameters.yml`
[task 2026-05-19T13:45:12.400+00:00] 2026-05-19 13:45:12,400 - INFO - writing artifact file `actions.json`
[task 2026-05-19T13:45:12.401+00:00] 2026-05-19 13:45:12,401 - INFO - Loading kinds
[task 2026-05-19T13:45:12.401+00:00] 2026-05-19 13:45:12,401 - DEBUG - loading kind `integration-test` from `taskcluster/kinds/integration-test`
[task 2026-05-19T13:45:12.402+00:00] 2026-05-19 13:45:12,402 - DEBUG - loading kind `docker-image` from `taskcluster/kinds/docker-image`
[task 2026-05-19T13:45:12.402+00:00] 2026-05-19 13:45:12,402 - DEBUG - loading kind `tc-admin` from `taskcluster/kinds/tc-admin`
[task 2026-05-19T13:45:12.403+00:00] 2026-05-19 13:45:12,403 - DEBUG - loading kind `firefoxci-artifact` from `taskcluster/kinds/firefoxci-artifact`
[task 2026-05-19T13:45:12.404+00:00] 2026-05-19 13:45:12,404 - DEBUG - loading kind `tests` from `taskcluster/kinds/tests`
[task 2026-05-19T13:45:12.404+00:00] 2026-05-19 13:45:12,404 - INFO - Generating full task set
[task 2026-05-19T13:45:12.414+00:00] 2026-05-19 13:45:12,413 - DEBUG - Loading tasks for kind docker-image
[task 2026-05-19T13:45:12.414+00:00] 2026-05-19 13:45:12,413 - DEBUG - Loading tasks for kind tests
[task 2026-05-19T13:45:12.428+00:00] 2026-05-19 13:45:12,428 - DEBUG - Generating tasks for docker-image build-decision
[task 2026-05-19T13:45:12.430+00:00] 2026-05-19 13:45:12,430 - INFO - Writing docker-contexts/build-decision.tar.gz for docker image build-decision
[task 2026-05-19T13:45:12.451+00:00] 2026-05-19 13:45:12,451 - DEBUG - Generating tasks for tests unit-ciadmin
[task 2026-05-19T13:45:12.453+00:00] 2026-05-19 13:45:12,453 - DEBUG - Generating tasks for tests unit-build-decision
[task 2026-05-19T13:45:12.454+00:00] 2026-05-19 13:45:12,454 - DEBUG - Generating tasks for tests unit-fxci-config-taskgraph
[task 2026-05-19T13:45:12.458+00:00] 2026-05-19 13:45:12,458 - INFO - Generated 3 tasks for kind tests
[task 2026-05-19T13:45:12.460+00:00] 2026-05-19 13:45:12,460 - DEBUG - Loading tasks for kind firefoxci-artifact
[task 2026-05-19T13:45:12.467+00:00] 2026-05-19 13:45:12,467 - INFO - Generated 0 tasks for kind firefoxci-artifact
[task 2026-05-19T13:45:12.468+00:00] 2026-05-19 13:45:12,468 - DEBUG - Loading tasks for kind tc-admin
[task 2026-05-19T13:45:12.468+00:00] 2026-05-19 13:45:12,468 - DEBUG - Generating tasks for docker-image python
[task 2026-05-19T13:45:12.469+00:00] 2026-05-19 13:45:12,468 - INFO - Writing docker-contexts/python.tar.gz for docker image python
[task 2026-05-19T13:45:12.471+00:00] 2026-05-19 13:45:12,471 - DEBUG - Generating tasks for tc-admin apply-staging
[task 2026-05-19T13:45:12.472+00:00] 2026-05-19 13:45:12,472 - INFO - Generated 1 tasks for kind tc-admin
[task 2026-05-19T13:45:12.474+00:00] 2026-05-19 13:45:12,474 - DEBUG - Loading tasks for kind integration-test
[task 2026-05-19T13:45:12.480+00:00] 2026-05-19 13:45:12,480 - INFO - Generated 0 tasks for kind integration-test
[task 2026-05-19T13:45:12.490+00:00] 2026-05-19 13:45:12,490 - INFO - Generated 2 tasks for kind docker-image
[task 2026-05-19T13:45:12.494+00:00] 2026-05-19 13:45:12,494 - INFO - Generating full task graph
[task 2026-05-19T13:45:12.494+00:00] 2026-05-19 13:45:12,494 - INFO - Full task graph contains 6 tasks and 4 dependencies
[task 2026-05-19T13:45:12.495+00:00] 2026-05-19 13:45:12,495 - INFO - writing artifact file `full-task-graph.json`
[task 2026-05-19T13:45:12.496+00:00] 2026-05-19 13:45:12,496 - INFO - writing artifact file `runnable-jobs.json`
[task 2026-05-19T13:45:12.496+00:00] 2026-05-19 13:45:12,496 - INFO - Generating target task set
[task 2026-05-19T13:45:12.496+00:00] 2026-05-19 13:45:12,496 - INFO - Filter filter_target_tasks pruned 3 tasks (3 remain)
[task 2026-05-19T13:45:12.497+00:00] 2026-05-19 13:45:12,496 - INFO - writing artifact file `target-tasks.json`
[task 2026-05-19T13:45:12.497+00:00] 2026-05-19 13:45:12,497 - INFO - Generating target task graph
[task 2026-05-19T13:45:12.497+00:00] 2026-05-19 13:45:12,497 - INFO - Adding 2 tasks with `always_target` attribute
[task 2026-05-19T13:45:12.497+00:00] 2026-05-19 13:45:12,497 - INFO - Generating optimized task graph
[task 2026-05-19T13:45:12.498+00:00] 2026-05-19 13:45:12,498 - DEBUG - no files found matching a pattern in `skip-unless-changed` for "tests-unit-fxci-config-taskgraph"
[task 2026-05-19T13:45:12.499+00:00] 2026-05-19 13:45:12,499 - DEBUG - no files found matching a pattern in `skip-unless-changed` for "tests-unit-build-decision"
[task 2026-05-19T13:45:12.499+00:00] 2026-05-19 13:45:12,499 - DEBUG - optimize: tests-unit-fxci-config-taskgraph removed because of skip-unless-changed (skip-unless-changed)
[task 2026-05-19T13:45:12.500+00:00] 2026-05-19 13:45:12,499 - DEBUG - optimize: tests-unit-ciadmin kept because of never
[task 2026-05-19T13:45:12.501+00:00] 2026-05-19 13:45:12,499 - DEBUG - optimize: tests-unit-build-decision removed because of skip-unless-changed (skip-unless-changed)
[task 2026-05-19T13:45:12.501+00:00] 2026-05-19 13:45:12,499 - DEBUG - optimize: docker-image-build-decision kept because of index-search (index-search)
[task 2026-05-19T13:45:12.502+00:00] 2026-05-19 13:45:12,499 - DEBUG - optimize: docker-image-python kept because of dependent tasks
[task 2026-05-19T13:45:12.503+00:00] 2026-05-19 13:45:12,499 - INFO - Removed 2 tasks by skip-unless-changed (skip-unless-changed) during optimization.
[task 2026-05-19T13:45:12.503+00:00] 2026-05-19 13:45:12,499 - DEBUG - credentials key scrubbed from logging output
[task 2026-05-19T13:45:12.504+00:00] 2026-05-19 13:45:12,499 - DEBUG - {'rootUrl': 'http://172.17.0.1:80', 'maxRetries': 5, 'signedUrlExpiration': 900}
[task 2026-05-19T13:45:12.504+00:00] 2026-05-19 13:45:12,500 - DEBUG - Using method(payload=payload, query=query, params={k1: v1, k2: v2}) calling convention
[task 2026-05-19T13:45:12.504+00:00] 2026-05-19 13:45:12,500 - DEBUG - After processing positional arguments, we have: {}
[task 2026-05-19T13:45:12.504+00:00] 2026-05-19 13:45:12,500 - DEBUG - After keyword arguments, we have: {}
[task 2026-05-19T13:45:12.504+00:00] 2026-05-19 13:45:12,500 - DEBUG - Full URL used is: http://172.17.0.1:80/api/index/v1/tasks/indexes
[task 2026-05-19T13:45:12.504+00:00] 2026-05-19 13:45:12,500 - DEBUG - Not using hawk!
[task 2026-05-19T13:45:12.504+00:00] 2026-05-19 13:45:12,500 - DEBUG - Making attempt 0
[task 2026-05-19T13:45:12.504+00:00] 2026-05-19 13:45:12,500 - DEBUG - Making a POST request to http://172.17.0.1:80/api/index/v1/tasks/indexes
[task 2026-05-19T13:45:12.504+00:00] 2026-05-19 13:45:12,500 - DEBUG - HTTP Headers: {'Content-Type': 'application/json'}
[task 2026-05-19T13:45:12.504+00:00] 2026-05-19 13:45:12,500 - DEBUG - HTTP Payload: {"indexes":["releng.cache.level-2.docker-images.v2.python.hash.57583670e00e75ee99de844947a1198a385dd (limit 100 char)
[task 2026-05-19T13:45:12.504+00:00] 2026-05-19 13:45:12,503 - DEBUG - Starting new HTTP connection (1): 172.17.0.1:80
[task 2026-05-19T13:45:12.756+00:00] 2026-05-19 13:45:12,756 - DEBUG - http://172.17.0.1:80 "POST /api/index/v1/tasks/indexes HTTP/1.1" 200 835
[task 2026-05-19T13:45:12.757+00:00] 2026-05-19 13:45:12,757 - DEBUG - Received HTTP Status:    200
[task 2026-05-19T13:45:12.757+00:00] 2026-05-19 13:45:12,757 - DEBUG - Received HTTP Headers: {'Accept-Ranges': 'bytes', 'Access-Control-Allow-Headers': 'X-Requested-With,Content-Type,Authorization,Accept,Origin,Cache-Control', 'Access-Control-Allow-Methods': 'OPTIONS,GET,HEAD,POST,PUT,DELETE,TRACE,CONNECT', 'Access-Control-Allow-Origin': '*', 'Access-Control-Max-Age': '900', 'Access-Control-Request-Method': '*', 'Cache-Control': 'no-store no-cache must-revalidate', 'Content-Length': '835', 'Content-Security-Policy': "report-uri /__cspreport__;default-src 'none';frame-ancestors 'none';", 'Content-Type': 'application/json; charset=utf-8', 'Date': 'Tue, 19 May 2026 13:45:12 GMT', 'Etag': 'W/"343-srBnl37xwvnCuHBGdWULMsaF+SQ"', 'Server': 'openresty', 'Strict-Transport-Security': 'max-age=31536000', 'Vary': 'Accept-Encoding', 'Via': '1.1 google, 1.1 varnish, 1.1 varnish', 'X-Cache': 'MISS, MISS', 'X-Cache-Hits': '0, 0', 'X-Content-Type-Options': 'nosniff', 'X-For-Request-Id': 'd345f1ae-580e-4bbe-857c-61ab6eeb69c2', 'X-For-Trace-Id': '74dd14b21c95c61c697efefbd767b2b8', 'X-Served-By': 'cache-chi-kigq8000058-CHI, cache-chi-kigq8000142-CHI', 'X-Taskcluster-Authorized-Scopes': '["assume:repo:github.com/mozilla-releng/fxci-config:pull-request","queue:create-artifact:Dn1qVe8wQoqbM7mR2EJbgw/0"]', 'X-Taskcluster-Endpoint': 'https://firefox-ci-tc.services.mozilla.com/api/index/v1/tasks/indexes', 'X-Taskcluster-Proxy-Revision': 'ddb9ce7efdb98ae2d0917b69778e9f3cd125e07f', 'X-Taskcluster-Proxy-Temp-Clientid': 'task-client/Dn1qVe8wQoqbM7mR2EJbgw/0/on/us-central1-a/3215052571939035115/until/1779199494.836', 'X-Taskcluster-Proxy-Temp-Scopes': '["queue:reclaim-task:Dn1qVe8wQoqbM7mR2EJbgw/0","queue:resolve-task:Dn1qVe8wQoqbM7mR2EJbgw/0","queue:create-artifact:Dn1qVe8wQoqbM7mR2EJbgw/0","assume:repo:github.com/mozilla-releng/fxci-config:pull-request"]', 'X-Taskcluster-Proxy-Version': '99.2.1', 'X-Timer': 'S1779198313.605439,VS0,VE148'}
[task 2026-05-19T13:45:12.758+00:00] 2026-05-19 13:45:12,758 - DEBUG - credentials key scrubbed from logging output
[task 2026-05-19T13:45:12.758+00:00] 2026-05-19 13:45:12,758 - DEBUG - {'rootUrl': 'http://172.17.0.1:80', 'maxRetries': 5, 'signedUrlExpiration': 900}
[task 2026-05-19T13:45:12.759+00:00] 2026-05-19 13:45:12,759 - DEBUG - Using method(payload=payload, query=query, params={k1: v1, k2: v2}) calling convention
[task 2026-05-19T13:45:12.759+00:00] 2026-05-19 13:45:12,759 - DEBUG - After processing positional arguments, we have: {}
[task 2026-05-19T13:45:12.759+00:00] 2026-05-19 13:45:12,759 - DEBUG - After keyword arguments, we have: {}
[task 2026-05-19T13:45:12.759+00:00] 2026-05-19 13:45:12,759 - DEBUG - Full URL used is: http://172.17.0.1:80/api/queue/v1/tasks/status
[task 2026-05-19T13:45:12.759+00:00] 2026-05-19 13:45:12,759 - DEBUG - Not using hawk!
[task 2026-05-19T13:45:12.759+00:00] 2026-05-19 13:45:12,759 - DEBUG - Making attempt 0
[task 2026-05-19T13:45:12.760+00:00] 2026-05-19 13:45:12,759 - DEBUG - Making a POST request to http://172.17.0.1:80/api/queue/v1/tasks/status
[task 2026-05-19T13:45:12.760+00:00] 2026-05-19 13:45:12,760 - DEBUG - HTTP Headers: {'Content-Type': 'application/json'}
[task 2026-05-19T13:45:12.760+00:00] 2026-05-19 13:45:12,760 - DEBUG - HTTP Payload: {"taskIds":["LchX1OWMQeO6IVn3-C-6Ew","PPQfQs7SSiCd9po0IlEBqQ","f19j-YroQ5KALSuc6Jm-dw"]} (limit 100 char)
[task 2026-05-19T13:45:12.761+00:00] 2026-05-19 13:45:12,761 - DEBUG - Starting new HTTP connection (1): 172.17.0.1:80
[task 2026-05-19T13:45:12.916+00:00] 2026-05-19 13:45:12,916 - DEBUG - http://172.17.0.1:80 "POST /api/queue/v1/tasks/status HTTP/1.1" 200 813
[task 2026-05-19T13:45:12.917+00:00] 2026-05-19 13:45:12,917 - DEBUG - Received HTTP Status:    200
[task 2026-05-19T13:45:12.917+00:00] 2026-05-19 13:45:12,917 - DEBUG - Received HTTP Headers: {'Accept-Ranges': 'bytes', 'Access-Control-Allow-Headers': 'X-Requested-With,Content-Type,Authorization,Accept,Origin,Cache-Control', 'Access-Control-Allow-Methods': 'OPTIONS,GET,HEAD,POST,PUT,DELETE,TRACE,CONNECT', 'Access-Control-Allow-Origin': '*', 'Access-Control-Max-Age': '900', 'Access-Control-Request-Method': '*', 'Cache-Control': 'no-store no-cache must-revalidate', 'Content-Encoding': 'gzip', 'Content-Security-Policy': "report-uri /__cspreport__;default-src 'none';frame-ancestors 'none';", 'Content-Type': 'application/json; charset=utf-8', 'Date': 'Tue, 19 May 2026 13:45:12 GMT', 'Etag': 'W/"c40-C9sSMssl3QX3L5rNexu4xGCY9q8"', 'Server': 'openresty', 'Strict-Transport-Security': 'max-age=31536000', 'Vary': 'Accept-Encoding', 'Via': '1.1 google, 1.1 varnish, 1.1 varnish', 'X-Cache': 'MISS, MISS', 'X-Cache-Hits': '0, 0', 'X-Content-Type-Options': 'nosniff', 'X-For-Request-Id': 'a65a14a6-3b12-4ea0-af49-ff08f0b9b288', 'X-For-Trace-Id': 'bc9274ccce99b22133f75f89f6866b65', 'X-Served-By': 'cache-chi-kigq8000155-CHI, cache-chi-kigq8000142-CHI', 'X-Taskcluster-Authorized-Scopes': '["assume:repo:github.com/mozilla-releng/fxci-config:pull-request","queue:create-artifact:Dn1qVe8wQoqbM7mR2EJbgw/0"]', 'X-Taskcluster-Endpoint': 'https://firefox-ci-tc.services.mozilla.com/api/queue/v1/tasks/status', 'X-Taskcluster-Proxy-Revision': 'ddb9ce7efdb98ae2d0917b69778e9f3cd125e07f', 'X-Taskcluster-Proxy-Temp-Clientid': 'task-client/Dn1qVe8wQoqbM7mR2EJbgw/0/on/us-central1-a/3215052571939035115/until/1779199494.836', 'X-Taskcluster-Proxy-Temp-Scopes': '["queue:reclaim-task:Dn1qVe8wQoqbM7mR2EJbgw/0","queue:resolve-task:Dn1qVe8wQoqbM7mR2EJbgw/0","queue:create-artifact:Dn1qVe8wQoqbM7mR2EJbgw/0","assume:repo:github.com/mozilla-releng/fxci-config:pull-request"]', 'X-Taskcluster-Proxy-Version': '99.2.1', 'X-Timer': 'S1779198313.771663,VS0,VE142', 'Content-Length': '813'}
[task 2026-05-19T13:45:12.918+00:00] 2026-05-19 13:45:12,917 - DEBUG - replace_tasks: docker-image-python
[task 2026-05-19T13:45:12.921+00:00] 2026-05-19 13:45:12,920 - DEBUG - replace_tasks: docker-image-python replaced with f19j-YroQ5KALSuc6Jm-dw by optimization strategy
[task 2026-05-19T13:45:12.921+00:00] 2026-05-19 13:45:12,921 - DEBUG - replace_tasks: docker-image-build-decision
[task 2026-05-19T13:45:12.922+00:00] 2026-05-19 13:45:12,921 - DEBUG - replace_tasks: docker-image-build-decision replaced with PPQfQs7SSiCd9po0IlEBqQ by optimization strategy
[task 2026-05-19T13:45:12.922+00:00] 2026-05-19 13:45:12,921 - DEBUG - replace_tasks: tests-unit-build-decision
[task 2026-05-19T13:45:12.923+00:00] 2026-05-19 13:45:12,921 - DEBUG - replace_tasks: tests-unit-build-decision kept by optimization strategy
[task 2026-05-19T13:45:12.923+00:00] 2026-05-19 13:45:12,921 - DEBUG - replace_tasks: tests-unit-fxci-config-taskgraph
[task 2026-05-19T13:45:12.924+00:00] 2026-05-19 13:45:12,921 - DEBUG - replace_tasks: tests-unit-fxci-config-taskgraph kept by optimization strategy
[task 2026-05-19T13:45:12.924+00:00] 2026-05-19 13:45:12,921 - DEBUG - replace_tasks: tests-unit-ciadmin
[task 2026-05-19T13:45:12.924+00:00] 2026-05-19 13:45:12,921 - DEBUG - replace_tasks: tests-unit-ciadmin kept by optimization strategy
[task 2026-05-19T13:45:12.925+00:00] 2026-05-19 13:45:12,921 - INFO - Replaced 2 tasks by index-search (index-search) during optimization.
[task 2026-05-19T13:45:12.925+00:00] 2026-05-19 13:45:12,921 - DEBUG - Morphing: adding index tasks
[task 2026-05-19T13:45:12.926+00:00] 2026-05-19 13:45:12,922 - DEBUG - Morphing: adding code review task
[task 2026-05-19T13:45:12.927+00:00] 2026-05-19 13:45:12,922 - INFO - writing artifact file `task-graph.json`
[task 2026-05-19T13:45:12.927+00:00] 2026-05-19 13:45:12,922 - INFO - writing artifact file `label-to-taskid.json`
[task 2026-05-19T13:45:12.927+00:00] 2026-05-19 13:45:12,924 - INFO - Creating task with taskId Q9hW5MJrRWeDQT34JSpKVw for tests-unit-ciadmin
[task 2026-05-19T13:45:12.927+00:00] 2026-05-19 13:45:12,924 - DEBUG - Using method(v1, v2, payload) calling convention
[task 2026-05-19T13:45:12.927+00:00] 2026-05-19 13:45:12,925 - DEBUG - Found a positional argument: Q9hW5MJrRWeDQT34JSpKVw
[task 2026-05-19T13:45:12.927+00:00] 2026-05-19 13:45:12,925 - DEBUG - After processing positional arguments, we have: {'taskId': 'Q9hW5MJrRWeDQT34JSpKVw'}
[task 2026-05-19T13:45:12.927+00:00] 2026-05-19 13:45:12,925 - DEBUG - After keyword arguments, we have: {'taskId': 'Q9hW5MJrRWeDQT34JSpKVw'}
[task 2026-05-19T13:45:12.927+00:00] 2026-05-19 13:45:12,925 - DEBUG - Full URL used is: http://172.17.0.1:80/api/queue/v1/task/Q9hW5MJrRWeDQT34JSpKVw
[task 2026-05-19T13:45:12.927+00:00] 2026-05-19 13:45:12,925 - DEBUG - Not using hawk!
[task 2026-05-19T13:45:12.927+00:00] 2026-05-19 13:45:12,925 - DEBUG - Making attempt 0
[task 2026-05-19T13:45:12.927+00:00] 2026-05-19 13:45:12,925 - DEBUG - Making a PUT request to http://172.17.0.1:80/api/queue/v1/task/Q9hW5MJrRWeDQT34JSpKVw
[task 2026-05-19T13:45:12.928+00:00] 2026-05-19 13:45:12,925 - DEBUG - HTTP Headers: {'Content-Type': 'application/json'}
[task 2026-05-19T13:45:12.928+00:00] 2026-05-19 13:45:12,925 - DEBUG - HTTP Payload: {"provisionerId":"releng-t","workerType":"linux-docker","routes":["checks"],"created":"2026-05-19T13 (limit 100 char)
[task 2026-05-19T13:45:12.928+00:00] 2026-05-19 13:45:12,926 - DEBUG - Starting new HTTP connection (1): 172.17.0.1:80
[task 2026-05-19T13:45:13.075+00:00] 2026-05-19 13:45:13,075 - DEBUG - http://172.17.0.1:80 "PUT /api/queue/v1/task/Q9hW5MJrRWeDQT34JSpKVw HTTP/1.1" 200 454
[task 2026-05-19T13:45:13.075+00:00] 2026-05-19 13:45:13,075 - DEBUG - Received HTTP Status:    200
[task 2026-05-19T13:45:13.076+00:00] 2026-05-19 13:45:13,076 - DEBUG - Received HTTP Headers: {'Accept-Ranges': 'bytes', 'Access-Control-Allow-Headers': 'X-Requested-With,Content-Type,Authorization,Accept,Origin,Cache-Control', 'Access-Control-Allow-Methods': 'OPTIONS,GET,HEAD,POST,PUT,DELETE,TRACE,CONNECT', 'Access-Control-Allow-Origin': '*', 'Access-Control-Max-Age': '900', 'Access-Control-Request-Method': '*', 'Cache-Control': 'no-store no-cache must-revalidate', 'Content-Length': '454', 'Content-Security-Policy': "report-uri /__cspreport__;default-src 'none';frame-ancestors 'none';", 'Content-Type': 'application/json; charset=utf-8', 'Date': 'Tue, 19 May 2026 13:45:13 GMT', 'Etag': 'W/"1c6-HvnbJP8fISueXTHqpMcNI0zA3Hw"', 'Server': 'openresty', 'Strict-Transport-Security': 'max-age=31536000', 'Vary': 'Accept-Encoding', 'Via': '1.1 google, 1.1 varnish, 1.1 varnish', 'X-Cache': 'MISS, MISS', 'X-Cache-Hits': '0, 0', 'X-Content-Type-Options': 'nosniff', 'X-For-Request-Id': '0a40347b-1036-45ff-a11a-8c8c505cda28', 'X-For-Trace-Id': '70ce2df68adb36a0f4cf95c73e67c49a', 'X-Served-By': 'cache-chi-kigq8000079-CHI, cache-chi-kigq8000142-CHI', 'X-Taskcluster-Authorized-Scopes': '["assume:repo:github.com/mozilla-releng/fxci-config:pull-request","queue:create-artifact:Dn1qVe8wQoqbM7mR2EJbgw/0"]', 'X-Taskcluster-Endpoint': 'https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/Q9hW5MJrRWeDQT34JSpKVw', 'X-Taskcluster-Proxy-Revision': 'ddb9ce7efdb98ae2d0917b69778e9f3cd125e07f', 'X-Taskcluster-Proxy-Temp-Clientid': 'task-client/Dn1qVe8wQoqbM7mR2EJbgw/0/on/us-central1-a/3215052571939035115/until/1779199494.836', 'X-Taskcluster-Proxy-Temp-Scopes': '["queue:reclaim-task:Dn1qVe8wQoqbM7mR2EJbgw/0","queue:resolve-task:Dn1qVe8wQoqbM7mR2EJbgw/0","queue:create-artifact:Dn1qVe8wQoqbM7mR2EJbgw/0","assume:repo:github.com/mozilla-releng/fxci-config:pull-request"]', 'X-Taskcluster-Proxy-Version': '99.2.1', 'X-Timer': 'S1779198313.938513,VS0,VE134'}
[taskcluster 2026-05-19T13:45:13.278Z]                        Exit Code: 0
[taskcluster 2026-05-19T13:45:13.278Z]                        User Time: 14.43ms
[taskcluster 2026-05-19T13:45:13.278Z]                      Kernel Time: 19.584ms
[taskcluster 2026-05-19T13:45:13.278Z]                        Wall Time: 6.573901952s
[taskcluster 2026-05-19T13:45:13.278Z]  Average Available System Memory: 6.89 GiB
[taskcluster 2026-05-19T13:45:13.278Z]       Average System Memory Used: 885.45 MiB
[taskcluster 2026-05-19T13:45:13.278Z]          Peak System Memory Used: 899.80 MiB
[taskcluster 2026-05-19T13:45:13.278Z]              Total System Memory: 7.75 GiB
[taskcluster 2026-05-19T13:45:13.278Z]                           Result: SUCCEEDED
[taskcluster 2026-05-19T13:45:13.278Z] === Task Finished ===
[taskcluster 2026-05-19T13:45:13.278Z] Task Duration: 6.575760933s
[taskcluster 2026-05-19T13:45:14.891Z] [mounts] Preserving cache: Moving "/home/task_177919829357869/cache0" to "/home/generic-worker/caches/LVf-KP1XQN-95Xk1xRj5cQ"