2025-09-15 03:18:14.352230 | Job console starting 2025-09-15 03:18:14.358969 | Updating git repos 2025-09-15 03:18:14.387339 | Cloning repos into workspace 2025-09-15 03:18:14.459346 | Restoring repo states 2025-09-15 03:18:14.469106 | Merging changes 2025-09-15 03:18:14.469118 | Checking out repos 2025-09-15 03:18:14.537343 | Preparing playbooks 2025-09-15 03:18:15.493942 | Running Ansible setup 2025-09-15 03:18:19.368463 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-15 03:18:20.098027 | 2025-09-15 03:18:20.098158 | PLAY [Base pre] 2025-09-15 03:18:20.130532 | 2025-09-15 03:18:20.130663 | TASK [Setup log path fact] 2025-09-15 03:18:20.169658 | debian-bookworm | ok 2025-09-15 03:18:20.187503 | 2025-09-15 03:18:20.187648 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-15 03:18:20.247317 | debian-bookworm | ok 2025-09-15 03:18:20.256945 | 2025-09-15 03:18:20.257036 | TASK [emit-job-header : Print job information] 2025-09-15 03:18:20.295483 | # Job Information 2025-09-15 03:18:20.295803 | Ansible Version: 2.16.14 2025-09-15 03:18:20.295849 | Job: python-black 2025-09-15 03:18:20.295882 | Pipeline: periodic-daily 2025-09-15 03:18:20.295906 | Executor: 521e9411259a 2025-09-15 03:18:20.295927 | Triggered by: https://github.com/osism/openstack-sandbox-manager 2025-09-15 03:18:20.295949 | Event ID: 5e7dbb1c5edd4ecd95d9501c53342cee 2025-09-15 03:18:20.301086 | 2025-09-15 03:18:20.301174 | LOOP [emit-job-header : Print node information] 2025-09-15 03:18:20.441845 | debian-bookworm | ok: 2025-09-15 03:18:20.442021 | debian-bookworm | # Node Information 2025-09-15 03:18:20.442056 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-15 03:18:20.442081 | debian-bookworm | Hostname: debian 2025-09-15 03:18:20.442103 | debian-bookworm | Username: zuul 2025-09-15 03:18:20.442123 | debian-bookworm | Distro: Debian 12.12 2025-09-15 03:18:20.442146 | debian-bookworm | Provider: regiocloud-a 2025-09-15 03:18:20.442167 | debian-bookworm | Region: 2025-09-15 03:18:20.442189 | debian-bookworm | Label: debian-bookworm 2025-09-15 03:18:20.442208 | debian-bookworm | Product Name: OpenStack Nova 2025-09-15 03:18:20.442228 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feb6:c9c1 2025-09-15 03:18:20.469995 | 2025-09-15 03:18:20.470108 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-15 03:18:21.012163 | debian-bookworm -> localhost | changed 2025-09-15 03:18:21.019257 | 2025-09-15 03:18:21.019356 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-15 03:18:22.489499 | debian-bookworm -> localhost | changed 2025-09-15 03:18:22.516590 | 2025-09-15 03:18:22.516705 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-15 03:18:22.877187 | debian-bookworm -> localhost | ok 2025-09-15 03:18:22.889007 | 2025-09-15 03:18:22.889112 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-15 03:18:22.929379 | debian-bookworm | ok 2025-09-15 03:18:22.961501 | debian-bookworm | included: /var/lib/zuul/builds/14018516b83544b5968ed0bef6d77956/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-15 03:18:22.970426 | 2025-09-15 03:18:22.970516 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-15 03:18:24.170538 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-15 03:18:24.171008 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/14018516b83544b5968ed0bef6d77956/work/14018516b83544b5968ed0bef6d77956_id_rsa 2025-09-15 03:18:24.171112 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/14018516b83544b5968ed0bef6d77956/work/14018516b83544b5968ed0bef6d77956_id_rsa.pub 2025-09-15 03:18:24.171168 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-15 03:18:24.171220 | debian-bookworm -> localhost | SHA256:yiN+FkiWPamiDjbqzw8uWsKAd6TsMnrhR6+xKYTlhVM zuul-build-sshkey 2025-09-15 03:18:24.171265 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-15 03:18:24.171325 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-15 03:18:24.171371 | debian-bookworm -> localhost | | | 2025-09-15 03:18:24.171415 | debian-bookworm -> localhost | | E | 2025-09-15 03:18:24.171455 | debian-bookworm -> localhost | | o.o . | 2025-09-15 03:18:24.171495 | debian-bookworm -> localhost | |..+o= + | 2025-09-15 03:18:24.171536 | debian-bookworm -> localhost | |o++=.o .S | 2025-09-15 03:18:24.171606 | debian-bookworm -> localhost | |+o=.+... | 2025-09-15 03:18:24.171652 | debian-bookworm -> localhost | |=Bo=o.+. | 2025-09-15 03:18:24.171691 | debian-bookworm -> localhost | |**B.o=+. | 2025-09-15 03:18:24.171732 | debian-bookworm -> localhost | |B+o**= | 2025-09-15 03:18:24.171772 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-15 03:18:24.171879 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.704595 2025-09-15 03:18:24.183052 | 2025-09-15 03:18:24.183196 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-15 03:18:24.217223 | debian-bookworm | ok 2025-09-15 03:18:24.230430 | debian-bookworm | included: /var/lib/zuul/builds/14018516b83544b5968ed0bef6d77956/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-15 03:18:24.240429 | 2025-09-15 03:18:24.240511 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-15 03:18:24.253727 | debian-bookworm | skipping: Conditional result was False 2025-09-15 03:18:24.259885 | 2025-09-15 03:18:24.259978 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-15 03:18:24.828100 | debian-bookworm | changed 2025-09-15 03:18:24.838978 | 2025-09-15 03:18:24.839105 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-15 03:18:25.058694 | debian-bookworm | ok 2025-09-15 03:18:25.064642 | 2025-09-15 03:18:25.064734 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-15 03:18:25.633979 | debian-bookworm | changed 2025-09-15 03:18:25.640529 | 2025-09-15 03:18:25.640630 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-15 03:18:26.189353 | debian-bookworm | changed 2025-09-15 03:18:26.196171 | 2025-09-15 03:18:26.196277 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-15 03:18:26.219499 | debian-bookworm | skipping: Conditional result was False 2025-09-15 03:18:26.228133 | 2025-09-15 03:18:26.228243 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-15 03:18:26.671104 | debian-bookworm -> localhost | changed 2025-09-15 03:18:26.692042 | 2025-09-15 03:18:26.692137 | TASK [add-build-sshkey : Add back temp key] 2025-09-15 03:18:27.089192 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/14018516b83544b5968ed0bef6d77956/work/14018516b83544b5968ed0bef6d77956_id_rsa (zuul-build-sshkey) 2025-09-15 03:18:27.089437 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013196 2025-09-15 03:18:27.106367 | 2025-09-15 03:18:27.106472 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-15 03:18:27.530958 | debian-bookworm | ok 2025-09-15 03:18:27.544114 | 2025-09-15 03:18:27.544249 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-15 03:18:27.577743 | debian-bookworm | skipping: Conditional result was False 2025-09-15 03:18:27.587964 | 2025-09-15 03:18:27.588051 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-15 03:18:27.991521 | debian-bookworm | ok 2025-09-15 03:18:28.002078 | 2025-09-15 03:18:28.002233 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-15 03:18:28.029888 | debian-bookworm | ok 2025-09-15 03:18:28.034677 | 2025-09-15 03:18:28.034761 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-15 03:18:28.309749 | debian-bookworm -> localhost | ok 2025-09-15 03:18:28.315939 | 2025-09-15 03:18:28.316025 | TASK [validate-host : Collect information about the host] 2025-09-15 03:18:29.301832 | debian-bookworm | ok 2025-09-15 03:18:29.322824 | 2025-09-15 03:18:29.322973 | TASK [validate-host : Sanitize hostname] 2025-09-15 03:18:29.441454 | debian-bookworm | ok 2025-09-15 03:18:29.500419 | 2025-09-15 03:18:29.500589 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-15 03:18:30.105187 | debian-bookworm -> localhost | changed 2025-09-15 03:18:30.112109 | 2025-09-15 03:18:30.112238 | TASK [validate-host : Collect information about zuul worker] 2025-09-15 03:18:30.508809 | debian-bookworm | ok 2025-09-15 03:18:30.515591 | 2025-09-15 03:18:30.515717 | TASK [validate-host : Write out all zuul information for each host] 2025-09-15 03:18:31.134588 | debian-bookworm -> localhost | changed 2025-09-15 03:18:31.144923 | 2025-09-15 03:18:31.145048 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-15 03:18:31.381660 | debian-bookworm | ok 2025-09-15 03:18:31.389219 | 2025-09-15 03:18:31.389340 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-15 03:18:32.221724 | debian-bookworm | changed: 2025-09-15 03:18:32.221965 | debian-bookworm | cd+++++++++ src/ 2025-09-15 03:18:32.221999 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-15 03:18:32.222023 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-15 03:18:32.222044 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-sandbox-manager/ 2025-09-15 03:18:32.222065 | debian-bookworm | localhost | ok: Runtime: 0:00:00.003537 2025-09-15 03:19:00.240694 | 2025-09-15 03:19:00.240864 | TASK [upload-logs : Upload logs to log server] 2025-09-15 03:19:00.975164 | localhost | Output suppressed because no_log was given 2025-09-15 03:19:00.976831 | 2025-09-15 03:19:00.976920 | LOOP [upload-logs : Compress console log and json output] 2025-09-15 03:19:01.069317 | localhost | skipping: Conditional result was False 2025-09-15 03:19:01.084783 | localhost | skipping: Conditional result was False 2025-09-15 03:19:01.095449 | 2025-09-15 03:19:01.095568 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-15 03:19:01.190821 | localhost | skipping: Conditional result was False 2025-09-15 03:19:01.191170 | 2025-09-15 03:19:01.212213 | localhost | skipping: Conditional result was False 2025-09-15 03:19:01.221448 | 2025-09-15 03:19:01.221571 | LOOP [upload-logs : Upload console log and json output]