2025-09-01 03:16:09.251255 | Job console starting 2025-09-01 03:16:09.260066 | Updating git repos 2025-09-01 03:16:09.282586 | Cloning repos into workspace 2025-09-01 03:16:09.316103 | Restoring repo states 2025-09-01 03:16:09.321168 | Merging changes 2025-09-01 03:16:09.321253 | Checking out repos 2025-09-01 03:16:09.349270 | Preparing playbooks 2025-09-01 03:16:09.912544 | Running Ansible setup 2025-09-01 03:16:14.196581 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-01 03:16:14.966447 | 2025-09-01 03:16:14.966621 | PLAY [Base pre] 2025-09-01 03:16:14.983830 | 2025-09-01 03:16:14.983970 | TASK [Setup log path fact] 2025-09-01 03:16:15.013894 | debian-bookworm | ok 2025-09-01 03:16:15.029693 | 2025-09-01 03:16:15.029842 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-01 03:16:15.059879 | debian-bookworm | ok 2025-09-01 03:16:15.069954 | 2025-09-01 03:16:15.070078 | TASK [emit-job-header : Print job information] 2025-09-01 03:16:15.109450 | # Job Information 2025-09-01 03:16:15.109666 | Ansible Version: 2.16.14 2025-09-01 03:16:15.109703 | Job: python-black 2025-09-01 03:16:15.109736 | Pipeline: periodic-daily 2025-09-01 03:16:15.109759 | Executor: 521e9411259a 2025-09-01 03:16:15.109780 | Triggered by: https://github.com/osism/node-image 2025-09-01 03:16:15.109803 | Event ID: 439cc76cf66e46deaf85d031e22b0aad 2025-09-01 03:16:15.115075 | 2025-09-01 03:16:15.115196 | LOOP [emit-job-header : Print node information] 2025-09-01 03:16:15.222171 | debian-bookworm | ok: 2025-09-01 03:16:15.222477 | debian-bookworm | # Node Information 2025-09-01 03:16:15.222526 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-01 03:16:15.222553 | debian-bookworm | Hostname: debian 2025-09-01 03:16:15.222575 | debian-bookworm | Username: zuul 2025-09-01 03:16:15.222595 | debian-bookworm | Distro: Debian 12.11 2025-09-01 03:16:15.222618 | debian-bookworm | Provider: regiocloud-a 2025-09-01 03:16:15.222654 | debian-bookworm | Region: 2025-09-01 03:16:15.222677 | debian-bookworm | Label: debian-bookworm 2025-09-01 03:16:15.222698 | debian-bookworm | Product Name: OpenStack Nova 2025-09-01 03:16:15.222719 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe20:dce1 2025-09-01 03:16:15.243302 | 2025-09-01 03:16:15.243439 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-01 03:16:15.701902 | debian-bookworm -> localhost | changed 2025-09-01 03:16:15.709409 | 2025-09-01 03:16:15.709531 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-01 03:16:16.884445 | debian-bookworm -> localhost | changed 2025-09-01 03:16:16.898154 | 2025-09-01 03:16:16.898346 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-01 03:16:17.183301 | debian-bookworm -> localhost | ok 2025-09-01 03:16:17.193222 | 2025-09-01 03:16:17.193351 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-01 03:16:17.222308 | debian-bookworm | ok 2025-09-01 03:16:17.246912 | debian-bookworm | included: /var/lib/zuul/builds/cb7597d259aa418381c54d26c3d96bf1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-01 03:16:17.253244 | 2025-09-01 03:16:17.253346 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-01 03:16:18.726700 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-01 03:16:18.726949 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/cb7597d259aa418381c54d26c3d96bf1/work/cb7597d259aa418381c54d26c3d96bf1_id_rsa 2025-09-01 03:16:18.726988 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/cb7597d259aa418381c54d26c3d96bf1/work/cb7597d259aa418381c54d26c3d96bf1_id_rsa.pub 2025-09-01 03:16:18.727017 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-01 03:16:18.727042 | debian-bookworm -> localhost | SHA256:kjGYG6j4cbVw+yp7H9JibWiy18+ydJ3of+PND28C2TQ zuul-build-sshkey 2025-09-01 03:16:18.727065 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-01 03:16:18.727101 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-01 03:16:18.727124 | debian-bookworm -> localhost | | | 2025-09-01 03:16:18.727146 | debian-bookworm -> localhost | | . o | 2025-09-01 03:16:18.727167 | debian-bookworm -> localhost | | . = = | 2025-09-01 03:16:18.727187 | debian-bookworm -> localhost | |.. * * E | 2025-09-01 03:16:18.727208 | debian-bookworm -> localhost | |o . o = S + . | 2025-09-01 03:16:18.727233 | debian-bookworm -> localhost | | . o * oo.. | 2025-09-01 03:16:18.727255 | debian-bookworm -> localhost | | . . *.B o o.. | 2025-09-01 03:16:18.727275 | debian-bookworm -> localhost | | .=o*o= +=.| 2025-09-01 03:16:18.727297 | debian-bookworm -> localhost | | o=..o++..o.+*| 2025-09-01 03:16:18.727317 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-01 03:16:18.727372 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.947056 2025-09-01 03:16:18.734014 | 2025-09-01 03:16:18.734128 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-01 03:16:18.762880 | debian-bookworm | ok 2025-09-01 03:16:18.782789 | debian-bookworm | included: /var/lib/zuul/builds/cb7597d259aa418381c54d26c3d96bf1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-01 03:16:18.792091 | 2025-09-01 03:16:18.792191 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-01 03:16:18.816238 | debian-bookworm | skipping: Conditional result was False 2025-09-01 03:16:18.822276 | 2025-09-01 03:16:18.822380 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-01 03:16:19.500486 | debian-bookworm | changed 2025-09-01 03:16:19.509603 | 2025-09-01 03:16:19.509776 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-01 03:16:19.807236 | debian-bookworm | ok 2025-09-01 03:16:19.813407 | 2025-09-01 03:16:19.813526 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-01 03:16:20.430307 | debian-bookworm | changed 2025-09-01 03:16:20.437371 | 2025-09-01 03:16:20.437483 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-01 03:16:21.159580 | debian-bookworm | changed 2025-09-01 03:16:21.165483 | 2025-09-01 03:16:21.165587 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-01 03:16:21.189439 | debian-bookworm | skipping: Conditional result was False 2025-09-01 03:16:21.197290 | 2025-09-01 03:16:21.197425 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-01 03:16:21.747121 | debian-bookworm -> localhost | changed 2025-09-01 03:16:21.764306 | 2025-09-01 03:16:21.764429 | TASK [add-build-sshkey : Add back temp key] 2025-09-01 03:16:22.095321 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/cb7597d259aa418381c54d26c3d96bf1/work/cb7597d259aa418381c54d26c3d96bf1_id_rsa (zuul-build-sshkey) 2025-09-01 03:16:22.095614 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018957 2025-09-01 03:16:22.104845 | 2025-09-01 03:16:22.104963 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-01 03:16:22.508219 | debian-bookworm | ok 2025-09-01 03:16:22.515358 | 2025-09-01 03:16:22.515481 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-01 03:16:22.539828 | debian-bookworm | skipping: Conditional result was False 2025-09-01 03:16:22.555279 | 2025-09-01 03:16:22.555399 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-01 03:16:22.971158 | debian-bookworm | ok 2025-09-01 03:16:22.984097 | 2025-09-01 03:16:22.984234 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-01 03:16:23.029442 | debian-bookworm | ok 2025-09-01 03:16:23.037216 | 2025-09-01 03:16:23.037357 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-01 03:16:23.335207 | debian-bookworm -> localhost | ok 2025-09-01 03:16:23.349427 | 2025-09-01 03:16:23.349778 | TASK [validate-host : Collect information about the host] 2025-09-01 03:16:24.484236 | debian-bookworm | ok 2025-09-01 03:16:24.494711 | 2025-09-01 03:16:24.494854 | TASK [validate-host : Sanitize hostname] 2025-09-01 03:16:24.609845 | debian-bookworm | ok 2025-09-01 03:16:24.654167 | 2025-09-01 03:16:24.654297 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-01 03:16:25.233176 | debian-bookworm -> localhost | changed 2025-09-01 03:16:25.239447 | 2025-09-01 03:16:25.239567 | TASK [validate-host : Collect information about zuul worker] 2025-09-01 03:16:25.651468 | debian-bookworm | ok 2025-09-01 03:16:25.656318 | 2025-09-01 03:16:25.656428 | TASK [validate-host : Write out all zuul information for each host] 2025-09-01 03:16:26.286466 | debian-bookworm -> localhost | changed 2025-09-01 03:16:26.296263 | 2025-09-01 03:16:26.296372 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-01 03:16:26.567498 | debian-bookworm | ok 2025-09-01 03:16:26.573263 | 2025-09-01 03:16:26.573376 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-01 03:16:28.412962 | debian-bookworm | changed: 2025-09-01 03:16:28.413211 | debian-bookworm | cd+++++++++ src/ 2025-09-01 03:16:28.413249 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-01 03:16:28.413273 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-01 03:16:28.413294 | debian-bookworm | cd+++++++++ src/github.com/osism/node-image/ 2025-09-01 03:16:28.413315 | debian-bookworm | Containerfile 2025-09-01 03:16:28.413446 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006064 2025-09-01 03:16:57.727438 | 2025-09-01 03:16:57.727529 | TASK [upload-logs : Upload logs to log server] 2025-09-01 03:16:58.981859 | localhost | Output suppressed because no_log was given 2025-09-01 03:16:58.983237 | 2025-09-01 03:16:58.983309 | LOOP [upload-logs : Compress console log and json output] 2025-09-01 03:16:59.032087 | localhost | skipping: Conditional result was False 2025-09-01 03:16:59.037773 | localhost | skipping: Conditional result was False 2025-09-01 03:16:59.048036 | 2025-09-01 03:16:59.048132 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-01 03:16:59.134143 | localhost | skipping: Conditional result was False 2025-09-01 03:16:59.134339 | 2025-09-01 03:16:59.136786 | localhost | skipping: Conditional result was False 2025-09-01 03:16:59.143039 | 2025-09-01 03:16:59.143122 | LOOP [upload-logs : Upload console log and json output]