2025-05-28 16:49:18.924542 | Job console starting 2025-05-28 16:49:18.942908 | Updating git repos 2025-05-28 16:49:18.967346 | Cloning repos into workspace 2025-05-28 16:49:19.014638 | Restoring repo states 2025-05-28 16:49:19.025377 | Merging changes 2025-05-28 16:49:19.544678 | Checking out repos 2025-05-28 16:49:19.620951 | Preparing playbooks 2025-05-28 16:49:20.683190 | Running Ansible setup 2025-05-28 16:49:25.852599 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-28 16:49:26.756054 | 2025-05-28 16:49:26.756239 | PLAY [Base pre] 2025-05-28 16:49:26.772638 | 2025-05-28 16:49:26.772804 | TASK [Setup log path fact] 2025-05-28 16:49:26.803522 | debian-bookworm | ok 2025-05-28 16:49:26.819009 | 2025-05-28 16:49:26.819173 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-28 16:49:26.849786 | debian-bookworm | ok 2025-05-28 16:49:26.861491 | 2025-05-28 16:49:26.861630 | TASK [emit-job-header : Print job information] 2025-05-28 16:49:26.900964 | # Job Information 2025-05-28 16:49:26.901180 | Ansible Version: 2.16.14 2025-05-28 16:49:26.901215 | Job: container-image-inventory-reconciler-build 2025-05-28 16:49:26.901248 | Pipeline: check 2025-05-28 16:49:26.901271 | Executor: 521e9411259a 2025-05-28 16:49:26.901292 | Triggered by: https://github.com/osism/container-image-inventory-reconciler/pull/373 2025-05-28 16:49:26.901316 | Event ID: ad3aeb20-3be3-11f0-9972-aa76d317f9e1 2025-05-28 16:49:26.906321 | 2025-05-28 16:49:26.906465 | LOOP [emit-job-header : Print node information] 2025-05-28 16:49:27.092200 | debian-bookworm | ok: 2025-05-28 16:49:27.092469 | debian-bookworm | # Node Information 2025-05-28 16:49:27.092531 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-05-28 16:49:27.092559 | debian-bookworm | Hostname: debian 2025-05-28 16:49:27.092582 | debian-bookworm | Username: zuul 2025-05-28 16:49:27.092602 | debian-bookworm | Distro: Debian 12.11 2025-05-28 16:49:27.092626 | debian-bookworm | Provider: regiocloud-a 2025-05-28 16:49:27.092646 | debian-bookworm | Region: 2025-05-28 16:49:27.092667 | debian-bookworm | Label: debian-bookworm 2025-05-28 16:49:27.092686 | debian-bookworm | Product Name: OpenStack Nova 2025-05-28 16:49:27.092706 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe22:23d2 2025-05-28 16:49:27.114687 | 2025-05-28 16:49:27.114901 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-28 16:49:27.898255 | debian-bookworm -> localhost | changed 2025-05-28 16:49:27.906222 | 2025-05-28 16:49:27.906364 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-28 16:49:29.393953 | debian-bookworm -> localhost | changed 2025-05-28 16:49:29.405574 | 2025-05-28 16:49:29.405719 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-28 16:49:29.805470 | debian-bookworm -> localhost | ok 2025-05-28 16:49:29.812300 | 2025-05-28 16:49:29.812480 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-28 16:49:29.841937 | debian-bookworm | ok 2025-05-28 16:49:29.898745 | debian-bookworm | included: /var/lib/zuul/builds/3dee669c137b44dd9df7e94ffd65a576/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-28 16:49:29.909281 | 2025-05-28 16:49:29.909413 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-28 16:49:31.475360 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-05-28 16:49:31.475665 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/3dee669c137b44dd9df7e94ffd65a576/work/3dee669c137b44dd9df7e94ffd65a576_id_rsa 2025-05-28 16:49:31.475706 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/3dee669c137b44dd9df7e94ffd65a576/work/3dee669c137b44dd9df7e94ffd65a576_id_rsa.pub 2025-05-28 16:49:31.475732 | debian-bookworm -> localhost | The key fingerprint is: 2025-05-28 16:49:31.475756 | debian-bookworm -> localhost | SHA256:zCKJpsDzoAg1JWFcsucDbuB4OgfUtW2OqSui/pkPcHU zuul-build-sshkey 2025-05-28 16:49:31.475793 | debian-bookworm -> localhost | The key's randomart image is: 2025-05-28 16:49:31.475816 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-05-28 16:49:31.475837 | debian-bookworm -> localhost | | .=oo. | 2025-05-28 16:49:31.475858 | debian-bookworm -> localhost | | .o=. o | 2025-05-28 16:49:31.475878 | debian-bookworm -> localhost | |..=..o E | 2025-05-28 16:49:31.475897 | debian-bookworm -> localhost | |=+ *..*o | 2025-05-28 16:49:31.475916 | debian-bookworm -> localhost | |=**.=o..S | 2025-05-28 16:49:31.475946 | debian-bookworm -> localhost | |=B* .o . | 2025-05-28 16:49:31.475967 | debian-bookworm -> localhost | |* .+ | 2025-05-28 16:49:31.475988 | debian-bookworm -> localhost | |.+ = | 2025-05-28 16:49:31.476009 | debian-bookworm -> localhost | |=.o=.. | 2025-05-28 16:49:31.476029 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-05-28 16:49:31.476086 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.753005 2025-05-28 16:49:31.483927 | 2025-05-28 16:49:31.484053 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-28 16:49:31.531509 | debian-bookworm | ok 2025-05-28 16:49:31.551988 | debian-bookworm | included: /var/lib/zuul/builds/3dee669c137b44dd9df7e94ffd65a576/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-28 16:49:31.562004 | 2025-05-28 16:49:31.562154 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-28 16:49:31.586809 | debian-bookworm | skipping: Conditional result was False 2025-05-28 16:49:31.594599 | 2025-05-28 16:49:31.594740 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-28 16:49:32.351733 | debian-bookworm | changed 2025-05-28 16:49:32.361645 | 2025-05-28 16:49:32.361957 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-28 16:49:32.646359 | debian-bookworm | ok 2025-05-28 16:49:32.653817 | 2025-05-28 16:49:32.653946 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-28 16:49:33.386161 | debian-bookworm | changed 2025-05-28 16:49:33.400685 | 2025-05-28 16:49:33.400851 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-28 16:49:34.118379 | debian-bookworm | changed 2025-05-28 16:49:34.125662 | 2025-05-28 16:49:34.125774 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-28 16:49:34.149825 | debian-bookworm | skipping: Conditional result was False 2025-05-28 16:49:34.156410 | 2025-05-28 16:49:34.156545 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-28 16:49:34.757764 | debian-bookworm -> localhost | changed 2025-05-28 16:49:34.769719 | 2025-05-28 16:49:34.769865 | TASK [add-build-sshkey : Add back temp key] 2025-05-28 16:49:35.199564 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/3dee669c137b44dd9df7e94ffd65a576/work/3dee669c137b44dd9df7e94ffd65a576_id_rsa (zuul-build-sshkey) 2025-05-28 16:49:35.199882 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.036160 2025-05-28 16:49:35.208569 | 2025-05-28 16:49:35.208698 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-28 16:49:35.686370 | debian-bookworm | ok 2025-05-28 16:49:35.693352 | 2025-05-28 16:49:35.693525 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-28 16:49:35.748720 | debian-bookworm | skipping: Conditional result was False 2025-05-28 16:49:35.767545 | 2025-05-28 16:49:35.767687 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-28 16:49:36.241907 | debian-bookworm | ok 2025-05-28 16:49:36.257942 | 2025-05-28 16:49:36.262256 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-28 16:49:36.305316 | debian-bookworm | ok 2025-05-28 16:49:36.311100 | 2025-05-28 16:49:36.311210 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-28 16:49:36.639013 | debian-bookworm -> localhost | ok 2025-05-28 16:49:36.646732 | 2025-05-28 16:49:36.646907 | TASK [validate-host : Collect information about the host] 2025-05-28 16:49:37.824194 | debian-bookworm | ok 2025-05-28 16:49:37.855648 | 2025-05-28 16:49:37.855887 | TASK [validate-host : Sanitize hostname] 2025-05-28 16:49:37.990239 | debian-bookworm | ok 2025-05-28 16:49:38.035706 | 2025-05-28 16:49:38.035864 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-28 16:49:38.768635 | debian-bookworm -> localhost | changed 2025-05-28 16:49:38.779363 | 2025-05-28 16:49:38.779533 | TASK [validate-host : Collect information about zuul worker] 2025-05-28 16:49:39.229003 | debian-bookworm | ok 2025-05-28 16:49:39.234490 | 2025-05-28 16:49:39.234612 | TASK [validate-host : Write out all zuul information for each host] 2025-05-28 16:49:39.893812 | debian-bookworm -> localhost | changed 2025-05-28 16:49:39.904756 | 2025-05-28 16:49:39.904912 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-28 16:49:40.176031 | debian-bookworm | ok 2025-05-28 16:49:40.182138 | 2025-05-28 16:49:40.182252 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-28 16:49:41.230032 | debian-bookworm | changed: 2025-05-28 16:49:41.230302 | debian-bookworm | cd+++++++++ src/ 2025-05-28 16:49:41.230343 | debian-bookworm | cd+++++++++ src/github.com/ 2025-05-28 16:49:41.230368 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-05-28 16:49:41.230391 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-inventory-reconciler/ 2025-05-28 16:49:41.230412 | debian-bookworm | Containerfile 2025-05-28 16:49:41.230598 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006790 2025-05-28 16:51:22.958530 | 2025-05-28 16:51:22.958697 | TASK [upload-logs : Upload logs to log server] 2025-05-28 16:51:23.515643 | localhost | Output suppressed because no_log was given 2025-05-28 16:51:23.518344 | 2025-05-28 16:51:23.518479 | LOOP [upload-logs : Compress console log and json output] 2025-05-28 16:51:23.575217 | localhost | skipping: Conditional result was False 2025-05-28 16:51:23.580544 | localhost | skipping: Conditional result was False 2025-05-28 16:51:23.589660 | 2025-05-28 16:51:23.589818 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-28 16:51:23.641954 | localhost | skipping: Conditional result was False 2025-05-28 16:51:23.642737 | 2025-05-28 16:51:23.645192 | localhost | skipping: Conditional result was False 2025-05-28 16:51:23.660783 | 2025-05-28 16:51:23.660918 | LOOP [upload-logs : Upload console log and json output]