2026-05-08 10:07:06.264952 | Job console starting 2026-05-08 10:07:06.275363 | Updating git repos 2026-05-08 10:07:06.334824 | Cloning repos into workspace 2026-05-08 10:07:06.435780 | Restoring repo states 2026-05-08 10:07:06.461397 | Merging changes 2026-05-08 10:07:07.019247 | Checking out repos 2026-05-08 10:07:07.104456 | Preparing playbooks 2026-05-08 10:07:08.020055 | Running Ansible setup 2026-05-08 10:07:12.787356 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-08 10:07:13.639210 | 2026-05-08 10:07:13.639462 | PLAY [Base pre] 2026-05-08 10:07:13.664325 | 2026-05-08 10:07:13.664586 | TASK [Setup log path fact] 2026-05-08 10:07:13.697127 | debian-bookworm | ok 2026-05-08 10:07:13.715649 | 2026-05-08 10:07:13.715854 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-08 10:07:13.746252 | debian-bookworm | ok 2026-05-08 10:07:13.757162 | 2026-05-08 10:07:13.757379 | TASK [emit-job-header : Print job information] 2026-05-08 10:07:13.801562 | # Job Information 2026-05-08 10:07:13.801845 | Ansible Version: 2.16.14 2026-05-08 10:07:13.801892 | Job: container-image-python-osism-build 2026-05-08 10:07:13.801935 | Pipeline: check 2026-05-08 10:07:13.801966 | Executor: 521e9411259a 2026-05-08 10:07:13.801992 | Triggered by: https://github.com/osism/python-osism/pull/2251 2026-05-08 10:07:13.802019 | Event ID: 6f62c2e0-4ac5-11f1-9343-c145b2ffa4ce 2026-05-08 10:07:13.808378 | 2026-05-08 10:07:13.808515 | LOOP [emit-job-header : Print node information] 2026-05-08 10:07:13.936497 | debian-bookworm | ok: 2026-05-08 10:07:13.936848 | debian-bookworm | # Node Information 2026-05-08 10:07:13.936892 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-08 10:07:13.936945 | debian-bookworm | Hostname: debian 2026-05-08 10:07:13.936969 | debian-bookworm | Username: zuul 2026-05-08 10:07:13.936990 | debian-bookworm | Distro: Debian 12.13 2026-05-08 10:07:13.937014 | debian-bookworm | Provider: regiocloud-a 2026-05-08 10:07:13.937036 | debian-bookworm | Region: 2026-05-08 10:07:13.937128 | debian-bookworm | Label: debian-bookworm 2026-05-08 10:07:13.937150 | debian-bookworm | Product Name: OpenStack Nova 2026-05-08 10:07:13.937170 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe62:a90a 2026-05-08 10:07:13.953526 | 2026-05-08 10:07:13.953715 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-08 10:07:14.551156 | debian-bookworm -> localhost | changed 2026-05-08 10:07:14.559172 | 2026-05-08 10:07:14.559321 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-08 10:07:15.753062 | debian-bookworm -> localhost | changed 2026-05-08 10:07:15.764139 | 2026-05-08 10:07:15.764289 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-08 10:07:16.063371 | debian-bookworm -> localhost | ok 2026-05-08 10:07:16.076591 | 2026-05-08 10:07:16.076782 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-08 10:07:16.131185 | debian-bookworm | ok 2026-05-08 10:07:16.151580 | debian-bookworm | included: /var/lib/zuul/builds/24ed44853b644cd9acf02a587b43f202/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-08 10:07:16.158685 | 2026-05-08 10:07:16.158816 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-08 10:07:17.565527 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-08 10:07:17.565808 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/24ed44853b644cd9acf02a587b43f202/work/24ed44853b644cd9acf02a587b43f202_id_rsa 2026-05-08 10:07:17.565849 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/24ed44853b644cd9acf02a587b43f202/work/24ed44853b644cd9acf02a587b43f202_id_rsa.pub 2026-05-08 10:07:17.565875 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-08 10:07:17.565899 | debian-bookworm -> localhost | SHA256:eoJgdcpm8jBZuwWS+UE2Ti3RdEk6+F2Bo2Oud3hyoQs zuul-build-sshkey 2026-05-08 10:07:17.565934 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-08 10:07:17.565956 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-08 10:07:17.565976 | debian-bookworm -> localhost | | *=..oo. | 2026-05-08 10:07:17.565997 | debian-bookworm -> localhost | | B.ooo+ . | 2026-05-08 10:07:17.566018 | debian-bookworm -> localhost | | + B.+. .. | 2026-05-08 10:07:17.566037 | debian-bookworm -> localhost | | B B+o . | 2026-05-08 10:07:17.566057 | debian-bookworm -> localhost | | B Boo.S | 2026-05-08 10:07:17.566086 | debian-bookworm -> localhost | | . O +... | 2026-05-08 10:07:17.566106 | debian-bookworm -> localhost | | E.oo.. | 2026-05-08 10:07:17.566126 | debian-bookworm -> localhost | | ..=o+ | 2026-05-08 10:07:17.566146 | debian-bookworm -> localhost | | ..* | 2026-05-08 10:07:17.566166 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-08 10:07:17.566230 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.834466 2026-05-08 10:07:17.573289 | 2026-05-08 10:07:17.573398 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-08 10:07:17.607341 | debian-bookworm | ok 2026-05-08 10:07:17.621400 | debian-bookworm | included: /var/lib/zuul/builds/24ed44853b644cd9acf02a587b43f202/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-08 10:07:17.645958 | 2026-05-08 10:07:17.647093 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-08 10:07:17.686199 | debian-bookworm | skipping: Conditional result was False 2026-05-08 10:07:17.701664 | 2026-05-08 10:07:17.701902 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-08 10:07:18.354060 | debian-bookworm | changed 2026-05-08 10:07:18.361909 | 2026-05-08 10:07:18.362012 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-08 10:07:18.674163 | debian-bookworm | ok 2026-05-08 10:07:18.681936 | 2026-05-08 10:07:18.682075 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-08 10:07:19.287251 | debian-bookworm | changed 2026-05-08 10:07:19.294793 | 2026-05-08 10:07:19.294936 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-08 10:07:19.962906 | debian-bookworm | changed 2026-05-08 10:07:19.972096 | 2026-05-08 10:07:19.972212 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-08 10:07:19.997611 | debian-bookworm | skipping: Conditional result was False 2026-05-08 10:07:20.005725 | 2026-05-08 10:07:20.005866 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-08 10:07:20.508363 | debian-bookworm -> localhost | changed 2026-05-08 10:07:20.532403 | 2026-05-08 10:07:20.532713 | TASK [add-build-sshkey : Add back temp key] 2026-05-08 10:07:20.922496 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/24ed44853b644cd9acf02a587b43f202/work/24ed44853b644cd9acf02a587b43f202_id_rsa (zuul-build-sshkey) 2026-05-08 10:07:20.923053 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.021483 2026-05-08 10:07:20.936528 | 2026-05-08 10:07:20.936686 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-08 10:07:21.394384 | debian-bookworm | ok 2026-05-08 10:07:21.405354 | 2026-05-08 10:07:21.405487 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-08 10:07:21.429962 | debian-bookworm | skipping: Conditional result was False 2026-05-08 10:07:21.442574 | 2026-05-08 10:07:21.442745 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-08 10:07:21.934917 | debian-bookworm | ok 2026-05-08 10:07:21.946352 | 2026-05-08 10:07:21.946489 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-08 10:07:21.997819 | debian-bookworm | ok 2026-05-08 10:07:22.014252 | 2026-05-08 10:07:22.014516 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-08 10:07:22.363899 | debian-bookworm -> localhost | ok 2026-05-08 10:07:22.371355 | 2026-05-08 10:07:22.371510 | TASK [validate-host : Collect information about the host] 2026-05-08 10:07:23.645323 | debian-bookworm | ok 2026-05-08 10:07:23.656488 | 2026-05-08 10:07:23.656608 | TASK [validate-host : Sanitize hostname] 2026-05-08 10:07:23.799858 | debian-bookworm | ok 2026-05-08 10:07:23.851107 | 2026-05-08 10:07:23.851257 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-08 10:07:24.497153 | debian-bookworm -> localhost | changed 2026-05-08 10:07:24.504676 | 2026-05-08 10:07:24.504845 | TASK [validate-host : Collect information about zuul worker] 2026-05-08 10:07:24.954874 | debian-bookworm | ok 2026-05-08 10:07:24.960695 | 2026-05-08 10:07:24.960831 | TASK [validate-host : Write out all zuul information for each host] 2026-05-08 10:07:25.679804 | debian-bookworm -> localhost | changed 2026-05-08 10:07:25.690526 | 2026-05-08 10:07:25.690677 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-08 10:07:25.978234 | debian-bookworm | ok 2026-05-08 10:07:25.984096 | 2026-05-08 10:07:25.984226 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-08 10:07:27.286023 | debian-bookworm | changed: 2026-05-08 10:07:27.286307 | debian-bookworm | cd+++++++++ src/ 2026-05-08 10:07:27.286347 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-08 10:07:27.286371 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-08 10:07:27.286393 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-05-08 10:07:27.286414 | debian-bookworm | Containerfile 2026-05-08 10:07:27.286545 | debian-bookworm | Containerfile 2026-05-08 10:07:27.314004 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/24ed44853b644cd9acf02a587b43f202/work/logs" 2026-05-08 10:07:33.017380 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/24ed44853b644cd9acf02a587b43f202/work/artifacts" 2026-05-08 10:07:33.348387 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/24ed44853b644cd9acf02a587b43f202/work/docs" 2026-05-08 10:07:33.375867 | 2026-05-08 10:07:33.376054 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-08 10:07:34.278355 | debian-bookworm | changed: 2026-05-08 10:07:34.278615 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-08 10:07:34.278653 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-08 10:07:34.278683 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-08 10:07:34.278728 | debian-bookworm | changed: All items complete 2026-05-08 10:07:34.278754 | 2026-05-08 10:07:35.062200 | debian-bookworm | changed: .d..t...... ./ 2026-05-08 10:07:35.793130 | debian-bookworm | changed: .d..t...... ./ 2026-05-08 10:07:35.816057 | 2026-05-08 10:07:35.816194 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-08 10:07:36.379329 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.009814 2026-05-08 10:07:36.716941 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.031983 2026-05-08 10:07:36.737526 | 2026-05-08 10:07:36.737739 | PLAY RECAP 2026-05-08 10:07:36.739335 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-08 10:07:36.739400 | 2026-05-08 10:07:36.923133 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-08 10:07:36.924034 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-08 10:07:38.071718 | 2026-05-08 10:07:38.071904 | PLAY [Base post] 2026-05-08 10:07:38.106992 | 2026-05-08 10:07:38.107153 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-08 10:07:38.771021 | debian-bookworm | changed 2026-05-08 10:07:38.784448 | 2026-05-08 10:07:38.784597 | PLAY RECAP 2026-05-08 10:07:38.784665 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-08 10:07:38.784730 | 2026-05-08 10:07:38.988985 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-08 10:07:38.989916 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-08 10:07:40.049897 | 2026-05-08 10:07:40.050088 | PLAY [Base post-logs] 2026-05-08 10:07:40.063762 | 2026-05-08 10:07:40.063938 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-08 10:07:40.640593 | localhost | changed 2026-05-08 10:07:40.668826 | 2026-05-08 10:07:40.669085 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-08 10:07:40.705041 | localhost | ok 2026-05-08 10:07:40.708054 | 2026-05-08 10:07:40.708146 | TASK [Set zuul-log-path fact] 2026-05-08 10:07:40.722562 | localhost | ok 2026-05-08 10:07:40.730628 | 2026-05-08 10:07:40.730726 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-08 10:07:40.754957 | localhost | ok 2026-05-08 10:07:40.757751 | 2026-05-08 10:07:40.757834 | TASK [upload-logs : Create log directories] 2026-05-08 10:07:41.270434 | localhost | changed 2026-05-08 10:07:41.273318 | 2026-05-08 10:07:41.273423 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-08 10:07:41.781033 | localhost -> localhost | ok: Runtime: 0:00:00.010619 2026-05-08 10:07:41.785971 | 2026-05-08 10:07:41.786099 | TASK [upload-logs : Upload logs to log server] 2026-05-08 10:07:42.345385 | localhost | Output suppressed because no_log was given 2026-05-08 10:07:42.347906 | 2026-05-08 10:07:42.348035 | LOOP [upload-logs : Compress console log and json output] 2026-05-08 10:07:42.414030 | localhost | skipping: Conditional result was False 2026-05-08 10:07:42.419597 | localhost | skipping: Conditional result was False 2026-05-08 10:07:42.431441 | 2026-05-08 10:07:42.431539 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-08 10:07:42.474191 | localhost | skipping: Conditional result was False 2026-05-08 10:07:42.474440 | 2026-05-08 10:07:42.480992 | localhost | skipping: Conditional result was False 2026-05-08 10:07:42.487435 | 2026-05-08 10:07:42.487527 | LOOP [upload-logs : Upload console log and json output]