proxy logs

gistfile1.txt

[2018-06-26 23:51:57.945][26][debug][filter] external/envoy/source/extensions/filters/listener/original_dst/original_dst.cc:18] original_dst: New connection accepted
[2018-06-26 23:51:57.945][26][debug][filter] src/envoy/tcp/mixer/filter.cc:28] Called tcp filter: Filter
[2018-06-26 23:51:57.945][26][debug][filter] src/envoy/tcp/mixer/filter.cc:38] Called tcp filter: initializeReadFilterCallbacks
[2018-06-26 23:51:57.945][26][debug][filter] external/envoy/source/common/tcp_proxy/tcp_proxy.cc:168] [C1644] new tcp proxy session
[2018-06-26 23:51:57.946][26][debug][filter] src/envoy/tcp/mixer/filter.cc:98] [C1644] Called tcp filter onNewConnection: remote 172.17.0.20:35552, local 172.17.0.19:90
[2018-06-26 23:51:57.946][26][debug][filter] external/envoy/source/common/tcp_proxy/tcp_proxy.cc:305] [C1644] Creating connection to cluster inbound|9090||a.istio-system.svc.cluster.local
[2018-06-26 23:51:57.946][26][debug][connection] external/envoy/source/common/network/connection_impl.cc:564] [C1645] connecting to 127.0.0.1:90
[2018-06-26 23:51:57.946][26][debug][connection] external/envoy/source/common/network/connection_impl.cc:573] [C1645] connection in progress
[2018-06-26 23:51:57.946][26][debug][main] external/envoy/source/server/connection_handler_impl.cc:217] [C1644] new connection
[2018-06-26 23:51:57.946][26][debug][connection] external/envoy/source/common/network/connection_impl.cc:461] [C1645] connected
[2018-06-26 23:51:57.947][26][debug][filter] ./src/envoy/utils/header_update.h:46] Mixer forward attributes set: CjwKCnNvdXJjZS51aWQSLhIsa3ViZXJuZXRlczovL2EtNTk1NjU4NWI5OC05bXJiYi5pc3Rpby1zeXN0ZW0=
[2018-06-26 23:51:57.947][26][debug][router] external/envoy/source/common/router/router.cc:238] [C0][S8334508251455340261] cluster 'outbound|9091||istio-policy.istio-system.svc.cluster.local' match for URL '/istio.mixer.v1.Mixer/Check'
[2018-06-26 23:51:57.948][26][debug][router] external/envoy/source/common/router/router.cc:288] [C0][S8334508251455340261] router decoding headers:
':method', 'POST'
':path', '/istio.mixer.v1.Mixer/Check'
':authority', 'mixer'
':scheme', 'http'
'content-type', 'application/grpc'
'te', 'trailers'
'x-istio-attributes', 'CjwKCnNvdXJjZS51aWQSLhIsa3ViZXJuZXRlczovL2EtNTk1NjU4NWI5OC05bXJiYi5pc3Rpby1zeXN0ZW0='
'x-envoy-internal', 'true'
'x-forwarded-for', '172.17.0.19'
'x-envoy-expected-rq-timeout-ms', '5000'

[2018-06-26 23:51:57.948][26][debug][pool] external/envoy/source/common/http/http2/conn_pool.cc:97] [C19] creating stream
[2018-06-26 23:51:57.949][26][debug][router] external/envoy/source/common/router/router.cc:956] [C0][S8334508251455340261] pool ready
[2018-06-26 23:51:57.949][26][debug][grpc] src/envoy/utils/grpc_transport.cc:46] Sending Check request: attributes {
  words: "kubernetes://a-5956585b98-9mrbb.istio-system"
  words: "710d78ff-b2c2-44a6-b7bd-1880375c9b61-1644"
  words: "open"
  strings {
    key: 125
    value: -2
  }
  strings {
    key: 131
    value: 124
  }
  strings {
    key: 154
    value: -1
  }
  strings {
    key: 171
    value: -3
  }
  strings {
    key: 197
    value: -1
  }
  int64s {
    key: 151
    value: 90
  }
  bools {
    key: 177
    value: false
  }
  bools {
    key: 196
    value: true
  }
  timestamps {
    key: 133
    value {
      seconds: 1530057117
      nanos: 947093878
    }
  }
  bytes {
    key: 0
    value: "\254\021\000\024"
  }
  bytes {
    key: 150
    value: "\000\000\000\000\000\000\000\000\000\000\377\377\254\021\000\023"
  }
}
global_word_count: 198
deduplication_id: "de5c1f19-6025-48b9-a58a-961f98b24c9821"

[2018-06-26 23:51:57.950][26][debug][filter] src/envoy/tcp/mixer/filter.cc:78] [C1644] Called tcp filter onRead bytes: 100
[2018-06-26 23:51:57.952][26][debug][client] external/envoy/source/common/http/codec_client.cc:94] [C19] response complete
[2018-06-26 23:51:57.953][26][debug][pool] external/envoy/source/common/http/http2/conn_pool.cc:189] [C19] destroying stream: 0 remaining
[2018-06-26 23:51:57.953][26][debug][router] external/envoy/source/common/router/router.cc:568] [C0][S8334508251455340261] upstream headers complete: end_stream=true
[2018-06-26 23:51:57.953][26][debug][http] external/envoy/source/common/http/async_client_impl.cc:92] async http request response headers (end_stream=true):
':status', '200'
'content-type', 'application/grpc'
'grpc-status', '13'
'grpc-message', 'preprocessing attributes failed: identity parameter not found: 'destination.service''
'x-envoy-upstream-service-time', '4'
'date', 'Tue, 26 Jun 2018 23:51:57 GMT'
'server', 'envoy'
'x-envoy-decorator-operation', 'Check'

[2018-06-26 23:51:57.953][26][debug][grpc] src/envoy/utils/grpc_transport.cc:78] Check failed with code: 13, preprocessing attributes failed: identity parameter not found: 'destination.service'
[2018-06-26 23:51:57.953][26][debug][filter] src/envoy/tcp/mixer/filter.cc:105] Called tcp filter completeCheck: INTERNAL:preprocessing attributes failed: identity parameter not found: 'destination.service'
[2018-06-26 23:51:57.953][26][debug][connection] external/envoy/source/common/network/connection_impl.cc:98] [C1644] closing data_to_write=0 type=1
[2018-06-26 23:51:57.954][26][debug][connection] external/envoy/source/common/network/connection_impl.cc:133] [C1644] closing socket: 1
[2018-06-26 23:51:57.954][26][debug][filter] src/envoy/tcp/mixer/filter.cc:131] Called tcp filter onEvent: 1 upstream 127.0.0.1:90
[2018-06-26 23:51:57.954][26][debug][connection] external/envoy/source/common/network/connection_impl.cc:98] [C1645] closing data_to_write=0 type=1
[2018-06-26 23:51:57.954][26][debug][connection] external/envoy/source/common/network/connection_impl.cc:133] [C1645] closing socket: 1
[2018-06-26 23:51:57.955][26][debug][main] external/envoy/source/server/connection_handler_impl.cc:50] [C1644] adding to cleanup list
[2018-06-26 23:51:57.955][26][debug][http2] external/envoy/source/common/http/http2/codec_impl.cc:501] [C19] stream closed: 0
[2018-06-26 23:51:57.955][26][debug][filter] src/envoy/tcp/mixer/filter.cc:33] Called tcp filter : ~Filter
[2018-06-26 23:51:58.953][26][debug][filter] ./src/envoy/utils/header_update.h:46] Mixer forward attributes set: CjwKCnNvdXJjZS51aWQSLhIsa3ViZXJuZXRlczovL2EtNTk1NjU4NWI5OC05bXJiYi5pc3Rpby1zeXN0ZW0=
[2018-06-26 23:51:58.953][26][debug][router] external/envoy/source/common/router/router.cc:238] [C0][S5675467975364727942] cluster 'outbound|9091||istio-telemetry.istio-system.svc.cluster.local' match for URL '/istio.mixer.v1.Mixer/Report'
[2018-06-26 23:51:58.953][26][debug][router] external/envoy/source/common/router/router.cc:288] [C0][S5675467975364727942] router decoding headers:
':method', 'POST'
':path', '/istio.mixer.v1.Mixer/Report'
':authority', 'mixer'
':scheme', 'http'
'content-type', 'application/grpc'
'te', 'trailers'
'x-istio-attributes', 'CjwKCnNvdXJjZS51aWQSLhIsa3ViZXJuZXRlczovL2EtNTk1NjU4NWI5OC05bXJiYi5pc3Rpby1zeXN0ZW0='
'x-envoy-internal', 'true'
'x-forwarded-for', '172.17.0.19'
'x-envoy-expected-rq-timeout-ms', '5000'

[2018-06-26 23:51:58.953][26][debug][pool] external/envoy/source/common/http/http2/conn_pool.cc:97] [C22] creating stream
[2018-06-26 23:51:58.953][26][debug][router] external/envoy/source/common/router/router.cc:956] [C0][S5675467975364727942] pool ready
[2018-06-26 23:51:58.953][26][debug][grpc] src/envoy/utils/grpc_transport.cc:46] Sending Report request: attributes {
  strings {
    key: 125
    value: -3
  }
  strings {
    key: 131
    value: 124
  }
  strings {
    key: 154
    value: -2
  }
  strings {
    key: 168
    value: -1
  }
  strings {
    key: 171
    value: -4
  }
  strings {
    key: 197
    value: -2
  }
  int64s {
    key: 126
    value: 100
  }
  int64s {
    key: 127
    value: 100
  }
  int64s {
    key: 128
    value: 0
  }
  int64s {
    key: 129
    value: 0
  }
  int64s {
    key: 151
    value: 90
  }
  int64s {
    key: 167
    value: 13
  }
  bools {
    key: 172
    value: false
  }
  bools {
    key: 173
    value: false
  }
  bools {
    key: 177
    value: false
  }
  bools {
    key: 196
    value: true
  }
  timestamps {
    key: 133
    value {
      seconds: 1530057117
      nanos: 954255567
    }
  }
  durations {
    key: 130
    value {
      nanos: 8422815
    }
  }
  bytes {
    key: 0
    value: "\254\021\000\024"
  }
  bytes {
    key: 150
    value: "\000\000\000\000\000\000\000\000\000\000\377\377\254\021\000\023"
  }
}
default_words: "INTERNAL:preprocessing attributes failed: identity parameter not found: \'destination.service\'"
default_words: "kubernetes://a-5956585b98-9mrbb.istio-system"
default_words: "710d78ff-b2c2-44a6-b7bd-1880375c9b61-1644"
default_words: "close"
global_word_count: 198

[2018-06-26 23:51:58.957][26][debug][client] external/envoy/source/common/http/codec_client.cc:94] [C22] response complete
[2018-06-26 23:51:58.957][26][debug][pool] external/envoy/source/common/http/http2/conn_pool.cc:189] [C22] destroying stream: 0 remaining
[2018-06-26 23:51:58.957][26][debug][router] external/envoy/source/common/router/router.cc:568] [C0][S5675467975364727942] upstream headers complete: end_stream=true
[2018-06-26 23:51:58.957][26][debug][http] external/envoy/source/common/http/async_client_impl.cc:92] async http request response headers (end_stream=true):
':status', '200'
'content-type', 'application/grpc'
'grpc-status', '2'
'grpc-message', '1 error occurred:%0A%0A* preprocessing attributes failed: identity parameter not found: 'destination.service''
'x-envoy-upstream-service-time', '3'
'date', 'Tue, 26 Jun 2018 23:51:58 GMT'
'server', 'envoy'
'x-envoy-decorator-operation', 'Report'

[2018-06-26 23:51:58.957][26][debug][grpc] src/envoy/utils/grpc_transport.cc:78] Report failed with code: 2, 1 error occurred:%0A%0A* preprocessing attributes failed: identity parameter not found: 'destination.service'
[libprotobuf ERROR src/istio/mixerclient/report_batch.cc:83] Mixer Report failed with: UNKNOWN:1 error occurred:%0A%0A* preprocessing attributes failed: identity parameter not found: 'destination.service'
[2018-06-26 23:51:58.957][26][debug][http2] external/envoy/source/common/http/http2/codec_impl.cc:501] [C22] stream closed: 0
[2018-06-26 23:51:59.395][20][debug][main] external/envoy/source/server/server.cc:118] flushing stats