(RADIATOR) Cisco ADSL trouble.

Tue Oct 30 21:17:18 CST 2001

Hello Wayne -

The problem here is due to the fact that the NAS-Port value in all 
the access requests is always 0, therefore Radiator gets confused 
because the NAS-IP-Address/NAS-Port combination is what is used for 
the maintenance of the session database.

You will have to check with your vendor to get the problem fixed.

regards

Hugh

>     I have just turned up a 7206VXR with ADSL using PPPOA. I am
>authenticating to my Radiator server and everything works fine on the first
>DSL connection. But when I connect the second modem and look at radwho.cgi
>the connected user changes to the second modem that is connected and doesn't
>add the second user. The first user seems to be deleted in the database when
>the second user is added. I am using mysql for authentication and using the
>default online.db for storing on line users. Here is a cut from radwho and a
>debug session from two users connecing. The first user (dsl7844649) shows up
>in radwho.cgi than when the second one connects (dsl784044) the user
>infromation changes. I am running radiator-2.19 on freebsd 4.4. I get the
>same results with 2.18 on linux.
>       User-Name NAS-Identifier NAS-Port Acct-Session-Id Timestamp
>Framed-IP-Address NAS-Port-Type Service-Type
>   1 users:
>    dsl7844044 65.161.103.254 0 00000F95 Tue Oct 30 10:47:02 2001
>65.161.102.7 Virtual Framed-User delete session
>
>
>
>
>Tue Oct 30 10:45:02 2001: DEBUG: Packet dump:
>
>*** Received from 65.161.103.254 port 1645 ....
>
>Code: Access-Request
>
>Identifier: 196
>
>Authentic: <208>wq`<226><187><128>Q{<26><5><13>'<250>*<2>
>
>Attributes:
>
>NAS-IP-Address = 65.161.103.254
>
>NAS-Port = 0
>
>NAS-Port-Type = Virtual
>
>User-Name = "dsl7844649"
>
>User-Password = "{|<213> <166><0>x<201>n1j<228>X<12>i<148>"
>
>Service-Type = Framed-User
>
>Framed-Protocol = PPP
>
>Tue Oct 30 10:45:02 2001: DEBUG: Rewrote user name to dsl7844649
>
>Tue Oct 30 10:45:02 2001: DEBUG: Handling request with Handler
>'Realm=DEFAULT'
>
>Tue Oct 30 10:45:02 2001: DEBUG: Deleting session for dsl7844649,
>65.161.103.254, 0
>
>Tue Oct 30 10:45:02 2001: DEBUG: Handling with Radius::AuthSQL
>
>Tue Oct 30 10:45:02 2001: DEBUG: Handling with Radius::AuthSQL:
>
>Tue Oct 30 10:45:02 2001: DEBUG: Query is: select PASSWORD, CHECKATTR,
>REPLYATTR from SUBSCRIBERS where USERNAME='dsl7844649'
>
>Tue Oct 30 10:45:02 2001: DEBUG: Radius::AuthSQL looks for match with
>dsl7844649
>
>Tue Oct 30 10:45:02 2001: DEBUG: Expiration date converted to: 1261288800
>
>Tue Oct 30 10:45:02 2001: DEBUG: Radius::AuthSQL ACCEPT:
>
>Tue Oct 30 10:45:02 2001: DEBUG: Access accepted for dsl7844649
>
>Tue Oct 30 10:45:02 2001: DEBUG: Packet dump:
>
>*** Sending to 65.161.103.254 port 1645 ....
>
>Code: Access-Accept
>
>Identifier: 196
>
>Authentic: <208>wq`<226><187><128>Q{<26><5><13>'<250>*<2>
>
>Attributes:
>
>Framed-IP-Address = 65.161.102.20
>
>Service-Type = Framed-User
>
>Framed-Protocol = PPP
>
>Tue Oct 30 10:45:02 2001: DEBUG: Packet dump:
>
>*** Received from 65.161.103.254 port 1646 ....
>
>Code: Accounting-Request
>
>Identifier: 197
>
>Authentic: ^C<132><178><20>}X6<2><210><169>w<30><193>L:
>
>Attributes:
>
>NAS-IP-Address = 65.161.103.254
>
>NAS-Port = 0
>
>NAS-Port-Type = Virtual
>
>User-Name = "dsl7844649"
>
>Acct-Status-Type = Start
>
>Acct-Authentic = RADIUS
>
>Service-Type = Framed-User
>
>Acct-Session-Id = "00000F94"
>
>Framed-Protocol = PPP
>
>Acct-Delay-Time = 0
>
>Tue Oct 30 10:45:02 2001: DEBUG: Rewrote user name to dsl7844649
>
>Tue Oct 30 10:45:02 2001: DEBUG: Handling request with Handler
>'Realm=DEFAULT'
>
>Tue Oct 30 10:45:02 2001: DEBUG: Adding session for dsl7844649,
>65.161.103.254, 0
>
>Tue Oct 30 10:45:02 2001: DEBUG: Handling with Radius::AuthSQL
>
>Tue Oct 30 10:45:02 2001: DEBUG: Handling accounting with Radius::AuthSQL
>
>Tue Oct 30 10:45:02 2001: DEBUG: Accounting accepted
>
>Tue Oct 30 10:45:02 2001: DEBUG: Packet dump:
>
>*** Sending to 65.161.103.254 port 1646 ....
>
>Code: Accounting-Response
>
>Identifier: 197
>
>Authentic: ^C<132><178><20>}X6<2><210><169>w<30><193>L:
>
>Attributes:
>
>Tue Oct 30 10:45:02 2001: DEBUG: Packet dump:
>
>*** Received from 65.161.103.254 port 1646 ....
>
>Code: Accounting-Request
>
>Identifier: 198
>
>Authentic: v<128>]<191><254><142><218><21>F<202>f<142><213><145><224>r
>
>Attributes:
>
>NAS-IP-Address = 65.161.103.254
>
>NAS-Port = 0
>
>NAS-Port-Type = Virtual
>
>User-Name = "dsl7844649"
>
>Acct-Status-Type = Alive
>
>Acct-Authentic = RADIUS
>
>Service-Type = Framed-User
>
>Acct-Session-Id = "00000F94"
>
>Framed-Protocol = PPP
>
>Framed-IP-Address = 65.161.102.20
>
>Acct-Delay-Time = 0
>
>Tue Oct 30 10:45:02 2001: DEBUG: Rewrote user name to dsl7844649
>
>Tue Oct 30 10:45:02 2001: DEBUG: Handling request with Handler
>'Realm=DEFAULT'
>
>Tue Oct 30 10:45:02 2001: DEBUG: Adding session for dsl7844649,
>65.161.103.254, 0
>
>Tue Oct 30 10:45:02 2001: DEBUG: Handling with Radius::AuthSQL
>
>Tue Oct 30 10:45:02 2001: DEBUG: Handling accounting with Radius::AuthSQL
>
>Tue Oct 30 10:45:02 2001: DEBUG: Accounting accepted
>
>Tue Oct 30 10:45:02 2001: DEBUG: Packet dump:
>
>*** Sending to 65.161.103.254 port 1646 ....
>
>Code: Accounting-Response
>
>Identifier: 198
>
>Authentic: v<128>]<191><254><142><218><21>F<202>f<142><213><145><224>r
>
>Attributes:
>
>Tue Oct 30 10:47:02 2001: DEBUG: Packet dump:
>
>*** Received from 65.161.103.254 port 1645 ....
>
>Code: Access-Request
>
>Identifier: 199
>
>Authentic: <128><16><238>'&<228>T<208><2><217><159>Fbt:<228>
>
>Attributes:
>
>NAS-IP-Address = 65.161.103.254
>
>NAS-Port = 0
>
>NAS-Port-Type = Virtual
>
>User-Name = "dsl7844044"
>
>User-Password =
>"<180><165><157><140>;d{W<23><145>(<186><189><196><133><233>"
>
>Service-Type = Framed-User
>
>Framed-Protocol = PPP
>
>Tue Oct 30 10:47:02 2001: DEBUG: Rewrote user name to dsl7844044
>
>Tue Oct 30 10:47:02 2001: DEBUG: Handling request with Handler
>'Realm=DEFAULT'
>
>Tue Oct 30 10:47:02 2001: DEBUG: Deleting session for dsl7844044,
>65.161.103.254, 0
>
>Tue Oct 30 10:47:02 2001: DEBUG: Handling with Radius::AuthSQL
>
>Tue Oct 30 10:47:02 2001: DEBUG: Handling with Radius::AuthSQL:
>
>Tue Oct 30 10:47:02 2001: DEBUG: Query is: select PASSWORD, CHECKATTR,
>REPLYATTR from SUBSCRIBERS where USERNAME='dsl7844044'
>
>Tue Oct 30 10:47:02 2001: DEBUG: Radius::AuthSQL looks for match with
>dsl7844044
>
>Tue Oct 30 10:47:02 2001: DEBUG: Expiration date converted to: 1261288800
>
>Tue Oct 30 10:47:02 2001: DEBUG: Radius::AuthSQL ACCEPT:
>
>Tue Oct 30 10:47:02 2001: DEBUG: Access accepted for dsl7844044
>
>Tue Oct 30 10:47:02 2001: DEBUG: Packet dump:
>
>*** Sending to 65.161.103.254 port 1645 ....
>
>Code: Access-Accept
>
>Identifier: 199
>
>Authentic: <128><16><238>'&<228>T<208><2><217><159>Fbt:<228>
>
>Attributes:
>
>Framed-IP-Address = 65.161.102.7
>
>Service-Type = Framed-User
>
>Framed-Protocol = PPP
>
>Tue Oct 30 10:47:02 2001: DEBUG: Packet dump:
>
>*** Received from 65.161.103.254 port 1646 ....
>
>Code: Accounting-Request
>
>Identifier: 200
>
>Authentic: <167><195><220>;T<186><186><209><230><230><175><229>U<132>?<249>
>
>Attributes:
>
>NAS-IP-Address = 65.161.103.254
>
>NAS-Port = 0
>
>NAS-Port-Type = Virtual
>
>User-Name = "dsl7844044"
>
>Acct-Status-Type = Start
>
>Acct-Authentic = RADIUS
>
>Service-Type = Framed-User
>
>Acct-Session-Id = "00000F95"
>
>Framed-Protocol = PPP
>
>Acct-Delay-Time = 0
>
>Tue Oct 30 10:47:02 2001: DEBUG: Rewrote user name to dsl7844044
>
>Tue Oct 30 10:47:02 2001: DEBUG: Handling request with Handler
>'Realm=DEFAULT'
>
>Tue Oct 30 10:47:02 2001: DEBUG: Adding session for dsl7844044,
>65.161.103.254, 0
>
>Tue Oct 30 10:47:02 2001: DEBUG: Handling with Radius::AuthSQL
>
>Tue Oct 30 10:47:02 2001: DEBUG: Handling accounting with Radius::AuthSQL
>
>Tue Oct 30 10:47:02 2001: DEBUG: Accounting accepted
>
>Tue Oct 30 10:47:02 2001: DEBUG: Packet dump:
>
>*** Sending to 65.161.103.254 port 1646 ....
>
>Code: Accounting-Response
>
>Identifier: 200
>
>Authentic: <167><195><220>;T<186><186><209><230><230><175><229>U<132>?<249>
>
>Attributes:
>
>Tue Oct 30 10:47:02 2001: DEBUG: Packet dump:
>
>*** Received from 65.161.103.254 port 1646 ....
>
>Code: Accounting-Request
>
>Identifier: 201
>
>Authentic: <21>B<6><28>?<137><24><129><188>><196>*<222><240>Tv
>
>Attributes:
>
>NAS-IP-Address = 65.161.103.254
>
>NAS-Port = 0
>
>NAS-Port-Type = Virtual
>
>User-Name = "dsl7844044"
>
>Acct-Status-Type = Alive
>
>Acct-Authentic = RADIUS
>
>Service-Type = Framed-User
>
>Acct-Session-Id = "00000F95"
>
>Framed-Protocol = PPP
>
>Framed-IP-Address = 65.161.102.7
>
>Acct-Delay-Time = 0
>
>Tue Oct 30 10:47:02 2001: DEBUG: Rewrote user name to dsl7844044
>
>Tue Oct 30 10:47:02 2001: DEBUG: Handling request with Handler
>'Realm=DEFAULT'
>
>Tue Oct 30 10:47:02 2001: DEBUG: Adding session for dsl7844044,
>65.161.103.254, 0
>
>Tue Oct 30 10:47:02 2001: DEBUG: Handling with Radius::AuthSQL
>
>Tue Oct 30 10:47:02 2001: DEBUG: Handling accounting with Radius::AuthSQL
>
>Tue Oct 30 10:47:02 2001: DEBUG: Accounting accepted
>
>Tue Oct 30 10:47:02 2001: DEBUG: Packet dump:
>
>*** Sending to 65.161.103.254 port 1646 ....
>
>Code: Accounting-Response
>
>Identifier: 201
>
>Authentic: <21>B<6><28>?<137><24><129><188>><196>*<222><240>Tv
>
>Attributes:
>
>
>===
>Archive at http://www.open.com.au/archives/radiator/
>Announcements on radiator-announce at open.com.au
>To unsubscribe, email 'majordomo at open.com.au' with
>'unsubscribe radiator' in the body of the message.

-- 

NB: I am travelling this week, so there may be delays in our correspondence.

Radiator: the most portable, flexible and configurable RADIUS server
anywhere. SQL, proxy, DBM, files, LDAP, NIS+, password, NT, Emerald,
Platypus, Freeside, Interbiller, TACACS+, PAM, external, etc, etc.
Available on Unix, Linux, FreeBSD, Windows 95/98/2000, NT, MacOS X.
===
Archive at http://www.open.com.au/archives/radiator/
Announcements on radiator-announce at open.com.au
To unsubscribe, email 'majordomo at open.com.au' with
'unsubscribe radiator' in the body of the message.