2026-06-06 03:04:02.593358 | Job console starting 2026-06-06 03:04:02.637618 | Updating git repos 2026-06-06 03:04:02.687053 | Cloning repos into workspace 2026-06-06 03:04:02.776238 | Restoring repo states 2026-06-06 03:04:02.817468 | Merging changes 2026-06-06 03:04:02.817504 | Checking out repos 2026-06-06 03:04:02.907567 | Preparing playbooks 2026-06-06 03:04:04.327106 | Running Ansible setup 2026-06-06 03:04:10.808019 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-06 03:04:11.749494 | 2026-06-06 03:04:11.749607 | PLAY [Base pre] 2026-06-06 03:04:11.780538 | 2026-06-06 03:04:11.780838 | TASK [Setup log path fact] 2026-06-06 03:04:11.799379 | debian-bookworm | ok 2026-06-06 03:04:11.819769 | 2026-06-06 03:04:11.819892 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-06 03:04:11.883053 | debian-bookworm | ok 2026-06-06 03:04:11.897137 | 2026-06-06 03:04:11.897236 | TASK [emit-job-header : Print job information] 2026-06-06 03:04:11.988248 | # Job Information 2026-06-06 03:04:11.988426 | Ansible Version: 2.16.14 2026-06-06 03:04:11.988457 | Job: python-black 2026-06-06 03:04:11.988507 | Pipeline: periodic-daily 2026-06-06 03:04:11.988528 | Executor: 521e9411259a 2026-06-06 03:04:11.988546 | Triggered by: https://github.com/osism/netbox-plugin-osism 2026-06-06 03:04:11.988566 | Event ID: b23e26e21ca2494d9611bffa271fe440 2026-06-06 03:04:11.993248 | 2026-06-06 03:04:11.993334 | LOOP [emit-job-header : Print node information] 2026-06-06 03:04:12.103329 | debian-bookworm | ok: 2026-06-06 03:04:12.103475 | debian-bookworm | # Node Information 2026-06-06 03:04:12.103517 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-06 03:04:12.103538 | debian-bookworm | Hostname: debian 2026-06-06 03:04:12.103557 | debian-bookworm | Username: zuul 2026-06-06 03:04:12.103574 | debian-bookworm | Distro: Debian 12.14 2026-06-06 03:04:12.103592 | debian-bookworm | Provider: regiocloud-a 2026-06-06 03:04:12.103609 | debian-bookworm | Region: 2026-06-06 03:04:12.103627 | debian-bookworm | Label: debian-bookworm 2026-06-06 03:04:12.103643 | debian-bookworm | Product Name: OpenStack Nova 2026-06-06 03:04:12.103659 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe7f:f7d5 2026-06-06 03:04:12.126324 | 2026-06-06 03:04:12.126428 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-06 03:04:12.588017 | debian-bookworm -> localhost | changed 2026-06-06 03:04:12.593941 | 2026-06-06 03:04:12.594031 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-06 03:04:13.774197 | debian-bookworm -> localhost | changed 2026-06-06 03:04:13.784721 | 2026-06-06 03:04:13.784826 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-06 03:04:14.144504 | debian-bookworm -> localhost | ok 2026-06-06 03:04:14.150556 | 2026-06-06 03:04:14.150664 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-06 03:04:14.180008 | debian-bookworm | ok 2026-06-06 03:04:14.194817 | debian-bookworm | included: /var/lib/zuul/builds/14fc9a9e638048bbb008a8510e9f1f93/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-06 03:04:14.200740 | 2026-06-06 03:04:14.200830 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-06 03:04:15.737828 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-06 03:04:15.738002 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/14fc9a9e638048bbb008a8510e9f1f93/work/14fc9a9e638048bbb008a8510e9f1f93_id_rsa 2026-06-06 03:04:15.738034 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/14fc9a9e638048bbb008a8510e9f1f93/work/14fc9a9e638048bbb008a8510e9f1f93_id_rsa.pub 2026-06-06 03:04:15.738057 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-06 03:04:15.738078 | debian-bookworm -> localhost | SHA256:Y6LkgWbmhAdqmyWVvRpsIKcjbguXmI0o07gSlJy7V3s zuul-build-sshkey 2026-06-06 03:04:15.738097 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-06 03:04:15.738123 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-06 03:04:15.738141 | debian-bookworm -> localhost | | | 2026-06-06 03:04:15.738159 | debian-bookworm -> localhost | | o | 2026-06-06 03:04:15.738175 | debian-bookworm -> localhost | |+.+o . | 2026-06-06 03:04:15.738192 | debian-bookworm -> localhost | |oX+. . | 2026-06-06 03:04:15.738209 | debian-bookworm -> localhost | |BoO=o.. S | 2026-06-06 03:04:15.738229 | debian-bookworm -> localhost | |*^*+o+ o . | 2026-06-06 03:04:15.738246 | debian-bookworm -> localhost | |X*B.+ . | 2026-06-06 03:04:15.738263 | debian-bookworm -> localhost | |==.. . E | 2026-06-06 03:04:15.738280 | debian-bookworm -> localhost | |o.. . | 2026-06-06 03:04:15.738297 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-06 03:04:15.738337 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.963937 2026-06-06 03:04:15.743740 | 2026-06-06 03:04:15.743815 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-06 03:04:15.791176 | debian-bookworm | ok 2026-06-06 03:04:15.821852 | debian-bookworm | included: /var/lib/zuul/builds/14fc9a9e638048bbb008a8510e9f1f93/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-06 03:04:15.846710 | 2026-06-06 03:04:15.846808 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-06 03:04:15.891652 | debian-bookworm | skipping: Conditional result was False 2026-06-06 03:04:15.899626 | 2026-06-06 03:04:15.899719 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-06 03:04:16.829331 | debian-bookworm | changed 2026-06-06 03:04:16.844129 | 2026-06-06 03:04:16.844230 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-06 03:04:17.146157 | debian-bookworm | ok 2026-06-06 03:04:17.153166 | 2026-06-06 03:04:17.153255 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-06 03:04:18.130123 | debian-bookworm | changed 2026-06-06 03:04:18.142034 | 2026-06-06 03:04:18.142130 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-06 03:04:19.021911 | debian-bookworm | changed 2026-06-06 03:04:19.027360 | 2026-06-06 03:04:19.028183 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-06 03:04:19.076686 | debian-bookworm | skipping: Conditional result was False 2026-06-06 03:04:19.083241 | 2026-06-06 03:04:19.083337 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-06 03:04:20.030359 | debian-bookworm -> localhost | changed 2026-06-06 03:04:20.057562 | 2026-06-06 03:04:20.057756 | TASK [add-build-sshkey : Add back temp key] 2026-06-06 03:04:20.506147 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/14fc9a9e638048bbb008a8510e9f1f93/work/14fc9a9e638048bbb008a8510e9f1f93_id_rsa (zuul-build-sshkey) 2026-06-06 03:04:20.506341 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012632 2026-06-06 03:04:20.514966 | 2026-06-06 03:04:20.515209 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-06 03:04:20.917539 | debian-bookworm | ok 2026-06-06 03:04:20.923418 | 2026-06-06 03:04:20.923543 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-06 03:04:20.947057 | debian-bookworm | skipping: Conditional result was False 2026-06-06 03:04:20.957513 | 2026-06-06 03:04:20.957614 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-06 03:04:21.399173 | debian-bookworm | ok 2026-06-06 03:04:21.416944 | 2026-06-06 03:04:21.417060 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-06 03:04:21.478724 | debian-bookworm | ok 2026-06-06 03:04:21.487970 | 2026-06-06 03:04:21.488079 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-06 03:04:22.054417 | debian-bookworm -> localhost | ok 2026-06-06 03:04:22.059834 | 2026-06-06 03:04:22.059916 | TASK [validate-host : Collect information about the host] 2026-06-06 03:04:23.308747 | debian-bookworm | ok 2026-06-06 03:04:23.318171 | 2026-06-06 03:04:23.318274 | TASK [validate-host : Sanitize hostname] 2026-06-06 03:04:23.427171 | debian-bookworm | ok 2026-06-06 03:04:23.511589 | 2026-06-06 03:04:23.511706 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-06 03:04:24.365657 | debian-bookworm -> localhost | changed 2026-06-06 03:04:24.370143 | 2026-06-06 03:04:24.370226 | TASK [validate-host : Collect information about zuul worker] 2026-06-06 03:04:24.823990 | debian-bookworm | ok 2026-06-06 03:04:24.828463 | 2026-06-06 03:04:24.828585 | TASK [validate-host : Write out all zuul information for each host] 2026-06-06 03:04:25.331878 | debian-bookworm -> localhost | changed 2026-06-06 03:04:25.340797 | 2026-06-06 03:04:25.340884 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-06 03:04:25.646281 | debian-bookworm | ok 2026-06-06 03:04:25.651541 | 2026-06-06 03:04:25.651626 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-06 03:04:27.122600 | debian-bookworm | changed: 2026-06-06 03:04:27.122858 | debian-bookworm | cd+++++++++ src/ 2026-06-06 03:04:27.122898 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-06 03:04:27.122924 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-06 03:04:27.122956 | debian-bookworm | cd+++++++++ src/github.com/osism/netbox-plugin-osism/ 2026-06-06 03:04:27.123083 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/14fc9a9e638048bbb008a8510e9f1f93/work/logs" 2026-06-06 03:04:54.012408 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/14fc9a9e638048bbb008a8510e9f1f93/work/artifacts" 2026-06-06 03:04:54.300433 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/14fc9a9e638048bbb008a8510e9f1f93/work/docs" 2026-06-06 03:04:54.323179 | 2026-06-06 03:04:54.323324 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-06 03:04:55.201181 | debian-bookworm | changed: 2026-06-06 03:04:55.201370 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-06 03:04:55.201406 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-06 03:04:55.201435 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-06 03:04:55.201495 | debian-bookworm | changed: All items complete 2026-06-06 03:04:55.201524 | 2026-06-06 03:04:55.863621 | debian-bookworm | changed: .d..t...... ./ 2026-06-06 03:04:56.496540 | debian-bookworm | changed: .d..t...... ./ 2026-06-06 03:04:56.511327 | 2026-06-06 03:04:56.511424 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-06 03:04:56.557084 | debian-bookworm | skipping: Conditional result was False 2026-06-06 03:04:56.567905 | debian-bookworm | skipping: Conditional result was False 2026-06-06 03:04:56.580786 | 2026-06-06 03:04:56.580862 | PLAY RECAP 2026-06-06 03:04:56.580902 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-06-06 03:04:56.580922 | 2026-06-06 03:04:56.670649 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-06 03:04:56.671294 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-06 03:04:57.277923 | 2026-06-06 03:04:57.278053 | PLAY [Base post] 2026-06-06 03:04:57.297880 | 2026-06-06 03:04:57.298007 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-06 03:04:57.904878 | debian-bookworm | changed 2026-06-06 03:04:57.910916 | 2026-06-06 03:04:57.911012 | PLAY RECAP 2026-06-06 03:04:57.911070 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-06 03:04:57.911131 | 2026-06-06 03:04:58.000583 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-06 03:04:58.001300 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-06 03:04:58.746169 | 2026-06-06 03:04:58.746364 | PLAY [Base post-logs] 2026-06-06 03:04:58.755880 | 2026-06-06 03:04:58.755996 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-06 03:04:59.248116 | localhost | changed 2026-06-06 03:04:59.257367 | 2026-06-06 03:04:59.257506 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-06 03:04:59.281906 | localhost | ok 2026-06-06 03:04:59.284805 | 2026-06-06 03:04:59.284890 | TASK [Set zuul-log-path fact] 2026-06-06 03:04:59.298879 | localhost | ok 2026-06-06 03:04:59.306011 | 2026-06-06 03:04:59.306106 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-06 03:04:59.340440 | localhost | ok 2026-06-06 03:04:59.348876 | 2026-06-06 03:04:59.348981 | TASK [upload-logs : Create log directories] 2026-06-06 03:04:59.831747 | localhost | changed 2026-06-06 03:04:59.834629 | 2026-06-06 03:04:59.834745 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-06 03:05:00.499806 | localhost -> localhost | ok: Runtime: 0:00:00.005832 2026-06-06 03:05:00.505638 | 2026-06-06 03:05:00.505769 | TASK [upload-logs : Upload logs to log server] 2026-06-06 03:05:01.606045 | localhost | Output suppressed because no_log was given 2026-06-06 03:05:01.632783 | 2026-06-06 03:05:01.632936 | LOOP [upload-logs : Compress console log and json output] 2026-06-06 03:05:01.772441 | localhost | skipping: Conditional result was False 2026-06-06 03:05:01.786096 | localhost | skipping: Conditional result was False 2026-06-06 03:05:01.797775 | 2026-06-06 03:05:01.797916 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-06 03:05:01.965240 | localhost | skipping: Conditional result was False 2026-06-06 03:05:01.965544 | 2026-06-06 03:05:01.993043 | localhost | skipping: Conditional result was False 2026-06-06 03:05:02.003266 | 2026-06-06 03:05:02.003411 | LOOP [upload-logs : Upload console log and json output]