Сборка 13 - падает ядро при старте радиуса.
Сборка 13 - падает ядро при старте радиуса.
Сборка 13, RH7.3
Обновил, ядро стартует нормально.
Как только стартую радиус - ядро отваливается. В логах пусто.
Пришлось откатить все назад. Час простоя. (((
Есть мысли ?
Обновил, ядро стартует нормально.
Как только стартую радиус - ядро отваливается. В логах пусто.
Пришлось откатить все назад. Час простоя. (((
Есть мысли ?
Да, все делал окуратно.
Меня смущает вот это :
Warn : Jul 10 11:54:44 RPCFMan: <liburfa-graph:5.1.10-013-linux>: Verification failed
Info : Jul 10 11:54:44 RPCFMan: <liburfa-graph:5.1.10-013-linux>: Fetching license...
ERROR : Jul 10 11:54:44 RPCServer@0.0.0.0: <liburfa-graph:5.1.10-013-linux>: Unable to sign request: Request not found
...
Info : Jul 10 11:54:44 UTMCtx: License verification for <liburfa-radius:5.1.10-001-linux>
Warn : Jul 10 11:54:44 UTMCtx: License verification failed: no public key found
Warn : Jul 10 11:54:44 RPCFMan: <liburfa-radius:5.1.10-001-linux>: Verification failed
Info : Jul 10 11:54:44 RPCFMan: <liburfa-radius:5.1.10-001-linux>: Fetching license...
ERROR : Jul 10 11:54:44 RPCServer@0.0.0.0: <liburfa-radius:5.1.10-001-linux>: Unable to sign request: Request not found
-
liburfa-radius:5.1.10-001
Меня смущает вот это :
Warn : Jul 10 11:54:44 RPCFMan: <liburfa-graph:5.1.10-013-linux>: Verification failed
Info : Jul 10 11:54:44 RPCFMan: <liburfa-graph:5.1.10-013-linux>: Fetching license...
ERROR : Jul 10 11:54:44 RPCServer@0.0.0.0: <liburfa-graph:5.1.10-013-linux>: Unable to sign request: Request not found
...
Info : Jul 10 11:54:44 UTMCtx: License verification for <liburfa-radius:5.1.10-001-linux>
Warn : Jul 10 11:54:44 UTMCtx: License verification failed: no public key found
Warn : Jul 10 11:54:44 RPCFMan: <liburfa-radius:5.1.10-001-linux>: Verification failed
Info : Jul 10 11:54:44 RPCFMan: <liburfa-radius:5.1.10-001-linux>: Fetching license...
ERROR : Jul 10 11:54:44 RPCServer@0.0.0.0: <liburfa-radius:5.1.10-001-linux>: Unable to sign request: Request not found
-
liburfa-radius:5.1.10-001
Вот заметил аналогичную ситуацию на сборке для RH9
debug.log:
PS: Явленые было разовым. Пока во всяком случае
debug.log:
Код: Выделить всё
?Trace : Jul 13 17:20:47 Radius: init_session_log: Ready to run hook
?Trace : Jul 13 17:20:47 Radius: init_session_log: Done..
?Debug : Jul 13 17:20:47 RPCConn<radius@127.0.0.1>: Call finished...
Info : Jul 13 17:20:47 RPCServer@0.0.0.0: Client connecting: 127.0.0.1:37094
Info : Jul 13 17:20:47 RPCConn: Connection from: 127.0.0.1:37094
Notice: Jul 13 17:20:47 RPCConn: Service <radius@127.0.0.1> is connecting
?Debug : Jul 13 17:20:47 UTM5 DBA: Group: -2 from 1
Info : Jul 13 17:20:47 RPCConn<radius@127.0.0.1>: Access granted to <radius@127.0.0.1> (UID: -2)
?Debug : Jul 13 17:20:47 RPCConn<radius@127.0.0.1>: Call: 0x1003
?Debug : Jul 13 17:20:47 Radius: Changing upload RPC stream
?Debug : Jul 13 17:20:47 Rehash: Rehash messages listener added...
Info : Jul 13 17:27:58 UTM5 Logger: New `?Debug : ' stream: /netup/utm5/log/debug.log
Если повториться просьба провести такую же операцию с gdb как описано выше. Данные перешлите для анализа.Nick писал(а):Вот заметил аналогичную ситуацию на сборке для RH9
debug.log:PS: Явленые было разовым. Пока во всяком случаеКод: Выделить всё
?Trace : Jul 13 17:20:47 Radius: init_session_log: Ready to run hook ?Trace : Jul 13 17:20:47 Radius: init_session_log: Done.. ?Debug : Jul 13 17:20:47 RPCConn<radius@127.0.0.1>: Call finished... Info : Jul 13 17:20:47 RPCServer@0.0.0.0: Client connecting: 127.0.0.1:37094 Info : Jul 13 17:20:47 RPCConn: Connection from: 127.0.0.1:37094 Notice: Jul 13 17:20:47 RPCConn: Service <radius@127.0.0.1> is connecting ?Debug : Jul 13 17:20:47 UTM5 DBA: Group: -2 from 1 Info : Jul 13 17:20:47 RPCConn<radius@127.0.0.1>: Access granted to <radius@127.0.0.1> (UID: -2) ?Debug : Jul 13 17:20:47 RPCConn<radius@127.0.0.1>: Call: 0x1003 ?Debug : Jul 13 17:20:47 Radius: Changing upload RPC stream ?Debug : Jul 13 17:20:47 Rehash: Rehash messages listener added... Info : Jul 13 17:27:58 UTM5 Logger: New `?Debug : ' stream: /netup/utm5/log/debug.log
теперь падает при старте ядра:
[root@server utm5]# gdb /netup/utm5/bin/utm5_core
GNU gdb Red Hat Linux (5.2.1-4)
Copyright 2002 Free Software Foundation, Inc.
GDB is free software, covered by the GNU General Public License, and you are
[root@server utm5]# gdb /netup/utm5/bin/utm5_core
Type "show copying" to see the conditions.
There is absolutely no warranty for GDB. Type "show warranty" for details.
This GDB was configured as "i386-redhat-linux"...
(no debugging symbols found)...
(gdb) r
Starting program: /netup/utm5/bin/utm5_core
[New Thread 8192 (LWP 26640)]
?Debug : Aug 02 16:36:42 Rehash: Rehash manager started
Notice: Aug 02 16:36:42 ModMap: Sub-Module 'rehash' inserted...
Notice: Aug 02 16:36:42 UTM5 Config: Processing config file: /netup/utm5/utm5.c
fg
Notice: Aug 02 16:36:42 UTM5 Config: Pid file found: /var/run/utm5_core.pid; Ov
erwriting
Notice: Aug 02 16:36:42 ModMap: Sub-Module 'config' inserted...
Notice: Aug 02 16:36:42 ModMap: Sub-Module 'logger' inserted...
[New Thread 16385 (LWP 26647)]
[New Thread 8194 (LWP 26648)]
[New Thread 16387 (LWP 26649)]
[New Thread 24580 (LWP 26650)]
[New Thread 32773 (LWP 26651)]
Program received signal SIGSEGV, Segmentation fault.
[Switching to Thread 8192 (LWP 26640)]
0x42079318 in strcmp () from /lib/i686/libc.so.6
(gdb)
critical.log:
empty
debug.log (last 16 rows):
Info : Aug 02 16:38:39 BusClassif: NF5 processor thread started
?Debug : Aug 02 16:38:39 BusPeriodic: BusPeriodic::rehash_periodic calling pthre
?Debug : Aug 02 16:38:39 BusMod: try to start busperidic
Info : Aug 02 16:38:39 BusPeriodic: BusPeriodic thread started.
?Debug : Aug 02 16:38:39 BusPeriodic: real_rehash start
?Debug : Aug 02 16:38:39 BusPeriodic: real_rehash finished
?Debug : Aug 02 16:38:39 BusPeriodic: 3321 events remain
?Debug : Aug 02 16:38:39 BusPeriodic: first event time_t 1112299200
?Debug : Aug 02 16:38:39 BusPeriodic: i am going to wait for -10687119 sec...
?Debug : Aug 02 16:38:39 BusPeriodic: Wait result:0
?Debug : Aug 02 16:38:39 BusPeriodic: periodic type block_start for 516
?Debug : Aug 02 16:38:39 DBCtx: SQL query: UPDATE periodic_service_links SET una
Notice: Aug 02 16:38:39 ModMap: Sub-Module 'nfbuffer' inserted...
Notice: Aug 02 16:38:39 ModMap: Sub-Module 'busmod' inserted...
Notice: Aug 02 16:38:39 ModMap: Sub-Module 'fw' inserted...
?Debug : Aug 02 16:38:39 DBCtx: SQL query: UPDATE periodic_service_links SET una
main.log (last 16 rows):
Info : Aug 02 16:38:37 UTM5 DBA: parsed 5.000000 notification border
Info : Aug 02 16:38:37 UTM5 DBA: block_recalc_abon = 0
Info : Aug 02 16:38:37 UTM5 DBA: block_recalc_prepaid = 0
Info : Aug 02 16:38:37 UTM5 DBA: default_vat_rate = 0.000000
Info : Aug 02 16:38:37 UTM5 DBA: check_abon_on_payment = 0
Notice: Aug 02 16:38:38 ModMap: Sub-Module 'dba' inserted...
Notice: Aug 02 16:38:38 DBAGiga: Opening Gigabase storage: /netup/utm5/db/iptra
Notice: Aug 02 16:38:38 ModMap: Sub-Module 'dba:giga' inserted...
Info : Aug 02 16:38:38 BusClassif: Created...
Info : Aug 02 16:38:39 BusLogic: Worker thread started.
Info : Aug 02 16:38:39 BusClassif: Periodic cleanup thread started.
Info : Aug 02 16:38:39 BusClassif: NF5 processor thread started
Info : Aug 02 16:38:39 BusPeriodic: BusPeriodic thread started.
Notice: Aug 02 16:38:39 ModMap: Sub-Module 'nfbuffer' inserted...
Notice: Aug 02 16:38:39 ModMap: Sub-Module 'busmod' inserted...
Notice: Aug 02 16:38:39 ModMap: Sub-Module 'fw' inserted...
[root@server utm5]# gdb /netup/utm5/bin/utm5_core
GNU gdb Red Hat Linux (5.2.1-4)
Copyright 2002 Free Software Foundation, Inc.
GDB is free software, covered by the GNU General Public License, and you are
[root@server utm5]# gdb /netup/utm5/bin/utm5_core
Type "show copying" to see the conditions.
There is absolutely no warranty for GDB. Type "show warranty" for details.
This GDB was configured as "i386-redhat-linux"...
(no debugging symbols found)...
(gdb) r
Starting program: /netup/utm5/bin/utm5_core
[New Thread 8192 (LWP 26640)]
?Debug : Aug 02 16:36:42 Rehash: Rehash manager started
Notice: Aug 02 16:36:42 ModMap: Sub-Module 'rehash' inserted...
Notice: Aug 02 16:36:42 UTM5 Config: Processing config file: /netup/utm5/utm5.c
fg
Notice: Aug 02 16:36:42 UTM5 Config: Pid file found: /var/run/utm5_core.pid; Ov
erwriting
Notice: Aug 02 16:36:42 ModMap: Sub-Module 'config' inserted...
Notice: Aug 02 16:36:42 ModMap: Sub-Module 'logger' inserted...
[New Thread 16385 (LWP 26647)]
[New Thread 8194 (LWP 26648)]
[New Thread 16387 (LWP 26649)]
[New Thread 24580 (LWP 26650)]
[New Thread 32773 (LWP 26651)]
Program received signal SIGSEGV, Segmentation fault.
[Switching to Thread 8192 (LWP 26640)]
0x42079318 in strcmp () from /lib/i686/libc.so.6
(gdb)
critical.log:
empty
debug.log (last 16 rows):
Info : Aug 02 16:38:39 BusClassif: NF5 processor thread started
?Debug : Aug 02 16:38:39 BusPeriodic: BusPeriodic::rehash_periodic calling pthre
?Debug : Aug 02 16:38:39 BusMod: try to start busperidic
Info : Aug 02 16:38:39 BusPeriodic: BusPeriodic thread started.
?Debug : Aug 02 16:38:39 BusPeriodic: real_rehash start
?Debug : Aug 02 16:38:39 BusPeriodic: real_rehash finished
?Debug : Aug 02 16:38:39 BusPeriodic: 3321 events remain
?Debug : Aug 02 16:38:39 BusPeriodic: first event time_t 1112299200
?Debug : Aug 02 16:38:39 BusPeriodic: i am going to wait for -10687119 sec...
?Debug : Aug 02 16:38:39 BusPeriodic: Wait result:0
?Debug : Aug 02 16:38:39 BusPeriodic: periodic type block_start for 516
?Debug : Aug 02 16:38:39 DBCtx: SQL query: UPDATE periodic_service_links SET una
Notice: Aug 02 16:38:39 ModMap: Sub-Module 'nfbuffer' inserted...
Notice: Aug 02 16:38:39 ModMap: Sub-Module 'busmod' inserted...
Notice: Aug 02 16:38:39 ModMap: Sub-Module 'fw' inserted...
?Debug : Aug 02 16:38:39 DBCtx: SQL query: UPDATE periodic_service_links SET una
main.log (last 16 rows):
Info : Aug 02 16:38:37 UTM5 DBA: parsed 5.000000 notification border
Info : Aug 02 16:38:37 UTM5 DBA: block_recalc_abon = 0
Info : Aug 02 16:38:37 UTM5 DBA: block_recalc_prepaid = 0
Info : Aug 02 16:38:37 UTM5 DBA: default_vat_rate = 0.000000
Info : Aug 02 16:38:37 UTM5 DBA: check_abon_on_payment = 0
Notice: Aug 02 16:38:38 ModMap: Sub-Module 'dba' inserted...
Notice: Aug 02 16:38:38 DBAGiga: Opening Gigabase storage: /netup/utm5/db/iptra
Notice: Aug 02 16:38:38 ModMap: Sub-Module 'dba:giga' inserted...
Info : Aug 02 16:38:38 BusClassif: Created...
Info : Aug 02 16:38:39 BusLogic: Worker thread started.
Info : Aug 02 16:38:39 BusClassif: Periodic cleanup thread started.
Info : Aug 02 16:38:39 BusClassif: NF5 processor thread started
Info : Aug 02 16:38:39 BusPeriodic: BusPeriodic thread started.
Notice: Aug 02 16:38:39 ModMap: Sub-Module 'nfbuffer' inserted...
Notice: Aug 02 16:38:39 ModMap: Sub-Module 'busmod' inserted...
Notice: Aug 02 16:38:39 ModMap: Sub-Module 'fw' inserted...