2025-10-27 11:03:37.927529 | Job console starting 2025-10-27 11:03:37.948034 | Updating git repos 2025-10-27 11:03:38.018913 | Cloning repos into workspace 2025-10-27 11:03:38.082355 | Restoring repo states 2025-10-27 11:03:38.098361 | Merging changes 2025-10-27 11:03:38.729015 | Checking out repos 2025-10-27 11:03:38.820830 | Preparing playbooks 2025-10-27 11:03:39.912772 | Running Ansible setup 2025-10-27 11:03:45.905973 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-27 11:03:46.949812 | 2025-10-27 11:03:46.949935 | PLAY [Base pre] 2025-10-27 11:03:46.969554 | 2025-10-27 11:03:46.969661 | TASK [Setup log path fact] 2025-10-27 11:03:47.000048 | debian-bookworm | ok 2025-10-27 11:03:47.030052 | 2025-10-27 11:03:47.030180 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-27 11:03:47.078745 | debian-bookworm | ok 2025-10-27 11:03:47.100075 | 2025-10-27 11:03:47.100179 | TASK [emit-job-header : Print job information] 2025-10-27 11:03:47.128285 | # Job Information 2025-10-27 11:03:47.128516 | Ansible Version: 2.16.14 2025-10-27 11:03:47.128559 | Job: python-black 2025-10-27 11:03:47.128599 | Pipeline: check 2025-10-27 11:03:47.128625 | Executor: 521e9411259a 2025-10-27 11:03:47.128646 | Triggered by: https://github.com/osism/python-osism/pull/1776 2025-10-27 11:03:47.128668 | Event ID: 90de55d0-b324-11f0-8741-b6dd0675253d 2025-10-27 11:03:47.133495 | 2025-10-27 11:03:47.133593 | LOOP [emit-job-header : Print node information] 2025-10-27 11:03:47.415009 | debian-bookworm | ok: 2025-10-27 11:03:47.415220 | debian-bookworm | # Node Information 2025-10-27 11:03:47.415256 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-27 11:03:47.415281 | debian-bookworm | Hostname: debian 2025-10-27 11:03:47.415303 | debian-bookworm | Username: zuul 2025-10-27 11:03:47.415323 | debian-bookworm | Distro: Debian 12.12 2025-10-27 11:03:47.415347 | debian-bookworm | Provider: regiocloud-a 2025-10-27 11:03:47.415367 | debian-bookworm | Region: 2025-10-27 11:03:47.415388 | debian-bookworm | Label: debian-bookworm 2025-10-27 11:03:47.415408 | debian-bookworm | Product Name: OpenStack Nova 2025-10-27 11:03:47.415428 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe47:2f82 2025-10-27 11:03:47.433017 | 2025-10-27 11:03:47.439772 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-27 11:03:48.239857 | debian-bookworm -> localhost | changed 2025-10-27 11:03:48.247572 | 2025-10-27 11:03:48.247681 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-27 11:03:49.724353 | debian-bookworm -> localhost | changed 2025-10-27 11:03:49.733366 | 2025-10-27 11:03:49.733506 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-27 11:03:50.190492 | debian-bookworm -> localhost | ok 2025-10-27 11:03:50.195319 | 2025-10-27 11:03:50.195402 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-27 11:03:50.212525 | debian-bookworm | ok 2025-10-27 11:03:50.238346 | debian-bookworm | included: /var/lib/zuul/builds/079c29585e0d40f989b3f643347c9a9f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-27 11:03:50.243186 | 2025-10-27 11:03:50.243259 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-27 11:03:52.777659 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-27 11:03:52.777846 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/079c29585e0d40f989b3f643347c9a9f/work/079c29585e0d40f989b3f643347c9a9f_id_rsa 2025-10-27 11:03:52.777884 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/079c29585e0d40f989b3f643347c9a9f/work/079c29585e0d40f989b3f643347c9a9f_id_rsa.pub 2025-10-27 11:03:52.777911 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-27 11:03:52.777936 | debian-bookworm -> localhost | SHA256:R1bDpDczYXugyycrp/Th/milPxygobeWHfJiHSJR6D4 zuul-build-sshkey 2025-10-27 11:03:52.777958 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-27 11:03:52.777991 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-27 11:03:52.778014 | debian-bookworm -> localhost | | . oB | 2025-10-27 11:03:52.778036 | debian-bookworm -> localhost | | . . =.= | 2025-10-27 11:03:52.778056 | debian-bookworm -> localhost | | . . = * . | 2025-10-27 11:03:52.778075 | debian-bookworm -> localhost | | o .+.o = | 2025-10-27 11:03:52.778095 | debian-bookworm -> localhost | | . oSo=.. | 2025-10-27 11:03:52.778122 | debian-bookworm -> localhost | | E =.o+o | 2025-10-27 11:03:52.778144 | debian-bookworm -> localhost | | +oO+* . | 2025-10-27 11:03:52.778165 | debian-bookworm -> localhost | | .***oo | 2025-10-27 11:03:52.778185 | debian-bookworm -> localhost | | o.+=oo. | 2025-10-27 11:03:52.778205 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-27 11:03:52.778254 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.837448 2025-10-27 11:03:52.784251 | 2025-10-27 11:03:52.784334 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-27 11:03:52.803057 | debian-bookworm | ok 2025-10-27 11:03:52.818956 | debian-bookworm | included: /var/lib/zuul/builds/079c29585e0d40f989b3f643347c9a9f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-27 11:03:52.833813 | 2025-10-27 11:03:52.833922 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-27 11:03:52.847210 | debian-bookworm | skipping: Conditional result was False 2025-10-27 11:03:52.852695 | 2025-10-27 11:03:52.852781 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-27 11:03:53.496387 | debian-bookworm | changed 2025-10-27 11:03:53.503350 | 2025-10-27 11:03:53.503452 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-27 11:03:53.772147 | debian-bookworm | ok 2025-10-27 11:03:53.780074 | 2025-10-27 11:03:53.780185 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-27 11:03:54.428934 | debian-bookworm | changed 2025-10-27 11:03:54.435740 | 2025-10-27 11:03:54.435827 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-27 11:03:55.060221 | debian-bookworm | changed 2025-10-27 11:03:55.065442 | 2025-10-27 11:03:55.065540 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-27 11:03:55.078968 | debian-bookworm | skipping: Conditional result was False 2025-10-27 11:03:55.085844 | 2025-10-27 11:03:55.085951 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-27 11:03:55.546236 | debian-bookworm -> localhost | changed 2025-10-27 11:03:55.556442 | 2025-10-27 11:03:55.556582 | TASK [add-build-sshkey : Add back temp key] 2025-10-27 11:03:55.911880 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/079c29585e0d40f989b3f643347c9a9f/work/079c29585e0d40f989b3f643347c9a9f_id_rsa (zuul-build-sshkey) 2025-10-27 11:03:55.912103 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009857 2025-10-27 11:03:55.919571 | 2025-10-27 11:03:55.919662 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-27 11:03:56.424323 | debian-bookworm | ok 2025-10-27 11:03:56.429479 | 2025-10-27 11:03:56.429594 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-27 11:03:56.482993 | debian-bookworm | skipping: Conditional result was False 2025-10-27 11:03:56.492943 | 2025-10-27 11:03:56.493040 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-27 11:03:56.969005 | debian-bookworm | ok 2025-10-27 11:03:56.979116 | 2025-10-27 11:03:56.979217 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-27 11:03:57.007610 | debian-bookworm | ok 2025-10-27 11:03:57.014168 | 2025-10-27 11:03:57.014267 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-27 11:03:57.369439 | debian-bookworm -> localhost | ok 2025-10-27 11:03:57.375548 | 2025-10-27 11:03:57.375646 | TASK [validate-host : Collect information about the host] 2025-10-27 11:03:58.474142 | debian-bookworm | ok 2025-10-27 11:03:58.484957 | 2025-10-27 11:03:58.485054 | TASK [validate-host : Sanitize hostname] 2025-10-27 11:03:58.584461 | debian-bookworm | ok 2025-10-27 11:03:58.639667 | 2025-10-27 11:03:58.639766 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-27 11:03:59.365304 | debian-bookworm -> localhost | changed 2025-10-27 11:03:59.370667 | 2025-10-27 11:03:59.370757 | TASK [validate-host : Collect information about zuul worker] 2025-10-27 11:03:59.818078 | debian-bookworm | ok 2025-10-27 11:03:59.826490 | 2025-10-27 11:03:59.826589 | TASK [validate-host : Write out all zuul information for each host] 2025-10-27 11:04:00.455609 | debian-bookworm -> localhost | changed 2025-10-27 11:04:00.472390 | 2025-10-27 11:04:00.472516 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-27 11:04:00.758727 | debian-bookworm | ok 2025-10-27 11:04:00.763772 | 2025-10-27 11:04:00.763854 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-27 11:04:02.010700 | debian-bookworm | changed: 2025-10-27 11:04:02.010897 | debian-bookworm | cd+++++++++ src/ 2025-10-27 11:04:02.010934 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-27 11:04:02.010959 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-27 11:04:02.010981 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-10-27 11:04:02.011001 | debian-bookworm | Containerfile 2025-10-27 11:04:02.011235 | debian-bookworm | Containerfile 2025-10-27 11:04:02.021558 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006948 2025-10-27 11:04:28.032366 | 2025-10-27 11:04:28.032568 | TASK [upload-logs : Upload logs to log server] 2025-10-27 11:04:28.597017 | localhost | Output suppressed because no_log was given 2025-10-27 11:04:28.600259 | 2025-10-27 11:04:28.600445 | LOOP [upload-logs : Compress console log and json output] 2025-10-27 11:04:28.659568 | localhost | skipping: Conditional result was False 2025-10-27 11:04:28.664440 | localhost | skipping: Conditional result was False 2025-10-27 11:04:28.677281 | 2025-10-27 11:04:28.677657 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-27 11:04:28.723782 | localhost | skipping: Conditional result was False 2025-10-27 11:04:28.724386 | 2025-10-27 11:04:28.727907 | localhost | skipping: Conditional result was False 2025-10-27 11:04:28.740301 | 2025-10-27 11:04:28.740533 | LOOP [upload-logs : Upload console log and json output]