Comment 9 for bug 1336755

Revision history for this message
gordon chung (chungg) wrote :

currently debugging... either the number of messages increased substantially or something is negatively affected collector performance.

seems to be ~4min delay between receiving message in notification agent:
2014-07-23 00:03:17.634 28684 INFO ceilometer.network.notifications [-] network notification {u'_context_roles': [u'_member_', u'admin'], u'_context_request_id': u'req-1a56fae5-05e8-499f-ba8d-049778517b1e', u'_context_read_deleted': u'no', 'event_type': u'port.create.end', u'_context_user_name': u'neutron', u'_context_project_name': u'service', 'timestamp': u'2014-07-23 00:03:17.522174', u'_context_tenant_name': u'service', u'_context_tenant': u'a30c10acdcdf4a8982749b798df12e63', 'message_id': u'71a89d5e-6c4d-4a29-b27f-27761ba6c7cd', 'priority': 'info', u'_context_is_admin': True, u'_context_timestamp': u'2014-07-23 00:03:16.928028', u'_context_project_id': u'a30c10acdcdf4a8982749b798df12e63', u'_context_tenant_id': u'a30c10acdcdf4a8982749b798df12e63', u'_context_user': u'4dadb69da15c477e8ad5807bb51545ac', u'_context_user_id': u'4dadb69da15c477e8ad5807bb51545ac', 'publisher_id': u'network.devstack-trusty-hpcloud-b4-1037295', 'payload': {u'port': {u'status': u'DOWN', u'binding:host_id': u'devstack-trusty-hpcloud-b4-1037295', u'name': u'', u'allowed_address_pairs': [], u'admin_state_up': True, u'network_id': u'30ace1bf-0fe9-4fe9-9050-c8177eb46943', u'tenant_id': u'33727d88b92e4fccb6f1cee02e928a1f', u'extra_dhcp_opts': [], u'binding:vnic_type': u'normal', u'binding:vif_type': u'ovs', u'device_owner': u'compute:None', u'mac_address': u'fa:16:3e:a9:ef:15', u'id': u'fa55a4e9-c7f9-4e39-b4d3-dfe8179d401a', u'binding:profile': {}, u'fixed_ips': [{u'subnet_id': u'12c84344-654e-4054-92f0-e60ddeb81c8c', u'ip_address': u'10.100.0.2'}], u'binding:vif_details': {u'port_filter': True, u'ovs_hybrid_plug': True}, u'security_groups': [u'ccb7c2d3-6dcc-4221-a27d-36fe43a93bec'], u'device_id': u'35ce924d-27f7-4f79-a358-fdad61b2a41b'}}}

and writing it to db:

2014-07-23 00:07:40.124 28683 DEBUG ceilometer.dispatcher.database [-] metering data instance:m1.nano for 35ce924d-27f7-4f79-a358-fdad61b2a41b @ 2014-07-23 00:03:15.433578: 1 record_metering_data /opt/stack/new/ceilometer/ceilometer/dispatcher/database.py:55
2014-07-23 00:07:40.147 28683 DEBUG ceilometer.dispatcher.database [-] metering data vcpus for 35ce924d-27f7-4f79-a358-fdad61b2a41b @ 2014-07-23 00:03:15.433578: 1 record_metering_data /opt/stack/new/ceilometer/ceilometer/dispatcher/database.py:55
2014-07-23 00:07:40.212 28683 DEBUG ceilometer.dispatcher.database [-] metering data instance for 35ce924d-27f7-4f79-a358-fdad61b2a41b @ 2014-07-23 00:03:15.433578: 1 record_metering_data /opt/stack/new/ceilometer/ceilometer/dispatcher/database.py:55
2014-07-23 00:07:40.233 28683 DEBUG ceilometer.dispatcher.database [-] metering data memory for 35ce924d-27f7-4f79-a358-fdad61b2a41b @ 2014-07-23 00:03:15.433578: 64 record_metering_data /opt/stack/new/ceilometer/ceilometer/dispatcher/database.py:55