2025-12-05 03:15:49.530403 | Job console starting 2025-12-05 03:15:49.543529 | Updating git repos 2025-12-05 03:15:49.579982 | Cloning repos into workspace 2025-12-05 03:15:49.642459 | Restoring repo states 2025-12-05 03:15:49.698543 | Merging changes 2025-12-05 03:15:49.698564 | Checking out repos 2025-12-05 03:15:49.780694 | Preparing playbooks 2025-12-05 03:15:51.236381 | Running Ansible setup 2025-12-05 03:15:57.467123 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-05 03:15:58.680348 | 2025-12-05 03:15:58.680530 | PLAY [Base pre] 2025-12-05 03:15:58.709591 | 2025-12-05 03:15:58.709934 | TASK [Setup log path fact] 2025-12-05 03:15:58.754473 | debian-bookworm | ok 2025-12-05 03:15:58.774756 | 2025-12-05 03:15:58.774957 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-05 03:15:58.811966 | debian-bookworm | ok 2025-12-05 03:15:58.822436 | 2025-12-05 03:15:58.822574 | TASK [emit-job-header : Print job information] 2025-12-05 03:15:58.884233 | # Job Information 2025-12-05 03:15:58.884528 | Ansible Version: 2.16.14 2025-12-05 03:15:58.884569 | Job: python-black 2025-12-05 03:15:58.884606 | Pipeline: periodic-daily 2025-12-05 03:15:58.884634 | Executor: 521e9411259a 2025-12-05 03:15:58.884655 | Triggered by: https://github.com/osism/cinder-driver-dm-clone 2025-12-05 03:15:58.884678 | Event ID: eb40fd7e78a64b5ca4267abf26ea8bd9 2025-12-05 03:15:58.895441 | 2025-12-05 03:15:58.895608 | LOOP [emit-job-header : Print node information] 2025-12-05 03:15:59.090939 | debian-bookworm | ok: 2025-12-05 03:15:59.091147 | debian-bookworm | # Node Information 2025-12-05 03:15:59.091183 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-05 03:15:59.091208 | debian-bookworm | Hostname: debian 2025-12-05 03:15:59.091230 | debian-bookworm | Username: zuul 2025-12-05 03:15:59.091251 | debian-bookworm | Distro: Debian 12.12 2025-12-05 03:15:59.091274 | debian-bookworm | Provider: regiocloud-a 2025-12-05 03:15:59.091296 | debian-bookworm | Region: 2025-12-05 03:15:59.091317 | debian-bookworm | Label: debian-bookworm 2025-12-05 03:15:59.091336 | debian-bookworm | Product Name: OpenStack Nova 2025-12-05 03:15:59.091355 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fed6:2f7b 2025-12-05 03:15:59.107065 | 2025-12-05 03:15:59.107211 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-05 03:15:59.928390 | debian-bookworm -> localhost | changed 2025-12-05 03:15:59.936278 | 2025-12-05 03:15:59.936422 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-05 03:16:01.713467 | debian-bookworm -> localhost | changed 2025-12-05 03:16:01.729967 | 2025-12-05 03:16:01.730294 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-05 03:16:02.645007 | debian-bookworm -> localhost | ok 2025-12-05 03:16:02.663501 | 2025-12-05 03:16:02.663840 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-05 03:16:02.785507 | debian-bookworm | ok 2025-12-05 03:16:02.837042 | debian-bookworm | included: /var/lib/zuul/builds/1e3a58bf22364eadb5f95253e33a533b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-05 03:16:02.853496 | 2025-12-05 03:16:02.853637 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-05 03:16:05.177309 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-05 03:16:05.177572 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/1e3a58bf22364eadb5f95253e33a533b/work/1e3a58bf22364eadb5f95253e33a533b_id_rsa 2025-12-05 03:16:05.177613 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/1e3a58bf22364eadb5f95253e33a533b/work/1e3a58bf22364eadb5f95253e33a533b_id_rsa.pub 2025-12-05 03:16:05.177641 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-05 03:16:05.177665 | debian-bookworm -> localhost | SHA256:cPRMYxnZZPkFrt7Al1sbK+BCq7pRqRQbMPWCDwWur1A zuul-build-sshkey 2025-12-05 03:16:05.177688 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-05 03:16:05.177744 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-05 03:16:05.177769 | debian-bookworm -> localhost | | +oo . =*o... | 2025-12-05 03:16:05.177881 | debian-bookworm -> localhost | | . = .. =ooo. .| 2025-12-05 03:16:05.177911 | debian-bookworm -> localhost | | + +... o ... | 2025-12-05 03:16:05.177934 | debian-bookworm -> localhost | | . o =o. . ... | 2025-12-05 03:16:05.177954 | debian-bookworm -> localhost | | .E + oS. .+ o..| 2025-12-05 03:16:05.177979 | debian-bookworm -> localhost | | .. . o . o..+ o+| 2025-12-05 03:16:05.178000 | debian-bookworm -> localhost | |. . o o ...oo | 2025-12-05 03:16:05.178020 | debian-bookworm -> localhost | |. . . . . . | 2025-12-05 03:16:05.178042 | debian-bookworm -> localhost | | . oo. | 2025-12-05 03:16:05.178062 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-05 03:16:05.178130 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.271910 2025-12-05 03:16:05.187303 | 2025-12-05 03:16:05.187447 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-05 03:16:05.253539 | debian-bookworm | ok 2025-12-05 03:16:05.281992 | debian-bookworm | included: /var/lib/zuul/builds/1e3a58bf22364eadb5f95253e33a533b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-05 03:16:05.302695 | 2025-12-05 03:16:05.302888 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-05 03:16:05.352925 | debian-bookworm | skipping: Conditional result was False 2025-12-05 03:16:05.361134 | 2025-12-05 03:16:05.361274 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-05 03:16:06.169901 | debian-bookworm | changed 2025-12-05 03:16:06.180366 | 2025-12-05 03:16:06.180517 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-05 03:16:06.469228 | debian-bookworm | ok 2025-12-05 03:16:06.485941 | 2025-12-05 03:16:06.486084 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-05 03:16:07.322379 | debian-bookworm | changed 2025-12-05 03:16:07.334399 | 2025-12-05 03:16:07.334535 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-05 03:16:08.106946 | debian-bookworm | changed 2025-12-05 03:16:08.116552 | 2025-12-05 03:16:08.116708 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-05 03:16:08.164582 | debian-bookworm | skipping: Conditional result was False 2025-12-05 03:16:08.171281 | 2025-12-05 03:16:08.171404 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-05 03:16:08.801603 | debian-bookworm -> localhost | changed 2025-12-05 03:16:08.823797 | 2025-12-05 03:16:08.823942 | TASK [add-build-sshkey : Add back temp key] 2025-12-05 03:16:09.439641 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/1e3a58bf22364eadb5f95253e33a533b/work/1e3a58bf22364eadb5f95253e33a533b_id_rsa (zuul-build-sshkey) 2025-12-05 03:16:09.440159 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.021097 2025-12-05 03:16:09.454051 | 2025-12-05 03:16:09.454209 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-05 03:16:09.920925 | debian-bookworm | ok 2025-12-05 03:16:09.933467 | 2025-12-05 03:16:09.933618 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-05 03:16:09.982069 | debian-bookworm | skipping: Conditional result was False 2025-12-05 03:16:09.993510 | 2025-12-05 03:16:09.993640 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-05 03:16:10.581489 | debian-bookworm | ok 2025-12-05 03:16:10.610345 | 2025-12-05 03:16:10.611881 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-05 03:16:10.668860 | debian-bookworm | ok 2025-12-05 03:16:10.683636 | 2025-12-05 03:16:10.683818 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-05 03:16:11.343095 | debian-bookworm -> localhost | ok 2025-12-05 03:16:11.365077 | 2025-12-05 03:16:11.365222 | TASK [validate-host : Collect information about the host] 2025-12-05 03:16:12.814799 | debian-bookworm | ok 2025-12-05 03:16:12.825794 | 2025-12-05 03:16:12.825929 | TASK [validate-host : Sanitize hostname] 2025-12-05 03:16:12.948021 | debian-bookworm | ok 2025-12-05 03:16:12.997693 | 2025-12-05 03:16:12.997867 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-05 03:16:13.761618 | debian-bookworm -> localhost | changed 2025-12-05 03:16:13.773931 | 2025-12-05 03:16:13.774085 | TASK [validate-host : Collect information about zuul worker] 2025-12-05 03:16:14.346051 | debian-bookworm | ok 2025-12-05 03:16:14.355614 | 2025-12-05 03:16:14.355775 | TASK [validate-host : Write out all zuul information for each host] 2025-12-05 03:16:15.189078 | debian-bookworm -> localhost | changed 2025-12-05 03:16:15.201487 | 2025-12-05 03:16:15.201623 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-05 03:16:15.490386 | debian-bookworm | ok 2025-12-05 03:16:15.500562 | 2025-12-05 03:16:15.500712 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-05 03:16:16.602985 | debian-bookworm | changed: 2025-12-05 03:16:16.603325 | debian-bookworm | cd+++++++++ src/ 2025-12-05 03:16:16.603385 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-05 03:16:16.603425 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-05 03:16:16.603461 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/ 2025-12-05 03:16:16.603494 | debian-bookworm | localhost | ok: Runtime: 0:00:00.031852 2025-12-05 03:16:44.758060 | 2025-12-05 03:16:44.758197 | TASK [upload-logs : Upload logs to log server] 2025-12-05 03:16:45.520520 | localhost | Output suppressed because no_log was given 2025-12-05 03:16:45.522533 | 2025-12-05 03:16:45.522652 | LOOP [upload-logs : Compress console log and json output] 2025-12-05 03:16:45.660640 | localhost | skipping: Conditional result was False 2025-12-05 03:16:45.703699 | localhost | skipping: Conditional result was False 2025-12-05 03:16:45.716441 | 2025-12-05 03:16:45.716594 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-05 03:16:45.851589 | localhost | skipping: Conditional result was False 2025-12-05 03:16:45.851970 | 2025-12-05 03:16:45.865517 | localhost | skipping: Conditional result was False 2025-12-05 03:16:45.876442 | 2025-12-05 03:16:45.876587 | LOOP [upload-logs : Upload console log and json output]