2025-09-16 03:01:21.271434 | Job console starting 2025-09-16 03:01:21.281682 | Updating git repos 2025-09-16 03:01:21.392105 | Cloning repos into workspace 2025-09-16 03:01:21.459954 | Restoring repo states 2025-09-16 03:01:21.475753 | Merging changes 2025-09-16 03:01:21.475768 | Checking out repos 2025-09-16 03:01:21.538257 | Preparing playbooks 2025-09-16 03:01:22.754670 | Running Ansible setup 2025-09-16 03:01:31.554046 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-16 03:01:33.668913 | 2025-09-16 03:01:33.669053 | PLAY [Base pre] 2025-09-16 03:01:33.770004 | 2025-09-16 03:01:33.770135 | TASK [Setup log path fact] 2025-09-16 03:01:33.821977 | debian-bookworm | ok 2025-09-16 03:01:33.918803 | 2025-09-16 03:01:33.923204 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-16 03:01:33.996534 | debian-bookworm | ok 2025-09-16 03:01:34.050185 | 2025-09-16 03:01:34.050289 | TASK [emit-job-header : Print job information] 2025-09-16 03:01:34.131613 | # Job Information 2025-09-16 03:01:34.132014 | Ansible Version: 2.16.14 2025-09-16 03:01:34.132180 | Job: python-black 2025-09-16 03:01:34.132216 | Pipeline: periodic-daily 2025-09-16 03:01:34.132237 | Executor: 521e9411259a 2025-09-16 03:01:34.132255 | Triggered by: https://github.com/osism/cinder-driver-dm-clone 2025-09-16 03:01:34.132274 | Event ID: 74c830c6e3134f508a6d63e1e5ea0922 2025-09-16 03:01:34.144155 | 2025-09-16 03:01:34.144254 | LOOP [emit-job-header : Print node information] 2025-09-16 03:01:34.582600 | debian-bookworm | ok: 2025-09-16 03:01:34.582749 | debian-bookworm | # Node Information 2025-09-16 03:01:34.582779 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-16 03:01:34.582801 | debian-bookworm | Hostname: debian 2025-09-16 03:01:34.582819 | debian-bookworm | Username: zuul 2025-09-16 03:01:34.582849 | debian-bookworm | Distro: Debian 12.12 2025-09-16 03:01:34.582870 | debian-bookworm | Provider: regiocloud-a 2025-09-16 03:01:34.583025 | debian-bookworm | Region: 2025-09-16 03:01:34.583085 | debian-bookworm | Label: debian-bookworm 2025-09-16 03:01:34.583136 | debian-bookworm | Product Name: OpenStack Nova 2025-09-16 03:01:34.583159 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe26:f288 2025-09-16 03:01:34.608956 | 2025-09-16 03:01:34.609058 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-16 03:01:36.001065 | debian-bookworm -> localhost | changed 2025-09-16 03:01:36.006804 | 2025-09-16 03:01:36.006906 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-16 03:01:39.031370 | debian-bookworm -> localhost | changed 2025-09-16 03:01:39.044280 | 2025-09-16 03:01:39.044421 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-16 03:01:39.625521 | debian-bookworm -> localhost | ok 2025-09-16 03:01:39.630660 | 2025-09-16 03:01:39.630745 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-16 03:01:39.647391 | debian-bookworm | ok 2025-09-16 03:01:39.665967 | debian-bookworm | included: /var/lib/zuul/builds/9a988e393e8c48a495a8b8f6647fcc55/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-16 03:01:39.671272 | 2025-09-16 03:01:39.671374 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-16 03:01:40.972125 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-16 03:01:40.972296 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/9a988e393e8c48a495a8b8f6647fcc55/work/9a988e393e8c48a495a8b8f6647fcc55_id_rsa 2025-09-16 03:01:40.972342 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/9a988e393e8c48a495a8b8f6647fcc55/work/9a988e393e8c48a495a8b8f6647fcc55_id_rsa.pub 2025-09-16 03:01:40.972365 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-16 03:01:40.972385 | debian-bookworm -> localhost | SHA256:CYR0u6lOFjnoGbCtEuVKkK5q8zbuLtdCj9w0rM3cEPQ zuul-build-sshkey 2025-09-16 03:01:40.972403 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-16 03:01:40.972430 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-16 03:01:40.972448 | debian-bookworm -> localhost | | ...o | 2025-09-16 03:01:40.972466 | debian-bookworm -> localhost | | . .+ . | 2025-09-16 03:01:40.972483 | debian-bookworm -> localhost | |+ . . + | 2025-09-16 03:01:40.972499 | debian-bookworm -> localhost | |o* . o E . | 2025-09-16 03:01:40.972516 | debian-bookworm -> localhost | |oo= = + S | 2025-09-16 03:01:40.972535 | debian-bookworm -> localhost | |o= + O | 2025-09-16 03:01:40.972552 | debian-bookworm -> localhost | |= = # + | 2025-09-16 03:01:40.972568 | debian-bookworm -> localhost | |o+ % B . | 2025-09-16 03:01:40.972586 | debian-bookworm -> localhost | |o X=+ | 2025-09-16 03:01:40.972603 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-16 03:01:40.972651 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.610295 2025-09-16 03:01:40.978459 | 2025-09-16 03:01:40.978536 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-16 03:01:41.014811 | debian-bookworm | ok 2025-09-16 03:01:41.022132 | debian-bookworm | included: /var/lib/zuul/builds/9a988e393e8c48a495a8b8f6647fcc55/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-16 03:01:41.050660 | 2025-09-16 03:01:41.050749 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-16 03:01:41.075505 | debian-bookworm | skipping: Conditional result was False 2025-09-16 03:01:41.097117 | 2025-09-16 03:01:41.097211 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-16 03:01:42.073785 | debian-bookworm | changed 2025-09-16 03:01:42.078222 | 2025-09-16 03:01:42.078296 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-16 03:01:42.386561 | debian-bookworm | ok 2025-09-16 03:01:42.391467 | 2025-09-16 03:01:42.391549 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-16 03:01:43.113817 | debian-bookworm | changed 2025-09-16 03:01:43.124654 | 2025-09-16 03:01:43.124769 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-16 03:01:43.730296 | debian-bookworm | changed 2025-09-16 03:01:43.740176 | 2025-09-16 03:01:43.740260 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-16 03:01:43.784018 | debian-bookworm | skipping: Conditional result was False 2025-09-16 03:01:43.790081 | 2025-09-16 03:01:43.790180 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-16 03:01:44.218511 | debian-bookworm -> localhost | changed 2025-09-16 03:01:44.231199 | 2025-09-16 03:01:44.231299 | TASK [add-build-sshkey : Add back temp key] 2025-09-16 03:01:44.777654 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/9a988e393e8c48a495a8b8f6647fcc55/work/9a988e393e8c48a495a8b8f6647fcc55_id_rsa (zuul-build-sshkey) 2025-09-16 03:01:44.777930 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.030098 2025-09-16 03:01:44.786400 | 2025-09-16 03:01:44.786502 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-16 03:01:45.257375 | debian-bookworm | ok 2025-09-16 03:01:45.262207 | 2025-09-16 03:01:45.262298 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-16 03:01:45.330744 | debian-bookworm | skipping: Conditional result was False 2025-09-16 03:01:45.344655 | 2025-09-16 03:01:45.344756 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-16 03:01:46.362197 | debian-bookworm | ok 2025-09-16 03:01:46.408663 | 2025-09-16 03:01:46.408813 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-16 03:01:46.475147 | debian-bookworm | ok 2025-09-16 03:01:46.499512 | 2025-09-16 03:01:46.499621 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-16 03:01:47.335461 | debian-bookworm -> localhost | ok 2025-09-16 03:01:47.341146 | 2025-09-16 03:01:47.341243 | TASK [validate-host : Collect information about the host] 2025-09-16 03:01:49.720031 | debian-bookworm | ok 2025-09-16 03:01:49.738648 | 2025-09-16 03:01:49.738751 | TASK [validate-host : Sanitize hostname] 2025-09-16 03:01:50.100382 | debian-bookworm | ok 2025-09-16 03:01:50.189397 | 2025-09-16 03:01:50.189499 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-16 03:01:51.223845 | debian-bookworm -> localhost | changed 2025-09-16 03:01:51.228466 | 2025-09-16 03:01:51.228551 | TASK [validate-host : Collect information about zuul worker] 2025-09-16 03:01:51.802362 | debian-bookworm | ok 2025-09-16 03:01:51.807370 | 2025-09-16 03:01:51.807458 | TASK [validate-host : Write out all zuul information for each host] 2025-09-16 03:01:53.119175 | debian-bookworm -> localhost | changed 2025-09-16 03:01:53.126753 | 2025-09-16 03:01:53.126847 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-16 03:01:53.456090 | debian-bookworm | ok 2025-09-16 03:01:53.460562 | 2025-09-16 03:01:53.460639 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-16 03:01:54.411458 | debian-bookworm | changed: 2025-09-16 03:01:54.411607 | debian-bookworm | cd+++++++++ src/ 2025-09-16 03:01:54.411634 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-16 03:01:54.411654 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-16 03:01:54.411672 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/ 2025-09-16 03:01:54.411688 | debian-bookworm | localhost | ok: Runtime: 0:00:00.023520 2025-09-16 03:02:26.946063 | 2025-09-16 03:02:26.946413 | TASK [upload-logs : Upload logs to log server] 2025-09-16 03:02:28.115028 | localhost | Output suppressed because no_log was given 2025-09-16 03:02:28.116770 | 2025-09-16 03:02:28.116878 | LOOP [upload-logs : Compress console log and json output] 2025-09-16 03:02:28.203719 | localhost | skipping: Conditional result was False 2025-09-16 03:02:28.218505 | localhost | skipping: Conditional result was False 2025-09-16 03:02:28.223606 | 2025-09-16 03:02:28.223703 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-16 03:02:28.340304 | localhost | skipping: Conditional result was False 2025-09-16 03:02:28.340529 | 2025-09-16 03:02:28.353236 | localhost | skipping: Conditional result was False 2025-09-16 03:02:28.359564 | 2025-09-16 03:02:28.359672 | LOOP [upload-logs : Upload console log and json output]