a) Most of the failing tests appear to be towards the end of the test suite consisting of 1667+ test
b) It appears the test cases timeout while the L-3 agent is still in the middle of configuring the iptables for the floatingip. Here are couple of timing correlations I found in this particular test job.
c) While looking at these Mike brought up the point that there is a large accumulation of namespaces towards the tail end of the test suite. These accumulated namespaces could slow down the L-3 agent significantly.
Too early to conclude anything but from an analysis of the failing job http:// logs.openstack. org/22/ 149122/ 3/check/ check-tempest- dsvm-neutron- dvr/35e420c/ logs/testr_ results. html.gz noticed a few things:
a) Most of the failing tests appear to be towards the end of the test suite consisting of 1667+ test
b) It appears the test cases timeout while the L-3 agent is still in the middle of configuring the iptables for the floatingip. Here are couple of timing correlations I found in this particular test job.
c) While looking at these Mike brought up the point that there is a large accumulation of namespaces towards the tail end of the test suite. These accumulated namespaces could slow down the L-3 agent significantly.
http:// logs.openstack. org/22/ 149122/ 3/check/ check-tempest- dsvm-neutron- dvr/35e420c/ logs/testr_ results. html.gz
--> test_network_ basic_ops[ compute, gate,network, smoke]
2015-01-26 03:33:00,337 8115 DEBUG [tempest. scenario. manager] checking network connections to IP 172.24.4.119 with user: cirros scenario. manager] Public network connectivity check failed scenario. manager Traceback (most recent call last): scenario. manager File "tempest/ scenario/ manager. py", line 501, in check_public_ network_ connectivity scenario. manager should_ connect= should_ connect) scenario. manager File "tempest/ scenario/ manager. py", line 485, in check_vm_ connectivity scenario. manager msg=msg) scenario. manager File "/usr/local/ lib/python2. 7/dist- packages/ unittest2/ case.py" , line 678, in assertTrue scenario. manager raise self.failureExc eption( msg) scenario. manager AssertionError: False is not true : Timed out waiting for 172.24.4.119 to become reachable scenario. manager
2015-01-26 03:35:00,550 8115 ERROR [tempest.
2015-01-26 03:35:00.550 8115 TRACE tempest.
2015-01-26 03:35:00.550 8115 TRACE tempest.
2015-01-26 03:35:00.550 8115 TRACE tempest.
2015-01-26 03:35:00.550 8115 TRACE tempest.
2015-01-26 03:35:00.550 8115 TRACE tempest.
2015-01-26 03:35:00.550 8115 TRACE tempest.
2015-01-26 03:35:00.550 8115 TRACE tempest.
2015-01-26 03:35:00.550 8115 TRACE tempest.
2015-01-26 03:35:00.550 8115 TRACE tempest.
---> From L-3 agent log:
2015-01-26 03:35:03.970 DEBUG neutron. agent.linux. utils [req-8ba4a420- 10d9-4581- 86a0-8fbcd866a7 45 TestNetworkBasi cOps-82148639 TestNetworkBasi cOps-1630875080 ] bin/neutron- rootwrap' , '/etc/neutron/ rootwrap. conf', 'ip', 'netns', 'exec', 'qrouter- 190c5c9d- 4c95-4a77- 8efd-cc205e776c af', 'iptables-save', '-c'] vpn-agen- OUTPUT - [0:0] vpn-agen- PREROUTING - [0:0] vpn-agen- PREROUTING vpn-agen- OUTPUT postrouting- bottom - [0:0] vpn-agen- OUTPUT - [0:0] vpn-agen- POSTROUTING - [0:0] vpn-agen- PREROUTING - [0:0] vpn-agen- float-snat - [0:0] vpn-agen- snat - [0:0] vpn-agen- PREROUTING vpn-agen- OUTPUT vpn-agen- POSTROUTING postrouting- bottom postrouting- bottom -m comment --comment "Perform source NAT on outgoing traffic." -j neutron- vpn-agen- snat vpn-agen- OUTPUT -d 172.24.4.119/32 -j DNAT --to-destination 10.100.0.3 vpn-agen- PREROUTING -d 169.254.169.254/32 -p tcp -m tcp --dport 80 -j REDIRECT --to-ports 9697 vpn-agen- PREROUTING -d 172.24.4.119/32 -j DNAT --to-destination 10.100.0.3 vpn-agen- float-snat -s 10.100.0.3/32 -j SNAT --to-source 172.24.4.119 vpn-agen- snat -j neutron- vpn-agen- float-snat
Command: ['sudo', '/usr/local/
Exit code: 0
Stdout: # Generated by iptables-save v1.4.21 on Mon Jan 26 03:35:03 2015
*raw
:PREROUTING ACCEPT [3:714]
:OUTPUT ACCEPT [1:84]
:neutron-
:neutron-
[3:714] -A PREROUTING -j neutron-
[1:84] -A OUTPUT -j neutron-
COMMIT
# Completed on Mon Jan 26 03:35:03 2015
# Generated by iptables-save v1.4.21 on Mon Jan 26 03:35:03 2015
*nat
:PREROUTING ACCEPT [2:393]
:INPUT ACCEPT [2:393]
:OUTPUT ACCEPT [0:0]
:POSTROUTING ACCEPT [0:0]
:neutron-
:neutron-
:neutron-
:neutron-
:neutron-
:neutron-
[2:393] -A PREROUTING -j neutron-
[0:0] -A OUTPUT -j neutron-
[0:0] -A POSTROUTING -j neutron-
[0:0] -A POSTROUTING -j neutron-
[0:0] -A neutron-
[0:0] -A neutron-
[0:0] -A neutron-
[0:0] -A neutron-
[0:0] -A neutron-
[0:0] -A neutron-
COMMIT
# Completed on Mon Jan 26 03:35:03 2015
---> test_dhcp6_ stateless_ from_os[ compute, network]
2015-01-26 03:35:23.908 8113 TRACE tempest.common.ssh scenario. manager] Initializing SSH connection to 172.24.4.117 failed scenario. manager Traceback (most recent call last): scenario. manager File "tempest/ scenario/ manager. py", line 317, in get_remote_client scenario. manager linux_client. validate_ authentication( ) scenario. manager File "tempest/ common/ utils/linux/ remote_ client. py", line 55, in validate_ authentication scenario. manager self.ssh_ client. test_connection _auth() scenario. manager File "tempest/ common/ ssh.py" , line 151, in test_connection _auth scenario. manager connection = self._get_ ssh_connection( ) scenario. manager File "tempest/ common/ ssh.py" , line 88, in _get_ssh_connection scenario. manager password= self.password) scenario. manager SSHTimeout: Connection to the 172.24.4.117 via SSH timed out. scenario. manager User: cirros, Password: None
2015-01-26 03:35:23,909 8113 ERROR [tempest.
2015-01-26 03:35:23.909 8113 TRACE tempest.
2015-01-26 03:35:23.909 8113 TRACE tempest.
2015-01-26 03:35:23.909 8113 TRACE tempest.
2015-01-26 03:35:23.909 8113 TRACE tempest.
2015-01-26 03:35:23.909 8113 TRACE tempest.
2015-01-26 03:35:23.909 8113 TRACE tempest.
2015-01-26 03:35:23.909 8113 TRACE tempest.
2015-01-26 03:35:23.909 8113 TRACE tempest.
2015-01-26 03:35:23.909 8113 TRACE tempest.
2015-01-26 03:35:23.909 8113 TRACE tempest.
2015-01-26 03:35:23.909 8113 TRACE tempest.
---> From L-3 agent log:
Command: ['sudo', '/usr/local/ bin/neutron- rootwrap' , '/etc/neutron/ rootwrap. conf', 'ip', 'netns', 'exec', 'qrouter- 1f8d3856- b065-446c- 9d73-38b763c962 e1', 'iptables-save', '-c'] vpn-agen- OUTPUT - [0:0] vpn-agen- PREROUTING - [0:0] vpn-agen- PREROUTING vpn-agen- OUTPUT postrouting- bottom - [0:0] vpn-agen- OUTPUT - [0:0] vpn-agen- POSTROUTING - [0:0] vpn-agen- PREROUTING - [0:0] vpn-agen- float-snat - [0:0] vpn-agen- snat - [0:0] vpn-agen- PREROUTING vpn-agen- OUTPUT vpn-agen- POSTROUTING postrouting- bottom postrouting- bottom -m comment --comment "Perform source NAT on outgoing traffic." -j neutron- vpn-agen- snat vpn-agen- OUTPUT -d 172.24.4.117/32 -j DNAT --to-destination 10.100.0.3 vpn-agen- PREROUTING -d 169.254.169.254/32 -p tcp -m tcp --dport 80 -j REDIRECT --to-ports 9697 vpn-agen- PREROUTING -d 172.24.4.117/32 -j DNAT --to-destination 10.100.0.3 vpn-agen- float-snat -s 10.100.0.3/32 -j SNAT --to-source 172.24.4.117 vpn-agen- snat -j neutron- vpn-agen- float-snat
Exit code: 0
Stdout: # Generated by iptables-save v1.4.21 on Mon Jan 26 03:35:27 2015
*raw
:PREROUTING ACCEPT [3:714]
:OUTPUT ACCEPT [1:84]
:neutron-
:neutron-
[3:714] -A PREROUTING -j neutron-
[1:84] -A OUTPUT -j neutron-
COMMIT
# Completed on Mon Jan 26 03:35:27 2015
# Generated by iptables-save v1.4.21 on Mon Jan 26 03:35:27 2015
*nat
:PREROUTING ACCEPT [2:393]
:INPUT ACCEPT [2:393]
:OUTPUT ACCEPT [0:0]
:POSTROUTING ACCEPT [0:0]
:neutron-
:neutron-
:neutron-
:neutron-
:neutron-
:neutron-
[2:393] -A PREROUTING -j neutron-
[0:0] -A OUTPUT -j neutron-
[0:0] -A POSTROUTING -j neutron-
[0:0] -A POSTROUTING -j neutron-
[0:0] -A neutron-
[0:0] -A neutron-
[0:0] -A neutron-
[0:0] -A neutron-
[0:0] -A neutron-
[0:0] -A neutron-
COMMIT