2025-04-21 22:59:52.471453 | Job console starting... 2025-04-21 22:59:52.505495 | Updating repositories 2025-04-21 22:59:52.611425 | Preparing job workspace 2025-04-21 22:59:54.970217 | Running Ansible setup... 2025-04-21 23:00:01.871784 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-04-21 23:00:03.186481 | 2025-04-21 23:00:03.186606 | PLAY [Base pre] 2025-04-21 23:00:03.244747 | 2025-04-21 23:00:03.244892 | TASK [Setup log path fact] 2025-04-21 23:00:03.299112 | ubuntu-noble | ok 2025-04-21 23:00:03.334794 | 2025-04-21 23:00:03.334929 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-04-21 23:00:03.407848 | ubuntu-noble | ok 2025-04-21 23:00:03.436518 | 2025-04-21 23:00:03.436635 | TASK [emit-job-header : Print job information] 2025-04-21 23:00:03.578265 | # Job Information 2025-04-21 23:00:03.578429 | Ansible Version: 2.15.3 2025-04-21 23:00:03.578462 | Job: python-black 2025-04-21 23:00:03.578493 | Pipeline: check 2025-04-21 23:00:03.578514 | Executor: 7d211f194f6a 2025-04-21 23:00:03.578533 | Triggered by: https://github.com/osism/python-osism/pull/1293 2025-04-21 23:00:03.578550 | Event ID: 4fbd4660-1f04-11f0-8265-390392a4d015 2025-04-21 23:00:03.601228 | 2025-04-21 23:00:03.601355 | LOOP [emit-job-header : Print node information] 2025-04-21 23:00:03.937836 | ubuntu-noble | ok: 2025-04-21 23:00:03.937981 | ubuntu-noble | # Node Information 2025-04-21 23:00:03.938008 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-04-21 23:00:03.938028 | ubuntu-noble | Hostname: ubuntu 2025-04-21 23:00:03.938045 | ubuntu-noble | Username: zuul 2025-04-21 23:00:03.938062 | ubuntu-noble | Distro: Ubuntu 24.04 2025-04-21 23:00:03.938082 | ubuntu-noble | Provider: regiocloud-a 2025-04-21 23:00:03.938098 | ubuntu-noble | Label: ubuntu-noble 2025-04-21 23:00:03.938115 | ubuntu-noble | Product Name: OpenStack Nova 2025-04-21 23:00:03.938131 | ubuntu-noble | Interface IP: 81.163.192.44 2025-04-21 23:00:03.952298 | 2025-04-21 23:00:03.964476 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-04-21 23:00:04.906995 | ubuntu-noble -> localhost | changed 2025-04-21 23:00:04.914916 | 2025-04-21 23:00:04.915022 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-04-21 23:00:06.700230 | ubuntu-noble -> localhost | changed 2025-04-21 23:00:06.711745 | 2025-04-21 23:00:06.711851 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-04-21 23:00:07.298972 | ubuntu-noble -> localhost | ok 2025-04-21 23:00:07.305141 | 2025-04-21 23:00:07.305234 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-04-21 23:00:07.368355 | ubuntu-noble | ok 2025-04-21 23:00:07.400030 | ubuntu-noble | included: /var/lib/zuul/builds/d35fefa9d23b41c99dea1b00a32291a2/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-04-21 23:00:07.440015 | 2025-04-21 23:00:07.440144 | TASK [add-build-sshkey : Create Temp SSH key] 2025-04-21 23:00:09.227294 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-04-21 23:00:09.227476 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/d35fefa9d23b41c99dea1b00a32291a2/work/d35fefa9d23b41c99dea1b00a32291a2_id_rsa 2025-04-21 23:00:09.227508 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/d35fefa9d23b41c99dea1b00a32291a2/work/d35fefa9d23b41c99dea1b00a32291a2_id_rsa.pub 2025-04-21 23:00:09.227528 | ubuntu-noble -> localhost | The key fingerprint is: 2025-04-21 23:00:09.227547 | ubuntu-noble -> localhost | SHA256:jmhLzMOQDRcpmdraIkEZKbzTUXK+D2NK8dPYuht+Yas zuul-build-sshkey 2025-04-21 23:00:09.227564 | ubuntu-noble -> localhost | The key's randomart image is: 2025-04-21 23:00:09.227580 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-04-21 23:00:09.227597 | ubuntu-noble -> localhost | |..++o+ | 2025-04-21 23:00:09.227612 | ubuntu-noble -> localhost | |.=+.=. | 2025-04-21 23:00:09.227628 | ubuntu-noble -> localhost | |oo+oo. | 2025-04-21 23:00:09.227651 | ubuntu-noble -> localhost | |oo.*o = | 2025-04-21 23:00:09.227667 | ubuntu-noble -> localhost | | ++..O oS | 2025-04-21 23:00:09.227682 | ubuntu-noble -> localhost | |+ o=o.*= | 2025-04-21 23:00:09.227701 | ubuntu-noble -> localhost | |.. .Ooo.+ | 2025-04-21 23:00:09.227717 | ubuntu-noble -> localhost | | o.ooo | 2025-04-21 23:00:09.227733 | ubuntu-noble -> localhost | | .E+ | 2025-04-21 23:00:09.227749 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-04-21 23:00:09.227804 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.612318 2025-04-21 23:00:09.234223 | 2025-04-21 23:00:09.234309 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-04-21 23:00:09.295217 | ubuntu-noble | ok 2025-04-21 23:00:09.304286 | ubuntu-noble | included: /var/lib/zuul/builds/d35fefa9d23b41c99dea1b00a32291a2/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-04-21 23:00:09.327301 | 2025-04-21 23:00:09.327393 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-04-21 23:00:09.356468 | ubuntu-noble | skipping: Conditional result was False 2025-04-21 23:00:09.362399 | 2025-04-21 23:00:09.362479 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-04-21 23:00:10.085134 | ubuntu-noble | changed 2025-04-21 23:00:10.092703 | 2025-04-21 23:00:10.092816 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-04-21 23:00:10.380317 | ubuntu-noble | ok 2025-04-21 23:00:10.397823 | 2025-04-21 23:00:10.397937 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-04-21 23:00:11.091456 | ubuntu-noble | changed 2025-04-21 23:00:11.097382 | 2025-04-21 23:00:11.097467 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-04-21 23:00:11.870369 | ubuntu-noble | changed 2025-04-21 23:00:11.879507 | 2025-04-21 23:00:11.879602 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-04-21 23:00:11.919035 | ubuntu-noble | skipping: Conditional result was False 2025-04-21 23:00:11.925302 | 2025-04-21 23:00:11.925389 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-04-21 23:00:12.904624 | ubuntu-noble -> localhost | changed 2025-04-21 23:00:12.929800 | 2025-04-21 23:00:12.929904 | TASK [add-build-sshkey : Add back temp key] 2025-04-21 23:00:13.571585 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/d35fefa9d23b41c99dea1b00a32291a2/work/d35fefa9d23b41c99dea1b00a32291a2_id_rsa (zuul-build-sshkey) 2025-04-21 23:00:13.571748 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.009845 2025-04-21 23:00:13.616952 | 2025-04-21 23:00:13.617037 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-04-21 23:00:14.013918 | ubuntu-noble | ok 2025-04-21 23:00:14.019610 | 2025-04-21 23:00:14.019698 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-04-21 23:00:14.043215 | ubuntu-noble | skipping: Conditional result was False 2025-04-21 23:00:14.054215 | 2025-04-21 23:00:14.054293 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-04-21 23:00:14.458301 | ubuntu-noble | ok 2025-04-21 23:00:14.476091 | 2025-04-21 23:00:14.476188 | TASK [validate-host : Define zuul_info_dir fact] 2025-04-21 23:00:14.521243 | ubuntu-noble | ok 2025-04-21 23:00:14.526511 | 2025-04-21 23:00:14.526597 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-04-21 23:00:14.899982 | ubuntu-noble -> localhost | ok 2025-04-21 23:00:14.911524 | 2025-04-21 23:00:14.911642 | TASK [validate-host : Collect information about the host] 2025-04-21 23:00:16.035946 | ubuntu-noble | ok 2025-04-21 23:00:16.058571 | 2025-04-21 23:00:16.058679 | TASK [validate-host : Sanitize hostname] 2025-04-21 23:00:16.202425 | ubuntu-noble | ok 2025-04-21 23:00:16.208446 | 2025-04-21 23:00:16.208542 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-04-21 23:00:17.367369 | ubuntu-noble -> localhost | changed 2025-04-21 23:00:17.375180 | 2025-04-21 23:00:17.375290 | TASK [validate-host : Collect information about zuul worker] 2025-04-21 23:00:17.986143 | ubuntu-noble | ok 2025-04-21 23:00:17.992287 | 2025-04-21 23:00:17.992406 | TASK [validate-host : Write out all zuul information for each host] 2025-04-21 23:00:19.003496 | ubuntu-noble -> localhost | changed 2025-04-21 23:00:19.015853 | 2025-04-21 23:00:19.015957 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-04-21 23:00:19.400828 | ubuntu-noble | ok 2025-04-21 23:00:19.408082 | 2025-04-21 23:00:19.408179 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-04-21 23:00:20.775274 | ubuntu-noble | changed: 2025-04-21 23:00:20.775422 | ubuntu-noble | cd+++++++++ src/ 2025-04-21 23:00:20.775451 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-04-21 23:00:20.775472 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-04-21 23:00:20.775489 | ubuntu-noble | cd+++++++++ src/github.com/osism/python-osism/ 2025-04-21 23:00:20.775506 | ubuntu-noble | Containerfile 2025-04-21 23:00:20.775599 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.004325 2025-04-21 23:00:51.670480 | 2025-04-21 23:00:51.670597 | TASK [upload-logs : Upload logs to log server] 2025-04-21 23:00:52.269005 | localhost | Output suppressed because no_log was given 2025-04-21 23:00:52.273830 | 2025-04-21 23:00:52.273952 | LOOP [upload-logs : Compress console log and json output] 2025-04-21 23:00:52.361294 | localhost | skipping: Conditional result was False 2025-04-21 23:00:52.372205 | localhost | skipping: Conditional result was False 2025-04-21 23:00:52.384065 | 2025-04-21 23:00:52.384191 | LOOP [upload-logs : Upload compressed console log and json output] 2025-04-21 23:00:52.449731 | localhost | skipping: Conditional result was False 2025-04-21 23:00:52.450060 | 2025-04-21 23:00:52.465089 | localhost | skipping: Conditional result was False 2025-04-21 23:00:52.474712 | 2025-04-21 23:00:52.474992 | LOOP [upload-logs : Upload console log and json output]