WiFi does not start at boot



  • Version 2.1-BETA1 (i386)
    built on Mon Jan 14 11:26:01 EST 2013
    Alix 2D13, LAN, WAN, OPT1, WiFi (ath0)

    When it boots the WiFi does not come up.
    If I go to Interfaces_>WiFi and press save (no change to any config) then it comes up.
    Console output does not have any odd, other than the WiFi has no address/subnet on the console menu output:

    Trying to mount root from ufs:/dev/ufs/pfsense0
    Configuring crash dumps...
    Mounting filesystems...
    Setting up embedded specific environment... done.
    
         ___
     ___/ f \
    / p \___/ Sense
    \___/   \
        \___/
    
    Welcome to pfSense 2.1-BETA1  ...
    
    Creating symlinks......done.
    External config loader 1.0 is now starting... ad0s3
    Launching the init system... done.
    Initializing............................. done.
    Starting device manager (devd)...done.
    Loading configuration......done.
    Updating configuration...done.
    Cleaning backup cache........done.
    Setting up extended sysctls...done.
    Setting timezone...done.
    Configuring loopback interface...done.
    Starting syslog...done.
    Starting Secure Shell Services...done.
    Setting up polling defaults...done.
    Setting up interfaces microcode...done.
    Configuring loopback interface...done.
    Configuring LAGG interfaces...done.
    Configuring VLAN interfaces...done.
    Configuring QinQ interfaces...done.
    Configuring WAN interface...done.
    Configuring LAN interface...done.
    Configuring OPT1 interface...done.
    Configuring WIFI interface...done.
    Syncing OpenVPN settings...done.
    Configuring firewall......done.
    Starting PFLOG...done.
    Setting up gateway monitors...done.
    Synchronizing user settings...done.
    Starting webConfigurator...done.
    Configuring CRON...done.
    Starting DNS forwarder...done.
    Starting NTP time client...done.
    Starting DHCP service...done.
    Configuring firewall......done.
    Generating RRD graphs...done.
    Starting CRON... done.
     Starting package Cron...done.
     Starting package blinkled...done.
    Bootup complete
    
    FreeBSD/i386 (imp-rt-01.imp.infn) (console)
    
    *** Welcome to pfSense 2.1-BETA1-nanobsd (i386) on imp-rt-01 ***
    
     WAN (wan)       -> vr1        -> v4/DHCP4: 192.168.12.203/24
     LAN (lan)       -> vr0        -> v4: 10.49.112.250/24
     OPT1 (opt1)     -> vr2        ->
     WIFI (opt2)     -> ath0_wlan0 ->
    
     0) Logout (SSH only)                  8) Shell
     1) Assign Interfaces                  9) pfTop
     2) Set interface(s) IP address       10) Filter Logs
     3) Reset webConfigurator password    11) Restart webConfigurator
     4) Reset to factory defaults         12) pfSense Developer Shell
     5) Reboot system                     13) Upgrade from console
     6) Halt system                       14) Disable Secure Shell (sshd)
     7) Ping host                         15) Restore recent configuration
    
    Enter an option: 8
    

    I also cannot see anything bad in syslog:

    Jan 15 09:14:40 imp-rt-01 syslogd: kernel boot file is /boot/kernel/kernel
    Jan 15 09:14:40 imp-rt-01 kernel: Copyright (c) 1992-2012 The FreeBSD Project.
    Jan 15 09:14:40 imp-rt-01 kernel: Copyright (c) 1979, 1980, 1983, 1986, 1988, 1989, 1991, 1992, 1993, 1994
    Jan 15 09:14:40 imp-rt-01 kernel: The Regents of the University of California. All rights reserved.
    Jan 15 09:14:40 imp-rt-01 kernel: FreeBSD is a registered trademark of The FreeBSD Foundation.
    Jan 15 09:14:40 imp-rt-01 kernel: FreeBSD 8.3-RELEASE-p5 #0: Mon Jan 14 12:14:51 EST 2013
    Jan 15 09:14:40 imp-rt-01 kernel: root@snapshots-8_3-i386.builders.pfsense.org:/usr/obj./usr/pfSensesrc/src/sys/pfSense_wrap.8.i386 i386
    Jan 15 09:14:40 imp-rt-01 kernel: Timecounter "i8254" frequency 1193182 Hz quality 0
    Jan 15 09:14:40 imp-rt-01 kernel: CPU: Geode(TM) Integrated Processor by AMD PCS (498.05-MHz 586-class CPU)
    Jan 15 09:14:40 imp-rt-01 kernel: Origin = "AuthenticAMD"  Id = 0x5a2  Family = 5  Model = a  Stepping = 2
    Jan 15 09:14:40 imp-rt-01 kernel: Features=0x88a93d <fpu,de,pse,tsc,msr,cx8,sep,pge,cmov,clflush,mmx>Jan 15 09:14:40 imp-rt-01 kernel: AMD Features=0xc0400000 <mmx+,3dnow!+,3dnow!>Jan 15 09:14:40 imp-rt-01 kernel: real memory  = 268435456 (256 MB)
    Jan 15 09:14:40 imp-rt-01 kernel: avail memory = 239239168 (228 MB)
    Jan 15 09:14:40 imp-rt-01 kernel: pnpbios: Bad PnP BIOS data checksum
    Jan 15 09:14:40 imp-rt-01 kernel: ipw_bss: You need to read the LICENSE file in /usr/share/doc/legal/intel_ipw/.
    Jan 15 09:14:40 imp-rt-01 kernel: ipw_bss: If you agree with the license, set legal.intel_ipw.license_ack=1 in /boot/loader.conf.
    Jan 15 09:14:40 imp-rt-01 kernel: module_register_init: MOD_LOAD (ipw_bss_fw, 0xc0731270, 0) error 1
    Jan 15 09:14:40 imp-rt-01 kernel: ipw_ibss: You need to read the LICENSE file in /usr/share/doc/legal/intel_ipw/.
    Jan 15 09:14:40 imp-rt-01 kernel: ipw_ibss: If you agree with the license, set legal.intel_ipw.license_ack=1 in /boot/loader.conf.
    Jan 15 09:14:40 imp-rt-01 kernel: module_register_init: MOD_LOAD (ipw_ibss_fw, 0xc0731310, 0) error 1
    Jan 15 09:14:40 imp-rt-01 kernel: ipw_monitor: You need to read the LICENSE file in /usr/share/doc/legal/intel_ipw/.
    Jan 15 09:14:40 imp-rt-01 kernel: ipw_monitor: If you agree with the license, set legal.intel_ipw.license_ack=1 in /boot/loader.conf.
    Jan 15 09:14:40 imp-rt-01 kernel: module_register_init: MOD_LOAD (ipw_monitor_fw, 0xc07313b0, 0) error 1
    Jan 15 09:14:40 imp-rt-01 kernel: wlan: mac acl policy registered
    Jan 15 09:14:40 imp-rt-01 kernel: K6-family MTRR support enabled (2 registers)
    Jan 15 09:14:40 imp-rt-01 kernel: ACPI Error: A valid RSDP was not found (20101013/tbxfroot-309)
    Jan 15 09:14:40 imp-rt-01 kernel: ACPI: Table initialisation failed: AE_NOT_FOUND
    Jan 15 09:14:40 imp-rt-01 kernel: ACPI: Try disabling either ACPI or apic support.
    Jan 15 09:14:40 imp-rt-01 kernel: cryptosoft0: <software crypto=""> on motherboard
    Jan 15 09:14:40 imp-rt-01 kernel: padlock0: No ACE support.
    Jan 15 09:14:40 imp-rt-01 kernel: pcib0: <host to="" pci="" bridge=""> pcibus 0 on motherboard
    Jan 15 09:14:40 imp-rt-01 kernel: pci0: <pci bus=""> on pcib0
    Jan 15 09:14:40 imp-rt-01 kernel: Geode LX: PC Engines ALIX.2 v0.99h tinyBIOS V1.4a (C)1997-2007
    Jan 15 09:14:40 imp-rt-01 kernel: pci0: <encrypt decrypt,="" entertainment="" crypto=""> at device 1.2 (no driver attached)
    Jan 15 09:14:40 imp-rt-01 kernel: vr0: <via 10="" vt6105m="" rhine="" iii="" 100basetx=""> port 0x1000-0x10ff mem 0xe0000000-0xe00000ff irq 10 at device 9.0 on pci0
    Jan 15 09:14:40 imp-rt-01 kernel: vr0: Quirks: 0x2
    Jan 15 09:14:40 imp-rt-01 kernel: vr0: Revision: 0x96
    Jan 15 09:14:40 imp-rt-01 kernel: miibus0: <mii bus=""> on vr0
    Jan 15 09:14:40 imp-rt-01 kernel: ukphy0: <generic ieee="" 802.3u="" media="" interface=""> PHY 1 on miibus0
    Jan 15 09:14:40 imp-rt-01 kernel: ukphy0:  none, 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto, auto-flow
    Jan 15 09:14:40 imp-rt-01 kernel: vr0: [ITHREAD]
    Jan 15 09:14:40 imp-rt-01 kernel: vr1: <via 10="" vt6105m="" rhine="" iii="" 100basetx=""> port 0x1400-0x14ff mem 0xe0040000-0xe00400ff irq 11 at device 10.0 on pci0
    Jan 15 09:14:40 imp-rt-01 kernel: vr1: Quirks: 0x2
    Jan 15 09:14:40 imp-rt-01 kernel: vr1: Revision: 0x96
    Jan 15 09:14:40 imp-rt-01 kernel: miibus1: <mii bus=""> on vr1
    Jan 15 09:14:40 imp-rt-01 kernel: ukphy1: <generic ieee="" 802.3u="" media="" interface=""> PHY 1 on miibus1
    Jan 15 09:14:40 imp-rt-01 kernel: ukphy1:  none, 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto, auto-flow
    Jan 15 09:14:40 imp-rt-01 kernel: vr1: [ITHREAD]
    Jan 15 09:14:40 imp-rt-01 kernel: vr2: <via 10="" vt6105m="" rhine="" iii="" 100basetx=""> port 0x1800-0x18ff mem 0xe0080000-0xe00800ff irq 15 at device 11.0 on pci0
    Jan 15 09:14:40 imp-rt-01 kernel: vr2: Quirks: 0x2
    Jan 15 09:14:40 imp-rt-01 kernel: vr2: Revision: 0x96
    Jan 15 09:14:40 imp-rt-01 kernel: miibus2: <mii bus=""> on vr2
    Jan 15 09:14:40 imp-rt-01 kernel: ukphy2: <generic ieee="" 802.3u="" media="" interface=""> PHY 1 on miibus2
    Jan 15 09:14:40 imp-rt-01 kernel: ukphy2:  none, 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto, auto-flow
    Jan 15 09:14:40 imp-rt-01 kernel: vr2: [ITHREAD]
    Jan 15 09:14:40 imp-rt-01 kernel: ath0: <atheros 5212=""> mem 0xe00c0000-0xe00cffff irq 9 at device 12.0 on pci0
    Jan 15 09:14:40 imp-rt-01 kernel: ath0: [ITHREAD]
    Jan 15 09:14:40 imp-rt-01 kernel: ath0: AR5212 mac 5.9 RF5112 phy 4.3
    Jan 15 09:14:40 imp-rt-01 kernel: isab0: <pci-isa bridge=""> port 0x6000-0x6007,0x6100-0x61ff,0x6200-0x623f,0x9d00-0x9d7f,0x9c00-0x9c3f at device 15.0 on pci0
    Jan 15 09:14:40 imp-rt-01 kernel: isa0: <isa bus=""> on isab0
    Jan 15 09:14:40 imp-rt-01 kernel: atapci0: <amd cs5536="" udma100="" controller=""> port 0x1f0-0x1f7,0x3f6,0x170-0x177,0x376,0xff00-0xff0f at device 15.2 on pci0
    Jan 15 09:14:40 imp-rt-01 kernel: ata0: <ata channel=""> at channel 0 on atapci0
    Jan 15 09:14:40 imp-rt-01 kernel: ata0: [ITHREAD]
    Jan 15 09:14:40 imp-rt-01 kernel: ata1: <ata channel=""> at channel 1 on atapci0
    Jan 15 09:14:40 imp-rt-01 kernel: ata1: [ITHREAD]
    Jan 15 09:14:40 imp-rt-01 kernel: ohci0: <ohci (generic)="" usb="" controller=""> mem 0xefffe000-0xefffefff irq 12 at device 15.4 on pci0
    Jan 15 09:14:40 imp-rt-01 kernel: ohci0: [ITHREAD]
    Jan 15 09:14:40 imp-rt-01 kernel: usbus0: <ohci (generic)="" usb="" controller=""> on ohci0
    Jan 15 09:14:40 imp-rt-01 kernel: ehci0: <amd cs5536="" (geode)="" usb="" 2.0="" controller=""> mem 0xefffd000-0xefffdfff irq 12 at device 15.5 on pci0
    Jan 15 09:14:40 imp-rt-01 kernel: ehci0: [ITHREAD]
    Jan 15 09:14:40 imp-rt-01 kernel: usbus1: EHCI version 1.0
    Jan 15 09:14:40 imp-rt-01 kernel: usbus1: <amd cs5536="" (geode)="" usb="" 2.0="" controller=""> on ehci0
    Jan 15 09:14:40 imp-rt-01 kernel: cpu0 on motherboard
    Jan 15 09:14:40 imp-rt-01 kernel: orm0: <isa option="" rom=""> at iomem 0xe0000-0xea7ff pnpid ORM0000 on isa0
    Jan 15 09:14:40 imp-rt-01 kernel: atrtc0: <at real="" time="" clock=""> at port 0x70 irq 8 on isa0
    Jan 15 09:14:40 imp-rt-01 kernel: ppc0: parallel port not found.
    Jan 15 09:14:40 imp-rt-01 kernel: uart0: <16550 or compatible> at port 0x3f8-0x3ff irq 4 flags 0x10 on isa0
    Jan 15 09:14:40 imp-rt-01 kernel: uart0: [FILTER]
    Jan 15 09:14:40 imp-rt-01 kernel: uart0: console (9600,n,8,1)
    Jan 15 09:14:41 imp-rt-01 kernel: uart1: <16550 or compatible> at port 0x2f8-0x2ff irq 3 on isa0
    Jan 15 09:14:41 imp-rt-01 kernel: uart1: [FILTER]
    Jan 15 09:14:41 imp-rt-01 kernel: Timecounter "TSC" frequency 498052738 Hz quality 800
    Jan 15 09:14:41 imp-rt-01 kernel: Timecounters tick every 10.000 msec
    Jan 15 09:14:41 imp-rt-01 kernel: IPsec: Initialized Security Association Processing.
    Jan 15 09:14:41 imp-rt-01 kernel: usbus0: 12Mbps Full Speed USB v1.0
    Jan 15 09:14:41 imp-rt-01 kernel: usbus1: 480Mbps High Speed USB v2.0
    Jan 15 09:14:41 imp-rt-01 kernel: ugen0.1: <amd> at usbus0
    Jan 15 09:14:41 imp-rt-01 kernel: uhub0: <amd 1="" 9="" ohci="" root="" hub,="" class="" 0,="" rev="" 1.00="" 1.00,="" addr=""> on usbus0
    Jan 15 09:14:41 imp-rt-01 kernel: ugen1.1: <amd> at usbus1
    Jan 15 09:14:41 imp-rt-01 kernel: uhub1: <amd 1="" 9="" ehci="" root="" hub,="" class="" 0,="" rev="" 2.00="" 1.00,="" addr=""> on usbus1
    Jan 15 09:14:41 imp-rt-01 kernel: ad0: 3811MB <elite pro="" cf="" card="" ver6.04k=""> at ata0-master PIO4 
    Jan 15 09:14:41 imp-rt-01 kernel: GEOM: ad0s1: media size does not match label.
    Jan 15 09:14:41 imp-rt-01 kernel: GEOM: ad0s2: media size does not match label.
    Jan 15 09:14:41 imp-rt-01 kernel: uhub0: 4 ports with 4 removable, self powered
    Jan 15 09:14:41 imp-rt-01 kernel: Root mount waiting for: usbus1
    Jan 15 09:14:41 imp-rt-01 kernel: Root mount waiting for: usbus1
    Jan 15 09:14:41 imp-rt-01 kernel: uhub1: 4 ports with 4 removable, self powered
    Jan 15 09:14:41 imp-rt-01 kernel: Trying to mount root from ufs:/dev/ufs/pfsense0
    Jan 15 09:14:41 imp-rt-01 kernel: vr1: link state changed to DOWN
    Jan 15 09:14:40 imp-rt-01 php: : Deny router advertisements for interface wan
    Jan 15 09:14:40 imp-rt-01 check_reload_status: Linkup starting vr1
    Jan 15 09:14:42 imp-rt-01 sshd[7822]: Server listening on :: port 22.
    Jan 15 09:14:42 imp-rt-01 sshlockout[7838]: sshlockout/webConfigurator v3.0 starting up
    Jan 15 09:14:42 imp-rt-01 sshd[7822]: Server listening on 0.0.0.0 port 22.
    Jan 15 09:14:43 imp-rt-01 check_reload_status: Linkup starting vr1
    Jan 15 09:14:43 imp-rt-01 kernel: vr1: link state changed to UP
    Jan 15 09:14:43 imp-rt-01 dhclient: PREINIT
    Jan 15 09:14:43 imp-rt-01 dhclient: Starting delete_old_states()
    Jan 15 09:14:43 imp-rt-01 dhclient: Comparing Routers: Old:  New: 
    Jan 15 09:14:43 imp-rt-01 dhclient[7235]: DHCPDISCOVER on vr1 to 255.255.255.255 port 67 interval 1
    Jan 15 09:14:43 imp-rt-01 dhclient[7235]: DHCPOFFER from 192.168.12.1
    Jan 15 09:14:43 imp-rt-01 dhclient: ARPSEND
    Jan 15 09:14:45 imp-rt-01 dhclient: ARPCHECK
    Jan 15 09:14:45 imp-rt-01 dhclient[7235]: DHCPREQUEST on vr1 to 255.255.255.255 port 67
    Jan 15 09:14:45 imp-rt-01 dhclient[7235]: DHCPACK from 192.168.12.1
    Jan 15 09:14:45 imp-rt-01 dhclient: BOUND
    Jan 15 09:14:45 imp-rt-01 dhclient: Starting delete_old_states()
    Jan 15 09:14:45 imp-rt-01 dhclient: Comparing Routers: Old:  New: 192.168.12.1
    Jan 15 09:14:45 imp-rt-01 dhclient: Removing states through old gateway '' (new gateway '192.168.12.1')
    Jan 15 09:14:45 imp-rt-01 dhclient: Starting add_new_address()
    Jan 15 09:14:45 imp-rt-01 dhclient: ifconfig vr1 inet 192.168.12.203 netmask 255.255.255.0 broadcast 192.168.12.255 
    Jan 15 09:14:45 imp-rt-01 dhclient: New IP Address (vr1): 192.168.12.203
    Jan 15 09:14:45 imp-rt-01 dhclient: New Subnet Mask (vr1): 255.255.255.0
    Jan 15 09:14:45 imp-rt-01 dhclient: New Broadcast Address (vr1): 192.168.12.255
    Jan 15 09:14:45 imp-rt-01 dhclient: New Routers (vr1): 192.168.12.1
    Jan 15 09:14:45 imp-rt-01 dhclient: Adding new routes to interface: vr1
    Jan 15 09:14:45 imp-rt-01 dhclient: /sbin/route add default 192.168.12.1
    Jan 15 09:14:45 imp-rt-01 dhclient: Creating resolv.conf
    Jan 15 09:14:45 imp-rt-01 dhclient[7235]: bound to 192.168.12.203 -- renewal in 129600 seconds.
    Jan 15 09:14:45 imp-rt-01 php: : Deny router advertisements for interface lan
    Jan 15 09:14:45 imp-rt-01 php: : Deny router advertisements for interface opt1
    Jan 15 09:14:45 imp-rt-01 kernel: vr0: link state changed to DOWN
    Jan 15 09:14:45 imp-rt-01 check_reload_status: rc.newwanip starting vr1
    Jan 15 09:14:45 imp-rt-01 kernel: vr2: link state changed to DOWN
    Jan 15 09:14:45 imp-rt-01 check_reload_status: Linkup starting vr0
    Jan 15 09:14:45 imp-rt-01 check_reload_status: Linkup starting vr2
    Jan 15 09:14:48 imp-rt-01 check_reload_status: Linkup starting vr0
    Jan 15 09:14:48 imp-rt-01 kernel: vr0: link state changed to UP
    Jan 15 09:14:53 imp-rt-01 php: : rc.newwanip: Informational is starting vr1.
    Jan 15 09:14:53 imp-rt-01 php: : rc.newwanip: on (IP address: 192.168.12.203) (interface: wan) (real interface: vr1).
    Jan 15 09:14:53 imp-rt-01 php: : ROUTING: setting default route to 192.168.12.1
    Jan 15 09:14:53 imp-rt-01 php: : Removing static route for monitor 8.8.8.8 and adding a new route through 192.168.12.1
    Jan 15 09:14:54 imp-rt-01 check_reload_status: Reloading filter
    Jan 15 09:14:55 imp-rt-01 php: : DynDns: updatedns() starting
    Jan 15 09:14:56 imp-rt-01 php: : The command '/sbin/dhclient -c /var/etc/dhclient_opt1.conf vr2 > /tmp/vr2_output > /tmp/vr2_error_output' returned exit code '1', the output was '' 
    Jan 15 09:14:56 imp-rt-01 php: : Resyncing OpenVPN instances.
    Jan 15 09:14:56 imp-rt-01 kernel: tun1: changing name to 'ovpnc1'
    Jan 15 09:14:56 imp-rt-01 php: : The command '/sbin/route -q delete 10.49.243.30' returned exit code '1', the output was 'route: writing to routing socket: No such process' 
    Jan 15 09:14:57 imp-rt-01 kernel: tun2: changing name to 'ovpnc2'
    Jan 15 09:14:57 imp-rt-01 php: : The command '/sbin/route -q delete 10.49.240.30' returned exit code '1', the output was 'route: writing to routing socket: No such process' 
    Jan 15 09:14:57 imp-rt-01 kernel: pflog0: promiscuous mode enabled
    Jan 15 09:14:58 imp-rt-01 php: : Removing static route for monitor 8.8.8.8 and adding a new route through 192.168.12.1
    Jan 15 09:15:00 imp-rt-01 php: : DynDns debug information (ntc-imp-inf.dyndns-ip.com): 49.244.247.158 extracted from checkip.dyndns.org
    Jan 15 09:15:00 imp-rt-01 php: : DynDNS (ntc-imp-inf.dyndns-ip.com): running get_failover_interface for wan. found vr1
    Jan 15 09:15:02 imp-rt-01 kernel: ovpnc2: link state changed to UP
    Jan 15 09:15:02 imp-rt-01 kernel: ovpnc1: link state changed to UP
    Jan 15 09:15:02 imp-rt-01 check_reload_status: rc.newwanip starting ovpnc1
    Jan 15 09:15:02 imp-rt-01 check_reload_status: rc.newwanip starting ovpnc2
    Jan 15 09:15:03 imp-rt-01 php: : ROUTING: setting default route to 192.168.12.1
    Jan 15 09:15:05 imp-rt-01 check_reload_status: Updating all dyndns
    Jan 15 09:15:06 imp-rt-01 php: : DynDns debug information (ntc-imp-inf.dyndns-ip.com): 49.244.247.158 extracted from checkip.dyndns.org
    Jan 15 09:15:06 imp-rt-01 php: : DynDns (ntc-imp-inf.dyndns-ip.com): Current WAN IP: 49.244.247.158 Cached IP: 49.244.247.158 
    Jan 15 09:15:06 imp-rt-01 php: : phpDynDNS: No change in my IP address and/or 25 days has not passed. Not updating dynamic DNS entry.
    Jan 15 09:15:12 imp-rt-01 php: : rc.newwanip: Informational is starting ovpnc2.
    Jan 15 09:15:12 imp-rt-01 php: : rc.newwanip: on (IP address: 10.49.240.30) (interface: ) (real interface: ovpnc2).
    Jan 15 09:15:12 imp-rt-01 php: : rc.newwanip: Informational is starting ovpnc1.
    Jan 15 09:15:12 imp-rt-01 check_reload_status: Reloading filter
    Jan 15 09:15:12 imp-rt-01 php: : rc.newwanip: on (IP address: 10.49.243.30) (interface: ) (real interface: ovpnc1).
    Jan 15 09:15:12 imp-rt-01 php: : pfSense package system has detected an ip change  ->   ... Restarting packages.
    Jan 15 09:15:12 imp-rt-01 php: : pfSense package system has detected an ip change  ->   ... Restarting packages.
    Jan 15 09:15:12 imp-rt-01 check_reload_status: Starting packages
    Jan 15 09:15:12 imp-rt-01 php: : Resyncing OpenVPN instances for interface WAN.
    Jan 15 09:15:12 imp-rt-01 kernel: ovpnc1: link state changed to DOWN
    Jan 15 09:15:12 imp-rt-01 check_reload_status: Restarting ipsec tunnels
    Jan 15 09:15:13 imp-rt-01 php: : The command '/sbin/route -q delete 10.49.243.30' returned exit code '1', the output was 'route: writing to routing socket: No such process' 
    Jan 15 09:15:13 imp-rt-01 kernel: ovpnc1: link state changed to UP
    Jan 15 09:15:13 imp-rt-01 kernel: ovpnc2: link state changed to DOWN
    Jan 15 09:15:13 imp-rt-01 check_reload_status: rc.newwanip starting ovpnc1
    Jan 15 09:15:13 imp-rt-01 php: : The command '/sbin/route -q delete 10.49.240.30' returned exit code '1', the output was 'route: writing to routing socket: No such process' 
    Jan 15 09:15:13 imp-rt-01 kernel: ovpnc2: link state changed to UP
    Jan 15 09:15:13 imp-rt-01 check_reload_status: rc.newwanip starting ovpnc2
    Jan 15 09:15:14 imp-rt-01 php: : Creating rrd update script
    Jan 15 09:15:14 imp-rt-01 php: : pfSense package system has detected an ip change 0.0.0.0 ->   ... Restarting packages.
    Jan 15 09:15:17 imp-rt-01 php: : DynDns: updatedns() starting
    Jan 15 09:15:18 imp-rt-01 php: : DynDns debug information (ntc-imp-inf.dyndns-ip.com): 49.244.247.158 extracted from checkip.dyndns.org
    Jan 15 09:15:18 imp-rt-01 php: : DynDNS (ntc-imp-inf.dyndns-ip.com): running get_failover_interface for wan. found vr1
    Jan 15 09:15:18 imp-rt-01 php: : DynDns debug information (ntc-imp-inf.dyndns-ip.com): 49.244.247.158 extracted from checkip.dyndns.org
    Jan 15 09:15:19 imp-rt-01 php: : DynDns (ntc-imp-inf.dyndns-ip.com): Current WAN IP: 49.244.247.158 Cached IP: 49.244.247.158 
    Jan 15 09:15:19 imp-rt-01 php: : phpDynDNS: No change in my IP address and/or 25 days has not passed. Not updating dynamic DNS entry.
    Jan 15 09:15:26 imp-rt-01 php: : Restarting/Starting all packages.
    Jan 15 09:15:27 imp-rt-01 php: : rc.newwanip: Informational is starting ovpnc2.
    Jan 15 09:15:27 imp-rt-01 php: : rc.newwanip: on (IP address: 10.49.240.30) (interface: ) (real interface: ovpnc2).
    Jan 15 09:15:27 imp-rt-01 check_reload_status: Reloading filter
    Jan 15 09:15:27 imp-rt-01 php: : rc.newwanip: Informational is starting ovpnc1.
    Jan 15 09:15:27 imp-rt-01 php: : rc.newwanip: on (IP address: 10.49.243.30) (interface: ) (real interface: ovpnc1).
    Jan 15 09:15:27 imp-rt-01 php: : pfSense package system has detected an ip change  ->   ... Restarting packages.
    Jan 15 09:15:27 imp-rt-01 check_reload_status: Starting packages
    Jan 15 09:15:27 imp-rt-01 php: : pfSense package system has detected an ip change  ->   ... Restarting packages.
    Jan 15 09:15:38 imp-rt-01 php: : Restarting/Starting all packages.
    Jan 15 09:15:48 imp-rt-01 php: : Creating rrd update script
    Jan 15 09:15:50 imp-rt-01 php: : Restarting/Starting all packages.
    Jan 15 09:15:57 imp-rt-01 login: login on console as root
    Jan 15 09:16:12 imp-rt-01 php: /index.php: Successful login for user 'admin' from: 10.49.112.111
    Jan 15 09:16:12 imp-rt-01 php: /index.php: Successful login for user 'admin' from: 10.49.112.111</elite></amd></amd></amd></amd></at></isa></amd></amd></ohci></ohci></ata></ata></amd></isa></pci-isa></atheros></generic></mii></via></generic></mii></via></generic></mii></via></encrypt></pci></host></software></mmx+,3dnow!+,3dnow!></fpu,de,pse,tsc,msr,cx8,sep,pge,cmov,clflush,mmx>
    

    If I boot the previous slice:
    2.1-BETA1 (i386)
    built on Sun Jan 13 19:34:21 EST 2013
    The WiFi comes up fine.
    I know there are a few underlying changes to stuff in this new snap, but I can't see anything in GitHub that is particularly WiFi-related.
    Any ideas?



  • i tried the latest snap and same issue with me, i have to goto wifi and click save to get it up



  • The syslog for the Jan 13 snapshot has extra references to ath0 and opt2:

    Jan 15 17:37:53 imp-rt-01 syslogd: kernel boot file is /boot/kernel/kernel
    Jan 15 17:37:53 imp-rt-01 kernel: Copyright (c) 1992-2012 The FreeBSD Project.
    Jan 15 17:37:53 imp-rt-01 kernel: Copyright (c) 1979, 1980, 1983, 1986, 1988, 1989, 1991, 1992, 1993, 1994
    Jan 15 17:37:53 imp-rt-01 kernel: The Regents of the University of California. All rights reserved.
    Jan 15 17:37:53 imp-rt-01 kernel: FreeBSD is a registered trademark of The FreeBSD Foundation.
    Jan 15 17:37:53 imp-rt-01 kernel: FreeBSD 8.3-RELEASE-p5 #0: Sun Jan 13 20:21:12 EST 2013
    Jan 15 17:37:53 imp-rt-01 kernel: root@snapshots-8_3-i386.builders.pfsense.org:/usr/obj./usr/pfSensesrc/src/sys/pfSense_wrap.8.i386 i386
    Jan 15 17:37:53 imp-rt-01 kernel: Timecounter "i8254" frequency 1193182 Hz quality 0
    Jan 15 17:37:53 imp-rt-01 kernel: CPU: Geode(TM) Integrated Processor by AMD PCS (498.05-MHz 586-class CPU)
    Jan 15 17:37:53 imp-rt-01 kernel: Origin = "AuthenticAMD"  Id = 0x5a2  Family = 5  Model = a  Stepping = 2
    Jan 15 17:37:53 imp-rt-01 kernel: Features=0x88a93d <fpu,de,pse,tsc,msr,cx8,sep,pge,cmov,clflush,mmx>Jan 15 17:37:53 imp-rt-01 kernel: AMD Features=0xc0400000 <mmx+,3dnow!+,3dnow!>Jan 15 17:37:53 imp-rt-01 kernel: real memory  = 268435456 (256 MB)
    Jan 15 17:37:53 imp-rt-01 kernel: avail memory = 239239168 (228 MB)
    Jan 15 17:37:53 imp-rt-01 kernel: pnpbios: Bad PnP BIOS data checksum
    Jan 15 17:37:53 imp-rt-01 kernel: ipw_bss: You need to read the LICENSE file in /usr/share/doc/legal/intel_ipw/.
    Jan 15 17:37:53 imp-rt-01 kernel: ipw_bss: If you agree with the license, set legal.intel_ipw.license_ack=1 in /boot/loader.conf.
    Jan 15 17:37:53 imp-rt-01 kernel: module_register_init: MOD_LOAD (ipw_bss_fw, 0xc0731270, 0) error 1
    Jan 15 17:37:53 imp-rt-01 kernel: ipw_ibss: You need to read the LICENSE file in /usr/share/doc/legal/intel_ipw/.
    Jan 15 17:37:53 imp-rt-01 kernel: ipw_ibss: If you agree with the license, set legal.intel_ipw.license_ack=1 in /boot/loader.conf.
    Jan 15 17:37:53 imp-rt-01 kernel: module_register_init: MOD_LOAD (ipw_ibss_fw, 0xc0731310, 0) error 1
    Jan 15 17:37:53 imp-rt-01 kernel: ipw_monitor: You need to read the LICENSE file in /usr/share/doc/legal/intel_ipw/.
    Jan 15 17:37:53 imp-rt-01 kernel: ipw_monitor: If you agree with the license, set legal.intel_ipw.license_ack=1 in /boot/loader.conf.
    Jan 15 17:37:53 imp-rt-01 kernel: module_register_init: MOD_LOAD (ipw_monitor_fw, 0xc07313b0, 0) error 1
    Jan 15 17:37:53 imp-rt-01 kernel: wlan: mac acl policy registered
    Jan 15 17:37:53 imp-rt-01 kernel: K6-family MTRR support enabled (2 registers)
    Jan 15 17:37:53 imp-rt-01 kernel: ACPI Error: A valid RSDP was not found (20101013/tbxfroot-309)
    Jan 15 17:37:53 imp-rt-01 kernel: ACPI: Table initialisation failed: AE_NOT_FOUND
    Jan 15 17:37:53 imp-rt-01 kernel: ACPI: Try disabling either ACPI or apic support.
    Jan 15 17:37:53 imp-rt-01 kernel: cryptosoft0: <software crypto=""> on motherboard
    Jan 15 17:37:53 imp-rt-01 kernel: padlock0: No ACE support.
    Jan 15 17:37:53 imp-rt-01 kernel: pcib0: <host to="" pci="" bridge=""> pcibus 0 on motherboard
    Jan 15 17:37:53 imp-rt-01 kernel: pci0: <pci bus=""> on pcib0
    Jan 15 17:37:53 imp-rt-01 kernel: Geode LX: PC Engines ALIX.2 v0.99h tinyBIOS V1.4a (C)1997-2007
    Jan 15 17:37:53 imp-rt-01 kernel: pci0: <encrypt decrypt,="" entertainment="" crypto=""> at device 1.2 (no driver attached)
    Jan 15 17:37:53 imp-rt-01 kernel: vr0: <via 10="" vt6105m="" rhine="" iii="" 100basetx=""> port 0x1000-0x10ff mem 0xe0000000-0xe00000ff irq 10 at device 9.0 on pci0
    Jan 15 17:37:53 imp-rt-01 kernel: vr0: Quirks: 0x2
    Jan 15 17:37:53 imp-rt-01 kernel: vr0: Revision: 0x96
    Jan 15 17:37:53 imp-rt-01 kernel: miibus0: <mii bus=""> on vr0
    Jan 15 17:37:53 imp-rt-01 kernel: ukphy0: <generic ieee="" 802.3u="" media="" interface=""> PHY 1 on miibus0
    Jan 15 17:37:53 imp-rt-01 kernel: ukphy0:  none, 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto, auto-flow
    Jan 15 17:37:53 imp-rt-01 kernel: vr0: [ITHREAD]
    Jan 15 17:37:53 imp-rt-01 kernel: vr1: <via 10="" vt6105m="" rhine="" iii="" 100basetx=""> port 0x1400-0x14ff mem 0xe0040000-0xe00400ff irq 11 at device 10.0 on pci0
    Jan 15 17:37:53 imp-rt-01 kernel: vr1: Quirks: 0x2
    Jan 15 17:37:53 imp-rt-01 kernel: vr1: Revision: 0x96
    Jan 15 17:37:53 imp-rt-01 kernel: miibus1: <mii bus=""> on vr1
    Jan 15 17:37:53 imp-rt-01 kernel: ukphy1: <generic ieee="" 802.3u="" media="" interface=""> PHY 1 on miibus1
    Jan 15 17:37:53 imp-rt-01 kernel: ukphy1:  none, 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto, auto-flow
    Jan 15 17:37:53 imp-rt-01 kernel: vr1: [ITHREAD]
    Jan 15 17:37:53 imp-rt-01 kernel: vr2: <via 10="" vt6105m="" rhine="" iii="" 100basetx=""> port 0x1800-0x18ff mem 0xe0080000-0xe00800ff irq 15 at device 11.0 on pci0
    Jan 15 17:37:53 imp-rt-01 kernel: vr2: Quirks: 0x2
    Jan 15 17:37:53 imp-rt-01 kernel: vr2: Revision: 0x96
    Jan 15 17:37:53 imp-rt-01 kernel: miibus2: <mii bus=""> on vr2
    Jan 15 17:37:53 imp-rt-01 kernel: ukphy2: <generic ieee="" 802.3u="" media="" interface=""> PHY 1 on miibus2
    Jan 15 17:37:53 imp-rt-01 kernel: ukphy2:  none, 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto, auto-flow
    Jan 15 17:37:53 imp-rt-01 kernel: vr2: [ITHREAD]
    Jan 15 17:37:53 imp-rt-01 kernel: ath0: <atheros 5212=""> mem 0xe00c0000-0xe00cffff irq 9 at device 12.0 on pci0
    Jan 15 17:37:53 imp-rt-01 kernel: ath0: [ITHREAD]
    Jan 15 17:37:53 imp-rt-01 kernel: ath0: AR5212 mac 5.9 RF5112 phy 4.3
    Jan 15 17:37:53 imp-rt-01 kernel: isab0: <pci-isa bridge=""> port 0x6000-0x6007,0x6100-0x61ff,0x6200-0x623f,0x9d00-0x9d7f,0x9c00-0x9c3f at device 15.0 on pci0
    Jan 15 17:37:53 imp-rt-01 kernel: isa0: <isa bus=""> on isab0
    Jan 15 17:37:53 imp-rt-01 kernel: atapci0: <amd cs5536="" udma100="" controller=""> port 0x1f0-0x1f7,0x3f6,0x170-0x177,0x376,0xff00-0xff0f at device 15.2 on pci0
    Jan 15 17:37:53 imp-rt-01 kernel: ata0: <ata channel=""> at channel 0 on atapci0
    Jan 15 17:37:53 imp-rt-01 kernel: ata0: [ITHREAD]
    Jan 15 17:37:53 imp-rt-01 kernel: ata1: <ata channel=""> at channel 1 on atapci0
    Jan 15 17:37:53 imp-rt-01 kernel: ata1: [ITHREAD]
    Jan 15 17:37:53 imp-rt-01 kernel: ohci0: <ohci (generic)="" usb="" controller=""> mem 0xefffe000-0xefffefff irq 12 at device 15.4 on pci0
    Jan 15 17:37:53 imp-rt-01 kernel: ohci0: [ITHREAD]
    Jan 15 17:37:53 imp-rt-01 kernel: usbus0: <ohci (generic)="" usb="" controller=""> on ohci0
    Jan 15 17:37:53 imp-rt-01 kernel: ehci0: <amd cs5536="" (geode)="" usb="" 2.0="" controller=""> mem 0xefffd000-0xefffdfff irq 12 at device 15.5 on pci0
    Jan 15 17:37:53 imp-rt-01 kernel: ehci0: [ITHREAD]
    Jan 15 17:37:53 imp-rt-01 kernel: usbus1: EHCI version 1.0
    Jan 15 17:37:53 imp-rt-01 kernel: usbus1: <amd cs5536="" (geode)="" usb="" 2.0="" controller=""> on ehci0
    Jan 15 17:37:53 imp-rt-01 kernel: cpu0 on motherboard
    Jan 15 17:37:53 imp-rt-01 kernel: orm0: <isa option="" rom=""> at iomem 0xe0000-0xea7ff pnpid ORM0000 on isa0
    Jan 15 17:37:53 imp-rt-01 kernel: atrtc0: <at real="" time="" clock=""> at port 0x70 irq 8 on isa0
    Jan 15 17:37:53 imp-rt-01 kernel: ppc0: parallel port not found.
    Jan 15 17:37:53 imp-rt-01 kernel: uart0: <16550 or compatible> at port 0x3f8-0x3ff irq 4 flags 0x10 on isa0
    Jan 15 17:37:53 imp-rt-01 kernel: uart0: [FILTER]
    Jan 15 17:37:53 imp-rt-01 kernel: uart0: console (9600,n,8,1)
    Jan 15 17:37:53 imp-rt-01 kernel: uart1: <16550 or compatible> at port 0x2f8-0x2ff irq 3 on isa0
    Jan 15 17:37:53 imp-rt-01 kernel: uart1: [FILTER]
    Jan 15 17:37:53 imp-rt-01 kernel: Timecounter "TSC" frequency 498052892 Hz quality 800
    Jan 15 17:37:53 imp-rt-01 kernel: Timecounters tick every 10.000 msec
    Jan 15 17:37:53 imp-rt-01 kernel: IPsec: Initialized Security Association Processing.
    Jan 15 17:37:53 imp-rt-01 kernel: usbus0: 12Mbps Full Speed USB v1.0
    Jan 15 17:37:53 imp-rt-01 kernel: usbus1: 480Mbps High Speed USB v2.0
    Jan 15 17:37:53 imp-rt-01 kernel: ugen0.1: <amd> at usbus0
    Jan 15 17:37:53 imp-rt-01 kernel: uhub0: <amd 1="" 9="" ohci="" root="" hub,="" class="" 0,="" rev="" 1.00="" 1.00,="" addr=""> on usbus0
    Jan 15 17:37:53 imp-rt-01 kernel: ugen1.1: <amd> at usbus1
    Jan 15 17:37:53 imp-rt-01 kernel: uhub1: <amd 1="" 9="" ehci="" root="" hub,="" class="" 0,="" rev="" 2.00="" 1.00,="" addr=""> on usbus1
    Jan 15 17:37:53 imp-rt-01 kernel: ad0: 3811MB <elite pro="" cf="" card="" ver6.04k=""> at ata0-master PIO4 
    Jan 15 17:37:53 imp-rt-01 kernel: GEOM: ad0s1: media size does not match label.
    Jan 15 17:37:53 imp-rt-01 kernel: GEOM: ad0s2: media size does not match label.
    Jan 15 17:37:53 imp-rt-01 kernel: uhub0: 4 ports with 4 removable, self powered
    Jan 15 17:37:53 imp-rt-01 kernel: Root mount waiting for: usbus1
    Jan 15 17:37:53 imp-rt-01 kernel: Root mount waiting for: usbus1
    Jan 15 17:37:53 imp-rt-01 kernel: uhub1: 4 ports with 4 removable, self powered
    Jan 15 17:37:53 imp-rt-01 kernel: Trying to mount root from ufs:/dev/ufs/pfsense1
    Jan 15 17:37:53 imp-rt-01 php: : Deny router advertisements for interface wan
    Jan 15 17:37:53 imp-rt-01 check_reload_status: Linkup starting vr1
    Jan 15 17:37:53 imp-rt-01 kernel: vr1: link state changed to DOWN
    Jan 15 17:37:56 imp-rt-01 sshd[8300]: Server listening on :: port 22.
    Jan 15 17:37:56 imp-rt-01 sshlockout[8664]: sshlockout/webConfigurator v3.0 starting up
    Jan 15 17:37:56 imp-rt-01 sshd[8300]: Server listening on 0.0.0.0 port 22.
    Jan 15 17:37:56 imp-rt-01 check_reload_status: Linkup starting vr1
    Jan 15 17:37:56 imp-rt-01 kernel: vr1: link state changed to UP
    Jan 15 17:37:56 imp-rt-01 dhclient: PREINIT
    Jan 15 17:37:56 imp-rt-01 dhclient: Starting delete_old_states()
    Jan 15 17:37:56 imp-rt-01 dhclient: Comparing Routers: Old:  New: 
    Jan 15 17:37:56 imp-rt-01 dhclient[7034]: DHCPDISCOVER on vr1 to 255.255.255.255 port 67 interval 2
    Jan 15 17:37:56 imp-rt-01 dhclient[7034]: DHCPOFFER from 192.168.12.1
    Jan 15 17:37:56 imp-rt-01 dhclient: ARPSEND
    Jan 15 17:37:58 imp-rt-01 dhclient: ARPCHECK
    Jan 15 17:37:58 imp-rt-01 dhclient[7034]: DHCPREQUEST on vr1 to 255.255.255.255 port 67
    Jan 15 17:37:58 imp-rt-01 dhclient[7034]: DHCPACK from 192.168.12.1
    Jan 15 17:37:58 imp-rt-01 dhclient: BOUND
    Jan 15 17:37:58 imp-rt-01 dhclient: Starting delete_old_states()
    Jan 15 17:37:58 imp-rt-01 dhclient: Comparing Routers: Old:  New: 192.168.12.1
    Jan 15 17:37:58 imp-rt-01 dhclient: Removing states through old gateway '' (new gateway '192.168.12.1')
    Jan 15 17:37:58 imp-rt-01 dhclient: Starting add_new_address()
    Jan 15 17:37:58 imp-rt-01 dhclient: ifconfig vr1 inet 192.168.12.203 netmask 255.255.255.0 broadcast 192.168.12.255 
    Jan 15 17:37:58 imp-rt-01 dhclient: New IP Address (vr1): 192.168.12.203
    Jan 15 17:37:58 imp-rt-01 dhclient: New Subnet Mask (vr1): 255.255.255.0
    Jan 15 17:37:58 imp-rt-01 dhclient: New Broadcast Address (vr1): 192.168.12.255
    Jan 15 17:37:58 imp-rt-01 dhclient: New Routers (vr1): 192.168.12.1
    Jan 15 17:37:59 imp-rt-01 dhclient: Adding new routes to interface: vr1
    Jan 15 17:37:59 imp-rt-01 dhclient: /sbin/route add default 192.168.12.1
    Jan 15 17:37:59 imp-rt-01 dhclient: Creating resolv.conf
    Jan 15 17:37:59 imp-rt-01 dhclient[7034]: bound to 192.168.12.203 -- renewal in 129600 seconds.
    Jan 15 17:37:59 imp-rt-01 php: : Deny router advertisements for interface lan
    Jan 15 17:37:59 imp-rt-01 php: : Deny router advertisements for interface opt1
    Jan 15 17:37:59 imp-rt-01 kernel: vr0: link state changed to DOWN
    Jan 15 17:37:59 imp-rt-01 check_reload_status: rc.newwanip starting vr1
    Jan 15 17:37:59 imp-rt-01 kernel: vr2: link state changed to DOWN
    Jan 15 17:37:59 imp-rt-01 check_reload_status: Linkup starting vr0
    Jan 15 17:37:59 imp-rt-01 check_reload_status: Linkup starting vr2
    Jan 15 17:38:02 imp-rt-01 check_reload_status: Linkup starting vr0
    Jan 15 17:38:02 imp-rt-01 kernel: vr0: link state changed to UP
    Jan 15 17:38:07 imp-rt-01 php: : rc.newwanip: Informational is starting vr1.
    Jan 15 17:38:07 imp-rt-01 php: : rc.newwanip: on (IP address: 192.168.12.203) (interface: wan) (real interface: vr1).
    Jan 15 17:38:07 imp-rt-01 php: : ROUTING: setting default route to 192.168.12.1
    Jan 15 17:38:07 imp-rt-01 php: : Removing static route for monitor 8.8.8.8 and adding a new route through 192.168.12.1
    Jan 15 17:38:08 imp-rt-01 check_reload_status: Reloading filter
    Jan 15 17:38:08 imp-rt-01 php: : DynDns: updatedns() starting
    Jan 15 17:38:10 imp-rt-01 php: : The command '/sbin/dhclient -c /var/etc/dhclient_opt1.conf vr2 > /tmp/vr2_output > /tmp/vr2_error_output' returned exit code '1', the output was '' 
    Jan 15 17:38:10 imp-rt-01 php: : Deny router advertisements for interface opt2
    Jan 15 17:38:10 imp-rt-01 php: : The command '/sbin/ifconfig 'ath0_wlan0' inet6 -accept_rtadv' returned exit code '1', the output was 'ifconfig: interface ath0_wlan0 does not exist' 
    Jan 15 17:38:10 imp-rt-01 php: : Cloning new wireless interface ath0_wlan0
    Jan 15 17:38:10 imp-rt-01 kernel: wlan0: changing name to 'ath0_wlan0'
    Jan 15 17:38:10 imp-rt-01 php: : The command '/sbin/ifconfig 'ath0_wlan0' country 'NP' 'indoor'' returned exit code '1', the output was 'ifconfig: SIOCS80211: Invalid argument' 
    Jan 15 17:38:12 imp-rt-01 php: : Resyncing OpenVPN instances.
    Jan 15 17:38:12 imp-rt-01 kernel: tun1: changing name to 'ovpnc1'
    Jan 15 17:38:12 imp-rt-01 php: : The command '/sbin/route -q delete 10.49.243.30' returned exit code '1', the output was 'route: writing to routing socket: No such process' 
    Jan 15 17:38:12 imp-rt-01 kernel: tun2: changing name to 'ovpnc2'
    Jan 15 17:38:12 imp-rt-01 php: : The command '/sbin/route -q delete 10.49.240.30' returned exit code '1', the output was 'route: writing to routing socket: No such process' 
    Jan 15 17:38:12 imp-rt-01 kernel: pflog0: promiscuous mode enabled
    Jan 15 17:38:14 imp-rt-01 php: : Removing static route for monitor 8.8.8.8 and adding a new route through 192.168.12.1
    Jan 15 17:38:17 imp-rt-01 kernel: ovpnc1: link state changed to UP
    Jan 15 17:38:17 imp-rt-01 check_reload_status: rc.newwanip starting ovpnc1
    Jan 15 17:38:17 imp-rt-01 php: : DynDns debug information (ntc-imp-inf.dyndns-ip.com): 49.244.247.158 extracted from checkip.dyndns.org
    Jan 15 17:38:17 imp-rt-01 php: : DynDNS (ntc-imp-inf.dyndns-ip.com): running get_failover_interface for wan. found vr1
    Jan 15 17:38:17 imp-rt-01 kernel: ovpnc2: link state changed to UP
    Jan 15 17:38:17 imp-rt-01 check_reload_status: rc.newwanip starting ovpnc2
    Jan 15 17:38:19 imp-rt-01 lighttpd[42145]: (log.c.166) server started 
    Jan 15 17:38:19 imp-rt-01 php: : ROUTING: setting default route to 192.168.12.1
    Jan 15 17:38:21 imp-rt-01 check_reload_status: Updating all dyndns
    Jan 15 17:38:23 imp-rt-01 php: : DynDns debug information (ntc-imp-inf.dyndns-ip.com): 49.244.247.158 extracted from checkip.dyndns.org
    Jan 15 17:38:23 imp-rt-01 php: : DynDns (ntc-imp-inf.dyndns-ip.com): Current WAN IP: 49.244.247.158 Cached IP: 49.244.247.158 
    Jan 15 17:38:23 imp-rt-01 php: : phpDynDNS: No change in my IP address and/or 25 days has not passed. Not updating dynamic DNS entry.
    Jan 15 17:38:25 imp-rt-01 check_reload_status: Restarting ipsec tunnels
    Jan 15 17:38:29 imp-rt-01 php: : Resyncing OpenVPN instances for interface WAN.
    Jan 15 17:38:29 imp-rt-01 kernel: ovpnc1: link state changed to DOWN
    Jan 15 17:38:29 imp-rt-01 check_reload_status: Reloading filter
    Jan 15 17:38:29 imp-rt-01 php: : The command '/sbin/route -q delete 10.49.243.30' returned exit code '1', the output was 'route: writing to routing socket: No such process' 
    Jan 15 17:38:29 imp-rt-01 kernel: ovpnc1: link state changed to UP
    Jan 15 17:38:29 imp-rt-01 kernel: ovpnc2: link state changed to DOWN
    Jan 15 17:38:30 imp-rt-01 php: : The command '/sbin/route -q delete 10.49.240.30' returned exit code '1', the output was 'route: writing to routing socket: No such process' 
    Jan 15 17:38:30 imp-rt-01 check_reload_status: rc.newwanip starting ovpnc1
    Jan 15 17:38:30 imp-rt-01 php: : rc.newwanip: Informational is starting ovpnc2.
    Jan 15 17:38:30 imp-rt-01 kernel: ovpnc2: link state changed to UP
    Jan 15 17:38:30 imp-rt-01 php: : rc.newwanip: on (IP address: ) (interface: ) (real interface: ovpnc2).
    Jan 15 17:38:30 imp-rt-01 php: : rc.newwanip: Failed to update  IP, restarting...
    Jan 15 17:38:30 imp-rt-01 php: : send_event: sent interface reconfigure  got ERROR:	incomplete command.
    Jan 15 17:38:30 imp-rt-01 php: : rc.newwanip: Informational is starting ovpnc1.
    Jan 15 17:38:31 imp-rt-01 php: : rc.newwanip: on (IP address: 10.49.243.30) (interface: ) (real interface: ovpnc1).
    Jan 15 17:38:31 imp-rt-01 check_reload_status: rc.newwanip starting ovpnc2
    Jan 15 17:38:31 imp-rt-01 php: : pfSense package system has detected an ip change  ->   ... Restarting packages.
    Jan 15 17:38:31 imp-rt-01 check_reload_status: Starting packages
    Jan 15 17:38:32 imp-rt-01 php: : DynDns: updatedns() starting
    Jan 15 17:38:32 imp-rt-01 php: : Creating rrd update script
    Jan 15 17:38:32 imp-rt-01 php: : rrdtool restore -f '/var/db/rrd//ipsec-packets.xml' '/var/db/rrd//ipsec-packets.rrd' failed returning 15.
    Jan 15 17:38:32 imp-rt-01 php: : pfSense package system has detected an ip change 0.0.0.0 ->   ... Restarting packages.
    Jan 15 17:38:32 imp-rt-01 php: : DynDns debug information (ntc-imp-inf.dyndns-ip.com): 49.244.247.158 extracted from checkip.dyndns.org
    Jan 15 17:38:33 imp-rt-01 php: : DynDNS (ntc-imp-inf.dyndns-ip.com): running get_failover_interface for wan. found vr1
    Jan 15 17:38:33 imp-rt-01 php: : DynDns debug information (ntc-imp-inf.dyndns-ip.com): 49.244.247.158 extracted from checkip.dyndns.org
    Jan 15 17:38:33 imp-rt-01 php: : DynDns (ntc-imp-inf.dyndns-ip.com): Current WAN IP: 49.244.247.158 Cached IP: 49.244.247.158 
    Jan 15 17:38:33 imp-rt-01 php: : phpDynDNS: No change in my IP address and/or 25 days has not passed. Not updating dynamic DNS entry.
    Jan 15 17:38:42 imp-rt-01 php: : rc.newwanip: Informational is starting ovpnc1.
    Jan 15 17:38:42 imp-rt-01 php: : rc.newwanip: on (IP address: 10.49.243.30) (interface: ) (real interface: ovpnc1).
    Jan 15 17:38:42 imp-rt-01 check_reload_status: Reloading filter
    Jan 15 17:38:42 imp-rt-01 php: : pfSense package system has detected an ip change  ->   ... Restarting packages.
    Jan 15 17:38:42 imp-rt-01 check_reload_status: Starting packages
    Jan 15 17:38:43 imp-rt-01 php: : rc.newwanip: Informational is starting ovpnc2.
    Jan 15 17:38:43 imp-rt-01 php: : rc.newwanip: on (IP address: 10.49.240.30) (interface: ) (real interface: ovpnc2).
    Jan 15 17:38:44 imp-rt-01 php: : pfSense package system has detected an ip change  ->   ... Restarting packages.
    Jan 15 17:38:44 imp-rt-01 php: : Restarting/Starting all packages.
    Jan 15 17:38:53 imp-rt-01 php: : Restarting/Starting all packages.
    Jan 15 17:39:03 imp-rt-01 php: : Creating rrd update script
    Jan 15 17:39:05 imp-rt-01 php: : Restarting/Starting all packages.
    Jan 15 17:39:13 imp-rt-01 login: login on console as root
    Jan 15 17:39:49 imp-rt-01 sshd[60982]: Accepted keyboard-interactive/pam for admin from 10.49.80.163 port 58158 ssh2
    Jan 15 17:40:02 imp-rt-01 php: : DynDns: updatedns() starting
    Jan 15 17:40:03 imp-rt-01 php: : DynDns debug information (ntc-imp-inf.dyndns-ip.com): 49.244.247.158 extracted from checkip.dyndns.org
    Jan 15 17:40:03 imp-rt-01 php: : DynDNS (ntc-imp-inf.dyndns-ip.com): running get_failover_interface for wan. found vr1
    Jan 15 17:40:03 imp-rt-01 php: : DynDns debug information (ntc-imp-inf.dyndns-ip.com): 49.244.247.158 extracted from checkip.dyndns.org
    Jan 15 17:40:03 imp-rt-01 php: : DynDns (ntc-imp-inf.dyndns-ip.com): Current WAN IP: 49.244.247.158 Cached IP: 49.244.247.158 
    Jan 15 17:40:03 imp-rt-01 php: : phpDynDNS: No change in my IP address and/or 25 days has not passed. Not updating dynamic DNS entry</elite></amd></amd></amd></amd></at></isa></amd></amd></ohci></ohci></ata></ata></amd></isa></pci-isa></atheros></generic></mii></via></generic></mii></via></generic></mii></via></encrypt></pci></host></software></mmx+,3dnow!+,3dnow!></fpu,de,pse,tsc,msr,cx8,sep,pge,cmov,clflush,mmx>
    

    "Deny router advertisements for…" appears for wan, lan, opt1 and opt2.
    In Jan 14 syslog, there is no message about opt2, and no subsequent "ath0" messages.
    The code in this commit looks like a problem: https://github.com/bsdperimeter/pfsense/commit/8e9d1265506035ace51a8e94aa9714cca5f38734

    if (!does_interface_exist($realhwif))
      return 0;
    

    This is new code, I am guessing that it returns for the opt2/ath0 case (unfortunately!).
    I commented out those 2 new lines, rebooted and WiFi (opt2, ath0) starts at boot.
    Can someone look at why that code was added and sort it out?



  • At boot time, the value of $realhwif is ath0_wlan0
    Executing this code shows that this interface name is found after the system is up, but I suspect that it does not exist yet at boot time, until the items at 10, 11 and 12 are created? It needs to somehow just match the "ath0" bit.

    $zz = get_interface_arr(true);
    var_dump($zz);
    array(13) {
      [0]=>
      string(3) "vr0"
      [1]=>
      string(3) "vr1"
      [2]=>
      string(3) "vr2"
      [3]=>
      string(4) "ath0"
      [4]=>
      string(6) "usbus0"
      [5]=>
      string(6) "usbus1"
      [6]=>
      string(4) "enc0"
      [7]=>
      string(6) "pflog0"
      [8]=>
      string(7) "pfsync0"
      [9]=>
      string(3) "lo0"
      [10]=>
      string(10) "ath0_wlan0"
      [11]=>
      string(6) "ovpnc1"
      [12]=>
      string(6) "ovpnc2"
    }
    

  • Administrator

    I reverted this change for now.

    Thanks!



  • Thanks, latest snapshot works fine.


Locked