2026-05-18 12:12:05.892313 | Job console starting 2026-05-18 12:12:05.913600 | Updating git repos 2026-05-18 12:12:05.954746 | Cloning repos into workspace 2026-05-18 12:12:06.029075 | Restoring repo states 2026-05-18 12:12:06.052674 | Merging changes 2026-05-18 12:12:06.656923 | Checking out repos 2026-05-18 12:12:06.709960 | Preparing playbooks 2026-05-18 12:12:07.797518 | Running Ansible setup 2026-05-18 12:12:12.909812 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-18 12:12:14.453562 | 2026-05-18 12:12:14.453742 | PLAY [Base pre] 2026-05-18 12:12:14.471919 | 2026-05-18 12:12:14.472075 | TASK [Setup log path fact] 2026-05-18 12:12:14.492434 | debian-bookworm | ok 2026-05-18 12:12:14.510392 | 2026-05-18 12:12:14.510566 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-18 12:12:14.572132 | debian-bookworm | ok 2026-05-18 12:12:14.587901 | 2026-05-18 12:12:14.588057 | TASK [emit-job-header : Print job information] 2026-05-18 12:12:14.642932 | # Job Information 2026-05-18 12:12:14.643213 | Ansible Version: 2.16.14 2026-05-18 12:12:14.643267 | Job: ansible-collection-ensure-readme 2026-05-18 12:12:14.643307 | Pipeline: check 2026-05-18 12:12:14.643332 | Executor: 521e9411259a 2026-05-18 12:12:14.643353 | Triggered by: https://github.com/osism/ansible-collection-validations/pull/258 2026-05-18 12:12:14.643375 | Event ID: c2ebb6c0-52b2-11f1-8180-3cc58038f89f 2026-05-18 12:12:14.657059 | 2026-05-18 12:12:14.657214 | LOOP [emit-job-header : Print node information] 2026-05-18 12:12:14.890752 | debian-bookworm | ok: 2026-05-18 12:12:14.890989 | debian-bookworm | # Node Information 2026-05-18 12:12:14.891026 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-18 12:12:14.891052 | debian-bookworm | Hostname: debian 2026-05-18 12:12:14.891075 | debian-bookworm | Username: zuul 2026-05-18 12:12:14.891095 | debian-bookworm | Distro: Debian 12.14 2026-05-18 12:12:14.891119 | debian-bookworm | Provider: regiocloud-a 2026-05-18 12:12:14.891140 | debian-bookworm | Region: 2026-05-18 12:12:14.891161 | debian-bookworm | Label: debian-bookworm 2026-05-18 12:12:14.891180 | debian-bookworm | Product Name: OpenStack Nova 2026-05-18 12:12:14.891200 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe85:8103 2026-05-18 12:12:14.910767 | 2026-05-18 12:12:14.919000 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-18 12:12:15.677886 | debian-bookworm -> localhost | changed 2026-05-18 12:12:15.687352 | 2026-05-18 12:12:15.687561 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-18 12:12:17.349666 | debian-bookworm -> localhost | changed 2026-05-18 12:12:17.360056 | 2026-05-18 12:12:17.360164 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-18 12:12:17.646883 | debian-bookworm -> localhost | ok 2026-05-18 12:12:17.652845 | 2026-05-18 12:12:17.652943 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-18 12:12:17.724271 | debian-bookworm | ok 2026-05-18 12:12:17.754736 | debian-bookworm | included: /var/lib/zuul/builds/6f4310329f834b28b17c6897c053797e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-18 12:12:17.770520 | 2026-05-18 12:12:17.770636 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-18 12:12:19.184449 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-18 12:12:19.184654 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/6f4310329f834b28b17c6897c053797e/work/6f4310329f834b28b17c6897c053797e_id_rsa 2026-05-18 12:12:19.184692 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/6f4310329f834b28b17c6897c053797e/work/6f4310329f834b28b17c6897c053797e_id_rsa.pub 2026-05-18 12:12:19.184719 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-18 12:12:19.184744 | debian-bookworm -> localhost | SHA256:/wzM+pJKBS0xhG/tYeg7xgn+UYJeso8IZHw24nYOuOc zuul-build-sshkey 2026-05-18 12:12:19.184777 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-18 12:12:19.184801 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-18 12:12:19.184822 | debian-bookworm -> localhost | | o+ | 2026-05-18 12:12:19.184844 | debian-bookworm -> localhost | | . + | 2026-05-18 12:12:19.184866 | debian-bookworm -> localhost | | .oo. | 2026-05-18 12:12:19.184886 | debian-bookworm -> localhost | |. .+o+ | 2026-05-18 12:12:19.184906 | debian-bookworm -> localhost | | = +ooooS. | 2026-05-18 12:12:19.184928 | debian-bookworm -> localhost | |= +.o+.+.+ | 2026-05-18 12:12:19.184949 | debian-bookworm -> localhost | |o+ ooooo .= | 2026-05-18 12:12:19.184969 | debian-bookworm -> localhost | |.o=..+*.o. + | 2026-05-18 12:12:19.184990 | debian-bookworm -> localhost | |.oE..o+o.o. o | 2026-05-18 12:12:19.185011 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-18 12:12:19.185058 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.839801 2026-05-18 12:12:19.191322 | 2026-05-18 12:12:19.191417 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-18 12:12:19.219801 | debian-bookworm | ok 2026-05-18 12:12:19.235210 | debian-bookworm | included: /var/lib/zuul/builds/6f4310329f834b28b17c6897c053797e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-18 12:12:19.245442 | 2026-05-18 12:12:19.245532 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-18 12:12:19.278639 | debian-bookworm | skipping: Conditional result was False 2026-05-18 12:12:19.284796 | 2026-05-18 12:12:19.284935 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-18 12:12:19.957746 | debian-bookworm | changed 2026-05-18 12:12:19.966884 | 2026-05-18 12:12:19.967015 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-18 12:12:20.219978 | debian-bookworm | ok 2026-05-18 12:12:20.225603 | 2026-05-18 12:12:20.225686 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-18 12:12:20.927132 | debian-bookworm | changed 2026-05-18 12:12:20.936787 | 2026-05-18 12:12:20.936892 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-18 12:12:21.582187 | debian-bookworm | changed 2026-05-18 12:12:21.591821 | 2026-05-18 12:12:21.591923 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-18 12:12:21.605476 | debian-bookworm | skipping: Conditional result was False 2026-05-18 12:12:21.612401 | 2026-05-18 12:12:21.612514 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-18 12:12:22.011411 | debian-bookworm -> localhost | changed 2026-05-18 12:12:22.023571 | 2026-05-18 12:12:22.023681 | TASK [add-build-sshkey : Add back temp key] 2026-05-18 12:12:22.464319 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/6f4310329f834b28b17c6897c053797e/work/6f4310329f834b28b17c6897c053797e_id_rsa (zuul-build-sshkey) 2026-05-18 12:12:22.464545 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009665 2026-05-18 12:12:22.473670 | 2026-05-18 12:12:22.473767 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-18 12:12:22.867219 | debian-bookworm | ok 2026-05-18 12:12:22.872172 | 2026-05-18 12:12:22.872275 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-18 12:12:22.900124 | debian-bookworm | skipping: Conditional result was False 2026-05-18 12:12:22.911977 | 2026-05-18 12:12:22.912079 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-18 12:12:23.344072 | debian-bookworm | ok 2026-05-18 12:12:23.354351 | 2026-05-18 12:12:23.354446 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-18 12:12:23.381788 | debian-bookworm | ok 2026-05-18 12:12:23.386681 | 2026-05-18 12:12:23.386765 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-18 12:12:23.662467 | debian-bookworm -> localhost | ok 2026-05-18 12:12:23.670027 | 2026-05-18 12:12:23.670124 | TASK [validate-host : Collect information about the host] 2026-05-18 12:12:24.761781 | debian-bookworm | ok 2026-05-18 12:12:24.777541 | 2026-05-18 12:12:24.777643 | TASK [validate-host : Sanitize hostname] 2026-05-18 12:12:24.866522 | debian-bookworm | ok 2026-05-18 12:12:24.911343 | 2026-05-18 12:12:24.911452 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-18 12:12:25.537450 | debian-bookworm -> localhost | changed 2026-05-18 12:12:25.543751 | 2026-05-18 12:12:25.543885 | TASK [validate-host : Collect information about zuul worker] 2026-05-18 12:12:26.002519 | debian-bookworm | ok 2026-05-18 12:12:26.017405 | 2026-05-18 12:12:26.017571 | TASK [validate-host : Write out all zuul information for each host] 2026-05-18 12:12:26.802491 | debian-bookworm -> localhost | changed 2026-05-18 12:12:26.815405 | 2026-05-18 12:12:26.815542 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-18 12:12:27.103289 | debian-bookworm | ok 2026-05-18 12:12:27.112713 | 2026-05-18 12:12:27.112852 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-18 12:12:28.169194 | debian-bookworm | changed: 2026-05-18 12:12:28.169500 | debian-bookworm | cd+++++++++ src/ 2026-05-18 12:12:28.169542 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-18 12:12:28.169571 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-18 12:12:28.169598 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-validations/ 2026-05-18 12:12:28.169623 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/6f4310329f834b28b17c6897c053797e/work/logs" 2026-05-18 12:12:37.193368 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/6f4310329f834b28b17c6897c053797e/work/artifacts" 2026-05-18 12:12:37.462685 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/6f4310329f834b28b17c6897c053797e/work/docs" 2026-05-18 12:12:37.482784 | 2026-05-18 12:12:37.483061 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-18 12:12:38.318181 | debian-bookworm | changed: 2026-05-18 12:12:38.318633 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-18 12:12:38.318725 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-18 12:12:38.318820 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-18 12:12:38.318954 | debian-bookworm | changed: All items complete 2026-05-18 12:12:38.319009 | 2026-05-18 12:12:38.919136 | debian-bookworm | changed: .d..t...... ./ 2026-05-18 12:12:39.538226 | debian-bookworm | changed: .d..t...... ./ 2026-05-18 12:12:39.570656 | 2026-05-18 12:12:39.570881 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-18 12:12:40.143420 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.008735 2026-05-18 12:12:40.418684 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.008161 2026-05-18 12:12:40.432432 | 2026-05-18 12:12:40.432560 | PLAY RECAP 2026-05-18 12:12:40.432626 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-18 12:12:40.432658 | 2026-05-18 12:12:40.596968 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-18 12:12:40.597860 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-18 12:12:41.380671 | 2026-05-18 12:12:41.380838 | PLAY [Base post] 2026-05-18 12:12:41.395827 | 2026-05-18 12:12:41.395974 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-18 12:12:41.984939 | debian-bookworm | changed 2026-05-18 12:12:41.994650 | 2026-05-18 12:12:41.994779 | PLAY RECAP 2026-05-18 12:12:41.994880 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-18 12:12:41.994978 | 2026-05-18 12:12:42.118565 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-18 12:12:42.119695 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-18 12:12:42.934656 | 2026-05-18 12:12:42.934876 | PLAY [Base post-logs] 2026-05-18 12:12:42.945909 | 2026-05-18 12:12:42.946050 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-18 12:12:43.481718 | localhost | changed 2026-05-18 12:12:43.499936 | 2026-05-18 12:12:43.500134 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-18 12:12:43.527435 | localhost | ok 2026-05-18 12:12:43.532644 | 2026-05-18 12:12:43.532832 | TASK [Set zuul-log-path fact] 2026-05-18 12:12:43.550248 | localhost | ok 2026-05-18 12:12:43.562109 | 2026-05-18 12:12:43.562283 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-18 12:12:43.598321 | localhost | ok 2026-05-18 12:12:43.602784 | 2026-05-18 12:12:43.602949 | TASK [upload-logs : Create log directories] 2026-05-18 12:12:44.138800 | localhost | changed 2026-05-18 12:12:44.144095 | 2026-05-18 12:12:44.144262 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-18 12:12:44.672921 | localhost -> localhost | ok: Runtime: 0:00:00.007910 2026-05-18 12:12:44.682589 | 2026-05-18 12:12:44.682896 | TASK [upload-logs : Upload logs to log server] 2026-05-18 12:12:45.308626 | localhost | Output suppressed because no_log was given 2026-05-18 12:12:45.310621 | 2026-05-18 12:12:45.310731 | LOOP [upload-logs : Compress console log and json output] 2026-05-18 12:12:45.362058 | localhost | skipping: Conditional result was False 2026-05-18 12:12:45.368096 | localhost | skipping: Conditional result was False 2026-05-18 12:12:45.379138 | 2026-05-18 12:12:45.379280 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-18 12:12:45.431069 | localhost | skipping: Conditional result was False 2026-05-18 12:12:45.431392 | 2026-05-18 12:12:45.436239 | localhost | skipping: Conditional result was False 2026-05-18 12:12:45.447514 | 2026-05-18 12:12:45.447680 | LOOP [upload-logs : Upload console log and json output]