2025-11-04 03:14:20.911753 | Job console starting 2025-11-04 03:14:20.922856 | Updating git repos 2025-11-04 03:14:20.960853 | Cloning repos into workspace 2025-11-04 03:14:20.987714 | Restoring repo states 2025-11-04 03:14:20.999266 | Merging changes 2025-11-04 03:14:20.999298 | Checking out repos 2025-11-04 03:14:21.060021 | Preparing playbooks 2025-11-04 03:14:22.130416 | Running Ansible setup 2025-11-04 03:14:27.256299 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-04 03:14:28.069989 | 2025-11-04 03:14:28.070121 | PLAY [Base pre] 2025-11-04 03:14:28.108105 | 2025-11-04 03:14:28.108263 | TASK [Setup log path fact] 2025-11-04 03:14:28.149241 | debian-bookworm | ok 2025-11-04 03:14:28.167958 | 2025-11-04 03:14:28.168098 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-04 03:14:28.236917 | debian-bookworm | ok 2025-11-04 03:14:28.263725 | 2025-11-04 03:14:28.263835 | TASK [emit-job-header : Print job information] 2025-11-04 03:14:28.342292 | # Job Information 2025-11-04 03:14:28.342474 | Ansible Version: 2.16.14 2025-11-04 03:14:28.342512 | Job: python-black 2025-11-04 03:14:28.342544 | Pipeline: periodic-daily 2025-11-04 03:14:28.342567 | Executor: 521e9411259a 2025-11-04 03:14:28.342588 | Triggered by: https://github.com/osism/testbed 2025-11-04 03:14:28.342609 | Event ID: 7a5c9798035c4401a2c6d4588935a654 2025-11-04 03:14:28.350063 | 2025-11-04 03:14:28.350318 | LOOP [emit-job-header : Print node information] 2025-11-04 03:14:28.474411 | debian-bookworm | ok: 2025-11-04 03:14:28.474668 | debian-bookworm | # Node Information 2025-11-04 03:14:28.475177 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-04 03:14:28.475228 | debian-bookworm | Hostname: debian 2025-11-04 03:14:28.475254 | debian-bookworm | Username: zuul 2025-11-04 03:14:28.475275 | debian-bookworm | Distro: Debian 12.12 2025-11-04 03:14:28.475299 | debian-bookworm | Provider: regiocloud-a 2025-11-04 03:14:28.475320 | debian-bookworm | Region: 2025-11-04 03:14:28.475341 | debian-bookworm | Label: debian-bookworm 2025-11-04 03:14:28.475361 | debian-bookworm | Product Name: OpenStack Nova 2025-11-04 03:14:28.475380 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe1c:6901 2025-11-04 03:14:28.497768 | 2025-11-04 03:14:28.497882 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-04 03:14:29.182420 | debian-bookworm -> localhost | changed 2025-11-04 03:14:29.189752 | 2025-11-04 03:14:29.189852 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-04 03:14:30.671355 | debian-bookworm -> localhost | changed 2025-11-04 03:14:30.693703 | 2025-11-04 03:14:30.693812 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-04 03:14:31.307533 | debian-bookworm -> localhost | ok 2025-11-04 03:14:31.324362 | 2025-11-04 03:14:31.324983 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-04 03:14:31.365291 | debian-bookworm | ok 2025-11-04 03:14:31.386903 | debian-bookworm | included: /var/lib/zuul/builds/b06bc70d905a4ae3815332de8f29f41f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-04 03:14:31.393249 | 2025-11-04 03:14:31.393352 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-04 03:14:32.780057 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-04 03:14:32.780327 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/b06bc70d905a4ae3815332de8f29f41f/work/b06bc70d905a4ae3815332de8f29f41f_id_rsa 2025-11-04 03:14:32.780366 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/b06bc70d905a4ae3815332de8f29f41f/work/b06bc70d905a4ae3815332de8f29f41f_id_rsa.pub 2025-11-04 03:14:32.780413 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-04 03:14:32.780440 | debian-bookworm -> localhost | SHA256:rP/RBBUXQ+1p/hzTa0u5EzwMaqI7dTMxMX1fE1Mq2ek zuul-build-sshkey 2025-11-04 03:14:32.780462 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-04 03:14:32.780497 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-04 03:14:32.780519 | debian-bookworm -> localhost | | +o==+| 2025-11-04 03:14:32.780540 | debian-bookworm -> localhost | | + = *+| 2025-11-04 03:14:32.780559 | debian-bookworm -> localhost | | . = =.=| 2025-11-04 03:14:32.780579 | debian-bookworm -> localhost | | . + + oo| 2025-11-04 03:14:32.780598 | debian-bookworm -> localhost | | S = E .| 2025-11-04 03:14:32.780627 | debian-bookworm -> localhost | | . o O Oo| 2025-11-04 03:14:32.780647 | debian-bookworm -> localhost | | . o = + +B| 2025-11-04 03:14:32.780666 | debian-bookworm -> localhost | | + . .++| 2025-11-04 03:14:32.780686 | debian-bookworm -> localhost | | .+.. .oo| 2025-11-04 03:14:32.780706 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-04 03:14:32.780764 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.866231 2025-11-04 03:14:32.788154 | 2025-11-04 03:14:32.788268 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-04 03:14:32.817742 | debian-bookworm | ok 2025-11-04 03:14:32.827641 | debian-bookworm | included: /var/lib/zuul/builds/b06bc70d905a4ae3815332de8f29f41f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-04 03:14:32.837040 | 2025-11-04 03:14:32.837144 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-04 03:14:32.861257 | debian-bookworm | skipping: Conditional result was False 2025-11-04 03:14:32.867040 | 2025-11-04 03:14:32.867145 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-04 03:14:33.641018 | debian-bookworm | changed 2025-11-04 03:14:33.649908 | 2025-11-04 03:14:33.650035 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-04 03:14:33.969469 | debian-bookworm | ok 2025-11-04 03:14:33.977996 | 2025-11-04 03:14:33.978253 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-04 03:14:34.741050 | debian-bookworm | changed 2025-11-04 03:14:34.762800 | 2025-11-04 03:14:34.763023 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-04 03:14:35.412303 | debian-bookworm | changed 2025-11-04 03:14:35.421976 | 2025-11-04 03:14:35.422121 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-04 03:14:35.447408 | debian-bookworm | skipping: Conditional result was False 2025-11-04 03:14:35.455596 | 2025-11-04 03:14:35.455718 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-04 03:14:36.014075 | debian-bookworm -> localhost | changed 2025-11-04 03:14:36.035494 | 2025-11-04 03:14:36.035621 | TASK [add-build-sshkey : Add back temp key] 2025-11-04 03:14:36.503858 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/b06bc70d905a4ae3815332de8f29f41f/work/b06bc70d905a4ae3815332de8f29f41f_id_rsa (zuul-build-sshkey) 2025-11-04 03:14:36.504454 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015995 2025-11-04 03:14:36.535051 | 2025-11-04 03:14:36.535204 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-04 03:14:36.956885 | debian-bookworm | ok 2025-11-04 03:14:36.964132 | 2025-11-04 03:14:36.964242 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-04 03:14:36.988222 | debian-bookworm | skipping: Conditional result was False 2025-11-04 03:14:36.999705 | 2025-11-04 03:14:36.999805 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-04 03:14:37.474304 | debian-bookworm | ok 2025-11-04 03:14:37.504852 | 2025-11-04 03:14:37.505011 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-04 03:14:37.549720 | debian-bookworm | ok 2025-11-04 03:14:37.557500 | 2025-11-04 03:14:37.557619 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-04 03:14:37.971647 | debian-bookworm -> localhost | ok 2025-11-04 03:14:37.979739 | 2025-11-04 03:14:37.979897 | TASK [validate-host : Collect information about the host] 2025-11-04 03:14:39.301821 | debian-bookworm | ok 2025-11-04 03:14:39.343005 | 2025-11-04 03:14:39.343751 | TASK [validate-host : Sanitize hostname] 2025-11-04 03:14:39.540871 | debian-bookworm | ok 2025-11-04 03:14:39.602302 | 2025-11-04 03:14:39.602471 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-04 03:14:40.337757 | debian-bookworm -> localhost | changed 2025-11-04 03:14:40.344213 | 2025-11-04 03:14:40.344336 | TASK [validate-host : Collect information about zuul worker] 2025-11-04 03:14:40.798280 | debian-bookworm | ok 2025-11-04 03:14:40.808554 | 2025-11-04 03:14:40.808652 | TASK [validate-host : Write out all zuul information for each host] 2025-11-04 03:14:41.402866 | debian-bookworm -> localhost | changed 2025-11-04 03:14:41.412227 | 2025-11-04 03:14:41.412323 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-04 03:14:41.721977 | debian-bookworm | ok 2025-11-04 03:14:41.727331 | 2025-11-04 03:14:41.727430 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-04 03:14:43.053599 | debian-bookworm | changed: 2025-11-04 03:14:43.053899 | debian-bookworm | cd+++++++++ src/ 2025-11-04 03:14:43.053975 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-04 03:14:43.054022 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-04 03:14:43.054077 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-11-04 03:14:43.054114 | debian-bookworm | localhost | ok: Runtime: 0:00:00.010208 2025-11-04 03:15:11.542804 | 2025-11-04 03:15:11.545160 | TASK [upload-logs : Upload logs to log server] 2025-11-04 03:15:12.391178 | localhost | Output suppressed because no_log was given 2025-11-04 03:15:12.392585 | 2025-11-04 03:15:12.392659 | LOOP [upload-logs : Compress console log and json output] 2025-11-04 03:15:12.440187 | localhost | skipping: Conditional result was False 2025-11-04 03:15:12.444767 | localhost | skipping: Conditional result was False 2025-11-04 03:15:12.448185 | 2025-11-04 03:15:12.448263 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-04 03:15:12.500025 | localhost | skipping: Conditional result was False 2025-11-04 03:15:12.500236 | 2025-11-04 03:15:12.505250 | localhost | skipping: Conditional result was False 2025-11-04 03:15:12.513518 | 2025-11-04 03:15:12.513597 | LOOP [upload-logs : Upload console log and json output]