2025-11-19 22:07:48.176431 | Job console starting 2025-11-19 22:07:48.187897 | Updating git repos 2025-11-19 22:07:48.222395 | Cloning repos into workspace 2025-11-19 22:07:48.299335 | Restoring repo states 2025-11-19 22:07:48.307840 | Merging changes 2025-11-19 22:07:48.973172 | Checking out repos 2025-11-19 22:07:49.048523 | Preparing playbooks 2025-11-19 22:07:49.783746 | Running Ansible setup 2025-11-19 22:07:54.207301 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-19 22:07:55.157411 | 2025-11-19 22:07:55.157593 | PLAY [Base pre] 2025-11-19 22:07:55.174180 | 2025-11-19 22:07:55.174346 | TASK [Setup log path fact] 2025-11-19 22:07:55.204362 | debian-bookworm | ok 2025-11-19 22:07:55.220550 | 2025-11-19 22:07:55.220739 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-19 22:07:55.250974 | debian-bookworm | ok 2025-11-19 22:07:55.261345 | 2025-11-19 22:07:55.261528 | TASK [emit-job-header : Print job information] 2025-11-19 22:07:55.301788 | # Job Information 2025-11-19 22:07:55.301984 | Ansible Version: 2.16.14 2025-11-19 22:07:55.302018 | Job: python-black 2025-11-19 22:07:55.302052 | Pipeline: check 2025-11-19 22:07:55.302075 | Executor: 521e9411259a 2025-11-19 22:07:55.302096 | Triggered by: https://github.com/osism/testbed/pull/2786 2025-11-19 22:07:55.302118 | Event ID: 28b11150-c594-11f0-8bc4-31002c649c25 2025-11-19 22:07:55.307146 | 2025-11-19 22:07:55.307268 | LOOP [emit-job-header : Print node information] 2025-11-19 22:07:55.417344 | debian-bookworm | ok: 2025-11-19 22:07:55.417625 | debian-bookworm | # Node Information 2025-11-19 22:07:55.417660 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-19 22:07:55.417685 | debian-bookworm | Hostname: debian 2025-11-19 22:07:55.417706 | debian-bookworm | Username: zuul 2025-11-19 22:07:55.417726 | debian-bookworm | Distro: Debian 12.12 2025-11-19 22:07:55.417748 | debian-bookworm | Provider: regiocloud-a 2025-11-19 22:07:55.417768 | debian-bookworm | Region: 2025-11-19 22:07:55.417789 | debian-bookworm | Label: debian-bookworm 2025-11-19 22:07:55.417809 | debian-bookworm | Product Name: OpenStack Nova 2025-11-19 22:07:55.417828 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fed3:fa04 2025-11-19 22:07:55.439423 | 2025-11-19 22:07:55.439569 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-19 22:07:56.014228 | debian-bookworm -> localhost | changed 2025-11-19 22:07:56.022129 | 2025-11-19 22:07:56.022283 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-19 22:07:57.254018 | debian-bookworm -> localhost | changed 2025-11-19 22:07:57.274617 | 2025-11-19 22:07:57.274809 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-19 22:07:57.594438 | debian-bookworm -> localhost | ok 2025-11-19 22:07:57.601153 | 2025-11-19 22:07:57.601298 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-19 22:07:57.631949 | debian-bookworm | ok 2025-11-19 22:07:57.651696 | debian-bookworm | included: /var/lib/zuul/builds/004a78efc5a441e1b6fa6673002c8ed8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-19 22:07:57.660522 | 2025-11-19 22:07:57.660666 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-19 22:07:58.937484 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-19 22:07:58.937806 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/004a78efc5a441e1b6fa6673002c8ed8/work/004a78efc5a441e1b6fa6673002c8ed8_id_rsa 2025-11-19 22:07:58.937848 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/004a78efc5a441e1b6fa6673002c8ed8/work/004a78efc5a441e1b6fa6673002c8ed8_id_rsa.pub 2025-11-19 22:07:58.937874 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-19 22:07:58.937898 | debian-bookworm -> localhost | SHA256:CNn/bLUgf8k+ufozcovVv2JpLdAGeuWS0e0mn+5yd+I zuul-build-sshkey 2025-11-19 22:07:58.937920 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-19 22:07:58.937953 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-19 22:07:58.937976 | debian-bookworm -> localhost | | | 2025-11-19 22:07:58.937997 | debian-bookworm -> localhost | | o | 2025-11-19 22:07:58.938018 | debian-bookworm -> localhost | | o . . . | 2025-11-19 22:07:58.938037 | debian-bookworm -> localhost | | . o o o . | 2025-11-19 22:07:58.938056 | debian-bookworm -> localhost | | . S o O . | 2025-11-19 22:07:58.938079 | debian-bookworm -> localhost | | * O O o | 2025-11-19 22:07:58.938099 | debian-bookworm -> localhost | | * X.B .| 2025-11-19 22:07:58.938118 | debian-bookworm -> localhost | | ..=*B.*o| 2025-11-19 22:07:58.938138 | debian-bookworm -> localhost | | o=BBE==| 2025-11-19 22:07:58.938158 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-19 22:07:58.938212 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.744564 2025-11-19 22:07:58.944880 | 2025-11-19 22:07:58.944995 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-19 22:07:58.973322 | debian-bookworm | ok 2025-11-19 22:07:58.982800 | debian-bookworm | included: /var/lib/zuul/builds/004a78efc5a441e1b6fa6673002c8ed8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-19 22:07:58.991945 | 2025-11-19 22:07:58.992051 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-19 22:07:59.006134 | debian-bookworm | skipping: Conditional result was False 2025-11-19 22:07:59.013044 | 2025-11-19 22:07:59.013174 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-19 22:07:59.649350 | debian-bookworm | changed 2025-11-19 22:07:59.655072 | 2025-11-19 22:07:59.655189 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-19 22:07:59.903101 | debian-bookworm | ok 2025-11-19 22:07:59.911970 | 2025-11-19 22:07:59.912137 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-19 22:08:00.603348 | debian-bookworm | changed 2025-11-19 22:08:00.612038 | 2025-11-19 22:08:00.612174 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-19 22:08:01.254817 | debian-bookworm | changed 2025-11-19 22:08:01.262193 | 2025-11-19 22:08:01.262328 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-19 22:08:01.288661 | debian-bookworm | skipping: Conditional result was False 2025-11-19 22:08:01.301570 | 2025-11-19 22:08:01.301723 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-19 22:08:01.796711 | debian-bookworm -> localhost | changed 2025-11-19 22:08:01.808631 | 2025-11-19 22:08:01.808769 | TASK [add-build-sshkey : Add back temp key] 2025-11-19 22:08:02.140336 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/004a78efc5a441e1b6fa6673002c8ed8/work/004a78efc5a441e1b6fa6673002c8ed8_id_rsa (zuul-build-sshkey) 2025-11-19 22:08:02.140674 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014416 2025-11-19 22:08:02.149456 | 2025-11-19 22:08:02.149707 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-19 22:08:02.560336 | debian-bookworm | ok 2025-11-19 22:08:02.568866 | 2025-11-19 22:08:02.569030 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-19 22:08:02.596768 | debian-bookworm | skipping: Conditional result was False 2025-11-19 22:08:02.621680 | 2025-11-19 22:08:02.621878 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-19 22:08:03.072861 | debian-bookworm | ok 2025-11-19 22:08:03.090890 | 2025-11-19 22:08:03.091085 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-19 22:08:03.143676 | debian-bookworm | ok 2025-11-19 22:08:03.151808 | 2025-11-19 22:08:03.151950 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-19 22:08:03.484323 | debian-bookworm -> localhost | ok 2025-11-19 22:08:03.494057 | 2025-11-19 22:08:03.494189 | TASK [validate-host : Collect information about the host] 2025-11-19 22:08:04.621882 | debian-bookworm | ok 2025-11-19 22:08:04.633916 | 2025-11-19 22:08:04.634054 | TASK [validate-host : Sanitize hostname] 2025-11-19 22:08:04.755225 | debian-bookworm | ok 2025-11-19 22:08:04.796790 | 2025-11-19 22:08:04.796933 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-19 22:08:05.442865 | debian-bookworm -> localhost | changed 2025-11-19 22:08:05.448869 | 2025-11-19 22:08:05.448991 | TASK [validate-host : Collect information about zuul worker] 2025-11-19 22:08:05.865586 | debian-bookworm | ok 2025-11-19 22:08:05.873492 | 2025-11-19 22:08:05.873637 | TASK [validate-host : Write out all zuul information for each host] 2025-11-19 22:08:06.419311 | debian-bookworm -> localhost | changed 2025-11-19 22:08:06.429148 | 2025-11-19 22:08:06.429272 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-19 22:08:06.704750 | debian-bookworm | ok 2025-11-19 22:08:06.712173 | 2025-11-19 22:08:06.712353 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-19 22:08:07.781302 | debian-bookworm | changed: 2025-11-19 22:08:07.781536 | debian-bookworm | cd+++++++++ src/ 2025-11-19 22:08:07.781573 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-19 22:08:07.781597 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-19 22:08:07.781618 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-11-19 22:08:07.781639 | debian-bookworm | localhost | ok: Runtime: 0:00:00.005452 2025-11-19 22:08:32.588155 | 2025-11-19 22:08:32.588311 | TASK [upload-logs : Upload logs to log server] 2025-11-19 22:08:33.189242 | localhost | Output suppressed because no_log was given 2025-11-19 22:08:33.196951 | 2025-11-19 22:08:33.197117 | LOOP [upload-logs : Compress console log and json output] 2025-11-19 22:08:33.263450 | localhost | skipping: Conditional result was False 2025-11-19 22:08:33.270073 | localhost | skipping: Conditional result was False 2025-11-19 22:08:33.279590 | 2025-11-19 22:08:33.279708 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-19 22:08:33.330666 | localhost | skipping: Conditional result was False 2025-11-19 22:08:33.331094 | 2025-11-19 22:08:33.334661 | localhost | skipping: Conditional result was False 2025-11-19 22:08:33.339302 | 2025-11-19 22:08:33.339475 | LOOP [upload-logs : Upload console log and json output]