2025-10-25 00:26:15.816330 | Job console starting 2025-10-25 00:26:15.835474 | Updating git repos 2025-10-25 00:26:15.882932 | Cloning repos into workspace 2025-10-25 00:26:15.952929 | Restoring repo states 2025-10-25 00:26:15.975250 | Merging changes 2025-10-25 00:26:16.515442 | Checking out repos 2025-10-25 00:26:16.628950 | Preparing playbooks 2025-10-25 00:26:17.623548 | Running Ansible setup 2025-10-25 00:26:24.098060 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-25 00:26:25.624607 | 2025-10-25 00:26:25.624775 | PLAY [Base pre] 2025-10-25 00:26:25.657345 | 2025-10-25 00:26:25.657502 | TASK [Setup log path fact] 2025-10-25 00:26:25.684700 | debian-bookworm | ok 2025-10-25 00:26:25.722227 | 2025-10-25 00:26:25.722410 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-25 00:26:25.771800 | debian-bookworm | ok 2025-10-25 00:26:25.784220 | 2025-10-25 00:26:25.784351 | TASK [emit-job-header : Print job information] 2025-10-25 00:26:25.891723 | # Job Information 2025-10-25 00:26:25.891894 | Ansible Version: 2.16.14 2025-10-25 00:26:25.891928 | Job: python-black 2025-10-25 00:26:25.891962 | Pipeline: check 2025-10-25 00:26:25.891985 | Executor: 521e9411259a 2025-10-25 00:26:25.892006 | Triggered by: https://github.com/osism/python-osism/pull/1714 2025-10-25 00:26:25.892028 | Event ID: 31fcd1f0-b139-11f0-85c1-802c6cf4bff8 2025-10-25 00:26:25.896803 | 2025-10-25 00:26:25.896903 | LOOP [emit-job-header : Print node information] 2025-10-25 00:26:26.048421 | debian-bookworm | ok: 2025-10-25 00:26:26.048584 | debian-bookworm | # Node Information 2025-10-25 00:26:26.048617 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-25 00:26:26.048641 | debian-bookworm | Hostname: debian 2025-10-25 00:26:26.048663 | debian-bookworm | Username: zuul 2025-10-25 00:26:26.048684 | debian-bookworm | Distro: Debian 12.12 2025-10-25 00:26:26.048707 | debian-bookworm | Provider: regiocloud-a 2025-10-25 00:26:26.048728 | debian-bookworm | Region: 2025-10-25 00:26:26.048749 | debian-bookworm | Label: debian-bookworm 2025-10-25 00:26:26.048769 | debian-bookworm | Product Name: OpenStack Nova 2025-10-25 00:26:26.048789 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fea4:ea60 2025-10-25 00:26:26.059782 | 2025-10-25 00:26:26.059881 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-25 00:26:26.797086 | debian-bookworm -> localhost | changed 2025-10-25 00:26:26.802710 | 2025-10-25 00:26:26.802799 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-25 00:26:28.450177 | debian-bookworm -> localhost | changed 2025-10-25 00:26:28.460494 | 2025-10-25 00:26:28.460586 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-25 00:26:29.058378 | debian-bookworm -> localhost | ok 2025-10-25 00:26:29.065085 | 2025-10-25 00:26:29.065214 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-25 00:26:29.096943 | debian-bookworm | ok 2025-10-25 00:26:29.134165 | debian-bookworm | included: /var/lib/zuul/builds/5e5d893ae8c3456fa634fa6b52cbbca6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-25 00:26:29.143335 | 2025-10-25 00:26:29.143435 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-25 00:26:31.612143 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-25 00:26:31.612567 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/5e5d893ae8c3456fa634fa6b52cbbca6/work/5e5d893ae8c3456fa634fa6b52cbbca6_id_rsa 2025-10-25 00:26:31.612688 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/5e5d893ae8c3456fa634fa6b52cbbca6/work/5e5d893ae8c3456fa634fa6b52cbbca6_id_rsa.pub 2025-10-25 00:26:31.612762 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-25 00:26:31.612826 | debian-bookworm -> localhost | SHA256:nK5VA9cV9kz7XKjC/Oca9G7T468gJ3we5xI8q53m/Is zuul-build-sshkey 2025-10-25 00:26:31.612908 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-25 00:26:31.613002 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-25 00:26:31.613060 | debian-bookworm -> localhost | | +..| 2025-10-25 00:26:31.613134 | debian-bookworm -> localhost | | . o =.| 2025-10-25 00:26:31.613187 | debian-bookworm -> localhost | | . . . ..+| 2025-10-25 00:26:31.613237 | debian-bookworm -> localhost | | . * . .o| 2025-10-25 00:26:31.613287 | debian-bookworm -> localhost | | S *.o o| 2025-10-25 00:26:31.613355 | debian-bookworm -> localhost | | . o =+. | 2025-10-25 00:26:31.613408 | debian-bookworm -> localhost | | o + B++. | 2025-10-25 00:26:31.613461 | debian-bookworm -> localhost | | o O+%o..| 2025-10-25 00:26:31.613515 | debian-bookworm -> localhost | | . .+E=O=+| 2025-10-25 00:26:31.613568 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-25 00:26:31.613694 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.651259 2025-10-25 00:26:31.626577 | 2025-10-25 00:26:31.627288 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-25 00:26:31.644912 | debian-bookworm | ok 2025-10-25 00:26:31.652378 | debian-bookworm | included: /var/lib/zuul/builds/5e5d893ae8c3456fa634fa6b52cbbca6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-25 00:26:31.659653 | 2025-10-25 00:26:31.659723 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-25 00:26:31.672245 | debian-bookworm | skipping: Conditional result was False 2025-10-25 00:26:31.676747 | 2025-10-25 00:26:31.676858 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-25 00:26:32.347497 | debian-bookworm | changed 2025-10-25 00:26:32.352847 | 2025-10-25 00:26:32.352938 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-25 00:26:32.646595 | debian-bookworm | ok 2025-10-25 00:26:32.656342 | 2025-10-25 00:26:32.656469 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-25 00:26:33.351947 | debian-bookworm | changed 2025-10-25 00:26:33.358297 | 2025-10-25 00:26:33.358386 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-25 00:26:34.008484 | debian-bookworm | changed 2025-10-25 00:26:34.016529 | 2025-10-25 00:26:34.016624 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-25 00:26:34.059672 | debian-bookworm | skipping: Conditional result was False 2025-10-25 00:26:34.065712 | 2025-10-25 00:26:34.065817 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-25 00:26:34.677294 | debian-bookworm -> localhost | changed 2025-10-25 00:26:34.694117 | 2025-10-25 00:26:34.694219 | TASK [add-build-sshkey : Add back temp key] 2025-10-25 00:26:35.274459 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/5e5d893ae8c3456fa634fa6b52cbbca6/work/5e5d893ae8c3456fa634fa6b52cbbca6_id_rsa (zuul-build-sshkey) 2025-10-25 00:26:35.274648 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009913 2025-10-25 00:26:35.280700 | 2025-10-25 00:26:35.280779 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-25 00:26:35.640065 | debian-bookworm | ok 2025-10-25 00:26:35.644064 | 2025-10-25 00:26:35.644149 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-25 00:26:35.656543 | debian-bookworm | skipping: Conditional result was False 2025-10-25 00:26:35.664532 | 2025-10-25 00:26:35.664619 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-25 00:26:36.080163 | debian-bookworm | ok 2025-10-25 00:26:36.096440 | 2025-10-25 00:26:36.096580 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-25 00:26:36.128340 | debian-bookworm | ok 2025-10-25 00:26:36.136479 | 2025-10-25 00:26:36.136600 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-25 00:26:36.542194 | debian-bookworm -> localhost | ok 2025-10-25 00:26:36.548641 | 2025-10-25 00:26:36.548736 | TASK [validate-host : Collect information about the host] 2025-10-25 00:26:37.759522 | debian-bookworm | ok 2025-10-25 00:26:37.789040 | 2025-10-25 00:26:37.789174 | TASK [validate-host : Sanitize hostname] 2025-10-25 00:26:37.877756 | debian-bookworm | ok 2025-10-25 00:26:37.928431 | 2025-10-25 00:26:37.928535 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-25 00:26:38.672159 | debian-bookworm -> localhost | changed 2025-10-25 00:26:38.678058 | 2025-10-25 00:26:38.678165 | TASK [validate-host : Collect information about zuul worker] 2025-10-25 00:26:39.083667 | debian-bookworm | ok 2025-10-25 00:26:39.088251 | 2025-10-25 00:26:39.088353 | TASK [validate-host : Write out all zuul information for each host] 2025-10-25 00:26:39.627205 | debian-bookworm -> localhost | changed 2025-10-25 00:26:39.637122 | 2025-10-25 00:26:39.637221 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-25 00:26:39.939736 | debian-bookworm | ok 2025-10-25 00:26:39.944920 | 2025-10-25 00:26:39.945011 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-25 00:26:41.280448 | debian-bookworm | changed: 2025-10-25 00:26:41.280586 | debian-bookworm | cd+++++++++ src/ 2025-10-25 00:26:41.280614 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-25 00:26:41.280633 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-25 00:26:41.280650 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-10-25 00:26:41.280666 | debian-bookworm | Containerfile 2025-10-25 00:26:41.280757 | debian-bookworm | Containerfile 2025-10-25 00:26:41.286654 | debian-bookworm | localhost | ok: Runtime: 0:00:00.012259 2025-10-25 00:27:08.662012 | 2025-10-25 00:27:08.662192 | TASK [upload-logs : Upload logs to log server] 2025-10-25 00:27:09.219216 | localhost | Output suppressed because no_log was given 2025-10-25 00:27:09.221038 | 2025-10-25 00:27:09.221158 | LOOP [upload-logs : Compress console log and json output] 2025-10-25 00:27:09.267481 | localhost | skipping: Conditional result was False 2025-10-25 00:27:09.275504 | localhost | skipping: Conditional result was False 2025-10-25 00:27:09.287652 | 2025-10-25 00:27:09.287761 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-25 00:27:09.341382 | localhost | skipping: Conditional result was False 2025-10-25 00:27:09.342035 | 2025-10-25 00:27:09.345266 | localhost | skipping: Conditional result was False 2025-10-25 00:27:09.354498 | 2025-10-25 00:27:09.354611 | LOOP [upload-logs : Upload console log and json output]