2025-11-23 13:06:58.550617 | Job console starting 2025-11-23 13:06:58.579568 | Updating git repos 2025-11-23 13:06:58.691028 | Cloning repos into workspace 2025-11-23 13:06:58.783550 | Restoring repo states 2025-11-23 13:06:58.811386 | Merging changes 2025-11-23 13:06:59.471821 | Checking out repos 2025-11-23 13:06:59.535307 | Preparing playbooks 2025-11-23 13:07:00.737911 | Running Ansible setup 2025-11-23 13:07:07.357143 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-23 13:07:08.880621 | 2025-11-23 13:07:08.880745 | PLAY [Base pre] 2025-11-23 13:07:08.909511 | 2025-11-23 13:07:08.909629 | TASK [Setup log path fact] 2025-11-23 13:07:08.948388 | debian-bookworm | ok 2025-11-23 13:07:08.978297 | 2025-11-23 13:07:08.978435 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-23 13:07:09.052595 | debian-bookworm | ok 2025-11-23 13:07:09.071001 | 2025-11-23 13:07:09.071162 | TASK [emit-job-header : Print job information] 2025-11-23 13:07:09.140480 | # Job Information 2025-11-23 13:07:09.140660 | Ansible Version: 2.16.14 2025-11-23 13:07:09.140696 | Job: python-black 2025-11-23 13:07:09.140730 | Pipeline: check 2025-11-23 13:07:09.140753 | Executor: 521e9411259a 2025-11-23 13:07:09.140773 | Triggered by: https://github.com/osism/python-osism/pull/1843 2025-11-23 13:07:09.140797 | Event ID: 4555b280-c86d-11f0-9d9c-205353df39cf 2025-11-23 13:07:09.145690 | 2025-11-23 13:07:09.145789 | LOOP [emit-job-header : Print node information] 2025-11-23 13:07:09.334682 | debian-bookworm | ok: 2025-11-23 13:07:09.335001 | debian-bookworm | # Node Information 2025-11-23 13:07:09.335070 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-23 13:07:09.335097 | debian-bookworm | Hostname: debian 2025-11-23 13:07:09.335119 | debian-bookworm | Username: zuul 2025-11-23 13:07:09.335140 | debian-bookworm | Distro: Debian 12.12 2025-11-23 13:07:09.335167 | debian-bookworm | Provider: regiocloud-a 2025-11-23 13:07:09.335189 | debian-bookworm | Region: 2025-11-23 13:07:09.335210 | debian-bookworm | Label: debian-bookworm 2025-11-23 13:07:09.335230 | debian-bookworm | Product Name: OpenStack Nova 2025-11-23 13:07:09.335249 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe5b:e54a 2025-11-23 13:07:09.359281 | 2025-11-23 13:07:09.359421 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-23 13:07:10.051851 | debian-bookworm -> localhost | changed 2025-11-23 13:07:10.058662 | 2025-11-23 13:07:10.058757 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-23 13:07:11.783343 | debian-bookworm -> localhost | changed 2025-11-23 13:07:11.793518 | 2025-11-23 13:07:11.793629 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-23 13:07:12.364733 | debian-bookworm -> localhost | ok 2025-11-23 13:07:12.371611 | 2025-11-23 13:07:12.371712 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-23 13:07:12.409485 | debian-bookworm | ok 2025-11-23 13:07:12.439741 | debian-bookworm | included: /var/lib/zuul/builds/0f9127cc39e046f9a7056b51be8f3723/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-23 13:07:12.451051 | 2025-11-23 13:07:12.451154 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-23 13:07:14.568333 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-23 13:07:14.568581 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/0f9127cc39e046f9a7056b51be8f3723/work/0f9127cc39e046f9a7056b51be8f3723_id_rsa 2025-11-23 13:07:14.568621 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/0f9127cc39e046f9a7056b51be8f3723/work/0f9127cc39e046f9a7056b51be8f3723_id_rsa.pub 2025-11-23 13:07:14.568648 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-23 13:07:14.568674 | debian-bookworm -> localhost | SHA256:MyviX28d2i99R67J5IrEQHTGWwMrH+0J7UqnqgJBWc8 zuul-build-sshkey 2025-11-23 13:07:14.568697 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-23 13:07:14.568731 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-23 13:07:14.568753 | debian-bookworm -> localhost | | o. ..+. | 2025-11-23 13:07:14.568775 | debian-bookworm -> localhost | | o o . o.+o | 2025-11-23 13:07:14.568795 | debian-bookworm -> localhost | | . E o +oo. | 2025-11-23 13:07:14.568815 | debian-bookworm -> localhost | | . . o.= . | 2025-11-23 13:07:14.568835 | debian-bookworm -> localhost | | . S o = | 2025-11-23 13:07:14.568860 | debian-bookworm -> localhost | | . B +. .| 2025-11-23 13:07:14.568880 | debian-bookworm -> localhost | | .. . o =+ o.o | 2025-11-23 13:07:14.568899 | debian-bookworm -> localhost | | ... o +o.++..+| 2025-11-23 13:07:14.568919 | debian-bookworm -> localhost | | .oo...o .+*o.| 2025-11-23 13:07:14.568939 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-23 13:07:14.568996 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.178170 2025-11-23 13:07:14.575667 | 2025-11-23 13:07:14.575783 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-23 13:07:14.595087 | debian-bookworm | ok 2025-11-23 13:07:14.614721 | debian-bookworm | included: /var/lib/zuul/builds/0f9127cc39e046f9a7056b51be8f3723/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-23 13:07:14.623732 | 2025-11-23 13:07:14.623875 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-23 13:07:14.647322 | debian-bookworm | skipping: Conditional result was False 2025-11-23 13:07:14.653076 | 2025-11-23 13:07:14.653181 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-23 13:07:15.332156 | debian-bookworm | changed 2025-11-23 13:07:15.337660 | 2025-11-23 13:07:15.337755 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-23 13:07:15.618552 | debian-bookworm | ok 2025-11-23 13:07:15.624168 | 2025-11-23 13:07:15.624272 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-23 13:07:16.245436 | debian-bookworm | changed 2025-11-23 13:07:16.264056 | 2025-11-23 13:07:16.264165 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-23 13:07:16.980145 | debian-bookworm | changed 2025-11-23 13:07:16.985350 | 2025-11-23 13:07:16.985438 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-23 13:07:17.051850 | debian-bookworm | skipping: Conditional result was False 2025-11-23 13:07:17.057817 | 2025-11-23 13:07:17.057917 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-23 13:07:17.708060 | debian-bookworm -> localhost | changed 2025-11-23 13:07:17.719439 | 2025-11-23 13:07:17.719583 | TASK [add-build-sshkey : Add back temp key] 2025-11-23 13:07:18.193271 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/0f9127cc39e046f9a7056b51be8f3723/work/0f9127cc39e046f9a7056b51be8f3723_id_rsa (zuul-build-sshkey) 2025-11-23 13:07:18.193535 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.029655 2025-11-23 13:07:18.202153 | 2025-11-23 13:07:18.202298 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-23 13:07:18.717433 | debian-bookworm | ok 2025-11-23 13:07:18.724022 | 2025-11-23 13:07:18.724233 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-23 13:07:18.747979 | debian-bookworm | skipping: Conditional result was False 2025-11-23 13:07:18.759899 | 2025-11-23 13:07:18.760018 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-23 13:07:19.256284 | debian-bookworm | ok 2025-11-23 13:07:19.295710 | 2025-11-23 13:07:19.295861 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-23 13:07:19.361675 | debian-bookworm | ok 2025-11-23 13:07:19.367760 | 2025-11-23 13:07:19.367916 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-23 13:07:19.973584 | debian-bookworm -> localhost | ok 2025-11-23 13:07:19.980650 | 2025-11-23 13:07:19.980768 | TASK [validate-host : Collect information about the host] 2025-11-23 13:07:21.217347 | debian-bookworm | ok 2025-11-23 13:07:21.238453 | 2025-11-23 13:07:21.238618 | TASK [validate-host : Sanitize hostname] 2025-11-23 13:07:21.363501 | debian-bookworm | ok 2025-11-23 13:07:21.459523 | 2025-11-23 13:07:21.459712 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-23 13:07:22.131359 | debian-bookworm -> localhost | changed 2025-11-23 13:07:22.137937 | 2025-11-23 13:07:22.138077 | TASK [validate-host : Collect information about zuul worker] 2025-11-23 13:07:22.595261 | debian-bookworm | ok 2025-11-23 13:07:22.602536 | 2025-11-23 13:07:22.602669 | TASK [validate-host : Write out all zuul information for each host] 2025-11-23 13:07:23.601771 | debian-bookworm -> localhost | changed 2025-11-23 13:07:23.613924 | 2025-11-23 13:07:23.614117 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-23 13:07:23.892914 | debian-bookworm | ok 2025-11-23 13:07:23.911339 | 2025-11-23 13:07:23.911513 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-23 13:07:25.421409 | debian-bookworm | changed: 2025-11-23 13:07:25.421660 | debian-bookworm | cd+++++++++ src/ 2025-11-23 13:07:25.421699 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-23 13:07:25.421723 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-23 13:07:25.421745 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-11-23 13:07:25.421766 | debian-bookworm | Containerfile 2025-11-23 13:07:25.421882 | debian-bookworm | Containerfile 2025-11-23 13:07:25.456022 | debian-bookworm | localhost | ok: Runtime: 0:00:00.012512 2025-11-23 13:07:53.491155 | 2025-11-23 13:07:53.491324 | TASK [upload-logs : Upload logs to log server] 2025-11-23 13:07:54.100026 | localhost | Output suppressed because no_log was given 2025-11-23 13:07:54.103239 | 2025-11-23 13:07:54.103419 | LOOP [upload-logs : Compress console log and json output] 2025-11-23 13:07:54.166334 | localhost | skipping: Conditional result was False 2025-11-23 13:07:54.175700 | localhost | skipping: Conditional result was False 2025-11-23 13:07:54.183773 | 2025-11-23 13:07:54.183934 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-23 13:07:54.234411 | localhost | skipping: Conditional result was False 2025-11-23 13:07:54.234743 | 2025-11-23 13:07:54.248499 | localhost | skipping: Conditional result was False 2025-11-23 13:07:54.264233 | 2025-11-23 13:07:54.264623 | LOOP [upload-logs : Upload console log and json output]