2025-11-23 12:58:36.871889 | Job console starting 2025-11-23 12:58:36.918682 | Updating git repos 2025-11-23 12:58:37.063250 | Cloning repos into workspace 2025-11-23 12:58:37.209807 | Restoring repo states 2025-11-23 12:58:37.260945 | Merging changes 2025-11-23 12:58:37.941077 | Checking out repos 2025-11-23 12:58:38.060401 | Preparing playbooks 2025-11-23 12:58:39.296237 | Running Ansible setup 2025-11-23 12:58:44.886115 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-23 12:58:45.812913 | 2025-11-23 12:58:45.813132 | PLAY [Base pre] 2025-11-23 12:58:45.860344 | 2025-11-23 12:58:45.860518 | TASK [Setup log path fact] 2025-11-23 12:58:45.921173 | debian-bookworm | ok 2025-11-23 12:58:45.959326 | 2025-11-23 12:58:45.959510 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-23 12:58:46.020203 | debian-bookworm | ok 2025-11-23 12:58:46.042437 | 2025-11-23 12:58:46.042587 | TASK [emit-job-header : Print job information] 2025-11-23 12:58:46.123741 | # Job Information 2025-11-23 12:58:46.123943 | Ansible Version: 2.16.14 2025-11-23 12:58:46.123994 | Job: python-black 2025-11-23 12:58:46.124024 | Pipeline: check 2025-11-23 12:58:46.124047 | Executor: 521e9411259a 2025-11-23 12:58:46.124068 | Triggered by: https://github.com/osism/python-osism/pull/1843 2025-11-23 12:58:46.124090 | Event ID: 1a77d710-c86c-11f0-97f0-61f04c5ab10d 2025-11-23 12:58:46.129104 | 2025-11-23 12:58:46.129220 | LOOP [emit-job-header : Print node information] 2025-11-23 12:58:46.347174 | debian-bookworm | ok: 2025-11-23 12:58:46.347497 | debian-bookworm | # Node Information 2025-11-23 12:58:46.347538 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-23 12:58:46.347565 | debian-bookworm | Hostname: debian 2025-11-23 12:58:46.347588 | debian-bookworm | Username: zuul 2025-11-23 12:58:46.347608 | debian-bookworm | Distro: Debian 12.12 2025-11-23 12:58:46.347633 | debian-bookworm | Provider: regiocloud-a 2025-11-23 12:58:46.347654 | debian-bookworm | Region: 2025-11-23 12:58:46.347675 | debian-bookworm | Label: debian-bookworm 2025-11-23 12:58:46.347694 | debian-bookworm | Product Name: OpenStack Nova 2025-11-23 12:58:46.347713 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec9:931c 2025-11-23 12:58:46.377122 | 2025-11-23 12:58:46.377272 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-23 12:58:47.260198 | debian-bookworm -> localhost | changed 2025-11-23 12:58:47.267947 | 2025-11-23 12:58:47.268095 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-23 12:58:49.242187 | debian-bookworm -> localhost | changed 2025-11-23 12:58:49.254213 | 2025-11-23 12:58:49.254344 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-23 12:58:49.933457 | debian-bookworm -> localhost | ok 2025-11-23 12:58:49.938423 | 2025-11-23 12:58:49.938512 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-23 12:58:49.975197 | debian-bookworm | ok 2025-11-23 12:58:49.996287 | debian-bookworm | included: /var/lib/zuul/builds/170b010ae6074d8eb96b748e1fbfca31/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-23 12:58:50.009295 | 2025-11-23 12:58:50.009392 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-23 12:58:51.363325 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-23 12:58:51.363519 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/170b010ae6074d8eb96b748e1fbfca31/work/170b010ae6074d8eb96b748e1fbfca31_id_rsa 2025-11-23 12:58:51.363557 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/170b010ae6074d8eb96b748e1fbfca31/work/170b010ae6074d8eb96b748e1fbfca31_id_rsa.pub 2025-11-23 12:58:51.363585 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-23 12:58:51.363607 | debian-bookworm -> localhost | SHA256:6rRaBDK7jH0Qix+7sa99QhKEac3fgNtyTxzaFlZG7pA zuul-build-sshkey 2025-11-23 12:58:51.363629 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-23 12:58:51.363659 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-23 12:58:51.363682 | debian-bookworm -> localhost | | oo . o+ | 2025-11-23 12:58:51.363705 | debian-bookworm -> localhost | |o..+ . ++ | 2025-11-23 12:58:51.363725 | debian-bookworm -> localhost | |..+ = BEo. | 2025-11-23 12:58:51.363745 | debian-bookworm -> localhost | | ..O * *o | 2025-11-23 12:58:51.363765 | debian-bookworm -> localhost | |. =.o = S. | 2025-11-23 12:58:51.363790 | debian-bookworm -> localhost | | =.=.. o | 2025-11-23 12:58:51.363810 | debian-bookworm -> localhost | |. Bo. + | 2025-11-23 12:58:51.363829 | debian-bookworm -> localhost | | *.+.. | 2025-11-23 12:58:51.363850 | debian-bookworm -> localhost | | +o++o | 2025-11-23 12:58:51.363870 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-23 12:58:51.363919 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.646186 2025-11-23 12:58:51.370008 | 2025-11-23 12:58:51.370112 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-23 12:58:51.407983 | debian-bookworm | ok 2025-11-23 12:58:51.417046 | debian-bookworm | included: /var/lib/zuul/builds/170b010ae6074d8eb96b748e1fbfca31/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-23 12:58:51.436375 | 2025-11-23 12:58:51.436485 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-23 12:58:51.489875 | debian-bookworm | skipping: Conditional result was False 2025-11-23 12:58:51.495911 | 2025-11-23 12:58:51.496017 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-23 12:58:52.365757 | debian-bookworm | changed 2025-11-23 12:58:52.370938 | 2025-11-23 12:58:52.371035 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-23 12:58:52.650094 | debian-bookworm | ok 2025-11-23 12:58:52.661856 | 2025-11-23 12:58:52.661979 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-23 12:58:53.390507 | debian-bookworm | changed 2025-11-23 12:58:53.399634 | 2025-11-23 12:58:53.399751 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-23 12:58:54.049308 | debian-bookworm | changed 2025-11-23 12:58:54.054513 | 2025-11-23 12:58:54.054603 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-23 12:58:54.082466 | debian-bookworm | skipping: Conditional result was False 2025-11-23 12:58:54.088698 | 2025-11-23 12:58:54.088812 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-23 12:58:54.598819 | debian-bookworm -> localhost | changed 2025-11-23 12:58:54.616215 | 2025-11-23 12:58:54.616364 | TASK [add-build-sshkey : Add back temp key] 2025-11-23 12:58:55.009692 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/170b010ae6074d8eb96b748e1fbfca31/work/170b010ae6074d8eb96b748e1fbfca31_id_rsa (zuul-build-sshkey) 2025-11-23 12:58:55.009998 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018086 2025-11-23 12:58:55.019748 | 2025-11-23 12:58:55.019885 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-23 12:58:55.504943 | debian-bookworm | ok 2025-11-23 12:58:55.511310 | 2025-11-23 12:58:55.511431 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-23 12:58:55.546008 | debian-bookworm | skipping: Conditional result was False 2025-11-23 12:58:55.558405 | 2025-11-23 12:58:55.558531 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-23 12:58:56.002818 | debian-bookworm | ok 2025-11-23 12:58:56.026912 | 2025-11-23 12:58:56.027135 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-23 12:58:56.086679 | debian-bookworm | ok 2025-11-23 12:58:56.092103 | 2025-11-23 12:58:56.092227 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-23 12:58:56.527310 | debian-bookworm -> localhost | ok 2025-11-23 12:58:56.534212 | 2025-11-23 12:58:56.534335 | TASK [validate-host : Collect information about the host] 2025-11-23 12:58:59.114338 | debian-bookworm | ok 2025-11-23 12:58:59.128027 | 2025-11-23 12:58:59.128175 | TASK [validate-host : Sanitize hostname] 2025-11-23 12:58:59.277664 | debian-bookworm | ok 2025-11-23 12:58:59.377914 | 2025-11-23 12:58:59.378180 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-23 12:59:00.248732 | debian-bookworm -> localhost | changed 2025-11-23 12:59:00.255242 | 2025-11-23 12:59:00.255374 | TASK [validate-host : Collect information about zuul worker] 2025-11-23 12:59:00.770621 | debian-bookworm | ok 2025-11-23 12:59:00.775971 | 2025-11-23 12:59:00.776101 | TASK [validate-host : Write out all zuul information for each host] 2025-11-23 12:59:01.724507 | debian-bookworm -> localhost | changed 2025-11-23 12:59:01.735848 | 2025-11-23 12:59:01.736002 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-23 12:59:02.059256 | debian-bookworm | ok 2025-11-23 12:59:02.065518 | 2025-11-23 12:59:02.065638 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-23 12:59:03.433479 | debian-bookworm | changed: 2025-11-23 12:59:03.433710 | debian-bookworm | cd+++++++++ src/ 2025-11-23 12:59:03.433747 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-23 12:59:03.433772 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-23 12:59:03.433794 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-11-23 12:59:03.433815 | debian-bookworm | Containerfile 2025-11-23 12:59:03.433926 | debian-bookworm | Containerfile 2025-11-23 12:59:03.460936 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007634 2025-11-23 12:59:32.568705 | 2025-11-23 12:59:32.568824 | TASK [upload-logs : Upload logs to log server] 2025-11-23 12:59:33.155862 | localhost | Output suppressed because no_log was given 2025-11-23 12:59:33.158352 | 2025-11-23 12:59:33.158479 | LOOP [upload-logs : Compress console log and json output] 2025-11-23 12:59:33.220527 | localhost | skipping: Conditional result was False 2025-11-23 12:59:33.226754 | localhost | skipping: Conditional result was False 2025-11-23 12:59:33.248599 | 2025-11-23 12:59:33.248797 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-23 12:59:33.307339 | localhost | skipping: Conditional result was False 2025-11-23 12:59:33.307652 | 2025-11-23 12:59:33.313175 | localhost | skipping: Conditional result was False 2025-11-23 12:59:33.317940 | 2025-11-23 12:59:33.318112 | LOOP [upload-logs : Upload console log and json output]