2025-05-30 07:55:22.046992 | Job console starting 2025-05-30 07:55:22.088043 | Updating git repos 2025-05-30 07:55:22.183511 | Cloning repos into workspace 2025-05-30 07:55:22.303780 | Restoring repo states 2025-05-30 07:55:22.329855 | Merging changes 2025-05-30 07:55:23.087559 | Checking out repos 2025-05-30 07:55:23.249096 | Preparing playbooks 2025-05-30 07:55:25.089566 | Running Ansible setup 2025-05-30 07:55:33.678821 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-30 07:55:35.134712 | 2025-05-30 07:55:35.135596 | PLAY [Base pre] 2025-05-30 07:55:35.195465 | 2025-05-30 07:55:35.195697 | TASK [Setup log path fact] 2025-05-30 07:55:35.255615 | debian-bookworm | ok 2025-05-30 07:55:35.303502 | 2025-05-30 07:55:35.304583 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-30 07:55:35.396704 | debian-bookworm | ok 2025-05-30 07:55:35.437863 | 2025-05-30 07:55:35.440389 | TASK [emit-job-header : Print job information] 2025-05-30 07:55:35.612125 | # Job Information 2025-05-30 07:55:35.612729 | Ansible Version: 2.16.14 2025-05-30 07:55:35.612815 | Job: ansible-collection-ensure-readme 2025-05-30 07:55:35.613003 | Pipeline: check 2025-05-30 07:55:35.613034 | Executor: 521e9411259a 2025-05-30 07:55:35.613154 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1819 2025-05-30 07:55:35.613260 | Event ID: 6aa5e370-3d2b-11f0-9edf-5e8427825e4a 2025-05-30 07:55:35.634407 | 2025-05-30 07:55:35.635328 | LOOP [emit-job-header : Print node information] 2025-05-30 07:55:36.060838 | debian-bookworm | ok: 2025-05-30 07:55:36.061183 | debian-bookworm | # Node Information 2025-05-30 07:55:36.061224 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-05-30 07:55:36.061249 | debian-bookworm | Hostname: debian 2025-05-30 07:55:36.061270 | debian-bookworm | Username: zuul 2025-05-30 07:55:36.061290 | debian-bookworm | Distro: Debian 12.11 2025-05-30 07:55:36.061313 | debian-bookworm | Provider: regiocloud-a 2025-05-30 07:55:36.061334 | debian-bookworm | Region: 2025-05-30 07:55:36.061354 | debian-bookworm | Label: debian-bookworm 2025-05-30 07:55:36.061374 | debian-bookworm | Product Name: OpenStack Nova 2025-05-30 07:55:36.061393 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe13:deb9 2025-05-30 07:55:36.096647 | 2025-05-30 07:55:36.097120 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-30 07:55:37.488609 | debian-bookworm -> localhost | changed 2025-05-30 07:55:37.517802 | 2025-05-30 07:55:37.517978 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-30 07:55:39.991285 | debian-bookworm -> localhost | changed 2025-05-30 07:55:40.003643 | 2025-05-30 07:55:40.003842 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-30 07:55:41.082607 | debian-bookworm -> localhost | ok 2025-05-30 07:55:41.087811 | 2025-05-30 07:55:41.087914 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-30 07:55:41.125124 | debian-bookworm | ok 2025-05-30 07:55:41.176245 | debian-bookworm | included: /var/lib/zuul/builds/dd9eed6f867d45b388ee69a43235bf71/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-30 07:55:41.184305 | 2025-05-30 07:55:41.184395 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-30 07:55:45.409875 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-05-30 07:55:45.410096 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/dd9eed6f867d45b388ee69a43235bf71/work/dd9eed6f867d45b388ee69a43235bf71_id_rsa 2025-05-30 07:55:45.410129 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/dd9eed6f867d45b388ee69a43235bf71/work/dd9eed6f867d45b388ee69a43235bf71_id_rsa.pub 2025-05-30 07:55:45.410151 | debian-bookworm -> localhost | The key fingerprint is: 2025-05-30 07:55:45.410173 | debian-bookworm -> localhost | SHA256:8t8RIJUe1YO1oGPWAfTTikGRxOapQKjiZ7XgyYPrUEM zuul-build-sshkey 2025-05-30 07:55:45.410203 | debian-bookworm -> localhost | The key's randomart image is: 2025-05-30 07:55:45.410221 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-05-30 07:55:45.410238 | debian-bookworm -> localhost | | . +B*++. | 2025-05-30 07:55:45.410257 | debian-bookworm -> localhost | | . . o*+.+o. | 2025-05-30 07:55:45.410274 | debian-bookworm -> localhost | | E. . .+Bo+ o. | 2025-05-30 07:55:45.410290 | debian-bookworm -> localhost | |.... .. ++= o | 2025-05-30 07:55:45.410307 | debian-bookworm -> localhost | |..* + o.S.. o | 2025-05-30 07:55:45.410332 | debian-bookworm -> localhost | | + O . o. . | 2025-05-30 07:55:45.410349 | debian-bookworm -> localhost | |. + . . . | 2025-05-30 07:55:45.410365 | debian-bookworm -> localhost | |.. . . . | 2025-05-30 07:55:45.410382 | debian-bookworm -> localhost | |.. . . | 2025-05-30 07:55:45.410399 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-05-30 07:55:45.410446 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.936209 2025-05-30 07:55:45.415937 | 2025-05-30 07:55:45.416031 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-30 07:55:45.459756 | debian-bookworm | ok 2025-05-30 07:55:45.468980 | debian-bookworm | included: /var/lib/zuul/builds/dd9eed6f867d45b388ee69a43235bf71/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-30 07:55:45.481374 | 2025-05-30 07:55:45.481466 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-30 07:55:45.504694 | debian-bookworm | skipping: Conditional result was False 2025-05-30 07:55:45.509901 | 2025-05-30 07:55:45.509984 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-30 07:55:46.173386 | debian-bookworm | changed 2025-05-30 07:55:46.182011 | 2025-05-30 07:55:46.182242 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-30 07:55:46.472081 | debian-bookworm | ok 2025-05-30 07:55:46.496691 | 2025-05-30 07:55:46.496804 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-30 07:55:47.215132 | debian-bookworm | changed 2025-05-30 07:55:47.225814 | 2025-05-30 07:55:47.225943 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-30 07:55:47.889944 | debian-bookworm | changed 2025-05-30 07:55:47.895455 | 2025-05-30 07:55:47.895671 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-30 07:55:47.918881 | debian-bookworm | skipping: Conditional result was False 2025-05-30 07:55:47.924551 | 2025-05-30 07:55:47.924643 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-30 07:55:48.624665 | debian-bookworm -> localhost | changed 2025-05-30 07:55:48.639767 | 2025-05-30 07:55:48.639878 | TASK [add-build-sshkey : Add back temp key] 2025-05-30 07:55:49.050451 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/dd9eed6f867d45b388ee69a43235bf71/work/dd9eed6f867d45b388ee69a43235bf71_id_rsa (zuul-build-sshkey) 2025-05-30 07:55:49.050695 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012240 2025-05-30 07:55:49.058595 | 2025-05-30 07:55:49.058706 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-30 07:55:49.574089 | debian-bookworm | ok 2025-05-30 07:55:49.579287 | 2025-05-30 07:55:49.579387 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-30 07:55:49.629767 | debian-bookworm | skipping: Conditional result was False 2025-05-30 07:55:49.639843 | 2025-05-30 07:55:49.639939 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-30 07:55:50.177995 | debian-bookworm | ok 2025-05-30 07:55:50.188389 | 2025-05-30 07:55:50.188490 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-30 07:55:50.217381 | debian-bookworm | ok 2025-05-30 07:55:50.223990 | 2025-05-30 07:55:50.224104 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-30 07:55:50.562376 | debian-bookworm -> localhost | ok 2025-05-30 07:55:50.569140 | 2025-05-30 07:55:50.569260 | TASK [validate-host : Collect information about the host] 2025-05-30 07:55:51.780030 | debian-bookworm | ok 2025-05-30 07:55:51.790085 | 2025-05-30 07:55:51.790188 | TASK [validate-host : Sanitize hostname] 2025-05-30 07:55:51.890225 | debian-bookworm | ok 2025-05-30 07:55:51.929238 | 2025-05-30 07:55:51.929362 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-30 07:55:52.898025 | debian-bookworm -> localhost | changed 2025-05-30 07:55:52.903751 | 2025-05-30 07:55:52.903845 | TASK [validate-host : Collect information about zuul worker] 2025-05-30 07:55:53.335942 | debian-bookworm | ok 2025-05-30 07:55:53.340640 | 2025-05-30 07:55:53.340738 | TASK [validate-host : Write out all zuul information for each host] 2025-05-30 07:55:54.951355 | debian-bookworm -> localhost | changed 2025-05-30 07:55:54.964163 | 2025-05-30 07:55:54.964270 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-30 07:55:55.259967 | debian-bookworm | ok 2025-05-30 07:55:55.265701 | 2025-05-30 07:55:55.265798 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-30 07:55:57.258966 | debian-bookworm | changed: 2025-05-30 07:55:57.259176 | debian-bookworm | cd+++++++++ src/ 2025-05-30 07:55:57.259211 | debian-bookworm | cd+++++++++ src/github.com/ 2025-05-30 07:55:57.259236 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-05-30 07:55:57.259257 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-05-30 07:55:57.259283 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007273 2025-05-30 07:56:14.748140 | 2025-05-30 07:56:14.748331 | TASK [upload-logs : Upload logs to log server] 2025-05-30 07:56:15.342051 | localhost | Output suppressed because no_log was given 2025-05-30 07:56:15.345646 | 2025-05-30 07:56:15.345828 | LOOP [upload-logs : Compress console log and json output] 2025-05-30 07:56:15.410813 | localhost | skipping: Conditional result was False 2025-05-30 07:56:15.415943 | localhost | skipping: Conditional result was False 2025-05-30 07:56:15.428948 | 2025-05-30 07:56:15.429155 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-30 07:56:15.480524 | localhost | skipping: Conditional result was False 2025-05-30 07:56:15.481235 | 2025-05-30 07:56:15.484499 | localhost | skipping: Conditional result was False 2025-05-30 07:56:15.490816 | 2025-05-30 07:56:15.491040 | LOOP [upload-logs : Upload console log and json output]