Pppoe dials took 5 minutes

Mon Aug 21 10:11:59 2017 daemon.notice netifd: Network device 'pppoe-wan' link is up
Mon Aug 21 10:11:59 2017 daemon.notice netifd: Interface 'wan' is now up
Mon Aug 21 10:11:59 2017 daemon.info dnsmasq[32409]: reading /tmp/resolv.conf.auto
Mon Aug 21 10:11:59 2017 daemon.info dnsmasq[32409]: using local addresses only for domain test
Mon Aug 21 10:11:59 2017 daemon.info dnsmasq[32409]: using local addresses only for domain onion
Mon Aug 21 10:11:59 2017 daemon.info dnsmasq[32409]: using local addresses only for domain localhost
Mon Aug 21 10:11:59 2017 daemon.info dnsmasq[32409]: using local addresses only for domain local
Mon Aug 21 10:11:59 2017 daemon.info dnsmasq[32409]: using local addresses only for domain invalid
Mon Aug 21 10:11:59 2017 daemon.info dnsmasq[32409]: using local addresses only for domain example.net
Mon Aug 21 10:11:59 2017 daemon.info dnsmasq[32409]: using local addresses only for domain example.org
Mon Aug 21 10:11:59 2017 daemon.info dnsmasq[32409]: using local addresses only for domain example.com
Mon Aug 21 10:11:59 2017 daemon.info dnsmasq[32409]: using nameserver 202.102.154.3#53
Mon Aug 21 10:11:59 2017 daemon.info dnsmasq[32409]: using nameserver 202.102.152.3#53
Mon Aug 21 10:11:59 2017 daemon.info dnsmasq[32409]: using 3 more local addresses
Mon Aug 21 10:11:59 2017 user.notice firewall: Reloading firewall due to ifup of wan (pppoe-wan)
Mon Aug 21 10:12:02 2017 daemon.info dnsmasq[32409]: exiting on receipt of SIGTERM
Mon Aug 21 10:12:02 2017 daemon.info dnsmasq[2928]: started, version 2.77 cachesize 150
Mon Aug 21 10:12:02 2017 daemon.info dnsmasq[2928]: DNS service limited to local subnets
Mon Aug 21 10:12:02 2017 daemon.info dnsmasq[2928]: compile time options: IPv6 GNU-getopt no-DBus no-i18n no-IDN DHCP no-DHCPv6 no-Lua TFTP no-conntrack no-ipset no-auth no-DNSSEC no-ID loop-detect inotify
Mon Aug 21 10:12:02 2017 daemon.info dnsmasq-dhcp[2928]: DHCP, IP range 192.168.1.100 -- 192.168.1.249, lease time 12h
Mon Aug 21 10:12:02 2017 daemon.info dnsmasq[2928]: using local addresses only for domain test
Mon Aug 21 10:12:02 2017 daemon.info dnsmasq[2928]: using local addresses only for domain onion
Mon Aug 21 10:12:02 2017 daemon.info dnsmasq[2928]: using local addresses only for domain localhost
Mon Aug 21 10:12:02 2017 daemon.info dnsmasq[2928]: using local addresses only for domain local
Mon Aug 21 10:12:02 2017 daemon.info dnsmasq[2928]: using local addresses only for domain invalid
Mon Aug 21 10:12:02 2017 daemon.info dnsmasq[2928]: using local addresses only for domain example.net
Mon Aug 21 10:12:02 2017 daemon.info dnsmasq[2928]: using local addresses only for domain example.org
Mon Aug 21 10:12:02 2017 daemon.info dnsmasq[2928]: using local addresses only for domain example.com
Mon Aug 21 10:12:02 2017 daemon.info dnsmasq[2928]: using 3 more local addresses
Mon Aug 21 10:12:02 2017 daemon.info dnsmasq[2928]: reading /tmp/resolv.conf.auto
Mon Aug 21 10:12:02 2017 daemon.info dnsmasq[2928]: using local addresses only for domain test
Mon Aug 21 10:12:02 2017 daemon.info dnsmasq[2928]: using local addresses only for domain onion
Mon Aug 21 10:12:02 2017 daemon.info dnsmasq[2928]: using local addresses only for domain localhost
Mon Aug 21 10:12:02 2017 daemon.info dnsmasq[2928]: using local addresses only for domain local
Mon Aug 21 10:12:02 2017 daemon.info dnsmasq[2928]: using local addresses only for domain invalid
Mon Aug 21 10:12:02 2017 daemon.info dnsmasq[2928]: using local addresses only for domain example.net
Mon Aug 21 10:12:02 2017 daemon.info dnsmasq[2928]: using local addresses only for domain example.org
Mon Aug 21 10:12:02 2017 daemon.info dnsmasq[2928]: using local addresses only for domain example.com
Mon Aug 21 10:12:02 2017 daemon.info dnsmasq[2928]: using nameserver 202.102.154.3#53
Mon Aug 21 10:12:02 2017 daemon.info dnsmasq[2928]: using nameserver 202.102.152.3#53
Mon Aug 21 10:12:02 2017 daemon.info dnsmasq[2928]: using 3 more local addresses
Mon Aug 21 10:12:02 2017 daemon.info dnsmasq[2928]: read /etc/hosts - 4 addresses
Mon Aug 21 10:12:02 2017 daemon.info dnsmasq[2928]: read /tmp/hosts/dhcp.cfg02411c - 2 addresses
Mon Aug 21 10:12:02 2017 daemon.info dnsmasq[2928]: read /tmp/hosts/odhcpd - 1 addresses
Mon Aug 21 10:12:02 2017 daemon.info dnsmasq-dhcp[2928]: read /etc/ethers - 0 addresses
Mon Aug 21 10:18:40 2017 daemon.info dnsmasq-dhcp[2928]: DHCPINFORM(br-lan) 192.168.1.151 00:25:22:53:5f:08 
Mon Aug 21 10:18:40 2017 daemon.info dnsmasq-dhcp[2928]: DHCPACK(br-lan) 192.168.1.151 00:25:22:53:5f:08 7-1t-PC


[    0.000000] Linux version 4.9.40 (john@ubuntu) (gcc version 5.4.0 (LEDE GCC 5.4.0 r4151-0dcc36f) ) #0 Sat Aug 5 07:47:41 2017
[    0.000000] Board has DDR2
[    0.000000] Analog PMU set to hw control
[    0.000000] Digital PMU set to hw control
[    0.000000] SoC Type: MediaTek MT7620A ver:2 eco:6
[    0.000000] bootconsole [early0] enabled
[    0.000000] CPU0 revision is: 00019650 (MIPS 24KEc)
[    0.000000] MIPS: machine is Phicomm PSG1218 rev.A
[    0.000000] Determined physical RAM map:
[    0.000000]  memory: 04000000 @ 00000000 (usable)
[    0.000000] Initrd not found or empty - disabling initrd
[    0.000000] Primary instruction cache 64kB, VIPT, 4-way, linesize 32 bytes.
[    0.000000] Primary data cache 32kB, 4-way, PIPT, no aliases, linesize 32 bytes
[    0.000000] Zone ranges:
[    0.000000]   Normal   [mem 0x0000000000000000-0x0000000003ffffff]
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x0000000000000000-0x0000000003ffffff]
[    0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x0000000003ffffff]
[    0.000000] On node 0 totalpages: 16384
[    0.000000] free_area_init_node: node 0, pgdat 803f8f44, node_mem_map 81000020
[    0.000000]   Normal zone: 128 pages used for memmap
[    0.000000]   Normal zone: 0 pages reserved
[    0.000000]   Normal zone: 16384 pages, LIFO batch:3
[    0.000000] pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768
[    0.000000] pcpu-alloc: [0] 0 
[    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 16256
[    0.000000] Kernel command line: console=ttyS0,57600 rootfstype=squashfs,jffs2
[    0.000000] PID hash table entries: 256 (order: -2, 1024 bytes)
[    0.000000] Dentry cache hash table entries: 8192 (order: 3, 32768 bytes)
[    0.000000] Inode-cache hash table entries: 4096 (order: 2, 16384 bytes)
[    0.000000] Writing ErrCtl register=000795f0
[    0.000000] Readback ErrCtl register=000795f0
[    0.000000] Memory: 60364K/65536K available (3158K kernel code, 158K rwdata, 756K rodata, 208K init, 216K bss, 5172K reserved, 0K cma-reserved)
[    0.000000] SLUB: HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
[    0.000000] NR_IRQS:256
[    0.000000] CPU Clock: 580MHz
[    0.000000] clocksource: systick: mask: 0xffff max_cycles: 0xffff, max_idle_ns: 583261500 ns
[    0.000000] systick: enable autosleep mode
[    0.000000] systick: running - mult: 214748, shift: 32
[    0.000000] clocksource: MIPS: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 6590553264 ns
[    0.000012] sched_clock: 32 bits at 290MHz, resolution 3ns, wraps every 7405115902ns
[    0.015461] Calibrating delay loop... 385.84 BogoMIPS (lpj=1929216)
[    0.080602] pid_max: default: 32768 minimum: 301
[    0.089917] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
[    0.102942] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
[    0.123547] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[    0.143027] futex hash table entries: 256 (order: -1, 3072 bytes)
[    0.155173] pinctrl core: initialized pinctrl subsystem
[    0.166163] NET: Registered protocol family 16
[    0.435611] PCI host bridge /pcie@10140000 ranges:
[    0.444998]  MEM 0x0000000020000000..0x000000002fffffff
[    0.455382]   IO 0x0000000010160000..0x000000001016ffff
[    0.478438] rt2880_gpio 10000600.gpio: registering 24 gpios
[    0.489465] rt2880_gpio 10000600.gpio: registering 24 irq handlers
[    0.502596] PCI host bridge to bus 0000:00
[    0.510596] pci_bus 0000:00: root bus resource [mem 0x20000000-0x2fffffff]
[    0.524307] pci_bus 0000:00: root bus resource [io  0xffffffff]
[    0.536040] pci_bus 0000:00: root bus resource [??? 0x00000000 flags 0x0]
[    0.549539] pci_bus 0000:00: No busn resource found for root bus, will use [bus 00-ff]
[    0.565330] pci 0000:00:00.0: [1814:0801] type 01 class 0x060400
[    0.565364] pci 0000:00:00.0: reg 0x10: [mem 0x00000000-0x7fffffff]
[    0.565380] pci 0000:00:00.0: reg 0x14: [mem 0x20200000-0x2020ffff]
[    0.565456] pci 0000:00:00.0: supports D1
[    0.565468] pci 0000:00:00.0: PME# supported from D0 D1 D3hot
[    0.565915] pci 0000:01:00.0: [14c3:7662] type 00 class 0x028000
[    0.565965] pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x000fffff 64bit]
[    0.566019] pci 0000:01:00.0: reg 0x30: [mem 0x00000000-0x0000ffff pref]
[    0.566117] pci 0000:01:00.0: PME# supported from D0 D3hot D3cold
[    0.566366] pci_bus 0000:01: busn_res: [bus 01-ff] end is updated to 01
[    0.566386] pci_bus 0000:00: busn_res: [bus 00-ff] end is updated to 01
[    0.566437] pci 0000:00:00.0: BAR 0: no space for [mem size 0x80000000]
[    0.579488] pci 0000:00:00.0: BAR 0: failed to assign [mem size 0x80000000]
[    0.593303] pci 0000:00:00.0: BAR 8: assigned [mem 0x20000000-0x200fffff]
[    0.606805] pci 0000:00:00.0: BAR 9: assigned [mem 0x20100000-0x201fffff pref]
[    0.621170] pci 0000:00:00.0: BAR 1: assigned [mem 0x20200000-0x2020ffff]
[    0.634679] pci 0000:01:00.0: BAR 0: assigned [mem 0x20000000-0x200fffff 64bit]
[    0.649227] pci 0000:01:00.0: BAR 6: assigned [mem 0x20100000-0x2010ffff pref]
[    0.663570] pci 0000:00:00.0: PCI bridge to [bus 01]
[    0.673428] pci 0000:00:00.0:   bridge window [mem 0x20000000-0x200fffff]
[    0.686936] pci 0000:00:00.0:   bridge window [mem 0x20100000-0x201fffff pref]
[    0.701316] pci 0000:00:00.0: card - bus=0x0, slot = 0x0 irq=0
[    0.712899] pci 0000:01:00.0: card - bus=0x1, slot = 0x0 irq=4
[    0.727570] clocksource: Switched to clocksource systick
[    0.739337] NET: Registered protocol family 2
[    0.748839] TCP established hash table entries: 1024 (order: 0, 4096 bytes)
[    0.762615] TCP bind hash table entries: 1024 (order: 0, 4096 bytes)
[    0.775201] TCP: Hash tables configured (established 1024 bind 1024)
[    0.787933] UDP hash table entries: 256 (order: 0, 4096 bytes)
[    0.799459] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes)
[    0.812147] NET: Registered protocol family 1
[    0.820775] PCI: CLS 80 bytes, default 32
[    0.822981] rt-timer 10000100.timer: maximum frequency is 1220Hz
[    0.835701] Crashlog allocated RAM at address 0x3f00000
[    0.847111] workingset: timestamp_bits=30 max_order=14 bucket_order=0
[    0.868138] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[    0.879624] jffs2: version 2.2 (NAND) (SUMMARY) (LZMA) (RTIME) (CMODE_PRIORITY) (c) 2001-2006 Red Hat, Inc.
[    0.907428] io scheduler noop registered
[    0.915129] io scheduler deadline registered (default)
[    0.925588] ralink-usb-phy usbphy: invalid resource
[    0.935783] Serial: 8250/16550 driver, 2 ports, IRQ sharing disabled
[    0.949430] console [ttyS0] disabled
[    0.956421] 10000c00.uartlite: ttyS0 at MMIO 0x10000c00 (irq = 20, base_baud = 2500000) is a Palmchip BK-3103
[    0.976196] console [ttyS0] enabled
[    0.989966] bootconsole [early0] disabled
[    1.010073] spi spi0.0: force spi mode3
[    1.018549] m25p80 spi0.0: s25fl064k (8192 Kbytes)
[    1.028186] 4 ofpart partitions found on MTD device spi0.0
[    1.039117] Creating 4 MTD partitions on "spi0.0":
[    1.048673] 0x000000000000-0x000000030000 : "u-boot"
[    1.060236] 0x000000030000-0x000000040000 : "u-boot-env"
[    1.072713] 0x000000040000-0x000000050000 : "factory"
[    1.084658] 0x000000050000-0x000000800000 : "firmware"
[    1.766304] 2 uimage-fw partitions found on MTD device firmware
[    1.778146] 0x000000050000-0x00000019ba66 : "kernel"
[    1.789689] 0x00000019ba66-0x000000800000 : "rootfs"
[    1.801426] mtd: device 5 (rootfs) set to be root filesystem
[    1.813326] 1 squashfs-split partitions found on MTD device rootfs
[    1.825713] 0x0000003d6000-0x000000800000 : "rootfs_data"
[    1.838807] libphy: Fixed MDIO Bus: probed
[    1.850556] gsw: setting port4 to ephy mode
[    1.858964] mtk_soc_eth 10100000.ethernet eth0 (uninitialized): port 1 link up (100Mbps/Full duplex)
[    1.877162] mtk_soc_eth 10100000.ethernet eth0 (uninitialized): port 4 link up (100Mbps/Full duplex)
[    1.895592] mtk_soc_eth 10100000.ethernet: loaded mt7620 driver
[    1.908264] mtk_soc_eth 10100000.ethernet eth0: mediatek frame engine at 0xb0100000, irq 5
[    1.925308] rt2880_wdt 10000120.watchdog: Initialized
[    1.936539] NET: Registered protocol family 10
[    1.948509] NET: Registered protocol family 17
[    1.957413] 8021q: 802.1Q VLAN Support v1.8
[    1.980285] VFS: Mounted root (squashfs filesystem) readonly on device 31:5.
[    1.995508] Freeing unused kernel memory: 208K (803fc000 - 80430000)
[    2.008195] This architecture does not have kernel memory protection.
[    2.737527] random: fast init done
[    3.673636] init: Console is alive
[    3.680728] init: - watchdog -
[    4.930497] kmodloader: loading kernel modules from /etc/modules-boot.d/*
[    5.196873] kmodloader: done loading kernel modules from /etc/modules-boot.d/*
[    5.215400] init: - preinit -
[    7.045761] 8021q: adding VLAN 0 to HW filter on device eth0
[    8.691389] jffs2: notice: (317) jffs2_build_xattr_subsystem: complete building xattr subsystem, 0 of xdatum (0 unchecked, 0 orphan) and 0 of xref (0 dead, 0 orphan) found.
[    8.725634] mount_root: switching to jffs2 overlay
[    8.771823] urandom-seed: Seeding with /etc/urandom.seed
[    8.833167] procd: - early -
[    8.840406] procd: - watchdog -
[    9.370209] procd: - watchdog -
[    9.376738] procd: - ubus -
[    9.523148] procd: - init -
[    9.990629] kmodloader: loading kernel modules from /etc/modules.d/*
[   10.009493] ip6_tables: (C) 2000-2006 Netfilter Core Team
[   10.031854] Loading modules backported from Linux version wt-2017-01-31-0-ge882dff19e7f
[   10.047876] Backport generated by backports.git backports-20160324-13-g24da7d3c
[   10.114696] mt76x2e 0000:01:00.0: ASIC revision: 76120044
[   10.133170] mt76x2e 0000:01:00.0: ROM patch already applied
[   10.243182] mt76x2e 0000:01:00.0: Firmware Version: 0.0.00
[   10.254175] mt76x2e 0000:01:00.0: Build: 1
[   10.262327] mt76x2e 0000:01:00.0: Build Time: 201507311614____
[   10.294700] mt76x2e 0000:01:00.0: Firmware running!
[   10.305318] ieee80211 phy0: Selected rate control algorithm 'minstrel_ht'
[   10.388185] ip_tables: (C) 2000-2006 Netfilter Core Team
[   10.410693] nf_conntrack version 0.5.0 (1024 buckets, 4096 max)
[   10.587935] xt_time: kernel timezone is -0000
[   10.609140] PPP generic driver version 2.4.2
[   10.623736] NET: Registered protocol family 24
[   10.676121] rt2800_wmac 10180000.wmac: loaded eeprom from mtd device "factory"
[   10.690559] ieee80211 phy1: rt2x00_set_rt: Info - RT chipset 6352, rev 0500 detected
[   10.706023] ieee80211 phy1: rt2x00_set_rf: Info - RF chipset 7620 detected
[   10.720460] ieee80211 phy1: Selected rate control algorithm 'minstrel_ht'
[   10.781575] kmodloader: done loading kernel modules from /etc/modules.d/*
[   19.393862] 8021q: adding VLAN 0 to HW filter on device eth0
[   19.430300] br-lan: port 1(eth0.1) entered blocking state
[   19.441330] br-lan: port 1(eth0.1) entered disabled state
[   19.452569] device eth0.1 entered promiscuous mode
[   19.462155] device eth0 entered promiscuous mode
[   19.529480] br-lan: port 1(eth0.1) entered blocking state
[   19.540315] br-lan: port 1(eth0.1) entered forwarding state
[   21.667205] pppoe-wan: renamed from ppp0
[   24.338816] ieee80211 phy1: rt2800_config_channel: Warning - Using incomplete support for external PA
[   24.363800] IPv6: ADDRCONF(NETDEV_UP): wlan1: link is not ready
[   24.519552] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
[   24.531961] br-lan: port 2(wlan1) entered blocking state
[   24.542630] br-lan: port 2(wlan1) entered disabled state
[   24.553699] device wlan1 entered promiscuous mode
[   24.595005] br-lan: port 3(wlan0) entered blocking state
[   24.605671] br-lan: port 3(wlan0) entered disabled state
[   24.616774] device wlan0 entered promiscuous mode
[   24.626294] br-lan: port 3(wlan0) entered blocking state
[   24.636906] br-lan: port 3(wlan0) entered forwarding state
[   25.145341] br-lan: port 3(wlan0) entered disabled state
[   25.327861] pppoe-wan: renamed from ppp0
[   25.965149] ieee80211 phy1: rt2800_config_channel: Warning - Using incomplete support for external PA
[   26.012442] IPv6: ADDRCONF(NETDEV_CHANGE): wlan1: link becomes ready
[   26.025386] br-lan: port 2(wlan1) entered blocking state
[   26.035999] br-lan: port 2(wlan1) entered forwarding state
[   26.759798] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
[   26.772705] br-lan: port 3(wlan0) entered blocking state
[   26.783333] br-lan: port 3(wlan0) entered forwarding state
[   28.565619] pppoe-wan: renamed from ppp0
[   44.644782] random: crng init done
[  192.353893] pppoe-wan: renamed from ppp0
[ 6881.130625] mtk_soc_eth 10100000.ethernet eth0: port 1 link down
[ 6881.689148] mtk_soc_eth 10100000.ethernet eth0: port 1 link up (100Mbps/Full duplex)
[ 6881.911695] mtk_soc_eth 10100000.ethernet eth0: port 1 link down
[ 8878.330677] pppoe-wan: renamed from ppp0
[16103.663772] pppoe-wan: renamed from ppp0
[18117.915982] mtk_soc_eth 10100000.ethernet eth0: port 1 link up (100Mbps/Full duplex)
[18126.326609] mtk_soc_eth 10100000.ethernet eth0: port 1 link down
[18127.029190] mtk_soc_eth 10100000.ethernet eth0: port 1 link up (100Mbps/Full duplex)
[19289.744195] pppoe-wan: renamed from ppp0
[19290.192398] pppoe-wan: renamed from ppp0
[19290.639099] pppoe-wan: renamed from ppp0
[19439.284970] pppoe-wan: renamed from ppp0
[19491.620015] pppoe-wan: renamed from ppp0
[19494.297871] pppoe-wan: renamed from ppp0
[19496.424473] pppoe-wan: renamed from ppp0
[19625.015882] pppoe-wan: renamed from ppp0
  1. Your first log shows the message after the WAN interface becomes UP; then there is a DCHP request from a client in the LAN; there is no way we can know what is happening there.
  2. Your second log does not contain any useful information, either.
  3. Without seeing your config files, it is even harder to know what is going on.

HI, updating from 17.01.4 to 18.06 RC1 also I have the same problem with the DIR-860L and Xiaomi 3G.

Sun Jun 24 22:36:37 2018 daemon.notice netifd: Interface 'wan' is now down
Sun Jun 24 22:36:37 2018 daemon.notice netifd: Interface 'wan' is setting up now
Sun Jun 24 22:36:38 2018 daemon.err insmod: module is already loaded - slhc
Sun Jun 24 22:36:38 2018 daemon.err insmod: module is already loaded - ppp_generic
Sun Jun 24 22:36:38 2018 daemon.err insmod: module is already loaded - pppox
Sun Jun 24 22:36:38 2018 daemon.err insmod: module is already loaded - pppoe
Sun Jun 24 22:36:38 2018 daemon.info dnsmasq[3452]: read /etc/hosts - 4 addresses
Sun Jun 24 22:36:38 2018 daemon.info dnsmasq[3452]: read /tmp/hosts/odhcpd - 1 addresses
Sun Jun 24 22:36:38 2018 daemon.info dnsmasq[3452]: read /tmp/hosts/dhcp.cfg01411c - 3 addresses
Sun Jun 24 22:36:38 2018 daemon.info dnsmasq-dhcp[3452]: read /etc/ethers - 0 addresses
Sun Jun 24 22:36:38 2018 daemon.info pppd[6291]: Plugin rp-pppoe.so loaded.
Sun Jun 24 22:36:38 2018 daemon.info pppd[6291]: RP-PPPoE plugin version 3.8p compiled against pppd 2.4.7
Sun Jun 24 22:36:38 2018 daemon.notice pppd[6291]: pppd 2.4.7 started by root, uid 0
Sun Jun 24 22:36:53 2018 daemon.warn pppd[6291]: Timeout waiting for PADO packets
Sun Jun 24 22:36:53 2018 daemon.err pppd[6291]: Unable to complete PPPoE Discovery
Sun Jun 24 22:36:53 2018 daemon.info pppd[6291]: Exit.
Sun Jun 24 22:36:53 2018 daemon.notice netifd: Interface 'wan' is now down
Sun Jun 24 22:36:53 2018 daemon.notice netifd: Interface 'wan' is setting up now
Sun Jun 24 22:36:53 2018 daemon.err insmod: module is already loaded - slhc
Sun Jun 24 22:36:53 2018 daemon.err insmod: module is already loaded - ppp_generic
Sun Jun 24 22:36:53 2018 daemon.err insmod: module is already loaded - pppox
Sun Jun 24 22:36:53 2018 daemon.err insmod: module is already loaded - pppoe
Sun Jun 24 22:36:53 2018 daemon.info pppd[6494]: Plugin rp-pppoe.so loaded.
Sun Jun 24 22:36:53 2018 daemon.info pppd[6494]: RP-PPPoE plugin version 3.8p compiled against pppd 2.4.7
Sun Jun 24 22:36:53 2018 daemon.notice pppd[6494]: pppd 2.4.7 started by root, uid 0
Sun Jun 24 22:37:08 2018 daemon.warn pppd[6494]: Timeout waiting for PADO packets
Sun Jun 24 22:37:08 2018 daemon.err pppd[6494]: Unable to complete PPPoE Discovery
Sun Jun 24 22:37:08 2018 daemon.info pppd[6494]: Exit.
Sun Jun 24 22:37:08 2018 daemon.notice netifd: Interface 'wan' is now down
Sun Jun 24 22:37:08 2018 daemon.notice netifd: Interface 'wan' is setting up now
Sun Jun 24 22:37:08 2018 daemon.err insmod: module is already loaded - slhc
Sun Jun 24 22:37:08 2018 daemon.err insmod: module is already loaded - ppp_generic
Sun Jun 24 22:37:08 2018 daemon.err insmod: module is already loaded - pppox
Sun Jun 24 22:37:08 2018 daemon.err insmod: module is already loaded - pppoe
Sun Jun 24 22:37:09 2018 daemon.info pppd[6666]: Plugin rp-pppoe.so loaded.
Sun Jun 24 22:37:09 2018 daemon.info pppd[6666]: RP-PPPoE plugin version 3.8p compiled against pppd 2.4.7
Sun Jun 24 22:37:09 2018 daemon.notice pppd[6666]: pppd 2.4.7 started by root, uid 0
Sun Jun 24 22:37:24 2018 daemon.warn pppd[6666]: Timeout waiting for PADO packets
Sun Jun 24 22:37:24 2018 daemon.err pppd[6666]: Unable to complete PPPoE Discovery
Sun Jun 24 22:37:24 2018 daemon.info pppd[6666]: Exit.
Sun Jun 24 22:37:24 2018 daemon.notice netifd: Interface 'wan' is now down
Sun Jun 24 22:37:24 2018 daemon.notice netifd: Interface 'wan' is setting up now
Sun Jun 24 22:37:24 2018 daemon.err insmod: module is already loaded - slhc
Sun Jun 24 22:37:24 2018 daemon.err insmod: module is already loaded - ppp_generic
Sun Jun 24 22:37:24 2018 daemon.err insmod: module is already loaded - pppox
Sun Jun 24 22:37:24 2018 daemon.err insmod: module is already loaded - pppoe
Sun Jun 24 22:37:24 2018 daemon.info pppd[6799]: Plugin rp-pppoe.so loaded.
Sun Jun 24 22:37:24 2018 daemon.info pppd[6799]: RP-PPPoE plugin version 3.8p compiled against pppd 2.4.7
Sun Jun 24 22:37:24 2018 daemon.notice pppd[6799]: pppd 2.4.7 started by root, uid 0
Sun Jun 24 22:37:39 2018 daemon.warn pppd[6799]: Timeout waiting for PADO packets
Sun Jun 24 22:37:39 2018 daemon.err pppd[6799]: Unable to complete PPPoE Discovery
Sun Jun 24 22:37:39 2018 daemon.info pppd[6799]: Exit.
Sun Jun 24 22:37:39 2018 daemon.notice netifd: Interface 'wan' is now down
Sun Jun 24 22:37:39 2018 daemon.notice netifd: Interface 'wan' is setting up now
Sun Jun 24 22:37:39 2018 daemon.err insmod: module is already loaded - slhc
Sun Jun 24 22:37:39 2018 daemon.err insmod: module is already loaded - ppp_generic
Sun Jun 24 22:37:39 2018 daemon.err insmod: module is already loaded - pppox
Sun Jun 24 22:37:39 2018 daemon.err insmod: module is already loaded - pppoe
Sun Jun 24 22:37:39 2018 daemon.info pppd[6909]: Plugin rp-pppoe.so loaded.
Sun Jun 24 22:37:39 2018 daemon.info pppd[6909]: RP-PPPoE plugin version 3.8p compiled against pppd 2.4.7
Sun Jun 24 22:37:40 2018 daemon.notice pppd[6909]: pppd 2.4.7 started by root, uid 0
Sun Jun 24 22:37:55 2018 daemon.warn pppd[6909]: Timeout waiting for PADO packets
Sun Jun 24 22:37:55 2018 daemon.err pppd[6909]: Unable to complete PPPoE Discovery
Sun Jun 24 22:37:55 2018 daemon.info pppd[6909]: Exit.
Sun Jun 24 22:37:55 2018 daemon.notice netifd: Interface 'wan' is now down
Sun Jun 24 22:37:55 2018 daemon.notice netifd: Interface 'wan' is setting up now
Sun Jun 24 22:37:55 2018 daemon.err insmod: module is already loaded - slhc
Sun Jun 24 22:37:55 2018 daemon.err insmod: module is already loaded - ppp_generic
Sun Jun 24 22:37:55 2018 daemon.err insmod: module is already loaded - pppox
Sun Jun 24 22:37:55 2018 daemon.err insmod: module is already loaded - pppoe
Sun Jun 24 22:37:55 2018 daemon.info pppd[7086]: Plugin rp-pppoe.so loaded.
Sun Jun 24 22:37:55 2018 daemon.info pppd[7086]: RP-PPPoE plugin version 3.8p compiled against pppd 2.4.7
Sun Jun 24 22:37:55 2018 daemon.notice pppd[7086]: pppd 2.4.7 started by root, uid 0
Sun Jun 24 22:38:00 2018 daemon.info pppd[7086]: PPP session is 26266
Sun Jun 24 22:38:00 2018 daemon.warn pppd[7086]: Connected to 08:96:ad:6b:74:d0 via interface eth0.2
Sun Jun 24 22:38:00 2018 kern.info kernel: [  353.525389] pppoe-wan: renamed from ppp0
Sun Jun 24 22:38:00 2018 daemon.info pppd[7086]: Using interface pppoe-wan
Sun Jun 24 22:38:00 2018 daemon.notice pppd[7086]: Connect: pppoe-wan <--> eth0.2
Sun Jun 24 22:38:03 2018 daemon.info pppd[7086]: CHAP authentication succeeded
Sun Jun 24 22:38:03 2018 daemon.notice pppd[7086]: CHAP authentication succeeded
Sun Jun 24 22:38:03 2018 daemon.notice pppd[7086]: peer from calling number 08:96:AD:6B:74:D0 authorized
Sun Jun 24 22:38:03 2018 daemon.notice pppd[7086]: local  IP address 94.35.xxx.xxx
Sun Jun 24 22:38:03 2018 daemon.notice pppd[7086]: remote IP address 94.32.xxx.xxx
Sun Jun 24 22:38:03 2018 daemon.notice pppd[7086]: primary   DNS address 213.205.32.70
Sun Jun 24 22:38:03 2018 daemon.notice pppd[7086]: secondary DNS address 213.205.36.70
Sun Jun 24 22:38:04 2018 daemon.notice netifd: Network device 'pppoe-wan' link is up
Sun Jun 24 22:38:04 2018 daemon.notice netifd: Interface 'wan' is now up

Does anyone have the same problem with 18.06 RC1?

I am running 18.06RC1 on my dir-860l and pppoe connects just fine for me.

Does the router connect immediately after restart?
I have this problem with 2 DIR-860L and Xiaomi 3G, all routers use different modem and DSL line.

root@OpenWrt:~# opkg list
base-files - 190-r7102-3f3a2c9
block-mount - 2018-04-16-e2436836-1
busybox - 1.28.3-4
chat - 2.4.7-12
comgt - 0.32-30
ddns-scripts - 2.7.7-6
dnsmasq - 2.80test2-3
dropbear - 2017.75-5
firewall - 2018-05-14-b45e162e-1
fstools - 2018-04-16-e2436836-1
fwtool - 1
hd-idle - 1.05-1
hostapd-common - 2018-04-09-fa617ee6-5
ip6tables - 1.6.2-1
iptables - 1.6.2-1
iptables-mod-conntrack-extra - 1.6.2-1
iptables-mod-ipopt - 1.6.2-1
iw - 4.14-1
jshn - 2018-04-12-6eff829d-1
jsonfilter - 2018-02-04-c7e938d6-1
kernel - 4.14.50-1-2071d82307d5f3d726fb88c15048cc15
kmod-cfg80211 - 4.14.50+2017-11-01-9
kmod-crypto-aead - 4.14.50-1
kmod-crypto-crc32c - 4.14.50-1
kmod-crypto-ecb - 4.14.50-1
kmod-crypto-hash - 4.14.50-1
kmod-crypto-manager - 4.14.50-1
kmod-crypto-null - 4.14.50-1
kmod-crypto-pcompress - 4.14.50-1
kmod-crypto-sha1 - 4.14.50-1
kmod-fs-exfat - 4.14.50+2017-06-20-de4c760b-1
kmod-fs-ext4 - 4.14.50-1
kmod-fs-vfat - 4.14.50-1
kmod-gpio-button-hotplug - 4.14.50-2
kmod-gre - 4.14.50-1
kmod-ifb - 4.14.50-1
kmod-ip6tables - 4.14.50-1
kmod-ipt-conntrack - 4.14.50-1
kmod-ipt-conntrack-extra - 4.14.50-1
kmod-ipt-core - 4.14.50-1
kmod-ipt-ipopt - 4.14.50-1
kmod-ipt-nat - 4.14.50-1
kmod-ipt-offload - 4.14.50-1
kmod-iptunnel - 4.14.50-1
kmod-leds-gpio - 4.14.50-1
kmod-lib-crc-ccitt - 4.14.50-1
kmod-lib-crc16 - 4.14.50-1
kmod-mac80211 - 4.14.50+2017-11-01-9
kmod-mii - 4.14.50-1
kmod-mppe - 4.14.50-1
kmod-mt76-core - 4.14.50+2018-06-19-1d4ca10a-1
kmod-mt76x2 - 4.14.50+2018-06-19-1d4ca10a-1
kmod-nf-conntrack - 4.14.50-1
kmod-nf-conntrack6 - 4.14.50-1
kmod-nf-flow - 4.14.50-1
kmod-nf-ipt - 4.14.50-1
kmod-nf-ipt6 - 4.14.50-1
kmod-nf-nat - 4.14.50-1
kmod-nf-reject - 4.14.50-1
kmod-nf-reject6 - 4.14.50-1
kmod-nls-base - 4.14.50-1
kmod-nls-cp437 - 4.14.50-1
kmod-nls-iso8859-1 - 4.14.50-1
kmod-nls-utf8 - 4.14.50-1
kmod-ppp - 4.14.50-1
kmod-pppoe - 4.14.50-1
kmod-pppox - 4.14.50-1
kmod-sched-cake - 4.14.50+2018-05-15-779e91a9-1
kmod-sched-core - 4.14.50-1
kmod-scsi-core - 4.14.50-1
kmod-slhc - 4.14.50-1
kmod-tun - 4.14.50-1
kmod-usb-core - 4.14.50-1
kmod-usb-ledtrig-usbport - 4.14.50-1
kmod-usb-net - 4.14.50-1
kmod-usb-net-cdc-ether - 4.14.50-1
kmod-usb-net-cdc-ncm - 4.14.50-1
kmod-usb-net-huawei-cdc-ncm - 4.14.50-1
kmod-usb-printer - 4.14.50-1
kmod-usb-serial - 4.14.50-1
kmod-usb-serial-option - 4.14.50-1
kmod-usb-serial-wwan - 4.14.50-1
kmod-usb-storage - 4.14.50-1
kmod-usb-storage-extras - 4.14.50-1
kmod-usb-storage-uas - 4.14.50-1
kmod-usb-wdm - 4.14.50-1
kmod-usb3 - 4.14.50-1
libblobmsg-json - 2018-04-12-6eff829d-1
libbz2 - 1.0.6-3
libc - 1.1.19-1
libexif - 0.6.21-1
libffmpeg-mini - 3.2.10-3
libflac - 1.3.2-1
libgcc - 7.3.0-1
libid3tag - 0.15.1b-4
libip4tc - 1.6.2-1
libip6tc - 1.6.2-1
libiwinfo - 2018-02-15-223e09bf-1
libiwinfo-lua - 2018-02-15-223e09bf-1
libjpeg - 9a-1
libjson-c - 0.12.1-1
libjson-script - 2018-04-12-6eff829d-1
liblua - 5.1.5-1
liblucihttp - 2018-04-22-ccc685e5-1
liblucihttp-lua - 2018-04-22-ccc685e5-1
liblzo - 2.10-1
libnl-tiny - 0.1-5
libogg - 1.3.2-2
libopenssl - 1.0.2o-1
libpthread - 1.1.19-1
librt - 1.1.19-1
libsqlite3 - 3230100-1
libubox - 2018-04-12-6eff829d-1
libubus - 2018-01-16-5bae22eb-1
libubus-lua - 2018-01-16-5bae22eb-1
libuci - 2018-03-24-5d2bf09e-1
libuclient - 2017-11-02-4b87d831-1
libusb-1.0 - 1.0.22-1
libuuid - 2.32-2
libvorbis - 1.3.6-1
libxtables - 1.6.2-1
logd - 2018-02-14-128bc35f-2
lua - 5.1.5-1
luci - git-18.163.60998-c379f00-1
luci-app-ddns - 2.4.9-3
luci-app-firewall - git-18.163.60998-c379f00-1
luci-app-hd-idle - git-18.163.60998-c379f00-1
luci-app-minidlna - git-18.163.60998-c379f00-1
luci-app-openvpn - git-18.163.60998-c379f00-1
luci-app-p910nd - git-18.163.60998-c379f00-1
luci-app-samba - git-18.163.60998-c379f00-1
luci-app-sqm - 1.2.3-1
luci-app-upnp - git-18.163.60998-c379f00-1
luci-app-wifischedule - git-18.163.60998-c379f00-1
luci-base - git-18.163.60998-c379f00-1
luci-lib-ip - git-18.163.60998-c379f00-1
luci-lib-jsonc - git-18.163.60998-c379f00-1
luci-lib-nixio - git-18.163.60998-c379f00-1
luci-mod-admin-full - git-18.163.60998-c379f00-1
luci-proto-3g - git-18.163.60998-c379f00-1
luci-proto-ipv6 - git-18.163.60998-c379f00-1
luci-proto-ppp - git-18.163.60998-c379f00-1
luci-proto-relay - git-18.163.60998-c379f00-1
luci-theme-bootstrap - git-18.163.60998-c379f00-1
minidlna - 1.2.1-3
miniupnpd - 2.1-1
mtd - 21
netifd - 2018-05-30-a580028d-1
odhcp6c - 2018-04-29-5316d7f8-12
odhcpd-ipv6only - 1.7-1
openssl-util - 1.0.2o-1
openvpn-easy-rsa - 3.0.1-1
openvpn-openssl - 2.4.5-3
openwrt-keyring - 2018-05-18-103a32e9-1
opkg - 2017-12-07-3b417b9f-2
p910nd - 0.97-5
ppp - 2.4.7-12
ppp-mod-pppoe - 2.4.7-12
pptpd - 1.4.0-3
procd - 2018-03-28-dfb68f85-1
relayd - 2016-02-07-ad0b25ad-2
rpcd - 2018-05-13-82062195-1
rpcd-mod-rrdns - 20170710
samba36-server - 3.6.25-10
sqm-scripts - 1.2.3-1
swconfig - 11
tc - 4.16.0-3
ubi-utils - 2.0.2-1
ubox - 2018-02-14-128bc35f-2
ubus - 2018-01-16-5bae22eb-1
ubusd - 2018-01-16-5bae22eb-1
uci - 2018-03-24-5d2bf09e-1
uclient-fetch - 2017-11-02-4b87d831-1
uhttpd - 2017-11-04-a235636a-1
uhttpd-mod-ubus - 2017-11-04-a235636a-1
usb-modeswitch - 2017-12-19-f40f84c2-1
usign - 2015-07-04-ef641914-1
wifischedule - 1-2
wireless-regdb - 2017-10-20-4343d359
wpad-mini - 2018-04-09-fa617ee6-5
zlib - 1.2.11-2
root@OpenWrt:~#

Yep it does for me.

Have you checked with your ISP? Some ISPs will enforce a "cool-down" period after a PPPoE connection tear-down. So maybe they simply force you to wait say 5 minutes? One rationale for that might be that their end might be configured to wait a considerable amount of time for further LCP packets on the pppoe link to not confuse a transient outage with a full tear-down.

Looks like a sysupgrade going awry somewhere.
Did you preserve settings while upgrading? I would flash a factory image and set everything up again to see if that fixes the problem.