2026-07-20 05:58:40.575830 | Job console starting 2026-07-20 05:58:40.599400 | Updating git repos 2026-07-20 05:58:40.650671 | Cloning repos into workspace 2026-07-20 05:58:40.818925 | Restoring repo states 2026-07-20 05:58:40.851999 | Merging changes 2026-07-20 05:58:41.655008 | Checking out repos 2026-07-20 05:58:41.747379 | Preparing playbooks 2026-07-20 05:58:42.812165 | Running Ansible setup 2026-07-20 05:58:47.448981 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-20 05:58:48.303226 | 2026-07-20 05:58:48.303434 | PLAY [Base pre] 2026-07-20 05:58:48.329763 | 2026-07-20 05:58:48.329960 | TASK [Setup log path fact] 2026-07-20 05:58:48.364987 | debian-bookworm | ok 2026-07-20 05:58:48.382617 | 2026-07-20 05:58:48.382818 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-20 05:58:48.413575 | debian-bookworm | ok 2026-07-20 05:58:48.426471 | 2026-07-20 05:58:48.426608 | TASK [emit-job-header : Print job information] 2026-07-20 05:58:48.466338 | # Job Information 2026-07-20 05:58:48.466580 | Ansible Version: 2.16.14 2026-07-20 05:58:48.466615 | Job: python-osism-test-setup 2026-07-20 05:58:48.466647 | Pipeline: check 2026-07-20 05:58:48.466669 | Executor: 521e9411259a 2026-07-20 05:58:48.466689 | Triggered by: https://github.com/osism/python-osism/pull/2494 2026-07-20 05:58:48.466711 | Event ID: bb667830-83ff-11f1-96c2-d2be356548ea 2026-07-20 05:58:48.472095 | 2026-07-20 05:58:48.472224 | LOOP [emit-job-header : Print node information] 2026-07-20 05:58:48.586373 | debian-bookworm | ok: 2026-07-20 05:58:48.586733 | debian-bookworm | # Node Information 2026-07-20 05:58:48.586776 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-20 05:58:48.586802 | debian-bookworm | Hostname: debian 2026-07-20 05:58:48.586824 | debian-bookworm | Username: zuul 2026-07-20 05:58:48.586872 | debian-bookworm | Distro: Debian 12.15 2026-07-20 05:58:48.586897 | debian-bookworm | Provider: regiocloud-a 2026-07-20 05:58:48.586918 | debian-bookworm | Region: 2026-07-20 05:58:48.586940 | debian-bookworm | Label: debian-bookworm 2026-07-20 05:58:48.586959 | debian-bookworm | Product Name: OpenStack Nova 2026-07-20 05:58:48.586979 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fefb:e110 2026-07-20 05:58:48.610694 | 2026-07-20 05:58:48.610885 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-20 05:58:49.283533 | debian-bookworm -> localhost | changed 2026-07-20 05:58:49.291770 | 2026-07-20 05:58:49.291910 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-20 05:58:50.611721 | debian-bookworm -> localhost | changed 2026-07-20 05:58:50.632986 | 2026-07-20 05:58:50.633150 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-20 05:58:50.966686 | debian-bookworm -> localhost | ok 2026-07-20 05:58:50.974627 | 2026-07-20 05:58:50.974874 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-20 05:58:51.025408 | debian-bookworm | ok 2026-07-20 05:58:51.049071 | debian-bookworm | included: /var/lib/zuul/builds/d549148a7fef45aa8942756f9c1a4a96/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-20 05:58:51.063272 | 2026-07-20 05:58:51.063466 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-20 05:58:52.207623 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-20 05:58:52.207933 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d549148a7fef45aa8942756f9c1a4a96/work/d549148a7fef45aa8942756f9c1a4a96_id_rsa 2026-07-20 05:58:52.207975 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d549148a7fef45aa8942756f9c1a4a96/work/d549148a7fef45aa8942756f9c1a4a96_id_rsa.pub 2026-07-20 05:58:52.208002 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-20 05:58:52.208029 | debian-bookworm -> localhost | SHA256:t1hMsUMZjPWHGEZ4i0P/MvXTGDZX20ppcuGPoCTRdNA zuul-build-sshkey 2026-07-20 05:58:52.208052 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-20 05:58:52.208087 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-20 05:58:52.208109 | debian-bookworm -> localhost | | O@=. | 2026-07-20 05:58:52.208131 | debian-bookworm -> localhost | | =o=BE.. .| 2026-07-20 05:58:52.208152 | debian-bookworm -> localhost | | . ==.o..o+| 2026-07-20 05:58:52.208173 | debian-bookworm -> localhost | | +o+.+.X.o| 2026-07-20 05:58:52.208193 | debian-bookworm -> localhost | | S+++ O X | 2026-07-20 05:58:52.208222 | debian-bookworm -> localhost | | ++.. * o| 2026-07-20 05:58:52.208244 | debian-bookworm -> localhost | | . .o . | 2026-07-20 05:58:52.208264 | debian-bookworm -> localhost | | | 2026-07-20 05:58:52.208286 | debian-bookworm -> localhost | | | 2026-07-20 05:58:52.208306 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-20 05:58:52.208366 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.551585 2026-07-20 05:58:52.216447 | 2026-07-20 05:58:52.216591 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-20 05:58:52.247305 | debian-bookworm | ok 2026-07-20 05:58:52.259253 | debian-bookworm | included: /var/lib/zuul/builds/d549148a7fef45aa8942756f9c1a4a96/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-20 05:58:52.268220 | 2026-07-20 05:58:52.268340 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-20 05:58:52.299001 | debian-bookworm | skipping: Conditional result was False 2026-07-20 05:58:52.310912 | 2026-07-20 05:58:52.311058 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-20 05:58:52.916676 | debian-bookworm | changed 2026-07-20 05:58:52.923837 | 2026-07-20 05:58:52.923961 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-20 05:58:53.166860 | debian-bookworm | ok 2026-07-20 05:58:53.180516 | 2026-07-20 05:58:53.180664 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-20 05:58:53.829605 | debian-bookworm | changed 2026-07-20 05:58:53.837995 | 2026-07-20 05:58:53.838126 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-20 05:58:54.515769 | debian-bookworm | changed 2026-07-20 05:58:54.526059 | 2026-07-20 05:58:54.526212 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-20 05:58:54.560736 | debian-bookworm | skipping: Conditional result was False 2026-07-20 05:58:54.569041 | 2026-07-20 05:58:54.569213 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-20 05:58:55.087601 | debian-bookworm -> localhost | changed 2026-07-20 05:58:55.099945 | 2026-07-20 05:58:55.100093 | TASK [add-build-sshkey : Add back temp key] 2026-07-20 05:58:55.479129 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d549148a7fef45aa8942756f9c1a4a96/work/d549148a7fef45aa8942756f9c1a4a96_id_rsa (zuul-build-sshkey) 2026-07-20 05:58:55.479416 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.022897 2026-07-20 05:58:55.488677 | 2026-07-20 05:58:55.488827 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-20 05:58:56.001477 | debian-bookworm | ok 2026-07-20 05:58:56.017795 | 2026-07-20 05:58:56.017963 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-20 05:58:56.064804 | debian-bookworm | skipping: Conditional result was False 2026-07-20 05:58:56.087332 | 2026-07-20 05:58:56.087511 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-20 05:58:56.613675 | debian-bookworm | ok 2026-07-20 05:58:56.629816 | 2026-07-20 05:58:56.630002 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-20 05:58:56.662586 | debian-bookworm | ok 2026-07-20 05:58:56.672406 | 2026-07-20 05:58:56.672621 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-20 05:58:57.000762 | debian-bookworm -> localhost | ok 2026-07-20 05:58:57.011735 | 2026-07-20 05:58:57.011909 | TASK [validate-host : Collect information about the host] 2026-07-20 05:58:58.190623 | debian-bookworm | ok 2026-07-20 05:58:58.204039 | 2026-07-20 05:58:58.204168 | TASK [validate-host : Sanitize hostname] 2026-07-20 05:58:58.386889 | debian-bookworm | ok 2026-07-20 05:58:58.392532 | 2026-07-20 05:58:58.392668 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-20 05:58:59.109735 | debian-bookworm -> localhost | changed 2026-07-20 05:58:59.122233 | 2026-07-20 05:58:59.122515 | TASK [validate-host : Collect information about zuul worker] 2026-07-20 05:58:59.585809 | debian-bookworm | ok 2026-07-20 05:58:59.593617 | 2026-07-20 05:58:59.593774 | TASK [validate-host : Write out all zuul information for each host] 2026-07-20 05:59:00.220603 | debian-bookworm -> localhost | changed 2026-07-20 05:59:00.241570 | 2026-07-20 05:59:00.241817 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-20 05:59:00.551612 | debian-bookworm | ok 2026-07-20 05:59:00.557672 | 2026-07-20 05:59:00.557783 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-20 05:59:01.883402 | debian-bookworm | changed: 2026-07-20 05:59:01.883699 | debian-bookworm | cd+++++++++ src/ 2026-07-20 05:59:01.883739 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-20 05:59:01.883764 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-20 05:59:01.883786 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-07-20 05:59:01.883806 | debian-bookworm | Containerfile 2026-07-20 05:59:01.883936 | debian-bookworm | Containerfile 2026-07-20 05:59:01.918202 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/d549148a7fef45aa8942756f9c1a4a96/work/logs" 2026-07-20 06:01:34.000588 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/d549148a7fef45aa8942756f9c1a4a96/work/artifacts" 2026-07-20 06:01:34.295824 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/d549148a7fef45aa8942756f9c1a4a96/work/docs" 2026-07-20 06:01:34.313549 | 2026-07-20 06:01:34.313736 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-20 06:01:35.152690 | debian-bookworm | changed: 2026-07-20 06:01:35.152992 | debian-bookworm | .d..t...... ./ 2026-07-20 06:01:35.153042 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-20 06:01:35.153205 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-20 06:01:35.153239 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-20 06:01:35.153261 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-20 06:01:35.153282 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-20 06:01:35.153331 | debian-bookworm | changed: All items complete 2026-07-20 06:01:35.153355 | 2026-07-20 06:01:35.768628 | debian-bookworm | changed: .d..t...... ./ 2026-07-20 06:01:36.372436 | debian-bookworm | changed: .d..t...... ./ 2026-07-20 06:01:36.402415 | 2026-07-20 06:01:36.402626 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-20 06:01:36.786350 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.011068 2026-07-20 06:01:37.120375 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.011507 2026-07-20 06:01:37.130559 | 2026-07-20 06:01:37.130655 | PLAY RECAP 2026-07-20 06:01:37.130711 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-07-20 06:01:37.130735 | 2026-07-20 06:01:37.285691 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-20 06:01:37.287867 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-20 06:01:38.064355 | 2026-07-20 06:01:38.064601 | PLAY [Base post] 2026-07-20 06:01:38.082241 | 2026-07-20 06:01:38.082438 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-20 06:01:38.870338 | debian-bookworm | changed 2026-07-20 06:01:38.880406 | 2026-07-20 06:01:38.880576 | PLAY RECAP 2026-07-20 06:01:38.880658 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-20 06:01:38.880739 | 2026-07-20 06:01:39.030750 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-20 06:01:39.032884 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-20 06:01:39.850710 | 2026-07-20 06:01:39.850951 | PLAY [Base post-logs] 2026-07-20 06:01:39.862045 | 2026-07-20 06:01:39.862191 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-20 06:01:40.390643 | localhost | changed 2026-07-20 06:01:40.416203 | 2026-07-20 06:01:40.416439 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-20 06:01:40.458253 | localhost | ok 2026-07-20 06:01:40.465811 | 2026-07-20 06:01:40.465975 | TASK [Set zuul-log-path fact] 2026-07-20 06:01:40.495693 | localhost | ok 2026-07-20 06:01:40.506983 | 2026-07-20 06:01:40.507106 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-20 06:01:40.548056 | localhost | ok 2026-07-20 06:01:40.555644 | 2026-07-20 06:01:40.555897 | TASK [upload-logs : Create log directories] 2026-07-20 06:01:41.115623 | localhost | changed 2026-07-20 06:01:41.118683 | 2026-07-20 06:01:41.118801 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-20 06:01:41.683022 | localhost -> localhost | ok: Runtime: 0:00:00.008237 2026-07-20 06:01:41.689542 | 2026-07-20 06:01:41.689707 | TASK [upload-logs : Upload logs to log server] 2026-07-20 06:01:42.373165 | localhost | Output suppressed because no_log was given 2026-07-20 06:01:42.378289 | 2026-07-20 06:01:42.378492 | LOOP [upload-logs : Compress console log and json output] 2026-07-20 06:01:42.434758 | localhost | skipping: Conditional result was False 2026-07-20 06:01:42.438633 | localhost | skipping: Conditional result was False 2026-07-20 06:01:42.452266 | 2026-07-20 06:01:42.452522 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-20 06:01:42.506012 | localhost | skipping: Conditional result was False 2026-07-20 06:01:42.506697 | 2026-07-20 06:01:42.510349 | localhost | skipping: Conditional result was False 2026-07-20 06:01:42.528253 | 2026-07-20 06:01:42.528524 | LOOP [upload-logs : Upload console log and json output]