2026-09-02 03:06:55.189786 | Job console starting 2026-09-02 03:06:55.216022 | Updating git repos 2026-09-02 03:06:55.270246 | Cloning repos into workspace 2026-09-02 03:06:55.392054 | Restoring repo states 2026-09-02 03:06:55.404523 | Merging changes 2026-09-02 03:06:55.404542 | Checking out repos 2026-09-02 03:06:55.456831 | Preparing playbooks 2026-09-02 03:06:56.351596 | Running Ansible setup 2026-09-02 03:07:00.232966 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-02 03:07:00.970662 | 2026-09-02 03:07:00.970784 | PLAY [Base pre] 2026-09-02 03:07:00.988836 | 2026-09-02 03:07:00.988937 | TASK [Setup log path fact] 2026-09-02 03:07:01.017084 | debian-bookworm | ok 2026-09-02 03:07:01.033377 | 2026-09-02 03:07:01.033505 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-02 03:07:01.071685 | debian-bookworm | ok 2026-09-02 03:07:01.081682 | 2026-09-02 03:07:01.081775 | TASK [emit-job-header : Print job information] 2026-09-02 03:07:01.122980 | # Job Information 2026-09-02 03:07:01.123160 | Ansible Version: 2.16.14 2026-09-02 03:07:01.123197 | Job: python-black 2026-09-02 03:07:01.123230 | Pipeline: periodic-daily 2026-09-02 03:07:01.123254 | Executor: 521e9411259a 2026-09-02 03:07:01.123275 | Triggered by: https://github.com/osism/openstack-project-manager 2026-09-02 03:07:01.123297 | Event ID: e15ca3d04f564371b8fd8766053c386a 2026-09-02 03:07:01.128168 | 2026-09-02 03:07:01.128257 | LOOP [emit-job-header : Print node information] 2026-09-02 03:07:01.230088 | debian-bookworm | ok: 2026-09-02 03:07:01.230299 | debian-bookworm | # Node Information 2026-09-02 03:07:01.230335 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-02 03:07:01.230362 | debian-bookworm | Hostname: debian 2026-09-02 03:07:01.230385 | debian-bookworm | Username: zuul 2026-09-02 03:07:01.230406 | debian-bookworm | Distro: Debian 12.15 2026-09-02 03:07:01.230431 | debian-bookworm | Provider: regiocloud-a 2026-09-02 03:07:01.230453 | debian-bookworm | Region: 2026-09-02 03:07:01.230504 | debian-bookworm | Label: debian-bookworm 2026-09-02 03:07:01.230526 | debian-bookworm | Product Name: OpenStack Nova 2026-09-02 03:07:01.230546 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe2b:e420 2026-09-02 03:07:01.249672 | 2026-09-02 03:07:01.249768 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-02 03:07:01.683236 | debian-bookworm -> localhost | changed 2026-09-02 03:07:01.697542 | 2026-09-02 03:07:01.697671 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-02 03:07:02.727694 | debian-bookworm -> localhost | changed 2026-09-02 03:07:02.755191 | 2026-09-02 03:07:02.755327 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-02 03:07:03.004028 | debian-bookworm -> localhost | ok 2026-09-02 03:07:03.009163 | 2026-09-02 03:07:03.009244 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-02 03:07:03.026965 | debian-bookworm | ok 2026-09-02 03:07:03.048836 | debian-bookworm | included: /var/lib/zuul/builds/249d14ecd7b34fbd8e4ae5c039d6594a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-02 03:07:03.057830 | 2026-09-02 03:07:03.057899 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-02 03:07:04.634623 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-02 03:07:04.634888 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/249d14ecd7b34fbd8e4ae5c039d6594a/work/249d14ecd7b34fbd8e4ae5c039d6594a_id_rsa 2026-09-02 03:07:04.634929 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/249d14ecd7b34fbd8e4ae5c039d6594a/work/249d14ecd7b34fbd8e4ae5c039d6594a_id_rsa.pub 2026-09-02 03:07:04.634969 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-02 03:07:04.634995 | debian-bookworm -> localhost | SHA256:7ntugU59Ohua/n3lmLmjG6Rinicf1wHR8R6ouCuyFUk zuul-build-sshkey 2026-09-02 03:07:04.635018 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-02 03:07:04.635052 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-02 03:07:04.635074 | debian-bookworm -> localhost | | .... | 2026-09-02 03:07:04.635096 | debian-bookworm -> localhost | | .o. | 2026-09-02 03:07:04.635117 | debian-bookworm -> localhost | | E .. ..| 2026-09-02 03:07:04.635136 | debian-bookworm -> localhost | | . . . .. ..| 2026-09-02 03:07:04.635156 | debian-bookworm -> localhost | | oS+ .. . .| 2026-09-02 03:07:04.635182 | debian-bookworm -> localhost | | .+ +o.. ..| 2026-09-02 03:07:04.635202 | debian-bookworm -> localhost | | ++.++o .* | 2026-09-02 03:07:04.635222 | debian-bookworm -> localhost | | ..=o=B= .* .| 2026-09-02 03:07:04.635242 | debian-bookworm -> localhost | | .o.X@=o++.o | 2026-09-02 03:07:04.635262 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-02 03:07:04.635319 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.092252 2026-09-02 03:07:04.642261 | 2026-09-02 03:07:04.642371 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-02 03:07:04.671451 | debian-bookworm | ok 2026-09-02 03:07:04.683066 | debian-bookworm | included: /var/lib/zuul/builds/249d14ecd7b34fbd8e4ae5c039d6594a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-02 03:07:04.691709 | 2026-09-02 03:07:04.691809 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-02 03:07:04.716608 | debian-bookworm | skipping: Conditional result was False 2026-09-02 03:07:04.723315 | 2026-09-02 03:07:04.723427 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-02 03:07:05.607868 | debian-bookworm | changed 2026-09-02 03:07:05.613856 | 2026-09-02 03:07:05.613960 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-02 03:07:05.889546 | debian-bookworm | ok 2026-09-02 03:07:05.895295 | 2026-09-02 03:07:05.895402 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-02 03:07:06.688291 | debian-bookworm | changed 2026-09-02 03:07:06.696643 | 2026-09-02 03:07:06.696802 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-02 03:07:07.394084 | debian-bookworm | changed 2026-09-02 03:07:07.411629 | 2026-09-02 03:07:07.411757 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-02 03:07:07.436164 | debian-bookworm | skipping: Conditional result was False 2026-09-02 03:07:07.442863 | 2026-09-02 03:07:07.442977 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-02 03:07:07.901249 | debian-bookworm -> localhost | changed 2026-09-02 03:07:07.917863 | 2026-09-02 03:07:07.918057 | TASK [add-build-sshkey : Add back temp key] 2026-09-02 03:07:08.265576 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/249d14ecd7b34fbd8e4ae5c039d6594a/work/249d14ecd7b34fbd8e4ae5c039d6594a_id_rsa (zuul-build-sshkey) 2026-09-02 03:07:08.265814 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010987 2026-09-02 03:07:08.274069 | 2026-09-02 03:07:08.274182 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-02 03:07:08.697475 | debian-bookworm | ok 2026-09-02 03:07:08.703042 | 2026-09-02 03:07:08.703147 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-02 03:07:08.726827 | debian-bookworm | skipping: Conditional result was False 2026-09-02 03:07:08.737227 | 2026-09-02 03:07:08.737334 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-02 03:07:09.180300 | debian-bookworm | ok 2026-09-02 03:07:09.193880 | 2026-09-02 03:07:09.193988 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-02 03:07:09.232494 | debian-bookworm | ok 2026-09-02 03:07:09.237769 | 2026-09-02 03:07:09.237866 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-02 03:07:09.535400 | debian-bookworm -> localhost | ok 2026-09-02 03:07:09.546213 | 2026-09-02 03:07:09.546378 | TASK [validate-host : Collect information about the host] 2026-09-02 03:07:10.739248 | debian-bookworm | ok 2026-09-02 03:07:10.755502 | 2026-09-02 03:07:10.755626 | TASK [validate-host : Sanitize hostname] 2026-09-02 03:07:10.963998 | debian-bookworm | ok 2026-09-02 03:07:10.973698 | 2026-09-02 03:07:10.973823 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-02 03:07:11.615004 | debian-bookworm -> localhost | changed 2026-09-02 03:07:11.622945 | 2026-09-02 03:07:11.623056 | TASK [validate-host : Collect information about zuul worker] 2026-09-02 03:07:12.079597 | debian-bookworm | ok 2026-09-02 03:07:12.085221 | 2026-09-02 03:07:12.085335 | TASK [validate-host : Write out all zuul information for each host] 2026-09-02 03:07:13.137007 | debian-bookworm -> localhost | changed 2026-09-02 03:07:13.150073 | 2026-09-02 03:07:13.150590 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-02 03:07:13.458474 | debian-bookworm | ok 2026-09-02 03:07:13.478352 | 2026-09-02 03:07:13.478518 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-02 03:07:14.778174 | debian-bookworm | changed: 2026-09-02 03:07:14.778490 | debian-bookworm | cd+++++++++ src/ 2026-09-02 03:07:14.778540 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-02 03:07:14.778572 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-02 03:07:14.778600 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-project-manager/ 2026-09-02 03:07:14.778627 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/249d14ecd7b34fbd8e4ae5c039d6594a/work/logs" 2026-09-02 03:08:20.124077 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/249d14ecd7b34fbd8e4ae5c039d6594a/work/artifacts" 2026-09-02 03:08:20.438158 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/249d14ecd7b34fbd8e4ae5c039d6594a/work/docs" 2026-09-02 03:08:20.452143 | 2026-09-02 03:08:20.452283 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-02 03:08:21.298473 | debian-bookworm | changed: 2026-09-02 03:08:21.298806 | debian-bookworm | .d..t...... ./ 2026-09-02 03:08:21.298888 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-02 03:08:21.298915 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-02 03:08:21.298938 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-02 03:08:21.298960 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-02 03:08:21.298981 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-02 03:08:21.299029 | debian-bookworm | changed: All items complete 2026-09-02 03:08:21.299053 | 2026-09-02 03:08:21.914759 | debian-bookworm | changed: .d..t...... ./ 2026-09-02 03:08:22.521493 | debian-bookworm | changed: .d..t...... ./ 2026-09-02 03:08:22.550467 | 2026-09-02 03:08:22.550782 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-02 03:08:22.577674 | debian-bookworm | skipping: Conditional result was False 2026-09-02 03:08:22.581642 | debian-bookworm | skipping: Conditional result was False 2026-09-02 03:08:22.610027 | 2026-09-02 03:08:22.610282 | PLAY RECAP 2026-09-02 03:08:22.610375 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-09-02 03:08:22.610607 | 2026-09-02 03:08:22.769551 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-02 03:08:22.770520 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-02 03:08:23.757345 | 2026-09-02 03:08:23.757519 | PLAY [Base post] 2026-09-02 03:08:23.772775 | 2026-09-02 03:08:23.772913 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-02 03:08:24.481368 | debian-bookworm | changed 2026-09-02 03:08:24.490985 | 2026-09-02 03:08:24.491230 | PLAY RECAP 2026-09-02 03:08:24.491308 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-02 03:08:24.491379 | 2026-09-02 03:08:24.659372 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-02 03:08:24.660281 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-02 03:08:25.973727 | 2026-09-02 03:08:25.973901 | PLAY [Base post-logs] 2026-09-02 03:08:25.987088 | 2026-09-02 03:08:25.987239 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-02 03:08:26.785730 | localhost | changed 2026-09-02 03:08:26.793714 | 2026-09-02 03:08:26.793821 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-02 03:08:26.818086 | localhost | ok 2026-09-02 03:08:26.820359 | 2026-09-02 03:08:26.820449 | TASK [Set zuul-log-path fact] 2026-09-02 03:08:26.834022 | localhost | ok 2026-09-02 03:08:26.839994 | 2026-09-02 03:08:26.840076 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-02 03:08:26.863960 | localhost | ok 2026-09-02 03:08:26.866225 | 2026-09-02 03:08:26.866298 | TASK [upload-logs : Create log directories] 2026-09-02 03:08:27.309674 | localhost | changed 2026-09-02 03:08:27.313925 | 2026-09-02 03:08:27.314046 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-02 03:08:27.814182 | localhost -> localhost | ok: Runtime: 0:00:00.010340 2026-09-02 03:08:27.818027 | 2026-09-02 03:08:27.818117 | TASK [upload-logs : Upload logs to log server] 2026-09-02 03:08:28.267696 | localhost | Output suppressed because no_log was given 2026-09-02 03:08:28.269258 | 2026-09-02 03:08:28.269341 | LOOP [upload-logs : Compress console log and json output] 2026-09-02 03:08:28.319833 | localhost | skipping: Conditional result was False 2026-09-02 03:08:28.325100 | localhost | skipping: Conditional result was False 2026-09-02 03:08:28.334747 | 2026-09-02 03:08:28.334882 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-02 03:08:28.383531 | localhost | skipping: Conditional result was False 2026-09-02 03:08:28.383800 | 2026-09-02 03:08:28.388082 | localhost | skipping: Conditional result was False 2026-09-02 03:08:28.400571 | 2026-09-02 03:08:28.400681 | LOOP [upload-logs : Upload console log and json output]