2025-07-09 16:55:13.128466 | Job console starting 2025-07-09 16:55:13.145058 | Updating git repos 2025-07-09 16:55:13.256734 | Cloning repos into workspace 2025-07-09 16:55:13.322444 | Restoring repo states 2025-07-09 16:55:13.364700 | Merging changes 2025-07-09 16:55:14.112043 | Checking out repos 2025-07-09 16:55:14.173709 | Preparing playbooks 2025-07-09 16:55:15.686431 | Running Ansible setup 2025-07-09 16:55:22.892872 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-07-09 16:55:23.893059 | 2025-07-09 16:55:23.893190 | PLAY [Base pre] 2025-07-09 16:55:23.915793 | 2025-07-09 16:55:23.915919 | TASK [Setup log path fact] 2025-07-09 16:55:23.945490 | debian-bookworm | ok 2025-07-09 16:55:23.970825 | 2025-07-09 16:55:23.972017 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-07-09 16:55:24.000712 | debian-bookworm | ok 2025-07-09 16:55:24.010487 | 2025-07-09 16:55:24.010618 | TASK [emit-job-header : Print job information] 2025-07-09 16:55:24.055973 | # Job Information 2025-07-09 16:55:24.056211 | Ansible Version: 2.16.14 2025-07-09 16:55:24.056256 | Job: python-black 2025-07-09 16:55:24.056291 | Pipeline: check 2025-07-09 16:55:24.056314 | Executor: 521e9411259a 2025-07-09 16:55:24.056335 | Triggered by: https://github.com/osism/python-osism/pull/1566 2025-07-09 16:55:24.056357 | Event ID: 75a43f90-5ce5-11f0-8f71-ae7439404c5c 2025-07-09 16:55:24.063477 | 2025-07-09 16:55:24.063607 | LOOP [emit-job-header : Print node information] 2025-07-09 16:55:24.195018 | debian-bookworm | ok: 2025-07-09 16:55:24.195176 | debian-bookworm | # Node Information 2025-07-09 16:55:24.195210 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-07-09 16:55:24.195235 | debian-bookworm | Hostname: debian 2025-07-09 16:55:24.195257 | debian-bookworm | Username: zuul 2025-07-09 16:55:24.195277 | debian-bookworm | Distro: Debian 12.11 2025-07-09 16:55:24.195399 | debian-bookworm | Provider: regiocloud-a 2025-07-09 16:55:24.195432 | debian-bookworm | Region: 2025-07-09 16:55:24.195456 | debian-bookworm | Label: debian-bookworm 2025-07-09 16:55:24.195476 | debian-bookworm | Product Name: OpenStack Nova 2025-07-09 16:55:24.195496 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe2d:e5c0 2025-07-09 16:55:24.215416 | 2025-07-09 16:55:24.215542 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-07-09 16:55:24.941917 | debian-bookworm -> localhost | changed 2025-07-09 16:55:24.949443 | 2025-07-09 16:55:24.949548 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-07-09 16:55:26.227646 | debian-bookworm -> localhost | changed 2025-07-09 16:55:26.238050 | 2025-07-09 16:55:26.238165 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-07-09 16:55:26.708811 | debian-bookworm -> localhost | ok 2025-07-09 16:55:26.715847 | 2025-07-09 16:55:26.715969 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-07-09 16:55:26.759694 | debian-bookworm | ok 2025-07-09 16:55:26.779798 | debian-bookworm | included: /var/lib/zuul/builds/600a82ece2bd471abf982175bd220a33/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-07-09 16:55:26.785816 | 2025-07-09 16:55:26.785913 | TASK [add-build-sshkey : Create Temp SSH key] 2025-07-09 16:55:29.093215 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-07-09 16:55:29.093433 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/600a82ece2bd471abf982175bd220a33/work/600a82ece2bd471abf982175bd220a33_id_rsa 2025-07-09 16:55:29.093473 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/600a82ece2bd471abf982175bd220a33/work/600a82ece2bd471abf982175bd220a33_id_rsa.pub 2025-07-09 16:55:29.093499 | debian-bookworm -> localhost | The key fingerprint is: 2025-07-09 16:55:29.093523 | debian-bookworm -> localhost | SHA256:1b/IuIobWe/yNZdxq20d/PWLl1M7x2HAXzwnpIxgUqg zuul-build-sshkey 2025-07-09 16:55:29.093545 | debian-bookworm -> localhost | The key's randomart image is: 2025-07-09 16:55:29.093586 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-07-09 16:55:29.093610 | debian-bookworm -> localhost | | o. | 2025-07-09 16:55:29.093633 | debian-bookworm -> localhost | | o o . . | 2025-07-09 16:55:29.093653 | debian-bookworm -> localhost | | . o ..ooo . | 2025-07-09 16:55:29.093673 | debian-bookworm -> localhost | | E .. o+..+| 2025-07-09 16:55:29.093693 | debian-bookworm -> localhost | | S *.=| 2025-07-09 16:55:29.093719 | debian-bookworm -> localhost | | o . o . @+| 2025-07-09 16:55:29.093740 | debian-bookworm -> localhost | | o o = =o@| 2025-07-09 16:55:29.093760 | debian-bookworm -> localhost | | o.. o o+B*| 2025-07-09 16:55:29.093781 | debian-bookworm -> localhost | | o..++ ooo=| 2025-07-09 16:55:29.093800 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-07-09 16:55:29.093851 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.512595 2025-07-09 16:55:29.100016 | 2025-07-09 16:55:29.100103 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-07-09 16:55:29.133260 | debian-bookworm | ok 2025-07-09 16:55:29.142220 | debian-bookworm | included: /var/lib/zuul/builds/600a82ece2bd471abf982175bd220a33/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-07-09 16:55:29.150883 | 2025-07-09 16:55:29.150967 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-07-09 16:55:29.174203 | debian-bookworm | skipping: Conditional result was False 2025-07-09 16:55:29.186819 | 2025-07-09 16:55:29.186994 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-07-09 16:55:29.847729 | debian-bookworm | changed 2025-07-09 16:55:29.855812 | 2025-07-09 16:55:29.855955 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-07-09 16:55:30.132604 | debian-bookworm | ok 2025-07-09 16:55:30.137799 | 2025-07-09 16:55:30.137890 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-07-09 16:55:30.803711 | debian-bookworm | changed 2025-07-09 16:55:30.810189 | 2025-07-09 16:55:30.810288 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-07-09 16:55:31.467591 | debian-bookworm | changed 2025-07-09 16:55:31.473032 | 2025-07-09 16:55:31.473140 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-07-09 16:55:31.486121 | debian-bookworm | skipping: Conditional result was False 2025-07-09 16:55:31.492939 | 2025-07-09 16:55:31.493060 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-07-09 16:55:32.071288 | debian-bookworm -> localhost | changed 2025-07-09 16:55:32.092426 | 2025-07-09 16:55:32.092600 | TASK [add-build-sshkey : Add back temp key] 2025-07-09 16:55:32.559389 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/600a82ece2bd471abf982175bd220a33/work/600a82ece2bd471abf982175bd220a33_id_rsa (zuul-build-sshkey) 2025-07-09 16:55:32.559751 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.020017 2025-07-09 16:55:32.572022 | 2025-07-09 16:55:32.572156 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-07-09 16:55:33.003227 | debian-bookworm | ok 2025-07-09 16:55:33.008619 | 2025-07-09 16:55:33.008743 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-07-09 16:55:33.033598 | debian-bookworm | skipping: Conditional result was False 2025-07-09 16:55:33.044426 | 2025-07-09 16:55:33.044555 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-07-09 16:55:33.491485 | debian-bookworm | ok 2025-07-09 16:55:33.515917 | 2025-07-09 16:55:33.516066 | TASK [validate-host : Define zuul_info_dir fact] 2025-07-09 16:55:33.556799 | debian-bookworm | ok 2025-07-09 16:55:33.562798 | 2025-07-09 16:55:33.562942 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-07-09 16:55:33.851723 | debian-bookworm -> localhost | ok 2025-07-09 16:55:33.859016 | 2025-07-09 16:55:33.859129 | TASK [validate-host : Collect information about the host] 2025-07-09 16:55:35.040892 | debian-bookworm | ok 2025-07-09 16:55:35.061328 | 2025-07-09 16:55:35.061470 | TASK [validate-host : Sanitize hostname] 2025-07-09 16:55:35.182601 | debian-bookworm | ok 2025-07-09 16:55:35.231319 | 2025-07-09 16:55:35.231482 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-07-09 16:55:35.896292 | debian-bookworm -> localhost | changed 2025-07-09 16:55:35.905268 | 2025-07-09 16:55:35.905410 | TASK [validate-host : Collect information about zuul worker] 2025-07-09 16:55:36.359645 | debian-bookworm | ok 2025-07-09 16:55:36.367089 | 2025-07-09 16:55:36.367254 | TASK [validate-host : Write out all zuul information for each host] 2025-07-09 16:55:36.997336 | debian-bookworm -> localhost | changed 2025-07-09 16:55:37.017982 | 2025-07-09 16:55:37.018131 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-07-09 16:55:37.332279 | debian-bookworm | ok 2025-07-09 16:55:37.342905 | 2025-07-09 16:55:37.343062 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-07-09 16:55:38.394522 | debian-bookworm | changed: 2025-07-09 16:55:38.394767 | debian-bookworm | cd+++++++++ src/ 2025-07-09 16:55:38.394804 | debian-bookworm | cd+++++++++ src/github.com/ 2025-07-09 16:55:38.394827 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-07-09 16:55:38.395088 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-07-09 16:55:38.395109 | debian-bookworm | Containerfile 2025-07-09 16:55:38.395225 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006881 2025-07-09 16:56:05.168373 | 2025-07-09 16:56:05.168555 | TASK [upload-logs : Upload logs to log server] 2025-07-09 16:56:05.682785 | localhost | Output suppressed because no_log was given 2025-07-09 16:56:05.686402 | 2025-07-09 16:56:05.686645 | LOOP [upload-logs : Compress console log and json output] 2025-07-09 16:56:05.733711 | localhost | skipping: Conditional result was False 2025-07-09 16:56:05.738489 | localhost | skipping: Conditional result was False 2025-07-09 16:56:05.750619 | 2025-07-09 16:56:05.750951 | LOOP [upload-logs : Upload compressed console log and json output] 2025-07-09 16:56:05.791270 | localhost | skipping: Conditional result was False 2025-07-09 16:56:05.791508 | 2025-07-09 16:56:05.795874 | localhost | skipping: Conditional result was False 2025-07-09 16:56:05.799194 | 2025-07-09 16:56:05.799285 | LOOP [upload-logs : Upload console log and json output]