2025-05-25 14:56:12.108465 | Job console starting 2025-05-25 14:56:12.135457 | Updating git repos 2025-05-25 14:56:12.187517 | Cloning repos into workspace 2025-05-25 14:56:12.236531 | Restoring repo states 2025-05-25 14:56:12.248004 | Merging changes 2025-05-25 14:56:12.804622 | Checking out repos 2025-05-25 14:56:12.880035 | Preparing playbooks 2025-05-25 14:56:14.064835 | Running Ansible setup 2025-05-25 14:56:20.303523 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-25 14:56:21.881915 | 2025-05-25 14:56:21.882089 | PLAY [Base pre] 2025-05-25 14:56:21.927877 | 2025-05-25 14:56:21.928058 | TASK [Setup log path fact] 2025-05-25 14:56:21.970443 | debian-bookworm | ok 2025-05-25 14:56:22.003514 | 2025-05-25 14:56:22.005292 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-25 14:56:22.112517 | debian-bookworm | ok 2025-05-25 14:56:22.125449 | 2025-05-25 14:56:22.125586 | TASK [emit-job-header : Print job information] 2025-05-25 14:56:22.236348 | # Job Information 2025-05-25 14:56:22.236532 | Ansible Version: 2.16.14 2025-05-25 14:56:22.236567 | Job: container-image-inventory-reconciler-build 2025-05-25 14:56:22.236600 | Pipeline: check 2025-05-25 14:56:22.236623 | Executor: 521e9411259a 2025-05-25 14:56:22.236644 | Triggered by: https://github.com/osism/container-image-inventory-reconciler/pull/336 2025-05-25 14:56:22.236665 | Event ID: 61776a00-3978-11f0-9b22-23828888ef4e 2025-05-25 14:56:22.248940 | 2025-05-25 14:56:22.249073 | LOOP [emit-job-header : Print node information] 2025-05-25 14:56:22.458697 | debian-bookworm | ok: 2025-05-25 14:56:22.458993 | debian-bookworm | # Node Information 2025-05-25 14:56:22.459620 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-05-25 14:56:22.459692 | debian-bookworm | Hostname: debian 2025-05-25 14:56:22.459719 | debian-bookworm | Username: zuul 2025-05-25 14:56:22.459742 | debian-bookworm | Distro: Debian 12.11 2025-05-25 14:56:22.459767 | debian-bookworm | Provider: regiocloud-a 2025-05-25 14:56:22.459789 | debian-bookworm | Region: 2025-05-25 14:56:22.459811 | debian-bookworm | Label: debian-bookworm 2025-05-25 14:56:22.459831 | debian-bookworm | Product Name: OpenStack Nova 2025-05-25 14:56:22.459850 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe72:1c46 2025-05-25 14:56:22.494414 | 2025-05-25 14:56:22.494569 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-25 14:56:23.506399 | debian-bookworm -> localhost | changed 2025-05-25 14:56:23.514404 | 2025-05-25 14:56:23.514533 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-25 14:56:25.483424 | debian-bookworm -> localhost | changed 2025-05-25 14:56:25.508653 | 2025-05-25 14:56:25.508786 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-25 14:56:25.919872 | debian-bookworm -> localhost | ok 2025-05-25 14:56:25.927410 | 2025-05-25 14:56:25.927585 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-25 14:56:25.961037 | debian-bookworm | ok 2025-05-25 14:56:26.000095 | debian-bookworm | included: /var/lib/zuul/builds/f92551218e5d4c71a82b47664e29c5a0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-25 14:56:26.008835 | 2025-05-25 14:56:26.009027 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-25 14:56:27.653755 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-05-25 14:56:27.654065 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/f92551218e5d4c71a82b47664e29c5a0/work/f92551218e5d4c71a82b47664e29c5a0_id_rsa 2025-05-25 14:56:27.654121 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/f92551218e5d4c71a82b47664e29c5a0/work/f92551218e5d4c71a82b47664e29c5a0_id_rsa.pub 2025-05-25 14:56:27.654148 | debian-bookworm -> localhost | The key fingerprint is: 2025-05-25 14:56:27.654173 | debian-bookworm -> localhost | SHA256:+/TnVGDTtCcjF1cKBFh1jEbyjBLpS4s5JoNEaoI7xP0 zuul-build-sshkey 2025-05-25 14:56:27.654207 | debian-bookworm -> localhost | The key's randomart image is: 2025-05-25 14:56:27.654230 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-05-25 14:56:27.654251 | debian-bookworm -> localhost | | .++==oo =| 2025-05-25 14:56:27.654273 | debian-bookworm -> localhost | | . o. =oo.*.| 2025-05-25 14:56:27.654293 | debian-bookworm -> localhost | |oo. .. ..+ O.o| 2025-05-25 14:56:27.654312 | debian-bookworm -> localhost | |++.. o. + =.| 2025-05-25 14:56:27.654332 | debian-bookworm -> localhost | |+o .. +So .| 2025-05-25 14:56:27.654357 | debian-bookworm -> localhost | |o . oE= o. . | 2025-05-25 14:56:27.654378 | debian-bookworm -> localhost | | . + .. . . | 2025-05-25 14:56:27.654398 | debian-bookworm -> localhost | | o . .. | 2025-05-25 14:56:27.654419 | debian-bookworm -> localhost | | . .o. | 2025-05-25 14:56:27.654440 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-05-25 14:56:27.654650 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.769615 2025-05-25 14:56:27.664791 | 2025-05-25 14:56:27.664925 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-25 14:56:27.704167 | debian-bookworm | ok 2025-05-25 14:56:27.716040 | debian-bookworm | included: /var/lib/zuul/builds/f92551218e5d4c71a82b47664e29c5a0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-25 14:56:27.725651 | 2025-05-25 14:56:27.725775 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-25 14:56:27.752611 | debian-bookworm | skipping: Conditional result was False 2025-05-25 14:56:27.764442 | 2025-05-25 14:56:27.764584 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-25 14:56:28.381361 | debian-bookworm | changed 2025-05-25 14:56:28.389274 | 2025-05-25 14:56:28.389391 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-25 14:56:28.678430 | debian-bookworm | ok 2025-05-25 14:56:28.687474 | 2025-05-25 14:56:28.687601 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-25 14:56:29.337117 | debian-bookworm | changed 2025-05-25 14:56:29.349828 | 2025-05-25 14:56:29.349931 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-25 14:56:29.936700 | debian-bookworm | changed 2025-05-25 14:56:29.941959 | 2025-05-25 14:56:29.942043 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-25 14:56:29.958681 | debian-bookworm | skipping: Conditional result was False 2025-05-25 14:56:29.964343 | 2025-05-25 14:56:29.964429 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-25 14:56:30.435847 | debian-bookworm -> localhost | changed 2025-05-25 14:56:30.446272 | 2025-05-25 14:56:30.446372 | TASK [add-build-sshkey : Add back temp key] 2025-05-25 14:56:30.751947 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/f92551218e5d4c71a82b47664e29c5a0/work/f92551218e5d4c71a82b47664e29c5a0_id_rsa (zuul-build-sshkey) 2025-05-25 14:56:30.752188 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010575 2025-05-25 14:56:30.759841 | 2025-05-25 14:56:30.759939 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-25 14:56:31.144592 | debian-bookworm | ok 2025-05-25 14:56:31.151533 | 2025-05-25 14:56:31.151630 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-25 14:56:31.174351 | debian-bookworm | skipping: Conditional result was False 2025-05-25 14:56:31.184910 | 2025-05-25 14:56:31.185035 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-25 14:56:31.607357 | debian-bookworm | ok 2025-05-25 14:56:31.618447 | 2025-05-25 14:56:31.618553 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-25 14:56:31.648166 | debian-bookworm | ok 2025-05-25 14:56:31.653013 | 2025-05-25 14:56:31.653104 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-25 14:56:31.977495 | debian-bookworm -> localhost | ok 2025-05-25 14:56:31.984511 | 2025-05-25 14:56:31.984641 | TASK [validate-host : Collect information about the host] 2025-05-25 14:56:33.151740 | debian-bookworm | ok 2025-05-25 14:56:33.162222 | 2025-05-25 14:56:33.162358 | TASK [validate-host : Sanitize hostname] 2025-05-25 14:56:33.264702 | debian-bookworm | ok 2025-05-25 14:56:33.303727 | 2025-05-25 14:56:33.303856 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-25 14:56:34.251297 | debian-bookworm -> localhost | changed 2025-05-25 14:56:34.257257 | 2025-05-25 14:56:34.257383 | TASK [validate-host : Collect information about zuul worker] 2025-05-25 14:56:34.724871 | debian-bookworm | ok 2025-05-25 14:56:34.730509 | 2025-05-25 14:56:34.730626 | TASK [validate-host : Write out all zuul information for each host] 2025-05-25 14:56:35.426360 | debian-bookworm -> localhost | changed 2025-05-25 14:56:35.437081 | 2025-05-25 14:56:35.437217 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-25 14:56:35.712128 | debian-bookworm | ok 2025-05-25 14:56:35.720781 | 2025-05-25 14:56:35.720906 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-25 14:56:36.721754 | debian-bookworm | changed: 2025-05-25 14:56:36.721959 | debian-bookworm | cd+++++++++ src/ 2025-05-25 14:56:36.721995 | debian-bookworm | cd+++++++++ src/github.com/ 2025-05-25 14:56:36.722019 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-05-25 14:56:36.722040 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-inventory-reconciler/ 2025-05-25 14:56:36.722060 | debian-bookworm | Containerfile 2025-05-25 14:56:36.722235 | debian-bookworm | localhost | ok: Runtime: 0:00:00.011320 2025-05-25 14:58:18.903284 | 2025-05-25 14:58:18.903479 | TASK [upload-logs : Upload logs to log server] 2025-05-25 14:58:20.043377 | localhost | Output suppressed because no_log was given 2025-05-25 14:58:20.044782 | 2025-05-25 14:58:20.044854 | LOOP [upload-logs : Compress console log and json output] 2025-05-25 14:58:20.121942 | localhost | skipping: Conditional result was False 2025-05-25 14:58:20.126753 | localhost | skipping: Conditional result was False 2025-05-25 14:58:20.129718 | 2025-05-25 14:58:20.129799 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-25 14:58:20.189192 | localhost | skipping: Conditional result was False 2025-05-25 14:58:20.189426 | 2025-05-25 14:58:20.193284 | localhost | skipping: Conditional result was False 2025-05-25 14:58:20.201468 | 2025-05-25 14:58:20.201555 | LOOP [upload-logs : Upload console log and json output]