2026-05-25 03:06:42.648184 | Job console starting 2026-05-25 03:06:42.659382 | Updating git repos 2026-05-25 03:06:42.721575 | Cloning repos into workspace 2026-05-25 03:06:42.886733 | Restoring repo states 2026-05-25 03:06:42.949141 | Merging changes 2026-05-25 03:06:42.949166 | Checking out repos 2026-05-25 03:06:43.071501 | Preparing playbooks 2026-05-25 03:06:44.729938 | Running Ansible setup 2026-05-25 03:06:53.391371 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-25 03:06:56.739883 | 2026-05-25 03:06:56.740037 | PLAY [Base pre] 2026-05-25 03:06:56.764475 | 2026-05-25 03:06:56.764616 | TASK [Setup log path fact] 2026-05-25 03:06:56.783753 | debian-bookworm | ok 2026-05-25 03:06:56.845933 | 2026-05-25 03:06:56.846097 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-25 03:06:56.893973 | debian-bookworm | ok 2026-05-25 03:06:56.905631 | 2026-05-25 03:06:56.905756 | TASK [emit-job-header : Print job information] 2026-05-25 03:06:57.035256 | # Job Information 2026-05-25 03:06:57.035454 | Ansible Version: 2.16.14 2026-05-25 03:06:57.035494 | Job: python-black 2026-05-25 03:06:57.035528 | Pipeline: periodic-daily 2026-05-25 03:06:57.035551 | Executor: 521e9411259a 2026-05-25 03:06:57.035571 | Triggered by: https://github.com/osism/ansible-collection-validations 2026-05-25 03:06:57.035593 | Event ID: e61335302ca24bdd80ac709d4c305869 2026-05-25 03:06:57.044220 | 2026-05-25 03:06:57.044328 | LOOP [emit-job-header : Print node information] 2026-05-25 03:06:57.452623 | debian-bookworm | ok: 2026-05-25 03:06:57.452894 | debian-bookworm | # Node Information 2026-05-25 03:06:57.452931 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-25 03:06:57.452956 | debian-bookworm | Hostname: debian 2026-05-25 03:06:57.452977 | debian-bookworm | Username: zuul 2026-05-25 03:06:57.452997 | debian-bookworm | Distro: Debian 12.14 2026-05-25 03:06:57.453027 | debian-bookworm | Provider: regiocloud-a 2026-05-25 03:06:57.453053 | debian-bookworm | Region: 2026-05-25 03:06:57.453074 | debian-bookworm | Label: debian-bookworm 2026-05-25 03:06:57.453094 | debian-bookworm | Product Name: OpenStack Nova 2026-05-25 03:06:57.453113 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe1f:54a8 2026-05-25 03:06:57.498002 | 2026-05-25 03:06:57.498143 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-25 03:06:58.803897 | debian-bookworm -> localhost | changed 2026-05-25 03:06:58.811197 | 2026-05-25 03:06:58.811330 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-25 03:07:01.503004 | debian-bookworm -> localhost | changed 2026-05-25 03:07:01.515657 | 2026-05-25 03:07:01.515773 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-25 03:07:02.068203 | debian-bookworm -> localhost | ok 2026-05-25 03:07:02.075219 | 2026-05-25 03:07:02.075324 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-25 03:07:02.118377 | debian-bookworm | ok 2026-05-25 03:07:02.143993 | debian-bookworm | included: /var/lib/zuul/builds/2dccd5e9ee0e4863a545c153920e40bf/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-25 03:07:02.163343 | 2026-05-25 03:07:02.163467 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-25 03:07:05.195669 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-25 03:07:05.195967 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/2dccd5e9ee0e4863a545c153920e40bf/work/2dccd5e9ee0e4863a545c153920e40bf_id_rsa 2026-05-25 03:07:05.196027 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/2dccd5e9ee0e4863a545c153920e40bf/work/2dccd5e9ee0e4863a545c153920e40bf_id_rsa.pub 2026-05-25 03:07:05.196072 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-25 03:07:05.196110 | debian-bookworm -> localhost | SHA256:NNvQ96l8uc9PUQuETZUFH7D2ChwmlZSJqPNKIa6RcN8 zuul-build-sshkey 2026-05-25 03:07:05.196145 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-25 03:07:05.196195 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-25 03:07:05.196232 | debian-bookworm -> localhost | | . ooB++++| 2026-05-25 03:07:05.196266 | debian-bookworm -> localhost | | . o.=...o.| 2026-05-25 03:07:05.196298 | debian-bookworm -> localhost | | . +..o.+ o| 2026-05-25 03:07:05.196333 | debian-bookworm -> localhost | |. .. + . =+.o.o.o| 2026-05-25 03:07:05.196407 | debian-bookworm -> localhost | |..o...+ S .o o+ | 2026-05-25 03:07:05.196457 | debian-bookworm -> localhost | | o ...E. ......| 2026-05-25 03:07:05.196492 | debian-bookworm -> localhost | | o . . o.o .| 2026-05-25 03:07:05.196524 | debian-bookworm -> localhost | | . . . + | 2026-05-25 03:07:05.196559 | debian-bookworm -> localhost | | ..=| 2026-05-25 03:07:05.196591 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-25 03:07:05.196670 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.850127 2026-05-25 03:07:05.206467 | 2026-05-25 03:07:05.206590 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-25 03:07:05.236101 | debian-bookworm | ok 2026-05-25 03:07:05.245101 | debian-bookworm | included: /var/lib/zuul/builds/2dccd5e9ee0e4863a545c153920e40bf/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-25 03:07:05.253783 | 2026-05-25 03:07:05.253865 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-25 03:07:05.272239 | debian-bookworm | skipping: Conditional result was False 2026-05-25 03:07:05.278087 | 2026-05-25 03:07:05.278188 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-25 03:07:06.032827 | debian-bookworm | changed 2026-05-25 03:07:06.038660 | 2026-05-25 03:07:06.038755 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-25 03:07:06.309469 | debian-bookworm | ok 2026-05-25 03:07:06.330581 | 2026-05-25 03:07:06.330727 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-25 03:07:07.045338 | debian-bookworm | changed 2026-05-25 03:07:07.062725 | 2026-05-25 03:07:07.062885 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-25 03:07:07.805368 | debian-bookworm | changed 2026-05-25 03:07:07.812351 | 2026-05-25 03:07:07.812459 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-25 03:07:07.835677 | debian-bookworm | skipping: Conditional result was False 2026-05-25 03:07:07.842658 | 2026-05-25 03:07:07.842755 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-25 03:07:08.471436 | debian-bookworm -> localhost | changed 2026-05-25 03:07:08.482056 | 2026-05-25 03:07:08.482172 | TASK [add-build-sshkey : Add back temp key] 2026-05-25 03:07:09.118739 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/2dccd5e9ee0e4863a545c153920e40bf/work/2dccd5e9ee0e4863a545c153920e40bf_id_rsa (zuul-build-sshkey) 2026-05-25 03:07:09.119050 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010228 2026-05-25 03:07:09.141131 | 2026-05-25 03:07:09.142348 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-25 03:07:09.868099 | debian-bookworm | ok 2026-05-25 03:07:09.889746 | 2026-05-25 03:07:09.889918 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-25 03:07:09.959749 | debian-bookworm | skipping: Conditional result was False 2026-05-25 03:07:09.972167 | 2026-05-25 03:07:09.972322 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-25 03:07:10.505929 | debian-bookworm | ok 2026-05-25 03:07:10.523110 | 2026-05-25 03:07:10.523286 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-25 03:07:10.564167 | debian-bookworm | ok 2026-05-25 03:07:10.569530 | 2026-05-25 03:07:10.569640 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-25 03:07:10.921130 | debian-bookworm -> localhost | ok 2026-05-25 03:07:10.928539 | 2026-05-25 03:07:10.928660 | TASK [validate-host : Collect information about the host] 2026-05-25 03:07:12.217624 | debian-bookworm | ok 2026-05-25 03:07:12.248437 | 2026-05-25 03:07:12.248602 | TASK [validate-host : Sanitize hostname] 2026-05-25 03:07:12.401441 | debian-bookworm | ok 2026-05-25 03:07:12.534014 | 2026-05-25 03:07:12.534187 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-25 03:07:13.991594 | debian-bookworm -> localhost | changed 2026-05-25 03:07:13.997255 | 2026-05-25 03:07:13.997361 | TASK [validate-host : Collect information about zuul worker] 2026-05-25 03:07:14.577811 | debian-bookworm | ok 2026-05-25 03:07:14.581859 | 2026-05-25 03:07:14.582009 | TASK [validate-host : Write out all zuul information for each host] 2026-05-25 03:07:15.598705 | debian-bookworm -> localhost | changed 2026-05-25 03:07:15.607015 | 2026-05-25 03:07:15.607094 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-25 03:07:15.906302 | debian-bookworm | ok 2026-05-25 03:07:15.914445 | 2026-05-25 03:07:15.914562 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-25 03:07:16.778177 | debian-bookworm | changed: 2026-05-25 03:07:16.778361 | debian-bookworm | cd+++++++++ src/ 2026-05-25 03:07:16.778412 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-25 03:07:16.778438 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-25 03:07:16.778460 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-validations/ 2026-05-25 03:07:16.778481 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/2dccd5e9ee0e4863a545c153920e40bf/work/logs" 2026-05-25 03:07:50.814752 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/2dccd5e9ee0e4863a545c153920e40bf/work/artifacts" 2026-05-25 03:07:52.054308 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/2dccd5e9ee0e4863a545c153920e40bf/work/docs" 2026-05-25 03:07:52.069844 | 2026-05-25 03:07:52.069952 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-25 03:07:53.947590 | debian-bookworm | changed: 2026-05-25 03:07:53.947783 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-25 03:07:53.947812 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-25 03:07:53.947836 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-25 03:07:53.947875 | debian-bookworm | changed: All items complete 2026-05-25 03:07:53.947897 | 2026-05-25 03:07:55.058348 | debian-bookworm | changed: .d..t...... ./ 2026-05-25 03:07:56.396502 | debian-bookworm | changed: .d..t...... ./ 2026-05-25 03:07:56.406204 | 2026-05-25 03:07:56.406286 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-25 03:07:56.500947 | debian-bookworm | skipping: Conditional result was False 2026-05-25 03:07:56.523830 | debian-bookworm | skipping: Conditional result was False 2026-05-25 03:07:56.529693 | 2026-05-25 03:07:56.529751 | PLAY RECAP 2026-05-25 03:07:56.529790 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-25 03:07:56.529810 | 2026-05-25 03:07:56.770598 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-25 03:07:56.771383 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-25 03:07:59.462411 | 2026-05-25 03:07:59.462558 | PLAY [Base post] 2026-05-25 03:07:59.504099 | 2026-05-25 03:07:59.504243 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-25 03:08:00.696854 | debian-bookworm | changed 2026-05-25 03:08:00.707597 | 2026-05-25 03:08:00.707708 | PLAY RECAP 2026-05-25 03:08:00.707761 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-25 03:08:00.707813 | 2026-05-25 03:08:01.162091 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-25 03:08:01.162759 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-25 03:08:03.661400 | 2026-05-25 03:08:03.661559 | PLAY [Base post-logs] 2026-05-25 03:08:03.717147 | 2026-05-25 03:08:03.717288 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-25 03:08:04.921148 | localhost | changed 2026-05-25 03:08:04.932783 | 2026-05-25 03:08:04.932918 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-25 03:08:04.988080 | localhost | ok 2026-05-25 03:08:04.990814 | 2026-05-25 03:08:04.991047 | TASK [Set zuul-log-path fact] 2026-05-25 03:08:05.032606 | localhost | ok 2026-05-25 03:08:05.040926 | 2026-05-25 03:08:05.041038 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-25 03:08:05.109758 | localhost | ok 2026-05-25 03:08:05.112377 | 2026-05-25 03:08:05.112457 | TASK [upload-logs : Create log directories] 2026-05-25 03:08:06.881019 | localhost | changed 2026-05-25 03:08:06.883952 | 2026-05-25 03:08:06.884030 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-25 03:08:08.517682 | localhost -> localhost | ok: Runtime: 0:00:00.005441 2026-05-25 03:08:08.521065 | 2026-05-25 03:08:08.521156 | TASK [upload-logs : Upload logs to log server] 2026-05-25 03:08:10.631708 | localhost | Output suppressed because no_log was given 2026-05-25 03:08:10.633108 | 2026-05-25 03:08:10.633184 | LOOP [upload-logs : Compress console log and json output] 2026-05-25 03:08:10.718356 | localhost | skipping: Conditional result was False 2026-05-25 03:08:10.736029 | localhost | skipping: Conditional result was False 2026-05-25 03:08:10.740989 | 2026-05-25 03:08:10.741087 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-25 03:08:10.819500 | localhost | skipping: Conditional result was False 2026-05-25 03:08:10.819731 | 2026-05-25 03:08:10.826982 | localhost | skipping: Conditional result was False 2026-05-25 03:08:10.837132 | 2026-05-25 03:08:10.837233 | LOOP [upload-logs : Upload console log and json output]