2025-10-05 18:38:15.467502 | Job console starting 2025-10-05 18:38:15.495109 | Updating git repos 2025-10-05 18:38:15.547872 | Cloning repos into workspace 2025-10-05 18:38:15.617711 | Restoring repo states 2025-10-05 18:38:15.644202 | Merging changes 2025-10-05 18:38:16.283868 | Checking out repos 2025-10-05 18:38:16.346658 | Preparing playbooks 2025-10-05 18:38:17.107592 | Running Ansible setup 2025-10-05 18:38:22.301236 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-05 18:38:23.173727 | 2025-10-05 18:38:23.173894 | PLAY [Base pre] 2025-10-05 18:38:23.209475 | 2025-10-05 18:38:23.209630 | TASK [Setup log path fact] 2025-10-05 18:38:23.239446 | debian-bookworm | ok 2025-10-05 18:38:23.268725 | 2025-10-05 18:38:23.268886 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-05 18:38:23.331130 | debian-bookworm | ok 2025-10-05 18:38:23.353204 | 2025-10-05 18:38:23.353343 | TASK [emit-job-header : Print job information] 2025-10-05 18:38:23.413430 | # Job Information 2025-10-05 18:38:23.413712 | Ansible Version: 2.16.14 2025-10-05 18:38:23.413751 | Job: ansible-collection-ensure-readme 2025-10-05 18:38:23.413786 | Pipeline: check 2025-10-05 18:38:23.413813 | Executor: 521e9411259a 2025-10-05 18:38:23.413834 | Triggered by: https://github.com/osism/ansible-collection-services/pull/2002 2025-10-05 18:38:23.413856 | Event ID: 6fb7eee0-a21a-11f0-8184-b24382cfc188 2025-10-05 18:38:23.419107 | 2025-10-05 18:38:23.419233 | LOOP [emit-job-header : Print node information] 2025-10-05 18:38:23.587585 | debian-bookworm | ok: 2025-10-05 18:38:23.587786 | debian-bookworm | # Node Information 2025-10-05 18:38:23.587821 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-05 18:38:23.587847 | debian-bookworm | Hostname: debian 2025-10-05 18:38:23.587870 | debian-bookworm | Username: zuul 2025-10-05 18:38:23.587891 | debian-bookworm | Distro: Debian 12.12 2025-10-05 18:38:23.587914 | debian-bookworm | Provider: regiocloud-a 2025-10-05 18:38:23.587936 | debian-bookworm | Region: 2025-10-05 18:38:23.587956 | debian-bookworm | Label: debian-bookworm 2025-10-05 18:38:23.587975 | debian-bookworm | Product Name: OpenStack Nova 2025-10-05 18:38:23.587994 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe36:892f 2025-10-05 18:38:23.603682 | 2025-10-05 18:38:23.603829 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-05 18:38:24.325134 | debian-bookworm -> localhost | changed 2025-10-05 18:38:24.332664 | 2025-10-05 18:38:24.332784 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-05 18:38:25.713258 | debian-bookworm -> localhost | changed 2025-10-05 18:38:25.723703 | 2025-10-05 18:38:25.723804 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-05 18:38:25.955581 | debian-bookworm -> localhost | ok 2025-10-05 18:38:25.961367 | 2025-10-05 18:38:25.961488 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-05 18:38:25.989440 | debian-bookworm | ok 2025-10-05 18:38:26.022019 | debian-bookworm | included: /var/lib/zuul/builds/db1b276990ad4bf88f99646467497da5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-05 18:38:26.038471 | 2025-10-05 18:38:26.038579 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-05 18:38:28.655941 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-05 18:38:28.656103 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/db1b276990ad4bf88f99646467497da5/work/db1b276990ad4bf88f99646467497da5_id_rsa 2025-10-05 18:38:28.656135 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/db1b276990ad4bf88f99646467497da5/work/db1b276990ad4bf88f99646467497da5_id_rsa.pub 2025-10-05 18:38:28.656157 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-05 18:38:28.656179 | debian-bookworm -> localhost | SHA256:zXdTWv1Rjoxww94wbr14EOSjEcE070/6nFDgU9PyoY0 zuul-build-sshkey 2025-10-05 18:38:28.656205 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-05 18:38:28.656224 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-05 18:38:28.656240 | debian-bookworm -> localhost | | o*++ .| 2025-10-05 18:38:28.656310 | debian-bookworm -> localhost | | .B=+ +o| 2025-10-05 18:38:28.656331 | debian-bookworm -> localhost | | .o***o*| 2025-10-05 18:38:28.656348 | debian-bookworm -> localhost | | o ==+*B+| 2025-10-05 18:38:28.656364 | debian-bookworm -> localhost | | S +.=E*oo| 2025-10-05 18:38:28.656384 | debian-bookworm -> localhost | | ..Bo. | 2025-10-05 18:38:28.656401 | debian-bookworm -> localhost | | o.. | 2025-10-05 18:38:28.656419 | debian-bookworm -> localhost | | + . | 2025-10-05 18:38:28.656437 | debian-bookworm -> localhost | | + | 2025-10-05 18:38:28.656476 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-05 18:38:28.656528 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.026093 2025-10-05 18:38:28.662005 | 2025-10-05 18:38:28.662081 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-05 18:38:28.679070 | debian-bookworm | ok 2025-10-05 18:38:28.687711 | debian-bookworm | included: /var/lib/zuul/builds/db1b276990ad4bf88f99646467497da5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-05 18:38:28.694747 | 2025-10-05 18:38:28.694815 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-05 18:38:28.721878 | debian-bookworm | skipping: Conditional result was False 2025-10-05 18:38:28.726618 | 2025-10-05 18:38:28.726690 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-05 18:38:29.321326 | debian-bookworm | changed 2025-10-05 18:38:29.326517 | 2025-10-05 18:38:29.326602 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-05 18:38:29.566649 | debian-bookworm | ok 2025-10-05 18:38:29.571903 | 2025-10-05 18:38:29.571986 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-05 18:38:30.182592 | debian-bookworm | changed 2025-10-05 18:38:30.189372 | 2025-10-05 18:38:30.189471 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-05 18:38:30.799953 | debian-bookworm | changed 2025-10-05 18:38:30.805793 | 2025-10-05 18:38:30.805881 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-05 18:38:30.839066 | debian-bookworm | skipping: Conditional result was False 2025-10-05 18:38:30.845589 | 2025-10-05 18:38:30.845686 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-05 18:38:31.237918 | debian-bookworm -> localhost | changed 2025-10-05 18:38:31.249980 | 2025-10-05 18:38:31.250068 | TASK [add-build-sshkey : Add back temp key] 2025-10-05 18:38:31.524947 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/db1b276990ad4bf88f99646467497da5/work/db1b276990ad4bf88f99646467497da5_id_rsa (zuul-build-sshkey) 2025-10-05 18:38:31.525158 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012208 2025-10-05 18:38:31.532669 | 2025-10-05 18:38:31.532766 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-05 18:38:31.930433 | debian-bookworm | ok 2025-10-05 18:38:31.938166 | 2025-10-05 18:38:31.938267 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-05 18:38:31.961005 | debian-bookworm | skipping: Conditional result was False 2025-10-05 18:38:31.969285 | 2025-10-05 18:38:31.969362 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-05 18:38:32.369583 | debian-bookworm | ok 2025-10-05 18:38:32.389367 | 2025-10-05 18:38:32.389553 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-05 18:38:32.453314 | debian-bookworm | ok 2025-10-05 18:38:32.457416 | 2025-10-05 18:38:32.457525 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-05 18:38:32.739227 | debian-bookworm -> localhost | ok 2025-10-05 18:38:32.744786 | 2025-10-05 18:38:32.744859 | TASK [validate-host : Collect information about the host] 2025-10-05 18:38:33.839099 | debian-bookworm | ok 2025-10-05 18:38:33.852243 | 2025-10-05 18:38:33.852346 | TASK [validate-host : Sanitize hostname] 2025-10-05 18:38:33.965649 | debian-bookworm | ok 2025-10-05 18:38:34.015361 | 2025-10-05 18:38:34.015479 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-05 18:38:34.523854 | debian-bookworm -> localhost | changed 2025-10-05 18:38:34.529155 | 2025-10-05 18:38:34.529249 | TASK [validate-host : Collect information about zuul worker] 2025-10-05 18:38:34.974312 | debian-bookworm | ok 2025-10-05 18:38:34.980013 | 2025-10-05 18:38:34.980114 | TASK [validate-host : Write out all zuul information for each host] 2025-10-05 18:38:35.468770 | debian-bookworm -> localhost | changed 2025-10-05 18:38:35.481347 | 2025-10-05 18:38:35.481484 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-05 18:38:35.732096 | debian-bookworm | ok 2025-10-05 18:38:35.737237 | 2025-10-05 18:38:35.737321 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-05 18:38:36.804882 | debian-bookworm | changed: 2025-10-05 18:38:36.805048 | debian-bookworm | cd+++++++++ src/ 2025-10-05 18:38:36.805082 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-05 18:38:36.805107 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-05 18:38:36.805162 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-10-05 18:38:36.805188 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007271 2025-10-05 18:38:53.217222 | 2025-10-05 18:38:53.217434 | TASK [upload-logs : Upload logs to log server] 2025-10-05 18:38:53.783885 | localhost | Output suppressed because no_log was given 2025-10-05 18:38:53.787535 | 2025-10-05 18:38:53.787714 | LOOP [upload-logs : Compress console log and json output] 2025-10-05 18:38:53.851955 | localhost | skipping: Conditional result was False 2025-10-05 18:38:53.857044 | localhost | skipping: Conditional result was False 2025-10-05 18:38:53.868673 | 2025-10-05 18:38:53.868858 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-05 18:38:53.915274 | localhost | skipping: Conditional result was False 2025-10-05 18:38:53.915879 | 2025-10-05 18:38:53.919230 | localhost | skipping: Conditional result was False 2025-10-05 18:38:53.934061 | 2025-10-05 18:38:53.934259 | LOOP [upload-logs : Upload console log and json output]