2025-11-29 03:14:30.418677 | Job console starting 2025-11-29 03:14:30.433616 | Updating git repos 2025-11-29 03:14:30.487196 | Cloning repos into workspace 2025-11-29 03:14:30.559273 | Restoring repo states 2025-11-29 03:14:30.601274 | Merging changes 2025-11-29 03:14:30.601298 | Checking out repos 2025-11-29 03:14:30.680847 | Preparing playbooks 2025-11-29 03:14:31.910393 | Running Ansible setup 2025-11-29 03:14:36.780203 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-29 03:14:37.593999 | 2025-11-29 03:14:37.594175 | PLAY [Base pre] 2025-11-29 03:14:37.611387 | 2025-11-29 03:14:37.611523 | TASK [Setup log path fact] 2025-11-29 03:14:37.641040 | debian-bookworm | ok 2025-11-29 03:14:37.656188 | 2025-11-29 03:14:37.656342 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-29 03:14:37.687272 | debian-bookworm | ok 2025-11-29 03:14:37.697839 | 2025-11-29 03:14:37.697968 | TASK [emit-job-header : Print job information] 2025-11-29 03:14:37.737346 | # Job Information 2025-11-29 03:14:37.737533 | Ansible Version: 2.16.14 2025-11-29 03:14:37.737569 | Job: python-black 2025-11-29 03:14:37.737600 | Pipeline: periodic-daily 2025-11-29 03:14:37.737623 | Executor: 521e9411259a 2025-11-29 03:14:37.737644 | Triggered by: https://github.com/osism/cinder-driver-dm-clone 2025-11-29 03:14:37.737667 | Event ID: 9d16513488a24981b72b5981a6484ac6 2025-11-29 03:14:37.742705 | 2025-11-29 03:14:37.742816 | LOOP [emit-job-header : Print node information] 2025-11-29 03:14:37.860817 | debian-bookworm | ok: 2025-11-29 03:14:37.861138 | debian-bookworm | # Node Information 2025-11-29 03:14:37.861205 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-29 03:14:37.861233 | debian-bookworm | Hostname: debian 2025-11-29 03:14:37.861256 | debian-bookworm | Username: zuul 2025-11-29 03:14:37.861277 | debian-bookworm | Distro: Debian 12.12 2025-11-29 03:14:37.861306 | debian-bookworm | Provider: regiocloud-a 2025-11-29 03:14:37.861329 | debian-bookworm | Region: 2025-11-29 03:14:37.861350 | debian-bookworm | Label: debian-bookworm 2025-11-29 03:14:37.861370 | debian-bookworm | Product Name: OpenStack Nova 2025-11-29 03:14:37.861394 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe78:d4ba 2025-11-29 03:14:37.890305 | 2025-11-29 03:14:37.890476 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-29 03:14:38.465563 | debian-bookworm -> localhost | changed 2025-11-29 03:14:38.476455 | 2025-11-29 03:14:38.476616 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-29 03:14:39.643926 | debian-bookworm -> localhost | changed 2025-11-29 03:14:39.658046 | 2025-11-29 03:14:39.658183 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-29 03:14:39.956638 | debian-bookworm -> localhost | ok 2025-11-29 03:14:39.963460 | 2025-11-29 03:14:39.963586 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-29 03:14:39.995539 | debian-bookworm | ok 2025-11-29 03:14:40.023443 | debian-bookworm | included: /var/lib/zuul/builds/1a3da51078a04d8e9ae6528fa8b05793/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-29 03:14:40.032561 | 2025-11-29 03:14:40.032689 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-29 03:14:41.999140 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-29 03:14:41.999446 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/1a3da51078a04d8e9ae6528fa8b05793/work/1a3da51078a04d8e9ae6528fa8b05793_id_rsa 2025-11-29 03:14:41.999491 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/1a3da51078a04d8e9ae6528fa8b05793/work/1a3da51078a04d8e9ae6528fa8b05793_id_rsa.pub 2025-11-29 03:14:41.999519 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-29 03:14:41.999545 | debian-bookworm -> localhost | SHA256:w7hLzhfEFLWuvMUdpPzlP8SbwtZyG5BHbYo6as5+sdY zuul-build-sshkey 2025-11-29 03:14:41.999568 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-29 03:14:42.000080 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-29 03:14:42.000783 | debian-bookworm -> localhost | | .o. | 2025-11-29 03:14:42.002645 | debian-bookworm -> localhost | | . . .| 2025-11-29 03:14:42.002710 | debian-bookworm -> localhost | | o . . .o| 2025-11-29 03:14:42.003177 | debian-bookworm -> localhost | | ooo o .oo | 2025-11-29 03:14:42.003433 | debian-bookworm -> localhost | | ..S + oo+. | 2025-11-29 03:14:42.003470 | debian-bookworm -> localhost | | o.+.+ +oo | 2025-11-29 03:14:42.003796 | debian-bookworm -> localhost | | o o.=++ +.o| 2025-11-29 03:14:42.005236 | debian-bookworm -> localhost | | + oo++.E= B.| 2025-11-29 03:14:42.005595 | debian-bookworm -> localhost | | +=*o . +.+| 2025-11-29 03:14:42.005821 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-29 03:14:42.005913 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.303225 2025-11-29 03:14:42.019763 | 2025-11-29 03:14:42.019886 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-29 03:14:42.052565 | debian-bookworm | ok 2025-11-29 03:14:42.064221 | debian-bookworm | included: /var/lib/zuul/builds/1a3da51078a04d8e9ae6528fa8b05793/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-29 03:14:42.073867 | 2025-11-29 03:14:42.073982 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-29 03:14:42.098082 | debian-bookworm | skipping: Conditional result was False 2025-11-29 03:14:42.104890 | 2025-11-29 03:14:42.105019 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-29 03:14:42.767179 | debian-bookworm | changed 2025-11-29 03:14:42.778234 | 2025-11-29 03:14:42.778497 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-29 03:14:43.050453 | debian-bookworm | ok 2025-11-29 03:14:43.060789 | 2025-11-29 03:14:43.060943 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-29 03:14:43.759599 | debian-bookworm | changed 2025-11-29 03:14:43.768802 | 2025-11-29 03:14:43.768945 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-29 03:14:44.440310 | debian-bookworm | changed 2025-11-29 03:14:44.447390 | 2025-11-29 03:14:44.447604 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-29 03:14:44.468537 | debian-bookworm | skipping: Conditional result was False 2025-11-29 03:14:44.482513 | 2025-11-29 03:14:44.482689 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-29 03:14:44.984064 | debian-bookworm -> localhost | changed 2025-11-29 03:14:44.996325 | 2025-11-29 03:14:44.996475 | TASK [add-build-sshkey : Add back temp key] 2025-11-29 03:14:45.443584 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/1a3da51078a04d8e9ae6528fa8b05793/work/1a3da51078a04d8e9ae6528fa8b05793_id_rsa (zuul-build-sshkey) 2025-11-29 03:14:45.443891 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.022200 2025-11-29 03:14:45.453806 | 2025-11-29 03:14:45.453948 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-29 03:14:45.850217 | debian-bookworm | ok 2025-11-29 03:14:45.855930 | 2025-11-29 03:14:45.856053 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-29 03:14:45.880520 | debian-bookworm | skipping: Conditional result was False 2025-11-29 03:14:45.891810 | 2025-11-29 03:14:45.891953 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-29 03:14:46.338352 | debian-bookworm | ok 2025-11-29 03:14:46.350768 | 2025-11-29 03:14:46.350943 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-29 03:14:46.380550 | debian-bookworm | ok 2025-11-29 03:14:46.385739 | 2025-11-29 03:14:46.385852 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-29 03:14:46.827353 | debian-bookworm -> localhost | ok 2025-11-29 03:14:46.834073 | 2025-11-29 03:14:46.834200 | TASK [validate-host : Collect information about the host] 2025-11-29 03:14:47.951791 | debian-bookworm | ok 2025-11-29 03:14:47.967795 | 2025-11-29 03:14:47.968000 | TASK [validate-host : Sanitize hostname] 2025-11-29 03:14:48.079461 | debian-bookworm | ok 2025-11-29 03:14:48.136797 | 2025-11-29 03:14:48.136935 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-29 03:14:48.803211 | debian-bookworm -> localhost | changed 2025-11-29 03:14:48.817632 | 2025-11-29 03:14:48.817808 | TASK [validate-host : Collect information about zuul worker] 2025-11-29 03:14:49.238889 | debian-bookworm | ok 2025-11-29 03:14:49.245905 | 2025-11-29 03:14:49.246031 | TASK [validate-host : Write out all zuul information for each host] 2025-11-29 03:14:49.830689 | debian-bookworm -> localhost | changed 2025-11-29 03:14:49.841911 | 2025-11-29 03:14:49.842047 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-29 03:14:50.120590 | debian-bookworm | ok 2025-11-29 03:14:50.131689 | 2025-11-29 03:14:50.131856 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-29 03:14:50.975844 | debian-bookworm | changed: 2025-11-29 03:14:50.976051 | debian-bookworm | cd+++++++++ src/ 2025-11-29 03:14:50.976228 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-29 03:14:50.976264 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-29 03:14:50.976288 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/ 2025-11-29 03:14:50.976311 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007263 2025-11-29 03:15:17.984383 | 2025-11-29 03:15:17.984501 | TASK [upload-logs : Upload logs to log server] 2025-11-29 03:15:18.579564 | localhost | Output suppressed because no_log was given 2025-11-29 03:15:18.581508 | 2025-11-29 03:15:18.581624 | LOOP [upload-logs : Compress console log and json output] 2025-11-29 03:15:18.634885 | localhost | skipping: Conditional result was False 2025-11-29 03:15:18.643508 | localhost | skipping: Conditional result was False 2025-11-29 03:15:18.651059 | 2025-11-29 03:15:18.651211 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-29 03:15:18.700720 | localhost | skipping: Conditional result was False 2025-11-29 03:15:18.701031 | 2025-11-29 03:15:18.708430 | localhost | skipping: Conditional result was False 2025-11-29 03:15:18.717911 | 2025-11-29 03:15:18.718045 | LOOP [upload-logs : Upload console log and json output]