2025-11-01 09:38:15.532220 | Job console starting 2025-11-01 09:38:15.556521 | Updating git repos 2025-11-01 09:38:15.667884 | Cloning repos into workspace 2025-11-01 09:38:15.746801 | Restoring repo states 2025-11-01 09:38:15.761175 | Merging changes 2025-11-01 09:38:16.426620 | Checking out repos 2025-11-01 09:38:16.513433 | Preparing playbooks 2025-11-01 09:38:17.619241 | Running Ansible setup 2025-11-01 09:38:24.002975 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-01 09:38:24.981758 | 2025-11-01 09:38:24.981888 | PLAY [Base pre] 2025-11-01 09:38:24.996816 | 2025-11-01 09:38:24.996936 | TASK [Setup log path fact] 2025-11-01 09:38:25.014496 | debian-bookworm | ok 2025-11-01 09:38:25.029473 | 2025-11-01 09:38:25.029594 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-01 09:38:25.057724 | debian-bookworm | ok 2025-11-01 09:38:25.067093 | 2025-11-01 09:38:25.067196 | TASK [emit-job-header : Print job information] 2025-11-01 09:38:25.125266 | # Job Information 2025-11-01 09:38:25.125432 | Ansible Version: 2.16.14 2025-11-01 09:38:25.125468 | Job: python-black 2025-11-01 09:38:25.125501 | Pipeline: check 2025-11-01 09:38:25.125524 | Executor: 521e9411259a 2025-11-01 09:38:25.125544 | Triggered by: https://github.com/osism/python-osism/pull/1780 2025-11-01 09:38:25.125566 | Event ID: 77f2e820-b706-11f0-84f6-7ce7585e7acb 2025-11-01 09:38:25.136887 | 2025-11-01 09:38:25.136997 | LOOP [emit-job-header : Print node information] 2025-11-01 09:38:25.327125 | debian-bookworm | ok: 2025-11-01 09:38:25.327346 | debian-bookworm | # Node Information 2025-11-01 09:38:25.327383 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-01 09:38:25.327435 | debian-bookworm | Hostname: debian 2025-11-01 09:38:25.327460 | debian-bookworm | Username: zuul 2025-11-01 09:38:25.327481 | debian-bookworm | Distro: Debian 12.12 2025-11-01 09:38:25.327512 | debian-bookworm | Provider: regiocloud-a 2025-11-01 09:38:25.327539 | debian-bookworm | Region: 2025-11-01 09:38:25.327560 | debian-bookworm | Label: debian-bookworm 2025-11-01 09:38:25.327580 | debian-bookworm | Product Name: OpenStack Nova 2025-11-01 09:38:25.327600 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe7f:60f7 2025-11-01 09:38:25.341667 | 2025-11-01 09:38:25.341778 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-01 09:38:25.929004 | debian-bookworm -> localhost | changed 2025-11-01 09:38:25.935663 | 2025-11-01 09:38:25.935757 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-01 09:38:27.213633 | debian-bookworm -> localhost | changed 2025-11-01 09:38:27.222071 | 2025-11-01 09:38:27.222150 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-01 09:38:27.758682 | debian-bookworm -> localhost | ok 2025-11-01 09:38:27.763515 | 2025-11-01 09:38:27.763602 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-01 09:38:27.790055 | debian-bookworm | ok 2025-11-01 09:38:27.814796 | debian-bookworm | included: /var/lib/zuul/builds/6ae865c7811b4cf18249ee392e5bb846/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-01 09:38:27.826252 | 2025-11-01 09:38:27.826335 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-01 09:38:29.570569 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-01 09:38:29.570722 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/6ae865c7811b4cf18249ee392e5bb846/work/6ae865c7811b4cf18249ee392e5bb846_id_rsa 2025-11-01 09:38:29.570752 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/6ae865c7811b4cf18249ee392e5bb846/work/6ae865c7811b4cf18249ee392e5bb846_id_rsa.pub 2025-11-01 09:38:29.570774 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-01 09:38:29.570806 | debian-bookworm -> localhost | SHA256:VUBzw4U+Vd7x4esI0afGeN7ZY4hgenJ7ceBTfThTRLw zuul-build-sshkey 2025-11-01 09:38:29.570826 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-01 09:38:29.570862 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-01 09:38:29.570882 | debian-bookworm -> localhost | | .+o+o.B+| 2025-11-01 09:38:29.570901 | debian-bookworm -> localhost | | ++.o.B| 2025-11-01 09:38:29.570917 | debian-bookworm -> localhost | | .o o.==| 2025-11-01 09:38:29.570934 | debian-bookworm -> localhost | | . .*.*Eo| 2025-11-01 09:38:29.570950 | debian-bookworm -> localhost | | So.oo* +.| 2025-11-01 09:38:29.570970 | debian-bookworm -> localhost | | o .+*.= o| 2025-11-01 09:38:29.570986 | debian-bookworm -> localhost | | o o .++ *.| 2025-11-01 09:38:29.571002 | debian-bookworm -> localhost | | + .. . .| 2025-11-01 09:38:29.571019 | debian-bookworm -> localhost | | .. | 2025-11-01 09:38:29.571035 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-01 09:38:29.571080 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.953217 2025-11-01 09:38:29.576154 | 2025-11-01 09:38:29.576229 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-01 09:38:29.591916 | debian-bookworm | ok 2025-11-01 09:38:29.600183 | debian-bookworm | included: /var/lib/zuul/builds/6ae865c7811b4cf18249ee392e5bb846/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-01 09:38:29.610116 | 2025-11-01 09:38:29.610196 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-01 09:38:29.622666 | debian-bookworm | skipping: Conditional result was False 2025-11-01 09:38:29.628031 | 2025-11-01 09:38:29.628113 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-01 09:38:30.256855 | debian-bookworm | changed 2025-11-01 09:38:30.264440 | 2025-11-01 09:38:30.264538 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-01 09:38:30.537069 | debian-bookworm | ok 2025-11-01 09:38:30.545668 | 2025-11-01 09:38:30.545789 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-01 09:38:31.226284 | debian-bookworm | changed 2025-11-01 09:38:31.240150 | 2025-11-01 09:38:31.240250 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-01 09:38:31.909451 | debian-bookworm | changed 2025-11-01 09:38:31.914691 | 2025-11-01 09:38:31.914781 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-01 09:38:31.927374 | debian-bookworm | skipping: Conditional result was False 2025-11-01 09:38:31.932985 | 2025-11-01 09:38:31.933068 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-01 09:38:32.410043 | debian-bookworm -> localhost | changed 2025-11-01 09:38:32.421490 | 2025-11-01 09:38:32.421585 | TASK [add-build-sshkey : Add back temp key] 2025-11-01 09:38:32.969503 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/6ae865c7811b4cf18249ee392e5bb846/work/6ae865c7811b4cf18249ee392e5bb846_id_rsa (zuul-build-sshkey) 2025-11-01 09:38:32.969713 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.027504 2025-11-01 09:38:32.977122 | 2025-11-01 09:38:32.978188 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-01 09:38:33.527768 | debian-bookworm | ok 2025-11-01 09:38:33.532697 | 2025-11-01 09:38:33.532781 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-01 09:38:33.555624 | debian-bookworm | skipping: Conditional result was False 2025-11-01 09:38:33.565305 | 2025-11-01 09:38:33.565392 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-01 09:38:34.010675 | debian-bookworm | ok 2025-11-01 09:38:34.026776 | 2025-11-01 09:38:34.026898 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-01 09:38:34.054516 | debian-bookworm | ok 2025-11-01 09:38:34.059443 | 2025-11-01 09:38:34.059537 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-01 09:38:34.382540 | debian-bookworm -> localhost | ok 2025-11-01 09:38:34.392882 | 2025-11-01 09:38:34.392982 | TASK [validate-host : Collect information about the host] 2025-11-01 09:38:35.580276 | debian-bookworm | ok 2025-11-01 09:38:35.594257 | 2025-11-01 09:38:35.594367 | TASK [validate-host : Sanitize hostname] 2025-11-01 09:38:35.728875 | debian-bookworm | ok 2025-11-01 09:38:35.779975 | 2025-11-01 09:38:35.780077 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-01 09:38:36.485953 | debian-bookworm -> localhost | changed 2025-11-01 09:38:36.491485 | 2025-11-01 09:38:36.491584 | TASK [validate-host : Collect information about zuul worker] 2025-11-01 09:38:36.945088 | debian-bookworm | ok 2025-11-01 09:38:36.952309 | 2025-11-01 09:38:36.952439 | TASK [validate-host : Write out all zuul information for each host] 2025-11-01 09:38:37.466761 | debian-bookworm -> localhost | changed 2025-11-01 09:38:37.475826 | 2025-11-01 09:38:37.475915 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-01 09:38:37.782718 | debian-bookworm | ok 2025-11-01 09:38:37.787849 | 2025-11-01 09:38:37.787938 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-01 09:38:39.386509 | debian-bookworm | changed: 2025-11-01 09:38:39.386665 | debian-bookworm | cd+++++++++ src/ 2025-11-01 09:38:39.386698 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-01 09:38:39.386721 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-01 09:38:39.386742 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-11-01 09:38:39.386762 | debian-bookworm | Containerfile 2025-11-01 09:38:39.386980 | debian-bookworm | Containerfile 2025-11-01 09:38:39.409004 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006312 2025-11-01 09:39:06.317589 | 2025-11-01 09:39:06.317711 | TASK [upload-logs : Upload logs to log server] 2025-11-01 09:39:06.868531 | localhost | Output suppressed because no_log was given 2025-11-01 09:39:06.871067 | 2025-11-01 09:39:06.871189 | LOOP [upload-logs : Compress console log and json output] 2025-11-01 09:39:06.938984 | localhost | skipping: Conditional result was False 2025-11-01 09:39:06.945217 | localhost | skipping: Conditional result was False 2025-11-01 09:39:06.949403 | 2025-11-01 09:39:06.949571 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-01 09:39:06.996347 | localhost | skipping: Conditional result was False 2025-11-01 09:39:06.996705 | 2025-11-01 09:39:07.001535 | localhost | skipping: Conditional result was False 2025-11-01 09:39:07.009707 | 2025-11-01 09:39:07.009816 | LOOP [upload-logs : Upload console log and json output]