2026-07-09 03:02:04.650473 | Job console starting 2026-07-09 03:02:04.656836 | Updating git repos 2026-07-09 03:02:04.711951 | Cloning repos into workspace 2026-07-09 03:02:04.833078 | Restoring repo states 2026-07-09 03:02:04.859603 | Merging changes 2026-07-09 03:02:04.859619 | Checking out repos 2026-07-09 03:02:04.975838 | Preparing playbooks 2026-07-09 03:02:06.867788 | Running Ansible setup 2026-07-09 03:02:14.486970 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-09 03:02:16.412129 | 2026-07-09 03:02:16.412258 | PLAY [Base pre] 2026-07-09 03:02:16.474871 | 2026-07-09 03:02:16.475002 | TASK [Setup log path fact] 2026-07-09 03:02:16.518104 | debian-bookworm | ok 2026-07-09 03:02:16.555674 | 2026-07-09 03:02:16.557201 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-09 03:02:16.608994 | debian-bookworm | ok 2026-07-09 03:02:16.621041 | 2026-07-09 03:02:16.621153 | TASK [emit-job-header : Print job information] 2026-07-09 03:02:16.711401 | # Job Information 2026-07-09 03:02:16.711605 | Ansible Version: 2.16.14 2026-07-09 03:02:16.711639 | Job: python-black 2026-07-09 03:02:16.711671 | Pipeline: periodic-daily 2026-07-09 03:02:16.711694 | Executor: 521e9411259a 2026-07-09 03:02:16.711711 | Triggered by: https://github.com/osism/openstack-health-middleware 2026-07-09 03:02:16.711730 | Event ID: 5d96db0934424024aa8890dc4e968599 2026-07-09 03:02:16.722481 | 2026-07-09 03:02:16.722588 | LOOP [emit-job-header : Print node information] 2026-07-09 03:02:16.920067 | debian-bookworm | ok: 2026-07-09 03:02:16.920260 | debian-bookworm | # Node Information 2026-07-09 03:02:16.920291 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-09 03:02:16.920311 | debian-bookworm | Hostname: debian 2026-07-09 03:02:16.920329 | debian-bookworm | Username: zuul 2026-07-09 03:02:16.920345 | debian-bookworm | Distro: Debian 12.14 2026-07-09 03:02:16.920365 | debian-bookworm | Provider: regiocloud-a 2026-07-09 03:02:16.920382 | debian-bookworm | Region: 2026-07-09 03:02:16.920400 | debian-bookworm | Label: debian-bookworm 2026-07-09 03:02:16.920416 | debian-bookworm | Product Name: OpenStack Nova 2026-07-09 03:02:16.920431 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fef2:1936 2026-07-09 03:02:16.941467 | 2026-07-09 03:02:16.941576 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-09 03:02:18.060502 | debian-bookworm -> localhost | changed 2026-07-09 03:02:18.066459 | 2026-07-09 03:02:18.066552 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-09 03:02:20.922598 | debian-bookworm -> localhost | changed 2026-07-09 03:02:20.935444 | 2026-07-09 03:02:20.935544 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-09 03:02:21.296288 | debian-bookworm -> localhost | ok 2026-07-09 03:02:21.301524 | 2026-07-09 03:02:21.301621 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-09 03:02:21.340783 | debian-bookworm | ok 2026-07-09 03:02:21.358998 | debian-bookworm | included: /var/lib/zuul/builds/2adc8611e6484c13be8bc33cdd463423/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-09 03:02:21.365159 | 2026-07-09 03:02:21.365253 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-09 03:02:22.255669 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-09 03:02:22.255837 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/2adc8611e6484c13be8bc33cdd463423/work/2adc8611e6484c13be8bc33cdd463423_id_rsa 2026-07-09 03:02:22.255868 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/2adc8611e6484c13be8bc33cdd463423/work/2adc8611e6484c13be8bc33cdd463423_id_rsa.pub 2026-07-09 03:02:22.255889 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-09 03:02:22.255908 | debian-bookworm -> localhost | SHA256:PVc1cqKqZw+LC2jbLziUbt4U5g3tSiX15Uq/Z+L2q9E zuul-build-sshkey 2026-07-09 03:02:22.255926 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-09 03:02:22.255953 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-09 03:02:22.255971 | debian-bookworm -> localhost | | o o.| 2026-07-09 03:02:22.256014 | debian-bookworm -> localhost | | . +..| 2026-07-09 03:02:22.256032 | debian-bookworm -> localhost | | . o . | 2026-07-09 03:02:22.256048 | debian-bookworm -> localhost | | o ..+ . | 2026-07-09 03:02:22.256064 | debian-bookworm -> localhost | | .= oS+o.. | 2026-07-09 03:02:22.256084 | debian-bookworm -> localhost | | o+ B o oo. | 2026-07-09 03:02:22.256101 | debian-bookworm -> localhost | | oo.= + = o E | 2026-07-09 03:02:22.256117 | debian-bookworm -> localhost | | .=*.o + +ooo | 2026-07-09 03:02:22.256134 | debian-bookworm -> localhost | | oo.+o+..o=*o. | 2026-07-09 03:02:22.256151 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-09 03:02:22.256192 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.434218 2026-07-09 03:02:22.261264 | 2026-07-09 03:02:22.261343 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-09 03:02:22.277424 | debian-bookworm | ok 2026-07-09 03:02:22.285468 | debian-bookworm | included: /var/lib/zuul/builds/2adc8611e6484c13be8bc33cdd463423/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-09 03:02:22.291872 | 2026-07-09 03:02:22.291949 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-09 03:02:22.304519 | debian-bookworm | skipping: Conditional result was False 2026-07-09 03:02:22.309060 | 2026-07-09 03:02:22.309133 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-09 03:02:22.870774 | debian-bookworm | changed 2026-07-09 03:02:22.875391 | 2026-07-09 03:02:22.875470 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-09 03:02:23.104211 | debian-bookworm | ok 2026-07-09 03:02:23.109570 | 2026-07-09 03:02:23.109707 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-09 03:02:23.659564 | debian-bookworm | changed 2026-07-09 03:02:23.672485 | 2026-07-09 03:02:23.672587 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-09 03:02:24.266087 | debian-bookworm | changed 2026-07-09 03:02:24.271417 | 2026-07-09 03:02:24.271503 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-09 03:02:24.314549 | debian-bookworm | skipping: Conditional result was False 2026-07-09 03:02:24.320794 | 2026-07-09 03:02:24.320906 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-09 03:02:24.836190 | debian-bookworm -> localhost | changed 2026-07-09 03:02:24.846916 | 2026-07-09 03:02:24.847055 | TASK [add-build-sshkey : Add back temp key] 2026-07-09 03:02:25.219203 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/2adc8611e6484c13be8bc33cdd463423/work/2adc8611e6484c13be8bc33cdd463423_id_rsa (zuul-build-sshkey) 2026-07-09 03:02:25.219446 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.028845 2026-07-09 03:02:25.226754 | 2026-07-09 03:02:25.226882 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-09 03:02:25.622957 | debian-bookworm | ok 2026-07-09 03:02:25.628278 | 2026-07-09 03:02:25.628381 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-09 03:02:25.654485 | debian-bookworm | skipping: Conditional result was False 2026-07-09 03:02:25.676573 | 2026-07-09 03:02:25.676686 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-09 03:02:26.107415 | debian-bookworm | ok 2026-07-09 03:02:26.118564 | 2026-07-09 03:02:26.118670 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-09 03:02:26.157225 | debian-bookworm | ok 2026-07-09 03:02:26.162278 | 2026-07-09 03:02:26.162364 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-09 03:02:26.529038 | debian-bookworm -> localhost | ok 2026-07-09 03:02:26.535785 | 2026-07-09 03:02:26.535882 | TASK [validate-host : Collect information about the host] 2026-07-09 03:02:27.722016 | debian-bookworm | ok 2026-07-09 03:02:27.735029 | 2026-07-09 03:02:27.735142 | TASK [validate-host : Sanitize hostname] 2026-07-09 03:02:27.875626 | debian-bookworm | ok 2026-07-09 03:02:27.880443 | 2026-07-09 03:02:27.880534 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-09 03:02:28.407271 | debian-bookworm -> localhost | changed 2026-07-09 03:02:28.413179 | 2026-07-09 03:02:28.413276 | TASK [validate-host : Collect information about zuul worker] 2026-07-09 03:02:28.843844 | debian-bookworm | ok 2026-07-09 03:02:28.851730 | 2026-07-09 03:02:28.851889 | TASK [validate-host : Write out all zuul information for each host] 2026-07-09 03:02:29.424308 | debian-bookworm -> localhost | changed 2026-07-09 03:02:29.448447 | 2026-07-09 03:02:29.448692 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-09 03:02:29.728137 | debian-bookworm | ok 2026-07-09 03:02:29.735503 | 2026-07-09 03:02:29.735626 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-09 03:02:30.658770 | debian-bookworm | changed: 2026-07-09 03:02:30.659216 | debian-bookworm | cd+++++++++ src/ 2026-07-09 03:02:30.659257 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-09 03:02:30.659282 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-09 03:02:30.659305 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-health-middleware/ 2026-07-09 03:02:30.659324 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/2adc8611e6484c13be8bc33cdd463423/work/logs" 2026-07-09 03:03:38.778940 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/2adc8611e6484c13be8bc33cdd463423/work/artifacts" 2026-07-09 03:03:39.445160 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/2adc8611e6484c13be8bc33cdd463423/work/docs" 2026-07-09 03:03:39.459766 | 2026-07-09 03:03:39.459916 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-09 03:03:40.739802 | debian-bookworm | changed: 2026-07-09 03:03:40.739991 | debian-bookworm | .d..t...... ./ 2026-07-09 03:03:40.740023 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-09 03:03:40.740043 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-09 03:03:40.740060 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-09 03:03:40.740077 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-09 03:03:40.740094 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-09 03:03:40.740131 | debian-bookworm | changed: All items complete 2026-07-09 03:03:40.740153 | 2026-07-09 03:03:41.575241 | debian-bookworm | changed: .d..t...... ./ 2026-07-09 03:03:42.813014 | debian-bookworm | changed: .d..t...... ./ 2026-07-09 03:03:42.832681 | 2026-07-09 03:03:42.832781 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-09 03:03:42.862198 | debian-bookworm | skipping: Conditional result was False 2026-07-09 03:03:42.866187 | debian-bookworm | skipping: Conditional result was False 2026-07-09 03:03:42.875096 | 2026-07-09 03:03:42.875164 | PLAY RECAP 2026-07-09 03:03:42.875207 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-07-09 03:03:42.875227 | 2026-07-09 03:03:43.094786 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-09 03:03:43.095568 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-09 03:03:43.909683 | 2026-07-09 03:03:43.909806 | PLAY [Base post] 2026-07-09 03:03:43.949149 | 2026-07-09 03:03:43.949310 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-09 03:03:44.835575 | debian-bookworm | changed 2026-07-09 03:03:44.844528 | 2026-07-09 03:03:44.844642 | PLAY RECAP 2026-07-09 03:03:44.844704 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-09 03:03:44.844766 | 2026-07-09 03:03:45.067552 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-09 03:03:45.068308 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-09 03:03:46.433214 | 2026-07-09 03:03:46.433346 | PLAY [Base post-logs] 2026-07-09 03:03:46.459731 | 2026-07-09 03:03:46.459863 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-09 03:03:47.614207 | localhost | changed 2026-07-09 03:03:47.624270 | 2026-07-09 03:03:47.624391 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-09 03:03:47.672191 | localhost | ok 2026-07-09 03:03:47.674645 | 2026-07-09 03:03:47.674723 | TASK [Set zuul-log-path fact] 2026-07-09 03:03:47.702890 | localhost | ok 2026-07-09 03:03:47.721667 | 2026-07-09 03:03:47.721771 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-09 03:03:47.804623 | localhost | ok 2026-07-09 03:03:47.808042 | 2026-07-09 03:03:47.808124 | TASK [upload-logs : Create log directories] 2026-07-09 03:03:48.281296 | localhost | changed 2026-07-09 03:03:48.283475 | 2026-07-09 03:03:48.283553 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-09 03:03:48.926248 | localhost -> localhost | ok: Runtime: 0:00:00.020263 2026-07-09 03:03:48.930595 | 2026-07-09 03:03:48.930681 | TASK [upload-logs : Upload logs to log server] 2026-07-09 03:03:49.786446 | localhost | Output suppressed because no_log was given 2026-07-09 03:03:49.787920 | 2026-07-09 03:03:49.788027 | LOOP [upload-logs : Compress console log and json output] 2026-07-09 03:03:49.883284 | localhost | skipping: Conditional result was False 2026-07-09 03:03:49.897928 | localhost | skipping: Conditional result was False 2026-07-09 03:03:49.908827 | 2026-07-09 03:03:49.908920 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-09 03:03:49.955050 | localhost | skipping: Conditional result was False 2026-07-09 03:03:49.955267 | 2026-07-09 03:03:49.961320 | localhost | skipping: Conditional result was False 2026-07-09 03:03:49.967915 | 2026-07-09 03:03:49.968027 | LOOP [upload-logs : Upload console log and json output]