Date: Thu, 17 Sep 2015 15:33:24 +1000 From: andrew clarke <mail@ozzmosis.com> To: freebsd-questions@freebsd.org Subject: ppp client not relinquishing IP address Message-ID: <20150917053324.GA26115@ozzmosis.com>
next in thread | raw e-mail | index | archive | help
Hi, I run my ADSL modem in bridge mode. Often when my the ADSL service disconnects for whatever reason, FreeBSD's ppp client will 'hold' the old IP address despite it no longer being connected: $ ifconfig tun0 tun0: flags=8051<UP,POINTOPOINT,RUNNING,MULTICAST> metric 0 mtu 1492 options=80000<LINKSTATE> inet 203.206.32.1 --> 150.101.32.78 netmask 0xffffff00 inet 114.198.37.186 --> 150.101.32.44 netmask 0xffffff00 nd6 options=21<PERFORMNUD,AUTO_LINKLOCAL> Opened by PID 10470 What's causing this, and is there any way I can prevent it? For one, ddclient doesn't update my dynamic DNS server with the new IP address. My /etc/ppp.conf is as follows, and hopefully some useful bits of /var/log/ppp.log below it. Thanks. Regards Andrew default: set log phase ipcp ccp tun command nat enable yes enable echo enable lqr set speed sync set ctsrts off set ifaddr 10.2.0.1/0 10.2.0.2/0 255.255.255.0 0.0.0.0 iinet: set device PPPoE:bge0 set authname username set authkey password set dial set login set mru 1492 set mtu 1492 set timeout 0 set redial 30 0 add default HISADDR Sep 17 13:59:19 xyz ppp[10470]: tun0: Phase: deflink: ** Too many LCP ECHO packets lost ** Sep 17 13:59:19 xyz ppp[10470]: tun0: CCP: deflink: State change Stopped --> Closed Sep 17 13:59:19 xyz ppp[10470]: tun0: CCP: deflink: State change Closed --> Initial Sep 17 13:59:19 xyz ppp[10470]: tun0: Phase: deflink: open -> lcp Sep 17 13:59:19 xyz ppp[10470]: tun0: Warning: 0.0.0.0: Change route failed: errno: No such process Sep 17 13:59:19 xyz ppp[10470]: tun0: IPCP: deflink: LayerDown: 203.206.32.1 Sep 17 13:59:19 xyz ppp[10470]: tun0: IPCP: Using trigger address 0.0.0.0 Sep 17 13:59:19 xyz ppp[10470]: tun0: IPCP: deflink: State change Opened --> Starting Sep 17 13:59:19 xyz ppp[10470]: tun0: IPCP: deflink: LayerFinish. Sep 17 13:59:19 xyz ppp[10470]: tun0: IPCP: Connect time: 177032 secs: 4603586184 octets in, 3639482180 octets out Sep 17 13:59:19 xyz ppp[10470]: tun0: IPCP: 5337253 packets in, 5181568 packets out Sep 17 13:59:19 xyz ppp[10470]: tun0: IPCP: total 46562 bytes/sec, peak 554035 bytes/sec on Wed Sep 16 09:05:32 2015 Sep 17 13:59:19 xyz ppp[10470]: tun0: IPCP: deflink: State change Starting --> Initial Sep 17 13:59:19 xyz ppp[10470]: tun0: Phase: bundle: Terminate Sep 17 13:59:19 xyz ppp[10470]: tun0: Phase: deflink: Disconnected! Sep 17 13:59:19 xyz ppp[10470]: tun0: Phase: deflink: lcp -> logout Sep 17 13:59:19 xyz ppp[10470]: tun0: Phase: deflink: Disconnected! Sep 17 13:59:19 xyz ppp[10470]: tun0: Phase: deflink: logout -> hangup Sep 17 13:59:19 xyz ppp[10470]: tun0: Phase: deflink: Connect time: 177034 secs: 4593045207 octets in, 3649979017 octets out Sep 17 13:59:19 xyz ppp[10470]: tun0: Phase: deflink: 5345986 packets in, 5190311 packets out Sep 17 13:59:19 xyz ppp[10470]: tun0: Phase: total 46561 bytes/sec, peak 554561 bytes/sec on Wed Sep 16 09:06:03 2015 Sep 17 13:59:19 xyz ppp[10470]: tun0: Phase: deflink: hangup -> opening Sep 17 13:59:19 xyz ppp[10470]: tun0: Phase: bundle: Establish Sep 17 13:59:19 xyz ppp[10470]: tun0: Phase: deflink: Enter pause (3) for redialing. ... Sep 17 14:05:53 xyz ppp[10470]: tun0: Phase: deflink: hangup -> opening Sep 17 14:05:53 xyz ppp[10470]: tun0: Phase: deflink: Enter pause (30) for redialing. Sep 17 14:06:23 xyz ppp[10470]: tun0: Phase: deflink: Connected! Sep 17 14:06:23 xyz ppp[10470]: tun0: Phase: deflink: opening -> dial Sep 17 14:06:23 xyz ppp[10470]: tun0: Phase: deflink: dial -> carrier Sep 17 14:06:24 xyz ppp[10470]: tun0: Phase: Received NGM_PPPOE_ACNAME (hook "bng1.mel4") Sep 17 14:06:24 xyz ppp[10470]: tun0: Phase: Received NGM_PPPOE_SESSIONID Sep 17 14:06:24 xyz ppp[10470]: tun0: Phase: Received NGM_PPPOE_SUCCESS Sep 17 14:06:24 xyz ppp[10470]: tun0: Phase: deflink: carrier -> login Sep 17 14:06:24 xyz ppp[10470]: tun0: Phase: deflink: login -> lcp Sep 17 14:06:25 xyz ppp[10470]: tun0: Phase: bundle: Authenticate Sep 17 14:06:25 xyz ppp[10470]: tun0: Phase: deflink: his = PAP, mine = none Sep 17 14:06:25 xyz ppp[10470]: tun0: Phase: Pap Output: username ******** Sep 17 14:06:25 xyz ppp[10470]: tun0: Phase: Pap Input: SUCCESS () Sep 17 14:06:25 xyz ppp[10470]: tun0: IPCP: Using trigger address 0.0.0.0 Sep 17 14:06:25 xyz ppp[10470]: tun0: CCP: FSM: Using "deflink" as a transport Sep 17 14:06:25 xyz ppp[10470]: tun0: CCP: deflink: State change Initial --> Closed Sep 17 14:06:25 xyz ppp[10470]: tun0: CCP: deflink: LayerStart. Sep 17 14:06:25 xyz ppp[10470]: tun0: CCP: MPPE: Not usable without CHAP81 Sep 17 14:06:25 xyz ppp[10470]: tun0: CCP: deflink: SendConfigReq(1) state = Closed Sep 17 14:06:25 xyz ppp[10470]: tun0: CCP: DEFLATE[4] win 15 Sep 17 14:06:25 xyz ppp[10470]: tun0: CCP: PRED1[2] Sep 17 14:06:25 xyz ppp[10470]: tun0: CCP: deflink: State change Closed --> Req-Sent Sep 17 14:06:25 xyz ppp[10470]: tun0: Phase: deflink: lcp -> open Sep 17 14:06:25 xyz ppp[10470]: tun0: Phase: bundle: Network Sep 17 14:06:25 xyz ppp[10470]: tun0: IPCP: FSM: Using "deflink" as a transport Sep 17 14:06:25 xyz ppp[10470]: tun0: IPCP: deflink: State change Initial --> Closed Sep 17 14:06:25 xyz ppp[10470]: tun0: IPCP: deflink: LayerStart. Sep 17 14:06:25 xyz ppp[10470]: tun0: IPCP: deflink: SendConfigReq(4) state = Closed Sep 17 14:06:25 xyz ppp[10470]: tun0: IPCP: IPADDR[6] 0.0.0.0 Sep 17 14:06:25 xyz ppp[10470]: tun0: IPCP: COMPPROTO[6] 16 VJ slots with slot compression Sep 17 14:06:25 xyz ppp[10470]: tun0: IPCP: deflink: State change Closed --> Req-Sent Sep 17 14:06:25 xyz ppp[10470]: tun0: IPCP: deflink: RecvConfigReq(117) state = Req-Sent Sep 17 14:06:25 xyz ppp[10470]: tun0: IPCP: IPADDR[6] 150.101.32.44 Sep 17 14:06:25 xyz ppp[10470]: tun0: IPCP: deflink: SendConfigAck(117) state = Req-Sent Sep 17 14:06:25 xyz ppp[10470]: tun0: IPCP: IPADDR[6] 150.101.32.44 Sep 17 14:06:25 xyz ppp[10470]: tun0: IPCP: deflink: State change Req-Sent --> Ack-Sent Sep 17 14:06:25 xyz ppp[10470]: tun0: CCP: deflink: State change Req-Sent --> Stopped Sep 17 14:06:25 xyz ppp[10470]: tun0: IPCP: deflink: RecvConfigRej(4) state = Ack-Sent Sep 17 14:06:25 xyz ppp[10470]: tun0: IPCP: COMPPROTO[6] 16 VJ slots with slot compression Sep 17 14:06:25 xyz ppp[10470]: tun0: IPCP: deflink: SendConfigReq(5) state = Ack-Sent Sep 17 14:06:25 xyz ppp[10470]: tun0: IPCP: IPADDR[6] 0.0.0.0 Sep 17 14:06:25 xyz ppp[10470]: tun0: Phase: deflink: IPV6CP protocol reject closes IPV6CP ! Sep 17 14:06:25 xyz ppp[10470]: tun0: IPCP: deflink: RecvConfigNak(5) state = Ack-Sent Sep 17 14:06:25 xyz ppp[10470]: tun0: IPCP: IPADDR[6] 114.198.37.186 Sep 17 14:06:25 xyz ppp[10470]: tun0: IPCP: IPADDR[6] changing address: 0.0.0.0 --> 114.198.37.186 Sep 17 14:06:25 xyz ppp[10470]: tun0: IPCP: deflink: SendConfigReq(6) state = Ack-Sent Sep 17 14:06:25 xyz ppp[10470]: tun0: IPCP: IPADDR[6] 114.198.37.186 Sep 17 14:06:25 xyz ppp[10470]: tun0: Phase: deflink: IPV6CP protocol reject closes IPV6CP ! Sep 17 14:06:25 xyz ppp[10470]: tun0: IPCP: deflink: RecvConfigAck(6) state = Ack-Sent Sep 17 14:06:25 xyz ppp[10470]: tun0: IPCP: IPADDR[6] 114.198.37.186 Sep 17 14:06:25 xyz ppp[10470]: tun0: IPCP: deflink: State change Ack-Sent --> Opened Sep 17 14:06:25 xyz ppp[10470]: tun0: IPCP: deflink: LayerUp. Sep 17 14:06:25 xyz ppp[10470]: tun0: IPCP: myaddr 114.198.37.186 hisaddr = 150.101.32.44 Sep 17 14:06:25 xyz ppp[10470]: tun0: Command: iinet: !bg sh /etc/ppp/freedns.sh Sep 17 14:06:25 xyz ppp[10470]: tun0: Warning: 0.0.0.0: Change route failed: errno: No such process Sep 17 14:06:28 xyz ppp[10470]: tun0: Phase: deflink: IPV6CP protocol reject closes IPV6CP ! Sep 17 14:06:37 xyz last message repeated 3 times EOT
Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?20150917053324.GA26115>