2025-07-27 03:01:08.757812 | Job console starting 2025-07-27 03:01:08.771932 | Updating git repos 2025-07-27 03:01:09.363986 | Cloning repos into workspace 2025-07-27 03:01:09.452639 | Restoring repo states 2025-07-27 03:01:09.496582 | Merging changes 2025-07-27 03:01:09.496599 | Checking out repos 2025-07-27 03:01:09.651354 | Preparing playbooks 2025-07-27 03:01:11.043235 | Running Ansible setup 2025-07-27 03:01:17.304426 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-07-27 03:01:18.768951 | 2025-07-27 03:01:18.769081 | PLAY [Base pre] 2025-07-27 03:01:18.801033 | 2025-07-27 03:01:18.801155 | TASK [Setup log path fact] 2025-07-27 03:01:18.839156 | debian-bookworm | ok 2025-07-27 03:01:18.863938 | 2025-07-27 03:01:18.864065 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-07-27 03:01:18.902982 | debian-bookworm | ok 2025-07-27 03:01:18.931805 | 2025-07-27 03:01:18.931919 | TASK [emit-job-header : Print job information] 2025-07-27 03:01:18.980046 | # Job Information 2025-07-27 03:01:18.980200 | Ansible Version: 2.16.14 2025-07-27 03:01:18.980235 | Job: python-black 2025-07-27 03:01:18.980267 | Pipeline: periodic-daily 2025-07-27 03:01:18.980290 | Executor: 521e9411259a 2025-07-27 03:01:18.980311 | Triggered by: https://github.com/osism/cinder-driver-dm-clone 2025-07-27 03:01:18.980333 | Event ID: 31d3f980a7e443448733734367d90664 2025-07-27 03:01:18.984927 | 2025-07-27 03:01:18.985017 | LOOP [emit-job-header : Print node information] 2025-07-27 03:01:19.143650 | debian-bookworm | ok: 2025-07-27 03:01:19.143816 | debian-bookworm | # Node Information 2025-07-27 03:01:19.143846 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-07-27 03:01:19.143867 | debian-bookworm | Hostname: debian 2025-07-27 03:01:19.143885 | debian-bookworm | Username: zuul 2025-07-27 03:01:19.143903 | debian-bookworm | Distro: Debian 12.11 2025-07-27 03:01:19.143923 | debian-bookworm | Provider: regiocloud-a 2025-07-27 03:01:19.143940 | debian-bookworm | Region: 2025-07-27 03:01:19.143957 | debian-bookworm | Label: debian-bookworm 2025-07-27 03:01:19.143973 | debian-bookworm | Product Name: OpenStack Nova 2025-07-27 03:01:19.143990 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe05:31a4 2025-07-27 03:01:19.166957 | 2025-07-27 03:01:19.167079 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-07-27 03:01:19.974787 | debian-bookworm -> localhost | changed 2025-07-27 03:01:19.988071 | 2025-07-27 03:01:19.988185 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-07-27 03:01:21.915156 | debian-bookworm -> localhost | changed 2025-07-27 03:01:21.925184 | 2025-07-27 03:01:21.925280 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-07-27 03:01:22.486319 | debian-bookworm -> localhost | ok 2025-07-27 03:01:22.492629 | 2025-07-27 03:01:22.492742 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-07-27 03:01:22.530923 | debian-bookworm | ok 2025-07-27 03:01:22.560277 | debian-bookworm | included: /var/lib/zuul/builds/de26301e86e94823b5b46ae3f3dd7d53/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-07-27 03:01:22.570849 | 2025-07-27 03:01:22.576923 | TASK [add-build-sshkey : Create Temp SSH key] 2025-07-27 03:01:24.894903 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-07-27 03:01:24.895086 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/de26301e86e94823b5b46ae3f3dd7d53/work/de26301e86e94823b5b46ae3f3dd7d53_id_rsa 2025-07-27 03:01:24.895136 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/de26301e86e94823b5b46ae3f3dd7d53/work/de26301e86e94823b5b46ae3f3dd7d53_id_rsa.pub 2025-07-27 03:01:24.895176 | debian-bookworm -> localhost | The key fingerprint is: 2025-07-27 03:01:24.895216 | debian-bookworm -> localhost | SHA256:d+wCbfdfMHGhSkH7sXTLXrP2wxSKT+8uq753Y1FErEc zuul-build-sshkey 2025-07-27 03:01:24.895253 | debian-bookworm -> localhost | The key's randomart image is: 2025-07-27 03:01:24.895289 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-07-27 03:01:24.895311 | debian-bookworm -> localhost | | .o +.| 2025-07-27 03:01:24.895332 | debian-bookworm -> localhost | | o . E| 2025-07-27 03:01:24.895353 | debian-bookworm -> localhost | | o +.=.| 2025-07-27 03:01:24.895372 | debian-bookworm -> localhost | | ...+ *++| 2025-07-27 03:01:24.895392 | debian-bookworm -> localhost | | S +.=o+=+| 2025-07-27 03:01:24.895417 | debian-bookworm -> localhost | | + = +.=+| 2025-07-27 03:01:24.895437 | debian-bookworm -> localhost | | . + =+o| 2025-07-27 03:01:24.895457 | debian-bookworm -> localhost | | . +.Oo| 2025-07-27 03:01:24.895478 | debian-bookworm -> localhost | | .++.Bo=| 2025-07-27 03:01:24.895512 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-07-27 03:01:24.895569 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.322997 2025-07-27 03:01:24.904028 | 2025-07-27 03:01:24.904119 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-07-27 03:01:24.967899 | debian-bookworm | ok 2025-07-27 03:01:24.991071 | debian-bookworm | included: /var/lib/zuul/builds/de26301e86e94823b5b46ae3f3dd7d53/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-07-27 03:01:25.022882 | 2025-07-27 03:01:25.022985 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-07-27 03:01:25.081762 | debian-bookworm | skipping: Conditional result was False 2025-07-27 03:01:25.088587 | 2025-07-27 03:01:25.088688 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-07-27 03:01:25.968234 | debian-bookworm | changed 2025-07-27 03:01:25.977547 | 2025-07-27 03:01:25.977780 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-07-27 03:01:26.290090 | debian-bookworm | ok 2025-07-27 03:01:26.320145 | 2025-07-27 03:01:26.320252 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-07-27 03:01:27.284040 | debian-bookworm | changed 2025-07-27 03:01:27.299425 | 2025-07-27 03:01:27.299535 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-07-27 03:01:28.145842 | debian-bookworm | changed 2025-07-27 03:01:28.153197 | 2025-07-27 03:01:28.154987 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-07-27 03:01:28.251421 | debian-bookworm | skipping: Conditional result was False 2025-07-27 03:01:28.258316 | 2025-07-27 03:01:28.258418 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-07-27 03:01:29.504708 | debian-bookworm -> localhost | changed 2025-07-27 03:01:29.527999 | 2025-07-27 03:01:29.528116 | TASK [add-build-sshkey : Add back temp key] 2025-07-27 03:01:30.306692 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/de26301e86e94823b5b46ae3f3dd7d53/work/de26301e86e94823b5b46ae3f3dd7d53_id_rsa (zuul-build-sshkey) 2025-07-27 03:01:30.306970 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.022568 2025-07-27 03:01:30.313553 | 2025-07-27 03:01:30.313641 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-07-27 03:01:30.705318 | debian-bookworm | ok 2025-07-27 03:01:30.709935 | 2025-07-27 03:01:30.710010 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-07-27 03:01:30.745605 | debian-bookworm | skipping: Conditional result was False 2025-07-27 03:01:30.754031 | 2025-07-27 03:01:30.754113 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-07-27 03:01:31.422333 | debian-bookworm | ok 2025-07-27 03:01:31.453560 | 2025-07-27 03:01:31.453661 | TASK [validate-host : Define zuul_info_dir fact] 2025-07-27 03:01:31.550684 | debian-bookworm | ok 2025-07-27 03:01:31.560615 | 2025-07-27 03:01:31.560704 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-07-27 03:01:32.446417 | debian-bookworm -> localhost | ok 2025-07-27 03:01:32.451540 | 2025-07-27 03:01:32.451616 | TASK [validate-host : Collect information about the host] 2025-07-27 03:01:33.976530 | debian-bookworm | ok 2025-07-27 03:01:33.998778 | 2025-07-27 03:01:33.999226 | TASK [validate-host : Sanitize hostname] 2025-07-27 03:01:34.171801 | debian-bookworm | ok 2025-07-27 03:01:34.289257 | 2025-07-27 03:01:34.289354 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-07-27 03:01:36.052518 | debian-bookworm -> localhost | changed 2025-07-27 03:01:36.057238 | 2025-07-27 03:01:36.057323 | TASK [validate-host : Collect information about zuul worker] 2025-07-27 03:01:36.961703 | debian-bookworm | ok 2025-07-27 03:01:36.965569 | 2025-07-27 03:01:36.965648 | TASK [validate-host : Write out all zuul information for each host] 2025-07-27 03:01:38.480389 | debian-bookworm -> localhost | changed 2025-07-27 03:01:38.488056 | 2025-07-27 03:01:38.488140 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-07-27 03:01:38.861586 | debian-bookworm | ok 2025-07-27 03:01:38.875438 | 2025-07-27 03:01:38.875566 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-07-27 03:01:40.498232 | debian-bookworm | changed: 2025-07-27 03:01:40.498389 | debian-bookworm | cd+++++++++ src/ 2025-07-27 03:01:40.498424 | debian-bookworm | cd+++++++++ src/github.com/ 2025-07-27 03:01:40.498448 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-07-27 03:01:40.498488 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/ 2025-07-27 03:01:40.498509 | debian-bookworm | localhost | ok: Runtime: 0:00:00.010205 2025-07-27 03:02:10.852589 | 2025-07-27 03:02:10.852679 | TASK [upload-logs : Upload logs to log server] 2025-07-27 03:02:11.726485 | localhost | Output suppressed because no_log was given 2025-07-27 03:02:11.728115 | 2025-07-27 03:02:11.728201 | LOOP [upload-logs : Compress console log and json output] 2025-07-27 03:02:11.826381 | localhost | skipping: Conditional result was False 2025-07-27 03:02:11.837391 | localhost | skipping: Conditional result was False 2025-07-27 03:02:11.844769 | 2025-07-27 03:02:11.844876 | LOOP [upload-logs : Upload compressed console log and json output] 2025-07-27 03:02:11.933437 | localhost | skipping: Conditional result was False 2025-07-27 03:02:11.933670 | 2025-07-27 03:02:11.939331 | localhost | skipping: Conditional result was False 2025-07-27 03:02:11.951770 | 2025-07-27 03:02:11.951885 | LOOP [upload-logs : Upload console log and json output]