Netgate Discussion Forum
    • Categories
    • Recent
    • Tags
    • Popular
    • Users
    • Search
    • Register
    • Login

    PPPoE client failing to parse PADO replies

    General pfSense Questions
    2
    2
    469
    Loading More Posts
    • Oldest to Newest
    • Newest to Oldest
    • Most Votes
    Reply
    • Reply as topic
    Log in to reply
    This topic has been deleted. Only users with topic management privileges can see it.
    • H
      Hoji
      last edited by

      It appears that for some reason the PPPoE client in pfSense can fail to connect in some circimstances. The remote access concentrator replies to the discovery initiation but this doesn't make it up to the PPP client which doesn't see the AC-name and then sends another PADI. I've been seeing this problem for some years now and it doesn't appear to be specific to pfSense hardware, ADSL / VDSL bridge hardware or ISP.

      This experiment was done on a freshly installed pfsense 2.4.1 box with a completely stock configuration save the PPPoE WAN settings.

      Here's a PPP log:

      Apr 22 00:56:50 	ppp 		[wan_link0] PPPoE: Connecting to ''
Apr 22 00:56:50 	ppp 		[wan_link0] Link: reconnection attempt 3
Apr 22 00:56:46 	ppp 		[wan_link0] Link: reconnection attempt 3 in 4 seconds
Apr 22 00:56:46 	ppp 		[wan_link0] LCP: Down event
Apr 22 00:56:46 	ppp 		[wan_link0] Link: DOWN event
Apr 22 00:56:46 	ppp 		[wan_link0] PPPoE connection timeout after 9 seconds
Apr 22 00:56:37 	ppp 		[wan_link0] PPPoE: Connecting to ''
Apr 22 00:56:37 	ppp 		[wan_link0] Link: reconnection attempt 2
Apr 22 00:56:33 	ppp 		[wan_link0] Link: reconnection attempt 2 in 4 seconds
Apr 22 00:56:33 	ppp 		[wan_link0] LCP: Down event
Apr 22 00:56:33 	ppp 		[wan_link0] Link: DOWN event
Apr 22 00:56:33 	ppp 		[wan_link0] PPPoE connection timeout after 9 seconds
Apr 22 00:56:24 	ppp 		[wan_link0] PPPoE: Connecting to ''
Apr 22 00:56:24 	ppp 		[wan_link0] Link: reconnection attempt 1
Apr 22 00:56:22 	ppp 		[wan_link0] Link: reconnection attempt 1 in 2 seconds
Apr 22 00:56:22 	ppp 		[wan_link0] LCP: Down event

      And here's a packet capture of the interface on which PPPoE is run, showing the PADI / PADO sequence

      10:03:04.527057 PPPoE PADI [Host-Uniq 0x00AFB35000F8FFFF] [Service-Name]
10:03:04.539562 PPPoE PADO [Service-Name] [AC-Name "acc-aln1.elh"] [Host-Uniq 0x00AFB35000F8FFFF] [AC-Cookie ".'.&...(..Z'/t)Y"]
10:03:06.526946 PPPoE PADI [Host-Uniq 0x00AFB35000F8FFFF] [Service-Name]
10:03:06.539342 PPPoE PADO [Service-Name] [AC-Name "acc-aln1.elh"] [Host-Uniq 0x00AFB35000F8FFFF] [AC-Cookie ".'.&...(..Z'/t)Y"]
10:03:10.526947 PPPoE PADI [Host-Uniq 0x00AFB35000F8FFFF] [Service-Name]
10:03:10.538986 PPPoE PADO [Service-Name] [AC-Name "acc-aln1.elh"] [Host-Uniq 0x00AFB35000F8FFFF] [AC-Cookie ".'.&...(..Z'/t)Y"]
10:03:14.552063 PPPoE PADI [Host-Uniq 0x80D9141701F8FFFF] [Service-Name]
10:03:14.564778 PPPoE PADO [Service-Name] [AC-Name "acc-aln1.elh"] [Host-Uniq 0x80D9141701F8FFFF] [AC-Cookie ".'.&...(..Z'/t)Y"]
10:03:16.551947 PPPoE PADI [Host-Uniq 0x80D9141701F8FFFF] [Service-Name]
10:03:16.565033 PPPoE PADO [Service-Name] [AC-Name "acc-aln1.elh"] [Host-Uniq 0x80D9141701F8FFFF] [AC-Cookie ".'.&...(..Z'/t)Y"]
10:03:20.551949 PPPoE PADI [Host-Uniq 0x80D9141701F8FFFF] [Service-Name]
10:03:20.564840 PPPoE PADO [Service-Name] [AC-Name "acc-aln1.elh"] [Host-Uniq 0x80D9141701F8FFFF] [AC-Cookie ".'.&...(..Z'/t)Y"]
10:03:27.653003 PPPoE PADI [Host-Uniq 0x40DBB25000F8FFFF] [Service-Name]
10:03:27.665587 PPPoE PADO [Service-Name] [AC-Name "acc-aln1.elh"] [Host-Uniq 0x40DBB25000F8FFFF] [AC-Cookie ".'.&...(..Z'/t)Y"]
10:03:29.652945 PPPoE PADI [Host-Uniq 0x40DBB25000F8FFFF] [Service-Name]
10:03:29.673354 PPPoE PADO [Service-Name] [AC-Name "acc-aln1.elh"] [Host-Uniq 0x40DBB25000F8FFFF] [AC-Cookie ".'.&...(..Z'/t)Y"]
10:03:33.652947 PPPoE PADI [Host-Uniq 0x40DBB25000F8FFFF] [Service-Name]
10:03:33.665914 PPPoE PADO [Service-Name] [AC-Name "acc-aln1.elh"] [Host-Uniq 0x40DBB25000F8FFFF] [AC-Cookie ".'.&...(..Z'/t)Y"]
10:03:37.696252 PPPoE PADI [Host-Uniq 0x40DBB25000F8FFFF] [Service-Name]
10:03:37.707916 PPPoE PADO [Service-Name] [AC-Name "acc-aln1.elh"] [Host-Uniq 0x40DBB25000F8FFFF] [AC-Cookie ".'.&...(..Z'/t)Y"]
10:03:39.695928 PPPoE PADI [Host-Uniq 0x40DBB25000F8FFFF] [Service-Name]
10:03:39.708697 PPPoE PADO [Service-Name] [AC-Name "acc-aln1.elh"] [Host-Uniq 0x40DBB25000F8FFFF] [AC-Cookie ".'.&...(..Z'/t)Y"]
10:03:43.695989 PPPoE PADI [Host-Uniq 0x40DBB25000F8FFFF] [Service-Name]
10:03:43.707980 PPPoE PADO [Service-Name] [AC-Name "acc-aln1.elh"] [Host-Uniq 0x40DBB25000F8FFFF] [AC-Cookie ".'.&...(..Z'/t)Y"]
10:03:49.702238 PPPoE PADI [Host-Uniq 0x00E8141701F8FFFF] [Service-Name]
10:03:49.715166 PPPoE PADO [Service-Name] [AC-Name "acc-aln1.elh"] [Host-Uniq 0x00E8141701F8FFFF] [AC-Cookie ".'.&...(..Z'/t)Y"]
      1 Reply Last reply Reply Quote 0
      • A
        aelakkad
        last edited by

        did you resolve this? I'm having the same issue

        1 Reply Last reply Reply Quote 0
        • First post
          Last post
        Copyright 2025 Rubicon Communications LLC (Netgate). All rights reserved.