Log rotated after 5 minutes in NSMgr / Registry #1506

dualBreath · 2023-08-31T13:04:12Z

Description

networkservicemesh/deployments-k8s#9726

Draft implementation

Issue link

How Has This Been Tested?

Added unit testing to cover
Tested manually
Tested by integration testing
Have not tested

Types of changes

…n for networkservise) Signed-off-by: Alexander Peretyatko <[email protected]>

dualBreath · 2023-08-31T13:13:39Z

@denis-tingaikin, @NikitaSkrynnik Currently the client request is not printing for some reason, but could you please take a look and check the overall solution?

Output example in forwarder:

...
Aug 31 08:47:37.180 [DEBU] [id:97d619f7-b85c-44a7-a0fa-e51ad21f95e7] [type:networkService] server-request={"connection":{"id":"97d619f7-b85c-44a7-a0fa-e51ad21f95e7","network_service":"kernel2kernel","mechanism":{"cls":"LOCAL","type":"KERNEL","parameters":{"inodeURL":"inode://4/4026533900","name":"nsm-1"}},"context":{"ip_context":{"src_ip_addrs":["172.16.1.101/32"],"dst_ip_addrs":["172.16.1.100/32"],"src_routes":[{"prefix":"172.16.1.100/32"}],"dst_routes":[{"prefix":"172.16.1.101/32"}],"excluded_prefixes":["10.96.0.0/16","10.244.0.0/16"]},"dns_context":{},"MTU":9000},"labels":{"nodeName":"test-logs-control-plane","podName":"alpine"},"path":{"index":1,"path_segments":[{"name":"alpine-7c4c519c-e466-4b8f-862d-7d27fd37ac19","id":"alpine-7c4c519c-e466-4b8f-862d-7d27fd37ac19-0","token":"eyJhbGciOiJFUzI1NiIsInR5cCI6IkpXVCJ9.eyJzdWIiOiJzcGlmZmU6Ly9rOHMubnNtL25zL25zLWtlcm5lbDJrZXJuZWwvcG9kL2FscGluZSIsImF1ZCI6WyJzcGlmZmU6Ly9rOHMubnNtL25zL25zbS1zeXN0ZW0vcG9kL25zbWdyLWRoY2c3Il0sImV4cCI6MTY5MzQ3MjI1N30.EV9v3GWFdpZ8uB4kz5MJc2jCXNYA8XQUYxo0HKg_ckOqzUA1qEFOGF2n4OAKj89VUm-IIVbSQetsfoyzqXXMpA","expires":{"seconds":1693472257,"nanos":147577899}},{"name":"nsmgr-dhcg7","id":"97d619f7-b85c-44a7-a0fa-e51ad21f95e7","token":"eyJhbGciOiJFUzI1NiIsInR5cCI6IkpXVCJ9.eyJzdWIiOiJzcGlmZmU6Ly9rOHMubnNtL25zL25zbS1zeXN0ZW0vcG9kL25zbWdyLWRoY2c3IiwiYXVkIjpbInNwaWZmZTovL2s4cy5uc20vbnMvbnMta2VybmVsMmtlcm5lbC9wb2QvYWxwaW5lIl0sImV4cCI6MTY5MzQ3MjI1N30.KnG6g87RaCP32PMIleAOKtrH_-JVcZHRSdjS3WOBIkLvbcUjJEDdMJdl4kGSuZyjyiQBKaOP56V2nmdnyqO08Q","expires":{"seconds":1693472257,"nanos":148875289}},{"name":"forwarder-vpp-wzrm9","id":"70e929ab-bd3f-4ef8-9792-0ee344b4db6b","token":"eyJhbGciOiJFUzI1NiIsInR5cCI6IkpXVCJ9.eyJzdWIiOiJzcGlmZmU6Ly9rOHMubnNtL25zL25zbS1zeXN0ZW0vcG9kL2ZvcndhcmRlci12cHAtd3pybTkiLCJhdWQiOlsic3BpZmZlOi8vazhzLm5zbS9ucy9ucy1rZXJuZWwya2VybmVsL3BvZC9uc2Uta2VybmVsLTViN2Y0Y2I3NjktdG42ZnciXSwiZXhwIjoxNjkzNDcyMTM1fQ.o_PnOpHLSOWvLMYoRHtLmCiqoFnIPnoV6-z_ov2L14bBAgNJ5HUKdpzeSBVrd0HmkHdAecFKOC2hFRlG8pzoeg","expires":{"seconds":1693472135,"nanos":393287289},"metrics":{"client_drops":"7","client_rx_bytes":"33740","client_rx_packets":"580","client_tx_bytes":"33740","client_tx_packets":"580","server_drops":"0","server_rx_bytes":"33856","server_rx_packets":"582","server_tx_bytes":"33250","server_tx_packets":"575"}},{"name":"nse-kernel-5b7f4cb769-tn6fw","id":"eb3874d1-45bc-453c-80ab-4a7b5b74d0de","token":"eyJhbGciOiJFUzI1NiIsInR5cCI6IkpXVCJ9.eyJzdWIiOiJzcGlmZmU6Ly9rOHMubnNtL25zL25zLWtlcm5lbDJrZXJuZWwvcG9kL25zZS1rZXJuZWwtNWI3ZjRjYjc2OS10bjZmdyIsImF1ZCI6WyJzcGlmZmU6Ly9rOHMubnNtL25zL25zbS1zeXN0ZW0vcG9kL2ZvcndhcmRlci12cHAtd3pybTkiXSwiZXhwIjoxNjkzNDcyMTM1fQ.ilszjIHMVngj2BaEFcrn9PTPyuMQKQFx3FhPG37uQzPEHISpsLtkoaBOUnc4zUkOWgVcITsgpDqXehkjI_AJZg","expires":{"seconds":1693472135,"nanos":394388399}}]},"network_service_endpoint_name":"nse-kernel-5b7f4cb769-tn6fw","payload":"ETHERNET"},"mechanism_preferences":[{"cls":"LOCAL","type":"KERNEL","parameters":{"inodeURL":"inode://4/4026533900","name":"nsm-1"}}]}
Aug 31 08:47:37.266 [DEBU] [id:70e929ab-bd3f-4ef8-9792-0ee344b4db6b] [type:networkService] client-request-response={"id":"70e929ab-bd3f-4ef8-9792-0ee344b4db6b","network_service":"kernel2kernel","mechanism":{"cls":"LOCAL","type":"KERNEL","parameters":{"inodeURL":"inode://4/4026533782","name":"kernel2ker-eb38"}},"context":{"ip_context":{"src_ip_addrs":["172.16.1.101/32"],"dst_ip_addrs":["172.16.1.100/32"],"src_routes":[{"prefix":"172.16.1.100/32"}],"dst_routes":[{"prefix":"172.16.1.101/32"}],"excluded_prefixes":["10.96.0.0/16","10.244.0.0/16"]},"dns_context":{},"MTU":9000},"labels":{"nodeName":"test-logs-control-plane","podName":"alpine"},"path":{"index":2,"path_segments":[{"name":"alpine-7c4c519c-e466-4b8f-862d-7d27fd37ac19","id":"alpine-7c4c519c-e466-4b8f-862d-7d27fd37ac19-0","token":"eyJhbGciOiJFUzI1NiIsInR5cCI6IkpXVCJ9.eyJzdWIiOiJzcGlmZmU6Ly9rOHMubnNtL25zL25zLWtlcm5lbDJrZXJuZWwvcG9kL2FscGluZSIsImF1ZCI6WyJzcGlmZmU6Ly9rOHMubnNtL25zL25zbS1zeXN0ZW0vcG9kL25zbWdyLWRoY2c3Il0sImV4cCI6MTY5MzQ3MjI1N30.EV9v3GWFdpZ8uB4kz5MJc2jCXNYA8XQUYxo0HKg_ckOqzUA1qEFOGF2n4OAKj89VUm-IIVbSQetsfoyzqXXMpA","expires":{"seconds":1693472257,"nanos":147577899}},{"name":"nsmgr-dhcg7","id":"97d619f7-b85c-44a7-a0fa-e51ad21f95e7","token":"eyJhbGciOiJFUzI1NiIsInR5cCI6IkpXVCJ9.eyJzdWIiOiJzcGlmZmU6Ly9rOHMubnNtL25zL25zbS1zeXN0ZW0vcG9kL25zbWdyLWRoY2c3IiwiYXVkIjpbInNwaWZmZTovL2s4cy5uc20vbnMvbnNtLXN5c3RlbS9wb2QvZm9yd2FyZGVyLXZwcC13enJtOSJdLCJleHAiOjE2OTM0NzIyNTd9.s78B1ZHR1OxCwQiE-AaH9ZY9XsrJ8fr6aEQqyNntWaTu7DGaoHXmIjwnfiJ4hoxvK9Ibj9kkph4SUifN2dn2mQ","expires":{"seconds":1693472257,"nanos":179435371}},{"name":"forwarder-vpp-wzrm9","id":"70e929ab-bd3f-4ef8-9792-0ee344b4db6b","token":"eyJhbGciOiJFUzI1NiIsInR5cCI6IkpXVCJ9.eyJzdWIiOiJzcGlmZmU6Ly9rOHMubnNtL25zL25zbS1zeXN0ZW0vcG9kL2ZvcndhcmRlci12cHAtd3pybTkiLCJhdWQiOlsic3BpZmZlOi8vazhzLm5zbS9ucy9ucy1rZXJuZWwya2VybmVsL3BvZC9uc2Uta2VybmVsLTViN2Y0Y2I3NjktdG42ZnciXSwiZXhwIjoxNjkzNDcyMjU3fQ.f3bI7NWEfDhL4XTwQB3PI-Paaq_mDh7gIZUflulI5-EzgYODBhYcXiDrm7QLaqRaG-XzxQNjMsTvqttHOjf3Hw","expires":{"seconds":1693472257,"nanos":217378601},"metrics":{"client_drops":"7","client_rx_bytes":"33740","client_rx_packets":"580","client_tx_bytes":"33740","client_tx_packets":"580","server_drops":"0","server_rx_bytes":"33856","server_rx_packets":"582","server_tx_bytes":"33250","server_tx_packets":"575"}},{"name":"nse-kernel-5b7f4cb769-tn6fw","id":"eb3874d1-45bc-453c-80ab-4a7b5b74d0de","token":"eyJhbGciOiJFUzI1NiIsInR5cCI6IkpXVCJ9.eyJzdWIiOiJzcGlmZmU6Ly9rOHMubnNtL25zL25zLWtlcm5lbDJrZXJuZWwvcG9kL25zZS1rZXJuZWwtNWI3ZjRjYjc2OS10bjZmdyIsImF1ZCI6WyJzcGlmZmU6Ly9rOHMubnNtL25zL25zbS1zeXN0ZW0vcG9kL2ZvcndhcmRlci12cHAtd3pybTkiXSwiZXhwIjoxNjkzNDcyMjU3fQ.3pbdXk-XkH9xMrbtkbLlrkCWms4gfuKqHd7WRPcnSXEBPMVwtt20ZW2lbE8OtOOKK8ZKoIoXWsXfeahFfrj0EQ","expires":{"seconds":1693472257,"nanos":218520812}}]},"network_service_endpoint_name":"nse-kernel-5b7f4cb769-tn6fw","payload":"ETHERNET"}
Aug 31 08:47:38.317 [DEBU] [id:70e929ab-bd3f-4ef8-9792-0ee344b4db6b] [type:networkService] server-request-response={"id":"70e929ab-bd3f-4ef8-9792-0ee344b4db6b","network_service":"kernel2kernel","mechanism":{"cls":"LOCAL","type":"KERNEL","parameters":{"inodeURL":"file:///proc/2899/fd/19","name":"nsm-1"}},"context":{"ip_context":{"src_ip_addrs":["172.16.1.101/32"],"dst_ip_addrs":["172.16.1.100/32"],"src_routes":[{"prefix":"172.16.1.100/32"}],"dst_routes":[{"prefix":"172.16.1.101/32"}],"excluded_prefixes":["10.96.0.0/16","10.244.0.0/16"]},"dns_context":{},"MTU":9000},"labels":{"nodeName":"test-logs-control-plane","podName":"alpine"},"path":{"index":2,"path_segments":[{"name":"alpine-7c4c519c-e466-4b8f-862d-7d27fd37ac19","id":"alpine-7c4c519c-e466-4b8f-862d-7d27fd37ac19-0","token":"eyJhbGciOiJFUzI1NiIsInR5cCI6IkpXVCJ9.eyJzdWIiOiJzcGlmZmU6Ly9rOHMubnNtL25zL25zLWtlcm5lbDJrZXJuZWwvcG9kL2FscGluZSIsImF1ZCI6WyJzcGlmZmU6Ly9rOHMubnNtL25zL25zbS1zeXN0ZW0vcG9kL25zbWdyLWRoY2c3Il0sImV4cCI6MTY5MzQ3MjI1N30.EV9v3GWFdpZ8uB4kz5MJc2jCXNYA8XQUYxo0HKg_ckOqzUA1qEFOGF2n4OAKj89VUm-IIVbSQetsfoyzqXXMpA","expires":{"seconds":1693472257,"nanos":147577899}},{"name":"nsmgr-dhcg7","id":"97d619f7-b85c-44a7-a0fa-e51ad21f95e7","token":"eyJhbGciOiJFUzI1NiIsInR5cCI6IkpXVCJ9.eyJzdWIiOiJzcGlmZmU6Ly9rOHMubnNtL25zL25zbS1zeXN0ZW0vcG9kL25zbWdyLWRoY2c3IiwiYXVkIjpbInNwaWZmZTovL2s4cy5uc20vbnMvbnNtLXN5c3RlbS9wb2QvZm9yd2FyZGVyLXZwcC13enJtOSJdLCJleHAiOjE2OTM0NzIyNTd9.s78B1ZHR1OxCwQiE-AaH9ZY9XsrJ8fr6aEQqyNntWaTu7DGaoHXmIjwnfiJ4hoxvK9Ibj9kkph4SUifN2dn2mQ","expires":{"seconds":1693472257,"nanos":179435371}},{"name":"forwarder-vpp-wzrm9","id":"70e929ab-bd3f-4ef8-9792-0ee344b4db6b","token":"eyJhbGciOiJFUzI1NiIsInR5cCI6IkpXVCJ9.eyJzdWIiOiJzcGlmZmU6Ly9rOHMubnNtL25zL25zbS1zeXN0ZW0vcG9kL2ZvcndhcmRlci12cHAtd3pybTkiLCJhdWQiOlsic3BpZmZlOi8vazhzLm5zbS9ucy9ucy1rZXJuZWwya2VybmVsL3BvZC9uc2Uta2VybmVsLTViN2Y0Y2I3NjktdG42ZnciXSwiZXhwIjoxNjkzNDcyMjU3fQ.f3bI7NWEfDhL4XTwQB3PI-Paaq_mDh7gIZUflulI5-EzgYODBhYcXiDrm7QLaqRaG-XzxQNjMsTvqttHOjf3Hw","expires":{"seconds":1693472257,"nanos":217378601},"metrics":{"client_drops":"7","client_rx_bytes":"66710","client_rx_packets":"1151","client_tx_bytes":"66710","client_tx_packets":"1151","server_drops":"0","server_rx_bytes":"33856","server_rx_packets":"582","server_tx_bytes":"33250","server_tx_packets":"575"}},{"name":"nse-kernel-5b7f4cb769-tn6fw","id":"eb3874d1-45bc-453c-80ab-4a7b5b74d0de","token":"eyJhbGciOiJFUzI1NiIsInR5cCI6IkpXVCJ9.eyJzdWIiOiJzcGlmZmU6Ly9rOHMubnNtL25zL25zLWtlcm5lbDJrZXJuZWwvcG9kL25zZS1rZXJuZWwtNWI3ZjRjYjc2OS10bjZmdyIsImF1ZCI6WyJzcGlmZmU6Ly9rOHMubnNtL25zL25zbS1zeXN0ZW0vcG9kL2ZvcndhcmRlci12cHAtd3pybTkiXSwiZXhwIjoxNjkzNDcyMjU3fQ.3pbdXk-XkH9xMrbtkbLlrkCWms4gfuKqHd7WRPcnSXEBPMVwtt20ZW2lbE8OtOOKK8ZKoIoXWsXfeahFfrj0EQ","expires":{"seconds":1693472257,"nanos":218520812}}]},"network_service_endpoint_name":"nse-kernel-5b7f4cb769-tn6fw","payload":"ETHERNET"}
...

…ation) Signed-off-by: Alexander Peretyatko <[email protected]>

Signed-off-by: Alexander Peretyatko <[email protected]>

dualBreath · 2023-09-05T12:54:24Z

@denis-tingaikin, @NikitaSkrynnik Currently the client request is not printing for some reason, but could you please take a look and check the overall solution?

Output example in forwarder:

...
Aug 31 08:47:37.180 [DEBU] [id:97d619f7-b85c-44a7-a0fa-e51ad21f95e7] [type:networkService] server-request={"connection":{"id":"97d619f7-b85c-44a7-a0fa-e51ad21f95e7","network_service":"kernel2kernel","mechanism":{"cls":"LOCAL","type":"KERNEL","parameters":{"inodeURL":"inode://4/4026533900","name":"nsm-1"}},"context":{"ip_context":{"src_ip_addrs":["172.16.1.101/32"],"dst_ip_addrs":["172.16.1.100/32"],"src_routes":[{"prefix":"172.16.1.100/32"}],"dst_routes":[{"prefix":"172.16.1.101/32"}],"excluded_prefixes":["10.96.0.0/16","10.244.0.0/16"]},"dns_context":{},"MTU":9000},"labels":{"nodeName":"test-logs-control-plane","podName":"alpine"},"path":{"index":1,"path_segments":[{"name":"alpine-7c4c519c-e466-4b8f-862d-7d27fd37ac19","id":"alpine-7c4c519c-e466-4b8f-862d-7d27fd37ac19-0","token":"eyJhbGciOiJFUzI1NiIsInR5cCI6IkpXVCJ9.eyJzdWIiOiJzcGlmZmU6Ly9rOHMubnNtL25zL25zLWtlcm5lbDJrZXJuZWwvcG9kL2FscGluZSIsImF1ZCI6WyJzcGlmZmU6Ly9rOHMubnNtL25zL25zbS1zeXN0ZW0vcG9kL25zbWdyLWRoY2c3Il0sImV4cCI6MTY5MzQ3MjI1N30.EV9v3GWFdpZ8uB4kz5MJc2jCXNYA8XQUYxo0HKg_ckOqzUA1qEFOGF2n4OAKj89VUm-IIVbSQetsfoyzqXXMpA","expires":{"seconds":1693472257,"nanos":147577899}},{"name":"nsmgr-dhcg7","id":"97d619f7-b85c-44a7-a0fa-e51ad21f95e7","token":"eyJhbGciOiJFUzI1NiIsInR5cCI6IkpXVCJ9.eyJzdWIiOiJzcGlmZmU6Ly9rOHMubnNtL25zL25zbS1zeXN0ZW0vcG9kL25zbWdyLWRoY2c3IiwiYXVkIjpbInNwaWZmZTovL2s4cy5uc20vbnMvbnMta2VybmVsMmtlcm5lbC9wb2QvYWxwaW5lIl0sImV4cCI6MTY5MzQ3MjI1N30.KnG6g87RaCP32PMIleAOKtrH_-JVcZHRSdjS3WOBIkLvbcUjJEDdMJdl4kGSuZyjyiQBKaOP56V2nmdnyqO08Q","expires":{"seconds":1693472257,"nanos":148875289}},{"name":"forwarder-vpp-wzrm9","id":"70e929ab-bd3f-4ef8-9792-0ee344b4db6b","token":"eyJhbGciOiJFUzI1NiIsInR5cCI6IkpXVCJ9.eyJzdWIiOiJzcGlmZmU6Ly9rOHMubnNtL25zL25zbS1zeXN0ZW0vcG9kL2ZvcndhcmRlci12cHAtd3pybTkiLCJhdWQiOlsic3BpZmZlOi8vazhzLm5zbS9ucy9ucy1rZXJuZWwya2VybmVsL3BvZC9uc2Uta2VybmVsLTViN2Y0Y2I3NjktdG42ZnciXSwiZXhwIjoxNjkzNDcyMTM1fQ.o_PnOpHLSOWvLMYoRHtLmCiqoFnIPnoV6-z_ov2L14bBAgNJ5HUKdpzeSBVrd0HmkHdAecFKOC2hFRlG8pzoeg","expires":{"seconds":1693472135,"nanos":393287289},"metrics":{"client_drops":"7","client_rx_bytes":"33740","client_rx_packets":"580","client_tx_bytes":"33740","client_tx_packets":"580","server_drops":"0","server_rx_bytes":"33856","server_rx_packets":"582","server_tx_bytes":"33250","server_tx_packets":"575"}},{"name":"nse-kernel-5b7f4cb769-tn6fw","id":"eb3874d1-45bc-453c-80ab-4a7b5b74d0de","token":"eyJhbGciOiJFUzI1NiIsInR5cCI6IkpXVCJ9.eyJzdWIiOiJzcGlmZmU6Ly9rOHMubnNtL25zL25zLWtlcm5lbDJrZXJuZWwvcG9kL25zZS1rZXJuZWwtNWI3ZjRjYjc2OS10bjZmdyIsImF1ZCI6WyJzcGlmZmU6Ly9rOHMubnNtL25zL25zbS1zeXN0ZW0vcG9kL2ZvcndhcmRlci12cHAtd3pybTkiXSwiZXhwIjoxNjkzNDcyMTM1fQ.ilszjIHMVngj2BaEFcrn9PTPyuMQKQFx3FhPG37uQzPEHISpsLtkoaBOUnc4zUkOWgVcITsgpDqXehkjI_AJZg","expires":{"seconds":1693472135,"nanos":394388399}}]},"network_service_endpoint_name":"nse-kernel-5b7f4cb769-tn6fw","payload":"ETHERNET"},"mechanism_preferences":[{"cls":"LOCAL","type":"KERNEL","parameters":{"inodeURL":"inode://4/4026533900","name":"nsm-1"}}]}
Aug 31 08:47:37.266 [DEBU] [id:70e929ab-bd3f-4ef8-9792-0ee344b4db6b] [type:networkService] client-request-response={"id":"70e929ab-bd3f-4ef8-9792-0ee344b4db6b","network_service":"kernel2kernel","mechanism":{"cls":"LOCAL","type":"KERNEL","parameters":{"inodeURL":"inode://4/4026533782","name":"kernel2ker-eb38"}},"context":{"ip_context":{"src_ip_addrs":["172.16.1.101/32"],"dst_ip_addrs":["172.16.1.100/32"],"src_routes":[{"prefix":"172.16.1.100/32"}],"dst_routes":[{"prefix":"172.16.1.101/32"}],"excluded_prefixes":["10.96.0.0/16","10.244.0.0/16"]},"dns_context":{},"MTU":9000},"labels":{"nodeName":"test-logs-control-plane","podName":"alpine"},"path":{"index":2,"path_segments":[{"name":"alpine-7c4c519c-e466-4b8f-862d-7d27fd37ac19","id":"alpine-7c4c519c-e466-4b8f-862d-7d27fd37ac19-0","token":"eyJhbGciOiJFUzI1NiIsInR5cCI6IkpXVCJ9.eyJzdWIiOiJzcGlmZmU6Ly9rOHMubnNtL25zL25zLWtlcm5lbDJrZXJuZWwvcG9kL2FscGluZSIsImF1ZCI6WyJzcGlmZmU6Ly9rOHMubnNtL25zL25zbS1zeXN0ZW0vcG9kL25zbWdyLWRoY2c3Il0sImV4cCI6MTY5MzQ3MjI1N30.EV9v3GWFdpZ8uB4kz5MJc2jCXNYA8XQUYxo0HKg_ckOqzUA1qEFOGF2n4OAKj89VUm-IIVbSQetsfoyzqXXMpA","expires":{"seconds":1693472257,"nanos":147577899}},{"name":"nsmgr-dhcg7","id":"97d619f7-b85c-44a7-a0fa-e51ad21f95e7","token":"eyJhbGciOiJFUzI1NiIsInR5cCI6IkpXVCJ9.eyJzdWIiOiJzcGlmZmU6Ly9rOHMubnNtL25zL25zbS1zeXN0ZW0vcG9kL25zbWdyLWRoY2c3IiwiYXVkIjpbInNwaWZmZTovL2s4cy5uc20vbnMvbnNtLXN5c3RlbS9wb2QvZm9yd2FyZGVyLXZwcC13enJtOSJdLCJleHAiOjE2OTM0NzIyNTd9.s78B1ZHR1OxCwQiE-AaH9ZY9XsrJ8fr6aEQqyNntWaTu7DGaoHXmIjwnfiJ4hoxvK9Ibj9kkph4SUifN2dn2mQ","expires":{"seconds":1693472257,"nanos":179435371}},{"name":"forwarder-vpp-wzrm9","id":"70e929ab-bd3f-4ef8-9792-0ee344b4db6b","token":"eyJhbGciOiJFUzI1NiIsInR5cCI6IkpXVCJ9.eyJzdWIiOiJzcGlmZmU6Ly9rOHMubnNtL25zL25zbS1zeXN0ZW0vcG9kL2ZvcndhcmRlci12cHAtd3pybTkiLCJhdWQiOlsic3BpZmZlOi8vazhzLm5zbS9ucy9ucy1rZXJuZWwya2VybmVsL3BvZC9uc2Uta2VybmVsLTViN2Y0Y2I3NjktdG42ZnciXSwiZXhwIjoxNjkzNDcyMjU3fQ.f3bI7NWEfDhL4XTwQB3PI-Paaq_mDh7gIZUflulI5-EzgYODBhYcXiDrm7QLaqRaG-XzxQNjMsTvqttHOjf3Hw","expires":{"seconds":1693472257,"nanos":217378601},"metrics":{"client_drops":"7","client_rx_bytes":"33740","client_rx_packets":"580","client_tx_bytes":"33740","client_tx_packets":"580","server_drops":"0","server_rx_bytes":"33856","server_rx_packets":"582","server_tx_bytes":"33250","server_tx_packets":"575"}},{"name":"nse-kernel-5b7f4cb769-tn6fw","id":"eb3874d1-45bc-453c-80ab-4a7b5b74d0de","token":"eyJhbGciOiJFUzI1NiIsInR5cCI6IkpXVCJ9.eyJzdWIiOiJzcGlmZmU6Ly9rOHMubnNtL25zL25zLWtlcm5lbDJrZXJuZWwvcG9kL25zZS1rZXJuZWwtNWI3ZjRjYjc2OS10bjZmdyIsImF1ZCI6WyJzcGlmZmU6Ly9rOHMubnNtL25zL25zbS1zeXN0ZW0vcG9kL2ZvcndhcmRlci12cHAtd3pybTkiXSwiZXhwIjoxNjkzNDcyMjU3fQ.3pbdXk-XkH9xMrbtkbLlrkCWms4gfuKqHd7WRPcnSXEBPMVwtt20ZW2lbE8OtOOKK8ZKoIoXWsXfeahFfrj0EQ","expires":{"seconds":1693472257,"nanos":218520812}}]},"network_service_endpoint_name":"nse-kernel-5b7f4cb769-tn6fw","payload":"ETHERNET"}
Aug 31 08:47:38.317 [DEBU] [id:70e929ab-bd3f-4ef8-9792-0ee344b4db6b] [type:networkService] server-request-response={"id":"70e929ab-bd3f-4ef8-9792-0ee344b4db6b","network_service":"kernel2kernel","mechanism":{"cls":"LOCAL","type":"KERNEL","parameters":{"inodeURL":"file:///proc/2899/fd/19","name":"nsm-1"}},"context":{"ip_context":{"src_ip_addrs":["172.16.1.101/32"],"dst_ip_addrs":["172.16.1.100/32"],"src_routes":[{"prefix":"172.16.1.100/32"}],"dst_routes":[{"prefix":"172.16.1.101/32"}],"excluded_prefixes":["10.96.0.0/16","10.244.0.0/16"]},"dns_context":{},"MTU":9000},"labels":{"nodeName":"test-logs-control-plane","podName":"alpine"},"path":{"index":2,"path_segments":[{"name":"alpine-7c4c519c-e466-4b8f-862d-7d27fd37ac19","id":"alpine-7c4c519c-e466-4b8f-862d-7d27fd37ac19-0","token":"eyJhbGciOiJFUzI1NiIsInR5cCI6IkpXVCJ9.eyJzdWIiOiJzcGlmZmU6Ly9rOHMubnNtL25zL25zLWtlcm5lbDJrZXJuZWwvcG9kL2FscGluZSIsImF1ZCI6WyJzcGlmZmU6Ly9rOHMubnNtL25zL25zbS1zeXN0ZW0vcG9kL25zbWdyLWRoY2c3Il0sImV4cCI6MTY5MzQ3MjI1N30.EV9v3GWFdpZ8uB4kz5MJc2jCXNYA8XQUYxo0HKg_ckOqzUA1qEFOGF2n4OAKj89VUm-IIVbSQetsfoyzqXXMpA","expires":{"seconds":1693472257,"nanos":147577899}},{"name":"nsmgr-dhcg7","id":"97d619f7-b85c-44a7-a0fa-e51ad21f95e7","token":"eyJhbGciOiJFUzI1NiIsInR5cCI6IkpXVCJ9.eyJzdWIiOiJzcGlmZmU6Ly9rOHMubnNtL25zL25zbS1zeXN0ZW0vcG9kL25zbWdyLWRoY2c3IiwiYXVkIjpbInNwaWZmZTovL2s4cy5uc20vbnMvbnNtLXN5c3RlbS9wb2QvZm9yd2FyZGVyLXZwcC13enJtOSJdLCJleHAiOjE2OTM0NzIyNTd9.s78B1ZHR1OxCwQiE-AaH9ZY9XsrJ8fr6aEQqyNntWaTu7DGaoHXmIjwnfiJ4hoxvK9Ibj9kkph4SUifN2dn2mQ","expires":{"seconds":1693472257,"nanos":179435371}},{"name":"forwarder-vpp-wzrm9","id":"70e929ab-bd3f-4ef8-9792-0ee344b4db6b","token":"eyJhbGciOiJFUzI1NiIsInR5cCI6IkpXVCJ9.eyJzdWIiOiJzcGlmZmU6Ly9rOHMubnNtL25zL25zbS1zeXN0ZW0vcG9kL2ZvcndhcmRlci12cHAtd3pybTkiLCJhdWQiOlsic3BpZmZlOi8vazhzLm5zbS9ucy9ucy1rZXJuZWwya2VybmVsL3BvZC9uc2Uta2VybmVsLTViN2Y0Y2I3NjktdG42ZnciXSwiZXhwIjoxNjkzNDcyMjU3fQ.f3bI7NWEfDhL4XTwQB3PI-Paaq_mDh7gIZUflulI5-EzgYODBhYcXiDrm7QLaqRaG-XzxQNjMsTvqttHOjf3Hw","expires":{"seconds":1693472257,"nanos":217378601},"metrics":{"client_drops":"7","client_rx_bytes":"66710","client_rx_packets":"1151","client_tx_bytes":"66710","client_tx_packets":"1151","server_drops":"0","server_rx_bytes":"33856","server_rx_packets":"582","server_tx_bytes":"33250","server_tx_packets":"575"}},{"name":"nse-kernel-5b7f4cb769-tn6fw","id":"eb3874d1-45bc-453c-80ab-4a7b5b74d0de","token":"eyJhbGciOiJFUzI1NiIsInR5cCI6IkpXVCJ9.eyJzdWIiOiJzcGlmZmU6Ly9rOHMubnNtL25zL25zLWtlcm5lbDJrZXJuZWwvcG9kL25zZS1rZXJuZWwtNWI3ZjRjYjc2OS10bjZmdyIsImF1ZCI6WyJzcGlmZmU6Ly9rOHMubnNtL25zL25zbS1zeXN0ZW0vcG9kL2ZvcndhcmRlci12cHAtd3pybTkiXSwiZXhwIjoxNjkzNDcyMjU3fQ.3pbdXk-XkH9xMrbtkbLlrkCWms4gfuKqHd7WRPcnSXEBPMVwtt20ZW2lbE8OtOOKK8ZKoIoXWsXfeahFfrj0EQ","expires":{"seconds":1693472257,"nanos":218520812}}]},"network_service_endpoint_name":"nse-kernel-5b7f4cb769-tn6fw","payload":"ETHERNET"}
...

UPD:
Logs are now displayed correctly with the correct ID:

...
Sep  5 12:40:33.739 [DEBU] [id:58e8c7b2-5a05-4b59-bac5-4760cd00c20f] [type:networkService] server-request={"connection":{"id":"58e8c7b2-5a05-4b59-bac5-4760cd00c20f","network_service":"kernel2kernel","context":{"ip_context":{}},"labels":{"podName":"alpine"},"path":{"index":1,"path_segments":[{"name":"alpine-9789a3df-ac99-4f84-a586-70c06913275e","id":"alpine-9789a3df-ac99-4f84-a586-70c06913275e-0"},{"name":"nsmgr-zjdcm","id":"58e8c7b2-5a05-4b59-bac5-4760cd00c20f"}]}},"mechanism_preferences":[{"cls":"LOCAL","type":"KERNEL","parameters":{"inodeURL":"inode://4/4026533894","name":"nsm-1"}}]}

Sep  5 12:40:33.816 [DEBU] [id:58e8c7b2-5a05-4b59-bac5-4760cd00c20f] [type:networkService] client-request={"connection":{"id":"58e8c7b2-5a05-4b59-bac5-4760cd00c20f","network_service":"kernel2kernel","context":{"ip_context":{"excluded_prefixes":["10.96.0.0/16","10.244.0.0/16"]}},"labels":{"nodeName":"test-logs-control-plane","podName":"alpine"},"path":{"index":1,"path_segments":[{"name":"alpine-9789a3df-ac99-4f84-a586-70c06913275e","id":"alpine-9789a3df-ac99-4f84-a586-70c06913275e-0","token":"eyJhbGciOiJFUzI1NiIsInR5cCI6IkpXVCJ9.eyJzdWIiOiJzcGlmZmU6Ly9rOHMubnNtL25zL25zLWtlcm5lbDJrZXJuZWwvcG9kL2FscGluZSIsImF1ZCI6WyJzcGlmZmU6Ly9rOHMubnNtL25zL25zbS1zeXN0ZW0vcG9kL25zbWdyLXpqZGNtIl0sImV4cCI6MTY5MzkxODIzM30.we1718-Ju-QwWD9x6QW3SvMc0lbtp0TwxjIYcjjMUzBjM0jUUK4vJ7BkASy_p_6OU_rh340SZuRA6IdFVfUQKg","expires":{"seconds":1693918233,"nanos":734647644}},{"name":"nsmgr-zjdcm","id":"58e8c7b2-5a05-4b59-bac5-4760cd00c20f","token":"eyJhbGciOiJFUzI1NiIsInR5cCI6IkpXVCJ9.eyJzdWIiOiJzcGlmZmU6Ly9rOHMubnNtL25zL25zbS1zeXN0ZW0vcG9kL25zbWdyLXpqZGNtIiwiYXVkIjpbInNwaWZmZTovL2s4cy5uc20vbnMvbnMta2VybmVsMmtlcm5lbC9wb2QvYWxwaW5lIl0sImV4cCI6MTY5MzkxODIzM30.6jwTYeTv7lGI__heFORf4oAwkFuAppPNx17ycjpZWWG8t1F5iEqFGcG5lPIVEWOTf_BSDhz9A68Sd4JuBfAbKw","expires":{"seconds":1693918233,"nanos":739885358}}]}},"mechanism_preferences":[{"cls":"LOCAL","type":"KERNEL","parameters":{"inodeURL":"file:///proc/1/fd/65","name":"nsm-1"}}]}

Sep  5 12:40:35.542 [DEBU] [id:58e8c7b2-5a05-4b59-bac5-4760cd00c20f] [type:networkService] client-request-response={"id":"58e8c7b2-5a05-4b59-bac5-4760cd00c20f","network_service":"kernel2kernel","mechanism":{"cls":"LOCAL","type":"KERNEL","parameters":{"inodeURL":"inode://4/4026533894","name":"nsm-1"}},"context":{"ip_context":{"src_ip_addrs":["172.16.1.101/32"],"dst_ip_addrs":["172.16.1.100/32"],"src_routes":[{"prefix":"172.16.1.100/32"}],"dst_routes":[{"prefix":"172.16.1.101/32"}],"excluded_prefixes":["10.96.0.0/16","10.244.0.0/16"]},"dns_context":{},"MTU":9000},"labels":{"nodeName":"test-logs-control-plane","podName":"alpine"},"path":{"index":1,"path_segments":[{"name":"alpine-9789a3df-ac99-4f84-a586-70c06913275e","id":"alpine-9789a3df-ac99-4f84-a586-70c06913275e-0","token":"eyJhbGciOiJFUzI1NiIsInR5cCI6IkpXVCJ9.eyJzdWIiOiJzcGlmZmU6Ly9rOHMubnNtL25zL25zLWtlcm5lbDJrZXJuZWwvcG9kL2FscGluZSIsImF1ZCI6WyJzcGlmZmU6Ly9rOHMubnNtL25zL25zbS1zeXN0ZW0vcG9kL25zbWdyLXpqZGNtIl0sImV4cCI6MTY5MzkxODIzM30.we1718-Ju-QwWD9x6QW3SvMc0lbtp0TwxjIYcjjMUzBjM0jUUK4vJ7BkASy_p_6OU_rh340SZuRA6IdFVfUQKg","expires":{"seconds":1693918233,"nanos":734647644}},{"name":"nsmgr-zjdcm","id":"58e8c7b2-5a05-4b59-bac5-4760cd00c20f","token":"eyJhbGciOiJFUzI1NiIsInR5cCI6IkpXVCJ9.eyJzdWIiOiJzcGlmZmU6Ly9rOHMubnNtL25zL25zbS1zeXN0ZW0vcG9kL25zbWdyLXpqZGNtIiwiYXVkIjpbInNwaWZmZTovL2s4cy5uc20vbnMvbnNtLXN5c3RlbS9wb2QvZm9yd2FyZGVyLXZwcC04ZzJ3NSJdLCJleHAiOjE2OTM5MTgyMzN9.BC_a7P7Wawjqb5KCAZ0wJF0xFv6HvFH73QJ_w94UCq38ETWH0qcLKeL5MeyDq-XrLdEK9qmNEEot4mOZ1V75Cg","expires":{"seconds":1693918233,"nanos":825455471}},{"name":"forwarder-vpp-8g2w5","id":"e71cc270-3160-430a-93e0-8d375814343c","token":"eyJhbGciOiJFUzI1NiIsInR5cCI6IkpXVCJ9.eyJzdWIiOiJzcGlmZmU6Ly9rOHMubnNtL25zL25zbS1zeXN0ZW0vcG9kL2ZvcndhcmRlci12cHAtOGcydzUiLCJhdWQiOlsic3BpZmZlOi8vazhzLm5zbS9ucy9ucy1rZXJuZWwya2VybmVsL3BvZC9uc2Uta2VybmVsLTViN2Y0Y2I3NjktanByenoiXSwiZXhwIjoxNjkzOTE4MjM0fQ.sr6IdfeA4aQuVoPXZHaxUI_fkK-O7zeK_7vF8hJ1kz4jwsNPXFQh8_lVyofGWYZfNu9GIWIM5c3NIBEwx3B7IQ","expires":{"seconds":1693918234,"nanos":53768532},"metrics":{"client_drops":"0","client_rx_bytes":"0","client_rx_packets":"0","client_tx_bytes":"0","client_tx_packets":"0","server_drops":"0","server_rx_bytes":"0","server_rx_packets":"0","server_tx_bytes":"0","server_tx_packets":"0"}},{"name":"nse-kernel-5b7f4cb769-jprzz","id":"aa3f550a-9b87-4108-aa3e-02c7d5dfc03d","token":"eyJhbGciOiJFUzI1NiIsInR5cCI6IkpXVCJ9.eyJzdWIiOiJzcGlmZmU6Ly9rOHMubnNtL25zL25zLWtlcm5lbDJrZXJuZWwvcG9kL25zZS1rZXJuZWwtNWI3ZjRjYjc2OS1qcHJ6eiIsImF1ZCI6WyJzcGlmZmU6Ly9rOHMubnNtL25zL25zbS1zeXN0ZW0vcG9kL2ZvcndhcmRlci12cHAtOGcydzUiXSwiZXhwIjoxNjkzOTE4MjM0fQ.axewzM9ZUEPhEQIulfJotjjvex3secKGNoxu6kFz2BkGsd56U9SOGYCT8fU_Bo0XFyDdjDhQwweTogKd2ZaK1g","expires":{"seconds":1693918234,"nanos":60496617}}]},"network_service_endpoint_name":"nse-kernel-5b7f4cb769-jprzz","payload":"ETHERNET"}

Sep  5 12:40:35.543 [DEBU] [id:58e8c7b2-5a05-4b59-bac5-4760cd00c20f] [type:networkService] server-request-response={"id":"58e8c7b2-5a05-4b59-bac5-4760cd00c20f","network_service":"kernel2kernel","mechanism":{"cls":"LOCAL","type":"KERNEL","parameters":{"inodeURL":"file:///proc/1/fd/65","name":"nsm-1"}},"context":{"ip_context":{"src_ip_addrs":["172.16.1.101/32"],"dst_ip_addrs":["172.16.1.100/32"],"src_routes":[{"prefix":"172.16.1.100/32"}],"dst_routes":[{"prefix":"172.16.1.101/32"}],"excluded_prefixes":["10.96.0.0/16","10.244.0.0/16"]},"dns_context":{},"MTU":9000},"labels":{"nodeName":"test-logs-control-plane","podName":"alpine"},"path":{"index":1,"path_segments":[{"name":"alpine-9789a3df-ac99-4f84-a586-70c06913275e","id":"alpine-9789a3df-ac99-4f84-a586-70c06913275e-0","token":"eyJhbGciOiJFUzI1NiIsInR5cCI6IkpXVCJ9.eyJzdWIiOiJzcGlmZmU6Ly9rOHMubnNtL25zL25zLWtlcm5lbDJrZXJuZWwvcG9kL2FscGluZSIsImF1ZCI6WyJzcGlmZmU6Ly9rOHMubnNtL25zL25zbS1zeXN0ZW0vcG9kL25zbWdyLXpqZGNtIl0sImV4cCI6MTY5MzkxODIzM30.we1718-Ju-QwWD9x6QW3SvMc0lbtp0TwxjIYcjjMUzBjM0jUUK4vJ7BkASy_p_6OU_rh340SZuRA6IdFVfUQKg","expires":{"seconds":1693918233,"nanos":734647644}},{"name":"nsmgr-zjdcm","id":"58e8c7b2-5a05-4b59-bac5-4760cd00c20f","token":"eyJhbGciOiJFUzI1NiIsInR5cCI6IkpXVCJ9.eyJzdWIiOiJzcGlmZmU6Ly9rOHMubnNtL25zL25zbS1zeXN0ZW0vcG9kL25zbWdyLXpqZGNtIiwiYXVkIjpbInNwaWZmZTovL2s4cy5uc20vbnMvbnNtLXN5c3RlbS9wb2QvZm9yd2FyZGVyLXZwcC04ZzJ3NSJdLCJleHAiOjE2OTM5MTgyMzN9.BC_a7P7Wawjqb5KCAZ0wJF0xFv6HvFH73QJ_w94UCq38ETWH0qcLKeL5MeyDq-XrLdEK9qmNEEot4mOZ1V75Cg","expires":{"seconds":1693918233,"nanos":825455471}},{"name":"forwarder-vpp-8g2w5","id":"e71cc270-3160-430a-93e0-8d375814343c","token":"eyJhbGciOiJFUzI1NiIsInR5cCI6IkpXVCJ9.eyJzdWIiOiJzcGlmZmU6Ly9rOHMubnNtL25zL25zbS1zeXN0ZW0vcG9kL2ZvcndhcmRlci12cHAtOGcydzUiLCJhdWQiOlsic3BpZmZlOi8vazhzLm5zbS9ucy9ucy1rZXJuZWwya2VybmVsL3BvZC9uc2Uta2VybmVsLTViN2Y0Y2I3NjktanByenoiXSwiZXhwIjoxNjkzOTE4MjM0fQ.sr6IdfeA4aQuVoPXZHaxUI_fkK-O7zeK_7vF8hJ1kz4jwsNPXFQh8_lVyofGWYZfNu9GIWIM5c3NIBEwx3B7IQ","expires":{"seconds":1693918234,"nanos":53768532},"metrics":{"client_drops":"0","client_rx_bytes":"0","client_rx_packets":"0","client_tx_bytes":"0","client_tx_packets":"0","server_drops":"0","server_rx_bytes":"0","server_rx_packets":"0","server_tx_bytes":"0","server_tx_packets":"0"}},{"name":"nse-kernel-5b7f4cb769-jprzz","id":"aa3f550a-9b87-4108-aa3e-02c7d5dfc03d","token":"eyJhbGciOiJFUzI1NiIsInR5cCI6IkpXVCJ9.eyJzdWIiOiJzcGlmZmU6Ly9rOHMubnNtL25zL25zLWtlcm5lbDJrZXJuZWwvcG9kL25zZS1rZXJuZWwtNWI3ZjRjYjc2OS1qcHJ6eiIsImF1ZCI6WyJzcGlmZmU6Ly9rOHMubnNtL25zL25zbS1zeXN0ZW0vcG9kL2ZvcndhcmRlci12cHAtOGcydzUiXSwiZXhwIjoxNjkzOTE4MjM0fQ.axewzM9ZUEPhEQIulfJotjjvex3secKGNoxu6kFz2BkGsd56U9SOGYCT8fU_Bo0XFyDdjDhQwweTogKd2ZaK1g","expires":{"seconds":1693918234,"nanos":60496617}}]},"network_service_endpoint_name":"nse-kernel-5b7f4cb769-jprzz","payload":"ETHERNET"}

Signed-off-by: Alexander Peretyatko <[email protected]>

Log rotated after 5 minutes in NSMgr / Registry (-draft implementatio…

e14cfd4

…n for networkservise) Signed-off-by: Alexander Peretyatko <[email protected]>

Alexander Peretyatko added 2 commits September 5, 2023 15:00

Log rotated after 5 minutes in NSMgr / Registry (-forwarder implement…

a92903d

…ation) Signed-off-by: Alexander Peretyatko <[email protected]>

Log rotated after 5 minutes in NSMgr / Registry (-skip the same errors)

b2e3009

Signed-off-by: Alexander Peretyatko <[email protected]>

Alexander Peretyatko added 6 commits September 7, 2023 11:44

Log rotated after 5 minutes in NSMgr / Registry (-clean up)

b9a4298

Signed-off-by: Alexander Peretyatko <[email protected]>

Log rotated after 5 minutes in NSMgr / Registry (-handle errors)

932cdf6

Signed-off-by: Alexander Peretyatko <[email protected]>

Log rotated after 5 minutes in NSMgr / Registry (-handle registry logs)

a27136d

Signed-off-by: Alexander Peretyatko <[email protected]>

Log rotated after 5 minutes in NSMgr / Registry (-clean up)

2ade321

Signed-off-by: Alexander Peretyatko <[email protected]>

Log rotated after 5 minutes in NSMgr / Registry (-clean up)

0c7afac

Signed-off-by: Alexander Peretyatko <[email protected]>

Log rotated after 5 minutes in NSMgr / Registry (-clean up)

056aed3

Signed-off-by: Alexander Peretyatko <[email protected]>

glazychev-art mentioned this pull request Sep 25, 2023

Add concise tracing #1513

Merged

9 tasks

denis-tingaikin closed this in #1513 Sep 28, 2023

Provide feedback

Saved searches

Use saved searches to filter your results more quickly

Log rotated after 5 minutes in NSMgr / Registry #1506

Log rotated after 5 minutes in NSMgr / Registry #1506

dualBreath commented Aug 31, 2023

dualBreath commented Aug 31, 2023

dualBreath commented Sep 5, 2023

Log rotated after 5 minutes in NSMgr / Registry #1506

Log rotated after 5 minutes in NSMgr / Registry #1506

Conversation

dualBreath commented Aug 31, 2023

Description

Issue link

How Has This Been Tested?

Types of changes

dualBreath commented Aug 31, 2023

dualBreath commented Sep 5, 2023