2025-06-09 19:56:24.969118 | Job console starting 2025-06-09 19:56:24.992198 | Updating git repos 2025-06-09 19:56:25.048343 | Cloning repos into workspace 2025-06-09 19:56:25.147060 | Restoring repo states 2025-06-09 19:56:25.169437 | Merging changes 2025-06-09 19:56:25.691103 | Checking out repos 2025-06-09 19:56:25.799578 | Preparing playbooks 2025-06-09 19:56:26.953325 | Running Ansible setup 2025-06-09 19:56:32.979092 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-09 19:56:34.905619 | 2025-06-09 19:56:34.905787 | PLAY [Base pre] 2025-06-09 19:56:34.951761 | 2025-06-09 19:56:34.951934 | TASK [Setup log path fact] 2025-06-09 19:56:34.987547 | debian-bookworm | ok 2025-06-09 19:56:35.022750 | 2025-06-09 19:56:35.052770 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-09 19:56:35.120049 | debian-bookworm | ok 2025-06-09 19:56:35.139441 | 2025-06-09 19:56:35.139583 | TASK [emit-job-header : Print job information] 2025-06-09 19:56:35.249064 | # Job Information 2025-06-09 19:56:35.249472 | Ansible Version: 2.16.14 2025-06-09 19:56:35.249539 | Job: container-image-python-osism-build 2025-06-09 19:56:35.249574 | Pipeline: check 2025-06-09 19:56:35.249598 | Executor: 521e9411259a 2025-06-09 19:56:35.249620 | Triggered by: https://github.com/osism/python-osism/pull/1404 2025-06-09 19:56:35.249643 | Event ID: cc64f130-456b-11f0-99e7-8698883cdc92 2025-06-09 19:56:35.263025 | 2025-06-09 19:56:35.263635 | LOOP [emit-job-header : Print node information] 2025-06-09 19:56:35.523817 | debian-bookworm | ok: 2025-06-09 19:56:35.524148 | debian-bookworm | # Node Information 2025-06-09 19:56:35.524196 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-09 19:56:35.524223 | debian-bookworm | Hostname: debian 2025-06-09 19:56:35.524246 | debian-bookworm | Username: zuul 2025-06-09 19:56:35.524268 | debian-bookworm | Distro: Debian 12.11 2025-06-09 19:56:35.524300 | debian-bookworm | Provider: regiocloud-a 2025-06-09 19:56:35.524369 | debian-bookworm | Region: 2025-06-09 19:56:35.524466 | debian-bookworm | Label: debian-bookworm 2025-06-09 19:56:35.524492 | debian-bookworm | Product Name: OpenStack Nova 2025-06-09 19:56:35.524514 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fefd:a5ab 2025-06-09 19:56:35.546669 | 2025-06-09 19:56:35.547313 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-09 19:56:36.511005 | debian-bookworm -> localhost | changed 2025-06-09 19:56:36.521378 | 2025-06-09 19:56:36.521589 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-09 19:56:39.115410 | debian-bookworm -> localhost | changed 2025-06-09 19:56:39.132284 | 2025-06-09 19:56:39.132678 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-09 19:56:39.684020 | debian-bookworm -> localhost | ok 2025-06-09 19:56:39.691467 | 2025-06-09 19:56:39.691693 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-09 19:56:39.724646 | debian-bookworm | ok 2025-06-09 19:56:39.803423 | debian-bookworm | included: /var/lib/zuul/builds/fbc84b490f3b4de1b20eadc16dce2bd9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-09 19:56:39.817373 | 2025-06-09 19:56:39.817518 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-09 19:56:43.684023 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-09 19:56:43.684265 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/fbc84b490f3b4de1b20eadc16dce2bd9/work/fbc84b490f3b4de1b20eadc16dce2bd9_id_rsa 2025-06-09 19:56:43.684307 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/fbc84b490f3b4de1b20eadc16dce2bd9/work/fbc84b490f3b4de1b20eadc16dce2bd9_id_rsa.pub 2025-06-09 19:56:43.684352 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-09 19:56:43.684377 | debian-bookworm -> localhost | SHA256:kqneZypqTSKM9hNFvK+87c+NL/Zf2J9Kp/+yesF/nWo zuul-build-sshkey 2025-06-09 19:56:43.684418 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-09 19:56:43.684440 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-09 19:56:43.684462 | debian-bookworm -> localhost | | . | 2025-06-09 19:56:43.684482 | debian-bookworm -> localhost | | o | 2025-06-09 19:56:43.684502 | debian-bookworm -> localhost | | . . | 2025-06-09 19:56:43.684521 | debian-bookworm -> localhost | | o o | 2025-06-09 19:56:43.684541 | debian-bookworm -> localhost | |o . = S . | 2025-06-09 19:56:43.684566 | debian-bookworm -> localhost | |oo.... o = | 2025-06-09 19:56:43.684586 | debian-bookworm -> localhost | |...++ . o *o| 2025-06-09 19:56:43.684605 | debian-bookworm -> localhost | | .+o+. +oo .E*.*| 2025-06-09 19:56:43.684626 | debian-bookworm -> localhost | | ...oo=*o++++B===| 2025-06-09 19:56:43.684647 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-09 19:56:43.684696 | debian-bookworm -> localhost | ok: Runtime: 0:00:03.094679 2025-06-09 19:56:43.691510 | 2025-06-09 19:56:43.691639 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-09 19:56:43.720192 | debian-bookworm | ok 2025-06-09 19:56:43.735727 | debian-bookworm | included: /var/lib/zuul/builds/fbc84b490f3b4de1b20eadc16dce2bd9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-09 19:56:43.744853 | 2025-06-09 19:56:43.744964 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-09 19:56:43.768982 | debian-bookworm | skipping: Conditional result was False 2025-06-09 19:56:43.775037 | 2025-06-09 19:56:43.775151 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-09 19:56:44.464810 | debian-bookworm | changed 2025-06-09 19:56:44.473574 | 2025-06-09 19:56:44.473698 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-09 19:56:44.753667 | debian-bookworm | ok 2025-06-09 19:56:44.770658 | 2025-06-09 19:56:44.770794 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-09 19:56:45.530935 | debian-bookworm | changed 2025-06-09 19:56:45.539078 | 2025-06-09 19:56:45.539207 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-09 19:56:46.199188 | debian-bookworm | changed 2025-06-09 19:56:46.204931 | 2025-06-09 19:56:46.205055 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-09 19:56:46.268098 | debian-bookworm | skipping: Conditional result was False 2025-06-09 19:56:46.283516 | 2025-06-09 19:56:46.283654 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-09 19:56:46.897819 | debian-bookworm -> localhost | changed 2025-06-09 19:56:46.909727 | 2025-06-09 19:56:46.909863 | TASK [add-build-sshkey : Add back temp key] 2025-06-09 19:56:47.321170 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/fbc84b490f3b4de1b20eadc16dce2bd9/work/fbc84b490f3b4de1b20eadc16dce2bd9_id_rsa (zuul-build-sshkey) 2025-06-09 19:56:47.321450 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.037018 2025-06-09 19:56:47.329744 | 2025-06-09 19:56:47.329855 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-09 19:56:47.851482 | debian-bookworm | ok 2025-06-09 19:56:47.857011 | 2025-06-09 19:56:47.857125 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-09 19:56:47.882600 | debian-bookworm | skipping: Conditional result was False 2025-06-09 19:56:47.903718 | 2025-06-09 19:56:47.903859 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-09 19:56:48.347272 | debian-bookworm | ok 2025-06-09 19:56:48.366881 | 2025-06-09 19:56:48.367026 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-09 19:56:48.408924 | debian-bookworm | ok 2025-06-09 19:56:48.414260 | 2025-06-09 19:56:48.414402 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-09 19:56:48.918117 | debian-bookworm -> localhost | ok 2025-06-09 19:56:48.925307 | 2025-06-09 19:56:48.925449 | TASK [validate-host : Collect information about the host] 2025-06-09 19:56:50.180513 | debian-bookworm | ok 2025-06-09 19:56:50.202122 | 2025-06-09 19:56:50.202257 | TASK [validate-host : Sanitize hostname] 2025-06-09 19:56:50.380202 | debian-bookworm | ok 2025-06-09 19:56:50.434201 | 2025-06-09 19:56:50.434382 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-09 19:56:51.272534 | debian-bookworm -> localhost | changed 2025-06-09 19:56:51.279709 | 2025-06-09 19:56:51.279843 | TASK [validate-host : Collect information about zuul worker] 2025-06-09 19:56:51.724386 | debian-bookworm | ok 2025-06-09 19:56:51.729631 | 2025-06-09 19:56:51.729755 | TASK [validate-host : Write out all zuul information for each host] 2025-06-09 19:56:52.620119 | debian-bookworm -> localhost | changed 2025-06-09 19:56:52.630427 | 2025-06-09 19:56:52.630549 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-09 19:56:52.931904 | debian-bookworm | ok 2025-06-09 19:56:52.939872 | 2025-06-09 19:56:52.939999 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-09 19:56:54.042595 | debian-bookworm | changed: 2025-06-09 19:56:54.042937 | debian-bookworm | cd+++++++++ src/ 2025-06-09 19:56:54.043012 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-09 19:56:54.043086 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-09 19:56:54.043136 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-06-09 19:56:54.043173 | debian-bookworm | Containerfile 2025-06-09 19:56:54.043444 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007760 2025-06-09 20:01:20.881691 | 2025-06-09 20:01:20.881970 | TASK [upload-logs : Upload logs to log server] 2025-06-09 20:01:21.491065 | localhost | Output suppressed because no_log was given 2025-06-09 20:01:21.493385 | 2025-06-09 20:01:21.493501 | LOOP [upload-logs : Compress console log and json output] 2025-06-09 20:01:21.548223 | localhost | skipping: Conditional result was False 2025-06-09 20:01:21.552836 | localhost | skipping: Conditional result was False 2025-06-09 20:01:21.562769 | 2025-06-09 20:01:21.563009 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-09 20:01:21.629764 | localhost | skipping: Conditional result was False 2025-06-09 20:01:21.630130 | 2025-06-09 20:01:21.638720 | localhost | skipping: Conditional result was False 2025-06-09 20:01:21.645957 | 2025-06-09 20:01:21.646173 | LOOP [upload-logs : Upload console log and json output]