In GBP, we happen to run many consecutive transactions using the same session object (when calling Neutron's plugins for creating implicit objects for example).
This can sometimes create inconsistencies between what is persisted in the session and the actual DB state. using expunge_all() before such operations will make sure that the session object will refresh its state.
An example is what sporadically happens with the following UT:
gbp.neutron.tests.unit.services.grouppolicy.test_resource_mapping.TestPolicyRuleSet.test_update_policy_classifier_hier
gbp.neutron.tests.unit.services.grouppolicy.test_resource_mapping.TestPolicyRuleSet.test_update_policy_classifier_hier_StringException: Traceback (most recent call last):
_StringException: Empty attachments:
pythonlogging:'neutron.api.extensions'
stderr
stdout
pythonlogging:'': {{{
2014-12-19 20:04:23,280 INFO [neutron.manager] Loading core plugin: gbp.neutron.tests.unit.services.grouppolicy.test_resource_mapping.NoL3NatSGTestPlugin
2014-12-19 20:04:23,281 INFO [neutron.manager] Loading Plugin: gbp.neutron.services.grouppolicy.plugin.GroupPolicyPlugin
2014-12-19 20:04:23,281 INFO [gbp.neutron.services.grouppolicy.extension_manager] Configured extension driver names: []
2014-12-19 20:04:23,282 INFO [gbp.neutron.services.grouppolicy.extension_manager] Loaded extension driver names: []
2014-12-19 20:04:23,282 INFO [gbp.neutron.services.grouppolicy.extension_manager] Registered extension drivers: []
2014-12-19 20:04:23,282 INFO [gbp.neutron.services.grouppolicy.policy_driver_manager] Configured policy driver names: ['implicit_policy', 'resource_mapping']
2014-12-19 20:04:23,283 INFO [gbp.neutron.services.grouppolicy.policy_driver_manager] Loaded policy driver names: ['implicit_policy', 'resource_mapping']
2014-12-19 20:04:23,283 INFO [gbp.neutron.services.grouppolicy.policy_driver_manager] Registered policy drivers: ['implicit_policy', 'resource_mapping']
2014-12-19 20:04:23,283 INFO [gbp.neutron.services.grouppolicy.policy_driver_manager] Initializing policy driver 'implicit_policy'
2014-12-19 20:04:23,284 INFO [gbp.neutron.services.grouppolicy.policy_driver_manager] Initializing policy driver 'resource_mapping'
2014-12-19 20:04:23,284 INFO [neutron.manager] Loading Plugin: router
2014-12-19 20:04:23,285 INFO [neutron.db.l3_agentschedulers_db] Skipping period L3 agent status check because automatic router rescheduling is disabled.
2014-12-19 20:04:23,285 INFO [neutron.manager] Loading Plugin: gbp.neutron.services.servicechain.servicechain_plugin.ServiceChainPlugin
2014-12-19 20:04:23,286 INFO [gbp.neutron.services.servicechain.driver_manager] Configured servicechain driver names: ['dummy']
2014-12-19 20:04:23,286 INFO [gbp.neutron.services.servicechain.driver_manager] Loaded servicechain driver names: ['dummy']
2014-12-19 20:04:23,286 INFO [gbp.neutron.services.servicechain.driver_manager] Registered servicechain drivers: ['dummy']
2014-12-19 20:04:23,286 INFO [gbp.neutron.services.servicechain.driver_manager] Initializing servicechain driver 'dummy'
2014-12-19 20:04:23,310 INFO [neutron.common.config] Config paste file: /home/jenkins/workspace/gate-group-based-policy-python27/.tox/py27/src/neutron/neutron/tests/etc/api-paste.ini.test
2014-12-19 20:04:23,313 WARNING [neutron.quota] security_group is already registered.
2014-12-19 20:04:23,314 WARNING [neutron.quota] security_group_rule is already registered.
2014-12-19 20:04:23,322 WARNING [neutron.quota] router is already registered.
2014-12-19 20:04:23,323 WARNING [neutron.quota] floatingip is already registered.
2014-12-19 20:04:24,055 WARNING [gbp.neutron.services.grouppolicy.drivers.resource_mapping] Security Group already exists Security group rule already exists. Rule id is %(id)s.
2014-12-19 20:04:24,069 WARNING [gbp.neutron.services.grouppolicy.drivers.resource_mapping] Security Group already exists Security group rule already exists. Rule id is %(id)s.
2014-12-19 20:04:24,508 WARNING [neutron.scheduler.l3_agent_scheduler] No active L3 agents
2014-12-19 20:04:24,611 WARNING [gbp.neutron.services.grouppolicy.drivers.resource_mapping] Security Group already exists Security group rule already exists. Rule id is %(id)s.
2014-12-19 20:04:24,639 WARNING [gbp.neutron.services.grouppolicy.drivers.resource_mapping] Security Group already exists Security group rule already exists. Rule id is %(id)s.
2014-12-19 20:04:25,075 WARNING [neutron.scheduler.l3_agent_scheduler] No active L3 agents
2014-12-19 20:04:25,198 WARNING [gbp.neutron.services.grouppolicy.drivers.resource_mapping] Security Group already exists Security group rule already exists. Rule id is %(id)s.
2014-12-19 20:04:25,217 WARNING [gbp.neutron.services.grouppolicy.drivers.resource_mapping] Security Group already exists Security group rule already exists. Rule id is %(id)s.
}}}
Traceback (most recent call last):
File "gbp/neutron/tests/unit/services/grouppolicy/test_resource_mapping.py", line 1712, in test_update_policy_classifier_hier
self._verify_prs_rules(prs['id'])
File "gbp/neutron/tests/unit/services/grouppolicy/test_resource_mapping.py", line 273, in _verify_prs_rules
"Rule not found, expected:\n%s" % rule)
File "/home/jenkins/workspace/gate-group-based-policy-python27/.tox/py27/local/lib/python2.7/site-packages/unittest2/case.py", line 678, in assertTrue
raise self.failureException(msg)
AssertionError: False is not true : Rule not found, expected:
{'direction': ['ingress'], 'protocol': [u'tcp'], 'remote_ip_prefix': [u'10.0.0.64/26'], 'port_range_max': [8080], 'security_group_id': [u'1f59175f-46e7-4702-b23e-ffb30d2218bf'], 'port_range_min': [8080]}
Also see the logs here:
http://logs.openstack.org/29/143029/3/check/gate-group-based-policy-python27/7b97432/testr_results.html.gz
Fix proposed to branch: master
Review: https:/