2026-08-20 03:08:23.763896 | Job console starting 2026-08-20 03:08:23.771546 | Updating git repos 2026-08-20 03:08:23.812250 | Cloning repos into workspace 2026-08-20 03:08:23.896924 | Restoring repo states 2026-08-20 03:08:23.918618 | Merging changes 2026-08-20 03:08:23.918636 | Checking out repos 2026-08-20 03:08:24.114693 | Preparing playbooks 2026-08-20 03:08:25.473548 | Running Ansible setup 2026-08-20 03:08:31.869271 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-08-20 03:08:32.671716 | 2026-08-20 03:08:32.671857 | PLAY [Base pre] 2026-08-20 03:08:32.688505 | 2026-08-20 03:08:32.688618 | TASK [Setup log path fact] 2026-08-20 03:08:32.717569 | debian-bookworm | ok 2026-08-20 03:08:32.734996 | 2026-08-20 03:08:32.735120 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-20 03:08:32.763414 | debian-bookworm | ok 2026-08-20 03:08:32.772903 | 2026-08-20 03:08:32.773001 | TASK [emit-job-header : Print job information] 2026-08-20 03:08:32.841613 | # Job Information 2026-08-20 03:08:32.841770 | Ansible Version: 2.16.14 2026-08-20 03:08:32.841804 | Job: python-osism-test-setup 2026-08-20 03:08:32.841837 | Pipeline: periodic-daily 2026-08-20 03:08:32.841859 | Executor: 521e9411259a 2026-08-20 03:08:32.841880 | Triggered by: https://github.com/osism/python-osism 2026-08-20 03:08:32.841902 | Event ID: cef6eb48328345638beb644c1094bb7a 2026-08-20 03:08:32.848693 | 2026-08-20 03:08:32.848795 | LOOP [emit-job-header : Print node information] 2026-08-20 03:08:32.960209 | debian-bookworm | ok: 2026-08-20 03:08:32.960424 | debian-bookworm | # Node Information 2026-08-20 03:08:32.960463 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-08-20 03:08:32.960488 | debian-bookworm | Hostname: debian 2026-08-20 03:08:32.960510 | debian-bookworm | Username: zuul 2026-08-20 03:08:32.960530 | debian-bookworm | Distro: Debian 12.15 2026-08-20 03:08:32.960554 | debian-bookworm | Provider: regiocloud-a 2026-08-20 03:08:32.960575 | debian-bookworm | Region: 2026-08-20 03:08:32.960596 | debian-bookworm | Label: debian-bookworm 2026-08-20 03:08:32.960615 | debian-bookworm | Product Name: OpenStack Nova 2026-08-20 03:08:32.960634 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe9a:ac89 2026-08-20 03:08:32.979556 | 2026-08-20 03:08:32.979666 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-20 03:08:33.673537 | debian-bookworm -> localhost | changed 2026-08-20 03:08:33.683155 | 2026-08-20 03:08:33.683270 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-20 03:08:35.008776 | debian-bookworm -> localhost | changed 2026-08-20 03:08:35.020937 | 2026-08-20 03:08:35.021289 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-20 03:08:35.673122 | debian-bookworm -> localhost | ok 2026-08-20 03:08:35.685432 | 2026-08-20 03:08:35.685612 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-20 03:08:35.752107 | debian-bookworm | ok 2026-08-20 03:08:35.786126 | debian-bookworm | included: /var/lib/zuul/builds/f1b9c0e0660548af850d3ebfe7a3643a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-20 03:08:35.793993 | 2026-08-20 03:08:35.794111 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-20 03:08:37.475038 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-08-20 03:08:37.475251 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/f1b9c0e0660548af850d3ebfe7a3643a/work/f1b9c0e0660548af850d3ebfe7a3643a_id_rsa 2026-08-20 03:08:37.475291 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/f1b9c0e0660548af850d3ebfe7a3643a/work/f1b9c0e0660548af850d3ebfe7a3643a_id_rsa.pub 2026-08-20 03:08:37.475318 | debian-bookworm -> localhost | The key fingerprint is: 2026-08-20 03:08:37.475342 | debian-bookworm -> localhost | SHA256:Fmcn8aSnJWqn3kUwIgfe64UqFZQDLJOywdSDBZQGj0Q zuul-build-sshkey 2026-08-20 03:08:37.475365 | debian-bookworm -> localhost | The key's randomart image is: 2026-08-20 03:08:37.475420 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-08-20 03:08:37.475446 | debian-bookworm -> localhost | |BE*+..o. . . | 2026-08-20 03:08:37.475468 | debian-bookworm -> localhost | |+B+o.ooo = | 2026-08-20 03:08:37.475489 | debian-bookworm -> localhost | |o+.o. +.= O = | 2026-08-20 03:08:37.475509 | debian-bookworm -> localhost | |. + O X | 2026-08-20 03:08:37.475530 | debian-bookworm -> localhost | | . S + . | 2026-08-20 03:08:37.475561 | debian-bookworm -> localhost | | . = + . | 2026-08-20 03:08:37.475582 | debian-bookworm -> localhost | | . . o . | 2026-08-20 03:08:37.475604 | debian-bookworm -> localhost | | . . . . | 2026-08-20 03:08:37.475625 | debian-bookworm -> localhost | | . . | 2026-08-20 03:08:37.475645 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-08-20 03:08:37.475698 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.781971 2026-08-20 03:08:37.481982 | 2026-08-20 03:08:37.482075 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-20 03:08:37.501083 | debian-bookworm | ok 2026-08-20 03:08:37.511310 | debian-bookworm | included: /var/lib/zuul/builds/f1b9c0e0660548af850d3ebfe7a3643a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-20 03:08:37.519685 | 2026-08-20 03:08:37.519771 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-20 03:08:37.533202 | debian-bookworm | skipping: Conditional result was False 2026-08-20 03:08:37.539764 | 2026-08-20 03:08:37.539867 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-20 03:08:38.157545 | debian-bookworm | changed 2026-08-20 03:08:38.163256 | 2026-08-20 03:08:38.163352 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-20 03:08:38.418237 | debian-bookworm | ok 2026-08-20 03:08:38.423819 | 2026-08-20 03:08:38.423909 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-20 03:08:39.042529 | debian-bookworm | changed 2026-08-20 03:08:39.052812 | 2026-08-20 03:08:39.052917 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-20 03:08:39.810370 | debian-bookworm | changed 2026-08-20 03:08:39.835759 | 2026-08-20 03:08:39.835899 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-20 03:08:39.859444 | debian-bookworm | skipping: Conditional result was False 2026-08-20 03:08:39.866465 | 2026-08-20 03:08:39.866581 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-20 03:08:40.503412 | debian-bookworm -> localhost | changed 2026-08-20 03:08:40.519851 | 2026-08-20 03:08:40.519998 | TASK [add-build-sshkey : Add back temp key] 2026-08-20 03:08:41.377969 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/f1b9c0e0660548af850d3ebfe7a3643a/work/f1b9c0e0660548af850d3ebfe7a3643a_id_rsa (zuul-build-sshkey) 2026-08-20 03:08:41.378268 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.035877 2026-08-20 03:08:41.407820 | 2026-08-20 03:08:41.407983 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-20 03:08:42.057970 | debian-bookworm | ok 2026-08-20 03:08:42.068830 | 2026-08-20 03:08:42.070722 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-20 03:08:42.126983 | debian-bookworm | skipping: Conditional result was False 2026-08-20 03:08:42.138766 | 2026-08-20 03:08:42.147166 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-08-20 03:08:42.793605 | debian-bookworm | ok 2026-08-20 03:08:42.809130 | 2026-08-20 03:08:42.809265 | TASK [validate-host : Define zuul_info_dir fact] 2026-08-20 03:08:42.869820 | debian-bookworm | ok 2026-08-20 03:08:42.876225 | 2026-08-20 03:08:42.876479 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-08-20 03:08:43.311752 | debian-bookworm -> localhost | ok 2026-08-20 03:08:43.342079 | 2026-08-20 03:08:43.342256 | TASK [validate-host : Collect information about the host] 2026-08-20 03:08:44.871077 | debian-bookworm | ok 2026-08-20 03:08:44.901545 | 2026-08-20 03:08:44.901797 | TASK [validate-host : Sanitize hostname] 2026-08-20 03:08:45.200505 | debian-bookworm | ok 2026-08-20 03:08:45.205420 | 2026-08-20 03:08:45.205530 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-08-20 03:08:46.248846 | debian-bookworm -> localhost | changed 2026-08-20 03:08:46.256120 | 2026-08-20 03:08:46.256247 | TASK [validate-host : Collect information about zuul worker] 2026-08-20 03:08:46.740129 | debian-bookworm | ok 2026-08-20 03:08:46.754711 | 2026-08-20 03:08:46.754915 | TASK [validate-host : Write out all zuul information for each host] 2026-08-20 03:08:48.266642 | debian-bookworm -> localhost | changed 2026-08-20 03:08:48.279654 | 2026-08-20 03:08:48.279801 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-08-20 03:08:48.613808 | debian-bookworm | ok 2026-08-20 03:08:48.618673 | 2026-08-20 03:08:48.618756 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-08-20 03:08:50.166582 | debian-bookworm | changed: 2026-08-20 03:08:50.166761 | debian-bookworm | cd+++++++++ src/ 2026-08-20 03:08:50.166795 | debian-bookworm | cd+++++++++ src/github.com/ 2026-08-20 03:08:50.166819 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-08-20 03:08:50.166905 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-08-20 03:08:50.166928 | debian-bookworm | Containerfile 2026-08-20 03:08:50.167059 | debian-bookworm | Containerfile 2026-08-20 03:08:50.183147 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/f1b9c0e0660548af850d3ebfe7a3643a/work/logs" 2026-08-20 03:11:20.139730 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/f1b9c0e0660548af850d3ebfe7a3643a/work/artifacts" 2026-08-20 03:11:20.459461 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/f1b9c0e0660548af850d3ebfe7a3643a/work/docs" 2026-08-20 03:11:20.474959 | 2026-08-20 03:11:20.475131 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-20 03:11:21.279499 | debian-bookworm | changed: 2026-08-20 03:11:21.279881 | debian-bookworm | .d..t...... ./ 2026-08-20 03:11:21.279938 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-08-20 03:11:21.279963 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-08-20 03:11:21.279985 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-08-20 03:11:21.280005 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-08-20 03:11:21.280027 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-08-20 03:11:21.280075 | debian-bookworm | changed: All items complete 2026-08-20 03:11:21.280104 | 2026-08-20 03:11:21.867412 | debian-bookworm | changed: .d..t...... ./ 2026-08-20 03:11:22.417899 | debian-bookworm | changed: .d..t...... ./ 2026-08-20 03:11:22.440208 | 2026-08-20 03:11:22.440338 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-20 03:11:22.463182 | debian-bookworm | skipping: Conditional result was False 2026-08-20 03:11:22.466423 | debian-bookworm | skipping: Conditional result was False 2026-08-20 03:11:22.481095 | 2026-08-20 03:11:22.481174 | PLAY RECAP 2026-08-20 03:11:22.481227 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-08-20 03:11:22.481251 | 2026-08-20 03:11:22.591978 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-08-20 03:11:22.592756 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-20 03:11:23.278016 | 2026-08-20 03:11:23.278148 | PLAY [Base post] 2026-08-20 03:11:23.290694 | 2026-08-20 03:11:23.290812 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-20 03:11:24.006742 | debian-bookworm | changed 2026-08-20 03:11:24.012728 | 2026-08-20 03:11:24.012813 | PLAY RECAP 2026-08-20 03:11:24.012873 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-20 03:11:24.012970 | 2026-08-20 03:11:24.099758 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-20 03:11:24.100535 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-20 03:11:24.934580 | 2026-08-20 03:11:24.934799 | PLAY [Base post-logs] 2026-08-20 03:11:24.947772 | 2026-08-20 03:11:24.947954 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-20 03:11:25.536241 | localhost | changed 2026-08-20 03:11:25.548912 | 2026-08-20 03:11:25.549114 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-20 03:11:25.586398 | localhost | ok 2026-08-20 03:11:25.590644 | 2026-08-20 03:11:25.590756 | TASK [Set zuul-log-path fact] 2026-08-20 03:11:25.627472 | localhost | ok 2026-08-20 03:11:25.637155 | 2026-08-20 03:11:25.637332 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-20 03:11:25.663522 | localhost | ok 2026-08-20 03:11:25.666624 | 2026-08-20 03:11:25.666735 | TASK [upload-logs : Create log directories] 2026-08-20 03:11:26.211172 | localhost | changed 2026-08-20 03:11:26.214209 | 2026-08-20 03:11:26.214366 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-20 03:11:26.940208 | localhost -> localhost | ok: Runtime: 0:00:00.022901 2026-08-20 03:11:26.944935 | 2026-08-20 03:11:26.945067 | TASK [upload-logs : Upload logs to log server] 2026-08-20 03:11:27.802918 | localhost | Output suppressed because no_log was given 2026-08-20 03:11:27.805224 | 2026-08-20 03:11:27.805390 | LOOP [upload-logs : Compress console log and json output] 2026-08-20 03:11:27.884296 | localhost | skipping: Conditional result was False 2026-08-20 03:11:27.890651 | localhost | skipping: Conditional result was False 2026-08-20 03:11:27.895353 | 2026-08-20 03:11:27.895489 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-20 03:11:27.996214 | localhost | skipping: Conditional result was False 2026-08-20 03:11:27.997107 | 2026-08-20 03:11:28.017203 | localhost | skipping: Conditional result was False 2026-08-20 03:11:28.024766 | 2026-08-20 03:11:28.024896 | LOOP [upload-logs : Upload console log and json output]