2026-09-27 08:40:50.873830 | Job console starting 2026-09-27 08:40:50.894978 | Updating git repos 2026-09-27 08:40:50.962413 | Cloning repos into workspace 2026-09-27 08:40:51.084912 | Restoring repo states 2026-09-27 08:40:51.136941 | Merging changes 2026-09-27 08:40:52.595167 | Checking out repos 2026-09-27 08:40:52.691949 | Preparing playbooks 2026-09-27 08:40:54.157987 | Running Ansible setup 2026-09-27 08:40:59.784405 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-27 08:41:00.614910 | 2026-09-27 08:41:00.615043 | PLAY [Base pre] 2026-09-27 08:41:00.635015 | 2026-09-27 08:41:00.635153 | TASK [Setup log path fact] 2026-09-27 08:41:00.665886 | debian-bookworm | ok 2026-09-27 08:41:00.718327 | 2026-09-27 08:41:00.718464 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-27 08:41:00.777913 | debian-bookworm | ok 2026-09-27 08:41:00.791061 | 2026-09-27 08:41:00.792878 | TASK [emit-job-header : Print job information] 2026-09-27 08:41:00.875664 | # Job Information 2026-09-27 08:41:00.875806 | Ansible Version: 2.16.14 2026-09-27 08:41:00.875836 | Job: python-black 2026-09-27 08:41:00.875864 | Pipeline: check 2026-09-27 08:41:00.875883 | Executor: 521e9411259a 2026-09-27 08:41:00.875901 | Triggered by: https://github.com/osism/python-osism/pull/2726 2026-09-27 08:41:00.875919 | Event ID: faaea140-ba4e-11f1-8a01-fedfaf2caa1a 2026-09-27 08:41:00.881205 | 2026-09-27 08:41:00.881298 | LOOP [emit-job-header : Print node information] 2026-09-27 08:41:01.046819 | debian-bookworm | ok: 2026-09-27 08:41:01.046999 | debian-bookworm | # Node Information 2026-09-27 08:41:01.047035 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-27 08:41:01.047061 | debian-bookworm | Hostname: debian 2026-09-27 08:41:01.047083 | debian-bookworm | Username: zuul 2026-09-27 08:41:01.047115 | debian-bookworm | Distro: Debian 12.15 2026-09-27 08:41:01.047142 | debian-bookworm | Provider: regiocloud-a 2026-09-27 08:41:01.047163 | debian-bookworm | Region: 2026-09-27 08:41:01.047184 | debian-bookworm | Label: debian-bookworm 2026-09-27 08:41:01.047204 | debian-bookworm | Product Name: OpenStack Nova 2026-09-27 08:41:01.047223 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe54:a761 2026-09-27 08:41:01.056352 | 2026-09-27 08:41:01.056449 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-27 08:41:01.782942 | debian-bookworm -> localhost | changed 2026-09-27 08:41:01.795195 | 2026-09-27 08:41:01.795305 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-27 08:41:03.539607 | debian-bookworm -> localhost | changed 2026-09-27 08:41:03.556858 | 2026-09-27 08:41:03.557508 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-27 08:41:03.986160 | debian-bookworm -> localhost | ok 2026-09-27 08:41:04.000350 | 2026-09-27 08:41:04.000739 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-27 08:41:04.030310 | debian-bookworm | ok 2026-09-27 08:41:04.043320 | debian-bookworm | included: /var/lib/zuul/builds/76d618cd23964530b4af52d3e51585c4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-27 08:41:04.048430 | 2026-09-27 08:41:04.048505 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-27 08:41:05.639787 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-27 08:41:05.639978 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/76d618cd23964530b4af52d3e51585c4/work/76d618cd23964530b4af52d3e51585c4_id_rsa 2026-09-27 08:41:05.640017 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/76d618cd23964530b4af52d3e51585c4/work/76d618cd23964530b4af52d3e51585c4_id_rsa.pub 2026-09-27 08:41:05.640043 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-27 08:41:05.640068 | debian-bookworm -> localhost | SHA256:D6fysUTSUuRrNMAjvt+XiiMAKPkblWiP7yrY3bK8Pcc zuul-build-sshkey 2026-09-27 08:41:05.640102 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-27 08:41:05.640134 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-27 08:41:05.640157 | debian-bookworm -> localhost | | .. . | 2026-09-27 08:41:05.640178 | debian-bookworm -> localhost | | . o+ | 2026-09-27 08:41:05.640198 | debian-bookworm -> localhost | |.. o o .= | 2026-09-27 08:41:05.640218 | debian-bookworm -> localhost | |= o + + o | 2026-09-27 08:41:05.640238 | debian-bookworm -> localhost | |.+ + .o S . | 2026-09-27 08:41:05.640261 | debian-bookworm -> localhost | | = o = = | 2026-09-27 08:41:05.640281 | debian-bookworm -> localhost | |.. * o.o+ .. | 2026-09-27 08:41:05.640302 | debian-bookworm -> localhost | |o o.=.==Eoo | 2026-09-27 08:41:05.640323 | debian-bookworm -> localhost | | ..o==o++o | 2026-09-27 08:41:05.640343 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-27 08:41:05.640390 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.084390 2026-09-27 08:41:05.646688 | 2026-09-27 08:41:05.646773 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-27 08:41:05.674373 | debian-bookworm | ok 2026-09-27 08:41:05.684189 | debian-bookworm | included: /var/lib/zuul/builds/76d618cd23964530b4af52d3e51585c4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-27 08:41:05.709281 | 2026-09-27 08:41:05.709382 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-27 08:41:05.752679 | debian-bookworm | skipping: Conditional result was False 2026-09-27 08:41:05.758336 | 2026-09-27 08:41:05.758429 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-27 08:41:06.418392 | debian-bookworm | changed 2026-09-27 08:41:06.422737 | 2026-09-27 08:41:06.422810 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-27 08:41:06.685961 | debian-bookworm | ok 2026-09-27 08:41:06.694501 | 2026-09-27 08:41:06.694609 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-27 08:41:07.417151 | debian-bookworm | changed 2026-09-27 08:41:07.431165 | 2026-09-27 08:41:07.431270 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-27 08:41:08.152113 | debian-bookworm | changed 2026-09-27 08:41:08.159896 | 2026-09-27 08:41:08.159995 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-27 08:41:08.189108 | debian-bookworm | skipping: Conditional result was False 2026-09-27 08:41:08.196147 | 2026-09-27 08:41:08.196277 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-27 08:41:08.749377 | debian-bookworm -> localhost | changed 2026-09-27 08:41:08.760009 | 2026-09-27 08:41:08.760108 | TASK [add-build-sshkey : Add back temp key] 2026-09-27 08:41:09.050195 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/76d618cd23964530b4af52d3e51585c4/work/76d618cd23964530b4af52d3e51585c4_id_rsa (zuul-build-sshkey) 2026-09-27 08:41:09.050384 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.020002 2026-09-27 08:41:09.056489 | 2026-09-27 08:41:09.056563 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-27 08:41:09.440177 | debian-bookworm | ok 2026-09-27 08:41:09.444880 | 2026-09-27 08:41:09.444952 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-27 08:41:09.467696 | debian-bookworm | skipping: Conditional result was False 2026-09-27 08:41:09.476191 | 2026-09-27 08:41:09.476270 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-27 08:41:09.882406 | debian-bookworm | ok 2026-09-27 08:41:09.893632 | 2026-09-27 08:41:09.893725 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-27 08:41:09.920991 | debian-bookworm | ok 2026-09-27 08:41:09.926247 | 2026-09-27 08:41:09.926324 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-27 08:41:10.193000 | debian-bookworm -> localhost | ok 2026-09-27 08:41:10.207224 | 2026-09-27 08:41:10.207321 | TASK [validate-host : Collect information about the host] 2026-09-27 08:41:12.249931 | debian-bookworm | ok 2026-09-27 08:41:12.263482 | 2026-09-27 08:41:12.263579 | TASK [validate-host : Sanitize hostname] 2026-09-27 08:41:12.390343 | debian-bookworm | ok 2026-09-27 08:41:12.394484 | 2026-09-27 08:41:12.394566 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-27 08:41:12.945832 | debian-bookworm -> localhost | changed 2026-09-27 08:41:12.951187 | 2026-09-27 08:41:12.951275 | TASK [validate-host : Collect information about zuul worker] 2026-09-27 08:41:13.327535 | debian-bookworm | ok 2026-09-27 08:41:13.332851 | 2026-09-27 08:41:13.332949 | TASK [validate-host : Write out all zuul information for each host] 2026-09-27 08:41:13.918308 | debian-bookworm -> localhost | changed 2026-09-27 08:41:13.935642 | 2026-09-27 08:41:13.935793 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-27 08:41:14.192370 | debian-bookworm | ok 2026-09-27 08:41:14.200847 | 2026-09-27 08:41:14.200972 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-27 08:41:15.886822 | debian-bookworm | changed: 2026-09-27 08:41:15.888914 | debian-bookworm | cd+++++++++ src/ 2026-09-27 08:41:15.888968 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-27 08:41:15.888998 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-27 08:41:15.889025 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-09-27 08:41:15.889050 | debian-bookworm | Containerfile 2026-09-27 08:41:15.889367 | debian-bookworm | Containerfile 2026-09-27 08:41:15.896426 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/76d618cd23964530b4af52d3e51585c4/work/logs" 2026-09-27 08:42:32.008197 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/76d618cd23964530b4af52d3e51585c4/work/artifacts" 2026-09-27 08:42:32.300321 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/76d618cd23964530b4af52d3e51585c4/work/docs" 2026-09-27 08:42:32.338329 | 2026-09-27 08:42:32.338463 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-27 08:42:33.125582 | debian-bookworm | changed: 2026-09-27 08:42:33.125943 | debian-bookworm | .d..t...... ./ 2026-09-27 08:42:33.126008 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-27 08:42:33.126048 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-27 08:42:33.126084 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-27 08:42:33.126118 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-27 08:42:33.126151 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-27 08:42:33.126208 | debian-bookworm | changed: All items complete 2026-09-27 08:42:33.126243 | 2026-09-27 08:42:33.668751 | debian-bookworm | changed: .d..t...... ./ 2026-09-27 08:42:34.198906 | debian-bookworm | changed: .d..t...... ./ 2026-09-27 08:42:34.219970 | 2026-09-27 08:42:34.220110 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-27 08:42:34.570199 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.005682 2026-09-27 08:42:34.876558 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.010579 2026-09-27 08:42:34.895116 | 2026-09-27 08:42:34.895217 | PLAY RECAP 2026-09-27 08:42:34.895269 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-09-27 08:42:34.895294 | 2026-09-27 08:42:35.025498 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-27 08:42:35.026774 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-27 08:42:35.801208 | 2026-09-27 08:42:35.801623 | PLAY [Base post] 2026-09-27 08:42:35.821711 | 2026-09-27 08:42:35.822263 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-27 08:42:36.479859 | debian-bookworm | changed 2026-09-27 08:42:36.487890 | 2026-09-27 08:42:36.488018 | PLAY RECAP 2026-09-27 08:42:36.488083 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-27 08:42:36.488146 | 2026-09-27 08:42:36.659382 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-27 08:42:36.660313 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-27 08:42:37.481222 | 2026-09-27 08:42:37.481381 | PLAY [Base post-logs] 2026-09-27 08:42:37.492188 | 2026-09-27 08:42:37.492332 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-27 08:42:37.984899 | localhost | changed 2026-09-27 08:42:37.995970 | 2026-09-27 08:42:37.996115 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-27 08:42:38.022060 | localhost | ok 2026-09-27 08:42:38.025218 | 2026-09-27 08:42:38.025322 | TASK [Set zuul-log-path fact] 2026-09-27 08:42:38.040555 | localhost | ok 2026-09-27 08:42:38.048707 | 2026-09-27 08:42:38.048871 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-27 08:42:38.073792 | localhost | ok 2026-09-27 08:42:38.076758 | 2026-09-27 08:42:38.076878 | TASK [upload-logs : Create log directories] 2026-09-27 08:42:38.636457 | localhost | changed 2026-09-27 08:42:38.641845 | 2026-09-27 08:42:38.641978 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-27 08:42:39.193833 | localhost -> localhost | ok: Runtime: 0:00:00.019254 2026-09-27 08:42:39.199875 | 2026-09-27 08:42:39.200012 | TASK [upload-logs : Upload logs to log server] 2026-09-27 08:42:39.765941 | localhost | Output suppressed because no_log was given 2026-09-27 08:42:39.768927 | 2026-09-27 08:42:39.769083 | LOOP [upload-logs : Compress console log and json output] 2026-09-27 08:42:39.833290 | localhost | skipping: Conditional result was False 2026-09-27 08:42:39.842168 | localhost | skipping: Conditional result was False 2026-09-27 08:42:39.847684 | 2026-09-27 08:42:39.847848 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-27 08:42:39.901295 | localhost | skipping: Conditional result was False 2026-09-27 08:42:39.901610 | 2026-09-27 08:42:39.908699 | localhost | skipping: Conditional result was False 2026-09-27 08:42:39.917292 | 2026-09-27 08:42:39.917408 | LOOP [upload-logs : Upload console log and json output]