2025-07-15 17:00:39.759190 | Job console starting 2025-07-15 17:00:39.775320 | Updating git repos 2025-07-15 17:00:39.827297 | Cloning repos into workspace 2025-07-15 17:00:39.968399 | Restoring repo states 2025-07-15 17:00:40.013696 | Merging changes 2025-07-15 17:00:40.627611 | Checking out repos 2025-07-15 17:00:40.702976 | Preparing playbooks 2025-07-15 17:00:42.093371 | Running Ansible setup 2025-07-15 17:00:47.679595 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-07-15 17:00:48.746301 | 2025-07-15 17:00:48.746479 | PLAY [Base pre] 2025-07-15 17:00:48.794023 | 2025-07-15 17:00:48.794340 | TASK [Setup log path fact] 2025-07-15 17:00:48.845834 | debian-bookworm | ok 2025-07-15 17:00:48.882650 | 2025-07-15 17:00:48.882855 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-07-15 17:00:48.914930 | debian-bookworm | ok 2025-07-15 17:00:48.935023 | 2025-07-15 17:00:48.935169 | TASK [emit-job-header : Print job information] 2025-07-15 17:00:49.015809 | # Job Information 2025-07-15 17:00:49.015999 | Ansible Version: 2.16.14 2025-07-15 17:00:49.016034 | Job: check-shell-syntax 2025-07-15 17:00:49.016067 | Pipeline: check 2025-07-15 17:00:49.016089 | Executor: 521e9411259a 2025-07-15 17:00:49.016110 | Triggered by: https://github.com/osism/cfg-generics/pull/549 2025-07-15 17:00:49.016132 | Event ID: 37046500-619d-11f0-97a0-bc1c765bf37d 2025-07-15 17:00:49.021350 | 2025-07-15 17:00:49.021473 | LOOP [emit-job-header : Print node information] 2025-07-15 17:00:49.268000 | debian-bookworm | ok: 2025-07-15 17:00:49.270956 | debian-bookworm | # Node Information 2025-07-15 17:00:49.271052 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-07-15 17:00:49.271084 | debian-bookworm | Hostname: debian 2025-07-15 17:00:49.271107 | debian-bookworm | Username: zuul 2025-07-15 17:00:49.271130 | debian-bookworm | Distro: Debian 12.11 2025-07-15 17:00:49.271153 | debian-bookworm | Provider: regiocloud-a 2025-07-15 17:00:49.271175 | debian-bookworm | Region: 2025-07-15 17:00:49.271196 | debian-bookworm | Label: debian-bookworm 2025-07-15 17:00:49.271216 | debian-bookworm | Product Name: OpenStack Nova 2025-07-15 17:00:49.271235 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fef1:9e2c 2025-07-15 17:00:49.291276 | 2025-07-15 17:00:49.291421 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-07-15 17:00:50.690010 | debian-bookworm -> localhost | changed 2025-07-15 17:00:50.697671 | 2025-07-15 17:00:50.697829 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-07-15 17:00:52.384412 | debian-bookworm -> localhost | changed 2025-07-15 17:00:52.404787 | 2025-07-15 17:00:52.404901 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-07-15 17:00:52.853357 | debian-bookworm -> localhost | ok 2025-07-15 17:00:52.859161 | 2025-07-15 17:00:52.859261 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-07-15 17:00:52.897031 | debian-bookworm | ok 2025-07-15 17:00:52.925935 | debian-bookworm | included: /var/lib/zuul/builds/0f562f68417643e1a119ad126bd668b7/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-07-15 17:00:52.952294 | 2025-07-15 17:00:52.952401 | TASK [add-build-sshkey : Create Temp SSH key] 2025-07-15 17:00:55.131177 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-07-15 17:00:55.131334 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/0f562f68417643e1a119ad126bd668b7/work/0f562f68417643e1a119ad126bd668b7_id_rsa 2025-07-15 17:00:55.131365 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/0f562f68417643e1a119ad126bd668b7/work/0f562f68417643e1a119ad126bd668b7_id_rsa.pub 2025-07-15 17:00:55.131386 | debian-bookworm -> localhost | The key fingerprint is: 2025-07-15 17:00:55.131406 | debian-bookworm -> localhost | SHA256:J4gzJ06SvSRAYOo81DpoU066ann0nOc12u2eW6LXR64 zuul-build-sshkey 2025-07-15 17:00:55.131424 | debian-bookworm -> localhost | The key's randomart image is: 2025-07-15 17:00:55.131449 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-07-15 17:00:55.131467 | debian-bookworm -> localhost | |oo | 2025-07-15 17:00:55.131484 | debian-bookworm -> localhost | |+ . | 2025-07-15 17:00:55.131502 | debian-bookworm -> localhost | |o. + | 2025-07-15 17:00:55.131528 | debian-bookworm -> localhost | |=.*o . . | 2025-07-15 17:00:55.131545 | debian-bookworm -> localhost | |.X+.O o S . | 2025-07-15 17:00:55.131567 | debian-bookworm -> localhost | |. =B * o . | 2025-07-15 17:00:55.131585 | debian-bookworm -> localhost | | .o = . o ...o | 2025-07-15 17:00:55.131602 | debian-bookworm -> localhost | |.o . + .+ +.+. o | 2025-07-15 17:00:55.131619 | debian-bookworm -> localhost | |o . oo o+*.Eo | 2025-07-15 17:00:55.131635 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-07-15 17:00:55.131678 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.286416 2025-07-15 17:00:55.136847 | 2025-07-15 17:00:55.136932 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-07-15 17:00:55.179236 | debian-bookworm | ok 2025-07-15 17:00:55.186654 | debian-bookworm | included: /var/lib/zuul/builds/0f562f68417643e1a119ad126bd668b7/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-07-15 17:00:55.194396 | 2025-07-15 17:00:55.194478 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-07-15 17:00:55.228282 | debian-bookworm | skipping: Conditional result was False 2025-07-15 17:00:55.233045 | 2025-07-15 17:00:55.233137 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-07-15 17:00:55.836891 | debian-bookworm | changed 2025-07-15 17:00:55.841829 | 2025-07-15 17:00:55.841918 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-07-15 17:00:56.108036 | debian-bookworm | ok 2025-07-15 17:00:56.112648 | 2025-07-15 17:00:56.112726 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-07-15 17:00:56.744321 | debian-bookworm | changed 2025-07-15 17:00:56.754637 | 2025-07-15 17:00:56.754767 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-07-15 17:00:57.421940 | debian-bookworm | changed 2025-07-15 17:00:57.427253 | 2025-07-15 17:00:57.427351 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-07-15 17:00:57.460370 | debian-bookworm | skipping: Conditional result was False 2025-07-15 17:00:57.476044 | 2025-07-15 17:00:57.476154 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-07-15 17:00:58.067920 | debian-bookworm -> localhost | changed 2025-07-15 17:00:58.078375 | 2025-07-15 17:00:58.078474 | TASK [add-build-sshkey : Add back temp key] 2025-07-15 17:00:58.455235 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/0f562f68417643e1a119ad126bd668b7/work/0f562f68417643e1a119ad126bd668b7_id_rsa (zuul-build-sshkey) 2025-07-15 17:00:58.455443 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011231 2025-07-15 17:00:58.462923 | 2025-07-15 17:00:58.463026 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-07-15 17:00:58.819842 | debian-bookworm | ok 2025-07-15 17:00:58.825148 | 2025-07-15 17:00:58.825286 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-07-15 17:00:58.849468 | debian-bookworm | skipping: Conditional result was False 2025-07-15 17:00:58.859801 | 2025-07-15 17:00:58.859912 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-07-15 17:00:59.352319 | debian-bookworm | ok 2025-07-15 17:00:59.371091 | 2025-07-15 17:00:59.371204 | TASK [validate-host : Define zuul_info_dir fact] 2025-07-15 17:00:59.419231 | debian-bookworm | ok 2025-07-15 17:00:59.424302 | 2025-07-15 17:00:59.424399 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-07-15 17:00:59.991162 | debian-bookworm -> localhost | ok 2025-07-15 17:00:59.997196 | 2025-07-15 17:00:59.997294 | TASK [validate-host : Collect information about the host] 2025-07-15 17:01:01.329460 | debian-bookworm | ok 2025-07-15 17:01:01.350440 | 2025-07-15 17:01:01.350663 | TASK [validate-host : Sanitize hostname] 2025-07-15 17:01:01.600368 | debian-bookworm | ok 2025-07-15 17:01:01.687629 | 2025-07-15 17:01:01.687765 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-07-15 17:01:02.738818 | debian-bookworm -> localhost | changed 2025-07-15 17:01:02.745026 | 2025-07-15 17:01:02.745157 | TASK [validate-host : Collect information about zuul worker] 2025-07-15 17:01:03.241729 | debian-bookworm | ok 2025-07-15 17:01:03.246796 | 2025-07-15 17:01:03.246956 | TASK [validate-host : Write out all zuul information for each host] 2025-07-15 17:01:04.388183 | debian-bookworm -> localhost | changed 2025-07-15 17:01:04.398487 | 2025-07-15 17:01:04.398663 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-07-15 17:01:04.691603 | debian-bookworm | ok 2025-07-15 17:01:04.697829 | 2025-07-15 17:01:04.697955 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-07-15 17:01:05.983738 | debian-bookworm | changed: 2025-07-15 17:01:05.983899 | debian-bookworm | cd+++++++++ src/ 2025-07-15 17:01:05.983932 | debian-bookworm | cd+++++++++ src/github.com/ 2025-07-15 17:01:05.983956 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-07-15 17:01:05.983977 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-generics/ 2025-07-15 17:01:05.983998 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006091 2025-07-15 17:01:14.780093 | 2025-07-15 17:01:14.780311 | TASK [upload-logs : Upload logs to log server] 2025-07-15 17:01:15.325038 | localhost | Output suppressed because no_log was given 2025-07-15 17:01:15.326889 | 2025-07-15 17:01:15.326977 | LOOP [upload-logs : Compress console log and json output] 2025-07-15 17:01:15.369935 | localhost | skipping: Conditional result was False 2025-07-15 17:01:15.376047 | localhost | skipping: Conditional result was False 2025-07-15 17:01:15.385525 | 2025-07-15 17:01:15.385722 | LOOP [upload-logs : Upload compressed console log and json output] 2025-07-15 17:01:15.428713 | localhost | skipping: Conditional result was False 2025-07-15 17:01:15.429334 | 2025-07-15 17:01:15.431401 | localhost | skipping: Conditional result was False 2025-07-15 17:01:15.438379 | 2025-07-15 17:01:15.438618 | LOOP [upload-logs : Upload console log and json output]