2025-12-01 14:33:22.443810 | Job console starting 2025-12-01 14:33:22.456543 | Updating git repos 2025-12-01 14:33:22.505398 | Cloning repos into workspace 2025-12-01 14:33:22.556647 | Restoring repo states 2025-12-01 14:33:22.581384 | Merging changes 2025-12-01 14:33:23.281593 | Checking out repos 2025-12-01 14:33:23.337899 | Preparing playbooks 2025-12-01 14:33:24.044851 | Running Ansible setup 2025-12-01 14:33:28.525055 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-01 14:33:29.342095 | 2025-12-01 14:33:29.342268 | PLAY [Base pre] 2025-12-01 14:33:29.360066 | 2025-12-01 14:33:29.360296 | TASK [Setup log path fact] 2025-12-01 14:33:29.380455 | debian-bookworm | ok 2025-12-01 14:33:29.396465 | 2025-12-01 14:33:29.396632 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-01 14:33:29.428021 | debian-bookworm | ok 2025-12-01 14:33:29.438523 | 2025-12-01 14:33:29.438655 | TASK [emit-job-header : Print job information] 2025-12-01 14:33:29.479742 | # Job Information 2025-12-01 14:33:29.479960 | Ansible Version: 2.16.14 2025-12-01 14:33:29.480001 | Job: ansible-collection-ensure-readme 2025-12-01 14:33:29.480037 | Pipeline: check 2025-12-01 14:33:29.480061 | Executor: 521e9411259a 2025-12-01 14:33:29.480083 | Triggered by: https://github.com/osism/ansible-collection-services/pull/2033 2025-12-01 14:33:29.480106 | Event ID: 7a0481c0-ceba-11f0-9649-14d00d11e02c 2025-12-01 14:33:29.485378 | 2025-12-01 14:33:29.485491 | LOOP [emit-job-header : Print node information] 2025-12-01 14:33:29.597134 | debian-bookworm | ok: 2025-12-01 14:33:29.597343 | debian-bookworm | # Node Information 2025-12-01 14:33:29.597379 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-01 14:33:29.597405 | debian-bookworm | Hostname: debian 2025-12-01 14:33:29.597426 | debian-bookworm | Username: zuul 2025-12-01 14:33:29.597447 | debian-bookworm | Distro: Debian 12.12 2025-12-01 14:33:29.597471 | debian-bookworm | Provider: regiocloud-a 2025-12-01 14:33:29.597492 | debian-bookworm | Region: 2025-12-01 14:33:29.597514 | debian-bookworm | Label: debian-bookworm 2025-12-01 14:33:29.597533 | debian-bookworm | Product Name: OpenStack Nova 2025-12-01 14:33:29.597553 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe80:890c 2025-12-01 14:33:29.613373 | 2025-12-01 14:33:29.613516 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-01 14:33:30.104654 | debian-bookworm -> localhost | changed 2025-12-01 14:33:30.112514 | 2025-12-01 14:33:30.112660 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-01 14:33:31.226459 | debian-bookworm -> localhost | changed 2025-12-01 14:33:31.245234 | 2025-12-01 14:33:31.245475 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-01 14:33:31.550462 | debian-bookworm -> localhost | ok 2025-12-01 14:33:31.557262 | 2025-12-01 14:33:31.557384 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-01 14:33:31.587419 | debian-bookworm | ok 2025-12-01 14:33:31.608859 | debian-bookworm | included: /var/lib/zuul/builds/5d6d66c7d2d54d67a7f089311c748ed6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-01 14:33:31.615566 | 2025-12-01 14:33:31.615676 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-01 14:33:33.893441 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-01 14:33:33.893682 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/5d6d66c7d2d54d67a7f089311c748ed6/work/5d6d66c7d2d54d67a7f089311c748ed6_id_rsa 2025-12-01 14:33:33.893722 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/5d6d66c7d2d54d67a7f089311c748ed6/work/5d6d66c7d2d54d67a7f089311c748ed6_id_rsa.pub 2025-12-01 14:33:33.893750 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-01 14:33:33.893792 | debian-bookworm -> localhost | SHA256:gZvxYXrnuGluHYiSw0LOllPDlPX5sSZCU1g12dwUwqY zuul-build-sshkey 2025-12-01 14:33:33.893827 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-01 14:33:33.893849 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-01 14:33:33.893870 | debian-bookworm -> localhost | | o.oo.o=.oo. | 2025-12-01 14:33:33.893891 | debian-bookworm -> localhost | | o .+ ...=.. | 2025-12-01 14:33:33.893911 | debian-bookworm -> localhost | | o = * .o | 2025-12-01 14:33:33.893931 | debian-bookworm -> localhost | | . +. O +Eo | 2025-12-01 14:33:33.893951 | debian-bookworm -> localhost | | + + o=.S.= | 2025-12-01 14:33:33.893978 | debian-bookworm -> localhost | | B = .o.*. | 2025-12-01 14:33:33.893999 | debian-bookworm -> localhost | | . o o .... | 2025-12-01 14:33:33.894018 | debian-bookworm -> localhost | | oo. | 2025-12-01 14:33:33.894038 | debian-bookworm -> localhost | | ++ | 2025-12-01 14:33:33.894058 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-01 14:33:33.894114 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.685032 2025-12-01 14:33:33.900910 | 2025-12-01 14:33:33.901040 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-01 14:33:33.930894 | debian-bookworm | ok 2025-12-01 14:33:33.949419 | debian-bookworm | included: /var/lib/zuul/builds/5d6d66c7d2d54d67a7f089311c748ed6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-01 14:33:33.968051 | 2025-12-01 14:33:33.968184 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-01 14:33:33.992349 | debian-bookworm | skipping: Conditional result was False 2025-12-01 14:33:33.998918 | 2025-12-01 14:33:33.999052 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-01 14:33:34.774392 | debian-bookworm | changed 2025-12-01 14:33:34.783546 | 2025-12-01 14:33:34.783693 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-01 14:33:35.072244 | debian-bookworm | ok 2025-12-01 14:33:35.077988 | 2025-12-01 14:33:35.078105 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-01 14:33:35.809102 | debian-bookworm | changed 2025-12-01 14:33:35.824212 | 2025-12-01 14:33:35.824404 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-01 14:33:36.575917 | debian-bookworm | changed 2025-12-01 14:33:36.584352 | 2025-12-01 14:33:36.584496 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-01 14:33:36.629322 | debian-bookworm | skipping: Conditional result was False 2025-12-01 14:33:36.637275 | 2025-12-01 14:33:36.637400 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-01 14:33:37.330989 | debian-bookworm -> localhost | changed 2025-12-01 14:33:37.343301 | 2025-12-01 14:33:37.343445 | TASK [add-build-sshkey : Add back temp key] 2025-12-01 14:33:37.683197 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/5d6d66c7d2d54d67a7f089311c748ed6/work/5d6d66c7d2d54d67a7f089311c748ed6_id_rsa (zuul-build-sshkey) 2025-12-01 14:33:37.683464 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011327 2025-12-01 14:33:37.692194 | 2025-12-01 14:33:37.692325 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-01 14:33:38.127177 | debian-bookworm | ok 2025-12-01 14:33:38.136259 | 2025-12-01 14:33:38.136435 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-01 14:33:38.175665 | debian-bookworm | skipping: Conditional result was False 2025-12-01 14:33:38.188780 | 2025-12-01 14:33:38.188915 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-01 14:33:38.665348 | debian-bookworm | ok 2025-12-01 14:33:38.681027 | 2025-12-01 14:33:38.681240 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-01 14:33:38.722422 | debian-bookworm | ok 2025-12-01 14:33:38.729257 | 2025-12-01 14:33:38.729385 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-01 14:33:39.027913 | debian-bookworm -> localhost | ok 2025-12-01 14:33:39.035223 | 2025-12-01 14:33:39.035370 | TASK [validate-host : Collect information about the host] 2025-12-01 14:33:40.209363 | debian-bookworm | ok 2025-12-01 14:33:40.220181 | 2025-12-01 14:33:40.220319 | TASK [validate-host : Sanitize hostname] 2025-12-01 14:33:40.343677 | debian-bookworm | ok 2025-12-01 14:33:40.393958 | 2025-12-01 14:33:40.394204 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-01 14:33:41.018634 | debian-bookworm -> localhost | changed 2025-12-01 14:33:41.025401 | 2025-12-01 14:33:41.025532 | TASK [validate-host : Collect information about zuul worker] 2025-12-01 14:33:41.482431 | debian-bookworm | ok 2025-12-01 14:33:41.491344 | 2025-12-01 14:33:41.491527 | TASK [validate-host : Write out all zuul information for each host] 2025-12-01 14:33:42.179337 | debian-bookworm -> localhost | changed 2025-12-01 14:33:42.200002 | 2025-12-01 14:33:42.200185 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-01 14:33:42.489522 | debian-bookworm | ok 2025-12-01 14:33:42.495951 | 2025-12-01 14:33:42.496086 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-01 14:33:43.690596 | debian-bookworm | changed: 2025-12-01 14:33:43.691048 | debian-bookworm | cd+++++++++ src/ 2025-12-01 14:33:43.691088 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-01 14:33:43.691113 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-01 14:33:43.691135 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-12-01 14:33:43.691184 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007336 2025-12-01 14:34:01.484471 | 2025-12-01 14:34:01.484651 | TASK [upload-logs : Upload logs to log server] 2025-12-01 14:34:02.145931 | localhost | Output suppressed because no_log was given 2025-12-01 14:34:02.148199 | 2025-12-01 14:34:02.148339 | LOOP [upload-logs : Compress console log and json output] 2025-12-01 14:34:02.218498 | localhost | skipping: Conditional result was False 2025-12-01 14:34:02.224129 | localhost | skipping: Conditional result was False 2025-12-01 14:34:02.235971 | 2025-12-01 14:34:02.236247 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-01 14:34:02.290291 | localhost | skipping: Conditional result was False 2025-12-01 14:34:02.291257 | 2025-12-01 14:34:02.294937 | localhost | skipping: Conditional result was False 2025-12-01 14:34:02.303862 | 2025-12-01 14:34:02.304169 | LOOP [upload-logs : Upload console log and json output]