[taskcluster 2025-01-06 23:02:54.641Z] Task ID: CQjzhBADQrCcgvTMPKacBw
[taskcluster 2025-01-06 23:02:54.641Z] Worker ID: 4735511827064151635
[taskcluster 2025-01-06 23:02:54.641Z] Worker Group: us-west1-b
[taskcluster 2025-01-06 23:02:54.641Z] Worker Node Type: projects/887720501152/machineTypes/c2-standard-4
[taskcluster 2025-01-06 23:02:54.641Z] Worker Type: t-linux-large-gcp
[taskcluster 2025-01-06 23:02:54.641Z] Public IP: 35.227.155.190
[taskcluster 2025-01-06 23:02:54.641Z] Hostname: mozilla-t-t-linux-large-gcp-fjywrfnbt9gvdqbscgblpa
[taskcluster 2025-01-06 23:02:54.641Z] using cache "mozilla-level-1-checkouts-v3-7afeb851dd97df8f3607-aWyKOWP4RGWBM3PC6n5Sow" -> /builds/worker/checkouts

[taskcluster 2025-01-06 23:02:55.055Z] Downloading artifact "public/image.tar.zst" from task ID: aWyKOWP4RGWBM3PC6n5Sow.
[taskcluster 2025-01-06 23:02:58.100Z] Downloaded artifact successfully.
[taskcluster 2025-01-06 23:02:58.100Z] Downloaded 412.254 mb
[taskcluster 2025-01-06 23:02:58.100Z] Decompressing downloaded image
[taskcluster 2025-01-06 23:03:00.497Z] Loading docker image from downloaded archive.
[taskcluster 2025-01-06 23:03:21.924Z] Image 'public/image.tar.zst' from task 'aWyKOWP4RGWBM3PC6n5Sow' loaded.  Using image ID sha256:d1582e1f57df0777ef9ee5fdc94de00337431a516056d2524dc4cb9b8ecff794.
[taskcluster 2025-01-06 23:03:22.069Z] === Task Starting ===
[setup 2025-01-06T23:03:22.667Z] run-task started in /
[setup 2025-01-06T23:03:22.667Z] Invoked by command: --reps-checkout=/builds/worker/checkouts/vcs/ --task-cwd /builds/worker/checkouts/vcs -- bash -cx uv run tox --parallel
[setup 2025-01-06T23:03:22.667Z] Python version: 3.9.19
[cache 2025-01-06T23:03:22.668Z] cache /builds/worker/checkouts is empty; writing requirements: gid=1000 uid=1000 version=1
[volume 2025-01-06T23:03:22.668Z] changing ownership of volume /builds/worker/.cache to 1000:1000
[volume 2025-01-06T23:03:22.668Z] volume /builds/worker/checkouts is a cache
[setup 2025-01-06T23:03:22.669Z] running as worker:worker
[vcs 2025-01-06T23:03:22.669Z] executing ['git', 'config', '--global', '--add', 'safe.directory', '/builds/worker/checkouts/vcs']
[vcs 2025-01-06T23:03:22.671Z] executing ['git', 'clone', 'https://github.com/mozilla-releng/reps', '/builds/worker/checkouts/vcs']
[vcs 2025-01-06T23:03:22.673Z] Cloning into '/builds/worker/checkouts/vcs'...
[vcs 2025-01-06T23:03:23.253Z] executing ['git', 'fetch', '--tags', '--force', 'https://github.com/mozilla-releng/reps', 'pre-commit-ci-update-config']
[vcs 2025-01-06T23:03:23.581Z] From https://github.com/mozilla-releng/reps
[vcs 2025-01-06T23:03:23.581Z]  * branch            pre-commit-ci-update-config -> FETCH_HEAD
[vcs 2025-01-06T23:03:23.585Z] executing ['git', 'fetch', '--no-tags', 'https://github.com/mozilla-releng/reps', 'pre-commit-ci-update-config']
[vcs 2025-01-06T23:03:23.809Z] From https://github.com/mozilla-releng/reps
[vcs 2025-01-06T23:03:23.809Z]  * branch            pre-commit-ci-update-config -> FETCH_HEAD
[vcs 2025-01-06T23:03:23.813Z] executing ['git', 'checkout', '-f', '-B', 'pre-commit-ci-update-config', '324ff6c220d27f66f4edcabaf24b42f384c69b2e']
[vcs 2025-01-06T23:03:23.818Z] Switched to a new branch 'pre-commit-ci-update-config'
[vcs 2025-01-06T23:03:23.818Z] cleaning git checkout...
[vcs 2025-01-06T23:03:23.818Z] executing ['git', 'clean', '-nxdff']
[vcs 2025-01-06T23:03:23.821Z] removing []
[vcs 2025-01-06T23:03:23.821Z] successfully cleaned git checkout!
[vcs 2025-01-06T23:03:23.822Z] TinderboxPrint:<a href='https://github.com/mozilla-releng/reps/commit/324ff6c220d27f66f4edcabaf24b42f384c69b2e' title='Built from reps commit 324ff6c220d27f66f4edcabaf24b42f384c69b2e'>324ff6c220d27f66f4edcabaf24b42f384c69b2e</a>
[task 2025-01-06T23:03:23.823Z] executing ['bash', '-cx', 'uv run tox --parallel']
[task 2025-01-06T23:03:23.824Z] + uv run tox --parallel
[task 2025-01-06T23:03:23.965Z] Using Python 3.11.9
[task 2025-01-06T23:03:23.965Z] Creating virtualenv at: .venv
[task 2025-01-06T23:03:25.094Z] warning: Failed to hardlink files; falling back to full copy. This may lead to degraded performance.
[task 2025-01-06T23:03:25.094Z]          If the cache and target directories are on different filesystems, hardlinking may not be supported.
[task 2025-01-06T23:03:25.094Z]          If this is intentional, set `export UV_LINK_MODE=copy` or use `--link-mode=copy` to suppress this warning.
[task 2025-01-06T23:03:25.145Z] Installed 53 packages in 51ms
[task 2025-01-06T23:03:59.692Z] .pkg: install_requires> python -I -m pip install hatchling
[task 2025-01-06T23:03:59.692Z] .pkg: _optional_hooks> python /builds/worker/checkouts/vcs/.venv/lib/python3.11/site-packages/pyproject_api/_backend.py True hatchling.build
[task 2025-01-06T23:03:59.692Z] .pkg: get_requires_for_build_sdist> python /builds/worker/checkouts/vcs/.venv/lib/python3.11/site-packages/pyproject_api/_backend.py True hatchling.build
[task 2025-01-06T23:03:59.692Z] .pkg: build_sdist> python /builds/worker/checkouts/vcs/.venv/lib/python3.11/site-packages/pyproject_api/_backend.py True hatchling.build
[task 2025-01-06T23:03:59.693Z] clean: install_package_deps> python -I -m pip install 'cookiecutter<3,>=2.6.0' 'halo<1,>=0.0.31' 'pip-tools<8,>=7.4.0' 'pre-commit<4,>=3.5.0' 'ruamel-yaml<1,>=0.18.6'
[task 2025-01-06T23:03:59.693Z] clean: install_package> python -I -m pip install --force-reinstall --no-deps /builds/worker/checkouts/vcs/.tox/.tmp/package/1/reps_new-0.3.6.tar.gz
[task 2025-01-06T23:03:59.693Z] clean: commands[0]> uv run coverage erase
[task 2025-01-06T23:03:59.693Z] py310: skipped because could not find python interpreter with spec(s): py310
[task 2025-01-06T23:03:59.693Z] py38: skipped because could not find python interpreter with spec(s): py38
[task 2025-01-06T23:03:59.693Z] py311: install_package_deps> python -I -m pip install 'cookiecutter<3,>=2.6.0' 'halo<1,>=0.0.31' 'pip-tools<8,>=7.4.0' 'pre-commit<4,>=3.5.0' 'ruamel-yaml<1,>=0.18.6'
[task 2025-01-06T23:03:59.693Z] py311: install_package> python -I -m pip install --force-reinstall --no-deps /builds/worker/checkouts/vcs/.tox/.tmp/package/2/reps_new-0.3.6.tar.gz
[task 2025-01-06T23:03:59.693Z] py311: commands[0]> uv run python --version
[task 2025-01-06T23:03:59.694Z] Python 3.11.9
[task 2025-01-06T23:03:59.694Z] py311: commands[1]> uv run coverage run --context=py311 -p -m pytest -vv
[task 2025-01-06T23:03:59.694Z] ============================= test session starts ==============================
[task 2025-01-06T23:03:59.694Z] platform linux -- Python 3.11.9, pytest-7.4.4, pluggy-1.5.0 -- /builds/worker/checkouts/vcs/.venv/bin/python
[task 2025-01-06T23:03:59.694Z] cachedir: .tox/py311/.pytest_cache
[task 2025-01-06T23:03:59.694Z] rootdir: /builds/worker/checkouts/vcs
[task 2025-01-06T23:03:59.694Z] configfile: pyproject.toml
[task 2025-01-06T23:03:59.694Z] testpaths: test
[task 2025-01-06T23:03:59.694Z] collecting ... collected 3 items
[task 2025-01-06T23:03:59.694Z] 
[task 2025-01-06T23:03:59.694Z] test/test_template_python.py::test_generated_files PASSED                [ 33%]
[task 2025-01-06T23:03:59.694Z] test/test_template_python.py::test_cookiecutter_json[defaults] PASSED    [ 66%]
[task 2025-01-06T23:03:59.694Z] test/test_template_python.py::test_cookiecutter_json[package_name_normalized] PASSED [100%]
[task 2025-01-06T23:03:59.694Z] 
[task 2025-01-06T23:03:59.694Z] ============================== 3 passed in 9.25s ===============================
[task 2025-01-06T23:03:59.694Z] py39: install_package_deps> python -I -m pip install 'cookiecutter<3,>=2.6.0' 'halo<1,>=0.0.31' 'pip-tools<8,>=7.4.0' 'pre-commit<4,>=3.5.0' 'ruamel-yaml<1,>=0.18.6'
[task 2025-01-06T23:03:59.694Z] py39: install_package> python -I -m pip install --force-reinstall --no-deps /builds/worker/checkouts/vcs/.tox/.tmp/package/3/reps_new-0.3.6.tar.gz
[task 2025-01-06T23:03:59.694Z] py39: commands[0]> uv run python --version
[task 2025-01-06T23:03:59.694Z] Python 3.11.9
[task 2025-01-06T23:03:59.694Z] py39: commands[1]> uv run coverage run --context=py39 -p -m pytest -vv
[task 2025-01-06T23:03:59.694Z] ============================= test session starts ==============================
[task 2025-01-06T23:03:59.694Z] platform linux -- Python 3.11.9, pytest-7.4.4, pluggy-1.5.0 -- /builds/worker/checkouts/vcs/.venv/bin/python
[task 2025-01-06T23:03:59.694Z] cachedir: .tox/py39/.pytest_cache
[task 2025-01-06T23:03:59.694Z] rootdir: /builds/worker/checkouts/vcs
[task 2025-01-06T23:03:59.694Z] configfile: pyproject.toml
[task 2025-01-06T23:03:59.694Z] testpaths: test
[task 2025-01-06T23:03:59.694Z] collecting ... collected 3 items
[task 2025-01-06T23:03:59.694Z] 
[task 2025-01-06T23:03:59.694Z] test/test_template_python.py::test_generated_files PASSED                [ 33%]
[task 2025-01-06T23:03:59.694Z] test/test_template_python.py::test_cookiecutter_json[defaults] PASSED    [ 66%]
[task 2025-01-06T23:03:59.694Z] test/test_template_python.py::test_cookiecutter_json[package_name_normalized] PASSED [100%]
[task 2025-01-06T23:03:59.694Z] 
[task 2025-01-06T23:03:59.694Z] ============================== 3 passed in 7.97s ===============================
[task 2025-01-06T23:03:59.694Z] .pkg: _exit> python /builds/worker/checkouts/vcs/.venv/lib/python3.11/site-packages/pyproject_api/_backend.py True hatchling.build
[task 2025-01-06T23:03:59.694Z] report: install_package_deps> python -I -m pip install 'cookiecutter<3,>=2.6.0' 'halo<1,>=0.0.31' 'pip-tools<8,>=7.4.0' 'pre-commit<4,>=3.5.0' 'ruamel-yaml<1,>=0.18.6'
[task 2025-01-06T23:03:59.694Z] report: install_package> python -I -m pip install --force-reinstall --no-deps /builds/worker/checkouts/vcs/.tox/.tmp/package/4/reps_new-0.3.6.tar.gz
[task 2025-01-06T23:03:59.694Z] report: commands[0]> uv run coverage combine
[task 2025-01-06T23:03:59.694Z] Combined data file .coverage.4e14bd27d7f3.248.XoqxBKMx
[task 2025-01-06T23:03:59.694Z] Combined data file .coverage.4e14bd27d7f3.365.XNZCFPCx
[task 2025-01-06T23:03:59.694Z] report: commands[1]> uv run coverage xml -o /builds/worker/artifacts/coverage.xml
[task 2025-01-06T23:03:59.694Z] Wrote XML report to /builds/worker/artifacts/coverage.xml
[task 2025-01-06T23:03:59.694Z] clean: OK ✔ in 9.03 seconds
[task 2025-01-06T23:03:59.695Z] py310: SKIP ⚠ in 0.34 seconds
[task 2025-01-06T23:03:59.695Z] py38: SKIP ⚠ in 0.34 seconds
[task 2025-01-06T23:03:59.695Z] py311: OK ✔ in 17.15 seconds
[task 2025-01-06T23:03:59.695Z] py39: OK ✔ in 18.99 seconds
[task 2025-01-06T23:03:59.695Z]   clean: OK (9.03=setup[8.81]+cmd[0.22] seconds)
[task 2025-01-06T23:03:59.695Z]   py38: SKIP (0.34 seconds)
[task 2025-01-06T23:03:59.695Z]   py39: OK (18.99=setup[10.47]+cmd[0.02,8.50] seconds)
[task 2025-01-06T23:03:59.695Z]   py310: SKIP (0.34 seconds)
[task 2025-01-06T23:03:59.695Z]   py311: OK (17.15=setup[6.76]+cmd[0.02,10.37] seconds)
[task 2025-01-06T23:03:59.695Z]   report: OK (6.03=setup[5.82]+cmd[0.10,0.11] seconds)
[task 2025-01-06T23:03:59.695Z]   congratulations :) (34.18 seconds)
[taskcluster 2025-01-06 23:03:59.991Z] === Task Finished ===
[taskcluster 2025-01-06 23:04:00.311Z] Successful task run with exit code: 0 completed in 65.671 seconds