2026-06-12 09:28:50.613618 | Job console starting 2026-06-12 09:28:50.750825 | Updating git repos 2026-06-12 09:28:51.372684 | Cloning repos into workspace 2026-06-12 09:28:51.503818 | Restoring repo states 2026-06-12 09:28:51.519907 | Merging changes 2026-06-12 09:28:52.026555 | Checking out repos 2026-06-12 09:28:52.154778 | Preparing playbooks 2026-06-12 09:28:54.880627 | Running Ansible setup 2026-06-12 09:29:03.205219 | PRE-RUN START: [trusted : gitlab.com/softwarefactory-project/centosinfra-prod/sf-config/playbooks/base/pre.yaml@main] 2026-06-12 09:29:03.917544 | 2026-06-12 09:29:03.917704 | PLAY [localhost] 2026-06-12 09:29:03.925327 | 2026-06-12 09:29:03.925408 | TASK [Gathering Facts] 2026-06-12 09:29:04.914493 | localhost | ok 2026-06-12 09:29:04.930447 | 2026-06-12 09:29:04.930707 | TASK [Setup log path fact] 2026-06-12 09:29:04.953482 | localhost | ok 2026-06-12 09:29:04.975067 | 2026-06-12 09:29:04.975216 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-12 09:29:05.004386 | localhost | ok 2026-06-12 09:29:05.011685 | 2026-06-12 09:29:05.011775 | TASK [emit-job-header : Print job information] 2026-06-12 09:29:05.063276 | # Job Information 2026-06-12 09:29:05.063650 | Ansible Version: 2.16.18 2026-06-12 09:29:05.063726 | Job: premetal-unit-tests 2026-06-12 09:29:05.063771 | Pipeline: check 2026-06-12 09:29:05.063810 | Executor: 38.102.83.51 2026-06-12 09:29:05.063852 | Triggered by: https://gitlab.com/softwarefactory-project/premetal/merge_requests/84 2026-06-12 09:29:05.063896 | Log URL (when completed): https://gateway-cloud-softwarefactory.apps.ocp.cloud.ci.centos.org/logs/c28/sf/c28fa9822cf14c62b4cb1a0672c6fadf/ 2026-06-12 09:29:05.063940 | Event ID: 6c177c9a-4225-4847-ba76-ca59e77ea132 2026-06-12 09:29:05.070673 | 2026-06-12 09:29:05.070869 | LOOP [emit-job-header : Print node information] 2026-06-12 09:29:05.176534 | localhost | ok: 2026-06-12 09:29:05.176835 | localhost | # Node Information 2026-06-12 09:29:05.176890 | localhost | Inventory Hostname: primary 2026-06-12 09:29:05.176932 | localhost | Hostname: d3dcef529c62 2026-06-12 09:29:05.176972 | localhost | Username: zuul 2026-06-12 09:29:05.177015 | localhost | Distro: Fedora 43 2026-06-12 09:29:05.177053 | localhost | Provider: k1s03 2026-06-12 09:29:05.177110 | localhost | Region: 2026-06-12 09:29:05.177156 | localhost | Label: zuul-worker-fedora-stable 2026-06-12 09:29:05.177196 | localhost | Product Name: OpenStack Nova 2026-06-12 09:29:05.177235 | localhost | Interface IP: zuul-worker-fedora-stable-0000071676 2026-06-12 09:29:05.192230 | 2026-06-12 09:29:05.192448 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-12 09:29:05.641161 | localhost -> localhost | changed 2026-06-12 09:29:05.650670 | 2026-06-12 09:29:05.650835 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-12 09:29:06.735997 | localhost -> localhost | changed 2026-06-12 09:29:06.742874 | 2026-06-12 09:29:06.742941 | PLAY [all] 2026-06-12 09:29:06.747574 | 2026-06-12 09:29:06.747638 | TASK [include_role : start-zuul-console] 2026-06-12 09:29:06.765450 | primary | ok 2026-06-12 09:29:06.781472 | 2026-06-12 09:29:06.781556 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-12 09:29:12.852751 | primary | ok 2026-06-12 09:29:12.864679 | 2026-06-12 09:29:12.864811 | TASK [include_role : validate-host] 2026-06-12 09:29:12.882538 | primary | skipping: Conditional result was False 2026-06-12 09:29:12.891458 | 2026-06-12 09:29:12.891595 | TASK [include_role : prepare-workspace] 2026-06-12 09:29:12.908227 | primary | skipping: Conditional result was False 2026-06-12 09:29:12.916383 | 2026-06-12 09:29:12.916510 | TASK [include_role : add-build-sshkey] 2026-06-12 09:29:12.943253 | primary | skipping: Conditional result was False 2026-06-12 09:29:12.951412 | 2026-06-12 09:29:12.951536 | TASK [include_role : prepare-workspace-openshift] 2026-06-12 09:29:12.984102 | primary | ok 2026-06-12 09:29:13.003693 | 2026-06-12 09:29:13.003862 | LOOP [prepare-workspace-openshift : Include rsync tasks] 2026-06-12 09:29:13.066254 | primary | ok: 2026-06-12 09:29:13.066532 | primary | [ 2026-06-12 09:29:13.066563 | primary | "primary", 2026-06-12 09:29:13.066588 | primary | { 2026-06-12 09:29:13.066609 | primary | "context": "main:zuul-worker/38-102-83-139:9023", 2026-06-12 09:29:13.066627 | primary | "namespace": "main", 2026-06-12 09:29:13.066645 | primary | "pod": "zuul-worker-fedora-stable-0000071676", 2026-06-12 09:29:13.066661 | primary | "resources": { 2026-06-12 09:29:13.066678 | primary | "cores": 0, 2026-06-12 09:29:13.066694 | primary | "instances": 1, 2026-06-12 09:29:13.066714 | primary | "ram": 0 2026-06-12 09:29:13.066734 | primary | }, 2026-06-12 09:29:13.066755 | primary | "stream_port1": 45603, 2026-06-12 09:29:13.066776 | primary | "stream_port2": 44509 2026-06-12 09:29:13.066796 | primary | } 2026-06-12 09:29:13.066814 | primary | ] 2026-06-12 09:29:13.066850 | primary | ok: All items complete 2026-06-12 09:29:13.066873 | 2026-06-12 09:29:13.085120 | primary | included: /var/lib/zuul/builds/c28fa9822cf14c62b4cb1a0672c6fadf/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/prepare-workspace-openshift/tasks/rsync.yaml 2026-06-12 09:29:13.093770 | 2026-06-12 09:29:13.093923 | TASK [prepare-workspace-openshift : Create src directory] 2026-06-12 09:29:14.518385 | primary -> localhost | ok: Runtime: 0:00:00.916152 2026-06-12 09:29:14.526485 | 2026-06-12 09:29:14.526645 | TASK [prepare-workspace-openshift : Copy src repos to the pod] 2026-06-12 09:29:16.422712 | primary -> localhost | Output suppressed because no_log was given 2026-06-12 09:29:16.430251 | 2026-06-12 09:29:16.430326 | TASK [include_role : remove-zuul-sshkey] 2026-06-12 09:29:16.461952 | primary | ok 2026-06-12 09:29:16.477496 | 2026-06-12 09:29:16.477609 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-12 09:29:16.931105 | primary -> localhost | changed 2026-06-12 09:29:16.991277 | 2026-06-12 09:29:16.991476 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-06-12 09:29:22.834976 | primary | ok: "logs" 2026-06-12 09:29:29.444210 | primary | ok: "artifacts" 2026-06-12 09:29:35.413406 | primary | ok: "docs" 2026-06-12 09:29:35.427541 | 2026-06-12 09:29:35.427743 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-06-12 09:29:41.452215 | primary | changed: "logs" 2026-06-12 09:29:41.452873 | primary | ok: All items complete 2026-06-12 09:29:41.452953 | 2026-06-12 09:29:47.494949 | primary | changed: "artifacts" 2026-06-12 09:29:53.707642 | primary | changed: "docs" 2026-06-12 09:29:53.732912 | 2026-06-12 09:29:53.733133 | LOOP [Tune dnf options] 2026-06-12 09:30:00.090866 | primary | changed: option added 2026-06-12 09:30:06.779316 | primary | changed: option added 2026-06-12 09:30:13.265056 | primary | changed: option added 2026-06-12 09:30:13.272661 | 2026-06-12 09:30:13.272897 | PLAY RECAP 2026-06-12 09:30:13.273001 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-12 09:30:13.273060 | primary | ok: 8 changed: 5 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-06-12 09:30:13.273140 | 2026-06-12 09:30:13.439107 | PRE-RUN END RESULT_NORMAL: [trusted : gitlab.com/softwarefactory-project/centosinfra-prod/sf-config/playbooks/base/pre.yaml@main] 2026-06-12 09:30:13.441240 | PRE-RUN START: [trusted : gitlab.com/softwarefactory-project/centosinfra-prod/sf-config/playbooks/rhel_subscription/register.yaml@main] 2026-06-12 09:30:14.113800 | 2026-06-12 09:30:14.113938 | PLAY [all] 2026-06-12 09:30:14.123161 | 2026-06-12 09:30:14.123252 | TASK [Register system] 2026-06-12 09:30:14.174034 | 2026-06-12 09:30:14.174266 | TASK [Get minor release for EUS activation] 2026-06-12 09:30:14.249973 | primary | skipping: Conditional result was False 2026-06-12 09:30:14.257963 | 2026-06-12 09:30:14.258172 | LOOP [Manage Extended Update Support repos] 2026-06-12 09:30:14.324687 | primary | skipping: Conditional result was False 2026-06-12 09:30:14.329017 | primary | skipping: Conditional result was False 2026-06-12 09:30:14.345137 | 2026-06-12 09:30:14.345414 | TASK [Upgrade all packages] 2026-06-12 09:30:14.401987 | primary | skipping: Conditional result was False 2026-06-12 09:30:14.411152 | 2026-06-12 09:30:14.411303 | TASK [Reboot to use new kernel] 2026-06-12 09:30:14.477675 | primary | skipping: Conditional result was False 2026-06-12 09:30:14.480073 | 2026-06-12 09:30:14.480180 | PLAY RECAP 2026-06-12 09:30:14.480325 | primary | ok: 0 changed: 0 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2026-06-12 09:30:14.480415 | 2026-06-12 09:30:14.619233 | PRE-RUN END RESULT_NORMAL: [trusted : gitlab.com/softwarefactory-project/centosinfra-prod/sf-config/playbooks/rhel_subscription/register.yaml@main] 2026-06-12 09:30:14.621991 | RUN START: [untrusted : gitlab.com/softwarefactory-project/premetal/playbooks/unit-tests.yaml@main] 2026-06-12 09:30:15.309085 | 2026-06-12 09:30:15.309262 | PLAY [all] 2026-06-12 09:30:15.319214 | 2026-06-12 09:30:15.319339 | TASK [Install uv] 2026-06-12 09:30:32.397902 | primary | changed 2026-06-12 09:30:32.406752 | 2026-06-12 09:30:32.406920 | TASK [Run nox] 2026-06-12 09:30:37.719461 | primary | Using CPython 3.14.2 interpreter at: /usr/sbin/python3 2026-06-12 09:30:37.719705 | primary | Creating virtual environment at: .venv 2026-06-12 09:30:38.427472 | primary | Building zironic @ file:///workspace/src/gitlab.com/softwarefactory-project/premetal 2026-06-12 09:30:38.450778 | primary | Downloading cryptography (4.3MiB) 2026-06-12 09:30:38.453363 | primary | Downloading ruff (13.2MiB) 2026-06-12 09:30:38.453552 | primary | Downloading setuptools (1.1MiB) 2026-06-12 09:30:38.453798 | primary | Downloading pygments (1.2MiB) 2026-06-12 09:30:38.454652 | primary | Downloading uvloop (4.1MiB) 2026-06-12 09:30:38.455068 | primary | Downloading virtualenv (5.7MiB) 2026-06-12 09:30:38.465458 | primary | Downloading pydantic-core (2.0MiB) 2026-06-12 09:30:38.486530 | primary | Downloading ansible-core (2.3MiB) 2026-06-12 09:30:38.486830 | primary | Downloading ansible (51.1MiB) 2026-06-12 09:30:38.494530 | primary | Downloading openstacksdk (1.8MiB) 2026-06-12 09:30:38.945223 | primary | Downloaded pydantic-core 2026-06-12 09:30:38.958074 | primary | Downloaded pygments 2026-06-12 09:30:39.096237 | primary | Downloaded setuptools 2026-06-12 09:30:39.158542 | primary | Downloaded uvloop 2026-06-12 09:30:39.194391 | primary | Downloaded cryptography 2026-06-12 09:30:39.211123 | primary | Downloaded virtualenv 2026-06-12 09:30:39.325256 | primary | Downloaded ruff 2026-06-12 09:30:39.433743 | primary | Downloaded ansible-core 2026-06-12 09:30:39.458475 | primary | Downloaded openstacksdk 2026-06-12 09:30:40.731086 | primary | Built zironic @ file:///workspace/src/gitlab.com/softwarefactory-project/premetal 2026-06-12 09:30:47.053591 | primary | Downloaded ansible 2026-06-12 09:30:54.446094 | primary | Installed 71 packages in 7.39s 2026-06-12 09:30:54.800982 | primary | nox > Running session test 2026-06-12 09:30:54.801241 | primary | nox > Creating virtual environment (virtualenv) using python in .nox/test 2026-06-12 09:30:56.036329 | primary | nox > python -m pip install -e '.[dev]' 2026-06-12 09:31:46.070906 | primary | nox > pytest -c pyproject.toml 2026-06-12 09:31:48.485667 | primary | ============================= test session starts ============================== 2026-06-12 09:31:48.485800 | primary | platform linux -- Python 3.14.2, pytest-9.0.3, pluggy-1.6.0 2026-06-12 09:31:48.485820 | primary | rootdir: /workspace/src/gitlab.com/softwarefactory-project/premetal 2026-06-12 09:31:48.485834 | primary | configfile: pyproject.toml 2026-06-12 09:31:48.485846 | primary | plugins: anyio-4.13.0, cov-7.1.0, asyncio-1.4.0, respx-0.23.1 2026-06-12 09:31:48.485858 | primary | asyncio: mode=Mode.AUTO, debug=False, asyncio_default_fixture_loop_scope=None, asyncio_default_test_loop_scope=function 2026-06-12 09:31:48.485869 | primary | collected 106 items 2026-06-12 09:31:48.485881 | primary | 2026-06-12 09:31:48.500542 | primary | tests/test_ansible_async.py .... [ 3%] 2026-06-12 09:31:48.508401 | primary | tests/test_ansible_provisioner.py .... [ 7%] 2026-06-12 09:32:08.310263 | primary | tests/test_api_contract.py ............................................. [ 50%] 2026-06-12 09:32:09.725080 | primary | ............. [ 62%] 2026-06-12 09:32:10.981959 | primary | tests/test_foreman_async.py ......... [ 70%] 2026-06-12 09:32:11.220167 | primary | tests/test_git_hash_tracking.py .... [ 74%] 2026-06-12 09:32:11.379410 | primary | tests/test_proactive_provisioner.py ...... [ 80%] 2026-06-12 09:32:11.701185 | primary | tests/test_reverse_proxy.py ....... [ 86%] 2026-06-12 09:32:11.708832 | primary | tests/test_scheduler.py ..... [ 91%] 2026-06-12 09:32:12.445882 | primary | tests/test_state_healing.py ......... [100%] 2026-06-12 09:32:12.445928 | primary | 2026-06-12 09:32:12.445934 | primary | =============================== warnings summary =============================== 2026-06-12 09:32:12.445940 | primary | .nox/test/lib/python3.14/site-packages/fastapi/testclient.py:1 2026-06-12 09:32:12.445953 | primary | /workspace/src/gitlab.com/softwarefactory-project/premetal/.nox/test/lib/python3.14/site-packages/fastapi/testclient.py:1: StarletteDeprecationWarning: Using `httpx` with `starlette.testclient` is deprecated; install `httpx2` instead. 2026-06-12 09:32:12.445983 | primary | from starlette.testclient import TestClient as TestClient # noqa 2026-06-12 09:32:12.445989 | primary | 2026-06-12 09:32:12.445994 | primary | -- Docs: https://docs.pytest.org/en/stable/how-to/capture-warnings.html 2026-06-12 09:32:12.445999 | primary | ================================ tests coverage ================================ 2026-06-12 09:32:12.446003 | primary | _______________ coverage: platform linux, python 3.14.2-final-0 ________________ 2026-06-12 09:32:12.446008 | primary | 2026-06-12 09:32:12.446015 | primary | Name Stmts Miss Cover Missing 2026-06-12 09:32:12.446020 | primary | ------------------------------------------------------------------- 2026-06-12 09:32:12.446025 | primary | src/premetal/__init__.py 0 0 100% 2026-06-12 09:32:12.446029 | primary | src/premetal/ansible_provisioner.py 51 6 88% 45, 78-81, 84-85 2026-06-12 09:32:12.446034 | primary | src/premetal/ansible_runner.py 86 15 83% 24, 28-31, 35-38, 122, 168, 232, 236-241, 260-263 2026-06-12 09:32:12.446039 | primary | src/premetal/config.py 38 0 100% 2026-06-12 09:32:12.446044 | primary | src/premetal/foreman_manager.py 103 14 86% 33-34, 44-50, 113, 148-151, 195-199 2026-06-12 09:32:12.446051 | primary | src/premetal/main.py 1131 174 85% 59, 142-144, 149-165, 180-183, 267-280, 361, 405, 409, 422, 426, 445-446, 462-512, 588-596, 602-605, 620-621, 639-642, 648, 705, 818, 820, 853, 895-899, 953, 1020-1032, 1070-1074, 1181, 1183-1184, 1192, 1206-1207, 1230, 1246, 1250-1253, 1267-1268, 1301-1312, 1352, 1402-1403, 1456-1458, 1462-1467, 1477-1482, 1497-1499, 1579, 1584, 1591-1593, 1661, 1762, 1789, 1873-1877, 1972-1975, 2004, 2062, 2084, 2131, 2135, 2170, 2174, 2218, 2228-2229, 2268-2280, 2302, 2321-2323, 2404 2026-06-12 09:32:12.446056 | primary | ------------------------------------------------------------------- 2026-06-12 09:32:12.446061 | primary | TOTAL 1409 209 85% 2026-06-12 09:32:12.446066 | primary | Required test coverage of 83.0% reached. Total coverage: 85.17% 2026-06-12 09:32:12.446071 | primary | ======================= 106 passed, 1 warning in 24.82s ======================== 2026-06-12 09:32:12.878166 | primary | nox > Session test was successful in a minute. 2026-06-12 09:32:12.878299 | primary | nox > Running session lint 2026-06-12 09:32:12.878591 | primary | nox > Creating virtual environment (virtualenv) using python in .nox/lint 2026-06-12 09:32:13.258321 | primary | nox > python -m pip install ruff 2026-06-12 09:32:15.229231 | primary | nox > ruff check src tests noxfile.py 2026-06-12 09:32:15.258965 | primary | All checks passed! 2026-06-12 09:32:15.262777 | primary | nox > Session lint was successful in 2 seconds. 2026-06-12 09:32:15.262824 | primary | nox > Ran 2 sessions in a minute: 2026-06-12 09:32:15.262857 | primary | nox > * test: success, took a minute 2026-06-12 09:32:15.262886 | primary | nox > * lint: success, took 2 seconds 2026-06-12 09:32:16.534266 | primary | ok: Runtime: 0:01:37.782047 2026-06-12 09:32:16.539957 | 2026-06-12 09:32:16.540094 | PLAY RECAP 2026-06-12 09:32:16.540182 | primary | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-12 09:32:16.540225 | 2026-06-12 09:32:16.745081 | RUN END RESULT_NORMAL: [untrusted : gitlab.com/softwarefactory-project/premetal/playbooks/unit-tests.yaml@main] 2026-06-12 09:32:16.746498 | POST-RUN START: [trusted : gitlab.com/softwarefactory-project/centosinfra-prod/sf-config/playbooks/base/post.yaml@main] 2026-06-12 09:32:17.461713 | 2026-06-12 09:32:17.461868 | PLAY [all] 2026-06-12 09:32:17.470887 | 2026-06-12 09:32:17.470977 | TASK [include_role : fetch-output] 2026-06-12 09:32:17.495682 | primary | skipping: Conditional result was False 2026-06-12 09:32:17.501370 | 2026-06-12 09:32:17.501450 | TASK [include_role : fetch-output-openshift] 2026-06-12 09:32:17.541866 | primary | ok 2026-06-12 09:32:17.558020 | 2026-06-12 09:32:17.558143 | TASK [fetch-output-openshift : Set log path for multiple nodes] 2026-06-12 09:32:17.624731 | primary | skipping: Conditional result was False 2026-06-12 09:32:17.632627 | 2026-06-12 09:32:17.632766 | TASK [fetch-output-openshift : Set log path for single node] 2026-06-12 09:32:17.686193 | primary | ok 2026-06-12 09:32:17.692777 | 2026-06-12 09:32:17.692910 | LOOP [fetch-output-openshift : Ensure local output dirs] 2026-06-12 09:32:18.138142 | primary -> localhost | changed: "/var/lib/zuul/builds/c28fa9822cf14c62b4cb1a0672c6fadf/work/logs" 2026-06-12 09:32:18.446200 | primary -> localhost | changed: "/var/lib/zuul/builds/c28fa9822cf14c62b4cb1a0672c6fadf/work/logs/npm" 2026-06-12 09:32:18.706456 | primary -> localhost | changed: "/var/lib/zuul/builds/c28fa9822cf14c62b4cb1a0672c6fadf/work/artifacts" 2026-06-12 09:32:18.985809 | primary -> localhost | changed: "/var/lib/zuul/builds/c28fa9822cf14c62b4cb1a0672c6fadf/work/docs" 2026-06-12 09:32:19.003815 | 2026-06-12 09:32:19.003983 | LOOP [fetch-output-openshift : Include rsync tasks] 2026-06-12 09:32:19.086917 | primary | ok: 2026-06-12 09:32:19.087204 | primary | [ 2026-06-12 09:32:19.087261 | primary | "primary", 2026-06-12 09:32:19.087305 | primary | { 2026-06-12 09:32:19.087381 | primary | "context": "main:zuul-worker/38-102-83-139:9023", 2026-06-12 09:32:19.087433 | primary | "namespace": "main", 2026-06-12 09:32:19.087474 | primary | "pod": "zuul-worker-fedora-stable-0000071676", 2026-06-12 09:32:19.087512 | primary | "resources": { 2026-06-12 09:32:19.087550 | primary | "cores": 0, 2026-06-12 09:32:19.087588 | primary | "instances": 1, 2026-06-12 09:32:19.087626 | primary | "ram": 0 2026-06-12 09:32:19.087663 | primary | }, 2026-06-12 09:32:19.087705 | primary | "stream_port1": 45603, 2026-06-12 09:32:19.087744 | primary | "stream_port2": 44509 2026-06-12 09:32:19.087782 | primary | } 2026-06-12 09:32:19.087820 | primary | ] 2026-06-12 09:32:19.087877 | primary | changed: All items complete 2026-06-12 09:32:19.087921 | 2026-06-12 09:32:19.105920 | primary | included: /var/lib/zuul/builds/c28fa9822cf14c62b4cb1a0672c6fadf/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/fetch-output-openshift/tasks/rsync.yaml 2026-06-12 09:32:19.119653 | 2026-06-12 09:32:19.119842 | LOOP [fetch-output-openshift : Fetch zuul-output from the pod] 2026-06-12 09:32:24.766217 | primary | Output suppressed because no_log was given 2026-06-12 09:32:24.774379 | 2026-06-12 09:32:24.774514 | TASK [fetch-output-openshift : Remove empty directory] 2026-06-12 09:32:25.133457 | primary -> localhost | ok: Runtime: 0:00:00.017196 2026-06-12 09:32:25.148398 | 2026-06-12 09:32:25.148569 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-12 09:32:25.480022 | primary -> localhost | find: ‘/var/lib/zuul/builds/c28fa9822cf14c62b4cb1a0672c6fadf/work/artifacts’: No such file or directory 2026-06-12 09:32:25.480459 | primary -> localhost | find: ‘/var/lib/zuul/builds/c28fa9822cf14c62b4cb1a0672c6fadf/work/artifacts’: No such file or directory 2026-06-12 09:32:25.480565 | primary -> localhost | ok: Item: artifacts Runtime: 0:00:00.015073 2026-06-12 09:32:25.737550 | primary -> localhost | find: ‘/var/lib/zuul/builds/c28fa9822cf14c62b4cb1a0672c6fadf/work/docs’: No such file or directory 2026-06-12 09:32:25.737887 | primary -> localhost | find: ‘/var/lib/zuul/builds/c28fa9822cf14c62b4cb1a0672c6fadf/work/docs’: No such file or directory 2026-06-12 09:32:25.737968 | primary -> localhost | ok: Item: docs Runtime: 0:00:00.012297 2026-06-12 09:32:25.761644 | 2026-06-12 09:32:25.761849 | PLAY [localhost] 2026-06-12 09:32:25.775994 | 2026-06-12 09:32:25.776237 | TASK [add-fileserver : Create SSH private key tempfile] 2026-06-12 09:32:26.191748 | localhost | changed 2026-06-12 09:32:26.195977 | 2026-06-12 09:32:26.196041 | TASK [add-fileserver : Create SSH private key from secret] 2026-06-12 09:32:27.049488 | localhost | changed 2026-06-12 09:32:27.056825 | 2026-06-12 09:32:27.056945 | TASK [add-fileserver : Add fileserver ssh key] 2026-06-12 09:32:27.431966 | localhost | Identity added: /var/lib/zuul/builds/c28fa9822cf14c62b4cb1a0672c6fadf/work/tmp/ansible.okx6zgan (/var/lib/zuul/builds/c28fa9822cf14c62b4cb1a0672c6fadf/work/tmp/ansible.okx6zgan) 2026-06-12 09:32:27.432418 | localhost | ok: Runtime: 0:00:00.022188 2026-06-12 09:32:27.442604 | 2026-06-12 09:32:27.442759 | TASK [add-fileserver : Remove SSH private key from disk] 2026-06-12 09:32:27.893183 | localhost | ok: Runtime: 0:00:00.010207 2026-06-12 09:32:27.897980 | 2026-06-12 09:32:27.898057 | TASK [add-fileserver : Add fileserver to inventory] 2026-06-12 09:32:27.981331 | localhost | changed 2026-06-12 09:32:27.988857 | 2026-06-12 09:32:27.988987 | TASK [add-fileserver : Add fileserver server to known hosts] 2026-06-12 09:32:28.459212 | localhost | changed 2026-06-12 09:32:28.472785 | 2026-06-12 09:32:28.472930 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-12 09:32:28.908981 | localhost | changed 2026-06-12 09:32:28.931115 | 2026-06-12 09:32:28.931302 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-12 09:32:28.965276 | localhost | ok 2026-06-12 09:32:28.977637 | 2026-06-12 09:32:28.977790 | TASK [zuul_return] 2026-06-12 09:32:29.044451 | localhost | skipping: Conditional result was False 2026-06-12 09:32:29.049041 | 2026-06-12 09:32:29.049142 | PLAY [a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com] 2026-06-12 09:32:29.056925 | 2026-06-12 09:32:29.057061 | TASK [Set zuul-log-path fact] 2026-06-12 09:32:29.086563 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | ok 2026-06-12 09:32:29.101489 | 2026-06-12 09:32:29.101713 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-12 09:32:29.151443 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | ok 2026-06-12 09:32:29.155165 | 2026-06-12 09:32:29.155248 | TASK [upload-logs : Create log directories] 2026-06-12 09:32:29.939120 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | changed 2026-06-12 09:32:29.942812 | 2026-06-12 09:32:29.942941 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-12 09:32:30.307246 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com -> localhost | ok: Runtime: 0:00:00.008045 2026-06-12 09:32:30.313567 | 2026-06-12 09:32:30.313694 | TASK [upload-logs : Upload logs to log server] 2026-06-12 09:32:31.452681 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | changed: 2026-06-12 09:32:31.452990 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | .d..tp..... ./ 2026-06-12 09:32:31.453027 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com |