2025-11-23 17:22:19.755671 | Job console starting 2025-11-23 17:22:19.770312 | Updating git repos 2025-11-23 17:22:19.818518 | Cloning repos into workspace 2025-11-23 17:22:19.875761 | Restoring repo states 2025-11-23 17:22:19.885315 | Merging changes 2025-11-23 17:22:20.405048 | Checking out repos 2025-11-23 17:22:20.492078 | Preparing playbooks 2025-11-23 17:22:21.531506 | Running Ansible setup 2025-11-23 17:22:27.354599 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-23 17:22:28.554946 | 2025-11-23 17:22:28.555132 | PLAY [Base pre] 2025-11-23 17:22:28.590620 | 2025-11-23 17:22:28.590825 | TASK [Setup log path fact] 2025-11-23 17:22:28.623175 | debian-bookworm | ok 2025-11-23 17:22:28.645041 | 2025-11-23 17:22:28.645257 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-23 17:22:28.676053 | debian-bookworm | ok 2025-11-23 17:22:28.699316 | 2025-11-23 17:22:28.699465 | TASK [emit-job-header : Print job information] 2025-11-23 17:22:28.748879 | # Job Information 2025-11-23 17:22:28.749084 | Ansible Version: 2.16.14 2025-11-23 17:22:28.749123 | Job: python-black 2025-11-23 17:22:28.749157 | Pipeline: check 2025-11-23 17:22:28.749180 | Executor: 521e9411259a 2025-11-23 17:22:28.749201 | Triggered by: https://github.com/osism/python-osism/pull/1847 2025-11-23 17:22:28.749226 | Event ID: c9d23dd0-c890-11f0-9a9f-0fdc065c0739 2025-11-23 17:22:28.755765 | 2025-11-23 17:22:28.755891 | LOOP [emit-job-header : Print node information] 2025-11-23 17:22:28.960035 | debian-bookworm | ok: 2025-11-23 17:22:28.960377 | debian-bookworm | # Node Information 2025-11-23 17:22:28.960422 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-23 17:22:28.960451 | debian-bookworm | Hostname: debian 2025-11-23 17:22:28.960479 | debian-bookworm | Username: zuul 2025-11-23 17:22:28.960501 | debian-bookworm | Distro: Debian 12.12 2025-11-23 17:22:28.960525 | debian-bookworm | Provider: regiocloud-a 2025-11-23 17:22:28.960546 | debian-bookworm | Region: 2025-11-23 17:22:28.960568 | debian-bookworm | Label: debian-bookworm 2025-11-23 17:22:28.960588 | debian-bookworm | Product Name: OpenStack Nova 2025-11-23 17:22:28.960607 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe66:6ab3 2025-11-23 17:22:29.002544 | 2025-11-23 17:22:29.002729 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-23 17:22:30.204385 | debian-bookworm -> localhost | changed 2025-11-23 17:22:30.234000 | 2025-11-23 17:22:30.234161 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-23 17:22:32.000396 | debian-bookworm -> localhost | changed 2025-11-23 17:22:32.013106 | 2025-11-23 17:22:32.013241 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-23 17:22:32.444530 | debian-bookworm -> localhost | ok 2025-11-23 17:22:32.460468 | 2025-11-23 17:22:32.461162 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-23 17:22:32.521471 | debian-bookworm | ok 2025-11-23 17:22:32.562890 | debian-bookworm | included: /var/lib/zuul/builds/bf50d70ee9d3484c976852c91437e729/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-23 17:22:32.579327 | 2025-11-23 17:22:32.579465 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-23 17:22:33.838856 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-23 17:22:33.839087 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/bf50d70ee9d3484c976852c91437e729/work/bf50d70ee9d3484c976852c91437e729_id_rsa 2025-11-23 17:22:33.839127 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/bf50d70ee9d3484c976852c91437e729/work/bf50d70ee9d3484c976852c91437e729_id_rsa.pub 2025-11-23 17:22:33.839153 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-23 17:22:33.839177 | debian-bookworm -> localhost | SHA256:bBQcSbfqnRwVCUcCuCvw9T0p6fm1EHhZlKbZsE7tEYM zuul-build-sshkey 2025-11-23 17:22:33.839199 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-23 17:22:33.839231 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-23 17:22:33.839253 | debian-bookworm -> localhost | | +=+++=o | 2025-11-23 17:22:33.839275 | debian-bookworm -> localhost | | . ooE=*. | 2025-11-23 17:22:33.839294 | debian-bookworm -> localhost | | .. .Ooo | 2025-11-23 17:22:33.839314 | debian-bookworm -> localhost | | . oo o=++ | 2025-11-23 17:22:33.839334 | debian-bookworm -> localhost | | o . oS==o . | 2025-11-23 17:22:33.839359 | debian-bookworm -> localhost | | o .o++=+. | 2025-11-23 17:22:33.839379 | debian-bookworm -> localhost | | . ..o=.. | 2025-11-23 17:22:33.839398 | debian-bookworm -> localhost | | o o . | 2025-11-23 17:22:33.839419 | debian-bookworm -> localhost | | .. . | 2025-11-23 17:22:33.839440 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-23 17:22:33.839496 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.622171 2025-11-23 17:22:33.846366 | 2025-11-23 17:22:33.846480 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-23 17:22:33.895117 | debian-bookworm | ok 2025-11-23 17:22:33.905313 | debian-bookworm | included: /var/lib/zuul/builds/bf50d70ee9d3484c976852c91437e729/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-23 17:22:33.916806 | 2025-11-23 17:22:33.916932 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-23 17:22:33.941416 | debian-bookworm | skipping: Conditional result was False 2025-11-23 17:22:33.947860 | 2025-11-23 17:22:33.947980 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-23 17:22:34.706732 | debian-bookworm | changed 2025-11-23 17:22:34.712811 | 2025-11-23 17:22:34.712936 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-23 17:22:34.989232 | debian-bookworm | ok 2025-11-23 17:22:34.995069 | 2025-11-23 17:22:34.995185 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-23 17:22:35.756181 | debian-bookworm | changed 2025-11-23 17:22:35.772871 | 2025-11-23 17:22:35.773011 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-23 17:22:36.479854 | debian-bookworm | changed 2025-11-23 17:22:36.489223 | 2025-11-23 17:22:36.489366 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-23 17:22:36.513989 | debian-bookworm | skipping: Conditional result was False 2025-11-23 17:22:36.521743 | 2025-11-23 17:22:36.521875 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-23 17:22:37.028758 | debian-bookworm -> localhost | changed 2025-11-23 17:22:37.056122 | 2025-11-23 17:22:37.056767 | TASK [add-build-sshkey : Add back temp key] 2025-11-23 17:22:37.403782 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/bf50d70ee9d3484c976852c91437e729/work/bf50d70ee9d3484c976852c91437e729_id_rsa (zuul-build-sshkey) 2025-11-23 17:22:37.404090 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013207 2025-11-23 17:22:37.413223 | 2025-11-23 17:22:37.417394 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-23 17:22:37.894502 | debian-bookworm | ok 2025-11-23 17:22:37.902482 | 2025-11-23 17:22:37.902618 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-23 17:22:37.937291 | debian-bookworm | skipping: Conditional result was False 2025-11-23 17:22:37.949554 | 2025-11-23 17:22:37.949679 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-23 17:22:38.428871 | debian-bookworm | ok 2025-11-23 17:22:38.450446 | 2025-11-23 17:22:38.450596 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-23 17:22:38.501993 | debian-bookworm | ok 2025-11-23 17:22:38.510440 | 2025-11-23 17:22:38.510569 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-23 17:22:39.005041 | debian-bookworm -> localhost | ok 2025-11-23 17:22:39.012733 | 2025-11-23 17:22:39.012874 | TASK [validate-host : Collect information about the host] 2025-11-23 17:22:40.412150 | debian-bookworm | ok 2025-11-23 17:22:40.435744 | 2025-11-23 17:22:40.435887 | TASK [validate-host : Sanitize hostname] 2025-11-23 17:22:40.569034 | debian-bookworm | ok 2025-11-23 17:22:40.621726 | 2025-11-23 17:22:40.621875 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-23 17:22:41.511429 | debian-bookworm -> localhost | changed 2025-11-23 17:22:41.517759 | 2025-11-23 17:22:41.517876 | TASK [validate-host : Collect information about zuul worker] 2025-11-23 17:22:42.025822 | debian-bookworm | ok 2025-11-23 17:22:42.034887 | 2025-11-23 17:22:42.035083 | TASK [validate-host : Write out all zuul information for each host] 2025-11-23 17:22:43.004110 | debian-bookworm -> localhost | changed 2025-11-23 17:22:43.033974 | 2025-11-23 17:22:43.034110 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-23 17:22:43.330536 | debian-bookworm | ok 2025-11-23 17:22:43.337027 | 2025-11-23 17:22:43.337158 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-23 17:22:44.428443 | debian-bookworm | changed: 2025-11-23 17:22:44.428716 | debian-bookworm | cd+++++++++ src/ 2025-11-23 17:22:44.439908 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-23 17:22:44.440099 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-23 17:22:44.440185 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-11-23 17:22:44.440253 | debian-bookworm | Containerfile 2025-11-23 17:22:44.440590 | debian-bookworm | Containerfile 2025-11-23 17:22:44.470207 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006284 2025-11-23 17:23:12.443039 | 2025-11-23 17:23:12.443207 | TASK [upload-logs : Upload logs to log server] 2025-11-23 17:23:13.031229 | localhost | Output suppressed because no_log was given 2025-11-23 17:23:13.033090 | 2025-11-23 17:23:13.033195 | LOOP [upload-logs : Compress console log and json output] 2025-11-23 17:23:13.101663 | localhost | skipping: Conditional result was False 2025-11-23 17:23:13.110670 | localhost | skipping: Conditional result was False 2025-11-23 17:23:13.123903 | 2025-11-23 17:23:13.124093 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-23 17:23:13.177232 | localhost | skipping: Conditional result was False 2025-11-23 17:23:13.177512 | 2025-11-23 17:23:13.185900 | localhost | skipping: Conditional result was False 2025-11-23 17:23:13.193022 | 2025-11-23 17:23:13.193164 | LOOP [upload-logs : Upload console log and json output]