2026-05-18 03:10:27.907291 | Job console starting 2026-05-18 03:10:27.961262 | Updating git repos 2026-05-18 03:10:28.028155 | Cloning repos into workspace 2026-05-18 03:10:28.139988 | Restoring repo states 2026-05-18 03:10:28.158413 | Merging changes 2026-05-18 03:10:28.158440 | Checking out repos 2026-05-18 03:10:28.231934 | Preparing playbooks 2026-05-18 03:10:29.730092 | Running Ansible setup 2026-05-18 03:10:35.764656 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-18 03:10:36.681316 | 2026-05-18 03:10:36.681509 | PLAY [Base pre] 2026-05-18 03:10:36.702350 | 2026-05-18 03:10:36.702526 | TASK [Setup log path fact] 2026-05-18 03:10:36.749326 | debian-bookworm | ok 2026-05-18 03:10:36.772814 | 2026-05-18 03:10:36.772989 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-18 03:10:36.803887 | debian-bookworm | ok 2026-05-18 03:10:36.814868 | 2026-05-18 03:10:36.815028 | TASK [emit-job-header : Print job information] 2026-05-18 03:10:36.876878 | # Job Information 2026-05-18 03:10:36.877095 | Ansible Version: 2.16.14 2026-05-18 03:10:36.877130 | Job: ansible-lint 2026-05-18 03:10:36.877164 | Pipeline: periodic-daily 2026-05-18 03:10:36.877186 | Executor: 521e9411259a 2026-05-18 03:10:36.877207 | Triggered by: https://github.com/osism/calendar 2026-05-18 03:10:36.877229 | Event ID: d84930d25bc941e7af9b1081623b2128 2026-05-18 03:10:36.882538 | 2026-05-18 03:10:36.882676 | LOOP [emit-job-header : Print node information] 2026-05-18 03:10:37.072761 | debian-bookworm | ok: 2026-05-18 03:10:37.072978 | debian-bookworm | # Node Information 2026-05-18 03:10:37.073013 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-18 03:10:37.073039 | debian-bookworm | Hostname: debian 2026-05-18 03:10:37.073061 | debian-bookworm | Username: zuul 2026-05-18 03:10:37.073082 | debian-bookworm | Distro: Debian 12.14 2026-05-18 03:10:37.073107 | debian-bookworm | Provider: regiocloud-a 2026-05-18 03:10:37.073129 | debian-bookworm | Region: 2026-05-18 03:10:37.073149 | debian-bookworm | Label: debian-bookworm 2026-05-18 03:10:37.073169 | debian-bookworm | Product Name: OpenStack Nova 2026-05-18 03:10:37.073188 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fee4:6e7e 2026-05-18 03:10:37.095229 | 2026-05-18 03:10:37.095402 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-18 03:10:37.784976 | debian-bookworm -> localhost | changed 2026-05-18 03:10:37.794240 | 2026-05-18 03:10:37.794388 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-18 03:10:38.950689 | debian-bookworm -> localhost | changed 2026-05-18 03:10:38.962644 | 2026-05-18 03:10:38.962762 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-18 03:10:39.297517 | debian-bookworm -> localhost | ok 2026-05-18 03:10:39.303748 | 2026-05-18 03:10:39.303855 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-18 03:10:39.325801 | debian-bookworm | ok 2026-05-18 03:10:39.342749 | debian-bookworm | included: /var/lib/zuul/builds/b39df434b9de4c419e4846b9e832f517/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-18 03:10:39.348656 | 2026-05-18 03:10:39.348774 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-18 03:10:41.179289 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-18 03:10:41.179464 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/b39df434b9de4c419e4846b9e832f517/work/b39df434b9de4c419e4846b9e832f517_id_rsa 2026-05-18 03:10:41.179496 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/b39df434b9de4c419e4846b9e832f517/work/b39df434b9de4c419e4846b9e832f517_id_rsa.pub 2026-05-18 03:10:41.179517 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-18 03:10:41.179537 | debian-bookworm -> localhost | SHA256:lPgCDTY9/qt5wkzTbE/7sauZg0yibmwat0zm7gU4nYE zuul-build-sshkey 2026-05-18 03:10:41.179554 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-18 03:10:41.179579 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-18 03:10:41.179597 | debian-bookworm -> localhost | | +. | 2026-05-18 03:10:41.179614 | debian-bookworm -> localhost | | o +o. . | 2026-05-18 03:10:41.179631 | debian-bookworm -> localhost | | E o.o.o | 2026-05-18 03:10:41.179646 | debian-bookworm -> localhost | | o +.o | 2026-05-18 03:10:41.179662 | debian-bookworm -> localhost | | o + .+S | 2026-05-18 03:10:41.179681 | debian-bookworm -> localhost | | . .+.* . | 2026-05-18 03:10:41.179728 | debian-bookworm -> localhost | | ..+=.* = .. | 2026-05-18 03:10:41.179750 | debian-bookworm -> localhost | | B=o+.= +o o | 2026-05-18 03:10:41.179768 | debian-bookworm -> localhost | | .BB o+ +++. | 2026-05-18 03:10:41.179793 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-18 03:10:41.179837 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.372741 2026-05-18 03:10:41.193909 | 2026-05-18 03:10:41.194009 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-18 03:10:41.226154 | debian-bookworm | ok 2026-05-18 03:10:41.235713 | debian-bookworm | included: /var/lib/zuul/builds/b39df434b9de4c419e4846b9e832f517/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-18 03:10:41.245912 | 2026-05-18 03:10:41.246079 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-18 03:10:41.281467 | debian-bookworm | skipping: Conditional result was False 2026-05-18 03:10:41.288118 | 2026-05-18 03:10:41.288255 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-18 03:10:41.901152 | debian-bookworm | changed 2026-05-18 03:10:41.917563 | 2026-05-18 03:10:41.917773 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-18 03:10:42.141445 | debian-bookworm | ok 2026-05-18 03:10:42.147126 | 2026-05-18 03:10:42.147245 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-18 03:10:42.831735 | debian-bookworm | changed 2026-05-18 03:10:42.838493 | 2026-05-18 03:10:42.838598 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-18 03:10:43.570173 | debian-bookworm | changed 2026-05-18 03:10:43.575726 | 2026-05-18 03:10:43.575834 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-18 03:10:43.597614 | debian-bookworm | skipping: Conditional result was False 2026-05-18 03:10:43.607939 | 2026-05-18 03:10:43.608072 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-18 03:10:44.139323 | debian-bookworm -> localhost | changed 2026-05-18 03:10:44.160847 | 2026-05-18 03:10:44.160959 | TASK [add-build-sshkey : Add back temp key] 2026-05-18 03:10:44.843001 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/b39df434b9de4c419e4846b9e832f517/work/b39df434b9de4c419e4846b9e832f517_id_rsa (zuul-build-sshkey) 2026-05-18 03:10:44.843296 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.039362 2026-05-18 03:10:44.854322 | 2026-05-18 03:10:44.854468 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-18 03:10:45.487289 | debian-bookworm | ok 2026-05-18 03:10:45.506986 | 2026-05-18 03:10:45.507124 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-18 03:10:45.555467 | debian-bookworm | skipping: Conditional result was False 2026-05-18 03:10:45.583596 | 2026-05-18 03:10:45.587351 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-18 03:10:46.588994 | debian-bookworm | ok 2026-05-18 03:10:46.613876 | 2026-05-18 03:10:46.614026 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-18 03:10:46.667164 | debian-bookworm | ok 2026-05-18 03:10:46.673056 | 2026-05-18 03:10:46.673208 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-18 03:10:47.462932 | debian-bookworm -> localhost | ok 2026-05-18 03:10:47.470415 | 2026-05-18 03:10:47.470534 | TASK [validate-host : Collect information about the host] 2026-05-18 03:10:48.555415 | debian-bookworm | ok 2026-05-18 03:10:48.567170 | 2026-05-18 03:10:48.567266 | TASK [validate-host : Sanitize hostname] 2026-05-18 03:10:48.698575 | debian-bookworm | ok 2026-05-18 03:10:48.727023 | 2026-05-18 03:10:48.727123 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-18 03:10:49.237296 | debian-bookworm -> localhost | changed 2026-05-18 03:10:49.242127 | 2026-05-18 03:10:49.242221 | TASK [validate-host : Collect information about zuul worker] 2026-05-18 03:10:49.775898 | debian-bookworm | ok 2026-05-18 03:10:49.781109 | 2026-05-18 03:10:49.781210 | TASK [validate-host : Write out all zuul information for each host] 2026-05-18 03:10:50.964795 | debian-bookworm -> localhost | changed 2026-05-18 03:10:50.973959 | 2026-05-18 03:10:50.974986 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-18 03:10:51.244115 | debian-bookworm | ok 2026-05-18 03:10:51.249626 | 2026-05-18 03:10:51.249756 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-18 03:10:52.113491 | debian-bookworm | changed: 2026-05-18 03:10:52.113654 | debian-bookworm | cd+++++++++ src/ 2026-05-18 03:10:52.113697 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-18 03:10:52.113722 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-18 03:10:52.113744 | debian-bookworm | cd+++++++++ src/github.com/osism/calendar/ 2026-05-18 03:10:52.113764 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/b39df434b9de4c419e4846b9e832f517/work/logs" 2026-05-18 03:11:37.418311 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/b39df434b9de4c419e4846b9e832f517/work/artifacts" 2026-05-18 03:11:37.724564 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/b39df434b9de4c419e4846b9e832f517/work/docs" 2026-05-18 03:11:37.742977 | 2026-05-18 03:11:37.743257 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-18 03:11:38.805490 | debian-bookworm | changed: 2026-05-18 03:11:38.805866 | debian-bookworm | .d..t...... ./ 2026-05-18 03:11:38.805922 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-18 03:11:38.805969 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-18 03:11:38.806009 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-18 03:11:38.806072 | debian-bookworm | changed: All items complete 2026-05-18 03:11:38.806109 | 2026-05-18 03:11:39.419242 | debian-bookworm | changed: .d..t...... ./ 2026-05-18 03:11:40.103620 | debian-bookworm | changed: .d..t...... ./ 2026-05-18 03:11:40.116898 | 2026-05-18 03:11:40.117043 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-18 03:11:40.144224 | debian-bookworm | skipping: Conditional result was False 2026-05-18 03:11:40.151023 | debian-bookworm | skipping: Conditional result was False 2026-05-18 03:11:40.159309 | 2026-05-18 03:11:40.159414 | PLAY RECAP 2026-05-18 03:11:40.159473 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-18 03:11:40.159500 | 2026-05-18 03:11:40.329733 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-18 03:11:40.330771 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-18 03:11:41.326587 | 2026-05-18 03:11:41.326818 | PLAY [Base post] 2026-05-18 03:11:41.343553 | 2026-05-18 03:11:41.343773 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-18 03:11:42.030945 | debian-bookworm | changed 2026-05-18 03:11:42.040166 | 2026-05-18 03:11:42.040303 | PLAY RECAP 2026-05-18 03:11:42.040368 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-18 03:11:42.040441 | 2026-05-18 03:11:42.217119 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-18 03:11:42.218024 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-18 03:11:43.290140 | 2026-05-18 03:11:43.290410 | PLAY [Base post-logs] 2026-05-18 03:11:43.303666 | 2026-05-18 03:11:43.303890 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-18 03:11:43.861516 | localhost | changed 2026-05-18 03:11:43.873830 | 2026-05-18 03:11:43.874049 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-18 03:11:43.902049 | localhost | ok 2026-05-18 03:11:43.906395 | 2026-05-18 03:11:43.906542 | TASK [Set zuul-log-path fact] 2026-05-18 03:11:43.926244 | localhost | ok 2026-05-18 03:11:43.935970 | 2026-05-18 03:11:43.936180 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-18 03:11:43.963402 | localhost | ok 2026-05-18 03:11:43.967651 | 2026-05-18 03:11:43.967801 | TASK [upload-logs : Create log directories] 2026-05-18 03:11:44.809151 | localhost | changed 2026-05-18 03:11:44.812512 | 2026-05-18 03:11:44.812686 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-18 03:11:45.564418 | localhost -> localhost | ok: Runtime: 0:00:00.031126 2026-05-18 03:11:45.569598 | 2026-05-18 03:11:45.569786 | TASK [upload-logs : Upload logs to log server] 2026-05-18 03:11:46.285344 | localhost | Output suppressed because no_log was given 2026-05-18 03:11:46.287760 | 2026-05-18 03:11:46.287900 | LOOP [upload-logs : Compress console log and json output] 2026-05-18 03:11:46.355386 | localhost | skipping: Conditional result was False 2026-05-18 03:11:46.361812 | localhost | skipping: Conditional result was False 2026-05-18 03:11:46.366650 | 2026-05-18 03:11:46.366855 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-18 03:11:46.425291 | localhost | skipping: Conditional result was False 2026-05-18 03:11:46.425643 | 2026-05-18 03:11:46.432643 | localhost | skipping: Conditional result was False 2026-05-18 03:11:46.446483 | 2026-05-18 03:11:46.446693 | LOOP [upload-logs : Upload console log and json output]