2025-05-14 14:21:28.156550 | Job console starting 2025-05-14 14:21:28.166587 | Updating git repos 2025-05-14 14:21:28.192732 | Cloning repos into workspace 2025-05-14 14:21:28.276184 | Restoring repo states 2025-05-14 14:21:28.296845 | Merging changes 2025-05-14 14:21:28.780740 | Checking out repos 2025-05-14 14:21:28.821176 | Preparing playbooks 2025-05-14 14:21:29.492158 | Running Ansible setup 2025-05-14 14:21:33.875992 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-14 14:21:34.737706 | 2025-05-14 14:21:34.737869 | PLAY [Base pre] 2025-05-14 14:21:34.754897 | 2025-05-14 14:21:34.755039 | TASK [Setup log path fact] 2025-05-14 14:21:34.785778 | debian-bookworm | ok 2025-05-14 14:21:34.806448 | 2025-05-14 14:21:34.806679 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-14 14:21:34.856546 | debian-bookworm | ok 2025-05-14 14:21:34.877871 | 2025-05-14 14:21:34.878031 | TASK [emit-job-header : Print job information] 2025-05-14 14:21:34.921490 | # Job Information 2025-05-14 14:21:34.921739 | Ansible Version: 2.16.14 2025-05-14 14:21:34.921797 | Job: container-image-python-osism-build 2025-05-14 14:21:34.921851 | Pipeline: check 2025-05-14 14:21:34.921890 | Executor: 521e9411259a 2025-05-14 14:21:34.921924 | Triggered by: https://github.com/osism/python-osism/pull/1338 2025-05-14 14:21:34.921962 | Event ID: a1ab4e00-30ce-11f0-8379-489455d214b6 2025-05-14 14:21:34.928713 | 2025-05-14 14:21:34.928842 | LOOP [emit-job-header : Print node information] 2025-05-14 14:21:35.059436 | debian-bookworm | ok: 2025-05-14 14:21:35.059781 | debian-bookworm | # Node Information 2025-05-14 14:21:35.059864 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-05-14 14:21:35.059918 | debian-bookworm | Hostname: debian 2025-05-14 14:21:35.059957 | debian-bookworm | Username: zuul 2025-05-14 14:21:35.060043 | debian-bookworm | Distro: Debian 12.10 2025-05-14 14:21:35.060165 | debian-bookworm | Provider: regiocloud-a 2025-05-14 14:21:35.060213 | debian-bookworm | Region: 2025-05-14 14:21:35.060253 | debian-bookworm | Label: debian-bookworm 2025-05-14 14:21:35.060289 | debian-bookworm | Product Name: OpenStack Nova 2025-05-14 14:21:35.060325 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe07:5476 2025-05-14 14:21:35.088879 | 2025-05-14 14:21:35.089024 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-14 14:21:35.617501 | debian-bookworm -> localhost | changed 2025-05-14 14:21:35.625220 | 2025-05-14 14:21:35.625342 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-14 14:21:36.773226 | debian-bookworm -> localhost | changed 2025-05-14 14:21:36.790598 | 2025-05-14 14:21:36.790742 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-14 14:21:37.138956 | debian-bookworm -> localhost | ok 2025-05-14 14:21:37.154719 | 2025-05-14 14:21:37.154904 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-14 14:21:37.185071 | debian-bookworm | ok 2025-05-14 14:21:37.203269 | debian-bookworm | included: /var/lib/zuul/builds/a3358dc48d8047ba83bec8ccd79cc471/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-14 14:21:37.209440 | 2025-05-14 14:21:37.209550 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-14 14:21:38.517412 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-05-14 14:21:38.517737 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/a3358dc48d8047ba83bec8ccd79cc471/work/a3358dc48d8047ba83bec8ccd79cc471_id_rsa 2025-05-14 14:21:38.517805 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/a3358dc48d8047ba83bec8ccd79cc471/work/a3358dc48d8047ba83bec8ccd79cc471_id_rsa.pub 2025-05-14 14:21:38.517849 | debian-bookworm -> localhost | The key fingerprint is: 2025-05-14 14:21:38.517888 | debian-bookworm -> localhost | SHA256:MlGDNzZDOjG6UjB4Nymj3uVP2t1Fhmx5HTBOR9R5taA zuul-build-sshkey 2025-05-14 14:21:38.517942 | debian-bookworm -> localhost | The key's randomart image is: 2025-05-14 14:21:38.517979 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-05-14 14:21:38.518013 | debian-bookworm -> localhost | | .o .oo+ =++=| 2025-05-14 14:21:38.518048 | debian-bookworm -> localhost | |. +o+..=*. + +o+| 2025-05-14 14:21:38.518083 | debian-bookworm -> localhost | | o +o.+o +.Eo...o| 2025-05-14 14:21:38.518117 | debian-bookworm -> localhost | |. . o o = + . | 2025-05-14 14:21:38.518152 | debian-bookworm -> localhost | |. o + o S . + | 2025-05-14 14:21:38.518199 | debian-bookworm -> localhost | | . o . + . | 2025-05-14 14:21:38.518234 | debian-bookworm -> localhost | | = . . . | 2025-05-14 14:21:38.518271 | debian-bookworm -> localhost | | . o . . | 2025-05-14 14:21:38.518306 | debian-bookworm -> localhost | | | 2025-05-14 14:21:38.518339 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-05-14 14:21:38.518450 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.753268 2025-05-14 14:21:38.527999 | 2025-05-14 14:21:38.528146 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-14 14:21:38.559894 | debian-bookworm | ok 2025-05-14 14:21:38.571822 | debian-bookworm | included: /var/lib/zuul/builds/a3358dc48d8047ba83bec8ccd79cc471/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-14 14:21:38.581555 | 2025-05-14 14:21:38.581681 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-14 14:21:38.605864 | debian-bookworm | skipping: Conditional result was False 2025-05-14 14:21:38.619636 | 2025-05-14 14:21:38.619809 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-14 14:21:39.238216 | debian-bookworm | changed 2025-05-14 14:21:39.244269 | 2025-05-14 14:21:39.244422 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-14 14:21:39.542690 | debian-bookworm | ok 2025-05-14 14:21:39.552732 | 2025-05-14 14:21:39.553740 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-14 14:21:40.172097 | debian-bookworm | changed 2025-05-14 14:21:40.185316 | 2025-05-14 14:21:40.185440 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-14 14:21:40.788318 | debian-bookworm | changed 2025-05-14 14:21:40.795552 | 2025-05-14 14:21:40.795675 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-14 14:21:40.820120 | debian-bookworm | skipping: Conditional result was False 2025-05-14 14:21:40.837181 | 2025-05-14 14:21:40.837711 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-14 14:21:41.302297 | debian-bookworm -> localhost | changed 2025-05-14 14:21:41.313825 | 2025-05-14 14:21:41.313983 | TASK [add-build-sshkey : Add back temp key] 2025-05-14 14:21:41.632657 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/a3358dc48d8047ba83bec8ccd79cc471/work/a3358dc48d8047ba83bec8ccd79cc471_id_rsa (zuul-build-sshkey) 2025-05-14 14:21:41.633190 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010232 2025-05-14 14:21:41.650941 | 2025-05-14 14:21:41.651092 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-14 14:21:42.065672 | debian-bookworm | ok 2025-05-14 14:21:42.071184 | 2025-05-14 14:21:42.071322 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-14 14:21:42.107843 | debian-bookworm | skipping: Conditional result was False 2025-05-14 14:21:42.120665 | 2025-05-14 14:21:42.120804 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-14 14:21:42.525775 | debian-bookworm | ok 2025-05-14 14:21:42.538567 | 2025-05-14 14:21:42.538670 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-14 14:21:42.566065 | debian-bookworm | ok 2025-05-14 14:21:42.583128 | 2025-05-14 14:21:42.583246 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-14 14:21:42.886349 | debian-bookworm -> localhost | ok 2025-05-14 14:21:42.893098 | 2025-05-14 14:21:42.893218 | TASK [validate-host : Collect information about the host] 2025-05-14 14:21:44.043647 | debian-bookworm | ok 2025-05-14 14:21:44.058871 | 2025-05-14 14:21:44.059009 | TASK [validate-host : Sanitize hostname] 2025-05-14 14:21:44.195828 | debian-bookworm | ok 2025-05-14 14:21:44.236890 | 2025-05-14 14:21:44.237026 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-14 14:21:44.858399 | debian-bookworm -> localhost | changed 2025-05-14 14:21:44.869118 | 2025-05-14 14:21:44.869260 | TASK [validate-host : Collect information about zuul worker] 2025-05-14 14:21:45.307798 | debian-bookworm | ok 2025-05-14 14:21:45.319449 | 2025-05-14 14:21:45.319603 | TASK [validate-host : Write out all zuul information for each host] 2025-05-14 14:21:45.890273 | debian-bookworm -> localhost | changed 2025-05-14 14:21:45.900333 | 2025-05-14 14:21:45.900532 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-14 14:21:46.176742 | debian-bookworm | ok 2025-05-14 14:21:46.183916 | 2025-05-14 14:21:46.184034 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-14 14:21:47.106794 | debian-bookworm | changed: 2025-05-14 14:21:47.107057 | debian-bookworm | cd+++++++++ src/ 2025-05-14 14:21:47.107092 | debian-bookworm | cd+++++++++ src/github.com/ 2025-05-14 14:21:47.107116 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-05-14 14:21:47.107138 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-05-14 14:21:47.107159 | debian-bookworm | Containerfile 2025-05-14 14:21:47.107278 | debian-bookworm | localhost | ok: Runtime: 0:00:00.008744 2025-05-14 14:30:57.615410 | 2025-05-14 14:30:57.615550 | TASK [upload-logs : Upload logs to log server] 2025-05-14 14:30:58.244592 | localhost | Output suppressed because no_log was given 2025-05-14 14:30:58.247309 | 2025-05-14 14:30:58.247447 | LOOP [upload-logs : Compress console log and json output] 2025-05-14 14:30:58.324031 | localhost | skipping: Conditional result was False 2025-05-14 14:30:58.333474 | localhost | skipping: Conditional result was False 2025-05-14 14:30:58.338280 | 2025-05-14 14:30:58.338428 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-14 14:30:58.396005 | localhost | skipping: Conditional result was False 2025-05-14 14:30:58.396360 | 2025-05-14 14:30:58.400687 | localhost | skipping: Conditional result was False 2025-05-14 14:30:58.412793 | 2025-05-14 14:30:58.412988 | LOOP [upload-logs : Upload console log and json output]