2025-06-12 08:01:58.796631 | Job console starting 2025-06-12 08:01:58.826454 | Updating git repos 2025-06-12 08:01:58.896097 | Cloning repos into workspace 2025-06-12 08:01:58.961543 | Restoring repo states 2025-06-12 08:01:58.975062 | Merging changes 2025-06-12 08:01:59.439118 | Checking out repos 2025-06-12 08:01:59.534713 | Preparing playbooks 2025-06-12 08:02:00.465670 | Running Ansible setup 2025-06-12 08:02:05.727263 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-12 08:02:07.255727 | 2025-06-12 08:02:07.255905 | PLAY [Base pre] 2025-06-12 08:02:07.272078 | 2025-06-12 08:02:07.272224 | TASK [Setup log path fact] 2025-06-12 08:02:07.291805 | debian-bookworm | ok 2025-06-12 08:02:07.324478 | 2025-06-12 08:02:07.324719 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-12 08:02:07.373612 | debian-bookworm | ok 2025-06-12 08:02:07.388199 | 2025-06-12 08:02:07.388349 | TASK [emit-job-header : Print job information] 2025-06-12 08:02:07.470779 | # Job Information 2025-06-12 08:02:07.471047 | Ansible Version: 2.16.14 2025-06-12 08:02:07.471089 | Job: container-image-python-osism-build 2025-06-12 08:02:07.471124 | Pipeline: check 2025-06-12 08:02:07.471147 | Executor: 521e9411259a 2025-06-12 08:02:07.471169 | Triggered by: https://github.com/osism/python-osism/pull/1405 2025-06-12 08:02:07.471192 | Event ID: 7e89cd60-4763-11f0-893c-be1138a49dba 2025-06-12 08:02:07.480085 | 2025-06-12 08:02:07.480240 | LOOP [emit-job-header : Print node information] 2025-06-12 08:02:07.803702 | debian-bookworm | ok: 2025-06-12 08:02:07.804036 | debian-bookworm | # Node Information 2025-06-12 08:02:07.804078 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-12 08:02:07.804104 | debian-bookworm | Hostname: debian 2025-06-12 08:02:07.804127 | debian-bookworm | Username: zuul 2025-06-12 08:02:07.804148 | debian-bookworm | Distro: Debian 12.11 2025-06-12 08:02:07.804171 | debian-bookworm | Provider: regiocloud-a 2025-06-12 08:02:07.804193 | debian-bookworm | Region: 2025-06-12 08:02:07.804214 | debian-bookworm | Label: debian-bookworm 2025-06-12 08:02:07.804233 | debian-bookworm | Product Name: OpenStack Nova 2025-06-12 08:02:07.804253 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe33:659f 2025-06-12 08:02:07.836218 | 2025-06-12 08:02:07.836392 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-12 08:02:09.099879 | debian-bookworm -> localhost | changed 2025-06-12 08:02:09.125948 | 2025-06-12 08:02:09.126129 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-12 08:02:12.009657 | debian-bookworm -> localhost | changed 2025-06-12 08:02:12.103724 | 2025-06-12 08:02:12.104518 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-12 08:02:12.845728 | debian-bookworm -> localhost | ok 2025-06-12 08:02:12.878116 | 2025-06-12 08:02:12.878278 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-12 08:02:12.967577 | debian-bookworm | ok 2025-06-12 08:02:13.064556 | debian-bookworm | included: /var/lib/zuul/builds/23709f25ba144be5a9ec1da689cc4293/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-12 08:02:13.129470 | 2025-06-12 08:02:13.129736 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-12 08:02:15.283095 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-12 08:02:15.283444 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/23709f25ba144be5a9ec1da689cc4293/work/23709f25ba144be5a9ec1da689cc4293_id_rsa 2025-06-12 08:02:15.283493 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/23709f25ba144be5a9ec1da689cc4293/work/23709f25ba144be5a9ec1da689cc4293_id_rsa.pub 2025-06-12 08:02:15.283559 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-12 08:02:15.283587 | debian-bookworm -> localhost | SHA256:uLS/7sSsE2qNeERsU7t7ODP6U/XaofMS40P2L1MpEoY zuul-build-sshkey 2025-06-12 08:02:15.283623 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-12 08:02:15.283645 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-12 08:02:15.283667 | debian-bookworm -> localhost | | | 2025-06-12 08:02:15.283689 | debian-bookworm -> localhost | | . | 2025-06-12 08:02:15.283709 | debian-bookworm -> localhost | | . . . . | 2025-06-12 08:02:15.283730 | debian-bookworm -> localhost | | = ..E + | 2025-06-12 08:02:15.283750 | debian-bookworm -> localhost | | o .o.So o . | 2025-06-12 08:02:15.283777 | debian-bookworm -> localhost | | ..o=. * + o | 2025-06-12 08:02:15.283798 | debian-bookworm -> localhost | | o +o=++ O + | 2025-06-12 08:02:15.283817 | debian-bookworm -> localhost | | . = X+. B = | 2025-06-12 08:02:15.283887 | debian-bookworm -> localhost | | o.ooX=. =.+. | 2025-06-12 08:02:15.283914 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-12 08:02:15.283979 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.964467 2025-06-12 08:02:15.291071 | 2025-06-12 08:02:15.291184 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-12 08:02:15.336580 | debian-bookworm | ok 2025-06-12 08:02:15.355764 | debian-bookworm | included: /var/lib/zuul/builds/23709f25ba144be5a9ec1da689cc4293/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-12 08:02:15.373731 | 2025-06-12 08:02:15.373910 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-12 08:02:15.409992 | debian-bookworm | skipping: Conditional result was False 2025-06-12 08:02:15.427275 | 2025-06-12 08:02:15.427466 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-12 08:02:16.182016 | debian-bookworm | changed 2025-06-12 08:02:16.189215 | 2025-06-12 08:02:16.189335 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-12 08:02:16.479094 | debian-bookworm | ok 2025-06-12 08:02:16.489464 | 2025-06-12 08:02:16.490001 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-12 08:02:17.259308 | debian-bookworm | changed 2025-06-12 08:02:17.273087 | 2025-06-12 08:02:17.273396 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-12 08:02:17.965980 | debian-bookworm | changed 2025-06-12 08:02:17.974494 | 2025-06-12 08:02:17.974992 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-12 08:02:18.003314 | debian-bookworm | skipping: Conditional result was False 2025-06-12 08:02:18.020776 | 2025-06-12 08:02:18.021511 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-12 08:02:18.791049 | debian-bookworm -> localhost | changed 2025-06-12 08:02:18.807072 | 2025-06-12 08:02:18.807265 | TASK [add-build-sshkey : Add back temp key] 2025-06-12 08:02:19.288215 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/23709f25ba144be5a9ec1da689cc4293/work/23709f25ba144be5a9ec1da689cc4293_id_rsa (zuul-build-sshkey) 2025-06-12 08:02:19.288651 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011159 2025-06-12 08:02:19.300238 | 2025-06-12 08:02:19.301479 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-12 08:02:19.756017 | debian-bookworm | ok 2025-06-12 08:02:19.773389 | 2025-06-12 08:02:19.774155 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-12 08:02:19.808646 | debian-bookworm | skipping: Conditional result was False 2025-06-12 08:02:19.836034 | 2025-06-12 08:02:19.836194 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-12 08:02:20.549318 | debian-bookworm | ok 2025-06-12 08:02:20.567396 | 2025-06-12 08:02:20.567596 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-12 08:02:20.614988 | debian-bookworm | ok 2025-06-12 08:02:20.628818 | 2025-06-12 08:02:20.628941 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-12 08:02:20.956482 | debian-bookworm -> localhost | ok 2025-06-12 08:02:20.963923 | 2025-06-12 08:02:20.964106 | TASK [validate-host : Collect information about the host] 2025-06-12 08:02:22.216190 | debian-bookworm | ok 2025-06-12 08:02:22.266407 | 2025-06-12 08:02:22.267333 | TASK [validate-host : Sanitize hostname] 2025-06-12 08:02:22.485924 | debian-bookworm | ok 2025-06-12 08:02:22.608398 | 2025-06-12 08:02:22.608542 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-12 08:02:23.430805 | debian-bookworm -> localhost | changed 2025-06-12 08:02:23.437036 | 2025-06-12 08:02:23.437163 | TASK [validate-host : Collect information about zuul worker] 2025-06-12 08:02:23.874799 | debian-bookworm | ok 2025-06-12 08:02:23.880444 | 2025-06-12 08:02:23.880576 | TASK [validate-host : Write out all zuul information for each host] 2025-06-12 08:02:24.568521 | debian-bookworm -> localhost | changed 2025-06-12 08:02:24.584153 | 2025-06-12 08:02:24.585793 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-12 08:02:24.853932 | debian-bookworm | ok 2025-06-12 08:02:24.859926 | 2025-06-12 08:02:24.860045 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-12 08:02:26.087161 | debian-bookworm | changed: 2025-06-12 08:02:26.087388 | debian-bookworm | cd+++++++++ src/ 2025-06-12 08:02:26.087424 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-12 08:02:26.087449 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-12 08:02:26.087470 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-06-12 08:02:26.087491 | debian-bookworm | Containerfile 2025-06-12 08:02:26.087605 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007149 2025-06-12 08:06:48.279928 | 2025-06-12 08:06:48.280045 | TASK [upload-logs : Upload logs to log server] 2025-06-12 08:06:48.878035 | localhost | Output suppressed because no_log was given 2025-06-12 08:06:48.881457 | 2025-06-12 08:06:48.881623 | LOOP [upload-logs : Compress console log and json output] 2025-06-12 08:06:48.956033 | localhost | skipping: Conditional result was False 2025-06-12 08:06:48.964055 | localhost | skipping: Conditional result was False 2025-06-12 08:06:48.970878 | 2025-06-12 08:06:48.970997 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-12 08:06:49.028510 | localhost | skipping: Conditional result was False 2025-06-12 08:06:49.029093 | 2025-06-12 08:06:49.033225 | localhost | skipping: Conditional result was False 2025-06-12 08:06:49.043468 | 2025-06-12 08:06:49.043586 | LOOP [upload-logs : Upload console log and json output]