2025-10-13 03:11:59.797136 | Job console starting 2025-10-13 03:11:59.808865 | Updating git repos 2025-10-13 03:11:59.852107 | Cloning repos into workspace 2025-10-13 03:11:59.909093 | Restoring repo states 2025-10-13 03:11:59.922506 | Merging changes 2025-10-13 03:11:59.922619 | Checking out repos 2025-10-13 03:11:59.983146 | Preparing playbooks 2025-10-13 03:12:00.886216 | Running Ansible setup 2025-10-13 03:12:05.691916 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-13 03:12:06.611249 | 2025-10-13 03:12:06.611508 | PLAY [Base pre] 2025-10-13 03:12:06.649258 | 2025-10-13 03:12:06.649427 | TASK [Setup log path fact] 2025-10-13 03:12:06.679651 | debian-bookworm | ok 2025-10-13 03:12:06.713896 | 2025-10-13 03:12:06.714123 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-13 03:12:06.765178 | debian-bookworm | ok 2025-10-13 03:12:06.786916 | 2025-10-13 03:12:06.787176 | TASK [emit-job-header : Print job information] 2025-10-13 03:12:06.857234 | # Job Information 2025-10-13 03:12:06.857422 | Ansible Version: 2.16.14 2025-10-13 03:12:06.857458 | Job: python-black 2025-10-13 03:12:06.857491 | Pipeline: periodic-daily 2025-10-13 03:12:06.857514 | Executor: 521e9411259a 2025-10-13 03:12:06.857534 | Triggered by: https://github.com/osism/python-osism 2025-10-13 03:12:06.857557 | Event ID: 6803f616198848cca7453d793138f794 2025-10-13 03:12:06.863479 | 2025-10-13 03:12:06.863611 | LOOP [emit-job-header : Print node information] 2025-10-13 03:12:06.971438 | debian-bookworm | ok: 2025-10-13 03:12:06.971714 | debian-bookworm | # Node Information 2025-10-13 03:12:06.971753 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-13 03:12:06.971778 | debian-bookworm | Hostname: debian 2025-10-13 03:12:06.971799 | debian-bookworm | Username: zuul 2025-10-13 03:12:06.971819 | debian-bookworm | Distro: Debian 12.12 2025-10-13 03:12:06.971842 | debian-bookworm | Provider: regiocloud-a 2025-10-13 03:12:06.971862 | debian-bookworm | Region: 2025-10-13 03:12:06.971883 | debian-bookworm | Label: debian-bookworm 2025-10-13 03:12:06.971902 | debian-bookworm | Product Name: OpenStack Nova 2025-10-13 03:12:06.971922 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe7f:8b65 2025-10-13 03:12:06.989939 | 2025-10-13 03:12:06.990117 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-13 03:12:07.607149 | debian-bookworm -> localhost | changed 2025-10-13 03:12:07.615713 | 2025-10-13 03:12:07.615845 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-13 03:12:09.004172 | debian-bookworm -> localhost | changed 2025-10-13 03:12:09.015754 | 2025-10-13 03:12:09.015890 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-13 03:12:09.367418 | debian-bookworm -> localhost | ok 2025-10-13 03:12:09.374683 | 2025-10-13 03:12:09.374809 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-13 03:12:09.404988 | debian-bookworm | ok 2025-10-13 03:12:09.440340 | debian-bookworm | included: /var/lib/zuul/builds/1cafe431292549739bd7386db4020a46/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-13 03:12:09.450784 | 2025-10-13 03:12:09.454977 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-13 03:12:10.979227 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-13 03:12:10.979418 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/1cafe431292549739bd7386db4020a46/work/1cafe431292549739bd7386db4020a46_id_rsa 2025-10-13 03:12:10.979455 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/1cafe431292549739bd7386db4020a46/work/1cafe431292549739bd7386db4020a46_id_rsa.pub 2025-10-13 03:12:10.979482 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-13 03:12:10.979506 | debian-bookworm -> localhost | SHA256:OvtCiyPhbutzldJ3+M5XTvib+7y4OAmq38KykE8nNsc zuul-build-sshkey 2025-10-13 03:12:10.979528 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-13 03:12:10.979557 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-13 03:12:10.979579 | debian-bookworm -> localhost | | | 2025-10-13 03:12:10.979600 | debian-bookworm -> localhost | | | 2025-10-13 03:12:10.979620 | debian-bookworm -> localhost | | | 2025-10-13 03:12:10.979640 | debian-bookworm -> localhost | | | 2025-10-13 03:12:10.979659 | debian-bookworm -> localhost | | . .S. . | 2025-10-13 03:12:10.979686 | debian-bookworm -> localhost | | . o *.o.. . o | 2025-10-13 03:12:10.979705 | debian-bookworm -> localhost | | . + X+E.o. .= | 2025-10-13 03:12:10.979724 | debian-bookworm -> localhost | | = O.B*...oo +o | 2025-10-13 03:12:10.979744 | debian-bookworm -> localhost | | ++= =*+oooo.o==+| 2025-10-13 03:12:10.979764 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-13 03:12:10.979814 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.720565 2025-10-13 03:12:10.988375 | 2025-10-13 03:12:10.988460 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-13 03:12:11.015616 | debian-bookworm | ok 2025-10-13 03:12:11.032574 | debian-bookworm | included: /var/lib/zuul/builds/1cafe431292549739bd7386db4020a46/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-13 03:12:11.047111 | 2025-10-13 03:12:11.047199 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-13 03:12:11.060110 | debian-bookworm | skipping: Conditional result was False 2025-10-13 03:12:11.065648 | 2025-10-13 03:12:11.065739 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-13 03:12:11.735022 | debian-bookworm | changed 2025-10-13 03:12:11.740130 | 2025-10-13 03:12:11.740210 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-13 03:12:12.000420 | debian-bookworm | ok 2025-10-13 03:12:12.005624 | 2025-10-13 03:12:12.005719 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-13 03:12:12.643733 | debian-bookworm | changed 2025-10-13 03:12:12.649913 | 2025-10-13 03:12:12.650000 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-13 03:12:13.344262 | debian-bookworm | changed 2025-10-13 03:12:13.353985 | 2025-10-13 03:12:13.354182 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-13 03:12:13.378906 | debian-bookworm | skipping: Conditional result was False 2025-10-13 03:12:13.387998 | 2025-10-13 03:12:13.388147 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-13 03:12:13.891290 | debian-bookworm -> localhost | changed 2025-10-13 03:12:13.902669 | 2025-10-13 03:12:13.902764 | TASK [add-build-sshkey : Add back temp key] 2025-10-13 03:12:14.314380 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/1cafe431292549739bd7386db4020a46/work/1cafe431292549739bd7386db4020a46_id_rsa (zuul-build-sshkey) 2025-10-13 03:12:14.314648 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.033819 2025-10-13 03:12:14.327706 | 2025-10-13 03:12:14.327883 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-13 03:12:14.770450 | debian-bookworm | ok 2025-10-13 03:12:14.777696 | 2025-10-13 03:12:14.777989 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-13 03:12:14.816869 | debian-bookworm | skipping: Conditional result was False 2025-10-13 03:12:14.829300 | 2025-10-13 03:12:14.829417 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-13 03:12:15.344664 | debian-bookworm | ok 2025-10-13 03:12:15.355969 | 2025-10-13 03:12:15.356113 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-13 03:12:15.387234 | debian-bookworm | ok 2025-10-13 03:12:15.394538 | 2025-10-13 03:12:15.394651 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-13 03:12:15.967512 | debian-bookworm -> localhost | ok 2025-10-13 03:12:15.974541 | 2025-10-13 03:12:15.974658 | TASK [validate-host : Collect information about the host] 2025-10-13 03:12:17.099639 | debian-bookworm | ok 2025-10-13 03:12:17.110011 | 2025-10-13 03:12:17.110158 | TASK [validate-host : Sanitize hostname] 2025-10-13 03:12:17.240909 | debian-bookworm | ok 2025-10-13 03:12:17.286957 | 2025-10-13 03:12:17.287126 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-13 03:12:17.981857 | debian-bookworm -> localhost | changed 2025-10-13 03:12:17.988618 | 2025-10-13 03:12:17.988734 | TASK [validate-host : Collect information about zuul worker] 2025-10-13 03:12:18.453238 | debian-bookworm | ok 2025-10-13 03:12:18.471267 | 2025-10-13 03:12:18.471447 | TASK [validate-host : Write out all zuul information for each host] 2025-10-13 03:12:19.123247 | debian-bookworm -> localhost | changed 2025-10-13 03:12:19.139930 | 2025-10-13 03:12:19.140105 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-13 03:12:19.424527 | debian-bookworm | ok 2025-10-13 03:12:19.440576 | 2025-10-13 03:12:19.440715 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-13 03:12:20.606676 | debian-bookworm | changed: 2025-10-13 03:12:20.606950 | debian-bookworm | cd+++++++++ src/ 2025-10-13 03:12:20.606989 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-13 03:12:20.607013 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-13 03:12:20.607055 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-10-13 03:12:20.607076 | debian-bookworm | Containerfile 2025-10-13 03:12:20.607192 | debian-bookworm | Containerfile 2025-10-13 03:12:20.636081 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006787 2025-10-13 03:12:47.249842 | 2025-10-13 03:12:47.249977 | TASK [upload-logs : Upload logs to log server] 2025-10-13 03:12:47.920530 | localhost | Output suppressed because no_log was given 2025-10-13 03:12:47.923168 | 2025-10-13 03:12:47.923423 | LOOP [upload-logs : Compress console log and json output] 2025-10-13 03:12:47.986109 | localhost | skipping: Conditional result was False 2025-10-13 03:12:47.994330 | localhost | skipping: Conditional result was False 2025-10-13 03:12:48.002432 | 2025-10-13 03:12:48.002550 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-13 03:12:48.061827 | localhost | skipping: Conditional result was False 2025-10-13 03:12:48.062802 | 2025-10-13 03:12:48.068848 | localhost | skipping: Conditional result was False 2025-10-13 03:12:48.080854 | 2025-10-13 03:12:48.080979 | LOOP [upload-logs : Upload console log and json output]