Re: [Help-gnu-radius] Assign network informations

[Frank Matthias]

Hi there,

> 
>       category debug {
>              ...
>              level "radius.c"=100;
> 
> 
I'm doing this and finally it works. BTW if there is follow config,
radiusd core dumps with signal 11.
category debug {
        level "radius.c"=100;
        channel debug;
}

As I had changed the lines, it works.
But anyway, the output is similar to yours

Okt 31 13:04:51: Info: ready
Okt 31 13:04:51: Info: /usr/local/etc/raddb/users reloaded.
Okt 31 13:04:51: Info: using 146.254.160.26 as my IP address
      recv: NAS-IP-Address = 10.1.9.20
      recv: NAS-Port-Id = 30001
      recv: Cisco-PRI-Circuit = "BRI0/0:1*"
      recv: NAS-Port-Type = ISDN
      recv: User-Name = "alex"
      recv: Called-Station-Id = "897245"
      recv: Calling-Station-Id = "9131897239"
      recv: Password = "2<3ó»RÅ?C© Z±?¥"
      recv: Service-Type = Framed-User
      recv: Framed-Protocol = PPP
     reply: Service-Type = Framed-User
     reply: Framed-Protocol = PPP
     reply: Cisco-AVPair = "ip:addr-pool = access1"
     reply: Cisco-AVPair = "ip:dns-servers = 146.254.160.30"
     reply: Cisco-AVPair = "ip:wins-servers = 146.254.168.201"

The debugging output of the cisco shows that there are some problems
around lcp and multilink. 
Cisco-AVPair .... is not applied for [lcp|multilink].

> If it is so, then the problem should be looked in the configuration of
> cisco. If not, we'll have to dig further :^)
I agree with you that there have to be a problem with the cisco,
because the A/V-Pairs were sent out.

Regards 
Matthias

00:29:90194313216: %LINK-3-UPDOWN: Interface BRI0/0:1, changed state to up
00:29:92341796837: BR0/0:1 PPP: Treating connection as a callin
00:29:92352406100: BR0/0:1 PPP: Phase is ESTABLISHING, Passive Open [0 sess, 1 l
oad]
00:29:92354857276: BR0/0:1 LCP: State is Listen
00:29:21: BR0/0:1 LCP: I CONFREQ [Listen] id 0 len 41
00:29:21: BR0/0:1 LCP:    MagicNumber 0x6EEE1097 (0x05066EEE1097)
00:29:21: BR0/0:1 LCP:    PFC (0x0702)
00:29:21: BR0/0:1 LCP:    ACFC (0x0802)
00:29:21: BR0/0:1 LCP:    MRRU 1614 (0x1104064E)
00:29:21: BR0/0:1 LCP:    EndpointDisc 1 Local
00:29:21: BR0/0:1 LCP:     (0x131701E4E8F601854D42E3A6890AE10F)
00:29:21: BR0/0:1 LCP:     (0x774AEA00000000)
00:29:21: BR0/0:1 LCP: O CONFREQ [Listen] id 2 len 34
00:29:21: BR0/0:1 LCP:    AuthProto PAP (0x0304C023)
00:29:21: BR0/0:1 LCP:    MagicNumber 0x015DD9F1 (0x0506015DD9F1)
00:29:21: BR0/0:1 LCP:    MRRU 1524 (0x110405F4)
00:29:21: BR0/0:1 LCP:    EndpointDisc 1 NAS-Ralf-Test (0x1310014E41532D52616C66
2D54657374)
00:29:21: BR0/0:1 LCP: O CONFACK [Listen] id 0 len 41
00:29:21: BR0/0:1 LCP:    MagicNumber 0x6EEE1097 (0x05066EEE1097)
00:29:21: BR0/0:1 LCP:    PFC (0x0702)
00:29:21: BR0/0:1 LCP:    ACFC (0x0802)
00:29:21: BR0/0:1 LCP:    MRRU 1614 (0x1104064E)
00:29:21: BR0/0:1 LCP:    EndpointDisc 1 Local
00:29:21: BR0/0:1 LCP:     (0x131701E4E8F601854D42E3A6890AE10F)
00:29:21: BR0/0:1 LCP:     (0x774AEA00000000)
00:29:21: BR0/0:1 LCP: I CONFACK [ACKsent] id 2 len 34
00:29:21: BR0/0:1 LCP:    AuthProto PAP (0x0304C023)
00:29:21: BR0/0:1 LCP:    MagicNumber 0x015DD9F1 (0x0506015DD9F1)
00:29:21: BR0/0:1 LCP:    MRRU 1524 (0x110405F4)
00:29:21: BR0/0:1 LCP:    EndpointDisc 1 NAS-Ralf-Test (0x1310014E41532D52616C66
2D54657374)
00:29:21: BR0/0:1 LCP: State is Open
00:29:21: BR0/0:1 PPP: Phase is AUTHENTICATING, by this end [0 sess, 0 load]
00:29:21: BR0/0:1 PAP: I AUTH-REQ id 1 len 14 from "alex"
00:29:21: BR0/0:1 PAP: Authenticating peer alex
00:29:21: RADIUS: ustruct sharecount=2
00:29:21: Radius: radius_port_info() success=1 radius_nas_port=1
00:29:21: RADIUS: added cisco VSA 2 len 9 "BRI0/0:1*"
00:29:21: RADIUS: Initial Transmit BRI0/0:1* id 2 146.254.160.26:1645, Access-Re
quest, len 111
00:29:21:         Attribute 4 6 0A010914
00:29:21:         Attribute 5 6 00007531
00:29:21:         Attribute 26 17 00000009020B4252
00:29:21:         Attribute 61 6 00000002
00:29:21:         Attribute 1 6 616C6578
00:29:21:         Attribute 30 8 38393732
00:29:21:         Attribute 31 12 39313331
00:29:21:         Attribute 2 18 323C33A2
00:29:21:         Attribute 6 6 00000002
00:29:21:         Attribute 7 6 00000001
00:29:21: RADIUS: Received from id 2 146.254.160.26:1645, Access-Accept, len 142

00:29:21:         Attribute 6 6 00000002
00:29:21:         Attribute 7 6 00000001
00:29:21:         Attribute 26 30 0000000901186970
00:29:21:         Attribute 26 39 0000000901216970
00:29:21:         Attribute 26 41 0000000901236970
00:29:21: RADIUS: saved authorization data for user 80D80794 at 80E25114
00:29:21: RADIUS: cisco AVPair "ip:addr-pool = access1" not applied for lcp
00:29:21: RADIUS: cisco AVPair "ip:dns-servers = 146.254.160.30" not applied for
 lcp
00:29:21: RADIUS: cisco AVPair "ip:wins-servers = 146.254.168.201" not applied f
or lcp
00:29:21: BR0/0:1 PAP: O AUTH-ACK id 1 len 5
00:29:21: BR0/0:1 PPP: Phase is VIRTUALIZED [0 sess, 0 load]
00:29:21: RADIUS: cisco AVPair "ip:addr-pool = access1" not applied for multilin
k
00:29:21: RADIUS: cisco AVPair "ip:dns-servers = 146.254.160.30" not applied for
 multilink
00:29:21: RADIUS: cisco AVPair "ip:wins-servers = 146.254.168.201" not applied f
or multilink
00:29:21: Vi1 PPP: Phase is DOWN, Setup [0 sess, 0 load]
00:29:21: %LINK-3-UPDOWN: Interface Virtual-Access1, changed state to up
00:29:21: Vi1 PPP: Treating connection as a callin
00:29:21: Vi1 PPP: Phase is ESTABLISHING, Passive Open [0 sess, 0 load]
00:29:21: Vi1 LCP: State is Listen
00:29:21: Vi1 PPP: Phase is UP [0 sess, 0 load]
00:29:21: RADIUS: cisco AVPair "ip:addr-pool = access1"
00:29:21: RADIUS: cisco AVPair "ip:dns-servers = 146.254.160.30"
00:29:21: RADIUS: cisco AVPair "ip:wins-servers = 146.254.168.201"
00:29:21: Vi1 IPCP: O CONFREQ [Closed] id 1 len 10
00:29:21: Vi1 IPCP:    Address 10.1.9.20 (0x03060A010914)
00:29:21: Vi1 MLP: Added first link BR0/0:1 to bundle alex
00:29:21: Vi1 CCP: I CONFREQ [Not negotiated] id 1 len 10
00:29:21: Vi1 CCP:    MS-PPC supported bits 0x00000001 (0x120600000001)
00:29:21: Vi1 LCP: O PROTREJ [Open] id 1 len 16 protocol CCP (0x80FD0101000A1206
00000001)
00:29:21: Vi1 IPCP: I CONFREQ [REQsent] id 2 len 40
00:29:21: Vi1 IPCP:    CompressType VJ 15 slots CompressSlotID (0x0206002D0F01)
00:29:21: Vi1 IPCP:    Address 0.0.0.0 (0x030600000000)
00:29:21: Vi1 IPCP:    PrimaryDNS 0.0.0.0 (0x810600000000)
00:29:21: Vi1 IPCP:    PrimaryWINS 0.0.0.0 (0x820600000000)
00:29:21: Vi1 IPCP:    SecondaryDNS 0.0.0.0 (0x830600000000)
00:29:21: Vi1 IPCP:    SecondaryWINS 0.0.0.0 (0x840600000000)
00:29:21: Vi1 AAA/AUTHOR/IPCP: Start.  Her address 0.0.0.0, we want 0.0.0.0
00:29:21: RADIUS: cisco AVPair "ip:addr-pool = access1"
00:29:21: RADIUS: cisco AVPair "ip:dns-servers = 146.254.160.30"
00:29:21: RADIUS: cisco AVPair "ip:wins-servers = 146.254.168.201"
00:29:21: Vi1 LCP: O PROTREJ [Open] id 2 len 46 protocol IPCP
00:29:21: Vi1 LCP:  (0x8021010200280206002D0F0103060000)
00:29:21: Vi1 LCP:  (0x00008106000000008206000000008306)
00:29:21: Vi1 LCP:  (0x00000000840600000000)
00:29:21: Vi1 IPCP: State is Closed
00:29:21: Vi1 IPCP: I CONFACK [Closed] id 1 len 10
00:29:21: Vi1 IPCP:    Address 10.1.9.20 (0x03060A010914)
00:29:21: Vi1 IPCP: Lower layer not up, discarding packet
00:29:22: BR0/0:1 LCP: I TERMREQ [Open] id 3 len 16 (0x6EEE1097003CCD7400000000)

00:29:22: BR0/0:1 LCP: O TERMACK [Open] id 3 len 4
00:29:22: BR0/0:1 PPP: Phase is TERMINATING [0 sess, 0 load]
00:29:22: %ISDN-6-CONNECT: Interface BRI0/0:1 is now connected to 9131897239 ale
x
00:29:22: %LINK-3-UPDOWN: Interface BRI0/0:1, changed state to down
00:29:22: BR0/0:1 LCP: State is Closed
00:29:22: BR0/0:1 PPP: Phase is DOWN [0 sess, 0 load]
00:29:23: Vi1 LCP: Missed link down notification
00:29:23: Vi1 PPP: Phase is TERMINATING [0 sess, 0 load]
00:29:23: Vi1 LCP: State is Closed
00:29:23: Vi1 PPP: Phase is DOWN [0 sess, 0 load]
00:30:94489280512: %LINK-3-UPDOWN: Interface BRI0/0:1, changed state to up
00:30:96636764133: BR0/0:1 PPP: Treating connection as a callin
00:30:96647373396: BR0/0:1 PPP: Phase is ESTABLISHING, Passive Open [0 sess, 0 l
oad]
00:30:96649824572: BR0/0:1 LCP: State is Listen
00:30:23: BR0/0:1 LCP: I CONFREQ [Listen] id 0 len 41
00:30:23: BR0/0:1 LCP:    MagicNumber 0x7E63166F (0x05067E63166F)
00:30:23: BR0/0:1 LCP:    PFC (0x0702)
00:30:23: BR0/0:1 LCP:    ACFC (0x0802)
00:30:23: BR0/0:1 LCP:    MRRU 1614 (0x1104064E)
00:30:23: BR0/0:1 LCP:    EndpointDisc 1 Local
00:30:23: BR0/0:1 LCP:     (0x131701E4E8F601854D42E3A6890AE10F)
00:30:23: BR0/0:1 LCP:     (0x774AEA00000000)
00:30:23: BR0/0:1 LCP: O CONFREQ [Listen] id 3 len 34
00:30:23: BR0/0:1 LCP:    AuthProto PAP (0x0304C023)
00:30:23: BR0/0:1 LCP:    MagicNumber 0x015EC9F2 (0x0506015EC9F2)
00:30:23: BR0/0:1 LCP:    MRRU 1524 (0x110405F4)
00:30:23: BR0/0:1 LCP:    EndpointDisc 1 NAS-Ralf-Test (0x1310014E41532D52616C66
2D54657374)
00:30:23: BR0/0:1 LCP: O CONFACK [Listen] id 0 len 41
00:30:23: BR0/0:1 LCP:    MagicNumber 0x7E63166F (0x05067E63166F)
00:30:23: BR0/0:1 LCP:    PFC (0x0702)
00:30:23: BR0/0:1 LCP:    ACFC (0x0802)
00:30:23: BR0/0:1 LCP:    MRRU 1614 (0x1104064E)
00:30:23: BR0/0:1 LCP:    EndpointDisc 1 Local
00:30:23: BR0/0:1 LCP:     (0x131701E4E8F601854D42E3A6890AE10F)
00:30:23: BR0/0:1 LCP:     (0x774AEA00000000)
00:30:23: BR0/0:1 LCP: I CONFACK [ACKsent] id 3 len 34
00:30:23: BR0/0:1 LCP:    AuthProto PAP (0x0304C023)
00:30:23: BR0/0:1 LCP:    MagicNumber 0x015EC9F2 (0x0506015EC9F2)
00:30:23: BR0/0:1 LCP:    MRRU 1524 (0x110405F4)
00:30:23: BR0/0:1 LCP:    EndpointDisc 1 NAS-Ralf-Test (0x1310014E41532D52616C66
2D54657374)
00:30:23: BR0/0:1 LCP: State is Open
00:30:23: BR0/0:1 PPP: Phase is AUTHENTICATING, by this end [0 sess, 0 load]
00:30:23: BR0/0:1 PAP: I AUTH-REQ id 2 len 14 from "alex"
00:30:23: BR0/0:1 PAP: Authenticating peer alex
00:30:23: RADIUS: ustruct sharecount=2
00:30:23: Radius: radius_port_info() success=1 radius_nas_port=1
00:30:23: RADIUS: added cisco VSA 2 len 9 "BRI0/0:1*"
00:30:23: RADIUS: Initial Transmit BRI0/0:1* id 3 146.254.160.26:1645, Access-Re
quest, len 111
00:30:23:         Attribute 4 6 0A010914
00:30:23:         Attribute 5 6 00007531
00:30:23:         Attribute 26 17 00000009020B4252
00:30:23:         Attribute 61 6 00000002
00:30:23:         Attribute 1 6 616C6578
00:30:23:         Attribute 30 8 38393732
00:30:23:         Attribute 31 12 39313331
00:30:23:         Attribute 2 18 D098FFEE
00:30:23:         Attribute 6 6 00000002
00:30:23:         Attribute 7 6 00000001
00:30:23: RADIUS: Received from id 3 146.254.160.26:1645, Access-Accept, len 142

00:30:23:         Attribute 6 6 00000002
00:30:23:         Attribute 7 6 00000001
00:30:23:         Attribute 26 30 0000000901186970
00:30:23:         Attribute 26 39 0000000901216970
00:30:23:         Attribute 26 41 0000000901236970
00:30:23: RADIUS: saved authorization data for user 80E25114 at 810482B8
00:30:23: RADIUS: cisco AVPair "ip:addr-pool = access1" not applied for lcp
00:30:23: RADIUS: cisco AVPair "ip:dns-servers = 146.254.160.30" not applied for
 lcp
00:30:23: RADIUS: cisco AVPair "ip:wins-servers = 146.254.168.201" not applied f
or lcp
00:30:23: BR0/0:1 PAP: O AUTH-ACK id 2 len 5
00:30:23: BR0/0:1 PPP: Phase is VIRTUALIZED [0 sess, 0 load]
00:30:23: RADIUS: cisco AVPair "ip:addr-pool = access1" not applied for multilin
k
00:30:23: RADIUS: cisco AVPair "ip:dns-servers = 146.254.160.30" not applied for
 multilink
00:30:23: RADIUS: cisco AVPair "ip:wins-servers = 146.254.168.201" not applied f
or multilink
00:30:23: Vi1 PPP: Phase is DOWN, Setup [0 sess, 0 load]