2026-06-14 20:02:00.009736 | Job console starting 2026-06-14 20:02:00.025853 | Updating git repos 2026-06-14 20:02:00.074895 | Cloning repos into workspace 2026-06-14 20:02:00.141687 | Restoring repo states 2026-06-14 20:02:00.179753 | Merging changes 2026-06-14 20:02:01.248628 | Checking out repos 2026-06-14 20:02:01.298737 | Preparing playbooks 2026-06-14 20:02:02.935808 | Running Ansible setup 2026-06-14 20:02:09.345927 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-14 20:02:10.454453 | 2026-06-14 20:02:10.454631 | PLAY [Base pre] 2026-06-14 20:02:10.475713 | 2026-06-14 20:02:10.475870 | TASK [Setup log path fact] 2026-06-14 20:02:10.498073 | debian-bookworm | ok 2026-06-14 20:02:10.519058 | 2026-06-14 20:02:10.519234 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-14 20:02:10.549345 | debian-bookworm | ok 2026-06-14 20:02:10.603248 | 2026-06-14 20:02:10.603425 | TASK [emit-job-header : Print job information] 2026-06-14 20:02:10.654807 | # Job Information 2026-06-14 20:02:10.655312 | Ansible Version: 2.16.14 2026-06-14 20:02:10.655374 | Job: python-osism-test-setup 2026-06-14 20:02:10.655410 | Pipeline: check 2026-06-14 20:02:10.655434 | Executor: 521e9411259a 2026-06-14 20:02:10.655456 | Triggered by: https://github.com/osism/python-osism/pull/2322 2026-06-14 20:02:10.655479 | Event ID: ac1fbe80-682b-11f1-819b-f36354052141 2026-06-14 20:02:10.661261 | 2026-06-14 20:02:10.661397 | LOOP [emit-job-header : Print node information] 2026-06-14 20:02:10.798271 | debian-bookworm | ok: 2026-06-14 20:02:10.798492 | debian-bookworm | # Node Information 2026-06-14 20:02:10.798529 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-14 20:02:10.798557 | debian-bookworm | Hostname: debian 2026-06-14 20:02:10.798580 | debian-bookworm | Username: zuul 2026-06-14 20:02:10.798822 | debian-bookworm | Distro: Debian 12.14 2026-06-14 20:02:10.798880 | debian-bookworm | Provider: regiocloud-a 2026-06-14 20:02:10.798906 | debian-bookworm | Region: 2026-06-14 20:02:10.798929 | debian-bookworm | Label: debian-bookworm 2026-06-14 20:02:10.798951 | debian-bookworm | Product Name: OpenStack Nova 2026-06-14 20:02:10.798971 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feeb:d01f 2026-06-14 20:02:10.815521 | 2026-06-14 20:02:10.815670 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-14 20:02:11.777586 | debian-bookworm -> localhost | changed 2026-06-14 20:02:11.787805 | 2026-06-14 20:02:11.787955 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-14 20:02:13.564391 | debian-bookworm -> localhost | changed 2026-06-14 20:02:13.582400 | 2026-06-14 20:02:13.582746 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-14 20:02:13.943242 | debian-bookworm -> localhost | ok 2026-06-14 20:02:13.951135 | 2026-06-14 20:02:13.951254 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-14 20:02:13.985863 | debian-bookworm | ok 2026-06-14 20:02:14.033220 | debian-bookworm | included: /var/lib/zuul/builds/115f53cd8ad7461a884a8b927da08510/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-14 20:02:14.051715 | 2026-06-14 20:02:14.051825 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-14 20:02:15.850825 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-14 20:02:15.851088 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/115f53cd8ad7461a884a8b927da08510/work/115f53cd8ad7461a884a8b927da08510_id_rsa 2026-06-14 20:02:15.851147 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/115f53cd8ad7461a884a8b927da08510/work/115f53cd8ad7461a884a8b927da08510_id_rsa.pub 2026-06-14 20:02:15.851185 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-14 20:02:15.851223 | debian-bookworm -> localhost | SHA256:wAdq40lN2TDdaoS6q/aLqjyt5Fohu+k0WmJmDKmWlwo zuul-build-sshkey 2026-06-14 20:02:15.851252 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-14 20:02:15.851286 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-14 20:02:15.851307 | debian-bookworm -> localhost | | =* . | 2026-06-14 20:02:15.851330 | debian-bookworm -> localhost | | =oo+ . | 2026-06-14 20:02:15.851351 | debian-bookworm -> localhost | | =.+... | 2026-06-14 20:02:15.851371 | debian-bookworm -> localhost | | . +.o oo | 2026-06-14 20:02:15.851391 | debian-bookworm -> localhost | |+ . o. .S | 2026-06-14 20:02:15.851418 | debian-bookworm -> localhost | |+o..o | 2026-06-14 20:02:15.851439 | debian-bookworm -> localhost | |E@+o . | 2026-06-14 20:02:15.851461 | debian-bookworm -> localhost | |%B=o. | 2026-06-14 20:02:15.851482 | debian-bookworm -> localhost | |@O=oo. | 2026-06-14 20:02:15.851502 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-14 20:02:15.851563 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.078670 2026-06-14 20:02:15.857955 | 2026-06-14 20:02:15.858091 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-14 20:02:15.906260 | debian-bookworm | ok 2026-06-14 20:02:15.939322 | debian-bookworm | included: /var/lib/zuul/builds/115f53cd8ad7461a884a8b927da08510/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-14 20:02:15.970271 | 2026-06-14 20:02:15.970397 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-14 20:02:16.004163 | debian-bookworm | skipping: Conditional result was False 2026-06-14 20:02:16.019394 | 2026-06-14 20:02:16.019514 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-14 20:02:16.786762 | debian-bookworm | changed 2026-06-14 20:02:16.792249 | 2026-06-14 20:02:16.792338 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-14 20:02:17.078223 | debian-bookworm | ok 2026-06-14 20:02:17.083956 | 2026-06-14 20:02:17.084136 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-14 20:02:17.794658 | debian-bookworm | changed 2026-06-14 20:02:17.799490 | 2026-06-14 20:02:17.799574 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-14 20:02:18.478944 | debian-bookworm | changed 2026-06-14 20:02:18.491812 | 2026-06-14 20:02:18.491918 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-14 20:02:18.519450 | debian-bookworm | skipping: Conditional result was False 2026-06-14 20:02:18.525599 | 2026-06-14 20:02:18.525702 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-14 20:02:19.248737 | debian-bookworm -> localhost | changed 2026-06-14 20:02:19.267173 | 2026-06-14 20:02:19.267284 | TASK [add-build-sshkey : Add back temp key] 2026-06-14 20:02:19.725797 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/115f53cd8ad7461a884a8b927da08510/work/115f53cd8ad7461a884a8b927da08510_id_rsa (zuul-build-sshkey) 2026-06-14 20:02:19.726041 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011475 2026-06-14 20:02:19.733595 | 2026-06-14 20:02:19.733699 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-14 20:02:20.182482 | debian-bookworm | ok 2026-06-14 20:02:20.188650 | 2026-06-14 20:02:20.188750 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-14 20:02:20.211923 | debian-bookworm | skipping: Conditional result was False 2026-06-14 20:02:20.222334 | 2026-06-14 20:02:20.222445 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-14 20:02:20.650998 | debian-bookworm | ok 2026-06-14 20:02:20.673591 | 2026-06-14 20:02:20.673705 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-14 20:02:20.721922 | debian-bookworm | ok 2026-06-14 20:02:20.726823 | 2026-06-14 20:02:20.726939 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-14 20:02:21.214484 | debian-bookworm -> localhost | ok 2026-06-14 20:02:21.221195 | 2026-06-14 20:02:21.221294 | TASK [validate-host : Collect information about the host] 2026-06-14 20:02:22.428396 | debian-bookworm | ok 2026-06-14 20:02:22.444984 | 2026-06-14 20:02:22.445131 | TASK [validate-host : Sanitize hostname] 2026-06-14 20:02:22.648475 | debian-bookworm | ok 2026-06-14 20:02:22.653728 | 2026-06-14 20:02:22.653868 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-14 20:02:23.413337 | debian-bookworm -> localhost | changed 2026-06-14 20:02:23.428073 | 2026-06-14 20:02:23.428191 | TASK [validate-host : Collect information about zuul worker] 2026-06-14 20:02:23.920532 | debian-bookworm | ok 2026-06-14 20:02:23.925438 | 2026-06-14 20:02:23.925542 | TASK [validate-host : Write out all zuul information for each host] 2026-06-14 20:02:24.599737 | debian-bookworm -> localhost | changed 2026-06-14 20:02:24.617411 | 2026-06-14 20:02:24.617533 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-14 20:02:24.918291 | debian-bookworm | ok 2026-06-14 20:02:24.923855 | 2026-06-14 20:02:24.923953 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-14 20:02:26.132654 | debian-bookworm | changed: 2026-06-14 20:02:26.132853 | debian-bookworm | cd+++++++++ src/ 2026-06-14 20:02:26.132891 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-14 20:02:26.132922 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-14 20:02:26.132944 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-06-14 20:02:26.132965 | debian-bookworm | Containerfile 2026-06-14 20:02:26.133113 | debian-bookworm | Containerfile 2026-06-14 20:02:26.154278 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/115f53cd8ad7461a884a8b927da08510/work/logs" 2026-06-14 20:05:16.556269 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/115f53cd8ad7461a884a8b927da08510/work/artifacts" 2026-06-14 20:05:17.294189 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/115f53cd8ad7461a884a8b927da08510/work/docs" 2026-06-14 20:05:17.308587 | 2026-06-14 20:05:17.308718 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-14 20:05:19.263630 | debian-bookworm | changed: 2026-06-14 20:05:19.264402 | debian-bookworm | .d..t...... ./ 2026-06-14 20:05:19.264462 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-06-14 20:05:19.264490 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-06-14 20:05:19.264513 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-14 20:05:19.264541 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-14 20:05:19.264577 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-14 20:05:19.264630 | debian-bookworm | changed: All items complete 2026-06-14 20:05:19.264658 | 2026-06-14 20:05:20.354234 | debian-bookworm | changed: .d..t...... ./ 2026-06-14 20:05:21.126694 | debian-bookworm | changed: .d..t...... ./ 2026-06-14 20:05:21.147787 | 2026-06-14 20:05:21.147900 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-14 20:05:21.581169 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.008738 2026-06-14 20:05:21.973075 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.018266 2026-06-14 20:05:21.990250 | 2026-06-14 20:05:21.990382 | PLAY RECAP 2026-06-14 20:05:21.990435 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-14 20:05:21.990460 | 2026-06-14 20:05:22.276966 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-14 20:05:22.277753 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-14 20:05:23.632125 | 2026-06-14 20:05:23.632302 | PLAY [Base post] 2026-06-14 20:05:23.651586 | 2026-06-14 20:05:23.651716 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-14 20:05:24.502124 | debian-bookworm | changed 2026-06-14 20:05:24.511847 | 2026-06-14 20:05:24.511972 | PLAY RECAP 2026-06-14 20:05:24.512028 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-14 20:05:24.512083 | 2026-06-14 20:05:24.598755 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-14 20:05:24.599568 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-14 20:05:25.815670 | 2026-06-14 20:05:25.815798 | PLAY [Base post-logs] 2026-06-14 20:05:25.825389 | 2026-06-14 20:05:25.825499 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-14 20:05:26.582288 | localhost | changed 2026-06-14 20:05:26.598552 | 2026-06-14 20:05:26.598695 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-14 20:05:26.654261 | localhost | ok 2026-06-14 20:05:26.657105 | 2026-06-14 20:05:26.657202 | TASK [Set zuul-log-path fact] 2026-06-14 20:05:26.683903 | localhost | ok 2026-06-14 20:05:26.691673 | 2026-06-14 20:05:26.698267 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-14 20:05:26.741302 | localhost | ok 2026-06-14 20:05:26.745956 | 2026-06-14 20:05:26.746180 | TASK [upload-logs : Create log directories] 2026-06-14 20:05:28.015997 | localhost | changed 2026-06-14 20:05:28.018597 | 2026-06-14 20:05:28.018693 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-14 20:05:29.032049 | localhost -> localhost | ok: Runtime: 0:00:00.015859 2026-06-14 20:05:29.037714 | 2026-06-14 20:05:29.037818 | TASK [upload-logs : Upload logs to log server] 2026-06-14 20:05:30.003145 | localhost | Output suppressed because no_log was given 2026-06-14 20:05:30.004821 | 2026-06-14 20:05:30.004904 | LOOP [upload-logs : Compress console log and json output] 2026-06-14 20:05:30.113001 | localhost | skipping: Conditional result was False 2026-06-14 20:05:30.122278 | localhost | skipping: Conditional result was False 2026-06-14 20:05:30.128642 | 2026-06-14 20:05:30.128788 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-14 20:05:30.304128 | localhost | skipping: Conditional result was False 2026-06-14 20:05:30.304360 | 2026-06-14 20:05:30.319884 | localhost | skipping: Conditional result was False 2026-06-14 20:05:30.328032 | 2026-06-14 20:05:30.328173 | LOOP [upload-logs : Upload console log and json output]