2025-10-02 03:00:13.264244 | Job console starting 2025-10-02 03:00:13.292646 | Updating git repos 2025-10-02 03:00:13.338656 | Cloning repos into workspace 2025-10-02 03:00:13.370637 | Restoring repo states 2025-10-02 03:00:13.392688 | Merging changes 2025-10-02 03:00:13.392710 | Checking out repos 2025-10-02 03:00:13.488280 | Preparing playbooks 2025-10-02 03:00:15.054988 | Running Ansible setup 2025-10-02 03:00:21.238500 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-02 03:00:22.968227 | 2025-10-02 03:00:22.968374 | PLAY [Base pre] 2025-10-02 03:00:23.040113 | 2025-10-02 03:00:23.040227 | TASK [Setup log path fact] 2025-10-02 03:00:23.082260 | debian-bookworm | ok 2025-10-02 03:00:23.128004 | 2025-10-02 03:00:23.128129 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-02 03:00:23.206722 | debian-bookworm | ok 2025-10-02 03:00:23.228659 | 2025-10-02 03:00:23.228752 | TASK [emit-job-header : Print job information] 2025-10-02 03:00:23.293367 | # Job Information 2025-10-02 03:00:23.293503 | Ansible Version: 2.16.14 2025-10-02 03:00:23.293531 | Job: python-black 2025-10-02 03:00:23.293557 | Pipeline: periodic-daily 2025-10-02 03:00:23.293575 | Executor: 521e9411259a 2025-10-02 03:00:23.293592 | Triggered by: https://github.com/osism/cinder-driver-dm-clone 2025-10-02 03:00:23.293610 | Event ID: e2182371296c4f21b1234d738eff4a43 2025-10-02 03:00:23.297528 | 2025-10-02 03:00:23.297605 | LOOP [emit-job-header : Print node information] 2025-10-02 03:00:23.476904 | debian-bookworm | ok: 2025-10-02 03:00:23.477090 | debian-bookworm | # Node Information 2025-10-02 03:00:23.477120 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-02 03:00:23.477140 | debian-bookworm | Hostname: debian 2025-10-02 03:00:23.477157 | debian-bookworm | Username: zuul 2025-10-02 03:00:23.477174 | debian-bookworm | Distro: Debian 12.12 2025-10-02 03:00:23.477193 | debian-bookworm | Provider: regiocloud-a 2025-10-02 03:00:23.477210 | debian-bookworm | Region: 2025-10-02 03:00:23.477227 | debian-bookworm | Label: debian-bookworm 2025-10-02 03:00:23.477243 | debian-bookworm | Product Name: OpenStack Nova 2025-10-02 03:00:23.477259 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe85:b747 2025-10-02 03:00:23.502693 | 2025-10-02 03:00:23.502788 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-02 03:00:24.599805 | debian-bookworm -> localhost | changed 2025-10-02 03:00:24.605890 | 2025-10-02 03:00:24.605981 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-02 03:00:26.746681 | debian-bookworm -> localhost | changed 2025-10-02 03:00:26.756748 | 2025-10-02 03:00:26.756874 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-02 03:00:27.435005 | debian-bookworm -> localhost | ok 2025-10-02 03:00:27.439971 | 2025-10-02 03:00:27.440053 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-02 03:00:27.466319 | debian-bookworm | ok 2025-10-02 03:00:27.487828 | debian-bookworm | included: /var/lib/zuul/builds/f62ca6940a2c4ce78986bf578df6f261/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-02 03:00:27.493207 | 2025-10-02 03:00:27.493283 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-02 03:00:29.043166 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-02 03:00:29.043367 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/f62ca6940a2c4ce78986bf578df6f261/work/f62ca6940a2c4ce78986bf578df6f261_id_rsa 2025-10-02 03:00:29.043405 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/f62ca6940a2c4ce78986bf578df6f261/work/f62ca6940a2c4ce78986bf578df6f261_id_rsa.pub 2025-10-02 03:00:29.043427 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-02 03:00:29.043448 | debian-bookworm -> localhost | SHA256:UOeoIJLrCu1bDq8Hw5G5AGb0rZr6zBXXLzwIzA3rxZ8 zuul-build-sshkey 2025-10-02 03:00:29.043466 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-02 03:00:29.043494 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-02 03:00:29.043512 | debian-bookworm -> localhost | |.. . . | 2025-10-02 03:00:29.043531 | debian-bookworm -> localhost | |.+. . . + | 2025-10-02 03:00:29.043547 | debian-bookworm -> localhost | |* .+o.. . . | 2025-10-02 03:00:29.043564 | debian-bookworm -> localhost | |.o++.* + | 2025-10-02 03:00:29.043580 | debian-bookworm -> localhost | |.o +* * S | 2025-10-02 03:00:29.043599 | debian-bookworm -> localhost | |..B. = + o | 2025-10-02 03:00:29.043615 | debian-bookworm -> localhost | |.+oo+ . E . | 2025-10-02 03:00:29.043631 | debian-bookworm -> localhost | |++ *. o | 2025-10-02 03:00:29.043648 | debian-bookworm -> localhost | |o.B+o | 2025-10-02 03:00:29.043664 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-02 03:00:29.043706 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.829995 2025-10-02 03:00:29.049711 | 2025-10-02 03:00:29.049793 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-02 03:00:29.101148 | debian-bookworm | ok 2025-10-02 03:00:29.123390 | debian-bookworm | included: /var/lib/zuul/builds/f62ca6940a2c4ce78986bf578df6f261/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-02 03:00:29.152421 | 2025-10-02 03:00:29.152517 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-02 03:00:29.211786 | debian-bookworm | skipping: Conditional result was False 2025-10-02 03:00:29.227040 | 2025-10-02 03:00:29.227140 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-02 03:00:30.101288 | debian-bookworm | changed 2025-10-02 03:00:30.105510 | 2025-10-02 03:00:30.105586 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-02 03:00:30.393581 | debian-bookworm | ok 2025-10-02 03:00:30.397935 | 2025-10-02 03:00:30.398012 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-02 03:00:31.173098 | debian-bookworm | changed 2025-10-02 03:00:31.183582 | 2025-10-02 03:00:31.183679 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-02 03:00:31.920981 | debian-bookworm | changed 2025-10-02 03:00:31.925943 | 2025-10-02 03:00:31.926024 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-02 03:00:31.958784 | debian-bookworm | skipping: Conditional result was False 2025-10-02 03:00:31.964421 | 2025-10-02 03:00:31.964503 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-02 03:00:32.529840 | debian-bookworm -> localhost | changed 2025-10-02 03:00:32.538267 | 2025-10-02 03:00:32.538374 | TASK [add-build-sshkey : Add back temp key] 2025-10-02 03:00:33.134456 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/f62ca6940a2c4ce78986bf578df6f261/work/f62ca6940a2c4ce78986bf578df6f261_id_rsa (zuul-build-sshkey) 2025-10-02 03:00:33.134630 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.026681 2025-10-02 03:00:33.143921 | 2025-10-02 03:00:33.144007 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-02 03:00:33.900949 | debian-bookworm | ok 2025-10-02 03:00:33.905772 | 2025-10-02 03:00:33.905862 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-02 03:00:33.955308 | debian-bookworm | skipping: Conditional result was False 2025-10-02 03:00:33.965402 | 2025-10-02 03:00:33.965507 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-02 03:00:34.474441 | debian-bookworm | ok 2025-10-02 03:00:34.487093 | 2025-10-02 03:00:34.487188 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-02 03:00:34.532762 | debian-bookworm | ok 2025-10-02 03:00:34.537501 | 2025-10-02 03:00:34.537587 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-02 03:00:35.052508 | debian-bookworm -> localhost | ok 2025-10-02 03:00:35.061302 | 2025-10-02 03:00:35.061425 | TASK [validate-host : Collect information about the host] 2025-10-02 03:00:36.474253 | debian-bookworm | ok 2025-10-02 03:00:36.505840 | 2025-10-02 03:00:36.505954 | TASK [validate-host : Sanitize hostname] 2025-10-02 03:00:36.668783 | debian-bookworm | ok 2025-10-02 03:00:36.777467 | 2025-10-02 03:00:36.777566 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-02 03:00:38.052352 | debian-bookworm -> localhost | changed 2025-10-02 03:00:38.056863 | 2025-10-02 03:00:38.056951 | TASK [validate-host : Collect information about zuul worker] 2025-10-02 03:00:38.614241 | debian-bookworm | ok 2025-10-02 03:00:38.617984 | 2025-10-02 03:00:38.618062 | TASK [validate-host : Write out all zuul information for each host] 2025-10-02 03:00:39.866882 | debian-bookworm -> localhost | changed 2025-10-02 03:00:39.875986 | 2025-10-02 03:00:39.876075 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-02 03:00:40.175439 | debian-bookworm | ok 2025-10-02 03:00:40.185620 | 2025-10-02 03:00:40.185711 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-02 03:00:41.200096 | debian-bookworm | changed: 2025-10-02 03:00:41.200236 | debian-bookworm | cd+++++++++ src/ 2025-10-02 03:00:41.200264 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-02 03:00:41.200284 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-02 03:00:41.200302 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/ 2025-10-02 03:00:41.200318 | debian-bookworm | localhost | ok: Runtime: 0:00:00.030758 2025-10-02 03:01:12.801799 | 2025-10-02 03:01:12.801879 | TASK [upload-logs : Upload logs to log server] 2025-10-02 03:01:14.033463 | localhost | Output suppressed because no_log was given 2025-10-02 03:01:14.035078 | 2025-10-02 03:01:14.035157 | LOOP [upload-logs : Compress console log and json output] 2025-10-02 03:01:14.086754 | localhost | skipping: Conditional result was False 2025-10-02 03:01:14.093072 | localhost | skipping: Conditional result was False 2025-10-02 03:01:14.099852 | 2025-10-02 03:01:14.099936 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-02 03:01:14.212084 | localhost | skipping: Conditional result was False 2025-10-02 03:01:14.212308 | 2025-10-02 03:01:14.227166 | localhost | skipping: Conditional result was False 2025-10-02 03:01:14.238155 | 2025-10-02 03:01:14.238246 | LOOP [upload-logs : Upload console log and json output]