2026-06-10 06:42:41.739855 | Job console starting 2026-06-10 06:42:41.787033 | Updating git repos 2026-06-10 06:42:41.849866 | Cloning repos into workspace 2026-06-10 06:42:41.930501 | Restoring repo states 2026-06-10 06:42:41.946279 | Merging changes 2026-06-10 06:42:42.471874 | Checking out repos 2026-06-10 06:42:42.565042 | Preparing playbooks 2026-06-10 06:42:44.246456 | Running Ansible setup 2026-06-10 06:42:49.889303 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-10 06:42:50.891337 | 2026-06-10 06:42:50.891482 | PLAY [Base pre] 2026-06-10 06:42:50.926589 | 2026-06-10 06:42:50.926716 | TASK [Setup log path fact] 2026-06-10 06:42:50.954652 | debian-bookworm | ok 2026-06-10 06:42:50.987223 | 2026-06-10 06:42:50.987360 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-10 06:42:51.035453 | debian-bookworm | ok 2026-06-10 06:42:51.055626 | 2026-06-10 06:42:51.055750 | TASK [emit-job-header : Print job information] 2026-06-10 06:42:51.125280 | # Job Information 2026-06-10 06:42:51.125444 | Ansible Version: 2.16.14 2026-06-10 06:42:51.125479 | Job: container-image-inventory-reconciler-unit-tests 2026-06-10 06:42:51.125512 | Pipeline: check 2026-06-10 06:42:51.125535 | Executor: 521e9411259a 2026-06-10 06:42:51.125556 | Triggered by: https://github.com/osism/container-image-inventory-reconciler/pull/545 2026-06-10 06:42:51.125578 | Event ID: 8dc5dd30-6497-11f1-8850-4bb94d1ce951 2026-06-10 06:42:51.130653 | 2026-06-10 06:42:51.130762 | LOOP [emit-job-header : Print node information] 2026-06-10 06:42:51.249288 | debian-bookworm | ok: 2026-06-10 06:42:51.250483 | debian-bookworm | # Node Information 2026-06-10 06:42:51.250554 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-10 06:42:51.250584 | debian-bookworm | Hostname: debian 2026-06-10 06:42:51.250607 | debian-bookworm | Username: zuul 2026-06-10 06:42:51.250629 | debian-bookworm | Distro: Debian 12.14 2026-06-10 06:42:51.250653 | debian-bookworm | Provider: regiocloud-a 2026-06-10 06:42:51.250674 | debian-bookworm | Region: 2026-06-10 06:42:51.250694 | debian-bookworm | Label: debian-bookworm 2026-06-10 06:42:51.250714 | debian-bookworm | Product Name: OpenStack Nova 2026-06-10 06:42:51.250734 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feed:4347 2026-06-10 06:42:51.267232 | 2026-06-10 06:42:51.267332 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-10 06:42:51.687377 | debian-bookworm -> localhost | changed 2026-06-10 06:42:51.693224 | 2026-06-10 06:42:51.693326 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-10 06:42:53.244346 | debian-bookworm -> localhost | changed 2026-06-10 06:42:53.264944 | 2026-06-10 06:42:53.265043 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-10 06:42:53.611959 | debian-bookworm -> localhost | ok 2026-06-10 06:42:53.616865 | 2026-06-10 06:42:53.616956 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-10 06:42:53.634649 | debian-bookworm | ok 2026-06-10 06:42:53.651274 | debian-bookworm | included: /var/lib/zuul/builds/3f507f051c994180900f65316bcf23ec/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-10 06:42:53.660728 | 2026-06-10 06:42:53.660810 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-10 06:42:54.882762 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-10 06:42:54.882936 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/3f507f051c994180900f65316bcf23ec/work/3f507f051c994180900f65316bcf23ec_id_rsa 2026-06-10 06:42:54.882967 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/3f507f051c994180900f65316bcf23ec/work/3f507f051c994180900f65316bcf23ec_id_rsa.pub 2026-06-10 06:42:54.882987 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-10 06:42:54.883008 | debian-bookworm -> localhost | SHA256:DPhed1TZ9jL72qrqLvluIxqV+px0a87uKn4GgzcQoQM zuul-build-sshkey 2026-06-10 06:42:54.883038 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-10 06:42:54.883056 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-10 06:42:54.883074 | debian-bookworm -> localhost | |E .. .o | 2026-06-10 06:42:54.883092 | debian-bookworm -> localhost | | . ... .. o| 2026-06-10 06:42:54.883109 | debian-bookworm -> localhost | | o ... . ..| 2026-06-10 06:42:54.883125 | debian-bookworm -> localhost | | ... o . . o .| 2026-06-10 06:42:54.883141 | debian-bookworm -> localhost | | o. S . . + | 2026-06-10 06:42:54.883163 | debian-bookworm -> localhost | | ..=+ . . . | 2026-06-10 06:42:54.883179 | debian-bookworm -> localhost | | .++... . | 2026-06-10 06:42:54.883217 | debian-bookworm -> localhost | | .=*++. ..| 2026-06-10 06:42:54.883236 | debian-bookworm -> localhost | | .o==#%o..oo.| 2026-06-10 06:42:54.883253 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-10 06:42:54.883296 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.714979 2026-06-10 06:42:54.888283 | 2026-06-10 06:42:54.888365 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-10 06:42:54.926179 | debian-bookworm | ok 2026-06-10 06:42:54.935398 | debian-bookworm | included: /var/lib/zuul/builds/3f507f051c994180900f65316bcf23ec/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-10 06:42:54.941899 | 2026-06-10 06:42:54.941968 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-10 06:42:54.974813 | debian-bookworm | skipping: Conditional result was False 2026-06-10 06:42:54.980354 | 2026-06-10 06:42:54.980436 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-10 06:42:55.641327 | debian-bookworm | changed 2026-06-10 06:42:55.649326 | 2026-06-10 06:42:55.649438 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-10 06:42:55.930953 | debian-bookworm | ok 2026-06-10 06:42:55.943595 | 2026-06-10 06:42:55.943745 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-10 06:42:56.662915 | debian-bookworm | changed 2026-06-10 06:42:56.670942 | 2026-06-10 06:42:56.671071 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-10 06:42:57.319910 | debian-bookworm | changed 2026-06-10 06:42:57.324386 | 2026-06-10 06:42:57.324469 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-10 06:42:57.356836 | debian-bookworm | skipping: Conditional result was False 2026-06-10 06:42:57.361657 | 2026-06-10 06:42:57.361748 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-10 06:42:57.917118 | debian-bookworm -> localhost | changed 2026-06-10 06:42:57.933102 | 2026-06-10 06:42:57.933228 | TASK [add-build-sshkey : Add back temp key] 2026-06-10 06:42:58.213739 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/3f507f051c994180900f65316bcf23ec/work/3f507f051c994180900f65316bcf23ec_id_rsa (zuul-build-sshkey) 2026-06-10 06:42:58.213925 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.008092 2026-06-10 06:42:58.226436 | 2026-06-10 06:42:58.226548 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-10 06:42:58.665745 | debian-bookworm | ok 2026-06-10 06:42:58.674973 | 2026-06-10 06:42:58.675083 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-10 06:42:58.698103 | debian-bookworm | skipping: Conditional result was False 2026-06-10 06:42:58.714963 | 2026-06-10 06:42:58.715080 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-10 06:42:59.121948 | debian-bookworm | ok 2026-06-10 06:42:59.135176 | 2026-06-10 06:42:59.135296 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-10 06:42:59.187632 | debian-bookworm | ok 2026-06-10 06:42:59.192621 | 2026-06-10 06:42:59.192708 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-10 06:42:59.653003 | debian-bookworm -> localhost | ok 2026-06-10 06:42:59.658362 | 2026-06-10 06:42:59.658456 | TASK [validate-host : Collect information about the host] 2026-06-10 06:43:00.735010 | debian-bookworm | ok 2026-06-10 06:43:00.750902 | 2026-06-10 06:43:00.751008 | TASK [validate-host : Sanitize hostname] 2026-06-10 06:43:00.963183 | debian-bookworm | ok 2026-06-10 06:43:00.973250 | 2026-06-10 06:43:00.973346 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-10 06:43:01.581070 | debian-bookworm -> localhost | changed 2026-06-10 06:43:01.586455 | 2026-06-10 06:43:01.586549 | TASK [validate-host : Collect information about zuul worker] 2026-06-10 06:43:02.038981 | debian-bookworm | ok 2026-06-10 06:43:02.046053 | 2026-06-10 06:43:02.046169 | TASK [validate-host : Write out all zuul information for each host] 2026-06-10 06:43:02.768589 | debian-bookworm -> localhost | changed 2026-06-10 06:43:02.778415 | 2026-06-10 06:43:02.778543 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-10 06:43:03.052672 | debian-bookworm | ok 2026-06-10 06:43:03.061633 | 2026-06-10 06:43:03.061801 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-10 06:43:04.072142 | debian-bookworm | changed: 2026-06-10 06:43:04.072376 | debian-bookworm | cd+++++++++ src/ 2026-06-10 06:43:04.072411 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-10 06:43:04.072435 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-10 06:43:04.072456 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-inventory-reconciler/ 2026-06-10 06:43:04.072477 | debian-bookworm | Containerfile 2026-06-10 06:43:04.072634 | debian-bookworm | =2.0 (from Jinja2==3.1.6->-r files/requirements.txt (line 1)) 2026-06-10 06:43:51.138321 | 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-06-10 06:43:51.238978 | debian-bookworm | Collecting PyYAML>=5.1 (from ansible-core==2.19.3->-r files/requirements.txt (line 2)) 2026-06-10 06:43:51.251634 | 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-06-10 06:43:51.517227 | debian-bookworm | Collecting cryptography (from ansible-core==2.19.3->-r files/requirements.txt (line 2)) 2026-06-10 06:43:51.529145 | debian-bookworm | Downloading cryptography-48.0.1-cp311-abi3-manylinux_2_34_x86_64.whl.metadata (4.3 kB) 2026-06-10 06:43:51.568944 | debian-bookworm | Collecting packaging (from ansible-core==2.19.3->-r files/requirements.txt (line 2)) 2026-06-10 06:43:51.581045 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl.metadata (3.5 kB) 2026-06-10 06:43:51.616410 | debian-bookworm | Collecting resolvelib<2.0.0,>=0.5.3 (from ansible-core==2.19.3->-r files/requirements.txt (line 2)) 2026-06-10 06:43:51.629569 | debian-bookworm | Downloading resolvelib-1.2.1-py3-none-any.whl.metadata (3.7 kB) 2026-06-10 06:43:51.675545 | debian-bookworm | Collecting requests<3.0,>=2.20.0 (from pynetbox==7.7.0->-r files/requirements.txt (line 5)) 2026-06-10 06:43:51.687668 | debian-bookworm | Downloading requests-2.34.2-py3-none-any.whl.metadata (4.8 kB) 2026-06-10 06:43:51.721869 | debian-bookworm | Collecting iniconfig>=1.0.1 (from pytest==9.0.3->-r files/test-requirements.txt (line 2)) 2026-06-10 06:43:51.734054 | debian-bookworm | Downloading iniconfig-2.3.0-py3-none-any.whl.metadata (2.5 kB) 2026-06-10 06:43:51.771016 | debian-bookworm | Collecting pluggy<2,>=1.5 (from pytest==9.0.3->-r files/test-requirements.txt (line 2)) 2026-06-10 06:43:51.784322 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl.metadata (4.8 kB) 2026-06-10 06:43:51.829683 | debian-bookworm | Collecting pygments>=2.7.2 (from pytest==9.0.3->-r files/test-requirements.txt (line 2)) 2026-06-10 06:43:51.842068 | debian-bookworm | Downloading pygments-2.20.0-py3-none-any.whl.metadata (2.5 kB) 2026-06-10 06:43:52.376093 | 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-06-10 06:43:52.390134 | debian-bookworm | Downloading coverage-7.14.1-cp311-cp311-manylinux1_x86_64.manylinux_2_28_x86_64.manylinux_2_5_x86_64.whl.metadata (8.6 kB) 2026-06-10 06:43:52.541232 | 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-06-10 06:43:52.555798 | 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-06-10 06:43:52.610957 | 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-06-10 06:43:52.624769 | debian-bookworm | Downloading idna-3.18-py3-none-any.whl.metadata (6.1 kB) 2026-06-10 06:43:52.681107 | 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-06-10 06:43:52.693391 | debian-bookworm | Downloading urllib3-2.7.0-py3-none-any.whl.metadata (6.9 kB) 2026-06-10 06:43:52.741559 | 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-06-10 06:43:52.755168 | debian-bookworm | Downloading certifi-2026.5.20-py3-none-any.whl.metadata (2.5 kB) 2026-06-10 06:43:52.967372 | debian-bookworm | Collecting cffi>=2.0.0 (from cryptography->ansible-core==2.19.3->-r files/requirements.txt (line 2)) 2026-06-10 06:43:52.980007 | debian-bookworm | Downloading cffi-2.0.0-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.whl.metadata (2.6 kB) 2026-06-10 06:43:53.027278 | debian-bookworm | Collecting pycparser (from cffi>=2.0.0->cryptography->ansible-core==2.19.3->-r files/requirements.txt (line 2)) 2026-06-10 06:43:53.040443 | debian-bookworm | Downloading pycparser-3.0-py3-none-any.whl.metadata (8.2 kB) 2026-06-10 06:43:53.071253 | debian-bookworm | Downloading jinja2-3.1.6-py3-none-any.whl (134 kB) 2026-06-10 06:43:53.110663 | debian-bookworm | Downloading ansible_core-2.19.3-py3-none-any.whl (2.4 MB) 2026-06-10 06:43:53.220970 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.4/2.4 MB 22.0 MB/s 0:00:00 2026-06-10 06:43:53.235965 | debian-bookworm | Downloading dynaconf-3.2.13-py2.py3-none-any.whl (238 kB) 2026-06-10 06:43:53.263365 | debian-bookworm | Downloading netaddr-1.3.0-py3-none-any.whl (2.3 MB) 2026-06-10 06:43:53.365349 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.3/2.3 MB 21.4 MB/s 0:00:00 2026-06-10 06:43:53.380712 | debian-bookworm | Downloading pynetbox-7.7.0-py3-none-any.whl (40 kB) 2026-06-10 06:43:53.406582 | debian-bookworm | Downloading pytest-9.0.3-py3-none-any.whl (375 kB) 2026-06-10 06:43:53.443726 | debian-bookworm | Downloading pytest_cov-7.1.0-py3-none-any.whl (22 kB) 2026-06-10 06:43:53.466035 | debian-bookworm | Downloading pytest_mock-3.15.1-py3-none-any.whl (10 kB) 2026-06-10 06:43:53.489326 | debian-bookworm | Downloading loguru-0.7.3-py3-none-any.whl (61 kB) 2026-06-10 06:43:53.512878 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-06-10 06:43:53.536082 | debian-bookworm | Downloading requests-2.34.2-py3-none-any.whl (73 kB) 2026-06-10 06:43:53.561966 | 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-06-10 06:43:53.588881 | debian-bookworm | Downloading idna-3.18-py3-none-any.whl (65 kB) 2026-06-10 06:43:53.615373 | debian-bookworm | Downloading resolvelib-1.2.1-py3-none-any.whl (18 kB) 2026-06-10 06:43:53.639207 | debian-bookworm | Downloading urllib3-2.7.0-py3-none-any.whl (131 kB) 2026-06-10 06:43:53.663222 | debian-bookworm | Downloading certifi-2026.5.20-py3-none-any.whl (134 kB) 2026-06-10 06:43:53.689584 | debian-bookworm | Downloading coverage-7.14.1-cp311-cp311-manylinux1_x86_64.manylinux_2_28_x86_64.manylinux_2_5_x86_64.whl (252 kB) 2026-06-10 06:43:53.718777 | debian-bookworm | Downloading iniconfig-2.3.0-py3-none-any.whl (7.5 kB) 2026-06-10 06:43:53.742587 | 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-06-10 06:43:53.766086 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-06-10 06:43:53.792627 | debian-bookworm | Downloading pygments-2.20.0-py3-none-any.whl (1.2 MB) 2026-06-10 06:43:53.861044 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.2/1.2 MB 18.8 MB/s 0:00:00 2026-06-10 06:43:53.875542 | 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-06-10 06:43:53.923877 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 806.6/806.6 kB 13.9 MB/s 0:00:00 2026-06-10 06:43:53.938441 | debian-bookworm | Downloading cryptography-48.0.1-cp311-abi3-manylinux_2_34_x86_64.whl (4.7 MB) 2026-06-10 06:43:54.171649 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.7/4.7 MB 20.1 MB/s 0:00:00 2026-06-10 06:43:54.185385 | debian-bookworm | Downloading cffi-2.0.0-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.whl (215 kB) 2026-06-10 06:43:54.216256 | debian-bookworm | Downloading pycparser-3.0-py3-none-any.whl (48 kB) 2026-06-10 06:43:54.345583 | 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-06-10 06:43:58.787620 | debian-bookworm | 2026-06-10 06:43:58.792586 | debian-bookworm | Successfully installed Jinja2-3.1.6 MarkupSafe-3.0.3 PyYAML-6.0.3 ansible-core-2.19.3 certifi-2026.5.20 cffi-2.0.0 charset_normalizer-3.4.7 coverage-7.14.1 cryptography-48.0.1 dynaconf-3.2.13 idna-3.18 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-06-10 06:43:59.508690 | debian-bookworm | ok: Runtime: 0:00:16.088434 2026-06-10 06:43:59.515024 | 2026-06-10 06:43:59.515146 | TASK [Run pytest] 2026-06-10 06:43:59.850902 | debian-bookworm | + /tmp/test-unit-venv/bin/pytest tests/unit 2026-06-10 06:44:00.638578 | debian-bookworm | ============================= test session starts ============================== 2026-06-10 06:44:00.638713 | debian-bookworm | platform linux -- Python 3.11.2, pytest-9.0.3, pluggy-1.6.0 2026-06-10 06:44:00.638741 | debian-bookworm | rootdir: /home/zuul/src/github.com/osism/container-image-inventory-reconciler 2026-06-10 06:44:00.638760 | debian-bookworm | configfile: pyproject.toml 2026-06-10 06:44:00.638775 | debian-bookworm | plugins: mock-3.15.1, cov-7.1.0 2026-06-10 06:44:00.638800 | debian-bookworm | collected 259 items 2026-06-10 06:44:00.638866 | debian-bookworm | 2026-06-10 06:44:00.645276 | debian-bookworm | tests/unit/netbox/test_base_extractor.py ...... [ 2%] 2026-06-10 06:44:00.658778 | debian-bookworm | tests/unit/netbox/test_cache.py ............. [ 7%] 2026-06-10 06:44:00.688176 | debian-bookworm | tests/unit/netbox/test_config.py .......................... [ 17%] 2026-06-10 06:44:00.694822 | debian-bookworm | tests/unit/netbox/test_config_context_extractor.py ......... [ 20%] 2026-06-10 06:44:00.704988 | debian-bookworm | tests/unit/netbox/test_custom_field_extractor.py ............. [ 25%] 2026-06-10 06:44:00.722354 | debian-bookworm | tests/unit/netbox/test_device_mapping.py .................. [ 32%] 2026-06-10 06:44:00.728599 | debian-bookworm | tests/unit/netbox/test_exceptions.py ........ [ 35%] 2026-06-10 06:44:00.753063 | debian-bookworm | tests/unit/netbox/test_filters.py ...................................... [ 50%] 2026-06-10 06:44:00.759243 | debian-bookworm | ......... [ 54%] 2026-06-10 06:44:00.785483 | debian-bookworm | tests/unit/netbox/test_gnmic_extractor.py ........................... [ 64%] 2026-06-10 06:44:00.797773 | debian-bookworm | tests/unit/netbox/test_netplan_extractor.py ........... [ 68%] 2026-06-10 06:44:00.829208 | debian-bookworm | tests/unit/netbox/test_parallel_processor.py ................... [ 76%] 2026-06-10 06:44:00.838102 | debian-bookworm | tests/unit/netbox/test_primary_ip_extractor.py ....... [ 78%] 2026-06-10 06:44:00.858586 | debian-bookworm | tests/unit/netbox/test_retry_utils.py .................... [ 86%] 2026-06-10 06:44:00.868583 | debian-bookworm | tests/unit/netbox/test_secrets_extractor.py ............. [ 91%] 2026-06-10 06:44:00.870729 | debian-bookworm | tests/unit/netbox/test_smoke.py ... [ 92%] 2026-06-10 06:44:00.977416 | debian-bookworm | tests/unit/netbox/test_utils.py ................... [100%] 2026-06-10 06:44:00.977510 | debian-bookworm | 2026-06-10 06:44:00.977520 | debian-bookworm | ============================= 259 passed in 0.72s ============================== 2026-06-10 06:44:01.544111 | debian-bookworm | ok: Runtime: 0:00:01.250790 2026-06-10 06:44:01.548385 | 2026-06-10 06:44:01.548574 | PLAY RECAP 2026-06-10 06:44:01.548718 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-10 06:44:01.548789 | 2026-06-10 06:44:01.680204 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/container-image-inventory-reconciler/playbooks/test-unit.yml@main] 2026-06-10 06:44:01.681145 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-10 06:44:02.483339 | 2026-06-10 06:44:02.484059 | PLAY [Base post-fetch] 2026-06-10 06:44:02.501894 | 2026-06-10 06:44:02.502044 | TASK [diagnose-network : Ensure log directory exists] 2026-06-10 06:44:02.883056 | debian-bookworm | ok 2026-06-10 06:44:02.894876 | 2026-06-10 06:44:02.895069 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-06-10 06:44:08.931773 | debian-bookworm | ok: Runtime: 0:00:05.453972 2026-06-10 06:44:08.941898 | 2026-06-10 06:44:08.942073 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-06-10 06:44:09.484566 | debian-bookworm | ok: Runtime: 0:00:00.008287 2026-06-10 06:44:09.490658 | 2026-06-10 06:44:09.490806 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-06-10 06:44:10.023396 | debian-bookworm | ok: Runtime: 0:00:00.008482 2026-06-10 06:44:10.045233 | 2026-06-10 06:44:10.045465 | TASK [fetch-output : Set log path for multiple nodes] 2026-06-10 06:44:10.090797 | debian-bookworm | skipping: Conditional result was False 2026-06-10 06:44:10.101887 | 2026-06-10 06:44:10.102056 | TASK [fetch-output : Set log path for single node] 2026-06-10 06:44:10.154635 | debian-bookworm | ok 2026-06-10 06:44:10.160675 | 2026-06-10 06:44:10.160816 | LOOP [fetch-output : Ensure local output dirs] 2026-06-10 06:44:10.483586 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/3f507f051c994180900f65316bcf23ec/work/logs" 2026-06-10 06:44:10.914173 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/3f507f051c994180900f65316bcf23ec/work/artifacts" 2026-06-10 06:44:11.209148 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/3f507f051c994180900f65316bcf23ec/work/docs" 2026-06-10 06:44:11.231472 | 2026-06-10 06:44:11.231670 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-10 06:44:12.037397 | debian-bookworm | changed: 2026-06-10 06:44:12.037638 | debian-bookworm | .d..t...... ./ 2026-06-10 06:44:12.037678 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-06-10 06:44:12.037703 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-06-10 06:44:12.037725 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-10 06:44:12.037745 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-10 06:44:12.037765 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-10 06:44:12.037808 | debian-bookworm | changed: All items complete 2026-06-10 06:44:12.037835 | 2026-06-10 06:44:12.606066 | debian-bookworm | changed: .d..t...... ./ 2026-06-10 06:44:13.206383 | debian-bookworm | changed: .d..t...... ./ 2026-06-10 06:44:13.229726 | 2026-06-10 06:44:13.229884 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-10 06:44:13.601009 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.008103 2026-06-10 06:44:13.910429 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.008417 2026-06-10 06:44:13.925737 | 2026-06-10 06:44:13.925869 | PLAY RECAP 2026-06-10 06:44:13.925937 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-10 06:44:13.925969 | 2026-06-10 06:44:14.093738 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-10 06:44:14.094589 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-10 06:44:14.880735 | 2026-06-10 06:44:14.880903 | PLAY [Base post] 2026-06-10 06:44:14.894741 | 2026-06-10 06:44:14.894915 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-10 06:44:15.541975 | debian-bookworm | changed 2026-06-10 06:44:15.554356 | 2026-06-10 06:44:15.554491 | PLAY RECAP 2026-06-10 06:44:15.554557 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-10 06:44:15.554683 | 2026-06-10 06:44:15.718272 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-10 06:44:15.719520 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-10 06:44:16.562742 | 2026-06-10 06:44:16.562977 | PLAY [Base post-logs] 2026-06-10 06:44:16.574418 | 2026-06-10 06:44:16.574576 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-10 06:44:17.094412 | localhost | changed 2026-06-10 06:44:17.120591 | 2026-06-10 06:44:17.120772 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-10 06:44:17.177188 | localhost | ok 2026-06-10 06:44:17.183610 | 2026-06-10 06:44:17.183738 | TASK [Set zuul-log-path fact] 2026-06-10 06:44:17.213221 | localhost | ok 2026-06-10 06:44:17.223211 | 2026-06-10 06:44:17.223358 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-10 06:44:17.248533 | localhost | ok 2026-06-10 06:44:17.251774 | 2026-06-10 06:44:17.251886 | TASK [upload-logs : Create log directories] 2026-06-10 06:44:17.782031 | localhost | changed 2026-06-10 06:44:17.785504 | 2026-06-10 06:44:17.785638 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-10 06:44:18.286804 | localhost -> localhost | ok: Runtime: 0:00:00.007696 2026-06-10 06:44:18.290993 | 2026-06-10 06:44:18.291115 | TASK [upload-logs : Upload logs to log server] 2026-06-10 06:44:18.916523 | localhost | Output suppressed because no_log was given 2026-06-10 06:44:18.921384 | 2026-06-10 06:44:18.921684 | LOOP [upload-logs : Compress console log and json output] 2026-06-10 06:44:18.992174 | localhost | skipping: Conditional result was False 2026-06-10 06:44:18.998554 | localhost | skipping: Conditional result was False 2026-06-10 06:44:19.011340 | 2026-06-10 06:44:19.011712 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-10 06:44:19.090090 | localhost | skipping: Conditional result was False 2026-06-10 06:44:19.090687 | 2026-06-10 06:44:19.097411 | localhost | skipping: Conditional result was False 2026-06-10 06:44:19.106610 | 2026-06-10 06:44:19.106877 | LOOP [upload-logs : Upload console log and json output]