2026-01-27 19:13:24.451300 | Job console starting 2026-01-27 19:13:24.468809 | Updating git repos 2026-01-27 19:13:24.496679 | Cloning repos into workspace 2026-01-27 19:13:24.555612 | Restoring repo states 2026-01-27 19:13:24.575292 | Merging changes 2026-01-27 19:13:25.134253 | Checking out repos 2026-01-27 19:13:25.161458 | Preparing playbooks 2026-01-27 19:13:25.705194 | Running Ansible setup 2026-01-27 19:13:29.952193 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-27 19:13:30.757972 | 2026-01-27 19:13:30.758130 | PLAY [Base pre] 2026-01-27 19:13:30.791662 | 2026-01-27 19:13:30.791824 | TASK [Setup log path fact] 2026-01-27 19:13:30.834733 | debian-bookworm | ok 2026-01-27 19:13:30.860145 | 2026-01-27 19:13:30.860311 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-27 19:13:30.915849 | debian-bookworm | ok 2026-01-27 19:13:30.938144 | 2026-01-27 19:13:30.938348 | TASK [emit-job-header : Print job information] 2026-01-27 19:13:31.041769 | # Job Information 2026-01-27 19:13:31.042042 | Ansible Version: 2.16.14 2026-01-27 19:13:31.042086 | Job: python-black 2026-01-27 19:13:31.042119 | Pipeline: check 2026-01-27 19:13:31.042142 | Executor: 521e9411259a 2026-01-27 19:13:31.042163 | Triggered by: https://github.com/osism/python-osism/pull/1969 2026-01-27 19:13:31.042186 | Event ID: 20696af0-fbb4-11f0-84a4-a47a7cdba30f 2026-01-27 19:13:31.047944 | 2026-01-27 19:13:31.048080 | LOOP [emit-job-header : Print node information] 2026-01-27 19:13:31.271736 | debian-bookworm | ok: 2026-01-27 19:13:31.271970 | debian-bookworm | # Node Information 2026-01-27 19:13:31.272009 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-27 19:13:31.272034 | debian-bookworm | Hostname: debian 2026-01-27 19:13:31.272055 | debian-bookworm | Username: zuul 2026-01-27 19:13:31.272076 | debian-bookworm | Distro: Debian 12.13 2026-01-27 19:13:31.272099 | debian-bookworm | Provider: regiocloud-a 2026-01-27 19:13:31.272120 | debian-bookworm | Region: 2026-01-27 19:13:31.272141 | debian-bookworm | Label: debian-bookworm 2026-01-27 19:13:31.272160 | debian-bookworm | Product Name: OpenStack Nova 2026-01-27 19:13:31.272180 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fefb:ab0b 2026-01-27 19:13:31.285401 | 2026-01-27 19:13:31.285599 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-27 19:13:31.878777 | debian-bookworm -> localhost | changed 2026-01-27 19:13:31.887709 | 2026-01-27 19:13:31.887856 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-27 19:13:33.735991 | debian-bookworm -> localhost | changed 2026-01-27 19:13:33.748569 | 2026-01-27 19:13:33.748712 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-27 19:13:34.248682 | debian-bookworm -> localhost | ok 2026-01-27 19:13:34.255797 | 2026-01-27 19:13:34.255936 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-27 19:13:34.284788 | debian-bookworm | ok 2026-01-27 19:13:34.305370 | debian-bookworm | included: /var/lib/zuul/builds/4db55d0d4c9a480890f5439f244703bb/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-27 19:13:34.312207 | 2026-01-27 19:13:34.312328 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-27 19:13:35.523292 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-27 19:13:35.524604 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/4db55d0d4c9a480890f5439f244703bb/work/4db55d0d4c9a480890f5439f244703bb_id_rsa 2026-01-27 19:13:35.524689 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/4db55d0d4c9a480890f5439f244703bb/work/4db55d0d4c9a480890f5439f244703bb_id_rsa.pub 2026-01-27 19:13:35.524720 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-27 19:13:35.524748 | debian-bookworm -> localhost | SHA256:o9lyBt1icWb6oMnozyU2A9xiFZPyYfq6wGd474hXFdE zuul-build-sshkey 2026-01-27 19:13:35.524772 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-27 19:13:35.524810 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-27 19:13:35.524833 | debian-bookworm -> localhost | | o..o | 2026-01-27 19:13:35.524856 | debian-bookworm -> localhost | | . +o. E | 2026-01-27 19:13:35.524877 | debian-bookworm -> localhost | | =....+ | 2026-01-27 19:13:35.524898 | debian-bookworm -> localhost | | ..o...B | 2026-01-27 19:13:35.524918 | debian-bookworm -> localhost | | =.o.S . | 2026-01-27 19:13:35.524947 | debian-bookworm -> localhost | | . o =oO = | 2026-01-27 19:13:35.524969 | debian-bookworm -> localhost | | + =o% = . | 2026-01-27 19:13:35.524989 | debian-bookworm -> localhost | | Bo= O | 2026-01-27 19:13:35.525011 | debian-bookworm -> localhost | | ..++= | 2026-01-27 19:13:35.525030 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-27 19:13:35.525087 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.429653 2026-01-27 19:13:35.531822 | 2026-01-27 19:13:35.531930 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-27 19:13:35.560825 | debian-bookworm | ok 2026-01-27 19:13:35.579480 | debian-bookworm | included: /var/lib/zuul/builds/4db55d0d4c9a480890f5439f244703bb/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-27 19:13:35.600007 | 2026-01-27 19:13:35.600142 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-27 19:13:35.624141 | debian-bookworm | skipping: Conditional result was False 2026-01-27 19:13:35.630283 | 2026-01-27 19:13:35.630410 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-27 19:13:36.336976 | debian-bookworm | changed 2026-01-27 19:13:36.344184 | 2026-01-27 19:13:36.344310 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-27 19:13:36.661881 | debian-bookworm | ok 2026-01-27 19:13:36.668219 | 2026-01-27 19:13:36.668348 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-27 19:13:37.392328 | debian-bookworm | changed 2026-01-27 19:13:37.405438 | 2026-01-27 19:13:37.405646 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-27 19:13:38.164305 | debian-bookworm | changed 2026-01-27 19:13:38.169964 | 2026-01-27 19:13:38.170072 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-27 19:13:38.203505 | debian-bookworm | skipping: Conditional result was False 2026-01-27 19:13:38.210405 | 2026-01-27 19:13:38.210575 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-27 19:13:38.819676 | debian-bookworm -> localhost | changed 2026-01-27 19:13:38.838861 | 2026-01-27 19:13:38.838997 | TASK [add-build-sshkey : Add back temp key] 2026-01-27 19:13:39.243228 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/4db55d0d4c9a480890f5439f244703bb/work/4db55d0d4c9a480890f5439f244703bb_id_rsa (zuul-build-sshkey) 2026-01-27 19:13:39.243512 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012617 2026-01-27 19:13:39.253931 | 2026-01-27 19:13:39.254109 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-27 19:13:39.730125 | debian-bookworm | ok 2026-01-27 19:13:39.750411 | 2026-01-27 19:13:39.750649 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-27 19:13:39.805743 | debian-bookworm | skipping: Conditional result was False 2026-01-27 19:13:39.820522 | 2026-01-27 19:13:39.820690 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-27 19:13:40.555912 | debian-bookworm | ok 2026-01-27 19:13:40.568451 | 2026-01-27 19:13:40.568617 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-27 19:13:40.624699 | debian-bookworm | ok 2026-01-27 19:13:40.629857 | 2026-01-27 19:13:40.629959 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-27 19:13:41.007758 | debian-bookworm -> localhost | ok 2026-01-27 19:13:41.015169 | 2026-01-27 19:13:41.015287 | TASK [validate-host : Collect information about the host] 2026-01-27 19:13:42.230525 | debian-bookworm | ok 2026-01-27 19:13:42.248836 | 2026-01-27 19:13:42.248967 | TASK [validate-host : Sanitize hostname] 2026-01-27 19:13:42.360756 | debian-bookworm | ok 2026-01-27 19:13:42.407442 | 2026-01-27 19:13:42.407591 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-27 19:13:43.087919 | debian-bookworm -> localhost | changed 2026-01-27 19:13:43.094011 | 2026-01-27 19:13:43.094184 | TASK [validate-host : Collect information about zuul worker] 2026-01-27 19:13:43.568219 | debian-bookworm | ok 2026-01-27 19:13:43.573116 | 2026-01-27 19:13:43.573230 | TASK [validate-host : Write out all zuul information for each host] 2026-01-27 19:13:44.176147 | debian-bookworm -> localhost | changed 2026-01-27 19:13:44.187795 | 2026-01-27 19:13:44.187925 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-27 19:13:44.474293 | debian-bookworm | ok 2026-01-27 19:13:44.481067 | 2026-01-27 19:13:44.481175 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-27 19:13:45.692896 | debian-bookworm | changed: 2026-01-27 19:13:45.693159 | debian-bookworm | cd+++++++++ src/ 2026-01-27 19:13:45.693204 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-27 19:13:45.693235 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-27 19:13:45.693263 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-01-27 19:13:45.693288 | debian-bookworm | Containerfile 2026-01-27 19:13:45.693453 | debian-bookworm | Containerfile 2026-01-27 19:13:45.721679 | debian-bookworm | localhost | ok: Runtime: 0:00:00.005235 2026-01-27 19:14:13.485875 | 2026-01-27 19:14:13.486103 | TASK [upload-logs : Upload logs to log server] 2026-01-27 19:14:14.057028 | localhost | Output suppressed because no_log was given 2026-01-27 19:14:14.059600 | 2026-01-27 19:14:14.059736 | LOOP [upload-logs : Compress console log and json output] 2026-01-27 19:14:14.124034 | localhost | skipping: Conditional result was False 2026-01-27 19:14:14.129415 | localhost | skipping: Conditional result was False 2026-01-27 19:14:14.138673 | 2026-01-27 19:14:14.138811 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-27 19:14:14.188708 | localhost | skipping: Conditional result was False 2026-01-27 19:14:14.189399 | 2026-01-27 19:14:14.192430 | localhost | skipping: Conditional result was False 2026-01-27 19:14:14.199798 | 2026-01-27 19:14:14.199918 | LOOP [upload-logs : Upload console log and json output]