2026-07-28 03:04:42.917591 | Job console starting 2026-07-28 03:04:42.968749 | Updating git repos 2026-07-28 03:04:42.998822 | Cloning repos into workspace 2026-07-28 03:04:43.060201 | Restoring repo states 2026-07-28 03:04:43.068959 | Merging changes 2026-07-28 03:04:43.068984 | Checking out repos 2026-07-28 03:04:43.110119 | Preparing playbooks 2026-07-28 03:04:44.428167 | Running Ansible setup 2026-07-28 03:04:50.243472 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-28 03:04:51.203094 | 2026-07-28 03:04:51.203283 | PLAY [Base pre] 2026-07-28 03:04:51.223132 | 2026-07-28 03:04:51.223283 | TASK [Setup log path fact] 2026-07-28 03:04:51.266524 | debian-bookworm | ok 2026-07-28 03:04:51.288531 | 2026-07-28 03:04:51.288721 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-28 03:04:51.334181 | debian-bookworm | ok 2026-07-28 03:04:51.350884 | 2026-07-28 03:04:51.351075 | TASK [emit-job-header : Print job information] 2026-07-28 03:04:51.402404 | # Job Information 2026-07-28 03:04:51.402612 | Ansible Version: 2.16.14 2026-07-28 03:04:51.402649 | Job: python-black 2026-07-28 03:04:51.402684 | Pipeline: periodic-daily 2026-07-28 03:04:51.402707 | Executor: 521e9411259a 2026-07-28 03:04:51.402728 | Triggered by: https://github.com/osism/openstack-sandbox-manager 2026-07-28 03:04:51.402750 | Event ID: ae39ef1949b547ebbc2b33de536518cb 2026-07-28 03:04:51.412385 | 2026-07-28 03:04:51.412531 | LOOP [emit-job-header : Print node information] 2026-07-28 03:04:51.672362 | debian-bookworm | ok: 2026-07-28 03:04:51.672634 | debian-bookworm | # Node Information 2026-07-28 03:04:51.672674 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-28 03:04:51.672701 | debian-bookworm | Hostname: debian 2026-07-28 03:04:51.672723 | debian-bookworm | Username: zuul 2026-07-28 03:04:51.672745 | debian-bookworm | Distro: Debian 12.15 2026-07-28 03:04:51.672768 | debian-bookworm | Provider: regiocloud-a 2026-07-28 03:04:51.672790 | debian-bookworm | Region: 2026-07-28 03:04:51.672810 | debian-bookworm | Label: debian-bookworm 2026-07-28 03:04:51.672830 | debian-bookworm | Product Name: OpenStack Nova 2026-07-28 03:04:51.672851 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe4b:1be1 2026-07-28 03:04:51.701128 | 2026-07-28 03:04:51.702467 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-28 03:04:52.771986 | debian-bookworm -> localhost | changed 2026-07-28 03:04:52.777790 | 2026-07-28 03:04:52.777883 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-28 03:04:54.157340 | debian-bookworm -> localhost | changed 2026-07-28 03:04:54.166588 | 2026-07-28 03:04:54.166688 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-28 03:04:54.489782 | debian-bookworm -> localhost | ok 2026-07-28 03:04:54.494973 | 2026-07-28 03:04:54.495071 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-28 03:04:54.524457 | debian-bookworm | ok 2026-07-28 03:04:54.546573 | debian-bookworm | included: /var/lib/zuul/builds/b777fff6938e40258184dcac59006554/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-28 03:04:54.556802 | 2026-07-28 03:04:54.556895 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-28 03:04:56.441944 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-28 03:04:56.442124 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/b777fff6938e40258184dcac59006554/work/b777fff6938e40258184dcac59006554_id_rsa 2026-07-28 03:04:56.442156 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/b777fff6938e40258184dcac59006554/work/b777fff6938e40258184dcac59006554_id_rsa.pub 2026-07-28 03:04:56.442177 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-28 03:04:56.442197 | debian-bookworm -> localhost | SHA256:U2Vy70cP9oGm+v8vhZsZ/qrcOf4uGPnkfhFf2ESGu64 zuul-build-sshkey 2026-07-28 03:04:56.442216 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-28 03:04:56.442241 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-28 03:04:56.442259 | debian-bookworm -> localhost | | . + oo| 2026-07-28 03:04:56.442278 | debian-bookworm -> localhost | | = .o..| 2026-07-28 03:04:56.442295 | debian-bookworm -> localhost | | . o+*.| 2026-07-28 03:04:56.442311 | debian-bookworm -> localhost | | . ooo==| 2026-07-28 03:04:56.442328 | debian-bookworm -> localhost | | S . ..oB| 2026-07-28 03:04:56.442346 | debian-bookworm -> localhost | | .. o =oo| 2026-07-28 03:04:56.442362 | debian-bookworm -> localhost | | . O *.| 2026-07-28 03:04:56.442379 | debian-bookworm -> localhost | | ....%..| 2026-07-28 03:04:56.442395 | debian-bookworm -> localhost | | .E*B@*| 2026-07-28 03:04:56.442412 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-28 03:04:56.442449 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.230606 2026-07-28 03:04:56.448264 | 2026-07-28 03:04:56.448345 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-28 03:04:56.465162 | debian-bookworm | ok 2026-07-28 03:04:56.474938 | debian-bookworm | included: /var/lib/zuul/builds/b777fff6938e40258184dcac59006554/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-28 03:04:56.481596 | 2026-07-28 03:04:56.481671 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-28 03:04:56.514596 | debian-bookworm | skipping: Conditional result was False 2026-07-28 03:04:56.519689 | 2026-07-28 03:04:56.519773 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-28 03:04:57.311002 | debian-bookworm | changed 2026-07-28 03:04:57.323066 | 2026-07-28 03:04:57.323181 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-28 03:04:57.635850 | debian-bookworm | ok 2026-07-28 03:04:57.645201 | 2026-07-28 03:04:57.645300 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-28 03:04:58.438707 | debian-bookworm | changed 2026-07-28 03:04:58.444326 | 2026-07-28 03:04:58.444421 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-28 03:04:59.153578 | debian-bookworm | changed 2026-07-28 03:04:59.161005 | 2026-07-28 03:04:59.161161 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-28 03:04:59.190457 | debian-bookworm | skipping: Conditional result was False 2026-07-28 03:04:59.198553 | 2026-07-28 03:04:59.198679 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-28 03:04:59.774220 | debian-bookworm -> localhost | changed 2026-07-28 03:04:59.795153 | 2026-07-28 03:04:59.795273 | TASK [add-build-sshkey : Add back temp key] 2026-07-28 03:05:00.408772 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/b777fff6938e40258184dcac59006554/work/b777fff6938e40258184dcac59006554_id_rsa (zuul-build-sshkey) 2026-07-28 03:05:00.408988 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012342 2026-07-28 03:05:00.420097 | 2026-07-28 03:05:00.420202 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-28 03:05:01.017624 | debian-bookworm | ok 2026-07-28 03:05:01.031230 | 2026-07-28 03:05:01.031350 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-28 03:05:01.075371 | debian-bookworm | skipping: Conditional result was False 2026-07-28 03:05:01.091873 | 2026-07-28 03:05:01.091994 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-28 03:05:01.600694 | debian-bookworm | ok 2026-07-28 03:05:01.617533 | 2026-07-28 03:05:01.617646 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-28 03:05:01.651650 | debian-bookworm | ok 2026-07-28 03:05:01.656645 | 2026-07-28 03:05:01.656733 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-28 03:05:02.138304 | debian-bookworm -> localhost | ok 2026-07-28 03:05:02.143639 | 2026-07-28 03:05:02.143724 | TASK [validate-host : Collect information about the host] 2026-07-28 03:05:03.581610 | debian-bookworm | ok 2026-07-28 03:05:03.597916 | 2026-07-28 03:05:03.598109 | TASK [validate-host : Sanitize hostname] 2026-07-28 03:05:03.840620 | debian-bookworm | ok 2026-07-28 03:05:03.847915 | 2026-07-28 03:05:03.848000 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-28 03:05:04.820168 | debian-bookworm -> localhost | changed 2026-07-28 03:05:04.825719 | 2026-07-28 03:05:04.825802 | TASK [validate-host : Collect information about zuul worker] 2026-07-28 03:05:05.369508 | debian-bookworm | ok 2026-07-28 03:05:05.374389 | 2026-07-28 03:05:05.374489 | TASK [validate-host : Write out all zuul information for each host] 2026-07-28 03:05:06.572087 | debian-bookworm -> localhost | changed 2026-07-28 03:05:06.584959 | 2026-07-28 03:05:06.585087 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-28 03:05:06.914802 | debian-bookworm | ok 2026-07-28 03:05:06.919375 | 2026-07-28 03:05:06.919449 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-28 03:05:08.068161 | debian-bookworm | changed: 2026-07-28 03:05:08.068306 | debian-bookworm | cd+++++++++ src/ 2026-07-28 03:05:08.068334 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-28 03:05:08.068354 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-28 03:05:08.068372 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-sandbox-manager/ 2026-07-28 03:05:08.068389 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/b777fff6938e40258184dcac59006554/work/logs" 2026-07-28 03:06:13.620525 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/b777fff6938e40258184dcac59006554/work/artifacts" 2026-07-28 03:06:14.419248 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/b777fff6938e40258184dcac59006554/work/docs" 2026-07-28 03:06:14.433396 | 2026-07-28 03:06:14.433548 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-28 03:06:15.877947 | debian-bookworm | changed: 2026-07-28 03:06:15.878246 | debian-bookworm | .d..t...... ./ 2026-07-28 03:06:15.878288 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-28 03:06:15.878313 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-28 03:06:15.878334 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-28 03:06:15.878355 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-28 03:06:15.878376 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-28 03:06:15.878421 | debian-bookworm | changed: All items complete 2026-07-28 03:06:15.878447 | 2026-07-28 03:06:16.535637 | debian-bookworm | changed: .d..t...... ./ 2026-07-28 03:06:17.203149 | debian-bookworm | changed: .d..t...... ./ 2026-07-28 03:06:17.233222 | 2026-07-28 03:06:17.233347 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-28 03:06:17.261025 | debian-bookworm | skipping: Conditional result was False 2026-07-28 03:06:17.264973 | debian-bookworm | skipping: Conditional result was False 2026-07-28 03:06:17.274596 | 2026-07-28 03:06:17.274805 | PLAY RECAP 2026-07-28 03:06:17.275263 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-07-28 03:06:17.275352 | 2026-07-28 03:06:17.397958 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-28 03:06:17.398800 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-28 03:06:18.401664 | 2026-07-28 03:06:18.401813 | PLAY [Base post] 2026-07-28 03:06:18.416962 | 2026-07-28 03:06:18.417094 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-28 03:06:18.964445 | debian-bookworm | changed 2026-07-28 03:06:18.971728 | 2026-07-28 03:06:18.971817 | PLAY RECAP 2026-07-28 03:06:18.971869 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-28 03:06:18.971920 | 2026-07-28 03:06:19.084558 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-28 03:06:19.085341 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-28 03:06:20.109809 | 2026-07-28 03:06:20.109976 | PLAY [Base post-logs] 2026-07-28 03:06:20.142778 | 2026-07-28 03:06:20.142968 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-28 03:06:20.876113 | localhost | changed 2026-07-28 03:06:20.886733 | 2026-07-28 03:06:20.886904 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-28 03:06:20.911713 | localhost | ok 2026-07-28 03:06:20.914816 | 2026-07-28 03:06:20.917174 | TASK [Set zuul-log-path fact] 2026-07-28 03:06:20.937100 | localhost | ok 2026-07-28 03:06:20.956804 | 2026-07-28 03:06:20.956907 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-28 03:06:20.982256 | localhost | ok 2026-07-28 03:06:20.985218 | 2026-07-28 03:06:20.985310 | TASK [upload-logs : Create log directories] 2026-07-28 03:06:21.753758 | localhost | changed 2026-07-28 03:06:21.756107 | 2026-07-28 03:06:21.756239 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-28 03:06:22.425956 | localhost -> localhost | ok: Runtime: 0:00:00.020658 2026-07-28 03:06:22.429071 | 2026-07-28 03:06:22.429156 | TASK [upload-logs : Upload logs to log server] 2026-07-28 03:06:22.981460 | localhost | Output suppressed because no_log was given 2026-07-28 03:06:22.983099 | 2026-07-28 03:06:22.983179 | LOOP [upload-logs : Compress console log and json output] 2026-07-28 03:06:23.025605 | localhost | skipping: Conditional result was False 2026-07-28 03:06:23.031184 | localhost | skipping: Conditional result was False 2026-07-28 03:06:23.040057 | 2026-07-28 03:06:23.040195 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-28 03:06:23.089625 | localhost | skipping: Conditional result was False 2026-07-28 03:06:23.089871 | 2026-07-28 03:06:23.102971 | localhost | skipping: Conditional result was False 2026-07-28 03:06:23.106791 | 2026-07-28 03:06:23.106939 | LOOP [upload-logs : Upload console log and json output]