2025-10-31 19:23:06.335556 | Job console starting 2025-10-31 19:23:06.354454 | Updating git repos 2025-10-31 19:23:06.378246 | Cloning repos into workspace 2025-10-31 19:23:06.425276 | Restoring repo states 2025-10-31 19:23:06.439185 | Merging changes 2025-10-31 19:23:06.926927 | Checking out repos 2025-10-31 19:23:06.970713 | Preparing playbooks 2025-10-31 19:23:07.920933 | Running Ansible setup 2025-10-31 19:23:12.641165 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-31 19:23:13.457601 | 2025-10-31 19:23:13.457766 | PLAY [Base pre] 2025-10-31 19:23:13.473982 | 2025-10-31 19:23:13.474128 | TASK [Setup log path fact] 2025-10-31 19:23:13.494577 | debian-bookworm | ok 2025-10-31 19:23:13.531778 | 2025-10-31 19:23:13.531996 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-31 19:23:13.610251 | debian-bookworm | ok 2025-10-31 19:23:13.632430 | 2025-10-31 19:23:13.632567 | TASK [emit-job-header : Print job information] 2025-10-31 19:23:13.672613 | # Job Information 2025-10-31 19:23:13.672793 | Ansible Version: 2.16.14 2025-10-31 19:23:13.672827 | Job: container-image-inventory-reconciler-build 2025-10-31 19:23:13.672861 | Pipeline: check 2025-10-31 19:23:13.672884 | Executor: 521e9411259a 2025-10-31 19:23:13.672904 | Triggered by: https://github.com/osism/container-image-inventory-reconciler/pull/447 2025-10-31 19:23:13.672925 | Event ID: 01a64da0-b68f-11f0-9c67-a429dd657ef4 2025-10-31 19:23:13.677928 | 2025-10-31 19:23:13.678073 | LOOP [emit-job-header : Print node information] 2025-10-31 19:23:13.859086 | debian-bookworm | ok: 2025-10-31 19:23:13.859289 | debian-bookworm | # Node Information 2025-10-31 19:23:13.859325 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-31 19:23:13.859350 | debian-bookworm | Hostname: debian 2025-10-31 19:23:13.859372 | debian-bookworm | Username: zuul 2025-10-31 19:23:13.859393 | debian-bookworm | Distro: Debian 12.12 2025-10-31 19:23:13.859417 | debian-bookworm | Provider: regiocloud-a 2025-10-31 19:23:13.859438 | debian-bookworm | Region: 2025-10-31 19:23:13.859458 | debian-bookworm | Label: debian-bookworm 2025-10-31 19:23:13.859477 | debian-bookworm | Product Name: OpenStack Nova 2025-10-31 19:23:13.859496 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe93:dfa3 2025-10-31 19:23:13.880093 | 2025-10-31 19:23:13.880272 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-31 19:23:14.460840 | debian-bookworm -> localhost | changed 2025-10-31 19:23:14.468084 | 2025-10-31 19:23:14.468209 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-31 19:23:15.787654 | debian-bookworm -> localhost | changed 2025-10-31 19:23:15.797715 | 2025-10-31 19:23:15.797810 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-31 19:23:16.105507 | debian-bookworm -> localhost | ok 2025-10-31 19:23:16.111228 | 2025-10-31 19:23:16.111327 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-31 19:23:16.138965 | debian-bookworm | ok 2025-10-31 19:23:16.157707 | debian-bookworm | included: /var/lib/zuul/builds/d396e2c168a742f9935ad1b99e44a083/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-31 19:23:16.164580 | 2025-10-31 19:23:16.164662 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-31 19:23:17.888792 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-31 19:23:17.889233 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d396e2c168a742f9935ad1b99e44a083/work/d396e2c168a742f9935ad1b99e44a083_id_rsa 2025-10-31 19:23:17.889327 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d396e2c168a742f9935ad1b99e44a083/work/d396e2c168a742f9935ad1b99e44a083_id_rsa.pub 2025-10-31 19:23:17.889393 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-31 19:23:17.889456 | debian-bookworm -> localhost | SHA256:ImarptL1nvsHVneG3uNaHeC6loM2N7sro7DBNsUdP1U zuul-build-sshkey 2025-10-31 19:23:17.889529 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-31 19:23:17.889586 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-31 19:23:17.889640 | debian-bookworm -> localhost | | E | 2025-10-31 19:23:17.889694 | debian-bookworm -> localhost | | . | 2025-10-31 19:23:17.889745 | debian-bookworm -> localhost | | . + | 2025-10-31 19:23:17.889795 | debian-bookworm -> localhost | | . . + = + | 2025-10-31 19:23:17.889845 | debian-bookworm -> localhost | | + .oSo = = . | 2025-10-31 19:23:17.889903 | debian-bookworm -> localhost | | ooo..o + o..| 2025-10-31 19:23:17.889982 | debian-bookworm -> localhost | | . ..B . ........| 2025-10-31 19:23:17.890037 | debian-bookworm -> localhost | |. o.. *. *.*... | 2025-10-31 19:23:17.890090 | debian-bookworm -> localhost | |oo. o+++.*=B. | 2025-10-31 19:23:17.890141 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-31 19:23:17.890265 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.191759 2025-10-31 19:23:17.903682 | 2025-10-31 19:23:17.903819 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-31 19:23:17.937789 | debian-bookworm | ok 2025-10-31 19:23:17.951189 | debian-bookworm | included: /var/lib/zuul/builds/d396e2c168a742f9935ad1b99e44a083/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-31 19:23:17.960013 | 2025-10-31 19:23:17.960094 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-31 19:23:17.973077 | debian-bookworm | skipping: Conditional result was False 2025-10-31 19:23:17.978422 | 2025-10-31 19:23:17.978505 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-31 19:23:18.606663 | debian-bookworm | changed 2025-10-31 19:23:18.615376 | 2025-10-31 19:23:18.615506 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-31 19:23:18.859759 | debian-bookworm | ok 2025-10-31 19:23:18.865303 | 2025-10-31 19:23:18.865393 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-31 19:23:19.482483 | debian-bookworm | changed 2025-10-31 19:23:19.493798 | 2025-10-31 19:23:19.493905 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-31 19:23:20.150619 | debian-bookworm | changed 2025-10-31 19:23:20.156430 | 2025-10-31 19:23:20.156520 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-31 19:23:20.189420 | debian-bookworm | skipping: Conditional result was False 2025-10-31 19:23:20.196250 | 2025-10-31 19:23:20.196346 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-31 19:23:20.524404 | debian-bookworm -> localhost | changed 2025-10-31 19:23:20.538612 | 2025-10-31 19:23:20.542967 | TASK [add-build-sshkey : Add back temp key] 2025-10-31 19:23:20.901411 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d396e2c168a742f9935ad1b99e44a083/work/d396e2c168a742f9935ad1b99e44a083_id_rsa (zuul-build-sshkey) 2025-10-31 19:23:20.901730 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.016697 2025-10-31 19:23:20.913532 | 2025-10-31 19:23:20.913636 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-31 19:23:21.287277 | debian-bookworm | ok 2025-10-31 19:23:21.294318 | 2025-10-31 19:23:21.294431 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-31 19:23:21.327957 | debian-bookworm | skipping: Conditional result was False 2025-10-31 19:23:21.336406 | 2025-10-31 19:23:21.336480 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-31 19:23:21.729190 | debian-bookworm | ok 2025-10-31 19:23:21.737823 | 2025-10-31 19:23:21.737901 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-31 19:23:21.764110 | debian-bookworm | ok 2025-10-31 19:23:21.768056 | 2025-10-31 19:23:21.768134 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-31 19:23:21.992717 | debian-bookworm -> localhost | ok 2025-10-31 19:23:21.997693 | 2025-10-31 19:23:21.997775 | TASK [validate-host : Collect information about the host] 2025-10-31 19:23:23.075564 | debian-bookworm | ok 2025-10-31 19:23:23.085184 | 2025-10-31 19:23:23.085273 | TASK [validate-host : Sanitize hostname] 2025-10-31 19:23:23.174361 | debian-bookworm | ok 2025-10-31 19:23:23.202188 | 2025-10-31 19:23:23.202285 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-31 19:23:23.668466 | debian-bookworm -> localhost | changed 2025-10-31 19:23:23.677088 | 2025-10-31 19:23:23.677205 | TASK [validate-host : Collect information about zuul worker] 2025-10-31 19:23:24.082370 | debian-bookworm | ok 2025-10-31 19:23:24.090415 | 2025-10-31 19:23:24.090531 | TASK [validate-host : Write out all zuul information for each host] 2025-10-31 19:23:24.566048 | debian-bookworm -> localhost | changed 2025-10-31 19:23:24.575399 | 2025-10-31 19:23:24.575488 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-31 19:23:24.860574 | debian-bookworm | ok 2025-10-31 19:23:24.866256 | 2025-10-31 19:23:24.866350 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-31 19:23:25.687055 | debian-bookworm | changed: 2025-10-31 19:23:25.687262 | debian-bookworm | cd+++++++++ src/ 2025-10-31 19:23:25.687298 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-31 19:23:25.687322 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-31 19:23:25.687344 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-inventory-reconciler/ 2025-10-31 19:23:25.687365 | debian-bookworm | Containerfile 2025-10-31 19:23:25.687495 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006838 2025-10-31 19:25:01.567724 | 2025-10-31 19:25:01.567845 | TASK [upload-logs : Upload logs to log server] 2025-10-31 19:25:02.112372 | localhost | Output suppressed because no_log was given 2025-10-31 19:25:02.114903 | 2025-10-31 19:25:02.115033 | LOOP [upload-logs : Compress console log and json output] 2025-10-31 19:25:02.162616 | localhost | skipping: Conditional result was False 2025-10-31 19:25:02.175401 | localhost | skipping: Conditional result was False 2025-10-31 19:25:02.182453 | 2025-10-31 19:25:02.182557 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-31 19:25:02.236632 | localhost | skipping: Conditional result was False 2025-10-31 19:25:02.237081 | 2025-10-31 19:25:02.241236 | localhost | skipping: Conditional result was False 2025-10-31 19:25:02.252615 | 2025-10-31 19:25:02.252789 | LOOP [upload-logs : Upload console log and json output]