2026-06-01 03:15:27.034965 | Job console starting 2026-06-01 03:15:27.047520 | Updating git repos 2026-06-01 03:15:27.090727 | Cloning repos into workspace 2026-06-01 03:15:27.157634 | Restoring repo states 2026-06-01 03:15:27.183658 | Merging changes 2026-06-01 03:15:27.183795 | Checking out repos 2026-06-01 03:15:27.245354 | Preparing playbooks 2026-06-01 03:15:28.090704 | Running Ansible setup 2026-06-01 03:15:32.925744 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-01 03:15:33.820464 | 2026-06-01 03:15:33.820638 | PLAY [Base pre] 2026-06-01 03:15:33.837977 | 2026-06-01 03:15:33.838140 | TASK [Setup log path fact] 2026-06-01 03:15:33.858067 | debian-bookworm | ok 2026-06-01 03:15:33.875843 | 2026-06-01 03:15:33.876012 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-01 03:15:33.941195 | debian-bookworm | ok 2026-06-01 03:15:33.965666 | 2026-06-01 03:15:33.965947 | TASK [emit-job-header : Print job information] 2026-06-01 03:15:34.027600 | # Job Information 2026-06-01 03:15:34.028016 | Ansible Version: 2.16.14 2026-06-01 03:15:34.028100 | Job: python-black 2026-06-01 03:15:34.028164 | Pipeline: periodic-daily 2026-06-01 03:15:34.028208 | Executor: 521e9411259a 2026-06-01 03:15:34.028246 | Triggered by: https://github.com/osism/netbox-plugin-osism 2026-06-01 03:15:34.028287 | Event ID: 5d3eca6e0b124e68bbaba15e033c00ee 2026-06-01 03:15:34.037958 | 2026-06-01 03:15:34.038237 | LOOP [emit-job-header : Print node information] 2026-06-01 03:15:34.185735 | debian-bookworm | ok: 2026-06-01 03:15:34.185953 | debian-bookworm | # Node Information 2026-06-01 03:15:34.185989 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-01 03:15:34.186017 | debian-bookworm | Hostname: debian 2026-06-01 03:15:34.187043 | debian-bookworm | Username: zuul 2026-06-01 03:15:34.188235 | debian-bookworm | Distro: Debian 12.14 2026-06-01 03:15:34.188868 | debian-bookworm | Provider: regiocloud-a 2026-06-01 03:15:34.189464 | debian-bookworm | Region: 2026-06-01 03:15:34.189497 | debian-bookworm | Label: debian-bookworm 2026-06-01 03:15:34.189549 | debian-bookworm | Product Name: OpenStack Nova 2026-06-01 03:15:34.189575 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe0b:944a 2026-06-01 03:15:34.214671 | 2026-06-01 03:15:34.214905 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-01 03:15:34.751175 | debian-bookworm -> localhost | changed 2026-06-01 03:15:34.768444 | 2026-06-01 03:15:34.768626 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-01 03:15:35.893444 | debian-bookworm -> localhost | changed 2026-06-01 03:15:35.914072 | 2026-06-01 03:15:35.914223 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-01 03:15:36.244741 | debian-bookworm -> localhost | ok 2026-06-01 03:15:36.252581 | 2026-06-01 03:15:36.252736 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-01 03:15:36.297967 | debian-bookworm | ok 2026-06-01 03:15:36.315713 | debian-bookworm | included: /var/lib/zuul/builds/7da57eb429654fca8cdd44e5ddc1729e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-01 03:15:36.322328 | 2026-06-01 03:15:36.322433 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-01 03:15:37.391844 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-01 03:15:37.392211 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/7da57eb429654fca8cdd44e5ddc1729e/work/7da57eb429654fca8cdd44e5ddc1729e_id_rsa 2026-06-01 03:15:37.392262 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/7da57eb429654fca8cdd44e5ddc1729e/work/7da57eb429654fca8cdd44e5ddc1729e_id_rsa.pub 2026-06-01 03:15:37.392294 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-01 03:15:37.392322 | debian-bookworm -> localhost | SHA256:KoRRRCiQ/pI9r5pXezZJKyGoFz+dLrlat3mGbCpVfXQ zuul-build-sshkey 2026-06-01 03:15:37.392349 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-01 03:15:37.392391 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-01 03:15:37.392418 | debian-bookworm -> localhost | |o. ++ | 2026-06-01 03:15:37.392443 | debian-bookworm -> localhost | |o .. . E | 2026-06-01 03:15:37.392467 | debian-bookworm -> localhost | |... . . . | 2026-06-01 03:15:37.392491 | debian-bookworm -> localhost | | . o . . . | 2026-06-01 03:15:37.392515 | debian-bookworm -> localhost | | * .. S. | 2026-06-01 03:15:37.392547 | debian-bookworm -> localhost | | +.*.o o | 2026-06-01 03:15:37.392571 | debian-bookworm -> localhost | |. .+B+*oo | 2026-06-01 03:15:37.392595 | debian-bookworm -> localhost | |. +o=**Oo | 2026-06-01 03:15:37.392620 | debian-bookworm -> localhost | | ++++BBo. | 2026-06-01 03:15:37.392645 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-01 03:15:37.392731 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.501493 2026-06-01 03:15:37.401463 | 2026-06-01 03:15:37.401626 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-01 03:15:37.439370 | debian-bookworm | ok 2026-06-01 03:15:37.453858 | debian-bookworm | included: /var/lib/zuul/builds/7da57eb429654fca8cdd44e5ddc1729e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-01 03:15:37.468061 | 2026-06-01 03:15:37.468209 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-01 03:15:37.493753 | debian-bookworm | skipping: Conditional result was False 2026-06-01 03:15:37.504204 | 2026-06-01 03:15:37.504452 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-01 03:15:38.183730 | debian-bookworm | changed 2026-06-01 03:15:38.192323 | 2026-06-01 03:15:38.192455 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-01 03:15:38.503482 | debian-bookworm | ok 2026-06-01 03:15:38.515331 | 2026-06-01 03:15:38.515515 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-01 03:15:39.204412 | debian-bookworm | changed 2026-06-01 03:15:39.213734 | 2026-06-01 03:15:39.213863 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-01 03:15:39.902078 | debian-bookworm | changed 2026-06-01 03:15:39.911653 | 2026-06-01 03:15:39.911816 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-01 03:15:39.946093 | debian-bookworm | skipping: Conditional result was False 2026-06-01 03:15:39.952976 | 2026-06-01 03:15:39.953096 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-01 03:15:40.526644 | debian-bookworm -> localhost | changed 2026-06-01 03:15:40.542312 | 2026-06-01 03:15:40.542439 | TASK [add-build-sshkey : Add back temp key] 2026-06-01 03:15:40.924046 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/7da57eb429654fca8cdd44e5ddc1729e/work/7da57eb429654fca8cdd44e5ddc1729e_id_rsa (zuul-build-sshkey) 2026-06-01 03:15:40.924333 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.020854 2026-06-01 03:15:40.933070 | 2026-06-01 03:15:40.933185 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-01 03:15:41.391315 | debian-bookworm | ok 2026-06-01 03:15:41.399960 | 2026-06-01 03:15:41.400153 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-01 03:15:41.435790 | debian-bookworm | skipping: Conditional result was False 2026-06-01 03:15:41.452035 | 2026-06-01 03:15:41.452221 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-01 03:15:41.909975 | debian-bookworm | ok 2026-06-01 03:15:41.921797 | 2026-06-01 03:15:41.921942 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-01 03:15:41.952472 | debian-bookworm | ok 2026-06-01 03:15:41.957591 | 2026-06-01 03:15:41.957711 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-01 03:15:42.331460 | debian-bookworm -> localhost | ok 2026-06-01 03:15:42.338931 | 2026-06-01 03:15:42.339059 | TASK [validate-host : Collect information about the host] 2026-06-01 03:15:43.510129 | debian-bookworm | ok 2026-06-01 03:15:43.521321 | 2026-06-01 03:15:43.522280 | TASK [validate-host : Sanitize hostname] 2026-06-01 03:15:43.667587 | debian-bookworm | ok 2026-06-01 03:15:43.719344 | 2026-06-01 03:15:43.719500 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-01 03:15:44.376270 | debian-bookworm -> localhost | changed 2026-06-01 03:15:44.383307 | 2026-06-01 03:15:44.383439 | TASK [validate-host : Collect information about zuul worker] 2026-06-01 03:15:44.821572 | debian-bookworm | ok 2026-06-01 03:15:44.828364 | 2026-06-01 03:15:44.828487 | TASK [validate-host : Write out all zuul information for each host] 2026-06-01 03:15:45.391181 | debian-bookworm -> localhost | changed 2026-06-01 03:15:45.402416 | 2026-06-01 03:15:45.402572 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-01 03:15:45.703535 | debian-bookworm | ok 2026-06-01 03:15:45.716257 | 2026-06-01 03:15:45.716440 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-01 03:15:46.645244 | debian-bookworm | changed: 2026-06-01 03:15:46.645557 | debian-bookworm | cd+++++++++ src/ 2026-06-01 03:15:46.645614 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-01 03:15:46.645655 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-01 03:15:46.645743 | debian-bookworm | cd+++++++++ src/github.com/osism/netbox-plugin-osism/ 2026-06-01 03:15:46.645780 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/7da57eb429654fca8cdd44e5ddc1729e/work/logs" 2026-06-01 03:16:14.960765 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/7da57eb429654fca8cdd44e5ddc1729e/work/artifacts" 2026-06-01 03:16:15.346191 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/7da57eb429654fca8cdd44e5ddc1729e/work/docs" 2026-06-01 03:16:15.361487 | 2026-06-01 03:16:15.361604 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-01 03:16:16.152453 | debian-bookworm | changed: 2026-06-01 03:16:16.152732 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-01 03:16:16.152769 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-01 03:16:16.152799 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-01 03:16:16.152843 | debian-bookworm | changed: All items complete 2026-06-01 03:16:16.152869 | 2026-06-01 03:16:17.048099 | debian-bookworm | changed: .d..t...... ./ 2026-06-01 03:16:17.954888 | debian-bookworm | changed: .d..t...... ./ 2026-06-01 03:16:17.975636 | 2026-06-01 03:16:17.975812 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-01 03:16:18.043031 | debian-bookworm | skipping: Conditional result was False 2026-06-01 03:16:18.052755 | debian-bookworm | skipping: Conditional result was False 2026-06-01 03:16:18.067664 | 2026-06-01 03:16:18.067792 | PLAY RECAP 2026-06-01 03:16:18.067848 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-06-01 03:16:18.067875 | 2026-06-01 03:16:18.374202 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-01 03:16:18.375068 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-01 03:16:20.323536 | 2026-06-01 03:16:20.323806 | PLAY [Base post] 2026-06-01 03:16:20.360593 | 2026-06-01 03:16:20.360736 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-01 03:16:21.051205 | debian-bookworm | changed 2026-06-01 03:16:21.062121 | 2026-06-01 03:16:21.062211 | PLAY RECAP 2026-06-01 03:16:21.062261 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-01 03:16:21.062435 | 2026-06-01 03:16:21.174469 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-01 03:16:21.175228 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-01 03:16:22.309157 | 2026-06-01 03:16:22.309297 | PLAY [Base post-logs] 2026-06-01 03:16:22.333266 | 2026-06-01 03:16:22.333521 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-01 03:16:22.978340 | localhost | changed 2026-06-01 03:16:22.987465 | 2026-06-01 03:16:22.987589 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-01 03:16:23.015039 | localhost | ok 2026-06-01 03:16:23.021330 | 2026-06-01 03:16:23.021468 | TASK [Set zuul-log-path fact] 2026-06-01 03:16:23.036677 | localhost | ok 2026-06-01 03:16:23.043792 | 2026-06-01 03:16:23.043880 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-01 03:16:23.067835 | localhost | ok 2026-06-01 03:16:23.070502 | 2026-06-01 03:16:23.070582 | TASK [upload-logs : Create log directories] 2026-06-01 03:16:23.637175 | localhost | changed 2026-06-01 03:16:23.639876 | 2026-06-01 03:16:23.639975 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-01 03:16:24.346521 | localhost -> localhost | ok: Runtime: 0:00:00.004681 2026-06-01 03:16:24.351483 | 2026-06-01 03:16:24.351598 | TASK [upload-logs : Upload logs to log server] 2026-06-01 03:16:25.630171 | localhost | Output suppressed because no_log was given 2026-06-01 03:16:25.635697 | 2026-06-01 03:16:25.636354 | LOOP [upload-logs : Compress console log and json output] 2026-06-01 03:16:25.729312 | localhost | skipping: Conditional result was False 2026-06-01 03:16:25.742948 | localhost | skipping: Conditional result was False 2026-06-01 03:16:25.750003 | 2026-06-01 03:16:25.750129 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-01 03:16:25.834956 | localhost | skipping: Conditional result was False 2026-06-01 03:16:25.835246 | 2026-06-01 03:16:25.841444 | localhost | skipping: Conditional result was False 2026-06-01 03:16:25.858653 | 2026-06-01 03:16:25.858784 | LOOP [upload-logs : Upload console log and json output]