2026-05-29 03:14:07.326892 | Job console starting 2026-05-29 03:14:07.335514 | Updating git repos 2026-05-29 03:14:07.359363 | Cloning repos into workspace 2026-05-29 03:14:07.452899 | Restoring repo states 2026-05-29 03:14:07.458805 | Merging changes 2026-05-29 03:14:07.458825 | Checking out repos 2026-05-29 03:14:07.510910 | Preparing playbooks 2026-05-29 03:14:08.957395 | Running Ansible setup 2026-05-29 03:14:13.780011 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-29 03:14:14.406048 | 2026-05-29 03:14:14.406163 | PLAY [Base pre] 2026-05-29 03:14:14.424301 | 2026-05-29 03:14:14.424403 | TASK [Setup log path fact] 2026-05-29 03:14:14.441381 | debian-bookworm | ok 2026-05-29 03:14:14.457419 | 2026-05-29 03:14:14.457527 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-29 03:14:14.484777 | debian-bookworm | ok 2026-05-29 03:14:14.493141 | 2026-05-29 03:14:14.493235 | TASK [emit-job-header : Print job information] 2026-05-29 03:14:14.521332 | # Job Information 2026-05-29 03:14:14.521484 | Ansible Version: 2.16.14 2026-05-29 03:14:14.521513 | Job: flake8 2026-05-29 03:14:14.521540 | Pipeline: periodic-daily 2026-05-29 03:14:14.521559 | Executor: 521e9411259a 2026-05-29 03:14:14.521576 | Triggered by: https://github.com/osism/cinder-driver-dm-clone 2026-05-29 03:14:14.521594 | Event ID: b6bcd69a167540d69328ee5e9bceb684 2026-05-29 03:14:14.525613 | 2026-05-29 03:14:14.525691 | LOOP [emit-job-header : Print node information] 2026-05-29 03:14:14.611231 | debian-bookworm | ok: 2026-05-29 03:14:14.611416 | debian-bookworm | # Node Information 2026-05-29 03:14:14.611454 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-29 03:14:14.611480 | debian-bookworm | Hostname: debian 2026-05-29 03:14:14.611503 | debian-bookworm | Username: zuul 2026-05-29 03:14:14.611524 | debian-bookworm | Distro: Debian 12.14 2026-05-29 03:14:14.611549 | debian-bookworm | Provider: regiocloud-a 2026-05-29 03:14:14.611570 | debian-bookworm | Region: 2026-05-29 03:14:14.611591 | debian-bookworm | Label: debian-bookworm 2026-05-29 03:14:14.611612 | debian-bookworm | Product Name: OpenStack Nova 2026-05-29 03:14:14.611632 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feb7:118e 2026-05-29 03:14:14.621292 | 2026-05-29 03:14:14.621397 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-29 03:14:14.958481 | debian-bookworm -> localhost | changed 2026-05-29 03:14:14.976616 | 2026-05-29 03:14:14.976724 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-29 03:14:16.072531 | debian-bookworm -> localhost | changed 2026-05-29 03:14:16.085056 | 2026-05-29 03:14:16.085174 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-29 03:14:16.444739 | debian-bookworm -> localhost | ok 2026-05-29 03:14:16.449769 | 2026-05-29 03:14:16.449869 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-29 03:14:16.468788 | debian-bookworm | ok 2026-05-29 03:14:16.483803 | debian-bookworm | included: /var/lib/zuul/builds/984fbe9eb1b04ae7bb0515dcab30d0c8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-29 03:14:16.488794 | 2026-05-29 03:14:16.488866 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-29 03:14:17.895763 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-29 03:14:17.895950 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/984fbe9eb1b04ae7bb0515dcab30d0c8/work/984fbe9eb1b04ae7bb0515dcab30d0c8_id_rsa 2026-05-29 03:14:17.895986 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/984fbe9eb1b04ae7bb0515dcab30d0c8/work/984fbe9eb1b04ae7bb0515dcab30d0c8_id_rsa.pub 2026-05-29 03:14:17.896011 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-29 03:14:17.896035 | debian-bookworm -> localhost | SHA256:CES/5TEJ0ChUWSo021oP9ZGbyebs5hET51c9rigB8VM zuul-build-sshkey 2026-05-29 03:14:17.896056 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-29 03:14:17.896086 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-29 03:14:17.896109 | debian-bookworm -> localhost | | .+o=*+... E | 2026-05-29 03:14:17.896130 | debian-bookworm -> localhost | | ..=o+.o+o. . | 2026-05-29 03:14:17.896150 | debian-bookworm -> localhost | | o.* .oB*. ...| 2026-05-29 03:14:17.896170 | debian-bookworm -> localhost | | + + =B*. .. .| 2026-05-29 03:14:17.896188 | debian-bookworm -> localhost | | . ++S.. . . | 2026-05-29 03:14:17.896216 | debian-bookworm -> localhost | | oo... . | 2026-05-29 03:14:17.896238 | debian-bookworm -> localhost | | ... . . | 2026-05-29 03:14:17.896257 | debian-bookworm -> localhost | | o.. | 2026-05-29 03:14:17.896289 | debian-bookworm -> localhost | | o. | 2026-05-29 03:14:17.896309 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-29 03:14:17.896360 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.590601 2026-05-29 03:14:17.902559 | 2026-05-29 03:14:17.902662 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-29 03:14:17.940306 | debian-bookworm | ok 2026-05-29 03:14:17.955122 | debian-bookworm | included: /var/lib/zuul/builds/984fbe9eb1b04ae7bb0515dcab30d0c8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-29 03:14:17.968762 | 2026-05-29 03:14:17.968866 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-29 03:14:18.017299 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:14:18.023112 | 2026-05-29 03:14:18.023214 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-29 03:14:18.750004 | debian-bookworm | changed 2026-05-29 03:14:18.754552 | 2026-05-29 03:14:18.754637 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-29 03:14:18.993172 | debian-bookworm | ok 2026-05-29 03:14:18.997918 | 2026-05-29 03:14:18.998001 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-29 03:14:19.597918 | debian-bookworm | changed 2026-05-29 03:14:19.603422 | 2026-05-29 03:14:19.603513 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-29 03:14:20.210410 | debian-bookworm | changed 2026-05-29 03:14:20.218153 | 2026-05-29 03:14:20.218251 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-29 03:14:20.243769 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:14:20.251809 | 2026-05-29 03:14:20.251992 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-29 03:14:20.770707 | debian-bookworm -> localhost | changed 2026-05-29 03:14:20.783827 | 2026-05-29 03:14:20.783931 | TASK [add-build-sshkey : Add back temp key] 2026-05-29 03:14:21.309737 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/984fbe9eb1b04ae7bb0515dcab30d0c8/work/984fbe9eb1b04ae7bb0515dcab30d0c8_id_rsa (zuul-build-sshkey) 2026-05-29 03:14:21.309944 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.059141 2026-05-29 03:14:21.317703 | 2026-05-29 03:14:21.317805 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-29 03:14:21.671605 | debian-bookworm | ok 2026-05-29 03:14:21.677622 | 2026-05-29 03:14:21.677717 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-29 03:14:21.710950 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:14:21.728100 | 2026-05-29 03:14:21.728225 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-29 03:14:22.146792 | debian-bookworm | ok 2026-05-29 03:14:22.160247 | 2026-05-29 03:14:22.160371 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-29 03:14:22.209394 | debian-bookworm | ok 2026-05-29 03:14:22.216409 | 2026-05-29 03:14:22.216522 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-29 03:14:22.535422 | debian-bookworm -> localhost | ok 2026-05-29 03:14:22.541609 | 2026-05-29 03:14:22.541699 | TASK [validate-host : Collect information about the host] 2026-05-29 03:14:23.612753 | debian-bookworm | ok 2026-05-29 03:14:23.626361 | 2026-05-29 03:14:23.626463 | TASK [validate-host : Sanitize hostname] 2026-05-29 03:14:23.726358 | debian-bookworm | ok 2026-05-29 03:14:23.761867 | 2026-05-29 03:14:23.761966 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-29 03:14:24.287750 | debian-bookworm -> localhost | changed 2026-05-29 03:14:24.293279 | 2026-05-29 03:14:24.293390 | TASK [validate-host : Collect information about zuul worker] 2026-05-29 03:14:24.719322 | debian-bookworm | ok 2026-05-29 03:14:24.726191 | 2026-05-29 03:14:24.726344 | TASK [validate-host : Write out all zuul information for each host] 2026-05-29 03:14:25.276354 | debian-bookworm -> localhost | changed 2026-05-29 03:14:25.300684 | 2026-05-29 03:14:25.300840 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-29 03:14:25.555544 | debian-bookworm | ok 2026-05-29 03:14:25.566704 | 2026-05-29 03:14:25.566912 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-29 03:14:26.373382 | debian-bookworm | changed: 2026-05-29 03:14:26.373592 | debian-bookworm | cd+++++++++ src/ 2026-05-29 03:14:26.373628 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-29 03:14:26.373652 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-29 03:14:26.373673 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/ 2026-05-29 03:14:26.373695 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/984fbe9eb1b04ae7bb0515dcab30d0c8/work/logs" 2026-05-29 03:14:51.073347 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/984fbe9eb1b04ae7bb0515dcab30d0c8/work/artifacts" 2026-05-29 03:14:51.606277 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/984fbe9eb1b04ae7bb0515dcab30d0c8/work/docs" 2026-05-29 03:14:51.618390 | 2026-05-29 03:14:51.618537 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-29 03:14:52.558887 | debian-bookworm | changed: 2026-05-29 03:14:52.559056 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-29 03:14:52.559084 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-29 03:14:52.559108 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-29 03:14:52.559390 | debian-bookworm | changed: All items complete 2026-05-29 03:14:52.559447 | 2026-05-29 03:14:53.344940 | debian-bookworm | changed: .d..t...... ./ 2026-05-29 03:14:54.093339 | debian-bookworm | changed: .d..t...... ./ 2026-05-29 03:14:54.111464 | 2026-05-29 03:14:54.111567 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-29 03:14:54.144293 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:14:54.147927 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:14:54.163321 | 2026-05-29 03:14:54.163396 | PLAY RECAP 2026-05-29 03:14:54.163446 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-29 03:14:54.163471 | 2026-05-29 03:14:54.307930 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-29 03:14:54.308694 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-29 03:14:55.032877 | 2026-05-29 03:14:55.033005 | PLAY [Base post] 2026-05-29 03:14:55.045121 | 2026-05-29 03:14:55.045308 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-29 03:14:55.604846 | debian-bookworm | changed 2026-05-29 03:14:55.615478 | 2026-05-29 03:14:55.615594 | PLAY RECAP 2026-05-29 03:14:55.615660 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-29 03:14:55.615729 | 2026-05-29 03:14:55.730322 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-29 03:14:55.731260 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-29 03:14:56.578729 | 2026-05-29 03:14:56.578875 | PLAY [Base post-logs] 2026-05-29 03:14:56.605395 | 2026-05-29 03:14:56.605535 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-29 03:14:57.107258 | localhost | changed 2026-05-29 03:14:57.119991 | 2026-05-29 03:14:57.120117 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-29 03:14:57.158367 | localhost | ok 2026-05-29 03:14:57.161737 | 2026-05-29 03:14:57.161835 | TASK [Set zuul-log-path fact] 2026-05-29 03:14:57.178132 | localhost | ok 2026-05-29 03:14:57.185648 | 2026-05-29 03:14:57.185751 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-29 03:14:57.211077 | localhost | ok 2026-05-29 03:14:57.214438 | 2026-05-29 03:14:57.214533 | TASK [upload-logs : Create log directories] 2026-05-29 03:14:58.377704 | localhost | changed 2026-05-29 03:14:58.382454 | 2026-05-29 03:14:58.382533 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-29 03:14:59.200491 | localhost -> localhost | ok: Runtime: 0:00:00.025777 2026-05-29 03:14:59.206071 | 2026-05-29 03:14:59.206164 | TASK [upload-logs : Upload logs to log server] 2026-05-29 03:15:00.114528 | localhost | Output suppressed because no_log was given 2026-05-29 03:15:00.116010 | 2026-05-29 03:15:00.116087 | LOOP [upload-logs : Compress console log and json output] 2026-05-29 03:15:00.192229 | localhost | skipping: Conditional result was False 2026-05-29 03:15:00.207883 | localhost | skipping: Conditional result was False 2026-05-29 03:15:00.214828 | 2026-05-29 03:15:00.215118 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-29 03:15:00.258698 | localhost | skipping: Conditional result was False 2026-05-29 03:15:00.259356 | 2026-05-29 03:15:00.263785 | localhost | skipping: Conditional result was False 2026-05-29 03:15:00.271976 | 2026-05-29 03:15:00.272064 | LOOP [upload-logs : Upload console log and json output]