2025-08-31 00:18:24.418782 | Job console starting 2025-08-31 00:18:24.433606 | Updating git repos 2025-08-31 00:18:24.762727 | Cloning repos into workspace 2025-08-31 00:18:24.879260 | Restoring repo states 2025-08-31 00:18:24.902772 | Merging changes 2025-08-31 00:18:25.535261 | Checking out repos 2025-08-31 00:18:25.615508 | Preparing playbooks 2025-08-31 00:18:26.620814 | Running Ansible setup 2025-08-31 00:18:33.051632 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-31 00:18:34.476622 | 2025-08-31 00:18:34.476747 | PLAY [Base pre] 2025-08-31 00:18:34.537323 | 2025-08-31 00:18:34.537444 | TASK [Setup log path fact] 2025-08-31 00:18:34.569938 | debian-bookworm | ok 2025-08-31 00:18:34.585831 | 2025-08-31 00:18:34.585961 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-31 00:18:34.614937 | debian-bookworm | ok 2025-08-31 00:18:34.633172 | 2025-08-31 00:18:34.633280 | TASK [emit-job-header : Print job information] 2025-08-31 00:18:34.689648 | # Job Information 2025-08-31 00:18:34.689799 | Ansible Version: 2.16.14 2025-08-31 00:18:34.689833 | Job: python-black 2025-08-31 00:18:34.689866 | Pipeline: check 2025-08-31 00:18:34.689890 | Executor: 521e9411259a 2025-08-31 00:18:34.689913 | Triggered by: https://github.com/osism/openstack-image-manager/pull/917 2025-08-31 00:18:34.689934 | Event ID: fc7b0240-85ff-11f0-8e0c-2c774c0bbb07 2025-08-31 00:18:34.696469 | 2025-08-31 00:18:34.696573 | LOOP [emit-job-header : Print node information] 2025-08-31 00:18:34.925709 | debian-bookworm | ok: 2025-08-31 00:18:34.925967 | debian-bookworm | # Node Information 2025-08-31 00:18:34.926005 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-31 00:18:34.926032 | debian-bookworm | Hostname: debian 2025-08-31 00:18:34.926054 | debian-bookworm | Username: zuul 2025-08-31 00:18:34.926075 | debian-bookworm | Distro: Debian 12.11 2025-08-31 00:18:34.926099 | debian-bookworm | Provider: regiocloud-a 2025-08-31 00:18:34.926119 | debian-bookworm | Region: 2025-08-31 00:18:34.926140 | debian-bookworm | Label: debian-bookworm 2025-08-31 00:18:34.926160 | debian-bookworm | Product Name: OpenStack Nova 2025-08-31 00:18:34.926179 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fea4:88f 2025-08-31 00:18:34.948012 | 2025-08-31 00:18:34.948122 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-31 00:18:36.225591 | debian-bookworm -> localhost | changed 2025-08-31 00:18:36.232529 | 2025-08-31 00:18:36.232633 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-31 00:18:38.462335 | debian-bookworm -> localhost | changed 2025-08-31 00:18:38.472842 | 2025-08-31 00:18:38.472931 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-31 00:18:38.993111 | debian-bookworm -> localhost | ok 2025-08-31 00:18:38.998161 | 2025-08-31 00:18:38.998246 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-31 00:18:39.025596 | debian-bookworm | ok 2025-08-31 00:18:39.049472 | debian-bookworm | included: /var/lib/zuul/builds/d2499b0d7cce4c978224c75fe173b210/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-31 00:18:39.054392 | 2025-08-31 00:18:39.054469 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-31 00:18:40.235351 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-31 00:18:40.235525 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d2499b0d7cce4c978224c75fe173b210/work/d2499b0d7cce4c978224c75fe173b210_id_rsa 2025-08-31 00:18:40.235557 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d2499b0d7cce4c978224c75fe173b210/work/d2499b0d7cce4c978224c75fe173b210_id_rsa.pub 2025-08-31 00:18:40.235581 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-31 00:18:40.235603 | debian-bookworm -> localhost | SHA256:VAcSVvxu5GOzfVNHoJDW1ON7oqBXSWMNaecssj2nsok zuul-build-sshkey 2025-08-31 00:18:40.235621 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-31 00:18:40.235647 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-31 00:18:40.235665 | debian-bookworm -> localhost | | +++=oo | 2025-08-31 00:18:40.235684 | debian-bookworm -> localhost | | . o=.= = | 2025-08-31 00:18:40.235701 | debian-bookworm -> localhost | | .. + O o | 2025-08-31 00:18:40.235718 | debian-bookworm -> localhost | | . . O = .| 2025-08-31 00:18:40.235735 | debian-bookworm -> localhost | | S X + o | 2025-08-31 00:18:40.235754 | debian-bookworm -> localhost | | o % + +| 2025-08-31 00:18:40.235770 | debian-bookworm -> localhost | | . = X oo| 2025-08-31 00:18:40.235787 | debian-bookworm -> localhost | | ..o.+ ...| 2025-08-31 00:18:40.235804 | debian-bookworm -> localhost | | E.oo ..| 2025-08-31 00:18:40.235821 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-31 00:18:40.235860 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.586683 2025-08-31 00:18:40.241230 | 2025-08-31 00:18:40.241342 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-31 00:18:40.267920 | debian-bookworm | ok 2025-08-31 00:18:40.275549 | debian-bookworm | included: /var/lib/zuul/builds/d2499b0d7cce4c978224c75fe173b210/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-31 00:18:40.291881 | 2025-08-31 00:18:40.291954 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-31 00:18:40.316705 | debian-bookworm | skipping: Conditional result was False 2025-08-31 00:18:40.321318 | 2025-08-31 00:18:40.321395 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-31 00:18:40.966506 | debian-bookworm | changed 2025-08-31 00:18:40.970775 | 2025-08-31 00:18:40.970892 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-31 00:18:41.217162 | debian-bookworm | ok 2025-08-31 00:18:41.226140 | 2025-08-31 00:18:41.226245 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-31 00:18:41.920747 | debian-bookworm | changed 2025-08-31 00:18:41.929720 | 2025-08-31 00:18:41.929823 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-31 00:18:42.600947 | debian-bookworm | changed 2025-08-31 00:18:42.606322 | 2025-08-31 00:18:42.606404 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-31 00:18:42.618776 | debian-bookworm | skipping: Conditional result was False 2025-08-31 00:18:42.623287 | 2025-08-31 00:18:42.623356 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-31 00:18:43.023401 | debian-bookworm -> localhost | changed 2025-08-31 00:18:43.033923 | 2025-08-31 00:18:43.034040 | TASK [add-build-sshkey : Add back temp key] 2025-08-31 00:18:43.384743 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d2499b0d7cce4c978224c75fe173b210/work/d2499b0d7cce4c978224c75fe173b210_id_rsa (zuul-build-sshkey) 2025-08-31 00:18:43.384920 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009702 2025-08-31 00:18:43.392212 | 2025-08-31 00:18:43.392435 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-31 00:18:43.780774 | debian-bookworm | ok 2025-08-31 00:18:43.784868 | 2025-08-31 00:18:43.784939 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-31 00:18:43.825327 | debian-bookworm | skipping: Conditional result was False 2025-08-31 00:18:43.835275 | 2025-08-31 00:18:43.835380 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-31 00:18:44.260951 | debian-bookworm | ok 2025-08-31 00:18:44.270454 | 2025-08-31 00:18:44.270544 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-31 00:18:44.297561 | debian-bookworm | ok 2025-08-31 00:18:44.301842 | 2025-08-31 00:18:44.301915 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-31 00:18:44.640837 | debian-bookworm -> localhost | ok 2025-08-31 00:18:44.647850 | 2025-08-31 00:18:44.647941 | TASK [validate-host : Collect information about the host] 2025-08-31 00:18:45.734156 | debian-bookworm | ok 2025-08-31 00:18:45.744873 | 2025-08-31 00:18:45.744967 | TASK [validate-host : Sanitize hostname] 2025-08-31 00:18:45.854394 | debian-bookworm | ok 2025-08-31 00:18:45.885780 | 2025-08-31 00:18:45.885876 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-31 00:18:46.408268 | debian-bookworm -> localhost | changed 2025-08-31 00:18:46.413780 | 2025-08-31 00:18:46.413868 | TASK [validate-host : Collect information about zuul worker] 2025-08-31 00:18:46.937565 | debian-bookworm | ok 2025-08-31 00:18:46.942192 | 2025-08-31 00:18:46.942311 | TASK [validate-host : Write out all zuul information for each host] 2025-08-31 00:18:47.573537 | debian-bookworm -> localhost | changed 2025-08-31 00:18:47.592034 | 2025-08-31 00:18:47.592123 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-31 00:18:47.875584 | debian-bookworm | ok 2025-08-31 00:18:47.883629 | 2025-08-31 00:18:47.883744 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-31 00:18:49.385680 | debian-bookworm | changed: 2025-08-31 00:18:49.385888 | debian-bookworm | cd+++++++++ src/ 2025-08-31 00:18:49.385924 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-31 00:18:49.385949 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-31 00:18:49.385971 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-08-31 00:18:49.385991 | debian-bookworm | localhost | ok: Runtime: 0:00:00.024868 2025-08-31 00:19:17.239929 | 2025-08-31 00:19:17.240053 | TASK [upload-logs : Upload logs to log server] 2025-08-31 00:19:17.821963 | localhost | Output suppressed because no_log was given 2025-08-31 00:19:17.823666 | 2025-08-31 00:19:17.823759 | LOOP [upload-logs : Compress console log and json output] 2025-08-31 00:19:17.865204 | localhost | skipping: Conditional result was False 2025-08-31 00:19:17.871249 | localhost | skipping: Conditional result was False 2025-08-31 00:19:17.879593 | 2025-08-31 00:19:17.879697 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-31 00:19:17.942138 | localhost | skipping: Conditional result was False 2025-08-31 00:19:17.942436 | 2025-08-31 00:19:17.958890 | localhost | skipping: Conditional result was False 2025-08-31 00:19:17.966262 | 2025-08-31 00:19:17.966382 | LOOP [upload-logs : Upload console log and json output]