2025-07-10 15:22:57.090932 | Job console starting 2025-07-10 15:22:57.104243 | Updating git repos 2025-07-10 15:22:57.123216 | Cloning repos into workspace 2025-07-10 15:22:57.167552 | Restoring repo states 2025-07-10 15:22:57.179354 | Merging changes 2025-07-10 15:22:57.179380 | Checking out repos 2025-07-10 15:22:57.231613 | Preparing playbooks 2025-07-10 15:22:57.873513 | Running Ansible setup 2025-07-10 15:23:01.993834 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-07-10 15:23:02.777202 | 2025-07-10 15:23:02.777365 | PLAY [Base pre] 2025-07-10 15:23:02.793626 | 2025-07-10 15:23:02.793780 | TASK [Setup log path fact] 2025-07-10 15:23:02.822777 | debian-bookworm | ok 2025-07-10 15:23:02.837822 | 2025-07-10 15:23:02.837959 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-07-10 15:23:02.883149 | debian-bookworm | ok 2025-07-10 15:23:02.895883 | 2025-07-10 15:23:02.896008 | TASK [emit-job-header : Print job information] 2025-07-10 15:23:02.937749 | # Job Information 2025-07-10 15:23:02.937970 | Ansible Version: 2.16.14 2025-07-10 15:23:02.938017 | Job: container-image-inventory-reconciler-push 2025-07-10 15:23:02.938060 | Pipeline: post 2025-07-10 15:23:02.938091 | Executor: 521e9411259a 2025-07-10 15:23:02.938119 | Triggered by: https://github.com/osism/container-image-inventory-reconciler/commit/10b0237e0b0ff696f209f9bc71d8da7d1a17d361 2025-07-10 15:23:02.938150 | Event ID: ac1d8ac4-5da1-11f0-8399-9fda5519333b 2025-07-10 15:23:02.944952 | 2025-07-10 15:23:02.945107 | LOOP [emit-job-header : Print node information] 2025-07-10 15:23:03.063462 | debian-bookworm | ok: 2025-07-10 15:23:03.063787 | debian-bookworm | # Node Information 2025-07-10 15:23:03.063851 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-07-10 15:23:03.063896 | debian-bookworm | Hostname: debian 2025-07-10 15:23:03.063936 | debian-bookworm | Username: zuul 2025-07-10 15:23:03.063972 | debian-bookworm | Distro: Debian 12.11 2025-07-10 15:23:03.064016 | debian-bookworm | Provider: regiocloud-a 2025-07-10 15:23:03.064054 | debian-bookworm | Region: 2025-07-10 15:23:03.064093 | debian-bookworm | Label: debian-bookworm 2025-07-10 15:23:03.064129 | debian-bookworm | Product Name: OpenStack Nova 2025-07-10 15:23:03.064163 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe4d:648a 2025-07-10 15:23:03.090524 | 2025-07-10 15:23:03.090746 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-07-10 15:23:03.553470 | debian-bookworm -> localhost | changed 2025-07-10 15:23:03.569376 | 2025-07-10 15:23:03.569555 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-07-10 15:23:04.660771 | debian-bookworm -> localhost | changed 2025-07-10 15:23:04.681045 | 2025-07-10 15:23:04.681188 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-07-10 15:23:04.959912 | debian-bookworm -> localhost | ok 2025-07-10 15:23:04.974134 | 2025-07-10 15:23:04.974316 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-07-10 15:23:04.996842 | debian-bookworm | ok 2025-07-10 15:23:05.017455 | debian-bookworm | included: /var/lib/zuul/builds/5adf5a39c3b54f8b929bcf63d10ab60c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-07-10 15:23:05.023615 | 2025-07-10 15:23:05.023763 | TASK [add-build-sshkey : Create Temp SSH key] 2025-07-10 15:23:06.584094 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-07-10 15:23:06.584431 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/5adf5a39c3b54f8b929bcf63d10ab60c/work/5adf5a39c3b54f8b929bcf63d10ab60c_id_rsa 2025-07-10 15:23:06.584490 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/5adf5a39c3b54f8b929bcf63d10ab60c/work/5adf5a39c3b54f8b929bcf63d10ab60c_id_rsa.pub 2025-07-10 15:23:06.584530 | debian-bookworm -> localhost | The key fingerprint is: 2025-07-10 15:23:06.584565 | debian-bookworm -> localhost | SHA256:eYDV4zJ+N2afajIAP48+b6OwJ1u7e8wTXj6prIZkUPM zuul-build-sshkey 2025-07-10 15:23:06.584611 | debian-bookworm -> localhost | The key's randomart image is: 2025-07-10 15:23:06.584645 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-07-10 15:23:06.584692 | debian-bookworm -> localhost | | .. | 2025-07-10 15:23:06.584726 | debian-bookworm -> localhost | | oo o | 2025-07-10 15:23:06.584756 | debian-bookworm -> localhost | | ..o.. . | 2025-07-10 15:23:06.584785 | debian-bookworm -> localhost | | . . Eo. | 2025-07-10 15:23:06.584814 | debian-bookworm -> localhost | | . +So. | 2025-07-10 15:23:06.584848 | debian-bookworm -> localhost | | o =.o * | 2025-07-10 15:23:06.584877 | debian-bookworm -> localhost | | o...X B + . | 2025-07-10 15:23:06.584906 | debian-bookworm -> localhost | | o+=o% = o | 2025-07-10 15:23:06.584936 | debian-bookworm -> localhost | | o*BX+B.o | 2025-07-10 15:23:06.584966 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-07-10 15:23:06.585035 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.080280 2025-07-10 15:23:06.593753 | 2025-07-10 15:23:06.593892 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-07-10 15:23:06.625482 | debian-bookworm | ok 2025-07-10 15:23:06.636226 | debian-bookworm | included: /var/lib/zuul/builds/5adf5a39c3b54f8b929bcf63d10ab60c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-07-10 15:23:06.645466 | 2025-07-10 15:23:06.645565 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-07-10 15:23:06.669915 | debian-bookworm | skipping: Conditional result was False 2025-07-10 15:23:06.684310 | 2025-07-10 15:23:06.684585 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-07-10 15:23:07.314828 | debian-bookworm | changed 2025-07-10 15:23:07.324473 | 2025-07-10 15:23:07.324612 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-07-10 15:23:07.595102 | debian-bookworm | ok 2025-07-10 15:23:07.604598 | 2025-07-10 15:23:07.604797 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-07-10 15:23:08.277121 | debian-bookworm | changed 2025-07-10 15:23:08.291809 | 2025-07-10 15:23:08.292026 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-07-10 15:23:08.957633 | debian-bookworm | changed 2025-07-10 15:23:08.966613 | 2025-07-10 15:23:08.966797 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-07-10 15:23:08.992843 | debian-bookworm | skipping: Conditional result was False 2025-07-10 15:23:09.003492 | 2025-07-10 15:23:09.003638 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-07-10 15:23:09.484654 | debian-bookworm -> localhost | changed 2025-07-10 15:23:09.497757 | 2025-07-10 15:23:09.497897 | TASK [add-build-sshkey : Add back temp key] 2025-07-10 15:23:09.858327 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/5adf5a39c3b54f8b929bcf63d10ab60c/work/5adf5a39c3b54f8b929bcf63d10ab60c_id_rsa (zuul-build-sshkey) 2025-07-10 15:23:09.858929 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018267 2025-07-10 15:23:09.875913 | 2025-07-10 15:23:09.876085 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-07-10 15:23:10.276433 | debian-bookworm | ok 2025-07-10 15:23:10.284883 | 2025-07-10 15:23:10.285056 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-07-10 15:23:10.320288 | debian-bookworm | skipping: Conditional result was False 2025-07-10 15:23:10.337381 | 2025-07-10 15:23:10.337543 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-07-10 15:23:10.780446 | debian-bookworm | ok 2025-07-10 15:23:10.795503 | 2025-07-10 15:23:10.795642 | TASK [validate-host : Define zuul_info_dir fact] 2025-07-10 15:23:10.841268 | debian-bookworm | ok 2025-07-10 15:23:10.849820 | 2025-07-10 15:23:10.849963 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-07-10 15:23:11.168438 | debian-bookworm -> localhost | ok 2025-07-10 15:23:11.182759 | 2025-07-10 15:23:11.182961 | TASK [validate-host : Collect information about the host] 2025-07-10 15:23:12.286267 | debian-bookworm | ok 2025-07-10 15:23:12.300734 | 2025-07-10 15:23:12.300866 | TASK [validate-host : Sanitize hostname] 2025-07-10 15:23:12.411050 | debian-bookworm | ok 2025-07-10 15:23:12.453997 | 2025-07-10 15:23:12.454133 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-07-10 15:23:13.018908 | debian-bookworm -> localhost | changed 2025-07-10 15:23:13.031156 | 2025-07-10 15:23:13.031338 | TASK [validate-host : Collect information about zuul worker] 2025-07-10 15:23:13.444609 | debian-bookworm | ok 2025-07-10 15:23:13.452849 | 2025-07-10 15:23:13.452996 | TASK [validate-host : Write out all zuul information for each host] 2025-07-10 15:23:14.015164 | debian-bookworm -> localhost | changed 2025-07-10 15:23:14.029925 | 2025-07-10 15:23:14.030072 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-07-10 15:23:14.308871 | debian-bookworm | ok 2025-07-10 15:23:14.317964 | 2025-07-10 15:23:14.318105 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-07-10 15:23:15.155911 | debian-bookworm | changed: 2025-07-10 15:23:15.156328 | debian-bookworm | cd+++++++++ src/ 2025-07-10 15:23:15.156439 | debian-bookworm | cd+++++++++ src/github.com/ 2025-07-10 15:23:15.156479 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-07-10 15:23:15.156512 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-inventory-reconciler/ 2025-07-10 15:23:15.156543 | debian-bookworm | Containerfile 2025-07-10 15:23:15.156939 | debian-bookworm | 3.5.1-r0) 2025-07-10 15:24:16.770014 | debian-bookworm | #9 6.373 (25/34) Upgrading libssl3 (3.5.0-r0 -> 3.5.1-r0) 2025-07-10 15:24:16.990426 | debian-bookworm | #9 6.394 (26/34) Installing openssl-dev (3.5.1-r0) 2025-07-10 15:24:16.990497 | debian-bookworm | #9 6.429 (27/34) Installing mpdecimal (4.0.1-r0) 2025-07-10 15:24:16.990516 | debian-bookworm | #9 6.443 (28/34) Installing python3 (3.12.11-r0) 2025-07-10 15:24:17.115240 | debian-bookworm | #9 6.718 (29/34) Installing python3-pycache-pyc0 (3.12.11-r0) 2025-07-10 15:24:17.278365 | debian-bookworm | #9 6.881 (30/34) Installing pyc (3.12.11-r0) 2025-07-10 15:24:17.278421 | debian-bookworm | #9 6.881 (31/34) Installing python3-pyc (3.12.11-r0) 2025-07-10 15:24:17.278427 | debian-bookworm | #9 6.881 (32/34) Installing python3-dev (3.12.11-r0) 2025-07-10 15:24:17.756444 | debian-bookworm | #9 7.359 (33/34) Installing yq-go (4.46.1-r0) 2025-07-10 15:24:17.927760 | debian-bookworm | #9 7.531 (34/34) Installing .build-deps (20250710.152412) 2025-07-10 15:24:18.158350 | debian-bookworm | #9 7.533 Executing busybox-1.37.0-r18.trigger 2025-07-10 15:24:18.158413 | debian-bookworm | #9 7.542 Executing ca-certificates-20241121-r2.trigger 2025-07-10 15:24:18.158419 | debian-bookworm | #9 7.608 OK: 359 MiB in 82 packages 2025-07-10 15:24:18.467422 | debian-bookworm | #9 DONE 8.1s 2025-07-10 15:24:18.577520 | debian-bookworm | 2025-07-10 15:24:18.577609 | debian-bookworm | #10 [builder 4/22] COPY --link files/requirements.txt /requirements.txt 2025-07-10 15:24:18.577619 | debian-bookworm | #10 DONE 0.1s 2025-07-10 15:24:18.694420 | debian-bookworm | 2025-07-10 15:24:18.694546 | debian-bookworm | #11 [builder 5/22] COPY --link files/render-python-requirements.py /render-python-requirements.py 2025-07-10 15:24:18.694601 | debian-bookworm | #11 DONE 0.1s 2025-07-10 15:24:18.694635 | debian-bookworm | 2025-07-10 15:24:18.694666 | debian-bookworm | #12 [builder 6/22] COPY --link files/templates /templates 2025-07-10 15:24:18.694701 | debian-bookworm | #12 DONE 0.1s 2025-07-10 15:24:18.849564 | debian-bookworm | 2025-07-10 15:24:18.849689 | debian-bookworm | #13 [builder 7/22] RUN --mount=type=cache,target=/root/.cache/uv uv pip install --no-cache --system -r /requirements.txt 2025-07-10 15:24:19.444379 | debian-bookworm | #13 0.745 Using Python 3.13.5 environment at: /usr/local 2025-07-10 15:24:19.773257 | debian-bookworm | #13 1.074 Resolved 17 packages in 325ms 2025-07-10 15:24:19.973536 | debian-bookworm | #13 1.098 Downloading netaddr (2.2MiB) 2025-07-10 15:24:19.973591 | debian-bookworm | #13 1.121 Downloading cryptography (4.4MiB) 2025-07-10 15:24:19.973596 | debian-bookworm | #13 1.124 Downloading ansible-core (2.1MiB) 2025-07-10 15:24:20.170880 | debian-bookworm | #13 1.472 Downloading netaddr 2025-07-10 15:24:20.332536 | debian-bookworm | #13 1.505 Downloading cryptography 2025-07-10 15:24:20.332589 | debian-bookworm | #13 1.634 Downloading ansible-core 2025-07-10 15:24:20.513559 | debian-bookworm | #13 1.634 Prepared 17 packages in 557ms 2025-07-10 15:24:20.513670 | debian-bookworm | #13 1.683 Installed 17 packages in 48ms 2025-07-10 15:24:20.513685 | debian-bookworm | #13 1.683 + ansible-core==2.18.6 2025-07-10 15:24:20.513699 | debian-bookworm | #13 1.683 + certifi==2025.7.9 2025-07-10 15:24:20.513711 | debian-bookworm | #13 1.683 + cffi==1.17.1 2025-07-10 15:24:20.513722 | debian-bookworm | #13 1.683 + charset-normalizer==3.4.2 2025-07-10 15:24:20.513734 | debian-bookworm | #13 1.683 + cryptography==45.0.5 2025-07-10 15:24:20.513765 | debian-bookworm | #13 1.683 + dynaconf==3.2.11 2025-07-10 15:24:20.513777 | debian-bookworm | #13 1.683 + idna==3.10 2025-07-10 15:24:20.513789 | debian-bookworm | #13 1.683 + jinja2==3.1.6 2025-07-10 15:24:20.513800 | debian-bookworm | #13 1.683 + markupsafe==3.0.2 2025-07-10 15:24:20.513810 | debian-bookworm | #13 1.683 + netaddr==1.3.0 2025-07-10 15:24:20.513821 | debian-bookworm | #13 1.683 + packaging==25.0 2025-07-10 15:24:20.513846 | debian-bookworm | #13 1.683 + pycparser==2.22 2025-07-10 15:24:20.513858 | debian-bookworm | #13 1.683 + pynetbox==7.5.0 2025-07-10 15:24:20.513869 | debian-bookworm | #13 1.684 + pyyaml==6.0.2 2025-07-10 15:24:20.513880 | debian-bookworm | #13 1.684 + requests==2.32.4 2025-07-10 15:24:20.513890 | debian-bookworm | #13 1.684 + resolvelib==1.0.1 2025-07-10 15:24:20.513901 | debian-bookworm | #13 1.684 + urllib3==2.5.0 2025-07-10 15:24:20.513912 | debian-bookworm | #13 DONE 1.8s 2025-07-10 15:24:20.671630 | debian-bookworm | 2025-07-10 15:24:20.671705 | debian-bookworm | #14 [builder 8/22] RUN < localhost | ok: Runtime: 0:00:00.007826 2025-07-10 15:25:45.003622 | 2025-07-10 15:25:45.003743 | TASK [upload-logs : Upload logs to log server] 2025-07-10 15:25:45.578287 | localhost | Output suppressed because no_log was given 2025-07-10 15:25:45.580424 | 2025-07-10 15:25:45.580543 | LOOP [upload-logs : Compress console log and json output] 2025-07-10 15:25:45.640143 | localhost | skipping: Conditional result was False 2025-07-10 15:25:45.645814 | localhost | skipping: Conditional result was False 2025-07-10 15:25:45.652597 | 2025-07-10 15:25:45.652879 | LOOP [upload-logs : Upload compressed console log and json output] 2025-07-10 15:25:45.701393 | localhost | skipping: Conditional result was False 2025-07-10 15:25:45.702113 | 2025-07-10 15:25:45.705854 | localhost | skipping: Conditional result was False 2025-07-10 15:25:45.714201 | 2025-07-10 15:25:45.714421 | LOOP [upload-logs : Upload console log and json output]