2026-05-26 03:01:43.753701 | Job console starting 2026-05-26 03:01:43.761431 | Updating git repos 2026-05-26 03:01:43.794600 | Cloning repos into workspace 2026-05-26 03:01:43.833160 | Restoring repo states 2026-05-26 03:01:43.842472 | Merging changes 2026-05-26 03:01:43.842485 | Checking out repos 2026-05-26 03:01:43.898533 | Preparing playbooks 2026-05-26 03:01:45.497992 | Running Ansible setup 2026-05-26 03:01:52.924570 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-26 03:01:54.320773 | 2026-05-26 03:01:54.325793 | PLAY [Base pre] 2026-05-26 03:01:54.356716 | 2026-05-26 03:01:54.356833 | TASK [Setup log path fact] 2026-05-26 03:01:54.393903 | debian-bookworm | ok 2026-05-26 03:01:54.431986 | 2026-05-26 03:01:54.432132 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-26 03:01:54.480146 | debian-bookworm | ok 2026-05-26 03:01:54.503591 | 2026-05-26 03:01:54.503703 | TASK [emit-job-header : Print job information] 2026-05-26 03:01:54.598223 | # Job Information 2026-05-26 03:01:54.598463 | Ansible Version: 2.16.14 2026-05-26 03:01:54.598504 | Job: python-black 2026-05-26 03:01:54.598542 | Pipeline: periodic-daily 2026-05-26 03:01:54.598570 | Executor: 521e9411259a 2026-05-26 03:01:54.598591 | Triggered by: https://github.com/osism/ansible-collection-validations 2026-05-26 03:01:54.598612 | Event ID: e7dbbfbed2ff459c8ca8022eda545186 2026-05-26 03:01:54.611956 | 2026-05-26 03:01:54.612075 | LOOP [emit-job-header : Print node information] 2026-05-26 03:01:54.784828 | debian-bookworm | ok: 2026-05-26 03:01:54.785028 | debian-bookworm | # Node Information 2026-05-26 03:01:54.785059 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-26 03:01:54.785079 | debian-bookworm | Hostname: debian 2026-05-26 03:01:54.785097 | debian-bookworm | Username: zuul 2026-05-26 03:01:54.785114 | debian-bookworm | Distro: Debian 12.14 2026-05-26 03:01:54.785139 | debian-bookworm | Provider: regiocloud-a 2026-05-26 03:01:54.785160 | debian-bookworm | Region: 2026-05-26 03:01:54.785178 | debian-bookworm | Label: debian-bookworm 2026-05-26 03:01:54.785194 | debian-bookworm | Product Name: OpenStack Nova 2026-05-26 03:01:54.785210 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe44:90d4 2026-05-26 03:01:54.810245 | 2026-05-26 03:01:54.810522 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-26 03:01:55.733575 | debian-bookworm -> localhost | changed 2026-05-26 03:01:55.740697 | 2026-05-26 03:01:55.740806 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-26 03:01:58.157287 | debian-bookworm -> localhost | changed 2026-05-26 03:01:58.168394 | 2026-05-26 03:01:58.168491 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-26 03:01:59.112215 | debian-bookworm -> localhost | ok 2026-05-26 03:01:59.117477 | 2026-05-26 03:01:59.117567 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-26 03:01:59.166155 | debian-bookworm | ok 2026-05-26 03:01:59.190463 | debian-bookworm | included: /var/lib/zuul/builds/d33daf72b76548319920307c4c54020c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-26 03:01:59.202780 | 2026-05-26 03:01:59.202890 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-26 03:02:02.733928 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-26 03:02:02.734090 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d33daf72b76548319920307c4c54020c/work/d33daf72b76548319920307c4c54020c_id_rsa 2026-05-26 03:02:02.734120 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d33daf72b76548319920307c4c54020c/work/d33daf72b76548319920307c4c54020c_id_rsa.pub 2026-05-26 03:02:02.734141 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-26 03:02:02.734160 | debian-bookworm -> localhost | SHA256:Emc+N0fi8H7MNguI1FLHXbmr0oUoAljNMh4P8I079Dc zuul-build-sshkey 2026-05-26 03:02:02.734178 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-26 03:02:02.734203 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-26 03:02:02.734221 | debian-bookworm -> localhost | | .. o .. | 2026-05-26 03:02:02.734238 | debian-bookworm -> localhost | | .*oo . . .. | 2026-05-26 03:02:02.734255 | debian-bookworm -> localhost | | ++*o = + o . | 2026-05-26 03:02:02.734270 | debian-bookworm -> localhost | | ..oo.B = o . | 2026-05-26 03:02:02.734286 | debian-bookworm -> localhost | | o.= E =... . | 2026-05-26 03:02:02.734306 | debian-bookworm -> localhost | | o.=.*.=. o | 2026-05-26 03:02:02.734321 | debian-bookworm -> localhost | | ....o.*o | 2026-05-26 03:02:02.734349 | debian-bookworm -> localhost | | .+oo | 2026-05-26 03:02:02.734367 | debian-bookworm -> localhost | | .. | 2026-05-26 03:02:02.734383 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-26 03:02:02.734427 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.905327 2026-05-26 03:02:02.740087 | 2026-05-26 03:02:02.740174 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-26 03:02:02.766934 | debian-bookworm | ok 2026-05-26 03:02:02.780819 | debian-bookworm | included: /var/lib/zuul/builds/d33daf72b76548319920307c4c54020c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-26 03:02:02.792732 | 2026-05-26 03:02:02.792816 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-26 03:02:02.815935 | debian-bookworm | skipping: Conditional result was False 2026-05-26 03:02:02.821610 | 2026-05-26 03:02:02.821712 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-26 03:02:03.721909 | debian-bookworm | changed 2026-05-26 03:02:03.726494 | 2026-05-26 03:02:03.726586 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-26 03:02:04.036081 | debian-bookworm | ok 2026-05-26 03:02:04.040644 | 2026-05-26 03:02:04.040736 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-26 03:02:04.766460 | debian-bookworm | changed 2026-05-26 03:02:04.780705 | 2026-05-26 03:02:04.780810 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-26 03:02:05.586625 | debian-bookworm | changed 2026-05-26 03:02:05.599452 | 2026-05-26 03:02:05.599554 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-26 03:02:05.627294 | debian-bookworm | skipping: Conditional result was False 2026-05-26 03:02:05.635623 | 2026-05-26 03:02:05.635723 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-26 03:02:06.318705 | debian-bookworm -> localhost | changed 2026-05-26 03:02:06.328381 | 2026-05-26 03:02:06.331853 | TASK [add-build-sshkey : Add back temp key] 2026-05-26 03:02:06.837424 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d33daf72b76548319920307c4c54020c/work/d33daf72b76548319920307c4c54020c_id_rsa (zuul-build-sshkey) 2026-05-26 03:02:06.837609 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013978 2026-05-26 03:02:06.843887 | 2026-05-26 03:02:06.843981 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-26 03:02:07.554481 | debian-bookworm | ok 2026-05-26 03:02:07.558534 | 2026-05-26 03:02:07.558607 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-26 03:02:07.603692 | debian-bookworm | skipping: Conditional result was False 2026-05-26 03:02:07.612355 | 2026-05-26 03:02:07.612448 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-26 03:02:08.201186 | debian-bookworm | ok 2026-05-26 03:02:08.212375 | 2026-05-26 03:02:08.212464 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-26 03:02:08.259069 | debian-bookworm | ok 2026-05-26 03:02:08.263248 | 2026-05-26 03:02:08.263329 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-26 03:02:08.766221 | debian-bookworm -> localhost | ok 2026-05-26 03:02:08.772693 | 2026-05-26 03:02:08.772787 | TASK [validate-host : Collect information about the host] 2026-05-26 03:02:10.058036 | debian-bookworm | ok 2026-05-26 03:02:10.068931 | 2026-05-26 03:02:10.069042 | TASK [validate-host : Sanitize hostname] 2026-05-26 03:02:10.217953 | debian-bookworm | ok 2026-05-26 03:02:10.263280 | 2026-05-26 03:02:10.263382 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-26 03:02:11.503734 | debian-bookworm -> localhost | changed 2026-05-26 03:02:11.509673 | 2026-05-26 03:02:11.509768 | TASK [validate-host : Collect information about zuul worker] 2026-05-26 03:02:12.113450 | debian-bookworm | ok 2026-05-26 03:02:12.118390 | 2026-05-26 03:02:12.118492 | TASK [validate-host : Write out all zuul information for each host] 2026-05-26 03:02:12.865485 | debian-bookworm -> localhost | changed 2026-05-26 03:02:12.875290 | 2026-05-26 03:02:12.875404 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-26 03:02:13.205679 | debian-bookworm | ok 2026-05-26 03:02:13.216751 | 2026-05-26 03:02:13.216862 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-26 03:02:14.239328 | debian-bookworm | changed: 2026-05-26 03:02:14.239506 | debian-bookworm | cd+++++++++ src/ 2026-05-26 03:02:14.239540 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-26 03:02:14.239564 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-26 03:02:14.239586 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-validations/ 2026-05-26 03:02:14.239607 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/d33daf72b76548319920307c4c54020c/work/logs" 2026-05-26 03:02:42.675657 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/d33daf72b76548319920307c4c54020c/work/artifacts" 2026-05-26 03:02:43.195488 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/d33daf72b76548319920307c4c54020c/work/docs" 2026-05-26 03:02:43.203626 | 2026-05-26 03:02:43.203720 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-26 03:02:43.993127 | debian-bookworm | changed: 2026-05-26 03:02:43.993332 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-26 03:02:43.993368 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-26 03:02:43.993428 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-26 03:02:43.993473 | debian-bookworm | changed: All items complete 2026-05-26 03:02:43.993499 | 2026-05-26 03:02:44.523411 | debian-bookworm | changed: .d..t...... ./ 2026-05-26 03:02:45.072463 | debian-bookworm | changed: .d..t...... ./ 2026-05-26 03:02:45.091795 | 2026-05-26 03:02:45.091906 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-26 03:02:45.115192 | debian-bookworm | skipping: Conditional result was False 2026-05-26 03:02:45.118752 | debian-bookworm | skipping: Conditional result was False 2026-05-26 03:02:45.132610 | 2026-05-26 03:02:45.132692 | PLAY RECAP 2026-05-26 03:02:45.132751 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-26 03:02:45.132776 | 2026-05-26 03:02:45.254286 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-26 03:02:45.256385 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-26 03:02:45.886105 | 2026-05-26 03:02:45.886236 | PLAY [Base post] 2026-05-26 03:02:45.905473 | 2026-05-26 03:02:45.905605 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-26 03:02:46.515950 | debian-bookworm | changed 2026-05-26 03:02:46.523931 | 2026-05-26 03:02:46.524030 | PLAY RECAP 2026-05-26 03:02:46.524104 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-26 03:02:46.524156 | 2026-05-26 03:02:46.642883 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-26 03:02:46.643632 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-26 03:02:47.471722 | 2026-05-26 03:02:47.471857 | PLAY [Base post-logs] 2026-05-26 03:02:47.481757 | 2026-05-26 03:02:47.481880 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-26 03:02:48.269435 | localhost | changed 2026-05-26 03:02:48.288957 | 2026-05-26 03:02:48.289093 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-26 03:02:48.314899 | localhost | ok 2026-05-26 03:02:48.317738 | 2026-05-26 03:02:48.317820 | TASK [Set zuul-log-path fact] 2026-05-26 03:02:48.333038 | localhost | ok 2026-05-26 03:02:48.348475 | 2026-05-26 03:02:48.348593 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-26 03:02:48.375436 | localhost | ok 2026-05-26 03:02:48.382251 | 2026-05-26 03:02:48.382648 | TASK [upload-logs : Create log directories] 2026-05-26 03:02:49.350100 | localhost | changed 2026-05-26 03:02:49.354722 | 2026-05-26 03:02:49.354822 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-26 03:02:50.739556 | localhost -> localhost | ok: Runtime: 0:00:00.046580 2026-05-26 03:02:50.743349 | 2026-05-26 03:02:50.743474 | TASK [upload-logs : Upload logs to log server] 2026-05-26 03:02:52.298265 | localhost | Output suppressed because no_log was given 2026-05-26 03:02:52.303157 | 2026-05-26 03:02:52.303929 | LOOP [upload-logs : Compress console log and json output] 2026-05-26 03:02:52.440596 | localhost | skipping: Conditional result was False 2026-05-26 03:02:52.454690 | localhost | skipping: Conditional result was False 2026-05-26 03:02:52.464119 | 2026-05-26 03:02:52.464231 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-26 03:02:52.592881 | localhost | skipping: Conditional result was False 2026-05-26 03:02:52.593179 | 2026-05-26 03:02:52.597160 | localhost | skipping: Conditional result was False 2026-05-26 03:02:52.608089 | 2026-05-26 03:02:52.608193 | LOOP [upload-logs : Upload console log and json output]