2025-07-09 16:39:10.511560 | Job console starting 2025-07-09 16:39:10.541411 | Updating git repos 2025-07-09 16:39:10.662551 | Cloning repos into workspace 2025-07-09 16:39:10.712528 | Restoring repo states 2025-07-09 16:39:10.737741 | Merging changes 2025-07-09 16:39:11.350947 | Checking out repos 2025-07-09 16:39:11.401705 | Preparing playbooks 2025-07-09 16:39:12.546940 | Running Ansible setup 2025-07-09 16:39:17.680675 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-07-09 16:39:18.713084 | 2025-07-09 16:39:18.713259 | PLAY [Base pre] 2025-07-09 16:39:18.730186 | 2025-07-09 16:39:18.730362 | TASK [Setup log path fact] 2025-07-09 16:39:18.758584 | debian-bookworm | ok 2025-07-09 16:39:18.790889 | 2025-07-09 16:39:18.791063 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-07-09 16:39:18.822266 | debian-bookworm | ok 2025-07-09 16:39:18.842708 | 2025-07-09 16:39:18.842889 | TASK [emit-job-header : Print job information] 2025-07-09 16:39:18.902292 | # Job Information 2025-07-09 16:39:18.902489 | Ansible Version: 2.16.14 2025-07-09 16:39:18.902523 | Job: python-black 2025-07-09 16:39:18.902557 | Pipeline: check 2025-07-09 16:39:18.902579 | Executor: 521e9411259a 2025-07-09 16:39:18.902601 | Triggered by: https://github.com/osism/python-osism/pull/1566 2025-07-09 16:39:18.902623 | Event ID: 386cc770-5ce3-11f0-94f6-2cceebfbe55d 2025-07-09 16:39:18.919714 | 2025-07-09 16:39:18.919871 | LOOP [emit-job-header : Print node information] 2025-07-09 16:39:19.067480 | debian-bookworm | ok: 2025-07-09 16:39:19.067767 | debian-bookworm | # Node Information 2025-07-09 16:39:19.067808 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-07-09 16:39:19.067833 | debian-bookworm | Hostname: debian 2025-07-09 16:39:19.067855 | debian-bookworm | Username: zuul 2025-07-09 16:39:19.067876 | debian-bookworm | Distro: Debian 12.11 2025-07-09 16:39:19.067900 | debian-bookworm | Provider: regiocloud-a 2025-07-09 16:39:19.067921 | debian-bookworm | Region: 2025-07-09 16:39:19.067943 | debian-bookworm | Label: debian-bookworm 2025-07-09 16:39:19.067963 | debian-bookworm | Product Name: OpenStack Nova 2025-07-09 16:39:19.067983 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fedf:e79a 2025-07-09 16:39:19.086095 | 2025-07-09 16:39:19.086228 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-07-09 16:39:19.756509 | debian-bookworm -> localhost | changed 2025-07-09 16:39:19.765321 | 2025-07-09 16:39:19.765477 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-07-09 16:39:21.219501 | debian-bookworm -> localhost | changed 2025-07-09 16:39:21.234224 | 2025-07-09 16:39:21.234391 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-07-09 16:39:21.800976 | debian-bookworm -> localhost | ok 2025-07-09 16:39:21.808119 | 2025-07-09 16:39:21.808271 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-07-09 16:39:21.848400 | debian-bookworm | ok 2025-07-09 16:39:21.881473 | debian-bookworm | included: /var/lib/zuul/builds/eab0365ae2064c619efe7c327d9be6f1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-07-09 16:39:21.889888 | 2025-07-09 16:39:21.890011 | TASK [add-build-sshkey : Create Temp SSH key] 2025-07-09 16:39:24.040527 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-07-09 16:39:24.040954 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/eab0365ae2064c619efe7c327d9be6f1/work/eab0365ae2064c619efe7c327d9be6f1_id_rsa 2025-07-09 16:39:24.041034 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/eab0365ae2064c619efe7c327d9be6f1/work/eab0365ae2064c619efe7c327d9be6f1_id_rsa.pub 2025-07-09 16:39:24.041087 | debian-bookworm -> localhost | The key fingerprint is: 2025-07-09 16:39:24.041135 | debian-bookworm -> localhost | SHA256:itk9BjYgvrdAxPFiIDRka4t7TixmREK33MKS+x7b5fM zuul-build-sshkey 2025-07-09 16:39:24.041180 | debian-bookworm -> localhost | The key's randomart image is: 2025-07-09 16:39:24.041246 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-07-09 16:39:24.041293 | debian-bookworm -> localhost | |=*.. | 2025-07-09 16:39:24.041338 | debian-bookworm -> localhost | |+oBoo | 2025-07-09 16:39:24.041379 | debian-bookworm -> localhost | |.**=o. | 2025-07-09 16:39:24.041418 | debian-bookworm -> localhost | |=++o.. | 2025-07-09 16:39:24.041457 | debian-bookworm -> localhost | |.+o + S | 2025-07-09 16:39:24.041505 | debian-bookworm -> localhost | |.+.. = = | 2025-07-09 16:39:24.041545 | debian-bookworm -> localhost | |oo*o+ o.+ | 2025-07-09 16:39:24.041583 | debian-bookworm -> localhost | |o=.o+.oo . | 2025-07-09 16:39:24.041624 | debian-bookworm -> localhost | | .o.. .oE | 2025-07-09 16:39:24.041685 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-07-09 16:39:24.041786 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.358369 2025-07-09 16:39:24.053625 | 2025-07-09 16:39:24.053826 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-07-09 16:39:24.075151 | debian-bookworm | ok 2025-07-09 16:39:24.092307 | debian-bookworm | included: /var/lib/zuul/builds/eab0365ae2064c619efe7c327d9be6f1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-07-09 16:39:24.102558 | 2025-07-09 16:39:24.102713 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-07-09 16:39:24.128141 | debian-bookworm | skipping: Conditional result was False 2025-07-09 16:39:24.134956 | 2025-07-09 16:39:24.135078 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-07-09 16:39:24.816513 | debian-bookworm | changed 2025-07-09 16:39:24.834118 | 2025-07-09 16:39:24.834299 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-07-09 16:39:25.092527 | debian-bookworm | ok 2025-07-09 16:39:25.102276 | 2025-07-09 16:39:25.102434 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-07-09 16:39:25.775418 | debian-bookworm | changed 2025-07-09 16:39:25.793431 | 2025-07-09 16:39:25.793817 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-07-09 16:39:26.501747 | debian-bookworm | changed 2025-07-09 16:39:26.511783 | 2025-07-09 16:39:26.511955 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-07-09 16:39:26.543499 | debian-bookworm | skipping: Conditional result was False 2025-07-09 16:39:26.553081 | 2025-07-09 16:39:26.553239 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-07-09 16:39:27.447168 | debian-bookworm -> localhost | changed 2025-07-09 16:39:27.470337 | 2025-07-09 16:39:27.471252 | TASK [add-build-sshkey : Add back temp key] 2025-07-09 16:39:28.083097 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/eab0365ae2064c619efe7c327d9be6f1/work/eab0365ae2064c619efe7c327d9be6f1_id_rsa (zuul-build-sshkey) 2025-07-09 16:39:28.083505 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011599 2025-07-09 16:39:28.102928 | 2025-07-09 16:39:28.103121 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-07-09 16:39:28.647542 | debian-bookworm | ok 2025-07-09 16:39:28.670521 | 2025-07-09 16:39:28.671270 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-07-09 16:39:28.723064 | debian-bookworm | skipping: Conditional result was False 2025-07-09 16:39:28.760898 | 2025-07-09 16:39:28.762395 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-07-09 16:39:29.271571 | debian-bookworm | ok 2025-07-09 16:39:29.342165 | 2025-07-09 16:39:29.343195 | TASK [validate-host : Define zuul_info_dir fact] 2025-07-09 16:39:29.491783 | debian-bookworm | ok 2025-07-09 16:39:29.501324 | 2025-07-09 16:39:29.501480 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-07-09 16:39:30.035212 | debian-bookworm -> localhost | ok 2025-07-09 16:39:30.044700 | 2025-07-09 16:39:30.044954 | TASK [validate-host : Collect information about the host] 2025-07-09 16:39:31.593898 | debian-bookworm | ok 2025-07-09 16:39:31.631141 | 2025-07-09 16:39:31.632080 | TASK [validate-host : Sanitize hostname] 2025-07-09 16:39:31.833415 | debian-bookworm | ok 2025-07-09 16:39:32.004140 | 2025-07-09 16:39:32.004333 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-07-09 16:39:33.008008 | debian-bookworm -> localhost | changed 2025-07-09 16:39:33.044445 | 2025-07-09 16:39:33.046370 | TASK [validate-host : Collect information about zuul worker] 2025-07-09 16:39:33.515742 | debian-bookworm | ok 2025-07-09 16:39:33.521232 | 2025-07-09 16:39:33.521351 | TASK [validate-host : Write out all zuul information for each host] 2025-07-09 16:39:34.821797 | debian-bookworm -> localhost | changed 2025-07-09 16:39:34.833140 | 2025-07-09 16:39:34.833275 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-07-09 16:39:35.121026 | debian-bookworm | ok 2025-07-09 16:39:35.133320 | 2025-07-09 16:39:35.133502 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-07-09 16:39:36.414143 | debian-bookworm | changed: 2025-07-09 16:39:36.414406 | debian-bookworm | cd+++++++++ src/ 2025-07-09 16:39:36.414451 | debian-bookworm | cd+++++++++ src/github.com/ 2025-07-09 16:39:36.414482 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-07-09 16:39:36.414510 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-07-09 16:39:36.414536 | debian-bookworm | Containerfile 2025-07-09 16:39:36.414727 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007661 2025-07-09 16:40:03.408051 | 2025-07-09 16:40:03.408288 | TASK [upload-logs : Upload logs to log server] 2025-07-09 16:40:04.047632 | localhost | Output suppressed because no_log was given 2025-07-09 16:40:04.050661 | 2025-07-09 16:40:04.050877 | LOOP [upload-logs : Compress console log and json output] 2025-07-09 16:40:04.114784 | localhost | skipping: Conditional result was False 2025-07-09 16:40:04.120312 | localhost | skipping: Conditional result was False 2025-07-09 16:40:04.128628 | 2025-07-09 16:40:04.128935 | LOOP [upload-logs : Upload compressed console log and json output] 2025-07-09 16:40:04.181890 | localhost | skipping: Conditional result was False 2025-07-09 16:40:04.182547 | 2025-07-09 16:40:04.185632 | localhost | skipping: Conditional result was False 2025-07-09 16:40:04.193476 | 2025-07-09 16:40:04.193817 | LOOP [upload-logs : Upload console log and json output]