2025-05-13 18:44:52.300923 | Job console starting 2025-05-13 18:44:52.321831 | Updating git repos 2025-05-13 18:44:52.359348 | Cloning repos into workspace 2025-05-13 18:44:52.403568 | Restoring repo states 2025-05-13 18:44:52.409639 | Merging changes 2025-05-13 18:44:52.918595 | Checking out repos 2025-05-13 18:44:52.985921 | Preparing playbooks 2025-05-13 18:44:54.256032 | Running Ansible setup 2025-05-13 18:45:00.772664 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-13 18:45:01.730674 | 2025-05-13 18:45:01.730807 | PLAY [Base pre] 2025-05-13 18:45:01.746368 | 2025-05-13 18:45:01.746487 | TASK [Setup log path fact] 2025-05-13 18:45:01.785193 | ubuntu-noble | ok 2025-05-13 18:45:01.812856 | 2025-05-13 18:45:01.812991 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-13 18:45:01.875585 | ubuntu-noble | ok 2025-05-13 18:45:01.893472 | 2025-05-13 18:45:01.894009 | TASK [emit-job-header : Print job information] 2025-05-13 18:45:01.953796 | # Job Information 2025-05-13 18:45:01.953961 | Ansible Version: 2.16.14 2025-05-13 18:45:01.953995 | Job: python-black 2025-05-13 18:45:01.954028 | Pipeline: check 2025-05-13 18:45:01.954050 | Executor: 521e9411259a 2025-05-13 18:45:01.954069 | Triggered by: https://github.com/osism/testbed/pull/2682 2025-05-13 18:45:01.954155 | Event ID: 567bf7d0-302a-11f0-8b28-c5154bc13020 2025-05-13 18:45:01.958750 | 2025-05-13 18:45:01.958859 | LOOP [emit-job-header : Print node information] 2025-05-13 18:45:02.074105 | ubuntu-noble | ok: 2025-05-13 18:45:02.074395 | ubuntu-noble | # Node Information 2025-05-13 18:45:02.074435 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-05-13 18:45:02.074460 | ubuntu-noble | Hostname: ubuntu 2025-05-13 18:45:02.074482 | ubuntu-noble | Username: zuul 2025-05-13 18:45:02.074502 | ubuntu-noble | Distro: Ubuntu 24.04 2025-05-13 18:45:02.074525 | ubuntu-noble | Provider: regiocloud-a 2025-05-13 18:45:02.074546 | ubuntu-noble | Region: 2025-05-13 18:45:02.074568 | ubuntu-noble | Label: ubuntu-noble 2025-05-13 18:45:02.074587 | ubuntu-noble | Product Name: OpenStack Nova 2025-05-13 18:45:02.074606 | ubuntu-noble | Interface IP: 81.163.192.108 2025-05-13 18:45:02.095971 | 2025-05-13 18:45:02.096096 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-13 18:45:02.921519 | ubuntu-noble -> localhost | changed 2025-05-13 18:45:02.929463 | 2025-05-13 18:45:02.929594 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-13 18:45:04.028674 | ubuntu-noble -> localhost | changed 2025-05-13 18:45:04.044564 | 2025-05-13 18:45:04.044721 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-13 18:45:04.409427 | ubuntu-noble -> localhost | ok 2025-05-13 18:45:04.416550 | 2025-05-13 18:45:04.416705 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-13 18:45:04.466302 | ubuntu-noble | ok 2025-05-13 18:45:04.487915 | ubuntu-noble | included: /var/lib/zuul/builds/f702b23242bc498889fb5f1089aefd43/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-13 18:45:04.496817 | 2025-05-13 18:45:04.496963 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-13 18:45:05.588355 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-05-13 18:45:05.588599 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/f702b23242bc498889fb5f1089aefd43/work/f702b23242bc498889fb5f1089aefd43_id_rsa 2025-05-13 18:45:05.588639 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/f702b23242bc498889fb5f1089aefd43/work/f702b23242bc498889fb5f1089aefd43_id_rsa.pub 2025-05-13 18:45:05.588667 | ubuntu-noble -> localhost | The key fingerprint is: 2025-05-13 18:45:05.588691 | ubuntu-noble -> localhost | SHA256:01HoVpept3M6sxbl45YNFrVunIDy3fdjACwU0nglFlI zuul-build-sshkey 2025-05-13 18:45:05.588715 | ubuntu-noble -> localhost | The key's randomart image is: 2025-05-13 18:45:05.588736 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-05-13 18:45:05.588772 | ubuntu-noble -> localhost | | o+E+o. o | 2025-05-13 18:45:05.588796 | ubuntu-noble -> localhost | | .++o.. + .| 2025-05-13 18:45:05.588818 | ubuntu-noble -> localhost | | o.o..o ..| 2025-05-13 18:45:05.588837 | ubuntu-noble -> localhost | | +o=..o..| 2025-05-13 18:45:05.588857 | ubuntu-noble -> localhost | | S.= o.==.| 2025-05-13 18:45:05.588881 | ubuntu-noble -> localhost | | . . o*B+| 2025-05-13 18:45:05.588901 | ubuntu-noble -> localhost | | .+**| 2025-05-13 18:45:05.588921 | ubuntu-noble -> localhost | | =*o| 2025-05-13 18:45:05.588941 | ubuntu-noble -> localhost | | .++.| 2025-05-13 18:45:05.588961 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-05-13 18:45:05.589020 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.580930 2025-05-13 18:45:05.595781 | 2025-05-13 18:45:05.595901 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-13 18:45:05.630467 | ubuntu-noble | ok 2025-05-13 18:45:05.640066 | ubuntu-noble | included: /var/lib/zuul/builds/f702b23242bc498889fb5f1089aefd43/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-13 18:45:05.648594 | 2025-05-13 18:45:05.648698 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-13 18:45:05.672572 | ubuntu-noble | skipping: Conditional result was False 2025-05-13 18:45:05.678650 | 2025-05-13 18:45:05.678761 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-13 18:45:06.377143 | ubuntu-noble | changed 2025-05-13 18:45:06.383995 | 2025-05-13 18:45:06.384117 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-13 18:45:06.713213 | ubuntu-noble | ok 2025-05-13 18:45:06.718861 | 2025-05-13 18:45:06.718974 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-13 18:45:07.455919 | ubuntu-noble | changed 2025-05-13 18:45:07.463805 | 2025-05-13 18:45:07.463966 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-13 18:45:08.207283 | ubuntu-noble | changed 2025-05-13 18:45:08.217820 | 2025-05-13 18:45:08.217966 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-13 18:45:08.253451 | ubuntu-noble | skipping: Conditional result was False 2025-05-13 18:45:08.268197 | 2025-05-13 18:45:08.268438 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-13 18:45:08.774349 | ubuntu-noble -> localhost | changed 2025-05-13 18:45:08.786759 | 2025-05-13 18:45:08.787000 | TASK [add-build-sshkey : Add back temp key] 2025-05-13 18:45:09.136508 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/f702b23242bc498889fb5f1089aefd43/work/f702b23242bc498889fb5f1089aefd43_id_rsa (zuul-build-sshkey) 2025-05-13 18:45:09.137070 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.020042 2025-05-13 18:45:09.154959 | 2025-05-13 18:45:09.155161 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-13 18:45:09.615783 | ubuntu-noble | ok 2025-05-13 18:45:09.640579 | 2025-05-13 18:45:09.640719 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-13 18:45:09.665070 | ubuntu-noble | skipping: Conditional result was False 2025-05-13 18:45:09.678617 | 2025-05-13 18:45:09.678773 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-13 18:45:10.146598 | ubuntu-noble | ok 2025-05-13 18:45:10.167961 | 2025-05-13 18:45:10.168108 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-13 18:45:10.198019 | ubuntu-noble | ok 2025-05-13 18:45:10.203481 | 2025-05-13 18:45:10.203613 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-13 18:45:10.545766 | ubuntu-noble -> localhost | ok 2025-05-13 18:45:10.554536 | 2025-05-13 18:45:10.554694 | TASK [validate-host : Collect information about the host] 2025-05-13 18:45:11.795630 | ubuntu-noble | ok 2025-05-13 18:45:11.806473 | 2025-05-13 18:45:11.806626 | TASK [validate-host : Sanitize hostname] 2025-05-13 18:45:11.888841 | ubuntu-noble | ok 2025-05-13 18:45:11.906024 | 2025-05-13 18:45:11.906222 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-13 18:45:12.547776 | ubuntu-noble -> localhost | changed 2025-05-13 18:45:12.565392 | 2025-05-13 18:45:12.565656 | TASK [validate-host : Collect information about zuul worker] 2025-05-13 18:45:13.064453 | ubuntu-noble | ok 2025-05-13 18:45:13.069517 | 2025-05-13 18:45:13.069634 | TASK [validate-host : Write out all zuul information for each host] 2025-05-13 18:45:13.685805 | ubuntu-noble -> localhost | changed 2025-05-13 18:45:13.736391 | 2025-05-13 18:45:13.736532 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-13 18:45:14.038795 | ubuntu-noble | ok 2025-05-13 18:45:14.044726 | 2025-05-13 18:45:14.044843 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-13 18:45:15.181944 | ubuntu-noble | changed: 2025-05-13 18:45:15.182513 | ubuntu-noble | cd+++++++++ src/ 2025-05-13 18:45:15.183008 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-05-13 18:45:15.183137 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-05-13 18:45:15.183206 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-05-13 18:45:15.183266 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.007177 2025-05-13 18:46:12.853223 | 2025-05-13 18:46:12.853510 | TASK [upload-logs : Upload logs to log server] 2025-05-13 18:46:13.462646 | localhost | Output suppressed because no_log was given 2025-05-13 18:46:13.466785 | 2025-05-13 18:46:13.466994 | LOOP [upload-logs : Compress console log and json output] 2025-05-13 18:46:13.527256 | localhost | skipping: Conditional result was False 2025-05-13 18:46:13.532245 | localhost | skipping: Conditional result was False 2025-05-13 18:46:13.539192 | 2025-05-13 18:46:13.539409 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-13 18:46:13.592828 | localhost | skipping: Conditional result was False 2025-05-13 18:46:13.593581 | 2025-05-13 18:46:13.596836 | localhost | skipping: Conditional result was False 2025-05-13 18:46:13.611169 | 2025-05-13 18:46:13.611469 | LOOP [upload-logs : Upload console log and json output]