2026-08-07 03:03:47.625552 | Job console starting 2026-08-07 03:03:47.633756 | Updating git repos 2026-08-07 03:03:47.670315 | Cloning repos into workspace 2026-08-07 03:03:47.766235 | Restoring repo states 2026-08-07 03:03:47.783001 | Merging changes 2026-08-07 03:03:47.783016 | Checking out repos 2026-08-07 03:03:47.857135 | Preparing playbooks 2026-08-07 03:03:49.298260 | Running Ansible setup 2026-08-07 03:03:55.471198 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-08-07 03:03:56.787291 | 2026-08-07 03:03:56.787409 | PLAY [Base pre] 2026-08-07 03:03:56.816825 | 2026-08-07 03:03:56.816938 | TASK [Setup log path fact] 2026-08-07 03:03:56.833602 | debian-bookworm | ok 2026-08-07 03:03:56.849866 | 2026-08-07 03:03:56.849992 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-07 03:03:56.885852 | debian-bookworm | ok 2026-08-07 03:03:56.901087 | 2026-08-07 03:03:56.901209 | TASK [emit-job-header : Print job information] 2026-08-07 03:03:56.959974 | # Job Information 2026-08-07 03:03:56.960147 | Ansible Version: 2.16.14 2026-08-07 03:03:56.960183 | Job: python-black 2026-08-07 03:03:56.960215 | Pipeline: periodic-daily 2026-08-07 03:03:56.960239 | Executor: 521e9411259a 2026-08-07 03:03:56.960259 | Triggered by: https://github.com/osism/netbox-plugin-osism 2026-08-07 03:03:56.960282 | Event ID: db38dd94d8184ce19d35ce0e54e2349a 2026-08-07 03:03:56.965109 | 2026-08-07 03:03:56.965213 | LOOP [emit-job-header : Print node information] 2026-08-07 03:03:57.116923 | debian-bookworm | ok: 2026-08-07 03:03:57.117130 | debian-bookworm | # Node Information 2026-08-07 03:03:57.117164 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-08-07 03:03:57.117184 | debian-bookworm | Hostname: debian 2026-08-07 03:03:57.117203 | debian-bookworm | Username: zuul 2026-08-07 03:03:57.117219 | debian-bookworm | Distro: Debian 12.15 2026-08-07 03:03:57.117239 | debian-bookworm | Provider: regiocloud-a 2026-08-07 03:03:57.117257 | debian-bookworm | Region: 2026-08-07 03:03:57.117276 | debian-bookworm | Label: debian-bookworm 2026-08-07 03:03:57.117292 | debian-bookworm | Product Name: OpenStack Nova 2026-08-07 03:03:57.117307 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe80:c189 2026-08-07 03:03:57.134684 | 2026-08-07 03:03:57.134798 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-07 03:03:57.815283 | debian-bookworm -> localhost | changed 2026-08-07 03:03:57.823319 | 2026-08-07 03:03:57.823474 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-07 03:03:59.411970 | debian-bookworm -> localhost | changed 2026-08-07 03:03:59.420654 | 2026-08-07 03:03:59.420770 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-07 03:03:59.665825 | debian-bookworm -> localhost | ok 2026-08-07 03:03:59.670827 | 2026-08-07 03:03:59.671061 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-07 03:03:59.688656 | debian-bookworm | ok 2026-08-07 03:03:59.710104 | debian-bookworm | included: /var/lib/zuul/builds/07cd3cef5dce4c2287b4179c9516cecc/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-07 03:03:59.718713 | 2026-08-07 03:03:59.718906 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-07 03:04:01.186165 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-08-07 03:04:01.186417 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/07cd3cef5dce4c2287b4179c9516cecc/work/07cd3cef5dce4c2287b4179c9516cecc_id_rsa 2026-08-07 03:04:01.186456 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/07cd3cef5dce4c2287b4179c9516cecc/work/07cd3cef5dce4c2287b4179c9516cecc_id_rsa.pub 2026-08-07 03:04:01.186500 | debian-bookworm -> localhost | The key fingerprint is: 2026-08-07 03:04:01.186528 | debian-bookworm -> localhost | SHA256:um85Jpgxq8tQNijqdtIlXyUrUc6g/FqJYXZndbMkl0c zuul-build-sshkey 2026-08-07 03:04:01.186551 | debian-bookworm -> localhost | The key's randomart image is: 2026-08-07 03:04:01.186583 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-08-07 03:04:01.186606 | debian-bookworm -> localhost | | oE | 2026-08-07 03:04:01.186629 | debian-bookworm -> localhost | | . . o * . | 2026-08-07 03:04:01.186656 | debian-bookworm -> localhost | | . . = . = + | 2026-08-07 03:04:01.186676 | debian-bookworm -> localhost | | . * o * . . | 2026-08-07 03:04:01.186696 | debian-bookworm -> localhost | |o * = = S | 2026-08-07 03:04:01.186725 | debian-bookworm -> localhost | |oo +o* + | 2026-08-07 03:04:01.186773 | debian-bookworm -> localhost | |o . **+ . | 2026-08-07 03:04:01.186794 | debian-bookworm -> localhost | |.= ++...= | 2026-08-07 03:04:01.186815 | debian-bookworm -> localhost | |..*o .=.. | 2026-08-07 03:04:01.186954 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-08-07 03:04:01.187018 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.994508 2026-08-07 03:04:01.193784 | 2026-08-07 03:04:01.193884 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-07 03:04:01.244133 | debian-bookworm | ok 2026-08-07 03:04:01.252426 | debian-bookworm | included: /var/lib/zuul/builds/07cd3cef5dce4c2287b4179c9516cecc/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-07 03:04:01.263419 | 2026-08-07 03:04:01.263594 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-07 03:04:01.287241 | debian-bookworm | skipping: Conditional result was False 2026-08-07 03:04:01.295530 | 2026-08-07 03:04:01.295634 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-07 03:04:01.968023 | debian-bookworm | changed 2026-08-07 03:04:01.978771 | 2026-08-07 03:04:01.978896 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-07 03:04:02.245479 | debian-bookworm | ok 2026-08-07 03:04:02.251545 | 2026-08-07 03:04:02.251654 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-07 03:04:02.946916 | debian-bookworm | changed 2026-08-07 03:04:02.964369 | 2026-08-07 03:04:02.964488 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-07 03:04:03.716683 | debian-bookworm | changed 2026-08-07 03:04:03.721661 | 2026-08-07 03:04:03.721775 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-07 03:04:03.787825 | debian-bookworm | skipping: Conditional result was False 2026-08-07 03:04:03.793961 | 2026-08-07 03:04:03.794098 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-07 03:04:04.687300 | debian-bookworm -> localhost | changed 2026-08-07 03:04:04.695829 | 2026-08-07 03:04:04.695914 | TASK [add-build-sshkey : Add back temp key] 2026-08-07 03:04:05.037527 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/07cd3cef5dce4c2287b4179c9516cecc/work/07cd3cef5dce4c2287b4179c9516cecc_id_rsa (zuul-build-sshkey) 2026-08-07 03:04:05.037743 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.022837 2026-08-07 03:04:05.044428 | 2026-08-07 03:04:05.044522 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-07 03:04:05.437596 | debian-bookworm | ok 2026-08-07 03:04:05.445353 | 2026-08-07 03:04:05.445447 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-07 03:04:05.471097 | debian-bookworm | skipping: Conditional result was False 2026-08-07 03:04:05.481964 | 2026-08-07 03:04:05.482066 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-08-07 03:04:05.887563 | debian-bookworm | ok 2026-08-07 03:04:05.904989 | 2026-08-07 03:04:05.905103 | TASK [validate-host : Define zuul_info_dir fact] 2026-08-07 03:04:05.953179 | debian-bookworm | ok 2026-08-07 03:04:05.958061 | 2026-08-07 03:04:05.958147 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-08-07 03:04:06.347143 | debian-bookworm -> localhost | ok 2026-08-07 03:04:06.353931 | 2026-08-07 03:04:06.354039 | TASK [validate-host : Collect information about the host] 2026-08-07 03:04:07.476452 | debian-bookworm | ok 2026-08-07 03:04:07.489778 | 2026-08-07 03:04:07.489913 | TASK [validate-host : Sanitize hostname] 2026-08-07 03:04:07.640251 | debian-bookworm | ok 2026-08-07 03:04:07.645249 | 2026-08-07 03:04:07.645353 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-08-07 03:04:08.255852 | debian-bookworm -> localhost | changed 2026-08-07 03:04:08.263019 | 2026-08-07 03:04:08.263218 | TASK [validate-host : Collect information about zuul worker] 2026-08-07 03:04:08.726871 | debian-bookworm | ok 2026-08-07 03:04:08.732175 | 2026-08-07 03:04:08.732288 | TASK [validate-host : Write out all zuul information for each host] 2026-08-07 03:04:09.375055 | debian-bookworm -> localhost | changed 2026-08-07 03:04:09.385059 | 2026-08-07 03:04:09.385157 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-08-07 03:04:09.644525 | debian-bookworm | ok 2026-08-07 03:04:09.649933 | 2026-08-07 03:04:09.650034 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-08-07 03:04:10.929928 | debian-bookworm | changed: 2026-08-07 03:04:10.930153 | debian-bookworm | cd+++++++++ src/ 2026-08-07 03:04:10.930328 | debian-bookworm | cd+++++++++ src/github.com/ 2026-08-07 03:04:10.930358 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-08-07 03:04:10.930382 | debian-bookworm | cd+++++++++ src/github.com/osism/netbox-plugin-osism/ 2026-08-07 03:04:10.930404 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/07cd3cef5dce4c2287b4179c9516cecc/work/logs" 2026-08-07 03:05:14.280203 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/07cd3cef5dce4c2287b4179c9516cecc/work/artifacts" 2026-08-07 03:05:14.967958 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/07cd3cef5dce4c2287b4179c9516cecc/work/docs" 2026-08-07 03:05:14.979748 | 2026-08-07 03:05:14.979848 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-07 03:05:16.317268 | debian-bookworm | changed: 2026-08-07 03:05:16.317450 | debian-bookworm | .d..t...... ./ 2026-08-07 03:05:16.317489 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-08-07 03:05:16.317509 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-08-07 03:05:16.317527 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-08-07 03:05:16.317544 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-08-07 03:05:16.317560 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-08-07 03:05:16.317591 | debian-bookworm | changed: All items complete 2026-08-07 03:05:16.317612 | 2026-08-07 03:05:17.332173 | debian-bookworm | changed: .d..t...... ./ 2026-08-07 03:05:18.341583 | debian-bookworm | changed: .d..t...... ./ 2026-08-07 03:05:18.361239 | 2026-08-07 03:05:18.361340 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-07 03:05:18.400095 | debian-bookworm | skipping: Conditional result was False 2026-08-07 03:05:18.413594 | debian-bookworm | skipping: Conditional result was False 2026-08-07 03:05:18.420350 | 2026-08-07 03:05:18.420414 | PLAY RECAP 2026-08-07 03:05:18.420474 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-08-07 03:05:18.420499 | 2026-08-07 03:05:18.629583 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-08-07 03:05:18.630234 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-07 03:05:20.015986 | 2026-08-07 03:05:20.016102 | PLAY [Base post] 2026-08-07 03:05:20.026892 | 2026-08-07 03:05:20.027000 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-07 03:05:20.516145 | debian-bookworm | changed 2026-08-07 03:05:20.523073 | 2026-08-07 03:05:20.523160 | PLAY RECAP 2026-08-07 03:05:20.523218 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-07 03:05:20.523280 | 2026-08-07 03:05:20.693479 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-07 03:05:20.694280 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-07 03:05:21.776351 | 2026-08-07 03:05:21.776527 | PLAY [Base post-logs] 2026-08-07 03:05:21.807548 | 2026-08-07 03:05:21.807683 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-07 03:05:22.729333 | localhost | changed 2026-08-07 03:05:22.738519 | 2026-08-07 03:05:22.738639 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-07 03:05:22.783606 | localhost | ok 2026-08-07 03:05:22.786291 | 2026-08-07 03:05:22.786385 | TASK [Set zuul-log-path fact] 2026-08-07 03:05:22.811877 | localhost | ok 2026-08-07 03:05:22.819598 | 2026-08-07 03:05:22.819716 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-07 03:05:22.854215 | localhost | ok 2026-08-07 03:05:22.856772 | 2026-08-07 03:05:22.856862 | TASK [upload-logs : Create log directories] 2026-08-07 03:05:23.907416 | localhost | changed 2026-08-07 03:05:23.909681 | 2026-08-07 03:05:23.909760 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-07 03:05:25.183968 | localhost -> localhost | ok: Runtime: 0:00:00.021406 2026-08-07 03:05:25.187344 | 2026-08-07 03:05:25.187434 | TASK [upload-logs : Upload logs to log server] 2026-08-07 03:05:26.124570 | localhost | Output suppressed because no_log was given 2026-08-07 03:05:26.126115 | 2026-08-07 03:05:26.126197 | LOOP [upload-logs : Compress console log and json output] 2026-08-07 03:05:26.208601 | localhost | skipping: Conditional result was False 2026-08-07 03:05:26.225055 | localhost | skipping: Conditional result was False 2026-08-07 03:05:26.232265 | 2026-08-07 03:05:26.232348 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-07 03:05:26.309912 | localhost | skipping: Conditional result was False 2026-08-07 03:05:26.310158 | 2026-08-07 03:05:26.319146 | localhost | skipping: Conditional result was False 2026-08-07 03:05:26.327916 | 2026-08-07 03:05:26.328012 | LOOP [upload-logs : Upload console log and json output]