2025-09-09 19:23:25.629636 | Job console starting 2025-09-09 19:23:25.646023 | Updating git repos 2025-09-09 19:23:25.700264 | Cloning repos into workspace 2025-09-09 19:23:25.745516 | Restoring repo states 2025-09-09 19:23:25.778385 | Merging changes 2025-09-09 19:23:26.417935 | Checking out repos 2025-09-09 19:23:26.460858 | Preparing playbooks 2025-09-09 19:23:27.059596 | Running Ansible setup 2025-09-09 19:24:51.372268 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-09 19:24:52.342144 | 2025-09-09 19:24:52.342310 | PLAY [Base pre] 2025-09-09 19:24:52.365529 | 2025-09-09 19:24:52.365674 | TASK [Setup log path fact] 2025-09-09 19:24:52.396529 | debian-bookworm | ok 2025-09-09 19:24:52.416622 | 2025-09-09 19:24:52.416781 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-09 19:24:52.460086 | debian-bookworm | ok 2025-09-09 19:24:52.485943 | 2025-09-09 19:24:52.486090 | TASK [emit-job-header : Print job information] 2025-09-09 19:24:52.556107 | # Job Information 2025-09-09 19:24:52.556306 | Ansible Version: 2.16.14 2025-09-09 19:24:52.556353 | Job: ansible-collection-ensure-readme 2025-09-09 19:24:52.556435 | Pipeline: check 2025-09-09 19:24:52.556462 | Executor: 521e9411259a 2025-09-09 19:24:52.556483 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1994 2025-09-09 19:24:52.556505 | Event ID: 99837a60-8dab-11f0-8dc1-ca67a049e5e2 2025-09-09 19:24:52.566792 | 2025-09-09 19:24:52.566961 | LOOP [emit-job-header : Print node information] 2025-09-09 19:24:52.829827 | debian-bookworm | ok: 2025-09-09 19:24:52.830098 | debian-bookworm | # Node Information 2025-09-09 19:24:52.830147 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-09 19:24:52.830182 | debian-bookworm | Hostname: debian 2025-09-09 19:24:52.830213 | debian-bookworm | Username: zuul 2025-09-09 19:24:52.830243 | debian-bookworm | Distro: Debian 12.12 2025-09-09 19:24:52.830277 | debian-bookworm | Provider: regiocloud-a 2025-09-09 19:24:52.830307 | debian-bookworm | Region: 2025-09-09 19:24:52.830338 | debian-bookworm | Label: debian-bookworm 2025-09-09 19:24:52.830366 | debian-bookworm | Product Name: OpenStack Nova 2025-09-09 19:24:52.830593 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe98:c188 2025-09-09 19:24:52.844292 | 2025-09-09 19:24:52.844468 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-09 19:24:53.599238 | debian-bookworm -> localhost | changed 2025-09-09 19:24:53.618874 | 2025-09-09 19:24:53.619034 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-09 19:24:55.280544 | debian-bookworm -> localhost | changed 2025-09-09 19:24:55.291088 | 2025-09-09 19:24:55.291185 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-09 19:24:55.705951 | debian-bookworm -> localhost | ok 2025-09-09 19:24:55.714611 | 2025-09-09 19:24:55.714718 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-09 19:24:55.756481 | debian-bookworm | ok 2025-09-09 19:24:55.807390 | debian-bookworm | included: /var/lib/zuul/builds/d2426720b1a64323beecd7183f15914e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-09 19:24:55.814812 | 2025-09-09 19:24:55.815022 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-09 19:24:57.385153 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-09 19:24:57.385351 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d2426720b1a64323beecd7183f15914e/work/d2426720b1a64323beecd7183f15914e_id_rsa 2025-09-09 19:24:57.385402 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d2426720b1a64323beecd7183f15914e/work/d2426720b1a64323beecd7183f15914e_id_rsa.pub 2025-09-09 19:24:57.385430 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-09 19:24:57.385456 | debian-bookworm -> localhost | SHA256:jPin+gWTBwExcWJTxH72Vbenpt67RMmtxNA6rwdMj68 zuul-build-sshkey 2025-09-09 19:24:57.385489 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-09 19:24:57.385512 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-09 19:24:57.385533 | debian-bookworm -> localhost | | OB= | 2025-09-09 19:24:57.385555 | debian-bookworm -> localhost | | . =.. .. .| 2025-09-09 19:24:57.385575 | debian-bookworm -> localhost | | .. .....| 2025-09-09 19:24:57.385595 | debian-bookworm -> localhost | | ..=o o= +.| 2025-09-09 19:24:57.385615 | debian-bookworm -> localhost | | . =oS. +oo*.o| 2025-09-09 19:24:57.385640 | debian-bookworm -> localhost | | . + . +=+. | 2025-09-09 19:24:57.385660 | debian-bookworm -> localhost | | . o =+ | 2025-09-09 19:24:57.385680 | debian-bookworm -> localhost | | + .+o | 2025-09-09 19:24:57.385701 | debian-bookworm -> localhost | | .oo .Eo+o | 2025-09-09 19:24:57.385721 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-09 19:24:57.385773 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.690801 2025-09-09 19:24:57.393364 | 2025-09-09 19:24:57.393481 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-09 19:24:57.455774 | debian-bookworm | ok 2025-09-09 19:24:57.471962 | debian-bookworm | included: /var/lib/zuul/builds/d2426720b1a64323beecd7183f15914e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-09 19:24:57.489451 | 2025-09-09 19:24:57.489556 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-09 19:24:57.529002 | debian-bookworm | skipping: Conditional result was False 2025-09-09 19:24:57.534795 | 2025-09-09 19:24:57.535060 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-09 19:24:58.216279 | debian-bookworm | changed 2025-09-09 19:24:58.227610 | 2025-09-09 19:24:58.227696 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-09 19:24:58.528362 | debian-bookworm | ok 2025-09-09 19:24:58.532828 | 2025-09-09 19:24:58.532903 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-09 19:24:59.130525 | debian-bookworm | changed 2025-09-09 19:24:59.135961 | 2025-09-09 19:24:59.136045 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-09 19:24:59.727841 | debian-bookworm | changed 2025-09-09 19:24:59.733045 | 2025-09-09 19:24:59.739036 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-09 19:24:59.752246 | debian-bookworm | skipping: Conditional result was False 2025-09-09 19:24:59.758789 | 2025-09-09 19:24:59.758921 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-09 19:25:00.235754 | debian-bookworm -> localhost | changed 2025-09-09 19:25:00.246979 | 2025-09-09 19:25:00.247087 | TASK [add-build-sshkey : Add back temp key] 2025-09-09 19:25:00.726198 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d2426720b1a64323beecd7183f15914e/work/d2426720b1a64323beecd7183f15914e_id_rsa (zuul-build-sshkey) 2025-09-09 19:25:00.726440 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011684 2025-09-09 19:25:00.733798 | 2025-09-09 19:25:00.733884 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-09 19:25:01.095798 | debian-bookworm | ok 2025-09-09 19:25:01.100897 | 2025-09-09 19:25:01.100985 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-09 19:25:01.123828 | debian-bookworm | skipping: Conditional result was False 2025-09-09 19:25:01.133993 | 2025-09-09 19:25:01.134094 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-09 19:25:01.538871 | debian-bookworm | ok 2025-09-09 19:25:01.554346 | 2025-09-09 19:25:01.554462 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-09 19:25:01.595194 | debian-bookworm | ok 2025-09-09 19:25:01.600961 | 2025-09-09 19:25:01.601052 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-09 19:25:01.871092 | debian-bookworm -> localhost | ok 2025-09-09 19:25:01.877495 | 2025-09-09 19:25:01.877599 | TASK [validate-host : Collect information about the host] 2025-09-09 19:25:43.019896 | debian-bookworm | ok 2025-09-09 19:25:43.034055 | 2025-09-09 19:25:43.034184 | TASK [validate-host : Sanitize hostname] 2025-09-09 19:25:43.146807 | debian-bookworm | ok 2025-09-09 19:25:43.197800 | 2025-09-09 19:25:43.197937 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-09 19:25:43.784489 | debian-bookworm -> localhost | changed 2025-09-09 19:25:43.797734 | 2025-09-09 19:25:43.797882 | TASK [validate-host : Collect information about zuul worker] 2025-09-09 19:25:44.226795 | debian-bookworm | ok 2025-09-09 19:25:44.232434 | 2025-09-09 19:25:44.232557 | TASK [validate-host : Write out all zuul information for each host] 2025-09-09 19:25:44.837058 | debian-bookworm -> localhost | changed 2025-09-09 19:25:44.847993 | 2025-09-09 19:25:44.848122 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-09 19:25:45.109982 | debian-bookworm | ok 2025-09-09 19:25:45.116144 | 2025-09-09 19:25:45.116260 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-09 19:25:46.303736 | debian-bookworm | changed: 2025-09-09 19:25:46.303968 | debian-bookworm | cd+++++++++ src/ 2025-09-09 19:25:46.304005 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-09 19:25:46.304029 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-09 19:25:46.304050 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-09-09 19:25:46.304071 | debian-bookworm | localhost | ok: Runtime: 0:00:00.005981 2025-09-09 19:26:02.198744 | 2025-09-09 19:26:02.198914 | TASK [upload-logs : Upload logs to log server] 2025-09-09 19:26:02.739704 | localhost | Output suppressed because no_log was given 2025-09-09 19:26:02.743853 | 2025-09-09 19:26:02.744029 | LOOP [upload-logs : Compress console log and json output] 2025-09-09 19:26:02.792193 | localhost | skipping: Conditional result was False 2025-09-09 19:26:02.801123 | localhost | skipping: Conditional result was False 2025-09-09 19:26:02.817103 | 2025-09-09 19:26:02.817356 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-09 19:26:02.877676 | localhost | skipping: Conditional result was False 2025-09-09 19:26:02.877979 | 2025-09-09 19:26:02.882676 | localhost | skipping: Conditional result was False 2025-09-09 19:26:02.890107 | 2025-09-09 19:26:02.890253 | LOOP [upload-logs : Upload console log and json output]