2025-06-12 23:32:40.785822 | Job console starting 2025-06-12 23:32:40.798409 | Updating git repos 2025-06-12 23:32:40.832195 | Cloning repos into workspace 2025-06-12 23:32:40.885978 | Restoring repo states 2025-06-12 23:32:40.895238 | Merging changes 2025-06-12 23:32:41.432339 | Checking out repos 2025-06-12 23:32:41.474070 | Preparing playbooks 2025-06-12 23:32:42.058136 | Running Ansible setup 2025-06-12 23:32:46.671343 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-12 23:32:47.623354 | 2025-06-12 23:32:47.623532 | PLAY [Base pre] 2025-06-12 23:32:47.639837 | 2025-06-12 23:32:47.639986 | TASK [Setup log path fact] 2025-06-12 23:32:47.669542 | debian-bookworm | ok 2025-06-12 23:32:47.685090 | 2025-06-12 23:32:47.685281 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-12 23:32:47.716159 | debian-bookworm | ok 2025-06-12 23:32:47.729353 | 2025-06-12 23:32:47.729496 | TASK [emit-job-header : Print job information] 2025-06-12 23:32:47.769703 | # Job Information 2025-06-12 23:32:47.769899 | Ansible Version: 2.16.14 2025-06-12 23:32:47.769934 | Job: python-black 2025-06-12 23:32:47.769966 | Pipeline: check 2025-06-12 23:32:47.769989 | Executor: 521e9411259a 2025-06-12 23:32:47.770010 | Triggered by: https://github.com/osism/python-osism/pull/1421 2025-06-12 23:32:47.770032 | Event ID: 6eaf7200-47e5-11f0-9fd2-f38071db0eed 2025-06-12 23:32:47.775059 | 2025-06-12 23:32:47.775172 | LOOP [emit-job-header : Print node information] 2025-06-12 23:32:47.882169 | debian-bookworm | ok: 2025-06-12 23:32:47.882517 | debian-bookworm | # Node Information 2025-06-12 23:32:47.882560 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-12 23:32:47.882586 | debian-bookworm | Hostname: debian 2025-06-12 23:32:47.882608 | debian-bookworm | Username: zuul 2025-06-12 23:32:47.882629 | debian-bookworm | Distro: Debian 12.11 2025-06-12 23:32:47.882662 | debian-bookworm | Provider: regiocloud-a 2025-06-12 23:32:47.882687 | debian-bookworm | Region: 2025-06-12 23:32:47.882707 | debian-bookworm | Label: debian-bookworm 2025-06-12 23:32:47.882726 | debian-bookworm | Product Name: OpenStack Nova 2025-06-12 23:32:47.882745 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fead:43e0 2025-06-12 23:32:47.915626 | 2025-06-12 23:32:47.915774 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-12 23:32:48.487158 | debian-bookworm -> localhost | changed 2025-06-12 23:32:48.494556 | 2025-06-12 23:32:48.494694 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-12 23:32:49.683950 | debian-bookworm -> localhost | changed 2025-06-12 23:32:49.694297 | 2025-06-12 23:32:49.694400 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-12 23:32:49.969666 | debian-bookworm -> localhost | ok 2025-06-12 23:32:49.975395 | 2025-06-12 23:32:49.975493 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-12 23:32:50.022944 | debian-bookworm | ok 2025-06-12 23:32:50.049622 | debian-bookworm | included: /var/lib/zuul/builds/59404d9faa4f493595afe5c0762ff5eb/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-12 23:32:50.055351 | 2025-06-12 23:32:50.055439 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-12 23:32:51.444871 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-12 23:32:51.445060 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/59404d9faa4f493595afe5c0762ff5eb/work/59404d9faa4f493595afe5c0762ff5eb_id_rsa 2025-06-12 23:32:51.445099 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/59404d9faa4f493595afe5c0762ff5eb/work/59404d9faa4f493595afe5c0762ff5eb_id_rsa.pub 2025-06-12 23:32:51.445125 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-12 23:32:51.445149 | debian-bookworm -> localhost | SHA256:pU2czQMDiBn3cLtMp8MGOGC0bNBETfR2m5GfVukn2DI zuul-build-sshkey 2025-06-12 23:32:51.445172 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-12 23:32:51.445215 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-12 23:32:51.445238 | debian-bookworm -> localhost | |.=*+++o.o.o | 2025-06-12 23:32:51.445259 | debian-bookworm -> localhost | | +.o++.+ + * . | 2025-06-12 23:32:51.445279 | debian-bookworm -> localhost | | + o + B * * | 2025-06-12 23:32:51.445299 | debian-bookworm -> localhost | | . o * & * . | 2025-06-12 23:32:51.445319 | debian-bookworm -> localhost | | S E + . | 2025-06-12 23:32:51.445344 | debian-bookworm -> localhost | | . o o o | 2025-06-12 23:32:51.445364 | debian-bookworm -> localhost | | | 2025-06-12 23:32:51.445383 | debian-bookworm -> localhost | | | 2025-06-12 23:32:51.445403 | debian-bookworm -> localhost | | | 2025-06-12 23:32:51.445423 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-12 23:32:51.445476 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.859100 2025-06-12 23:32:51.453922 | 2025-06-12 23:32:51.454016 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-12 23:32:51.491379 | debian-bookworm | ok 2025-06-12 23:32:51.499893 | debian-bookworm | included: /var/lib/zuul/builds/59404d9faa4f493595afe5c0762ff5eb/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-12 23:32:51.508249 | 2025-06-12 23:32:51.508339 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-12 23:32:51.541358 | debian-bookworm | skipping: Conditional result was False 2025-06-12 23:32:51.547166 | 2025-06-12 23:32:51.547268 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-12 23:32:52.132570 | debian-bookworm | changed 2025-06-12 23:32:52.141629 | 2025-06-12 23:32:52.141753 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-12 23:32:52.379013 | debian-bookworm | ok 2025-06-12 23:32:52.386445 | 2025-06-12 23:32:52.386552 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-12 23:32:52.974214 | debian-bookworm | changed 2025-06-12 23:32:52.987746 | 2025-06-12 23:32:52.987856 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-12 23:32:53.605828 | debian-bookworm | changed 2025-06-12 23:32:53.636649 | 2025-06-12 23:32:53.636888 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-12 23:32:53.664304 | debian-bookworm | skipping: Conditional result was False 2025-06-12 23:32:53.670019 | 2025-06-12 23:32:53.670113 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-12 23:32:54.076815 | debian-bookworm -> localhost | changed 2025-06-12 23:32:54.087320 | 2025-06-12 23:32:54.087413 | TASK [add-build-sshkey : Add back temp key] 2025-06-12 23:32:54.455352 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/59404d9faa4f493595afe5c0762ff5eb/work/59404d9faa4f493595afe5c0762ff5eb_id_rsa (zuul-build-sshkey) 2025-06-12 23:32:54.455605 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.017036 2025-06-12 23:32:54.465563 | 2025-06-12 23:32:54.465666 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-12 23:32:54.807077 | debian-bookworm | ok 2025-06-12 23:32:54.817003 | 2025-06-12 23:32:54.817106 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-12 23:32:54.851172 | debian-bookworm | skipping: Conditional result was False 2025-06-12 23:32:54.861146 | 2025-06-12 23:32:54.861257 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-12 23:32:55.296319 | debian-bookworm | ok 2025-06-12 23:32:55.306693 | 2025-06-12 23:32:55.306813 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-12 23:32:55.350320 | debian-bookworm | ok 2025-06-12 23:32:55.355296 | 2025-06-12 23:32:55.355396 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-12 23:32:55.641536 | debian-bookworm -> localhost | ok 2025-06-12 23:32:55.653428 | 2025-06-12 23:32:55.653582 | TASK [validate-host : Collect information about the host] 2025-06-12 23:32:56.783799 | debian-bookworm | ok 2025-06-12 23:32:56.801238 | 2025-06-12 23:32:56.801461 | TASK [validate-host : Sanitize hostname] 2025-06-12 23:32:56.904056 | debian-bookworm | ok 2025-06-12 23:32:56.934685 | 2025-06-12 23:32:56.934797 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-12 23:32:57.498071 | debian-bookworm -> localhost | changed 2025-06-12 23:32:57.503943 | 2025-06-12 23:32:57.504044 | TASK [validate-host : Collect information about zuul worker] 2025-06-12 23:32:57.924929 | debian-bookworm | ok 2025-06-12 23:32:57.929365 | 2025-06-12 23:32:57.929456 | TASK [validate-host : Write out all zuul information for each host] 2025-06-12 23:32:58.549237 | debian-bookworm -> localhost | changed 2025-06-12 23:32:58.560417 | 2025-06-12 23:32:58.560541 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-12 23:32:58.842796 | debian-bookworm | ok 2025-06-12 23:32:58.857055 | 2025-06-12 23:32:58.857186 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-12 23:33:00.108911 | debian-bookworm | changed: 2025-06-12 23:33:00.109140 | debian-bookworm | cd+++++++++ src/ 2025-06-12 23:33:00.109176 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-12 23:33:00.109220 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-12 23:33:00.109241 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-06-12 23:33:00.109262 | debian-bookworm | Containerfile 2025-06-12 23:33:00.109371 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006685 2025-06-12 23:33:30.425021 | 2025-06-12 23:33:30.425118 | TASK [upload-logs : Upload logs to log server] 2025-06-12 23:33:31.169618 | localhost | Output suppressed because no_log was given 2025-06-12 23:33:31.171268 | 2025-06-12 23:33:31.171355 | LOOP [upload-logs : Compress console log and json output] 2025-06-12 23:33:31.235079 | localhost | skipping: Conditional result was False 2025-06-12 23:33:31.242875 | localhost | skipping: Conditional result was False 2025-06-12 23:33:31.247650 | 2025-06-12 23:33:31.247746 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-12 23:33:31.311575 | localhost | skipping: Conditional result was False 2025-06-12 23:33:31.311800 | 2025-06-12 23:33:31.318048 | localhost | skipping: Conditional result was False 2025-06-12 23:33:31.325341 | 2025-06-12 23:33:31.325486 | LOOP [upload-logs : Upload console log and json output]