Random reboots



  • I have been having random reboots on my Alix 2D13 with a USB wifi adapter based on RT3070 chipset (run driver).
    I managed to capture these:

    Fatal trap 12: page fault while in kernel mode
    cpuid = 0; apic id = 00
    fault virtual address   = 0xc54cf908
    fault code              = supervisor read, page not present
    instruction pointer     = 0x20:0xc088e9fe
    stack pointer           = 0x28:0xe39c8c38
    frame pointer           = 0x28:0xe39c8c64
    code segment            = base 0x0, limit 0xfffff, type 0x1b
                           = DPL 0, pres 1, def32 1, gran 1
    processor eflags        = interrupt enabled, resume, IOPL = 0
    current process         = 0 (run0 taskq)
    trap number             = 12
    panic: page fault
    cpuid = 0
    Uptime: 22m1s
    Cannot dump. Device not defined or unavailable.

    Fatal trap 12: page fault while in kernel mode
    cpuid = 0; apic id = 00
    fault virtual address   = 0xc5a39908
    fault code              = supervisor read, page not present
    instruction pointer     = 0x20:0xc088ed6e
    stack pointer           = 0x28:0xe39c8c38
    frame pointer           = 0x28:0xe39c8c64
    code segment            = base 0x0, limit 0xfffff, type 0x1b
                           = DPL 0, pres 1, def32 1, gran 1
    processor eflags        = interrupt enabled, resume, IOPL = 0
    current process         = 0 (run0 taskq)
    trap number             = 12
    panic: page fault
    cpuid = 0
    Uptime: 9h21m52s
    Cannot dump. Device not defined or unavailable.

    I'm not sure if it's related, but I also noticed that my logs are full of these messages repeating almost every minute:

    2013-01-27 8:30 PM,Debug,192.168.1.1,run0_wlan0: WPA rekeying GTK
    2013-01-27 8:30 PM,Debug,192.168.1.1,run0_wlan0: STA yy:yy:yy:yy:yy:yy WPA: sending 1/2 msg of Group Key Handshake
    2013-01-27 8:30 PM,Debug,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx WPA: sending 1/2 msg of Group Key Handshake
    2013-01-27 8:30 PM,Debug,192.168.1.1,run0_wlan0: STA yy:yy:yy:yy:yy:yy WPA: EAPOL-Key timeout
    2013-01-27 8:30 PM,Debug,192.168.1.1,run0_wlan0: STA yy:yy:yy:yy:yy:yy WPA: sending 1/2 msg of Group Key Handshake
    2013-01-27 8:30 PM,Debug,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx WPA: EAPOL-Key timeout
    2013-01-27 8:30 PM,Debug,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx WPA: sending 1/2 msg of Group Key Handshake
    2013-01-27 8:30 PM,Debug,192.168.1.1,run0_wlan0: STA yy:yy:yy:yy:yy:yy WPA: EAPOL-Key timeout
    2013-01-27 8:30 PM,Debug,192.168.1.1,run0_wlan0: STA yy:yy:yy:yy:yy:yy WPA: sending 1/2 msg of Group Key Handshake
    2013-01-27 8:30 PM,Debug,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx WPA: EAPOL-Key timeout
    2013-01-27 8:30 PM,Debug,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx WPA: sending 1/2 msg of Group Key Handshake
    2013-01-27 8:30 PM,Debug,192.168.1.1,run0_wlan0: STA yy:yy:yy:yy:yy:yy WPA: EAPOL-Key timeout
    2013-01-27 8:30 PM,Debug,192.168.1.1,run0_wlan0: STA yy:yy:yy:yy:yy:yy WPA: sending 1/2 msg of Group Key Handshake
    2013-01-27 8:30 PM,Debug,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx WPA: EAPOL-Key timeout
    2013-01-27 8:30 PM,Debug,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx WPA: sending 1/2 msg of Group Key Handshake
    2013-01-27 8:30 PM,Debug,192.168.1.1,run0_wlan0: STA yy:yy:yy:yy:yy:yy WPA: EAPOL-Key timeout
    2013-01-27 8:30 PM,Debug,192.168.1.1,run0_wlan0: STA yy:yy:yy:yy:yy:yy IEEE 802.1X: unauthorizing port
    2013-01-27 8:30 PM,Debug,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx WPA: EAPOL-Key timeout
    2013-01-27 8:30 PM,Debug,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx IEEE 802.1X: unauthorizing port
    2013-01-27 8:30 PM,Info,192.168.1.1,run0_wlan0: STA yy:yy:yy:yy:yy:yy IEEE 802.11: deassociated
    2013-01-27 8:30 PM,Debug,192.168.1.1,run0_wlan0: STA yy:yy:yy:yy:yy:yy WPA: event 2 notification
    2013-01-27 8:30 PM,Debug,192.168.1.1,run0_wlan0: STA yy:yy:yy:yy:yy:yy IEEE 802.1X: unauthorizing port
    2013-01-27 8:30 PM,Info,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx IEEE 802.11: deauthenticated due to local deauth request
    2013-01-27 8:30 PM,Info,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx IEEE 802.11: deassociated
    2013-01-27 8:30 PM,Info,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx IEEE 802.11: associated
    2013-01-27 8:30 PM,Debug,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx WPA: event 1 notification
    2013-01-27 8:30 PM,Debug,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx WPA: start authentication
    2013-01-27 8:30 PM,Debug,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx IEEE 802.1X: unauthorizing port
    2013-01-27 8:30 PM,Debug,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx WPA: sending 1/4 msg of 4-Way Handshake
    2013-01-27 8:30 PM,Debug,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx WPA: received EAPOL-Key frame (2/4 Pairwise)
    2013-01-27 8:30 PM,Debug,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx WPA: sending 3/4 msg of 4-Way Handshake
    2013-01-27 8:30 PM,Debug,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx WPA: received EAPOL-Key frame (4/4 Pairwise)
    2013-01-27 8:30 PM,Debug,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx IEEE 802.1X: authorizing port
    2013-01-27 8:30 PM,Info,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx RADIUS: starting accounting session 51055164-000001EB
    2013-01-27 8:30 PM,Info,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx WPA: pairwise key handshake completed (RSN)
    2013-01-27 8:30 PM,Info,192.168.1.1,DHCPREQUEST for 192.168.1.8 from xx:xx:xx:xx:xx:xx via bridge0
    2013-01-27 8:30 PM,Info,192.168.1.1,DHCPACK on 192.168.1.8 to xx:xx:xx:xx:xx:xx via bridge0
    2013-01-27 8:31 PM,Debug,192.168.1.1,run0_wlan0: WPA rekeying GTK
    2013-01-27 8:31 PM,Debug,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx WPA: sending 1/2 msg of Group Key Handshake
    2013-01-27 8:31 PM,Debug,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx WPA: EAPOL-Key timeout
    2013-01-27 8:31 PM,Debug,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx WPA: sending 1/2 msg of Group Key Handshake
    2013-01-27 8:31 PM,Debug,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx WPA: EAPOL-Key timeout
    2013-01-27 8:31 PM,Debug,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx WPA: sending 1/2 msg of Group Key Handshake
    2013-01-27 8:31 PM,Debug,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx WPA: EAPOL-Key timeout
    2013-01-27 8:31 PM,Debug,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx WPA: sending 1/2 msg of Group Key Handshake
    2013-01-27 8:31 PM,Debug,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx WPA: EAPOL-Key timeout
    2013-01-27 8:31 PM,Debug,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx IEEE 802.1X: unauthorizing port
    2013-01-27 8:31 PM,Info,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx IEEE 802.11: deauthenticated due to local deauth request
    2013-01-27 8:31 PM,Info,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx IEEE 802.11: deassociated
    2013-01-27 8:31 PM,Info,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx IEEE 802.11: associated
    2013-01-27 8:31 PM,Debug,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx WPA: event 1 notification
    2013-01-27 8:31 PM,Debug,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx WPA: start authentication
    2013-01-27 8:31 PM,Debug,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx IEEE 802.1X: unauthorizing port
    2013-01-27 8:31 PM,Debug,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx WPA: sending 1/4 msg of 4-Way Handshake
    2013-01-27 8:31 PM,Debug,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx WPA: EAPOL-Key timeout
    2013-01-27 8:31 PM,Debug,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx WPA: sending 1/4 msg of 4-Way Handshake
    2013-01-27 8:31 PM,Info,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx IEEE 802.11: deassociated
    2013-01-27 8:31 PM,Debug,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx WPA: event 2 notification
    2013-01-27 8:31 PM,Debug,192.168.1.1,run0_wlan0: STA xx:xx:xx:xx:xx:xx IEEE 802.1X: unauthorizing port

    I suspect it might be related with the USB adapter, but it used to work fine in the past.



  • @MaxPF:

    I suspect it might be related with the USB adapter, but it used to work fine in the past.

    Can you specify what "used to work fine in the past" exactly means? If it worked on a previous 2.1 snapshot, do you know which one was the last one that worked?

    Edit:
    Also without a full crash dump it's normally very hard to debug such problems.


  • Rebel Alliance Developer Netgate

    Since both dumps mention run0, it probably is the USB wireless adapter.



  • I also suspect the USB adapter as the cause of the problem. In Dec-Jan I tried many 2.1 builds and up to a certain point and up to a certain point there were no reboots, but then it started (can't remember exactly when). It may be just a the adapter acting up, but I thought I'd post it just in case.

    Any idea why all the "EAPOL-Key timeout" messages with Android clients? In the wireless forum somebody else is having experiencing the same.



  • I think this issue could be related to this thread



  • It crashed and rebooted again after 28h of uptime. Now I set the traffic shaping only for the LAN interface instead on the bridged (LAN + WLAN) see if it make any difference.


Log in to reply