2026-09-01 03:00:10.125433 | Job console starting 2026-09-01 03:00:10.152665 | Updating git repos 2026-09-01 03:00:10.425539 | Cloning repos into workspace 2026-09-01 03:00:10.523131 | Restoring repo states 2026-09-01 03:00:10.550532 | Merging changes 2026-09-01 03:00:10.550552 | Checking out repos 2026-09-01 03:00:10.672234 | Preparing playbooks 2026-09-01 03:00:12.058779 | Running Ansible setup 2026-09-01 03:00:17.469196 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-01 03:00:18.680298 | 2026-09-01 03:00:18.680429 | PLAY [Base pre] 2026-09-01 03:00:18.696892 | 2026-09-01 03:00:18.697001 | TASK [Setup log path fact] 2026-09-01 03:00:18.714947 | debian-bookworm | ok 2026-09-01 03:00:18.730119 | 2026-09-01 03:00:18.730241 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-01 03:00:18.757653 | debian-bookworm | ok 2026-09-01 03:00:18.773906 | 2026-09-01 03:00:18.774006 | TASK [emit-job-header : Print job information] 2026-09-01 03:00:18.802244 | # Job Information 2026-09-01 03:00:18.802432 | Ansible Version: 2.16.14 2026-09-01 03:00:18.802467 | Job: python-black 2026-09-01 03:00:18.802503 | Pipeline: periodic-daily 2026-09-01 03:00:18.802527 | Executor: 521e9411259a 2026-09-01 03:00:18.802547 | Triggered by: https://github.com/osism/ansible-collection-commons 2026-09-01 03:00:18.802569 | Event ID: 2978344d9c2d4e8c936ddeefd7d5a435 2026-09-01 03:00:18.807407 | 2026-09-01 03:00:18.807510 | LOOP [emit-job-header : Print node information] 2026-09-01 03:00:18.984588 | debian-bookworm | ok: 2026-09-01 03:00:18.984799 | debian-bookworm | # Node Information 2026-09-01 03:00:18.984830 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-01 03:00:18.984850 | debian-bookworm | Hostname: debian 2026-09-01 03:00:18.984869 | debian-bookworm | Username: zuul 2026-09-01 03:00:18.984886 | debian-bookworm | Distro: Debian 12.15 2026-09-01 03:00:18.984905 | debian-bookworm | Provider: regiocloud-a 2026-09-01 03:00:18.984923 | debian-bookworm | Region: 2026-09-01 03:00:18.984940 | debian-bookworm | Label: debian-bookworm 2026-09-01 03:00:18.984957 | debian-bookworm | Product Name: OpenStack Nova 2026-09-01 03:00:18.984973 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe8a:b833 2026-09-01 03:00:19.002329 | 2026-09-01 03:00:19.002424 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-01 03:00:19.701810 | debian-bookworm -> localhost | changed 2026-09-01 03:00:19.709540 | 2026-09-01 03:00:19.709701 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-01 03:00:21.631742 | debian-bookworm -> localhost | changed 2026-09-01 03:00:21.647713 | 2026-09-01 03:00:21.647804 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-01 03:00:22.197197 | debian-bookworm -> localhost | ok 2026-09-01 03:00:22.202132 | 2026-09-01 03:00:22.202229 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-01 03:00:22.230321 | debian-bookworm | ok 2026-09-01 03:00:22.247720 | debian-bookworm | included: /var/lib/zuul/builds/ce59c1e522fb469385a87dded4e2f56f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-01 03:00:22.252520 | 2026-09-01 03:00:22.252595 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-01 03:00:24.096599 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-01 03:00:24.096755 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/ce59c1e522fb469385a87dded4e2f56f/work/ce59c1e522fb469385a87dded4e2f56f_id_rsa 2026-09-01 03:00:24.096785 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/ce59c1e522fb469385a87dded4e2f56f/work/ce59c1e522fb469385a87dded4e2f56f_id_rsa.pub 2026-09-01 03:00:24.096807 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-01 03:00:24.096826 | debian-bookworm -> localhost | SHA256:UVJVZHg8nsfPJurtwDMLb0d1c8BPlnoZ4Cuu97gjBug zuul-build-sshkey 2026-09-01 03:00:24.096844 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-01 03:00:24.096871 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-01 03:00:24.096889 | debian-bookworm -> localhost | | ..o..B= .| 2026-09-01 03:00:24.096907 | debian-bookworm -> localhost | | o o.*oo| 2026-09-01 03:00:24.096923 | debian-bookworm -> localhost | | . +.Oo| 2026-09-01 03:00:24.096939 | debian-bookworm -> localhost | | . .++B| 2026-09-01 03:00:24.096955 | debian-bookworm -> localhost | | . S . ..+=| 2026-09-01 03:00:24.096975 | debian-bookworm -> localhost | | . . ... o +| 2026-09-01 03:00:24.096992 | debian-bookworm -> localhost | | . . ..=o o | 2026-09-01 03:00:24.097009 | debian-bookworm -> localhost | | E o.=+*. | 2026-09-01 03:00:24.097026 | debian-bookworm -> localhost | | ..o=B+o | 2026-09-01 03:00:24.097070 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-01 03:00:24.097113 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.122017 2026-09-01 03:00:24.102234 | 2026-09-01 03:00:24.102312 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-01 03:00:24.128970 | debian-bookworm | ok 2026-09-01 03:00:24.155512 | debian-bookworm | included: /var/lib/zuul/builds/ce59c1e522fb469385a87dded4e2f56f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-01 03:00:24.167562 | 2026-09-01 03:00:24.167763 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-01 03:00:24.205874 | debian-bookworm | skipping: Conditional result was False 2026-09-01 03:00:24.216147 | 2026-09-01 03:00:24.216234 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-01 03:00:25.064472 | debian-bookworm | changed 2026-09-01 03:00:25.068739 | 2026-09-01 03:00:25.068815 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-01 03:00:25.349886 | debian-bookworm | ok 2026-09-01 03:00:25.362152 | 2026-09-01 03:00:25.372449 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-01 03:00:26.182506 | debian-bookworm | changed 2026-09-01 03:00:26.193470 | 2026-09-01 03:00:26.193560 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-01 03:00:27.022154 | debian-bookworm | changed 2026-09-01 03:00:27.032617 | 2026-09-01 03:00:27.032698 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-01 03:00:27.082629 | debian-bookworm | skipping: Conditional result was False 2026-09-01 03:00:27.089061 | 2026-09-01 03:00:27.089148 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-01 03:00:27.631122 | debian-bookworm -> localhost | changed 2026-09-01 03:00:27.639864 | 2026-09-01 03:00:27.639947 | TASK [add-build-sshkey : Add back temp key] 2026-09-01 03:00:27.945112 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/ce59c1e522fb469385a87dded4e2f56f/work/ce59c1e522fb469385a87dded4e2f56f_id_rsa (zuul-build-sshkey) 2026-09-01 03:00:27.945285 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010696 2026-09-01 03:00:27.951512 | 2026-09-01 03:00:27.951600 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-01 03:00:28.375956 | debian-bookworm | ok 2026-09-01 03:00:28.380296 | 2026-09-01 03:00:28.380374 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-01 03:00:28.416690 | debian-bookworm | skipping: Conditional result was False 2026-09-01 03:00:28.427817 | 2026-09-01 03:00:28.427908 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-01 03:00:28.985826 | debian-bookworm | ok 2026-09-01 03:00:29.002710 | 2026-09-01 03:00:29.002805 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-01 03:00:29.050447 | debian-bookworm | ok 2026-09-01 03:00:29.054643 | 2026-09-01 03:00:29.054726 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-01 03:00:29.576677 | debian-bookworm -> localhost | ok 2026-09-01 03:00:29.581902 | 2026-09-01 03:00:29.581986 | TASK [validate-host : Collect information about the host] 2026-09-01 03:00:30.753244 | debian-bookworm | ok 2026-09-01 03:00:30.773802 | 2026-09-01 03:00:30.774652 | TASK [validate-host : Sanitize hostname] 2026-09-01 03:00:30.969068 | debian-bookworm | ok 2026-09-01 03:00:30.973303 | 2026-09-01 03:00:30.973382 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-01 03:00:31.898631 | debian-bookworm -> localhost | changed 2026-09-01 03:00:31.903474 | 2026-09-01 03:00:31.903549 | TASK [validate-host : Collect information about zuul worker] 2026-09-01 03:00:32.530706 | debian-bookworm | ok 2026-09-01 03:00:32.534689 | 2026-09-01 03:00:32.534765 | TASK [validate-host : Write out all zuul information for each host] 2026-09-01 03:00:33.904138 | debian-bookworm -> localhost | changed 2026-09-01 03:00:33.914345 | 2026-09-01 03:00:33.914429 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-01 03:00:34.227707 | debian-bookworm | ok 2026-09-01 03:00:34.233260 | 2026-09-01 03:00:34.233346 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-01 03:00:35.953686 | debian-bookworm | changed: 2026-09-01 03:00:35.953855 | debian-bookworm | cd+++++++++ src/ 2026-09-01 03:00:35.953890 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-01 03:00:35.953914 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-01 03:00:35.953936 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-commons/ 2026-09-01 03:00:35.953957 | debian-bookworm | RedHat.yml 2026-09-01 03:00:36.066974 | debian-bookworm | cL+++++++++ src/github.com/osism/ansible-collection-commons/roles/repository/tasks/CentOS.yml -> RedHat.yml 2026-09-01 03:00:36.066992 | debian-bookworm | RedHat.yml 2026-09-01 03:00:36.067156 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/ce59c1e522fb469385a87dded4e2f56f/work/logs" 2026-09-01 03:01:40.268363 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/ce59c1e522fb469385a87dded4e2f56f/work/artifacts" 2026-09-01 03:01:40.559746 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/ce59c1e522fb469385a87dded4e2f56f/work/docs" 2026-09-01 03:01:40.575549 | 2026-09-01 03:01:40.575656 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-01 03:01:41.432665 | debian-bookworm | changed: 2026-09-01 03:01:41.433838 | debian-bookworm | .d..t...... ./ 2026-09-01 03:01:41.433909 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-01 03:01:41.433938 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-01 03:01:41.433962 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-01 03:01:41.433984 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-01 03:01:41.434005 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-01 03:01:41.434059 | debian-bookworm | changed: All items complete 2026-09-01 03:01:41.434086 | 2026-09-01 03:01:42.193163 | debian-bookworm | changed: .d..t...... ./ 2026-09-01 03:01:42.996717 | debian-bookworm | changed: .d..t...... ./ 2026-09-01 03:01:43.018759 | 2026-09-01 03:01:43.018883 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-01 03:01:43.081623 | debian-bookworm | skipping: Conditional result was False 2026-09-01 03:01:43.085398 | debian-bookworm | skipping: Conditional result was False 2026-09-01 03:01:43.097017 | 2026-09-01 03:01:43.097106 | PLAY RECAP 2026-09-01 03:01:43.097159 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-09-01 03:01:43.097184 | 2026-09-01 03:01:43.245723 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-01 03:01:43.246453 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-01 03:01:44.482275 | 2026-09-01 03:01:44.482624 | PLAY [Base post] 2026-09-01 03:01:44.510686 | 2026-09-01 03:01:44.511077 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-01 03:01:45.220649 | debian-bookworm | changed 2026-09-01 03:01:45.231470 | 2026-09-01 03:01:45.231573 | PLAY RECAP 2026-09-01 03:01:45.231633 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-01 03:01:45.231693 | 2026-09-01 03:01:45.510644 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-01 03:01:45.511261 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-01 03:01:47.276499 | 2026-09-01 03:01:47.276909 | PLAY [Base post-logs] 2026-09-01 03:01:47.285409 | 2026-09-01 03:01:47.285502 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-01 03:01:48.398432 | localhost | changed 2026-09-01 03:01:48.406244 | 2026-09-01 03:01:48.406364 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-01 03:01:48.439259 | localhost | ok 2026-09-01 03:01:48.442872 | 2026-09-01 03:01:48.443005 | TASK [Set zuul-log-path fact] 2026-09-01 03:01:48.469161 | localhost | ok 2026-09-01 03:01:48.477761 | 2026-09-01 03:01:48.477862 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-01 03:01:48.524320 | localhost | ok 2026-09-01 03:01:48.526690 | 2026-09-01 03:01:48.526768 | TASK [upload-logs : Create log directories] 2026-09-01 03:01:49.718002 | localhost | changed 2026-09-01 03:01:49.720414 | 2026-09-01 03:01:49.720491 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-01 03:01:50.765161 | localhost -> localhost | ok: Runtime: 0:00:00.019840 2026-09-01 03:01:50.768153 | 2026-09-01 03:01:50.768241 | TASK [upload-logs : Upload logs to log server] 2026-09-01 03:01:51.923937 | localhost | Output suppressed because no_log was given 2026-09-01 03:01:51.925548 | 2026-09-01 03:01:51.925625 | LOOP [upload-logs : Compress console log and json output] 2026-09-01 03:01:52.000867 | localhost | skipping: Conditional result was False 2026-09-01 03:01:52.016631 | localhost | skipping: Conditional result was False 2026-09-01 03:01:52.020735 | 2026-09-01 03:01:52.020817 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-01 03:01:52.081744 | localhost | skipping: Conditional result was False 2026-09-01 03:01:52.081970 | 2026-09-01 03:01:52.087032 | localhost | skipping: Conditional result was False 2026-09-01 03:01:52.095742 | 2026-09-01 03:01:52.095824 | LOOP [upload-logs : Upload console log and json output]