2026-09-14 03:19:59.495746 | Job console starting 2026-09-14 03:19:59.519796 | Updating git repos 2026-09-14 03:19:59.570251 | Cloning repos into workspace 2026-09-14 03:19:59.628099 | Restoring repo states 2026-09-14 03:19:59.644050 | Merging changes 2026-09-14 03:19:59.644071 | Checking out repos 2026-09-14 03:19:59.698709 | Preparing playbooks 2026-09-14 03:20:01.109817 | Running Ansible setup 2026-09-14 03:20:05.917651 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-14 03:20:06.627090 | 2026-09-14 03:20:06.627207 | PLAY [Base pre] 2026-09-14 03:20:06.643597 | 2026-09-14 03:20:06.643699 | TASK [Setup log path fact] 2026-09-14 03:20:06.671515 | debian-bookworm | ok 2026-09-14 03:20:06.686467 | 2026-09-14 03:20:06.686576 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-14 03:20:06.736993 | debian-bookworm | ok 2026-09-14 03:20:06.748282 | 2026-09-14 03:20:06.748373 | TASK [emit-job-header : Print job information] 2026-09-14 03:20:06.798490 | # Job Information 2026-09-14 03:20:06.798641 | Ansible Version: 2.16.14 2026-09-14 03:20:06.798676 | Job: python-black 2026-09-14 03:20:06.798709 | Pipeline: periodic-daily 2026-09-14 03:20:06.798732 | Executor: 521e9411259a 2026-09-14 03:20:06.798753 | Triggered by: https://github.com/osism/netbox-plugin-osism 2026-09-14 03:20:06.798776 | Event ID: 32317ab1e9aa4a979b71add4eb526de8 2026-09-14 03:20:06.803459 | 2026-09-14 03:20:06.803546 | LOOP [emit-job-header : Print node information] 2026-09-14 03:20:06.909266 | debian-bookworm | ok: 2026-09-14 03:20:06.910873 | debian-bookworm | # Node Information 2026-09-14 03:20:06.910945 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-14 03:20:06.910975 | debian-bookworm | Hostname: debian 2026-09-14 03:20:06.910999 | debian-bookworm | Username: zuul 2026-09-14 03:20:06.911021 | debian-bookworm | Distro: Debian 12.15 2026-09-14 03:20:06.911045 | debian-bookworm | Provider: regiocloud-a 2026-09-14 03:20:06.911066 | debian-bookworm | Region: 2026-09-14 03:20:06.911088 | debian-bookworm | Label: debian-bookworm 2026-09-14 03:20:06.911108 | debian-bookworm | Product Name: OpenStack Nova 2026-09-14 03:20:06.911127 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe84:100a 2026-09-14 03:20:06.928961 | 2026-09-14 03:20:06.929074 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-14 03:20:07.337528 | debian-bookworm -> localhost | changed 2026-09-14 03:20:07.355644 | 2026-09-14 03:20:07.355870 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-14 03:20:08.275579 | debian-bookworm -> localhost | changed 2026-09-14 03:20:08.286005 | 2026-09-14 03:20:08.286097 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-14 03:20:08.612429 | debian-bookworm -> localhost | ok 2026-09-14 03:20:08.618748 | 2026-09-14 03:20:08.618846 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-14 03:20:08.638352 | debian-bookworm | ok 2026-09-14 03:20:08.652778 | debian-bookworm | included: /var/lib/zuul/builds/77b8155c99654f3b834fdc7a1ec3a808/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-14 03:20:08.659013 | 2026-09-14 03:20:08.659098 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-14 03:20:10.197764 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-14 03:20:10.198007 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/77b8155c99654f3b834fdc7a1ec3a808/work/77b8155c99654f3b834fdc7a1ec3a808_id_rsa 2026-09-14 03:20:10.198047 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/77b8155c99654f3b834fdc7a1ec3a808/work/77b8155c99654f3b834fdc7a1ec3a808_id_rsa.pub 2026-09-14 03:20:10.198075 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-14 03:20:10.198100 | debian-bookworm -> localhost | SHA256:G62KMb9wWBsC6UtP2T4Y2HpMtStZmdelzQA1mAd+QEc zuul-build-sshkey 2026-09-14 03:20:10.198122 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-14 03:20:10.198153 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-14 03:20:10.198175 | debian-bookworm -> localhost | | .=*E | 2026-09-14 03:20:10.198197 | debian-bookworm -> localhost | | . .o+.. | 2026-09-14 03:20:10.198217 | debian-bookworm -> localhost | | o . ..o . | 2026-09-14 03:20:10.198273 | debian-bookworm -> localhost | | . + + + + * | 2026-09-14 03:20:10.198296 | debian-bookworm -> localhost | | + B O S + o | 2026-09-14 03:20:10.198322 | debian-bookworm -> localhost | | . B X = + | 2026-09-14 03:20:10.198343 | debian-bookworm -> localhost | | o % * o | 2026-09-14 03:20:10.198363 | debian-bookworm -> localhost | | . O o | 2026-09-14 03:20:10.198385 | debian-bookworm -> localhost | | . +. | 2026-09-14 03:20:10.198406 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-14 03:20:10.198461 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.108086 2026-09-14 03:20:10.204811 | 2026-09-14 03:20:10.204903 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-14 03:20:10.224786 | debian-bookworm | ok 2026-09-14 03:20:10.235840 | debian-bookworm | included: /var/lib/zuul/builds/77b8155c99654f3b834fdc7a1ec3a808/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-14 03:20:10.244928 | 2026-09-14 03:20:10.245011 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-14 03:20:10.259038 | debian-bookworm | skipping: Conditional result was False 2026-09-14 03:20:10.264945 | 2026-09-14 03:20:10.265066 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-14 03:20:11.061613 | debian-bookworm | changed 2026-09-14 03:20:11.067078 | 2026-09-14 03:20:11.067165 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-14 03:20:11.356916 | debian-bookworm | ok 2026-09-14 03:20:11.362300 | 2026-09-14 03:20:11.362390 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-14 03:20:12.047511 | debian-bookworm | changed 2026-09-14 03:20:12.053335 | 2026-09-14 03:20:12.053423 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-14 03:20:12.761442 | debian-bookworm | changed 2026-09-14 03:20:12.766794 | 2026-09-14 03:20:12.766876 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-14 03:20:12.779535 | debian-bookworm | skipping: Conditional result was False 2026-09-14 03:20:12.785079 | 2026-09-14 03:20:12.785162 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-14 03:20:13.314326 | debian-bookworm -> localhost | changed 2026-09-14 03:20:13.326944 | 2026-09-14 03:20:13.327031 | TASK [add-build-sshkey : Add back temp key] 2026-09-14 03:20:13.642974 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/77b8155c99654f3b834fdc7a1ec3a808/work/77b8155c99654f3b834fdc7a1ec3a808_id_rsa (zuul-build-sshkey) 2026-09-14 03:20:13.643187 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.016560 2026-09-14 03:20:13.650437 | 2026-09-14 03:20:13.650519 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-14 03:20:14.071130 | debian-bookworm | ok 2026-09-14 03:20:14.079895 | 2026-09-14 03:20:14.080133 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-14 03:20:14.114645 | debian-bookworm | skipping: Conditional result was False 2026-09-14 03:20:14.130806 | 2026-09-14 03:20:14.130918 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-14 03:20:14.584927 | debian-bookworm | ok 2026-09-14 03:20:14.596997 | 2026-09-14 03:20:14.597113 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-14 03:20:14.637107 | debian-bookworm | ok 2026-09-14 03:20:14.642440 | 2026-09-14 03:20:14.642541 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-14 03:20:14.991698 | debian-bookworm -> localhost | ok 2026-09-14 03:20:15.007164 | 2026-09-14 03:20:15.007386 | TASK [validate-host : Collect information about the host] 2026-09-14 03:20:16.254395 | debian-bookworm | ok 2026-09-14 03:20:16.276123 | 2026-09-14 03:20:16.276297 | TASK [validate-host : Sanitize hostname] 2026-09-14 03:20:16.449059 | debian-bookworm | ok 2026-09-14 03:20:16.453930 | 2026-09-14 03:20:16.454038 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-14 03:20:17.016497 | debian-bookworm -> localhost | changed 2026-09-14 03:20:17.022581 | 2026-09-14 03:20:17.022710 | TASK [validate-host : Collect information about zuul worker] 2026-09-14 03:20:17.490157 | debian-bookworm | ok 2026-09-14 03:20:17.495423 | 2026-09-14 03:20:17.495537 | TASK [validate-host : Write out all zuul information for each host] 2026-09-14 03:20:18.046184 | debian-bookworm -> localhost | changed 2026-09-14 03:20:18.060701 | 2026-09-14 03:20:18.060819 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-14 03:20:18.358767 | debian-bookworm | ok 2026-09-14 03:20:18.367542 | 2026-09-14 03:20:18.367662 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-14 03:20:19.229269 | debian-bookworm | changed: 2026-09-14 03:20:19.229524 | debian-bookworm | cd+++++++++ src/ 2026-09-14 03:20:19.229851 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-14 03:20:19.229899 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-14 03:20:19.229934 | debian-bookworm | cd+++++++++ src/github.com/osism/netbox-plugin-osism/ 2026-09-14 03:20:19.229966 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/77b8155c99654f3b834fdc7a1ec3a808/work/logs" 2026-09-14 03:21:26.190109 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/77b8155c99654f3b834fdc7a1ec3a808/work/artifacts" 2026-09-14 03:21:26.713289 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/77b8155c99654f3b834fdc7a1ec3a808/work/docs" 2026-09-14 03:21:26.724843 | 2026-09-14 03:21:26.724941 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-14 03:21:27.757476 | debian-bookworm | changed: 2026-09-14 03:21:27.757814 | debian-bookworm | .d..t...... ./ 2026-09-14 03:21:27.757848 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-14 03:21:27.757870 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-14 03:21:27.757888 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-14 03:21:27.757905 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-14 03:21:27.757921 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-14 03:21:27.757953 | debian-bookworm | changed: All items complete 2026-09-14 03:21:27.757973 | 2026-09-14 03:21:28.523861 | debian-bookworm | changed: .d..t...... ./ 2026-09-14 03:21:29.120218 | debian-bookworm | changed: .d..t...... ./ 2026-09-14 03:21:29.142848 | 2026-09-14 03:21:29.142935 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-14 03:21:29.168239 | debian-bookworm | skipping: Conditional result was False 2026-09-14 03:21:29.173205 | debian-bookworm | skipping: Conditional result was False 2026-09-14 03:21:29.181845 | 2026-09-14 03:21:29.181900 | PLAY RECAP 2026-09-14 03:21:29.181940 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-09-14 03:21:29.181961 | 2026-09-14 03:21:29.288537 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-14 03:21:29.289246 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-14 03:21:30.489369 | 2026-09-14 03:21:30.489512 | PLAY [Base post] 2026-09-14 03:21:30.532430 | 2026-09-14 03:21:30.532556 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-14 03:21:31.192628 | debian-bookworm | changed 2026-09-14 03:21:31.205627 | 2026-09-14 03:21:31.205729 | PLAY RECAP 2026-09-14 03:21:31.205789 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-14 03:21:31.205850 | 2026-09-14 03:21:31.390660 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-14 03:21:31.391378 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-14 03:21:32.192680 | 2026-09-14 03:21:32.192795 | PLAY [Base post-logs] 2026-09-14 03:21:32.218590 | 2026-09-14 03:21:32.218703 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-14 03:21:32.777567 | localhost | changed 2026-09-14 03:21:32.785033 | 2026-09-14 03:21:32.785137 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-14 03:21:32.825260 | localhost | ok 2026-09-14 03:21:32.828413 | 2026-09-14 03:21:32.828540 | TASK [Set zuul-log-path fact] 2026-09-14 03:21:32.843106 | localhost | ok 2026-09-14 03:21:32.862139 | 2026-09-14 03:21:32.862235 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-14 03:21:32.886687 | localhost | ok 2026-09-14 03:21:32.889345 | 2026-09-14 03:21:32.889426 | TASK [upload-logs : Create log directories] 2026-09-14 03:21:33.441416 | localhost | changed 2026-09-14 03:21:33.445400 | 2026-09-14 03:21:33.445499 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-14 03:21:33.934139 | localhost -> localhost | ok: Runtime: 0:00:00.007107 2026-09-14 03:21:33.939631 | 2026-09-14 03:21:33.939725 | TASK [upload-logs : Upload logs to log server] 2026-09-14 03:21:34.459721 | localhost | Output suppressed because no_log was given 2026-09-14 03:21:34.461308 | 2026-09-14 03:21:34.461417 | LOOP [upload-logs : Compress console log and json output] 2026-09-14 03:21:34.496371 | localhost | skipping: Conditional result was False 2026-09-14 03:21:34.501187 | localhost | skipping: Conditional result was False 2026-09-14 03:21:34.508852 | 2026-09-14 03:21:34.509024 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-14 03:21:34.560219 | localhost | skipping: Conditional result was False 2026-09-14 03:21:34.560425 | 2026-09-14 03:21:34.565353 | localhost | skipping: Conditional result was False 2026-09-14 03:21:34.575808 | 2026-09-14 03:21:34.575897 | LOOP [upload-logs : Upload console log and json output]