2025-12-19 07:55:08.043015 | Job console starting 2025-12-19 07:55:08.067541 | Updating git repos 2025-12-19 07:55:08.250997 | Cloning repos into workspace 2025-12-19 07:55:08.307319 | Restoring repo states 2025-12-19 07:55:08.333288 | Merging changes 2025-12-19 07:55:09.117184 | Checking out repos 2025-12-19 07:55:09.184308 | Preparing playbooks 2025-12-19 07:55:10.618041 | Running Ansible setup 2025-12-19 07:55:18.612802 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-19 07:55:20.859074 | 2025-12-19 07:55:20.859277 | PLAY [Base pre] 2025-12-19 07:55:20.908569 | 2025-12-19 07:55:20.908776 | TASK [Setup log path fact] 2025-12-19 07:55:20.950455 | debian-bookworm | ok 2025-12-19 07:55:20.980907 | 2025-12-19 07:55:20.981091 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-19 07:55:21.085945 | debian-bookworm | ok 2025-12-19 07:55:21.098313 | 2025-12-19 07:55:21.098453 | TASK [emit-job-header : Print job information] 2025-12-19 07:55:21.141704 | # Job Information 2025-12-19 07:55:21.142065 | Ansible Version: 2.16.14 2025-12-19 07:55:21.142114 | Job: python-black 2025-12-19 07:55:21.142148 | Pipeline: check 2025-12-19 07:55:21.142172 | Executor: 521e9411259a 2025-12-19 07:55:21.142280 | Triggered by: https://github.com/osism/python-osism/pull/1916 2025-12-19 07:55:21.142310 | Event ID: 03f2e450-dcb0-11f0-913a-13c2b9bea56b 2025-12-19 07:55:21.149830 | 2025-12-19 07:55:21.149973 | LOOP [emit-job-header : Print node information] 2025-12-19 07:55:21.293352 | debian-bookworm | ok: 2025-12-19 07:55:21.293555 | debian-bookworm | # Node Information 2025-12-19 07:55:21.293589 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-19 07:55:21.293654 | debian-bookworm | Hostname: debian 2025-12-19 07:55:21.293679 | debian-bookworm | Username: zuul 2025-12-19 07:55:21.293701 | debian-bookworm | Distro: Debian 12.12 2025-12-19 07:55:21.293724 | debian-bookworm | Provider: regiocloud-a 2025-12-19 07:55:21.293745 | debian-bookworm | Region: 2025-12-19 07:55:21.293766 | debian-bookworm | Label: debian-bookworm 2025-12-19 07:55:21.293786 | debian-bookworm | Product Name: OpenStack Nova 2025-12-19 07:55:21.293805 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe9d:bc82 2025-12-19 07:55:21.313302 | 2025-12-19 07:55:21.313444 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-19 07:55:22.596456 | debian-bookworm -> localhost | changed 2025-12-19 07:55:22.604444 | 2025-12-19 07:55:22.604582 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-19 07:55:26.241493 | debian-bookworm -> localhost | changed 2025-12-19 07:55:26.259539 | 2025-12-19 07:55:26.259776 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-19 07:55:27.440160 | debian-bookworm -> localhost | ok 2025-12-19 07:55:27.446731 | 2025-12-19 07:55:27.447660 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-19 07:55:27.576180 | debian-bookworm | ok 2025-12-19 07:55:27.674526 | debian-bookworm | included: /var/lib/zuul/builds/942e516fdcad46c5a9390cd21bea8976/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-19 07:55:27.727154 | 2025-12-19 07:55:27.727295 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-19 07:55:31.908194 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-19 07:55:31.908460 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/942e516fdcad46c5a9390cd21bea8976/work/942e516fdcad46c5a9390cd21bea8976_id_rsa 2025-12-19 07:55:31.908565 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/942e516fdcad46c5a9390cd21bea8976/work/942e516fdcad46c5a9390cd21bea8976_id_rsa.pub 2025-12-19 07:55:31.908694 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-19 07:55:31.908723 | debian-bookworm -> localhost | SHA256:YNvY+k+E1mvd2vzQQdoC/BT+aUhlfZi97OEKEqnRR+U zuul-build-sshkey 2025-12-19 07:55:31.908746 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-19 07:55:31.908783 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-19 07:55:31.908806 | debian-bookworm -> localhost | | .o *.| 2025-12-19 07:55:31.908828 | debian-bookworm -> localhost | | ..o * +| 2025-12-19 07:55:31.908848 | debian-bookworm -> localhost | | o . oo E..o| 2025-12-19 07:55:31.908867 | debian-bookworm -> localhost | | . B * .= *+.| 2025-12-19 07:55:31.908887 | debian-bookworm -> localhost | | o S = =o*.| 2025-12-19 07:55:31.908923 | debian-bookworm -> localhost | | + o + .o+.| 2025-12-19 07:55:31.908945 | debian-bookworm -> localhost | | . = o + .| 2025-12-19 07:55:31.908965 | debian-bookworm -> localhost | | . o = . | 2025-12-19 07:55:31.908985 | debian-bookworm -> localhost | | ... . o..| 2025-12-19 07:55:31.909006 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-19 07:55:31.909068 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.053943 2025-12-19 07:55:31.920991 | 2025-12-19 07:55:31.921126 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-19 07:55:31.970142 | debian-bookworm | ok 2025-12-19 07:55:31.993197 | debian-bookworm | included: /var/lib/zuul/builds/942e516fdcad46c5a9390cd21bea8976/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-19 07:55:32.030818 | 2025-12-19 07:55:32.031071 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-19 07:55:32.080926 | debian-bookworm | skipping: Conditional result was False 2025-12-19 07:55:32.088894 | 2025-12-19 07:55:32.089039 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-19 07:55:33.090596 | debian-bookworm | changed 2025-12-19 07:55:33.102142 | 2025-12-19 07:55:33.102275 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-19 07:55:33.397026 | debian-bookworm | ok 2025-12-19 07:55:33.403037 | 2025-12-19 07:55:33.403160 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-19 07:55:34.190753 | debian-bookworm | changed 2025-12-19 07:55:34.204728 | 2025-12-19 07:55:34.204880 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-19 07:55:35.102944 | debian-bookworm | changed 2025-12-19 07:55:35.108812 | 2025-12-19 07:55:35.108931 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-19 07:55:35.174862 | debian-bookworm | skipping: Conditional result was False 2025-12-19 07:55:35.190548 | 2025-12-19 07:55:35.191291 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-19 07:55:36.767966 | debian-bookworm -> localhost | changed 2025-12-19 07:55:36.779578 | 2025-12-19 07:55:36.779730 | TASK [add-build-sshkey : Add back temp key] 2025-12-19 07:55:37.988565 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/942e516fdcad46c5a9390cd21bea8976/work/942e516fdcad46c5a9390cd21bea8976_id_rsa (zuul-build-sshkey) 2025-12-19 07:55:37.988816 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011969 2025-12-19 07:55:37.996635 | 2025-12-19 07:55:37.996730 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-19 07:55:38.619744 | debian-bookworm | ok 2025-12-19 07:55:38.627714 | 2025-12-19 07:55:38.627806 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-19 07:55:38.660812 | debian-bookworm | skipping: Conditional result was False 2025-12-19 07:55:38.673310 | 2025-12-19 07:55:38.673417 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-19 07:55:39.128815 | debian-bookworm | ok 2025-12-19 07:55:39.147925 | 2025-12-19 07:55:39.148050 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-19 07:55:39.187272 | debian-bookworm | ok 2025-12-19 07:55:39.200017 | 2025-12-19 07:55:39.200129 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-19 07:55:39.950786 | debian-bookworm -> localhost | ok 2025-12-19 07:55:39.956987 | 2025-12-19 07:55:39.957080 | TASK [validate-host : Collect information about the host] 2025-12-19 07:55:41.125569 | debian-bookworm | ok 2025-12-19 07:55:41.169360 | 2025-12-19 07:55:41.169467 | TASK [validate-host : Sanitize hostname] 2025-12-19 07:55:41.343143 | debian-bookworm | ok 2025-12-19 07:55:41.445628 | 2025-12-19 07:55:41.445732 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-19 07:55:43.159069 | debian-bookworm -> localhost | changed 2025-12-19 07:55:43.167128 | 2025-12-19 07:55:43.167375 | TASK [validate-host : Collect information about zuul worker] 2025-12-19 07:55:43.981652 | debian-bookworm | ok 2025-12-19 07:55:43.986890 | 2025-12-19 07:55:43.986994 | TASK [validate-host : Write out all zuul information for each host] 2025-12-19 07:55:45.519713 | debian-bookworm -> localhost | changed 2025-12-19 07:55:45.527196 | 2025-12-19 07:55:45.527274 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-19 07:55:45.838733 | debian-bookworm | ok 2025-12-19 07:55:45.852872 | 2025-12-19 07:55:45.852971 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-19 07:55:47.239912 | debian-bookworm | changed: 2025-12-19 07:55:47.240063 | debian-bookworm | cd+++++++++ src/ 2025-12-19 07:55:47.240090 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-19 07:55:47.240110 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-19 07:55:47.240128 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-12-19 07:55:47.240145 | debian-bookworm | Containerfile 2025-12-19 07:55:47.240254 | debian-bookworm | Containerfile 2025-12-19 07:55:47.245498 | debian-bookworm | localhost | ok: Runtime: 0:00:00.008599 2025-12-19 07:56:15.416009 | 2025-12-19 07:56:15.416239 | TASK [upload-logs : Upload logs to log server] 2025-12-19 07:56:16.158808 | localhost | Output suppressed because no_log was given 2025-12-19 07:56:16.161395 | 2025-12-19 07:56:16.161512 | LOOP [upload-logs : Compress console log and json output] 2025-12-19 07:56:16.213827 | localhost | skipping: Conditional result was False 2025-12-19 07:56:16.220200 | localhost | skipping: Conditional result was False 2025-12-19 07:56:16.229239 | 2025-12-19 07:56:16.229360 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-19 07:56:16.279947 | localhost | skipping: Conditional result was False 2025-12-19 07:56:16.280271 | 2025-12-19 07:56:16.285550 | localhost | skipping: Conditional result was False 2025-12-19 07:56:16.296538 | 2025-12-19 07:56:16.296679 | LOOP [upload-logs : Upload console log and json output]