2025-10-26 20:52:44.393629 | Job console starting 2025-10-26 20:52:44.413365 | Updating git repos 2025-10-26 20:52:44.492019 | Cloning repos into workspace 2025-10-26 20:52:44.587067 | Restoring repo states 2025-10-26 20:52:44.612002 | Merging changes 2025-10-26 20:52:45.221784 | Checking out repos 2025-10-26 20:52:45.291939 | Preparing playbooks 2025-10-26 20:52:46.368734 | Running Ansible setup 2025-10-26 20:52:51.467077 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-26 20:52:52.233205 | 2025-10-26 20:52:52.233319 | PLAY [Base pre] 2025-10-26 20:52:52.245594 | 2025-10-26 20:52:52.245689 | TASK [Setup log path fact] 2025-10-26 20:52:52.261975 | debian-bookworm | ok 2025-10-26 20:52:52.277385 | 2025-10-26 20:52:52.277487 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-26 20:52:52.304331 | debian-bookworm | ok 2025-10-26 20:52:52.311820 | 2025-10-26 20:52:52.311896 | TASK [emit-job-header : Print job information] 2025-10-26 20:52:52.375297 | # Job Information 2025-10-26 20:52:52.375427 | Ansible Version: 2.16.14 2025-10-26 20:52:52.375456 | Job: python-black 2025-10-26 20:52:52.375483 | Pipeline: check 2025-10-26 20:52:52.375502 | Executor: 521e9411259a 2025-10-26 20:52:52.375519 | Triggered by: https://github.com/osism/python-osism/pull/1773 2025-10-26 20:52:52.375539 | Event ID: b40750b0-b2ad-11f0-94ce-02f71cb467cc 2025-10-26 20:52:52.379358 | 2025-10-26 20:52:52.379433 | LOOP [emit-job-header : Print node information] 2025-10-26 20:52:52.585551 | debian-bookworm | ok: 2025-10-26 20:52:52.585695 | debian-bookworm | # Node Information 2025-10-26 20:52:52.585723 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-26 20:52:52.585743 | debian-bookworm | Hostname: debian 2025-10-26 20:52:52.585761 | debian-bookworm | Username: zuul 2025-10-26 20:52:52.585779 | debian-bookworm | Distro: Debian 12.12 2025-10-26 20:52:52.585798 | debian-bookworm | Provider: regiocloud-a 2025-10-26 20:52:52.585815 | debian-bookworm | Region: 2025-10-26 20:52:52.585832 | debian-bookworm | Label: debian-bookworm 2025-10-26 20:52:52.585848 | debian-bookworm | Product Name: OpenStack Nova 2025-10-26 20:52:52.585864 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe19:56f4 2025-10-26 20:52:52.612571 | 2025-10-26 20:52:52.612677 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-26 20:52:53.311391 | debian-bookworm -> localhost | changed 2025-10-26 20:52:53.320357 | 2025-10-26 20:52:53.320459 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-26 20:52:54.728317 | debian-bookworm -> localhost | changed 2025-10-26 20:52:54.737011 | 2025-10-26 20:52:54.737092 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-26 20:52:55.164725 | debian-bookworm -> localhost | ok 2025-10-26 20:52:55.176084 | 2025-10-26 20:52:55.176184 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-26 20:52:55.212923 | debian-bookworm | ok 2025-10-26 20:52:55.235011 | debian-bookworm | included: /var/lib/zuul/builds/4689d6eed0b34430b37af0b5bdd2a85b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-26 20:52:55.244899 | 2025-10-26 20:52:55.244985 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-26 20:52:56.508561 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-26 20:52:56.508728 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/4689d6eed0b34430b37af0b5bdd2a85b/work/4689d6eed0b34430b37af0b5bdd2a85b_id_rsa 2025-10-26 20:52:56.508761 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/4689d6eed0b34430b37af0b5bdd2a85b/work/4689d6eed0b34430b37af0b5bdd2a85b_id_rsa.pub 2025-10-26 20:52:56.508783 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-26 20:52:56.508804 | debian-bookworm -> localhost | SHA256:Gbv5vhpbPW4bxLtqcHPyNhsz5hiuYgOP/ET9Emuk/Bo zuul-build-sshkey 2025-10-26 20:52:56.508822 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-26 20:52:56.508848 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-26 20:52:56.508866 | debian-bookworm -> localhost | | | 2025-10-26 20:52:56.508884 | debian-bookworm -> localhost | | | 2025-10-26 20:52:56.508901 | debian-bookworm -> localhost | | . | 2025-10-26 20:52:56.508918 | debian-bookworm -> localhost | | . + . | 2025-10-26 20:52:56.508934 | debian-bookworm -> localhost | | . S o | 2025-10-26 20:52:56.508952 | debian-bookworm -> localhost | | .o o.*+o.. | 2025-10-26 20:52:56.508968 | debian-bookworm -> localhost | | . +E Bo+=X | 2025-10-26 20:52:56.508984 | debian-bookworm -> localhost | | o.=+ B.*=B | 2025-10-26 20:52:56.509001 | debian-bookworm -> localhost | | oo+==B=*+ | 2025-10-26 20:52:56.509018 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-26 20:52:56.509056 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.720178 2025-10-26 20:52:56.514030 | 2025-10-26 20:52:56.514106 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-26 20:52:56.550812 | debian-bookworm | ok 2025-10-26 20:52:56.564886 | debian-bookworm | included: /var/lib/zuul/builds/4689d6eed0b34430b37af0b5bdd2a85b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-26 20:52:56.584016 | 2025-10-26 20:52:56.584096 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-26 20:52:56.601579 | debian-bookworm | skipping: Conditional result was False 2025-10-26 20:52:56.606039 | 2025-10-26 20:52:56.606109 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-26 20:52:57.318531 | debian-bookworm | changed 2025-10-26 20:52:57.323571 | 2025-10-26 20:52:57.323648 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-26 20:52:57.565473 | debian-bookworm | ok 2025-10-26 20:52:57.571937 | 2025-10-26 20:52:57.572014 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-26 20:52:58.181258 | debian-bookworm | changed 2025-10-26 20:52:58.186605 | 2025-10-26 20:52:58.186681 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-26 20:52:58.807311 | debian-bookworm | changed 2025-10-26 20:52:58.811552 | 2025-10-26 20:52:58.811619 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-26 20:52:58.824306 | debian-bookworm | skipping: Conditional result was False 2025-10-26 20:52:58.828972 | 2025-10-26 20:52:58.829044 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-26 20:52:59.240490 | debian-bookworm -> localhost | changed 2025-10-26 20:52:59.251427 | 2025-10-26 20:52:59.251522 | TASK [add-build-sshkey : Add back temp key] 2025-10-26 20:52:59.579989 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/4689d6eed0b34430b37af0b5bdd2a85b/work/4689d6eed0b34430b37af0b5bdd2a85b_id_rsa (zuul-build-sshkey) 2025-10-26 20:52:59.580240 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.027577 2025-10-26 20:52:59.589830 | 2025-10-26 20:52:59.589930 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-26 20:52:59.983990 | debian-bookworm | ok 2025-10-26 20:52:59.988330 | 2025-10-26 20:52:59.988407 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-26 20:53:00.010904 | debian-bookworm | skipping: Conditional result was False 2025-10-26 20:53:00.019717 | 2025-10-26 20:53:00.019805 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-26 20:53:00.513381 | debian-bookworm | ok 2025-10-26 20:53:00.521756 | 2025-10-26 20:53:00.521843 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-26 20:53:00.560680 | debian-bookworm | ok 2025-10-26 20:53:00.564720 | 2025-10-26 20:53:00.564794 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-26 20:53:00.811210 | debian-bookworm -> localhost | ok 2025-10-26 20:53:00.817606 | 2025-10-26 20:53:00.817687 | TASK [validate-host : Collect information about the host] 2025-10-26 20:53:01.997829 | debian-bookworm | ok 2025-10-26 20:53:02.007558 | 2025-10-26 20:53:02.007652 | TASK [validate-host : Sanitize hostname] 2025-10-26 20:53:02.083002 | debian-bookworm | ok 2025-10-26 20:53:02.117072 | 2025-10-26 20:53:02.117169 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-26 20:53:02.901848 | debian-bookworm -> localhost | changed 2025-10-26 20:53:02.907291 | 2025-10-26 20:53:02.907384 | TASK [validate-host : Collect information about zuul worker] 2025-10-26 20:53:03.301482 | debian-bookworm | ok 2025-10-26 20:53:03.307032 | 2025-10-26 20:53:03.307131 | TASK [validate-host : Write out all zuul information for each host] 2025-10-26 20:53:04.065572 | debian-bookworm -> localhost | changed 2025-10-26 20:53:04.073103 | 2025-10-26 20:53:04.073190 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-26 20:53:04.394153 | debian-bookworm | ok 2025-10-26 20:53:04.403332 | 2025-10-26 20:53:04.403445 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-26 20:53:05.238451 | debian-bookworm | changed: 2025-10-26 20:53:05.238610 | debian-bookworm | cd+++++++++ src/ 2025-10-26 20:53:05.238639 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-26 20:53:05.238659 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-26 20:53:05.238676 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-10-26 20:53:05.238693 | debian-bookworm | Containerfile 2025-10-26 20:53:05.238794 | debian-bookworm | Containerfile 2025-10-26 20:53:05.245853 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006818 2025-10-26 20:53:31.781622 | 2025-10-26 20:53:31.781788 | TASK [upload-logs : Upload logs to log server] 2025-10-26 20:53:32.337064 | localhost | Output suppressed because no_log was given 2025-10-26 20:53:32.339436 | 2025-10-26 20:53:32.339562 | LOOP [upload-logs : Compress console log and json output] 2025-10-26 20:53:32.396011 | localhost | skipping: Conditional result was False 2025-10-26 20:53:32.400972 | localhost | skipping: Conditional result was False 2025-10-26 20:53:32.412928 | 2025-10-26 20:53:32.413131 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-26 20:53:32.459478 | localhost | skipping: Conditional result was False 2025-10-26 20:53:32.460295 | 2025-10-26 20:53:32.463550 | localhost | skipping: Conditional result was False 2025-10-26 20:53:32.476585 | 2025-10-26 20:53:32.476792 | LOOP [upload-logs : Upload console log and json output]