Главная страница


ru.unix.bsd

 
 - RU.UNIX.BSD ------------------------------------------------------------------
 From : Alexey Popov                         2:5020/400     27 Jan 2005  11:55:08
 To : All
 Subject : userland ppp в 4.11 иногда не посылает Радиусу стоп-пакеты
 -------------------------------------------------------------------------------- 
 
 Привет!
 
 Случается это, например, когда момент отваливания по idle-таймеру 
 совпадает c моментом отправки alive-пакета радиусу. Бывает очень 
 неприятно, юзер по мнению радиуса продолжает всиеть на линии и больше не 
 может авторизоваться.
 
 Вот пример неправильной работы (добавлены отладочные сообщения):
 
 Jan 26 17:17:16 magnum ppp[289]: Phase: Using interface: tun0
 Jan 26 17:17:16 magnum ppp[289]: Phase: deflink: Created in closed state
 Jan 26 17:17:16 magnum ppp[289]: tun0: Command: default: ident user-ppp 
 VERSION (built COMPILATIONDATE)
 Jan 26 17:17:16 magnum ppp[289]: tun0: Command: default: set device 
 /dev/cuaa1
 Jan 26 17:17:16 magnum ppp[289]: tun0: Command: default: set speed 115200
 Jan 26 17:17:16 magnum ppp[289]: tun0: Command: default: set dial ABORT 
 BUSY ABORT NO\sCARRIER TIMEOUT 5            "" AT OK-AT-OK ATE1Q0 OK 
 \dATDT\T TIMEOUT
 40 CONNECT
 Jan 26 17:17:16 magnum ppp[289]: tun0: Command: default: set timeout 180
 Jan 26 17:17:16 magnum ppp[289]: tun0: Command: default: enable dns
 Jan 26 17:17:16 magnum ppp[289]: tun0: Command: pppoed: enable chap pap 
 passwdauth
 Jan 26 17:17:16 magnum ppp[289]: tun0: Command: pppoed: set ifaddr 
 192.168.2.1 192.168.2.101-192.168.2.199
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP: Selected IP address 
 192.168.2.156
 Jan 26 17:17:16 magnum ppp[289]: tun0: Command: pppoed: disable pap chap
 Jan 26 17:17:16 magnum ppp[289]: tun0: Command: pppoed: deny pap chap
 Jan 26 17:17:16 magnum ppp[289]: tun0: Command: pppoed: enable chap
 Jan 26 17:17:16 magnum ppp[289]: tun0: Command: pppoed: accept dns
 Jan 26 17:17:16 magnum ppp[289]: tun0: Command: pppoed: disable ipv6cp
 Jan 26 17:17:16 magnum ppp[289]: tun0: Command: pppoed: disable pred1 
 deflate lqr
 Jan 26 17:17:16 magnum ppp[289]: tun0: Command: pppoed: deny pred1 
 deflate lqr
 Jan 26 17:17:16 magnum ppp[289]: tun0: Command: pppoed: set timeout 30
 Jan 26 17:17:16 magnum ppp[289]: tun0: Command: pppoed: set rad_alive 30
 Jan 26 17:17:16 magnum ppp[289]: tun0: Command: pppoed: set radius 
 /etc/radius.conf
 Jan 26 17:17:16 magnum ppp[289]: tun0: Phase: PPP Started (direct mode).
 Jan 26 17:17:16 magnum ppp[289]: tun0: Phase: bundle: Establish
 Jan 26 17:17:16 magnum ppp[289]: tun0: Phase: deflink: closed -> opening
 Jan 26 17:17:16 magnum ppp[289]: tun0: Phase: deflink: Link is a 
 netgraph node
 Jan 26 17:17:16 magnum ppp[289]: tun0: Phase: deflink: Connected!
 Jan 26 17:17:16 magnum ppp[289]: tun0: Phase: deflink: opening -> carrier
 Jan 26 17:17:16 magnum ppp[289]: tun0: Phase: deflink: carrier -> lcp
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP: FSM: Using "deflink" as a 
 transport
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP: deflink: State change 
 Initial --> Closed
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP: deflink: State change Closed 
 
 --> Stopped
 
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP: deflink: RecvConfigReq(0) 
 state = Stopped
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  MRU[4] 1492
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  MAGICNUM[6] 0x408648e9
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  CALLBACK[3] CBCP
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  MRRU[4] 1614
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  ENDDISC[23] Local Addr: 
 <FF>-<FD><B4>]sG<F6><BC><A4>[<FD>6<<DA><F3>
 Jan 26 17:17:16 magnum ppp[289]: tun0: Warning: deflink: Reducing 
 configured MRU from 1500 to 1492
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP: deflink: SendConfigReq(1) 
 state = Stopped
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  ACFCOMP[2]
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  PROTOCOMP[2]
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  ACCMAP[6] 0x00000000
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  MRU[4] 1492
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  MAGICNUM[6] 0x98bd24e8
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x05)
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP: deflink: SendConfigRej(0) 
 state = Stopped
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  CALLBACK[3] CBCP
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  MRRU[4] 1614
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP: deflink: SendIdent(0) state 
 = Stopped
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  MAGICNUM 98bd24e8
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  TEXT user-ppp 3.2 (built 
 Jan 24 2005)
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP: deflink: LayerStart
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP: deflink: State change 
 Stopped --> Req-Sent
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP: deflink: RecvConfigRej(1) 
 state = Req-Sent
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP: deflink: SendIdent(1) state 
 = Req-Sent
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  MAGICNUM 98bd24e8
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  TEXT user-ppp 3.2 (built 
 Jan 24 2005)
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  ACFCOMP[2]
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  PROTOCOMP[2]
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP: deflink: SendConfigReq(2) 
 state = Req-Sent
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  ACCMAP[6] 0x00000000
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  MRU[4] 1492
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  MAGICNUM[6] 0x98bd24e8
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x05)
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP: deflink: RecvConfigReq(1) 
 state = Req-Sent
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  MRU[4] 1492
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  MAGICNUM[6] 0x408648e9
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  ENDDISC[23] Local Addr: 
 <FF>-<FD><B4>]sG<F6><BC><A4>[<FD>6<<DA><F3>
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP: deflink: SendConfigAck(1) 
 state = Req-Sent
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  MRU[4] 1492
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  MAGICNUM[6] 0x408648e9
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  ENDDISC[23] Local Addr: 
 <FF>-<FD><B4>]sG<F6><BC><A4>[<FD>6<<DA><F3>
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP: deflink: State change 
 Req-Sent --> Ack-Sent
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP: deflink: RecvConfigAck(2) 
 state = Ack-Sent
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  ACCMAP[6] 0x00000000
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  MRU[4] 1492
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  MAGICNUM[6] 0x98bd24e8
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x05)
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP: deflink: State change 
 Ack-Sent --> Opened
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP: deflink: LayerUp
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP: deflink: SendIdent(2) state 
 = Opened
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  MAGICNUM 98bd24e8
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  TEXT user-ppp 3.2 (built 
 Jan 24 2005)
 Jan 26 17:17:16 magnum ppp[289]: tun0: Phase: bundle: Authenticate
 Jan 26 17:17:16 magnum ppp[289]: tun0: Phase: deflink: his = none, mine 
 = CHAP 0x05
 Jan 26 17:17:16 magnum ppp[289]: tun0: Phase: Chap Output: CHALLENGE
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP: deflink: RecvIdent(2) state 
 = Opened
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  MAGICNUM 408648e9
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  TEXT MSRA
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP: deflink: RecvIdent(3) state 
 = Opened
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  MAGICNUM 408648e9
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  TEXT MSRAS-0-QUZZHWBWR
 Jan 26 17:17:16 magnum ppp[289]: tun0: Phase: Chap Input: RESPONSE (16 
 bytes from llp)
 Jan 26 17:17:16 magnum ppp[289]: tun0: Radius: Radius(auth): CHAP data 
 sent for llp
 Jan 26 17:17:16 magnum ppp[289]: tun0: Radius: Radius: Request sent
 Jan 26 17:17:16 magnum ppp[289]: tun0: Radius: Radius(auth): ACCEPT received
 Jan 26 17:17:16 magnum ppp[289]: tun0: Phase: Chap Output: SUCCESS
 Jan 26 17:17:16 magnum ppp[289]: tun0: CCP: FSM: Using "deflink" as a 
 transport
 Jan 26 17:17:16 magnum ppp[289]: tun0: CCP: deflink: State change 
 Initial --> Closed
 Jan 26 17:17:16 magnum ppp[289]: tun0: CCP: deflink: LayerStart.
 Jan 26 17:17:16 magnum ppp[289]: tun0: CCP: MPPE: Not permitted by 
 RADIUS server
 Jan 26 17:17:16 magnum ppp[289]: tun0: CCP: deflink: SendConfigReq(1) 
 state = Closed
 Jan 26 17:17:16 magnum ppp[289]: tun0: CCP:   [EMPTY]
 Jan 26 17:17:16 magnum ppp[289]: tun0: CCP: deflink: State change Closed 
 
 --> Req-Sent
 
 Jan 26 17:17:16 magnum ppp[289]: tun0: Phase: deflink: lcp -> open
 Jan 26 17:17:16 magnum ppp[289]: tun0: Phase: bundle: Network
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP: FSM: Using "deflink" as a 
 transport
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP: deflink: State change 
 Initial --> Closed
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP: deflink: LayerStart.
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP: deflink: SendConfigReq(1) 
 state = Closed
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP:  IPADDR[6] 192.168.2.1
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP:  COMPPROTO[6] 16 VJ slots 
 with slot compression
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP:  PRIDNS[6] 212.74.231.161
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP:  SECDNS[6] 255.255.255.255
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP: deflink: State change 
 Closed --> Req-Sent
 Jan 26 17:17:16 magnum ppp[289]: tun0: CCP: deflink: RecvConfigReq(4) 
 state = Req-Sent
 Jan 26 17:17:16 magnum ppp[289]: tun0: CCP:  MPPE[6] value 0x00000001 (0 
 bits, stateful, compressed)
 Jan 26 17:17:16 magnum ppp[289]: tun0: CCP: MPPE: Not permitted by 
 RADIUS server
 Jan 26 17:17:16 magnum ppp[289]: tun0: CCP: deflink: SendConfigRej(4) 
 state = Req-Sent
 Jan 26 17:17:16 magnum ppp[289]: tun0: CCP:  MPPE[6] value 0x00000001 (0 
 bits, stateful, compressed)
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP: deflink: SendIdent(3) state 
 = Opened
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  MAGICNUM 98bd24e8
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  TEXT user-ppp 3.2 (built 
 Jan 24 2005)
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP: deflink: RecvConfigReq(5) 
 state = Req-Sent
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP:  COMPPROTO[6] 16 VJ slots 
 with slot compression
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP:  IPADDR[6] 0.0.0.0
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP: 0.0.0.0: Address invalid or 
 already in use
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP:  PRIDNS[6] 0.0.0.0
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP:  PRINBNS[6] 0.0.0.0
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP: NBNS REQ - rejected - nbns 
 not set
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP:  SECDNS[6] 0.0.0.0
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP:  SECNBNS[6] 0.0.0.0
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP: NBNS REQ - rejected - nbns 
 not set
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP: deflink: SendConfigRej(5) 
 state = Req-Sent
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP:  PRINBNS[6] 0.0.0.0
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP:  SECNBNS[6] 0.0.0.0
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP: deflink: SendIdent(4) state 
 = Opened
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  MAGICNUM 98bd24e8
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  TEXT user-ppp 3.2 (built 
 Jan 24 2005)
 Jan 26 17:17:16 magnum ppp[289]: tun0: CCP: deflink: RecvConfigAck(1) 
 state = Req-Sent
 Jan 26 17:17:16 magnum ppp[289]: tun0: CCP:   [EMPTY]
 Jan 26 17:17:16 magnum ppp[289]: tun0: CCP: deflink: State change 
 Req-Sent --> Ack-Rcvd
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP: deflink: RecvConfigRej(1) 
 state = Req-Sent
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP: deflink: SendIdent(5) state 
 = Opened
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  MAGICNUM 98bd24e8
 Jan 26 17:17:16 magnum ppp[289]: tun0: LCP:  TEXT user-ppp 3.2 (built 
 Jan 24 2005)
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP:  PRIDNS[6] 212.74.231.161
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP:  SECDNS[6] 255.255.255.255
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP: deflink: SendConfigReq(2) 
 state = Req-Sent
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP:  IPADDR[6] 192.168.2.1
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP:  COMPPROTO[6] 16 VJ slots 
 with slot compression
 Jan 26 17:17:16 magnum ppp[289]: tun0: CCP: deflink: RecvTerminateReq(6) 
 state = Ack-Rcvd
 Jan 26 17:17:16 magnum ppp[289]: tun0: CCP: deflink: SendTerminateAck(6) 
 state = Ack-Rcvd
 Jan 26 17:17:16 magnum ppp[289]: tun0: CCP: deflink: State change 
 Ack-Rcvd --> Req-Sent
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP: deflink: RecvConfigReq(7) 
 state = Req-Sent
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP:  COMPPROTO[6] 16 VJ slots 
 with slot compression
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP:  IPADDR[6] 0.0.0.0
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP: 0.0.0.0: Address invalid or 
 already in use
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP:  PRIDNS[6] 0.0.0.0
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP:  SECDNS[6] 0.0.0.0
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP: deflink: SendConfigNak(7) 
 state = Req-Sent
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP:  IPADDR[6] 192.168.2.156
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP:  PRIDNS[6] 212.74.231.161
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP:  SECDNS[6] 255.255.255.255
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP: deflink: RecvConfigAck(2) 
 state = Req-Sent
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP:  IPADDR[6] 192.168.2.1
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP:  COMPPROTO[6] 16 VJ slots 
 with slot compression
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP: deflink: State change 
 Req-Sent --> Ack-Rcvd
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP: deflink: RecvConfigReq(8) 
 state = Ack-Rcvd
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP:  COMPPROTO[6] 16 VJ slots 
 with slot compression
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP:  IPADDR[6] 192.168.2.156
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP:  PRIDNS[6] 212.74.231.161
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP:  SECDNS[6] 255.255.255.255
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP: deflink: SendConfigAck(8) 
 state = Ack-Rcvd
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP:  COMPPROTO[6] 16 VJ slots 
 with slot compression
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP:  IPADDR[6] 192.168.2.156
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP:  PRIDNS[6] 212.74.231.161
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP:  SECDNS[6] 255.255.255.255
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP: deflink: State change 
 Ack-Rcvd --> Opened
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP: deflink: LayerUp.
 Jan 26 17:17:16 magnum ppp[289]: tun0: IPCP: myaddr 192.168.2.1 hisaddr 
 = 192.168.2.156
 Jan 26 17:17:16 magnum ppp[289]: tun0: Radius: Radius(acct): *r->cfg.file<>0
 Jan 26 17:17:16 magnum ppp[289]: tun0: Radius: Radius(acct): r->cx.fd != -1
 Jan 26 17:17:16 magnum ppp[289]: tun0: Radius: Now before logging data sent
 Jan 26 17:17:16 magnum ppp[289]: tun0: Phase: Radius(acct): START data sent
 Jan 26 17:17:16 magnum ppp[289]: tun0: Radius: Radius(acct): *r->cfg.file<>0
 Jan 26 17:17:16 magnum ppp[289]: tun0: Radius: Radius(acct): Accounting 
 response received
 Jan 26 17:17:36 magnum ppp[289]: tun0: LCP: deflink: RecvEchoRequest(20) 
 state = Opened
 Jan 26 17:17:36 magnum ppp[289]: tun0: LCP: deflink: SendEchoReply(20) 
 state = Opened
 Jan 26 17:17:46 magnum ppp[289]: tun0: Radius: Radius(acct): *r->cfg.file<>0
 Jan 26 17:17:46 magnum ppp[289]: tun0: Radius: Radius(acct): r->cx.fd != -1
 Jan 26 17:17:46 magnum ppp[289]: tun0: Radius: Now before logging data sent
 Jan 26 17:17:46 magnum ppp[289]: tun0: Radius: Radius(acct): ALIVE data sent
 Jan 26 17:17:46 magnum ppp[289]: tun0: Phase: Idle timer expired
 Jan 26 17:17:46 magnum ppp[289]: tun0: IPCP: deflink: LayerDown: 192.168.2.1
 Jan 26 17:17:46 magnum ppp[289]: tun0: Radius: Radius(acct): in 
 radius_Account to send stop packet
 Jan 26 17:17:46 magnum ppp[289]: tun0: Radius: Radius(acct): *r->cfg.file<>0
 Jan 26 17:17:46 magnum ppp[289]: tun0: IPCP: deflink: 
 SendTerminateReq(3) state = Opened
 Jan 26 17:17:46 magnum ppp[289]: tun0: IPCP: deflink: State change 
 Opened --> Closing
 Jan 26 17:17:46 magnum ppp[289]: tun0: Radius: Radius(acct): Accounting 
 response received
 Jan 26 17:17:46 magnum ppp[289]: tun0: IPCP: deflink: 
 RecvTerminateAck(3) state = Closing
 Jan 26 17:17:46 magnum ppp[289]: tun0: IPCP: deflink: LayerFinish.
 Jan 26 17:17:46 magnum ppp[289]: tun0: IPCP: Connect time: 30 secs: 0 
 octets in, 0 octets out
 Jan 26 17:17:46 magnum ppp[289]: tun0: IPCP: 0 packets in, 0 packets out
 Jan 26 17:17:46 magnum ppp[289]: tun0: IPCP:  total 0 bytes/sec, peak 0 
 bytes/sec on Wed Jan 26 17:17:16 2005
 Jan 26 17:17:46 magnum ppp[289]: tun0: IPCP: deflink: State change 
 Closing --> Closed
 Jan 26 17:17:46 magnum ppp[289]: tun0: Phase: bundle: Terminate
 Jan 26 17:17:46 magnum ppp[289]: tun0: CCP: deflink: State change 
 Req-Sent --> Starting
 Jan 26 17:17:46 magnum ppp[289]: tun0: CCP: deflink: LayerFinish.
 Jan 26 17:17:46 magnum ppp[289]: tun0: CCP: deflink: State change 
 Starting --> Initial
 Jan 26 17:17:46 magnum ppp[289]: tun0: LCP: deflink: LayerDown
 Jan 26 17:17:46 magnum ppp[289]: tun0: LCP: deflink: SendTerminateReq(4) 
 state = Opened
 Jan 26 17:17:46 magnum ppp[289]: tun0: LCP: deflink: State change Opened 
 
 --> Closing
 
 Jan 26 17:17:46 magnum ppp[289]: tun0: Phase: deflink: open -> lcp
 Jan 26 17:17:46 magnum ppp[289]: tun0: Warning: ff02:9::/32: Change 
 route failed: errno: Network is unreachable
 Jan 26 17:17:46 magnum ppp[289]: tun0: IPCP: deflink: State change 
 Closed --> Initial
 Jan 26 17:17:46 magnum ppp[289]: tun0: LCP: deflink: RecvTerminateAck(4) 
 state = Closing
 Jan 26 17:17:46 magnum ppp[289]: tun0: LCP: deflink: LayerFinish
 Jan 26 17:17:46 magnum ppp[289]: tun0: LCP: deflink: State change 
 Closing --> Closed
 Jan 26 17:17:46 magnum ppp[289]: tun0: LCP: deflink: State change Closed 
 
 --> Initial
 
 Jan 26 17:17:46 magnum ppp[289]: tun0: Phase: deflink: Disconnected!
 Jan 26 17:17:46 magnum ppp[289]: tun0: Phase: deflink: Connect time: 30 
 secs: 401 octets in, 570 octets out
 Jan 26 17:17:46 magnum ppp[289]: tun0: Phase: deflink: 18 packets in, 23 
 packets out
 Jan 26 17:17:46 magnum ppp[289]: tun0: Phase:  total 32 bytes/sec, peak 
 459 bytes/sec on Wed Jan 26 17:17:17 2005
 Jan 26 17:17:46 magnum ppp[289]: tun0: Phase: deflink: lcp -> closed
 Jan 26 17:17:46 magnum ppp[289]: tun0: Phase: bundle: Dead
 Jan 26 17:17:46 magnum ppp[289]: tun0: Phase: PPP Terminated (normal).
 
 После 'Idle timer expired' оно пытается отправить стоп-пакет, заходит в 
 radius_Account в radius.c, но сразу же выходит оттуда после проверки 
 
 r->cx.fd == -1, видимо, потому что ожидается ответ на alive-пакет.
 
 Я не силен в программировании, может кто из местных посмотрит или send-pr?
 
 -- 
 С уважением, Alexey Popov.
 --- ifmail v.2.15dev5.3
  * Origin: Demos online service (2:5020/400)
 
 

Вернуться к списку тем, сортированных по: возрастание даты  уменьшение даты  тема  автор 

 Тема:    Автор:    Дата:  
 userland ppp в 4.11 иногда не посылает Радиусу стоп-пакеты   Alexey Popov   27 Jan 2005 11:55:08 
 Re: userland ppp в 4.11 иногда не посылает Радиусу стоп-пакеты   Alexey Popov   27 Jan 2005 18:11:41 
Архивное /ru.unix.bsd/6577b5256de4.html, оценка 1 из 5, голосов 10
Яндекс.Метрика
Valid HTML 4.01 Transitional