2025-06-10 01:00:45.860813 | Job console starting 2025-06-10 01:00:45.878086 | Updating git repos 2025-06-10 01:00:45.909059 | Cloning repos into workspace 2025-06-10 01:00:45.962673 | Restoring repo states 2025-06-10 01:00:45.972572 | Merging changes 2025-06-10 01:00:46.578407 | Checking out repos 2025-06-10 01:00:46.658490 | Preparing playbooks 2025-06-10 01:00:47.943196 | Running Ansible setup 2025-06-10 01:00:53.747209 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-10 01:00:54.969493 | 2025-06-10 01:00:54.969689 | PLAY [Base pre] 2025-06-10 01:00:55.001468 | 2025-06-10 01:00:55.001645 | TASK [Setup log path fact] 2025-06-10 01:00:55.042461 | debian-bookworm | ok 2025-06-10 01:00:55.091788 | 2025-06-10 01:00:55.091986 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-10 01:00:55.143859 | debian-bookworm | ok 2025-06-10 01:00:55.166896 | 2025-06-10 01:00:55.167059 | TASK [emit-job-header : Print job information] 2025-06-10 01:00:55.245706 | # Job Information 2025-06-10 01:00:55.246876 | Ansible Version: 2.16.14 2025-06-10 01:00:55.246958 | Job: python-black 2025-06-10 01:00:55.246996 | Pipeline: check 2025-06-10 01:00:55.247022 | Executor: 521e9411259a 2025-06-10 01:00:55.247045 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/757 2025-06-10 01:00:55.247069 | Event ID: 5007ba20-4596-11f0-9bb8-67892a72f051 2025-06-10 01:00:55.252268 | 2025-06-10 01:00:55.252396 | LOOP [emit-job-header : Print node information] 2025-06-10 01:00:55.381408 | debian-bookworm | ok: 2025-06-10 01:00:55.381746 | debian-bookworm | # Node Information 2025-06-10 01:00:55.381786 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-10 01:00:55.381810 | debian-bookworm | Hostname: debian 2025-06-10 01:00:55.381831 | debian-bookworm | Username: zuul 2025-06-10 01:00:55.381852 | debian-bookworm | Distro: Debian 12.11 2025-06-10 01:00:55.381882 | debian-bookworm | Provider: regiocloud-a 2025-06-10 01:00:55.381908 | debian-bookworm | Region: 2025-06-10 01:00:55.381930 | debian-bookworm | Label: debian-bookworm 2025-06-10 01:00:55.381949 | debian-bookworm | Product Name: OpenStack Nova 2025-06-10 01:00:55.381969 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe24:8908 2025-06-10 01:00:55.416958 | 2025-06-10 01:00:55.417114 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-10 01:00:56.468598 | debian-bookworm -> localhost | changed 2025-06-10 01:00:56.478794 | 2025-06-10 01:00:56.478956 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-10 01:00:58.713272 | debian-bookworm -> localhost | changed 2025-06-10 01:00:58.724871 | 2025-06-10 01:00:58.725011 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-10 01:00:59.225341 | debian-bookworm -> localhost | ok 2025-06-10 01:00:59.232288 | 2025-06-10 01:00:59.232436 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-10 01:00:59.281985 | debian-bookworm | ok 2025-06-10 01:00:59.318898 | debian-bookworm | included: /var/lib/zuul/builds/e497ac5639274696b1ab65e327a79a35/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-10 01:00:59.336089 | 2025-06-10 01:00:59.336231 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-10 01:01:01.146989 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-10 01:01:01.147445 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/e497ac5639274696b1ab65e327a79a35/work/e497ac5639274696b1ab65e327a79a35_id_rsa 2025-06-10 01:01:01.147493 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/e497ac5639274696b1ab65e327a79a35/work/e497ac5639274696b1ab65e327a79a35_id_rsa.pub 2025-06-10 01:01:01.147521 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-10 01:01:01.147547 | debian-bookworm -> localhost | SHA256:zBGLYixg520ngSaD3cjQcMoj7B6185s+zRMoldU1DSY zuul-build-sshkey 2025-06-10 01:01:01.147570 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-10 01:01:01.147640 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-10 01:01:01.147667 | debian-bookworm -> localhost | |=B.+.. oE.=o | 2025-06-10 01:01:01.147689 | debian-bookworm -> localhost | |=*B+o .o +o .. | 2025-06-10 01:01:01.147710 | debian-bookworm -> localhost | |o+=o+++.o | 2025-06-10 01:01:01.147730 | debian-bookworm -> localhost | |o ooo+oo . | 2025-06-10 01:01:01.147750 | debian-bookworm -> localhost | | o o. . S | 2025-06-10 01:01:01.147778 | debian-bookworm -> localhost | |. ..o. . | 2025-06-10 01:01:01.147809 | debian-bookworm -> localhost | | . ..o . | 2025-06-10 01:01:01.147831 | debian-bookworm -> localhost | | .o+ | 2025-06-10 01:01:01.147853 | debian-bookworm -> localhost | | .+. . | 2025-06-10 01:01:01.147875 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-10 01:01:01.147938 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.741954 2025-06-10 01:01:01.154656 | 2025-06-10 01:01:01.154776 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-10 01:01:01.231890 | debian-bookworm | ok 2025-06-10 01:01:01.249138 | debian-bookworm | included: /var/lib/zuul/builds/e497ac5639274696b1ab65e327a79a35/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-10 01:01:01.266871 | 2025-06-10 01:01:01.266993 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-10 01:01:01.302249 | debian-bookworm | skipping: Conditional result was False 2025-06-10 01:01:01.308536 | 2025-06-10 01:01:01.308669 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-10 01:01:02.140649 | debian-bookworm | changed 2025-06-10 01:01:02.154218 | 2025-06-10 01:01:02.154338 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-10 01:01:02.435650 | debian-bookworm | ok 2025-06-10 01:01:02.444773 | 2025-06-10 01:01:02.444958 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-10 01:01:03.181474 | debian-bookworm | changed 2025-06-10 01:01:03.188898 | 2025-06-10 01:01:03.189025 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-10 01:01:03.834191 | debian-bookworm | changed 2025-06-10 01:01:03.848959 | 2025-06-10 01:01:03.849152 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-10 01:01:03.884795 | debian-bookworm | skipping: Conditional result was False 2025-06-10 01:01:03.899272 | 2025-06-10 01:01:03.899467 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-10 01:01:04.465215 | debian-bookworm -> localhost | changed 2025-06-10 01:01:04.478456 | 2025-06-10 01:01:04.478640 | TASK [add-build-sshkey : Add back temp key] 2025-06-10 01:01:05.001977 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/e497ac5639274696b1ab65e327a79a35/work/e497ac5639274696b1ab65e327a79a35_id_rsa (zuul-build-sshkey) 2025-06-10 01:01:05.002250 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.020231 2025-06-10 01:01:05.012089 | 2025-06-10 01:01:05.012239 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-10 01:01:05.437712 | debian-bookworm | ok 2025-06-10 01:01:05.445240 | 2025-06-10 01:01:05.445382 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-10 01:01:05.494782 | debian-bookworm | skipping: Conditional result was False 2025-06-10 01:01:05.516860 | 2025-06-10 01:01:05.517039 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-10 01:01:06.031626 | debian-bookworm | ok 2025-06-10 01:01:06.054796 | 2025-06-10 01:01:06.063962 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-10 01:01:06.123813 | debian-bookworm | ok 2025-06-10 01:01:06.129228 | 2025-06-10 01:01:06.129343 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-10 01:01:06.648130 | debian-bookworm -> localhost | ok 2025-06-10 01:01:06.656510 | 2025-06-10 01:01:06.656740 | TASK [validate-host : Collect information about the host] 2025-06-10 01:01:08.060819 | debian-bookworm | ok 2025-06-10 01:01:08.073521 | 2025-06-10 01:01:08.073663 | TASK [validate-host : Sanitize hostname] 2025-06-10 01:01:08.194827 | debian-bookworm | ok 2025-06-10 01:01:08.244077 | 2025-06-10 01:01:08.244214 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-10 01:01:09.008385 | debian-bookworm -> localhost | changed 2025-06-10 01:01:09.017909 | 2025-06-10 01:01:09.018064 | TASK [validate-host : Collect information about zuul worker] 2025-06-10 01:01:09.514200 | debian-bookworm | ok 2025-06-10 01:01:09.521189 | 2025-06-10 01:01:09.521320 | TASK [validate-host : Write out all zuul information for each host] 2025-06-10 01:01:10.405983 | debian-bookworm -> localhost | changed 2025-06-10 01:01:10.416983 | 2025-06-10 01:01:10.417103 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-10 01:01:10.710524 | debian-bookworm | ok 2025-06-10 01:01:10.716173 | 2025-06-10 01:01:10.716268 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-10 01:01:11.681522 | debian-bookworm | changed: 2025-06-10 01:01:11.681723 | debian-bookworm | cd+++++++++ src/ 2025-06-10 01:01:11.681760 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-10 01:01:11.681784 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-10 01:01:11.681805 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-06-10 01:01:11.681826 | debian-bookworm | Containerfile 2025-06-10 01:01:11.681966 | debian-bookworm | localhost | ok: Runtime: 0:00:00.021114 2025-06-10 01:01:41.525978 | 2025-06-10 01:01:41.526099 | TASK [upload-logs : Upload logs to log server] 2025-06-10 01:01:42.841442 | localhost | Output suppressed because no_log was given 2025-06-10 01:01:42.843663 | 2025-06-10 01:01:42.843773 | LOOP [upload-logs : Compress console log and json output] 2025-06-10 01:01:42.894982 | localhost | skipping: Conditional result was False 2025-06-10 01:01:42.901098 | localhost | skipping: Conditional result was False 2025-06-10 01:01:42.910707 | 2025-06-10 01:01:42.910864 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-10 01:01:42.963130 | localhost | skipping: Conditional result was False 2025-06-10 01:01:42.963455 | 2025-06-10 01:01:42.968522 | localhost | skipping: Conditional result was False 2025-06-10 01:01:42.977345 | 2025-06-10 01:01:42.977482 | LOOP [upload-logs : Upload console log and json output]