Constant PPPoE disconnection
-
I have reinstalled a fresh pfSense 2.0 RC1 x64 VM according to the following steps :-
Step 1 : Installed using pfSense-2.0-RC1-amd64-20110226-1807.iso.gz
Step 2 : Configured 2 NICs (1 for WAN, 1 for LAN)
Step 3 : Configured to not use VLAN on initial setup
Step 4 : Specified em0 for WAN and em1 for LAN
Step 5 : Configured internal IP, DHCP, and revert back to HTTP webconfig on console
Step 6 : Configured hostname, time zone on General Settings
Step 7 : Configured WAN interface to dial PPPoE connectionEverything works fine until the last step. However if I rebooted the VM, the PPPoE connection drops every 8 minutes or so. Pretty sure from the above steps that the pfSense box is at a very clean state. ???
-
Mar 29 22:27:32 php: : Resyncing OpenVPN instances for interface WAN. Mar 29 22:27:27 apinger: Starting Alarm Pinger, apinger(14843) Mar 29 22:27:27 check_reload_status: reloading filter Mar 29 22:27:26 apinger: Exiting on signal 15. Mar 29 22:27:26 php: : ROUTING: change default route to 219.93.218.177 Mar 29 22:27:25 check_reload_status: Rewriting resolv.conf Mar 29 22:27:20 check_reload_status: Rewriting resolv.conf Mar 29 22:25:38 check_reload_status: reloading filter Mar 29 22:25:28 apinger: ALARM: WAN(219.93.218.177) *** down *** Mar 29 22:17:53 php: : Resyncing OpenVPN instances for interface WAN. Mar 29 22:17:48 apinger: Starting Alarm Pinger, apinger(29535) Mar 29 22:17:48 check_reload_status: reloading filter Mar 29 22:17:47 apinger: Exiting on signal 15. Mar 29 22:17:47 php: : ROUTING: change default route to 219.93.218.177 Mar 29 22:17:46 check_reload_status: Rewriting resolv.conf Mar 29 22:17:39 check_reload_status: Rewriting resolv.conf Mar 29 22:15:57 check_reload_status: reloading filter Mar 29 22:15:47 apinger: ALARM: WAN(219.93.218.177) *** down *** Mar 29 22:08:21 syslogd: kernel boot file is /boot/kernel/kernel Mar 29 22:08:21 syslogd: exiting on signal 15 Mar 29 22:08:12 php: : Resyncing OpenVPN instances for interface WAN. Mar 29 22:08:07 apinger: Starting Alarm Pinger, apinger(31234) Mar 29 22:08:07 check_reload_status: reloading filter Mar 29 22:08:06 apinger: Exiting on signal 15. Mar 29 22:08:06 php: : ROUTING: change default route to 219.93.218.177 Mar 29 22:08:06 sshlockout[21122]: sshlockout/webConfigurator v3.0 starting up Mar 29 22:08:06 php: /index.php: Successful webConfigurator login for user 'admin' from 192.168.85.111 Mar 29 22:08:06 php: /index.php: Successful webConfigurator login for user 'admin' from 192.168.85.111 Mar 29 22:08:05 check_reload_status: Rewriting resolv.conf Mar 29 22:07:59 check_reload_status: Rewriting resolv.conf Mar 29 22:06:16 check_reload_status: reloading filter Mar 29 22:06:06 apinger: ALARM: WAN(219.93.218.177) *** down *** Mar 29 21:58:38 check_reload_status: reloading filter Mar 29 21:59:07 kernel: VMware memory control driver initialized Mar 29 21:59:07 php: : The command '/usr/local/sbin/unbound-control start' returned exit code '1', the output was '[1301407147] unbound[28839:0] error: bind: address already in use [1301407147] unbound[28839:0] fatal error: could not open ports' Mar 29 21:59:07 php: : IPSEC: One or more IPsec tunnel endpoints has changed its IP. Refreshing. Mar 29 21:59:04 php: : Resyncing OpenVPN instances for interface WAN. Mar 29 21:59:04 php: : Resyncing configuration for all packages. Mar 29 21:59:04 miniupnpd[63143]: Listening for NAT-PMP traffic on port 5351 Mar 29 21:59:04 miniupnpd[63143]: Listening for NAT-PMP traffic on port 5351 Mar 29 21:59:04 miniupnpd[63143]: HTTP listening on port 2189 Mar 29 21:59:04 miniupnpd[63143]: HTTP listening on port 2189 Mar 29 21:59:04 php: miniupnpd: Starting service on interface: lan Mar 29 21:59:04 php: : Creating rrd update script Mar 29 21:58:59 apinger: Starting Alarm Pinger, apinger(43283) Mar 29 21:58:27 check_reload_status: reloading filter Mar 29 21:58:27 check_reload_status: updating all dyndns Mar 29 21:58:27 dhcpd: For info, please visit https://www.isc.org/software/dhcp/ Mar 29 21:58:27 dhcpd: All rights reserved. Mar 29 21:58:27 dhcpd: Copyright 2004-2010 Internet Systems Consortium. Mar 29 21:58:27 dhcpd: Internet Systems Consortium DHCP Server 4.1.1-P1 Mar 29 21:58:26 php: : ROUTING: change default route to 219.93.218.177 Mar 29 21:58:26 php: : ROUTING: change default route to 219.93.218.177 Mar 29 21:58:25 apinger: No usable targets found, exiting Mar 29 21:58:25 apinger: Starting Alarm Pinger, apinger(22569) Mar 29 21:58:24 check_reload_status: Rewriting resolv.conf Mar 29 21:58:23 kernel: pflog0: promiscuous mode enabled Mar 29 21:58:23 kernel: Trying to mount root from ufs:/dev/da0s1a Mar 29 21:58:23 kernel: da0: 10240MB (20971520 512 byte sectors: 255H 63S/T 1305C) Mar 29 21:58:23 kernel: da0: Command Queueing enabled Mar 29 21:58:23 kernel: da0: 300.000MB/s transfers Mar 29 21:58:23 kernel: da0: <vmware virtual="" disk="" 1.0=""> Fixed Direct Access SCSI-2 device Mar 29 21:58:23 kernel: da0 at mpt0 bus 0 scbus0 target 0 lun 0 Mar 29 21:58:23 kernel: acd0: DVDR <vmware virtual="" ide="" cdrom="" drive="" 00000001=""> at ata1-master UDMA33 Mar 29 21:58:23 kernel: IPsec: Initialized Security Association Processing. Mar 29 21:58:23 kernel: Timecounters tick every 10.000 msec Mar 29 21:58:23 kernel: Timecounter "TSC" frequency 2832618174 Hz quality 800 Mar 29 21:58:23 kernel: acpi_throttle0: <acpi cpu="" throttling=""> on cpu0 Mar 29 21:58:23 kernel: vga0: <generic isa="" vga=""> at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa0 Mar 29 21:58:23 kernel: sc0: VGA <16 virtual consoles, flags=0x300> Mar 29 21:58:23 kernel: sc0: <system console=""> at flags 0x100 on isa0 Mar 29 21:58:23 kernel: orm0: <isa option="" roms=""> at iomem 0xc0000-0xc7fff,0xc8000-0xc8fff,0xc9000-0xc9fff,0xdc000-0xdffff,0xe0000-0xe3fff on isa0 Mar 29 21:58:23 kernel: fd0: <1440-KB 3.5" drive> on fdc0 drive 0 Mar 29 21:58:23 kernel: fdc0: [FILTER] Mar 29 21:58:23 kernel: fdc0: <floppy drive="" controller=""> port 0x3f0-0x3f5,0x3f7 irq 6 drq 2 on acpi0 Mar 29 21:58:23 kernel: uart1: [FILTER] Mar 29 21:58:23 kernel: uart1: <16550 or compatible> port 0x2f8-0x2ff irq 3 on acpi0 Mar 29 21:58:23 kernel: uart0: [FILTER] Mar 29 21:58:23 kernel: uart0: <16550 or compatible> port 0x3f8-0x3ff irq 4 flags 0x10 on acpi0 Mar 29 21:58:23 kernel: ppi0: <parallel i="" o=""> on ppbus0 Mar 29 21:58:23 kernel: lpt0: Interrupt-driven port Mar 29 21:58:23 kernel: lpt0: [ITHREAD] Mar 29 21:58:23 kernel: lpt0: <printer> on ppbus0 Mar 29 21:58:23 kernel: plip0: [ITHREAD] Mar 29 21:58:23 kernel: plip0: <plip network="" interface=""> on ppbus0 Mar 29 21:58:23 kernel: ppbus0: <parallel port="" bus=""> on ppc0 Mar 29 21:58:23 kernel: ppc0: [ITHREAD] Mar 29 21:58:23 kernel: ppc0: Generic chipset (NIBBLE-only) in COMPATIBLE mode Mar 29 21:58:23 kernel: ppc0: <parallel port=""> port 0x378-0x37f irq 7 on acpi0 Mar 29 21:58:23 kernel: psm0: model IntelliMouse, device ID 3 Mar 29 21:58:23 kernel: psm0: [ITHREAD] Mar 29 21:58:23 kernel: psm0: [GIANT-LOCKED] Mar 29 21:58:23 kernel: psm0: <ps 2="" mouse=""> irq 12 on atkbdc0 Mar 29 21:58:23 kernel: atkbd0: [ITHREAD] Mar 29 21:58:23 kernel: atkbd0: [GIANT-LOCKED] Mar 29 21:58:23 kernel: kbd0 at atkbd0 Mar 29 21:58:23 kernel: atkbd0: <at keyboard=""> irq 1 on atkbdc0 Mar 29 21:58:23 kernel: atkbdc0: <keyboard controller="" (i8042)=""> port 0x60,0x64 irq 1 on acpi0 Mar 29 21:58:23 kernel: atrtc0: <at realtime="" clock=""> port 0x70-0x71 irq 8 on acpi0 Mar 29 21:58:23 kernel: acpi_acad0: <ac adapter=""> on acpi0 Mar 29 21:58:23 kernel: pci34: <acpi pci="" bus=""> on pcib34 Mar 29 21:58:23 kernel: pcib34: <acpi pci-pci="" bridge=""> at device 24.7 on pci0 Mar 29 21:58:23 kernel: pci33: <acpi pci="" bus=""> on pcib33 Mar 29 21:58:23 kernel: pcib33: <acpi pci-pci="" bridge=""> at device 24.6 on pci0 Mar 29 21:58:23 kernel: pci32: <acpi pci="" bus=""> on pcib32 Mar 29 21:58:23 kernel: pcib32: <acpi pci-pci="" bridge=""> at device 24.5 on pci0 Mar 29 21:58:23 kernel: pci31: <acpi pci="" bus=""> on pcib31 Mar 29 21:58:23 kernel: pcib31: <acpi pci-pci="" bridge=""> at device 24.4 on pci0 Mar 29 21:58:23 kernel: pci30: <acpi pci="" bus=""> on pcib30 Mar 29 21:58:23 kernel: pcib30: <acpi pci-pci="" bridge=""> at device 24.3 on pci0 Mar 29 21:58:23 kernel: pci29: <acpi pci="" bus=""> on pcib29 Mar 29 21:58:23 kernel: pcib29: <acpi pci-pci="" bridge=""> at device 24.2 on pci0 Mar 29 21:58:23 kernel: pci28: <acpi pci="" bus=""> on pcib28 Mar 29 21:58:23 kernel: pcib28: <acpi pci-pci="" bridge=""> at device 24.1 on pci0 Mar 29 21:58:23 kernel: pci27: <acpi pci="" bus=""> on pcib27 Mar 29 21:58:23 kernel: pcib27: <acpi pci-pci="" bridge=""> at device 24.0 on pci0 Mar 29 21:58:23 kernel: pci26: <acpi pci="" bus=""> on pcib26 Mar 29 21:58:23 kernel: pcib26: <acpi pci-pci="" bridge=""> at device 23.7 on pci0 Mar 29 21:58:23 kernel: pci25: <acpi pci="" bus=""> on pcib25 Mar 29 21:58:23 kernel: pcib25: <acpi pci-pci="" bridge=""> at device 23.6 on pci0 Mar 29 21:58:23 kernel: pci24: <acpi pci="" bus=""> on pcib24 Mar 29 21:58:23 kernel: pcib24: <acpi pci-pci="" bridge=""> at device 23.5 on pci0 Mar 29 21:58:23 kernel: pci23: <acpi pci="" bus=""> on pcib23 Mar 29 21:58:23 kernel: pcib23: <acpi pci-pci="" bridge=""> at device 23.4 on pci0 Mar 29 21:58:23 kernel: pci22: <acpi pci="" bus=""> on pcib22 Mar 29 21:58:23 kernel: pcib22: <acpi pci-pci="" bridge=""> at device 23.3 on pci0 Mar 29 21:58:23 kernel: pci21: <acpi pci="" bus=""> on pcib21 Mar 29 21:58:23 kernel: pcib21: <acpi pci-pci="" bridge=""> at device 23.2 on pci0 Mar 29 21:58:23 kernel: pci20: <acpi pci="" bus=""> on pcib20 Mar 29 21:58:23 kernel: pcib20: <acpi pci-pci="" bridge=""> at device 23.1 on pci0 Mar 29 21:58:23 kernel: pci19: <acpi pci="" bus=""> on pcib19 Mar 29 21:58:23 kernel: pcib19: <acpi pci-pci="" bridge=""> at device 23.0 on pci0 Mar 29 21:58:23 kernel: pci18: <acpi pci="" bus=""> on pcib18 Mar 29 21:58:23 kernel: pcib18: <acpi pci-pci="" bridge=""> at device 22.7 on pci0 Mar 29 21:58:23 kernel: pci17: <acpi pci="" bus=""> on pcib17 Mar 29 21:58:23 kernel: pcib17: <acpi pci-pci="" bridge=""> at device 22.6 on pci0 Mar 29 21:58:23 kernel: pci16: <acpi pci="" bus=""> on pcib16 Mar 29 21:58:23 kernel: pcib16: <acpi pci-pci="" bridge=""> at device 22.5 on pci0 Mar 29 21:58:23 kernel: pci15: <acpi pci="" bus=""> on pcib15 Mar 29 21:58:23 kernel: pcib15: <acpi pci-pci="" bridge=""> at device 22.4 on pci0 Mar 29 21:58:23 kernel: pci14: <acpi pci="" bus=""> on pcib14 Mar 29 21:58:23 kernel: pcib14: <acpi pci-pci="" bridge=""> at device 22.3 on pci0 Mar 29 21:58:23 kernel: pci13: <acpi pci="" bus=""> on pcib13 Mar 29 21:58:23 kernel: pcib13: <acpi pci-pci="" bridge=""> at device 22.2 on pci0 Mar 29 21:58:23 kernel: pci12: <acpi pci="" bus=""> on pcib12 Mar 29 21:58:23 kernel: pcib12: <acpi pci-pci="" bridge=""> at device 22.1 on pci0 Mar 29 21:58:23 kernel: pci11: <acpi pci="" bus=""> on pcib11 Mar 29 21:58:23 kernel: pcib11: <acpi pci-pci="" bridge=""> at device 22.0 on pci0 Mar 29 21:58:23 kernel: pci10: <acpi pci="" bus=""> on pcib10 Mar 29 21:58:23 kernel: pcib10: <acpi pci-pci="" bridge=""> at device 21.7 on pci0 Mar 29 21:58:23 kernel: pci9: <acpi pci="" bus=""> on pcib9 Mar 29 21:58:23 kernel: pcib9: <acpi pci-pci="" bridge=""> at device 21.6 on pci0 Mar 29 21:58:23 kernel: pci8: <acpi pci="" bus=""> on pcib8 Mar 29 21:58:23 kernel: pcib8: <acpi pci-pci="" bridge=""> at device 21.5 on pci0 Mar 29 21:58:23 kernel: pci7: <acpi pci="" bus=""> on pcib7 Mar 29 21:58:23 kernel: pcib7: <acpi pci-pci="" bridge=""> at device 21.4 on pci0 Mar 29 21:58:23 kernel: pci6: <acpi pci="" bus=""> on pcib6 Mar 29 21:58:23 kernel: pcib6: <acpi pci-pci="" bridge=""> at device 21.3 on pci0 Mar 29 21:58:23 kernel: pci5: <acpi pci="" bus=""> on pcib5 Mar 29 21:58:23 kernel: pcib5: <acpi pci-pci="" bridge=""> at device 21.2 on pci0 Mar 29 21:58:23 kernel: pci4: <acpi pci="" bus=""> on pcib4 Mar 29 21:58:23 kernel: pcib4: <acpi pci-pci="" bridge=""> at device 21.1 on pci0 Mar 29 21:58:23 kernel: mpt0: MPI Version=1.5.0.0 Mar 29 21:58:23 kernel: mpt0: [ITHREAD] Mar 29 21:58:23 kernel: mpt0: <lsilogic sas="" sata="" adapter=""> port 0x4000-0x40ff mem 0xd9c04000-0xd9c07fff,0xd9c10000-0xd9c1ffff irq 18 at device 0.0 on pci3 Mar 29 21:58:23 kernel: pci3: <acpi pci="" bus=""> on pcib3 Mar 29 21:58:23 kernel: pcib3: <acpi pci-pci="" bridge=""> at device 21.0 on pci0 Mar 29 21:58:23 kernel: em1: [FILTER] Mar 29 21:58:23 kernel: em1: Memory Access and/or Bus Master bits were not set! Mar 29 21:58:23 kernel: em1: <intel(r) 1000="" pro="" legacy="" network="" connection="" 1.0.3=""> port 0x2040-0x207f mem 0xd8840000-0xd885ffff,0xd8810000-0xd881ffff irq 19 at device 1.0 on pci2 Mar 29 21:58:23 kernel: em0: [FILTER] Mar 29 21:58:23 kernel: em0: Memory Access and/or Bus Master bits were not set! Mar 29 21:58:23 kernel: em0: <intel(r) 1000="" pro="" legacy="" network="" connection="" 1.0.3=""> port 0x2000-0x203f mem 0xd8820000-0xd883ffff,0xd8800000-0xd880ffff irq 18 at device 0.0 on pci2 Mar 29 21:58:23 kernel: pci2: <acpi pci="" bus=""> on pcib2 Mar 29 21:58:23 kernel: pcib2: <acpi pci-pci="" bridge=""> at device 17.0 on pci0 Mar 29 21:58:23 kernel: vgapci0: <vga-compatible display=""> port 0x10d0-0x10df mem 0xd4000000-0xd7ffffff,0xd8000000-0xd87fffff irq 16 at device 15.0 on pci0 Mar 29 21:58:23 kernel: pci0: <base peripheral=""> at device 7.7 (no driver attached) Mar 29 21:58:23 kernel: pci0: <bridge> at device 7.3 (no driver attached) Mar 29 21:58:23 kernel: ata1: [ITHREAD] Mar 29 21:58:23 kernel: ata1: <ata 1="" channel=""> on atapci0 Mar 29 21:58:23 kernel: ata0: [ITHREAD] Mar 29 21:58:23 kernel: ata0: <ata 0="" channel=""> on atapci0 Mar 29 21:58:23 kernel: atapci0: <intel piix4="" udma33="" controller=""> port 0x1f0-0x1f7,0x3f6,0x170-0x177,0x376,0x10c0-0x10cf at device 7.1 on pci0 Mar 29 21:58:23 kernel: isa0: <isa bus=""> on isab0 Mar 29 21:58:23 kernel: isab0: <pci-isa bridge=""> at device 7.0 on pci0 Mar 29 21:58:23 kernel: pci1: <acpi pci="" bus=""> on pcib1 Mar 29 21:58:23 kernel: pcib1: <acpi pci-pci="" bridge=""> at device 1.0 on pci0 Mar 29 21:58:23 kernel: pci0: <acpi pci="" bus=""> on pcib0 Mar 29 21:58:23 kernel: pcib0: <acpi host-pci="" bridge=""> port 0xcf8-0xcff on acpi0 Mar 29 21:58:23 kernel: cpu0: <acpi cpu=""> on acpi0 Mar 29 21:58:23 kernel: acpi_timer0: <24-bit timer at 3.579545MHz> port 0x1008-0x100b on acpi0 Mar 29 21:58:23 kernel: Timecounter "ACPI-safe" frequency 3579545 Hz quality 850 Mar 29 21:58:23 kernel: acpi0: Power Button (fixed) Mar 29 21:58:23 kernel: acpi0: [ITHREAD] Mar 29 21:58:23 kernel: acpi0: <intel 440bx=""> on motherboard Mar 29 21:58:23 kernel: padlock0: No ACE support. Mar 29 21:58:23 kernel: cryptosoft0: <software crypto=""> on motherboard Mar 29 21:58:23 kernel: kbd1 at kbdmux0 Mar 29 21:58:23 kernel: module_register_init: MOD_LOAD (ipw_ibss_fw, 0xffffffff80469700, 0) error 1 Mar 29 21:58:23 kernel: ipw_ibss: If you agree with the license, set legal.intel_ipw.license_ack=1 in /boot/loader.conf. Mar 29 21:58:23 kernel: ipw_ibss: You need to read the LICENSE file in /usr/share/doc/legal/intel_ipw/. Mar 29 21:58:23 kernel: module_register_init: MOD_LOAD (ipw_bss_fw, 0xffffffff80469660, 0) error 1 Mar 29 21:58:23 kernel: ipw_bss: If you agree with the license, set legal.intel_ipw.license_ack=1 in /boot/loader.conf. Mar 29 21:58:23 kernel: ipw_bss: You need to read the LICENSE file in /usr/share/doc/legal/intel_ipw/. Mar 29 21:58:23 kernel: module_register_init: MOD_LOAD (wpi_fw, 0xffffffff8064d130, 0) error 1 Mar 29 21:58:23 kernel: wpi: If you agree with the license, set legal.intel_wpi.license_ack=1 in /boot/loader.conf. Mar 29 21:58:23 kernel: wpi: You need to read the LICENSE file in /usr/share/doc/legal/intel_wpi/. Mar 29 21:58:23 kernel: module_register_init: MOD_LOAD (ipw_monitor_fw, 0xffffffff804697a0, 0) error 1 Mar 29 21:58:23 kernel: ipw_monitor: If you agree with the license, set legal.intel_ipw.license_ack=1 in /boot/loader.conf. Mar 29 21:58:23 kernel: ipw_monitor: You need to read the LICENSE file in /usr/share/doc/legal/intel_ipw/. Mar 29 21:58:23 kernel: wlan: mac acl policy registered Mar 29 21:58:23 kernel: ioapic0 <version 1.1=""> irqs 0-23 on motherboard Mar 29 21:58:23 kernel: MADT: Forcing active-low polarity and level trigger for SCI Mar 29 21:58:23 kernel: ACPI APIC Table: <ptltd apic=""> Mar 29 21:58:23 kernel: avail memory = 1012514816 (965 MB) Mar 29 21:58:23 kernel: real memory = 1073741824 (1024 MB) Mar 29 21:58:23 kernel: TSC: P-state invariant Mar 29 21:58:23 kernel: AMD Features2=0x1 <lahf>Mar 29 21:58:23 kernel: AMD Features=0x20100800 <syscall,nx,lm>Mar 29 21:58:23 kernel: Features2=0x80082201<sse3,ssse3,cx16,sse4.1,<b31>> Mar 29 21:58:23 kernel: Features=0xfebfbff <fpu,vme,de,pse,tsc,msr,pae,mce,cx8,apic,sep,mtrr,pge,mca,cmov,pat,pse36,clflush,dts,acpi,mmx,fxsr,sse,sse2,ss>Mar 29 21:58:23 kernel: Origin = "GenuineIntel" Id = 0x1067a Family = 6 Model = 17 Stepping = 10 Mar 29 21:58:23 kernel: CPU: Intel(R) Core(TM)2 Quad CPU Q9550 @ 2.83GHz (2832.62-MHz K8-class CPU) Mar 29 21:58:23 kernel: Timecounter "i8254" frequency 1193182 Hz quality 0 Mar 29 21:58:23 kernel: root@FreeBSD_8.0_pfSense_2.0-AMD64.snaps.pfsense.org:/usr/obj.pfSense/usr/pfSensesrc/src/sys/pfSense.8 amd64 Mar 29 21:58:23 kernel: FreeBSD 8.1-RELEASE-p2 #0: Sat Feb 26 17:29:13 EST 2011 Mar 29 21:58:23 kernel: FreeBSD is a registered trademark of The FreeBSD Foundation. Mar 29 21:58:23 kernel: The Regents of the University of California. All rights reserved. Mar 29 21:58:23 kernel: Copyright (c) 1979, 1980, 1983, 1986, 1988, 1989, 1991, 1992, 1993, 1994 Mar 29 21:58:23 kernel: Copyright (c) 1992-2010 The FreeBSD Project. Mar 29 21:58:23 kernel: Rebooting... Mar 29 21:58:23 kernel: Uptime: 13m21s Mar 29 21:58:23 kernel: All buffers synced. Mar 29 21:58:23 kernel: Syncing disks, vnodes remaining...0 0 done Mar 29 21:58:23 kernel: Waiting (max 60 seconds) for system process `syncer' to stop... Mar 29 21:58:23 kernel: Waiting (max 60 seconds) for system process `bufdaemon' to stop...done Mar 29 21:58:23 kernel: Waiting (max 60 seconds) for system process `vnlru' to stop...done Mar 29 21:58:23 kernel: pflog0: promiscuous mode disabled Mar 29 21:58:23 syslogd: kernel boot file is /boot/kernel/kernel</fpu,vme,de,pse,tsc,msr,pae,mce,cx8,apic,sep,mtrr,pge,mca,cmov,pat,pse36,clflush,dts,acpi,mmx,fxsr,sse,sse2,ss></sse3,ssse3,cx16,sse4.1,<b31></syscall,nx,lm></lahf></ptltd></version></software></intel></acpi></acpi></acpi></acpi></acpi></pci-isa></isa></intel></ata></ata></bridge></vga-compatible></acpi></acpi></intel(r)></intel(r)></acpi></acpi></lsilogic></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></ac></at></keyboard></at></ps></parallel></parallel></plip></printer></parallel></floppy></isa></system></generic></acpi></vmware></vmware>
as you can see.. it is disconnecting itself at a consistent rate of 8mins
Mar 29 22:27:26 ppp: [wan] IFACE: Up event Mar 29 22:27:25 ppp: [wan] 175.139.30.21 -> 219.93.218.177 Mar 29 22:27:25 ppp: [wan] IPCP: LayerUp Mar 29 22:27:25 ppp: [wan] IPCP: state change Ack-Rcvd --> Opened Mar 29 22:27:25 ppp: [wan] IPADDR 219.93.218.177 Mar 29 22:27:25 ppp: [wan] IPCP: SendConfigAck #138 Mar 29 22:27:25 ppp: [wan] 219.93.218.177 is OK Mar 29 22:27:25 ppp: [wan] IPADDR 219.93.218.177 Mar 29 22:27:25 ppp: [wan] IPCP: rec'd Configure Request #138 (Ack-Rcvd) Mar 29 22:27:25 ppp: [wan] IPCP: state change Req-Sent --> Ack-Rcvd Mar 29 22:27:25 ppp: [wan] SECDNS 202.188.1.5 Mar 29 22:27:25 ppp: [wan] PRIDNS 202.188.0.133 Mar 29 22:27:25 ppp: [wan] IPADDR 175.139.30.21 Mar 29 22:27:25 ppp: [wan] IPCP: rec'd Configure Ack #15 (Req-Sent) Mar 29 22:27:25 ppp: [wan] SECDNS 202.188.1.5 Mar 29 22:27:25 ppp: [wan] PRIDNS 202.188.0.133 Mar 29 22:27:25 ppp: [wan] IPADDR 175.139.30.21 Mar 29 22:27:25 ppp: [wan] IPCP: SendConfigReq #15 Mar 29 22:27:25 ppp: [wan] SECDNS 202.188.1.5 Mar 29 22:27:25 ppp: [wan] PRIDNS 202.188.0.133 Mar 29 22:27:25 ppp: [wan] 175.139.30.21 is OK Mar 29 22:27:25 ppp: [wan] IPADDR 175.139.30.21 Mar 29 22:27:25 ppp: [wan] IPCP: rec'd Configure Nak #14 (Req-Sent) Mar 29 22:27:25 ppp: [wan] SECDNS 0.0.0.0 Mar 29 22:27:25 ppp: [wan] PRIDNS 0.0.0.0 Mar 29 22:27:25 ppp: [wan] IPADDR 0.0.0.0 Mar 29 22:27:25 ppp: [wan] IPCP: SendConfigReq #14 Mar 29 22:27:25 ppp: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Mar 29 22:27:25 ppp: [wan] IPCP: rec'd Configure Reject #13 (Req-Sent) Mar 29 22:27:25 ppp: [wan] SECDNS 0.0.0.0 Mar 29 22:27:25 ppp: [wan] PRIDNS 0.0.0.0 Mar 29 22:27:25 ppp: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Mar 29 22:27:25 ppp: [wan] IPADDR 0.0.0.0 Mar 29 22:27:25 ppp: [wan] IPCP: SendConfigReq #13 Mar 29 22:27:25 ppp: [wan] IPCP: state change Starting --> Req-Sent Mar 29 22:27:25 ppp: [wan] IPCP: Up event Mar 29 22:27:25 ppp: [wan] IPCP: LayerStart Mar 29 22:27:25 ppp: [wan] IPCP: state change Initial --> Starting Mar 29 22:27:25 ppp: [wan] IPCP: Open event Mar 29 22:27:25 ppp: [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps Mar 29 22:27:25 ppp: [wan_link0] Link: Join bundle "wan" Mar 29 22:27:25 ppp: [wan_link0] Link: Matched action 'bundle "wan" ""' Mar 29 22:27:25 ppp: [wan_link0] LCP: authorization successful Mar 29 22:27:25 ppp: [wan_link0] PAP: rec'd ACK #1 len: 5 Mar 29 22:27:25 ppp: [wan_link0] LCP: LayerUp Mar 29 22:27:25 ppp: [wan_link0] PAP: sending REQUEST #1 len: 34 Mar 29 22:27:25 ppp: [wan_link0] PAP: using authname "hiddenusername@unifi" Mar 29 22:27:25 ppp: [wan_link0] LCP: auth: peer wants PAP, I want nothing Mar 29 22:27:25 ppp: [wan_link0] LCP: state change Ack-Sent --> Opened Mar 29 22:27:25 ppp: [wan_link0] MAGICNUM b9bc94e0 Mar 29 22:27:25 ppp: [wan_link0] MRU 1492 Mar 29 22:27:25 ppp: [wan_link0] PROTOCOMP Mar 29 22:27:25 ppp: [wan_link0] LCP: rec'd Configure Ack #7 (Ack-Sent) Mar 29 22:27:25 ppp: [wan_link0] LCP: state change Req-Sent --> Ack-Sent Mar 29 22:27:25 ppp: [wan_link0] MAGICNUM 0a8c0325 Mar 29 22:27:25 ppp: [wan_link0] AUTHPROTO PAP Mar 29 22:27:25 ppp: [wan_link0] MRU 1492 Mar 29 22:27:25 ppp: [wan_link0] LCP: SendConfigAck #236 Mar 29 22:27:25 ppp: [wan_link0] MAGICNUM 0a8c0325 Mar 29 22:27:25 ppp: [wan_link0] AUTHPROTO PAP Mar 29 22:27:25 ppp: [wan_link0] MRU 1492 Mar 29 22:27:25 ppp: [wan_link0] LCP: rec'd Configure Request #236 (Req-Sent) Mar 29 22:27:24 ppp: [wan_link0] MAGICNUM b9bc94e0 Mar 29 22:27:24 ppp: [wan_link0] MRU 1492 Mar 29 22:27:24 ppp: [wan_link0] PROTOCOMP Mar 29 22:27:24 ppp: [wan_link0] LCP: SendConfigReq #7 Mar 29 22:27:24 ppp: [wan_link0] LCP: state change Starting --> Req-Sent Mar 29 22:27:24 ppp: [wan_link0] LCP: Up event Mar 29 22:27:24 ppp: [wan_link0] Link: UP event Mar 29 22:27:24 ppp: [wan_link0] PPPoE: connection successful Mar 29 22:27:24 ppp: PPPoE: rec'd ACNAME "ERXKLJ22" Mar 29 22:27:24 ppp: [wan_link0] PPPoE: Connecting to '*' Mar 29 22:27:24 ppp: [wan_link0] Link: reconnection attempt 1 Mar 29 22:27:22 ppp: [wan_link0] Link: reconnection attempt 1 in 2 seconds Mar 29 22:27:22 ppp: [wan_link0] LCP: LayerStart Mar 29 22:27:22 ppp: [wan_link0] LCP: state change Stopped --> Starting Mar 29 22:27:22 ppp: [wan_link0] LCP: Down event Mar 29 22:27:22 ppp: [wan_link0] Link: DOWN event Mar 29 22:27:22 ppp: [wan_link0] PPPoE: connection closed Mar 29 22:27:22 ppp: [wan_link0] LCP: LayerFinish Mar 29 22:27:22 ppp: [wan_link0] LCP: state change Stopping --> Stopped Mar 29 22:27:20 ppp: [wan_link0] LCP: LayerDown Mar 29 22:27:20 ppp: [wan_link0] LCP: SendTerminateAck #6 Mar 29 22:27:20 ppp: [wan] IPCP: state change Closing --> Initial Mar 29 22:27:20 ppp: [wan] Bundle: No NCPs left. Closing links... Mar 29 22:27:20 ppp: [wan] IPCP: LayerFinish Mar 29 22:27:20 ppp: [wan] IPCP: Down event Mar 29 22:27:20 ppp: [wan] IFACE: Down event Mar 29 22:27:20 ppp: [wan] IPCP: LayerDown Mar 29 22:27:20 ppp: [wan] IPCP: SendTerminateReq #12 Mar 29 22:27:20 ppp: [wan] IPCP: state change Opened --> Closing Mar 29 22:27:20 ppp: [wan] IPCP: Close event Mar 29 22:27:20 ppp: [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps Mar 29 22:27:20 ppp: [wan_link0] Link: Leave bundle "wan" Mar 29 22:27:20 ppp: [wan_link0] LCP: state change Opened --> Stopping Mar 29 22:27:20 ppp: [wan_link0] LCP: rec'd Terminate Request #244 (Opened) Mar 29 22:17:47 ppp: [wan] IFACE: Up event Mar 29 22:17:46 ppp: [wan] 175.136.186.104 -> 219.93.218.177 Mar 29 22:17:46 ppp: [wan] IPCP: LayerUp Mar 29 22:17:46 ppp: [wan] IPCP: state change Ack-Sent --> Opened Mar 29 22:17:46 ppp: [wan] SECDNS 202.188.1.5 Mar 29 22:17:46 ppp: [wan] PRIDNS 202.188.0.133 Mar 29 22:17:46 ppp: [wan] IPADDR 175.136.186.104 Mar 29 22:17:46 ppp: [wan] IPCP: rec'd Configure Ack #11 (Ack-Sent) Mar 29 22:17:46 ppp: [wan] IPCP: state change Req-Sent --> Ack-Sent Mar 29 22:17:46 ppp: [wan] IPADDR 219.93.218.177 Mar 29 22:17:46 ppp: [wan] IPCP: SendConfigAck #171 Mar 29 22:17:46 ppp: [wan] 219.93.218.177 is OK Mar 29 22:17:46 ppp: [wan] IPADDR 219.93.218.177 Mar 29 22:17:46 ppp: [wan] IPCP: rec'd Configure Request #171 (Req-Sent) Mar 29 22:17:46 ppp: [wan] SECDNS 202.188.1.5 Mar 29 22:17:46 ppp: [wan] PRIDNS 202.188.0.133 Mar 29 22:17:46 ppp: [wan] IPADDR 175.136.186.104 Mar 29 22:17:46 ppp: [wan] IPCP: SendConfigReq #11 Mar 29 22:17:46 ppp: [wan] SECDNS 202.188.1.5 Mar 29 22:17:46 ppp: [wan] PRIDNS 202.188.0.133 Mar 29 22:17:46 ppp: [wan] 175.136.186.104 is OK Mar 29 22:17:46 ppp: [wan] IPADDR 175.136.186.104 Mar 29 22:17:46 ppp: [wan] IPCP: rec'd Configure Nak #10 (Req-Sent) Mar 29 22:17:46 ppp: [wan] SECDNS 0.0.0.0 Mar 29 22:17:46 ppp: [wan] PRIDNS 0.0.0.0 Mar 29 22:17:46 ppp: [wan] IPADDR 0.0.0.0 Mar 29 22:17:46 ppp: [wan] IPCP: SendConfigReq #10 Mar 29 22:17:46 ppp: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Mar 29 22:17:46 ppp: [wan] IPCP: rec'd Configure Reject #9 (Req-Sent) Mar 29 22:17:46 ppp: [wan] SECDNS 0.0.0.0 Mar 29 22:17:46 ppp: [wan] PRIDNS 0.0.0.0 Mar 29 22:17:46 ppp: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Mar 29 22:17:46 ppp: [wan] IPADDR 0.0.0.0 Mar 29 22:17:46 ppp: [wan] IPCP: SendConfigReq #9 Mar 29 22:17:46 ppp: [wan] IPCP: state change Starting --> Req-Sent Mar 29 22:17:46 ppp: [wan] IPCP: Up event Mar 29 22:17:46 ppp: [wan] IPCP: LayerStart Mar 29 22:17:46 ppp: [wan] IPCP: state change Initial --> Starting Mar 29 22:17:46 ppp: [wan] IPCP: Open event Mar 29 22:17:46 ppp: [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps Mar 29 22:17:46 ppp: [wan_link0] Link: Join bundle "wan" Mar 29 22:17:46 ppp: [wan_link0] Link: Matched action 'bundle "wan" ""' Mar 29 22:17:46 ppp: [wan_link0] LCP: authorization successful Mar 29 22:17:46 ppp: [wan_link0] PAP: rec'd ACK #1 len: 5 Mar 29 22:17:45 ppp: [wan_link0] LCP: LayerUp Mar 29 22:17:45 ppp: [wan_link0] PAP: sending REQUEST #1 len: 34 Mar 29 22:17:45 ppp: [wan_link0] PAP: using authname "hiddenusername@unifi" Mar 29 22:17:45 ppp: [wan_link0] LCP: auth: peer wants PAP, I want nothing Mar 29 22:17:45 ppp: [wan_link0] LCP: state change Ack-Sent --> Opened Mar 29 22:17:45 ppp: [wan_link0] MAGICNUM 188f6200 Mar 29 22:17:45 ppp: [wan_link0] MRU 1492 Mar 29 22:17:45 ppp: [wan_link0] PROTOCOMP Mar 29 22:17:45 ppp: [wan_link0] LCP: rec'd Configure Ack #5 (Ack-Sent) Mar 29 22:17:45 ppp: [wan_link0] LCP: state change Req-Sent --> Ack-Sent Mar 29 22:17:45 ppp: [wan_link0] MAGICNUM 7c54906b Mar 29 22:17:45 ppp: [wan_link0] AUTHPROTO PAP Mar 29 22:17:45 ppp: [wan_link0] MRU 1492 Mar 29 22:17:45 ppp: [wan_link0] LCP: SendConfigAck #240 Mar 29 22:17:45 ppp: [wan_link0] MAGICNUM 7c54906b Mar 29 22:17:45 ppp: [wan_link0] AUTHPROTO PAP Mar 29 22:17:45 ppp: [wan_link0] MRU 1492 Mar 29 22:17:45 ppp: [wan_link0] LCP: rec'd Configure Request #240 (Req-Sent) Mar 29 22:17:45 ppp: [wan_link0] MAGICNUM 188f6200 Mar 29 22:17:45 ppp: [wan_link0] MRU 1492 Mar 29 22:17:45 ppp: [wan_link0] PROTOCOMP Mar 29 22:17:45 ppp: [wan_link0] LCP: SendConfigReq #5 Mar 29 22:17:45 ppp: [wan_link0] LCP: state change Starting --> Req-Sent Mar 29 22:17:45 ppp: [wan_link0] LCP: Up event Mar 29 22:17:45 ppp: [wan_link0] Link: UP event Mar 29 22:17:45 ppp: [wan_link0] PPPoE: connection successful Mar 29 22:17:45 ppp: PPPoE: rec'd ACNAME "ERXKLJ22" Mar 29 22:17:45 ppp: [wan_link0] PPPoE: Connecting to '*' Mar 29 22:17:45 ppp: [wan_link0] Link: reconnection attempt 1 Mar 29 22:17:41 ppp: [wan_link0] Link: reconnection attempt 1 in 4 seconds Mar 29 22:17:41 ppp: [wan_link0] LCP: LayerStart Mar 29 22:17:41 ppp: [wan_link0] LCP: state change Stopped --> Starting Mar 29 22:17:41 ppp: [wan_link0] LCP: Down event Mar 29 22:17:41 ppp: [wan_link0] Link: DOWN event Mar 29 22:17:41 ppp: [wan_link0] PPPoE: connection closed Mar 29 22:17:41 ppp: [wan_link0] LCP: LayerFinish Mar 29 22:17:41 ppp: [wan_link0] LCP: state change Stopping --> Stopped Mar 29 22:17:39 ppp: [wan_link0] LCP: LayerDown Mar 29 22:17:39 ppp: [wan_link0] LCP: SendTerminateAck #4 Mar 29 22:17:39 ppp: [wan] IPCP: state change Closing --> Initial Mar 29 22:17:39 ppp: [wan] Bundle: No NCPs left. Closing links... Mar 29 22:17:39 ppp: [wan] IPCP: LayerFinish Mar 29 22:17:39 ppp: [wan] IPCP: Down event Mar 29 22:17:39 ppp: [wan] IFACE: Down event Mar 29 22:17:39 ppp: [wan] IPCP: LayerDown Mar 29 22:17:39 ppp: [wan] IPCP: SendTerminateReq #8 Mar 29 22:17:39 ppp: [wan] IPCP: state change Opened --> Closing Mar 29 22:17:39 ppp: [wan] IPCP: Close event Mar 29 22:17:39 ppp: [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps Mar 29 22:17:39 ppp: [wan_link0] Link: Leave bundle "wan" Mar 29 22:17:39 ppp: [wan_link0] LCP: state change Opened --> Stopping Mar 29 22:17:39 ppp: [wan_link0] LCP: rec'd Terminate Request #249 (Opened) Mar 29 22:08:06 ppp: [wan] IFACE: Up event Mar 29 22:08:05 ppp: [wan] 175.139.24.89 -> 219.93.218.177 Mar 29 22:08:05 ppp: [wan] IPCP: LayerUp Mar 29 22:08:05 ppp: [wan] IPCP: state change Ack-Rcvd --> Opened Mar 29 22:08:05 ppp: [wan] IPADDR 219.93.218.177 Mar 29 22:08:05 ppp: [wan] IPCP: SendConfigAck #84 Mar 29 22:08:05 ppp: [wan] 219.93.218.177 is OK Mar 29 22:08:05 ppp: [wan] IPADDR 219.93.218.177 Mar 29 22:08:05 ppp: [wan] IPCP: rec'd Configure Request #84 (Ack-Rcvd) Mar 29 22:08:05 ppp: [wan] IPCP: state change Req-Sent --> Ack-Rcvd Mar 29 22:08:05 ppp: [wan] SECDNS 202.188.1.5 Mar 29 22:08:05 ppp: [wan] PRIDNS 202.188.0.133 Mar 29 22:08:05 ppp: [wan] IPADDR 175.139.24.89 Mar 29 22:08:05 ppp: [wan] IPCP: rec'd Configure Ack #7 (Req-Sent) Mar 29 22:08:05 ppp: [wan] SECDNS 202.188.1.5 Mar 29 22:08:05 ppp: [wan] PRIDNS 202.188.0.133 Mar 29 22:08:05 ppp: [wan] IPADDR 175.139.24.89 Mar 29 22:08:05 ppp: [wan] IPCP: SendConfigReq #7 Mar 29 22:08:05 ppp: [wan] SECDNS 202.188.1.5 Mar 29 22:08:05 ppp: [wan] PRIDNS 202.188.0.133 Mar 29 22:08:05 ppp: [wan] 175.139.24.89 is OK Mar 29 22:08:05 ppp: [wan] IPADDR 175.139.24.89 Mar 29 22:08:05 ppp: [wan] IPCP: rec'd Configure Nak #6 (Req-Sent) Mar 29 22:08:05 ppp: [wan] SECDNS 0.0.0.0 Mar 29 22:08:05 ppp: [wan] PRIDNS 0.0.0.0 Mar 29 22:08:05 ppp: [wan] IPADDR 0.0.0.0 Mar 29 22:08:05 ppp: [wan] IPCP: SendConfigReq #6 Mar 29 22:08:05 ppp: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Mar 29 22:08:05 ppp: [wan] IPCP: rec'd Configure Reject #5 (Req-Sent) Mar 29 22:08:05 ppp: [wan] SECDNS 0.0.0.0 Mar 29 22:08:05 ppp: [wan] PRIDNS 0.0.0.0 Mar 29 22:08:05 ppp: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Mar 29 22:08:05 ppp: [wan] IPADDR 0.0.0.0 Mar 29 22:08:05 ppp: [wan] IPCP: SendConfigReq #5 Mar 29 22:08:05 ppp: [wan] IPCP: state change Starting --> Req-Sent Mar 29 22:08:05 ppp: [wan] IPCP: Up event Mar 29 22:08:05 ppp: [wan] IPCP: LayerStart Mar 29 22:08:05 ppp: [wan] IPCP: state change Initial --> Starting Mar 29 22:08:05 ppp: [wan] IPCP: Open event Mar 29 22:08:05 ppp: [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps Mar 29 22:08:05 ppp: [wan_link0] Link: Join bundle "wan" Mar 29 22:08:05 ppp: [wan_link0] Link: Matched action 'bundle "wan" ""' Mar 29 22:08:05 ppp: [wan_link0] LCP: authorization successful Mar 29 22:08:05 ppp: [wan_link0] PAP: rec'd ACK #1 len: 5 Mar 29 22:08:04 ppp: [wan_link0] LCP: LayerUp Mar 29 22:08:04 ppp: [wan_link0] PAP: sending REQUEST #1 len: 34 Mar 29 22:08:04 ppp: [wan_link0] PAP: using authname "hiddenusername@unifi" Mar 29 22:08:04 ppp: [wan_link0] LCP: auth: peer wants PAP, I want nothing Mar 29 22:08:04 ppp: [wan_link0] LCP: state change Ack-Sent --> Opened Mar 29 22:08:04 ppp: [wan_link0] MAGICNUM f8e55540 Mar 29 22:08:04 ppp: [wan_link0] MRU 1492 Mar 29 22:08:04 ppp: [wan_link0] PROTOCOMP Mar 29 22:08:04 ppp: [wan_link0] LCP: rec'd Configure Ack #3 (Ack-Sent) Mar 29 22:08:04 ppp: [wan_link0] LCP: state change Req-Sent --> Ack-Sent Mar 29 22:08:04 ppp: [wan_link0] MAGICNUM 00f84efc Mar 29 22:08:04 ppp: [wan_link0] AUTHPROTO PAP Mar 29 22:08:04 ppp: [wan_link0] MRU 1492 Mar 29 22:08:04 ppp: [wan_link0] LCP: SendConfigAck #245 Mar 29 22:08:04 ppp: [wan_link0] MAGICNUM 00f84efc Mar 29 22:08:04 ppp: [wan_link0] AUTHPROTO PAP Mar 29 22:08:04 ppp: [wan_link0] MRU 1492 Mar 29 22:08:04 ppp: [wan_link0] LCP: rec'd Configure Request #245 (Req-Sent) Mar 29 22:08:04 ppp: [wan_link0] MAGICNUM f8e55540 Mar 29 22:08:04 ppp: [wan_link0] MRU 1492 Mar 29 22:08:04 ppp: [wan_link0] PROTOCOMP Mar 29 22:08:04 ppp: [wan_link0] LCP: SendConfigReq #3 Mar 29 22:08:04 ppp: [wan_link0] LCP: state change Starting --> Req-Sent Mar 29 22:08:04 ppp: [wan_link0] LCP: Up event Mar 29 22:08:04 ppp: [wan_link0] Link: UP event Mar 29 22:08:04 ppp: [wan_link0] PPPoE: connection successful Mar 29 22:08:04 ppp: PPPoE: rec'd ACNAME "ERXKLJ22" Mar 29 22:08:04 ppp: [wan_link0] PPPoE: Connecting to '*' Mar 29 22:08:04 ppp: [wan_link0] Link: reconnection attempt 1 Mar 29 22:08:01 ppp: [wan_link0] Link: reconnection attempt 1 in 3 seconds Mar 29 22:08:01 ppp: [wan_link0] LCP: LayerStart Mar 29 22:08:01 ppp: [wan_link0] LCP: state change Stopped --> Starting Mar 29 22:08:01 ppp: [wan_link0] LCP: Down event Mar 29 22:08:01 ppp: [wan_link0] Link: DOWN event Mar 29 22:08:01 ppp: [wan_link0] PPPoE: connection closed Mar 29 22:08:01 ppp: [wan_link0] LCP: LayerFinish Mar 29 22:08:01 ppp: [wan_link0] LCP: state change Stopping --> Stopped Mar 29 22:07:59 ppp: [wan_link0] LCP: LayerDown Mar 29 22:07:59 ppp: [wan_link0] LCP: SendTerminateAck #2 Mar 29 22:07:59 ppp: [wan] IPCP: state change Closing --> Initial Mar 29 22:07:59 ppp: [wan] Bundle: No NCPs left. Closing links... Mar 29 22:07:59 ppp: [wan] IPCP: LayerFinish Mar 29 22:07:59 ppp: [wan] IPCP: Down event Mar 29 22:07:59 ppp: [wan] IFACE: Down event Mar 29 22:07:59 ppp: [wan] IPCP: LayerDown Mar 29 22:07:59 ppp: [wan] IPCP: SendTerminateReq #4 Mar 29 22:07:59 ppp: [wan] IPCP: state change Opened --> Closing Mar 29 22:07:59 ppp: [wan] IPCP: Close event Mar 29 22:07:59 ppp: [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps Mar 29 22:07:59 ppp: [wan_link0] Link: Leave bundle "wan" Mar 29 22:07:59 ppp: [wan_link0] LCP: state change Opened --> Stopping Mar 29 22:07:59 ppp: [wan_link0] LCP: rec'd Terminate Request #122 (Opened) Mar 29 21:58:26 ppp: [wan] IFACE: Up event Mar 29 21:58:24 ppp: [wan] 175.139.27.26 -> 219.93.218.177 Mar 29 21:58:24 ppp: [wan] IPCP: LayerUp Mar 29 21:58:24 ppp: [wan] IPCP: state change Ack-Sent --> Opened Mar 29 21:58:24 ppp: [wan] SECDNS 202.188.1.5 Mar 29 21:58:24 ppp: [wan] PRIDNS 202.188.0.133 Mar 29 21:58:24 ppp: [wan] IPADDR 175.139.27.26 Mar 29 21:58:24 ppp: [wan] IPCP: rec'd Configure Ack #3 (Ack-Sent) Mar 29 21:58:24 ppp: [wan] SECDNS 202.188.1.5 Mar 29 21:58:24 ppp: [wan] PRIDNS 202.188.0.133 Mar 29 21:58:24 ppp: [wan] IPADDR 175.139.27.26 Mar 29 21:58:24 ppp: [wan] IPCP: SendConfigReq #3 Mar 29 21:58:24 ppp: [wan] SECDNS 202.188.1.5 Mar 29 21:58:24 ppp: [wan] PRIDNS 202.188.0.133 Mar 29 21:58:24 ppp: [wan] 175.139.27.26 is OK Mar 29 21:58:24 ppp: [wan] IPADDR 175.139.27.26 Mar 29 21:58:24 ppp: [wan] IPCP: rec'd Configure Nak #2 (Ack-Sent) Mar 29 21:58:24 ppp: [wan] IPCP: state change Req-Sent --> Ack-Sent Mar 29 21:58:24 ppp: [wan] IPADDR 219.93.218.177 Mar 29 21:58:24 ppp: [wan] IPCP: SendConfigAck #56 Mar 29 21:58:24 ppp: [wan] 219.93.218.177 is OK Mar 29 21:58:24 ppp: [wan] IPADDR 219.93.218.177 Mar 29 21:58:24 ppp: [wan] IPCP: rec'd Configure Request #56 (Req-Sent) Mar 29 21:58:24 ppp: [wan] SECDNS 0.0.0.0 Mar 29 21:58:24 ppp: [wan] PRIDNS 0.0.0.0 Mar 29 21:58:24 ppp: [wan] IPADDR 0.0.0.0 Mar 29 21:58:24 ppp: [wan] IPCP: SendConfigReq #2 Mar 29 21:58:24 ppp: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Mar 29 21:58:24 ppp: [wan] IPCP: rec'd Configure Reject #1 (Req-Sent) Mar 29 21:58:24 ppp: [wan] SECDNS 0.0.0.0 Mar 29 21:58:24 ppp: [wan] PRIDNS 0.0.0.0 Mar 29 21:58:24 ppp: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Mar 29 21:58:24 ppp: [wan] IPADDR 0.0.0.0 Mar 29 21:58:24 ppp: [wan] IPCP: SendConfigReq #1 Mar 29 21:58:24 ppp: [wan] IPCP: state change Starting --> Req-Sent Mar 29 21:58:24 ppp: [wan] IPCP: Up event Mar 29 21:58:24 ppp: [wan] IPCP: LayerStart Mar 29 21:58:24 ppp: [wan] IPCP: state change Initial --> Starting Mar 29 21:58:24 ppp: [wan] IPCP: Open event Mar 29 21:58:24 ppp: [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps Mar 29 21:58:24 ppp: [wan_link0] Link: Join bundle "wan" Mar 29 21:58:24 ppp: [wan_link0] Link: Matched action 'bundle "wan" ""' Mar 29 21:58:24 ppp: [wan_link0] LCP: authorization successful Mar 29 21:58:24 ppp: [wan_link0] PAP: rec'd ACK #1 len: 5 Mar 29 21:58:24 ppp: [wan_link0] LCP: LayerUp Mar 29 21:58:24 ppp: [wan_link0] PAP: sending REQUEST #1 len: 34 Mar 29 21:58:24 ppp: [wan_link0] PAP: using authname "hiddenusername@unifi" Mar 29 21:58:24 ppp: [wan_link0] LCP: auth: peer wants PAP, I want nothing Mar 29 21:58:24 ppp: [wan_link0] LCP: state change Ack-Sent --> Opened Mar 29 21:58:24 ppp: [wan_link0] MAGICNUM b377b380 Mar 29 21:58:24 ppp: [wan_link0] MRU 1492 Mar 29 21:58:24 ppp: [wan_link0] PROTOCOMP Mar 29 21:58:24 ppp: [wan_link0] LCP: rec'd Configure Ack #1 (Ack-Sent) Mar 29 21:58:24 ppp: [wan_link0] LCP: state change Req-Sent --> Ack-Sent Mar 29 21:58:24 ppp: [wan_link0] MAGICNUM 18e3dba3 Mar 29 21:58:24 ppp: [wan_link0] AUTHPROTO PAP Mar 29 21:58:24 ppp: [wan_link0] MRU 1492 Mar 29 21:58:24 ppp: [wan_link0] LCP: SendConfigAck #118 Mar 29 21:58:24 ppp: [wan_link0] MAGICNUM 18e3dba3 Mar 29 21:58:24 ppp: [wan_link0] AUTHPROTO PAP Mar 29 21:58:24 ppp: [wan_link0] MRU 1492 Mar 29 21:58:24 ppp: [wan_link0] LCP: rec'd Configure Request #118 (Req-Sent) Mar 29 21:58:23 ppp: [wan_link0] MAGICNUM b377b380 Mar 29 21:58:23 ppp: [wan_link0] MRU 1492 Mar 29 21:58:23 ppp: [wan_link0] PROTOCOMP Mar 29 21:58:23 ppp: [wan_link0] LCP: SendConfigReq #1 Mar 29 21:58:23 ppp: [wan_link0] LCP: state change Starting --> Req-Sent Mar 29 21:58:23 ppp: [wan_link0] LCP: Up event Mar 29 21:58:23 ppp: [wan_link0] Link: UP event Mar 29 21:58:23 ppp: [wan_link0] PPPoE: connection successful Mar 29 21:58:23 ppp: PPPoE: rec'd ACNAME "ERXKLJ22" Mar 29 21:58:23 ppp: [wan_link0] PPPoE: Connecting to '*' Mar 29 21:58:23 ppp: [wan_link0] LCP: LayerStart Mar 29 21:58:23 ppp: [wan_link0] LCP: state change Initial --> Starting Mar 29 21:58:23 ppp: [wan_link0] LCP: Open event
-
updated with sys logs , ppp logs .. it seems like the ISP does not like certain PPP settings by pfSense and requesting it to disconnect
update: tried with pfsense 1.2.3 with open-vm-tools installed.. line still disconnects at the same rate.. have a feeling that the ISP doesn't like me using pfsense >:(
-
Hi All,
I may have found the root cause of the problem. It seems that my ISP requires a LCP echo interval of 30 seconds no more or less in order to keep a constant connection. Is this option configurable under pfsense ?
-
I take it that screen shot is from an ISP supplied router? Is it their custom firmware?
It seems a little odd that they would require you to send LCP echos. More likely they are sending echos and you are not replying if it's them that is dropping the ppp session.
Or more likely it is a negotiated LQR echo they need.
Anyway you can enable lcp echos in ppp though I have never done it.
See the ppp man page about half way down.I'm not sure how you'd go about enabling it though. Maybe try adding 'enable echo' to /etc/ppp/ppp.conf :-\
Steve
-
hi Steve,
thanks for the reply. its not a custom firmware, that option is available from a stock firmware. now I would need to figure out how to add that setting under pfsense ???
-
i have tried manually creating a mpd_wan.conf file stating the keep alive timing under /conf .. still doesn't help at all :(
checked the /etc/ppp/ppp.conf but there's no configuration details about my pppoe interface in there ???
edit : and the thing I'm curious about now is why does the connection not drop at all upon a clean installation. After the first reboot, the disconnection keeps coming ??? :(
-
checked the /etc/ppp/ppp.conf but there's no configuration details about my pppoe interface in there ???
Try /var/etc/mpd_wan.conf
-
checked the /etc/ppp/ppp.conf but there's no configuration details about my pppoe interface in there ???
Try /var/etc/mpd_wan.conf
tried to modify the configurations there.. upon disconnection and reconnection the settings revert back to the default ones
-
one thing that I have noticed is , when WAN interface is on DHCP the keep alive option is working perfectly fine. Changing it to PPPoE remains working however syslogs continue to cough out dhclient:FAIL . Restarting the machine removes the dhclient:FAIL log but keep-alive option is not working anymore.
-
with the DHCP trick, the connection stayed alive for 2 days and counting.. but I wouldn't want to have this as a permanent solution :-\ are there any ways I can see verbose output of what is happening on the LCP ?