2025-06-29 18:13:20.848118 | Job console starting 2025-06-29 18:13:20.894363 | Updating git repos 2025-06-29 18:13:20.962147 | Cloning repos into workspace 2025-06-29 18:13:21.001782 | Restoring repo states 2025-06-29 18:13:21.016631 | Merging changes 2025-06-29 18:13:21.568421 | Checking out repos 2025-06-29 18:13:21.654665 | Preparing playbooks 2025-06-29 18:13:22.798767 | Running Ansible setup 2025-06-29 18:13:27.884023 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-29 18:13:28.714937 | 2025-06-29 18:13:28.715122 | PLAY [Base pre] 2025-06-29 18:13:28.751683 | 2025-06-29 18:13:28.751850 | TASK [Setup log path fact] 2025-06-29 18:13:28.771787 | debian-bookworm | ok 2025-06-29 18:13:28.786888 | 2025-06-29 18:13:28.787042 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-29 18:13:28.817134 | debian-bookworm | ok 2025-06-29 18:13:28.835347 | 2025-06-29 18:13:28.835495 | TASK [emit-job-header : Print job information] 2025-06-29 18:13:28.897632 | # Job Information 2025-06-29 18:13:28.897826 | Ansible Version: 2.16.14 2025-06-29 18:13:28.897862 | Job: container-image-python-osism-build 2025-06-29 18:13:28.897895 | Pipeline: check 2025-06-29 18:13:28.897919 | Executor: 521e9411259a 2025-06-29 18:13:28.897940 | Triggered by: https://github.com/osism/python-osism/pull/1525 2025-06-29 18:13:28.897965 | Event ID: b820f580-5514-11f0-85bf-5e249238d339 2025-06-29 18:13:28.915228 | 2025-06-29 18:13:28.915369 | LOOP [emit-job-header : Print node information] 2025-06-29 18:13:29.064740 | debian-bookworm | ok: 2025-06-29 18:13:29.065112 | debian-bookworm | # Node Information 2025-06-29 18:13:29.065163 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-29 18:13:29.065190 | debian-bookworm | Hostname: debian 2025-06-29 18:13:29.065213 | debian-bookworm | Username: zuul 2025-06-29 18:13:29.065234 | debian-bookworm | Distro: Debian 12.11 2025-06-29 18:13:29.065258 | debian-bookworm | Provider: regiocloud-a 2025-06-29 18:13:29.065279 | debian-bookworm | Region: 2025-06-29 18:13:29.065301 | debian-bookworm | Label: debian-bookworm 2025-06-29 18:13:29.065320 | debian-bookworm | Product Name: OpenStack Nova 2025-06-29 18:13:29.065340 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe12:5652 2025-06-29 18:13:29.086480 | 2025-06-29 18:13:29.086634 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-29 18:13:29.953760 | debian-bookworm -> localhost | changed 2025-06-29 18:13:29.961310 | 2025-06-29 18:13:29.961440 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-29 18:13:31.597709 | debian-bookworm -> localhost | changed 2025-06-29 18:13:31.612922 | 2025-06-29 18:13:31.613119 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-29 18:13:32.167251 | debian-bookworm -> localhost | ok 2025-06-29 18:13:32.173605 | 2025-06-29 18:13:32.173738 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-29 18:13:32.213727 | debian-bookworm | ok 2025-06-29 18:13:32.249776 | debian-bookworm | included: /var/lib/zuul/builds/b3ecce049dea44dd939ed445a6421cf9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-29 18:13:32.264580 | 2025-06-29 18:13:32.264717 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-29 18:13:33.778513 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-29 18:13:33.778746 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/b3ecce049dea44dd939ed445a6421cf9/work/b3ecce049dea44dd939ed445a6421cf9_id_rsa 2025-06-29 18:13:33.778788 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/b3ecce049dea44dd939ed445a6421cf9/work/b3ecce049dea44dd939ed445a6421cf9_id_rsa.pub 2025-06-29 18:13:33.778814 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-29 18:13:33.778854 | debian-bookworm -> localhost | SHA256:XWpYSl2oKE5VLpC4BmeMNYuH/956gX9ZS9NYfvmFfQM zuul-build-sshkey 2025-06-29 18:13:33.778885 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-29 18:13:33.778909 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-29 18:13:33.778931 | debian-bookworm -> localhost | | +o... .. .. | 2025-06-29 18:13:33.778953 | debian-bookworm -> localhost | |oo=o.... ... | 2025-06-29 18:13:33.778973 | debian-bookworm -> localhost | |o+o. ...o.o . | 2025-06-29 18:13:33.778993 | debian-bookworm -> localhost | | oo o .o.= o.E | 2025-06-29 18:13:33.779012 | debian-bookworm -> localhost | | ..o o S += .+ | 2025-06-29 18:13:33.779035 | debian-bookworm -> localhost | | .o . .= o +.+| 2025-06-29 18:13:33.779081 | debian-bookworm -> localhost | | .. . + o . .+| 2025-06-29 18:13:33.779105 | debian-bookworm -> localhost | | . .o o . .| 2025-06-29 18:13:33.779127 | debian-bookworm -> localhost | | oo.. | 2025-06-29 18:13:33.779147 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-29 18:13:33.779202 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.541932 2025-06-29 18:13:33.785179 | 2025-06-29 18:13:33.785270 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-29 18:13:33.802147 | debian-bookworm | ok 2025-06-29 18:13:33.810764 | debian-bookworm | included: /var/lib/zuul/builds/b3ecce049dea44dd939ed445a6421cf9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-29 18:13:33.819213 | 2025-06-29 18:13:33.819290 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-29 18:13:33.831657 | debian-bookworm | skipping: Conditional result was False 2025-06-29 18:13:33.837029 | 2025-06-29 18:13:33.837124 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-29 18:13:34.446253 | debian-bookworm | changed 2025-06-29 18:13:34.451520 | 2025-06-29 18:13:34.451646 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-29 18:13:34.703704 | debian-bookworm | ok 2025-06-29 18:13:34.716249 | 2025-06-29 18:13:34.716419 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-29 18:13:35.351284 | debian-bookworm | changed 2025-06-29 18:13:35.360476 | 2025-06-29 18:13:35.360575 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-29 18:13:36.002522 | debian-bookworm | changed 2025-06-29 18:13:36.011451 | 2025-06-29 18:13:36.011580 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-29 18:13:36.045164 | debian-bookworm | skipping: Conditional result was False 2025-06-29 18:13:36.054451 | 2025-06-29 18:13:36.054574 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-29 18:13:36.479609 | debian-bookworm -> localhost | changed 2025-06-29 18:13:36.490592 | 2025-06-29 18:13:36.490692 | TASK [add-build-sshkey : Add back temp key] 2025-06-29 18:13:36.779617 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/b3ecce049dea44dd939ed445a6421cf9/work/b3ecce049dea44dd939ed445a6421cf9_id_rsa (zuul-build-sshkey) 2025-06-29 18:13:36.779828 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011850 2025-06-29 18:13:36.787555 | 2025-06-29 18:13:36.787640 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-29 18:13:37.201645 | debian-bookworm | ok 2025-06-29 18:13:37.209374 | 2025-06-29 18:13:37.209601 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-29 18:13:37.235929 | debian-bookworm | skipping: Conditional result was False 2025-06-29 18:13:37.267569 | 2025-06-29 18:13:37.267716 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-29 18:13:37.766974 | debian-bookworm | ok 2025-06-29 18:13:37.779183 | 2025-06-29 18:13:37.779328 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-29 18:13:37.808224 | debian-bookworm | ok 2025-06-29 18:13:37.813518 | 2025-06-29 18:13:37.813647 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-29 18:13:38.215690 | debian-bookworm -> localhost | ok 2025-06-29 18:13:38.222504 | 2025-06-29 18:13:38.222628 | TASK [validate-host : Collect information about the host] 2025-06-29 18:13:39.402021 | debian-bookworm | ok 2025-06-29 18:13:39.417782 | 2025-06-29 18:13:39.417918 | TASK [validate-host : Sanitize hostname] 2025-06-29 18:13:39.579878 | debian-bookworm | ok 2025-06-29 18:13:39.625941 | 2025-06-29 18:13:39.626141 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-29 18:13:40.340338 | debian-bookworm -> localhost | changed 2025-06-29 18:13:40.346240 | 2025-06-29 18:13:40.346357 | TASK [validate-host : Collect information about zuul worker] 2025-06-29 18:13:40.885382 | debian-bookworm | ok 2025-06-29 18:13:40.890522 | 2025-06-29 18:13:40.890652 | TASK [validate-host : Write out all zuul information for each host] 2025-06-29 18:13:41.612607 | debian-bookworm -> localhost | changed 2025-06-29 18:13:41.626719 | 2025-06-29 18:13:41.626886 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-29 18:13:41.950604 | debian-bookworm | ok 2025-06-29 18:13:41.956391 | 2025-06-29 18:13:41.956516 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-29 18:13:42.973547 | debian-bookworm | changed: 2025-06-29 18:13:42.973760 | debian-bookworm | cd+++++++++ src/ 2025-06-29 18:13:42.973796 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-29 18:13:42.973821 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-29 18:13:42.973843 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-06-29 18:13:42.973865 | debian-bookworm | Containerfile 2025-06-29 18:13:42.973980 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007321 2025-06-29 18:19:04.174125 | 2025-06-29 18:19:04.174337 | TASK [upload-logs : Upload logs to log server] 2025-06-29 18:19:04.755289 | localhost | Output suppressed because no_log was given 2025-06-29 18:19:04.759507 | 2025-06-29 18:19:04.759679 | LOOP [upload-logs : Compress console log and json output] 2025-06-29 18:19:04.807819 | localhost | skipping: Conditional result was False 2025-06-29 18:19:04.812683 | localhost | skipping: Conditional result was False 2025-06-29 18:19:04.825419 | 2025-06-29 18:19:04.825663 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-29 18:19:04.872099 | localhost | skipping: Conditional result was False 2025-06-29 18:19:04.872702 | 2025-06-29 18:19:04.876229 | localhost | skipping: Conditional result was False 2025-06-29 18:19:04.888536 | 2025-06-29 18:19:04.888771 | LOOP [upload-logs : Upload console log and json output]