2025-03-09 14:37:36.206218 | Job console starting... 2025-03-09 14:37:36.234432 | Updating repositories 2025-03-09 14:37:36.333602 | Preparing job workspace 2025-03-09 14:37:39.175387 | Running Ansible setup... 2025-03-09 14:37:45.333472 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-03-09 14:37:46.213308 | 2025-03-09 14:37:46.213420 | PLAY [Base pre] 2025-03-09 14:37:46.285794 | 2025-03-09 14:37:46.285915 | TASK [Setup log path fact] 2025-03-09 14:37:46.341632 | ubuntu-noble | ok 2025-03-09 14:37:46.387399 | 2025-03-09 14:37:46.387519 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-09 14:37:46.458520 | ubuntu-noble | ok 2025-03-09 14:37:46.463796 | 2025-03-09 14:37:46.463873 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-09 14:37:46.527993 | ubuntu-noble | skipping: Conditional result was False 2025-03-09 14:37:46.533733 | 2025-03-09 14:37:46.533823 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-09 14:37:46.606373 | ubuntu-noble | skipping: Conditional result was False 2025-03-09 14:37:46.612958 | 2025-03-09 14:37:46.613050 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-09 14:37:46.653393 | ubuntu-noble | skipping: Conditional result was False 2025-03-09 14:37:46.659102 | 2025-03-09 14:37:46.659183 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-09 14:37:46.692409 | ubuntu-noble | skipping: Conditional result was False 2025-03-09 14:37:46.706292 | 2025-03-09 14:37:46.706405 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-09 14:37:46.749834 | ubuntu-noble | skipping: Conditional result was False 2025-03-09 14:37:46.774407 | 2025-03-09 14:37:46.774555 | TASK [emit-job-header : Print job information] 2025-03-09 14:37:46.825777 | # Job Information 2025-03-09 14:37:46.825931 | Ansible Version: 2.15.3 2025-03-09 14:37:46.825961 | Job: python-black 2025-03-09 14:37:46.825988 | Pipeline: check 2025-03-09 14:37:46.826008 | Executor: 7d211f194f6a 2025-03-09 14:37:46.826027 | Triggered by: https://github.com/osism/container-image-ceph-ansible/pull/565 2025-03-09 14:37:46.826044 | Event ID: 058b74e0-fcf4-11ef-8725-477c5b4a1e24 2025-03-09 14:37:46.832487 | 2025-03-09 14:37:46.832606 | LOOP [emit-job-header : Print node information] 2025-03-09 14:37:47.032315 | ubuntu-noble | ok: 2025-03-09 14:37:47.032555 | ubuntu-noble | # Node Information 2025-03-09 14:37:47.032593 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-03-09 14:37:47.032617 | ubuntu-noble | Hostname: ubuntu 2025-03-09 14:37:47.032640 | ubuntu-noble | Username: zuul 2025-03-09 14:37:47.032660 | ubuntu-noble | Distro: Ubuntu 24.04 2025-03-09 14:37:47.032680 | ubuntu-noble | Provider: regiocloud-a 2025-03-09 14:37:47.032701 | ubuntu-noble | Label: ubuntu-noble 2025-03-09 14:37:47.032721 | ubuntu-noble | Product Name: OpenStack Nova 2025-03-09 14:37:47.032742 | ubuntu-noble | Interface IP: 81.163.193.89 2025-03-09 14:37:47.046624 | 2025-03-09 14:37:47.046728 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-09 14:37:47.623386 | ubuntu-noble -> localhost | changed 2025-03-09 14:37:47.631516 | 2025-03-09 14:37:47.631641 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-09 14:37:49.026642 | ubuntu-noble -> localhost | changed 2025-03-09 14:37:49.055927 | 2025-03-09 14:37:49.057899 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-09 14:37:49.457170 | ubuntu-noble -> localhost | ok 2025-03-09 14:37:49.463119 | 2025-03-09 14:37:49.463203 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-09 14:37:49.491449 | ubuntu-noble | ok 2025-03-09 14:37:49.504622 | ubuntu-noble | included: /var/lib/zuul/builds/e41fcfa17465406a94b94ae88901a94c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-09 14:37:49.510734 | 2025-03-09 14:37:49.510816 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-09 14:37:50.216838 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-03-09 14:37:50.217028 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/e41fcfa17465406a94b94ae88901a94c/work/e41fcfa17465406a94b94ae88901a94c_id_rsa 2025-03-09 14:37:50.217061 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/e41fcfa17465406a94b94ae88901a94c/work/e41fcfa17465406a94b94ae88901a94c_id_rsa.pub 2025-03-09 14:37:50.217082 | ubuntu-noble -> localhost | The key fingerprint is: 2025-03-09 14:37:50.217102 | ubuntu-noble -> localhost | SHA256:rWMot4Egnv4Dbu3bVTRehrCXE+QufLjtkIkewtP12Jk zuul-build-sshkey 2025-03-09 14:37:50.217121 | ubuntu-noble -> localhost | The key's randomart image is: 2025-03-09 14:37:50.217142 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-03-09 14:37:50.217160 | ubuntu-noble -> localhost | | ..o | 2025-03-09 14:37:50.217176 | ubuntu-noble -> localhost | | + + | 2025-03-09 14:37:50.217192 | ubuntu-noble -> localhost | | . O o | 2025-03-09 14:37:50.217208 | ubuntu-noble -> localhost | | . *.= | 2025-03-09 14:37:50.217224 | ubuntu-noble -> localhost | |. . =S=. | 2025-03-09 14:37:50.217240 | ubuntu-noble -> localhost | |.oo...o.%.o | 2025-03-09 14:37:50.217255 | ubuntu-noble -> localhost | |.oo+o++B+E | 2025-03-09 14:37:50.217272 | ubuntu-noble -> localhost | |.o o=oo+o. | 2025-03-09 14:37:50.217288 | ubuntu-noble -> localhost | |..o+oo. . | 2025-03-09 14:37:50.217304 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-03-09 14:37:50.217340 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.143201 2025-03-09 14:37:50.235177 | 2025-03-09 14:37:50.235262 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-09 14:37:50.279852 | ubuntu-noble | ok 2025-03-09 14:37:50.303948 | ubuntu-noble | included: /var/lib/zuul/builds/e41fcfa17465406a94b94ae88901a94c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-09 14:37:50.317928 | 2025-03-09 14:37:50.318013 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-09 14:37:50.344539 | ubuntu-noble | skipping: Conditional result was False 2025-03-09 14:37:50.355227 | 2025-03-09 14:37:50.355312 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-09 14:37:51.291376 | ubuntu-noble | changed 2025-03-09 14:37:51.299699 | 2025-03-09 14:37:51.299791 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-09 14:37:51.633541 | ubuntu-noble | ok 2025-03-09 14:37:51.641982 | 2025-03-09 14:37:51.642081 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-09 14:37:52.461910 | ubuntu-noble | changed 2025-03-09 14:37:52.473250 | 2025-03-09 14:37:52.473348 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-09 14:37:53.238700 | ubuntu-noble | changed 2025-03-09 14:37:53.249827 | 2025-03-09 14:37:53.249934 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-09 14:37:53.278860 | ubuntu-noble | skipping: Conditional result was False 2025-03-09 14:37:53.286374 | 2025-03-09 14:37:53.286472 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-09 14:37:53.718229 | ubuntu-noble -> localhost | changed 2025-03-09 14:37:53.747747 | 2025-03-09 14:37:53.747852 | TASK [add-build-sshkey : Add back temp key] 2025-03-09 14:37:54.337413 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/e41fcfa17465406a94b94ae88901a94c/work/e41fcfa17465406a94b94ae88901a94c_id_rsa (zuul-build-sshkey) 2025-03-09 14:37:54.337636 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.008305 2025-03-09 14:37:54.345146 | 2025-03-09 14:37:54.345243 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-09 14:37:54.830108 | ubuntu-noble | ok 2025-03-09 14:37:54.838705 | 2025-03-09 14:37:54.838804 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-09 14:37:54.862662 | ubuntu-noble | skipping: Conditional result was False 2025-03-09 14:37:54.876990 | 2025-03-09 14:37:54.877085 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-09 14:37:55.333604 | ubuntu-noble | ok 2025-03-09 14:37:55.345975 | 2025-03-09 14:37:55.346064 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-09 14:37:55.378079 | ubuntu-noble | ok 2025-03-09 14:37:55.384515 | 2025-03-09 14:37:55.384630 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-09 14:37:55.751090 | ubuntu-noble -> localhost | ok 2025-03-09 14:37:55.764349 | 2025-03-09 14:37:55.764477 | TASK [validate-host : Collect information about the host] 2025-03-09 14:37:57.030244 | ubuntu-noble | ok 2025-03-09 14:37:57.053615 | 2025-03-09 14:37:57.053715 | TASK [validate-host : Sanitize hostname] 2025-03-09 14:37:57.112113 | ubuntu-noble | ok 2025-03-09 14:37:57.118022 | 2025-03-09 14:37:57.118110 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-09 14:37:57.809157 | ubuntu-noble -> localhost | changed 2025-03-09 14:37:57.815493 | 2025-03-09 14:37:57.815592 | TASK [validate-host : Collect information about zuul worker] 2025-03-09 14:37:58.434652 | ubuntu-noble | ok 2025-03-09 14:37:58.439555 | 2025-03-09 14:37:58.439634 | TASK [validate-host : Write out all zuul information for each host] 2025-03-09 14:37:59.130078 | ubuntu-noble -> localhost | changed 2025-03-09 14:37:59.144478 | 2025-03-09 14:37:59.144615 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-09 14:37:59.568958 | ubuntu-noble | ok 2025-03-09 14:37:59.574799 | 2025-03-09 14:37:59.574883 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-09 14:38:00.449744 | ubuntu-noble | changed: 2025-03-09 14:38:00.449904 | ubuntu-noble | cd+++++++++ src/ 2025-03-09 14:38:00.449936 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-03-09 14:38:00.449960 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-03-09 14:38:00.449981 | ubuntu-noble | cd+++++++++ src/github.com/osism/container-image-ceph-ansible/ 2025-03-09 14:38:00.450001 | ubuntu-noble | Containerfile 2025-03-09 14:38:00.450147 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.005908 2025-03-09 14:38:37.368579 | 2025-03-09 14:38:37.368725 | TASK [upload-logs : Upload logs to log server] 2025-03-09 14:38:37.887018 | localhost | Output suppressed because no_log was given 2025-03-09 14:38:37.890766 | 2025-03-09 14:38:37.890867 | LOOP [upload-logs : Compress console log and json output] 2025-03-09 14:38:37.959242 | localhost | skipping: Conditional result was False 2025-03-09 14:38:37.976349 | localhost | skipping: Conditional result was False 2025-03-09 14:38:37.985597 | 2025-03-09 14:38:37.985868 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-09 14:38:38.042907 | localhost | skipping: Conditional result was False 2025-03-09 14:38:38.043567 | 2025-03-09 14:38:38.054802 | localhost | skipping: Conditional result was False 2025-03-09 14:38:38.064652 | 2025-03-09 14:38:38.064818 | LOOP [upload-logs : Upload console log and json output]