2025-08-27 18:00:33.255326 | Job console starting 2025-08-27 18:00:33.272659 | Updating git repos 2025-08-27 18:00:33.318118 | Cloning repos into workspace 2025-08-27 18:00:33.391465 | Restoring repo states 2025-08-27 18:00:33.413243 | Merging changes 2025-08-27 18:00:34.002955 | Checking out repos 2025-08-27 18:00:34.062961 | Preparing playbooks 2025-08-27 18:00:35.093091 | Running Ansible setup 2025-08-27 18:00:40.635029 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-27 18:00:42.128209 | 2025-08-27 18:00:42.128337 | PLAY [Base pre] 2025-08-27 18:00:42.144617 | 2025-08-27 18:00:42.144730 | TASK [Setup log path fact] 2025-08-27 18:00:42.172546 | debian-bookworm | ok 2025-08-27 18:00:42.215668 | 2025-08-27 18:00:42.215832 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-27 18:00:42.268719 | debian-bookworm | ok 2025-08-27 18:00:42.287960 | 2025-08-27 18:00:42.288065 | TASK [emit-job-header : Print job information] 2025-08-27 18:00:42.347487 | # Job Information 2025-08-27 18:00:42.347686 | Ansible Version: 2.16.14 2025-08-27 18:00:42.347723 | Job: python-black 2025-08-27 18:00:42.347759 | Pipeline: check 2025-08-27 18:00:42.347787 | Executor: 521e9411259a 2025-08-27 18:00:42.347833 | Triggered by: https://github.com/osism/python-osism/pull/1679 2025-08-27 18:00:42.347856 | Event ID: b4e1f0c0-836f-11f0-8202-580ed479e508 2025-08-27 18:00:42.352809 | 2025-08-27 18:00:42.352920 | LOOP [emit-job-header : Print node information] 2025-08-27 18:00:42.600341 | debian-bookworm | ok: 2025-08-27 18:00:42.600575 | debian-bookworm | # Node Information 2025-08-27 18:00:42.600614 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-27 18:00:42.600640 | debian-bookworm | Hostname: debian 2025-08-27 18:00:42.600662 | debian-bookworm | Username: zuul 2025-08-27 18:00:42.600684 | debian-bookworm | Distro: Debian 12.11 2025-08-27 18:00:42.600712 | debian-bookworm | Provider: regiocloud-a 2025-08-27 18:00:42.600738 | debian-bookworm | Region: 2025-08-27 18:00:42.600760 | debian-bookworm | Label: debian-bookworm 2025-08-27 18:00:42.600894 | debian-bookworm | Product Name: OpenStack Nova 2025-08-27 18:00:42.600918 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe2d:6c96 2025-08-27 18:00:42.623106 | 2025-08-27 18:00:42.623223 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-27 18:00:43.347997 | debian-bookworm -> localhost | changed 2025-08-27 18:00:43.354704 | 2025-08-27 18:00:43.354817 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-27 18:00:44.989272 | debian-bookworm -> localhost | changed 2025-08-27 18:00:44.998310 | 2025-08-27 18:00:44.998401 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-27 18:00:45.496287 | debian-bookworm -> localhost | ok 2025-08-27 18:00:45.501300 | 2025-08-27 18:00:45.501383 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-27 18:00:45.538050 | debian-bookworm | ok 2025-08-27 18:00:45.559846 | debian-bookworm | included: /var/lib/zuul/builds/8aaddc8f4d45406dbc4cbb1f364ea02e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-27 18:00:45.575091 | 2025-08-27 18:00:45.575179 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-27 18:00:46.972420 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-27 18:00:46.972577 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/8aaddc8f4d45406dbc4cbb1f364ea02e/work/8aaddc8f4d45406dbc4cbb1f364ea02e_id_rsa 2025-08-27 18:00:46.972609 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/8aaddc8f4d45406dbc4cbb1f364ea02e/work/8aaddc8f4d45406dbc4cbb1f364ea02e_id_rsa.pub 2025-08-27 18:00:46.972632 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-27 18:00:46.972652 | debian-bookworm -> localhost | SHA256:lw/RQAGBUUPvOD8ZOG5dyxPZynrv9FsfSfFvvfY5CJ8 zuul-build-sshkey 2025-08-27 18:00:46.972671 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-27 18:00:46.972696 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-27 18:00:46.972714 | debian-bookworm -> localhost | | .=*++. | 2025-08-27 18:00:46.972731 | debian-bookworm -> localhost | | . o o | 2025-08-27 18:00:46.972747 | debian-bookworm -> localhost | | o . . | 2025-08-27 18:00:46.972763 | debian-bookworm -> localhost | | + o o o| 2025-08-27 18:00:46.972778 | debian-bookworm -> localhost | | S * + ...| 2025-08-27 18:00:46.972835 | debian-bookworm -> localhost | | . * X +. +| 2025-08-27 18:00:46.972854 | debian-bookworm -> localhost | | o = X +o=| 2025-08-27 18:00:46.972871 | debian-bookworm -> localhost | | . o.E =*| 2025-08-27 18:00:46.972888 | debian-bookworm -> localhost | | .. o++B| 2025-08-27 18:00:46.972904 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-27 18:00:46.972945 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.668629 2025-08-27 18:00:46.977833 | 2025-08-27 18:00:46.977906 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-27 18:00:47.018684 | debian-bookworm | ok 2025-08-27 18:00:47.031533 | debian-bookworm | included: /var/lib/zuul/builds/8aaddc8f4d45406dbc4cbb1f364ea02e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-27 18:00:47.044746 | 2025-08-27 18:00:47.044830 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-27 18:00:47.079027 | debian-bookworm | skipping: Conditional result was False 2025-08-27 18:00:47.095278 | 2025-08-27 18:00:47.095364 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-27 18:00:47.839625 | debian-bookworm | changed 2025-08-27 18:00:47.844695 | 2025-08-27 18:00:47.844775 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-27 18:00:48.121566 | debian-bookworm | ok 2025-08-27 18:00:48.129105 | 2025-08-27 18:00:48.129225 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-27 18:00:48.742169 | debian-bookworm | changed 2025-08-27 18:00:48.749536 | 2025-08-27 18:00:48.749638 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-27 18:00:49.378422 | debian-bookworm | changed 2025-08-27 18:00:49.385736 | 2025-08-27 18:00:49.385857 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-27 18:00:49.400194 | debian-bookworm | skipping: Conditional result was False 2025-08-27 18:00:49.408290 | 2025-08-27 18:00:49.408390 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-27 18:00:49.870110 | debian-bookworm -> localhost | changed 2025-08-27 18:00:49.880314 | 2025-08-27 18:00:49.880416 | TASK [add-build-sshkey : Add back temp key] 2025-08-27 18:00:50.360616 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/8aaddc8f4d45406dbc4cbb1f364ea02e/work/8aaddc8f4d45406dbc4cbb1f364ea02e_id_rsa (zuul-build-sshkey) 2025-08-27 18:00:50.360802 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.028592 2025-08-27 18:00:50.373996 | 2025-08-27 18:00:50.374086 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-27 18:00:50.820175 | debian-bookworm | ok 2025-08-27 18:00:50.824213 | 2025-08-27 18:00:50.824296 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-27 18:00:50.849110 | debian-bookworm | skipping: Conditional result was False 2025-08-27 18:00:50.857407 | 2025-08-27 18:00:50.857485 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-27 18:00:51.338439 | debian-bookworm | ok 2025-08-27 18:00:51.352004 | 2025-08-27 18:00:51.352231 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-27 18:00:51.382996 | debian-bookworm | ok 2025-08-27 18:00:51.389237 | 2025-08-27 18:00:51.389340 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-27 18:00:51.849420 | debian-bookworm -> localhost | ok 2025-08-27 18:00:51.855705 | 2025-08-27 18:00:51.855820 | TASK [validate-host : Collect information about the host] 2025-08-27 18:00:53.268817 | debian-bookworm | ok 2025-08-27 18:00:53.281194 | 2025-08-27 18:00:53.281320 | TASK [validate-host : Sanitize hostname] 2025-08-27 18:00:53.393924 | debian-bookworm | ok 2025-08-27 18:00:53.444387 | 2025-08-27 18:00:53.444524 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-27 18:00:54.475495 | debian-bookworm -> localhost | changed 2025-08-27 18:00:54.481489 | 2025-08-27 18:00:54.481612 | TASK [validate-host : Collect information about zuul worker] 2025-08-27 18:00:54.975019 | debian-bookworm | ok 2025-08-27 18:00:54.979915 | 2025-08-27 18:00:54.980034 | TASK [validate-host : Write out all zuul information for each host] 2025-08-27 18:00:55.761891 | debian-bookworm -> localhost | changed 2025-08-27 18:00:55.771585 | 2025-08-27 18:00:55.771697 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-27 18:00:56.045473 | debian-bookworm | ok 2025-08-27 18:00:56.053704 | 2025-08-27 18:00:56.053840 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-27 18:00:57.280274 | debian-bookworm | changed: 2025-08-27 18:00:57.280480 | debian-bookworm | cd+++++++++ src/ 2025-08-27 18:00:57.280516 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-27 18:00:57.280540 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-27 18:00:57.280563 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-08-27 18:00:57.280584 | debian-bookworm | Containerfile 2025-08-27 18:00:57.280699 | debian-bookworm | Containerfile 2025-08-27 18:00:57.299151 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007020 2025-08-27 18:01:25.012229 | 2025-08-27 18:01:25.012425 | TASK [upload-logs : Upload logs to log server] 2025-08-27 18:01:25.609215 | localhost | Output suppressed because no_log was given 2025-08-27 18:01:25.611843 | 2025-08-27 18:01:25.611978 | LOOP [upload-logs : Compress console log and json output] 2025-08-27 18:01:25.659723 | localhost | skipping: Conditional result was False 2025-08-27 18:01:25.665556 | localhost | skipping: Conditional result was False 2025-08-27 18:01:25.675474 | 2025-08-27 18:01:25.675697 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-27 18:01:25.722371 | localhost | skipping: Conditional result was False 2025-08-27 18:01:25.723228 | 2025-08-27 18:01:25.726259 | localhost | skipping: Conditional result was False 2025-08-27 18:01:25.741135 | 2025-08-27 18:01:25.741323 | LOOP [upload-logs : Upload console log and json output]