2025-04-20 03:14:30.157327 | Job console starting... 2025-04-20 03:14:30.177644 | Updating repositories 2025-04-20 03:14:30.222528 | Preparing job workspace 2025-04-20 03:14:32.231353 | Running Ansible setup... 2025-04-20 03:14:38.511185 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-04-20 03:14:39.438992 | 2025-04-20 03:14:39.439856 | PLAY [Base pre] 2025-04-20 03:14:39.517666 | 2025-04-20 03:14:39.517969 | TASK [Setup log path fact] 2025-04-20 03:14:39.571513 | ubuntu-noble | ok 2025-04-20 03:14:39.600530 | 2025-04-20 03:14:39.600643 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-04-20 03:14:39.643214 | ubuntu-noble | ok 2025-04-20 03:14:39.660277 | 2025-04-20 03:14:39.661492 | TASK [emit-job-header : Print job information] 2025-04-20 03:14:39.715564 | # Job Information 2025-04-20 03:14:39.715702 | Ansible Version: 2.15.3 2025-04-20 03:14:39.715730 | Job: python-black 2025-04-20 03:14:39.715755 | Pipeline: periodic-daily 2025-04-20 03:14:39.715773 | Executor: 7d211f194f6a 2025-04-20 03:14:39.715789 | Triggered by: https://github.com/osism/testbed 2025-04-20 03:14:39.715805 | Event ID: 3a2fd617f20e45e3acfd4c374505d13b 2025-04-20 03:14:39.722659 | 2025-04-20 03:14:39.722754 | LOOP [emit-job-header : Print node information] 2025-04-20 03:14:39.972067 | ubuntu-noble | ok: 2025-04-20 03:14:39.972234 | ubuntu-noble | # Node Information 2025-04-20 03:14:39.972267 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-04-20 03:14:39.972292 | ubuntu-noble | Hostname: ubuntu 2025-04-20 03:14:39.972315 | ubuntu-noble | Username: zuul 2025-04-20 03:14:39.972335 | ubuntu-noble | Distro: Ubuntu 24.04 2025-04-20 03:14:39.972358 | ubuntu-noble | Provider: regiocloud-a 2025-04-20 03:14:39.972379 | ubuntu-noble | Label: ubuntu-noble 2025-04-20 03:14:39.972433 | ubuntu-noble | Product Name: OpenStack Nova 2025-04-20 03:14:39.972454 | ubuntu-noble | Interface IP: 81.163.193.117 2025-04-20 03:14:40.016352 | 2025-04-20 03:14:40.016634 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-04-20 03:14:41.022197 | ubuntu-noble -> localhost | changed 2025-04-20 03:14:41.031783 | 2025-04-20 03:14:41.031867 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-04-20 03:14:42.837497 | ubuntu-noble -> localhost | changed 2025-04-20 03:14:42.862322 | 2025-04-20 03:14:42.862416 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-04-20 03:14:43.161308 | ubuntu-noble -> localhost | ok 2025-04-20 03:14:43.174569 | 2025-04-20 03:14:43.174711 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-04-20 03:14:43.204620 | ubuntu-noble | ok 2025-04-20 03:14:43.219063 | ubuntu-noble | included: /var/lib/zuul/builds/b6e9519345734308b98c62e5d1ec725a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-04-20 03:14:43.227433 | 2025-04-20 03:14:43.227511 | TASK [add-build-sshkey : Create Temp SSH key] 2025-04-20 03:14:43.829864 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-04-20 03:14:43.830155 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/b6e9519345734308b98c62e5d1ec725a/work/b6e9519345734308b98c62e5d1ec725a_id_rsa 2025-04-20 03:14:43.830199 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/b6e9519345734308b98c62e5d1ec725a/work/b6e9519345734308b98c62e5d1ec725a_id_rsa.pub 2025-04-20 03:14:43.830220 | ubuntu-noble -> localhost | The key fingerprint is: 2025-04-20 03:14:43.830240 | ubuntu-noble -> localhost | SHA256:1SZ2jc4cnd+5gq2d44xg2tYnoEgIm/8ZzJTJ7AUoe2w zuul-build-sshkey 2025-04-20 03:14:43.830258 | ubuntu-noble -> localhost | The key's randomart image is: 2025-04-20 03:14:43.830275 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-04-20 03:14:43.830292 | ubuntu-noble -> localhost | | | 2025-04-20 03:14:43.830308 | ubuntu-noble -> localhost | | . . + . | 2025-04-20 03:14:43.830324 | ubuntu-noble -> localhost | | . . . + * + | 2025-04-20 03:14:43.830347 | ubuntu-noble -> localhost | | .+ o + o B . .o| 2025-04-20 03:14:43.830364 | ubuntu-noble -> localhost | | .+E.* .S + .o| 2025-04-20 03:14:43.830380 | ubuntu-noble -> localhost | | oo.=.. . o .| 2025-04-20 03:14:43.830401 | ubuntu-noble -> localhost | | . .=. .oo. o . | 2025-04-20 03:14:43.830419 | ubuntu-noble -> localhost | | . .o.+..o=oo | 2025-04-20 03:14:43.830436 | ubuntu-noble -> localhost | | .o ... o+=. | 2025-04-20 03:14:43.830452 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-04-20 03:14:43.830497 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.142761 2025-04-20 03:14:43.840966 | 2025-04-20 03:14:43.841047 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-04-20 03:14:43.869636 | ubuntu-noble | ok 2025-04-20 03:14:43.878858 | ubuntu-noble | included: /var/lib/zuul/builds/b6e9519345734308b98c62e5d1ec725a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-04-20 03:14:43.887237 | 2025-04-20 03:14:43.887318 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-04-20 03:14:43.911549 | ubuntu-noble | skipping: Conditional result was False 2025-04-20 03:14:43.918341 | 2025-04-20 03:14:43.918418 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-04-20 03:14:44.592361 | ubuntu-noble | changed 2025-04-20 03:14:44.603988 | 2025-04-20 03:14:44.604079 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-04-20 03:14:44.931579 | ubuntu-noble | ok 2025-04-20 03:14:44.942138 | 2025-04-20 03:14:44.942257 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-04-20 03:14:45.683124 | ubuntu-noble | changed 2025-04-20 03:14:45.689985 | 2025-04-20 03:14:45.690080 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-04-20 03:14:46.429371 | ubuntu-noble | changed 2025-04-20 03:14:46.436837 | 2025-04-20 03:14:46.436935 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-04-20 03:14:46.484952 | ubuntu-noble | skipping: Conditional result was False 2025-04-20 03:14:46.497697 | 2025-04-20 03:14:46.498017 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-04-20 03:14:47.132225 | ubuntu-noble -> localhost | changed 2025-04-20 03:14:47.143616 | 2025-04-20 03:14:47.143702 | TASK [add-build-sshkey : Add back temp key] 2025-04-20 03:14:47.709240 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/b6e9519345734308b98c62e5d1ec725a/work/b6e9519345734308b98c62e5d1ec725a_id_rsa (zuul-build-sshkey) 2025-04-20 03:14:47.709411 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.012040 2025-04-20 03:14:47.715742 | 2025-04-20 03:14:47.715827 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-04-20 03:14:48.300162 | ubuntu-noble | ok 2025-04-20 03:14:48.306319 | 2025-04-20 03:14:48.306400 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-04-20 03:14:48.330106 | ubuntu-noble | skipping: Conditional result was False 2025-04-20 03:14:48.364333 | 2025-04-20 03:14:48.364451 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-04-20 03:14:48.761527 | ubuntu-noble | ok 2025-04-20 03:14:48.775424 | 2025-04-20 03:14:48.775511 | TASK [validate-host : Define zuul_info_dir fact] 2025-04-20 03:14:48.804122 | ubuntu-noble | ok 2025-04-20 03:14:48.813876 | 2025-04-20 03:14:48.813974 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-04-20 03:14:49.305551 | ubuntu-noble -> localhost | ok 2025-04-20 03:14:49.311695 | 2025-04-20 03:14:49.311774 | TASK [validate-host : Collect information about the host] 2025-04-20 03:14:50.639824 | ubuntu-noble | ok 2025-04-20 03:14:50.655977 | 2025-04-20 03:14:50.656076 | TASK [validate-host : Sanitize hostname] 2025-04-20 03:14:50.847861 | ubuntu-noble | ok 2025-04-20 03:14:50.866034 | 2025-04-20 03:14:50.866125 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-04-20 03:14:51.954561 | ubuntu-noble -> localhost | changed 2025-04-20 03:14:51.960177 | 2025-04-20 03:14:51.960266 | TASK [validate-host : Collect information about zuul worker] 2025-04-20 03:14:52.472417 | ubuntu-noble | ok 2025-04-20 03:14:52.477242 | 2025-04-20 03:14:52.477316 | TASK [validate-host : Write out all zuul information for each host] 2025-04-20 03:14:53.190017 | ubuntu-noble -> localhost | changed 2025-04-20 03:14:53.207406 | 2025-04-20 03:14:53.207497 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-04-20 03:14:53.532870 | ubuntu-noble | ok 2025-04-20 03:14:53.538575 | 2025-04-20 03:14:53.538653 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-04-20 03:14:54.879630 | ubuntu-noble | changed: 2025-04-20 03:14:54.879769 | ubuntu-noble | cd+++++++++ src/ 2025-04-20 03:14:54.879798 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-04-20 03:14:54.879819 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-04-20 03:14:54.879837 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-04-20 03:14:54.879853 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.023034 2025-04-20 03:15:29.428184 | 2025-04-20 03:15:29.428270 | TASK [upload-logs : Upload logs to log server] 2025-04-20 03:15:30.189134 | localhost | Output suppressed because no_log was given 2025-04-20 03:15:30.191516 | 2025-04-20 03:15:30.191594 | LOOP [upload-logs : Compress console log and json output] 2025-04-20 03:15:30.336910 | localhost | skipping: Conditional result was False 2025-04-20 03:15:30.361784 | localhost | skipping: Conditional result was False 2025-04-20 03:15:30.371650 | 2025-04-20 03:15:30.371744 | LOOP [upload-logs : Upload compressed console log and json output] 2025-04-20 03:15:30.451609 | localhost | skipping: Conditional result was False 2025-04-20 03:15:30.451893 | 2025-04-20 03:15:30.457069 | localhost | skipping: Conditional result was False 2025-04-20 03:15:30.460640 | 2025-04-20 03:15:30.460721 | LOOP [upload-logs : Upload console log and json output]