2025-04-08 18:00:42.615161 | Job console starting... 2025-04-08 18:00:42.631000 | Updating repositories 2025-04-08 18:00:42.684819 | Preparing job workspace 2025-04-08 18:00:44.455023 | Running Ansible setup... 2025-04-08 18:00:50.406883 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-04-08 18:00:51.138002 | 2025-04-08 18:00:51.138160 | PLAY [Base pre] 2025-04-08 18:00:51.167580 | 2025-04-08 18:00:51.167720 | TASK [Setup log path fact] 2025-04-08 18:00:51.210214 | ubuntu-noble | ok 2025-04-08 18:00:51.232092 | 2025-04-08 18:00:51.232232 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-04-08 18:00:51.275609 | ubuntu-noble | ok 2025-04-08 18:00:51.288873 | 2025-04-08 18:00:51.289009 | TASK [emit-job-header : Print job information] 2025-04-08 18:00:51.342040 | # Job Information 2025-04-08 18:00:51.342224 | Ansible Version: 2.15.3 2025-04-08 18:00:51.342259 | Job: container-image-inventory-reconciler-build 2025-04-08 18:00:51.342289 | Pipeline: check 2025-04-08 18:00:51.342310 | Executor: 7d211f194f6a 2025-04-08 18:00:51.342346 | Triggered by: https://github.com/osism/container-image-inventory-reconciler/pull/261 2025-04-08 18:00:51.342365 | Event ID: 5e87aca0-14a3-11f0-81ae-a8e941f42e3a 2025-04-08 18:00:51.348750 | 2025-04-08 18:00:51.348874 | LOOP [emit-job-header : Print node information] 2025-04-08 18:00:51.480920 | ubuntu-noble | ok: 2025-04-08 18:00:51.481144 | ubuntu-noble | # Node Information 2025-04-08 18:00:51.481180 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-04-08 18:00:51.481205 | ubuntu-noble | Hostname: ubuntu 2025-04-08 18:00:51.481226 | ubuntu-noble | Username: zuul 2025-04-08 18:00:51.481246 | ubuntu-noble | Distro: Ubuntu 24.04 2025-04-08 18:00:51.481269 | ubuntu-noble | Provider: regiocloud-a 2025-04-08 18:00:51.481289 | ubuntu-noble | Label: ubuntu-noble 2025-04-08 18:00:51.481309 | ubuntu-noble | Product Name: OpenStack Nova 2025-04-08 18:00:51.481342 | ubuntu-noble | Interface IP: 81.163.192.107 2025-04-08 18:00:51.499583 | 2025-04-08 18:00:51.499685 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-04-08 18:00:51.932458 | ubuntu-noble -> localhost | changed 2025-04-08 18:00:51.939989 | 2025-04-08 18:00:51.940083 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-04-08 18:00:52.797259 | ubuntu-noble -> localhost | changed 2025-04-08 18:00:52.810827 | 2025-04-08 18:00:52.810937 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-04-08 18:00:53.112544 | ubuntu-noble -> localhost | ok 2025-04-08 18:00:53.120282 | 2025-04-08 18:00:53.120523 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-04-08 18:00:53.150672 | ubuntu-noble | ok 2025-04-08 18:00:53.167888 | ubuntu-noble | included: /var/lib/zuul/builds/dc148a32e3b34834977c6f01a8a5d301/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-04-08 18:00:53.175198 | 2025-04-08 18:00:53.175280 | TASK [add-build-sshkey : Create Temp SSH key] 2025-04-08 18:00:53.776695 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-04-08 18:00:53.776910 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/dc148a32e3b34834977c6f01a8a5d301/work/dc148a32e3b34834977c6f01a8a5d301_id_rsa 2025-04-08 18:00:53.776946 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/dc148a32e3b34834977c6f01a8a5d301/work/dc148a32e3b34834977c6f01a8a5d301_id_rsa.pub 2025-04-08 18:00:53.776972 | ubuntu-noble -> localhost | The key fingerprint is: 2025-04-08 18:00:53.776995 | ubuntu-noble -> localhost | SHA256:LRDTsfhiOuOuuKo+YGzMZ37qHXikf0uIUli+bVl1C3I zuul-build-sshkey 2025-04-08 18:00:53.777017 | ubuntu-noble -> localhost | The key's randomart image is: 2025-04-08 18:00:53.777038 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-04-08 18:00:53.777059 | ubuntu-noble -> localhost | | o... | 2025-04-08 18:00:53.777079 | ubuntu-noble -> localhost | | +.. | 2025-04-08 18:00:53.777107 | ubuntu-noble -> localhost | | . o..E . | 2025-04-08 18:00:53.777127 | ubuntu-noble -> localhost | | + o+.o . | 2025-04-08 18:00:53.777146 | ubuntu-noble -> localhost | |+. o .o.S .. | 2025-04-08 18:00:53.777165 | ubuntu-noble -> localhost | |.*.oBo+. . | 2025-04-08 18:00:53.777185 | ubuntu-noble -> localhost | |+.+=+B . | 2025-04-08 18:00:53.777205 | ubuntu-noble -> localhost | | o.o=+o. | 2025-04-08 18:00:53.777224 | ubuntu-noble -> localhost | |Oo+==o... | 2025-04-08 18:00:53.777243 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-04-08 18:00:53.777296 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.193105 2025-04-08 18:00:53.785681 | 2025-04-08 18:00:53.785774 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-04-08 18:00:53.805451 | ubuntu-noble | ok 2025-04-08 18:00:53.815789 | ubuntu-noble | included: /var/lib/zuul/builds/dc148a32e3b34834977c6f01a8a5d301/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-04-08 18:00:53.825395 | 2025-04-08 18:00:53.825474 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-04-08 18:00:53.849290 | ubuntu-noble | skipping: Conditional result was False 2025-04-08 18:00:53.856069 | 2025-04-08 18:00:53.856152 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-04-08 18:00:54.611553 | ubuntu-noble | changed 2025-04-08 18:00:54.621843 | 2025-04-08 18:00:54.621947 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-04-08 18:00:54.944944 | ubuntu-noble | ok 2025-04-08 18:00:54.955114 | 2025-04-08 18:00:54.955221 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-04-08 18:00:55.747350 | ubuntu-noble | changed 2025-04-08 18:00:55.756454 | 2025-04-08 18:00:55.756599 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-04-08 18:00:56.484745 | ubuntu-noble | changed 2025-04-08 18:00:56.491871 | 2025-04-08 18:00:56.491966 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-04-08 18:00:56.537962 | ubuntu-noble | skipping: Conditional result was False 2025-04-08 18:00:56.545365 | 2025-04-08 18:00:56.545462 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-04-08 18:00:57.285930 | ubuntu-noble -> localhost | changed 2025-04-08 18:00:57.299448 | 2025-04-08 18:00:57.299555 | TASK [add-build-sshkey : Add back temp key] 2025-04-08 18:00:57.618440 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/dc148a32e3b34834977c6f01a8a5d301/work/dc148a32e3b34834977c6f01a8a5d301_id_rsa (zuul-build-sshkey) 2025-04-08 18:00:57.618689 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.012187 2025-04-08 18:00:57.626409 | 2025-04-08 18:00:57.626515 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-04-08 18:00:58.033541 | ubuntu-noble | ok 2025-04-08 18:00:58.039982 | 2025-04-08 18:00:58.040076 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-04-08 18:00:58.064672 | ubuntu-noble | skipping: Conditional result was False 2025-04-08 18:00:58.077789 | 2025-04-08 18:00:58.077887 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-04-08 18:00:58.546372 | ubuntu-noble | ok 2025-04-08 18:00:58.587940 | 2025-04-08 18:00:58.588056 | TASK [validate-host : Define zuul_info_dir fact] 2025-04-08 18:00:58.630695 | ubuntu-noble | ok 2025-04-08 18:00:58.637607 | 2025-04-08 18:00:58.637718 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-04-08 18:00:58.897951 | ubuntu-noble -> localhost | ok 2025-04-08 18:00:58.906065 | 2025-04-08 18:00:58.906182 | TASK [validate-host : Collect information about the host] 2025-04-08 18:01:00.115000 | ubuntu-noble | ok 2025-04-08 18:01:00.128862 | 2025-04-08 18:01:00.128955 | TASK [validate-host : Sanitize hostname] 2025-04-08 18:01:00.194144 | ubuntu-noble | ok 2025-04-08 18:01:00.202741 | 2025-04-08 18:01:00.202843 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-04-08 18:01:00.705020 | ubuntu-noble -> localhost | changed 2025-04-08 18:01:00.719177 | 2025-04-08 18:01:00.719330 | TASK [validate-host : Collect information about zuul worker] 2025-04-08 18:01:01.225201 | ubuntu-noble | ok 2025-04-08 18:01:01.235838 | 2025-04-08 18:01:01.235940 | TASK [validate-host : Write out all zuul information for each host] 2025-04-08 18:01:01.774080 | ubuntu-noble -> localhost | changed 2025-04-08 18:01:01.784268 | 2025-04-08 18:01:01.784357 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-04-08 18:01:02.085769 | ubuntu-noble | ok 2025-04-08 18:01:02.091663 | 2025-04-08 18:01:02.091742 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-04-08 18:01:02.959628 | ubuntu-noble | changed: 2025-04-08 18:01:02.959826 | ubuntu-noble | cd+++++++++ src/ 2025-04-08 18:01:02.959860 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-04-08 18:01:02.959884 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-04-08 18:01:02.959905 | ubuntu-noble | cd+++++++++ src/github.com/osism/container-image-inventory-reconciler/ 2025-04-08 18:01:02.959925 | ubuntu-noble | Containerfile 2025-04-08 18:01:02.960053 | ubuntu-noble | 3.4.7-r0) 2025-04-08 18:02:17.448826 | ubuntu-noble | #25 5.954 (23/32) Installing pkgconf (2.3.0-r0) 2025-04-08 18:02:17.773415 | ubuntu-noble | #25 5.969 (24/32) Installing libffi-dev (3.4.7-r0) 2025-04-08 18:02:17.773533 | ubuntu-noble | #25 5.991 (25/32) Installing openssl-dev (3.3.3-r0) 2025-04-08 18:02:17.773541 | ubuntu-noble | #25 6.039 (26/32) Installing mpdecimal (4.0.0-r0) 2025-04-08 18:02:17.773547 | ubuntu-noble | #25 6.054 (27/32) Installing python3 (3.12.9-r0) 2025-04-08 18:02:17.773563 | ubuntu-noble | #25 6.378 (28/32) Installing python3-pycache-pyc0 (3.12.9-r0) 2025-04-08 18:02:17.968326 | ubuntu-noble | #25 6.573 (29/32) Installing pyc (3.12.9-r0) 2025-04-08 18:02:19.529237 | ubuntu-noble | #25 6.573 (30/32) Installing python3-pyc (3.12.9-r0) 2025-04-08 18:02:19.529322 | ubuntu-noble | #25 6.573 (31/32) Installing python3-dev (3.12.9-r0) 2025-04-08 18:02:19.529340 | ubuntu-noble | #25 8.135 (32/32) Installing .build-deps (20250408.180214) 2025-04-08 18:02:19.646628 | ubuntu-noble | #25 8.136 Executing busybox-1.37.0-r12.trigger 2025-04-08 18:02:20.074109 | ubuntu-noble | #25 8.145 OK: 394 MiB in 80 packages 2025-04-08 18:02:20.074189 | ubuntu-noble | #25 8.251 + uv pip install --no-cache --system -r /requirements.txt 2025-04-08 18:02:20.074207 | ubuntu-noble | #25 8.679 Using Python 3.13.2 environment at: /usr/local 2025-04-08 18:02:20.427427 | ubuntu-noble | #25 9.032 Resolved 20 packages in 350ms 2025-04-08 18:02:20.620358 | ubuntu-noble | #25 9.075 Downloading netaddr (2.2MiB) 2025-04-08 18:02:20.751143 | ubuntu-noble | #25 9.075 Downloading cryptography (4.1MiB) 2025-04-08 18:02:20.751289 | ubuntu-noble | #25 9.075 Downloading ansible-core (2.1MiB) 2025-04-08 18:02:20.751308 | ubuntu-noble | #25 9.357 Downloaded netaddr 2025-04-08 18:02:20.959932 | ubuntu-noble | #25 9.423 Downloaded cryptography 2025-04-08 18:02:21.063153 | ubuntu-noble | #25 9.565 Downloaded ansible-core 2025-04-08 18:02:21.063310 | ubuntu-noble | #25 9.567 Prepared 20 packages in 532ms 2025-04-08 18:02:21.261969 | ubuntu-noble | #25 9.668 Installed 20 packages in 101ms 2025-04-08 18:02:22.083660 | ubuntu-noble | #25 9.670 + ansible-core==2.18.4 2025-04-08 18:02:22.083737 | ubuntu-noble | #25 9.670 + argcomplete==3.6.2 2025-04-08 18:02:22.083745 | ubuntu-noble | #25 9.670 + certifi==2025.1.31 2025-04-08 18:02:22.083750 | ubuntu-noble | #25 9.670 + cffi==1.17.1 2025-04-08 18:02:22.083756 | ubuntu-noble | #25 9.670 + charset-normalizer==3.4.1 2025-04-08 18:02:22.083762 | ubuntu-noble | #25 9.670 + cryptography==44.0.2 2025-04-08 18:02:22.083767 | ubuntu-noble | #25 9.670 + idna==3.10 2025-04-08 18:02:22.083772 | ubuntu-noble | #25 9.670 + jinja2==3.1.6 2025-04-08 18:02:22.083787 | ubuntu-noble | #25 9.670 + markupsafe==3.0.2 2025-04-08 18:02:22.083792 | ubuntu-noble | #25 9.670 + netaddr==1.3.0 2025-04-08 18:02:22.083797 | ubuntu-noble | #25 9.670 + packaging==24.2 2025-04-08 18:02:22.083802 | ubuntu-noble | #25 9.670 + pycparser==2.22 2025-04-08 18:02:22.083807 | ubuntu-noble | #25 9.670 + pynetbox==7.4.1 2025-04-08 18:02:22.083812 | ubuntu-noble | #25 9.670 + pyyaml==6.0.2 2025-04-08 18:02:22.083816 | ubuntu-noble | #25 9.670 + requests==2.32.3 2025-04-08 18:02:22.083821 | ubuntu-noble | #25 9.670 + resolvelib==1.0.1 2025-04-08 18:02:22.083826 | ubuntu-noble | #25 9.670 + tomlkit==0.13.2 2025-04-08 18:02:22.083831 | ubuntu-noble | #25 9.670 + urllib3==2.3.0 2025-04-08 18:02:22.083835 | ubuntu-noble | #25 9.670 + xmltodict==0.14.2 2025-04-08 18:02:22.083839 | ubuntu-noble | #25 9.670 + yq==3.4.3 2025-04-08 18:02:22.083844 | ubuntu-noble | #25 9.715 + git clone https://github.com/osism/release /release 2025-04-08 18:02:22.084144 | ubuntu-noble | #25 9.717 Cloning into '/release'... 2025-04-08 18:02:22.084165 | ubuntu-noble | #25 10.69 + git clone https://github.com/osism/defaults /defaults 2025-04-08 18:02:22.238089 | ubuntu-noble | #25 10.69 Cloning into '/defaults'... 2025-04-08 18:02:22.712562 | ubuntu-noble | #25 11.32 + git clone https://github.com/osism/cfg-generics /generics 2025-04-08 18:02:22.865635 | ubuntu-noble | #25 11.32 Cloning into '/generics'... 2025-04-08 18:02:23.328853 | ubuntu-noble | #25 11.93 + '[' latest '!=' latest ] 2025-04-08 18:02:23.481231 | ubuntu-noble | #25 11.94 + python3 /render-python-requirements.py 2025-04-08 18:02:24.370142 | ubuntu-noble | #25 12.97 + uv pip install --no-cache --system -r /requirements.extra.txt 2025-04-08 18:02:24.559815 | ubuntu-noble | #25 13.17 Using Python 3.13.2 environment at: /usr/local 2025-04-08 18:02:28.874954 | ubuntu-noble | #25 17.48 Resolved 120 packages in 4.31s 2025-04-08 18:02:29.005080 | ubuntu-noble | #25 17.61 Downloading uvloop (4.4MiB) 2025-04-08 18:02:29.213655 | ubuntu-noble | #25 17.61 Downloading openstacksdk (1.7MiB) 2025-04-08 18:02:29.831503 | ubuntu-noble | #25 17.62 Downloading sqlalchemy (3.0MiB) 2025-04-08 18:02:29.831678 | ubuntu-noble | #25 17.62 Downloading kubernetes (1.9MiB) 2025-04-08 18:02:29.831688 | ubuntu-noble | #25 17.62 Downloading pygments (1.2MiB) 2025-04-08 18:02:29.831694 | ubuntu-noble | #25 17.62 Downloading pynacl (1.1MiB) 2025-04-08 18:02:29.831700 | ubuntu-noble | #25 17.63 Downloading greenlet (1.1MiB) 2025-04-08 18:02:29.831705 | ubuntu-noble | #25 17.67 Downloading pydantic (3.0MiB) 2025-04-08 18:02:29.831720 | ubuntu-noble | #25 18.44 Building pyperclip==1.9.0 2025-04-08 18:02:29.993463 | ubuntu-noble | #25 18.44 Building clustershell==1.9.3 2025-04-08 18:02:30.275052 | ubuntu-noble | #25 18.45 Building polling==0.3.2 2025-04-08 18:02:30.425836 | ubuntu-noble | #25 18.88 Downloaded pynacl 2025-04-08 18:02:30.586402 | ubuntu-noble | #25 19.04 Downloaded greenlet 2025-04-08 18:02:30.839473 | ubuntu-noble | #25 19.44 Building watchdog==6.0.0 2025-04-08 18:02:31.128484 | ubuntu-noble | #25 19.73 Downloaded pydantic 2025-04-08 18:02:31.237352 | ubuntu-noble | #25 19.83 Building psutil==7.0.0 2025-04-08 18:02:31.365613 | ubuntu-noble | #25 19.84 Downloaded uvloop 2025-04-08 18:02:31.365702 | ubuntu-noble | #25 19.86 Downloaded pygments 2025-04-08 18:02:31.977028 | ubuntu-noble | #25 19.97 Downloaded sqlalchemy 2025-04-08 18:02:31.977113 | ubuntu-noble | #25 20.58 Downloaded kubernetes 2025-04-08 18:02:32.206762 | ubuntu-noble | #25 20.81 Downloaded openstacksdk 2025-04-08 18:02:33.625098 | ubuntu-noble | #25 22.23 Built polling==0.3.2 2025-04-08 18:02:33.752348 | ubuntu-noble | #25 22.36 Built pyperclip==1.9.0 2025-04-08 18:02:34.549689 | ubuntu-noble | #25 23.03 Built watchdog==6.0.0 2025-04-08 18:02:36.038509 | ubuntu-noble | #25 23.15 Built clustershell==1.9.3 2025-04-08 18:02:36.038647 | ubuntu-noble | #25 24.64 Built psutil==7.0.0 2025-04-08 18:02:36.198311 | ubuntu-noble | #25 24.65 Prepared 105 packages in 7.16s 2025-04-08 18:02:36.634815 | ubuntu-noble | #25 25.08 Installed 106 packages in 428ms 2025-04-08 18:02:36.712234 | ubuntu-noble | #25 25.08 + amqp==5.3.1 2025-04-08 18:02:36.712352 | ubuntu-noble | #25 25.08 + anyio==4.9.0 2025-04-08 18:02:36.712365 | ubuntu-noble | #25 25.08 + ara==1.7.2 2025-04-08 18:02:36.712375 | ubuntu-noble | #25 25.08 + autopage==0.5.2 2025-04-08 18:02:36.712384 | ubuntu-noble | #25 25.08 + bcrypt==4.3.0 2025-04-08 18:02:36.712393 | ubuntu-noble | #25 25.08 + billiard==4.2.1 2025-04-08 18:02:36.712402 | ubuntu-noble | #25 25.08 + cachetools==5.5.2 2025-04-08 18:02:36.712410 | ubuntu-noble | #25 25.08 + celery==5.5.0 2025-04-08 18:02:36.712419 | ubuntu-noble | #25 25.08 + click==8.1.8 2025-04-08 18:02:36.712428 | ubuntu-noble | #25 25.08 + click-didyoumean==0.3.1 2025-04-08 18:02:36.712440 | ubuntu-noble | #25 25.08 + click-plugins==1.1.1 2025-04-08 18:02:36.712468 | ubuntu-noble | #25 25.08 + click-repl==0.3.0 2025-04-08 18:02:36.712477 | ubuntu-noble | #25 25.08 + cliff==4.9.1 2025-04-08 18:02:36.712485 | ubuntu-noble | #25 25.08 + clustershell==1.9.3 2025-04-08 18:02:36.712493 | ubuntu-noble | #25 25.08 + cmd2==2.5.11 2025-04-08 18:02:36.712501 | ubuntu-noble | #25 25.08 + decorator==5.2.1 2025-04-08 18:02:36.712509 | ubuntu-noble | #25 25.08 + deepdiff==8.4.2 2025-04-08 18:02:36.712517 | ubuntu-noble | #25 25.08 + docker==7.1.0 2025-04-08 18:02:36.712526 | ubuntu-noble | #25 25.08 + dogpile-cache==1.3.4 2025-04-08 18:02:36.712533 | ubuntu-noble | #25 25.08 + dtrack-auditor==1.5.0 2025-04-08 18:02:36.712542 | ubuntu-noble | #25 25.08 + durationpy==0.9 2025-04-08 18:02:36.712550 | ubuntu-noble | #25 25.08 + fastapi==0.115.12 2025-04-08 18:02:36.712558 | ubuntu-noble | #25 25.08 + flower==2.0.1 2025-04-08 18:02:36.712566 | ubuntu-noble | #25 25.08 + future==1.0.0 2025-04-08 18:02:36.712574 | ubuntu-noble | #25 25.08 + gitdb==4.0.12 2025-04-08 18:02:36.712582 | ubuntu-noble | #25 25.08 + gitpython==3.1.44 2025-04-08 18:02:36.712590 | ubuntu-noble | #25 25.08 + google-auth==2.38.0 2025-04-08 18:02:36.712597 | ubuntu-noble | #25 25.08 + greenlet==3.1.1 2025-04-08 18:02:36.712605 | ubuntu-noble | #25 25.08 + h11==0.14.0 2025-04-08 18:02:36.712613 | ubuntu-noble | #25 25.08 + hiredis==3.1.0 2025-04-08 18:02:36.712621 | ubuntu-noble | #25 25.08 + httptools==0.6.4 2025-04-08 18:02:36.712629 | ubuntu-noble | #25 25.08 + humanize==4.12.2 2025-04-08 18:02:36.712636 | ubuntu-noble | #25 25.08 + iniconfig==2.1.0 2025-04-08 18:02:36.712644 | ubuntu-noble | #25 25.08 + iso8601==2.1.0 2025-04-08 18:02:36.712652 | ubuntu-noble | #25 25.08 + jc==1.25.4 2025-04-08 18:02:36.712660 | ubuntu-noble | #25 25.08 + jmespath==1.0.1 2025-04-08 18:02:36.712668 | ubuntu-noble | #25 25.08 + jsonpatch==1.33 2025-04-08 18:02:36.712675 | ubuntu-noble | #25 25.08 + jsonpointer==3.0.0 2025-04-08 18:02:36.712683 | ubuntu-noble | #25 25.08 + keystoneauth1==5.10.0 2025-04-08 18:02:36.712691 | ubuntu-noble | #25 25.08 + kombu==5.5.2 2025-04-08 18:02:36.712699 | ubuntu-noble | #25 25.08 + kubernetes==32.0.1 2025-04-08 18:02:36.712707 | ubuntu-noble | #25 25.08 + loguru==0.7.3 2025-04-08 18:02:36.712715 | ubuntu-noble | #25 25.08 + markdown-it-py==3.0.0 2025-04-08 18:02:36.712723 | ubuntu-noble | #25 25.08 + mdurl==0.1.2 2025-04-08 18:02:36.712730 | ubuntu-noble | #25 25.08 + mmh3==5.1.0 2025-04-08 18:02:36.712738 | ubuntu-noble | #25 25.09 + netmiko==4.5.0 2025-04-08 18:02:36.712746 | ubuntu-noble | #25 25.09 + nornir==3.5.0 2025-04-08 18:02:36.712754 | ubuntu-noble | #25 25.09 + nornir-ansible==2023.12.28 2025-04-08 18:02:36.712769 | ubuntu-noble | #25 25.09 + ntc-templates==7.8.0 2025-04-08 18:02:36.712778 | ubuntu-noble | #25 25.09 + oauthlib==3.2.2 2025-04-08 18:02:36.712786 | ubuntu-noble | #25 25.09 + openstacksdk==4.4.0 2025-04-08 18:02:36.712794 | ubuntu-noble | #25 25.09 + orderly-set==5.3.1 2025-04-08 18:02:36.712802 | ubuntu-noble | #25 25.09 + os-service-types==1.7.0 2025-04-08 18:02:36.712810 | ubuntu-noble | #25 25.09 + osism==0.20250407.0 2025-04-08 18:02:36.712817 | ubuntu-noble | #25 25.09 + paramiko==3.5.1 2025-04-08 18:02:36.712825 | ubuntu-noble | #25 25.09 + pbr==6.1.1 2025-04-08 18:02:36.712833 | ubuntu-noble | #25 25.09 + platformdirs==4.3.7 2025-04-08 18:02:36.712841 | ubuntu-noble | #25 25.09 + pluggy==1.5.0 2025-04-08 18:02:36.712849 | ubuntu-noble | #25 25.09 + polling==0.3.2 2025-04-08 18:02:36.713015 | ubuntu-noble | #25 25.09 + pottery==3.0.1 2025-04-08 18:02:36.713046 | ubuntu-noble | #25 25.09 + prettytable==3.16.0 2025-04-08 18:02:36.713054 | ubuntu-noble | #25 25.09 + prometheus-client==0.21.1 2025-04-08 18:02:36.713106 | ubuntu-noble | #25 25.09 + prompt-toolkit==3.0.50 2025-04-08 18:02:36.713180 | ubuntu-noble | #25 25.09 + psutil==7.0.0 2025-04-08 18:02:36.713189 | ubuntu-noble | #25 25.09 + pyasn1==0.6.1 2025-04-08 18:02:36.713197 | ubuntu-noble | #25 25.09 + pyasn1-modules==0.4.2 2025-04-08 18:02:36.713205 | ubuntu-noble | #25 25.09 + pydantic==1.10.21 2025-04-08 18:02:36.713213 | ubuntu-noble | #25 25.09 + pygments==2.19.1 2025-04-08 18:02:36.713221 | ubuntu-noble | #25 25.09 + pynacl==1.5.0 2025-04-08 18:02:36.713229 | ubuntu-noble | #25 25.09 + pyperclip==1.9.0 2025-04-08 18:02:36.713237 | ubuntu-noble | #25 25.09 + pyserial==3.5 2025-04-08 18:02:36.713245 | ubuntu-noble | #25 25.09 + pytest==8.3.5 2025-04-08 18:02:36.713252 | ubuntu-noble | #25 25.09 + pytest-testinfra==10.2.2 2025-04-08 18:02:36.713260 | ubuntu-noble | #25 25.09 + python-dateutil==2.9.0.post0 2025-04-08 18:02:36.713268 | ubuntu-noble | #25 25.09 + python-dotenv==1.1.0 2025-04-08 18:02:36.713276 | ubuntu-noble | #25 25.09 + pytz==2025.2 2025-04-08 18:02:36.713343 | ubuntu-noble | #25 25.09 + redis==5.2.1 2025-04-08 18:02:36.713352 | ubuntu-noble | #25 25.09 + requests-oauthlib==2.0.0 2025-04-08 18:02:36.713360 | ubuntu-noble | #25 25.09 + requestsexceptions==1.4.0 2025-04-08 18:02:36.713368 | ubuntu-noble | #25 25.09 + rich==14.0.0 2025-04-08 18:02:36.713389 | ubuntu-noble | #25 25.09 + rsa==4.9 2025-04-08 18:02:36.713397 | ubuntu-noble | #25 25.09 + ruamel-yaml==0.18.10 2025-04-08 18:02:36.713405 | ubuntu-noble | #25 25.09 + scp==0.15.0 2025-04-08 18:02:36.713413 | ubuntu-noble | #25 25.09 + setuptools==78.1.0 2025-04-08 18:02:36.713421 | ubuntu-noble | #25 25.09 + six==1.17.0 2025-04-08 18:02:36.713429 | ubuntu-noble | #25 25.09 + smmap==5.0.2 2025-04-08 18:02:36.713437 | ubuntu-noble | #25 25.09 + sniffio==1.3.1 2025-04-08 18:02:36.713445 | ubuntu-noble | #25 25.09 + sqlalchemy==2.0.40 2025-04-08 18:02:36.713452 | ubuntu-noble | #25 25.09 + sqlmodel==0.0.24 2025-04-08 18:02:36.713461 | ubuntu-noble | #25 25.09 + starlette==0.46.1 2025-04-08 18:02:36.713469 | ubuntu-noble | #25 25.09 + stevedore==5.4.1 2025-04-08 18:02:36.713477 | ubuntu-noble | #25 25.09 + sushy==5.5.0 2025-04-08 18:02:36.713485 | ubuntu-noble | #25 25.09 + tabulate==0.9.0 2025-04-08 18:02:36.713493 | ubuntu-noble | #25 25.09 + textfsm==1.1.3 2025-04-08 18:02:36.713502 | ubuntu-noble | #25 25.09 + tornado==6.4.2 2025-04-08 18:02:36.713509 | ubuntu-noble | #25 25.09 + transitions==0.9.2 2025-04-08 18:02:36.713517 | ubuntu-noble | #25 25.09 + typing-extensions==4.13.1 2025-04-08 18:02:36.713525 | ubuntu-noble | #25 25.09 + tzdata==2025.2 2025-04-08 18:02:36.713533 | ubuntu-noble | #25 25.09 + uvicorn==0.34.0 2025-04-08 18:02:36.713541 | ubuntu-noble | #25 25.09 + uvloop==0.21.0 2025-04-08 18:02:36.713549 | ubuntu-noble | #25 25.09 + vine==5.1.0 2025-04-08 18:02:36.713557 | ubuntu-noble | #25 25.09 + watchdog==6.0.0 2025-04-08 18:02:36.713565 | ubuntu-noble | #25 25.09 + watchfiles==1.0.5 2025-04-08 18:02:36.713573 | ubuntu-noble | #25 25.09 + wcwidth==0.2.13 2025-04-08 18:02:36.713581 | ubuntu-noble | #25 25.09 + websocket-client==1.8.0 2025-04-08 18:02:36.713589 | ubuntu-noble | #25 25.09 + websockets==15.0.1 2025-04-08 18:02:36.713609 | ubuntu-noble | #25 25.32 + mkdir -p /inventory.generics/ 2025-04-08 18:02:36.865519 | ubuntu-noble | #25 25.32 + cp /generics/inventory/50-ceph /generics/inventory/50-infrastruture /generics/inventory/50-kolla /generics/inventory/50-monitoring /generics/inventory/50-openstack /generics/inventory/50-rook /generics/inventory/51-ceph /generics/inventory/51-kolla /generics/inventory/60-generic /inventory.generics/ 2025-04-08 18:02:45.332696 | ubuntu-noble | #25 25.32 + ansible-galaxy collection install -v -f -r /ansible/requirements.yml -p /usr/share/ansible/collections 2025-04-08 18:02:45.332892 | ubuntu-noble | #25 33.94 No config file found; using defaults 2025-04-08 18:02:45.450825 | ubuntu-noble | #25 33.94 Starting galaxy collection install process 2025-04-08 18:02:45.452349 | ubuntu-noble | #25 33.94 Process install dependency map 2025-04-08 18:02:45.452386 | ubuntu-noble | #25 33.94 Starting collection install process 2025-04-08 18:02:45.452403 | ubuntu-noble | #25 33.94 Downloading https://galaxy.ansible.com/api/v3/plugin/ansible/content/published/collections/artifacts/netbox-netbox-3.21.0.tar.gz to /root/.ansible/tmp/ansible-local-23569oypp4z/tmp2jkjlvaa/netbox-netbox-3.21.0-1bywm8gc 2025-04-08 18:02:45.452440 | ubuntu-noble | #25 33.94 Installing 'netbox.netbox:3.21.0' to '/usr/share/ansible/collections/ansible_collections/netbox/netbox' 2025-04-08 18:02:45.452454 | ubuntu-noble | #25 33.94 netbox.netbox:3.21.0 was installed successfully 2025-04-08 18:02:45.452482 | ubuntu-noble | #25 34.06 + ln -s /usr/share/ansible/collections /ansible/collections 2025-04-08 18:02:45.551066 | ubuntu-noble | #25 34.07 + adduser -D inventory-reconciler 2025-04-08 18:02:45.664410 | ubuntu-noble | #25 34.09 + addgroup -g 45000 dragon 2025-04-08 18:02:45.664538 | ubuntu-noble | #25 34.09 + adduser -D -u 45000 -G dragon dragon 2025-04-08 18:02:45.664562 | ubuntu-noble | #25 34.11 + mkdir -p /extra /inventory /inventory.merge /inventory.pre /opt/configuration /state 2025-04-08 18:02:45.664581 | ubuntu-noble | #25 34.11 + chown -R dragon: /defaults /extra /inventory /inventory.generics /inventory.merge /inventory.pre /opt/configuration /state 2025-04-08 18:02:45.664601 | ubuntu-noble | #25 34.11 + apk del .build-deps 2025-04-08 18:02:45.664620 | ubuntu-noble | #25 34.12 WARNING: opening from cache https://dl-cdn.alpinelinux.org/alpine/v3.21/main: No such file or directory 2025-04-08 18:02:45.664638 | ubuntu-noble | #25 34.12 WARNING: opening from cache https://dl-cdn.alpinelinux.org/alpine/v3.21/community: No such file or directory 2025-04-08 18:02:45.664657 | ubuntu-noble | #25 34.12 (1/31) Purging .build-deps (20250408.180214) 2025-04-08 18:02:45.664674 | ubuntu-noble | #25 34.12 (2/31) Purging build-base (0.5-r3) 2025-04-08 18:02:45.664692 | ubuntu-noble | #25 34.12 (3/31) Purging file (5.46-r2) 2025-04-08 18:02:45.664709 | ubuntu-noble | #25 34.12 (4/31) Purging g++ (14.2.0-r4) 2025-04-08 18:02:45.664755 | ubuntu-noble | #25 34.13 (5/31) Purging libstdc++-dev (14.2.0-r4) 2025-04-08 18:02:45.664769 | ubuntu-noble | #25 34.16 (6/31) Purging gcc (14.2.0-r4) 2025-04-08 18:02:45.664797 | ubuntu-noble | #25 34.20 (7/31) Purging binutils (2.43.1-r2) 2025-04-08 18:02:45.837235 | ubuntu-noble | #25 34.20 (8/31) Purging libatomic (14.2.0-r4) 2025-04-08 18:02:45.837366 | ubuntu-noble | #25 34.20 (9/31) Purging libgomp (14.2.0-r4) 2025-04-08 18:02:45.837384 | ubuntu-noble | #25 34.20 (10/31) Purging make (4.4.1-r2) 2025-04-08 18:02:45.837399 | ubuntu-noble | #25 34.20 (11/31) Purging fortify-headers (1.1-r5) 2025-04-08 18:02:45.837412 | ubuntu-noble | #25 34.20 (12/31) Purging patch (2.7.6-r10) 2025-04-08 18:02:45.837424 | ubuntu-noble | #25 34.20 (13/31) Purging libffi-dev (3.4.7-r0) 2025-04-08 18:02:45.837436 | ubuntu-noble | #25 34.21 (14/31) Purging linux-headers (6.6-r1) 2025-04-08 18:02:45.837448 | ubuntu-noble | #25 34.23 (15/31) Purging openssl-dev (3.3.3-r0) 2025-04-08 18:02:45.837459 | ubuntu-noble | #25 34.23 (16/31) Purging python3-dev (3.12.9-r0) 2025-04-08 18:02:45.837471 | ubuntu-noble | #25 34.25 (17/31) Purging python3-pyc (3.12.9-r0) 2025-04-08 18:02:45.837484 | ubuntu-noble | #25 34.25 (18/31) Purging python3-pycache-pyc0 (3.12.9-r0) 2025-04-08 18:02:45.837496 | ubuntu-noble | #25 34.27 (19/31) Purging pyc (3.12.9-r0) 2025-04-08 18:02:45.837507 | ubuntu-noble | #25 34.27 (20/31) Purging python3 (3.12.9-r0) 2025-04-08 18:02:45.837535 | ubuntu-noble | #25 34.29 (21/31) Purging isl26 (0.26-r1) 2025-04-08 18:02:45.963532 | ubuntu-noble | #25 34.29 (22/31) Purging jansson (2.14-r4) 2025-04-08 18:02:45.963654 | ubuntu-noble | #25 34.29 (23/31) Purging libmagic (5.46-r2) 2025-04-08 18:02:45.963683 | ubuntu-noble | #25 34.29 (24/31) Purging mpc1 (1.3.1-r1) 2025-04-08 18:02:45.963717 | ubuntu-noble | #25 34.29 (25/31) Purging mpdecimal (4.0.0-r0) 2025-04-08 18:02:45.963738 | ubuntu-noble | #25 34.29 (26/31) Purging mpfr4 (4.2.1-r0) 2025-04-08 18:02:45.963750 | ubuntu-noble | #25 34.29 (27/31) Purging musl-dev (1.2.5-r9) 2025-04-08 18:02:45.963762 | ubuntu-noble | #25 34.30 (28/31) Purging pkgconf (2.3.0-r0) 2025-04-08 18:02:45.963773 | ubuntu-noble | #25 34.30 (29/31) Purging gmp (6.3.0-r2) 2025-04-08 18:02:45.963785 | ubuntu-noble | #25 34.30 (30/31) Purging libstdc++ (14.2.0-r4) 2025-04-08 18:02:45.963797 | ubuntu-noble | #25 34.30 (31/31) Purging libgcc (14.2.0-r4) 2025-04-08 18:02:45.963819 | ubuntu-noble | #25 34.30 Executing busybox-1.37.0-r12.trigger 2025-04-08 18:02:45.963833 | ubuntu-noble | #25 34.31 OK: 25 MiB in 49 packages 2025-04-08 18:02:45.963845 | ubuntu-noble | #25 34.31 + rm -f /etc/crontabs/root /render-python-requirements.py /templates/requirements.txt.j2 /requirements.extra.txt /requirements.txt 2025-04-08 18:02:45.963909 | ubuntu-noble | #25 34.33 + uv pip install --no-cache --system 'pyclean==3.0.0' 2025-04-08 18:02:45.963924 | ubuntu-noble | #25 34.44 Using Python 3.13.2 environment at: /usr/local 2025-04-08 18:02:45.963950 | ubuntu-noble | #25 34.57 Resolved 1 package in 118ms 2025-04-08 18:02:46.090327 | ubuntu-noble | #25 34.60 Prepared 1 package in 26ms 2025-04-08 18:02:46.958726 | ubuntu-noble | #25 34.60 Installed 1 package in 7ms 2025-04-08 18:02:46.958850 | ubuntu-noble | #25 34.60 + pyclean==3.0.0 2025-04-08 18:02:46.958906 | ubuntu-noble | #25 34.61 + pyclean /usr 2025-04-08 18:02:46.958922 | ubuntu-noble | #25 34.70 Cleaning directory /usr 2025-04-08 18:02:46.959216 | ubuntu-noble | #25 35.56 Total 467 files, 156 directories removed. 2025-04-08 18:02:47.121379 | ubuntu-noble | #25 35.58 + uv pip uninstall --system pyclean 2025-04-08 18:02:47.433820 | ubuntu-noble | #25 36.04 Using Python 3.13.2 environment at: /usr/local 2025-04-08 18:02:47.590502 | ubuntu-noble | #25 36.04 Uninstalled 1 package in 455ms 2025-04-08 18:02:47.660994 | ubuntu-noble | #25 36.04 - pyclean==3.0.0 2025-04-08 18:02:47.661131 | ubuntu-noble | #25 DONE 36.3s 2025-04-08 18:02:49.510464 | ubuntu-noble | 2025-04-08 18:02:52.857436 | ubuntu-noble | #26 [stage-1 2/2] COPY --link --from=builder / / 2025-04-08 18:02:52.857625 | ubuntu-noble | #26 DONE 3.3s 2025-04-08 18:02:53.015078 | ubuntu-noble | 2025-04-08 18:02:56.103847 | ubuntu-noble | #27 exporting to image 2025-04-08 18:02:56.103967 | ubuntu-noble | #27 exporting layers 2025-04-08 18:02:56.103996 | ubuntu-noble | #27 exporting layers 3.2s done 2025-04-08 18:02:56.241748 | ubuntu-noble | #27 writing image sha256:1b64f0db727b77a55b44d7c72893b5c98c5014b084316aae25b3acd510ca1562 done 2025-04-08 18:02:56.254989 | ubuntu-noble | #27 naming to docker.io/library/5b0589b done 2025-04-08 18:02:56.255099 | ubuntu-noble | #27 DONE 3.3s 2025-04-08 18:02:56.708738 | ubuntu-noble | changed 2025-04-08 18:02:56.729579 | 2025-04-08 18:02:56.729718 | TASK [Run push script] 2025-04-08 18:02:56.832912 | 2025-04-08 18:02:56.833112 | TASK [Run sbom script] 2025-04-08 18:02:56.952500 | ubuntu-noble | skipping: Conditional result was False 2025-04-08 18:02:56.990344 | 2025-04-08 18:02:56.990435 | PLAY RECAP 2025-04-08 18:02:56.990491 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2025-04-08 18:02:56.990516 | 2025-04-08 18:02:57.120766 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/container-image-inventory-reconciler/playbooks/build.yml@main] 2025-04-08 18:02:57.123940 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-04-08 18:02:57.870724 | 2025-04-08 18:02:57.870871 | PLAY [Base post] 2025-04-08 18:02:57.896204 | 2025-04-08 18:02:57.896356 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-04-08 18:02:58.772339 | ubuntu-noble | changed 2025-04-08 18:02:58.804465 | 2025-04-08 18:02:58.804606 | PLAY RECAP 2025-04-08 18:02:58.804678 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-04-08 18:02:58.804744 | 2025-04-08 18:02:58.917768 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-04-08 18:02:58.920994 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-04-08 18:02:59.727964 | 2025-04-08 18:02:59.728147 | PLAY [Base post-logs] 2025-04-08 18:02:59.746158 | 2025-04-08 18:02:59.746297 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-04-08 18:03:00.299139 | localhost | changed 2025-04-08 18:03:00.304713 | 2025-04-08 18:03:00.304883 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-04-08 18:03:00.334254 | localhost | ok 2025-04-08 18:03:00.352887 | 2025-04-08 18:03:00.353001 | TASK [Set zuul-log-path fact] 2025-04-08 18:03:00.381919 | localhost | ok 2025-04-08 18:03:00.399723 | 2025-04-08 18:03:00.400002 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-04-08 18:03:00.433056 | localhost | ok 2025-04-08 18:03:00.444811 | 2025-04-08 18:03:00.444927 | TASK [upload-logs : Create log directories] 2025-04-08 18:03:00.971166 | localhost | changed 2025-04-08 18:03:00.979250 | 2025-04-08 18:03:00.979456 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-04-08 18:03:01.486489 | localhost -> localhost | ok: Runtime: 0:00:00.006630 2025-04-08 18:03:01.498378 | 2025-04-08 18:03:01.498557 | TASK [upload-logs : Upload logs to log server] 2025-04-08 18:03:02.106407 | localhost | Output suppressed because no_log was given 2025-04-08 18:03:02.113446 | 2025-04-08 18:03:02.113630 | LOOP [upload-logs : Compress console log and json output] 2025-04-08 18:03:02.194680 | localhost | skipping: Conditional result was False 2025-04-08 18:03:02.213850 | localhost | skipping: Conditional result was False 2025-04-08 18:03:02.227503 | 2025-04-08 18:03:02.227722 | LOOP [upload-logs : Upload compressed console log and json output] 2025-04-08 18:03:02.300466 | localhost | skipping: Conditional result was False 2025-04-08 18:03:02.301116 | 2025-04-08 18:03:02.313400 | localhost | skipping: Conditional result was False 2025-04-08 18:03:02.325030 | 2025-04-08 18:03:02.325237 | LOOP [upload-logs : Upload console log and json output]