2025-07-18 03:17:40.082004 | Job console starting 2025-07-18 03:17:40.102384 | Updating git repos 2025-07-18 03:17:40.154007 | Cloning repos into workspace 2025-07-18 03:17:40.215114 | Restoring repo states 2025-07-18 03:17:40.235692 | Merging changes 2025-07-18 03:17:40.235718 | Checking out repos 2025-07-18 03:17:40.284143 | Preparing playbooks 2025-07-18 03:17:41.881891 | Running Ansible setup 2025-07-18 03:17:48.676949 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-07-18 03:17:49.810330 | 2025-07-18 03:17:49.810442 | PLAY [Base pre] 2025-07-18 03:17:49.829399 | 2025-07-18 03:17:49.829503 | TASK [Setup log path fact] 2025-07-18 03:17:49.857007 | debian-bookworm | ok 2025-07-18 03:17:49.875485 | 2025-07-18 03:17:49.875621 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-07-18 03:17:49.920545 | debian-bookworm | ok 2025-07-18 03:17:49.946782 | 2025-07-18 03:17:49.946898 | TASK [emit-job-header : Print job information] 2025-07-18 03:17:50.004512 | # Job Information 2025-07-18 03:17:50.004662 | Ansible Version: 2.16.14 2025-07-18 03:17:50.004690 | Job: python-black 2025-07-18 03:17:50.004716 | Pipeline: periodic-daily 2025-07-18 03:17:50.004735 | Executor: 521e9411259a 2025-07-18 03:17:50.004752 | Triggered by: https://github.com/osism/node-image 2025-07-18 03:17:50.004769 | Event ID: baf999571f8f42e285de8b22836241c3 2025-07-18 03:17:50.009222 | 2025-07-18 03:17:50.009306 | LOOP [emit-job-header : Print node information] 2025-07-18 03:17:50.235563 | debian-bookworm | ok: 2025-07-18 03:17:50.235810 | debian-bookworm | # Node Information 2025-07-18 03:17:50.235845 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-07-18 03:17:50.235866 | debian-bookworm | Hostname: debian 2025-07-18 03:17:50.235884 | debian-bookworm | Username: zuul 2025-07-18 03:17:50.235933 | debian-bookworm | Distro: Debian 12.11 2025-07-18 03:17:50.235955 | debian-bookworm | Provider: regiocloud-a 2025-07-18 03:17:50.235972 | debian-bookworm | Region: 2025-07-18 03:17:50.235990 | debian-bookworm | Label: debian-bookworm 2025-07-18 03:17:50.236006 | debian-bookworm | Product Name: OpenStack Nova 2025-07-18 03:17:50.236022 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe99:3566 2025-07-18 03:17:50.266934 | 2025-07-18 03:17:50.267164 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-07-18 03:17:51.510625 | debian-bookworm -> localhost | changed 2025-07-18 03:17:51.516316 | 2025-07-18 03:17:51.516406 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-07-18 03:17:53.324706 | debian-bookworm -> localhost | changed 2025-07-18 03:17:53.335141 | 2025-07-18 03:17:53.335239 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-07-18 03:17:54.060612 | debian-bookworm -> localhost | ok 2025-07-18 03:17:54.066764 | 2025-07-18 03:17:54.066888 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-07-18 03:17:54.106476 | debian-bookworm | ok 2025-07-18 03:17:54.130904 | debian-bookworm | included: /var/lib/zuul/builds/90560da1aa8c4e8cb59283524c518412/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-07-18 03:17:54.141759 | 2025-07-18 03:17:54.141843 | TASK [add-build-sshkey : Create Temp SSH key] 2025-07-18 03:17:55.597467 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-07-18 03:17:55.597718 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/90560da1aa8c4e8cb59283524c518412/work/90560da1aa8c4e8cb59283524c518412_id_rsa 2025-07-18 03:17:55.597753 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/90560da1aa8c4e8cb59283524c518412/work/90560da1aa8c4e8cb59283524c518412_id_rsa.pub 2025-07-18 03:17:55.597775 | debian-bookworm -> localhost | The key fingerprint is: 2025-07-18 03:17:55.597797 | debian-bookworm -> localhost | SHA256:iShAUaFzYdLCfYl9WPFQ1P5sgHc42n/VLDWhl2nKQ88 zuul-build-sshkey 2025-07-18 03:17:55.597816 | debian-bookworm -> localhost | The key's randomart image is: 2025-07-18 03:17:55.597842 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-07-18 03:17:55.597860 | debian-bookworm -> localhost | |.+==+ +++o. | 2025-07-18 03:17:55.597878 | debian-bookworm -> localhost | |.o++.= .o . . | 2025-07-18 03:17:55.597894 | debian-bookworm -> localhost | |.o... . .o . . +| 2025-07-18 03:17:55.597911 | debian-bookworm -> localhost | | .o . . o * + *.| 2025-07-18 03:17:55.597928 | debian-bookworm -> localhost | | . . . S + O *oo| 2025-07-18 03:17:55.598066 | debian-bookworm -> localhost | | . . . B.E+| 2025-07-18 03:17:55.598097 | debian-bookworm -> localhost | | o ...| 2025-07-18 03:17:55.598118 | debian-bookworm -> localhost | | . . | 2025-07-18 03:17:55.598232 | debian-bookworm -> localhost | | . | 2025-07-18 03:17:55.598256 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-07-18 03:17:55.598426 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.792877 2025-07-18 03:17:55.605062 | 2025-07-18 03:17:55.605141 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-07-18 03:17:55.632283 | debian-bookworm | ok 2025-07-18 03:17:55.645674 | debian-bookworm | included: /var/lib/zuul/builds/90560da1aa8c4e8cb59283524c518412/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-07-18 03:17:55.665752 | 2025-07-18 03:17:55.665843 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-07-18 03:17:55.693902 | debian-bookworm | skipping: Conditional result was False 2025-07-18 03:17:55.700145 | 2025-07-18 03:17:55.700234 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-07-18 03:17:56.394726 | debian-bookworm | changed 2025-07-18 03:17:56.400610 | 2025-07-18 03:17:56.400709 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-07-18 03:17:56.656884 | debian-bookworm | ok 2025-07-18 03:17:56.662189 | 2025-07-18 03:17:56.662288 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-07-18 03:17:57.297384 | debian-bookworm | changed 2025-07-18 03:17:57.304289 | 2025-07-18 03:17:57.304390 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-07-18 03:17:57.933357 | debian-bookworm | changed 2025-07-18 03:17:57.939025 | 2025-07-18 03:17:57.939116 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-07-18 03:17:57.972093 | debian-bookworm | skipping: Conditional result was False 2025-07-18 03:17:57.978646 | 2025-07-18 03:17:57.978751 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-07-18 03:17:58.873927 | debian-bookworm -> localhost | changed 2025-07-18 03:17:58.889225 | 2025-07-18 03:17:58.889333 | TASK [add-build-sshkey : Add back temp key] 2025-07-18 03:18:00.103311 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/90560da1aa8c4e8cb59283524c518412/work/90560da1aa8c4e8cb59283524c518412_id_rsa (zuul-build-sshkey) 2025-07-18 03:18:00.103531 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.047099 2025-07-18 03:18:00.111215 | 2025-07-18 03:18:00.111313 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-07-18 03:18:00.984034 | debian-bookworm | ok 2025-07-18 03:18:00.991305 | 2025-07-18 03:18:00.991411 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-07-18 03:18:01.034736 | debian-bookworm | skipping: Conditional result was False 2025-07-18 03:18:01.060193 | 2025-07-18 03:18:01.060302 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-07-18 03:18:01.590277 | debian-bookworm | ok 2025-07-18 03:18:01.615346 | 2025-07-18 03:18:01.615465 | TASK [validate-host : Define zuul_info_dir fact] 2025-07-18 03:18:01.668657 | debian-bookworm | ok 2025-07-18 03:18:01.673889 | 2025-07-18 03:18:01.673997 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-07-18 03:18:02.253938 | debian-bookworm -> localhost | ok 2025-07-18 03:18:02.269183 | 2025-07-18 03:18:02.269315 | TASK [validate-host : Collect information about the host] 2025-07-18 03:18:03.369771 | debian-bookworm | ok 2025-07-18 03:18:03.393748 | 2025-07-18 03:18:03.393874 | TASK [validate-host : Sanitize hostname] 2025-07-18 03:18:03.584303 | debian-bookworm | ok 2025-07-18 03:18:03.657889 | 2025-07-18 03:18:03.658003 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-07-18 03:18:05.025415 | debian-bookworm -> localhost | changed 2025-07-18 03:18:05.030012 | 2025-07-18 03:18:05.030104 | TASK [validate-host : Collect information about zuul worker] 2025-07-18 03:18:05.422083 | debian-bookworm | ok 2025-07-18 03:18:05.426826 | 2025-07-18 03:18:05.426959 | TASK [validate-host : Write out all zuul information for each host] 2025-07-18 03:18:06.433992 | debian-bookworm -> localhost | changed 2025-07-18 03:18:06.443281 | 2025-07-18 03:18:06.447714 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-07-18 03:18:06.725664 | debian-bookworm | ok 2025-07-18 03:18:06.735616 | 2025-07-18 03:18:06.735722 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-07-18 03:18:09.163832 | debian-bookworm | changed: 2025-07-18 03:18:09.163998 | debian-bookworm | cd+++++++++ src/ 2025-07-18 03:18:09.164030 | debian-bookworm | cd+++++++++ src/github.com/ 2025-07-18 03:18:09.164054 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-07-18 03:18:09.164075 | debian-bookworm | cd+++++++++ src/github.com/osism/node-image/ 2025-07-18 03:18:09.164095 | debian-bookworm | Containerfile 2025-07-18 03:18:09.164226 | debian-bookworm | localhost | ok: Runtime: 0:00:00.019256 2025-07-18 03:18:36.574123 | 2025-07-18 03:18:36.575229 | TASK [upload-logs : Upload logs to log server] 2025-07-18 03:18:37.167464 | localhost | Output suppressed because no_log was given 2025-07-18 03:18:37.169366 | 2025-07-18 03:18:37.169459 | LOOP [upload-logs : Compress console log and json output] 2025-07-18 03:18:37.208825 | localhost | skipping: Conditional result was False 2025-07-18 03:18:37.215924 | localhost | skipping: Conditional result was False 2025-07-18 03:18:37.226185 | 2025-07-18 03:18:37.226287 | LOOP [upload-logs : Upload compressed console log and json output] 2025-07-18 03:18:37.262638 | localhost | skipping: Conditional result was False 2025-07-18 03:18:37.262871 | 2025-07-18 03:18:37.266656 | localhost | skipping: Conditional result was False 2025-07-18 03:18:37.270601 | 2025-07-18 03:18:37.270678 | LOOP [upload-logs : Upload console log and json output]