2026-08-03 01:54:08.611007 | Job console starting 2026-08-03 01:54:08.632228 | Updating git repos 2026-08-03 01:54:08.681595 | Cloning repos into workspace 2026-08-03 01:54:08.794755 | Restoring repo states 2026-08-03 01:54:08.869491 | Merging changes 2026-08-03 01:54:09.594092 | Checking out repos 2026-08-03 01:54:09.629678 | Preparing playbooks 2026-08-03 01:54:10.667219 | Running Ansible setup 2026-08-03 01:54:17.740827 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-08-03 01:54:19.302535 | 2026-08-03 01:54:19.302864 | PLAY [Base pre] 2026-08-03 01:54:19.329131 | 2026-08-03 01:54:19.329273 | TASK [Setup log path fact] 2026-08-03 01:54:19.379553 | debian-bookworm | ok 2026-08-03 01:54:19.417409 | 2026-08-03 01:54:19.417871 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-03 01:54:19.475643 | debian-bookworm | ok 2026-08-03 01:54:19.492290 | 2026-08-03 01:54:19.492421 | TASK [emit-job-header : Print job information] 2026-08-03 01:54:19.531288 | # Job Information 2026-08-03 01:54:19.531461 | Ansible Version: 2.16.14 2026-08-03 01:54:19.531513 | Job: python-osism-test-setup 2026-08-03 01:54:19.531548 | Pipeline: check 2026-08-03 01:54:19.531572 | Executor: 521e9411259a 2026-08-03 01:54:19.531593 | Triggered by: https://github.com/osism/python-osism/pull/2545 2026-08-03 01:54:19.531615 | Event ID: e6a8ba10-8edd-11f1-8253-8e81a90e6c81 2026-08-03 01:54:19.536633 | 2026-08-03 01:54:19.536731 | LOOP [emit-job-header : Print node information] 2026-08-03 01:54:19.642455 | debian-bookworm | ok: 2026-08-03 01:54:19.642737 | debian-bookworm | # Node Information 2026-08-03 01:54:19.642778 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-08-03 01:54:19.642804 | debian-bookworm | Hostname: debian 2026-08-03 01:54:19.642827 | debian-bookworm | Username: zuul 2026-08-03 01:54:19.642872 | debian-bookworm | Distro: Debian 12.15 2026-08-03 01:54:19.642897 | debian-bookworm | Provider: regiocloud-a 2026-08-03 01:54:19.642919 | debian-bookworm | Region: 2026-08-03 01:54:19.642940 | debian-bookworm | Label: debian-bookworm 2026-08-03 01:54:19.642960 | debian-bookworm | Product Name: OpenStack Nova 2026-08-03 01:54:19.642980 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:febe:1f4f 2026-08-03 01:54:19.669463 | 2026-08-03 01:54:19.669627 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-03 01:54:20.305841 | debian-bookworm -> localhost | changed 2026-08-03 01:54:20.316174 | 2026-08-03 01:54:20.316298 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-03 01:54:22.210112 | debian-bookworm -> localhost | changed 2026-08-03 01:54:22.222919 | 2026-08-03 01:54:22.223037 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-03 01:54:22.923428 | debian-bookworm -> localhost | ok 2026-08-03 01:54:22.934186 | 2026-08-03 01:54:22.936609 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-03 01:54:23.007439 | debian-bookworm | ok 2026-08-03 01:54:23.040957 | debian-bookworm | included: /var/lib/zuul/builds/0b58dd838f604b7c95be9129cedcab94/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-03 01:54:23.047757 | 2026-08-03 01:54:23.047891 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-03 01:54:26.298300 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-08-03 01:54:26.298978 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/0b58dd838f604b7c95be9129cedcab94/work/0b58dd838f604b7c95be9129cedcab94_id_rsa 2026-08-03 01:54:26.299055 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/0b58dd838f604b7c95be9129cedcab94/work/0b58dd838f604b7c95be9129cedcab94_id_rsa.pub 2026-08-03 01:54:26.299209 | debian-bookworm -> localhost | The key fingerprint is: 2026-08-03 01:54:26.299241 | debian-bookworm -> localhost | SHA256:asnpqM7zXl3DFl7zmm/mGkCY0FJX+iQ6YzXkWemKfzA zuul-build-sshkey 2026-08-03 01:54:26.299266 | debian-bookworm -> localhost | The key's randomart image is: 2026-08-03 01:54:26.299362 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-08-03 01:54:26.299458 | debian-bookworm -> localhost | | .o. o.o. | 2026-08-03 01:54:26.299530 | debian-bookworm -> localhost | | ...* +. | 2026-08-03 01:54:26.299552 | debian-bookworm -> localhost | | .o X.+ | 2026-08-03 01:54:26.299588 | debian-bookworm -> localhost | | * B.o | 2026-08-03 01:54:26.299796 | debian-bookworm -> localhost | | S.B.. . | 2026-08-03 01:54:26.299831 | debian-bookworm -> localhost | | . *.=Eo o | 2026-08-03 01:54:26.299854 | debian-bookworm -> localhost | | B .. o+ | 2026-08-03 01:54:26.299876 | debian-bookworm -> localhost | | .. = . .oo | 2026-08-03 01:54:26.300014 | debian-bookworm -> localhost | | .+=+ . ..=o | 2026-08-03 01:54:26.300045 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-08-03 01:54:26.300260 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.280891 2026-08-03 01:54:26.313177 | 2026-08-03 01:54:26.313309 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-03 01:54:26.343153 | debian-bookworm | ok 2026-08-03 01:54:26.356748 | debian-bookworm | included: /var/lib/zuul/builds/0b58dd838f604b7c95be9129cedcab94/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-03 01:54:26.384263 | 2026-08-03 01:54:26.384602 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-03 01:54:26.420139 | debian-bookworm | skipping: Conditional result was False 2026-08-03 01:54:26.429028 | 2026-08-03 01:54:26.429305 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-03 01:54:27.308492 | debian-bookworm | changed 2026-08-03 01:54:27.315859 | 2026-08-03 01:54:27.315999 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-03 01:54:27.624710 | debian-bookworm | ok 2026-08-03 01:54:27.635637 | 2026-08-03 01:54:27.635808 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-03 01:54:28.424810 | debian-bookworm | changed 2026-08-03 01:54:28.435367 | 2026-08-03 01:54:28.436553 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-03 01:54:29.242092 | debian-bookworm | changed 2026-08-03 01:54:29.255585 | 2026-08-03 01:54:29.255752 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-03 01:54:29.317984 | debian-bookworm | skipping: Conditional result was False 2026-08-03 01:54:29.329514 | 2026-08-03 01:54:29.329663 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-03 01:54:30.321347 | debian-bookworm -> localhost | changed 2026-08-03 01:54:30.359716 | 2026-08-03 01:54:30.359892 | TASK [add-build-sshkey : Add back temp key] 2026-08-03 01:54:30.947609 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/0b58dd838f604b7c95be9129cedcab94/work/0b58dd838f604b7c95be9129cedcab94_id_rsa (zuul-build-sshkey) 2026-08-03 01:54:30.948551 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011738 2026-08-03 01:54:30.962796 | 2026-08-03 01:54:30.962978 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-03 01:54:31.432937 | debian-bookworm | ok 2026-08-03 01:54:31.439001 | 2026-08-03 01:54:31.439125 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-03 01:54:31.469259 | debian-bookworm | skipping: Conditional result was False 2026-08-03 01:54:31.481018 | 2026-08-03 01:54:31.481151 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-08-03 01:54:32.039691 | debian-bookworm | ok 2026-08-03 01:54:32.066804 | 2026-08-03 01:54:32.067043 | TASK [validate-host : Define zuul_info_dir fact] 2026-08-03 01:54:32.128409 | debian-bookworm | ok 2026-08-03 01:54:32.134651 | 2026-08-03 01:54:32.134777 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-08-03 01:54:32.437355 | debian-bookworm -> localhost | ok 2026-08-03 01:54:32.444664 | 2026-08-03 01:54:32.444789 | TASK [validate-host : Collect information about the host] 2026-08-03 01:54:33.755519 | debian-bookworm | ok 2026-08-03 01:54:33.800290 | 2026-08-03 01:54:33.800496 | TASK [validate-host : Sanitize hostname] 2026-08-03 01:54:34.043500 | debian-bookworm | ok 2026-08-03 01:54:34.053657 | 2026-08-03 01:54:34.053778 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-08-03 01:54:35.530144 | debian-bookworm -> localhost | changed 2026-08-03 01:54:35.537202 | 2026-08-03 01:54:35.537340 | TASK [validate-host : Collect information about zuul worker] 2026-08-03 01:54:36.075348 | debian-bookworm | ok 2026-08-03 01:54:36.086637 | 2026-08-03 01:54:36.086796 | TASK [validate-host : Write out all zuul information for each host] 2026-08-03 01:54:37.353391 | debian-bookworm -> localhost | changed 2026-08-03 01:54:37.367030 | 2026-08-03 01:54:37.367150 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-08-03 01:54:37.671827 | debian-bookworm | ok 2026-08-03 01:54:37.682279 | 2026-08-03 01:54:37.682395 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-08-03 01:54:38.876671 | debian-bookworm | changed: 2026-08-03 01:54:38.876864 | debian-bookworm | cd+++++++++ src/ 2026-08-03 01:54:38.876899 | debian-bookworm | cd+++++++++ src/github.com/ 2026-08-03 01:54:38.876923 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-08-03 01:54:38.876944 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-08-03 01:54:38.876964 | debian-bookworm | Containerfile 2026-08-03 01:54:38.877095 | debian-bookworm | Containerfile 2026-08-03 01:54:38.889988 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/0b58dd838f604b7c95be9129cedcab94/work/logs" 2026-08-03 01:57:09.739966 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/0b58dd838f604b7c95be9129cedcab94/work/artifacts" 2026-08-03 01:57:10.010745 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/0b58dd838f604b7c95be9129cedcab94/work/docs" 2026-08-03 01:57:10.029003 | 2026-08-03 01:57:10.029190 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-03 01:57:10.876352 | debian-bookworm | changed: 2026-08-03 01:57:10.876694 | debian-bookworm | .d..t...... ./ 2026-08-03 01:57:10.876746 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-08-03 01:57:10.876785 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-08-03 01:57:10.876821 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-08-03 01:57:10.876858 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-08-03 01:57:10.876885 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-08-03 01:57:10.876944 | debian-bookworm | changed: All items complete 2026-08-03 01:57:10.876977 | 2026-08-03 01:57:11.497384 | debian-bookworm | changed: .d..t...... ./ 2026-08-03 01:57:12.105175 | debian-bookworm | changed: .d..t...... ./ 2026-08-03 01:57:12.126512 | 2026-08-03 01:57:12.126696 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-03 01:57:12.499278 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.011247 2026-08-03 01:57:12.793325 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.011336 2026-08-03 01:57:12.812961 | 2026-08-03 01:57:12.813231 | PLAY RECAP 2026-08-03 01:57:12.813378 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-03 01:57:12.813476 | 2026-08-03 01:57:12.980955 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-08-03 01:57:12.983447 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-03 01:57:13.800224 | 2026-08-03 01:57:13.800469 | PLAY [Base post] 2026-08-03 01:57:13.815492 | 2026-08-03 01:57:13.815652 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-03 01:57:14.664817 | debian-bookworm | changed 2026-08-03 01:57:14.680975 | 2026-08-03 01:57:14.681151 | PLAY RECAP 2026-08-03 01:57:14.681237 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-03 01:57:14.681319 | 2026-08-03 01:57:14.856760 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-03 01:57:14.864250 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-03 01:57:15.692989 | 2026-08-03 01:57:15.693244 | PLAY [Base post-logs] 2026-08-03 01:57:15.705734 | 2026-08-03 01:57:15.705919 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-03 01:57:16.224970 | localhost | changed 2026-08-03 01:57:16.236825 | 2026-08-03 01:57:16.237199 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-03 01:57:16.276992 | localhost | ok 2026-08-03 01:57:16.280566 | 2026-08-03 01:57:16.280680 | TASK [Set zuul-log-path fact] 2026-08-03 01:57:16.297315 | localhost | ok 2026-08-03 01:57:16.306385 | 2026-08-03 01:57:16.306583 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-03 01:57:16.333034 | localhost | ok 2026-08-03 01:57:16.336597 | 2026-08-03 01:57:16.336736 | TASK [upload-logs : Create log directories] 2026-08-03 01:57:16.923418 | localhost | changed 2026-08-03 01:57:16.927331 | 2026-08-03 01:57:16.927488 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-03 01:57:17.470999 | localhost -> localhost | ok: Runtime: 0:00:00.021637 2026-08-03 01:57:17.477803 | 2026-08-03 01:57:17.477979 | TASK [upload-logs : Upload logs to log server] 2026-08-03 01:57:18.074049 | localhost | Output suppressed because no_log was given 2026-08-03 01:57:18.076382 | 2026-08-03 01:57:18.076526 | LOOP [upload-logs : Compress console log and json output] 2026-08-03 01:57:18.127317 | localhost | skipping: Conditional result was False 2026-08-03 01:57:18.135963 | localhost | skipping: Conditional result was False 2026-08-03 01:57:18.148161 | 2026-08-03 01:57:18.148531 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-03 01:57:18.202542 | localhost | skipping: Conditional result was False 2026-08-03 01:57:18.202919 | 2026-08-03 01:57:18.208067 | localhost | skipping: Conditional result was False 2026-08-03 01:57:18.221334 | 2026-08-03 01:57:18.221623 | LOOP [upload-logs : Upload console log and json output]