2025-10-14 03:09:40.276809 | Job console starting 2025-10-14 03:09:40.290082 | Updating git repos 2025-10-14 03:09:40.337910 | Cloning repos into workspace 2025-10-14 03:09:40.481410 | Restoring repo states 2025-10-14 03:09:40.498549 | Merging changes 2025-10-14 03:09:40.498576 | Checking out repos 2025-10-14 03:09:40.555419 | Preparing playbooks 2025-10-14 03:09:42.097851 | Running Ansible setup 2025-10-14 03:11:06.832083 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-14 03:11:07.428165 | 2025-10-14 03:11:07.428307 | PLAY [Base pre] 2025-10-14 03:11:07.444472 | 2025-10-14 03:11:07.444553 | TASK [Setup log path fact] 2025-10-14 03:11:07.472488 | debian-bookworm | ok 2025-10-14 03:11:07.484550 | 2025-10-14 03:11:07.484643 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-14 03:11:07.511983 | debian-bookworm | ok 2025-10-14 03:11:07.519512 | 2025-10-14 03:11:07.519590 | TASK [emit-job-header : Print job information] 2025-10-14 03:11:07.546508 | # Job Information 2025-10-14 03:11:07.546643 | Ansible Version: 2.16.14 2025-10-14 03:11:07.546671 | Job: openstack-image-manager-integration-test 2025-10-14 03:11:07.546696 | Pipeline: periodic-daily 2025-10-14 03:11:07.546714 | Executor: 521e9411259a 2025-10-14 03:11:07.546731 | Triggered by: https://github.com/osism/openstack-image-manager 2025-10-14 03:11:07.546749 | Event ID: e189443a4034425fbf0ec23128bd99de 2025-10-14 03:11:07.550572 | 2025-10-14 03:11:07.550648 | LOOP [emit-job-header : Print node information] 2025-10-14 03:11:07.629174 | debian-bookworm | ok: 2025-10-14 03:11:07.629368 | debian-bookworm | # Node Information 2025-10-14 03:11:07.629400 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-14 03:11:07.629420 | debian-bookworm | Hostname: debian 2025-10-14 03:11:07.629438 | debian-bookworm | Username: zuul 2025-10-14 03:11:07.629455 | debian-bookworm | Distro: Debian 12.12 2025-10-14 03:11:07.629475 | debian-bookworm | Provider: regiocloud-a 2025-10-14 03:11:07.629492 | debian-bookworm | Region: 2025-10-14 03:11:07.629509 | debian-bookworm | Label: debian-bookworm 2025-10-14 03:11:07.629525 | debian-bookworm | Product Name: OpenStack Nova 2025-10-14 03:11:07.629542 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe38:2363 2025-10-14 03:11:07.642825 | 2025-10-14 03:11:07.642924 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-14 03:11:08.018570 | debian-bookworm -> localhost | changed 2025-10-14 03:11:08.024722 | 2025-10-14 03:11:08.024816 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-14 03:11:09.001922 | debian-bookworm -> localhost | changed 2025-10-14 03:11:09.010908 | 2025-10-14 03:11:09.011003 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-14 03:11:09.296155 | debian-bookworm -> localhost | ok 2025-10-14 03:11:09.301651 | 2025-10-14 03:11:09.301750 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-14 03:11:09.329769 | debian-bookworm | ok 2025-10-14 03:11:09.344366 | debian-bookworm | included: /var/lib/zuul/builds/891ae3c084db49e1a5abb52450f3f457/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-14 03:11:09.349076 | 2025-10-14 03:11:09.349144 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-14 03:11:10.886538 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-14 03:11:10.886884 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/891ae3c084db49e1a5abb52450f3f457/work/891ae3c084db49e1a5abb52450f3f457_id_rsa 2025-10-14 03:11:10.886966 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/891ae3c084db49e1a5abb52450f3f457/work/891ae3c084db49e1a5abb52450f3f457_id_rsa.pub 2025-10-14 03:11:10.886993 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-14 03:11:10.887015 | debian-bookworm -> localhost | SHA256:914UIOaMKkSTwfFgDspm+292pi1bIR9uUOcplP8Dl/Y zuul-build-sshkey 2025-10-14 03:11:10.887043 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-14 03:11:10.887063 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-14 03:11:10.887081 | debian-bookworm -> localhost | | ..B+ o . | 2025-10-14 03:11:10.887100 | debian-bookworm -> localhost | |.. =o+ .= . . | 2025-10-14 03:11:10.887117 | debian-bookworm -> localhost | |.+ o .+..o . | 2025-10-14 03:11:10.887133 | debian-bookworm -> localhost | |o .. o.+ . . . | 2025-10-14 03:11:10.887149 | debian-bookworm -> localhost | | . .o.+S=.+ . | 2025-10-14 03:11:10.887175 | debian-bookworm -> localhost | | . .= +.=... | 2025-10-14 03:11:10.887193 | debian-bookworm -> localhost | | . = o.E. | 2025-10-14 03:11:10.887210 | debian-bookworm -> localhost | | .++o ... | 2025-10-14 03:11:10.887227 | debian-bookworm -> localhost | | o+*. . | 2025-10-14 03:11:10.887243 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-14 03:11:10.887292 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.138237 2025-10-14 03:11:10.894534 | 2025-10-14 03:11:10.894665 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-14 03:11:10.912802 | debian-bookworm | ok 2025-10-14 03:11:10.922910 | debian-bookworm | included: /var/lib/zuul/builds/891ae3c084db49e1a5abb52450f3f457/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-14 03:11:10.934505 | 2025-10-14 03:11:10.934585 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-14 03:11:10.969858 | debian-bookworm | skipping: Conditional result was False 2025-10-14 03:11:10.976923 | 2025-10-14 03:11:10.977007 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-14 03:11:11.604159 | debian-bookworm | changed 2025-10-14 03:11:11.612655 | 2025-10-14 03:11:11.612749 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-14 03:11:11.847563 | debian-bookworm | ok 2025-10-14 03:11:11.857864 | 2025-10-14 03:11:11.857960 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-14 03:11:12.513724 | debian-bookworm | changed 2025-10-14 03:11:12.519356 | 2025-10-14 03:11:12.519436 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-14 03:11:13.114946 | debian-bookworm | changed 2025-10-14 03:11:13.122349 | 2025-10-14 03:11:13.122446 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-14 03:11:13.148034 | debian-bookworm | skipping: Conditional result was False 2025-10-14 03:11:13.162291 | 2025-10-14 03:11:13.162521 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-14 03:11:13.623560 | debian-bookworm -> localhost | changed 2025-10-14 03:11:13.634324 | 2025-10-14 03:11:13.634459 | TASK [add-build-sshkey : Add back temp key] 2025-10-14 03:11:14.040445 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/891ae3c084db49e1a5abb52450f3f457/work/891ae3c084db49e1a5abb52450f3f457_id_rsa (zuul-build-sshkey) 2025-10-14 03:11:14.040691 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009103 2025-10-14 03:11:14.048436 | 2025-10-14 03:11:14.048544 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-14 03:11:14.443832 | debian-bookworm | ok 2025-10-14 03:11:14.448671 | 2025-10-14 03:11:14.450990 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-14 03:11:14.481673 | debian-bookworm | skipping: Conditional result was False 2025-10-14 03:11:14.491776 | 2025-10-14 03:11:14.491863 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-14 03:11:14.873140 | debian-bookworm | ok 2025-10-14 03:11:14.883692 | 2025-10-14 03:11:14.883783 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-14 03:11:14.911615 | debian-bookworm | ok 2025-10-14 03:11:14.916400 | 2025-10-14 03:11:14.916484 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-14 03:11:15.283566 | debian-bookworm -> localhost | ok 2025-10-14 03:11:15.289721 | 2025-10-14 03:11:15.289807 | TASK [validate-host : Collect information about the host] 2025-10-14 03:11:56.411135 | debian-bookworm | ok 2025-10-14 03:11:56.427849 | 2025-10-14 03:11:56.427992 | TASK [validate-host : Sanitize hostname] 2025-10-14 03:11:56.558202 | debian-bookworm | ok 2025-10-14 03:11:56.622481 | 2025-10-14 03:11:56.622650 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-14 03:11:57.287099 | debian-bookworm -> localhost | changed 2025-10-14 03:11:57.294493 | 2025-10-14 03:11:57.294615 | TASK [validate-host : Collect information about zuul worker] 2025-10-14 03:11:57.677767 | debian-bookworm | ok 2025-10-14 03:11:57.685203 | 2025-10-14 03:11:57.685348 | TASK [validate-host : Write out all zuul information for each host] 2025-10-14 03:11:58.245536 | debian-bookworm -> localhost | changed 2025-10-14 03:11:58.255659 | 2025-10-14 03:11:58.255765 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-14 03:11:58.506320 | debian-bookworm | ok 2025-10-14 03:11:58.512036 | 2025-10-14 03:11:58.512147 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-14 03:11:59.405124 | debian-bookworm | changed: 2025-10-14 03:11:59.405441 | debian-bookworm | cd+++++++++ src/ 2025-10-14 03:11:59.405494 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-14 03:11:59.405519 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-14 03:11:59.405542 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-10-14 03:11:59.405562 | debian-bookworm | localhost | ok: Runtime: 0:00:00.003387 2025-10-14 03:14:19.512357 | 2025-10-14 03:14:19.512466 | TASK [upload-logs : Upload logs to log server] 2025-10-14 03:14:20.275386 | localhost | Output suppressed because no_log was given 2025-10-14 03:14:20.276987 | 2025-10-14 03:14:20.277063 | LOOP [upload-logs : Compress console log and json output] 2025-10-14 03:14:20.336513 | localhost | skipping: Conditional result was False 2025-10-14 03:14:20.364086 | localhost | skipping: Conditional result was False 2025-10-14 03:14:20.373120 | 2025-10-14 03:14:20.373300 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-14 03:14:20.412152 | localhost | skipping: Conditional result was False 2025-10-14 03:14:20.412341 | 2025-10-14 03:14:20.417247 | localhost | skipping: Conditional result was False 2025-10-14 03:14:20.428623 | 2025-10-14 03:14:20.428703 | LOOP [upload-logs : Upload console log and json output]