2025-07-29 03:01:03.267902 | Job console starting 2025-07-29 03:01:03.285891 | Updating git repos 2025-07-29 03:01:03.561105 | Cloning repos into workspace 2025-07-29 03:01:03.716340 | Restoring repo states 2025-07-29 03:01:03.731516 | Merging changes 2025-07-29 03:01:03.731538 | Checking out repos 2025-07-29 03:01:03.867399 | Preparing playbooks 2025-07-29 03:01:05.921038 | Running Ansible setup 2025-07-29 03:01:15.965398 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-07-29 03:01:17.580250 | 2025-07-29 03:01:17.580365 | PLAY [Base pre] 2025-07-29 03:01:17.612916 | 2025-07-29 03:01:17.613025 | TASK [Setup log path fact] 2025-07-29 03:01:17.640738 | debian-bookworm | ok 2025-07-29 03:01:17.665747 | 2025-07-29 03:01:17.665869 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-07-29 03:01:17.703833 | debian-bookworm | ok 2025-07-29 03:01:17.715692 | 2025-07-29 03:01:17.715797 | TASK [emit-job-header : Print job information] 2025-07-29 03:01:17.764786 | # Job Information 2025-07-29 03:01:17.764927 | Ansible Version: 2.16.14 2025-07-29 03:01:17.764956 | Job: python-black 2025-07-29 03:01:17.764983 | Pipeline: periodic-daily 2025-07-29 03:01:17.765002 | Executor: 521e9411259a 2025-07-29 03:01:17.765019 | Triggered by: https://github.com/osism/ansible-collection-services 2025-07-29 03:01:17.765093 | Event ID: 303d38b7f74a49738ba1de611d42aa02 2025-07-29 03:01:17.768997 | 2025-07-29 03:01:17.769077 | LOOP [emit-job-header : Print node information] 2025-07-29 03:01:18.054108 | debian-bookworm | ok: 2025-07-29 03:01:18.054295 | debian-bookworm | # Node Information 2025-07-29 03:01:18.054354 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-07-29 03:01:18.054379 | debian-bookworm | Hostname: debian 2025-07-29 03:01:18.054398 | debian-bookworm | Username: zuul 2025-07-29 03:01:18.054434 | debian-bookworm | Distro: Debian 12.11 2025-07-29 03:01:18.054458 | debian-bookworm | Provider: regiocloud-a 2025-07-29 03:01:18.054476 | debian-bookworm | Region: 2025-07-29 03:01:18.054494 | debian-bookworm | Label: debian-bookworm 2025-07-29 03:01:18.054510 | debian-bookworm | Product Name: OpenStack Nova 2025-07-29 03:01:18.054526 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec1:247b 2025-07-29 03:01:18.072934 | 2025-07-29 03:01:18.073031 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-07-29 03:01:19.552229 | debian-bookworm -> localhost | changed 2025-07-29 03:01:19.559289 | 2025-07-29 03:01:19.559379 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-07-29 03:01:23.029300 | debian-bookworm -> localhost | changed 2025-07-29 03:01:23.039919 | 2025-07-29 03:01:23.040014 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-07-29 03:01:23.975767 | debian-bookworm -> localhost | ok 2025-07-29 03:01:23.982950 | 2025-07-29 03:01:23.983133 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-07-29 03:01:24.062320 | debian-bookworm | ok 2025-07-29 03:01:24.116227 | debian-bookworm | included: /var/lib/zuul/builds/d7bb699d3f4345da90f138d8ad2d897e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-07-29 03:01:24.134035 | 2025-07-29 03:01:24.134146 | TASK [add-build-sshkey : Create Temp SSH key] 2025-07-29 03:01:30.740909 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-07-29 03:01:30.741079 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d7bb699d3f4345da90f138d8ad2d897e/work/d7bb699d3f4345da90f138d8ad2d897e_id_rsa 2025-07-29 03:01:30.741111 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d7bb699d3f4345da90f138d8ad2d897e/work/d7bb699d3f4345da90f138d8ad2d897e_id_rsa.pub 2025-07-29 03:01:30.741134 | debian-bookworm -> localhost | The key fingerprint is: 2025-07-29 03:01:30.741156 | debian-bookworm -> localhost | SHA256:bbmUeaIgneUWI2PUCmFdA1jqXJ/yQgEMRPn8u4wD3eE zuul-build-sshkey 2025-07-29 03:01:30.741176 | debian-bookworm -> localhost | The key's randomart image is: 2025-07-29 03:01:30.741200 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-07-29 03:01:30.741219 | debian-bookworm -> localhost | | o+++=++o | 2025-07-29 03:01:30.741237 | debian-bookworm -> localhost | | ..++. .. | 2025-07-29 03:01:30.741253 | debian-bookworm -> localhost | | o..*.+ | 2025-07-29 03:01:30.741269 | debian-bookworm -> localhost | | oo+oO = + | 2025-07-29 03:01:30.741285 | debian-bookworm -> localhost | | .++*.S O . | 2025-07-29 03:01:30.741303 | debian-bookworm -> localhost | | . .oE= + + | 2025-07-29 03:01:30.741320 | debian-bookworm -> localhost | | . ..o . | 2025-07-29 03:01:30.741336 | debian-bookworm -> localhost | | .o.. | 2025-07-29 03:01:30.741353 | debian-bookworm -> localhost | | ..o. | 2025-07-29 03:01:30.741370 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-07-29 03:01:30.741416 | debian-bookworm -> localhost | ok: Runtime: 0:00:05.573060 2025-07-29 03:01:30.746589 | 2025-07-29 03:01:30.746699 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-07-29 03:01:30.821023 | debian-bookworm | ok 2025-07-29 03:01:30.852213 | debian-bookworm | included: /var/lib/zuul/builds/d7bb699d3f4345da90f138d8ad2d897e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-07-29 03:01:30.874265 | 2025-07-29 03:01:30.874367 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-07-29 03:01:30.897942 | debian-bookworm | skipping: Conditional result was False 2025-07-29 03:01:30.904526 | 2025-07-29 03:01:30.904624 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-07-29 03:01:32.002110 | debian-bookworm | changed 2025-07-29 03:01:32.006405 | 2025-07-29 03:01:32.006485 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-07-29 03:01:32.344588 | debian-bookworm | ok 2025-07-29 03:01:32.349929 | 2025-07-29 03:01:32.350018 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-07-29 03:01:33.169515 | debian-bookworm | changed 2025-07-29 03:01:33.175002 | 2025-07-29 03:01:33.175091 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-07-29 03:01:33.906211 | debian-bookworm | changed 2025-07-29 03:01:33.910714 | 2025-07-29 03:01:33.910793 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-07-29 03:01:33.949615 | debian-bookworm | skipping: Conditional result was False 2025-07-29 03:01:33.955305 | 2025-07-29 03:01:33.955394 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-07-29 03:01:35.493594 | debian-bookworm -> localhost | changed 2025-07-29 03:01:35.502354 | 2025-07-29 03:01:35.502444 | TASK [add-build-sshkey : Add back temp key] 2025-07-29 03:01:36.874727 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d7bb699d3f4345da90f138d8ad2d897e/work/d7bb699d3f4345da90f138d8ad2d897e_id_rsa (zuul-build-sshkey) 2025-07-29 03:01:36.875296 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.026787 2025-07-29 03:01:36.884133 | 2025-07-29 03:01:36.884227 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-07-29 03:01:37.871239 | debian-bookworm | ok 2025-07-29 03:01:37.875234 | 2025-07-29 03:01:37.875312 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-07-29 03:01:37.968826 | debian-bookworm | skipping: Conditional result was False 2025-07-29 03:01:37.979201 | 2025-07-29 03:01:37.979291 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-07-29 03:01:38.924832 | debian-bookworm | ok 2025-07-29 03:01:38.941933 | 2025-07-29 03:01:38.942581 | TASK [validate-host : Define zuul_info_dir fact] 2025-07-29 03:01:39.007287 | debian-bookworm | ok 2025-07-29 03:01:39.011352 | 2025-07-29 03:01:39.011430 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-07-29 03:01:40.156013 | debian-bookworm -> localhost | ok 2025-07-29 03:01:40.161128 | 2025-07-29 03:01:40.161206 | TASK [validate-host : Collect information about the host] 2025-07-29 03:01:41.536297 | debian-bookworm | ok 2025-07-29 03:01:41.575016 | 2025-07-29 03:01:41.575115 | TASK [validate-host : Sanitize hostname] 2025-07-29 03:01:41.677978 | debian-bookworm | ok 2025-07-29 03:01:41.830139 | 2025-07-29 03:01:41.830240 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-07-29 03:01:44.080830 | debian-bookworm -> localhost | changed 2025-07-29 03:01:44.086563 | 2025-07-29 03:01:44.086656 | TASK [validate-host : Collect information about zuul worker] 2025-07-29 03:01:44.700004 | debian-bookworm | ok 2025-07-29 03:01:44.704438 | 2025-07-29 03:01:44.704527 | TASK [validate-host : Write out all zuul information for each host] 2025-07-29 03:01:46.906720 | debian-bookworm -> localhost | changed 2025-07-29 03:01:46.914308 | 2025-07-29 03:01:46.914395 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-07-29 03:01:47.201983 | debian-bookworm | ok 2025-07-29 03:01:47.206273 | 2025-07-29 03:01:47.206348 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-07-29 03:01:48.889410 | debian-bookworm | changed: 2025-07-29 03:01:48.889570 | debian-bookworm | cd+++++++++ src/ 2025-07-29 03:01:48.889599 | debian-bookworm | cd+++++++++ src/github.com/ 2025-07-29 03:01:48.889641 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-07-29 03:01:48.889661 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-07-29 03:01:48.889678 | debian-bookworm | localhost | ok: Runtime: 0:00:00.018388 2025-07-29 03:02:18.479344 | 2025-07-29 03:02:18.479815 | TASK [upload-logs : Upload logs to log server] 2025-07-29 03:02:19.581311 | localhost | Output suppressed because no_log was given 2025-07-29 03:02:19.582962 | 2025-07-29 03:02:19.583056 | LOOP [upload-logs : Compress console log and json output] 2025-07-29 03:02:19.660463 | localhost | skipping: Conditional result was False 2025-07-29 03:02:19.665128 | localhost | skipping: Conditional result was False 2025-07-29 03:02:19.670894 | 2025-07-29 03:02:19.671004 | LOOP [upload-logs : Upload compressed console log and json output] 2025-07-29 03:02:19.748703 | localhost | skipping: Conditional result was False 2025-07-29 03:02:19.748965 | 2025-07-29 03:02:19.764129 | localhost | skipping: Conditional result was False 2025-07-29 03:02:19.771761 | 2025-07-29 03:02:19.771853 | LOOP [upload-logs : Upload console log and json output]