2025-06-12 02:40:58.505677 | Job console starting 2025-06-12 02:40:58.541460 | Updating git repos 2025-06-12 02:40:58.587991 | Cloning repos into workspace 2025-06-12 02:40:58.659745 | Restoring repo states 2025-06-12 02:40:58.684505 | Merging changes 2025-06-12 02:40:59.189742 | Checking out repos 2025-06-12 02:40:59.237312 | Preparing playbooks 2025-06-12 02:41:00.263131 | Running Ansible setup 2025-06-12 02:41:06.719904 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-12 02:41:07.895673 | 2025-06-12 02:41:07.895841 | PLAY [Base pre] 2025-06-12 02:41:07.911797 | 2025-06-12 02:41:07.911936 | TASK [Setup log path fact] 2025-06-12 02:41:07.940539 | debian-bookworm | ok 2025-06-12 02:41:07.962906 | 2025-06-12 02:41:07.963098 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-12 02:41:08.014486 | debian-bookworm | ok 2025-06-12 02:41:08.035270 | 2025-06-12 02:41:08.035419 | TASK [emit-job-header : Print job information] 2025-06-12 02:41:08.115547 | # Job Information 2025-06-12 02:41:08.115752 | Ansible Version: 2.16.14 2025-06-12 02:41:08.115788 | Job: container-image-python-osism-build 2025-06-12 02:41:08.115822 | Pipeline: check 2025-06-12 02:41:08.115845 | Executor: 521e9411259a 2025-06-12 02:41:08.115866 | Triggered by: https://github.com/osism/python-osism/pull/1410 2025-06-12 02:41:08.115889 | Event ID: a5e46460-4736-11f0-8fea-57ed43d906cb 2025-06-12 02:41:08.120945 | 2025-06-12 02:41:08.121106 | LOOP [emit-job-header : Print node information] 2025-06-12 02:41:08.294678 | debian-bookworm | ok: 2025-06-12 02:41:08.294937 | debian-bookworm | # Node Information 2025-06-12 02:41:08.294981 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-12 02:41:08.295008 | debian-bookworm | Hostname: debian 2025-06-12 02:41:08.295045 | debian-bookworm | Username: zuul 2025-06-12 02:41:08.295066 | debian-bookworm | Distro: Debian 12.11 2025-06-12 02:41:08.295091 | debian-bookworm | Provider: regiocloud-a 2025-06-12 02:41:08.295113 | debian-bookworm | Region: 2025-06-12 02:41:08.295135 | debian-bookworm | Label: debian-bookworm 2025-06-12 02:41:08.295155 | debian-bookworm | Product Name: OpenStack Nova 2025-06-12 02:41:08.295174 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe98:c1ed 2025-06-12 02:41:08.312081 | 2025-06-12 02:41:08.312221 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-12 02:41:09.014971 | debian-bookworm -> localhost | changed 2025-06-12 02:41:09.022422 | 2025-06-12 02:41:09.022549 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-12 02:41:10.640150 | debian-bookworm -> localhost | changed 2025-06-12 02:41:10.667386 | 2025-06-12 02:41:10.667503 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-12 02:41:11.032689 | debian-bookworm -> localhost | ok 2025-06-12 02:41:11.038631 | 2025-06-12 02:41:11.038735 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-12 02:41:11.067201 | debian-bookworm | ok 2025-06-12 02:41:11.115085 | debian-bookworm | included: /var/lib/zuul/builds/a2c596b4568540c0a3f2d121ad1ebc44/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-12 02:41:11.131396 | 2025-06-12 02:41:11.131501 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-12 02:41:12.819468 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-12 02:41:12.819659 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/a2c596b4568540c0a3f2d121ad1ebc44/work/a2c596b4568540c0a3f2d121ad1ebc44_id_rsa 2025-06-12 02:41:12.819839 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/a2c596b4568540c0a3f2d121ad1ebc44/work/a2c596b4568540c0a3f2d121ad1ebc44_id_rsa.pub 2025-06-12 02:41:12.819884 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-12 02:41:12.819913 | debian-bookworm -> localhost | SHA256:NMVdInqUxMIFWJLWGsUwNsLIASyY+8vnRz5N99zIgEo zuul-build-sshkey 2025-06-12 02:41:12.819949 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-12 02:41:12.819976 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-12 02:41:12.820000 | debian-bookworm -> localhost | |++.+. *X+**o... | 2025-06-12 02:41:12.820047 | debian-bookworm -> localhost | |+.o .o=+=++... | 2025-06-12 02:41:12.820073 | debian-bookworm -> localhost | |.. . o+.. | 2025-06-12 02:41:12.820096 | debian-bookworm -> localhost | |. .. o | 2025-06-12 02:41:12.820119 | debian-bookworm -> localhost | | . S. | 2025-06-12 02:41:12.820143 | debian-bookworm -> localhost | | . E o o | 2025-06-12 02:41:12.820164 | debian-bookworm -> localhost | | . . + + . = o | 2025-06-12 02:41:12.820245 | debian-bookworm -> localhost | | o . = . = . | 2025-06-12 02:41:12.820270 | debian-bookworm -> localhost | | o.. . | 2025-06-12 02:41:12.820292 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-12 02:41:12.820344 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.909816 2025-06-12 02:41:12.827848 | 2025-06-12 02:41:12.827940 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-12 02:41:12.868982 | debian-bookworm | ok 2025-06-12 02:41:12.886943 | debian-bookworm | included: /var/lib/zuul/builds/a2c596b4568540c0a3f2d121ad1ebc44/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-12 02:41:12.910301 | 2025-06-12 02:41:12.910402 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-12 02:41:12.957756 | debian-bookworm | skipping: Conditional result was False 2025-06-12 02:41:12.964604 | 2025-06-12 02:41:12.964721 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-12 02:41:13.666475 | debian-bookworm | changed 2025-06-12 02:41:13.672799 | 2025-06-12 02:41:13.672895 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-12 02:41:13.943666 | debian-bookworm | ok 2025-06-12 02:41:13.950401 | 2025-06-12 02:41:13.950499 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-12 02:41:14.621519 | debian-bookworm | changed 2025-06-12 02:41:14.628134 | 2025-06-12 02:41:14.628231 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-12 02:41:15.258313 | debian-bookworm | changed 2025-06-12 02:41:15.263743 | 2025-06-12 02:41:15.263836 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-12 02:41:15.313222 | debian-bookworm | skipping: Conditional result was False 2025-06-12 02:41:15.319658 | 2025-06-12 02:41:15.319755 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-12 02:41:15.829745 | debian-bookworm -> localhost | changed 2025-06-12 02:41:15.845141 | 2025-06-12 02:41:15.845293 | TASK [add-build-sshkey : Add back temp key] 2025-06-12 02:41:16.240258 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/a2c596b4568540c0a3f2d121ad1ebc44/work/a2c596b4568540c0a3f2d121ad1ebc44_id_rsa (zuul-build-sshkey) 2025-06-12 02:41:16.240503 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.017206 2025-06-12 02:41:16.248753 | 2025-06-12 02:41:16.248875 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-12 02:41:16.753651 | debian-bookworm | ok 2025-06-12 02:41:16.758936 | 2025-06-12 02:41:16.759078 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-12 02:41:16.792546 | debian-bookworm | skipping: Conditional result was False 2025-06-12 02:41:16.806259 | 2025-06-12 02:41:16.806386 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-12 02:41:17.260238 | debian-bookworm | ok 2025-06-12 02:41:17.272276 | 2025-06-12 02:41:17.272419 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-12 02:41:17.301441 | debian-bookworm | ok 2025-06-12 02:41:17.307156 | 2025-06-12 02:41:17.307275 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-12 02:41:17.626272 | debian-bookworm -> localhost | ok 2025-06-12 02:41:17.632968 | 2025-06-12 02:41:17.633109 | TASK [validate-host : Collect information about the host] 2025-06-12 02:41:18.855450 | debian-bookworm | ok 2025-06-12 02:41:18.875504 | 2025-06-12 02:41:18.875645 | TASK [validate-host : Sanitize hostname] 2025-06-12 02:41:18.986932 | debian-bookworm | ok 2025-06-12 02:41:19.031190 | 2025-06-12 02:41:19.031341 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-12 02:41:19.814114 | debian-bookworm -> localhost | changed 2025-06-12 02:41:19.825042 | 2025-06-12 02:41:19.825199 | TASK [validate-host : Collect information about zuul worker] 2025-06-12 02:41:20.270329 | debian-bookworm | ok 2025-06-12 02:41:20.276595 | 2025-06-12 02:41:20.276730 | TASK [validate-host : Write out all zuul information for each host] 2025-06-12 02:41:21.169983 | debian-bookworm -> localhost | changed 2025-06-12 02:41:21.180250 | 2025-06-12 02:41:21.180375 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-12 02:41:21.465211 | debian-bookworm | ok 2025-06-12 02:41:21.480183 | 2025-06-12 02:41:21.480318 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-12 02:41:22.639003 | debian-bookworm | changed: 2025-06-12 02:41:22.639267 | debian-bookworm | cd+++++++++ src/ 2025-06-12 02:41:22.639303 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-12 02:41:22.639327 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-12 02:41:22.639349 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-06-12 02:41:22.639369 | debian-bookworm | Containerfile 2025-06-12 02:41:22.639484 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007907 2025-06-12 02:43:45.196594 | 2025-06-12 02:43:45.196709 | TASK [upload-logs : Upload logs to log server] 2025-06-12 02:43:45.777863 | localhost | Output suppressed because no_log was given 2025-06-12 02:43:45.782711 | 2025-06-12 02:43:45.783055 | LOOP [upload-logs : Compress console log and json output] 2025-06-12 02:43:45.845827 | localhost | skipping: Conditional result was False 2025-06-12 02:43:45.850675 | localhost | skipping: Conditional result was False 2025-06-12 02:43:45.865905 | 2025-06-12 02:43:45.866135 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-12 02:43:45.914702 | localhost | skipping: Conditional result was False 2025-06-12 02:43:45.915453 | 2025-06-12 02:43:45.918717 | localhost | skipping: Conditional result was False 2025-06-12 02:43:45.926694 | 2025-06-12 02:43:45.926934 | LOOP [upload-logs : Upload console log and json output]