Nov 07 03:28:08 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:08.955 8480 DEBUG vitrage.entity_graph.processor.processor [-] processor event: Nov 07 03:28:08 dwj-vitrage vitrage-graph[8480]: {u'update_time': u'2017-11-07T03:28:08.725936', u'vitrage_entity_type': u'doctor', u'vitrage_event_type': u'compute.host.down', u'vitrage_datasource_action': u'update', u'vitrage_sample_date': u'2017-11-07 03:28:08.926129+00:00', u'details': {u'status': u'down', u'severity': u'critical', u'monitor_id': u'monitor-1', u'hostname': u'dwj-vitrage', u'source': u'sample_monitor', u'monitor_event_id': u'123', u'cause': u'link-down'}, u'time': u'2017-11-07T03:28:08.725936', u'type': u'compute.host.down'} process_event /opt/stack/vitrage/vitrage/entity_graph/processor/processor.py:56 Nov 07 03:28:08 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:08.969 8480 DEBUG vitrage.entity_graph.processor.processor [-] calculate event state _calculate_vitrage_aggregated_state /opt/stack/vitrage/vitrage/entity_graph/processor/processor.py:302 Nov 07 03:28:08 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:08.971 8480 DEBUG vitrage.graph.driver.networkx_graph [-] get_vertex item not found. v_id=f5744a2d-9837-4bd6-956f-8a777bbe69bd get_vertex /opt/stack/vitrage/vitrage/graph/driver/networkx_graph.py:109 Nov 07 03:28:08 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:08.972 8480 DEBUG vitrage.entity_graph.processor.processor [-] Update entity in entity graph: Nov 07 03:28:08 dwj-vitrage vitrage-graph[8480]: {vertex_id : f5744a2d-9837-4bd6-956f-8a777bbe69bd, properties : {'vitrage_id': 'f5744a2d-9837-4bd6-956f-8a777bbe69bd', u'status': u'down', 'vitrage_aggregated_severity': u'CRITICAL', u'severity': u'critical', 'update_timestamp': '2017-11-07T03:28:08Z', u'monitor_id': u'monitor-1', 'vitrage_operational_severity': u'CRITICAL', u'hostname': u'dwj-vitrage', 'vitrage_category': 'ALARM', 'name': u'compute.host.down', u'source': u'sample_monitor', 'state': 'Active', 'vitrage_type': u'doctor', 'vitrage_sample_timestamp': u'2017-11-07 03:28:08.926129+00:00', 'time': '2017-11-07T03:28:08Z', 'vitrage_is_placeholder': False, u'monitor_event_id': u'123', u'cause': u'link-down', 'is_real_vitrage_id': True, 'vitrage_is_deleted': False}} update_entity /opt/stack/vitrage/vitrage/entity_graph/processor/processor.py:94 Nov 07 03:28:08 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:08.974 8480 DEBUG vitrage.graph.driver.networkx_graph [-] get_vertex item not found. v_id=f5744a2d-9837-4bd6-956f-8a777bbe69bd get_vertex /opt/stack/vitrage/vitrage/graph/driver/networkx_graph.py:109 Nov 07 03:28:08 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:08.975 8480 DEBUG vitrage.graph.driver.networkx_graph [-] get_vertex item not found. v_id=f5744a2d-9837-4bd6-956f-8a777bbe69bd get_vertex /opt/stack/vitrage/vitrage/graph/driver/networkx_graph.py:109 Nov 07 03:28:08 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:08.976 8480 DEBUG vitrage.evaluator.scenario_evaluator [-] Process event disabled process_event /opt/stack/vitrage/vitrage/evaluator/scenario_evaluator.py:101 Nov 07 03:28:08 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:08.980 8715 DEBUG vitrage.graph.driver.networkx_graph [-] get_vertex item not found. v_id=f5744a2d-9837-4bd6-956f-8a777bbe69bd get_vertex /opt/stack/vitrage/vitrage/graph/driver/networkx_graph.py:109 Nov 07 03:28:08 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:08.982 8715 DEBUG vitrage.evaluator.scenario_evaluator [-] Process event - starting process_event /opt/stack/vitrage/vitrage/evaluator/scenario_evaluator.py:104 Nov 07 03:28:08 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:08.983 8715 DEBUG vitrage.evaluator.scenario_evaluator [-] Element before event: None, Current element: {vertex_id : f5744a2d-9837-4bd6-956f-8a777bbe69bd, properties : {'vitrage_id': 'f5744a2d-9837-4bd6-956f-8a777bbe69bd', u'status': u'down', 'update_timestamp': '2017-11-07T03:28:08Z', 'vitrage_operational_severity': u'CRITICAL', 'vitrage_category': 'ALARM', 'vitrage_type': u'doctor', 'vitrage_sample_timestamp': u'2017-11-07 03:28:08.926129+00:00', u'severity': u'critical', 'vitrage_is_deleted': False, u'monitor_id': u'monitor-1', u'cause': u'link-down', u'hostname': u'dwj-vitrage', 'name': u'compute.host.down', u'source': u'sample_monitor', 'state': 'Active', u'monitor_event_id': u'123', 'time': '2017-11-07T03:28:08Z', 'vitrage_is_placeholder': False, 'vitrage_aggregated_severity': u'CRITICAL', 'vitrage_resource_id': '333e1aff-36d0-486e-901a-fbd9efae40e0', 'vitrage_resource_type': 'nova.host', 'is_real_vitrage_id': True}} process_event /opt/stack/vitrage/vitrage/evaluator/scenario_evaluator.py:107 Nov 07 03:28:08 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:08.983 8715 DEBUG vitrage.evaluator.scenario_evaluator [-] Number of relevant scenarios found: undo = 0, do = 3 process_event /opt/stack/vitrage/vitrage/evaluator/scenario_evaluator.py:117 Nov 07 03:28:08 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:08.984 8715 DEBUG vitrage.evaluator.scenario_evaluator [-] Processing: ({vertex_id : host_down_alarm, properties : {'vitrage_category': u'ALARM', u'name': u'compute.host.down'}}, ) _process_and_get_actions /opt/stack/vitrage/vitrage/evaluator/scenario_evaluator.py:166 Nov 07 03:28:08 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:08.987 8715 DEBUG vitrage.evaluator.scenario_evaluator [-] Processing: ({vertex_id : host_down_alarm, properties : {'vitrage_category': u'ALARM', u'name': u'compute.host.down'}}, ) _process_and_get_actions /opt/stack/vitrage/vitrage/evaluator/scenario_evaluator.py:166 Nov 07 03:28:08 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:08.988 8715 DEBUG vitrage.evaluator.scenario_evaluator [-] Processing: ({vertex_id : host_down_alarm, properties : {'vitrage_category': u'ALARM', u'name': u'compute.host.down'}}, ) _process_and_get_actions /opt/stack/vitrage/vitrage/evaluator/scenario_evaluator.py:166 Nov 07 03:28:08 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:08.989 8715 DEBUG vitrage.evaluator.scenario_evaluator [-] Actions before filtering: [] _analyze_and_filter_actions /opt/stack/vitrage/vitrage/evaluator/scenario_evaluator.py:249 Nov 07 03:28:08 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:08.991 8715 DEBUG vitrage.evaluator.scenario_evaluator [-] Process event - completed process_event /opt/stack/vitrage/vitrage/evaluator/scenario_evaluator.py:137 Nov 07 03:28:08 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:08.992 8480 DEBUG vitrage.entity_graph.processor.processor [-] obsolete_edges - nothing to do _delete_old_connections /opt/stack/vitrage/vitrage/entity_graph/processor/processor.py:241 Nov 07 03:28:08 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:08.993 8480 DEBUG vitrage.entity_graph.processor.processor [-] Connect neighbors. Neighbors: [Neighbor(vertex={vertex_id : 333e1aff-36d0-486e-901a-fbd9efae40e0, properties : {'vitrage_id': '333e1aff-36d0-486e-901a-fbd9efae40e0', 'vitrage_is_deleted': False, 'vitrage_category': 'RESOURCE', 'vitrage_type': 'nova.host', 'vitrage_sample_timestamp': u'2017-11-07 03:28:08.926129+00:00', 'vitrage_is_placeholder': True, 'id': u'dwj-vitrage', 'is_real_vitrage_id': True}}, edge={source_id : f5744a2d-9837-4bd6-956f-8a777bbe69bd, target_id : 333e1aff-36d0-486e-901a-fbd9efae40e0, label = on, properties : {'relationship_type': 'on', 'vitrage_is_deleted': False}})], valid_edges: set([]) _connect_neighbors /opt/stack/vitrage/vitrage/entity_graph/processor/processor.py:217 Nov 07 03:28:08 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:08.993 8480 DEBUG vitrage.entity_graph.processor.processor [-] Updates edge: {source_id : f5744a2d-9837-4bd6-956f-8a777bbe69bd, target_id : 333e1aff-36d0-486e-901a-fbd9efae40e0, label = on, properties : {'relationship_type': 'on', 'vitrage_is_deleted': False}} _connect_neighbors /opt/stack/vitrage/vitrage/entity_graph/processor/processor.py:229 Nov 07 03:28:08 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:08.994 8480 DEBUG vitrage.graph.driver.networkx_graph [-] get_edge item not found. source_id=f5744a2d-9837-4bd6-956f-8a777bbe69bd, target_id=333e1aff-36d0-486e-901a-fbd9efae40e0, label=on get_edge /opt/stack/vitrage/vitrage/graph/driver/networkx_graph.py:117 Nov 07 03:28:08 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:08.994 8480 DEBUG vitrage.evaluator.scenario_evaluator [-] Process event disabled process_event /opt/stack/vitrage/vitrage/evaluator/scenario_evaluator.py:101 Nov 07 03:28:08 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:08.995 8715 DEBUG vitrage.graph.driver.networkx_graph [-] get_edge item not found. source_id=f5744a2d-9837-4bd6-956f-8a777bbe69bd, target_id=333e1aff-36d0-486e-901a-fbd9efae40e0, label=on get_edge /opt/stack/vitrage/vitrage/graph/driver/networkx_graph.py:117 Nov 07 03:28:08 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:08.995 8715 DEBUG vitrage.evaluator.scenario_evaluator [-] Process event - starting process_event /opt/stack/vitrage/vitrage/evaluator/scenario_evaluator.py:104 Nov 07 03:28:08 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:08.995 8715 DEBUG vitrage.evaluator.scenario_evaluator [-] Element before event: None, Current element: {source_id : f5744a2d-9837-4bd6-956f-8a777bbe69bd, target_id : 333e1aff-36d0-486e-901a-fbd9efae40e0, label = on, properties : {'relationship_type': 'on', 'vitrage_is_deleted': False}} process_event /opt/stack/vitrage/vitrage/evaluator/scenario_evaluator.py:107 Nov 07 03:28:08 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:08.996 8715 DEBUG vitrage.evaluator.scenario_evaluator [-] Number of relevant scenarios found: undo = 0, do = 3 process_event /opt/stack/vitrage/vitrage/evaluator/scenario_evaluator.py:117 Nov 07 03:28:08 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:08.996 8715 DEBUG vitrage.evaluator.scenario_evaluator [-] Processing: (EdgeDescription(edge={source_id : host_down_alarm, target_id : host, label = on, properties : {u'relationship_type': u'on'}}, source={vertex_id : host_down_alarm, properties : {'vitrage_category': u'ALARM', u'name': u'compute.host.down'}}, target={vertex_id : host, properties : {'vitrage_category': u'RESOURCE', 'vitrage_type': u'nova.host'}}), ) _process_and_get_actions /opt/stack/vitrage/vitrage/evaluator/scenario_evaluator.py:166 Nov 07 03:28:08 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:08.998 8715 DEBUG vitrage.evaluator.scenario_evaluator [-] Processing: (EdgeDescription(edge={source_id : host_down_alarm, target_id : host, label = on, properties : {u'relationship_type': u'on'}}, source={vertex_id : host_down_alarm, properties : {'vitrage_category': u'ALARM', u'name': u'compute.host.down'}}, target={vertex_id : host, properties : {'vitrage_category': u'RESOURCE', 'vitrage_type': u'nova.host'}}), ) _process_and_get_actions /opt/stack/vitrage/vitrage/evaluator/scenario_evaluator.py:166 Nov 07 03:28:08 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:08.999 8715 DEBUG vitrage.evaluator.scenario_evaluator [-] Processing: (EdgeDescription(edge={source_id : host_down_alarm, target_id : host, label = on, properties : {u'relationship_type': u'on'}}, source={vertex_id : host_down_alarm, properties : {'vitrage_category': u'ALARM', u'name': u'compute.host.down'}}, target={vertex_id : host, properties : {'vitrage_category': u'RESOURCE', 'vitrage_type': u'nova.host'}}), ) _process_and_get_actions /opt/stack/vitrage/vitrage/evaluator/scenario_evaluator.py:166 Nov 07 03:28:09 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:09.001 8715 DEBUG vitrage.evaluator.scenario_evaluator [-] Actions before filtering: [ActionInfo(specs=ActionSpecs(id=u'host_down_scenarios-scenario0-action0', type=u'set_state', targets={u'target': {vertex_id : 333e1aff-36d0-486e-901a-fbd9efae40e0, properties : {'vitrage_id': '333e1aff-36d0-486e-901a-fbd9efae40e0', 'name': u'dwj-vitrage', 'update_timestamp': u'2017-11-07 03:27:24.822838+00:00', 'vitrage_category': 'RESOURCE', 'vitrage_operational_state': u'OK', 'state': 'available', 'vitrage_type': 'nova.host', 'vitrage_sample_timestamp': u'2017-11-07 03:27:25.911323+00:00', 'vitrage_aggregated_state': 'AVAILABLE', 'vitrage_is_placeholder': False, 'id': u'dwj-vitrage', 'is_real_vitrage_id': True, 'vitrage_is_deleted': False}}}, properties={u'state': u'ERROR'}), mode='do', action_id=u'host_down_scenarios-scenario0-action0', trigger_id=6085638200849770853), ActionInfo(specs=ActionSpecs(id=u'host_down_scenarios-scenario0-action1', type=u'mark_down', targets={u'target': {vertex_id : 333e1aff-36d0-486e-901a-fbd9efae40e0, properties : {'vitrage_id': '333e1aff-36d0-486e-901a-fbd9efae40e0', 'name': u'dwj-vitrage', 'update_timestamp': u'2017-11-07 03:27:24.822838+00:00', 'vitrage_category': 'RESOURCE', 'vitrage_operational_state': u'OK', 'state': 'available', 'vitrage_type': 'nova.host', 'vitrage_sample_timestamp': u'2017-11-07 03:27:25.911323+00:00', 'vitrage_aggregated_state': 'AVAILABLE', 'vitrage_is_placeholder': False, 'id': u'dwj-vitrage', 'is_real_vitrage_id': True, 'vitrage_is_deleted': False}}}, properties={}), mode='do', action_id=u'host_down_scenarios-scenario0-action1', trigger_id=6085638200849770853)] _analyze_and_filter_actions /opt/stack/vitrage/vitrage/evaluator/scenario_evaluator.py:249 Nov 07 03:28:09 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:09.043 8715 DEBUG oslo_db.sqlalchemy.engines [-] MySQL server mode set to STRICT_TRANS_TABLES,STRICT_ALL_TABLES,NO_ZERO_IN_DATE,NO_ZERO_DATE,ERROR_FOR_DIVISION_BY_ZERO,TRADITIONAL,NO_AUTO_CREATE_USER,NO_ENGINE_SUBSTITUTION _check_effective_sql_mode /usr/local/lib/python2.7/dist-packages/oslo_db/sqlalchemy/engines.py:290 Nov 07 03:28:09 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:09.053 8715 DEBUG vitrage.evaluator.scenario_evaluator [-] DB Insert active_actions calc_do_action /opt/stack/vitrage/vitrage/evaluator/scenario_evaluator.py:458 Nov 07 03:28:09 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:09.088 8715 DEBUG vitrage.evaluator.scenario_evaluator [-] DB Insert active_actions calc_do_action /opt/stack/vitrage/vitrage/evaluator/scenario_evaluator.py:458 Nov 07 03:28:09 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:09.134 8715 INFO vitrage.evaluator.scenario_evaluator [-] Action: DO set_state 'host_down_scenarios-scenario0-action0' targets (,333e1aff-36d0-486e-901a-fbd9efae40e0) Nov 07 03:28:09 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:09.136 8715 INFO vitrage.evaluator.scenario_evaluator [-] Action: DO mark_down 'host_down_scenarios-scenario0-action1' targets (,333e1aff-36d0-486e-901a-fbd9efae40e0) Nov 07 03:28:09 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:09.137 8715 DEBUG vitrage.evaluator.scenario_evaluator [-] Process event - completed process_event /opt/stack/vitrage/vitrage/evaluator/scenario_evaluator.py:137 Nov 07 03:28:09 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:09.140 8480 DEBUG vitrage.entity_graph.processor.processor [-] processor event: Nov 07 03:28:09 dwj-vitrage vitrage-graph[8480]: {'vitrage_id': '333e1aff-36d0-486e-901a-fbd9efae40e0', 'vitrage_state': u'ERROR', 'vitrage_datasource_action': 'update', 'update_timestamp': '2017-11-07 03:28:09.134972', 'vitrage_entity_type': 'vitrage', 'vitrage_sample_timestamp': '2017-11-07 03:28:09.135054+00:00', 'type': 'update_vertex', 'is_real_vitrage_id': True} process_event /opt/stack/vitrage/vitrage/entity_graph/processor/processor.py:56 Nov 07 03:28:09 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:09.143 8480 DEBUG vitrage.entity_graph.processor.processor [-] calculate event state _calculate_vitrage_aggregated_state /opt/stack/vitrage/vitrage/entity_graph/processor/processor.py:302 Nov 07 03:28:09 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:09.143 8480 DEBUG vitrage.entity_graph.processor.processor [-] Update entity in entity graph: Nov 07 03:28:09 dwj-vitrage vitrage-graph[8480]: {vertex_id : 333e1aff-36d0-486e-901a-fbd9efae40e0, properties : {'vitrage_state': u'ERROR', 'update_timestamp': '2017-11-07T03:28:09Z', 'resource_id': None, 'vitrage_operational_state': u'ERROR', 'vitrage_aggregated_state': u'ERROR', 'vitrage_is_placeholder': False, 'is_real_vitrage_id': True}} update_entity /opt/stack/vitrage/vitrage/entity_graph/processor/processor.py:94 Nov 07 03:28:09 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:09.145 8480 DEBUG vitrage.evaluator.scenario_evaluator [-] Process event disabled process_event /opt/stack/vitrage/vitrage/evaluator/scenario_evaluator.py:101 Nov 07 03:28:09 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:09.147 8715 DEBUG vitrage.evaluator.scenario_evaluator [-] Process event - starting process_event /opt/stack/vitrage/vitrage/evaluator/scenario_evaluator.py:104 Nov 07 03:28:09 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:09.147 8715 DEBUG vitrage.evaluator.scenario_evaluator [-] Element before event: {vertex_id : 333e1aff-36d0-486e-901a-fbd9efae40e0, properties : {'vitrage_id': '333e1aff-36d0-486e-901a-fbd9efae40e0', 'name': u'dwj-vitrage', 'update_timestamp': u'2017-11-07 03:27:24.822838+00:00', 'vitrage_category': 'RESOURCE', 'vitrage_operational_state': u'OK', 'state': 'available', 'vitrage_type': 'nova.host', 'vitrage_sample_timestamp': u'2017-11-07 03:27:25.911323+00:00', 'vitrage_aggregated_state': 'AVAILABLE', 'vitrage_is_placeholder': False, 'id': u'dwj-vitrage', 'is_real_vitrage_id': True, 'vitrage_is_deleted': False}}, Current element: {vertex_id : 333e1aff-36d0-486e-901a-fbd9efae40e0, properties : {'vitrage_id': '333e1aff-36d0-486e-901a-fbd9efae40e0', 'vitrage_state': u'ERROR', 'vitrage_is_deleted': False, 'update_timestamp': '2017-11-07T03:28:09Z', 'vitrage_category': 'RESOURCE', 'vitrage_operational_state': u'ERROR', 'state': 'available', 'vitrage_type': 'nova.host', 'vitrage_sample_timestamp': u'2017-11-07 03:27:25.911323+00:00', 'vitrage_aggregated_state': u'ERROR', 'vitrage_is_placeholder': False, 'id': u'dwj-vitrage', 'is_real_vitrage_id': True, 'name': u'dwj-vitrage'}} process_event /opt/stack/vitrage/vitrage/evaluator/scenario_evaluator.py:107 Nov 07 03:28:09 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:09.148 8715 DEBUG vitrage.evaluator.scenario_evaluator [-] Actions before filtering: [] _analyze_and_filter_actions /opt/stack/vitrage/vitrage/evaluator/scenario_evaluator.py:249 Nov 07 03:28:09 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:09.148 8715 DEBUG vitrage.evaluator.scenario_evaluator [-] Process event - completed process_event /opt/stack/vitrage/vitrage/evaluator/scenario_evaluator.py:137 Nov 07 03:28:09 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:09.148 8480 DEBUG vitrage.entity_graph.processor.processor [-] obsolete_edges - nothing to do _delete_old_connections /opt/stack/vitrage/vitrage/entity_graph/processor/processor.py:241 Nov 07 03:28:09 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:09.149 8480 DEBUG vitrage.entity_graph.processor.processor [-] connect_neighbors - nothing to do _connect_neighbors /opt/stack/vitrage/vitrage/entity_graph/processor/processor.py:213 Nov 07 03:28:09 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:09.149 8480 DEBUG vitrage.entity_graph.processor.processor [-] processor event: Nov 07 03:28:09 dwj-vitrage vitrage-graph[8480]: {'vitrage_id': '333e1aff-36d0-486e-901a-fbd9efae40e0', 'vitrage_datasource_action': 'update', 'update_timestamp': '2017-11-07 03:28:09.137176', 'is_marked_down': True, 'vitrage_entity_type': 'vitrage', 'vitrage_sample_timestamp': '2017-11-07 03:28:09.137195+00:00', 'type': 'update_vertex', 'is_real_vitrage_id': True} process_event /opt/stack/vitrage/vitrage/entity_graph/processor/processor.py:56 Nov 07 03:28:09 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:09.150 8480 DEBUG vitrage.entity_graph.processor.processor [-] calculate event state _calculate_vitrage_aggregated_state /opt/stack/vitrage/vitrage/entity_graph/processor/processor.py:302 Nov 07 03:28:09 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:09.150 8480 DEBUG vitrage.entity_graph.processor.processor [-] Update entity in entity graph: Nov 07 03:28:09 dwj-vitrage vitrage-graph[8480]: {vertex_id : 333e1aff-36d0-486e-901a-fbd9efae40e0, properties : {'update_timestamp': '2017-11-07T03:28:09Z', 'resource_id': None, 'is_marked_down': True, 'vitrage_operational_state': u'ERROR', 'vitrage_aggregated_state': u'ERROR', 'vitrage_is_placeholder': False, 'is_real_vitrage_id': True}} update_entity /opt/stack/vitrage/vitrage/entity_graph/processor/processor.py:94 Nov 07 03:28:09 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:09.151 8480 DEBUG vitrage.evaluator.scenario_evaluator [-] Process event disabled process_event /opt/stack/vitrage/vitrage/evaluator/scenario_evaluator.py:101 Nov 07 03:28:09 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:09.152 8715 DEBUG vitrage.evaluator.scenario_evaluator [-] Process event - starting process_event /opt/stack/vitrage/vitrage/evaluator/scenario_evaluator.py:104 Nov 07 03:28:09 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:09.152 8715 DEBUG vitrage.evaluator.scenario_evaluator [-] Element before event: {vertex_id : 333e1aff-36d0-486e-901a-fbd9efae40e0, properties : {'vitrage_id': '333e1aff-36d0-486e-901a-fbd9efae40e0', 'vitrage_state': u'ERROR', 'vitrage_is_deleted': False, 'update_timestamp': '2017-11-07T03:28:09Z', 'vitrage_category': 'RESOURCE', 'vitrage_operational_state': u'ERROR', 'state': 'available', 'vitrage_type': 'nova.host', 'vitrage_sample_timestamp': u'2017-11-07 03:27:25.911323+00:00', 'vitrage_aggregated_state': u'ERROR', 'vitrage_is_placeholder': False, 'id': u'dwj-vitrage', 'is_real_vitrage_id': True, 'name': u'dwj-vitrage'}}, Current element: {vertex_id : 333e1aff-36d0-486e-901a-fbd9efae40e0, properties : {'vitrage_id': '333e1aff-36d0-486e-901a-fbd9efae40e0', 'vitrage_state': u'ERROR', 'vitrage_is_deleted': False, 'update_timestamp': '2017-11-07T03:28:09Z', 'is_marked_down': True, 'vitrage_category': 'RESOURCE', 'vitrage_operational_state': u'ERROR', 'state': 'available', 'vitrage_type': 'nova.host', 'vitrage_sample_timestamp': u'2017-11-07 03:27:25.911323+00:00', 'vitrage_aggregated_state': u'ERROR', 'vitrage_is_placeholder': False, 'id': u'dwj-vitrage', 'is_real_vitrage_id': True, 'name': u'dwj-vitrage'}} process_event /opt/stack/vitrage/vitrage/evaluator/scenario_evaluator.py:107 Nov 07 03:28:09 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:09.152 8715 DEBUG vitrage.evaluator.scenario_evaluator [-] Actions before filtering: [] _analyze_and_filter_actions /opt/stack/vitrage/vitrage/evaluator/scenario_evaluator.py:249 Nov 07 03:28:09 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:09.153 8715 DEBUG vitrage.evaluator.scenario_evaluator [-] Process event - completed process_event /opt/stack/vitrage/vitrage/evaluator/scenario_evaluator.py:137 Nov 07 03:28:09 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:09.153 8480 DEBUG vitrage.entity_graph.processor.processor [-] obsolete_edges - nothing to do _delete_old_connections /opt/stack/vitrage/vitrage/entity_graph/processor/processor.py:241 Nov 07 03:28:09 dwj-vitrage vitrage-graph[8480]: 2017-11-07 03:28:09.154 8480 DEBUG vitrage.entity_graph.processor.processor [-] connect_neighbors - nothing to do _connect_neighbors /opt/stack/vitrage/vitrage/entity_graph/processor/processor.py:213