2026-07-02 03:05:36.800651 | Job console starting 2026-07-02 03:05:36.815484 | Updating git repos 2026-07-02 03:05:36.840082 | Cloning repos into workspace 2026-07-02 03:05:36.879550 | Restoring repo states 2026-07-02 03:05:36.895276 | Merging changes 2026-07-02 03:05:36.895294 | Checking out repos 2026-07-02 03:05:36.980439 | Preparing playbooks 2026-07-02 03:05:38.140953 | Running Ansible setup 2026-07-02 03:05:44.747601 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-02 03:05:45.791303 | 2026-07-02 03:05:45.795926 | PLAY [Base pre] 2026-07-02 03:05:45.815865 | 2026-07-02 03:05:45.816165 | TASK [Setup log path fact] 2026-07-02 03:05:45.853794 | debian-bookworm | ok 2026-07-02 03:05:45.878343 | 2026-07-02 03:05:45.878471 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-02 03:05:45.932789 | debian-bookworm | ok 2026-07-02 03:05:45.942058 | 2026-07-02 03:05:45.942164 | TASK [emit-job-header : Print job information] 2026-07-02 03:05:45.999734 | # Job Information 2026-07-02 03:05:45.999873 | Ansible Version: 2.16.14 2026-07-02 03:05:45.999902 | Job: python-black 2026-07-02 03:05:45.999929 | Pipeline: periodic-daily 2026-07-02 03:05:45.999948 | Executor: 521e9411259a 2026-07-02 03:05:45.999965 | Triggered by: https://github.com/osism/netbox-plugin-osism 2026-07-02 03:05:45.999984 | Event ID: 93f72bff084c4af0b826c00fb51f43b4 2026-07-02 03:05:46.004546 | 2026-07-02 03:05:46.004630 | LOOP [emit-job-header : Print node information] 2026-07-02 03:05:46.127699 | debian-bookworm | ok: 2026-07-02 03:05:46.127849 | debian-bookworm | # Node Information 2026-07-02 03:05:46.127878 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-02 03:05:46.127899 | debian-bookworm | Hostname: debian 2026-07-02 03:05:46.127917 | debian-bookworm | Username: zuul 2026-07-02 03:05:46.127934 | debian-bookworm | Distro: Debian 12.14 2026-07-02 03:05:46.127954 | debian-bookworm | Provider: regiocloud-a 2026-07-02 03:05:46.127971 | debian-bookworm | Region: 2026-07-02 03:05:46.127989 | debian-bookworm | Label: debian-bookworm 2026-07-02 03:05:46.128005 | debian-bookworm | Product Name: OpenStack Nova 2026-07-02 03:05:46.128021 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe11:7302 2026-07-02 03:05:46.136287 | 2026-07-02 03:05:46.136379 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-02 03:05:46.756803 | debian-bookworm -> localhost | changed 2026-07-02 03:05:46.765808 | 2026-07-02 03:05:46.765940 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-02 03:05:48.133532 | debian-bookworm -> localhost | changed 2026-07-02 03:05:48.144095 | 2026-07-02 03:05:48.144221 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-02 03:05:48.450566 | debian-bookworm -> localhost | ok 2026-07-02 03:05:48.457448 | 2026-07-02 03:05:48.457558 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-02 03:05:48.498023 | debian-bookworm | ok 2026-07-02 03:05:48.535511 | debian-bookworm | included: /var/lib/zuul/builds/339592cd34514fbf8ff7eb7995d1a67d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-02 03:05:48.541570 | 2026-07-02 03:05:48.541663 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-02 03:05:49.613421 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-02 03:05:49.613593 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/339592cd34514fbf8ff7eb7995d1a67d/work/339592cd34514fbf8ff7eb7995d1a67d_id_rsa 2026-07-02 03:05:49.613625 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/339592cd34514fbf8ff7eb7995d1a67d/work/339592cd34514fbf8ff7eb7995d1a67d_id_rsa.pub 2026-07-02 03:05:49.613649 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-02 03:05:49.613669 | debian-bookworm -> localhost | SHA256:x+YwJ6tuNbv0Uorc/ogh2/VhgaCFuAuWvyM3q0nZcs4 zuul-build-sshkey 2026-07-02 03:05:49.613688 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-02 03:05:49.613716 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-02 03:05:49.613734 | debian-bookworm -> localhost | | | 2026-07-02 03:05:49.613753 | debian-bookworm -> localhost | | . . | 2026-07-02 03:05:49.613770 | debian-bookworm -> localhost | | . . o | 2026-07-02 03:05:49.613787 | debian-bookworm -> localhost | | .. o . o | 2026-07-02 03:05:49.613803 | debian-bookworm -> localhost | |.o. . S * | 2026-07-02 03:05:49.613822 | debian-bookworm -> localhost | |..+. oX.. | 2026-07-02 03:05:49.613838 | debian-bookworm -> localhost | | +.+...++=+ | 2026-07-02 03:05:49.613855 | debian-bookworm -> localhost | |..*+.++*== . | 2026-07-02 03:05:49.613872 | debian-bookworm -> localhost | | o+E=o=.+++ | 2026-07-02 03:05:49.613888 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-02 03:05:49.613929 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.431361 2026-07-02 03:05:49.619239 | 2026-07-02 03:05:49.619325 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-02 03:05:49.656021 | debian-bookworm | ok 2026-07-02 03:05:49.667496 | debian-bookworm | included: /var/lib/zuul/builds/339592cd34514fbf8ff7eb7995d1a67d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-02 03:05:49.674038 | 2026-07-02 03:05:49.674106 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-02 03:05:49.703806 | debian-bookworm | skipping: Conditional result was False 2026-07-02 03:05:49.709329 | 2026-07-02 03:05:49.709415 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-02 03:05:50.529763 | debian-bookworm | changed 2026-07-02 03:05:50.538401 | 2026-07-02 03:05:50.538536 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-02 03:05:50.831678 | debian-bookworm | ok 2026-07-02 03:05:50.837118 | 2026-07-02 03:05:50.837244 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-02 03:05:51.585525 | debian-bookworm | changed 2026-07-02 03:05:51.596358 | 2026-07-02 03:05:51.596507 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-02 03:05:52.357710 | debian-bookworm | changed 2026-07-02 03:05:52.364867 | 2026-07-02 03:05:52.364977 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-02 03:05:52.391559 | debian-bookworm | skipping: Conditional result was False 2026-07-02 03:05:52.397877 | 2026-07-02 03:05:52.397985 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-02 03:05:53.243109 | debian-bookworm -> localhost | changed 2026-07-02 03:05:53.260492 | 2026-07-02 03:05:53.261843 | TASK [add-build-sshkey : Add back temp key] 2026-07-02 03:05:53.924552 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/339592cd34514fbf8ff7eb7995d1a67d/work/339592cd34514fbf8ff7eb7995d1a67d_id_rsa (zuul-build-sshkey) 2026-07-02 03:05:53.924797 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010284 2026-07-02 03:05:53.932498 | 2026-07-02 03:05:53.932600 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-02 03:05:54.369436 | debian-bookworm | ok 2026-07-02 03:05:54.379419 | 2026-07-02 03:05:54.381041 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-02 03:05:54.462501 | debian-bookworm | skipping: Conditional result was False 2026-07-02 03:05:54.485452 | 2026-07-02 03:05:54.485568 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-02 03:05:55.052931 | debian-bookworm | ok 2026-07-02 03:05:55.072553 | 2026-07-02 03:05:55.072669 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-02 03:05:55.122070 | debian-bookworm | ok 2026-07-02 03:05:55.127906 | 2026-07-02 03:05:55.128008 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-02 03:05:55.687289 | debian-bookworm -> localhost | ok 2026-07-02 03:05:55.693681 | 2026-07-02 03:05:55.693770 | TASK [validate-host : Collect information about the host] 2026-07-02 03:05:56.882742 | debian-bookworm | ok 2026-07-02 03:05:56.920608 | 2026-07-02 03:05:56.920715 | TASK [validate-host : Sanitize hostname] 2026-07-02 03:05:57.192791 | debian-bookworm | ok 2026-07-02 03:05:57.206903 | 2026-07-02 03:05:57.207005 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-02 03:05:58.109345 | debian-bookworm -> localhost | changed 2026-07-02 03:05:58.114626 | 2026-07-02 03:05:58.114717 | TASK [validate-host : Collect information about zuul worker] 2026-07-02 03:05:58.518803 | debian-bookworm | ok 2026-07-02 03:05:58.524538 | 2026-07-02 03:05:58.524640 | TASK [validate-host : Write out all zuul information for each host] 2026-07-02 03:05:59.376957 | debian-bookworm -> localhost | changed 2026-07-02 03:05:59.388259 | 2026-07-02 03:05:59.388381 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-02 03:05:59.688030 | debian-bookworm | ok 2026-07-02 03:05:59.696254 | 2026-07-02 03:05:59.696362 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-02 03:06:00.974039 | debian-bookworm | changed: 2026-07-02 03:06:00.974209 | debian-bookworm | cd+++++++++ src/ 2026-07-02 03:06:00.974240 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-02 03:06:00.974260 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-02 03:06:00.974278 | debian-bookworm | cd+++++++++ src/github.com/osism/netbox-plugin-osism/ 2026-07-02 03:06:00.974295 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/339592cd34514fbf8ff7eb7995d1a67d/work/logs" 2026-07-02 03:07:09.165978 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/339592cd34514fbf8ff7eb7995d1a67d/work/artifacts" 2026-07-02 03:07:09.529277 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/339592cd34514fbf8ff7eb7995d1a67d/work/docs" 2026-07-02 03:07:09.547401 | 2026-07-02 03:07:09.547533 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-02 03:07:10.432425 | debian-bookworm | changed: 2026-07-02 03:07:10.432650 | debian-bookworm | .d..t...... ./ 2026-07-02 03:07:10.432686 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-02 03:07:10.432710 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-02 03:07:10.432732 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-02 03:07:10.432753 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-02 03:07:10.432774 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-02 03:07:10.432816 | debian-bookworm | changed: All items complete 2026-07-02 03:07:10.432843 | 2026-07-02 03:07:11.009026 | debian-bookworm | changed: .d..t...... ./ 2026-07-02 03:07:11.603141 | debian-bookworm | changed: .d..t...... ./ 2026-07-02 03:07:11.633023 | 2026-07-02 03:07:11.633172 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-02 03:07:11.655975 | debian-bookworm | skipping: Conditional result was False 2026-07-02 03:07:11.660609 | debian-bookworm | skipping: Conditional result was False 2026-07-02 03:07:11.673361 | 2026-07-02 03:07:11.673448 | PLAY RECAP 2026-07-02 03:07:11.673510 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-07-02 03:07:11.673536 | 2026-07-02 03:07:11.806054 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-02 03:07:11.806875 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-02 03:07:12.625498 | 2026-07-02 03:07:12.625645 | PLAY [Base post] 2026-07-02 03:07:12.653399 | 2026-07-02 03:07:12.653534 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-02 03:07:13.232770 | debian-bookworm | changed 2026-07-02 03:07:13.244833 | 2026-07-02 03:07:13.244992 | PLAY RECAP 2026-07-02 03:07:13.245057 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-02 03:07:13.245272 | 2026-07-02 03:07:13.378760 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-02 03:07:13.379559 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-02 03:07:14.908757 | 2026-07-02 03:07:14.908914 | PLAY [Base post-logs] 2026-07-02 03:07:14.918945 | 2026-07-02 03:07:14.919067 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-02 03:07:15.604254 | localhost | changed 2026-07-02 03:07:15.625859 | 2026-07-02 03:07:15.626017 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-02 03:07:15.665474 | localhost | ok 2026-07-02 03:07:15.668530 | 2026-07-02 03:07:15.668618 | TASK [Set zuul-log-path fact] 2026-07-02 03:07:15.717982 | localhost | ok 2026-07-02 03:07:15.725958 | 2026-07-02 03:07:15.726067 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-02 03:07:15.771215 | localhost | ok 2026-07-02 03:07:15.774087 | 2026-07-02 03:07:15.774268 | TASK [upload-logs : Create log directories] 2026-07-02 03:07:16.525507 | localhost | changed 2026-07-02 03:07:16.528536 | 2026-07-02 03:07:16.528640 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-02 03:07:17.320926 | localhost -> localhost | ok: Runtime: 0:00:00.006406 2026-07-02 03:07:17.325021 | 2026-07-02 03:07:17.325157 | TASK [upload-logs : Upload logs to log server] 2026-07-02 03:07:18.177004 | localhost | Output suppressed because no_log was given 2026-07-02 03:07:18.178787 | 2026-07-02 03:07:18.178946 | LOOP [upload-logs : Compress console log and json output] 2026-07-02 03:07:18.277504 | localhost | skipping: Conditional result was False 2026-07-02 03:07:18.300824 | localhost | skipping: Conditional result was False 2026-07-02 03:07:18.308843 | 2026-07-02 03:07:18.308974 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-02 03:07:18.395996 | localhost | skipping: Conditional result was False 2026-07-02 03:07:18.396254 | 2026-07-02 03:07:18.408453 | localhost | skipping: Conditional result was False 2026-07-02 03:07:18.416606 | 2026-07-02 03:07:18.416769 | LOOP [upload-logs : Upload console log and json output]