2026-05-29 03:18:56.741046 | Job console starting 2026-05-29 03:18:56.754122 | Updating git repos 2026-05-29 03:18:56.823255 | Cloning repos into workspace 2026-05-29 03:18:56.872549 | Restoring repo states 2026-05-29 03:18:56.907254 | Merging changes 2026-05-29 03:18:56.907282 | Checking out repos 2026-05-29 03:18:57.036611 | Preparing playbooks 2026-05-29 03:18:58.196745 | Running Ansible setup 2026-05-29 03:19:03.109017 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-29 03:19:04.659082 | 2026-05-29 03:19:04.659250 | PLAY [Base pre] 2026-05-29 03:19:04.679450 | 2026-05-29 03:19:04.679615 | TASK [Setup log path fact] 2026-05-29 03:19:04.723687 | debian-bookworm | ok 2026-05-29 03:19:04.745224 | 2026-05-29 03:19:04.745397 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-29 03:19:04.784869 | debian-bookworm | ok 2026-05-29 03:19:04.798759 | 2026-05-29 03:19:04.800267 | TASK [emit-job-header : Print job information] 2026-05-29 03:19:04.854458 | # Job Information 2026-05-29 03:19:04.854737 | Ansible Version: 2.16.14 2026-05-29 03:19:04.854776 | Job: python-osism-test-setup 2026-05-29 03:19:04.854818 | Pipeline: periodic-daily 2026-05-29 03:19:04.854983 | Executor: 521e9411259a 2026-05-29 03:19:04.855049 | Triggered by: https://github.com/osism/python-osism 2026-05-29 03:19:04.855072 | Event ID: f0746e55dc8741368f33f5c790cb4888 2026-05-29 03:19:04.866723 | 2026-05-29 03:19:04.866915 | LOOP [emit-job-header : Print node information] 2026-05-29 03:19:04.999080 | debian-bookworm | ok: 2026-05-29 03:19:04.999489 | debian-bookworm | # Node Information 2026-05-29 03:19:04.999549 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-29 03:19:04.999575 | debian-bookworm | Hostname: debian 2026-05-29 03:19:04.999598 | debian-bookworm | Username: zuul 2026-05-29 03:19:04.999619 | debian-bookworm | Distro: Debian 12.14 2026-05-29 03:19:04.999644 | debian-bookworm | Provider: regiocloud-a 2026-05-29 03:19:04.999665 | debian-bookworm | Region: 2026-05-29 03:19:04.999686 | debian-bookworm | Label: debian-bookworm 2026-05-29 03:19:04.999706 | debian-bookworm | Product Name: OpenStack Nova 2026-05-29 03:19:04.999725 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe49:7245 2026-05-29 03:19:05.025670 | 2026-05-29 03:19:05.025818 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-29 03:19:05.957548 | debian-bookworm -> localhost | changed 2026-05-29 03:19:05.971395 | 2026-05-29 03:19:05.971566 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-29 03:19:07.721971 | debian-bookworm -> localhost | changed 2026-05-29 03:19:07.737886 | 2026-05-29 03:19:07.738002 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-29 03:19:08.201993 | debian-bookworm -> localhost | ok 2026-05-29 03:19:08.216153 | 2026-05-29 03:19:08.216270 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-29 03:19:08.255767 | debian-bookworm | ok 2026-05-29 03:19:08.280295 | debian-bookworm | included: /var/lib/zuul/builds/195cf0e7de964f8887e77950843bcbe3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-29 03:19:08.286313 | 2026-05-29 03:19:08.286401 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-29 03:19:10.070347 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-29 03:19:10.070535 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/195cf0e7de964f8887e77950843bcbe3/work/195cf0e7de964f8887e77950843bcbe3_id_rsa 2026-05-29 03:19:10.070571 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/195cf0e7de964f8887e77950843bcbe3/work/195cf0e7de964f8887e77950843bcbe3_id_rsa.pub 2026-05-29 03:19:10.070597 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-29 03:19:10.070621 | debian-bookworm -> localhost | SHA256:qddbIQ2is9Obzo+Cs2QK17SQ2sn76882o91ApWGVOVo zuul-build-sshkey 2026-05-29 03:19:10.070643 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-29 03:19:10.070674 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-29 03:19:10.070697 | debian-bookworm -> localhost | | .o | 2026-05-29 03:19:10.070719 | debian-bookworm -> localhost | | .E | 2026-05-29 03:19:10.070739 | debian-bookworm -> localhost | | ooo.. | 2026-05-29 03:19:10.070759 | debian-bookworm -> localhost | | . ..= o o | 2026-05-29 03:19:10.070779 | debian-bookworm -> localhost | | o . = S . o | 2026-05-29 03:19:10.070807 | debian-bookworm -> localhost | | + = o = . . . | 2026-05-29 03:19:10.070827 | debian-bookworm -> localhost | |o = =.= o . . | 2026-05-29 03:19:10.070875 | debian-bookworm -> localhost | | o =oo=* + o | 2026-05-29 03:19:10.070897 | debian-bookworm -> localhost | | oo*B+=B.o | 2026-05-29 03:19:10.070918 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-29 03:19:10.070969 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.842568 2026-05-29 03:19:10.077756 | 2026-05-29 03:19:10.077860 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-29 03:19:10.095641 | debian-bookworm | ok 2026-05-29 03:19:10.104391 | debian-bookworm | included: /var/lib/zuul/builds/195cf0e7de964f8887e77950843bcbe3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-29 03:19:10.125851 | 2026-05-29 03:19:10.125949 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-29 03:19:10.160216 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:19:10.166117 | 2026-05-29 03:19:10.166220 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-29 03:19:10.869262 | debian-bookworm | changed 2026-05-29 03:19:10.880660 | 2026-05-29 03:19:10.880758 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-29 03:19:11.152580 | debian-bookworm | ok 2026-05-29 03:19:11.160425 | 2026-05-29 03:19:11.160534 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-29 03:19:11.923805 | debian-bookworm | changed 2026-05-29 03:19:11.930637 | 2026-05-29 03:19:11.930743 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-29 03:19:12.625872 | debian-bookworm | changed 2026-05-29 03:19:12.638266 | 2026-05-29 03:19:12.638365 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-29 03:19:12.661752 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:19:12.668276 | 2026-05-29 03:19:12.668395 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-29 03:19:13.426512 | debian-bookworm -> localhost | changed 2026-05-29 03:19:13.438591 | 2026-05-29 03:19:13.438692 | TASK [add-build-sshkey : Add back temp key] 2026-05-29 03:19:13.844105 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/195cf0e7de964f8887e77950843bcbe3/work/195cf0e7de964f8887e77950843bcbe3_id_rsa (zuul-build-sshkey) 2026-05-29 03:19:13.844311 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019221 2026-05-29 03:19:13.851757 | 2026-05-29 03:19:13.851867 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-29 03:19:14.264386 | debian-bookworm | ok 2026-05-29 03:19:14.272369 | 2026-05-29 03:19:14.272463 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-29 03:19:14.295372 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:19:14.305322 | 2026-05-29 03:19:14.305420 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-29 03:19:14.718506 | debian-bookworm | ok 2026-05-29 03:19:14.728731 | 2026-05-29 03:19:14.728854 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-29 03:19:14.767389 | debian-bookworm | ok 2026-05-29 03:19:14.772236 | 2026-05-29 03:19:14.772321 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-29 03:19:15.181102 | debian-bookworm -> localhost | ok 2026-05-29 03:19:15.187191 | 2026-05-29 03:19:15.187283 | TASK [validate-host : Collect information about the host] 2026-05-29 03:19:16.455768 | debian-bookworm | ok 2026-05-29 03:19:16.466610 | 2026-05-29 03:19:16.466709 | TASK [validate-host : Sanitize hostname] 2026-05-29 03:19:16.556606 | debian-bookworm | ok 2026-05-29 03:19:16.585755 | 2026-05-29 03:19:16.585894 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-29 03:19:17.238656 | debian-bookworm -> localhost | changed 2026-05-29 03:19:17.251600 | 2026-05-29 03:19:17.251743 | TASK [validate-host : Collect information about zuul worker] 2026-05-29 03:19:17.753813 | debian-bookworm | ok 2026-05-29 03:19:17.767755 | 2026-05-29 03:19:17.767935 | TASK [validate-host : Write out all zuul information for each host] 2026-05-29 03:19:18.450376 | debian-bookworm -> localhost | changed 2026-05-29 03:19:18.459501 | 2026-05-29 03:19:18.459596 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-29 03:19:18.847507 | debian-bookworm | ok 2026-05-29 03:19:18.853476 | 2026-05-29 03:19:18.853572 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-29 03:19:19.910461 | debian-bookworm | changed: 2026-05-29 03:19:19.910719 | debian-bookworm | cd+++++++++ src/ 2026-05-29 03:19:19.910779 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-29 03:19:19.910884 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-29 03:19:19.910932 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-05-29 03:19:19.910969 | debian-bookworm | Containerfile 2026-05-29 03:19:19.911192 | debian-bookworm | Containerfile 2026-05-29 03:19:19.925276 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/195cf0e7de964f8887e77950843bcbe3/work/logs" 2026-05-29 03:24:14.050444 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/195cf0e7de964f8887e77950843bcbe3/work/artifacts" 2026-05-29 03:24:14.359398 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/195cf0e7de964f8887e77950843bcbe3/work/docs" 2026-05-29 03:24:14.383798 | 2026-05-29 03:24:14.384035 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-29 03:24:15.209060 | debian-bookworm | changed: 2026-05-29 03:24:15.210030 | debian-bookworm | .d..t...... ./ 2026-05-29 03:24:15.210381 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-29 03:24:15.210441 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-29 03:24:15.210484 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-29 03:24:15.210571 | debian-bookworm | changed: All items complete 2026-05-29 03:24:15.210616 | 2026-05-29 03:24:15.811178 | debian-bookworm | changed: .d..t...... ./ 2026-05-29 03:24:16.460333 | debian-bookworm | changed: .d..t...... ./ 2026-05-29 03:24:16.482252 | 2026-05-29 03:24:16.482406 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-29 03:24:16.520788 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:24:16.524072 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:24:16.544655 | 2026-05-29 03:24:16.544804 | PLAY RECAP 2026-05-29 03:24:16.544904 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-29 03:24:16.544955 | 2026-05-29 03:24:16.688502 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-29 03:24:16.690598 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-29 03:24:17.461085 | 2026-05-29 03:24:17.461256 | PLAY [Base post] 2026-05-29 03:24:17.475187 | 2026-05-29 03:24:17.475323 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-29 03:24:18.313497 | debian-bookworm | changed 2026-05-29 03:24:18.323184 | 2026-05-29 03:24:18.323347 | PLAY RECAP 2026-05-29 03:24:18.323438 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-29 03:24:18.323526 | 2026-05-29 03:24:18.454689 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-29 03:24:18.456749 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-29 03:24:19.287411 | 2026-05-29 03:24:19.287636 | PLAY [Base post-logs] 2026-05-29 03:24:19.298490 | 2026-05-29 03:24:19.298673 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-29 03:24:19.772301 | localhost | changed 2026-05-29 03:24:19.782733 | 2026-05-29 03:24:19.782933 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-29 03:24:19.819451 | localhost | ok 2026-05-29 03:24:19.823412 | 2026-05-29 03:24:19.823534 | TASK [Set zuul-log-path fact] 2026-05-29 03:24:19.839202 | localhost | ok 2026-05-29 03:24:19.848472 | 2026-05-29 03:24:19.848655 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-29 03:24:19.874204 | localhost | ok 2026-05-29 03:24:19.878207 | 2026-05-29 03:24:19.878328 | TASK [upload-logs : Create log directories] 2026-05-29 03:24:20.421917 | localhost | changed 2026-05-29 03:24:20.427065 | 2026-05-29 03:24:20.427240 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-29 03:24:20.935304 | localhost -> localhost | ok: Runtime: 0:00:00.007905 2026-05-29 03:24:20.949182 | 2026-05-29 03:24:20.949351 | TASK [upload-logs : Upload logs to log server] 2026-05-29 03:24:21.546657 | localhost | Output suppressed because no_log was given 2026-05-29 03:24:21.550829 | 2026-05-29 03:24:21.551046 | LOOP [upload-logs : Compress console log and json output] 2026-05-29 03:24:21.606893 | localhost | skipping: Conditional result was False 2026-05-29 03:24:21.612181 | localhost | skipping: Conditional result was False 2026-05-29 03:24:21.623807 | 2026-05-29 03:24:21.624044 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-29 03:24:21.672621 | localhost | skipping: Conditional result was False 2026-05-29 03:24:21.673192 | 2026-05-29 03:24:21.675119 | localhost | skipping: Conditional result was False 2026-05-29 03:24:21.684495 | 2026-05-29 03:24:21.684690 | LOOP [upload-logs : Upload console log and json output]