PDA

Bekijk de volledige versie : Подскажите, что этот лог значит? (syslog)


Pages : [1] 2
VadimVB
06-03-2006, 02:57
Собсвтенно при загрузке в логе всё время ошибка

User.Error gw500.lan.local kernel: sflash: found no supported devices

Это очень страшно?
Oleg
06-03-2006, 11:16
Нет, не страшно. sflash (serial flash) действительно нет. Просто этот кусок выкинуть из ядра не получается.
VadimVB
06-03-2006, 16:45
Нет, не страшно. sflash (serial flash) действительно нет. Просто этот кусок выкинуть из ядра не получается.

А вот это?

WARNING: USB Mass Storage data integrity not assured

И кстати - если флэшка без партишон тэйбла то роутер не может определить её размер и считает что она гиговая. В тоже время W2K правильно её определяет (она 512MB). После FDISK (в роутере) всё встает на свои места.



scsi0 : SCSI emulation for USB Mass Storage devices
Vendor: OTi Model: Flash Disk Rev: 2.00
Type: Direct-Access ANSI SCSI revision: 02
Attached scsi removable disk sda at scsi0, channel 0, id 0, lun 0
sda : READ CAPACITY failed.
sda : status = 1, message = 00, host = 0, driver = 08
Current sd00:00: sns = 70 6
ASC=28 ASCQ= 0
Raw sense data:0x70 0x00 0x06 0x00 0x00 0x00 0x00 0x0a 0x00 0x00 0x00 0x00 0x28 0x00 0x00 0x00 0x00 0x00
sda : block size assumed to be 512 bytes, disk size 1GB.
Partition check:

WARNING: USB Mass Storage data integrity not assured
USB Mass Storage device found at 2
Oleg
07-03-2006, 06:52
WARNING: USB Mass Storage data integrity not assured

Предупреждает Вас, что если Вы флешку находу вытащите из разъёма, то целостность данных не гарантируется. :)
tatsuvan
18-10-2006, 10:38
Здравствуйте, у меня тут образовался странный лог. Очень было-бы интересно почитать Ваше мнение по поводу того, что значит его содержимое.
Опишу обстановку. Соединение с интернетом есть, прошивка WL500gp-1.9.2.7-7f-pre7.trx , все пашет. Память не расширял, бутлоадер не менял. Usb не подключал, дополнительные пакеты не ставил. В общем все работает, только в последнее время часто глючит провайдер - скорость интернета то падает до 0, то растет до нормальных величин (это не только у меня, у всех в сетке)... Не знаю как это связано с провайдером, но помимо всего прочего роутер выдает, на мой взгляд, странный лог.
Вот выдержки из него:
После "ISP Connected".


Jan 1 03:01:14 pptp[112]: anon log[logecho:pptp_ctrl.c:670]: Echo Reply received.
Jan 1 03:02:14 pptp[112]: anon log[logecho:pptp_ctrl.c:670]: Echo Reply received.
... (в таком духе, заканчивается все следующей строчкой)
Jan 1 03:10:14 pptp[112]: anon log[logecho:pptp_ctrl.c:672]: no more
Echo Reply/Request packets will be reported.

После нескольких часов работы в логе появляются следующие строчки в больших колличествах


Jan 5 23:24:18 kernel: ip_conntrack: table full, dropping packet.
Jan 5 23:29:46 pppd[98]: read /dev/ppp: Value too large for defined data type
Jan 5 23:32:42 kernel: NET: 4 messages suppressed.

В дополнение выкладываю файл лога.
Oleg
18-10-2006, 12:08
Первые сообщения - норма. Вторая - Вы видимо очень увлекаетесь П2П сетями, и видимо количество соединений у Вас в клиенте не ограничено. Отсюда и проблемы с превышением максимального на роутере.
tatsuvan
19-10-2006, 11:04
Все прояснилось, спасибо. Действительно все верно:D А какое допустимое количество соединений для Premium и сколько нужно поставить в клиенте?
Oleg
19-10-2006, 11:10
По умолчанию - 4096. В клиенте ставьте 1000. Нафига Вам больше?
justason
23-10-2006, 18:17
Не могу подключить телефон Noka9500 по WLAN.
Поставил все идентично.
В System Log ничего нету на счет подключения.
Oleg
26-10-2006, 18:23
Нет таких логов, за исключением статуса Wireless.

Какие у Вас там настройки для секьюрити?
justason
26-10-2006, 20:47
Pereproboval vse podrjad:
MAC filtering ON/OFF
WEP 64/128
WPA TKIP/AES

Ne konnektitsja dazhe kogda vse security OFF.
Na nokii Symbian, A ottuda smotret logi :confused: - legche na Asus-e WLAN log naiti.
tatsuvan
02-11-2006, 21:37
Так и не понял, где выставлять в торрент-клиенте количество допустимых соединений. Может кто знает, где это в BitComet?..
Но пишу не из-за этого. При выключенном п2п клиенте все равно получаю в больших количествах строчки


Jan 1 04:07:45 pppd[98]: read /dev/ppp: Value too large for defined data type
Jan 1 04:07:50 pppd[98]: read /dev/ppp: Value too large for defined data type
Jan 1 04:08:01 pppd[98]: read /dev/ppp: Value too large for defined data type
Jan 1 04:08:21 pppd[98]: read /dev/ppp: Value too large for defined data type

С чем это может быть связано?
Заранее большое вам спасибо за помощь и пояснения!
Oleg
03-11-2006, 10:00
Попробуйте добавить "mtu 1300" (без кавычек, через пробел) в Additional pppd options.
vaspupkin
28-01-2007, 11:48
В логе стали появляться подобные записи. Что бы это значило, и как пофиксить? Раньше не замечалось такого.
WK500GP c последней прошивкой 1.9.2.7-7f
Настроен на Корбину-ВПН и локальную районную сеть через роутинг.


Jan 26 11:41:49 kernel: Neighbour table overflow.
Jan 26 11:41:49 kernel: Neighbour table overflow.
Jan 26 11:41:49 kernel: Neighbour table overflow.
Jan 26 11:41:49 kernel: Neighbour table overflow.
Jan 26 11:41:54 kernel: NET: 200 messages suppressed.
Jan 26 11:41:54 kernel: Neighbour table overflow.
Jan 26 11:41:59 kernel: NET: 203 messages suppressed.
Jan 26 11:41:59 kernel: Neighbour table overflow.
Jan 26 11:42:05 kernel: NET: 238 messages suppressed.
Jan 26 11:42:05 kernel: Neighbour table overflow.
Jan 26 11:42:09 kernel: NET: 190 messages suppressed.
Jan 26 11:42:09 kernel: Neighbour table overflow.
Jan 26 11:42:14 kernel: NET: 205 messages suppressed.
Jan 26 11:42:14 kernel: Neighbour table overflow.
Jan 26 11:42:20 kernel: NET: 207 messages suppressed.
edo
28-01-2007, 13:13
http://www.opennet.ru/openforum/vsluhforumID10/1514.html
vaspupkin
29-01-2007, 17:03
Лаконично.
И все же. В люниксе есть команда arp, у нас, похоже нет. Так есть возможность очистить таблицу arp, или не логировать ее переполнение?
Возникает данное переполнение когда начинаешь сканировать локальную сеть с большим количеством компов.
oradba
03-03-2007, 22:24
Как избавиться от этого в логе:

Mar 4 00:49:51 kernel: VFS: Can't find ext3 filesystem on dev sd(8,0).
Mar 4 00:49:51 kernel: MSDOS FS: Using codepage 866
Mar 4 00:49:51 kernel: MSDOS FS: IO charset cp1251
Mar 4 00:49:51 USB storage: vfat fs mounted to /tmp/harddisk
Mar 4 00:49:51 kernel: VFS: Can't find ext3 filesystem on dev sd(8,1).
Mar 4 00:49:51 kernel: MSDOS FS: Using codepage 866
Mar 4 00:49:51 kernel: MSDOS FS: IO charset cp1251
Mar 4 00:49:51 kernel: FAT: bogus logical sector size 65535
Mar 4 00:49:51 kernel: VFS: Can't find a valid FAT filesystem on dev 08:01.
Mar 4 00:49:51 kernel: FAT: freeing iocharset=cp1251
Mar 4 00:49:51 kernel: FAT: bogus logical sector size 65535
Mar 4 00:49:51 kernel: VFS: Can't find a valid FAT filesystem on dev 08:01.
Mar 4 00:49:51 kernel: VFS: Can't find ext3 filesystem on dev sd(8,2).
Mar 4 00:49:51 kernel: MSDOS FS: Using codepage 866
Mar 4 00:49:51 kernel: MSDOS FS: IO charset cp1251
Mar 4 00:49:51 kernel: FAT: bogus logical sector size 65535
Mar 4 00:49:51 kernel: VFS: Can't find a valid FAT filesystem on dev 08:02.
Mar 4 00:49:51 kernel: FAT: freeing iocharset=cp1251
Mar 4 00:49:51 kernel: FAT: bogus logical sector size 65535
Mar 4 00:49:51 kernel: VFS: Can't find a valid FAT filesystem on dev 08:02.
Mar 4 00:49:51 kernel: VFS: Can't find ext3 filesystem on dev sd(8,3).
Mar 4 00:49:51 kernel: MSDOS FS: Using codepage 866
Mar 4 00:49:51 kernel: MSDOS FS: IO charset cp1251
Mar 4 00:49:51 kernel: FAT: bogus logical sector size 65535
Mar 4 00:49:51 kernel: VFS: Can't find a valid FAT filesystem on dev 08:03.
Mar 4 00:49:51 kernel: FAT: freeing iocharset=cp1251
Mar 4 00:49:51 kernel: FAT: bogus logical sector size 65535
Mar 4 00:49:51 kernel: VFS: Can't find a valid FAT filesystem on dev 08:03.
Mar 4 00:49:51 kernel: VFS: Can't find ext3 filesystem on dev sd(8,4).
Mar 4 00:49:51 kernel: MSDOS FS: Using codepage 866
Mar 4 00:49:51 kernel: MSDOS FS: IO charset cp1251
Mar 4 00:49:51 kernel: FAT: bogus logical sector size 65535
Mar 4 00:49:51 kernel: VFS: Can't find a valid FAT filesystem on dev 08:04.
Mar 4 00:49:51 kernel: FAT: freeing iocharset=cp1251
Mar 4 00:49:51 kernel: FAT: bogus logical sector size 65535
Mar 4 00:49:51 kernel: VFS: Can't find a valid FAT filesystem on dev 08:04.

Видимо это из-за инструкций в пункте 5) фака "как настроить с нуля" http://wl500g.info/showthread.php?t=3171


5) русифицировать и отключить STP
nvram set lan_stp=0
nvram set usb_vfat_options=codepage=866,iocharset=cp1251
nvram set usb_ntfs_options=iocharset=cp1251
nvram set usb_smbcpage_x=866
nvram set usb_smbcset_x=1251
nvram set regulation_domain=0x00ALL
nvram commit

Планирую подключить флэшку с ext3. Нужно ли мне очистить эти переменные в nvram?
oradba
03-03-2007, 22:41
чето я не совсем понимаю как отформатировать флэшку под ext3

mke2fs -j /dev/scsi/host0/bus0/target0/lun0/part1

отваливается с Writing inode tables: Terminated

Но флэшка автоматом монтируется как:

/dev/discs/disc0/disc on /tmp/harddisk type vfat (rw,noatime)

и ftp туда пихает свои папки.

Как правильно отформатировать под ext3?

Отмонтировать тоже не получается, только через кнопку Eject в веб-интерфейсе:
umount /tmp/harddisk
umount: Couldn't umount /tmp/harddisk: Invalid argument
usmailer™
04-03-2007, 09:06
чето я не совсем понимаю как отформатировать флэшку под ext3

mke2fs -j /dev/scsi/host0/bus0/target0/lun0/part1

отваливается с Writing inode tables: Terminated

Но флэшка автоматом монтируется как:

/dev/discs/disc0/disc on /tmp/harddisk type vfat (rw,noatime)

и ftp туда пихает свои папки.

Как правильно отформатировать под ext3?

Отмонтировать тоже не получается, только через кнопку Eject в веб-интерфейсе:
umount /tmp/harddisk
umount: Couldn't umount /tmp/harddisk: Invalid argument


разметить и отформатить можно вот этим -
fdisk /dev/scsi/host0/bus0/target0/lun0/disc

это чуть ниже описано, относительно указанной Вами команды...
работает на ура...

но самый верный вариант - сделать все это под линухой или кноппикс запустить..
idtelecom
22-04-2007, 07:22
:confused:
Роутер в логах написал такую штуку

The origin for route 239.255.255.250 changed from 10.9.52.20 to 10.9.52.40

Весь в смятении что бы это могло значить?
Oleg
22-04-2007, 07:33
Мультикаст это, не обращайте внимания.
idtelecom
22-04-2007, 07:41
:rolleyes:
BuHT
31-05-2007, 17:16
после сбоя роутера, сделал сброс кнопкой на задней панели.
перенастроил его заново, но вот незадача пропал лог файл:confused:
ни черег вэб интерфейс ни в файловой системе найти него не могу.
Mam(O)n
31-05-2007, 20:49
ps | grep syslogd чего нибудь говорит?
BuHT
01-06-2007, 17:16
вот что говорит


ps | grep syslogd
120 g00d-cat 400 S /sbin/syslogd -m 0 -O /opt/var/log/messages -S -l 7
163 g00d-cat 380 R grep syslogd


а вэб интерфейс из какого файла лог читает?
Mam(O)n
01-06-2007, 17:32
Вобщем то веб из /tmp/syslog.log должен читать.
BuHT
01-06-2007, 18:21
а в каком файле файле сислог запускается? надо б там параметр поправить на


/sbin/syslogd -m 0 -O /tmp/syslog.log -S -l 7

только не нашел где править.
или проще симлинк на него поставить и не париться?
Mam(O)n
01-06-2007, 18:34
syslogd должен запускаться из /bin/rc и с -O /tmp/syslog.log. Откуда взялось -O /opt/var/log/messages непонятно. Может стоит посмотреть его PPID (можно с помощью top). Если он не равен 1 то он явно он где то перезапускается после /bin/rc. Может в /tmp/local/sbin/pre-boot?
BuHT
01-06-2007, 19:02
вот так он в top выглядит


PID USER STATUS RSS PPID
120 g00d-cat S 400 1 0.0 1.3 syslogd


файл /tmp/local/sbin/pre-boot у меня отсутствует
/bin/rc у меня тоже не видно, покрайней мере ни через
vi /bin/rc ни миднайткомандером
О! зато нашел файл в opt/etc/init.d/S05syslogd
в котором то и трется начальный лог в нужной папке и переносится в новое место. и перезапускается syslogd. спасибо за подсказки буду разбираться для каких целей это было нужно... сдается мне что это для статистики трансмишна чтоли... буду вспоминать в вобщем :)
Mam(O)n
01-06-2007, 19:25
/bin/rc у меня тоже не видно
Сорри, на скорую руку писал. /sbin/rc правильнее. Это бинарный файл начальной инициализации.
А насчет S05syslogd, посмотри, может отсюда брал http://wl500g.info/showpost.php?p=48593&postcount=42.
bertok
13-06-2007, 07:42
у меня в логах пишет такую надпись *change ip from 4301a8c0 to 60911555*

что это за ip менятется.... ??
thebix
13-06-2007, 08:13
может быть это и не проблема вовсе. просто смущает факт наличия всего полутора мегабайт свободной памяти (по команде free).
вроде бы я далеко не все что можно установил на это мегаустройство. вот, что показывает команда top (с некоторыми моими комментариями):

Mem: 28560K used, 1556K free, 0K shrd, 1656K buff, 18084K cached
Load average: 0.00, 0.00, 0.00 (State: S=sleeping R=running, W=waiting)

PID USER STATUS RSS PPID %CPU %MEM COMMAND
855 admin R 448 845 0.7 1.4 top - это поянтно, сама команда
844 admin S 692 129 0.3 2.2 dropbear - это я соединился по ssh
119 admin S 428 116 0.1 1.4 pptp - мое pptp соединение с интернет
833 admin S 1332 1 0.0 4.4 lighttpd - веб сервер
845 admin S 556 844 0.0 1.8 sh - просто шелл.
149 admin S 464 1 0.0 1.5 stupid-ftpd - это встроенный ftp. его я использую
68 admin S 388 1 0.0 1.2 nas - инет сказал, что это демон для подключенной к роуетру флешки
75 nobody S 384 1 0.0 1.2 dnsmasq - из названия понятно, что это какой то днс маскарадинг. а что он делает?
111 admin S 384 1 0.0 1.2 pppd - не понимаю, что это.
612 admin S 348 1 0.0 1.1 httpd - возможно демон для веб-интерфейса настройки?
114 admin S 308 1 0.0 1.0 watchdog - нужно ли это?
127 admin S 272 1 0.0 0.9 pptp - почему то второе pptp соединение... не понимаю почему.
1 admin S 252 0 0.0 0.8 init - скрипты инициализации?
72 admin S 236 1 0.0 0.7 syslogd - логи.
129 admin S 228 1 0.0 0.7 dropbear - откуда второй dropbear? я сейчас использую только одно соединение.
113 admin S 216 1 0.0 0.7 infosvr - непонятно что
118 admin S 200 114 0.0 0.6 ntp - я так понимаю, я могу указать в качестве ntp-сервера на домашних машинах свой роутер...
116 admin S 188 111 0.0 0.6 sh - зачем то второй шелл :-/
92 admin S 188 1 0.0 0.6 rcamdmain - этого я не устанавливал. что это?
90 admin S 188 1 0.0 0.6 waveservermain - тоже не ставил...
73 admin S 184 1 0.0 0.6 klogd - тоже не понимаю что это
85 admin S 168 1 0.0 0.5 lpd - тоже не понимаю
87 admin S 160 1 0.0 0.5 p910nd - не понимаю
62 admin S 140 1 0.0 0.4 telnetd - как можно отключить telnet?
3 admin SWN 0 1 0.0 0.0 ksoftirqd_CPU0 - не понимаю
96 admin SW 0 1 0.0 0.0 usb-storage-0 - не понимаю, я же уже один демон для флешки упоминал...
4 admin SW 0 1 0.0 0.0 kswapd - в общем все что ниже я тоже не понимаю зачем и нужно ли...
147 admin SW 0 1 0.0 0.0 kjournald
7 admin SW 0 1 0.0 0.0 mtdblockd
5 admin SW 0 1 0.0 0.0 bdflush
2 admin SW 0 1 0.0 0.0 keventd
6 admin SW 0 1 0.0 0.0 kupdated
97 admin SW 0 1 0.0 0.0 scsi_eh_0
76 admin SW 0 1 0.0 0.0 khubd

вот и получается, если посчитать, что вроде бы никаких торрентов, скринов и прочих благ я не поставил, а памяти уже почти нет. и это с учетом расширения до 32-х мегабайт.
возможно, я что то не так понимаю в работе, возможно памяти столько и должно быть. смущает в первой строчке "18084K cached" - что это значит?
буду очень признателен за какие нибудь пояснения или наводки куда копать :)
Antonio_99RUS
13-06-2007, 14:19
Это означает, что некий адрес сменился с 192.168.1.67 на 85.21.145.96. Предположу, что это законнектился PPPoE либо PPTP.
Antonio_99RUS
13-06-2007, 14:30
Для виндовс-юзера типичное поведение менеджера памяти *NIX является шокирующим.

Он старается "отожрать" как можно больше под буфера ввода-вывода и дисковый кэш. Как только кому-то потребуется дополнительная память, она будет отрезана от буферов/кэша и отдана приложению.

Касаемо вопросов плана "почему 2 шелла и что это за процесс" -- ох, купите какую-нибудь книжку типа "Linux для сисадмина", изложение основ *NIX здесь займёт примерно страниц 20 текста.


1 admin S 252 0 0.0 0.8 init - скрипты инициализации?
Это не скрипты инициализации, а отец всех процессов, самый главный процесс.

А вот это

Mem: 28560K used, 1556K free, 0K shrd, 1656K buff, 18084K cached
просто отличный результат. Формально у вас свободно почти 20 мегабайт памяти (cached -- это почти свободная память).
thebix
14-06-2007, 11:35
я бывал и в роли линукс пользователя... просто линукс такой большооой :) я не все успел в нем узнать. книжка у меня есть, почитаю ее.

большое спасибо за разъяснение. теперь я спокоен и настроен настраивать это чудо штуку дальше :)
ma_lav
18-06-2007, 05:03
Вопрос остался нераскрыт. Что из вышеперечисленного нужно а что нет? Когда у себя я вижу что постоянно используется своп это не есть хорошо. Что это за процессы и нужно ли их убивать.

to thebix: Waveserver можешь погасить из html странички с параметрами
Antonio_99RUS
18-06-2007, 06:39
Что это за процессы и нужно ли их убивать.


Уже говорилось, книжку по UNIX в руки и в путь.
Оглашу выборочно, для затравки.

75 nobody S 384 1 0.0 1.2 dnsmasq - ДНС-кэш. Полезная вещь, если у провайдера тормозной DNS-сервер
111 admin S 384 1 0.0 1.2 pppd - запущен из-под pptp, осуществляет собственно доступ в инет.
612 admin S 348 1 0.0 1.1 httpd - демон для веб-интерфейса настройки
118 admin S 200 114 0.0 0.6 ntp - процесс, который синхронизирует время на роутере с эталонным.
73 admin S 184 1 0.0 0.6 klogd - kernel logger
85 admin S 168 1 0.0 0.5 lpd - демон принтера
3 admin SWN 0 1 0.0 0.0 ksoftirqd_CPU0 - демон обсдуживания прерываний
96 admin SW 0 1 0.0 0.0 usb-storage-0 - высокоуровневый интерфейс к флешке.
4 admin SW 0 1 0.0 0.0 kswapd - kernel swap daemon.
147 admin SW 0 1 0.0 0.0 kjournald -- отвечает за журналирование ext3
7 admin SW 0 1 0.0 0.0 mtdblockd -- работает с встроенным флешем
al37919
18-06-2007, 06:53
Если беспокоит свап, то надо прибить amule, torrent-ы, mldonkey и иже с ними и использовать только wget, а эти сервисы в принципе много не едят, что и было показано в ответе на вопрос.

Тем не менее:

612 admin S 348 1 0.0 1.1 httpd - возможно демон для веб-интерфейса настройки?

да

1 admin S 252 0 0.0 0.8 init - скрипты инициализации?

главный процесс, который запускает остальные

119 admin S 428 116 0.1 1.4 pptp - мое pptp соединение с интернет
68 admin S 388 1 0.0 1.2 nas - инет сказал, что это демон для подключенной к роуетру флешки
75 nobody S 384 1 0.0 1.2 dnsmasq - из названия понятно, что это какой то днс маскарадинг. а что он делает?
111 admin S 384 1 0.0 1.2 pppd - не понимаю, что это.

это все обеспечивает работу сети,

127 admin S 272 1 0.0 0.9 pptp - почему то второе pptp соединение... не понимаю почему.

не знаю

129 admin S 228 1 0.0 0.7 dropbear - откуда второй dropbear? я сейчас использую только одно соединение.

dropbear всегда запущен в количестве: число соединений+1.

87 admin S 160 1 0.0 0.5 p910nd - не понимаю

это демон принтера raw (рекомендуется Олегом) Если принтера нет, можно прибить в веб-интерфейсе

85 admin S 168 1 0.0 0.5 lpd - тоже не понимаю

это другой демон принтера. Его уж точно можно прибить в веб-иф

62 admin S 140 1 0.0 0.4 telnetd - как можно отключить telnet?

можно (тоже в веб-иф). Однако, я например его оставляю на всякий случае --- если взглюкнет ssh. Изредка такое бывает

118 admin S 200 114 0.0 0.6 ntp - я так понимаю, я могу
указать в качестве ntp-сервера на домашних машинах свой роутер...

каждые 2 часа эта штука уточняет время на роутере

116 admin S 188 111 0.0 0.6 sh - зачем то второй шелл :-/

на каждое интерактивное соединение (telnet, ssh) запускается отдельная копия шелла. Кроме того, если запущен какой-то скрипт в виде демона, то он тоже может держать копию шелла в памяти (смотря как запущен)

90 admin S 188 1 0.0 0.6 waveservermain - тоже не ставил...

звуковой сервер (убивать в веб-иф)

92 admin S 188 1 0.0 0.6 rcamdmain - этого я не устанавливал. что это?

там еще должен быть какой то демон для веб-камеры, похоже это он (убивать в веб-иф)

96 admin SW 0 1 0.0 0.0 usb-storage-0 - не понимаю, я же уже один демон для флешки упоминал...
97 admin SW 0 1 0.0 0.0 scsi_eh_0

это для внешнего usb носителя

73 admin S 184 1 0.0 0.6 klogd - тоже не понимаю что это
3 admin SWN 0 1 0.0 0.0 ksoftirqd_CPU0 - не понимаю
4 admin SW 0 1 0.0 0.0 kswapd - в общем все что ниже я тоже не понимаю зачем и нужно ли...
147 admin SW 0 1 0.0 0.0 kjournald
7 admin SW 0 1 0.0 0.0 mtdblockd
5 admin SW 0 1 0.0 0.0 bdflush
2 admin SW 0 1 0.0 0.0 keventd
6 admin SW 0 1 0.0 0.0 kupdated
76 admin SW 0 1 0.0 0.0 khubd

это все системные процессы, которые нужны ей для функционирования (буква к вначале названия от слова kernel).

Напоследок приведу список своих процессов (в свое время я почистил от ненужного [интернет у меня через PPPoE]) за исключением тех, которые я ставил сам через ipkg

root 1 0.0 0.3 2368 112 ? S Jun17 0:05 /sbin/init
root 2 0.0 0.0 0 0 ? S Jun17 0:00 [keventd]
root 3 0.1 0.0 0 0 ? RN Jun17 1:10 [ksoftirqd_CPU0]
root 4 0.0 0.0 0 0 ? S Jun17 0:15 [kswapd]
root 5 0.0 0.0 0 0 ? S Jun17 0:00 [bdflush]
root 6 0.0 0.0 0 0 ? S Jun17 0:00 [kupdated]
root 7 0.0 0.0 0 0 ? S Jun17 0:04 [mtdblockd]
root 57 0.0 0.1 2668 44 ? S Jun17 0:00 telnetd
root 62 0.0 0.8 1916 264 ? S Jun17 0:09 httpd vlan1
root 68 0.0 0.3 2668 92 ? S Jun17 0:00 klogd
nobody 69 0.0 0.4 964 140 ? S Jun17 0:05 dnsmasq
root 73 0.0 0.2 1888 88 ? Ss Jun17 0:01 nas /tmp/nas.lan.conf /tmp/nas.lan.pid lan
root 75 0.0 0.0 0 0 ? S Jun17 0:00 [khubd]
root 84 0.0 0.2 804 64 ? Ss Jun17 0:00 p9100d -f /dev/usb/lp0 0
root 88 0.0 0.3 1752 92 ? Ss Jun17 0:00 infosvr br0
root 89 0.0 0.7 2348 228 ? Ss Jun17 0:06 watchdog
root 92 0.0 0.2 2336 88 ? Ss Jun17 0:00 ntp
root 106 0.0 0.3 1752 104 ? S Jun17 0:03 dropbear
root 153 0.0 0.4 2684 148 ? S Jun17 0:01 udhcpc -i vlan1 -p /var/run/udhcpc0.pid -s /tmp/udhcpc
root 154 0.1 0.0 0 0 ? S Jun17 1:16 [usb-storage-0]
root 155 0.0 0.0 0 0 ? S Jun17 0:00 [scsi_eh_0]
root 163 0.0 0.0 0 0 ? S Jun17 0:03 [kjournald]
root 22439 0.0 1.1 1852 332 ? S 08:30 0:00 upnp -D -L br0 -W vlan1
root 24592 0.1 1.1 1840 332 ? Ss 08:59 0:03 dropbear
FilimoniC
18-06-2007, 07:29
Кажется где-то проскакивала фраза о том что в линухе нет потоков, поэтому создается несколько процессов.
Reyter
19-06-2007, 09:07
Такая же проблема роутер работает в режиме.. хм... роутера. :)
Т.е. роутит между двумя подсетями. Количество хостов сотни полторы. Сканирование ресурсов сетки - вполне нормальное явление в нашей домовой сети.
Так нашел кто-нибудь способ борьбы с переполнением таблицы arp?
owld
19-06-2007, 13:43
/bin/echo 1024 > /proc/sys/net/ipv4/neigh/default/gc_thresh1
/bin/echo 2048 > /proc/sys/net/ipv4/neigh/default/gc_thresh2
/bin/echo 4096 > /proc/sys/net/ipv4/neigh/default/gc_thresh3

в post-boot.

Мне помогло, правда ненадолго.

команда arp :
ip nei show

Кстати никакого там переполнения нет
Reyter
19-06-2007, 14:01
Кстати никакого там переполнения нет
Хм... А какого фига тогда эти мессаги сыплются?

Спасибо, попробую этот вариант. И за команду спасибо, может изучение arp-таблиц наведет на какие мысли полезные.
А вообще мысли есть, откуда вся эта ерунда берется? Не должно ведь такого быть.
Vaml7uP
19-06-2007, 19:48
меня один раз забанили в моей сетке за арп флуд от роутера.... ((
причём банил робот:)
djet
07-08-2007, 13:06
А что есть infosrv не подскажете?
mkk
11-08-2007, 19:02
Весь лог состоит из таких записей. Что это?


Aug 11 22:51:41 nmbd[122]: [2007/08/11 22:51:41, 0] nmbd/nmbd_incomingrequests.c:process_name_refresh_reque st(180)
Aug 11 22:51:41 nmbd[122]: process_name_refresh_request: unicast name registration request received for name MyPC<20> from IP 192.168.1.10 on subnet UNICAST_SUBNET.
Aug 11 22:51:41 nmbd[122]: [2007/08/11 22:51:41, 0] nmbd/nmbd_incomingrequests.c:process_name_refresh_reque st(181)
Aug 11 22:51:41 nmbd[122]: Error - should be sent to WINS server
Aug 11 22:51:41 nmbd[122]: [2007/08/11 22:51:41, 0] nmbd/nmbd_incomingrequests.c:process_name_refresh_reque st(180)
Aug 11 22:51:41 nmbd[122]: process_name_refresh_request: unicast name registration request received for name MyPC<00> from IP 192.168.1.10 on subnet UNICAST_SUBNET.
Aug 11 22:51:41 nmbd[122]: [2007/08/11 22:51:41, 0] nmbd/nmbd_incomingrequests.c:process_name_refresh_reque st(181)
Aug 11 22:51:41 nmbd[122]: Error - should be sent to WINS server
vsu
12-08-2007, 16:37
На машине 192.168.1.10 (с именем MyPC) в настройках сети в качестве сервера WINS указан адрес роутера, при этом на самом роутере WINS не включен. Нужно убрать роутер из списка серверов WINS на этой машине. Можно, конечно, сделать и наоборот - включить на роутере wins support = yes в smb.conf, но обычно это делать не стоит (хотя в некоторых ситуациях возможность поднять WINS на роутере может быть полезной).
mkk
13-08-2007, 20:05
спасибо :)
vladonline
18-09-2007, 16:23
Вот в такое состояние wl500gx иногда впадает - карточка отказывается ассоциироваться с AP (после перезагрузки wl500gx все в норме). Лог полностью в приложнении:


Initializing interface 'eth1' conf '/etc/wpa_supplicant/wpa_supplicant.conf' driver 'default' ctrl_interface 'N/A' bridge 'N/A'
Configuration file '/etc/wpa_supplicant/wpa_supplicant.conf' -> '/etc/wpa_supplicant/wpa_supplicant.conf'
Reading configuration file '/etc/wpa_supplicant/wpa_supplicant.conf'
ctrl_interface='/var/run/wpa_supplicant'
ctrl_interface_group='wheel' (DEPRECATED)
Line: 6 - start of a new network block
ssid - hexdump_ascii(len=6):
56 6f 6c 6e 61 31 Volna1
scan_ssid=1 (0x1)
key_mgmt: 0x2
proto: 0x1
pairwise: 0x8
group: 0x8
PSK (ASCII passphrase) - hexdump_ascii(len=9): [REMOVED]
PSK (from passphrase) - hexdump(len=32): [REMOVED]
Priority group 0
id=0 ssid='Volna1'
Initializing interface (2) 'eth1'
EAPOL: SUPP_PAE entering state DISCONNECTED
EAPOL: KEY_RX entering state NO_KEY_RECEIVE
EAPOL: SUPP_BE entering state INITIALIZE
EAP: EAP entering state DISABLED
EAPOL: External notification - portEnabled=0
EAPOL: External notification - portValid=0
SIOCGIWRANGE: WE(compiled)=22 WE(source)=18 enc_capa=0xf
capabilities: key_mgmt 0xf enc 0xf
WEXT: Operstate: linkmode=1, operstate=5
Own MAC address: 00:13:ce:c6:ff:30
wpa_driver_wext_set_wpa
wpa_driver_wext_set_key: alg=0 key_idx=0 set_tx=0 seq_len=0 key_len=0
wpa_driver_wext_set_key: alg=0 key_idx=1 set_tx=0 seq_len=0 key_len=0
wpa_driver_wext_set_key: alg=0 key_idx=2 set_tx=0 seq_len=0 key_len=0
wpa_driver_wext_set_key: alg=0 key_idx=3 set_tx=0 seq_len=0 key_len=0
wpa_driver_wext_set_countermeasures
wpa_driver_wext_set_drop_unencrypted
Setting scan request: 0 sec 100000 usec
ctrl_interface_group=10 (from group name 'wheel')
Added interface eth1
RTM_NEWLINK: operstate=0 ifi_flags=0x1002 ()
Wireless event: cmd=0x8b06 len=8
RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
RTM_NEWLINK, IFLA_IFNAME: Interface 'eth1' added
State: DISCONNECTED -> SCANNING
Starting AP scan (specific SSID)
Scan SSID - hexdump_ascii(len=6):
56 6f 6c 6e 61 31 Volna1
Trying to get current scan results first without requesting a new scan to speed up initial association
Received 522 bytes of scan results (2 BSSes)
Scan results: 2
Selecting BSS from priority group 0
0: 00:11:d8:f4:62:8b ssid='Volna1' wpa_ie_len=30 rsn_ie_len=26 caps=0x11
selected based on WPA IE
Trying to associate with 00:11:d8:f4:62:8b (SSID='Volna1' freq=2437 MHz)
Cancelling scan request
WPA: clearing own WPA/RSN IE
Automatic auth_alg selection: 0x1
WPA: using IEEE 802.11i/D3.0
WPA: Selected cipher suites: group 8 pairwise 24 key_mgmt 2 proto 1
WPA: set AP WPA IE - hexdump(len=30): dd 1c 00 50 f2 01 01 00 00 50 f2 02 02 00 00 50 f2 04 00 50 f2 02 01 00 00 50 f2 02 00 00
WPA: set AP RSN IE - hexdump(len=26): 30 18 01 00 00 0f ac 02 02 00 00 0f ac 04 00 0f ac 02 01 00 00 0f ac 02 00 00
WPA: using GTK TKIP
WPA: using PTK TKIP
WPA: using KEY_MGMT WPA-PSK
WPA: Set own WPA IE default - hexdump(len=24): dd 16 00 50 f2 01 01 00 00 50 f2 02 01 00 00 50 f2 02 01 00 00 50 f2 02
No keys have been configured - skip key clearing
wpa_driver_wext_set_drop_unencrypted
State: SCANNING -> ASSOCIATING
wpa_driver_wext_set_operstate: operstate 0->0 (DORMANT)
WEXT: Operstate: linkmode=-1, operstate=5
wpa_driver_wext_associate
Setting authentication timeout: 15 sec 0 usec
EAPOL: External notification - EAP success=0
EAPOL: External notification - EAP fail=0
EAPOL: External notification - portControl=Auto
RSN: Ignored PMKID candidate without preauth flag
RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
Wireless event: cmd=0x8b06 len=8
RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
Wireless event: cmd=0x8b04 len=12
RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
Wireless event: cmd=0x8b1a len=14
RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
Wireless event: cmd=0x8b19 len=8
Received 519 bytes of scan results (2 BSSes)
Scan results: 2
Selecting BSS from priority group 0
0: 00:11:d8:f4:62:8b ssid='Volna1' wpa_ie_len=30 rsn_ie_len=26 caps=0x11
selected based on WPA IE
Already associated with the selected AP.
RSN: Ignored PMKID candidate without preauth flag
RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
Wireless event: cmd=0x8b15 len=20
Wireless event: new AP: 00:00:00:00:00:00
Added BSSID 00:11:d8:f4:62:8b into blacklist
CTRL-EVENT-DISCONNECTED - Disconnect event - remove keys
wpa_driver_wext_set_key: alg=0 key_idx=0 set_tx=0 seq_len=0 key_len=0
wpa_driver_wext_set_key: alg=0 key_idx=1 set_tx=0 seq_len=0 key_len=0
wpa_driver_wext_set_key: alg=0 key_idx=2 set_tx=0 seq_len=0 key_len=0
wpa_driver_wext_set_key: alg=0 key_idx=3 set_tx=0 seq_len=0 key_len=0
wpa_driver_wext_set_key: alg=0 key_idx=0 set_tx=0 seq_len=0 key_len=0
State: ASSOCIATING -> DISCONNECTED
wpa_driver_wext_set_operstate: operstate 0->0 (DORMANT)
WEXT: Operstate: linkmode=-1, operstate=5
EAPOL: External notification - portEnabled=0
EAPOL: External notification - portValid=0
EAPOL: External notification - EAP success=0
RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
Wireless event: cmd=0x8b19 len=8
Received 519 bytes of scan results (2 BSSes)
Scan results: 2
Selecting BSS from priority group 0
0: 00:11:d8:f4:62:8b ssid='Volna1' wpa_ie_len=30 rsn_ie_len=26 caps=0x11
selected based on WPA IE
Trying to associate with 00:11:d8:f4:62:8b (SSID='Volna1' freq=2437 MHz)
Cancelling scan request
WPA: clearing own WPA/RSN IE
Automatic auth_alg selection: 0x1
WPA: using IEEE 802.11i/D3.0
WPA: Selected cipher suites: group 8 pairwise 24 key_mgmt 2 proto 1
WPA: set AP WPA IE - hexdump(len=30): dd 1c 00 50 f2 01 01 00 00 50 f2 02 02 00 00 50 f2 04 00 50 f2 02 01 00 00 50 f2 02 00 00
WPA: set AP RSN IE - hexdump(len=26): 30 18 01 00 00 0f ac 02 02 00 00 0f ac 04 00 0f ac 02 01 00 00 0f ac 02 00 00
WPA: using GTK TKIP
WPA: using PTK TKIP
WPA: using KEY_MGMT WPA-PSK
WPA: Set own WPA IE default - hexdump(len=24): dd 16 00 50 f2 01 01 00 00 50 f2 02 01 00 00 50 f2 02 01 00 00 50 f2 02
No keys have been configured - skip key clearing
wpa_driver_wext_set_drop_unencrypted
State: DISCONNECTED -> ASSOCIATING
wpa_driver_wext_set_operstate: operstate 0->0 (DORMANT)
WEXT: Operstate: linkmode=-1, operstate=5
wpa_driver_wext_associate
Setting authentication timeout: 15 sec 0 usec
..
nihil
21-09-2007, 10:27
1. Вылезают постоянные предупреждения в логе типа

Sep 21 10:37:26 syslog: Warn: The origin for route 239.255.255.250 changed from 10.242.17.18 to 10.242.29.54
Sep 21 10:38:00 syslog: Warn: The origin for route 239.255.255.250 changed from 10.242.29.54 to 10.242.56.119
Sep 21 10:39:09 syslog: Warn: The origin for route 239.255.255.250 changed from 10.242.56.119 to 10.242.29.237
Sep 21 10:39:46 syslog: Warn: The origin for route 239.255.255.250 changed from 10.242.29.237 to 10.242.31.167
Sep 21 10:40:11 syslog: Warn: The origin for route 239.255.255.250 changed from 10.242.31.167 to 10.242.63.45
Sep 21 10:42:53 syslog: Warn: The origin for route 239.255.255.250 changed from 10.242.63.45 to 10.242.54.142
Sep 21 10:44:03 syslog: Warn: The origin for route 239.255.255.250 changed from 10.242.54.142 to 10.242.54.68
Что это?

2. Стала часто рваться связь... непонятна стока, выделенная в логе:

Sep 21 10:55:38 pppd[188]: LCP terminated by peer
Sep 21 10:55:38 pppd[188]: Modem hangup
Sep 21 10:55:38 pppd[188]: Connection terminated.
Sep 21 10:55:38 pppd[188]: Connect time 476.0 minutes.
Из-за чего это может быть? Может из за Осла с Торрентом и превышением числа подключений?
Reyter
21-09-2007, 10:53
1. Если нет реальной необходимости в использовании этой фичи, то нужно отключить Enable Multicast routing на странице IP Config | Route
2. Соединение разорвано удаленной стороной. Провайдером. Вообще разрывы соединения раз в 8 часов не кажутся мне слишком уж "частыми".
nihil
21-09-2007, 11:08
все дело в том, что в корбине соединение должно быть вроде неделю...

я был на стриме 3 года, так там соединенеи раз в сутки стабильно рвется. а в корбине мне не понятно, что на разрыв влияет, до этого соденение было дня 3. а вчера я включил отдачу в емуле с 30 на 100кб/с и торрент на скорости 100 установлен. я подумал, может роутер не выдержал количества соединений.
nihil
30-09-2007, 12:09
Добавил новое правило в НАТ. Минут через 10 связь разорвалась. Полез в лог, а там:

Sep 30 14:53:12 pppd[126]: LCP terminated by peer
Sep 30 14:53:12 pppd[126]: Modem hangup
Sep 30 14:53:12 pppd[126]: Connection terminated.
Sep 30 14:53:12 pppd[126]: Connect time 19852492.1 minutes.
Sep 30 14:53:12 pppd[126]: Sent 255583753 bytes, received 34869675 bytes.
Sep 30 14:53:12 dnsmasq[69]: read /etc/hosts - 5 addresses
Sep 30 14:53:12 dnsmasq[69]: reading /tmp/resolv.conf
Sep 30 14:53:12 dnsmasq[69]: using nameserver 85.21.192.3#53
Sep 30 14:53:12 dnsmasq[69]: using nameserver 213.234.192.8#53
Sep 30 14:53:12 L2TP: Disconnected
Sep 30 14:53:12 pppd[126]: Connect time 19852492.1 minutes.
Sep 30 14:53:12 pppd[126]: Sent 255583753 bytes, received 34869675 bytes.
Sep 30 14:53:12 pppd[126]: Exit.
Через пять минут соеденилось, а через минуту опять порвалось:

Sep 30 14:59:34 pppd[243]: Modem hangup
Sep 30 14:59:34 pppd[243]: Connection terminated.
Sep 30 14:59:34 pppd[243]: Connect time 1.0 minutes.
Sep 30 14:59:34 pppd[243]: Sent 316452863 bytes, received 54 bytes.
Sep 30 14:59:34 pppd[243]: Connect time 1.0 minutes.
Sep 30 14:59:34 pppd[243]: Sent 316452863 bytes, received 54 bytes.
Sep 30 14:59:34 pppd[243]: Exit.
Глюк?
nihil
30-09-2007, 17:59
Соединение рвется через каждый час. Да еще вот такие ошибки полезли:

Sep 30 20:49:34 syslog: Warn: MRT_DEL_MFC; Errno(2): No such file or directory
Sep 30 20:49:34 syslog: Warn: MRT_DEL_MFC; Errno(2): No such file or directory
Sep 30 20:49:34 syslog: Warn: MRT_DEL_MFC; Errno(2): No such file or directory
Sep 30 20:49:34 syslog: Warn: MRT_DEL_MFC; Errno(2): No such file or directory
Sep 30 20:49:34 syslog: Warn: MRT_DEL_MFC; Errno(2): No such file or directory
Sep 30 20:49:34 syslog: Warn: MRT_DEL_MFC; Errno(2): No such file or directory
Sep 30 20:49:34 syslog: Warn: MRT_DEL_MFC; Errno(2): No such file or directory
Sep 30 20:49:34 syslog: Warn: MRT_DEL_MFC; Errno(2): No such file or directory
Причем я ничего не ставил и ничего в USB не подключал... Может с роутером проблемы:eek: :confused:
VEDMED007
30-09-2007, 20:14
Абсолютно такие же симптомы.
Это флуд в сети. Сеть не справляется - отсюда беспорядок с роутами и проблемы с коннектом.
Звони в поддержку, заводи заявки, пиши на форуме корбины.
Вот моя тема там же http://homenet.corbina.net/index.php?showtopic=143723

ЗЫ (В разделе Internet firewall включи log packets: Dropped и перезагрузи роутер - в моменты разрыва у тебя будет до 10 сообщений в секунду об отклоненных броадкастовых пакетах)
Andrey_3
16-10-2007, 10:32
Здравствуйте!

Обнаружил в системном логе множественные сообщения об ошибках "attempt to access beyond end of device":


...
Jan 1 03:00:05 kernel: SCSI subsystem driver Revision: 1.00
Jan 1 03:00:06 kernel: Initializing USB Mass Storage driver...
Jan 1 03:00:06 kernel: usb.c: registered new driver usb-storage
Jan 1 03:00:06 kernel: scsi0 : SCSI emulation for USB Mass Storage devices
Jan 1 03:00:06 kernel: Vendor: WDC WD80 Model: 0UE-00HCT0 Rev: 0000
Jan 1 03:00:06 kernel: Type: Direct-Access ANSI SCSI revision: 02
Jan 1 03:00:06 kernel: Attached scsi disk sda at scsi0, channel 0, id 0, lun 0
Jan 1 03:00:06 kernel: SCSI device sda: 156301488 512-byte hdwr sectors (80026 MB)
Jan 1 03:00:06 kernel: Partition check:
Jan 1 03:00:06 kernel: p1 p2 p3
Jan 1 03:00:06 kernel: USB Mass Storage support registered.
Jan 1 03:00:11 kernel: usb.c: deregistering driver usblp
Jan 1 03:00:15 kernel: VFS: Can't find ext3 filesystem on dev sd(8,0).
Jan 1 03:00:15 kernel: MSDOS FS: Using codepage 950
Jan 1 03:00:15 kernel: MSDOS FS: IO charset cp950
Jan 1 03:00:15 kernel: FAT: bogus logical sector size 64543
Jan 1 03:00:15 kernel: VFS: Can't find a valid FAT filesystem on dev 08:00.
Jan 1 03:00:15 kernel: FAT: freeing iocharset=cp950
Jan 1 03:00:15 kernel: FAT: bogus logical sector size 64543
Jan 1 03:00:15 kernel: VFS: Can't find a valid FAT filesystem on dev 08:00.
Jan 1 03:00:15 kernel: VFS: Can't find ext3 filesystem on dev sd(8,1).
Jan 1 03:00:15 kernel: MSDOS FS: Using codepage 950
Jan 1 03:00:15 kernel: MSDOS FS: IO charset cp950
Jan 1 03:00:15 kernel: Directory 1: bad FAT
Jan 1 03:00:16 kernel: attempt to access beyond end of device
Jan 1 03:00:16 kernel: 08:01: rw=0, want=1464544849, limit=56196
Jan 1 03:00:16 kernel: attempt to access beyond end of device
Jan 1 03:00:16 kernel: 08:01: rw=0, want=1464544850, limit=56196
Jan 1 03:00:16 kernel: attempt to access beyond end of device
Jan 1 03:00:16 kernel: 08:01: rw=0, want=1464544850, limit=56196
Jan 1 03:00:16 kernel: attempt to access beyond end of device
Jan 1 03:00:16 kernel: 08:01: rw=0, want=1464544851, limit=56196
Jan 1 03:00:16 kernel: attempt to access beyond end of device
Jan 1 03:00:16 kernel: 08:01: rw=0, want=1464544851, limit=56196
...
Jan 1 03:00:16 kernel: attempt to access beyond end of device
Jan 1 03:00:16 kernel: 08:01: rw=0, want=1464544881, limit=56196
Jan 1 03:00:16 kernel: Filesystem panic (dev 08:01).
Jan 1 03:00:16 kernel: FAT error
Jan 1 03:00:16 kernel: File system has been set read-only
Jan 1 03:00:16 USB storage: vfat fs mounted to /tmp/harddisk
Jan 1 03:00:16 kernel: attempt to access beyond end of device
Jan 1 03:00:16 kernel: 08:01: rw=0, want=150513, limit=56196
Jan 1 03:00:16 kernel: attempt to access beyond end of device
Jan 1 03:00:16 kernel: 08:01: rw=0, want=150514, limit=56196
Jan 1 03:00:16 kernel: attempt to access beyond end of device
Jan 1 03:00:16 kernel: 08:01: rw=0, want=150514, limit=56196
...
Jan 1 03:00:16 kernel: nd of device
...
Jan 1 03:00:17 kernel: attempt to access beyond end of device
Jan 1 03:00:17 kernel: 08:01: rw=0, want=169329777, limit=56196
Jan 1 03:00:17 kernel: Filesystem panic (dev 08:01).
Jan 1 03:00:17 kernel: FAT error
Jan 1 03:00:17 kernel: Directory 2: bad FAT
Jan 1 03:00:17 kernel: kjournald starting. Commit interval 5 seconds
Jan 1 03:00:17 kernel: EXT3 FS 2.4-0.9.19, 19 August 2002 on sd(8,2), internal journal
Jan 1 03:00:17 kernel: EXT3-fs: mounted filesystem with ordered data mode.
Jan 1 03:00:17 USB storage: ext3 fs mounted to /tmp/harddisk/part1
Jan 1 03:00:18 kernel: attempt to access beyond end of device
Jan 1 03:00:18 kernel: 08:01: rw=0, want=151633, limit=56196
Jan 1 03:00:18 kernel: attempt to access beyond end of device
...
Jan 1 03:00:18 kernel: 08:01: rw=0, want=151664, limit=56196
Jan 1 03:00:18 kernel: attempt to access beyond end of device
Jan 1 03:00:18 kernel: 08:01: rw=0, want=151665, limit=56196
Jan 1 03:00:18 kernel: Filesystem panic (dev 08:01).
Jan 1 03:00:18 kernel: FAT error
Jan 1 03:00:18 kernel: Directory 3: bad FAT
Jan 1 03:00:18 kernel: kjournald starting. Commit interval 5 seconds
Jan 1 03:00:18 kernel: EXT3 FS 2.4-0.9.19, 19 August 2002 on sd(8,3), internal journal
Jan 1 03:00:18 kernel: EXT3-fs: mounted filesystem with ordered data mode.
Jan 1 03:00:18 USB storage: ext3 fs mounted to /tmp/harddisk/part2
Jan 1 03:00:18 kernel: kjournald starting. Commit interval 5 seconds
Jan 1 03:00:18 kernel: EXT3 FS 2.4-0.9.19, 19 August 2002 on sd(8,2), internal journal
Jan 1 03:00:18 kernel: EXT3-fs: mounted filesystem with ordered data mode.
Jan 1 03:00:18 kernel: kjournald starting. Commit interval 5 seconds
Jan 1 03:00:18 kernel: EXT3 FS 2.4-0.9.19, 19 August 2002 on sd(8,3), internal journal
Jan 1 03:00:18 kernel: EXT3-fs: mounted filesystem with ordered data mode.
Jan 1 03:00:18 kernel: Adding Swap: 56188k swap-space (priority -1)
Jan 1 03:00:18 System log daemon exiting.
...

Диск разбит на 3 раздела:


Disk /dev/scsi/host0/bus0/target0/lun0/disc: 80.0 GB, 80026361856 bytes
255 heads, 63 sectors/track, 9729 cylinders
Units = cylinders of 16065 * 512 = 8225280 bytes

Device Boot Start End Blocks Id System
/dev/scsi/host0/bus0/target0/lun0/part1 1 7 56196 82 Linux swap
/dev/scsi/host0/bus0/target0/lun0/part2 8 251 1959930 83 Linux
/dev/scsi/host0/bus0/target0/lun0/part3 252 9729 76132035 83 Linux

Проверка разделов утилитой fsck.ext3 никаких ошибок не выявила.

Подскажите в чем может быть проблема?
Спасибо.
Duke
16-10-2007, 10:43
у меня подобное было на делюксе с однйо коробкой - вылечилось подключением коробки через хаб. та же коробка на премиуме работает без нареканий. какие-то проблемы с Usb.
Gaoo
18-10-2007, 17:42
Господа?
а что это значит:

Oct 18 20:34:41 pptp[105]: anon log[logecho:pptp_ctrl.c:670]: Echo Reply received.
Oct 18 20:35:41 pptp[105]: anon log[logecho:pptp_ctrl.c:670]: Echo Request received.
Oct 18 20:35:41 pptp[105]: anon log[ctrlp_rep:pptp_ctrl.c:251]: Sent control packet type is 6 'Echo-Reply'
Oct 18 20:36:41 pptp[105]: anon log[logecho:pptp_ctrl.c:670]: Echo Request received.
Oct 18 20:36:41 pptp[105]: anon log[ctrlp_rep:pptp_ctrl.c:251]: Sent control packet type is 6 'Echo-Reply'
Oct 18 20:36:41 pptp[105]: anon log[logecho:pptp_ctrl.c:670]: Echo Reply received.
Oct 18 20:36:41 pptp[105]: anon log[logecho:pptp_ctrl.c:672]: no more Echo Reply/Request packets will be reported.
nihil
24-10-2007, 17:27
Всю ночь и весь день выдавало это:

2007-10-24 08:11:05 User.Warning 192.168.1.1 kernel: NET: 8 messages suppressed.
2007-10-24 08:11:05 User.Warning 192.168.1.1 kernel: ip_conntrack: table full, dropping packet.
2007-10-24 08:11:11 User.Warning 192.168.1.1 kernel: NET: 4 messages suppressed.
2007-10-24 08:11:11 User.Warning 192.168.1.1 kernel: ip_conntrack: table full, dropping packet.
2007-10-24 08:11:15 User.Warning 192.168.1.1 kernel: NET: 6 messages suppressed.
2007-10-24 08:11:15 User.Warning 192.168.1.1 kernel: ip_conntrack: table full, dropping packet.
2007-10-24 08:11:20 User.Warning 192.168.1.1 kernel: NET: 9 messages suppressed.
2007-10-24 08:11:20 User.Warning 192.168.1.1 kernel: ip_conntrack: table full, dropping packet.
2007-10-24 08:11:25 User.Warning 192.168.1.1 kernel: NET: 9 messages suppressed.
2007-10-24 08:11:25 User.Warning 192.168.1.1 kernel: ip_conntrack: table full, dropping packet.
2007-10-24 08:11:31 User.Warning 192.168.1.1 kernel: NET: 12 messages suppressed.
Причем еле открывало страницы и в веб-интерфейс не мог зайти. Из-за чего это?
Я конечно понимаю что пакеты "дропались" и таблица переполнена, но вот что за таблица и почему переполнилась?
И что за сообщения, которые заблокировались?
Oleg
24-10-2007, 19:08
слишком большое число соединений от осла или торрента скорее всего. а сообщения были однотипные, поэтому он показал первое, а потом написал кол-во таких же.
ValZ
25-10-2007, 13:51
слишком большое число соединений от осла или торрента скорее всего. а сообщения были однотипные, поэтому он показал первое, а потом написал кол-во таких же.
Ничего ничем не качаю. -) Интернет радио сижу слушаю... полез на сайт, кое как открывается все. Радио выключил, все равно тормоза дикие какие то.
Пишет тоже самое... вот кусок:
Oct 25 18:41:45 kernel: ip_conntrack: table full, dropping packet.
Oct 25 18:41:50 kernel: ip_conntrack: table full, dropping packet.
Oct 25 18:41:51 kernel: ip_conntrack: table full, dropping packet.
Oct 25 18:41:51 kernel: ip_conntrack: table full, dropping packet.

Как лечить то? Роутер перезагружать? -)
Mam(O)n
25-10-2007, 14:09
Как лечить то?
А лечить похоже комп надо, ибо на червячок похоже...
nihil
29-10-2007, 20:15
Олег.
Сегодня днем мне вроде некто Андрей настраивал IPTV, и VLC стал показывать каналы, но изображение сыпется и т.п.
Но вопрос не в этом. С 17.00 стало рваться подключение по L2TP. До 21.00 была пре15, потом сменил на пре16, ситуация не изменилась. В логах при разрыве
l2tpd[105]: Too many retransmissions on tunnel (55387/52624); closing down и переодически серии
l2tpd[105]: Unknown tunnel 55387
Я не могу понять, у меня всегда работает еМул и Торрент на прием и отдачу на 3/4 тарифа 4Мегабита.
Какая причина этих ошибок? С моей стороны или Корбины?

ЗЫ До сегодняшнего дня неделю сесии по 100 и более часов держались...
Oleg
30-10-2007, 09:16
думаю, что у корбины один из л2тп серверов "того". :) просто теперь он выбирается в качестве сервера.
djet
30-10-2007, 10:52
похоже, 255-й брас вчера действительно всех дропал.
ValZ
01-11-2007, 08:46
Что то раньше не обращал внимания... а чего за ошибки он выдает? I/O error и все такое, но тут же все находит и подключает. Так и должно быть?

Nov 1 13:37:48 kernel: hub.c: new USB device 01:02.2-2, assigned address 4
Nov 1 13:37:51 kernel: I/O error: dev 08:00, sector 2
Nov 1 13:37:51 kernel: EXT3-fs: unable to read superblock
Nov 1 13:37:51 kernel: SCSI device sda: 4030464 512-byte hdwr sectors (2064 MB)
Nov 1 13:37:51 kernel: sda: Write Protect is off
Nov 1 13:37:51 kernel: p1
Nov 1 13:37:51 kernel: MSDOS FS: Using codepage 866
Nov 1 13:37:51 kernel: MSDOS FS: IO charset cp1251
Nov 1 13:37:51 kernel: FAT: bogus logical sector size 64543
Nov 1 13:37:51 kernel: VFS: Can't find a valid FAT filesystem on dev 08:00.
Nov 1 13:37:51 kernel: FAT: freeing iocharset=cp1251
Nov 1 13:37:51 kernel: FAT: bogus logical sector size 64543
Nov 1 13:37:51 kernel: VFS: Can't find a valid FAT filesystem on dev 08:00.
Nov 1 13:37:51 kernel: VFS: Can't find ext3 filesystem on dev sd(8,1).
Nov 1 13:37:51 kernel: MSDOS FS: Using codepage 866
Nov 1 13:37:51 kernel: MSDOS FS: IO charset cp1251
Nov 1 13:37:51 USB storage: vfat fs mounted to /tmp/harddisk
Nov 1 13:37:51 FTP server: daemon is started
Oleg
01-11-2007, 11:10
Поведение нормальное. Ошибки пишутся, поскольку код пытается монтировать "в лоб" всё подряд...
mkk
13-11-2007, 20:52
Весь лог усыпан такими сообщениями:

udhcpc[109]: Lease of 10.***.***.*** obtained, lease time 1200
Как это можно убрать?
al37919
13-11-2007, 21:06
похоже, что у dhcp сервера установлен lease time = 20 min (1200 сек). Вот он каждые 20 минут и обновляет арендованные адреса. Попробуйте поставить в веб-ИФ 86400 (сутки)
Oleg
14-11-2007, 08:04
Боюсь, что менять прийдётся у провайдера. :)
mkk
14-11-2007, 09:26
Видимо неправильно высказался.

То что это закончился срок аренды адреса, я понимаю.
Вопрос в том, можно ли запретить роутеру писать в лог эти сообщения?
al37919
14-11-2007, 11:02
полагаю можно перезапустить syslogd с меньшим значением loglevel
lexass
14-11-2007, 12:45
ничего ли лишнего?
да и накой частая Synchronizing time with time.nist.gov ...
al37919
14-11-2007, 12:50
не знаю как насчет pptp, а синхронизация времени каждые 2 часа задана а веб-ИФ в настройках ntp
lexass
14-11-2007, 12:55
во я лоханулся (со временем), спсиб...
ЗЫ
интересует обзор лога, мож что не нужное включено (никаких девайсов не подключено) :confused:
Oleg
14-11-2007, 12:57
Похоже версия прошивки не последняя.
lexass
14-11-2007, 13:09
1.9.2.7-7g
разве уже есть свежей?
lexass
14-11-2007, 13:11
аааа, нашел свежей 1.9.2.7-8 от 30.10.07
ща прошью, ее поверху?
настройки сохранятся?

сам себе отвечу - апгрейд
lexass
14-11-2007, 14:06
перешил
пинг есть
внешки нет
доступа через вебМорду нет
мигает индикатор ПАУВЕР
ХЕЛП!!!

перезагрузки и скидывание парамов не помогает!!!
lexass
14-11-2007, 14:40
спас Firmware Restoration
указал файло WL500gp-1.9.2.7-8.trx
как не странно все настройки остались:D
euseller
30-11-2007, 22:05
Подскажите, при работающем FTP в активном режиме это нормальная загрузка памяти? Или все же надо почистить что-то...

Mem: 29544K used, 540K free, 0K shrd, 1176K buff, 19428K cached
Load average: 0.18, 0.17, 0.07 (State: S=sleeping R=running, W=waiting)

PID USER STATUS RSS PPID %CPU %MEM COMMAND
180 magistr R 600 178 1.7 1.9 vsftpd
192 magistr R 448 182 0.9 1.4 top
181 magistr S 708 116 0.3 2.3 dropbear
112 magistr S 292 1 0.1 0.9 igmpproxy
3 magistr RWN 0 1 0.1 0.0 ksoftirqd_CPU0
161 magistr S 4432 160 0.0 14.7 php-fcgi
170 magistr S 4268 161 0.0 14.1 php-fcgi
142 magistr S 1764 140 0.0 5.8 smbd
143 magistr S 924 1 0.0 3.0 nmbd
160 magistr S 684 1 0.0 2.2 lighttpd
182 magistr S 556 181 0.0 1.8 sh
176 magistr S 544 1 0.0 1.8 upnp
140 magistr S 544 1 0.0 1.8 smbd
1 magistr S 492 0 0.0 1.6 init
178 nobody S 484 162 0.0 1.6 vsftpd
85 magistr S 440 1 0.0 1.4 watchdog
147 nobody S 436 1 0.0 1.4 darkstat
162 magistr S 388 1 0.0 1.2 vsftpd
61 magistr S 368 1 0.0 1.2 httpd
69 nobody S 368 1 0.0 1.2 dnsmasq
al37919
30-11-2007, 22:14
вполне, как отмечалось выше, cached и buff это почти тоже самое что free. Итого, реально задействовано 8-9 метров
euseller
02-12-2007, 11:54
Поставил samba 3 и cron, к системе скачки ADOS
в папке opt/etc/cron.1min есть файл ados.sh

теперь в системном логе роутера все время пишется..

Dec 2 14:18:01 /opt/sbin/cron[180]: (magistr) CMD (/opt/bin/run-parts /opt/etc/cron.1min)
Dec 2 14:19:01 /opt/sbin/cron[187]: (magistr) CMD (/opt/bin/run-parts /opt/etc/cron.1min)
Dec 2 14:20:01 /opt/sbin/cron[199]: (magistr) CMD (/opt/bin/run-parts /opt/etc/cron.5mins)
Dec 2 14:20:01 /opt/sbin/cron[201]: (magistr) CMD (/opt/bin/run-parts /opt/etc/cron.1min)

Нормально ли это, обновляется ли лог файл после ребута и можно, если это нормально, чтобы в лог не писалось от крона? Если нельзя, как сделать так, чтобы лог не разрастался?

также растет лог от vsftpd, что с ним делать?

Еще логи от 3-ей самбы тоже пишутся, мол перекодирую 1251 в UTF и опять и опять....

не по теме, но все же, тут системном логе появилась ошибка, к чему это?

Dec 2 14:16:58 kernel: EXT3-fs warning: maximal mount count reached, running e2fsck is recommended
Dec 2 14:16:58 kernel: EXT3 FS 2.4-0.9.19, 19 August 2002 on sd(8,3), internal journal
al37919
02-12-2007, 12:27
теперь в системном логе роутера все время пишется..
Dec 2 14:18:01 /opt/sbin/cron[180]: (magistr) CMD (/opt/bin/run-parts /opt/etc/cron.1min)

Нормально ли это, обновляется ли лог файл после ребута и можно, если это нормально, чтобы в лог не писалось от крона? Если нельзя, как сделать так, чтобы лог не разрастался?

http://wl500g.info/showpost.php?p=67421&postcount=5


также растет лог от vsftpd, что с ним делать?

Еще логи от 3-ей самбы тоже пишутся, мол перекодирую 1251 в UTF и опять и опять....

возможно оно и этому поможет


не по теме, но все же, тут системном логе появилась ошибка, к чему это?

Dec 2 14:16:58 kernel: EXT3-fs warning: maximal mount count reached, running e2fsck is recommended
Dec 2 14:16:58 kernel: EXT3 FS 2.4-0.9.19, 19 August 2002 on sd(8,3), internal journal

файловые системы в юникс имеют обычно счетчик монтирований, после которого автоматом запускается проверка фс. Судя по всему в нашем роутере автопроверка отключена, но выдается warning.

Счетчик можно изменить с помощью tunefs -c

Однако, лучше этого не делать, а просто прогнать e2fsck (предварительно размонтировав раздел).
euseller
02-12-2007, 12:55
спасибо, попробую..но логи самбы пишутся в свой лог файл, а не в системный...так же, как и для vsftpd...я где-то встречал топик, как кто то написал скрипт, архивирующий логи а потом уничтожащий периодчески по крону старые и старые архивные, но теперь не могу по поиску найти...
al37919
02-12-2007, 13:29
я использую такой вариант. При этом у меня syslogd перезапущен с loglevel 6 и выводом в /opt/var/log/syslog.log , а /tmp/syslog.log --- symlink на него же, чтобы в веб-иф показывал. Старые логи удаляю вручную.


#! /bin/sh
PATH="/opt/local/bin:/opt/sbin:/opt/bin:/usr/local/sbin:/usr/sbin:/usr/bin:/sbin:/bin"

LOG_FILE=/opt/var/log/syslog.log
LOG_DESTINATION=/opt/var/log/arv

#my cron runs cron.daily at 23:59
TIMESTAMPEDFILENAME=`date +%Y%m%d_syslog.log`

mv "$LOG_FILE" "$LOG_DESTINATION/$TIMESTAMPEDFILENAME"
touch $LOG_FILE
gzip "$LOG_DESTINATION/$TIMESTAMPEDFILENAME"

В принципе через ipkg можно поставить приблуду под названием logrotate
el-pashteto
04-12-2007, 19:33
Получаю на клиентском устройстве сообщения в syslog:
kernel: wlan1: CCMP decrypt failed for RX frame from aa:bb:cc:dd:ee:ff

Что это? Излишняя детализация лога или ... что?
Mam(O)n
04-12-2007, 20:14
Судя по контексту сообщения это ошибка дешифрации принятого пакета по wifi. Вот похожая проблема: https://bugs.launchpad.net/ubuntu/+source/linux-source-2.6.15/+bug/40763
el-pashteto
04-12-2007, 20:51
Oh, thank you. Тьфу. Спасибо.
Прочитал. Судя по линку, это к поставщику драйвера вопросы. Эта тема не для данного форума.
Кстати, у меня девайс на r t 2 5 0 0. А поставщик - openSuSE. ) А многие поговариавют, что стандартный драйвер глючит. Мягко говоря.
alinghi
28-12-2007, 20:47
Подскажите знающие люди,что в логах не так.Иногда пропадает интернет,локалка есть всегда.Тип соединения PPTP.Вообще может есть какая то инструкция с описанием параметров,которые пишутся в логах?Мог ко мне кто нибудь подключится,как это проверить?
MAV
29-12-2007, 07:50
кто виноват , кого пинать

Dec 29 08:52:52 kernel: Out of Memory: Killed process 72 (dnsmasq).
Dec 29 09:01:06 kernel: Out of Memory: Killed process 1667 (httpd).
Dec 29 09:02:58 kernel: Out of Memory: Killed process 1671 (httpd).
Dec 29 09:03:13 kernel: Out of Memory: Killed process 1674 (httpd).
Dec 29 09:03:23 kernel: Out of Memory: Killed process 1677 (httpd).
Dec 29 09:03:33 kernel: Out of Memory: Killed process 1680 (httpd).
Dec 29 09:03:43 kernel: Out of Memory: Killed process 1683 (httpd).
Dec 29 09:03:49 kernel: Out of Memory: Killed process 1686 (httpd).
Dec 29 09:03:59 kernel: Out of Memory: Killed process 1687 (httpd).
Dec 29 09:04:11 kernel: Out of Memory: Killed process 1690 (httpd).
Dec 29 09:04:20 kernel: Out of Memory: Killed process 1693 (httpd).
Dec 29 09:04:30 kernel: Out of Memory: Killed process 1696 (httpd).
Dec 29 09:04:54 kernel: Out of Memory: Killed process 1699 (httpd).
Dec 29 09:54:38 ntp client: Synchronizing time with time.nist.gov ...
Dec 29 09:54:41 kernel: Out of Memory: Killed process 1703 (killall).
Dec 29 09:54:59 kernel: Out of Memory: Killed process 1705 (watchdog).
Dec 29 09:54:59 kernel: VM: killing process httpd
Dec 29 09:55:07 kernel: Out of Memory: Killed process 572 (sh).
Dec 29 09:55:23 kernel: Out of Memory: Killed process 1708 (httpd).
Dec 29 09:55:31 kernel: Out of Memory: Killed process 1711 (httpd).
Dec 29 09:55:39 kernel: Out of Memory: Killed process 1714 (httpd).
Dec 29 09:55:48 kernel: Out of Memory: Killed process 1717 (httpd).
Dec 29 09:55:58 kernel: Out of Memory: Killed process 1720 (httpd).
Dec 29 09:56:10 kernel: Out of Memory: Killed process 1723 (httpd).
Dec 29 09:56:18 kernel: Out of Memory: Killed process 1724 (httpd).
Dec 29 09:56:30 kernel: Out of Memory: Killed process 1727 (httpd).
Dec 29 09:56:39 kernel: Out of Memory: Killed process 1728 (httpd).
Dec 29 09:56:49 kernel: Out of Memory: Killed process 1729 (httpd).
Dec 29 09:57:00 kernel: Out of Memory: Killed process 1732 (httpd).
Dec 29 09:57:10 kernel: Out of Memory: Killed process 1735 (httpd).
Dec 29 09:57:20 kernel: Out of Memory: Killed process 1736 (httpd).
Dec 29 09:57:30 kernel: Out of Memory: Killed process 1739 (httpd).
Dec 29 09:57:41 kernel: Out of Memory: Killed process 1742 (httpd).
Dec 29 09:57:52 kernel: Out of Memory: Killed process 1745 (httpd).
Dec 29 09:58:00 kernel: Out of Memory: Killed process 1746 (httpd).
Dec 29 09:58:12 kernel: Out of Memory: Killed process 1749 (httpd).
Dec 29 09:58:23 kernel: Out of Memory: Killed process 1752 (httpd).
Dec 29 09:58:33 kernel: Out of Memory: Killed process 1755 (httpd).
Dec 29 09:58:43 kernel: Out of Memory: Killed process 1758 (httpd).
Dec 29 09:58:53 kernel: Out of Memory: Killed process 1759 (httpd).
Dec 29 09:59:07 kernel: Out of Memory: Killed process 1761 (httpd).
Dec 29 09:59:15 kernel: Out of Memory: Killed process 1764 (httpd).
Dec 29 09:59:23 kernel: Out of Memory: Killed process 1765 (httpd).
Dec 29 09:59:33 kernel: Out of Memory: Killed process 1766 (httpd).
Dec 29 10:32:03 kernel: Out of Memory: Killed process 1769 (httpd).
Dec 29 10:32:14 kernel: Out of Memory: Killed process 1770 (httpd).
Dec 29 10:32:25 pppd[91]: Child process /usr/sbin/pptp as.rt.user.ru --nolaunchpppd (pid 1648) terminated with signal 15
Dec 29 10:32:25 kernel: Out of Memory: Killed process 1648 (sh).
Dec 29 10:32:30 kernel: Out of Memory: Killed process 1773 (httpd).
Dec 29 10:32:39 kernel: Out of Memory: Killed process 1776 (httpd).
Dec 29 10:32:47 kernel: Out of Memory: Killed process 1779 (httpd).
Dec 29 10:32:58 kernel: Out of Memory: Killed process 1782 (httpd).
Dec 29 10:33:09 kernel: Out of Memory: Killed process 1785 (httpd).
Dec 29 10:33:22 kernel: Out of Memory: Killed process 1788 (httpd).
al37919
29-12-2007, 07:55
a swap подключен?
MAV
29-12-2007, 08:03
a swap подключен?а у меня роутер без дисков...т.е. просто последняя прошивка от Олега без локальных дисков, samba и ftp
раньше такого не было = впервые такой лог
al37919
29-12-2007, 08:26
я бы посмотрел что память занимает:
free
top и ps aux (оба из пакета procps, хотя пакеты то некуда ставить...)
MAV
29-12-2007, 09:42
вот еще

Dec 29 12:20:27 kernel: Out of Memory: Killed process 1981 (httpd).
Dec 29 12:20:37 kernel: Out of Memory: Killed process 1983 (httpd).
Dec 29 12:20:43 kernel: Out of Memory: Killed process 1984 (httpd).
Dec 29 12:20:48 kernel: Out of Memory: Killed process 1985 (httpd).
Dec 29 12:20:58 kernel: Out of Memory: Killed process 1986 (httpd).
Dec 29 12:21:08 kernel: Out of Memory: Killed process 1987 (watchdog).
Dec 29 12:21:19 kernel: Out of Memory: Killed process 1988 (httpd).
Dec 29 12:21:28 kernel: Out of Memory: Killed process 1989 (watchdog).
Dec 29 12:21:38 kernel: Out of Memory: Killed process 1990 (watchdog).
Dec 29 12:21:38 kernel: VM: killing process watchdog
Dec 29 12:21:48 kernel: Out of Memory: Killed process 1991 (httpd).
Dec 29 12:21:59 kernel: Out of Memory: Killed process 1992 (watchdog).
Dec 29 12:21:59 kernel: VM: killing process httpd
Dec 29 12:22:07 System log daemon exiting.
al37919
29-12-2007, 11:21
а просто ps что кажет?
ABATAPA
29-12-2007, 12:25
Подскажите знающие люди,что в логах не так.Иногда пропадает интернет,локалка есть всегда.Тип соединения PPTP.Вообще может есть какая то инструкция с описанием параметров,которые пишутся в логах?Мог ко мне кто нибудь подключится,как это проверить?

В приведенном Вами "огрызке" лога нет ничего ненормального - там устанавливается PPtP-соединение, и все.




Jan 1 03:00:09 pppd[101]: local IP address 172.31.233.239 (чей это адрес?????)
Jan 1 03:00:09 pppd[101]: remote IP address 172.31.1.1 (чей это адрес?????)

Англо-русский словарь переводит "local" как "локальный", "remote" как "удаленный".
Следовательно, это локальный (Ваш) и удаленный (провайдера) адреса для PPtP-соединения.
OlegI
29-12-2007, 12:28
Jan 1 03:00:09 pppd[101]: local IP address 172.31.233.239 (чей это адрес?????) - сервер назначил этот адрес роутеру
Jan 1 03:00:09 pppd[101]: remote IP address 172.31.1.1 (чей это адрес?????) - адрес севера
alinghi
29-12-2007, 19:18
Ну раз вы говорите что все в порядке,я успокоюсь.Я просто боялся чтобы не получилось так что роутер выходит в сеть под другим IP.А слова в логах типа "connection established",это нормально?Спасибо за ответы,извините за ламерские вопросы,в сетях мало понимаю:):)
ABATAPA
29-12-2007, 21:02
А слова в логах типа "connection established",это нормально?
Это обозначает, что подключение к Вашему провайдеру установлено.
madcat
11-01-2008, 17:52
Коллеги, помогите. Внезапно (настройки WL-500gP не менялись) в логе стало появляться вот это:


Jan 1 03:00:17 syslogd started: BusyBox v1.1.3
Jan 1 03:00:17 /opt/sbin/cron[173]: (CRON) STARTUP (V5.0)
Jan 1 03:00:17 kernel: br0: topology change detected, propagating
Jan 1 03:00:17 kernel: Universal TUN/TAP device driver 1.5 (C)1999-2002 Maxim Krasnyansky
Jan 1 03:00:17 kernel: devfs_register(net/tun): could not append to parent, err: -17
Jan 1 03:00:18 kernel: VFS: Can't find ext3 filesystem on dev sd(8,0).
Jan 1 03:00:18 kernel: MSDOS FS: Using codepage 950
Jan 1 03:00:18 kernel: MSDOS FS: IO charset cp950
Jan 1 03:00:18 kernel: FAT: bogus logical sector size 0
Jan 1 03:00:18 kernel: VFS: Can't find a valid FAT filesystem on dev 08:00.
Jan 1 03:00:18 kernel: FAT: freeing iocharset=cp950
Jan 1 03:00:18 kernel: FAT: bogus logical sector size 0
Jan 1 03:00:18 kernel: VFS: Can't find a valid FAT filesystem on dev 08:00.
Jan 1 03:00:18 kernel: VFS: Can't find ext3 filesystem on dev sd(8,1).
Jan 1 03:00:18 kernel: MSDOS FS: Using codepage 950
Jan 1 03:00:18 kernel: MSDOS FS: IO charset cp950
Jan 1 03:00:18 kernel: FAT: bogus logical sector size 0
Jan 1 03:00:18 kernel: VFS: Can't find a valid FAT filesystem on dev 08:01.
Jan 1 03:00:18 kernel: FAT: freeing iocharset=cp950
Jan 1 03:00:18 kernel: FAT: bogus logical sector size 0
Jan 1 03:00:18 kernel: VFS: Can't find a valid FAT filesystem on dev 08:01.
Jan 1 03:00:18 openvpn[193]: OpenVPN 2.0.7 mipsel-linux [SSL] [LZO] [EPOLL] built on Oct 27 2007
Jan 1 03:00:18 openvpn[193]: TUN/TAP device tun0 opened
Jan 1 03:00:18 openvpn[193]: /sbin/ifconfig tun0 10.8.0.1 pointopoint 10.8.0.2 mtu 1500
Jan 1 03:00:18 openvpn[202]: Listening for incoming TCP connection on [undef]:443
Jan 1 03:00:18 kernel: kjournald starting. Commit interval 5 seconds
Jan 1 03:00:18 kernel: EXT3 FS 2.4-0.9.19, 19 August 2002 on sd(8,3), internal journal
Jan 1 03:00:18 kernel: EXT3-fs: recovery complete.
Jan 1 03:00:18 kernel: EXT3-fs: mounted filesystem with ordered data mode.
Jan 1 03:00:18 USB storage: ext3 fs mounted to /tmp/harddisk
Jan 1 03:00:19 kernel: br0: received tcn bpdu on port 1(vlan0)
Jan 1 03:00:19 kernel: br0: topology change detected, propagating
Jan 1 03:00:19 openvpn[202]: TCP connection established with ххх.ххх.ххх.ххх:3794
Jan 1 03:00:19 openvpn[202]: TCPv4_SERVER link local (bound): [undef]:443
Jan 1 03:00:19 openvpn[202]: TCPv4_SERVER link remote: ххх.ххх.ххх.ххх:3794
Jan 1 03:00:20 thttpd[229]: bind 0.0.0.0 - Address already in use
Jan 1 03:00:21 thttpd[229]: thttpd/2.25b PHP/5.2.5 starting on port 8088
Jan 1 03:00:21 thttpd[229]: started as root without requesting chroot(), warning only
Jan 1 03:00:21 kernel: br0: received tcn bpdu on port 1(vlan0)
Jan 1 03:00:21 kernel: br0: topology change detected, propagating
Jan 1 03:00:23 kernel: br0: received tcn bpdu on port 1(vlan0)
Jan 1 03:00:23 kernel: br0: topology change detected, propagating
Jan 1 03:00:25 kernel: br0: received tcn bpdu on port 1(vlan0)
Jan 1 03:00:25 kernel: br0: topology change detected, propagating
Jan 1 03:00:27 kernel: br0: received tcn bpdu on port 1(vlan0)
Jan 1 03:00:27 kernel: br0: topology change detected, propagating
Jan 11 20:27:55 openvpn[202]: Peer Connection Initiated with ххх.ххх.ххх.ххх:3794
Jan 11 20:27:55 openvpn[202]: Initialization Sequence Completed
Jan 11 20:27:56 kernel: br0: received tcn bpdu on port 1(vlan0)
Jan 11 20:27:56 kernel: br0: topology change detected, propagating
Jan 11 20:27:58 kernel: br0: received tcn bpdu on port 1(vlan0)
Jan 11 20:27:58 kernel: br0: topology change detected, propagating
Jan 11 20:28:00 kernel: br0: received tcn bpdu on port 1(vlan0)
Jan 11 20:28:00 kernel: br0: topology change detected, propagating
Jan 11 20:28:02 dropbear[232]: pubkey auth succeeded for 'root' with key md5 58:77:1d:75:89:b0:36:48:4f:36:61:c2:64:19:3f:6d from ::ffff:10.8.0.2:3820
Jan 11 20:28:02 kernel: br0: received tcn bpdu on port 1(vlan0)
Jan 11 20:28:02 kernel: br0: topology change detected, propagating
Jan 11 20:28:04 kernel: br0: received tcn bpdu on port 1(vlan0)
Jan 11 20:28:04 kernel: br0: topology change detected, propagating
Jan 11 20:28:05 ntp client: Synchronizing time with time.nist.gov ...
Jan 11 20:28:06 kernel: br0: received tcn bpdu on port 1(vlan0)
Jan 11 20:28:06 kernel: br0: topology change detected, propagating
Jan 11 20:28:07 xinetd[179]: xinetd Version 2.3.14 started with no options compiled in.
Jan 11 20:28:07 xinetd[179]: Started working: 1 available service
Jan 11 20:28:08 kernel: br0: received tcn bpdu on port 1(vlan0)
Jan 11 20:28:08 kernel: br0: topology change detected, propagating
Jan 11 20:28:10 kernel: br0: received tcn bpdu on port 1(vlan0)
Jan 11 20:28:10 kernel: br0: topology change detected, propagating

Дальше весь лог зафлужен такими вот сообщениями. Что это и как лечить?
Ilmarinen
12-01-2008, 05:56
Коллеги, помогите. Внезапно (настройки WL-500gP не менялись) в логе стало появляться вот это:


...
Jan 11 20:27:58 kernel: br0: received tcn bpdu on port 1(vlan0)
Jan 11 20:27:58 kernel: br0: topology change detected, propagating
...

Дальше весь лог зафлужен такими вот сообщениями. Что это и как лечить?
А что у Вас подключено к LAN портам?
Какое-то из устройств рассылает TCN BPDU (topology change notification Bridge Protocol Data Unit) (http://www.cisco.com/warp/public/473/17.html)
Чтобы дать совет как это лечить и стоит ли вообще лечить, нужно знать топологию внутренней сети.
madcat
12-01-2008, 07:23
Как показала практика, tcn bpdu рассылал powerline адаптер - фиг знает, что с ним. Раз в две секунды мигает лампа LAN - типа включается/отключается. Отключение его от сети помогло. Всем спасибо :)
djet
13-01-2008, 01:06
Странные вещи начали у меня твориться после запуска 'tcpdump -i ppp0'. Команда, конечно, бредовая при большом объёме трафика, но мне она нужна была всего на пару секунд. Ctrl+C я сделать не успел, т.к. отвалилась ssh-сессия. tcpdump я в итоге убил, но процессы больше долго не живут:


Jan 13 02:46:12 routah dropbear[7286]: password auth succeeded for 'djet' from ::ffff:192.168.1.4:15277
Jan 13 02:53:50 routah Out of Memory: Killed process 70 (dnsmasq).
Jan 13 02:54:01 routah Out of Memory: Killed process 7385 (ipkg).
Jan 13 02:54:15 routah Out of Memory: Killed process 7381 (ipkg).
Jan 13 02:54:15 routah device ppp0 entered promiscuous mode
Jan 13 02:54:19 routah device ppp0 left promiscuous mode
Jan 13 02:54:19 routah device ppp0 entered promiscuous mode
Jan 13 02:54:20 routah device ppp0 left promiscuous mode
Jan 13 02:54:22 routah device ppp0 entered promiscuous mode
Jan 13 02:54:24 routah device ppp0 left promiscuous mode
Jan 13 02:54:30 routah device ppp0 entered promiscuous mode
Jan 13 02:54:32 routah device ppp0 left promiscuous mode
Jan 13 02:54:33 routah Out of Memory: Killed process 7389 (ipkg).
Jan 13 02:54:39 routah device ppp0 entered promiscuous mode
Jan 13 02:54:58 routah Out of Memory: Killed process 4170 (smbd).
Jan 13 02:54:58 routah VM: killing process smbd
Jan 13 02:55:04 routah Out of Memory: Killed process 7397 (vim).
Jan 13 02:55:11 routah Out of Memory: Killed process 3212 (bash).
Jan 13 02:55:15 routah Out of Memory: Killed process 3219 (bash).
Jan 13 02:55:28 routah Out of Memory: Killed process 7287 (bash).
Jan 13 02:55:29 routah dropbear[7286]: exit after auth (djet): Exited normally
Jan 13 02:55:46 routah dropbear[7470]: password auth succeeded for 'djet-safe' from ::ffff:192.168.1.4:15326
Jan 13 02:55:49 routah Out of Memory: Killed process 3209 (sh).
Jan 13 02:55:48 routah dropbear[3208]: exit after auth (djet-safe): Exited normally
Jan 13 02:56:06 routah Out of Memory: Killed process 7474 (bash).
Jan 13 02:57:10 routah Out of Memory: Killed process 7471 (sh).
Jan 13 02:57:10 routah dropbear[7470]: exit after auth (djet-safe): Exited normally
Jan 13 02:57:12 routah dropbear[7497]: password auth succeeded for 'djet-safe' from ::ffff:192.168.1.4:15339
Jan 13 02:57:19 routah Out of Memory: Killed process 7501 (bash).
Jan 13 02:58:19 routah device ppp0 left promiscuous mode
Jan 13 02:58:26 routah dropbear[7543]: password auth succeeded for 'djet-safe' from ::ffff:192.168.1.4:15340
Jan 13 02:59:12 routah dropbear[7543]: exit after auth (djet-safe): Exited normally
Jan 13 02:59:27 routah dropbear[7549]: password auth succeeded for 'djet' from ::ffff:192.168.1.4:15343
Jan 13 02:59:33 routah dropbear[7497]: exit after auth (djet-safe): Exited normally
Jan 13 03:00:04 routah Out of Memory: Killed process 7550 (bash).
Jan 13 03:00:07 routah dropbear[7549]: exit after auth (djet): Exited normally
Jan 13 03:00:11 routah Out of Memory: Killed process 7617 (rrdtool).
Jan 13 03:00:17 routah Out of Memory: Killed process 7620 (rrdtool).
Jan 13 03:00:23 routah Out of Memory: Killed process 7623 (rrdtool).
Jan 13 03:09:33 routah dropbear[7712]: password auth succeeded for 'djet' from ::ffff:192.168.1.4:15444
Jan 13 03:09:49 routah Out of Memory: Killed process 7713 (bash).
Jan 13 03:09:49 routah dropbear[7712]: exit after auth (djet): Exited normally
Jan 13 03:09:52 routah dropbear[7718]: password auth succeeded for 'djet' from ::ffff:192.168.1.4:15446
Jan 13 03:10:05 routah Out of Memory: Killed process 7719 (bash).
Jan 13 03:10:06 routah dropbear[7718]: exit after auth (djet): Exited normally
Jan 13 03:10:08 routah dropbear[7778]: password auth succeeded for 'djet' from ::ffff:192.168.1.4:15447
Jan 13 03:10:10 routah Out of Memory: Killed process 7786 (rrdtool).
Jan 13 03:10:16 routah Out of Memory: Killed process 7790 (rrdtool).
Jan 13 03:10:21 routah Out of Memory: Killed process 7795 (rrdtool).
Jan 13 03:12:15 routah Out of Memory: Killed process 7929 (ipkg).
Jan 13 03:14:41 routah Out of Memory: Killed process 7787 (bash).
Jan 13 03:14:41 routah dropbear[7778]: exit after auth (djet): Exited normally
Jan 13 03:14:44 routah dropbear[7955]: password auth succeeded for 'djet' from ::ffff:192.168.1.4:15459
Jan 13 03:15:07 routah Out of Memory: Killed process 7956 (bash).
Jan 13 03:15:07 routah dropbear[7955]: exit after auth (djet): Exited normally
Jan 13 03:15:10 routah dropbear[8031]: password auth succeeded for 'djet' from ::ffff:192.168.1.4:15460
Jan 13 03:16:27 routah djet: Started /opt/etc/init.d/S01syslog-ng.
Jan 13 03:16:27 routah djet: Leaving /opt/etc/init.d/S01syslog-ng.
Jan 13 03:19:36 routah dropbear[8055]: password auth succeeded for 'djet' from ::ffff:192.168.1.4:15467
Jan 13 03:20:09 routah Out of Memory: Killed process 8123 (rrdtool).
Jan 13 03:20:15 routah Out of Memory: Killed process 8126 (rrdtool).
Jan 13 03:20:20 routah Out of Memory: Killed process 8129 (rrdtool).
Jan 13 03:25:30 routah Out of Memory: Killed process 8219 (ipkg).
Jan 13 03:30:05 routah Out of Memory: Killed process 8056 (bash).
Jan 13 03:30:05 routah dropbear[8055]: exit after auth (djet): Exited normally
Jan 13 03:30:12 routah Out of Memory: Killed process 8297 (rrdtool).
Jan 13 03:30:14 routah dropbear[8301]: password auth succeeded for 'djet' from ::ffff:192.168.1.4:15503
Jan 13 03:30:18 routah Out of Memory: Killed process 8300 (rrdtool).
Jan 13 03:30:23 routah Out of Memory: Killed process 8305 (rrdtool).
Jan 13 03:30:43 routah client: Synchronizing time with ntp.corbina.net ...

, хотя памяти, по показаниям free должно хватать:

[routah:~] free
total used free shared buffers cached
Mem: 30196 29612 584 0 768 15912
-/+ buffers/cache: 12932 17264
Swap: 0 0 0
djet
13-01-2008, 01:07
Вот полный список процессов:

[routah:~] ps -xv

PID TTY STAT TIME MAJFL TRS DRS RSS %MEM COMMAND
1 ? S 0:02 319 278 2093 220 0.7 /sbin/init
2 ? S 0:00 0 0 0 0 0.0 [keventd]
3 ? RN 1:00 0 0 0 0 0.0 [ksoftirqd_CPU0]
4 ? S 0:22 0 0 0 0 0.0 [kswapd]
5 ? S 0:00 0 0 0 0 0.0 [bdflush]
6 ? S 0:00 0 0 0 0 0.0 [kupdated]
7 ? S 0:01 0 0 0 0 0.0 [mtdblockd]
60 ? S 0:03 284 138 1793 268 0.8 httpd vlan1
62 ? S 0:00 33 174 1185 196 0.6 snmpd -c /tmp/snmpd.conf
72 ? Ss 0:01 184 103 1796 256 0.8 nas /tmp/nas.lan.conf /tmp/nas.lan.pid lan
75 ? S 0:00 0 0 0 0 0.0 [khubd]
84 ? Ss 0:00 60 158 797 136 0.4 lpd
86 ? Ss 0:00 9 9 794 116 0.3 p9100d -f /dev/usb/lp0 0
91 ? S 0:02 0 0 0 0 0.0 [usb-storage-0]
92 ? S 0:00 0 0 0 0 0.0 [scsi_eh_0]
96 ? S 0:00 0 0 0 0 0.0 [usb-storage-1]
98 ? S 0:00 0 0 0 0 0.0 [scsi_eh_1]
116 ? S 0:00 0 0 0 0 0.0 [usb-storage-2]
117 ? S 0:00 0 0 0 0 0.0 [scsi_eh_2]
168 ? S 0:00 120 46 825 208 0.6 /usr/sbin/igmpproxy -c /etc/igmpproxy.conf
172 ? S 0:00 0 1160 1535 184 0.6 udhcpc -i vlan1 -p /var/run/udhcpc0.pid -s /tmp/udhcpc -b
174 ? S 3:46 228 114 1653 316 1.0 l2tpd
177 ? Ss 0:00 72 26 1425 160 0.5 infosvr br0
178 ? Ss 0:02 229 278 2097 256 0.8 watchdog
181 ? Ss 0:00 84 278 2081 164 0.5 ntp
191 ? S 0:00 108 325 1426 196 0.6 dropbear
195 ? Ss 0:00 66 305 1474 224 0.7 pppd file /usr/local/etc/ppp/rabbit-options.pptpd
213 ? S 0:00 0 0 0 0 0.0 [kjournald]
214 ? S 0:00 0 0 0 0 0.0 [kjournald]
216 ? Ss 0:06 621 169 2566 568 1.8 /usr/sbin/nmbd -D
218 ? Ss 0:00 72 504 2583 416 1.3 /usr/sbin/smbd -D
244 ? S 0:00 100 1160 1531 172 0.5 /bin/sh -c /opt/bin/syslog-ng-arpwatch
245 ? S 0:00 102 1160 1531 172 0.5 /bin/sh /opt/bin/syslog-ng-arpwatch
246 ? Ss 0:01 855 152 2075 444 1.4 /opt/sbin/syslog-ng
256 ? Ss 0:00 145 65 906 136 0.4 /opt/sbin/cron
276 ? S 0:11 106 186 2637 552 1.8 /opt/sbin/arpwatch -N -i vlan1 -n 10.111.64.111
286 ? S 0:00 9 1160 1547 180 0.5 /usr/sbin/busybox_httpd -c /opt/etc/httpd.conf -p 8888 -h /opt/share/www
318 ? S 0:03 279 305 1478 276 0.9 pppd sync nodetach noaccomp nobsdcomp nodeflate nopcomp novj novjccomp file /tmp/ppp/options.
349 ? Ss 0:01 96 325 1510 304 1.0 dropbear
367 pts/2 Ss 0:00 106 1160 1547 188 0.6 -sh
370 pts/2 S+ 0:00 251 913 1914 908 3.0 bash
393 pts/3 Ss 0:00 106 1160 1547 188 0.6 -sh
396 pts/3 S 0:00 236 913 1870 876 2.9 bash
397 pts/3 S+ 0:00 87 71 996 120 0.3 man test
398 pts/3 S+ 0:00 96 1160 1535 176 0.5 sh -c (cd "/opt/man" && (echo ".ll 15.1i"; echo ".nr LL 15.1i"; echo ".pl 1100i"; /bin/cat '/
399 pts/3 S+ 0:00 10 1160 1535 176 0.5 sh -c (cd "/opt/man" && (echo ".ll 15.1i"; echo ".nr LL 15.1i"; echo ".pl 1100i"; /bin/cat '/
402 pts/3 S+ 0:00 162 168 1355 132 0.4 /opt/bin/less -isR
413 pts/2 S 0:03 1778 1446 1981 1084 3.5 BitchX -n djet`log -c #rombuild -B -A
6113 ? S 0:01 167 98 1765 288 0.9 upnp -D -L br0 -W vlan1
7778 ? Ss 0:02 149 325 1510 396 1.3 dropbear
7787 pts/0 Ss 0:02 522 913 1898 1504 4.9 -bash
7938 pts/0 R+ 0:00 113 69 1374 472 1.5 ps -axv

Видел такое пару раз и раньше, но не придавал значения, думая, что действительно кто-то съел всю память. Но коллега описывал аналогичную ситуацию с парой недель аптайтма и Out of memory, а ведь у него даже нет флешки..

Update:
Чуть позже на некоторое время нормализовалось, пока free показывал хотя бы пару МБ свободной памяти:

[routah:~] free
total used free shared buffers cached
Mem: 30196 27984 2212 0 1172 16464
-/+ buffers/cache: 10348 19848
Swap: 0 0 0
Потом снова пошло процессоубийство. Почему-то оно всегда начиналось с dnsmasq..

Что происходит? Если cached - это кэш, почему он не расходуется, когда системе нужна память?
djet
13-01-2008, 01:08
А вот и ужасы нашего городка...


Jan 3 18:17:37 routah Out of Memory: Killed process 68 (dnsmasq).
Jan 3 18:17:42 routah Out of Memory: Killed process 2148 (ipkg).
Jan 3 18:18:23 routah Out of Memory: Killed process 169 (smbd).
Jan 3 18:18:30 routah Out of Memory: Killed process 1008 (bash).
Jan 3 18:18:59 routah Out of Memory: Killed process 2154 (bash).
Jan 3 18:19:10 routah Out of Memory: Killed process 132 (udhcpc).
Jan 3 18:19:27 routah Out of Memory: Killed process 194 (sh).
Jan 3 18:19:38 routah Out of Memory: Killed process 200 (syslog-ng-arpwa).
Jan 3 18:19:43 routah Out of Memory: Killed process 368 (sh).
Jan 3 18:19:48 routah Out of Memory: Killed process 1005 (sh).
Jan 3 18:19:53 routah Out of Memory: Killed process 1734 (busybox_httpd).
Jan 3 18:19:58 routah Out of Memory: Killed process 2149 (sh).
Jan 3 18:20:04 routah Out of Memory: Killed process 2151 (sh).
Jan 3 18:20:09 routah Out of Memory: Killed process 2160 (sh).
Jan 3 18:20:14 routah Out of Memory: Killed process 1 (init).
Jan 10 19:58:14 routah Out of Memory: Killed process 66 (dnsmasq).
Jan 10 19:58:22 routah Out of Memory: Killed process 1299 (smbd).
Jan 10 19:58:28 routah Out of Memory: Killed process 5926 (kismet_server).
Jan 10 19:59:08 routah Out of Memory: Killed process 1457 (bash).
Jan 10 20:00:10 routah Out of Memory: Killed process 6086 (rrdtool).
Jan 10 20:00:18 routah Out of Memory: Killed process 6089 (rrdtool).
Jan 10 20:00:25 routah Out of Memory: Killed process 6093 (rrdtool).
Jan 10 20:01:31 routah Out of Memory: Killed process 6097 (bash).
Jan 10 20:01:44 routah Out of Memory: Killed process 6119 (bash).
Jan 10 20:01:59 routah Out of Memory: Killed process 6125 (bash).
Jan 10 20:02:10 routah Out of Memory: Killed process 6140 (kismet_server).
Jan 10 20:02:30 routah Out of Memory: Killed process 6145 (kismet_client).
Jan 13 02:53:50 routah Out of Memory: Killed process 70 (dnsmasq).
Jan 13 02:54:01 routah Out of Memory: Killed process 7385 (ipkg).
Jan 13 02:54:15 routah Out of Memory: Killed process 7381 (ipkg).
Jan 13 02:54:33 routah Out of Memory: Killed process 7389 (ipkg).
Jan 13 02:54:58 routah Out of Memory: Killed process 4170 (smbd).
Jan 13 02:55:04 routah Out of Memory: Killed process 7397 (vim).
Jan 13 02:55:11 routah Out of Memory: Killed process 3212 (bash).
Jan 13 02:55:15 routah Out of Memory: Killed process 3219 (bash).
Jan 13 02:55:28 routah Out of Memory: Killed process 7287 (bash).
Jan 13 02:55:49 routah Out of Memory: Killed process 3209 (sh).
Jan 13 02:56:06 routah Out of Memory: Killed process 7474 (bash).
Jan 13 02:57:10 routah Out of Memory: Killed process 7471 (sh).
Jan 13 02:57:19 routah Out of Memory: Killed process 7501 (bash).
Jan 13 03:00:04 routah Out of Memory: Killed process 7550 (bash).
Jan 13 03:00:11 routah Out of Memory: Killed process 7617 (rrdtool).
Jan 13 03:00:17 routah Out of Memory: Killed process 7620 (rrdtool).
Jan 13 03:00:23 routah Out of Memory: Killed process 7623 (rrdtool).
Jan 13 03:09:49 routah Out of Memory: Killed process 7713 (bash).
Jan 13 03:10:05 routah Out of Memory: Killed process 7719 (bash).
Jan 13 03:10:10 routah Out of Memory: Killed process 7786 (rrdtool).
Jan 13 03:10:16 routah Out of Memory: Killed process 7790 (rrdtool).
Jan 13 03:10:21 routah Out of Memory: Killed process 7795 (rrdtool).
Jan 13 03:12:15 routah Out of Memory: Killed process 7929 (ipkg).
Jan 13 03:14:41 routah Out of Memory: Killed process 7787 (bash).
Jan 13 03:15:07 routah Out of Memory: Killed process 7956 (bash).
Jan 13 03:20:09 routah Out of Memory: Killed process 8123 (rrdtool).
Jan 13 03:20:15 routah Out of Memory: Killed process 8126 (rrdtool).
Jan 13 03:20:20 routah Out of Memory: Killed process 8129 (rrdtool).
Jan 13 03:25:30 routah Out of Memory: Killed process 8219 (ipkg).
Jan 13 03:30:05 routah Out of Memory: Killed process 8056 (bash).
Jan 13 03:30:12 routah Out of Memory: Killed process 8297 (rrdtool).
Jan 13 03:30:18 routah Out of Memory: Killed process 8300 (rrdtool).
Jan 13 03:30:23 routah Out of Memory: Killed process 8305 (rrdtool).
Jan 13 03:50:09 routah Out of Memory: Killed process 8610 (dnsmasq).
Jan 13 03:50:12 routah Out of Memory: Killed process 8707 (rrdtool).
Jan 13 03:50:18 routah Out of Memory: Killed process 8711 (rrdtool).
Jan 13 03:50:25 routah Out of Memory: Killed process 8714 (rrdtool).
Oleg
13-01-2008, 14:39
Похоже /tmp переполнился. Он будет как раз в cached, если склероз мне не изменяет. :)
angel_il
13-01-2008, 15:20
как это нет потокомв? есть потоки!
djet
13-01-2008, 15:44
Похоже /tmp переполнился. Он будет как раз в cached, если склероз мне не изменяет. :)

А кто его может использовать?
ABATAPA
14-01-2008, 08:51
А кто его может использовать?
/tmp/syslog*?
al37919
14-01-2008, 09:04
Объем /tmp посмотрите du /tmp или flashfs save
djet
14-01-2008, 12:10
flashfs в порядке. Нашёл вот что:

524288 /tmp/var/lock/SHARE_MEM_FILE

Это от самбы?
djet
14-01-2008, 15:58
Блин... ну а теперь-то что:


[routah:root] uptime
19:11:47 up 19:40, 2 users, load average: 2.36, 3.50, 2.71

[routah:root] tf /opt/var/log/syslog

Jan 14 18:38:00 routah SCSI device sdc: 195371568 512-byte hdwr sectors (100030 MB)
Jan 14 18:38:00 routah /dev/scsi/host2/bus0/target0/lun0: p1 p2
Jan 14 18:39:24 routah Out of Memory: Killed process 5771 (dnsmasq).
Jan 14 18:39:40 routah Out of Memory: Killed process 18379 (mke2fs).
Jan 14 18:42:11 routah nvram_commit: out of memory
Jan 14 18:42:11 routah nvram_commit: out of memory
Jan 14 18:42:20 routah nvram_commit: out of memory
Jan 14 18:43:53 routah dnsmasq[18499]: started, version 2.22 cachesize 150
Jan 14 18:43:53 routah dnsmasq[18499]: DHCP, IP range 192.168.1.2 -- 192.168.1.254, lease time 24h
Jan 14 18:43:53 routah dnsmasq[18499]: DHCP, /tmp/dnsmasq.log will be written every 8h
Jan 14 18:43:53 routah dnsmasq[18499]: read /etc/hosts - 5 addresses
Jan 14 18:43:53 routah dnsmasq[18499]: read /etc/ethers - 4 addresses
Jan 14 18:43:53 routah dnsmasq[18499]: reading /tmp/resolv.conf
Jan 14 18:43:53 routah dnsmasq[18499]: using nameserver 195.14.50.21#53
Jan 14 18:43:53 routah dnsmasq[18499]: using nameserver 213.234.192.7#53
Jan 14 18:44:48 routah nvram_commit: out of memory

[routah:root] nvram commit
/dev/nvram: Cannot allocate memory

[routah:root] du -abx /tmp/
.....
360781 /tmp/
360781 total


[routah:root] free
total used free shared buffers cached
Mem: 30196 29572 624 0 1548 13700
-/+ buffers/cache: 14324 15872
Swap: 0 0 0

[routah:root] ps axf
PID TTY STAT TIME COMMAND
1 ? S 0:02 /sbin/init
2 ? S 0:00 [keventd]
3 ? RN 8:09 [ksoftirqd_CPU0]
4 ? S 2:29 [kswapd]
5 ? S 0:00 [bdflush]
6 ? S 0:00 [kupdated]
7 ? S 0:04 [mtdblockd]
60 ? S 0:13 httpd vlan1
66 ? S 0:00 snmpd -c /tmp/snmpd.conf
72 ? Ss 0:04 nas /tmp/nas.lan.conf /tmp/nas.lan.pid lan
75 ? S 0:00 [khubd]
83 ? Ss 0:00 lpd
85 ? Ss 0:00 p9100d -f /dev/usb/lp0 0
90 ? S 0:14 [usb-storage-0]
91 ? S 0:00 [scsi_eh_0]
114 ? S 0:00 [usb-storage-1]
115 ? S 0:00 [scsi_eh_1]
135 ? S 0:42 [usb-storage-2]
136 ? S 0:00 [scsi_eh_2]
174 ? S 0:01 /usr/sbin/igmpproxy -c /etc/igmpproxy.conf
178 ? S 0:00 udhcpc -i vlan1 -p /var/run/udhcpc0.pid -s /tmp/udhcpc -b
180 ? S 254:00 l2tpd
368 ? S 0:08 \_ pppd sync nodetach noaccomp nobsdcomp nodeflate nopcomp novj novjccomp file /tmp/ppp/options.wan0
183 ? Ss 0:00 infosvr br0
184 ? Ss 0:07 watchdog
187 ? Ss 0:00 \_ ntp
258 ? S 0:00 [kjournald]
291 ? Ss 0:02 /opt/sbin/syslog-ng
333 ? S 0:00 /usr/sbin/busybox_httpd -c /opt/etc/httpd.conf -h /opt/share/www
516 ? S 0:05 BitchX -n djet`log -c #rombuild -B -A
6008 ? S 0:00 dropbear
14457 ? Ss 0:12 \_ dropbear
14458 pts/0 Ss+ 0:00 | \_ screen -A -x -RR
14690 ? Ss 0:04 \_ dropbear
14691 pts/3 Ss+ 0:00 \_ screen -A -x -RR
6104 ? Ss 0:14 SCREEN -A -x -RR
6110 pts/2 Ss 0:02 \_ -bash
18590 pts/2 R+ 0:00 | \_ ps axf
18305 pts/4 Ss+ 0:00 \_ -bash
17302 ? S 0:03 upnp -D -L br0 -W vlan1
18183 ? S 0:00 [kjournald]
18185 ? Ss 0:01 /usr/sbin/nmbd -D
18187 ? Ss 0:00 /usr/sbin/smbd -D
18207 ? Ss 0:00 /opt/sbin/cron
18235 ? S 0:01 /opt/sbin/arpwatch -N -i vlan1 -n 10.111.64.111
18251 ? S 0:00 /opt/sbin/in.tftpd -cvvvvls -u nobody /opt/ftproot/
18499 ? S 0:00 [dnsmasq]
Mam(O)n
15-01-2008, 00:17
Jan 14 18:39:40 routah Out of Memory: Killed process 18379 (mke2fs).

mke2fs при создании журнала для немалого объёма раздела требует много памяти и порой тут без свопа необойтись.
DikHell
07-02-2008, 12:47
Настроил PPTP вроде все работает
НО в логах постоянно идет ошибка

Jan 1 03:00:07 pptp[113]: anon log[main:pptp.c:267]: The synchronous pptp option is NOT activated
Jan 1 03:00:07 pptp[119]: anon log[ctrlp_rep:pptp_ctrl.c:251]: Sent control packet type is 1 'Start-Control-Connection-Request'
Jan 1 03:00:07 pptp[119]: anon log[ctrlp_disp:pptp_ctrl.c:732]: Received Start Control Connection Reply
Jan 1 03:00:07 pptp[119]: anon log[ctrlp_disp:pptp_ctrl.c:766]: Client connection established.
Jan 1 03:00:08 pptp[119]: anon log[ctrlp_rep:pptp_ctrl.c:251]: Sent control packet type is 7 'Outgoing-Call-Request'
Jan 1 03:00:09 pptp[119]: anon log[ctrlp_disp:pptp_ctrl.c:851]: Received Outgoing Call Reply.
Jan 1 03:00:09 pptp[119]: anon log[ctrlp_disp:pptp_ctrl.c:890]: Outgoing call established (call ID 0, peer's call ID 35712).
и
Feb 7 15:31:23 pptp[119]: anon log[logecho:pptp_ctrl.c:670]: Echo Reply received.
Feb 7 15:32:23 pptp[119]: anon log[logecho:pptp_ctrl.c:670]: Echo Reply received.

Что это может быть и самое главное как это исправить?
TVadim
07-02-2008, 13:07
А где ошибка? Нет ее. Это лог установления связи
Venik
13-02-2008, 19:19
Гуру, подскажите, чем вызваны такие строчки в логах?
Появляются при включенной самбе. При выключении пропадают...


Feb 13 19:15:16 nmbd[154]: [2008/02/13 19:15:16, 0] nmbd/nmbd_incomingrequests.c:process_name_refresh_reque st(180)
Feb 13 19:15:16 nmbd[154]: process_name_refresh_request: unicast name registration request received for name VENIK<20> from IP 192.168.1.2 on subnet UNICAST_SUBNET.
Feb 13 19:15:16 nmbd[154]: [2008/02/13 19:15:16, 0] nmbd/nmbd_incomingrequests.c:process_name_refresh_reque st(181)
Feb 13 19:15:16 nmbd[154]: Error - should be sent to WINS server
Feb 13 19:15:16 nmbd[154]: [2008/02/13 19:15:16, 0] nmbd/nmbd_incomingrequests.c:process_name_refresh_reque st(180)
Feb 13 19:15:16 nmbd[154]: process_name_refresh_request: unicast name registration request received for name VENIK<00> from IP 192.168.1.2 on subnet UNICAST_SUBNET.
Feb 13 19:15:16 nmbd[154]: [2008/02/13 19:15:16, 0] nmbd/nmbd_incomingrequests.c:process_name_refresh_reque st(181)
Feb 13 19:15:16 nmbd[154]: Error - should be sent to WINS server
Feb 13 19:15:16 nmbd[154]: [2008/02/13 19:15:16, 0] nmbd/nmbd_incomingrequests.c:process_name_refresh_reque st(180)
Feb 13 19:15:16 nmbd[154]: process_name_refresh_request: unicast name registration request received for name WORKGROUP<00> from IP 192.168.1.2 on subnet UNICAST_SUBNET.
Feb 13 19:15:16 nmbd[154]: [2008/02/13 19:15:16, 0] nmbd/nmbd_incomingrequests.c:process_name_refresh_reque st(181)
Feb 13 19:15:16 nmbd[154]: Error - should be sent to WINS server
Oleg
13-02-2008, 20:09
Похоже, что Вы указали роутер в качестве WINS сервера. Зачем Вы это сделали?
Venik
13-02-2008, 20:16
ээээм
где я мог это сделать?
ничего подобного вроде не делал :confused:
Oleg
13-02-2008, 20:52
Минимум два места: 1) в настройках DHCP сервера у роутреа есть поле WINS; 2) У форточек в настройках TCP/IP есть поле для адреса WINS сервера.
Venik
13-02-2008, 21:40
в dhcp чисто
а вот в винде действительно ;)
ща понаблюдаю за логом, для верности :rolleyes:
Спасибо за наводку :cool:
Bot
25-02-2008, 10:14
Народ! А что за хрень такая в логе появилась?

Feb 25 13:02:25 kernel: change ip from a7ba8c0 to 8f6bd5b

Появляется с разной периодичностью... точнее - без явного периода :)
WL550gE с прошивкой 1.9.2.7-7f
bocman
28-02-2008, 20:05
Помогите расшифровать лог:


...
Feb 28 21:32:19 pptp[313]: anon log[logecho:pptp_ctrl.c:670]: Echo Reply received.
Feb 28 21:33:19 pptp[313]: anon log[logecho:pptp_ctrl.c:670]: Echo Reply received.
Feb 28 21:33:19 pptp[313]: anon log[logecho:pptp_ctrl.c:672]: no more Echo Reply/Request packets will be reported.
Feb 28 21:40:34 dnsmasq[73]: DHCPINFORM(br0) 192.168.0.147 00:04:75:71:b2:b7
Feb 28 21:40:34 dnsmasq[73]: DHCPACK(br0) 192.168.0.147 00:04:75:71:b2:b7 user
Feb 28 21:40:37 dnsmasq[73]: DHCPINFORM(br0) 192.168.0.147 00:04:75:71:b2:b7
Feb 28 21:40:37 dnsmasq[73]: DHCPACK(br0) 192.168.0.147 00:04:75:71:b2:b7 user
Feb 28 22:07:20 pptp[313]: anon log[ctrlp_rep:pptp_ctrl.c:251]: Sent control packet type is 12 'Call-Clear-Request'
Feb 28 22:07:20 pptp[313]: anon log[pptp_conn_close:pptp_ctrl.c:433]: Closing PPTP connection
Feb 28 22:07:20 pptp[313]: anon log[ctrlp_rep:pptp_ctrl.c:251]: Sent control packet type is 3 'Stop-Control-Connection-Request'
Feb 28 22:07:20 pptp[313]: anon log[call_callback:pptp_callmgr.c:83]: Closing connection
Feb 28 22:07:20 pppd[110]: Modem hangup
Feb 28 22:07:20 PPTP: Disconnected
Feb 28 22:07:20 pppd[110]: Connection terminated.
Feb 28 22:07:20 pppd[110]: Connect time 44.3 minutes.
Feb 28 22:07:20 pppd[110]: Sent 3266644 bytes, received 19333409 bytes.
Feb 28 22:07:50 pppd[110]: Serial connection established.
Feb 28 22:07:50 pppd[110]: Using interface ppp0
Feb 28 22:07:50 pppd[110]: Connect: ppp0 <--> /dev/pts/0
Feb 28 22:07:50 pptp[327]: anon log[main:pptp.c:267]: The synchronous pptp option is activated
Feb 28 22:07:50 pptp[331]: anon warn[route_add:pptp_callmgr.c:457]: route_add: not adding existing route
Feb 28 22:07:50 pptp[331]: anon log[ctrlp_rep:pptp_ctrl.c:251]: Sent control packet type is 1 'Start-Control-Connection-Request'
Feb 28 22:07:50 pptp[331]: anon log[ctrlp_disp:pptp_ctrl.c:732]: Received Start Control Connection Reply
Feb 28 22:07:50 pptp[331]: anon log[ctrlp_disp:pptp_ctrl.c:766]: Client connection established.
Feb 28 22:07:51 pptp[331]: anon log[ctrlp_rep:pptp_ctrl.c:251]: Sent control packet type is 7 'Outgoing-Call-Request'
Feb 28 22:07:51 pptp[331]: anon log[ctrlp_disp:pptp_ctrl.c:851]: Received Outgoing Call Reply.
Feb 28 22:07:51 pptp[331]: anon log[ctrlp_disp:pptp_ctrl.c:890]: Outgoing call established (call ID 0, peer's call ID 21744).
Feb 28 22:07:51 pppd[110]: local IP address 213.141.140.91
Feb 28 22:07:51 pppd[110]: remote IP address 212.1.254.37
Feb 28 22:07:51 PPTP: connect to ISP
Feb 28 22:08:51 pptp[331]: anon log[logecho:pptp_ctrl.c:670]: Echo Reply received.
Feb 28 22:09:51 pptp[331]: anon log[logecho:pptp_ctrl.c:670]: Echo Reply received.
Feb 28 22:10:51 pptp[331]: anon log[logecho:pptp_ctrl.c:670]: Echo Reply received.
Feb 28 22:11:51 pptp[331]: anon log[logecho:pptp_ctrl.c:670]: Echo Reply received.
Feb 28 22:12:51 pptp[331]: anon log[logecho:pptp_ctrl.c:670]: Echo Reply received.
Feb 28 22:13:51 pptp[331]: anon log[logecho:pptp_ctrl.c:670]: Echo Reply received.
Feb 28 22:14:51 pptp[331]: anon log[logecho:pptp_ctrl.c:670]: Echo Reply received.
Feb 28 22:15:51 pptp[331]: anon log[logecho:pptp_ctrl.c:670]: Echo Reply received.
Feb 28 22:16:51 pptp[331]: anon log[logecho:pptp_ctrl.c:670]: Echo Reply received.
Feb 28 22:17:51 pptp[331]: anon log[logecho:pptp_ctrl.c:670]: Echo Reply received.
Feb 28 22:17:51 pptp[331]: anon log[logecho:pptp_ctrl.c:672]: no more Echo Reply/Request packets will be reported.
Feb 28 22:33:56 smbd[342]: [2008/02/28 22:33:56, 0] smbd/nttrans.c:call_nt_transact_ioctl(2516)
Feb 28 22:33:56 smbd[342]: call_nt_transact_ioctl: Currently not implemented.
Feb 28 22:34:27 FTP server: user anonymous logged in from 192.168.0.147
Feb 28 22:35:18 dropbear[346]: Child connection from ::ffff:192.168.0.147:2922
Feb 28 22:36:02 dropbear[346]: password auth succeeded for 'admin' from ::ffff:192.168.0.147:2922


что значать строчки кода времени 21:40:34 - 21:40:37 ? что происходило с 192.168.0.147 (это ip моей локальной машины)?

И почему в 22:07:20 произошел дисконнект?

И вообще подскажите, что не так в этом логе?
catmat
28-02-2008, 20:44
Машина 192.168.0.147 (user) обновила лизинг адреса (продлила аренду) с dhcp на роутере.

потом произошел отвал башки у pptp , инициатор разрыва - похоже что роутер ( не стоит idle сессии 1800 сек? ). сессия провисела 44.3 минуты. потом vpn соединение поднялось, pptp клиент получил адрес 213.141.140.91 .

потом клиент anonymous подключился с машины 192.168.0.147 к ftp.

потом юзер 192.168.0.147 залогинился по ssh.

не так в этом логе только какая-то ошибка самбы. (лень искать, что за ошибка)

усе.
avk
28-02-2008, 21:09
потом произошел отвал башки у pptp , инициатор разрыва - похоже что роутер ( не стоит idle сессии 1800 сек? )

Причина разрыва соединения не тайм-аут, а какой-то сбой. Разрыв по тайм-ауту выглядит так:

02:57:15 pppd[102]: Terminating connection due to lack of activity.
bocman
29-02-2008, 05:55
Подскажите, а гед можно поискать про ошибку, которая возникла у самбы
ди а вообще, где можно почитать про то чтов лог пишется...

стоит 1800сек, но это все же 30мин, а не 44,3мин....
а как можно знать почему произошел разрыв? дело в том что это произошло 2-3 раза в течении вечера...
avk
29-02-2008, 06:52
стоит 1800сек, но это все же 30мин, а не 44,3мин....
а как можно знать почему произошел разрыв? дело в том что это произошло 2-3 раза в течении вечера...

Idle Disconnect 1800 sec - это дисконнект при бездействии, т.е. сессия может продолжаться и 1, 2, 3... часа.

У меня была ситуация, когда за 1,5 часа могло произойти 7 обрывов. Я достал тех.поддержку провайдера, которая выяснила, что где-то рядом был зараженный компьютер, который засорял эфир - постоянно что-то слал. Когда заблокировали порт все нормализовалось.
bocman
29-02-2008, 07:10
Ну что бы доставать техподдержку, надо им что-то предъявить....

А по поводу дисконнекта при бездействии - когда после него я пытаюсь полезть в сеть, он коннектится?
avk
29-02-2008, 07:34
Если это был именно
Terminating connection due to lack of activity,
то ответ - ДА, соединение устанавливается автоматически, и например, при синхронизации
ntp client: Synchronizing time with time.nist.gov ...
bocman
29-02-2008, 07:43
Спасибо за ответы!
DikHell
01-03-2008, 14:45
А где ошибка? Нет ее. Это лог установления связи

позвольте с вами не согласиться - это все же ошибка какаято

1. связь устанавливается ДО того как эта ошибка появляется

Mar 1 17:27:56 pptp[116]: anon log[logecho:pptp_ctrl.c:670]: Echo Reply received.
Mar 1 17:28:56 pptp[116]: anon log[logecho:pptp_ctrl.c:670]: Echo Reply received.
Mar 1 17:29:56 pptp[116]: anon log[logecho:pptp_ctrl.c:670]: Echo Reply received.
Mar 1 17:30:56 pptp[116]: anon log[logecho:pptp_ctrl.c:670]: Echo Reply received.
Mar 1 17:31:56 pptp[116]: anon log[logecho:pptp_ctrl.c:670]: Echo Reply received.
Mar 1 17:32:56 pptp[116]: anon log[logecho:pptp_ctrl.c:670]: Echo Reply received.
Mar 1 17:33:56 pptp[116]: anon log[logecho:pptp_ctrl.c:670]: Echo Reply received.
Mar 1 17:34:40 dnsmasq[72]: DHCPREQUEST(br0)
Mar 1 17:34:40 dnsmasq[72]: DHCPACK(br0)
Mar 1 17:34:43 dnsmasq[72]: DHCPREQUEST(br0)
Mar 1 17:34:43 dnsmasq[72]: DHCPACK(br0)
Mar 1 17:34:56 pptp[116]: anon log[logecho:pptp_ctrl.c:670]: Echo Reply received.
Mar 1 17:35:56 pptp[116]: anon log[logecho:pptp_ctrl.c:670]: Echo Reply received.
Mar 1 17:36:56 pptp[116]: anon log[logecho:pptp_ctrl.c:670]: Echo Reply received.
Mar 1 17:36:56 pptp[116]: anon log[logecho:pptp_ctrl.c:672]: no more Echo Reply/Request packets will be reported.

ПОМОГИТЕ СОВЕТОМ ЧТО СДЕЛАТЬ какую настройку
Oleg
01-03-2008, 15:50
Нет там никаких ошибок. Это отладочные сообщения. Чтобы от них избавится прошейте "превью" версию.
Saros
09-03-2008, 22:24
увидел у себя аналогичные строки:
Mar 9 22:20:49 kernel: change ip from c033515d to c033515d
Mar 9 22:20:50 kernel: change ip from e377e457 to e377e457
Mar 9 22:20:50 kernel: change ip from 7d87bd59 to 7d87bd59
Mar 9 22:20:50 kernel: change ip from 2592505d to 2592505d
Mar 9 22:20:50 kernel: change ip from 755db73e to 755db73e
Mar 9 22:20:51 kernel: change ip from c40df955 to c40df955
Mar 9 22:20:52 kernel: change ip from 552997c1 to 552997c1
Mar 9 22:20:53 kernel: change ip from 4081951 to 4081951
Mar 9 22:20:55 kernel: change ip from adb2955b to adb2955b
Mar 9 22:20:56 kernel: change ip from d2d5965a to d2d5965a
Mar 9 22:29:46 kernel: change ip from f01a8c0 to 5660b00a
Mar 9 22:41:47 kernel: change ip from 4e257e4f to 4e257e4f
Mar 9 22:41:48 kernel: change ip from 3e2dd59 to 3e2dd59
Mar 9 22:42:44 kernel: change ip from f01a8c0 to 5660b00a

500W 8.21
Oleg
10-03-2008, 06:52
Запретите старкрафт в веб-интерфейсе.
Saros
10-03-2008, 17:30
Спасибо. Но хотелось бы узнать что именно означает этот лог и ф-я старкрафт. Я сам гамаю по BattleNET и в старик и в варик...
aarnet
19-04-2008, 17:10
весь лог "забит" вот этим:
Apr 19 16:06:08 kernel: br0: topology change detected, propagating
Apr 19 16:06:10 kernel: br0: received tcn bpdu on port 1(vlan0)
Apr 19 16:06:10 kernel: br0: topology change detected, propagating

виновник Powerline адаптер DHP-300 от D-link

Но вся беда в том что его не отключить - на Powerline построена часть сетки, можно ли на WL-500gP каким то образом отключить проверку топологии на конкретном порту LAN или что нить еще ?
dimokrat
25-04-2008, 21:19
Похоже, что Вы указали роутер в качестве WINS сервера. Зачем Вы это сделали?
Олег, а почему это не рекомендуется?
almeewar
04-05-2008, 11:39
Глянул в лог и увидел непонятную вещь, связанную с MAC-адресом, что-то вроде "девайс eth0 имеет тот же MAC-адрес..."
Провайдер Корбина.

Это критично? Хелп.



Jan 1 03:06:16 wan: connected manually
Jan 1 03:06:16 udhcpc[107]: Unicasting a release of 10.198.23.223 to 83.102.233.202
Jan 1 03:06:17 dhcp client: deconfig: lease is lost
Jan 1 03:06:17 udhcpc[107]: Entering released state
Jan 1 03:06:17 udhcpc[107]: Received SIGTERM
Jan 1 03:06:19 kernel: vlan1: Setting MAC address to 00 2e 3c 36 ad 97.
Jan 1 03:06:19 kernel: VLAN (vlan1): Underlying device (eth0) has same MAC, not checking promiscious mode.
Jan 1 03:06:19 udhcpc[182]: udhcpc (v0.9.9-pre) started
Jan 1 03:06:19 dhcp client: deconfig: lease is lost
Jan 1 03:06:20 udhcpc[182]: Lease of 10.198.23.223 obtained, lease time 604800
Jan 1 03:06:20 dnsmasq[72]: read /etc/hosts - 5 addresses
Jan 1 03:06:20 dnsmasq[72]: read /etc/ethers - 2 addresses
Jan 1 03:06:20 dnsmasq[72]: reading /tmp/resolv.conf
Jan 1 03:06:20 dnsmasq[72]: using nameserver 85.21.192.3#53
Jan 1 03:06:20 dnsmasq[72]: using nameserver 213.234.192.8#53
Jan 1 03:06:20 dhcp client: bound IP : 10.198.23.223 from 10.198.16.1
Jan 1 03:06:54 dnsmasq[72]: DHCPINFORM(br0) 192.168.1.2 00:17:31:90:2f:72
Jan 1 03:06:54 dnsmasq[72]: DHCPACK(br0) 192.168.1.2 00:17:31:90:2f:72 klb
May 4 14:13:02 l2tpd[195]: tunnel_establish: gethostbyname failed for 'vpn.corbina.net'
May 4 14:13:10 ntp client: Synchronizing time with ntp.corbina.ru ...
Spacesoft
04-05-2008, 13:09
MAC адрес чтоли не введён? Лучше таки вввести.
Критичнее это:
May 4 14:13:02 l2tpd[195]: tunnel_establish: gethostbyname failed for 'vpn.corbina.net'
VEDMED007
04-05-2008, 13:15
Глянул в лог и увидел непонятную вещь, связанную с MAC-адресом, что-то вроде "девайс eth0 имеет тот же MAC-адрес..."
Провайдер Корбина.

Это критично? Хелп.
Абсолютно не критично, после ребута устройство каждый раз назначает vlan1 "свой" мак. Он один и тот же, волноваться не о чем.

По поводу 2го поста - либо блок инета-локалки, либо роутинг не сработал, либо днс-сервер "лежит" (или неправильный).
(ху из ху решается пингом)
vectorm
04-05-2008, 13:20
Глянул в лог и увидел непонятную вещь, связанную с MAC-адресом, что-то вроде "девайс eth0 имеет тот же MAC-адрес..."
Провайдер Корбина.

Это критично? Хелп.
Это говорит о том, что MAC адрес WAN был скопирован с компа, видимо по причине того, что провайдер (как почти все сейчас) привязывает доступ к MAC. Это не ошибка, а предупреждение. Забить.
UPD: уже ответили до меня :)
almeewar
04-05-2008, 20:35
Всем большое спасибо за ответы!
Инет в то время действительно не работал - электричество выключали :)
Steven_GT
04-06-2008, 12:31
WL 500GP V1, прошивка 1.9.2.7-10. Аналогичные сообщения появились в логе, только их намного больше. И скорость исходящего от меня трафика рухнула до 80-150 килобит (при канале 3 мегабита).
Напрямую подключенный компьютер спидтестом показывает 3 мегабита в обе стороны, за рутером входящий 3 мегабита, исходящий 80 килобит :mad: Соединение с провайдером по PPTP, шифрования нет. Некоторое время назад все работало нормально.
С моей стороны была перепрошивка с 1.9.2.7-7 до 1.9.2.7-9, но не припомню уже, совпало по времени или нет. Сегодня перешился до 1.9.2.7-10, никаких изменений, опять тормоза.
Пробовал сброс кнопкой до заводских установок и настройку вручную заново, не помогает. Никаких дополнительных сервисов на асусе не поднято, вынут из коробки, перешит прошивкой Олега да настроен на провайдера, по USB ничего не подключено.

Подскажите, куда копать?
nikita1234
04-06-2008, 20:17
Здравствуйте, недавно в логе стало появляться сообщение об ошибки шифрования.
Jan 1 03:00:34 kernel: mppe_decomp_alloc: options rejected: o[0]=12, o[1]=06, o[2]=00, o[3]=00, o[4]=00, o[5]=00
Jan 1 03:00:34 pppd[111]: Received bad configure-ack:
Jan 1 03:00:37 kernel: mppe_decomp_alloc: options rejected: o[0]=12, o[1]=06, o[2]=00, o[3]=00, o[4]=00, o[5]=00
Jan 1 03:00:37 pppd[111]: Received bad configure-ack:
Jan 1 03:00:40 kernel: mppe_decomp_alloc: options rejected: o[0]=12, o[1]=06, o[2]=00, o[3]=00, o[4]=00, o[5]=00
Jan 1 03:00:40 pppd[111]: Received bad configure-ack:
Jan 1 03:00:43 pppd[111]: CCP: timeout sending Config-Requests
Прошивка 1.9.2.7-9, в additional pppd options ничего не прописано, так как прошивка все сама должна делать, у других тоже такая ошибка возникала, но решения не нашел. Помогите пожалуйста.
Antosha
06-06-2008, 18:47
Со вчерашнего дня началась такая же фигня:



Jun 6 17:44:01 kernel: br0: neighbour 8000.00:17:9a:04:5d:73 lost on port 1(vlan0)
Jun 6 17:44:01 kernel: br0: topology change detected, propagating
Jun 6 17:44:05 kernel: br0: retransmitting tcn bpdu

Котролировать сеть не имеется возможности, как игнорировать это дело?
vsu
07-06-2008, 11:07
Описано в инструкции по настройке WL-500g* (http://wl500g.info/showthread.php?t=3171):
5) отключить STP (чтобы не флудил в LAN):
nvram set lan_stp=0
nvram commit(при этом, кроме передачи, отключается и приём пакетов STP).
Antosha
07-06-2008, 12:20
Спасибо, поиск всё же рулит :)
ncat
10-06-2008, 01:11
С недавних пор весь лог роутера зафлужен следующими сообщениями

Jun 10 04:00:55 kernel: svc: short len 3, dropping request

Сообщения появляются каждые 4 секунды

Ещё иногда проскакивают и такие
Jun 10 04:01:26 kernel: svc: bad direction -1365425920, dropping request
Jun 10 04:03:15 kernel: svc: bad direction -991545600, dropping request

Надеюсь кто-нибудь объяснит мне что они обозначают.

p.s. wl500gp, 1.9.2.7-9, corbina (l2tp).
vaspupkin
11-07-2008, 08:56
Роутер WL500GP, прошивка последняя - .10, подключен USB диск

Обнаружил в логе следующую запись, как это трактовать?

Jul 11 09:29:48 kernel: Unhandled kernel unaligned access in unaligned.c::emulate_load_store_insn, line 481:
Jul 11 09:29:48 kernel: $0 : 00000000 10009c00 00000001 800d7984 81b05f20 00000001 00000000 00000137
Jul 11 09:29:48 kernel: $8 : 0000000a 00000003 00000001 73746b70 7479622f 00001000 00000000 652f7365
Jul 11 09:29:48 kernel: $16: 81b05f20 00000000 00000001 00000138 00000004 7fff6798 00000000 80a7cf80
Jul 11 09:29:48 kernel: $24: 00000018 2ad8a910 81ec4000 81ec5e98 81b05f38 800540fc
Jul 11 09:29:48 kernel: Hi : 00000000
Jul 11 09:29:48 kernel: Lo : 00000000
Jul 11 09:29:48 kernel: epc : 800d7994 Tainted: P
Jul 11 09:29:48 kernel: Status: 10009c03
Jul 11 09:29:48 kernel: Cause : 00000010
Jul 11 09:29:48 kernel: Process mc (pid: 404, stackpage=81ec4000)
Jul 11 09:29:48 kernel: Stack: 81b05f20 00000001 00000001 7fff6798 800540fc 80054014 00000000
Jul 11 09:29:48 kernel: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000004
Jul 11 09:29:48 kernel: 80a7cf60 ffffffea 7fff6798 00480000 7fff6798 00000004 004bb298 004bb2dc
Jul 11 09:29:48 kernel: 800369f8 81e73720 7fff6700 80040198 800401c0 000001a0 0051ded8 00515428
Jul 11 09:29:48 kernel: 004d0000 00000096 00000004 00514ad8 7fff6798 800085c4 800085c4 ffffffff
Jul 11 09:29:48 kernel: 7fff6090 ...
Jul 11 09:29:48 kernel: Call Trace: [<800540fc>] [<80054014>] [<800369f8>] [<80040198>] [<800401c0>]
Jul 11 09:29:48 kernel: [<800085c4>] [<800085c4>] [<801976a0>]
Jul 11 09:29:48 kernel:
Jul 11 09:29:48 kernel: Code: afbf0010 10a0000a 24020001 <8ca40134> c0830028 00622823 e0850028 10a0fffc 00622823
vectorm
11-07-2008, 10:24
Ну а подробности? Что из софта стоит и т.д. ...
Часом win шары не подмеплено в роутере с компа?
vaspupkin
11-07-2008, 11:24
Из софта стоит mc, lihttpd, cron, встроенный ftp, включена самба, дисковая папка расшарена на компы, как домашний каталог. вот и все подробности.
vectorm
11-07-2008, 12:32
дисковая папка расшарена на компы, как домашний каталог.
Вот это наверное и вызывает ошибки.
Попытка через mc почитать данные в домашней папке компового юзера - одновременный доступ к данным в роутере плохо сказывается.
zen1985
16-07-2008, 14:12
Несколько дней назад появилась ошибка в логе, роутер работает нормально. Может кто сталкивался с этим, в чем может быть проблема? Заранее спасибо

Jul 15 23:44:02 smbd[282]: [2008/07/15 23:44:02, 0] lib/util_sock.c:read_socket_data(477)
Jul 15 23:44:02 smbd[282]: read_socket_data: recv failure for 4. Error = Connection reset by peer
azhur
16-07-2008, 14:52
Насколько я понял, это самба ругается, что кто-то на том конце провода грубо оборвал сеанс связи.
Проблема в том, кто незадолго до этого что-то качал через самбу.
Или может потери пакетов, но там вроде другая ошибка.
zen1985
17-07-2008, 13:56
Насколько я понял, это самба ругается, что кто-то на том конце провода грубо оборвал сеанс связи.
Проблема в том, кто незадолго до этого что-то качал через самбу.
Или может потери пакетов, но там вроде другая ошибка.

Как от нее можно избавится? ошибка появляется и повторяется весь период при включенном компе, когда комп выключен ошибок не возникает.


Jul 16 19:13:55 smbd[318]: read_socket_data: recv failure for 4. Error = Connection reset by peer
Jul 16 19:33:54 smbd[320]: [2008/07/16 19:33:54, 0] lib/util_sock.c:read_socket_data(477)
Jul 16 19:33:54 smbd[320]: read_socket_data: recv failure for 4. Error = Connection reset by peer
Jul 16 19:53:54 smbd[321]: [2008/07/16 19:53:54, 0] lib/util_sock.c:read_socket_data(477)
Jul 16 19:53:54 smbd[321]: read_socket_data: recv failure for 4. Error = Connection reset by peer
Jul 16 20:13:53 smbd[323]: [2008/07/16 20:13:53, 0] lib/util_sock.c:read_socket_data(477)
Jul 16 20:13:53 smbd[323]: read_socket_data: recv failure for 4. Error = Connection reset by peer
Jul 16 20:33:53 smbd[325]: [2008/07/16 20:33:53, 0] lib/util_sock.c:read_socket_data(477)
qman
26-07-2008, 21:24
Что значат в этом логе DST=239.255.255.250???

более подробный лог:
Jan 1 07:22:03 kernel: ACCEPT IN=br0 OUT= MAC= SRC=192.168.0.254 DST=239.255.255.250 LEN=333 TOS=0x00 PREC=0x00 TTL=4 ID=0 DF PROTO=UDP SPT=1900 DPT=1900 LEN=313
Jan 1 07:22:03 kernel: ACCEPT IN=br0 OUT= MAC= SRC=192.168.0.254 DST=239.255.255.250 LEN=342 TOS=0x00 PREC=0x00 TTL=4 ID=0 DF PROTO=UDP SPT=1900 DPT=1900 LEN=322
Jan 1 07:22:03 kernel: ACCEPT IN=br0 OUT= MAC= SRC=192.168.0.254 DST=239.255.255.250 LEN=405 TOS=0x00 PREC=0x00 TTL=4 ID=0 DF PROTO=UDP SPT=1900 DPT=1900 LEN=385
Jan 1 07:22:03 kernel: ACCEPT IN=br0 OUT= MAC= SRC=192.168.0.254 DST=239.255.255.250 LEN=397 TOS=0x00 PREC=0x00 TTL=4 ID=0 DF PROTO=UDP SPT=1900 DPT=1900 LEN=377
Jan 1 07:22:03 kernel: ACCEPT IN=br0 OUT= MAC= SRC=192.168.0.254 DST=239.255.255.250 LEN=342 TOS=0x00 PREC=0x00 TTL=4 ID=0 DF PROTO=UDP SPT=1900 DPT=1900 LEN=322
Jan 1 07:22:03 kernel: ACCEPT IN=br0 OUT= MAC= SRC=192.168.0.254 DST=239.255.255.250 LEN=381 TOS=0x00 PREC=0x00 TTL=4 ID=0 DF PROTO=UDP SPT=1900 DPT=1900 LEN=361
Jan 1 07:22:03 kernel: ACCEPT IN=br0 OUT= MAC= SRC=192.168.0.254 DST=239.255.255.250 LEN=413 TOS=0x00 PREC=0x00 TTL=4 ID=0 DF PROTO=UDP SPT=1900 DPT=1900 LEN=393
Jan 1 07:22:03 kernel: ACCEPT IN=br0 OUT= MAC= SRC=192.168.0.254 DST=239.255.255.250 LEN=342 TOS=0x00 PREC=0x00 TTL=4 ID=0 DF PROTO=UDP SPT=1900 DPT=1900 LEN=322
Jan 1 07:22:03 kernel: ACCEPT IN=br0 OUT= MAC= SRC=192.168.0.254 DST=239.255.255.250 LEN=401 TOS=0x00 PREC=0x00 TTL=4 ID=0 DF PROTO=UDP SPT=1900 DPT=1900 LEN=381
Jan 1 07:22:03 kernel: ACCEPT IN=br0 OUT= MAC= SRC=192.168.0.254 DST=239.255.255.250 LEN=395 TOS=0x00 PREC=0x00 TTL=4 ID=0 DF PROTO=UDP SPT=1900 DPT=1900 LEN=375

если попробовать пинговать
PING 239.255.255.250 (239.255.255.250): 56 data bytes
ping: sendto: Network is unreachable
У меня нет такой подсети.. В добавок в момент появления таких ошибок винда пишет что были утеряны данные при копровании по беспроводной сети.
Подскажите как решить вторую проблему? откуда такие логи?
AndreyPopov
26-07-2008, 21:48
Что значат в этом логе DST=239.255.255.250???

более подробный лог:
Jan 1 07:22:03 kernel: ACCEPT IN=br0 OUT= MAC= SRC=192.168.0.254 DST=239.255.255.250 LEN=333 TOS=0x00 PREC=0x00 TTL=4 ID=0 DF PROTO=UDP SPT=1900 DPT=1900 LEN=313
Jan 1 07:22:03 kernel: ACCEPT IN=br0 OUT= MAC= SRC=192.168.0.254 DST=239.255.255.250 LEN=342 TOS=0x00 PREC=0x00 TTL=4 ID=0 DF PROTO=UDP SPT=1900 DPT=1900 LEN=322
Jan 1 07:22:03 kernel: ACCEPT IN=br0 OUT= MAC= SRC=192.168.0.254 DST=239.255.255.250 LEN=405 TOS=0x00 PREC=0x00 TTL=4 ID=0 DF PROTO=UDP SPT=1900 DPT=1900 LEN=385
Jan 1 07:22:03 kernel: ACCEPT IN=br0 OUT= MAC= SRC=192.168.0.254 DST=239.255.255.250 LEN=397 TOS=0x00 PREC=0x00 TTL=4 ID=0 DF PROTO=UDP SPT=1900 DPT=1900 LEN=377
Jan 1 07:22:03 kernel: ACCEPT IN=br0 OUT= MAC= SRC=192.168.0.254 DST=239.255.255.250 LEN=342 TOS=0x00 PREC=0x00 TTL=4 ID=0 DF PROTO=UDP SPT=1900 DPT=1900 LEN=322
Jan 1 07:22:03 kernel: ACCEPT IN=br0 OUT= MAC= SRC=192.168.0.254 DST=239.255.255.250 LEN=381 TOS=0x00 PREC=0x00 TTL=4 ID=0 DF PROTO=UDP SPT=1900 DPT=1900 LEN=361
Jan 1 07:22:03 kernel: ACCEPT IN=br0 OUT= MAC= SRC=192.168.0.254 DST=239.255.255.250 LEN=413 TOS=0x00 PREC=0x00 TTL=4 ID=0 DF PROTO=UDP SPT=1900 DPT=1900 LEN=393
Jan 1 07:22:03 kernel: ACCEPT IN=br0 OUT= MAC= SRC=192.168.0.254 DST=239.255.255.250 LEN=342 TOS=0x00 PREC=0x00 TTL=4 ID=0 DF PROTO=UDP SPT=1900 DPT=1900 LEN=322
Jan 1 07:22:03 kernel: ACCEPT IN=br0 OUT= MAC= SRC=192.168.0.254 DST=239.255.255.250 LEN=401 TOS=0x00 PREC=0x00 TTL=4 ID=0 DF PROTO=UDP SPT=1900 DPT=1900 LEN=381
Jan 1 07:22:03 kernel: ACCEPT IN=br0 OUT= MAC= SRC=192.168.0.254 DST=239.255.255.250 LEN=395 TOS=0x00 PREC=0x00 TTL=4 ID=0 DF PROTO=UDP SPT=1900 DPT=1900 LEN=375

если попробовать пинговать
PING 239.255.255.250 (239.255.255.250): 56 data bytes
ping: sendto: Network is unreachable
У меня нет такой подсети.. В добавок в момент появления таких ошибок винда пишет что были утеряны данные при копровании по беспроводной сети.
Подскажите как решить вторую проблему? откуда такие логи?

все адреса, которые больше 223.255.255.254 - это ШИРОКОВЕЩАТЕЛЬНЫЕ пакеты.

SRC=192.168.0.254 DST=239.255.255.250 - это значит, что адрес 192.168.0.254 отослал шировещательное сообщение
basilz
14-08-2008, 20:21
Прицепил к роутеру винт, отформатированный некогда на компе в ext3. Зашел телнетом и для теста включил копирование 5 гигабайтного файла:
cp huge_file1 huge_file2

Через некоторое время выпало Segmentation fault и в логе появилась та самая ошибка про unaligned access.

Роутер wl500w. Питание винта от усб роутера, защита усб закорочена перемычкой. Файловая система предварительно проверена на роутере командой e2fsck -fp. Память перепаяна на 128Мб и разогнана, проц разогнан, memtest успешный. Никаких параллельных операций с диском не было. Во втором усб флэшка, примонтированная в /opt.
sauron093
18-09-2008, 14:54
седня у видел в логе эту хрень... и что бы это значило?:confused:


17:27:36 18-09-2008 (emerg|user|PPPoE) PPPoE: connect to ISP
17:27:36 18-09-2008 (emerg|user|update) update: connected to members.dyndns.org (63.208.196.95) on port 80.
17:27:36 18-09-2008 (emerg|user|update) update: request successful
17:27:37 18-09-2008 (warning|kern|kernel) nvram_commit: out of memory
17:27:36 18-09-2008 (emerg|user|ddns) ddns: ddns update ok
sauron093
19-09-2008, 09:51
что скажут Гуру?
sauron093
22-09-2008, 14:07
седня какието гады отрубали электричество на 20 мин. после загруза роутера проверил логи, напрягшая меня строчка пропала...

что всетаки было?
:confused:
vectorm
22-09-2008, 18:54
седня какието гады отрубали электричество на 20 мин. после загруза роутера проверил логи, напрягшая меня строчка пропала...

что всетаки было?
:confused:
Память освободилась и коммит стал проходить нормально.
denver_83
23-09-2008, 10:48
В логе появляется регулярно надпись:

23.09.2008 12:55:53 User.Error ASUS kernel: ipt_tcpmss_target: bad length (1460 bytes)

Что это значит и отчего она может появляться?
спасибо.

PS: А почему бы не создать мини-фак по ошибкам??
sauron093
24-09-2008, 08:08
Память освободилась и коммит стал проходить нормально.
хм... интересно чем она забивалась? ошибка появлялась также после перезагрузки
denver_83
24-09-2008, 10:57
Товарищи! Неужели никто не поможет мне?
makcumka
27-09-2008, 01:09
не обращай внимания, если это была единственная строчка. если их много, тогда у тебя проблемы с Path MTU Discovery.

у тебя в iptables есть такая строка:

-p tcp --tcp-flags SYN,RST SYN -j TCPMSS --clamp-mss-to-pmtu

вот на ней твой iptables ругнулся получив такой пакет который не смог обработать должным образом ;)
Power
03-10-2008, 12:58
Гугл (первая же ссылка): http://lists.netfilter.org/pipermail/netfilter/2003-August/046096.html

Вольный перевод:
Правило (которое -p tcp --syn -j TCPMSS --clamp-mss-to-pmtu) применяется только к SYN-пакетам, а они не должны содержать в себе данные, т.е. длина TCP-пакета должна быть равна длине TCP-заголовка. В противном случае это неправильная длина и неправильный пакет, и он не обрабатывается, о чём и добавляется запись в лог.

Другими словами, у кого-то не очень правильная реализация протокола TCP и эти записи вполне можно игнорировать.
Slav_on
28-10-2008, 20:02
Доброго времени суток уважаемые участники данного форума, в очередной раз наблюда в локах роутера WL500GP v.1 вот такую картину:


Oct 28 22:50:46 kernel: nvram_commit: out of memory
Oct 28 22:52:57 kernel: nvram_commit: out of memory
Oct 28 22:53:00 kernel: nvram_commit: out of memory
Oct 28 22:53:02 kernel: nvram_commit: out of memory
Oct 28 22:53:03 kernel: nvram_commit: out of memory


Что сие означает и вообще нужно ломать голову или время от времени перезагружать зверька?

Вопрос уже задавал:
http://wl500g.info/showpost.php?p=116355&postcount=108
http://wl500g.info/showpost.php?p=116357&postcount=109
но не получил ответа.
al37919
28-10-2008, 20:18
при такой настойчивости в поиске решения и при временном отсутсвии в форуме человека, который знает ответ на данный вопрос, могу посоветовать поискать данное сообщение и его смысл в исходниках прошивки.
DfDf
29-10-2008, 00:09
Хм... nvram commit - сохранение изменений в nvram (настройки и т.п.). По логике это означает, что место там кончилось. Думаю, для начала надо сбросить роутер в настройки по умолчанию, затем настроить заново.

Вот, в качестве примера, здесь видно, что такое nvram и когда делается commit: http://wl500g.info/showpost.php?p=77301&postcount=24
vectorm
29-10-2008, 11:02
Как я уже неоднократно советовал - ребутните роутер и все пройдет, видимо /tmp забивается, например логами.
Slav_on
29-10-2008, 15:20
Как я уже неоднократно советовал - ребутните роутер и все пройдет, видимо /tmp забивается, например логами.Ребутить и востанавливать роутер я уже пробовал и повторюсь большими буквами:

1. Ребут спасает положение но до поры до времени.

2. Перестановка и перепрошивка ничего не дает ошибка вылетает рано или поздно.

Теперь из замеченного в процессе работы роутера и к чему приводит данная ошибка. Для простого пользователя не ломающего себе голову всякими глупостями типа консоль и ошибки ничего не происходит т.е. роутер продолжает исправно пускать в Интернет и качать торенты. Зато сам факт ошибок имеет место быть на любой железке с Линуксом внутри. Какой либо тенденции в выдаче данного сообщения немамечено т.е. ошибки выпадают хаотично порой их нет секунд 20, а порой просто каждую секунду.

Копаться в сырцах не умею по причине отсутствия необходимых навыков и знаний, моя специальность далека от программирования ну очень далекооо... Следовательно проанализировать код или ядро я не могу. Вопрос к людям которые разбираются и приближонным к телу Олега который если появится пусть примет на заметку.

Вообще считаю необходимо людым присмотреться к логам которые выдает роутер и если есть такие строчки то сообщить на какой машинке и при каких условиях это происходит. Больше информации больше вероятность того что глюк в будущих, если будут, прошивках будет исправлен. Допускаю что это специфическая проблема возникающая на конкретной, моей, конфигурации и фиксить ее из-за одного человека не стоит т.к. а вот из-за 100... думаю стоит подумать.
2bars
29-10-2008, 17:19
солидарен, ты чёто такое ставишь что забивает память...
тоесть у тя запись логов непрерывная, полезно очищать их....
Slav_on
29-10-2008, 17:25
солидарен, ты чёто такое ставишь что забивает память...Да собственно ничего. Но заметил тенденцию, если на роутере работает торент, затем я смотрю кино по WiFi и попутно чего нибудь тыну по FTP с HDD подключенного к роутеру такое происходит. Вообще в приведённых скриншотах наглядно видно, что и в какой пропорции грузит ОЗУ.

тоесть у тя запись логов непрерывная, полезно очищать их...Очищать в ВЭБ-интерфейсе? Не помогает пробовал.
madprepod
11-11-2008, 14:00
Может кто подскажет???
Nov 11 15:35:35 smbd[151]: [2008/11/11 15:35:35, 0] lib/util_sock.c:read_socket_data(477)
Nov 11 15:35:35 smbd[151]: read_socket_data: recv failure for 4. Error = Connection reset by peer
vectorm
11-11-2008, 14:49
Диск роутера подмеплен в Винде? Отмепте и глядите лог - ошибки должны пропасть.
sonice
19-11-2008, 05:16
у меня подобное oбнаружил в системном логе множественные сообщения об ошибках:

Aug 11 21:27:28 dropbear[627]: Child connection from ::ffff:59.63.25.158:38357
Aug 11 21:27:31 dropbear[627]: login attempt for nonexistent user from ::ffff:59.63.25.158:38357
Aug 11 21:27:32 dropbear[627]: exit before auth: Disconnect received
Aug 11 21:27:32 dropbear[628]: Child connection from ::ffff:59.63.25.158:38728
Aug 11 21:27:35 dropbear[628]: login attempt for nonexistent user from ::ffff:59.63.25.158:38728
Aug 11 21:27:35 dropbear[628]: exit before auth: Disconnect received
Aug 11 21:27:36 dropbear[629]: Child connect&#208;&#225;206ž*b&#232;8&K<ŠŠ·&#253;[Z,lI |®¤ivPfš%¤e9&#235;&#211;
>\$ &#161;W#c&#223;&#198;X!&#248;–®&#215;u‚8 w#WY’¦‰_‹&#213;&#224;&#249;&#225;v|&#214;Ÿ=„Š:&#232;‘§«&#224;{&#213;;›&#201;&#252;&#205; ™q}V:&#247;€&#193;”&#194;™&#234;&#193;&#245;i&#229;,Œ&#211;&#188;‚Ÿ&#170;>&#179;&#228;&#204;"·H&#212;&#226;Ÿƒ'&#163;&#211;&#245;‚&#178;!q*i&#224;„N &#162;&#251;Xƒ1™K&#215;M&#243;&#210;&#178;&#234;¬G&#180; &#224;&#192;&#200;©€#
! &#253;˜—&#220;g¤&#249;&#220;
©&#191; &#250;L:/ &#240;0¶‘0&#224;™&#229;
Ip)&#180;&#223;•µ&#230;Z&#189;&#207;&#226;˜(« ˆƒ%&#193; CL‰m&#231;•&#192;*Y]«‘&#175;&#203;A&#201;&#211;œ&#247;&#190;>W(A§&#199;Œ&#232;&#238;©#"j‚D&#189;ƒœ&#193;‚t&#218;POŒ&#163;…a8„2N&#170;s T&#215;&#168;„'V 4&#210;N‘&#178;&#227;B5&#168;V‰°&#188;•&#199;&#180;&#233;&#162;&#209;‹&#214;Q‰W
&#192;su [<&#251;&#232;&#190;&#226;}‘sAˆz±j&#178;(!…d„1O&#248;&#246;‚–©V&#214;h[…&#175;&#201;q&#195;`&#196;‰&#223;&#198;&#192;&#195;0&#179;&#248;·V e Fyug‡&#170;µ9&#241;8‰8_8&#219;x–_&#253;&#193;t&#185;&#241;bz&#198;EPŠ‰ &#165;&#206;Ÿ:&#246;#&#212;&#184; &#254;&#241;(!&#251;ŸT&#168;&#188;&#185;*&#175;&#223;+&#202;‘G&#252;¬&#185;P“&#193;,w†›™cJ
|~ŠI&#198;&#225;ENU|&#250;&#188;h{pb&#246;8H•«·S&#252;¦?&#235;u&#188;%Lœ&#206;&#163;8#&#246;&#234;j¤ &#196;&#236;¬t»Ÿ&#247;&#219;II&#192;ldclšš‹‡|%™Ht7&#170;&#252;&#165;N&#219;&#209;™&#210;Ps&#197;Cš&#188;iG&#248; ˆ&#236;&#248;e¶¬Ž&#218;+&#225;d&#178;&#240;D.&#223;&#230;–^&#231;&#165;&#231;F&#225;‘I&#244;‹&#193;&#232;r&#202;‘Œ#8v|u&#178;.&#165;&#188; r#&#204;&#201;&#191;T"ps
j) &#194;&#168;&#227;ŒZe 0«&#229;’&#224;&#224;&#184;qˆ/\e»*&#222;j&#211;D&#194;‚‡m•I˜T fˆŽ&#245;gv&#211;4¬=UW&#161;'=6ibag&#254; O&#196;B&#165;zU&#209;&#170;f } a›f€&#247;&#229;&#196;&#224;&#197;n&#226;sC&#175;&#211;&#198;&#204;«V&#205;Gš7ŸUf&#250;&#232;uc&#233;8ŽV6&#225;&#253;&#224;…&#254;]&#161;—&#224;&#226;:_&#238;&#242;`ˆ&#207;…9X#&#221;&#195;&#234;&#232;Ÿ{–&#226;k&#230;ƒ&#206;;&#231;&#215;Ÿ3˜kO¶&#216;&#185;'Xy&#191;&#234;†&#170; ¦ž&#184;&#207;N|&#213;&#200;-&#210;&#162;¦&#184;
Ž&#246;)&#170;)KZ(¤c&#208;`P·[&#209;(Hj® p\&#227;&#201;&#180;pŸ?]sVTaQ&#246;UƒA‚+Y 1&#227;G dœ&#214; ‚ž‹‚< &#224;&#195;&#224;€&#168;°»D°|&#254;&#213;&#243;&#224;Tb¬&#168;&#224;ˆQ¤&#226;&#218;dgeZ&#214;“Œ?&#238;&#224;‰&#204;&#202;µt&#195;-&#221;&#234;&#202;&#213;&#227;a&#230;&#189;&#236;&#185;Q(&#209;[t`ž&#200;&#193;s&#227;rd&#186;a–ŽF¦&#196;&#201;20&#165;J% S&#254;&#193;&#229;
&#168;&#235;D&#222;&#186;"R &#222;&#235;P 'ˆ&#193;X±j&#189;/»&#190;*&#214;X &#239;&#192;&#163;&#228;&#205;&#214;H@&#216;&#209; *&#226;&#216;`¤&#241;‘Ÿ&#220;Q¦u‚L&#222;&#253;R5&#213;&#202;J&#220;&#244;&#235;&#224;&#162;N<&#199;&#244; &#198;†–{&#180;&#231;p&#194;^¶&#205;&#228;'!y5€&#235;z<.œ‘&#239;&#168;]&#229;/&#243;§&#192;O&#165;Ÿ&#217;&#237;W&#236;)…§ž‡W{ƒ?~&#180;&#243;&#225;&#204;7&#231;&#198; xS;&#193;,
~
©5:d˜Tt&#254;&#237;&#179;&#255;ƒ&#227;]&#206;\‡&#228;&#205;&#207;+&#198;&#234;&#247;(: [#&#192;S·&#254;&#247;V€®{Dq&#204;|
Œ c&#245;pp*5k'&#213;l6¤#
&#236;*G&#212;°©•&#240; K&#192;&#168;&#196;/&#214;0&#175;…hVy&#232;_&#191;I&#214;&#178;&#196;k&#212;aLs&#237;>˜"&#254;¶&#197;^&#242;&#180;&#216;9Dl0Œ‘“©…U•C &#194;@7&#193;•j&#162;&#224;a&#226;&#240;’>pK9:&#217;&#191;‚me&#194;›j_RP€
m#zr>Œ&zD.L0«b&#193;&#240;&#241;@—&#229;m&#213;&#224;&#207;&#188;Ž&#197;&#192;l&#179;Ir–{`w&#179;&#163;&#188;&#170;”UPµŸ¬&#209;&#175;u&#210;&#195;&#198;¶-m]A§vT«&#198;•&#180;&#186;v›&#214;&#161;¬R"‰&#163;«&#196;z&#188;&#227;}&#221;G&#255;&#202;&#189;?u^&#163;x–_3*‹&#225;”&#238;©,eR:•“&#253;<w&#217;&#196;)¶§@&#240;&#249;B/&#236;b}&#179;Š&#212;&#202;&#178;&#252;'V;”O&#238;‚x&#222;&#204;fsEmI&#236;g“Rr&#246;g&#241;&#216;d~Š&#211;&#189;&#242;ž µwf >&#211;w&#163;3v &#194;(&#184;qX0!«H&#199;a &#222;QUS+U‚&#211;&”_&#212;&&#221;—ƒ_&#193;(Kžo&#195;&#188;b˜j‹&#235;&#209;&#245;”‡i–®Œ“&#238;±Za3¤q&#161;~¶T&#200;(1C&#219;&#201; –&#201;—&#214;%<®*)D†R&#243;s$*&#242;µxk&#254;-&#206;y&#194;u&#254;Š&#214;&#204;&#189;&#190;&#248;S&#216;H&#246;&#186;~‰&#233;@&#192;€&#161;Ÿ+B&#197;’&#246;>&#178;@<&#226;*=>¶&#220;&#237;%&#240;¤‹&#255;g[L&#215;&#228;&#247;zœ&#234;oS&l[&#195;&#212;x^¦&#196;§&#196;±&#253;{&#209;V&#192;C4G`z3Ÿk&#223;&#252;&#250;¶&#247;W&#247;œ^&#215;§&#223; •*&#232;“&#253;WUŽ¤¦©&#238;šJ&#193;/e&#191;Ÿjž\Žµ&#193;&#168;&#190;&#178;8&#244;&#193;@%‚&#245;P&#248;&#185;&#168;$ZRW&#207;&#238;®"j,&#248;—T0a&#226;€R{Uƒ &#238;mQ/cZi1&#222;˜&#232;&#212;^&#196;:%&#193;p&#194;&#184; &#178;&#191;&#168;&#232;xtJ&#168;> &#170;™`&#197;k&#225;'J&#243;&#229;.T&#192;Š]RX&#190;9Ž/&#238;Z&#189;,&#221;š1&#217;‚I~&#165;G‘y&#178;u
Zq]‘®g&#203;h_&#212;&#231;†v
&#213;&#249;SD &#239; °©&#163;&#252;a"O¶ •¤C&#215;&#219;&#191;W&#253;&#254;&#237;&#206;&#222;,H&#240;&#220;$&#213;‰"Yju&#196;
‰‚›C&#225;&#200;{&#242;›&#222;†&#233;&#195;f±2c&&#229;’&#247;€&#248;P®ƒH &#255;‚2~U®‚a&#241;&#210;&#203;
&#221;URt&#202;b!)W”&#238;4&#162;qa0»‚µ&#196;m·%&#165;‡s &#209;&#233;†|>“HFaA—„&#217; {&#195;av&#231;CSh&#206;&#245;aDX&#190;›ƒK&#168;&#168;&#192;(-“o&#209;&#218;G&#212;¤k “0&#252;&#192;·&#254;;&#250;t^œ’Q•ž¬J&#244;e&#224;h}{&#234;
Ulx–KjŒ&#231;y©&#161;,.S&#219;DZ%b.–Š€&#216;2u[%&#234;&#219;e_&#238;¶&#218;›¶&#222;&#242;TY‘ˆ„&#219;&#207;f&#189;-—&#210;”&#242;œW*‚&#180;@± ‚&#240;BŒ‚&#255;C&#228;&#204;-&#216;&#255;„&#199;&#211;&#165;B$&#197;&#251;G&#208;~&#191;&#254;®K&#188;CKd[7‡ˆ&#175;Ig¦&#199;A†ˆ&#252;k&#205;%%&#225;“±¬&#198;I«&#237;¤&#229;q„&#199;’§‘&#211;n™&#170;Q{c&#161;&#215;; &#189;k‹·&#208;Y$n‹&#214;-„&#161;R&#191;z}&#245;¤s„&#191;&#189;KƒZS”r…&#231;“&#212;&#170;”U&#170;&#192;`BT"&#168;o&#228;c&#225;$F&#254;&#253;@z&#161;&#238;xK&#189;±§&#251;n&#219;&#188;&#232;J˜&#188;L&#212;[Y&#220;•
 &#255;&#212;@&#217;ž&#237;&#184;· G°Ÿ&#222;WV&#192;qs&#203;’g&#163;&#200;“&#184;&#201;&#197;k&#211;&#240;•&#179;&#205;&#225;ši&#202;»<ED"&#227;!bv™j.+&#241; "”I|=&#222;[bc‰«
felix_cat
19-11-2008, 06:07
это скорее всего проблемы с питанием, как у вас винт подключен?
xebra
14-12-2008, 18:05
Всем доброе время суток.
Зашел сегодня на роутер, посмотрел мимолетом логи и офигел...
В логе куча записей такого типа:


Dec 9 17:19:47 dropbear[11252]: login attempt for nonexistent user from ::ffff:221.130.200.122:33654
Dec 9 17:19:48 dropbear[11252]: exit before auth: Disconnect received

Dec 9 17:22:02 dropbear[11281]: Child connection from ::ffff:221.130.200.122:36690
Dec 9 17:22:05 dropbear[11281]: bad password attempt for 'admin' from ::ffff:221.130.200.122:36690

Кроме 221.130.200.122 в логах фигурируют следующие ip:
219.142.114.254
125.75.232.29
219.232.236.132

Судя по доступной информации (https://isc.incidents.org/ipinfo.html?ip=219.232.236.132), эти ip принадлежат китайским провайдерам.

Вопросы:
1. Что это означает? Насколь я понимаю, кто-то пытается залогиниться по ssh на мой роутер?
2. Нужно ли о чем-то сейчас беспокоиться? Чем это грозит?
3. Как от этого избавиться?
DfDf
14-12-2008, 18:13
Ну ломают... Ну dropbear честно обороняется... :)
Можете поставить фильтры на эти ip - до dropbear'а дело не дойдет.

А общедоступная информация и тут есть: https://www.nic.ru/whois/ ;)
kir-g
14-12-2008, 19:05
загляните сюда http://wl500g.info/showpost.php?p=69964&postcount=63
alexuz1977
16-12-2008, 23:13
Всем доброй ночи

Проблема:
Помогите разобраться почему наблюдаются такие логи и соответственно блочатся некоторые соединения к клиенту DC++ на роутере

Что имеем:
wl500gp_v1/прошивка от Олега (настройки по большей части дефолтовые)
внешняя сетка PPPoE, выдается адрес типа 10.25.1.142
внутри стандартно комп (LAN) с ноутом (wifi)

Ситуевина:
У всех, включая роутер, стоят DC клиенты (microdc и strong-и соответственно). Хаб стоит на стороне провайдера. Проброс портов сделал - на компе и ноуте с DC проблем нет. На роутере microdc в принципе раздает, но постоянно вижу в логах, что роутер блочит некоторых юзеров. Выглядит это так:

Dec 16 20:25:16 kernel: DROP IN=ppp0 OUT= MAC= SRC=10.25.4.24 DST=10.25.1.142 LEN=52 TOS=0x00 PREC=0x00 TTL=127 ID=55333 DF PROTO=TCP SPT=1104 DPT=4898 SEQ=2363910644 ACK=0 WINDOW=65535 RES=0x00 SYN URGP=0 OPT (020405820103030301010402)

4898 - мой порт microdc на роутере
Логи все время аналогичные. Какой-то специфики у заблоченных юзеров не нашел, одинаково успешно пропускаются и блочатся как активные так и пассивные DC клиенты. Диапазон адресов также произвольный (10.25.1.xxx, 10.25.2.xxx, 10.25.3.xxx, 10.25.4.xxx, статические ip-адреса) - может пропустить может заблочить.

Кто-нибудь знает в чем дело?

Заранее спасибо всем пожелавшим помочь :-)
alexuz1977
17-12-2008, 20:31
Народ, ну неужто никто не знает ?
DfDf
17-12-2008, 20:57
Internet Firewall - Basic Config
Enable DoS protection - что стоит? Попробуйте в No если стояло в Yes.
alexuz1977
17-12-2008, 21:21
Internet Firewall - Basic Config
Enable DoS protection - что стоит? Попробуйте в No если стояло в Yes.

No - как стояло по дефолту, так и не менял
Power
17-12-2008, 21:51
Кто-нибудь знает в чем дело?


Покажите вывод команды


iptables -L -nv
alexuz1977
18-12-2008, 19:48
iptables -L -nv

много буков. результат приатачил :-)
Power
19-12-2008, 00:26
iptables -L -nv

много буков. результат приатачил :-)

Так у вас порт 4898 не открыт (таблица INPUT) для входящих на роутер соединений, вот они и блокируются.
alexuz1977
19-12-2008, 20:07
Так у вас порт 4898 не открыт (таблица INPUT) для входящих на роутер соединений, вот они и блокируются.

но блокируются ведь далеко не все соединения. Если этот порт закрыт, как же вообще кто-то ко мне попадает?
Power
20-12-2008, 03:07
но блокируются ведь далеко не все соединения. Если этот порт закрыт, как же вообще кто-то ко мне попадает?
Я сказал как есть, честно. Попробуйте открыть порт (в post-firewall) :


iptables -I INPUT 5 -p tcp -m tcp --syn --dport 4898 -j ACCEPT

# если нужно ещё и udp порт открыть:
iptables -I INPUT 6 -p udp -m udp --dport номер_udp_порта -j ACCEPT

Если это решит проблему - замечательно. Остальное же (почему не всех блокирует) - это уже тонкости работы протокола DC и к роутеру это не относится.
alexuz1977
22-12-2008, 20:59
Я сказал как есть, честно. Попробуйте открыть порт (в post-firewall) :


Спасибо, видимо действительно помогло. Как добавил эти правила, вот уж пару дней как в логах нет ничего :-)
Pavlik-jugend
23-12-2008, 20:17
Собственно сабж, роутер первой версии этим не сыплется, а у второго всё вот это вылезает. Не пойму есть причины волноваться?

(WL500gP V2 прошивка Олега 1.9.2.7-10 (2008-03-30), по проводу подключены ПК и игровая приставка PS3, по вай-фаю ноут + usb принтер)

Jan 1 03:00:11 PPPoE: connect to ISP
Dec 23 21:49:33 ntp client: Synchronizing time with time.nist.gov pool.ntp.org ...
Dec 23 21:49:34 kernel: sda : READ CAPACITY failed.
Dec 23 21:49:34 kernel: sda : status = 1, message = 00, host = 0, driver = 08
Dec 23 21:49:34 kernel: Current sd00:00: sns = 70 2
Dec 23 21:49:34 kernel: ASC=3a ASCQ= 0
Dec 23 21:49:34 kernel: Raw sense data:0x70 0x00 0x02 0x00 0x00 0x00 0x00 0x0a 0x00 0x00 0x00 0x00 0x3a 0x00 0x00 0x00 0x00 0x00
Dec 23 21:49:34 kernel: sda : block size assumed to be 512 bytes, disk size 1GB.
Dec 23 21:49:34 kernel: sda: test WP failed, assume Write Enabled
Dec 23 21:49:34 kernel: /dev/scsi/host0/bus0/target0/lun0: I/O error: dev 08:00, sector 0
Dec 23 21:49:34 kernel: I/O error: dev 08:00, sector 0
Dec 23 21:49:34 kernel: sda : READ CAPACITY failed.
Dec 23 21:49:34 kernel: sda : status = 1, message = 00, host = 0, driver = 08
Dec 23 21:49:34 kernel: Current sd00:00: sns = 70 2
Dec 23 21:49:34 kernel: ASC=3a ASCQ= 0
Dec 23 21:49:34 kernel: Raw sense data:0x70 0x00 0x02 0x00 0x00 0x00 0x00 0x0a 0x00 0x00 0x00 0x00 0x3a 0x00 0x00 0x00 0x00 0x00
Dec 23 21:49:34 kernel: sda : block size assumed to be 512 bytes, disk size 1GB.
Dec 23 21:49:34 kernel: sda: test WP failed, assume Write Enabled
Dec 23 21:49:34 kernel: /dev/scsi/host0/bus0/target0/lun0: I/O error: dev 08:00, sector 0
Dec 23 21:49:34 kernel: I/O error: dev 08:00, sector 0
Dec 23 21:49:34 kernel: unable to read partition table
Dec 23 21:49:34 kernel: I/O error: dev 08:00, sector 0
Dec 23 21:49:40 dnsmasq[75]: DHCPREQUEST(br0) 192.168.1.4 00:21:5d:54:c0:6a
Dec 23 21:49:40 dnsmasq[75]: DHCPACK(br0) 192.168.1.4 00:21:5d:54:c0:6a
Dec 23 22:01:28 kernel: printer.c: usblp0 Device ID string [101/max 1552]='MFG:EPSON;CMD:ESCPL2,BDC,D4,ESCPR1;MDL:Stylus Photo RX520;CLS:PRINTER;DES:EPSON Stylus Photo RX520;'
Dec 23 22:01:28 kernel: printer.c: Parsing USBLPID...
Dec 23 22:20:42 kernel: printer.c: usblp0 Device ID string [101/max 1552]='MFG:EPSON;CMD:ESCPL2,BDC,D4,ESCPR1;MDL:Stylus Photo RX520;CLS:PRINTER;DES:EPSON Stylus Photo RX520;'
Dec 23 22:20:42 kernel: printer.c: Parsing USBLPID...
Dec 23 22:20:47 kernel: printer.c: usblp0 Device ID string [101/max 1552]='MFG:EPSON;CMD:ESCPL2,BDC,D4,ESCPR1;MDL:Stylus Photo RX520;CLS:PRINTER;DES:EPSON Stylus Photo RX520;'
Dec 23 22:20:47 kernel: printer.c: Parsing USBLPID...
Doublekey
29-12-2008, 12:10
А никто из многоуважаемых гуру не подскажет.
У меня в логе регулярно появляются следующие записи
Dec 29 14:06:45 dnsmasq[73]: DHCPINFORM(br0) 192.168.1.51 00:11:6b:36:19:8c
Dec 29 14:06:45 dnsmasq[73]: DHCPACK(br0) 192.168.1.51 00:11:6b:36:19:8c pc

Причем интервал стабилен. 1 пара, вторая пара через пять секунд третья пара через 20 минут.

PC это компьютер который подключен к LAN и соответственно его IP.

Вопрос в том, где бы настроить регулярность этих сообщений и в чем природа их регулярности.
Evgenii
29-12-2008, 12:27
Это обновление DNS... У меня ими весь лог забит :)
Doublekey
29-12-2008, 14:12
Это обновление DNS... У меня ими весь лог забит :)

А нафига оно каждые 20 минут обновляется? может его как то пореже сделать? Или еще как А то один и те же данные гонит понимаю если хоть менял бы адреса или еще что нить
DfDf
29-12-2008, 23:01
А нафига оно каждые 20 минут обновляется? может его как то пореже сделать? Или еще как А то один и те же данные гонит понимаю если хоть менял бы адреса или еще что нить

Это не DNS, а DHCP. Поставьте время выдачи адреса на закладке с настройками dhcp не 1200 (20 мин), а 86400 (сутки). А то у вас каждые 20 мин компы обновляют свои ИП, а вы это дело в логе и наблюдаете.
Doublekey
30-12-2008, 06:39
так все хрень в том что время аренды IP и стоит 86400 :-( В веб интерфейсе. специально проверял :-(
Но за наводку спасибо. Мож просто после скриптовой настройке DHCP-серверу уже плевать на веб-интерфейс.
Покопаюсь по конфигам
Corvin1975
06-01-2009, 13:58
В логе стали появляться практически каждую минуту следующие сообщения:


Jan 6 12:42:39 kernel: ipt_tcpmss_target: bad length (1396 bytes)
Jan 6 12:42:39 kernel: ipt_tcpmss_target: bad length (40 bytes)
Jan 6 12:43:18 kernel: ipt_tcpmss_target: bad length (1280 bytes)
Jan 6 12:44:22 kernel: ipt_tcpmss_target: bad length (1380 bytes)
Jan 6 12:44:22 kernel: ipt_tcpmss_target: bad length (40 bytes)
Jan 6 12:44:52 kernel: ipt_tcpmss_target: bad length (1496 bytes)
Jan 6 12:44:52 kernel: ipt_tcpmss_target: bad length (40 bytes)

Знает ли кто-нибудь, в чем причина? Машинка v2, прошивка 10. Если можно, отвечайте попроще, я чайник.
Power
06-01-2009, 21:59
Если попроще, то: не обращайте внимания.
Если нужно подробнее - в поиск, было уже.
Если хотите знать, кто шлёт такие пакеты, запустите, указав вместо $i имя интерфейса, например vlan1


tcpdump -i $i -nlptttt -c 20 '(tcp[tcpflags] = tcp-syn) and ((ip[0] & 0xf) * 4 + (tcp[12] & 0xf0) / 4 < ip[2:2])' > /tmp/bad-length-packets.log 2>&1 &

оно соберёт первые 20 таких пакетов в файл /tmp/bad-length-packets.log
Corvin1975
06-01-2009, 23:27
Все, что я хочу знать - не является ли это ошибкой с моей стороны, то есть внутри прошивки роутера до WAN. Если нет, а я теперь буду думать, что нет, то и проблема исчезла. :)
Alx1m1K
08-01-2009, 22:47
Извиняюсь, что поднимаю старую тему, но у меня тоже аналогичный лог.

Jan 9 00:22:11 pppd[105]: read /dev/ppp: Value too large for defined data type
Подобные сообщения появляются в большом количестве при активной закачке торрентов (~350-450 КБ/с). Если же оставить только раздачу с аналогичными скоростями, то ничего крамольного не происходит :confused:
По
cat /proc/net/ip_conntrack | wc -l
выводит в среднем 1500 соединений.
При одновременной раздаче и закачке загрузка процессом pptp около 80 процентов, только при раздаче ~45%
Пробовал ставить mtu 1300 - не помогло..
Роутер WL-500gP v1, прошивка 1.9.2.7-10 от Олега. Сделаны начальные настройки из этой темы (http://wl500g.info/showthread.php?t=3171), сменен маскарадинг на SNAT.
Буду признателен любым мыслям по данной проблеме :) Конфиги, если будет нужно, выложу.
Accept2
11-01-2009, 11:48
Добрый день всем.Установил на свой Asus WL 500GP2 торрент качалку из темы " Простая настройка роутера до торрентов", все работает, доволен. Но возник такой вопрос- поскольку в Линуксе не силен, хотелось бы знать как разобраться в логе, какая строка что обозначает.Поиск не помог.Спасибо
Cd_spb
11-01-2009, 13:02
Я думаю, если Вы приложите сам лог, то будет проще Вам помочь. В противном случае - в google. :)
ale_xb
12-01-2009, 20:10
я тоже решил продолжить тему со своим логом. Судя по нему, где-то что-то сбоит. К сожалению, я не силен в Linux. Знатоки, подскажите, пожалуйста, где копать и что подкрутить.
Собственно лог:

Jan 12 10:52:39 dropbear[1560]: Failed listening on '22': Error listening: Address already in use
Jan 12 10:52:39 dropbear[1560]: premature exit: No listening ports available.
Jan 12 10:52:41 kernel: Unable to handle kernel paging request at virtual address 000000f4, epc == c00f8598, ra == c00fb82c
Jan 12 10:52:41 kernel: Oops in fault.c::do_page_fault, line 192:
Jan 12 10:52:41 kernel: $0 : 00000000 10009c00 c00f8598 ffffffea 00000000 0000000f 10051012 00000100
Jan 12 10:52:41 kernel: $8 : 00000000 00000000 80036940 00000003 2aaa8238 2ab9e4a8 00000000 00000000
Jan 12 10:52:41 kernel: $16: 10051012 00000000 0000000f 10051012 817deac0 909091c0 00000000 00000005
Jan 12 10:52:41 kernel: $24: 00000000 2abfd1e0 81466000 81467e78 00000000 c00fb82c
Jan 12 10:52:41 kernel: Hi : 00000382
Jan 12 10:52:41 kernel: Lo : 00001b07
Jan 12 10:52:41 kernel: epc : c00f8598 Tainted: P
Jan 12 10:52:41 kernel: Status: 10009c03
Jan 12 10:52:41 kernel: Cause : 00000008
Jan 12 10:52:41 kernel: Process infosvr (pid: 1554, stackpage=81466000)
Jan 12 10:52:41 kernel: Stack: 817deac0 817976e0 00000001 8002fe3c 8004412c 80044248 0000000e
Jan 12 10:52:41 kernel: 00030002 80030454 00000000 10051012 909091f8 8142a000 10005e00 c011e2e0
Jan 12 10:52:41 kernel: 810e5000 00000000 000001b6 00000000 810e5000 81467ed4 00000000 00000000
Jan 12 10:52:41 kernel: 00000000 00000100 817976c0 ffffffea 10005e00 7fff7078 7fff7578 00000001
Jan 12 10:52:41 kernel: 800369f8 ffffffe7 7fff6f60 800483a0 80035ec8 00000000 7fff79e0 2ac4aa4a
Jan 12 10:52:41 kernel: 2ac4aa48 ...
Jan 12 10:52:41 kernel: Call Trace: [<8002fe3c>] [<8004412c>] [<80044248>] [<80030454>] [<c011e2e0>]
Jan 12 10:52:41 kernel: [<800369f8>] [<800483a0>] [<80035ec8>] [<800085c4>] [<800085c4>]
Jan 12 10:52:41 kernel:
Jan 12 10:52:41 kernel: Code: 2407ffea 03e00008 00e01021 <8c8300f4> 90620004
Power
12-01-2009, 20:22
я тоже решил продолжить тему со своим логом. Судя по нему, где-то что-то сбоит. К сожалению, я не силен в Linux. Знатоки, подскажите, пожалуйста, где копать и что подкрутить.


Ну, для начала, у вас dropbear не может запуститься из-за того, что кто-то уже висит на 22 порту (скорее всего, другой dropbear, запущенный ранее). Вы его каким образом (откуда) запускаете?
ale_xb
13-01-2009, 09:18
dropbear у меня запускается скриптом /usr/local/sbin/post-boot :


#!/bin/sh
# Start SSH demon
dropbear
#
# Default gateway
GW=10.149.8.253
# Static routing table
route add -net 192.168.0.0/16 gw $GW
route add -net 10.0.0.0/8 gw $GW
...

и далее вся таблица маршрутов.

Запускается нормально, т.е. я без проблем захожу на роутер с помощью PuTTY.
В с писке процессов я действительно вижу две записи, касающиеся dropbear (PID 115 и 3107):

PID Uid VmSize Stat Command
1 user123 656 S /sbin/init
2 user123 SW [keventd]
3 user123 SWN [ksoftirqd_CPU0]
4 user123 SW [kswapd]
5 user123 SW [bdflush]
6 user123 SW [kupdated]
7 user123 SW [mtdblockd]
115 user123 484 S dropbear
2943 user123 396 S httpd vlan1
2944 nobody 496 S [dnsmasq]
2950 user123 560 S nas /tmp/nas.lan.conf /tmp/nas.lan.pid lan
2953 user123 408 S syslogd -m 0 -O /tmp/syslog.log -S -l 7
2954 user123 364 S klogd
2955 user123 SW [khubd]
2965 user123 260 S p9100d -f /dev/usb/lp0 0
2976 user123 364 S /usr/sbin/udpxy -a br0 -m vlan1 -p 81
2977 user123 328 S /usr/sbin/igmpproxy -c /etc/igmpproxy.conf
2979 user123 756 S pppd file /tmp/ppp/options.wan0
2983 user123 436 S watchdog
2989 user123 344 S ntp
3093 user123 464 S sh -c /usr/sbin/pptp --idle-wait 0 ppp.lan -
3094 user123 424 S pptp: GRE-to-PPP gateway on /dev/ptmx --sync
3097 user123 428 S pptp: call manager for 10.150.5.10 --sync
3106 user123 444 S upnp -D -L br0 -W ppp0
3107 user123 728 S dropbear
3108 user123 548 S -sh
3113 user123 396 R ps
это нормально или где-то у меня запускается лишний dropbear? Если лишний, где еще искать его запуск?

Еще обратил внимание, что строки
Jan 12 10:52:39 dropbear[1560]: Failed listening on '22': Error listening: Address already in use
Jan 12 10:52:39 dropbear[1560]: premature exit: No listening ports available
периодически повторяются в логе с постепенным увеличением PID
vectorm
13-01-2009, 10:40
dropbear у меня запускается скриптом /usr/local/sbin/post-boot :
Еще обратил внимание, что строки
Jan 12 10:52:39 dropbear[1560]: Failed listening on '22': Error listening: Address already in use
Jan 12 10:52:39 dropbear[1560]: premature exit: No listening ports available
периодически повторяются в логе с постепенным увеличением PID
проверьте все post- и pre- скипты.
Power
13-01-2009, 10:45
В с писке процессов я действительно вижу две записи, касающиеся dropbear (PID 115 и 3107):

это нормально или где-то у меня запускается лишний dropbear? Если лишний, где еще искать его запуск?

Еще обратил внимание, что строки
Jan 12 10:52:39 dropbear[1560]: Failed listening on '22': Error listening: Address already in use
Jan 12 10:52:39 dropbear[1560]: premature exit: No listening ports available
периодически повторяются в логе с постепенным увеличением PID

Два - это нормально. Один сервер и по одному на каждого подключенного клиента.
Но периодически у вас пытается запуститься ещё один сервер, и это уже ненормально. Откуда он запускается? Ну это вам лучше знать. Возможно, из post-mount или post-firewall или по расписанию кроном, или ещё откуда... Ищите, вы же его конфигурировали.
ale_xb
13-01-2009, 13:39
внимательно проверил все скрипты post-... и pre-...
dropbear прописан в единственном месте, как указывал выше, cron у меня не установлен вовсе, т.е. я уверен, что никакой прописанный мной скрипт больше не запускает dropbear. Если это и происходит, то без моего ведома и желания.
Во вложении Log1.txt - это лог сразу после reboot (вкладываю, т.к. пост получается слишком длинный). Ничего плохого в нем не вижу, может вы подскажите.

и список процессов (брал из web-интерфейса, поэтому, как вы и сказали dropbear присутствует только один раз в качестве сервера).

PID Uid VmSize Stat Command
1 user123 644 S /sbin/init
2 user123 SW [keventd]
3 user123 SWN [ksoftirqd_CPU0]
4 user123 SW [kswapd]
5 user123 SW [bdflush]
6 user123 SW [kupdated]
7 user123 SW [mtdblockd]
59 user123 440 S httpd vlan1
61 user123 408 S syslogd -m 0 -O /tmp/syslog.log -S -l 7
65 user123 364 S klogd
67 nobody 472 S [dnsmasq]
69 user123 520 S nas /tmp/nas.lan.conf /tmp/nas.lan.pid lan
72 user123 SW [khubd]
80 user123 276 S lpd
82 user123 260 S p9100d -f /dev/usb/lp0 0
93 user123 364 S /usr/sbin/udpxy -a br0 -m vlan1 -p 81
94 user123 328 S /usr/sbin/igmpproxy -c /etc/igmpproxy.conf
96 user123 756 S pppd file /tmp/ppp/options.wan0
99 user123 312 S infosvr br0
100 user123 448 S watchdog
102 user123 344 S ntp
108 user123 464 S sh -c /usr/sbin/pptp --idle-wait 0 ppp.lan -
109 user123 424 S pptp: GRE-to-PPP gateway on /dev/ptmx --sync
114 user123 468 S dropbear
196 user123 428 S pptp: call manager for 10.150.5.22 --sync
211 user123 444 S upnp -D -L br0 -W ppp0
214 user123 464 S sh -c ps > /tmp/syscmd.log 2>&1
215 user123 396 R ps

а приведенный мною выше лог с ошибками dropbear и что-там с памятью появляется через некоторое время (часы) стабильной работы и затем периодически повторяется. Также заметил, что при этом исчезают прописанные мной в post-boot маршруты, т.е. я их не вижу в web-интерфейсе, хотя сразу после загрузки с ними все в порядке.
Может, все же проблемы в чем-то другом, а не в dropbear (он лишь следствие)? Где посоветуете копать? Может, у меня просто железо сбоит? Доп.пакетов никаких у меня не установлено, из внешних устройств - только принтер. Клиенты - ПК по кабелю и ноут + КПК через Wi-Fi.
Power
13-01-2009, 18:57
а приведенный мною выше лог с ошибками dropbear и что-там с памятью появляется через некоторое время (часы) стабильной работы и затем периодически повторяется.

Может, выложите тогда лог полностью, после того как эти ошибки пару раз повторятся?
И ещё: у вас, случайно, оперативная память свободная на девайсе не кончается? Проверьте на всякий случай командой free.



Также заметил, что при этом исчезают прописанные мной в post-boot маршруты, т.е. я их не вижу в web-интерфейсе, хотя сразу после загрузки с ними все в порядке.


Предположение: а эти маршруты точно на правильный интерфейс вешаются? Мало ли, к моменту выполнения post-boot уже может подняться ppp0, а явно интерфейс у вас не указан.


---
Но, в целом, конечно, странно. Ещё меня смущают большие значения PID из поста #10 (http://wl500g.info/showpost.php?p=127442&postcount=10) (dropbear - 115, а за ним сразу 2943).
Alx1m1K
13-01-2009, 19:07
А по моей проблеме даже нет идей? Логи забиваются этой ерундой, не знаю что и делать:confused:
Подскажите пожалуйста
ale_xb
13-01-2009, 19:43
Может, выложите тогда лог полностью, после того как эти ошибки пару раз повторятся?
И ещё: у вас, случайно, оперативная память свободная на девайсе не кончается? Проверьте на всякий случай командой free.

Предположение: а эти маршруты точно на правильный интерфейс вешаются? Мало ли, к моменту выполнения post-boot уже может подняться ppp0, а явно интерфейс у вас не указан.
Прежде всего, спасибо вам за желание помочь!
Лог обязательно выложу, как только снова обнаружу ошибки.
памяти половина свободна (это на момент, когда никаких ошибок в логе нет):

total used free shared buffers
Mem: 30164 15236 14928 0 1908
Swap: 0 0 0
Total: 30164 15236 14928
А как проверить правильность интерфейса маршрутов?

Вот уже получил и лог с ошибками (во вложении).
Не перегружает ли у меня периодически самопроизвольно роутер некоторые процессы? Обратил внимание на повторяющиеся строки

Jan 13 23:42:01 System log daemon exiting.
Jan 13 23:42:03 syslogd started: BusyBox v1.1.3
Jan 13 23:42:03 kernel: klogd started: BusyBox v1.1.3 (2008.03.17-18:24+0000)
и далее очень похоже на процедуру первоначальной загрузки.
Power
14-01-2009, 11:57
памяти половина свободна (это на момент, когда никаких ошибок в логе нет):

Проверьте ещё, когда есть ошибки.



А как проверить правильность интерфейса маршрутов?

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



Вот уже получил и лог с ошибками (во вложении).
Не перегружает ли у меня периодически самопроизвольно роутер некоторые процессы?

У меня впечатление, что роутер перезагружает часть ядра, некоторые процессы а также интерфейсы. Перезагрузка интерфейсов может быть причиной сброса маршрутов. Вот цитата части вашего лога


Jan 13 23:42:00 kernel: usb.c: deregistering driver usb-storage
Jan 13 23:42:00 kernel: usb.c: deregistering driver usblp
Jan 13 23:42:00 kernel: ehci_hcd 01:03.2: remove state 3
Jan 13 23:42:00 kernel: usb.c: USB disconnect on device 01:03.2-0 address 1
Jan 13 23:42:00 kernel: usb.c: USB bus 3 deregistered
Jan 13 23:42:00 kernel: usb.c: USB disconnect on device 01:03.0-0 address 1
Jan 13 23:42:01 kernel: usb.c: USB bus 1 deregistered
Jan 13 23:42:01 kernel: usb.c: USB disconnect on device 01:03.1-0 address 1
Jan 13 23:42:01 kernel: usb.c: USB bus 2 deregistered
Jan 13 23:42:01 kernel: usb.c: deregistering driver usbdevfs
Jan 13 23:42:01 kernel: usb.c: deregistering driver hub
Jan 13 23:42:01 kernel: Kernel log daemon exiting.
Jan 13 23:42:01 System log daemon exiting.
Jan 13 23:42:03 syslogd started: BusyBox v1.1.3
Jan 13 23:42:03 kernel: klogd started: BusyBox v1.1.3 (2008.03.17-18:24+0000)
Jan 13 23:42:03 kernel: br0: port 2(eth1) entering disabled state
Jan 13 23:42:03 kernel: br0: port 1(vlan0) entering disabled state
Jan 13 23:42:03 kernel: br0: port 1(vlan0) entering disabled state
Jan 13 23:42:03 kernel: device vlan0 left promiscuous mode
Jan 13 23:42:03 kernel: br0: port 2(eth1) entering disabled state
Jan 13 23:42:03 kernel: device eth1 left promiscuous mode
Jan 13 23:42:03 kernel: device eth1 entered promiscuous mode
Jan 13 23:42:03 kernel: br0: port 2(eth1) entering listening state
Jan 13 23:42:03 kernel: br0: port 1(vlan0) entering listening state
Jan 13 23:42:03 kernel: br0: port 2(eth1) entering learning state
Jan 13 23:42:03 kernel: br0: port 1(vlan0) entering learning state
Jan 13 23:42:03 kernel: br0: port 2(eth1) entering forwarding state
Jan 13 23:42:03 kernel: br0: topology change detected, propagating
Jan 13 23:42:03 kernel: br0: port 1(vlan0) entering forwarding state
Jan 13 23:42:03 kernel: br0: topology change detected, propagating
Jan 13 23:42:03 kernel: usb.c: registered new driver usbdevfs
Jan 13 23:42:03 kernel: usb.c: registered new driver hub
< далее идут ещё строки, связанные с инициализацией устройств и стартом процессов, в частности, post-boot(!) >


Видно, что сначала выгружаются драйверы usb, потом убивается и вновь стартует syslogd, потом переинициализируются интерфейсы, загружаются драйверы, а потом опять выполняется post-boot и запускаются некоторые другие процессы. Короче говоря, роутер колбасит, и я понятия не имею о причине. Тут нужны эксперты, понимающие что-то в этой прошивке.
ale_xb
14-01-2009, 13:49
память, проверил. Свободной - практически без изменений:

total used free shared buffers
Mem: 30164 15580 14584 0 1916
Swap: 0 0 0
Total: 30164 15580 14584
Конечно, это не в момент ошибки (как это можно поймать?), но в любом случае после того, как эта ошибка несколько раз проявилась в логе.

По команде route -n все маршруты в последнем столбце имеют интерфейс vlan1 кроме пары строк:

192.168.1.0 0.0.0.0 255.255.255.0 U 0 0 0 br0
127.0.0.0 0.0.0.0 255.0.0.0 U 0 0 0 lo
0.0.0.0 212.1.254.61 0.0.0.0 UG 0 0 0 ppp0
lo и ppp0, как я понимаю, так и должно быть (loopback и VPN PPPTP с адресом, получаемым от DHCP провайдера), а br0 - (как я понимаю, это моя домашняя локалка) тоже верно?
На данный момент, роутер после перезагрузки живет чуть более суток. Таблица маршрутов пока еще жива, в логе указанная ошибка ("жалобы" на паямть) присутствует 4 раза. При этом частичная перезагрузка (драйверов/интерфейсов/syslog/...) произошла 6 раз. Да, наверное, надо просить помощи у гуру прошивки. В любом случае спасибо вам еще раз!
vectorm
15-01-2009, 09:25
Вот уже получил и лог с ошибками (во вложении).
Не перегружает ли у меня периодически самопроизвольно роутер некоторые процессы? Обратил внимание на повторяющиеся строки

Jan 13 23:42:01 System log daemon exiting.
Jan 13 23:42:03 syslogd started: BusyBox v1.1.3
Jan 13 23:42:03 kernel: klogd started: BusyBox v1.1.3 (2008.03.17-18:24+0000)
и далее очень похоже на процедуру первоначальной загрузки.
Такое впечатление, что у Вас напряжение сети скачет, либо БП роутера проседает - либо проблема в напряжении сети, либо роутер бракованный.
ale_xb
15-01-2009, 14:48
Такое впечатление, что у Вас напряжение сети скачет, либо БП роутера проседает - либо проблема в напряжении сети, либо роутер бракованный.
хм-м. Попробую пособирать статистику. ИБП нет, только фильтр, типа Пилот, но сбоев в каком-либо другом оборудовании никогда не наблюдал. Напряжение в розетке померял вечером, оно в норме - 118 В. Проверю еще и в другое время суток.
Что касается брака, именно это и хочется проверить. Есть ли какой тест, хотя бы для памяти? Как им воспользоваться?
gekko_g
15-01-2009, 20:59
Jan 25 23:16:02 kernel: Adding Swap: 500920k swap-space (priority -1)
Jan 25 23:16:02 /opt/sbin/cron[152]: (CRON) STARTUP (V5.0)
Jan 25 23:16:03 smbd[166]: [2009/01/25 23:16:03, 0] lib/pidfile.cidfile_create(86)
Jan 25 23:16:03 smbd[166]: ERROR: smbd is already running. File /var/lock/smbd.pid exists and process id 142 is running.
Jan 25 23:16:14 ntp client: Synchronizing time with time.nist.gov ...
Jan 25 23:17:01 /opt/sbin/cron[207]: (admin) CMD (/opt/bin/run-parts /opt/etc/cron.1min)
Jan 25 23:18:01 /opt/sbin/cron[214]: (admin) CMD (/opt/bin/run-parts /opt/etc/cron.1min)
Jan 25 23:19:01 /opt/sbin/cron[221]: (admin) CMD (/opt/bin/run-parts /opt/etc/cron.1min)
Jan 25 23:20:01 /opt/sbin/cron[229]: (admin) CMD (/opt/bin/run-parts /opt/etc/cron.5mins )
Jan 25 23:20:01 /opt/sbin/cron[230]: (admin) CMD (/opt/bin/run-parts /opt/etc/cron.1min)
Jan 25 23:21:01 /opt/sbin/cron[240]: (admin) CMD (/opt/bin/run-parts /opt/etc/cron.1min)
Jan 25 23:22:01 /opt/sbin/cron[247]: (admin) CMD (/opt/bin/run-parts /opt/etc/cron.1min)
Jan 25 23:23:01 /opt/sbin/cron[254]: (admin) CMD (/opt/bin/run-parts /opt/etc/cron.1min)
Jan 25 23:24:01 /opt/sbin/cron[261]: (admin) CMD (/opt/bin/run-parts /opt/etc/cron.1min)
Jan 25 23:25:01 /opt/sbin/cron[269]: (admin) CMD (/opt/bin/run-parts /opt/etc/cron.5mins )
Jan 25 23:25:01 /opt/sbin/cron[270]: (admin) CMD (/opt/bin/run-parts /opt/etc/cron.1min)
Jan 25 23:26:01 /opt/sbin/cron[280]: (admin) CMD (/opt/bin/run-parts /opt/etc/cron.1min)
Jan 25 23:27:01 /opt/sbin/cron[287]: (admin) CMD (/opt/bin/run-parts /opt/etc/cron.1min)
Jan 25 23:28:01 /opt/sbin/cron[294]: (admin) CMD (/opt/bin/run-parts /opt/etc/cron.1min)
Jan 25 23:29:01 /opt/sbin/cron[301]: (admin) CMD (/opt/bin/run-parts /opt/etc/cron.1min)
vectorm
16-01-2009, 07:12
что это и с чем связанно


Jan 15 23:34:14 kernel: ACCEPT IN=br0 OUT= MAC=00:1d:60:46:90:51:00:13:02:18:90:4e:08:00 SRC=192.168.1.184 DST=192.168.1.2 LEN=66 TOS=0x00 PREC=0x00 TTL=128 ID=30977 PROTO=UDP SPT=64564 DPT=53 LEN=46
Jan 15 23:34:14 kernel: ACCEPT IN=br0 OUT= MAC=00:1d:60:46:90:51:00:13:02:18:90:4e:08:00 SRC=192.168.1.184 DST=192.168.1.2 LEN=60 TOS=0x00 PREC=0x00 TTL=128 ID=31063 PROTO=UDP SPT=63589 DPT=53 LEN=40
Jan 15 23:34:17 kernel: ACCEPT IN=lo OUT= MAC=00:00:00:00:00:00:00:00:00:00:00:00:08:00 SRC=127.0.0.1 DST=127.0.0.1 LEN=60 TOS=0x00 PREC=0x00 TTL=64 ID=29080 DF PROTO=TCP SPT=1974 DPT=80 SEQ=3076016333 ACK=0 WINDOW=16396 RES=0x00 SYN URGP=0 OPT (020440
Jan 15 23:34:18 kernel: ACCEPT IN=br0 OUT= MAC= SRC=192.168.1.2 DST=239.255.255.250 LEN=331 TOS=0x00 PREC=0x00 TTL=4 ID=0 DF PROTO=UDP SPT=1900 DPT=1900 LEN=311
Jan 15 23:34:18 kernel: ACCEPT IN=br0 OUT= MAC= SRC=192.168.1.2 DST=239.255.255.250 LEN=340 TOS=0x00 PREC=0x00 TTL=4 ID=0 DF PROTO=UDP SPT=1900 DPT=1900 LEN=320
Jan 15 23:34:18 kernel: ACCEPT IN=br0 OUT= MAC= SRC=192.168.1.2 DST=239.255.255.250 LEN=403 TOS=0x00 PREC=0x00 TTL=4 ID=0 DF PROTO=UDP SPT=1900 DPT=1900 LEN=383
Jan 15 23:34:18 kernel: ACCEPT IN=br0 OUT= MAC= SRC=192.168.1.2 DST=239.255.255.250 LEN=395 TOS=0x00 PREC=0x00 TTL=4 ID=0 DF PROTO=UDP SPT=1900 DPT=1900 LEN=375
Выключить LOGDROP в фильтрации WAN to LAN в веб морде.
ale_xb
16-01-2009, 09:40
проверил напряжение в розетке днем - 221-223 В, даже с включенным в эту же розетку утюгом (2,2 КВт) проседает лишь до 210 В, т.е. оно стабильно и в любом случае в пределах нормы (+/-10%). Мощные потребители в других помещениях еще меньше влияют на напряжение (1-3 В проседает всего). Роутер на данный момент после перезагрузки работает полтора суток. Ошибок памяти в логе сейчас нет, но странные строки все равно периодически повторяются:

Jan 15 19:06:28 dropbear[1010]: Failed listening on '22': Error listening: Address already in use
Jan 15 19:06:28 dropbear[1010]: premature exit: No listening ports available. и такие (это я вовсе не знаю, о чем речь):

Jan 15 19:06:27 syslog: ERRO: There must be at least 2 Vif's where one is upstream.
Где все же посоветуете копать? И, кстати, можно как-то временно перевести лог на более подробный вывод, либо ведутся ли еще какие-то логи (того же dropbear) и где их искать?
Power
16-01-2009, 14:14
Я бы сказал, что, для начала, это не logdrop, а logaccept; а чтобы избавиться от этого, надо изменить на странице Internet Firewall - Basic Config параметр Logged packets type: на значение None.
sonice
16-01-2009, 17:08
А у меня такие строчки в логе, что бы это значило?


Jan 16 08:50:37 kernel: br0: neighbour 8000.00:13:10:17:f7:c0 lost on port 2(eth1)
Jan 16 08:50:37 kernel: br0: topology change detected, propagating
Jan 16 08:50:57 kernel: br0: retransmitting tcn bpdu
MaFIA
23-01-2009, 18:23
сегодня случайно заметил в логах такое

Jan 23 18:18:14 dropbear[291]: Child connection from ::ffff:114.200.199.14:34954
Jan 23 18:18:17 dropbear[291]: login attempt for nonexistent user from ::ffff:114.200.199.14:34954
Jan 23 18:18:18 dropbear[291]: exit before auth: Disconnect received
Jan 23 18:18:18 dropbear[292]: Child connection from ::ffff:114.200.199.14:40983
Jan 23 18:18:23 dropbear[292]: login attempt for nonexistent user from ::ffff:114.200.199.14:40983
Jan 23 18:18:24 dropbear[292]: exit before auth: Disconnect received
Jan 23 18:18:24 dropbear[293]: Child connection from ::ffff:114.200.199.14:48386
Jan 23 18:18:28 dropbear[293]: login attempt for nonexistent user from ::ffff:114.200.199.14:48386
Jan 23 18:18:29 dropbear[293]: exit before auth: Disconnect received
Jan 23 18:18:30 dropbear[294]: Child connection from ::ffff:114.200.199.14:33859
Jan 23 18:18:33 dropbear[294]: login attempt for nonexistent user from ::ffff:114.200.199.14:33859
Jan 23 18:18:34 dropbear[294]: exit before auth: Disconnect received
Jan 23 18:18:37 dropbear[295]: Child connection from ::ffff:114.200.199.14:39797
Jan 23 18:18:40 dropbear[295]: login attempt for nonexistent user from ::ffff:114.200.199.14:39797
Jan 23 18:18:41 dropbear[295]: exit before auth: Disconnect received
Jan 23 18:18:42 dropbear[296]: Child connection from ::ffff:114.200.199.14:48761
Jan 23 18:18:46 dropbear[296]: login attempt for nonexistent user from ::ffff:114.200.199.14:48761
Jan 23 18:18:47 dropbear[296]: exit before auth: Disconnect received
Jan 23 18:18:48 dropbear[297]: Child connection from ::ffff:114.200.199.14:55425
Jan 23 18:18:52 dropbear[297]: login attempt for nonexistent user from ::ffff:114.200.199.14:55425
Jan 23 18:18:53 dropbear[297]: exit before auth: Disconnect received
Jan 23 18:18:53 dropbear[298]: Child connection from ::ffff:114.200.199.14:35112
Jan 23 18:18:59 dropbear[298]: login attempt for nonexistent user from ::ffff:114.200.199.14:35112
Jan 23 18:19:00 dropbear[298]: exit before auth: Disconnect received
Jan 23 18:19:00 dropbear[299]: Child connection from ::ffff:114.200.199.14:43447
Jan 23 18:19:03 dropbear[299]: login attempt for nonexistent user from ::ffff:114.200.199.14:43447
Jan 23 18:19:04 dropbear[299]: exit before auth: Disconnect received
Jan 23 18:19:05 dropbear[300]: Child connection from ::ffff:114.200.199.14:48646
Jan 23 18:19:08 dropbear[300]: login attempt for nonexistent user from ::ffff:114.200.199.14:48646
Jan 23 18:19:09 dropbear[300]: exit before auth: Disconnect received
Jan 23 18:19:09 dropbear[301]: Child connection from ::ffff:114.200.199.14:54271
Jan 23 18:19:12 dropbear[301]: login attempt for nonexistent user from ::ffff:114.200.199.14:54271
Jan 23 18:19:14 dropbear[301]: exit before auth: Disconnect received
Jan 23 18:19:14 dropbear[302]: Child connection from ::ffff:114.200.199.14:59922
Jan 23 18:19:18 dropbear[302]: login attempt for nonexistent user from ::ffff:114.200.199.14:59922
Jan 23 18:19:19 dropbear[302]: exit before auth: Disconnect received
Jan 23 18:19:23 dropbear[303]: Child connection from ::ffff:114.200.199.14:37701
Jan 23 18:19:27 dropbear[303]: login attempt for nonexistent user from ::ffff:114.200.199.14:37701
Jan 23 18:19:28 dropbear[303]: exit before auth: Disconnect received
Jan 23 18:19:28 dropbear[304]: Child connection from ::ffff:114.200.199.14:47864
Jan 23 18:19:33 dropbear[304]: login attempt for nonexistent user from ::ffff:114.200.199.14:47864
Jan 23 18:19:34 dropbear[304]: exit before auth: Disconnect received
Jan 23 18:19:34 dropbear[305]: Child connection from ::ffff:114.200.199.14:55530
Jan 23 18:19:40 dropbear[305]: login attempt for nonexistent user from ::ffff:114.200.199.14:55530
Jan 23 18:19:41 dropbear[305]: exit before auth: Disconnect received
Jan 23 18:19:41 dropbear[306]: Child connection from ::ffff:114.200.199.14:35397
Jan 23 18:19:44 dropbear[306]: login attempt for nonexistent user from ::ffff:114.200.199.14:35397
Jan 23 18:19:45 dropbear[306]: exit before auth: Disconnect received
Jan 23 18:19:46 dropbear[307]: Child connection from ::ffff:114.200.199.14:41052
Jan 23 18:19:49 dropbear[307]: login attempt for nonexistent user from ::ffff:114.200.199.14:41052
Jan 23 18:19:50 dropbear[307]: exit before auth: Disconnect received
Jan 23 18:19:50 dropbear[308]: Child connection from ::ffff:114.200.199.14:45579
Jan 23 18:19:55 dropbear[308]: login attempt for nonexistent user from ::ffff:114.200.199.14:45579
Jan 23 18:19:56 dropbear[308]: exit before auth: Disconnect received
Jan 23 18:19:56 dropbear[309]: Child connection from ::ffff:114.200.199.14:52918
Jan 23 18:19:59 dropbear[309]: login attempt for nonexistent user from ::ffff:114.200.199.14:52918
Jan 23 18:20:00 dropbear[309]: exit before auth: Disconnect received
Jan 23 18:20:01 dropbear[310]: Child connection from ::ffff:114.200.199.14:57391
Jan 23 18:20:05 dropbear[310]: login attempt for nonexistent user from ::ffff:114.200.199.14:57391
Jan 23 18:20:06 dropbear[310]: exit before auth: Disconnect received
Jan 23 18:20:07 dropbear[311]: Child connection from ::ffff:114.200.199.14:36196
Jan 23 18:20:10 dropbear[311]: login attempt for nonexistent user from ::ffff:114.200.199.14:36196
Jan 23 18:20:11 dropbear[311]: exit before auth: Disconnect received
Jan 23 18:20:14 dropbear[312]: Child connection from ::ffff:114.200.199.14:41605
Jan 23 18:20:17 dropbear[312]: login attempt for nonexistent user from ::ffff:114.200.199.14:41605
Jan 23 18:20:18 dropbear[312]: exit before auth: Disconnect received
Jan 23 18:20:19 dropbear[313]: Child connection from ::ffff:114.200.199.14:49011
Jan 23 18:20:22 dropbear[313]: login attempt for nonexistent user from ::ffff:114.200.199.14:49011
Jan 23 18:20:23 dropbear[313]: exit before auth: Disconnect received
Jan 23 18:20:23 dropbear[314]: Child connection from ::ffff:114.200.199.14:54827
Jan 23 18:20:26 dropbear[314]: login attempt for nonexistent user from ::ffff:114.200.199.14:54827
Jan 23 18:20:27 dropbear[314]: exit before auth: Disconnect received
Jan 23 18:20:28 dropbear[315]: Child connection from ::ffff:114.200.199.14:60572
Jan 23 18:20:31 dropbear[315]: login attempt for nonexistent user from ::ffff:114.200.199.14:60572
Jan 23 18:20:32 dropbear[315]: exit before auth: Disconnect received
Jan 23 18:20:33 dropbear[316]: Child connection from ::ffff:114.200.199.14:37071
Jan 23 18:20:37 dropbear[316]: login attempt for nonexistent user from ::ffff:114.200.199.14:37071
Jan 23 18:20:38 dropbear[316]: exit before auth: Disconnect received
Jan 23 18:20:38 dropbear[317]: Child connection from ::ffff:114.200.199.14:44332
Jan 23 18:20:42 dropbear[317]: login attempt for nonexistent user from ::ffff:114.200.199.14:44332
Jan 23 18:20:43 dropbear[317]: exit before auth: Disconnect received
Jan 23 18:20:43 dropbear[318]: Child connection from ::ffff:114.200.199.14:50128
Jan 23 18:20:46 dropbear[318]: login attempt for nonexistent user from ::ffff:114.200.199.14:50128
Jan 23 18:20:47 dropbear[318]: exit before auth: Disconnect received
Jan 23 18:20:48 dropbear[319]: Child connection from ::ffff:114.200.199.14:54811
Jan 23 18:20:51 dropbear[319]: login attempt for nonexistent user from ::ffff:114.200.199.14:54811
Jan 23 18:20:52 dropbear[319]: exit before auth: Disconnect received
Jan 23 18:20:52 dropbear[320]: Child connection from ::ffff:114.200.199.14:60555
Jan 23 18:20:58 dropbear[320]: login attempt for nonexistent user from ::ffff:114.200.199.14:60555
Jan 23 18:20:59 dropbear[320]: exit before auth: Disconnect received
Jan 23 18:20:59 dropbear[321]: Child connection from ::ffff:114.200.199.14:40926
Jan 23 18:21:03 dropbear[321]: login attempt for nonexistent user from ::ffff:114.200.199.14:40926
Jan 23 18:21:04 dropbear[321]: exit before auth: Disconnect received
Jan 23 18:21:05 dropbear[322]: Child connection from ::ffff:114.200.199.14:46855
Jan 23 18:21:08 dropbear[322]: login attempt for nonexistent user from ::ffff:114.200.199.14:46855
Jan 23 18:21:09 dropbear[322]: exit before auth: Disconnect received
Jan 23 18:21:09 dropbear[323]: Child connection from ::ffff:114.200.199.14:52554
Jan 23 18:21:12 dropbear[323]: login attempt for nonexistent user from ::ffff:114.200.199.14:52554
Jan 23 18:21:13 dropbear[323]: exit before auth: Disconnect received


Это чего меня ломать пытались или что это?
Заранее спасибо.
azhur
23-01-2009, 19:24
Какая-то редиска с адреса 114.200.199.14 пыталась брутфорсить телнет.
Но даже логин не угадала. :)
DafT
23-01-2009, 19:42
советую почитать темы про iptables и настроить вход на ssh/telnet тока по тем адресам которые вы можете реально использовать, остальных блочить наглухо.
smi
23-01-2009, 22:21
Вообще то достаточно поднимать dropbear на нестандартном порту, т.е. любом свободном > 1024 выбранным случайно. Меня после этого не беспокоят :)
sonice
24-01-2009, 00:39
А у меня такие строчки в логе, что бы это значило?

http://wl500g.info/showpost.php?p=127985&postcount=22
gekko_g
25-01-2009, 20:36
спасибо !!!!
но есть новая проблемма, В ШАПКЕ темы
vectorm
26-01-2009, 07:08
Jan 25 23:16:03 smbd[166]: [2009/01/25 23:16:03, 0] lib/pidfile.cidfile_create(86)
Jan 25 23:16:03 smbd[166]: ERROR: smbd is already running. File /var/lock/smbd.pid exists and process id 142 is running.

И где здесь проблема?
Выключите Самбу в веб морде, раз руками ее запускаете.
ale_xb
27-01-2009, 20:13
Итак, отвечаю сам себе, может, кому пригодится (мой пост № 8 в этой теме и далее):

Как выяснилось, гадили настройки DC++ на одном из ПК в домашней локалке! Пока не настроил Port Forward на двух ПК в локалке клиенты DC++ работали в пассивном режиме. Затем злой юзер на одной из машин без моего ведома поменял на "как было раньше" - активный режим с указанием в качестве IP адреса, который выдается провайдером, т.е. того самого, что сейчас висит на WAN роутера. Как только DC++ с такими "настройками" выходила в сеть и пыталась что-то скачать роутер начинало колбасить со всеми вытекающими последствиями (см.приведенные выше логи).
Возможно это баг прошивки роутера, а может, он в принципе в такой ситуации не может адекватно без сбоев реагировать, но хотелось бы, чтобы никакие некорректные настройки сетевого ПО на ПК в локалке не могли довести роутер до такого невменяемого состояния.
Сейчас на роутере и соответственно на обоих ПК в локалке на клиентах DC++ сделан проброс портов. Все работает без единого сбоя и перезагрузки 10-й день.
nihil
07-02-2009, 16:07
Здравствуйте. Еще раз прошу помощи. Было отключение напряжения в доме. Но всё мое оборудование было на бесперебойнике. После включения напряжения интернет Корбины пропал. В логах следующее:

Jan 1 03:00:07 kernel: vlan1: Setting MAC address to 00 1b fc 06 4d c5.
Jan 1 03:00:07 kernel: VLAN (vlan1): Underlying device (eth0) has same MAC, not checking promiscious mode.
Jan 1 03:00:07 udhcpc[92]: udhcpc (v0.9.9-pre) started
Jan 1 03:00:07 dhcp client: deconfig: lease is lost
Jan 1 03:00:11 udhcpc[92]: Lease of 10.48.91.236 obtained, lease time 604800
Jan 1 03:00:12 dnsmasq[69]: read /etc/hosts - 5 addresses
Jan 1 03:00:12 dnsmasq[69]: read /etc/ethers - 1 addresses
Jan 1 03:00:12 dnsmasq[69]: reading /tmp/resolv.conf
Jan 1 03:00:12 dnsmasq[69]: using nameserver 85.21.192.3#53
Jan 1 03:00:12 dnsmasq[69]: using nameserver 213.234.192.8#53
Jan 1 03:00:12 dhcp client: bound IP : 10.48.91.236 from 10.48.88.1
Jan 1 03:07:54 wan: connected manually
Jan 1 03:07:54 udhcpc[103]: Unicasting a release of 10.48.91.236 to 83.102.233.202
Jan 1 03:07:55 dhcp client: deconfig: lease is lost
Jan 1 03:07:55 udhcpc[103]: Entering released state
Jan 1 03:07:55 udhcpc[103]: Received SIGTERM
Последние четыре строчки после попытки подключения вручную.
Техподдержка К. как обычно валит всё на роутер...
nihil
07-02-2009, 19:58
Проблема решилась. Корбина сменила l2tp сервер. Теперь tp.corbina.net
avk
07-02-2009, 20:26
Проблема решилась. Корбина сменила l2tp сервер. Теперь tp.corbina.net

Это не есть причина. Попробуйте:

ping l2tp.corbina.net
и
tp.corbina.net
Работают оба имени.

Лог говорит о неполучени роутером IP-адреса.

dhcp client: deconfig: lease is lost
Ваше роутер запитан от бесперебойника. А оборудование провайдера?..
nihil
07-02-2009, 22:32
http://homenet.corbina.net/index.php?act=announce&f=4&id=143

Да, я пинговал l2tp.corbina.net, когда роутер не мог получить адрес. Пинг был нормальный. Но l2tp.corbina.net не выдавал IP.

Потом я прочитал эту "новость" и сменил адрес. Сразу всё заработало.
Likhaex
11-02-2009, 23:44
Откуда такая цифра в трафике?
1473946432

Feb 11 19:02:41 pptp[743]: pppd may have shutdown, see pppd log
Feb 11 19:03:26 pppd[97]: Starting link
Feb 11 19:03:26 pptp[756]: route_add: not adding existing route
Feb 11 19:03:26 pppd[97]: Serial connection established.
Feb 11 19:03:26 pppd[97]: Connect: ppp0 <--> /dev/pts/0
Feb 11 19:03:30 PPTP: connect to ISP
Feb 11 19:22:27 ntp client: Synchronizing time with time.nist.gov ...
Feb 11 20:03:03 pppd[97]: No response to 6 echo-requests
Feb 11 20:03:03 pppd[97]: Serial link appears to be disconnected.
Feb 11 20:03:03 PPTP: Disconnected
Feb 11 20:03:09 pppd[97]: Connection terminated.
Feb 11 20:03:09 pppd[97]: Connect time 59.7 minutes.
Feb 11 20:03:09 pppd[97]: Sent 1345378188 bytes, received 1473946432 bytes.
Feb 11 20:03:09 pptp[756]: short read (-1): Input/output error
Feb 11 20:03:09 pptp[756]: pppd may have shutdown, see pppd log
Feb 11 20:04:06 pppd[97]: Starting link
Feb 11 20:04:07 pptp[778]: route_add: not adding existing route
Feb 11 20:04:07 pppd[97]: Serial connection established.
Feb 11 20:04:07 pppd[97]: Connect: ppp0 <--> /dev/pts/0
Feb 11 20:04:13 PPTP: connect to ISP
Feb 11 21:22:29 ntp client: Synchronizing time with time.nist.gov ...
Feb 11 22:31:30 vsftpd[802]: CONNECT: Client "192.168.10.100"
Feb 11 22:31:31 vsftpd[801]: [ad_min_] OK LOGIN: Client "192.168.10.100"
Morze
12-02-2009, 03:52
А что удивляет ? Это всеголиш ~1,4 гига. За час на хороших скоростях и поболее скачать можно.
Likhaex
12-02-2009, 23:52
Удивляет что объем скаченного ~ объему закачаного.
А включен был только ФТП без права на запись.
CharlyX
25-02-2009, 17:25
Вот иногда рвёт соединение PPTP
В логах пишет:


Feb 25 16:30:39 pppd[93]: LCP terminated by peer
Feb 25 16:30:39 PPTP: Disconnected
Feb 25 16:30:39 pppd[93]: Child process /tmp/ppp/ip-down (pid 176) terminated with signal 11
Feb 25 16:30:42 pppd[93]: Connection terminated.
Feb 25 16:30:42 pppd[93]: Connect time 67.6 minutes.
Feb 25 16:30:42 pppd[93]: Sent 284 bytes, received 575 bytes.
Feb 25 16:30:43 pptp[157]: short read (-1): Input/output error
Feb 25 16:30:43 pptp[157]: pppd may have shutdown, see pppd log

Что бы это могло значить?
userouter
25-02-2009, 18:43
а такого нету случайно в логе?

Jan 28 03:43:15 pppd[288]: No response to 6 echo-requests
Jan 28 03:43:15 pppd[288]: Serial link appears to be disconnected.
CharlyX
25-02-2009, 19:09
а такого нету случайно в логе?

Jan 28 03:43:15 pppd[288]: No response to 6 echo-requests
Jan 28 03:43:15 pppd[288]: Serial link appears to be disconnected.

Нет это всё что есть. Потом идёт опять соединение.
lly
25-02-2009, 19:14
Вы бы хоть версию прошивки и модель роутера написали для разнообразия что-ли :rolleyes:
CharlyX
26-02-2009, 05:06
Вы бы хоть версию прошивки и модель роутера написали для разнообразия что-ли :rolleyes:

Asus WL500GP V2
Прошивка что Олега (10я), что официальная. Всё равно одно и тоже.

Похоже разъеденяется, когда никто не подсоеденён, т.е. ни по ЛАН, ни ПО Вайфай.

Idle Disconnect Time in seconds(option): 0

Странно.
vectorm
26-02-2009, 20:45
"Иногда" - это какая периодичность?
Рандомно - это нормально для роутерного Линукса, похоже на заточенность pptp серверов провайдеров под Винду.
ramile
27-02-2009, 03:00
Подскажите, что не так, если в логах постоянно присудствуют строки вида:

Feb 27 02:10:20 pptp[149]: accepting packet 9324 (expecting 9323, lost or reordered)
Feb 27 02:10:20 pptp[149]: accepting packet 9333 (expecting 9327, lost or reordered)
Feb 27 02:10:20 pptp[149]: accepting packet 9336 (expecting 9334, lost or reordered)
Feb 27 02:10:20 pptp[149]: accepting packet 9338 (expecting 9337, lost or reordered)
Feb 27 02:10:20 pptp[149]: accepting packet 9340 (expecting 9339, lost or reordered)
Feb 27 02:10:20 pptp[149]: accepting packet 9344 (expecting 9343, lost or reordered)
Feb 27 02:10:20 pptp[149]: accepting packet 9347 (expecting 9346, lost or reordered)
Feb 27 02:13:56 pptp[149]: accepting packet 10587 (expecting 10586, lost or reordered)
Feb 27 02:13:56 pptp[149]: discarding duplicate or old packet 10586 (expecting 10590)
CharlyX
27-02-2009, 04:54
"Иногда" - это какая периодичность?
Рандомно - это нормально для роутерного Линукса, похоже на заточенность pptp серверов провайдеров под Винду.

в 99% идёт разрыв через
Feb 26 23:51:59 pppd[103]: Connect time 37.6 minutes.

Не понятно.
CharlyX
01-03-2009, 19:32
Как понял из тестирования. Разрывается соединение, только когда никто не подключен. Ровно через 37.5 минуты. Что это может быть? Настройки провайдера?
Oleg
01-03-2009, 19:43
Как понял из тестирования. Разрывается соединение, только когда никто не подключен. Ровно через 37.5 минуты. Что это может быть? Настройки провайдера?
Ага, похоже на то. И число круглое - 2250 секунд.
userouter
02-03-2009, 11:52
аналогично только rtorrent вместо mc вызвал ошибку как я понимаю
из-за чего ? только самба встроенная на роутере работает, из шар


Mar 2 13:02:06 kernel: Unhandled kernel unaligned access in unaligned.c::emulate_load_store_insn, line 487:
Mar 2 13:02:06 kernel: $0 : 00000000 1000d800 00000000 00000001 306eafce 00000000 00000000 00000206
Mar 2 13:02:06 kernel: $8 : 00000030 801976a0 8778d39d 5fd3a97b 801c3278 8157de48 00000000 00000000
Mar 2 13:02:06 kernel: $16: 00000001 8114fe00 8064ee28 8064eefc 8064ede0 8064eff8 00000000 00000610
Mar 2 13:02:06 kernel: $24: 00000002 80b1258c 8157c000 8157dcf8 00000206 800fad44
Mar 2 13:02:06 kernel: Hi : 00000000
Mar 2 13:02:06 kernel: Lo : 00000000
Mar 2 13:02:06 kernel: epc : 8003051c Tainted: P
Mar 2 13:02:06 kernel: Status: 1000d803
Mar 2 13:02:06 kernel: Cause : 00000010
Mar 2 13:02:06 kernel: Process rtorrent (pid: 243, stackpage=8157c000)
Mar 2 13:02:06 kernel: Stack: 00000000 00000816 800163f4 80100984 800fad44 8189ae60 00000000
Mar 2 13:02:06 kernel: 8106ea00 00000000 801e9080 8114fe00 0000034a 800fad74 8157de68 800160cc
Mar 2 13:02:06 kernel: 800d8f14 8114fe00 0000034a 8114fe00 800faf10 8064ede0 8064eff8 00000000
Mar 2 13:02:06 kernel: 00000816 8114fe00 801289b0 802448a0 8125e9e0 802448a0 8125e9e0 802448a0
Mar 2 13:02:06 kernel: c000c2c4 005788a0 00000206 ffffff7a 00000000 00000000 00000001 8064ee10
Mar 2 13:02:06 kernel: 00000001 ...
Mar 2 13:02:06 kernel: Call Trace: [<800163f4>] [<80100984>] [<800fad44>] [<800fad74>] [<800160cc>]
Mar 2 13:02:06 kernel: [<800d8f14>] [<800faf10>] [<801289b0>] [<c000c2c4>] [<80148e1c>] [<800f7130>]
Mar 2 13:02:06 kernel: [<800f81b0>] [<801a120c>] [<80030550>] [<800156d8>] [<80049610>] [<80009130>]
Mar 2 13:02:06 kernel: [<80009178>] [<800f823c>] [<800085c4>] [<800085c4>]
Mar 2 13:02:06 kernel:
Mar 2 13:02:06 kernel: Code: 30420001 14400009 24030001 <c0870014> 00e31023 e0820014 1040fffc 00e31023 0000000f
vectorm
02-03-2009, 17:32
аналогично только rtorrent вместо mc вызвал ошибку как я понимаю
из-за чего ? только самба встроенная на роутере работает, из шар

Проверяйте диск на ошибки.
Graftsman
17-03-2009, 07:43
У меня тоже подобная ерунда:
Mar 17 04:22:53 smbd[642]: [2009/03/17 04:22:53, 0] lib/util_sock.c:read_socket_data(477)
Mar 17 04:22:53 smbd[642]: read_socket_data: recv failure for 4. Error = Connection reset by peer
Хотя я в это время спал:eek:.
Компьютер был выключен.
Это что, попытка взлома?
ramile
26-03-2009, 19:11
Что бы это значило? В логах повторяется периодически:
kernel: HTB: quantum of class 10012 is big. Consider r2q change.
Где что поравить?
alpcrimea
26-03-2009, 19:13
Что-то ты с нарезкой канала намутил