incoming call suppresses established ppp connection
Hanspeter Roth
hampi at rootshell.be
Sat Dec 6 16:07:27 PST 2003
Hello,
when I have an ongoing PPP connection and another telephone call is
coming in which is handle by the same machine the IP traffic
immediately is suppressed on the established PPP channel but the PPP
process has no idea that it's being disturbed by an incoming
telephone call.
Only establishing another IP connection after the telephone call
establishes restores a PPP connection.
In the attached isdnd.log the call occurred at 21:56:36.
Is there a means to make the IP/PPP connection (traffic) continue
while there is another telephone call being served?
Or is it possible to reject telephone calls on the second channel
while there is a PPP connection on the first channel?
-Hanspeter
-------------- next part --------------
06.12.2003 21:54:55 DBG F_MDI: disconnect indication, local disconnected
06.12.2003 21:55:10 DBG msg_l12stat_ind: unit 0, layer 2, state 0
06.12.2003 21:55:40 DBG msg_l12stat_ind: unit 0, layer 1, state 0
06.12.2003 21:55:48 DBG msg_dialoutnumber: dial req from rbch, unit 0
06.12.2003 21:55:48 DBG setup_dialout: entry BLUEWIN ok!
06.12.2003 21:55:48 DBG find_by_device_for_dialoutnumber: found entry 0!
06.12.2003 21:55:48 DBG FSM event [msg-dialout]: [idle => dialing]
06.12.2003 21:55:48 DBG F_DIAL: local dial out request
06.12.2003 21:55:48 DBG select_first_dialno: only one no, no = 1000
06.12.2003 21:55:48 CHD 00005 BLUEWIN rate 60 sec/unit (unitlen unknown)
06.12.2003 21:55:48 DBG sendm_connect_req: ctrl = 0, chan = -1
06.12.2003 21:55:48 DBG decr_free_channels: ctrl 0, now 1 chan free
06.12.2003 21:55:48 CHD 00005 BLUEWIN dialing out from 4443332 to 1000
06.12.2003 21:55:48 DBG msg_l12stat_ind: unit 0, layer 1, state 1
06.12.2003 21:55:48 DBG msg_l12stat_ind: unit 0, layer 2, state 1
06.12.2003 21:55:49 DBG set_channel_busy: controller [0] channel B1 set to BUSY!
06.12.2003 21:55:49 CHD 00005 BLUEWIN outgoing call proceeding (ctl 0, ch 0)
06.12.2003 21:55:49 DBG msg_charging: 1 unit(s) (estimated)
06.12.2003 21:55:49 DBG set_channel_busy: controller [0] channel B1 already busy!
06.12.2003 21:55:49 CHD 00005 BLUEWIN outgoing call active (ctl 0, ch 0, rbch0)
06.12.2003 21:55:49 DBG FSM event [msg-con-act-ind]: [dialing => connected]
06.12.2003 21:55:49 DBG F_DOK: dial out ok
06.12.2003 21:55:49 DBG select_this_dialno: index = 0, no = 1000
06.12.2003 21:55:49 DBG msg_charging: 0 unit(s) (AOCD)
06.12.2003 21:56:36 DBG find_matching_entry_incoming: entry 0, myno 4443332 != incomingno 4443331
06.12.2003 21:56:36 DBG find_matching_entry_incoming: entry 1, myno 4443332 != incomingno 4443331
06.12.2003 21:56:36 DBG find_matching_entry_incoming: entry 2, myno 4443332 != incomingno 4443331
06.12.2003 21:56:36 DBG decr_free_channels: ctrl 0, now 0 chan free
06.12.2003 21:56:36 CHD 00006 I4BTEL answering: incoming call from 0771234567 to 4443331 ()
06.12.2003 21:56:36 DBG FSM event [msg-con-ind]: [idle => accepted]
06.12.2003 21:56:36 DBG F_MCI: tx SETUP_RESP_ACCEPT
06.12.2003 21:56:36 DBG sendm_connect_resp: accept
06.12.2003 21:56:36 DBG 0771234567 - screening network provided
06.12.2003 21:56:36 DBG 0771234567 - presentation allowed
06.12.2003 21:56:36 DBG set_channel_busy: controller [0] channel B2 set to BUSY!
06.12.2003 21:56:36 CHD 00006 I4BTEL incoming call active (ctl 0, ch 1, tel0)
06.12.2003 21:56:36 DBG FSM event [msg-con-act-ind]: [accepted => connected]
06.12.2003 21:56:36 DBG F_MCAI: Connection active!
06.12.2003 21:56:36 DBG exec_answer: prog=[tp]
06.12.2003 21:56:36 DBG exec_prog: /etc/isdn/tp, args: -D /dev/i4btel0 -d 4443331 -s 0771234567
06.12.2003 21:56:42 CHD 00006 I4BTEL incoming call disconnected (remote)
06.12.2003 21:56:42 CHD 00006 I4BTEL cause 16: Normal call clearing (Q.850)
06.12.2003 21:56:42 CHD 00006 I4BTEL connected 6 seconds
06.12.2003 21:56:42 DBG set_channel_idle: controller [0] channel B2 set to IDLE!
06.12.2003 21:56:42 DBG incr_free_channels: ctrl 0, now 1 chan free
06.12.2003 21:56:42 DBG FSM event [msg-disc-ind]: [connected => idle]
06.12.2003 21:56:42 DBG F_IDIS: disconnect indication
06.12.2003 21:56:42 DBG normal child (pid=782) termination, exitstat = 0
06.12.2003 21:56:49 DBG msg_charging: 2 unit(s) (estimated)
06.12.2003 21:57:49 DBG msg_charging: 3 unit(s) (estimated)
06.12.2003 21:57:55 DBG msg_drvrdisc_req: req from rbch, unit 0
06.12.2003 21:57:55 DBG get_cep_by_driver: found entry 0!
06.12.2003 21:57:55 DBG FSM event [disconnect-req]: [connected => waitdisconnect]
06.12.2003 21:57:55 DBG F_DRQ: local disconnect request
06.12.2003 21:57:55 DBG sendm_disconnect_req: sent DISCONNECT_REQ
06.12.2003 21:57:55 DBG msg_drvrdisc_req: req from rbch, unit 0
06.12.2003 21:57:55 DBG get_cep_by_driver: found entry 0!
06.12.2003 21:57:55 DBG FSM event [disconnect-req]: [waitdisconnect => waitdisconnect]
06.12.2003 21:57:55 DBG msg_drvrdisc_req: req from rbch, unit 0
06.12.2003 21:57:55 DBG get_cep_by_driver: found entry 0!
06.12.2003 21:57:55 DBG FSM event [disconnect-req]: [waitdisconnect => waitdisconnect]
06.12.2003 21:57:55 DBG msg_drvrdisc_req: req from rbch, unit 0
06.12.2003 21:57:55 DBG get_cep_by_driver: found entry 0!
06.12.2003 21:57:55 DBG FSM event [disconnect-req]: [waitdisconnect => waitdisconnect]
06.12.2003 21:57:56 DBG msg_charging: 0 unit(s) (AOCE)
06.12.2003 21:57:56 CHD 00005 BLUEWIN outgoing call disconnected (local)
06.12.2003 21:57:56 CHD 00005 BLUEWIN cause 0: normal call clearing (I4B)
06.12.2003 21:57:56 CHD 00005 BLUEWIN charging: 0 units, 127 seconds
06.12.2003 21:57:56 CHD 00005 BLUEWIN accounting: in 373176, out 8949
06.12.2003 21:57:56 DBG set_channel_idle: controller [0] channel B1 set to IDLE!
06.12.2003 21:57:56 DBG incr_free_channels: ctrl 0, now 2 chan free
06.12.2003 21:57:56 DBG FSM event [msg-disc-ind]: [waitdisconnect => idle]
06.12.2003 21:57:56 DBG F_MDI: disconnect indication, local disconnected
06.12.2003 21:58:11 DBG msg_l12stat_ind: unit 0, layer 2, state 0
06.12.2003 21:58:41 DBG msg_l12stat_ind: unit 0, layer 1, state 0
-------------- next part --------------
Dec 6 21:54:57 snoopy ppp[236]: tun0: Phase: /var/run/ppp/ctl: Client connection dropped.
Dec 6 21:55:48 snoopy ppp[236]: tun0: Phase: bundle: Establish
Dec 6 21:55:48 snoopy ppp[236]: tun0: Phase: deflink: closed -> opening
Dec 6 21:55:48 snoopy ppp[236]: tun0: Chat: Phone: 1000
Dec 6 21:55:48 snoopy ppp[236]: tun0: Phase: deflink: Connected!
Dec 6 21:55:48 snoopy ppp[236]: tun0: Phase: deflink: opening -> dial
Dec 6 21:55:48 snoopy ppp[236]: tun0: Chat: deflink: Dial attempt 1 of 1
Dec 6 21:55:48 snoopy ppp[236]: tun0: Phase: deflink: dial -> carrier
Dec 6 21:55:49 snoopy ppp[236]: tun0: Phase: deflink: /dev/i4brbch0: CD detected
Dec 6 21:55:49 snoopy ppp[236]: tun0: Phase: deflink: carrier -> login
Dec 6 21:55:49 snoopy ppp[236]: tun0: Phase: deflink: login -> lcp
Dec 6 21:55:49 snoopy ppp[236]: tun0: LCP: FSM: Using "deflink" as a transport
Dec 6 21:55:49 snoopy ppp[236]: tun0: LCP: deflink: State change Initial --> Closed
Dec 6 21:55:49 snoopy ppp[236]: tun0: LCP: deflink: State change Closed --> Stopped
Dec 6 21:55:50 snoopy ppp[236]: tun0: LCP: deflink: LayerStart
Dec 6 21:55:50 snoopy ppp[236]: tun0: LCP: deflink: SendConfigReq(4) state = Stopped
Dec 6 21:55:50 snoopy ppp[236]: tun0: LCP: MRU[4] 1500
Dec 6 21:55:50 snoopy ppp[236]: tun0: LCP: MAGICNUM[6] 0xa9cfb38e
Dec 6 21:55:50 snoopy ppp[236]: tun0: LCP: deflink: State change Stopped --> Req-Sent
Dec 6 21:55:50 snoopy ppp[236]: tun0: LCP: deflink: RecvConfigReq(150) state = Req-Sent
Dec 6 21:55:50 snoopy ppp[236]: tun0: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x05)
Dec 6 21:55:50 snoopy ppp[236]: tun0: LCP: MAGICNUM[6] 0x203d60bc
Dec 6 21:55:50 snoopy ppp[236]: tun0: LCP: MRRU[4] 1524
Dec 6 21:55:50 snoopy ppp[236]: tun0: LCP: ENDDISC[11] Local Addr: tbwmlppp
Dec 6 21:55:50 snoopy ppp[236]: tun0: LCP: deflink: SendConfigRej(150) state = Req-Sent
Dec 6 21:55:50 snoopy ppp[236]: tun0: LCP: MRRU[4] 1524
Dec 6 21:55:50 snoopy ppp[236]: tun0: LCP: deflink: RecvConfigAck(4) state = Req-Sent
Dec 6 21:55:50 snoopy ppp[236]: tun0: LCP: MRU[4] 1500
Dec 6 21:55:50 snoopy ppp[236]: tun0: LCP: MAGICNUM[6] 0xa9cfb38e
Dec 6 21:55:50 snoopy ppp[236]: tun0: LCP: deflink: State change Req-Sent --> Ack-Rcvd
Dec 6 21:55:50 snoopy ppp[236]: tun0: LCP: deflink: RecvConfigReq(151) state = Ack-Rcvd
Dec 6 21:55:50 snoopy ppp[236]: tun0: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x05)
Dec 6 21:55:50 snoopy ppp[236]: tun0: LCP: MAGICNUM[6] 0x203d60bc
Dec 6 21:55:50 snoopy ppp[236]: tun0: LCP: ENDDISC[11] Local Addr: tbwmlppp
Dec 6 21:55:50 snoopy ppp[236]: tun0: LCP: deflink: SendConfigAck(151) state = Ack-Rcvd
Dec 6 21:55:50 snoopy ppp[236]: tun0: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x05)
Dec 6 21:55:50 snoopy ppp[236]: tun0: LCP: MAGICNUM[6] 0x203d60bc
Dec 6 21:55:50 snoopy ppp[236]: tun0: LCP: ENDDISC[11] Local Addr: tbwmlppp
Dec 6 21:55:50 snoopy ppp[236]: tun0: LCP: deflink: State change Ack-Rcvd --> Opened
Dec 6 21:55:50 snoopy ppp[236]: tun0: LCP: deflink: LayerUp
Dec 6 21:55:50 snoopy ppp[236]: tun0: Phase: bundle: Authenticate
Dec 6 21:55:50 snoopy ppp[236]: tun0: Phase: deflink: his = CHAP 0x05, mine = none
Dec 6 21:55:50 snoopy ppp[236]: tun0: Phase: Chap Input: CHALLENGE (16 bytes from tbwmlppp)
Dec 6 21:55:50 snoopy ppp[236]: tun0: Phase: Chap Output: RESPONSE (gchristi)
Dec 6 21:55:50 snoopy ppp[236]: tun0: Phase: Chap Input: SUCCESS
Dec 6 21:55:50 snoopy ppp[236]: tun0: IPCP: Using trigger address 0.0.0.0
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: FSM: Using "deflink" as a transport
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: deflink: State change Initial --> Closed
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: deflink: LayerStart.
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: MPPE: Not usable without CHAP81
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: deflink: SendConfigReq(15) state = Closed
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: DEFLATE[4] win 15
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: PRED1[2]
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: deflink: State change Closed --> Req-Sent
Dec 6 21:55:50 snoopy ppp[236]: tun0: Phase: deflink: lcp -> open
Dec 6 21:55:50 snoopy ppp[236]: tun0: Phase: bundle: Network
Dec 6 21:55:50 snoopy ppp[236]: tun0: IPCP: FSM: Using "deflink" as a transport
Dec 6 21:55:50 snoopy ppp[236]: tun0: IPCP: deflink: State change Initial --> Closed
Dec 6 21:55:50 snoopy ppp[236]: tun0: IPCP: deflink: LayerStart.
Dec 6 21:55:50 snoopy ppp[236]: tun0: IPCP: deflink: SendConfigReq(6) state = Closed
Dec 6 21:55:50 snoopy ppp[236]: tun0: IPCP: IPADDR[6] 0.0.0.0
Dec 6 21:55:50 snoopy ppp[236]: tun0: IPCP: COMPPROTO[6] 16 VJ slots with slot compression
Dec 6 21:55:50 snoopy ppp[236]: tun0: IPCP: deflink: State change Closed --> Req-Sent
Dec 6 21:55:50 snoopy ppp[236]: tun0: IPCP: deflink: RecvConfigReq(72) state = Req-Sent
Dec 6 21:55:50 snoopy ppp[236]: tun0: IPCP: COMPPROTO[6] 16 VJ slots without slot compression
Dec 6 21:55:50 snoopy ppp[236]: tun0: IPCP: IPADDR[6] 3.3.3.1
Dec 6 21:55:50 snoopy ppp[236]: tun0: IPCP: deflink: SendConfigAck(72) state = Req-Sent
Dec 6 21:55:50 snoopy ppp[236]: tun0: IPCP: COMPPROTO[6] 16 VJ slots without slot compression
Dec 6 21:55:50 snoopy ppp[236]: tun0: IPCP: IPADDR[6] 3.3.3.1
Dec 6 21:55:50 snoopy ppp[236]: tun0: IPCP: deflink: State change Req-Sent --> Ack-Sent
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: deflink: RecvConfigReq(75) state = Req-Sent
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: MPPE[6] value 0x00000001 (0 bits, stateful, compressed)
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: MPPE: Not usable without CHAP81
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: deflink: SendConfigRej(75) state = Req-Sent
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: MPPE[6] value 0x00000001 (0 bits, stateful, compressed)
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: deflink: RecvConfigRej(15) state = Req-Sent
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: DEFLATE[4] win 15
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: MPPE: Not usable without CHAP81
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: deflink: SendConfigReq(16) state = Req-Sent
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: PRED1[2]
Dec 6 21:55:50 snoopy ppp[236]: tun0: IPCP: deflink: RecvConfigNak(6) state = Ack-Sent
Dec 6 21:55:50 snoopy ppp[236]: tun0: IPCP: IPADDR[6] 3.3.3.248
Dec 6 21:55:50 snoopy ppp[236]: tun0: IPCP: IPADDR[6] changing address: 0.0.0.0 --> 3.3.3.248
Dec 6 21:55:50 snoopy ppp[236]: tun0: IPCP: deflink: SendConfigReq(7) state = Ack-Sent
Dec 6 21:55:50 snoopy ppp[236]: tun0: IPCP: IPADDR[6] 3.3.3.248
Dec 6 21:55:50 snoopy ppp[236]: tun0: IPCP: COMPPROTO[6] 16 VJ slots with slot compression
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: deflink: RecvConfigReq(76) state = Req-Sent
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: LZS-DCP[6]
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: deflink: SendConfigRej(76) state = Req-Sent
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: LZS-DCP[6]
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: deflink: RecvConfigAck(16) state = Req-Sent
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: PRED1[2]
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: deflink: State change Req-Sent --> Ack-Rcvd
Dec 6 21:55:50 snoopy ppp[236]: tun0: IPCP: deflink: RecvConfigAck(7) state = Ack-Sent
Dec 6 21:55:50 snoopy ppp[236]: tun0: IPCP: IPADDR[6] 3.3.3.248
Dec 6 21:55:50 snoopy ppp[236]: tun0: IPCP: COMPPROTO[6] 16 VJ slots with slot compression
Dec 6 21:55:50 snoopy ppp[236]: tun0: IPCP: deflink: State change Ack-Sent --> Opened
Dec 6 21:55:50 snoopy ppp[236]: tun0: IPCP: deflink: LayerUp.
Dec 6 21:55:50 snoopy ppp[236]: tun0: IPCP: myaddr 3.3.3.248 hisaddr = 3.3.3.1
Dec 6 21:55:50 snoopy ppp[236]: tun0: Command: MYADDR: !bg nslookup MYADDR
Dec 6 21:55:50 snoopy ppp[236]: tun0: Command: MYADDR: !bg nslookup HISADDR
Dec 6 21:55:50 snoopy ppp[236]: tun0: Command: MYADDR: !bg /root/bin/ntponce
Dec 6 21:55:50 snoopy ppp[236]: tun0: Command: MYADDR: !bg /root/etc/linkupsound
Dec 6 21:55:50 snoopy ppp[236]: tun0: Command: MYADDR: !bg /usr/sbin/sendmail -q
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: deflink: RecvConfigReq(77) state = Ack-Rcvd
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: STAC[5]
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: deflink: SendConfigRej(77) state = Ack-Rcvd
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: STAC[5]
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: deflink: RecvConfigReq(78) state = Ack-Rcvd
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: STAC[5]
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: deflink: SendConfigRej(78) state = Ack-Rcvd
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: STAC[5]
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: deflink: RecvConfigReq(79) state = Ack-Rcvd
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: PRED1[2]
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: deflink: SendConfigAck(79) state = Ack-Rcvd
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: PRED1[2]
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: deflink: State change Ack-Rcvd --> Opened
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: deflink: LayerUp.
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: Predictor1: Input channel reset
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: Predictor1: Output channel reset
Dec 6 21:55:50 snoopy ppp[236]: tun0: CCP: deflink: Out = PRED1[1], In = PRED1[1]
Dec 6 21:57:00 snoopy ppp[236]: tun0: Phase: Unknown protocol 0x009f (unrecognised protocol)
Dec 6 21:57:00 snoopy ppp[236]: tun0: LCP: deflink: SendProtocolRej(5) state = Opened
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: deflink: Bad compressed CRC-16
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: deflink: LayerDown.
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: MPPE: Not usable without CHAP81
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: deflink: SendConfigReq(17) state = Opened
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: DEFLATE[4] win 15
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: PRED1[2]
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: deflink: State change Opened --> Req-Sent
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: deflink: RecvConfigReq(80) state = Req-Sent
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: MPPE[6] value 0x00000001 (0 bits, stateful, compressed)
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: MPPE: Not usable without CHAP81
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: deflink: SendConfigRej(80) state = Req-Sent
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: MPPE[6] value 0x00000001 (0 bits, stateful, compressed)
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: deflink: RecvConfigRej(17) state = Req-Sent
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: DEFLATE[4] win 15
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: MPPE: Not usable without CHAP81
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: deflink: SendConfigReq(18) state = Req-Sent
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: PRED1[2]
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: deflink: RecvConfigReq(81) state = Req-Sent
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: LZS-DCP[6]
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: deflink: SendConfigRej(81) state = Req-Sent
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: LZS-DCP[6]
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: deflink: RecvConfigAck(18) state = Req-Sent
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: PRED1[2]
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: deflink: State change Req-Sent --> Ack-Rcvd
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: deflink: RecvConfigReq(82) state = Ack-Rcvd
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: STAC[5]
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: deflink: SendConfigRej(82) state = Ack-Rcvd
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: STAC[5]
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: deflink: RecvConfigReq(83) state = Ack-Rcvd
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: STAC[5]
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: deflink: SendConfigRej(83) state = Ack-Rcvd
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: STAC[5]
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: deflink: RecvConfigReq(84) state = Ack-Rcvd
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: PRED1[2]
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: deflink: SendConfigAck(84) state = Ack-Rcvd
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: PRED1[2]
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: deflink: State change Ack-Rcvd --> Opened
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: deflink: LayerUp.
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: Predictor1: Input channel reset
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: Predictor1: Output channel reset
Dec 6 21:57:01 snoopy ppp[236]: tun0: CCP: deflink: Out = PRED1[1], In = PRED1[1]
Dec 6 21:57:23 snoopy ppp[236]: tun0: Phase: Connected to local client.
Dec 6 21:57:23 snoopy ppp[236]: tun0: Command: /var/run/ppp/ctl: show bundle
Dec 6 21:57:23 snoopy ppp[236]: tun0: Command: /var/run/ppp/ctl: set timeout 32
Dec 6 21:57:53 snoopy ppp[236]: tun0: Phase: deflink: HDLC errors -> FCS: 0, ADDR: 0, COMD: 0, PROTO: 1
Dec 6 21:57:55 snoopy ppp[236]: tun0: Phase: Idle timer expired
Dec 6 21:57:55 snoopy ppp[236]: tun0: IPCP: deflink: LayerDown: 3.3.3.248
Dec 6 21:57:55 snoopy ppp[236]: tun0: Command: MYADDR: delete! default
Dec 6 21:57:55 snoopy ppp[236]: tun0: Command: MYADDR: set ifaddr 10.0.0.1/0 10.0.0.2/0 255.255.255.0 0.0.0.0
Dec 6 21:57:55 snoopy ppp[236]: tun0: Command: MYADDR: add default HISADDR
Dec 6 21:57:55 snoopy ppp[236]: tun0: Command: MYADDR: !bg /root/etc/linkdownsound
Dec 6 21:57:55 snoopy ppp[236]: tun0: IPCP: Using trigger address 0.0.0.0
Dec 6 21:57:55 snoopy ppp[236]: tun0: IPCP: deflink: SendTerminateReq(8) state = Opened
Dec 6 21:57:55 snoopy ppp[236]: tun0: IPCP: deflink: State change Opened --> Closing
Dec 6 21:57:55 snoopy ppp[236]: tun0: IPCP: deflink: RecvTerminateAck(8) state = Closing
Dec 6 21:57:55 snoopy ppp[236]: tun0: IPCP: deflink: LayerFinish.
Dec 6 21:57:55 snoopy ppp[236]: tun0: IPCP: Connect time: 125 secs: 182516 octets in, 10431 octets out
Dec 6 21:57:55 snoopy ppp[236]: tun0: IPCP: 1193 packets in, 1133 packets out
Dec 6 21:57:55 snoopy ppp[236]: tun0: IPCP: total 1543 bytes/sec, peak 8391 bytes/sec on Sat Dec 6 21:56:28 2003
Dec 6 21:57:55 snoopy ppp[236]: tun0: IPCP: deflink: State change Closing --> Closed
Dec 6 21:57:55 snoopy ppp[236]: tun0: Phase: bundle: Terminate
Dec 6 21:57:55 snoopy ppp[236]: tun0: CCP: deflink: LayerDown.
Dec 6 21:57:55 snoopy ppp[236]: tun0: CCP: deflink: State change Opened --> Starting
Dec 6 21:57:55 snoopy ppp[236]: tun0: CCP: deflink: LayerFinish.
Dec 6 21:57:55 snoopy ppp[236]: tun0: CCP: deflink: State change Starting --> Initial
Dec 6 21:57:55 snoopy ppp[236]: tun0: LCP: deflink: LayerDown
Dec 6 21:57:55 snoopy ppp[236]: tun0: LCP: deflink: SendTerminateReq(5) state = Opened
Dec 6 21:57:55 snoopy ppp[236]: tun0: LCP: deflink: State change Opened --> Closing
Dec 6 21:57:55 snoopy ppp[236]: tun0: Phase: deflink: open -> lcp
Dec 6 21:57:55 snoopy ppp[236]: tun0: IPCP: deflink: State change Closed --> Initial
Dec 6 21:57:55 snoopy ppp[236]: tun0: LCP: deflink: RecvTerminateAck(5) state = Closing
Dec 6 21:57:55 snoopy ppp[236]: tun0: LCP: deflink: LayerFinish
Dec 6 21:57:55 snoopy ppp[236]: tun0: LCP: deflink: State change Closing --> Closed
Dec 6 21:57:55 snoopy ppp[236]: tun0: LCP: deflink: State change Closed --> Initial
Dec 6 21:57:55 snoopy ppp[236]: tun0: Phase: deflink: Disconnected!
Dec 6 21:57:55 snoopy ppp[236]: tun0: Phase: deflink: lcp -> logout
Dec 6 21:57:55 snoopy ppp[236]: tun0: Phase: deflink: logout -> hangup
Dec 6 21:57:55 snoopy ppp[236]: tun0: Phase: deflink: Disconnected!
Dec 6 21:57:55 snoopy ppp[236]: tun0: Phase: deflink: Connect time: 127 secs: 181832 octets in, 8965 octets out
Dec 6 21:57:55 snoopy ppp[236]: tun0: Phase: deflink: 1295 packets in, 1226 packets out
Dec 6 21:57:55 snoopy ppp[236]: tun0: Phase: total 1502 bytes/sec, peak 8342 bytes/sec on Sat Dec 6 21:56:30 2003
Dec 6 21:57:55 snoopy ppp[236]: tun0: Phase: deflink: hangup -> closed
Dec 6 21:57:55 snoopy ppp[236]: tun0: Phase: bundle: Dead
Dec 6 21:57:58 snoopy ppp[236]: tun0: Command: /var/run/ppp/ctl: set timeout 178
Dec 6 21:57:58 snoopy ppp[236]: tun0: Command: /var/run/ppp/ctl: quit
Dec 6 21:57:58 snoopy ppp[236]: tun0: Phase: /var/run/ppp/ctl: Client connection dropped.
-------------- next part --------------
#------------------------------------------------------------------------------
# $Id: isdnd.rc,v 1.3 2003/12/04 18:22:30 root Exp $
#
#------------------------------------------------------------------------------
#==============================================================================
# SYSTEM section: global configuration parameters
#==============================================================================
system
ratesfile = /etc/isdn/isdnd.rates # name & location of rates file
useacctfile = yes # generate accouting info to file
acctall = on # generate info for everything
acctfile = /var/log/isdnd.acct # name & location of accounting file
rtprio = 25 # modify isdnd's priority
regexpr = "HPPPP.*call active" # look for matches in log messages
regprog = i4brunppp # execute program when match is found
# Controller section:
controller
protocol = dss1
#==============================================================================
# ENTRY: Userland PPP over ISDN
#==============================================================================
entry
name = BLUEWIN # name for reference
direction = inout
usrdevicename = rbch # ipr, tel, rbch
usrdeviceunit = 0 # unit number
isdncontroller = 0 # contoller to use or -1 to use any
isdnchannel = -1 # channel (1/2) to use or 0 or -1 for any
# numbers used to verify at DIAL IN
local-phone-incoming = 4443332 # this is my number
remote-phone-incoming = 0000000000 # this one can call in
# numbers used to DIAL OUT
local-phone-dialout = 4443332 # this is my number
remote-phone-dialout = 1000 # i call this number
remdial-handling = first # first, last or next
dialin-reaction = ignore # accept, reject, ignore, answer
dialout-type = normal # normal / calledback
b1protocol = hdlc # hdlc, raw
earlyhangup = 3
idletime-incoming = 30 # 3 seconds idle timeout
idletime-outgoing = 56 # 3 seconds idle timeout
ratetype = 0 # ratesfile entry to use
unitlength = 60 # unitlength to assume
dialretries = 2 # # of dial retries
recoverytime = 5 # time to wait between 2 dial tries
#==============================================================================
# telephony with pseudo callback
#==============================================================================
entry
name = I4BTEL # name for reference
usrdevicename = tel # ipr, tel, rbch
usrdeviceunit = 0 # unit number
isdncontroller = 0 # controller to use or -1 to use any
isdnchannel = -1 # channel (1/2) to use or 0 or -1 for any
# numbers used to verify at DIAL IN
local-phone-incoming = 4443332 # we take calls for this local number
remote-phone-incoming = 017256247
dialin-reaction = answer # accept, reject, ignore, answer
answerprog = myanswer
b1protocol = raw # hdlc, raw
idletime-incoming = 10
#==============================================================================
# telephony without pseudo callback
#==============================================================================
entry
name = I4BTEL # name for reference
usrdevicename = tel # ipr, tel, rbch
usrdeviceunit = 0 # unit number
isdncontroller = 0 # controller to use or -1 to use any
isdnchannel = -1 # channel (1/2) to use or 0 or -1 for any
# numbers used to verify at DIAL IN
local-phone-incoming = 4443332 # we take calls for this local number
remote-phone-incoming = 0771234567
dialin-reaction = answer # accept, reject, ignore, answer
answerprog = answer
b1protocol = raw # hdlc, raw
idletime-incoming = 10
#==============================================================================
# telepredigt
#==============================================================================
entry
name = I4BTEL # name for reference
usrdevicename = tel # ipr, tel, rbch
usrdeviceunit = 0 # unit number
isdncontroller = 0 # controller to use or -1 to use any
isdnchannel = -1 # channel (1/2) to use or 0 or -1 for any
# numbers used to verify at DIAL IN
local-phone-incoming = 4443331 # we take calls for this local number
remote-phone-incoming = * # we take calls from this remote machine
dialin-reaction = answer # accept, reject, ignore, answer
answerprog = tp # program to use
b1protocol = raw # hdlc, raw
idletime-incoming = 10
More information about the freebsd-isdn
mailing list