2025-10-15 07:05:49.404306 | Job console starting 2025-10-15 07:05:49.434680 | Updating git repos 2025-10-15 07:05:49.467214 | Cloning repos into workspace 2025-10-15 07:05:49.539311 | Restoring repo states 2025-10-15 07:05:49.547877 | Merging changes 2025-10-15 07:05:50.107588 | Checking out repos 2025-10-15 07:05:50.181478 | Preparing playbooks 2025-10-15 07:05:51.001707 | Running Ansible setup 2025-10-15 07:05:55.792805 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-15 07:05:56.616569 | 2025-10-15 07:05:56.616727 | PLAY [Base pre] 2025-10-15 07:05:56.632871 | 2025-10-15 07:05:56.633013 | TASK [Setup log path fact] 2025-10-15 07:05:56.662256 | debian-bookworm | ok 2025-10-15 07:05:56.677529 | 2025-10-15 07:05:56.677679 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-15 07:05:56.720603 | debian-bookworm | ok 2025-10-15 07:05:56.731036 | 2025-10-15 07:05:56.731191 | TASK [emit-job-header : Print job information] 2025-10-15 07:05:56.770592 | # Job Information 2025-10-15 07:05:56.770785 | Ansible Version: 2.16.14 2025-10-15 07:05:56.770821 | Job: python-black 2025-10-15 07:05:56.770902 | Pipeline: check 2025-10-15 07:05:56.770926 | Executor: 521e9411259a 2025-10-15 07:05:56.770948 | Triggered by: https://github.com/osism/openstack-image-manager/pull/960 2025-10-15 07:05:56.770971 | Event ID: 5b1eece0-a995-11f0-9cf8-1b93776a7a2d 2025-10-15 07:05:56.776145 | 2025-10-15 07:05:56.776264 | LOOP [emit-job-header : Print node information] 2025-10-15 07:05:56.883671 | debian-bookworm | ok: 2025-10-15 07:05:56.883936 | debian-bookworm | # Node Information 2025-10-15 07:05:56.883972 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-15 07:05:56.883996 | debian-bookworm | Hostname: debian 2025-10-15 07:05:56.884017 | debian-bookworm | Username: zuul 2025-10-15 07:05:56.884038 | debian-bookworm | Distro: Debian 12.12 2025-10-15 07:05:56.884109 | debian-bookworm | Provider: regiocloud-a 2025-10-15 07:05:56.884131 | debian-bookworm | Region: 2025-10-15 07:05:56.884152 | debian-bookworm | Label: debian-bookworm 2025-10-15 07:05:56.884171 | debian-bookworm | Product Name: OpenStack Nova 2025-10-15 07:05:56.884190 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe21:fbe8 2025-10-15 07:05:56.900670 | 2025-10-15 07:05:56.900792 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-15 07:05:57.369959 | debian-bookworm -> localhost | changed 2025-10-15 07:05:57.375581 | 2025-10-15 07:05:57.375666 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-15 07:05:58.374285 | debian-bookworm -> localhost | changed 2025-10-15 07:05:58.382789 | 2025-10-15 07:05:58.382899 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-15 07:05:58.809130 | debian-bookworm -> localhost | ok 2025-10-15 07:05:58.813931 | 2025-10-15 07:05:58.814016 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-15 07:05:58.830097 | debian-bookworm | ok 2025-10-15 07:05:58.843160 | debian-bookworm | included: /var/lib/zuul/builds/a6fd207fa6724d2e921f35e46b2a28e6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-15 07:05:58.847845 | 2025-10-15 07:05:58.847912 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-15 07:05:59.721435 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-15 07:05:59.721823 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/a6fd207fa6724d2e921f35e46b2a28e6/work/a6fd207fa6724d2e921f35e46b2a28e6_id_rsa 2025-10-15 07:05:59.721905 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/a6fd207fa6724d2e921f35e46b2a28e6/work/a6fd207fa6724d2e921f35e46b2a28e6_id_rsa.pub 2025-10-15 07:05:59.721963 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-15 07:05:59.722014 | debian-bookworm -> localhost | SHA256:R9asdV2o9dM+yB/3bxhmX8MQdgam+i+7U4A2gkvFhI4 zuul-build-sshkey 2025-10-15 07:05:59.722111 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-15 07:05:59.722176 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-15 07:05:59.722224 | debian-bookworm -> localhost | | +. o...| 2025-10-15 07:05:59.722265 | debian-bookworm -> localhost | | . o oooo+.| 2025-10-15 07:05:59.722301 | debian-bookworm -> localhost | | o o +.=o=.o| 2025-10-15 07:05:59.722337 | debian-bookworm -> localhost | | E + . *.+.o .o| 2025-10-15 07:05:59.722372 | debian-bookworm -> localhost | | . . S.+ o +..| 2025-10-15 07:05:59.722414 | debian-bookworm -> localhost | | . .. ++=+| 2025-10-15 07:05:59.722451 | debian-bookworm -> localhost | | ..o.+B| 2025-10-15 07:05:59.722485 | debian-bookworm -> localhost | | o. ..+| 2025-10-15 07:05:59.722522 | debian-bookworm -> localhost | | o=. .o| 2025-10-15 07:05:59.722557 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-15 07:05:59.722645 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.490034 2025-10-15 07:05:59.733278 | 2025-10-15 07:05:59.733383 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-15 07:05:59.760820 | debian-bookworm | ok 2025-10-15 07:05:59.772499 | debian-bookworm | included: /var/lib/zuul/builds/a6fd207fa6724d2e921f35e46b2a28e6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-15 07:05:59.791255 | 2025-10-15 07:05:59.791334 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-15 07:05:59.803815 | debian-bookworm | skipping: Conditional result was False 2025-10-15 07:05:59.809427 | 2025-10-15 07:05:59.809524 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-15 07:06:00.453211 | debian-bookworm | changed 2025-10-15 07:06:00.458419 | 2025-10-15 07:06:00.458508 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-15 07:06:00.738011 | debian-bookworm | ok 2025-10-15 07:06:00.745577 | 2025-10-15 07:06:00.745689 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-15 07:06:01.404956 | debian-bookworm | changed 2025-10-15 07:06:01.410283 | 2025-10-15 07:06:01.410358 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-15 07:06:02.006923 | debian-bookworm | changed 2025-10-15 07:06:02.012280 | 2025-10-15 07:06:02.012372 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-15 07:06:02.035347 | debian-bookworm | skipping: Conditional result was False 2025-10-15 07:06:02.042237 | 2025-10-15 07:06:02.042329 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-15 07:06:02.433623 | debian-bookworm -> localhost | changed 2025-10-15 07:06:02.443914 | 2025-10-15 07:06:02.444001 | TASK [add-build-sshkey : Add back temp key] 2025-10-15 07:06:02.761114 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/a6fd207fa6724d2e921f35e46b2a28e6/work/a6fd207fa6724d2e921f35e46b2a28e6_id_rsa (zuul-build-sshkey) 2025-10-15 07:06:02.761329 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.016039 2025-10-15 07:06:02.769038 | 2025-10-15 07:06:02.769150 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-15 07:06:03.143954 | debian-bookworm | ok 2025-10-15 07:06:03.148838 | 2025-10-15 07:06:03.148924 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-15 07:06:03.171823 | debian-bookworm | skipping: Conditional result was False 2025-10-15 07:06:03.181960 | 2025-10-15 07:06:03.182068 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-15 07:06:03.573892 | debian-bookworm | ok 2025-10-15 07:06:03.584092 | 2025-10-15 07:06:03.584182 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-15 07:06:03.611434 | debian-bookworm | ok 2025-10-15 07:06:03.616253 | 2025-10-15 07:06:03.616339 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-15 07:06:03.851803 | debian-bookworm -> localhost | ok 2025-10-15 07:06:03.857748 | 2025-10-15 07:06:03.857830 | TASK [validate-host : Collect information about the host] 2025-10-15 07:06:05.939250 | debian-bookworm | ok 2025-10-15 07:06:05.948951 | 2025-10-15 07:06:05.949053 | TASK [validate-host : Sanitize hostname] 2025-10-15 07:06:06.037408 | debian-bookworm | ok 2025-10-15 07:06:06.065446 | 2025-10-15 07:06:06.065546 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-15 07:06:06.542735 | debian-bookworm -> localhost | changed 2025-10-15 07:06:06.548082 | 2025-10-15 07:06:06.548167 | TASK [validate-host : Collect information about zuul worker] 2025-10-15 07:06:06.971366 | debian-bookworm | ok 2025-10-15 07:06:06.977346 | 2025-10-15 07:06:06.977449 | TASK [validate-host : Write out all zuul information for each host] 2025-10-15 07:06:07.466951 | debian-bookworm -> localhost | changed 2025-10-15 07:06:07.475758 | 2025-10-15 07:06:07.475847 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-15 07:06:07.734872 | debian-bookworm | ok 2025-10-15 07:06:07.739929 | 2025-10-15 07:06:07.740011 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-15 07:06:08.646295 | debian-bookworm | changed: 2025-10-15 07:06:08.646473 | debian-bookworm | cd+++++++++ src/ 2025-10-15 07:06:08.646507 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-15 07:06:08.646533 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-15 07:06:08.646555 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-10-15 07:06:08.646576 | debian-bookworm | localhost | ok: Runtime: 0:00:00.003927 2025-10-15 07:06:34.013474 | 2025-10-15 07:06:34.013589 | TASK [upload-logs : Upload logs to log server] 2025-10-15 07:06:34.608615 | localhost | Output suppressed because no_log was given 2025-10-15 07:06:34.610622 | 2025-10-15 07:06:34.610739 | LOOP [upload-logs : Compress console log and json output] 2025-10-15 07:06:34.676400 | localhost | skipping: Conditional result was False 2025-10-15 07:06:34.684442 | localhost | skipping: Conditional result was False 2025-10-15 07:06:34.691022 | 2025-10-15 07:06:34.691177 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-15 07:06:34.738246 | localhost | skipping: Conditional result was False 2025-10-15 07:06:34.738512 | 2025-10-15 07:06:34.743405 | localhost | skipping: Conditional result was False 2025-10-15 07:06:34.748838 | 2025-10-15 07:06:34.748959 | LOOP [upload-logs : Upload console log and json output]