2025-05-30 21:23:42.369805 | Job console starting 2025-05-30 21:23:42.381633 | Updating git repos 2025-05-30 21:23:42.424580 | Cloning repos into workspace 2025-05-30 21:23:42.516091 | Restoring repo states 2025-05-30 21:23:42.541260 | Merging changes 2025-05-30 21:23:43.263221 | Checking out repos 2025-05-30 21:23:43.289861 | Preparing playbooks 2025-05-30 21:23:43.822737 | Running Ansible setup 2025-05-30 21:23:48.672989 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-30 21:23:49.646088 | 2025-05-30 21:23:49.646397 | PLAY [Base pre] 2025-05-30 21:23:49.674308 | 2025-05-30 21:23:49.674539 | TASK [Setup log path fact] 2025-05-30 21:23:49.728319 | debian-bookworm | ok 2025-05-30 21:23:49.755270 | 2025-05-30 21:23:49.755495 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-30 21:23:49.787756 | debian-bookworm | ok 2025-05-30 21:23:49.798073 | 2025-05-30 21:23:49.798203 | TASK [emit-job-header : Print job information] 2025-05-30 21:23:49.873212 | # Job Information 2025-05-30 21:23:49.873464 | Ansible Version: 2.16.14 2025-05-30 21:23:49.873507 | Job: container-image-inventory-reconciler-build 2025-05-30 21:23:49.873542 | Pipeline: check 2025-05-30 21:23:49.873565 | Executor: 521e9411259a 2025-05-30 21:23:49.873585 | Triggered by: https://github.com/osism/container-image-inventory-reconciler/pull/379 2025-05-30 21:23:49.873607 | Event ID: 3b2ca720-3d9c-11f0-94d6-e0fcb3b59804 2025-05-30 21:23:49.878968 | 2025-05-30 21:23:49.879086 | LOOP [emit-job-header : Print node information] 2025-05-30 21:23:50.028739 | debian-bookworm | ok: 2025-05-30 21:23:50.028965 | debian-bookworm | # Node Information 2025-05-30 21:23:50.029015 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-05-30 21:23:50.029051 | debian-bookworm | Hostname: debian 2025-05-30 21:23:50.029074 | debian-bookworm | Username: zuul 2025-05-30 21:23:50.029096 | debian-bookworm | Distro: Debian 12.11 2025-05-30 21:23:50.029120 | debian-bookworm | Provider: regiocloud-a 2025-05-30 21:23:50.029141 | debian-bookworm | Region: 2025-05-30 21:23:50.029163 | debian-bookworm | Label: debian-bookworm 2025-05-30 21:23:50.029183 | debian-bookworm | Product Name: OpenStack Nova 2025-05-30 21:23:50.029204 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fef0:5d1a 2025-05-30 21:23:50.046919 | 2025-05-30 21:23:50.047079 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-30 21:23:50.587711 | debian-bookworm -> localhost | changed 2025-05-30 21:23:50.596014 | 2025-05-30 21:23:50.596168 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-30 21:23:52.286946 | debian-bookworm -> localhost | changed 2025-05-30 21:23:52.299903 | 2025-05-30 21:23:52.300040 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-30 21:23:52.759604 | debian-bookworm -> localhost | ok 2025-05-30 21:23:52.813153 | 2025-05-30 21:23:52.813381 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-30 21:23:52.843646 | debian-bookworm | ok 2025-05-30 21:23:52.865276 | debian-bookworm | included: /var/lib/zuul/builds/70ad2a5062f146118d8eaa1bd781ddb6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-30 21:23:52.872864 | 2025-05-30 21:23:52.872984 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-30 21:23:54.382081 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-05-30 21:23:54.382340 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/70ad2a5062f146118d8eaa1bd781ddb6/work/70ad2a5062f146118d8eaa1bd781ddb6_id_rsa 2025-05-30 21:23:54.382398 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/70ad2a5062f146118d8eaa1bd781ddb6/work/70ad2a5062f146118d8eaa1bd781ddb6_id_rsa.pub 2025-05-30 21:23:54.382424 | debian-bookworm -> localhost | The key fingerprint is: 2025-05-30 21:23:54.382448 | debian-bookworm -> localhost | SHA256:1+NuT8wrV52KpZw0O/ZlJJ8tRP1TeKogcvIEgObx2UU zuul-build-sshkey 2025-05-30 21:23:54.382489 | debian-bookworm -> localhost | The key's randomart image is: 2025-05-30 21:23:54.382511 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-05-30 21:23:54.382532 | debian-bookworm -> localhost | | .. .E | 2025-05-30 21:23:54.382553 | debian-bookworm -> localhost | | + . . o | 2025-05-30 21:23:54.382574 | debian-bookworm -> localhost | | o o o.. o +| 2025-05-30 21:23:54.382593 | debian-bookworm -> localhost | | . o .. . . oo| 2025-05-30 21:23:54.382613 | debian-bookworm -> localhost | | o S o o.oo+| 2025-05-30 21:23:54.382644 | debian-bookworm -> localhost | | * o = B+.*| 2025-05-30 21:23:54.382666 | debian-bookworm -> localhost | | . o X **.| 2025-05-30 21:23:54.382686 | debian-bookworm -> localhost | | Xoo+o | 2025-05-30 21:23:54.382707 | debian-bookworm -> localhost | | ..+=o | 2025-05-30 21:23:54.382728 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-05-30 21:23:54.382787 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.816552 2025-05-30 21:23:54.389734 | 2025-05-30 21:23:54.389855 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-30 21:23:54.451742 | debian-bookworm | ok 2025-05-30 21:23:54.470232 | debian-bookworm | included: /var/lib/zuul/builds/70ad2a5062f146118d8eaa1bd781ddb6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-30 21:23:54.491168 | 2025-05-30 21:23:54.491315 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-30 21:23:54.538553 | debian-bookworm | skipping: Conditional result was False 2025-05-30 21:23:54.546675 | 2025-05-30 21:23:54.546827 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-30 21:23:55.540203 | debian-bookworm | changed 2025-05-30 21:23:55.546019 | 2025-05-30 21:23:55.546132 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-30 21:23:55.847636 | debian-bookworm | ok 2025-05-30 21:23:55.854340 | 2025-05-30 21:23:55.854468 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-30 21:23:56.710989 | debian-bookworm | changed 2025-05-30 21:23:56.731713 | 2025-05-30 21:23:56.731896 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-30 21:23:57.653095 | debian-bookworm | changed 2025-05-30 21:23:57.663615 | 2025-05-30 21:23:57.663776 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-30 21:23:57.718211 | debian-bookworm | skipping: Conditional result was False 2025-05-30 21:23:57.751544 | 2025-05-30 21:23:57.751865 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-30 21:23:58.357833 | debian-bookworm -> localhost | changed 2025-05-30 21:23:58.380794 | 2025-05-30 21:23:58.380930 | TASK [add-build-sshkey : Add back temp key] 2025-05-30 21:23:58.888514 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/70ad2a5062f146118d8eaa1bd781ddb6/work/70ad2a5062f146118d8eaa1bd781ddb6_id_rsa (zuul-build-sshkey) 2025-05-30 21:23:58.888793 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009178 2025-05-30 21:23:58.896285 | 2025-05-30 21:23:58.896391 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-30 21:23:59.406513 | debian-bookworm | ok 2025-05-30 21:23:59.419772 | 2025-05-30 21:23:59.419894 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-30 21:23:59.443851 | debian-bookworm | skipping: Conditional result was False 2025-05-30 21:23:59.459907 | 2025-05-30 21:23:59.460040 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-30 21:24:00.006604 | debian-bookworm | ok 2025-05-30 21:24:00.025972 | 2025-05-30 21:24:00.026099 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-30 21:24:00.084806 | debian-bookworm | ok 2025-05-30 21:24:00.090560 | 2025-05-30 21:24:00.090670 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-30 21:24:00.439189 | debian-bookworm -> localhost | ok 2025-05-30 21:24:00.454822 | 2025-05-30 21:24:00.455631 | TASK [validate-host : Collect information about the host] 2025-05-30 21:24:01.651417 | debian-bookworm | ok 2025-05-30 21:24:01.667648 | 2025-05-30 21:24:01.667781 | TASK [validate-host : Sanitize hostname] 2025-05-30 21:24:01.757514 | debian-bookworm | ok 2025-05-30 21:24:01.791910 | 2025-05-30 21:24:01.792027 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-30 21:24:02.393835 | debian-bookworm -> localhost | changed 2025-05-30 21:24:02.405240 | 2025-05-30 21:24:02.405492 | TASK [validate-host : Collect information about zuul worker] 2025-05-30 21:24:02.852487 | debian-bookworm | ok 2025-05-30 21:24:02.859487 | 2025-05-30 21:24:02.859615 | TASK [validate-host : Write out all zuul information for each host] 2025-05-30 21:24:03.450770 | debian-bookworm -> localhost | changed 2025-05-30 21:24:03.462468 | 2025-05-30 21:24:03.462621 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-30 21:24:03.761235 | debian-bookworm | ok 2025-05-30 21:24:03.771220 | 2025-05-30 21:24:03.771432 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-30 21:24:04.599780 | debian-bookworm | changed: 2025-05-30 21:24:04.600086 | debian-bookworm | cd+++++++++ src/ 2025-05-30 21:24:04.600147 | debian-bookworm | cd+++++++++ src/github.com/ 2025-05-30 21:24:04.600188 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-05-30 21:24:04.600227 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-inventory-reconciler/ 2025-05-30 21:24:04.600264 | debian-bookworm | Containerfile 2025-05-30 21:24:04.600523 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007889 2025-05-30 21:25:43.666968 | 2025-05-30 21:25:43.667135 | TASK [upload-logs : Upload logs to log server] 2025-05-30 21:25:44.287063 | localhost | Output suppressed because no_log was given 2025-05-30 21:25:44.290663 | 2025-05-30 21:25:44.290949 | LOOP [upload-logs : Compress console log and json output] 2025-05-30 21:25:44.352811 | localhost | skipping: Conditional result was False 2025-05-30 21:25:44.357994 | localhost | skipping: Conditional result was False 2025-05-30 21:25:44.363358 | 2025-05-30 21:25:44.363530 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-30 21:25:44.411772 | localhost | skipping: Conditional result was False 2025-05-30 21:25:44.412529 | 2025-05-30 21:25:44.415857 | localhost | skipping: Conditional result was False 2025-05-30 21:25:44.423032 | 2025-05-30 21:25:44.423194 | LOOP [upload-logs : Upload console log and json output]