2025-11-01 23:02:17.145697 | Job console starting 2025-11-01 23:02:17.160255 | Updating git repos 2025-11-01 23:02:17.187519 | Cloning repos into workspace 2025-11-01 23:02:17.213071 | Restoring repo states 2025-11-01 23:02:17.226716 | Merging changes 2025-11-01 23:02:17.726623 | Checking out repos 2025-11-01 23:02:17.779622 | Preparing playbooks 2025-11-01 23:02:18.479053 | Running Ansible setup 2025-11-01 23:02:22.890401 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-01 23:02:23.580416 | 2025-11-01 23:02:23.580549 | PLAY [Base pre] 2025-11-01 23:02:23.595772 | 2025-11-01 23:02:23.595894 | TASK [Setup log path fact] 2025-11-01 23:02:23.624046 | debian-bookworm | ok 2025-11-01 23:02:23.638385 | 2025-11-01 23:02:23.638499 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-01 23:02:23.667042 | debian-bookworm | ok 2025-11-01 23:02:23.676398 | 2025-11-01 23:02:23.676491 | TASK [emit-job-header : Print job information] 2025-11-01 23:02:23.719614 | # Job Information 2025-11-01 23:02:23.734796 | Ansible Version: 2.16.14 2025-11-01 23:02:23.734866 | Job: python-black 2025-11-01 23:02:23.734904 | Pipeline: check 2025-11-01 23:02:23.734928 | Executor: 521e9411259a 2025-11-01 23:02:23.734950 | Triggered by: https://github.com/osism/python-osism/pull/1787 2025-11-01 23:02:23.734973 | Event ID: 81ed93a0-b776-11f0-9256-cc154d325e46 2025-11-01 23:02:23.739909 | 2025-11-01 23:02:23.740010 | LOOP [emit-job-header : Print node information] 2025-11-01 23:02:23.837018 | debian-bookworm | ok: 2025-11-01 23:02:23.837188 | debian-bookworm | # Node Information 2025-11-01 23:02:23.837222 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-01 23:02:23.837247 | debian-bookworm | Hostname: debian 2025-11-01 23:02:23.837269 | debian-bookworm | Username: zuul 2025-11-01 23:02:23.837290 | debian-bookworm | Distro: Debian 12.12 2025-11-01 23:02:23.837313 | debian-bookworm | Provider: regiocloud-a 2025-11-01 23:02:23.837335 | debian-bookworm | Region: 2025-11-01 23:02:23.837356 | debian-bookworm | Label: debian-bookworm 2025-11-01 23:02:23.837376 | debian-bookworm | Product Name: OpenStack Nova 2025-11-01 23:02:23.837395 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe8b:3116 2025-11-01 23:02:23.855282 | 2025-11-01 23:02:23.855387 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-01 23:02:24.443978 | debian-bookworm -> localhost | changed 2025-11-01 23:02:24.451496 | 2025-11-01 23:02:24.451606 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-01 23:02:25.441450 | debian-bookworm -> localhost | changed 2025-11-01 23:02:25.451976 | 2025-11-01 23:02:25.452061 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-01 23:02:25.779337 | debian-bookworm -> localhost | ok 2025-11-01 23:02:25.788525 | 2025-11-01 23:02:25.788652 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-01 23:02:25.826807 | debian-bookworm | ok 2025-11-01 23:02:25.853477 | debian-bookworm | included: /var/lib/zuul/builds/fbda8b98b44d4146bb262fe9e7978ab4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-01 23:02:25.868216 | 2025-11-01 23:02:25.868311 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-01 23:02:27.192819 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-01 23:02:27.193259 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/fbda8b98b44d4146bb262fe9e7978ab4/work/fbda8b98b44d4146bb262fe9e7978ab4_id_rsa 2025-11-01 23:02:27.193322 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/fbda8b98b44d4146bb262fe9e7978ab4/work/fbda8b98b44d4146bb262fe9e7978ab4_id_rsa.pub 2025-11-01 23:02:27.193351 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-01 23:02:27.193398 | debian-bookworm -> localhost | SHA256:nTjMWNWPENLXKJ2dvNXJcJFUklH2iFM/z/yJCNVogL8 zuul-build-sshkey 2025-11-01 23:02:27.193423 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-01 23:02:27.193458 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-01 23:02:27.193480 | debian-bookworm -> localhost | | ooo+ BBOX| 2025-11-01 23:02:27.193502 | debian-bookworm -> localhost | | . o= OoBO+| 2025-11-01 23:02:27.193688 | debian-bookworm -> localhost | | o Bo+.+o| 2025-11-01 23:02:27.193728 | debian-bookworm -> localhost | | = +o...ooo| 2025-11-01 23:02:27.193753 | debian-bookworm -> localhost | | . S.+ +| 2025-11-01 23:02:27.193782 | debian-bookworm -> localhost | | E. . . o| 2025-11-01 23:02:27.193824 | debian-bookworm -> localhost | | . . ..| 2025-11-01 23:02:27.193847 | debian-bookworm -> localhost | | | 2025-11-01 23:02:27.193868 | debian-bookworm -> localhost | | | 2025-11-01 23:02:27.193888 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-01 23:02:27.193941 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.661068 2025-11-01 23:02:27.204203 | 2025-11-01 23:02:27.204316 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-01 23:02:27.222767 | debian-bookworm | ok 2025-11-01 23:02:27.234725 | debian-bookworm | included: /var/lib/zuul/builds/fbda8b98b44d4146bb262fe9e7978ab4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-01 23:02:27.243375 | 2025-11-01 23:02:27.243455 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-01 23:02:27.256067 | debian-bookworm | skipping: Conditional result was False 2025-11-01 23:02:27.261472 | 2025-11-01 23:02:27.261555 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-01 23:02:27.935728 | debian-bookworm | changed 2025-11-01 23:02:27.940845 | 2025-11-01 23:02:27.940929 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-01 23:02:28.180650 | debian-bookworm | ok 2025-11-01 23:02:28.186364 | 2025-11-01 23:02:28.186461 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-01 23:02:28.883436 | debian-bookworm | changed 2025-11-01 23:02:28.892505 | 2025-11-01 23:02:28.892618 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-01 23:02:29.491301 | debian-bookworm | changed 2025-11-01 23:02:29.495725 | 2025-11-01 23:02:29.495803 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-01 23:02:29.510211 | debian-bookworm | skipping: Conditional result was False 2025-11-01 23:02:29.517163 | 2025-11-01 23:02:29.517278 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-01 23:02:29.909420 | debian-bookworm -> localhost | changed 2025-11-01 23:02:29.919598 | 2025-11-01 23:02:29.919691 | TASK [add-build-sshkey : Add back temp key] 2025-11-01 23:02:30.226070 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/fbda8b98b44d4146bb262fe9e7978ab4/work/fbda8b98b44d4146bb262fe9e7978ab4_id_rsa (zuul-build-sshkey) 2025-11-01 23:02:30.226584 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015906 2025-11-01 23:02:30.243620 | 2025-11-01 23:02:30.243710 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-01 23:02:30.615841 | debian-bookworm | ok 2025-11-01 23:02:30.625262 | 2025-11-01 23:02:30.625358 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-01 23:02:30.648296 | debian-bookworm | skipping: Conditional result was False 2025-11-01 23:02:30.658558 | 2025-11-01 23:02:30.658652 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-01 23:02:31.030251 | debian-bookworm | ok 2025-11-01 23:02:31.042448 | 2025-11-01 23:02:31.042559 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-01 23:02:31.081971 | debian-bookworm | ok 2025-11-01 23:02:31.099751 | 2025-11-01 23:02:31.099849 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-01 23:02:31.416228 | debian-bookworm -> localhost | ok 2025-11-01 23:02:31.422299 | 2025-11-01 23:02:31.422387 | TASK [validate-host : Collect information about the host] 2025-11-01 23:02:32.505144 | debian-bookworm | ok 2025-11-01 23:02:32.515897 | 2025-11-01 23:02:32.515986 | TASK [validate-host : Sanitize hostname] 2025-11-01 23:02:32.614935 | debian-bookworm | ok 2025-11-01 23:02:32.655314 | 2025-11-01 23:02:32.655416 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-01 23:02:33.189145 | debian-bookworm -> localhost | changed 2025-11-01 23:02:33.194483 | 2025-11-01 23:02:33.194574 | TASK [validate-host : Collect information about zuul worker] 2025-11-01 23:02:33.600924 | debian-bookworm | ok 2025-11-01 23:02:33.606547 | 2025-11-01 23:02:33.606640 | TASK [validate-host : Write out all zuul information for each host] 2025-11-01 23:02:34.479279 | debian-bookworm -> localhost | changed 2025-11-01 23:02:34.495560 | 2025-11-01 23:02:34.495688 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-01 23:02:34.771607 | debian-bookworm | ok 2025-11-01 23:02:34.777761 | 2025-11-01 23:02:34.777875 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-01 23:02:36.187061 | debian-bookworm | changed: 2025-11-01 23:02:36.187311 | debian-bookworm | cd+++++++++ src/ 2025-11-01 23:02:36.187347 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-01 23:02:36.187371 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-01 23:02:36.187393 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-11-01 23:02:36.187413 | debian-bookworm | Containerfile 2025-11-01 23:02:36.187525 | debian-bookworm | Containerfile 2025-11-01 23:02:36.190655 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007078 2025-11-01 23:03:03.549222 | 2025-11-01 23:03:03.549346 | TASK [upload-logs : Upload logs to log server] 2025-11-01 23:03:04.203460 | localhost | Output suppressed because no_log was given 2025-11-01 23:03:04.205305 | 2025-11-01 23:03:04.205409 | LOOP [upload-logs : Compress console log and json output] 2025-11-01 23:03:04.300006 | localhost | skipping: Conditional result was False 2025-11-01 23:03:04.327075 | localhost | skipping: Conditional result was False 2025-11-01 23:03:04.335334 | 2025-11-01 23:03:04.335456 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-01 23:03:04.543554 | localhost | skipping: Conditional result was False 2025-11-01 23:03:04.543884 | 2025-11-01 23:03:04.554991 | localhost | skipping: Conditional result was False 2025-11-01 23:03:04.566548 | 2025-11-01 23:03:04.566660 | LOOP [upload-logs : Upload console log and json output]