Thank You Shawn,
Here is the log.
root@Teltonika-RUTX11:/tmp# ./ziti-edge-tunnel run -v 6 -i TeltonikaX11.json --dns=dnsmasq:/tmp/hosts
[ 0.000] INFO ziti-edge-tunnel:ziti-edge-tunnel.c:1834 run() DNS dnsmasq -- AM I coming here ???
[ 0.000] INFO ziti-edge-tunnel:dnsmasq_manager.c:64 get_dnsmasq_manager() smapping_dir = /tmp/hosts
[ 0.000] INFO ziti-edge-tunnel:dnsmasq_manager.c:67 get_dnsmasq_manager() dnsmasq_manager = /tmp/hosts
[ 0.000] INFO ziti-edge-tunnel:ziti-edge-tunnel.c:1843 run() dnsmasq_manager = /tmp/hosts
[ 0.000] INFO ziti-edge-tunnel:ziti-edge-tunnel.c:1844 run() DNS = 0xbed72c6c
[ 0.000] DEBUG ziti-edge-tunnel:utils.c:32 run_command_va() system(ip link set tun0 up) returned 0
[ 0.000] DEBUG ziti-edge-tunnel:utils.c:32 run_command_va() system(ip addr add 100.64.0.1 dev tun0) returned 0
[ 0.000] DEBUG ziti-edge-tunnel:utils.c:32 run_command_va() system(ip route add 100.64.0.0/10 dev tun0) returned 0
[ 0.000] ERROR tunnel-sdk:ziti_tunnel.c:92 ziti_tunneler_init() Entering here
[ 0.000] INFO tunnel-sdk:ziti_tunnel.c:68 create_tunneler_ctx() Ziti Tunneler SDK (v0.18.6-local)
[ 0.000] ERROR tunnel-sdk:ziti_tunnel.c:624 run_packet_loop() Entering here
[ 0.000] INFO tunnel-cbs:ziti_dns.c:153 ziti_dns_setup() Entering this function
[ 0.000] INFO tunnel-cbs:ziti_dns.c:147 seed_dns() DNS configured with range 100.64.0.0 - 100.127.255.255
[ 0.000] DEBUG tunnel-sdk:ziti_tunnel.c:433 ziti_tunneler_intercept() intercepting address[udp:100.64.0.2:53] service[ziti:dns-resolver]
[ 0.053] INFO tunnel-cbs:ziti_tunnel_ctrl.c:861 load_ziti_async() attempting to load ziti instance from file[TeltonikaX11.json]
[ 0.053] INFO tunnel-cbs:ziti_tunnel_ctrl.c:868 load_ziti_async() loading ziti instance from /tmp/TeltonikaX11.json
[ 0.053] INFO ziti_log_set_level set log level: ziti_log_lvl=6 &ziti_log_lvl = 0x1dd7e8
[ 0.053] INFO ziti-edge-tunnel:ziti-edge-tunnel.c:1037 load_id_cb() identity[TeltonikaX11.json] loaded
[ 0.053] WARN ziti-edge-tunnel:instance.c:37 find_tunnel_identity() Identity ztx[TeltonikaX11.json] is not loaded yet or already removed.
[ 0.053] ERROR ziti-edge-tunnel:instance-config.c:121 save_tunnel_status_to_file() Could not save the config file [/var/lib/ziti/config.json] due to semaphore lock not initialized error.
[ 0.086] INFO ziti-sdk:ziti.c:406 ziti_init_async() ztx[0] Ziti C SDK version 0.27.10 @ca8b793(HEAD) starting at (2022-06-07T17:47:45.371)
[ 0.086] INFO ziti-sdk:ziti.c:407 ziti_init_async() ztx[0] using uv_mbed[v0.14.5], tls[mbed TLS 3.1.0]
[ 0.086] INFO ziti-sdk:ziti.c:408 ziti_init_async() ztx[0] Loading from config[TeltonikaX11.json] controller[https://ziti-edge-controller:1280]
[ 0.086] INFO ziti-sdk:ziti_ctrl.c:375 ziti_ctrl_init() ctrl[ziti-edge-controller] ziti controller client initialized
[ 0.086] DEBUG ziti-sdk:ziti.c:432 ziti_init_async() ztx[0] using metrics interval: 0
[ 0.086] DEBUG ziti-sdk:ziti_ctrl.c:133 start_request() ctrl[ziti-edge-controller] starting GET[/version]
[ 0.086] DEBUG ziti-sdk:ziti.c:241 ziti_set_unauthenticated() ztx[0] setting api_session_state[0] to 0
[ 0.086] DEBUG ziti-sdk:ziti_ctrl.c:228 ziti_ctrl_clear_api_session() ctrl[ziti-edge-controller] clearing api session token for ziti_controller
[ 0.086] DEBUG ziti-sdk:ziti.c:836 ziti_re_auth() ztx[0] re-auth executing, transitioning to unauthenticated
[ 0.086] DEBUG ziti-sdk:ziti.c:241 ziti_set_unauthenticated() ztx[0] setting api_session_state[0] to 0
[ 0.086] DEBUG ziti-sdk:ziti_ctrl.c:228 ziti_ctrl_clear_api_session() ctrl[ziti-edge-controller] clearing api session token for ziti_controller
[ 0.086] DEBUG ziti-sdk:ziti.c:272 is_api_session_expired() ztx[0] is_api_session_expired[TRUE] - api_session is null
[ 0.086] INFO ziti-sdk:ziti.c:792 ziti_re_auth_with_cb() ztx[0] starting to re-auth with ctlr[https://ziti-edge-controller:1280] api_session_status[0] api_session_expired[TRUE]
[ 0.086] DEBUG ziti-sdk:ziti.c:234 ziti_set_auth_started() ztx[0] setting api_session_state[0] to 1
[ 0.086] DEBUG ziti-sdk:ziti.c:302 ziti_stop_api_session_refresh() ztx[0] ziti_stop_api_session_refresh: stopping api session refresh
[ 0.086] DEBUG ziti-sdk:ziti_ctrl.c:133 start_request() ctrl[ziti-edge-controller] starting POST[/authenticate?method=cert]
[ 0.748] DEBUG ziti-sdk:ziti_ctrl.c:160 ctrl_resp_cb() ctrl[ziti-edge-controller] received headers GET[/version]
[ 0.748] DEBUG ziti-sdk:ziti_ctrl.c:308 ctrl_body_cb() ctrl[ziti-edge-controller] completed GET[/version] in 40268688.000 s
[ 0.748] INFO ziti-sdk:ziti.c:1441 version_cb() ztx[0] connected to controller https://ziti-edge-controller:1280 version v0.25.5(2cd97dc79e5d 2022-05-03T02:47:46Z)
[ 0.811] DEBUG ziti-sdk:ziti_ctrl.c:160 ctrl_resp_cb() ctrl[ziti-edge-controller] received headers POST[/authenticate?method=cert]
[ 0.811] DEBUG ziti-sdk:ziti_ctrl.c:308 ctrl_body_cb() ctrl[ziti-edge-controller] completed POST[/authenticate?method=cert] in 40268688.000 s
[ 0.811] DEBUG ziti-sdk:ziti_ctrl.c:241 ctrl_login_cb() ctrl[ziti-edge-controller] authenticated successfully session[cl44gg4e60ldv8s86dpx64v4t]
[ 0.811] DEBUG ziti-sdk:ziti.c:1357 api_session_cb() ztx[0] logged in successfully => api_session[cl44gg4e60ldv8s86dpx64v4t]
[ 0.811] TRACE ziti-sdk:ziti.c:1296 ziti_set_api_session() ztx[0] API supports cached_last_activity_at
[ 0.811] DEBUG ziti-sdk:ziti.c:1307 ziti_set_api_session() ztx[0] ziti api session expires in 600 seconds
[ 0.811] INFO ziti-sdk:ziti.c:1331 ziti_set_api_session() ztx[0] api session set, setting api_session_timer to 540s
[ 0.811] DEBUG ziti-sdk:ziti.c:307 ziti_schedule_api_session_refresh() ztx[0] ziti_schedule_api_session_refresh: scheduling api session refresh: -1093213160ms
[ 0.811] DEBUG ziti-sdk:ziti.c:266 ziti_set_fully_authenticated() ztx[0] setting api_session_state[1] to 3
[ 0.811] DEBUG ziti-sdk:ziti_ctrl.c:133 start_request() ctrl[ziti-edge-controller] starting GET[/current-identity]
[ 0.811] VERBOSE ziti-sdk:ziti.c:1246 session_post_auth_query_cb() ztx[0] post auth query callback starting with status[OK]
[ 0.811] VERBOSE ziti-sdk:ziti.c:1248 session_post_auth_query_cb() ztx[0] transitioning to fully authenticated
[ 0.811] DEBUG ziti-sdk:ziti.c:266 ziti_set_fully_authenticated() ztx[0] setting api_session_state[3] to 3
[ 0.811] INFO tunnel-cbs:ziti_tunnel_ctrl.c:724 on_ziti_event() ziti_ctx[ TeltonikaX11] connected to controller
[ 0.811] DEBUG tunnel-sdk:ziti_tunnel.c:118 ziti_tunneler_exclude_route() excluding ziti-edge-controller from tunneler intercept
[ 0.811] TRACE tunnel-sdk:ziti_tunnel.c:140 ziti_tunneler_exclude_route() ipv6 address compare not implemented
[ 0.811] TRACE tunnel-sdk:ziti_tunnel.c:140 ziti_tunneler_exclude_route() ipv6 address compare not implemented
[ 0.811] TRACE tunnel-sdk:ziti_tunnel.c:140 ziti_tunneler_exclude_route() ipv6 address compare not implemented
[ 0.811] TRACE tunnel-sdk:ziti_tunnel.c:140 ziti_tunneler_exclude_route() ipv6 address compare not implemented
[ 0.811] TRACE tunnel-sdk:ziti_tunnel.c:140 ziti_tunneler_exclude_route() ipv6 address compare not implemented
[ 0.811] TRACE tunnel-sdk:ziti_tunnel.c:140 ziti_tunneler_exclude_route() ipv6 address compare not implemented
[ 0.811] TRACE tunnel-sdk:ziti_tunnel.c:140 ziti_tunneler_exclude_route() ipv6 address compare not implemented
[ 0.811] DEBUG ziti-edge-tunnel:tun.c:257 tun_exclude_rt() default route is 'default via 192.168.3.1 dev wlan1 proto static src 192.168.3.4 metric 3 '
[ 0.811] DEBUG ziti-edge-tunnel:utils.c:32 run_command_va() system(ip route replace 203.160.138.65 via 192.168.3.1) returned 0
[ 0.811] TRACE tunnel-sdk:ziti_tunnel.c:140 ziti_tunneler_exclude_route() ipv6 address compare not implemented
[ 0.811] TRACE tunnel-sdk:ziti_tunnel.c:140 ziti_tunneler_exclude_route() ipv6 address compare not implemented
[ 0.811] TRACE tunnel-sdk:ziti_tunnel.c:140 ziti_tunneler_exclude_route() ipv6 address compare not implemented
[ 0.811] TRACE tunnel-sdk:ziti_tunnel.c:140 ziti_tunneler_exclude_route() ipv6 address compare not implemented
[ 0.811] TRACE tunnel-sdk:ziti_tunnel.c:140 ziti_tunneler_exclude_route() ipv6 address compare not implemented
[ 0.811] TRACE tunnel-sdk:ziti_tunnel.c:140 ziti_tunneler_exclude_route() ipv6 address compare not implemented
[ 0.811] TRACE tunnel-sdk:ziti_tunnel.c:140 ziti_tunneler_exclude_route() ipv6 address compare not implemented
[ 0.811] DEBUG ziti-edge-tunnel:tun.c:257 tun_exclude_rt() default route is 'default via 192.168.3.1 dev wlan1 proto static src 192.168.3.4 metric 3 '
[ 0.811] DEBUG ziti-edge-tunnel:utils.c:32 run_command_va() system(ip route replace 203.160.138.65 via 192.168.3.1) returned 0
[ 0.811] INFO ziti-edge-tunnel:ziti-edge-tunnel.c:1067 on_event() ztx[TeltonikaX11.json] context event : status is OK
[ 0.811] DEBUG ziti-edge-tunnel:ziti-edge-tunnel.c:1119 on_event() ztx[TeltonikaX11.json] controller connected
[ 0.811] DEBUG ziti-edge-tunnel:ziti-edge-tunnel.c:697 send_events_message() Events Message => {"Op":"identity","Action":"added","Fingerprint":"TeltonikaX11","Id":{"Name":" TeltonikaX11","Identifier":"TeltonikaX11.json","FingerPrint":"TeltonikaX11","Active":true,"Loaded":true,"Config":{"ztAPI":"https://ziti-edge-controller:1280"},"ControllerVersion":"v0.25.5","IdFileStatus":true,"MfaEnabled":false,"MfaNeeded":false,"Metrics":{"Up":0,"Down":0},"MfaMinTimeout":0,"MfaMaxTimeout":0,"MfaMinTimeoutRem":0,"MfaMaxTimeoutRem":0,"MinTimeoutRemInSvcEvent":0,"MaxTimeoutRemInSvcEvent":0,"Deleted":false,"Notified":false}}
[ 0.811] DEBUG ziti-edge-tunnel:ziti-edge-tunnel.c:697 send_events_message() Events Message => {"Op":"controller","Action":"connected","Identifier":"TeltonikaX11.json","Fingerprint":"TeltonikaX11"}
[ 0.811] DEBUG ziti-sdk:ziti_ctrl.c:133 start_request() ctrl[ziti-edge-controller] starting GET[/current-identity]
[ 0.811] DEBUG ziti-sdk:ziti.c:1263 session_post_auth_query_cb() ztx[0] refresh_interval set to 10 seconds
[ 0.811] DEBUG ziti-sdk:ziti_ctrl.c:133 start_request() ctrl[ziti-edge-controller] starting GET[/current-api-session/service-updates]
[ 0.811] DEBUG ziti-sdk:ziti_ctrl.c:735 ctrl_paging_req() ctrl[ziti-edge-controller] starting paging request GET[/current-identity/edge-routers]
[ 0.811] VERBOSE ziti-sdk:ziti_ctrl.c:740 ctrl_paging_req() ctrl[ziti-edge-controller] requesting /current-identity/edge-routers?limit=25&offset=0
[ 0.811] DEBUG ziti-sdk:ziti_ctrl.c:133 start_request() ctrl[ziti-edge-controller] starting GET[/current-identity/edge-routers?limit=25&offset=0]
[ 0.894] DEBUG ziti-sdk:ziti_ctrl.c:160 ctrl_resp_cb() ctrl[ziti-edge-controller] received headers GET[/current-identity]
[ 0.894] DEBUG ziti-sdk:ziti_ctrl.c:308 ctrl_body_cb() ctrl[ziti-edge-controller] completed GET[/current-identity] in 40227712.000 s
[ 0.940] DEBUG ziti-sdk:ziti_ctrl.c:160 ctrl_resp_cb() ctrl[ziti-edge-controller] received headers GET[/current-identity]
[ 0.940] DEBUG ziti-sdk:ziti_ctrl.c:308 ctrl_body_cb() ctrl[ziti-edge-controller] completed GET[/current-identity] in 40227712.000 s
[ 0.986] DEBUG ziti-sdk:ziti_ctrl.c:160 ctrl_resp_cb() ctrl[ziti-edge-controller] received headers GET[/current-api-session/service-updates]
[ 0.986] DEBUG ziti-sdk:ziti_ctrl.c:308 ctrl_body_cb() ctrl[ziti-edge-controller] completed GET[/current-api-session/service-updates] in 40227712.000 s
[ 0.986] VERBOSE ziti-sdk:ziti.c:1119 check_service_update() ztx[0] ztx last_update = 2022-06-07T17:46:15.244Z
[ 0.986] DEBUG ziti-sdk:ziti_ctrl.c:735 ctrl_paging_req() ctrl[ziti-edge-controller] starting paging request GET[/services]
[ 0.986] VERBOSE ziti-sdk:ziti_ctrl.c:740 ctrl_paging_req() ctrl[ziti-edge-controller] requesting /services?limit=25&offset=0
[ 0.986] DEBUG ziti-sdk:ziti_ctrl.c:133 start_request() ctrl[ziti-edge-controller] starting GET[/services?limit=25&offset=0]
[ 1.035] DEBUG ziti-sdk:ziti_ctrl.c:160 ctrl_resp_cb() ctrl[ziti-edge-controller] received headers GET[/current-identity/edge-routers?limit=25&offset=0]
[ 1.035] DEBUG ziti-sdk:ziti_ctrl.c:308 ctrl_body_cb() ctrl[ziti-edge-controller] completed GET[/current-identity/edge-routers?limit=25&offset=0] in 40227712.000 s
[ 1.035] DEBUG ziti-sdk:ziti_ctrl.c:324 ctrl_body_cb() ctrl[ziti-edge-controller] received 1/1 for paging request GET[/current-identity/edge-routers]
[ 1.035] DEBUG ziti-sdk:ziti_ctrl.c:336 ctrl_body_cb() ctrl[ziti-edge-controller] completed paging request GET[/current-identity/edge-routers] in 0.000 s
[ 1.035] TRACE ziti-sdk:ziti.c:1194 edge_routers_cb() ztx[0] connecting to ziti-edge-router(tls://ziti-edge-router:3022)
[ 1.035] INFO ziti-sdk:channel.c:219 new_ziti_channel() ch[0] (ziti-edge-router@tls://ziti-edge-router:3022) new channel for ztx[0] identity[ TeltonikaX11]
[ 1.035] INFO tunnel-cbs:ziti_tunnel_ctrl.c:794 on_ziti_event() ztx[ TeltonikaX11] added edge router ziti-edge-router@tls://ziti-edge-router:3022@ziti-edge-router
[ 1.035] DEBUG tunnel-sdk:ziti_tunnel.c:118 ziti_tunneler_exclude_route() excluding ziti-edge-router from tunneler intercept
[ 1.035] TRACE tunnel-sdk:ziti_tunnel.c:140 ziti_tunneler_exclude_route() ipv6 address compare not implemented
[ 1.035] TRACE tunnel-sdk:ziti_tunnel.c:140 ziti_tunneler_exclude_route() ipv6 address compare not implemented
[ 1.035] TRACE tunnel-sdk:ziti_tunnel.c:140 ziti_tunneler_exclude_route() ipv6 address compare not implemented
[ 1.035] TRACE tunnel-sdk:ziti_tunnel.c:140 ziti_tunneler_exclude_route() ipv6 address compare not implemented
[ 1.035] TRACE tunnel-sdk:ziti_tunnel.c:140 ziti_tunneler_exclude_route() ipv6 address compare not implemented
[ 1.035] TRACE tunnel-sdk:ziti_tunnel.c:140 ziti_tunneler_exclude_route() ipv6 address compare not implemented
[ 1.035] TRACE tunnel-sdk:ziti_tunnel.c:140 ziti_tunneler_exclude_route() ipv6 address compare not implemented
[ 1.035] DEBUG ziti-edge-tunnel:tun.c:257 tun_exclude_rt() default route is 'default via 192.168.3.1 dev wlan1 proto static src 192.168.3.4 metric 3 '
[ 1.035] DEBUG ziti-edge-tunnel:utils.c:32 run_command_va() system(ip route replace 203.160.138.70 via 192.168.3.1) returned 0
[ 1.035] TRACE tunnel-sdk:ziti_tunnel.c:140 ziti_tunneler_exclude_route() ipv6 address compare not implemented
[ 1.035] TRACE tunnel-sdk:ziti_tunnel.c:140 ziti_tunneler_exclude_route() ipv6 address compare not implemented
[ 1.035] TRACE tunnel-sdk:ziti_tunnel.c:140 ziti_tunneler_exclude_route() ipv6 address compare not implemented
[ 1.035] TRACE tunnel-sdk:ziti_tunnel.c:140 ziti_tunneler_exclude_route() ipv6 address compare not implemented
[ 1.035] TRACE tunnel-sdk:ziti_tunnel.c:140 ziti_tunneler_exclude_route() ipv6 address compare not implemented
[ 1.035] TRACE tunnel-sdk:ziti_tunnel.c:140 ziti_tunneler_exclude_route() ipv6 address compare not implemented
[ 1.035] TRACE tunnel-sdk:ziti_tunnel.c:140 ziti_tunneler_exclude_route() ipv6 address compare not implemented
[ 1.035] DEBUG ziti-edge-tunnel:tun.c:257 tun_exclude_rt() default route is 'default via 192.168.3.1 dev wlan1 proto static src 192.168.3.4 metric 3 '
[ 1.035] DEBUG ziti-edge-tunnel:utils.c:32 run_command_va() system(ip route replace 203.160.138.70 via 192.168.3.1) returned 0
[ 1.035] INFO ziti-sdk:channel.c:733 reconnect_channel() ch[0] reconnecting NOW
[ 1.070] DEBUG ziti-sdk:channel.c:704 reconnect_cb() ch[0] connecting to ziti-edge-router:3022
[ 1.117] DEBUG ziti-sdk:ziti_ctrl.c:160 ctrl_resp_cb() ctrl[ziti-edge-controller] received headers GET[/services?limit=25&offset=0]
[ 1.117] DEBUG ziti-sdk:ziti_ctrl.c:308 ctrl_body_cb() ctrl[ziti-edge-controller] completed GET[/services?limit=25&offset=0] in 40244448.000 s
[ 1.117] DEBUG ziti-sdk:ziti_ctrl.c:324 ctrl_body_cb() ctrl[ziti-edge-controller] received 1/1 for paging request GET[/services]
[ 1.117] DEBUG ziti-sdk:ziti_ctrl.c:336 ctrl_body_cb() ctrl[ziti-edge-controller] completed paging request GET[/services] in 0.000 s
[ 1.117] VERBOSE ziti-sdk:ziti.c:971 update_services() ztx[0] scheduling service refresh 10 seconds from now
[ 1.117] VERBOSE ziti-sdk:ziti.c:992 update_services() ztx[0] processing service updates
[ 1.117] DEBUG ziti-sdk:ziti.c:1069 update_services() ztx[0] sending service event 1 added, 0 removed, 0 changed
[ 1.117] DEBUG tunnel-cbs:ziti_tunnel_ctrl.c:681 on_service() service[basic.web.test.service]
[ 1.117] DEBUG tunnel-cbs:ziti_tunnel_cbs.c:519 ziti_sdk_c_on_service() Entering here
[ 1.117] INFO tunnel-cbs:ziti_tunnel_cbs.c:411 new_ziti_intercept() creating intercept for service[basic.web.test.service] with intercept.v1 = {"addresses":["simple.web.test"],"portRanges":[{"high":80,"low":80}],"protocols":["tcp"]}
[ 1.117] DEBUG tunnel-cbs:ziti_tunnel_cbs.c:538 ziti_sdk_c_on_service() I am here
[ 1.117] INFO tunnel-cbs:ziti_tunnel_cbs.c:447 new_intercept_ctx() Entering this function
[ 1.117] INFO tunnel-cbs:ziti_tunnel_cbs.c:468 new_intercept_ctx() Entering this function at INTERCEPT_CFG_V1
[ 1.117] INFO tunnel-cbs:ziti_tunnel_cbs.c:469 new_intercept_ctx() Halla bol
[ 1.117] INFO tunnel-cbs:ziti_dns.c:349 ziti_dns_register_hostname() Entering this function simple.web.test
[ 1.117] INFO tunnel-cbs:ziti_dns.c:257 new_ipv4_entry() registered DNS entry simple.web.test -> 100.64.0.10
[ 1.117] INFO tunnel-sdk:ziti_tunnel.c:334 parse_address() Entered if dns is true & got addr->str = 100.64.0.10
[ 1.117] INFO ziti-edge-tunnel:dnsmasq_manager.c:41 apply_address() Entered this function simple.web.test: 100.64.0.10
[ 1.117] INFO ziti-edge-tunnel:dnsmasq_manager.c:58 apply_address() successfully written the file /tmp/hosts/simple.web.test
[ 1.117] DEBUG tunnel-sdk:ziti_tunnel.c:433 ziti_tunneler_intercept() intercepting address[tcp:100.64.0.10:80] service[basic.web.test.service]
[ 1.117] DEBUG tunnel-cbs:ziti_tunnel_cbs.c:549 ziti_sdk_c_on_service() 2. I am here
[ 1.117] INFO tunnel-cbs:ziti_tunnel_ctrl.c:684 on_service() starting intercepting for service[basic.web.test.service]
[ 1.117] VERBOSE ziti-edge-tunnel:ziti-edge-tunnel.c:1136 on_event() =============== ztx[TeltonikaX11.json] service event ===============
[ 1.117] TRACE ziti-edge-tunnel:instance.c:215 setTunnelPostureDataTimeout() Posture Query set returned a Dial policy: kvKcoSIGi, is_passing 1
[ 1.117] DEBUG ziti-edge-tunnel:instance.c:257 setTunnelPostureDataTimeout() service[basic.web.test.service] timeout=-1 timeoutRemaining=-1
[ 1.117] TRACE ziti-edge-tunnel:instance.c:295 setTunnelServiceAddress() intercept.v1: {"addresses":["simple.web.test"],"portRanges":[{"high":80,"low":80}],"protocols":["tcp"]}
[ 1.117] TRACE ziti-edge-tunnel:instance.c:276 to_address() Hostname: simple.web.test
[ 1.117] INFO ziti-edge-tunnel:ziti-edge-tunnel.c:1192 on_event() =============== service event (added) - basic.web.test.service:mQqOfzJSxZ ===============
[ 1.117] DEBUG ziti-edge-tunnel:ziti-edge-tunnel.c:697 send_events_message() Events Message => {"Op":"bulkservice","Action":"updated","Identifier":"TeltonikaX11.json","Fingerprint":"TeltonikaX11","AddedServices":[{"Id":"mQqOfzJSxZ","Name":"basic.web.test.service","Protocols":["tcp"],"Addresses":[{"IsHost":true,"HostName":"simple.web.test","Prefix":0}],"Ports":[{"High":80,"Low":80}],"OwnsIntercept":true,"IsAccessible":true,"Timeout":-1,"TimeoutRemaining":-1}],"RemovedServices":[]}
[ 1.117] DEBUG ziti-edge-tunnel:ziti-edge-tunnel.c:697 send_events_message() Events Message => {"Op":"identity","Action":"updated","Fingerprint":"TeltonikaX11","Id":{"Name":" TeltonikaX11","Identifier":"TeltonikaX11.json","FingerPrint":"TeltonikaX11","Active":true,"Loaded":true,"Config":{"ztAPI":"https://ziti-edge-controller:1280"},"ControllerVersion":"v0.25.5","IdFileStatus":true,"MfaEnabled":false,"MfaNeeded":false,"Services":[{"Id":"mQqOfzJSxZ","Name":"basic.web.test.service","Protocols":["tcp"],"Addresses":[{"IsHost":true,"HostName":"simple.web.test","Prefix":0}],"Ports":[{"High":80,"Low":80}],"OwnsIntercept":true,"IsAccessible":true,"Timeout":-1,"TimeoutRemaining":-1}],"Metrics":{"Up":0,"Down":0},"MfaMinTimeout":-1,"MfaMaxTimeout":-1,"MfaMinTimeoutRem":-1,"MfaMaxTimeoutRem":-1,"MinTimeoutRemInSvcEvent":-1,"MaxTimeoutRemInSvcEvent":-1,"ServiceUpdatedTime":"2022-06-07T17:47:46.435671Z","Deleted":false,"Notified":false}}
[ 1.599] DEBUG ziti-sdk:channel.c:854 on_channel_connect_internal() ch[0] connected
[ 1.599] TRACE ziti-sdk:channel.c:371 ziti_channel_send_for_reply() ch[0] => ct[0000] seq[0] len[34]
[ 1.601] TRACE ziti-sdk:channel.c:778 on_write() on_write(0x2667930,0)
[ 1.641] TRACE ziti-sdk:channel.c:841 on_channel_data() ch[0] on_data [len=114]
[ 1.641] TRACE ziti-sdk:channel.c:527 process_inbound() ch[0] <= ct[0002] seq[-1] len[0] hdrs[94]
[ 1.641] TRACE ziti-sdk:channel.c:537 process_inbound() ch[0] completing msg seq[-1] body+hrds=0+94, in_offset=0, want=94, got=94
[ 1.641] TRACE ziti-sdk:channel.c:548 process_inbound() ch[0] message is complete seq[-1] ct[0002]
[ 1.641] INFO ziti-sdk:channel.c:629 hello_reply_cb() ch[0] connected. EdgeRouter version: v0.25.5|2cd97dc79e5d|2022-05-03T02:47:46Z|linux|amd64
[ 1.641] INFO tunnel-cbs:ziti_tunnel_ctrl.c:798 on_ziti_event() ztx[ TeltonikaX11] router ziti-edge-router@tls://ziti-edge-router:3022 connected
[ 5.053] TRACE tunnel-cbs:ziti_tunnel_ctrl.c:198 process_cmd() processing command[GetMetrics] with data[{"Identifier":"TeltonikaX11.json"}]
[ 10.053] TRACE tunnel-cbs:ziti_tunnel_ctrl.c:198 process_cmd() processing command[GetMetrics] with data[{"Identifier":"TeltonikaX11.json"}]
[ 11.117] DEBUG ziti-sdk:ziti_ctrl.c:133 start_request() ctrl[ziti-edge-controller] starting GET[/current-api-session/service-updates]
[ 11.235] DEBUG ziti-sdk:ziti_ctrl.c:160 ctrl_resp_cb() ctrl[ziti-edge-controller] received headers GET[/current-api-session/service-updates]
[ 11.235] DEBUG ziti-sdk:ziti_ctrl.c:308 ctrl_body_cb() ctrl[ziti-edge-controller] completed GET[/current-api-session/service-updates] in 40244448.000 s
[ 11.235] VERBOSE ziti-sdk:ziti.c:1124 check_service_update() ztx[0] not updating: last_update is same previous (2022-06-07T17:46:15.244Z == 2022-06-07T17:46:15.244Z)
[ 14.867] INFO tunnel-sdk:tunnel_tcp.c:287 recv_tcp() Flowing from here
[ 14.867] INFO tunnel-sdk:tunnel_tcp.c:305 recv_tcp() 2.Flowing from here
[ 14.867] TRACE tunnel-sdk:tunnel_tcp.c:326 recv_tcp() received segment 100.64.0.10:42814->100.64.0.10:80
[ 14.867] INFO tunnel-cbs:ziti_tunnel_cbs.c:428 intercept_match_addr() matching 100.64.0.10
[ 14.867] INFO tunnel-cbs:ziti_tunnel_cbs.c:431 intercept_match_addr() I am coming here
[ 14.867] INFO tunnel-cbs:ziti_tunnel_cbs.c:434 intercept_match_addr() I am coming here domain (null)
[ 14.867] TRACE tunnel-sdk:intercept.c:81 lookup_intercept_by_address() Did Not Find matching address
[ 14.867] INFO tunnel-sdk:intercept.c:38 address_match() comparing intercepted ip 100.64.0.10 to 0.0.0.0
[ 14.867] TRACE tunnel-sdk:intercept.c:92 lookup_intercept_by_address() Matched address and intercept Not Found
[ 14.867] TRACE tunnel-sdk:tunnel_tcp.c:337 recv_tcp() no intercepted addresses match tcp:100.64.0.10:80
[ 15.054] TRACE tunnel-cbs:ziti_tunnel_ctrl.c:198 process_cmd() processing command[GetMetrics] with data[{"Identifier":"TeltonikaX11.json"}]
[ 15.905] INFO tunnel-sdk:tunnel_tcp.c:287 recv_tcp() Flowing from here
[ 15.905] INFO tunnel-sdk:tunnel_tcp.c:305 recv_tcp() 2.Flowing from here
[ 15.905] TRACE tunnel-sdk:tunnel_tcp.c:326 recv_tcp() received segment 100.64.0.10:42814->100.64.0.10:80
[ 15.905] INFO tunnel-cbs:ziti_tunnel_cbs.c:428 intercept_match_addr() matching 100.64.0.10
[ 15.905] INFO tunnel-cbs:ziti_tunnel_cbs.c:431 intercept_match_addr() I am coming here
[ 15.905] INFO tunnel-cbs:ziti_tunnel_cbs.c:434 intercept_match_addr() I am coming here domain (null)
[ 15.905] TRACE tunnel-sdk:intercept.c:81 lookup_intercept_by_address() Did Not Find matching address
[ 15.905] INFO tunnel-sdk:intercept.c:38 address_match() comparing intercepted ip 100.64.0.10 to 0.0.0.0
[ 15.905] TRACE tunnel-sdk:intercept.c:92 lookup_intercept_by_address() Matched address and intercept Not Found
[ 15.905] TRACE tunnel-sdk:tunnel_tcp.c:337 recv_tcp() no intercepted addresses match tcp:100.64.0.10:80
[ 17.985] INFO tunnel-sdk:tunnel_tcp.c:287 recv_tcp() Flowing from here
[ 17.985] INFO tunnel-sdk:tunnel_tcp.c:305 recv_tcp() 2.Flowing from here
[ 17.985] TRACE tunnel-sdk:tunnel_tcp.c:326 recv_tcp() received segment 100.64.0.10:42814->100.64.0.10:80
[ 17.985] INFO tunnel-cbs:ziti_tunnel_cbs.c:428 intercept_match_addr() matching 100.64.0.10
[ 17.985] INFO tunnel-cbs:ziti_tunnel_cbs.c:431 intercept_match_addr() I am coming here
[ 17.985] INFO tunnel-cbs:ziti_tunnel_cbs.c:434 intercept_match_addr() I am coming here domain (null)
[ 17.985] TRACE tunnel-sdk:intercept.c:81 lookup_intercept_by_address() Did Not Find matching address
[ 17.985] INFO tunnel-sdk:intercept.c:38 address_match() comparing intercepted ip 100.64.0.10 to 0.0.0.0
[ 17.985] TRACE tunnel-sdk:intercept.c:92 lookup_intercept_by_address() Matched address and intercept Not Found
[ 17.985] TRACE tunnel-sdk:tunnel_tcp.c:337 recv_tcp() no intercepted addresses match tcp:100.64.0.10:80
[ 20.054] TRACE tunnel-cbs:ziti_tunnel_ctrl.c:198 process_cmd() processing command[GetMetrics] with data[{"Identifier":"TeltonikaX11.json"}]
[ 20.811] VERBOSE ziti-sdk:posture.c:191 ziti_send_posture_data() ztx[0] starting to send posture data
[ 20.811] INFO ziti-sdk:posture.c:197 ziti_send_posture_data() ztx[0] first run or potential controller restart detected
[ 20.811] DEBUG ziti-sdk:posture.c:204 ziti_send_posture_data() ztx[0] posture checks must_send set to TRUE, new_session_id[TRUE], must_send_every_time[TRUE], new_controller_instance[TRUE]
[ 20.811] VERBOSE ziti-sdk:posture.c:229 ziti_send_posture_data() ztx[0] checking posture queries on 1 service(s)
[ 20.811] DEBUG ziti-sdk:posture.c:519 ziti_pr_send_bulk() ztx[0] no change in posture data, not sending
[ 21.235] DEBUG ziti-sdk:ziti_ctrl.c:133 start_request() ctrl[ziti-edge-controller] starting GET[/current-api-session/service-updates]
[ 21.358] DEBUG ziti-sdk:ziti_ctrl.c:160 ctrl_resp_cb() ctrl[ziti-edge-controller] received headers GET[/current-api-session/service-updates]
[ 21.358] DEBUG ziti-sdk:ziti_ctrl.c:308 ctrl_body_cb() ctrl[ziti-edge-controller] completed GET[/current-api-session/service-updates] in 40212544.000 s
[ 21.358] VERBOSE ziti-sdk:ziti.c:1124 check_service_update() ztx[0] not updating: last_update is same previous (2022-06-07T17:46:15.244Z == 2022-06-07T17:46:15.244Z)
[ 22.065] INFO tunnel-sdk:tunnel_tcp.c:287 recv_tcp() Flowing from here
[ 22.065] INFO tunnel-sdk:tunnel_tcp.c:305 recv_tcp() 2.Flowing from here
[ 22.065] TRACE tunnel-sdk:tunnel_tcp.c:326 recv_tcp() received segment 100.64.0.10:42814->100.64.0.10:80
[ 22.065] INFO tunnel-cbs:ziti_tunnel_cbs.c:428 intercept_match_addr() matching 100.64.0.10
[ 22.065] INFO tunnel-cbs:ziti_tunnel_cbs.c:431 intercept_match_addr() I am coming here
[ 22.065] INFO tunnel-cbs:ziti_tunnel_cbs.c:434 intercept_match_addr() I am coming here domain (null)
[ 22.065] TRACE tunnel-sdk:intercept.c:81 lookup_intercept_by_address() Did Not Find matching address
[ 22.065] INFO tunnel-sdk:intercept.c:38 address_match() comparing intercepted ip 100.64.0.10 to 0.0.0.0
[ 22.065] TRACE tunnel-sdk:intercept.c:92 lookup_intercept_by_address() Matched address and intercept Not Found
[ 22.065] TRACE tunnel-sdk:tunnel_tcp.c:337 recv_tcp() no intercepted addresses match tcp:100.64.0.10:80
[ 25.055] TRACE tunnel-cbs:ziti_tunnel_ctrl.c:198 process_cmd() processing command[GetMetrics] with data[{"Identifier":"TeltonikaX11.json"}]
[ 30.056] TRACE tunnel-cbs:ziti_tunnel_ctrl.c:198 process_cmd() processing command[GetMetrics] with data[{"Identifier":"TeltonikaX11.json"}]
[ 31.358] DEBUG ziti-sdk:ziti_ctrl.c:133 start_request() ctrl[ziti-edge-controller] starting GET[/current-api-session/service-updates]
[ 31.489] DEBUG ziti-sdk:ziti_ctrl.c:160 ctrl_resp_cb() ctrl[ziti-edge-controller] received headers GET[/current-api-session/service-updates]
[ 31.489] DEBUG ziti-sdk:ziti_ctrl.c:308 ctrl_body_cb() ctrl[ziti-edge-controller] completed GET[/current-api-session/service-updates] in 40212544.000 s
[ 31.489] VERBOSE ziti-sdk:ziti.c:1124 check_service_update() ztx[0] not updating: last_update is same previous (2022-06-07T17:46:15.244Z == 2022-06-07T17:46:15.244Z)