2026-08-26 12:01:11.331319 | Job console starting 2026-08-26 12:01:11.369640 | Updating git repos 2026-08-26 12:01:11.532190 | Cloning repos into workspace 2026-08-26 12:01:11.707773 | Restoring repo states 2026-08-26 12:01:11.761507 | Merging changes 2026-08-26 12:01:12.973957 | Checking out repos 2026-08-26 12:01:13.093611 | Preparing playbooks 2026-08-26 12:01:15.101542 | Running Ansible setup 2026-08-26 12:01:20.989061 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-08-26 12:01:22.151459 | 2026-08-26 12:01:22.151613 | PLAY [Base pre] 2026-08-26 12:01:22.169746 | 2026-08-26 12:01:22.169878 | TASK [Setup log path fact] 2026-08-26 12:01:22.197977 | debian-bookworm | ok 2026-08-26 12:01:22.218476 | 2026-08-26 12:01:22.218613 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-26 12:01:22.246967 | debian-bookworm | ok 2026-08-26 12:01:22.259296 | 2026-08-26 12:01:22.259430 | TASK [emit-job-header : Print job information] 2026-08-26 12:01:22.328389 | # Job Information 2026-08-26 12:01:22.328567 | Ansible Version: 2.16.14 2026-08-26 12:01:22.328602 | Job: python-black 2026-08-26 12:01:22.328635 | Pipeline: check 2026-08-26 12:01:22.328657 | Executor: 521e9411259a 2026-08-26 12:01:22.328678 | Triggered by: https://github.com/osism/python-osism/pull/2626 2026-08-26 12:01:22.328700 | Event ID: cd5f5b70-a145-11f1-985a-a7d03ab96f9c 2026-08-26 12:01:22.341088 | 2026-08-26 12:01:22.341220 | LOOP [emit-job-header : Print node information] 2026-08-26 12:01:22.558098 | debian-bookworm | ok: 2026-08-26 12:01:22.558423 | debian-bookworm | # Node Information 2026-08-26 12:01:22.558468 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-08-26 12:01:22.558494 | debian-bookworm | Hostname: debian 2026-08-26 12:01:22.558516 | debian-bookworm | Username: zuul 2026-08-26 12:01:22.558591 | debian-bookworm | Distro: Debian 12.15 2026-08-26 12:01:22.558620 | debian-bookworm | Provider: regiocloud-a 2026-08-26 12:01:22.558642 | debian-bookworm | Region: 2026-08-26 12:01:22.558663 | debian-bookworm | Label: debian-bookworm 2026-08-26 12:01:22.558683 | debian-bookworm | Product Name: OpenStack Nova 2026-08-26 12:01:22.558703 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fed2:d8a1 2026-08-26 12:01:22.577925 | 2026-08-26 12:01:22.578057 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-26 12:01:23.899293 | debian-bookworm -> localhost | changed 2026-08-26 12:01:23.909993 | 2026-08-26 12:01:23.910117 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-26 12:01:25.780177 | debian-bookworm -> localhost | changed 2026-08-26 12:01:25.793693 | 2026-08-26 12:01:25.793810 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-26 12:01:26.558141 | debian-bookworm -> localhost | ok 2026-08-26 12:01:26.569729 | 2026-08-26 12:01:26.569852 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-26 12:01:26.628112 | debian-bookworm | ok 2026-08-26 12:01:26.674230 | debian-bookworm | included: /var/lib/zuul/builds/853ed83b9ede45cfb3c7e4f25162ac1c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-26 12:01:26.697881 | 2026-08-26 12:01:26.697980 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-26 12:01:30.941546 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-08-26 12:01:30.941773 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/853ed83b9ede45cfb3c7e4f25162ac1c/work/853ed83b9ede45cfb3c7e4f25162ac1c_id_rsa 2026-08-26 12:01:30.941806 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/853ed83b9ede45cfb3c7e4f25162ac1c/work/853ed83b9ede45cfb3c7e4f25162ac1c_id_rsa.pub 2026-08-26 12:01:30.941828 | debian-bookworm -> localhost | The key fingerprint is: 2026-08-26 12:01:30.941848 | debian-bookworm -> localhost | SHA256:RntkgUu+lFjlnvK5dtWd/2e6Z2AJxMMUE3faShVPYps zuul-build-sshkey 2026-08-26 12:01:30.941866 | debian-bookworm -> localhost | The key's randomart image is: 2026-08-26 12:01:30.941891 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-08-26 12:01:30.941908 | debian-bookworm -> localhost | | oo+=o+.=| 2026-08-26 12:01:30.941925 | debian-bookworm -> localhost | | +. .=+ X.| 2026-08-26 12:01:30.941941 | debian-bookworm -> localhost | | =.o+. .E o| 2026-08-26 12:01:30.941957 | debian-bookworm -> localhost | | ..== ... . | 2026-08-26 12:01:30.941973 | debian-bookworm -> localhost | | .S.+ ..oo| 2026-08-26 12:01:30.941993 | debian-bookworm -> localhost | | ..+ . =.o| 2026-08-26 12:01:30.942010 | debian-bookworm -> localhost | | o o ..| 2026-08-26 12:01:30.942025 | debian-bookworm -> localhost | | ... *| 2026-08-26 12:01:30.942041 | debian-bookworm -> localhost | | ... o*+| 2026-08-26 12:01:30.942057 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-08-26 12:01:30.942100 | debian-bookworm -> localhost | ok: Runtime: 0:00:03.147837 2026-08-26 12:01:30.950168 | 2026-08-26 12:01:30.950248 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-26 12:01:31.007844 | debian-bookworm | ok 2026-08-26 12:01:31.022552 | debian-bookworm | included: /var/lib/zuul/builds/853ed83b9ede45cfb3c7e4f25162ac1c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-26 12:01:31.044806 | 2026-08-26 12:01:31.044901 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-26 12:01:31.078213 | debian-bookworm | skipping: Conditional result was False 2026-08-26 12:01:31.083259 | 2026-08-26 12:01:31.083368 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-26 12:01:32.160081 | debian-bookworm | changed 2026-08-26 12:01:32.164596 | 2026-08-26 12:01:32.164676 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-26 12:01:32.389222 | debian-bookworm | ok 2026-08-26 12:01:32.394605 | 2026-08-26 12:01:32.394689 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-26 12:01:33.088708 | debian-bookworm | changed 2026-08-26 12:01:33.093580 | 2026-08-26 12:01:33.093660 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-26 12:01:33.710443 | debian-bookworm | changed 2026-08-26 12:01:33.717184 | 2026-08-26 12:01:33.717296 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-26 12:01:33.753158 | debian-bookworm | skipping: Conditional result was False 2026-08-26 12:01:33.760904 | 2026-08-26 12:01:33.761080 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-26 12:01:34.558138 | debian-bookworm -> localhost | changed 2026-08-26 12:01:34.568290 | 2026-08-26 12:01:34.568417 | TASK [add-build-sshkey : Add back temp key] 2026-08-26 12:01:35.288282 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/853ed83b9ede45cfb3c7e4f25162ac1c/work/853ed83b9ede45cfb3c7e4f25162ac1c_id_rsa (zuul-build-sshkey) 2026-08-26 12:01:35.288490 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.025951 2026-08-26 12:01:35.294899 | 2026-08-26 12:01:35.295004 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-26 12:01:35.739719 | debian-bookworm | ok 2026-08-26 12:01:35.745278 | 2026-08-26 12:01:35.745387 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-26 12:01:35.778452 | debian-bookworm | skipping: Conditional result was False 2026-08-26 12:01:35.787256 | 2026-08-26 12:01:35.787420 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-08-26 12:01:36.466206 | debian-bookworm | ok 2026-08-26 12:01:36.481938 | 2026-08-26 12:01:36.482053 | TASK [validate-host : Define zuul_info_dir fact] 2026-08-26 12:01:36.535707 | debian-bookworm | ok 2026-08-26 12:01:36.541658 | 2026-08-26 12:01:36.541774 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-08-26 12:01:37.310459 | debian-bookworm -> localhost | ok 2026-08-26 12:01:37.316810 | 2026-08-26 12:01:37.316908 | TASK [validate-host : Collect information about the host] 2026-08-26 12:01:38.832918 | debian-bookworm | ok 2026-08-26 12:01:38.860952 | 2026-08-26 12:01:38.861094 | TASK [validate-host : Sanitize hostname] 2026-08-26 12:01:39.057730 | debian-bookworm | ok 2026-08-26 12:01:39.061644 | 2026-08-26 12:01:39.061734 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-08-26 12:01:41.134933 | debian-bookworm -> localhost | changed 2026-08-26 12:01:41.141829 | 2026-08-26 12:01:41.141920 | TASK [validate-host : Collect information about zuul worker] 2026-08-26 12:01:41.852720 | debian-bookworm | ok 2026-08-26 12:01:41.869421 | 2026-08-26 12:01:41.869526 | TASK [validate-host : Write out all zuul information for each host] 2026-08-26 12:01:42.667642 | debian-bookworm -> localhost | changed 2026-08-26 12:01:42.678209 | 2026-08-26 12:01:42.678301 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-08-26 12:01:43.014580 | debian-bookworm | ok 2026-08-26 12:01:43.064245 | 2026-08-26 12:01:43.066087 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-08-26 12:01:45.557991 | debian-bookworm | changed: 2026-08-26 12:01:45.558195 | debian-bookworm | cd+++++++++ src/ 2026-08-26 12:01:45.558234 | debian-bookworm | cd+++++++++ src/github.com/ 2026-08-26 12:01:45.558260 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-08-26 12:01:45.558283 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-08-26 12:01:45.558332 | debian-bookworm | Containerfile 2026-08-26 12:01:45.558475 | debian-bookworm | Containerfile 2026-08-26 12:01:45.619277 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/853ed83b9ede45cfb3c7e4f25162ac1c/work/logs" 2026-08-26 12:02:57.011618 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/853ed83b9ede45cfb3c7e4f25162ac1c/work/artifacts" 2026-08-26 12:02:57.304217 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/853ed83b9ede45cfb3c7e4f25162ac1c/work/docs" 2026-08-26 12:02:57.324646 | 2026-08-26 12:02:57.325009 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-26 12:02:58.157509 | debian-bookworm | changed: 2026-08-26 12:02:58.157842 | debian-bookworm | .d..t...... ./ 2026-08-26 12:02:58.157893 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-08-26 12:02:58.157929 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-08-26 12:02:58.157960 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-08-26 12:02:58.157990 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-08-26 12:02:58.158020 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-08-26 12:02:58.158080 | debian-bookworm | changed: All items complete 2026-08-26 12:02:58.158121 | 2026-08-26 12:02:58.742486 | debian-bookworm | changed: .d..t...... ./ 2026-08-26 12:02:59.324387 | debian-bookworm | changed: .d..t...... ./ 2026-08-26 12:02:59.344830 | 2026-08-26 12:02:59.344978 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-26 12:02:59.711136 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.014897 2026-08-26 12:03:00.030825 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.008926 2026-08-26 12:03:00.046941 | 2026-08-26 12:03:00.047084 | PLAY RECAP 2026-08-26 12:03:00.047148 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-26 12:03:00.047175 | 2026-08-26 12:03:00.218684 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-08-26 12:03:00.220851 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-26 12:03:01.098803 | 2026-08-26 12:03:01.099123 | PLAY [Base post] 2026-08-26 12:03:01.115819 | 2026-08-26 12:03:01.115986 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-26 12:03:01.728450 | debian-bookworm | changed 2026-08-26 12:03:01.737602 | 2026-08-26 12:03:01.737746 | PLAY RECAP 2026-08-26 12:03:01.737826 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-26 12:03:01.737900 | 2026-08-26 12:03:01.894315 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-26 12:03:01.898393 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-26 12:03:02.762409 | 2026-08-26 12:03:02.762622 | PLAY [Base post-logs] 2026-08-26 12:03:02.774696 | 2026-08-26 12:03:02.774892 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-26 12:03:03.262389 | localhost | changed 2026-08-26 12:03:03.277433 | 2026-08-26 12:03:03.277601 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-26 12:03:03.324448 | localhost | ok 2026-08-26 12:03:03.327912 | 2026-08-26 12:03:03.328028 | TASK [Set zuul-log-path fact] 2026-08-26 12:03:03.357209 | localhost | ok 2026-08-26 12:03:03.371959 | 2026-08-26 12:03:03.372240 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-26 12:03:03.415087 | localhost | ok 2026-08-26 12:03:03.422084 | 2026-08-26 12:03:03.422327 | TASK [upload-logs : Create log directories] 2026-08-26 12:03:03.985603 | localhost | changed 2026-08-26 12:03:03.990816 | 2026-08-26 12:03:03.991049 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-26 12:03:04.555094 | localhost -> localhost | ok: Runtime: 0:00:00.007989 2026-08-26 12:03:04.564949 | 2026-08-26 12:03:04.565364 | TASK [upload-logs : Upload logs to log server] 2026-08-26 12:03:05.239321 | localhost | Output suppressed because no_log was given 2026-08-26 12:03:05.241738 | 2026-08-26 12:03:05.241859 | LOOP [upload-logs : Compress console log and json output] 2026-08-26 12:03:05.321533 | localhost | skipping: Conditional result was False 2026-08-26 12:03:05.327188 | localhost | skipping: Conditional result was False 2026-08-26 12:03:05.335365 | 2026-08-26 12:03:05.335604 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-26 12:03:05.400528 | localhost | skipping: Conditional result was False 2026-08-26 12:03:05.401444 | 2026-08-26 12:03:05.404502 | localhost | skipping: Conditional result was False 2026-08-26 12:03:05.419618 | 2026-08-26 12:03:05.419745 | LOOP [upload-logs : Upload console log and json output]