2025-02-04 10:10:22.019854 | Job console starting... 2025-02-04 10:10:22.056115 | Updating repositories 2025-02-04 10:10:22.098884 | Preparing job workspace 2025-02-04 10:10:24.368092 | Running Ansible setup... 2025-02-04 10:10:30.924779 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-02-04 10:10:32.057911 | 2025-02-04 10:10:32.058070 | PLAY [Base pre] 2025-02-04 10:10:32.095425 | 2025-02-04 10:10:32.095578 | TASK [Setup log path fact] 2025-02-04 10:10:32.127024 | ubuntu-noble | ok 2025-02-04 10:10:32.156441 | 2025-02-04 10:10:32.156598 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-04 10:10:32.198266 | ubuntu-noble | ok 2025-02-04 10:10:32.205493 | 2025-02-04 10:10:32.205628 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-04 10:10:32.241113 | ubuntu-noble | skipping: Conditional result was False 2025-02-04 10:10:32.248840 | 2025-02-04 10:10:32.248978 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-04 10:10:32.294462 | ubuntu-noble | skipping: Conditional result was False 2025-02-04 10:10:32.303592 | 2025-02-04 10:10:32.303767 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-04 10:10:32.331329 | ubuntu-noble | skipping: Conditional result was False 2025-02-04 10:10:32.338845 | 2025-02-04 10:10:32.338971 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-04 10:10:32.363964 | ubuntu-noble | skipping: Conditional result was False 2025-02-04 10:10:32.371569 | 2025-02-04 10:10:32.371725 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-04 10:10:32.397504 | ubuntu-noble | skipping: Conditional result was False 2025-02-04 10:10:32.413642 | 2025-02-04 10:10:32.413815 | TASK [emit-job-header : Print job information] 2025-02-04 10:10:32.467284 | # Job Information 2025-02-04 10:10:32.467468 | Ansible Version: 2.15.3 2025-02-04 10:10:32.467500 | Job: python-black 2025-02-04 10:10:32.467529 | Pipeline: check 2025-02-04 10:10:32.467550 | Executor: 7d211f194f6a 2025-02-04 10:10:32.467568 | Triggered by: https://github.com/osism/python-osism/pull/1193 2025-02-04 10:10:32.467587 | Event ID: 38741ca0-e2e0-11ef-8feb-89363305f5e2 2025-02-04 10:10:32.474334 | 2025-02-04 10:10:32.474453 | LOOP [emit-job-header : Print node information] 2025-02-04 10:10:32.659991 | ubuntu-noble | ok: 2025-02-04 10:10:32.660181 | ubuntu-noble | # Node Information 2025-02-04 10:10:32.660214 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-02-04 10:10:32.660237 | ubuntu-noble | Hostname: ubuntu 2025-02-04 10:10:32.660258 | ubuntu-noble | Username: zuul 2025-02-04 10:10:32.660278 | ubuntu-noble | Distro: Ubuntu 24.04 2025-02-04 10:10:32.660298 | ubuntu-noble | Provider: regiocloud-a 2025-02-04 10:10:32.660317 | ubuntu-noble | Label: ubuntu-noble 2025-02-04 10:10:32.660335 | ubuntu-noble | Product Name: OpenStack Nova 2025-02-04 10:10:32.660355 | ubuntu-noble | Interface IP: 81.163.193.172 2025-02-04 10:10:32.681534 | 2025-02-04 10:10:32.681676 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-02-04 10:10:33.259496 | ubuntu-noble -> localhost | changed 2025-02-04 10:10:33.268565 | 2025-02-04 10:10:33.268689 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-02-04 10:10:34.350615 | ubuntu-noble -> localhost | changed 2025-02-04 10:10:34.363792 | 2025-02-04 10:10:34.363912 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-02-04 10:10:34.601814 | ubuntu-noble -> localhost | ok 2025-02-04 10:10:34.610203 | 2025-02-04 10:10:34.610392 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-02-04 10:10:34.656418 | ubuntu-noble | ok 2025-02-04 10:10:34.673316 | ubuntu-noble | included: /var/lib/zuul/builds/bb2a6624c87a4291a29ecfd28257b8db/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-02-04 10:10:34.680984 | 2025-02-04 10:10:34.681076 | TASK [add-build-sshkey : Create Temp SSH key] 2025-02-04 10:10:35.957163 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-02-04 10:10:35.957373 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/bb2a6624c87a4291a29ecfd28257b8db/work/bb2a6624c87a4291a29ecfd28257b8db_id_rsa 2025-02-04 10:10:35.957418 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/bb2a6624c87a4291a29ecfd28257b8db/work/bb2a6624c87a4291a29ecfd28257b8db_id_rsa.pub 2025-02-04 10:10:35.957447 | ubuntu-noble -> localhost | The key fingerprint is: 2025-02-04 10:10:35.957473 | ubuntu-noble -> localhost | SHA256:FoeYTyTwRDmOj24EsmHoELKUt+vbZT2U/ztvsTaFkX4 zuul-build-sshkey 2025-02-04 10:10:35.957498 | ubuntu-noble -> localhost | The key's randomart image is: 2025-02-04 10:10:35.957526 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-02-04 10:10:35.957552 | ubuntu-noble -> localhost | | . .o+.. | 2025-02-04 10:10:35.957575 | ubuntu-noble -> localhost | |oo . oo= . | 2025-02-04 10:10:35.957598 | ubuntu-noble -> localhost | |+o. .o+.+ . . | 2025-02-04 10:10:35.957620 | ubuntu-noble -> localhost | |*.... .o o. o | 2025-02-04 10:10:35.957642 | ubuntu-noble -> localhost | |++ ..o So . o | 2025-02-04 10:10:35.957664 | ubuntu-noble -> localhost | |.. .o ..o . o.E| 2025-02-04 10:10:35.957687 | ubuntu-noble -> localhost | | .o o o . .+| 2025-02-04 10:10:35.957725 | ubuntu-noble -> localhost | | .+ o . .. = | 2025-02-04 10:10:35.957749 | ubuntu-noble -> localhost | | o.. o*..| 2025-02-04 10:10:35.957771 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-02-04 10:10:35.957826 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.713874 2025-02-04 10:10:35.966623 | 2025-02-04 10:10:35.966731 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-02-04 10:10:35.997964 | ubuntu-noble | ok 2025-02-04 10:10:36.011814 | ubuntu-noble | included: /var/lib/zuul/builds/bb2a6624c87a4291a29ecfd28257b8db/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-02-04 10:10:36.023302 | 2025-02-04 10:10:36.023605 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-02-04 10:10:36.059013 | ubuntu-noble | skipping: Conditional result was False 2025-02-04 10:10:36.066102 | 2025-02-04 10:10:36.066197 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-02-04 10:10:36.742097 | ubuntu-noble | changed 2025-02-04 10:10:36.751635 | 2025-02-04 10:10:36.751741 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-02-04 10:10:37.021248 | ubuntu-noble | ok 2025-02-04 10:10:37.032929 | 2025-02-04 10:10:37.033201 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-02-04 10:10:37.692908 | ubuntu-noble | changed 2025-02-04 10:10:37.701537 | 2025-02-04 10:10:37.701656 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-02-04 10:10:38.373776 | ubuntu-noble | changed 2025-02-04 10:10:38.381226 | 2025-02-04 10:10:38.381317 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-02-04 10:10:38.405959 | ubuntu-noble | skipping: Conditional result was False 2025-02-04 10:10:38.415803 | 2025-02-04 10:10:38.415927 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-02-04 10:10:38.815208 | ubuntu-noble -> localhost | changed 2025-02-04 10:10:38.828472 | 2025-02-04 10:10:38.828572 | TASK [add-build-sshkey : Add back temp key] 2025-02-04 10:10:39.189461 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/bb2a6624c87a4291a29ecfd28257b8db/work/bb2a6624c87a4291a29ecfd28257b8db_id_rsa (zuul-build-sshkey) 2025-02-04 10:10:39.189920 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.014632 2025-02-04 10:10:39.204303 | 2025-02-04 10:10:39.204441 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-02-04 10:10:39.671474 | ubuntu-noble | ok 2025-02-04 10:10:39.677679 | 2025-02-04 10:10:39.677799 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-02-04 10:10:39.701569 | ubuntu-noble | skipping: Conditional result was False 2025-02-04 10:10:39.715006 | 2025-02-04 10:10:39.715110 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-02-04 10:10:40.150260 | ubuntu-noble | ok 2025-02-04 10:10:40.168959 | 2025-02-04 10:10:40.169071 | TASK [validate-host : Define zuul_info_dir fact] 2025-02-04 10:10:40.209164 | ubuntu-noble | ok 2025-02-04 10:10:40.215366 | 2025-02-04 10:10:40.215453 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-02-04 10:10:40.491632 | ubuntu-noble -> localhost | ok 2025-02-04 10:10:40.514284 | 2025-02-04 10:10:40.514395 | TASK [validate-host : Collect information about the host] 2025-02-04 10:10:41.753955 | ubuntu-noble | ok 2025-02-04 10:10:41.766665 | 2025-02-04 10:10:41.766820 | TASK [validate-host : Sanitize hostname] 2025-02-04 10:10:41.840678 | ubuntu-noble | ok 2025-02-04 10:10:41.848230 | 2025-02-04 10:10:41.848357 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-02-04 10:10:42.467940 | ubuntu-noble -> localhost | changed 2025-02-04 10:10:42.483893 | 2025-02-04 10:10:42.484042 | TASK [validate-host : Collect information about zuul worker] 2025-02-04 10:10:42.978254 | ubuntu-noble | ok 2025-02-04 10:10:42.985041 | 2025-02-04 10:10:42.985165 | TASK [validate-host : Write out all zuul information for each host] 2025-02-04 10:10:43.657378 | ubuntu-noble -> localhost | changed 2025-02-04 10:10:43.670933 | 2025-02-04 10:10:43.671067 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-02-04 10:10:44.011910 | ubuntu-noble | ok 2025-02-04 10:10:44.030340 | 2025-02-04 10:10:44.030482 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-02-04 10:10:45.507732 | ubuntu-noble | changed: 2025-02-04 10:10:45.507938 | ubuntu-noble | cd+++++++++ src/ 2025-02-04 10:10:45.507972 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-02-04 10:10:45.507996 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-02-04 10:10:45.508018 | ubuntu-noble | cd+++++++++ src/github.com/osism/python-osism/ 2025-02-04 10:10:45.508039 | ubuntu-noble | Containerfile 2025-02-04 10:10:45.508150 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.007924 2025-02-04 10:11:19.771052 | 2025-02-04 10:11:19.771161 | TASK [upload-logs : Upload logs to log server] 2025-02-04 10:11:20.370196 | localhost | Output suppressed because no_log was given 2025-02-04 10:11:20.373745 | 2025-02-04 10:11:20.373849 | LOOP [upload-logs : Compress console log and json output] 2025-02-04 10:11:20.449995 | localhost | skipping: Conditional result was False 2025-02-04 10:11:20.468881 | localhost | skipping: Conditional result was False 2025-02-04 10:11:20.483441 | 2025-02-04 10:11:20.483567 | LOOP [upload-logs : Upload compressed console log and json output] 2025-02-04 10:11:20.558474 | localhost | skipping: Conditional result was False 2025-02-04 10:11:20.558834 | 2025-02-04 10:11:20.573874 | localhost | skipping: Conditional result was False 2025-02-04 10:11:20.588027 | 2025-02-04 10:11:20.588201 | LOOP [upload-logs : Upload console log and json output]