- app@deb92:~/blade/vm/mod_signalwire$ ./testcli 127.0.0.1:2100 a.json
- [DEBUG] 17:34:17 #0000661B ks_thread.c:768 __ks_thread_create_ex Allocating new thread, current active and attached count: 1, current active and detatched count: 0
- [DEBUG] 17:34:17 #0000661B ks_thread.c:783 __ks_thread_create_ex Thread state change: KS_THREAD_CALLER_STATE_INIT => KS_THREAD_STARTING, address: 0x7ffd66b3a848, tid: 00000000
- [DEBUG] 17:34:17 #0000661B ks_thread.c:786 __ks_thread_create_ex Thread state change: KS_THREAD_CALLER_STATE_INIT => KS_THREAD_CALLER_STATE_START_REQUESTED, address: 0x7ffd66b3a848, tid: 00000000
- [DEBUG] 17:34:17 #0000661B ks_thread.c:794 __ks_thread_create_ex Waiting for thread thread to set running, with address: 0x55aff5917358, tid: 00000000
- [DEBUG] 17:34:17 #0000661C ks_thread.c:203 thread_launch Thread has launched with address: 0x55aff5917358, tid: 00000000
- [DEBUG] 17:34:17 #0000661C ks_thread.c:217 thread_launch Marking thread as running, with address: 0x55aff5917358, tid: 00000000
- [DEBUG] 17:34:17 #0000661C ks_thread.c:224 thread_launch Thread state change: KS_THREAD_STARTING => KS_THREAD_RUNNING, address: 0x7f6ef5a29850, tid: 00000000
- [DEBUG] 17:34:17 #0000661B ks_thread.c:821 __ks_thread_create_ex Allocated (attached) thread context ptr: 0x55aff5917358, tid: 0000661c
- [DEBUG] 17:34:17 #0000661C ks_thread.c:244 thread_launch START call user thread callback with address: 0x55aff5917358, tid: 0000661c
- [INFO] 17:34:17 #0000661C handle_manager.c:222 __manager_loop Manager loop starting
- [INFO] 17:34:17 #0000661C handle_manager.c:202 __requested_service_in_ms Manager over due for service, last service interval was 1530092057309ms ago (max allowed is 300000ms)
- [INFO] 17:34:17 #0000661C handle_manager.c:238 __manager_loop Manager sleeping for service in: 1ms
- [INFO] 17:34:17 #0000661C handle_manager.c:244 __manager_loop Manager timed out waiting for 1ms
- [INFO] 17:34:17 #0000661C handle_manager.c:147 __service_handle_type Service manager enumerating handles of type: Connection
- [INFO] 17:34:17 #0000661C handle_manager.c:162 __service_handle_type Service manager serviced: 0 handles of type: Connection
- [INFO] 17:34:17 #0000661C handle_manager.c:147 __service_handle_type Service manager enumerating handles of type: Session
- [INFO] 17:34:17 #0000661C handle_manager.c:162 __service_handle_type Service manager serviced: 0 handles of type: Session
- [INFO] 17:34:17 #0000661C handle_manager.c:147 __service_handle_type Service manager enumerating handles of type: Websocket
- [INFO] 17:34:17 #0000661C handle_manager.c:162 __service_handle_type Service manager serviced: 0 handles of type: Websocket
- [INFO] 17:34:17 #0000661C handle_manager.c:238 __manager_loop Manager sleeping for service in: 300000ms
- [DEBUG] 17:34:17 #0000661B ks_handle.c:284 __ks_handle_alloc_ex ALLOC - GROUP: 10 TOTAL: 0
- [DEBUG] 17:34:17 #0000661B ks_handle.c:340 __ks_handle_alloc_ex ALLOCHANDLE: 000a0003276e0001
- [DEBUG] 17:34:17 #0000661B ks_handle.c:605 ks_handle_set_ready READYHANDLE: 000a0003276e0001
- [ERROR] 17:34:17 #0000661B ks_handle.c:623 ks_handle_set_ready READYHANDLE: 000a0003276e0001 SUCCESS
- [INFO] 17:34:17 #0000661B testcli.c:225 main connecting to 127.0.0.1:2100 ...
- [DEBUG] 17:34:17 #0000661B ks_handle.c:284 __ks_handle_alloc_ex ALLOC - GROUP: 11 TOTAL: 0
- [DEBUG] 17:34:17 #0000661B ks_handle.c:340 __ks_handle_alloc_ex ALLOCHANDLE: 000b0005497f0001
- [DEBUG] 17:34:17 #0000661B identity.c:12 swclt_ident_from_str Parsing 127.0.0.1:2100
- [DEBUG] 17:34:17 #0000661B ks_handle.c:284 __ks_handle_alloc_ex ALLOC - GROUP: 10 TOTAL: 0
- [DEBUG] 17:34:17 #0000661B ks_handle.c:340 __ks_handle_alloc_ex ALLOCHANDLE: 000a0002276f0002
- [DEBUG] 17:34:17 #0000661B ks_handle.c:605 ks_handle_set_ready READYHANDLE: 000a0002276f0002
- [ERROR] 17:34:17 #0000661B ks_handle.c:623 ks_handle_set_ready READYHANDLE: 000a0002276f0002 SUCCESS
- [DEBUG] 17:34:17 #0000661B ks_handle.c:605 ks_handle_set_ready READYHANDLE: 000b0005497f0001
- [ERROR] 17:34:17 #0000661B ks_handle.c:623 ks_handle_set_ready READYHANDLE: 000b0005497f0001 SUCCESS
- [DEBUG] 17:34:17 #0000661B ks_handle.c:284 __ks_handle_alloc_ex ALLOC - GROUP: 10 TOTAL: 0
- [DEBUG] 17:34:17 #0000661B ks_handle.c:340 __ks_handle_alloc_ex ALLOCHANDLE: 000a000427700003
- [DEBUG] 17:34:17 #0000661B ks_handle.c:605 ks_handle_set_ready READYHANDLE: 000a000427700003
- [ERROR] 17:34:17 #0000661B ks_handle.c:623 ks_handle_set_ready READYHANDLE: 000a000427700003 SUCCESS
- [INFO] 17:34:17 #0000661B handle_state.c:233 __swclt_hstate_initiate_change_in Handle: Normal is initiating state change (state change: Online=>SWCLT Session - SWCLT Session - ) in: 1ms
- [INFO] 17:34:17 #0000661B handle_manager.c:314 swclt_hmgr_request_service_in Handle: SWCLT Session - SWCLT Session - SWCLT Session - is requesting manager service in: 1ms
- [INFO] 17:34:17 #0000661B handle_manager.c:180 __set_sleep_amount_ms Client service interval: 1ms is < current service interval of: 300000ms, signalling manager
- [INFO] 17:34:17 #0000661C handle_manager.c:257 __manager_loop Manager signalled, checking sleep amount
- [INFO] 17:34:17 #0000661C handle_manager.c:238 __manager_loop Manager sleeping for service in: 3000ms
- [INFO] 17:34:20 #0000661C handle_manager.c:244 __manager_loop Manager timed out waiting for 3000ms
- [INFO] 17:34:20 #0000661C handle_manager.c:147 __service_handle_type Service manager enumerating handles of type: Connection
- [INFO] 17:34:20 #0000661C handle_manager.c:162 __service_handle_type Service manager serviced: 0 handles of type: Connection
- [INFO] 17:34:20 #0000661C handle_manager.c:147 __service_handle_type Service manager enumerating handles of type: Session
- [INFO] 17:34:20 #0000661C handle_manager.c:155 __service_handle_type Service begin: SWCLT Session - SWCLT Session -
- [INFO] 17:34:20 #0000661C session.c:214 __do_connect Session is performing connect
- [ERROR] 17:34:20 #0000661C ssl.c:19 swclt_ssl_create_context Failed to allocate ssl context returning status: 21
- [INFO] 17:34:20 #0000661C session.c:221 __do_connect FAILED TO SETUP SSL: 21
- [INFO] 17:34:20 #0000661C handle_manager.c:112 __service_handle State change attempt (Normal=>Online) failed (21) re-queueing in: 5000ms
- [INFO] 17:34:20 #0000661C handle_state.c:233 __swclt_hstate_initiate_change_in Handle: Normal is initiating state change (state change: Online=>SWCLT Session - SWCLT Session - SWCLT Session - ) in: 5000ms
- [INFO] 17:34:20 #0000661C handle_manager.c:314 swclt_hmgr_request_service_in Handle: SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - is requesting manager service in: 5000ms
- [INFO] 17:34:20 #0000661C handle_manager.c:180 __set_sleep_amount_ms Client service interval: 5000ms is < current service interval of: 300000ms, signalling manager
- [INFO] 17:34:20 #0000661C handle_manager.c:157 __service_handle_type Service end: SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session -
- [INFO] 17:34:20 #0000661C handle_manager.c:162 __service_handle_type Service manager serviced: 1 handles of type: Session
- [INFO] 17:34:20 #0000661C handle_manager.c:147 __service_handle_type Service manager enumerating handles of type: Websocket
- [INFO] 17:34:20 #0000661C handle_manager.c:162 __service_handle_type Service manager serviced: 0 handles of type: Websocket
- [INFO] 17:34:20 #0000661C handle_manager.c:238 __manager_loop Manager sleeping for service in: 3000ms
- [INFO] 17:34:23 #0000661C handle_manager.c:244 __manager_loop Manager timed out waiting for 3000ms
- [INFO] 17:34:23 #0000661C handle_manager.c:147 __service_handle_type Service manager enumerating handles of type: Connection
- [INFO] 17:34:23 #0000661C handle_manager.c:162 __service_handle_type Service manager serviced: 0 handles of type: Connection
- [INFO] 17:34:23 #0000661C handle_manager.c:147 __service_handle_type Service manager enumerating handles of type: Session
- [INFO] 17:34:23 #0000661C handle_manager.c:155 __service_handle_type Service begin: SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session -
- [INFO] 17:34:23 #0000661C session.c:214 __do_connect Session is performing connect
- [ERROR] 17:34:23 #0000661C ssl.c:19 swclt_ssl_create_context Failed to allocate ssl context returning status: 21
- [INFO] 17:34:23 #0000661C session.c:221 __do_connect FAILED TO SETUP SSL: 21
- [INFO] 17:34:23 #0000661C handle_manager.c:112 __service_handle State change attempt (Normal=>Online) failed (21) re-queueing in: 5000ms
- [INFO] 17:34:23 #0000661C handle_state.c:233 __swclt_hstate_initiate_change_in Handle: Normal is initiating state change (state change: Online=>SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - ) in: 5000ms
- [INFO] 17:34:23 #0000661C handle_manager.c:314 swclt_hmgr_request_service_in Handle: SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - is requesting manager service in: 5000ms
- [INFO] 17:34:23 #0000661C handle_manager.c:180 __set_sleep_amount_ms Client service interval: 5000ms is < current service interval of: 300000ms, signalling manager
- [INFO] 17:34:23 #0000661C handle_manager.c:157 __service_handle_type Service end: SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session -
- [INFO] 17:34:23 #0000661C handle_manager.c:162 __service_handle_type Service manager serviced: 1 handles of type: Session
- [INFO] 17:34:23 #0000661C handle_manager.c:147 __service_handle_type Service manager enumerating handles of type: Websocket
- [INFO] 17:34:23 #0000661C handle_manager.c:162 __service_handle_type Service manager serviced: 0 handles of type: Websocket
- [INFO] 17:34:23 #0000661C handle_manager.c:238 __manager_loop Manager sleeping for service in: 3000ms
- [INFO] 17:34:26 #0000661C handle_manager.c:244 __manager_loop Manager timed out waiting for 3000ms
- [INFO] 17:34:26 #0000661C handle_manager.c:147 __service_handle_type Service manager enumerating handles of type: Connection
- [INFO] 17:34:26 #0000661C handle_manager.c:162 __service_handle_type Service manager serviced: 0 handles of type: Connection
- [INFO] 17:34:26 #0000661C handle_manager.c:147 __service_handle_type Service manager enumerating handles of type: Session
- [INFO] 17:34:26 #0000661C handle_manager.c:155 __service_handle_type Service begin: SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session -
- [INFO] 17:34:26 #0000661C session.c:214 __do_connect Session is performing connect
- [ERROR] 17:34:26 #0000661C ssl.c:19 swclt_ssl_create_context Failed to allocate ssl context returning status: 21
- [INFO] 17:34:26 #0000661C session.c:221 __do_connect FAILED TO SETUP SSL: 21
- [INFO] 17:34:26 #0000661C handle_manager.c:112 __service_handle State change attempt (Normal=>Online) failed (21) re-queueing in: 5000ms
- [INFO] 17:34:26 #0000661C handle_state.c:233 __swclt_hstate_initiate_change_in Handle: Normal is initiating state change (state change: Online=>SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - ) in: 5000ms
- [INFO] 17:34:26 #0000661C handle_manager.c:314 swclt_hmgr_request_service_in Handle: SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - is requesting manager service in: 5000ms
- [INFO] 17:34:26 #0000661C handle_manager.c:180 __set_sleep_amount_ms Client service interval: 5000ms is < current service interval of: 300000ms, signalling manager
- [INFO] 17:34:26 #0000661C handle_manager.c:157 __service_handle_type Service end: SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session - SWCLT Session -
- [INFO] 17:34:26 #0000661C handle_manager.c:162 __service_handle_type Service manager serviced: 1 handles of type: Session
- [INFO] 17:34:26 #0000661C handle_manager.c:147 __service_handle_type Service manager enumerating handles of type: Websocket
- [INFO] 17:34:26 #0000661C handle_manager.c:162 __service_handle_type Service manager serviced: 0 handles of type: Websocket
- [INFO] 17:34:26 #0000661C handle_manager.c:238 __manager_loop Manager sleeping for service in: 3000ms
- [INFO] 17:34:29 #0000661C handle_manager.c:244 __manager_loop