2026-06-28 13:39:12.135563 | Job console starting 2026-06-28 13:39:12.145004 | Updating git repos 2026-06-28 13:39:12.212165 | Cloning repos into workspace 2026-06-28 13:39:12.317649 | Restoring repo states 2026-06-28 13:39:12.345287 | Merging changes 2026-06-28 13:39:13.139418 | Checking out repos 2026-06-28 13:39:13.196814 | Preparing playbooks 2026-06-28 13:39:14.492460 | Running Ansible setup 2026-06-28 13:39:18.968551 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-28 13:39:19.906019 | 2026-06-28 13:39:19.906223 | PLAY [Base pre] 2026-06-28 13:39:19.923705 | 2026-06-28 13:39:19.923826 | TASK [Setup log path fact] 2026-06-28 13:39:19.942345 | debian-bookworm | ok 2026-06-28 13:39:19.957916 | 2026-06-28 13:39:19.958045 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-28 13:39:19.986949 | debian-bookworm | ok 2026-06-28 13:39:19.996960 | 2026-06-28 13:39:19.997092 | TASK [emit-job-header : Print job information] 2026-06-28 13:39:20.037586 | # Job Information 2026-06-28 13:39:20.037769 | Ansible Version: 2.16.14 2026-06-28 13:39:20.037804 | Job: python-osism-test-setup 2026-06-28 13:39:20.037837 | Pipeline: check 2026-06-28 13:39:20.037861 | Executor: 521e9411259a 2026-06-28 13:39:20.037882 | Triggered by: https://github.com/osism/python-osism/pull/2419 2026-06-28 13:39:20.037960 | Event ID: b06e3590-72f6-11f1-89e0-4634c04fe1d2 2026-06-28 13:39:20.042796 | 2026-06-28 13:39:20.042910 | LOOP [emit-job-header : Print node information] 2026-06-28 13:39:20.206469 | debian-bookworm | ok: 2026-06-28 13:39:20.206661 | debian-bookworm | # Node Information 2026-06-28 13:39:20.206695 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-28 13:39:20.206719 | debian-bookworm | Hostname: debian 2026-06-28 13:39:20.206740 | debian-bookworm | Username: zuul 2026-06-28 13:39:20.206760 | debian-bookworm | Distro: Debian 12.14 2026-06-28 13:39:20.206783 | debian-bookworm | Provider: regiocloud-a 2026-06-28 13:39:20.206804 | debian-bookworm | Region: 2026-06-28 13:39:20.206825 | debian-bookworm | Label: debian-bookworm 2026-06-28 13:39:20.207490 | debian-bookworm | Product Name: OpenStack Nova 2026-06-28 13:39:20.207548 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe82:1046 2026-06-28 13:39:20.223544 | 2026-06-28 13:39:20.223660 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-28 13:39:21.014033 | debian-bookworm -> localhost | changed 2026-06-28 13:39:21.021929 | 2026-06-28 13:39:21.022086 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-28 13:39:22.257288 | debian-bookworm -> localhost | changed 2026-06-28 13:39:22.272728 | 2026-06-28 13:39:22.272839 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-28 13:39:22.728069 | debian-bookworm -> localhost | ok 2026-06-28 13:39:22.734247 | 2026-06-28 13:39:22.734357 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-28 13:39:22.764447 | debian-bookworm | ok 2026-06-28 13:39:22.784636 | debian-bookworm | included: /var/lib/zuul/builds/7978e6ff697e490db6c2d0cf341112c4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-28 13:39:22.790576 | 2026-06-28 13:39:22.790663 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-28 13:39:24.425772 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-28 13:39:24.425970 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/7978e6ff697e490db6c2d0cf341112c4/work/7978e6ff697e490db6c2d0cf341112c4_id_rsa 2026-06-28 13:39:24.426018 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/7978e6ff697e490db6c2d0cf341112c4/work/7978e6ff697e490db6c2d0cf341112c4_id_rsa.pub 2026-06-28 13:39:24.426046 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-28 13:39:24.426072 | debian-bookworm -> localhost | SHA256:lcbmQHPFeOmt4X3r1bc+sFacu6iSPjhovVw7h5xcNZs zuul-build-sshkey 2026-06-28 13:39:24.426095 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-28 13:39:24.426126 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-28 13:39:24.426148 | debian-bookworm -> localhost | | o .+.. | 2026-06-28 13:39:24.426169 | debian-bookworm -> localhost | | . +..+ | 2026-06-28 13:39:24.426190 | debian-bookworm -> localhost | | . *o . | 2026-06-28 13:39:24.426209 | debian-bookworm -> localhost | | * oo. | 2026-06-28 13:39:24.426228 | debian-bookworm -> localhost | | S ...+= .| 2026-06-28 13:39:24.426250 | debian-bookworm -> localhost | | .oE.+o| 2026-06-28 13:39:24.426270 | debian-bookworm -> localhost | | o +.= +.*| 2026-06-28 13:39:24.426290 | debian-bookworm -> localhost | | o.+.X.. o.++| 2026-06-28 13:39:24.426310 | debian-bookworm -> localhost | | . o+o=.o.o=o| 2026-06-28 13:39:24.426330 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-28 13:39:24.426384 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.026372 2026-06-28 13:39:24.433007 | 2026-06-28 13:39:24.433105 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-28 13:39:24.452833 | debian-bookworm | ok 2026-06-28 13:39:24.462801 | debian-bookworm | included: /var/lib/zuul/builds/7978e6ff697e490db6c2d0cf341112c4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-28 13:39:24.470785 | 2026-06-28 13:39:24.470892 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-28 13:39:24.494126 | debian-bookworm | skipping: Conditional result was False 2026-06-28 13:39:24.500749 | 2026-06-28 13:39:24.500842 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-28 13:39:25.187507 | debian-bookworm | changed 2026-06-28 13:39:25.192996 | 2026-06-28 13:39:25.193091 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-28 13:39:25.474455 | debian-bookworm | ok 2026-06-28 13:39:25.501405 | 2026-06-28 13:39:25.501627 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-28 13:39:26.232525 | debian-bookworm | changed 2026-06-28 13:39:26.241770 | 2026-06-28 13:39:26.241904 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-28 13:39:26.943247 | debian-bookworm | changed 2026-06-28 13:39:26.949494 | 2026-06-28 13:39:26.949624 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-28 13:39:26.973845 | debian-bookworm | skipping: Conditional result was False 2026-06-28 13:39:26.981573 | 2026-06-28 13:39:26.981955 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-28 13:39:27.489769 | debian-bookworm -> localhost | changed 2026-06-28 13:39:27.508929 | 2026-06-28 13:39:27.509084 | TASK [add-build-sshkey : Add back temp key] 2026-06-28 13:39:27.900051 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/7978e6ff697e490db6c2d0cf341112c4/work/7978e6ff697e490db6c2d0cf341112c4_id_rsa (zuul-build-sshkey) 2026-06-28 13:39:27.900618 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.020307 2026-06-28 13:39:27.925035 | 2026-06-28 13:39:27.925199 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-28 13:39:28.349624 | debian-bookworm | ok 2026-06-28 13:39:28.357425 | 2026-06-28 13:39:28.357632 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-28 13:39:28.393595 | debian-bookworm | skipping: Conditional result was False 2026-06-28 13:39:28.409657 | 2026-06-28 13:39:28.409818 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-28 13:39:28.898625 | debian-bookworm | ok 2026-06-28 13:39:28.914989 | 2026-06-28 13:39:28.915158 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-28 13:39:28.973594 | debian-bookworm | ok 2026-06-28 13:39:28.985657 | 2026-06-28 13:39:28.985958 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-28 13:39:29.321157 | debian-bookworm -> localhost | ok 2026-06-28 13:39:29.334114 | 2026-06-28 13:39:29.334320 | TASK [validate-host : Collect information about the host] 2026-06-28 13:39:30.511611 | debian-bookworm | ok 2026-06-28 13:39:30.528376 | 2026-06-28 13:39:30.528508 | TASK [validate-host : Sanitize hostname] 2026-06-28 13:39:30.706130 | debian-bookworm | ok 2026-06-28 13:39:30.711226 | 2026-06-28 13:39:30.711344 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-28 13:39:31.386291 | debian-bookworm -> localhost | changed 2026-06-28 13:39:31.393757 | 2026-06-28 13:39:31.393907 | TASK [validate-host : Collect information about zuul worker] 2026-06-28 13:39:31.886599 | debian-bookworm | ok 2026-06-28 13:39:31.891802 | 2026-06-28 13:39:31.891921 | TASK [validate-host : Write out all zuul information for each host] 2026-06-28 13:39:32.510060 | debian-bookworm -> localhost | changed 2026-06-28 13:39:32.520925 | 2026-06-28 13:39:32.521062 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-28 13:39:32.822133 | debian-bookworm | ok 2026-06-28 13:39:32.832086 | 2026-06-28 13:39:32.832249 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-28 13:39:34.090795 | debian-bookworm | changed: 2026-06-28 13:39:34.091224 | debian-bookworm | cd+++++++++ src/ 2026-06-28 13:39:34.091294 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-28 13:39:34.091343 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-28 13:39:34.091387 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-06-28 13:39:34.091431 | debian-bookworm | Containerfile 2026-06-28 13:39:34.091893 | debian-bookworm | Containerfile 2026-06-28 13:39:34.116507 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/7978e6ff697e490db6c2d0cf341112c4/work/logs" 2026-06-28 13:42:10.412405 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/7978e6ff697e490db6c2d0cf341112c4/work/artifacts" 2026-06-28 13:42:10.728055 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/7978e6ff697e490db6c2d0cf341112c4/work/docs" 2026-06-28 13:42:10.741360 | 2026-06-28 13:42:10.741504 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-28 13:42:11.787593 | debian-bookworm | changed: 2026-06-28 13:42:11.787905 | debian-bookworm | .d..t...... ./ 2026-06-28 13:42:11.787944 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-06-28 13:42:11.787968 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-06-28 13:42:11.787990 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-28 13:42:11.788011 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-28 13:42:11.788031 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-28 13:42:11.788076 | debian-bookworm | changed: All items complete 2026-06-28 13:42:11.788149 | 2026-06-28 13:42:12.388915 | debian-bookworm | changed: .d..t...... ./ 2026-06-28 13:42:13.046278 | debian-bookworm | changed: .d..t...... ./ 2026-06-28 13:42:13.068872 | 2026-06-28 13:42:13.069044 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-28 13:42:13.553787 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.007668 2026-06-28 13:42:13.853452 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.008677 2026-06-28 13:42:13.879526 | 2026-06-28 13:42:13.879700 | PLAY RECAP 2026-06-28 13:42:13.879898 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-28 13:42:13.879945 | 2026-06-28 13:42:14.038902 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-28 13:42:14.040223 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-28 13:42:14.962061 | 2026-06-28 13:42:14.962272 | PLAY [Base post] 2026-06-28 13:42:14.978416 | 2026-06-28 13:42:14.978637 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-28 13:42:15.838458 | debian-bookworm | changed 2026-06-28 13:42:15.853359 | 2026-06-28 13:42:15.853540 | PLAY RECAP 2026-06-28 13:42:15.853631 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-28 13:42:15.853701 | 2026-06-28 13:42:16.207005 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-28 13:42:16.208083 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-28 13:42:17.249225 | 2026-06-28 13:42:17.249436 | PLAY [Base post-logs] 2026-06-28 13:42:17.262148 | 2026-06-28 13:42:17.262349 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-28 13:42:17.934135 | localhost | changed 2026-06-28 13:42:17.947596 | 2026-06-28 13:42:17.947780 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-28 13:42:17.977829 | localhost | ok 2026-06-28 13:42:17.986605 | 2026-06-28 13:42:17.986743 | TASK [Set zuul-log-path fact] 2026-06-28 13:42:18.022906 | localhost | ok 2026-06-28 13:42:18.032385 | 2026-06-28 13:42:18.032531 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-28 13:42:18.080913 | localhost | ok 2026-06-28 13:42:18.084474 | 2026-06-28 13:42:18.084641 | TASK [upload-logs : Create log directories] 2026-06-28 13:42:18.756703 | localhost | changed 2026-06-28 13:42:18.760066 | 2026-06-28 13:42:18.760188 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-28 13:42:19.624931 | localhost -> localhost | ok: Runtime: 0:00:00.008730 2026-06-28 13:42:19.629774 | 2026-06-28 13:42:19.629924 | TASK [upload-logs : Upload logs to log server] 2026-06-28 13:42:20.312445 | localhost | Output suppressed because no_log was given 2026-06-28 13:42:20.314529 | 2026-06-28 13:42:20.314664 | LOOP [upload-logs : Compress console log and json output] 2026-06-28 13:42:20.374182 | localhost | skipping: Conditional result was False 2026-06-28 13:42:20.383590 | localhost | skipping: Conditional result was False 2026-06-28 13:42:20.392826 | 2026-06-28 13:42:20.392998 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-28 13:42:20.447526 | localhost | skipping: Conditional result was False 2026-06-28 13:42:20.448201 | 2026-06-28 13:42:20.451928 | localhost | skipping: Conditional result was False 2026-06-28 13:42:20.462091 | 2026-06-28 13:42:20.462246 | LOOP [upload-logs : Upload console log and json output]