2026-05-18 09:43:58.665404 | Job console starting 2026-05-18 09:43:58.676581 | Updating git repos 2026-05-18 09:43:58.754811 | Cloning repos into workspace 2026-05-18 09:43:58.958351 | Restoring repo states 2026-05-18 09:43:58.995323 | Merging changes 2026-05-18 09:43:59.695678 | Checking out repos 2026-05-18 09:43:59.773010 | Preparing playbooks 2026-05-18 09:44:01.229195 | Running Ansible setup 2026-05-18 09:44:07.485575 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-18 09:44:09.473244 | 2026-05-18 09:44:09.473366 | PLAY [Base pre] 2026-05-18 09:44:09.516053 | 2026-05-18 09:44:09.516163 | TASK [Setup log path fact] 2026-05-18 09:44:09.549020 | debian-bookworm | ok 2026-05-18 09:44:09.566748 | 2026-05-18 09:44:09.578961 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-18 09:44:09.628681 | debian-bookworm | ok 2026-05-18 09:44:09.648820 | 2026-05-18 09:44:09.648940 | TASK [emit-job-header : Print job information] 2026-05-18 09:44:09.739660 | # Job Information 2026-05-18 09:44:09.739801 | Ansible Version: 2.16.14 2026-05-18 09:44:09.739830 | Job: flake8 2026-05-18 09:44:09.739857 | Pipeline: check 2026-05-18 09:44:09.739876 | Executor: 521e9411259a 2026-05-18 09:44:09.739906 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1207 2026-05-18 09:44:09.739925 | Event ID: 12731b80-529e-11f1-949f-a247c0e75d52 2026-05-18 09:44:09.743869 | 2026-05-18 09:44:09.743974 | LOOP [emit-job-header : Print node information] 2026-05-18 09:44:10.039618 | debian-bookworm | ok: 2026-05-18 09:44:10.039850 | debian-bookworm | # Node Information 2026-05-18 09:44:10.039926 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-18 09:44:10.039960 | debian-bookworm | Hostname: debian 2026-05-18 09:44:10.039987 | debian-bookworm | Username: zuul 2026-05-18 09:44:10.040013 | debian-bookworm | Distro: Debian 12.14 2026-05-18 09:44:10.040042 | debian-bookworm | Provider: regiocloud-a 2026-05-18 09:44:10.040069 | debian-bookworm | Region: 2026-05-18 09:44:10.040095 | debian-bookworm | Label: debian-bookworm 2026-05-18 09:44:10.040120 | debian-bookworm | Product Name: OpenStack Nova 2026-05-18 09:44:10.040143 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe54:4a89 2026-05-18 09:44:10.056171 | 2026-05-18 09:44:10.056279 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-18 09:44:10.662059 | debian-bookworm -> localhost | changed 2026-05-18 09:44:10.681789 | 2026-05-18 09:44:10.681966 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-18 09:44:13.037952 | debian-bookworm -> localhost | changed 2026-05-18 09:44:13.049173 | 2026-05-18 09:44:13.049272 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-18 09:44:13.601174 | debian-bookworm -> localhost | ok 2026-05-18 09:44:13.607140 | 2026-05-18 09:44:13.607247 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-18 09:44:13.647045 | debian-bookworm | ok 2026-05-18 09:44:13.698209 | debian-bookworm | included: /var/lib/zuul/builds/15295a98389b422184fb7cf2a4f88865/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-18 09:44:13.721617 | 2026-05-18 09:44:13.721759 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-18 09:44:15.584541 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-18 09:44:15.584791 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/15295a98389b422184fb7cf2a4f88865/work/15295a98389b422184fb7cf2a4f88865_id_rsa 2026-05-18 09:44:15.584829 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/15295a98389b422184fb7cf2a4f88865/work/15295a98389b422184fb7cf2a4f88865_id_rsa.pub 2026-05-18 09:44:15.584855 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-18 09:44:15.584879 | debian-bookworm -> localhost | SHA256:D+av0Kfevta+Mg9yJNOzH9eEkOYJgAwv1FFnnB9IeLg zuul-build-sshkey 2026-05-18 09:44:15.584901 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-18 09:44:15.584962 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-18 09:44:15.584986 | debian-bookworm -> localhost | | o+.+o=+o | 2026-05-18 09:44:15.585008 | debian-bookworm -> localhost | | . .+ o+= .. | 2026-05-18 09:44:15.585029 | debian-bookworm -> localhost | | . . o..+. | 2026-05-18 09:44:15.585049 | debian-bookworm -> localhost | | . E. +.o . | 2026-05-18 09:44:15.585070 | debian-bookworm -> localhost | | S + o . .| 2026-05-18 09:44:15.585096 | debian-bookworm -> localhost | | + * o o | 2026-05-18 09:44:15.585117 | debian-bookworm -> localhost | | . + *.. . .| 2026-05-18 09:44:15.585137 | debian-bookworm -> localhost | | . B+o.o | 2026-05-18 09:44:15.585158 | debian-bookworm -> localhost | | .++=*=. | 2026-05-18 09:44:15.585178 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-18 09:44:15.585233 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.938748 2026-05-18 09:44:15.591965 | 2026-05-18 09:44:15.592083 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-18 09:44:15.674713 | debian-bookworm | ok 2026-05-18 09:44:15.695339 | debian-bookworm | included: /var/lib/zuul/builds/15295a98389b422184fb7cf2a4f88865/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-18 09:44:15.718941 | 2026-05-18 09:44:15.719079 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-18 09:44:15.745810 | debian-bookworm | skipping: Conditional result was False 2026-05-18 09:44:15.757346 | 2026-05-18 09:44:15.757454 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-18 09:44:16.401726 | debian-bookworm | changed 2026-05-18 09:44:16.410861 | 2026-05-18 09:44:16.410990 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-18 09:44:16.681180 | debian-bookworm | ok 2026-05-18 09:44:16.686821 | 2026-05-18 09:44:16.687007 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-18 09:44:17.341145 | debian-bookworm | changed 2026-05-18 09:44:17.348621 | 2026-05-18 09:44:17.348845 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-18 09:44:18.022322 | debian-bookworm | changed 2026-05-18 09:44:18.028657 | 2026-05-18 09:44:18.028758 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-18 09:44:18.052111 | debian-bookworm | skipping: Conditional result was False 2026-05-18 09:44:18.057914 | 2026-05-18 09:44:18.058046 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-18 09:44:19.317475 | debian-bookworm -> localhost | changed 2026-05-18 09:44:19.340005 | 2026-05-18 09:44:19.340125 | TASK [add-build-sshkey : Add back temp key] 2026-05-18 09:44:20.376049 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/15295a98389b422184fb7cf2a4f88865/work/15295a98389b422184fb7cf2a4f88865_id_rsa (zuul-build-sshkey) 2026-05-18 09:44:20.376356 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.032246 2026-05-18 09:44:20.383913 | 2026-05-18 09:44:20.384124 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-18 09:44:21.056581 | debian-bookworm | ok 2026-05-18 09:44:21.063694 | 2026-05-18 09:44:21.063798 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-18 09:44:21.097533 | debian-bookworm | skipping: Conditional result was False 2026-05-18 09:44:21.109814 | 2026-05-18 09:44:21.109923 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-18 09:44:21.719966 | debian-bookworm | ok 2026-05-18 09:44:21.772896 | 2026-05-18 09:44:21.773083 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-18 09:44:21.906203 | debian-bookworm | ok 2026-05-18 09:44:21.929199 | 2026-05-18 09:44:21.929340 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-18 09:44:22.468851 | debian-bookworm -> localhost | ok 2026-05-18 09:44:22.474004 | 2026-05-18 09:44:22.474088 | TASK [validate-host : Collect information about the host] 2026-05-18 09:44:23.550258 | debian-bookworm | ok 2026-05-18 09:44:23.565200 | 2026-05-18 09:44:23.565530 | TASK [validate-host : Sanitize hostname] 2026-05-18 09:44:23.759052 | debian-bookworm | ok 2026-05-18 09:44:23.814730 | 2026-05-18 09:44:23.814954 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-18 09:44:24.505196 | debian-bookworm -> localhost | changed 2026-05-18 09:44:24.512110 | 2026-05-18 09:44:24.512208 | TASK [validate-host : Collect information about zuul worker] 2026-05-18 09:44:24.986369 | debian-bookworm | ok 2026-05-18 09:44:24.992313 | 2026-05-18 09:44:24.992427 | TASK [validate-host : Write out all zuul information for each host] 2026-05-18 09:44:25.882869 | debian-bookworm -> localhost | changed 2026-05-18 09:44:25.896604 | 2026-05-18 09:44:25.896712 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-18 09:44:26.161617 | debian-bookworm | ok 2026-05-18 09:44:26.169218 | 2026-05-18 09:44:26.169325 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-18 09:44:27.233787 | debian-bookworm | changed: 2026-05-18 09:44:27.234123 | debian-bookworm | cd+++++++++ src/ 2026-05-18 09:44:27.234201 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-18 09:44:27.234230 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-18 09:44:27.234253 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-05-18 09:44:27.234274 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/15295a98389b422184fb7cf2a4f88865/work/logs" 2026-05-18 09:44:58.267852 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/15295a98389b422184fb7cf2a4f88865/work/artifacts" 2026-05-18 09:44:58.712565 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/15295a98389b422184fb7cf2a4f88865/work/docs" 2026-05-18 09:44:58.727576 | 2026-05-18 09:44:58.727712 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-18 09:44:59.998500 | debian-bookworm | changed: 2026-05-18 09:44:59.998697 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-18 09:44:59.998734 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-18 09:44:59.998770 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-18 09:44:59.998820 | debian-bookworm | changed: All items complete 2026-05-18 09:44:59.998863 | 2026-05-18 09:45:01.101214 | debian-bookworm | changed: .d..t...... ./ 2026-05-18 09:45:01.630616 | debian-bookworm | changed: .d..t...... ./ 2026-05-18 09:45:01.652195 | 2026-05-18 09:45:01.652314 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-18 09:45:02.302134 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.016128 2026-05-18 09:45:02.914176 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.023164 2026-05-18 09:45:02.921857 | 2026-05-18 09:45:02.921932 | PLAY RECAP 2026-05-18 09:45:02.921979 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-18 09:45:02.922005 | 2026-05-18 09:45:03.149971 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-18 09:45:03.150703 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-18 09:45:04.064819 | 2026-05-18 09:45:04.064952 | PLAY [Base post] 2026-05-18 09:45:04.077085 | 2026-05-18 09:45:04.077238 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-18 09:45:04.650755 | debian-bookworm | changed 2026-05-18 09:45:04.657259 | 2026-05-18 09:45:04.657368 | PLAY RECAP 2026-05-18 09:45:04.657429 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-18 09:45:04.657491 | 2026-05-18 09:45:04.773454 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-18 09:45:04.774215 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-18 09:45:05.865048 | 2026-05-18 09:45:05.865226 | PLAY [Base post-logs] 2026-05-18 09:45:05.884047 | 2026-05-18 09:45:05.884210 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-18 09:45:07.220184 | localhost | changed 2026-05-18 09:45:07.229086 | 2026-05-18 09:45:07.229229 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-18 09:45:07.275460 | localhost | ok 2026-05-18 09:45:07.277967 | 2026-05-18 09:45:07.278040 | TASK [Set zuul-log-path fact] 2026-05-18 09:45:07.293233 | localhost | ok 2026-05-18 09:45:07.300587 | 2026-05-18 09:45:07.300683 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-18 09:45:07.356419 | localhost | ok 2026-05-18 09:45:07.358983 | 2026-05-18 09:45:07.359059 | TASK [upload-logs : Create log directories] 2026-05-18 09:45:08.065575 | localhost | changed 2026-05-18 09:45:08.067802 | 2026-05-18 09:45:08.067880 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-18 09:45:08.961526 | localhost -> localhost | ok: Runtime: 0:00:00.010684 2026-05-18 09:45:08.964751 | 2026-05-18 09:45:08.964831 | TASK [upload-logs : Upload logs to log server] 2026-05-18 09:45:10.011792 | localhost | Output suppressed because no_log was given 2026-05-18 09:45:10.013367 | 2026-05-18 09:45:10.013446 | LOOP [upload-logs : Compress console log and json output] 2026-05-18 09:45:10.132262 | localhost | skipping: Conditional result was False 2026-05-18 09:45:10.143371 | localhost | skipping: Conditional result was False 2026-05-18 09:45:10.152191 | 2026-05-18 09:45:10.152282 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-18 09:45:10.277691 | localhost | skipping: Conditional result was False 2026-05-18 09:45:10.277980 | 2026-05-18 09:45:10.285943 | localhost | skipping: Conditional result was False 2026-05-18 09:45:10.292314 | 2026-05-18 09:45:10.292413 | LOOP [upload-logs : Upload console log and json output]