2026-05-22 03:16:03.327043 | Job console starting 2026-05-22 03:16:03.348441 | Updating git repos 2026-05-22 03:16:03.380561 | Cloning repos into workspace 2026-05-22 03:16:03.434256 | Restoring repo states 2026-05-22 03:16:03.457028 | Merging changes 2026-05-22 03:16:03.457046 | Checking out repos 2026-05-22 03:16:03.602741 | Preparing playbooks 2026-05-22 03:16:04.553286 | Running Ansible setup 2026-05-22 03:16:09.632356 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-22 03:16:10.449591 | 2026-05-22 03:16:10.449751 | PLAY [Base pre] 2026-05-22 03:16:10.466532 | 2026-05-22 03:16:10.466667 | TASK [Setup log path fact] 2026-05-22 03:16:10.496057 | debian-bookworm | ok 2026-05-22 03:16:10.512829 | 2026-05-22 03:16:10.512997 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-22 03:16:10.541936 | debian-bookworm | ok 2026-05-22 03:16:10.552956 | 2026-05-22 03:16:10.553099 | TASK [emit-job-header : Print job information] 2026-05-22 03:16:10.593585 | # Job Information 2026-05-22 03:16:10.593773 | Ansible Version: 2.16.14 2026-05-22 03:16:10.593809 | Job: python-black 2026-05-22 03:16:10.593844 | Pipeline: periodic-daily 2026-05-22 03:16:10.593868 | Executor: 521e9411259a 2026-05-22 03:16:10.593889 | Triggered by: https://github.com/osism/ansible-collection-services 2026-05-22 03:16:10.593911 | Event ID: cfb66910473f4108bfcf9fc1be0be316 2026-05-22 03:16:10.599039 | 2026-05-22 03:16:10.599151 | LOOP [emit-job-header : Print node information] 2026-05-22 03:16:10.713399 | debian-bookworm | ok: 2026-05-22 03:16:10.713612 | debian-bookworm | # Node Information 2026-05-22 03:16:10.713647 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-22 03:16:10.713672 | debian-bookworm | Hostname: debian 2026-05-22 03:16:10.713693 | debian-bookworm | Username: zuul 2026-05-22 03:16:10.713714 | debian-bookworm | Distro: Debian 12.14 2026-05-22 03:16:10.713738 | debian-bookworm | Provider: regiocloud-a 2026-05-22 03:16:10.713760 | debian-bookworm | Region: 2026-05-22 03:16:10.713781 | debian-bookworm | Label: debian-bookworm 2026-05-22 03:16:10.713800 | debian-bookworm | Product Name: OpenStack Nova 2026-05-22 03:16:10.713819 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe73:3b0a 2026-05-22 03:16:10.725414 | 2026-05-22 03:16:10.725565 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-22 03:16:11.266107 | debian-bookworm -> localhost | changed 2026-05-22 03:16:11.278000 | 2026-05-22 03:16:11.278159 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-22 03:16:12.761650 | debian-bookworm -> localhost | changed 2026-05-22 03:16:12.772897 | 2026-05-22 03:16:12.773019 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-22 03:16:13.050272 | debian-bookworm -> localhost | ok 2026-05-22 03:16:13.056920 | 2026-05-22 03:16:13.057039 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-22 03:16:13.088411 | debian-bookworm | ok 2026-05-22 03:16:13.103745 | debian-bookworm | included: /var/lib/zuul/builds/e6b16aad32084b9b9d8da18d148f8416/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-22 03:16:13.110175 | 2026-05-22 03:16:13.110293 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-22 03:16:14.377825 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-22 03:16:14.378054 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/e6b16aad32084b9b9d8da18d148f8416/work/e6b16aad32084b9b9d8da18d148f8416_id_rsa 2026-05-22 03:16:14.378092 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/e6b16aad32084b9b9d8da18d148f8416/work/e6b16aad32084b9b9d8da18d148f8416_id_rsa.pub 2026-05-22 03:16:14.378118 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-22 03:16:14.378143 | debian-bookworm -> localhost | SHA256:0PLbFz0aAqpk03/1k2JbOrNQrr8bPW4kYT9TT13mXok zuul-build-sshkey 2026-05-22 03:16:14.378166 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-22 03:16:14.378201 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-22 03:16:14.378224 | debian-bookworm -> localhost | | | 2026-05-22 03:16:14.378246 | debian-bookworm -> localhost | | . o| 2026-05-22 03:16:14.378266 | debian-bookworm -> localhost | | o o .o+| 2026-05-22 03:16:14.378285 | debian-bookworm -> localhost | | . = . oE .*| 2026-05-22 03:16:14.378304 | debian-bookworm -> localhost | | + o S ..=oo+o| 2026-05-22 03:16:14.378331 | debian-bookworm -> localhost | | o o . o =.*=oo| 2026-05-22 03:16:14.378351 | debian-bookworm -> localhost | | . o + BoBo | 2026-05-22 03:16:14.378371 | debian-bookworm -> localhost | | . =oB.o | 2026-05-22 03:16:14.378392 | debian-bookworm -> localhost | | ..BB. | 2026-05-22 03:16:14.378425 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-22 03:16:14.378481 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.635634 2026-05-22 03:16:14.385094 | 2026-05-22 03:16:14.385215 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-22 03:16:14.435264 | debian-bookworm | ok 2026-05-22 03:16:14.444734 | debian-bookworm | included: /var/lib/zuul/builds/e6b16aad32084b9b9d8da18d148f8416/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-22 03:16:14.461025 | 2026-05-22 03:16:14.461155 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-22 03:16:14.489823 | debian-bookworm | skipping: Conditional result was False 2026-05-22 03:16:14.498302 | 2026-05-22 03:16:14.498458 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-22 03:16:15.367157 | debian-bookworm | changed 2026-05-22 03:16:15.375921 | 2026-05-22 03:16:15.376116 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-22 03:16:15.799036 | debian-bookworm | ok 2026-05-22 03:16:15.811425 | 2026-05-22 03:16:15.811559 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-22 03:16:16.530073 | debian-bookworm | changed 2026-05-22 03:16:16.542793 | 2026-05-22 03:16:16.542963 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-22 03:16:17.365569 | debian-bookworm | changed 2026-05-22 03:16:17.373329 | 2026-05-22 03:16:17.373488 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-22 03:16:17.408476 | debian-bookworm | skipping: Conditional result was False 2026-05-22 03:16:17.436947 | 2026-05-22 03:16:17.437265 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-22 03:16:17.938559 | debian-bookworm -> localhost | changed 2026-05-22 03:16:17.957589 | 2026-05-22 03:16:17.957726 | TASK [add-build-sshkey : Add back temp key] 2026-05-22 03:16:18.356188 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/e6b16aad32084b9b9d8da18d148f8416/work/e6b16aad32084b9b9d8da18d148f8416_id_rsa (zuul-build-sshkey) 2026-05-22 03:16:18.356543 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.026324 2026-05-22 03:16:18.364859 | 2026-05-22 03:16:18.364982 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-22 03:16:18.818791 | debian-bookworm | ok 2026-05-22 03:16:18.825464 | 2026-05-22 03:16:18.825575 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-22 03:16:18.850069 | debian-bookworm | skipping: Conditional result was False 2026-05-22 03:16:18.862456 | 2026-05-22 03:16:18.862574 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-22 03:16:19.420641 | debian-bookworm | ok 2026-05-22 03:16:19.442490 | 2026-05-22 03:16:19.442627 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-22 03:16:19.525638 | debian-bookworm | ok 2026-05-22 03:16:19.546700 | 2026-05-22 03:16:19.546873 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-22 03:16:20.002937 | debian-bookworm -> localhost | ok 2026-05-22 03:16:20.009630 | 2026-05-22 03:16:20.009747 | TASK [validate-host : Collect information about the host] 2026-05-22 03:16:21.283222 | debian-bookworm | ok 2026-05-22 03:16:21.301188 | 2026-05-22 03:16:21.301328 | TASK [validate-host : Sanitize hostname] 2026-05-22 03:16:21.483449 | debian-bookworm | ok 2026-05-22 03:16:21.529876 | 2026-05-22 03:16:21.530018 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-22 03:16:22.272120 | debian-bookworm -> localhost | changed 2026-05-22 03:16:22.286179 | 2026-05-22 03:16:22.286338 | TASK [validate-host : Collect information about zuul worker] 2026-05-22 03:16:22.735928 | debian-bookworm | ok 2026-05-22 03:16:22.741924 | 2026-05-22 03:16:22.742065 | TASK [validate-host : Write out all zuul information for each host] 2026-05-22 03:16:23.429142 | debian-bookworm -> localhost | changed 2026-05-22 03:16:23.440705 | 2026-05-22 03:16:23.440834 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-22 03:16:23.732639 | debian-bookworm | ok 2026-05-22 03:16:23.738677 | 2026-05-22 03:16:23.738798 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-22 03:16:25.095871 | debian-bookworm | changed: 2026-05-22 03:16:25.096196 | debian-bookworm | cd+++++++++ src/ 2026-05-22 03:16:25.096235 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-22 03:16:25.096459 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-22 03:16:25.096545 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2026-05-22 03:16:25.096571 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/e6b16aad32084b9b9d8da18d148f8416/work/logs" 2026-05-22 03:16:55.493816 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/e6b16aad32084b9b9d8da18d148f8416/work/artifacts" 2026-05-22 03:16:55.834639 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/e6b16aad32084b9b9d8da18d148f8416/work/docs" 2026-05-22 03:16:55.858123 | 2026-05-22 03:16:55.858321 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-22 03:16:56.928539 | debian-bookworm | changed: 2026-05-22 03:16:56.928930 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-22 03:16:56.928979 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-22 03:16:56.929012 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-22 03:16:56.929066 | debian-bookworm | changed: All items complete 2026-05-22 03:16:56.929095 | 2026-05-22 03:16:57.942482 | debian-bookworm | changed: .d..t...... ./ 2026-05-22 03:16:58.697376 | debian-bookworm | changed: .d..t...... ./ 2026-05-22 03:16:58.734890 | 2026-05-22 03:16:58.735050 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-22 03:16:58.790575 | debian-bookworm | skipping: Conditional result was False 2026-05-22 03:16:58.795273 | debian-bookworm | skipping: Conditional result was False 2026-05-22 03:16:58.809494 | 2026-05-22 03:16:58.809655 | PLAY RECAP 2026-05-22 03:16:58.809709 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-22 03:16:58.809735 | 2026-05-22 03:16:59.022066 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-22 03:16:59.023032 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-22 03:17:00.121714 | 2026-05-22 03:17:00.121837 | PLAY [Base post] 2026-05-22 03:17:00.143530 | 2026-05-22 03:17:00.143659 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-22 03:17:00.819507 | debian-bookworm | changed 2026-05-22 03:17:00.828009 | 2026-05-22 03:17:00.828139 | PLAY RECAP 2026-05-22 03:17:00.828213 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-22 03:17:00.828290 | 2026-05-22 03:17:00.912128 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-22 03:17:00.912852 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-22 03:17:01.794194 | 2026-05-22 03:17:01.794311 | PLAY [Base post-logs] 2026-05-22 03:17:01.803137 | 2026-05-22 03:17:01.803240 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-22 03:17:02.471140 | localhost | changed 2026-05-22 03:17:02.484746 | 2026-05-22 03:17:02.485014 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-22 03:17:02.523142 | localhost | ok 2026-05-22 03:17:02.528656 | 2026-05-22 03:17:02.528748 | TASK [Set zuul-log-path fact] 2026-05-22 03:17:02.547307 | localhost | ok 2026-05-22 03:17:02.564930 | 2026-05-22 03:17:02.565044 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-22 03:17:02.602977 | localhost | ok 2026-05-22 03:17:02.608454 | 2026-05-22 03:17:02.608554 | TASK [upload-logs : Create log directories] 2026-05-22 03:17:03.469458 | localhost | changed 2026-05-22 03:17:03.472131 | 2026-05-22 03:17:03.472217 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-22 03:17:04.419932 | localhost -> localhost | ok: Runtime: 0:00:00.026198 2026-05-22 03:17:04.424200 | 2026-05-22 03:17:04.424300 | TASK [upload-logs : Upload logs to log server] 2026-05-22 03:17:05.607300 | localhost | Output suppressed because no_log was given 2026-05-22 03:17:05.608926 | 2026-05-22 03:17:05.609009 | LOOP [upload-logs : Compress console log and json output] 2026-05-22 03:17:05.666576 | localhost | skipping: Conditional result was False 2026-05-22 03:17:05.673385 | localhost | skipping: Conditional result was False 2026-05-22 03:17:05.684781 | 2026-05-22 03:17:05.684893 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-22 03:17:05.732264 | localhost | skipping: Conditional result was False 2026-05-22 03:17:05.732511 | 2026-05-22 03:17:05.737227 | localhost | skipping: Conditional result was False 2026-05-22 03:17:05.743245 | 2026-05-22 03:17:05.743367 | LOOP [upload-logs : Upload console log and json output]