[ 4292 4944][20 Jul 9:27:58][HelloRequest] HelloRequest::BuildHelloReq() - client mode: endpoint_security [ 4292 4944][20 Jul 9:27:58][HelloRequest] HelloRequest::BuildHelloReq() hello request: (ClientHello :client_info ( :client_type (TRAC) :client_version (986101816) :client_mode (endpoint_security) :gw_ip (here ip) ) )
[ 4292 4944][20 Jul 9:27:58][HelloRequest] HelloRequest::SendHelloRequest(): req_set_str (ClientHello :client_info ( :client_type (TRAC) :client_version (986101816) :client_mode (endpoint_security) :gw_ip (here ip) ) ) [ 4292 4944][20 Jul 9:27:58][HelloRequest] HelloRequest::SendHelloRequest(): Setting ccc ptr [ 4292 4944][20 Jul 9:27:58][TalkCCC] talkccc::send_request: the new request ID is: 8 [ 4292 4944][20 Jul 9:27:58][TalkCCC] talkccc::send_request: Adding general request to map [ 4292 4944][20 Jul 9:27:58][TalkCCC] talkccc::RunSend: inside [ 4292 4944][20 Jul 9:27:58][TalkCCC] talkccc::BuildRequest: inside [ 4292 4944][20 Jul 9:27:58][talkssl] talkssl::send_data: Entering for 389 bytes [ 4292 4944][20 Jul 9:27:58][cpwssl] cpSSL_fwasync_pending: No input data is pending. [ 4292 4944][20 Jul 9:27:58][cpwssl] cpSSL_fwasync_write: Entering... buf=35b1d90, len=389 [ 4292 4944][20 Jul 9:27:58][wssl] WinSSL_Encrypt: EncryptMessage returned 00000000 (SEC_E_OK) [ 4292 4944][20 Jul 9:27:58][cpwssl] cpSSL_fwasync_write: Encrypt status = 0. in=389, hdr=13, trailer=16 [ 4292 4944][20 Jul 9:27:58][cpwssl] cpSSL_fwasync_write: 418 of 418 bytes sent [ 4292 4944][20 Jul 9:27:58][talkssl] talkssl::client_handler: after sending packet [ 4292 4944][20 Jul 9:27:58][cpwssl] cpSSL_fwasync_pending: No input data is pending. [ 4292 4944][20 Jul 9:27:58][TalkCCC] talkccc::send_request: Deschedule idle timeout callback [ 4292 4944][20 Jul 9:27:58][TalkCCC] talkccc::send_request: Scheduling timeout callback for the request 8 in 60000ms [ 4292 4944][20 Jul 9:27:58][TR_FLOW] TR_FLOW::TrBaseFlow::reportDiagnosticEvent_: enter... [ 4292 4944][20 Jul 9:27:58][TR_CONN_MANAGER] TrConnManager::GetCurrentSiteUserName - entering... [ 4292 4944][20 Jul 9:27:58][TR_CONN_MANAGER] TrConnManager::GetCurrentSiteUserName - we have a user with name - Test [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] gw_ipaddr return value here ip, because it is Gateway config variable. Scope: site here ip ,gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][XmlWrapper] XmlDocument::XmlDocument: inside [ 4292 4944][20 Jul 9:27:58][XmlWrapper] XmlDocument::SaveString: inside [ 4292 4944][20 Jul 9:27:58][TR_CONN_MANAGER] diagnostic_reporter: entering... [ 4292 4944][20 Jul 9:27:58][TR_SRV2CL] TR_SRV2CL::SendNotification: client is not registered to this type of notification - TR_NOTIFICATION_DIGNOSTIC [ 4292 4944][20 Jul 9:27:58][cpwssl] cpWinSSL_fwasync_read: 1416 bytes read from socket. [ 4292 4944][20 Jul 9:27:58][wssl] WinSSL_Decrypt: DecryptMessage returned 00000000 (SEC_E_OK) [ 4292 4944][20 Jul 9:27:58][cpwssl] cpWinSSL_Decrypt_buffer: Decrypt status = 00000000. in=1416, out=1387, extra_len=0) [ 4292 4944][20 Jul 9:27:58][cpwssl] cpWinSSL_fwasync_read: cpWinSSL_Decrypt_buffer returned: 00000000 [ 4292 4944][20 Jul 9:27:58][cpwssl] cpWinSSL_fwasync_read: delivering 1387 chars to application [ 4292 4944][20 Jul 9:27:58][talkssl] talkssl::client_handler: state: SSL_RECV - entering [ 4292 4944][20 Jul 9:27:58][talkssl] talkssl::client_handler: got 1387 bytes, wanted 65536 bytes [ 4292 4944][20 Jul 9:27:58][talkssl] talkssl::client_handler: calling recv with dlen 1387 [ 4292 4944][20 Jul 9:27:58][talkhttps] ATalkHttps::ssl_packet_receive_cb: called [ 4292 4944][20 Jul 9:27:58][talkhttps] ATalkHttps::ssl_packet_receive_cb: HTTP server supports '1.0' version [ 4292 4944][20 Jul 9:27:58][TalkCCC] talkccc::ReceiveEv: HTTP server supports '1.0' version [ 4292 4944][20 Jul 9:27:58][TalkCCC] talkccc::ReceiveEv: Response status code - 200 [ 4292 4944][20 Jul 9:27:58][TalkCCC] talkccc::GetIdFromMsg: id: 8 [ 4292 4944][20 Jul 9:27:58][TalkCCC] talkccc::ParseSet: received set: [ 4292 4944][20 Jul 9:27:58][TalkCCC] (CCCserverResponse :ResponseHeader ( :id (8) :type (ClientHello) :session_id () :return_code (600) ) :ResponseData ( :protocol_version ( :protocol_version (100) :features (0x1) ) :upgrade_configuration ( :available_client_version (835000022) :client_upgrade_url ("/CSHELL/") :upgrade_mode (ask_user) ) :connectivity_info ( :default_authentication_method (client_decide) :client_enabled (true) :supported_data_tunnel_protocols ( : (IPSec) : (SSL) : (L2TP) ) :connectivity_type (IPSec) :server_ip (here ip) :ipsec_transport (auto_detect) :tcpt_port (443) :natt_port (4500) :connect_with_certificate_url ("/clients/cert/") :cookie_name (CPCVPN_SESSION_ID) :internal_ca_fingerprint () ) :end_point_security ( :ics ( :run_ics (false) :ics_base_url ("/clients/ICS/components") :ics_version (403006000) :ics_upgrade_url ("/clients/ICS/components/icsweb.cab") :ics_images_url ("/clients/ICS/components/ICS_images.cab") :ics_images_ver (403006000) :ics_cab_url ("/clients/ICS/components/cl_ics.cab") :ics_cab_version ("990000010 ") ) ) ) ) [ 4292 4944][20 Jul 9:27:58][TalkCCC] talkccc::ParseSet: got message type: ClientHello
[ 4292 4944][20 Jul 9:27:58][TalkCCC] talkccc::ParseSet: got session id: [ 4292 4944][20 Jul 9:27:58][TalkCCC] talkccc::ParseSet: got return_code: 600 [ 4292 4944][20 Jul 9:27:58][TalkCCC] talkccc::RemoveRequest: Called with cccError 0 [ 4292 4944][20 Jul 9:27:58][TalkCCC] talkccc::RemoveRequest: Calling the notify callback for the request 8 [ 4292 4944][20 Jul 9:27:58][HelloRequest] HelloRequest::Notify:Error - got ccc error response 0 [ 4292 4944][20 Jul 9:27:58][HelloRequest] HelloRequest::Notify: set_str ( :protocol_version ( :protocol_version (100) :features (0x1) ) :upgrade_configuration ( :available_client_version (835000022) :client_upgrade_url ("/CSHELL/") :upgrade_mode (ask_user) ) :connectivity_info ( :default_authentication_method (client_decide) :client_enabled (true) :supported_data_tunnel_protocols ( : (IPSec) : (SSL) : (L2TP) ) :connectivity_type (IPSec) :server_ip (here ip) :ipsec_transport (auto_detect) :tcpt_port (443) :natt_port (4500) :connect_with_certificate_url ("/clients/cert/") :cookie_name (CPCVPN_SESSION_ID) :internal_ca_fingerprint () ) :end_point_security ( :ics ( :run_ics (false) :ics_base_url ("/clients/ICS/components") :ics_version (403006000) :ics_upgrade_url ("/clients/ICS/components/icsweb.cab") :ics_images_url ("/clients/ICS/components/ICS_images.cab") :ics_images_ver (403006000) :ics_cab_url ("/clients/ICS/components/cl_ics.cab") :ics_cab_version ("990000010 ") ) ) ) [ 4292 4944][20 Jul 9:27:58][HelloRequest] HelloRequest::ParseBody():no firewall version, don't fail flow [ 4292 4944][20 Jul 9:27:58][HelloRequest] HelloRequest::ParseBody():upgrade mode = ask_user [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::removeParam remove 'client_enabled', source: '1' [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::save() [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::save() [ 4292 4944][20 Jul 9:27:58][HelloRequest] HelloRequest::ParseBody(): connectivity type: IPSec [ 4292 4944][20 Jul 9:27:58][HelloRequest] HelloRequest::ParseBody(): transport: Auto-Detect [ 4292 4944][20 Jul 9:27:58][HelloRequest] HelloRequest::ParseBody(): Setting cookie name [ 4292 4944][20 Jul 9:27:58][TalkCCC] Talkccc::SetCookieName: set cookie_name to CPCVPN_SESSION_ID [ 4292 4944][20 Jul 9:27:58][HelloRequest] HelloRequest::ParseBody(): No CCC ptr! [ 4292 4944][20 Jul 9:27:58][HelloRequest] HelloRequest::ParseGostFingerprints:enter... [ 4292 4944][20 Jul 9:27:58][HelloRequest] HelloRequest::ParseGostFingerprints: there is no 'gost_fingerprints_with_cn' entry -> abort [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] multi_realms return value true, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][HelloRequest] HelloRequest::ParseBody(): multi_realms is enabled. Retrieving realm list. [ 4292 4944][20 Jul 9:27:58][HelloRequest] HelloRequest::ParseBody(): login_options_data does not exist - defaulting to realm BC mode [ 4292 4944][20 Jul 9:27:58][HelloRequest] HelloRequest::ParseBody(): realms_configuration does not exist - defaulting to realm BC mode [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::removeParam remove 'hello_protocol_ver', source: '1' [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::save() [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::save() [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::removeParam remove 'client_version', source: '1' [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::save() [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::save() [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::removeParam remove 'trac_upgrade_url', source: '1' [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::save() [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::save() [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::removeParam remove 'neo_upgrade_mode', source: '1' [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::save() [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::save() [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::removeParam remove 'conn_type', source: '1' [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::save() [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::save() [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::removeParam remove 'transport', source: '1' [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::save() [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::save() [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::removeParam remove 'vpnd_ipaddr', source: '1' [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::save() [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::save() [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::removeParam remove 'default_authentication_method', source: '1' [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::save() [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::save() [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::removeParam remove 'tcpt_transport_port', source: '1' [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::save() [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::save() [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::removeParam remove 'natt_transport_port', source: '1' [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::save() [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::save() [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::removeParam remove 'certificate_url', source: '1' [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::save() [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::save() [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::removeParam remove 'cookie_name', source: '1' [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::save() [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::save() [ 4292 4944][20 Jul 9:27:58][HelloRequest] HelloRequest::ParseBody(): got that gw does not support login option, check site state [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] site_uses_login_options return value false, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TR_FLOW_STEP::TrClientHelloStep::Notify: Successfully recieved hello reply [ 4292 4944][20 Jul 9:27:58][TR_CONN_MANAGER] BuildConnDataWrapper: site:here ip, pConnDataSet add:367c228 [ 4292 4944][20 Jul 9:27:58][TR_CONN_MANAGER] BuildConnDataWrapper: gw: NULL [ 4292 4944][20 Jul 9:27:58][TR_CONN_MANAGER] BuildConnDataWrapper: user:USER [ 4292 4944][20 Jul 9:27:58][TR_CONN_DATA_ADAPTER] TrConnDataAdapter::BuildConnData: enter... [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] gw_ipaddr return value here ip, because it is Gateway config variable. Scope: site here ip ,gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] vpnd_ipaddr return value here ip, because it is Gateway config variable. Scope: site here ip ,gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] authentication_method return value username-password, because it is User config variable. Scope: site here ip ,gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] is_saa return value false, because it is User config variable. Scope: site here ip ,gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] transport return value Auto-Detect, because it is Gateway config variable. Scope: site here ip ,gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] display_name return value here ip, because it is User config variable. Scope: site here ip ,gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] gw_hostname return value here ip, because it is Gateway config variable. Scope: site here ip ,gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] username return value , because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] certificate_path return value , because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] neo_remember_user_password return value false, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] neo_remember_user_password_timeout return value 1440, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] neo_always_connected return value true, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] neo_upgrade_mode return value ask_user, because it is Gateway config variable. Scope: site here ip ,gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] neo_check_crl return value false, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] neo_user_re_auth_timeout return value 480, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] neo_always_connected_retry return value 1, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] neo_keep_alive_timeout return value 20, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] dgd_burst_timeout return value 2000, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] neo_keep_alive_timeout return value 20, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ike_connect_timeout return value 70000, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] transport_connect_timeout return value 40000, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] natt_transport_port return value 4500, because it is Gateway config variable. Scope: site here ip ,gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] tcpt_transport_port return value 443, because it is Gateway config variable. Scope: site here ip ,gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] gw_bc_mode return value false, because it is Gateway config variable. Scope: site here ip ,gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] enable_gw_resolving return value true, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] enable_natt_probing return value true, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] enable_dead_gw_detection return value true, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] securID_type return value pin_pad, because it is Default variable. Scope: site NULL, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] securID_type return value pin_pad, because it is Default variable. Scope: site NULL, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] gw_internal_ip return value , because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] user_upgrade_mode return value ASK_USER, because it is User config variable. Scope: site here ip ,gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] site_uses_login_options return value false, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] selected_realm_id return value , because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] def_gw_ipaddr return value , because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] keep_alive return value false, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] keep_alive_interval return value 0, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] log_tunnel_errors_to_helpdesk return value 1, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][TR_FEATURE_MANAGER] TR_FEATURE_MANAGER::isMultiSiteEnabled: enter... [ 4292 4944][20 Jul 9:27:58][TR_FEATURE_MANAGER] isMultiSiteEnabled: client type is not SECURE_REMOTE_TYPE -> multi-site cannot be supported -> abort [ 4292 4944][20 Jul 9:27:58][TR_CONN_MANAGER] TR_CONN_MANAGER::is_secondary_connect_enabled_and_supported_on_gw: enter... [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] is_secondary_connect_enabled_and_supported_on_gw return value false, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][TR_CONN_MANAGER] is_secondary_connect_enabled_and_supported_on_gw: site here ip support 'secondary connect': 0 [ 4292 4944][20 Jul 9:27:58][TR_CONN_MANAGER] TR_CONN_MANAGER::setIpRangesOnConnData: enter... [ 4292 4944][20 Jul 9:27:58][TR_CONN_MANAGER] setIpRangesOnConnData: about to set 'allowed-ip-ranges-num' to 0 [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] site_uses_login_options return value false, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][TR_REALM_CONFIG_MANAGER] TrRealmConfigManager::GetGatewayLoginOptionState: site here ip does not support login option [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] do_proxy_replacement return value true, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TR_FLOW_STEP::TrPokeGWStep::UpdateStepStatus: full flow. No need to poke gw [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TR_FLOW_STEP:: TrClientHelloStep::UpdateStepStatus: full flow. Step should be executed [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] site_uses_login_options return value false, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][FLOW] TrPrimaryConnFlow::GetFlowType: mIsPrimaryConn: 1, misUpdateSiteFlow: 0 [ 4292 4944][20 Jul 9:27:58][FLOW] TrPrimaryConnFlow::GetFlowType: mIsPrimaryConn: 1, misUpdateSiteFlow: 0 [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TR_FLOW_STEP:: TrRealmConfigStep::UpdateStepStatus: full flow [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TR_FLOW_STEP::TrUpgradeClientStep::UpdateStepStatus: entering... [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TR_FLOW_STEP::TrUpgradeClientStep::UpdateStepStatus: full flow. Step should be executed [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TR_FLOW_STEP::TrUpgradeClientStep::SkipUpgrade: entering... [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] upgrade_accept_customized_packages return value false, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TR_FLOW_STEP::TrGetAuthInfoStep::UpdateStepStatus: entering... [ 4292 4944][20 Jul 9:27:58][trac] [COVERAGE] [TrMachineConfigManager::IsMachineOnlyConfigured(s)] __start__ [ 4292 4944][20 Jul 9:27:58][trac] [COVERAGE] [TrMachineConfigManager::isMachineAuthenticationEnabled(s)] __start__ [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] enable_machine_auth return value true, because it is Default variable. Scope: site NULL, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][trac] [INFO] [TrMachineConfigManager::isMachineAuthenticationEnabled(s)] Machine authentication is enabled. [ 4292 4944][20 Jul 9:27:58][trac] [COVERAGE] [TrMachineConfigManager::isMachineAuthenticationEnabled(s)] __end__ Total: 0 milliseconds. [ 4292 4944][20 Jul 9:27:58][trac] [COVERAGE] [TrMachineConfigManager::isMachineOnlyDefaultSiteConfigured(s)] __start__ [ 4292 4944][20 Jul 9:27:58][trac] [COVERAGE] [TrMachineConfigManager::getMachineOnlyDefaultSite(s)] __start__ [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] machine_tunnel_site return value , because it is Default variable. Scope: site NULL, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][trac] [INFO] [TrMachineConfigManager::getMachineOnlyDefaultSite(s)] No valid machine tunnel site is is configured. [ 4292 4944][20 Jul 9:27:58][trac] [COVERAGE] [TrMachineConfigManager::getMachineOnlyDefaultSite(s)] __end__ Total: 0 milliseconds. [ 4292 4944][20 Jul 9:27:58][trac] [COVERAGE] [TrMachineConfigManager::isMachineOnlyDefaultSiteConfigured(s)] __end__ Total: 0 milliseconds. [ 4292 4944][20 Jul 9:27:58][trac] [INFO] [TrMachineConfigManager::IsMachineOnlyConfigured(s)] Machine only is not configured. [ 4292 4944][20 Jul 9:27:58][trac] [COVERAGE] [TrMachineConfigManager::IsMachineOnlyConfigured(s)] __end__ Total: 0 milliseconds. [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TR_FLOW_STEP::TrDownloadClSettingStep::UpdateStepStatus: enter... [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TR_FLOW_STEP::TrDownloadClSettingStep::UpdateStepStatus: full flow. Step should be executed [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TR_FLOW_STEP::TrUpgradeClientStep::UpdateStepStatus: entering... [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TR_FLOW_STEP::TrUpgradeClientStep::UpdateStepStatus: full flow. Step should be executed [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TR_FLOW_STEP::TrUpgradeClientStep::SkipUpgrade: entering... [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] upgrade_accept_customized_packages return value false, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TR_FLOW_STEP::TrUpgradeClientStep::SkipUpgrade: In late upgrade step and 'upgrade_accept_customized_packages' flag is set to false, skipping step [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TR_FLOW_STEP::TrFirewallStep::UpdateStepStatus: entering... [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] enable_firewall return value false, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TR_FLOW_STEP::TrFirewallStep::UpdateStepStatus: firewall is disable, don't run step [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TR_FLOW_STEP::TrScvStep::UpdateStepStatus: entering... [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TR_FLOW_STEP::TrPostConnectionRunScriptsStep::GetScriptPath: entering... [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] post_connect_script return value , because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TR_FLOW_STEP::TrRunScriptsStep::UpdateStepStatus: This step is not runnable. [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] send_client_logs return value , because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][TalkCCC] talkccc::RemoveRequest: Returned callback for the request 8 [ 4292 4944][20 Jul 9:27:58][TalkCCC] talkccc::RemoveRequest: Descheduling timeout callback for the request 8 [ 4292 4944][20 Jul 9:27:58][TalkCCC] talkccc::ReceiveEv: map and queue are both empty. Schedule idle timeout [ 4292 4944][20 Jul 9:27:58][TalkCCC] talkccc::ReceiveEv: Http 1.0 reconnect sequence started, blocking callbacks and disconnecting [ 4292 4944][20 Jul 9:27:58][TalkCCC] talkccc::disconnect: Disconnecting ssl tunnel [ 4292 4944][20 Jul 9:27:58][talkhttps] ATalkHttps::CloseConn: Close SSL conn: 0x3574330 State 0x5 Reason: Disconnect. [ 4292 4944][20 Jul 9:27:58][talkssl] talkssl::disconnect: called [ 4292 4944][20 Jul 9:27:58][] T_event_do_del: failed to remove WSAsocket event [ 4292 4944][20 Jul 9:27:58][talkssl] talkssl::disconnect: zero connection and status [ 4292 4944][20 Jul 9:27:58][talkhttps] ResetRcvBuffer: data 0371A918 size 65536 free_buffer=1. [ 4292 4944][20 Jul 9:27:58][] fwasync_conn_get: get max buffer size (1048576) . [ 4292 4944][20 Jul 9:27:58][] fwasync_set_events: connection 1460 already closed [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::saveToFile() [ 4292 4944][20 Jul 9:27:58][XmlWrapper] XmlDocument::XmlDocument: inside [ 4292 4944][20 Jul 9:27:58][XmlWrapper] XmlDocument::SaveString: inside [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] OBSCURE_FILE return value 1, because it is Default variable. Scope: site NULL, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][FLOW] TrPrimaryConnFlow::GetFlowType: mIsPrimaryConn: 1, misUpdateSiteFlow: 0 [ 4292 4944][20 Jul 9:27:58][TR_FLOW] TR_FLOW::TrBaseFlow::FinishStep: <------------------------------------- (1) Step 4 (class TrClientHelloStep) finished with status 0 - TrOK [ 4292 4944][20 Jul 9:27:58][FLOW] TrPrimaryConnFlow::GetFlowType: mIsPrimaryConn: 1, misUpdateSiteFlow: 0 [ 4292 4944][20 Jul 9:27:58][TR_SRV2CL] TR_SRV2CL::SendNotification: Successfully sent notification of type TR_NOTIFICATION_CONNECTION_PROGRESS [ 4292 4944][20 Jul 9:27:58][TR_FLOW] TR_FLOW::TrBaseFlow::FinishStep: Scheduling next step [ 4292 4944][20 Jul 9:27:58][proxy_wrapper] ProxyWrapper::NotifyEndConnection (3): Starting ... [ 4292 4944][20 Jul 9:27:58][TR_FIREWALL] CFirewallWrapper::RemoveSingleProxyRule (1): entering... my_addr:0, my_port:63346, peer_addr:0, peer_port:0 [ 4292 4944][20 Jul 9:27:58][] CFirewallWrapper::RemoveSingleProxyRule (1): ntohl(my_addr),ntohs(my_port),ntohl(peer_addr),ntohs(peer_port) : <0,29431> -> <0,0> [ 4292 4944][20 Jul 9:27:58][TR_FIREWALL] CFirewallWrapper::RemoveSingleProxyRule (2): entering, src_ip_str=0.0.0.0, src_port=29431, dest_ip_str=0.0.0.0, dest_port=0 [ 4292 4944][20 Jul 9:27:58][TR_FIREWALL] CFirewallWrapper::RemoveSingleProxyRule (2): Firewall Driver Not Initialized [ 4292 4944][20 Jul 9:27:58][talkssl] talkssl::end_handler: ending connection [ 4292 4944][20 Jul 9:27:58][talkhttps] ATalkHttps::ssl_failure_cb: SSL ended. err=3 [ 4292 4944][20 Jul 9:27:58][talkhttps] ResetRcvBuffer: data 00000000 size 0 free_buffer=1. [ 4292 4944][20 Jul 9:27:58][TalkCCC] talkccc::EndEv: got disconnected with AuthError_t==2. [ 4292 4944][20 Jul 9:27:58][TalkCCC] talkccc::EndEv: connection status 0 [ 4292 4944][20 Jul 9:27:58][TalkCCC] talkccc::EndEv: disconnection succeeded. will stay in this state [ 4292 4944][20 Jul 9:27:58][cpwssl] cpWinSSL_fwasync_close: start shutdown [ 4292 4944][20 Jul 9:27:58][cpwssl] cpWinSSL_fwasync_close: Sending Close Notification. [ 4292 4944][20 Jul 9:27:58][cpwssl] cpWinSSL_fwasync_close: Sent 31 of 31 bytes of close notification. [ 4292 4944][20 Jul 9:27:58][cpwssl] cpWinSSL_fwasync_close: closing - conn - 0x3574330 [ 4292 4944][20 Jul 9:27:58][TR_FLOW] TR_FLOW::TrBaseFlow::RunStep: =====================================> (1) Executing step 5 (class TrRealmConfigStep) [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TR_FLOW_STEP:: TrRealmConfigStep::Run: entering... [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TR_FLOW_STEP:: TrRealmConfigStep::Run: Failed to extract gw, use initial gw [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] site_uses_login_options return value false, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][FLOW] TrPrimaryConnFlow::GetFlowType: mIsPrimaryConn: 1, misUpdateSiteFlow: 0 [ 4292 4944][20 Jul 9:27:58][FLOW] TrPrimaryConnFlow::GetFlowType: mIsPrimaryConn: 1, misUpdateSiteFlow: 0 [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TR_FLOW_STEP:: TrRealmConfigStep::UpdateStepStatus: full flow [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TR_FLOW_STEP:: TrRealmConfigStep::Run: No need to execute step [ 4292 4944][20 Jul 9:27:58][FLOW] TrPrimaryConnFlow::GetFlowType: mIsPrimaryConn: 1, misUpdateSiteFlow: 0 [ 4292 4944][20 Jul 9:27:58][TR_FLOW] TR_FLOW::TrBaseFlow::FinishStep: <------------------------------------- (1) Step 5 (class TrRealmConfigStep) finished with status -7003 - TrStepEmpty [ 4292 4944][20 Jul 9:27:58][FLOW] TrPrimaryConnFlow::GetFlowType: mIsPrimaryConn: 1, misUpdateSiteFlow: 0 [ 4292 4944][20 Jul 9:27:58][TR_SRV2CL] TR_SRV2CL::SendNotification: Successfully sent notification of type TR_NOTIFICATION_CONNECTION_PROGRESS [ 4292 4944][20 Jul 9:27:58][TR_FLOW] TR_FLOW::TrBaseFlow::FinishStep: Scheduling next step [ 4292 4944][20 Jul 9:27:58][TR_FLOW] TR_FLOW::TrBaseFlow::RunStep: =====================================> (1) Executing step 6 (class TrUpgradeClientStep) [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TR_FLOW_STEP::TrUpgradeClientStep::Run: entering... [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] client_version return value 835000022, because it is Gateway config variable. Scope: site here ip ,gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][TR_FLOW] TR_FLOW::TrBaseFlow::reportDiagnosticEvent_: enter... [ 4292 4944][20 Jul 9:27:58][TR_CONN_MANAGER] TrConnManager::GetCurrentSiteUserName - entering... [ 4292 4944][20 Jul 9:27:58][TR_CONN_MANAGER] TrConnManager::GetCurrentSiteUserName - we have a user with name - Test [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] gw_ipaddr return value here ip, because it is Gateway config variable. Scope: site here ip ,gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][XmlWrapper] XmlDocument::XmlDocument: inside [ 4292 4944][20 Jul 9:27:58][XmlWrapper] XmlDocument::SaveString: inside [ 4292 4944][20 Jul 9:27:58][TR_CONN_MANAGER] diagnostic_reporter: entering... [ 4292 4944][20 Jul 9:27:58][TR_SRV2CL] TR_SRV2CL::SendNotification: client is not registered to this type of notification - TR_NOTIFICATION_DIGNOSTIC [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TR_FLOW_STEP::TrUpgradeClientStep::Run: No need for upgrade. Don't remind user [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::removeParam remove 'user_upgrade_mode', source: '3' [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::save() [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::save() [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ConfigurationManager::saveToFile() [ 4292 4944][20 Jul 9:27:58][XmlWrapper] XmlDocument::XmlDocument: inside [ 4292 4944][20 Jul 9:27:58][XmlWrapper] XmlDocument::SaveString: inside [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] OBSCURE_FILE return value 1, because it is Default variable. Scope: site NULL, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][FLOW] TrPrimaryConnFlow::GetFlowType: mIsPrimaryConn: 1, misUpdateSiteFlow: 0 [ 4292 4944][20 Jul 9:27:58][TR_FLOW] TR_FLOW::TrBaseFlow::FinishStep: <------------------------------------- (1) Step 6 (class TrUpgradeClientStep) finished with status 0 - TrOK [ 4292 4944][20 Jul 9:27:58][FLOW] TrPrimaryConnFlow::GetFlowType: mIsPrimaryConn: 1, misUpdateSiteFlow: 0 [ 4292 4944][20 Jul 9:27:58][TR_SRV2CL] TR_SRV2CL::SendNotification: Successfully sent notification of type TR_NOTIFICATION_CONNECTION_PROGRESS [ 4292 4944][20 Jul 9:27:58][TR_FLOW] TR_FLOW::TrBaseFlow::FinishStep: Scheduling next step [ 4292 4944][20 Jul 9:27:58][TR_FLOW] TR_FLOW::TrBaseFlow::RunStep: =====================================> (1) Executing step 7 (class TrGetAuthInfoStep) [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TR_FLOW_STEP::TrGetAuthInfoStep::Run: Started [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TR_FLOW_STEP::TrGetAuthInfoStep::UpdateStepStatus: entering... [ 4292 4944][20 Jul 9:27:58][trac] [COVERAGE] [TrMachineConfigManager::IsMachineOnlyConfigured(s)] __start__ [ 4292 4944][20 Jul 9:27:58][trac] [COVERAGE] [TrMachineConfigManager::isMachineAuthenticationEnabled(s)] __start__ [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] enable_machine_auth return value true, because it is Default variable. Scope: site NULL, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][trac] [INFO] [TrMachineConfigManager::isMachineAuthenticationEnabled(s)] Machine authentication is enabled. [ 4292 4944][20 Jul 9:27:58][trac] [COVERAGE] [TrMachineConfigManager::isMachineAuthenticationEnabled(s)] __end__ Total: 1 milliseconds. [ 4292 4944][20 Jul 9:27:58][trac] [COVERAGE] [TrMachineConfigManager::isMachineOnlyDefaultSiteConfigured(s)] __start__ [ 4292 4944][20 Jul 9:27:58][trac] [COVERAGE] [TrMachineConfigManager::getMachineOnlyDefaultSite(s)] __start__ [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] machine_tunnel_site return value , because it is Default variable. Scope: site NULL, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][trac] [INFO] [TrMachineConfigManager::getMachineOnlyDefaultSite(s)] No valid machine tunnel site is is configured. [ 4292 4944][20 Jul 9:27:58][trac] [COVERAGE] [TrMachineConfigManager::getMachineOnlyDefaultSite(s)] __end__ Total: 0 milliseconds. [ 4292 4944][20 Jul 9:27:58][trac] [COVERAGE] [TrMachineConfigManager::isMachineOnlyDefaultSiteConfigured(s)] __end__ Total: 0 milliseconds. [ 4292 4944][20 Jul 9:27:58][trac] [INFO] [TrMachineConfigManager::IsMachineOnlyConfigured(s)] Machine only is not configured. [ 4292 4944][20 Jul 9:27:58][trac] [COVERAGE] [TrMachineConfigManager::IsMachineOnlyConfigured(s)] __end__ Total: 1 milliseconds. [ 4292 4944][20 Jul 9:27:58][FLOW] TrPrimaryConnFlow::GetFlowType: mIsPrimaryConn: 1, misUpdateSiteFlow: 0 [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TR_FLOW_STEP::TrGetAuthInfoStep::Run: no inner gw name found. [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TR_FLOW_STEP::TrGetAuthInfoStep::Run: no inner gw name found. [ 4292 4944][20 Jul 9:27:58][TR_AUTH_MANAGER] TrCredKey::TrCredKey: creating credKey [ 4292 4944][20 Jul 9:27:58][TR_AUTH_MANAGER] TrAuthenticationManager::CredsInCache: enter, item - (gw = here ip) [ 4292 4944][20 Jul 9:27:58][TR_AUTH_MANAGER] TR_AUTH_MANAGER::TrAuthenticationManager::CredsInCache: creds request auth type is not certificate, user_password or it doesn't need to be cached [ 4292 4944][20 Jul 9:27:58][TR_AUTH_MANAGER] TR_AUTH_MANAGER::TrAuthenticationManager::CredsInCache: did not find an appropriate auth object in cache [ 4292 4944][20 Jul 9:27:58][TR_CONN_MANAGER] TrConnManager::GetRegOrCPLogonCreds: site name is: here ip [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] save_cli_credentials_for_ATM return value false, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][TR_CONN_MANAGER] TrConnManager::IsCredsInRegOrCPLogon: site name is: here ip [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] save_cli_credentials_for_ATM return value false, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][ICS] TrFeatureManager::isATM: return value - is ATM = false [ 4292 4944][20 Jul 9:27:58][TR_CONN_MANAGER] TR_CONN_MANAGER::TrConnManager::IsCredsInRegOrCPLogon: Check if CPLogon enabled [ 4292 4944][20 Jul 9:27:58][TR_CPLOGON] IsEnabled: LogonAgentAPI dll not loaded [ 4292 4944][20 Jul 9:27:58][TR_CONN_MANAGER] TR_CONN_MANAGER::TrConnManager::IsCredsInRegOrCPLogon: Credentials are not in cplogon and not in registry [ 4292 4944][20 Jul 9:27:58][ICS] TrFeatureManager::isATM: return value - is ATM = false [ 4292 4944][20 Jul 9:27:58][TR_CONN_MANAGER] TR_CONN_MANAGER::TrConnManager::GetRegOrCPLogonCreds: Creds are not in registry or cplogon [ 4292 4944][20 Jul 9:27:58][TR_AUTH_MANAGER] TR_AUTH_MANAGER::TrAuthenticationManager::GetAuthInfo: enter... [ 4292 4944][20 Jul 9:27:58][TR_AUTH_MANAGER] TrAuthenticationManager::GetAuthInfo: __start__ 9:27:58.823 [ 4292 4944][20 Jul 9:27:58][TR_AUTH_MANAGER] TrAuthenticationManager::GetAuthInfo: requesting a non-cached username-password authentication for gw=here ip, realm_id= (cb object: 353ef80) [ 4292 4944][20 Jul 9:27:58][TR_AUTH_MANAGER] TrCredKey::TrCredKey: creating credKey [ 4292 4944][20 Jul 9:27:58][TR_AUTH_MANAGER] TrAuthenticationManager::GetAuthInfo: auth item for (gw = here ip) found in cache [ 4292 4944][20 Jul 9:27:58][TR_AUTH_MANAGER] TR_AUTH_MANAGER::TrAuthenticationManager::GetAuthInfo: using existing request [ 4292 4944][20 Jul 9:27:58][auth_IS] BaseAuth::Init: mIsMultiFactor=false [ 4292 4944][20 Jul 9:27:58][auth_IS] auth_IS::BaseAuth::AuthenticationHandler: Failed to get if challenge is required [ 4292 4944][20 Jul 9:27:58][auth_IS] auth_IS::BaseAuth::AuthenticationHandler: Already has credentials [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TR_FLOW_STEP::TrGetAuthInfoStep::UserPasswordCB: started [ 4292 4944][20 Jul 9:27:58][TR_CONN_MANAGER] TrConnManager::SetGivenUserName: Storing given username: Test [ 4292 4944][20 Jul 9:27:58][TR_AUTH_MANAGER] TrAuthenticationManager::GetAuthInfo: __end__ 9:27:58.823. Total time - 0 milliseconds [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TrGetAuthInfoStep::Run: setting GET_AUTH_HANDLER 353ef80 [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TR_FLOW_STEP::TrGetAuthInfoStep::Run: done [ 4292 4944][20 Jul 9:27:58][FLOW] TrPrimaryConnFlow::GetFlowType: mIsPrimaryConn: 1, misUpdateSiteFlow: 0 [ 4292 4944][20 Jul 9:27:58][TR_FLOW] TR_FLOW::TrBaseFlow::FinishStep: <------------------------------------- (1) Step 7 (class TrGetAuthInfoStep) finished with status 0 - TrOK [ 4292 4944][20 Jul 9:27:58][FLOW] TrPrimaryConnFlow::GetFlowType: mIsPrimaryConn: 1, misUpdateSiteFlow: 0 [ 4292 4944][20 Jul 9:27:58][TR_SRV2CL] TR_SRV2CL::SendNotification: Successfully sent notification of type TR_NOTIFICATION_CONNECTION_PROGRESS [ 4292 4944][20 Jul 9:27:58][TR_FLOW] TR_FLOW::TrBaseFlow::FinishStep: Scheduling next step [ 4292 4944][20 Jul 9:27:58][TR_FLOW] TR_FLOW::TrBaseFlow::RunStep: =====================================> (1) Executing step 8 (class TrConnEngineConnectStep) [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TR_FLOW_STEP::TrConnEngineConnectStep::Run: entering... [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TR_FLOW_STEP::TrConnEngineConnectStep::Run: Failed to extract gw, use initial gw [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] multi_realms return value true, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TrConnEngineConnectStep::Run: multi_realms is enabled. [ 4292 4944][20 Jul 9:27:58][trac] [COVERAGE] [TrMachineConfigManager::isMachineAuthenticationEnabled(s)] __start__ [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] enable_machine_auth return value true, because it is Default variable. Scope: site NULL, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][trac] [INFO] [TrMachineConfigManager::isMachineAuthenticationEnabled(s)] Machine authentication is enabled. [ 4292 4944][20 Jul 9:27:58][trac] [COVERAGE] [TrMachineConfigManager::isMachineAuthenticationEnabled(s)] __end__ Total: 0 milliseconds. [ 4292 4944][20 Jul 9:27:58][trac] [COVERAGE] [TrMachineConfigManager::machineSiteKeyWasFoundInConnections(s)] __start__ [ 4292 4944][20 Jul 9:27:58][trac] [INFO] [TrMachineConfigManager::machineSiteKeyWasFoundInConnections(s)] The machine's tunnel site does not exist in the connections. [ 4292 4944][20 Jul 9:27:58][trac] [COVERAGE] [TrMachineConfigManager::machineSiteKeyWasFoundInConnections(s)] __end__ Total: 0 milliseconds. [ 4292 4944][20 Jul 9:27:58][FLOW] TrConnEngineConnectStep::BuildAuthenticationBlob: Failed to get os type [ 4292 4944][20 Jul 9:27:58][FLOW] TrConnEngineConnectStep::BuildAuthenticationBlob: Empty session ID [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] hello_protocol_ver return value 100, because it is Gateway config variable. Scope: site here ip ,gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][FLOW] TrConnEngineConnectStep::BuildAuthenticationBlob: OM enabled - use ClientSubTypeName from feature manager [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TR_FLOW_STEP::TrConnEngineConnectStep::BuildAuthenticationBlob: Failed to extract gw, use initial gw [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] site_uses_login_options return value false, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][TR_REALM_CONFIG_MANAGER] TrRealmConfigManager::GetGatewayLoginOptionState: site here ip does not support login option [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TrConnEngineConnectStep::BuildAuthenticationBlob: authentication blob ( :clientType (TRAC) :oldSessionId () :protocolVersion (100) :client_mode (endpoint_security) ) [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TrConnEngineConnectStep::AddLoggingData: starting... [ 4292 4944][20 Jul 9:27:58][FLOW] TrConnEngineConnectStep::GetClientGUID: szUniqueId already exists. [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TrConnEngineConnectStep::AddLoggingData: client build number 986101816 [ 4292 4944][20 Jul 9:27:58][DTIS_UTILS] get_computer_info: Succeeded, returning [ 4292 4944][20 Jul 9:27:58][DTIS_UTILS] get_computer_info: Succeeded, returning NR032 [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TR_FLOW_STEP::TrConnEngineConnectStep::AddLoggingData: fail to get Gw name -> the mac addresses will not be sorted as expected [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] gw_ipaddr return value here ip, because it is Gateway config variable. Scope: site here ip ,gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][location_awareness] GetExternalInterfaceIndex: External index interface is 0x7, Default gw is here ip [ 4292 4944][20 Jul 9:27:58][location_awareness] get_all_interfaces_physical_add: enter... [ 4292 4944][20 Jul 9:27:58][location_awareness] get_all_interfaces_physical_add: count: 1, pAdapter->Description: Realtek PCIe GbE Family Controller [ 4292 4944][20 Jul 9:27:58][location_awareness] get_all_interfaces_physical_add: mac address is: 94:de:80:7f:5b:23 [ 4292 4944][20 Jul 9:27:58][location_awareness] get_all_interfaces_physical_add: count: 2, pAdapter->Description: Check Point Virtual Network Adapter For Endpoint VPN Client [ 4292 4944][20 Jul 9:27:58][location_awareness] get_all_interfaces_physical_add: mac address is: 54:f2:22:ff:50:0b [ 4292 4944][20 Jul 9:27:58][location_awareness] get_all_interfaces_physical_add: count: 3, pAdapter->Description: SAMSUNG Mobile USB Remote NDIS Network Device [ 4292 4944][20 Jul 9:27:58][location_awareness] get_all_interfaces_physical_add: mac address is: 02:28:7f:61:1e:0c [ 4292 4944][20 Jul 9:27:58][location_awareness] get_all_interfaces_physical_add: main Interface desc is SAMSUNG Mobile USB Remote NDIS Network Device [ 4292 4944][20 Jul 9:27:58][TR_FLOW_STEP] TrConnEngineConnectStep::AddLoggingData: mac_addresses_list: 02:28:7f:61:1e:0c,94:de:80:7f:5b:23,54:f2:22:ff:50:0b [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] site_uses_login_options return value false, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][TR_REALM_CONFIG_MANAGER] TrRealmConfigManager::GetGatewayLoginOptionState: site here ip does not support login option [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] om_extended_dhcp_params return value false, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][FLOW] TrConnEngineConnectStep::Run: OM enabled [ 4292 4944][20 Jul 9:27:58][FLOW] TrPrimaryConnFlow::GetFlowType: mIsPrimaryConn: 1, misUpdateSiteFlow: 0 [ 4292 4944][20 Jul 9:27:58][FLOW] TrConnEngineConnectStep::Run: mFlow->GetFlowType() = 0 [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] ica_dn return value , because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][TR_FLOW] TR_FLOW::TrBaseFlow::reportDiagnosticEvent_: enter... [ 4292 4944][20 Jul 9:27:58][TR_CONN_MANAGER] TrConnManager::GetCurrentSiteUserName - entering... [ 4292 4944][20 Jul 9:27:58][TR_CONN_MANAGER] TrConnManager::GetCurrentSiteUserName - we have a user with name - Test [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] gw_ipaddr return value here ip, because it is Gateway config variable. Scope: site here ip ,gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][XmlWrapper] XmlDocument::XmlDocument: inside [ 4292 4944][20 Jul 9:27:58][XmlWrapper] XmlDocument::SaveString: inside [ 4292 4944][20 Jul 9:27:58][TR_CONN_MANAGER] diagnostic_reporter: entering... [ 4292 4944][20 Jul 9:27:58][TR_SRV2CL] TR_SRV2CL::SendNotification: client is not registered to this type of notification - TR_NOTIFICATION_DIGNOSTIC [ 4292 4944][20 Jul 9:27:58][FLOW] TrConnEngineConnectStep::Run: Starting new connection (1) [ 4292 4944][20 Jul 9:27:58][FLOW] TrPrimaryConnFlow::GetFlowType: mIsPrimaryConn: 1, misUpdateSiteFlow: 0 [ 4292 4944][20 Jul 9:27:58][util] Option IKE transport == "Auto-Detect" - value is 3 [ 4292 4944][20 Jul 9:27:58][util] Option authentication method == "username-password" - value is 20 [ 4292 4944][20 Jul 9:27:58][util] Option check CRLs == "false" - value is 0 [ 4292 4944][20 Jul 9:27:58][tunnel] [WARNING] [IkeV1Tunnel::convert] (0x035A0560): there is no om-address [ 4292 4944][20 Jul 9:27:58][tunnel] [WARNING] [IkeV1Tunnel::convert] (0x035A0560): there is no host-name [ 4292 4944][20 Jul 9:27:58][tunnel] [WARNING] [IkeV1Tunnel::convert] (0x035A0560): there is no FQDN [ 4292 4944][20 Jul 9:27:58][tunnel] [WARNING] [IkeV1Tunnel::convert] (0x035A0560): there is no vendorclass [ 4292 4944][20 Jul 9:27:58][tunnel] [WARNING] [IkeV1Tunnel::convert] (0x035A0560): there is no userclass [ 4292 4944][20 Jul 9:27:58][tunnel] [WARNING] [IkeV1Tunnel::convert] (0x035A0560): there is no additional_attrs [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] max_retrans_attempts return value 10, because it is Default variable. Scope: site 196.100.216.197, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][CONFIG_MANAGER] retransmit_interval return value 250, because it is Default variable. Scope: site 196.100.216.197, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:58][esp_transport] EspTransport::EspT_RegisterEspHandle: Successfully registered handler [ 4292 4944][20 Jul 9:27:58][esp_transport] EspTransport::EspT_RegisterEspHandle: Successfully registered handler [ 4292 4944][20 Jul 9:27:58][transport] UDP_Transport::UDP_Cleanup entering ... [ 4292 4944][20 Jul 9:27:58][transport] UDP_Transport::UDP_Cleanup this = 56045240 [ 4292 4944][20 Jul 9:27:58][CLIPS_IPSEC_ENC_DEC] Clips_IPSecEncDec::Clips_IPSecEncDec - started [ 4292 4944][20 Jul 9:27:58][CLIPS_IPSEC_ENC_DEC] Clips_IPSecEncDec::~Clips_IPSecEncDec - started [ 4292 4944][20 Jul 9:27:58][proxy_wrapper] [COVERAGE] [ProxyWrapper::CreateProxyConn(s)] __start__ [ 4292 4944][20 Jul 9:27:58][proxy_wrapper] ProxyWrapper::CreateProxyConn: set currentConns[prxConnHandle] to the global default -1 = INIT_STATE [ 4292 4944][20 Jul 9:27:58][proxy_wrapper] [COVERAGE] [ProxyWrapper::CreateProxyConn(s)] __end__ Total: 0 milliseconds. [ 4292 4944][20 Jul 9:27:58][proxy_wrapper] ProxyWrapper::Connect: Starting ... [ 4292 4944][20 Jul 9:27:58][proxy_wrapper] ProxyWrapper::Connect: cb_opq = 38346376 [ 4292 4944][20 Jul 9:27:58][proxy_wrapper] ProxyWrapper::Connect: prxConn = 36958528 [ 4292 4944][20 Jul 9:27:58][proxy_wrapper] ProxyWrapper::Connect: No proxy should be used. set mGlobalConnectivityPreferringMode = NO_PRX_STATE [ 4292 4944][20 Jul 9:27:58][proxy_wrapper] ProxyWrapper::Connect: currentConns[prxConn] is INIT_STATE [ 4292 4944][20 Jul 9:27:58][proxy_wrapper] ProxyWrapper::Connect: *** (prxConnHandle->ConnState is INIT_STATE [ 4292 4944][20 Jul 9:27:58][proxy_wrapper] ProxyWrapper::Connect: *** currentConns[prxConn] is INIT_STATE [ 4292 4944][20 Jul 9:27:58][proxy_wrapper] ProxyWrapper::Connect: this request is not 'ProxyAnalysisRequest' -> reset 'ConnRetries' [ 4292 4944][20 Jul 9:27:58][proxy_wrapper] ProxyWrapper::Connect: No proxy should be used. Trying only direct access [ 4292 4944][20 Jul 9:27:58][proxy_wrapper] ProxyWrapper::isProxyConnectivityAnalysisRequired: Starting ... [ 4292 4944][20 Jul 9:27:58][proxy_wrapper] ProxyWrapper::isProxyConnectivityAnalysisRequired: mGlobalConnectivityPreferringMode is not Init, it is NO_PRX_STATE -> not required [ 4292 4944][20 Jul 9:27:58][proxy_wrapper] ProxyWrapper::Connect: proxy Analysis phase is not required -> this is probably part of it (this conn may be part of it or not) -> use currentConns[prxConn] [ 4292 4944][20 Jul 9:27:58][proxy_wrapper] ProxyWrapper::isProxyConnectivityAnalysisInProgress: Starting ... [ 4292 4944][20 Jul 9:27:58][proxy_wrapper] ProxyWrapper::isProxyConnectivityAnalysisInProgress: INIT_STATE != mGlobalConnectivityPreferringMode -> not in progress [ 4292 4944][20 Jul 9:27:58][proxy_wrapper] ProxyWrapper::isProxyConnectivityAnalysisInProgress: Starting ... [ 4292 4944][20 Jul 9:27:58][proxy_wrapper] ProxyWrapper::isProxyConnectivityAnalysisInProgress: INIT_STATE != mGlobalConnectivityPreferringMode -> not in progress [ 4292 4944][20 Jul 9:27:58][proxy_wrapper] ProxyWrapper::Connect: proxy Analysis phase is not in process or this request is part of it -> proceed... [ 4292 4944][20 Jul 9:27:58][proxy_wrapper] ProxyWrapper::Connect: debug: prxConnHandle->ConnState is NO_PRX_STATE [ 4292 4944][20 Jul 9:27:58][proxy_wrapper] ProxyWrapper::Connect: about to DoConnect... [ 4292 4944][20 Jul 9:27:58][proxy_wrapper] ProxyWrapper::DoConnect: Starting ... [ 4292 4944][20 Jul 9:27:58][proxy_wrapper] ProxyWrapper::DoConnect: Current state is NO_PRX_STATE [ 4292 4944][20 Jul 9:27:58][proxy_wrapper] ProxyWrapper::DoConnect: connecting directly [ 4292 4944][20 Jul 9:27:58][proxy_wrapper] ProxyWrapper::DoConnect: Creating a new connection gw: here ip, port: 443 [ 4292 4944][20 Jul 9:27:58][proxy_wrapper] ProxyWrapper::DirectConnect: Starting ... [ 4292 4944][20 Jul 9:27:58][proxy_wrapper] ProxyWrapper::DirectConnect: using wsa [ 4292 4944][20 Jul 9:27:58][proxy_wrapper] ProxyWrapper::DoConnect: init connect successfuly [ 4292 4944][20 Jul 9:27:58][proxy_wrapper] ProxyWrapper::Connect: Successfully init connect [ 4292 4944][20 Jul 9:27:59][] fwasync_conn_params: <52.70.168.192:2768> -> <196.100.216.197:443> [ 4292 4944][20 Jul 9:27:59][] fwasync_conn_params: <c0a84634,2768> -> <c5d864c4,443> [ 4292 4944][20 Jul 9:27:59][proxy_wrapper] ProxyWrapper::DirectNewConnHandler: Starting ... [ 4292 4944][20 Jul 9:27:59][proxy_wrapper] ProxyWrapper::DirectNewConnHandler: Successfully connected direct with state NO_PRX_STATE [ 4292 4944][20 Jul 9:27:59][proxy_wrapper] ProxyWrapper::NotifyConnect: Starting ... prxConnHandle is 36958528 [ 4292 4944][20 Jul 9:27:59][proxy_wrapper] ProxyWrapper::NotifyConnect: prxConnHandle is: 36958528 conn state is NO_PRX_STATE [ 4292 4944][20 Jul 9:27:59][proxy_wrapper] ProxyWrapper::NotifyConnect: note: conn managment - do not reset the conn - in order to release it later - if it is reset then there is no way to notify the FW later in order to remove the rule [ 4292 4944][20 Jul 9:27:59][proxy_wrapper] ProxyWrapper::NotifyConnect: *** conn address is: 56210832 [ 4292 4944][20 Jul 9:27:59][proxy_wrapper] ProxyWrapper::NotifyConnect: *** conn address is: 56210832 [ 4292 4944][20 Jul 9:27:59][proxy_wrapper] ProxyWrapper::NotifyConnect: Setting proxy global state to NO_PRX_STATE [ 4292 4944][20 Jul 9:27:59][proxy_wrapper] ProxyWrapper::NotifyConnect: Notify a successful connect [ 4292 4944][20 Jul 9:27:59][] fwasync_conn_get: get max buffer size (1048576) . [ 4292 4944][20 Jul 9:27:59][] fwasync_connbuf_realloc: reallocating 0 from 0 to 66560 [ 4292 4944][20 Jul 9:27:59][] T_event_do_WSAresume: not resuming IN operation - it was not suspended [ 4292 4944][20 Jul 9:27:59][] fwasync_connbuf_realloc: reallocating 0 from 0 to 1044 [ 4292 4944][20 Jul 9:27:59][] T_event_do_WSAresume: WSAEventSelect failed: Invalid Argument [ 4292 4944][20 Jul 9:27:59][] T_event_WSAEventSelect: SetEvent failed: Неверный дескриптор. [ 4292 4944][20 Jul 9:27:59][ike_transport] IkeTransport::IkeT_NotifyConnect: __start__ 9:27:59.40 [ 4292 4944][20 Jul 9:27:59][ike_transport] IkeTransport::IkeT_NotifyConnect: __end__ 9:27:59.40. Total time - 0 milliseconds [ 4292 4944][20 Jul 9:27:59][esp_transport] EspTransport::EspT_NotifyConnect: __start__ 9:27:59.40 [ 4292 4944][20 Jul 9:27:59][tunnel] IkeV1Tunnel::EspT_ReceivedConnect: started, mTunnelState: 1, ConnectSuccess=1 [ 4292 4944][20 Jul 9:27:59][tunnel] IkeV1Tunnel::EspT_ReceivedConnect: 1: , mTunnelState: 1, ConnectSuccess:1 [ 4292 4944][20 Jul 9:27:59][esp_transport] EspTransport::EspT_NotifyConnect: __end__ 9:27:59.40. Total time - 0 milliseconds [ 4292 4944][20 Jul 9:27:59][] fwasync_conn_get: get max buffer size (1048576) . [ 4292 4944][20 Jul 9:27:59][] fwasync_conn_get: get max buffer size (1048576) . [ 4292 4944][20 Jul 9:27:59][ike_transport] IkeTransport::IkeT_NotifyConnect: __start__ 9:27:59.257 [ 4292 4944][20 Jul 9:27:59][IKE] **** create_MM1: Create packet 1 [ 4292 4944][20 Jul 9:27:59][IKE] **** <user-name-password, 28800 secs> [ 4292 4944][20 Jul 9:27:59][IKE] create_MM1: multi_realms is enabled. [ 4292 4944][20 Jul 9:27:59][IKE] create_MM1: machine authentication is enabled. [ 4292 4944][20 Jul 9:27:59][ike_transport] IkeTransport::setIkeCacheTimeout: setting ike_cache_timeout to 0 [ 4292 4944][20 Jul 9:27:59][ike_transport] IkeTransport::setIkeCacheTimeout: setting ike_cache_timeout to 0 [ 4292 4944][20 Jul 9:27:59][transport] AutoDetect_Transport::IkeT_PacketSend: start... [ 4292 4944][20 Jul 9:27:59][ike_transport] IkeTransport::IkeT_NotifyConnect: __end__ 9:27:59.258. Total time - 1 milliseconds [ 4292 4944][20 Jul 9:27:59][esp_transport] EspTransport::EspT_NotifyConnect: __start__ 9:27:59.258 [ 4292 4944][20 Jul 9:27:59][esp_transport] EspTransport::EspT_NotifyConnect: __end__ 9:27:59.258. Total time - 0 milliseconds [ 4292 4944][20 Jul 9:27:59][] fwasync_conn_get: get max buffer size (1048576) . [ 4292 4944][20 Jul 9:27:59][IKE] **** MM2PacketHandler: Receive packet 2: Main Mode packet, cookies 87cb30683ad68105,22e757b50e7c590d, length 220, 6 payloads [ 4292 4944][20 Jul 9:27:59][IKE] DEBUG MM2PacketHandler: Receive policy_id notification payload [ 4292 4944][20 Jul 9:27:59][FLOW] TrConnEngineConnectStep::update_policy_ID: got gw policy ID [ 4292 4944][20 Jul 9:27:59][FLOW] 82 ee eb 60 [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrConnEngineConnectStep::update_policy_ID: Full flow. No need to check for new policy [ 4292 4944][20 Jul 9:27:59][IKE] DEBUG MM2PacketHandler: did NOT receive login_options notification payload [ 4292 4944][20 Jul 9:27:59][CONFIG_MANAGER] site_uses_login_options return value false, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TrConnEngineConnectStep::update_login_option_ID: site here ip does not support login option - nothing to do [ 4292 4944][20 Jul 9:27:59][IKE] DEBUG MM2PacketHandler: pfs support disabled on GW [ 4292 4944][20 Jul 9:27:59][IKE] DEBUG MM2PacketHandler: will check now if machine authentication is required [ 4292 4944][20 Jul 9:27:59][IKE] MM2PacketHandler: Agreed enc-alg 5 (key-length param 0) [ 4292 4944][20 Jul 9:27:59][IKE] MM2PacketHandler hash-alg 2, group 2 [ 4292 4944][20 Jul 9:27:59][IKE] **** create_MM3: Create packet 3 [ 4292 4944][20 Jul 9:27:59][IKE] **** Cookies 6830cb870581d63a b557e7220d597c0e [ 4292 4944][20 Jul 9:27:59][IKE] **** DH group isakmp1024 (2) key, 20 bytes nonce [ 4292 4944][20 Jul 9:27:59][] cpSDH_imp::cpSDH_imp: Cannot find DH pre computation for group - isakmp1024. Will compute without pre computation. [ 4292 4944][20 Jul 9:27:59][IKE] ike_hash_method_to_alg: hash method is 2 = SHA1 [ 4292 4944][20 Jul 9:27:59][IKE] compute_nat_d_hash: MAC algorithm 2 [ 4292 4944][20 Jul 9:27:59][IKE] 51 fc 3d cd 47 8e 37 b0 dc 1a 5e 4e da 36 6f 6b ac e3 9d 1d [ 4292 4944][20 Jul 9:27:59][IKE] ike_hash_method_to_alg: hash method is 2 = SHA1 [ 4292 4944][20 Jul 9:27:59][IKE] compute_nat_d_hash: MAC algorithm 2 [ 4292 4944][20 Jul 9:27:59][IKE] d6 15 56 d6 b7 d6 74 46 de 8a 5f 34 67 69 79 3d c3 12 97 d8 [ 4292 4944][20 Jul 9:27:59][ike_transport] IkeTransport::setIkeCacheTimeout: setting ike_cache_timeout to 36 [ 4292 4944][20 Jul 9:27:59][ike_transport] IkeTransport::setIkeCacheTimeout: setting ike_cache_timeout to 36 [ 4292 4944][20 Jul 9:27:59][transport] AutoDetect_Transport::IkeT_PacketSend: start... [ 4292 4944][20 Jul 9:27:59][] fwasync_conn_get: get max buffer size (1048576) . [ 4292 4944][20 Jul 9:27:59][IKE] **** MM4PacketHandler: Receive packet 4: Main Mode packet, cookies 87cb30683ad68105,22e757b50e7c590d, length 256, 5 payloads [ 4292 4944][20 Jul 9:27:59][IKE] MM4PacketHandler: Store gw nonce (20 bytes) [ 4292 4944][20 Jul 9:27:59][IKE] MM4PacketHandler: Process gw DH public key (128 bytes) [ 4292 4944][20 Jul 9:27:59][IKE] MM4PacketHandler: Store DH shared key (128 bytes) [ 4292 4944][20 Jul 9:27:59][IKE] c2 e0 3b 1c 73 a3 04 b4 c1 a7 31 85 e5 30 c9 41 [ 4292 4944][20 Jul 9:27:59][IKE] **** create_MM5(hybrid authentication): Create packet 5 [ 4292 4944][20 Jul 9:27:59][clips_gen_utils] ClipsGeneralUtils::getSerializedAuthenticationBlob: Entering... [ 4292 4944][20 Jul 9:27:59][IKE] create_MM5(hybrid authentication): authentication blob ( :clientType (TRAC) :oldSessionId () :protocolVersion (100) :client_mode (endpoint_security) :client_logging_data ( :device_id ("{2A7E3147-C042-4CAB-B06E-2A3FE8C8C8AB}") :client_name ("Endpoint Security VPN") :client_ver (E83.10) :client_build_number (986101816) :device_type (PC) :os_name (Windows) :os_version (10) :os_edition (Professional) :os_service_pack () :os_build (19042) :os_bits (64bit) :machine_domain () :machine_name (NR032) :physical_ip (here ip) :mac_address ("02:28:7f:61:1e:0c,94:de:80:7f:5b:23,54:f2:22:ff:50:0b") ) ) [ 4292 4944][20 Jul 9:27:59][IKE] ike_hash_method_to_alg: hash method is 2 = SHA1 [ 4292 4944][20 Jul 9:27:59][IKE] b5 16 d3 34 e0 48 6c b2 de 89 a1 96 81 29 e5 79 [ 4292 4944][20 Jul 9:27:59][IKE] c7 8a f0 62 c2 68 be 44 07 b5 e1 e3 b8 7e 86 a6 [ 4292 4944][20 Jul 9:27:59][IKE] d5 e8 e8 97 65 cf fb f8 19 25 a8 9f 35 43 be 7e [ 4292 4944][20 Jul 9:27:59][IKE] 81 e5 79 87 52 f9 3c 5f 8c f6 cc 9f b6 60 96 e3 [ 4292 4944][20 Jul 9:27:59][IKE] e9 29 7f 45 3f 24 59 73 f1 f7 95 45 e9 0f 33 67 [ 4292 4944][20 Jul 9:27:59][IKE] 83 66 b9 de eb 73 13 c9 83 39 32 a8 62 c6 8d 38 [ 4292 4944][20 Jul 9:27:59][IKE] ike_hash_method_to_alg: hash method is 2 = SHA1 [ 4292 4944][20 Jul 9:27:59][IKE] 00 00 00 00 00 00 00 01 00 00 02 c0 01 01 00 12 03 00 00 28 [ 4292 4944][20 Jul 9:27:59][IKE] 01 01 00 00 80 01 00 07 80 0e 00 80 80 02 00 02 80 04 00 02 [ 4292 4944][20 Jul 9:27:59][IKE] 80 03 fa dd 80 0b 00 01 00 0c 00 04 00 00 70 80 03 00 00 28 [ 4292 4944][20 Jul 9:27:59][IKE] 02 01 00 00 80 01 00 07 80 0e 00 80 80 02 00 01 80 04 00 02 [ 4292 4944][20 Jul 9:27:59][IKE] 80 03 fa dd 80 0b 00 01 00 0c 00 04 00 00 70 80 03 00 00 28 [ 4292 4944][20 Jul 9:27:59][IKE] 03 01 00 00 80 01 00 07 80 0e 01 00 80 02 00 02 80 04 00 02 [ 4292 4944][20 Jul 9:27:59][IKE] 80 03 fa dd 80 0b 00 01 00 0c 00 04 00 00 70 80 03 00 00 28 [ 4292 4944][20 Jul 9:27:59][IKE] 04 01 00 00 80 01 00 07 80 0e 01 00 80 02 00 01 80 04 00 02 [ 4292 4944][20 Jul 9:27:59][IKE] 80 03 fa dd 80 0b 00 01 00 0c 00 04 00 00 70 80 03 00 00 24 [ 4292 4944][20 Jul 9:27:59][IKE] 05 01 00 00 80 01 00 05 80 02 00 02 80 04 00 02 80 03 fa dd [ 4292 4944][20 Jul 9:27:59][IKE] 80 0b 00 01 00 0c 00 04 00 00 70 80 03 00 00 24 06 01 00 00 [ 4292 4944][20 Jul 9:27:59][IKE] 80 01 00 05 80 02 00 01 80 04 00 02 80 03 fa dd 80 0b 00 01 [ 4292 4944][20 Jul 9:27:59][IKE] 00 0c 00 04 00 00 70 80 03 00 00 28 07 01 00 00 80 01 00 07 [ 4292 4944][20 Jul 9:27:59][IKE] 80 0e 00 80 80 02 00 02 80 04 00 0e 80 03 fa dd 80 0b 00 01 [ 4292 4944][20 Jul 9:27:59][IKE] 00 0c 00 04 00 00 70 80 03 00 00 28 08 01 00 00 80 01 00 07 [ 4292 4944][20 Jul 9:27:59][IKE] 80 0e 00 80 80 02 00 01 80 04 00 0e 80 03 fa dd 80 0b 00 01 [ 4292 4944][20 Jul 9:27:59][IKE] 00 0c 00 04 00 00 70 80 03 00 00 28 09 01 00 00 80 01 00 07 [ 4292 4944][20 Jul 9:27:59][IKE] 80 0e 01 00 80 02 00 02 80 04 00 0e 80 03 fa dd 80 0b 00 01 [ 4292 4944][20 Jul 9:27:59][IKE] 00 0c 00 04 00 00 70 80 03 00 00 28 0a 01 00 00 80 01 00 07 [ 4292 4944][20 Jul 9:27:59][IKE] 80 0e 01 00 80 02 00 01 80 04 00 0e 80 03 fa dd 80 0b 00 01 [ 4292 4944][20 Jul 9:27:59][IKE] 03 00 00 00 [ 4292 4944][20 Jul 9:27:59][IKE] a2 4b 42 d4 6e d4 a8 9b 8b 02 cc 7c 44 45 6b 72 44 19 8e f9 [ 4292 4944][20 Jul 9:27:59][IKE] compute_phase1_enc_key: skeyid_e_key_len = 20, enc_keylen = 24 [ 4292 4944][20 Jul 9:27:59][IKE] ike_hash_method_to_alg: hash method is 2 = SHA1 [ 4292 4944][20 Jul 9:27:59][IKE] compute_phase1_enc_key: key1 len =20 , key2 len =20, key3 len =20 [ 4292 4944][20 Jul 9:27:59][IKE] compute_phase1_enc_key: key len =60 , enc_keylen = 24 [ 4292 4944][20 Jul 9:27:59][IKE] 7b 67 42 0d d7 d4 4c 70 80 0c e9 46 be 7e 10 c7 [ 4292 4944][20 Jul 9:27:59][IKE] ike_hash_method_to_alg: hash method is 2 = SHA1 [ 4292 4944][20 Jul 9:27:59][IKE] compute_IV: creating new IV [ 4292 4944][20 Jul 9:27:59][IKE] fd f5 26 e1 c9 3c dd bb 11 b9 95 83 97 c5 2e 8e [ 4292 4944][20 Jul 9:27:59][IKE_SA_DB] Adding SA for cookies: 6830cb870581d63a b557e7220d597c0e [ 4292 4944][20 Jul 9:27:59][IKE_SA_DB] IkeSADB::SADB_AddSa :added to the IkeSADB [ 4292 4944][20 Jul 9:27:59][IKE_SEC_ASSOC] IkeSecAssoc::Encrypt :- start encrypting packet [ 4292 4944][20 Jul 9:27:59][IKE_SEC_ASSOC] IkeSecAssoc::Encrypt :length=648 [ 4292 4944][20 Jul 9:27:59][ike_transport] IkeTransport::setIkeCacheTimeout: setting ike_cache_timeout to 0 [ 4292 4944][20 Jul 9:27:59][ike_transport] IkeTransport::setIkeCacheTimeout: setting ike_cache_timeout to 0 [ 4292 4944][20 Jul 9:27:59][transport] AutoDetect_Transport::IkeT_PacketSend: start... [ 4292 4944][20 Jul 9:27:59][] fwasync_conn_get: get max buffer size (1048576) . [ 4292 4944][20 Jul 9:27:59][IKE] **** InformationalPktEventHandler: Receive Information packet: Informational packet, cookies 87cb30683ad68105,22e757b50e7c590d [ 4292 4944][20 Jul 9:27:59][rais] [DEBUG] [RaisMessages::CreateMessageSet(s)] message: (msg_obj :format (1.0) :id (ClipsMessagesInternalError) :def_msg ("Internal error; connection failed. More details may be available in the logs") :arguments () ) [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrConnEngineConnectStep::operation_failed: Cb arrived [ 4292 4944][20 Jul 9:27:59][FLOW] TrConnEngineConnectStep::operation_failed: user message set: (msg_obj :format (1.0) :id (ClipsMessagesInternalError) :def_msg ("Internal error; connection failed. More details may be available in the logs") :arguments () ) [ 4292 4944][20 Jul 9:27:59][String] String::String::Translate (fwset): Message has been translated to string: Internal error; connection failed. More details may be available in the logs [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TrConnEngineConnectStep::operation_failed: Translated user message: Internal error; connection failed. More details may be available in the logs [ 4292 4944][20 Jul 9:27:59][String] String::String::Translate: String with id 429 has been translated to string: Checking if connectivity parameters have changed on site [ 4292 4944][20 Jul 9:27:59][FLOW] TrPrimaryConnFlow::GetFlowType: mIsPrimaryConn: 1, misUpdateSiteFlow: 0 [ 4292 4944][20 Jul 9:27:59][TR_FLOW] TR_FLOW::TrBaseFlow::FinishStep: <------------------------------------- (1) Step 8 (class TrConnEngineConnectStep) finished with status -7002 - TrFlowRestart [ 4292 4944][20 Jul 9:27:59][TR_FLOW] TR_FLOW::TrBaseFlow::FinishStep: Step failed [ 4292 4944][20 Jul 9:27:59][FLOW] TrPrimaryConnFlow::GetFlowType: mIsPrimaryConn: 1, misUpdateSiteFlow: 0 [ 4292 4944][20 Jul 9:27:59][FLOW] TrPrimaryConnFlow::GetFlowType: mIsPrimaryConn: 1, misUpdateSiteFlow: 0 [ 4292 4944][20 Jul 9:27:59][TR_SRV2CL] TR_SRV2CL::SendNotification: Successfully sent notification of type TR_NOTIFICATION_CONNECTION_PROGRESS [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] TR_CONN_MANAGER::ConnEventMainHandler: Current connection state is TR_CONN_STATE_CONNECTING. Receiving event of type CONN_EVENT_FLOW_FAILED. Connection handle = 4. System state: TR_SYSTEM_STATE_RUNNING [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] ConnEventMainHandler: event for tunnel 1. tunnel state is TR_CONN_STATE_CONNECTING [ 4292 4944][20 Jul 9:27:59][CONFIG_MANAGER] gw_ipaddr return value here ip, because it is Gateway config variable. Scope: site here ip ,gw NULL ,user USER [ 4292 4944][20 Jul 9:27:59][CONFIG_MANAGER] suspend_tunnel_while_locked return value false, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:59][XmlWrapper] XmlDocument::XmlDocument: inside [ 4292 4944][20 Jul 9:27:59][XmlWrapper] XmlDocument::SaveString: inside [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] diagnostic_reporter: entering... [ 4292 4944][20 Jul 9:27:59][TR_SRV2CL] TR_SRV2CL::SendNotification: client is not registered to this type of notification - TR_NOTIFICATION_DIGNOSTIC [ 4292 4944][20 Jul 9:27:59][CONFIG_MANAGER] gw_ipaddr return value here ip, because it is Gateway config variable. Scope: site here ip ,gw NULL ,user USER [ 4292 4944][20 Jul 9:27:59][CONFIG_MANAGER] gw_ipaddr return value here ip, because it is Gateway config variable. Scope: site here ip ,gw NULL ,user USER [ 4292 4944][20 Jul 9:27:59][XmlWrapper] XmlDocument::XmlDocument: inside [ 4292 4944][20 Jul 9:27:59][XmlWrapper] XmlDocument::SaveString: inside [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] diagnostic_reporter: entering... [ 4292 4944][20 Jul 9:27:59][TR_SRV2CL] TR_SRV2CL::SendNotification: client is not registered to this type of notification - TR_NOTIFICATION_DIGNOSTIC [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] TunnelEventConnectingHandler: Flow failed - cancelling connection (1) [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] TR_CONN_MANAGER::ConnCancel: CANCELLING FLOW [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] TR_CONN_MANAGER::isFullCleanUpRequired: gw is primary [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] isAllGWsAreAboutToDisconnect: GW details: type=Primary mGwDisplayName=initial gw , mGwName=initial gw [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] TR_CONN_MANAGER::isAllGWsAreAboutToDisconnect: skip this one [ 4292 4944][20 Jul 9:27:59][TR_FEATURE_MANAGER] TR_FEATURE_MANAGER::isMultiSiteEnabled: enter... [ 4292 4944][20 Jul 9:27:59][TR_FEATURE_MANAGER] isMultiSiteEnabled: client type is not SECURE_REMOTE_TYPE -> multi-site cannot be supported -> abort [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] TR_CONN_MANAGER::isAllGWsAreAboutToDisconnect: not found running GW -> all GWS disconnecting -> return true [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] TR_CONN_MANAGER::isFullCleanUpRequired: all GWs disconnected -> run full cleanup (regardless of primary or not) [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] TR_CONN_MANAGER::ConnCancelAllGWs: enter... [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] TR_CONN_MANAGER::ConnCancelAllGWs: CANCELLING ALL TUNNELS FLOW (full cleanup) [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] ConnCancelAllGWs: isFatalError = false [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] TR_CONN_MANAGER::ConnCancelAllGWs: about to cancel all GWs due to 'full clean up' [ 4292 4944][20 Jul 9:27:59][TR_FEATURE_MANAGER] TR_FEATURE_MANAGER::isMultiSiteEnabled: enter... [ 4292 4944][20 Jul 9:27:59][TR_FEATURE_MANAGER] isMultiSiteEnabled: client type is not SECURE_REMOTE_TYPE -> multi-site cannot be supported -> abort [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] TR_CONN_MANAGER::ConnCancelAllGWs: multi-site disabled -> about to cancel all GWs in the site [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] TR_CONN_MANAGER::ConnCancelSite: enter... [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] ConnCancelSite: about to cancel all tunnel for site 4 (here ip) [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] TR_CONN_MANAGER::ConnCancelSite: about to cancel all GWs due to 'full clean up' [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] TR_CONN_MANAGER::ConnCancelSite: mark full cleanup on the flow... [ 4292 4944][20 Jul 9:27:59][FLOW] TrBaseFlow::setIsFullCleanup: IsFullCleanup change it from 1 to 1 [ 4292 4944][20 Jul 9:27:59][TR_FLOW] TR_FLOW::TrPrimaryConnFlow::RunPostDisconnectFlow: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW] TR_FLOW::TrPrimaryConnFlow::GetPostDisconnectFlowModeFromConfig: Entering... [ 4292 4944][20 Jul 9:27:59][CONFIG_MANAGER] post_disconnect_mode return value 0, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] ConnCancelSite: site name is 'here ip' [ 4292 4944][20 Jul 9:27:59][TR_FLOW] TR_FLOW::TrPrimaryConnFlow::Cancel: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW] TR_FLOW::TrPrimaryConnFlow::CancelDisconnect: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW] TR_FLOW::TrPrimaryConnFlow::CancelReconnect: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW] TR_FLOW::TrPrimaryConnFlow::CancelReauthentication: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW] TR_FLOW::TrPrimaryConnFlow::CancelPostDisconnectFlow: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW] TR_FLOW::TrBaseFlow::Cancel: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrConnEngineConnectStep::Cancel: called [ 4292 4944][20 Jul 9:27:59][TR_OFFICE_MODE] TrOfficeMode::DeschedVerifyVnaRoutes: Descheduling routing table verification [ 4292 4944][20 Jul 9:27:59][TR_AUTH_MANAGER] TrAuthenticationManager::AbortAuthRequest: __start__ 9:27:59.968 [ 4292 4944][20 Jul 9:27:59][TR_AUTH_MANAGER] TrCredKey::TrCredKey: creating credKey [ 4292 4944][20 Jul 9:27:59][TR_AUTH_MANAGER] TrAuthCache::GetSiteAuthReq: entering - item (gw = here ip) [ 4292 4944][20 Jul 9:27:59][TR_AUTH_MANAGER] TrAuthCache::UpdateSettings: same cache expiration setting. no change needed for (gw = here ip) [ 4292 4944][20 Jul 9:27:59][TR_AUTH_MANAGER] TrAuthenticationManager::AbortAuthRequest: removing 22d0968 [ 4292 4944][20 Jul 9:27:59][auth_IS] auth_IS::BaseAuth::RemoveReplyCB: cb object was not found [ 4292 4944][20 Jul 9:27:59][TR_EVENTS] TR_EVENTS::Raise: No registered cbs for event 2bdef18 [ 4292 4944][20 Jul 9:27:59][TR_AUTH_MANAGER] TrAuthenticationManager::AbortAuthRequest: __end__ 9:27:59.968. Total time - 0 milliseconds [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrConnEngineConnectStep::Cancel: Sending disconnect to GW [ 4292 4944][20 Jul 9:27:59][tunnel] IkeV1Tunnel::cancel_connect: started [ 4292 4944][20 Jul 9:27:59][tunnel] IkeV1Tunnel::notifyGwSADeletion: started [ 4292 4944][20 Jul 9:27:59][IKE_SA_DB] IkeSADB::CleanIkeSADB: started [ 4292 4944][20 Jul 9:27:59][IKE_SA_DB] IkeSADB::CleanIkeSADB: removing Ike SA [ 4292 4944][20 Jul 9:27:59][IKE] IkeTunnel::StopKeepAlive: entering. [ 4292 4944][20 Jul 9:27:59][] T_event_do_del: no event for socket/type: 2312/1 [ 4292 4944][20 Jul 9:27:59][proxy_wrapper] ProxyWrapper::CancelConnect: Starting ... prxConn is 36958528 [ 4292 4944][20 Jul 9:27:59][proxy_wrapper] ProxyWrapper::print_connectivity_analysis_request_queue: Starting ... [ 4292 4944][20 Jul 9:27:59][proxy_wrapper] ProxyWrapper::print_connectivity_analysis_request_queue: request list is empty. [ 4292 4944][20 Jul 9:27:59][proxy_wrapper] ProxyWrapper::removeConnFrom_ProxyConnectivityAnalysisRequestQueue : Starting ...prxConnHandle is 36958528 [ 4292 4944][20 Jul 9:27:59][proxy_wrapper] ProxyWrapper::removeConnFrom_ProxyConnectivityAnalysisRequestQueue : about to look for the handle in the list... (0 elements) [ 4292 4944][20 Jul 9:27:59][proxy_wrapper] ProxyWrapper::removeConnFrom_ProxyConnectivityAnalysisRequestQueue : prxConnHandle is not found in the queue [ 4292 4944][20 Jul 9:27:59][proxy_wrapper] ProxyWrapper::CancelConnect: Proxy connection is in init state. Cannot cancel connection [ 4292 4944][20 Jul 9:27:59][proxy_wrapper] ProxyWrapper::CloseProxyConn: Starting ... [ 4292 4944][20 Jul 9:27:59][proxy_wrapper] ProxyWrapper::CancelConnect: Starting ... prxConn is 36958528 [ 4292 4944][20 Jul 9:27:59][proxy_wrapper] ProxyWrapper::print_connectivity_analysis_request_queue: Starting ... [ 4292 4944][20 Jul 9:27:59][proxy_wrapper] ProxyWrapper::print_connectivity_analysis_request_queue: request list is empty. [ 4292 4944][20 Jul 9:27:59][proxy_wrapper] ProxyWrapper::removeConnFrom_ProxyConnectivityAnalysisRequestQueue : Starting ...prxConnHandle is 36958528 [ 4292 4944][20 Jul 9:27:59][proxy_wrapper] ProxyWrapper::removeConnFrom_ProxyConnectivityAnalysisRequestQueue : about to look for the handle in the list... (0 elements) [ 4292 4944][20 Jul 9:27:59][proxy_wrapper] ProxyWrapper::removeConnFrom_ProxyConnectivityAnalysisRequestQueue : prxConnHandle is not found in the queue [ 4292 4944][20 Jul 9:27:59][proxy_wrapper] ProxyWrapper::CancelConnect: Proxy connection is in init state. Cannot cancel connection [ 4292 4944][20 Jul 9:27:59][proxy_wrapper] ProxyWrapper::CloseProxyConn: about to check prxConnHandle->ConnProxyEntity [ 4292 4944][20 Jul 9:27:59][proxy_wrapper] ProxyWrapper::CloseProxyConn:closed a tunnel proxy - set tunnel proxy state to false [ 4292 4944][20 Jul 9:27:59][proxy_wrapper] ProxyWrapper::CloseProxyConn: done. [ 4292 4944][20 Jul 9:27:59][transport] UDP_Transport::UDP_Cleanup entering ... [ 4292 4944][20 Jul 9:27:59][transport] UDP_Transport::UDP_Cleanup this = 56046200 [ 4292 4944][20 Jul 9:27:59][trac] [COVERAGE] [TrMachineConfigManager::IsMachineOnlyConfigured(s)] __start__ [ 4292 4944][20 Jul 9:27:59][trac] [COVERAGE] [TrMachineConfigManager::isMachineAuthenticationEnabled(s)] __start__ [ 4292 4944][20 Jul 9:27:59][CONFIG_MANAGER] enable_machine_auth return value true, because it is Default variable. Scope: site NULL, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:59][trac] [INFO] [TrMachineConfigManager::isMachineAuthenticationEnabled(s)] Machine authentication is enabled. [ 4292 4944][20 Jul 9:27:59][trac] [COVERAGE] [TrMachineConfigManager::isMachineAuthenticationEnabled(s)] __end__ Total: 0 milliseconds. [ 4292 4944][20 Jul 9:27:59][trac] [COVERAGE] [TrMachineConfigManager::isMachineOnlyDefaultSiteConfigured(s)] __start__ [ 4292 4944][20 Jul 9:27:59][trac] [COVERAGE] [TrMachineConfigManager::getMachineOnlyDefaultSite(s)] __start__ [ 4292 4944][20 Jul 9:27:59][CONFIG_MANAGER] machine_tunnel_site return value , because it is Default variable. Scope: site NULL, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:59][trac] [INFO] [TrMachineConfigManager::getMachineOnlyDefaultSite(s)] No valid machine tunnel site is is configured. [ 4292 4944][20 Jul 9:27:59][trac] [COVERAGE] [TrMachineConfigManager::getMachineOnlyDefaultSite(s)] __end__ Total: 0 milliseconds. [ 4292 4944][20 Jul 9:27:59][trac] [COVERAGE] [TrMachineConfigManager::isMachineOnlyDefaultSiteConfigured(s)] __end__ Total: 0 milliseconds. [ 4292 4944][20 Jul 9:27:59][trac] [INFO] [TrMachineConfigManager::IsMachineOnlyConfigured(s)] Machine only is not configured. [ 4292 4944][20 Jul 9:27:59][trac] [COVERAGE] [TrMachineConfigManager::IsMachineOnlyConfigured(s)] __end__ Total: 0 milliseconds. [ 4292 4944][20 Jul 9:27:59][CONFIG_MANAGER] authentication_method return value username-password, because it is User config variable. Scope: site here ip ,gw NULL ,user USER [ 4292 4944][20 Jul 9:27:59][TR_FLOW] TrBaseFlow::ResetAuthMethod: Resetting the authentication method, cur_auth_method=username-password, set org_auth_method=username-password [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrBaseConnStep::Cancel: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrGetAuthInfoStep::Cancel: Cleaning up [ 4292 4944][20 Jul 9:27:59][TR_AUTH_MANAGER] TrAuthenticationManager::AbortAuthRequest: __start__ 9:27:59.969 [ 4292 4944][20 Jul 9:27:59][TR_AUTH_MANAGER] TrCredKey::TrCredKey: creating credKey [ 4292 4944][20 Jul 9:27:59][TR_AUTH_MANAGER] TrAuthCache::GetSiteAuthReq: entering - item (gw = here ip) [ 4292 4944][20 Jul 9:27:59][TR_AUTH_MANAGER] TrAuthCache::UpdateSettings: same cache expiration setting. no change needed for (gw = here ip) [ 4292 4944][20 Jul 9:27:59][TR_AUTH_MANAGER] TrAuthenticationManager::AbortAuthRequest: removing 353ef80 [ 4292 4944][20 Jul 9:27:59][auth_IS] auth_IS::BaseAuth::RemoveReplyCB: cb object was not found [ 4292 4944][20 Jul 9:27:59][TR_EVENTS] TR_EVENTS::Raise: No registered cbs for event 2bdef18 [ 4292 4944][20 Jul 9:27:59][TR_AUTH_MANAGER] TrAuthenticationManager::AbortAuthRequest: __end__ 9:27:59.969. Total time - 0 milliseconds [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrBaseConnStep::Cancel: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrUpgradeClientStep::Cancel: entering... [ 4292 4944][20 Jul 9:27:59][UPGRADE_MANAGER] UpgradeManager::CancelUpgrade: clean resources [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrBaseConnStep::Cancel: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP:: TrRealmConfigStep::Cancel: entering... [ 4292 4944][20 Jul 9:27:59][FLOW] TrPrimaryConnFlow::GetFlowType: mIsPrimaryConn: 1, misUpdateSiteFlow: 0 [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrBaseConnStep::Cancel: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrClientHelloStep::Cancel: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrBaseConnStep::Cancel: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrPokeGWStep::Cancel: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrBaseConnStep::Cancel: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrResolveGwNameStep::Cancel: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrBaseConnStep::Cancel: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrProxyDetectionStep::Cancel: entering... [ 4292 4944][20 Jul 9:27:59][proxysupp] [COVERAGE] [proxyConfigurationImage::RemoveInProgressListener] Listener '0353F2A0' will be removed from notifiers list. [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrBaseConnStep::Cancel: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrCheckNetworkStep::Cancel: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrBaseConnStep::Cancel: entering... [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] TR_CONN_MANAGER::ConnCancelSite: about to delete gwEntry->mFlow [ 4292 4944][20 Jul 9:27:59][TR_FLOW] TR_FLOW::TrPrimaryConnFlow::Dtor: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW] TR_FLOW::TrPrimaryConnFlow::Cancel: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW] TR_FLOW::TrPrimaryConnFlow::CancelDisconnect: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW] TR_FLOW::TrPrimaryConnFlow::CancelReconnect: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW] TR_FLOW::TrPrimaryConnFlow::CancelReauthentication: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW] TR_FLOW::TrPrimaryConnFlow::CancelPostDisconnectFlow: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW] TR_FLOW::TrBaseFlow::Cancel: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW] TR_FLOW::TrBaseFlow::Dtor: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrBaseConnStep::Dtor: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrCloseConnectionsStep::Dtor: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrBaseConnStep::Dtor: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrBaseConnStep::Dtor: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::~TrScvStep::Dtor: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrBaseConnStep::Dtor: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrFirewallStep::Dtor: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrBaseConnStep::Dtor: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrBaseConnStep::Dtor: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrVerifyEpsServerStep::Dtor: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrBaseConnStep::Dtor: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrDownloadClSettingStep::Dtor: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrBaseConnStep::Dtor: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrConnEngineConnectStep::Dtor: entering... [ 4292 4944][20 Jul 9:27:59][tunnel] IkeV1Tunnel::cancel_connect: started [ 4292 4944][20 Jul 9:27:59][tunnel] IkeV1Tunnel::notifyGwSADeletion: started [ 4292 4944][20 Jul 9:27:59][IKE_SA_DB] IkeSADB::CleanIkeSADB: started [ 4292 4944][20 Jul 9:27:59][IKE] IkeTunnel::StopKeepAlive: entering. [ 4292 4944][20 Jul 9:27:59][transport] UDP_Transport::UDP_Cleanup entering ... [ 4292 4944][20 Jul 9:27:59][transport] UDP_Transport::UDP_Cleanup this = 56046200 [ 4292 4944][20 Jul 9:27:59][CLIPS_IPSEC_ENC_DEC] Clips_IPSecEncDec::~Clips_IPSecEncDec - started [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrBaseConnStep::Dtor: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrGetAuthInfoStep::Dtor: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrBaseConnStep::Dtor: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrBaseConnStep::Dtor: entering... [ 4292 4944][20 Jul 9:27:59][TR_REALM_CONFIG_MANAGER] TrRealmConfigManager::UnRegisterCB: call to unregister 353eee0 [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrBaseConnStep::Dtor: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrClientHelloStep::Dtor: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrBaseConnStep::Dtor: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrPokeGWStep::Dtor: entering... [ 4292 4944][20 Jul 9:27:59][transport] UDP_Transport::UDP_Cleanup entering ... [ 4292 4944][20 Jul 9:27:59][transport] UDP_Transport::UDP_Cleanup this = 56046520 [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrBaseConnStep::Dtor: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrResolveGwNameStep::Dtor: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrBaseConnStep::Dtor: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrBaseConnStep::Dtor: entering... [ 4292 4944][20 Jul 9:27:59][TR_FLOW_STEP] TR_FLOW_STEP::TrBaseConnStep::Dtor: entering... [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] TR_CONN_MANAGER::ConnCancelSite: about to delete gwEntry->mConnData [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] TR_CONN_MANAGER::ConnCancelSite: done deleting gwEntry->mFlow [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] TR_CONN_MANAGER::DeschedGwRoamingTimeout: Roaming timeout callback is not scheduled [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] ConnCancelSite: Done. return with site name : 'here ip' [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] ConnCancelAllGWs: about to check if IsFirewallPolicyOfGatewayEnforced with site here ip [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] ConnCancelAllGWs: isUpdateSiteFlow false [ 4292 4944][20 Jul 9:27:59][TR_FEATURE_MANAGER] TR_FEATURE_MANAGER::isMultiSiteEnabled: enter... [ 4292 4944][20 Jul 9:27:59][TR_FEATURE_MANAGER] isMultiSiteEnabled: client type is not SECURE_REMOTE_TYPE -> multi-site cannot be supported -> abort [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] TR_CONN_MANAGER::ConnCancelAllGWs: multi-site disabled -> set only the site state to Idle [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] TrConnManager::ConnFlowEntry::setSiteState : about to change site (here ip/4) state - change it from 1-TR_CONN_STATE_CONNECTING to 0-TR_CONN_STATE_IDLE [ 4292 4944][20 Jul 9:27:59][XmlWrapper] XmlDocument::XmlDocument: inside [ 4292 4944][20 Jul 9:27:59][XmlWrapper] XmlDocument::SaveString: inside [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] diagnostic_reporter: entering... [ 4292 4944][20 Jul 9:27:59][TR_SRV2CL] TR_SRV2CL::SendNotification: client is not registered to this type of notification - TR_NOTIFICATION_DIGNOSTIC [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] TR_CONN_MANAGER::ConnCancelAllGWs: stop Upload Logs [ 4292 4944][20 Jul 9:27:59][TR_FIREWALL] UploadLogsComponent::setConnected: m_connected:false, m_logConf=0 [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] TR_CONN_MANAGER::ConnCancelAllGWs: note: about to do FW cleanup [ 4292 4944][20 Jul 9:27:59][TR_SRV2CL] TR_SRV2CL::SendNotification: Successfully sent notification of type TR_NOTIFICATION_TRAFFIC_IDLE [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] ConnUpdateStatusInRegistry: SCUIAPI mode is off. No need to publish state [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] TR_CONN_MANAGER::ConnCancelAllGWs: about to check MEP Alternatives [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] TR_CONN_MANAGER::ConnCancelAllGWs: Invalid encdom [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] TR_CONN_MANAGER::ConnCancelAllGWs: Scheduling another connect try [ 4292 4944][20 Jul 9:27:59][CONFIG_MANAGER] neo_always_connected_retry return value 1, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:59][CONFIG_MANAGER] neo_always_connected_max_retry return value 0, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:59][CONFIG_MANAGER] neo_always_connected_delta_seconds return value 10, because it is Default variable. Scope: site here ip, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:59][TR_CONN_MANAGER] CalcAlwaysConnectRetryTime: neo_always_connected_max_retry is 0, always connect retries will be done according to neo_always_connected_retry [ 4292 4944][20 Jul 9:27:59][trac] [COVERAGE] [TrMachineConfigManager::machineMainEventHandler(s)] __start__ [ 4292 4944][20 Jul 9:27:59][trac] [INFO] [TrMachineConfigManager::machineMainEventHandler(s)] FLOW_FAILED event received. [ 4292 4944][20 Jul 9:27:59][trac] [COVERAGE] [TrMachineConfigManager::machineFlowFailedEventHandler(s)] __start__ [ 4292 4944][20 Jul 9:27:59][trac] [COVERAGE] [TrMachineConfigManager::schedMachineConnectIfNeeded(s)] __start__ [ 4292 4944][20 Jul 9:27:59][trac] [COVERAGE] [TrMachineConfigManager::shouldUseMachineOnly(s)] __start__ [ 4292 4944][20 Jul 9:27:59][trac] [COVERAGE] [TrMachineConfigManager::IsMachineOnlyConfigured(s)] __start__ [ 4292 4944][20 Jul 9:27:59][trac] [COVERAGE] [TrMachineConfigManager::isMachineAuthenticationEnabled(s)] __start__ [ 4292 4944][20 Jul 9:27:59][CONFIG_MANAGER] enable_machine_auth return value true, because it is Default variable. Scope: site NULL, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:59][trac] [INFO] [TrMachineConfigManager::isMachineAuthenticationEnabled(s)] Machine authentication is enabled. [ 4292 4944][20 Jul 9:27:59][trac] [COVERAGE] [TrMachineConfigManager::isMachineAuthenticationEnabled(s)] __end__ Total: 0 milliseconds. [ 4292 4944][20 Jul 9:27:59][trac] [COVERAGE] [TrMachineConfigManager::isMachineOnlyDefaultSiteConfigured(s)] __start__ [ 4292 4944][20 Jul 9:27:59][trac] [COVERAGE] [TrMachineConfigManager::getMachineOnlyDefaultSite(s)] __start__ [ 4292 4944][20 Jul 9:27:59][CONFIG_MANAGER] machine_tunnel_site return value , because it is Default variable. Scope: site NULL, gw NULL ,user USER [ 4292 4944][20 Jul 9:27:59][trac] [INFO] [TrMachineConfigManager::getMachineOnlyDefaultSite(s)] No valid machine tunnel site is is configured. [ 4292 4944][20 Jul 9:27:59][trac] [COVERAGE] [TrMachineConfigManager::getMachineOnlyDefaultSite(s)] __end__ Total: 0 milliseconds. [ 4292 4944][20 Jul 9:27:59][trac] [COVERAGE] [TrMachineConfigManager::isMachineOnlyDefaultSiteConfigured(s)] __end__ Total: 0 milliseconds. [ 4292 4944][20 Jul 9:27:59][trac] [INFO] [TrMachineConfigManager::IsMachineOnlyConfigured(s)] Machine only is not configured. [ 4292 4944][20 Jul 9:27:59][trac] [COVERAGE] [TrMachineConfigManager::IsMachineOnlyConfigured(s)] __end__ Total: 0 milliseconds. [ 4292 4944][20 Jul 9:27:59][trac] [INFO] [TrMachineConfigManager::shouldUseMachineOnly(s)] Machine only should not be used. [ 4292 4944][20 Jul 9:27:59][trac] [COVERAGE] [TrMachineConfigManager::shouldUseMachineOnly(s)] __end__ Total: 0 milliseconds. [ 4292 4944][20 Jul 9:27:59][trac] [COVERAGE] [TrMachineConfigManager::schedMachineConnectIfNeeded(s)] __end__ Total: 0 milliseconds. [ 4292 4944][20 Jul 9:27:59][trac] [COVERAGE] [TrMachineConfigManager::machineFlowFailedEventHandler(s)] __end__ Total: 0 milliseconds. [ 4292 4944][20 Jul 9:27:59][trac] [COVERAGE] [TrMachineConfigManager::machineMainEventHandler(s)] __end__ Total: 0 milliseconds. [ 4292 4944][20 Jul 9:27:59][proxy_wrapper] ProxyWrapper::NotifyEndConnection (3): Starting ... [ 4292 4944][20 Jul 9:27:59][TR_FIREWALL] CFirewallWrapper::RemoveSingleProxyRule (1): entering... my_addr:0, my_port:53258, peer_addr:0, peer_port:0 [ 4292 4944][20 Jul 9:27:59][] CFirewallWrapper::RemoveSingleProxyRule (1): ntohl(my_addr),ntohs(my_port),ntohl(peer_addr),ntohs(peer_port) : <0,2768> -> <0,0> [ 4292 4944][20 Jul 9:27:59][TR_FIREWALL] CFirewallWrapper::RemoveSingleProxyRule (2): entering, src_ip_str=0.0.0.0, src_port=2768, dest_ip_str=0.0.0.0, dest_port=0 [ 4292 4944][20 Jul 9:27:59][TR_FIREWALL] CFirewallWrapper::RemoveSingleProxyRule (2): Firewall Driver Not Initialized [ 4292 4944][20 Jul 9:27:59][TR_REALM_CONFIG_MANAGER] TrRealmConfigManager::SafeUnRegisterCB: object 353eee0 not found in vector [ 4292 4944][20 Jul 9:28:28][TalkCCC] talkccc::idle_timeout_cb: closing CCC [ 4292 4944][20 Jul 9:28:28][TalkCCC] talkccc::Close: Disconnecting ssl tunnel and removing all requests [ 4292 4944][20 Jul 9:28:28][TalkCCC] talkccc::disconnect: CCC is already disconnected
|