2026-05-05 22:47:36.324101 | Job console starting 2026-05-05 22:47:36.347449 | Updating git repos 2026-05-05 22:47:36.400214 | Cloning repos into workspace 2026-05-05 22:47:36.458676 | Restoring repo states 2026-05-05 22:47:36.474068 | Merging changes 2026-05-05 22:47:37.817750 | Checking out repos 2026-05-05 22:47:37.952104 | Preparing playbooks 2026-05-05 22:47:38.738290 | Running Ansible setup 2026-05-05 22:47:44.184501 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-05 22:47:45.056341 | 2026-05-05 22:47:45.056582 | PLAY [Base pre] 2026-05-05 22:47:45.077678 | 2026-05-05 22:47:45.077838 | TASK [Setup log path fact] 2026-05-05 22:47:45.100776 | debian-bookworm | ok 2026-05-05 22:47:45.138887 | 2026-05-05 22:47:45.139049 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-05 22:47:45.167859 | debian-bookworm | ok 2026-05-05 22:47:45.177573 | 2026-05-05 22:47:45.177681 | TASK [emit-job-header : Print job information] 2026-05-05 22:47:45.226641 | # Job Information 2026-05-05 22:47:45.226818 | Ansible Version: 2.16.14 2026-05-05 22:47:45.226885 | Job: ansible-collection-ensure-readme 2026-05-05 22:47:45.226918 | Pipeline: check 2026-05-05 22:47:45.226940 | Executor: 521e9411259a 2026-05-05 22:47:45.226961 | Triggered by: https://github.com/osism/osism-kubernetes/pull/280 2026-05-05 22:47:45.226982 | Event ID: 63bbe180-48d4-11f1-9d7d-8c0e1010d022 2026-05-05 22:47:45.231941 | 2026-05-05 22:47:45.232047 | LOOP [emit-job-header : Print node information] 2026-05-05 22:47:45.332321 | debian-bookworm | ok: 2026-05-05 22:47:45.332515 | debian-bookworm | # Node Information 2026-05-05 22:47:45.332551 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-05 22:47:45.332575 | debian-bookworm | Hostname: debian 2026-05-05 22:47:45.332597 | debian-bookworm | Username: zuul 2026-05-05 22:47:45.332617 | debian-bookworm | Distro: Debian 12.13 2026-05-05 22:47:45.332640 | debian-bookworm | Provider: regiocloud-a 2026-05-05 22:47:45.332661 | debian-bookworm | Region: 2026-05-05 22:47:45.332682 | debian-bookworm | Label: debian-bookworm 2026-05-05 22:47:45.332701 | debian-bookworm | Product Name: OpenStack Nova 2026-05-05 22:47:45.332721 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe0a:5c1a 2026-05-05 22:47:45.351368 | 2026-05-05 22:47:45.351536 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-05 22:47:46.345799 | debian-bookworm -> localhost | changed 2026-05-05 22:47:46.352939 | 2026-05-05 22:47:46.353052 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-05 22:47:48.235824 | debian-bookworm -> localhost | changed 2026-05-05 22:47:48.245387 | 2026-05-05 22:47:48.245488 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-05 22:47:48.724451 | debian-bookworm -> localhost | ok 2026-05-05 22:47:48.729283 | 2026-05-05 22:47:48.729367 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-05 22:47:48.798078 | debian-bookworm | ok 2026-05-05 22:47:48.828797 | debian-bookworm | included: /var/lib/zuul/builds/c2433692ba1c4bd88aa79b6eb077b2c3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-05 22:47:48.846637 | 2026-05-05 22:47:48.846734 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-05 22:47:50.243532 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-05 22:47:50.243761 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c2433692ba1c4bd88aa79b6eb077b2c3/work/c2433692ba1c4bd88aa79b6eb077b2c3_id_rsa 2026-05-05 22:47:50.243805 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c2433692ba1c4bd88aa79b6eb077b2c3/work/c2433692ba1c4bd88aa79b6eb077b2c3_id_rsa.pub 2026-05-05 22:47:50.243833 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-05 22:47:50.243858 | debian-bookworm -> localhost | SHA256:HkUGUq63QNfO7m8/0HSEo53JYPOGIv2cAEyvfRjerS8 zuul-build-sshkey 2026-05-05 22:47:50.243892 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-05 22:47:50.243914 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-05 22:47:50.243936 | debian-bookworm -> localhost | | .++.o . | 2026-05-05 22:47:50.243959 | debian-bookworm -> localhost | | oo= + o .| 2026-05-05 22:47:50.243979 | debian-bookworm -> localhost | | . oo=. O = | 2026-05-05 22:47:50.243999 | debian-bookworm -> localhost | | . o.B++o.O .| 2026-05-05 22:47:50.244019 | debian-bookworm -> localhost | | o S.*=o=.. | 2026-05-05 22:47:50.244045 | debian-bookworm -> localhost | | + + .=.. | 2026-05-05 22:47:50.244066 | debian-bookworm -> localhost | | o . .. | 2026-05-05 22:47:50.244086 | debian-bookworm -> localhost | | . E.. | 2026-05-05 22:47:50.244106 | debian-bookworm -> localhost | | .o.oo. | 2026-05-05 22:47:50.244127 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-05 22:47:50.244183 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.637729 2026-05-05 22:47:50.250860 | 2026-05-05 22:47:50.250968 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-05 22:47:50.293417 | debian-bookworm | ok 2026-05-05 22:47:50.312549 | debian-bookworm | included: /var/lib/zuul/builds/c2433692ba1c4bd88aa79b6eb077b2c3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-05 22:47:50.329672 | 2026-05-05 22:47:50.329788 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-05 22:47:50.363541 | debian-bookworm | skipping: Conditional result was False 2026-05-05 22:47:50.369600 | 2026-05-05 22:47:50.369707 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-05 22:47:51.256269 | debian-bookworm | changed 2026-05-05 22:47:51.261823 | 2026-05-05 22:47:51.261922 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-05 22:47:51.523392 | debian-bookworm | ok 2026-05-05 22:47:51.547136 | 2026-05-05 22:47:51.547262 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-05 22:47:52.161009 | debian-bookworm | changed 2026-05-05 22:47:52.166415 | 2026-05-05 22:47:52.166498 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-05 22:47:52.840851 | debian-bookworm | changed 2026-05-05 22:47:52.848078 | 2026-05-05 22:47:52.848196 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-05 22:47:52.875122 | debian-bookworm | skipping: Conditional result was False 2026-05-05 22:47:52.881982 | 2026-05-05 22:47:52.882082 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-05 22:47:53.391986 | debian-bookworm -> localhost | changed 2026-05-05 22:47:53.401139 | 2026-05-05 22:47:53.401231 | TASK [add-build-sshkey : Add back temp key] 2026-05-05 22:47:53.779264 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c2433692ba1c4bd88aa79b6eb077b2c3/work/c2433692ba1c4bd88aa79b6eb077b2c3_id_rsa (zuul-build-sshkey) 2026-05-05 22:47:53.779496 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010033 2026-05-05 22:47:53.786798 | 2026-05-05 22:47:53.786920 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-05 22:47:54.190275 | debian-bookworm | ok 2026-05-05 22:47:54.195486 | 2026-05-05 22:47:54.195582 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-05 22:47:54.218810 | debian-bookworm | skipping: Conditional result was False 2026-05-05 22:47:54.233698 | 2026-05-05 22:47:54.233811 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-05 22:47:54.636927 | debian-bookworm | ok 2026-05-05 22:47:54.647999 | 2026-05-05 22:47:54.648122 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-05 22:47:54.676843 | debian-bookworm | ok 2026-05-05 22:47:54.681843 | 2026-05-05 22:47:54.681931 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-05 22:47:54.980247 | debian-bookworm -> localhost | ok 2026-05-05 22:47:54.986709 | 2026-05-05 22:47:54.986817 | TASK [validate-host : Collect information about the host] 2026-05-05 22:47:56.115717 | debian-bookworm | ok 2026-05-05 22:47:56.127964 | 2026-05-05 22:47:56.128073 | TASK [validate-host : Sanitize hostname] 2026-05-05 22:47:56.237761 | debian-bookworm | ok 2026-05-05 22:47:56.288090 | 2026-05-05 22:47:56.288208 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-05 22:47:57.072099 | debian-bookworm -> localhost | changed 2026-05-05 22:47:57.077641 | 2026-05-05 22:47:57.077737 | TASK [validate-host : Collect information about zuul worker] 2026-05-05 22:47:57.448495 | debian-bookworm | ok 2026-05-05 22:47:57.453109 | 2026-05-05 22:47:57.453203 | TASK [validate-host : Write out all zuul information for each host] 2026-05-05 22:47:58.178062 | debian-bookworm -> localhost | changed 2026-05-05 22:47:58.206001 | 2026-05-05 22:47:58.206131 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-05 22:47:58.486855 | debian-bookworm | ok 2026-05-05 22:47:58.492361 | 2026-05-05 22:47:58.492490 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-05 22:48:01.197851 | debian-bookworm | changed: 2026-05-05 22:48:01.198097 | debian-bookworm | cd+++++++++ src/ 2026-05-05 22:48:01.198152 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-05 22:48:01.198186 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-05 22:48:01.198209 | debian-bookworm | cd+++++++++ src/github.com/osism/osism-kubernetes/ 2026-05-05 22:48:01.198231 | debian-bookworm | Containerfile 2026-05-05 22:48:01.198443 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/c2433692ba1c4bd88aa79b6eb077b2c3/work/logs" 2026-05-05 22:48:13.473902 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/c2433692ba1c4bd88aa79b6eb077b2c3/work/artifacts" 2026-05-05 22:48:13.789193 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/c2433692ba1c4bd88aa79b6eb077b2c3/work/docs" 2026-05-05 22:48:13.809096 | 2026-05-05 22:48:13.809278 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-05 22:48:14.654494 | debian-bookworm | changed: 2026-05-05 22:48:14.654754 | debian-bookworm | .d..t...... ./ 2026-05-05 22:48:14.654790 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-05 22:48:14.654820 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-05 22:48:14.654866 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-05 22:48:14.654911 | debian-bookworm | changed: All items complete 2026-05-05 22:48:14.654938 | 2026-05-05 22:48:15.253140 | debian-bookworm | changed: .d..t...... ./ 2026-05-05 22:48:15.862537 | debian-bookworm | changed: .d..t...... ./ 2026-05-05 22:48:15.877685 | 2026-05-05 22:48:15.877849 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-05 22:48:16.480480 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.012173 2026-05-05 22:48:16.779673 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.007088 2026-05-05 22:48:16.790487 | 2026-05-05 22:48:16.790616 | PLAY RECAP 2026-05-05 22:48:16.790675 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-05 22:48:16.790702 | 2026-05-05 22:48:16.961586 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-05 22:48:16.962453 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-05 22:48:17.799804 | 2026-05-05 22:48:17.799967 | PLAY [Base post] 2026-05-05 22:48:17.813796 | 2026-05-05 22:48:17.813940 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-05 22:48:18.365464 | debian-bookworm | changed 2026-05-05 22:48:18.373290 | 2026-05-05 22:48:18.373453 | PLAY RECAP 2026-05-05 22:48:18.373524 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-05 22:48:18.373587 | 2026-05-05 22:48:18.512691 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-05 22:48:18.513608 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-05 22:48:19.422620 | 2026-05-05 22:48:19.422823 | PLAY [Base post-logs] 2026-05-05 22:48:19.434238 | 2026-05-05 22:48:19.434430 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-05 22:48:19.907235 | localhost | changed 2026-05-05 22:48:19.917665 | 2026-05-05 22:48:19.917819 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-05 22:48:19.956484 | localhost | ok 2026-05-05 22:48:19.959913 | 2026-05-05 22:48:19.960021 | TASK [Set zuul-log-path fact] 2026-05-05 22:48:19.979984 | localhost | ok 2026-05-05 22:48:19.996653 | 2026-05-05 22:48:19.996821 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-05 22:48:20.024644 | localhost | ok 2026-05-05 22:48:20.028580 | 2026-05-05 22:48:20.028693 | TASK [upload-logs : Create log directories] 2026-05-05 22:48:20.624024 | localhost | changed 2026-05-05 22:48:20.628371 | 2026-05-05 22:48:20.628583 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-05 22:48:21.309522 | localhost -> localhost | ok: Runtime: 0:00:00.008332 2026-05-05 22:48:21.321357 | 2026-05-05 22:48:21.321656 | TASK [upload-logs : Upload logs to log server] 2026-05-05 22:48:21.934707 | localhost | Output suppressed because no_log was given 2026-05-05 22:48:21.939342 | 2026-05-05 22:48:21.939582 | LOOP [upload-logs : Compress console log and json output] 2026-05-05 22:48:22.008380 | localhost | skipping: Conditional result was False 2026-05-05 22:48:22.012680 | localhost | skipping: Conditional result was False 2026-05-05 22:48:22.023272 | 2026-05-05 22:48:22.023578 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-05 22:48:22.094335 | localhost | skipping: Conditional result was False 2026-05-05 22:48:22.095191 | 2026-05-05 22:48:22.098168 | localhost | skipping: Conditional result was False 2026-05-05 22:48:22.113556 | 2026-05-05 22:48:22.113824 | LOOP [upload-logs : Upload console log and json output]