2026-04-28 07:30:54.529997 | Job console starting 2026-04-28 07:30:54.555782 | Updating git repos 2026-04-28 07:30:54.676968 | Cloning repos into workspace 2026-04-28 07:30:54.804823 | Restoring repo states 2026-04-28 07:30:54.843363 | Merging changes 2026-04-28 07:30:55.646967 | Checking out repos 2026-04-28 07:30:55.793385 | Preparing playbooks 2026-04-28 07:30:57.654747 | Running Ansible setup 2026-04-28 07:31:03.436179 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-04-28 07:31:05.160379 | 2026-04-28 07:31:05.160583 | PLAY [Base pre] 2026-04-28 07:31:05.193680 | 2026-04-28 07:31:05.193844 | TASK [Setup log path fact] 2026-04-28 07:31:05.286140 | debian-bookworm | ok 2026-04-28 07:31:05.331085 | 2026-04-28 07:31:05.331316 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-28 07:31:05.416771 | debian-bookworm | ok 2026-04-28 07:31:05.428736 | 2026-04-28 07:31:05.428864 | TASK [emit-job-header : Print job information] 2026-04-28 07:31:05.489491 | # Job Information 2026-04-28 07:31:05.489781 | Ansible Version: 2.16.14 2026-04-28 07:31:05.489822 | Job: python-osism-test-setup 2026-04-28 07:31:05.489858 | Pipeline: check 2026-04-28 07:31:05.489886 | Executor: 521e9411259a 2026-04-28 07:31:05.489908 | Triggered by: https://github.com/osism/python-osism/pull/2234 2026-04-28 07:31:05.489931 | Event ID: 2a260230-42d4-11f1-9763-3957b71d8ada 2026-04-28 07:31:05.499820 | 2026-04-28 07:31:05.499957 | LOOP [emit-job-header : Print node information] 2026-04-28 07:31:05.711702 | debian-bookworm | ok: 2026-04-28 07:31:05.711911 | debian-bookworm | # Node Information 2026-04-28 07:31:05.711946 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-04-28 07:31:05.711974 | debian-bookworm | Hostname: debian 2026-04-28 07:31:05.711997 | debian-bookworm | Username: zuul 2026-04-28 07:31:05.712018 | debian-bookworm | Distro: Debian 12.13 2026-04-28 07:31:05.712044 | debian-bookworm | Provider: regiocloud-a 2026-04-28 07:31:05.712065 | debian-bookworm | Region: 2026-04-28 07:31:05.712086 | debian-bookworm | Label: debian-bookworm 2026-04-28 07:31:05.712107 | debian-bookworm | Product Name: OpenStack Nova 2026-04-28 07:31:05.712163 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fee0:f96a 2026-04-28 07:31:05.727258 | 2026-04-28 07:31:05.727412 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-28 07:31:06.668678 | debian-bookworm -> localhost | changed 2026-04-28 07:31:06.676031 | 2026-04-28 07:31:06.676191 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-28 07:31:08.728510 | debian-bookworm -> localhost | changed 2026-04-28 07:31:08.752441 | 2026-04-28 07:31:08.752593 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-28 07:31:09.388495 | debian-bookworm -> localhost | ok 2026-04-28 07:31:09.394247 | 2026-04-28 07:31:09.394340 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-28 07:31:09.423688 | debian-bookworm | ok 2026-04-28 07:31:09.458581 | debian-bookworm | included: /var/lib/zuul/builds/37dfaa0991624b5380444a338e4c98a5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-28 07:31:09.474789 | 2026-04-28 07:31:09.479895 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-28 07:31:10.687031 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-04-28 07:31:10.687218 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/37dfaa0991624b5380444a338e4c98a5/work/37dfaa0991624b5380444a338e4c98a5_id_rsa 2026-04-28 07:31:10.687250 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/37dfaa0991624b5380444a338e4c98a5/work/37dfaa0991624b5380444a338e4c98a5_id_rsa.pub 2026-04-28 07:31:10.687272 | debian-bookworm -> localhost | The key fingerprint is: 2026-04-28 07:31:10.687292 | debian-bookworm -> localhost | SHA256:pa1xWGgb5vkYLf0mdiM1P4nhGHoIXZFIchkQoji79G4 zuul-build-sshkey 2026-04-28 07:31:10.687310 | debian-bookworm -> localhost | The key's randomart image is: 2026-04-28 07:31:10.687341 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-04-28 07:31:10.687360 | debian-bookworm -> localhost | | . ++++.. | 2026-04-28 07:31:10.687377 | debian-bookworm -> localhost | | . . . oo... | 2026-04-28 07:31:10.687394 | debian-bookworm -> localhost | |o . = + | 2026-04-28 07:31:10.687411 | debian-bookworm -> localhost | | o = & | 2026-04-28 07:31:10.687427 | debian-bookworm -> localhost | |.. . S * + | 2026-04-28 07:31:10.687446 | debian-bookworm -> localhost | |... . @ * = . | 2026-04-28 07:31:10.687463 | debian-bookworm -> localhost | |. . = B B + | 2026-04-28 07:31:10.687479 | debian-bookworm -> localhost | | .E o = . . | 2026-04-28 07:31:10.687496 | debian-bookworm -> localhost | | .. | 2026-04-28 07:31:10.687513 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-04-28 07:31:10.687555 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.514562 2026-04-28 07:31:10.692733 | 2026-04-28 07:31:10.692827 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-28 07:31:10.732291 | debian-bookworm | ok 2026-04-28 07:31:10.739613 | debian-bookworm | included: /var/lib/zuul/builds/37dfaa0991624b5380444a338e4c98a5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-28 07:31:10.758873 | 2026-04-28 07:31:10.758958 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-28 07:31:10.793126 | debian-bookworm | skipping: Conditional result was False 2026-04-28 07:31:10.797905 | 2026-04-28 07:31:10.797991 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-28 07:31:11.457879 | debian-bookworm | changed 2026-04-28 07:31:11.465023 | 2026-04-28 07:31:11.465114 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-28 07:31:11.718726 | debian-bookworm | ok 2026-04-28 07:31:11.726470 | 2026-04-28 07:31:11.726563 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-28 07:31:12.368605 | debian-bookworm | changed 2026-04-28 07:31:12.377076 | 2026-04-28 07:31:12.377187 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-28 07:31:12.976335 | debian-bookworm | changed 2026-04-28 07:31:12.989247 | 2026-04-28 07:31:12.989380 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-28 07:31:13.014556 | debian-bookworm | skipping: Conditional result was False 2026-04-28 07:31:13.021662 | 2026-04-28 07:31:13.021765 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-28 07:31:13.558381 | debian-bookworm -> localhost | changed 2026-04-28 07:31:13.577734 | 2026-04-28 07:31:13.577836 | TASK [add-build-sshkey : Add back temp key] 2026-04-28 07:31:14.405242 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/37dfaa0991624b5380444a338e4c98a5/work/37dfaa0991624b5380444a338e4c98a5_id_rsa (zuul-build-sshkey) 2026-04-28 07:31:14.405490 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.036955 2026-04-28 07:31:14.413889 | 2026-04-28 07:31:14.414010 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-28 07:31:14.892302 | debian-bookworm | ok 2026-04-28 07:31:14.897873 | 2026-04-28 07:31:14.898005 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-28 07:31:14.922099 | debian-bookworm | skipping: Conditional result was False 2026-04-28 07:31:14.933175 | 2026-04-28 07:31:14.933311 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-04-28 07:31:15.394654 | debian-bookworm | ok 2026-04-28 07:31:15.406587 | 2026-04-28 07:31:15.406715 | TASK [validate-host : Define zuul_info_dir fact] 2026-04-28 07:31:15.439703 | debian-bookworm | ok 2026-04-28 07:31:15.445077 | 2026-04-28 07:31:15.445233 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-04-28 07:31:15.937710 | debian-bookworm -> localhost | ok 2026-04-28 07:31:15.947511 | 2026-04-28 07:31:15.947645 | TASK [validate-host : Collect information about the host] 2026-04-28 07:31:17.175540 | debian-bookworm | ok 2026-04-28 07:31:17.185791 | 2026-04-28 07:31:17.185903 | TASK [validate-host : Sanitize hostname] 2026-04-28 07:31:17.358430 | debian-bookworm | ok 2026-04-28 07:31:17.425088 | 2026-04-28 07:31:17.425270 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-04-28 07:31:18.934634 | debian-bookworm -> localhost | changed 2026-04-28 07:31:18.940852 | 2026-04-28 07:31:18.940977 | TASK [validate-host : Collect information about zuul worker] 2026-04-28 07:31:19.752642 | debian-bookworm | ok 2026-04-28 07:31:19.758925 | 2026-04-28 07:31:19.759045 | TASK [validate-host : Write out all zuul information for each host] 2026-04-28 07:31:20.587357 | debian-bookworm -> localhost | changed 2026-04-28 07:31:20.598607 | 2026-04-28 07:31:20.598733 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-04-28 07:31:20.881055 | debian-bookworm | ok 2026-04-28 07:31:20.890980 | 2026-04-28 07:31:20.891196 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-04-28 07:31:22.216007 | debian-bookworm | changed: 2026-04-28 07:31:22.216371 | debian-bookworm | cd+++++++++ src/ 2026-04-28 07:31:22.216416 | debian-bookworm | cd+++++++++ src/github.com/ 2026-04-28 07:31:22.216441 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-04-28 07:31:22.216463 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-04-28 07:31:22.216483 | debian-bookworm | Containerfile 2026-04-28 07:31:22.216612 | debian-bookworm | Containerfile 2026-04-28 07:31:22.251735 | debian-bookworm | localhost | ok: Runtime: 0:00:00.004543 2026-04-28 07:44:27.349135 | 2026-04-28 07:44:27.349396 | TASK [upload-logs : Upload logs to log server] 2026-04-28 07:44:27.939225 | localhost | Output suppressed because no_log was given 2026-04-28 07:44:27.942350 | 2026-04-28 07:44:27.942578 | LOOP [upload-logs : Compress console log and json output] 2026-04-28 07:44:28.005820 | localhost | skipping: Conditional result was False 2026-04-28 07:44:28.010830 | localhost | skipping: Conditional result was False 2026-04-28 07:44:28.025059 | 2026-04-28 07:44:28.025281 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-28 07:44:28.077116 | localhost | skipping: Conditional result was False 2026-04-28 07:44:28.077852 | 2026-04-28 07:44:28.081063 | localhost | skipping: Conditional result was False 2026-04-28 07:44:28.088444 | 2026-04-28 07:44:28.088698 | LOOP [upload-logs : Upload console log and json output]