2025-02-12 23:01:21.835065 | Job console starting... 2025-02-12 23:01:21.845539 | Updating repositories 2025-02-12 23:01:21.867381 | Preparing job workspace 2025-02-12 23:01:23.184889 | Running Ansible setup... 2025-02-12 23:01:27.927055 | PRE-RUN START: [trusted : github.com/YAKEcloud/zuul-config/playbooks/base/pre.yaml@main] 2025-02-12 23:01:28.699406 | 2025-02-12 23:01:28.699588 | PLAY [Base pre] 2025-02-12 23:01:28.729610 | 2025-02-12 23:01:28.729747 | TASK [Setup log path fact] 2025-02-12 23:01:28.775261 | ubuntu-jammy | ok 2025-02-12 23:01:28.806714 | 2025-02-12 23:01:28.806892 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-12 23:01:28.868704 | ubuntu-jammy | ok 2025-02-12 23:01:28.878491 | 2025-02-12 23:01:28.878635 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-12 23:01:28.925331 | ubuntu-jammy | skipping: Conditional result was False 2025-02-12 23:01:28.937217 | 2025-02-12 23:01:28.937375 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-12 23:01:28.983855 | ubuntu-jammy | skipping: Conditional result was False 2025-02-12 23:01:29.000775 | 2025-02-12 23:01:29.002200 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-12 23:01:29.033156 | ubuntu-jammy | skipping: Conditional result was False 2025-02-12 23:01:29.049483 | 2025-02-12 23:01:29.049641 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-12 23:01:29.076110 | ubuntu-jammy | skipping: Conditional result was False 2025-02-12 23:01:29.090136 | 2025-02-12 23:01:29.090304 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-12 23:01:29.117858 | ubuntu-jammy | skipping: Conditional result was False 2025-02-12 23:01:29.144160 | 2025-02-12 23:01:29.144293 | TASK [emit-job-header : Print job information] 2025-02-12 23:01:29.213350 | # Job Information 2025-02-12 23:01:29.213591 | Ansible Version: 2.15.3 2025-02-12 23:01:29.213641 | Job: python-black 2025-02-12 23:01:29.213687 | Pipeline: check 2025-02-12 23:01:29.213721 | Executor: 7d211f194f6a 2025-02-12 23:01:29.213752 | Triggered by: https://github.com/YAKEcloud/yake-ansible/pull/116 2025-02-12 23:01:29.213782 | Event ID: 2d707b80-e995-11ef-816d-62352312cbe2 2025-02-12 23:01:29.222216 | 2025-02-12 23:01:29.222335 | LOOP [emit-job-header : Print node information] 2025-02-12 23:01:29.363082 | ubuntu-jammy | ok: 2025-02-12 23:01:29.363275 | ubuntu-jammy | # Node Information 2025-02-12 23:01:29.363309 | ubuntu-jammy | Inventory Hostname: ubuntu-jammy 2025-02-12 23:01:29.363334 | ubuntu-jammy | Hostname: ubuntu 2025-02-12 23:01:29.363355 | ubuntu-jammy | Username: zuul 2025-02-12 23:01:29.363375 | ubuntu-jammy | Distro: Ubuntu 22.04 2025-02-12 23:01:29.363395 | ubuntu-jammy | Provider: regiocloud-a 2025-02-12 23:01:29.363414 | ubuntu-jammy | Label: ubuntu-jammy 2025-02-12 23:01:29.363433 | ubuntu-jammy | Product Name: OpenStack Nova 2025-02-12 23:01:29.363453 | ubuntu-jammy | Interface IP: 81.163.192.49 2025-02-12 23:01:29.393031 | 2025-02-12 23:01:29.393248 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-02-12 23:01:29.896217 | ubuntu-jammy -> localhost | changed 2025-02-12 23:01:29.906854 | 2025-02-12 23:01:29.907005 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-02-12 23:01:31.055218 | ubuntu-jammy -> localhost | changed 2025-02-12 23:01:31.082463 | 2025-02-12 23:01:31.082609 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-02-12 23:01:31.394307 | ubuntu-jammy -> localhost | ok 2025-02-12 23:01:31.410780 | 2025-02-12 23:01:31.410922 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-02-12 23:01:31.462180 | ubuntu-jammy | ok 2025-02-12 23:01:31.489259 | ubuntu-jammy | included: /var/lib/zuul/builds/5e54d5f197b046dbbfbb3f4376484450/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-02-12 23:01:31.498090 | 2025-02-12 23:01:31.498204 | TASK [add-build-sshkey : Create Temp SSH key] 2025-02-12 23:01:32.140585 | ubuntu-jammy -> localhost | Generating public/private rsa key pair. 2025-02-12 23:01:32.140895 | ubuntu-jammy -> localhost | Your identification has been saved in /var/lib/zuul/builds/5e54d5f197b046dbbfbb3f4376484450/work/5e54d5f197b046dbbfbb3f4376484450_id_rsa 2025-02-12 23:01:32.140943 | ubuntu-jammy -> localhost | Your public key has been saved in /var/lib/zuul/builds/5e54d5f197b046dbbfbb3f4376484450/work/5e54d5f197b046dbbfbb3f4376484450_id_rsa.pub 2025-02-12 23:01:32.140989 | ubuntu-jammy -> localhost | The key fingerprint is: 2025-02-12 23:01:32.141018 | ubuntu-jammy -> localhost | SHA256:xnHR2x6HLJteNQiQY+mzZ+4oJZBVq4W0YSIYKDFI9Is zuul-build-sshkey 2025-02-12 23:01:32.141045 | ubuntu-jammy -> localhost | The key's randomart image is: 2025-02-12 23:01:32.141076 | ubuntu-jammy -> localhost | +---[RSA 3072]----+ 2025-02-12 23:01:32.141103 | ubuntu-jammy -> localhost | |B=o. . +.o=. | 2025-02-12 23:01:32.141127 | ubuntu-jammy -> localhost | |+o. . +.+=.o. | 2025-02-12 23:01:32.141150 | ubuntu-jammy -> localhost | |. . oo+oo .+.. | 2025-02-12 23:01:32.141173 | ubuntu-jammy -> localhost | | . .o .o= o.=.o| 2025-02-12 23:01:32.141196 | ubuntu-jammy -> localhost | | E . ..S o = +.| 2025-02-12 23:01:32.141218 | ubuntu-jammy -> localhost | | o o oo o | 2025-02-12 23:01:32.141241 | ubuntu-jammy -> localhost | | o +. . | 2025-02-12 23:01:32.141264 | ubuntu-jammy -> localhost | | . ... | 2025-02-12 23:01:32.141287 | ubuntu-jammy -> localhost | | .... | 2025-02-12 23:01:32.141309 | ubuntu-jammy -> localhost | +----[SHA256]-----+ 2025-02-12 23:01:32.141363 | ubuntu-jammy -> localhost | ok: Runtime: 0:00:00.093252 2025-02-12 23:01:32.152287 | 2025-02-12 23:01:32.152431 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-02-12 23:01:32.185897 | ubuntu-jammy | ok 2025-02-12 23:01:32.198712 | ubuntu-jammy | included: /var/lib/zuul/builds/5e54d5f197b046dbbfbb3f4376484450/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-02-12 23:01:32.208561 | 2025-02-12 23:01:32.208664 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-02-12 23:01:32.243557 | ubuntu-jammy | skipping: Conditional result was False 2025-02-12 23:01:32.255588 | 2025-02-12 23:01:32.255739 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-02-12 23:01:32.968565 | ubuntu-jammy | changed 2025-02-12 23:01:32.979897 | 2025-02-12 23:01:32.980084 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-02-12 23:01:33.236734 | ubuntu-jammy | ok 2025-02-12 23:01:33.248558 | 2025-02-12 23:01:33.248720 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-02-12 23:01:33.896755 | ubuntu-jammy | changed 2025-02-12 23:01:33.904479 | 2025-02-12 23:01:33.904609 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-02-12 23:01:34.548986 | ubuntu-jammy | changed 2025-02-12 23:01:34.556730 | 2025-02-12 23:01:34.556843 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-02-12 23:01:34.592214 | ubuntu-jammy | skipping: Conditional result was False 2025-02-12 23:01:34.601368 | 2025-02-12 23:01:34.601491 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-02-12 23:01:35.045399 | ubuntu-jammy -> localhost | changed 2025-02-12 23:01:35.059900 | 2025-02-12 23:01:35.060046 | TASK [add-build-sshkey : Add back temp key] 2025-02-12 23:01:35.423513 | ubuntu-jammy -> localhost | Identity added: /var/lib/zuul/builds/5e54d5f197b046dbbfbb3f4376484450/work/5e54d5f197b046dbbfbb3f4376484450_id_rsa (zuul-build-sshkey) 2025-02-12 23:01:35.423759 | ubuntu-jammy -> localhost | ok: Runtime: 0:00:00.016544 2025-02-12 23:01:35.431948 | 2025-02-12 23:01:35.432078 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-02-12 23:01:35.879688 | ubuntu-jammy | ok 2025-02-12 23:01:35.886452 | 2025-02-12 23:01:35.886561 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-02-12 23:01:35.942258 | ubuntu-jammy | skipping: Conditional result was False 2025-02-12 23:01:35.956339 | 2025-02-12 23:01:35.968524 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-02-12 23:01:36.357784 | ubuntu-jammy | ok 2025-02-12 23:01:36.371234 | 2025-02-12 23:01:36.371357 | TASK [validate-host : Define zuul_info_dir fact] 2025-02-12 23:01:36.423526 | ubuntu-jammy | ok 2025-02-12 23:01:36.435062 | 2025-02-12 23:01:36.435222 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-02-12 23:01:36.737729 | ubuntu-jammy -> localhost | ok 2025-02-12 23:01:36.746078 | 2025-02-12 23:01:36.746205 | TASK [validate-host : Collect information about the host] 2025-02-12 23:01:37.913334 | ubuntu-jammy | ok 2025-02-12 23:01:37.928359 | 2025-02-12 23:01:37.928538 | TASK [validate-host : Sanitize hostname] 2025-02-12 23:01:38.018151 | ubuntu-jammy | ok 2025-02-12 23:01:38.027831 | 2025-02-12 23:01:38.027999 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-02-12 23:01:38.614297 | ubuntu-jammy -> localhost | changed 2025-02-12 23:01:38.622356 | 2025-02-12 23:01:38.622484 | TASK [validate-host : Collect information about zuul worker] 2025-02-12 23:01:39.081888 | ubuntu-jammy | ok 2025-02-12 23:01:39.088793 | 2025-02-12 23:01:39.088927 | TASK [validate-host : Write out all zuul information for each host] 2025-02-12 23:01:39.796231 | ubuntu-jammy -> localhost | changed 2025-02-12 23:01:39.823367 | 2025-02-12 23:01:39.823607 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-02-12 23:01:40.081141 | ubuntu-jammy | ok 2025-02-12 23:01:40.100227 | 2025-02-12 23:01:40.100349 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-02-12 23:01:41.046418 | ubuntu-jammy | changed: 2025-02-12 23:01:41.046695 | ubuntu-jammy | cd+++++++++ src/ 2025-02-12 23:01:41.046749 | ubuntu-jammy | cd+++++++++ src/github.com/ 2025-02-12 23:01:41.046788 | ubuntu-jammy | cd+++++++++ src/github.com/YAKEcloud/ 2025-02-12 23:01:41.046823 | ubuntu-jammy | cd+++++++++ src/github.com/YAKEcloud/yake-ansible/ 2025-02-12 23:01:41.046856 | ubuntu-jammy | Containerfile 2025-02-12 23:01:41.047118 | ubuntu-jammy | Containerfile 2025-02-12 23:01:41.080853 | ubuntu-jammy | Containerfile 2025-02-12 23:01:41.080922 | ubuntu-jammy | Containerfile 2025-02-12 23:01:41.081014 | ubuntu-jammy | Containerfile 2025-02-12 23:01:41.081084 | ubuntu-jammy | Containerfile 2025-02-12 23:01:41.081151 | ubuntu-jammy | Containerfile 2025-02-12 23:01:41.081220 | ubuntu-jammy | localhost | ok: Runtime: 0:00:00.007374 2025-02-12 23:02:10.425786 | 2025-02-12 23:02:10.425902 | TASK [upload-logs : Upload logs to log server] 2025-02-12 23:02:11.008306 | localhost | Output suppressed because no_log was given 2025-02-12 23:02:11.012406 | 2025-02-12 23:02:11.012532 | LOOP [upload-logs : Compress console log and json output] 2025-02-12 23:02:11.106919 | localhost | skipping: Conditional result was False 2025-02-12 23:02:11.125325 | localhost | skipping: Conditional result was False 2025-02-12 23:02:11.136211 | 2025-02-12 23:02:11.136376 | LOOP [upload-logs : Upload compressed console log and json output] 2025-02-12 23:02:11.200072 | localhost | skipping: Conditional result was False 2025-02-12 23:02:11.200410 | 2025-02-12 23:02:11.213443 | localhost | skipping: Conditional result was False 2025-02-12 23:02:11.223555 | 2025-02-12 23:02:11.223792 | LOOP [upload-logs : Upload console log and json output]