Uploaded image for project: 'ONOS'
  1. ONOS
  2. ONOS-1415

Device event timestamp mismatch between "topology-events" and "topology-events-metrics"

    XMLWordPrintable

    Details

    • Type: Bug
    • Status: Closed (View Workflow)
    • Priority: Major
    • Resolution: Done
    • Affects Version/s: 1.1.0
    • Fix Version/s: 1.2.0
    • Component/s: None
    • Labels:
    • Environment:

      commit a31e13471ee626abce2bc43c413fab17586f4fc3

    • Epic Link:
    • Sprint:
      Cardinal Sprint 1 (3/23-4/3), Cardinal Sprint 4 (5/4-5/15), Cardinal Sprint 5 (5/18-5/22)

      Description

      event reported from "topology-event" and "topology-events-metrics" mismatched when adding/removing a device:

      1) set up one ovs switch (1.3);
      2) connect or disconnect the switch from ONOS1 with 3 node cluster;
      3) check Device and Graph timestamps from "topology-event" and "topology-event-metrics".

      with topology-event:
      =================
      vent=DeviceEvent{time=2015-03-27T12:48:17.954, type=DEVICE_AVAILABILITY_CHANGED, subject=DefaultDevice{id=of:0000ce102bb8f243, type=SWITCH, manufacturer=Nicira, Inc., hwVersion=Open vSwitch, swVersion=2.3.1, serialNumber=None}}

      Event=TopologyEvent{time=2015-03-27T12:48:17.968, type=TOPOLOGY_CHANGED, subject=DefaultTopology{time=870578696290347, creationTime=1427485697966, computeCost=1825449, clusters=0, devices=0, links=0}}
      Reason=DeviceEvent{time=2015-03-27T12:48:17.954, type=DEVICE_AVAILABILITY_CHANGED, subject=DefaultDevice{id=of:0000ce102bb8f243, type=SWITCH, manufacturer=Nicira, Inc., hwVersion=Open vSwitch, swVersion=2.3.1, serialNumber=None}}
      ====================

      But with topology-event-metrics:
      ===================
      opology Device Event Timestamp (ms from epoch)=1427485697968
      Topology Graph Event Timestamp (ms from epoch)=1427485697968

      Topology Device Event Timestamp (ms from epoch)=1427485697956
      Topology Graph Event Timestamp (ms from epoch)=1427485697957

      Topology Device Event Timestamp (ms from epoch)=1427485697958
      Topology Graph Event Timestamp (ms from epoch)=1427485697960

      =====================

      check ONOS1 Device event timestamps, first method reports: .954; second method report 968. And this mismatch seems only happen on ONOS1, but other nodes seem report the right timing (with some delay).

      FYI the disconnect event is triggered and capture with tshark, as following:
      35102 1427485430.697874 10.254.1.201 -> 10.254.1.200 TCP 66 6633 > 47233 [FIN, ACK] Seq=837 Ack=2302 Win=37632 Len=0 TSval=217502857 TSecr=304825145

        Attachments

        No reviews matched the request. Check your Options in the drop-down menu of this sections header.

          Activity

            People

            Assignee:
            suibin suibin
            Reporter:
            suibin suibin
            Votes:
            0 Vote for this issue
            Watchers:
            1 Start watching this issue

              Dates

              Created:
              Updated:
              Resolved: