OpenVPN Support Forum

Community Support Forum
https://forums.openvpn.net/

OpenVPN using HTTP Proxy

https://forums.openvpn.net/viewtopic.php?t=12787

Page 1 of 1

OpenVPN using HTTP Proxy

Posted: Tue Apr 30, 2013 4:47 pm
by drewsonian
I'm trying to help a client connect to our VPN from behind their HTTP Proxy. Any ideas from looking at this log file what might be happening? Their configuration look right. Would the line that contains "DNS lookup failed on host 'vpn.ikindred.com': <twisted.names.dns.Message instance at 0x0264BAA8>" cause the problem?

Thanks!

Code: Select all

2013-04-30 11:18:58-0400 [-] Log opened.
2013-04-30 11:18:58-0400 [-] Network up
2013-04-30 11:18:58-0400 [-] C:\Program Files (x86)\OpenVPN Technologies\OpenVPN Client\core\library.zip\pyovpn\linux\distroname.py:1: exceptions.DeprecationWarning: The popen2 module is deprecated.  Use the subprocess module.
2013-04-30 11:18:58-0400 [-] ProfileSignatureVerify.verify: <depth=1 err=X509_V_ERR_SELF_SIGNED_CERT_IN_CHAIN: self signed certificate in certificate chain subj=<X509Name object '/CN=OpenVPN Web CA 2013.01.24 13:17:27 UTC ip-10-0-0-131'>> (pyovpn.pki.sign.CertVerifyFailed): client/profsig:14,pki/sign:228
2013-04-30 11:18:58-0400 [-] ClientSettings: extract_trust_group tg=None src='bundled' sign=None pref=False
2013-04-30 11:18:58-0400 [-] ClientSettings: preference 'basic_client' set from source 'bundled'
2013-04-30 11:18:58-0400 [-] ClientSettings: preference 'allow_web_import' set from source 'bundled'
2013-04-30 11:18:58-0400 [-] ClientSettings: preference 'enable_xd_proxy' set from source 'bundled'
2013-04-30 11:18:58-0400 [-] ClientSettings: preference 'enable_connect' set from source 'bundled'
2013-04-30 11:18:58-0400 [-] Schedule swupdate monitor in 120 seconds, range=(120,None), error=False, initial=True
2013-04-30 11:18:59-0400 [-] Successfully imported dynamic localhost root CA into Windows cert store (win32)
2013-04-30 11:18:59-0400 [-] FF CA import (passive): sinhan C:\Users\sinhan\AppData\Roaming\Mozilla\Firefox\Profiles/6nf70816.default
2013-04-30 11:18:59-0400 [-] Successfully imported dynamic localhost root CA into Firefox cert store (win32)
2013-04-30 11:19:00-0400 [-] Updating C:\Windows\system32\drivers\etc\hosts with [('client.openvpn.net', '127.94.0.1')]
2013-04-30 11:19:00-0400 [-] Starting AS Client API 1.8.4.200/MSI
2013-04-30 11:19:00-0400 [-] twisted.web.server.Site starting on 946
2013-04-30 11:19:00-0400 [-] twisted.web.server.Site starting on 944
2013-04-30 11:19:00-0400 [-] ProfileManager: importing bundled profile u'C:/Users/sinhan/AppData/Local/Temp/ovpn.~installer/client.ovpn' {u'owner': u'SINHAN', u'global': True}
2013-04-30 11:19:00-0400 [-] ProfileSignatureVerify.verify: <depth=1 err=X509_V_ERR_SELF_SIGNED_CERT_IN_CHAIN: self signed certificate in certificate chain subj=<X509Name object '/CN=OpenVPN Web CA 2013.01.24 13:17:27 UTC ip-10-0-0-131'>> (pyovpn.pki.sign.CertVerifyFailed): client/profsig:14,pki/sign:228
2013-04-30 11:19:00-0400 [-] ImportProfile: profile sanitized
2013-04-30 11:19:00-0400 [-] twisted.web.server.Site starting on 946
2013-04-30 11:19:00-0400 [-] Updating C:\Windows\system32\drivers\etc\hosts with [('client.openvpn.net', '127.94.0.1'), ('openvpn-client.vpn.ikindred.com', '127.94.0.2')]
2013-04-30 11:19:02-0400 [-] create_desktop_process: starting C:\Program Files (x86)\OpenVPN Technologies\OpenVPN Client\core\ovpntray.exe
2013-04-30 11:19:02-0400 [HTTPChannel,0,127.0.0.1] *** API CALL f=xmlrpc_GetPreferences args=[] kw={} ret={'proxy_auto': True, 'exec_admin_domain': '', 'update_base_url': 'http://swupdate.openvpn.net/updates', 'log_append': False, 'enable_xd_proxy': True, 'basic_client': False, 'auth_allow_cache_pw': True, 'restrict_domain': '*', 'proxy_auth_allow_basic': True, 'trust_group': '', 'proto_force': '', 'allow_ssl_v2': False, 'connect_timeout': 60, 'implicit_elevation': False, 'exec_user_domain': '*', 'universal_sessions_are_global': False, 'reroute_dns_partial': False, 'verb': '', 'proxy_auth_allow_save_pw': True, 'user_may_trust_cert': True, 'silent_update': False, 'route_nopull': False, 'enable_connect': True, 'notify_update': True, 'user_hostspec': '*', 'allow_web_import': True}
2013-04-30 11:19:02-0400 [HTTPChannel,1,127.0.0.1] *** API CALL f=xmlrpc_LocalUserContext args=[True] kw={} ret={'user': u'SINHAN', 'user_is_admin': False}
2013-04-30 11:19:02-0400 [HTTPChannel,2,127.0.0.1] *** API CALL f=xmlrpc_TrackActiveProfiles args=[True] kw={} ret='sess_TrackActiveProfiles_NpUIpS00f9KGbn1g_1'
2013-04-30 11:19:02-0400 [HTTPChannel,3,127.0.0.1] *** API CALL f=xmlrpc_UpdateStatus args=[] kw={} ret={}
2013-04-30 11:19:02-0400 [HTTPChannel,4,127.0.0.1] *** API CALL f=xmlrpc_Poll args=['sess_TrackActiveProfiles_NpUIpS00f9KGbn1g_1', 10] kw={} ret=[{'timestamp': 1367335142, 'state': 'add_profile', 'profile_id': 'vpn_ikindred_com_dynamic_p4303', 'type': 'PROFILE'}]
2013-04-30 11:19:02-0400 [HTTPChannel,5,127.0.0.1] *** API CALL f=xmlrpc_ProfileProperties args=['vpn_ikindred_com_dynamic_p4303'] kw={} ret={'hash': '8836495cbf591275a1668f22891f97c4cbc4bb0453e7c819b007d4848ba05017', 'name': 'vpn.ikindred.com/Dynamic', 'global': True, 'portal_url': 'https://vpn.ikindred.com/', 'host': 'vpn.ikindred.com', 'owner': u'SINHAN', 'org': 'OpenVPN Technologies, Inc.', 'type': ['dynamic'], 'id': 'vpn_ikindred_com_dynamic_p4303', 'access_allowed': True}
2013-04-30 11:19:03-0400 [-] Checking for service profiles
2013-04-30 11:19:48-0400 [-] *** API CALL f=xmlrpc_Poll args=['sess_TrackActiveProfiles_NpUIpS00f9KGbn1g_1', 10] kw={} ret=[{'type': 'PROFILE', 'state': 'connect', 'profile_id': 'vpn_ikindred_com_dynamic_p4303', 'cookie': 'TRAY_CLIENT_U0lOSEFO_zOeBQcFT', 'timestamp': 1367335188}]
2013-04-30 11:19:48-0400 [-] *** API CALL f=xmlrpc_VPNConnect args=[{'async': True, 'managed': 'tray'}] kw={} ret={}
2013-04-30 11:19:48-0400 [HTTPChannel,12,127.0.0.1] *** API CALL f=xmlrpc_ConnectActive args=['vpn_ikindred_com_dynamic_p4303', ['STATE', 'PASSWORD', 'ACTIVE', 'CERT_APPROVAL', 'INFO', 'CONNECTED_USER', 'FATAL', 'SCRIPT', 'CHALLENGE', 'DELETE_PENDING', 'NOTIFY', 'RSA_SIGN', 'CONNECT_TIMEOUT', 'BYTECOUNT'], 'pending'] kw={} ret='sess_vpn_ikindred_com_dynamic_p4303_1VjdyYKTIDWt4p6D_2'
2013-04-30 11:19:48-0400 [HTTPChannel,13,127.0.0.1] *** API CALL f=xmlrpc_Poll args=['sess_vpn_ikindred_com_dynamic_p4303_1VjdyYKTIDWt4p6D_2', 10] kw={} ret=[{'status': 'need', 'timestamp': 1367335188, 'need': ('username', 'password'), 'type': 'PASSWORD', 'auth_type': 'Dynamic'}]
2013-04-30 11:19:50-0400 [HTTPChannel,16,127.0.0.1] *** API CALL f=xmlrpc_Poll args=['sess_TrackActiveProfiles_NpUIpS00f9KGbn1g_1', 10] kw={} ret=[{'timestamp': 1367335190, 'state': 'disconnect', 'profile_id': 'vpn_ikindred_com_dynamic_p4303', 'type': 'PROFILE'}]
2013-04-30 11:19:50-0400 [HTTPChannel,16,127.0.0.1] *** API CALL f=xmlrpc_DisconnectAll args=[] kw={} ret=[(True, ('vpn_ikindred_com_dynamic_p4303', None))]
2013-04-30 11:19:50-0400 [-] *** API CALL f=xmlrpc_Poll args=['sess_vpn_ikindred_com_dynamic_p4303_1VjdyYKTIDWt4p6D_2', 10] kw={} ret=[{'timestamp': 1367335190, 'type': 'DELETE_PENDING'}]
2013-04-30 11:19:50-0400 [-] VPNConnect body: SessionUnspecifiedError
2013-04-30 11:19:50-0400 [HTTPChannel,18,127.0.0.1] *** API CALL f=xmlrpc_EnumProfiles args=[] kw={} ret=[{'hash': '8836495cbf591275a1668f22891f97c4cbc4bb0453e7c819b007d4848ba05017', 'name': 'vpn.ikindred.com/Dynamic', 'global': True, 'portal_url': 'https://vpn.ikindred.com/', 'host': 'vpn.ikindred.com', 'snapshot': {'delete_pending': True, 'password': {'status': 'need', 'timestamp': 1367335188, 'need': ('username', 'password'), 'type': 'PASSWORD', 'auth_type': 'Dynamic'}, 'cookie': 'TRAY_CLIENT_U0lOSEFO_zOeBQcFT'}, 'owner': u'SINHAN', 'org': 'OpenVPN Technologies, Inc.', 'type': ['dynamic'], 'id': 'vpn_ikindred_com_dynamic_p4303', 'access_allowed': True}]
2013-04-30 11:20:33-0400 [HTTPChannel,20,127.0.0.1] *** API CALL f=xmlrpc_Poll args=['sess_TrackActiveProfiles_NpUIpS00f9KGbn1g_1', 10] kw={} ret=[{'type': 'PROFILE', 'state': 'connect', 'profile_id': '54_236_2_63_u6292', 'cookie': 'TRAY_CLIENT_U0lOSEFO_UqdWFke9', 'timestamp': 1367335233}]
2013-04-30 11:20:33-0400 [HTTPChannel,20,127.0.0.1] *** API CALL f=xmlrpc_Connect args=[{'vpn_proto': 'tcp', 'ret_profile_id': True, 'non_interactive': False, 'host': '54.236.2.63', 'cookie': 'TRAY_CLIENT_U0lOSEFO_UqdWFke9', 'new_only': True, 'type': 'universal'}, ['STATE', 'PASSWORD', 'ACTIVE', 'CERT_APPROVAL', 'INFO', 'CONNECTED_USER', 'FATAL', 'SCRIPT', 'CHALLENGE', 'DELETE_PENDING', 'NOTIFY', 'RSA_SIGN', 'CONNECT_TIMEOUT', 'BYTECOUNT'], {}] kw={} ret=('sess_54_236_2_63_u6292_FcqqDWPVouBylcG5_1', '54_236_2_63_u6292')
2013-04-30 11:20:33-0400 [HTTPChannel,22,127.0.0.1] *** API CALL f=xmlrpc_ProfileProperties args=['54_236_2_63_u6292'] kw={} ret={'access_allowed': True, 'global': False, 'host': '54.236.2.63', 'snapshot': {'password': {'status': 'need', 'timestamp': 1367335233, 'need': ('username', 'password'), 'type': 'PASSWORD', 'auth_type': 'Dynamic'}, 'cookie': 'TRAY_CLIENT_U0lOSEFO_UqdWFke9'}, 'owner': u'SINHAN', 'type': ['universal'], 'id': '54_236_2_63_u6292', 'name': '54.236.2.63/Universal'}
2013-04-30 11:20:33-0400 [HTTPChannel,23,127.0.0.1] *** API CALL f=xmlrpc_Poll args=['sess_54_236_2_63_u6292_FcqqDWPVouBylcG5_1', 10] kw={} ret=[{'status': 'need', 'timestamp': 1367335233, 'need': ('username', 'password'), 'type': 'PASSWORD', 'auth_type': 'Dynamic'}]
2013-04-30 11:20:39-0400 [HTTPChannel,24,127.0.0.1] *** API CALL f=xmlrpc_Poll args=['sess_TrackActiveProfiles_NpUIpS00f9KGbn1g_1', 10] kw={} ret=[{'timestamp': 1367335239, 'state': 'disconnect', 'profile_id': '54_236_2_63_u6292', 'type': 'PROFILE'}]
2013-04-30 11:20:39-0400 [HTTPChannel,24,127.0.0.1] *** API CALL f=xmlrpc_DisconnectAll args=[] kw={} ret=[(True, None), (True, ('54_236_2_63_u6292', None))]
2013-04-30 11:20:39-0400 [HTTPChannel,25,127.0.0.1] *** API CALL f=xmlrpc_Poll args=['sess_54_236_2_63_u6292_FcqqDWPVouBylcG5_1', 10] kw={} ret=[{'timestamp': 1367335239, 'type': 'DELETE_PENDING'}]
2013-04-30 11:20:39-0400 [HTTPChannel,27,127.0.0.1] *** API CALL f=xmlrpc_EnumProfiles args=[] kw={} ret=[{'hash': '8836495cbf591275a1668f22891f97c4cbc4bb0453e7c819b007d4848ba05017', 'name': 'vpn.ikindred.com/Dynamic', 'global': True, 'portal_url': 'https://vpn.ikindred.com/', 'host': 'vpn.ikindred.com', 'snapshot': {'delete_pending': True, 'password': {'status': 'need', 'timestamp': 1367335188, 'need': ('username', 'password'), 'type': 'PASSWORD', 'auth_type': 'Dynamic'}, 'cookie': 'TRAY_CLIENT_U0lOSEFO_zOeBQcFT'}, 'owner': u'SINHAN', 'org': 'OpenVPN Technologies, Inc.', 'type': ['dynamic'], 'id': 'vpn_ikindred_com_dynamic_p4303', 'access_allowed': True}, {'access_allowed': True, 'global': False, 'host': '54.236.2.63', 'snapshot': {'delete_pending': True, 'password': {'status': 'need', 'timestamp': 1367335233, 'need': ('username', 'password'), 'type': 'PASSWORD', 'auth_type': 'Dynamic'}, 'cookie': 'TRAY_CLIENT_U0lOSEFO_UqdWFke9'}, 'owner': u'SINHAN', 'type': ['universal'], 'id': '54_236_2_63_u6292', 'name': '54.236.2.63/Universal'}]
2013-04-30 11:20:58-0400 [-] <class 'twisted.names.dns.DNSDatagramProtocol'> starting on 50839
2013-04-30 11:20:58-0400 [-] Starting protocol <twisted.names.dns.DNSDatagramProtocol object at 0x02638CD0>
2013-04-30 11:20:58-0400 [twisted.names.dns.DNSDatagramProtocol (UDP)] SoftwareUpdate: Update query error on http://swupdate.openvpn.net/updates/1.8.4.200/MSI.txt: <twisted.names.dns.Message instance at 0x02637698> (twisted.names.error.DNSNameError): update/swupdate:254,internet/defer:744,python/failure:338,update/swupdate:333,internet/defer:744,python/failure:338,update/swupdate:407,update/swupdate:368
2013-04-30 11:20:58-0400 [twisted.names.dns.DNSDatagramProtocol (UDP)] Schedule swupdate monitor in 8902 seconds, range=(120,14400), error=True, initial=False
2013-04-30 11:20:58-0400 [-] (Port 50839 Closed)
2013-04-30 11:20:58-0400 [-] Stopping protocol <twisted.names.dns.DNSDatagramProtocol object at 0x02638CD0>
2013-04-30 11:21:16-0400 [HTTPChannel,31,127.0.0.1] *** API CALL f=xmlrpc_DisconnectSet args=[[]] kw={} ret=None
2013-04-30 11:21:19-0400 [HTTPChannel,32,127.0.0.1] *** API CALL f=xmlrpc_GetPreferences args=[] kw={} ret={'proxy_auto': True, 'exec_admin_domain': '', 'update_base_url': 'http://swupdate.openvpn.net/updates', 'log_append': False, 'enable_xd_proxy': True, 'basic_client': False, 'auth_allow_cache_pw': True, 'restrict_domain': '*', 'proxy_auth_allow_basic': True, 'trust_group': '', 'proto_force': '', 'allow_ssl_v2': False, 'connect_timeout': 60, 'implicit_elevation': False, 'exec_user_domain': '*', 'universal_sessions_are_global': False, 'reroute_dns_partial': False, 'verb': '', 'proxy_auth_allow_save_pw': True, 'user_may_trust_cert': True, 'silent_update': False, 'route_nopull': False, 'enable_connect': True, 'notify_update': True, 'user_hostspec': '*', 'allow_web_import': True}
2013-04-30 11:21:19-0400 [HTTPChannel,33,127.0.0.1] *** API CALL f=xmlrpc_LocalUserContext args=[True] kw={} ret={'user': u'SINHAN', 'user_is_admin': False}
2013-04-30 11:21:19-0400 [HTTPChannel,34,127.0.0.1] *** API CALL f=xmlrpc_TrackActiveProfiles args=[True] kw={} ret='sess_TrackActiveProfiles_aDT21oa9G0OzCTz2_2'
2013-04-30 11:21:19-0400 [HTTPChannel,35,127.0.0.1] *** API CALL f=xmlrpc_UpdateStatus args=[] kw={} ret={}
2013-04-30 11:21:19-0400 [HTTPChannel,36,127.0.0.1] *** API CALL f=xmlrpc_Poll args=['sess_TrackActiveProfiles_aDT21oa9G0OzCTz2_2', 10] kw={} ret=[{'timestamp': 1367335279, 'state': 'add_profile', 'profile_id': 'vpn_ikindred_com_dynamic_p4303', 'type': 'PROFILE'}]
2013-04-30 11:21:19-0400 [HTTPChannel,37,127.0.0.1] *** API CALL f=xmlrpc_ProfileProperties args=['vpn_ikindred_com_dynamic_p4303'] kw={} ret={'hash': '8836495cbf591275a1668f22891f97c4cbc4bb0453e7c819b007d4848ba05017', 'name': 'vpn.ikindred.com/Dynamic', 'global': True, 'portal_url': 'https://vpn.ikindred.com/', 'host': 'vpn.ikindred.com', 'snapshot': {'delete_pending': True, 'password': {'status': 'need', 'timestamp': 1367335188, 'need': ('username', 'password'), 'type': 'PASSWORD', 'auth_type': 'Dynamic'}, 'cookie': 'TRAY_CLIENT_U0lOSEFO_zOeBQcFT'}, 'owner': u'SINHAN', 'org': 'OpenVPN Technologies, Inc.', 'type': ['dynamic'], 'id': 'vpn_ikindred_com_dynamic_p4303', 'access_allowed': True}
2013-04-30 11:21:32-0400 [HTTPChannel,40,127.0.0.1] *** API CALL f=xmlrpc_Poll args=['sess_TrackActiveProfiles_aDT21oa9G0OzCTz2_2', 10] kw={} ret=[{'type': 'PROFILE', 'state': 'connect', 'profile_id': 'vpn_ikindred_com_dynamic_p4303', 'cookie': 'TRAY_CLIENT_U0lOSEFO_NUWADH2O', 'timestamp': 1367335292}]
2013-04-30 11:21:32-0400 [HTTPChannel,40,127.0.0.1] *** API CALL f=xmlrpc_Connect args=[{'vpn_proto': 'tcp', 'non_interactive': False, 'profile_id': 'vpn_ikindred_com_dynamic_p4303', 'cookie': 'TRAY_CLIENT_U0lOSEFO_NUWADH2O', 'new_only': True, 'type': 'dynamic'}, ['STATE', 'PASSWORD', 'ACTIVE', 'CERT_APPROVAL', 'INFO', 'CONNECTED_USER', 'FATAL', 'SCRIPT', 'CHALLENGE', 'DELETE_PENDING', 'NOTIFY', 'RSA_SIGN', 'CONNECT_TIMEOUT', 'BYTECOUNT'], {}] kw={} ret='sess_vpn_ikindred_com_dynamic_p4303_k6PVoOKwdVApD0ny_1'
2013-04-30 11:21:32-0400 [HTTPChannel,42,127.0.0.1] *** API CALL f=xmlrpc_Poll args=['sess_vpn_ikindred_com_dynamic_p4303_k6PVoOKwdVApD0ny_1', 10] kw={} ret=[{'status': 'need', 'timestamp': 1367335292, 'need': ('username', 'password'), 'type': 'PASSWORD', 'auth_type': 'Dynamic'}]
2013-04-30 11:21:56-0400 [HTTPChannel,44,127.0.0.1] *** API CALL f=xmlrpc_SubmitCreds args=['sess_vpn_ikindred_com_dynamic_p4303_k6PVoOKwdVApD0ny_1', {'username': '<redacted>', 'password': '[redacted]'}, 'Dynamic', True] kw={} ret=None
2013-04-30 11:21:56-0400 [-] <class 'twisted.names.dns.DNSDatagramProtocol'> starting on 58995
2013-04-30 11:21:56-0400 [-] Starting protocol <twisted.names.dns.DNSDatagramProtocol object at 0x02652250>
2013-04-30 11:21:56-0400 [twisted.names.dns.DNSDatagramProtocol (UDP)] DynamicClientBase: DNS lookup failed on host 'vpn.ikindred.com': <twisted.names.dns.Message instance at 0x02643FD0> (twisted.names.error.DNSNameError): client/dyncli:90,internet/defer:744,python/failure:338,client/dyncli:128,internet/defer:744,python/failure:338,client/asxmlcli:72,internet/defer:744,python/failure:338,client/asxmlcli:112,client/asxmlcli:107
2013-04-30 11:21:56-0400 [twisted.names.dns.DNSDatagramProtocol (UDP)] *** API CALL f=xmlrpc_Poll args=['sess_vpn_ikindred_com_dynamic_p4303_k6PVoOKwdVApD0ny_1', 10] kw={} ret=[{'timestamp': 1367335316, 'info_type': 'twisted.names.error.DNSNameError', 'type': 'INFO', 'severity': 'error', 'value': "DNS lookup failed on host 'vpn.ikindred.com': <twisted.names.dns.Message instance at 0x02643FD0>"}]
2013-04-30 11:21:56-0400 [twisted.names.dns.DNSDatagramProtocol (UDP)] *** API CALL f=xmlrpc_Poll args=['sess_TrackActiveProfiles_aDT21oa9G0OzCTz2_2', 10] kw={} ret=[{'timestamp': 1367335316, 'state': 'disconnect', 'profile_id': 'vpn_ikindred_com_dynamic_p4303', 'type': 'PROFILE'}]
2013-04-30 11:21:56-0400 [-] (Port 58995 Closed)
2013-04-30 11:21:56-0400 [-] Stopping protocol <twisted.names.dns.DNSDatagramProtocol object at 0x02652250>
2013-04-30 11:21:56-0400 [HTTPChannel,46,127.0.0.1] *** API CALL f=xmlrpc_Poll args=['sess_vpn_ikindred_com_dynamic_p4303_k6PVoOKwdVApD0ny_1', 10] kw={} ret=[{'timestamp': 1367335316, 'type': 'DELETE_PENDING'}]
2013-04-30 11:25:00-0400 [-] ProfileManager: ProfileReader: error obtaining profile_id 'client': [Errno 2] No such file or directory: 'C:\\Program Files (x86)\\OpenVPN Technologies\\OpenVPN Client\\etc\\profile\\client.info' (exceptions.IOError): client/profman:396,client/profman:385,client/profman:376,util/simplefile:25,util/simplefile:17
2013-04-30 11:25:00-0400 [-] ProfileManager: ProfileReader: error obtaining profile_id 'client': [Errno 2] No such file or directory: 'C:\\Program Files (x86)\\OpenVPN Technologies\\OpenVPN Client\\etc\\profile\\client.info' (exceptions.IOError): client/profman:396,client/profman:385,client/profman:376,util/simplefile:25,util/simplefile:17
2013-04-30 11:57:43-0400 [-] ProfileManager: ProfileReader: error obtaining profile_id 'client': [Errno 2] No such file or directory: 'C:\\Program Files (x86)\\OpenVPN Technologies\\OpenVPN Client\\etc\\profile\\client.info' (exceptions.IOError): client/profman:396,client/profman:385,client/profman:376,util/simplefile:25,util/simplefile:17
2013-04-30 11:57:43-0400 [-] ProfileManager: ProfileReader: error obtaining profile_id 'client': [Errno 2] No such file or directory: 'C:\\Program Files (x86)\\OpenVPN Technologies\\OpenVPN Client\\etc\\profile\\client.info' (exceptions.IOError): client/profman:396,client/profman:385,client/profman:376,util/simplefile:25,util/simplefile:17
2013-04-30 11:57:46-0400 [HTTPChannel,77,127.0.0.1] *** API CALL f=xmlrpc_GetPreferences args=[] kw={} ret={'proxy_auto': True, 'exec_admin_domain': '', 'update_base_url': 'http://swupdate.openvpn.net/updates', 'log_append': False, 'enable_xd_proxy': True, 'basic_client': False, 'auth_allow_cache_pw': True, 'restrict_domain': '*', 'proxy_auth_allow_basic': True, 'trust_group': '', 'proto_force': '', 'allow_ssl_v2': False, 'connect_timeout': 60, 'implicit_elevation': False, 'exec_user_domain': '*', 'universal_sessions_are_global': False, 'reroute_dns_partial': False, 'verb': '', 'proxy_auth_allow_save_pw': True, 'user_may_trust_cert': True, 'silent_update': False, 'route_nopull': False, 'enable_connect': True, 'notify_update': True, 'user_hostspec': '*', 'allow_web_import': True}
2013-04-30 11:57:46-0400 [HTTPChannel,78,127.0.0.1] *** API CALL f=xmlrpc_LocalUserContext args=[True] kw={} ret={'user': u'SINHAN', 'user_is_admin': False}
2013-04-30 11:57:46-0400 [HTTPChannel,79,127.0.0.1] *** API CALL f=xmlrpc_TrackActiveProfiles args=[True] kw={} ret='sess_TrackActiveProfiles_lDmRenibE9gzJEiB_3'
2013-04-30 11:57:46-0400 [HTTPChannel,80,127.0.0.1] *** API CALL f=xmlrpc_Poll args=['sess_TrackActiveProfiles_lDmRenibE9gzJEiB_3', 10] kw={} ret=[{'timestamp': 1367337466, 'state': 'add_profile', 'profile_id': 'vpn_ikindred_com_dynamic_p4303', 'type': 'PROFILE'}]
2013-04-30 11:57:46-0400 [HTTPChannel,81,127.0.0.1] *** API CALL f=xmlrpc_ProfileProperties args=['vpn_ikindred_com_dynamic_p4303'] kw={} ret={'hash': '8836495cbf591275a1668f22891f97c4cbc4bb0453e7c819b007d4848ba05017', 'name': 'vpn.ikindred.com/Dynamic', 'global': True, 'portal_url': 'https://vpn.ikindred.com/', 'host': 'vpn.ikindred.com', 'snapshot': {'info': {'timestamp': 1367335316, 'info_type': 'twisted.names.error.DNSNameError', 'type': 'INFO', 'severity': 'error', 'value': "DNS lookup failed on host 'vpn.ikindred.com': <twisted.names.dns.Message instance at 0x02643FD0>"}, 'delete_pending': True, 'password': {'status': 'need', 'timestamp': 1367335292, 'need': ('username', 'password'), 'type': 'PASSWORD', 'auth_type': 'Dynamic'}, 'cookie': 'TRAY_CLIENT_U0lOSEFO_NUWADH2O'}, 'owner': u'SINHAN', 'org': 'OpenVPN Technologies, Inc.', 'type': ['dynamic'], 'id': 'vpn_ikindred_com_dynamic_p4303', 'access_allowed': True}
2013-04-30 12:01:43-0400 [-] Inactivity disconnect on profile ID 54_236_2_63_u6292
2013-04-30 12:02:43-0400 [-] Inactivity disconnect on profile ID vpn_ikindred_com_dynamic_p4303
2013-04-30 12:03:43-0400 [-] ProfileManager: ProfileReader: error obtaining profile_id 'client': [Errno 2] No such file or directory: 'C:\\Program Files (x86)\\OpenVPN Technologies\\OpenVPN Client\\etc\\profile\\client.info' (exceptions.IOError): client/profman:396,client/profman:385,client/profman:376,util/simplefile:25,util/simplefile:17
2013-04-30 12:03:43-0400 [-] ProfileManager: ProfileReader: error obtaining profile_id 'client': [Errno 2] No such file or directory: 'C:\\Program Files (x86)\\OpenVPN Technologies\\OpenVPN Client\\etc\\profile\\client.info' (exceptions.IOError): client/profman:396,client/profman:385,client/profman:376,util/simplefile:25,util/simplefile:17
2013-04-30 12:09:43-0400 [-] ProfileManager: ProfileReader: error obtaining profile_id 'client': [Errno 2] No such file or directory: 'C:\\Program Files (x86)\\OpenVPN Technologies\\OpenVPN Client\\etc\\profile\\client.info' (exceptions.IOError): client/profman:396,client/profman:385,client/profman:376,util/simplefile:25,util/simplefile:17
2013-04-30 12:09:43-0400 [-] ProfileManager: ProfileReader: error obtaining profile_id 'client': [Errno 2] No such file or directory: 'C:\\Program Files (x86)\\OpenVPN Technologies\\OpenVPN Client\\etc\\profile\\client.info' (exceptions.IOError): client/profman:396,client/profman:385,client/profman:376,util/simplefile:25,util/simplefile:17
2013-04-30 12:09:56-0400 [HTTPChannel,155,127.0.0.1] *** API CALL f=xmlrpc_DisconnectSet args=[[]] kw={} ret=None
2013-04-30 12:10:09-0400 [HTTPChannel,156,127.0.0.1] *** API CALL f=xmlrpc_GetPreferences args=[] kw={} ret={'proxy_auto': True, 'exec_admin_domain': '', 'update_base_url': 'http://swupdate.openvpn.net/updates', 'log_append': False, 'enable_xd_proxy': True, 'basic_client': False, 'auth_allow_cache_pw': True, 'restrict_domain': '*', 'proxy_auth_allow_basic': True, 'trust_group': '', 'proto_force': '', 'allow_ssl_v2': False, 'connect_timeout': 60, 'implicit_elevation': False, 'exec_user_domain': '*', 'universal_sessions_are_global': False, 'reroute_dns_partial': False, 'verb': '', 'proxy_auth_allow_save_pw': True, 'user_may_trust_cert': True, 'silent_update': False, 'route_nopull': False, 'enable_connect': True, 'notify_update': True, 'user_hostspec': '*', 'allow_web_import': True}
2013-04-30 12:10:09-0400 [HTTPChannel,157,127.0.0.1] *** API CALL f=xmlrpc_LocalUserContext args=[True] kw={} ret={'user': u'SINHAN', 'user_is_admin': False}
2013-04-30 12:10:09-0400 [HTTPChannel,158,127.0.0.1] *** API CALL f=xmlrpc_TrackActiveProfiles args=[True] kw={} ret='sess_TrackActiveProfiles_7L32nlbHECzohmjo_4'
2013-04-30 12:10:09-0400 [HTTPChannel,159,127.0.0.1] *** API CALL f=xmlrpc_UpdateStatus args=[] kw={} ret={}
2013-04-30 12:10:09-0400 [HTTPChannel,160,127.0.0.1] *** API CALL f=xmlrpc_Poll args=['sess_TrackActiveProfiles_7L32nlbHECzohmjo_4', 10] kw={} ret=[{'timestamp': 1367338209, 'state': 'add_profile', 'profile_id': 'vpn_ikindred_com_dynamic_p4303', 'type': 'PROFILE'}]
2013-04-30 12:10:09-0400 [HTTPChannel,161,127.0.0.1] *** API CALL f=xmlrpc_ProfileProperties args=['vpn_ikindred_com_dynamic_p4303'] kw={} ret={'hash': '8836495cbf591275a1668f22891f97c4cbc4bb0453e7c819b007d4848ba05017', 'name': 'vpn.ikindred.com/Dynamic', 'global': True, 'portal_url': 'https://vpn.ikindred.com/', 'host': 'vpn.ikindred.com', 'owner': u'SINHAN', 'org': 'OpenVPN Technologies, Inc.', 'type': ['dynamic'], 'id': 'vpn_ikindred_com_dynamic_p4303', 'access_allowed': True}
2013-04-30 12:10:23-0400 [HTTPChannel,163,127.0.0.1] *** API CALL f=xmlrpc_Connect args=[{'vpn_proto': 'tcp', 'non_interactive': False, 'profile_id': 'vpn_ikindred_com_dynamic_p4303', 'cookie': 'TRAY_CLIENT_U0lOSEFO_Tkb4HFEV', 'new_only': True, 'type': 'dynamic'}, ['STATE', 'PASSWORD', 'ACTIVE', 'CERT_APPROVAL', 'INFO', 'CONNECTED_USER', 'FATAL', 'SCRIPT', 'CHALLENGE', 'DELETE_PENDING', 'NOTIFY', 'RSA_SIGN', 'CONNECT_TIMEOUT', 'BYTECOUNT'], {}] kw={} ret='sess_vpn_ikindred_com_dynamic_p4303_rWtZEqngrLvz7NbZ_1'
2013-04-30 12:10:23-0400 [HTTPChannel,164,127.0.0.1] *** API CALL f=xmlrpc_Poll args=['sess_TrackActiveProfiles_7L32nlbHECzohmjo_4', 10] kw={} ret=[{'type': 'PROFILE', 'state': 'connect', 'profile_id': 'vpn_ikindred_com_dynamic_p4303', 'cookie': 'TRAY_CLIENT_U0lOSEFO_Tkb4HFEV', 'timestamp': 1367338223}]
2013-04-30 12:10:23-0400 [HTTPChannel,165,127.0.0.1] *** API CALL f=xmlrpc_Poll args=['sess_vpn_ikindred_com_dynamic_p4303_rWtZEqngrLvz7NbZ_1', 10] kw={} ret=[{'status': 'need', 'timestamp': 1367338223, 'need': ('username', 'password'), 'type': 'PASSWORD', 'auth_type': 'Dynamic'}]
2013-04-30 12:10:40-0400 [HTTPChannel,168,127.0.0.1] *** API CALL f=xmlrpc_SubmitCreds args=['sess_vpn_ikindred_com_dynamic_p4303_rWtZEqngrLvz7NbZ_1', {'username': '<redacted>', 'password': '[redacted]'}, 'Dynamic', True] kw={} ret=None
2013-04-30 12:10:40-0400 [-] <class 'twisted.names.dns.DNSDatagramProtocol'> starting on 22320
2013-04-30 12:10:40-0400 [-] Starting protocol <twisted.names.dns.DNSDatagramProtocol object at 0x02652A30>
2013-04-30 12:10:40-0400 [twisted.names.dns.DNSDatagramProtocol (UDP)] DynamicClientBase: DNS lookup failed on host 'vpn.ikindred.com': <twisted.names.dns.Message instance at 0x0264BAA8> (twisted.names.error.DNSNameError): client/dyncli:90,internet/defer:744,python/failure:338,client/dyncli:128,internet/defer:744,python/failure:338,client/asxmlcli:72,internet/defer:744,python/failure:338,client/asxmlcli:112,client/asxmlcli:107
2013-04-30 12:10:40-0400 [twisted.names.dns.DNSDatagramProtocol (UDP)] *** API CALL f=xmlrpc_Poll args=['sess_vpn_ikindred_com_dynamic_p4303_rWtZEqngrLvz7NbZ_1', 10] kw={} ret=[{'timestamp': 1367338240, 'info_type': 'twisted.names.error.DNSNameError', 'type': 'INFO', 'severity': 'error', 'value': "DNS lookup failed on host 'vpn.ikindred.com': <twisted.names.dns.Message instance at 0x0264BAA8>"}]
2013-04-30 12:10:40-0400 [twisted.names.dns.DNSDatagramProtocol (UDP)] *** API CALL f=xmlrpc_Poll args=['sess_TrackActiveProfiles_7L32nlbHECzohmjo_4', 10] kw={} ret=[{'timestamp': 1367338240, 'state': 'disconnect', 'profile_id': 'vpn_ikindred_com_dynamic_p4303', 'type': 'PROFILE'}]
2013-04-30 12:10:40-0400 [-] (Port 22320 Closed)
2013-04-30 12:10:40-0400 [-] Stopping protocol <twisted.names.dns.DNSDatagramProtocol object at 0x02652A30>
2013-04-30 12:10:40-0400 [HTTPChannel,170,127.0.0.1] *** API CALL f=xmlrpc_Poll args=['sess_vpn_ikindred_com_dynamic_p4303_rWtZEqngrLvz7NbZ_1', 10] kw={} ret=[{'timestamp': 1367338240, 'type': 'DELETE_PENDING'}]
2013-04-30 12:12:00-0400 [HTTPChannel,179,127.0.0.1] *** API CALL f=xmlrpc_Poll args=['sess_TrackActiveProfiles_7L32nlbHECzohmjo_4', 10] kw={} ret=[{'type': 'PROFILE', 'state': 'connect', 'profile_id': '54_236_2_63_u3054', 'cookie': 'TRAY_CLIENT_U0lOSEFO_Tkb4HFEV', 'timestamp': 1367338320}]
2013-04-30 12:12:00-0400 [HTTPChannel,179,127.0.0.1] *** API CALL f=xmlrpc_Connect args=[{'vpn_proto': 'tcp', 'ret_profile_id': True, 'non_interactive': False, 'host': '54.236.2.63', 'cookie': 'TRAY_CLIENT_U0lOSEFO_Tkb4HFEV', 'new_only': True, 'type': 'universal'}, ['STATE', 'PASSWORD', 'ACTIVE', 'CERT_APPROVAL', 'INFO', 'CONNECTED_USER', 'FATAL', 'SCRIPT', 'CHALLENGE', 'DELETE_PENDING', 'NOTIFY', 'RSA_SIGN', 'CONNECT_TIMEOUT', 'BYTECOUNT'], {}] kw={} ret=('sess_54_236_2_63_u3054_NONdlqsPtq1DWwQg_1', '54_236_2_63_u3054')
2013-04-30 12:12:00-0400 [HTTPChannel,181,127.0.0.1] *** API CALL f=xmlrpc_ProfileProperties args=['54_236_2_63_u3054'] kw={} ret={'access_allowed': True, 'global': False, 'host': '54.236.2.63', 'snapshot': {'password': {'status': 'need', 'timestamp': 1367338320, 'need': ('username', 'password'), 'type': 'PASSWORD', 'auth_type': 'Dynamic'}, 'cookie': 'TRAY_CLIENT_U0lOSEFO_Tkb4HFEV'}, 'owner': u'SINHAN', 'type': ['universal'], 'id': '54_236_2_63_u3054', 'name': '54.236.2.63/Universal'}
2013-04-30 12:12:00-0400 [HTTPChannel,182,127.0.0.1] *** API CALL f=xmlrpc_Poll args=['sess_54_236_2_63_u3054_NONdlqsPtq1DWwQg_1', 10] kw={} ret=[{'status': 'need', 'timestamp': 1367338320, 'need': ('username', 'password'), 'type': 'PASSWORD', 'auth_type': 'Dynamic'}]
2013-04-30 12:12:22-0400 [HTTPChannel,183,127.0.0.1] *** API CALL f=xmlrpc_SubmitCreds args=['sess_54_236_2_63_u3054_NONdlqsPtq1DWwQg_1', {'username': '<redacted>', 'password': '[redacted]'}, 'Dynamic', True] kw={} ret=None
2013-04-30 12:12:42-0400 [-] DynamicClientBase: Unable to obtain Session ID from 54.236.2.63, port(s)=(443, 943): XML-RPC: TimeoutError. (twisted.internet.error.TimeoutError): client/dyncli:90,internet/defer:744,python/failure:338,client/dyncli:128,internet/defer:744,python/failure:338,client/asxmlcli:102,client/asxmlcli:81,internet/defer:744,python/failure:338,client/asxmlcli:124,internet/defer:744,python/failure:338,client/asxmlcli:190,client/asxmlcli:174
2013-04-30 12:12:42-0400 [-] *** API CALL f=xmlrpc_Poll args=['sess_54_236_2_63_u3054_NONdlqsPtq1DWwQg_1', 10] kw={} ret=[{'timestamp': 1367338362, 'info_type': 'twisted.internet.error.TimeoutError', 'type': 'INFO', 'severity': 'error', 'value': 'Unable to obtain Session ID from 54.236.2.63, port(s)=(443, 943): XML-RPC: TimeoutError.'}]
2013-04-30 12:12:42-0400 [-] *** API CALL f=xmlrpc_Poll args=['sess_TrackActiveProfiles_7L32nlbHECzohmjo_4', 10] kw={} ret=[{'timestamp': 1367338362, 'state': 'disconnect', 'profile_id': '54_236_2_63_u3054', 'type': 'PROFILE'}]
2013-04-30 12:12:42-0400 [HTTPChannel,188,127.0.0.1] *** API CALL f=xmlrpc_Poll args=['sess_54_236_2_63_u3054_NONdlqsPtq1DWwQg_1', 10] kw={} ret=[{'timestamp': 1367338362, 'type': 'DELETE_PENDING'}]
2013-04-30 12:14:09-0400 [HTTPChannel,198,127.0.0.1] *** API CALL f=xmlrpc_DisconnectSet args=[[]] kw={} ret=None
2013-04-30 12:14:12-0400 [HTTPChannel,199,127.0.0.1] *** API CALL f=xmlrpc_GetPreferences args=[] kw={} ret={'proxy_auto': True, 'exec_admin_domain': '', 'update_base_url': 'http://swupdate.openvpn.net/updates', 'log_append': False, 'enable_xd_proxy': True, 'basic_client': False, 'auth_allow_cache_pw': True, 'restrict_domain': '*', 'proxy_auth_allow_basic': True, 'trust_group': '', 'proto_force': '', 'allow_ssl_v2': False, 'connect_timeout': 60, 'implicit_elevation': False, 'exec_user_domain': '*', 'universal_sessions_are_global': False, 'reroute_dns_partial': False, 'verb': '', 'proxy_auth_allow_save_pw': True, 'user_may_trust_cert': True, 'silent_update': False, 'route_nopull': False, 'enable_connect': True, 'notify_update': True, 'user_hostspec': '*', 'allow_web_import': True}
2013-04-30 12:14:13-0400 [HTTPChannel,200,127.0.0.1] *** API CALL f=xmlrpc_LocalUserContext args=[True] kw={} ret={'user': u'SINHAN', 'user_is_admin': False}
2013-04-30 12:14:13-0400 [HTTPChannel,201,127.0.0.1] *** API CALL f=xmlrpc_TrackActiveProfiles args=[True] kw={} ret='sess_TrackActiveProfiles_ofTkZ3hOLmf4ioiq_5'
2013-04-30 12:14:13-0400 [HTTPChannel,202,127.0.0.1] *** API CALL f=xmlrpc_UpdateStatus args=[] kw={} ret={}
2013-04-30 12:14:13-0400 [HTTPChannel,203,127.0.0.1] *** API CALL f=xmlrpc_Poll args=['sess_TrackActiveProfiles_ofTkZ3hOLmf4ioiq_5', 10] kw={} ret=[{'timestamp': 1367338453, 'state': 'add_profile', 'profile_id': 'vpn_ikindred_com_dynamic_p4303', 'type': 'PROFILE'}]
2013-04-30 12:14:13-0400 [HTTPChannel,204,127.0.0.1] *** API CALL f=xmlrpc_ProfileProperties args=['vpn_ikindred_com_dynamic_p4303'] kw={} ret={'hash': '8836495cbf591275a1668f22891f97c4cbc4bb0453e7c819b007d4848ba05017', 'name': 'vpn.ikindred.com/Dynamic', 'global': True, 'portal_url': 'https://vpn.ikindred.com/', 'host': 'vpn.ikindred.com', 'snapshot': {'info': {'timestamp': 1367338240, 'info_type': 'twisted.names.error.DNSNameError', 'type': 'INFO', 'severity': 'error', 'value': "DNS lookup failed on host 'vpn.ikindred.com': <twisted.names.dns.Message instance at 0x0264BAA8>"}, 'delete_pending': True, 'password': {'status': 'need', 'timestamp': 1367338223, 'need': ('username', 'password'), 'type': 'PASSWORD', 'auth_type': 'Dynamic'}, 'cookie': 'TRAY_CLIENT_U0lOSEFO_Tkb4HFEV'}, 'owner': u'SINHAN', 'org': 'OpenVPN Technologies, Inc.', 'type': ['dynamic'], 'id': 'vpn_ikindred_com_dynamic_p4303', 'access_allowed': True}
2013-04-30 12:14:19-0400 [HTTPChannel,206,127.0.0.1] *** API CALL f=xmlrpc_Poll args=['sess_TrackActiveProfiles_ofTkZ3hOLmf4ioiq_5', 10] kw={} ret=[{'type': 'PROFILE', 'state': 'connect', 'profile_id': '54_236_2_63_u1139', 'cookie': 'TRAY_CLIENT_U0lOSEFO_CusZc8UN', 'timestamp': 1367338459}]
2013-04-30 12:14:19-0400 [HTTPChannel,206,127.0.0.1] *** API CALL f=xmlrpc_Connect args=[{'vpn_proto': 'tcp', 'ret_profile_id': True, 'non_interactive': False, 'host': '54.236.2.63', 'cookie': 'TRAY_CLIENT_U0lOSEFO_CusZc8UN', 'new_only': True, 'type': 'universal'}, ['STATE', 'PASSWORD', 'ACTIVE', 'CERT_APPROVAL', 'INFO', 'CONNECTED_USER', 'FATAL', 'SCRIPT', 'CHALLENGE', 'DELETE_PENDING', 'NOTIFY', 'RSA_SIGN', 'CONNECT_TIMEOUT', 'BYTECOUNT'], {}] kw={} ret=('sess_54_236_2_63_u1139_KwRfdrtx0BQwcdpb_1', '54_236_2_63_u1139')
2013-04-30 12:14:19-0400 [HTTPChannel,208,127.0.0.1] *** API CALL f=xmlrpc_ProfileProperties args=['54_236_2_63_u1139'] kw={} ret={'access_allowed': True, 'global': False, 'host': '54.236.2.63', 'snapshot': {'password': {'status': 'need', 'timestamp': 1367338459, 'need': ('username', 'password'), 'type': 'PASSWORD', 'auth_type': 'Dynamic'}, 'cookie': 'TRAY_CLIENT_U0lOSEFO_CusZc8UN'}, 'owner': u'SINHAN', 'type': ['universal'], 'id': '54_236_2_63_u1139', 'name': '54.236.2.63/Universal'}
2013-04-30 12:14:19-0400 [HTTPChannel,209,127.0.0.1] *** API CALL f=xmlrpc_Poll args=['sess_54_236_2_63_u1139_KwRfdrtx0BQwcdpb_1', 10] kw={} ret=[{'status': 'need', 'timestamp': 1367338459, 'need': ('username', 'password'), 'type': 'PASSWORD', 'auth_type': 'Dynamic'}]
2013-04-30 12:14:33-0400 [HTTPChannel,210,127.0.0.1] *** API CALL f=xmlrpc_SubmitCreds args=['sess_54_236_2_63_u1139_KwRfdrtx0BQwcdpb_1', {'username': '<redacted>', 'password': '[redacted]'}, 'Dynamic', True] kw={} ret=None
2013-04-30 12:14:53-0400 [-] DynamicClientBase: Unable to obtain Session ID from 54.236.2.63, port(s)=(443, 943): XML-RPC: TimeoutError. (twisted.internet.error.TimeoutError): client/dyncli:90,internet/defer:744,python/failure:338,client/dyncli:128,internet/defer:744,python/failure:338,client/asxmlcli:102,client/asxmlcli:81,internet/defer:744,python/failure:338,client/asxmlcli:124,internet/defer:744,python/failure:338,client/asxmlcli:190,client/asxmlcli:174
2013-04-30 12:14:53-0400 [-] *** API CALL f=xmlrpc_Poll args=['sess_54_236_2_63_u1139_KwRfdrtx0BQwcdpb_1', 10] kw={} ret=[{'timestamp': 1367338493, 'info_type': 'twisted.internet.error.TimeoutError', 'type': 'INFO', 'severity': 'error', 'value': 'Unable to obtain Session ID from 54.236.2.63, port(s)=(443, 943): XML-RPC: TimeoutError.'}]
2013-04-30 12:14:53-0400 [-] *** API CALL f=xmlrpc_Poll args=['sess_TrackActiveProfiles_ofTkZ3hOLmf4ioiq_5', 10] kw={} ret=[{'timestamp': 1367338493, 'state': 'disconnect', 'profile_id': '54_236_2_63_u1139', 'type': 'PROFILE'}]
2013-04-30 12:14:53-0400 [HTTPChannel,215,127.0.0.1] *** API CALL f=xmlrpc_Poll args=['sess_54_236_2_63_u1139_KwRfdrtx0BQwcdpb_1', 10] kw={} ret=[{'timestamp': 1367338493, 'type': 'DELETE_PENDING'}]
2013-04-30 12:17:14-0400 [HTTPChannel,230,127.0.0.1] *** API CALL f=xmlrpc_DisconnectSet args=[[]] kw={} ret=None
2013-04-30 12:17:21-0400 [HTTPChannel,232,127.0.0.1] *** API CALL f=xmlrpc_GetPreferences args=[] kw={} ret={'proxy_auto': True, 'exec_admin_domain': '', 'update_base_url': 'http://swupdate.openvpn.net/updates', 'log_append': False, 'enable_xd_proxy': True, 'basic_client': False, 'auth_allow_cache_pw': True, 'restrict_domain': '*', 'proxy_auth_allow_basic': True, 'trust_group': '', 'proto_force': '', 'allow_ssl_v2': False, 'connect_timeout': 60, 'implicit_elevation': False, 'exec_user_domain': '*', 'universal_sessions_are_global': False, 'reroute_dns_partial': False, 'verb': '', 'proxy_auth_allow_save_pw': True, 'user_may_trust_cert': True, 'silent_update': False, 'route_nopull': False, 'enable_connect': True, 'notify_update': True, 'user_hostspec': '*', 'allow_web_import': True}
2013-04-30 12:17:21-0400 [HTTPChannel,233,127.0.0.1] *** API CALL f=xmlrpc_LocalUserContext args=[True] kw={} ret={'user': u'SINHAN', 'user_is_admin': False}
2013-04-30 12:17:21-0400 [HTTPChannel,234,127.0.0.1] *** API CALL f=xmlrpc_TrackActiveProfiles args=[True] kw={} ret='sess_TrackActiveProfiles_C13zSxtiR9aC5iyH_6'
2013-04-30 12:17:21-0400 [HTTPChannel,235,127.0.0.1] *** API CALL f=xmlrpc_UpdateStatus args=[] kw={} ret={}
2013-04-30 12:17:21-0400 [HTTPChannel,236,127.0.0.1] *** API CALL f=xmlrpc_Poll args=['sess_TrackActiveProfiles_C13zSxtiR9aC5iyH_6', 10] kw={} ret=[{'timestamp': 1367338641, 'state': 'add_profile', 'profile_id': 'vpn_ikindred_com_dynamic_p4303', 'type': 'PROFILE'}]
2013-04-30 12:17:21-0400 [HTTPChannel,237,127.0.0.1] *** API CALL f=xmlrpc_ProfileProperties args=['vpn_ikindred_com_dynamic_p4303'] kw={} ret={'hash': '8836495cbf591275a1668f22891f97c4cbc4bb0453e7c819b007d4848ba05017', 'name': 'vpn.ikindred.com/Dynamic', 'global': True, 'portal_url': 'https://vpn.ikindred.com/', 'host': 'vpn.ikindred.com', 'snapshot': {'info': {'timestamp': 1367338240, 'info_type': 'twisted.names.error.DNSNameError', 'type': 'INFO', 'severity': 'error', 'value': "DNS lookup failed on host 'vpn.ikindred.com': <twisted.names.dns.Message instance at 0x0264BAA8>"}, 'delete_pending': True, 'password': {'status': 'need', 'timestamp': 1367338223, 'need': ('username', 'password'), 'type': 'PASSWORD', 'auth_type': 'Dynamic'}, 'cookie': 'TRAY_CLIENT_U0lOSEFO_Tkb4HFEV'}, 'owner': u'SINHAN', 'org': 'OpenVPN Technologies, Inc.', 'type': ['dynamic'], 'id': 'vpn_ikindred_com_dynamic_p4303', 'access_allowed': True}
2013-04-30 12:17:28-0400 [HTTPChannel,239,127.0.0.1] *** API CALL f=xmlrpc_Poll args=['sess_TrackActiveProfiles_C13zSxtiR9aC5iyH_6', 10] kw={} ret=[{'type': 'PROFILE', 'state': 'connect', 'profile_id': '54_236_2_63_u6984', 'cookie': 'TRAY_CLIENT_U0lOSEFO_8ehbqqum', 'timestamp': 1367338648}]
2013-04-30 12:17:28-0400 [HTTPChannel,239,127.0.0.1] *** API CALL f=xmlrpc_Connect args=[{'vpn_proto': 'tcp', 'ret_profile_id': True, 'non_interactive': False, 'host': '54.236.2.63', 'cookie': 'TRAY_CLIENT_U0lOSEFO_8ehbqqum', 'new_only': True, 'type': 'universal'}, ['STATE', 'PASSWORD', 'ACTIVE', 'CERT_APPROVAL', 'INFO', 'CONNECTED_USER', 'FATAL', 'SCRIPT', 'CHALLENGE', 'DELETE_PENDING', 'NOTIFY', 'RSA_SIGN', 'CONNECT_TIMEOUT', 'BYTECOUNT'], {}] kw={} ret=('sess_54_236_2_63_u6984_hRtLdS3UQybQpomi_1', '54_236_2_63_u6984')
2013-04-30 12:17:28-0400 [HTTPChannel,241,127.0.0.1] *** API CALL f=xmlrpc_ProfileProperties args=['54_236_2_63_u6984'] kw={} ret={'access_allowed': True, 'global': False, 'host': '54.236.2.63', 'snapshot': {'password': {'status': 'need', 'timestamp': 1367338648, 'need': ('username', 'password'), 'type': 'PASSWORD', 'auth_type': 'Dynamic'}, 'cookie': 'TRAY_CLIENT_U0lOSEFO_8ehbqqum'}, 'owner': u'SINHAN', 'type': ['universal'], 'id': '54_236_2_63_u6984', 'name': '54.236.2.63/Universal'}
2013-04-30 12:17:28-0400 [HTTPChannel,242,127.0.0.1] *** API CALL f=xmlrpc_Poll args=['sess_54_236_2_63_u6984_hRtLdS3UQybQpomi_1', 10] kw={} ret=[{'status': 'need', 'timestamp': 1367338648, 'need': ('username', 'password'), 'type': 'PASSWORD', 'auth_type': 'Dynamic'}]
2013-04-30 12:17:31-0400 [HTTPChannel,243,127.0.0.1] *** API CALL f=xmlrpc_SubmitCreds args=['sess_54_236_2_63_u6984_hRtLdS3UQybQpomi_1', {'username': '<redacted>', 'password': '[redacted]'}, 'Dynamic', True] kw={} ret=None
2013-04-30 12:17:51-0400 [-] DynamicClientBase: Unable to obtain Session ID from 54.236.2.63, port(s)=(443, 943): XML-RPC: TimeoutError. (twisted.internet.error.TimeoutError): client/dyncli:90,internet/defer:744,python/failure:338,client/dyncli:128,internet/defer:744,python/failure:338,client/asxmlcli:102,client/asxmlcli:81,internet/defer:744,python/failure:338,client/asxmlcli:124,internet/defer:744,python/failure:338,client/asxmlcli:190,client/asxmlcli:174
2013-04-30 12:17:51-0400 [-] *** API CALL f=xmlrpc_Poll args=['sess_54_236_2_63_u6984_hRtLdS3UQybQpomi_1', 10] kw={} ret=[{'timestamp': 1367338671, 'info_type': 'twisted.internet.error.TimeoutError', 'type': 'INFO', 'severity': 'error', 'value': 'Unable to obtain Session ID from 54.236.2.63, port(s)=(443, 943): XML-RPC: TimeoutError.'}]
2013-04-30 12:17:51-0400 [-] *** API CALL f=xmlrpc_Poll args=['sess_TrackActiveProfiles_C13zSxtiR9aC5iyH_6', 10] kw={} ret=[{'timestamp': 1367338671, 'state': 'disconnect', 'profile_id': '54_236_2_63_u6984', 'type': 'PROFILE'}]
2013-04-30 12:17:51-0400 [HTTPChannel,248,127.0.0.1] *** API CALL f=xmlrpc_Poll args=['sess_54_236_2_63_u6984_hRtLdS3UQybQpomi_1', 10] kw={} ret=[{'timestamp': 1367338671, 'type': 'DELETE_PENDING'}]
2013-04-30 12:20:43-0400 [-] Inactivity disconnect on profile ID vpn_ikindred_com_dynamic_p4303
All times are UTC
Page 1 of 1
Powered by phpBB® Forum Software © phpBB Limited
https://www.phpbb.com/