2026-06-09 20:58:46.835967 | Job console starting 2026-06-09 20:58:46.892445 | Updating git repos 2026-06-09 20:58:46.986476 | Cloning repos into workspace 2026-06-09 20:58:47.147319 | Restoring repo states 2026-06-09 20:58:47.171128 | Merging changes 2026-06-09 20:58:48.033022 | Checking out repos 2026-06-09 20:58:48.208858 | Preparing playbooks 2026-06-09 20:58:51.343048 | Running Ansible setup 2026-06-09 20:58:58.934720 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-09 20:59:01.291969 | 2026-06-09 20:59:01.292122 | PLAY [Base pre] 2026-06-09 20:59:01.316141 | 2026-06-09 20:59:01.316276 | TASK [Setup log path fact] 2026-06-09 20:59:01.356577 | debian-bookworm | ok 2026-06-09 20:59:01.384754 | 2026-06-09 20:59:01.384947 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-09 20:59:01.438773 | debian-bookworm | ok 2026-06-09 20:59:01.451323 | 2026-06-09 20:59:01.451447 | TASK [emit-job-header : Print job information] 2026-06-09 20:59:01.504479 | # Job Information 2026-06-09 20:59:01.504668 | Ansible Version: 2.16.14 2026-06-09 20:59:01.504706 | Job: python-osism-test-setup 2026-06-09 20:59:01.504739 | Pipeline: check 2026-06-09 20:59:01.504762 | Executor: 521e9411259a 2026-06-09 20:59:01.504782 | Triggered by: https://github.com/osism/python-osism/pull/2334 2026-06-09 20:59:01.504804 | Event ID: fafad6a0-6445-11f1-93f0-f2928fc61640 2026-06-09 20:59:01.511914 | 2026-06-09 20:59:01.512044 | LOOP [emit-job-header : Print node information] 2026-06-09 20:59:01.829209 | debian-bookworm | ok: 2026-06-09 20:59:01.829445 | debian-bookworm | # Node Information 2026-06-09 20:59:01.829482 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-09 20:59:01.829507 | debian-bookworm | Hostname: debian 2026-06-09 20:59:01.829529 | debian-bookworm | Username: zuul 2026-06-09 20:59:01.829549 | debian-bookworm | Distro: Debian 12.14 2026-06-09 20:59:01.829572 | debian-bookworm | Provider: regiocloud-a 2026-06-09 20:59:01.829593 | debian-bookworm | Region: 2026-06-09 20:59:01.829614 | debian-bookworm | Label: debian-bookworm 2026-06-09 20:59:01.829634 | debian-bookworm | Product Name: OpenStack Nova 2026-06-09 20:59:01.829653 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe3b:2392 2026-06-09 20:59:01.850208 | 2026-06-09 20:59:01.850331 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-09 20:59:02.961512 | debian-bookworm -> localhost | changed 2026-06-09 20:59:02.968632 | 2026-06-09 20:59:02.968764 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-09 20:59:05.903841 | debian-bookworm -> localhost | changed 2026-06-09 20:59:05.941339 | 2026-06-09 20:59:05.941618 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-09 20:59:06.749423 | debian-bookworm -> localhost | ok 2026-06-09 20:59:06.754711 | 2026-06-09 20:59:06.754816 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-09 20:59:06.804558 | debian-bookworm | ok 2026-06-09 20:59:06.841066 | debian-bookworm | included: /var/lib/zuul/builds/9adcaf7d130646f2a9c9026bfce9cf17/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-09 20:59:06.851731 | 2026-06-09 20:59:06.851847 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-09 20:59:09.395414 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-09 20:59:09.395608 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/9adcaf7d130646f2a9c9026bfce9cf17/work/9adcaf7d130646f2a9c9026bfce9cf17_id_rsa 2026-06-09 20:59:09.395640 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/9adcaf7d130646f2a9c9026bfce9cf17/work/9adcaf7d130646f2a9c9026bfce9cf17_id_rsa.pub 2026-06-09 20:59:09.395662 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-09 20:59:09.395682 | debian-bookworm -> localhost | SHA256:ky2atU72rr8jwOVAzRUNMh5iOEW/TaxPNZoV+CwJAPI zuul-build-sshkey 2026-06-09 20:59:09.395701 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-09 20:59:09.395732 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-09 20:59:09.395751 | debian-bookworm -> localhost | | . .=*++.+=. | 2026-06-09 20:59:09.395769 | debian-bookworm -> localhost | | oo..++=. .. | 2026-06-09 20:59:09.395786 | debian-bookworm -> localhost | | Eo o.o++ | 2026-06-09 20:59:09.395802 | debian-bookworm -> localhost | | . .Bo=o. | 2026-06-09 20:59:09.395818 | debian-bookworm -> localhost | | . +S *. | 2026-06-09 20:59:09.395838 | debian-bookworm -> localhost | | o+.* | 2026-06-09 20:59:09.395855 | debian-bookworm -> localhost | | o.+ . | 2026-06-09 20:59:09.395870 | debian-bookworm -> localhost | | +... | 2026-06-09 20:59:09.395910 | debian-bookworm -> localhost | | o==o | 2026-06-09 20:59:09.395928 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-09 20:59:09.395976 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.061855 2026-06-09 20:59:09.401324 | 2026-06-09 20:59:09.401412 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-09 20:59:09.439816 | debian-bookworm | ok 2026-06-09 20:59:09.456318 | debian-bookworm | included: /var/lib/zuul/builds/9adcaf7d130646f2a9c9026bfce9cf17/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-09 20:59:09.467871 | 2026-06-09 20:59:09.467974 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-09 20:59:09.518607 | debian-bookworm | skipping: Conditional result was False 2026-06-09 20:59:09.540149 | 2026-06-09 20:59:09.540281 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-09 20:59:10.420151 | debian-bookworm | changed 2026-06-09 20:59:10.425658 | 2026-06-09 20:59:10.425740 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-09 20:59:10.709625 | debian-bookworm | ok 2026-06-09 20:59:10.717856 | 2026-06-09 20:59:10.717954 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-09 20:59:11.438067 | debian-bookworm | changed 2026-06-09 20:59:11.442637 | 2026-06-09 20:59:11.442719 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-09 20:59:12.130546 | debian-bookworm | changed 2026-06-09 20:59:12.136498 | 2026-06-09 20:59:12.136578 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-09 20:59:12.173532 | debian-bookworm | skipping: Conditional result was False 2026-06-09 20:59:12.178535 | 2026-06-09 20:59:12.178621 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-09 20:59:13.180144 | debian-bookworm -> localhost | changed 2026-06-09 20:59:13.190410 | 2026-06-09 20:59:13.190511 | TASK [add-build-sshkey : Add back temp key] 2026-06-09 20:59:13.762858 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/9adcaf7d130646f2a9c9026bfce9cf17/work/9adcaf7d130646f2a9c9026bfce9cf17_id_rsa (zuul-build-sshkey) 2026-06-09 20:59:13.763218 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.041264 2026-06-09 20:59:13.770724 | 2026-06-09 20:59:13.770864 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-09 20:59:14.145350 | debian-bookworm | ok 2026-06-09 20:59:14.150279 | 2026-06-09 20:59:14.150364 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-09 20:59:14.197330 | debian-bookworm | skipping: Conditional result was False 2026-06-09 20:59:14.207163 | 2026-06-09 20:59:14.207263 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-09 20:59:14.845605 | debian-bookworm | ok 2026-06-09 20:59:14.864192 | 2026-06-09 20:59:14.864297 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-09 20:59:14.906073 | debian-bookworm | ok 2026-06-09 20:59:14.911313 | 2026-06-09 20:59:14.911408 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-09 20:59:15.606484 | debian-bookworm -> localhost | ok 2026-06-09 20:59:15.612588 | 2026-06-09 20:59:15.612680 | TASK [validate-host : Collect information about the host] 2026-06-09 20:59:16.961054 | debian-bookworm | ok 2026-06-09 20:59:17.006703 | 2026-06-09 20:59:17.006804 | TASK [validate-host : Sanitize hostname] 2026-06-09 20:59:17.385514 | debian-bookworm | ok 2026-06-09 20:59:17.399426 | 2026-06-09 20:59:17.399555 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-09 20:59:18.291089 | debian-bookworm -> localhost | changed 2026-06-09 20:59:18.297430 | 2026-06-09 20:59:18.297526 | TASK [validate-host : Collect information about zuul worker] 2026-06-09 20:59:18.834933 | debian-bookworm | ok 2026-06-09 20:59:18.847952 | 2026-06-09 20:59:18.848072 | TASK [validate-host : Write out all zuul information for each host] 2026-06-09 20:59:20.007038 | debian-bookworm -> localhost | changed 2026-06-09 20:59:20.014440 | 2026-06-09 20:59:20.014515 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-09 20:59:20.323760 | debian-bookworm | ok 2026-06-09 20:59:20.328759 | 2026-06-09 20:59:20.328856 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-09 20:59:21.915684 | debian-bookworm | changed: 2026-06-09 20:59:21.915905 | debian-bookworm | cd+++++++++ src/ 2026-06-09 20:59:21.915943 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-09 20:59:21.915968 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-09 20:59:21.915990 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-06-09 20:59:21.916010 | debian-bookworm | Containerfile 2026-06-09 20:59:21.916162 | debian-bookworm | Containerfile 2026-06-09 20:59:21.943805 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/9adcaf7d130646f2a9c9026bfce9cf17/work/logs" 2026-06-09 21:02:26.027252 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/9adcaf7d130646f2a9c9026bfce9cf17/work/artifacts" 2026-06-09 21:02:26.370460 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/9adcaf7d130646f2a9c9026bfce9cf17/work/docs" 2026-06-09 21:02:26.386635 | 2026-06-09 21:02:26.387254 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-09 21:02:27.506713 | debian-bookworm | changed: 2026-06-09 21:02:27.507004 | debian-bookworm | .d..t...... ./ 2026-06-09 21:02:27.507044 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-06-09 21:02:27.507069 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-06-09 21:02:27.507092 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-09 21:02:27.507113 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-09 21:02:27.507134 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-09 21:02:27.507174 | debian-bookworm | changed: All items complete 2026-06-09 21:02:27.507196 | 2026-06-09 21:02:28.147091 | debian-bookworm | changed: .d..t...... ./ 2026-06-09 21:02:28.778561 | debian-bookworm | changed: .d..t...... ./ 2026-06-09 21:02:28.794668 | 2026-06-09 21:02:28.794854 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-09 21:02:29.213576 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.012020 2026-06-09 21:02:29.588436 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.013707 2026-06-09 21:02:29.597054 | 2026-06-09 21:02:29.597150 | PLAY RECAP 2026-06-09 21:02:29.597201 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-09 21:02:29.597226 | 2026-06-09 21:02:29.804334 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-09 21:02:29.805260 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-09 21:02:30.968490 | 2026-06-09 21:02:30.970911 | PLAY [Base post] 2026-06-09 21:02:31.003736 | 2026-06-09 21:02:31.003942 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-09 21:02:31.833246 | debian-bookworm | changed 2026-06-09 21:02:31.859820 | 2026-06-09 21:02:31.860628 | PLAY RECAP 2026-06-09 21:02:31.860716 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-09 21:02:31.860825 | 2026-06-09 21:02:32.186211 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-09 21:02:32.187172 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-09 21:02:33.146807 | 2026-06-09 21:02:33.147037 | PLAY [Base post-logs] 2026-06-09 21:02:33.166470 | 2026-06-09 21:02:33.166655 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-09 21:02:33.694347 | localhost | changed 2026-06-09 21:02:33.706452 | 2026-06-09 21:02:33.706696 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-09 21:02:33.733951 | localhost | ok 2026-06-09 21:02:33.737330 | 2026-06-09 21:02:33.737576 | TASK [Set zuul-log-path fact] 2026-06-09 21:02:33.753523 | localhost | ok 2026-06-09 21:02:33.764116 | 2026-06-09 21:02:33.764231 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-09 21:02:33.791124 | localhost | ok 2026-06-09 21:02:33.794196 | 2026-06-09 21:02:33.794296 | TASK [upload-logs : Create log directories] 2026-06-09 21:02:34.347870 | localhost | changed 2026-06-09 21:02:34.351397 | 2026-06-09 21:02:34.351522 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-09 21:02:35.180522 | localhost -> localhost | ok: Runtime: 0:00:00.011172 2026-06-09 21:02:35.190356 | 2026-06-09 21:02:35.190579 | TASK [upload-logs : Upload logs to log server] 2026-06-09 21:02:35.801089 | localhost | Output suppressed because no_log was given 2026-06-09 21:02:35.804494 | 2026-06-09 21:02:35.804650 | LOOP [upload-logs : Compress console log and json output] 2026-06-09 21:02:35.863424 | localhost | skipping: Conditional result was False 2026-06-09 21:02:35.872322 | localhost | skipping: Conditional result was False 2026-06-09 21:02:35.876680 | 2026-06-09 21:02:35.876819 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-09 21:02:35.926042 | localhost | skipping: Conditional result was False 2026-06-09 21:02:35.926366 | 2026-06-09 21:02:35.931324 | localhost | skipping: Conditional result was False 2026-06-09 21:02:35.934780 | 2026-06-09 21:02:35.934943 | LOOP [upload-logs : Upload console log and json output]