2026-06-08 03:18:38.574294 | Job console starting 2026-06-08 03:18:38.595094 | Updating git repos 2026-06-08 03:18:38.639810 | Cloning repos into workspace 2026-06-08 03:18:38.700930 | Restoring repo states 2026-06-08 03:18:38.728312 | Merging changes 2026-06-08 03:18:38.728329 | Checking out repos 2026-06-08 03:18:38.810584 | Preparing playbooks 2026-06-08 03:18:40.047888 | Running Ansible setup 2026-06-08 03:18:44.850871 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-08 03:18:45.758550 | 2026-06-08 03:18:45.758728 | PLAY [Base pre] 2026-06-08 03:18:45.776693 | 2026-06-08 03:18:45.776848 | TASK [Setup log path fact] 2026-06-08 03:18:45.806339 | debian-bookworm | ok 2026-06-08 03:18:45.824346 | 2026-06-08 03:18:45.824535 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-08 03:18:45.855864 | debian-bookworm | ok 2026-06-08 03:18:45.868249 | 2026-06-08 03:18:45.868418 | TASK [emit-job-header : Print job information] 2026-06-08 03:18:45.908084 | # Job Information 2026-06-08 03:18:45.908287 | Ansible Version: 2.16.14 2026-06-08 03:18:45.908323 | Job: python-osism-test-setup 2026-06-08 03:18:45.908355 | Pipeline: periodic-daily 2026-06-08 03:18:45.908395 | Executor: 521e9411259a 2026-06-08 03:18:45.908417 | Triggered by: https://github.com/osism/python-osism 2026-06-08 03:18:45.908439 | Event ID: dfd2904ea8c04832b6034305808b19a6 2026-06-08 03:18:45.913569 | 2026-06-08 03:18:45.913695 | LOOP [emit-job-header : Print node information] 2026-06-08 03:18:46.034537 | debian-bookworm | ok: 2026-06-08 03:18:46.034822 | debian-bookworm | # Node Information 2026-06-08 03:18:46.034924 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-08 03:18:46.034965 | debian-bookworm | Hostname: debian 2026-06-08 03:18:46.035000 | debian-bookworm | Username: zuul 2026-06-08 03:18:46.035032 | debian-bookworm | Distro: Debian 12.14 2026-06-08 03:18:46.035068 | debian-bookworm | Provider: regiocloud-a 2026-06-08 03:18:46.035102 | debian-bookworm | Region: 2026-06-08 03:18:46.035136 | debian-bookworm | Label: debian-bookworm 2026-06-08 03:18:46.035168 | debian-bookworm | Product Name: OpenStack Nova 2026-06-08 03:18:46.035199 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe83:6a9b 2026-06-08 03:18:46.052143 | 2026-06-08 03:18:46.052299 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-08 03:18:46.738084 | debian-bookworm -> localhost | changed 2026-06-08 03:18:46.745783 | 2026-06-08 03:18:46.745911 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-08 03:18:47.961463 | debian-bookworm -> localhost | changed 2026-06-08 03:18:47.985883 | 2026-06-08 03:18:47.986089 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-08 03:18:48.377797 | debian-bookworm -> localhost | ok 2026-06-08 03:18:48.386320 | 2026-06-08 03:18:48.386631 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-08 03:18:48.454694 | debian-bookworm | ok 2026-06-08 03:18:48.473351 | debian-bookworm | included: /var/lib/zuul/builds/36aa29108d0c4c8cab08de73f58c751e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-08 03:18:48.481753 | 2026-06-08 03:18:48.481876 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-08 03:18:51.506593 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-08 03:18:51.507025 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/36aa29108d0c4c8cab08de73f58c751e/work/36aa29108d0c4c8cab08de73f58c751e_id_rsa 2026-06-08 03:18:51.507089 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/36aa29108d0c4c8cab08de73f58c751e/work/36aa29108d0c4c8cab08de73f58c751e_id_rsa.pub 2026-06-08 03:18:51.507129 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-08 03:18:51.507164 | debian-bookworm -> localhost | SHA256:EsRNoi1mIhXj16oD1DhVZbTZ+0HzO3Uq0k3imI4mGiY zuul-build-sshkey 2026-06-08 03:18:51.507212 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-08 03:18:51.507273 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-08 03:18:51.507308 | debian-bookworm -> localhost | | +o.o=*. | 2026-06-08 03:18:51.507367 | debian-bookworm -> localhost | | o+. =o.= | 2026-06-08 03:18:51.507399 | debian-bookworm -> localhost | |.+o.* +o . o | 2026-06-08 03:18:51.507427 | debian-bookworm -> localhost | |...= o . o o | 2026-06-08 03:18:51.507456 | debian-bookworm -> localhost | |. . . S. ......| 2026-06-08 03:18:51.507488 | debian-bookworm -> localhost | | . . . .=.+o..| 2026-06-08 03:18:51.507517 | debian-bookworm -> localhost | | E o +.+oo | 2026-06-08 03:18:51.507544 | debian-bookworm -> localhost | | + .. .o . .. | 2026-06-08 03:18:51.507574 | debian-bookworm -> localhost | | .. o. . | 2026-06-08 03:18:51.507604 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-08 03:18:51.507683 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.091375 2026-06-08 03:18:51.516900 | 2026-06-08 03:18:51.517030 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-08 03:18:51.546721 | debian-bookworm | ok 2026-06-08 03:18:51.556427 | debian-bookworm | included: /var/lib/zuul/builds/36aa29108d0c4c8cab08de73f58c751e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-08 03:18:51.565957 | 2026-06-08 03:18:51.566106 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-08 03:18:51.590332 | debian-bookworm | skipping: Conditional result was False 2026-06-08 03:18:51.596889 | 2026-06-08 03:18:51.597134 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-08 03:18:52.346401 | debian-bookworm | changed 2026-06-08 03:18:52.352329 | 2026-06-08 03:18:52.352481 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-08 03:18:52.617064 | debian-bookworm | ok 2026-06-08 03:18:52.622715 | 2026-06-08 03:18:52.622822 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-08 03:18:53.326969 | debian-bookworm | changed 2026-06-08 03:18:53.343999 | 2026-06-08 03:18:53.345026 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-08 03:18:54.080970 | debian-bookworm | changed 2026-06-08 03:18:54.091420 | 2026-06-08 03:18:54.091552 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-08 03:18:54.115557 | debian-bookworm | skipping: Conditional result was False 2026-06-08 03:18:54.121687 | 2026-06-08 03:18:54.121800 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-08 03:18:54.683692 | debian-bookworm -> localhost | changed 2026-06-08 03:18:54.695951 | 2026-06-08 03:18:54.696080 | TASK [add-build-sshkey : Add back temp key] 2026-06-08 03:18:55.075386 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/36aa29108d0c4c8cab08de73f58c751e/work/36aa29108d0c4c8cab08de73f58c751e_id_rsa (zuul-build-sshkey) 2026-06-08 03:18:55.075650 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.028674 2026-06-08 03:18:55.084919 | 2026-06-08 03:18:55.085042 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-08 03:18:55.520751 | debian-bookworm | ok 2026-06-08 03:18:55.543386 | 2026-06-08 03:18:55.545059 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-08 03:18:55.587393 | debian-bookworm | skipping: Conditional result was False 2026-06-08 03:18:55.601036 | 2026-06-08 03:18:55.601172 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-08 03:18:56.076537 | debian-bookworm | ok 2026-06-08 03:18:56.088183 | 2026-06-08 03:18:56.088324 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-08 03:18:56.130892 | debian-bookworm | ok 2026-06-08 03:18:56.137037 | 2026-06-08 03:18:56.137157 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-08 03:18:56.445645 | debian-bookworm -> localhost | ok 2026-06-08 03:18:56.453044 | 2026-06-08 03:18:56.453159 | TASK [validate-host : Collect information about the host] 2026-06-08 03:18:57.666476 | debian-bookworm | ok 2026-06-08 03:18:57.678597 | 2026-06-08 03:18:57.678724 | TASK [validate-host : Sanitize hostname] 2026-06-08 03:18:57.800623 | debian-bookworm | ok 2026-06-08 03:18:57.847256 | 2026-06-08 03:18:57.847415 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-08 03:18:58.452410 | debian-bookworm -> localhost | changed 2026-06-08 03:18:58.464457 | 2026-06-08 03:18:58.464606 | TASK [validate-host : Collect information about zuul worker] 2026-06-08 03:18:58.963495 | debian-bookworm | ok 2026-06-08 03:18:58.968989 | 2026-06-08 03:18:58.969110 | TASK [validate-host : Write out all zuul information for each host] 2026-06-08 03:18:59.677003 | debian-bookworm -> localhost | changed 2026-06-08 03:18:59.692518 | 2026-06-08 03:18:59.692914 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-08 03:19:00.022117 | debian-bookworm | ok 2026-06-08 03:19:00.031995 | 2026-06-08 03:19:00.032244 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-08 03:19:01.385730 | debian-bookworm | changed: 2026-06-08 03:19:01.385944 | debian-bookworm | cd+++++++++ src/ 2026-06-08 03:19:01.385980 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-08 03:19:01.386005 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-08 03:19:01.386026 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-06-08 03:19:01.386046 | debian-bookworm | Containerfile 2026-06-08 03:19:01.386174 | debian-bookworm | Containerfile 2026-06-08 03:19:01.400305 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/36aa29108d0c4c8cab08de73f58c751e/work/logs" 2026-06-08 03:21:03.639951 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/36aa29108d0c4c8cab08de73f58c751e/work/artifacts" 2026-06-08 03:21:03.930392 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/36aa29108d0c4c8cab08de73f58c751e/work/docs" 2026-06-08 03:21:03.955200 | 2026-06-08 03:21:03.955383 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-08 03:21:04.741863 | debian-bookworm | changed: 2026-06-08 03:21:04.742092 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-08 03:21:04.742166 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-08 03:21:04.742199 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-08 03:21:04.742248 | debian-bookworm | changed: All items complete 2026-06-08 03:21:04.742277 | 2026-06-08 03:21:05.354789 | debian-bookworm | changed: .d..t...... ./ 2026-06-08 03:21:05.993936 | debian-bookworm | changed: .d..t...... ./ 2026-06-08 03:21:06.026110 | 2026-06-08 03:21:06.026415 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-08 03:21:06.059297 | debian-bookworm | skipping: Conditional result was False 2026-06-08 03:21:06.073750 | debian-bookworm | skipping: Conditional result was False 2026-06-08 03:21:06.097356 | 2026-06-08 03:21:06.097509 | PLAY RECAP 2026-06-08 03:21:06.097590 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-06-08 03:21:06.097631 | 2026-06-08 03:21:06.246879 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-08 03:21:06.247794 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-08 03:21:07.012267 | 2026-06-08 03:21:07.012454 | PLAY [Base post] 2026-06-08 03:21:07.027553 | 2026-06-08 03:21:07.027721 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-08 03:21:07.875775 | debian-bookworm | changed 2026-06-08 03:21:07.883675 | 2026-06-08 03:21:07.883789 | PLAY RECAP 2026-06-08 03:21:07.883856 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-08 03:21:07.883924 | 2026-06-08 03:21:08.009220 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-08 03:21:08.010185 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-08 03:21:08.831909 | 2026-06-08 03:21:08.832080 | PLAY [Base post-logs] 2026-06-08 03:21:08.842861 | 2026-06-08 03:21:08.842999 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-08 03:21:09.283999 | localhost | changed 2026-06-08 03:21:09.300628 | 2026-06-08 03:21:09.300832 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-08 03:21:09.327786 | localhost | ok 2026-06-08 03:21:09.333322 | 2026-06-08 03:21:09.333455 | TASK [Set zuul-log-path fact] 2026-06-08 03:21:09.348944 | localhost | ok 2026-06-08 03:21:09.357853 | 2026-06-08 03:21:09.357994 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-08 03:21:09.394981 | localhost | ok 2026-06-08 03:21:09.401089 | 2026-06-08 03:21:09.401305 | TASK [upload-logs : Create log directories] 2026-06-08 03:21:09.952242 | localhost | changed 2026-06-08 03:21:09.961727 | 2026-06-08 03:21:09.961949 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-08 03:21:10.546683 | localhost -> localhost | ok: Runtime: 0:00:00.007237 2026-06-08 03:21:10.553754 | 2026-06-08 03:21:10.554278 | TASK [upload-logs : Upload logs to log server] 2026-06-08 03:21:11.128773 | localhost | Output suppressed because no_log was given 2026-06-08 03:21:11.131271 | 2026-06-08 03:21:11.131405 | LOOP [upload-logs : Compress console log and json output] 2026-06-08 03:21:11.188503 | localhost | skipping: Conditional result was False 2026-06-08 03:21:11.194554 | localhost | skipping: Conditional result was False 2026-06-08 03:21:11.204133 | 2026-06-08 03:21:11.204270 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-08 03:21:11.254946 | localhost | skipping: Conditional result was False 2026-06-08 03:21:11.255318 | 2026-06-08 03:21:11.260500 | localhost | skipping: Conditional result was False 2026-06-08 03:21:11.273679 | 2026-06-08 03:21:11.273908 | LOOP [upload-logs : Upload console log and json output]