2025-05-22 18:10:12.189072 | Job console starting 2025-05-22 18:10:12.201011 | Updating git repos 2025-05-22 18:10:12.220525 | Cloning repos into workspace 2025-05-22 18:10:12.254491 | Restoring repo states 2025-05-22 18:10:12.268620 | Merging changes 2025-05-22 18:10:12.730264 | Checking out repos 2025-05-22 18:10:12.807275 | Preparing playbooks 2025-05-22 18:10:13.699570 | Running Ansible setup 2025-05-22 18:10:19.205862 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-22 18:10:20.435949 | 2025-05-22 18:10:20.436131 | PLAY [Base pre] 2025-05-22 18:10:20.474969 | 2025-05-22 18:10:20.475155 | TASK [Setup log path fact] 2025-05-22 18:10:20.515669 | debian-bookworm | ok 2025-05-22 18:10:20.552504 | 2025-05-22 18:10:20.552712 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-22 18:10:20.630123 | debian-bookworm | ok 2025-05-22 18:10:20.646050 | 2025-05-22 18:10:20.646202 | TASK [emit-job-header : Print job information] 2025-05-22 18:10:20.734591 | # Job Information 2025-05-22 18:10:20.734790 | Ansible Version: 2.16.14 2025-05-22 18:10:20.734826 | Job: container-image-inventory-reconciler-build 2025-05-22 18:10:20.734894 | Pipeline: check 2025-05-22 18:10:20.734918 | Executor: 521e9411259a 2025-05-22 18:10:20.734939 | Triggered by: https://github.com/osism/container-image-inventory-reconciler/pull/312 2025-05-22 18:10:20.734961 | Event ID: fbf2aec0-3737-11f0-96b1-d87a19cc0d71 2025-05-22 18:10:20.744739 | 2025-05-22 18:10:20.744894 | LOOP [emit-job-header : Print node information] 2025-05-22 18:10:20.986230 | debian-bookworm | ok: 2025-05-22 18:10:20.986936 | debian-bookworm | # Node Information 2025-05-22 18:10:20.987058 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-05-22 18:10:20.987089 | debian-bookworm | Hostname: debian 2025-05-22 18:10:20.987114 | debian-bookworm | Username: zuul 2025-05-22 18:10:20.987136 | debian-bookworm | Distro: Debian 12.11 2025-05-22 18:10:20.987160 | debian-bookworm | Provider: regiocloud-a 2025-05-22 18:10:20.987182 | debian-bookworm | Region: 2025-05-22 18:10:20.987205 | debian-bookworm | Label: debian-bookworm 2025-05-22 18:10:20.987226 | debian-bookworm | Product Name: OpenStack Nova 2025-05-22 18:10:20.987246 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe3c:86ad 2025-05-22 18:10:21.014121 | 2025-05-22 18:10:21.015084 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-22 18:10:22.203644 | debian-bookworm -> localhost | changed 2025-05-22 18:10:22.213600 | 2025-05-22 18:10:22.213744 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-22 18:10:24.087846 | debian-bookworm -> localhost | changed 2025-05-22 18:10:24.110794 | 2025-05-22 18:10:24.111610 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-22 18:10:24.690793 | debian-bookworm -> localhost | ok 2025-05-22 18:10:24.700923 | 2025-05-22 18:10:24.701152 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-22 18:10:24.769911 | debian-bookworm | ok 2025-05-22 18:10:24.825466 | debian-bookworm | included: /var/lib/zuul/builds/e98116be9d184eb794573a256c2632e4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-22 18:10:24.846395 | 2025-05-22 18:10:24.847011 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-22 18:10:27.577725 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-05-22 18:10:27.577993 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/e98116be9d184eb794573a256c2632e4/work/e98116be9d184eb794573a256c2632e4_id_rsa 2025-05-22 18:10:27.578033 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/e98116be9d184eb794573a256c2632e4/work/e98116be9d184eb794573a256c2632e4_id_rsa.pub 2025-05-22 18:10:27.578061 | debian-bookworm -> localhost | The key fingerprint is: 2025-05-22 18:10:27.578086 | debian-bookworm -> localhost | SHA256:RVMCWo3XW8Jg6Dq6SXnQpVukqjsUsxgpZjoCFptFB18 zuul-build-sshkey 2025-05-22 18:10:27.578122 | debian-bookworm -> localhost | The key's randomart image is: 2025-05-22 18:10:27.578145 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-05-22 18:10:27.578166 | debian-bookworm -> localhost | | .o.. Eo=*=. | 2025-05-22 18:10:27.578188 | debian-bookworm -> localhost | | . .o .ooooo+ . | 2025-05-22 18:10:27.578209 | debian-bookworm -> localhost | | .= ...o.. + | 2025-05-22 18:10:27.578229 | debian-bookworm -> localhost | |=*o . =.. . | 2025-05-22 18:10:27.578249 | debian-bookworm -> localhost | |Bo +. +.S | 2025-05-22 18:10:27.578272 | debian-bookworm -> localhost | |= o +oo | 2025-05-22 18:10:27.578292 | debian-bookworm -> localhost | |.o +.o. | 2025-05-22 18:10:27.578312 | debian-bookworm -> localhost | | .o.o | 2025-05-22 18:10:27.578332 | debian-bookworm -> localhost | | ooo. | 2025-05-22 18:10:27.578352 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-05-22 18:10:27.578407 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.318351 2025-05-22 18:10:27.614343 | 2025-05-22 18:10:27.614489 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-22 18:10:27.700099 | debian-bookworm | ok 2025-05-22 18:10:27.773920 | debian-bookworm | included: /var/lib/zuul/builds/e98116be9d184eb794573a256c2632e4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-22 18:10:27.787716 | 2025-05-22 18:10:27.787847 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-22 18:10:27.834213 | debian-bookworm | skipping: Conditional result was False 2025-05-22 18:10:27.840334 | 2025-05-22 18:10:27.840447 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-22 18:10:28.520638 | debian-bookworm | changed 2025-05-22 18:10:28.525853 | 2025-05-22 18:10:28.525941 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-22 18:10:28.801445 | debian-bookworm | ok 2025-05-22 18:10:28.808912 | 2025-05-22 18:10:28.809025 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-22 18:10:29.447528 | debian-bookworm | changed 2025-05-22 18:10:29.454089 | 2025-05-22 18:10:29.454182 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-22 18:10:30.098743 | debian-bookworm | changed 2025-05-22 18:10:30.108175 | 2025-05-22 18:10:30.108262 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-22 18:10:30.131422 | debian-bookworm | skipping: Conditional result was False 2025-05-22 18:10:30.140642 | 2025-05-22 18:10:30.140756 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-22 18:10:30.590604 | debian-bookworm -> localhost | changed 2025-05-22 18:10:30.604464 | 2025-05-22 18:10:30.604591 | TASK [add-build-sshkey : Add back temp key] 2025-05-22 18:10:30.921325 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/e98116be9d184eb794573a256c2632e4/work/e98116be9d184eb794573a256c2632e4_id_rsa (zuul-build-sshkey) 2025-05-22 18:10:30.921537 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010912 2025-05-22 18:10:30.928857 | 2025-05-22 18:10:30.928948 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-22 18:10:31.337067 | debian-bookworm | ok 2025-05-22 18:10:31.348331 | 2025-05-22 18:10:31.348539 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-22 18:10:31.378807 | debian-bookworm | skipping: Conditional result was False 2025-05-22 18:10:31.389623 | 2025-05-22 18:10:31.389734 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-22 18:10:31.800259 | debian-bookworm | ok 2025-05-22 18:10:31.815440 | 2025-05-22 18:10:31.815555 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-22 18:10:31.843174 | debian-bookworm | ok 2025-05-22 18:10:31.848198 | 2025-05-22 18:10:31.848291 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-22 18:10:32.116927 | debian-bookworm -> localhost | ok 2025-05-22 18:10:32.128970 | 2025-05-22 18:10:32.129129 | TASK [validate-host : Collect information about the host] 2025-05-22 18:10:33.297773 | debian-bookworm | ok 2025-05-22 18:10:33.308873 | 2025-05-22 18:10:33.308999 | TASK [validate-host : Sanitize hostname] 2025-05-22 18:10:33.441303 | debian-bookworm | ok 2025-05-22 18:10:33.496682 | 2025-05-22 18:10:33.496826 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-22 18:10:34.128313 | debian-bookworm -> localhost | changed 2025-05-22 18:10:34.134609 | 2025-05-22 18:10:34.134727 | TASK [validate-host : Collect information about zuul worker] 2025-05-22 18:10:34.573099 | debian-bookworm | ok 2025-05-22 18:10:34.588030 | 2025-05-22 18:10:34.588176 | TASK [validate-host : Write out all zuul information for each host] 2025-05-22 18:10:35.197939 | debian-bookworm -> localhost | changed 2025-05-22 18:10:35.208942 | 2025-05-22 18:10:35.209062 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-22 18:10:35.537512 | debian-bookworm | ok 2025-05-22 18:10:35.550341 | 2025-05-22 18:10:35.550479 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-22 18:10:36.397174 | debian-bookworm | changed: 2025-05-22 18:10:36.397666 | debian-bookworm | cd+++++++++ src/ 2025-05-22 18:10:36.397737 | debian-bookworm | cd+++++++++ src/github.com/ 2025-05-22 18:10:36.397771 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-05-22 18:10:36.397801 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-inventory-reconciler/ 2025-05-22 18:10:36.397829 | debian-bookworm | Containerfile 2025-05-22 18:10:36.398000 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006914 2025-05-22 18:12:13.504213 | 2025-05-22 18:12:13.504451 | TASK [upload-logs : Upload logs to log server] 2025-05-22 18:12:14.098730 | localhost | Output suppressed because no_log was given 2025-05-22 18:12:14.100682 | 2025-05-22 18:12:14.100784 | LOOP [upload-logs : Compress console log and json output] 2025-05-22 18:12:14.159889 | localhost | skipping: Conditional result was False 2025-05-22 18:12:14.164875 | localhost | skipping: Conditional result was False 2025-05-22 18:12:14.174048 | 2025-05-22 18:12:14.174372 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-22 18:12:14.229150 | localhost | skipping: Conditional result was False 2025-05-22 18:12:14.229848 | 2025-05-22 18:12:14.233231 | localhost | skipping: Conditional result was False 2025-05-22 18:12:14.248826 | 2025-05-22 18:12:14.249075 | LOOP [upload-logs : Upload console log and json output]