2026-09-18 03:19:06.425522 | Job console starting 2026-09-18 03:19:06.435802 | Updating git repos 2026-09-18 03:19:06.482283 | Cloning repos into workspace 2026-09-18 03:19:06.578263 | Restoring repo states 2026-09-18 03:19:06.610214 | Merging changes 2026-09-18 03:19:06.610233 | Checking out repos 2026-09-18 03:19:06.695668 | Preparing playbooks 2026-09-18 03:19:07.789694 | Running Ansible setup 2026-09-18 03:19:12.287968 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-18 03:19:13.230132 | 2026-09-18 03:19:13.230241 | PLAY [Base pre] 2026-09-18 03:19:13.248221 | 2026-09-18 03:19:13.248328 | TASK [Setup log path fact] 2026-09-18 03:19:13.278206 | debian-bookworm | ok 2026-09-18 03:19:13.294842 | 2026-09-18 03:19:13.294969 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-18 03:19:13.340255 | debian-bookworm | ok 2026-09-18 03:19:13.354648 | 2026-09-18 03:19:13.354761 | TASK [emit-job-header : Print job information] 2026-09-18 03:19:13.393014 | # Job Information 2026-09-18 03:19:13.393162 | Ansible Version: 2.16.14 2026-09-18 03:19:13.393195 | Job: python-black 2026-09-18 03:19:13.393228 | Pipeline: periodic-daily 2026-09-18 03:19:13.393252 | Executor: 521e9411259a 2026-09-18 03:19:13.393273 | Triggered by: https://github.com/osism/netbox-plugin-osism 2026-09-18 03:19:13.393295 | Event ID: da8fb4f660d64104ba8d38f9a0186065 2026-09-18 03:19:13.398227 | 2026-09-18 03:19:13.398321 | LOOP [emit-job-header : Print node information] 2026-09-18 03:19:13.503412 | debian-bookworm | ok: 2026-09-18 03:19:13.503598 | debian-bookworm | # Node Information 2026-09-18 03:19:13.503629 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-18 03:19:13.503649 | debian-bookworm | Hostname: debian 2026-09-18 03:19:13.503667 | debian-bookworm | Username: zuul 2026-09-18 03:19:13.503684 | debian-bookworm | Distro: Debian 12.15 2026-09-18 03:19:13.503703 | debian-bookworm | Provider: regiocloud-a 2026-09-18 03:19:13.503721 | debian-bookworm | Region: 2026-09-18 03:19:13.503738 | debian-bookworm | Label: debian-bookworm 2026-09-18 03:19:13.503754 | debian-bookworm | Product Name: OpenStack Nova 2026-09-18 03:19:13.503775 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe75:fd65 2026-09-18 03:19:13.515062 | 2026-09-18 03:19:13.515166 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-18 03:19:14.151606 | debian-bookworm -> localhost | changed 2026-09-18 03:19:14.162297 | 2026-09-18 03:19:14.163126 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-18 03:19:15.171891 | debian-bookworm -> localhost | changed 2026-09-18 03:19:15.182284 | 2026-09-18 03:19:15.182385 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-18 03:19:15.681690 | debian-bookworm -> localhost | ok 2026-09-18 03:19:15.687878 | 2026-09-18 03:19:15.688677 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-18 03:19:15.713030 | debian-bookworm | ok 2026-09-18 03:19:15.773230 | debian-bookworm | included: /var/lib/zuul/builds/3506b82d48a3424da28d4be3f9faef1d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-18 03:19:15.794966 | 2026-09-18 03:19:15.795068 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-18 03:19:18.360325 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-18 03:19:18.360666 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/3506b82d48a3424da28d4be3f9faef1d/work/3506b82d48a3424da28d4be3f9faef1d_id_rsa 2026-09-18 03:19:18.360719 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/3506b82d48a3424da28d4be3f9faef1d/work/3506b82d48a3424da28d4be3f9faef1d_id_rsa.pub 2026-09-18 03:19:18.360838 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-18 03:19:18.360869 | debian-bookworm -> localhost | SHA256:vF3VquUjB3aJUNpOUmOgHPCJFjZJRlR3rLjLTwlXsiA zuul-build-sshkey 2026-09-18 03:19:18.360894 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-18 03:19:18.360925 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-18 03:19:18.360948 | debian-bookworm -> localhost | | +X+o oo* | 2026-09-18 03:19:18.360971 | debian-bookworm -> localhost | | o.* = B.. . | 2026-09-18 03:19:18.361070 | debian-bookworm -> localhost | | E *.=.+ . .| 2026-09-18 03:19:18.361102 | debian-bookworm -> localhost | | . o...O o o | 2026-09-18 03:19:18.361124 | debian-bookworm -> localhost | | S.o * = | 2026-09-18 03:19:18.361149 | debian-bookworm -> localhost | | .= + * | 2026-09-18 03:19:18.361171 | debian-bookworm -> localhost | | ...+ o + | 2026-09-18 03:19:18.361191 | debian-bookworm -> localhost | | o. o . | 2026-09-18 03:19:18.361212 | debian-bookworm -> localhost | | .. | 2026-09-18 03:19:18.361232 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-18 03:19:18.361379 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.974221 2026-09-18 03:19:18.378336 | 2026-09-18 03:19:18.378460 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-18 03:19:18.412801 | debian-bookworm | ok 2026-09-18 03:19:18.429156 | debian-bookworm | included: /var/lib/zuul/builds/3506b82d48a3424da28d4be3f9faef1d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-18 03:19:18.440721 | 2026-09-18 03:19:18.441009 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-18 03:19:18.476268 | debian-bookworm | skipping: Conditional result was False 2026-09-18 03:19:18.484264 | 2026-09-18 03:19:18.484365 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-18 03:19:19.270560 | debian-bookworm | changed 2026-09-18 03:19:19.277308 | 2026-09-18 03:19:19.277408 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-18 03:19:19.507253 | debian-bookworm | ok 2026-09-18 03:19:19.512576 | 2026-09-18 03:19:19.512663 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-18 03:19:20.098084 | debian-bookworm | changed 2026-09-18 03:19:20.102457 | 2026-09-18 03:19:20.102529 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-18 03:19:20.706245 | debian-bookworm | changed 2026-09-18 03:19:20.710621 | 2026-09-18 03:19:20.710693 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-18 03:19:20.743101 | debian-bookworm | skipping: Conditional result was False 2026-09-18 03:19:20.748877 | 2026-09-18 03:19:20.748963 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-18 03:19:21.331613 | debian-bookworm -> localhost | changed 2026-09-18 03:19:21.343259 | 2026-09-18 03:19:21.343353 | TASK [add-build-sshkey : Add back temp key] 2026-09-18 03:19:21.622357 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/3506b82d48a3424da28d4be3f9faef1d/work/3506b82d48a3424da28d4be3f9faef1d_id_rsa (zuul-build-sshkey) 2026-09-18 03:19:21.622790 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018839 2026-09-18 03:19:21.634861 | 2026-09-18 03:19:21.634989 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-18 03:19:22.042225 | debian-bookworm | ok 2026-09-18 03:19:22.050127 | 2026-09-18 03:19:22.050252 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-18 03:19:22.074595 | debian-bookworm | skipping: Conditional result was False 2026-09-18 03:19:22.089227 | 2026-09-18 03:19:22.089325 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-18 03:19:22.568007 | debian-bookworm | ok 2026-09-18 03:19:22.586345 | 2026-09-18 03:19:22.586479 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-18 03:19:22.636004 | debian-bookworm | ok 2026-09-18 03:19:22.647795 | 2026-09-18 03:19:22.647916 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-18 03:19:23.136370 | debian-bookworm -> localhost | ok 2026-09-18 03:19:23.143103 | 2026-09-18 03:19:23.143196 | TASK [validate-host : Collect information about the host] 2026-09-18 03:19:24.292723 | debian-bookworm | ok 2026-09-18 03:19:24.311681 | 2026-09-18 03:19:24.311786 | TASK [validate-host : Sanitize hostname] 2026-09-18 03:19:24.469636 | debian-bookworm | ok 2026-09-18 03:19:24.480055 | 2026-09-18 03:19:24.480188 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-18 03:19:25.126216 | debian-bookworm -> localhost | changed 2026-09-18 03:19:25.131825 | 2026-09-18 03:19:25.131919 | TASK [validate-host : Collect information about zuul worker] 2026-09-18 03:19:25.609040 | debian-bookworm | ok 2026-09-18 03:19:25.613683 | 2026-09-18 03:19:25.613775 | TASK [validate-host : Write out all zuul information for each host] 2026-09-18 03:19:26.148217 | debian-bookworm -> localhost | changed 2026-09-18 03:19:26.157538 | 2026-09-18 03:19:26.157646 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-18 03:19:26.442027 | debian-bookworm | ok 2026-09-18 03:19:26.449991 | 2026-09-18 03:19:26.450097 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-18 03:19:27.238190 | debian-bookworm | changed: 2026-09-18 03:19:27.238389 | debian-bookworm | cd+++++++++ src/ 2026-09-18 03:19:27.239981 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-18 03:19:27.240053 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-18 03:19:27.240082 | debian-bookworm | cd+++++++++ src/github.com/osism/netbox-plugin-osism/ 2026-09-18 03:19:27.240104 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/3506b82d48a3424da28d4be3f9faef1d/work/logs" 2026-09-18 03:20:31.862078 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/3506b82d48a3424da28d4be3f9faef1d/work/artifacts" 2026-09-18 03:20:32.171966 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/3506b82d48a3424da28d4be3f9faef1d/work/docs" 2026-09-18 03:20:32.198137 | 2026-09-18 03:20:32.198244 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-18 03:20:33.050977 | debian-bookworm | changed: 2026-09-18 03:20:33.051163 | debian-bookworm | .d..t...... ./ 2026-09-18 03:20:33.051210 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-18 03:20:33.051238 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-18 03:20:33.051260 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-18 03:20:33.051404 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-18 03:20:33.051436 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-18 03:20:33.051477 | debian-bookworm | changed: All items complete 2026-09-18 03:20:33.051500 | 2026-09-18 03:20:33.671537 | debian-bookworm | changed: .d..t...... ./ 2026-09-18 03:20:34.185159 | debian-bookworm | changed: .d..t...... ./ 2026-09-18 03:20:34.207488 | 2026-09-18 03:20:34.207591 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-18 03:20:34.230284 | debian-bookworm | skipping: Conditional result was False 2026-09-18 03:20:34.235141 | debian-bookworm | skipping: Conditional result was False 2026-09-18 03:20:34.249867 | 2026-09-18 03:20:34.250029 | PLAY RECAP 2026-09-18 03:20:34.250085 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-09-18 03:20:34.250126 | 2026-09-18 03:20:34.367251 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-18 03:20:34.367998 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-18 03:20:35.140128 | 2026-09-18 03:20:35.140259 | PLAY [Base post] 2026-09-18 03:20:35.152169 | 2026-09-18 03:20:35.152284 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-18 03:20:35.707231 | debian-bookworm | changed 2026-09-18 03:20:35.714192 | 2026-09-18 03:20:35.714273 | PLAY RECAP 2026-09-18 03:20:35.714344 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-18 03:20:35.714405 | 2026-09-18 03:20:35.794566 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-18 03:20:35.796497 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-18 03:20:36.634459 | 2026-09-18 03:20:36.634591 | PLAY [Base post-logs] 2026-09-18 03:20:36.646668 | 2026-09-18 03:20:36.646882 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-18 03:20:37.056863 | localhost | changed 2026-09-18 03:20:37.065998 | 2026-09-18 03:20:37.066124 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-18 03:20:37.090476 | localhost | ok 2026-09-18 03:20:37.093286 | 2026-09-18 03:20:37.093382 | TASK [Set zuul-log-path fact] 2026-09-18 03:20:37.107489 | localhost | ok 2026-09-18 03:20:37.114846 | 2026-09-18 03:20:37.114934 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-18 03:20:37.128516 | localhost | ok 2026-09-18 03:20:37.131063 | 2026-09-18 03:20:37.131140 | TASK [upload-logs : Create log directories] 2026-09-18 03:20:37.534593 | localhost | changed 2026-09-18 03:20:37.537078 | 2026-09-18 03:20:37.537162 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-18 03:20:37.953730 | localhost -> localhost | ok: Runtime: 0:00:00.011976 2026-09-18 03:20:37.957198 | 2026-09-18 03:20:37.957290 | TASK [upload-logs : Upload logs to log server] 2026-09-18 03:20:38.487362 | localhost | Output suppressed because no_log was given 2026-09-18 03:20:38.488960 | 2026-09-18 03:20:38.489044 | LOOP [upload-logs : Compress console log and json output] 2026-09-18 03:20:38.528754 | localhost | skipping: Conditional result was False 2026-09-18 03:20:38.535912 | localhost | skipping: Conditional result was False 2026-09-18 03:20:38.544246 | 2026-09-18 03:20:38.544352 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-18 03:20:38.583240 | localhost | skipping: Conditional result was False 2026-09-18 03:20:38.583463 | 2026-09-18 03:20:38.589576 | localhost | skipping: Conditional result was False 2026-09-18 03:20:38.599360 | 2026-09-18 03:20:38.599457 | LOOP [upload-logs : Upload console log and json output]