2026-09-03 03:13:41.125746 | Job console starting 2026-09-03 03:13:41.142056 | Updating git repos 2026-09-03 03:13:41.163468 | Cloning repos into workspace 2026-09-03 03:13:41.189785 | Restoring repo states 2026-09-03 03:13:41.193423 | Merging changes 2026-09-03 03:13:41.193436 | Checking out repos 2026-09-03 03:13:41.234498 | Preparing playbooks 2026-09-03 03:13:42.054695 | Running Ansible setup 2026-09-03 03:13:46.785925 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-03 03:13:47.583931 | 2026-09-03 03:13:47.584040 | PLAY [Base pre] 2026-09-03 03:13:47.606238 | 2026-09-03 03:13:47.606347 | TASK [Setup log path fact] 2026-09-03 03:13:47.624461 | debian-bookworm | ok 2026-09-03 03:13:47.641053 | 2026-09-03 03:13:47.641219 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-03 03:13:47.669763 | debian-bookworm | ok 2026-09-03 03:13:47.684846 | 2026-09-03 03:13:47.684948 | TASK [emit-job-header : Print job information] 2026-09-03 03:13:47.723195 | # Job Information 2026-09-03 03:13:47.723348 | Ansible Version: 2.16.14 2026-09-03 03:13:47.723383 | Job: flake8 2026-09-03 03:13:47.723416 | Pipeline: periodic-daily 2026-09-03 03:13:47.723439 | Executor: 521e9411259a 2026-09-03 03:13:47.723459 | Triggered by: https://github.com/osism/cinder-driver-dm-clone 2026-09-03 03:13:47.723482 | Event ID: c21d1de150ee49f8b075bb5b8b809457 2026-09-03 03:13:47.728382 | 2026-09-03 03:13:47.728474 | LOOP [emit-job-header : Print node information] 2026-09-03 03:13:47.846759 | debian-bookworm | ok: 2026-09-03 03:13:47.846924 | debian-bookworm | # Node Information 2026-09-03 03:13:47.846953 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-03 03:13:47.846974 | debian-bookworm | Hostname: debian 2026-09-03 03:13:47.846992 | debian-bookworm | Username: zuul 2026-09-03 03:13:47.847010 | debian-bookworm | Distro: Debian 12.15 2026-09-03 03:13:47.847029 | debian-bookworm | Provider: regiocloud-a 2026-09-03 03:13:47.847047 | debian-bookworm | Region: 2026-09-03 03:13:47.847064 | debian-bookworm | Label: debian-bookworm 2026-09-03 03:13:47.847081 | debian-bookworm | Product Name: OpenStack Nova 2026-09-03 03:13:47.847098 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe65:fc19 2026-09-03 03:13:47.858274 | 2026-09-03 03:13:47.858385 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-03 03:13:48.279937 | debian-bookworm -> localhost | changed 2026-09-03 03:13:48.286948 | 2026-09-03 03:13:48.287060 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-03 03:13:49.159297 | debian-bookworm -> localhost | changed 2026-09-03 03:13:49.169551 | 2026-09-03 03:13:49.169654 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-03 03:13:49.437091 | debian-bookworm -> localhost | ok 2026-09-03 03:13:49.442591 | 2026-09-03 03:13:49.442697 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-03 03:13:49.461973 | debian-bookworm | ok 2026-09-03 03:13:49.476202 | debian-bookworm | included: /var/lib/zuul/builds/423931457cd4434cb36733f564eaf5c3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-03 03:13:49.481913 | 2026-09-03 03:13:49.481985 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-03 03:13:50.559393 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-03 03:13:50.559579 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/423931457cd4434cb36733f564eaf5c3/work/423931457cd4434cb36733f564eaf5c3_id_rsa 2026-09-03 03:13:50.559618 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/423931457cd4434cb36733f564eaf5c3/work/423931457cd4434cb36733f564eaf5c3_id_rsa.pub 2026-09-03 03:13:50.559645 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-03 03:13:50.559670 | debian-bookworm -> localhost | SHA256:F4TdVcC9PBbUuD5Lqz1OTQ373rA4Lb5Ra9w29mrTCFY zuul-build-sshkey 2026-09-03 03:13:50.559693 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-03 03:13:50.559722 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-03 03:13:50.559746 | debian-bookworm -> localhost | | o.. o+*o| 2026-09-03 03:13:50.559768 | debian-bookworm -> localhost | | ... . o.o| 2026-09-03 03:13:50.559788 | debian-bookworm -> localhost | | . o.o| 2026-09-03 03:13:50.559807 | debian-bookworm -> localhost | | . EB.| 2026-09-03 03:13:50.559828 | debian-bookworm -> localhost | | S . o+ +| 2026-09-03 03:13:50.559853 | debian-bookworm -> localhost | | . oo+* | 2026-09-03 03:13:50.559873 | debian-bookworm -> localhost | | ..+*O=| 2026-09-03 03:13:50.559893 | debian-bookworm -> localhost | | o*X==| 2026-09-03 03:13:50.559914 | debian-bookworm -> localhost | | .=B=++| 2026-09-03 03:13:50.559933 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-03 03:13:50.559984 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.676039 2026-09-03 03:13:50.566507 | 2026-09-03 03:13:50.566593 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-03 03:13:50.584610 | debian-bookworm | ok 2026-09-03 03:13:50.594633 | debian-bookworm | included: /var/lib/zuul/builds/423931457cd4434cb36733f564eaf5c3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-03 03:13:50.602999 | 2026-09-03 03:13:50.603138 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-03 03:13:50.616211 | debian-bookworm | skipping: Conditional result was False 2026-09-03 03:13:50.622315 | 2026-09-03 03:13:50.622407 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-03 03:13:51.278703 | debian-bookworm | changed 2026-09-03 03:13:51.284295 | 2026-09-03 03:13:51.284381 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-03 03:13:51.551487 | debian-bookworm | ok 2026-09-03 03:13:51.559831 | 2026-09-03 03:13:51.559935 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-03 03:13:52.191522 | debian-bookworm | changed 2026-09-03 03:13:52.197493 | 2026-09-03 03:13:52.197596 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-03 03:13:52.795262 | debian-bookworm | changed 2026-09-03 03:13:52.803425 | 2026-09-03 03:13:52.803517 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-03 03:13:52.827511 | debian-bookworm | skipping: Conditional result was False 2026-09-03 03:13:52.834376 | 2026-09-03 03:13:52.834566 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-03 03:13:53.398856 | debian-bookworm -> localhost | changed 2026-09-03 03:13:53.420454 | 2026-09-03 03:13:53.420559 | TASK [add-build-sshkey : Add back temp key] 2026-09-03 03:13:53.771246 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/423931457cd4434cb36733f564eaf5c3/work/423931457cd4434cb36733f564eaf5c3_id_rsa (zuul-build-sshkey) 2026-09-03 03:13:53.771449 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.008822 2026-09-03 03:13:53.778591 | 2026-09-03 03:13:53.778674 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-03 03:13:54.152996 | debian-bookworm | ok 2026-09-03 03:13:54.160163 | 2026-09-03 03:13:54.160288 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-03 03:13:54.195286 | debian-bookworm | skipping: Conditional result was False 2026-09-03 03:13:54.216509 | 2026-09-03 03:13:54.216651 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-03 03:13:54.648231 | debian-bookworm | ok 2026-09-03 03:13:54.661540 | 2026-09-03 03:13:54.661642 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-03 03:13:54.704465 | debian-bookworm | ok 2026-09-03 03:13:54.712328 | 2026-09-03 03:13:54.712439 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-03 03:13:54.998924 | debian-bookworm -> localhost | ok 2026-09-03 03:13:55.005007 | 2026-09-03 03:13:55.005089 | TASK [validate-host : Collect information about the host] 2026-09-03 03:13:56.070114 | debian-bookworm | ok 2026-09-03 03:13:56.082210 | 2026-09-03 03:13:56.082314 | TASK [validate-host : Sanitize hostname] 2026-09-03 03:13:56.211626 | debian-bookworm | ok 2026-09-03 03:13:56.215905 | 2026-09-03 03:13:56.215991 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-03 03:13:56.746200 | debian-bookworm -> localhost | changed 2026-09-03 03:13:56.757598 | 2026-09-03 03:13:56.757754 | TASK [validate-host : Collect information about zuul worker] 2026-09-03 03:13:57.191982 | debian-bookworm | ok 2026-09-03 03:13:57.197012 | 2026-09-03 03:13:57.197127 | TASK [validate-host : Write out all zuul information for each host] 2026-09-03 03:13:57.794375 | debian-bookworm -> localhost | changed 2026-09-03 03:13:57.811639 | 2026-09-03 03:13:57.811765 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-03 03:13:58.104910 | debian-bookworm | ok 2026-09-03 03:13:58.113345 | 2026-09-03 03:13:58.113468 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-03 03:13:59.052445 | debian-bookworm | changed: 2026-09-03 03:13:59.052650 | debian-bookworm | cd+++++++++ src/ 2026-09-03 03:13:59.052685 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-03 03:13:59.052709 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-03 03:13:59.052731 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/ 2026-09-03 03:13:59.052750 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/423931457cd4434cb36733f564eaf5c3/work/logs" 2026-09-03 03:15:02.345566 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/423931457cd4434cb36733f564eaf5c3/work/artifacts" 2026-09-03 03:15:02.614964 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/423931457cd4434cb36733f564eaf5c3/work/docs" 2026-09-03 03:15:02.628172 | 2026-09-03 03:15:02.628675 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-03 03:15:03.374252 | debian-bookworm | changed: 2026-09-03 03:15:03.374528 | debian-bookworm | .d..t...... ./ 2026-09-03 03:15:03.374566 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-03 03:15:03.374592 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-03 03:15:03.374614 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-03 03:15:03.374636 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-03 03:15:03.374657 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-03 03:15:03.374702 | debian-bookworm | changed: All items complete 2026-09-03 03:15:03.374728 | 2026-09-03 03:15:03.887869 | debian-bookworm | changed: .d..t...... ./ 2026-09-03 03:15:04.418216 | debian-bookworm | changed: .d..t...... ./ 2026-09-03 03:15:04.435003 | 2026-09-03 03:15:04.435117 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-03 03:15:04.467524 | debian-bookworm | skipping: Conditional result was False 2026-09-03 03:15:04.471417 | debian-bookworm | skipping: Conditional result was False 2026-09-03 03:15:04.480494 | 2026-09-03 03:15:04.480573 | PLAY RECAP 2026-09-03 03:15:04.480629 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-09-03 03:15:04.480653 | 2026-09-03 03:15:04.607728 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-03 03:15:04.608601 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-03 03:15:05.327416 | 2026-09-03 03:15:05.327595 | PLAY [Base post] 2026-09-03 03:15:05.361271 | 2026-09-03 03:15:05.361505 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-03 03:15:05.950233 | debian-bookworm | changed 2026-09-03 03:15:05.960550 | 2026-09-03 03:15:05.960679 | PLAY RECAP 2026-09-03 03:15:05.960766 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-03 03:15:05.960854 | 2026-09-03 03:15:06.087054 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-03 03:15:06.087954 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-03 03:15:06.920408 | 2026-09-03 03:15:06.920572 | PLAY [Base post-logs] 2026-09-03 03:15:06.933101 | 2026-09-03 03:15:06.933261 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-03 03:15:07.399955 | localhost | changed 2026-09-03 03:15:07.412896 | 2026-09-03 03:15:07.413052 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-03 03:15:07.449405 | localhost | ok 2026-09-03 03:15:07.454174 | 2026-09-03 03:15:07.454317 | TASK [Set zuul-log-path fact] 2026-09-03 03:15:07.472400 | localhost | ok 2026-09-03 03:15:07.484761 | 2026-09-03 03:15:07.484886 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-03 03:15:07.522583 | localhost | ok 2026-09-03 03:15:07.528935 | 2026-09-03 03:15:07.529085 | TASK [upload-logs : Create log directories] 2026-09-03 03:15:08.084276 | localhost | changed 2026-09-03 03:15:08.087231 | 2026-09-03 03:15:08.087386 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-03 03:15:08.627591 | localhost -> localhost | ok: Runtime: 0:00:00.008623 2026-09-03 03:15:08.632392 | 2026-09-03 03:15:08.632523 | TASK [upload-logs : Upload logs to log server] 2026-09-03 03:15:09.202955 | localhost | Output suppressed because no_log was given 2026-09-03 03:15:09.207268 | 2026-09-03 03:15:09.207451 | LOOP [upload-logs : Compress console log and json output] 2026-09-03 03:15:09.256621 | localhost | skipping: Conditional result was False 2026-09-03 03:15:09.261614 | localhost | skipping: Conditional result was False 2026-09-03 03:15:09.274413 | 2026-09-03 03:15:09.274623 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-03 03:15:09.333423 | localhost | skipping: Conditional result was False 2026-09-03 03:15:09.333703 | 2026-09-03 03:15:09.348252 | localhost | skipping: Conditional result was False 2026-09-03 03:15:09.359675 | 2026-09-03 03:15:09.359868 | LOOP [upload-logs : Upload console log and json output]