2025-06-26 12:40:30.349737 | Job console starting 2025-06-26 12:40:30.391828 | Updating git repos 2025-06-26 12:40:30.451581 | Cloning repos into workspace 2025-06-26 12:40:30.546558 | Restoring repo states 2025-06-26 12:40:30.578060 | Merging changes 2025-06-26 12:40:31.228803 | Checking out repos 2025-06-26 12:40:31.311358 | Preparing playbooks 2025-06-26 12:40:32.131061 | Running Ansible setup 2025-06-26 12:40:38.828567 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-26 12:40:39.957033 | 2025-06-26 12:40:39.957208 | PLAY [Base pre] 2025-06-26 12:40:39.997042 | 2025-06-26 12:40:39.997236 | TASK [Setup log path fact] 2025-06-26 12:40:40.027866 | debian-bookworm | ok 2025-06-26 12:40:40.059507 | 2025-06-26 12:40:40.059691 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-26 12:40:40.106116 | debian-bookworm | ok 2025-06-26 12:40:40.121271 | 2025-06-26 12:40:40.121992 | TASK [emit-job-header : Print job information] 2025-06-26 12:40:40.197392 | # Job Information 2025-06-26 12:40:40.197624 | Ansible Version: 2.16.14 2025-06-26 12:40:40.197661 | Job: ansible-collection-ensure-readme 2025-06-26 12:40:40.197695 | Pipeline: check 2025-06-26 12:40:40.197718 | Executor: 521e9411259a 2025-06-26 12:40:40.197738 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1924 2025-06-26 12:40:40.197760 | Event ID: b92612d0-528a-11f0-8d50-7be7ca02fd38 2025-06-26 12:40:40.204767 | 2025-06-26 12:40:40.205909 | LOOP [emit-job-header : Print node information] 2025-06-26 12:40:40.469174 | debian-bookworm | ok: 2025-06-26 12:40:40.469384 | debian-bookworm | # Node Information 2025-06-26 12:40:40.469466 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-26 12:40:40.469495 | debian-bookworm | Hostname: debian 2025-06-26 12:40:40.469517 | debian-bookworm | Username: zuul 2025-06-26 12:40:40.469538 | debian-bookworm | Distro: Debian 12.11 2025-06-26 12:40:40.469561 | debian-bookworm | Provider: regiocloud-a 2025-06-26 12:40:40.469583 | debian-bookworm | Region: 2025-06-26 12:40:40.469603 | debian-bookworm | Label: debian-bookworm 2025-06-26 12:40:40.469622 | debian-bookworm | Product Name: OpenStack Nova 2025-06-26 12:40:40.469642 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe6b:6eac 2025-06-26 12:40:40.489809 | 2025-06-26 12:40:40.489975 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-26 12:40:41.233606 | debian-bookworm -> localhost | changed 2025-06-26 12:40:41.243863 | 2025-06-26 12:40:41.244108 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-26 12:40:43.728828 | debian-bookworm -> localhost | changed 2025-06-26 12:40:43.739778 | 2025-06-26 12:40:43.739906 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-26 12:40:44.112935 | debian-bookworm -> localhost | ok 2025-06-26 12:40:44.119866 | 2025-06-26 12:40:44.119993 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-26 12:40:44.158623 | debian-bookworm | ok 2025-06-26 12:40:44.190823 | debian-bookworm | included: /var/lib/zuul/builds/1c16940ed7a74e31b7de108067c480db/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-26 12:40:44.209364 | 2025-06-26 12:40:44.209509 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-26 12:40:45.895147 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-26 12:40:45.895334 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/1c16940ed7a74e31b7de108067c480db/work/1c16940ed7a74e31b7de108067c480db_id_rsa 2025-06-26 12:40:45.895367 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/1c16940ed7a74e31b7de108067c480db/work/1c16940ed7a74e31b7de108067c480db_id_rsa.pub 2025-06-26 12:40:45.895399 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-26 12:40:45.895450 | debian-bookworm -> localhost | SHA256:y/B3cRXAFeHPguAFY/HUde3RCwYs8eVAvgieYAduf/c zuul-build-sshkey 2025-06-26 12:40:45.895489 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-26 12:40:45.895516 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-26 12:40:45.895542 | debian-bookworm -> localhost | | . .O=++o*B| 2025-06-26 12:40:45.895569 | debian-bookworm -> localhost | | . . oo*++o.=| 2025-06-26 12:40:45.895595 | debian-bookworm -> localhost | | = o oo+..o+| 2025-06-26 12:40:45.895619 | debian-bookworm -> localhost | | o = o..o.. +o| 2025-06-26 12:40:45.895643 | debian-bookworm -> localhost | | .+So.oo o o| 2025-06-26 12:40:45.895670 | debian-bookworm -> localhost | | +... .o . | 2025-06-26 12:40:45.895695 | debian-bookworm -> localhost | | + . .E | 2025-06-26 12:40:45.895720 | debian-bookworm -> localhost | | . . | 2025-06-26 12:40:45.895745 | debian-bookworm -> localhost | | | 2025-06-26 12:40:45.895769 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-26 12:40:45.895824 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.610407 2025-06-26 12:40:45.902954 | 2025-06-26 12:40:45.903060 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-26 12:40:45.919294 | debian-bookworm | ok 2025-06-26 12:40:45.926543 | debian-bookworm | included: /var/lib/zuul/builds/1c16940ed7a74e31b7de108067c480db/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-26 12:40:45.933572 | 2025-06-26 12:40:45.933644 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-26 12:40:45.945993 | debian-bookworm | skipping: Conditional result was False 2025-06-26 12:40:45.950432 | 2025-06-26 12:40:45.950500 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-26 12:40:46.492728 | debian-bookworm | changed 2025-06-26 12:40:46.501535 | 2025-06-26 12:40:46.501684 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-26 12:40:46.759028 | debian-bookworm | ok 2025-06-26 12:40:46.766620 | 2025-06-26 12:40:46.766721 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-26 12:40:47.398874 | debian-bookworm | changed 2025-06-26 12:40:47.409626 | 2025-06-26 12:40:47.409761 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-26 12:40:48.030759 | debian-bookworm | changed 2025-06-26 12:40:48.036146 | 2025-06-26 12:40:48.036235 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-26 12:40:48.049097 | debian-bookworm | skipping: Conditional result was False 2025-06-26 12:40:48.055496 | 2025-06-26 12:40:48.055589 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-26 12:40:48.524195 | debian-bookworm -> localhost | changed 2025-06-26 12:40:48.535132 | 2025-06-26 12:40:48.535231 | TASK [add-build-sshkey : Add back temp key] 2025-06-26 12:40:48.930845 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/1c16940ed7a74e31b7de108067c480db/work/1c16940ed7a74e31b7de108067c480db_id_rsa (zuul-build-sshkey) 2025-06-26 12:40:48.931052 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009994 2025-06-26 12:40:48.938323 | 2025-06-26 12:40:48.938423 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-26 12:40:49.319965 | debian-bookworm | ok 2025-06-26 12:40:49.331165 | 2025-06-26 12:40:49.331268 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-26 12:40:49.351051 | debian-bookworm | skipping: Conditional result was False 2025-06-26 12:40:49.362581 | 2025-06-26 12:40:49.362678 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-26 12:40:49.758017 | debian-bookworm | ok 2025-06-26 12:40:49.775729 | 2025-06-26 12:40:49.778342 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-26 12:40:49.828902 | debian-bookworm | ok 2025-06-26 12:40:49.841081 | 2025-06-26 12:40:49.841219 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-26 12:40:50.310691 | debian-bookworm -> localhost | ok 2025-06-26 12:40:50.317596 | 2025-06-26 12:40:50.317717 | TASK [validate-host : Collect information about the host] 2025-06-26 12:40:51.471267 | debian-bookworm | ok 2025-06-26 12:40:51.481481 | 2025-06-26 12:40:51.481614 | TASK [validate-host : Sanitize hostname] 2025-06-26 12:40:51.592777 | debian-bookworm | ok 2025-06-26 12:40:51.633505 | 2025-06-26 12:40:51.633646 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-26 12:40:52.296750 | debian-bookworm -> localhost | changed 2025-06-26 12:40:52.302668 | 2025-06-26 12:40:52.302790 | TASK [validate-host : Collect information about zuul worker] 2025-06-26 12:40:52.705073 | debian-bookworm | ok 2025-06-26 12:40:52.711099 | 2025-06-26 12:40:52.712508 | TASK [validate-host : Write out all zuul information for each host] 2025-06-26 12:40:53.450517 | debian-bookworm -> localhost | changed 2025-06-26 12:40:53.460693 | 2025-06-26 12:40:53.460802 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-26 12:40:53.711387 | debian-bookworm | ok 2025-06-26 12:40:53.717140 | 2025-06-26 12:40:53.717254 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-26 12:40:54.944171 | debian-bookworm | changed: 2025-06-26 12:40:54.944488 | debian-bookworm | cd+++++++++ src/ 2025-06-26 12:40:54.944540 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-26 12:40:54.944571 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-26 12:40:54.944597 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-06-26 12:40:54.944621 | debian-bookworm | localhost | ok: Runtime: 0:00:00.008357 2025-06-26 12:41:10.940566 | 2025-06-26 12:41:10.940750 | TASK [upload-logs : Upload logs to log server] 2025-06-26 12:41:11.518785 | localhost | Output suppressed because no_log was given 2025-06-26 12:41:11.522233 | 2025-06-26 12:41:11.522470 | LOOP [upload-logs : Compress console log and json output] 2025-06-26 12:41:11.577090 | localhost | skipping: Conditional result was False 2025-06-26 12:41:11.586823 | localhost | skipping: Conditional result was False 2025-06-26 12:41:11.592592 | 2025-06-26 12:41:11.592719 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-26 12:41:11.642477 | localhost | skipping: Conditional result was False 2025-06-26 12:41:11.642984 | 2025-06-26 12:41:11.648150 | localhost | skipping: Conditional result was False 2025-06-26 12:41:11.655975 | 2025-06-26 12:41:11.656161 | LOOP [upload-logs : Upload console log and json output]