2025-12-05 20:59:34.903547 | Job console starting 2025-12-05 20:59:34.953906 | Updating git repos 2025-12-05 20:59:34.996316 | Cloning repos into workspace 2025-12-05 20:59:35.077829 | Restoring repo states 2025-12-05 20:59:35.086093 | Merging changes 2025-12-05 20:59:35.636268 | Checking out repos 2025-12-05 20:59:35.767904 | Preparing playbooks 2025-12-05 20:59:36.746111 | Running Ansible setup 2025-12-05 20:59:41.448681 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-05 20:59:42.327234 | 2025-12-05 20:59:42.327508 | PLAY [Base pre] 2025-12-05 20:59:42.346956 | 2025-12-05 20:59:42.347105 | TASK [Setup log path fact] 2025-12-05 20:59:42.376845 | debian-bookworm | ok 2025-12-05 20:59:42.394065 | 2025-12-05 20:59:42.394228 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-05 20:59:42.434603 | debian-bookworm | ok 2025-12-05 20:59:42.448801 | 2025-12-05 20:59:42.448945 | TASK [emit-job-header : Print job information] 2025-12-05 20:59:42.489644 | # Job Information 2025-12-05 20:59:42.489841 | Ansible Version: 2.16.14 2025-12-05 20:59:42.489877 | Job: python-black 2025-12-05 20:59:42.489909 | Pipeline: check 2025-12-05 20:59:42.489931 | Executor: 521e9411259a 2025-12-05 20:59:42.489952 | Triggered by: https://github.com/osism/testbed/pull/2797 2025-12-05 20:59:42.489975 | Event ID: 4926a7c0-d21d-11f0-9501-64a6fda61f1e 2025-12-05 20:59:42.495335 | 2025-12-05 20:59:42.495504 | LOOP [emit-job-header : Print node information] 2025-12-05 20:59:42.612058 | debian-bookworm | ok: 2025-12-05 20:59:42.612380 | debian-bookworm | # Node Information 2025-12-05 20:59:42.612465 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-05 20:59:42.612494 | debian-bookworm | Hostname: debian 2025-12-05 20:59:42.612516 | debian-bookworm | Username: zuul 2025-12-05 20:59:42.612537 | debian-bookworm | Distro: Debian 12.12 2025-12-05 20:59:42.612562 | debian-bookworm | Provider: regiocloud-a 2025-12-05 20:59:42.612582 | debian-bookworm | Region: 2025-12-05 20:59:42.612603 | debian-bookworm | Label: debian-bookworm 2025-12-05 20:59:42.612623 | debian-bookworm | Product Name: OpenStack Nova 2025-12-05 20:59:42.612642 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe45:829d 2025-12-05 20:59:42.634812 | 2025-12-05 20:59:42.634988 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-05 20:59:43.115697 | debian-bookworm -> localhost | changed 2025-12-05 20:59:43.123661 | 2025-12-05 20:59:43.123817 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-05 20:59:44.242926 | debian-bookworm -> localhost | changed 2025-12-05 20:59:44.254310 | 2025-12-05 20:59:44.254497 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-05 20:59:44.544663 | debian-bookworm -> localhost | ok 2025-12-05 20:59:44.551813 | 2025-12-05 20:59:44.551953 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-05 20:59:44.581878 | debian-bookworm | ok 2025-12-05 20:59:44.600868 | debian-bookworm | included: /var/lib/zuul/builds/bb8e00954fea444da76abacc1c0fff6e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-05 20:59:44.607243 | 2025-12-05 20:59:44.607363 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-05 20:59:45.930162 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-05 20:59:45.930486 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/bb8e00954fea444da76abacc1c0fff6e/work/bb8e00954fea444da76abacc1c0fff6e_id_rsa 2025-12-05 20:59:45.930537 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/bb8e00954fea444da76abacc1c0fff6e/work/bb8e00954fea444da76abacc1c0fff6e_id_rsa.pub 2025-12-05 20:59:45.930564 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-05 20:59:45.930588 | debian-bookworm -> localhost | SHA256:EbmqSRSbmwr+Q+ia0sOaRqtwHrPXx0rtUhg/SgKFyGI zuul-build-sshkey 2025-12-05 20:59:45.930610 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-05 20:59:45.930645 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-05 20:59:45.930667 | debian-bookworm -> localhost | |.. . .. | 2025-12-05 20:59:45.930688 | debian-bookworm -> localhost | |oE. o .. | 2025-12-05 20:59:45.930709 | debian-bookworm -> localhost | |o . + .. | 2025-12-05 20:59:45.930728 | debian-bookworm -> localhost | | . + . .. | 2025-12-05 20:59:45.930748 | debian-bookworm -> localhost | | .o o =S | 2025-12-05 20:59:45.930769 | debian-bookworm -> localhost | |.o .= +.+ | 2025-12-05 20:59:45.930789 | debian-bookworm -> localhost | |=+*o *.+.. | 2025-12-05 20:59:45.930808 | debian-bookworm -> localhost | |oX==+.+.o | 2025-12-05 20:59:45.930829 | debian-bookworm -> localhost | |@.++. .+. | 2025-12-05 20:59:45.930867 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-05 20:59:45.930927 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.835022 2025-12-05 20:59:45.937746 | 2025-12-05 20:59:45.937875 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-05 20:59:45.978785 | debian-bookworm | ok 2025-12-05 20:59:45.989599 | debian-bookworm | included: /var/lib/zuul/builds/bb8e00954fea444da76abacc1c0fff6e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-05 20:59:46.020621 | 2025-12-05 20:59:46.020750 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-05 20:59:46.055355 | debian-bookworm | skipping: Conditional result was False 2025-12-05 20:59:46.063290 | 2025-12-05 20:59:46.063469 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-05 20:59:46.728821 | debian-bookworm | changed 2025-12-05 20:59:46.735460 | 2025-12-05 20:59:46.735603 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-05 20:59:46.998309 | debian-bookworm | ok 2025-12-05 20:59:47.007770 | 2025-12-05 20:59:47.007932 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-05 20:59:47.725671 | debian-bookworm | changed 2025-12-05 20:59:47.733994 | 2025-12-05 20:59:47.734127 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-05 20:59:48.393134 | debian-bookworm | changed 2025-12-05 20:59:48.398872 | 2025-12-05 20:59:48.398997 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-05 20:59:48.423612 | debian-bookworm | skipping: Conditional result was False 2025-12-05 20:59:48.431515 | 2025-12-05 20:59:48.431660 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-05 20:59:48.928065 | debian-bookworm -> localhost | changed 2025-12-05 20:59:48.941901 | 2025-12-05 20:59:48.942114 | TASK [add-build-sshkey : Add back temp key] 2025-12-05 20:59:49.356077 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/bb8e00954fea444da76abacc1c0fff6e/work/bb8e00954fea444da76abacc1c0fff6e_id_rsa (zuul-build-sshkey) 2025-12-05 20:59:49.356324 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019046 2025-12-05 20:59:49.364505 | 2025-12-05 20:59:49.364636 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-05 20:59:49.849120 | debian-bookworm | ok 2025-12-05 20:59:49.856717 | 2025-12-05 20:59:49.856879 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-05 20:59:49.891989 | debian-bookworm | skipping: Conditional result was False 2025-12-05 20:59:49.913586 | 2025-12-05 20:59:49.913748 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-05 20:59:50.399670 | debian-bookworm | ok 2025-12-05 20:59:50.414279 | 2025-12-05 20:59:50.414490 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-05 20:59:50.445053 | debian-bookworm | ok 2025-12-05 20:59:50.454097 | 2025-12-05 20:59:50.454245 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-05 20:59:50.774195 | debian-bookworm -> localhost | ok 2025-12-05 20:59:50.782870 | 2025-12-05 20:59:50.783010 | TASK [validate-host : Collect information about the host] 2025-12-05 20:59:51.962084 | debian-bookworm | ok 2025-12-05 20:59:51.972434 | 2025-12-05 20:59:51.972561 | TASK [validate-host : Sanitize hostname] 2025-12-05 20:59:52.093753 | debian-bookworm | ok 2025-12-05 20:59:52.136374 | 2025-12-05 20:59:52.136556 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-05 20:59:52.762259 | debian-bookworm -> localhost | changed 2025-12-05 20:59:52.775428 | 2025-12-05 20:59:52.775624 | TASK [validate-host : Collect information about zuul worker] 2025-12-05 20:59:53.201156 | debian-bookworm | ok 2025-12-05 20:59:53.205911 | 2025-12-05 20:59:53.206019 | TASK [validate-host : Write out all zuul information for each host] 2025-12-05 20:59:53.775295 | debian-bookworm -> localhost | changed 2025-12-05 20:59:53.786942 | 2025-12-05 20:59:53.787087 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-05 20:59:54.070279 | debian-bookworm | ok 2025-12-05 20:59:54.077209 | 2025-12-05 20:59:54.077355 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-05 20:59:55.285440 | debian-bookworm | changed: 2025-12-05 20:59:55.285657 | debian-bookworm | cd+++++++++ src/ 2025-12-05 20:59:55.285693 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-05 20:59:55.285716 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-05 20:59:55.285738 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-12-05 20:59:55.285758 | debian-bookworm | localhost | ok: Runtime: 0:00:00.005562 2025-12-05 21:00:21.156969 | 2025-12-05 21:00:21.157097 | TASK [upload-logs : Upload logs to log server] 2025-12-05 21:00:21.745456 | localhost | Output suppressed because no_log was given 2025-12-05 21:00:21.751576 | 2025-12-05 21:00:21.751806 | LOOP [upload-logs : Compress console log and json output] 2025-12-05 21:00:21.809629 | localhost | skipping: Conditional result was False 2025-12-05 21:00:21.815180 | localhost | skipping: Conditional result was False 2025-12-05 21:00:21.825541 | 2025-12-05 21:00:21.825691 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-05 21:00:21.880064 | localhost | skipping: Conditional result was False 2025-12-05 21:00:21.880503 | 2025-12-05 21:00:21.887912 | localhost | skipping: Conditional result was False 2025-12-05 21:00:21.893303 | 2025-12-05 21:00:21.893485 | LOOP [upload-logs : Upload console log and json output]