2025-07-13 10:30:20.368232 | Job console starting 2025-07-13 10:30:20.419998 | Updating git repos 2025-07-13 10:30:20.520416 | Cloning repos into workspace 2025-07-13 10:30:20.564849 | Restoring repo states 2025-07-13 10:30:20.573702 | Merging changes 2025-07-13 10:30:21.144775 | Checking out repos 2025-07-13 10:30:21.183911 | Preparing playbooks 2025-07-13 10:30:22.142636 | Running Ansible setup 2025-07-13 10:30:27.999121 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-07-13 10:30:29.183731 | 2025-07-13 10:30:29.183915 | PLAY [Base pre] 2025-07-13 10:30:29.205899 | 2025-07-13 10:30:29.206074 | TASK [Setup log path fact] 2025-07-13 10:30:29.249301 | debian-bookworm | ok 2025-07-13 10:30:29.270175 | 2025-07-13 10:30:29.270382 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-07-13 10:30:29.333413 | debian-bookworm | ok 2025-07-13 10:30:29.345132 | 2025-07-13 10:30:29.345329 | TASK [emit-job-header : Print job information] 2025-07-13 10:30:29.435575 | # Job Information 2025-07-13 10:30:29.435867 | Ansible Version: 2.16.14 2025-07-13 10:30:29.435916 | Job: python-black 2025-07-13 10:30:29.435954 | Pipeline: check 2025-07-13 10:30:29.436016 | Executor: 521e9411259a 2025-07-13 10:30:29.436040 | Triggered by: https://github.com/osism/python-osism/pull/1571 2025-07-13 10:30:29.436063 | Event ID: 5ba04160-5fd4-11f0-9352-1176827d317b 2025-07-13 10:30:29.441316 | 2025-07-13 10:30:29.441440 | LOOP [emit-job-header : Print node information] 2025-07-13 10:30:29.676575 | debian-bookworm | ok: 2025-07-13 10:30:29.676821 | debian-bookworm | # Node Information 2025-07-13 10:30:29.676859 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-07-13 10:30:29.676885 | debian-bookworm | Hostname: debian 2025-07-13 10:30:29.676906 | debian-bookworm | Username: zuul 2025-07-13 10:30:29.676926 | debian-bookworm | Distro: Debian 12.11 2025-07-13 10:30:29.676953 | debian-bookworm | Provider: regiocloud-a 2025-07-13 10:30:29.676974 | debian-bookworm | Region: 2025-07-13 10:30:29.676995 | debian-bookworm | Label: debian-bookworm 2025-07-13 10:30:29.677014 | debian-bookworm | Product Name: OpenStack Nova 2025-07-13 10:30:29.677034 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feef:406a 2025-07-13 10:30:29.702144 | 2025-07-13 10:30:29.702349 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-07-13 10:30:30.294865 | debian-bookworm -> localhost | changed 2025-07-13 10:30:30.302825 | 2025-07-13 10:30:30.303000 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-07-13 10:30:32.172475 | debian-bookworm -> localhost | changed 2025-07-13 10:30:32.197096 | 2025-07-13 10:30:32.197251 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-07-13 10:30:32.787839 | debian-bookworm -> localhost | ok 2025-07-13 10:30:32.795379 | 2025-07-13 10:30:32.795514 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-07-13 10:30:32.824785 | debian-bookworm | ok 2025-07-13 10:30:32.844255 | debian-bookworm | included: /var/lib/zuul/builds/41102520ca344a0d9095071c5cfbb2f4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-07-13 10:30:32.857853 | 2025-07-13 10:30:32.857996 | TASK [add-build-sshkey : Create Temp SSH key] 2025-07-13 10:30:35.094727 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-07-13 10:30:35.095254 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/41102520ca344a0d9095071c5cfbb2f4/work/41102520ca344a0d9095071c5cfbb2f4_id_rsa 2025-07-13 10:30:35.095300 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/41102520ca344a0d9095071c5cfbb2f4/work/41102520ca344a0d9095071c5cfbb2f4_id_rsa.pub 2025-07-13 10:30:35.095328 | debian-bookworm -> localhost | The key fingerprint is: 2025-07-13 10:30:35.095352 | debian-bookworm -> localhost | SHA256:g/JlCRvrEtzQuyX/9AVModMtFzy0/ZqYhTcAvxKeZDg zuul-build-sshkey 2025-07-13 10:30:35.095375 | debian-bookworm -> localhost | The key's randomart image is: 2025-07-13 10:30:35.095415 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-07-13 10:30:35.095437 | debian-bookworm -> localhost | | . .oo | 2025-07-13 10:30:35.095459 | debian-bookworm -> localhost | | . . = oo+ | 2025-07-13 10:30:35.095479 | debian-bookworm -> localhost | | . + E * * +..| 2025-07-13 10:30:35.095498 | debian-bookworm -> localhost | | . o B * * * .| 2025-07-13 10:30:35.095517 | debian-bookworm -> localhost | | + B S + = + .| 2025-07-13 10:30:35.095542 | debian-bookworm -> localhost | | = B . . * + | 2025-07-13 10:30:35.095562 | debian-bookworm -> localhost | | . + . . o + | 2025-07-13 10:30:35.095582 | debian-bookworm -> localhost | | . o . . | 2025-07-13 10:30:35.095602 | debian-bookworm -> localhost | | . . | 2025-07-13 10:30:35.095622 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-07-13 10:30:35.095707 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.679406 2025-07-13 10:30:35.102406 | 2025-07-13 10:30:35.102533 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-07-13 10:30:35.132327 | debian-bookworm | ok 2025-07-13 10:30:35.143279 | debian-bookworm | included: /var/lib/zuul/builds/41102520ca344a0d9095071c5cfbb2f4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-07-13 10:30:35.153482 | 2025-07-13 10:30:35.153610 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-07-13 10:30:35.178103 | debian-bookworm | skipping: Conditional result was False 2025-07-13 10:30:35.184705 | 2025-07-13 10:30:35.184845 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-07-13 10:30:35.851016 | debian-bookworm | changed 2025-07-13 10:30:35.862624 | 2025-07-13 10:30:35.862946 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-07-13 10:30:36.154695 | debian-bookworm | ok 2025-07-13 10:30:36.162819 | 2025-07-13 10:30:36.162996 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-07-13 10:30:36.874939 | debian-bookworm | changed 2025-07-13 10:30:36.885790 | 2025-07-13 10:30:36.885932 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-07-13 10:30:37.639597 | debian-bookworm | changed 2025-07-13 10:30:37.655292 | 2025-07-13 10:30:37.655438 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-07-13 10:30:37.699847 | debian-bookworm | skipping: Conditional result was False 2025-07-13 10:30:37.707052 | 2025-07-13 10:30:37.707182 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-07-13 10:30:38.447319 | debian-bookworm -> localhost | changed 2025-07-13 10:30:38.458454 | 2025-07-13 10:30:38.458591 | TASK [add-build-sshkey : Add back temp key] 2025-07-13 10:30:38.998219 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/41102520ca344a0d9095071c5cfbb2f4/work/41102520ca344a0d9095071c5cfbb2f4_id_rsa (zuul-build-sshkey) 2025-07-13 10:30:38.998518 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018216 2025-07-13 10:30:39.009235 | 2025-07-13 10:30:39.009375 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-07-13 10:30:39.488851 | debian-bookworm | ok 2025-07-13 10:30:39.530121 | 2025-07-13 10:30:39.530279 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-07-13 10:30:39.602929 | debian-bookworm | skipping: Conditional result was False 2025-07-13 10:30:39.651062 | 2025-07-13 10:30:39.651209 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-07-13 10:30:40.350753 | debian-bookworm | ok 2025-07-13 10:30:40.386342 | 2025-07-13 10:30:40.386494 | TASK [validate-host : Define zuul_info_dir fact] 2025-07-13 10:30:40.442641 | debian-bookworm | ok 2025-07-13 10:30:40.453721 | 2025-07-13 10:30:40.453863 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-07-13 10:30:41.123944 | debian-bookworm -> localhost | ok 2025-07-13 10:30:41.131774 | 2025-07-13 10:30:41.131909 | TASK [validate-host : Collect information about the host] 2025-07-13 10:30:42.371578 | debian-bookworm | ok 2025-07-13 10:30:42.385268 | 2025-07-13 10:30:42.385413 | TASK [validate-host : Sanitize hostname] 2025-07-13 10:30:42.564724 | debian-bookworm | ok 2025-07-13 10:30:42.623009 | 2025-07-13 10:30:42.623156 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-07-13 10:30:43.415927 | debian-bookworm -> localhost | changed 2025-07-13 10:30:43.421855 | 2025-07-13 10:30:43.421977 | TASK [validate-host : Collect information about zuul worker] 2025-07-13 10:30:43.858325 | debian-bookworm | ok 2025-07-13 10:30:43.863910 | 2025-07-13 10:30:43.864031 | TASK [validate-host : Write out all zuul information for each host] 2025-07-13 10:30:44.664314 | debian-bookworm -> localhost | changed 2025-07-13 10:30:44.685729 | 2025-07-13 10:30:44.685860 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-07-13 10:30:45.013795 | debian-bookworm | ok 2025-07-13 10:30:45.019811 | 2025-07-13 10:30:45.019939 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-07-13 10:30:46.460769 | debian-bookworm | changed: 2025-07-13 10:30:46.461049 | debian-bookworm | cd+++++++++ src/ 2025-07-13 10:30:46.461088 | debian-bookworm | cd+++++++++ src/github.com/ 2025-07-13 10:30:46.461113 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-07-13 10:30:46.461135 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-07-13 10:30:46.461164 | debian-bookworm | Containerfile 2025-07-13 10:30:46.461278 | debian-bookworm | localhost | ok: Runtime: 0:00:00.004045 2025-07-13 10:31:12.792945 | 2025-07-13 10:31:12.793061 | TASK [upload-logs : Upload logs to log server] 2025-07-13 10:31:13.367519 | localhost | Output suppressed because no_log was given 2025-07-13 10:31:13.369412 | 2025-07-13 10:31:13.369518 | LOOP [upload-logs : Compress console log and json output] 2025-07-13 10:31:13.428243 | localhost | skipping: Conditional result was False 2025-07-13 10:31:13.433290 | localhost | skipping: Conditional result was False 2025-07-13 10:31:13.441207 | 2025-07-13 10:31:13.441441 | LOOP [upload-logs : Upload compressed console log and json output] 2025-07-13 10:31:13.503957 | localhost | skipping: Conditional result was False 2025-07-13 10:31:13.504541 | 2025-07-13 10:31:13.506777 | localhost | skipping: Conditional result was False 2025-07-13 10:31:13.514431 | 2025-07-13 10:31:13.514653 | LOOP [upload-logs : Upload console log and json output]