i have another problem with a windows 2003 AD used as a radius server though the user logs in...
User user1 was granted access.
Fully-Qualified-User-Name = domain/Users/user1
NAS-IP-Address = 10.x.x.254
NAS-Identifier =
http://www.domain.com
Client-Friendly-Name = proxy
Client-IP-Address = 10.x.x.254
Calling-Station-Identifier = 10.x.x.250
NAS-Port-Type = Virtual
NAS-Port = 925
Proxy-Policy-Name = Use Windows authentication for all users
Authentication-Provider = Windows
Authentication-Server = <undetermined>
Policy-Name = pptp
Authentication-Type = MS-CHAPv2
EAP-Type = <undetermined>
with pfsense as a pptp server using win2003 as a radius server it works just fine.
here is the log
Aug 22 12:17:49 10.x.x.254 pptp,ppp,info <pptp-0>: waiting for call...
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet rcvd Start-Control-Connection-Request from 10.x.x.250
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet protocol-version=0x0100
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet framing-capabilities=1
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet bearer-capabilities=1
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet maximum-channels=0
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet firmware-revision=0
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet host-name=
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet vendor-name=Microsoft
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet sent Start-Control-Connection-Reply to 10.x.x.250
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet protocol-version=0x0100
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet result-code=1
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet error-code=0
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet framing-capabilities=2
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet bearer-capabilities=0
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet maximum-channels=0
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet firmware-revision=1
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet host-name=
www.domain.com
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet vendor-name=MikroTik
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet rcvd Outgoing-Call-Request from 10.x.x.250
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet call-id=17884
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet call-serial-number=177
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet minimum-bps=300
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet maximum-bps=100000000
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet bearer-type=3
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet phone-number-length=0
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet phone-number=
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet subaddress=
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug <10.x.x.250>: LCP lowerup
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug <10.x.x.250>: LCP open
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet sent Outgoing-Call-Reply to 10.x.x.250
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet call-id=10
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet peers-call-id=17884
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet result-code=1
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet error-code=0
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet cause-code=0
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet connect-speed=100000
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet packet-recv-window-size=100
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet packet-processing-delay=0
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet physical-channel-id=0
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet rcvd Set-Link-Info from 10.x.x.250
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet peers-call-id=10
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet send-accm=0xffffffff
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet receive-accm=0xffffffff
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet sent Set-Link-Info to 10.x.x.250
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet peers-call-id=17884
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet send-accm=0xffffffff
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet receive-accm=0xffffffff
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <10.x.x.250>: rcvd LCP ConfReq id=0x0
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <mru 1400>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <magic 0x1c0a46e4>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <pcomp>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <accomp>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <callback 0x06>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <mrru 1614>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <ed 0x01 d7 dd b4 78 21 ea 4d c3 a5 04 a5 74 3f d9 a8 6c 00 00 00 51>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <10.x.x.250>: sent LCP ConfReq id=0x1
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <mru 1460>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <magic 0x6457c351>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <auth mschap2>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <10.x.x.250>: rcvd LCP ConfAck id=0x1
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <mru 1460>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <magic 0x6457c351>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <auth mschap2>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <10.x.x.250>: rcvd LCP ConfReq id=0x1
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <mru 1400>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <magic 0x1c0a46e4>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <callback 0x06>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <10.x.x.250>: sent LCP ConfAck id=0x1
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <mru 1400>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <magic 0x1c0a46e4>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <callback 0x06>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug <10.x.x.250>: LCP opened
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <10.x.x.250>: sent CHAP Challenge id=0x1
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <challenge len=10>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <name
http://www.domain.com>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <10.x.x.250>: rcvd LCP Ident id=0x2
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <magic 0x1c0a46e4>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet MSRASV5.20
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <10.x.x.250>: rcvd LCP Ident id=0x3
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <magic 0x1c0a46e4>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet MSRAS-0-HP-IS7
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet rcvd Set-Link-Info from 10.x.x.250
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet peers-call-id=10
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet send-accm=0xffffffff
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet receive-accm=0xffffffff
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet sent Set-Link-Info to 10.x.x.250
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet peers-call-id=17884
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet send-accm=0xffffffff
Aug 22 12:17:49 10.x.x.254 pptp,debug,packet receive-accm=0xffffffff
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <10.x.x.250>: rcvd LCP Ident id=0x4
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <magic 0x1c0a46e4>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet G--/EH--N-J
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <10.x.x.250>: rcvd CHAP Response id=0x1
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <response len=31>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <name user1>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <10.x.x.250>: sent CHAP Success id=0x1
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet S=3484F82899EC2D941D895008F878B06A25331C9B
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <10.x.x.250>: sent CBCP CallbackReq id=0x0
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet 01 02
Aug 22 12:17:49 10.x.x.254 pptp,ppp,info mikrotik: <pptp-0>: authenticated
Aug 22 12:17:49 10.x.x.254 pptp,ppp,info <pptp-0>: authenticated
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug <10.x.x.250>: IPCP lowerup
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug <10.x.x.250>: IPCP open
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <10.x.x.250>: sent IPCP ConfReq id=0x1
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <addr 0.0.0.0>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug <10.x.x.250>: IPV6CP open
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug <10.x.x.250>: MPLSCP open
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug <10.x.x.250>: BCP open
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug <10.x.x.250>: CCP lowerup
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug <10.x.x.250>: CCP open
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <10.x.x.250>: sent CCP ConfReq id=0x1
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <mppe 1000060>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <10.x.x.250>: rcvd CBCP CallbackResp id=0x0
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet 01 02
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <10.x.x.250>: sent CBCP CallbackAck id=0x1
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet 01 02
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <10.x.x.250>: rcvd CCP ConfReq id=0x5
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <mppe 1000001>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <10.x.x.250>: sent CCP ConfNak id=0x5
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <mppe 1000040>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <10.x.x.250>: rcvd IPCP ConfReq id=0x6
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <addr 0.0.0.0>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <ms-dns 0.0.0.0>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <ms-dns 0.0.0.0>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <ms-wins 0.0.0.0>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <ms-wins 0.0.0.0>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <10.x.x.250>: sent IPCP ConfRej id=0x6
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <addr 0.0.0.0>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <ms-dns 0.0.0.0>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <ms-wins 0.0.0.0>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <ms-wins 0.0.0.0>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <10.x.x.250>: rcvd CCP ConfReq id=0x7
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <mppe 1000040>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <10.x.x.250>: sent CCP ConfAck id=0x7
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <mppe 1000040>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <10.x.x.250>: rcvd IPCP ConfReq id=0x8
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <addr 0.0.0.0>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <10.x.x.250>: sent IPCP ConfRej id=0x8
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <addr 0.0.0.0>
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <10.x.x.250>: rcvd IPCP TermReq id=0x9
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet F-
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <10.x.x.250>: sent IPCP TermAck id=0x9
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug <10.x.x.250>: LCP close
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug <10.x.x.250>: LCP closed
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug <10.x.x.250>: CCP lowerdown
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug <10.x.x.250>: BCP lowerdown
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug <10.x.x.250>: BCP down event in starting state
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug <10.x.x.250>: IPCP lowerdown
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug <10.x.x.250>: IPV6CP lowerdown
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug <10.x.x.250>: IPV6CP down event in starting state
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug <10.x.x.250>: MPLSCP lowerdown
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug <10.x.x.250>: MPLSCP down event in starting state
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <10.x.x.250>: sent LCP TermReq id=0x2
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet no network protocols running
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet <10.x.x.250>: rcvd LCP TermAck id=0x2
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug,packet no network protocols running
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug <10.x.x.250>: LCP lowerdown
Aug 22 12:17:49 10.x.x.254 pptp,ppp,info mikrotik: <pptp-0>: terminating... - no network protocols running
Aug 22 12:17:49 10.x.x.254 pptp,ppp,info <pptp-0>: terminating... - no network protocols running
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug <10.x.x.250>: LCP lowerdown
Aug 22 12:17:49 10.x.x.254 pptp,ppp,debug <10.x.x.250>: LCP down event in initial state
Aug 22 12:17:49 10.x.x.254 pptp,ppp,info mikrotik: <pptp-0>: disconnected
Aug 22 12:17:49 10.x.x.254 pptp,ppp,info <pptp-0>: disconnected
and radius talk...
Aug 22 12:25:12 10.x.x.254 pptp,info mikrotik: TCP connection established from 10.x.x.250
Aug 22 12:25:12 10.x.x.254 pptp,ppp,info mikrotik: <pptp-0>: waiting for call...
Aug 22 12:25:12 10.x.x.254 radius,debug new request 1b:4d code=Access-Request service=ppp called-id=ip.public.ip
Aug 22 12:25:12 10.x.x.254 radius,debug sending 1b:4d to 10.100.200.20:1812
Aug 22 12:25:12 10.x.x.254 radius,debug,packet sending Access-Request with id 42 to 10.x.x.20:1812
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Signature = 0xe478dbf8ee71760a0a3ed948994e18d3
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Service-Type = 2
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Framed-Protocol = 1
Aug 22 12:25:12 10.x.x.254 radius,debug,packet NAS-Port = 159
Aug 22 12:25:12 10.x.x.254 radius,debug,packet NAS-Port-Type = 5
Aug 22 12:25:12 10.x.x.254 radius,debug,packet User-Name = "user1"
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Calling-Station-Id = "10.x.x.250"
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Called-Station-Id = "ip.public.ip"
Aug 22 12:25:12 10.x.x.254 radius,debug,packet MS-CHAP-Challenge = 0xb0f7477aeeb8681e7de535280f9f9fdc
Aug 22 12:25:12 10.x.x.254 radius,debug,packet MS-CHAP2-Response = 0x01000564593a7297d2498f66e9371359
Aug 22 12:25:12 10.x.x.254 radius,debug,packet 8d0f0000000000000000f986c7e0e9a2
Aug 22 12:25:12 10.x.x.254 radius,debug,packet 795b4d5963efea1632fcd7fb4d439337
Aug 22 12:25:12 10.x.x.254 radius,debug,packet 0523
Aug 22 12:25:12 10.x.x.254 radius,debug,packet NAS-Identifier = "
www.domain.ciom"
Aug 22 12:25:12 10.x.x.254 radius,debug,packet NAS-IP-Address = 10.x.x.254
Aug 22 12:25:12 10.x.x.254 radius,debug,packet received Access-Accept with id 42 from 10.x.x.20:1812
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Signature = 0xdfc85acfb9c918a03510cbe6051f8dd0
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Framed-IP-Address = 255.255.255.255
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Framed-Protocol = 1
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Service-Type = 2
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Class = 0x44fc050a0000013700010a64c81401ce
Aug 22 12:25:12 10.x.x.254 radius,debug,packet 9f035022c8aa0000000000000031
Aug 22 12:25:12 10.x.x.254 radius,debug,packet MS-MPPE-Recv-Key = 0x8045dfefe2a690d3c9ad995ab31080b1
Aug 22 12:25:12 10.x.x.254 radius,debug,packet 190a68d817e6bf57817e0bd5f74ce3a4
Aug 22 12:25:12 10.x.x.254 radius,debug,packet b471
Aug 22 12:25:12 10.x.x.254 radius,debug,packet MS-MPPE-Send-Key = 0x80465d38904bb8e1c3a889a44670f436
Aug 22 12:25:12 10.x.x.254 radius,debug,packet 67476785bd70b6e6c7b464c30eddcf8c
Aug 22 12:25:12 10.x.x.254 radius,debug,packet ffb9
Aug 22 12:25:12 10.x.x.254 radius,debug,packet MS-CHAP2-Success = 0x01533d36363743303144454631373146
Aug 22 12:25:12 10.x.x.254 radius,debug,packet 45313939413943383431374639453630
Aug 22 12:25:12 10.x.x.254 radius,debug,packet 3936444334393135353730
Aug 22 12:25:12 10.x.x.254 radius,debug,packet MS-CHAP-Domain = 0x01434a4442
Aug 22 12:25:12 10.x.x.254 radius,debug,packet MS-MPPE-Encryption-Policy = 2
Aug 22 12:25:12 10.x.x.254 radius,debug,packet MS-MPPE-Encryption-Type = 4
Aug 22 12:25:12 10.x.x.254 radius,debug received reply for 1b:4d
Aug 22 12:25:12 10.x.x.254 pptp,ppp,info mikrotik: <pptp-0>: authenticated
Aug 22 12:25:12 10.x.x.254 radius,debug new request 1b:00 code=Accounting-Request service=ppp called-id=ip.public.ip
Aug 22 12:25:12 10.x.x.254 radius,debug sending 1b:00 to 10.x.x.20:1813
Aug 22 12:25:12 10.x.x.254 radius,debug,packet sending Accounting-Request with id 43 to 10.x.x.20:1813
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Signature = 0x7e79ed987b3360ceb05d993a0963ef87
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Service-Type = 2
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Framed-Protocol = 1
Aug 22 12:25:12 10.x.x.254 radius,debug,packet NAS-Port = 159
Aug 22 12:25:12 10.x.x.254 radius,debug,packet NAS-Port-Type = 5
Aug 22 12:25:12 10.x.x.254 radius,debug,packet User-Name = "user1"
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Calling-Station-Id = "10.x.x.250"
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Called-Station-Id = "ip.public.ip"
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Class = 0x44fc050a0000013700010a64c81401ce
Aug 22 12:25:12 10.x.x.254 radius,debug,packet 9f035022c8aa0000000000000031
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Acct-Session-Id = "8100000e"
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Framed-IP-Address = 0.0.0.0
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Acct-Authentic = 1
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Event-Timestamp = 1377163512
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Acct-Status-Type = 1
Aug 22 12:25:12 10.x.x.254 radius,debug,packet NAS-Identifier = "
www.domain.ciom"
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Acct-Delay-Time = 0
Aug 22 12:25:12 10.x.x.254 radius,debug,packet NAS-IP-Address = 10.x.x.254
Aug 22 12:25:12 10.x.x.254 radius,debug,packet received Accounting-Response with id 43 from 10.x.x.20:1813
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Signature = 0x81980e9cefba57fb81f1b03066a3b0d4
Aug 22 12:25:12 10.x.x.254 radius,debug received reply for 1b:00
Aug 22 12:25:12 10.x.x.254 radius,debug request 1b:00 processed
Aug 22 12:25:12 10.x.x.254 pptp,ppp,info mikrotik: <pptp-0>: terminating... - no network protocols running
Aug 22 12:25:12 10.x.x.254 radius,debug new request 1b:00 code=Accounting-Request service=ppp called-id=ip.public.ip
Aug 22 12:25:12 10.x.x.254 radius,debug sending 1b:00 to 10.x.x.20:1813
Aug 22 12:25:12 10.x.x.254 radius,debug,packet sending Accounting-Request with id 44 to 10.x.x.20:1813
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Signature = 0xddfc31329a4136c5b0843b9197a1054c
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Service-Type = 2
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Framed-Protocol = 1
Aug 22 12:25:12 10.x.x.254 radius,debug,packet NAS-Port = 159
Aug 22 12:25:12 10.x.x.254 radius,debug,packet NAS-Port-Type = 5
Aug 22 12:25:12 10.x.x.254 radius,debug,packet User-Name = "user1"
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Calling-Station-Id = "10.x.x.250"
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Called-Station-Id = "ip.public.ip"
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Class = 0x44fc050a0000013700010a64c81401ce
Aug 22 12:25:12 10.x.x.254 radius,debug,packet 9f035022c8aa0000000000000031
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Acct-Session-Id = "8100000e"
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Framed-IP-Address = 0.0.0.0
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Acct-Authentic = 1
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Event-Timestamp = 1377163512
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Acct-Session-Time = 0
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Acct-Input-Octets = 80
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Acct-Input-Gigawords = 0
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Acct-Input-Packets = 5
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Acct-Output-Octets = 82
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Acct-Output-Gigawords = 0
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Acct-Output-Packets = 7
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Acct-Status-Type = 2
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Acct-Terminate-Cause = 10
Aug 22 12:25:12 10.x.x.254 radius,debug,packet NAS-Identifier = "
www.domain.ciom"
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Acct-Delay-Time = 0
Aug 22 12:25:12 10.x.x.254 radius,debug,packet NAS-IP-Address = 10.x.x.254
Aug 22 12:25:12 10.x.x.254 radius,debug,packet received Accounting-Response with id 44 from 10.x.x.20:1813
Aug 22 12:25:12 10.x.x.254 radius,debug,packet Signature = 0x33c0d5173366b6406e73c888eb22b2fe
Aug 22 12:25:12 10.x.x.254 radius,debug received reply for 1b:00
Aug 22 12:25:12 10.x.x.254 radius,debug request 1b:00 processed
Aug 22 12:25:12 10.x.x.254 pptp,ppp,info mikrotik: <pptp-0>: disconnected