2026-08-31 03:16:03.778688 | Job console starting 2026-08-31 03:16:03.788352 | Updating git repos 2026-08-31 03:16:03.828400 | Cloning repos into workspace 2026-08-31 03:16:03.915851 | Restoring repo states 2026-08-31 03:16:03.955988 | Merging changes 2026-08-31 03:16:03.956015 | Checking out repos 2026-08-31 03:16:04.096398 | Preparing playbooks 2026-08-31 03:16:05.505173 | Running Ansible setup 2026-08-31 03:16:10.280270 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-08-31 03:16:11.595899 | 2026-08-31 03:16:11.596048 | PLAY [Base pre] 2026-08-31 03:16:11.632167 | 2026-08-31 03:16:11.632312 | TASK [Setup log path fact] 2026-08-31 03:16:11.661878 | debian-bookworm | ok 2026-08-31 03:16:11.681908 | 2026-08-31 03:16:11.682047 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-31 03:16:11.730485 | debian-bookworm | ok 2026-08-31 03:16:11.749001 | 2026-08-31 03:16:11.749126 | TASK [emit-job-header : Print job information] 2026-08-31 03:16:11.817586 | # Job Information 2026-08-31 03:16:11.817756 | Ansible Version: 2.16.14 2026-08-31 03:16:11.817790 | Job: python-black 2026-08-31 03:16:11.817823 | Pipeline: periodic-daily 2026-08-31 03:16:11.817846 | Executor: 521e9411259a 2026-08-31 03:16:11.817866 | Triggered by: https://github.com/osism/ansible-collection-services 2026-08-31 03:16:11.817888 | Event ID: dc9936c2de03425a9ab85195fddb1195 2026-08-31 03:16:11.823812 | 2026-08-31 03:16:11.823917 | LOOP [emit-job-header : Print node information] 2026-08-31 03:16:11.923085 | debian-bookworm | ok: 2026-08-31 03:16:11.923261 | debian-bookworm | # Node Information 2026-08-31 03:16:11.923294 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-08-31 03:16:11.923320 | debian-bookworm | Hostname: debian 2026-08-31 03:16:11.923342 | debian-bookworm | Username: zuul 2026-08-31 03:16:11.923363 | debian-bookworm | Distro: Debian 12.15 2026-08-31 03:16:11.923387 | debian-bookworm | Provider: regiocloud-a 2026-08-31 03:16:11.923408 | debian-bookworm | Region: 2026-08-31 03:16:11.923430 | debian-bookworm | Label: debian-bookworm 2026-08-31 03:16:11.923450 | debian-bookworm | Product Name: OpenStack Nova 2026-08-31 03:16:11.923470 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe6a:24a1 2026-08-31 03:16:11.939861 | 2026-08-31 03:16:11.939989 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-31 03:16:12.376446 | debian-bookworm -> localhost | changed 2026-08-31 03:16:12.384211 | 2026-08-31 03:16:12.384322 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-31 03:16:13.477089 | debian-bookworm -> localhost | changed 2026-08-31 03:16:13.494276 | 2026-08-31 03:16:13.494411 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-31 03:16:13.992511 | debian-bookworm -> localhost | ok 2026-08-31 03:16:14.005624 | 2026-08-31 03:16:14.005787 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-31 03:16:14.041974 | debian-bookworm | ok 2026-08-31 03:16:14.072833 | debian-bookworm | included: /var/lib/zuul/builds/d742963b7c6d4200bbf1b61c754fd5bc/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-31 03:16:14.082051 | 2026-08-31 03:16:14.082175 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-31 03:16:17.977368 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-08-31 03:16:17.977607 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d742963b7c6d4200bbf1b61c754fd5bc/work/d742963b7c6d4200bbf1b61c754fd5bc_id_rsa 2026-08-31 03:16:17.977855 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d742963b7c6d4200bbf1b61c754fd5bc/work/d742963b7c6d4200bbf1b61c754fd5bc_id_rsa.pub 2026-08-31 03:16:17.977900 | debian-bookworm -> localhost | The key fingerprint is: 2026-08-31 03:16:17.977927 | debian-bookworm -> localhost | SHA256:HjmFX9ax38qccGKcg/+AMfqfFHy5vhQRSS7JSeg3Q4s zuul-build-sshkey 2026-08-31 03:16:17.977950 | debian-bookworm -> localhost | The key's randomart image is: 2026-08-31 03:16:17.977983 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-08-31 03:16:17.978006 | debian-bookworm -> localhost | | ...+. | 2026-08-31 03:16:17.978028 | debian-bookworm -> localhost | | ..o.=.+ | 2026-08-31 03:16:17.978048 | debian-bookworm -> localhost | | ...oB.= | 2026-08-31 03:16:17.978067 | debian-bookworm -> localhost | | +E*=o +.| 2026-08-31 03:16:17.978087 | debian-bookworm -> localhost | | S =.Xo= o| 2026-08-31 03:16:17.978117 | debian-bookworm -> localhost | | . + * X = | 2026-08-31 03:16:17.978138 | debian-bookworm -> localhost | | o . + B | 2026-08-31 03:16:17.978158 | debian-bookworm -> localhost | | . . * | 2026-08-31 03:16:17.978179 | debian-bookworm -> localhost | | ..o +. | 2026-08-31 03:16:17.978199 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-08-31 03:16:17.978252 | debian-bookworm -> localhost | ok: Runtime: 0:00:03.175995 2026-08-31 03:16:17.991741 | 2026-08-31 03:16:17.991987 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-31 03:16:18.025752 | debian-bookworm | ok 2026-08-31 03:16:18.038891 | debian-bookworm | included: /var/lib/zuul/builds/d742963b7c6d4200bbf1b61c754fd5bc/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-31 03:16:18.048644 | 2026-08-31 03:16:18.048748 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-31 03:16:18.072568 | debian-bookworm | skipping: Conditional result was False 2026-08-31 03:16:18.080170 | 2026-08-31 03:16:18.080300 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-31 03:16:18.789868 | debian-bookworm | changed 2026-08-31 03:16:18.795463 | 2026-08-31 03:16:18.795575 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-31 03:16:19.090337 | debian-bookworm | ok 2026-08-31 03:16:19.096627 | 2026-08-31 03:16:19.096731 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-31 03:16:19.819738 | debian-bookworm | changed 2026-08-31 03:16:19.826640 | 2026-08-31 03:16:19.826764 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-31 03:16:20.508167 | debian-bookworm | changed 2026-08-31 03:16:20.520310 | 2026-08-31 03:16:20.520434 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-31 03:16:20.554145 | debian-bookworm | skipping: Conditional result was False 2026-08-31 03:16:20.560907 | 2026-08-31 03:16:20.561013 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-31 03:16:21.231525 | debian-bookworm -> localhost | changed 2026-08-31 03:16:21.242157 | 2026-08-31 03:16:21.242251 | TASK [add-build-sshkey : Add back temp key] 2026-08-31 03:16:21.939420 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d742963b7c6d4200bbf1b61c754fd5bc/work/d742963b7c6d4200bbf1b61c754fd5bc_id_rsa (zuul-build-sshkey) 2026-08-31 03:16:21.939686 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010558 2026-08-31 03:16:21.947003 | 2026-08-31 03:16:21.947099 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-31 03:16:22.429081 | debian-bookworm | ok 2026-08-31 03:16:22.435150 | 2026-08-31 03:16:22.435247 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-31 03:16:22.471503 | debian-bookworm | skipping: Conditional result was False 2026-08-31 03:16:22.481513 | 2026-08-31 03:16:22.481608 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-08-31 03:16:23.059624 | debian-bookworm | ok 2026-08-31 03:16:23.090289 | 2026-08-31 03:16:23.090429 | TASK [validate-host : Define zuul_info_dir fact] 2026-08-31 03:16:23.152858 | debian-bookworm | ok 2026-08-31 03:16:23.158551 | 2026-08-31 03:16:23.158646 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-08-31 03:16:24.009835 | debian-bookworm -> localhost | ok 2026-08-31 03:16:24.019098 | 2026-08-31 03:16:24.019219 | TASK [validate-host : Collect information about the host] 2026-08-31 03:16:25.676211 | debian-bookworm | ok 2026-08-31 03:16:25.716967 | 2026-08-31 03:16:25.717112 | TASK [validate-host : Sanitize hostname] 2026-08-31 03:16:25.973594 | debian-bookworm | ok 2026-08-31 03:16:25.983612 | 2026-08-31 03:16:25.983731 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-08-31 03:16:27.247319 | debian-bookworm -> localhost | changed 2026-08-31 03:16:27.252265 | 2026-08-31 03:16:27.252355 | TASK [validate-host : Collect information about zuul worker] 2026-08-31 03:16:27.685075 | debian-bookworm | ok 2026-08-31 03:16:27.693456 | 2026-08-31 03:16:27.693610 | TASK [validate-host : Write out all zuul information for each host] 2026-08-31 03:16:28.414995 | debian-bookworm -> localhost | changed 2026-08-31 03:16:28.430609 | 2026-08-31 03:16:28.430701 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-08-31 03:16:28.714600 | debian-bookworm | ok 2026-08-31 03:16:28.721306 | 2026-08-31 03:16:28.721421 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-08-31 03:16:29.824742 | debian-bookworm | changed: 2026-08-31 03:16:29.824924 | debian-bookworm | cd+++++++++ src/ 2026-08-31 03:16:29.824958 | debian-bookworm | cd+++++++++ src/github.com/ 2026-08-31 03:16:29.824982 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-08-31 03:16:29.825004 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2026-08-31 03:16:29.825026 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/d742963b7c6d4200bbf1b61c754fd5bc/work/logs" 2026-08-31 03:17:36.491766 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/d742963b7c6d4200bbf1b61c754fd5bc/work/artifacts" 2026-08-31 03:17:37.418194 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/d742963b7c6d4200bbf1b61c754fd5bc/work/docs" 2026-08-31 03:17:37.433932 | 2026-08-31 03:17:37.434106 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-31 03:17:38.437752 | debian-bookworm | changed: 2026-08-31 03:17:38.438004 | debian-bookworm | .d..t...... ./ 2026-08-31 03:17:38.438045 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-08-31 03:17:38.438069 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-08-31 03:17:38.438090 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-08-31 03:17:38.438111 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-08-31 03:17:38.438131 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-08-31 03:17:38.438174 | debian-bookworm | changed: All items complete 2026-08-31 03:17:38.438202 | 2026-08-31 03:17:39.077149 | debian-bookworm | changed: .d..t...... ./ 2026-08-31 03:17:39.971223 | debian-bookworm | changed: .d..t...... ./ 2026-08-31 03:17:39.991448 | 2026-08-31 03:17:39.991560 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-31 03:17:40.038011 | debian-bookworm | skipping: Conditional result was False 2026-08-31 03:17:40.044545 | debian-bookworm | skipping: Conditional result was False 2026-08-31 03:17:40.051101 | 2026-08-31 03:17:40.051181 | PLAY RECAP 2026-08-31 03:17:40.051225 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-08-31 03:17:40.051245 | 2026-08-31 03:17:40.174465 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-08-31 03:17:40.175246 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-31 03:17:40.959572 | 2026-08-31 03:17:40.959718 | PLAY [Base post] 2026-08-31 03:17:40.973609 | 2026-08-31 03:17:40.973753 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-31 03:17:41.523204 | debian-bookworm | changed 2026-08-31 03:17:41.529388 | 2026-08-31 03:17:41.529497 | PLAY RECAP 2026-08-31 03:17:41.529557 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-31 03:17:41.529618 | 2026-08-31 03:17:41.643278 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-31 03:17:41.645360 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-31 03:17:42.743792 | 2026-08-31 03:17:42.743939 | PLAY [Base post-logs] 2026-08-31 03:17:42.769411 | 2026-08-31 03:17:42.769563 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-31 03:17:43.530514 | localhost | changed 2026-08-31 03:17:43.545130 | 2026-08-31 03:17:43.545362 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-31 03:17:43.618558 | localhost | ok 2026-08-31 03:17:43.622540 | 2026-08-31 03:17:43.622708 | TASK [Set zuul-log-path fact] 2026-08-31 03:17:43.650378 | localhost | ok 2026-08-31 03:17:43.659943 | 2026-08-31 03:17:43.660128 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-31 03:17:43.709910 | localhost | ok 2026-08-31 03:17:43.713211 | 2026-08-31 03:17:43.713288 | TASK [upload-logs : Create log directories] 2026-08-31 03:17:44.515888 | localhost | changed 2026-08-31 03:17:44.520067 | 2026-08-31 03:17:44.520153 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-31 03:17:45.388479 | localhost -> localhost | ok: Runtime: 0:00:00.009180 2026-08-31 03:17:45.392379 | 2026-08-31 03:17:45.392488 | TASK [upload-logs : Upload logs to log server] 2026-08-31 03:17:46.184507 | localhost | Output suppressed because no_log was given 2026-08-31 03:17:46.186262 | 2026-08-31 03:17:46.186349 | LOOP [upload-logs : Compress console log and json output] 2026-08-31 03:17:46.313253 | localhost | skipping: Conditional result was False 2026-08-31 03:17:46.329831 | localhost | skipping: Conditional result was False 2026-08-31 03:17:46.340104 | 2026-08-31 03:17:46.340235 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-31 03:17:46.410478 | localhost | skipping: Conditional result was False 2026-08-31 03:17:46.410760 | 2026-08-31 03:17:46.417261 | localhost | skipping: Conditional result was False 2026-08-31 03:17:46.426760 | 2026-08-31 03:17:46.426902 | LOOP [upload-logs : Upload console log and json output]