2025-09-10 22:31:24.596593 | Job console starting 2025-09-10 22:31:24.649730 | Updating git repos 2025-09-10 22:31:24.722623 | Cloning repos into workspace 2025-09-10 22:31:24.824929 | Restoring repo states 2025-09-10 22:31:24.838849 | Merging changes 2025-09-10 22:31:25.397179 | Checking out repos 2025-09-10 22:31:25.496375 | Preparing playbooks 2025-09-10 22:31:26.771159 | Running Ansible setup 2025-09-10 22:31:32.220135 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-10 22:31:33.211894 | 2025-09-10 22:31:33.212024 | PLAY [Base pre] 2025-09-10 22:31:33.245484 | 2025-09-10 22:31:33.245608 | TASK [Setup log path fact] 2025-09-10 22:31:33.269702 | debian-bookworm | ok 2025-09-10 22:31:33.301877 | 2025-09-10 22:31:33.302010 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-10 22:31:33.350821 | debian-bookworm | ok 2025-09-10 22:31:33.371797 | 2025-09-10 22:31:33.371898 | TASK [emit-job-header : Print job information] 2025-09-10 22:31:33.430687 | # Job Information 2025-09-10 22:31:33.430901 | Ansible Version: 2.16.14 2025-09-10 22:31:33.430938 | Job: python-black 2025-09-10 22:31:33.430975 | Pipeline: check 2025-09-10 22:31:33.430998 | Executor: 521e9411259a 2025-09-10 22:31:33.431018 | Triggered by: https://github.com/osism/python-osism/pull/1715 2025-09-10 22:31:33.431042 | Event ID: dd9cafb0-8e95-11f0-84e4-0d4e96c2a356 2025-09-10 22:31:33.435900 | 2025-09-10 22:31:33.435996 | LOOP [emit-job-header : Print node information] 2025-09-10 22:31:33.624011 | debian-bookworm | ok: 2025-09-10 22:31:33.624180 | debian-bookworm | # Node Information 2025-09-10 22:31:33.624225 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-10 22:31:33.624250 | debian-bookworm | Hostname: debian 2025-09-10 22:31:33.624271 | debian-bookworm | Username: zuul 2025-09-10 22:31:33.624291 | debian-bookworm | Distro: Debian 12.12 2025-09-10 22:31:33.630886 | debian-bookworm | Provider: regiocloud-a 2025-09-10 22:31:33.630964 | debian-bookworm | Region: 2025-09-10 22:31:33.630994 | debian-bookworm | Label: debian-bookworm 2025-09-10 22:31:33.631017 | debian-bookworm | Product Name: OpenStack Nova 2025-09-10 22:31:33.631039 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe7c:ec85 2025-09-10 22:31:33.644396 | 2025-09-10 22:31:33.644499 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-10 22:31:34.395641 | debian-bookworm -> localhost | changed 2025-09-10 22:31:34.402304 | 2025-09-10 22:31:34.402402 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-10 22:31:35.699642 | debian-bookworm -> localhost | changed 2025-09-10 22:31:35.715308 | 2025-09-10 22:31:35.715400 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-10 22:31:36.236433 | debian-bookworm -> localhost | ok 2025-09-10 22:31:36.241292 | 2025-09-10 22:31:36.241373 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-10 22:31:36.260421 | debian-bookworm | ok 2025-09-10 22:31:36.284083 | debian-bookworm | included: /var/lib/zuul/builds/bdfb7334d98f4c50a419877b39367ee9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-10 22:31:36.288843 | 2025-09-10 22:31:36.288914 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-10 22:31:38.330856 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-10 22:31:38.331045 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/bdfb7334d98f4c50a419877b39367ee9/work/bdfb7334d98f4c50a419877b39367ee9_id_rsa 2025-09-10 22:31:38.331083 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/bdfb7334d98f4c50a419877b39367ee9/work/bdfb7334d98f4c50a419877b39367ee9_id_rsa.pub 2025-09-10 22:31:38.331111 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-10 22:31:38.331137 | debian-bookworm -> localhost | SHA256:JX1ViQC665V9P/WXv1qC7+q8g+PVLVFgMuoaIWaHxgA zuul-build-sshkey 2025-09-10 22:31:38.331160 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-10 22:31:38.331189 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-10 22:31:38.331223 | debian-bookworm -> localhost | | E.. ..+.oo.o| 2025-09-10 22:31:38.331245 | debian-bookworm -> localhost | | o . ... +o.. | 2025-09-10 22:31:38.331265 | debian-bookworm -> localhost | | B +..o . . | 2025-09-10 22:31:38.331285 | debian-bookworm -> localhost | | + o +o . . | 2025-09-10 22:31:38.331304 | debian-bookworm -> localhost | | oS. . | 2025-09-10 22:31:38.331327 | debian-bookworm -> localhost | | + o o o .| 2025-09-10 22:31:38.331347 | debian-bookworm -> localhost | | o o.+ = o+| 2025-09-10 22:31:38.331368 | debian-bookworm -> localhost | | . .oo.o =oo| 2025-09-10 22:31:38.331389 | debian-bookworm -> localhost | | ...o==+.o*| 2025-09-10 22:31:38.331409 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-10 22:31:38.331460 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.548210 2025-09-10 22:31:38.337945 | 2025-09-10 22:31:38.338034 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-10 22:31:38.374739 | debian-bookworm | ok 2025-09-10 22:31:38.398578 | debian-bookworm | included: /var/lib/zuul/builds/bdfb7334d98f4c50a419877b39367ee9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-10 22:31:38.427390 | 2025-09-10 22:31:38.427466 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-10 22:31:38.467017 | debian-bookworm | skipping: Conditional result was False 2025-09-10 22:31:38.472695 | 2025-09-10 22:31:38.472779 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-10 22:31:39.163752 | debian-bookworm | changed 2025-09-10 22:31:39.169773 | 2025-09-10 22:31:39.169951 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-10 22:31:39.408892 | debian-bookworm | ok 2025-09-10 22:31:39.424754 | 2025-09-10 22:31:39.425084 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-10 22:31:40.036258 | debian-bookworm | changed 2025-09-10 22:31:40.043618 | 2025-09-10 22:31:40.043712 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-10 22:31:40.603092 | debian-bookworm | changed 2025-09-10 22:31:40.608609 | 2025-09-10 22:31:40.608695 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-10 22:31:40.634311 | debian-bookworm | skipping: Conditional result was False 2025-09-10 22:31:40.645543 | 2025-09-10 22:31:40.645692 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-10 22:31:41.094107 | debian-bookworm -> localhost | changed 2025-09-10 22:31:41.104710 | 2025-09-10 22:31:41.104807 | TASK [add-build-sshkey : Add back temp key] 2025-09-10 22:31:41.627371 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/bdfb7334d98f4c50a419877b39367ee9/work/bdfb7334d98f4c50a419877b39367ee9_id_rsa (zuul-build-sshkey) 2025-09-10 22:31:41.627592 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018086 2025-09-10 22:31:41.635101 | 2025-09-10 22:31:41.635240 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-10 22:31:42.039668 | debian-bookworm | ok 2025-09-10 22:31:42.043622 | 2025-09-10 22:31:42.043693 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-10 22:31:42.066060 | debian-bookworm | skipping: Conditional result was False 2025-09-10 22:31:42.074178 | 2025-09-10 22:31:42.074277 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-10 22:31:42.539633 | debian-bookworm | ok 2025-09-10 22:31:42.558246 | 2025-09-10 22:31:42.558339 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-10 22:31:42.599804 | debian-bookworm | ok 2025-09-10 22:31:42.605546 | 2025-09-10 22:31:42.605625 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-10 22:31:43.063114 | debian-bookworm -> localhost | ok 2025-09-10 22:31:43.069311 | 2025-09-10 22:31:43.069402 | TASK [validate-host : Collect information about the host] 2025-09-10 22:31:44.242532 | debian-bookworm | ok 2025-09-10 22:31:44.263508 | 2025-09-10 22:31:44.268159 | TASK [validate-host : Sanitize hostname] 2025-09-10 22:31:44.490256 | debian-bookworm | ok 2025-09-10 22:31:44.606289 | 2025-09-10 22:31:44.606387 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-10 22:31:45.703519 | debian-bookworm -> localhost | changed 2025-09-10 22:31:45.708682 | 2025-09-10 22:31:45.708763 | TASK [validate-host : Collect information about zuul worker] 2025-09-10 22:31:46.274090 | debian-bookworm | ok 2025-09-10 22:31:46.277812 | 2025-09-10 22:31:46.277893 | TASK [validate-host : Write out all zuul information for each host] 2025-09-10 22:31:47.024663 | debian-bookworm -> localhost | changed 2025-09-10 22:31:47.040058 | 2025-09-10 22:31:47.040154 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-10 22:31:47.319419 | debian-bookworm | ok 2025-09-10 22:31:47.323855 | 2025-09-10 22:31:47.323930 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-10 22:31:48.872262 | debian-bookworm | changed: 2025-09-10 22:31:48.872410 | debian-bookworm | cd+++++++++ src/ 2025-09-10 22:31:48.872437 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-10 22:31:48.872458 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-10 22:31:48.872476 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-09-10 22:31:48.872493 | debian-bookworm | Containerfile 2025-09-10 22:31:48.872589 | debian-bookworm | Containerfile 2025-09-10 22:31:48.910289 | debian-bookworm | localhost | ok: Runtime: 0:00:00.004195 2025-09-10 22:32:14.956852 | 2025-09-10 22:32:14.956959 | TASK [upload-logs : Upload logs to log server] 2025-09-10 22:32:15.575027 | localhost | Output suppressed because no_log was given 2025-09-10 22:32:15.576932 | 2025-09-10 22:32:15.577040 | LOOP [upload-logs : Compress console log and json output] 2025-09-10 22:32:15.635466 | localhost | skipping: Conditional result was False 2025-09-10 22:32:15.641342 | localhost | skipping: Conditional result was False 2025-09-10 22:32:15.654131 | 2025-09-10 22:32:15.654273 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-10 22:32:15.704327 | localhost | skipping: Conditional result was False 2025-09-10 22:32:15.704729 | 2025-09-10 22:32:15.718594 | localhost | skipping: Conditional result was False 2025-09-10 22:32:15.726540 | 2025-09-10 22:32:15.726673 | LOOP [upload-logs : Upload console log and json output]