2026-07-01 21:01:42.596225 | Job console starting 2026-07-01 21:01:42.608675 | Updating git repos 2026-07-01 21:01:42.962385 | Cloning repos into workspace 2026-07-01 21:01:43.105313 | Restoring repo states 2026-07-01 21:01:43.152047 | Merging changes 2026-07-01 21:01:44.069761 | Checking out repos 2026-07-01 21:01:44.256387 | Preparing playbooks 2026-07-01 21:01:46.336386 | Running Ansible setup 2026-07-01 21:01:53.087408 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-01 21:01:55.303582 | 2026-07-01 21:01:55.303723 | PLAY [Base pre] 2026-07-01 21:01:55.357122 | 2026-07-01 21:01:55.367040 | TASK [Setup log path fact] 2026-07-01 21:01:55.395483 | debian-bookworm | ok 2026-07-01 21:01:55.427814 | 2026-07-01 21:01:55.428138 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-01 21:01:55.476114 | debian-bookworm | ok 2026-07-01 21:01:55.484640 | 2026-07-01 21:01:55.484743 | TASK [emit-job-header : Print job information] 2026-07-01 21:01:55.563519 | # Job Information 2026-07-01 21:01:55.563679 | Ansible Version: 2.16.14 2026-07-01 21:01:55.563709 | Job: python-osism-test-setup 2026-07-01 21:01:55.563737 | Pipeline: check 2026-07-01 21:01:55.563755 | Executor: 521e9411259a 2026-07-01 21:01:55.563773 | Triggered by: https://github.com/osism/python-osism/pull/2426 2026-07-01 21:01:55.563791 | Event ID: 054da0f0-7590-11f1-80c8-0cc4bc8c06e7 2026-07-01 21:01:55.567925 | 2026-07-01 21:01:55.568009 | LOOP [emit-job-header : Print node information] 2026-07-01 21:01:55.785408 | debian-bookworm | ok: 2026-07-01 21:01:55.785655 | debian-bookworm | # Node Information 2026-07-01 21:01:55.785691 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-01 21:01:55.785713 | debian-bookworm | Hostname: debian 2026-07-01 21:01:55.785731 | debian-bookworm | Username: zuul 2026-07-01 21:01:55.785748 | debian-bookworm | Distro: Debian 12.14 2026-07-01 21:01:55.785767 | debian-bookworm | Provider: regiocloud-a 2026-07-01 21:01:55.785785 | debian-bookworm | Region: 2026-07-01 21:01:55.785802 | debian-bookworm | Label: debian-bookworm 2026-07-01 21:01:55.785819 | debian-bookworm | Product Name: OpenStack Nova 2026-07-01 21:01:55.785835 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe22:7071 2026-07-01 21:01:55.794581 | 2026-07-01 21:01:55.794677 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-01 21:01:57.267526 | debian-bookworm -> localhost | changed 2026-07-01 21:01:57.273518 | 2026-07-01 21:01:57.273618 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-01 21:02:00.001914 | debian-bookworm -> localhost | changed 2026-07-01 21:02:00.011004 | 2026-07-01 21:02:00.011108 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-01 21:02:00.753567 | debian-bookworm -> localhost | ok 2026-07-01 21:02:00.758598 | 2026-07-01 21:02:00.758692 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-01 21:02:00.786599 | debian-bookworm | ok 2026-07-01 21:02:00.826865 | debian-bookworm | included: /var/lib/zuul/builds/91b0f0cc716041b0aa6d417913e4bf0e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-01 21:02:00.832137 | 2026-07-01 21:02:00.832240 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-01 21:02:03.477853 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-01 21:02:03.478069 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/91b0f0cc716041b0aa6d417913e4bf0e/work/91b0f0cc716041b0aa6d417913e4bf0e_id_rsa 2026-07-01 21:02:03.478111 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/91b0f0cc716041b0aa6d417913e4bf0e/work/91b0f0cc716041b0aa6d417913e4bf0e_id_rsa.pub 2026-07-01 21:02:03.478139 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-01 21:02:03.478165 | debian-bookworm -> localhost | SHA256:auaisKt0b1fuOmUv4sfezDKf+qmwZjdsOTiImOM66Ns zuul-build-sshkey 2026-07-01 21:02:03.478201 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-01 21:02:03.478234 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-01 21:02:03.478255 | debian-bookworm -> localhost | | | 2026-07-01 21:02:03.478277 | debian-bookworm -> localhost | | | 2026-07-01 21:02:03.478297 | debian-bookworm -> localhost | | | 2026-07-01 21:02:03.478317 | debian-bookworm -> localhost | | | 2026-07-01 21:02:03.478337 | debian-bookworm -> localhost | | S | 2026-07-01 21:02:03.478360 | debian-bookworm -> localhost | | . + | 2026-07-01 21:02:03.478381 | debian-bookworm -> localhost | |o.o.. =.O o | 2026-07-01 21:02:03.478414 | debian-bookworm -> localhost | |+*o.o* Oo#+.o | 2026-07-01 21:02:03.478434 | debian-bookworm -> localhost | |X*+E.o*+@=@O | 2026-07-01 21:02:03.478454 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-01 21:02:03.478503 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.509863 2026-07-01 21:02:03.484965 | 2026-07-01 21:02:03.485064 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-01 21:02:03.533839 | debian-bookworm | ok 2026-07-01 21:02:03.552045 | debian-bookworm | included: /var/lib/zuul/builds/91b0f0cc716041b0aa6d417913e4bf0e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-01 21:02:03.572063 | 2026-07-01 21:02:03.572172 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-01 21:02:03.606084 | debian-bookworm | skipping: Conditional result was False 2026-07-01 21:02:03.613166 | 2026-07-01 21:02:03.613318 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-01 21:02:04.348070 | debian-bookworm | changed 2026-07-01 21:02:04.370860 | 2026-07-01 21:02:04.370979 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-01 21:02:04.661133 | debian-bookworm | ok 2026-07-01 21:02:04.668252 | 2026-07-01 21:02:04.668358 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-01 21:02:05.475976 | debian-bookworm | changed 2026-07-01 21:02:05.486509 | 2026-07-01 21:02:05.486616 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-01 21:02:06.257565 | debian-bookworm | changed 2026-07-01 21:02:06.285737 | 2026-07-01 21:02:06.285864 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-01 21:02:06.335879 | debian-bookworm | skipping: Conditional result was False 2026-07-01 21:02:06.342677 | 2026-07-01 21:02:06.342781 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-01 21:02:07.544508 | debian-bookworm -> localhost | changed 2026-07-01 21:02:07.553525 | 2026-07-01 21:02:07.553632 | TASK [add-build-sshkey : Add back temp key] 2026-07-01 21:02:08.224382 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/91b0f0cc716041b0aa6d417913e4bf0e/work/91b0f0cc716041b0aa6d417913e4bf0e_id_rsa (zuul-build-sshkey) 2026-07-01 21:02:08.224654 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.024451 2026-07-01 21:02:08.232053 | 2026-07-01 21:02:08.232145 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-01 21:02:08.842316 | debian-bookworm | ok 2026-07-01 21:02:08.846499 | 2026-07-01 21:02:08.846577 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-01 21:02:08.896320 | debian-bookworm | skipping: Conditional result was False 2026-07-01 21:02:08.904984 | 2026-07-01 21:02:08.905116 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-01 21:02:09.382737 | debian-bookworm | ok 2026-07-01 21:02:09.392071 | 2026-07-01 21:02:09.392154 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-01 21:02:09.419031 | debian-bookworm | ok 2026-07-01 21:02:09.423244 | 2026-07-01 21:02:09.423315 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-01 21:02:09.772091 | debian-bookworm -> localhost | ok 2026-07-01 21:02:09.777372 | 2026-07-01 21:02:09.777450 | TASK [validate-host : Collect information about the host] 2026-07-01 21:02:11.040213 | debian-bookworm | ok 2026-07-01 21:02:11.052066 | 2026-07-01 21:02:11.052159 | TASK [validate-host : Sanitize hostname] 2026-07-01 21:02:11.172320 | debian-bookworm | ok 2026-07-01 21:02:11.176673 | 2026-07-01 21:02:11.176757 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-01 21:02:11.776736 | debian-bookworm -> localhost | changed 2026-07-01 21:02:11.782948 | 2026-07-01 21:02:11.783044 | TASK [validate-host : Collect information about zuul worker] 2026-07-01 21:02:12.271830 | debian-bookworm | ok 2026-07-01 21:02:12.305167 | 2026-07-01 21:02:12.305306 | TASK [validate-host : Write out all zuul information for each host] 2026-07-01 21:02:13.180143 | debian-bookworm -> localhost | changed 2026-07-01 21:02:13.193257 | 2026-07-01 21:02:13.193363 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-01 21:02:13.485292 | debian-bookworm | ok 2026-07-01 21:02:13.495716 | 2026-07-01 21:02:13.495853 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-01 21:02:14.742492 | debian-bookworm | changed: 2026-07-01 21:02:14.742673 | debian-bookworm | cd+++++++++ src/ 2026-07-01 21:02:14.742707 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-01 21:02:14.742732 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-01 21:02:14.742753 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-07-01 21:02:14.742773 | debian-bookworm | Containerfile 2026-07-01 21:02:14.742917 | debian-bookworm | Containerfile 2026-07-01 21:02:14.764611 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/91b0f0cc716041b0aa6d417913e4bf0e/work/logs" 2026-07-01 21:05:02.435725 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/91b0f0cc716041b0aa6d417913e4bf0e/work/artifacts" 2026-07-01 21:05:02.708841 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/91b0f0cc716041b0aa6d417913e4bf0e/work/docs" 2026-07-01 21:05:02.730547 | 2026-07-01 21:05:02.730753 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-01 21:05:03.611682 | debian-bookworm | changed: 2026-07-01 21:05:03.611925 | debian-bookworm | .d..t...... ./ 2026-07-01 21:05:03.611961 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-01 21:05:03.611986 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-01 21:05:03.612007 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-01 21:05:03.612029 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-01 21:05:03.612050 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-01 21:05:03.612094 | debian-bookworm | changed: All items complete 2026-07-01 21:05:03.612122 | 2026-07-01 21:05:04.199203 | debian-bookworm | changed: .d..t...... ./ 2026-07-01 21:05:04.819825 | debian-bookworm | changed: .d..t...... ./ 2026-07-01 21:05:04.844992 | 2026-07-01 21:05:04.845139 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-01 21:05:05.223678 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.010011 2026-07-01 21:05:05.529678 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.011321 2026-07-01 21:05:05.549402 | 2026-07-01 21:05:05.550323 | PLAY RECAP 2026-07-01 21:05:05.550397 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-07-01 21:05:05.550429 | 2026-07-01 21:05:05.759761 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-01 21:05:05.760747 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-01 21:05:06.627241 | 2026-07-01 21:05:06.627427 | PLAY [Base post] 2026-07-01 21:05:06.641773 | 2026-07-01 21:05:06.641943 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-01 21:05:07.480990 | debian-bookworm | changed 2026-07-01 21:05:07.499768 | 2026-07-01 21:05:07.500005 | PLAY RECAP 2026-07-01 21:05:07.500083 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-01 21:05:07.500147 | 2026-07-01 21:05:07.656041 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-01 21:05:07.657058 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-01 21:05:08.504699 | 2026-07-01 21:05:08.504901 | PLAY [Base post-logs] 2026-07-01 21:05:08.517731 | 2026-07-01 21:05:08.517913 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-01 21:05:09.023780 | localhost | changed 2026-07-01 21:05:09.041592 | 2026-07-01 21:05:09.041965 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-01 21:05:09.091097 | localhost | ok 2026-07-01 21:05:09.094732 | 2026-07-01 21:05:09.095022 | TASK [Set zuul-log-path fact] 2026-07-01 21:05:09.111599 | localhost | ok 2026-07-01 21:05:09.121888 | 2026-07-01 21:05:09.122001 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-01 21:05:09.147314 | localhost | ok 2026-07-01 21:05:09.150509 | 2026-07-01 21:05:09.150624 | TASK [upload-logs : Create log directories] 2026-07-01 21:05:09.745039 | localhost | changed 2026-07-01 21:05:09.750066 | 2026-07-01 21:05:09.750240 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-01 21:05:10.331677 | localhost -> localhost | ok: Runtime: 0:00:00.014707 2026-07-01 21:05:10.339083 | 2026-07-01 21:05:10.339259 | TASK [upload-logs : Upload logs to log server] 2026-07-01 21:05:10.962362 | localhost | Output suppressed because no_log was given 2026-07-01 21:05:10.964501 | 2026-07-01 21:05:10.964625 | LOOP [upload-logs : Compress console log and json output] 2026-07-01 21:05:11.016741 | localhost | skipping: Conditional result was False 2026-07-01 21:05:11.023738 | localhost | skipping: Conditional result was False 2026-07-01 21:05:11.032664 | 2026-07-01 21:05:11.032806 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-01 21:05:11.084480 | localhost | skipping: Conditional result was False 2026-07-01 21:05:11.084808 | 2026-07-01 21:05:11.094091 | localhost | skipping: Conditional result was False 2026-07-01 21:05:11.102178 | 2026-07-01 21:05:11.102576 | LOOP [upload-logs : Upload console log and json output]