2025-03-19 22:57:42.699884 | Job console starting... 2025-03-19 22:57:42.721840 | Updating repositories 2025-03-19 22:57:42.764697 | Preparing job workspace 2025-03-19 22:57:44.721590 | Running Ansible setup... 2025-03-19 22:57:49.770324 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-03-19 22:57:50.598543 | 2025-03-19 22:57:50.598712 | PLAY [Base pre] 2025-03-19 22:57:50.628370 | 2025-03-19 22:57:50.628575 | TASK [Setup log path fact] 2025-03-19 22:57:50.680855 | ubuntu-noble | ok 2025-03-19 22:57:50.731482 | 2025-03-19 22:57:50.731663 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-19 22:57:50.824323 | ubuntu-noble | ok 2025-03-19 22:57:50.835859 | 2025-03-19 22:57:50.835990 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-19 22:57:50.930410 | ubuntu-noble | skipping: Conditional result was False 2025-03-19 22:57:50.937998 | 2025-03-19 22:57:50.938142 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-19 22:57:50.993941 | ubuntu-noble | skipping: Conditional result was False 2025-03-19 22:57:51.002701 | 2025-03-19 22:57:51.002887 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-19 22:57:51.040684 | ubuntu-noble | skipping: Conditional result was False 2025-03-19 22:57:51.048330 | 2025-03-19 22:57:51.048506 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-19 22:57:51.083598 | ubuntu-noble | skipping: Conditional result was False 2025-03-19 22:57:51.091393 | 2025-03-19 22:57:51.091534 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-19 22:57:51.116455 | ubuntu-noble | skipping: Conditional result was False 2025-03-19 22:57:51.132235 | 2025-03-19 22:57:51.132370 | TASK [emit-job-header : Print job information] 2025-03-19 22:57:51.185200 | # Job Information 2025-03-19 22:57:51.185380 | Ansible Version: 2.15.3 2025-03-19 22:57:51.185412 | Job: ansible-lint 2025-03-19 22:57:51.185439 | Pipeline: check 2025-03-19 22:57:51.185459 | Executor: 7d211f194f6a 2025-03-19 22:57:51.185479 | Triggered by: https://github.com/osism/testbed/pull/2615 2025-03-19 22:57:51.185497 | Event ID: 8bee7cc0-0515-11f0-9eae-0ab3159231d7 2025-03-19 22:57:51.193008 | 2025-03-19 22:57:51.193136 | LOOP [emit-job-header : Print node information] 2025-03-19 22:57:51.348278 | ubuntu-noble | ok: 2025-03-19 22:57:51.348760 | ubuntu-noble | # Node Information 2025-03-19 22:57:51.348816 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-03-19 22:57:51.348846 | ubuntu-noble | Hostname: ubuntu 2025-03-19 22:57:51.348868 | ubuntu-noble | Username: zuul 2025-03-19 22:57:51.348887 | ubuntu-noble | Distro: Ubuntu 24.04 2025-03-19 22:57:51.348907 | ubuntu-noble | Provider: regiocloud-a 2025-03-19 22:57:51.348925 | ubuntu-noble | Label: ubuntu-noble 2025-03-19 22:57:51.348945 | ubuntu-noble | Product Name: OpenStack Nova 2025-03-19 22:57:51.348965 | ubuntu-noble | Interface IP: 81.163.193.143 2025-03-19 22:57:51.371870 | 2025-03-19 22:57:51.372013 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-19 22:57:51.912206 | ubuntu-noble -> localhost | changed 2025-03-19 22:57:51.931993 | 2025-03-19 22:57:51.932150 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-19 22:57:53.145607 | ubuntu-noble -> localhost | changed 2025-03-19 22:57:53.160980 | 2025-03-19 22:57:53.161117 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-19 22:57:53.461570 | ubuntu-noble -> localhost | ok 2025-03-19 22:57:53.470650 | 2025-03-19 22:57:53.470821 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-19 22:57:53.506966 | ubuntu-noble | ok 2025-03-19 22:57:53.526284 | ubuntu-noble | included: /var/lib/zuul/builds/22ecd0c35eea458e93cbb9f69debe505/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-19 22:57:53.534595 | 2025-03-19 22:57:53.534704 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-19 22:57:54.212772 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-03-19 22:57:54.212998 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/22ecd0c35eea458e93cbb9f69debe505/work/22ecd0c35eea458e93cbb9f69debe505_id_rsa 2025-03-19 22:57:54.213035 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/22ecd0c35eea458e93cbb9f69debe505/work/22ecd0c35eea458e93cbb9f69debe505_id_rsa.pub 2025-03-19 22:57:54.213061 | ubuntu-noble -> localhost | The key fingerprint is: 2025-03-19 22:57:54.213084 | ubuntu-noble -> localhost | SHA256:3aqDI2Kn0HMJ1IyR2rafQZaiu2H0nDMKRdTtlFVzJ04 zuul-build-sshkey 2025-03-19 22:57:54.213106 | ubuntu-noble -> localhost | The key's randomart image is: 2025-03-19 22:57:54.213132 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-03-19 22:57:54.213154 | ubuntu-noble -> localhost | | oo . o..o E . | 2025-03-19 22:57:54.213174 | ubuntu-noble -> localhost | | ..=. + = o | 2025-03-19 22:57:54.213194 | ubuntu-noble -> localhost | | o+ o+ . | 2025-03-19 22:57:54.213213 | ubuntu-noble -> localhost | |.o+ + . . . | 2025-03-19 22:57:54.213232 | ubuntu-noble -> localhost | | +o= S . . | 2025-03-19 22:57:54.213252 | ubuntu-noble -> localhost | |oo+.o. . | 2025-03-19 22:57:54.213272 | ubuntu-noble -> localhost | |+ooBoo . . | 2025-03-19 22:57:54.213292 | ubuntu-noble -> localhost | |+o+oB o .. | 2025-03-19 22:57:54.213312 | ubuntu-noble -> localhost | |.+.+ . ... | 2025-03-19 22:57:54.213331 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-03-19 22:57:54.213380 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.125452 2025-03-19 22:57:54.221475 | 2025-03-19 22:57:54.221591 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-19 22:57:54.254164 | ubuntu-noble | ok 2025-03-19 22:57:54.265709 | ubuntu-noble | included: /var/lib/zuul/builds/22ecd0c35eea458e93cbb9f69debe505/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-19 22:57:54.275741 | 2025-03-19 22:57:54.275845 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-19 22:57:54.301001 | ubuntu-noble | skipping: Conditional result was False 2025-03-19 22:57:54.308619 | 2025-03-19 22:57:54.308764 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-19 22:57:55.206275 | ubuntu-noble | changed 2025-03-19 22:57:55.216422 | 2025-03-19 22:57:55.216532 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-19 22:57:55.572038 | ubuntu-noble | ok 2025-03-19 22:57:55.581417 | 2025-03-19 22:57:55.581556 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-19 22:57:56.358100 | ubuntu-noble | changed 2025-03-19 22:57:56.367989 | 2025-03-19 22:57:56.368124 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-19 22:57:57.192741 | ubuntu-noble | changed 2025-03-19 22:57:57.204183 | 2025-03-19 22:57:57.204290 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-19 22:57:57.238522 | ubuntu-noble | skipping: Conditional result was False 2025-03-19 22:57:57.253492 | 2025-03-19 22:57:57.253630 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-19 22:57:57.659460 | ubuntu-noble -> localhost | changed 2025-03-19 22:57:57.675230 | 2025-03-19 22:57:57.675336 | TASK [add-build-sshkey : Add back temp key] 2025-03-19 22:57:57.995089 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/22ecd0c35eea458e93cbb9f69debe505/work/22ecd0c35eea458e93cbb9f69debe505_id_rsa (zuul-build-sshkey) 2025-03-19 22:57:57.995287 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.008352 2025-03-19 22:57:58.027912 | 2025-03-19 22:57:58.028054 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-19 22:57:58.431789 | ubuntu-noble | ok 2025-03-19 22:57:58.438343 | 2025-03-19 22:57:58.438446 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-19 22:57:58.462383 | ubuntu-noble | skipping: Conditional result was False 2025-03-19 22:57:58.475164 | 2025-03-19 22:57:58.475275 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-19 22:57:58.909228 | ubuntu-noble | ok 2025-03-19 22:57:58.923401 | 2025-03-19 22:57:58.923491 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-19 22:57:58.952660 | ubuntu-noble | ok 2025-03-19 22:57:58.960956 | 2025-03-19 22:57:58.961044 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-19 22:57:59.238579 | ubuntu-noble -> localhost | ok 2025-03-19 22:57:59.245932 | 2025-03-19 22:57:59.246023 | TASK [validate-host : Collect information about the host] 2025-03-19 22:58:00.470078 | ubuntu-noble | ok 2025-03-19 22:58:00.484415 | 2025-03-19 22:58:00.484511 | TASK [validate-host : Sanitize hostname] 2025-03-19 22:58:00.551657 | ubuntu-noble | ok 2025-03-19 22:58:00.560804 | 2025-03-19 22:58:00.560925 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-19 22:58:01.167120 | ubuntu-noble -> localhost | changed 2025-03-19 22:58:01.174316 | 2025-03-19 22:58:01.174425 | TASK [validate-host : Collect information about zuul worker] 2025-03-19 22:58:01.648861 | ubuntu-noble | ok 2025-03-19 22:58:01.654510 | 2025-03-19 22:58:01.654600 | TASK [validate-host : Write out all zuul information for each host] 2025-03-19 22:58:02.197068 | ubuntu-noble -> localhost | changed 2025-03-19 22:58:02.208901 | 2025-03-19 22:58:02.209001 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-19 22:58:02.563391 | ubuntu-noble | ok 2025-03-19 22:58:02.569814 | 2025-03-19 22:58:02.569903 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-19 22:58:04.013218 | ubuntu-noble | changed: 2025-03-19 22:58:04.013419 | ubuntu-noble | cd+++++++++ src/ 2025-03-19 22:58:04.013451 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-03-19 22:58:04.013474 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-03-19 22:58:04.013495 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-03-19 22:58:04.013515 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.006510 2025-03-19 22:59:39.691516 | 2025-03-19 22:59:39.691635 | TASK [upload-logs : Upload logs to log server] 2025-03-19 22:59:40.231894 | localhost | Output suppressed because no_log was given 2025-03-19 22:59:40.236879 | 2025-03-19 22:59:40.237031 | LOOP [upload-logs : Compress console log and json output] 2025-03-19 22:59:40.322776 | localhost | skipping: Conditional result was False 2025-03-19 22:59:40.351433 | localhost | skipping: Conditional result was False 2025-03-19 22:59:40.359732 | 2025-03-19 22:59:40.359904 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-19 22:59:40.421273 | localhost | skipping: Conditional result was False 2025-03-19 22:59:40.421552 | 2025-03-19 22:59:40.434265 | localhost | skipping: Conditional result was False 2025-03-19 22:59:40.445998 | 2025-03-19 22:59:40.446309 | LOOP [upload-logs : Upload console log and json output]