2025-06-12 03:03:15.719916 | Job console starting 2025-06-12 03:03:15.733097 | Updating git repos 2025-06-12 03:03:15.787886 | Cloning repos into workspace 2025-06-12 03:03:15.920269 | Restoring repo states 2025-06-12 03:03:15.944880 | Merging changes 2025-06-12 03:03:15.944902 | Checking out repos 2025-06-12 03:03:16.020774 | Preparing playbooks 2025-06-12 03:03:17.421831 | Running Ansible setup 2025-06-12 03:03:24.682515 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-12 03:03:26.403757 | 2025-06-12 03:03:26.403951 | PLAY [Base pre] 2025-06-12 03:03:26.446393 | 2025-06-12 03:03:26.447514 | TASK [Setup log path fact] 2025-06-12 03:03:26.491980 | debian-bookworm | ok 2025-06-12 03:03:26.538223 | 2025-06-12 03:03:26.538404 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-12 03:03:26.625581 | debian-bookworm | ok 2025-06-12 03:03:26.682351 | 2025-06-12 03:03:26.682513 | TASK [emit-job-header : Print job information] 2025-06-12 03:03:26.764684 | # Job Information 2025-06-12 03:03:26.764880 | Ansible Version: 2.16.14 2025-06-12 03:03:26.764955 | Job: python-black 2025-06-12 03:03:26.764991 | Pipeline: periodic-daily 2025-06-12 03:03:26.765016 | Executor: 521e9411259a 2025-06-12 03:03:26.765038 | Triggered by: https://github.com/osism/openstack-image-manager 2025-06-12 03:03:26.765062 | Event ID: 074f723277ad473da846ddf6aa24d936 2025-06-12 03:03:26.770300 | 2025-06-12 03:03:26.770426 | LOOP [emit-job-header : Print node information] 2025-06-12 03:03:26.959838 | debian-bookworm | ok: 2025-06-12 03:03:26.960148 | debian-bookworm | # Node Information 2025-06-12 03:03:26.960198 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-12 03:03:26.960225 | debian-bookworm | Hostname: debian 2025-06-12 03:03:26.960247 | debian-bookworm | Username: zuul 2025-06-12 03:03:26.960269 | debian-bookworm | Distro: Debian 12.11 2025-06-12 03:03:26.960292 | debian-bookworm | Provider: regiocloud-a 2025-06-12 03:03:26.960313 | debian-bookworm | Region: 2025-06-12 03:03:26.960333 | debian-bookworm | Label: debian-bookworm 2025-06-12 03:03:26.960354 | debian-bookworm | Product Name: OpenStack Nova 2025-06-12 03:03:26.960374 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe4f:68b7 2025-06-12 03:03:26.982899 | 2025-06-12 03:03:26.983036 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-12 03:03:27.526016 | debian-bookworm -> localhost | changed 2025-06-12 03:03:27.535990 | 2025-06-12 03:03:27.536269 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-12 03:03:28.708914 | debian-bookworm -> localhost | changed 2025-06-12 03:03:28.728342 | 2025-06-12 03:03:28.728503 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-12 03:03:29.052569 | debian-bookworm -> localhost | ok 2025-06-12 03:03:29.059082 | 2025-06-12 03:03:29.059205 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-12 03:03:29.091800 | debian-bookworm | ok 2025-06-12 03:03:29.112416 | debian-bookworm | included: /var/lib/zuul/builds/6f23a7a211a74ea4935e900033ed988e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-12 03:03:29.119846 | 2025-06-12 03:03:29.119969 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-12 03:03:30.830847 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-12 03:03:30.831151 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/6f23a7a211a74ea4935e900033ed988e/work/6f23a7a211a74ea4935e900033ed988e_id_rsa 2025-06-12 03:03:30.831193 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/6f23a7a211a74ea4935e900033ed988e/work/6f23a7a211a74ea4935e900033ed988e_id_rsa.pub 2025-06-12 03:03:30.831221 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-12 03:03:30.831247 | debian-bookworm -> localhost | SHA256:JSM9b+NeBO7nP4RH7wXqTVg28nNVXKQXWjUnEs/CMh8 zuul-build-sshkey 2025-06-12 03:03:30.831269 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-12 03:03:30.831303 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-12 03:03:30.831326 | debian-bookworm -> localhost | | o..*B| 2025-06-12 03:03:30.831348 | debian-bookworm -> localhost | | . . +oo*| 2025-06-12 03:03:30.831369 | debian-bookworm -> localhost | | . = = E.+ o| 2025-06-12 03:03:30.831390 | debian-bookworm -> localhost | | . B =.o*..| 2025-06-12 03:03:30.831409 | debian-bookworm -> localhost | | S = oX +.| 2025-06-12 03:03:30.831438 | debian-bookworm -> localhost | | + o+ * +| 2025-06-12 03:03:30.831460 | debian-bookworm -> localhost | | o.o= +.| 2025-06-12 03:03:30.831481 | debian-bookworm -> localhost | | . +. o .| 2025-06-12 03:03:30.831502 | debian-bookworm -> localhost | | . .... | 2025-06-12 03:03:30.831523 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-12 03:03:30.831584 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.017438 2025-06-12 03:03:30.838200 | 2025-06-12 03:03:30.838329 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-12 03:03:30.889556 | debian-bookworm | ok 2025-06-12 03:03:30.913071 | debian-bookworm | included: /var/lib/zuul/builds/6f23a7a211a74ea4935e900033ed988e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-12 03:03:30.927522 | 2025-06-12 03:03:30.927681 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-12 03:03:30.953043 | debian-bookworm | skipping: Conditional result was False 2025-06-12 03:03:30.961098 | 2025-06-12 03:03:30.961229 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-12 03:03:31.867800 | debian-bookworm | changed 2025-06-12 03:03:31.879415 | 2025-06-12 03:03:31.880662 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-12 03:03:32.176901 | debian-bookworm | ok 2025-06-12 03:03:32.197908 | 2025-06-12 03:03:32.198071 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-12 03:03:33.126784 | debian-bookworm | changed 2025-06-12 03:03:33.165902 | 2025-06-12 03:03:33.166018 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-12 03:03:33.928028 | debian-bookworm | changed 2025-06-12 03:03:33.936552 | 2025-06-12 03:03:33.937563 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-12 03:03:33.991673 | debian-bookworm | skipping: Conditional result was False 2025-06-12 03:03:33.999869 | 2025-06-12 03:03:33.999974 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-12 03:03:35.646170 | debian-bookworm -> localhost | changed 2025-06-12 03:03:35.701762 | 2025-06-12 03:03:35.702993 | TASK [add-build-sshkey : Add back temp key] 2025-06-12 03:03:36.897691 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/6f23a7a211a74ea4935e900033ed988e/work/6f23a7a211a74ea4935e900033ed988e_id_rsa (zuul-build-sshkey) 2025-06-12 03:03:36.898018 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.017653 2025-06-12 03:03:36.906977 | 2025-06-12 03:03:36.907140 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-12 03:03:37.488100 | debian-bookworm | ok 2025-06-12 03:03:37.506585 | 2025-06-12 03:03:37.506735 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-12 03:03:37.570681 | debian-bookworm | skipping: Conditional result was False 2025-06-12 03:03:37.584708 | 2025-06-12 03:03:37.585876 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-12 03:03:38.340580 | debian-bookworm | ok 2025-06-12 03:03:38.357859 | 2025-06-12 03:03:38.358299 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-12 03:03:38.450861 | debian-bookworm | ok 2025-06-12 03:03:38.457050 | 2025-06-12 03:03:38.457789 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-12 03:03:39.598610 | debian-bookworm -> localhost | ok 2025-06-12 03:03:39.605088 | 2025-06-12 03:03:39.605168 | TASK [validate-host : Collect information about the host] 2025-06-12 03:03:41.556093 | debian-bookworm | ok 2025-06-12 03:03:41.576492 | 2025-06-12 03:03:41.576591 | TASK [validate-host : Sanitize hostname] 2025-06-12 03:03:41.816064 | debian-bookworm | ok 2025-06-12 03:03:41.901452 | 2025-06-12 03:03:41.901896 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-12 03:03:44.189474 | debian-bookworm -> localhost | changed 2025-06-12 03:03:44.194759 | 2025-06-12 03:03:44.194876 | TASK [validate-host : Collect information about zuul worker] 2025-06-12 03:03:44.667306 | debian-bookworm | ok 2025-06-12 03:03:44.678113 | 2025-06-12 03:03:44.678225 | TASK [validate-host : Write out all zuul information for each host] 2025-06-12 03:03:45.600175 | debian-bookworm -> localhost | changed 2025-06-12 03:03:45.608536 | 2025-06-12 03:03:45.608708 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-12 03:03:45.893175 | debian-bookworm | ok 2025-06-12 03:03:45.897603 | 2025-06-12 03:03:45.897698 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-12 03:03:47.016097 | debian-bookworm | changed: 2025-06-12 03:03:47.016504 | debian-bookworm | cd+++++++++ src/ 2025-06-12 03:03:47.016543 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-12 03:03:47.016678 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-12 03:03:47.016702 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-06-12 03:03:47.016721 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006426 2025-06-12 03:04:12.976033 | 2025-06-12 03:04:12.976186 | TASK [upload-logs : Upload logs to log server] 2025-06-12 03:04:13.513814 | localhost | Output suppressed because no_log was given 2025-06-12 03:04:13.518233 | 2025-06-12 03:04:13.518443 | LOOP [upload-logs : Compress console log and json output] 2025-06-12 03:04:13.576750 | localhost | skipping: Conditional result was False 2025-06-12 03:04:13.581316 | localhost | skipping: Conditional result was False 2025-06-12 03:04:13.590714 | 2025-06-12 03:04:13.590806 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-12 03:04:13.644989 | localhost | skipping: Conditional result was False 2025-06-12 03:04:13.645233 | 2025-06-12 03:04:13.651303 | localhost | skipping: Conditional result was False 2025-06-12 03:04:13.662348 | 2025-06-12 03:04:13.662570 | LOOP [upload-logs : Upload console log and json output]