2025-12-10 14:41:32.721345 | Job console starting 2025-12-10 14:41:32.749014 | Updating git repos 2025-12-10 14:41:32.777623 | Cloning repos into workspace 2025-12-10 14:41:32.826539 | Restoring repo states 2025-12-10 14:41:32.832224 | Merging changes 2025-12-10 14:41:33.407458 | Checking out repos 2025-12-10 14:41:33.464984 | Preparing playbooks 2025-12-10 14:41:34.385958 | Running Ansible setup 2025-12-10 14:41:39.583108 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-10 14:41:40.791945 | 2025-12-10 14:41:40.792130 | PLAY [Base pre] 2025-12-10 14:41:40.818265 | 2025-12-10 14:41:40.818433 | TASK [Setup log path fact] 2025-12-10 14:41:40.838339 | debian-bookworm | ok 2025-12-10 14:41:40.854802 | 2025-12-10 14:41:40.854995 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-10 14:41:40.885652 | debian-bookworm | ok 2025-12-10 14:41:40.903613 | 2025-12-10 14:41:40.903758 | TASK [emit-job-header : Print job information] 2025-12-10 14:41:40.990075 | # Job Information 2025-12-10 14:41:40.990276 | Ansible Version: 2.16.14 2025-12-10 14:41:40.990312 | Job: python-black 2025-12-10 14:41:40.990345 | Pipeline: check 2025-12-10 14:41:40.990367 | Executor: 521e9411259a 2025-12-10 14:41:40.990387 | Triggered by: https://github.com/osism/testbed/pull/2798 2025-12-10 14:41:40.990410 | Event ID: 4c5a9d90-d5d6-11f0-92dc-f3de0a1a54f8 2025-12-10 14:41:41.011877 | 2025-12-10 14:41:41.012059 | LOOP [emit-job-header : Print node information] 2025-12-10 14:41:41.185260 | debian-bookworm | ok: 2025-12-10 14:41:41.185467 | debian-bookworm | # Node Information 2025-12-10 14:41:41.185501 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-10 14:41:41.185549 | debian-bookworm | Hostname: debian 2025-12-10 14:41:41.185573 | debian-bookworm | Username: zuul 2025-12-10 14:41:41.185593 | debian-bookworm | Distro: Debian 12.12 2025-12-10 14:41:41.185617 | debian-bookworm | Provider: regiocloud-a 2025-12-10 14:41:41.185637 | debian-bookworm | Region: 2025-12-10 14:41:41.185658 | debian-bookworm | Label: debian-bookworm 2025-12-10 14:41:41.185679 | debian-bookworm | Product Name: OpenStack Nova 2025-12-10 14:41:41.185698 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe19:6e70 2025-12-10 14:41:41.209395 | 2025-12-10 14:41:41.209580 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-10 14:41:42.083439 | debian-bookworm -> localhost | changed 2025-12-10 14:41:42.098063 | 2025-12-10 14:41:42.098213 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-10 14:41:43.620835 | debian-bookworm -> localhost | changed 2025-12-10 14:41:43.635778 | 2025-12-10 14:41:43.636000 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-10 14:41:44.096771 | debian-bookworm -> localhost | ok 2025-12-10 14:41:44.104282 | 2025-12-10 14:41:44.104440 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-10 14:41:44.159033 | debian-bookworm | ok 2025-12-10 14:41:44.194404 | debian-bookworm | included: /var/lib/zuul/builds/57b3e2ee78da49d784f0369201e9dc16/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-10 14:41:44.209821 | 2025-12-10 14:41:44.209972 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-10 14:41:46.673389 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-10 14:41:46.673670 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/57b3e2ee78da49d784f0369201e9dc16/work/57b3e2ee78da49d784f0369201e9dc16_id_rsa 2025-12-10 14:41:46.673718 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/57b3e2ee78da49d784f0369201e9dc16/work/57b3e2ee78da49d784f0369201e9dc16_id_rsa.pub 2025-12-10 14:41:46.673748 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-10 14:41:46.673774 | debian-bookworm -> localhost | SHA256:DN82EisUQDB1oYbtDwcu+o6gQHPGaeW9o8rFskFgDTw zuul-build-sshkey 2025-12-10 14:41:46.673796 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-10 14:41:46.673835 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-10 14:41:46.673860 | debian-bookworm -> localhost | |..o++.+. | 2025-12-10 14:41:46.673883 | debian-bookworm -> localhost | | Eo+ o . | 2025-12-10 14:41:46.673905 | debian-bookworm -> localhost | | oo.=.o . | 2025-12-10 14:41:46.673926 | debian-bookworm -> localhost | |. o++o.+ + | 2025-12-10 14:41:46.673947 | debian-bookworm -> localhost | | o.B+.o.S + | 2025-12-10 14:41:46.673981 | debian-bookworm -> localhost | |..*..+ ..o . | 2025-12-10 14:41:46.674003 | debian-bookworm -> localhost | |+ o o.o | 2025-12-10 14:41:46.674024 | debian-bookworm -> localhost | |+o. = . . | 2025-12-10 14:41:46.674045 | debian-bookworm -> localhost | |o.o+.. | 2025-12-10 14:41:46.674066 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-10 14:41:46.674124 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.790480 2025-12-10 14:41:46.682196 | 2025-12-10 14:41:46.682341 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-10 14:41:46.717715 | debian-bookworm | ok 2025-12-10 14:41:46.733837 | debian-bookworm | included: /var/lib/zuul/builds/57b3e2ee78da49d784f0369201e9dc16/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-10 14:41:46.744629 | 2025-12-10 14:41:46.744783 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-10 14:41:46.796044 | debian-bookworm | skipping: Conditional result was False 2025-12-10 14:41:46.809193 | 2025-12-10 14:41:46.809393 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-10 14:41:47.451719 | debian-bookworm | changed 2025-12-10 14:41:47.462409 | 2025-12-10 14:41:47.462684 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-10 14:41:47.751370 | debian-bookworm | ok 2025-12-10 14:41:47.758073 | 2025-12-10 14:41:47.758204 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-10 14:41:48.486185 | debian-bookworm | changed 2025-12-10 14:41:48.493931 | 2025-12-10 14:41:48.494068 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-10 14:41:49.173359 | debian-bookworm | changed 2025-12-10 14:41:49.190230 | 2025-12-10 14:41:49.191266 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-10 14:41:49.244505 | debian-bookworm | skipping: Conditional result was False 2025-12-10 14:41:49.265007 | 2025-12-10 14:41:49.265161 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-10 14:41:50.099688 | debian-bookworm -> localhost | changed 2025-12-10 14:41:50.111124 | 2025-12-10 14:41:50.111263 | TASK [add-build-sshkey : Add back temp key] 2025-12-10 14:41:50.513890 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/57b3e2ee78da49d784f0369201e9dc16/work/57b3e2ee78da49d784f0369201e9dc16_id_rsa (zuul-build-sshkey) 2025-12-10 14:41:50.514279 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.020421 2025-12-10 14:41:50.527905 | 2025-12-10 14:41:50.528052 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-10 14:41:50.979719 | debian-bookworm | ok 2025-12-10 14:41:50.985167 | 2025-12-10 14:41:50.985300 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-10 14:41:51.009330 | debian-bookworm | skipping: Conditional result was False 2025-12-10 14:41:51.023348 | 2025-12-10 14:41:51.023494 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-10 14:41:51.577921 | debian-bookworm | ok 2025-12-10 14:41:51.594796 | 2025-12-10 14:41:51.595464 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-10 14:41:51.635983 | debian-bookworm | ok 2025-12-10 14:41:51.642762 | 2025-12-10 14:41:51.643062 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-10 14:41:52.005963 | debian-bookworm -> localhost | ok 2025-12-10 14:41:52.012979 | 2025-12-10 14:41:52.013114 | TASK [validate-host : Collect information about the host] 2025-12-10 14:41:53.268453 | debian-bookworm | ok 2025-12-10 14:41:53.289259 | 2025-12-10 14:41:53.289402 | TASK [validate-host : Sanitize hostname] 2025-12-10 14:41:53.504855 | debian-bookworm | ok 2025-12-10 14:41:53.596646 | 2025-12-10 14:41:53.596782 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-10 14:41:54.256033 | debian-bookworm -> localhost | changed 2025-12-10 14:41:54.262175 | 2025-12-10 14:41:54.262307 | TASK [validate-host : Collect information about zuul worker] 2025-12-10 14:41:54.688619 | debian-bookworm | ok 2025-12-10 14:41:54.693703 | 2025-12-10 14:41:54.693839 | TASK [validate-host : Write out all zuul information for each host] 2025-12-10 14:41:55.611119 | debian-bookworm -> localhost | changed 2025-12-10 14:41:55.622641 | 2025-12-10 14:41:55.622779 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-10 14:41:55.932706 | debian-bookworm | ok 2025-12-10 14:41:55.938601 | 2025-12-10 14:41:55.938717 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-10 14:41:57.225170 | debian-bookworm | changed: 2025-12-10 14:41:57.225447 | debian-bookworm | cd+++++++++ src/ 2025-12-10 14:41:57.225498 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-10 14:41:57.225581 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-10 14:41:57.225616 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-12-10 14:41:57.225646 | debian-bookworm | localhost | ok: Runtime: 0:00:00.004060 2025-12-10 14:42:23.424478 | 2025-12-10 14:42:23.424670 | TASK [upload-logs : Upload logs to log server] 2025-12-10 14:42:24.111688 | localhost | Output suppressed because no_log was given 2025-12-10 14:42:24.114797 | 2025-12-10 14:42:24.114993 | LOOP [upload-logs : Compress console log and json output] 2025-12-10 14:42:24.170060 | localhost | skipping: Conditional result was False 2025-12-10 14:42:24.177136 | localhost | skipping: Conditional result was False 2025-12-10 14:42:24.195042 | 2025-12-10 14:42:24.195296 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-10 14:42:24.290353 | localhost | skipping: Conditional result was False 2025-12-10 14:42:24.290771 | 2025-12-10 14:42:24.298795 | localhost | skipping: Conditional result was False 2025-12-10 14:42:24.304745 | 2025-12-10 14:42:24.304880 | LOOP [upload-logs : Upload console log and json output]