2025-09-15 21:33:46.642912 | Job console starting 2025-09-15 21:33:46.662372 | Updating git repos 2025-09-15 21:33:46.693084 | Cloning repos into workspace 2025-09-15 21:33:46.747702 | Restoring repo states 2025-09-15 21:33:46.759886 | Merging changes 2025-09-15 21:33:47.312575 | Checking out repos 2025-09-15 21:33:47.359835 | Preparing playbooks 2025-09-15 21:33:48.050593 | Running Ansible setup 2025-09-15 21:33:52.968878 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-15 21:33:53.736972 | 2025-09-15 21:33:53.737174 | PLAY [Base pre] 2025-09-15 21:33:53.778928 | 2025-09-15 21:33:53.779728 | TASK [Setup log path fact] 2025-09-15 21:33:53.809368 | debian-bookworm | ok 2025-09-15 21:33:53.837554 | 2025-09-15 21:33:53.837723 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-15 21:33:53.899876 | debian-bookworm | ok 2025-09-15 21:33:53.922749 | 2025-09-15 21:33:53.922922 | TASK [emit-job-header : Print job information] 2025-09-15 21:33:53.993255 | # Job Information 2025-09-15 21:33:53.993435 | Ansible Version: 2.16.14 2025-09-15 21:33:53.993472 | Job: python-black 2025-09-15 21:33:53.993504 | Pipeline: check 2025-09-15 21:33:53.993527 | Executor: 521e9411259a 2025-09-15 21:33:53.993547 | Triggered by: https://github.com/osism/ansible-collection-validations/pull/243 2025-09-15 21:33:53.993570 | Event ID: a4261fc0-927b-11f0-880c-4a27ef3144bf 2025-09-15 21:33:53.998516 | 2025-09-15 21:33:53.998632 | LOOP [emit-job-header : Print node information] 2025-09-15 21:33:54.161441 | debian-bookworm | ok: 2025-09-15 21:33:54.161627 | debian-bookworm | # Node Information 2025-09-15 21:33:54.161664 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-15 21:33:54.161690 | debian-bookworm | Hostname: debian 2025-09-15 21:33:54.161713 | debian-bookworm | Username: zuul 2025-09-15 21:33:54.161735 | debian-bookworm | Distro: Debian 12.12 2025-09-15 21:33:54.161759 | debian-bookworm | Provider: regiocloud-a 2025-09-15 21:33:54.161781 | debian-bookworm | Region: 2025-09-15 21:33:54.161803 | debian-bookworm | Label: debian-bookworm 2025-09-15 21:33:54.161822 | debian-bookworm | Product Name: OpenStack Nova 2025-09-15 21:33:54.161842 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe7d:16af 2025-09-15 21:33:54.183685 | 2025-09-15 21:33:54.183831 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-15 21:33:54.879326 | debian-bookworm -> localhost | changed 2025-09-15 21:33:54.891158 | 2025-09-15 21:33:54.891318 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-15 21:33:55.887707 | debian-bookworm -> localhost | changed 2025-09-15 21:33:55.897736 | 2025-09-15 21:33:55.897839 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-15 21:33:56.205189 | debian-bookworm -> localhost | ok 2025-09-15 21:33:56.210929 | 2025-09-15 21:33:56.211030 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-15 21:33:56.228096 | debian-bookworm | ok 2025-09-15 21:33:56.244539 | debian-bookworm | included: /var/lib/zuul/builds/1429b3e91c82408db75e291c20981f46/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-15 21:33:56.252155 | 2025-09-15 21:33:56.252248 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-15 21:33:57.316448 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-15 21:33:57.316605 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/1429b3e91c82408db75e291c20981f46/work/1429b3e91c82408db75e291c20981f46_id_rsa 2025-09-15 21:33:57.316637 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/1429b3e91c82408db75e291c20981f46/work/1429b3e91c82408db75e291c20981f46_id_rsa.pub 2025-09-15 21:33:57.316658 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-15 21:33:57.316678 | debian-bookworm -> localhost | SHA256:wa4UMNTDyyG3Lnmhmy9LSgebDe+9nNFFzZjqH1tnXlY zuul-build-sshkey 2025-09-15 21:33:57.316703 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-15 21:33:57.316721 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-15 21:33:57.316738 | debian-bookworm -> localhost | | .+o | 2025-09-15 21:33:57.316755 | debian-bookworm -> localhost | | .o*. = | 2025-09-15 21:33:57.316772 | debian-bookworm -> localhost | | +.=o + o | 2025-09-15 21:33:57.316788 | debian-bookworm -> localhost | | =o + | 2025-09-15 21:33:57.316805 | debian-bookworm -> localhost | | o +..S . E| 2025-09-15 21:33:57.316827 | debian-bookworm -> localhost | | B+.o+ . .| 2025-09-15 21:33:57.316844 | debian-bookworm -> localhost | | + ==o o . . o o| 2025-09-15 21:33:57.316860 | debian-bookworm -> localhost | | . =+o o . + + o | 2025-09-15 21:33:57.316876 | debian-bookworm -> localhost | | . o+*. o . | 2025-09-15 21:33:57.316892 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-15 21:33:57.316934 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.574146 2025-09-15 21:33:57.321992 | 2025-09-15 21:33:57.322069 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-15 21:33:57.358062 | debian-bookworm | ok 2025-09-15 21:33:57.365397 | debian-bookworm | included: /var/lib/zuul/builds/1429b3e91c82408db75e291c20981f46/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-15 21:33:57.395396 | 2025-09-15 21:33:57.395464 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-15 21:33:57.427741 | debian-bookworm | skipping: Conditional result was False 2025-09-15 21:33:57.432274 | 2025-09-15 21:33:57.432348 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-15 21:33:58.156323 | debian-bookworm | changed 2025-09-15 21:33:58.160567 | 2025-09-15 21:33:58.161001 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-15 21:33:58.390732 | debian-bookworm | ok 2025-09-15 21:33:58.395348 | 2025-09-15 21:33:58.395418 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-15 21:33:59.052297 | debian-bookworm | changed 2025-09-15 21:33:59.062298 | 2025-09-15 21:33:59.062457 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-15 21:33:59.716345 | debian-bookworm | changed 2025-09-15 21:33:59.724865 | 2025-09-15 21:33:59.724986 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-15 21:33:59.738241 | debian-bookworm | skipping: Conditional result was False 2025-09-15 21:33:59.747055 | 2025-09-15 21:33:59.747211 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-15 21:34:00.136121 | debian-bookworm -> localhost | changed 2025-09-15 21:34:00.144487 | 2025-09-15 21:34:00.144564 | TASK [add-build-sshkey : Add back temp key] 2025-09-15 21:34:00.451076 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/1429b3e91c82408db75e291c20981f46/work/1429b3e91c82408db75e291c20981f46_id_rsa (zuul-build-sshkey) 2025-09-15 21:34:00.451664 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015486 2025-09-15 21:34:00.471927 | 2025-09-15 21:34:00.472035 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-15 21:34:00.846345 | debian-bookworm | ok 2025-09-15 21:34:00.856036 | 2025-09-15 21:34:00.856185 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-15 21:34:00.879483 | debian-bookworm | skipping: Conditional result was False 2025-09-15 21:34:00.890138 | 2025-09-15 21:34:00.890236 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-15 21:34:01.340893 | debian-bookworm | ok 2025-09-15 21:34:01.355715 | 2025-09-15 21:34:01.355823 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-15 21:34:01.393235 | debian-bookworm | ok 2025-09-15 21:34:01.402395 | 2025-09-15 21:34:01.402484 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-15 21:34:01.647315 | debian-bookworm -> localhost | ok 2025-09-15 21:34:01.653288 | 2025-09-15 21:34:01.653372 | TASK [validate-host : Collect information about the host] 2025-09-15 21:34:02.768014 | debian-bookworm | ok 2025-09-15 21:34:02.786779 | 2025-09-15 21:34:02.786876 | TASK [validate-host : Sanitize hostname] 2025-09-15 21:34:02.864057 | debian-bookworm | ok 2025-09-15 21:34:02.888958 | 2025-09-15 21:34:02.889047 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-15 21:34:03.386034 | debian-bookworm -> localhost | changed 2025-09-15 21:34:03.393357 | 2025-09-15 21:34:03.393438 | TASK [validate-host : Collect information about zuul worker] 2025-09-15 21:34:03.803536 | debian-bookworm | ok 2025-09-15 21:34:03.807916 | 2025-09-15 21:34:03.808003 | TASK [validate-host : Write out all zuul information for each host] 2025-09-15 21:34:04.237683 | debian-bookworm -> localhost | changed 2025-09-15 21:34:04.245030 | 2025-09-15 21:34:04.245126 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-15 21:34:04.537508 | debian-bookworm | ok 2025-09-15 21:34:04.545714 | 2025-09-15 21:34:04.545802 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-15 21:34:05.424956 | debian-bookworm | changed: 2025-09-15 21:34:05.425152 | debian-bookworm | cd+++++++++ src/ 2025-09-15 21:34:05.425247 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-15 21:34:05.425276 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-15 21:34:05.425299 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-validations/ 2025-09-15 21:34:05.425320 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007913 2025-09-15 21:34:29.178398 | 2025-09-15 21:34:29.178617 | TASK [upload-logs : Upload logs to log server] 2025-09-15 21:34:29.718014 | localhost | Output suppressed because no_log was given 2025-09-15 21:34:29.720034 | 2025-09-15 21:34:29.720163 | LOOP [upload-logs : Compress console log and json output] 2025-09-15 21:34:29.773556 | localhost | skipping: Conditional result was False 2025-09-15 21:34:29.779653 | localhost | skipping: Conditional result was False 2025-09-15 21:34:29.790562 | 2025-09-15 21:34:29.790808 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-15 21:34:29.837832 | localhost | skipping: Conditional result was False 2025-09-15 21:34:29.838154 | 2025-09-15 21:34:29.842821 | localhost | skipping: Conditional result was False 2025-09-15 21:34:29.851603 | 2025-09-15 21:34:29.851709 | LOOP [upload-logs : Upload console log and json output]