2025-07-21 03:01:23.897319 | Job console starting 2025-07-21 03:01:23.906664 | Updating git repos 2025-07-21 03:01:24.239242 | Cloning repos into workspace 2025-07-21 03:01:24.314197 | Restoring repo states 2025-07-21 03:01:24.317834 | Merging changes 2025-07-21 03:01:24.317847 | Checking out repos 2025-07-21 03:01:24.348214 | Preparing playbooks 2025-07-21 03:01:25.654998 | Running Ansible setup 2025-07-21 03:01:31.743013 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-07-21 03:01:33.439159 | 2025-07-21 03:01:33.439646 | PLAY [Base pre] 2025-07-21 03:01:33.469810 | 2025-07-21 03:01:33.469920 | TASK [Setup log path fact] 2025-07-21 03:01:33.497310 | debian-bookworm | ok 2025-07-21 03:01:33.515167 | 2025-07-21 03:01:33.515327 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-07-21 03:01:33.587346 | debian-bookworm | ok 2025-07-21 03:01:33.601880 | 2025-07-21 03:01:33.601983 | TASK [emit-job-header : Print job information] 2025-07-21 03:01:33.720412 | # Job Information 2025-07-21 03:01:33.720553 | Ansible Version: 2.16.14 2025-07-21 03:01:33.720581 | Job: python-black 2025-07-21 03:01:33.720607 | Pipeline: periodic-daily 2025-07-21 03:01:33.720626 | Executor: 521e9411259a 2025-07-21 03:01:33.720643 | Triggered by: https://github.com/osism/cinder-driver-dm-clone 2025-07-21 03:01:33.720685 | Event ID: 69a169b3297248559ba628e7c90db915 2025-07-21 03:01:33.724678 | 2025-07-21 03:01:33.724761 | LOOP [emit-job-header : Print node information] 2025-07-21 03:01:33.894324 | debian-bookworm | ok: 2025-07-21 03:01:33.894462 | debian-bookworm | # Node Information 2025-07-21 03:01:33.894491 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-07-21 03:01:33.894511 | debian-bookworm | Hostname: debian 2025-07-21 03:01:33.894529 | debian-bookworm | Username: zuul 2025-07-21 03:01:33.894545 | debian-bookworm | Distro: Debian 12.11 2025-07-21 03:01:33.894565 | debian-bookworm | Provider: regiocloud-a 2025-07-21 03:01:33.894582 | debian-bookworm | Region: 2025-07-21 03:01:33.894600 | debian-bookworm | Label: debian-bookworm 2025-07-21 03:01:33.894616 | debian-bookworm | Product Name: OpenStack Nova 2025-07-21 03:01:33.894632 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feff:f417 2025-07-21 03:01:33.904423 | 2025-07-21 03:01:33.904519 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-07-21 03:01:35.253121 | debian-bookworm -> localhost | changed 2025-07-21 03:01:35.259050 | 2025-07-21 03:01:35.259149 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-07-21 03:01:37.058042 | debian-bookworm -> localhost | changed 2025-07-21 03:01:37.067014 | 2025-07-21 03:01:37.067114 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-07-21 03:01:37.788130 | debian-bookworm -> localhost | ok 2025-07-21 03:01:37.792968 | 2025-07-21 03:01:37.793054 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-07-21 03:01:37.829869 | debian-bookworm | ok 2025-07-21 03:01:37.848284 | debian-bookworm | included: /var/lib/zuul/builds/53702ed882b042fa99a404c8b461edd5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-07-21 03:01:37.854214 | 2025-07-21 03:01:37.854302 | TASK [add-build-sshkey : Create Temp SSH key] 2025-07-21 03:01:40.195262 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-07-21 03:01:40.195515 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/53702ed882b042fa99a404c8b461edd5/work/53702ed882b042fa99a404c8b461edd5_id_rsa 2025-07-21 03:01:40.195551 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/53702ed882b042fa99a404c8b461edd5/work/53702ed882b042fa99a404c8b461edd5_id_rsa.pub 2025-07-21 03:01:40.195573 | debian-bookworm -> localhost | The key fingerprint is: 2025-07-21 03:01:40.195593 | debian-bookworm -> localhost | SHA256:kz9t1prIJPqoVq/EKxSj/81ZAVWCX/eznrsR/QL4jNc zuul-build-sshkey 2025-07-21 03:01:40.195611 | debian-bookworm -> localhost | The key's randomart image is: 2025-07-21 03:01:40.195637 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-07-21 03:01:40.195679 | debian-bookworm -> localhost | | .o.. | 2025-07-21 03:01:40.195700 | debian-bookworm -> localhost | | .. .. . | 2025-07-21 03:01:40.195717 | debian-bookworm -> localhost | | .. . . . | 2025-07-21 03:01:40.195734 | debian-bookworm -> localhost | | o o.. .o| 2025-07-21 03:01:40.195750 | debian-bookworm -> localhost | | . o S o . .+| 2025-07-21 03:01:40.195772 | debian-bookworm -> localhost | | . ... o * + .o| 2025-07-21 03:01:40.195788 | debian-bookworm -> localhost | | o .o.. * B E.o| 2025-07-21 03:01:40.195803 | debian-bookworm -> localhost | | +. *.* * o +.| 2025-07-21 03:01:40.195820 | debian-bookworm -> localhost | | ..+*o= o o oo| 2025-07-21 03:01:40.195836 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-07-21 03:01:40.195884 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.471052 2025-07-21 03:01:40.202630 | 2025-07-21 03:01:40.202725 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-07-21 03:01:40.269741 | debian-bookworm | ok 2025-07-21 03:01:40.310701 | debian-bookworm | included: /var/lib/zuul/builds/53702ed882b042fa99a404c8b461edd5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-07-21 03:01:40.359088 | 2025-07-21 03:01:40.359188 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-07-21 03:01:40.407992 | debian-bookworm | skipping: Conditional result was False 2025-07-21 03:01:40.412967 | 2025-07-21 03:01:40.413051 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-07-21 03:01:41.090500 | debian-bookworm | changed 2025-07-21 03:01:41.095111 | 2025-07-21 03:01:41.095187 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-07-21 03:01:41.413810 | debian-bookworm | ok 2025-07-21 03:01:41.432761 | 2025-07-21 03:01:41.432858 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-07-21 03:01:42.264018 | debian-bookworm | changed 2025-07-21 03:01:42.277593 | 2025-07-21 03:01:42.280357 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-07-21 03:01:43.227460 | debian-bookworm | changed 2025-07-21 03:01:43.238638 | 2025-07-21 03:01:43.238736 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-07-21 03:01:43.255941 | debian-bookworm | skipping: Conditional result was False 2025-07-21 03:01:43.270487 | 2025-07-21 03:01:43.270577 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-07-21 03:01:44.385458 | debian-bookworm -> localhost | changed 2025-07-21 03:01:44.404757 | 2025-07-21 03:01:44.404854 | TASK [add-build-sshkey : Add back temp key] 2025-07-21 03:01:45.091575 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/53702ed882b042fa99a404c8b461edd5/work/53702ed882b042fa99a404c8b461edd5_id_rsa (zuul-build-sshkey) 2025-07-21 03:01:45.091812 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.042127 2025-07-21 03:01:45.098397 | 2025-07-21 03:01:45.098492 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-07-21 03:01:45.585822 | debian-bookworm | ok 2025-07-21 03:01:45.589877 | 2025-07-21 03:01:45.589957 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-07-21 03:01:45.633834 | debian-bookworm | skipping: Conditional result was False 2025-07-21 03:01:45.647287 | 2025-07-21 03:01:45.647382 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-07-21 03:01:46.213744 | debian-bookworm | ok 2025-07-21 03:01:46.246434 | 2025-07-21 03:01:46.246539 | TASK [validate-host : Define zuul_info_dir fact] 2025-07-21 03:01:46.323223 | debian-bookworm | ok 2025-07-21 03:01:46.328216 | 2025-07-21 03:01:46.328303 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-07-21 03:01:47.083885 | debian-bookworm -> localhost | ok 2025-07-21 03:01:47.089005 | 2025-07-21 03:01:47.089085 | TASK [validate-host : Collect information about the host] 2025-07-21 03:01:48.795599 | debian-bookworm | ok 2025-07-21 03:01:48.812883 | 2025-07-21 03:01:48.812976 | TASK [validate-host : Sanitize hostname] 2025-07-21 03:01:49.058630 | debian-bookworm | ok 2025-07-21 03:01:49.138108 | 2025-07-21 03:01:49.138210 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-07-21 03:01:50.393112 | debian-bookworm -> localhost | changed 2025-07-21 03:01:50.398692 | 2025-07-21 03:01:50.398793 | TASK [validate-host : Collect information about zuul worker] 2025-07-21 03:01:50.930825 | debian-bookworm | ok 2025-07-21 03:01:50.934729 | 2025-07-21 03:01:50.934813 | TASK [validate-host : Write out all zuul information for each host] 2025-07-21 03:01:52.156953 | debian-bookworm -> localhost | changed 2025-07-21 03:01:52.164888 | 2025-07-21 03:01:52.164974 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-07-21 03:01:52.465563 | debian-bookworm | ok 2025-07-21 03:01:52.470350 | 2025-07-21 03:01:52.470436 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-07-21 03:01:53.452805 | debian-bookworm | changed: 2025-07-21 03:01:53.453099 | debian-bookworm | cd+++++++++ src/ 2025-07-21 03:01:53.453139 | debian-bookworm | cd+++++++++ src/github.com/ 2025-07-21 03:01:53.453160 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-07-21 03:01:53.453178 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/ 2025-07-21 03:01:53.453195 | debian-bookworm | localhost | ok: Runtime: 0:00:00.059431 2025-07-21 03:02:25.614384 | 2025-07-21 03:02:25.614467 | TASK [upload-logs : Upload logs to log server] 2025-07-21 03:02:26.356014 | localhost | Output suppressed because no_log was given 2025-07-21 03:02:26.357416 | 2025-07-21 03:02:26.357493 | LOOP [upload-logs : Compress console log and json output] 2025-07-21 03:02:26.411575 | localhost | skipping: Conditional result was False 2025-07-21 03:02:26.417700 | localhost | skipping: Conditional result was False 2025-07-21 03:02:26.423860 | 2025-07-21 03:02:26.423950 | LOOP [upload-logs : Upload compressed console log and json output] 2025-07-21 03:02:26.459275 | localhost | skipping: Conditional result was False 2025-07-21 03:02:26.459479 | 2025-07-21 03:02:26.470123 | localhost | skipping: Conditional result was False 2025-07-21 03:02:26.478411 | 2025-07-21 03:02:26.478503 | LOOP [upload-logs : Upload console log and json output]