2026-09-15 03:18:19.400120 | Job console starting 2026-09-15 03:18:19.409405 | Updating git repos 2026-09-15 03:18:19.431251 | Cloning repos into workspace 2026-09-15 03:18:19.454601 | Restoring repo states 2026-09-15 03:18:19.459520 | Merging changes 2026-09-15 03:18:19.459532 | Checking out repos 2026-09-15 03:18:19.485456 | Preparing playbooks 2026-09-15 03:18:20.252522 | Running Ansible setup 2026-09-15 03:18:24.702072 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-15 03:18:25.589823 | 2026-09-15 03:18:25.589944 | PLAY [Base pre] 2026-09-15 03:18:25.615696 | 2026-09-15 03:18:25.615823 | TASK [Setup log path fact] 2026-09-15 03:18:25.648997 | debian-bookworm | ok 2026-09-15 03:18:25.682144 | 2026-09-15 03:18:25.682275 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-15 03:18:25.730021 | debian-bookworm | ok 2026-09-15 03:18:25.749329 | 2026-09-15 03:18:25.749437 | TASK [emit-job-header : Print job information] 2026-09-15 03:18:25.797420 | # Job Information 2026-09-15 03:18:25.797585 | Ansible Version: 2.16.14 2026-09-15 03:18:25.797621 | Job: python-black 2026-09-15 03:18:25.797654 | Pipeline: periodic-daily 2026-09-15 03:18:25.797678 | Executor: 521e9411259a 2026-09-15 03:18:25.797699 | Triggered by: https://github.com/osism/netbox-plugin-osism 2026-09-15 03:18:25.797732 | Event ID: 8839be77fadc4f58855cfd64a48cd1d6 2026-09-15 03:18:25.802507 | 2026-09-15 03:18:25.802595 | LOOP [emit-job-header : Print node information] 2026-09-15 03:18:25.966051 | debian-bookworm | ok: 2026-09-15 03:18:25.966278 | debian-bookworm | # Node Information 2026-09-15 03:18:25.966317 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-15 03:18:25.966388 | debian-bookworm | Hostname: debian 2026-09-15 03:18:25.966414 | debian-bookworm | Username: zuul 2026-09-15 03:18:25.966436 | debian-bookworm | Distro: Debian 12.15 2026-09-15 03:18:25.966461 | debian-bookworm | Provider: regiocloud-a 2026-09-15 03:18:25.966482 | debian-bookworm | Region: 2026-09-15 03:18:25.966504 | debian-bookworm | Label: debian-bookworm 2026-09-15 03:18:25.966524 | debian-bookworm | Product Name: OpenStack Nova 2026-09-15 03:18:25.966543 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe80:af4c 2026-09-15 03:18:25.987160 | 2026-09-15 03:18:25.987266 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-15 03:18:26.744404 | debian-bookworm -> localhost | changed 2026-09-15 03:18:26.751925 | 2026-09-15 03:18:26.752033 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-15 03:18:27.954509 | debian-bookworm -> localhost | changed 2026-09-15 03:18:27.965499 | 2026-09-15 03:18:27.965611 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-15 03:18:28.211713 | debian-bookworm -> localhost | ok 2026-09-15 03:18:28.217652 | 2026-09-15 03:18:28.217777 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-15 03:18:28.245122 | debian-bookworm | ok 2026-09-15 03:18:28.264471 | debian-bookworm | included: /var/lib/zuul/builds/23b15dc324e7464fb1eb415460aace96/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-15 03:18:28.270364 | 2026-09-15 03:18:28.270445 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-15 03:18:30.571688 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-15 03:18:30.571902 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/23b15dc324e7464fb1eb415460aace96/work/23b15dc324e7464fb1eb415460aace96_id_rsa 2026-09-15 03:18:30.571941 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/23b15dc324e7464fb1eb415460aace96/work/23b15dc324e7464fb1eb415460aace96_id_rsa.pub 2026-09-15 03:18:30.571968 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-15 03:18:30.571992 | debian-bookworm -> localhost | SHA256:S9LUf4jG3Tv32FbKaAS/SbfaAUy7Kx7AnN5NoqLFDeA zuul-build-sshkey 2026-09-15 03:18:30.572014 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-15 03:18:30.572045 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-15 03:18:30.572067 | debian-bookworm -> localhost | | | 2026-09-15 03:18:30.572089 | debian-bookworm -> localhost | | . | 2026-09-15 03:18:30.572109 | debian-bookworm -> localhost | | . . . . | 2026-09-15 03:18:30.572129 | debian-bookworm -> localhost | | . . = o.* + | 2026-09-15 03:18:30.572149 | debian-bookworm -> localhost | | E o S =oO o | 2026-09-15 03:18:30.572171 | debian-bookworm -> localhost | | . * * +++...| 2026-09-15 03:18:30.572191 | debian-bookworm -> localhost | | + = ooo*+oo| 2026-09-15 03:18:30.572210 | debian-bookworm -> localhost | | o . ..=o+*o| 2026-09-15 03:18:30.572230 | debian-bookworm -> localhost | | . ..oo.o.o| 2026-09-15 03:18:30.572250 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-15 03:18:30.572299 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.863840 2026-09-15 03:18:30.578361 | 2026-09-15 03:18:30.578442 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-15 03:18:30.595695 | debian-bookworm | ok 2026-09-15 03:18:30.605370 | debian-bookworm | included: /var/lib/zuul/builds/23b15dc324e7464fb1eb415460aace96/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-15 03:18:30.613515 | 2026-09-15 03:18:30.613618 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-15 03:18:30.628539 | debian-bookworm | skipping: Conditional result was False 2026-09-15 03:18:30.633959 | 2026-09-15 03:18:30.634041 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-15 03:18:31.212867 | debian-bookworm | changed 2026-09-15 03:18:31.218986 | 2026-09-15 03:18:31.219081 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-15 03:18:31.474843 | debian-bookworm | ok 2026-09-15 03:18:31.483082 | 2026-09-15 03:18:31.483291 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-15 03:18:32.158150 | debian-bookworm | changed 2026-09-15 03:18:32.166606 | 2026-09-15 03:18:32.166699 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-15 03:18:32.861350 | debian-bookworm | changed 2026-09-15 03:18:32.886496 | 2026-09-15 03:18:32.886589 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-15 03:18:32.921834 | debian-bookworm | skipping: Conditional result was False 2026-09-15 03:18:32.927099 | 2026-09-15 03:18:32.927177 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-15 03:18:33.536255 | debian-bookworm -> localhost | changed 2026-09-15 03:18:33.553937 | 2026-09-15 03:18:33.554051 | TASK [add-build-sshkey : Add back temp key] 2026-09-15 03:18:34.212684 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/23b15dc324e7464fb1eb415460aace96/work/23b15dc324e7464fb1eb415460aace96_id_rsa (zuul-build-sshkey) 2026-09-15 03:18:34.212877 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014909 2026-09-15 03:18:34.219314 | 2026-09-15 03:18:34.219392 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-15 03:18:34.663788 | debian-bookworm | ok 2026-09-15 03:18:34.678430 | 2026-09-15 03:18:34.678515 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-15 03:18:34.711139 | debian-bookworm | skipping: Conditional result was False 2026-09-15 03:18:34.719556 | 2026-09-15 03:18:34.719633 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-15 03:18:35.182554 | debian-bookworm | ok 2026-09-15 03:18:35.200688 | 2026-09-15 03:18:35.200808 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-15 03:18:35.240145 | debian-bookworm | ok 2026-09-15 03:18:35.244348 | 2026-09-15 03:18:35.244421 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-15 03:18:35.930170 | debian-bookworm -> localhost | ok 2026-09-15 03:18:35.936223 | 2026-09-15 03:18:35.936307 | TASK [validate-host : Collect information about the host] 2026-09-15 03:18:37.210810 | debian-bookworm | ok 2026-09-15 03:18:37.223913 | 2026-09-15 03:18:37.224004 | TASK [validate-host : Sanitize hostname] 2026-09-15 03:18:37.365862 | debian-bookworm | ok 2026-09-15 03:18:37.369671 | 2026-09-15 03:18:37.369758 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-15 03:18:38.133420 | debian-bookworm -> localhost | changed 2026-09-15 03:18:38.137918 | 2026-09-15 03:18:38.137996 | TASK [validate-host : Collect information about zuul worker] 2026-09-15 03:18:38.533167 | debian-bookworm | ok 2026-09-15 03:18:38.548419 | 2026-09-15 03:18:38.548513 | TASK [validate-host : Write out all zuul information for each host] 2026-09-15 03:18:39.707009 | debian-bookworm -> localhost | changed 2026-09-15 03:18:39.714776 | 2026-09-15 03:18:39.714860 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-15 03:18:39.978744 | debian-bookworm | ok 2026-09-15 03:18:39.983124 | 2026-09-15 03:18:39.983203 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-15 03:18:40.794365 | debian-bookworm | changed: 2026-09-15 03:18:40.794510 | debian-bookworm | cd+++++++++ src/ 2026-09-15 03:18:40.794660 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-15 03:18:40.794684 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-15 03:18:40.794703 | debian-bookworm | cd+++++++++ src/github.com/osism/netbox-plugin-osism/ 2026-09-15 03:18:40.794744 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/23b15dc324e7464fb1eb415460aace96/work/logs" 2026-09-15 03:19:40.904534 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/23b15dc324e7464fb1eb415460aace96/work/artifacts" 2026-09-15 03:19:41.178262 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/23b15dc324e7464fb1eb415460aace96/work/docs" 2026-09-15 03:19:41.191726 | 2026-09-15 03:19:41.191853 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-15 03:19:41.899955 | debian-bookworm | changed: 2026-09-15 03:19:41.900139 | debian-bookworm | .d..t...... ./ 2026-09-15 03:19:41.900175 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-15 03:19:41.900199 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-15 03:19:41.900220 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-15 03:19:41.900241 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-15 03:19:41.900261 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-15 03:19:41.900297 | debian-bookworm | changed: All items complete 2026-09-15 03:19:41.900322 | 2026-09-15 03:19:42.533404 | debian-bookworm | changed: .d..t...... ./ 2026-09-15 03:19:43.275465 | debian-bookworm | changed: .d..t...... ./ 2026-09-15 03:19:43.298152 | 2026-09-15 03:19:43.298288 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-15 03:19:43.327604 | debian-bookworm | skipping: Conditional result was False 2026-09-15 03:19:43.332286 | debian-bookworm | skipping: Conditional result was False 2026-09-15 03:19:43.359639 | 2026-09-15 03:19:43.359799 | PLAY RECAP 2026-09-15 03:19:43.359861 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-09-15 03:19:43.359889 | 2026-09-15 03:19:43.495212 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-15 03:19:43.496108 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-15 03:19:44.266331 | 2026-09-15 03:19:44.266491 | PLAY [Base post] 2026-09-15 03:19:44.281373 | 2026-09-15 03:19:44.281515 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-15 03:19:45.033434 | debian-bookworm | changed 2026-09-15 03:19:45.055842 | 2026-09-15 03:19:45.055946 | PLAY RECAP 2026-09-15 03:19:45.056006 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-15 03:19:45.056066 | 2026-09-15 03:19:45.154737 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-15 03:19:45.155447 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-15 03:19:45.911743 | 2026-09-15 03:19:45.911852 | PLAY [Base post-logs] 2026-09-15 03:19:45.932252 | 2026-09-15 03:19:45.932360 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-15 03:19:46.424849 | localhost | changed 2026-09-15 03:19:46.438001 | 2026-09-15 03:19:46.438141 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-15 03:19:46.462505 | localhost | ok 2026-09-15 03:19:46.465353 | 2026-09-15 03:19:46.465483 | TASK [Set zuul-log-path fact] 2026-09-15 03:19:46.480948 | localhost | ok 2026-09-15 03:19:46.489765 | 2026-09-15 03:19:46.489847 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-15 03:19:46.513274 | localhost | ok 2026-09-15 03:19:46.516102 | 2026-09-15 03:19:46.516216 | TASK [upload-logs : Create log directories] 2026-09-15 03:19:46.925878 | localhost | changed 2026-09-15 03:19:46.928609 | 2026-09-15 03:19:46.928698 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-15 03:19:47.524224 | localhost -> localhost | ok: Runtime: 0:00:00.007989 2026-09-15 03:19:47.527891 | 2026-09-15 03:19:47.527983 | TASK [upload-logs : Upload logs to log server] 2026-09-15 03:19:48.027603 | localhost | Output suppressed because no_log was given 2026-09-15 03:19:48.029200 | 2026-09-15 03:19:48.029285 | LOOP [upload-logs : Compress console log and json output] 2026-09-15 03:19:48.069441 | localhost | skipping: Conditional result was False 2026-09-15 03:19:48.081021 | localhost | skipping: Conditional result was False 2026-09-15 03:19:48.087602 | 2026-09-15 03:19:48.087694 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-15 03:19:48.165463 | localhost | skipping: Conditional result was False 2026-09-15 03:19:48.165806 | 2026-09-15 03:19:48.174032 | localhost | skipping: Conditional result was False 2026-09-15 03:19:48.184013 | 2026-09-15 03:19:48.184096 | LOOP [upload-logs : Upload console log and json output]