Hallo Frank, hallo nicht ich,
neues Phämomen: Netzwerksicherung läuft stabil bis zum Ende durch, Timebackup stellt nur teilweise fertig, aber ich glaube, das wird.
ABER: Der Server scheint in unregelmäßigen Abständen die VPN-Verbindung zu kappen, die dann aber vom Client (DS109) wieder neu aufgebaut wird, so dass die Sicherungen weiterlaufen können.
Könnt Ihr anhand des Logfiles die Ursache erkennen? Würde mich freuen, wenn Ihr einen Blick auf das Logfile werfen könntet. Ich habe wegen der Länge nur den heutigen Tag eingehängt.
Danke vorab!
Christian
Logfile (/var/log/openvpn.log):
Thu Nov 27 00:49:36 2014 Open_VPN/::ffff:91.2.138.362(1194) TLS: new session incoming connection from [AF_INET6]::ffff:91.2.138.362:1194
Thu Nov 27 00:49:37 2014 RADIUS-PLUGIN: FOREGROUND THREAD: isAuthenticated()1Thu Nov 27 00:49:37 2014 RADIUS-PLUGIN: FOREGROUND THREAD: isAcct()1Thu Nov 27 00:49:38 2014 RADIUS-PLUGIN: Got no response from radius server.
Thu Nov 27 00:49:38 2014 RADIUS-PLUGIN: FOREGROUND THREAD: Error ar rekeying!
Thu Nov 27 00:49:38 2014 RADIUS-PLUGIN: BACKGROUND ACCT: No accounting data was found for Open_VPN,::ffff:91.2.138.362:1194.
Thu Nov 27 00:49:38 2014 Error: RADIUS-PLUGIN: BACKGROUND AUTH: Auth failed!.
Thu Nov 27 00:49:39 2014 RADIUS-PLUGIN: BACKGROUND-ACCT: Error on sending stop packet.Thu Nov 27 00:49:39 2014 RADIUS-PLUGIN: FOREGROUND THREAD: Error receiving auth confirmation from background process.
Thu Nov 27 00:49:39 2014 Open_VPN/::ffff:91.2.138.362(1194) PLUGIN_CALL: POST /var/packages/VPNCenter/target/lib/radiusplugin.so/PLUGIN_AUTH_USER_PASS_VERIFY status=1
Thu Nov 27 00:49:39 2014 Open_VPN/::ffff:91.2.138.362(1194) PLUGIN_CALL: plugin function PLUGIN_AUTH_USER_PASS_VERIFY failed with status 1: /var/packages/VPNCenter/target/lib/radiusplugin.so
Thu Nov 27 00:49:39 2014 Open_VPN/::ffff:91.2.138.362(1194) TLS Auth Error: Auth Username/Password verification failed for peer
Thu Nov 27 00:49:39 2014 Open_VPN/::ffff:91.2.138.362(1194) TLS: move_session: dest=TM_ACTIVE src=TM_UNTRUSTED reinit_src=1
Thu Nov 27 00:49:39 2014 Open_VPN/::ffff:91.2.138.362(1194) TLS: tls_multi_process: untrusted session promoted to semi-trusted
Thu Nov 27 00:49:39 2014 Open_VPN/::ffff:91.2.138.362(1194) Control Channel: TLSv1, cipher TLSv1/SSLv3 DHE-RSA-AES256-SHA
Thu Nov 27 00:49:42 2014 Open_VPN/::ffff:91.2.138.362(1194) SIGTERM[soft,auth-control-exit] received, client-instance exiting
Thu Nov 27 00:49:42 2014 RADIUS-PLUGIN: FOREGROUND:Error: No user with this common_name!
Thu Nov 27 00:49:42 2014 PLUGIN_CALL: POST /var/packages/VPNCenter/target/lib/radiusplugin.so/PLUGIN_CLIENT_DISCONNECT status=1
Thu Nov 27 00:49:42 2014 PLUGIN_CALL: plugin function PLUGIN_CLIENT_DISCONNECT failed with status 1: /var/packages/VPNCenter/target/lib/radiusplugin.so
Thu Nov 27 00:49:42 2014 WARNING: client-disconnect plugin call failed
Thu Nov 27 00:51:41 2014 ::ffff:91.2.138.362(1194) TLS: Initial packet from [AF_INET6]::ffff:91.2.138.362:1194, sid=593c1ebe 5e5b36fd
Thu Nov 27 00:51:41 2014 RADIUS-PLUGIN: FOREGROUND THREAD: New user.
Thu Nov 27 00:51:42 2014 RADIUS-PLUGIN: Got no response from radius server.
Thu Nov 27 00:51:42 2014 Error: Thu Nov 27 00:51:42 2014 RADIUS-PLUGIN: BACKGROUND AUTH: Auth failed!.
RADIUS-PLUGIN: FOREGROUND THREAD: Error receiving auth confirmation from background process.
Thu Nov 27 00:51:42 2014 ::ffff:91.2.138.362(1194) PLUGIN_CALL: POST /var/packages/VPNCenter/target/lib/radiusplugin.so/PLUGIN_AUTH_USER_PASS_VERIFY status=1
Thu Nov 27 00:51:42 2014 ::ffff:91.2.138.362(1194) PLUGIN_CALL: plugin function PLUGIN_AUTH_USER_PASS_VERIFY failed with status 1: /var/packages/VPNCenter/target/lib/radiusplugin.so
Thu Nov 27 00:51:42 2014 ::ffff:91.2.138.362(1194) TLS Auth Error: Auth Username/Password verification failed for peer
Thu Nov 27 00:51:42 2014 ::ffff:91.2.138.362(1194) Control Channel: TLSv1, cipher TLSv1/SSLv3 DHE-RSA-AES256-SHA
Thu Nov 27 00:51:42 2014 ::ffff:91.2.138.362(1194) Peer Connection Initiated with [AF_INET6]::ffff:91.2.138.362:1194
Thu Nov 27 00:51:44 2014 ::ffff:91.2.138.362(1194) PUSH: Received control message: 'PUSH_REQUEST'
Thu Nov 27 00:51:44 2014 ::ffff:91.2.138.362(1194) Delayed exit in 5 seconds
Thu Nov 27 00:51:44 2014 ::ffff:91.2.138.362(1194) SENT CONTROL [UNDEF]: 'AUTH_FAILED' (status=1)
Thu Nov 27 00:51:44 2014 ::ffff:91.2.138.362(1194) TLS Error: local/remote TLS keys are out of sync: [AF_INET6]::ffff:91.2.138.362:1194 [0]
Thu Nov 27 00:51:49 2014 ::ffff:91.2.138.362(1194) SIGTERM[soft,delayed-exit] received, client-instance exiting
Thu Nov 27 00:52:17 2014 ::ffff:91.2.138.362(1194) TLS: Initial packet from [AF_INET6]::ffff:91.2.138.362:1194, sid=4ad9e70a 209b9081
Thu Nov 27 00:52:18 2014 RADIUS-PLUGIN: FOREGROUND THREAD: New user.
Thu Nov 27 00:52:18 2014 RADIUS-PLUGIN: No attributes Acct Interim Interval or bad length.
Thu Nov 27 00:52:18 2014 RADIUS-PLUGIN: Client config file was not written, overwriteccfiles is false
.Thu Nov 27 00:52:18 2014 RADIUS-PLUGIN: FOREGROUND THREAD: Add user to map.
Thu Nov 27 00:52:18 2014 ::ffff:91.2.138.362(1194) PLUGIN_CALL: POST /var/packages/VPNCenter/target/lib/radiusplugin.so/PLUGIN_AUTH_USER_PASS_VERIFY status=0
Thu Nov 27 00:52:18 2014 ::ffff:91.2.138.362(1194) TLS: Username/Password authentication succeeded for username 'Open_VPN' [CN SET]
Thu Nov 27 00:52:18 2014 ::ffff:91.2.138.362(1194) Data Channel Encrypt: Cipher 'BF-CBC' initialized with 128 bit key
Thu Nov 27 00:52:18 2014 ::ffff:91.2.138.362(1194) Data Channel Encrypt: Using 160 bit message hash 'SHA1' for HMAC authentication
Thu Nov 27 00:52:18 2014 ::ffff:91.2.138.362(1194) Data Channel Decrypt: Cipher 'BF-CBC' initialized with 128 bit key
Thu Nov 27 00:52:18 2014 ::ffff:91.2.138.362(1194) Data Channel Decrypt: Using 160 bit message hash 'SHA1' for HMAC authentication
Thu Nov 27 00:52:18 2014 ::ffff:91.2.138.362(1194) Control Channel: TLSv1, cipher TLSv1/SSLv3 DHE-RSA-AES256-SHA
Thu Nov 27 00:52:18 2014 ::ffff:91.2.138.362(1194) [Open_VPN] Peer Connection Initiated with [AF_INET6]::ffff:91.2.138.362:1194
Thu Nov 27 00:52:18 2014 Open_VPN/::ffff:91.2.138.362(1194) OPTIONS IMPORT: reading client specific options from: ccd/Open_VPN
Thu Nov 27 00:52:19 2014 Open_VPN/::ffff:91.2.138.362(1194) MULTI_sva: pool returned IPv4=10.8.0.6, IPv6=(Not enabled)
Thu Nov 27 00:52:19 2014 Open_VPN/::ffff:91.2.138.362(1194) PLUGIN_CALL: POST /var/packages/VPNCenter/target/lib/radiusplugin.so/PLUGIN_CLIENT_CONNECT status=0
Thu Nov 27 00:52:19 2014 Open_VPN/::ffff:91.2.138.362(1194) OPTIONS IMPORT: reading client specific options from: /tmp/openvpn_cc_503f4950e4672a16539e8fea8b3d1334.tmp
Thu Nov 27 00:52:19 2014 Open_VPN/::ffff:91.2.138.362(1194) MULTI: Learn: 10.8.0.6 -> Open_VPN/::ffff:91.2.138.362(1194)
Thu Nov 27 00:52:19 2014 Open_VPN/::ffff:91.2.138.362(1194) MULTI: primary virtual IP for Open_VPN/::ffff:91.2.138.362(1194): 10.8.0.6
Thu Nov 27 00:52:19 2014 Open_VPN/::ffff:91.2.138.362(1194) MULTI: internal route 192.168.178.0/24 -> Open_VPN/::ffff:91.2.138.362(1194)
Thu Nov 27 00:52:19 2014 Open_VPN/::ffff:91.2.138.362(1194) MULTI: Learn: 192.168.178.0/24 -> Open_VPN/::ffff:91.2.138.362(1194)
Thu Nov 27 00:52:21 2014 Open_VPN/::ffff:91.2.138.362(1194) PUSH: Received control message: 'PUSH_REQUEST'
Thu Nov 27 00:52:21 2014 Open_VPN/::ffff:91.2.138.362(1194) send_push_reply(): safe_cap=940
Thu Nov 27 00:52:21 2014 Open_VPN/::ffff:91.2.138.362(1194) SENT CONTROL [Open_VPN]: 'PUSH_REPLY,route 10.8.0.0 255.255.255.0,route 10.8.0.0 255.255.255.0,topology net30,ping 10,ping-restart 60,ifconfig 10.8.0.6 10.8.0.5' (status=1)
Thu Nov 27 01:00:05 2014 MULTI: Learn: 192.168.178.19 -> Open_VPN/::ffff:91.2.138.362(1194)