freebsd kernel panic

Gerald · Непрочитанное сообщение **Gerald** » 2013-05-30 6:10:54

Доброе время суток, имеется сервер с FreeBSD 9.1-RELEASE-p2. В последнее время он стал периодически зависать, при этом выпадает core. Трассировал с помощью kgdb -q /boot/kernel/kernel /var/crash/vmcore.1
bt, выдало:

Код: Выделить всё

Loaded symbols for /boot/kernel/ng_iface.ko
Reading symbols from /boot/kernel/ng_ppp.ko...Reading symbols from /boot/kernel/ng_ppp.ko.symbols...done.
done.
Loaded symbols for /boot/kernel/ng_ppp.ko
Reading symbols from /boot/kernel/ng_tee.ko...Reading symbols from /boot/kernel/ng_tee.ko.symbols...done.
done.
Loaded symbols for /boot/kernel/ng_tee.ko
Reading symbols from /boot/kernel/ng_l2tp.ko...Reading symbols from /boot/kernel/ng_l2tp.ko.symbols...done.
done.
Loaded symbols for /boot/kernel/ng_l2tp.ko
Reading symbols from /boot/kernel/ng_ksocket.ko...Reading symbols from /boot/kernel/ng_ksocket.ko.symbols...done.
done.
Loaded symbols for /boot/kernel/ng_ksocket.ko
#0  doadump (textdump=1) at pcpu.h:244
244     pcpu.h: Нет такого файла или каталога.
        in pcpu.h
(kgdb) bt
#0  doadump (textdump=1) at pcpu.h:244
#1  0xc0a4214f in kern_reboot (howto=260) at ../../../kern/kern_shutdown.c:448
#2  0xc0a42442 in panic (fmt=Variable "fmt" is not available.
) at ../../../kern/kern_shutdown.c:636
#3  0xc0d9c183 in trap_fatal (frame=0xc5fc0b84, eva=0)
    at ../../../i386/i386/trap.c:1018
#4  0xc0d9c1f7 in trap_pfault (frame=0xc5fc0b84, usermode=0, eva=0)
    at ../../../i386/i386/trap.c:833
#5  0xc0d9d1fa in trap (frame=0xc5fc0b84) at ../../../i386/i386/trap.c:545
#6  0xc0d867dc in calltrap () at ../../../i386/i386/exception.s:169
#7  0x00000000 in ?? ()
Previous frame inner to this frame (corrupt stack?)
(kgdb)

Может кто нибудь сможет подсказать, с чем это может быть связанно?

Хостинг HostFood.ru · **Хостинг HostFood.ru**

Тарифы на хостинг в России, от 12 рублей: https://www.host-food.ru/tariffs/hosting/
Тарифы на виртуальные сервера (VPS/VDS/KVM) в РФ, от 189 руб.: https://www.host-food.ru/tariffs/virtualny-server-vps/
Выделенные сервера, Россия, Москва, от 2000 рублей (HP Proliant G5, Intel Xeon E5430 (2.66GHz, Quad-Core, 12Mb), 8Gb RAM, 2x300Gb SAS HDD, P400i, 512Mb, BBU):
https://www.host-food.ru/tariffs/vydelennyi-server-ds/
Недорогие домены в популярных зонах: https://www.host-food.ru/domains/

ChihPih · Непрочитанное сообщение **ChihPih** » 2013-05-30 7:10:18

Последнее время... Значит раньше не было, значит что-то поменялось?

Gerald · Непрочитанное сообщение **Gerald** » 2013-05-30 15:13:04

ChihPih писал(а):следнее время... Значит раньше не было, значит что-то поменялось?

На самом деле было это уже довольно давно, но не часто раз в месяц, в последнее время все чаще и чаще. Сервер, по большей части тестовый, так что это не критично, но хотелось бы разобраться из-за чего это происходит. Вполне возможно связанно с обновлением системы.

skeletor

Проблемы с netgraph (возможно с mpd). Возможно криво обновились или не до конца.

Gerald · Непрочитанное сообщение **Gerald** » 2013-05-30 20:04:39

skeletor писал(а):Проблемы с netgraph (возможно с mpd). Возможно криво обновились или не до конца.

Спасибо за ответ, скорее всего дело действительно в mpd, т.к. в моменты зависания системы, в mpd.log всегда одни и теже записи совподающие по времени:

Код: Выделить всё

May 26 06:13:46 serv mpd: Multi-link PPP daemon for FreeBSD
May 26 06:13:46 serv mpd:  
May 26 06:13:46 serv mpd: process 1708 started, version 5.6 (root@serv.ru 11:00 21-Aug-2012)
May 26 06:13:47 serv mpd: Label 'startup' not found
May 26 06:13:47 serv mpd: [Bl2tp] Bundle: Interface ng0 created
May 26 06:13:47 serv mpd: [ng0] Link: OPEN event
May 26 06:13:47 serv mpd: [ng0] LCP: Open event
May 26 06:13:47 serv mpd: [ng0] LCP: state change Initial --> Starting
May 26 06:13:47 serv mpd: [ng0] LCP: LayerStart
May 26 06:13:47 serv mpd: L2TP: Initiating control connection 0x28806408 0.0.0.0 0 <-> 10.0.0.70 1701
May 26 06:13:47 serv mpd: L2TP: Control connection 0x28806408 10.3.14.64 47427 <-> 10.0.0.70 1701 connected
May 26 06:13:47 serv mpd: [ng0] L2TP: Incoming call #5650000 via control connection 0x28806408 initiated
May 26 06:13:47 serv mpd: [ng0] L2TP: Call #5650000 connected
May 26 06:13:47 serv mpd: [ng0] Link: UP event
May 26 06:13:47 serv mpd: [ng0] LCP: Up event
May 26 06:13:47 serv mpd: [ng0] LCP: state change Starting --> Req-Sent
May 26 06:13:47 serv mpd: [ng0] LCP: SendConfigReq #1
May 26 06:13:47 serv mpd: [ng0]   MRU 1460
May 26 06:13:47 serv mpd: [ng0]   MAGICNUM 61d87698
May 26 06:13:47 serv mpd: [ng0] LCP: rec'd Configure Request #1 (Req-Sent)
May 26 06:13:47 serv mpd: [ng0]   MRU 1460
May 26 06:13:47 serv mpd: [ng0]   AUTHPROTO CHAP MD5
May 26 06:13:47 serv mpd: [ng0]   MAGICNUM d0d3be89
May 26 06:13:47 serv mpd: [ng0] LCP: SendConfigAck #1
May 26 06:13:47 serv mpd: [ng0]   MRU 1460
May 26 06:13:47 serv mpd: [ng0]   AUTHPROTO CHAP MD5
May 26 06:13:47 serv mpd: [ng0]   MAGICNUM d0d3be89
May 26 06:13:47 serv mpd: [ng0] LCP: state change Req-Sent --> Ack-Sent
May 26 06:13:47 serv mpd: [ng0] LCP: rec'd Configure Ack #1 (Ack-Sent)
May 26 06:13:47 serv mpd: [ng0]   MRU 1460
May 26 06:13:47 serv mpd: [ng0]   MAGICNUM 61d87698
May 26 06:13:47 serv mpd: [ng0] LCP: state change Ack-Sent --> Opened
May 26 06:13:47 serv mpd: [ng0] LCP: auth: peer wants CHAP, I want nothing
May 26 06:13:47 serv mpd: [ng0] LCP: LayerUp
May 26 06:13:47 serv mpd: [ng0] CHAP: rec'd CHALLENGE #1 len: 25
May 26 06:13:47 serv mpd: [ng0]   Name: "VPN6"
May 26 06:13:47 serv mpd: [ng0] CHAP: Using authname "namelogin"
May 26 06:13:47 serv mpd: [ng0] CHAP: sending RESPONSE #1 len: 25
May 26 06:13:47 serv mpd: [ng0] CHAP: rec'd SUCCESS #1 len: 4
May 26 06:13:47 serv mpd: [ng0] LCP: authorization successful
May 26 06:13:47 serv mpd: [ng0] Link: Matched action 'bundle "Bl2tp" ""'
May 26 06:13:47 serv mpd: [ng0] Link: Join bundle "Bl2tp"
May 26 06:13:47 serv mpd: [Bl2tp] Bundle: Status update: up 1 link, total bandwidth 64000 bps
May 26 06:13:47 serv mpd: [Bl2tp] IPCP: Open event
May 26 06:13:47 serv mpd: [Bl2tp] IPCP: state change Initial --> Starting
May 26 06:13:47 serv mpd: [Bl2tp] IPCP: LayerStart
May 26 06:13:47 serv mpd: [Bl2tp] IPCP: Up event
May 26 06:13:47 serv mpd: [Bl2tp] IPCP: state change Starting --> Req-Sent
May 26 06:13:47 serv mpd: [Bl2tp] IPCP: SendConfigReq #1
May 26 06:13:47 serv mpd: [Bl2tp]   IPADDR 10.3.14.64
May 26 06:13:47 serv mpd: [Bl2tp]   COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
May 26 06:13:47 serv mpd: [Bl2tp] IPCP: rec'd Configure Request #1 (Req-Sent)
May 26 06:13:47 serv mpd: [Bl2tp]   IPADDR 217.76.183.240
May 26 06:13:47 serv mpd: [Bl2tp]     217.76.183.240 is OK
May 26 06:13:47 serv mpd: [Bl2tp] IPCP: SendConfigAck #1
May 26 06:13:47 serv mpd: [Bl2tp]   IPADDR 217.76.183.240
May 26 06:13:47 serv mpd: [Bl2tp] IPCP: state change Req-Sent --> Ack-Sent
May 26 06:13:47 serv mpd: [Bl2tp] IPCP: rec'd Configure Reject #1 (Ack-Sent)
May 26 06:13:47 serv mpd: [Bl2tp]   COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
May 26 06:13:47 serv mpd: [Bl2tp] IPCP: SendConfigReq #2
May 26 06:13:47 serv mpd: [Bl2tp]   IPADDR 10.3.14.64
May 26 06:13:47 serv mpd: [Bl2tp] IPCP: rec'd Configure Nak #2 (Ack-Sent)
May 26 06:13:47 serv mpd: [Bl2tp]   IPADDR 76.127.166.198
May 26 06:13:47 serv mpd: [Bl2tp]     76.127.166.198 is OK
May 26 06:13:47 serv mpd: [Bl2tp] IPCP: SendConfigReq #3
May 26 06:13:47 serv mpd: [Bl2tp]   IPADDR 76.127.166.198
May 26 06:13:47 serv mpd: [Bl2tp] IPCP: rec'd Configure Ack #3 (Ack-Sent)
May 26 06:13:47 serv mpd: [Bl2tp]   IPADDR 76.127.166.198
May 26 06:13:47 serv mpd: [Bl2tp] IPCP: state change Ack-Sent --> Opened
May 26 06:13:47 serv mpd: [Bl2tp] IPCP: LayerUp
May 26 06:13:47 serv mpd: [Bl2tp]   76.127.166.198 -> 217.76.183.240
May 26 06:13:47 serv mpd: [Bl2tp] IFACE: Up event

May 27 22:49:53 serv mpd: Multi-link PPP daemon for FreeBSD
May 27 22:49:53 serv mpd:  
May 27 22:49:53 serv mpd: process 1708 started, version 5.6 (root@serv.ru 11:00 21-Aug-2012)
May 27 22:49:53 serv mpd: Label 'startup' not found
May 27 22:49:53 serv mpd: [Bl2tp] Bundle: Interface ng0 created
May 27 22:49:53 serv mpd: [ng0] Link: OPEN event
May 27 22:49:53 serv mpd: [ng0] LCP: Open event
May 27 22:49:53 serv mpd: [ng0] LCP: state change Initial --> Starting
May 27 22:49:53 serv mpd: [ng0] LCP: LayerStart
May 27 22:49:53 serv mpd: L2TP: Initiating control connection 0x28806408 0.0.0.0 0 <-> 10.0.0.66 1701
May 27 22:49:53 serv mpd: L2TP: Control connection 0x28806408 10.3.14.64 17434 <-> 10.0.0.66 1701 connected
May 27 22:49:53 serv mpd: [ng0] L2TP: Incoming call #310000 via control connection 0x28806408 initiated
May 27 22:49:53 serv mpd: [ng0] L2TP: Call #310000 connected
May 27 22:49:53 serv mpd: [ng0] Link: UP event
May 27 22:49:53 serv mpd: [ng0] LCP: Up event
May 27 22:49:53 serv mpd: [ng0] LCP: state change Starting --> Req-Sent
May 27 22:49:53 serv mpd: [ng0] LCP: SendConfigReq #1
May 27 22:49:53 serv mpd: [ng0]   MRU 1460
May 27 22:49:53 serv mpd: [ng0]   MAGICNUM 87f52468
May 27 22:49:53 serv mpd: [ng0] LCP: rec'd Configure Request #1 (Req-Sent)
May 27 22:49:53 serv mpd: [ng0]   MRU 1460
May 27 22:49:53 serv mpd: [ng0]   AUTHPROTO CHAP MD5
May 27 22:49:53 serv mpd: [ng0]   MAGICNUM 38d9d304
May 27 22:49:53 serv mpd: [ng0] LCP: SendConfigAck #1
May 27 22:49:53 serv mpd: [ng0]   MRU 1460
May 27 22:49:53 serv mpd: [ng0]   AUTHPROTO CHAP MD5
May 27 22:49:53 serv mpd: [ng0]   MAGICNUM 38d9d304
May 27 22:49:53 serv mpd: [ng0] LCP: state change Req-Sent --> Ack-Sent
May 27 22:49:53 serv mpd: [ng0] LCP: rec'd Configure Ack #1 (Ack-Sent)
May 27 22:49:53 serv mpd: [ng0]   MRU 1460
May 27 22:49:53 serv mpd: [ng0]   MAGICNUM 87f52468
May 27 22:49:53 serv mpd: [ng0] LCP: state change Ack-Sent --> Opened
May 27 22:49:53 serv mpd: [ng0] LCP: auth: peer wants CHAP, I want nothing
May 27 22:49:53 serv mpd: [ng0] LCP: LayerUp
May 27 22:49:53 serv mpd: [ng0] CHAP: rec'd CHALLENGE #1 len: 25
May 27 22:49:53 serv mpd: [ng0]   Name: "VPN2"
May 27 22:49:53 serv mpd: [ng0] CHAP: Using authname "namelogin"
May 27 22:49:53 serv mpd: [ng0] CHAP: sending RESPONSE #1 len: 25
May 27 22:49:53 serv mpd: [ng0] CHAP: rec'd SUCCESS #1 len: 4
May 27 22:49:53 serv mpd: [ng0] LCP: authorization successful
May 27 22:49:53 serv mpd: [ng0] Link: Matched action 'bundle "Bl2tp" ""'
May 27 22:49:53 serv mpd: [ng0] Link: Join bundle "Bl2tp"
May 27 22:49:53 serv mpd: [Bl2tp] Bundle: Status update: up 1 link, total bandwidth 64000 bps
May 27 22:49:53 serv mpd: [Bl2tp] IPCP: Open event
May 27 22:49:53 serv mpd: [Bl2tp] IPCP: state change Initial --> Starting
May 27 22:49:53 serv mpd: [Bl2tp] IPCP: LayerStart
May 27 22:49:53 serv mpd: [Bl2tp] IPCP: Up event
May 27 22:49:53 serv mpd: [Bl2tp] IPCP: state change Starting --> Req-Sent
May 27 22:49:53 serv mpd: [Bl2tp] IPCP: SendConfigReq #1
May 27 22:49:53 serv mpd: [Bl2tp]   IPADDR 10.3.14.64
May 27 22:49:53 serv mpd: [Bl2tp]   COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
May 27 22:49:53 serv mpd: [Bl2tp] IPCP: rec'd Configure Request #1 (Req-Sent)
May 27 22:49:53 serv mpd: [Bl2tp]   IPADDR 127.36.143.162
May 27 22:49:53 serv mpd: [Bl2tp]     127.36.143.162 is OK
May 27 22:49:53 serv mpd: [Bl2tp] IPCP: SendConfigAck #1
May 27 22:49:53 serv mpd: [Bl2tp]   IPADDR 127.36.143.162
May 27 22:49:53 serv mpd: [Bl2tp] IPCP: state change Req-Sent --> Ack-Sent
May 27 22:49:53 serv mpd: [Bl2tp] IPCP: rec'd Configure Reject #1 (Ack-Sent)
May 27 22:49:53 serv mpd: [Bl2tp]   COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
May 27 22:49:53 serv mpd: [Bl2tp] IPCP: SendConfigReq #2
May 27 22:49:53 serv mpd: [Bl2tp]   IPADDR 10.3.14.64
May 27 22:49:53 serv mpd: [Bl2tp] IPCP: rec'd Configure Nak #2 (Ack-Sent)
May 27 22:49:53 serv mpd: [Bl2tp]   IPADDR 76.127.166.198
May 27 22:49:53 serv mpd: [Bl2tp]     76.127.166.198 is OK
May 27 22:49:53 serv mpd: [Bl2tp] IPCP: SendConfigReq #3
May 27 22:49:53 serv mpd: [Bl2tp]   IPADDR 76.127.166.198
May 27 22:49:53 serv mpd: [Bl2tp] IPCP: rec'd Configure Ack #3 (Ack-Sent)
May 27 22:49:53 serv mpd: [Bl2tp]   IPADDR 76.127.166.198
May 27 22:49:53 serv mpd: [Bl2tp] IPCP: state change Ack-Sent --> Opened
May 27 22:49:53 serv mpd: [Bl2tp] IPCP: LayerUp
May 27 22:49:53 serv mpd: [Bl2tp]   76.127.166.198 -> 127.36.143.162
May 27 22:49:53 serv mpd: [Bl2tp] IFACE: Up event

Но судя по этому логу он просто пытается пере подключится к впн серверу? В чем же может быть причина?

_skeletor

С какими опциями собирали mpd? Включали ли поддержку netgraph в ядро?
Возможно стоит попробовать другие реализации vpn-клиентов?

_skeletor

Не ваш ли это pr http://www.freebsd.org/cgi/query-pr.cgi?pr=178854 ?

Gerald · Непрочитанное сообщение **Gerald** » 2013-05-31 17:54:55

_skeletor писал(а):С какими опциями собирали mpd? Включали ли поддержку netgraph в ядро?
В ядре нет встроенной поддержки NETGRAPH, есть смысл персобирать его?

mpd собран без дополнительных опции.
Код: Выделить всё
make showconfig
===> The following configuration options are available for mpd-5.6:
     NG_CAR=off: Use ng_car kernel module from port (< 7.0 only)
     NG_IPACCT=off: Use ng_ipacct kernel module from port
===> Use 'make config' to modify these settings
_skeletor писал(а):Не ваш ли это pr http://www.freebsd.org/cgi/query-pr.cgi?pr=178854 ?

нет pr я не отсылал.

skeletor

Тогда следите за решением вашего бага.

Gerald · Непрочитанное сообщение **Gerald** » 2013-06-04 0:12:36

skeletor писал(а):Тогда следите за решением вашего бага.

разве у нас с ним схожие проблемы? core вроде разные.

_skeletor

Разные, но судя по трейсу валится оно после загрузки модуля ng_socket.ko, так, что можно считать, что в некоторой степени похожи.

Gerald · Непрочитанное сообщение **Gerald** » 2013-06-06 13:52:26

_skeletor писал(а):Разные, но судя по трейсу валится оно после загрузки модуля ng_socket.ko, так, что можно считать, что в некоторой степени похожи.

Может тогда подскажите альтернативный l2tp клиент кроме mpd, или таких для freebsd попросту не существует?

hizel · Непрочитанное сообщение **hizel** » 2013-06-06 14:32:04

_skeletor писал(а):Разные, но судя по трейсу валится оно после загрузки модуля ng_socket.ko, так, что можно считать, что в некоторой степени похожи.

Это не загрузка модуля ng_socket, это дебагер грузит от туда debug symbol. *facepalm*

Gerald · Непрочитанное сообщение **Gerald** » 2013-06-06 16:12:12

hizel писал(а):
_skeletor писал(а):Разные, но судя по трейсу валится оно после загрузки модуля ng_socket.ko, так, что можно считать, что в некоторой степени похожи.
Это не загрузка модуля ng_socket, это дебагер грузит от туда debug symbol. *facepalm*

Дак в чем же все таки проблема в netgraph или mpd? И есть ли l2tp клиент который не использует netgraph?

hizel · Непрочитанное сообщение **hizel** » 2013-06-06 16:22:44

Непонятно он чего panic. Железо гавно например.

Gerald · Непрочитанное сообщение **Gerald** » 2013-06-06 17:06:27

hizel писал(а):Непонятно он чего panic. Железо гавно например.

Год назад работа была стабильной, предположительно после настройки vpn клиента начались такие зависания, при панике ядра в логах mpd один и тоже текст. При чем иногда аптайм достигает 14-21 день.

Gerald · Непрочитанное сообщение **Gerald** » 2013-06-17 7:43:22

Странно попробовал использовать другую сетевую карту core изменился, стало выпадать:

Код: Выделить всё

Loaded symbols for /boot/kernel/linprocfs.ko
Reading symbols from /boot/kernel/linux.ko...Reading symbols from /boot/kernel/linux.ko.symbols...done.
done.
Loaded symbols for /boot/kernel/linux.ko
Reading symbols from /boot/kernel/accf_http.ko...Reading symbols from /boot/kernel/accf_http.ko.symbols...done.
done.
Loaded symbols for /boot/kernel/accf_http.ko
#0  doadump (textdump=1) at pcpu.h:244
244     pcpu.h: Нет такого файла или каталога.
        in pcpu.h
(kgdb) bt
#0  doadump (textdump=1) at pcpu.h:244
#1  0xc0a431af in kern_reboot (howto=260) at ../../../kern/kern_shutdown.c:448
#2  0xc0a434a2 in panic (fmt=Variable "fmt" is not available.
) at ../../../kern/kern_shutdown.c:636
#3  0xc0dda4d1 in mca_intr () at ../../../x86/x86/mca.c:963
#4  0xc0dbe65a in trap (frame=0xc5fc0aa4) at ../../../i386/i386/trap.c:257
#5  0xc0da7fdc in calltrap () at ../../../i386/i386/exception.s:169
#6  0xc0daded2 in spinlock_enter () at ../../../i386/i386/machdep.c:3096
#7  0xc0a31b0d in _thread_lock_flags (td=0xc619f8a0, opts=2,
    file=0xc0f72ee8 "../../../kern/kern_clock.c", line=768)
    at ../../../kern/kern_mutex.c:593
#8  0xc09f5f52 in statclock_cnt (cnt=1, usermode=0)
    at ../../../kern/kern_clock.c:768
#9  0xc0dc531a in handleevents (now=0xc5fc0bdc, fake=0)
    at ../../../kern/kern_clocksource.c:224
#10 0xc0dc6a1f in timercb (et=0xc1186100, arg=0x0)
    at ../../../kern/kern_clocksource.c:390
#11 0xc0dd7cef in lapic_handle_timer (frame=0xc5fc0c20)
    at ../../../x86/x86/local_apic.c:818
#12 0xc0da8550 in Xtimerint () at apic_vector.s:108
#13 0xc0dadea4 in cpu_idle_acpi (busy=1) at ../../../i386/i386/machdep.c:1263
#14 0xc0db0ad9 in cpu_idle (busy=1) at ../../../i386/i386/machdep.c:1400
#15 0xc0a689d9 in sched_idletd (dummy=0x0) at ../../../kern/sched_ule.c:2617
#16 0xc0a13456 in fork_exit (callout=0xc0a687c0 <sched_idletd>, arg=0x0,
---Type <return> to continue, or q <return> to quit---
    frame=0xc5fc0d08) at ../../../kern/kern_fork.c:992
#17 0xc0da8054 in fork_trampoline () at ../../../i386/i386/exception.s:276
(kgdb)

Что бы это могло значить?

forum.lissyara.su

freebsd kernel panic

freebsd kernel panic

Услуги хостинговой компании Host-Food.ru

Re: freebsd kernel panic

Re: freebsd kernel panic

Re: freebsd kernel panic

Re: freebsd kernel panic

Re: freebsd kernel panic

Re: freebsd kernel panic

Re: freebsd kernel panic

Re: freebsd kernel panic

Re: freebsd kernel panic

Re: freebsd kernel panic

Re: freebsd kernel panic

Re: freebsd kernel panic

Re: freebsd kernel panic

Re: freebsd kernel panic

Re: freebsd kernel panic

Re: freebsd kernel panic