2025-08-23 20:31:28.052099 | Job console starting 2025-08-23 20:31:28.063028 | Updating git repos 2025-08-23 20:31:28.101695 | Cloning repos into workspace 2025-08-23 20:31:28.202981 | Restoring repo states 2025-08-23 20:31:28.233051 | Merging changes 2025-08-23 20:31:28.890752 | Checking out repos 2025-08-23 20:31:28.945817 | Preparing playbooks 2025-08-23 20:31:29.596568 | Running Ansible setup 2025-08-23 20:31:34.652322 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-23 20:31:35.941397 | 2025-08-23 20:31:35.941523 | PLAY [Base pre] 2025-08-23 20:31:35.970369 | 2025-08-23 20:31:35.970514 | TASK [Setup log path fact] 2025-08-23 20:31:36.009626 | debian-bookworm | ok 2025-08-23 20:31:36.040715 | 2025-08-23 20:31:36.040865 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-23 20:31:36.082005 | debian-bookworm | ok 2025-08-23 20:31:36.094120 | 2025-08-23 20:31:36.094218 | TASK [emit-job-header : Print job information] 2025-08-23 20:31:36.132174 | # Job Information 2025-08-23 20:31:36.132321 | Ansible Version: 2.16.14 2025-08-23 20:31:36.132355 | Job: python-black 2025-08-23 20:31:36.132387 | Pipeline: check 2025-08-23 20:31:36.132409 | Executor: 521e9411259a 2025-08-23 20:31:36.132430 | Triggered by: https://github.com/osism/python-osism/pull/1658 2025-08-23 20:31:36.132451 | Event ID: fa869da0-805f-11f0-8916-71b33a7d97ab 2025-08-23 20:31:36.137115 | 2025-08-23 20:31:36.137201 | LOOP [emit-job-header : Print node information] 2025-08-23 20:31:36.233580 | debian-bookworm | ok: 2025-08-23 20:31:36.233816 | debian-bookworm | # Node Information 2025-08-23 20:31:36.233853 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-23 20:31:36.233879 | debian-bookworm | Hostname: debian 2025-08-23 20:31:36.233900 | debian-bookworm | Username: zuul 2025-08-23 20:31:36.233920 | debian-bookworm | Distro: Debian 12.11 2025-08-23 20:31:36.233944 | debian-bookworm | Provider: regiocloud-a 2025-08-23 20:31:36.233965 | debian-bookworm | Region: 2025-08-23 20:31:36.233985 | debian-bookworm | Label: debian-bookworm 2025-08-23 20:31:36.234004 | debian-bookworm | Product Name: OpenStack Nova 2025-08-23 20:31:36.234023 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fee2:f600 2025-08-23 20:31:36.251749 | 2025-08-23 20:31:36.251863 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-23 20:31:36.695981 | debian-bookworm -> localhost | changed 2025-08-23 20:31:36.703038 | 2025-08-23 20:31:36.703164 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-23 20:31:37.650890 | debian-bookworm -> localhost | changed 2025-08-23 20:31:37.663702 | 2025-08-23 20:31:37.663806 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-23 20:31:37.962818 | debian-bookworm -> localhost | ok 2025-08-23 20:31:37.968290 | 2025-08-23 20:31:37.968384 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-23 20:31:37.996757 | debian-bookworm | ok 2025-08-23 20:31:38.011499 | debian-bookworm | included: /var/lib/zuul/builds/0e3de27229be4c56bf7ca0cc62f4dee8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-23 20:31:38.024222 | 2025-08-23 20:31:38.024315 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-23 20:31:39.365946 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-23 20:31:39.366413 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/0e3de27229be4c56bf7ca0cc62f4dee8/work/0e3de27229be4c56bf7ca0cc62f4dee8_id_rsa 2025-08-23 20:31:39.366474 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/0e3de27229be4c56bf7ca0cc62f4dee8/work/0e3de27229be4c56bf7ca0cc62f4dee8_id_rsa.pub 2025-08-23 20:31:39.366504 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-23 20:31:39.366533 | debian-bookworm -> localhost | SHA256:zXj6FmM5YOh3H6d+UVwYY+BoDxomu5RRG4z1q1AfERs zuul-build-sshkey 2025-08-23 20:31:39.366572 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-23 20:31:39.366629 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-23 20:31:39.366754 | debian-bookworm -> localhost | | ++ E...+o | 2025-08-23 20:31:39.366923 | debian-bookworm -> localhost | | ...+ * ....| 2025-08-23 20:31:39.366954 | debian-bookworm -> localhost | | o.= B . ..| 2025-08-23 20:31:39.366979 | debian-bookworm -> localhost | | .BoO = o| 2025-08-23 20:31:39.367003 | debian-bookworm -> localhost | | .=.S.*.. . | 2025-08-23 20:31:39.367035 | debian-bookworm -> localhost | | ..o.+B . o | 2025-08-23 20:31:39.367058 | debian-bookworm -> localhost | | ..oo = + . | 2025-08-23 20:31:39.367091 | debian-bookworm -> localhost | | .. o . | 2025-08-23 20:31:39.367116 | debian-bookworm -> localhost | | ..... | 2025-08-23 20:31:39.367138 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-23 20:31:39.367195 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.821948 2025-08-23 20:31:39.376807 | 2025-08-23 20:31:39.376889 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-23 20:31:39.397889 | debian-bookworm | ok 2025-08-23 20:31:39.409638 | debian-bookworm | included: /var/lib/zuul/builds/0e3de27229be4c56bf7ca0cc62f4dee8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-23 20:31:39.424405 | 2025-08-23 20:31:39.424523 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-23 20:31:39.439633 | debian-bookworm | skipping: Conditional result was False 2025-08-23 20:31:39.457399 | 2025-08-23 20:31:39.457576 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-23 20:31:40.132729 | debian-bookworm | changed 2025-08-23 20:31:40.137832 | 2025-08-23 20:31:40.137915 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-23 20:31:40.392212 | debian-bookworm | ok 2025-08-23 20:31:40.397376 | 2025-08-23 20:31:40.397461 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-23 20:31:41.065751 | debian-bookworm | changed 2025-08-23 20:31:41.074400 | 2025-08-23 20:31:41.074515 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-23 20:31:41.716498 | debian-bookworm | changed 2025-08-23 20:31:41.724606 | 2025-08-23 20:31:41.724726 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-23 20:31:41.749819 | debian-bookworm | skipping: Conditional result was False 2025-08-23 20:31:41.764361 | 2025-08-23 20:31:41.764493 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-23 20:31:42.222987 | debian-bookworm -> localhost | changed 2025-08-23 20:31:42.235332 | 2025-08-23 20:31:42.235461 | TASK [add-build-sshkey : Add back temp key] 2025-08-23 20:31:42.619374 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/0e3de27229be4c56bf7ca0cc62f4dee8/work/0e3de27229be4c56bf7ca0cc62f4dee8_id_rsa (zuul-build-sshkey) 2025-08-23 20:31:42.620397 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.017511 2025-08-23 20:31:42.633722 | 2025-08-23 20:31:42.633850 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-23 20:31:43.078644 | debian-bookworm | ok 2025-08-23 20:31:43.085375 | 2025-08-23 20:31:43.085494 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-23 20:31:43.110922 | debian-bookworm | skipping: Conditional result was False 2025-08-23 20:31:43.125241 | 2025-08-23 20:31:43.125351 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-23 20:31:43.553613 | debian-bookworm | ok 2025-08-23 20:31:43.565847 | 2025-08-23 20:31:43.565962 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-23 20:31:43.607480 | debian-bookworm | ok 2025-08-23 20:31:43.617164 | 2025-08-23 20:31:43.617271 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-23 20:31:43.945523 | debian-bookworm -> localhost | ok 2025-08-23 20:31:43.955386 | 2025-08-23 20:31:43.955752 | TASK [validate-host : Collect information about the host] 2025-08-23 20:31:45.195726 | debian-bookworm | ok 2025-08-23 20:31:45.209155 | 2025-08-23 20:31:45.209290 | TASK [validate-host : Sanitize hostname] 2025-08-23 20:31:45.338009 | debian-bookworm | ok 2025-08-23 20:31:45.380146 | 2025-08-23 20:31:45.380277 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-23 20:31:45.964536 | debian-bookworm -> localhost | changed 2025-08-23 20:31:45.972825 | 2025-08-23 20:31:45.973052 | TASK [validate-host : Collect information about zuul worker] 2025-08-23 20:31:46.434221 | debian-bookworm | ok 2025-08-23 20:31:46.442816 | 2025-08-23 20:31:46.442976 | TASK [validate-host : Write out all zuul information for each host] 2025-08-23 20:31:47.098418 | debian-bookworm -> localhost | changed 2025-08-23 20:31:47.108915 | 2025-08-23 20:31:47.109038 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-23 20:31:47.432285 | debian-bookworm | ok 2025-08-23 20:31:47.438539 | 2025-08-23 20:31:47.438656 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-23 20:31:48.750131 | debian-bookworm | changed: 2025-08-23 20:31:48.750360 | debian-bookworm | cd+++++++++ src/ 2025-08-23 20:31:48.750396 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-23 20:31:48.750419 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-23 20:31:48.750440 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-08-23 20:31:48.750460 | debian-bookworm | Containerfile 2025-08-23 20:31:48.750578 | debian-bookworm | Containerfile 2025-08-23 20:31:48.827221 | debian-bookworm | localhost | ok: Runtime: 0:00:00.008353 2025-08-23 20:32:15.401825 | 2025-08-23 20:32:15.402008 | TASK [upload-logs : Upload logs to log server] 2025-08-23 20:32:16.040806 | localhost | Output suppressed because no_log was given 2025-08-23 20:32:16.044643 | 2025-08-23 20:32:16.044826 | LOOP [upload-logs : Compress console log and json output] 2025-08-23 20:32:16.109026 | localhost | skipping: Conditional result was False 2025-08-23 20:32:16.113764 | localhost | skipping: Conditional result was False 2025-08-23 20:32:16.127523 | 2025-08-23 20:32:16.127733 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-23 20:32:16.180904 | localhost | skipping: Conditional result was False 2025-08-23 20:32:16.181525 | 2025-08-23 20:32:16.185207 | localhost | skipping: Conditional result was False 2025-08-23 20:32:16.192880 | 2025-08-23 20:32:16.193135 | LOOP [upload-logs : Upload console log and json output]