2025-10-08 13:33:39.775338 | Job console starting 2025-10-08 13:33:39.785873 | Updating git repos 2025-10-08 13:33:39.800312 | Cloning repos into workspace 2025-10-08 13:33:39.845054 | Restoring repo states 2025-10-08 13:33:39.853043 | Merging changes 2025-10-08 13:33:40.301318 | Checking out repos 2025-10-08 13:33:40.334045 | Preparing playbooks 2025-10-08 13:33:40.941621 | Running Ansible setup 2025-10-08 13:34:15.586204 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-08 13:34:16.314325 | 2025-10-08 13:34:16.314500 | PLAY [Base pre] 2025-10-08 13:34:16.330474 | 2025-10-08 13:34:16.330624 | TASK [Setup log path fact] 2025-10-08 13:34:16.360668 | ubuntu-noble-large | ok 2025-10-08 13:34:16.375558 | 2025-10-08 13:34:16.375696 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-08 13:34:16.405148 | ubuntu-noble-large | ok 2025-10-08 13:34:16.414771 | 2025-10-08 13:34:16.414906 | TASK [emit-job-header : Print job information] 2025-10-08 13:34:16.457348 | # Job Information 2025-10-08 13:34:16.457586 | Ansible Version: 2.16.14 2025-10-08 13:34:16.457639 | Job: ci-image-build 2025-10-08 13:34:16.457690 | Pipeline: check 2025-10-08 13:34:16.457725 | Executor: 521e9411259a 2025-10-08 13:34:16.457757 | Triggered by: https://github.com/osism/ci-image/pull/57 2025-10-08 13:34:16.457790 | Event ID: 4bff7260-a44b-11f0-95cc-2106dc2243e7 2025-10-08 13:34:16.464212 | 2025-10-08 13:34:16.464335 | LOOP [emit-job-header : Print node information] 2025-10-08 13:34:16.572774 | ubuntu-noble-large | ok: 2025-10-08 13:34:16.573057 | ubuntu-noble-large | # Node Information 2025-10-08 13:34:16.573117 | ubuntu-noble-large | Inventory Hostname: ubuntu-noble-large 2025-10-08 13:34:16.573162 | ubuntu-noble-large | Hostname: ubuntu 2025-10-08 13:34:16.573203 | ubuntu-noble-large | Username: zuul 2025-10-08 13:34:16.573241 | ubuntu-noble-large | Distro: Ubuntu 24.04 2025-10-08 13:34:16.573284 | ubuntu-noble-large | Provider: regiocloud-a 2025-10-08 13:34:16.573321 | ubuntu-noble-large | Region: 2025-10-08 13:34:16.573359 | ubuntu-noble-large | Label: ubuntu-noble-large 2025-10-08 13:34:16.573395 | ubuntu-noble-large | Product Name: OpenStack Nova 2025-10-08 13:34:16.573429 | ubuntu-noble-large | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe77:cc21 2025-10-08 13:34:16.597577 | 2025-10-08 13:34:16.597730 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-08 13:34:17.080128 | ubuntu-noble-large -> localhost | changed 2025-10-08 13:34:17.090716 | 2025-10-08 13:34:17.090881 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-08 13:34:18.111328 | ubuntu-noble-large -> localhost | changed 2025-10-08 13:34:18.130812 | 2025-10-08 13:34:18.130968 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-08 13:34:18.428157 | ubuntu-noble-large -> localhost | ok 2025-10-08 13:34:18.434366 | 2025-10-08 13:34:18.434481 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-08 13:34:18.464448 | ubuntu-noble-large | ok 2025-10-08 13:34:18.479192 | ubuntu-noble-large | included: /var/lib/zuul/builds/423956bcae6e43a6a6a4cc01bcf8c228/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-08 13:34:18.485323 | 2025-10-08 13:34:18.485418 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-08 13:34:19.871142 | ubuntu-noble-large -> localhost | Generating public/private rsa key pair. 2025-10-08 13:34:19.871506 | ubuntu-noble-large -> localhost | Your identification has been saved in /var/lib/zuul/builds/423956bcae6e43a6a6a4cc01bcf8c228/work/423956bcae6e43a6a6a4cc01bcf8c228_id_rsa 2025-10-08 13:34:19.871601 | ubuntu-noble-large -> localhost | Your public key has been saved in /var/lib/zuul/builds/423956bcae6e43a6a6a4cc01bcf8c228/work/423956bcae6e43a6a6a4cc01bcf8c228_id_rsa.pub 2025-10-08 13:34:19.871657 | ubuntu-noble-large -> localhost | The key fingerprint is: 2025-10-08 13:34:19.871706 | ubuntu-noble-large -> localhost | SHA256:YnEtrPBAzH40RfJnRyLI1wqaGQQqW4uDKiXBYRxAQmY zuul-build-sshkey 2025-10-08 13:34:19.871772 | ubuntu-noble-large -> localhost | The key's randomart image is: 2025-10-08 13:34:19.871817 | ubuntu-noble-large -> localhost | +---[RSA 3072]----+ 2025-10-08 13:34:19.871863 | ubuntu-noble-large -> localhost | |BEo=o..++.. . | 2025-10-08 13:34:19.871907 | ubuntu-noble-large -> localhost | |*o..+ *+.o.o | 2025-10-08 13:34:19.871949 | ubuntu-noble-large -> localhost | |+...o*.+=.+ . | 2025-10-08 13:34:19.872002 | ubuntu-noble-large -> localhost | |o= .=+.+.+ . | 2025-10-08 13:34:19.872043 | ubuntu-noble-large -> localhost | |* o .= S | 2025-10-08 13:34:19.872090 | ubuntu-noble-large -> localhost | |.+ . . | 2025-10-08 13:34:19.872130 | ubuntu-noble-large -> localhost | |o | 2025-10-08 13:34:19.872169 | ubuntu-noble-large -> localhost | |. | 2025-10-08 13:34:19.872209 | ubuntu-noble-large -> localhost | | | 2025-10-08 13:34:19.872250 | ubuntu-noble-large -> localhost | +----[SHA256]-----+ 2025-10-08 13:34:19.872351 | ubuntu-noble-large -> localhost | ok: Runtime: 0:00:00.888619 2025-10-08 13:34:19.883088 | 2025-10-08 13:34:19.883212 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-08 13:34:19.918304 | ubuntu-noble-large | ok 2025-10-08 13:34:19.931236 | ubuntu-noble-large | included: /var/lib/zuul/builds/423956bcae6e43a6a6a4cc01bcf8c228/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-08 13:34:19.940798 | 2025-10-08 13:34:19.940893 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-08 13:34:19.963938 | ubuntu-noble-large | skipping: Conditional result was False 2025-10-08 13:34:19.970469 | 2025-10-08 13:34:19.970585 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-08 13:34:20.704486 | ubuntu-noble-large | changed 2025-10-08 13:34:20.712902 | 2025-10-08 13:34:20.713036 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-08 13:34:21.025345 | ubuntu-noble-large | ok 2025-10-08 13:34:21.037789 | 2025-10-08 13:34:21.037970 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-08 13:34:21.785127 | ubuntu-noble-large | changed 2025-10-08 13:34:21.791496 | 2025-10-08 13:34:21.791647 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-08 13:34:22.535731 | ubuntu-noble-large | changed 2025-10-08 13:34:22.544212 | 2025-10-08 13:34:22.544343 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-08 13:34:22.569405 | ubuntu-noble-large | skipping: Conditional result was False 2025-10-08 13:34:22.580756 | 2025-10-08 13:34:22.580913 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-08 13:34:23.030481 | ubuntu-noble-large -> localhost | changed 2025-10-08 13:34:23.041394 | 2025-10-08 13:34:23.041506 | TASK [add-build-sshkey : Add back temp key] 2025-10-08 13:34:23.379380 | ubuntu-noble-large -> localhost | Identity added: /var/lib/zuul/builds/423956bcae6e43a6a6a4cc01bcf8c228/work/423956bcae6e43a6a6a4cc01bcf8c228_id_rsa (zuul-build-sshkey) 2025-10-08 13:34:23.379937 | ubuntu-noble-large -> localhost | ok: Runtime: 0:00:00.020120 2025-10-08 13:34:23.395725 | 2025-10-08 13:34:23.395872 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-08 13:34:23.839748 | ubuntu-noble-large | ok 2025-10-08 13:34:23.847696 | 2025-10-08 13:34:23.847824 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-08 13:34:23.872857 | ubuntu-noble-large | skipping: Conditional result was False 2025-10-08 13:34:23.893840 | 2025-10-08 13:34:23.893977 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-08 13:34:24.365615 | ubuntu-noble-large | ok 2025-10-08 13:34:24.381925 | 2025-10-08 13:34:24.382045 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-08 13:34:24.420860 | ubuntu-noble-large | ok 2025-10-08 13:34:24.425759 | 2025-10-08 13:34:24.425854 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-08 13:34:24.711949 | ubuntu-noble-large -> localhost | ok 2025-10-08 13:34:24.718461 | 2025-10-08 13:34:24.718582 | TASK [validate-host : Collect information about the host] 2025-10-08 13:34:36.018509 | ubuntu-noble-large | ok 2025-10-08 13:34:36.030081 | 2025-10-08 13:34:36.030200 | TASK [validate-host : Sanitize hostname] 2025-10-08 13:34:36.167269 | ubuntu-noble-large | ok 2025-10-08 13:34:36.171980 | 2025-10-08 13:34:36.172086 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-08 13:34:36.743359 | ubuntu-noble-large -> localhost | changed 2025-10-08 13:34:36.755014 | 2025-10-08 13:34:36.755175 | TASK [validate-host : Collect information about zuul worker] 2025-10-08 13:34:37.226422 | ubuntu-noble-large | ok 2025-10-08 13:34:37.235393 | 2025-10-08 13:34:37.235596 | TASK [validate-host : Write out all zuul information for each host] 2025-10-08 13:34:37.807248 | ubuntu-noble-large -> localhost | changed 2025-10-08 13:34:37.825315 | 2025-10-08 13:34:37.825446 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-08 13:34:38.142811 | ubuntu-noble-large | ok 2025-10-08 13:34:38.151150 | 2025-10-08 13:34:38.151288 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-08 13:34:38.940776 | ubuntu-noble-large | changed: 2025-10-08 13:34:38.941006 | ubuntu-noble-large | cd+++++++++ src/ 2025-10-08 13:34:38.941049 | ubuntu-noble-large | cd+++++++++ src/github.com/ 2025-10-08 13:34:38.941079 | ubuntu-noble-large | cd+++++++++ src/github.com/osism/ 2025-10-08 13:34:38.941107 | ubuntu-noble-large | cd+++++++++ src/github.com/osism/ci-image/ 2025-10-08 13:34:38.941132 | ubuntu-noble-large | localhost | ok: Runtime: 0:00:00.007027 2025-10-08 14:04:23.172692 | 2025-10-08 14:04:23.172864 | TASK [upload-logs : Upload logs to log server] 2025-10-08 14:04:23.815869 | localhost | Output suppressed because no_log was given 2025-10-08 14:04:23.817747 | 2025-10-08 14:04:23.817875 | LOOP [upload-logs : Compress console log and json output] 2025-10-08 14:04:23.864525 | localhost | skipping: Conditional result was False 2025-10-08 14:04:23.870505 | localhost | skipping: Conditional result was False 2025-10-08 14:04:23.874215 | 2025-10-08 14:04:23.874358 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-08 14:04:23.922529 | localhost | skipping: Conditional result was False 2025-10-08 14:04:23.922883 | 2025-10-08 14:04:23.927702 | localhost | skipping: Conditional result was False 2025-10-08 14:04:23.932873 | 2025-10-08 14:04:23.932991 | LOOP [upload-logs : Upload console log and json output]