2025-05-23 18:00:37.475453 | Job console starting 2025-05-23 18:00:37.492403 | Updating git repos 2025-05-23 18:00:37.514674 | Cloning repos into workspace 2025-05-23 18:00:37.547720 | Restoring repo states 2025-05-23 18:00:37.561978 | Merging changes 2025-05-23 18:00:38.046452 | Checking out repos 2025-05-23 18:00:38.130934 | Preparing playbooks 2025-05-23 18:00:39.044334 | Running Ansible setup 2025-05-23 18:00:44.785109 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-23 18:00:46.116237 | 2025-05-23 18:00:46.116421 | PLAY [Base pre] 2025-05-23 18:00:46.145471 | 2025-05-23 18:00:46.145649 | TASK [Setup log path fact] 2025-05-23 18:00:46.181098 | debian-bookworm | ok 2025-05-23 18:00:46.210868 | 2025-05-23 18:00:46.211166 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-23 18:00:46.265484 | debian-bookworm | ok 2025-05-23 18:00:46.279330 | 2025-05-23 18:00:46.279907 | TASK [emit-job-header : Print job information] 2025-05-23 18:00:46.395547 | # Job Information 2025-05-23 18:00:46.395780 | Ansible Version: 2.16.14 2025-05-23 18:00:46.395820 | Job: container-image-inventory-reconciler-build 2025-05-23 18:00:46.395854 | Pipeline: check 2025-05-23 18:00:46.395878 | Executor: 521e9411259a 2025-05-23 18:00:46.395900 | Triggered by: https://github.com/osism/container-image-inventory-reconciler/pull/320 2025-05-23 18:00:46.395922 | Event ID: cfe561b0-37ff-11f0-8cf1-3881ef410d8b 2025-05-23 18:00:46.403311 | 2025-05-23 18:00:46.403867 | LOOP [emit-job-header : Print node information] 2025-05-23 18:00:46.614515 | debian-bookworm | ok: 2025-05-23 18:00:46.614817 | debian-bookworm | # Node Information 2025-05-23 18:00:46.614902 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-05-23 18:00:46.614930 | debian-bookworm | Hostname: debian 2025-05-23 18:00:46.614953 | debian-bookworm | Username: zuul 2025-05-23 18:00:46.614975 | debian-bookworm | Distro: Debian 12.11 2025-05-23 18:00:46.615004 | debian-bookworm | Provider: regiocloud-a 2025-05-23 18:00:46.615027 | debian-bookworm | Region: 2025-05-23 18:00:46.615048 | debian-bookworm | Label: debian-bookworm 2025-05-23 18:00:46.615068 | debian-bookworm | Product Name: OpenStack Nova 2025-05-23 18:00:46.615088 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fecd:f83b 2025-05-23 18:00:46.638531 | 2025-05-23 18:00:46.638685 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-23 18:00:47.453535 | debian-bookworm -> localhost | changed 2025-05-23 18:00:47.466011 | 2025-05-23 18:00:47.466169 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-23 18:00:49.781178 | debian-bookworm -> localhost | changed 2025-05-23 18:00:49.803367 | 2025-05-23 18:00:49.803520 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-23 18:00:50.411251 | debian-bookworm -> localhost | ok 2025-05-23 18:00:50.419289 | 2025-05-23 18:00:50.419430 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-23 18:00:50.475407 | debian-bookworm | ok 2025-05-23 18:00:50.533807 | debian-bookworm | included: /var/lib/zuul/builds/10bb537689e642f8a91343a5cb5efbf2/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-23 18:00:50.549857 | 2025-05-23 18:00:50.549992 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-23 18:00:53.379886 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-05-23 18:00:53.380143 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/10bb537689e642f8a91343a5cb5efbf2/work/10bb537689e642f8a91343a5cb5efbf2_id_rsa 2025-05-23 18:00:53.380184 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/10bb537689e642f8a91343a5cb5efbf2/work/10bb537689e642f8a91343a5cb5efbf2_id_rsa.pub 2025-05-23 18:00:53.380228 | debian-bookworm -> localhost | The key fingerprint is: 2025-05-23 18:00:53.380254 | debian-bookworm -> localhost | SHA256:F3V0C/IclCmTP+bxYjVVXhQgVZYgf11dpsju/mcOfc0 zuul-build-sshkey 2025-05-23 18:00:53.380291 | debian-bookworm -> localhost | The key's randomart image is: 2025-05-23 18:00:53.380313 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-05-23 18:00:53.380333 | debian-bookworm -> localhost | | +=OO=#| 2025-05-23 18:00:53.380355 | debian-bookworm -> localhost | | *B=+*B| 2025-05-23 18:00:53.380375 | debian-bookworm -> localhost | | . *+.o+| 2025-05-23 18:00:53.380394 | debian-bookworm -> localhost | | o =.o | 2025-05-23 18:00:53.380413 | debian-bookworm -> localhost | | S . + = .| 2025-05-23 18:00:53.380437 | debian-bookworm -> localhost | | . . + +.| 2025-05-23 18:00:53.380458 | debian-bookworm -> localhost | | o o E| 2025-05-23 18:00:53.380478 | debian-bookworm -> localhost | | . .+| 2025-05-23 18:00:53.380498 | debian-bookworm -> localhost | | ...+.| 2025-05-23 18:00:53.380518 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-05-23 18:00:53.380572 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.845856 2025-05-23 18:00:53.387228 | 2025-05-23 18:00:53.387346 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-23 18:00:53.425819 | debian-bookworm | ok 2025-05-23 18:00:53.441798 | debian-bookworm | included: /var/lib/zuul/builds/10bb537689e642f8a91343a5cb5efbf2/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-23 18:00:53.455489 | 2025-05-23 18:00:53.455603 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-23 18:00:53.479897 | debian-bookworm | skipping: Conditional result was False 2025-05-23 18:00:53.485826 | 2025-05-23 18:00:53.485930 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-23 18:00:54.137001 | debian-bookworm | changed 2025-05-23 18:00:54.142745 | 2025-05-23 18:00:54.142882 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-23 18:00:54.393369 | debian-bookworm | ok 2025-05-23 18:00:54.401853 | 2025-05-23 18:00:54.402036 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-23 18:00:55.070808 | debian-bookworm | changed 2025-05-23 18:00:55.078540 | 2025-05-23 18:00:55.078670 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-23 18:00:55.740409 | debian-bookworm | changed 2025-05-23 18:00:55.746001 | 2025-05-23 18:00:55.746114 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-23 18:00:55.778078 | debian-bookworm | skipping: Conditional result was False 2025-05-23 18:00:55.785462 | 2025-05-23 18:00:55.785595 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-23 18:00:56.327871 | debian-bookworm -> localhost | changed 2025-05-23 18:00:56.342271 | 2025-05-23 18:00:56.342425 | TASK [add-build-sshkey : Add back temp key] 2025-05-23 18:00:56.751734 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/10bb537689e642f8a91343a5cb5efbf2/work/10bb537689e642f8a91343a5cb5efbf2_id_rsa (zuul-build-sshkey) 2025-05-23 18:00:56.752002 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.023789 2025-05-23 18:00:56.761258 | 2025-05-23 18:00:56.761393 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-23 18:00:57.188357 | debian-bookworm | ok 2025-05-23 18:00:57.194108 | 2025-05-23 18:00:57.194274 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-23 18:00:57.238617 | debian-bookworm | skipping: Conditional result was False 2025-05-23 18:00:57.249557 | 2025-05-23 18:00:57.249690 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-23 18:00:57.757643 | debian-bookworm | ok 2025-05-23 18:00:57.771884 | 2025-05-23 18:00:57.772021 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-23 18:00:57.824713 | debian-bookworm | ok 2025-05-23 18:00:57.837364 | 2025-05-23 18:00:57.837502 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-23 18:00:58.236711 | debian-bookworm -> localhost | ok 2025-05-23 18:00:58.249623 | 2025-05-23 18:00:58.250370 | TASK [validate-host : Collect information about the host] 2025-05-23 18:00:59.382687 | debian-bookworm | ok 2025-05-23 18:00:59.394344 | 2025-05-23 18:00:59.394497 | TASK [validate-host : Sanitize hostname] 2025-05-23 18:00:59.505541 | debian-bookworm | ok 2025-05-23 18:00:59.545770 | 2025-05-23 18:00:59.545903 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-23 18:01:00.125227 | debian-bookworm -> localhost | changed 2025-05-23 18:01:00.131652 | 2025-05-23 18:01:00.131777 | TASK [validate-host : Collect information about zuul worker] 2025-05-23 18:01:00.578718 | debian-bookworm | ok 2025-05-23 18:01:00.583713 | 2025-05-23 18:01:00.583837 | TASK [validate-host : Write out all zuul information for each host] 2025-05-23 18:01:01.264305 | debian-bookworm -> localhost | changed 2025-05-23 18:01:01.286494 | 2025-05-23 18:01:01.286629 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-23 18:01:01.545113 | debian-bookworm | ok 2025-05-23 18:01:01.551319 | 2025-05-23 18:01:01.551461 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-23 18:01:02.403230 | debian-bookworm | changed: 2025-05-23 18:01:02.403463 | debian-bookworm | cd+++++++++ src/ 2025-05-23 18:01:02.403500 | debian-bookworm | cd+++++++++ src/github.com/ 2025-05-23 18:01:02.403524 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-05-23 18:01:02.403547 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-inventory-reconciler/ 2025-05-23 18:01:02.403569 | debian-bookworm | Containerfile 2025-05-23 18:01:02.403703 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007594 2025-05-23 18:02:38.956443 | 2025-05-23 18:02:38.956628 | TASK [upload-logs : Upload logs to log server] 2025-05-23 18:02:39.527219 | localhost | Output suppressed because no_log was given 2025-05-23 18:02:39.531169 | 2025-05-23 18:02:39.531392 | LOOP [upload-logs : Compress console log and json output] 2025-05-23 18:02:39.589684 | localhost | skipping: Conditional result was False 2025-05-23 18:02:39.595414 | localhost | skipping: Conditional result was False 2025-05-23 18:02:39.606396 | 2025-05-23 18:02:39.606666 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-23 18:02:39.669566 | localhost | skipping: Conditional result was False 2025-05-23 18:02:39.670138 | 2025-05-23 18:02:39.673474 | localhost | skipping: Conditional result was False 2025-05-23 18:02:39.681495 | 2025-05-23 18:02:39.681708 | LOOP [upload-logs : Upload console log and json output]