[taskcluster 2026-01-14T09:30:10.553Z] Worker Type (releng-1/decision) settings:
[taskcluster 2026-01-14T09:30:10.554Z]   {
[taskcluster 2026-01-14T09:30:10.554Z]     "config": {
[taskcluster 2026-01-14T09:30:10.554Z]       "deploymentId": ""
[taskcluster 2026-01-14T09:30:10.554Z]     },
[taskcluster 2026-01-14T09:30:10.554Z]     "generic-worker": {
[taskcluster 2026-01-14T09:30:10.554Z]       "config": {
[taskcluster 2026-01-14T09:30:10.554Z]         "headlessTasks": true
[taskcluster 2026-01-14T09:30:10.554Z]       },
[taskcluster 2026-01-14T09:30:10.554Z]       "engine": "multiuser",
[taskcluster 2026-01-14T09:30:10.554Z]       "go-arch": "amd64",
[taskcluster 2026-01-14T09:30:10.554Z]       "go-os": "linux",
[taskcluster 2026-01-14T09:30:10.554Z]       "go-version": "go1.25.4",
[taskcluster 2026-01-14T09:30:10.554Z]       "release": "https://github.com/taskcluster/taskcluster/releases/tag/v93.1.2",
[taskcluster 2026-01-14T09:30:10.554Z]       "revision": "e954a7555fe32f7de69247759908749d1d670889",
[taskcluster 2026-01-14T09:30:10.554Z]       "source": "https://github.com/taskcluster/taskcluster/commits/e954a7555fe32f7de69247759908749d1d670889",
[taskcluster 2026-01-14T09:30:10.554Z]       "version": "93.1.2"
[taskcluster 2026-01-14T09:30:10.554Z]     },
[taskcluster 2026-01-14T09:30:10.554Z]     "image": "projects/taskcluster-imaging/global/images/gw-fxci-gcp-l1-2404-amd64-headless-googlecompute-2025-11-14",
[taskcluster 2026-01-14T09:30:10.554Z]     "instance-id": "4917784410801757929",

...(32 lines hidden)...

[vcs 2026-01-14T09:30:22.880+00:00]  * branch            588d3982ae6d88a2340af72439ad1b8749a63550 -> FETCH_HEAD
[vcs 2026-01-14T09:30:22.882+00:00] executing ['git', 'fetch', '--tags', '--force', 'https://github.com/jcristau/fxci-config', 'batched-task-defs']
[vcs 2026-01-14T09:30:23.054+00:00] From https://github.com/jcristau/fxci-config
[vcs 2026-01-14T09:30:23.054+00:00]  * branch            batched-task-defs -> FETCH_HEAD
[vcs 2026-01-14T09:30:23.059+00:00] executing ['git', 'checkout', '-f', '-B', 'batched-task-defs', '75ec1042f036fcbf438de447fb163de3b48825e4']
[vcs 2026-01-14T09:30:23.072+00:00] Switched to a new branch 'batched-task-defs'
[vcs 2026-01-14T09:30:23.073+00:00] cleaning git checkout...
[vcs 2026-01-14T09:30:23.073+00:00] executing ['git', 'clean', '-nxdff']
[vcs 2026-01-14T09:30:23.075+00:00] removing []
[vcs 2026-01-14T09:30:23.075+00:00] successfully cleaned git checkout!
[vcs 2026-01-14T09:30:23.077+00:00] TinderboxPrint:<a href='https://github.com/jcristau/fxci-config/commit/75ec1042f036fcbf438de447fb163de3b48825e4' title='Built from fxci-config commit 75ec1042f036fcbf438de447fb163de3b48825e4'>75ec1042f036fcbf438de447fb163de3b48825e4</a>
[task 2026-01-14T09:30:23.077+00:00] executing ['bash', '-cx', 'ln -s /builds/worker/artifacts artifacts && taskgraph decision --verbose --pushlog-id=\'0\' --pushdate=\'0\' --project=\'fxci-config\' --owner=\'[email protected]\' --level=\'1\' --repository-type=git --tasks-for=\'github-pull-request\' --base-repository=\'https://github.com/mozilla-releng/fxci-config\' --base-ref=\'main\' --base-rev=\'588d3982ae6d88a2340af72439ad1b8749a63550\' --head-repository=\'https://github.com/jcristau/fxci-config\' --head-ref=\'batched-task-defs\' --head-rev=\'75ec1042f036fcbf438de447fb163de3b48825e4\' ${TRY_TASK_CONFIG_FILE+--try-task-config-file="${TRY_TASK_CONFIG_FILE}"} \n']
[task 2026-01-14T09:30:23.079+00:00] + ln -s /builds/worker/artifacts artifacts
[task 2026-01-14T09:30:23.080+00:00] + taskgraph decision --verbose --pushlog-id=0 --pushdate=0 --project=fxci-config [email protected] --level=1 --repository-type=git --tasks-for=github-pull-request --base-repository=https://github.com/mozilla-releng/fxci-config --base-ref=main --base-rev=588d3982ae6d88a2340af72439ad1b8749a63550 --head-repository=https://github.com/jcristau/fxci-config --head-ref=batched-task-defs --head-rev=75ec1042f036fcbf438de447fb163de3b48825e4
[task 2026-01-14T09:30:23.561+00:00] 2026-01-14 09:30:23,561 - INFO - Loading graph configuration.
[task 2026-01-14T09:30:23.561+00:00] 2026-01-14 09:30:23,561 - DEBUG - loading config from `taskcluster/config.yml`
[task 2026-01-14T09:30:23.568+00:00] 2026-01-14 09:30:23,568 - 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 2026-01-14T09:30:23.569+00:00] 2026-01-14 09:30:23,569 - INFO - Using Parameters(id=db15bd2fc3ec) (from defaults)
[task 2026-01-14T09:30:23.569+00:00] 2026-01-14 09:30:23,569 - DEBUG - Dumping parameters:
[task 2026-01-14T09:30:23.569+00:00] { 'base_ref': 'main',
[task 2026-01-14T09:30:23.569+00:00]   'base_repository': 'https://github.com/mozilla-releng/fxci-config',
[task 2026-01-14T09:30:23.569+00:00]   'base_rev': '588d3982ae6d88a2340af72439ad1b8749a63550',
[task 2026-01-14T09:30:23.569+00:00]   'build_date': 1768383023,
[task 2026-01-14T09:30:23.569+00:00]   'build_number': 1,
[task 2026-01-14T09:30:23.569+00:00]   'do_not_optimize': [],
[task 2026-01-14T09:30:23.569+00:00]   'enable_always_target': True,
[task 2026-01-14T09:30:23.569+00:00]   'existing_tasks': {},
[task 2026-01-14T09:30:23.569+00:00]   'files_changed': [ 'taskcluster/test/test_transforms_firefoxci_artifact.py',
[task 2026-01-14T09:30:23.569+00:00]                      'taskcluster/test/test_transforms_integration_test.py',
[task 2026-01-14T09:30:23.570+00:00]                      '.taskcluster.yml',
[task 2026-01-14T09:30:23.570+00:00]                      'pyproject.toml',
[task 2026-01-14T09:30:23.570+00:00]                      'taskcluster/fxci_config_taskgraph/util/integration.py',
[task 2026-01-14T09:30:23.570+00:00]                      'taskcluster/test/test_transforms_firefoxci_artifact.py',
[task 2026-01-14T09:30:23.570+00:00]                      'taskcluster/test/test_transforms_integration_test.py',
[task 2026-01-14T09:30:23.570+00:00]                      'uv.lock'],
[task 2026-01-14T09:30:23.570+00:00]   'filters': ['target_tasks_method'],
[task 2026-01-14T09:30:23.570+00:00]   'head_ref': 'batched-task-defs',
[task 2026-01-14T09:30:23.570+00:00]   'head_repository': 'https://github.com/jcristau/fxci-config',
[task 2026-01-14T09:30:23.570+00:00]   'head_rev': '75ec1042f036fcbf438de447fb163de3b48825e4',
[task 2026-01-14T09:30:23.570+00:00]   'head_tag': '',
[task 2026-01-14T09:30:23.570+00:00]   'level': '1',
[task 2026-01-14T09:30:23.570+00:00]   'moz_build_date': '20260114093023',
[task 2026-01-14T09:30:23.570+00:00]   'next_version': None,
[task 2026-01-14T09:30:23.570+00:00]   'optimize_strategies': None,
[task 2026-01-14T09:30:23.570+00:00]   'optimize_target_tasks': True,
[task 2026-01-14T09:30:23.570+00:00]   'owner': '[email protected]',
[task 2026-01-14T09:30:23.570+00:00]   'project': 'fxci-config',
[task 2026-01-14T09:30:23.570+00:00]   'pushdate': 0,
[task 2026-01-14T09:30:23.570+00:00]   'pushlog_id': '0',
[task 2026-01-14T09:30:23.570+00:00]   'repository_type': 'git',
[task 2026-01-14T09:30:23.570+00:00]   'target_tasks_method': 'default',
[task 2026-01-14T09:30:23.570+00:00]   'tasks_for': 'github-pull-request',
[task 2026-01-14T09:30:23.570+00:00]   'version': None}
[task 2026-01-14T09:30:23.570+00:00] 2026-01-14 09:30:23,569 - INFO - writing artifact file `parameters.yml`
[task 2026-01-14T09:30:23.579+00:00] 2026-01-14 09:30:23,579 - INFO - writing artifact file `actions.json`
[task 2026-01-14T09:30:23.579+00:00] 2026-01-14 09:30:23,579 - INFO - Loading kinds
[task 2026-01-14T09:30:23.579+00:00] 2026-01-14 09:30:23,579 - DEBUG - loading kind `tests` from `taskcluster/kinds/tests`
[task 2026-01-14T09:30:23.580+00:00] 2026-01-14 09:30:23,580 - DEBUG - loading kind `tc-admin` from `taskcluster/kinds/tc-admin`
[task 2026-01-14T09:30:23.580+00:00] 2026-01-14 09:30:23,580 - DEBUG - loading kind `integration-test` from `taskcluster/kinds/integration-test`
[task 2026-01-14T09:30:23.581+00:00] 2026-01-14 09:30:23,581 - DEBUG - loading kind `firefoxci-artifact` from `taskcluster/kinds/firefoxci-artifact`
[task 2026-01-14T09:30:23.581+00:00] 2026-01-14 09:30:23,581 - DEBUG - loading kind `docker-image` from `taskcluster/kinds/docker-image`
[task 2026-01-14T09:30:23.582+00:00] 2026-01-14 09:30:23,582 - INFO - Generating full task set
[task 2026-01-14T09:30:23.589+00:00] 2026-01-14 09:30:23,588 - DEBUG - Loading tasks for kind firefoxci-artifact
[task 2026-01-14T09:30:23.592+00:00] 2026-01-14 09:30:23,590 - DEBUG - Loading tasks for kind tc-admin
[task 2026-01-14T09:30:23.619+00:00] 2026-01-14 09:30:23,619 - DEBUG - Generating tasks for tc-admin apply-staging
[task 2026-01-14T09:30:23.622+00:00] 2026-01-14 09:30:23,622 - INFO - Generated 1 tasks for kind tc-admin
[task 2026-01-14T09:30:23.623+00:00] 2026-01-14 09:30:23,623 - INFO - Generated 0 tasks for kind firefoxci-artifact
[task 2026-01-14T09:30:23.623+00:00] 2026-01-14 09:30:23,623 - DEBUG - Loading tasks for kind tests
[task 2026-01-14T09:30:23.624+00:00] 2026-01-14 09:30:23,623 - DEBUG - Loading tasks for kind docker-image
[task 2026-01-14T09:30:23.626+00:00] 2026-01-14 09:30:23,626 - DEBUG - Generating tasks for tests unit-ciadmin
[task 2026-01-14T09:30:23.626+00:00] 2026-01-14 09:30:23,626 - DEBUG - Generating tasks for tests unit-build-decision
[task 2026-01-14T09:30:23.627+00:00] 2026-01-14 09:30:23,627 - DEBUG - Generating tasks for tests unit-fxci-config-taskgraph
[task 2026-01-14T09:30:23.629+00:00] 2026-01-14 09:30:23,629 - DEBUG - Generating tasks for docker-image build-decision
[task 2026-01-14T09:30:23.630+00:00] 2026-01-14 09:30:23,630 - INFO - Writing docker-contexts/build-decision.tar.gz for docker image build-decision
[task 2026-01-14T09:30:23.631+00:00] 2026-01-14 09:30:23,631 - INFO - Generated 3 tasks for kind tests
[task 2026-01-14T09:30:23.632+00:00] 2026-01-14 09:30:23,632 - DEBUG - Loading tasks for kind integration-test
[task 2026-01-14T09:30:23.636+00:00] 2026-01-14 09:30:23,636 - INFO - Generated 0 tasks for kind integration-test
[task 2026-01-14T09:30:23.653+00:00] 2026-01-14 09:30:23,653 - DEBUG - Generating tasks for docker-image python
[task 2026-01-14T09:30:23.654+00:00] 2026-01-14 09:30:23,653 - INFO - Writing docker-contexts/python.tar.gz for docker image python
[task 2026-01-14T09:30:23.671+00:00] 2026-01-14 09:30:23,671 - INFO - Generated 2 tasks for kind docker-image
[task 2026-01-14T09:30:23.674+00:00] 2026-01-14 09:30:23,674 - INFO - Generating full task graph
[task 2026-01-14T09:30:23.675+00:00] 2026-01-14 09:30:23,674 - INFO - Full task graph contains 6 tasks and 4 dependencies
[task 2026-01-14T09:30:23.676+00:00] 2026-01-14 09:30:23,676 - INFO - writing artifact file `full-task-graph.json`
[task 2026-01-14T09:30:23.676+00:00] 2026-01-14 09:30:23,676 - INFO - writing artifact file `runnable-jobs.json`
[task 2026-01-14T09:30:23.677+00:00] 2026-01-14 09:30:23,677 - INFO - Generating target task set
[task 2026-01-14T09:30:23.677+00:00] 2026-01-14 09:30:23,677 - INFO - Filter filter_target_tasks pruned 3 tasks (3 remain)
[task 2026-01-14T09:30:23.677+00:00] 2026-01-14 09:30:23,677 - INFO - writing artifact file `target-tasks.json`
[task 2026-01-14T09:30:23.677+00:00] 2026-01-14 09:30:23,677 - INFO - Generating target task graph
[task 2026-01-14T09:30:23.677+00:00] 2026-01-14 09:30:23,677 - INFO - Adding 2 tasks with `always_target` attribute
[task 2026-01-14T09:30:23.678+00:00] 2026-01-14 09:30:23,678 - INFO - Generating optimized task graph
[task 2026-01-14T09:30:23.678+00:00] 2026-01-14 09:30:23,678 - DEBUG - no files found matching a pattern in `skip-unless-changed` for "tests-unit-build-decision"
[task 2026-01-14T09:30:23.679+00:00] 2026-01-14 09:30:23,679 - DEBUG - optimize: tests-unit-build-decision removed because of skip-unless-changed (skip-unless-changed)
[task 2026-01-14T09:30:23.679+00:00] 2026-01-14 09:30:23,679 - DEBUG - optimize: docker-image-build-decision kept because of index-search (index-search)
[task 2026-01-14T09:30:23.679+00:00] 2026-01-14 09:30:23,679 - DEBUG - optimize: tests-unit-fxci-config-taskgraph kept because of skip-unless-changed (skip-unless-changed)
[task 2026-01-14T09:30:23.679+00:00] 2026-01-14 09:30:23,679 - DEBUG - optimize: tests-unit-ciadmin kept because of never
[task 2026-01-14T09:30:23.679+00:00] 2026-01-14 09:30:23,679 - DEBUG - optimize: docker-image-python kept because of dependent tasks
[task 2026-01-14T09:30:23.679+00:00] 2026-01-14 09:30:23,679 - INFO - Removed 1 tasks by skip-unless-changed (skip-unless-changed) during optimization.
[task 2026-01-14T09:30:23.680+00:00] 2026-01-14 09:30:23,680 - DEBUG - credentials key scrubbed from logging output
[task 2026-01-14T09:30:23.680+00:00] 2026-01-14 09:30:23,680 - DEBUG - {'rootUrl': 'http://172.17.0.1:80', 'maxRetries': 5, 'signedUrlExpiration': 900}
[task 2026-01-14T09:30:23.680+00:00] 2026-01-14 09:30:23,680 - DEBUG - Using method(payload=payload, query=query, params={k1: v1, k2: v2}) calling convention
[task 2026-01-14T09:30:23.680+00:00] 2026-01-14 09:30:23,680 - DEBUG - After processing positional arguments, we have: {}
[task 2026-01-14T09:30:23.681+00:00] 2026-01-14 09:30:23,680 - DEBUG - After keyword arguments, we have: {}
[task 2026-01-14T09:30:23.681+00:00] 2026-01-14 09:30:23,681 - DEBUG - Full URL used is: http://172.17.0.1:80/api/index/v1/tasks/indexes
[task 2026-01-14T09:30:23.681+00:00] 2026-01-14 09:30:23,681 - DEBUG - Not using hawk!
[task 2026-01-14T09:30:23.682+00:00] 2026-01-14 09:30:23,681 - DEBUG - Making attempt 0
[task 2026-01-14T09:30:23.682+00:00] 2026-01-14 09:30:23,681 - DEBUG - Making a POST request to http://172.17.0.1:80/api/index/v1/tasks/indexes
[task 2026-01-14T09:30:23.682+00:00] 2026-01-14 09:30:23,681 - DEBUG - HTTP Headers: {'Content-Type': 'application/json'}
[task 2026-01-14T09:30:23.683+00:00] 2026-01-14 09:30:23,681 - DEBUG - HTTP Payload: {"indexes":["releng.cache.pr.docker-images.v2.build-decision.hash.4d482d54610b48dd5edd68eb617fcd6fde (limit 100 char)
[task 2026-01-14T09:30:23.685+00:00] 2026-01-14 09:30:23,684 - DEBUG - Starting new HTTP connection (1): 172.17.0.1:80
[task 2026-01-14T09:30:23.847+00:00] 2026-01-14 09:30:23,847 - DEBUG - http://172.17.0.1:80 "POST /api/index/v1/tasks/indexes HTTP/1.1" 200 290
[task 2026-01-14T09:30:23.848+00:00] 2026-01-14 09:30:23,848 - DEBUG - Received HTTP Status:    200
[task 2026-01-14T09:30:23.848+00:00] 2026-01-14 09:30:23,848 - 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': '290', 'Content-Security-Policy': "report-uri /__cspreport__;default-src 'none';frame-ancestors 'none';", 'Content-Type': 'application/json; charset=utf-8', 'Date': 'Wed, 14 Jan 2026 09:30:23 GMT', 'Etag': 'W/"122-XIcZkedghTXrxXm17E6Nv6J2dH4"', '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': '9f6953da-d87c-4c0e-a25f-4cb69e78206c', 'X-For-Trace-Id': '403859c6c58029ede47fc305391e9adb', 'X-Served-By': 'cache-chi-kigq8000036-CHI, cache-chi-kigq8000150-CHI', 'X-Taskcluster-Authorized-Scopes': '["assume:repo:github.com/mozilla-releng/fxci-config:pull-request","queue:create-artifact:SwHTPAwQSLS4QCMMjQ4P5g/0"]', 'X-Taskcluster-Endpoint': 'https://firefox-ci-tc.services.mozilla.com/api/index/v1/tasks/indexes', 'X-Taskcluster-Proxy-Revision': 'e954a7555fe32f7de69247759908749d1d670889', 'X-Taskcluster-Proxy-Temp-Clientid': 'task-client/SwHTPAwQSLS4QCMMjQ4P5g/0/on/us-central1-f/4917784410801757929/until/1768384210.465', 'X-Taskcluster-Proxy-Temp-Scopes': '["queue:reclaim-task:SwHTPAwQSLS4QCMMjQ4P5g/0","queue:resolve-task:SwHTPAwQSLS4QCMMjQ4P5g/0","queue:create-artifact:SwHTPAwQSLS4QCMMjQ4P5g/0","assume:repo:github.com/mozilla-releng/fxci-config:pull-request"]', 'X-Taskcluster-Proxy-Version': '93.1.2', 'X-Timer': 'S1768383024.736537,VS0,VE105'}
[task 2026-01-14T09:30:23.849+00:00] 2026-01-14 09:30:23,848 - DEBUG - credentials key scrubbed from logging output
[task 2026-01-14T09:30:23.849+00:00] 2026-01-14 09:30:23,848 - DEBUG - {'rootUrl': 'http://172.17.0.1:80', 'maxRetries': 5, 'signedUrlExpiration': 900}
[task 2026-01-14T09:30:23.849+00:00] 2026-01-14 09:30:23,849 - DEBUG - Using method(payload=payload, query=query, params={k1: v1, k2: v2}) calling convention
[task 2026-01-14T09:30:23.849+00:00] 2026-01-14 09:30:23,849 - DEBUG - After processing positional arguments, we have: {}
[task 2026-01-14T09:30:23.849+00:00] 2026-01-14 09:30:23,849 - DEBUG - After keyword arguments, we have: {}
[task 2026-01-14T09:30:23.850+00:00] 2026-01-14 09:30:23,849 - DEBUG - Full URL used is: http://172.17.0.1:80/api/queue/v1/tasks/status
[task 2026-01-14T09:30:23.850+00:00] 2026-01-14 09:30:23,849 - DEBUG - Not using hawk!
[task 2026-01-14T09:30:23.850+00:00] 2026-01-14 09:30:23,849 - DEBUG - Making attempt 0
[task 2026-01-14T09:30:23.850+00:00] 2026-01-14 09:30:23,849 - DEBUG - Making a POST request to http://172.17.0.1:80/api/queue/v1/tasks/status
[task 2026-01-14T09:30:23.850+00:00] 2026-01-14 09:30:23,849 - DEBUG - HTTP Headers: {'Content-Type': 'application/json'}
[task 2026-01-14T09:30:23.851+00:00] 2026-01-14 09:30:23,849 - DEBUG - HTTP Payload: {"taskIds":["HVjeBp-KQpuNuUntl1Dgkg"]} (limit 100 char)
[task 2026-01-14T09:30:23.851+00:00] 2026-01-14 09:30:23,851 - DEBUG - Starting new HTTP connection (1): 172.17.0.1:80
[task 2026-01-14T09:30:23.969+00:00] 2026-01-14 09:30:23,969 - DEBUG - http://172.17.0.1:80 "POST /api/queue/v1/tasks/status HTTP/1.1" 200 1035
[task 2026-01-14T09:30:23.970+00:00] 2026-01-14 09:30:23,970 - DEBUG - Received HTTP Status:    200
[task 2026-01-14T09:30:23.970+00:00] 2026-01-14 09:30:23,970 - 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': '1035', 'Content-Security-Policy': "report-uri /__cspreport__;default-src 'none';frame-ancestors 'none';", 'Content-Type': 'application/json; charset=utf-8', 'Date': 'Wed, 14 Jan 2026 09:30:23 GMT', 'Etag': 'W/"40b-EdabPTBWQ5sckrKdeumILw6Ro50"', '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': 'e0bb5f2d-b924-4393-a70a-cc26370f957b', 'X-For-Trace-Id': '0debd3eed9ce7c115555fbbd2e614909', 'X-Served-By': 'cache-chi-kigq8000111-CHI, cache-chi-kigq8000150-CHI', 'X-Taskcluster-Authorized-Scopes': '["assume:repo:github.com/mozilla-releng/fxci-config:pull-request","queue:create-artifact:SwHTPAwQSLS4QCMMjQ4P5g/0"]', 'X-Taskcluster-Endpoint': 'https://firefox-ci-tc.services.mozilla.com/api/queue/v1/tasks/status', 'X-Taskcluster-Proxy-Revision': 'e954a7555fe32f7de69247759908749d1d670889', 'X-Taskcluster-Proxy-Temp-Clientid': 'task-client/SwHTPAwQSLS4QCMMjQ4P5g/0/on/us-central1-f/4917784410801757929/until/1768384210.465', 'X-Taskcluster-Proxy-Temp-Scopes': '["queue:reclaim-task:SwHTPAwQSLS4QCMMjQ4P5g/0","queue:resolve-task:SwHTPAwQSLS4QCMMjQ4P5g/0","queue:create-artifact:SwHTPAwQSLS4QCMMjQ4P5g/0","assume:repo:github.com/mozilla-releng/fxci-config:pull-request"]', 'X-Taskcluster-Proxy-Version': '93.1.2', 'X-Timer': 'S1768383024.857946,VS0,VE105'}
[task 2026-01-14T09:30:23.970+00:00] 2026-01-14 09:30:23,970 - DEBUG - replace_tasks: docker-image-python
[task 2026-01-14T09:30:23.972+00:00] 2026-01-14 09:30:23,972 - DEBUG - replace_tasks: docker-image-python replaced with HVjeBp-KQpuNuUntl1Dgkg by optimization strategy
[task 2026-01-14T09:30:23.972+00:00] 2026-01-14 09:30:23,972 - DEBUG - replace_tasks: docker-image-build-decision
[task 2026-01-14T09:30:23.973+00:00] 2026-01-14 09:30:23,973 - DEBUG - replace_tasks: docker-image-build-decision kept by optimization strategy
[task 2026-01-14T09:30:23.973+00:00] 2026-01-14 09:30:23,973 - DEBUG - replace_tasks: tests-unit-build-decision
[task 2026-01-14T09:30:23.973+00:00] 2026-01-14 09:30:23,973 - DEBUG - replace_tasks: tests-unit-build-decision kept by optimization strategy
[task 2026-01-14T09:30:23.973+00:00] 2026-01-14 09:30:23,973 - DEBUG - replace_tasks: tests-unit-fxci-config-taskgraph
[task 2026-01-14T09:30:23.973+00:00] 2026-01-14 09:30:23,973 - DEBUG - replace_tasks: tests-unit-fxci-config-taskgraph kept by optimization strategy
[task 2026-01-14T09:30:23.973+00:00] 2026-01-14 09:30:23,973 - DEBUG - replace_tasks: tests-unit-ciadmin
[task 2026-01-14T09:30:23.973+00:00] 2026-01-14 09:30:23,973 - DEBUG - replace_tasks: tests-unit-ciadmin kept by optimization strategy
[task 2026-01-14T09:30:23.973+00:00] 2026-01-14 09:30:23,973 - INFO - Replaced 1 tasks by index-search (index-search) during optimization.
[task 2026-01-14T09:30:23.974+00:00] 2026-01-14 09:30:23,974 - DEBUG - Morphing: adding index tasks
[task 2026-01-14T09:30:23.974+00:00] 2026-01-14 09:30:23,974 - DEBUG - Morphing: adding code review task
[task 2026-01-14T09:30:23.974+00:00] 2026-01-14 09:30:23,974 - INFO - writing artifact file `task-graph.json`
[task 2026-01-14T09:30:23.974+00:00] 2026-01-14 09:30:23,974 - INFO - writing artifact file `label-to-taskid.json`
[task 2026-01-14T09:30:23.976+00:00] 2026-01-14 09:30:23,976 - INFO - Creating task with taskId TvcSgNW3TRuUc5DNSWBDQg for tests-unit-ciadmin
[task 2026-01-14T09:30:23.977+00:00] 2026-01-14 09:30:23,976 - INFO - Creating task with taskId WscSonYQSu-HDDUXv4NZXA for tests-unit-fxci-config-taskgraph
[task 2026-01-14T09:30:23.977+00:00] 2026-01-14 09:30:23,977 - DEBUG - Using method(v1, v2, payload) calling convention
[task 2026-01-14T09:30:23.977+00:00] 2026-01-14 09:30:23,977 - DEBUG - Found a positional argument: TvcSgNW3TRuUc5DNSWBDQg
[task 2026-01-14T09:30:23.977+00:00] 2026-01-14 09:30:23,977 - DEBUG - After processing positional arguments, we have: {'taskId': 'TvcSgNW3TRuUc5DNSWBDQg'}
[task 2026-01-14T09:30:23.977+00:00] 2026-01-14 09:30:23,977 - INFO - Creating task with taskId ZreKr0eFRMi0Hhl_iyaBzA for docker-image-build-decision
[task 2026-01-14T09:30:23.978+00:00] 2026-01-14 09:30:23,977 - DEBUG - Using method(v1, v2, payload) calling convention
[task 2026-01-14T09:30:23.978+00:00] 2026-01-14 09:30:23,977 - DEBUG - After keyword arguments, we have: {'taskId': 'TvcSgNW3TRuUc5DNSWBDQg'}
[task 2026-01-14T09:30:23.978+00:00] 2026-01-14 09:30:23,978 - DEBUG - Using method(v1, v2, payload) calling convention
[task 2026-01-14T09:30:23.979+00:00] 2026-01-14 09:30:23,978 - DEBUG - Full URL used is: http://172.17.0.1:80/api/queue/v1/task/TvcSgNW3TRuUc5DNSWBDQg
[task 2026-01-14T09:30:23.979+00:00] 2026-01-14 09:30:23,979 - DEBUG - Not using hawk!
[task 2026-01-14T09:30:23.979+00:00] 2026-01-14 09:30:23,978 - DEBUG - Found a positional argument: ZreKr0eFRMi0Hhl_iyaBzA
[task 2026-01-14T09:30:23.979+00:00] 2026-01-14 09:30:23,978 - DEBUG - Found a positional argument: WscSonYQSu-HDDUXv4NZXA
[task 2026-01-14T09:30:23.979+00:00] 2026-01-14 09:30:23,979 - DEBUG - Making attempt 0
[task 2026-01-14T09:30:23.980+00:00] 2026-01-14 09:30:23,979 - DEBUG - Making a PUT request to http://172.17.0.1:80/api/queue/v1/task/TvcSgNW3TRuUc5DNSWBDQg
[task 2026-01-14T09:30:23.980+00:00] 2026-01-14 09:30:23,979 - DEBUG - After processing positional arguments, we have: {'taskId': 'ZreKr0eFRMi0Hhl_iyaBzA'}
[task 2026-01-14T09:30:23.980+00:00] 2026-01-14 09:30:23,980 - DEBUG - After keyword arguments, we have: {'taskId': 'ZreKr0eFRMi0Hhl_iyaBzA'}
[task 2026-01-14T09:30:23.980+00:00] 2026-01-14 09:30:23,980 - DEBUG - Full URL used is: http://172.17.0.1:80/api/queue/v1/task/ZreKr0eFRMi0Hhl_iyaBzA
[task 2026-01-14T09:30:23.980+00:00] 2026-01-14 09:30:23,979 - DEBUG - HTTP Headers: {'Content-Type': 'application/json'}
[task 2026-01-14T09:30:23.980+00:00] 2026-01-14 09:30:23,980 - DEBUG - HTTP Payload: {"provisionerId":"releng-t","workerType":"linux-docker","routes":["checks"],"created":"2026-01-14T09 (limit 100 char)
[task 2026-01-14T09:30:23.980+00:00] 2026-01-14 09:30:23,980 - DEBUG - Not using hawk!
[task 2026-01-14T09:30:23.981+00:00] 2026-01-14 09:30:23,979 - DEBUG - After processing positional arguments, we have: {'taskId': 'WscSonYQSu-HDDUXv4NZXA'}
[task 2026-01-14T09:30:23.981+00:00] 2026-01-14 09:30:23,981 - DEBUG - After keyword arguments, we have: {'taskId': 'WscSonYQSu-HDDUXv4NZXA'}
[task 2026-01-14T09:30:23.981+00:00] 2026-01-14 09:30:23,981 - DEBUG - Making attempt 0
[task 2026-01-14T09:30:23.982+00:00] 2026-01-14 09:30:23,981 - DEBUG - Making a PUT request to http://172.17.0.1:80/api/queue/v1/task/ZreKr0eFRMi0Hhl_iyaBzA
[task 2026-01-14T09:30:23.982+00:00] 2026-01-14 09:30:23,981 - DEBUG - Full URL used is: http://172.17.0.1:80/api/queue/v1/task/WscSonYQSu-HDDUXv4NZXA
[task 2026-01-14T09:30:23.982+00:00] 2026-01-14 09:30:23,981 - DEBUG - Starting new HTTP connection (1): 172.17.0.1:80
[task 2026-01-14T09:30:23.982+00:00] 2026-01-14 09:30:23,982 - DEBUG - HTTP Headers: {'Content-Type': 'application/json'}
[task 2026-01-14T09:30:23.983+00:00] 2026-01-14 09:30:23,982 - DEBUG - Not using hawk!
[task 2026-01-14T09:30:23.983+00:00] 2026-01-14 09:30:23,983 - DEBUG - Making attempt 0
[task 2026-01-14T09:30:23.983+00:00] 2026-01-14 09:30:23,982 - DEBUG - HTTP Payload: {"provisionerId":"releng-1","workerType":"linux-docker","routes":["index.releng.cache.pr.docker-imag (limit 100 char)
[task 2026-01-14T09:30:23.983+00:00] 2026-01-14 09:30:23,983 - DEBUG - Making a PUT request to http://172.17.0.1:80/api/queue/v1/task/WscSonYQSu-HDDUXv4NZXA
[task 2026-01-14T09:30:23.984+00:00] 2026-01-14 09:30:23,983 - DEBUG - HTTP Headers: {'Content-Type': 'application/json'}
[task 2026-01-14T09:30:23.984+00:00] 2026-01-14 09:30:23,983 - DEBUG - HTTP Payload: {"provisionerId":"releng-t","workerType":"linux-docker","routes":["checks"],"created":"2026-01-14T09 (limit 100 char)
[task 2026-01-14T09:30:23.985+00:00] 2026-01-14 09:30:23,985 - DEBUG - Starting new HTTP connection (1): 172.17.0.1:80
[task 2026-01-14T09:30:23.986+00:00] 2026-01-14 09:30:23,986 - DEBUG - Starting new HTTP connection (1): 172.17.0.1:80
[task 2026-01-14T09:30:24.127+00:00] 2026-01-14 09:30:24,127 - DEBUG - http://172.17.0.1:80 "PUT /api/queue/v1/task/WscSonYQSu-HDDUXv4NZXA HTTP/1.1" 200 431
[task 2026-01-14T09:30:24.127+00:00] 2026-01-14 09:30:24,127 - DEBUG - Received HTTP Status:    200
[task 2026-01-14T09:30:24.128+00:00] 2026-01-14 09:30:24,127 - 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': '431', 'Content-Security-Policy': "report-uri /__cspreport__;default-src 'none';frame-ancestors 'none';", 'Content-Type': 'application/json; charset=utf-8', 'Date': 'Wed, 14 Jan 2026 09:30:24 GMT', 'Etag': 'W/"1af-3kb3FUF9Ras+tF5EGo2F1vjpZFc"', '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': '4f690016-1cec-49da-9e9a-0038a8b43bfd', 'X-For-Trace-Id': '7dd0bc08a70621904c9b4b8e048789de', 'X-Served-By': 'cache-chi-kigq8000153-CHI, cache-chi-kigq8000150-CHI', 'X-Taskcluster-Authorized-Scopes': '["assume:repo:github.com/mozilla-releng/fxci-config:pull-request","queue:create-artifact:SwHTPAwQSLS4QCMMjQ4P5g/0"]', 'X-Taskcluster-Endpoint': 'https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/WscSonYQSu-HDDUXv4NZXA', 'X-Taskcluster-Proxy-Revision': 'e954a7555fe32f7de69247759908749d1d670889', 'X-Taskcluster-Proxy-Temp-Clientid': 'task-client/SwHTPAwQSLS4QCMMjQ4P5g/0/on/us-central1-f/4917784410801757929/until/1768384210.465', 'X-Taskcluster-Proxy-Temp-Scopes': '["queue:reclaim-task:SwHTPAwQSLS4QCMMjQ4P5g/0","queue:resolve-task:SwHTPAwQSLS4QCMMjQ4P5g/0","queue:create-artifact:SwHTPAwQSLS4QCMMjQ4P5g/0","assume:repo:github.com/mozilla-releng/fxci-config:pull-request"]', 'X-Taskcluster-Proxy-Version': '93.1.2', 'X-Timer': 'S1768383024.993374,VS0,VE127'}
[task 2026-01-14T09:30:24.128+00:00] 2026-01-14 09:30:24,128 - DEBUG - http://172.17.0.1:80 "PUT /api/queue/v1/task/ZreKr0eFRMi0Hhl_iyaBzA HTTP/1.1" 200 431
[task 2026-01-14T09:30:24.129+00:00] 2026-01-14 09:30:24,128 - DEBUG - http://172.17.0.1:80 "PUT /api/queue/v1/task/TvcSgNW3TRuUc5DNSWBDQg HTTP/1.1" 200 431
[task 2026-01-14T09:30:24.129+00:00] 2026-01-14 09:30:24,129 - DEBUG - Received HTTP Status:    200
[task 2026-01-14T09:30:24.129+00:00] 2026-01-14 09:30:24,129 - DEBUG - Received HTTP Status:    200
[task 2026-01-14T09:30:24.130+00:00] 2026-01-14 09:30:24,129 - 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': '431', 'Content-Security-Policy': "report-uri /__cspreport__;default-src 'none';frame-ancestors 'none';", 'Content-Type': 'application/json; charset=utf-8', 'Date': 'Wed, 14 Jan 2026 09:30:24 GMT', 'Etag': 'W/"1af-Jwols2oVtpZ4VN1stsH53hdX0yU"', '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': '8b523de5-bf0e-47b2-88b8-4347b8e860ae', 'X-For-Trace-Id': '694d5bf1c842001e8a2549de2ff31df4', 'X-Served-By': 'cache-chi-kigq8000081-CHI, cache-chi-kigq8000150-CHI', 'X-Taskcluster-Authorized-Scopes': '["assume:repo:github.com/mozilla-releng/fxci-config:pull-request","queue:create-artifact:SwHTPAwQSLS4QCMMjQ4P5g/0"]', 'X-Taskcluster-Endpoint': 'https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/ZreKr0eFRMi0Hhl_iyaBzA', 'X-Taskcluster-Proxy-Revision': 'e954a7555fe32f7de69247759908749d1d670889', 'X-Taskcluster-Proxy-Temp-Clientid': 'task-client/SwHTPAwQSLS4QCMMjQ4P5g/0/on/us-central1-f/4917784410801757929/until/1768384210.465', 'X-Taskcluster-Proxy-Temp-Scopes': '["queue:reclaim-task:SwHTPAwQSLS4QCMMjQ4P5g/0","queue:resolve-task:SwHTPAwQSLS4QCMMjQ4P5g/0","queue:create-artifact:SwHTPAwQSLS4QCMMjQ4P5g/0","assume:repo:github.com/mozilla-releng/fxci-config:pull-request"]', 'X-Taskcluster-Proxy-Version': '93.1.2', 'X-Timer': 'S1768383024.993124,VS0,VE128'}
[task 2026-01-14T09:30:24.130+00:00] 2026-01-14 09:30:24,130 - 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': '431', 'Content-Security-Policy': "report-uri /__cspreport__;default-src 'none';frame-ancestors 'none';", 'Content-Type': 'application/json; charset=utf-8', 'Date': 'Wed, 14 Jan 2026 09:30:24 GMT', 'Etag': 'W/"1af-xVNaiHf/zvPLa2/LOBOk8szLZvE"', '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': '998acc3f-2502-48a3-a76d-cf377108bfdd', 'X-For-Trace-Id': '87cab2618f8275b05be3d190d84b6b6d', 'X-Served-By': 'cache-chi-kigq8000046-CHI, cache-chi-kigq8000150-CHI', 'X-Taskcluster-Authorized-Scopes': '["assume:repo:github.com/mozilla-releng/fxci-config:pull-request","queue:create-artifact:SwHTPAwQSLS4QCMMjQ4P5g/0"]', 'X-Taskcluster-Endpoint': 'https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/TvcSgNW3TRuUc5DNSWBDQg', 'X-Taskcluster-Proxy-Revision': 'e954a7555fe32f7de69247759908749d1d670889', 'X-Taskcluster-Proxy-Temp-Clientid': 'task-client/SwHTPAwQSLS4QCMMjQ4P5g/0/on/us-central1-f/4917784410801757929/until/1768384210.465', 'X-Taskcluster-Proxy-Temp-Scopes': '["queue:reclaim-task:SwHTPAwQSLS4QCMMjQ4P5g/0","queue:resolve-task:SwHTPAwQSLS4QCMMjQ4P5g/0","queue:create-artifact:SwHTPAwQSLS4QCMMjQ4P5g/0","assume:repo:github.com/mozilla-releng/fxci-config:pull-request"]', 'X-Taskcluster-Proxy-Version': '93.1.2', 'X-Timer': 'S1768383024.990501,VS0,VE130'}
[taskcluster 2026-01-14T09:30:24.294Z]                        Exit Code: 0
[taskcluster 2026-01-14T09:30:24.294Z]                        User Time: 14.317ms
[taskcluster 2026-01-14T09:30:24.294Z]                      Kernel Time: 15.51ms
[taskcluster 2026-01-14T09:30:24.294Z]                        Wall Time: 4.88256757s
[taskcluster 2026-01-14T09:30:24.294Z]  Average Available System Memory: 7.12 GiB
[taskcluster 2026-01-14T09:30:24.294Z]       Average System Memory Used: 643.36 MiB
[taskcluster 2026-01-14T09:30:24.294Z]          Peak System Memory Used: 692.84 MiB
[taskcluster 2026-01-14T09:30:24.294Z]              Total System Memory: 7.75 GiB
[taskcluster 2026-01-14T09:30:24.294Z]                           Result: SUCCEEDED
[taskcluster 2026-01-14T09:30:24.294Z] === Task Finished ===
[taskcluster 2026-01-14T09:30:24.294Z] Task Duration: 4.883143133s
[taskcluster 2026-01-14T09:30:25.559Z] [mounts] Preserving cache: Moving "/home/task_176838301014325/cache0" to "/home/generic-worker/caches/dyyNOWQ2QyW86RY9XOI3Ag"