2026-06-12 12:48:31.379559 | Job console starting 2026-06-12 12:48:31.413290 | Updating git repos 2026-06-12 12:48:31.526922 | Cloning repos into workspace 2026-06-12 12:48:31.635772 | Restoring repo states 2026-06-12 12:48:31.654351 | Merging changes 2026-06-12 12:48:32.517498 | Checking out repos 2026-06-12 12:48:32.652555 | Preparing playbooks 2026-06-12 12:48:35.114120 | Running Ansible setup 2026-06-12 12:48:41.780143 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-12 12:48:42.953850 | 2026-06-12 12:48:42.954006 | PLAY [Base pre] 2026-06-12 12:48:42.989823 | 2026-06-12 12:48:42.989967 | TASK [Setup log path fact] 2026-06-12 12:48:43.019262 | debian-bookworm | ok 2026-06-12 12:48:43.035105 | 2026-06-12 12:48:43.035245 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-12 12:48:43.095544 | debian-bookworm | ok 2026-06-12 12:48:43.105477 | 2026-06-12 12:48:43.105577 | TASK [emit-job-header : Print job information] 2026-06-12 12:48:43.172807 | # Job Information 2026-06-12 12:48:43.173068 | Ansible Version: 2.16.14 2026-06-12 12:48:43.173108 | Job: python-osism-test-setup 2026-06-12 12:48:43.173147 | Pipeline: check 2026-06-12 12:48:43.173174 | Executor: 521e9411259a 2026-06-12 12:48:43.173196 | Triggered by: https://github.com/osism/python-osism/pull/2367 2026-06-12 12:48:43.173218 | Event ID: fde51830-665c-11f1-877b-b4fe09937e69 2026-06-12 12:48:43.178500 | 2026-06-12 12:48:43.178628 | LOOP [emit-job-header : Print node information] 2026-06-12 12:48:43.346515 | debian-bookworm | ok: 2026-06-12 12:48:43.346695 | debian-bookworm | # Node Information 2026-06-12 12:48:43.346737 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-12 12:48:43.346767 | debian-bookworm | Hostname: debian 2026-06-12 12:48:43.346796 | debian-bookworm | Username: zuul 2026-06-12 12:48:43.346824 | debian-bookworm | Distro: Debian 12.14 2026-06-12 12:48:43.346869 | debian-bookworm | Provider: regiocloud-a 2026-06-12 12:48:43.346897 | debian-bookworm | Region: 2026-06-12 12:48:43.346924 | debian-bookworm | Label: debian-bookworm 2026-06-12 12:48:43.346950 | debian-bookworm | Product Name: OpenStack Nova 2026-06-12 12:48:43.346976 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec2:a87d 2026-06-12 12:48:43.359512 | 2026-06-12 12:48:43.359647 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-12 12:48:43.883350 | debian-bookworm -> localhost | changed 2026-06-12 12:48:43.890670 | 2026-06-12 12:48:43.890784 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-12 12:48:45.523483 | debian-bookworm -> localhost | changed 2026-06-12 12:48:45.535170 | 2026-06-12 12:48:45.535295 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-12 12:48:46.189643 | debian-bookworm -> localhost | ok 2026-06-12 12:48:46.195917 | 2026-06-12 12:48:46.196063 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-12 12:48:46.227478 | debian-bookworm | ok 2026-06-12 12:48:46.283344 | debian-bookworm | included: /var/lib/zuul/builds/c2b48aa49b0947b58f977824fc480729/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-12 12:48:46.289623 | 2026-06-12 12:48:46.289718 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-12 12:48:48.113359 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-12 12:48:48.113529 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c2b48aa49b0947b58f977824fc480729/work/c2b48aa49b0947b58f977824fc480729_id_rsa 2026-06-12 12:48:48.113560 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c2b48aa49b0947b58f977824fc480729/work/c2b48aa49b0947b58f977824fc480729_id_rsa.pub 2026-06-12 12:48:48.113581 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-12 12:48:48.113600 | debian-bookworm -> localhost | SHA256:Xb/5NBxMjgjWjzphp/O3BsPmoLjlMVklmPhj4U3Es2E zuul-build-sshkey 2026-06-12 12:48:48.113619 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-12 12:48:48.113646 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-12 12:48:48.113664 | debian-bookworm -> localhost | | .. | 2026-06-12 12:48:48.113682 | debian-bookworm -> localhost | | . +E. | 2026-06-12 12:48:48.113698 | debian-bookworm -> localhost | | . +.=+o. . | 2026-06-12 12:48:48.113715 | debian-bookworm -> localhost | | o =o+.+.= | 2026-06-12 12:48:48.113731 | debian-bookworm -> localhost | | =S=o+ o.+ | 2026-06-12 12:48:48.113749 | debian-bookworm -> localhost | | . =.== .o.| 2026-06-12 12:48:48.113765 | debian-bookworm -> localhost | | .=.=+ o oo.| 2026-06-12 12:48:48.113841 | debian-bookworm -> localhost | | .o.o +. o o.| 2026-06-12 12:48:48.113864 | debian-bookworm -> localhost | | ... .o.. .| 2026-06-12 12:48:48.113882 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-12 12:48:48.113940 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.695372 2026-06-12 12:48:48.127431 | 2026-06-12 12:48:48.127526 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-12 12:48:48.164356 | debian-bookworm | ok 2026-06-12 12:48:48.172864 | debian-bookworm | included: /var/lib/zuul/builds/c2b48aa49b0947b58f977824fc480729/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-12 12:48:48.180190 | 2026-06-12 12:48:48.180260 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-12 12:48:48.233488 | debian-bookworm | skipping: Conditional result was False 2026-06-12 12:48:48.238497 | 2026-06-12 12:48:48.238597 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-12 12:48:48.914306 | debian-bookworm | changed 2026-06-12 12:48:48.923616 | 2026-06-12 12:48:48.923762 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-12 12:48:49.212572 | debian-bookworm | ok 2026-06-12 12:48:49.220151 | 2026-06-12 12:48:49.220264 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-12 12:48:49.902546 | debian-bookworm | changed 2026-06-12 12:48:49.908358 | 2026-06-12 12:48:49.908454 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-12 12:48:50.506641 | debian-bookworm | changed 2026-06-12 12:48:50.512316 | 2026-06-12 12:48:50.512441 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-12 12:48:50.540927 | debian-bookworm | skipping: Conditional result was False 2026-06-12 12:48:50.547332 | 2026-06-12 12:48:50.547446 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-12 12:48:51.475194 | debian-bookworm -> localhost | changed 2026-06-12 12:48:51.485990 | 2026-06-12 12:48:51.486151 | TASK [add-build-sshkey : Add back temp key] 2026-06-12 12:48:52.175236 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c2b48aa49b0947b58f977824fc480729/work/c2b48aa49b0947b58f977824fc480729_id_rsa (zuul-build-sshkey) 2026-06-12 12:48:52.175509 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.045700 2026-06-12 12:48:52.184930 | 2026-06-12 12:48:52.185072 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-12 12:48:52.890780 | debian-bookworm | ok 2026-06-12 12:48:52.896315 | 2026-06-12 12:48:52.896434 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-12 12:48:52.936939 | debian-bookworm | skipping: Conditional result was False 2026-06-12 12:48:52.948703 | 2026-06-12 12:48:52.948847 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-12 12:48:53.520539 | debian-bookworm | ok 2026-06-12 12:48:53.555948 | 2026-06-12 12:48:53.556126 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-12 12:48:53.609550 | debian-bookworm | ok 2026-06-12 12:48:53.626134 | 2026-06-12 12:48:53.626322 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-12 12:48:54.134983 | debian-bookworm -> localhost | ok 2026-06-12 12:48:54.142269 | 2026-06-12 12:48:54.142409 | TASK [validate-host : Collect information about the host] 2026-06-12 12:48:55.492818 | debian-bookworm | ok 2026-06-12 12:48:55.519437 | 2026-06-12 12:48:55.519590 | TASK [validate-host : Sanitize hostname] 2026-06-12 12:48:56.040753 | debian-bookworm | ok 2026-06-12 12:48:56.062566 | 2026-06-12 12:48:56.062713 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-12 12:48:56.915789 | debian-bookworm -> localhost | changed 2026-06-12 12:48:56.921188 | 2026-06-12 12:48:56.921280 | TASK [validate-host : Collect information about zuul worker] 2026-06-12 12:48:57.417007 | debian-bookworm | ok 2026-06-12 12:48:57.421589 | 2026-06-12 12:48:57.421678 | TASK [validate-host : Write out all zuul information for each host] 2026-06-12 12:48:58.294055 | debian-bookworm -> localhost | changed 2026-06-12 12:48:58.308052 | 2026-06-12 12:48:58.308167 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-12 12:48:58.590429 | debian-bookworm | ok 2026-06-12 12:48:58.596294 | 2026-06-12 12:48:58.596392 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-12 12:48:59.664977 | debian-bookworm | changed: 2026-06-12 12:48:59.665186 | debian-bookworm | cd+++++++++ src/ 2026-06-12 12:48:59.665230 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-12 12:48:59.665259 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-12 12:48:59.665285 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-06-12 12:48:59.665310 | debian-bookworm | Containerfile 2026-06-12 12:48:59.665467 | debian-bookworm | Containerfile 2026-06-12 12:48:59.690049 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/c2b48aa49b0947b58f977824fc480729/work/logs" 2026-06-12 12:51:44.029727 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/c2b48aa49b0947b58f977824fc480729/work/artifacts" 2026-06-12 12:51:44.312052 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/c2b48aa49b0947b58f977824fc480729/work/docs" 2026-06-12 12:51:44.326594 | 2026-06-12 12:51:44.326745 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-12 12:51:45.231766 | debian-bookworm | changed: 2026-06-12 12:51:45.232488 | debian-bookworm | .d..t...... ./ 2026-06-12 12:51:45.232538 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-06-12 12:51:45.232563 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-06-12 12:51:45.232586 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-12 12:51:45.232607 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-12 12:51:45.232628 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-12 12:51:45.232683 | debian-bookworm | changed: All items complete 2026-06-12 12:51:45.232710 | 2026-06-12 12:51:45.917144 | debian-bookworm | changed: .d..t...... ./ 2026-06-12 12:51:46.799232 | debian-bookworm | changed: .d..t...... ./ 2026-06-12 12:51:46.836086 | 2026-06-12 12:51:46.836452 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-12 12:51:47.281612 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.018598 2026-06-12 12:51:47.652915 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.032849 2026-06-12 12:51:47.667052 | 2026-06-12 12:51:47.667168 | PLAY RECAP 2026-06-12 12:51:47.667226 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-12 12:51:47.667251 | 2026-06-12 12:51:47.847727 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-12 12:51:47.849206 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-12 12:51:48.695295 | 2026-06-12 12:51:48.695473 | PLAY [Base post] 2026-06-12 12:51:48.730661 | 2026-06-12 12:51:48.730893 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-12 12:51:49.778644 | debian-bookworm | changed 2026-06-12 12:51:49.799994 | 2026-06-12 12:51:49.801197 | PLAY RECAP 2026-06-12 12:51:49.801314 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-12 12:51:49.801381 | 2026-06-12 12:51:50.387450 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-12 12:51:50.388295 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-12 12:51:51.543446 | 2026-06-12 12:51:51.543643 | PLAY [Base post-logs] 2026-06-12 12:51:51.562159 | 2026-06-12 12:51:51.562502 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-12 12:51:52.831734 | localhost | changed 2026-06-12 12:51:52.850977 | 2026-06-12 12:51:52.851267 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-12 12:51:52.915179 | localhost | ok 2026-06-12 12:51:52.918554 | 2026-06-12 12:51:52.918664 | TASK [Set zuul-log-path fact] 2026-06-12 12:51:52.947305 | localhost | ok 2026-06-12 12:51:52.956415 | 2026-06-12 12:51:52.956541 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-12 12:51:53.011141 | localhost | ok 2026-06-12 12:51:53.015073 | 2026-06-12 12:51:53.015190 | TASK [upload-logs : Create log directories] 2026-06-12 12:51:53.628992 | localhost | changed 2026-06-12 12:51:53.632465 | 2026-06-12 12:51:53.632586 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-12 12:51:54.382227 | localhost -> localhost | ok: Runtime: 0:00:00.034229 2026-06-12 12:51:54.387311 | 2026-06-12 12:51:54.387436 | TASK [upload-logs : Upload logs to log server] 2026-06-12 12:51:55.527402 | localhost | Output suppressed because no_log was given 2026-06-12 12:51:55.529337 | 2026-06-12 12:51:55.529448 | LOOP [upload-logs : Compress console log and json output] 2026-06-12 12:51:55.631983 | localhost | skipping: Conditional result was False 2026-06-12 12:51:55.650436 | localhost | skipping: Conditional result was False 2026-06-12 12:51:55.657907 | 2026-06-12 12:51:55.658085 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-12 12:51:55.763863 | localhost | skipping: Conditional result was False 2026-06-12 12:51:55.764247 | 2026-06-12 12:51:55.773826 | localhost | skipping: Conditional result was False 2026-06-12 12:51:55.781754 | 2026-06-12 12:51:55.781916 | LOOP [upload-logs : Upload console log and json output]