2026-07-06 10:26:00.394083 | Job console starting 2026-07-06 10:26:00.422774 | Updating git repos 2026-07-06 10:26:00.535502 | Cloning repos into workspace 2026-07-06 10:26:00.624725 | Restoring repo states 2026-07-06 10:26:00.665237 | Merging changes 2026-07-06 10:26:01.443497 | Checking out repos 2026-07-06 10:26:01.638029 | Preparing playbooks 2026-07-06 10:26:04.005370 | Running Ansible setup 2026-07-06 10:26:10.549900 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-06 10:26:12.122936 | 2026-07-06 10:26:12.123080 | PLAY [Base pre] 2026-07-06 10:26:12.143610 | 2026-07-06 10:26:12.143730 | TASK [Setup log path fact] 2026-07-06 10:26:12.171241 | debian-bookworm | ok 2026-07-06 10:26:12.184587 | 2026-07-06 10:26:12.184717 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-06 10:26:12.242170 | debian-bookworm | ok 2026-07-06 10:26:12.251081 | 2026-07-06 10:26:12.251177 | TASK [emit-job-header : Print job information] 2026-07-06 10:26:12.308619 | # Job Information 2026-07-06 10:26:12.308766 | Ansible Version: 2.16.14 2026-07-06 10:26:12.308795 | Job: python-osism-test-setup 2026-07-06 10:26:12.308822 | Pipeline: check 2026-07-06 10:26:12.308841 | Executor: 521e9411259a 2026-07-06 10:26:12.308859 | Triggered by: https://github.com/osism/python-osism/pull/2440 2026-07-06 10:26:12.308878 | Event ID: 0ef600f0-7925-11f1-84e3-b2c6f3452f0b 2026-07-06 10:26:12.312964 | 2026-07-06 10:26:12.313046 | LOOP [emit-job-header : Print node information] 2026-07-06 10:26:12.590322 | debian-bookworm | ok: 2026-07-06 10:26:12.590482 | debian-bookworm | # Node Information 2026-07-06 10:26:12.590510 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-06 10:26:12.590530 | debian-bookworm | Hostname: debian 2026-07-06 10:26:12.590549 | debian-bookworm | Username: zuul 2026-07-06 10:26:12.590566 | debian-bookworm | Distro: Debian 12.14 2026-07-06 10:26:12.590587 | debian-bookworm | Provider: regiocloud-a 2026-07-06 10:26:12.590604 | debian-bookworm | Region: 2026-07-06 10:26:12.590622 | debian-bookworm | Label: debian-bookworm 2026-07-06 10:26:12.590638 | debian-bookworm | Product Name: OpenStack Nova 2026-07-06 10:26:12.590655 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe69:bb1 2026-07-06 10:26:12.608907 | 2026-07-06 10:26:12.609022 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-06 10:26:13.513451 | debian-bookworm -> localhost | changed 2026-07-06 10:26:13.519858 | 2026-07-06 10:26:13.519983 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-06 10:26:16.749361 | debian-bookworm -> localhost | changed 2026-07-06 10:26:16.758451 | 2026-07-06 10:26:16.758557 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-06 10:26:17.505085 | debian-bookworm -> localhost | ok 2026-07-06 10:26:17.510432 | 2026-07-06 10:26:17.510529 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-06 10:26:17.535646 | debian-bookworm | ok 2026-07-06 10:26:17.576717 | debian-bookworm | included: /var/lib/zuul/builds/5c8561162f7b4923bc0fd90664cebd3f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-06 10:26:17.583462 | 2026-07-06 10:26:17.583551 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-06 10:26:20.401755 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-06 10:26:20.401930 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/5c8561162f7b4923bc0fd90664cebd3f/work/5c8561162f7b4923bc0fd90664cebd3f_id_rsa 2026-07-06 10:26:20.401960 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/5c8561162f7b4923bc0fd90664cebd3f/work/5c8561162f7b4923bc0fd90664cebd3f_id_rsa.pub 2026-07-06 10:26:20.401981 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-06 10:26:20.402002 | debian-bookworm -> localhost | SHA256:ueqMkXNO3r1QvA3lNMz7ssvaMY/wK8A88wfT+AxAhzA zuul-build-sshkey 2026-07-06 10:26:20.402021 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-06 10:26:20.402049 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-06 10:26:20.402068 | debian-bookworm -> localhost | | E. . | 2026-07-06 10:26:20.402086 | debian-bookworm -> localhost | | .o .o | 2026-07-06 10:26:20.402103 | debian-bookworm -> localhost | | . . * | 2026-07-06 10:26:20.402120 | debian-bookworm -> localhost | | .o + o | 2026-07-06 10:26:20.402137 | debian-bookworm -> localhost | | oS.+oo | 2026-07-06 10:26:20.402159 | debian-bookworm -> localhost | | . *o=+.. | 2026-07-06 10:26:20.402176 | debian-bookworm -> localhost | | + o o=o*= . | 2026-07-06 10:26:20.402204 | debian-bookworm -> localhost | | X o oo=+B | 2026-07-06 10:26:20.402222 | debian-bookworm -> localhost | | ..* . +=Oo. | 2026-07-06 10:26:20.402238 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-06 10:26:20.402282 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.720201 2026-07-06 10:26:20.407819 | 2026-07-06 10:26:20.407910 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-06 10:26:20.434756 | debian-bookworm | ok 2026-07-06 10:26:20.443145 | debian-bookworm | included: /var/lib/zuul/builds/5c8561162f7b4923bc0fd90664cebd3f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-06 10:26:20.450136 | 2026-07-06 10:26:20.450220 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-06 10:26:20.463284 | debian-bookworm | skipping: Conditional result was False 2026-07-06 10:26:20.469394 | 2026-07-06 10:26:20.469507 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-06 10:26:21.168252 | debian-bookworm | changed 2026-07-06 10:26:21.177773 | 2026-07-06 10:26:21.177885 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-06 10:26:21.456211 | debian-bookworm | ok 2026-07-06 10:26:21.462429 | 2026-07-06 10:26:21.462527 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-06 10:26:22.243747 | debian-bookworm | changed 2026-07-06 10:26:22.248496 | 2026-07-06 10:26:22.248596 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-06 10:26:22.980575 | debian-bookworm | changed 2026-07-06 10:26:22.985163 | 2026-07-06 10:26:22.985269 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-06 10:26:23.019287 | debian-bookworm | skipping: Conditional result was False 2026-07-06 10:26:23.026971 | 2026-07-06 10:26:23.027094 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-06 10:26:23.582251 | debian-bookworm -> localhost | changed 2026-07-06 10:26:23.594590 | 2026-07-06 10:26:23.594719 | TASK [add-build-sshkey : Add back temp key] 2026-07-06 10:26:24.111407 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/5c8561162f7b4923bc0fd90664cebd3f/work/5c8561162f7b4923bc0fd90664cebd3f_id_rsa (zuul-build-sshkey) 2026-07-06 10:26:24.111637 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.047825 2026-07-06 10:26:24.119103 | 2026-07-06 10:26:24.119237 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-06 10:26:24.670333 | debian-bookworm | ok 2026-07-06 10:26:24.675488 | 2026-07-06 10:26:24.675584 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-06 10:26:24.729045 | debian-bookworm | skipping: Conditional result was False 2026-07-06 10:26:24.739210 | 2026-07-06 10:26:24.739320 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-06 10:26:25.439340 | debian-bookworm | ok 2026-07-06 10:26:25.457221 | 2026-07-06 10:26:25.457346 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-06 10:26:25.489756 | debian-bookworm | ok 2026-07-06 10:26:25.496195 | 2026-07-06 10:26:25.496294 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-06 10:26:25.762302 | debian-bookworm -> localhost | ok 2026-07-06 10:26:25.769745 | 2026-07-06 10:26:25.769882 | TASK [validate-host : Collect information about the host] 2026-07-06 10:26:26.928986 | debian-bookworm | ok 2026-07-06 10:26:26.958291 | 2026-07-06 10:26:26.958408 | TASK [validate-host : Sanitize hostname] 2026-07-06 10:26:27.165012 | debian-bookworm | ok 2026-07-06 10:26:27.173661 | 2026-07-06 10:26:27.173776 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-06 10:26:27.944246 | debian-bookworm -> localhost | changed 2026-07-06 10:26:27.949790 | 2026-07-06 10:26:27.949890 | TASK [validate-host : Collect information about zuul worker] 2026-07-06 10:26:28.455403 | debian-bookworm | ok 2026-07-06 10:26:28.459359 | 2026-07-06 10:26:28.459448 | TASK [validate-host : Write out all zuul information for each host] 2026-07-06 10:26:29.121869 | debian-bookworm -> localhost | changed 2026-07-06 10:26:29.133666 | 2026-07-06 10:26:29.133778 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-06 10:26:29.478765 | debian-bookworm | ok 2026-07-06 10:26:29.487823 | 2026-07-06 10:26:29.487932 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-06 10:26:30.791119 | debian-bookworm | changed: 2026-07-06 10:26:30.791384 | debian-bookworm | cd+++++++++ src/ 2026-07-06 10:26:30.791422 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-06 10:26:30.791446 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-06 10:26:30.791468 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-07-06 10:26:30.791488 | debian-bookworm | Containerfile 2026-07-06 10:26:30.791621 | debian-bookworm | Containerfile 2026-07-06 10:26:30.798140 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/5c8561162f7b4923bc0fd90664cebd3f/work/logs" 2026-07-06 10:29:14.428024 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/5c8561162f7b4923bc0fd90664cebd3f/work/artifacts" 2026-07-06 10:29:14.725790 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/5c8561162f7b4923bc0fd90664cebd3f/work/docs" 2026-07-06 10:29:14.748440 | 2026-07-06 10:29:14.748657 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-06 10:29:15.548337 | debian-bookworm | changed: 2026-07-06 10:29:15.548688 | debian-bookworm | .d..t...... ./ 2026-07-06 10:29:15.548746 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-06 10:29:15.548787 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-06 10:29:15.548823 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-06 10:29:15.548863 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-06 10:29:15.548899 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-06 10:29:15.548969 | debian-bookworm | changed: All items complete 2026-07-06 10:29:15.549013 | 2026-07-06 10:29:16.123899 | debian-bookworm | changed: .d..t...... ./ 2026-07-06 10:29:16.703750 | debian-bookworm | changed: .d..t...... ./ 2026-07-06 10:29:16.734414 | 2026-07-06 10:29:16.734611 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-06 10:29:17.103273 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.008684 2026-07-06 10:29:17.415241 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.010453 2026-07-06 10:29:17.427055 | 2026-07-06 10:29:17.427194 | PLAY RECAP 2026-07-06 10:29:17.427250 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-07-06 10:29:17.427290 | 2026-07-06 10:29:17.580073 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-06 10:29:17.582285 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-06 10:29:18.379436 | 2026-07-06 10:29:18.379645 | PLAY [Base post] 2026-07-06 10:29:18.395574 | 2026-07-06 10:29:18.395764 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-06 10:29:19.234894 | debian-bookworm | changed 2026-07-06 10:29:19.244734 | 2026-07-06 10:29:19.244872 | PLAY RECAP 2026-07-06 10:29:19.244990 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-06 10:29:19.245092 | 2026-07-06 10:29:19.410404 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-06 10:29:19.412059 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-06 10:29:20.249977 | 2026-07-06 10:29:20.250208 | PLAY [Base post-logs] 2026-07-06 10:29:20.261699 | 2026-07-06 10:29:20.261848 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-06 10:29:20.746767 | localhost | changed 2026-07-06 10:29:20.757768 | 2026-07-06 10:29:20.757931 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-06 10:29:20.794823 | localhost | ok 2026-07-06 10:29:20.799241 | 2026-07-06 10:29:20.799368 | TASK [Set zuul-log-path fact] 2026-07-06 10:29:20.815475 | localhost | ok 2026-07-06 10:29:20.833829 | 2026-07-06 10:29:20.834005 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-06 10:29:20.873631 | localhost | ok 2026-07-06 10:29:20.881331 | 2026-07-06 10:29:20.881649 | TASK [upload-logs : Create log directories] 2026-07-06 10:29:21.489853 | localhost | changed 2026-07-06 10:29:21.493047 | 2026-07-06 10:29:21.493201 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-06 10:29:22.026367 | localhost -> localhost | ok: Runtime: 0:00:00.007301 2026-07-06 10:29:22.035168 | 2026-07-06 10:29:22.035445 | TASK [upload-logs : Upload logs to log server] 2026-07-06 10:29:22.628609 | localhost | Output suppressed because no_log was given 2026-07-06 10:29:22.633354 | 2026-07-06 10:29:22.633657 | LOOP [upload-logs : Compress console log and json output] 2026-07-06 10:29:22.688425 | localhost | skipping: Conditional result was False 2026-07-06 10:29:22.697006 | localhost | skipping: Conditional result was False 2026-07-06 10:29:22.707600 | 2026-07-06 10:29:22.707813 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-06 10:29:22.759656 | localhost | skipping: Conditional result was False 2026-07-06 10:29:22.759989 | 2026-07-06 10:29:22.766937 | localhost | skipping: Conditional result was False 2026-07-06 10:29:22.782509 | 2026-07-06 10:29:22.782774 | LOOP [upload-logs : Upload console log and json output]