2026-10-03 03:04:42.252152 | Job console starting 2026-10-03 03:04:42.257856 | Updating git repos 2026-10-03 03:04:42.282557 | Cloning repos into workspace 2026-10-03 03:04:42.339378 | Restoring repo states 2026-10-03 03:04:42.351375 | Merging changes 2026-10-03 03:04:42.351387 | Checking out repos 2026-10-03 03:04:42.412852 | Preparing playbooks 2026-10-03 03:04:43.647653 | Running Ansible setup 2026-10-03 03:04:53.287328 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-10-03 03:04:54.018354 | 2026-10-03 03:04:54.018479 | PLAY [Base pre] 2026-10-03 03:04:54.039411 | 2026-10-03 03:04:54.039584 | TASK [Setup log path fact] 2026-10-03 03:04:54.067487 | debian-bookworm | ok 2026-10-03 03:04:54.082620 | 2026-10-03 03:04:54.082733 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-10-03 03:04:54.110222 | debian-bookworm | ok 2026-10-03 03:04:54.119850 | 2026-10-03 03:04:54.119955 | TASK [emit-job-header : Print job information] 2026-10-03 03:04:54.148879 | # Job Information 2026-10-03 03:04:54.149091 | Ansible Version: 2.16.14 2026-10-03 03:04:54.149130 | Job: python-black 2026-10-03 03:04:54.149166 | Pipeline: periodic-daily 2026-10-03 03:04:54.149194 | Executor: 521e9411259a 2026-10-03 03:04:54.149215 | Triggered by: https://github.com/osism/openstack-sandbox-manager 2026-10-03 03:04:54.149263 | Event ID: 691136b66d2f4ea297c3e20fc7ffe9fd 2026-10-03 03:04:54.154274 | 2026-10-03 03:04:54.154380 | LOOP [emit-job-header : Print node information] 2026-10-03 03:04:54.255736 | debian-bookworm | ok: 2026-10-03 03:04:54.255908 | debian-bookworm | # Node Information 2026-10-03 03:04:54.255944 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-10-03 03:04:54.255970 | debian-bookworm | Hostname: debian 2026-10-03 03:04:54.255992 | debian-bookworm | Username: zuul 2026-10-03 03:04:54.256013 | debian-bookworm | Distro: Debian 12.15 2026-10-03 03:04:54.256037 | debian-bookworm | Provider: regiocloud-a 2026-10-03 03:04:54.256059 | debian-bookworm | Region: 2026-10-03 03:04:54.256080 | debian-bookworm | Label: debian-bookworm 2026-10-03 03:04:54.256102 | debian-bookworm | Product Name: OpenStack Nova 2026-10-03 03:04:54.256124 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe9f:8c98 2026-10-03 03:04:54.272018 | 2026-10-03 03:04:54.272133 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-10-03 03:04:54.939998 | debian-bookworm -> localhost | changed 2026-10-03 03:04:54.946889 | 2026-10-03 03:04:54.946988 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-10-03 03:04:56.421998 | debian-bookworm -> localhost | changed 2026-10-03 03:04:56.432831 | 2026-10-03 03:04:56.432927 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-10-03 03:04:56.751592 | debian-bookworm -> localhost | ok 2026-10-03 03:04:56.757542 | 2026-10-03 03:04:56.757657 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-10-03 03:04:56.798366 | debian-bookworm | ok 2026-10-03 03:04:56.819488 | debian-bookworm | included: /var/lib/zuul/builds/363b5c6f60e3488cb5d732ae05e2d141/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-10-03 03:04:56.825441 | 2026-10-03 03:04:56.825537 | TASK [add-build-sshkey : Create Temp SSH key] 2026-10-03 03:05:00.742313 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-10-03 03:05:00.742490 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/363b5c6f60e3488cb5d732ae05e2d141/work/363b5c6f60e3488cb5d732ae05e2d141_id_rsa 2026-10-03 03:05:00.742522 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/363b5c6f60e3488cb5d732ae05e2d141/work/363b5c6f60e3488cb5d732ae05e2d141_id_rsa.pub 2026-10-03 03:05:00.742545 | debian-bookworm -> localhost | The key fingerprint is: 2026-10-03 03:05:00.742565 | debian-bookworm -> localhost | SHA256:ap7b/ZCeR5Try/XyGcBFHUQDEs2ljDyNQgl+AfG8C0g zuul-build-sshkey 2026-10-03 03:05:00.742584 | debian-bookworm -> localhost | The key's randomart image is: 2026-10-03 03:05:00.742611 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-10-03 03:05:00.742629 | debian-bookworm -> localhost | | ++o.o+.=Bo| 2026-10-03 03:05:00.742647 | debian-bookworm -> localhost | | . +.o *oo o| 2026-10-03 03:05:00.742664 | debian-bookworm -> localhost | | E . = = = . | 2026-10-03 03:05:00.742680 | debian-bookworm -> localhost | | . . . o = . | 2026-10-03 03:05:00.742697 | debian-bookworm -> localhost | | . .S. . + | 2026-10-03 03:05:00.742716 | debian-bookworm -> localhost | | .. ..o . | 2026-10-03 03:05:00.742732 | debian-bookworm -> localhost | | o .oo .. | 2026-10-03 03:05:00.742749 | debian-bookworm -> localhost | | o o o +o...o| 2026-10-03 03:05:00.742766 | debian-bookworm -> localhost | | +.. +o+. +o| 2026-10-03 03:05:00.742783 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-10-03 03:05:00.742827 | debian-bookworm -> localhost | ok: Runtime: 0:00:03.009325 2026-10-03 03:05:00.761059 | 2026-10-03 03:05:00.761150 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-10-03 03:05:00.798437 | debian-bookworm | ok 2026-10-03 03:05:00.820804 | debian-bookworm | included: /var/lib/zuul/builds/363b5c6f60e3488cb5d732ae05e2d141/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-10-03 03:05:00.837449 | 2026-10-03 03:05:00.840621 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-10-03 03:05:00.863511 | debian-bookworm | skipping: Conditional result was False 2026-10-03 03:05:00.868620 | 2026-10-03 03:05:00.868712 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-10-03 03:05:01.774210 | debian-bookworm | changed 2026-10-03 03:05:01.778679 | 2026-10-03 03:05:01.778896 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-10-03 03:05:02.109055 | debian-bookworm | ok 2026-10-03 03:05:02.114080 | 2026-10-03 03:05:02.114161 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-10-03 03:05:02.868120 | debian-bookworm | changed 2026-10-03 03:05:02.872370 | 2026-10-03 03:05:02.872447 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-10-03 03:05:03.670590 | debian-bookworm | changed 2026-10-03 03:05:03.675112 | 2026-10-03 03:05:03.675192 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-10-03 03:05:03.719362 | debian-bookworm | skipping: Conditional result was False 2026-10-03 03:05:03.727600 | 2026-10-03 03:05:03.727703 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-10-03 03:05:04.723352 | debian-bookworm -> localhost | changed 2026-10-03 03:05:04.732239 | 2026-10-03 03:05:04.732321 | TASK [add-build-sshkey : Add back temp key] 2026-10-03 03:05:05.394660 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/363b5c6f60e3488cb5d732ae05e2d141/work/363b5c6f60e3488cb5d732ae05e2d141_id_rsa (zuul-build-sshkey) 2026-10-03 03:05:05.394844 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.026949 2026-10-03 03:05:05.403390 | 2026-10-03 03:05:05.403619 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-10-03 03:05:05.862117 | debian-bookworm | ok 2026-10-03 03:05:05.866319 | 2026-10-03 03:05:05.866398 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-10-03 03:05:05.903585 | debian-bookworm | skipping: Conditional result was False 2026-10-03 03:05:05.912018 | 2026-10-03 03:05:05.912110 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-10-03 03:05:06.367912 | debian-bookworm | ok 2026-10-03 03:05:06.382689 | 2026-10-03 03:05:06.382781 | TASK [validate-host : Define zuul_info_dir fact] 2026-10-03 03:05:06.417381 | debian-bookworm | ok 2026-10-03 03:05:06.421754 | 2026-10-03 03:05:06.421829 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-10-03 03:05:06.998093 | debian-bookworm -> localhost | ok 2026-10-03 03:05:07.004125 | 2026-10-03 03:05:07.004202 | TASK [validate-host : Collect information about the host] 2026-10-03 03:05:08.114653 | debian-bookworm | ok 2026-10-03 03:05:08.128941 | 2026-10-03 03:05:08.129043 | TASK [validate-host : Sanitize hostname] 2026-10-03 03:05:08.352052 | debian-bookworm | ok 2026-10-03 03:05:08.369358 | 2026-10-03 03:05:08.369448 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-10-03 03:05:08.973825 | debian-bookworm -> localhost | changed 2026-10-03 03:05:08.983408 | 2026-10-03 03:05:08.983505 | TASK [validate-host : Collect information about zuul worker] 2026-10-03 03:05:09.440590 | debian-bookworm | ok 2026-10-03 03:05:09.450255 | 2026-10-03 03:05:09.450354 | TASK [validate-host : Write out all zuul information for each host] 2026-10-03 03:05:09.994142 | debian-bookworm -> localhost | changed 2026-10-03 03:05:10.018912 | 2026-10-03 03:05:10.019015 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-10-03 03:05:10.308307 | debian-bookworm | ok 2026-10-03 03:05:10.313520 | 2026-10-03 03:05:10.313800 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-10-03 03:05:11.393354 | debian-bookworm | changed: 2026-10-03 03:05:11.393703 | debian-bookworm | cd+++++++++ src/ 2026-10-03 03:05:11.393778 | debian-bookworm | cd+++++++++ src/github.com/ 2026-10-03 03:05:11.393830 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-10-03 03:05:11.393874 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-sandbox-manager/ 2026-10-03 03:05:11.393917 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/363b5c6f60e3488cb5d732ae05e2d141/work/logs" 2026-10-03 03:06:16.406194 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/363b5c6f60e3488cb5d732ae05e2d141/work/artifacts" 2026-10-03 03:06:16.765355 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/363b5c6f60e3488cb5d732ae05e2d141/work/docs" 2026-10-03 03:06:16.774301 | 2026-10-03 03:06:16.774390 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-10-03 03:06:17.575637 | debian-bookworm | changed: 2026-10-03 03:06:17.575825 | debian-bookworm | .d..t...... ./ 2026-10-03 03:06:17.575865 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-10-03 03:06:17.575894 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-10-03 03:06:17.575916 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-10-03 03:06:17.575942 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-10-03 03:06:17.575966 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-10-03 03:06:17.576010 | debian-bookworm | changed: All items complete 2026-10-03 03:06:17.576043 | 2026-10-03 03:06:18.188763 | debian-bookworm | changed: .d..t...... ./ 2026-10-03 03:06:19.037235 | debian-bookworm | changed: .d..t...... ./ 2026-10-03 03:06:19.050762 | 2026-10-03 03:06:19.050858 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-10-03 03:06:19.105282 | debian-bookworm | skipping: Conditional result was False 2026-10-03 03:06:19.113372 | debian-bookworm | skipping: Conditional result was False 2026-10-03 03:06:19.126200 | 2026-10-03 03:06:19.126274 | PLAY RECAP 2026-10-03 03:06:19.126315 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-10-03 03:06:19.126336 | 2026-10-03 03:06:19.351750 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-10-03 03:06:19.352378 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-10-03 03:06:20.062922 | 2026-10-03 03:06:20.063036 | PLAY [Base post] 2026-10-03 03:06:20.086160 | 2026-10-03 03:06:20.086272 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-10-03 03:06:20.702658 | debian-bookworm | changed 2026-10-03 03:06:20.707808 | 2026-10-03 03:06:20.707882 | PLAY RECAP 2026-10-03 03:06:20.707932 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-10-03 03:06:20.707981 | 2026-10-03 03:06:20.821313 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-10-03 03:06:20.821950 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-10-03 03:06:21.579738 | 2026-10-03 03:06:21.579855 | PLAY [Base post-logs] 2026-10-03 03:06:21.590770 | 2026-10-03 03:06:21.590880 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-10-03 03:06:22.026631 | localhost | changed 2026-10-03 03:06:22.056246 | 2026-10-03 03:06:22.059775 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-10-03 03:06:22.111593 | localhost | ok 2026-10-03 03:06:22.114483 | 2026-10-03 03:06:22.114566 | TASK [Set zuul-log-path fact] 2026-10-03 03:06:22.140558 | localhost | ok 2026-10-03 03:06:22.153947 | 2026-10-03 03:06:22.154032 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-10-03 03:06:22.202024 | localhost | ok 2026-10-03 03:06:22.204845 | 2026-10-03 03:06:22.204924 | TASK [upload-logs : Create log directories] 2026-10-03 03:06:22.811363 | localhost | changed 2026-10-03 03:06:22.813446 | 2026-10-03 03:06:22.813516 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-10-03 03:06:23.426568 | localhost -> localhost | ok: Runtime: 0:00:00.018294 2026-10-03 03:06:23.431089 | 2026-10-03 03:06:23.431176 | TASK [upload-logs : Upload logs to log server] 2026-10-03 03:06:24.238477 | localhost | Output suppressed because no_log was given 2026-10-03 03:06:24.240105 | 2026-10-03 03:06:24.240194 | LOOP [upload-logs : Compress console log and json output] 2026-10-03 03:06:24.279023 | localhost | skipping: Conditional result was False 2026-10-03 03:06:24.285405 | localhost | skipping: Conditional result was False 2026-10-03 03:06:24.296786 | 2026-10-03 03:06:24.296872 | LOOP [upload-logs : Upload compressed console log and json output] 2026-10-03 03:06:24.341171 | localhost | skipping: Conditional result was False 2026-10-03 03:06:24.341377 | 2026-10-03 03:06:24.345704 | localhost | skipping: Conditional result was False 2026-10-03 03:06:24.355440 | 2026-10-03 03:06:24.355517 | LOOP [upload-logs : Upload console log and json output]