2026-05-06 22:02:00.675675 | Job console starting 2026-05-06 22:02:00.698019 | Updating git repos 2026-05-06 22:02:00.750713 | Cloning repos into workspace 2026-05-06 22:02:00.870085 | Restoring repo states 2026-05-06 22:02:00.880323 | Merging changes 2026-05-06 22:02:01.711392 | Checking out repos 2026-05-06 22:02:01.805489 | Preparing playbooks 2026-05-06 22:02:03.525203 | Running Ansible setup 2026-05-06 22:03:29.489881 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-06 22:03:30.271743 | 2026-05-06 22:03:30.271922 | PLAY [Base pre] 2026-05-06 22:03:30.289743 | 2026-05-06 22:03:30.289890 | TASK [Setup log path fact] 2026-05-06 22:03:30.319517 | debian-bookworm | ok 2026-05-06 22:03:30.335918 | 2026-05-06 22:03:30.336078 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-06 22:03:30.377480 | debian-bookworm | ok 2026-05-06 22:03:30.389341 | 2026-05-06 22:03:30.389472 | TASK [emit-job-header : Print job information] 2026-05-06 22:03:30.446218 | # Job Information 2026-05-06 22:03:30.446565 | Ansible Version: 2.16.14 2026-05-06 22:03:30.446635 | Job: yamllint 2026-05-06 22:03:30.446693 | Pipeline: check 2026-05-06 22:03:30.446733 | Executor: 521e9411259a 2026-05-06 22:03:30.446772 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/832 2026-05-06 22:03:30.446811 | Event ID: 2edb4f50-4997-11f1-8df3-3a5162997436 2026-05-06 22:03:30.453922 | 2026-05-06 22:03:30.454068 | LOOP [emit-job-header : Print node information] 2026-05-06 22:03:30.569740 | debian-bookworm | ok: 2026-05-06 22:03:30.570049 | debian-bookworm | # Node Information 2026-05-06 22:03:30.570113 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-06 22:03:30.570161 | debian-bookworm | Hostname: debian 2026-05-06 22:03:30.570202 | debian-bookworm | Username: zuul 2026-05-06 22:03:30.570240 | debian-bookworm | Distro: Debian 12.13 2026-05-06 22:03:30.570282 | debian-bookworm | Provider: regiocloud-a 2026-05-06 22:03:30.570320 | debian-bookworm | Region: 2026-05-06 22:03:30.570356 | debian-bookworm | Label: debian-bookworm 2026-05-06 22:03:30.570391 | debian-bookworm | Product Name: OpenStack Nova 2026-05-06 22:03:30.570425 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fed6:4172 2026-05-06 22:03:30.597600 | 2026-05-06 22:03:30.597764 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-06 22:03:31.099220 | debian-bookworm -> localhost | changed 2026-05-06 22:03:31.114154 | 2026-05-06 22:03:31.114365 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-06 22:03:32.262173 | debian-bookworm -> localhost | changed 2026-05-06 22:03:32.273925 | 2026-05-06 22:03:32.274059 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-06 22:03:32.563316 | debian-bookworm -> localhost | ok 2026-05-06 22:03:32.577323 | 2026-05-06 22:03:32.577561 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-06 22:03:32.605124 | debian-bookworm | ok 2026-05-06 22:03:32.621815 | debian-bookworm | included: /var/lib/zuul/builds/d51cdf03f7b14109bc07279a856e3530/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-06 22:03:32.628083 | 2026-05-06 22:03:32.628183 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-06 22:03:34.130609 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-06 22:03:34.130916 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d51cdf03f7b14109bc07279a856e3530/work/d51cdf03f7b14109bc07279a856e3530_id_rsa 2026-05-06 22:03:34.130970 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d51cdf03f7b14109bc07279a856e3530/work/d51cdf03f7b14109bc07279a856e3530_id_rsa.pub 2026-05-06 22:03:34.131007 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-06 22:03:34.131041 | debian-bookworm -> localhost | SHA256:HzAe4u2sVquyJ8HCLTP7CmsXEC5QSy1XiGadyKOWkPw zuul-build-sshkey 2026-05-06 22:03:34.131071 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-06 22:03:34.131119 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-06 22:03:34.131149 | debian-bookworm -> localhost | |.+o= +. | 2026-05-06 22:03:34.131179 | debian-bookworm -> localhost | |++O.* | 2026-05-06 22:03:34.131206 | debian-bookworm -> localhost | |++=+ . + | 2026-05-06 22:03:34.131231 | debian-bookworm -> localhost | |o= E . + + | 2026-05-06 22:03:34.131258 | debian-bookworm -> localhost | |o..o . S . | 2026-05-06 22:03:34.131295 | debian-bookworm -> localhost | | *.+ o.. . | 2026-05-06 22:03:34.131323 | debian-bookworm -> localhost | |. *.. .o.. | 2026-05-06 22:03:34.131354 | debian-bookworm -> localhost | | +..o o.. | 2026-05-06 22:03:34.131383 | debian-bookworm -> localhost | |o ooo*o. | 2026-05-06 22:03:34.131411 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-06 22:03:34.131479 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.982514 2026-05-06 22:03:34.139927 | 2026-05-06 22:03:34.140070 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-06 22:03:34.160105 | debian-bookworm | ok 2026-05-06 22:03:34.169478 | debian-bookworm | included: /var/lib/zuul/builds/d51cdf03f7b14109bc07279a856e3530/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-06 22:03:34.178554 | 2026-05-06 22:03:34.178654 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-06 22:03:34.192727 | debian-bookworm | skipping: Conditional result was False 2026-05-06 22:03:34.198602 | 2026-05-06 22:03:34.198707 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-06 22:03:34.814577 | debian-bookworm | changed 2026-05-06 22:03:34.823966 | 2026-05-06 22:03:34.824116 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-06 22:03:35.073012 | debian-bookworm | ok 2026-05-06 22:03:35.081981 | 2026-05-06 22:03:35.082131 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-06 22:03:35.757372 | debian-bookworm | changed 2026-05-06 22:03:35.768481 | 2026-05-06 22:03:35.768721 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-06 22:03:36.414770 | debian-bookworm | changed 2026-05-06 22:03:36.423696 | 2026-05-06 22:03:36.423840 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-06 22:03:36.448341 | debian-bookworm | skipping: Conditional result was False 2026-05-06 22:03:36.460126 | 2026-05-06 22:03:36.460299 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-06 22:03:36.921794 | debian-bookworm -> localhost | changed 2026-05-06 22:03:36.942797 | 2026-05-06 22:03:36.943019 | TASK [add-build-sshkey : Add back temp key] 2026-05-06 22:03:37.321979 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d51cdf03f7b14109bc07279a856e3530/work/d51cdf03f7b14109bc07279a856e3530_id_rsa (zuul-build-sshkey) 2026-05-06 22:03:37.322306 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019824 2026-05-06 22:03:37.331239 | 2026-05-06 22:03:37.331379 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-06 22:03:37.756939 | debian-bookworm | ok 2026-05-06 22:03:37.762262 | 2026-05-06 22:03:37.762378 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-06 22:03:37.796185 | debian-bookworm | skipping: Conditional result was False 2026-05-06 22:03:37.807117 | 2026-05-06 22:03:37.807225 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-06 22:03:38.269587 | debian-bookworm | ok 2026-05-06 22:03:38.284407 | 2026-05-06 22:03:38.284608 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-06 22:03:38.321371 | debian-bookworm | ok 2026-05-06 22:03:38.329611 | 2026-05-06 22:03:38.329778 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-06 22:03:38.661600 | debian-bookworm -> localhost | ok 2026-05-06 22:03:38.671561 | 2026-05-06 22:03:38.671711 | TASK [validate-host : Collect information about the host] 2026-05-06 22:04:19.875328 | debian-bookworm | ok 2026-05-06 22:04:19.888888 | 2026-05-06 22:04:19.889036 | TASK [validate-host : Sanitize hostname] 2026-05-06 22:04:20.021859 | debian-bookworm | ok 2026-05-06 22:04:20.112644 | 2026-05-06 22:04:20.112803 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-06 22:04:21.088760 | debian-bookworm -> localhost | changed 2026-05-06 22:04:21.095241 | 2026-05-06 22:04:21.095423 | TASK [validate-host : Collect information about zuul worker] 2026-05-06 22:04:21.556515 | debian-bookworm | ok 2026-05-06 22:04:21.561640 | 2026-05-06 22:04:21.561777 | TASK [validate-host : Write out all zuul information for each host] 2026-05-06 22:04:22.604534 | debian-bookworm -> localhost | changed 2026-05-06 22:04:22.615386 | 2026-05-06 22:04:22.615576 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-06 22:04:22.925402 | debian-bookworm | ok 2026-05-06 22:04:22.934926 | 2026-05-06 22:04:22.935104 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-06 22:04:23.845384 | debian-bookworm | changed: 2026-05-06 22:04:23.845656 | debian-bookworm | cd+++++++++ src/ 2026-05-06 22:04:23.845695 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-06 22:04:23.845719 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-06 22:04:23.845741 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2026-05-06 22:04:23.845762 | debian-bookworm | Containerfile 2026-05-06 22:04:23.845896 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/d51cdf03f7b14109bc07279a856e3530/work/logs" 2026-05-06 22:08:42.391819 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/d51cdf03f7b14109bc07279a856e3530/work/artifacts" 2026-05-06 22:08:42.649080 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/d51cdf03f7b14109bc07279a856e3530/work/docs" 2026-05-06 22:08:42.677277 | 2026-05-06 22:08:42.677445 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-06 22:08:43.513020 | debian-bookworm | changed: 2026-05-06 22:08:43.513530 | debian-bookworm | .d..t...... ./ 2026-05-06 22:08:43.513627 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-06 22:08:43.513734 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-06 22:08:43.513823 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-06 22:08:43.513937 | debian-bookworm | changed: All items complete 2026-05-06 22:08:43.514008 | 2026-05-06 22:08:44.090633 | debian-bookworm | changed: .d..t...... ./ 2026-05-06 22:08:44.676116 | debian-bookworm | changed: .d..t...... ./ 2026-05-06 22:08:44.705030 | 2026-05-06 22:08:44.705240 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-06 22:08:45.208117 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.010440 2026-05-06 22:08:45.507933 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.008410 2026-05-06 22:08:45.523687 | 2026-05-06 22:08:45.523799 | PLAY RECAP 2026-05-06 22:08:45.523862 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-06 22:08:45.523894 | 2026-05-06 22:08:45.661641 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-06 22:08:45.663089 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-06 22:08:46.414235 | 2026-05-06 22:08:46.414413 | PLAY [Base post] 2026-05-06 22:08:46.428881 | 2026-05-06 22:08:46.429021 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-06 22:08:47.059191 | debian-bookworm | changed 2026-05-06 22:08:47.069976 | 2026-05-06 22:08:47.070154 | PLAY RECAP 2026-05-06 22:08:47.070243 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-06 22:08:47.070325 | 2026-05-06 22:08:47.199837 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-06 22:08:47.200741 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-06 22:08:47.994025 | 2026-05-06 22:08:47.994205 | PLAY [Base post-logs] 2026-05-06 22:08:48.005683 | 2026-05-06 22:08:48.005840 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-06 22:08:48.525627 | localhost | changed 2026-05-06 22:08:48.540994 | 2026-05-06 22:08:48.541317 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-06 22:08:48.595723 | localhost | ok 2026-05-06 22:08:48.602447 | 2026-05-06 22:08:48.602784 | TASK [Set zuul-log-path fact] 2026-05-06 22:08:48.634196 | localhost | ok 2026-05-06 22:08:48.658088 | 2026-05-06 22:08:48.658291 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-06 22:08:48.687235 | localhost | ok 2026-05-06 22:08:48.690559 | 2026-05-06 22:08:48.690669 | TASK [upload-logs : Create log directories] 2026-05-06 22:08:49.276505 | localhost | changed 2026-05-06 22:08:49.281172 | 2026-05-06 22:08:49.281337 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-06 22:08:49.846813 | localhost -> localhost | ok: Runtime: 0:00:00.007556 2026-05-06 22:08:49.851334 | 2026-05-06 22:08:49.851463 | TASK [upload-logs : Upload logs to log server] 2026-05-06 22:08:50.440185 | localhost | Output suppressed because no_log was given 2026-05-06 22:08:50.444578 | 2026-05-06 22:08:50.444784 | LOOP [upload-logs : Compress console log and json output] 2026-05-06 22:08:50.494741 | localhost | skipping: Conditional result was False 2026-05-06 22:08:50.499909 | localhost | skipping: Conditional result was False 2026-05-06 22:08:50.507457 | 2026-05-06 22:08:50.507760 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-06 22:08:50.566333 | localhost | skipping: Conditional result was False 2026-05-06 22:08:50.566651 | 2026-05-06 22:08:50.573560 | localhost | skipping: Conditional result was False 2026-05-06 22:08:50.591047 | 2026-05-06 22:08:50.591303 | LOOP [upload-logs : Upload console log and json output]