2025-05-27 07:51:04.153988 | Job console starting 2025-05-27 07:51:04.185814 | Updating git repos 2025-05-27 07:51:04.225431 | Cloning repos into workspace 2025-05-27 07:51:04.324687 | Restoring repo states 2025-05-27 07:51:04.331121 | Merging changes 2025-05-27 07:51:04.892818 | Checking out repos 2025-05-27 07:51:04.978865 | Preparing playbooks 2025-05-27 07:51:05.790744 | Running Ansible setup 2025-05-27 07:51:10.325434 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-27 07:51:11.147855 | 2025-05-27 07:51:11.148039 | PLAY [Base pre] 2025-05-27 07:51:11.168921 | 2025-05-27 07:51:11.169085 | TASK [Setup log path fact] 2025-05-27 07:51:11.193135 | debian-bookworm | ok 2025-05-27 07:51:11.216106 | 2025-05-27 07:51:11.216310 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-27 07:51:11.248278 | debian-bookworm | ok 2025-05-27 07:51:11.262326 | 2025-05-27 07:51:11.262479 | TASK [emit-job-header : Print job information] 2025-05-27 07:51:11.313826 | # Job Information 2025-05-27 07:51:11.314054 | Ansible Version: 2.16.14 2025-05-27 07:51:11.314092 | Job: python-black 2025-05-27 07:51:11.314124 | Pipeline: check 2025-05-27 07:51:11.314147 | Executor: 521e9411259a 2025-05-27 07:51:11.314167 | Triggered by: https://github.com/osism/testbed/pull/2707 2025-05-27 07:51:11.314188 | Event ID: 51e44100-3acf-11f0-83fe-5a1b99080328 2025-05-27 07:51:11.322792 | 2025-05-27 07:51:11.323176 | LOOP [emit-job-header : Print node information] 2025-05-27 07:51:11.443267 | debian-bookworm | ok: 2025-05-27 07:51:11.444038 | debian-bookworm | # Node Information 2025-05-27 07:51:11.444092 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-05-27 07:51:11.444118 | debian-bookworm | Hostname: debian 2025-05-27 07:51:11.444140 | debian-bookworm | Username: zuul 2025-05-27 07:51:11.444161 | debian-bookworm | Distro: Debian 12.11 2025-05-27 07:51:11.444185 | debian-bookworm | Provider: regiocloud-a 2025-05-27 07:51:11.444206 | debian-bookworm | Region: 2025-05-27 07:51:11.444245 | debian-bookworm | Label: debian-bookworm 2025-05-27 07:51:11.444266 | debian-bookworm | Product Name: OpenStack Nova 2025-05-27 07:51:11.444286 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feed:d17d 2025-05-27 07:51:11.461910 | 2025-05-27 07:51:11.462049 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-27 07:51:12.025846 | debian-bookworm -> localhost | changed 2025-05-27 07:51:12.033598 | 2025-05-27 07:51:12.033753 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-27 07:51:13.240397 | debian-bookworm -> localhost | changed 2025-05-27 07:51:13.253656 | 2025-05-27 07:51:13.253879 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-27 07:51:13.558267 | debian-bookworm -> localhost | ok 2025-05-27 07:51:13.567545 | 2025-05-27 07:51:13.567694 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-27 07:51:13.596498 | debian-bookworm | ok 2025-05-27 07:51:13.614990 | debian-bookworm | included: /var/lib/zuul/builds/0721ca8e88ec4edb8a063fa9bb6e50cd/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-27 07:51:13.621717 | 2025-05-27 07:51:13.621828 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-27 07:51:14.616125 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-05-27 07:51:14.616432 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/0721ca8e88ec4edb8a063fa9bb6e50cd/work/0721ca8e88ec4edb8a063fa9bb6e50cd_id_rsa 2025-05-27 07:51:14.616472 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/0721ca8e88ec4edb8a063fa9bb6e50cd/work/0721ca8e88ec4edb8a063fa9bb6e50cd_id_rsa.pub 2025-05-27 07:51:14.616498 | debian-bookworm -> localhost | The key fingerprint is: 2025-05-27 07:51:14.616524 | debian-bookworm -> localhost | SHA256:EsLLfNqVicMoTJ8HkeqxWy3t2pjcBUF8mQ44ztsJMKs zuul-build-sshkey 2025-05-27 07:51:14.616546 | debian-bookworm -> localhost | The key's randomart image is: 2025-05-27 07:51:14.616583 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-05-27 07:51:14.616605 | debian-bookworm -> localhost | | .+. o | 2025-05-27 07:51:14.616626 | debian-bookworm -> localhost | | o.+oo + | 2025-05-27 07:51:14.616646 | debian-bookworm -> localhost | | .B+.o+ | 2025-05-27 07:51:14.616665 | debian-bookworm -> localhost | | o+++B +.o | 2025-05-27 07:51:14.616686 | debian-bookworm -> localhost | | oooB*O.S | 2025-05-27 07:51:14.616711 | debian-bookworm -> localhost | |E o.+=== | 2025-05-27 07:51:14.616731 | debian-bookworm -> localhost | | o.o. . | 2025-05-27 07:51:14.616751 | debian-bookworm -> localhost | | .. =.. | 2025-05-27 07:51:14.616772 | debian-bookworm -> localhost | | =.o | 2025-05-27 07:51:14.616793 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-05-27 07:51:14.616847 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.441367 2025-05-27 07:51:14.623658 | 2025-05-27 07:51:14.623792 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-27 07:51:14.652901 | debian-bookworm | ok 2025-05-27 07:51:14.662759 | debian-bookworm | included: /var/lib/zuul/builds/0721ca8e88ec4edb8a063fa9bb6e50cd/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-27 07:51:14.672285 | 2025-05-27 07:51:14.672393 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-27 07:51:14.696870 | debian-bookworm | skipping: Conditional result was False 2025-05-27 07:51:14.702739 | 2025-05-27 07:51:14.702884 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-27 07:51:15.380896 | debian-bookworm | changed 2025-05-27 07:51:15.388670 | 2025-05-27 07:51:15.388793 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-27 07:51:15.703030 | debian-bookworm | ok 2025-05-27 07:51:15.719248 | 2025-05-27 07:51:15.719419 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-27 07:51:16.413189 | debian-bookworm | changed 2025-05-27 07:51:16.422266 | 2025-05-27 07:51:16.422404 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-27 07:51:17.130585 | debian-bookworm | changed 2025-05-27 07:51:17.138962 | 2025-05-27 07:51:17.139135 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-27 07:51:17.174632 | debian-bookworm | skipping: Conditional result was False 2025-05-27 07:51:17.182432 | 2025-05-27 07:51:17.182561 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-27 07:51:17.724561 | debian-bookworm -> localhost | changed 2025-05-27 07:51:17.737944 | 2025-05-27 07:51:17.738097 | TASK [add-build-sshkey : Add back temp key] 2025-05-27 07:51:18.088750 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/0721ca8e88ec4edb8a063fa9bb6e50cd/work/0721ca8e88ec4edb8a063fa9bb6e50cd_id_rsa (zuul-build-sshkey) 2025-05-27 07:51:18.089090 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011205 2025-05-27 07:51:18.097876 | 2025-05-27 07:51:18.098003 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-27 07:51:18.533897 | debian-bookworm | ok 2025-05-27 07:51:18.539366 | 2025-05-27 07:51:18.539498 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-27 07:51:18.563852 | debian-bookworm | skipping: Conditional result was False 2025-05-27 07:51:18.575248 | 2025-05-27 07:51:18.575404 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-27 07:51:19.030949 | debian-bookworm | ok 2025-05-27 07:51:19.043794 | 2025-05-27 07:51:19.043989 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-27 07:51:19.085898 | debian-bookworm | ok 2025-05-27 07:51:19.092145 | 2025-05-27 07:51:19.092293 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-27 07:51:19.431894 | debian-bookworm -> localhost | ok 2025-05-27 07:51:19.444387 | 2025-05-27 07:51:19.444569 | TASK [validate-host : Collect information about the host] 2025-05-27 07:51:20.652451 | debian-bookworm | ok 2025-05-27 07:51:20.667884 | 2025-05-27 07:51:20.668038 | TASK [validate-host : Sanitize hostname] 2025-05-27 07:51:20.807875 | debian-bookworm | ok 2025-05-27 07:51:20.860374 | 2025-05-27 07:51:20.860539 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-27 07:51:21.482663 | debian-bookworm -> localhost | changed 2025-05-27 07:51:21.488965 | 2025-05-27 07:51:21.489091 | TASK [validate-host : Collect information about zuul worker] 2025-05-27 07:51:21.893031 | debian-bookworm | ok 2025-05-27 07:51:21.900397 | 2025-05-27 07:51:21.900546 | TASK [validate-host : Write out all zuul information for each host] 2025-05-27 07:51:22.556636 | debian-bookworm -> localhost | changed 2025-05-27 07:51:22.572687 | 2025-05-27 07:51:22.572852 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-27 07:51:22.848820 | debian-bookworm | ok 2025-05-27 07:51:22.855640 | 2025-05-27 07:51:22.855762 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-27 07:51:24.027380 | debian-bookworm | changed: 2025-05-27 07:51:24.027743 | debian-bookworm | cd+++++++++ src/ 2025-05-27 07:51:24.027834 | debian-bookworm | cd+++++++++ src/github.com/ 2025-05-27 07:51:24.027900 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-05-27 07:51:24.027949 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-05-27 07:51:24.027998 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007397 2025-05-27 07:51:50.419317 | 2025-05-27 07:51:50.419564 | TASK [upload-logs : Upload logs to log server] 2025-05-27 07:51:51.029109 | localhost | Output suppressed because no_log was given 2025-05-27 07:51:51.031366 | 2025-05-27 07:51:51.031492 | LOOP [upload-logs : Compress console log and json output] 2025-05-27 07:51:51.098739 | localhost | skipping: Conditional result was False 2025-05-27 07:51:51.111033 | localhost | skipping: Conditional result was False 2025-05-27 07:51:51.124745 | 2025-05-27 07:51:51.125009 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-27 07:51:51.185394 | localhost | skipping: Conditional result was False 2025-05-27 07:51:51.185705 | 2025-05-27 07:51:51.195182 | localhost | skipping: Conditional result was False 2025-05-27 07:51:51.207013 | 2025-05-27 07:51:51.207186 | LOOP [upload-logs : Upload console log and json output]