2025-05-21 07:38:14.599153 | Job console starting 2025-05-21 07:38:14.610759 | Updating git repos 2025-05-21 07:38:14.625168 | Cloning repos into workspace 2025-05-21 07:38:14.663923 | Restoring repo states 2025-05-21 07:38:14.673856 | Merging changes 2025-05-21 07:38:15.214342 | Checking out repos 2025-05-21 07:38:15.266906 | Preparing playbooks 2025-05-21 07:38:16.000851 | Running Ansible setup 2025-05-21 07:38:21.293838 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-21 07:38:22.350825 | 2025-05-21 07:38:22.351034 | PLAY [Base pre] 2025-05-21 07:38:22.367846 | 2025-05-21 07:38:22.368041 | TASK [Setup log path fact] 2025-05-21 07:38:22.397574 | debian-bookworm | ok 2025-05-21 07:38:22.413095 | 2025-05-21 07:38:22.413260 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-21 07:38:22.469443 | debian-bookworm | ok 2025-05-21 07:38:22.487392 | 2025-05-21 07:38:22.490352 | TASK [emit-job-header : Print job information] 2025-05-21 07:38:22.561893 | # Job Information 2025-05-21 07:38:22.562085 | Ansible Version: 2.16.14 2025-05-21 07:38:22.562121 | Job: container-image-cfg-cookiecutter-build 2025-05-21 07:38:22.562157 | Pipeline: check 2025-05-21 07:38:22.562181 | Executor: 521e9411259a 2025-05-21 07:38:22.562202 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/745 2025-05-21 07:38:22.562224 | Event ID: 6cb447e0-3616-11f0-8857-eda2c46e5588 2025-05-21 07:38:22.567393 | 2025-05-21 07:38:22.567540 | LOOP [emit-job-header : Print node information] 2025-05-21 07:38:22.745781 | debian-bookworm | ok: 2025-05-21 07:38:22.746088 | debian-bookworm | # Node Information 2025-05-21 07:38:22.746126 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-05-21 07:38:22.746152 | debian-bookworm | Hostname: debian 2025-05-21 07:38:22.746174 | debian-bookworm | Username: zuul 2025-05-21 07:38:22.746196 | debian-bookworm | Distro: Debian 12.11 2025-05-21 07:38:22.746220 | debian-bookworm | Provider: regiocloud-a 2025-05-21 07:38:22.746242 | debian-bookworm | Region: 2025-05-21 07:38:22.746263 | debian-bookworm | Label: debian-bookworm 2025-05-21 07:38:22.746284 | debian-bookworm | Product Name: OpenStack Nova 2025-05-21 07:38:22.746304 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe85:2165 2025-05-21 07:38:22.782153 | 2025-05-21 07:38:22.782308 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-21 07:38:23.555600 | debian-bookworm -> localhost | changed 2025-05-21 07:38:23.561633 | 2025-05-21 07:38:23.561727 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-21 07:38:24.995263 | debian-bookworm -> localhost | changed 2025-05-21 07:38:25.003968 | 2025-05-21 07:38:25.004055 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-21 07:38:25.320109 | debian-bookworm -> localhost | ok 2025-05-21 07:38:25.325081 | 2025-05-21 07:38:25.325172 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-21 07:38:25.341450 | debian-bookworm | ok 2025-05-21 07:38:25.354819 | debian-bookworm | included: /var/lib/zuul/builds/c97b9daf98144f0d98e0e469c7066e92/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-21 07:38:25.359922 | 2025-05-21 07:38:25.360005 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-21 07:38:26.625153 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-05-21 07:38:26.625380 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c97b9daf98144f0d98e0e469c7066e92/work/c97b9daf98144f0d98e0e469c7066e92_id_rsa 2025-05-21 07:38:26.625424 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c97b9daf98144f0d98e0e469c7066e92/work/c97b9daf98144f0d98e0e469c7066e92_id_rsa.pub 2025-05-21 07:38:26.625451 | debian-bookworm -> localhost | The key fingerprint is: 2025-05-21 07:38:26.625491 | debian-bookworm -> localhost | SHA256:cnZP2FKZGW+AlYpcFtrgH+x5Dg2tJu4RQk6lQO6dcS4 zuul-build-sshkey 2025-05-21 07:38:26.625522 | debian-bookworm -> localhost | The key's randomart image is: 2025-05-21 07:38:26.625544 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-05-21 07:38:26.625565 | debian-bookworm -> localhost | | .o o .++. | 2025-05-21 07:38:26.625586 | debian-bookworm -> localhost | | . . + =+..B | 2025-05-21 07:38:26.625605 | debian-bookworm -> localhost | | . =.++=.* o | 2025-05-21 07:38:26.625624 | debian-bookworm -> localhost | | . = =oo.X . | 2025-05-21 07:38:26.625644 | debian-bookworm -> localhost | | . E S @ = | 2025-05-21 07:38:26.625668 | debian-bookworm -> localhost | | B = B | 2025-05-21 07:38:26.625688 | debian-bookworm -> localhost | | o o | 2025-05-21 07:38:26.625707 | debian-bookworm -> localhost | | . . | 2025-05-21 07:38:26.625727 | debian-bookworm -> localhost | | . | 2025-05-21 07:38:26.625747 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-05-21 07:38:26.625799 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.875251 2025-05-21 07:38:26.631854 | 2025-05-21 07:38:26.631951 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-21 07:38:26.649487 | debian-bookworm | ok 2025-05-21 07:38:26.658862 | debian-bookworm | included: /var/lib/zuul/builds/c97b9daf98144f0d98e0e469c7066e92/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-21 07:38:26.667371 | 2025-05-21 07:38:26.667473 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-21 07:38:26.680558 | debian-bookworm | skipping: Conditional result was False 2025-05-21 07:38:26.685915 | 2025-05-21 07:38:26.685998 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-21 07:38:27.311947 | debian-bookworm | changed 2025-05-21 07:38:27.322334 | 2025-05-21 07:38:27.322491 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-21 07:38:27.590527 | debian-bookworm | ok 2025-05-21 07:38:27.599818 | 2025-05-21 07:38:27.599910 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-21 07:38:28.272643 | debian-bookworm | changed 2025-05-21 07:38:28.282604 | 2025-05-21 07:38:28.282720 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-21 07:38:28.957050 | debian-bookworm | changed 2025-05-21 07:38:28.969522 | 2025-05-21 07:38:28.969634 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-21 07:38:28.994575 | debian-bookworm | skipping: Conditional result was False 2025-05-21 07:38:29.004657 | 2025-05-21 07:38:29.004811 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-21 07:38:29.393191 | debian-bookworm -> localhost | changed 2025-05-21 07:38:29.404463 | 2025-05-21 07:38:29.404558 | TASK [add-build-sshkey : Add back temp key] 2025-05-21 07:38:29.731049 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c97b9daf98144f0d98e0e469c7066e92/work/c97b9daf98144f0d98e0e469c7066e92_id_rsa (zuul-build-sshkey) 2025-05-21 07:38:29.731552 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.021955 2025-05-21 07:38:29.744312 | 2025-05-21 07:38:29.744442 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-21 07:38:30.116639 | debian-bookworm | ok 2025-05-21 07:38:30.126260 | 2025-05-21 07:38:30.126427 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-21 07:38:30.161034 | debian-bookworm | skipping: Conditional result was False 2025-05-21 07:38:30.183671 | 2025-05-21 07:38:30.183795 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-21 07:38:30.626060 | debian-bookworm | ok 2025-05-21 07:38:30.636598 | 2025-05-21 07:38:30.636697 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-21 07:38:30.676908 | debian-bookworm | ok 2025-05-21 07:38:30.682513 | 2025-05-21 07:38:30.682620 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-21 07:38:30.985619 | debian-bookworm -> localhost | ok 2025-05-21 07:38:30.993150 | 2025-05-21 07:38:30.993241 | TASK [validate-host : Collect information about the host] 2025-05-21 07:38:32.088147 | debian-bookworm | ok 2025-05-21 07:38:32.098496 | 2025-05-21 07:38:32.098622 | TASK [validate-host : Sanitize hostname] 2025-05-21 07:38:32.229824 | debian-bookworm | ok 2025-05-21 07:38:32.275682 | 2025-05-21 07:38:32.275829 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-21 07:38:32.909558 | debian-bookworm -> localhost | changed 2025-05-21 07:38:32.925978 | 2025-05-21 07:38:32.926158 | TASK [validate-host : Collect information about zuul worker] 2025-05-21 07:38:33.365304 | debian-bookworm | ok 2025-05-21 07:38:33.373890 | 2025-05-21 07:38:33.374049 | TASK [validate-host : Write out all zuul information for each host] 2025-05-21 07:38:33.978981 | debian-bookworm -> localhost | changed 2025-05-21 07:38:33.989210 | 2025-05-21 07:38:33.989341 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-21 07:38:34.272901 | debian-bookworm | ok 2025-05-21 07:38:34.280616 | 2025-05-21 07:38:34.280761 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-21 07:38:35.099406 | debian-bookworm | changed: 2025-05-21 07:38:35.099657 | debian-bookworm | cd+++++++++ src/ 2025-05-21 07:38:35.099776 | debian-bookworm | cd+++++++++ src/github.com/ 2025-05-21 07:38:35.099807 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-05-21 07:38:35.099830 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-05-21 07:38:35.099853 | debian-bookworm | Containerfile 2025-05-21 07:38:35.099986 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007644 2025-05-21 07:39:58.460004 | 2025-05-21 07:39:58.460146 | TASK [upload-logs : Upload logs to log server] 2025-05-21 07:39:59.038060 | localhost | Output suppressed because no_log was given 2025-05-21 07:39:59.040579 | 2025-05-21 07:39:59.040702 | LOOP [upload-logs : Compress console log and json output] 2025-05-21 07:39:59.113647 | localhost | skipping: Conditional result was False 2025-05-21 07:39:59.124838 | localhost | skipping: Conditional result was False 2025-05-21 07:39:59.133407 | 2025-05-21 07:39:59.133597 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-21 07:39:59.185354 | localhost | skipping: Conditional result was False 2025-05-21 07:39:59.185966 | 2025-05-21 07:39:59.189102 | localhost | skipping: Conditional result was False 2025-05-21 07:39:59.198062 | 2025-05-21 07:39:59.198447 | LOOP [upload-logs : Upload console log and json output]