2025-06-02 14:52:42.778617 | Job console starting 2025-06-02 14:52:42.805387 | Updating git repos 2025-06-02 14:52:42.843148 | Cloning repos into workspace 2025-06-02 14:52:42.919227 | Restoring repo states 2025-06-02 14:52:42.926553 | Merging changes 2025-06-02 14:52:43.472882 | Checking out repos 2025-06-02 14:52:43.542366 | Preparing playbooks 2025-06-02 14:52:44.166254 | Running Ansible setup 2025-06-02 14:52:48.875264 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-02 14:52:49.658486 | 2025-06-02 14:52:49.658651 | PLAY [Base pre] 2025-06-02 14:52:49.675052 | 2025-06-02 14:52:49.675207 | TASK [Setup log path fact] 2025-06-02 14:52:49.704305 | debian-bookworm | ok 2025-06-02 14:52:49.730131 | 2025-06-02 14:52:49.730302 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-02 14:52:49.770242 | debian-bookworm | ok 2025-06-02 14:52:49.780486 | 2025-06-02 14:52:49.780623 | TASK [emit-job-header : Print job information] 2025-06-02 14:52:49.832080 | # Job Information 2025-06-02 14:52:49.832327 | Ansible Version: 2.16.14 2025-06-02 14:52:49.832370 | Job: python-black 2025-06-02 14:52:49.832402 | Pipeline: check 2025-06-02 14:52:49.832426 | Executor: 521e9411259a 2025-06-02 14:52:49.832447 | Triggered by: https://github.com/osism/testbed/pull/2701 2025-06-02 14:52:49.832469 | Event ID: 36ee24a0-3fc1-11f0-9ea3-053f6627dcc8 2025-06-02 14:52:49.842396 | 2025-06-02 14:52:49.842532 | LOOP [emit-job-header : Print node information] 2025-06-02 14:52:49.996671 | debian-bookworm | ok: 2025-06-02 14:52:49.996940 | debian-bookworm | # Node Information 2025-06-02 14:52:49.996979 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-02 14:52:49.997005 | debian-bookworm | Hostname: debian 2025-06-02 14:52:49.997028 | debian-bookworm | Username: zuul 2025-06-02 14:52:49.997049 | debian-bookworm | Distro: Debian 12.11 2025-06-02 14:52:49.997073 | debian-bookworm | Provider: regiocloud-a 2025-06-02 14:52:49.997094 | debian-bookworm | Region: 2025-06-02 14:52:49.997115 | debian-bookworm | Label: debian-bookworm 2025-06-02 14:52:49.997135 | debian-bookworm | Product Name: OpenStack Nova 2025-06-02 14:52:49.997154 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fed4:2fea 2025-06-02 14:52:50.018301 | 2025-06-02 14:52:50.018468 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-02 14:52:50.498632 | debian-bookworm -> localhost | changed 2025-06-02 14:52:50.506302 | 2025-06-02 14:52:50.506429 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-02 14:52:51.656435 | debian-bookworm -> localhost | changed 2025-06-02 14:52:51.680057 | 2025-06-02 14:52:51.680216 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-02 14:52:52.007440 | debian-bookworm -> localhost | ok 2025-06-02 14:52:52.014164 | 2025-06-02 14:52:52.014297 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-02 14:52:52.043676 | debian-bookworm | ok 2025-06-02 14:52:52.063330 | debian-bookworm | included: /var/lib/zuul/builds/4e543b29b32545948c7e3f66b74deef3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-02 14:52:52.089909 | 2025-06-02 14:52:52.090056 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-02 14:52:54.488285 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-02 14:52:54.488749 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/4e543b29b32545948c7e3f66b74deef3/work/4e543b29b32545948c7e3f66b74deef3_id_rsa 2025-06-02 14:52:54.488838 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/4e543b29b32545948c7e3f66b74deef3/work/4e543b29b32545948c7e3f66b74deef3_id_rsa.pub 2025-06-02 14:52:54.488896 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-02 14:52:54.488951 | debian-bookworm -> localhost | SHA256:mJWGC4pEGVP2V0XnbhSdoM47P7VLFVqZhXYw8Bg82oA zuul-build-sshkey 2025-06-02 14:52:54.488998 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-02 14:52:54.489063 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-02 14:52:54.489109 | debian-bookworm -> localhost | | ++o oo+o==oo| 2025-06-02 14:52:54.489153 | debian-bookworm -> localhost | |..o . .E.. *+++=| 2025-06-02 14:52:54.489194 | debian-bookworm -> localhost | | . ....+ =.=.* | 2025-06-02 14:52:54.489235 | debian-bookworm -> localhost | |.. . ..* + + o .| 2025-06-02 14:52:54.489276 | debian-bookworm -> localhost | |. . + S o + .| 2025-06-02 14:52:54.489329 | debian-bookworm -> localhost | | o ..| 2025-06-02 14:52:54.489374 | debian-bookworm -> localhost | | o ...| 2025-06-02 14:52:54.489417 | debian-bookworm -> localhost | | o... | 2025-06-02 14:52:54.489460 | debian-bookworm -> localhost | | ....| 2025-06-02 14:52:54.489502 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-02 14:52:54.489599 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.819404 2025-06-02 14:52:54.499913 | 2025-06-02 14:52:54.500063 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-02 14:52:54.546083 | debian-bookworm | ok 2025-06-02 14:52:54.559085 | debian-bookworm | included: /var/lib/zuul/builds/4e543b29b32545948c7e3f66b74deef3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-02 14:52:54.580087 | 2025-06-02 14:52:54.580250 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-02 14:52:54.604801 | debian-bookworm | skipping: Conditional result was False 2025-06-02 14:52:54.610982 | 2025-06-02 14:52:54.611102 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-02 14:52:55.333437 | debian-bookworm | changed 2025-06-02 14:52:55.340269 | 2025-06-02 14:52:55.340391 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-02 14:52:55.605682 | debian-bookworm | ok 2025-06-02 14:52:55.614394 | 2025-06-02 14:52:55.614547 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-02 14:52:56.271666 | debian-bookworm | changed 2025-06-02 14:52:56.281216 | 2025-06-02 14:52:56.281352 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-02 14:52:56.902960 | debian-bookworm | changed 2025-06-02 14:52:56.909062 | 2025-06-02 14:52:56.909190 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-02 14:52:56.944262 | debian-bookworm | skipping: Conditional result was False 2025-06-02 14:52:56.954618 | 2025-06-02 14:52:56.954884 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-02 14:52:57.439211 | debian-bookworm -> localhost | changed 2025-06-02 14:52:57.464646 | 2025-06-02 14:52:57.464896 | TASK [add-build-sshkey : Add back temp key] 2025-06-02 14:52:57.827441 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/4e543b29b32545948c7e3f66b74deef3/work/4e543b29b32545948c7e3f66b74deef3_id_rsa (zuul-build-sshkey) 2025-06-02 14:52:57.827985 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.025928 2025-06-02 14:52:57.840665 | 2025-06-02 14:52:57.840852 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-02 14:52:58.245921 | debian-bookworm | ok 2025-06-02 14:52:58.251247 | 2025-06-02 14:52:58.251364 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-02 14:52:58.275052 | debian-bookworm | skipping: Conditional result was False 2025-06-02 14:52:58.287902 | 2025-06-02 14:52:58.288044 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-02 14:52:58.754337 | debian-bookworm | ok 2025-06-02 14:52:58.765370 | 2025-06-02 14:52:58.765500 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-02 14:52:58.809897 | debian-bookworm | ok 2025-06-02 14:52:58.819794 | 2025-06-02 14:52:58.820504 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-02 14:52:59.121469 | debian-bookworm -> localhost | ok 2025-06-02 14:52:59.137102 | 2025-06-02 14:52:59.137289 | TASK [validate-host : Collect information about the host] 2025-06-02 14:53:00.285227 | debian-bookworm | ok 2025-06-02 14:53:00.295561 | 2025-06-02 14:53:00.295682 | TASK [validate-host : Sanitize hostname] 2025-06-02 14:53:00.429421 | debian-bookworm | ok 2025-06-02 14:53:00.471027 | 2025-06-02 14:53:00.471173 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-02 14:53:01.145061 | debian-bookworm -> localhost | changed 2025-06-02 14:53:01.151530 | 2025-06-02 14:53:01.151655 | TASK [validate-host : Collect information about zuul worker] 2025-06-02 14:53:01.582431 | debian-bookworm | ok 2025-06-02 14:53:01.591267 | 2025-06-02 14:53:01.591432 | TASK [validate-host : Write out all zuul information for each host] 2025-06-02 14:53:02.191122 | debian-bookworm -> localhost | changed 2025-06-02 14:53:02.211722 | 2025-06-02 14:53:02.211910 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-02 14:53:02.503062 | debian-bookworm | ok 2025-06-02 14:53:02.512797 | 2025-06-02 14:53:02.512956 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-02 14:53:03.753082 | debian-bookworm | changed: 2025-06-02 14:53:03.753299 | debian-bookworm | cd+++++++++ src/ 2025-06-02 14:53:03.753336 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-02 14:53:03.753361 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-02 14:53:03.753382 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-06-02 14:53:03.753402 | debian-bookworm | localhost | ok: Runtime: 0:00:00.005626 2025-06-02 14:53:29.109430 | 2025-06-02 14:53:29.109585 | TASK [upload-logs : Upload logs to log server] 2025-06-02 14:53:29.716350 | localhost | Output suppressed because no_log was given 2025-06-02 14:53:29.720910 | 2025-06-02 14:53:29.721072 | LOOP [upload-logs : Compress console log and json output] 2025-06-02 14:53:29.782185 | localhost | skipping: Conditional result was False 2025-06-02 14:53:29.787823 | localhost | skipping: Conditional result was False 2025-06-02 14:53:29.796408 | 2025-06-02 14:53:29.796538 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-02 14:53:29.858421 | localhost | skipping: Conditional result was False 2025-06-02 14:53:29.858811 | 2025-06-02 14:53:29.864924 | localhost | skipping: Conditional result was False 2025-06-02 14:53:29.873885 | 2025-06-02 14:53:29.874006 | LOOP [upload-logs : Upload console log and json output]