2026-06-29 02:39:04.181526 | Job console starting 2026-06-29 02:39:04.203146 | Updating git repos 2026-06-29 02:39:04.275858 | Cloning repos into workspace 2026-06-29 02:39:04.415560 | Restoring repo states 2026-06-29 02:39:04.497777 | Merging changes 2026-06-29 02:39:05.598533 | Checking out repos 2026-06-29 02:39:05.684267 | Preparing playbooks 2026-06-29 02:39:07.972818 | Running Ansible setup 2026-06-29 02:39:14.145601 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-29 02:39:15.577442 | 2026-06-29 02:39:15.577647 | PLAY [Base pre] 2026-06-29 02:39:15.607796 | 2026-06-29 02:39:15.607983 | TASK [Setup log path fact] 2026-06-29 02:39:15.652440 | debian-bookworm | ok 2026-06-29 02:39:15.671759 | 2026-06-29 02:39:15.671935 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-29 02:39:15.701633 | debian-bookworm | ok 2026-06-29 02:39:15.712425 | 2026-06-29 02:39:15.712577 | TASK [emit-job-header : Print job information] 2026-06-29 02:39:15.759745 | # Job Information 2026-06-29 02:39:15.760078 | Ansible Version: 2.16.14 2026-06-29 02:39:15.760148 | Job: python-osism-test-setup 2026-06-29 02:39:15.760217 | Pipeline: check 2026-06-29 02:39:15.760264 | Executor: 521e9411259a 2026-06-29 02:39:15.760307 | Triggered by: https://github.com/osism/python-osism/pull/2422 2026-06-29 02:39:15.760374 | Event ID: 90188a80-7363-11f1-9119-762c5b04703c 2026-06-29 02:39:15.769779 | 2026-06-29 02:39:15.769968 | LOOP [emit-job-header : Print node information] 2026-06-29 02:39:15.954695 | debian-bookworm | ok: 2026-06-29 02:39:15.954974 | debian-bookworm | # Node Information 2026-06-29 02:39:15.955011 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-29 02:39:15.955037 | debian-bookworm | Hostname: debian 2026-06-29 02:39:15.955061 | debian-bookworm | Username: zuul 2026-06-29 02:39:15.955082 | debian-bookworm | Distro: Debian 12.14 2026-06-29 02:39:15.955106 | debian-bookworm | Provider: regiocloud-a 2026-06-29 02:39:15.955127 | debian-bookworm | Region: 2026-06-29 02:39:15.955149 | debian-bookworm | Label: debian-bookworm 2026-06-29 02:39:15.955170 | debian-bookworm | Product Name: OpenStack Nova 2026-06-29 02:39:15.955190 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe8d:6e2c 2026-06-29 02:39:15.976441 | 2026-06-29 02:39:15.976612 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-29 02:39:16.757398 | debian-bookworm -> localhost | changed 2026-06-29 02:39:16.774441 | 2026-06-29 02:39:16.774713 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-29 02:39:18.212779 | debian-bookworm -> localhost | changed 2026-06-29 02:39:18.225535 | 2026-06-29 02:39:18.225700 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-29 02:39:18.745202 | debian-bookworm -> localhost | ok 2026-06-29 02:39:18.753322 | 2026-06-29 02:39:18.753522 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-29 02:39:18.788928 | debian-bookworm | ok 2026-06-29 02:39:18.815711 | debian-bookworm | included: /var/lib/zuul/builds/ee7f69e34b64428aa5cdf3a84487b2cc/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-29 02:39:18.827585 | 2026-06-29 02:39:18.827933 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-29 02:39:20.796396 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-29 02:39:20.797188 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/ee7f69e34b64428aa5cdf3a84487b2cc/work/ee7f69e34b64428aa5cdf3a84487b2cc_id_rsa 2026-06-29 02:39:20.797238 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/ee7f69e34b64428aa5cdf3a84487b2cc/work/ee7f69e34b64428aa5cdf3a84487b2cc_id_rsa.pub 2026-06-29 02:39:20.797267 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-29 02:39:20.797294 | debian-bookworm -> localhost | SHA256:g9hcE0mHTYMrfApMwRtdTUNB4N0FNiluqZ7O3QbLya0 zuul-build-sshkey 2026-06-29 02:39:20.797319 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-29 02:39:20.797397 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-29 02:39:20.797423 | debian-bookworm -> localhost | | ..o o=%X.+o. | 2026-06-29 02:39:20.797447 | debian-bookworm -> localhost | | + ..+++=.o | 2026-06-29 02:39:20.797469 | debian-bookworm -> localhost | | o + +o.o. | 2026-06-29 02:39:20.797490 | debian-bookworm -> localhost | | ++ooo.+ | 2026-06-29 02:39:20.797510 | debian-bookworm -> localhost | | ..++So | 2026-06-29 02:39:20.797532 | debian-bookworm -> localhost | | . ... | 2026-06-29 02:39:20.797554 | debian-bookworm -> localhost | | . + = | 2026-06-29 02:39:20.797574 | debian-bookworm -> localhost | | .o.=.o | 2026-06-29 02:39:20.797596 | debian-bookworm -> localhost | | .o Eo. | 2026-06-29 02:39:20.797616 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-29 02:39:20.797681 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.007405 2026-06-29 02:39:20.805661 | 2026-06-29 02:39:20.805799 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-29 02:39:20.839321 | debian-bookworm | ok 2026-06-29 02:39:20.865021 | debian-bookworm | included: /var/lib/zuul/builds/ee7f69e34b64428aa5cdf3a84487b2cc/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-29 02:39:20.890499 | 2026-06-29 02:39:20.890668 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-29 02:39:20.916201 | debian-bookworm | skipping: Conditional result was False 2026-06-29 02:39:20.938582 | 2026-06-29 02:39:20.938775 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-29 02:39:22.078224 | debian-bookworm | changed 2026-06-29 02:39:22.089888 | 2026-06-29 02:39:22.090244 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-29 02:39:22.371744 | debian-bookworm | ok 2026-06-29 02:39:22.388678 | 2026-06-29 02:39:22.388852 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-29 02:39:23.093448 | debian-bookworm | changed 2026-06-29 02:39:23.099447 | 2026-06-29 02:39:23.099590 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-29 02:39:23.811313 | debian-bookworm | changed 2026-06-29 02:39:23.820814 | 2026-06-29 02:39:23.820992 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-29 02:39:23.846506 | debian-bookworm | skipping: Conditional result was False 2026-06-29 02:39:23.860543 | 2026-06-29 02:39:23.860720 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-29 02:39:24.956758 | debian-bookworm -> localhost | changed 2026-06-29 02:39:24.968801 | 2026-06-29 02:39:24.968956 | TASK [add-build-sshkey : Add back temp key] 2026-06-29 02:39:25.511428 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/ee7f69e34b64428aa5cdf3a84487b2cc/work/ee7f69e34b64428aa5cdf3a84487b2cc_id_rsa (zuul-build-sshkey) 2026-06-29 02:39:25.511804 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013653 2026-06-29 02:39:25.521807 | 2026-06-29 02:39:25.521957 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-29 02:39:26.049682 | debian-bookworm | ok 2026-06-29 02:39:26.056906 | 2026-06-29 02:39:26.057070 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-29 02:39:26.091936 | debian-bookworm | skipping: Conditional result was False 2026-06-29 02:39:26.108188 | 2026-06-29 02:39:26.108416 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-29 02:39:26.622773 | debian-bookworm | ok 2026-06-29 02:39:26.645019 | 2026-06-29 02:39:26.645201 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-29 02:39:26.686302 | debian-bookworm | ok 2026-06-29 02:39:26.692202 | 2026-06-29 02:39:26.692363 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-29 02:39:27.429570 | debian-bookworm -> localhost | ok 2026-06-29 02:39:27.437178 | 2026-06-29 02:39:27.437325 | TASK [validate-host : Collect information about the host] 2026-06-29 02:39:29.253392 | debian-bookworm | ok 2026-06-29 02:39:29.279630 | 2026-06-29 02:39:29.279792 | TASK [validate-host : Sanitize hostname] 2026-06-29 02:39:29.681065 | debian-bookworm | ok 2026-06-29 02:39:29.691952 | 2026-06-29 02:39:29.692118 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-29 02:39:32.084305 | debian-bookworm -> localhost | changed 2026-06-29 02:39:32.092129 | 2026-06-29 02:39:32.092238 | TASK [validate-host : Collect information about zuul worker] 2026-06-29 02:39:32.727905 | debian-bookworm | ok 2026-06-29 02:39:32.732770 | 2026-06-29 02:39:32.732887 | TASK [validate-host : Write out all zuul information for each host] 2026-06-29 02:39:33.724042 | debian-bookworm -> localhost | changed 2026-06-29 02:39:33.742301 | 2026-06-29 02:39:33.742432 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-29 02:39:34.092975 | debian-bookworm | ok 2026-06-29 02:39:34.108324 | 2026-06-29 02:39:34.108453 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-29 02:39:36.028074 | debian-bookworm | changed: 2026-06-29 02:39:36.028232 | debian-bookworm | cd+++++++++ src/ 2026-06-29 02:39:36.028260 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-29 02:39:36.028281 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-29 02:39:36.028300 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-06-29 02:39:36.028317 | debian-bookworm | Containerfile 2026-06-29 02:39:36.028442 | debian-bookworm | Containerfile 2026-06-29 02:39:36.045034 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/ee7f69e34b64428aa5cdf3a84487b2cc/work/logs" 2026-06-29 02:42:19.720663 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/ee7f69e34b64428aa5cdf3a84487b2cc/work/artifacts" 2026-06-29 02:42:20.024174 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/ee7f69e34b64428aa5cdf3a84487b2cc/work/docs" 2026-06-29 02:42:20.048952 | 2026-06-29 02:42:20.049323 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-29 02:42:20.860502 | debian-bookworm | changed: 2026-06-29 02:42:20.861857 | debian-bookworm | .d..t...... ./ 2026-06-29 02:42:20.861934 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-06-29 02:42:20.861979 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-06-29 02:42:20.862017 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-29 02:42:20.862055 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-29 02:42:20.862092 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-29 02:42:20.862170 | debian-bookworm | changed: All items complete 2026-06-29 02:42:20.862217 | 2026-06-29 02:42:21.443072 | debian-bookworm | changed: .d..t...... ./ 2026-06-29 02:42:22.009821 | debian-bookworm | changed: .d..t...... ./ 2026-06-29 02:42:22.040574 | 2026-06-29 02:42:22.040746 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-29 02:42:22.438379 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.011749 2026-06-29 02:42:22.725278 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.009467 2026-06-29 02:42:22.745065 | 2026-06-29 02:42:22.745266 | PLAY RECAP 2026-06-29 02:42:22.745338 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-29 02:42:22.745371 | 2026-06-29 02:42:22.901824 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-29 02:42:22.902961 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-29 02:42:23.792129 | 2026-06-29 02:42:23.792318 | PLAY [Base post] 2026-06-29 02:42:23.808169 | 2026-06-29 02:42:23.808345 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-29 02:42:24.686303 | debian-bookworm | changed 2026-06-29 02:42:24.693139 | 2026-06-29 02:42:24.693257 | PLAY RECAP 2026-06-29 02:42:24.693323 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-29 02:42:24.693386 | 2026-06-29 02:42:24.857587 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-29 02:42:24.858501 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-29 02:42:25.852324 | 2026-06-29 02:42:25.852539 | PLAY [Base post-logs] 2026-06-29 02:42:25.864022 | 2026-06-29 02:42:25.864177 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-29 02:42:26.530997 | localhost | changed 2026-06-29 02:42:26.542381 | 2026-06-29 02:42:26.542592 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-29 02:42:26.579569 | localhost | ok 2026-06-29 02:42:26.583628 | 2026-06-29 02:42:26.583749 | TASK [Set zuul-log-path fact] 2026-06-29 02:42:26.599841 | localhost | ok 2026-06-29 02:42:26.608408 | 2026-06-29 02:42:26.608582 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-29 02:42:26.638376 | localhost | ok 2026-06-29 02:42:26.644205 | 2026-06-29 02:42:26.644366 | TASK [upload-logs : Create log directories] 2026-06-29 02:42:27.231793 | localhost | changed 2026-06-29 02:42:27.235225 | 2026-06-29 02:42:27.235344 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-29 02:42:27.779411 | localhost -> localhost | ok: Runtime: 0:00:00.007257 2026-06-29 02:42:27.784286 | 2026-06-29 02:42:27.784421 | TASK [upload-logs : Upload logs to log server] 2026-06-29 02:42:28.402471 | localhost | Output suppressed because no_log was given 2026-06-29 02:42:28.411328 | 2026-06-29 02:42:28.411549 | LOOP [upload-logs : Compress console log and json output] 2026-06-29 02:42:28.493982 | localhost | skipping: Conditional result was False 2026-06-29 02:42:28.503035 | localhost | skipping: Conditional result was False 2026-06-29 02:42:28.507602 | 2026-06-29 02:42:28.507736 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-29 02:42:28.559305 | localhost | skipping: Conditional result was False 2026-06-29 02:42:28.559624 | 2026-06-29 02:42:28.568392 | localhost | skipping: Conditional result was False 2026-06-29 02:42:28.578114 | 2026-06-29 02:42:28.578259 | LOOP [upload-logs : Upload console log and json output]