2025-10-18 03:01:17.751056 | Job console starting 2025-10-18 03:01:17.831393 | Updating git repos 2025-10-18 03:01:18.258236 | Cloning repos into workspace 2025-10-18 03:01:18.334154 | Restoring repo states 2025-10-18 03:01:18.365324 | Merging changes 2025-10-18 03:01:18.365343 | Checking out repos 2025-10-18 03:01:18.506780 | Preparing playbooks 2025-10-18 03:01:20.200606 | Running Ansible setup 2025-10-18 03:01:26.729532 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-18 03:01:27.815341 | 2025-10-18 03:01:27.815484 | PLAY [Base pre] 2025-10-18 03:01:27.853324 | 2025-10-18 03:01:27.863146 | TASK [Setup log path fact] 2025-10-18 03:01:27.926919 | debian-bookworm | ok 2025-10-18 03:01:27.955791 | 2025-10-18 03:01:27.955984 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-18 03:01:28.016832 | debian-bookworm | ok 2025-10-18 03:01:28.032624 | 2025-10-18 03:01:28.032720 | TASK [emit-job-header : Print job information] 2025-10-18 03:01:28.094284 | # Job Information 2025-10-18 03:01:28.094434 | Ansible Version: 2.16.14 2025-10-18 03:01:28.094464 | Job: python-black 2025-10-18 03:01:28.094491 | Pipeline: periodic-daily 2025-10-18 03:01:28.094510 | Executor: 521e9411259a 2025-10-18 03:01:28.094527 | Triggered by: https://github.com/osism/cinder-driver-dm-clone 2025-10-18 03:01:28.094546 | Event ID: fe787ddb5ec64f3788135043004cb2ae 2025-10-18 03:01:28.099717 | 2025-10-18 03:01:28.099806 | LOOP [emit-job-header : Print node information] 2025-10-18 03:01:28.365645 | debian-bookworm | ok: 2025-10-18 03:01:28.365876 | debian-bookworm | # Node Information 2025-10-18 03:01:28.365919 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-18 03:01:28.365942 | debian-bookworm | Hostname: debian 2025-10-18 03:01:28.365961 | debian-bookworm | Username: zuul 2025-10-18 03:01:28.365979 | debian-bookworm | Distro: Debian 12.12 2025-10-18 03:01:28.365999 | debian-bookworm | Provider: regiocloud-a 2025-10-18 03:01:28.366017 | debian-bookworm | Region: 2025-10-18 03:01:28.366035 | debian-bookworm | Label: debian-bookworm 2025-10-18 03:01:28.366052 | debian-bookworm | Product Name: OpenStack Nova 2025-10-18 03:01:28.366068 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe62:4412 2025-10-18 03:01:28.382988 | 2025-10-18 03:01:28.383081 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-18 03:01:29.123968 | debian-bookworm -> localhost | changed 2025-10-18 03:01:29.129718 | 2025-10-18 03:01:29.129806 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-18 03:01:31.132043 | debian-bookworm -> localhost | changed 2025-10-18 03:01:31.143091 | 2025-10-18 03:01:31.143198 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-18 03:01:31.863056 | debian-bookworm -> localhost | ok 2025-10-18 03:01:31.868056 | 2025-10-18 03:01:31.868141 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-18 03:01:31.904802 | debian-bookworm | ok 2025-10-18 03:01:31.935926 | debian-bookworm | included: /var/lib/zuul/builds/a65c9862f4e74385b439d2aa8565cdbe/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-18 03:01:31.946381 | 2025-10-18 03:01:31.946468 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-18 03:01:33.977181 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-18 03:01:33.977351 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/a65c9862f4e74385b439d2aa8565cdbe/work/a65c9862f4e74385b439d2aa8565cdbe_id_rsa 2025-10-18 03:01:33.977395 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/a65c9862f4e74385b439d2aa8565cdbe/work/a65c9862f4e74385b439d2aa8565cdbe_id_rsa.pub 2025-10-18 03:01:33.977416 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-18 03:01:33.977437 | debian-bookworm -> localhost | SHA256:X/fM7r/V1AxnlVE1Qiv54ZxD6IOX3RYNFAK6N+3rI9Y zuul-build-sshkey 2025-10-18 03:01:33.977456 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-18 03:01:33.977482 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-18 03:01:33.977500 | debian-bookworm -> localhost | | ..o+++O| 2025-10-18 03:01:33.977517 | debian-bookworm -> localhost | | . o.oo+| 2025-10-18 03:01:33.977534 | debian-bookworm -> localhost | | . + +..+| 2025-10-18 03:01:33.977551 | debian-bookworm -> localhost | | .o.O +=o| 2025-10-18 03:01:33.977567 | debian-bookworm -> localhost | | S.o=oB.o+| 2025-10-18 03:01:33.977587 | debian-bookworm -> localhost | | o.+..o=.| 2025-10-18 03:01:33.977604 | debian-bookworm -> localhost | | ... *| 2025-10-18 03:01:33.977620 | debian-bookworm -> localhost | | o E. ..| 2025-10-18 03:01:33.977638 | debian-bookworm -> localhost | | . oo. o*| 2025-10-18 03:01:33.977655 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-18 03:01:33.977697 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.903937 2025-10-18 03:01:33.982876 | 2025-10-18 03:01:33.982954 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-18 03:01:34.029629 | debian-bookworm | ok 2025-10-18 03:01:34.038181 | debian-bookworm | included: /var/lib/zuul/builds/a65c9862f4e74385b439d2aa8565cdbe/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-18 03:01:34.065716 | 2025-10-18 03:01:34.065815 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-18 03:01:34.102556 | debian-bookworm | skipping: Conditional result was False 2025-10-18 03:01:34.109883 | 2025-10-18 03:01:34.109986 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-18 03:01:35.008173 | debian-bookworm | changed 2025-10-18 03:01:35.012615 | 2025-10-18 03:01:35.012686 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-18 03:01:35.312413 | debian-bookworm | ok 2025-10-18 03:01:35.319528 | 2025-10-18 03:01:35.319610 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-18 03:01:36.142780 | debian-bookworm | changed 2025-10-18 03:01:36.152025 | 2025-10-18 03:01:36.152109 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-18 03:01:36.951459 | debian-bookworm | changed 2025-10-18 03:01:36.956102 | 2025-10-18 03:01:36.956233 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-18 03:01:36.979098 | debian-bookworm | skipping: Conditional result was False 2025-10-18 03:01:36.984527 | 2025-10-18 03:01:36.984605 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-18 03:01:37.415459 | debian-bookworm -> localhost | changed 2025-10-18 03:01:37.424648 | 2025-10-18 03:01:37.424740 | TASK [add-build-sshkey : Add back temp key] 2025-10-18 03:01:37.928136 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/a65c9862f4e74385b439d2aa8565cdbe/work/a65c9862f4e74385b439d2aa8565cdbe_id_rsa (zuul-build-sshkey) 2025-10-18 03:01:37.928327 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.020511 2025-10-18 03:01:37.934663 | 2025-10-18 03:01:37.934744 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-18 03:01:38.782052 | debian-bookworm | ok 2025-10-18 03:01:38.787048 | 2025-10-18 03:01:38.787130 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-18 03:01:38.890630 | debian-bookworm | skipping: Conditional result was False 2025-10-18 03:01:38.901669 | 2025-10-18 03:01:38.901769 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-18 03:01:39.848239 | debian-bookworm | ok 2025-10-18 03:01:39.876311 | 2025-10-18 03:01:39.878503 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-18 03:01:39.947665 | debian-bookworm | ok 2025-10-18 03:01:39.958152 | 2025-10-18 03:01:39.958253 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-18 03:01:40.773046 | debian-bookworm -> localhost | ok 2025-10-18 03:01:40.783453 | 2025-10-18 03:01:40.783626 | TASK [validate-host : Collect information about the host] 2025-10-18 03:01:42.338558 | debian-bookworm | ok 2025-10-18 03:01:42.354064 | 2025-10-18 03:01:42.354156 | TASK [validate-host : Sanitize hostname] 2025-10-18 03:01:42.466159 | debian-bookworm | ok 2025-10-18 03:01:42.583755 | 2025-10-18 03:01:42.583848 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-18 03:01:43.782079 | debian-bookworm -> localhost | changed 2025-10-18 03:01:43.786574 | 2025-10-18 03:01:43.786652 | TASK [validate-host : Collect information about zuul worker] 2025-10-18 03:01:44.729538 | debian-bookworm | ok 2025-10-18 03:01:44.734374 | 2025-10-18 03:01:44.734469 | TASK [validate-host : Write out all zuul information for each host] 2025-10-18 03:01:46.508136 | debian-bookworm -> localhost | changed 2025-10-18 03:01:46.515856 | 2025-10-18 03:01:46.515944 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-18 03:01:46.844690 | debian-bookworm | ok 2025-10-18 03:01:46.849025 | 2025-10-18 03:01:46.849104 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-18 03:01:48.657077 | debian-bookworm | changed: 2025-10-18 03:01:48.657227 | debian-bookworm | cd+++++++++ src/ 2025-10-18 03:01:48.657255 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-18 03:01:48.657275 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-18 03:01:48.657293 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/ 2025-10-18 03:01:48.657309 | debian-bookworm | localhost | ok: Runtime: 0:00:00.017526 2025-10-18 03:02:21.740674 | 2025-10-18 03:02:21.740756 | TASK [upload-logs : Upload logs to log server] 2025-10-18 03:02:22.979001 | localhost | Output suppressed because no_log was given 2025-10-18 03:02:22.980398 | 2025-10-18 03:02:22.980471 | LOOP [upload-logs : Compress console log and json output] 2025-10-18 03:02:23.055115 | localhost | skipping: Conditional result was False 2025-10-18 03:02:23.103997 | localhost | skipping: Conditional result was False 2025-10-18 03:02:23.107136 | 2025-10-18 03:02:23.107226 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-18 03:02:23.330222 | localhost | skipping: Conditional result was False 2025-10-18 03:02:23.330440 | 2025-10-18 03:02:23.350506 | localhost | skipping: Conditional result was False 2025-10-18 03:02:23.353221 | 2025-10-18 03:02:23.353314 | LOOP [upload-logs : Upload console log and json output]