2026-07-25 03:03:30.414275 | Job console starting 2026-07-25 03:03:30.422958 | Updating git repos 2026-07-25 03:03:30.449384 | Cloning repos into workspace 2026-07-25 03:03:30.489852 | Restoring repo states 2026-07-25 03:03:30.495076 | Merging changes 2026-07-25 03:03:30.495096 | Checking out repos 2026-07-25 03:03:30.537683 | Preparing playbooks 2026-07-25 03:03:31.378509 | Running Ansible setup 2026-07-25 03:03:35.358715 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-25 03:03:36.184408 | 2026-07-25 03:03:36.184549 | PLAY [Base pre] 2026-07-25 03:03:36.211967 | 2026-07-25 03:03:36.212092 | TASK [Setup log path fact] 2026-07-25 03:03:36.230127 | debian-bookworm | ok 2026-07-25 03:03:36.253622 | 2026-07-25 03:03:36.253823 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-25 03:03:36.282544 | debian-bookworm | ok 2026-07-25 03:03:36.298540 | 2026-07-25 03:03:36.298716 | TASK [emit-job-header : Print job information] 2026-07-25 03:03:36.358433 | # Job Information 2026-07-25 03:03:36.358609 | Ansible Version: 2.16.14 2026-07-25 03:03:36.358645 | Job: python-black 2026-07-25 03:03:36.358677 | Pipeline: periodic-daily 2026-07-25 03:03:36.358712 | Executor: 521e9411259a 2026-07-25 03:03:36.358733 | Triggered by: https://github.com/osism/netbox-plugin-osism 2026-07-25 03:03:36.358755 | Event ID: d28f174535ea4e168a47707b0a08c6d5 2026-07-25 03:03:36.363622 | 2026-07-25 03:03:36.363729 | LOOP [emit-job-header : Print node information] 2026-07-25 03:03:36.465527 | debian-bookworm | ok: 2026-07-25 03:03:36.465745 | debian-bookworm | # Node Information 2026-07-25 03:03:36.465783 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-25 03:03:36.465808 | debian-bookworm | Hostname: debian 2026-07-25 03:03:36.466074 | debian-bookworm | Username: zuul 2026-07-25 03:03:36.466116 | debian-bookworm | Distro: Debian 12.15 2026-07-25 03:03:36.466145 | debian-bookworm | Provider: regiocloud-a 2026-07-25 03:03:36.466168 | debian-bookworm | Region: 2026-07-25 03:03:36.466190 | debian-bookworm | Label: debian-bookworm 2026-07-25 03:03:36.466210 | debian-bookworm | Product Name: OpenStack Nova 2026-07-25 03:03:36.466230 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe56:3d3f 2026-07-25 03:03:36.481238 | 2026-07-25 03:03:36.481357 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-25 03:03:37.208969 | debian-bookworm -> localhost | changed 2026-07-25 03:03:37.216054 | 2026-07-25 03:03:37.216160 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-25 03:03:39.131028 | debian-bookworm -> localhost | changed 2026-07-25 03:03:39.149174 | 2026-07-25 03:03:39.149295 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-25 03:03:39.528471 | debian-bookworm -> localhost | ok 2026-07-25 03:03:39.534732 | 2026-07-25 03:03:39.534858 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-25 03:03:39.578431 | debian-bookworm | ok 2026-07-25 03:03:39.597953 | debian-bookworm | included: /var/lib/zuul/builds/1d949f330b374197ba5ffc08411268e0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-25 03:03:39.606428 | 2026-07-25 03:03:39.606525 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-25 03:03:42.607358 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-25 03:03:42.607575 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/1d949f330b374197ba5ffc08411268e0/work/1d949f330b374197ba5ffc08411268e0_id_rsa 2026-07-25 03:03:42.607613 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/1d949f330b374197ba5ffc08411268e0/work/1d949f330b374197ba5ffc08411268e0_id_rsa.pub 2026-07-25 03:03:42.607640 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-25 03:03:42.607666 | debian-bookworm -> localhost | SHA256:9743ULoPLR8i6dNEFLfEmyfjMFQvMjqjCGA6ckjWqZo zuul-build-sshkey 2026-07-25 03:03:42.607688 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-25 03:03:42.607733 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-25 03:03:42.607755 | debian-bookworm -> localhost | | .++ | 2026-07-25 03:03:42.607778 | debian-bookworm -> localhost | | . . oo.o | 2026-07-25 03:03:42.607800 | debian-bookworm -> localhost | | ooo oo oo.| 2026-07-25 03:03:42.607820 | debian-bookworm -> localhost | |o+.. .+o*..| 2026-07-25 03:03:42.607840 | debian-bookworm -> localhost | |=.. . S =. * + | 2026-07-25 03:03:42.607865 | debian-bookworm -> localhost | |o+ . . o =+.. | 2026-07-25 03:03:42.607886 | debian-bookworm -> localhost | |E . . oo=oo | 2026-07-25 03:03:42.607906 | debian-bookworm -> localhost | | ..oo=o. | 2026-07-25 03:03:42.607927 | debian-bookworm -> localhost | | ..o+o. | 2026-07-25 03:03:42.607946 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-25 03:03:42.607994 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.386787 2026-07-25 03:03:42.618077 | 2026-07-25 03:03:42.618183 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-25 03:03:42.650430 | debian-bookworm | ok 2026-07-25 03:03:42.663338 | debian-bookworm | included: /var/lib/zuul/builds/1d949f330b374197ba5ffc08411268e0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-25 03:03:42.671735 | 2026-07-25 03:03:42.671832 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-25 03:03:42.696122 | debian-bookworm | skipping: Conditional result was False 2026-07-25 03:03:42.711601 | 2026-07-25 03:03:42.712144 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-25 03:03:43.401773 | debian-bookworm | changed 2026-07-25 03:03:43.423042 | 2026-07-25 03:03:43.423154 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-25 03:03:43.712165 | debian-bookworm | ok 2026-07-25 03:03:43.722400 | 2026-07-25 03:03:43.722507 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-25 03:03:44.371970 | debian-bookworm | changed 2026-07-25 03:03:44.386558 | 2026-07-25 03:03:44.386683 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-25 03:03:45.111688 | debian-bookworm | changed 2026-07-25 03:03:45.122235 | 2026-07-25 03:03:45.122350 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-25 03:03:45.155655 | debian-bookworm | skipping: Conditional result was False 2026-07-25 03:03:45.162751 | 2026-07-25 03:03:45.162880 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-25 03:03:45.953986 | debian-bookworm -> localhost | changed 2026-07-25 03:03:45.969500 | 2026-07-25 03:03:45.969615 | TASK [add-build-sshkey : Add back temp key] 2026-07-25 03:03:46.551311 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/1d949f330b374197ba5ffc08411268e0/work/1d949f330b374197ba5ffc08411268e0_id_rsa (zuul-build-sshkey) 2026-07-25 03:03:46.551539 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.025304 2026-07-25 03:03:46.559082 | 2026-07-25 03:03:46.559176 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-25 03:03:47.142094 | debian-bookworm | ok 2026-07-25 03:03:47.147944 | 2026-07-25 03:03:47.148045 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-25 03:03:47.188827 | debian-bookworm | skipping: Conditional result was False 2026-07-25 03:03:47.203904 | 2026-07-25 03:03:47.204022 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-25 03:03:47.741778 | debian-bookworm | ok 2026-07-25 03:03:47.776832 | 2026-07-25 03:03:47.776961 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-25 03:03:47.844147 | debian-bookworm | ok 2026-07-25 03:03:47.858276 | 2026-07-25 03:03:47.858390 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-25 03:03:48.416880 | debian-bookworm -> localhost | ok 2026-07-25 03:03:48.423413 | 2026-07-25 03:03:48.423503 | TASK [validate-host : Collect information about the host] 2026-07-25 03:03:49.744242 | debian-bookworm | ok 2026-07-25 03:03:49.788539 | 2026-07-25 03:03:49.788658 | TASK [validate-host : Sanitize hostname] 2026-07-25 03:03:50.178056 | debian-bookworm | ok 2026-07-25 03:03:50.189991 | 2026-07-25 03:03:50.190086 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-25 03:03:51.649519 | debian-bookworm -> localhost | changed 2026-07-25 03:03:51.654281 | 2026-07-25 03:03:51.654371 | TASK [validate-host : Collect information about zuul worker] 2026-07-25 03:03:52.096635 | debian-bookworm | ok 2026-07-25 03:03:52.101195 | 2026-07-25 03:03:52.101339 | TASK [validate-host : Write out all zuul information for each host] 2026-07-25 03:03:53.709395 | debian-bookworm -> localhost | changed 2026-07-25 03:03:53.726134 | 2026-07-25 03:03:53.726257 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-25 03:03:54.042682 | debian-bookworm | ok 2026-07-25 03:03:54.051636 | 2026-07-25 03:03:54.051752 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-25 03:03:55.568109 | debian-bookworm | changed: 2026-07-25 03:03:55.568284 | debian-bookworm | cd+++++++++ src/ 2026-07-25 03:03:55.568462 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-25 03:03:55.568491 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-25 03:03:55.568514 | debian-bookworm | cd+++++++++ src/github.com/osism/netbox-plugin-osism/ 2026-07-25 03:03:55.568536 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/1d949f330b374197ba5ffc08411268e0/work/logs" 2026-07-25 03:05:03.725293 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/1d949f330b374197ba5ffc08411268e0/work/artifacts" 2026-07-25 03:05:04.872876 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/1d949f330b374197ba5ffc08411268e0/work/docs" 2026-07-25 03:05:04.889179 | 2026-07-25 03:05:04.889310 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-25 03:05:06.662486 | debian-bookworm | changed: 2026-07-25 03:05:06.662703 | debian-bookworm | .d..t...... ./ 2026-07-25 03:05:06.662738 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-25 03:05:06.662762 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-25 03:05:06.662784 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-25 03:05:06.662805 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-25 03:05:06.662826 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-25 03:05:06.662886 | debian-bookworm | changed: All items complete 2026-07-25 03:05:06.662912 | 2026-07-25 03:05:07.532451 | debian-bookworm | changed: .d..t...... ./ 2026-07-25 03:05:08.096518 | debian-bookworm | changed: .d..t...... ./ 2026-07-25 03:05:08.118616 | 2026-07-25 03:05:08.118772 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-25 03:05:08.176458 | debian-bookworm | skipping: Conditional result was False 2026-07-25 03:05:08.182353 | debian-bookworm | skipping: Conditional result was False 2026-07-25 03:05:08.198816 | 2026-07-25 03:05:08.198962 | PLAY RECAP 2026-07-25 03:05:08.199018 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-07-25 03:05:08.199042 | 2026-07-25 03:05:08.361246 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-25 03:05:08.361895 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-25 03:05:09.706014 | 2026-07-25 03:05:09.706337 | PLAY [Base post] 2026-07-25 03:05:09.723185 | 2026-07-25 03:05:09.723329 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-25 03:05:10.489298 | debian-bookworm | changed 2026-07-25 03:05:10.502471 | 2026-07-25 03:05:10.502574 | PLAY RECAP 2026-07-25 03:05:10.502634 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-25 03:05:10.502709 | 2026-07-25 03:05:10.793430 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-25 03:05:10.794235 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-25 03:05:12.110762 | 2026-07-25 03:05:12.110938 | PLAY [Base post-logs] 2026-07-25 03:05:12.145221 | 2026-07-25 03:05:12.145359 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-25 03:05:12.845608 | localhost | changed 2026-07-25 03:05:12.862019 | 2026-07-25 03:05:12.862170 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-25 03:05:12.907251 | localhost | ok 2026-07-25 03:05:12.910148 | 2026-07-25 03:05:12.910230 | TASK [Set zuul-log-path fact] 2026-07-25 03:05:12.934968 | localhost | ok 2026-07-25 03:05:12.942866 | 2026-07-25 03:05:12.942974 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-25 03:05:12.998371 | localhost | ok 2026-07-25 03:05:13.002025 | 2026-07-25 03:05:13.002126 | TASK [upload-logs : Create log directories] 2026-07-25 03:05:14.063477 | localhost | changed 2026-07-25 03:05:14.066246 | 2026-07-25 03:05:14.066345 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-25 03:05:14.781823 | localhost -> localhost | ok: Runtime: 0:00:00.024570 2026-07-25 03:05:14.786202 | 2026-07-25 03:05:14.786447 | TASK [upload-logs : Upload logs to log server] 2026-07-25 03:05:15.925607 | localhost | Output suppressed because no_log was given 2026-07-25 03:05:15.927548 | 2026-07-25 03:05:15.927639 | LOOP [upload-logs : Compress console log and json output] 2026-07-25 03:05:16.036653 | localhost | skipping: Conditional result was False 2026-07-25 03:05:16.063630 | localhost | skipping: Conditional result was False 2026-07-25 03:05:16.074357 | 2026-07-25 03:05:16.074468 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-25 03:05:16.172432 | localhost | skipping: Conditional result was False 2026-07-25 03:05:16.172666 | 2026-07-25 03:05:16.183360 | localhost | skipping: Conditional result was False 2026-07-25 03:05:16.192252 | 2026-07-25 03:05:16.192366 | LOOP [upload-logs : Upload console log and json output]