[taskcluster 2026-03-13T11:13:52.122Z] Worker Type (releng-t/linux-docker) settings:
[taskcluster 2026-03-13T11:13:52.122Z]   {
[taskcluster 2026-03-13T11:13:52.122Z]     "generic-worker": {
[taskcluster 2026-03-13T11:13:52.122Z]       "config": {
[taskcluster 2026-03-13T11:13:52.122Z]         "headlessTasks": true
[taskcluster 2026-03-13T11:13:52.122Z]       },
[taskcluster 2026-03-13T11:13:52.122Z]       "engine": "multiuser",
[taskcluster 2026-03-13T11:13:52.122Z]       "go-arch": "amd64",
[taskcluster 2026-03-13T11:13:52.122Z]       "go-os": "linux",
[taskcluster 2026-03-13T11:13:52.122Z]       "go-version": "go1.26.0",
[taskcluster 2026-03-13T11:13:52.122Z]       "release": "https://github.com/taskcluster/taskcluster/releases/tag/v97.0.1",
[taskcluster 2026-03-13T11:13:52.122Z]       "revision": "6519c127aad40a47b1412136d9a5797a76eca200",
[taskcluster 2026-03-13T11:13:52.122Z]       "source": "https://github.com/taskcluster/taskcluster/commits/6519c127aad40a47b1412136d9a5797a76eca200",
[taskcluster 2026-03-13T11:13:52.122Z]       "version": "97.0.1"
[taskcluster 2026-03-13T11:13:52.122Z]     },
[taskcluster 2026-03-13T11:13:52.122Z]     "image": "projects/taskcluster-imaging/global/images/gw-fxci-gcp-l1-2404-amd64-headless-googlecompute-2026-03-05",
[taskcluster 2026-03-13T11:13:52.122Z]     "instance-id": "1602048234981576692",
[taskcluster 2026-03-13T11:13:52.122Z]     "instance-type": "projects/887720501152/machineTypes/c2-standard-4",
[taskcluster 2026-03-13T11:13:52.122Z]     "local-ipv4": "10.128.2.52",
[taskcluster 2026-03-13T11:13:52.122Z]     "project-id": "fxci-production-level1-workers",
[taskcluster 2026-03-13T11:13:52.122Z]     "public-hostname": "releng-t-linux-docker-khtq1pnlrzodqjvu1faw5a.c.fxci-production-level1-workers.internal",
[taskcluster 2026-03-13T11:13:52.122Z]     "public-ipv4": "34.9.178.198",
[taskcluster 2026-03-13T11:13:52.122Z]     "region": "us-central1",
[taskcluster 2026-03-13T11:13:52.122Z]     "zone": "us-central1-f"
[taskcluster 2026-03-13T11:13:52.122Z]   }
[taskcluster 2026-03-13T11:13:52.122Z] Task ID: azgX3acyQOmN0HeBH0_FVg
[taskcluster 2026-03-13T11:13:52.122Z] === Task Starting ===
[taskcluster 2026-03-13T11:13:53.787Z] [mounts] No existing writable directory cache 'releng-level-1-checkouts-v3-cbbaf5380474618f5c43-TD-6ok12TIKsK9aYZN4Tsg' - creating /home/generic-worker/caches/bl8uj2bsSUieh7Vj3u2Iuw
[taskcluster 2026-03-13T11:13:53.787Z] [mounts] Creating directory /home/task_177340043127804/cache0
[taskcluster 2026-03-13T11:13:53.797Z] [mounts] Successfully mounted writable directory cache '/home/task_177340043127804/cache0'
[taskcluster 2026-03-13T11:13:53.798Z] [mounts] Downloading task TD-6ok12TIKsK9aYZN4Tsg artifact public/image.tar.zst to /home/generic-worker/downloads/Ec-k6IUtS3CGwdBsGgIPbw
[taskcluster 2026-03-13T11:14:03.792Z] [mounts] Downloaded 306132492 bytes with SHA256 ac8c6c34320e94796771a74833cb3976f3e9d1e658728c6c6bbd5ad47267c55d from task TD-6ok12TIKsK9aYZN4Tsg artifact public/image.tar.zst to /home/generic-worker/downloads/Ec-k6IUtS3CGwdBsGgIPbw
[taskcluster:warn 2026-03-13T11:14:03.793Z] [mounts] Download /home/generic-worker/downloads/Ec-k6IUtS3CGwdBsGgIPbw of task TD-6ok12TIKsK9aYZN4Tsg artifact public/image.tar.zst has SHA256 ac8c6c34320e94796771a74833cb3976f3e9d1e658728c6c6bbd5ad47267c55d but task payload does not declare a required value, so content authenticity cannot be verified
[taskcluster 2026-03-13T11:14:03.793Z] [mounts] File mount "dockerimage" handled by registered handler (cache: /home/generic-worker/downloads/Ec-k6IUtS3CGwdBsGgIPbw, SHA256: ac8c6c34320e94796771a74833cb3976f3e9d1e658728c6c6bbd5ad47267c55d)
[taskcluster 2026-03-13T11:14:03.793Z] [d2g] Loading docker image
[taskcluster 2026-03-13T11:14:18.755Z] [d2g] Loaded docker image "python3.13:latest"
[taskcluster 2026-03-13T11:14:18.755Z] Executing command 0: docker run -t --name taskcontainer_bAUyKYy2RGCp5sTcAphKug --memory-swap -1 --pids-limit -1 '--add-host=localhost.localdomain:127.0.0.1' -v /home/task_177340043127804/cache0:/builds/worker/checkouts --add-host=taskcluster:host-gateway --env-file 'env.list' 9c2d9c390d7b42d0416e57b28e4301b1786dfec2492bae3cc018a3229503023a /usr/local/bin/run-task --balrog-checkout=/builds/worker/checkouts/vcs/ --task-cwd /builds/worker/checkouts/vcs/agent -- uv run tox
[setup 2026-03-13T11:14:22.139+00:00] run-task started in /
[setup 2026-03-13T11:14:22.139+00:00] Invoked by command: --balrog-checkout=/builds/worker/checkouts/vcs/ --task-cwd /builds/worker/checkouts/vcs/agent -- uv run tox
[setup 2026-03-13T11:14:22.140+00:00] Python version: 3.13.11
[setup 2026-03-13T11:14:22.140+00:00] Subprocess python version: 
cpython-3.13.11-linux-x86_64-gnu    /usr/local/bin/python3.13
cpython-3.13.11-linux-x86_64-gnu    /usr/local/bin/python3 -> python3.13
cpython-3.13.11-linux-x86_64-gnu    /usr/local/bin/python -> python3
cpython-3.11.2-linux-x86_64-gnu     /usr/bin/python3.11
cpython-3.11.2-linux-x86_64-gnu     /usr/bin/python3 -> python3.11
[cache 2026-03-13T11:14:22.443+00:00] cache /builds/worker/checkouts is empty; writing requirements: gid=1000 uid=1000 version=1
[volume 2026-03-13T11:14:22.443+00:00] changing ownership of volume /builds/worker/.cache to 1000:1000
[volume 2026-03-13T11:14:22.443+00:00] volume /builds/worker/checkouts is a cache
[setup 2026-03-13T11:14:22.444+00:00] running as worker:worker
[vcs 2026-03-13T11:14:22.444+00:00] executing ['git', 'config', '--global', '--add', 'safe.directory', '/builds/worker/checkouts/vcs']
[vcs 2026-03-13T11:14:22.446+00:00] executing ['git', 'clone', 'https://github.com/mozilla-releng/balrog', '/builds/worker/checkouts/vcs']
[vcs 2026-03-13T11:14:22.448+00:00] Cloning into '/builds/worker/checkouts/vcs'...
[vcs 2026-03-13T11:14:25.989+00:00] executing ['git', 'fetch', 'https://github.com/renovate-bot/mozilla-releng-_-balrog', 'renovate/python-dependencies']
[vcs 2026-03-13T11:14:26.286+00:00] From https://github.com/renovate-bot/mozilla-releng-_-balrog
[vcs 2026-03-13T11:14:26.286+00:00]  * branch              renovate/python-dependencies -> FETCH_HEAD
[vcs 2026-03-13T11:14:26.289+00:00] executing ['git', 'checkout', '-f', '-B', 'renovate/python-dependencies', 'bb816cf0ac3737d02b4bc56d8c505a9d9e30e82b']
[vcs 2026-03-13T11:14:26.412+00:00] Switched to a new branch 'renovate/python-dependencies'
[vcs 2026-03-13T11:14:26.413+00:00] cleaning git checkout...
[vcs 2026-03-13T11:14:26.413+00:00] executing ['git', 'clean', '-nxdff']
[vcs 2026-03-13T11:14:26.421+00:00] removing []
[vcs 2026-03-13T11:14:26.421+00:00] successfully cleaned git checkout!
[vcs 2026-03-13T11:14:26.423+00:00] TinderboxPrint:<a href='https://github.com/renovate-bot/mozilla-releng-_-balrog/commit/bb816cf0ac3737d02b4bc56d8c505a9d9e30e82b' title='Built from mozilla-releng-_-balrog commit bb816cf0ac3737d02b4bc56d8c505a9d9e30e82b'>bb816cf0ac3737d02b4bc56d8c505a9d9e30e82b</a>
[task 2026-03-13T11:14:26.423+00:00] executing ['uv', 'run', 'tox']
[task 2026-03-13T11:14:26.525+00:00] Using CPython 3.13.11 interpreter at: /usr/local/bin/python3
[task 2026-03-13T11:14:26.525+00:00] Creating virtual environment at: /builds/worker/checkouts/vcs/.venv
[task 2026-03-13T11:14:26.544+00:00]    Building balrogagent @ file:///builds/worker/checkouts/vcs/agent
[task 2026-03-13T11:14:26.614+00:00] Downloading pygments (1.2MiB)
[task 2026-03-13T11:14:26.615+00:00] Downloading aiohttp (1.7MiB)
[task 2026-03-13T11:14:26.616+00:00] Downloading uv (22.4MiB)
[task 2026-03-13T11:14:26.616+00:00] Downloading virtualenv (5.6MiB)
[task 2026-03-13T11:14:26.618+00:00] Downloading black (1.7MiB)
[task 2026-03-13T11:14:27.190+00:00]  Downloaded virtualenv
[task 2026-03-13T11:14:27.196+00:00]  Downloaded uv
[task 2026-03-13T11:14:27.225+00:00]  Downloaded aiohttp
[task 2026-03-13T11:14:27.238+00:00]  Downloaded black
[task 2026-03-13T11:14:27.286+00:00]  Downloaded pygments
[task 2026-03-13T11:14:27.833+00:00]       Built balrogagent @ file:///builds/worker/checkouts/vcs/agent
[task 2026-03-13T11:14:27.836+00:00] warning: Failed to hardlink files; falling back to full copy. This may lead to degraded performance.
[task 2026-03-13T11:14:27.836+00:00]          If the cache and target directories are on different filesystems, hardlinking may not be supported.
[task 2026-03-13T11:14:27.837+00:00]          If this is intentional, set `export UV_LINK_MODE=copy` or use `--link-mode=copy` to suppress this warning.
[task 2026-03-13T11:14:27.913+00:00] Installed 46 packages in 78ms
[task 2026-03-13T11:14:28.733+00:00] py313: venv> /builds/worker/checkouts/vcs/.venv/bin/uv venv -p /builds/worker/checkouts/vcs/.venv/bin/python --allow-existing '--prompt=agent[py313]' --python-preference system /builds/worker/checkouts/vcs/agent/.tox/py313
[task 2026-03-13T11:14:28.845+00:00] py313: uv-sync> /builds/worker/checkouts/vcs/.venv/bin/uv sync --locked --python-preference system -p /builds/worker/checkouts/vcs/.venv/bin/python
[task 2026-03-13T11:14:30.319+00:00] py313: commands[0]> py.test -n auto --cov-config=tox.ini --cov-append --cov=balrogagent --cov-report term-missing tests
[task 2026-03-13T11:14:35.479+00:00] ============================= test session starts ==============================
[task 2026-03-13T11:14:35.479+00:00] platform linux -- Python 3.13.11, pytest-9.0.2, pluggy-1.6.0
[task 2026-03-13T11:14:35.479+00:00] cachedir: .tox/py313/.pytest_cache
[task 2026-03-13T11:14:35.480+00:00] rootdir: /builds/worker/checkouts/vcs/agent
[task 2026-03-13T11:14:35.480+00:00] configfile: tox.ini
[task 2026-03-13T11:14:35.480+00:00] plugins: cov-7.0.0, xdist-3.8.0, asyncio-1.3.0
[task 2026-03-13T11:14:35.480+00:00] asyncio: mode=Mode.STRICT, debug=False, asyncio_default_fixture_loop_scope=None, asyncio_default_test_loop_scope=function
[task 2026-03-13T11:14:35.480+00:00] created: 4/4 workers
[task 2026-03-13T11:14:35.480+00:00] 4 workers [31 items]
[task 2026-03-13T11:14:35.481+00:00] 
[task 2026-03-13T11:14:36.157+00:00] ...............................                                          [100%]
[task 2026-03-13T11:14:36.157+00:00] ================================ tests coverage ================================
[task 2026-03-13T11:14:36.157+00:00] _______________ coverage: platform linux, python 3.13.11-final-0 _______________
[task 2026-03-13T11:14:36.157+00:00] 
[task 2026-03-13T11:14:36.157+00:00] Name                          Stmts   Miss Branch BrPart  Cover   Missing
[task 2026-03-13T11:14:36.157+00:00] -------------------------------------------------------------------------
[task 2026-03-13T11:14:36.157+00:00] src/balrogagent/__init__.py       0      0      0      0   100%
[task 2026-03-13T11:14:36.157+00:00] src/balrogagent/changes.py       14      1      4      0    94%   6
[task 2026-03-13T11:14:36.157+00:00] src/balrogagent/client.py        37     27      4      0    24%   18-38, 42, 46-56
[task 2026-03-13T11:14:36.157+00:00] src/balrogagent/cmd.py           80     17     38      4    77%   47, 83-86, 89, 91->78, 106-122, 126
[task 2026-03-13T11:14:36.157+00:00] src/balrogagent/log.py           46     29     12      0    29%   63-65, 74-105, 116-120, 124-130
[task 2026-03-13T11:14:36.157+00:00] -------------------------------------------------------------------------
[task 2026-03-13T11:14:36.157+00:00] TOTAL                           177     74     58      4    57%
[task 2026-03-13T11:14:36.157+00:00] ============================== 31 passed in 4.60s ==============================
[task 2026-03-13T11:14:36.242+00:00]   py313: OK (7.51=setup[1.59]+cmd[5.92] seconds)
[task 2026-03-13T11:14:36.242+00:00]   congratulations :) (7.57 seconds)
[taskcluster 2026-03-13T11:14:37.221Z]                        Exit Code: 0
[taskcluster 2026-03-13T11:14:37.221Z]                        User Time: 15.489ms
[taskcluster 2026-03-13T11:14:37.221Z]                      Kernel Time: 11.617ms
[taskcluster 2026-03-13T11:14:37.221Z]                        Wall Time: 18.466288089s
[taskcluster 2026-03-13T11:14:37.221Z]  Average Available System Memory: 14.12 GiB
[taskcluster 2026-03-13T11:14:37.221Z]       Average System Memory Used: 1.50 GiB
[taskcluster 2026-03-13T11:14:37.221Z]          Peak System Memory Used: 1.67 GiB
[taskcluster 2026-03-13T11:14:37.221Z]              Total System Memory: 15.61 GiB
[taskcluster 2026-03-13T11:14:37.221Z]                           Result: SUCCEEDED
[taskcluster 2026-03-13T11:14:37.222Z] === Task Finished ===
[taskcluster 2026-03-13T11:14:37.222Z] Task Duration: 18.467165203s
[taskcluster 2026-03-13T11:14:37.246Z] [mounts] Preserving cache: Moving "/home/task_177340043127804/cache0" to "/home/generic-worker/caches/bl8uj2bsSUieh7Vj3u2Iuw"