2026-05-19 03:04:15.462461 | Job console starting 2026-05-19 03:04:15.471928 | Updating git repos 2026-05-19 03:04:15.492483 | Cloning repos into workspace 2026-05-19 03:04:15.580375 | Restoring repo states 2026-05-19 03:04:15.603895 | Merging changes 2026-05-19 03:04:15.603911 | Checking out repos 2026-05-19 03:04:15.705852 | Preparing playbooks 2026-05-19 03:04:16.766792 | Running Ansible setup 2026-05-19 03:04:22.330324 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-19 03:04:23.507397 | 2026-05-19 03:04:23.507526 | PLAY [Base pre] 2026-05-19 03:04:23.524071 | 2026-05-19 03:04:23.524191 | TASK [Setup log path fact] 2026-05-19 03:04:23.542590 | debian-bookworm | ok 2026-05-19 03:04:23.559725 | 2026-05-19 03:04:23.559851 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-19 03:04:23.590166 | debian-bookworm | ok 2026-05-19 03:04:23.601253 | 2026-05-19 03:04:23.601361 | TASK [emit-job-header : Print job information] 2026-05-19 03:04:23.641009 | # Job Information 2026-05-19 03:04:23.641174 | Ansible Version: 2.16.14 2026-05-19 03:04:23.641208 | Job: container-image-inventory-reconciler-unit-tests 2026-05-19 03:04:23.641242 | Pipeline: periodic-daily 2026-05-19 03:04:23.641265 | Executor: 521e9411259a 2026-05-19 03:04:23.641285 | Triggered by: https://github.com/osism/container-image-inventory-reconciler 2026-05-19 03:04:23.641307 | Event ID: 88a796ab4b52417fb3b270541450b9a1 2026-05-19 03:04:23.646132 | 2026-05-19 03:04:23.646239 | LOOP [emit-job-header : Print node information] 2026-05-19 03:04:23.752586 | debian-bookworm | ok: 2026-05-19 03:04:23.752828 | debian-bookworm | # Node Information 2026-05-19 03:04:23.752865 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-19 03:04:23.752890 | debian-bookworm | Hostname: debian 2026-05-19 03:04:23.752912 | debian-bookworm | Username: zuul 2026-05-19 03:04:23.752944 | debian-bookworm | Distro: Debian 12.14 2026-05-19 03:04:23.752973 | debian-bookworm | Provider: regiocloud-a 2026-05-19 03:04:23.752998 | debian-bookworm | Region: 2026-05-19 03:04:23.753019 | debian-bookworm | Label: debian-bookworm 2026-05-19 03:04:23.753039 | debian-bookworm | Product Name: OpenStack Nova 2026-05-19 03:04:23.753058 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feac:15a1 2026-05-19 03:04:23.773243 | 2026-05-19 03:04:23.773365 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-19 03:04:24.347372 | debian-bookworm -> localhost | changed 2026-05-19 03:04:24.354439 | 2026-05-19 03:04:24.354551 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-19 03:04:25.362512 | debian-bookworm -> localhost | changed 2026-05-19 03:04:25.371168 | 2026-05-19 03:04:25.371252 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-19 03:04:25.757354 | debian-bookworm -> localhost | ok 2026-05-19 03:04:25.764048 | 2026-05-19 03:04:25.764165 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-19 03:04:25.791789 | debian-bookworm | ok 2026-05-19 03:04:25.827166 | debian-bookworm | included: /var/lib/zuul/builds/493fdb6c59bf4efd91791db600f03db4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-19 03:04:25.835376 | 2026-05-19 03:04:25.835472 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-19 03:04:27.310098 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-19 03:04:27.310296 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/493fdb6c59bf4efd91791db600f03db4/work/493fdb6c59bf4efd91791db600f03db4_id_rsa 2026-05-19 03:04:27.310332 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/493fdb6c59bf4efd91791db600f03db4/work/493fdb6c59bf4efd91791db600f03db4_id_rsa.pub 2026-05-19 03:04:27.310357 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-19 03:04:27.310380 | debian-bookworm -> localhost | SHA256:tb/NWRPyBgXRVcclAp/u1laMfrZrIXZHvtlJucq+7ok zuul-build-sshkey 2026-05-19 03:04:27.310411 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-19 03:04:27.310432 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-19 03:04:27.310453 | debian-bookworm -> localhost | | ...o+.O| 2026-05-19 03:04:27.310473 | debian-bookworm -> localhost | | . o.oo| 2026-05-19 03:04:27.310492 | debian-bookworm -> localhost | | . o . | 2026-05-19 03:04:27.310511 | debian-bookworm -> localhost | | . o .o.| 2026-05-19 03:04:27.310531 | debian-bookworm -> localhost | | S . .o.++| 2026-05-19 03:04:27.310560 | debian-bookworm -> localhost | | o =+*+| 2026-05-19 03:04:27.310582 | debian-bookworm -> localhost | | = B+%| 2026-05-19 03:04:27.310603 | debian-bookworm -> localhost | | .o=o@+| 2026-05-19 03:04:27.310625 | debian-bookworm -> localhost | | E=OBo.| 2026-05-19 03:04:27.310646 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-19 03:04:27.310695 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.881533 2026-05-19 03:04:27.316970 | 2026-05-19 03:04:27.317073 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-19 03:04:27.337080 | debian-bookworm | ok 2026-05-19 03:04:27.349143 | debian-bookworm | included: /var/lib/zuul/builds/493fdb6c59bf4efd91791db600f03db4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-19 03:04:27.359520 | 2026-05-19 03:04:27.359677 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-19 03:04:27.383053 | debian-bookworm | skipping: Conditional result was False 2026-05-19 03:04:27.388793 | 2026-05-19 03:04:27.388887 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-19 03:04:28.017194 | debian-bookworm | changed 2026-05-19 03:04:28.022762 | 2026-05-19 03:04:28.023034 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-19 03:04:28.276294 | debian-bookworm | ok 2026-05-19 03:04:28.281640 | 2026-05-19 03:04:28.281731 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-19 03:04:28.937105 | debian-bookworm | changed 2026-05-19 03:04:28.942534 | 2026-05-19 03:04:28.942618 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-19 03:04:29.712300 | debian-bookworm | changed 2026-05-19 03:04:29.718307 | 2026-05-19 03:04:29.718398 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-19 03:04:29.741377 | debian-bookworm | skipping: Conditional result was False 2026-05-19 03:04:29.747899 | 2026-05-19 03:04:29.748100 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-19 03:04:30.250070 | debian-bookworm -> localhost | changed 2026-05-19 03:04:30.269017 | 2026-05-19 03:04:30.269187 | TASK [add-build-sshkey : Add back temp key] 2026-05-19 03:04:30.627687 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/493fdb6c59bf4efd91791db600f03db4/work/493fdb6c59bf4efd91791db600f03db4_id_rsa (zuul-build-sshkey) 2026-05-19 03:04:30.627894 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011066 2026-05-19 03:04:30.635328 | 2026-05-19 03:04:30.635431 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-19 03:04:31.063753 | debian-bookworm | ok 2026-05-19 03:04:31.077016 | 2026-05-19 03:04:31.077126 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-19 03:04:31.125867 | debian-bookworm | skipping: Conditional result was False 2026-05-19 03:04:31.137043 | 2026-05-19 03:04:31.137157 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-19 03:04:31.712683 | debian-bookworm | ok 2026-05-19 03:04:31.728590 | 2026-05-19 03:04:31.728709 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-19 03:04:31.759334 | debian-bookworm | ok 2026-05-19 03:04:31.768965 | 2026-05-19 03:04:31.769091 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-19 03:04:32.440429 | debian-bookworm -> localhost | ok 2026-05-19 03:04:32.447902 | 2026-05-19 03:04:32.448079 | TASK [validate-host : Collect information about the host] 2026-05-19 03:04:34.150942 | debian-bookworm | ok 2026-05-19 03:04:34.174570 | 2026-05-19 03:04:34.174725 | TASK [validate-host : Sanitize hostname] 2026-05-19 03:04:34.451664 | debian-bookworm | ok 2026-05-19 03:04:34.570477 | 2026-05-19 03:04:34.570629 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-19 03:04:35.675404 | debian-bookworm -> localhost | changed 2026-05-19 03:04:35.689854 | 2026-05-19 03:04:35.690033 | TASK [validate-host : Collect information about zuul worker] 2026-05-19 03:04:36.212839 | debian-bookworm | ok 2026-05-19 03:04:36.218175 | 2026-05-19 03:04:36.218307 | TASK [validate-host : Write out all zuul information for each host] 2026-05-19 03:04:37.002737 | debian-bookworm -> localhost | changed 2026-05-19 03:04:37.013738 | 2026-05-19 03:04:37.013877 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-19 03:04:37.297877 | debian-bookworm | ok 2026-05-19 03:04:37.324649 | 2026-05-19 03:04:37.324815 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-19 03:04:38.355714 | debian-bookworm | changed: 2026-05-19 03:04:38.356010 | debian-bookworm | cd+++++++++ src/ 2026-05-19 03:04:38.356052 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-19 03:04:38.356075 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-19 03:04:38.356096 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-inventory-reconciler/ 2026-05-19 03:04:38.356117 | debian-bookworm | Containerfile 2026-05-19 03:04:38.356271 | debian-bookworm | =2.0 (from Jinja2==3.1.6->-r files/requirements.txt (line 1)) 2026-05-19 03:04:52.675319 | debian-bookworm | Downloading markupsafe-3.0.3-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl.metadata (2.7 kB) 2026-05-19 03:04:52.749104 | debian-bookworm | Collecting PyYAML>=5.1 (from ansible-core==2.19.3->-r files/requirements.txt (line 2)) 2026-05-19 03:04:52.760753 | debian-bookworm | Downloading pyyaml-6.0.3-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl.metadata (2.4 kB) 2026-05-19 03:04:53.040295 | debian-bookworm | Collecting cryptography (from ansible-core==2.19.3->-r files/requirements.txt (line 2)) 2026-05-19 03:04:53.051831 | debian-bookworm | Downloading cryptography-48.0.0-cp311-abi3-manylinux_2_34_x86_64.whl.metadata (4.3 kB) 2026-05-19 03:04:53.125524 | debian-bookworm | Collecting packaging (from ansible-core==2.19.3->-r files/requirements.txt (line 2)) 2026-05-19 03:04:53.138080 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl.metadata (3.5 kB) 2026-05-19 03:04:53.226484 | debian-bookworm | Collecting resolvelib<2.0.0,>=0.5.3 (from ansible-core==2.19.3->-r files/requirements.txt (line 2)) 2026-05-19 03:04:53.240204 | debian-bookworm | Downloading resolvelib-1.2.1-py3-none-any.whl.metadata (3.7 kB) 2026-05-19 03:04:53.307887 | debian-bookworm | Collecting requests<3.0,>=2.20.0 (from pynetbox==7.7.0->-r files/requirements.txt (line 5)) 2026-05-19 03:04:53.320123 | debian-bookworm | Downloading requests-2.34.2-py3-none-any.whl.metadata (4.8 kB) 2026-05-19 03:04:53.368306 | debian-bookworm | Collecting iniconfig>=1.0.1 (from pytest==9.0.3->-r files/test-requirements.txt (line 2)) 2026-05-19 03:04:53.382105 | debian-bookworm | Downloading iniconfig-2.3.0-py3-none-any.whl.metadata (2.5 kB) 2026-05-19 03:04:53.418654 | debian-bookworm | Collecting pluggy<2,>=1.5 (from pytest==9.0.3->-r files/test-requirements.txt (line 2)) 2026-05-19 03:04:53.430936 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl.metadata (4.8 kB) 2026-05-19 03:04:53.474325 | debian-bookworm | Collecting pygments>=2.7.2 (from pytest==9.0.3->-r files/test-requirements.txt (line 2)) 2026-05-19 03:04:53.485250 | debian-bookworm | Downloading pygments-2.20.0-py3-none-any.whl.metadata (2.5 kB) 2026-05-19 03:04:53.993275 | debian-bookworm | Collecting coverage>=7.10.6 (from coverage[toml]>=7.10.6->pytest-cov==7.1.0->-r files/test-requirements.txt (line 3)) 2026-05-19 03:04:54.005525 | debian-bookworm | Downloading coverage-7.14.0-cp311-cp311-manylinux1_x86_64.manylinux_2_28_x86_64.manylinux_2_5_x86_64.whl.metadata (8.5 kB) 2026-05-19 03:04:54.135294 | debian-bookworm | Collecting charset_normalizer<4,>=2 (from requests<3.0,>=2.20.0->pynetbox==7.7.0->-r files/requirements.txt (line 5)) 2026-05-19 03:04:54.147301 | debian-bookworm | Downloading charset_normalizer-3.4.7-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl.metadata (40 kB) 2026-05-19 03:04:54.201415 | debian-bookworm | Collecting idna<4,>=2.5 (from requests<3.0,>=2.20.0->pynetbox==7.7.0->-r files/requirements.txt (line 5)) 2026-05-19 03:04:54.212700 | debian-bookworm | Downloading idna-3.15-py3-none-any.whl.metadata (7.7 kB) 2026-05-19 03:04:54.262566 | debian-bookworm | Collecting urllib3<3,>=1.26 (from requests<3.0,>=2.20.0->pynetbox==7.7.0->-r files/requirements.txt (line 5)) 2026-05-19 03:04:54.274076 | debian-bookworm | Downloading urllib3-2.7.0-py3-none-any.whl.metadata (6.9 kB) 2026-05-19 03:04:54.328891 | debian-bookworm | Collecting certifi>=2023.5.7 (from requests<3.0,>=2.20.0->pynetbox==7.7.0->-r files/requirements.txt (line 5)) 2026-05-19 03:04:54.340797 | debian-bookworm | Downloading certifi-2026.4.22-py3-none-any.whl.metadata (2.5 kB) 2026-05-19 03:04:54.531311 | debian-bookworm | Collecting cffi>=2.0.0 (from cryptography->ansible-core==2.19.3->-r files/requirements.txt (line 2)) 2026-05-19 03:04:54.543981 | debian-bookworm | Downloading cffi-2.0.0-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.whl.metadata (2.6 kB) 2026-05-19 03:04:54.577830 | debian-bookworm | Collecting pycparser (from cffi>=2.0.0->cryptography->ansible-core==2.19.3->-r files/requirements.txt (line 2)) 2026-05-19 03:04:54.590182 | debian-bookworm | Downloading pycparser-3.0-py3-none-any.whl.metadata (8.2 kB) 2026-05-19 03:04:54.619920 | debian-bookworm | Downloading jinja2-3.1.6-py3-none-any.whl (134 kB) 2026-05-19 03:04:54.653621 | debian-bookworm | Downloading ansible_core-2.19.3-py3-none-any.whl (2.4 MB) 2026-05-19 03:04:54.755579 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.4/2.4 MB 23.5 MB/s 0:00:00 2026-05-19 03:04:54.767850 | debian-bookworm | Downloading dynaconf-3.2.13-py2.py3-none-any.whl (238 kB) 2026-05-19 03:04:54.793345 | debian-bookworm | Downloading netaddr-1.3.0-py3-none-any.whl (2.3 MB) 2026-05-19 03:04:54.881627 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.3/2.3 MB 25.5 MB/s 0:00:00 2026-05-19 03:04:54.896223 | debian-bookworm | Downloading pynetbox-7.7.0-py3-none-any.whl (40 kB) 2026-05-19 03:04:54.919462 | debian-bookworm | Downloading pytest-9.0.3-py3-none-any.whl (375 kB) 2026-05-19 03:04:54.948757 | debian-bookworm | Downloading pytest_cov-7.1.0-py3-none-any.whl (22 kB) 2026-05-19 03:04:54.971349 | debian-bookworm | Downloading pytest_mock-3.15.1-py3-none-any.whl (10 kB) 2026-05-19 03:04:54.993887 | debian-bookworm | Downloading loguru-0.7.3-py3-none-any.whl (61 kB) 2026-05-19 03:04:55.017354 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-05-19 03:04:55.041893 | debian-bookworm | Downloading requests-2.34.2-py3-none-any.whl (73 kB) 2026-05-19 03:04:55.064228 | debian-bookworm | Downloading charset_normalizer-3.4.7-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (214 kB) 2026-05-19 03:04:55.090390 | debian-bookworm | Downloading idna-3.15-py3-none-any.whl (72 kB) 2026-05-19 03:04:55.113804 | debian-bookworm | Downloading resolvelib-1.2.1-py3-none-any.whl (18 kB) 2026-05-19 03:04:55.135877 | debian-bookworm | Downloading urllib3-2.7.0-py3-none-any.whl (131 kB) 2026-05-19 03:04:55.157841 | debian-bookworm | Downloading certifi-2026.4.22-py3-none-any.whl (135 kB) 2026-05-19 03:04:55.183214 | debian-bookworm | Downloading coverage-7.14.0-cp311-cp311-manylinux1_x86_64.manylinux_2_28_x86_64.manylinux_2_5_x86_64.whl (252 kB) 2026-05-19 03:04:55.209911 | debian-bookworm | Downloading iniconfig-2.3.0-py3-none-any.whl (7.5 kB) 2026-05-19 03:04:55.234052 | debian-bookworm | Downloading markupsafe-3.0.3-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (22 kB) 2026-05-19 03:04:55.255061 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-05-19 03:04:55.277622 | debian-bookworm | Downloading pygments-2.20.0-py3-none-any.whl (1.2 MB) 2026-05-19 03:04:55.344824 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.2/1.2 MB 16.9 MB/s 0:00:00 2026-05-19 03:04:55.358660 | debian-bookworm | Downloading pyyaml-6.0.3-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (806 kB) 2026-05-19 03:04:55.399140 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 806.6/806.6 kB 16.6 MB/s 0:00:00 2026-05-19 03:04:55.411860 | debian-bookworm | Downloading cryptography-48.0.0-cp311-abi3-manylinux_2_34_x86_64.whl (4.7 MB) 2026-05-19 03:04:55.593826 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.7/4.7 MB 25.8 MB/s 0:00:00 2026-05-19 03:04:55.606896 | debian-bookworm | Downloading cffi-2.0.0-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.whl (215 kB) 2026-05-19 03:04:55.633369 | debian-bookworm | Downloading pycparser-3.0-py3-none-any.whl (48 kB) 2026-05-19 03:04:55.774791 | debian-bookworm | Installing collected packages: urllib3, resolvelib, PyYAML, pygments, pycparser, pluggy, packaging, netaddr, MarkupSafe, loguru, iniconfig, idna, dynaconf, coverage, charset_normalizer, certifi, requests, pytest, Jinja2, cffi, pytest-mock, pytest-cov, pynetbox, cryptography, ansible-core 2026-05-19 03:05:00.131899 | debian-bookworm | 2026-05-19 03:05:00.134308 | debian-bookworm | Successfully installed Jinja2-3.1.6 MarkupSafe-3.0.3 PyYAML-6.0.3 ansible-core-2.19.3 certifi-2026.4.22 cffi-2.0.0 charset_normalizer-3.4.7 coverage-7.14.0 cryptography-48.0.0 dynaconf-3.2.13 idna-3.15 iniconfig-2.3.0 loguru-0.7.3 netaddr-1.3.0 packaging-26.2 pluggy-1.6.0 pycparser-3.0 pygments-2.20.0 pynetbox-7.7.0 pytest-9.0.3 pytest-cov-7.1.0 pytest-mock-3.15.1 requests-2.34.2 resolvelib-1.2.1 urllib3-2.7.0 2026-05-19 03:05:00.346165 | debian-bookworm | ok: Runtime: 0:00:15.916244 2026-05-19 03:05:00.351290 | 2026-05-19 03:05:00.351380 | TASK [Run pytest] 2026-05-19 03:05:00.628054 | debian-bookworm | + /tmp/test-unit-venv/bin/pytest tests/unit 2026-05-19 03:05:01.042998 | debian-bookworm | ============================= test session starts ============================== 2026-05-19 03:05:01.043127 | debian-bookworm | platform linux -- Python 3.11.2, pytest-9.0.3, pluggy-1.6.0 2026-05-19 03:05:01.043154 | debian-bookworm | rootdir: /home/zuul/src/github.com/osism/container-image-inventory-reconciler 2026-05-19 03:05:01.043173 | debian-bookworm | configfile: pyproject.toml 2026-05-19 03:05:01.043187 | debian-bookworm | plugins: cov-7.1.0, mock-3.15.1 2026-05-19 03:05:01.043207 | debian-bookworm | collected 3 items 2026-05-19 03:05:01.043250 | debian-bookworm | 2026-05-19 03:05:01.108254 | debian-bookworm | tests/unit/netbox/test_smoke.py ... [100%] 2026-05-19 03:05:01.108355 | debian-bookworm | 2026-05-19 03:05:01.108372 | debian-bookworm | ============================== 3 passed in 0.14s =============================== 2026-05-19 03:05:01.379655 | debian-bookworm | ok: Runtime: 0:00:00.560272 2026-05-19 03:05:01.381156 | 2026-05-19 03:05:01.381220 | PLAY RECAP 2026-05-19 03:05:01.381274 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-19 03:05:01.381307 | 2026-05-19 03:05:01.481458 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/container-image-inventory-reconciler/playbooks/test-unit.yml@main] 2026-05-19 03:05:01.482751 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-19 03:05:02.347227 | 2026-05-19 03:05:02.347365 | PLAY [Base post-fetch] 2026-05-19 03:05:02.373938 | 2026-05-19 03:05:02.374072 | TASK [fetch-output : Set log path for multiple nodes] 2026-05-19 03:05:02.441374 | debian-bookworm | skipping: Conditional result was False 2026-05-19 03:05:02.461889 | 2026-05-19 03:05:02.462065 | TASK [fetch-output : Set log path for single node] 2026-05-19 03:05:02.510656 | debian-bookworm | ok 2026-05-19 03:05:02.517244 | 2026-05-19 03:05:02.517351 | LOOP [fetch-output : Ensure local output dirs] 2026-05-19 03:05:03.575418 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/493fdb6c59bf4efd91791db600f03db4/work/logs" 2026-05-19 03:05:04.586477 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/493fdb6c59bf4efd91791db600f03db4/work/artifacts" 2026-05-19 03:05:05.627988 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/493fdb6c59bf4efd91791db600f03db4/work/docs" 2026-05-19 03:05:05.662577 | 2026-05-19 03:05:05.662726 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-19 03:05:07.160107 | debian-bookworm | changed: 2026-05-19 03:05:07.160333 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-19 03:05:07.160371 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-19 03:05:07.160396 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-19 03:05:07.160436 | debian-bookworm | changed: All items complete 2026-05-19 03:05:07.160458 | 2026-05-19 03:05:07.665221 | debian-bookworm | changed: .d..t...... ./ 2026-05-19 03:05:08.315600 | debian-bookworm | changed: .d..t...... ./ 2026-05-19 03:05:08.331585 | 2026-05-19 03:05:08.331705 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-19 03:05:08.354068 | debian-bookworm | skipping: Conditional result was False 2026-05-19 03:05:08.358201 | debian-bookworm | skipping: Conditional result was False 2026-05-19 03:05:08.371694 | 2026-05-19 03:05:08.371772 | PLAY RECAP 2026-05-19 03:05:08.371819 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-19 03:05:08.371845 | 2026-05-19 03:05:08.609090 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-19 03:05:08.609827 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-19 03:05:10.386354 | 2026-05-19 03:05:10.386553 | PLAY [Base post] 2026-05-19 03:05:10.429885 | 2026-05-19 03:05:10.430088 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-19 03:05:12.018081 | debian-bookworm | changed 2026-05-19 03:05:12.040858 | 2026-05-19 03:05:12.040998 | PLAY RECAP 2026-05-19 03:05:12.041498 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-19 03:05:12.041583 | 2026-05-19 03:05:12.378199 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-19 03:05:12.379271 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-19 03:05:13.616226 | 2026-05-19 03:05:13.616366 | PLAY [Base post-logs] 2026-05-19 03:05:13.632907 | 2026-05-19 03:05:13.633047 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-19 03:05:14.411464 | localhost | changed 2026-05-19 03:05:14.443047 | 2026-05-19 03:05:14.443200 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-19 03:05:14.493362 | localhost | ok 2026-05-19 03:05:14.496287 | 2026-05-19 03:05:14.496373 | TASK [Set zuul-log-path fact] 2026-05-19 03:05:14.531844 | localhost | ok 2026-05-19 03:05:14.539650 | 2026-05-19 03:05:14.539757 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-19 03:05:14.593159 | localhost | ok 2026-05-19 03:05:14.596270 | 2026-05-19 03:05:14.596365 | TASK [upload-logs : Create log directories] 2026-05-19 03:05:15.672082 | localhost | changed 2026-05-19 03:05:15.674675 | 2026-05-19 03:05:15.674763 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-19 03:05:16.717849 | localhost -> localhost | ok: Runtime: 0:00:00.008008 2026-05-19 03:05:16.724160 | 2026-05-19 03:05:16.724709 | TASK [upload-logs : Upload logs to log server] 2026-05-19 03:05:18.088382 | localhost | Output suppressed because no_log was given 2026-05-19 03:05:18.096834 | 2026-05-19 03:05:18.098019 | LOOP [upload-logs : Compress console log and json output] 2026-05-19 03:05:18.152278 | localhost | skipping: Conditional result was False 2026-05-19 03:05:18.162499 | localhost | skipping: Conditional result was False 2026-05-19 03:05:18.168841 | 2026-05-19 03:05:18.168983 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-19 03:05:18.293028 | localhost | skipping: Conditional result was False 2026-05-19 03:05:18.293267 | 2026-05-19 03:05:18.300551 | localhost | skipping: Conditional result was False 2026-05-19 03:05:18.304073 | 2026-05-19 03:05:18.304172 | LOOP [upload-logs : Upload console log and json output]