2026-07-06 11:57:47.384728 | Job console starting 2026-07-06 11:57:47.406164 | Updating git repos 2026-07-06 11:57:47.544324 | Cloning repos into workspace 2026-07-06 11:57:47.642665 | Restoring repo states 2026-07-06 11:57:47.658084 | Merging changes 2026-07-06 11:57:48.528793 | Checking out repos 2026-07-06 11:57:48.686239 | Preparing playbooks 2026-07-06 11:57:51.066469 | Running Ansible setup 2026-07-06 11:57:58.066435 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-06 11:57:59.772201 | 2026-07-06 11:57:59.772343 | PLAY [Base pre] 2026-07-06 11:57:59.821843 | 2026-07-06 11:57:59.821977 | TASK [Setup log path fact] 2026-07-06 11:57:59.852020 | debian-bookworm | ok 2026-07-06 11:57:59.881007 | 2026-07-06 11:57:59.881161 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-06 11:57:59.949354 | debian-bookworm | ok 2026-07-06 11:57:59.974546 | 2026-07-06 11:57:59.974674 | TASK [emit-job-header : Print job information] 2026-07-06 11:58:00.060128 | # Job Information 2026-07-06 11:58:00.060294 | Ansible Version: 2.16.14 2026-07-06 11:58:00.060330 | Job: python-osism-test-setup 2026-07-06 11:58:00.060363 | Pipeline: check 2026-07-06 11:58:00.060386 | Executor: 521e9411259a 2026-07-06 11:58:00.060407 | Triggered by: https://github.com/osism/python-osism/pull/2441 2026-07-06 11:58:00.060430 | Event ID: e117ae60-7931-11f1-91bc-aca403cfdc0e 2026-07-06 11:58:00.065372 | 2026-07-06 11:58:00.065476 | LOOP [emit-job-header : Print node information] 2026-07-06 11:58:00.206406 | debian-bookworm | ok: 2026-07-06 11:58:00.206611 | debian-bookworm | # Node Information 2026-07-06 11:58:00.206647 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-06 11:58:00.206673 | debian-bookworm | Hostname: debian 2026-07-06 11:58:00.206695 | debian-bookworm | Username: zuul 2026-07-06 11:58:00.206717 | debian-bookworm | Distro: Debian 12.14 2026-07-06 11:58:00.206742 | debian-bookworm | Provider: regiocloud-a 2026-07-06 11:58:00.206764 | debian-bookworm | Region: 2026-07-06 11:58:00.206797 | debian-bookworm | Label: debian-bookworm 2026-07-06 11:58:00.206819 | debian-bookworm | Product Name: OpenStack Nova 2026-07-06 11:58:00.206855 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe8c:5300 2026-07-06 11:58:00.226014 | 2026-07-06 11:58:00.226135 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-06 11:58:01.444516 | debian-bookworm -> localhost | changed 2026-07-06 11:58:01.451907 | 2026-07-06 11:58:01.452019 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-06 11:58:03.650964 | debian-bookworm -> localhost | changed 2026-07-06 11:58:03.659533 | 2026-07-06 11:58:03.659621 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-06 11:58:04.161654 | debian-bookworm -> localhost | ok 2026-07-06 11:58:04.166786 | 2026-07-06 11:58:04.167724 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-06 11:58:04.196391 | debian-bookworm | ok 2026-07-06 11:58:04.212574 | debian-bookworm | included: /var/lib/zuul/builds/0977de6bf19041f2afd891ae8c1e3943/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-06 11:58:04.217745 | 2026-07-06 11:58:04.217861 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-06 11:58:06.885908 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-06 11:58:06.886071 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/0977de6bf19041f2afd891ae8c1e3943/work/0977de6bf19041f2afd891ae8c1e3943_id_rsa 2026-07-06 11:58:06.886103 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/0977de6bf19041f2afd891ae8c1e3943/work/0977de6bf19041f2afd891ae8c1e3943_id_rsa.pub 2026-07-06 11:58:06.886126 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-06 11:58:06.886147 | debian-bookworm -> localhost | SHA256:Wvgx6xRpYm0p8ssOV9YHpS71kLxj3Jo6QS2+J5u3P40 zuul-build-sshkey 2026-07-06 11:58:06.886166 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-06 11:58:06.886196 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-06 11:58:06.886214 | debian-bookworm -> localhost | | . | 2026-07-06 11:58:06.886232 | debian-bookworm -> localhost | | . + | 2026-07-06 11:58:06.886248 | debian-bookworm -> localhost | | .B | 2026-07-06 11:58:06.886265 | debian-bookworm -> localhost | | ooB.* | 2026-07-06 11:58:06.886280 | debian-bookworm -> localhost | | . =oS.B + | 2026-07-06 11:58:06.886304 | debian-bookworm -> localhost | | + @oB = | 2026-07-06 11:58:06.886321 | debian-bookworm -> localhost | | . + +oo o | 2026-07-06 11:58:06.886338 | debian-bookworm -> localhost | | + ++oo E . | 2026-07-06 11:58:06.886354 | debian-bookworm -> localhost | | .+ =*.o.. | 2026-07-06 11:58:06.886370 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-06 11:58:06.886409 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.510002 2026-07-06 11:58:06.891778 | 2026-07-06 11:58:06.891868 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-06 11:58:06.931074 | debian-bookworm | ok 2026-07-06 11:58:06.944719 | debian-bookworm | included: /var/lib/zuul/builds/0977de6bf19041f2afd891ae8c1e3943/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-06 11:58:06.955859 | 2026-07-06 11:58:06.955961 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-06 11:58:06.989024 | debian-bookworm | skipping: Conditional result was False 2026-07-06 11:58:06.994095 | 2026-07-06 11:58:06.994186 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-06 11:58:07.780273 | debian-bookworm | changed 2026-07-06 11:58:07.785906 | 2026-07-06 11:58:07.786011 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-06 11:58:08.079897 | debian-bookworm | ok 2026-07-06 11:58:08.087762 | 2026-07-06 11:58:08.087893 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-06 11:58:08.805641 | debian-bookworm | changed 2026-07-06 11:58:08.811349 | 2026-07-06 11:58:08.811449 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-06 11:58:09.554385 | debian-bookworm | changed 2026-07-06 11:58:09.564262 | 2026-07-06 11:58:09.564378 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-06 11:58:09.597900 | debian-bookworm | skipping: Conditional result was False 2026-07-06 11:58:09.606447 | 2026-07-06 11:58:09.606560 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-06 11:58:10.271996 | debian-bookworm -> localhost | changed 2026-07-06 11:58:10.280772 | 2026-07-06 11:58:10.280880 | TASK [add-build-sshkey : Add back temp key] 2026-07-06 11:58:11.045425 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/0977de6bf19041f2afd891ae8c1e3943/work/0977de6bf19041f2afd891ae8c1e3943_id_rsa (zuul-build-sshkey) 2026-07-06 11:58:11.045613 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.026238 2026-07-06 11:58:11.051871 | 2026-07-06 11:58:11.051957 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-06 11:58:11.528081 | debian-bookworm | ok 2026-07-06 11:58:11.532335 | 2026-07-06 11:58:11.532415 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-06 11:58:11.591405 | debian-bookworm | skipping: Conditional result was False 2026-07-06 11:58:11.599933 | 2026-07-06 11:58:11.600038 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-06 11:58:12.114655 | debian-bookworm | ok 2026-07-06 11:58:12.127210 | 2026-07-06 11:58:12.127308 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-06 11:58:12.155442 | debian-bookworm | ok 2026-07-06 11:58:12.161688 | 2026-07-06 11:58:12.161786 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-06 11:58:12.787276 | debian-bookworm -> localhost | ok 2026-07-06 11:58:12.793822 | 2026-07-06 11:58:12.793926 | TASK [validate-host : Collect information about the host] 2026-07-06 11:58:14.271290 | debian-bookworm | ok 2026-07-06 11:58:14.282888 | 2026-07-06 11:58:14.282998 | TASK [validate-host : Sanitize hostname] 2026-07-06 11:58:14.429956 | debian-bookworm | ok 2026-07-06 11:58:14.435937 | 2026-07-06 11:58:14.436038 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-06 11:58:15.239934 | debian-bookworm -> localhost | changed 2026-07-06 11:58:15.245856 | 2026-07-06 11:58:15.245968 | TASK [validate-host : Collect information about zuul worker] 2026-07-06 11:58:15.686933 | debian-bookworm | ok 2026-07-06 11:58:15.690736 | 2026-07-06 11:58:15.690825 | TASK [validate-host : Write out all zuul information for each host] 2026-07-06 11:58:16.514570 | debian-bookworm -> localhost | changed 2026-07-06 11:58:16.525456 | 2026-07-06 11:58:16.525574 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-06 11:58:16.854766 | debian-bookworm | ok 2026-07-06 11:58:16.875522 | 2026-07-06 11:58:16.875663 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-06 11:58:17.895503 | debian-bookworm | changed: 2026-07-06 11:58:17.895769 | debian-bookworm | cd+++++++++ src/ 2026-07-06 11:58:17.895841 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-06 11:58:17.895881 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-06 11:58:17.895916 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-07-06 11:58:17.895950 | debian-bookworm | Containerfile 2026-07-06 11:58:17.896164 | debian-bookworm | Containerfile 2026-07-06 11:58:17.905367 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/0977de6bf19041f2afd891ae8c1e3943/work/logs" 2026-07-06 12:01:02.913221 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/0977de6bf19041f2afd891ae8c1e3943/work/artifacts" 2026-07-06 12:01:03.221939 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/0977de6bf19041f2afd891ae8c1e3943/work/docs" 2026-07-06 12:01:03.239441 | 2026-07-06 12:01:03.239712 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-06 12:01:04.113909 | debian-bookworm | changed: 2026-07-06 12:01:04.114614 | debian-bookworm | .d..t...... ./ 2026-07-06 12:01:04.114700 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-06 12:01:04.114736 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-06 12:01:04.114760 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-06 12:01:04.114781 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-06 12:01:04.114802 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-06 12:01:04.114891 | debian-bookworm | changed: All items complete 2026-07-06 12:01:04.114927 | 2026-07-06 12:01:04.704978 | debian-bookworm | changed: .d..t...... ./ 2026-07-06 12:01:05.291226 | debian-bookworm | changed: .d..t...... ./ 2026-07-06 12:01:05.315512 | 2026-07-06 12:01:05.315804 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-06 12:01:05.692813 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.006966 2026-07-06 12:01:06.060600 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.015998 2026-07-06 12:01:06.077624 | 2026-07-06 12:01:06.077750 | PLAY RECAP 2026-07-06 12:01:06.077810 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-07-06 12:01:06.077836 | 2026-07-06 12:01:06.251561 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-06 12:01:06.252530 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-06 12:01:07.212546 | 2026-07-06 12:01:07.212731 | PLAY [Base post] 2026-07-06 12:01:07.227523 | 2026-07-06 12:01:07.227683 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-06 12:01:08.110695 | debian-bookworm | changed 2026-07-06 12:01:08.121615 | 2026-07-06 12:01:08.121770 | PLAY RECAP 2026-07-06 12:01:08.121852 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-06 12:01:08.121934 | 2026-07-06 12:01:08.258176 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-06 12:01:08.259423 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-06 12:01:09.175150 | 2026-07-06 12:01:09.175359 | PLAY [Base post-logs] 2026-07-06 12:01:09.189789 | 2026-07-06 12:01:09.189974 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-06 12:01:09.681489 | localhost | changed 2026-07-06 12:01:09.701902 | 2026-07-06 12:01:09.702163 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-06 12:01:09.742941 | localhost | ok 2026-07-06 12:01:09.749739 | 2026-07-06 12:01:09.749905 | TASK [Set zuul-log-path fact] 2026-07-06 12:01:09.780629 | localhost | ok 2026-07-06 12:01:09.797928 | 2026-07-06 12:01:09.798146 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-06 12:01:09.841270 | localhost | ok 2026-07-06 12:01:09.848753 | 2026-07-06 12:01:09.848963 | TASK [upload-logs : Create log directories] 2026-07-06 12:01:10.430678 | localhost | changed 2026-07-06 12:01:10.433792 | 2026-07-06 12:01:10.433913 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-06 12:01:10.965628 | localhost -> localhost | ok: Runtime: 0:00:00.007891 2026-07-06 12:01:10.975510 | 2026-07-06 12:01:10.975718 | TASK [upload-logs : Upload logs to log server] 2026-07-06 12:01:11.606060 | localhost | Output suppressed because no_log was given 2026-07-06 12:01:11.609332 | 2026-07-06 12:01:11.609485 | LOOP [upload-logs : Compress console log and json output] 2026-07-06 12:01:11.673114 | localhost | skipping: Conditional result was False 2026-07-06 12:01:11.694683 | localhost | skipping: Conditional result was False 2026-07-06 12:01:11.709787 | 2026-07-06 12:01:11.709973 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-06 12:01:11.772302 | localhost | skipping: Conditional result was False 2026-07-06 12:01:11.772976 | 2026-07-06 12:01:11.776276 | localhost | skipping: Conditional result was False 2026-07-06 12:01:11.784598 | 2026-07-06 12:01:11.785289 | LOOP [upload-logs : Upload console log and json output]