Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

ca_filepath validation on client side #3050

Open
sushant126 opened this issue Jan 18, 2024 · 7 comments
Open

ca_filepath validation on client side #3050

sushant126 opened this issue Jan 18, 2024 · 7 comments

Comments

@sushant126
Copy link

i have client application in which i am using secure connection (wss) with server . I have same set of certificates on server and client side . But if i give wrong path of ca file at client side still i am able to establish connection with server . Below code from openssl-client.c file which do validation of file and file path but it still allow the connection .

                        if (!SSL_CTX_load_verify_locations(
		                            vh->tls.ssl_client_ctx, ca_filepath, NULL)) {
                        #endif
		                            lwsl_err(
			                            "Unable to load SSL Client certs "
			                            "file from %s -- client ssl isn't "
			                            "going to work\n", ca_filepath);
		                            lws_tls_err_describe_clear();
	                            }
@lws-team
Copy link
Member

have same set of certificates on server and client side

I think there's maybe some confusion about how the tls cert trust works. The client just needs to trust the CA cert used to sign the intermediate or server cert. The server passes the client the server and any intermediate signed by the CA.

When you create the context (or vhost) what .options flags are you using?

@sushant126
Copy link
Author

i am using below options :
/* Start with SSL */
pCreatInfo->options = LWS_SERVER_OPTION_EXPLICIT_VHOSTS |
LWS_SERVER_OPTION_DO_SSL_GLOBAL_INIT |
LWS_SERVER_OPTION_REQUIRE_VALID_OPENSSL_CLIENT_CERT |
LWS_SERVER_OPTION_SSL_ECDH;

@lws-team
Copy link
Member

You're trying to use mutual auth on tls? Where the server also validates a cert held by the client?

What example code did you base off of?

What do the verbose lws logs say?

@sushant126
Copy link
Author

I am passing cert info while creating vhost using lws_create_vhost call .
Please find below logs :
[2024/01/19 07:00:35:2247] D: _realloc: size 7920: context
[2024/01/19 07:00:35:2248] N: lws_create_context: LWS: 4.3.99-unknown, NET CLI SRV H1 H2 WS SS-JSON-POL ConMon IPv6-absent
[2024/01/19 07:00:35:2248] I: lws_create_context: Event loop: poll
[2024/01/19 07:00:35:2249] D: _realloc: size 72: lws_smd_register
[2024/01/19 07:00:35:2251] I: lws_smd_register: peer 0x55d56650ee30 (count 1) registered
[2024/01/19 07:00:35:2251] D: _realloc: size 8192: fds table
[2024/01/19 07:00:35:2251] I: lws_create_context: ctx: 6736B (2640 ctx + pt(1 thr x 4096)), pt-fds: 1024
[2024/01/19 07:00:35:2251] I: lws_create_context: http: ah_data: 4096, ah: 992, max count 1024
[2024/01/19 07:00:35:2251] D: _realloc: size 8192: lws_lookup
[2024/01/19 07:00:35:2251] I: lws_plat_init: mem: platform fd map: 8192 B
[2024/01/19 07:00:35:2252] D: _realloc: size 1184: __lws_wsi_create_with_role
[2024/01/19 07:00:35:2253] D: : lws_role_transition: wsistate 0x200, ops pipe
[2024/01/19 07:00:35:2253] N: __lws_lc_tag: ++ [wsi|0|pipe] (1)
[2024/01/19 07:00:35:2253] D: [wsi|0|pipe]: __insert_wsi_socket_into_fds: tsi=0, sock=6, pos-in-fds=0
[2024/01/19 07:00:35:2253] I: rops_pt_init_destroy_netlink: creating netlink skt
[2024/01/19 07:00:35:2256] D: _realloc: size 1184: __lws_wsi_create_with_role
[2024/01/19 07:00:35:2256] D: : lws_role_transition: wsistate 0x200, ops netlink
[2024/01/19 07:00:35:2256] N: __lws_lc_tag: ++ [vh|0|netlink] (1)
[2024/01/19 07:00:35:2256] D: [vh|0|netlink]: __insert_wsi_socket_into_fds: tsi=0, sock=7, pos-in-fds=1
[2024/01/19 07:00:35:2256] D: rops_pt_init_destroy_netlink: starting netlink coldplug wait
[2024/01/19 07:00:35:2258] I: lws_context_init_ssl_library: Compiled with OpenSSL support
[2024/01/19 07:00:35:2258] I: lws_context_init_ssl_library: SSL disabled: no LWS_SERVER_OPTION_DO_SSL_GLOBAL_INIT
[2024/01/19 07:00:35:2258] I: lws_server_get_canonical_hostname: canonical_hostname = dev
[2024/01/19 07:00:35:2258] D: _realloc: size 904: lws_create_vhost
[2024/01/19 07:00:35:2258] N: __lws_lc_tag: ++ [vh|1|default||-1] (2)
[2024/01/19 07:00:35:2258] D: _realloc: size 336: vh plugin table
[2024/01/19 07:00:35:2258] D: _realloc: size 120: same vh list
[2024/01/19 07:00:35:2258] I: [vh|1|default||-1]: lws_create_vhost: Creating Vhost 'default' (serving disabled), 5 protocols, IPv6 off
[2024/01/19 07:00:35:2260] I: lws_context_init_extensions: LWS_MAX_EXTENSIONS_ACTIVE: 1
[2024/01/19 07:00:35:2260] I: lws_create_context: mem: per-conn: 1184 bytes + protocol rx buf
[2024/01/19 07:00:35:2260] I: lws_plat_drop_app_privileges: not changing group
[2024/01/19 07:00:35:2260] I: lws_plat_drop_app_privileges: not changing user
[2024/01/19 07:00:35:2260] D: lws_cancel_service:
[2024/01/19 07:00:35:2261] D: _realloc: size 32: ring create
[2024/01/19 07:00:35:2261] D: _realloc: size 320: ring buf
[2024/01/19 07:00:35:2261] D: _realloc: size 32: ring create
[2024/01/19 07:00:35:2261] D: _realloc: size 12000: ring buf
[2024/01/19 07:00:35:2267] D: _realloc: size 920: lws_create_vhost
[2024/01/19 07:00:35:2267] N: __lws_lc_tag: ++ [vh|2|Node_000000000002_0.txt|ens33|ens33|-1] (3)
[2024/01/19 07:00:35:2267] D: _realloc: size 392: vh plugin table
[2024/01/19 07:00:35:2267] D: _realloc: size 144: same vh list
[2024/01/19 07:00:35:2267] I: [vh|2|Node_000000000002_0.txt|ens33|ens33|-1]: lws_create_vhost: Creating Vhost 'Node_000000000002_0.txt' (serving disabled), 6 protocols, IPv6 off
[2024/01/19 07:00:35:2275] D: _lws_state_transition: system: changed 1 'CONTEXT_CREATED' -> 2 'INITIALIZED'
[2024/01/19 07:00:35:2276] I: lws_state_notify_protocol_init: waiting for netlink coldplug
[2024/01/19 07:00:35:2276] I: _report: system: prot_init: rejected 'INITIALIZED' -> 'IFACE_COLDPLUG'
[2024/01/19 07:00:35:2276] I: lws_state_transition_steps: CONTEXT_CREATED -> INITIALIZED
[2024/01/19 07:00:35:2276] I: lws_protocol_init:
[2024/01/19 07:00:35:2276] D: [vh|1|default||-1]: lws_protocol_init_vhost: not instantiating http-only
[2024/01/19 07:00:35:2276] I: [vh|1|default||-1]: lws_protocol_init_vhost: init default.http-only
[2024/01/19 07:00:35:2276] D: [vh|1|default||-1]: lws_protocol_init_vhost: not instantiating lws-secstream-h1
[2024/01/19 07:00:35:2276] I: [vh|1|default||-1]: lws_protocol_init_vhost: init default.lws-secstream-h1
[2024/01/19 07:00:35:2276] D: [vh|1|default||-1]: lws_protocol_init_vhost: not instantiating lws-secstream-h2
[2024/01/19 07:00:35:2276] I: [vh|1|default||-1]: lws_protocol_init_vhost: init default.lws-secstream-h2
[2024/01/19 07:00:35:2277] D: [vh|1|default||-1]: lws_protocol_init_vhost: not instantiating lws-secstream-ws
[2024/01/19 07:00:35:2277] I: [vh|1|default||-1]: lws_protocol_init_vhost: init default.lws-secstream-ws
[2024/01/19 07:00:35:2277] D: [vh|1|default||-1]: lws_protocol_init_vhost: not instantiating lws-secstream-raw
[2024/01/19 07:00:35:2277] I: [vh|1|default||-1]: lws_protocol_init_vhost: init default.lws-secstream-raw
[2024/01/19 07:00:35:2277] I: rops_handle_POLLIN_netlink: RTM 24
[2024/01/19 07:00:35:2277] I: rops_handle_POLLIN_netlink: NEWROUTE
[2024/01/19 07:00:35:2277] I: rops_handle_POLLIN_netlink: ifidx 2
[2024/01/19 07:00:35:2277] I: rops_handle_POLLIN_netlink: NEWROUTE rtm_type 1
[2024/01/19 07:00:35:2277] D: _realloc: size 104: rops_handle_POLLIN_netlink
[2024/01/19 07:00:35:2277] I: rops_handle_POLLIN_netlink: route list size 1
[2024/01/19 07:00:35:2278] D: _realloc: size 79: lws_smd_msg_alloc
[2024/01/19 07:00:35:2278] D: lws_cancel_service:
[2024/01/19 07:00:35:2278] I: rops_handle_POLLIN_netlink: RTM 24
[2024/01/19 07:00:35:2278] I: rops_handle_POLLIN_netlink: NEWROUTE
[2024/01/19 07:00:35:2278] I: rops_handle_POLLIN_netlink: RTA_DST: 172.17.0.0
[2024/01/19 07:00:35:2278] I: rops_handle_POLLIN_netlink: RTA_SRC: 172.17.0.1
[2024/01/19 07:00:35:2278] I: rops_handle_POLLIN_netlink: ifidx 5
[2024/01/19 07:00:35:2278] I: rops_handle_POLLIN_netlink: NEWROUTE rtm_type 1
[2024/01/19 07:00:35:2278] D: _realloc: size 104: rops_handle_POLLIN_netlink
[2024/01/19 07:00:35:2278] I: rops_handle_POLLIN_netlink: route list size 2
[2024/01/19 07:00:35:2278] D: _realloc: size 79: lws_smd_msg_alloc
[2024/01/19 07:00:35:2278] D: lws_cancel_service:
[2024/01/19 07:00:35:2278] I: rops_handle_POLLIN_netlink: RTM 24
[2024/01/19 07:00:35:2278] I: rops_handle_POLLIN_netlink: NEWROUTE
[2024/01/19 07:00:35:2278] I: rops_handle_POLLIN_netlink: RTA_DST: 192.168.251.0
[2024/01/19 07:00:35:2279] I: rops_handle_POLLIN_netlink: RTA_SRC: 192.168.251.2
[2024/01/19 07:00:35:2279] I: rops_handle_POLLIN_netlink: ifidx 4
[2024/01/19 07:00:35:2279] I: rops_handle_POLLIN_netlink: NEWROUTE rtm_type 1
[2024/01/19 07:00:35:2279] D: _realloc: size 104: rops_handle_POLLIN_netlink
[2024/01/19 07:00:35:2279] I: rops_handle_POLLIN_netlink: route list size 3
[2024/01/19 07:00:35:2279] D: _realloc: size 79: lws_smd_msg_alloc
[2024/01/19 07:00:35:2279] D: lws_cancel_service:
[2024/01/19 07:00:35:2279] I: rops_handle_POLLIN_netlink: RTM 24
[2024/01/19 07:00:35:2279] I: rops_handle_POLLIN_netlink: NEWROUTE
[2024/01/19 07:00:35:2279] I: rops_handle_POLLIN_netlink: RTA_DST: 192.168.253.0
[2024/01/19 07:00:35:2279] I: rops_handle_POLLIN_netlink: RTA_SRC: 192.168.253.110
[2024/01/19 07:00:35:2279] I: rops_handle_POLLIN_netlink: ifidx 2
[2024/01/19 07:00:35:2279] I: rops_handle_POLLIN_netlink: NEWROUTE rtm_type 1
[2024/01/19 07:00:35:2279] D: _realloc: size 104: rops_handle_POLLIN_netlink
[2024/01/19 07:00:35:2279] I: rops_handle_POLLIN_netlink: route list size 4
[2024/01/19 07:00:35:2279] D: _realloc: size 79: lws_smd_msg_alloc
[2024/01/19 07:00:35:2279] D: lws_cancel_service:
[2024/01/19 07:00:35:2280] I: rops_handle_POLLIN_netlink: RTM 24
[2024/01/19 07:00:35:2280] I: rops_handle_POLLIN_netlink: NEWROUTE
[2024/01/19 07:00:35:2280] I: rops_handle_POLLIN_netlink: RTA_DST: 127.0.0.0
[2024/01/19 07:00:35:2280] I: rops_handle_POLLIN_netlink: RTA_SRC: 127.0.0.1
[2024/01/19 07:00:35:2280] I: rops_handle_POLLIN_netlink: ifidx 1
[2024/01/19 07:00:35:2280] I: rops_handle_POLLIN_netlink: NEWROUTE rtm_type 3
[2024/01/19 07:00:35:2280] I: rops_handle_POLLIN_netlink: RTM 24
[2024/01/19 07:00:35:2280] I: rops_handle_POLLIN_netlink: NEWROUTE
[2024/01/19 07:00:35:2280] I: rops_handle_POLLIN_netlink: RTA_DST: 127.0.0.0
[2024/01/19 07:00:35:2280] I: rops_handle_POLLIN_netlink: RTA_SRC: 127.0.0.1
[2024/01/19 07:00:35:2280] I: rops_handle_POLLIN_netlink: ifidx 1
[2024/01/19 07:00:35:2280] I: rops_handle_POLLIN_netlink: NEWROUTE rtm_type 2
[2024/01/19 07:00:35:2280] D: _realloc: size 104: rops_handle_POLLIN_netlink
[2024/01/19 07:00:35:2280] I: rops_handle_POLLIN_netlink: route list size 5
[2024/01/19 07:00:35:2280] D: _realloc: size 79: lws_smd_msg_alloc
[2024/01/19 07:00:35:2280] D: lws_cancel_service:
[2024/01/19 07:00:35:2281] I: rops_handle_POLLIN_netlink: RTM 24
[2024/01/19 07:00:35:2281] I: rops_handle_POLLIN_netlink: NEWROUTE
[2024/01/19 07:00:35:2281] I: rops_handle_POLLIN_netlink: Local addr: RTA_DST -> added to RTA_SRC
[2024/01/19 07:00:35:2281] I: rops_handle_POLLIN_netlink: RTA_DST: 127.0.0.1
[2024/01/19 07:00:35:2281] I: rops_handle_POLLIN_netlink: RTA_SRC: 127.0.0.1
[2024/01/19 07:00:35:2281] I: rops_handle_POLLIN_netlink: ifidx 1
[2024/01/19 07:00:35:2281] I: rops_handle_POLLIN_netlink: NEWROUTE rtm_type 2
[2024/01/19 07:00:35:2281] D: _realloc: size 104: rops_handle_POLLIN_netlink
[2024/01/19 07:00:35:2281] I: rops_handle_POLLIN_netlink: route list size 6
[2024/01/19 07:00:35:2281] D: _realloc: size 79: lws_smd_msg_alloc
[2024/01/19 07:00:35:2281] D: lws_cancel_service:
[2024/01/19 07:00:35:2281] I: rops_handle_POLLIN_netlink: RTM 24
[2024/01/19 07:00:35:2281] I: rops_handle_POLLIN_netlink: NEWROUTE
[2024/01/19 07:00:35:2281] I: rops_handle_POLLIN_netlink: RTA_DST: 127.255.255.255
[2024/01/19 07:00:35:2281] I: rops_handle_POLLIN_netlink: RTA_SRC: 127.0.0.1
[2024/01/19 07:00:35:2281] I: rops_handle_POLLIN_netlink: ifidx 1
[2024/01/19 07:00:35:2282] I: rops_handle_POLLIN_netlink: NEWROUTE rtm_type 3
[2024/01/19 07:00:35:2282] I: rops_handle_POLLIN_netlink: RTM 24
[2024/01/19 07:00:35:2282] I: rops_handle_POLLIN_netlink: NEWROUTE
[2024/01/19 07:00:35:2282] I: rops_handle_POLLIN_netlink: RTA_DST: 172.17.0.0
[2024/01/19 07:00:35:2282] I: rops_handle_POLLIN_netlink: RTA_SRC: 172.17.0.1
[2024/01/19 07:00:35:2282] I: rops_handle_POLLIN_netlink: ifidx 5
[2024/01/19 07:00:35:2282] I: rops_handle_POLLIN_netlink: NEWROUTE rtm_type 3
[2024/01/19 07:00:35:2282] I: rops_handle_POLLIN_netlink: RTM 24
[2024/01/19 07:00:35:2282] I: rops_handle_POLLIN_netlink: NEWROUTE
[2024/01/19 07:00:35:2282] I: rops_handle_POLLIN_netlink: Local addr: RTA_DST -> added to RTA_SRC
[2024/01/19 07:00:35:2282] I: rops_handle_POLLIN_netlink: RTA_DST: 172.17.0.1
[2024/01/19 07:00:35:2282] I: rops_handle_POLLIN_netlink: RTA_SRC: 172.17.0.1
[2024/01/19 07:00:35:2282] I: rops_handle_POLLIN_netlink: ifidx 5
[2024/01/19 07:00:35:2282] I: rops_handle_POLLIN_netlink: NEWROUTE rtm_type 2
[2024/01/19 07:00:35:2282] D: _realloc: size 104: rops_handle_POLLIN_netlink
[2024/01/19 07:00:35:2282] I: rops_handle_POLLIN_netlink: route list size 7
[2024/01/19 07:00:35:2282] D: _realloc: size 79: lws_smd_msg_alloc
[2024/01/19 07:00:35:2283] D: lws_cancel_service:
[2024/01/19 07:00:35:2283] I: rops_handle_POLLIN_netlink: RTM 24
[2024/01/19 07:00:35:2283] I: rops_handle_POLLIN_netlink: NEWROUTE
[2024/01/19 07:00:35:2283] I: rops_handle_POLLIN_netlink: RTA_DST: 172.17.255.255
[2024/01/19 07:00:35:2283] I: rops_handle_POLLIN_netlink: RTA_SRC: 172.17.0.1
[2024/01/19 07:00:35:2283] I: rops_handle_POLLIN_netlink: ifidx 5
[2024/01/19 07:00:35:2283] I: rops_handle_POLLIN_netlink: NEWROUTE rtm_type 3
[2024/01/19 07:00:35:2283] I: rops_handle_POLLIN_netlink: RTM 24
[2024/01/19 07:00:35:2283] I: rops_handle_POLLIN_netlink: NEWROUTE
[2024/01/19 07:00:35:2283] I: rops_handle_POLLIN_netlink: RTA_DST: 192.168.251.0
[2024/01/19 07:00:35:2283] I: rops_handle_POLLIN_netlink: RTA_SRC: 192.168.251.2
[2024/01/19 07:00:35:2283] I: rops_handle_POLLIN_netlink: ifidx 4
[2024/01/19 07:00:35:2283] I: rops_handle_POLLIN_netlink: NEWROUTE rtm_type 3
[2024/01/19 07:00:35:2283] I: rops_handle_POLLIN_netlink: RTM 24
[2024/01/19 07:00:35:2283] I: rops_handle_POLLIN_netlink: NEWROUTE
[2024/01/19 07:00:35:2283] I: rops_handle_POLLIN_netlink: Local addr: RTA_DST -> added to RTA_SRC
[2024/01/19 07:00:35:2283] I: rops_handle_POLLIN_netlink: RTA_DST: 192.168.251.2
[2024/01/19 07:00:35:2284] I: rops_handle_POLLIN_netlink: RTA_SRC: 192.168.251.2
[2024/01/19 07:00:35:2284] I: rops_handle_POLLIN_netlink: ifidx 4
[2024/01/19 07:00:35:2285] I: rops_handle_POLLIN_netlink: NEWROUTE rtm_type 2
[2024/01/19 07:00:35:2285] D: _realloc: size 104: rops_handle_POLLIN_netlink
[2024/01/19 07:00:35:2285] I: rops_handle_POLLIN_netlink: route list size 8
[2024/01/19 07:00:35:2285] D: _realloc: size 79: lws_smd_msg_alloc
[2024/01/19 07:00:35:2285] D: lws_cancel_service:
[2024/01/19 07:00:35:2285] I: rops_handle_POLLIN_netlink: RTM 24
[2024/01/19 07:00:35:2285] I: rops_handle_POLLIN_netlink: NEWROUTE
[2024/01/19 07:00:35:2286] I: rops_handle_POLLIN_netlink: RTA_DST: 192.168.251.255
[2024/01/19 07:00:35:2286] I: rops_handle_POLLIN_netlink: RTA_SRC: 192.168.251.2
[2024/01/19 07:00:35:2286] I: rops_handle_POLLIN_netlink: ifidx 4
[2024/01/19 07:00:35:2286] I: rops_handle_POLLIN_netlink: NEWROUTE rtm_type 3
[2024/01/19 07:00:35:2286] I: rops_handle_POLLIN_netlink: RTM 24
[2024/01/19 07:00:35:2286] I: rops_handle_POLLIN_netlink: NEWROUTE
[2024/01/19 07:00:35:2286] I: rops_handle_POLLIN_netlink: RTA_DST: 192.168.253.0
[2024/01/19 07:00:35:2286] I: rops_handle_POLLIN_netlink: RTA_SRC: 192.168.253.110
[2024/01/19 07:00:35:2286] I: rops_handle_POLLIN_netlink: ifidx 2
[2024/01/19 07:00:35:2286] I: rops_handle_POLLIN_netlink: NEWROUTE rtm_type 3
[2024/01/19 07:00:35:2286] I: rops_handle_POLLIN_netlink: RTM 24
[2024/01/19 07:00:35:2286] I: rops_handle_POLLIN_netlink: NEWROUTE
[2024/01/19 07:00:35:2286] I: rops_handle_POLLIN_netlink: Local addr: RTA_DST -> added to RTA_SRC
[2024/01/19 07:00:35:2286] I: rops_handle_POLLIN_netlink: RTA_DST: 192.168.253.110
[2024/01/19 07:00:35:2287] I: rops_handle_POLLIN_netlink: RTA_SRC: 192.168.253.110
[2024/01/19 07:00:35:2287] I: rops_handle_POLLIN_netlink: ifidx 2
[2024/01/19 07:00:35:2287] I: rops_handle_POLLIN_netlink: NEWROUTE rtm_type 2
[2024/01/19 07:00:35:2287] D: _realloc: size 104: rops_handle_POLLIN_netlink
[2024/01/19 07:00:35:2287] I: rops_handle_POLLIN_netlink: route list size 9
[2024/01/19 07:00:35:2287] D: _realloc: size 79: lws_smd_msg_alloc
[2024/01/19 07:00:35:2287] D: lws_cancel_service:
[2024/01/19 07:00:35:2287] I: rops_handle_POLLIN_netlink: RTM 24
[2024/01/19 07:00:35:2287] I: rops_handle_POLLIN_netlink: NEWROUTE
[2024/01/19 07:00:35:2287] I: rops_handle_POLLIN_netlink: RTA_DST: 192.168.253.255
[2024/01/19 07:00:35:2287] I: rops_handle_POLLIN_netlink: RTA_SRC: 192.168.253.110
[2024/01/19 07:00:35:2287] I: rops_handle_POLLIN_netlink: ifidx 2
[2024/01/19 07:00:35:2287] I: rops_handle_POLLIN_netlink: NEWROUTE rtm_type 3
[2024/01/19 07:00:35:2287] D: _realloc: size 108: lws_smd_msg_alloc
[2024/01/19 07:00:35:2287] D: lws_cancel_service:
[2024/01/19 07:00:35:2287] I: _lws_routing_table_dump:
[2024/01/19 07:00:35:2288] I: _lws_routing_entry_dump: gw: 192.168.253.2, ifidx: 2, pri: -1, proto: 3
[2024/01/19 07:00:35:2288] I: _lws_routing_entry_dump: dst: 172.17.0.0/16, src: 172.17.0.1/0, ifidx: 5, pri: -1, proto: 2
[2024/01/19 07:00:35:2288] I: _lws_routing_entry_dump: dst: 192.168.251.0/24, src: 192.168.251.2/0, ifidx: 4, pri: -1, proto: 2
[2024/01/19 07:00:35:2288] I: _lws_routing_entry_dump: dst: 192.168.253.0/24, src: 192.168.253.110/0, ifidx: 2, pri: -1, proto: 2
[2024/01/19 07:00:35:2288] I: _lws_routing_entry_dump: dst: 127.0.0.0/8, src: 127.0.0.1/0, ifidx: 1, pri: -1, proto: 2
[2024/01/19 07:00:35:2288] I: _lws_routing_entry_dump: dst: 127.0.0.1/32, src: 127.0.0.1/0, ifidx: 1, pri: -1, proto: 2
[2024/01/19 07:00:35:2288] I: _lws_routing_entry_dump: dst: 172.17.0.1/32, src: 172.17.0.1/0, ifidx: 5, pri: -1, proto: 2
[2024/01/19 07:00:35:2288] I: _lws_routing_entry_dump: dst: 192.168.251.2/32, src: 192.168.251.2/0, ifidx: 4, pri: -1, proto: 2
[2024/01/19 07:00:35:2288] I: _lws_routing_entry_dump: dst: 192.168.253.110/32, src: 192.168.253.110/0, ifidx: 2, pri: -1, proto: 2
[2024/01/19 07:00:35:2288] I: _lws_smd_msg_deliver_peer: deliver cl 0x4, len 13, refc 1, to peer 0x55d56650ee30
[2024/01/19 07:00:35:2288] I: _lws_smd_msg_destroy: destroy msg 0x7f641c000bd0
[2024/01/19 07:00:35:2288] I: _lws_smd_msg_deliver_peer: deliver cl 0x4, len 13, refc 1, to peer 0x55d56650ee30
[2024/01/19 07:00:35:2288] I: _lws_smd_msg_destroy: destroy msg 0x7f641c000ca0
[2024/01/19 07:00:35:2288] I: _lws_smd_msg_deliver_peer: deliver cl 0x4, len 13, refc 1, to peer 0x55d56650ee30
[2024/01/19 07:00:35:2288] I: _lws_smd_msg_destroy: destroy msg 0x7f641c000d70
[2024/01/19 07:00:35:2289] I: _lws_smd_msg_deliver_peer: deliver cl 0x4, len 13, refc 1, to peer 0x55d56650ee30
[2024/01/19 07:00:35:2289] I: _lws_smd_msg_destroy: destroy msg 0x7f641c000e40
[2024/01/19 07:00:35:2289] I: _lws_smd_msg_deliver_peer: deliver cl 0x4, len 13, refc 1, to peer 0x55d56650ee30
[2024/01/19 07:00:35:2289] I: _lws_smd_msg_destroy: destroy msg 0x7f641c000f10
[2024/01/19 07:00:35:2289] I: _lws_smd_msg_deliver_peer: deliver cl 0x4, len 13, refc 1, to peer 0x55d56650ee30
[2024/01/19 07:00:35:2289] I: _lws_smd_msg_destroy: destroy msg 0x7f641c000fe0
[2024/01/19 07:00:35:2289] I: _lws_smd_msg_deliver_peer: deliver cl 0x4, len 13, refc 1, to peer 0x55d56650ee30
[2024/01/19 07:00:35:2289] I: _lws_smd_msg_destroy: destroy msg 0x7f641c0010b0
[2024/01/19 07:00:35:2289] I: _lws_smd_msg_deliver_peer: deliver cl 0x4, len 13, refc 1, to peer 0x55d56650ee30
[2024/01/19 07:00:35:2289] I: _lws_smd_msg_destroy: destroy msg 0x7f641c001180
[2024/01/19 07:00:35:2289] I: _lws_smd_msg_deliver_peer: deliver cl 0x4, len 13, refc 1, to peer 0x55d56650ee30
[2024/01/19 07:00:35:2289] I: _lws_smd_msg_destroy: destroy msg 0x7f641c001250
[2024/01/19 07:00:35:2289] I: _lws_smd_msg_deliver_peer: deliver cl 0x4, len 42, refc 1, to peer 0x55d56650ee30
[2024/01/19 07:00:35:2289] I: lws_ss_create: unknown stream type captive_portal_detect
[2024/01/19 07:00:35:2289] I: lws_ss_sys_cpd: Create stream failed (policy?)
[2024/01/19 07:00:35:2289] I: _lws_smd_msg_destroy: destroy msg 0x7f641c0012b0
[2024/01/19 07:00:35:2290] I: rops_handle_POLLIN_netlink: RTM 24
[2024/01/19 07:00:35:2290] I: rops_handle_POLLIN_netlink: NEWROUTE
[2024/01/19 07:00:35:2290] I: rops_handle_POLLIN_netlink: RTA_DST: (ipv6 unsupp)
[2024/01/19 07:00:35:2290] I: rops_handle_POLLIN_netlink: ifidx 1
[2024/01/19 07:00:35:2290] I: rops_handle_POLLIN_netlink: NEWROUTE rtm_type 1
[2024/01/19 07:00:35:2290] D: _realloc: size 104: rops_handle_POLLIN_netlink
[2024/01/19 07:00:35:2293] I: rops_handle_POLLIN_netlink: route list size 10
[2024/01/19 07:00:35:2293] D: _realloc: size 79: lws_smd_msg_alloc
[2024/01/19 07:00:35:2293] D: lws_cancel_service:
[2024/01/19 07:00:35:2293] I: rops_handle_POLLIN_netlink: RTM 24
[2024/01/19 07:00:35:2293] I: rops_handle_POLLIN_netlink: NEWROUTE
[2024/01/19 07:00:35:2293] I: rops_handle_POLLIN_netlink: RTA_DST: (ipv6 unsupp)
[2024/01/19 07:00:35:2293] I: rops_handle_POLLIN_netlink: ifidx 4
[2024/01/19 07:00:35:2293] I: rops_handle_POLLIN_netlink: NEWROUTE rtm_type 1
[2024/01/19 07:00:35:2293] D: _realloc: size 104: rops_handle_POLLIN_netlink
[2024/01/19 07:00:35:2293] I: rops_handle_POLLIN_netlink: route list size 11
[2024/01/19 07:00:35:2293] D: _realloc: size 79: lws_smd_msg_alloc
[2024/01/19 07:00:35:2293] D: lws_cancel_service:
[2024/01/19 07:00:35:2294] I: rops_handle_POLLIN_netlink: RTM 24
[2024/01/19 07:00:35:2294] I: rops_handle_POLLIN_netlink: NEWROUTE
[2024/01/19 07:00:35:2294] I: rops_handle_POLLIN_netlink: RTA_DST: (ipv6 unsupp)
[2024/01/19 07:00:35:2294] I: rops_handle_POLLIN_netlink: ifidx 2
[2024/01/19 07:00:35:2294] I: rops_handle_POLLIN_netlink: NEWROUTE rtm_type 1
[2024/01/19 07:00:35:2294] D: _realloc: size 104: rops_handle_POLLIN_netlink
[2024/01/19 07:00:35:2294] I: rops_handle_POLLIN_netlink: route list size 12
[2024/01/19 07:00:35:2294] D: _realloc: size 79: lws_smd_msg_alloc
[2024/01/19 07:00:35:2294] D: lws_cancel_service:
[2024/01/19 07:00:35:2294] I: rops_handle_POLLIN_netlink: RTM 24
[2024/01/19 07:00:35:2294] I: rops_handle_POLLIN_netlink: NEWROUTE
[2024/01/19 07:00:35:2294] I: rops_handle_POLLIN_netlink: Local addr: RTA_DST -> added to RTA_SRC
[2024/01/19 07:00:35:2294] I: rops_handle_POLLIN_netlink: RTA_DST: (ipv6 unsupp)
[2024/01/19 07:00:35:2295] I: rops_handle_POLLIN_netlink: ifidx 1
[2024/01/19 07:00:35:2295] I: rops_handle_POLLIN_netlink: NEWROUTE rtm_type 2
[2024/01/19 07:00:35:2295] D: _realloc: size 104: rops_handle_POLLIN_netlink
[2024/01/19 07:00:35:2295] I: rops_handle_POLLIN_netlink: route list size 13
[2024/01/19 07:00:35:2295] D: _realloc: size 79: lws_smd_msg_alloc
[2024/01/19 07:00:35:2295] D: lws_cancel_service:
[2024/01/19 07:00:35:2295] I: rops_handle_POLLIN_netlink: RTM 24
[2024/01/19 07:00:35:2295] I: rops_handle_POLLIN_netlink: NEWROUTE
[2024/01/19 07:00:35:2296] I: rops_handle_POLLIN_netlink: Local addr: RTA_DST -> added to RTA_SRC
[2024/01/19 07:00:35:2296] I: rops_handle_POLLIN_netlink: RTA_DST: (ipv6 unsupp)
[2024/01/19 07:00:35:2296] I: rops_handle_POLLIN_netlink: ifidx 2
[2024/01/19 07:00:35:2296] I: rops_handle_POLLIN_netlink: NEWROUTE rtm_type 2
[2024/01/19 07:00:35:2296] D: _realloc: size 104: rops_handle_POLLIN_netlink
[2024/01/19 07:00:35:2296] I: rops_handle_POLLIN_netlink: route list size 14
[2024/01/19 07:00:35:2296] D: _realloc: size 79: lws_smd_msg_alloc
[2024/01/19 07:00:35:2296] D: lws_cancel_service:
[2024/01/19 07:00:35:2296] I: rops_handle_POLLIN_netlink: RTM 24
[2024/01/19 07:00:35:2296] I: rops_handle_POLLIN_netlink: NEWROUTE
[2024/01/19 07:00:35:2296] I: rops_handle_POLLIN_netlink: RTA_DST: (ipv6 unsupp)
[2024/01/19 07:00:35:2296] I: rops_handle_POLLIN_netlink: ifidx 2
[2024/01/19 07:00:35:2296] I: rops_handle_POLLIN_netlink: NEWROUTE rtm_type 5
[2024/01/19 07:00:35:2296] I: rops_handle_POLLIN_netlink: RTM 24
[2024/01/19 07:00:35:2297] I: rops_handle_POLLIN_netlink: NEWROUTE
[2024/01/19 07:00:35:2297] I: rops_handle_POLLIN_netlink: RTA_DST: (ipv6 unsupp)
[2024/01/19 07:00:35:2297] I: rops_handle_POLLIN_netlink: ifidx 4
[2024/01/19 07:00:35:2297] I: rops_handle_POLLIN_netlink: NEWROUTE rtm_type 5
[2024/01/19 07:00:35:2297] I: _lws_routing_table_dump:
[2024/01/19 07:00:35:2297] I: _lws_routing_entry_dump: gw: 192.168.253.2, ifidx: 2, pri: -1, proto: 3
[2024/01/19 07:00:35:2297] I: _lws_routing_entry_dump: dst: 172.17.0.0/16, src: 172.17.0.1/0, ifidx: 5, pri: -1, proto: 2
[2024/01/19 07:00:35:2297] I: _lws_routing_entry_dump: dst: 192.168.251.0/24, src: 192.168.251.2/0, ifidx: 4, pri: -1, proto: 2
[2024/01/19 07:00:35:2297] I: _lws_routing_entry_dump: dst: 192.168.253.0/24, src: 192.168.253.110/0, ifidx: 2, pri: -1, proto: 2
[2024/01/19 07:00:35:2297] I: _lws_routing_entry_dump: dst: 127.0.0.0/8, src: 127.0.0.1/0, ifidx: 1, pri: -1, proto: 2
[2024/01/19 07:00:35:2297] I: _lws_routing_entry_dump: dst: 127.0.0.1/32, src: 127.0.0.1/0, ifidx: 1, pri: -1, proto: 2
[2024/01/19 07:00:35:2297] I: _lws_routing_entry_dump: dst: 172.17.0.1/32, src: 172.17.0.1/0, ifidx: 5, pri: -1, proto: 2
[2024/01/19 07:00:35:2297] I: _lws_routing_entry_dump: dst: 192.168.251.2/32, src: 192.168.251.2/0, ifidx: 4, pri: -1, proto: 2
[2024/01/19 07:00:35:2297] I: _lws_routing_entry_dump: dst: 192.168.253.110/32, src: 192.168.253.110/0, ifidx: 2, pri: -1, proto: 2
[2024/01/19 07:00:35:2297] I: _lws_routing_entry_dump: dst: (ipv6 unsupp)/128, ifidx: 1, pri: 256, proto: 2
[2024/01/19 07:00:35:2298] I: _lws_routing_entry_dump: dst: (ipv6 unsupp)/64, ifidx: 4, pri: 256, proto: 2
[2024/01/19 07:00:35:2298] I: _lws_routing_entry_dump: dst: (ipv6 unsupp)/64, ifidx: 2, pri: 256, proto: 2
[2024/01/19 07:00:35:2298] I: _lws_routing_entry_dump: dst: (ipv6 unsupp)/128, src: (ipv6 unsupp)/0, ifidx: 1, pri: 0, proto: 2
[2024/01/19 07:00:35:2298] I: _lws_routing_entry_dump: dst: (ipv6 unsupp)/128, src: (ipv6 unsupp)/0, ifidx: 2, pri: 0, proto: 2
[2024/01/19 07:00:35:2304] D: _realloc: size 72: client ctx tcr
[2024/01/19 07:00:35:2304] I: lws_tls_client_create_vhost_context: vh Node_000000000002_0.txt: created new client ctx 0
[2024/01/19 07:00:35:2305] E: Unable to load SSL Client certs file from /home/projects/BTL_Test_CA1.pem -- client ssl isn't going to work
[2024/01/19 07:00:35:2305] I: openssl error: error:02001002:system library:fopen:No such file or directory
[2024/01/19 07:00:35:2305] I: openssl error: error:2006D080:BIO routines:BIO_new_file:no such file
[2024/01/19 07:00:35:2305] I: openssl error: error:0B084002:x509 certificate routines:X509_load_cert_crl_file:system lib
[2024/01/19 07:00:35:2305] I:
[2024/01/19 07:00:35:2305] N: lws_tls_client_create_vhost_context: doing cert filepath /home/projects/BRT/TestBRT.pem
[2024/01/19 07:00:35:2309] I: Loaded client cert /home/projects/BRT/TestBRT.pem
[2024/01/19 07:00:35:2309] I: lws_tls_client_create_vhost_context: using private key filepath
[2024/01/19 07:00:35:2310] I: Loaded client cert private key /home/projects/BRT/test-brt.key
[2024/01/19 07:00:35:2310] I: created client ssl context for Node_000000000002_0.txt
[2024/01/19 07:00:35:2310] I: lws_protocol_init:
[2024/01/19 07:00:35:2310] D: [vh|2|Node_000000000002_0.txt|ens33|ens33|-1]: lws_protocol_init_vhost: not instantiating hub.bsc.bacnet.org
[2024/01/19 07:00:35:2310] I: [vh|2|Node_000000000002_0.txt|ens33|ens33|-1]: lws_protocol_init_vhost: init Node_000000000002_0.txt.hub.bsc.bacnet.org
[2024/01/19 07:00:35:2310] D: [vh|2|Node_000000000002_0.txt|ens33|ens33|-1]: lws_protocol_init_vhost: not instantiating dc.bsc.bacnet.org
[2024/01/19 07:00:35:2310] I: [vh|2|Node_000000000002_0.txt|ens33|ens33|-1]: lws_protocol_init_vhost: init Node_000000000002_0.txt.dc.bsc.bacnet.org
[2024/01/19 07:00:35:2310] D: [vh|2|Node_000000000002_0.txt|ens33|ens33|-1]: lws_protocol_init_vhost: not instantiating lws-secstream-h1
[2024/01/19 07:00:35:2312] I: [vh|2|Node_000000000002_0.txt|ens33|ens33|-1]: lws_protocol_init_vhost: init Node_000000000002_0.txt.lws-secstream-h1
[2024/01/19 07:00:35:2312] D: [vh|2|Node_000000000002_0.txt|ens33|ens33|-1]: lws_protocol_init_vhost: not instantiating lws-secstream-h2
[2024/01/19 07:00:35:2312] I: [vh|2|Node_000000000002_0.txt|ens33|ens33|-1]: lws_protocol_init_vhost: init Node_000000000002_0.txt.lws-secstream-h2
[2024/01/19 07:00:35:2312] D: [vh|2|Node_000000000002_0.txt|ens33|ens33|-1]: lws_protocol_init_vhost: not instantiating lws-secstream-ws
[2024/01/19 07:00:35:2312] I: [vh|2|Node_000000000002_0.txt|ens33|ens33|-1]: lws_protocol_init_vhost: init Node_000000000002_0.txt.lws-secstream-ws
[2024/01/19 07:00:35:2312] D: [vh|2|Node_000000000002_0.txt|ens33|ens33|-1]: lws_protocol_init_vhost: not instantiating lws-secstream-raw
[2024/01/19 07:00:35:2312] I: [vh|2|Node_000000000002_0.txt|ens33|ens33|-1]: lws_protocol_init_vhost: init Node_000000000002_0.txt.lws-secstream-raw
[2024/01/19 07:00:35:2312] D: lws_cancel_service:
[2024/01/19 07:00:35:2313] I: _lws_smd_msg_deliver_peer: deliver cl 0x4, len 13, refc 1, to peer 0x55d56650ee30
[2024/01/19 07:00:35:2313] I: _lws_smd_msg_destroy: destroy msg 0x7f641c0010b0
[2024/01/19 07:00:35:2314] I: _lws_smd_msg_deliver_peer: deliver cl 0x4, len 13, refc 1, to peer 0x55d56650ee30
[2024/01/19 07:00:35:2314] I: _lws_smd_msg_destroy: destroy msg 0x7f641c000fe0
[2024/01/19 07:00:35:2314] I: _lws_smd_msg_deliver_peer: deliver cl 0x4, len 13, refc 1, to peer 0x55d56650ee30
[2024/01/19 07:00:35:2314] I: _lws_smd_msg_destroy: destroy msg 0x7f641c000f10
[2024/01/19 07:00:35:2314] I: _lws_smd_msg_deliver_peer: deliver cl 0x4, len 13, refc 1, to peer 0x55d56650ee30
[2024/01/19 07:00:35:2314] I: _lws_smd_msg_destroy: destroy msg 0x7f641c000e40
[2024/01/19 07:00:35:2314] I: _lws_smd_msg_deliver_peer: deliver cl 0x4, len 13, refc 1, to peer 0x55d56650ee30
[2024/01/19 07:00:35:2314] I: _lws_smd_msg_destroy: destroy msg 0x7f641c000d70
[2024/01/19 07:00:35:2314] D: lws_cancel_service:
[2024/01/19 07:00:35:2314] I: rops_handle_POLLIN_netlink: RTM 3
[2024/01/19 07:00:35:2314] I: rops_handle_POLLIN_netlink: *** Unknown RTM_3
[2024/01/19 07:00:35:3314] D: _lws_state_transition: system: changed 2 'INITIALIZED' -> 3 'IFACE_COLDPLUG'
[2024/01/19 07:00:35:3315] D: _lws_state_transition: system: changed 3 'IFACE_COLDPLUG' -> 4 'DHCP'
[2024/01/19 07:00:35:3315] D: _lws_state_transition: system: changed 4 'DHCP' -> 5 'CPD_PRE_TIME'
[2024/01/19 07:00:35:3315] D: _lws_state_transition: system: changed 5 'CPD_PRE_TIME' -> 6 'TIME_VALID'
[2024/01/19 07:00:35:3315] D: _lws_state_transition: system: changed 6 'TIME_VALID' -> 7 'CPD_POST_TIME'
[2024/01/19 07:00:35:3315] D: _lws_state_transition: system: changed 7 'CPD_POST_TIME' -> 8 'POLICY_VALID'
[2024/01/19 07:00:35:3315] D: _lws_state_transition: system: changed 8 'POLICY_VALID' -> 9 'REGISTERED'
[2024/01/19 07:00:35:3315] D: _lws_state_transition: system: changed 9 'REGISTERED' -> 10 'AUTH1'
[2024/01/19 07:00:35:3315] D: _lws_state_transition: system: changed 10 'AUTH1' -> 11 'AUTH2'
[2024/01/19 07:00:35:3315] D: _lws_state_transition: system: changed 11 'AUTH2' -> 12 'ONE_TIME_UPDATES'
[2024/01/19 07:00:35:3315] D: _lws_state_transition: system: changed 12 'ONE_TIME_UPDATES' -> 13 'OPERATIONAL'
[2024/01/19 07:00:35:3315] I: lws_state_transition_steps: INITIALIZED -> OPERATIONAL
[2024/01/19 07:00:36:2316] D: lws_cancel_service:
[2024/01/19 07:00:36:2316] D: lws_cancel_service:
[2024/01/19 07:00:36:2326] D: lws_cancel_service:
[2024/01/19 07:00:36:7316] D: lws_cancel_service:
[2024/01/19 07:00:36:7317] D: lws_cancel_service:
[2024/01/19 07:00:36:7327] D: lws_cancel_service:
[2024/01/19 07:00:36:7819] D: _realloc: size 1184: __lws_wsi_create_with_role
[2024/01/19 07:00:36:7819] D: : lws_role_transition: wsistate 0x200, ops (unset)
[2024/01/19 07:00:36:7820] D: : lws_vhost_bind_wsi: vh Node_000000000002_0.txt: wsi none/none, count_bound_wsi 1
[2024/01/19 07:00:36:7820] D: _realloc: size 368: client ws struct
[2024/01/19 07:00:36:7820] D: : lws_role_transition: wsistate 0x10000200, ops h1
[2024/01/19 07:00:36:7820] I: : lws_client_connect_via_info: role binding to h1
[2024/01/19 07:00:36:7820] I: : lws_client_connect_via_info: vh Node_000000000002_0.txt protocol binding to hub.bsc.bacnet.org
[2024/01/19 07:00:36:7820] D: : lws_ensure_user_space: protocol pss 56, user_space=0x7f641c001568
[2024/01/19 07:00:36:7820] I: : lws_client_connect_via_info: : h1 hub.bsc.bacnet.org entry
[2024/01/19 07:00:36:7820] D: _realloc: size 153: client stash
[2024/01/19 07:00:36:7820] N: __lws_lc_tag: ++ [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100] (1)
[2024/01/19 07:00:36:7820] I: lws_header_table_attach: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: ah (nil) (tsi 0, count = 0) in
[2024/01/19 07:00:36:7820] D: _realloc: size 992: ah struct
[2024/01/19 07:00:36:7820] D: _realloc: size 4096: ah data
[2024/01/19 07:00:36:7820] I: _lws_create_ah: created ah 0x7f641c001d00 (size 4096): pool length 1
[2024/01/19 07:00:36:7821] I: lws_header_table_attach: did attach wsi [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: ah 0x7f641c001d00: count 1 (on exit)
[2024/01/19 07:00:36:7821] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: __lws_set_timeout: 10 secs, reason 25
[2024/01/19 07:00:36:7821] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lws_http_client_connect_via_info2: stash 0x7f641c001c50
[2024/01/19 07:00:36:7821] D: _realloc: size 16: strdup
[2024/01/19 07:00:36:7821] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lws_client_connect_2_dnsreq: new conn on no pipeline flag
[2024/01/19 07:00:36:7821] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lwsi_set_state: lwsi_set_state 0x10000200 -> 0x10000201
[2024/01/19 07:00:36:7821] I: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lws_client_connect_2_dnsreq: lookup 192.168.253.100:8443
[2024/01/19 07:00:36:7821] I: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lws_getaddrinfo46: getaddrinfo '192.168.253.100' says 0
[2024/01/19 07:00:36:7821] I: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lws_sort_dns: sort_dns: 0x7f641c001250
[2024/01/19 07:00:36:7822] D: _realloc: size 104: lws_sort_dns
[2024/01/19 07:00:36:7822] I: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lws_sort_dns: unsorted entry (af 2) 192.168.253.100
[2024/01/19 07:00:36:7822] D: _lws_route_est_outgoing: dest af 2, rou gw af 2, pri -1
[2024/01/19 07:00:36:7822] I: _lws_route_est_outgoing: gw hit
[2024/01/19 07:00:36:7822] D: _lws_route_est_outgoing: dest af 2, rou gw af 0, pri -1
[2024/01/19 07:00:36:7822] D: _lws_route_est_outgoing: dest af 2, rou gw af 0, pri -1
[2024/01/19 07:00:36:7822] I: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lws_sort_dns_dump: 1: (2)192.168.253.100, gw (0)(unset), idi: 2, lbl: 0, prec: 0
[2024/01/19 07:00:36:7822] I: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lws_client_connect_3_connect: peer_route_uidx 4
[2024/01/19 07:00:36:7823] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lws_client_connect_3_connect: WAITING_CONNECT
[2024/01/19 07:00:36:7823] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lwsi_set_state: lwsi_set_state 0x10000201 -> 0x10000202
[2024/01/19 07:00:36:7823] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: __insert_wsi_socket_into_fds: tsi=0, sock=8, pos-in-fds=2
[2024/01/19 07:00:36:7823] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: _lws_change_pollfd: fd 8 events 1 -> 1
[2024/01/19 07:00:36:7823] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: __lws_set_timeout: 20 secs, reason 2
[2024/01/19 07:00:36:7823] N: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lws_client_connect_3_connect: trying 192.168.253.100
[2024/01/19 07:00:36:7826] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lws_client_connect_3_connect: connect: fd 8, EINPROGRESS
[2024/01/19 07:00:36:7826] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: _lws_change_pollfd: fd 8 events 1 -> 5
[2024/01/19 07:00:36:7826] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lws_client_connect_via_info: adoption cb 19 to h1 hub.bsc.bacnet.org
[2024/01/19 07:00:36:7844] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: _lws_change_pollfd: fd 8 events 5 -> 1
[2024/01/19 07:00:36:7844] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lws_client_connect_check: getsockopt: conn OK errno EINPROGRESS
[2024/01/19 07:00:36:7845] I: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lws_client_connect_3_connect: source ads 192.168.253.110
[2024/01/19 07:00:36:7845] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lws_client_connect_3_connect: going into connect_4
[2024/01/19 07:00:36:7845] I: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lws_client_connect_4_established: h1 hub.bsc.bacnet.org client created own conn (raw 0) vh Node_000000000002_0.txt st 0x202
[2024/01/19 07:00:36:7845] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lwsi_set_state: lwsi_set_state 0x10000202 -> 0x10000012
[2024/01/19 07:00:36:7845] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: __lws_set_timeout: 15 secs, reason 8
[2024/01/19 07:00:36:7845] D: lws_http_client_socket_service: LRS_H1C_ISSUE_HANDSHAKE
[2024/01/19 07:00:36:7845] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: _lws_change_pollfd: fd 8 events 1 -> 1
[2024/01/19 07:00:36:7845] I: lws_tls_restrict_borrow: 0 -> 1
[2024/01/19 07:00:36:7846] I: lws_tls_reuse_session: no existing session for Node_000000000002_0.txt_192.168.253.100_8443
[2024/01/19 07:00:36:7846] I: h1 client conn using alpn list 'http/1.1'
[2024/01/19 07:00:36:7850] D: lws_ssl_get_error: 0x7f641c003170 -1 -> 2 (errno 11)
[2024/01/19 07:00:36:7850] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lwsi_set_state: lwsi_set_state 0x10000012 -> 0x10000204
[2024/01/19 07:00:36:7850] D: lws_client_create_tls: lws_ssl_client_connect1: 0
[2024/01/19 07:00:36:7876] N: accepting self-signed certificate (verify_callback)
[2024/01/19 07:00:36:7897] D: lws_ssl_get_error: 0x7f641c003170 1 -> 0 (errno 0)
[2024/01/19 07:00:36:7897] I: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lws_role_call_alpn_negotiated: 'http/1.1'
[2024/01/19 07:00:36:7897] D: rops_alpn_negotiated_h1: client 1
[2024/01/19 07:00:36:7897] I: client connect OK
[2024/01/19 07:00:36:7898] I: lws_openssl_describe_cipher: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: TLS_AES_256_GCM_SHA384, TLS_AES_256_GCM_SHA384, 256 bits, TLSv1.3
[2024/01/19 07:00:36:7898] D: lws_ssl_client_connect2: SSL_connect says 0
[2024/01/19 07:00:36:7898] I: lws_tls_restrict_return_handshake: 1 -> 0
[2024/01/19 07:00:36:7898] I: lws_http_client_socket_service: HANDSHAKE2: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: sending headers (wsistate 0x10000204), w sock 8
[2024/01/19 07:00:36:7899] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lwsi_set_state: lwsi_set_state 0x10000204 -> 0x1000020b
[2024/01/19 07:00:36:7900] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: __lws_set_timeout: 15 secs, reason 4
[2024/01/19 07:00:36:7900] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: _lws_change_pollfd: fd 8 events 1 -> 5
[2024/01/19 07:00:36:7900] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lwsi_set_state: lwsi_set_state 0x1000020b -> 0x1000020b
[2024/01/19 07:00:36:7900] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: __lws_set_timeout: 15 secs, reason 4
[2024/01/19 07:00:36:7900] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: _lws_change_pollfd: fd 8 events 5 -> 1
[2024/01/19 07:00:36:7900] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: _lws_change_pollfd: fd 8 events 1 -> 1
[2024/01/19 07:00:36:7924] D: _realloc: size 125: lws_tls_session_add_entry
[2024/01/19 07:00:36:7924] I: lws_tls_session_new_cb: 0x7f641c00a590: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: new Node_000000000002_0.txt_192.168.253.100_8443, ttl 7200s (Node_000000000002_0.txt:1)
[2024/01/19 07:00:36:7925] I: lws_tls_session_new_cb: 0x7f641c014e80: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: reuse Node_000000000002_0.txt_192.168.253.100_8443, ttl 7200s (Node_000000000002_0.txt:1)
[2024/01/19 07:00:36:7925] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: SSL_read says 247
[2024/01/19 07:00:36:7925] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lws_buflist_aware_read: lws_http_client_socket_service: ssl_capable_read 247
[2024/01/19 07:00:36:7925] D: lws_http_client_socket_service: buflist-aware-read 0 247
[2024/01/19 07:00:36:7925] D: lws_client_interpret_server_handshake: no content length
[2024/01/19 07:00:36:7925] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lws_client_ws_upgrade: Selected protocol hub.bsc.bacnet.org
[2024/01/19 07:00:36:7925] N: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lws_client_ws_upgrade: checking client ext permessage-deflate
[2024/01/19 07:00:36:7925] N: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lws_client_ws_upgrade: instantiating client ext permessage-deflate
[2024/01/19 07:00:36:7925] D: _realloc: size 288: pmd priv
[2024/01/19 07:00:36:7926] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lws_ensure_user_space: protocol pss 56, user_space=0x7f641c001568
[2024/01/19 07:00:36:7926] I: __lws_header_table_detach: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: ah 0x7f641c001d00 (tsi=0, count = 1)
[2024/01/19 07:00:36:7926] I: __lws_header_table_detach: nobody usable waiting
[2024/01/19 07:00:36:7926] I: _lws_destroy_ah: freed ah 0x7f641c001d00 : pool length 0
[2024/01/19 07:00:36:7926] I: __lws_header_table_detach: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: ah 0x7f641c001d00 (tsi=0, count = 0)
[2024/01/19 07:00:36:7926] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lws_role_transition: wsistate 0x10000119, ops ws
[2024/01/19 07:00:36:7926] I: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: _lws_validity_confirmed_role: setting validity timer 300s (hup 0)
[2024/01/19 07:00:36:7926] D: _realloc: size 5725: client frame buffer
[2024/01/19 07:00:36:7926] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lws_client_ws_upgrade: handshake OK for protocol hub.bsc.bacnet.org
[2024/01/19 07:00:36:7926] D: _realloc: size 32: ring create
[2024/01/19 07:00:36:7926] D: _realloc: size 480: ring buf
[2024/01/19 07:00:36:7927] D: lws_cancel_service:
[2024/01/19 07:00:36:7934] D: lws_cancel_service:
[2024/01/19 07:00:36:7935] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: _lws_change_pollfd: fd 8 events 1 -> 5
[2024/01/19 07:00:36:7935] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: _lws_change_pollfd: fd 8 events 5 -> 5
[2024/01/19 07:00:36:7935] D: rops_handle_POLLOUT_ws: hub.bsc.bacnet.org: wsi->ws->tx_draining_ext 0
[2024/01/19 07:00:36:7935] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: _lws_change_pollfd: fd 8 events 5 -> 1
[2024/01/19 07:00:36:7935] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lws_handle_POLLOUT_event: non mux: wsistate 0x10000119, ops ws
[2024/01/19 07:00:36:7936] D: _realloc: size 1052: pmd tx deflate buf
[2024/01/19 07:00:36:7936] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lws_extension_callback_pm_deflate: PMD_CLIENT_NO_CONTEXT_TAKEOVER
[2024/01/19 07:00:36:7938] I: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lws_issue_raw: ssl_capable_write (33) says 33
[2024/01/19 07:00:36:7953] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: SSL_read says 29
[2024/01/19 07:00:36:7953] D: lws_read_h1: h1 path: wsi state 0x119
[2024/01/19 07:00:36:7953] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lws_ws_handshake_client: hs client feels it has 29 in
[2024/01/19 07:00:36:7953] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lws_ws_client_rx_sm: spilling as we have the whole frame
[2024/01/19 07:00:36:7955] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lws_ws_client_rx_sm: starting disbursal of 27 deframed rx
[2024/01/19 07:00:36:7955] D: _realloc: size 1052: pmd rx inflate buf
[2024/01/19 07:00:36:7955] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lws_extension_callback_pm_deflate: 0 1 0 0 1
[2024/01/19 07:00:36:7955] D: lws_is_final_fragment: final 1, rx pk length 0, draining 0
[2024/01/19 07:00:36:7955] D: lws_cancel_service:
[2024/01/19 07:00:36:7956] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lws_ws_client_rx_sm: bulk ws rx: inp used 27, output 30
[2024/01/19 07:00:36:7964] D: lws_cancel_service:
[2024/01/19 07:00:36:7967] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: _lws_change_pollfd: fd 8 events 1 -> 5
[2024/01/19 07:00:36:7970] D: rops_handle_POLLOUT_ws: hub.bsc.bacnet.org: wsi->ws->tx_draining_ext 0
[2024/01/19 07:00:36:7970] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: _lws_change_pollfd: fd 8 events 5 -> 1
[2024/01/19 07:00:36:7972] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lws_handle_POLLOUT_event: non mux: wsistate 0x10000119, ops ws
[2024/01/19 07:00:36:7973] D: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lws_extension_callback_pm_deflate: PMD_CLIENT_NO_CONTEXT_TAKEOVER
[2024/01/19 07:00:36:7975] I: [wsicli|0|WS/h1/Node_000000000002_0.txt/192.168.253.100]: lws_issue_raw: ssl_capable_write (19) says 19

@lws-team
Copy link
Member 

[2024/01/19 07:00:35:2258] I: lws_context_init_ssl_library: SSL disabled: no LWS_SERVER_OPTION_DO_SSL_GLOBAL_INIT

This is not what you were expecting, right?

@sushant126
Copy link
Author

yes i have already set this option in info :
pCreatInfo->options = LWS_SERVER_OPTION_EXPLICIT_VHOSTS |
LWS_SERVER_OPTION_DO_SSL_GLOBAL_INIT |
LWS_SERVER_OPTION_REQUIRE_VALID_OPENSSL_CLIENT_CERT |
LWS_SERVER_OPTION_SSL_ECDH;

@lws-team
Copy link
Member

The logs are telling you what you have actually done from lws perspective, not what you think you have done from the perspective of your code. It feels the .options it's actually using does not have that flag set. So you might want to look into why there is a difference of opinion with what's actually happening, not reiterate what you think should be happening.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
None yet
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
2 participants
@lws-team @sushant126