2026-07-17 16:42:32.714236 | Job console starting 2026-07-17 16:42:32.748243 | Updating git repos 2026-07-17 16:42:32.841861 | Cloning repos into workspace 2026-07-17 16:42:33.051815 | Restoring repo states 2026-07-17 16:42:33.084804 | Merging changes 2026-07-17 16:42:34.002071 | Checking out repos 2026-07-17 16:42:34.165720 | Preparing playbooks 2026-07-17 16:42:36.480398 | Running Ansible setup 2026-07-17 16:42:42.738576 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-17 16:42:44.445923 | 2026-07-17 16:42:44.446069 | PLAY [Base pre] 2026-07-17 16:42:44.488426 | 2026-07-17 16:42:44.488558 | TASK [Setup log path fact] 2026-07-17 16:42:44.536353 | debian-bookworm | ok 2026-07-17 16:42:44.554589 | 2026-07-17 16:42:44.554721 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-17 16:42:44.619571 | debian-bookworm | ok 2026-07-17 16:42:44.632938 | 2026-07-17 16:42:44.633042 | TASK [emit-job-header : Print job information] 2026-07-17 16:42:44.671422 | # Job Information 2026-07-17 16:42:44.671576 | Ansible Version: 2.16.14 2026-07-17 16:42:44.671606 | Job: python-osism-test-setup 2026-07-17 16:42:44.671632 | Pipeline: check 2026-07-17 16:42:44.671651 | Executor: 521e9411259a 2026-07-17 16:42:44.671667 | Triggered by: https://github.com/osism/python-osism/pull/2484 2026-07-17 16:42:44.671685 | Event ID: 7934dd60-81fe-11f1-90e8-24867037fae9 2026-07-17 16:42:44.676198 | 2026-07-17 16:42:44.676290 | LOOP [emit-job-header : Print node information] 2026-07-17 16:42:44.795848 | debian-bookworm | ok: 2026-07-17 16:42:44.796017 | debian-bookworm | # Node Information 2026-07-17 16:42:44.796050 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-17 16:42:44.796075 | debian-bookworm | Hostname: debian 2026-07-17 16:42:44.796096 | debian-bookworm | Username: zuul 2026-07-17 16:42:44.796116 | debian-bookworm | Distro: Debian 12.15 2026-07-17 16:42:44.796139 | debian-bookworm | Provider: regiocloud-a 2026-07-17 16:42:44.796160 | debian-bookworm | Region: 2026-07-17 16:42:44.796182 | debian-bookworm | Label: debian-bookworm 2026-07-17 16:42:44.796202 | debian-bookworm | Product Name: OpenStack Nova 2026-07-17 16:42:44.796221 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe67:e47b 2026-07-17 16:42:44.811883 | 2026-07-17 16:42:44.811999 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-17 16:42:46.204131 | debian-bookworm -> localhost | changed 2026-07-17 16:42:46.210364 | 2026-07-17 16:42:46.210468 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-17 16:42:48.939399 | debian-bookworm -> localhost | changed 2026-07-17 16:42:48.949377 | 2026-07-17 16:42:48.949492 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-17 16:42:49.506407 | debian-bookworm -> localhost | ok 2026-07-17 16:42:49.511775 | 2026-07-17 16:42:49.511874 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-17 16:42:49.560718 | debian-bookworm | ok 2026-07-17 16:42:49.619151 | debian-bookworm | included: /var/lib/zuul/builds/0cc2116261e747f99a01628c876a6f5f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-17 16:42:49.632328 | 2026-07-17 16:42:49.632858 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-17 16:42:52.026748 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-17 16:42:52.027065 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/0cc2116261e747f99a01628c876a6f5f/work/0cc2116261e747f99a01628c876a6f5f_id_rsa 2026-07-17 16:42:52.027128 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/0cc2116261e747f99a01628c876a6f5f/work/0cc2116261e747f99a01628c876a6f5f_id_rsa.pub 2026-07-17 16:42:52.027170 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-17 16:42:52.027210 | debian-bookworm -> localhost | SHA256:0OvW7/b6UMP6xzcjrVQatbW73OaRrkMMm8d9cz+RodU zuul-build-sshkey 2026-07-17 16:42:52.027247 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-17 16:42:52.027295 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-17 16:42:52.027332 | debian-bookworm -> localhost | | | 2026-07-17 16:42:52.027367 | debian-bookworm -> localhost | | . | 2026-07-17 16:42:52.027400 | debian-bookworm -> localhost | | . . .o| 2026-07-17 16:42:52.027432 | debian-bookworm -> localhost | | . . . ..oE| 2026-07-17 16:42:52.027464 | debian-bookworm -> localhost | | S *.B+o| 2026-07-17 16:42:52.027503 | debian-bookworm -> localhost | | . . o O+*=| 2026-07-17 16:42:52.027537 | debian-bookworm -> localhost | | o . =o.=*| 2026-07-17 16:42:52.027570 | debian-bookworm -> localhost | | . .o=o=X| 2026-07-17 16:42:52.027603 | debian-bookworm -> localhost | | o+*OBB| 2026-07-17 16:42:52.027636 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-17 16:42:52.027703 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.257206 2026-07-17 16:42:52.038584 | 2026-07-17 16:42:52.038690 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-17 16:42:52.056180 | debian-bookworm | ok 2026-07-17 16:42:52.064329 | debian-bookworm | included: /var/lib/zuul/builds/0cc2116261e747f99a01628c876a6f5f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-17 16:42:52.071069 | 2026-07-17 16:42:52.071145 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-17 16:42:52.083538 | debian-bookworm | skipping: Conditional result was False 2026-07-17 16:42:52.088135 | 2026-07-17 16:42:52.088205 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-17 16:42:52.717504 | debian-bookworm | changed 2026-07-17 16:42:52.724948 | 2026-07-17 16:42:52.725075 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-17 16:42:52.983566 | debian-bookworm | ok 2026-07-17 16:42:52.989621 | 2026-07-17 16:42:52.989736 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-17 16:42:53.719543 | debian-bookworm | changed 2026-07-17 16:42:53.747002 | 2026-07-17 16:42:53.748089 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-17 16:42:54.638802 | debian-bookworm | changed 2026-07-17 16:42:54.645725 | 2026-07-17 16:42:54.645843 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-17 16:42:54.669420 | debian-bookworm | skipping: Conditional result was False 2026-07-17 16:42:54.676824 | 2026-07-17 16:42:54.676940 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-17 16:42:55.621051 | debian-bookworm -> localhost | changed 2026-07-17 16:42:55.636582 | 2026-07-17 16:42:55.636688 | TASK [add-build-sshkey : Add back temp key] 2026-07-17 16:42:56.194530 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/0cc2116261e747f99a01628c876a6f5f/work/0cc2116261e747f99a01628c876a6f5f_id_rsa (zuul-build-sshkey) 2026-07-17 16:42:56.194750 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009714 2026-07-17 16:42:56.202238 | 2026-07-17 16:42:56.202342 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-17 16:42:56.783267 | debian-bookworm | ok 2026-07-17 16:42:56.788637 | 2026-07-17 16:42:56.788759 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-17 16:42:56.817402 | debian-bookworm | skipping: Conditional result was False 2026-07-17 16:42:56.825676 | 2026-07-17 16:42:56.825790 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-17 16:42:57.331765 | debian-bookworm | ok 2026-07-17 16:42:57.366876 | 2026-07-17 16:42:57.366976 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-17 16:42:57.417184 | debian-bookworm | ok 2026-07-17 16:42:57.421439 | 2026-07-17 16:42:57.421521 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-17 16:42:57.914751 | debian-bookworm -> localhost | ok 2026-07-17 16:42:57.919956 | 2026-07-17 16:42:57.920036 | TASK [validate-host : Collect information about the host] 2026-07-17 16:42:59.145533 | debian-bookworm | ok 2026-07-17 16:42:59.170351 | 2026-07-17 16:42:59.170461 | TASK [validate-host : Sanitize hostname] 2026-07-17 16:42:59.459855 | debian-bookworm | ok 2026-07-17 16:42:59.473322 | 2026-07-17 16:42:59.473425 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-17 16:43:00.447089 | debian-bookworm -> localhost | changed 2026-07-17 16:43:00.452660 | 2026-07-17 16:43:00.452791 | TASK [validate-host : Collect information about zuul worker] 2026-07-17 16:43:01.028941 | debian-bookworm | ok 2026-07-17 16:43:01.052358 | 2026-07-17 16:43:01.052518 | TASK [validate-host : Write out all zuul information for each host] 2026-07-17 16:43:01.921662 | debian-bookworm -> localhost | changed 2026-07-17 16:43:01.935959 | 2026-07-17 16:43:01.936062 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-17 16:43:02.258380 | debian-bookworm | ok 2026-07-17 16:43:02.267104 | 2026-07-17 16:43:02.267212 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-17 16:43:03.569260 | debian-bookworm | changed: 2026-07-17 16:43:03.569525 | debian-bookworm | cd+++++++++ src/ 2026-07-17 16:43:03.569587 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-17 16:43:03.569628 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-17 16:43:03.569666 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-07-17 16:43:03.569701 | debian-bookworm | Containerfile 2026-07-17 16:43:03.569951 | debian-bookworm | Containerfile 2026-07-17 16:43:03.605806 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/0cc2116261e747f99a01628c876a6f5f/work/logs" 2026-07-17 16:45:31.804442 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/0cc2116261e747f99a01628c876a6f5f/work/artifacts" 2026-07-17 16:45:32.083972 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/0cc2116261e747f99a01628c876a6f5f/work/docs" 2026-07-17 16:45:32.102049 | 2026-07-17 16:45:32.102206 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-17 16:45:32.934397 | debian-bookworm | changed: 2026-07-17 16:45:32.934649 | debian-bookworm | .d..t...... ./ 2026-07-17 16:45:32.934684 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-17 16:45:32.934727 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-17 16:45:32.934749 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-17 16:45:32.934770 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-17 16:45:32.934791 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-17 16:45:32.934859 | debian-bookworm | changed: All items complete 2026-07-17 16:45:32.934888 | 2026-07-17 16:45:33.564327 | debian-bookworm | changed: .d..t...... ./ 2026-07-17 16:45:34.177935 | debian-bookworm | changed: .d..t...... ./ 2026-07-17 16:45:34.194879 | 2026-07-17 16:45:34.195034 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-17 16:45:34.553410 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.011938 2026-07-17 16:45:34.882114 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.008868 2026-07-17 16:45:34.902212 | 2026-07-17 16:45:34.902345 | PLAY RECAP 2026-07-17 16:45:34.902403 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-07-17 16:45:34.902430 | 2026-07-17 16:45:35.072644 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-17 16:45:35.074552 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-17 16:45:35.864354 | 2026-07-17 16:45:35.864672 | PLAY [Base post] 2026-07-17 16:45:35.880025 | 2026-07-17 16:45:35.880217 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-17 16:45:36.695323 | debian-bookworm | changed 2026-07-17 16:45:36.705864 | 2026-07-17 16:45:36.706048 | PLAY RECAP 2026-07-17 16:45:36.706138 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-17 16:45:36.706229 | 2026-07-17 16:45:36.846550 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-17 16:45:36.847971 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-17 16:45:37.681492 | 2026-07-17 16:45:37.681687 | PLAY [Base post-logs] 2026-07-17 16:45:37.693061 | 2026-07-17 16:45:37.693222 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-17 16:45:38.169972 | localhost | changed 2026-07-17 16:45:38.184941 | 2026-07-17 16:45:38.185125 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-17 16:45:38.211062 | localhost | ok 2026-07-17 16:45:38.214218 | 2026-07-17 16:45:38.214324 | TASK [Set zuul-log-path fact] 2026-07-17 16:45:38.230728 | localhost | ok 2026-07-17 16:45:38.239246 | 2026-07-17 16:45:38.239364 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-17 16:45:38.274717 | localhost | ok 2026-07-17 16:45:38.277791 | 2026-07-17 16:45:38.277895 | TASK [upload-logs : Create log directories] 2026-07-17 16:45:38.840459 | localhost | changed 2026-07-17 16:45:38.844108 | 2026-07-17 16:45:38.844235 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-17 16:45:39.406049 | localhost -> localhost | ok: Runtime: 0:00:00.017411 2026-07-17 16:45:39.422735 | 2026-07-17 16:45:39.422916 | TASK [upload-logs : Upload logs to log server] 2026-07-17 16:45:40.073367 | localhost | Output suppressed because no_log was given 2026-07-17 16:45:40.075354 | 2026-07-17 16:45:40.075462 | LOOP [upload-logs : Compress console log and json output] 2026-07-17 16:45:40.125334 | localhost | skipping: Conditional result was False 2026-07-17 16:45:40.130559 | localhost | skipping: Conditional result was False 2026-07-17 16:45:40.146775 | 2026-07-17 16:45:40.147020 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-17 16:45:40.194402 | localhost | skipping: Conditional result was False 2026-07-17 16:45:40.194882 | 2026-07-17 16:45:40.199196 | localhost | skipping: Conditional result was False 2026-07-17 16:45:40.206382 | 2026-07-17 16:45:40.206549 | LOOP [upload-logs : Upload console log and json output]