Menu ▾ ▴

#63 Conectivity issues after #62

None
closed-fixed
Eugene Grosbein
None
5
2018-08-04
2018-08-01
Renato Botelho
No

After patch from ticket #62 reached pfSense I started to see issues with my 2 home ISPs. I'll submit all details I can here and will be able to send you every information you need and make tests.

Here is my config:

startup:
    # configure the console
    set console close
    # configure the web server
    set web close
    set log +iface +iface2

default:
pppoeclient:
    create bundle static wan
    set bundle enable ipv6cp
    set iface name pppoe0
    set iface disable on-demand
    set iface idle 0
    set iface enable tcpmssfix
    set iface up-script /usr/local/sbin/ppp-linkup
    set iface down-script /usr/local/sbin/ppp-linkdown
    set ipcp ranges 0.0.0.0/0 0.0.0.0/0
    #log -bund -ccp -chat -iface -ipcp -lcp -link

    create link static wan_link0 pppoe
    set link action bundle wan
    set link disable multilink
    set link keep-alive 10 60
    set link max-redial 0
    set link disable chap pap
    set link accept chap pap eap
    set link disable incoming
    set link mtu 1492
    set auth authname "renato.couto"
    set auth password renatocouto
    set pppoe service ""
    set pppoe iface igb1
    open
    ```

    Using mpd5 5.8_3, that works perfectly I got:

    ```
    Aug  1 07:40:55 pfgarga ppp: [wan] IFACE: Close event
Aug  1 07:40:55 pfgarga ppp: [wan] IPCP: Close event
Aug  1 07:40:55 pfgarga ppp: [wan] IPCP: state change Opened --> Closing
Aug  1 07:40:55 pfgarga ppp: [wan] IPCP: SendTerminateReq #4
Aug  1 07:40:55 pfgarga ppp: [wan] IPCP: LayerDown
Aug  1 07:40:55 pfgarga ppp: [wan] IFACE: Down event
Aug  1 07:40:55 pfgarga ppp: [wan] IFACE: Rename interface pppoe0 to pppoe0
Aug  1 07:40:55 pfgarga ppp: [wan] IPV6CP: Close event
Aug  1 07:40:55 pfgarga ppp: [wan] IPV6CP: state change Stopped --> Closed
Aug  1 07:40:55 pfgarga ppp: [wan] IPCP: rec'd Terminate Ack #4 (Closing)
Aug  1 07:40:55 pfgarga ppp: [wan] IPCP: state change Closing --> Closed
Aug  1 07:40:55 pfgarga ppp: [wan] IPCP: LayerFinish
Aug  1 07:40:55 pfgarga ppp: [wan] Bundle: No NCPs left. Closing links...
Aug  1 07:40:55 pfgarga ppp: [wan] Bundle: closing link "wan_link0"...
Aug  1 07:40:55 pfgarga ppp: [wan_link0] Link: CLOSE event
Aug  1 07:40:55 pfgarga ppp: [wan_link0] LCP: Close event
Aug  1 07:40:55 pfgarga ppp: [wan_link0] LCP: state change Opened --> Closing
Aug  1 07:40:55 pfgarga ppp: [wan_link0] Link: Leave bundle "wan"
Aug  1 07:40:55 pfgarga ppp: [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps
Aug  1 07:40:55 pfgarga ppp: [wan] IPCP: Close event
Aug  1 07:40:55 pfgarga ppp: [wan] IPV6CP: Close event
Aug  1 07:40:55 pfgarga ppp: [wan] IPCP: Down event
Aug  1 07:40:55 pfgarga ppp: [wan] IPCP: state change Closed --> Initial
Aug  1 07:40:55 pfgarga ppp: [wan] IPV6CP: Down event
Aug  1 07:40:55 pfgarga ppp: [wan] IPV6CP: state change Closed --> Initial
Aug  1 07:40:55 pfgarga ppp: [wan_link0] LCP: SendTerminateReq #4
Aug  1 07:40:55 pfgarga ppp: [wan_link0] LCP: LayerDown
Aug  1 07:40:55 pfgarga ppp: [wan_link0] LCP: rec'd Terminate Ack #4 (Closing)
Aug  1 07:40:55 pfgarga ppp: [wan_link0] LCP: state change Closing --> Closed
Aug  1 07:40:55 pfgarga ppp: [wan_link0] LCP: LayerFinish
Aug  1 07:40:55 pfgarga ppp: [wan_link0] Link: DOWN event
Aug  1 07:40:55 pfgarga ppp: [wan_link0] LCP: Down event
Aug  1 07:40:55 pfgarga ppp: [wan_link0] LCP: state change Closed --> Initial
Aug  1 07:40:57 pfgarga ppp: [wan] Bundle: Shutdown
Aug  1 07:40:57 pfgarga ppp: [wan_link0] Link: Shutdown
Aug  1 07:40:58 pfgarga ppp: [wan] Bundle: Interface ng0 created
Aug  1 07:40:58 pfgarga ppp: [wan_link0] Link: OPEN event
Aug  1 07:40:58 pfgarga ppp: [wan_link0] LCP: Open event
Aug  1 07:40:58 pfgarga ppp: [wan_link0] LCP: state change Initial --> Starting
Aug  1 07:40:58 pfgarga ppp: [wan_link0] LCP: LayerStart
Aug  1 07:40:58 pfgarga ppp: [wan_link0] PPPoE: Connecting to ''
Aug  1 07:40:58 pfgarga ppp: [wan_link0] PPPoE: connection successful
Aug  1 07:40:58 pfgarga ppp: [wan_link0] Link: UP event
Aug  1 07:40:58 pfgarga ppp: [wan_link0] LCP: Up event
Aug  1 07:40:58 pfgarga ppp: [wan_link0] LCP: state change Starting --> Req-Sent
Aug  1 07:40:58 pfgarga ppp: [wan_link0] LCP: SendConfigReq #1
Aug  1 07:40:58 pfgarga ppp: [wan_link0]   PROTOCOMP
Aug  1 07:40:58 pfgarga ppp: [wan_link0]   MRU 1492
Aug  1 07:40:58 pfgarga ppp: [wan_link0]   MAGICNUM 0x7c8beca2
Aug  1 07:40:59 pfgarga ppp: [wan_link0] LCP: rec'd Configure Request #1 (Req-Sent)
Aug  1 07:40:59 pfgarga ppp: [wan_link0]   AUTHPROTO CHAP MD5
Aug  1 07:40:59 pfgarga ppp: [wan_link0]   MRU 1480
Aug  1 07:40:59 pfgarga ppp: [wan_link0]   MAGICNUM 0x31299b17
Aug  1 07:40:59 pfgarga ppp: [wan_link0]   MP MRRU 1600
Aug  1 07:40:59 pfgarga ppp: [wan_link0] LCP: SendConfigRej #1
Aug  1 07:40:59 pfgarga ppp: [wan_link0]   MP MRRU 1600
Aug  1 07:40:59 pfgarga ppp: [wan_link0] LCP: rec'd Configure Request #2 (Req-Sent)
Aug  1 07:40:59 pfgarga ppp: [wan_link0]   AUTHPROTO CHAP MD5
Aug  1 07:40:59 pfgarga ppp: [wan_link0]   MRU 1480
Aug  1 07:40:59 pfgarga ppp: [wan_link0]   MAGICNUM 0x31299b17
Aug  1 07:40:59 pfgarga ppp: [wan_link0] LCP: SendConfigAck #2
Aug  1 07:40:59 pfgarga ppp: [wan_link0]   AUTHPROTO CHAP MD5
Aug  1 07:40:59 pfgarga ppp: [wan_link0]   MRU 1480
Aug  1 07:40:59 pfgarga ppp: [wan_link0]   MAGICNUM 0x31299b17
Aug  1 07:40:59 pfgarga ppp: [wan_link0] LCP: state change Req-Sent --> Ack-Sent
Aug  1 07:41:00 pfgarga ppp: [wan_link0] LCP: rec'd Configure Request #3 (Ack-Sent)
Aug  1 07:41:00 pfgarga ppp: [wan_link0]   AUTHPROTO CHAP MD5
Aug  1 07:41:00 pfgarga ppp: [wan_link0]   MRU 1480
Aug  1 07:41:00 pfgarga ppp: [wan_link0]   MAGICNUM 0x31299b17
Aug  1 07:41:00 pfgarga ppp: [wan_link0] LCP: SendConfigAck #3
Aug  1 07:41:00 pfgarga ppp: [wan_link0]   AUTHPROTO CHAP MD5
Aug  1 07:41:00 pfgarga ppp: [wan_link0]   MRU 1480
Aug  1 07:41:00 pfgarga ppp: [wan_link0]   MAGICNUM 0x31299b17
Aug  1 07:41:00 pfgarga ppp: [wan_link0] LCP: SendConfigReq #2
Aug  1 07:41:00 pfgarga ppp: [wan_link0]   PROTOCOMP
Aug  1 07:41:00 pfgarga ppp: [wan_link0]   MRU 1492
Aug  1 07:41:00 pfgarga ppp: [wan_link0]   MAGICNUM 0x7c8beca2
Aug  1 07:41:00 pfgarga ppp: [wan_link0] LCP: rec'd Configure Reject #2 (Ack-Sent)
Aug  1 07:41:00 pfgarga ppp: [wan_link0]   PROTOCOMP
Aug  1 07:41:00 pfgarga ppp: [wan_link0] LCP: SendConfigReq #3
Aug  1 07:41:00 pfgarga ppp: [wan_link0]   MRU 1492
Aug  1 07:41:00 pfgarga ppp: [wan_link0]   MAGICNUM 0x7c8beca2
Aug  1 07:41:00 pfgarga ppp: [wan_link0] LCP: rec'd Configure Ack #3 (Ack-Sent)
Aug  1 07:41:00 pfgarga ppp: [wan_link0]   MRU 1492
Aug  1 07:41:00 pfgarga ppp: [wan_link0]   MAGICNUM 0x7c8beca2
Aug  1 07:41:00 pfgarga ppp: [wan_link0] LCP: state change Ack-Sent --> Opened
Aug  1 07:41:00 pfgarga ppp: [wan_link0] LCP: auth: peer wants CHAP, I want nothing
Aug  1 07:41:00 pfgarga ppp: [wan_link0] LCP: LayerUp
Aug  1 07:41:00 pfgarga ppp: [wan_link0] CHAP: rec'd CHALLENGE #1 len: 56
Aug  1 07:41:00 pfgarga ppp: [wan_link0]   Name: "BRAS Iracemapolis - Telecom IntePe^S"
Aug  1 07:41:00 pfgarga ppp: [wan_link0] CHAP: Using authname "renato.couto"
Aug  1 07:41:00 pfgarga ppp: [wan_link0] CHAP: sending RESPONSE #1 len: 33
Aug  1 07:41:00 pfgarga ppp: [wan_link0] CHAP: rec'd SUCCESS #1 len: 12
Aug  1 07:41:00 pfgarga ppp: [wan_link0]   MESG: Welcome.
Aug  1 07:41:00 pfgarga ppp: [wan_link0] LCP: authorization successful
Aug  1 07:41:00 pfgarga ppp: [wan_link0] Link: Matched action 'bundle "wan" ""'
Aug  1 07:41:00 pfgarga ppp: [wan_link0] Link: Join bundle "wan"
Aug  1 07:41:00 pfgarga ppp: [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps
Aug  1 07:41:00 pfgarga ppp: [wan] IPCP: Open event
Aug  1 07:41:00 pfgarga ppp: [wan] IPCP: state change Initial --> Starting
Aug  1 07:41:00 pfgarga ppp: [wan] IPCP: LayerStart
Aug  1 07:41:00 pfgarga ppp: [wan] IPV6CP: Open event
Aug  1 07:41:00 pfgarga ppp: [wan] IPV6CP: state change Initial --> Starting
Aug  1 07:41:00 pfgarga ppp: [wan] IPV6CP: LayerStart
Aug  1 07:41:00 pfgarga ppp: [wan] IPCP: Up event
Aug  1 07:41:00 pfgarga ppp: [wan] IPCP: state change Starting --> Req-Sent
Aug  1 07:41:00 pfgarga ppp: [wan] IPCP: SendConfigReq #1
Aug  1 07:41:00 pfgarga ppp: [wan]   IPADDR 0.0.0.0
Aug  1 07:41:00 pfgarga ppp: [wan]   COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
Aug  1 07:41:00 pfgarga ppp: [wan] IPV6CP: Up event
Aug  1 07:41:00 pfgarga ppp: [wan] IPV6CP: state change Starting --> Req-Sent
Aug  1 07:41:00 pfgarga ppp: [wan] IPV6CP: SendConfigReq #1
Aug  1 07:41:00 pfgarga ppp: [wan] IPCP: rec'd Configure Request #1 (Req-Sent)
Aug  1 07:41:00 pfgarga ppp: [wan]   IPADDR 177.53.80.8
Aug  1 07:41:00 pfgarga ppp: [wan]     177.53.80.8 is OK
Aug  1 07:41:00 pfgarga ppp: [wan] IPCP: SendConfigAck #1
Aug  1 07:41:00 pfgarga ppp: [wan]   IPADDR 177.53.80.8
Aug  1 07:41:00 pfgarga ppp: [wan] IPCP: state change Req-Sent --> Ack-Sent
Aug  1 07:41:00 pfgarga ppp: [wan_link0] rec'd unexpected protocol MPLS Control Protocol (RFC 3032), rejecting
Aug  1 07:41:00 pfgarga ppp: [wan] IPCP: rec'd Configure Reject #1 (Ack-Sent)
Aug  1 07:41:00 pfgarga ppp: [wan]   COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
Aug  1 07:41:00 pfgarga ppp: [wan] IPCP: SendConfigReq #2
Aug  1 07:41:00 pfgarga ppp: [wan]   IPADDR 0.0.0.0
Aug  1 07:41:00 pfgarga ppp: [wan_link0] LCP: rec'd Protocol Reject #4 (Opened)
Aug  1 07:41:00 pfgarga ppp: [wan_link0] LCP: protocol IPV6CP was rejected
Aug  1 07:41:00 pfgarga ppp: [wan] IPV6CP: protocol was rejected by peer
Aug  1 07:41:00 pfgarga ppp: [wan] IPV6CP: state change Req-Sent --> Stopped
Aug  1 07:41:00 pfgarga ppp: [wan] IPV6CP: LayerFinish
Aug  1 07:41:00 pfgarga ppp: [wan] IPCP: rec'd Configure Nak #2 (Ack-Sent)
Aug  1 07:41:00 pfgarga ppp: [wan]   IPADDR 177.53.86.172
Aug  1 07:41:00 pfgarga ppp: [wan]     177.53.86.172 is OK
Aug  1 07:41:00 pfgarga ppp: [wan] IPCP: SendConfigReq #3
Aug  1 07:41:00 pfgarga ppp: [wan]   IPADDR 177.53.86.172
Aug  1 07:41:00 pfgarga ppp: [wan] IPCP: rec'd Configure Ack #3 (Ack-Sent)
Aug  1 07:41:00 pfgarga ppp: [wan]   IPADDR 177.53.86.172
Aug  1 07:41:00 pfgarga ppp: [wan] IPCP: state change Ack-Sent --> Opened
Aug  1 07:41:00 pfgarga ppp: [wan] IPCP: LayerUp
Aug  1 07:41:00 pfgarga ppp: [wan]   177.53.86.172 -> 177.53.80.8
Aug  1 07:41:00 pfgarga ppp: [wan] IFACE: Up event
Aug  1 07:41:00 pfgarga ppp: [wan] IFACE: Rename interface ng0 to pppoe0

# ifconfig pppoe0
pppoe0: flags=88d1<UP,POINTOPOINT,RUNNING,NOARP,SIMPLEX,MULTICAST> metric 0 mtu 1480
    inet 177.53.86.172 --> 177.53.80.8 netmask 0xffffffff
    inet6 fe80::208:a2ff:fe09:5b54%pppoe0 prefixlen 64 scopeid 0xc
    nd6 options=21<PERFORMNUD,AUTO_LINKLOCAL>

# netstat -nrWf inet
Routing tables

Internet:
Destination        Gateway            Flags       Use    Mtu      Netif Expire
default            177.53.80.8        UGS         171   1480     pppoe0
10.250.250.0/24    link#11            U             0   1500   igb0.666
10.250.250.1       link#11            UHS           0  16384        lo0
127.0.0.1          link#8             UH         7785  16384        lo0
172.21.4.0/24      link#1             U       9969928   1500       igb0
172.21.4.1         link#1             UHS           0  16384        lo0
177.53.80.4        pppoe0             UHS         446   1480     pppoe0
177.53.80.8        link#12            UH            0   1480     pppoe0
177.53.86.172      link#12            UHS           0  16384        lo0
201.77.127.155     link#13            UHS           0  16384        lo0
216.66.22.2        177.53.80.8        UGHS        539   1480     pppoe0

And then after I upgrade mpd5 to 5.8_5:

Aug  1 07:47:07 pfgarga ppp: [wan] IFACE: Close event
Aug  1 07:47:07 pfgarga ppp: [wan] IPCP: Close event
Aug  1 07:47:07 pfgarga ppp: [wan] IPCP: state change Opened --> Closing
Aug  1 07:47:07 pfgarga ppp: [wan] IPCP: SendTerminateReq #4
Aug  1 07:47:07 pfgarga ppp: [wan] IPCP: LayerDown
Aug  1 07:47:08 pfgarga ppp: [wan] IFACE: Down event
Aug  1 07:47:08 pfgarga ppp: [wan] IFACE: Rename interface pppoe0 to pppoe0
Aug  1 07:47:08 pfgarga ppp: [wan] IPV6CP: Close event
Aug  1 07:47:08 pfgarga ppp: [wan] IPV6CP: state change Stopped --> Closed
Aug  1 07:47:08 pfgarga ppp: [wan] IPCP: rec'd Terminate Ack #4 (Closing)
Aug  1 07:47:08 pfgarga ppp: [wan] IPCP: state change Closing --> Closed
Aug  1 07:47:08 pfgarga ppp: [wan] IPCP: LayerFinish
Aug  1 07:47:08 pfgarga ppp: [wan] Bundle: No NCPs left. Closing links...
Aug  1 07:47:08 pfgarga ppp: [wan] Bundle: closing link "wan_link0"...
Aug  1 07:47:08 pfgarga ppp: [wan_link0] Link: CLOSE event
Aug  1 07:47:08 pfgarga ppp: [wan_link0] LCP: Close event
Aug  1 07:47:08 pfgarga ppp: [wan_link0] LCP: state change Opened --> Closing
Aug  1 07:47:08 pfgarga ppp: [wan_link0] Link: Leave bundle "wan"
Aug  1 07:47:08 pfgarga ppp: [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps
Aug  1 07:47:08 pfgarga ppp: [wan] IPCP: Close event
Aug  1 07:47:08 pfgarga ppp: [wan] IPV6CP: Close event
Aug  1 07:47:08 pfgarga ppp: [wan] IPCP: Down event
Aug  1 07:47:08 pfgarga ppp: [wan] IPCP: state change Closed --> Initial
Aug  1 07:47:08 pfgarga ppp: [wan] IPV6CP: Down event
Aug  1 07:47:08 pfgarga ppp: [wan] IPV6CP: state change Closed --> Initial
Aug  1 07:47:08 pfgarga ppp: [wan_link0] LCP: SendTerminateReq #4
Aug  1 07:47:08 pfgarga ppp: [wan_link0] LCP: LayerDown
Aug  1 07:47:08 pfgarga ppp: [wan_link0] LCP: rec'd Terminate Ack #4 (Closing)
Aug  1 07:47:08 pfgarga ppp: [wan_link0] LCP: state change Closing --> Closed
Aug  1 07:47:08 pfgarga ppp: [wan_link0] LCP: LayerFinish
Aug  1 07:47:08 pfgarga ppp: [wan_link0] Link: DOWN event
Aug  1 07:47:08 pfgarga ppp: [wan_link0] LCP: Down event
Aug  1 07:47:08 pfgarga ppp: [wan_link0] LCP: state change Closed --> Initial
Aug  1 07:47:10 pfgarga ppp: [wan] Bundle: Shutdown
Aug  1 07:47:10 pfgarga ppp: [wan_link0] Link: Shutdown
Aug  1 07:47:10 pfgarga ppp: [wan] Bundle: Interface ng0 created
Aug  1 07:47:10 pfgarga ppp: [wan_link0] Link: OPEN event
Aug  1 07:47:10 pfgarga ppp: [wan_link0] LCP: Open event
Aug  1 07:47:10 pfgarga ppp: [wan_link0] LCP: state change Initial --> Starting
Aug  1 07:47:10 pfgarga ppp: [wan_link0] LCP: LayerStart
Aug  1 07:47:11 pfgarga ppp: [wan_link0] PPPoE: Connecting to ''
Aug  1 07:47:11 pfgarga ppp: [wan_link0] PPPoE: connection successful
Aug  1 07:47:11 pfgarga ppp: [wan_link0] Link: UP event
Aug  1 07:47:11 pfgarga ppp: [wan_link0] LCP: Up event
Aug  1 07:47:11 pfgarga ppp: [wan_link0] LCP: state change Starting --> Req-Sent
Aug  1 07:47:11 pfgarga ppp: [wan_link0] LCP: SendConfigReq #1
Aug  1 07:47:11 pfgarga ppp: [wan_link0]   PROTOCOMP
Aug  1 07:47:11 pfgarga ppp: [wan_link0]   MRU 1492
Aug  1 07:47:11 pfgarga ppp: [wan_link0]   MAGICNUM 0xe5091981
Aug  1 07:47:12 pfgarga ppp: [wan_link0] LCP: rec'd Configure Request #1 (Req-Sent)
Aug  1 07:47:12 pfgarga ppp: [wan_link0]   AUTHPROTO CHAP MD5
Aug  1 07:47:12 pfgarga ppp: [wan_link0]   MRU 1480
Aug  1 07:47:12 pfgarga ppp: [wan_link0]   MAGICNUM 0x21c40f19
Aug  1 07:47:12 pfgarga ppp: [wan_link0]   MP MRRU 1600
Aug  1 07:47:12 pfgarga ppp: [wan_link0] LCP: SendConfigRej #1
Aug  1 07:47:12 pfgarga ppp: [wan_link0]   MP MRRU 1600
Aug  1 07:47:12 pfgarga ppp: [wan_link0] LCP: rec'd Configure Request #2 (Req-Sent)
Aug  1 07:47:12 pfgarga ppp: [wan_link0]   AUTHPROTO CHAP MD5
Aug  1 07:47:12 pfgarga ppp: [wan_link0]   MRU 1480
Aug  1 07:47:12 pfgarga ppp: [wan_link0]   MAGICNUM 0x21c40f19
Aug  1 07:47:12 pfgarga ppp: [wan_link0] LCP: SendConfigAck #2
Aug  1 07:47:12 pfgarga ppp: [wan_link0]   AUTHPROTO CHAP MD5
Aug  1 07:47:12 pfgarga ppp: [wan_link0]   MRU 1480
Aug  1 07:47:12 pfgarga ppp: [wan_link0]   MAGICNUM 0x21c40f19
Aug  1 07:47:12 pfgarga ppp: [wan_link0] LCP: state change Req-Sent --> Ack-Sent
Aug  1 07:47:12 pfgarga ppp: [wan_link0] LCP: rec'd Configure Request #3 (Ack-Sent)
Aug  1 07:47:12 pfgarga ppp: [wan_link0]   AUTHPROTO CHAP MD5
Aug  1 07:47:12 pfgarga ppp: [wan_link0]   MRU 1480
Aug  1 07:47:12 pfgarga ppp: [wan_link0]   MAGICNUM 0x21c40f19
Aug  1 07:47:12 pfgarga ppp: [wan_link0] LCP: SendConfigAck #3
Aug  1 07:47:12 pfgarga ppp: [wan_link0]   AUTHPROTO CHAP MD5
Aug  1 07:47:12 pfgarga ppp: [wan_link0]   MRU 1480
Aug  1 07:47:12 pfgarga ppp: [wan_link0]   MAGICNUM 0x21c40f19
Aug  1 07:47:13 pfgarga ppp: [wan_link0] LCP: SendConfigReq #2
Aug  1 07:47:13 pfgarga ppp: [wan_link0]   PROTOCOMP
Aug  1 07:47:13 pfgarga ppp: [wan_link0]   MRU 1492
Aug  1 07:47:13 pfgarga ppp: [wan_link0]   MAGICNUM 0xe5091981
Aug  1 07:47:13 pfgarga ppp: [wan_link0] LCP: rec'd Configure Reject #2 (Ack-Sent)
Aug  1 07:47:13 pfgarga ppp: [wan_link0]   PROTOCOMP
Aug  1 07:47:13 pfgarga ppp: [wan_link0] LCP: SendConfigReq #3
Aug  1 07:47:13 pfgarga ppp: [wan_link0]   MRU 1492
Aug  1 07:47:13 pfgarga ppp: [wan_link0]   MAGICNUM 0xe5091981
Aug  1 07:47:13 pfgarga ppp: [wan_link0] LCP: rec'd Configure Ack #3 (Ack-Sent)
Aug  1 07:47:13 pfgarga ppp: [wan_link0]   MRU 1492
Aug  1 07:47:13 pfgarga ppp: [wan_link0]   MAGICNUM 0xe5091981
Aug  1 07:47:13 pfgarga ppp: [wan_link0] LCP: state change Ack-Sent --> Opened
Aug  1 07:47:13 pfgarga ppp: [wan_link0] LCP: auth: peer wants CHAP, I want nothing
Aug  1 07:47:13 pfgarga ppp: [wan_link0] LCP: LayerUp
Aug  1 07:47:13 pfgarga ppp: [wan_link0] CHAP: rec'd CHALLENGE #1 len: 56
Aug  1 07:47:13 pfgarga ppp: [wan_link0]   Name: "BRAS Iracemapolis - Telecom Inte�^_^X"
Aug  1 07:47:13 pfgarga ppp: [wan_link0] CHAP: Using authname "renato.couto"
Aug  1 07:47:13 pfgarga ppp: [wan_link0] CHAP: sending RESPONSE #1 len: 33
Aug  1 07:47:13 pfgarga ppp: [wan_link0] CHAP: rec'd SUCCESS #1 len: 12
Aug  1 07:47:13 pfgarga ppp: [wan_link0]   MESG: Welcome.
Aug  1 07:47:13 pfgarga ppp: [wan_link0] LCP: authorization successful
Aug  1 07:47:13 pfgarga ppp: [wan_link0] Link: Matched action 'bundle "wan" ""'
Aug  1 07:47:13 pfgarga ppp: [wan_link0] Link: Join bundle "wan"
Aug  1 07:47:13 pfgarga ppp: [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps
Aug  1 07:47:13 pfgarga ppp: [wan] IPCP: Open event
Aug  1 07:47:13 pfgarga ppp: [wan] IPCP: state change Initial --> Starting
Aug  1 07:47:13 pfgarga ppp: [wan] IPCP: LayerStart
Aug  1 07:47:13 pfgarga ppp: [wan] IPV6CP: Open event
Aug  1 07:47:13 pfgarga ppp: [wan] IPV6CP: state change Initial --> Starting
Aug  1 07:47:13 pfgarga ppp: [wan] IPV6CP: LayerStart
Aug  1 07:47:13 pfgarga ppp: [wan] IPCP: Up event
Aug  1 07:47:13 pfgarga ppp: [wan] IPCP: state change Starting --> Req-Sent
Aug  1 07:47:13 pfgarga ppp: [wan] IPCP: SendConfigReq #1
Aug  1 07:47:13 pfgarga ppp: [wan]   IPADDR 0.0.0.0
Aug  1 07:47:13 pfgarga ppp: [wan]   COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
Aug  1 07:47:13 pfgarga ppp: [wan] IPV6CP: Up event
Aug  1 07:47:13 pfgarga ppp: [wan] IPV6CP: state change Starting --> Req-Sent
Aug  1 07:47:13 pfgarga ppp: [wan] IPV6CP: SendConfigReq #1
Aug  1 07:47:13 pfgarga ppp: [wan_link0] rec'd unexpected protocol MPLS Control Protocol (RFC 3032), rejecting
Aug  1 07:47:13 pfgarga ppp: [wan] IPCP: rec'd Configure Reject #1 (Req-Sent)
Aug  1 07:47:13 pfgarga ppp: [wan]   COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
Aug  1 07:47:13 pfgarga ppp: [wan] IPCP: SendConfigReq #2
Aug  1 07:47:13 pfgarga ppp: [wan]   IPADDR 0.0.0.0
Aug  1 07:47:13 pfgarga ppp: [wan_link0] LCP: rec'd Protocol Reject #4 (Opened)
Aug  1 07:47:13 pfgarga ppp: [wan_link0] LCP: protocol IPV6CP was rejected
Aug  1 07:47:13 pfgarga ppp: [wan] IPV6CP: protocol was rejected by peer
Aug  1 07:47:13 pfgarga ppp: [wan] IPV6CP: state change Req-Sent --> Stopped
Aug  1 07:47:13 pfgarga ppp: [wan] IPV6CP: LayerFinish
Aug  1 07:47:13 pfgarga ppp: [wan] IPCP: rec'd Configure Nak #2 (Req-Sent)
Aug  1 07:47:13 pfgarga ppp: [wan]   IPADDR 177.53.86.172
Aug  1 07:47:13 pfgarga ppp: [wan]     177.53.86.172 is OK
Aug  1 07:47:13 pfgarga ppp: [wan] IPCP: SendConfigReq #3
Aug  1 07:47:13 pfgarga ppp: [wan]   IPADDR 177.53.86.172
Aug  1 07:47:13 pfgarga ppp: [wan] IPCP: rec'd Configure Ack #3 (Req-Sent)
Aug  1 07:47:13 pfgarga ppp: [wan]   IPADDR 177.53.86.172
Aug  1 07:47:13 pfgarga ppp: [wan] IPCP: state change Req-Sent --> Ack-Rcvd
Aug  1 07:47:13 pfgarga ppp: [wan] IPCP: rec'd Configure Request #2 (Ack-Rcvd)
Aug  1 07:47:13 pfgarga ppp: [wan]   IPADDR 177.53.80.8
Aug  1 07:47:13 pfgarga ppp: [wan]     177.53.80.8 is OK
Aug  1 07:47:13 pfgarga ppp: [wan] IPCP: SendConfigAck #2
Aug  1 07:47:13 pfgarga ppp: [wan]   IPADDR 177.53.80.8
Aug  1 07:47:13 pfgarga ppp: [wan] IPCP: state change Ack-Rcvd --> Opened
Aug  1 07:47:13 pfgarga ppp: [wan] IPCP: LayerUp
Aug  1 07:47:13 pfgarga ppp: [wan]   177.53.86.172 -> 177.53.80.8
Aug  1 07:47:13 pfgarga ppp: [wan] IFACE: Up event
Aug  1 07:47:13 pfgarga ppp: [wan] IFACE: Rename interface ng0 to pppoe0

# ifconfig pppoe0
pppoe0: flags=88d1<UP,POINTOPOINT,RUNNING,NOARP,SIMPLEX,MULTICAST> metric 0 mtu 1492
    inet 177.53.86.172 --> 177.53.80.8 netmask 0xffffffff
    inet6 fe80::208:a2ff:fe09:5b54%pppoe0 prefixlen 64 scopeid 0xc
    nd6 options=21<PERFORMNUD,AUTO_LINKLOCAL>

# netstat -nrWf inet
Routing tables

Internet:
Destination        Gateway            Flags       Use    Mtu      Netif Expire
default            177.53.80.8        UGS          43   1492     pppoe0
10.250.250.0/24    link#11            U             0   1500   igb0.666
10.250.250.1       link#11            UHS           0  16384        lo0
127.0.0.1          link#8             UH         7868  16384        lo0
172.21.4.0/24      link#1             U       9972647   1500       igb0
172.21.4.1         link#1             UHS           0  16384        lo0
177.53.80.4        pppoe0             UHS          94   1492     pppoe0
177.53.80.8        link#12            UH            0   1492     pppoe0
177.53.86.172      link#12            UHS           0  16384        lo0
201.77.127.155     link#13            UHS           0  16384        lo0
216.66.22.2        177.53.80.8        UGHS        115   1492     pppoe0

Using 5.8_5 I have problems to access many hosts.

Discussion

<< < 1 2 (Page 2 of 2)

  • Eugene Grosbein

    Eugene Grosbein - 2018-08-02

    That's because you still capture traffic before MSS correction happens.

     

  • Eugene Grosbein

    Eugene Grosbein - 2018-08-02

    Also, attach output of two following commands while PPPoE connection established using mtu=1492:

    traceroute -F -e -p 443 -P TCP 52.41.83.111 1492
    traceroute -I 52.41.83.111

     

    Last edit: Eugene Grosbein 2018-08-02

    • Renato Botelho

      Renato Botelho - 2018-08-02

      None have finished. I cut out * * * lines from the end of output

      traceroute to 52.41.83.111 (52.41.83.111) from 177.53.86.172, 64 hops max, 1492 byte packets
 1  177-53-80-8.telecominternet.com.br (177.53.80.8)  0.573 ms * *
 2  * * *
 3  * * 100.65.0.25 (100.65.0.25)  7.638 ms
 4  * * *
 5  * * *
 6  * * ae-4.r22.sttlwa01.us.bb.gin.ntt.net (129.250.4.13)  187.063 ms
 7  * * *
 8  * * *
 9  * ae-6.amazon.sttlwa01.us.bb.gin.ntt.net (198.104.202.186)  190.089 ms *
10  * * *
11  * * *
12  * * *
13  * * *
14  * * *
15  * * *
16  * * *
17  * 52.93.12.182 (52.93.12.182)  252.889 ms *

      traceroute to 52.41.83.111 (52.41.83.111), 64 hops max, 48 byte packets
 1  177-53-80-8.telecominternet.com.br (177.53.80.8)  0.944 ms  0.362 ms  0.317 ms
 2  177-53-80-1.telecominternet.com.br (177.53.80.1)  1.151 ms  0.717 ms  0.581 ms
 3  100.65.0.25 (100.65.0.25)  9.560 ms  7.102 ms  8.830 ms
 4  xe-0-0-0-3-1.r01.saplbr01.br.bb.gin.ntt.net (200.15.2.129)  8.084 ms  7.597 ms  7.661 ms
 5  ae-4.r24.nycmny01.us.bb.gin.ntt.net (129.250.2.227)  118.316 ms  118.654 ms  121.370 ms
 6  * * *
 7  ae-28.r05.sttlwa01.us.bb.gin.ntt.net (129.250.2.45)  188.416 ms  188.434 ms  188.374 ms
 8  ae-1.a01.sttlwa01.us.bb.gin.ntt.net (129.250.5.98)  187.752 ms  184.452 ms  184.276 ms
 9  ae-5.amazon.sttlwa01.us.bb.gin.ntt.net (198.104.202.182)  188.864 ms  188.786 ms  189.801 ms
10  * * *
11  52.95.52.27 (52.95.52.27)  204.967 ms  205.351 ms  204.957 ms
12  * * *
13  * * *
14  * * *
15  52.93.12.84 (52.93.12.84)  213.299 ms  208.985 ms  228.497 ms
16  * * *
17  52.93.12.178 (52.93.12.178)  209.180 ms  208.994 ms  208.881 ms
18  52.93.12.209 (52.93.12.209)  207.805 ms  207.757 ms *
       

  • Eugene Grosbein

    Eugene Grosbein - 2018-08-02

    That's enough diagnostics for a moment. It may take several days to produce a patch solving the problem.

     

    • Renato Botelho

      Renato Botelho - 2018-08-02

      It's awesome you identified the issue. Would you mind to describe it briefly? Whenever you have a patch I will be glad to test it.

       

      • Eugene Grosbein

        Eugene Grosbein - 2018-08-02

        Latest traceroute probes confirm that outgoing IP packets pass just fine upto size 1492 with DF-bit enabled. ping confirms that ICMP packets same size with DF-bit pass over PPPoE link to remote router just fine too. Your ISP agrees with mpd5's proposal for MRU 1492 too.

        However, for some unknown reason incoming IP packets containing TCP segments pass upto 1480 bytes only (MSS=1440 + 40 bytes headers overhead) - confirmed by your scrub/mtu experiments.

        Before bug #62 fix, mpd5 ignored remote peer acceptance of mpd5's own proposal for larger MTU if remote peer's initial proposal is less, so you have got MTU=1480 leading to automatic MSS=1440, hence no timeouts. After that fix, mpd5 uses remote peer acceptance of mpd5's own proposal for larger MTU to setup larger MTU and you get MTU=1492 and timeouts. I need to re-read what standards state.

         

        • Renato Botelho

          Renato Botelho - 2018-08-02

          I have a quick question. Looking at this log:

          Aug  2 08:46:40 pfgarga ppp: [wan_link0] LCP: SendConfigReq #1
Aug  2 08:46:40 pfgarga ppp: [wan_link0]   MRU 1492
Aug  2 08:46:40 pfgarga ppp: [wan_link0]   MAGICNUM 0x2e388320
Aug  2 08:46:41 pfgarga ppp: [wan_link0] LCP: rec'd Configure Request #1 (Req-Sent)
Aug  2 08:46:41 pfgarga ppp: [wan_link0]   AUTHPROTO CHAP MD5
Aug  2 08:46:41 pfgarga ppp: [wan_link0]   MRU 1480
Aug  2 08:46:41 pfgarga ppp: [wan_link0]   MAGICNUM 0xbd0c933a
Aug  2 08:46:41 pfgarga ppp: [wan_link0]   MP MRRU 1600
Aug  2 08:46:41 pfgarga ppp: [wan_link0] LCP: SendConfigRej #1
Aug  2 08:46:41 pfgarga ppp: [wan_link0]   MP MRRU 1600
Aug  2 08:46:41 pfgarga ppp: [wan_link0] LCP: rec'd Configure Request #2 (Req-Sent)
Aug  2 08:46:41 pfgarga ppp: [wan_link0]   AUTHPROTO CHAP MD5
Aug  2 08:46:41 pfgarga ppp: [wan_link0]   MRU 1480
Aug  2 08:46:41 pfgarga ppp: [wan_link0]   MAGICNUM 0xbd0c933a
Aug  2 08:46:41 pfgarga ppp: [wan_link0] LCP: SendConfigAck #2
Aug  2 08:46:41 pfgarga ppp: [wan_link0]   AUTHPROTO CHAP MD5
Aug  2 08:46:41 pfgarga ppp: [wan_link0]   MRU 1480
Aug  2 08:46:41 pfgarga ppp: [wan_link0]   MAGICNUM 0xbd0c933a
Aug  2 08:46:41 pfgarga ppp: [wan_link0] LCP: state change Req-Sent --> Ack-Sent
Aug  2 08:46:42 pfgarga ppp: [wan_link0] LCP: SendConfigReq #2
Aug  2 08:46:42 pfgarga ppp: [wan_link0]   MRU 1492
Aug  2 08:46:42 pfgarga ppp: [wan_link0]   MAGICNUM 0x2e388320
Aug  2 08:46:42 pfgarga ppp: [wan_link0] LCP: rec'd Configure Ack #2 (Ack-Sent)
Aug  2 08:46:42 pfgarga ppp: [wan_link0]   MRU 1492
Aug  2 08:46:42 pfgarga ppp: [wan_link0]   MAGICNUM 0x2e388320

          On the first LCP negotiation ISP answer saying it wants MRU to be 1480. Why do mpd5 ask to use MRU 1492 on 2nd SendConfigReq? Shouldn't it use the value defined by ISP on first one?

           

          • Eugene Grosbein

            Eugene Grosbein - 2018-08-02

            No. Each PPP peer may announce its own MRU value independently.

             

  • Eugene Grosbein

    Eugene Grosbein - 2018-08-02
    • Group: -->
     

  • Eugene Grosbein

    Eugene Grosbein - 2018-08-02

    By the way, logs show your ISP supports "LCP multilink extensions over single link".

    It would be nice and helped me a bit if you change "set link disable multilink" to "set link enable multilink" and retry the test with all mtu/mru settings commented out. You should get PPPoE connection with MTU=1500 and no connectivity problems (with oversized PPP frames transparently fragmented/defragmented by PPP peers at layer 2).

     

    • Renato Botelho

      Renato Botelho - 2018-08-02

      You are right. One of my ISPs (the one I'm using for testing on this bug)

      Aug  2 12:01:14 pfgarga ppp: [wan] IFACE: Close event
Aug  2 12:01:14 pfgarga ppp: [wan] IPCP: Close event
Aug  2 12:01:14 pfgarga ppp: [wan] IPCP: state change Opened --> Closing
Aug  2 12:01:14 pfgarga ppp: [wan] IPCP: SendTerminateReq #4
Aug  2 12:01:14 pfgarga ppp: [wan] IPCP: LayerDown
Aug  2 12:01:14 pfgarga ppp: [wan] system: /usr/local/sbin/ppp-linkdown pppoe0 inet 177.53.86.172/32 177.53.80.8 '-' '00:00:00:00:00:00' '-'
Aug  2 12:01:14 pfgarga ppp: [wan] IFACE: Remove address 177.53.86.172/32->177.53.80.8 from pppoe0
Aug  2 12:01:14 pfgarga ppp: [wan] IFACE: Down event
Aug  2 12:01:14 pfgarga ppp: [wan] IFACE: Change interface pppoe0 flags: -4097 +0
Aug  2 12:01:14 pfgarga ppp: [wan] IFACE: Rename interface pppoe0 to pppoe0
Aug  2 12:01:14 pfgarga ppp: [wan] IPV6CP: Close event
Aug  2 12:01:14 pfgarga ppp: [wan] IPV6CP: state change Stopped --> Closed
Aug  2 12:01:14 pfgarga ppp: [wan] IPCP: rec'd Terminate Ack #4 (Closing)
Aug  2 12:01:14 pfgarga ppp: [wan] IPCP: state change Closing --> Closed
Aug  2 12:01:14 pfgarga ppp: [wan] IPCP: LayerFinish
Aug  2 12:01:14 pfgarga ppp: [wan] Bundle: No NCPs left. Closing links...
Aug  2 12:01:14 pfgarga ppp: [wan] Bundle: closing link "wan_link0"...
Aug  2 12:01:14 pfgarga ppp: [wan_link0] Link: CLOSE event
Aug  2 12:01:14 pfgarga ppp: [wan_link0] LCP: Close event
Aug  2 12:01:14 pfgarga ppp: [wan_link0] LCP: state change Opened --> Closing
Aug  2 12:01:14 pfgarga ppp: [wan_link0] Link: Leave bundle "wan"
Aug  2 12:01:14 pfgarga ppp: [wan] IFACE: setting pppoe0 MTU to 1500 bytes
Aug  2 12:01:14 pfgarga ppp: [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps
Aug  2 12:01:14 pfgarga ppp: [wan] IPCP: Close event
Aug  2 12:01:14 pfgarga ppp: [wan] IPV6CP: Close event
Aug  2 12:01:14 pfgarga ppp: [wan] IPCP: Down event
Aug  2 12:01:14 pfgarga ppp: [wan] IPCP: state change Closed --> Initial
Aug  2 12:01:14 pfgarga ppp: [wan] IPV6CP: Down event
Aug  2 12:01:14 pfgarga ppp: [wan] IPV6CP: state change Closed --> Initial
Aug  2 12:01:14 pfgarga ppp: [wan_link0] LCP: SendTerminateReq #4
Aug  2 12:01:14 pfgarga ppp: [wan_link0] LCP: LayerDown
Aug  2 12:01:14 pfgarga ppp: [wan_link0] LCP: rec'd Terminate Ack #4 (Closing)
Aug  2 12:01:14 pfgarga ppp: [wan_link0] LCP: state change Closing --> Closed
Aug  2 12:01:14 pfgarga ppp: [wan_link0] LCP: LayerFinish
Aug  2 12:01:14 pfgarga ppp: [wan_link0] Link: DOWN event
Aug  2 12:01:14 pfgarga ppp: [wan_link0] LCP: Down event
Aug  2 12:01:14 pfgarga ppp: [wan_link0] LCP: state change Closed --> Initial
Aug  2 12:01:16 pfgarga ppp: [wan] Bundle: Shutdown
Aug  2 12:01:16 pfgarga ppp: [wan_link0] Link: Shutdown
Aug  2 12:01:17 pfgarga ppp: [wan] Bundle: Interface ng0 created
Aug  2 12:01:17 pfgarga ppp: [wan] IFACE: setting "ng0" name to "pppoe0"
Aug  2 12:01:17 pfgarga ppp: [wan_link0] Link: OPEN event
Aug  2 12:01:17 pfgarga ppp: [wan_link0] LCP: Open event
Aug  2 12:01:17 pfgarga ppp: [wan_link0] LCP: state change Initial --> Starting
Aug  2 12:01:17 pfgarga ppp: [wan_link0] LCP: LayerStart
Aug  2 12:01:17 pfgarga ppp: [wan_link0] PPPoE: Connecting to ''
Aug  2 12:01:17 pfgarga ppp: [wan_link0] PPPoE: connection successful
Aug  2 12:01:17 pfgarga ppp: [wan_link0] Link: UP event
Aug  2 12:01:17 pfgarga ppp: [wan_link0] LCP: Up event
Aug  2 12:01:17 pfgarga ppp: [wan_link0] LCP: state change Starting --> Req-Sent
Aug  2 12:01:17 pfgarga ppp: [wan_link0] LCP: SendConfigReq #1
Aug  2 12:01:17 pfgarga ppp: [wan_link0]   PROTOCOMP
Aug  2 12:01:17 pfgarga ppp: [wan_link0]   MRU 1492
Aug  2 12:01:17 pfgarga ppp: [wan_link0]   MAGICNUM 0x8f38cf90
Aug  2 12:01:17 pfgarga ppp: [wan_link0]   MP MRRU 2048
Aug  2 12:01:17 pfgarga ppp: [wan_link0]   MP SHORTSEQ
Aug  2 12:01:17 pfgarga ppp: [wan_link0]   ENDPOINTDISC [802.1] 00 08 a2 09 5b 54
Aug  2 12:01:18 pfgarga ppp: [wan_link0] LCP: rec'd Configure Request #1 (Req-Sent)
Aug  2 12:01:18 pfgarga ppp: [wan_link0]   AUTHPROTO CHAP MD5
Aug  2 12:01:18 pfgarga ppp: [wan_link0]   MRU 1480
Aug  2 12:01:18 pfgarga ppp: [wan_link0]   MAGICNUM 0x7372e67c
Aug  2 12:01:18 pfgarga ppp: [wan_link0]   MP MRRU 1600
Aug  2 12:01:18 pfgarga ppp: [wan_link0] LCP: SendConfigAck #1
Aug  2 12:01:18 pfgarga ppp: [wan_link0]   AUTHPROTO CHAP MD5
Aug  2 12:01:18 pfgarga ppp: [wan_link0]   MRU 1480
Aug  2 12:01:18 pfgarga ppp: [wan_link0]   MAGICNUM 0x7372e67c
Aug  2 12:01:18 pfgarga ppp: [wan_link0]   MP MRRU 1600
Aug  2 12:01:18 pfgarga ppp: [wan_link0] LCP: state change Req-Sent --> Ack-Sent
Aug  2 12:01:19 pfgarga ppp: [wan_link0] LCP: SendConfigReq #2
Aug  2 12:01:19 pfgarga ppp: [wan_link0]   PROTOCOMP
Aug  2 12:01:19 pfgarga ppp: [wan_link0]   MRU 1492
Aug  2 12:01:19 pfgarga ppp: [wan_link0]   MAGICNUM 0x8f38cf90
Aug  2 12:01:19 pfgarga ppp: [wan_link0]   MP MRRU 2048
Aug  2 12:01:19 pfgarga ppp: [wan_link0]   MP SHORTSEQ
Aug  2 12:01:19 pfgarga ppp: [wan_link0]   ENDPOINTDISC [802.1] 00 08 a2 09 5b 54
Aug  2 12:01:19 pfgarga ppp: [wan_link0] LCP: rec'd Configure Reject #2 (Ack-Sent)
Aug  2 12:01:19 pfgarga ppp: [wan_link0]   PROTOCOMP
Aug  2 12:01:19 pfgarga ppp: [wan_link0]   ENDPOINTDISC [802.1] 00 08 a2 09 5b 54
Aug  2 12:01:19 pfgarga ppp: [wan_link0]   MP SHORTSEQ
Aug  2 12:01:19 pfgarga ppp: [wan_link0] LCP: SendConfigReq #3
Aug  2 12:01:19 pfgarga ppp: [wan_link0]   MRU 1492
Aug  2 12:01:19 pfgarga ppp: [wan_link0]   MAGICNUM 0x8f38cf90
Aug  2 12:01:19 pfgarga ppp: [wan_link0]   MP MRRU 2048
Aug  2 12:01:19 pfgarga ppp: [wan_link0] LCP: rec'd Configure Ack #3 (Ack-Sent)
Aug  2 12:01:19 pfgarga ppp: [wan_link0]   MRU 1492
Aug  2 12:01:19 pfgarga ppp: [wan_link0]   MAGICNUM 0x8f38cf90
Aug  2 12:01:19 pfgarga ppp: [wan_link0]   MP MRRU 2048
Aug  2 12:01:19 pfgarga ppp: [wan_link0] LCP: state change Ack-Sent --> Opened
Aug  2 12:01:19 pfgarga ppp: [wan_link0] LCP: auth: peer wants CHAP, I want nothing
Aug  2 12:01:19 pfgarga ppp: [wan_link0] LCP: LayerUp
Aug  2 12:01:19 pfgarga ppp: [wan_link0] CHAP: rec'd CHALLENGE #1 len: 56
Aug  2 12:01:19 pfgarga ppp: [wan_link0]   Name: "BRAS Iracemapolis - Telecom InteM-^Xv^N"
Aug  2 12:01:19 pfgarga ppp: [wan_link0] CHAP: Using authname "renato.couto"
Aug  2 12:01:19 pfgarga ppp: [wan_link0] CHAP: sending RESPONSE #1 len: 33
Aug  2 12:01:19 pfgarga ppp: [wan_link0] CHAP: rec'd SUCCESS #1 len: 12
Aug  2 12:01:19 pfgarga ppp: [wan_link0]   MESG: Welcome.
Aug  2 12:01:19 pfgarga ppp: [wan_link0] LCP: authorization successful
Aug  2 12:01:19 pfgarga ppp: [wan_link0] Link: Matched action 'bundle "wan" ""'
Aug  2 12:01:19 pfgarga ppp: [wan_link0] Link: Join bundle "wan"
Aug  2 12:01:19 pfgarga ppp: [wan] IFACE: setting pppoe0 MTU to 1500 bytes
Aug  2 12:01:19 pfgarga ppp: [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps
Aug  2 12:01:19 pfgarga ppp: [wan] IPCP: Open event
Aug  2 12:01:19 pfgarga ppp: [wan] IPCP: state change Initial --> Starting
Aug  2 12:01:19 pfgarga ppp: [wan] IPCP: LayerStart
Aug  2 12:01:19 pfgarga ppp: [wan] IPV6CP: Open event
Aug  2 12:01:19 pfgarga ppp: [wan] IPV6CP: state change Initial --> Starting
Aug  2 12:01:19 pfgarga ppp: [wan] IPV6CP: LayerStart
Aug  2 12:01:19 pfgarga ppp: [wan] IPCP: Up event
Aug  2 12:01:19 pfgarga ppp: [wan] IPCP: state change Starting --> Req-Sent
Aug  2 12:01:19 pfgarga ppp: [wan] IPCP: SendConfigReq #1
Aug  2 12:01:19 pfgarga ppp: [wan]   IPADDR 0.0.0.0
Aug  2 12:01:19 pfgarga ppp: [wan]   COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
Aug  2 12:01:19 pfgarga ppp: [wan] IPV6CP: Up event
Aug  2 12:01:19 pfgarga ppp: [wan] IPV6CP: state change Starting --> Req-Sent
Aug  2 12:01:19 pfgarga ppp: [wan] IPV6CP: SendConfigReq #1
Aug  2 12:01:19 pfgarga ppp: [wan] IPCP: rec'd Configure Request #1 (Req-Sent)
Aug  2 12:01:19 pfgarga ppp: [wan]   IPADDR 177.53.80.8
Aug  2 12:01:19 pfgarga ppp: [wan]     177.53.80.8 is OK
Aug  2 12:01:19 pfgarga ppp: [wan] IPCP: SendConfigAck #1
Aug  2 12:01:19 pfgarga ppp: [wan]   IPADDR 177.53.80.8
Aug  2 12:01:19 pfgarga ppp: [wan] IPCP: state change Req-Sent --> Ack-Sent
Aug  2 12:01:19 pfgarga ppp: [wan_link0] rec'd unexpected protocol MPLS Control Protocol (RFC 3032), rejecting
Aug  2 12:01:19 pfgarga ppp: [wan] IPCP: rec'd Configure Reject #1 (Ack-Sent)
Aug  2 12:01:19 pfgarga ppp: [wan]   COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
Aug  2 12:01:19 pfgarga ppp: [wan] IPCP: SendConfigReq #2
Aug  2 12:01:19 pfgarga ppp: [wan]   IPADDR 0.0.0.0
Aug  2 12:01:19 pfgarga ppp: [wan_link0] LCP: rec'd Protocol Reject #2 (Opened)
Aug  2 12:01:19 pfgarga ppp: [wan_link0] LCP: protocol IPV6CP was rejected
Aug  2 12:01:19 pfgarga ppp: [wan] IPV6CP: protocol was rejected by peer
Aug  2 12:01:19 pfgarga ppp: [wan] IPV6CP: state change Req-Sent --> Stopped
Aug  2 12:01:19 pfgarga ppp: [wan] IPV6CP: LayerFinish
Aug  2 12:01:19 pfgarga ppp: [wan] IPCP: rec'd Configure Nak #2 (Ack-Sent)
Aug  2 12:01:19 pfgarga ppp: [wan]   IPADDR 177.53.86.172
Aug  2 12:01:19 pfgarga ppp: [wan]     177.53.86.172 is OK
Aug  2 12:01:19 pfgarga ppp: [wan] IPCP: SendConfigReq #3
Aug  2 12:01:19 pfgarga ppp: [wan]   IPADDR 177.53.86.172
Aug  2 12:01:19 pfgarga ppp: [wan] IPCP: rec'd Configure Ack #3 (Ack-Sent)
Aug  2 12:01:19 pfgarga ppp: [wan]   IPADDR 177.53.86.172
Aug  2 12:01:19 pfgarga ppp: [wan] IPCP: state change Ack-Sent --> Opened
Aug  2 12:01:19 pfgarga ppp: [wan] IPCP: LayerUp
Aug  2 12:01:19 pfgarga ppp: [wan]   177.53.86.172 -> 177.53.80.8
Aug  2 12:01:19 pfgarga ppp: [wan] IFACE: Connecting tcpmssfix
Aug  2 12:01:19 pfgarga ppp: [wan] IFACE: Configuring tcpmssfix mpd83596-wan-mss:: 1460
Aug  2 12:01:19 pfgarga ppp: [wan] IFACE: Add address 177.53.86.172/32->177.53.80.8 to pppoe0
Aug  2 12:01:19 pfgarga ppp: [wan] system: /usr/local/sbin/ppp-linkup pppoe0 inet 177.53.86.172/32 177.53.80.8 '-' '' '' '00:00:00:00:00:00' '-'
Aug  2 12:01:19 pfgarga ppp: [wan] IFACE: Up event
Aug  2 12:01:19 pfgarga ppp: [wan] IFACE: Rename interface ng0 to pppoe0
Aug  2 12:01:19 pfgarga ppp: [wan] IFACE: Change interface pppoe0 flags: -0 +1

      pppoe0: flags=88d1<UP,POINTOPOINT,RUNNING,NOARP,SIMPLEX,MULTICAST> metric 0 mtu 1500
    inet 177.53.86.172 --> 177.53.80.8 netmask 0xffffffff
    inet6 fe80::208:a2ff:fe09:5b54%pppoe0 prefixlen 64 scopeid 0xc
    nd6 options=21<PERFORMNUD,AUTO_LINKLOCAL>

      and it works fine.

      The second ISP I have here doesn't support multilink and then it ends up with the same sympthon when have MTU as 1492

       

  • Eugene Grosbein

    Eugene Grosbein - 2018-08-03

    I have re-implemented solution for the bug #62 in a way that changes default behaviour of mpd5 back to previous and requires special configuration for that case. I'm currently testing the patch and going to publish it this weekend. It will be in the mpd5-5.8_7.

     

    • Renato Botelho

      Renato Botelho - 2018-08-03

      This new patch works as expected here. My connection ended up with MTU 1480 as before. Thank you very much!

       

      • Eugene Grosbein

        Eugene Grosbein - 2018-08-04

        mpd5-5.8_7 containing the fix committed to FreeBSD Ports collection.

         

  • Eugene Grosbein

    Eugene Grosbein - 2018-08-04
    • status: open --> closed-fixed
    • assigned_to: Eugene Grosbein
     
<< < 1 2 (Page 2 of 2)

Log in to post a comment.

MongoDB Logo MongoDB