2025-07-09 20:14:55.194977 | Job console starting 2025-07-09 20:14:55.209972 | Updating git repos 2025-07-09 20:14:55.257010 | Cloning repos into workspace 2025-07-09 20:14:55.327094 | Restoring repo states 2025-07-09 20:14:55.341990 | Merging changes 2025-07-09 20:14:55.886173 | Checking out repos 2025-07-09 20:14:55.939719 | Preparing playbooks 2025-07-09 20:14:56.527285 | Running Ansible setup 2025-07-09 20:15:00.241537 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-07-09 20:15:00.957626 | 2025-07-09 20:15:00.957755 | PLAY [Base pre] 2025-07-09 20:15:00.972845 | 2025-07-09 20:15:00.972957 | TASK [Setup log path fact] 2025-07-09 20:15:01.001050 | debian-bookworm | ok 2025-07-09 20:15:01.015812 | 2025-07-09 20:15:01.015967 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-07-09 20:15:01.074885 | debian-bookworm | ok 2025-07-09 20:15:01.089187 | 2025-07-09 20:15:01.089327 | TASK [emit-job-header : Print job information] 2025-07-09 20:15:01.146114 | # Job Information 2025-07-09 20:15:01.146392 | Ansible Version: 2.16.14 2025-07-09 20:15:01.146450 | Job: ansible-collection-ensure-readme 2025-07-09 20:15:01.146559 | Pipeline: check 2025-07-09 20:15:01.146608 | Executor: 521e9411259a 2025-07-09 20:15:01.146644 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1942 2025-07-09 20:15:01.146681 | Event ID: 1f8648d0-5d01-11f0-8f24-6e84e29fc570 2025-07-09 20:15:01.153657 | 2025-07-09 20:15:01.153795 | LOOP [emit-job-header : Print node information] 2025-07-09 20:15:01.289460 | debian-bookworm | ok: 2025-07-09 20:15:01.289713 | debian-bookworm | # Node Information 2025-07-09 20:15:01.289778 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-07-09 20:15:01.289823 | debian-bookworm | Hostname: debian 2025-07-09 20:15:01.289864 | debian-bookworm | Username: zuul 2025-07-09 20:15:01.289899 | debian-bookworm | Distro: Debian 12.11 2025-07-09 20:15:01.289938 | debian-bookworm | Provider: regiocloud-a 2025-07-09 20:15:01.289974 | debian-bookworm | Region: 2025-07-09 20:15:01.290010 | debian-bookworm | Label: debian-bookworm 2025-07-09 20:15:01.290047 | debian-bookworm | Product Name: OpenStack Nova 2025-07-09 20:15:01.290084 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe29:6813 2025-07-09 20:15:01.317811 | 2025-07-09 20:15:01.317968 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-07-09 20:15:01.777713 | debian-bookworm -> localhost | changed 2025-07-09 20:15:01.787095 | 2025-07-09 20:15:01.787250 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-07-09 20:15:02.756423 | debian-bookworm -> localhost | changed 2025-07-09 20:15:02.776991 | 2025-07-09 20:15:02.777139 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-07-09 20:15:03.055435 | debian-bookworm -> localhost | ok 2025-07-09 20:15:03.061716 | 2025-07-09 20:15:03.061832 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-07-09 20:15:03.089923 | debian-bookworm | ok 2025-07-09 20:15:03.108251 | debian-bookworm | included: /var/lib/zuul/builds/b6f29d82ad194201a7abecc59d9bc000/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-07-09 20:15:03.114093 | 2025-07-09 20:15:03.114178 | TASK [add-build-sshkey : Create Temp SSH key] 2025-07-09 20:15:03.997326 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-07-09 20:15:03.997700 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/b6f29d82ad194201a7abecc59d9bc000/work/b6f29d82ad194201a7abecc59d9bc000_id_rsa 2025-07-09 20:15:03.997814 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/b6f29d82ad194201a7abecc59d9bc000/work/b6f29d82ad194201a7abecc59d9bc000_id_rsa.pub 2025-07-09 20:15:03.997880 | debian-bookworm -> localhost | The key fingerprint is: 2025-07-09 20:15:03.997933 | debian-bookworm -> localhost | SHA256:NWJUwYKVnVvcWoTpo6ZpmafcSvI7ovslQj+raNo9DeI zuul-build-sshkey 2025-07-09 20:15:03.998002 | debian-bookworm -> localhost | The key's randomart image is: 2025-07-09 20:15:03.998050 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-07-09 20:15:03.998094 | debian-bookworm -> localhost | | oo=o+ =. | 2025-07-09 20:15:03.998140 | debian-bookworm -> localhost | | ..o + = o | 2025-07-09 20:15:03.998184 | debian-bookworm -> localhost | | o.o+ o | 2025-07-09 20:15:03.998227 | debian-bookworm -> localhost | | . o..+ | 2025-07-09 20:15:03.998293 | debian-bookworm -> localhost | | . S . . | 2025-07-09 20:15:03.998392 | debian-bookworm -> localhost | | .... o | 2025-07-09 20:15:03.998444 | debian-bookworm -> localhost | | . ..o= o* | 2025-07-09 20:15:03.998488 | debian-bookworm -> localhost | | .Eo..oXB.. | 2025-07-09 20:15:03.998535 | debian-bookworm -> localhost | |.oo =*oo**. | 2025-07-09 20:15:03.998604 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-07-09 20:15:03.998736 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.410855 2025-07-09 20:15:04.009988 | 2025-07-09 20:15:04.010110 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-07-09 20:15:04.044530 | debian-bookworm | ok 2025-07-09 20:15:04.057515 | debian-bookworm | included: /var/lib/zuul/builds/b6f29d82ad194201a7abecc59d9bc000/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-07-09 20:15:04.070515 | 2025-07-09 20:15:04.070623 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-07-09 20:15:04.094435 | debian-bookworm | skipping: Conditional result was False 2025-07-09 20:15:04.105493 | 2025-07-09 20:15:04.105630 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-07-09 20:15:04.680400 | debian-bookworm | changed 2025-07-09 20:15:04.689345 | 2025-07-09 20:15:04.689492 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-07-09 20:15:04.938590 | debian-bookworm | ok 2025-07-09 20:15:04.947031 | 2025-07-09 20:15:04.947148 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-07-09 20:15:05.580953 | debian-bookworm | changed 2025-07-09 20:15:05.591424 | 2025-07-09 20:15:05.591567 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-07-09 20:15:06.185740 | debian-bookworm | changed 2025-07-09 20:15:06.194392 | 2025-07-09 20:15:06.194524 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-07-09 20:15:06.220611 | debian-bookworm | skipping: Conditional result was False 2025-07-09 20:15:06.236051 | 2025-07-09 20:15:06.236218 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-07-09 20:15:06.655143 | debian-bookworm -> localhost | changed 2025-07-09 20:15:06.674244 | 2025-07-09 20:15:06.674373 | TASK [add-build-sshkey : Add back temp key] 2025-07-09 20:15:07.012774 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/b6f29d82ad194201a7abecc59d9bc000/work/b6f29d82ad194201a7abecc59d9bc000_id_rsa (zuul-build-sshkey) 2025-07-09 20:15:07.013332 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019270 2025-07-09 20:15:07.028243 | 2025-07-09 20:15:07.028406 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-07-09 20:15:07.378991 | debian-bookworm | ok 2025-07-09 20:15:07.387077 | 2025-07-09 20:15:07.387205 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-07-09 20:15:07.421645 | debian-bookworm | skipping: Conditional result was False 2025-07-09 20:15:07.441991 | 2025-07-09 20:15:07.442143 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-07-09 20:15:07.824631 | debian-bookworm | ok 2025-07-09 20:15:07.838827 | 2025-07-09 20:15:07.838953 | TASK [validate-host : Define zuul_info_dir fact] 2025-07-09 20:15:07.881957 | debian-bookworm | ok 2025-07-09 20:15:07.889611 | 2025-07-09 20:15:07.889725 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-07-09 20:15:08.168674 | debian-bookworm -> localhost | ok 2025-07-09 20:15:08.184680 | 2025-07-09 20:15:08.184867 | TASK [validate-host : Collect information about the host] 2025-07-09 20:15:09.315819 | debian-bookworm | ok 2025-07-09 20:15:09.327149 | 2025-07-09 20:15:09.327275 | TASK [validate-host : Sanitize hostname] 2025-07-09 20:15:09.437171 | debian-bookworm | ok 2025-07-09 20:15:09.483987 | 2025-07-09 20:15:09.484132 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-07-09 20:15:10.045270 | debian-bookworm -> localhost | changed 2025-07-09 20:15:10.051113 | 2025-07-09 20:15:10.051229 | TASK [validate-host : Collect information about zuul worker] 2025-07-09 20:15:10.452428 | debian-bookworm | ok 2025-07-09 20:15:10.460526 | 2025-07-09 20:15:10.460680 | TASK [validate-host : Write out all zuul information for each host] 2025-07-09 20:15:11.021854 | debian-bookworm -> localhost | changed 2025-07-09 20:15:11.031432 | 2025-07-09 20:15:11.031553 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-07-09 20:15:11.304973 | debian-bookworm | ok 2025-07-09 20:15:11.318130 | 2025-07-09 20:15:11.318323 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-07-09 20:15:12.436788 | debian-bookworm | changed: 2025-07-09 20:15:12.437168 | debian-bookworm | cd+++++++++ src/ 2025-07-09 20:15:12.437253 | debian-bookworm | cd+++++++++ src/github.com/ 2025-07-09 20:15:12.437296 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-07-09 20:15:12.437332 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-07-09 20:15:12.437383 | debian-bookworm | localhost | ok: Runtime: 0:00:00.005764 2025-07-09 20:15:29.079122 | 2025-07-09 20:15:29.079296 | TASK [upload-logs : Upload logs to log server] 2025-07-09 20:15:29.636840 | localhost | Output suppressed because no_log was given 2025-07-09 20:15:29.641167 | 2025-07-09 20:15:29.641430 | LOOP [upload-logs : Compress console log and json output] 2025-07-09 20:15:29.710100 | localhost | skipping: Conditional result was False 2025-07-09 20:15:29.715146 | localhost | skipping: Conditional result was False 2025-07-09 20:15:29.719469 | 2025-07-09 20:15:29.719562 | LOOP [upload-logs : Upload compressed console log and json output] 2025-07-09 20:15:29.772593 | localhost | skipping: Conditional result was False 2025-07-09 20:15:29.773295 | 2025-07-09 20:15:29.775950 | localhost | skipping: Conditional result was False 2025-07-09 20:15:29.788463 | 2025-07-09 20:15:29.788664 | LOOP [upload-logs : Upload console log and json output]