telstra / open-kilda

OpenKilda is an open-source OpenFlow controller initially designed for use in a global network with high control-plane latency and a heavy emphasis on latency-centric data path optimisation.
Apache License 2.0
78 stars 53 forks source link

CacheBolt WFM_CACHE request error #157

Closed nikitamarchenko closed 6 years ago

nikitamarchenko commented 6 years ago

Found in kibana by request loggerName:=org.openkilda.wfm.topology.cache.CacheBolt

{
  "_index": "logstash-2018.01.02",
  "_type": "kilda-storm",
  "_id": "AWC4L4QbRRL3dYjTbQFW",
  "_version": 1,
  "_score": null,
  "_source": {
    "loggerFqcn": "org.apache.logging.slf4j.Log4jLogger",
    "level": "ERROR",
    "thrown": {
      "name": "com.fasterxml.jackson.databind.exc.InvalidTypeIdException",
      "extendedStackTrace": [
        {
          "file": "InvalidTypeIdException.java",
          "method": "from",
          "line": 43,
          "exact": false,
          "location": "jackson-databind-2.9.3.jar",
          "class": "com.fasterxml.jackson.databind.exc.InvalidTypeIdException",
          "version": "2.9.3"
        },
        {
          "file": "DeserializationContext.java",
          "method": "missingTypeIdException",
          "line": 1638,
          "exact": false,
          "location": "jackson-databind-2.9.3.jar",
          "class": "com.fasterxml.jackson.databind.DeserializationContext",
          "version": "2.9.3"
        },
        {
          "file": "DeserializationContext.java",
          "method": "handleMissingTypeId",
          "line": 1217,
          "exact": false,
          "location": "jackson-databind-2.9.3.jar",
          "class": "com.fasterxml.jackson.databind.DeserializationContext",
          "version": "2.9.3"
        },
        {
          "file": "TypeDeserializerBase.java",
          "method": "_handleMissingTypeId",
          "line": 300,
          "exact": false,
          "location": "jackson-databind-2.9.3.jar",
          "class": "com.fasterxml.jackson.databind.jsontype.impl.TypeDeserializerBase",
          "version": "2.9.3"
        },
        {
          "file": "AsPropertyTypeDeserializer.java",
          "method": "_deserializeTypedUsingDefaultImpl",
          "line": 164,
          "exact": false,
          "location": "jackson-databind-2.9.3.jar",
          "class": "com.fasterxml.jackson.databind.jsontype.impl.AsPropertyTypeDeserializer",
          "version": "2.9.3"
        },
        {
          "file": "AsPropertyTypeDeserializer.java",
          "method": "deserializeTypedFromObject",
          "line": 105,
          "exact": false,
          "location": "jackson-databind-2.9.3.jar",
          "class": "com.fasterxml.jackson.databind.jsontype.impl.AsPropertyTypeDeserializer",
          "version": "2.9.3"
        },
        {
          "file": "AbstractDeserializer.java",
          "method": "deserializeWithType",
          "line": 254,
          "exact": false,
          "location": "jackson-databind-2.9.3.jar",
          "class": "com.fasterxml.jackson.databind.deser.AbstractDeserializer",
          "version": "2.9.3"
        },
        {
          "file": "SettableBeanProperty.java",
          "method": "deserialize",
          "line": 517,
          "exact": false,
          "location": "jackson-databind-2.9.3.jar",
          "class": "com.fasterxml.jackson.databind.deser.SettableBeanProperty",
          "version": "2.9.3"
        },
        {
          "file": "BeanDeserializer.java",
          "method": "_deserializeWithErrorWrapping",
          "line": 527,
          "exact": false,
          "location": "jackson-databind-2.9.3.jar",
          "class": "com.fasterxml.jackson.databind.deser.BeanDeserializer",
          "version": "2.9.3"
        },
        {
          "file": "BeanDeserializer.java",
          "method": "_deserializeUsingPropertyBased",
          "line": 416,
          "exact": false,
          "location": "jackson-databind-2.9.3.jar",
          "class": "com.fasterxml.jackson.databind.deser.BeanDeserializer",
          "version": "2.9.3"
        },
        {
          "file": "BeanDeserializerBase.java",
          "method": "deserializeFromObjectUsingNonDefault",
          "line": 1265,
          "exact": false,
          "location": "jackson-databind-2.9.3.jar",
          "class": "com.fasterxml.jackson.databind.deser.BeanDeserializerBase",
          "version": "2.9.3"
        },
        {
          "file": "BeanDeserializer.java",
          "method": "deserializeFromObject",
          "line": 325,
          "exact": false,
          "location": "jackson-databind-2.9.3.jar",
          "class": "com.fasterxml.jackson.databind.deser.BeanDeserializer",
          "version": "2.9.3"
        },
        {
          "file": "BeanDeserializer.java",
          "method": "_deserializeOther",
          "line": 194,
          "exact": false,
          "location": "jackson-databind-2.9.3.jar",
          "class": "com.fasterxml.jackson.databind.deser.BeanDeserializer",
          "version": "2.9.3"
        },
        {
          "file": "BeanDeserializer.java",
          "method": "deserialize",
          "line": 161,
          "exact": false,
          "location": "jackson-databind-2.9.3.jar",
          "class": "com.fasterxml.jackson.databind.deser.BeanDeserializer",
          "version": "2.9.3"
        },
        {
          "file": "AsPropertyTypeDeserializer.java",
          "method": "_deserializeTypedForId",
          "line": 130,
          "exact": false,
          "location": "jackson-databind-2.9.3.jar",
          "class": "com.fasterxml.jackson.databind.jsontype.impl.AsPropertyTypeDeserializer",
          "version": "2.9.3"
        },
        {
          "file": "AsPropertyTypeDeserializer.java",
          "method": "deserializeTypedFromObject",
          "line": 97,
          "exact": false,
          "location": "jackson-databind-2.9.3.jar",
          "class": "com.fasterxml.jackson.databind.jsontype.impl.AsPropertyTypeDeserializer",
          "version": "2.9.3"
        },
        {
          "file": "AbstractDeserializer.java",
          "method": "deserializeWithType",
          "line": 254,
          "exact": false,
          "location": "jackson-databind-2.9.3.jar",
          "class": "com.fasterxml.jackson.databind.deser.AbstractDeserializer",
          "version": "2.9.3"
        },
        {
          "file": "TypeWrappedDeserializer.java",
          "method": "deserialize",
          "line": 68,
          "exact": false,
          "location": "jackson-databind-2.9.3.jar",
          "class": "com.fasterxml.jackson.databind.deser.impl.TypeWrappedDeserializer",
          "version": "2.9.3"
        },
        {
          "file": "ObjectMapper.java",
          "method": "_readMapAndClose",
          "line": 4001,
          "exact": false,
          "location": "jackson-databind-2.9.3.jar",
          "class": "com.fasterxml.jackson.databind.ObjectMapper",
          "version": "2.9.3"
        },
        {
          "file": "ObjectMapper.java",
          "method": "readValue",
          "line": 2992,
          "exact": false,
          "location": "jackson-databind-2.9.3.jar",
          "class": "com.fasterxml.jackson.databind.ObjectMapper",
          "version": "2.9.3"
        },
        {
          "file": "CacheBolt.java",
          "method": "doWork",
          "line": 187,
          "exact": true,
          "location": "stormjar.jar",
          "class": "org.openkilda.wfm.topology.cache.CacheBolt",
          "version": "?"
        },
        {
          "file": "AbstractTickStatefulBolt.java",
          "method": "execute",
          "line": 83,
          "exact": true,
          "location": "stormjar.jar",
          "class": "org.openkilda.wfm.topology.utils.AbstractTickStatefulBolt",
          "version": "?"
        },
        {
          "file": "StatefulBoltExecutor.java",
          "method": "doExecute",
          "line": 145,
          "exact": true,
          "location": "storm-core-1.1.0.jar",
          "class": "org.apache.storm.topology.StatefulBoltExecutor",
          "version": "1.1.0"
        },
        {
          "file": "StatefulBoltExecutor.java",
          "method": "handleTuple",
          "line": 137,
          "exact": true,
          "location": "storm-core-1.1.0.jar",
          "class": "org.apache.storm.topology.StatefulBoltExecutor",
          "version": "1.1.0"
        },
        {
          "file": "BaseStatefulBoltExecutor.java",
          "method": "execute",
          "line": 78,
          "exact": true,
          "location": "storm-core-1.1.0.jar",
          "class": "org.apache.storm.topology.BaseStatefulBoltExecutor",
          "version": "1.1.0"
        },
        {
          "file": "executor.clj",
          "method": "invoke",
          "line": 727,
          "exact": true,
          "location": "storm-core-1.1.0.jar",
          "class": "org.apache.storm.daemon.executor$fn__5044$tuple_action_fn__5046",
          "version": "1.1.0"
        },
        {
          "file": "executor.clj",
          "method": "invoke",
          "line": 459,
          "exact": true,
          "location": "storm-core-1.1.0.jar",
          "class": "org.apache.storm.daemon.executor$mk_task_receiver$fn__4965",
          "version": "1.1.0"
        },
        {
          "file": "disruptor.clj",
          "method": "onEvent",
          "line": 40,
          "exact": true,
          "location": "storm-core-1.1.0.jar",
          "class": "org.apache.storm.disruptor$clojure_handler$reify__4480",
          "version": "1.1.0"
        },
        {
          "file": "DisruptorQueue.java",
          "method": "consumeBatchToCursor",
          "line": 472,
          "exact": true,
          "location": "storm-core-1.1.0.jar",
          "class": "org.apache.storm.utils.DisruptorQueue",
          "version": "1.1.0"
        },
        {
          "file": "DisruptorQueue.java",
          "method": "consumeBatchWhenAvailable",
          "line": 451,
          "exact": true,
          "location": "storm-core-1.1.0.jar",
          "class": "org.apache.storm.utils.DisruptorQueue",
          "version": "1.1.0"
        },
        {
          "file": "disruptor.clj",
          "method": "invoke",
          "line": 73,
          "exact": true,
          "location": "storm-core-1.1.0.jar",
          "class": "org.apache.storm.disruptor$consume_batch_when_available",
          "version": "1.1.0"
        },
        {
          "file": "executor.clj",
          "method": "invoke",
          "line": 846,
          "exact": true,
          "location": "storm-core-1.1.0.jar",
          "class": "org.apache.storm.daemon.executor$fn__5044$fn__5057$fn__5110",
          "version": "1.1.0"
        },
        {
          "file": "util.clj",
          "method": "invoke",
          "line": 484,
          "exact": true,
          "location": "storm-core-1.1.0.jar",
          "class": "org.apache.storm.util$async_loop$fn__557",
          "version": "1.1.0"
        },
        {
          "file": "AFn.java",
          "method": "run",
          "line": 22,
          "exact": true,
          "location": "clojure-1.7.0.jar",
          "class": "clojure.lang.AFn",
          "version": "?"
        },
        {
          "file": "Thread.java",
          "method": "run",
          "line": 748,
          "exact": true,
          "location": "?",
          "class": "java.lang.Thread",
          "version": "1.8.0_131"
        }
      ],
      "commonElementCount": 0,
      "localizedMessage": "Missing type id when trying to resolve subtype of [simple type, class org.openkilda.messaging.info.InfoData]: missing type id property 'clazz' (for POJO property 'payload')\n at [Source: (String)\"{\n    \"timestamp\": 1514918609115, \n    \"correlation_id\": \"system-request\", \n    \"destination\": \"WFM_CACHE\", \n    \"payload\": {\n        \"switches\": [], \n        \"isls\": [], \n        \"message_type\": \"network\", \n        \"flows\": []\n    }, \n    \"clazz\": \"org.openkilda.messaging.info.InfoMessage\"\n}\"; line: 11, column: 14] (through reference chain: org.openkilda.messaging.info.InfoMessage[\"payload\"])",
      "message": "Missing type id when trying to resolve subtype of [simple type, class org.openkilda.messaging.info.InfoData]: missing type id property 'clazz' (for POJO property 'payload')\n at [Source: (String)\"{\n    \"timestamp\": 1514918609115, \n    \"correlation_id\": \"system-request\", \n    \"destination\": \"WFM_CACHE\", \n    \"payload\": {\n        \"switches\": [], \n        \"isls\": [], \n        \"message_type\": \"network\", \n        \"flows\": []\n    }, \n    \"clazz\": \"org.openkilda.messaging.info.InfoMessage\"\n}\"; line: 11, column: 14] (through reference chain: org.openkilda.messaging.info.InfoMessage[\"payload\"])"
    },
    "endOfBatch": false,
    "thread": "Thread-12-cache-executor[3 3]",
    "message": "Could not deserialize message {str={\n    \"timestamp\": 1514918609115, \n    \"correlation_id\": \"system-request\", \n    \"destination\": \"WFM_CACHE\", \n    \"payload\": {\n        \"switches\": [], \n        \"isls\": [], \n        \"message_type\": \"network\", \n        \"flows\": []\n    }, \n    \"clazz\": \"org.openkilda.messaging.info.InfoMessage\"\n}}",
    "threadPriority": 5,
    "type": "kilda-storm",
    "threadId": 47,
    "@timestamp": "2018-01-02T18:43:29.940Z",
    "port": 55206,
    "@version": "1",
    "host": "172.19.0.16",
    "loggerName": "org.openkilda.wfm.topology.cache.CacheBolt",
    "timeMillis": 1514918609725
  },
  "fields": {
    "@timestamp": [
      1514918609940
    ]
  },
  "highlight": {
    "loggerName": [
      "@kibana-highlighted-field@org.openkilda.wfm.topology.cache.CacheBolt@/kibana-highlighted-field@"
    ]
  },
  "sort": [
    1514918609940
  ]
}
nikitamarchenko commented 6 years ago

fixed with 33f6cb5c39239557c67f4a52eed538d1a121aa94