2025-10-08 14:04:57.600581 | Job console starting 2025-10-08 14:04:57.608360 | Updating git repos 2025-10-08 14:04:57.626945 | Cloning repos into workspace 2025-10-08 14:04:57.672236 | Restoring repo states 2025-10-08 14:04:57.683289 | Merging changes 2025-10-08 14:04:58.117762 | Checking out repos 2025-10-08 14:04:58.136354 | Preparing playbooks 2025-10-08 14:04:58.668934 | Running Ansible setup 2025-10-08 14:05:33.377033 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-08 14:05:34.054819 | 2025-10-08 14:05:34.054961 | PLAY [Base pre] 2025-10-08 14:05:34.069498 | 2025-10-08 14:05:34.069601 | TASK [Setup log path fact] 2025-10-08 14:05:34.097578 | ubuntu-noble-large | ok 2025-10-08 14:05:34.111567 | 2025-10-08 14:05:34.111673 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-08 14:05:34.139762 | ubuntu-noble-large | ok 2025-10-08 14:05:34.148909 | 2025-10-08 14:05:34.148997 | TASK [emit-job-header : Print job information] 2025-10-08 14:05:34.184852 | # Job Information 2025-10-08 14:05:34.185091 | Ansible Version: 2.16.14 2025-10-08 14:05:34.185153 | Job: ci-image-build 2025-10-08 14:05:34.185213 | Pipeline: check 2025-10-08 14:05:34.185254 | Executor: 521e9411259a 2025-10-08 14:05:34.185291 | Triggered by: https://github.com/osism/ci-image/pull/57 2025-10-08 14:05:34.185328 | Event ID: 4bff7260-a44b-11f0-95cc-2106dc2243e7 2025-10-08 14:05:34.192078 | 2025-10-08 14:05:34.192188 | LOOP [emit-job-header : Print node information] 2025-10-08 14:05:34.286659 | ubuntu-noble-large | ok: 2025-10-08 14:05:34.286857 | ubuntu-noble-large | # Node Information 2025-10-08 14:05:34.286896 | ubuntu-noble-large | Inventory Hostname: ubuntu-noble-large 2025-10-08 14:05:34.286923 | ubuntu-noble-large | Hostname: ubuntu 2025-10-08 14:05:34.286947 | ubuntu-noble-large | Username: zuul 2025-10-08 14:05:34.286968 | ubuntu-noble-large | Distro: Ubuntu 24.04 2025-10-08 14:05:34.286991 | ubuntu-noble-large | Provider: regiocloud-a 2025-10-08 14:05:34.287014 | ubuntu-noble-large | Region: 2025-10-08 14:05:34.287035 | ubuntu-noble-large | Label: ubuntu-noble-large 2025-10-08 14:05:34.287056 | ubuntu-noble-large | Product Name: OpenStack Nova 2025-10-08 14:05:34.287075 | ubuntu-noble-large | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec3:20ed 2025-10-08 14:05:34.308701 | 2025-10-08 14:05:34.308881 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-08 14:05:34.708553 | ubuntu-noble-large -> localhost | changed 2025-10-08 14:05:34.724767 | 2025-10-08 14:05:34.724931 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-08 14:05:35.701613 | ubuntu-noble-large -> localhost | changed 2025-10-08 14:05:35.719561 | 2025-10-08 14:05:35.719696 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-08 14:05:35.998612 | ubuntu-noble-large -> localhost | ok 2025-10-08 14:05:36.004992 | 2025-10-08 14:05:36.005105 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-08 14:05:36.035523 | ubuntu-noble-large | ok 2025-10-08 14:05:36.050441 | ubuntu-noble-large | included: /var/lib/zuul/builds/c6f77b1c53e24063ae7a54aefb26a494/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-08 14:05:36.056562 | 2025-10-08 14:05:36.056659 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-08 14:05:37.010372 | ubuntu-noble-large -> localhost | Generating public/private rsa key pair. 2025-10-08 14:05:37.010628 | ubuntu-noble-large -> localhost | Your identification has been saved in /var/lib/zuul/builds/c6f77b1c53e24063ae7a54aefb26a494/work/c6f77b1c53e24063ae7a54aefb26a494_id_rsa 2025-10-08 14:05:37.010674 | ubuntu-noble-large -> localhost | Your public key has been saved in /var/lib/zuul/builds/c6f77b1c53e24063ae7a54aefb26a494/work/c6f77b1c53e24063ae7a54aefb26a494_id_rsa.pub 2025-10-08 14:05:37.010707 | ubuntu-noble-large -> localhost | The key fingerprint is: 2025-10-08 14:05:37.010736 | ubuntu-noble-large -> localhost | SHA256:wYdNQ4K0IRH7nv55V0JhpDmnPwEAJa7NWTwz+B+41OU zuul-build-sshkey 2025-10-08 14:05:37.010776 | ubuntu-noble-large -> localhost | The key's randomart image is: 2025-10-08 14:05:37.010824 | ubuntu-noble-large -> localhost | +---[RSA 3072]----+ 2025-10-08 14:05:37.010926 | ubuntu-noble-large -> localhost | | ++=++.+.. | 2025-10-08 14:05:37.010973 | ubuntu-noble-large -> localhost | | +.B * +o | 2025-10-08 14:05:37.011002 | ubuntu-noble-large -> localhost | | . + X B.o. | 2025-10-08 14:05:37.011027 | ubuntu-noble-large -> localhost | | = + O B. | 2025-10-08 14:05:37.011052 | ubuntu-noble-large -> localhost | | . = S +.E | 2025-10-08 14:05:37.011084 | ubuntu-noble-large -> localhost | | . o o o... | 2025-10-08 14:05:37.011109 | ubuntu-noble-large -> localhost | | o . . oo | 2025-10-08 14:05:37.011133 | ubuntu-noble-large -> localhost | | . .. .. | 2025-10-08 14:05:37.011159 | ubuntu-noble-large -> localhost | | ..o. . | 2025-10-08 14:05:37.011184 | ubuntu-noble-large -> localhost | +----[SHA256]-----+ 2025-10-08 14:05:37.011254 | ubuntu-noble-large -> localhost | ok: Runtime: 0:00:00.484180 2025-10-08 14:05:37.020177 | 2025-10-08 14:05:37.020308 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-08 14:05:37.053354 | ubuntu-noble-large | ok 2025-10-08 14:05:37.065871 | ubuntu-noble-large | included: /var/lib/zuul/builds/c6f77b1c53e24063ae7a54aefb26a494/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-08 14:05:37.075130 | 2025-10-08 14:05:37.075228 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-08 14:05:37.098460 | ubuntu-noble-large | skipping: Conditional result was False 2025-10-08 14:05:37.105628 | 2025-10-08 14:05:37.105737 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-08 14:05:37.774002 | ubuntu-noble-large | changed 2025-10-08 14:05:37.782052 | 2025-10-08 14:05:37.782170 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-08 14:05:38.086260 | ubuntu-noble-large | ok 2025-10-08 14:05:38.094925 | 2025-10-08 14:05:38.095078 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-08 14:05:38.884050 | ubuntu-noble-large | changed 2025-10-08 14:05:38.892260 | 2025-10-08 14:05:38.892395 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-08 14:05:39.636456 | ubuntu-noble-large | changed 2025-10-08 14:05:39.645173 | 2025-10-08 14:05:39.645282 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-08 14:05:39.669354 | ubuntu-noble-large | skipping: Conditional result was False 2025-10-08 14:05:39.683144 | 2025-10-08 14:05:39.683279 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-08 14:05:40.082379 | ubuntu-noble-large -> localhost | changed 2025-10-08 14:05:40.100898 | 2025-10-08 14:05:40.101007 | TASK [add-build-sshkey : Add back temp key] 2025-10-08 14:05:40.397878 | ubuntu-noble-large -> localhost | Identity added: /var/lib/zuul/builds/c6f77b1c53e24063ae7a54aefb26a494/work/c6f77b1c53e24063ae7a54aefb26a494_id_rsa (zuul-build-sshkey) 2025-10-08 14:05:40.398132 | ubuntu-noble-large -> localhost | ok: Runtime: 0:00:00.016187 2025-10-08 14:05:40.405413 | 2025-10-08 14:05:40.405503 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-08 14:05:40.815583 | ubuntu-noble-large | ok 2025-10-08 14:05:40.823908 | 2025-10-08 14:05:40.824026 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-08 14:05:40.858546 | ubuntu-noble-large | skipping: Conditional result was False 2025-10-08 14:05:40.880995 | 2025-10-08 14:05:40.881117 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-08 14:05:41.330871 | ubuntu-noble-large | ok 2025-10-08 14:05:41.343857 | 2025-10-08 14:05:41.343970 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-08 14:05:41.386291 | ubuntu-noble-large | ok 2025-10-08 14:05:41.393726 | 2025-10-08 14:05:41.393858 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-08 14:05:41.671056 | ubuntu-noble-large -> localhost | ok 2025-10-08 14:05:41.677114 | 2025-10-08 14:05:41.677200 | TASK [validate-host : Collect information about the host] 2025-10-08 14:05:52.911175 | ubuntu-noble-large | ok 2025-10-08 14:05:52.926384 | 2025-10-08 14:05:52.926478 | TASK [validate-host : Sanitize hostname] 2025-10-08 14:05:53.045562 | ubuntu-noble-large | ok 2025-10-08 14:05:53.049778 | 2025-10-08 14:05:53.049893 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-08 14:05:53.517903 | ubuntu-noble-large -> localhost | changed 2025-10-08 14:05:53.529536 | 2025-10-08 14:05:53.529680 | TASK [validate-host : Collect information about zuul worker] 2025-10-08 14:05:53.991834 | ubuntu-noble-large | ok 2025-10-08 14:05:54.000024 | 2025-10-08 14:05:54.000154 | TASK [validate-host : Write out all zuul information for each host] 2025-10-08 14:05:54.519331 | ubuntu-noble-large -> localhost | changed 2025-10-08 14:05:54.528386 | 2025-10-08 14:05:54.528481 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-08 14:05:54.855254 | ubuntu-noble-large | ok 2025-10-08 14:05:54.864604 | 2025-10-08 14:05:54.864722 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-08 14:05:55.619990 | ubuntu-noble-large | changed: 2025-10-08 14:05:55.620679 | ubuntu-noble-large | cd+++++++++ src/ 2025-10-08 14:05:55.620735 | ubuntu-noble-large | cd+++++++++ src/github.com/ 2025-10-08 14:05:55.620766 | ubuntu-noble-large | cd+++++++++ src/github.com/osism/ 2025-10-08 14:05:55.620806 | ubuntu-noble-large | cd+++++++++ src/github.com/osism/ci-image/ 2025-10-08 14:05:55.620833 | ubuntu-noble-large | localhost | ok: Runtime: 0:00:00.008045 2025-10-08 14:35:39.779046 | 2025-10-08 14:35:39.779179 | TASK [upload-logs : Upload logs to log server] 2025-10-08 14:35:40.352749 | localhost | Output suppressed because no_log was given 2025-10-08 14:35:40.356756 | 2025-10-08 14:35:40.356952 | LOOP [upload-logs : Compress console log and json output] 2025-10-08 14:35:40.417647 | localhost | skipping: Conditional result was False 2025-10-08 14:35:40.422095 | localhost | skipping: Conditional result was False 2025-10-08 14:35:40.439100 | 2025-10-08 14:35:40.439369 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-08 14:35:40.485493 | localhost | skipping: Conditional result was False 2025-10-08 14:35:40.486113 | 2025-10-08 14:35:40.489349 | localhost | skipping: Conditional result was False 2025-10-08 14:35:40.503659 | 2025-10-08 14:35:40.503820 | LOOP [upload-logs : Upload console log and json output]