2026-01-29 22:31:54.524867 | Job console starting 2026-01-29 22:31:54.557203 | Updating git repos 2026-01-29 22:31:54.638568 | Cloning repos into workspace 2026-01-29 22:31:54.786958 | Restoring repo states 2026-01-29 22:31:54.821760 | Merging changes 2026-01-29 22:31:55.566846 | Checking out repos 2026-01-29 22:31:55.715341 | Preparing playbooks 2026-01-29 22:31:57.469416 | Running Ansible setup 2026-01-29 22:32:05.807972 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-29 22:32:07.672142 | 2026-01-29 22:32:07.672284 | PLAY [Base pre] 2026-01-29 22:32:07.732245 | 2026-01-29 22:32:07.732382 | TASK [Setup log path fact] 2026-01-29 22:32:07.772311 | debian-bookworm | ok 2026-01-29 22:32:07.818678 | 2026-01-29 22:32:07.818820 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-29 22:32:07.913074 | debian-bookworm | ok 2026-01-29 22:32:07.942870 | 2026-01-29 22:32:07.943020 | TASK [emit-job-header : Print job information] 2026-01-29 22:32:08.041860 | # Job Information 2026-01-29 22:32:08.042073 | Ansible Version: 2.16.14 2026-01-29 22:32:08.042113 | Job: container-image-inventory-reconciler-build 2026-01-29 22:32:08.042147 | Pipeline: check 2026-01-29 22:32:08.042171 | Executor: 521e9411259a 2026-01-29 22:32:08.042191 | Triggered by: https://github.com/osism/container-image-inventory-reconciler/pull/485 2026-01-29 22:32:08.042213 | Event ID: 6eeeeaf0-fd5e-11f0-8431-37f02339f864 2026-01-29 22:32:08.047467 | 2026-01-29 22:32:08.047556 | LOOP [emit-job-header : Print node information] 2026-01-29 22:32:08.370983 | debian-bookworm | ok: 2026-01-29 22:32:08.371209 | debian-bookworm | # Node Information 2026-01-29 22:32:08.371245 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-29 22:32:08.371270 | debian-bookworm | Hostname: debian 2026-01-29 22:32:08.371292 | debian-bookworm | Username: zuul 2026-01-29 22:32:08.371312 | debian-bookworm | Distro: Debian 12.13 2026-01-29 22:32:08.371336 | debian-bookworm | Provider: regiocloud-a 2026-01-29 22:32:08.371357 | debian-bookworm | Region: 2026-01-29 22:32:08.371379 | debian-bookworm | Label: debian-bookworm 2026-01-29 22:32:08.371426 | debian-bookworm | Product Name: OpenStack Nova 2026-01-29 22:32:08.371452 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe62:c2d3 2026-01-29 22:32:08.412383 | 2026-01-29 22:32:08.412519 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-29 22:32:09.477106 | debian-bookworm -> localhost | changed 2026-01-29 22:32:09.506666 | 2026-01-29 22:32:09.507765 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-29 22:32:12.689507 | debian-bookworm -> localhost | changed 2026-01-29 22:32:12.698458 | 2026-01-29 22:32:12.698549 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-29 22:32:13.601153 | debian-bookworm -> localhost | ok 2026-01-29 22:32:13.606041 | 2026-01-29 22:32:13.606126 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-29 22:32:13.633116 | debian-bookworm | ok 2026-01-29 22:32:13.670496 | debian-bookworm | included: /var/lib/zuul/builds/326bef70f4ee435ebc869a1311983fef/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-29 22:32:13.686423 | 2026-01-29 22:32:13.686502 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-29 22:32:16.210155 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-29 22:32:16.210332 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/326bef70f4ee435ebc869a1311983fef/work/326bef70f4ee435ebc869a1311983fef_id_rsa 2026-01-29 22:32:16.210365 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/326bef70f4ee435ebc869a1311983fef/work/326bef70f4ee435ebc869a1311983fef_id_rsa.pub 2026-01-29 22:32:16.210388 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-29 22:32:16.210410 | debian-bookworm -> localhost | SHA256:iArrOIXj8iR/+SJ0LEgTCTuajTX3F5w0BkyYXQug/Zk zuul-build-sshkey 2026-01-29 22:32:16.210437 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-29 22:32:16.210456 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-29 22:32:16.210474 | debian-bookworm -> localhost | |o . .B+o= | 2026-01-29 22:32:16.210492 | debian-bookworm -> localhost | | + oo o= + | 2026-01-29 22:32:16.210508 | debian-bookworm -> localhost | |o = o = | 2026-01-29 22:32:16.210525 | debian-bookworm -> localhost | |.O o + + . | 2026-01-29 22:32:16.210541 | debian-bookworm -> localhost | |*oo.. E S | 2026-01-29 22:32:16.210561 | debian-bookworm -> localhost | |+o+.o . | 2026-01-29 22:32:16.210578 | debian-bookworm -> localhost | |++oo . | 2026-01-29 22:32:16.210594 | debian-bookworm -> localhost | |==. + | 2026-01-29 22:32:16.210612 | debian-bookworm -> localhost | |o+oo o. | 2026-01-29 22:32:16.210629 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-29 22:32:16.210669 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.231422 2026-01-29 22:32:16.216019 | 2026-01-29 22:32:16.216094 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-29 22:32:16.264210 | debian-bookworm | ok 2026-01-29 22:32:16.281539 | debian-bookworm | included: /var/lib/zuul/builds/326bef70f4ee435ebc869a1311983fef/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-29 22:32:16.303547 | 2026-01-29 22:32:16.303646 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-29 22:32:16.342623 | debian-bookworm | skipping: Conditional result was False 2026-01-29 22:32:16.347958 | 2026-01-29 22:32:16.348053 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-29 22:32:17.155851 | debian-bookworm | changed 2026-01-29 22:32:17.161297 | 2026-01-29 22:32:17.161388 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-29 22:32:17.608687 | debian-bookworm | ok 2026-01-29 22:32:17.628262 | 2026-01-29 22:32:17.628371 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-29 22:32:18.439260 | debian-bookworm | changed 2026-01-29 22:32:18.451018 | 2026-01-29 22:32:18.451162 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-29 22:32:19.326288 | debian-bookworm | changed 2026-01-29 22:32:19.336006 | 2026-01-29 22:32:19.336138 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-29 22:32:19.389431 | debian-bookworm | skipping: Conditional result was False 2026-01-29 22:32:19.395538 | 2026-01-29 22:32:19.395642 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-29 22:32:20.577693 | debian-bookworm -> localhost | changed 2026-01-29 22:32:20.586651 | 2026-01-29 22:32:20.586737 | TASK [add-build-sshkey : Add back temp key] 2026-01-29 22:32:21.476732 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/326bef70f4ee435ebc869a1311983fef/work/326bef70f4ee435ebc869a1311983fef_id_rsa (zuul-build-sshkey) 2026-01-29 22:32:21.476963 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.029219 2026-01-29 22:32:21.484344 | 2026-01-29 22:32:21.484434 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-29 22:32:22.089678 | debian-bookworm | ok 2026-01-29 22:32:22.097173 | 2026-01-29 22:32:22.097277 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-29 22:32:22.183290 | debian-bookworm | skipping: Conditional result was False 2026-01-29 22:32:22.197529 | 2026-01-29 22:32:22.197639 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-29 22:32:23.055837 | debian-bookworm | ok 2026-01-29 22:32:23.069772 | 2026-01-29 22:32:23.069861 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-29 22:32:23.129649 | debian-bookworm | ok 2026-01-29 22:32:23.133845 | 2026-01-29 22:32:23.133995 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-29 22:32:24.126054 | debian-bookworm -> localhost | ok 2026-01-29 22:32:24.132513 | 2026-01-29 22:32:24.132612 | TASK [validate-host : Collect information about the host] 2026-01-29 22:32:26.401989 | debian-bookworm | ok 2026-01-29 22:32:26.411705 | 2026-01-29 22:32:26.411819 | TASK [validate-host : Sanitize hostname] 2026-01-29 22:32:26.537100 | debian-bookworm | ok 2026-01-29 22:32:26.625214 | 2026-01-29 22:32:26.627585 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-29 22:32:28.133443 | debian-bookworm -> localhost | changed 2026-01-29 22:32:28.138175 | 2026-01-29 22:32:28.138257 | TASK [validate-host : Collect information about zuul worker] 2026-01-29 22:32:29.027557 | debian-bookworm | ok 2026-01-29 22:32:29.031420 | 2026-01-29 22:32:29.031504 | TASK [validate-host : Write out all zuul information for each host] 2026-01-29 22:32:31.336361 | debian-bookworm -> localhost | changed 2026-01-29 22:32:31.345668 | 2026-01-29 22:32:31.345763 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-29 22:32:31.699599 | debian-bookworm | ok 2026-01-29 22:32:31.704895 | 2026-01-29 22:32:31.705003 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-29 22:32:33.909515 | debian-bookworm | changed: 2026-01-29 22:32:33.909685 | debian-bookworm | cd+++++++++ src/ 2026-01-29 22:32:33.909719 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-29 22:32:33.909744 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-29 22:32:33.909765 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-inventory-reconciler/ 2026-01-29 22:32:33.909785 | debian-bookworm | Containerfile 2026-01-29 22:32:33.909946 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006927 2026-01-29 22:34:43.073920 | 2026-01-29 22:34:43.074030 | TASK [upload-logs : Upload logs to log server] 2026-01-29 22:34:43.655146 | localhost | Output suppressed because no_log was given 2026-01-29 22:34:43.657958 | 2026-01-29 22:34:43.658142 | LOOP [upload-logs : Compress console log and json output] 2026-01-29 22:34:43.713202 | localhost | skipping: Conditional result was False 2026-01-29 22:34:43.717972 | localhost | skipping: Conditional result was False 2026-01-29 22:34:43.732670 | 2026-01-29 22:34:43.732889 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-29 22:34:43.779598 | localhost | skipping: Conditional result was False 2026-01-29 22:34:43.780193 | 2026-01-29 22:34:43.783723 | localhost | skipping: Conditional result was False 2026-01-29 22:34:43.797234 | 2026-01-29 22:34:43.797458 | LOOP [upload-logs : Upload console log and json output]