2025-12-11 18:10:24.616953 | Job console starting 2025-12-11 18:10:24.678597 | Updating git repos 2025-12-11 18:10:24.725043 | Cloning repos into workspace 2025-12-11 18:10:24.869152 | Restoring repo states 2025-12-11 18:10:24.903262 | Merging changes 2025-12-11 18:10:25.450483 | Checking out repos 2025-12-11 18:10:25.520087 | Preparing playbooks 2025-12-11 18:10:26.326443 | Running Ansible setup 2025-12-11 18:10:31.493644 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-11 18:10:32.447411 | 2025-12-11 18:10:32.447608 | PLAY [Base pre] 2025-12-11 18:10:32.464409 | 2025-12-11 18:10:32.464591 | TASK [Setup log path fact] 2025-12-11 18:10:32.502125 | debian-bookworm | ok 2025-12-11 18:10:32.517939 | 2025-12-11 18:10:32.518112 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-11 18:10:32.579616 | debian-bookworm | ok 2025-12-11 18:10:32.592781 | 2025-12-11 18:10:32.592979 | TASK [emit-job-header : Print job information] 2025-12-11 18:10:32.634510 | # Job Information 2025-12-11 18:10:32.634791 | Ansible Version: 2.16.14 2025-12-11 18:10:32.634829 | Job: python-black 2025-12-11 18:10:32.634899 | Pipeline: check 2025-12-11 18:10:32.634928 | Executor: 521e9411259a 2025-12-11 18:10:32.634949 | Triggered by: https://github.com/osism/testbed/pull/2815 2025-12-11 18:10:32.634972 | Event ID: a4ca4340-d6bc-11f0-87b5-d2df5f95692f 2025-12-11 18:10:32.642881 | 2025-12-11 18:10:32.643069 | LOOP [emit-job-header : Print node information] 2025-12-11 18:10:32.780912 | debian-bookworm | ok: 2025-12-11 18:10:32.781985 | debian-bookworm | # Node Information 2025-12-11 18:10:32.782071 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-11 18:10:32.782099 | debian-bookworm | Hostname: debian 2025-12-11 18:10:32.782122 | debian-bookworm | Username: zuul 2025-12-11 18:10:32.782143 | debian-bookworm | Distro: Debian 12.12 2025-12-11 18:10:32.782166 | debian-bookworm | Provider: regiocloud-a 2025-12-11 18:10:32.782188 | debian-bookworm | Region: 2025-12-11 18:10:32.782210 | debian-bookworm | Label: debian-bookworm 2025-12-11 18:10:32.782231 | debian-bookworm | Product Name: OpenStack Nova 2025-12-11 18:10:32.782250 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe2e:3c0b 2025-12-11 18:10:32.804931 | 2025-12-11 18:10:32.805097 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-11 18:10:33.336385 | debian-bookworm -> localhost | changed 2025-12-11 18:10:33.350959 | 2025-12-11 18:10:33.351120 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-11 18:10:34.765112 | debian-bookworm -> localhost | changed 2025-12-11 18:10:34.781034 | 2025-12-11 18:10:34.781236 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-11 18:10:35.176599 | debian-bookworm -> localhost | ok 2025-12-11 18:10:35.183406 | 2025-12-11 18:10:35.183559 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-11 18:10:35.213071 | debian-bookworm | ok 2025-12-11 18:10:35.246783 | debian-bookworm | included: /var/lib/zuul/builds/84fb7928f1d447e69aca25a247c0d4d2/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-11 18:10:35.253308 | 2025-12-11 18:10:35.253434 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-11 18:10:36.851148 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-11 18:10:36.851415 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/84fb7928f1d447e69aca25a247c0d4d2/work/84fb7928f1d447e69aca25a247c0d4d2_id_rsa 2025-12-11 18:10:36.851458 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/84fb7928f1d447e69aca25a247c0d4d2/work/84fb7928f1d447e69aca25a247c0d4d2_id_rsa.pub 2025-12-11 18:10:36.851485 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-11 18:10:36.851510 | debian-bookworm -> localhost | SHA256:+N4mB9ZTr9ZZakrml+QXVQQmNn7P6wPFVoXCjf399H4 zuul-build-sshkey 2025-12-11 18:10:36.851553 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-11 18:10:36.851589 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-11 18:10:36.851611 | debian-bookworm -> localhost | | .++o++| 2025-12-11 18:10:36.851632 | debian-bookworm -> localhost | | o+++ o| 2025-12-11 18:10:36.851653 | debian-bookworm -> localhost | | ..o.+| 2025-12-11 18:10:36.851673 | debian-bookworm -> localhost | | . .. *=| 2025-12-11 18:10:36.851692 | debian-bookworm -> localhost | | . S. . .o.*| 2025-12-11 18:10:36.851722 | debian-bookworm -> localhost | | .o o .o.=| 2025-12-11 18:10:36.851770 | debian-bookworm -> localhost | | ... .o=.B.| 2025-12-11 18:10:36.851791 | debian-bookworm -> localhost | | ...o+o X.E| 2025-12-11 18:10:36.851811 | debian-bookworm -> localhost | | .+..o+ oo| 2025-12-11 18:10:36.851831 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-11 18:10:36.851902 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.689061 2025-12-11 18:10:36.859358 | 2025-12-11 18:10:36.859498 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-11 18:10:36.893926 | debian-bookworm | ok 2025-12-11 18:10:36.906397 | debian-bookworm | included: /var/lib/zuul/builds/84fb7928f1d447e69aca25a247c0d4d2/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-11 18:10:36.924657 | 2025-12-11 18:10:36.924809 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-11 18:10:36.953094 | debian-bookworm | skipping: Conditional result was False 2025-12-11 18:10:36.959271 | 2025-12-11 18:10:36.959389 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-11 18:10:37.686113 | debian-bookworm | changed 2025-12-11 18:10:37.692466 | 2025-12-11 18:10:37.692605 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-11 18:10:37.966601 | debian-bookworm | ok 2025-12-11 18:10:37.979350 | 2025-12-11 18:10:37.979536 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-11 18:10:38.707280 | debian-bookworm | changed 2025-12-11 18:10:38.717205 | 2025-12-11 18:10:38.717387 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-11 18:10:39.329033 | debian-bookworm | changed 2025-12-11 18:10:39.335451 | 2025-12-11 18:10:39.335643 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-11 18:10:39.370549 | debian-bookworm | skipping: Conditional result was False 2025-12-11 18:10:39.389964 | 2025-12-11 18:10:39.390152 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-11 18:10:39.861280 | debian-bookworm -> localhost | changed 2025-12-11 18:10:39.878156 | 2025-12-11 18:10:39.878418 | TASK [add-build-sshkey : Add back temp key] 2025-12-11 18:10:40.294124 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/84fb7928f1d447e69aca25a247c0d4d2/work/84fb7928f1d447e69aca25a247c0d4d2_id_rsa (zuul-build-sshkey) 2025-12-11 18:10:40.294476 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018911 2025-12-11 18:10:40.307466 | 2025-12-11 18:10:40.307640 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-11 18:10:40.743428 | debian-bookworm | ok 2025-12-11 18:10:40.750612 | 2025-12-11 18:10:40.750758 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-11 18:10:40.775404 | debian-bookworm | skipping: Conditional result was False 2025-12-11 18:10:40.787063 | 2025-12-11 18:10:40.787196 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-11 18:10:41.239351 | debian-bookworm | ok 2025-12-11 18:10:41.256406 | 2025-12-11 18:10:41.256570 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-11 18:10:41.302467 | debian-bookworm | ok 2025-12-11 18:10:41.309002 | 2025-12-11 18:10:41.309134 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-11 18:10:41.633926 | debian-bookworm -> localhost | ok 2025-12-11 18:10:41.640922 | 2025-12-11 18:10:41.641044 | TASK [validate-host : Collect information about the host] 2025-12-11 18:10:42.766032 | debian-bookworm | ok 2025-12-11 18:10:42.777480 | 2025-12-11 18:10:42.777690 | TASK [validate-host : Sanitize hostname] 2025-12-11 18:10:42.900107 | debian-bookworm | ok 2025-12-11 18:10:42.946447 | 2025-12-11 18:10:42.946610 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-11 18:10:43.609964 | debian-bookworm -> localhost | changed 2025-12-11 18:10:43.627939 | 2025-12-11 18:10:43.628681 | TASK [validate-host : Collect information about zuul worker] 2025-12-11 18:10:44.101536 | debian-bookworm | ok 2025-12-11 18:10:44.107115 | 2025-12-11 18:10:44.107250 | TASK [validate-host : Write out all zuul information for each host] 2025-12-11 18:10:44.764693 | debian-bookworm -> localhost | changed 2025-12-11 18:10:44.779843 | 2025-12-11 18:10:44.780035 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-11 18:10:45.067691 | debian-bookworm | ok 2025-12-11 18:10:45.076133 | 2025-12-11 18:10:45.076274 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-11 18:10:46.533833 | debian-bookworm | changed: 2025-12-11 18:10:46.534058 | debian-bookworm | cd+++++++++ src/ 2025-12-11 18:10:46.534094 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-11 18:10:46.534120 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-11 18:10:46.534143 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-12-11 18:10:46.534164 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006544 2025-12-11 18:11:13.136957 | 2025-12-11 18:11:13.137082 | TASK [upload-logs : Upload logs to log server] 2025-12-11 18:11:13.715773 | localhost | Output suppressed because no_log was given 2025-12-11 18:11:13.718415 | 2025-12-11 18:11:13.718560 | LOOP [upload-logs : Compress console log and json output] 2025-12-11 18:11:13.774082 | localhost | skipping: Conditional result was False 2025-12-11 18:11:13.782558 | localhost | skipping: Conditional result was False 2025-12-11 18:11:13.787867 | 2025-12-11 18:11:13.788070 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-11 18:11:13.847826 | localhost | skipping: Conditional result was False 2025-12-11 18:11:13.848307 | 2025-12-11 18:11:13.852967 | localhost | skipping: Conditional result was False 2025-12-11 18:11:13.862827 | 2025-12-11 18:11:13.863255 | LOOP [upload-logs : Upload console log and json output]