2025-12-05 21:03:48.823917 | Job console starting 2025-12-05 21:03:48.841725 | Updating git repos 2025-12-05 21:03:48.874510 | Cloning repos into workspace 2025-12-05 21:03:48.962256 | Restoring repo states 2025-12-05 21:03:48.968014 | Merging changes 2025-12-05 21:03:49.480097 | Checking out repos 2025-12-05 21:03:49.522629 | Preparing playbooks 2025-12-05 21:03:50.439977 | Running Ansible setup 2025-12-05 21:03:55.220842 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-05 21:03:56.086689 | 2025-12-05 21:03:56.086918 | PLAY [Base pre] 2025-12-05 21:03:56.105786 | 2025-12-05 21:03:56.105944 | TASK [Setup log path fact] 2025-12-05 21:03:56.136249 | debian-bookworm | ok 2025-12-05 21:03:56.152629 | 2025-12-05 21:03:56.152805 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-05 21:03:56.196469 | debian-bookworm | ok 2025-12-05 21:03:56.228989 | 2025-12-05 21:03:56.229141 | TASK [emit-job-header : Print job information] 2025-12-05 21:03:56.280686 | # Job Information 2025-12-05 21:03:56.280882 | Ansible Version: 2.16.14 2025-12-05 21:03:56.280919 | Job: python-black 2025-12-05 21:03:56.280952 | Pipeline: check 2025-12-05 21:03:56.280976 | Executor: 521e9411259a 2025-12-05 21:03:56.280998 | Triggered by: https://github.com/osism/testbed/pull/2797 2025-12-05 21:03:56.281021 | Event ID: e0337a80-d21d-11f0-9bba-379666b84464 2025-12-05 21:03:56.286681 | 2025-12-05 21:03:56.286825 | LOOP [emit-job-header : Print node information] 2025-12-05 21:03:56.438312 | debian-bookworm | ok: 2025-12-05 21:03:56.439354 | debian-bookworm | # Node Information 2025-12-05 21:03:56.439479 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-05 21:03:56.439511 | debian-bookworm | Hostname: debian 2025-12-05 21:03:56.439536 | debian-bookworm | Username: zuul 2025-12-05 21:03:56.439559 | debian-bookworm | Distro: Debian 12.12 2025-12-05 21:03:56.439584 | debian-bookworm | Provider: regiocloud-a 2025-12-05 21:03:56.439605 | debian-bookworm | Region: 2025-12-05 21:03:56.439626 | debian-bookworm | Label: debian-bookworm 2025-12-05 21:03:56.439646 | debian-bookworm | Product Name: OpenStack Nova 2025-12-05 21:03:56.439666 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fea5:a3ec 2025-12-05 21:03:56.459978 | 2025-12-05 21:03:56.460131 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-05 21:03:56.983989 | debian-bookworm -> localhost | changed 2025-12-05 21:03:56.992621 | 2025-12-05 21:03:56.992769 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-05 21:03:58.140245 | debian-bookworm -> localhost | changed 2025-12-05 21:03:58.152491 | 2025-12-05 21:03:58.152639 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-05 21:03:58.444849 | debian-bookworm -> localhost | ok 2025-12-05 21:03:58.460645 | 2025-12-05 21:03:58.460792 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-05 21:03:58.493732 | debian-bookworm | ok 2025-12-05 21:03:58.522558 | debian-bookworm | included: /var/lib/zuul/builds/3c41cae3d61f4e0e891e8863d5b428b6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-05 21:03:58.528890 | 2025-12-05 21:03:58.529010 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-05 21:03:59.871494 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-05 21:03:59.871861 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/3c41cae3d61f4e0e891e8863d5b428b6/work/3c41cae3d61f4e0e891e8863d5b428b6_id_rsa 2025-12-05 21:03:59.871914 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/3c41cae3d61f4e0e891e8863d5b428b6/work/3c41cae3d61f4e0e891e8863d5b428b6_id_rsa.pub 2025-12-05 21:03:59.871955 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-05 21:03:59.871993 | debian-bookworm -> localhost | SHA256:NEXwiv+nQ/s3PYAG0eu7MG1hY84XkhxZCxT5x3hD3ZI zuul-build-sshkey 2025-12-05 21:03:59.872028 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-05 21:03:59.872077 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-05 21:03:59.872110 | debian-bookworm -> localhost | | .o=+o. .o| 2025-12-05 21:03:59.872142 | debian-bookworm -> localhost | | + o+ E.o| 2025-12-05 21:03:59.872163 | debian-bookworm -> localhost | | o ooo.+. | 2025-12-05 21:03:59.872184 | debian-bookworm -> localhost | | o +..oo = | 2025-12-05 21:03:59.872204 | debian-bookworm -> localhost | | . S oO..o .| 2025-12-05 21:03:59.872234 | debian-bookworm -> localhost | | . B++.. | 2025-12-05 21:03:59.872254 | debian-bookworm -> localhost | | .+.*.... | 2025-12-05 21:03:59.872275 | debian-bookworm -> localhost | | .*.o o..| 2025-12-05 21:03:59.872295 | debian-bookworm -> localhost | | o*o. ..| 2025-12-05 21:03:59.872316 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-05 21:03:59.872423 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.835992 2025-12-05 21:03:59.879818 | 2025-12-05 21:03:59.879947 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-05 21:03:59.932962 | debian-bookworm | ok 2025-12-05 21:03:59.960147 | debian-bookworm | included: /var/lib/zuul/builds/3c41cae3d61f4e0e891e8863d5b428b6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-05 21:03:59.975569 | 2025-12-05 21:03:59.975742 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-05 21:04:00.010532 | debian-bookworm | skipping: Conditional result was False 2025-12-05 21:04:00.018268 | 2025-12-05 21:04:00.018417 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-05 21:04:00.631313 | debian-bookworm | changed 2025-12-05 21:04:00.645025 | 2025-12-05 21:04:00.645325 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-05 21:04:00.910331 | debian-bookworm | ok 2025-12-05 21:04:00.921756 | 2025-12-05 21:04:00.921949 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-05 21:04:01.558536 | debian-bookworm | changed 2025-12-05 21:04:01.571729 | 2025-12-05 21:04:01.572058 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-05 21:04:02.230544 | debian-bookworm | changed 2025-12-05 21:04:02.242461 | 2025-12-05 21:04:02.242613 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-05 21:04:02.278028 | debian-bookworm | skipping: Conditional result was False 2025-12-05 21:04:02.294595 | 2025-12-05 21:04:02.294747 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-05 21:04:02.778266 | debian-bookworm -> localhost | changed 2025-12-05 21:04:02.790059 | 2025-12-05 21:04:02.790206 | TASK [add-build-sshkey : Add back temp key] 2025-12-05 21:04:03.206616 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/3c41cae3d61f4e0e891e8863d5b428b6/work/3c41cae3d61f4e0e891e8863d5b428b6_id_rsa (zuul-build-sshkey) 2025-12-05 21:04:03.206970 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019196 2025-12-05 21:04:03.216723 | 2025-12-05 21:04:03.216857 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-05 21:04:03.662552 | debian-bookworm | ok 2025-12-05 21:04:03.671357 | 2025-12-05 21:04:03.671552 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-05 21:04:03.706679 | debian-bookworm | skipping: Conditional result was False 2025-12-05 21:04:03.720655 | 2025-12-05 21:04:03.720800 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-05 21:04:04.169860 | debian-bookworm | ok 2025-12-05 21:04:04.182676 | 2025-12-05 21:04:04.182867 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-05 21:04:04.224880 | debian-bookworm | ok 2025-12-05 21:04:04.231535 | 2025-12-05 21:04:04.231663 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-05 21:04:04.596040 | debian-bookworm -> localhost | ok 2025-12-05 21:04:04.606583 | 2025-12-05 21:04:04.606723 | TASK [validate-host : Collect information about the host] 2025-12-05 21:04:05.775317 | debian-bookworm | ok 2025-12-05 21:04:05.804067 | 2025-12-05 21:04:05.804266 | TASK [validate-host : Sanitize hostname] 2025-12-05 21:04:05.928594 | debian-bookworm | ok 2025-12-05 21:04:05.973658 | 2025-12-05 21:04:05.973828 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-05 21:04:06.563612 | debian-bookworm -> localhost | changed 2025-12-05 21:04:06.570064 | 2025-12-05 21:04:06.570197 | TASK [validate-host : Collect information about zuul worker] 2025-12-05 21:04:07.000772 | debian-bookworm | ok 2025-12-05 21:04:07.010404 | 2025-12-05 21:04:07.010610 | TASK [validate-host : Write out all zuul information for each host] 2025-12-05 21:04:07.635143 | debian-bookworm -> localhost | changed 2025-12-05 21:04:07.647731 | 2025-12-05 21:04:07.647877 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-05 21:04:07.940273 | debian-bookworm | ok 2025-12-05 21:04:07.946078 | 2025-12-05 21:04:07.946202 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-05 21:04:09.045557 | debian-bookworm | changed: 2025-12-05 21:04:09.045863 | debian-bookworm | cd+++++++++ src/ 2025-12-05 21:04:09.045907 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-05 21:04:09.045936 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-05 21:04:09.045969 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-12-05 21:04:09.046002 | debian-bookworm | localhost | ok: Runtime: 0:00:00.011859 2025-12-05 21:04:34.382328 | 2025-12-05 21:04:34.382589 | TASK [upload-logs : Upload logs to log server] 2025-12-05 21:04:34.959675 | localhost | Output suppressed because no_log was given 2025-12-05 21:04:34.961887 | 2025-12-05 21:04:34.962015 | LOOP [upload-logs : Compress console log and json output] 2025-12-05 21:04:35.012728 | localhost | skipping: Conditional result was False 2025-12-05 21:04:35.019306 | localhost | skipping: Conditional result was False 2025-12-05 21:04:35.029169 | 2025-12-05 21:04:35.029303 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-05 21:04:35.079656 | localhost | skipping: Conditional result was False 2025-12-05 21:04:35.079972 | 2025-12-05 21:04:35.085181 | localhost | skipping: Conditional result was False 2025-12-05 21:04:35.096096 | 2025-12-05 21:04:35.096224 | LOOP [upload-logs : Upload console log and json output]