2026-07-13 03:52:32.159117 | Job console starting 2026-07-13 03:52:32.167954 | Updating git repos 2026-07-13 03:52:32.208227 | Cloning repos into workspace 2026-07-13 03:52:32.312715 | Restoring repo states 2026-07-13 03:52:32.364236 | Merging changes 2026-07-13 03:52:33.553648 | Checking out repos 2026-07-13 03:52:33.667273 | Preparing playbooks 2026-07-13 03:52:35.405744 | Running Ansible setup 2026-07-13 03:52:41.938905 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-13 03:52:42.694313 | 2026-07-13 03:52:42.694451 | PLAY [Base pre] 2026-07-13 03:52:42.725977 | 2026-07-13 03:52:42.726123 | TASK [Setup log path fact] 2026-07-13 03:52:42.755318 | debian-bookworm | ok 2026-07-13 03:52:42.793228 | 2026-07-13 03:52:42.793399 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-13 03:52:42.841945 | debian-bookworm | ok 2026-07-13 03:52:42.858025 | 2026-07-13 03:52:42.858138 | TASK [emit-job-header : Print job information] 2026-07-13 03:52:42.896968 | # Job Information 2026-07-13 03:52:42.897130 | Ansible Version: 2.16.14 2026-07-13 03:52:42.897167 | Job: python-osism-test-setup 2026-07-13 03:52:42.897201 | Pipeline: check 2026-07-13 03:52:42.897225 | Executor: 521e9411259a 2026-07-13 03:52:42.897246 | Triggered by: https://github.com/osism/python-osism/pull/2454 2026-07-13 03:52:42.897283 | Event ID: 125be270-7e6e-11f1-9f65-78c69b0c3a8f 2026-07-13 03:52:42.919644 | 2026-07-13 03:52:42.919778 | LOOP [emit-job-header : Print node information] 2026-07-13 03:52:43.051550 | debian-bookworm | ok: 2026-07-13 03:52:43.051757 | debian-bookworm | # Node Information 2026-07-13 03:52:43.051787 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-13 03:52:43.051808 | debian-bookworm | Hostname: debian 2026-07-13 03:52:43.051882 | debian-bookworm | Username: zuul 2026-07-13 03:52:43.051978 | debian-bookworm | Distro: Debian 12.15 2026-07-13 03:52:43.052000 | debian-bookworm | Provider: regiocloud-a 2026-07-13 03:52:43.052018 | debian-bookworm | Region: 2026-07-13 03:52:43.052035 | debian-bookworm | Label: debian-bookworm 2026-07-13 03:52:43.052052 | debian-bookworm | Product Name: OpenStack Nova 2026-07-13 03:52:43.052068 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe7b:a65f 2026-07-13 03:52:43.072738 | 2026-07-13 03:52:43.072867 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-13 03:52:43.673589 | debian-bookworm -> localhost | changed 2026-07-13 03:52:43.680816 | 2026-07-13 03:52:43.680933 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-13 03:52:45.093724 | debian-bookworm -> localhost | changed 2026-07-13 03:52:45.104757 | 2026-07-13 03:52:45.104873 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-13 03:52:45.528157 | debian-bookworm -> localhost | ok 2026-07-13 03:52:45.534607 | 2026-07-13 03:52:45.534716 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-13 03:52:45.575510 | debian-bookworm | ok 2026-07-13 03:52:45.605744 | debian-bookworm | included: /var/lib/zuul/builds/6935d1a35ab140abb06eee8cc9b5190f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-13 03:52:45.631057 | 2026-07-13 03:52:45.631179 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-13 03:52:46.800911 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-13 03:52:46.801148 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/6935d1a35ab140abb06eee8cc9b5190f/work/6935d1a35ab140abb06eee8cc9b5190f_id_rsa 2026-07-13 03:52:46.801187 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/6935d1a35ab140abb06eee8cc9b5190f/work/6935d1a35ab140abb06eee8cc9b5190f_id_rsa.pub 2026-07-13 03:52:46.801214 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-13 03:52:46.801239 | debian-bookworm -> localhost | SHA256:ZXvPh8OIKnBa6vgCA8PxjYRw87OWPu2csHbq/7ak/bc zuul-build-sshkey 2026-07-13 03:52:46.801275 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-13 03:52:46.801308 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-13 03:52:46.801330 | debian-bookworm -> localhost | |o + | 2026-07-13 03:52:46.801351 | debian-bookworm -> localhost | | + + | 2026-07-13 03:52:46.801372 | debian-bookworm -> localhost | |. + = o | 2026-07-13 03:52:46.801392 | debian-bookworm -> localhost | |o. o = o . | 2026-07-13 03:52:46.801411 | debian-bookworm -> localhost | |.. + S . . | 2026-07-13 03:52:46.801438 | debian-bookworm -> localhost | |o o..o o = . | 2026-07-13 03:52:46.801459 | debian-bookworm -> localhost | | o +*. . . . * .| 2026-07-13 03:52:46.801479 | debian-bookworm -> localhost | | ..+*o=.. . o | 2026-07-13 03:52:46.801500 | debian-bookworm -> localhost | | .**+*+=o..E. | 2026-07-13 03:52:46.801521 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-13 03:52:46.801572 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.497881 2026-07-13 03:52:46.815846 | 2026-07-13 03:52:46.815940 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-13 03:52:46.853380 | debian-bookworm | ok 2026-07-13 03:52:46.863244 | debian-bookworm | included: /var/lib/zuul/builds/6935d1a35ab140abb06eee8cc9b5190f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-13 03:52:46.871230 | 2026-07-13 03:52:46.871348 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-13 03:52:46.895481 | debian-bookworm | skipping: Conditional result was False 2026-07-13 03:52:46.902238 | 2026-07-13 03:52:46.902359 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-13 03:52:47.945424 | debian-bookworm | changed 2026-07-13 03:52:48.017136 | 2026-07-13 03:52:48.017793 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-13 03:52:48.427448 | debian-bookworm | ok 2026-07-13 03:52:48.456975 | 2026-07-13 03:52:48.457087 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-13 03:52:49.151904 | debian-bookworm | changed 2026-07-13 03:52:49.160131 | 2026-07-13 03:52:49.160252 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-13 03:52:49.809372 | debian-bookworm | changed 2026-07-13 03:52:49.815451 | 2026-07-13 03:52:49.815554 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-13 03:52:49.835500 | debian-bookworm | skipping: Conditional result was False 2026-07-13 03:52:49.841884 | 2026-07-13 03:52:49.841997 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-13 03:52:50.292272 | debian-bookworm -> localhost | changed 2026-07-13 03:52:50.302977 | 2026-07-13 03:52:50.303088 | TASK [add-build-sshkey : Add back temp key] 2026-07-13 03:52:50.621431 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/6935d1a35ab140abb06eee8cc9b5190f/work/6935d1a35ab140abb06eee8cc9b5190f_id_rsa (zuul-build-sshkey) 2026-07-13 03:52:50.621646 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012137 2026-07-13 03:52:50.629118 | 2026-07-13 03:52:50.629213 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-13 03:52:51.063729 | debian-bookworm | ok 2026-07-13 03:52:51.069074 | 2026-07-13 03:52:51.069172 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-13 03:52:51.092384 | debian-bookworm | skipping: Conditional result was False 2026-07-13 03:52:51.102616 | 2026-07-13 03:52:51.102727 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-13 03:52:51.582765 | debian-bookworm | ok 2026-07-13 03:52:51.623721 | 2026-07-13 03:52:51.626722 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-13 03:52:51.703019 | debian-bookworm | ok 2026-07-13 03:52:51.708280 | 2026-07-13 03:52:51.708380 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-13 03:52:52.000480 | debian-bookworm -> localhost | ok 2026-07-13 03:52:52.009005 | 2026-07-13 03:52:52.009097 | TASK [validate-host : Collect information about the host] 2026-07-13 03:52:53.450196 | debian-bookworm | ok 2026-07-13 03:52:53.469364 | 2026-07-13 03:52:53.469513 | TASK [validate-host : Sanitize hostname] 2026-07-13 03:52:53.763366 | debian-bookworm | ok 2026-07-13 03:52:53.803759 | 2026-07-13 03:52:53.803936 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-13 03:52:54.801515 | debian-bookworm -> localhost | changed 2026-07-13 03:52:54.821790 | 2026-07-13 03:52:54.822006 | TASK [validate-host : Collect information about zuul worker] 2026-07-13 03:52:55.605107 | debian-bookworm | ok 2026-07-13 03:52:55.625996 | 2026-07-13 03:52:55.626133 | TASK [validate-host : Write out all zuul information for each host] 2026-07-13 03:52:56.166391 | debian-bookworm -> localhost | changed 2026-07-13 03:52:56.175915 | 2026-07-13 03:52:56.176019 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-13 03:52:56.465744 | debian-bookworm | ok 2026-07-13 03:52:56.471449 | 2026-07-13 03:52:56.471551 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-13 03:52:57.682729 | debian-bookworm | changed: 2026-07-13 03:52:57.682941 | debian-bookworm | cd+++++++++ src/ 2026-07-13 03:52:57.682978 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-13 03:52:57.683003 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-13 03:52:57.683025 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-07-13 03:52:57.683045 | debian-bookworm | Containerfile 2026-07-13 03:52:57.683176 | debian-bookworm | Containerfile 2026-07-13 03:52:57.720920 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/6935d1a35ab140abb06eee8cc9b5190f/work/logs" 2026-07-13 03:55:45.022351 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/6935d1a35ab140abb06eee8cc9b5190f/work/artifacts" 2026-07-13 03:55:45.355586 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/6935d1a35ab140abb06eee8cc9b5190f/work/docs" 2026-07-13 03:55:45.368897 | 2026-07-13 03:55:45.369006 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-13 03:55:46.359968 | debian-bookworm | changed: 2026-07-13 03:55:46.360160 | debian-bookworm | .d..t...... ./ 2026-07-13 03:55:46.360193 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-13 03:55:46.360216 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-13 03:55:46.360237 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-13 03:55:46.360258 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-13 03:55:46.360278 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-13 03:55:46.360317 | debian-bookworm | changed: All items complete 2026-07-13 03:55:46.360342 | 2026-07-13 03:55:46.929344 | debian-bookworm | changed: .d..t...... ./ 2026-07-13 03:55:47.494172 | debian-bookworm | changed: .d..t...... ./ 2026-07-13 03:55:47.525926 | 2026-07-13 03:55:47.526081 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-13 03:55:47.874608 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.007136 2026-07-13 03:55:48.185843 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.018786 2026-07-13 03:55:48.206168 | 2026-07-13 03:55:48.206265 | PLAY RECAP 2026-07-13 03:55:48.206315 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-07-13 03:55:48.206338 | 2026-07-13 03:55:48.354505 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-13 03:55:48.355300 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-13 03:55:49.176707 | 2026-07-13 03:55:49.176907 | PLAY [Base post] 2026-07-13 03:55:49.191980 | 2026-07-13 03:55:49.192152 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-13 03:55:50.095274 | debian-bookworm | changed 2026-07-13 03:55:50.103497 | 2026-07-13 03:55:50.103623 | PLAY RECAP 2026-07-13 03:55:50.103689 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-13 03:55:50.103753 | 2026-07-13 03:55:50.256802 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-13 03:55:50.257697 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-13 03:55:51.224199 | 2026-07-13 03:55:51.224394 | PLAY [Base post-logs] 2026-07-13 03:55:51.235634 | 2026-07-13 03:55:51.235790 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-13 03:55:51.728719 | localhost | changed 2026-07-13 03:55:51.739853 | 2026-07-13 03:55:51.740031 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-13 03:55:51.769422 | localhost | ok 2026-07-13 03:55:51.772756 | 2026-07-13 03:55:51.772873 | TASK [Set zuul-log-path fact] 2026-07-13 03:55:51.790899 | localhost | ok 2026-07-13 03:55:51.826678 | 2026-07-13 03:55:51.826861 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-13 03:55:51.917660 | localhost | ok 2026-07-13 03:55:51.921009 | 2026-07-13 03:55:51.921124 | TASK [upload-logs : Create log directories] 2026-07-13 03:55:52.692532 | localhost | changed 2026-07-13 03:55:52.695652 | 2026-07-13 03:55:52.695774 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-13 03:55:53.287213 | localhost -> localhost | ok: Runtime: 0:00:00.006918 2026-07-13 03:55:53.295828 | 2026-07-13 03:55:53.295963 | TASK [upload-logs : Upload logs to log server] 2026-07-13 03:55:54.150560 | localhost | Output suppressed because no_log was given 2026-07-13 03:55:54.156005 | 2026-07-13 03:55:54.156302 | LOOP [upload-logs : Compress console log and json output] 2026-07-13 03:55:54.291867 | localhost | skipping: Conditional result was False 2026-07-13 03:55:54.315662 | localhost | skipping: Conditional result was False 2026-07-13 03:55:54.329715 | 2026-07-13 03:55:54.329885 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-13 03:55:54.502953 | localhost | skipping: Conditional result was False 2026-07-13 03:55:54.503299 | 2026-07-13 03:55:54.508718 | localhost | skipping: Conditional result was False 2026-07-13 03:55:54.521742 | 2026-07-13 03:55:54.521888 | LOOP [upload-logs : Upload console log and json output]