2026-02-26 18:22:13.853225 | Job console starting 2026-02-26 18:22:13.885353 | Updating git repos 2026-02-26 18:22:13.918178 | Cloning repos into workspace 2026-02-26 18:22:13.996993 | Restoring repo states 2026-02-26 18:22:14.007159 | Merging changes 2026-02-26 18:22:14.654113 | Checking out repos 2026-02-26 18:22:14.764343 | Preparing playbooks 2026-02-26 18:22:15.587050 | Running Ansible setup 2026-02-26 18:22:19.928190 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-02-26 18:22:20.771376 | 2026-02-26 18:22:20.771535 | PLAY [Base pre] 2026-02-26 18:22:20.793465 | 2026-02-26 18:22:20.793640 | TASK [Setup log path fact] 2026-02-26 18:22:20.814718 | debian-bookworm | ok 2026-02-26 18:22:20.831356 | 2026-02-26 18:22:20.831521 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-26 18:22:20.862078 | debian-bookworm | ok 2026-02-26 18:22:20.872252 | 2026-02-26 18:22:20.872390 | TASK [emit-job-header : Print job information] 2026-02-26 18:22:20.911758 | # Job Information 2026-02-26 18:22:20.911941 | Ansible Version: 2.16.14 2026-02-26 18:22:20.911976 | Job: python-black 2026-02-26 18:22:20.912007 | Pipeline: check 2026-02-26 18:22:20.912030 | Executor: 521e9411259a 2026-02-26 18:22:20.912051 | Triggered by: https://github.com/osism/testbed/pull/2850 2026-02-26 18:22:20.912075 | Event ID: 0ceb7bf0-1340-11f1-95fd-212f3e0224ee 2026-02-26 18:22:20.917094 | 2026-02-26 18:22:20.917206 | LOOP [emit-job-header : Print node information] 2026-02-26 18:22:21.057555 | debian-bookworm | ok: 2026-02-26 18:22:21.057874 | debian-bookworm | # Node Information 2026-02-26 18:22:21.057915 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-02-26 18:22:21.057941 | debian-bookworm | Hostname: debian 2026-02-26 18:22:21.057963 | debian-bookworm | Username: zuul 2026-02-26 18:22:21.057984 | debian-bookworm | Distro: Debian 12.13 2026-02-26 18:22:21.058008 | debian-bookworm | Provider: regiocloud-a 2026-02-26 18:22:21.058029 | debian-bookworm | Region: 2026-02-26 18:22:21.058051 | debian-bookworm | Label: debian-bookworm 2026-02-26 18:22:21.058071 | debian-bookworm | Product Name: OpenStack Nova 2026-02-26 18:22:21.058090 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fee2:fcad 2026-02-26 18:22:21.081149 | 2026-02-26 18:22:21.081287 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-26 18:22:21.591919 | debian-bookworm -> localhost | changed 2026-02-26 18:22:21.605987 | 2026-02-26 18:22:21.606135 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-26 18:22:22.704173 | debian-bookworm -> localhost | changed 2026-02-26 18:22:22.715075 | 2026-02-26 18:22:22.715202 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-26 18:22:22.974756 | debian-bookworm -> localhost | ok 2026-02-26 18:22:22.981871 | 2026-02-26 18:22:22.982024 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-26 18:22:23.011595 | debian-bookworm | ok 2026-02-26 18:22:23.032393 | debian-bookworm | included: /var/lib/zuul/builds/0cc436566cb845558b398692f9a29e60/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-26 18:22:23.038603 | 2026-02-26 18:22:23.038749 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-26 18:22:24.716565 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-02-26 18:22:24.716874 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/0cc436566cb845558b398692f9a29e60/work/0cc436566cb845558b398692f9a29e60_id_rsa 2026-02-26 18:22:24.716914 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/0cc436566cb845558b398692f9a29e60/work/0cc436566cb845558b398692f9a29e60_id_rsa.pub 2026-02-26 18:22:24.716941 | debian-bookworm -> localhost | The key fingerprint is: 2026-02-26 18:22:24.716966 | debian-bookworm -> localhost | SHA256:+5lD96AXTBri1XFjagsIO4Y9okb69fYC28kH4jCk4ZQ zuul-build-sshkey 2026-02-26 18:22:24.716989 | debian-bookworm -> localhost | The key's randomart image is: 2026-02-26 18:22:24.717053 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-02-26 18:22:24.717076 | debian-bookworm -> localhost | | | 2026-02-26 18:22:24.717098 | debian-bookworm -> localhost | | . . + | 2026-02-26 18:22:24.717118 | debian-bookworm -> localhost | | . o o . . = . | 2026-02-26 18:22:24.717138 | debian-bookworm -> localhost | |.Eo o * o + = | 2026-02-26 18:22:24.717158 | debian-bookworm -> localhost | |o* . o +So B . | 2026-02-26 18:22:24.717186 | debian-bookworm -> localhost | |o.= + . ..o * | 2026-02-26 18:22:24.717206 | debian-bookworm -> localhost | | o = B o.. o + | 2026-02-26 18:22:24.717227 | debian-bookworm -> localhost | | . o B ..oo. . | 2026-02-26 18:22:24.717249 | debian-bookworm -> localhost | | . +. +o | 2026-02-26 18:22:24.717269 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-02-26 18:22:24.717328 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.084591 2026-02-26 18:22:24.724834 | 2026-02-26 18:22:24.724973 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-26 18:22:24.762276 | debian-bookworm | ok 2026-02-26 18:22:24.776236 | debian-bookworm | included: /var/lib/zuul/builds/0cc436566cb845558b398692f9a29e60/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-26 18:22:24.785970 | 2026-02-26 18:22:24.786075 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-26 18:22:24.810820 | debian-bookworm | skipping: Conditional result was False 2026-02-26 18:22:24.820016 | 2026-02-26 18:22:24.820179 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-26 18:22:25.439030 | debian-bookworm | changed 2026-02-26 18:22:25.450856 | 2026-02-26 18:22:25.451011 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-26 18:22:25.730239 | debian-bookworm | ok 2026-02-26 18:22:25.739989 | 2026-02-26 18:22:25.740156 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-26 18:22:26.407938 | debian-bookworm | changed 2026-02-26 18:22:26.417502 | 2026-02-26 18:22:26.417662 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-26 18:22:27.092092 | debian-bookworm | changed 2026-02-26 18:22:27.105512 | 2026-02-26 18:22:27.105673 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-26 18:22:27.129849 | debian-bookworm | skipping: Conditional result was False 2026-02-26 18:22:27.135955 | 2026-02-26 18:22:27.136062 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-26 18:22:27.588643 | debian-bookworm -> localhost | changed 2026-02-26 18:22:27.600299 | 2026-02-26 18:22:27.600423 | TASK [add-build-sshkey : Add back temp key] 2026-02-26 18:22:27.925320 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/0cc436566cb845558b398692f9a29e60/work/0cc436566cb845558b398692f9a29e60_id_rsa (zuul-build-sshkey) 2026-02-26 18:22:27.925568 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011410 2026-02-26 18:22:27.933752 | 2026-02-26 18:22:27.933871 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-26 18:22:28.365655 | debian-bookworm | ok 2026-02-26 18:22:28.379089 | 2026-02-26 18:22:28.379213 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-26 18:22:28.413159 | debian-bookworm | skipping: Conditional result was False 2026-02-26 18:22:28.432084 | 2026-02-26 18:22:28.432212 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-02-26 18:22:28.881326 | debian-bookworm | ok 2026-02-26 18:22:28.893295 | 2026-02-26 18:22:28.893432 | TASK [validate-host : Define zuul_info_dir fact] 2026-02-26 18:22:28.923589 | debian-bookworm | ok 2026-02-26 18:22:28.928759 | 2026-02-26 18:22:28.928863 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-02-26 18:22:29.253028 | debian-bookworm -> localhost | ok 2026-02-26 18:22:29.264145 | 2026-02-26 18:22:29.264294 | TASK [validate-host : Collect information about the host] 2026-02-26 18:22:30.463389 | debian-bookworm | ok 2026-02-26 18:22:30.473656 | 2026-02-26 18:22:30.473771 | TASK [validate-host : Sanitize hostname] 2026-02-26 18:22:30.575153 | debian-bookworm | ok 2026-02-26 18:22:30.614068 | 2026-02-26 18:22:30.614205 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-02-26 18:22:31.215505 | debian-bookworm -> localhost | changed 2026-02-26 18:22:31.221803 | 2026-02-26 18:22:31.221926 | TASK [validate-host : Collect information about zuul worker] 2026-02-26 18:22:31.655646 | debian-bookworm | ok 2026-02-26 18:22:31.660471 | 2026-02-26 18:22:31.660586 | TASK [validate-host : Write out all zuul information for each host] 2026-02-26 18:22:32.273385 | debian-bookworm -> localhost | changed 2026-02-26 18:22:32.293910 | 2026-02-26 18:22:32.294146 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-02-26 18:22:32.576075 | debian-bookworm | ok 2026-02-26 18:22:32.581843 | 2026-02-26 18:22:32.581948 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-02-26 18:22:33.807046 | debian-bookworm | changed: 2026-02-26 18:22:33.807321 | debian-bookworm | cd+++++++++ src/ 2026-02-26 18:22:33.807370 | debian-bookworm | cd+++++++++ src/github.com/ 2026-02-26 18:22:33.807407 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-02-26 18:22:33.807438 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2026-02-26 18:22:33.807467 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006535 2026-02-26 18:22:59.280534 | 2026-02-26 18:22:59.280679 | TASK [upload-logs : Upload logs to log server] 2026-02-26 18:22:59.847536 | localhost | Output suppressed because no_log was given 2026-02-26 18:22:59.849399 | 2026-02-26 18:22:59.849506 | LOOP [upload-logs : Compress console log and json output] 2026-02-26 18:22:59.915947 | localhost | skipping: Conditional result was False 2026-02-26 18:22:59.926212 | localhost | skipping: Conditional result was False 2026-02-26 18:22:59.930182 | 2026-02-26 18:22:59.930296 | LOOP [upload-logs : Upload compressed console log and json output] 2026-02-26 18:22:59.993186 | localhost | skipping: Conditional result was False 2026-02-26 18:22:59.993483 | 2026-02-26 18:22:59.998307 | localhost | skipping: Conditional result was False 2026-02-26 18:23:00.010259 | 2026-02-26 18:23:00.010381 | LOOP [upload-logs : Upload console log and json output]