2025-10-21 16:02:45.423197 | Job console starting 2025-10-21 16:02:45.453202 | Updating git repos 2025-10-21 16:02:45.526158 | Cloning repos into workspace 2025-10-21 16:02:45.588582 | Restoring repo states 2025-10-21 16:02:45.598024 | Merging changes 2025-10-21 16:02:46.102802 | Checking out repos 2025-10-21 16:02:46.143040 | Preparing playbooks 2025-10-21 16:02:46.799192 | Running Ansible setup 2025-10-21 16:02:51.321873 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-21 16:02:52.104840 | 2025-10-21 16:02:52.104999 | PLAY [Base pre] 2025-10-21 16:02:52.121712 | 2025-10-21 16:02:52.121850 | TASK [Setup log path fact] 2025-10-21 16:02:52.151306 | debian-bookworm | ok 2025-10-21 16:02:52.166265 | 2025-10-21 16:02:52.166760 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-21 16:02:52.199307 | debian-bookworm | ok 2025-10-21 16:02:52.212098 | 2025-10-21 16:02:52.212242 | TASK [emit-job-header : Print job information] 2025-10-21 16:02:52.271906 | # Job Information 2025-10-21 16:02:52.272187 | Ansible Version: 2.16.14 2025-10-21 16:02:52.272247 | Job: python-black 2025-10-21 16:02:52.272370 | Pipeline: check 2025-10-21 16:02:52.272418 | Executor: 521e9411259a 2025-10-21 16:02:52.272460 | Triggered by: https://github.com/osism/python-osism/pull/1766 2025-10-21 16:02:52.272504 | Event ID: 0f4a07d0-ae97-11f0-800d-408382576d32 2025-10-21 16:02:52.282162 | 2025-10-21 16:02:52.282294 | LOOP [emit-job-header : Print node information] 2025-10-21 16:02:52.420001 | debian-bookworm | ok: 2025-10-21 16:02:52.420195 | debian-bookworm | # Node Information 2025-10-21 16:02:52.420229 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-21 16:02:52.420254 | debian-bookworm | Hostname: debian 2025-10-21 16:02:52.420276 | debian-bookworm | Username: zuul 2025-10-21 16:02:52.420297 | debian-bookworm | Distro: Debian 12.12 2025-10-21 16:02:52.420321 | debian-bookworm | Provider: regiocloud-a 2025-10-21 16:02:52.420342 | debian-bookworm | Region: 2025-10-21 16:02:52.420363 | debian-bookworm | Label: debian-bookworm 2025-10-21 16:02:52.420383 | debian-bookworm | Product Name: OpenStack Nova 2025-10-21 16:02:52.420402 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feb6:ea51 2025-10-21 16:02:52.439906 | 2025-10-21 16:02:52.440171 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-21 16:02:53.088429 | debian-bookworm -> localhost | changed 2025-10-21 16:02:53.095913 | 2025-10-21 16:02:53.096041 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-21 16:02:54.249993 | debian-bookworm -> localhost | changed 2025-10-21 16:02:54.265893 | 2025-10-21 16:02:54.266018 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-21 16:02:54.721625 | debian-bookworm -> localhost | ok 2025-10-21 16:02:54.729243 | 2025-10-21 16:02:54.729370 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-21 16:02:54.760744 | debian-bookworm | ok 2025-10-21 16:02:54.794626 | debian-bookworm | included: /var/lib/zuul/builds/82093fdeb2a24b87bd2528c2247a5207/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-21 16:02:54.815001 | 2025-10-21 16:02:54.815134 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-21 16:02:56.431583 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-21 16:02:56.431772 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/82093fdeb2a24b87bd2528c2247a5207/work/82093fdeb2a24b87bd2528c2247a5207_id_rsa 2025-10-21 16:02:56.431808 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/82093fdeb2a24b87bd2528c2247a5207/work/82093fdeb2a24b87bd2528c2247a5207_id_rsa.pub 2025-10-21 16:02:56.431834 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-21 16:02:56.431859 | debian-bookworm -> localhost | SHA256:TVyXeZvjOsEm2JZeysucBPiYTdyzU6B5njvIyQT3Lb0 zuul-build-sshkey 2025-10-21 16:02:56.431881 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-21 16:02:56.431912 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-21 16:02:56.431935 | debian-bookworm -> localhost | | . .o | 2025-10-21 16:02:56.431957 | debian-bookworm -> localhost | | . . .o .| 2025-10-21 16:02:56.431977 | debian-bookworm -> localhost | | o. .o| 2025-10-21 16:02:56.431997 | debian-bookworm -> localhost | | .o++ . + | 2025-10-21 16:02:56.432018 | debian-bookworm -> localhost | | .S*=+=.. .| 2025-10-21 16:02:56.432044 | debian-bookworm -> localhost | | *o+B=B . | 2025-10-21 16:02:56.432064 | debian-bookworm -> localhost | | o+o*** + | 2025-10-21 16:02:56.432084 | debian-bookworm -> localhost | | =+=+E | 2025-10-21 16:02:56.432104 | debian-bookworm -> localhost | | *o . | 2025-10-21 16:02:56.432125 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-21 16:02:56.432170 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.806664 2025-10-21 16:02:56.438227 | 2025-10-21 16:02:56.438316 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-21 16:02:56.455341 | debian-bookworm | ok 2025-10-21 16:02:56.464020 | debian-bookworm | included: /var/lib/zuul/builds/82093fdeb2a24b87bd2528c2247a5207/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-21 16:02:56.472641 | 2025-10-21 16:02:56.472726 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-21 16:02:56.485530 | debian-bookworm | skipping: Conditional result was False 2025-10-21 16:02:56.491080 | 2025-10-21 16:02:56.491168 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-21 16:02:57.255224 | debian-bookworm | changed 2025-10-21 16:02:57.260321 | 2025-10-21 16:02:57.260403 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-21 16:02:57.575600 | debian-bookworm | ok 2025-10-21 16:02:57.580991 | 2025-10-21 16:02:57.581083 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-21 16:02:58.294880 | debian-bookworm | changed 2025-10-21 16:02:58.301640 | 2025-10-21 16:02:58.301737 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-21 16:02:58.956839 | debian-bookworm | changed 2025-10-21 16:02:58.961984 | 2025-10-21 16:02:58.962069 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-21 16:02:58.988382 | debian-bookworm | skipping: Conditional result was False 2025-10-21 16:02:58.993944 | 2025-10-21 16:02:58.994028 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-21 16:02:59.472306 | debian-bookworm -> localhost | changed 2025-10-21 16:02:59.482602 | 2025-10-21 16:02:59.482705 | TASK [add-build-sshkey : Add back temp key] 2025-10-21 16:02:59.971662 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/82093fdeb2a24b87bd2528c2247a5207/work/82093fdeb2a24b87bd2528c2247a5207_id_rsa (zuul-build-sshkey) 2025-10-21 16:02:59.971883 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015563 2025-10-21 16:02:59.979272 | 2025-10-21 16:02:59.979359 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-21 16:03:00.377885 | debian-bookworm | ok 2025-10-21 16:03:00.382774 | 2025-10-21 16:03:00.382879 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-21 16:03:00.405718 | debian-bookworm | skipping: Conditional result was False 2025-10-21 16:03:00.415610 | 2025-10-21 16:03:00.415699 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-21 16:03:00.828269 | debian-bookworm | ok 2025-10-21 16:03:00.838312 | 2025-10-21 16:03:00.838413 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-21 16:03:00.888471 | debian-bookworm | ok 2025-10-21 16:03:00.893217 | 2025-10-21 16:03:00.893303 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-21 16:03:01.191509 | debian-bookworm -> localhost | ok 2025-10-21 16:03:01.197703 | 2025-10-21 16:03:01.197790 | TASK [validate-host : Collect information about the host] 2025-10-21 16:03:02.306468 | debian-bookworm | ok 2025-10-21 16:03:02.325222 | 2025-10-21 16:03:02.325313 | TASK [validate-host : Sanitize hostname] 2025-10-21 16:03:02.395287 | debian-bookworm | ok 2025-10-21 16:03:02.427500 | 2025-10-21 16:03:02.427613 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-21 16:03:02.900040 | debian-bookworm -> localhost | changed 2025-10-21 16:03:02.916259 | 2025-10-21 16:03:02.916357 | TASK [validate-host : Collect information about zuul worker] 2025-10-21 16:03:03.380972 | debian-bookworm | ok 2025-10-21 16:03:03.386329 | 2025-10-21 16:03:03.386429 | TASK [validate-host : Write out all zuul information for each host] 2025-10-21 16:03:03.897312 | debian-bookworm -> localhost | changed 2025-10-21 16:03:03.906423 | 2025-10-21 16:03:03.906523 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-21 16:03:04.196023 | debian-bookworm | ok 2025-10-21 16:03:04.201206 | 2025-10-21 16:03:04.201294 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-21 16:03:05.119926 | debian-bookworm | changed: 2025-10-21 16:03:05.120088 | debian-bookworm | cd+++++++++ src/ 2025-10-21 16:03:05.120121 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-21 16:03:05.120144 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-21 16:03:05.120165 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-10-21 16:03:05.120186 | debian-bookworm | Containerfile 2025-10-21 16:03:05.120296 | debian-bookworm | Containerfile 2025-10-21 16:03:05.125459 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006081 2025-10-21 16:03:32.478309 | 2025-10-21 16:03:32.478404 | TASK [upload-logs : Upload logs to log server] 2025-10-21 16:03:32.999790 | localhost | Output suppressed because no_log was given 2025-10-21 16:03:33.001889 | 2025-10-21 16:03:33.002005 | LOOP [upload-logs : Compress console log and json output] 2025-10-21 16:03:33.052318 | localhost | skipping: Conditional result was False 2025-10-21 16:03:33.056805 | localhost | skipping: Conditional result was False 2025-10-21 16:03:33.071247 | 2025-10-21 16:03:33.071446 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-21 16:03:33.123873 | localhost | skipping: Conditional result was False 2025-10-21 16:03:33.124441 | 2025-10-21 16:03:33.127531 | localhost | skipping: Conditional result was False 2025-10-21 16:03:33.134537 | 2025-10-21 16:03:33.134788 | LOOP [upload-logs : Upload console log and json output]