2026-05-28 03:12:36.716353 | Job console starting 2026-05-28 03:12:36.725755 | Updating git repos 2026-05-28 03:12:37.602198 | Cloning repos into workspace 2026-05-28 03:12:37.701430 | Restoring repo states 2026-05-28 03:12:37.735190 | Merging changes 2026-05-28 03:12:37.735204 | Checking out repos 2026-05-28 03:12:37.859798 | Preparing playbooks 2026-05-28 03:12:39.152252 | Running Ansible setup 2026-05-28 03:12:43.537618 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-28 03:12:44.375508 | 2026-05-28 03:12:44.375668 | PLAY [Base pre] 2026-05-28 03:12:44.396906 | 2026-05-28 03:12:44.397029 | TASK [Setup log path fact] 2026-05-28 03:12:44.414805 | debian-bookworm | ok 2026-05-28 03:12:44.429712 | 2026-05-28 03:12:44.429834 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-28 03:12:44.487806 | debian-bookworm | ok 2026-05-28 03:12:44.504676 | 2026-05-28 03:12:44.504792 | TASK [emit-job-header : Print job information] 2026-05-28 03:12:44.543298 | # Job Information 2026-05-28 03:12:44.543452 | Ansible Version: 2.16.14 2026-05-28 03:12:44.543488 | Job: flake8 2026-05-28 03:12:44.543521 | Pipeline: periodic-daily 2026-05-28 03:12:44.543544 | Executor: 521e9411259a 2026-05-28 03:12:44.543565 | Triggered by: https://github.com/osism/cinder-driver-dm-clone 2026-05-28 03:12:44.543589 | Event ID: d16d8d3948814ddaa6d0ba3e0fbb9dde 2026-05-28 03:12:44.548807 | 2026-05-28 03:12:44.548908 | LOOP [emit-job-header : Print node information] 2026-05-28 03:12:44.684845 | debian-bookworm | ok: 2026-05-28 03:12:44.685003 | debian-bookworm | # Node Information 2026-05-28 03:12:44.685036 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-28 03:12:44.685060 | debian-bookworm | Hostname: debian 2026-05-28 03:12:44.685081 | debian-bookworm | Username: zuul 2026-05-28 03:12:44.685101 | debian-bookworm | Distro: Debian 12.14 2026-05-28 03:12:44.685125 | debian-bookworm | Provider: regiocloud-a 2026-05-28 03:12:44.685146 | debian-bookworm | Region: 2026-05-28 03:12:44.685167 | debian-bookworm | Label: debian-bookworm 2026-05-28 03:12:44.685186 | debian-bookworm | Product Name: OpenStack Nova 2026-05-28 03:12:44.685205 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fef4:905e 2026-05-28 03:12:44.695775 | 2026-05-28 03:12:44.695877 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-28 03:12:45.225069 | debian-bookworm -> localhost | changed 2026-05-28 03:12:45.232134 | 2026-05-28 03:12:45.232232 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-28 03:12:46.557750 | debian-bookworm -> localhost | changed 2026-05-28 03:12:46.570913 | 2026-05-28 03:12:46.571016 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-28 03:12:46.839296 | debian-bookworm -> localhost | ok 2026-05-28 03:12:46.846143 | 2026-05-28 03:12:46.846247 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-28 03:12:46.880121 | debian-bookworm | ok 2026-05-28 03:12:46.897930 | debian-bookworm | included: /var/lib/zuul/builds/ee9b85b1145746a38e8d3b1efeb8067c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-28 03:12:46.905070 | 2026-05-28 03:12:46.905163 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-28 03:12:48.101965 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-28 03:12:48.102148 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/ee9b85b1145746a38e8d3b1efeb8067c/work/ee9b85b1145746a38e8d3b1efeb8067c_id_rsa 2026-05-28 03:12:48.102186 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/ee9b85b1145746a38e8d3b1efeb8067c/work/ee9b85b1145746a38e8d3b1efeb8067c_id_rsa.pub 2026-05-28 03:12:48.102212 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-28 03:12:48.102235 | debian-bookworm -> localhost | SHA256:mvXWLUUv5gBOI7OaKC2wg4+12vxX9Dp9HggCA53kg5k zuul-build-sshkey 2026-05-28 03:12:48.102257 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-28 03:12:48.102288 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-28 03:12:48.102311 | debian-bookworm -> localhost | | .o.. | 2026-05-28 03:12:48.102332 | debian-bookworm -> localhost | | *o | 2026-05-28 03:12:48.102352 | debian-bookworm -> localhost | | E = o + . | 2026-05-28 03:12:48.102371 | debian-bookworm -> localhost | | + .* o . . | 2026-05-28 03:12:48.102390 | debian-bookworm -> localhost | |. ..S.. . + .| 2026-05-28 03:12:48.102414 | debian-bookworm -> localhost | |.o . . B.o.o * . | 2026-05-28 03:12:48.102434 | debian-bookworm -> localhost | |+ + o =. o+ + o | 2026-05-28 03:12:48.102453 | debian-bookworm -> localhost | | B + . o.. .o | 2026-05-28 03:12:48.102474 | debian-bookworm -> localhost | |o.=... . o. | 2026-05-28 03:12:48.102494 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-28 03:12:48.102541 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.654994 2026-05-28 03:12:48.113779 | 2026-05-28 03:12:48.113887 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-28 03:12:48.159969 | debian-bookworm | ok 2026-05-28 03:12:48.177449 | debian-bookworm | included: /var/lib/zuul/builds/ee9b85b1145746a38e8d3b1efeb8067c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-28 03:12:48.195712 | 2026-05-28 03:12:48.195814 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-28 03:12:48.232265 | debian-bookworm | skipping: Conditional result was False 2026-05-28 03:12:48.238254 | 2026-05-28 03:12:48.238355 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-28 03:12:48.954206 | debian-bookworm | changed 2026-05-28 03:12:48.963659 | 2026-05-28 03:12:48.963800 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-28 03:12:49.232851 | debian-bookworm | ok 2026-05-28 03:12:49.245842 | 2026-05-28 03:12:49.246008 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-28 03:12:49.962511 | debian-bookworm | changed 2026-05-28 03:12:49.972460 | 2026-05-28 03:12:49.972562 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-28 03:12:50.673436 | debian-bookworm | changed 2026-05-28 03:12:50.681762 | 2026-05-28 03:12:50.681881 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-28 03:12:50.737722 | debian-bookworm | skipping: Conditional result was False 2026-05-28 03:12:50.744252 | 2026-05-28 03:12:50.744386 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-28 03:12:51.858803 | debian-bookworm -> localhost | changed 2026-05-28 03:12:51.874245 | 2026-05-28 03:12:51.874386 | TASK [add-build-sshkey : Add back temp key] 2026-05-28 03:12:52.369258 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/ee9b85b1145746a38e8d3b1efeb8067c/work/ee9b85b1145746a38e8d3b1efeb8067c_id_rsa (zuul-build-sshkey) 2026-05-28 03:12:52.369523 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.024424 2026-05-28 03:12:52.378097 | 2026-05-28 03:12:52.378230 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-28 03:12:52.864169 | debian-bookworm | ok 2026-05-28 03:12:52.870239 | 2026-05-28 03:12:52.870369 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-28 03:12:52.894592 | debian-bookworm | skipping: Conditional result was False 2026-05-28 03:12:52.907602 | 2026-05-28 03:12:52.907823 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-28 03:12:53.392039 | debian-bookworm | ok 2026-05-28 03:12:53.406546 | 2026-05-28 03:12:53.406707 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-28 03:12:53.458145 | debian-bookworm | ok 2026-05-28 03:12:53.468199 | 2026-05-28 03:12:53.468329 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-28 03:12:54.117751 | debian-bookworm -> localhost | ok 2026-05-28 03:12:54.123906 | 2026-05-28 03:12:54.123994 | TASK [validate-host : Collect information about the host] 2026-05-28 03:12:55.447844 | debian-bookworm | ok 2026-05-28 03:12:55.468235 | 2026-05-28 03:12:55.468346 | TASK [validate-host : Sanitize hostname] 2026-05-28 03:12:55.603907 | debian-bookworm | ok 2026-05-28 03:12:55.648716 | 2026-05-28 03:12:55.648818 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-28 03:12:56.596162 | debian-bookworm -> localhost | changed 2026-05-28 03:12:56.601513 | 2026-05-28 03:12:56.601611 | TASK [validate-host : Collect information about zuul worker] 2026-05-28 03:12:57.036292 | debian-bookworm | ok 2026-05-28 03:12:57.041014 | 2026-05-28 03:12:57.041120 | TASK [validate-host : Write out all zuul information for each host] 2026-05-28 03:12:58.070390 | debian-bookworm -> localhost | changed 2026-05-28 03:12:58.079309 | 2026-05-28 03:12:58.079408 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-28 03:12:58.385826 | debian-bookworm | ok 2026-05-28 03:12:58.392099 | 2026-05-28 03:12:58.392200 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-28 03:12:59.136146 | debian-bookworm | changed: 2026-05-28 03:12:59.136315 | debian-bookworm | cd+++++++++ src/ 2026-05-28 03:12:59.136348 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-28 03:12:59.136373 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-28 03:12:59.136395 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/ 2026-05-28 03:12:59.136416 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/ee9b85b1145746a38e8d3b1efeb8067c/work/logs" 2026-05-28 03:13:26.999248 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/ee9b85b1145746a38e8d3b1efeb8067c/work/artifacts" 2026-05-28 03:13:27.257469 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/ee9b85b1145746a38e8d3b1efeb8067c/work/docs" 2026-05-28 03:13:27.274409 | 2026-05-28 03:13:27.274549 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-28 03:13:28.209428 | debian-bookworm | changed: 2026-05-28 03:13:28.209731 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-28 03:13:28.209770 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-28 03:13:28.209800 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-28 03:13:28.209847 | debian-bookworm | changed: All items complete 2026-05-28 03:13:28.209874 | 2026-05-28 03:13:28.850026 | debian-bookworm | changed: .d..t...... ./ 2026-05-28 03:13:29.586275 | debian-bookworm | changed: .d..t...... ./ 2026-05-28 03:13:29.603175 | 2026-05-28 03:13:29.603311 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-28 03:13:29.652786 | debian-bookworm | skipping: Conditional result was False 2026-05-28 03:13:29.656130 | debian-bookworm | skipping: Conditional result was False 2026-05-28 03:13:29.670434 | 2026-05-28 03:13:29.670671 | PLAY RECAP 2026-05-28 03:13:29.670755 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-28 03:13:29.670793 | 2026-05-28 03:13:29.814810 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-28 03:13:29.816094 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-28 03:13:30.679907 | 2026-05-28 03:13:30.680066 | PLAY [Base post] 2026-05-28 03:13:30.695950 | 2026-05-28 03:13:30.696094 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-28 03:13:31.316641 | debian-bookworm | changed 2026-05-28 03:13:31.325300 | 2026-05-28 03:13:31.325514 | PLAY RECAP 2026-05-28 03:13:31.325664 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-28 03:13:31.325732 | 2026-05-28 03:13:31.569043 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-28 03:13:31.569945 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-28 03:13:32.947942 | 2026-05-28 03:13:32.949839 | PLAY [Base post-logs] 2026-05-28 03:13:32.966631 | 2026-05-28 03:13:32.966794 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-28 03:13:34.239983 | localhost | changed 2026-05-28 03:13:34.260430 | 2026-05-28 03:13:34.260636 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-28 03:13:34.338871 | localhost | ok 2026-05-28 03:13:34.344253 | 2026-05-28 03:13:34.345052 | TASK [Set zuul-log-path fact] 2026-05-28 03:13:34.391936 | localhost | ok 2026-05-28 03:13:34.415241 | 2026-05-28 03:13:34.415392 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-28 03:13:34.473648 | localhost | ok 2026-05-28 03:13:34.480760 | 2026-05-28 03:13:34.480895 | TASK [upload-logs : Create log directories] 2026-05-28 03:13:35.215293 | localhost | changed 2026-05-28 03:13:35.220615 | 2026-05-28 03:13:35.221003 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-28 03:13:35.633198 | localhost -> localhost | ok: Runtime: 0:00:00.006078 2026-05-28 03:13:35.639480 | 2026-05-28 03:13:35.640337 | TASK [upload-logs : Upload logs to log server] 2026-05-28 03:13:36.092480 | localhost | Output suppressed because no_log was given 2026-05-28 03:13:36.093848 | 2026-05-28 03:13:36.093921 | LOOP [upload-logs : Compress console log and json output] 2026-05-28 03:13:36.134151 | localhost | skipping: Conditional result was False 2026-05-28 03:13:36.139140 | localhost | skipping: Conditional result was False 2026-05-28 03:13:36.148765 | 2026-05-28 03:13:36.148848 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-28 03:13:36.197235 | localhost | skipping: Conditional result was False 2026-05-28 03:13:36.197451 | 2026-05-28 03:13:36.203443 | localhost | skipping: Conditional result was False 2026-05-28 03:13:36.215877 | 2026-05-28 03:13:36.215986 | LOOP [upload-logs : Upload console log and json output]