[taskcluster 2024-12-12 13:58:59.141Z] Task ID: SoCtY-EWRpW7WMlqwt1LVQ
[taskcluster 2024-12-12 13:58:59.141Z] Worker ID: 7207089343535994170
[taskcluster 2024-12-12 13:58:59.141Z] Worker Group: us-central1-f
[taskcluster 2024-12-12 13:58:59.141Z] Worker Node Type: projects/970387039909/machineTypes/c2-standard-4
[taskcluster 2024-12-12 13:58:59.141Z] Worker Pool: scriptworker-3/b-linux-gcp
[taskcluster 2024-12-12 13:58:59.141Z] Worker Version: 38.0.5
[taskcluster 2024-12-12 13:58:59.141Z] Public IP: 34.71.138.20
[taskcluster 2024-12-12 13:58:59.141Z] Hostname: scriptworker-3-b-linux-gcp-ao73o1s9qcwiw9i2jkjkga
[taskcluster 2024-12-12 13:58:59.141Z] using cache "scriptworker-level-3-checkouts-v3-7afeb851dd97df8f3607-DBS6rkORSV2FBLVFGWbQHA" -> /builds/worker/checkouts

[taskcluster 2024-12-12 13:59:01.503Z] Downloading artifact "public/image.tar.zst" from task ID: DBS6rkORSV2FBLVFGWbQHA.
[taskcluster 2024-12-12 13:59:05.000Z] Downloaded artifact successfully.
[taskcluster 2024-12-12 13:59:05.001Z] Downloaded 285.440 mb
[taskcluster 2024-12-12 13:59:05.002Z] Decompressing downloaded image
[taskcluster 2024-12-12 13:59:07.379Z] Loading docker image from downloaded archive.
[taskcluster 2024-12-12 13:59:25.625Z] Image 'public/image.tar.zst' from task 'DBS6rkORSV2FBLVFGWbQHA' loaded.  Using image ID sha256:60321cf0c7e2778eeb1d676e892d746ab5a5a30e6c1b723690dc85fd99995106.
[taskcluster 2024-12-12 13:59:25.813Z] === Task Starting ===
[setup 2024-12-12T13:59:28.392Z] run-task started in /
[setup 2024-12-12T13:59:28.392Z] Invoked by command: --scriptworker-checkout=/builds/worker/checkouts/vcs/ --task-cwd /builds/worker/checkouts/vcs -- sh -lxce tox -e addonscript-py311
[setup 2024-12-12T13:59:28.393Z] Python version: 3.11.9
[cache 2024-12-12T13:59:28.394Z] cache /builds/worker/checkouts is empty; writing requirements: gid=1000 uid=1000 version=1
[volume 2024-12-12T13:59:28.394Z] changing ownership of volume /builds/worker/.cache to 1000:1000
[volume 2024-12-12T13:59:28.394Z] volume /builds/worker/checkouts is a cache
[setup 2024-12-12T13:59:28.395Z] running as worker:worker
[vcs 2024-12-12T13:59:28.395Z] executing ['git', 'config', '--global', '--add', 'safe.directory', '/builds/worker/checkouts/vcs']
[vcs 2024-12-12T13:59:28.399Z] executing ['git', 'clone', 'https://github.com/mozilla-releng/scriptworker-scripts', '/builds/worker/checkouts/vcs']
[vcs 2024-12-12T13:59:28.400Z] Cloning into '/builds/worker/checkouts/vcs'...
[vcs 2024-12-12T13:59:32.276Z] executing ['git', 'fetch', '--tags', '--force', 'https://github.com/mozilla-releng/scriptworker-scripts', 'refs/heads/dev-beetmoverscript']
[vcs 2024-12-12T13:59:32.485Z] From https://github.com/mozilla-releng/scriptworker-scripts
[vcs 2024-12-12T13:59:32.485Z]  * branch              dev-beetmoverscript -> FETCH_HEAD
[vcs 2024-12-12T13:59:32.490Z] executing ['git', 'fetch', '--no-tags', 'https://github.com/mozilla-releng/scriptworker-scripts', 'refs/heads/dev-beetmoverscript']
[vcs 2024-12-12T13:59:32.670Z] From https://github.com/mozilla-releng/scriptworker-scripts
[vcs 2024-12-12T13:59:32.670Z]  * branch              dev-beetmoverscript -> FETCH_HEAD
[vcs 2024-12-12T13:59:32.675Z] executing ['git', 'checkout', '-f', '-B', 'refs/heads/dev-beetmoverscript', 'bb05034cd86256b99b15cc27399f167e2bcf6c2f']
[vcs 2024-12-12T13:59:33.472Z] Switched to a new branch 'refs/heads/dev-beetmoverscript'
[vcs 2024-12-12T13:59:33.473Z] cleaning git checkout...
[vcs 2024-12-12T13:59:33.473Z] executing ['git', 'clean', '-nxdff']
[vcs 2024-12-12T13:59:33.484Z] removing []
[vcs 2024-12-12T13:59:33.484Z] successfully cleaned git checkout!
[vcs 2024-12-12T13:59:33.485Z] TinderboxPrint:<a href='https://github.com/mozilla-releng/scriptworker-scripts/commit/bb05034cd86256b99b15cc27399f167e2bcf6c2f' title='Built from scriptworker-scripts commit bb05034cd86256b99b15cc27399f167e2bcf6c2f'>bb05034cd86256b99b15cc27399f167e2bcf6c2f</a>
[task 2024-12-12T13:59:33.485Z] executing ['sh', '-lxce', 'tox -e addonscript-py311']
[task 2024-12-12T13:59:33.487Z] + id -u
[task 2024-12-12T13:59:33.488Z] + [ 1000 -eq 0 ]
[task 2024-12-12T13:59:33.488Z] + PATH=/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games
[task 2024-12-12T13:59:33.488Z] + export PATH
[task 2024-12-12T13:59:33.488Z] + [ $  ]
[task 2024-12-12T13:59:33.488Z] + [  ]
[task 2024-12-12T13:59:33.488Z] + id -u
[task 2024-12-12T13:59:33.489Z] + [ 1000 -eq 0 ]
[task 2024-12-12T13:59:33.489Z] + PS1=$ 
[task 2024-12-12T13:59:33.489Z] + [ -d /etc/profile.d ]
[task 2024-12-12T13:59:33.489Z] + [ -r /etc/profile.d/*.sh ]
[task 2024-12-12T13:59:33.489Z] + unset i
[task 2024-12-12T13:59:33.489Z] + [ -n  ]
[task 2024-12-12T13:59:33.489Z] + [ -d /builds/worker/bin ]
[task 2024-12-12T13:59:33.489Z] + [ -d /builds/worker/.local/bin ]
[task 2024-12-12T13:59:33.489Z] + tox -e addonscript-py311
[task 2024-12-12T13:59:34.011Z] addonscript-py311: install_deps> python -I -m pip install pyparsing tox
[task 2024-12-12T13:59:37.153Z] addonscript-py311: commands[0] /builds/worker/checkouts/vcs/addonscript> tox -e py311
[task 2024-12-12T13:59:37.865Z] py311: install_deps> python -I -m pip install -r /builds/worker/checkouts/vcs/addonscript/requirements/test.txt
[task 2024-12-12T13:59:49.594Z] .pkg: install_requires> python -I -m pip install 'setuptools>=40.8.0' wheel
[task 2024-12-12T13:59:50.513Z] .pkg: _optional_hooks> python /builds/worker/checkouts/vcs/.tox/addonscript-py311/lib/python3.11/site-packages/pyproject_api/_backend.py True setuptools.build_meta __legacy__
[task 2024-12-12T13:59:50.810Z] .pkg: get_requires_for_build_editable> python /builds/worker/checkouts/vcs/.tox/addonscript-py311/lib/python3.11/site-packages/pyproject_api/_backend.py True setuptools.build_meta __legacy__
[task 2024-12-12T13:59:51.038Z] .pkg: build_editable> python /builds/worker/checkouts/vcs/.tox/addonscript-py311/lib/python3.11/site-packages/pyproject_api/_backend.py True setuptools.build_meta __legacy__
[task 2024-12-12T13:59:51.303Z] py311: install_package_deps> python -I -m pip install 'aiohttp>3' async_timeout python-jose scriptworker
[task 2024-12-12T13:59:51.955Z] py311: install_package> python -I -m pip install --force-reinstall --no-deps /builds/worker/checkouts/vcs/.tox/.tmp/package/1/addonscript-1.0-0.editable-py3-none-any.whl
[task 2024-12-12T13:59:52.439Z] py311: commands[0]> py.test --cov-config=tox.ini --cov-append --cov=/builds/worker/checkouts/vcs/addonscript/src/addonscript --cov-report term-missing tests
[task 2024-12-12T13:59:53.171Z] /builds/worker/checkouts/vcs/.tox/py311/lib/python3.11/site-packages/pytest_asyncio/plugin.py:208: PytestDeprecationWarning: The configuration option "asyncio_default_fixture_loop_scope" is unset.
[task 2024-12-12T13:59:53.171Z] The event loop scope for asynchronous fixtures will default to the fixture caching scope. Future versions of pytest-asyncio will default the loop scope for asynchronous fixtures to function scope. Set the default fixture loop scope explicitly in order to avoid unexpected behavior in the future. Valid fixture loop scopes are: "function", "class", "module", "package", "session"
[task 2024-12-12T13:59:53.171Z] 
[task 2024-12-12T13:59:53.171Z]   warnings.warn(PytestDeprecationWarning(_DEFAULT_FIXTURE_LOOP_SCOPE_UNSET))
[task 2024-12-12T13:59:53.505Z] ============================= test session starts ==============================
[task 2024-12-12T13:59:53.505Z] platform linux -- Python 3.11.9, pytest-8.3.4, pluggy-1.5.0
[task 2024-12-12T13:59:53.505Z] cachedir: .tox/py311/.pytest_cache
[task 2024-12-12T13:59:53.505Z] rootdir: /builds/worker/checkouts/vcs
[task 2024-12-12T13:59:53.505Z] configfile: setup.cfg
[task 2024-12-12T13:59:53.505Z] plugins: asyncio-0.24.0, cov-6.0.0, mock-1.12.1
[task 2024-12-12T13:59:53.505Z] asyncio: mode=Mode.STRICT, default_loop_scope=None
[task 2024-12-12T13:59:53.505Z] collected 79 items
[task 2024-12-12T13:59:53.505Z] 
[task 2024-12-12T13:59:53.791Z] tests/test_api.py ............................                           [ 35%]
[task 2024-12-12T13:59:53.819Z] tests/test_config.py ..                                                  [ 37%]
[task 2024-12-12T13:59:53.879Z] tests/test_script.py ...                                                 [ 41%]
[task 2024-12-12T13:59:53.925Z] tests/test_task.py ......................                                [ 69%]
[task 2024-12-12T13:59:54.190Z] tests/test_utils.py ......................                               [ 97%]
[task 2024-12-12T13:59:54.243Z] tests/test_xpi.py ..                                                     [100%]
[task 2024-12-12T13:59:54.243Z] 
[task 2024-12-12T13:59:54.243Z] =============================== warnings summary ===============================
[task 2024-12-12T13:59:54.243Z] ../.tox/py311/lib/python3.11/site-packages/pytest_asyncio/plugin.py:255
[task 2024-12-12T13:59:54.244Z] ../.tox/py311/lib/python3.11/site-packages/pytest_asyncio/plugin.py:255
[task 2024-12-12T13:59:54.244Z]   /builds/worker/checkouts/vcs/.tox/py311/lib/python3.11/site-packages/pytest_asyncio/plugin.py:255: PytestDeprecationWarning: fake_session is asynchronous and explicitly requests the "event_loop" fixture. Asynchronous fixtures and test functions should use "asyncio.get_running_loop()" instead.
[task 2024-12-12T13:59:54.244Z]     warnings.warn(
[task 2024-12-12T13:59:54.244Z] 
[task 2024-12-12T13:59:54.244Z] -- Docs: https://docs.pytest.org/en/stable/how-to/capture-warnings.html
[task 2024-12-12T13:59:54.244Z] 
[task 2024-12-12T13:59:54.244Z] ---------- coverage: platform linux, python 3.11.9-final-0 -----------
[task 2024-12-12T13:59:54.244Z] Name                            Stmts   Miss Branch BrPart  Cover   Missing
[task 2024-12-12T13:59:54.244Z] ---------------------------------------------------------------------------
[task 2024-12-12T13:59:54.244Z] src/addonscript/__init__.py         0      0      0      0   100%
[task 2024-12-12T13:59:54.244Z] src/addonscript/api.py             85      0     24      0   100%
[task 2024-12-12T13:59:54.244Z] src/addonscript/exceptions.py      14      0      0      0   100%
[task 2024-12-12T13:59:54.245Z] src/addonscript/script.py          51     16      6      0    65%   19, 23-29, 75-89, 93
[task 2024-12-12T13:59:54.245Z] src/addonscript/task.py            30      0     10      0   100%
[task 2024-12-12T13:59:54.245Z] src/addonscript/utils.py           62      0      2      0   100%
[task 2024-12-12T13:59:54.245Z] src/addonscript/xpi.py             11      0      0      0   100%
[task 2024-12-12T13:59:54.245Z] ---------------------------------------------------------------------------
[task 2024-12-12T13:59:54.245Z] TOTAL                             253     16     42      0    93%
[task 2024-12-12T13:59:54.245Z] 
[task 2024-12-12T13:59:54.245Z] ======================== 79 passed, 2 warnings in 1.04s ========================
[task 2024-12-12T13:59:54.369Z]   py311: OK (16.91=setup[14.98]+cmd[1.93] seconds)
[task 2024-12-12T13:59:54.369Z]   congratulations :) (17.06 seconds)
[task 2024-12-12T13:59:54.414Z] addonscript-py311: commands[1] /builds/worker/checkouts/vcs/addonscript> tox -e coveralls
[task 2024-12-12T13:59:54.645Z] ROOT: HandledError| provided environments not found in configuration file:
[task 2024-12-12T13:59:54.645Z] coveralls
[task 2024-12-12T13:59:54.686Z] addonscript-py311: exit 254 (0.27 seconds) /builds/worker/checkouts/vcs/addonscript> tox -e coveralls pid=234
[task 2024-12-12T13:59:54.686Z] addonscript-py311: command failed but is marked ignore outcome so handling it as success
[task 2024-12-12T13:59:54.687Z]   addonscript-py311: OK (20.98=setup[3.44]+cmd[17.26,0.27] seconds)
[task 2024-12-12T13:59:54.687Z]   congratulations :) (21.05 seconds)
[taskcluster 2024-12-12 13:59:55.813Z] === Task Finished ===
[taskcluster 2024-12-12 13:59:55.814Z] Successful task run with exit code: 0 completed in 56.673 seconds