2019-08-16 04:33:01.088652 | Job console starting... 2019-08-16 04:33:14.125144 | Running Ansible setup... 2019-08-16 04:33:21.210872 | PRE-RUN START: [trusted : opendev.org/opendev/base-jobs/playbooks/base/pre.yaml@master] 2019-08-16 04:33:25.064513 | 2019-08-16 04:33:25.064740 | PLAY [localhost] 2019-08-16 04:33:25.092270 | 2019-08-16 04:33:25.092451 | TASK [Setup log path fact] 2019-08-16 04:33:25.148298 | localhost | ok 2019-08-16 04:33:25.209726 | 2019-08-16 04:33:25.209933 | TASK [set-zuul-log-path-fact : Set log path for a change] 2019-08-16 04:33:25.310400 | localhost | ok 2019-08-16 04:33:25.334898 | 2019-08-16 04:33:25.335094 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2019-08-16 04:33:25.388066 | localhost | skipping: Conditional result was False 2019-08-16 04:33:25.417582 | 2019-08-16 04:33:25.417878 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2019-08-16 04:33:25.475131 | localhost | skipping: Conditional result was False 2019-08-16 04:33:25.505018 | 2019-08-16 04:33:25.505228 | TASK [emit-job-header : Print job information] 2019-08-16 04:33:25.600744 | # Job Information 2019-08-16 04:33:25.601226 | Ansible Version: 2.7.9 2019-08-16 04:33:25.601336 | Job: tripleo-build-containers-centos-7 2019-08-16 04:33:25.601440 | Pipeline: check 2019-08-16 04:33:25.601541 | Executor: ze11.openstack.org 2019-08-16 04:33:25.601675 | Triggered by: https://review.opendev.org/676447 2019-08-16 04:33:25.601776 | Log URL (when completed): https://logs.opendev.org/47/676447/1/check/tripleo-build-containers-centos-7/5b97af7/ 2019-08-16 04:33:25.626363 | 2019-08-16 04:33:25.626560 | LOOP [emit-job-header : Print node information] 2019-08-16 04:33:25.795807 | localhost | ok: 2019-08-16 04:33:25.796304 | localhost | # Node Information 2019-08-16 04:33:25.796416 | localhost | Hostname: centos-7-rax-ord-0010221455 2019-08-16 04:33:25.796521 | localhost | Provider: rax-ord 2019-08-16 04:33:25.796623 | localhost | Label: centos-7 2019-08-16 04:33:25.796725 | localhost | Interface IP: 23.253.164.73 2019-08-16 04:33:25.832007 | 2019-08-16 04:33:25.832239 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2019-08-16 04:33:26.450699 | localhost -> localhost | changed 2019-08-16 04:33:26.490411 | 2019-08-16 04:33:26.490646 | TASK [log-inventory : Copy ansible inventory to logs dir] 2019-08-16 04:33:27.639923 | localhost -> localhost | changed 2019-08-16 04:33:27.697322 | 2019-08-16 04:33:27.698370 | PLAY [all] 2019-08-16 04:33:27.779588 | 2019-08-16 04:33:27.779890 | TASK [Gather network facts] 2019-08-16 04:33:29.066121 | primary | ok 2019-08-16 04:33:29.182754 | 2019-08-16 04:33:29.183033 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2019-08-16 04:33:29.517213 | primary -> localhost | ok 2019-08-16 04:33:29.561203 | 2019-08-16 04:33:29.561443 | TASK [add-build-sshkey : Create Temp SSH key] 2019-08-16 04:33:30.221144 | primary -> localhost | Generating public/private rsa key pair. 2019-08-16 04:33:30.221974 | primary -> localhost | Your identification has been saved in /var/lib/zuul/builds/5b97af71f8734123988a6845338513b8/work/5b97af71f8734123988a6845338513b8_id_rsa. 2019-08-16 04:33:30.222127 | primary -> localhost | Your public key has been saved in /var/lib/zuul/builds/5b97af71f8734123988a6845338513b8/work/5b97af71f8734123988a6845338513b8_id_rsa.pub. 2019-08-16 04:33:30.222243 | primary -> localhost | The key fingerprint is: 2019-08-16 04:33:30.222359 | primary -> localhost | SHA256:Alg7+xi9CdKc7OK2WKRB3VcyiEtunTsdN1jqsZwokT0 zuul-build-sshkey 2019-08-16 04:33:30.222473 | primary -> localhost | The key's randomart image is: 2019-08-16 04:33:30.222592 | primary -> localhost | +---[RSA 1024]----+ 2019-08-16 04:33:30.222707 | primary -> localhost | | o .o . | 2019-08-16 04:33:30.222814 | primary -> localhost | | .=.o +. | 2019-08-16 04:33:30.222920 | primary -> localhost | | .+.O...+ | 2019-08-16 04:33:30.223030 | primary -> localhost | |. X E.= o | 2019-08-16 04:33:30.223135 | primary -> localhost | |. + X X S . | 2019-08-16 04:33:30.223262 | primary -> localhost | | + + O X | 2019-08-16 04:33:30.223368 | primary -> localhost | |. o + = | 2019-08-16 04:33:30.223477 | primary -> localhost | | +.. | 2019-08-16 04:33:30.223594 | primary -> localhost | |..o. | 2019-08-16 04:33:30.223698 | primary -> localhost | +----[SHA256]-----+ 2019-08-16 04:33:30.223925 | primary -> localhost | ok: Runtime: 0:00:00.076674 2019-08-16 04:33:30.263520 | 2019-08-16 04:33:30.263820 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2019-08-16 04:33:30.323133 | primary | skipping: Conditional result was False 2019-08-16 04:33:30.359686 | 2019-08-16 04:33:30.359970 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2019-08-16 04:33:31.181093 | primary | changed 2019-08-16 04:33:31.214337 | 2019-08-16 04:33:31.214576 | TASK [add-build-sshkey : Make sure user has a .ssh] 2019-08-16 04:33:31.618158 | primary | ok 2019-08-16 04:33:31.654032 | 2019-08-16 04:33:31.654304 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2019-08-16 04:33:33.151869 | primary | changed 2019-08-16 04:33:33.183883 | 2019-08-16 04:33:33.184123 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2019-08-16 04:33:34.739423 | primary | changed 2019-08-16 04:33:34.787612 | 2019-08-16 04:33:34.787990 | TASK [add-build-sshkey : Remove master key from local agent] 2019-08-16 04:33:35.356966 | primary -> localhost | changed 2019-08-16 04:33:35.399908 | 2019-08-16 04:33:35.400153 | TASK [add-build-sshkey : Add back temp key] 2019-08-16 04:33:35.728223 | primary -> localhost | Identity added: /var/lib/zuul/builds/5b97af71f8734123988a6845338513b8/work/5b97af71f8734123988a6845338513b8_id_rsa (/var/lib/zuul/builds/5b97af71f8734123988a6845338513b8/work/5b97af71f8734123988a6845338513b8_id_rsa) 2019-08-16 04:33:35.729037 | primary -> localhost | ok: Runtime: 0:00:00.007275 2019-08-16 04:33:35.764789 | 2019-08-16 04:33:35.765085 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2019-08-16 04:33:36.449540 | primary | ok 2019-08-16 04:33:36.482424 | 2019-08-16 04:33:36.482702 | TASK [start-zuul-console : Start zuul_console daemon.] 2019-08-16 04:33:37.159045 | primary | ok 2019-08-16 04:33:37.201115 | 2019-08-16 04:33:37.201340 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2019-08-16 04:33:37.738581 | primary | changed: "logs" 2019-08-16 04:33:37.739189 | primary | ok: All items complete 2019-08-16 04:33:37.739300 | 2019-08-16 04:33:37.986447 | primary | changed: "artifacts" 2019-08-16 04:33:38.241137 | primary | changed: "docs" 2019-08-16 04:33:38.273190 | 2019-08-16 04:33:38.273421 | PLAY [all] 2019-08-16 04:33:38.315539 | 2019-08-16 04:33:38.315835 | TASK [configure-unbound : Check that Unbound is installed] 2019-08-16 04:33:38.834103 | primary | ok 2019-08-16 04:33:38.879970 | 2019-08-16 04:33:38.880289 | TASK [configure-unbound : Ensure that Unbound is installed] 2019-08-16 04:33:39.146632 | primary | ok: All assertions passed 2019-08-16 04:33:39.181293 | 2019-08-16 04:33:39.181548 | TASK [configure-unbound : Check for IPv6] 2019-08-16 04:33:39.264505 | primary | skipping: Conditional result was False 2019-08-16 04:33:39.304425 | 2019-08-16 04:33:39.304684 | TASK [configure-unbound : Set IPv6 nameservers] 2019-08-16 04:33:39.370621 | primary | skipping: Conditional result was False 2019-08-16 04:33:39.416405 | 2019-08-16 04:33:39.416692 | TASK [configure-unbound : Set IPv4 nameservers] 2019-08-16 04:33:39.723391 | primary | ok 2019-08-16 04:33:39.762908 | 2019-08-16 04:33:39.763144 | LOOP [configure-unbound : Include OS-specific variables] 2019-08-16 04:33:40.078611 | primary | ok: "/var/lib/zuul/builds/5b97af71f8734123988a6845338513b8/trusted/project_0/opendev.org/opendev/base-jobs/roles/configure-unbound/vars/default.yaml" 2019-08-16 04:33:40.121701 | 2019-08-16 04:33:40.122000 | TASK [configure-unbound : Ensure Unbound conf.d directory exists] 2019-08-16 04:33:40.739766 | primary | ok 2019-08-16 04:33:40.774070 | 2019-08-16 04:33:40.774330 | TASK [configure-unbound : Configure unbound forwarding] 2019-08-16 04:33:42.394725 | primary | changed 2019-08-16 04:33:42.429935 | 2019-08-16 04:33:42.430134 | TASK [configure-unbound : Configure unbound TTL] 2019-08-16 04:33:43.988422 | primary | changed 2019-08-16 04:33:44.019865 | 2019-08-16 04:33:44.020067 | TASK [configure-unbound : Start unbound] 2019-08-16 04:33:45.214003 | primary | ok 2019-08-16 04:33:45.255100 | 2019-08-16 04:33:45.255339 | TASK [configure-unbound : Restart unbound] 2019-08-16 04:33:46.077258 | primary | changed 2019-08-16 04:33:46.109024 | 2019-08-16 04:33:46.109213 | PLAY [all] 2019-08-16 04:33:46.146315 | 2019-08-16 04:33:46.146499 | TASK [validate-host : Define zuul_info_dir fact] 2019-08-16 04:33:46.443386 | primary | ok 2019-08-16 04:33:46.485047 | 2019-08-16 04:33:46.485315 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2019-08-16 04:33:46.780425 | primary -> localhost | ok 2019-08-16 04:33:46.815489 | 2019-08-16 04:33:46.815732 | TASK [validate-host : Collect information about the host] 2019-08-16 04:33:47.678673 | primary | ok 2019-08-16 04:33:47.741325 | 2019-08-16 04:33:47.741673 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2019-08-16 04:33:48.424761 | primary -> localhost | changed 2019-08-16 04:33:48.463329 | 2019-08-16 04:33:48.463525 | TASK [validate-host : Collect information about zuul worker] 2019-08-16 04:33:54.291625 | primary | ok 2019-08-16 04:33:54.337498 | 2019-08-16 04:33:54.337763 | TASK [validate-host : Write out all zuul information for each host] 2019-08-16 04:33:54.898728 | primary -> localhost | changed 2019-08-16 04:33:54.939443 | 2019-08-16 04:33:54.939750 | LOOP [use-cached-repos : Find locally cached git repos] 2019-08-16 04:33:55.583422 | primary | ok: 2019-08-16 04:33:55.583968 | primary | { 2019-08-16 04:33:55.584084 | primary | "canonical_hostname": "opendev.org", 2019-08-16 04:33:55.584194 | primary | "canonical_name": "opendev.org/openstack/python-tripleoclient", 2019-08-16 04:33:55.584299 | primary | "checkout": "master", 2019-08-16 04:33:55.584404 | primary | "name": "openstack/python-tripleoclient", 2019-08-16 04:33:55.584507 | primary | "required": true, 2019-08-16 04:33:55.584610 | primary | "short_name": "python-tripleoclient", 2019-08-16 04:33:55.584712 | primary | "src_dir": "src/opendev.org/openstack/python-tripleoclient" 2019-08-16 04:33:55.584814 | primary | } 2019-08-16 04:33:55.584962 | primary | ok: All items complete 2019-08-16 04:33:55.585062 | 2019-08-16 04:33:55.825837 | primary | ok: 2019-08-16 04:33:55.826048 | primary | { 2019-08-16 04:33:55.826162 | primary | "canonical_hostname": "opendev.org", 2019-08-16 04:33:55.826270 | primary | "canonical_name": "opendev.org/openstack/tripleo-upgrade", 2019-08-16 04:33:55.826490 | primary | "checkout": "master", 2019-08-16 04:33:55.826599 | primary | "name": "openstack/tripleo-upgrade", 2019-08-16 04:33:55.826705 | primary | "required": true, 2019-08-16 04:33:55.826809 | primary | "short_name": "tripleo-upgrade", 2019-08-16 04:33:55.826912 | primary | "src_dir": "src/opendev.org/openstack/tripleo-upgrade" 2019-08-16 04:33:55.827014 | primary | } 2019-08-16 04:33:56.056887 | primary | ok: 2019-08-16 04:33:56.057107 | primary | { 2019-08-16 04:33:56.057220 | primary | "canonical_hostname": "opendev.org", 2019-08-16 04:33:56.057329 | primary | "canonical_name": "opendev.org/openstack/tripleo-repos", 2019-08-16 04:33:56.057436 | primary | "checkout": "master", 2019-08-16 04:33:56.057540 | primary | "name": "openstack/tripleo-repos", 2019-08-16 04:33:56.057671 | primary | "required": true, 2019-08-16 04:33:56.057777 | primary | "short_name": "tripleo-repos", 2019-08-16 04:33:56.057880 | primary | "src_dir": "src/opendev.org/openstack/tripleo-repos" 2019-08-16 04:33:56.057982 | primary | } 2019-08-16 04:33:56.302695 | primary | ok: 2019-08-16 04:33:56.302922 | primary | { 2019-08-16 04:33:56.303037 | primary | "canonical_hostname": "opendev.org", 2019-08-16 04:33:56.303160 | primary | "canonical_name": "opendev.org/openstack/kolla", 2019-08-16 04:33:56.303267 | primary | "checkout": "master", 2019-08-16 04:33:56.303371 | primary | "name": "openstack/kolla", 2019-08-16 04:33:56.303475 | primary | "required": true, 2019-08-16 04:33:56.303578 | primary | "short_name": "kolla", 2019-08-16 04:33:56.303679 | primary | "src_dir": "src/opendev.org/openstack/kolla" 2019-08-16 04:33:56.303781 | primary | } 2019-08-16 04:33:56.560945 | primary | ok: 2019-08-16 04:33:56.561203 | primary | { 2019-08-16 04:33:56.561457 | primary | "canonical_hostname": "opendev.org", 2019-08-16 04:33:56.561591 | primary | "canonical_name": "opendev.org/openstack/ansible-role-python_venv_build", 2019-08-16 04:33:56.561708 | primary | "checkout": "master", 2019-08-16 04:33:56.561869 | primary | "name": "openstack/ansible-role-python_venv_build", 2019-08-16 04:33:56.561989 | primary | "required": true, 2019-08-16 04:33:56.562107 | primary | "short_name": "ansible-role-python_venv_build", 2019-08-16 04:33:56.562219 | primary | "src_dir": "src/opendev.org/openstack/ansible-role-python_venv_build" 2019-08-16 04:33:56.562329 | primary | } 2019-08-16 04:33:56.807295 | primary | ok: 2019-08-16 04:33:56.807497 | primary | { 2019-08-16 04:33:56.807610 | primary | "canonical_hostname": "opendev.org", 2019-08-16 04:33:56.807717 | primary | "canonical_name": "opendev.org/openstack/tripleo-ha-utils", 2019-08-16 04:33:56.807821 | primary | "checkout": "master", 2019-08-16 04:33:56.807924 | primary | "name": "openstack/tripleo-ha-utils", 2019-08-16 04:33:56.808026 | primary | "required": true, 2019-08-16 04:33:56.808127 | primary | "short_name": "tripleo-ha-utils", 2019-08-16 04:33:56.808228 | primary | "src_dir": "src/opendev.org/openstack/tripleo-ha-utils" 2019-08-16 04:33:56.808328 | primary | } 2019-08-16 04:33:57.049785 | primary | ok: 2019-08-16 04:33:57.050029 | primary | { 2019-08-16 04:33:57.050144 | primary | "canonical_hostname": "opendev.org", 2019-08-16 04:33:57.050254 | primary | "canonical_name": "opendev.org/x/browbeat", 2019-08-16 04:33:57.050374 | primary | "checkout": "master", 2019-08-16 04:33:57.050525 | primary | "name": "x/browbeat", 2019-08-16 04:33:57.050634 | primary | "required": true, 2019-08-16 04:33:57.050765 | primary | "short_name": "browbeat", 2019-08-16 04:33:57.050873 | primary | "src_dir": "src/opendev.org/x/browbeat" 2019-08-16 04:33:57.050976 | primary | } 2019-08-16 04:33:57.294995 | primary | ok: 2019-08-16 04:33:57.295225 | primary | { 2019-08-16 04:33:57.295370 | primary | "canonical_hostname": "opendev.org", 2019-08-16 04:33:57.295482 | primary | "canonical_name": "opendev.org/openstack/tripleo-quickstart-extras", 2019-08-16 04:33:57.295620 | primary | "checkout": "master", 2019-08-16 04:33:57.295760 | primary | "name": "openstack/tripleo-quickstart-extras", 2019-08-16 04:33:57.295872 | primary | "required": true, 2019-08-16 04:33:57.296019 | primary | "short_name": "tripleo-quickstart-extras", 2019-08-16 04:33:57.296227 | primary | "src_dir": "src/opendev.org/openstack/tripleo-quickstart-extras" 2019-08-16 04:33:57.296414 | primary | } 2019-08-16 04:33:57.551153 | primary | ok: 2019-08-16 04:33:57.551364 | primary | { 2019-08-16 04:33:57.551477 | primary | "canonical_hostname": "opendev.org", 2019-08-16 04:33:57.551585 | primary | "canonical_name": "opendev.org/openstack/tripleo-common", 2019-08-16 04:33:57.551690 | primary | "checkout": "master", 2019-08-16 04:33:57.551813 | primary | "name": "openstack/tripleo-common", 2019-08-16 04:33:57.551918 | primary | "required": true, 2019-08-16 04:33:57.552019 | primary | "short_name": "tripleo-common", 2019-08-16 04:33:57.552121 | primary | "src_dir": "src/opendev.org/openstack/tripleo-common" 2019-08-16 04:33:57.552239 | primary | } 2019-08-16 04:33:57.794795 | primary | ok: 2019-08-16 04:33:57.795044 | primary | { 2019-08-16 04:33:57.795156 | primary | "canonical_hostname": "opendev.org", 2019-08-16 04:33:57.795262 | primary | "canonical_name": "opendev.org/openstack/openstack-ansible-os_tempest", 2019-08-16 04:33:57.795382 | primary | "checkout": "master", 2019-08-16 04:33:57.795486 | primary | "name": "openstack/openstack-ansible-os_tempest", 2019-08-16 04:33:57.795587 | primary | "required": true, 2019-08-16 04:33:57.795689 | primary | "short_name": "openstack-ansible-os_tempest", 2019-08-16 04:33:57.795789 | primary | "src_dir": "src/opendev.org/openstack/openstack-ansible-os_tempest" 2019-08-16 04:33:57.795890 | primary | } 2019-08-16 04:33:58.038925 | primary | ok: 2019-08-16 04:33:58.039204 | primary | { 2019-08-16 04:33:58.039362 | primary | "canonical_hostname": "opendev.org", 2019-08-16 04:33:58.039497 | primary | "canonical_name": "opendev.org/openstack/ansible-role-collect-logs", 2019-08-16 04:33:58.039607 | primary | "checkout": "master", 2019-08-16 04:33:58.039718 | primary | "name": "openstack/ansible-role-collect-logs", 2019-08-16 04:33:58.039835 | primary | "required": true, 2019-08-16 04:33:58.039941 | primary | "short_name": "ansible-role-collect-logs", 2019-08-16 04:33:58.040124 | primary | "src_dir": "src/opendev.org/openstack/ansible-role-collect-logs" 2019-08-16 04:33:58.040320 | primary | } 2019-08-16 04:33:58.294832 | primary | ok: 2019-08-16 04:33:58.295044 | primary | { 2019-08-16 04:33:58.295158 | primary | "canonical_hostname": "opendev.org", 2019-08-16 04:33:58.295266 | primary | "canonical_name": "opendev.org/openstack/tripleo-quickstart", 2019-08-16 04:33:58.295371 | primary | "checkout": "master", 2019-08-16 04:33:58.295476 | primary | "name": "openstack/tripleo-quickstart", 2019-08-16 04:33:58.295579 | primary | "required": true, 2019-08-16 04:33:58.295682 | primary | "short_name": "tripleo-quickstart", 2019-08-16 04:33:58.295783 | primary | "src_dir": "src/opendev.org/openstack/tripleo-quickstart" 2019-08-16 04:33:58.295885 | primary | } 2019-08-16 04:33:58.536598 | primary | ok: 2019-08-16 04:33:58.536805 | primary | { 2019-08-16 04:33:58.536918 | primary | "canonical_hostname": "opendev.org", 2019-08-16 04:33:58.537025 | primary | "canonical_name": "opendev.org/openstack/ansible-config_template", 2019-08-16 04:33:58.537131 | primary | "checkout": "master", 2019-08-16 04:33:58.537235 | primary | "name": "openstack/ansible-config_template", 2019-08-16 04:33:58.537337 | primary | "required": true, 2019-08-16 04:33:58.537440 | primary | "short_name": "ansible-config_template", 2019-08-16 04:33:58.537541 | primary | "src_dir": "src/opendev.org/openstack/ansible-config_template" 2019-08-16 04:33:58.537666 | primary | } 2019-08-16 04:33:58.772859 | primary | ok: 2019-08-16 04:33:58.773087 | primary | { 2019-08-16 04:33:58.773206 | primary | "canonical_hostname": "opendev.org", 2019-08-16 04:33:58.773314 | primary | "canonical_name": "opendev.org/openstack/tripleo-ci", 2019-08-16 04:33:58.773420 | primary | "checkout": "master", 2019-08-16 04:33:58.773524 | primary | "name": "openstack/tripleo-ci", 2019-08-16 04:33:58.773668 | primary | "required": true, 2019-08-16 04:33:58.773772 | primary | "short_name": "tripleo-ci", 2019-08-16 04:33:58.773876 | primary | "src_dir": "src/opendev.org/openstack/tripleo-ci" 2019-08-16 04:33:58.773978 | primary | } 2019-08-16 04:33:59.046608 | primary | ok: 2019-08-16 04:33:59.046842 | primary | { 2019-08-16 04:33:59.046955 | primary | "canonical_hostname": "opendev.org", 2019-08-16 04:33:59.047063 | primary | "canonical_name": "opendev.org/openstack/openstack-virtual-baremetal", 2019-08-16 04:33:59.047167 | primary | "checkout": "stable/1.0", 2019-08-16 04:33:59.047271 | primary | "name": "openstack/openstack-virtual-baremetal", 2019-08-16 04:33:59.047373 | primary | "required": true, 2019-08-16 04:33:59.047474 | primary | "short_name": "openstack-virtual-baremetal", 2019-08-16 04:33:59.047575 | primary | "src_dir": "src/opendev.org/openstack/openstack-virtual-baremetal" 2019-08-16 04:33:59.047677 | primary | } 2019-08-16 04:33:59.314325 | primary | ok: 2019-08-16 04:33:59.314545 | primary | { 2019-08-16 04:33:59.314673 | primary | "canonical_hostname": "opendev.org", 2019-08-16 04:33:59.314848 | primary | "canonical_name": "opendev.org/openstack/ansible-role-container-registry", 2019-08-16 04:33:59.314960 | primary | "checkout": "master", 2019-08-16 04:33:59.315066 | primary | "name": "openstack/ansible-role-container-registry", 2019-08-16 04:33:59.315170 | primary | "required": true, 2019-08-16 04:33:59.315272 | primary | "short_name": "ansible-role-container-registry", 2019-08-16 04:33:59.315374 | primary | "src_dir": "src/opendev.org/openstack/ansible-role-container-registry" 2019-08-16 04:33:59.315602 | primary | } 2019-08-16 04:33:59.566721 | primary | ok: 2019-08-16 04:33:59.566960 | primary | { 2019-08-16 04:33:59.567072 | primary | "canonical_hostname": "opendev.org", 2019-08-16 04:33:59.567179 | primary | "canonical_name": "opendev.org/openstack/requirements", 2019-08-16 04:33:59.567288 | primary | "checkout": "master", 2019-08-16 04:33:59.567391 | primary | "name": "openstack/requirements", 2019-08-16 04:33:59.567492 | primary | "required": true, 2019-08-16 04:33:59.567592 | primary | "short_name": "requirements", 2019-08-16 04:33:59.567691 | primary | "src_dir": "src/opendev.org/openstack/requirements" 2019-08-16 04:33:59.567793 | primary | } 2019-08-16 04:33:59.632123 | 2019-08-16 04:33:59.632427 | LOOP [use-cached-repos : Clone cached repo to workspace] 2019-08-16 04:34:00.546742 | primary | Cloning into '/home/zuul/src/opendev.org/openstack/python-tripleoclient'... 2019-08-16 04:34:00.547403 | primary | done. 2019-08-16 04:34:00.547596 | primary | ok: Item: Runtime: 0:00:00.234598 2019-08-16 04:34:00.884780 | primary | Cloning into '/home/zuul/src/opendev.org/openstack/tripleo-upgrade'... 2019-08-16 04:34:00.885034 | primary | done. 2019-08-16 04:34:00.885189 | primary | ok: Item: Runtime: 0:00:00.067868 2019-08-16 04:34:01.160788 | primary | Cloning into '/home/zuul/src/opendev.org/openstack/tripleo-repos'... 2019-08-16 04:34:01.161052 | primary | done. 2019-08-16 04:34:01.161226 | primary | ok: Item: Runtime: 0:00:00.035070 2019-08-16 04:34:02.002088 | primary | Cloning into '/home/zuul/src/opendev.org/openstack/kolla'... 2019-08-16 04:34:02.002301 | primary | done. 2019-08-16 04:34:02.002444 | primary | ok: Item: Runtime: 0:00:00.599964 2019-08-16 04:34:02.366417 | primary | Cloning into '/home/zuul/src/opendev.org/openstack/ansible-role-python_venv_build'... 2019-08-16 04:34:02.366638 | primary | done. 2019-08-16 04:34:02.366790 | primary | ok: Item: Runtime: 0:00:00.045425 2019-08-16 04:34:02.690911 | primary | Cloning into '/home/zuul/src/opendev.org/openstack/tripleo-ha-utils'... 2019-08-16 04:34:02.691147 | primary | done. 2019-08-16 04:34:02.691293 | primary | ok: Item: Runtime: 0:00:00.072249 2019-08-16 04:34:03.117007 | primary | Cloning into '/home/zuul/src/opendev.org/x/browbeat'... 2019-08-16 04:34:03.117253 | primary | done. 2019-08-16 04:34:03.117415 | primary | ok: Item: Runtime: 0:00:00.186639 2019-08-16 04:34:03.571410 | primary | Cloning into '/home/zuul/src/opendev.org/openstack/tripleo-quickstart-extras'... 2019-08-16 04:34:03.571623 | primary | done. 2019-08-16 04:34:03.571767 | primary | ok: Item: Runtime: 0:00:00.204747 2019-08-16 04:34:04.067485 | primary | Cloning into '/home/zuul/src/opendev.org/openstack/tripleo-common'... 2019-08-16 04:34:04.067703 | primary | done. 2019-08-16 04:34:04.067846 | primary | ok: Item: Runtime: 0:00:00.248134 2019-08-16 04:34:04.492268 | primary | Cloning into '/home/zuul/src/opendev.org/openstack/openstack-ansible-os_tempest'... 2019-08-16 04:34:04.492484 | primary | done. 2019-08-16 04:34:04.492627 | primary | ok: Item: Runtime: 0:00:00.077440 2019-08-16 04:34:04.784058 | primary | Cloning into '/home/zuul/src/opendev.org/openstack/ansible-role-collect-logs'... 2019-08-16 04:34:04.784288 | primary | done. 2019-08-16 04:34:04.784441 | primary | ok: Item: Runtime: 0:00:00.045330 2019-08-16 04:34:05.225835 | primary | Cloning into '/home/zuul/src/opendev.org/openstack/tripleo-quickstart'... 2019-08-16 04:34:05.226047 | primary | done. 2019-08-16 04:34:05.226205 | primary | ok: Item: Runtime: 0:00:00.186158 2019-08-16 04:34:05.559196 | primary | Cloning into '/home/zuul/src/opendev.org/openstack/ansible-config_template'... 2019-08-16 04:34:05.559406 | primary | done. 2019-08-16 04:34:05.559563 | primary | ok: Item: Runtime: 0:00:00.055590 2019-08-16 04:34:05.973136 | primary | Cloning into '/home/zuul/src/opendev.org/openstack/tripleo-ci'... 2019-08-16 04:34:05.973368 | primary | done. 2019-08-16 04:34:05.973517 | primary | ok: Item: Runtime: 0:00:00.170595 2019-08-16 04:34:06.501458 | primary | Cloning into '/home/zuul/src/opendev.org/openstack/openstack-virtual-baremetal'... 2019-08-16 04:34:06.501974 | primary | done. 2019-08-16 04:34:06.502121 | primary | ok: Item: Runtime: 0:00:00.240103 2019-08-16 04:34:06.836482 | primary | Cloning into '/home/zuul/src/opendev.org/openstack/ansible-role-container-registry'... 2019-08-16 04:34:06.836747 | primary | done. 2019-08-16 04:34:06.836902 | primary | ok: Item: Runtime: 0:00:00.039133 2019-08-16 04:34:07.394645 | primary | Cloning into '/home/zuul/src/opendev.org/openstack/requirements'... 2019-08-16 04:34:07.394860 | primary | done. 2019-08-16 04:34:07.395020 | primary | ok: Item: Runtime: 0:00:00.311764 2019-08-16 04:34:07.475183 | 2019-08-16 04:34:07.475431 | LOOP [use-cached-repos : Clone upstream repo to workspace] 2019-08-16 04:34:07.649422 | primary | skipping: Conditional result was False 2019-08-16 04:34:07.650272 | primary | changed: All items complete 2019-08-16 04:34:07.650387 | 2019-08-16 04:34:07.664108 | primary | skipping: Conditional result was False 2019-08-16 04:34:07.676620 | primary | skipping: Conditional result was False 2019-08-16 04:34:07.689670 | primary | skipping: Conditional result was False 2019-08-16 04:34:07.702281 | primary | skipping: Conditional result was False 2019-08-16 04:34:07.714397 | primary | skipping: Conditional result was False 2019-08-16 04:34:07.726502 | primary | skipping: Conditional result was False 2019-08-16 04:34:07.738167 | primary | skipping: Conditional result was False 2019-08-16 04:34:07.751341 | primary | skipping: Conditional result was False 2019-08-16 04:34:07.763571 | primary | skipping: Conditional result was False 2019-08-16 04:34:07.775778 | primary | skipping: Conditional result was False 2019-08-16 04:34:07.787476 | primary | skipping: Conditional result was False 2019-08-16 04:34:07.799317 | primary | skipping: Conditional result was False 2019-08-16 04:34:07.811049 | primary | skipping: Conditional result was False 2019-08-16 04:34:07.822754 | primary | skipping: Conditional result was False 2019-08-16 04:34:07.834461 | primary | skipping: Conditional result was False 2019-08-16 04:34:07.847257 | primary | skipping: Conditional result was False 2019-08-16 04:34:07.931807 | 2019-08-16 04:34:07.932027 | LOOP [use-cached-repos : Remove origin from local git repos] 2019-08-16 04:34:08.470130 | primary | origin /opt/git/openstack/python-tripleoclient (fetch) 2019-08-16 04:34:08.470731 | primary | origin /opt/git/openstack/python-tripleoclient (push) 2019-08-16 04:34:08.470914 | primary | ok: Item: Runtime: 0:00:00.018185 2019-08-16 04:34:08.471040 | 2019-08-16 04:34:08.713547 | primary | origin /opt/git/openstack/tripleo-upgrade (fetch) 2019-08-16 04:34:08.713848 | primary | origin /opt/git/openstack/tripleo-upgrade (push) 2019-08-16 04:34:08.714004 | primary | ok: Item: Runtime: 0:00:00.013251 2019-08-16 04:34:08.966082 | primary | origin /opt/git/openstack/tripleo-repos (fetch) 2019-08-16 04:34:08.966282 | primary | origin /opt/git/openstack/tripleo-repos (push) 2019-08-16 04:34:08.966425 | primary | ok: Item: Runtime: 0:00:00.012865 2019-08-16 04:34:09.216868 | primary | origin /opt/git/openstack/kolla (fetch) 2019-08-16 04:34:09.217262 | primary | origin /opt/git/openstack/kolla (push) 2019-08-16 04:34:09.217417 | primary | ok: Item: Runtime: 0:00:00.017537 2019-08-16 04:34:09.484009 | primary | origin /opt/git/openstack/ansible-role-python_venv_build (fetch) 2019-08-16 04:34:09.484251 | primary | origin /opt/git/openstack/ansible-role-python_venv_build (push) 2019-08-16 04:34:09.484425 | primary | ok: Item: Runtime: 0:00:00.014658 2019-08-16 04:34:09.726032 | primary | origin /opt/git/openstack/tripleo-ha-utils (fetch) 2019-08-16 04:34:09.726392 | primary | origin /opt/git/openstack/tripleo-ha-utils (push) 2019-08-16 04:34:09.726547 | primary | ok: Item: Runtime: 0:00:00.013741 2019-08-16 04:34:09.980420 | primary | origin /opt/git/x/browbeat (fetch) 2019-08-16 04:34:09.980820 | primary | origin /opt/git/x/browbeat (push) 2019-08-16 04:34:09.980978 | primary | ok: Item: Runtime: 0:00:00.012366 2019-08-16 04:34:10.232845 | primary | origin /opt/git/openstack/tripleo-quickstart-extras (fetch) 2019-08-16 04:34:10.233119 | primary | origin /opt/git/openstack/tripleo-quickstart-extras (push) 2019-08-16 04:34:10.233275 | primary | ok: Item: Runtime: 0:00:00.012246 2019-08-16 04:34:10.494556 | primary | origin /opt/git/openstack/tripleo-common (fetch) 2019-08-16 04:34:10.494796 | primary | origin /opt/git/openstack/tripleo-common (push) 2019-08-16 04:34:10.494948 | primary | ok: Item: Runtime: 0:00:00.018297 2019-08-16 04:34:10.744981 | primary | origin /opt/git/openstack/openstack-ansible-os_tempest (fetch) 2019-08-16 04:34:10.745188 | primary | origin /opt/git/openstack/openstack-ansible-os_tempest (push) 2019-08-16 04:34:10.745331 | primary | ok: Item: Runtime: 0:00:00.019368 2019-08-16 04:34:10.995951 | primary | origin /opt/git/openstack/ansible-role-collect-logs (fetch) 2019-08-16 04:34:10.996165 | primary | origin /opt/git/openstack/ansible-role-collect-logs (push) 2019-08-16 04:34:10.996327 | primary | ok: Item: Runtime: 0:00:00.012268 2019-08-16 04:34:11.247838 | primary | origin /opt/git/openstack/tripleo-quickstart (fetch) 2019-08-16 04:34:11.248071 | primary | origin /opt/git/openstack/tripleo-quickstart (push) 2019-08-16 04:34:11.248220 | primary | ok: Item: Runtime: 0:00:00.013589 2019-08-16 04:34:11.492236 | primary | origin /opt/git/openstack/ansible-config_template (fetch) 2019-08-16 04:34:11.492463 | primary | origin /opt/git/openstack/ansible-config_template (push) 2019-08-16 04:34:11.492638 | primary | ok: Item: Runtime: 0:00:00.012902 2019-08-16 04:34:11.735077 | primary | origin /opt/git/openstack/tripleo-ci (fetch) 2019-08-16 04:34:11.735307 | primary | origin /opt/git/openstack/tripleo-ci (push) 2019-08-16 04:34:11.735456 | primary | ok: Item: Runtime: 0:00:00.011077 2019-08-16 04:34:11.989218 | primary | origin /opt/git/openstack/openstack-virtual-baremetal (fetch) 2019-08-16 04:34:11.989472 | primary | origin /opt/git/openstack/openstack-virtual-baremetal (push) 2019-08-16 04:34:11.989673 | primary | ok: Item: Runtime: 0:00:00.012379 2019-08-16 04:34:12.248176 | primary | origin /opt/git/openstack/ansible-role-container-registry (fetch) 2019-08-16 04:34:12.248437 | primary | origin /opt/git/openstack/ansible-role-container-registry (push) 2019-08-16 04:34:12.248593 | primary | ok: Item: Runtime: 0:00:00.012779 2019-08-16 04:34:12.489278 | primary | origin /opt/git/openstack/requirements (fetch) 2019-08-16 04:34:12.489506 | primary | origin /opt/git/openstack/requirements (push) 2019-08-16 04:34:12.489688 | primary | ok: Item: Runtime: 0:00:00.016319 2019-08-16 04:34:12.534988 | 2019-08-16 04:34:12.535200 | LOOP [mirror-workspace-git-repos : Allow pushing to non-bare repo] 2019-08-16 04:34:13.151650 | primary | changed: setting changed 2019-08-16 04:34:13.376388 | primary | changed: setting changed 2019-08-16 04:34:13.629334 | primary | changed: setting changed 2019-08-16 04:34:13.864545 | primary | changed: setting changed 2019-08-16 04:34:14.107824 | primary | changed: setting changed 2019-08-16 04:34:14.349077 | primary | changed: setting changed 2019-08-16 04:34:14.604237 | primary | changed: setting changed 2019-08-16 04:34:14.844451 | primary | changed: setting changed 2019-08-16 04:34:15.085946 | primary | changed: setting changed 2019-08-16 04:34:15.326960 | primary | changed: setting changed 2019-08-16 04:34:15.567708 | primary | changed: setting changed 2019-08-16 04:34:15.798566 | primary | changed: setting changed 2019-08-16 04:34:16.041538 | primary | changed: setting changed 2019-08-16 04:34:16.275567 | primary | changed: setting changed 2019-08-16 04:34:16.518951 | primary | changed: setting changed 2019-08-16 04:34:16.769886 | primary | changed: setting changed 2019-08-16 04:34:17.010310 | primary | changed: setting changed 2019-08-16 04:34:17.079321 | 2019-08-16 04:34:17.079718 | LOOP [mirror-workspace-git-repos : Synchronize src repos to workspace directory] 2019-08-16 04:34:18.878655 | primary -> localhost | To git+ssh://zuul@23.253.164.73:22//home/zuul/src/opendev.org/openstack/python-tripleoclient 2019-08-16 04:34:18.879544 | primary -> localhost | cf334f9..5a66fe5 master -> master 2019-08-16 04:34:18.879720 | primary -> localhost | * [new branch] stable/ocata -> stable/ocata 2019-08-16 04:34:18.879889 | primary -> localhost | * [new branch] stable/pike -> stable/pike 2019-08-16 04:34:18.880055 | primary -> localhost | * [new branch] stable/queens -> stable/queens 2019-08-16 04:34:18.880220 | primary -> localhost | * [new branch] stable/rocky -> stable/rocky 2019-08-16 04:34:18.880387 | primary -> localhost | * [new branch] stable/stein -> stable/stein 2019-08-16 04:34:18.880554 | primary -> localhost | * [new branch] origin/HEAD -> origin/HEAD 2019-08-16 04:34:18.880721 | primary -> localhost | * [new branch] origin/master -> origin/master 2019-08-16 04:34:18.880890 | primary -> localhost | * [new branch] origin/stable/ocata -> origin/stable/ocata 2019-08-16 04:34:18.881066 | primary -> localhost | * [new branch] origin/stable/pike -> origin/stable/pike 2019-08-16 04:34:18.881195 | primary -> localhost | * [new branch] origin/stable/queens -> origin/stable/queens 2019-08-16 04:34:18.881306 | primary -> localhost | * [new branch] origin/stable/rocky -> origin/stable/rocky 2019-08-16 04:34:18.881414 | primary -> localhost | * [new branch] origin/stable/stein -> origin/stable/stein 2019-08-16 04:34:18.881547 | primary -> localhost | To git+ssh://zuul@23.253.164.73:22//home/zuul/src/opendev.org/openstack/python-tripleoclient 2019-08-16 04:34:18.881701 | primary -> localhost | cf334f9..5a66fe5 master -> master 2019-08-16 04:34:18.881811 | primary -> localhost | * [new branch] stable/ocata -> stable/ocata 2019-08-16 04:34:18.881918 | primary -> localhost | * [new branch] stable/pike -> stable/pike 2019-08-16 04:34:18.882025 | primary -> localhost | * [new branch] stable/queens -> stable/queens 2019-08-16 04:34:18.882131 | primary -> localhost | * [new branch] stable/rocky -> stable/rocky 2019-08-16 04:34:18.882236 | primary -> localhost | * [new branch] stable/stein -> stable/stein 2019-08-16 04:34:18.882341 | primary -> localhost | * [new branch] origin/HEAD -> origin/HEAD 2019-08-16 04:34:18.882447 | primary -> localhost | * [new branch] origin/master -> origin/master 2019-08-16 04:34:18.882552 | primary -> localhost | * [new branch] origin/stable/ocata -> origin/stable/ocata 2019-08-16 04:34:18.882658 | primary -> localhost | * [new branch] origin/stable/pike -> origin/stable/pike 2019-08-16 04:34:18.882764 | primary -> localhost | * [new branch] origin/stable/queens -> origin/stable/queens 2019-08-16 04:34:18.882869 | primary -> localhost | * [new branch] origin/stable/rocky -> origin/stable/rocky 2019-08-16 04:34:18.882974 | primary -> localhost | * [new branch] origin/stable/stein -> origin/stable/stein 2019-08-16 04:34:18.883137 | primary -> localhost | ok: Item: Runtime: 0:00:01.468530 2019-08-16 04:34:18.883295 | primary -> localhost | changed: All items complete 2019-08-16 04:34:18.883396 | 2019-08-16 04:34:20.379702 | primary -> localhost | To git+ssh://zuul@23.253.164.73:22//home/zuul/src/opendev.org/openstack/tripleo-upgrade 2019-08-16 04:34:20.379941 | primary -> localhost | * [new branch] stable/pike -> stable/pike 2019-08-16 04:34:20.380062 | primary -> localhost | * [new branch] stable/queens -> stable/queens 2019-08-16 04:34:20.380178 | primary -> localhost | * [new branch] stable/rocky -> stable/rocky 2019-08-16 04:34:20.380309 | primary -> localhost | * [new branch] stable/stein -> stable/stein 2019-08-16 04:34:20.380419 | primary -> localhost | * [new branch] origin/HEAD -> origin/HEAD 2019-08-16 04:34:20.380526 | primary -> localhost | * [new branch] origin/master -> origin/master 2019-08-16 04:34:20.380632 | primary -> localhost | * [new branch] origin/stable/pike -> origin/stable/pike 2019-08-16 04:34:20.380739 | primary -> localhost | * [new branch] origin/stable/queens -> origin/stable/queens 2019-08-16 04:34:20.380845 | primary -> localhost | * [new branch] origin/stable/rocky -> origin/stable/rocky 2019-08-16 04:34:20.380950 | primary -> localhost | * [new branch] origin/stable/stein -> origin/stable/stein 2019-08-16 04:34:20.381068 | primary -> localhost | To git+ssh://zuul@23.253.164.73:22//home/zuul/src/opendev.org/openstack/tripleo-upgrade 2019-08-16 04:34:20.381177 | primary -> localhost | * [new branch] stable/pike -> stable/pike 2019-08-16 04:34:20.381283 | primary -> localhost | * [new branch] stable/queens -> stable/queens 2019-08-16 04:34:20.381389 | primary -> localhost | * [new branch] stable/rocky -> stable/rocky 2019-08-16 04:34:20.381494 | primary -> localhost | * [new branch] stable/stein -> stable/stein 2019-08-16 04:34:20.381640 | primary -> localhost | * [new branch] origin/HEAD -> origin/HEAD 2019-08-16 04:34:20.381747 | primary -> localhost | * [new branch] origin/master -> origin/master 2019-08-16 04:34:20.381853 | primary -> localhost | * [new branch] origin/stable/pike -> origin/stable/pike 2019-08-16 04:34:20.381958 | primary -> localhost | * [new branch] origin/stable/queens -> origin/stable/queens 2019-08-16 04:34:20.382062 | primary -> localhost | * [new branch] origin/stable/rocky -> origin/stable/rocky 2019-08-16 04:34:20.382167 | primary -> localhost | * [new branch] origin/stable/stein -> origin/stable/stein 2019-08-16 04:34:20.382300 | primary -> localhost | ok: Item: Runtime: 0:00:01.264417 2019-08-16 04:34:21.400234 | primary -> localhost | To git+ssh://zuul@23.253.164.73:22//home/zuul/src/opendev.org/openstack/tripleo-ci 2019-08-16 04:34:21.400565 | primary -> localhost | 9467a1b..512bed3 master -> master 2019-08-16 04:34:21.400757 | primary -> localhost | * [new branch] origin/HEAD -> origin/HEAD 2019-08-16 04:34:21.400942 | primary -> localhost | * [new branch] origin/master -> origin/master 2019-08-16 04:34:21.401179 | primary -> localhost | To git+ssh://zuul@23.253.164.73:22//home/zuul/src/opendev.org/openstack/tripleo-ci 2019-08-16 04:34:21.401363 | primary -> localhost | 9467a1b..512bed3 master -> master 2019-08-16 04:34:21.401543 | primary -> localhost | * [new branch] origin/HEAD -> origin/HEAD 2019-08-16 04:34:21.401751 | primary -> localhost | * [new branch] origin/master -> origin/master 2019-08-16 04:34:21.401976 | primary -> localhost | ok: Item: Runtime: 0:00:00.780277 2019-08-16 04:34:22.422386 | primary -> localhost | To git+ssh://zuul@23.253.164.73:22//home/zuul/src/opendev.org/openstack/tripleo-repos 2019-08-16 04:34:22.422630 | primary -> localhost | * [new branch] origin/HEAD -> origin/HEAD 2019-08-16 04:34:22.422748 | primary -> localhost | * [new branch] origin/master -> origin/master 2019-08-16 04:34:22.422875 | primary -> localhost | To git+ssh://zuul@23.253.164.73:22//home/zuul/src/opendev.org/openstack/tripleo-repos 2019-08-16 04:34:22.422989 | primary -> localhost | * [new branch] origin/HEAD -> origin/HEAD 2019-08-16 04:34:22.423101 | primary -> localhost | * [new branch] origin/master -> origin/master 2019-08-16 04:34:22.423238 | primary -> localhost | ok: Item: Runtime: 0:00:00.783028 2019-08-16 04:34:23.924899 | primary -> localhost | To git+ssh://zuul@23.253.164.73:22//home/zuul/src/opendev.org/openstack/kolla 2019-08-16 04:34:23.925171 | primary -> localhost | * [new branch] stable/ocata -> stable/ocata 2019-08-16 04:34:23.925327 | primary -> localhost | * [new branch] stable/pike -> stable/pike 2019-08-16 04:34:23.925492 | primary -> localhost | * [new branch] stable/queens -> stable/queens 2019-08-16 04:34:23.925673 | primary -> localhost | * [new branch] stable/rocky -> stable/rocky 2019-08-16 04:34:23.925823 | primary -> localhost | * [new branch] stable/stein -> stable/stein 2019-08-16 04:34:23.925970 | primary -> localhost | * [new branch] origin/HEAD -> origin/HEAD 2019-08-16 04:34:23.926117 | primary -> localhost | * [new branch] origin/master -> origin/master 2019-08-16 04:34:23.926263 | primary -> localhost | * [new branch] origin/stable/ocata -> origin/stable/ocata 2019-08-16 04:34:23.926418 | primary -> localhost | * [new branch] origin/stable/pike -> origin/stable/pike 2019-08-16 04:34:23.926567 | primary -> localhost | * [new branch] origin/stable/queens -> origin/stable/queens 2019-08-16 04:34:23.926711 | primary -> localhost | * [new branch] origin/stable/rocky -> origin/stable/rocky 2019-08-16 04:34:23.926853 | primary -> localhost | * [new branch] origin/stable/stein -> origin/stable/stein 2019-08-16 04:34:23.927007 | primary -> localhost | To git+ssh://zuul@23.253.164.73:22//home/zuul/src/opendev.org/openstack/kolla 2019-08-16 04:34:23.927149 | primary -> localhost | * [new branch] stable/ocata -> stable/ocata 2019-08-16 04:34:23.927287 | primary -> localhost | * [new branch] stable/pike -> stable/pike 2019-08-16 04:34:23.927436 | primary -> localhost | * [new branch] stable/queens -> stable/queens 2019-08-16 04:34:23.927573 | primary -> localhost | * [new branch] stable/rocky -> stable/rocky 2019-08-16 04:34:23.927716 | primary -> localhost | * [new branch] stable/stein -> stable/stein 2019-08-16 04:34:23.927858 | primary -> localhost | * [new branch] origin/HEAD -> origin/HEAD 2019-08-16 04:34:23.928002 | primary -> localhost | * [new branch] origin/master -> origin/master 2019-08-16 04:34:23.928144 | primary -> localhost | * [new branch] origin/stable/ocata -> origin/stable/ocata 2019-08-16 04:34:23.928287 | primary -> localhost | * [new branch] origin/stable/pike -> origin/stable/pike 2019-08-16 04:34:23.928431 | primary -> localhost | * [new branch] origin/stable/queens -> origin/stable/queens 2019-08-16 04:34:23.928574 | primary -> localhost | * [new branch] origin/stable/rocky -> origin/stable/rocky 2019-08-16 04:34:23.928722 | primary -> localhost | * [new branch] origin/stable/stein -> origin/stable/stein 2019-08-16 04:34:23.928902 | primary -> localhost | ok: Item: Runtime: 0:00:01.270720 2019-08-16 04:34:24.947883 | primary -> localhost | To git+ssh://zuul@23.253.164.73:22//home/zuul/src/opendev.org/openstack/ansible-role-python_venv_build 2019-08-16 04:34:24.948145 | primary -> localhost | * [new branch] stable/rocky -> stable/rocky 2019-08-16 04:34:24.948265 | primary -> localhost | * [new branch] stable/stein -> stable/stein 2019-08-16 04:34:24.948380 | primary -> localhost | * [new branch] origin/HEAD -> origin/HEAD 2019-08-16 04:34:24.948492 | primary -> localhost | * [new branch] origin/master -> origin/master 2019-08-16 04:34:24.948602 | primary -> localhost | * [new branch] origin/stable/rocky -> origin/stable/rocky 2019-08-16 04:34:24.948736 | primary -> localhost | * [new branch] origin/stable/stein -> origin/stable/stein 2019-08-16 04:34:24.948885 | primary -> localhost | To git+ssh://zuul@23.253.164.73:22//home/zuul/src/opendev.org/openstack/ansible-role-python_venv_build 2019-08-16 04:34:24.948997 | primary -> localhost | * [new branch] stable/rocky -> stable/rocky 2019-08-16 04:34:24.949103 | primary -> localhost | * [new branch] stable/stein -> stable/stein 2019-08-16 04:34:24.949210 | primary -> localhost | * [new branch] origin/HEAD -> origin/HEAD 2019-08-16 04:34:24.949316 | primary -> localhost | * [new branch] origin/master -> origin/master 2019-08-16 04:34:24.949430 | primary -> localhost | * [new branch] origin/stable/rocky -> origin/stable/rocky 2019-08-16 04:34:24.949579 | primary -> localhost | * [new branch] origin/stable/stein -> origin/stable/stein 2019-08-16 04:34:24.949728 | primary -> localhost | ok: Item: Runtime: 0:00:00.790405 2019-08-16 04:34:26.151024 | primary -> localhost | To git+ssh://zuul@23.253.164.73:22//home/zuul/src/opendev.org/openstack/tripleo-ha-utils 2019-08-16 04:34:26.151286 | primary -> localhost | * [new branch] develop -> develop 2019-08-16 04:34:26.151403 | primary -> localhost | * [new branch] origin/HEAD -> origin/HEAD 2019-08-16 04:34:26.151515 | primary -> localhost | * [new branch] origin/develop -> origin/develop 2019-08-16 04:34:26.151625 | primary -> localhost | * [new branch] origin/master -> origin/master 2019-08-16 04:34:26.151769 | primary -> localhost | To git+ssh://zuul@23.253.164.73:22//home/zuul/src/opendev.org/openstack/tripleo-ha-utils 2019-08-16 04:34:26.151880 | primary -> localhost | * [new branch] develop -> develop 2019-08-16 04:34:26.151996 | primary -> localhost | * [new branch] origin/HEAD -> origin/HEAD 2019-08-16 04:34:26.152103 | primary -> localhost | * [new branch] origin/develop -> origin/develop 2019-08-16 04:34:26.152210 | primary -> localhost | * [new branch] origin/master -> origin/master 2019-08-16 04:34:26.152342 | primary -> localhost | ok: Item: Runtime: 0:00:00.960595 2019-08-16 04:34:27.129880 | primary -> localhost | To git+ssh://zuul@23.253.164.73:22//home/zuul/src/opendev.org/x/browbeat 2019-08-16 04:34:27.130101 | primary -> localhost | 3d13705..c670032 master -> master 2019-08-16 04:34:27.130219 | primary -> localhost | * [new branch] origin/HEAD -> origin/HEAD 2019-08-16 04:34:27.130334 | primary -> localhost | * [new branch] origin/master -> origin/master 2019-08-16 04:34:27.130460 | primary -> localhost | To git+ssh://zuul@23.253.164.73:22//home/zuul/src/opendev.org/x/browbeat 2019-08-16 04:34:27.130572 | primary -> localhost | 3d13705..c670032 master -> master 2019-08-16 04:34:27.130682 | primary -> localhost | * [new branch] origin/HEAD -> origin/HEAD 2019-08-16 04:34:27.130791 | primary -> localhost | * [new branch] origin/master -> origin/master 2019-08-16 04:34:27.130923 | primary -> localhost | ok: Item: Runtime: 0:00:00.753419 2019-08-16 04:34:28.271625 | primary -> localhost | To git+ssh://zuul@23.253.164.73:22//home/zuul/src/opendev.org/openstack/tripleo-quickstart-extras 2019-08-16 04:34:28.271907 | primary -> localhost | * [new branch] origin/HEAD -> origin/HEAD 2019-08-16 04:34:28.272030 | primary -> localhost | * [new branch] origin/master -> origin/master 2019-08-16 04:34:28.272180 | primary -> localhost | To git+ssh://zuul@23.253.164.73:22//home/zuul/src/opendev.org/openstack/tripleo-quickstart-extras 2019-08-16 04:34:28.272324 | primary -> localhost | * [new branch] origin/HEAD -> origin/HEAD 2019-08-16 04:34:28.272438 | primary -> localhost | * [new branch] origin/master -> origin/master 2019-08-16 04:34:28.272577 | primary -> localhost | ok: Item: Runtime: 0:00:00.905049 2019-08-16 04:34:29.952334 | primary -> localhost | To git+ssh://zuul@23.253.164.73:22//home/zuul/src/opendev.org/openstack/tripleo-common 2019-08-16 04:34:29.952566 | primary -> localhost | 314917b..b993462 master -> master 2019-08-16 04:34:29.952684 | primary -> localhost | * [new branch] stable/ocata -> stable/ocata 2019-08-16 04:34:29.952796 | primary -> localhost | * [new branch] stable/pike -> stable/pike 2019-08-16 04:34:29.952906 | primary -> localhost | * [new branch] stable/queens -> stable/queens 2019-08-16 04:34:29.953014 | primary -> localhost | * [new branch] stable/rocky -> stable/rocky 2019-08-16 04:34:29.953121 | primary -> localhost | * [new branch] stable/stein -> stable/stein 2019-08-16 04:34:29.953226 | primary -> localhost | * [new branch] origin/master -> origin/master 2019-08-16 04:34:29.953332 | primary -> localhost | * [new branch] origin/stable/ocata -> origin/stable/ocata 2019-08-16 04:34:29.953455 | primary -> localhost | * [new branch] origin/stable/pike -> origin/stable/pike 2019-08-16 04:34:29.953591 | primary -> localhost | * [new branch] origin/stable/queens -> origin/stable/queens 2019-08-16 04:34:29.953700 | primary -> localhost | * [new branch] origin/stable/rocky -> origin/stable/rocky 2019-08-16 04:34:29.953806 | primary -> localhost | * [new branch] origin/stable/stein -> origin/stable/stein 2019-08-16 04:34:29.953924 | primary -> localhost | To git+ssh://zuul@23.253.164.73:22//home/zuul/src/opendev.org/openstack/tripleo-common 2019-08-16 04:34:29.954031 | primary -> localhost | 314917b..b993462 master -> master 2019-08-16 04:34:29.954136 | primary -> localhost | * [new branch] stable/ocata -> stable/ocata 2019-08-16 04:34:29.954240 | primary -> localhost | * [new branch] stable/pike -> stable/pike 2019-08-16 04:34:29.954345 | primary -> localhost | * [new branch] stable/queens -> stable/queens 2019-08-16 04:34:29.954449 | primary -> localhost | * [new branch] stable/rocky -> stable/rocky 2019-08-16 04:34:29.954552 | primary -> localhost | * [new branch] stable/stein -> stable/stein 2019-08-16 04:34:29.954656 | primary -> localhost | * [new branch] origin/master -> origin/master 2019-08-16 04:34:29.954760 | primary -> localhost | * [new branch] origin/stable/ocata -> origin/stable/ocata 2019-08-16 04:34:29.954864 | primary -> localhost | * [new branch] origin/stable/pike -> origin/stable/pike 2019-08-16 04:34:29.954968 | primary -> localhost | * [new branch] origin/stable/queens -> origin/stable/queens 2019-08-16 04:34:29.955072 | primary -> localhost | * [new branch] origin/stable/rocky -> origin/stable/rocky 2019-08-16 04:34:29.955175 | primary -> localhost | * [new branch] origin/stable/stein -> origin/stable/stein 2019-08-16 04:34:29.955305 | primary -> localhost | ok: Item: Runtime: 0:00:01.446005 2019-08-16 04:34:31.094596 | primary -> localhost | To git+ssh://zuul@23.253.164.73:22//home/zuul/src/opendev.org/openstack/openstack-ansible-os_tempest 2019-08-16 04:34:31.094881 | primary -> localhost | * [new branch] stable/ocata -> stable/ocata 2019-08-16 04:34:31.095085 | primary -> localhost | * [new branch] stable/pike -> stable/pike 2019-08-16 04:34:31.095266 | primary -> localhost | * [new branch] stable/queens -> stable/queens 2019-08-16 04:34:31.095413 | primary -> localhost | * [new branch] stable/rocky -> stable/rocky 2019-08-16 04:34:31.095526 | primary -> localhost | * [new branch] stable/stein -> stable/stein 2019-08-16 04:34:31.095636 | primary -> localhost | * [new branch] origin/HEAD -> origin/HEAD 2019-08-16 04:34:31.095745 | primary -> localhost | * [new branch] origin/master -> origin/master 2019-08-16 04:34:31.095858 | primary -> localhost | * [new branch] origin/stable/ocata -> origin/stable/ocata 2019-08-16 04:34:31.096014 | primary -> localhost | * [new branch] origin/stable/pike -> origin/stable/pike 2019-08-16 04:34:31.096176 | primary -> localhost | * [new branch] origin/stable/queens -> origin/stable/queens 2019-08-16 04:34:31.096287 | primary -> localhost | * [new branch] origin/stable/rocky -> origin/stable/rocky 2019-08-16 04:34:31.096393 | primary -> localhost | * [new branch] origin/stable/stein -> origin/stable/stein 2019-08-16 04:34:31.096513 | primary -> localhost | To git+ssh://zuul@23.253.164.73:22//home/zuul/src/opendev.org/openstack/openstack-ansible-os_tempest 2019-08-16 04:34:31.096621 | primary -> localhost | * [new branch] stable/ocata -> stable/ocata 2019-08-16 04:34:31.096727 | primary -> localhost | * [new branch] stable/pike -> stable/pike 2019-08-16 04:34:31.096833 | primary -> localhost | * [new branch] stable/queens -> stable/queens 2019-08-16 04:34:31.096950 | primary -> localhost | * [new branch] stable/rocky -> stable/rocky 2019-08-16 04:34:31.097120 | primary -> localhost | * [new branch] stable/stein -> stable/stein 2019-08-16 04:34:31.097272 | primary -> localhost | * [new branch] origin/HEAD -> origin/HEAD 2019-08-16 04:34:31.097380 | primary -> localhost | * [new branch] origin/master -> origin/master 2019-08-16 04:34:31.097484 | primary -> localhost | * [new branch] origin/stable/ocata -> origin/stable/ocata 2019-08-16 04:34:31.097699 | primary -> localhost | * [new branch] origin/stable/pike -> origin/stable/pike 2019-08-16 04:34:31.097806 | primary -> localhost | * [new branch] origin/stable/queens -> origin/stable/queens 2019-08-16 04:34:31.097973 | primary -> localhost | * [new branch] origin/stable/rocky -> origin/stable/rocky 2019-08-16 04:34:31.098106 | primary -> localhost | * [new branch] origin/stable/stein -> origin/stable/stein 2019-08-16 04:34:31.098243 | primary -> localhost | ok: Item: Runtime: 0:00:00.904094 2019-08-16 04:34:32.290435 | primary -> localhost | To git+ssh://zuul@23.253.164.73:22//home/zuul/src/opendev.org/openstack/tripleo-quickstart 2019-08-16 04:34:32.290673 | primary -> localhost | * [new branch] tqmerge -> tqmerge 2019-08-16 04:34:32.290790 | primary -> localhost | * [new branch] origin/HEAD -> origin/HEAD 2019-08-16 04:34:32.290902 | primary -> localhost | * [new branch] origin/master -> origin/master 2019-08-16 04:34:32.291013 | primary -> localhost | * [new branch] origin/tqmerge -> origin/tqmerge 2019-08-16 04:34:32.291136 | primary -> localhost | To git+ssh://zuul@23.253.164.73:22//home/zuul/src/opendev.org/openstack/tripleo-quickstart 2019-08-16 04:34:32.291248 | primary -> localhost | * [new branch] tqmerge -> tqmerge 2019-08-16 04:34:32.291356 | primary -> localhost | * [new branch] origin/HEAD -> origin/HEAD 2019-08-16 04:34:32.291463 | primary -> localhost | * [new branch] origin/master -> origin/master 2019-08-16 04:34:32.291568 | primary -> localhost | * [new branch] origin/tqmerge -> origin/tqmerge 2019-08-16 04:34:32.291699 | primary -> localhost | ok: Item: Runtime: 0:00:00.968311 2019-08-16 04:34:33.257871 | primary -> localhost | To git+ssh://zuul@23.253.164.73:22//home/zuul/src/opendev.org/openstack/ansible-config_template 2019-08-16 04:34:33.258118 | primary -> localhost | * [new branch] origin/HEAD -> origin/HEAD 2019-08-16 04:34:33.258237 | primary -> localhost | * [new branch] origin/master -> origin/master 2019-08-16 04:34:33.258399 | primary -> localhost | To git+ssh://zuul@23.253.164.73:22//home/zuul/src/opendev.org/openstack/ansible-config_template 2019-08-16 04:34:33.258519 | primary -> localhost | * [new branch] origin/HEAD -> origin/HEAD 2019-08-16 04:34:33.258632 | primary -> localhost | * [new branch] origin/master -> origin/master 2019-08-16 04:34:33.258771 | primary -> localhost | ok: Item: Runtime: 0:00:00.744497 2019-08-16 04:34:34.257624 | primary -> localhost | To git+ssh://zuul@23.253.164.73:22//home/zuul/src/opendev.org/openstack/ansible-role-collect-logs 2019-08-16 04:34:34.257889 | primary -> localhost | 9dc533d..4bef161 master -> master 2019-08-16 04:34:34.258008 | primary -> localhost | * [new branch] origin/HEAD -> origin/HEAD 2019-08-16 04:34:34.258122 | primary -> localhost | * [new branch] origin/master -> origin/master 2019-08-16 04:34:34.258246 | primary -> localhost | To git+ssh://zuul@23.253.164.73:22//home/zuul/src/opendev.org/openstack/ansible-role-collect-logs 2019-08-16 04:34:34.258359 | primary -> localhost | 9dc533d..4bef161 master -> master 2019-08-16 04:34:34.258498 | primary -> localhost | * [new branch] origin/HEAD -> origin/HEAD 2019-08-16 04:34:34.258667 | primary -> localhost | * [new branch] origin/master -> origin/master 2019-08-16 04:34:34.258808 | primary -> localhost | ok: Item: Runtime: 0:00:00.771886 2019-08-16 04:34:35.399546 | primary -> localhost | To git+ssh://zuul@23.253.164.73:22//home/zuul/src/opendev.org/openstack/openstack-virtual-baremetal 2019-08-16 04:34:35.399788 | primary -> localhost | * [new branch] stable/1.0 -> stable/1.0 2019-08-16 04:34:35.399909 | primary -> localhost | * [new branch] origin/HEAD -> origin/HEAD 2019-08-16 04:34:35.400041 | primary -> localhost | * [new branch] origin/master -> origin/master 2019-08-16 04:34:35.400157 | primary -> localhost | * [new branch] origin/stable/1.0 -> origin/stable/1.0 2019-08-16 04:34:35.400286 | primary -> localhost | To git+ssh://zuul@23.253.164.73:22//home/zuul/src/opendev.org/openstack/openstack-virtual-baremetal 2019-08-16 04:34:35.400398 | primary -> localhost | * [new branch] stable/1.0 -> stable/1.0 2019-08-16 04:34:35.400506 | primary -> localhost | * [new branch] origin/HEAD -> origin/HEAD 2019-08-16 04:34:35.400612 | primary -> localhost | * [new branch] origin/master -> origin/master 2019-08-16 04:34:35.400718 | primary -> localhost | * [new branch] origin/stable/1.0 -> origin/stable/1.0 2019-08-16 04:34:35.400850 | primary -> localhost | ok: Item: Runtime: 0:00:00.911674 2019-08-16 04:34:36.602320 | primary -> localhost | To git+ssh://zuul@23.253.164.73:22//home/zuul/src/opendev.org/openstack/ansible-role-container-registry 2019-08-16 04:34:36.602563 | primary -> localhost | * [new branch] origin/HEAD -> origin/HEAD 2019-08-16 04:34:36.602684 | primary -> localhost | * [new branch] origin/master -> origin/master 2019-08-16 04:34:36.602813 | primary -> localhost | To git+ssh://zuul@23.253.164.73:22//home/zuul/src/opendev.org/openstack/ansible-role-container-registry 2019-08-16 04:34:36.602929 | primary -> localhost | * [new branch] origin/HEAD -> origin/HEAD 2019-08-16 04:34:36.603042 | primary -> localhost | * [new branch] origin/master -> origin/master 2019-08-16 04:34:36.603180 | primary -> localhost | ok: Item: Runtime: 0:00:00.973029 2019-08-16 04:34:38.761107 | primary -> localhost | To git+ssh://zuul@23.253.164.73:22//home/zuul/src/opendev.org/openstack/requirements 2019-08-16 04:34:38.761416 | primary -> localhost | * [new branch] stable/newton -> stable/newton 2019-08-16 04:34:38.761598 | primary -> localhost | * [new branch] stable/ocata -> stable/ocata 2019-08-16 04:34:38.762755 | primary -> localhost | * [new branch] stable/pike -> stable/pike 2019-08-16 04:34:38.762879 | primary -> localhost | * [new branch] stable/queens -> stable/queens 2019-08-16 04:34:38.762991 | primary -> localhost | * [new branch] stable/rocky -> stable/rocky 2019-08-16 04:34:38.763101 | primary -> localhost | * [new branch] stable/stein -> stable/stein 2019-08-16 04:34:38.763209 | primary -> localhost | * [new branch] origin/HEAD -> origin/HEAD 2019-08-16 04:34:38.763316 | primary -> localhost | * [new branch] origin/master -> origin/master 2019-08-16 04:34:38.763425 | primary -> localhost | * [new branch] origin/stable/newton -> origin/stable/newton 2019-08-16 04:34:38.763532 | primary -> localhost | * [new branch] origin/stable/ocata -> origin/stable/ocata 2019-08-16 04:34:38.763638 | primary -> localhost | * [new branch] origin/stable/pike -> origin/stable/pike 2019-08-16 04:34:38.763745 | primary -> localhost | * [new branch] origin/stable/queens -> origin/stable/queens 2019-08-16 04:34:38.763889 | primary -> localhost | * [new branch] origin/stable/rocky -> origin/stable/rocky 2019-08-16 04:34:38.764001 | primary -> localhost | * [new branch] origin/stable/stein -> origin/stable/stein 2019-08-16 04:34:38.764121 | primary -> localhost | To git+ssh://zuul@23.253.164.73:22//home/zuul/src/opendev.org/openstack/requirements 2019-08-16 04:34:38.764232 | primary -> localhost | * [new branch] stable/newton -> stable/newton 2019-08-16 04:34:38.764339 | primary -> localhost | * [new branch] stable/ocata -> stable/ocata 2019-08-16 04:34:38.764445 | primary -> localhost | * [new branch] stable/pike -> stable/pike 2019-08-16 04:34:38.764550 | primary -> localhost | * [new branch] stable/queens -> stable/queens 2019-08-16 04:34:38.764656 | primary -> localhost | * [new branch] stable/rocky -> stable/rocky 2019-08-16 04:34:38.764761 | primary -> localhost | * [new branch] stable/stein -> stable/stein 2019-08-16 04:34:38.764883 | primary -> localhost | * [new branch] origin/HEAD -> origin/HEAD 2019-08-16 04:34:38.764989 | primary -> localhost | * [new branch] origin/master -> origin/master 2019-08-16 04:34:38.765094 | primary -> localhost | * [new branch] origin/stable/newton -> origin/stable/newton 2019-08-16 04:34:38.765199 | primary -> localhost | * [new branch] origin/stable/ocata -> origin/stable/ocata 2019-08-16 04:34:38.765304 | primary -> localhost | * [new branch] origin/stable/pike -> origin/stable/pike 2019-08-16 04:34:38.765408 | primary -> localhost | * [new branch] origin/stable/queens -> origin/stable/queens 2019-08-16 04:34:38.765513 | primary -> localhost | * [new branch] origin/stable/rocky -> origin/stable/rocky 2019-08-16 04:34:38.765648 | primary -> localhost | * [new branch] origin/stable/stein -> origin/stable/stein 2019-08-16 04:34:38.765783 | primary -> localhost | ok: Item: Runtime: 0:00:01.922615 2019-08-16 04:34:38.827242 | 2019-08-16 04:34:38.827517 | LOOP [mirror-workspace-git-repos : Update remote repository state correctly] 2019-08-16 04:34:39.416742 | primary | HEAD is now at 5a66fe5 Merge "update constraints url" 2019-08-16 04:34:39.417387 | primary | Already on 'master' 2019-08-16 04:34:39.417504 | primary | opendev.org/openstack/python-tripleoclient checked out to: 2019-08-16 04:34:39.417640 | primary | 5a66fe5446809a62efb9f1bf5d9a60903a10fd33 Merge "update constraints url" 2019-08-16 04:34:39.417824 | primary | ok: Item: Runtime: 0:00:00.051375 2019-08-16 04:34:39.723458 | primary | HEAD is now at 615c05b Merge "Adapt nic templates play for Rocky to Stein upgrade." 2019-08-16 04:34:39.723670 | primary | Already on 'master' 2019-08-16 04:34:39.723783 | primary | opendev.org/openstack/tripleo-upgrade checked out to: 2019-08-16 04:34:39.723890 | primary | 615c05b52965cd4b2cbbf8ab5ee0efca06cdb59a Merge "Adapt nic templates play for Rocky to Stein upgrade." 2019-08-16 04:34:39.724030 | primary | ok: Item: Runtime: 0:00:00.028387 2019-08-16 04:34:40.007295 | primary | HEAD is now at 512bed3 Merge "Dump all hostvars to files" 2019-08-16 04:34:40.007509 | primary | Already on 'master' 2019-08-16 04:34:40.007622 | primary | opendev.org/openstack/tripleo-ci checked out to: 2019-08-16 04:34:40.007730 | primary | 512bed38ced2528903162295e5b2e663f6bcc5fe Merge "Dump all hostvars to files" 2019-08-16 04:34:40.007867 | primary | ok: Item: Runtime: 0:00:00.037262 2019-08-16 04:34:40.268371 | primary | HEAD is now at 1cf6e0b Merge "Add Python 3 Train unit tests" 2019-08-16 04:34:40.268589 | primary | Already on 'master' 2019-08-16 04:34:40.268702 | primary | opendev.org/openstack/tripleo-repos checked out to: 2019-08-16 04:34:40.268810 | primary | 1cf6e0b7173f6a07ed0f7c7a31843428bd87d33d Merge "Add Python 3 Train unit tests" 2019-08-16 04:34:40.268951 | primary | ok: Item: Runtime: 0:00:00.022418 2019-08-16 04:34:40.665113 | primary | HEAD is now at 0ffd3ae Merge "Ensures monasca-thresh data and worker dirs exist and are empty on start up" 2019-08-16 04:34:40.665375 | primary | Already on 'master' 2019-08-16 04:34:40.665524 | primary | opendev.org/openstack/kolla checked out to: 2019-08-16 04:34:40.665668 | primary | 0ffd3aefda90fd7206f4b0989ff17ace414423fe Merge "Ensures monasca-thresh data and worker dirs exist and are empty on start up" 2019-08-16 04:34:40.665824 | primary | ok: Item: Runtime: 0:00:00.086748 2019-08-16 04:34:40.926839 | primary | HEAD is now at 3e86352 Merge "Updated from OpenStack Ansible Tests" 2019-08-16 04:34:40.927075 | primary | Already on 'master' 2019-08-16 04:34:40.927190 | primary | opendev.org/openstack/ansible-role-python_venv_build checked out to: 2019-08-16 04:34:40.927299 | primary | 3e86352fb464780962beda8476eb6c74a536a347 Merge "Updated from OpenStack Ansible Tests" 2019-08-16 04:34:40.927442 | primary | ok: Item: Runtime: 0:00:00.023372 2019-08-16 04:34:41.188148 | primary | HEAD is now at 8bb060b Replace '-' with '_' in fence_compute options. 2019-08-16 04:34:41.188388 | primary | Already on 'master' 2019-08-16 04:34:41.188528 | primary | opendev.org/openstack/tripleo-ha-utils checked out to: 2019-08-16 04:34:41.188684 | primary | 8bb060b864baa79d50d411683b4ad75c96de34b8 Replace '-' with '_' in fence_compute options. 2019-08-16 04:34:41.188838 | primary | ok: Item: Runtime: 0:00:00.027327 2019-08-16 04:34:41.494305 | primary | HEAD is now at c670032 Remove ansible check for inventory generation 2019-08-16 04:34:41.494519 | primary | Already on 'master' 2019-08-16 04:34:41.494632 | primary | opendev.org/x/browbeat checked out to: 2019-08-16 04:34:41.494740 | primary | c670032c252f7f9870cb8e455c1fc6daebd2236a Remove ansible check for inventory generation 2019-08-16 04:34:41.494882 | primary | ok: Item: Runtime: 0:00:00.055346 2019-08-16 04:34:41.797748 | primary | HEAD is now at dfe7238 Configure rhel container for tempest 2019-08-16 04:34:41.797994 | primary | Already on 'master' 2019-08-16 04:34:41.798108 | primary | opendev.org/openstack/tripleo-quickstart-extras checked out to: 2019-08-16 04:34:41.798216 | primary | dfe7238db1e2c2b6b2d33d449097affab9603c7f Configure rhel container for tempest 2019-08-16 04:34:41.798365 | primary | ok: Item: Runtime: 0:00:00.061518 2019-08-16 04:34:42.101800 | primary | HEAD is now at b993462 Merge commit 'refs/changes/47/676447/1' of ssh://review.opendev.org:29418/openstack/tripleo-common into HEAD 2019-08-16 04:34:42.102150 | primary | Already on 'master' 2019-08-16 04:34:42.102314 | primary | opendev.org/openstack/tripleo-common checked out to: 2019-08-16 04:34:42.102470 | primary | b9934627358842d2def32e0045ef37bdcf6581c6 Merge commit 'refs/changes/47/676447/1' of ssh://review.opendev.org:29418/openstack/tripleo-common into HEAD 2019-08-16 04:34:42.102689 | primary | ok: Item: Runtime: 0:00:00.059686 2019-08-16 04:34:42.365395 | primary | HEAD is now at 3640f71 Merge "Add mixed setup for debian based OS" 2019-08-16 04:34:42.365656 | primary | Already on 'master' 2019-08-16 04:34:42.365771 | primary | opendev.org/openstack/openstack-ansible-os_tempest checked out to: 2019-08-16 04:34:42.365880 | primary | 3640f71679368bd57aed129590bb07385908a1ff Merge "Add mixed setup for debian based OS" 2019-08-16 04:34:42.366024 | primary | ok: Item: Runtime: 0:00:00.024723 2019-08-16 04:34:42.658406 | primary | HEAD is now at ec61b56 Use py3 firstly in running get-overcloud-nodes 2019-08-16 04:34:42.658679 | primary | Already on 'master' 2019-08-16 04:34:42.658795 | primary | opendev.org/openstack/tripleo-quickstart checked out to: 2019-08-16 04:34:42.658904 | primary | ec61b56821b867b167dbabf0554df37bb9437258 Use py3 firstly in running get-overcloud-nodes 2019-08-16 04:34:42.659054 | primary | ok: Item: Runtime: 0:00:00.049712 2019-08-16 04:34:42.930416 | primary | HEAD is now at ffc97df Merge "Add the ability to parse list only files" 2019-08-16 04:34:42.930659 | primary | Already on 'master' 2019-08-16 04:34:42.930792 | primary | opendev.org/openstack/ansible-config_template checked out to: 2019-08-16 04:34:42.930903 | primary | ffc97df5d3b54c01ec734da1614e4dc6c1dbf3ae Merge "Add the ability to parse list only files" 2019-08-16 04:34:42.931039 | primary | ok: Item: Runtime: 0:00:00.027111 2019-08-16 04:34:43.194215 | primary | HEAD is now at 4bef161 Split the collect logs task 2019-08-16 04:34:43.194441 | primary | Already on 'master' 2019-08-16 04:34:43.194554 | primary | opendev.org/openstack/ansible-role-collect-logs checked out to: 2019-08-16 04:34:43.194662 | primary | 4bef1611b51d5f55285c9e38f56e724d31ebba18 Split the collect logs task 2019-08-16 04:34:43.194805 | primary | ok: Item: Runtime: 0:00:00.027358 2019-08-16 04:34:43.669248 | primary | HEAD is now at b5b7791 Add embedded iPXE script to retry 2019-08-16 04:34:43.669460 | primary | Switched to branch 'stable/1.0' 2019-08-16 04:34:43.669593 | primary | opendev.org/openstack/openstack-virtual-baremetal checked out to: 2019-08-16 04:34:43.669706 | primary | 07debc3613d83dca8c4981b0cd1c760c4a496ec6 Removed deprecated --centos-mirror param 2019-08-16 04:34:43.669844 | primary | ok: Item: Runtime: 0:00:00.241269 2019-08-16 04:34:43.960689 | primary | HEAD is now at 884a8f6 Specify a default for container_registry_logins 2019-08-16 04:34:43.960916 | primary | Already on 'master' 2019-08-16 04:34:43.961711 | primary | opendev.org/openstack/ansible-role-container-registry checked out to: 2019-08-16 04:34:43.961826 | primary | 884a8f6f1b45166a79a4eafbec2eb5156eff9eb4 Specify a default for container_registry_logins 2019-08-16 04:34:43.961965 | primary | ok: Item: Runtime: 0:00:00.025173 2019-08-16 04:34:44.233106 | primary | HEAD is now at 8112495 Merge "update constraint for openstacksdk to new release 0.34.0" 2019-08-16 04:34:44.233332 | primary | Already on 'master' 2019-08-16 04:34:44.233447 | primary | opendev.org/openstack/requirements checked out to: 2019-08-16 04:34:44.233603 | primary | 811249596c8502cc5acdc83798292dd1d9ac96ba Merge "update constraint for openstacksdk to new release 0.34.0" 2019-08-16 04:34:44.233748 | primary | ok: Item: Runtime: 0:00:00.026739 2019-08-16 04:34:44.280300 | 2019-08-16 04:34:44.280491 | TASK [mirror-info : Create /etc/ci] 2019-08-16 04:34:44.798040 | primary | changed 2019-08-16 04:34:44.839322 | 2019-08-16 04:34:44.839543 | TASK [mirror-info : Install ci_mirror script] 2019-08-16 04:34:46.356385 | primary | changed 2019-08-16 04:34:46.398188 | 2019-08-16 04:34:46.398422 | TASK [configure-mirrors : Set up infrastructure mirrors] 2019-08-16 04:34:46.491268 | primary | ok 2019-08-16 04:34:46.544709 | primary | included: /var/lib/zuul/builds/5b97af71f8734123988a6845338513b8/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/configure-mirrors/tasks/mirror.yaml 2019-08-16 04:34:46.566494 | 2019-08-16 04:34:46.566659 | TASK [configure-mirrors : Install .pydistutils.cfg configuration in homedir] 2019-08-16 04:34:48.074752 | primary | changed 2019-08-16 04:34:48.112436 | 2019-08-16 04:34:48.112654 | LOOP [configure-mirrors : Include OS-specific variables] 2019-08-16 04:34:48.317337 | primary | ok: "/var/lib/zuul/builds/5b97af71f8734123988a6845338513b8/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/configure-mirrors/vars/CentOS.yaml" 2019-08-16 04:34:48.317965 | primary | changed: All items complete 2019-08-16 04:34:48.318083 | 2019-08-16 04:34:48.359760 | 2019-08-16 04:34:48.360041 | TASK [configure-mirrors : Install /etc/pip.conf configuration] 2019-08-16 04:34:49.858160 | primary | changed 2019-08-16 04:34:49.896130 | 2019-08-16 04:34:49.896455 | LOOP [configure-mirrors : Setup distribution specific packaging mirrors] 2019-08-16 04:34:49.989292 | primary | ok: "/var/lib/zuul/builds/5b97af71f8734123988a6845338513b8/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/configure-mirrors/tasks/mirror/CentOS.yaml" 2019-08-16 04:34:50.043154 | primary | included: /var/lib/zuul/builds/5b97af71f8734123988a6845338513b8/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/configure-mirrors/tasks/mirror/CentOS.yaml 2019-08-16 04:34:50.066618 | 2019-08-16 04:34:50.066912 | LOOP [configure-mirrors : Install CentOS repository files] 2019-08-16 04:34:51.604151 | primary | changed: "etc/yum.repos.d/CentOS-Base.repo" 2019-08-16 04:34:51.604847 | primary | ok: All items complete 2019-08-16 04:34:51.604958 | 2019-08-16 04:34:52.893091 | primary | changed: "etc/yum.repos.d/epel.repo" 2019-08-16 04:34:52.945912 | 2019-08-16 04:34:52.946112 | TASK [configure-mirrors : Disable deltrarpm] 2019-08-16 04:34:53.694608 | primary | changed: option added 2019-08-16 04:34:53.718719 | 2019-08-16 04:34:53.718913 | LOOP [configure-mirrors : Update yum cache] 2019-08-16 04:34:54.695959 | primary | Loaded plugins: fastestmirror 2019-08-16 04:34:54.696637 | primary | Cleaning repos: base extras updates 2019-08-16 04:34:54.696753 | primary | Cleaning up list of fastest mirrors 2019-08-16 04:34:54.696861 | primary | Other repos take up 84 M of disk space (use --verbose for details) 2019-08-16 04:34:54.697041 | primary | ok: Item: yum clean all Runtime: 0:00:00.426610 2019-08-16 04:35:04.248896 | primary | Loaded plugins: fastestmirror 2019-08-16 04:35:04.249113 | primary | Determining fastest mirrors 2019-08-16 04:35:04.249243 | primary | Metadata Cache Created 2019-08-16 04:35:04.249385 | primary | ok: Item: yum makecache Runtime: 0:00:09.257008 2019-08-16 04:35:04.270719 | 2019-08-16 04:35:04.270877 | PLAY RECAP 2019-08-16 04:35:04.271015 | localhost | ok: 5 changed: 2 unreachable: 0 failed: 0 2019-08-16 04:35:04.271145 | primary | ok: 43 changed: 24 unreachable: 0 failed: 0 2019-08-16 04:35:04.271249 | 2019-08-16 04:35:04.741301 | PRE-RUN END RESULT_NORMAL: [trusted : opendev.org/opendev/base-jobs/playbooks/base/pre.yaml@master] 2019-08-16 04:35:04.741622 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/multinode/pre.yaml@master] 2019-08-16 04:35:08.230398 | 2019-08-16 04:35:08.230674 | PLAY [Configure a multi node environment] 2019-08-16 04:35:08.271488 | 2019-08-16 04:35:08.271767 | TASK [Set up multi-node known hosts] 2019-08-16 04:35:08.322448 | primary | ok 2019-08-16 04:35:08.432007 | 2019-08-16 04:35:08.432275 | TASK [multi-node-known-hosts : Get known_hosts facts] 2019-08-16 04:35:09.211450 | primary | ok 2019-08-16 04:35:09.257857 | 2019-08-16 04:35:09.258116 | LOOP [multi-node-known-hosts : add known_host record for every public key of every other ip, hostname for ansible_user] 2019-08-16 04:35:09.976874 | primary | changed: 2019-08-16 04:35:09.977475 | primary | { 2019-08-16 04:35:09.977617 | primary | "key": "10.210.64.162 ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBAhDrwMeddTjDFNWTcDwLFIFaQ9WFZ7CenZ5IUX5yi73kCHNHDwb1XKSMZyvsrkuAvP4MF7hJGg8q2JXLRJSiU8=", 2019-08-16 04:35:09.977735 | primary | "name": "10.210.64.162" 2019-08-16 04:35:09.977841 | primary | } 2019-08-16 04:35:10.229516 | primary | changed: 2019-08-16 04:35:10.229737 | primary | { 2019-08-16 04:35:10.229853 | primary | "key": "10.210.64.162 ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIByUis7bjnzUn+uzxxnqHuoPDUNRPizjPmZrfxSuB43d", 2019-08-16 04:35:10.229959 | primary | "name": "10.210.64.162" 2019-08-16 04:35:10.230062 | primary | } 2019-08-16 04:35:10.482987 | primary | changed: 2019-08-16 04:35:10.483240 | primary | { 2019-08-16 04:35:10.483355 | primary | "key": "10.210.64.162 ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC/m044QHGT57KSo8cEX+ixa/8lwVgQgiN1UH3tqVHIBTcTvNl4Qy1U0b+ticsDff8xnCabTo460KiSEkrjkcnWwvORbtLpaZ3ShQGpU+6AdTGvDE4xhFvMgkCDa8dsaDm174Xz2I+g9yITEc3PWLnk7CkeiZKxf/Q+NsqQ3Wbjat2mgEiwyPRCsH/KYZN8rbhMFLuL3cTUwizcw3YzbwNb9i1dGus6kYTtl5lpuCjlOsV7wBMItXNyKL1PNYy2tcacwkgN3Q3fYUUfFxrnYwxzSnSHt/9PY8UKl+kMwRw6rKnbbkHFRkV2TYqmrQK3kYDRwmvWDU673CVxTWM4/pz/", 2019-08-16 04:35:10.483467 | primary | "name": "10.210.64.162" 2019-08-16 04:35:10.483575 | primary | } 2019-08-16 04:35:10.728181 | primary | changed: 2019-08-16 04:35:10.728404 | primary | { 2019-08-16 04:35:10.728514 | primary | "key": "2001:4801:7825:103:be76:4eff:fe10:372 ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBAhDrwMeddTjDFNWTcDwLFIFaQ9WFZ7CenZ5IUX5yi73kCHNHDwb1XKSMZyvsrkuAvP4MF7hJGg8q2JXLRJSiU8=", 2019-08-16 04:35:10.728630 | primary | "name": "2001:4801:7825:103:be76:4eff:fe10:372" 2019-08-16 04:35:10.728733 | primary | } 2019-08-16 04:35:10.979524 | primary | changed: 2019-08-16 04:35:10.979722 | primary | { 2019-08-16 04:35:10.979836 | primary | "key": "2001:4801:7825:103:be76:4eff:fe10:372 ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIByUis7bjnzUn+uzxxnqHuoPDUNRPizjPmZrfxSuB43d", 2019-08-16 04:35:10.979947 | primary | "name": "2001:4801:7825:103:be76:4eff:fe10:372" 2019-08-16 04:35:10.980054 | primary | } 2019-08-16 04:35:11.221873 | primary | changed: 2019-08-16 04:35:11.222092 | primary | { 2019-08-16 04:35:11.222204 | primary | "key": "2001:4801:7825:103:be76:4eff:fe10:372 ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC/m044QHGT57KSo8cEX+ixa/8lwVgQgiN1UH3tqVHIBTcTvNl4Qy1U0b+ticsDff8xnCabTo460KiSEkrjkcnWwvORbtLpaZ3ShQGpU+6AdTGvDE4xhFvMgkCDa8dsaDm174Xz2I+g9yITEc3PWLnk7CkeiZKxf/Q+NsqQ3Wbjat2mgEiwyPRCsH/KYZN8rbhMFLuL3cTUwizcw3YzbwNb9i1dGus6kYTtl5lpuCjlOsV7wBMItXNyKL1PNYy2tcacwkgN3Q3fYUUfFxrnYwxzSnSHt/9PY8UKl+kMwRw6rKnbbkHFRkV2TYqmrQK3kYDRwmvWDU673CVxTWM4/pz/", 2019-08-16 04:35:11.222322 | primary | "name": "2001:4801:7825:103:be76:4eff:fe10:372" 2019-08-16 04:35:11.222445 | primary | } 2019-08-16 04:35:11.473467 | primary | changed: 2019-08-16 04:35:11.473737 | primary | { 2019-08-16 04:35:11.473855 | primary | "key": "23.253.164.73 ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBAhDrwMeddTjDFNWTcDwLFIFaQ9WFZ7CenZ5IUX5yi73kCHNHDwb1XKSMZyvsrkuAvP4MF7hJGg8q2JXLRJSiU8=", 2019-08-16 04:35:11.473966 | primary | "name": "23.253.164.73" 2019-08-16 04:35:11.474074 | primary | } 2019-08-16 04:35:11.735903 | primary | changed: 2019-08-16 04:35:11.736127 | primary | { 2019-08-16 04:35:11.736255 | primary | "key": "23.253.164.73 ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIByUis7bjnzUn+uzxxnqHuoPDUNRPizjPmZrfxSuB43d", 2019-08-16 04:35:11.736363 | primary | "name": "23.253.164.73" 2019-08-16 04:35:11.736469 | primary | } 2019-08-16 04:35:11.987710 | primary | changed: 2019-08-16 04:35:11.987910 | primary | { 2019-08-16 04:35:11.988021 | primary | "key": "23.253.164.73 ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC/m044QHGT57KSo8cEX+ixa/8lwVgQgiN1UH3tqVHIBTcTvNl4Qy1U0b+ticsDff8xnCabTo460KiSEkrjkcnWwvORbtLpaZ3ShQGpU+6AdTGvDE4xhFvMgkCDa8dsaDm174Xz2I+g9yITEc3PWLnk7CkeiZKxf/Q+NsqQ3Wbjat2mgEiwyPRCsH/KYZN8rbhMFLuL3cTUwizcw3YzbwNb9i1dGus6kYTtl5lpuCjlOsV7wBMItXNyKL1PNYy2tcacwkgN3Q3fYUUfFxrnYwxzSnSHt/9PY8UKl+kMwRw6rKnbbkHFRkV2TYqmrQK3kYDRwmvWDU673CVxTWM4/pz/", 2019-08-16 04:35:11.988128 | primary | "name": "23.253.164.73" 2019-08-16 04:35:11.988231 | primary | } 2019-08-16 04:35:12.228269 | primary | changed: 2019-08-16 04:35:12.228470 | primary | { 2019-08-16 04:35:12.228580 | primary | "key": "centos-7-rax-ord-0010221455 ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBAhDrwMeddTjDFNWTcDwLFIFaQ9WFZ7CenZ5IUX5yi73kCHNHDwb1XKSMZyvsrkuAvP4MF7hJGg8q2JXLRJSiU8=", 2019-08-16 04:35:12.228686 | primary | "name": "centos-7-rax-ord-0010221455" 2019-08-16 04:35:12.228789 | primary | } 2019-08-16 04:35:12.493201 | primary | changed: 2019-08-16 04:35:12.493402 | primary | { 2019-08-16 04:35:12.493533 | primary | "key": "centos-7-rax-ord-0010221455 ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIByUis7bjnzUn+uzxxnqHuoPDUNRPizjPmZrfxSuB43d", 2019-08-16 04:35:12.493673 | primary | "name": "centos-7-rax-ord-0010221455" 2019-08-16 04:35:12.493778 | primary | } 2019-08-16 04:35:12.755947 | primary | changed: 2019-08-16 04:35:12.756189 | primary | { 2019-08-16 04:35:12.756301 | primary | "key": "centos-7-rax-ord-0010221455 ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC/m044QHGT57KSo8cEX+ixa/8lwVgQgiN1UH3tqVHIBTcTvNl4Qy1U0b+ticsDff8xnCabTo460KiSEkrjkcnWwvORbtLpaZ3ShQGpU+6AdTGvDE4xhFvMgkCDa8dsaDm174Xz2I+g9yITEc3PWLnk7CkeiZKxf/Q+NsqQ3Wbjat2mgEiwyPRCsH/KYZN8rbhMFLuL3cTUwizcw3YzbwNb9i1dGus6kYTtl5lpuCjlOsV7wBMItXNyKL1PNYy2tcacwkgN3Q3fYUUfFxrnYwxzSnSHt/9PY8UKl+kMwRw6rKnbbkHFRkV2TYqmrQK3kYDRwmvWDU673CVxTWM4/pz/", 2019-08-16 04:35:12.756413 | primary | "name": "centos-7-rax-ord-0010221455" 2019-08-16 04:35:12.756520 | primary | } 2019-08-16 04:35:13.019896 | primary | changed: 2019-08-16 04:35:13.020103 | primary | { 2019-08-16 04:35:13.020230 | primary | "key": "fe80::be76:4eff:fe10:372 ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBAhDrwMeddTjDFNWTcDwLFIFaQ9WFZ7CenZ5IUX5yi73kCHNHDwb1XKSMZyvsrkuAvP4MF7hJGg8q2JXLRJSiU8=", 2019-08-16 04:35:13.020345 | primary | "name": "fe80::be76:4eff:fe10:372" 2019-08-16 04:35:13.020451 | primary | } 2019-08-16 04:35:13.284240 | primary | changed: 2019-08-16 04:35:13.284448 | primary | { 2019-08-16 04:35:13.284560 | primary | "key": "fe80::be76:4eff:fe10:372 ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIByUis7bjnzUn+uzxxnqHuoPDUNRPizjPmZrfxSuB43d", 2019-08-16 04:35:13.284667 | primary | "name": "fe80::be76:4eff:fe10:372" 2019-08-16 04:35:13.284772 | primary | } 2019-08-16 04:35:13.546332 | primary | changed: 2019-08-16 04:35:13.546534 | primary | { 2019-08-16 04:35:13.546644 | primary | "key": "fe80::be76:4eff:fe10:372 ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC/m044QHGT57KSo8cEX+ixa/8lwVgQgiN1UH3tqVHIBTcTvNl4Qy1U0b+ticsDff8xnCabTo460KiSEkrjkcnWwvORbtLpaZ3ShQGpU+6AdTGvDE4xhFvMgkCDa8dsaDm174Xz2I+g9yITEc3PWLnk7CkeiZKxf/Q+NsqQ3Wbjat2mgEiwyPRCsH/KYZN8rbhMFLuL3cTUwizcw3YzbwNb9i1dGus6kYTtl5lpuCjlOsV7wBMItXNyKL1PNYy2tcacwkgN3Q3fYUUfFxrnYwxzSnSHt/9PY8UKl+kMwRw6rKnbbkHFRkV2TYqmrQK3kYDRwmvWDU673CVxTWM4/pz/", 2019-08-16 04:35:13.546761 | primary | "name": "fe80::be76:4eff:fe10:372" 2019-08-16 04:35:13.546865 | primary | } 2019-08-16 04:35:13.808574 | primary | changed: 2019-08-16 04:35:13.808795 | primary | { 2019-08-16 04:35:13.808907 | primary | "key": "fe80::be76:4eff:fe10:376 ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBAhDrwMeddTjDFNWTcDwLFIFaQ9WFZ7CenZ5IUX5yi73kCHNHDwb1XKSMZyvsrkuAvP4MF7hJGg8q2JXLRJSiU8=", 2019-08-16 04:35:13.809014 | primary | "name": "fe80::be76:4eff:fe10:376" 2019-08-16 04:35:13.809117 | primary | } 2019-08-16 04:35:14.059814 | primary | changed: 2019-08-16 04:35:14.060034 | primary | { 2019-08-16 04:35:14.060142 | primary | "key": "fe80::be76:4eff:fe10:376 ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIByUis7bjnzUn+uzxxnqHuoPDUNRPizjPmZrfxSuB43d", 2019-08-16 04:35:14.060247 | primary | "name": "fe80::be76:4eff:fe10:376" 2019-08-16 04:35:14.060348 | primary | } 2019-08-16 04:35:14.313984 | primary | changed: 2019-08-16 04:35:14.314221 | primary | { 2019-08-16 04:35:14.314335 | primary | "key": "fe80::be76:4eff:fe10:376 ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC/m044QHGT57KSo8cEX+ixa/8lwVgQgiN1UH3tqVHIBTcTvNl4Qy1U0b+ticsDff8xnCabTo460KiSEkrjkcnWwvORbtLpaZ3ShQGpU+6AdTGvDE4xhFvMgkCDa8dsaDm174Xz2I+g9yITEc3PWLnk7CkeiZKxf/Q+NsqQ3Wbjat2mgEiwyPRCsH/KYZN8rbhMFLuL3cTUwizcw3YzbwNb9i1dGus6kYTtl5lpuCjlOsV7wBMItXNyKL1PNYy2tcacwkgN3Q3fYUUfFxrnYwxzSnSHt/9PY8UKl+kMwRw6rKnbbkHFRkV2TYqmrQK3kYDRwmvWDU673CVxTWM4/pz/", 2019-08-16 04:35:14.314448 | primary | "name": "fe80::be76:4eff:fe10:376" 2019-08-16 04:35:14.314554 | primary | } 2019-08-16 04:35:14.377343 | 2019-08-16 04:35:14.377695 | LOOP [multi-node-known-hosts : add default known_host record for every user] 2019-08-16 04:35:14.897831 | primary | changed: 2019-08-16 04:35:14.898456 | primary | { 2019-08-16 04:35:14.898572 | primary | "key": "10.210.64.162 ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBAhDrwMeddTjDFNWTcDwLFIFaQ9WFZ7CenZ5IUX5yi73kCHNHDwb1XKSMZyvsrkuAvP4MF7hJGg8q2JXLRJSiU8=", 2019-08-16 04:35:14.898689 | primary | "name": "10.210.64.162" 2019-08-16 04:35:14.898796 | primary | } 2019-08-16 04:35:14.898944 | primary | changed: All items complete 2019-08-16 04:35:14.899046 | 2019-08-16 04:35:15.194055 | primary | changed: 2019-08-16 04:35:15.194284 | primary | { 2019-08-16 04:35:15.194395 | primary | "key": "10.210.64.162 ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIByUis7bjnzUn+uzxxnqHuoPDUNRPizjPmZrfxSuB43d", 2019-08-16 04:35:15.194517 | primary | "name": "10.210.64.162" 2019-08-16 04:35:15.194622 | primary | } 2019-08-16 04:35:15.504114 | primary | changed: 2019-08-16 04:35:15.504351 | primary | { 2019-08-16 04:35:15.504464 | primary | "key": "10.210.64.162 ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC/m044QHGT57KSo8cEX+ixa/8lwVgQgiN1UH3tqVHIBTcTvNl4Qy1U0b+ticsDff8xnCabTo460KiSEkrjkcnWwvORbtLpaZ3ShQGpU+6AdTGvDE4xhFvMgkCDa8dsaDm174Xz2I+g9yITEc3PWLnk7CkeiZKxf/Q+NsqQ3Wbjat2mgEiwyPRCsH/KYZN8rbhMFLuL3cTUwizcw3YzbwNb9i1dGus6kYTtl5lpuCjlOsV7wBMItXNyKL1PNYy2tcacwkgN3Q3fYUUfFxrnYwxzSnSHt/9PY8UKl+kMwRw6rKnbbkHFRkV2TYqmrQK3kYDRwmvWDU673CVxTWM4/pz/", 2019-08-16 04:35:15.504594 | primary | "name": "10.210.64.162" 2019-08-16 04:35:15.504704 | primary | } 2019-08-16 04:35:15.796888 | primary | changed: 2019-08-16 04:35:15.797138 | primary | { 2019-08-16 04:35:15.797253 | primary | "key": "2001:4801:7825:103:be76:4eff:fe10:372 ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBAhDrwMeddTjDFNWTcDwLFIFaQ9WFZ7CenZ5IUX5yi73kCHNHDwb1XKSMZyvsrkuAvP4MF7hJGg8q2JXLRJSiU8=", 2019-08-16 04:35:15.797368 | primary | "name": "2001:4801:7825:103:be76:4eff:fe10:372" 2019-08-16 04:35:15.797473 | primary | } 2019-08-16 04:35:16.110467 | primary | changed: 2019-08-16 04:35:16.110701 | primary | { 2019-08-16 04:35:16.110813 | primary | "key": "2001:4801:7825:103:be76:4eff:fe10:372 ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIByUis7bjnzUn+uzxxnqHuoPDUNRPizjPmZrfxSuB43d", 2019-08-16 04:35:16.110934 | primary | "name": "2001:4801:7825:103:be76:4eff:fe10:372" 2019-08-16 04:35:16.111040 | primary | } 2019-08-16 04:35:16.412856 | primary | changed: 2019-08-16 04:35:16.413082 | primary | { 2019-08-16 04:35:16.413194 | primary | "key": "2001:4801:7825:103:be76:4eff:fe10:372 ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC/m044QHGT57KSo8cEX+ixa/8lwVgQgiN1UH3tqVHIBTcTvNl4Qy1U0b+ticsDff8xnCabTo460KiSEkrjkcnWwvORbtLpaZ3ShQGpU+6AdTGvDE4xhFvMgkCDa8dsaDm174Xz2I+g9yITEc3PWLnk7CkeiZKxf/Q+NsqQ3Wbjat2mgEiwyPRCsH/KYZN8rbhMFLuL3cTUwizcw3YzbwNb9i1dGus6kYTtl5lpuCjlOsV7wBMItXNyKL1PNYy2tcacwkgN3Q3fYUUfFxrnYwxzSnSHt/9PY8UKl+kMwRw6rKnbbkHFRkV2TYqmrQK3kYDRwmvWDU673CVxTWM4/pz/", 2019-08-16 04:35:16.413319 | primary | "name": "2001:4801:7825:103:be76:4eff:fe10:372" 2019-08-16 04:35:16.413424 | primary | } 2019-08-16 04:35:16.727524 | primary | changed: 2019-08-16 04:35:16.727744 | primary | { 2019-08-16 04:35:16.727856 | primary | "key": "23.253.164.73 ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBAhDrwMeddTjDFNWTcDwLFIFaQ9WFZ7CenZ5IUX5yi73kCHNHDwb1XKSMZyvsrkuAvP4MF7hJGg8q2JXLRJSiU8=", 2019-08-16 04:35:16.727963 | primary | "name": "23.253.164.73" 2019-08-16 04:35:16.728067 | primary | } 2019-08-16 04:35:17.030582 | primary | changed: 2019-08-16 04:35:17.030785 | primary | { 2019-08-16 04:35:17.030896 | primary | "key": "23.253.164.73 ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIByUis7bjnzUn+uzxxnqHuoPDUNRPizjPmZrfxSuB43d", 2019-08-16 04:35:17.031004 | primary | "name": "23.253.164.73" 2019-08-16 04:35:17.031107 | primary | } 2019-08-16 04:35:17.341889 | primary | changed: 2019-08-16 04:35:17.342090 | primary | { 2019-08-16 04:35:17.342202 | primary | "key": "23.253.164.73 ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC/m044QHGT57KSo8cEX+ixa/8lwVgQgiN1UH3tqVHIBTcTvNl4Qy1U0b+ticsDff8xnCabTo460KiSEkrjkcnWwvORbtLpaZ3ShQGpU+6AdTGvDE4xhFvMgkCDa8dsaDm174Xz2I+g9yITEc3PWLnk7CkeiZKxf/Q+NsqQ3Wbjat2mgEiwyPRCsH/KYZN8rbhMFLuL3cTUwizcw3YzbwNb9i1dGus6kYTtl5lpuCjlOsV7wBMItXNyKL1PNYy2tcacwkgN3Q3fYUUfFxrnYwxzSnSHt/9PY8UKl+kMwRw6rKnbbkHFRkV2TYqmrQK3kYDRwmvWDU673CVxTWM4/pz/", 2019-08-16 04:35:17.342310 | primary | "name": "23.253.164.73" 2019-08-16 04:35:17.342413 | primary | } 2019-08-16 04:35:17.634471 | primary | changed: 2019-08-16 04:35:17.634675 | primary | { 2019-08-16 04:35:17.634829 | primary | "key": "centos-7-rax-ord-0010221455 ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBAhDrwMeddTjDFNWTcDwLFIFaQ9WFZ7CenZ5IUX5yi73kCHNHDwb1XKSMZyvsrkuAvP4MF7hJGg8q2JXLRJSiU8=", 2019-08-16 04:35:17.634946 | primary | "name": "centos-7-rax-ord-0010221455" 2019-08-16 04:35:17.635051 | primary | } 2019-08-16 04:35:17.916927 | primary | changed: 2019-08-16 04:35:17.917142 | primary | { 2019-08-16 04:35:17.917254 | primary | "key": "centos-7-rax-ord-0010221455 ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIByUis7bjnzUn+uzxxnqHuoPDUNRPizjPmZrfxSuB43d", 2019-08-16 04:35:17.917361 | primary | "name": "centos-7-rax-ord-0010221455" 2019-08-16 04:35:17.917466 | primary | } 2019-08-16 04:35:18.229838 | primary | changed: 2019-08-16 04:35:18.230059 | primary | { 2019-08-16 04:35:18.230172 | primary | "key": "centos-7-rax-ord-0010221455 ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC/m044QHGT57KSo8cEX+ixa/8lwVgQgiN1UH3tqVHIBTcTvNl4Qy1U0b+ticsDff8xnCabTo460KiSEkrjkcnWwvORbtLpaZ3ShQGpU+6AdTGvDE4xhFvMgkCDa8dsaDm174Xz2I+g9yITEc3PWLnk7CkeiZKxf/Q+NsqQ3Wbjat2mgEiwyPRCsH/KYZN8rbhMFLuL3cTUwizcw3YzbwNb9i1dGus6kYTtl5lpuCjlOsV7wBMItXNyKL1PNYy2tcacwkgN3Q3fYUUfFxrnYwxzSnSHt/9PY8UKl+kMwRw6rKnbbkHFRkV2TYqmrQK3kYDRwmvWDU673CVxTWM4/pz/", 2019-08-16 04:35:18.230281 | primary | "name": "centos-7-rax-ord-0010221455" 2019-08-16 04:35:18.230385 | primary | } 2019-08-16 04:35:18.522414 | primary | changed: 2019-08-16 04:35:18.522633 | primary | { 2019-08-16 04:35:18.522744 | primary | "key": "fe80::be76:4eff:fe10:372 ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBAhDrwMeddTjDFNWTcDwLFIFaQ9WFZ7CenZ5IUX5yi73kCHNHDwb1XKSMZyvsrkuAvP4MF7hJGg8q2JXLRJSiU8=", 2019-08-16 04:35:18.522865 | primary | "name": "fe80::be76:4eff:fe10:372" 2019-08-16 04:35:18.522971 | primary | } 2019-08-16 04:35:18.817354 | primary | changed: 2019-08-16 04:35:18.817593 | primary | { 2019-08-16 04:35:18.817709 | primary | "key": "fe80::be76:4eff:fe10:372 ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIByUis7bjnzUn+uzxxnqHuoPDUNRPizjPmZrfxSuB43d", 2019-08-16 04:35:18.817816 | primary | "name": "fe80::be76:4eff:fe10:372" 2019-08-16 04:35:18.817919 | primary | } 2019-08-16 04:35:19.108782 | primary | changed: 2019-08-16 04:35:19.109002 | primary | { 2019-08-16 04:35:19.109113 | primary | "key": "fe80::be76:4eff:fe10:372 ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC/m044QHGT57KSo8cEX+ixa/8lwVgQgiN1UH3tqVHIBTcTvNl4Qy1U0b+ticsDff8xnCabTo460KiSEkrjkcnWwvORbtLpaZ3ShQGpU+6AdTGvDE4xhFvMgkCDa8dsaDm174Xz2I+g9yITEc3PWLnk7CkeiZKxf/Q+NsqQ3Wbjat2mgEiwyPRCsH/KYZN8rbhMFLuL3cTUwizcw3YzbwNb9i1dGus6kYTtl5lpuCjlOsV7wBMItXNyKL1PNYy2tcacwkgN3Q3fYUUfFxrnYwxzSnSHt/9PY8UKl+kMwRw6rKnbbkHFRkV2TYqmrQK3kYDRwmvWDU673CVxTWM4/pz/", 2019-08-16 04:35:19.109221 | primary | "name": "fe80::be76:4eff:fe10:372" 2019-08-16 04:35:19.109326 | primary | } 2019-08-16 04:35:19.415289 | primary | changed: 2019-08-16 04:35:19.415526 | primary | { 2019-08-16 04:35:19.415639 | primary | "key": "fe80::be76:4eff:fe10:376 ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBAhDrwMeddTjDFNWTcDwLFIFaQ9WFZ7CenZ5IUX5yi73kCHNHDwb1XKSMZyvsrkuAvP4MF7hJGg8q2JXLRJSiU8=", 2019-08-16 04:35:19.415747 | primary | "name": "fe80::be76:4eff:fe10:376" 2019-08-16 04:35:19.415865 | primary | } 2019-08-16 04:35:19.706488 | primary | changed: 2019-08-16 04:35:19.706711 | primary | { 2019-08-16 04:35:19.706823 | primary | "key": "fe80::be76:4eff:fe10:376 ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIByUis7bjnzUn+uzxxnqHuoPDUNRPizjPmZrfxSuB43d", 2019-08-16 04:35:19.706933 | primary | "name": "fe80::be76:4eff:fe10:376" 2019-08-16 04:35:19.707037 | primary | } 2019-08-16 04:35:20.010105 | primary | changed: 2019-08-16 04:35:20.010370 | primary | { 2019-08-16 04:35:20.010484 | primary | "key": "fe80::be76:4eff:fe10:376 ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC/m044QHGT57KSo8cEX+ixa/8lwVgQgiN1UH3tqVHIBTcTvNl4Qy1U0b+ticsDff8xnCabTo460KiSEkrjkcnWwvORbtLpaZ3ShQGpU+6AdTGvDE4xhFvMgkCDa8dsaDm174Xz2I+g9yITEc3PWLnk7CkeiZKxf/Q+NsqQ3Wbjat2mgEiwyPRCsH/KYZN8rbhMFLuL3cTUwizcw3YzbwNb9i1dGus6kYTtl5lpuCjlOsV7wBMItXNyKL1PNYy2tcacwkgN3Q3fYUUfFxrnYwxzSnSHt/9PY8UKl+kMwRw6rKnbbkHFRkV2TYqmrQK3kYDRwmvWDU673CVxTWM4/pz/", 2019-08-16 04:35:20.010614 | primary | "name": "fe80::be76:4eff:fe10:376" 2019-08-16 04:35:20.010721 | primary | } 2019-08-16 04:35:20.062399 | 2019-08-16 04:35:20.062710 | TASK [Set up multi-node hosts file] 2019-08-16 04:35:20.127444 | primary | ok 2019-08-16 04:35:20.204800 | 2019-08-16 04:35:20.205072 | TASK [multi-node-hosts-file : Set up the list of hosts and addresses] 2019-08-16 04:35:20.429541 | primary | ok 2019-08-16 04:35:20.472882 | 2019-08-16 04:35:20.473182 | LOOP [multi-node-hosts-file : Add inventory hostnames to the hosts file] 2019-08-16 04:35:21.262291 | primary | changed: line added 2019-08-16 04:35:21.574717 | primary | changed: line added 2019-08-16 04:35:21.612477 | 2019-08-16 04:35:21.612721 | TASK [Set up multi-node firewall] 2019-08-16 04:35:21.675560 | primary | ok 2019-08-16 04:35:21.761519 | 2019-08-16 04:35:21.761811 | TASK [multi-node-firewall : Ensure iptables] 2019-08-16 04:35:22.954653 | primary | ok 2019-08-16 04:35:22.994907 | 2019-08-16 04:35:22.995231 | TASK [multi-node-firewall : Set up the host ip addresses] 2019-08-16 04:35:23.346133 | primary | ok 2019-08-16 04:35:23.386527 | 2019-08-16 04:35:23.386778 | LOOP [multi-node-firewall : Set up ipv4 iptables rules] 2019-08-16 04:35:24.160434 | primary | changed: "10.210.64.162" 2019-08-16 04:35:24.161078 | primary | changed: All items complete 2019-08-16 04:35:24.161207 | 2019-08-16 04:35:24.462893 | primary | changed: "23.253.164.73" 2019-08-16 04:35:24.499567 | 2019-08-16 04:35:24.499758 | LOOP [multi-node-firewall : Set up ipv6 iptables rules] 2019-08-16 04:35:25.077832 | primary | changed: "2001:4801:7825:103:be76:4eff:fe10:372" 2019-08-16 04:35:25.116949 | 2019-08-16 04:35:25.117236 | TASK [Persist iptables rules] 2019-08-16 04:35:25.193203 | primary | ok 2019-08-16 04:35:25.281684 | 2019-08-16 04:35:25.281982 | TASK [persistent-firewall : List current ipv4 rules] 2019-08-16 04:35:25.961956 | primary | # Generated by iptables-save v1.4.21 on Fri Aug 16 04:35:25 2019 2019-08-16 04:35:25.962085 | primary | *filter 2019-08-16 04:35:25.962164 | primary | :INPUT ACCEPT [0:0] 2019-08-16 04:35:25.962238 | primary | :FORWARD ACCEPT [0:0] 2019-08-16 04:35:25.962317 | primary | :OUTPUT ACCEPT [82:7594] 2019-08-16 04:35:25.962394 | primary | :openstack-INPUT - [0:0] 2019-08-16 04:35:25.962495 | primary | -A INPUT -s 23.253.164.73/32 -j ACCEPT 2019-08-16 04:35:25.962615 | primary | -A INPUT -s 10.210.64.162/32 -j ACCEPT 2019-08-16 04:35:25.962704 | primary | -A INPUT -j openstack-INPUT 2019-08-16 04:35:25.962802 | primary | -A openstack-INPUT -i lo -j ACCEPT 2019-08-16 04:35:25.962942 | primary | -A openstack-INPUT -p icmp -m icmp --icmp-type any -j ACCEPT 2019-08-16 04:35:25.963072 | primary | -A openstack-INPUT -p tcp -m tcp --dport 22 -j ACCEPT 2019-08-16 04:35:25.963220 | primary | -A openstack-INPUT -m state --state RELATED,ESTABLISHED -j ACCEPT 2019-08-16 04:35:25.963388 | primary | -A openstack-INPUT -p tcp -m state --state NEW -m tcp --dport 19885 -j ACCEPT 2019-08-16 04:35:25.963544 | primary | -A openstack-INPUT -s 172.24.4.0/23 -p udp -m udp --dport 69 -j ACCEPT 2019-08-16 04:35:25.963723 | primary | -A openstack-INPUT -s 172.24.4.0/23 -p tcp -m tcp --dport 6385 -j ACCEPT 2019-08-16 04:35:25.963885 | primary | -A openstack-INPUT -s 172.24.4.0/23 -p tcp -m tcp --dport 80 -j ACCEPT 2019-08-16 04:35:25.964046 | primary | -A openstack-INPUT -s 172.24.4.0/23 -p tcp -m tcp --dport 8000 -j ACCEPT 2019-08-16 04:35:25.964205 | primary | -A openstack-INPUT -s 172.24.4.0/23 -p tcp -m tcp --dport 8003 -j ACCEPT 2019-08-16 04:35:25.964364 | primary | -A openstack-INPUT -s 172.24.4.0/23 -p tcp -m tcp --dport 8004 -j ACCEPT 2019-08-16 04:35:25.964540 | primary | -A openstack-INPUT -m limit --limit 2/min -j LOG --log-prefix "iptables dropped: " 2019-08-16 04:35:25.964704 | primary | -A openstack-INPUT -j REJECT --reject-with icmp-host-prohibited 2019-08-16 04:35:25.964755 | primary | COMMIT 2019-08-16 04:35:25.964864 | primary | # Completed on Fri Aug 16 04:35:25 2019 2019-08-16 04:35:26.463435 | primary | ok: Runtime: 0:00:00.010266 2019-08-16 04:35:26.500743 | 2019-08-16 04:35:26.500947 | TASK [persistent-firewall : List current ipv6 rules] 2019-08-16 04:35:27.009145 | primary | # Generated by ip6tables-save v1.4.21 on Fri Aug 16 04:35:27 2019 2019-08-16 04:35:27.009411 | primary | *filter 2019-08-16 04:35:27.009491 | primary | :INPUT ACCEPT [0:0] 2019-08-16 04:35:27.009565 | primary | :FORWARD ACCEPT [0:0] 2019-08-16 04:35:27.009662 | primary | :OUTPUT ACCEPT [0:0] 2019-08-16 04:35:27.009741 | primary | :openstack-INPUT - [0:0] 2019-08-16 04:35:27.009887 | primary | -A INPUT -s 2001:4801:7825:103:be76:4eff:fe10:372/128 -j ACCEPT 2019-08-16 04:35:27.009969 | primary | -A INPUT -j openstack-INPUT 2019-08-16 04:35:27.010064 | primary | -A openstack-INPUT -i lo -j ACCEPT 2019-08-16 04:35:27.010170 | primary | -A openstack-INPUT -p ipv6-icmp -j ACCEPT 2019-08-16 04:35:27.010297 | primary | -A openstack-INPUT -p tcp -m tcp --dport 22 -j ACCEPT 2019-08-16 04:35:27.010444 | primary | -A openstack-INPUT -m state --state RELATED,ESTABLISHED -j ACCEPT 2019-08-16 04:35:27.010626 | primary | -A openstack-INPUT -p tcp -m state --state NEW -m tcp --dport 19885 -j ACCEPT 2019-08-16 04:35:27.010797 | primary | -A openstack-INPUT -j REJECT --reject-with icmp6-adm-prohibited 2019-08-16 04:35:27.010846 | primary | COMMIT 2019-08-16 04:35:27.010956 | primary | # Completed on Fri Aug 16 04:35:27 2019 2019-08-16 04:35:27.114286 | primary | ok: Runtime: 0:00:00.009734 2019-08-16 04:35:27.156808 | 2019-08-16 04:35:27.157050 | LOOP [persistent-firewall : Configure persistent iptables rules] 2019-08-16 04:35:27.249218 | primary | ok: "/var/lib/zuul/builds/5b97af71f8734123988a6845338513b8/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/persistent-firewall/tasks/persist/RedHat.yaml" 2019-08-16 04:35:27.249803 | primary | changed: All items complete 2019-08-16 04:35:27.249915 | 2019-08-16 04:35:27.303003 | primary | included: /var/lib/zuul/builds/5b97af71f8734123988a6845338513b8/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/persistent-firewall/tasks/persist/RedHat.yaml 2019-08-16 04:35:27.328684 | 2019-08-16 04:35:27.328858 | TASK [persistent-firewall : Persist ipv4 rules] 2019-08-16 04:35:29.147632 | primary | changed 2019-08-16 04:35:29.186326 | 2019-08-16 04:35:29.186812 | TASK [persistent-firewall : Persist ipv6 rules] 2019-08-16 04:35:30.734114 | primary | changed 2019-08-16 04:35:30.770809 | 2019-08-16 04:35:30.770987 | TASK [persistent-firewall : Ensure iptables-services is installed] 2019-08-16 04:35:31.500322 | primary | ok 2019-08-16 04:35:31.548008 | 2019-08-16 04:35:31.548291 | TASK [persistent-firewall : Ensure iptables is started] 2019-08-16 04:35:32.862756 | primary | ok 2019-08-16 04:35:32.896626 | 2019-08-16 04:35:32.896804 | PLAY [Configure multi-node networking switch and peer nodes] 2019-08-16 04:35:32.954788 | 2019-08-16 04:35:32.954981 | LOOP [multi-node-bridge : Include OS-specific variables] 2019-08-16 04:35:33.199145 | primary | ok: "/var/lib/zuul/builds/5b97af71f8734123988a6845338513b8/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/multi-node-bridge/vars/CentOS.yaml" 2019-08-16 04:35:33.240642 | 2019-08-16 04:35:33.241123 | TASK [multi-node-bridge : Set up RDO GPG key] 2019-08-16 04:35:34.827716 | primary | changed 2019-08-16 04:35:34.872295 | 2019-08-16 04:35:34.872530 | TASK [multi-node-bridge : Set up RDO repository] 2019-08-16 04:35:36.415327 | primary | changed 2019-08-16 04:35:36.460242 | 2019-08-16 04:35:36.460519 | LOOP [multi-node-bridge : Set package.use values for OVS on Gentoo] 2019-08-16 04:35:36.539372 | primary | skipping: Conditional result was False 2019-08-16 04:35:36.540567 | primary | ok: All items complete 2019-08-16 04:35:36.540686 | 2019-08-16 04:35:36.542343 | primary | skipping: Conditional result was False 2019-08-16 04:35:36.553289 | primary | skipping: Conditional result was False 2019-08-16 04:35:36.594894 | 2019-08-16 04:35:36.595144 | TASK [multi-node-bridge : Install openvswitch] 2019-08-16 04:35:42.972391 | primary | changed: 2019-08-16 04:35:42.972976 | primary | warning: /var/cache/yum/centos-openstack-queens/packages/openvswitch-2.9.0-3.el7.x86_64.rpm: Header V4 RSA/SHA1 Signature, key ID 764429e6: NOKEY 2019-08-16 04:35:42.973101 | primary | Importing GPG key 0x764429E6: 2019-08-16 04:35:42.973212 | primary | Userid : "CentOS Cloud SIG (http://wiki.centos.org/SpecialInterestGroup/Cloud) " 2019-08-16 04:35:42.973321 | primary | Fingerprint: 736a f511 6d9c 40e2 af6b 074b f9b9 fee7 7644 29e6 2019-08-16 04:35:42.973426 | primary | From : /tmp/RPM-GPG-KEY-CentOS-SIG-Cloud 2019-08-16 04:35:43.022890 | 2019-08-16 04:35:43.023207 | TASK [multi-node-bridge : Ensure openvswitch is started] 2019-08-16 04:35:44.166451 | primary | changed 2019-08-16 04:35:44.208448 | 2019-08-16 04:35:44.208661 | LOOP [multi-node-bridge : Remove RDO repository files] 2019-08-16 04:35:45.030657 | primary | changed: "/tmp/RPM-GPG-KEY-CentOS-SIG-Cloud" 2019-08-16 04:35:45.031314 | 2019-08-16 04:35:45.344960 | primary | changed: "/etc/yum.repos.d/zuul-multi-node-bridge-ovs.repo" 2019-08-16 04:35:45.384716 | 2019-08-16 04:35:45.384934 | TASK [multi-node-bridge : Authorize the multi-node-bridge network] 2019-08-16 04:35:45.447104 | primary | skipping: Conditional result was False 2019-08-16 04:35:45.491785 | 2019-08-16 04:35:45.492027 | TASK [multi-node-bridge : Determine bridge mtu] 2019-08-16 04:35:45.610076 | primary | skipping: Conditional result was False 2019-08-16 04:35:45.659716 | 2019-08-16 04:35:45.659965 | TASK [multi-node-bridge : Set bridge_mtu] 2019-08-16 04:35:45.722249 | primary | skipping: Conditional result was False 2019-08-16 04:35:45.770487 | 2019-08-16 04:35:45.770755 | TASK [multi-node-bridge : include] 2019-08-16 04:35:56.110048 | primary | ok 2019-08-16 04:35:56.171686 | primary | included: /var/lib/zuul/builds/5b97af71f8734123988a6845338513b8/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/multi-node-bridge/tasks/switch.yaml 2019-08-16 04:35:56.204304 | 2019-08-16 04:35:56.204544 | TASK [multi-node-bridge : Ensure the bridge exists] 2019-08-16 04:35:57.004407 | primary | changed 2019-08-16 04:35:57.047322 | 2019-08-16 04:35:57.047589 | TASK [multi-node-bridge : Set the bridge MTU] 2019-08-16 04:35:57.647133 | primary | ok: Runtime: 0:00:00.005691 2019-08-16 04:35:57.701703 | 2019-08-16 04:35:57.701991 | TASK [multi-node-bridge : Verify if the bridge address is set] 2019-08-16 04:35:58.319720 | primary | ok: Runtime: 0:00:00.009877 2019-08-16 04:35:58.381994 | 2019-08-16 04:35:58.382308 | TASK [multi-node-bridge : Set the bridge address] 2019-08-16 04:35:58.992542 | primary | ok: Runtime: 0:00:00.007241 2019-08-16 04:35:59.033681 | 2019-08-16 04:35:59.033958 | TASK [multi-node-bridge : Bring bridge interface up] 2019-08-16 04:35:59.652187 | primary | ok: Runtime: 0:00:00.010163 2019-08-16 04:35:59.725584 | 2019-08-16 04:35:59.725822 | TASK [multi-node-bridge : include] 2019-08-16 04:35:59.797184 | primary | skipping: Conditional result was False 2019-08-16 04:35:59.855041 | 2019-08-16 04:35:59.855295 | TASK [Persist iptables rules] 2019-08-16 04:35:59.925993 | primary | ok 2019-08-16 04:36:00.029926 | 2019-08-16 04:36:00.030375 | TASK [persistent-firewall : List current ipv4 rules] 2019-08-16 04:36:00.605627 | primary | # Generated by iptables-save v1.4.21 on Fri Aug 16 04:36:00 2019 2019-08-16 04:36:00.605856 | primary | *filter 2019-08-16 04:36:00.605934 | primary | :INPUT ACCEPT [0:0] 2019-08-16 04:36:00.606009 | primary | :FORWARD ACCEPT [0:0] 2019-08-16 04:36:00.606095 | primary | :OUTPUT ACCEPT [1699:157157] 2019-08-16 04:36:00.606172 | primary | :openstack-INPUT - [0:0] 2019-08-16 04:36:00.606273 | primary | -A INPUT -s 23.253.164.73/32 -j ACCEPT 2019-08-16 04:36:00.606378 | primary | -A INPUT -s 10.210.64.162/32 -j ACCEPT 2019-08-16 04:36:00.606461 | primary | -A INPUT -j openstack-INPUT 2019-08-16 04:36:00.606555 | primary | -A openstack-INPUT -i lo -j ACCEPT 2019-08-16 04:36:00.606711 | primary | -A openstack-INPUT -p icmp -m icmp --icmp-type any -j ACCEPT 2019-08-16 04:36:00.606842 | primary | -A openstack-INPUT -p tcp -m tcp --dport 22 -j ACCEPT 2019-08-16 04:36:00.606990 | primary | -A openstack-INPUT -m state --state RELATED,ESTABLISHED -j ACCEPT 2019-08-16 04:36:00.607158 | primary | -A openstack-INPUT -p tcp -m state --state NEW -m tcp --dport 19885 -j ACCEPT 2019-08-16 04:36:00.607314 | primary | -A openstack-INPUT -s 172.24.4.0/23 -p udp -m udp --dport 69 -j ACCEPT 2019-08-16 04:36:00.607473 | primary | -A openstack-INPUT -s 172.24.4.0/23 -p tcp -m tcp --dport 6385 -j ACCEPT 2019-08-16 04:36:00.607657 | primary | -A openstack-INPUT -s 172.24.4.0/23 -p tcp -m tcp --dport 80 -j ACCEPT 2019-08-16 04:36:00.607823 | primary | -A openstack-INPUT -s 172.24.4.0/23 -p tcp -m tcp --dport 8000 -j ACCEPT 2019-08-16 04:36:00.607981 | primary | -A openstack-INPUT -s 172.24.4.0/23 -p tcp -m tcp --dport 8003 -j ACCEPT 2019-08-16 04:36:00.608139 | primary | -A openstack-INPUT -s 172.24.4.0/23 -p tcp -m tcp --dport 8004 -j ACCEPT 2019-08-16 04:36:00.608314 | primary | -A openstack-INPUT -m limit --limit 2/min -j LOG --log-prefix "iptables dropped: " 2019-08-16 04:36:00.608464 | primary | -A openstack-INPUT -j REJECT --reject-with icmp-host-prohibited 2019-08-16 04:36:00.608511 | primary | COMMIT 2019-08-16 04:36:00.608627 | primary | # Completed on Fri Aug 16 04:36:00 2019 2019-08-16 04:36:00.689739 | primary | ok: Runtime: 0:00:00.011726 2019-08-16 04:36:00.817212 | 2019-08-16 04:36:00.817446 | TASK [persistent-firewall : List current ipv6 rules] 2019-08-16 04:36:01.339002 | primary | # Generated by ip6tables-save v1.4.21 on Fri Aug 16 04:36:01 2019 2019-08-16 04:36:01.339131 | primary | *filter 2019-08-16 04:36:01.339206 | primary | :INPUT ACCEPT [0:0] 2019-08-16 04:36:01.339278 | primary | :FORWARD ACCEPT [0:0] 2019-08-16 04:36:01.339351 | primary | :OUTPUT ACCEPT [2:152] 2019-08-16 04:36:01.339428 | primary | :openstack-INPUT - [0:0] 2019-08-16 04:36:01.339569 | primary | -A INPUT -s 2001:4801:7825:103:be76:4eff:fe10:372/128 -j ACCEPT 2019-08-16 04:36:01.339672 | primary | -A INPUT -j openstack-INPUT 2019-08-16 04:36:01.339767 | primary | -A openstack-INPUT -i lo -j ACCEPT 2019-08-16 04:36:01.339871 | primary | -A openstack-INPUT -p ipv6-icmp -j ACCEPT 2019-08-16 04:36:01.339995 | primary | -A openstack-INPUT -p tcp -m tcp --dport 22 -j ACCEPT 2019-08-16 04:36:01.340140 | primary | -A openstack-INPUT -m state --state RELATED,ESTABLISHED -j ACCEPT 2019-08-16 04:36:01.340303 | primary | -A openstack-INPUT -p tcp -m state --state NEW -m tcp --dport 19885 -j ACCEPT 2019-08-16 04:36:01.340444 | primary | -A openstack-INPUT -j REJECT --reject-with icmp6-adm-prohibited 2019-08-16 04:36:01.340489 | primary | COMMIT 2019-08-16 04:36:01.340608 | primary | # Completed on Fri Aug 16 04:36:01 2019 2019-08-16 04:36:01.434591 | primary | ok: Runtime: 0:00:00.009226 2019-08-16 04:36:01.473660 | 2019-08-16 04:36:01.473870 | LOOP [persistent-firewall : Configure persistent iptables rules] 2019-08-16 04:36:01.564515 | primary | ok: "/var/lib/zuul/builds/5b97af71f8734123988a6845338513b8/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/persistent-firewall/tasks/persist/RedHat.yaml" 2019-08-16 04:36:01.612267 | primary | included: /var/lib/zuul/builds/5b97af71f8734123988a6845338513b8/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/persistent-firewall/tasks/persist/RedHat.yaml 2019-08-16 04:36:01.639669 | 2019-08-16 04:36:01.639952 | TASK [persistent-firewall : Persist ipv4 rules] 2019-08-16 04:36:03.206901 | primary | changed 2019-08-16 04:36:03.247266 | 2019-08-16 04:36:03.247587 | TASK [persistent-firewall : Persist ipv6 rules] 2019-08-16 04:36:04.801229 | primary | changed 2019-08-16 04:36:04.841330 | 2019-08-16 04:36:04.841727 | TASK [persistent-firewall : Ensure iptables-services is installed] 2019-08-16 04:36:05.614808 | primary | ok 2019-08-16 04:36:05.656736 | 2019-08-16 04:36:05.656950 | TASK [persistent-firewall : Ensure iptables is started] 2019-08-16 04:36:06.361951 | primary | ok 2019-08-16 04:36:06.392891 | 2019-08-16 04:36:06.393069 | PLAY [Copy the build ssh key to authorized_keys on all hosts for root] 2019-08-16 04:36:06.446192 | 2019-08-16 04:36:06.446477 | TASK [copy-build-sshkey : Authorize build key] 2019-08-16 04:36:07.343140 | primary | changed 2019-08-16 04:36:07.388373 | 2019-08-16 04:36:07.388658 | TASK [copy-build-sshkey : Get the root user home folder] 2019-08-16 04:36:08.325829 | primary | ok 2019-08-16 04:36:08.368150 | 2019-08-16 04:36:08.368464 | TASK [copy-build-sshkey : Install the build private key] 2019-08-16 04:36:09.973117 | primary | changed 2019-08-16 04:36:10.017761 | 2019-08-16 04:36:10.018012 | TASK [copy-build-sshkey : Install the build public key] 2019-08-16 04:36:11.530017 | primary | changed 2019-08-16 04:36:11.549302 | 2019-08-16 04:36:11.549440 | PLAY RECAP 2019-08-16 04:36:11.549607 | primary | ok: 39 changed: 21 unreachable: 0 failed: 0 2019-08-16 04:36:11.549713 | 2019-08-16 04:36:12.080262 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/multinode/pre.yaml@master] 2019-08-16 04:36:12.080562 | PRE-RUN START: [untrusted : opendev.org/openstack/tripleo-ci/playbooks/nodepool-provider/pre.yaml@master] 2019-08-16 04:36:15.484622 | 2019-08-16 04:36:15.484901 | PLAY [Configure /etc/nodepool/provider for backwards compatibility] 2019-08-16 04:36:15.531795 | 2019-08-16 04:36:15.532023 | TASK [Warn that /etc/nodepool/provider is deprecated] 2019-08-16 04:36:15.710530 | The /etc/nodepool/provider file no longer exists and is being created 2019-08-16 04:36:15.711386 | for backwards compatibility purposes. The variables provided by this 2019-08-16 04:36:15.711533 | file are now available through Ansible under hostvars[$HOST]['nodepool']. 2019-08-16 04:36:15.769872 | 2019-08-16 04:36:15.770202 | TASK [Create /etc/nodepool/provider file] 2019-08-16 04:36:17.672571 | primary | changed 2019-08-16 04:36:17.693237 | 2019-08-16 04:36:17.693386 | PLAY RECAP 2019-08-16 04:36:17.693586 | primary | ok: 2 changed: 1 unreachable: 0 failed: 0 2019-08-16 04:36:17.693748 | 2019-08-16 04:36:18.179939 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/openstack/tripleo-ci/playbooks/nodepool-provider/pre.yaml@master] 2019-08-16 04:36:18.180265 | PRE-RUN START: [untrusted : opendev.org/openstack/tripleo-ci/playbooks/openstack-zuul-jobs/legacy/pre.yaml@master] 2019-08-16 04:36:21.748258 | 2019-08-16 04:36:21.748551 | PLAY [all] 2019-08-16 04:36:21.796906 | 2019-08-16 04:36:21.797123 | TASK [Create nodepool directory] 2019-08-16 04:36:22.528158 | primary | ok 2019-08-16 04:36:22.594785 | 2019-08-16 04:36:22.595197 | TASK [Create nodepool sub_nodes file] 2019-08-16 04:36:24.485667 | primary | changed 2019-08-16 04:36:24.525166 | 2019-08-16 04:36:24.525374 | TASK [Create nodepool sub_nodes_private file] 2019-08-16 04:36:25.881806 | primary | changed 2019-08-16 04:36:25.919082 | 2019-08-16 04:36:25.919363 | LOOP [Populate nodepool sub_nodes file] 2019-08-16 04:36:26.025241 | 2019-08-16 04:36:26.025671 | LOOP [Populate nodepool sub_nodes_private file] 2019-08-16 04:36:26.121970 | 2019-08-16 04:36:26.122422 | TASK [Create nodepool primary file] 2019-08-16 04:36:27.580360 | primary | changed 2019-08-16 04:36:27.618957 | 2019-08-16 04:36:27.619169 | TASK [Create nodepool node_private for this node] 2019-08-16 04:36:29.007333 | primary | changed 2019-08-16 04:36:29.046474 | 2019-08-16 04:36:29.046680 | LOOP [Copy ssh keys to nodepool directory] 2019-08-16 04:36:29.786589 | primary | ok: Item: id_rsa Runtime: 0:00:00.005664 2019-08-16 04:36:29.787179 | 2019-08-16 04:36:30.019029 | primary | ok: Item: id_rsa.pub Runtime: 0:00:00.005787 2019-08-16 04:36:30.057418 | 2019-08-16 04:36:30.057722 | TASK [Add sudoers role for zuul-sudo-grep.sh] 2019-08-16 04:36:31.519219 | primary | changed 2019-08-16 04:36:31.561223 | 2019-08-16 04:36:31.561451 | TASK [Validate sudoers config after edits] 2019-08-16 04:36:32.015723 | primary | /etc/sudoers: parsed OK 2019-08-16 04:36:32.016022 | primary | /etc/sudoers.d/zuul: parsed OK 2019-08-16 04:36:32.016173 | primary | /etc/sudoers.d/zuul-sudo-grep: parsed OK 2019-08-16 04:36:32.174721 | primary | ok: Runtime: 0:00:00.008888 2019-08-16 04:36:32.216464 | 2019-08-16 04:36:32.216677 | TASK [Show the environment passed in to job shell scripts] 2019-08-16 04:36:32.688478 | primary | XDG_SESSION_ID=1 2019-08-16 04:36:32.688818 | primary | ZUUL_PROJECT=openstack/tripleo-common 2019-08-16 04:36:32.688905 | primary | SELINUX_ROLE_REQUESTED= 2019-08-16 04:36:32.688970 | primary | SHELL=/bin/bash 2019-08-16 04:36:32.689065 | primary | SSH_CLIENT=104.239.149.58 60384 22 2019-08-16 04:36:32.689146 | primary | SELINUX_USE_CURRENT_RANGE= 2019-08-16 04:36:32.689232 | primary | WORKSPACE=/home/zuul/workspace 2019-08-16 04:36:32.689298 | primary | ZUUL_BRANCH=master 2019-08-16 04:36:32.689351 | primary | USER=zuul 2019-08-16 04:36:32.689419 | primary | ZUUL_VOTING=True 2019-08-16 04:36:32.689486 | primary | ZUUL_CHANGE=676447 2019-08-16 04:36:32.689852 | primary | TOX_TESTENV_PASSENV=ZUUL_UUID ZUUL_CHANGES ZUUL_SHORT_PROJECT_NAME WORKSPACE ZUUL_CHANGE_IDS ZUUL_PATCHSET ZUUL_VOTING BUILD_TIMEOUT ZUUL_PIPELINE ZUUL_BRANCH ZUUL_PROJECT ZUUL_CHANGE 2019-08-16 04:36:32.689949 | primary | MAIL=/var/mail/zuul 2019-08-16 04:36:32.690035 | primary | PATH=/usr/local/bin:/usr/bin 2019-08-16 04:36:32.690096 | primary | _=/usr/bin/env 2019-08-16 04:36:32.690155 | primary | PWD=/home/zuul 2019-08-16 04:36:32.690218 | primary | LANG=en_US.UTF-8 2019-08-16 04:36:32.690368 | primary | ZUUL_CHANGES=openstack/tripleo-common:master:refs/changes/47/676447/1 2019-08-16 04:36:32.690445 | primary | SELINUX_LEVEL_REQUESTED= 2019-08-16 04:36:32.690493 | primary | SHLVL=3 2019-08-16 04:36:32.690554 | primary | HOME=/home/zuul 2019-08-16 04:36:32.690647 | primary | ZUUL_CHANGE_IDS=676447,1 2019-08-16 04:36:32.690721 | primary | BUILD_TIMEOUT=7200000 2019-08-16 04:36:32.690778 | primary | LOGNAME=zuul 2019-08-16 04:36:32.690900 | primary | SSH_CONNECTION=104.239.149.58 60384 23.253.164.73 22 2019-08-16 04:36:32.691038 | primary | LESSOPEN=||/usr/bin/lesspipe.sh %s 2019-08-16 04:36:32.691200 | primary | ZUUL_SHORT_PROJECT_NAME=tripleo-common 2019-08-16 04:36:32.691294 | primary | ZUUL_PIPELINE=check 2019-08-16 04:36:32.691412 | primary | XDG_RUNTIME_DIR=/run/user/1000 2019-08-16 04:36:32.691493 | primary | ZUUL_PATCHSET=1 2019-08-16 04:36:32.691646 | primary | ZUUL_UUID=5b97af71f8734123988a6845338513b8 2019-08-16 04:36:32.851132 | primary | ok: Runtime: 0:00:00.012287 2019-08-16 04:36:32.876474 | 2019-08-16 04:36:32.876664 | PLAY RECAP 2019-08-16 04:36:32.876811 | primary | ok: 9 changed: 6 unreachable: 0 failed: 0 2019-08-16 04:36:32.876915 | 2019-08-16 04:36:33.381630 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/openstack/tripleo-ci/playbooks/openstack-zuul-jobs/legacy/pre.yaml@master] 2019-08-16 04:36:33.381946 | PRE-RUN START: [untrusted : opendev.org/openstack/tripleo-ci/playbooks/tripleo-ci/ceph.yaml@master] 2019-08-16 04:36:36.756120 | 2019-08-16 04:36:36.756410 | PLAY [Bootstrap subnodes - setup ceph-ansible /dev/loop3 /var/lib/ceph-osd.img] 2019-08-16 04:36:36.766234 | 2019-08-16 04:36:36.766411 | PLAY RECAP 2019-08-16 04:36:36.766523 | 2019-08-16 04:36:37.236470 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/openstack/tripleo-ci/playbooks/tripleo-ci/ceph.yaml@master] 2019-08-16 04:36:37.236768 | PRE-RUN START: [untrusted : opendev.org/openstack/tripleo-ci/playbooks/tripleo-ci/pre.yaml@master] 2019-08-16 04:36:40.929485 | 2019-08-16 04:36:40.929787 | PLAY [Common tasks for nodes preparation] 2019-08-16 04:36:40.985876 | 2019-08-16 04:36:40.986107 | TASK [common : Include the vars to be available for the playbook] 2019-08-16 04:36:41.186056 | primary | ok 2019-08-16 04:36:41.248996 | 2019-08-16 04:36:41.249311 | TASK [common : apply o-w workaround on src to avoid failure to load ansible.cfg] 2019-08-16 04:36:47.656342 | primary | ok 2019-08-16 04:36:47.698682 | 2019-08-16 04:36:47.699030 | TASK [Swap is essential as we are not meeting memory requirements] 2019-08-16 04:36:47.787339 | primary | ok 2019-08-16 04:36:47.899292 | 2019-08-16 04:36:47.899555 | TASK [configure-swap : Set ephemeral device if /dev/xvde exists] 2019-08-16 04:36:48.103679 | primary | ok 2019-08-16 04:36:48.145759 | 2019-08-16 04:36:48.146081 | TASK [configure-swap : Get ephemeral0 device node] 2019-08-16 04:36:48.260503 | primary | skipping: Conditional result was False 2019-08-16 04:36:48.308273 | 2019-08-16 04:36:48.308593 | TASK [configure-swap : Set ephemeral device if LABEL exists] 2019-08-16 04:36:48.365623 | primary | skipping: Conditional result was False 2019-08-16 04:36:48.408637 | 2019-08-16 04:36:48.409246 | TASK [configure-swap : include] 2019-08-16 04:36:58.790571 | primary | ok 2019-08-16 04:36:58.872732 | primary | included: /var/lib/zuul/builds/5b97af71f8734123988a6845338513b8/untrusted/project_3/opendev.org/openstack/openstack-zuul-jobs/roles/configure-swap/tasks/ephemeral.yaml 2019-08-16 04:36:58.900575 | 2019-08-16 04:36:58.900890 | TASK [configure-swap : Assert that ephemeral_device is defined] 2019-08-16 04:36:59.107980 | primary | ok: All assertions passed 2019-08-16 04:36:59.149670 | 2019-08-16 04:36:59.150020 | TASK [configure-swap : Set partition names] 2019-08-16 04:36:59.341130 | primary | ok 2019-08-16 04:36:59.390921 | 2019-08-16 04:36:59.391283 | LOOP [configure-swap : Ensure ephemeral device is unmounted] 2019-08-16 04:37:00.245166 | primary | ok: "unmounted" 2019-08-16 04:37:00.540392 | primary | ok: "absent" 2019-08-16 04:37:00.580893 | 2019-08-16 04:37:00.581137 | TASK [configure-swap : Get existing partitions] 2019-08-16 04:37:01.361961 | primary | ok 2019-08-16 04:37:01.402997 | 2019-08-16 04:37:01.403237 | LOOP [configure-swap : Remove any existing partitions] 2019-08-16 04:37:01.969757 | primary | changed: 2019-08-16 04:37:01.970363 | primary | { 2019-08-16 04:37:01.970513 | primary | "begin": 1.0, 2019-08-16 04:37:01.970622 | primary | "end": 81920.0, 2019-08-16 04:37:01.970727 | primary | "flags": [], 2019-08-16 04:37:01.970845 | primary | "fstype": "", 2019-08-16 04:37:01.970947 | primary | "name": "", 2019-08-16 04:37:01.971048 | primary | "num": 1, 2019-08-16 04:37:01.971165 | primary | "size": 81919.0, 2019-08-16 04:37:01.971266 | primary | "unit": "mib" 2019-08-16 04:37:01.971366 | primary | } 2019-08-16 04:37:01.971534 | primary | ok: All items complete 2019-08-16 04:37:01.971635 | 2019-08-16 04:37:02.010288 | 2019-08-16 04:37:02.010505 | TASK [configure-swap : Create new disk label] 2019-08-16 04:37:02.502993 | primary | ok 2019-08-16 04:37:02.545121 | 2019-08-16 04:37:02.545361 | TASK [configure-swap : Create swap partition] 2019-08-16 04:37:03.192368 | primary | changed 2019-08-16 04:37:03.234984 | 2019-08-16 04:37:03.235246 | TASK [configure-swap : Create opt partition] 2019-08-16 04:37:03.910115 | primary | changed 2019-08-16 04:37:03.955721 | 2019-08-16 04:37:03.956166 | TASK [configure-swap : Make swap on partition] 2019-08-16 04:37:04.756620 | primary | Setting up swapspace version 1, size = 8387580 KiB 2019-08-16 04:37:04.756869 | primary | no label, UUID=7a0e534b-f9d6-4d3b-8a79-3a170d4454ee 2019-08-16 04:37:05.089835 | primary | ok: Runtime: 0:00:00.013636 2019-08-16 04:37:05.175504 | 2019-08-16 04:37:05.175838 | TASK [configure-swap : Write swap to fstab] 2019-08-16 04:37:05.814864 | primary | changed 2019-08-16 04:37:05.883494 | 2019-08-16 04:37:05.883820 | TASK [configure-swap : Add all swap] 2019-08-16 04:37:06.993516 | primary | ok: Runtime: 0:00:00.018207 2019-08-16 04:37:07.083695 | 2019-08-16 04:37:07.083947 | TASK [configure-swap : Create /opt filesystem] 2019-08-16 04:37:09.268169 | primary | changed 2019-08-16 04:37:09.398402 | 2019-08-16 04:37:09.398664 | TASK [configure-swap : Copy old /opt] 2019-08-16 04:41:05.825151 | primary | ok: Runtime: 0:03:55.403915 2019-08-16 04:41:05.871153 | 2019-08-16 04:41:05.871466 | TASK [configure-swap : Add opt to fstab and mount] 2019-08-16 04:41:06.573600 | primary | changed 2019-08-16 04:41:06.614458 | 2019-08-16 04:41:06.614682 | TASK [configure-swap : include] 2019-08-16 04:41:06.674863 | primary | skipping: Conditional result was False 2019-08-16 04:41:06.728130 | 2019-08-16 04:41:06.728437 | TASK [configure-swap : Set swappiness] 2019-08-16 04:41:07.492203 | primary | changed 2019-08-16 04:41:07.531231 | 2019-08-16 04:41:07.531448 | TASK [configure-swap : debug] 2019-08-16 04:41:07.794546 | primary | ok: 2019-08-16 04:41:07.795139 | primary | { 2019-08-16 04:41:07.795253 | primary | "ephemeral_device": "/dev/xvde" 2019-08-16 04:41:07.795359 | primary | } 2019-08-16 04:41:07.838112 | 2019-08-16 04:41:07.838427 | TASK [Set legacy log path] 2019-08-16 04:41:07.925511 | primary | ok 2019-08-16 04:41:08.014537 | 2019-08-16 04:41:08.014913 | TASK [set-zuul-log-path-fact : Set log path for a change] 2019-08-16 04:41:08.317192 | primary | ok 2019-08-16 04:41:08.359641 | 2019-08-16 04:41:08.359897 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2019-08-16 04:41:08.425404 | primary | skipping: Conditional result was False 2019-08-16 04:41:08.468879 | 2019-08-16 04:41:08.469126 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2019-08-16 04:41:08.608329 | primary | skipping: Conditional result was False 2019-08-16 04:41:08.717697 | 2019-08-16 04:41:08.718026 | TASK [prepare-node : Ensure legacy workspace directory] 2019-08-16 04:41:09.205673 | primary | changed 2019-08-16 04:41:09.250618 | 2019-08-16 04:41:09.250925 | TASK [prepare-node : Ensure legacy logs directory] 2019-08-16 04:41:09.702341 | primary | changed 2019-08-16 04:41:09.740010 | 2019-08-16 04:41:09.740223 | TASK [prepare-node : Assure src folder has safe permissions] 2019-08-16 04:41:16.345496 | primary | changed 2019-08-16 04:41:16.388497 | 2019-08-16 04:41:16.388737 | TASK [prepare-node : set zull_dump] 2019-08-16 04:41:16.573982 | primary | ok 2019-08-16 04:41:16.622972 | 2019-08-16 04:41:16.623260 | TASK [prepare-node : Dump zuul variables on the host to pass it to inner ansible] 2019-08-16 04:41:18.399996 | primary | changed 2019-08-16 04:41:18.441020 | 2019-08-16 04:41:18.441450 | TASK [prepare-node : Dump hostvars with job variables] 2019-08-16 04:41:18.689058 | primary | ok 2019-08-16 04:41:18.746833 | 2019-08-16 04:41:18.747080 | TASK [prepare-node : Dump hostvars on the host to pass it to inner ansible] 2019-08-16 04:41:18.852961 | primary | ERROR 2019-08-16 04:41:18.853668 | primary | { 2019-08-16 04:41:18.853793 | primary | "msg": "The task includes an option with an undefined variable. The error was: 'featureset' is undefined\n\nThe error appears to have been in '/var/lib/zuul/builds/5b97af71f8734123988a6845338513b8/untrusted/project_2/opendev.org/openstack/tripleo-ci/roles/prepare-node/tasks/main.yaml': line 40, column 3, but may\nbe elsewhere in the file depending on the exact syntax problem.\n\nThe offending line appears to be:\n\n\n- name: Dump hostvars on the host to pass it to inner ansible\n ^ here\n" 2019-08-16 04:41:18.853905 | primary | } 2019-08-16 04:41:18.876348 | 2019-08-16 04:41:18.876592 | PLAY RECAP 2019-08-16 04:41:18.876750 | primary | ok: 27 changed: 14 unreachable: 0 failed: 1 2019-08-16 04:41:18.876856 | 2019-08-16 04:41:19.400771 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/openstack/tripleo-ci/playbooks/tripleo-ci/pre.yaml@master] 2019-08-16 04:41:19.401333 | POST-RUN START: [untrusted : opendev.org/openstack/tripleo-ci/playbooks/tripleo-buildcontainers/post.yaml@master] 2019-08-16 04:41:22.852446 | 2019-08-16 04:41:22.852708 | PLAY [primary] 2019-08-16 04:41:22.892566 | 2019-08-16 04:41:22.892811 | TASK [Run build containers post tasks] 2019-08-16 04:41:22.945605 | primary | ok 2019-08-16 04:41:23.045508 | 2019-08-16 04:41:23.045819 | TASK [build-containers : Include common vars] 2019-08-16 04:41:23.252963 | primary | ok 2019-08-16 04:41:23.292855 | 2019-08-16 04:41:23.293094 | TASK [build-containers : Grab job artifacts] 2019-08-16 04:41:24.054402 | primary | + mkdir -p /home/zuul/workspace/conf/ 2019-08-16 04:41:24.056366 | primary | + mkdir -p /home/zuul/workspace/logs/system 2019-08-16 04:41:24.057908 | primary | + mkdir -p /home/zuul/workspace/etc/docker 2019-08-16 04:41:24.059470 | primary | + mkdir -p /home/zuul/workspace/logs/buildah-builds 2019-08-16 04:41:24.061104 | primary | + mv '*.conf' /home/zuul/workspace/conf/ 2019-08-16 04:41:24.062976 | primary | mv: cannot stat ‘*.conf’: No such file or directory 2019-08-16 04:41:24.063351 | primary | + mv /home/zuul/src/opendev.org/openstack/tripleo-common/container-images/overcloud_containers.yaml /home/zuul/workspace/conf/ 2019-08-16 04:41:24.065097 | primary | + mv '*.log' /home/zuul/workspace/logs/ 2019-08-16 04:41:24.066775 | primary | mv: cannot stat ‘*.log’: No such file or directory 2019-08-16 04:41:24.067060 | primary | + mv '*.sh' /home/zuul/workspace/logs/ 2019-08-16 04:41:24.068754 | primary | mv: cannot stat ‘*.sh’: No such file or directory 2019-08-16 04:41:24.069178 | primary | + mv '/tmp/kolla-*' /home/zuul/workspace/logs/buildah-builds/ 2019-08-16 04:41:24.071243 | primary | mv: cannot stat ‘/tmp/kolla-*’: No such file or directory 2019-08-16 04:41:24.071437 | primary | + true 2019-08-16 04:41:24.071616 | primary | + rsync -var --no-links /var/log/ /home/zuul/workspace/logs/system/ 2019-08-16 04:41:24.077909 | primary | sending incremental file list 2019-08-16 04:41:24.083617 | primary | ./ 2019-08-16 04:41:24.083691 | primary | btmp 2019-08-16 04:41:24.083738 | primary | cron 2019-08-16 04:41:24.083785 | primary | dmesg 2019-08-16 04:41:24.084614 | primary | grubby_prune_debug 2019-08-16 04:41:24.084671 | primary | lastlog 2019-08-16 04:41:24.086799 | primary | maillog 2019-08-16 04:41:24.086862 | primary | messages 2019-08-16 04:41:24.089061 | primary | secure 2019-08-16 04:41:24.089263 | primary | spooler 2019-08-16 04:41:24.089321 | primary | tallylog 2019-08-16 04:41:24.089378 | primary | unbound.log 2019-08-16 04:41:24.089422 | primary | wtmp 2019-08-16 04:41:24.089738 | primary | yum.log 2019-08-16 04:41:24.090039 | primary | audit/ 2019-08-16 04:41:24.090110 | primary | audit/audit.log 2019-08-16 04:41:24.093851 | primary | journal/ 2019-08-16 04:41:24.093972 | primary | journal/762f8e4bebd742e6adf942016590b7e1/ 2019-08-16 04:41:24.094108 | primary | journal/762f8e4bebd742e6adf942016590b7e1/system.journal 2019-08-16 04:41:24.149441 | primary | journal/762f8e4bebd742e6adf942016590b7e1/user-1000.journal 2019-08-16 04:41:24.215516 | primary | ntpstats/ 2019-08-16 04:41:24.215731 | primary | openvswitch/ 2019-08-16 04:41:24.215867 | primary | openvswitch/ovs-vswitchd.log 2019-08-16 04:41:24.216003 | primary | openvswitch/ovsdb-server.log 2019-08-16 04:41:24.217485 | primary | 2019-08-16 04:41:24.217741 | primary | sent 18,267,168 bytes received 393 bytes 36,535,122.00 bytes/sec 2019-08-16 04:41:24.217914 | primary | total size is 18,261,170 speedup is 1.00 2019-08-16 04:41:24.218151 | primary | + rsync -var --no-links /etc/docker/ /home/zuul/workspace/etc/docker/ 2019-08-16 04:41:24.220130 | primary | sending incremental file list 2019-08-16 04:41:24.220299 | primary | rsync: change_dir "/etc/docker" failed: No such file or directory (2) 2019-08-16 04:41:24.321654 | primary | 2019-08-16 04:41:24.321935 | primary | sent 20 bytes received 12 bytes 64.00 bytes/sec 2019-08-16 04:41:24.322074 | primary | total size is 0 speedup is 0.00 2019-08-16 04:41:24.322407 | primary | rsync error: some files/attrs were not transferred (see previous errors) (code 23) at main.c(1178) [sender=3.1.2] 2019-08-16 04:41:24.322491 | primary | + true 2019-08-16 04:41:24.322761 | primary | + rsync -var --no-links /etc/containers/ /home/zuul/workspace/etc/containers/ 2019-08-16 04:41:24.324639 | primary | sending incremental file list 2019-08-16 04:41:24.324881 | primary | rsync: change_dir "/etc/containers" failed: No such file or directory (2) 2019-08-16 04:41:24.325373 | primary | created directory /home/zuul/workspace/etc/containers 2019-08-16 04:41:24.426380 | primary | 2019-08-16 04:41:24.426631 | primary | sent 20 bytes received 70 bytes 180.00 bytes/sec 2019-08-16 04:41:24.426756 | primary | total size is 0 speedup is 0.00 2019-08-16 04:41:24.427025 | primary | rsync error: some files/attrs were not transferred (see previous errors) (code 23) at main.c(1178) [sender=3.1.2] 2019-08-16 04:41:24.427082 | primary | + true 2019-08-16 04:41:24.427376 | primary | + rsync -var --no-links --include 'yum.repos.d/***' --include yum.conf --include 'dnf/***' '--exclude=*' /etc/ /home/zuul/workspace/etc/ 2019-08-16 04:41:24.429099 | primary | sending incremental file list 2019-08-16 04:41:24.438137 | primary | ./ 2019-08-16 04:41:24.438256 | primary | yum.conf 2019-08-16 04:41:24.438587 | primary | yum.repos.d/ 2019-08-16 04:41:24.438708 | primary | yum.repos.d/CentOS-Base.repo 2019-08-16 04:41:24.438953 | primary | yum.repos.d/CentOS-CR.repo 2019-08-16 04:41:24.439286 | primary | yum.repos.d/CentOS-Debuginfo.repo 2019-08-16 04:41:24.439583 | primary | yum.repos.d/CentOS-Media.repo 2019-08-16 04:41:24.439887 | primary | yum.repos.d/CentOS-Sources.repo 2019-08-16 04:41:24.440184 | primary | yum.repos.d/CentOS-Vault.repo 2019-08-16 04:41:24.440536 | primary | yum.repos.d/CentOS-fasttrack.repo 2019-08-16 04:41:24.440828 | primary | yum.repos.d/epel-testing.repo 2019-08-16 04:41:24.441110 | primary | yum.repos.d/epel.repo 2019-08-16 04:41:24.442838 | primary | 2019-08-16 04:41:24.442992 | primary | sent 14,130 bytes received 221 bytes 28,702.00 bytes/sec 2019-08-16 04:41:24.443098 | primary | total size is 13,330 speedup is 0.93 2019-08-16 04:41:24.443309 | primary | + gzip -r /home/zuul/workspace/logs /home/zuul/workspace/conf /home/zuul/workspace/etc 2019-08-16 04:41:24.679915 | primary | + chmod -R a+r /home/zuul/workspace 2019-08-16 04:41:24.682688 | primary | + chown -R zuul: /home/zuul/workspace 2019-08-16 04:41:24.919560 | primary | ok: Runtime: 0:00:00.640438 2019-08-16 04:41:24.972026 | 2019-08-16 04:41:24.972461 | TASK [build-containers : Rename compressed text based files to end with txt.gz extension] 2019-08-16 04:41:25.613432 | primary | ok: Runtime: 0:00:00.065756 2019-08-16 04:41:25.665233 | 2019-08-16 04:41:25.665461 | TASK [build-containers : Copy files from /home/zuul/workspace/ on node] 2019-08-16 04:41:27.346122 | primary | changed: 2019-08-16 04:41:27.346714 | primary | .d..tp..... ./ 2019-08-16 04:41:27.346830 | primary | cd+++++++++ conf/ 2019-08-16 04:41:27.346939 | primary | >f+++++++++ conf/overcloud_containers.yaml.txt.gz 2019-08-16 04:41:27.347044 | primary | cd+++++++++ etc/ 2019-08-16 04:41:27.347147 | primary | >f+++++++++ etc/yum.conf.txt.gz 2019-08-16 04:41:27.347250 | primary | cd+++++++++ etc/yum.repos.d/ 2019-08-16 04:41:27.347351 | primary | >f+++++++++ etc/yum.repos.d/CentOS-Base.repo.txt.gz 2019-08-16 04:41:27.347453 | primary | >f+++++++++ etc/yum.repos.d/CentOS-CR.repo.txt.gz 2019-08-16 04:41:27.347553 | primary | >f+++++++++ etc/yum.repos.d/CentOS-Debuginfo.repo.txt.gz 2019-08-16 04:41:27.347654 | primary | >f+++++++++ etc/yum.repos.d/CentOS-Media.repo.txt.gz 2019-08-16 04:41:27.347754 | primary | >f+++++++++ etc/yum.repos.d/CentOS-Sources.repo.txt.gz 2019-08-16 04:41:27.347854 | primary | >f+++++++++ etc/yum.repos.d/CentOS-Vault.repo.txt.gz 2019-08-16 04:41:27.347988 | primary | >f+++++++++ etc/yum.repos.d/CentOS-fasttrack.repo.txt.gz 2019-08-16 04:41:27.348091 | primary | >f+++++++++ etc/yum.repos.d/epel-testing.repo.txt.gz 2019-08-16 04:41:27.348192 | primary | >f+++++++++ etc/yum.repos.d/epel.repo.txt.gz 2019-08-16 04:41:27.348291 | primary | cd+++++++++ logs/ 2019-08-16 04:41:27.348391 | primary | >f+++++++++ logs/zuul-variables.yaml.txt.gz 2019-08-16 04:41:27.348491 | primary | cd+++++++++ logs/system/ 2019-08-16 04:41:27.348590 | primary | >f+++++++++ logs/system/btmp.gz 2019-08-16 04:41:27.348690 | primary | >f+++++++++ logs/system/cron.gz 2019-08-16 04:41:27.348790 | primary | >f+++++++++ logs/system/dmesg.gz 2019-08-16 04:41:27.348889 | primary | >f+++++++++ logs/system/grubby_prune_debug.gz 2019-08-16 04:41:27.348988 | primary | >f+++++++++ logs/system/lastlog.gz 2019-08-16 04:41:27.349089 | primary | >f+++++++++ logs/system/maillog.gz 2019-08-16 04:41:27.349389 | primary | >f+++++++++ logs/system/messages.gz 2019-08-16 04:41:27.349556 | primary | >f+++++++++ logs/system/secure.gz 2019-08-16 04:41:27.349692 | primary | >f+++++++++ logs/system/spooler.gz 2019-08-16 04:41:27.349794 | primary | >f+++++++++ logs/system/tallylog.gz 2019-08-16 04:41:27.349894 | primary | >f+++++++++ logs/system/unbound.log.txt.gz 2019-08-16 04:41:27.349994 | primary | >f+++++++++ logs/system/wtmp.gz 2019-08-16 04:41:27.350094 | primary | >f+++++++++ logs/system/yum.log.txt.gz 2019-08-16 04:41:27.350258 | primary | cd+++++++++ logs/system/audit/ 2019-08-16 04:41:27.350360 | primary | >f+++++++++ logs/system/audit/audit.log.txt.gz 2019-08-16 04:41:27.350483 | primary | cd+++++++++ logs/system/journal/ 2019-08-16 04:41:27.350602 | primary | cd+++++++++ logs/system/journal/762f8e4bebd742e6adf942016590b7e1/ 2019-08-16 04:41:27.350707 | primary | >f+++++++++ logs/system/journal/762f8e4bebd742e6adf942016590b7e1/system.journal.gz 2019-08-16 04:41:27.350829 | primary | >f+++++++++ logs/system/journal/762f8e4bebd742e6adf942016590b7e1/user-1000.journal.gz 2019-08-16 04:41:27.350935 | primary | cd+++++++++ logs/system/openvswitch/ 2019-08-16 04:41:27.351050 | primary | >f+++++++++ logs/system/openvswitch/ovs-vswitchd.log.txt.gz 2019-08-16 04:41:27.351172 | primary | >f+++++++++ logs/system/openvswitch/ovsdb-server.log.txt.gz 2019-08-16 04:41:27.373409 | 2019-08-16 04:41:27.373593 | PLAY RECAP 2019-08-16 04:41:27.373754 | primary | ok: 4 changed: 3 unreachable: 0 failed: 0 2019-08-16 04:41:27.373860 | 2019-08-16 04:41:27.968903 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/openstack/tripleo-ci/playbooks/tripleo-buildcontainers/post.yaml@master] 2019-08-16 04:41:27.969272 | POST-RUN START: [untrusted : opendev.org/openstack/tripleo-ci/playbooks/tripleo-ci/post.yaml@master] 2019-08-16 04:41:31.520376 | 2019-08-16 04:41:31.520859 | PLAY [Write console log to localhost as fact zuul_console_json] 2019-08-16 04:41:31.554450 | 2019-08-16 04:41:31.554709 | TASK [capture console log json as fact] 2019-08-16 04:41:32.533436 | localhost | ok 2019-08-16 04:41:33.018166 | 2019-08-16 04:41:33.018393 | PLAY [Collect logs] 2019-08-16 04:41:33.058349 | 2019-08-16 04:41:33.058601 | TASK [set collection timeout] 2019-08-16 04:41:33.248017 | primary | ok 2019-08-16 04:41:33.297684 | 2019-08-16 04:41:33.297910 | TASK [Copy zuul_console_json log to workspace for reproducer] 2019-08-16 04:41:36.039439 | primary | changed 2019-08-16 04:41:36.078658 | 2019-08-16 04:41:36.078968 | TASK [Check for artifacts created by a previous collect_logs] 2019-08-16 04:41:36.503179 | primary | ok 2019-08-16 04:41:36.560217 | 2019-08-16 04:41:36.560548 | TASK [Remark of collect logs running before post in ovb] 2019-08-16 04:41:36.621743 | primary | skipping: Conditional result was False 2019-08-16 04:41:36.665829 | 2019-08-16 04:41:36.666087 | TASK [Run ansible playbook to collect logs for ovb jobs that weren't able to run collect logs] 2019-08-16 04:41:36.775674 | primary | skipping: Conditional result was False 2019-08-16 04:41:36.814752 | 2019-08-16 04:41:36.814979 | TASK [Check script existence] 2019-08-16 04:41:47.281217 | primary | ok 2019-08-16 04:41:47.324904 | 2019-08-16 04:41:47.325252 | TASK [Run ansible playbook to collect logs] 2019-08-16 04:41:47.446098 | primary | skipping: Conditional result was False 2019-08-16 04:41:47.499496 | 2019-08-16 04:41:47.499763 | TASK [Ensure artifacts directory exists] 2019-08-16 04:41:48.002984 | primary -> localhost | changed 2019-08-16 04:41:48.059446 | 2019-08-16 04:41:48.059731 | TASK [Copy files from /home/zuul/workspace/ on node] 2019-08-16 04:41:59.961512 | primary | Output suppressed because no_log was given 2019-08-16 04:41:59.985543 | 2019-08-16 04:41:59.985858 | PLAY RECAP 2019-08-16 04:41:59.986060 | localhost | ok: 1 changed: 0 unreachable: 0 failed: 0 2019-08-16 04:41:59.986255 | primary | ok: 6 changed: 3 unreachable: 0 failed: 0 2019-08-16 04:41:59.986412 | 2019-08-16 04:42:00.829725 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/openstack/tripleo-ci/playbooks/tripleo-ci/post.yaml@master] 2019-08-16 04:42:00.830040 | POST-RUN START: [trusted : opendev.org/opendev/base-jobs/playbooks/base/post.yaml@master] 2019-08-16 04:42:04.455733 | 2019-08-16 04:42:04.455979 | PLAY [all] 2019-08-16 04:42:04.500494 | 2019-08-16 04:42:04.500734 | TASK [fetch-output : Set log path for multiple nodes] 2019-08-16 04:42:04.560147 | primary | skipping: Conditional result was False 2019-08-16 04:42:04.609246 | 2019-08-16 04:42:04.609465 | TASK [fetch-output : Set log path for single node] 2019-08-16 04:42:04.815909 | primary | ok 2019-08-16 04:42:04.878769 | 2019-08-16 04:42:04.879051 | LOOP [fetch-output : Ensure local output dirs] 2019-08-16 04:42:05.432743 | primary -> localhost | ok: "/var/lib/zuul/builds/5b97af71f8734123988a6845338513b8/work/logs" 2019-08-16 04:42:05.648304 | primary -> localhost | ok: "/var/lib/zuul/builds/5b97af71f8734123988a6845338513b8/work/artifacts" 2019-08-16 04:42:05.862829 | primary -> localhost | changed: "/var/lib/zuul/builds/5b97af71f8734123988a6845338513b8/work/docs" 2019-08-16 04:42:05.906151 | 2019-08-16 04:42:05.906382 | TASK [fetch-output : Collect log output] 2019-08-16 04:42:07.471300 | primary | changed: .d..t...... ./ 2019-08-16 04:42:07.512849 | 2019-08-16 04:42:07.513072 | TASK [fetch-output : Collect artifacts] 2019-08-16 04:42:09.006954 | primary | changed: .d..tp..... ./ 2019-08-16 04:42:09.049274 | 2019-08-16 04:42:09.049529 | TASK [fetch-output : Collect docs] 2019-08-16 04:42:10.422758 | primary | changed: .d..tp..... ./ 2019-08-16 04:42:10.509333 | 2019-08-16 04:42:10.509622 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2019-08-16 04:42:11.098075 | primary -> localhost | ok: Item: artifacts Runtime: 0:00:00.007401 2019-08-16 04:42:11.098811 | primary -> localhost | changed: All items complete 2019-08-16 04:42:11.098922 | 2019-08-16 04:42:11.325207 | primary -> localhost | ok: Item: docs Runtime: 0:00:00.005836 2019-08-16 04:42:11.359461 | 2019-08-16 04:42:11.359688 | PLAY [all] 2019-08-16 04:42:11.404225 | 2019-08-16 04:42:11.404472 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2019-08-16 04:42:12.264242 | primary | changed 2019-08-16 04:42:12.286536 | 2019-08-16 04:42:12.286693 | PLAY RECAP 2019-08-16 04:42:12.286840 | primary | ok: 7 changed: 6 unreachable: 0 failed: 0 2019-08-16 04:42:12.286944 | 2019-08-16 04:42:13.088537 | POST-RUN END RESULT_NORMAL: [trusted : opendev.org/opendev/base-jobs/playbooks/base/post.yaml@master] 2019-08-16 04:42:13.088865 | POST-RUN START: [trusted : opendev.org/opendev/base-jobs/playbooks/base/post-logs.yaml@master] 2019-08-16 04:42:16.611630 | 2019-08-16 04:42:16.611869 | PLAY [localhost] 2019-08-16 04:42:16.648941 | 2019-08-16 04:42:16.649159 | TASK [Include ara report role] 2019-08-16 04:42:16.697516 | localhost | ok 2019-08-16 04:42:16.805630 | 2019-08-16 04:42:16.805900 | TASK [ara-report : Check that ARA is installed] 2019-08-16 04:42:17.455130 | localhost | /usr/local/bin/ara 2019-08-16 04:42:17.455717 | localhost | ok: Runtime: 0:00:00.004452 2019-08-16 04:42:17.487342 | 2019-08-16 04:42:17.487574 | TASK [ara-report : Warn if ARA is not installed] 2019-08-16 04:42:17.541548 | localhost | skipping: Conditional result was False 2019-08-16 04:42:17.571364 | 2019-08-16 04:42:17.571573 | TASK [ara-report : Check that the ARA database exists] 2019-08-16 04:42:18.124874 | localhost | ok 2019-08-16 04:42:18.165886 | 2019-08-16 04:42:18.166146 | TASK [ara-report : Warn if no database is found] 2019-08-16 04:42:18.225890 | localhost | skipping: Conditional result was False 2019-08-16 04:42:18.261712 | 2019-08-16 04:42:18.261917 | TASK [ara-report : Validate role configuration] 2019-08-16 04:42:18.375292 | localhost | ok: All assertions passed 2019-08-16 04:42:18.406393 | 2019-08-16 04:42:18.406673 | TASK [ara-report : Prefix the log path with the log root] 2019-08-16 04:42:18.510740 | localhost | ok 2019-08-16 04:42:18.538994 | 2019-08-16 04:42:18.539233 | TASK [ara-report : Generate ARA HTML output] 2019-08-16 04:42:30.955483 | localhost | Done. 2019-08-16 04:42:30.956080 | localhost | ok: Runtime: 0:00:12.076589 2019-08-16 04:42:31.006707 | 2019-08-16 04:42:31.007066 | TASK [ara-report : Compress ARA HTML output] 2019-08-16 04:42:31.093339 | localhost | skipping: Conditional result was False 2019-08-16 04:42:31.126498 | 2019-08-16 04:42:31.126708 | TASK [ara-report : Create the ARA database report directory] 2019-08-16 04:42:31.189439 | localhost | skipping: Conditional result was False 2019-08-16 04:42:31.217836 | 2019-08-16 04:42:31.218046 | TASK [ara-report : Save the ARA database] 2019-08-16 04:42:31.290434 | localhost | skipping: Conditional result was False 2019-08-16 04:42:31.327527 | 2019-08-16 04:42:31.327761 | TASK [Include Zuul manifest role] 2019-08-16 04:42:31.389873 | localhost | ok 2019-08-16 04:42:31.496884 | 2019-08-16 04:42:31.497192 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2019-08-16 04:42:32.302630 | localhost | changed 2019-08-16 04:42:32.370306 | 2019-08-16 04:42:32.370616 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2019-08-16 04:42:32.471636 | localhost | ok 2019-08-16 04:42:32.500914 | 2019-08-16 04:42:32.501172 | LOOP [Include upload logs role] 2019-08-16 04:42:32.593267 | localhost | Output suppressed because no_log was given 2019-08-16 04:42:32.705728 | 2019-08-16 04:42:32.706002 | TASK [Set zuul-log-path fact] 2019-08-16 04:42:32.799562 | localhost | ok 2019-08-16 04:42:32.865220 | 2019-08-16 04:42:32.865502 | TASK [set-zuul-log-path-fact : Set log path for a change] 2019-08-16 04:42:32.990484 | localhost | ok 2019-08-16 04:42:33.017214 | 2019-08-16 04:42:33.017436 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2019-08-16 04:42:33.073927 | localhost | skipping: Conditional result was False 2019-08-16 04:42:33.101149 | 2019-08-16 04:42:33.101386 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2019-08-16 04:42:33.158372 | localhost | skipping: Conditional result was False 2019-08-16 04:42:33.193106 | 2019-08-16 04:42:33.193325 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2019-08-16 04:42:33.536772 | localhost -> localhost | ok: Runtime: 0:00:00.019013 2019-08-16 04:42:33.581187 | 2019-08-16 04:42:33.581471 | TASK [upload-logs-swift : Upload logs to swift]