2026-06-20 03:17:26.936909 | Job console starting 2026-06-20 03:17:26.960769 | Updating git repos 2026-06-20 03:17:27.006391 | Cloning repos into workspace 2026-06-20 03:17:27.078530 | Restoring repo states 2026-06-20 03:17:27.095921 | Merging changes 2026-06-20 03:17:27.095936 | Checking out repos 2026-06-20 03:17:27.146117 | Preparing playbooks 2026-06-20 03:17:28.937554 | Running Ansible setup 2026-06-20 03:17:34.418976 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-20 03:17:35.373446 | 2026-06-20 03:17:35.373625 | PLAY [Base pre] 2026-06-20 03:17:35.396179 | 2026-06-20 03:17:35.396348 | TASK [Setup log path fact] 2026-06-20 03:17:35.417299 | debian-bookworm | ok 2026-06-20 03:17:35.443102 | 2026-06-20 03:17:35.443273 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-20 03:17:35.473940 | debian-bookworm | ok 2026-06-20 03:17:35.485688 | 2026-06-20 03:17:35.485831 | TASK [emit-job-header : Print job information] 2026-06-20 03:17:35.525710 | # Job Information 2026-06-20 03:17:35.525904 | Ansible Version: 2.16.14 2026-06-20 03:17:35.525941 | Job: python-black 2026-06-20 03:17:35.525986 | Pipeline: periodic-daily 2026-06-20 03:17:35.526010 | Executor: 521e9411259a 2026-06-20 03:17:35.526030 | Triggered by: https://github.com/osism/cinder-driver-dm-clone 2026-06-20 03:17:35.526053 | Event ID: 313b72e2127a4ba8a4a5adff6bff699f 2026-06-20 03:17:35.532026 | 2026-06-20 03:17:35.532162 | LOOP [emit-job-header : Print node information] 2026-06-20 03:17:35.655931 | debian-bookworm | ok: 2026-06-20 03:17:35.656268 | debian-bookworm | # Node Information 2026-06-20 03:17:35.656309 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-20 03:17:35.656337 | debian-bookworm | Hostname: debian 2026-06-20 03:17:35.656361 | debian-bookworm | Username: zuul 2026-06-20 03:17:35.656382 | debian-bookworm | Distro: Debian 12.14 2026-06-20 03:17:35.656407 | debian-bookworm | Provider: regiocloud-a 2026-06-20 03:17:35.656428 | debian-bookworm | Region: 2026-06-20 03:17:35.656452 | debian-bookworm | Label: debian-bookworm 2026-06-20 03:17:35.656473 | debian-bookworm | Product Name: OpenStack Nova 2026-06-20 03:17:35.656492 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe52:27a8 2026-06-20 03:17:35.671105 | 2026-06-20 03:17:35.671248 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-20 03:17:36.213978 | debian-bookworm -> localhost | changed 2026-06-20 03:17:36.221951 | 2026-06-20 03:17:36.222113 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-20 03:17:37.893614 | debian-bookworm -> localhost | changed 2026-06-20 03:17:37.905735 | 2026-06-20 03:17:37.905880 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-20 03:17:38.445951 | debian-bookworm -> localhost | ok 2026-06-20 03:17:38.460632 | 2026-06-20 03:17:38.461324 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-20 03:17:38.507516 | debian-bookworm | ok 2026-06-20 03:17:38.531488 | debian-bookworm | included: /var/lib/zuul/builds/61a685b893ce4653b136db59388b5b26/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-20 03:17:38.540219 | 2026-06-20 03:17:38.540345 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-20 03:17:40.057716 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-20 03:17:40.058940 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/61a685b893ce4653b136db59388b5b26/work/61a685b893ce4653b136db59388b5b26_id_rsa 2026-06-20 03:17:40.059004 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/61a685b893ce4653b136db59388b5b26/work/61a685b893ce4653b136db59388b5b26_id_rsa.pub 2026-06-20 03:17:40.059030 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-20 03:17:40.059052 | debian-bookworm -> localhost | SHA256:y+w5JNuF1YK/zod5jUlb3A2YN51htbtkHJGxkyEV/aA zuul-build-sshkey 2026-06-20 03:17:40.059071 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-20 03:17:40.059097 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-20 03:17:40.059116 | debian-bookworm -> localhost | | ..*B| 2026-06-20 03:17:40.059133 | debian-bookworm -> localhost | | o+B| 2026-06-20 03:17:40.059150 | debian-bookworm -> localhost | | . . +.O+| 2026-06-20 03:17:40.059166 | debian-bookworm -> localhost | | . o E =.*| 2026-06-20 03:17:40.059182 | debian-bookworm -> localhost | | S+ . o O.| 2026-06-20 03:17:40.059204 | debian-bookworm -> localhost | | .oo.o . = +| 2026-06-20 03:17:40.059221 | debian-bookworm -> localhost | | =+. = * . | 2026-06-20 03:17:40.059238 | debian-bookworm -> localhost | | ..oo+ * . | 2026-06-20 03:17:40.059256 | debian-bookworm -> localhost | | oooo | 2026-06-20 03:17:40.059272 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-20 03:17:40.059372 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.623298 2026-06-20 03:17:40.065254 | 2026-06-20 03:17:40.065342 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-20 03:17:40.093081 | debian-bookworm | ok 2026-06-20 03:17:40.103654 | debian-bookworm | included: /var/lib/zuul/builds/61a685b893ce4653b136db59388b5b26/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-20 03:17:40.111569 | 2026-06-20 03:17:40.111671 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-20 03:17:40.145875 | debian-bookworm | skipping: Conditional result was False 2026-06-20 03:17:40.163453 | 2026-06-20 03:17:40.163732 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-20 03:17:40.893264 | debian-bookworm | changed 2026-06-20 03:17:40.898633 | 2026-06-20 03:17:40.898744 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-20 03:17:41.216349 | debian-bookworm | ok 2026-06-20 03:17:41.221890 | 2026-06-20 03:17:41.221984 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-20 03:17:41.892963 | debian-bookworm | changed 2026-06-20 03:17:41.899760 | 2026-06-20 03:17:41.899861 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-20 03:17:42.563662 | debian-bookworm | changed 2026-06-20 03:17:42.572323 | 2026-06-20 03:17:42.572433 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-20 03:17:42.586542 | debian-bookworm | skipping: Conditional result was False 2026-06-20 03:17:42.603006 | 2026-06-20 03:17:42.603166 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-20 03:17:43.030048 | debian-bookworm -> localhost | changed 2026-06-20 03:17:43.043935 | 2026-06-20 03:17:43.044033 | TASK [add-build-sshkey : Add back temp key] 2026-06-20 03:17:43.342772 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/61a685b893ce4653b136db59388b5b26/work/61a685b893ce4653b136db59388b5b26_id_rsa (zuul-build-sshkey) 2026-06-20 03:17:43.343464 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010564 2026-06-20 03:17:43.359516 | 2026-06-20 03:17:43.359678 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-20 03:17:43.752578 | debian-bookworm | ok 2026-06-20 03:17:43.757657 | 2026-06-20 03:17:43.757747 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-20 03:17:43.780716 | debian-bookworm | skipping: Conditional result was False 2026-06-20 03:17:43.790754 | 2026-06-20 03:17:43.790859 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-20 03:17:44.231928 | debian-bookworm | ok 2026-06-20 03:17:44.242307 | 2026-06-20 03:17:44.242410 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-20 03:17:44.270787 | debian-bookworm | ok 2026-06-20 03:17:44.277447 | 2026-06-20 03:17:44.277545 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-20 03:17:44.575546 | debian-bookworm -> localhost | ok 2026-06-20 03:17:44.581775 | 2026-06-20 03:17:44.581866 | TASK [validate-host : Collect information about the host] 2026-06-20 03:17:45.776587 | debian-bookworm | ok 2026-06-20 03:17:45.796557 | 2026-06-20 03:17:45.796671 | TASK [validate-host : Sanitize hostname] 2026-06-20 03:17:45.920862 | debian-bookworm | ok 2026-06-20 03:17:45.924394 | 2026-06-20 03:17:45.924467 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-20 03:17:46.645507 | debian-bookworm -> localhost | changed 2026-06-20 03:17:46.650102 | 2026-06-20 03:17:46.650190 | TASK [validate-host : Collect information about zuul worker] 2026-06-20 03:17:47.089227 | debian-bookworm | ok 2026-06-20 03:17:47.092957 | 2026-06-20 03:17:47.093035 | TASK [validate-host : Write out all zuul information for each host] 2026-06-20 03:17:47.509475 | debian-bookworm -> localhost | changed 2026-06-20 03:17:47.517250 | 2026-06-20 03:17:47.517328 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-20 03:17:47.795626 | debian-bookworm | ok 2026-06-20 03:17:47.799957 | 2026-06-20 03:17:47.800031 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-20 03:17:48.574804 | debian-bookworm | changed: 2026-06-20 03:17:48.575238 | debian-bookworm | cd+++++++++ src/ 2026-06-20 03:17:48.575277 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-20 03:17:48.575302 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-20 03:17:48.575323 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/ 2026-06-20 03:17:48.575343 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/61a685b893ce4653b136db59388b5b26/work/logs" 2026-06-20 03:19:09.268264 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/61a685b893ce4653b136db59388b5b26/work/artifacts" 2026-06-20 03:19:09.822780 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/61a685b893ce4653b136db59388b5b26/work/docs" 2026-06-20 03:19:09.843593 | 2026-06-20 03:19:09.843779 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-20 03:19:10.751515 | debian-bookworm | changed: 2026-06-20 03:19:10.751843 | debian-bookworm | .d..t...... ./ 2026-06-20 03:19:10.751881 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-06-20 03:19:10.751906 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-06-20 03:19:10.751927 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-20 03:19:10.751949 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-20 03:19:10.751970 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-20 03:19:10.752025 | debian-bookworm | changed: All items complete 2026-06-20 03:19:10.752065 | 2026-06-20 03:19:11.364980 | debian-bookworm | changed: .d..t...... ./ 2026-06-20 03:19:11.983712 | debian-bookworm | changed: .d..t...... ./ 2026-06-20 03:19:12.010560 | 2026-06-20 03:19:12.010778 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-20 03:19:12.063730 | debian-bookworm | skipping: Conditional result was False 2026-06-20 03:19:12.068438 | debian-bookworm | skipping: Conditional result was False 2026-06-20 03:19:12.085510 | 2026-06-20 03:19:12.085643 | PLAY RECAP 2026-06-20 03:19:12.085702 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-06-20 03:19:12.085727 | 2026-06-20 03:19:12.267481 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-20 03:19:12.268404 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-20 03:19:13.068935 | 2026-06-20 03:19:13.069113 | PLAY [Base post] 2026-06-20 03:19:13.083710 | 2026-06-20 03:19:13.083871 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-20 03:19:13.711702 | debian-bookworm | changed 2026-06-20 03:19:13.734325 | 2026-06-20 03:19:13.734465 | PLAY RECAP 2026-06-20 03:19:13.734529 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-20 03:19:13.734593 | 2026-06-20 03:19:13.884286 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-20 03:19:13.886401 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-20 03:19:14.878083 | 2026-06-20 03:19:14.878279 | PLAY [Base post-logs] 2026-06-20 03:19:14.895565 | 2026-06-20 03:19:14.895742 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-20 03:19:15.557438 | localhost | changed 2026-06-20 03:19:15.575359 | 2026-06-20 03:19:15.575572 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-20 03:19:15.633246 | localhost | ok 2026-06-20 03:19:15.639931 | 2026-06-20 03:19:15.640056 | TASK [Set zuul-log-path fact] 2026-06-20 03:19:15.657531 | localhost | ok 2026-06-20 03:19:15.667542 | 2026-06-20 03:19:15.667701 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-20 03:19:15.703889 | localhost | ok 2026-06-20 03:19:15.707127 | 2026-06-20 03:19:15.707243 | TASK [upload-logs : Create log directories] 2026-06-20 03:19:16.806471 | localhost | changed 2026-06-20 03:19:16.809117 | 2026-06-20 03:19:16.809210 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-20 03:19:17.530899 | localhost -> localhost | ok: Runtime: 0:00:00.020851 2026-06-20 03:19:17.534681 | 2026-06-20 03:19:17.534806 | TASK [upload-logs : Upload logs to log server] 2026-06-20 03:19:18.507823 | localhost | Output suppressed because no_log was given 2026-06-20 03:19:18.509410 | 2026-06-20 03:19:18.509494 | LOOP [upload-logs : Compress console log and json output] 2026-06-20 03:19:18.549244 | localhost | skipping: Conditional result was False 2026-06-20 03:19:18.554885 | localhost | skipping: Conditional result was False 2026-06-20 03:19:18.564785 | 2026-06-20 03:19:18.564886 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-20 03:19:18.627909 | localhost | skipping: Conditional result was False 2026-06-20 03:19:18.628917 | 2026-06-20 03:19:18.632641 | localhost | skipping: Conditional result was False 2026-06-20 03:19:18.641116 | 2026-06-20 03:19:18.641208 | LOOP [upload-logs : Upload console log and json output]