2025-10-21 16:15:37.545017 | Job console starting 2025-10-21 16:15:37.553879 | Updating git repos 2025-10-21 16:15:37.603987 | Cloning repos into workspace 2025-10-21 16:15:37.662921 | Restoring repo states 2025-10-21 16:15:37.673104 | Merging changes 2025-10-21 16:15:38.354909 | Checking out repos 2025-10-21 16:15:38.445200 | Preparing playbooks 2025-10-21 16:15:39.493634 | Running Ansible setup 2025-10-21 16:15:45.883753 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-21 16:15:46.960177 | 2025-10-21 16:15:46.960294 | PLAY [Base pre] 2025-10-21 16:15:46.997117 | 2025-10-21 16:15:46.997222 | TASK [Setup log path fact] 2025-10-21 16:15:47.045482 | debian-bookworm | ok 2025-10-21 16:15:47.067737 | 2025-10-21 16:15:47.067860 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-21 16:15:47.141550 | debian-bookworm | ok 2025-10-21 16:15:47.149591 | 2025-10-21 16:15:47.149674 | TASK [emit-job-header : Print job information] 2025-10-21 16:15:47.202632 | # Job Information 2025-10-21 16:15:47.202771 | Ansible Version: 2.16.14 2025-10-21 16:15:47.202799 | Job: python-black 2025-10-21 16:15:47.202826 | Pipeline: check 2025-10-21 16:15:47.202863 | Executor: 521e9411259a 2025-10-21 16:15:47.202880 | Triggered by: https://github.com/osism/python-osism/pull/1703 2025-10-21 16:15:47.202898 | Event ID: a28f19a0-ae96-11f0-9b63-ed0356fef284 2025-10-21 16:15:47.207595 | 2025-10-21 16:15:47.207690 | LOOP [emit-job-header : Print node information] 2025-10-21 16:15:47.340992 | debian-bookworm | ok: 2025-10-21 16:15:47.341171 | debian-bookworm | # Node Information 2025-10-21 16:15:47.341242 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-21 16:15:47.341271 | debian-bookworm | Hostname: debian 2025-10-21 16:15:47.341293 | debian-bookworm | Username: zuul 2025-10-21 16:15:47.341314 | debian-bookworm | Distro: Debian 12.12 2025-10-21 16:15:47.341390 | debian-bookworm | Provider: regiocloud-a 2025-10-21 16:15:47.341425 | debian-bookworm | Region: 2025-10-21 16:15:47.341447 | debian-bookworm | Label: debian-bookworm 2025-10-21 16:15:47.341466 | debian-bookworm | Product Name: OpenStack Nova 2025-10-21 16:15:47.341486 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe59:f121 2025-10-21 16:15:47.359719 | 2025-10-21 16:15:47.359830 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-21 16:15:48.069633 | debian-bookworm -> localhost | changed 2025-10-21 16:15:48.082049 | 2025-10-21 16:15:48.082143 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-21 16:15:49.671751 | debian-bookworm -> localhost | changed 2025-10-21 16:15:49.680245 | 2025-10-21 16:15:49.680327 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-21 16:15:50.434530 | debian-bookworm -> localhost | ok 2025-10-21 16:15:50.439498 | 2025-10-21 16:15:50.439584 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-21 16:15:50.466078 | debian-bookworm | ok 2025-10-21 16:15:50.491773 | debian-bookworm | included: /var/lib/zuul/builds/a90655f03f754e70b771d629ed621bc5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-21 16:15:50.500720 | 2025-10-21 16:15:50.500793 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-21 16:15:52.488657 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-21 16:15:52.488832 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/a90655f03f754e70b771d629ed621bc5/work/a90655f03f754e70b771d629ed621bc5_id_rsa 2025-10-21 16:15:52.488865 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/a90655f03f754e70b771d629ed621bc5/work/a90655f03f754e70b771d629ed621bc5_id_rsa.pub 2025-10-21 16:15:52.488889 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-21 16:15:52.488911 | debian-bookworm -> localhost | SHA256:PEFNStFJ4ZQSnoclG5JXYewIBliQnGfHvdZ6HyG4gkQ zuul-build-sshkey 2025-10-21 16:15:52.488932 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-21 16:15:52.488960 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-21 16:15:52.488980 | debian-bookworm -> localhost | | ..*oo.oBXX= | 2025-10-21 16:15:52.489000 | debian-bookworm -> localhost | | = E *=+%* | 2025-10-21 16:15:52.489018 | debian-bookworm -> localhost | | + o oBBo | 2025-10-21 16:15:52.489036 | debian-bookworm -> localhost | | . .=o+ . | 2025-10-21 16:15:52.489053 | debian-bookworm -> localhost | | . . .So . . | 2025-10-21 16:15:52.489077 | debian-bookworm -> localhost | | . . o.. . | 2025-10-21 16:15:52.489096 | debian-bookworm -> localhost | | . . . . | 2025-10-21 16:15:52.489115 | debian-bookworm -> localhost | | . | 2025-10-21 16:15:52.489134 | debian-bookworm -> localhost | | | 2025-10-21 16:15:52.489153 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-21 16:15:52.489201 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.262027 2025-10-21 16:15:52.494506 | 2025-10-21 16:15:52.494587 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-21 16:15:52.522702 | debian-bookworm | ok 2025-10-21 16:15:52.541445 | debian-bookworm | included: /var/lib/zuul/builds/a90655f03f754e70b771d629ed621bc5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-21 16:15:52.588827 | 2025-10-21 16:15:52.588922 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-21 16:15:52.637336 | debian-bookworm | skipping: Conditional result was False 2025-10-21 16:15:52.642249 | 2025-10-21 16:15:52.642334 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-21 16:15:53.546665 | debian-bookworm | changed 2025-10-21 16:15:53.550951 | 2025-10-21 16:15:53.551026 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-21 16:15:53.809921 | debian-bookworm | ok 2025-10-21 16:15:53.814506 | 2025-10-21 16:15:53.814577 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-21 16:15:54.511677 | debian-bookworm | changed 2025-10-21 16:15:54.518486 | 2025-10-21 16:15:54.518587 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-21 16:15:55.203350 | debian-bookworm | changed 2025-10-21 16:15:55.212436 | 2025-10-21 16:15:55.212525 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-21 16:15:55.234788 | debian-bookworm | skipping: Conditional result was False 2025-10-21 16:15:55.240182 | 2025-10-21 16:15:55.240287 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-21 16:15:55.880998 | debian-bookworm -> localhost | changed 2025-10-21 16:15:55.892295 | 2025-10-21 16:15:55.892385 | TASK [add-build-sshkey : Add back temp key] 2025-10-21 16:15:56.280852 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/a90655f03f754e70b771d629ed621bc5/work/a90655f03f754e70b771d629ed621bc5_id_rsa (zuul-build-sshkey) 2025-10-21 16:15:56.281026 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014990 2025-10-21 16:15:56.299243 | 2025-10-21 16:15:56.299334 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-21 16:15:56.648925 | debian-bookworm | ok 2025-10-21 16:15:56.652866 | 2025-10-21 16:15:56.652939 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-21 16:15:56.675521 | debian-bookworm | skipping: Conditional result was False 2025-10-21 16:15:56.683909 | 2025-10-21 16:15:56.683990 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-21 16:15:57.143558 | debian-bookworm | ok 2025-10-21 16:15:57.158137 | 2025-10-21 16:15:57.158240 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-21 16:15:57.185775 | debian-bookworm | ok 2025-10-21 16:15:57.191049 | 2025-10-21 16:15:57.191138 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-21 16:15:57.776604 | debian-bookworm -> localhost | ok 2025-10-21 16:15:57.782762 | 2025-10-21 16:15:57.790899 | TASK [validate-host : Collect information about the host] 2025-10-21 16:15:59.029642 | debian-bookworm | ok 2025-10-21 16:15:59.040500 | 2025-10-21 16:15:59.040596 | TASK [validate-host : Sanitize hostname] 2025-10-21 16:15:59.118164 | debian-bookworm | ok 2025-10-21 16:15:59.168778 | 2025-10-21 16:15:59.168865 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-21 16:15:59.849440 | debian-bookworm -> localhost | changed 2025-10-21 16:15:59.855126 | 2025-10-21 16:15:59.855242 | TASK [validate-host : Collect information about zuul worker] 2025-10-21 16:16:00.205105 | debian-bookworm | ok 2025-10-21 16:16:00.209668 | 2025-10-21 16:16:00.209765 | TASK [validate-host : Write out all zuul information for each host] 2025-10-21 16:16:00.784130 | debian-bookworm -> localhost | changed 2025-10-21 16:16:00.793668 | 2025-10-21 16:16:00.793762 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-21 16:16:01.062364 | debian-bookworm | ok 2025-10-21 16:16:01.067946 | 2025-10-21 16:16:01.068036 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-21 16:16:01.989503 | debian-bookworm | changed: 2025-10-21 16:16:01.989723 | debian-bookworm | cd+++++++++ src/ 2025-10-21 16:16:01.989780 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-21 16:16:01.989822 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-21 16:16:01.989864 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-10-21 16:16:01.989901 | debian-bookworm | Containerfile 2025-10-21 16:16:01.990128 | debian-bookworm | Containerfile 2025-10-21 16:16:02.001437 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007160 2025-10-21 16:16:28.738349 | 2025-10-21 16:16:28.738547 | TASK [upload-logs : Upload logs to log server] 2025-10-21 16:16:29.285131 | localhost | Output suppressed because no_log was given 2025-10-21 16:16:29.289496 | 2025-10-21 16:16:29.289680 | LOOP [upload-logs : Compress console log and json output] 2025-10-21 16:16:29.343648 | localhost | skipping: Conditional result was False 2025-10-21 16:16:29.348784 | localhost | skipping: Conditional result was False 2025-10-21 16:16:29.362162 | 2025-10-21 16:16:29.362391 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-21 16:16:29.407529 | localhost | skipping: Conditional result was False 2025-10-21 16:16:29.408102 | 2025-10-21 16:16:29.411679 | localhost | skipping: Conditional result was False 2025-10-21 16:16:29.425039 | 2025-10-21 16:16:29.425266 | LOOP [upload-logs : Upload console log and json output]