2025-12-06 16:54:39.892372 | Job console starting 2025-12-06 16:54:39.931287 | Updating git repos 2025-12-06 16:54:39.981399 | Cloning repos into workspace 2025-12-06 16:54:40.038333 | Restoring repo states 2025-12-06 16:54:40.055886 | Merging changes 2025-12-06 16:54:40.683948 | Checking out repos 2025-12-06 16:54:40.791793 | Preparing playbooks 2025-12-06 16:54:41.982028 | Running Ansible setup 2025-12-06 16:54:47.524745 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-06 16:54:48.506996 | 2025-12-06 16:54:48.507166 | PLAY [Base pre] 2025-12-06 16:54:48.547235 | 2025-12-06 16:54:48.547407 | TASK [Setup log path fact] 2025-12-06 16:54:48.577167 | debian-bookworm | ok 2025-12-06 16:54:48.594685 | 2025-12-06 16:54:48.594878 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-06 16:54:48.643095 | debian-bookworm | ok 2025-12-06 16:54:48.660998 | 2025-12-06 16:54:48.661140 | TASK [emit-job-header : Print job information] 2025-12-06 16:54:48.700872 | # Job Information 2025-12-06 16:54:48.701082 | Ansible Version: 2.16.14 2025-12-06 16:54:48.701119 | Job: container-image-inventory-reconciler-build 2025-12-06 16:54:48.701154 | Pipeline: check 2025-12-06 16:54:48.701178 | Executor: 521e9411259a 2025-12-06 16:54:48.701200 | Triggered by: https://github.com/osism/container-image-inventory-reconciler/pull/467 2025-12-06 16:54:48.701223 | Event ID: 3c4d7ea0-d2c4-11f0-80af-8e228834e2f0 2025-12-06 16:54:48.707802 | 2025-12-06 16:54:48.707959 | LOOP [emit-job-header : Print node information] 2025-12-06 16:54:48.976298 | debian-bookworm | ok: 2025-12-06 16:54:48.976556 | debian-bookworm | # Node Information 2025-12-06 16:54:48.976594 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-06 16:54:48.976658 | debian-bookworm | Hostname: debian 2025-12-06 16:54:48.976684 | debian-bookworm | Username: zuul 2025-12-06 16:54:48.976706 | debian-bookworm | Distro: Debian 12.12 2025-12-06 16:54:48.976730 | debian-bookworm | Provider: regiocloud-a 2025-12-06 16:54:48.976752 | debian-bookworm | Region: 2025-12-06 16:54:48.976773 | debian-bookworm | Label: debian-bookworm 2025-12-06 16:54:48.976792 | debian-bookworm | Product Name: OpenStack Nova 2025-12-06 16:54:48.976812 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe7b:f001 2025-12-06 16:54:48.990080 | 2025-12-06 16:54:48.990223 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-06 16:54:49.851463 | debian-bookworm -> localhost | changed 2025-12-06 16:54:49.862978 | 2025-12-06 16:54:49.863128 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-06 16:54:51.947742 | debian-bookworm -> localhost | changed 2025-12-06 16:54:51.961588 | 2025-12-06 16:54:51.961778 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-06 16:54:52.399928 | debian-bookworm -> localhost | ok 2025-12-06 16:54:52.406321 | 2025-12-06 16:54:52.406461 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-06 16:54:52.446401 | debian-bookworm | ok 2025-12-06 16:54:52.472806 | debian-bookworm | included: /var/lib/zuul/builds/59329cbc9eb84a7c909a06148c017594/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-06 16:54:52.482516 | 2025-12-06 16:54:52.482687 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-06 16:54:54.668435 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-06 16:54:54.668734 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/59329cbc9eb84a7c909a06148c017594/work/59329cbc9eb84a7c909a06148c017594_id_rsa 2025-12-06 16:54:54.668782 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/59329cbc9eb84a7c909a06148c017594/work/59329cbc9eb84a7c909a06148c017594_id_rsa.pub 2025-12-06 16:54:54.668809 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-06 16:54:54.668833 | debian-bookworm -> localhost | SHA256:h3Ib3sU59njOcLhv8A2qJondADvyaQBqLEwTNWrXMwo zuul-build-sshkey 2025-12-06 16:54:54.668869 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-06 16:54:54.668891 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-06 16:54:54.668912 | debian-bookworm -> localhost | | .o | 2025-12-06 16:54:54.668933 | debian-bookworm -> localhost | | .. o | 2025-12-06 16:54:54.668952 | debian-bookworm -> localhost | | E.. + | 2025-12-06 16:54:54.668971 | debian-bookworm -> localhost | |.o+ . + . . . | 2025-12-06 16:54:54.668990 | debian-bookworm -> localhost | |+..o .oS . * | 2025-12-06 16:54:54.669013 | debian-bookworm -> localhost | |o+ o o+.= o.=. | 2025-12-06 16:54:54.669034 | debian-bookworm -> localhost | |o + =o+. +++o | 2025-12-06 16:54:54.669053 | debian-bookworm -> localhost | | = + o .Bo .| 2025-12-06 16:54:54.669074 | debian-bookworm -> localhost | | . o...o+ | 2025-12-06 16:54:54.669094 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-06 16:54:54.669147 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.336965 2025-12-06 16:54:54.676043 | 2025-12-06 16:54:54.676375 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-06 16:54:54.721752 | debian-bookworm | ok 2025-12-06 16:54:54.732158 | debian-bookworm | included: /var/lib/zuul/builds/59329cbc9eb84a7c909a06148c017594/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-06 16:54:54.781386 | 2025-12-06 16:54:54.781532 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-06 16:54:54.805482 | debian-bookworm | skipping: Conditional result was False 2025-12-06 16:54:54.811698 | 2025-12-06 16:54:54.811818 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-06 16:54:55.585832 | debian-bookworm | changed 2025-12-06 16:54:55.591742 | 2025-12-06 16:54:55.591876 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-06 16:54:55.843052 | debian-bookworm | ok 2025-12-06 16:54:55.852151 | 2025-12-06 16:54:55.852335 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-06 16:54:56.551919 | debian-bookworm | changed 2025-12-06 16:54:56.562955 | 2025-12-06 16:54:56.563119 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-06 16:54:57.254205 | debian-bookworm | changed 2025-12-06 16:54:57.262805 | 2025-12-06 16:54:57.262984 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-06 16:54:57.287052 | debian-bookworm | skipping: Conditional result was False 2025-12-06 16:54:57.294311 | 2025-12-06 16:54:57.294437 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-06 16:54:58.223858 | debian-bookworm -> localhost | changed 2025-12-06 16:54:58.240192 | 2025-12-06 16:54:58.240329 | TASK [add-build-sshkey : Add back temp key] 2025-12-06 16:54:58.683376 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/59329cbc9eb84a7c909a06148c017594/work/59329cbc9eb84a7c909a06148c017594_id_rsa (zuul-build-sshkey) 2025-12-06 16:54:58.683671 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015622 2025-12-06 16:54:58.693729 | 2025-12-06 16:54:58.693862 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-06 16:54:59.306705 | debian-bookworm | ok 2025-12-06 16:54:59.312228 | 2025-12-06 16:54:59.312358 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-06 16:54:59.384033 | debian-bookworm | skipping: Conditional result was False 2025-12-06 16:54:59.400985 | 2025-12-06 16:54:59.401120 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-06 16:54:59.920291 | debian-bookworm | ok 2025-12-06 16:54:59.934278 | 2025-12-06 16:54:59.934426 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-06 16:54:59.975138 | debian-bookworm | ok 2025-12-06 16:54:59.981015 | 2025-12-06 16:54:59.981127 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-06 16:55:00.316997 | debian-bookworm -> localhost | ok 2025-12-06 16:55:00.325423 | 2025-12-06 16:55:00.325583 | TASK [validate-host : Collect information about the host] 2025-12-06 16:55:01.495605 | debian-bookworm | ok 2025-12-06 16:55:01.525970 | 2025-12-06 16:55:01.526118 | TASK [validate-host : Sanitize hostname] 2025-12-06 16:55:01.676219 | debian-bookworm | ok 2025-12-06 16:55:01.780708 | 2025-12-06 16:55:01.780910 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-06 16:55:02.898502 | debian-bookworm -> localhost | changed 2025-12-06 16:55:02.905050 | 2025-12-06 16:55:02.905584 | TASK [validate-host : Collect information about zuul worker] 2025-12-06 16:55:03.393666 | debian-bookworm | ok 2025-12-06 16:55:03.398747 | 2025-12-06 16:55:03.398916 | TASK [validate-host : Write out all zuul information for each host] 2025-12-06 16:55:04.291253 | debian-bookworm -> localhost | changed 2025-12-06 16:55:04.302050 | 2025-12-06 16:55:04.302192 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-06 16:55:04.587699 | debian-bookworm | ok 2025-12-06 16:55:04.599362 | 2025-12-06 16:55:04.599498 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-06 16:55:05.596419 | debian-bookworm | changed: 2025-12-06 16:55:05.596680 | debian-bookworm | cd+++++++++ src/ 2025-12-06 16:55:05.596724 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-06 16:55:05.596749 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-06 16:55:05.596771 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-inventory-reconciler/ 2025-12-06 16:55:05.596792 | debian-bookworm | Containerfile 2025-12-06 16:55:05.596943 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007519 2025-12-06 16:57:09.891208 | 2025-12-06 16:57:09.891379 | TASK [upload-logs : Upload logs to log server] 2025-12-06 16:57:10.509950 | localhost | Output suppressed because no_log was given 2025-12-06 16:57:10.512716 | 2025-12-06 16:57:10.512861 | LOOP [upload-logs : Compress console log and json output] 2025-12-06 16:57:10.582225 | localhost | skipping: Conditional result was False 2025-12-06 16:57:10.587979 | localhost | skipping: Conditional result was False 2025-12-06 16:57:10.595907 | 2025-12-06 16:57:10.596204 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-06 16:57:10.648721 | localhost | skipping: Conditional result was False 2025-12-06 16:57:10.649448 | 2025-12-06 16:57:10.654728 | localhost | skipping: Conditional result was False 2025-12-06 16:57:10.663633 | 2025-12-06 16:57:10.663880 | LOOP [upload-logs : Upload console log and json output]