2026-01-01 03:16:10.232459 | Job console starting 2026-01-01 03:16:10.248037 | Updating git repos 2026-01-01 03:16:10.305947 | Cloning repos into workspace 2026-01-01 03:16:10.386821 | Restoring repo states 2026-01-01 03:16:10.400812 | Merging changes 2026-01-01 03:16:10.400984 | Checking out repos 2026-01-01 03:16:10.509701 | Preparing playbooks 2026-01-01 03:16:12.499821 | Running Ansible setup 2026-01-01 03:16:19.984145 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-01 03:16:21.390182 | 2026-01-01 03:16:21.390391 | PLAY [Base pre] 2026-01-01 03:16:21.442483 | 2026-01-01 03:16:21.442689 | TASK [Setup log path fact] 2026-01-01 03:16:21.485702 | debian-bookworm | ok 2026-01-01 03:16:21.522777 | 2026-01-01 03:16:21.522972 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-01 03:16:21.581035 | debian-bookworm | ok 2026-01-01 03:16:21.612635 | 2026-01-01 03:16:21.612782 | TASK [emit-job-header : Print job information] 2026-01-01 03:16:21.701266 | # Job Information 2026-01-01 03:16:21.701506 | Ansible Version: 2.16.14 2026-01-01 03:16:21.701551 | Job: python-black 2026-01-01 03:16:21.701592 | Pipeline: periodic-daily 2026-01-01 03:16:21.701622 | Executor: 521e9411259a 2026-01-01 03:16:21.701649 | Triggered by: https://github.com/osism/cinder-driver-dm-clone 2026-01-01 03:16:21.701677 | Event ID: 7b8d9c66303d4e77bc8100455b7a3f7d 2026-01-01 03:16:21.708453 | 2026-01-01 03:16:21.708593 | LOOP [emit-job-header : Print node information] 2026-01-01 03:16:21.829972 | debian-bookworm | ok: 2026-01-01 03:16:21.830168 | debian-bookworm | # Node Information 2026-01-01 03:16:21.830209 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-01 03:16:21.830236 | debian-bookworm | Hostname: debian 2026-01-01 03:16:21.830263 | debian-bookworm | Username: zuul 2026-01-01 03:16:21.830303 | debian-bookworm | Distro: Debian 12.12 2026-01-01 03:16:21.830328 | debian-bookworm | Provider: regiocloud-a 2026-01-01 03:16:21.830349 | debian-bookworm | Region: 2026-01-01 03:16:21.830371 | debian-bookworm | Label: debian-bookworm 2026-01-01 03:16:21.830391 | debian-bookworm | Product Name: OpenStack Nova 2026-01-01 03:16:21.830411 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec7:f8cc 2026-01-01 03:16:21.848160 | 2026-01-01 03:16:21.848340 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-01 03:16:23.051766 | debian-bookworm -> localhost | changed 2026-01-01 03:16:23.063592 | 2026-01-01 03:16:23.063737 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-01 03:16:25.320987 | debian-bookworm -> localhost | changed 2026-01-01 03:16:25.364218 | 2026-01-01 03:16:25.364485 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-01 03:16:25.927840 | debian-bookworm -> localhost | ok 2026-01-01 03:16:25.938389 | 2026-01-01 03:16:25.938558 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-01 03:16:25.979748 | debian-bookworm | ok 2026-01-01 03:16:26.006205 | debian-bookworm | included: /var/lib/zuul/builds/845cd74115df41e9b8a9c76b34b4cfcd/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-01 03:16:26.016577 | 2026-01-01 03:16:26.016712 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-01 03:16:27.238498 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-01 03:16:27.238735 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/845cd74115df41e9b8a9c76b34b4cfcd/work/845cd74115df41e9b8a9c76b34b4cfcd_id_rsa 2026-01-01 03:16:27.238775 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/845cd74115df41e9b8a9c76b34b4cfcd/work/845cd74115df41e9b8a9c76b34b4cfcd_id_rsa.pub 2026-01-01 03:16:27.238802 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-01 03:16:27.238828 | debian-bookworm -> localhost | SHA256:IAgN8xgrX7DcXnHUI+0y38BZH71gVa6d29zFGECn5Yc zuul-build-sshkey 2026-01-01 03:16:27.238871 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-01 03:16:27.238903 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-01 03:16:27.238925 | debian-bookworm -> localhost | |=o. ..oo .o +oo| 2026-01-01 03:16:27.238946 | debian-bookworm -> localhost | | O.= o. + .O.o.| 2026-01-01 03:16:27.238966 | debian-bookworm -> localhost | |+ = + o + +o.E.+| 2026-01-01 03:16:27.238986 | debian-bookworm -> localhost | |.. o o .o = .O.| 2026-01-01 03:16:27.239006 | debian-bookworm -> localhost | | . . S+ o o.+| 2026-01-01 03:16:27.239036 | debian-bookworm -> localhost | | . . .=| 2026-01-01 03:16:27.239058 | debian-bookworm -> localhost | | .+| 2026-01-01 03:16:27.239080 | debian-bookworm -> localhost | | | 2026-01-01 03:16:27.239102 | debian-bookworm -> localhost | | | 2026-01-01 03:16:27.239122 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-01 03:16:27.239176 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.596830 2026-01-01 03:16:27.246365 | 2026-01-01 03:16:27.246495 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-01 03:16:27.270484 | debian-bookworm | ok 2026-01-01 03:16:27.280674 | debian-bookworm | included: /var/lib/zuul/builds/845cd74115df41e9b8a9c76b34b4cfcd/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-01 03:16:27.290487 | 2026-01-01 03:16:27.290617 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-01 03:16:27.315190 | debian-bookworm | skipping: Conditional result was False 2026-01-01 03:16:27.323449 | 2026-01-01 03:16:27.323580 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-01 03:16:28.079472 | debian-bookworm | changed 2026-01-01 03:16:28.086520 | 2026-01-01 03:16:28.086751 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-01 03:16:28.380289 | debian-bookworm | ok 2026-01-01 03:16:28.387681 | 2026-01-01 03:16:28.387858 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-01 03:16:29.133802 | debian-bookworm | changed 2026-01-01 03:16:29.141900 | 2026-01-01 03:16:29.142067 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-01 03:16:29.842164 | debian-bookworm | changed 2026-01-01 03:16:29.851221 | 2026-01-01 03:16:29.851423 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-01 03:16:29.886077 | debian-bookworm | skipping: Conditional result was False 2026-01-01 03:16:29.892791 | 2026-01-01 03:16:29.892930 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-01 03:16:30.435501 | debian-bookworm -> localhost | changed 2026-01-01 03:16:30.450711 | 2026-01-01 03:16:30.450875 | TASK [add-build-sshkey : Add back temp key] 2026-01-01 03:16:30.836315 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/845cd74115df41e9b8a9c76b34b4cfcd/work/845cd74115df41e9b8a9c76b34b4cfcd_id_rsa (zuul-build-sshkey) 2026-01-01 03:16:30.836812 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013004 2026-01-01 03:16:30.860463 | 2026-01-01 03:16:30.860698 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-01 03:16:31.319510 | debian-bookworm | ok 2026-01-01 03:16:31.326889 | 2026-01-01 03:16:31.327029 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-01 03:16:31.402454 | debian-bookworm | skipping: Conditional result was False 2026-01-01 03:16:31.422679 | 2026-01-01 03:16:31.422826 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-01 03:16:31.971185 | debian-bookworm | ok 2026-01-01 03:16:31.997896 | 2026-01-01 03:16:31.998095 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-01 03:16:32.044519 | debian-bookworm | ok 2026-01-01 03:16:32.050556 | 2026-01-01 03:16:32.050687 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-01 03:16:32.432081 | debian-bookworm -> localhost | ok 2026-01-01 03:16:32.445763 | 2026-01-01 03:16:32.445903 | TASK [validate-host : Collect information about the host] 2026-01-01 03:16:33.977905 | debian-bookworm | ok 2026-01-01 03:16:34.019975 | 2026-01-01 03:16:34.021041 | TASK [validate-host : Sanitize hostname] 2026-01-01 03:16:34.311862 | debian-bookworm | ok 2026-01-01 03:16:34.426768 | 2026-01-01 03:16:34.426943 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-01 03:16:35.939383 | debian-bookworm -> localhost | changed 2026-01-01 03:16:35.945870 | 2026-01-01 03:16:35.946006 | TASK [validate-host : Collect information about zuul worker] 2026-01-01 03:16:36.495234 | debian-bookworm | ok 2026-01-01 03:16:36.503619 | 2026-01-01 03:16:36.503771 | TASK [validate-host : Write out all zuul information for each host] 2026-01-01 03:16:37.144908 | debian-bookworm -> localhost | changed 2026-01-01 03:16:37.156555 | 2026-01-01 03:16:37.156702 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-01 03:16:37.452509 | debian-bookworm | ok 2026-01-01 03:16:37.460517 | 2026-01-01 03:16:37.460645 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-01 03:16:38.385493 | debian-bookworm | changed: 2026-01-01 03:16:38.385701 | debian-bookworm | cd+++++++++ src/ 2026-01-01 03:16:38.385736 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-01 03:16:38.385760 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-01 03:16:38.385781 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/ 2026-01-01 03:16:38.385802 | debian-bookworm | localhost | ok: Runtime: 0:00:00.013178 2026-01-01 03:17:08.050938 | 2026-01-01 03:17:08.051071 | TASK [upload-logs : Upload logs to log server] 2026-01-01 03:17:09.296811 | localhost | Output suppressed because no_log was given 2026-01-01 03:17:09.298746 | 2026-01-01 03:17:09.298889 | LOOP [upload-logs : Compress console log and json output] 2026-01-01 03:17:09.440441 | localhost | skipping: Conditional result was False 2026-01-01 03:17:09.454045 | localhost | skipping: Conditional result was False 2026-01-01 03:17:09.459792 | 2026-01-01 03:17:09.459925 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-01 03:17:09.594558 | localhost | skipping: Conditional result was False 2026-01-01 03:17:09.594901 | 2026-01-01 03:17:09.609855 | localhost | skipping: Conditional result was False 2026-01-01 03:17:09.620220 | 2026-01-01 03:17:09.620412 | LOOP [upload-logs : Upload console log and json output]