2025-10-07 16:55:59.974080 | Job console starting 2025-10-07 16:55:59.988944 | Updating git repos 2025-10-07 16:56:00.018698 | Cloning repos into workspace 2025-10-07 16:56:00.081595 | Restoring repo states 2025-10-07 16:56:00.097001 | Merging changes 2025-10-07 16:56:00.612306 | Checking out repos 2025-10-07 16:56:00.676079 | Preparing playbooks 2025-10-07 16:56:01.337582 | Running Ansible setup 2025-10-07 16:56:09.513458 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-07 16:56:10.276827 | 2025-10-07 16:56:10.276979 | PLAY [Base pre] 2025-10-07 16:56:10.292506 | 2025-10-07 16:56:10.292627 | TASK [Setup log path fact] 2025-10-07 16:56:10.329092 | debian-bookworm | ok 2025-10-07 16:56:10.348663 | 2025-10-07 16:56:10.348794 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-07 16:56:10.393194 | debian-bookworm | ok 2025-10-07 16:56:10.406972 | 2025-10-07 16:56:10.407093 | TASK [emit-job-header : Print job information] 2025-10-07 16:56:10.449194 | # Job Information 2025-10-07 16:56:10.449469 | Ansible Version: 2.16.14 2025-10-07 16:56:10.449528 | Job: container-image-python-osism-build 2025-10-07 16:56:10.449581 | Pipeline: check 2025-10-07 16:56:10.449618 | Executor: 521e9411259a 2025-10-07 16:56:10.449652 | Triggered by: https://github.com/osism/python-osism/pull/1744 2025-10-07 16:56:10.449688 | Event ID: 90867810-a39d-11f0-98a7-6cafdd5febb5 2025-10-07 16:56:10.456124 | 2025-10-07 16:56:10.456247 | LOOP [emit-job-header : Print node information] 2025-10-07 16:56:10.554107 | debian-bookworm | ok: 2025-10-07 16:56:10.554373 | debian-bookworm | # Node Information 2025-10-07 16:56:10.554434 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-07 16:56:10.554472 | debian-bookworm | Hostname: debian 2025-10-07 16:56:10.554500 | debian-bookworm | Username: zuul 2025-10-07 16:56:10.554522 | debian-bookworm | Distro: Debian 12.12 2025-10-07 16:56:10.554546 | debian-bookworm | Provider: regiocloud-a 2025-10-07 16:56:10.554568 | debian-bookworm | Region: 2025-10-07 16:56:10.554589 | debian-bookworm | Label: debian-bookworm 2025-10-07 16:56:10.554608 | debian-bookworm | Product Name: OpenStack Nova 2025-10-07 16:56:10.554628 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fef4:2b96 2025-10-07 16:56:10.576846 | 2025-10-07 16:56:10.576995 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-07 16:56:11.037516 | debian-bookworm -> localhost | changed 2025-10-07 16:56:11.053002 | 2025-10-07 16:56:11.053159 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-07 16:56:12.092860 | debian-bookworm -> localhost | changed 2025-10-07 16:56:12.103821 | 2025-10-07 16:56:12.103940 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-07 16:56:12.403639 | debian-bookworm -> localhost | ok 2025-10-07 16:56:12.416545 | 2025-10-07 16:56:12.416722 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-07 16:56:12.449579 | debian-bookworm | ok 2025-10-07 16:56:12.470855 | debian-bookworm | included: /var/lib/zuul/builds/91d7adfb9ded4eec8b920c94c02f5b71/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-07 16:56:12.476841 | 2025-10-07 16:56:12.476938 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-07 16:56:13.614283 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-07 16:56:13.614561 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/91d7adfb9ded4eec8b920c94c02f5b71/work/91d7adfb9ded4eec8b920c94c02f5b71_id_rsa 2025-10-07 16:56:13.614611 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/91d7adfb9ded4eec8b920c94c02f5b71/work/91d7adfb9ded4eec8b920c94c02f5b71_id_rsa.pub 2025-10-07 16:56:13.614644 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-07 16:56:13.614676 | debian-bookworm -> localhost | SHA256:NkX53lSP5J8/jo5G4bEi8yc9q+JikBX8YM9NE8AUf0g zuul-build-sshkey 2025-10-07 16:56:13.614718 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-07 16:56:13.614745 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-07 16:56:13.614770 | debian-bookworm -> localhost | | . o+oEo. | 2025-10-07 16:56:13.614796 | debian-bookworm -> localhost | | = .o+o . .| 2025-10-07 16:56:13.614821 | debian-bookworm -> localhost | | . * oooo o o.| 2025-10-07 16:56:13.614904 | debian-bookworm -> localhost | | . + o.o. + .| 2025-10-07 16:56:13.614931 | debian-bookworm -> localhost | | o S ..+o ..| 2025-10-07 16:56:13.614960 | debian-bookworm -> localhost | | o + o +. ...| 2025-10-07 16:56:13.614986 | debian-bookworm -> localhost | | . + + .| 2025-10-07 16:56:13.615011 | debian-bookworm -> localhost | | o . o =. ...| 2025-10-07 16:56:13.615035 | debian-bookworm -> localhost | | . o...=o+o...| 2025-10-07 16:56:13.615059 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-07 16:56:13.615120 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.656805 2025-10-07 16:56:13.623083 | 2025-10-07 16:56:13.623201 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-07 16:56:13.657116 | debian-bookworm | ok 2025-10-07 16:56:13.671168 | debian-bookworm | included: /var/lib/zuul/builds/91d7adfb9ded4eec8b920c94c02f5b71/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-07 16:56:13.681254 | 2025-10-07 16:56:13.681348 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-07 16:56:13.704741 | debian-bookworm | skipping: Conditional result was False 2025-10-07 16:56:13.712010 | 2025-10-07 16:56:13.712125 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-07 16:56:14.389113 | debian-bookworm | changed 2025-10-07 16:56:14.396666 | 2025-10-07 16:56:14.396796 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-07 16:56:14.673338 | debian-bookworm | ok 2025-10-07 16:56:14.681067 | 2025-10-07 16:56:14.681194 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-07 16:56:15.365209 | debian-bookworm | changed 2025-10-07 16:56:15.374491 | 2025-10-07 16:56:15.374613 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-07 16:56:16.045747 | debian-bookworm | changed 2025-10-07 16:56:16.052998 | 2025-10-07 16:56:16.053127 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-07 16:56:16.077096 | debian-bookworm | skipping: Conditional result was False 2025-10-07 16:56:16.088536 | 2025-10-07 16:56:16.088686 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-07 16:56:16.550396 | debian-bookworm -> localhost | changed 2025-10-07 16:56:16.561324 | 2025-10-07 16:56:16.561490 | TASK [add-build-sshkey : Add back temp key] 2025-10-07 16:56:16.901264 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/91d7adfb9ded4eec8b920c94c02f5b71/work/91d7adfb9ded4eec8b920c94c02f5b71_id_rsa (zuul-build-sshkey) 2025-10-07 16:56:16.901955 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.016717 2025-10-07 16:56:16.917828 | 2025-10-07 16:56:16.917973 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-07 16:56:17.313717 | debian-bookworm | ok 2025-10-07 16:56:17.322692 | 2025-10-07 16:56:17.322873 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-07 16:56:17.358952 | debian-bookworm | skipping: Conditional result was False 2025-10-07 16:56:17.377487 | 2025-10-07 16:56:17.377608 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-07 16:56:17.789479 | debian-bookworm | ok 2025-10-07 16:56:17.803708 | 2025-10-07 16:56:17.803818 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-07 16:56:17.849576 | debian-bookworm | ok 2025-10-07 16:56:17.857503 | 2025-10-07 16:56:17.857623 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-07 16:56:18.145180 | debian-bookworm -> localhost | ok 2025-10-07 16:56:18.158974 | 2025-10-07 16:56:18.159120 | TASK [validate-host : Collect information about the host] 2025-10-07 16:56:19.225589 | debian-bookworm | ok 2025-10-07 16:56:19.239381 | 2025-10-07 16:56:19.239518 | TASK [validate-host : Sanitize hostname] 2025-10-07 16:56:19.345916 | debian-bookworm | ok 2025-10-07 16:56:19.384800 | 2025-10-07 16:56:19.384921 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-07 16:56:19.947290 | debian-bookworm -> localhost | changed 2025-10-07 16:56:19.961125 | 2025-10-07 16:56:19.961295 | TASK [validate-host : Collect information about zuul worker] 2025-10-07 16:56:20.371937 | debian-bookworm | ok 2025-10-07 16:56:20.381230 | 2025-10-07 16:56:20.381391 | TASK [validate-host : Write out all zuul information for each host] 2025-10-07 16:56:20.933118 | debian-bookworm -> localhost | changed 2025-10-07 16:56:20.947896 | 2025-10-07 16:56:20.948031 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-07 16:56:21.229932 | debian-bookworm | ok 2025-10-07 16:56:21.240837 | 2025-10-07 16:56:21.240981 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-07 16:56:22.249353 | debian-bookworm | changed: 2025-10-07 16:56:22.249635 | debian-bookworm | cd+++++++++ src/ 2025-10-07 16:56:22.249688 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-07 16:56:22.249724 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-07 16:56:22.249755 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-10-07 16:56:22.249784 | debian-bookworm | Containerfile 2025-10-07 16:56:22.249947 | debian-bookworm | Containerfile 2025-10-07 16:56:22.276855 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006775 2025-10-07 17:01:50.873427 | 2025-10-07 17:01:50.873603 | TASK [upload-logs : Upload logs to log server] 2025-10-07 17:01:51.418458 | localhost | Output suppressed because no_log was given 2025-10-07 17:01:51.420869 | 2025-10-07 17:01:51.420991 | LOOP [upload-logs : Compress console log and json output] 2025-10-07 17:01:51.474692 | localhost | skipping: Conditional result was False 2025-10-07 17:01:51.479823 | localhost | skipping: Conditional result was False 2025-10-07 17:01:51.491145 | 2025-10-07 17:01:51.491357 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-07 17:01:51.536611 | localhost | skipping: Conditional result was False 2025-10-07 17:01:51.537121 | 2025-10-07 17:01:51.540675 | localhost | skipping: Conditional result was False 2025-10-07 17:01:51.552898 | 2025-10-07 17:01:51.553110 | LOOP [upload-logs : Upload console log and json output]