(RADIATOR) Multilink Issues
Robert
robert at dicus.org
Fri Oct 8 08:14:48 CDT 2004
Radiator version that works: Radiator-3.3.1-1
Radiator version trying to move to: Radiator-3.9-2
Radiator version also tried: Radiator-3.6
Currently, we have several clients who utilize multilink sessions, both
PPP and ISDN. In our radius
attributes, we set them all to MPP and relay the attribute
Ascend-Maximum-Channels = 2. What we are
having a problem with is that when trying to move forward to the later
versions of Radiator, our
multilink clients are then unable to bond channels. We have no issues
with the current version running -
3.3.1-1, but when we tried 3.6, it failed, and now, we see the same
issue with 3.9-2. Previously, we had
no concerns or need to move forward, but we are faced with a requirement
now that we need the later
versions to work with. Problems exist when just plugging the exact same
configuration file in the new version
or a newer refined version allowing for our additional services.
I have trace 4 logs from both versions of Radiator:
***************************************************************************
3.3.1-1 of a working multilink:
Tue Sep 28 14:31:27 2004: DEBUG: Packet dump:
*** Received from 216.229.87.130 port 49 ....
Code: Access-Request
Identifier: 114
Authentic: O<212>K<189><20><175><251>b<153><255>Oh<207><16><139>&
Attributes:
User-Name = "marta"
User-Password = "<151>]/y<147> ><202><218>"
NAS-IP-Address = 216.229.87.130
NAS-Port = 10102
NAS-Port-Type = ISDN
Service-Type = Framed-User
Framed-Protocol = PPP
State = ""
Called-Station-Id = "4210192"
Acct-Session-Id = "386607085"
Ascend-Endpoint-Disc = "<3><0><160><197><224>w."
Ascend-Data-Rate = 64000
Ascend-Xmit-Rate = 64000
Tue Sep 28 14:31:27 2004: DEBUG: Rewrote user name to marta
Tue Sep 28 14:31:27 2004: DEBUG: Handling request with Handler ''
Tue Sep 28 14:31:27 2004: DEBUG: Deleting session for marta,
216.229.87.130, 10102
Tue Sep 28 14:31:27 2004: DEBUG: do query is: delete from radonline
where nasidentifier='216.229.87.130' and nasport='10102'
Tue Sep 28 14:31:27 2004: DEBUG: Handling with Radius::AuthSQL
Tue Sep 28 14:31:27 2004: DEBUG: Handling with Radius::AuthSQL:
Tue Sep 28 14:31:27 2004: DEBUG: Query is: select auth_pwd,
auth_checkattr, auth_replyattr from tools2002.authdata where
auth_uname='marta'
Tue Sep 28 14:31:27 2004: DEBUG: Radius::AuthSQL looks for match with marta
Tue Sep 28 14:31:27 2004: DEBUG: Query is: select nasidentifier,
nasport, acctsessionid from radonline where username='marta'
Tue Sep 28 14:31:27 2004: DEBUG: Radius::AuthSQL ACCEPT:
Tue Sep 28 14:31:27 2004: DEBUG: Access accepted for marta
Tue Sep 28 14:31:27 2004: DEBUG: Packet dump:
*** Sending to 216.229.87.130 port 49 ....
Code: Access-Accept
Identifier: 114
Authentic: O<212>K<189><20><175><251>b<153><255>Oh<207><16><139>&
Attributes:
Framed-IP-Address = 64.251.136.45
Framed-Protocol = MPP
Framed-IP-Netmask = 255.255.255.252
Ascend-Maximum-Channels = 2
Ascend-Idle-Limit = 1200
Ascend-Maximum-Call-Duration = 300
Service-Type = Framed-User
Framed-Routing = None
Tue Sep 28 14:31:27 2004: DEBUG: Packet dump:
*** Received from 216.229.87.130 port 50 ....
Code: Accounting-Request
Identifier: 134
Authentic: <249>W<29><181>l<221><211><168><138>g%{6v<22><241>
Attributes:
User-Name = "marta"
NAS-IP-Address = 216.229.87.130
NAS-Port = 10102
NAS-Port-Type = ISDN
Service-Type = Framed-User
Acct-Status-Type = Start
Acct-Delay-Time = 0
Acct-Session-Id = "386607085"
Acct-Authentic = RADIUS
Idle-Timeout = 30
Ascend-Multilink-ID = 1468152372
Ascend-Num-In-Multilink = 1
Acct-Link-Count = 1
Acct-Multi-Session-Id = "57823a34"
Ascend-Modem-PortNo = 2
Ascend-Modem-SlotNo = 9
Called-Station-Id = "4210192"
Framed-Protocol = 262
Framed-IP-Address = 64.251.136.45
Tue Sep 28 14:31:27 2004: DEBUG: Rewrote user name to marta
Tue Sep 28 14:31:27 2004: DEBUG: Handling request with Handler ''
Tue Sep 28 14:31:27 2004: DEBUG: Adding session for marta,
216.229.87.130, 10102
Tue Sep 28 14:31:27 2004: DEBUG: do query is: delete from radonline
where nasidentifier='216.229.87.130' and nasport='10102'
Tue Sep 28 14:31:27 2004: DEBUG: do query is: insert into radonline
(username, nasidentifier, nasport, acctsessionid, time_stamp,
framedipaddress, nasporttype, protocol, dnis, statid) values ('marta',
'216.229.87.130', 10102, '386607085',1096399887, '64.251.136.45',
'ISDN', '262','','4210192')
Tue Sep 28 14:31:27 2004: DEBUG: Handling with Radius::AuthSQL
Tue Sep 28 14:31:27 2004: DEBUG: Handling accounting with Radius::AuthSQL
Tue Sep 28 14:31:27 2004: DEBUG: Accounting accepted
Tue Sep 28 14:31:27 2004: DEBUG: Packet dump:
*** Sending to 216.229.87.130 port 50 ....
Code: Accounting-Response
Identifier: 134
Authentic: <249>W<29><181>l<221><211><168><138>g%{6v<22><241>
Attributes:
Tue Sep 28 14:31:32 2004: DEBUG: Packet dump:
*** Received from 216.229.87.130 port 49 ....
Code: Access-Request
Identifier: 115
Authentic: :<216><214>)<200>.5<231><131><211><172><175>P<11>h<
Attributes:
User-Name = "marta"
User-Password = "Dr<176>+<3><219><249>@<182>"
NAS-IP-Address = 216.229.87.130
NAS-Port = 10101
NAS-Port-Type = ISDN
Service-Type = Framed-User
Framed-Protocol = PPP
State = ""
Called-Station-Id = "4210192"
Acct-Session-Id = "386607086"
Ascend-Endpoint-Disc = "<3><0><160><197><224>w."
Ascend-Data-Rate = 64000
Ascend-Xmit-Rate = 64000
Tue Sep 28 14:31:32 2004: DEBUG: Rewrote user name to marta
Tue Sep 28 14:31:32 2004: DEBUG: Handling request with Handler ''
Tue Sep 28 14:31:32 2004: DEBUG: Deleting session for marta,
216.229.87.130, 10101
Tue Sep 28 14:31:32 2004: DEBUG: do query is: delete from radonline
where nasidentifier='216.229.87.130' and nasport='10101'
Tue Sep 28 14:31:32 2004: DEBUG: Handling with Radius::AuthSQL
Tue Sep 28 14:31:32 2004: DEBUG: Handling with Radius::AuthSQL:
Tue Sep 28 14:31:32 2004: DEBUG: Query is: select auth_pwd,
auth_checkattr, auth_replyattr from tools2002.authdata where
auth_uname='marta'
Tue Sep 28 14:31:32 2004: DEBUG: Radius::AuthSQL looks for match with marta
Tue Sep 28 14:31:32 2004: DEBUG: Query is: select nasidentifier,
nasport, acctsessionid from radonline where username='marta'
Tue Sep 28 14:31:32 2004: DEBUG: Radius::AuthSQL ACCEPT:
Tue Sep 28 14:31:32 2004: DEBUG: Access accepted for marta
Tue Sep 28 14:31:32 2004: DEBUG: Packet dump:
*** Sending to 216.229.87.130 port 49 ....
Code: Access-Accept
Identifier: 115
Authentic: :<216><214>)<200>.5<231><131><211><172><175>P<11>h<
Attributes:
Framed-IP-Address = 64.251.136.45
Framed-Protocol = MPP
Framed-IP-Netmask = 255.255.255.252
Ascend-Maximum-Channels = 2
Ascend-Idle-Limit = 1200
Ascend-Maximum-Call-Duration = 300
Service-Type = Framed-User
Framed-Routing = None
Tue Sep 28 14:31:32 2004: DEBUG: Packet dump:
*** Received from 216.229.87.130 port 50 ....
Code: Accounting-Request
Identifier: 135
Authentic: W<187><238>zdS:<29><27><217>?<7<212>#m
Attributes:
User-Name = "marta"
NAS-IP-Address = 216.229.87.130
NAS-Port = 10101
NAS-Port-Type = ISDN
Service-Type = Framed-User
Acct-Status-Type = Start
Acct-Delay-Time = 0
Acct-Session-Id = "386607086"
Acct-Authentic = RADIUS
Idle-Timeout = 30
Ascend-Multilink-ID = 1468152372
Ascend-Num-In-Multilink = 2
Acct-Link-Count = 2
Acct-Multi-Session-Id = "57823a34"
Ascend-Modem-PortNo = 1
Ascend-Modem-SlotNo = 9
Called-Station-Id = "4210192"
Framed-Protocol = 262
Framed-IP-Address = 64.251.136.45
Tue Sep 28 14:31:32 2004: DEBUG: Rewrote user name to marta
Tue Sep 28 14:31:32 2004: DEBUG: Handling request with Handler ''
Tue Sep 28 14:31:32 2004: DEBUG: Adding session for marta,
216.229.87.130, 10101
Tue Sep 28 14:31:32 2004: DEBUG: do query is: delete from radonline
where nasidentifier='216.229.87.130' and nasport='10101'
Tue Sep 28 14:31:32 2004: DEBUG: do query is: insert into radonline
(username, nasidentifier, nasport, acctsessionid, time_stamp,
framedipaddress, nasporttype, protocol, dnis, statid) values ('marta',
'216.229.87.130', 10101, '386607086',1096399892, '64.251.136.45',
'ISDN', '262','','4210192')
Tue Sep 28 14:31:32 2004: DEBUG: Handling with Radius::AuthSQL
Tue Sep 28 14:31:32 2004: DEBUG: Handling accounting with Radius::AuthSQL
Tue Sep 28 14:31:32 2004: DEBUG: Accounting accepted
Tue Sep 28 14:31:32 2004: DEBUG: Packet dump:
*** Sending to 216.229.87.130 port 50 ....
Code: Accounting-Response
Identifier: 135
Authentic: W<187><238>zdS:<29><27><217>?<7<212>#m
Attributes:
******************************************************************************************
3.9-2 of a non-working multilink, same customer:
Tue Sep 28 14:10:45 2004: DEBUG: Packet dump:
*** Received from 216.229.87.130 port 49 ....
Code: Access-Request
Identifier: 10
Authentic: 58<139><168><151>N<176><241>d<191><2>pU<253>Q<218>
Attributes:
User-Name = "marta"
User-Password = "<8><30><148>nk<162><243><189><241>"
NAS-IP-Address = 216.229.87.130
NAS-Port = 10101
NAS-Port-Type = ISDN
Service-Type = Framed-User
Framed-Protocol = PPP
State = ""
Called-Station-Id = "4210192"
Acct-Session-Id = "386607029"
Ascend-Endpoint-Disc = "<3><0><160><197><224>w."
Ascend-Data-Rate = 64000
Ascend-Xmit-Rate = 64000
Tue Sep 28 14:10:45 2004: DEBUG: Rewrote user name to marta
Tue Sep 28 14:10:45 2004: DEBUG: Rewrote user name to marta
Tue Sep 28 14:10:45 2004: DEBUG: Handling request with Handler ''
Tue Sep 28 14:10:45 2004: DEBUG: Rewrote user name to marta
Tue Sep 28 14:10:45 2004: DEBUG: Fidelity_RadOnline Deleting session for
marta, 216.229.87.130, 10101
Tue Sep 28 14:10:45 2004: DEBUG: do query is: 'delete from radonline
where nasidentifier='216.229.87.130' and nasport='10101'':
Tue Sep 28 14:10:45 2004: DEBUG: Handling with Radius::AuthSQL
Tue Sep 28 14:10:45 2004: DEBUG: Handling with Radius::AuthSQL:
Tue Sep 28 14:10:45 2004: DEBUG: Query is: 'select
auth_pwd,auth_checkattr,auth_replyattr from tools2002.authdata where
auth_uname='marta'':
Tue Sep 28 14:10:45 2004: DEBUG: Radius::AuthSQL looks for match with marta
Tue Sep 28 14:10:45 2004: DEBUG: Query is: 'select nasidentifier,
nasport, acctsessionid, framedipaddress from radonline where
username='marta'':
Tue Sep 28 14:10:45 2004: DEBUG: Radius::AuthSQL ACCEPT:
Tue Sep 28 14:10:45 2004: DEBUG: Access accepted for marta
Tue Sep 28 14:10:45 2004: DEBUG: Packet dump:
*** Sending to 216.229.87.130 port 49 ....
Code: Access-Accept
Identifier: 10
Authentic: 58<139><168><151>N<176><241>d<191><2>pU<253>Q<218>
Attributes:
Framed-IP-Address = 64.251.136.45
Framed-Protocol = MPP
Framed-IP-Netmask = 255.255.255.252
Ascend-Maximum-Channels = 2
Ascend-Idle-Limit = 1200
Ascend-Maximum-Call-Duration = 300
Service-Type = Framed-User
Framed-Routing = None
Tue Sep 28 14:10:45 2004: DEBUG: Packet dump:
*** Received from 216.229.87.130 port 50 ....
Code: Accounting-Request
Identifier: 56
Authentic: E<232>,<159><210><13><136><181><178>g<251>C<230><183>+<252>
Attributes:
User-Name = "marta"
NAS-IP-Address = 216.229.87.130
NAS-Port = 10101
NAS-Port-Type = ISDN
Service-Type = Framed-User
Acct-Status-Type = Start
Acct-Delay-Time = 0
Acct-Session-Id = "386607029"
Acct-Authentic = RADIUS
Idle-Timeout = 20
Ascend-Multilink-ID = 1468152361
Ascend-Num-In-Multilink = 1
Acct-Link-Count = 1
Acct-Multi-Session-Id = "57823a29"
Ascend-Modem-PortNo = 1
Ascend-Modem-SlotNo = 9
Called-Station-Id = "4210192"
Framed-Protocol = MP
Framed-IP-Address = 64.251.136.45
Tue Sep 28 14:10:45 2004: DEBUG: Rewrote user name to marta
Tue Sep 28 14:10:45 2004: DEBUG: Rewrote user name to marta
Tue Sep 28 14:10:45 2004: DEBUG: Handling request with Handler ''
Tue Sep 28 14:10:45 2004: DEBUG: Rewrote user name to marta
Tue Sep 28 14:10:45 2004: DEBUG: Fidelity_RadOnline Adding session for
marta, 216.229.87.130, 10101
Tue Sep 28 14:10:45 2004: DEBUG: do query is: 'delete from radonline
where nasidentifier='216.229.87.130' and nasport='10101'':
Tue Sep 28 14:10:45 2004: DEBUG: do query is: 'insert into radonline
(username, nasidentifier, nasport, acctsessionid, time_stamp,
framedipaddress, nasporttype, servicetype, protocol, dnis, statid)
values ('marta', '216.229.87.130', 10101, '386607029', 1096398645,
'64.251.136.45', 'ISDN', 'Framed-User', 'MP', '', '4210192')':
Tue Sep 28 14:10:45 2004: DEBUG: Handling with Radius::AuthSQL
Tue Sep 28 14:10:45 2004: DEBUG: Handling accounting with Radius::AuthSQL
Tue Sep 28 14:10:45 2004: DEBUG: Accounting accepted
Tue Sep 28 14:10:45 2004: DEBUG: Packet dump:
*** Sending to 216.229.87.130 port 50 ....
Code: Accounting-Response
Identifier: 56
Authentic: E<232>,<159><210><13><136><181><178>g<251>C<230><183>+<252>
Attributes:
Tue Sep 28 14:10:49 2004: DEBUG: Packet dump:
*** Received from 216.229.87.130 port 49 ....
Code: Access-Request
Identifier: 11
Authentic: <31><27><27><171><204><197>7[<26>Y<31>&2P<156><156>
Attributes:
User-Name = "marta"
User-Password = "<134><180><151><237>%<250>-<134>J"
NAS-IP-Address = 216.229.87.130
NAS-Port = 10102
NAS-Port-Type = ISDN
Service-Type = Framed-User
Framed-Protocol = PPP
State = ""
Called-Station-Id = "4210192"
Acct-Session-Id = "386607030"
Ascend-Endpoint-Disc = "<3><0><160><197><224>w."
Ascend-Data-Rate = 64000
Ascend-Xmit-Rate = 64000
Tue Sep 28 14:10:49 2004: DEBUG: Rewrote user name to marta
Tue Sep 28 14:10:49 2004: DEBUG: Rewrote user name to marta
Tue Sep 28 14:10:49 2004: DEBUG: Handling request with Handler ''
Tue Sep 28 14:10:49 2004: DEBUG: Rewrote user name to marta
Tue Sep 28 14:10:49 2004: DEBUG: Fidelity_RadOnline Deleting session for
marta, 216.229.87.130, 10102
Tue Sep 28 14:10:49 2004: DEBUG: do query is: 'delete from radonline
where nasidentifier='216.229.87.130' and nasport='10102'':
Tue Sep 28 14:10:49 2004: DEBUG: Handling with Radius::AuthSQL
Tue Sep 28 14:10:49 2004: DEBUG: Handling with Radius::AuthSQL:
Tue Sep 28 14:10:49 2004: DEBUG: Query is: 'select
auth_pwd,auth_checkattr,auth_replyattr from tools2002.authdata where
auth_uname='marta'':
Tue Sep 28 14:10:49 2004: DEBUG: Radius::AuthSQL looks for match with marta
Tue Sep 28 14:10:49 2004: DEBUG: Query is: 'select nasidentifier,
nasport, acctsessionid, framedipaddress from radonline where
username='marta'':
Tue Sep 28 14:10:49 2004: DEBUG: Radius::AuthSQL ACCEPT:
Tue Sep 28 14:10:49 2004: DEBUG: Access accepted for marta
Tue Sep 28 14:10:49 2004: DEBUG: Packet dump:
*** Sending to 216.229.87.130 port 49 ....
Code: Access-Accept
Identifier: 11
Authentic: <31><27><27><171><204><197>7[<26>Y<31>&2P<156><156>
Attributes:
Framed-IP-Address = 64.251.136.45
Framed-Protocol = MPP
Framed-IP-Netmask = 255.255.255.252
Ascend-Maximum-Channels = 2
Ascend-Idle-Limit = 1200
Ascend-Maximum-Call-Duration = 300
Service-Type = Framed-User
Framed-Routing = None
Tue Sep 28 14:10:49 2004: DEBUG: Packet dump:
*** Received from 216.229.87.130 port 50 ....
Code: Accounting-Request
Identifier: 57
Authentic:
<159><176><181>R<208><210><154>M<242><216><182><154>m<196><16><229>
Attributes:
User-Name = "marta"
NAS-IP-Address = 216.229.87.130
NAS-Port = 10102
NAS-Port-Type = ISDN
Service-Type = Framed-User
Acct-Status-Type = Stop
Acct-Delay-Time = 0
Acct-Session-Id = "386607030"
Ascend-Disconnect-Cause = pppClosedMpAddChanFail
Ascend-Connect-Progress = prLCPOpened
Ascend-Xmit-Rate = 64000
Ascend-Data-Rate = 64000
Ascend-PreSession-Time = 1
Ascend-Pre-Input-Octets = 153
Ascend-Pre-Output-Octets = 125
Ascend-Pre-Input-Packets = 5
Ascend-Pre-Output-Packets = 5
Ascend-Modem-PortNo = 2
Ascend-Modem-SlotNo = 9
Called-Station-Id = "4210192"
Framed-Protocol = MP
Framed-IP-Address = 64.251.136.45
Tue Sep 28 14:10:49 2004: DEBUG: Rewrote user name to marta
Tue Sep 28 14:10:49 2004: DEBUG: Rewrote user name to marta
Tue Sep 28 14:10:49 2004: DEBUG: Handling request with Handler ''
Tue Sep 28 14:10:49 2004: DEBUG: Rewrote user name to marta
Tue Sep 28 14:10:49 2004: DEBUG: Fidelity_RadOnline Deleting session for
marta, 216.229.87.130, 10102
Tue Sep 28 14:10:49 2004: DEBUG: do query is: 'delete from radonline
where nasidentifier='216.229.87.130' and nasport='10102'':
Tue Sep 28 14:10:49 2004: DEBUG: Handling with Radius::AuthSQL
Tue Sep 28 14:10:49 2004: DEBUG: Handling accounting with Radius::AuthSQL
Tue Sep 28 14:10:49 2004: DEBUG: do query is: 'insert into accounting
(acctdelaytime,acctsessionid,acctstatustype,acctterminatecause,calledstation,datarate,disconnect,framedipaddress,modemport,modemslot,nasidentifier,nasport,protocol,servicetype,time_stamp,transmitrate,username)
values
(0,'386607030','Stop',49,'4210192',64000,'pppClosedMpAddChanFail','64.251.136.45','2','9','216.229.87.130',10102,'MP','Framed-User',1096398649,64000,'marta')':
Tue Sep 28 14:10:49 2004: DEBUG: Accounting accepted
Tue Sep 28 14:10:49 2004: DEBUG: Packet dump:
*** Sending to 216.229.87.130 port 50 ....
Code: Accounting-Response
Identifier: 57
Authentic:
<159><176><181>R<208><210><154>M<242><216><182><154>m<196><16><229>
Attributes:
*******************************************************************
I can also provide all configurations if necessary also. I've gone
through the mailing lists trying to find an old resolution but have
not run across any answers to my question. If anyone has any
information that may help me, I would appreciate it and as said before, I
can provide any information necessary.
Thanks,
Robert
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://www.open.com.au/pipermail/radiator/attachments/20041008/4bf75632/attachment.html>
More information about the radiator
mailing list