Merge "Change ovs-agent iteration log level to INFO"

This commit is contained in:
Zuul 2019-09-13 03:15:42 +00:00 committed by Gerrit Code Review
commit e77a4a840b

View File

@ -1966,7 +1966,7 @@ class OVSNeutronAgent(l2population_rpc.L2populationRpcCallBackTunnelMixin,
need_binding_devices, failed_devices['added']) = ( need_binding_devices, failed_devices['added']) = (
self.treat_devices_added_or_updated( self.treat_devices_added_or_updated(
devices_added_updated, provisioning_needed)) devices_added_updated, provisioning_needed))
LOG.debug("process_network_ports - iteration:%(iter_num)d - " LOG.info("process_network_ports - iteration:%(iter_num)d - "
"treat_devices_added_or_updated completed. " "treat_devices_added_or_updated completed. "
"Skipped %(num_skipped)d and no activated binding " "Skipped %(num_skipped)d and no activated binding "
"devices %(num_no_active_binding)d of %(num_current)d " "devices %(num_no_active_binding)d of %(num_current)d "
@ -2000,14 +2000,14 @@ class OVSNeutronAgent(l2population_rpc.L2populationRpcCallBackTunnelMixin,
start = time.time() start = time.time()
failed_devices['removed'] |= self.treat_devices_removed( failed_devices['removed'] |= self.treat_devices_removed(
port_info['removed']) port_info['removed'])
LOG.debug("process_network_ports - iteration:%(iter_num)d - " LOG.info("process_network_ports - iteration:%(iter_num)d - "
"treat_devices_removed completed in %(elapsed).3f", "treat_devices_removed completed in %(elapsed).3f",
{'iter_num': self.iter_num, {'iter_num': self.iter_num,
'elapsed': time.time() - start}) 'elapsed': time.time() - start})
if skipped_devices: if skipped_devices:
start = time.time() start = time.time()
self.treat_devices_skipped(skipped_devices) self.treat_devices_skipped(skipped_devices)
LOG.debug("process_network_ports - iteration:%(iter_num)d - " LOG.info("process_network_ports - iteration:%(iter_num)d - "
"treat_devices_skipped completed in %(elapsed).3f", "treat_devices_skipped completed in %(elapsed).3f",
{'iter_num': self.iter_num, {'iter_num': self.iter_num,
'elapsed': time.time() - start}) 'elapsed': time.time() - start})
@ -2019,7 +2019,7 @@ class OVSNeutronAgent(l2population_rpc.L2populationRpcCallBackTunnelMixin,
start = time.time() start = time.time()
failed_added = self.treat_ancillary_devices_added( failed_added = self.treat_ancillary_devices_added(
port_info['added']) port_info['added'])
LOG.debug("process_ancillary_network_ports - iteration: " LOG.info("process_ancillary_network_ports - iteration: "
"%(iter_num)d - treat_ancillary_devices_added " "%(iter_num)d - treat_ancillary_devices_added "
"completed in %(elapsed).3f", "completed in %(elapsed).3f",
{'iter_num': self.iter_num, {'iter_num': self.iter_num,
@ -2032,7 +2032,7 @@ class OVSNeutronAgent(l2population_rpc.L2populationRpcCallBackTunnelMixin,
port_info['removed']) port_info['removed'])
failed_devices['removed'] = failed_removed failed_devices['removed'] = failed_removed
LOG.debug("process_ancillary_network_ports - iteration: " LOG.info("process_ancillary_network_ports - iteration: "
"%(iter_num)d - treat_ancillary_devices_removed " "%(iter_num)d - treat_ancillary_devices_removed "
"completed in %(elapsed).3f", "completed in %(elapsed).3f",
{'iter_num': self.iter_num, {'iter_num': self.iter_num,
@ -2132,7 +2132,7 @@ class OVSNeutronAgent(l2population_rpc.L2populationRpcCallBackTunnelMixin,
def loop_count_and_wait(self, start_time, port_stats): def loop_count_and_wait(self, start_time, port_stats):
# sleep till end of polling interval # sleep till end of polling interval
elapsed = time.time() - start_time elapsed = time.time() - start_time
LOG.debug("Agent rpc_loop - iteration:%(iter_num)d " LOG.info("Agent rpc_loop - iteration:%(iter_num)d "
"completed. Processed ports statistics: " "completed. Processed ports statistics: "
"%(port_stats)s. Elapsed:%(elapsed).3f", "%(port_stats)s. Elapsed:%(elapsed).3f",
{'iter_num': self.iter_num, {'iter_num': self.iter_num,
@ -2209,7 +2209,7 @@ class OVSNeutronAgent(l2population_rpc.L2populationRpcCallBackTunnelMixin,
if self.ancillary_brs: if self.ancillary_brs:
ancillary_port_info = self.scan_ancillary_ports( ancillary_port_info = self.scan_ancillary_ports(
ancillary_ports, sync) ancillary_ports, sync)
LOG.debug("Agent rpc_loop - iteration:%(iter_num)d" LOG.info("Agent rpc_loop - iteration:%(iter_num)d"
" - ancillary port info retrieved. " " - ancillary port info retrieved. "
"Elapsed:%(elapsed).3f", "Elapsed:%(elapsed).3f",
{'iter_num': self.iter_num, {'iter_num': self.iter_num,
@ -2348,7 +2348,7 @@ class OVSNeutronAgent(l2population_rpc.L2populationRpcCallBackTunnelMixin,
port_info = {} port_info = {}
ancillary_port_info = {} ancillary_port_info = {}
start = time.time() start = time.time()
LOG.debug("Agent rpc_loop - iteration:%d started", LOG.info("Agent rpc_loop - iteration:%d started",
self.iter_num) self.iter_num)
ovs_status = self.check_ovs_status() ovs_status = self.check_ovs_status()
if ovs_status == constants.OVS_RESTARTED: if ovs_status == constants.OVS_RESTARTED:
@ -2380,7 +2380,7 @@ class OVSNeutronAgent(l2population_rpc.L2populationRpcCallBackTunnelMixin,
if (self._agent_has_updates(polling_manager) or sync or if (self._agent_has_updates(polling_manager) or sync or
devices_need_retry): devices_need_retry):
try: try:
LOG.debug("Agent rpc_loop - iteration:%(iter_num)d - " LOG.info("Agent rpc_loop - iteration:%(iter_num)d - "
"starting polling. Elapsed:%(elapsed).3f", "starting polling. Elapsed:%(elapsed).3f",
{'iter_num': self.iter_num, {'iter_num': self.iter_num,
'elapsed': time.time() - start}) 'elapsed': time.time() - start})
@ -2417,7 +2417,7 @@ class OVSNeutronAgent(l2population_rpc.L2populationRpcCallBackTunnelMixin,
if ofport_changed_ports: if ofport_changed_ports:
port_info.setdefault('updated', set()).update( port_info.setdefault('updated', set()).update(
ofport_changed_ports) ofport_changed_ports)
LOG.debug("Agent rpc_loop - iteration:%(iter_num)d - " LOG.info("Agent rpc_loop - iteration:%(iter_num)d - "
"port information retrieved. " "port information retrieved. "
"Elapsed:%(elapsed).3f", "Elapsed:%(elapsed).3f",
{'iter_num': self.iter_num, {'iter_num': self.iter_num,
@ -2436,7 +2436,7 @@ class OVSNeutronAgent(l2population_rpc.L2populationRpcCallBackTunnelMixin,
if need_clean_stale_flow: if need_clean_stale_flow:
self.cleanup_stale_flows() self.cleanup_stale_flows()
need_clean_stale_flow = False need_clean_stale_flow = False
LOG.debug("Agent rpc_loop - iteration:%(iter_num)d - " LOG.info("Agent rpc_loop - iteration:%(iter_num)d - "
"ports processed. Elapsed:%(elapsed).3f", "ports processed. Elapsed:%(elapsed).3f",
{'iter_num': self.iter_num, {'iter_num': self.iter_num,
'elapsed': time.time() - start}) 'elapsed': time.time() - start})
@ -2447,7 +2447,7 @@ class OVSNeutronAgent(l2population_rpc.L2populationRpcCallBackTunnelMixin,
failed_ancillary_devices = ( failed_ancillary_devices = (
self.process_ancillary_network_ports( self.process_ancillary_network_ports(
ancillary_port_info)) ancillary_port_info))
LOG.debug("Agent rpc_loop - iteration: " LOG.info("Agent rpc_loop - iteration: "
"%(iter_num)d - ancillary ports " "%(iter_num)d - ancillary ports "
"processed. Elapsed:%(elapsed).3f", "processed. Elapsed:%(elapsed).3f",
{'iter_num': self.iter_num, {'iter_num': self.iter_num,