2026-05-14 19:42:28.761452 | Job console starting 2026-05-14 19:42:28.771048 | Updating git repos 2026-05-14 19:42:28.846678 | Cloning repos into workspace 2026-05-14 19:42:28.946329 | Restoring repo states 2026-05-14 19:42:28.978621 | Merging changes 2026-05-14 19:42:29.634622 | Checking out repos 2026-05-14 19:42:29.710610 | Preparing playbooks 2026-05-14 19:42:30.317137 | Running Ansible setup 2026-05-14 19:42:34.883615 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-14 19:42:35.912610 | 2026-05-14 19:42:35.912727 | PLAY [Base pre] 2026-05-14 19:42:35.925669 | 2026-05-14 19:42:35.925762 | TASK [Setup log path fact] 2026-05-14 19:42:35.953323 | debian-bookworm | ok 2026-05-14 19:42:35.965816 | 2026-05-14 19:42:35.965928 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-14 19:42:35.993294 | debian-bookworm | ok 2026-05-14 19:42:36.013142 | 2026-05-14 19:42:36.013260 | TASK [emit-job-header : Print job information] 2026-05-14 19:42:36.051855 | # Job Information 2026-05-14 19:42:36.052056 | Ansible Version: 2.16.14 2026-05-14 19:42:36.052093 | Job: ansible-collection-ensure-readme 2026-05-14 19:42:36.052127 | Pipeline: check 2026-05-14 19:42:36.052151 | Executor: 521e9411259a 2026-05-14 19:42:36.052171 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1782 2026-05-14 19:42:36.052193 | Event ID: 6506a810-4fc6-11f1-9571-32512711cdec 2026-05-14 19:42:36.057123 | 2026-05-14 19:42:36.057240 | LOOP [emit-job-header : Print node information] 2026-05-14 19:42:36.230964 | debian-bookworm | ok: 2026-05-14 19:42:36.231243 | debian-bookworm | # Node Information 2026-05-14 19:42:36.231280 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-14 19:42:36.231305 | debian-bookworm | Hostname: debian 2026-05-14 19:42:36.231327 | debian-bookworm | Username: zuul 2026-05-14 19:42:36.231349 | debian-bookworm | Distro: Debian 12.13 2026-05-14 19:42:36.231372 | debian-bookworm | Provider: regiocloud-a 2026-05-14 19:42:36.231393 | debian-bookworm | Region: 2026-05-14 19:42:36.231414 | debian-bookworm | Label: debian-bookworm 2026-05-14 19:42:36.231434 | debian-bookworm | Product Name: OpenStack Nova 2026-05-14 19:42:36.231453 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe45:d352 2026-05-14 19:42:36.254984 | 2026-05-14 19:42:36.255130 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-14 19:42:36.820873 | debian-bookworm -> localhost | changed 2026-05-14 19:42:36.835031 | 2026-05-14 19:42:36.835204 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-14 19:42:38.366261 | debian-bookworm -> localhost | changed 2026-05-14 19:42:38.378038 | 2026-05-14 19:42:38.378189 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-14 19:42:38.720814 | debian-bookworm -> localhost | ok 2026-05-14 19:42:38.750417 | 2026-05-14 19:42:38.750643 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-14 19:42:38.793541 | debian-bookworm | ok 2026-05-14 19:42:38.809371 | debian-bookworm | included: /var/lib/zuul/builds/6bbafaec028b458f87d5eb4693682b11/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-14 19:42:38.816189 | 2026-05-14 19:42:38.816299 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-14 19:42:40.464301 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-14 19:42:40.464960 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/6bbafaec028b458f87d5eb4693682b11/work/6bbafaec028b458f87d5eb4693682b11_id_rsa 2026-05-14 19:42:40.465081 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/6bbafaec028b458f87d5eb4693682b11/work/6bbafaec028b458f87d5eb4693682b11_id_rsa.pub 2026-05-14 19:42:40.465157 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-14 19:42:40.465226 | debian-bookworm -> localhost | SHA256:/WDqUOIuYQ9OXht3Ezs2INwTbHbs1sH3HzXQVH7VP78 zuul-build-sshkey 2026-05-14 19:42:40.465319 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-14 19:42:40.465406 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-14 19:42:40.465513 | debian-bookworm -> localhost | | . . . .+.=| 2026-05-14 19:42:40.465621 | debian-bookworm -> localhost | | = o o .++| 2026-05-14 19:42:40.465724 | debian-bookworm -> localhost | | . + + . o .*| 2026-05-14 19:42:40.465825 | debian-bookworm -> localhost | | o +.+ . o+| 2026-05-14 19:42:40.465956 | debian-bookworm -> localhost | | ..S++o =| 2026-05-14 19:42:40.466087 | debian-bookworm -> localhost | | =.oo.oBo o| 2026-05-14 19:42:40.466189 | debian-bookworm -> localhost | | = =o+.o +. .| 2026-05-14 19:42:40.466279 | debian-bookworm -> localhost | | +.oo E | 2026-05-14 19:42:40.466343 | debian-bookworm -> localhost | | .. . | 2026-05-14 19:42:40.467198 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-14 19:42:40.467375 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.112204 2026-05-14 19:42:40.474097 | 2026-05-14 19:42:40.474208 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-14 19:42:40.503649 | debian-bookworm | ok 2026-05-14 19:42:40.513226 | debian-bookworm | included: /var/lib/zuul/builds/6bbafaec028b458f87d5eb4693682b11/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-14 19:42:40.527792 | 2026-05-14 19:42:40.527938 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-14 19:42:40.553171 | debian-bookworm | skipping: Conditional result was False 2026-05-14 19:42:40.560280 | 2026-05-14 19:42:40.560414 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-14 19:42:41.311470 | debian-bookworm | changed 2026-05-14 19:42:41.317607 | 2026-05-14 19:42:41.317741 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-14 19:42:41.562307 | debian-bookworm | ok 2026-05-14 19:42:41.575723 | 2026-05-14 19:42:41.575882 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-14 19:42:42.299467 | debian-bookworm | changed 2026-05-14 19:42:42.306696 | 2026-05-14 19:42:42.306818 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-14 19:42:43.002721 | debian-bookworm | changed 2026-05-14 19:42:43.009491 | 2026-05-14 19:42:43.009611 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-14 19:42:43.033775 | debian-bookworm | skipping: Conditional result was False 2026-05-14 19:42:43.040361 | 2026-05-14 19:42:43.040479 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-14 19:42:43.797185 | debian-bookworm -> localhost | changed 2026-05-14 19:42:43.809450 | 2026-05-14 19:42:43.809617 | TASK [add-build-sshkey : Add back temp key] 2026-05-14 19:42:44.304983 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/6bbafaec028b458f87d5eb4693682b11/work/6bbafaec028b458f87d5eb4693682b11_id_rsa (zuul-build-sshkey) 2026-05-14 19:42:44.305727 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.027135 2026-05-14 19:42:44.325120 | 2026-05-14 19:42:44.325269 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-14 19:42:44.797130 | debian-bookworm | ok 2026-05-14 19:42:44.813009 | 2026-05-14 19:42:44.813142 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-14 19:42:44.862218 | debian-bookworm | skipping: Conditional result was False 2026-05-14 19:42:44.874162 | 2026-05-14 19:42:44.874294 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-14 19:42:45.374007 | debian-bookworm | ok 2026-05-14 19:42:45.398993 | 2026-05-14 19:42:45.399145 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-14 19:42:45.451581 | debian-bookworm | ok 2026-05-14 19:42:45.456988 | 2026-05-14 19:42:45.457113 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-14 19:42:45.867456 | debian-bookworm -> localhost | ok 2026-05-14 19:42:45.874402 | 2026-05-14 19:42:45.874516 | TASK [validate-host : Collect information about the host] 2026-05-14 19:42:47.306596 | debian-bookworm | ok 2026-05-14 19:42:47.317509 | 2026-05-14 19:42:47.317615 | TASK [validate-host : Sanitize hostname] 2026-05-14 19:42:47.430302 | debian-bookworm | ok 2026-05-14 19:42:47.476376 | 2026-05-14 19:42:47.476494 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-14 19:42:48.008941 | debian-bookworm -> localhost | changed 2026-05-14 19:42:48.014682 | 2026-05-14 19:42:48.014786 | TASK [validate-host : Collect information about zuul worker] 2026-05-14 19:42:48.435923 | debian-bookworm | ok 2026-05-14 19:42:48.440497 | 2026-05-14 19:42:48.440589 | TASK [validate-host : Write out all zuul information for each host] 2026-05-14 19:42:49.032924 | debian-bookworm -> localhost | changed 2026-05-14 19:42:49.044285 | 2026-05-14 19:42:49.044387 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-14 19:42:49.317336 | debian-bookworm | ok 2026-05-14 19:42:49.326221 | 2026-05-14 19:42:49.326349 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-14 19:42:50.437735 | debian-bookworm | changed: 2026-05-14 19:42:50.437923 | debian-bookworm | cd+++++++++ src/ 2026-05-14 19:42:50.437958 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-14 19:42:50.437981 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-14 19:42:50.438002 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2026-05-14 19:42:50.438022 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/6bbafaec028b458f87d5eb4693682b11/work/logs" 2026-05-14 19:43:09.193957 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/6bbafaec028b458f87d5eb4693682b11/work/artifacts" 2026-05-14 19:43:09.699965 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/6bbafaec028b458f87d5eb4693682b11/work/docs" 2026-05-14 19:43:09.718548 | 2026-05-14 19:43:09.718747 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-14 19:43:10.872567 | debian-bookworm | changed: 2026-05-14 19:43:10.874935 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-14 19:43:10.875030 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-14 19:43:10.875064 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-14 19:43:10.875124 | debian-bookworm | changed: All items complete 2026-05-14 19:43:10.875151 | 2026-05-14 19:43:11.881722 | debian-bookworm | changed: .d..t...... ./ 2026-05-14 19:43:13.052919 | debian-bookworm | changed: .d..t...... ./ 2026-05-14 19:43:13.084180 | 2026-05-14 19:43:13.085464 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-14 19:43:14.311687 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.062759 2026-05-14 19:43:15.124767 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.056548 2026-05-14 19:43:15.133776 | 2026-05-14 19:43:15.133881 | PLAY RECAP 2026-05-14 19:43:15.133981 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-14 19:43:15.134006 | 2026-05-14 19:43:15.681656 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-14 19:43:15.682559 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-14 19:43:16.966980 | 2026-05-14 19:43:16.967164 | PLAY [Base post] 2026-05-14 19:43:16.981179 | 2026-05-14 19:43:16.981336 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-14 19:43:17.559353 | debian-bookworm | changed 2026-05-14 19:43:17.569792 | 2026-05-14 19:43:17.569925 | PLAY RECAP 2026-05-14 19:43:17.569989 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-14 19:43:17.570056 | 2026-05-14 19:43:17.719716 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-14 19:43:17.720477 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-14 19:43:18.566264 | 2026-05-14 19:43:18.566397 | PLAY [Base post-logs] 2026-05-14 19:43:18.588663 | 2026-05-14 19:43:18.588795 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-14 19:43:19.153737 | localhost | changed 2026-05-14 19:43:19.164069 | 2026-05-14 19:43:19.164204 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-14 19:43:19.219314 | localhost | ok 2026-05-14 19:43:19.222305 | 2026-05-14 19:43:19.222399 | TASK [Set zuul-log-path fact] 2026-05-14 19:43:19.257601 | localhost | ok 2026-05-14 19:43:19.265198 | 2026-05-14 19:43:19.265300 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-14 19:43:19.289788 | localhost | ok 2026-05-14 19:43:19.292770 | 2026-05-14 19:43:19.292851 | TASK [upload-logs : Create log directories] 2026-05-14 19:43:19.967983 | localhost | changed 2026-05-14 19:43:19.970798 | 2026-05-14 19:43:19.971003 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-14 19:43:20.692748 | localhost -> localhost | ok: Runtime: 0:00:00.015457 2026-05-14 19:43:20.697548 | 2026-05-14 19:43:20.697674 | TASK [upload-logs : Upload logs to log server] 2026-05-14 19:43:21.996926 | localhost | Output suppressed because no_log was given 2026-05-14 19:43:21.998826 | 2026-05-14 19:43:21.999007 | LOOP [upload-logs : Compress console log and json output] 2026-05-14 19:43:22.102501 | localhost | skipping: Conditional result was False 2026-05-14 19:43:22.146322 | localhost | skipping: Conditional result was False 2026-05-14 19:43:22.150305 | 2026-05-14 19:43:22.150458 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-14 19:43:22.336106 | localhost | skipping: Conditional result was False 2026-05-14 19:43:22.336441 | 2026-05-14 19:43:22.362978 | localhost | skipping: Conditional result was False 2026-05-14 19:43:22.374750 | 2026-05-14 19:43:22.374943 | LOOP [upload-logs : Upload console log and json output]