2026-06-17 16:06:17.627345 | Job console starting 2026-06-17 16:06:17.643783 | Updating git repos 2026-06-17 16:06:17.705951 | Cloning repos into workspace 2026-06-17 16:06:17.755044 | Restoring repo states 2026-06-17 16:06:17.789584 | Merging changes 2026-06-17 16:06:18.631003 | Checking out repos 2026-06-17 16:06:18.713512 | Preparing playbooks 2026-06-17 16:06:20.071131 | Running Ansible setup 2026-06-17 16:06:26.059286 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-17 16:06:26.882342 | 2026-06-17 16:06:26.882515 | PLAY [Base pre] 2026-06-17 16:06:26.899429 | 2026-06-17 16:06:26.899905 | TASK [Setup log path fact] 2026-06-17 16:06:26.935696 | debian-bookworm | ok 2026-06-17 16:06:26.959996 | 2026-06-17 16:06:26.960197 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-17 16:06:27.005511 | debian-bookworm | ok 2026-06-17 16:06:27.024808 | 2026-06-17 16:06:27.024922 | TASK [emit-job-header : Print job information] 2026-06-17 16:06:27.090421 | # Job Information 2026-06-17 16:06:27.090769 | Ansible Version: 2.16.14 2026-06-17 16:06:27.090808 | Job: python-osism-test-setup 2026-06-17 16:06:27.091075 | Pipeline: check 2026-06-17 16:06:27.091256 | Executor: 521e9411259a 2026-06-17 16:06:27.091285 | Triggered by: https://github.com/osism/python-osism/pull/2326 2026-06-17 16:06:27.091309 | Event ID: f8bca5f0-6a65-11f1-80e9-2e45f41533af 2026-06-17 16:06:27.099489 | 2026-06-17 16:06:27.099908 | LOOP [emit-job-header : Print node information] 2026-06-17 16:06:27.220181 | debian-bookworm | ok: 2026-06-17 16:06:27.220442 | debian-bookworm | # Node Information 2026-06-17 16:06:27.220541 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-17 16:06:27.220569 | debian-bookworm | Hostname: debian 2026-06-17 16:06:27.220592 | debian-bookworm | Username: zuul 2026-06-17 16:06:27.220614 | debian-bookworm | Distro: Debian 12.14 2026-06-17 16:06:27.220638 | debian-bookworm | Provider: regiocloud-a 2026-06-17 16:06:27.220659 | debian-bookworm | Region: 2026-06-17 16:06:27.220680 | debian-bookworm | Label: debian-bookworm 2026-06-17 16:06:27.220700 | debian-bookworm | Product Name: OpenStack Nova 2026-06-17 16:06:27.220719 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe12:4cd6 2026-06-17 16:06:27.237008 | 2026-06-17 16:06:27.237271 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-17 16:06:27.920142 | debian-bookworm -> localhost | changed 2026-06-17 16:06:27.947192 | 2026-06-17 16:06:27.947445 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-17 16:06:29.352595 | debian-bookworm -> localhost | changed 2026-06-17 16:06:29.366824 | 2026-06-17 16:06:29.367156 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-17 16:06:29.778810 | debian-bookworm -> localhost | ok 2026-06-17 16:06:29.792492 | 2026-06-17 16:06:29.792675 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-17 16:06:29.828089 | debian-bookworm | ok 2026-06-17 16:06:29.857566 | debian-bookworm | included: /var/lib/zuul/builds/52c53ecd11be499785193c16cb98a623/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-17 16:06:29.864566 | 2026-06-17 16:06:29.864727 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-17 16:06:31.206477 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-17 16:06:31.207674 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/52c53ecd11be499785193c16cb98a623/work/52c53ecd11be499785193c16cb98a623_id_rsa 2026-06-17 16:06:31.207768 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/52c53ecd11be499785193c16cb98a623/work/52c53ecd11be499785193c16cb98a623_id_rsa.pub 2026-06-17 16:06:31.207819 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-17 16:06:31.207869 | debian-bookworm -> localhost | SHA256:zITQFXA2PPj5x1vHOGOkbLgfSdSSUa+i5zhfnpqEGxo zuul-build-sshkey 2026-06-17 16:06:31.207912 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-17 16:06:31.207969 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-17 16:06:31.208009 | debian-bookworm -> localhost | | ...=*. ... | 2026-06-17 16:06:31.208058 | debian-bookworm -> localhost | | .o+o. + . | 2026-06-17 16:06:31.208097 | debian-bookworm -> localhost | | ...o + . .| 2026-06-17 16:06:31.208133 | debian-bookworm -> localhost | | +o . ... | 2026-06-17 16:06:31.208168 | debian-bookworm -> localhost | | S. +oo.o | 2026-06-17 16:06:31.208210 | debian-bookworm -> localhost | | o+*o* o| 2026-06-17 16:06:31.208247 | debian-bookworm -> localhost | | E ++=+.+ | 2026-06-17 16:06:31.208283 | debian-bookworm -> localhost | | ooB.= . | 2026-06-17 16:06:31.208321 | debian-bookworm -> localhost | | . o+*.o | 2026-06-17 16:06:31.208358 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-17 16:06:31.208464 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.577865 2026-06-17 16:06:31.230032 | 2026-06-17 16:06:31.230278 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-17 16:06:31.262575 | debian-bookworm | ok 2026-06-17 16:06:31.284603 | debian-bookworm | included: /var/lib/zuul/builds/52c53ecd11be499785193c16cb98a623/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-17 16:06:31.330228 | 2026-06-17 16:06:31.330437 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-17 16:06:31.396923 | debian-bookworm | skipping: Conditional result was False 2026-06-17 16:06:31.407026 | 2026-06-17 16:06:31.407212 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-17 16:06:32.226540 | debian-bookworm | changed 2026-06-17 16:06:32.234256 | 2026-06-17 16:06:32.234423 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-17 16:06:32.501217 | debian-bookworm | ok 2026-06-17 16:06:32.511636 | 2026-06-17 16:06:32.511817 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-17 16:06:33.248930 | debian-bookworm | changed 2026-06-17 16:06:33.255349 | 2026-06-17 16:06:33.255505 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-17 16:06:33.888249 | debian-bookworm | changed 2026-06-17 16:06:33.895946 | 2026-06-17 16:06:33.896076 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-17 16:06:33.920779 | debian-bookworm | skipping: Conditional result was False 2026-06-17 16:06:33.928015 | 2026-06-17 16:06:33.928159 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-17 16:06:34.631431 | debian-bookworm -> localhost | changed 2026-06-17 16:06:34.644868 | 2026-06-17 16:06:34.645049 | TASK [add-build-sshkey : Add back temp key] 2026-06-17 16:06:35.101694 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/52c53ecd11be499785193c16cb98a623/work/52c53ecd11be499785193c16cb98a623_id_rsa (zuul-build-sshkey) 2026-06-17 16:06:35.102254 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011446 2026-06-17 16:06:35.118026 | 2026-06-17 16:06:35.118189 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-17 16:06:35.633069 | debian-bookworm | ok 2026-06-17 16:06:35.642492 | 2026-06-17 16:06:35.642637 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-17 16:06:35.678480 | debian-bookworm | skipping: Conditional result was False 2026-06-17 16:06:35.701127 | 2026-06-17 16:06:35.701288 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-17 16:06:36.227531 | debian-bookworm | ok 2026-06-17 16:06:36.247918 | 2026-06-17 16:06:36.248065 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-17 16:06:36.287709 | debian-bookworm | ok 2026-06-17 16:06:36.298924 | 2026-06-17 16:06:36.299066 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-17 16:06:36.777455 | debian-bookworm -> localhost | ok 2026-06-17 16:06:36.784723 | 2026-06-17 16:06:36.784849 | TASK [validate-host : Collect information about the host] 2026-06-17 16:06:38.065437 | debian-bookworm | ok 2026-06-17 16:06:38.077729 | 2026-06-17 16:06:38.077854 | TASK [validate-host : Sanitize hostname] 2026-06-17 16:06:38.265368 | debian-bookworm | ok 2026-06-17 16:06:38.275301 | 2026-06-17 16:06:38.276999 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-17 16:06:39.020649 | debian-bookworm -> localhost | changed 2026-06-17 16:06:39.028032 | 2026-06-17 16:06:39.028169 | TASK [validate-host : Collect information about zuul worker] 2026-06-17 16:06:39.485772 | debian-bookworm | ok 2026-06-17 16:06:39.491321 | 2026-06-17 16:06:39.491494 | TASK [validate-host : Write out all zuul information for each host] 2026-06-17 16:06:40.151899 | debian-bookworm -> localhost | changed 2026-06-17 16:06:40.170666 | 2026-06-17 16:06:40.170875 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-17 16:06:40.472639 | debian-bookworm | ok 2026-06-17 16:06:40.478945 | 2026-06-17 16:06:40.479060 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-17 16:06:41.569225 | debian-bookworm | changed: 2026-06-17 16:06:41.569612 | debian-bookworm | cd+++++++++ src/ 2026-06-17 16:06:41.569667 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-17 16:06:41.569703 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-17 16:06:41.569734 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-06-17 16:06:41.569764 | debian-bookworm | Containerfile 2026-06-17 16:06:41.570069 | debian-bookworm | Containerfile 2026-06-17 16:06:41.577168 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/52c53ecd11be499785193c16cb98a623/work/logs" 2026-06-17 16:09:49.344116 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/52c53ecd11be499785193c16cb98a623/work/artifacts" 2026-06-17 16:09:49.625647 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/52c53ecd11be499785193c16cb98a623/work/docs" 2026-06-17 16:09:49.655446 | 2026-06-17 16:09:49.655641 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-17 16:09:50.526648 | debian-bookworm | changed: 2026-06-17 16:09:50.527041 | debian-bookworm | .d..t...... ./ 2026-06-17 16:09:50.527095 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-06-17 16:09:50.527130 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-06-17 16:09:50.527180 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-17 16:09:50.527210 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-17 16:09:50.527239 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-17 16:09:50.527294 | debian-bookworm | changed: All items complete 2026-06-17 16:09:50.527327 | 2026-06-17 16:09:51.147557 | debian-bookworm | changed: .d..t...... ./ 2026-06-17 16:09:51.738429 | debian-bookworm | changed: .d..t...... ./ 2026-06-17 16:09:51.772176 | 2026-06-17 16:09:51.772392 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-17 16:09:52.118605 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.010387 2026-06-17 16:09:52.436765 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.013540 2026-06-17 16:09:52.451228 | 2026-06-17 16:09:52.451353 | PLAY RECAP 2026-06-17 16:09:52.451410 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-17 16:09:52.451435 | 2026-06-17 16:09:52.612025 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-17 16:09:52.613048 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-17 16:09:53.424082 | 2026-06-17 16:09:53.424321 | PLAY [Base post] 2026-06-17 16:09:53.439127 | 2026-06-17 16:09:53.439318 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-17 16:09:54.292552 | debian-bookworm | changed 2026-06-17 16:09:54.301208 | 2026-06-17 16:09:54.301408 | PLAY RECAP 2026-06-17 16:09:54.301486 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-17 16:09:54.301563 | 2026-06-17 16:09:54.478719 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-17 16:09:54.480687 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-17 16:09:55.336538 | 2026-06-17 16:09:55.336785 | PLAY [Base post-logs] 2026-06-17 16:09:55.351302 | 2026-06-17 16:09:55.351578 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-17 16:09:55.912299 | localhost | changed 2026-06-17 16:09:55.935996 | 2026-06-17 16:09:55.936290 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-17 16:09:55.967105 | localhost | ok 2026-06-17 16:09:55.974172 | 2026-06-17 16:09:55.974376 | TASK [Set zuul-log-path fact] 2026-06-17 16:09:55.994355 | localhost | ok 2026-06-17 16:09:56.009997 | 2026-06-17 16:09:56.010252 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-17 16:09:56.039243 | localhost | ok 2026-06-17 16:09:56.045681 | 2026-06-17 16:09:56.045931 | TASK [upload-logs : Create log directories] 2026-06-17 16:09:56.571846 | localhost | changed 2026-06-17 16:09:56.578228 | 2026-06-17 16:09:56.578463 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-17 16:09:57.134239 | localhost -> localhost | ok: Runtime: 0:00:00.008734 2026-06-17 16:09:57.145511 | 2026-06-17 16:09:57.145730 | TASK [upload-logs : Upload logs to log server] 2026-06-17 16:09:57.754014 | localhost | Output suppressed because no_log was given 2026-06-17 16:09:57.757433 | 2026-06-17 16:09:57.757604 | LOOP [upload-logs : Compress console log and json output] 2026-06-17 16:09:57.822523 | localhost | skipping: Conditional result was False 2026-06-17 16:09:57.826677 | localhost | skipping: Conditional result was False 2026-06-17 16:09:57.835065 | 2026-06-17 16:09:57.835374 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-17 16:09:57.888674 | localhost | skipping: Conditional result was False 2026-06-17 16:09:57.889316 | 2026-06-17 16:09:57.892797 | localhost | skipping: Conditional result was False 2026-06-17 16:09:57.902293 | 2026-06-17 16:09:57.902578 | LOOP [upload-logs : Upload console log and json output]