2026-07-24 03:14:58.958583 | Job console starting 2026-07-24 03:14:58.970733 | Updating git repos 2026-07-24 03:14:58.996379 | Cloning repos into workspace 2026-07-24 03:14:59.031320 | Restoring repo states 2026-07-24 03:14:59.039898 | Merging changes 2026-07-24 03:14:59.039919 | Checking out repos 2026-07-24 03:14:59.078291 | Preparing playbooks 2026-07-24 03:15:00.052415 | Running Ansible setup 2026-07-24 03:15:05.090625 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-24 03:15:05.866342 | 2026-07-24 03:15:05.866500 | PLAY [Base pre] 2026-07-24 03:15:05.901843 | 2026-07-24 03:15:05.901987 | TASK [Setup log path fact] 2026-07-24 03:15:05.930799 | debian-bookworm | ok 2026-07-24 03:15:05.948974 | 2026-07-24 03:15:05.949109 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-24 03:15:05.997403 | debian-bookworm | ok 2026-07-24 03:15:06.015196 | 2026-07-24 03:15:06.015327 | TASK [emit-job-header : Print job information] 2026-07-24 03:15:06.053800 | # Job Information 2026-07-24 03:15:06.053976 | Ansible Version: 2.16.14 2026-07-24 03:15:06.054011 | Job: python-black 2026-07-24 03:15:06.054044 | Pipeline: periodic-daily 2026-07-24 03:15:06.054066 | Executor: 521e9411259a 2026-07-24 03:15:06.054086 | Triggered by: https://github.com/osism/cinder-driver-dm-clone 2026-07-24 03:15:06.054108 | Event ID: 05835bd29b564fe9ab259b62b2b34dc8 2026-07-24 03:15:06.062307 | 2026-07-24 03:15:06.062429 | LOOP [emit-job-header : Print node information] 2026-07-24 03:15:06.158968 | debian-bookworm | ok: 2026-07-24 03:15:06.159118 | debian-bookworm | # Node Information 2026-07-24 03:15:06.159146 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-24 03:15:06.159167 | debian-bookworm | Hostname: debian 2026-07-24 03:15:06.159185 | debian-bookworm | Username: zuul 2026-07-24 03:15:06.159202 | debian-bookworm | Distro: Debian 12.15 2026-07-24 03:15:06.159231 | debian-bookworm | Provider: regiocloud-a 2026-07-24 03:15:06.159248 | debian-bookworm | Region: 2026-07-24 03:15:06.159265 | debian-bookworm | Label: debian-bookworm 2026-07-24 03:15:06.159282 | debian-bookworm | Product Name: OpenStack Nova 2026-07-24 03:15:06.159298 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe36:f153 2026-07-24 03:15:06.176807 | 2026-07-24 03:15:06.176928 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-24 03:15:06.707008 | debian-bookworm -> localhost | changed 2026-07-24 03:15:06.716790 | 2026-07-24 03:15:06.717076 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-24 03:15:08.254492 | debian-bookworm -> localhost | changed 2026-07-24 03:15:08.264959 | 2026-07-24 03:15:08.265066 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-24 03:15:08.511862 | debian-bookworm -> localhost | ok 2026-07-24 03:15:08.518015 | 2026-07-24 03:15:08.518117 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-24 03:15:08.538607 | debian-bookworm | ok 2026-07-24 03:15:08.558904 | debian-bookworm | included: /var/lib/zuul/builds/2bea971f633b421ea8f77192e90b15fa/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-24 03:15:08.578850 | 2026-07-24 03:15:08.578973 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-24 03:15:10.423719 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-24 03:15:10.423940 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/2bea971f633b421ea8f77192e90b15fa/work/2bea971f633b421ea8f77192e90b15fa_id_rsa 2026-07-24 03:15:10.423980 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/2bea971f633b421ea8f77192e90b15fa/work/2bea971f633b421ea8f77192e90b15fa_id_rsa.pub 2026-07-24 03:15:10.424007 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-24 03:15:10.424032 | debian-bookworm -> localhost | SHA256:z/0ffrgokRYcksCRsq6xUDRAZY9xiSAmaPPFnC0rTmA zuul-build-sshkey 2026-07-24 03:15:10.424055 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-24 03:15:10.424085 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-24 03:15:10.424108 | debian-bookworm -> localhost | |*=o++o*+ . | 2026-07-24 03:15:10.424129 | debian-bookworm -> localhost | |=E+.*Bo.o . | 2026-07-24 03:15:10.424149 | debian-bookworm -> localhost | |o.+o.+o o . | 2026-07-24 03:15:10.424168 | debian-bookworm -> localhost | | .+.. o | 2026-07-24 03:15:10.424189 | debian-bookworm -> localhost | | .o.. S o | 2026-07-24 03:15:10.424254 | debian-bookworm -> localhost | |. ... o+. | 2026-07-24 03:15:10.424281 | debian-bookworm -> localhost | | . + .o.. o | 2026-07-24 03:15:10.424303 | debian-bookworm -> localhost | | o . oo o| 2026-07-24 03:15:10.424327 | debian-bookworm -> localhost | | .. o+o| 2026-07-24 03:15:10.424348 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-24 03:15:10.424401 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.334022 2026-07-24 03:15:10.432874 | 2026-07-24 03:15:10.432977 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-24 03:15:10.466524 | debian-bookworm | ok 2026-07-24 03:15:10.484533 | debian-bookworm | included: /var/lib/zuul/builds/2bea971f633b421ea8f77192e90b15fa/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-24 03:15:10.493579 | 2026-07-24 03:15:10.493847 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-24 03:15:10.527783 | debian-bookworm | skipping: Conditional result was False 2026-07-24 03:15:10.533821 | 2026-07-24 03:15:10.533919 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-24 03:15:11.169351 | debian-bookworm | changed 2026-07-24 03:15:11.180380 | 2026-07-24 03:15:11.180505 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-24 03:15:11.471307 | debian-bookworm | ok 2026-07-24 03:15:11.483074 | 2026-07-24 03:15:11.483188 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-24 03:15:12.201396 | debian-bookworm | changed 2026-07-24 03:15:12.209261 | 2026-07-24 03:15:12.209367 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-24 03:15:12.830521 | debian-bookworm | changed 2026-07-24 03:15:12.837337 | 2026-07-24 03:15:12.837444 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-24 03:15:12.862370 | debian-bookworm | skipping: Conditional result was False 2026-07-24 03:15:12.875544 | 2026-07-24 03:15:12.875669 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-24 03:15:13.393312 | debian-bookworm -> localhost | changed 2026-07-24 03:15:13.404482 | 2026-07-24 03:15:13.404584 | TASK [add-build-sshkey : Add back temp key] 2026-07-24 03:15:13.732288 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/2bea971f633b421ea8f77192e90b15fa/work/2bea971f633b421ea8f77192e90b15fa_id_rsa (zuul-build-sshkey) 2026-07-24 03:15:13.732542 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014024 2026-07-24 03:15:13.740572 | 2026-07-24 03:15:13.740675 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-24 03:15:14.143252 | debian-bookworm | ok 2026-07-24 03:15:14.152486 | 2026-07-24 03:15:14.152592 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-24 03:15:14.199927 | debian-bookworm | skipping: Conditional result was False 2026-07-24 03:15:14.212764 | 2026-07-24 03:15:14.212877 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-24 03:15:14.649577 | debian-bookworm | ok 2026-07-24 03:15:14.666005 | 2026-07-24 03:15:14.666144 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-24 03:15:14.738700 | debian-bookworm | ok 2026-07-24 03:15:14.746435 | 2026-07-24 03:15:14.746538 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-24 03:15:15.141329 | debian-bookworm -> localhost | ok 2026-07-24 03:15:15.148238 | 2026-07-24 03:15:15.148360 | TASK [validate-host : Collect information about the host] 2026-07-24 03:15:16.307941 | debian-bookworm | ok 2026-07-24 03:15:16.335519 | 2026-07-24 03:15:16.335743 | TASK [validate-host : Sanitize hostname] 2026-07-24 03:15:16.590536 | debian-bookworm | ok 2026-07-24 03:15:16.595425 | 2026-07-24 03:15:16.595527 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-24 03:15:17.219220 | debian-bookworm -> localhost | changed 2026-07-24 03:15:17.225540 | 2026-07-24 03:15:17.225639 | TASK [validate-host : Collect information about zuul worker] 2026-07-24 03:15:17.634703 | debian-bookworm | ok 2026-07-24 03:15:17.640586 | 2026-07-24 03:15:17.640689 | TASK [validate-host : Write out all zuul information for each host] 2026-07-24 03:15:18.235461 | debian-bookworm -> localhost | changed 2026-07-24 03:15:18.248979 | 2026-07-24 03:15:18.249098 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-24 03:15:18.506334 | debian-bookworm | ok 2026-07-24 03:15:18.515327 | 2026-07-24 03:15:18.515440 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-24 03:15:19.290056 | debian-bookworm | changed: 2026-07-24 03:15:19.290384 | debian-bookworm | cd+++++++++ src/ 2026-07-24 03:15:19.290455 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-24 03:15:19.290504 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-24 03:15:19.290550 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/ 2026-07-24 03:15:19.290594 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/2bea971f633b421ea8f77192e90b15fa/work/logs" 2026-07-24 03:16:22.943811 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/2bea971f633b421ea8f77192e90b15fa/work/artifacts" 2026-07-24 03:16:23.259930 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/2bea971f633b421ea8f77192e90b15fa/work/docs" 2026-07-24 03:16:23.274459 | 2026-07-24 03:16:23.274627 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-24 03:16:24.274723 | debian-bookworm | changed: 2026-07-24 03:16:24.275678 | debian-bookworm | .d..t...... ./ 2026-07-24 03:16:24.275763 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-24 03:16:24.275790 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-24 03:16:24.275813 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-24 03:16:24.275835 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-24 03:16:24.275856 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-24 03:16:24.275907 | debian-bookworm | changed: All items complete 2026-07-24 03:16:24.275929 | 2026-07-24 03:16:25.127165 | debian-bookworm | changed: .d..t...... ./ 2026-07-24 03:16:25.755314 | debian-bookworm | changed: .d..t...... ./ 2026-07-24 03:16:25.782532 | 2026-07-24 03:16:25.782709 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-24 03:16:25.822579 | debian-bookworm | skipping: Conditional result was False 2026-07-24 03:16:25.829357 | debian-bookworm | skipping: Conditional result was False 2026-07-24 03:16:25.854039 | 2026-07-24 03:16:25.854251 | PLAY RECAP 2026-07-24 03:16:25.854339 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-07-24 03:16:25.854379 | 2026-07-24 03:16:26.017931 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-24 03:16:26.018874 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-24 03:16:27.015887 | 2026-07-24 03:16:27.016062 | PLAY [Base post] 2026-07-24 03:16:27.036870 | 2026-07-24 03:16:27.037025 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-24 03:16:27.648454 | debian-bookworm | changed 2026-07-24 03:16:27.662941 | 2026-07-24 03:16:27.663120 | PLAY RECAP 2026-07-24 03:16:27.663193 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-24 03:16:27.663257 | 2026-07-24 03:16:27.855943 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-24 03:16:27.856918 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-24 03:16:28.750760 | 2026-07-24 03:16:28.751595 | PLAY [Base post-logs] 2026-07-24 03:16:28.772354 | 2026-07-24 03:16:28.772537 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-24 03:16:29.574875 | localhost | changed 2026-07-24 03:16:29.596646 | 2026-07-24 03:16:29.596792 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-24 03:16:29.655004 | localhost | ok 2026-07-24 03:16:29.661365 | 2026-07-24 03:16:29.661480 | TASK [Set zuul-log-path fact] 2026-07-24 03:16:29.689279 | localhost | ok 2026-07-24 03:16:29.699771 | 2026-07-24 03:16:29.699886 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-24 03:16:29.739542 | localhost | ok 2026-07-24 03:16:29.743510 | 2026-07-24 03:16:29.743625 | TASK [upload-logs : Create log directories] 2026-07-24 03:16:30.751695 | localhost | changed 2026-07-24 03:16:30.755341 | 2026-07-24 03:16:30.755547 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-24 03:16:31.568316 | localhost -> localhost | ok: Runtime: 0:00:00.011603 2026-07-24 03:16:31.572185 | 2026-07-24 03:16:31.572284 | TASK [upload-logs : Upload logs to log server] 2026-07-24 03:16:32.404829 | localhost | Output suppressed because no_log was given 2026-07-24 03:16:32.406477 | 2026-07-24 03:16:32.406563 | LOOP [upload-logs : Compress console log and json output] 2026-07-24 03:16:32.451258 | localhost | skipping: Conditional result was False 2026-07-24 03:16:32.456731 | localhost | skipping: Conditional result was False 2026-07-24 03:16:32.463206 | 2026-07-24 03:16:32.463310 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-24 03:16:32.526630 | localhost | skipping: Conditional result was False 2026-07-24 03:16:32.527037 | 2026-07-24 03:16:32.556370 | localhost | skipping: Conditional result was False 2026-07-24 03:16:32.560268 | 2026-07-24 03:16:32.560382 | LOOP [upload-logs : Upload console log and json output]