2025-10-26 21:46:24.439915 | Job console starting 2025-10-26 21:46:24.471753 | Updating git repos 2025-10-26 21:46:24.548239 | Cloning repos into workspace 2025-10-26 21:46:24.596247 | Restoring repo states 2025-10-26 21:46:24.610039 | Merging changes 2025-10-26 21:46:25.214071 | Checking out repos 2025-10-26 21:46:25.267930 | Preparing playbooks 2025-10-26 21:46:26.518205 | Running Ansible setup 2025-10-26 21:46:32.273520 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-26 21:46:33.800245 | 2025-10-26 21:46:33.800421 | PLAY [Base pre] 2025-10-26 21:46:33.829410 | 2025-10-26 21:46:33.829563 | TASK [Setup log path fact] 2025-10-26 21:46:33.877025 | debian-bookworm | ok 2025-10-26 21:46:33.905184 | 2025-10-26 21:46:33.905353 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-26 21:46:33.966661 | debian-bookworm | ok 2025-10-26 21:46:33.986193 | 2025-10-26 21:46:33.986331 | TASK [emit-job-header : Print job information] 2025-10-26 21:46:34.076806 | # Job Information 2025-10-26 21:46:34.076976 | Ansible Version: 2.16.14 2025-10-26 21:46:34.077011 | Job: python-black 2025-10-26 21:46:34.077044 | Pipeline: check 2025-10-26 21:46:34.077067 | Executor: 521e9411259a 2025-10-26 21:46:34.077087 | Triggered by: https://github.com/osism/python-osism/pull/1775 2025-10-26 21:46:34.077109 | Event ID: 32e357b0-b2b5-11f0-89ef-5c5b6bdefa9a 2025-10-26 21:46:34.082159 | 2025-10-26 21:46:34.082265 | LOOP [emit-job-header : Print node information] 2025-10-26 21:46:34.245503 | debian-bookworm | ok: 2025-10-26 21:46:34.245720 | debian-bookworm | # Node Information 2025-10-26 21:46:34.245757 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-26 21:46:34.245783 | debian-bookworm | Hostname: debian 2025-10-26 21:46:34.245805 | debian-bookworm | Username: zuul 2025-10-26 21:46:34.245826 | debian-bookworm | Distro: Debian 12.12 2025-10-26 21:46:34.245850 | debian-bookworm | Provider: regiocloud-a 2025-10-26 21:46:34.245870 | debian-bookworm | Region: 2025-10-26 21:46:34.245891 | debian-bookworm | Label: debian-bookworm 2025-10-26 21:46:34.245910 | debian-bookworm | Product Name: OpenStack Nova 2025-10-26 21:46:34.245929 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feee:ee09 2025-10-26 21:46:34.266828 | 2025-10-26 21:46:34.268338 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-26 21:46:34.848864 | debian-bookworm -> localhost | changed 2025-10-26 21:46:34.855870 | 2025-10-26 21:46:34.855976 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-26 21:46:36.387430 | debian-bookworm -> localhost | changed 2025-10-26 21:46:36.396064 | 2025-10-26 21:46:36.396145 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-26 21:46:36.965244 | debian-bookworm -> localhost | ok 2025-10-26 21:46:36.970175 | 2025-10-26 21:46:36.970259 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-26 21:46:36.999781 | debian-bookworm | ok 2025-10-26 21:46:37.045115 | debian-bookworm | included: /var/lib/zuul/builds/0905f1dac7804962a6b57b371733013b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-26 21:46:37.063967 | 2025-10-26 21:46:37.064050 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-26 21:46:38.713682 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-26 21:46:38.713839 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/0905f1dac7804962a6b57b371733013b/work/0905f1dac7804962a6b57b371733013b_id_rsa 2025-10-26 21:46:38.713870 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/0905f1dac7804962a6b57b371733013b/work/0905f1dac7804962a6b57b371733013b_id_rsa.pub 2025-10-26 21:46:38.713896 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-26 21:46:38.713917 | debian-bookworm -> localhost | SHA256:A9DVLx2LWhmLbTESjmxbUxVLxWX/ZbAvmKEb9gEAmtg zuul-build-sshkey 2025-10-26 21:46:38.713943 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-26 21:46:38.713968 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-26 21:46:38.713986 | debian-bookworm -> localhost | | ...o+o..++o.o| 2025-10-26 21:46:38.714004 | debian-bookworm -> localhost | | o =.o.o=....+.| 2025-10-26 21:46:38.714021 | debian-bookworm -> localhost | | . E = ++.Xoo. +| 2025-10-26 21:46:38.714037 | debian-bookworm -> localhost | | . +..Oo++ oo| 2025-10-26 21:46:38.714054 | debian-bookworm -> localhost | | . S++.+ . o| 2025-10-26 21:46:38.714076 | debian-bookworm -> localhost | | .o + . . | 2025-10-26 21:46:38.714094 | debian-bookworm -> localhost | | . . | 2025-10-26 21:46:38.714111 | debian-bookworm -> localhost | | | 2025-10-26 21:46:38.714128 | debian-bookworm -> localhost | | | 2025-10-26 21:46:38.714145 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-26 21:46:38.714185 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.029315 2025-10-26 21:46:38.721698 | 2025-10-26 21:46:38.721774 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-26 21:46:38.737843 | debian-bookworm | ok 2025-10-26 21:46:38.744922 | debian-bookworm | included: /var/lib/zuul/builds/0905f1dac7804962a6b57b371733013b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-26 21:46:38.751909 | 2025-10-26 21:46:38.751973 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-26 21:46:38.764022 | debian-bookworm | skipping: Conditional result was False 2025-10-26 21:46:38.768484 | 2025-10-26 21:46:38.768548 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-26 21:46:39.391765 | debian-bookworm | changed 2025-10-26 21:46:39.400027 | 2025-10-26 21:46:39.400133 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-26 21:46:39.660994 | debian-bookworm | ok 2025-10-26 21:46:39.668187 | 2025-10-26 21:46:39.668285 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-26 21:46:40.263551 | debian-bookworm | changed 2025-10-26 21:46:40.270003 | 2025-10-26 21:46:40.270090 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-26 21:46:40.873496 | debian-bookworm | changed 2025-10-26 21:46:40.881008 | 2025-10-26 21:46:40.881098 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-26 21:46:40.913792 | debian-bookworm | skipping: Conditional result was False 2025-10-26 21:46:40.918544 | 2025-10-26 21:46:40.918649 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-26 21:46:41.540889 | debian-bookworm -> localhost | changed 2025-10-26 21:46:41.552784 | 2025-10-26 21:46:41.552898 | TASK [add-build-sshkey : Add back temp key] 2025-10-26 21:46:41.918520 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/0905f1dac7804962a6b57b371733013b/work/0905f1dac7804962a6b57b371733013b_id_rsa (zuul-build-sshkey) 2025-10-26 21:46:41.918701 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.007741 2025-10-26 21:46:41.924775 | 2025-10-26 21:46:41.924846 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-26 21:46:42.464449 | debian-bookworm | ok 2025-10-26 21:46:42.472327 | 2025-10-26 21:46:42.472448 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-26 21:46:42.509575 | debian-bookworm | skipping: Conditional result was False 2025-10-26 21:46:42.517970 | 2025-10-26 21:46:42.518044 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-26 21:46:42.938637 | debian-bookworm | ok 2025-10-26 21:46:42.947089 | 2025-10-26 21:46:42.947173 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-26 21:46:42.981089 | debian-bookworm | ok 2025-10-26 21:46:42.986238 | 2025-10-26 21:46:42.986333 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-26 21:46:43.262905 | debian-bookworm -> localhost | ok 2025-10-26 21:46:43.269469 | 2025-10-26 21:46:43.269566 | TASK [validate-host : Collect information about the host] 2025-10-26 21:46:44.319921 | debian-bookworm | ok 2025-10-26 21:46:44.336027 | 2025-10-26 21:46:44.336129 | TASK [validate-host : Sanitize hostname] 2025-10-26 21:46:44.437023 | debian-bookworm | ok 2025-10-26 21:46:44.488811 | 2025-10-26 21:46:44.488914 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-26 21:46:45.105868 | debian-bookworm -> localhost | changed 2025-10-26 21:46:45.111468 | 2025-10-26 21:46:45.111558 | TASK [validate-host : Collect information about zuul worker] 2025-10-26 21:46:45.516106 | debian-bookworm | ok 2025-10-26 21:46:45.519713 | 2025-10-26 21:46:45.519782 | TASK [validate-host : Write out all zuul information for each host] 2025-10-26 21:46:46.115022 | debian-bookworm -> localhost | changed 2025-10-26 21:46:46.130563 | 2025-10-26 21:46:46.130688 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-26 21:46:46.439809 | debian-bookworm | ok 2025-10-26 21:46:46.448810 | 2025-10-26 21:46:46.448900 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-26 21:46:47.420667 | debian-bookworm | changed: 2025-10-26 21:46:47.420824 | debian-bookworm | cd+++++++++ src/ 2025-10-26 21:46:47.420857 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-26 21:46:47.420880 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-26 21:46:47.420901 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-10-26 21:46:47.420921 | debian-bookworm | Containerfile 2025-10-26 21:46:47.421031 | debian-bookworm | Containerfile 2025-10-26 21:46:47.423000 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006739 2025-10-26 21:47:13.304064 | 2025-10-26 21:47:13.304251 | TASK [upload-logs : Upload logs to log server] 2025-10-26 21:47:13.872056 | localhost | Output suppressed because no_log was given 2025-10-26 21:47:13.876171 | 2025-10-26 21:47:13.876352 | LOOP [upload-logs : Compress console log and json output] 2025-10-26 21:47:13.933828 | localhost | skipping: Conditional result was False 2025-10-26 21:47:13.938746 | localhost | skipping: Conditional result was False 2025-10-26 21:47:13.951899 | 2025-10-26 21:47:13.952105 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-26 21:47:13.997292 | localhost | skipping: Conditional result was False 2025-10-26 21:47:13.997878 | 2025-10-26 21:47:14.001602 | localhost | skipping: Conditional result was False 2025-10-26 21:47:14.013856 | 2025-10-26 21:47:14.014054 | LOOP [upload-logs : Upload console log and json output]