2026-09-25 03:18:38.946277 | Job console starting 2026-09-25 03:18:38.953433 | Updating git repos 2026-09-25 03:18:38.992636 | Cloning repos into workspace 2026-09-25 03:18:39.061004 | Restoring repo states 2026-09-25 03:18:39.087453 | Merging changes 2026-09-25 03:18:39.087466 | Checking out repos 2026-09-25 03:18:39.229412 | Preparing playbooks 2026-09-25 03:18:40.524867 | Running Ansible setup 2026-09-25 03:18:45.074738 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-25 03:18:46.022750 | 2026-09-25 03:18:46.024856 | PLAY [Base pre] 2026-09-25 03:18:46.078128 | 2026-09-25 03:18:46.078270 | TASK [Setup log path fact] 2026-09-25 03:18:46.105370 | debian-bookworm | ok 2026-09-25 03:18:46.142165 | 2026-09-25 03:18:46.142289 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-25 03:18:46.190182 | debian-bookworm | ok 2026-09-25 03:18:46.201401 | 2026-09-25 03:18:46.201497 | TASK [emit-job-header : Print job information] 2026-09-25 03:18:46.269903 | # Job Information 2026-09-25 03:18:46.270046 | Ansible Version: 2.16.14 2026-09-25 03:18:46.270076 | Job: python-black 2026-09-25 03:18:46.270104 | Pipeline: periodic-daily 2026-09-25 03:18:46.270123 | Executor: 521e9411259a 2026-09-25 03:18:46.270140 | Triggered by: https://github.com/osism/ansible-collection-services 2026-09-25 03:18:46.270158 | Event ID: 93dc20c1bd154a9eabfc352cd82aeaea 2026-09-25 03:18:46.274748 | 2026-09-25 03:18:46.274839 | LOOP [emit-job-header : Print node information] 2026-09-25 03:18:46.410913 | debian-bookworm | ok: 2026-09-25 03:18:46.411101 | debian-bookworm | # Node Information 2026-09-25 03:18:46.411132 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-25 03:18:46.411153 | debian-bookworm | Hostname: debian 2026-09-25 03:18:46.411172 | debian-bookworm | Username: zuul 2026-09-25 03:18:46.411189 | debian-bookworm | Distro: Debian 12.15 2026-09-25 03:18:46.411212 | debian-bookworm | Provider: regiocloud-a 2026-09-25 03:18:46.411231 | debian-bookworm | Region: 2026-09-25 03:18:46.411248 | debian-bookworm | Label: debian-bookworm 2026-09-25 03:18:46.411264 | debian-bookworm | Product Name: OpenStack Nova 2026-09-25 03:18:46.411280 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe9c:a9b0 2026-09-25 03:18:46.425726 | 2026-09-25 03:18:46.425851 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-25 03:18:47.152822 | debian-bookworm -> localhost | changed 2026-09-25 03:18:47.158826 | 2026-09-25 03:18:47.158910 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-25 03:18:48.631150 | debian-bookworm -> localhost | changed 2026-09-25 03:18:48.650708 | 2026-09-25 03:18:48.650919 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-25 03:18:49.215826 | debian-bookworm -> localhost | ok 2026-09-25 03:18:49.224008 | 2026-09-25 03:18:49.224107 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-25 03:18:49.273294 | debian-bookworm | ok 2026-09-25 03:18:49.344991 | debian-bookworm | included: /var/lib/zuul/builds/b788dfc065074af9890dbb70621711a8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-25 03:18:49.372147 | 2026-09-25 03:18:49.372252 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-25 03:18:50.856556 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-25 03:18:50.856762 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/b788dfc065074af9890dbb70621711a8/work/b788dfc065074af9890dbb70621711a8_id_rsa 2026-09-25 03:18:50.856798 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/b788dfc065074af9890dbb70621711a8/work/b788dfc065074af9890dbb70621711a8_id_rsa.pub 2026-09-25 03:18:50.856822 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-25 03:18:50.856843 | debian-bookworm -> localhost | SHA256:9DC0aEL7Frf+SgpiWrtW2zUw90BjsMlnFbEHMHCE9Mk zuul-build-sshkey 2026-09-25 03:18:50.856863 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-25 03:18:50.856890 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-25 03:18:50.856909 | debian-bookworm -> localhost | | ..+=*.=o | 2026-09-25 03:18:50.856927 | debian-bookworm -> localhost | | . o.O+= o | 2026-09-25 03:18:50.856944 | debian-bookworm -> localhost | | o BoE.. . | 2026-09-25 03:18:50.856960 | debian-bookworm -> localhost | | +o*o= . | 2026-09-25 03:18:50.856977 | debian-bookworm -> localhost | | o+So. | 2026-09-25 03:18:50.857026 | debian-bookworm -> localhost | | .. .o . | 2026-09-25 03:18:50.857045 | debian-bookworm -> localhost | | +..o .o. | 2026-09-25 03:18:50.857062 | debian-bookworm -> localhost | | +.o...o . | 2026-09-25 03:18:50.857080 | debian-bookworm -> localhost | |..o. . ... | 2026-09-25 03:18:50.857097 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-25 03:18:50.857147 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.596805 2026-09-25 03:18:50.864148 | 2026-09-25 03:18:50.864240 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-25 03:18:50.908373 | debian-bookworm | ok 2026-09-25 03:18:50.925695 | debian-bookworm | included: /var/lib/zuul/builds/b788dfc065074af9890dbb70621711a8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-25 03:18:50.945672 | 2026-09-25 03:18:50.945769 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-25 03:18:50.969962 | debian-bookworm | skipping: Conditional result was False 2026-09-25 03:18:50.978192 | 2026-09-25 03:18:50.978276 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-25 03:18:51.724442 | debian-bookworm | changed 2026-09-25 03:18:51.729277 | 2026-09-25 03:18:51.729390 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-25 03:18:51.995102 | debian-bookworm | ok 2026-09-25 03:18:52.000620 | 2026-09-25 03:18:52.000702 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-25 03:18:52.650921 | debian-bookworm | changed 2026-09-25 03:18:52.655270 | 2026-09-25 03:18:52.655355 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-25 03:18:53.304228 | debian-bookworm | changed 2026-09-25 03:18:53.314934 | 2026-09-25 03:18:53.315051 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-25 03:18:53.338485 | debian-bookworm | skipping: Conditional result was False 2026-09-25 03:18:53.344531 | 2026-09-25 03:18:53.344647 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-25 03:18:53.700244 | debian-bookworm -> localhost | changed 2026-09-25 03:18:53.711127 | 2026-09-25 03:18:53.711218 | TASK [add-build-sshkey : Add back temp key] 2026-09-25 03:18:54.109917 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/b788dfc065074af9890dbb70621711a8/work/b788dfc065074af9890dbb70621711a8_id_rsa (zuul-build-sshkey) 2026-09-25 03:18:54.110109 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014775 2026-09-25 03:18:54.116584 | 2026-09-25 03:18:54.116674 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-25 03:18:54.516250 | debian-bookworm | ok 2026-09-25 03:18:54.520748 | 2026-09-25 03:18:54.520828 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-25 03:18:54.534068 | debian-bookworm | skipping: Conditional result was False 2026-09-25 03:18:54.542878 | 2026-09-25 03:18:54.542955 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-25 03:18:54.915366 | debian-bookworm | ok 2026-09-25 03:18:54.925524 | 2026-09-25 03:18:54.925645 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-25 03:18:54.952157 | debian-bookworm | ok 2026-09-25 03:18:54.956725 | 2026-09-25 03:18:54.956804 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-25 03:18:55.204436 | debian-bookworm -> localhost | ok 2026-09-25 03:18:55.219000 | 2026-09-25 03:18:55.219112 | TASK [validate-host : Collect information about the host] 2026-09-25 03:18:56.308332 | debian-bookworm | ok 2026-09-25 03:18:56.337904 | 2026-09-25 03:18:56.338004 | TASK [validate-host : Sanitize hostname] 2026-09-25 03:18:56.474979 | debian-bookworm | ok 2026-09-25 03:18:56.479296 | 2026-09-25 03:18:56.479386 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-25 03:18:57.042775 | debian-bookworm -> localhost | changed 2026-09-25 03:18:57.047865 | 2026-09-25 03:18:57.047953 | TASK [validate-host : Collect information about zuul worker] 2026-09-25 03:18:57.521808 | debian-bookworm | ok 2026-09-25 03:18:57.526445 | 2026-09-25 03:18:57.526533 | TASK [validate-host : Write out all zuul information for each host] 2026-09-25 03:18:58.684983 | debian-bookworm -> localhost | changed 2026-09-25 03:18:58.696278 | 2026-09-25 03:18:58.698731 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-25 03:18:59.018090 | debian-bookworm | ok 2026-09-25 03:18:59.030747 | 2026-09-25 03:18:59.030846 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-25 03:19:00.074604 | debian-bookworm | changed: 2026-09-25 03:19:00.075533 | debian-bookworm | cd+++++++++ src/ 2026-09-25 03:19:00.075583 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-25 03:19:00.075619 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-25 03:19:00.075640 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2026-09-25 03:19:00.075657 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/b788dfc065074af9890dbb70621711a8/work/logs" 2026-09-25 03:20:04.126703 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/b788dfc065074af9890dbb70621711a8/work/artifacts" 2026-09-25 03:20:04.558724 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/b788dfc065074af9890dbb70621711a8/work/docs" 2026-09-25 03:20:04.577824 | 2026-09-25 03:20:04.577953 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-25 03:20:05.678572 | debian-bookworm | changed: 2026-09-25 03:20:05.679315 | debian-bookworm | .d..t...... ./ 2026-09-25 03:20:05.679385 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-25 03:20:05.679414 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-25 03:20:05.679437 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-25 03:20:05.679461 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-25 03:20:05.679482 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-25 03:20:05.679529 | debian-bookworm | changed: All items complete 2026-09-25 03:20:05.680082 | 2026-09-25 03:20:06.339522 | debian-bookworm | changed: .d..t...... ./ 2026-09-25 03:20:06.956462 | debian-bookworm | changed: .d..t...... ./ 2026-09-25 03:20:06.987273 | 2026-09-25 03:20:06.987407 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-25 03:20:07.065287 | debian-bookworm | skipping: Conditional result was False 2026-09-25 03:20:07.098678 | debian-bookworm | skipping: Conditional result was False 2026-09-25 03:20:07.124053 | 2026-09-25 03:20:07.124350 | PLAY RECAP 2026-09-25 03:20:07.124456 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-09-25 03:20:07.124686 | 2026-09-25 03:20:07.401001 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-25 03:20:07.405352 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-25 03:20:08.376523 | 2026-09-25 03:20:08.376699 | PLAY [Base post] 2026-09-25 03:20:08.390810 | 2026-09-25 03:20:08.390953 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-25 03:20:09.084539 | debian-bookworm | changed 2026-09-25 03:20:09.095806 | 2026-09-25 03:20:09.095931 | PLAY RECAP 2026-09-25 03:20:09.095993 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-25 03:20:09.096055 | 2026-09-25 03:20:09.287532 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-25 03:20:09.288394 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-25 03:20:10.251763 | 2026-09-25 03:20:10.251914 | PLAY [Base post-logs] 2026-09-25 03:20:10.259602 | 2026-09-25 03:20:10.259721 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-25 03:20:10.810374 | localhost | changed 2026-09-25 03:20:10.826350 | 2026-09-25 03:20:10.826531 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-25 03:20:10.853636 | localhost | ok 2026-09-25 03:20:10.859562 | 2026-09-25 03:20:10.859665 | TASK [Set zuul-log-path fact] 2026-09-25 03:20:10.876222 | localhost | ok 2026-09-25 03:20:10.889425 | 2026-09-25 03:20:10.889524 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-25 03:20:10.915886 | localhost | ok 2026-09-25 03:20:10.920102 | 2026-09-25 03:20:10.920263 | TASK [upload-logs : Create log directories] 2026-09-25 03:20:11.521694 | localhost | changed 2026-09-25 03:20:11.524245 | 2026-09-25 03:20:11.524331 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-25 03:20:12.210245 | localhost -> localhost | ok: Runtime: 0:00:00.020293 2026-09-25 03:20:12.213963 | 2026-09-25 03:20:12.214335 | TASK [upload-logs : Upload logs to log server] 2026-09-25 03:20:12.968019 | localhost | Output suppressed because no_log was given 2026-09-25 03:20:12.969355 | 2026-09-25 03:20:12.969424 | LOOP [upload-logs : Compress console log and json output] 2026-09-25 03:20:13.019824 | localhost | skipping: Conditional result was False 2026-09-25 03:20:13.025076 | localhost | skipping: Conditional result was False 2026-09-25 03:20:13.035464 | 2026-09-25 03:20:13.035553 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-25 03:20:13.117373 | localhost | skipping: Conditional result was False 2026-09-25 03:20:13.117659 | 2026-09-25 03:20:13.123518 | localhost | skipping: Conditional result was False 2026-09-25 03:20:13.130511 | 2026-09-25 03:20:13.130590 | LOOP [upload-logs : Upload console log and json output]