2026-05-15 03:12:47.229289 | Job console starting 2026-05-15 03:12:47.250431 | Updating git repos 2026-05-15 03:12:47.283525 | Cloning repos into workspace 2026-05-15 03:12:47.370328 | Restoring repo states 2026-05-15 03:12:47.380247 | Merging changes 2026-05-15 03:12:47.380263 | Checking out repos 2026-05-15 03:12:47.453135 | Preparing playbooks 2026-05-15 03:12:48.769666 | Running Ansible setup 2026-05-15 03:12:53.752633 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-15 03:12:54.778471 | 2026-05-15 03:12:54.778637 | PLAY [Base pre] 2026-05-15 03:12:54.795478 | 2026-05-15 03:12:54.795620 | TASK [Setup log path fact] 2026-05-15 03:12:54.825367 | debian-bookworm | ok 2026-05-15 03:12:54.858909 | 2026-05-15 03:12:54.859070 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-15 03:12:54.908357 | debian-bookworm | ok 2026-05-15 03:12:54.922170 | 2026-05-15 03:12:54.922296 | TASK [emit-job-header : Print job information] 2026-05-15 03:12:54.981153 | # Job Information 2026-05-15 03:12:54.981341 | Ansible Version: 2.16.14 2026-05-15 03:12:54.981376 | Job: flake8 2026-05-15 03:12:54.981410 | Pipeline: periodic-daily 2026-05-15 03:12:54.981433 | Executor: 521e9411259a 2026-05-15 03:12:54.981454 | Triggered by: https://github.com/osism/cinder-driver-dm-clone 2026-05-15 03:12:54.981477 | Event ID: 47a4f92cfc734c6c8bdc66a14a44b00f 2026-05-15 03:12:54.993863 | 2026-05-15 03:12:54.994001 | LOOP [emit-job-header : Print node information] 2026-05-15 03:12:55.187148 | debian-bookworm | ok: 2026-05-15 03:12:55.187339 | debian-bookworm | # Node Information 2026-05-15 03:12:55.187373 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-15 03:12:55.187398 | debian-bookworm | Hostname: debian 2026-05-15 03:12:55.187420 | debian-bookworm | Username: zuul 2026-05-15 03:12:55.187440 | debian-bookworm | Distro: Debian 12.13 2026-05-15 03:12:55.187465 | debian-bookworm | Provider: regiocloud-a 2026-05-15 03:12:55.187486 | debian-bookworm | Region: 2026-05-15 03:12:55.187507 | debian-bookworm | Label: debian-bookworm 2026-05-15 03:12:55.187527 | debian-bookworm | Product Name: OpenStack Nova 2026-05-15 03:12:55.187547 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe98:7bf7 2026-05-15 03:12:55.201802 | 2026-05-15 03:12:55.201927 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-15 03:12:56.014053 | debian-bookworm -> localhost | changed 2026-05-15 03:12:56.022018 | 2026-05-15 03:12:56.022141 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-15 03:12:57.308906 | debian-bookworm -> localhost | changed 2026-05-15 03:12:57.320105 | 2026-05-15 03:12:57.320214 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-15 03:12:57.602344 | debian-bookworm -> localhost | ok 2026-05-15 03:12:57.608304 | 2026-05-15 03:12:57.608413 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-15 03:12:57.630493 | debian-bookworm | ok 2026-05-15 03:12:57.647812 | debian-bookworm | included: /var/lib/zuul/builds/99c8f4b2b10d492185ddb79e6e934618/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-15 03:12:57.653991 | 2026-05-15 03:12:57.654090 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-15 03:12:58.928805 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-15 03:12:58.929099 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/99c8f4b2b10d492185ddb79e6e934618/work/99c8f4b2b10d492185ddb79e6e934618_id_rsa 2026-05-15 03:12:58.929164 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/99c8f4b2b10d492185ddb79e6e934618/work/99c8f4b2b10d492185ddb79e6e934618_id_rsa.pub 2026-05-15 03:12:58.929212 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-15 03:12:58.929256 | debian-bookworm -> localhost | SHA256:sM8Qq+OILQlxqKcWfPEz7qr9Q7pkpyiqcNts6ODP04E zuul-build-sshkey 2026-05-15 03:12:58.929297 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-15 03:12:58.929352 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-15 03:12:58.929394 | debian-bookworm -> localhost | | | 2026-05-15 03:12:58.929434 | debian-bookworm -> localhost | | | 2026-05-15 03:12:58.929470 | debian-bookworm -> localhost | | . o | 2026-05-15 03:12:58.929505 | debian-bookworm -> localhost | |o .. = | 2026-05-15 03:12:58.929541 | debian-bookworm -> localhost | |oo + + S | 2026-05-15 03:12:58.929622 | debian-bookworm -> localhost | |oo.E B + | 2026-05-15 03:12:58.929662 | debian-bookworm -> localhost | |++++B.+ o | 2026-05-15 03:12:58.929698 | debian-bookworm -> localhost | |B*BO+= | 2026-05-15 03:12:58.929736 | debian-bookworm -> localhost | |O*BOXo. | 2026-05-15 03:12:58.929773 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-15 03:12:58.929854 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.802692 2026-05-15 03:12:58.940096 | 2026-05-15 03:12:58.940217 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-15 03:12:58.958361 | debian-bookworm | ok 2026-05-15 03:12:58.968210 | debian-bookworm | included: /var/lib/zuul/builds/99c8f4b2b10d492185ddb79e6e934618/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-15 03:12:58.978377 | 2026-05-15 03:12:58.978456 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-15 03:12:58.991160 | debian-bookworm | skipping: Conditional result was False 2026-05-15 03:12:58.996970 | 2026-05-15 03:12:58.997059 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-15 03:12:59.628261 | debian-bookworm | changed 2026-05-15 03:12:59.635080 | 2026-05-15 03:12:59.635176 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-15 03:12:59.902389 | debian-bookworm | ok 2026-05-15 03:12:59.908463 | 2026-05-15 03:12:59.908922 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-15 03:13:00.595931 | debian-bookworm | changed 2026-05-15 03:13:00.606767 | 2026-05-15 03:13:00.606937 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-15 03:13:01.245219 | debian-bookworm | changed 2026-05-15 03:13:01.250966 | 2026-05-15 03:13:01.251070 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-15 03:13:01.275231 | debian-bookworm | skipping: Conditional result was False 2026-05-15 03:13:01.285084 | 2026-05-15 03:13:01.285244 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-15 03:13:01.713906 | debian-bookworm -> localhost | changed 2026-05-15 03:13:01.724702 | 2026-05-15 03:13:01.724811 | TASK [add-build-sshkey : Add back temp key] 2026-05-15 03:13:02.148644 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/99c8f4b2b10d492185ddb79e6e934618/work/99c8f4b2b10d492185ddb79e6e934618_id_rsa (zuul-build-sshkey) 2026-05-15 03:13:02.148864 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010165 2026-05-15 03:13:02.156488 | 2026-05-15 03:13:02.156601 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-15 03:13:02.546258 | debian-bookworm | ok 2026-05-15 03:13:02.556532 | 2026-05-15 03:13:02.556725 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-15 03:13:02.593079 | debian-bookworm | skipping: Conditional result was False 2026-05-15 03:13:02.614352 | 2026-05-15 03:13:02.614483 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-15 03:13:03.059673 | debian-bookworm | ok 2026-05-15 03:13:03.070500 | 2026-05-15 03:13:03.070613 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-15 03:13:03.100891 | debian-bookworm | ok 2026-05-15 03:13:03.109863 | 2026-05-15 03:13:03.109969 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-15 03:13:03.610185 | debian-bookworm -> localhost | ok 2026-05-15 03:13:03.643340 | 2026-05-15 03:13:03.643454 | TASK [validate-host : Collect information about the host] 2026-05-15 03:13:05.083520 | debian-bookworm | ok 2026-05-15 03:13:05.102136 | 2026-05-15 03:13:05.102883 | TASK [validate-host : Sanitize hostname] 2026-05-15 03:13:05.285361 | debian-bookworm | ok 2026-05-15 03:13:05.381282 | 2026-05-15 03:13:05.381397 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-15 03:13:06.448868 | debian-bookworm -> localhost | changed 2026-05-15 03:13:06.457325 | 2026-05-15 03:13:06.457460 | TASK [validate-host : Collect information about zuul worker] 2026-05-15 03:13:07.024689 | debian-bookworm | ok 2026-05-15 03:13:07.032645 | 2026-05-15 03:13:07.032774 | TASK [validate-host : Write out all zuul information for each host] 2026-05-15 03:13:07.729614 | debian-bookworm -> localhost | changed 2026-05-15 03:13:07.740512 | 2026-05-15 03:13:07.740627 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-15 03:13:08.050807 | debian-bookworm | ok 2026-05-15 03:13:08.060745 | 2026-05-15 03:13:08.060853 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-15 03:13:09.102688 | debian-bookworm | changed: 2026-05-15 03:13:09.102867 | debian-bookworm | cd+++++++++ src/ 2026-05-15 03:13:09.102901 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-15 03:13:09.102924 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-15 03:13:09.102945 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/ 2026-05-15 03:13:09.102966 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/99c8f4b2b10d492185ddb79e6e934618/work/logs" 2026-05-15 03:13:35.471838 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/99c8f4b2b10d492185ddb79e6e934618/work/artifacts" 2026-05-15 03:13:36.466027 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/99c8f4b2b10d492185ddb79e6e934618/work/docs" 2026-05-15 03:13:36.486057 | 2026-05-15 03:13:36.486245 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-15 03:13:37.657383 | debian-bookworm | changed: 2026-05-15 03:13:37.657630 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-15 03:13:37.657665 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-15 03:13:37.657696 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-15 03:13:37.657779 | debian-bookworm | changed: All items complete 2026-05-15 03:13:37.657803 | 2026-05-15 03:13:38.436440 | debian-bookworm | changed: .d..t...... ./ 2026-05-15 03:13:39.305546 | debian-bookworm | changed: .d..t...... ./ 2026-05-15 03:13:39.411318 | 2026-05-15 03:13:39.411420 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-15 03:13:39.484436 | debian-bookworm | skipping: Conditional result was False 2026-05-15 03:13:39.488367 | debian-bookworm | skipping: Conditional result was False 2026-05-15 03:13:39.500347 | 2026-05-15 03:13:39.500425 | PLAY RECAP 2026-05-15 03:13:39.500469 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-15 03:13:39.500489 | 2026-05-15 03:13:39.849293 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-15 03:13:39.850576 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-15 03:13:41.102958 | 2026-05-15 03:13:41.103098 | PLAY [Base post] 2026-05-15 03:13:41.123683 | 2026-05-15 03:13:41.123842 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-15 03:13:41.666447 | debian-bookworm | changed 2026-05-15 03:13:41.671831 | 2026-05-15 03:13:41.671908 | PLAY RECAP 2026-05-15 03:13:41.671959 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-15 03:13:41.672008 | 2026-05-15 03:13:41.779119 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-15 03:13:41.779938 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-15 03:13:42.848374 | 2026-05-15 03:13:42.848524 | PLAY [Base post-logs] 2026-05-15 03:13:42.861159 | 2026-05-15 03:13:42.861321 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-15 03:13:43.471274 | localhost | changed 2026-05-15 03:13:43.483821 | 2026-05-15 03:13:43.483961 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-15 03:13:43.510679 | localhost | ok 2026-05-15 03:13:43.513539 | 2026-05-15 03:13:43.513626 | TASK [Set zuul-log-path fact] 2026-05-15 03:13:43.527973 | localhost | ok 2026-05-15 03:13:43.541612 | 2026-05-15 03:13:43.541703 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-15 03:13:43.572303 | localhost | ok 2026-05-15 03:13:43.577863 | 2026-05-15 03:13:43.577951 | TASK [upload-logs : Create log directories] 2026-05-15 03:13:44.084647 | localhost | changed 2026-05-15 03:13:44.091256 | 2026-05-15 03:13:44.091347 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-15 03:13:44.560796 | localhost -> localhost | ok: Runtime: 0:00:00.012460 2026-05-15 03:13:44.563967 | 2026-05-15 03:13:44.564048 | TASK [upload-logs : Upload logs to log server] 2026-05-15 03:13:45.042467 | localhost | Output suppressed because no_log was given 2026-05-15 03:13:45.043913 | 2026-05-15 03:13:45.043993 | LOOP [upload-logs : Compress console log and json output] 2026-05-15 03:13:45.085125 | localhost | skipping: Conditional result was False 2026-05-15 03:13:45.096193 | localhost | skipping: Conditional result was False 2026-05-15 03:13:45.098933 | 2026-05-15 03:13:45.099033 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-15 03:13:45.133079 | localhost | skipping: Conditional result was False 2026-05-15 03:13:45.133339 | 2026-05-15 03:13:45.137039 | localhost | skipping: Conditional result was False 2026-05-15 03:13:45.143433 | 2026-05-15 03:13:45.143527 | LOOP [upload-logs : Upload console log and json output]