2025-06-04 18:32:26.787143 | Job console starting 2025-06-04 18:32:26.799727 | Updating git repos 2025-06-04 18:32:26.837082 | Cloning repos into workspace 2025-06-04 18:32:26.870123 | Restoring repo states 2025-06-04 18:32:26.882214 | Merging changes 2025-06-04 18:32:27.389782 | Checking out repos 2025-06-04 18:32:27.418725 | Preparing playbooks 2025-06-04 18:32:28.002279 | Running Ansible setup 2025-06-04 18:32:32.585468 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-04 18:32:33.353923 | 2025-06-04 18:32:33.354086 | PLAY [Base pre] 2025-06-04 18:32:33.371456 | 2025-06-04 18:32:33.371615 | TASK [Setup log path fact] 2025-06-04 18:32:33.431060 | debian-bookworm | ok 2025-06-04 18:32:33.460016 | 2025-06-04 18:32:33.460447 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-04 18:32:33.506152 | debian-bookworm | ok 2025-06-04 18:32:33.515864 | 2025-06-04 18:32:33.515973 | TASK [emit-job-header : Print job information] 2025-06-04 18:32:33.557886 | # Job Information 2025-06-04 18:32:33.558188 | Ansible Version: 2.16.14 2025-06-04 18:32:33.558235 | Job: python-black 2025-06-04 18:32:33.558367 | Pipeline: check 2025-06-04 18:32:33.558397 | Executor: 521e9411259a 2025-06-04 18:32:33.558418 | Triggered by: https://github.com/osism/python-osism/pull/1390 2025-06-04 18:32:33.558441 | Event ID: 28f77ab0-4172-11f0-857b-fdb22e976d36 2025-06-04 18:32:33.566219 | 2025-06-04 18:32:33.566369 | LOOP [emit-job-header : Print node information] 2025-06-04 18:32:33.681412 | debian-bookworm | ok: 2025-06-04 18:32:33.681676 | debian-bookworm | # Node Information 2025-06-04 18:32:33.681724 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-04 18:32:33.681753 | debian-bookworm | Hostname: debian 2025-06-04 18:32:33.681779 | debian-bookworm | Username: zuul 2025-06-04 18:32:33.681804 | debian-bookworm | Distro: Debian 12.11 2025-06-04 18:32:33.681832 | debian-bookworm | Provider: regiocloud-a 2025-06-04 18:32:33.681857 | debian-bookworm | Region: 2025-06-04 18:32:33.681882 | debian-bookworm | Label: debian-bookworm 2025-06-04 18:32:33.681905 | debian-bookworm | Product Name: OpenStack Nova 2025-06-04 18:32:33.681928 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe29:695f 2025-06-04 18:32:33.695722 | 2025-06-04 18:32:33.695869 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-04 18:32:34.201588 | debian-bookworm -> localhost | changed 2025-06-04 18:32:34.220338 | 2025-06-04 18:32:34.221056 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-04 18:32:35.801286 | debian-bookworm -> localhost | changed 2025-06-04 18:32:35.829080 | 2025-06-04 18:32:35.829462 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-04 18:32:36.311143 | debian-bookworm -> localhost | ok 2025-06-04 18:32:36.320054 | 2025-06-04 18:32:36.320205 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-04 18:32:36.375387 | debian-bookworm | ok 2025-06-04 18:32:36.410898 | debian-bookworm | included: /var/lib/zuul/builds/191babd5d4494d0e911c7d449f38d9d0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-04 18:32:36.421590 | 2025-06-04 18:32:36.421736 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-04 18:32:38.292207 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-04 18:32:38.292440 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/191babd5d4494d0e911c7d449f38d9d0/work/191babd5d4494d0e911c7d449f38d9d0_id_rsa 2025-06-04 18:32:38.292479 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/191babd5d4494d0e911c7d449f38d9d0/work/191babd5d4494d0e911c7d449f38d9d0_id_rsa.pub 2025-06-04 18:32:38.292505 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-04 18:32:38.292530 | debian-bookworm -> localhost | SHA256:T2cj4nyWsoNgDoO3Dt7hh0y/l1425lcVTvwU5nL2vdc zuul-build-sshkey 2025-06-04 18:32:38.292578 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-04 18:32:38.292618 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-04 18:32:38.292641 | debian-bookworm -> localhost | | .o.| 2025-06-04 18:32:38.292663 | debian-bookworm -> localhost | | o+.| 2025-06-04 18:32:38.292684 | debian-bookworm -> localhost | | .o=o| 2025-06-04 18:32:38.292704 | debian-bookworm -> localhost | | +o+| 2025-06-04 18:32:38.292723 | debian-bookworm -> localhost | | . S o + . o| 2025-06-04 18:32:38.292752 | debian-bookworm -> localhost | |. +.o o + = o o| 2025-06-04 18:32:38.292774 | debian-bookworm -> localhost | |..oBo. .=== . .E| 2025-06-04 18:32:38.292795 | debian-bookworm -> localhost | |..+ooo.o*=.. .| 2025-06-04 18:32:38.292815 | debian-bookworm -> localhost | | o.o..+..o. | 2025-06-04 18:32:38.292836 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-04 18:32:38.292893 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.210426 2025-06-04 18:32:38.300352 | 2025-06-04 18:32:38.300468 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-04 18:32:38.339316 | debian-bookworm | ok 2025-06-04 18:32:38.351349 | debian-bookworm | included: /var/lib/zuul/builds/191babd5d4494d0e911c7d449f38d9d0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-04 18:32:38.361680 | 2025-06-04 18:32:38.361794 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-04 18:32:38.386368 | debian-bookworm | skipping: Conditional result was False 2025-06-04 18:32:38.392808 | 2025-06-04 18:32:38.392933 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-04 18:32:39.047650 | debian-bookworm | changed 2025-06-04 18:32:39.054586 | 2025-06-04 18:32:39.054710 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-04 18:32:39.343262 | debian-bookworm | ok 2025-06-04 18:32:39.352140 | 2025-06-04 18:32:39.352298 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-04 18:32:40.005644 | debian-bookworm | changed 2025-06-04 18:32:40.019374 | 2025-06-04 18:32:40.019516 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-04 18:32:40.680845 | debian-bookworm | changed 2025-06-04 18:32:40.689933 | 2025-06-04 18:32:40.690087 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-04 18:32:40.716711 | debian-bookworm | skipping: Conditional result was False 2025-06-04 18:32:40.726929 | 2025-06-04 18:32:40.727063 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-04 18:32:41.228245 | debian-bookworm -> localhost | changed 2025-06-04 18:32:41.246428 | 2025-06-04 18:32:41.246624 | TASK [add-build-sshkey : Add back temp key] 2025-06-04 18:32:41.647838 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/191babd5d4494d0e911c7d449f38d9d0/work/191babd5d4494d0e911c7d449f38d9d0_id_rsa (zuul-build-sshkey) 2025-06-04 18:32:41.648084 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.020757 2025-06-04 18:32:41.656634 | 2025-06-04 18:32:41.656748 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-04 18:32:42.062996 | debian-bookworm | ok 2025-06-04 18:32:42.068519 | 2025-06-04 18:32:42.068659 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-04 18:32:42.094853 | debian-bookworm | skipping: Conditional result was False 2025-06-04 18:32:42.105768 | 2025-06-04 18:32:42.105907 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-04 18:32:42.534602 | debian-bookworm | ok 2025-06-04 18:32:42.548555 | 2025-06-04 18:32:42.548695 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-04 18:32:42.577631 | debian-bookworm | ok 2025-06-04 18:32:42.582985 | 2025-06-04 18:32:42.583096 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-04 18:32:42.906760 | debian-bookworm -> localhost | ok 2025-06-04 18:32:42.914098 | 2025-06-04 18:32:42.914222 | TASK [validate-host : Collect information about the host] 2025-06-04 18:32:43.976096 | debian-bookworm | ok 2025-06-04 18:32:43.987303 | 2025-06-04 18:32:43.987418 | TASK [validate-host : Sanitize hostname] 2025-06-04 18:32:44.128501 | debian-bookworm | ok 2025-06-04 18:32:44.175423 | 2025-06-04 18:32:44.175604 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-04 18:32:44.752144 | debian-bookworm -> localhost | changed 2025-06-04 18:32:44.758070 | 2025-06-04 18:32:44.758177 | TASK [validate-host : Collect information about zuul worker] 2025-06-04 18:32:45.156335 | debian-bookworm | ok 2025-06-04 18:32:45.161605 | 2025-06-04 18:32:45.161717 | TASK [validate-host : Write out all zuul information for each host] 2025-06-04 18:32:45.717506 | debian-bookworm -> localhost | changed 2025-06-04 18:32:45.727514 | 2025-06-04 18:32:45.727666 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-04 18:32:45.983366 | debian-bookworm | ok 2025-06-04 18:32:45.989331 | 2025-06-04 18:32:45.989444 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-04 18:32:46.933144 | debian-bookworm | changed: 2025-06-04 18:32:46.933370 | debian-bookworm | cd+++++++++ src/ 2025-06-04 18:32:46.933412 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-04 18:32:46.933440 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-04 18:32:46.933466 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-06-04 18:32:46.933491 | debian-bookworm | Containerfile 2025-06-04 18:32:46.933680 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007324 2025-06-04 18:33:12.952067 | 2025-06-04 18:33:12.952252 | TASK [upload-logs : Upload logs to log server] 2025-06-04 18:33:13.500064 | localhost | Output suppressed because no_log was given 2025-06-04 18:33:13.503813 | 2025-06-04 18:33:13.503991 | LOOP [upload-logs : Compress console log and json output] 2025-06-04 18:33:13.557771 | localhost | skipping: Conditional result was False 2025-06-04 18:33:13.562763 | localhost | skipping: Conditional result was False 2025-06-04 18:33:13.575675 | 2025-06-04 18:33:13.575930 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-04 18:33:13.623015 | localhost | skipping: Conditional result was False 2025-06-04 18:33:13.623699 | 2025-06-04 18:33:13.628678 | localhost | skipping: Conditional result was False 2025-06-04 18:33:13.639919 | 2025-06-04 18:33:13.640165 | LOOP [upload-logs : Upload console log and json output]