Стабильность работы биллинга

Технические вопросы по UTM 5.0

Насколько стабильно работает ваша биллинговая система, до появления сбоя:

не более 1 часа непрерывной работы
0
Голосов нет
не более 3 часов непрерывной работы
0
Голосов нет
не более 6 часов непрерывной работы
0
Голосов нет
не более 12 часов непрерывной работы
4
14%
не более 1 суток непрерывной работы
3
11%
не более 3 суток непрерывной работы
0
Голосов нет
не более 7 суток непрерывной работы
5
18%
не более 14 суток непрерывной работы
1
4%
не более 30 суток непрерывной работы
15
54%
 
Всего голосов: 28

PEBA
Сообщения: 15
Зарегистрирован: Вт май 06, 2008 22:44

Сообщение PEBA »

Вот ловлю момент зависания:

+------+------+-----------+------+---------+------+-------+------------------+
| Id | User | Host | db | Command | Time | State | Info |
+------+------+-----------+------+---------+------+-------+------------------+
| 9146 | root | localhost | UTM5 | Sleep | 132 | | |
| 9147 | root | localhost | UTM5 | Sleep | 1168 | | |
| 9148 | root | localhost | UTM5 | Sleep | 1168 | | |
| 9149 | root | localhost | UTM5 | Sleep | 465 | | |
| 9150 | root | localhost | UTM5 | Sleep | 375 | | |
| 9151 | root | localhost | UTM5 | Sleep | 1223 | | |
| 9152 | root | localhost | UTM5 | Sleep | 1223 | | |
| 9153 | root | localhost | UTM5 | Sleep | 1223 | | |
| 9154 | root | localhost | UTM5 | Sleep | 351 | | |
| 9155 | root | localhost | UTM5 | Sleep | 1223 | | |
| 9156 | root | localhost | UTM5 | Sleep | 1223 | | |
| 9157 | root | localhost | UTM5 | Sleep | 1220 | | |
| 9158 | root | localhost | UTM5 | Sleep | 1217 | | |
| 9159 | root | localhost | UTM5 | Sleep | 366 | | |
| 9160 | root | localhost | UTM5 | Sleep | 1209 | | |
| 9161 | root | localhost | UTM5 | Sleep | 381 | | |
| 9162 | root | localhost | UTM5 | Sleep | 1223 | | |
| 9163 | root | localhost | UTM5 | Sleep | 616 | | |
| 9164 | root | localhost | UTM5 | Sleep | 887 | | |
| 9165 | root | localhost | UTM5 | Sleep | 467 | | |
| 9166 | root | localhost | UTM5 | Sleep | 423 | | |
| 9167 | root | localhost | UTM5 | Sleep | 778 | | |
| 9168 | root | localhost | UTM5 | Sleep | 672 | | |
| 9169 | root | localhost | UTM5 | Sleep | 1216 | | |
| 9184 | root | localhost | | Query | 0 | | show processlist |
+------+------+-----------+------+---------+------+-------+------------------+


Вот что debug.log

?Debug : Май 10 10:05:07 2008 RPCConn<kniagnickaya@10.0.3.239>: Session closed...
Info : Май 10 10:05:07 2008 RPCServer@0.0.0.0: Client connecting: 10.0.0.6:2779
Info : Май 10 10:05:07 2008 RPCConn: Connection from: 10.0.0.6:2779
Info : Май 10 10:05:07 2008 RPCConn: Card user <init@10.0.0.6> is connecting
?Debug : Май 10 10:05:07 2008 DBA Groups: Group: -1 from 1
-Stats : Май 10 10:05:07 2008 DBA Groups: Stats: Uptime: 00:00:00. Events: 0; Errors: 0
Info : Май 10 10:05:07 2008 RPCConn<init@10.0.0.6>: Access granted to <init@10.0.0.6> (UID: -1)
?Debug : Май 10 10:05:07 2008 RPCConn<init@10.0.0.6>: Call: 0x2400 (rpcf_get_groups_list)
?Debug : Май 10 10:05:07 2008 RPCConn<init@10.0.0.6>: Real Call: 0x2400 (rpcf_get_groups_list)
?Debug : Май 10 10:05:07 2008 DBA:Ctx: Looking for free context
?Debug : Май 10 10:05:07 2008 DBCtx: SQL SELECT query: SELECT id, group_name FROM groups
?Debug : Май 10 10:05:07 2008 DBA:Ctx: Pushing back free context
-Stats : Май 10 10:05:07 2008 DBA Groups: Stats: Uptime: 00:00:00. Events: 0; Errors: 0
?Debug : Май 10 10:05:07 2008 RPCConn<init@10.0.0.6>: Call 0x2400 (rpcf_get_groups_list) finished...
?Debug : Май 10 10:05:07 2008 RPCConn<init@10.0.0.6>: Stream cleared
?Debug : Май 10 10:05:07 2008 RPCConn<init@10.0.0.6>: Call: 0x2001 (rpcf_get_users_list)
?Debug : Май 10 10:05:07 2008 RPCConn<init@10.0.0.6>: Real Call: 0x2001 (rpcf_get_users_list)
?Debug : Май 10 10:05:27 2008 FW@127.0.0.1: Ping reply received
Info : Май 10 10:05:31 2008 RPCServer@0.0.0.0: Client connecting: 127.0.0.1:45060
Info : Май 10 10:05:31 2008 RPCConn: Connection from: 127.0.0.1:45060
Notice: Май 10 10:05:31 2008 RPCConn: Service <web@127.0.0.1> is connecting
?Debug : Май 10 10:05:31 2008 RPCConn: Session restored for <kniagnickaya@10.0.3.239>
Info : Май 10 10:05:31 2008 RPCConn<kniagnickaya@10.0.3.239>: Access granted to <kniagnickaya@10.0.3.239> (UID: 736)
?Debug : Май 10 10:05:31 2008 RPCConn<kniagnickaya@10.0.3.239>: Call: 0xffffbfdd (__rpcs_user5_get_services)
?Debug : Май 10 10:05:31 2008 RPCConn<kniagnickaya@10.0.3.239>: Real Call: 0xffffbfdd (__rpcs_user5_get_services)
?Debug : Май 10 10:05:31 2008 RPCConn<kniagnickaya@10.0.3.239>: Call 0xffffbfdd (__rpcs_user5_get_services) finished...
?Debug : Май 10 10:05:31 2008 RPCConn<kniagnickaya@10.0.3.239>: Stream cleared
Info : Май 10 10:05:31 2008 RPCConn<kniagnickaya@10.0.3.239>: Connection terminated by peer
?Debug : Май 10 10:05:31 2008 RPCConn<kniagnickaya@10.0.3.239>: Session stored for UID 736 and IP ef03000a
?Debug : Май 10 10:05:31 2008 RPCConn<kniagnickaya@10.0.3.239>: Session closed...
Info : Май 10 10:05:47 2008 RPCServer@0.0.0.0: Client connecting: 10.0.0.6:2780
Info : Май 10 10:05:47 2008 RPCConn: Connection from: 10.0.0.6:2780
Info : Май 10 10:05:48 2008 RPCConn: Card user <east@10.0.0.6> is connecting
?Debug : Май 10 10:05:48 2008 DBA Groups: Group: -4 not from 1
?Debug : Май 10 10:05:48 2008 DBA Groups: Group: -4 not from 2
?Debug : Май 10 10:05:48 2008 DBA Groups: Group: -4 from 3
-Stats : Май 10 10:05:48 2008 DBA Groups: Stats: Uptime: 00:00:00. Events: 0; Errors: 0
Info : Май 10 10:05:48 2008 RPCConn<east@10.0.0.6>: Access granted to <east@10.0.0.6> (UID: -4)
?Debug : Май 10 10:05:48 2008 RPCConn<east@10.0.0.6>: Call: 0x0045 (Get-Core-Version)
?Debug : Май 10 10:05:48 2008 RPCConn<east@10.0.0.6>: Real Call: 0x0045 (Get-Core-Version)
?Debug : Май 10 10:05:48 2008 RPCConn<east@10.0.0.6>: Call 0x0045 (Get-Core-Version) finished...
?Debug : Май 10 10:05:48 2008 RPCConn<east@10.0.0.6>: Stream cleared
?Debug : Май 10 10:05:48 2008 RPCConn<east@10.0.0.6>: Call: 0x0046 (Get-Core-BUILD)
?Debug : Май 10 10:05:48 2008 RPCConn<east@10.0.0.6>: Real Call: 0x0046 (Get-Core-BUILD)
?Debug : Май 10 10:05:48 2008 RPCConn<east@10.0.0.6>: Call 0x0046 (Get-Core-BUILD) finished...
?Debug : Май 10 10:05:48 2008 RPCConn<east@10.0.0.6>: Stream cleared
?Debug : Май 10 10:05:48 2008 RPCConn<east@10.0.0.6>: Call: 0x11112 (rpcf_get_core_time)
?Debug : Май 10 10:05:48 2008 RPCConn<east@10.0.0.6>: Real Call: 0x11112 (rpcf_get_core_time)
?Debug : Май 10 10:05:48 2008 RPCConn<east@10.0.0.6>: Call 0x11112 (rpcf_get_core_time) finished...
?Debug : Май 10 10:05:48 2008 RPCConn<east@10.0.0.6>: Stream cleared
?Debug : Май 10 10:05:49 2008 RPCConn<east@10.0.0.6>: Call: 0x2910 (rpcf_get_currency_list)
?Debug : Май 10 10:05:49 2008 RPCConn<east@10.0.0.6>: Real Call: 0x2910 (rpcf_get_currency_list)
?Debug : Май 10 10:05:49 2008 RPCConn<east@10.0.0.6>: Call 0x2910 (rpcf_get_currency_list) finished...
?Debug : Май 10 10:05:49 2008 RPCConn<east@10.0.0.6>: Stream cleared
?Debug : Май 10 10:05:49 2008 RPCConn<east@10.0.0.6>: Call: 0x2011 (rpcf_get_users_count)
?Debug : Май 10 10:05:49 2008 RPCConn<east@10.0.0.6>: Real Call: 0x2011 (rpcf_get_users_count)
?Debug : Май 10 10:05:49 2008 RPCConn<east@10.0.0.6>: Call 0x2011 (rpcf_get_users_count) finished...
?Debug : Май 10 10:05:49 2008 RPCConn<east@10.0.0.6>: Stream cleared
?Debug : Май 10 10:05:49 2008 RPCConn<east@10.0.0.6>: Call: 0x2011 (rpcf_get_users_count)
?Debug : Май 10 10:05:49 2008 RPCConn<east@10.0.0.6>: Real Call: 0x2011 (rpcf_get_users_count)
?Debug : Май 10 10:05:49 2008 RPCConn<east@10.0.0.6>: Call 0x2011 (rpcf_get_users_count) finished...
?Debug : Май 10 10:05:49 2008 RPCConn<east@10.0.0.6>: Stream cleared
?Debug : Май 10 10:05:49 2008 RPCConn<east@10.0.0.6>: Call: 0x2400 (rpcf_get_groups_list)
?Debug : Май 10 10:05:49 2008 RPCConn<east@10.0.0.6>: Real Call: 0x2400 (rpcf_get_groups_list)
?Debug : Май 10 10:05:49 2008 DBA:Ctx: Looking for free context
?Debug : Май 10 10:05:49 2008 DBCtx: SQL SELECT query: SELECT id, group_name FROM groups
?Debug : Май 10 10:05:49 2008 DBA:Ctx: Pushing back free context
-Stats : Май 10 10:05:49 2008 DBA Groups: Stats: Uptime: 00:00:00. Events: 0; Errors: 0
?Debug : Май 10 10:05:49 2008 RPCConn<east@10.0.0.6>: Call 0x2400 (rpcf_get_groups_list) finished...
?Debug : Май 10 10:05:49 2008 RPCConn<east@10.0.0.6>: Stream cleared
?Debug : Май 10 10:05:49 2008 RPCConn<east@10.0.0.6>: Call: 0x2001 (rpcf_get_users_list)
?Debug : Май 10 10:05:49 2008 RPCConn<east@10.0.0.6>: Real Call: 0x2001 (rpcf_get_users_list)
Info : Май 10 10:05:55 2008 RPCServer@0.0.0.0: Client connecting: 127.0.0.1:45061
Info : Май 10 10:05:55 2008 RPCConn: Connection from: 127.0.0.1:45061
Notice: Май 10 10:05:55 2008 RPCConn: Service <web@127.0.0.1> is connecting
?Debug : Май 10 10:05:55 2008 RPCConn: Session restored for <kniagnickaya@10.0.3.239>
Info : Май 10 10:05:55 2008 RPCConn<kniagnickaya@10.0.3.239>: Access granted to <kniagnickaya@10.0.3.239> (UID: 736)
?Debug : Май 10 10:05:55 2008 RPCConn<kniagnickaya@10.0.3.239>: Call: 0xffffbfe9 (__rpcs_user5_dhs_report)
?Debug : Май 10 10:05:55 2008 RPCConn<kniagnickaya@10.0.3.239>: Real Call: 0xffffbfe9 (__rpcs_user5_dhs_report)
?Debug : Май 10 10:05:55 2008 UTM5 DBA: DBAccess instance created
?Debug : Май 10 10:05:55 2008 DBA:Ctx: Looking for free context
?Debug : Май 10 10:05:55 2008 DBCtx: SQL SELECT query: SELECT id,account_id,slink_id,recv_date,last_update_date,Framed_IP_Address,NAS_Port,Acct_Session_Id,NAS_Port_Type,User_Name,Service_Type,Framed_Protocol,NAS_IP_Address,NAS_Id,Acct_Status_Type,Acct_Input_Packets,Acct_Input_Octets,Acct_Output_Packets,Acct_Output_Octets,Acct_Session_Time,Called_Station_Id,Calling_Station_Id,Acct_Input_Gigawords,Acct_Output_Gigawords,Acct_Terminate_Cause FROM dhs_sessions_log WHERE last_update_date>='1209589200' AND last_update_date<='1210403155' AND account_id='1467'
?Debug : Май 10 10:05:55 2008 DBCtx: SQL SELECT query: SELECT dhs_sess_id,recv_date,account_id,trange_id,duration,base_cost,sum_cost FROM dhs_sessions_detail WHERE recv_date>='1209589200' AND recv_date<='1210403155' AND account_id='1467'
?Debug : Май 10 10:05:55 2008 DBCtx: SQL SELECT query: SELECT id,account_id,slink_id,recv_date,last_update_date,Framed_IP_Address,NAS_Port,Acct_Session_Id,NAS_Port_Type,User_Name,Service_Type,Framed_Protocol,NAS_IP_Address,NAS_Id,Acct_Status_Type,Acct_Input_Packets,Acct_Input_Octets,Acct_Output_Packets,Acct_Output_Octets,Acct_Session_Time,Called_Station_Id,Calling_Station_Id,Acct_Input_Gigawords,Acct_Output_Gigawords,Acct_Terminate_Cause FROM dhs_sessions_log WHERE last_update_date>='1209589200' AND last_update_date<='1210403155' AND account_id='1468'
?Debug : Май 10 10:05:55 2008 DBCtx: SQL SELECT query: SELECT dhs_sess_id,recv_date,account_id,trange_id,duration,base_cost,sum_cost FROM dhs_sessions_detail WHERE recv_date>='1209589200' AND recv_date<='1210403155' AND account_id='1468'
?Debug : Май 10 10:05:55 2008 DBA:Ctx: Pushing back free context
-Stats : Май 10 10:05:55 2008 UTM5 DBA: Stats: Uptime: 00:00:00. Events: 0; Errors: 0
?Debug : Май 10 10:05:55 2008 RPCConn<kniagnickaya@10.0.3.239>: Call 0xffffbfe9 (__rpcs_user5_dhs_report) finished...
?Debug : Май 10 10:05:55 2008 RPCConn<kniagnickaya@10.0.3.239>: Stream cleared
Info : Май 10 10:05:55 2008 RPCConn<kniagnickaya@10.0.3.239>: Connection terminated by peer
?Debug : Май 10 10:05:55 2008 RPCConn<kniagnickaya@10.0.3.239>: Session stored for UID 736 and IP ef03000a
?Debug : Май 10 10:05:55 2008 RPCConn<kniagnickaya@10.0.3.239>: Session closed...
?Debug : Май 10 10:05:57 2008 FW@127.0.0.1: Ping reply received
Info : Май 10 10:06:04 2008 RPCServer@0.0.0.0: Client connecting: 127.0.0.1:45062
Info : Май 10 10:06:04 2008 RPCConn: Connection from: 127.0.0.1:45062
Notice: Май 10 10:06:04 2008 RPCConn: Service <web@127.0.0.1> is connecting
?Debug : Май 10 10:06:04 2008 RPCConn: Session restored for <kniagnickaya@10.0.3.239>
Info : Май 10 10:06:04 2008 RPCConn<kniagnickaya@10.0.3.239>: Access granted to <kniagnickaya@10.0.3.239> (UID: 736)
?Debug : Май 10 10:06:04 2008 RPCConn<kniagnickaya@10.0.3.239>: Call: 0xffffbfef (__rpcs_user5_service_report)
?Debug : Май 10 10:06:04 2008 RPCConn<kniagnickaya@10.0.3.239>: Real Call: 0xffffbfef (__rpcs_user5_service_report)
?Debug : Май 10 10:06:04 2008 UTM5 DBA: DBAccess instance created
?Debug : Май 10 10:06:04 2008 DBA:Ctx: Looking for free context
?Debug : Май 10 10:06:04 2008 DBCtx: SQL SELECT query: SELECT discount, slink_id, discount_date, discount_period_id, discount_transactions_all.comment,account_id, services_data.service_name, services_data.service_type, discount_with_tax FROM discount_transactions_all, services_data WHERE services_data.id=discount_transactions_all.service_id AND discount_date>='1209589200' AND discount_date <='1210403164' AND account_id='1467' AND (discount_transactions_all.service_type='2' OR discount_transactions_all.service_type='1') ORDER BY discount_date DESC
?Debug : Май 10 10:06:04 2008 DBCtx: SQL SELECT query: SELECT discount, slink_id, discount_date, discount_period_id, discount_transactions_all.comment,account_id, services_data.service_name, services_data.service_type, discount_with_tax FROM discount_transactions_all, services_data WHERE services_data.id=discount_transactions_all.service_id AND discount_date>='1209589200' AND discount_date <='1210403164' AND account_id='1468' AND (discount_transactions_all.service_type='2' OR discount_transactions_all.service_type='1') ORDER BY discount_date DESC
?Debug : Май 10 10:06:04 2008 DBA:Ctx: Pushing back free context
-Stats : Май 10 10:06:04 2008 UTM5 DBA: Stats: Uptime: 00:00:00. Events: 0; Errors: 0
?Debug : Май 10 10:06:04 2008 RPCConn<kniagnickaya@10.0.3.239>: Call 0xffffbfef (__rpcs_user5_service_report) finished...
?Debug : Май 10 10:06:04 2008 RPCConn<kniagnickaya@10.0.3.239>: Stream cleared
Info : Май 10 10:06:04 2008 RPCConn<kniagnickaya@10.0.3.239>: Connection terminated by peer
?Debug : Май 10 10:06:04 2008 RPCConn<kniagnickaya@10.0.3.239>: Session stored for UID 736 and IP ef03000a
?Debug : Май 10 10:06:04 2008 RPCConn<kniagnickaya@10.0.3.239>: Session closed...
Info : Май 10 10:06:19 2008 RPCServer@0.0.0.0: Client connecting: 127.0.0.1:45063
Info : Май 10 10:06:19 2008 RPCConn: Connection from: 127.0.0.1:45063
Notice: Май 10 10:06:19 2008 RPCConn: Service <web@127.0.0.1> is connecting
?Debug : Май 10 10:06:19 2008 RPCConn: Session restored for <kniagnickaya@10.0.3.239>
Info : Май 10 10:06:19 2008 RPCConn<kniagnickaya@10.0.3.239>: Access granted to <kniagnickaya@10.0.3.239> (UID: 736)
?Debug : Май 10 10:06:19 2008 RPCConn<kniagnickaya@10.0.3.239>: Call: 0xffffbf67 (rpcf_user5_get_tel_report)
?Debug : Май 10 10:06:19 2008 RPCConn<kniagnickaya@10.0.3.239>: Real Call: 0xffffbf67 (rpcf_user5_get_tel_report)
?Debug : Май 10 10:06:19 2008 UTM5 DBA: DBAccess instance created
?Debug : Май 10 10:06:19 2008 DBA:Ctx: Looking for free context
?Debug : Май 10 10:06:19 2008 DBCtx: SQL SELECT query: SELECT id,account_id,slink_id,session_start_date,last_update_date,'0',NAS_Port,Acct_Session_Id,NAS_Port_Type,User_Name,Service_Type,Framed_Protocol,NAS_IP_Address,NAS_Id,Acct_Status_Type,Acct_Input_Packets,Acct_Input_Octets,Acct_Output_Packets,Acct_Output_Octets,Acct_Session_Time,Called_Station_Id,Calling_Station_Id,h323_remote_address,h323_conf_id,h323_setup_time,h323_call_origin,h323_call_type,h323_connect_time,h323_disconnect_time,h323_disconnect_cause,h323_gw_id,zone_id,did FROM tel_sessions_log WHERE session_start_date>='1209589200' AND session_start_date<='1210403179' AND account_id='1467'
?Debug : Май 10 10:06:19 2008 DBCtx: SQL SELECT query: SELECT dhs_sess_id,trange_id,duration,base_cost,sum_cost FROM tel_sessions_detail WHERE dhs_sess_id>='4294967295' AND dhs_sess_id <='0' AND account_id='1467'
?Debug : Май 10 10:06:19 2008 DBCtx: SQL SELECT query: SELECT id,account_id,slink_id,session_start_date,last_update_date,'0',NAS_Port,Acct_Session_Id,NAS_Port_Type,User_Name,Service_Type,Framed_Protocol,NAS_IP_Address,NAS_Id,Acct_Status_Type,Acct_Input_Packets,Acct_Input_Octets,Acct_Output_Packets,Acct_Output_Octets,Acct_Session_Time,Called_Station_Id,Calling_Station_Id,h323_remote_address,h323_conf_id,h323_setup_time,h323_call_origin,h323_call_type,h323_connect_time,h323_disconnect_time,h323_disconnect_cause,h323_gw_id,zone_id,did FROM tel_sessions_log WHERE session_start_date>='1209589200' AND session_start_date<='1210403179' AND account_id='1468'
?Debug : Май 10 10:06:19 2008 DBCtx: SQL SELECT query: SELECT dhs_sess_id,trange_id,duration,base_cost,sum_cost FROM tel_sessions_detail WHERE dhs_sess_id>='4294967295' AND dhs_sess_id <='0' AND account_id='1468'
?Debug : Май 10 10:06:19 2008 DBA:Ctx: Pushing back free context
-Stats : Май 10 10:06:19 2008 UTM5 DBA: Stats: Uptime: 00:00:00. Events: 0; Errors: 0
?Debug : Май 10 10:06:19 2008 RPCConn<kniagnickaya@10.0.3.239>: Call 0xffffbf67 (rpcf_user5_get_tel_report) finished...
?Debug : Май 10 10:06:19 2008 RPCConn<kniagnickaya@10.0.3.239>: Stream cleared
Info : Май 10 10:06:19 2008 RPCConn<kniagnickaya@10.0.3.239>: Connection terminated by peer
?Debug : Май 10 10:06:19 2008 RPCConn<kniagnickaya@10.0.3.239>: Session stored for UID 736 and IP ef03000a
?Debug : Май 10 10:06:19 2008 RPCConn<kniagnickaya@10.0.3.239>: Session closed...
?Debug : Май 10 10:06:28 2008 FW@127.0.0.1: Ping reply received
?Debug : Май 10 10:06:57 2008 FW@127.0.0.1: Ping reply received
?Debug : Май 10 10:07:28 2008 FW@127.0.0.1: Ping reply received
?Debug : Май 10 10:07:58 2008 FW@127.0.0.1: Ping reply received
?Debug : Май 10 10:08:28 2008 FW@127.0.0.1: Ping reply received
?Debug : Май 10 10:08:58 2008 FW@127.0.0.1: Ping reply received
?Debug : Май 10 10:09:28 2008 FW@127.0.0.1: Ping reply received

PEBA
Сообщения: 15
Зарегистрирован: Вт май 06, 2008 22:44

Сообщение PEBA »

и продолжение дебага, еще 15 минут зависания, и в самом внизу что пишет в лог при работе админки(нажал обновить) с зависнущим ядром

?Debug : Май 10 10:09:28 2008 FW@127.0.0.1: Ping reply received
?Debug : Май 10 10:09:58 2008 FW@127.0.0.1: Ping reply received
Info : Май 10 10:09:58 2008 RPCServer@0.0.0.0: Client connecting: 127.0.0.1:55347
Info : Май 10 10:09:58 2008 RPCConn: Connection from: 127.0.0.1:55347
Info : Май 10 10:09:58 2008 RPCConn<kovalenko1983@10.0.2.183>: Access granted to <kovalenko1983@10.0.2.183> (UID: 330)
Info : Май 10 10:09:58 2008 RPCConn<kovalenko1983@10.0.2.183>: Connection terminated by peer
?Debug : Май 10 10:09:58 2008 RPCConn<kovalenko1983@10.0.2.183>: Session stored for UID 330 and IP b702000a
?Debug : Май 10 10:09:58 2008 RPCConn<kovalenko1983@10.0.2.183>: Session closed...
Info : Май 10 10:09:58 2008 RPCServer@0.0.0.0: Client connecting: 127.0.0.1:55348
Info : Май 10 10:09:58 2008 RPCConn: Connection from: 127.0.0.1:55348
Notice: Май 10 10:09:58 2008 RPCConn: Service <web@127.0.0.1> is connecting
?Debug : Май 10 10:09:58 2008 RPCConn: Session restored for <kovalenko1983@10.0.2.183>
Info : Май 10 10:09:58 2008 RPCConn<kovalenko1983@10.0.2.183>: Access granted to <kovalenko1983@10.0.2.183> (UID: 330)
?Debug : Май 10 10:09:58 2008 RPCConn<kovalenko1983@10.0.2.183>: Call: 0xffffbffa (__rpcs_get_user_info)
?Debug : Май 10 10:09:58 2008 RPCConn<kovalenko1983@10.0.2.183>: Real Call: 0xffffbffa (__rpcs_get_user_info)
?Debug : Май 10 10:09:58 2008 DBCtx: SQL SELECT query: SELECT login, password, basic_account, is_blocked, create_date, last_change_date, who_create, who_change, is_juridical, full_name, juridical_address, actual_address, work_telephone, home_telephone, mobile_telephone, web_page, icq_number, tax_number, kpp_number, bank_id, bank_account, comments, discount_period_id, email, house_id, flat_number, entrance, floor, district, building, passport, personal_manager, connect_date, is_send_invoice, advance_payment FROM users WHERE id='330' AND is_deleted=0
?Debug : Май 10 10:09:58 2008 DBCtx: SQL SELECT query: SELECT group_id FROM users_groups_link WHERE user_id='330'
?Debug : Май 10 10:09:58 2008 DBCtx: SQL SELECT query: SELECT paramid, value FROM user_additional_params WHERE userid='330'
?Debug : Май 10 10:09:58 2008 RPCConn<kovalenko1983@10.0.2.183>: Call 0xffffbffa (__rpcs_get_user_info) finished...
?Debug : Май 10 10:09:58 2008 RPCConn<kovalenko1983@10.0.2.183>: Stream cleared
?Debug : Май 10 10:09:58 2008 RPCConn<kovalenko1983@10.0.2.183>: Call: 0xffffbfab (__rpcs_user5_get_accounts)
?Debug : Май 10 10:09:58 2008 RPCConn<kovalenko1983@10.0.2.183>: Real Call: 0xffffbfab (__rpcs_user5_get_accounts)
?Debug : Май 10 10:09:58 2008 RPCConn<kovalenko1983@10.0.2.183>: Call 0xffffbfab (__rpcs_user5_get_accounts) finished...
?Debug : Май 10 10:09:58 2008 RPCConn<kovalenko1983@10.0.2.183>: Stream cleared
Info : Май 10 10:09:58 2008 RPCConn<kovalenko1983@10.0.2.183>: Connection terminated by peer
?Debug : Май 10 10:09:58 2008 RPCConn<kovalenko1983@10.0.2.183>: Session stored for UID 330 and IP b702000a
?Debug : Май 10 10:09:58 2008 RPCConn<kovalenko1983@10.0.2.183>: Session closed...
?Debug : Май 10 10:10:28 2008 FW@127.0.0.1: Ping reply received
?Debug : Май 10 10:10:58 2008 FW@127.0.0.1: Ping reply received
?Debug : Май 10 10:11:28 2008 FW@127.0.0.1: Ping reply received
?Debug : Май 10 10:11:58 2008 FW@127.0.0.1: Ping reply received
?Debug : Май 10 10:12:28 2008 FW@127.0.0.1: Ping reply received
?Debug : Май 10 10:12:58 2008 FW@127.0.0.1: Ping reply received
?Debug : Май 10 10:13:28 2008 FW@127.0.0.1: Ping reply received
?Debug : Май 10 10:13:58 2008 FW@127.0.0.1: Ping reply received
?Debug : Май 10 10:14:28 2008 FW@127.0.0.1: Ping reply received
?Debug : Май 10 10:14:58 2008 FW@127.0.0.1: Ping reply received
Info : Май 10 10:15:12 2008 RPCServer@0.0.0.0: Client connecting: 127.0.0.1:44939
Info : Май 10 10:15:12 2008 RPCConn: Connection from: 127.0.0.1:44939
Info : Май 10 10:15:12 2008 RPCConn<lilia@10.0.2.85>: Access granted to <lilia@10.0.2.85> (UID: 108)
Info : Май 10 10:15:12 2008 RPCConn<lilia@10.0.2.85>: Connection terminated by peer
?Debug : Май 10 10:15:12 2008 RPCConn<lilia@10.0.2.85>: Session stored for UID 108 and IP 5502000a
?Debug : Май 10 10:15:12 2008 RPCConn<lilia@10.0.2.85>: Session closed...
Info : Май 10 10:15:12 2008 RPCServer@0.0.0.0: Client connecting: 127.0.0.1:44940
Info : Май 10 10:15:12 2008 RPCConn: Connection from: 127.0.0.1:44940
Notice: Май 10 10:15:12 2008 RPCConn: Service <web@127.0.0.1> is connecting
?Debug : Май 10 10:15:12 2008 RPCConn: Session restored for <lilia@10.0.2.85>
Info : Май 10 10:15:12 2008 RPCConn<lilia@10.0.2.85>: Access granted to <lilia@10.0.2.85> (UID: 108)
?Debug : Май 10 10:15:12 2008 RPCConn<lilia@10.0.2.85>: Call: 0xffffbffa (__rpcs_get_user_info)
?Debug : Май 10 10:15:12 2008 RPCConn<lilia@10.0.2.85>: Real Call: 0xffffbffa (__rpcs_get_user_info)
?Debug : Май 10 10:15:12 2008 DBCtx: SQL SELECT query: SELECT login, password, basic_account, is_blocked, create_date, last_change_date, who_create, who_change, is_juridical, full_name, juridical_address, actual_address, work_telephone, home_telephone, mobile_telephone, web_page, icq_number, tax_number, kpp_number, bank_id, bank_account, comments, discount_period_id, email, house_id, flat_number, entrance, floor, district, building, passport, personal_manager, connect_date, is_send_invoice, advance_payment FROM users WHERE id='108' AND is_deleted=0
?Debug : Май 10 10:15:12 2008 DBCtx: SQL SELECT query: SELECT group_id FROM users_groups_link WHERE user_id='108'
?Debug : Май 10 10:15:12 2008 DBCtx: SQL SELECT query: SELECT paramid, value FROM user_additional_params WHERE userid='108'
?Debug : Май 10 10:15:12 2008 RPCConn<lilia@10.0.2.85>: Call 0xffffbffa (__rpcs_get_user_info) finished...
?Debug : Май 10 10:15:12 2008 RPCConn<lilia@10.0.2.85>: Stream cleared
?Debug : Май 10 10:15:12 2008 RPCConn<lilia@10.0.2.85>: Call: 0xffffbfab (__rpcs_user5_get_accounts)
?Debug : Май 10 10:15:12 2008 RPCConn<lilia@10.0.2.85>: Real Call: 0xffffbfab (__rpcs_user5_get_accounts)
?Debug : Май 10 10:15:12 2008 RPCConn<lilia@10.0.2.85>: Call 0xffffbfab (__rpcs_user5_get_accounts) finished...
?Debug : Май 10 10:15:12 2008 RPCConn<lilia@10.0.2.85>: Stream cleared
Info : Май 10 10:15:12 2008 RPCConn<lilia@10.0.2.85>: Connection terminated by peer
?Debug : Май 10 10:15:12 2008 RPCConn<lilia@10.0.2.85>: Session stored for UID 108 and IP 5502000a
?Debug : Май 10 10:15:12 2008 RPCConn<lilia@10.0.2.85>: Session closed...
Info : Май 10 10:15:26 2008 RPCServer@0.0.0.0: Client connecting: 127.0.0.1:44941
Info : Май 10 10:15:26 2008 RPCConn: Connection from: 127.0.0.1:44941
Notice: Май 10 10:15:26 2008 RPCConn: Service <web@127.0.0.1> is connecting
?Debug : Май 10 10:15:26 2008 RPCConn: Session restored for <lilia@10.0.2.85>
Info : Май 10 10:15:26 2008 RPCConn<lilia@10.0.2.85>: Access granted to <lilia@10.0.2.85> (UID: 108)
?Debug : Май 10 10:15:26 2008 RPCConn<lilia@10.0.2.85>: Call: 0xffffbffa (__rpcs_get_user_info)
?Debug : Май 10 10:15:26 2008 RPCConn<lilia@10.0.2.85>: Real Call: 0xffffbffa (__rpcs_get_user_info)
?Debug : Май 10 10:15:26 2008 DBCtx: SQL SELECT query: SELECT login, password, basic_account, is_blocked, create_date, last_change_date, who_create, who_change, is_juridical, full_name, juridical_address, actual_address, work_telephone, home_telephone, mobile_telephone, web_page, icq_number, tax_number, kpp_number, bank_id, bank_account, comments, discount_period_id, email, house_id, flat_number, entrance, floor, district, building, passport, personal_manager, connect_date, is_send_invoice, advance_payment FROM users WHERE id='108' AND is_deleted=0
?Debug : Май 10 10:15:26 2008 DBCtx: SQL SELECT query: SELECT group_id FROM users_groups_link WHERE user_id='108'
?Debug : Май 10 10:15:26 2008 DBCtx: SQL SELECT query: SELECT paramid, value FROM user_additional_params WHERE userid='108'
?Debug : Май 10 10:15:26 2008 RPCConn<lilia@10.0.2.85>: Call 0xffffbffa (__rpcs_get_user_info) finished...
?Debug : Май 10 10:15:26 2008 RPCConn<lilia@10.0.2.85>: Stream cleared
?Debug : Май 10 10:15:26 2008 RPCConn<lilia@10.0.2.85>: Call: 0xffffbfab (__rpcs_user5_get_accounts)
?Debug : Май 10 10:15:26 2008 RPCConn<lilia@10.0.2.85>: Real Call: 0xffffbfab (__rpcs_user5_get_accounts)
?Debug : Май 10 10:15:26 2008 RPCConn<lilia@10.0.2.85>: Call 0xffffbfab (__rpcs_user5_get_accounts) finished...
?Debug : Май 10 10:15:26 2008 RPCConn<lilia@10.0.2.85>: Stream cleared
Info : Май 10 10:15:26 2008 RPCConn<lilia@10.0.2.85>: Connection terminated by peer
?Debug : Май 10 10:15:26 2008 RPCConn<lilia@10.0.2.85>: Session stored for UID 108 and IP 5502000a
?Debug : Май 10 10:15:26 2008 RPCConn<lilia@10.0.2.85>: Session closed...
?Debug : Май 10 10:15:28 2008 FW@127.0.0.1: Ping reply received
?Debug : Май 10 10:15:58 2008 FW@127.0.0.1: Ping reply received
?Debug : Май 10 10:16:28 2008 FW@127.0.0.1: Ping reply received
Info : Май 10 10:16:31 2008 RPCServer@0.0.0.0: Client connecting: 127.0.0.1:44942
Info : Май 10 10:16:31 2008 RPCConn: Connection from: 127.0.0.1:44942
Info : Май 10 10:16:31 2008 RPCConn<set@10.0.0.147>: Access granted to <set@10.0.0.147> (UID: 45)
Info : Май 10 10:16:31 2008 RPCConn<set@10.0.0.147>: Connection terminated by peer
?Debug : Май 10 10:16:31 2008 RPCConn<set@10.0.0.147>: Session stored for UID 45 and IP 9300000a
?Debug : Май 10 10:16:31 2008 RPCConn<set@10.0.0.147>: Session closed...
Info : Май 10 10:16:31 2008 RPCServer@0.0.0.0: Client connecting: 127.0.0.1:44943
Info : Май 10 10:16:31 2008 RPCConn: Connection from: 127.0.0.1:44943
Notice: Май 10 10:16:31 2008 RPCConn: Service <web@127.0.0.1> is connecting
?Debug : Май 10 10:16:31 2008 RPCConn: Session restored for <set@10.0.0.147>
Info : Май 10 10:16:31 2008 RPCConn<set@10.0.0.147>: Access granted to <set@10.0.0.147> (UID: 45)
?Debug : Май 10 10:16:31 2008 RPCConn<set@10.0.0.147>: Call: 0xffffbffa (__rpcs_get_user_info)
?Debug : Май 10 10:16:31 2008 RPCConn<set@10.0.0.147>: Real Call: 0xffffbffa (__rpcs_get_user_info)
?Debug : Май 10 10:16:31 2008 DBCtx: SQL SELECT query: SELECT login, password, basic_account, is_blocked, create_date, last_change_date, who_create, who_change, is_juridical, full_name, juridical_address, actual_address, work_telephone, home_telephone, mobile_telephone, web_page, icq_number, tax_number, kpp_number, bank_id, bank_account, comments, discount_period_id, email, house_id, flat_number, entrance, floor, district, building, passport, personal_manager, connect_date, is_send_invoice, advance_payment FROM users WHERE id='45' AND is_deleted=0
?Debug : Май 10 10:16:31 2008 DBCtx: SQL SELECT query: SELECT group_id FROM users_groups_link WHERE user_id='45'
?Debug : Май 10 10:16:31 2008 DBCtx: SQL SELECT query: SELECT paramid, value FROM user_additional_params WHERE userid='45'
?Debug : Май 10 10:16:31 2008 RPCConn<set@10.0.0.147>: Call 0xffffbffa (__rpcs_get_user_info) finished...
?Debug : Май 10 10:16:31 2008 RPCConn<set@10.0.0.147>: Stream cleared
?Debug : Май 10 10:16:32 2008 RPCConn<set@10.0.0.147>: Call: 0xffffbfab (__rpcs_user5_get_accounts)
?Debug : Май 10 10:16:32 2008 RPCConn<set@10.0.0.147>: Real Call: 0xffffbfab (__rpcs_user5_get_accounts)
?Debug : Май 10 10:16:32 2008 RPCConn<set@10.0.0.147>: Call 0xffffbfab (__rpcs_user5_get_accounts) finished...
?Debug : Май 10 10:16:32 2008 RPCConn<set@10.0.0.147>: Stream cleared
Info : Май 10 10:16:32 2008 RPCConn<set@10.0.0.147>: Connection terminated by peer
?Debug : Май 10 10:16:32 2008 RPCConn<set@10.0.0.147>: Session stored for UID 45 and IP 9300000a
?Debug : Май 10 10:16:32 2008 RPCConn<set@10.0.0.147>: Session closed...
Info : Май 10 10:16:38 2008 RPCServer@0.0.0.0: Client connecting: 127.0.0.1:44944
Info : Май 10 10:16:38 2008 RPCConn: Connection from: 127.0.0.1:44944
Notice: Май 10 10:16:38 2008 RPCConn: Service <web@127.0.0.1> is connecting
?Debug : Май 10 10:16:38 2008 RPCConn: Session restored for <set@10.0.0.147>
Info : Май 10 10:16:38 2008 RPCConn<set@10.0.0.147>: Access granted to <set@10.0.0.147> (UID: 45)
?Debug : Май 10 10:16:38 2008 RPCConn<set@10.0.0.147>: Call: 0xffffbff9 (__rpcs_user5_change_int_status)
?Debug : Май 10 10:16:38 2008 RPCConn<set@10.0.0.147>: Real Call: 0xffffbff9 (__rpcs_user5_change_int_status)
?Debug : Май 10 10:16:38 2008 DBCtx: SQL SELECT query: SELECT login, password, basic_account, is_blocked, create_date, last_change_date, who_create, who_change, is_juridical, full_name, juridical_address, actual_address, work_telephone, home_telephone, mobile_telephone, web_page, icq_number, tax_number, kpp_number, bank_id, bank_account, comments, discount_period_id, email, house_id, flat_number, entrance, floor, district, building, passport, personal_manager, connect_date, is_send_invoice, advance_payment FROM users WHERE id='45' AND is_deleted=0
?Debug : Май 10 10:16:38 2008 DBCtx: SQL SELECT query: SELECT group_id FROM users_groups_link WHERE user_id='45'
?Debug : Май 10 10:16:38 2008 DBCtx: SQL SELECT query: SELECT paramid, value FROM user_additional_params WHERE userid='45'
?Debug : Май 10 10:16:38 2008 DBCtx: SQL query: UPDATE accounts SET int_status='0' WHERE id='81'
?Debug : Май 10 10:16:38 2008 BusLogic: currently blm with code 38 executing
?Debug : Май 10 10:16:38 2008 BusLogic: BLM(38) pushed (comment: )
?Debug : Май 10 10:16:38 2008 UTM5 DBA: hw block for account 81
?Debug : Май 10 10:16:38 2008 DBCtx: SQL query: UPDATE accounts SET int_status='0' WHERE id='82'
?Debug : Май 10 10:16:38 2008 BusLogic: currently blm with code 38 executing
?Debug : Май 10 10:16:38 2008 BusLogic: BLM(38) pushed (comment: )
?Debug : Май 10 10:16:38 2008 UTM5 DBA: hw block for account 82
?Debug : Май 10 10:16:38 2008 RPCConn<set@10.0.0.147>: Call 0xffffbff9 (__rpcs_user5_change_int_status) finished...
?Debug : Май 10 10:16:38 2008 RPCConn<set@10.0.0.147>: Stream cleared
?Debug : Май 10 10:16:38 2008 RPCConn<set@10.0.0.147>: Call: 0xffffbffa (__rpcs_get_user_info)
?Debug : Май 10 10:16:38 2008 RPCConn<set@10.0.0.147>: Real Call: 0xffffbffa (__rpcs_get_user_info)
?Debug : Май 10 10:16:38 2008 DBCtx: SQL SELECT query: SELECT login, password, basic_account, is_blocked, create_date, last_change_date, who_create, who_change, is_juridical, full_name, juridical_address, actual_address, work_telephone, home_telephone, mobile_telephone, web_page, icq_number, tax_number, kpp_number, bank_id, bank_account, comments, discount_period_id, email, house_id, flat_number, entrance, floor, district, building, passport, personal_manager, connect_date, is_send_invoice, advance_payment FROM users WHERE id='45' AND is_deleted=0
?Debug : Май 10 10:16:38 2008 DBCtx: SQL SELECT query: SELECT group_id FROM users_groups_link WHERE user_id='45'
?Debug : Май 10 10:16:38 2008 DBCtx: SQL SELECT query: SELECT paramid, value FROM user_additional_params WHERE userid='45'
?Debug : Май 10 10:16:38 2008 RPCConn<set@10.0.0.147>: Call 0xffffbffa (__rpcs_get_user_info) finished...
?Debug : Май 10 10:16:38 2008 RPCConn<set@10.0.0.147>: Stream cleared
?Debug : Май 10 10:16:38 2008 RPCConn<set@10.0.0.147>: Call: 0xffffbfab (__rpcs_user5_get_accounts)
?Debug : Май 10 10:16:38 2008 RPCConn<set@10.0.0.147>: Real Call: 0xffffbfab (__rpcs_user5_get_accounts)
?Debug : Май 10 10:16:38 2008 RPCConn<set@10.0.0.147>: Call 0xffffbfab (__rpcs_user5_get_accounts) finished...
?Debug : Май 10 10:16:38 2008 RPCConn<set@10.0.0.147>: Stream cleared
Info : Май 10 10:16:38 2008 RPCConn<set@10.0.0.147>: Connection terminated by peer
?Debug : Май 10 10:16:38 2008 RPCConn<set@10.0.0.147>: Session stored for UID 45 and IP 9300000a
?Debug : Май 10 10:16:38 2008 RPCConn<set@10.0.0.147>: Session closed...
Info : Май 10 10:16:41 2008 RPCServer@0.0.0.0: Client connecting: 127.0.0.1:44945
Info : Май 10 10:16:41 2008 RPCConn: Connection from: 127.0.0.1:44945
Notice: Май 10 10:16:41 2008 RPCConn: Service <web@127.0.0.1> is connecting
?Debug : Май 10 10:16:41 2008 RPCConn: Session restored for <set@10.0.0.147>
Info : Май 10 10:16:41 2008 RPCConn<set@10.0.0.147>: Access granted to <set@10.0.0.147> (UID: 45)
?Debug : Май 10 10:16:41 2008 RPCConn<set@10.0.0.147>: Call: 0xffffbff9 (__rpcs_user5_change_int_status)
?Debug : Май 10 10:16:41 2008 RPCConn<set@10.0.0.147>: Real Call: 0xffffbff9 (__rpcs_user5_change_int_status)
?Debug : Май 10 10:16:41 2008 DBCtx: SQL SELECT query: SELECT login, password, basic_account, is_blocked, create_date, last_change_date, who_create, who_change, is_juridical, full_name, juridical_address, actual_address, work_telephone, home_telephone, mobile_telephone, web_page, icq_number, tax_number, kpp_number, bank_id, bank_account, comments, discount_period_id, email, house_id, flat_number, entrance, floor, district, building, passport, personal_manager, connect_date, is_send_invoice, advance_payment FROM users WHERE id='45' AND is_deleted=0
?Debug : Май 10 10:16:41 2008 DBCtx: SQL SELECT query: SELECT group_id FROM users_groups_link WHERE user_id='45'
?Debug : Май 10 10:16:41 2008 DBCtx: SQL SELECT query: SELECT paramid, value FROM user_additional_params WHERE userid='45'
?Debug : Май 10 10:16:41 2008 DBCtx: SQL query: UPDATE accounts SET int_status='1' WHERE id='81'
?Debug : Май 10 10:16:41 2008 BusLogic: currently blm with code 38 executing
?Debug : Май 10 10:16:41 2008 BusLogic: BLM(39) pushed (comment: )
?Debug : Май 10 10:16:41 2008 UTM5 DBA: hw unblock for account 81
?Debug : Май 10 10:16:41 2008 DBCtx: SQL query: UPDATE accounts SET int_status='1' WHERE id='82'
?Debug : Май 10 10:16:41 2008 BusLogic: currently blm with code 38 executing
?Debug : Май 10 10:16:41 2008 BusLogic: BLM(39) pushed (comment: )
?Debug : Май 10 10:16:41 2008 UTM5 DBA: hw unblock for account 82
?Debug : Май 10 10:16:41 2008 RPCConn<set@10.0.0.147>: Call 0xffffbff9 (__rpcs_user5_change_int_status) finished...
?Debug : Май 10 10:16:41 2008 RPCConn<set@10.0.0.147>: Stream cleared
?Debug : Май 10 10:16:41 2008 RPCConn<set@10.0.0.147>: Call: 0xffffbffa (__rpcs_get_user_info)
?Debug : Май 10 10:16:41 2008 RPCConn<set@10.0.0.147>: Real Call: 0xffffbffa (__rpcs_get_user_info)
?Debug : Май 10 10:16:41 2008 DBCtx: SQL SELECT query: SELECT login, password, basic_account, is_blocked, create_date, last_change_date, who_create, who_change, is_juridical, full_name, juridical_address, actual_address, work_telephone, home_telephone, mobile_telephone, web_page, icq_number, tax_number, kpp_number, bank_id, bank_account, comments, discount_period_id, email, house_id, flat_number, entrance, floor, district, building, passport, personal_manager, connect_date, is_send_invoice, advance_payment FROM users WHERE id='45' AND is_deleted=0
?Debug : Май 10 10:16:41 2008 DBCtx: SQL SELECT query: SELECT group_id FROM users_groups_link WHERE user_id='45'
?Debug : Май 10 10:16:41 2008 DBCtx: SQL SELECT query: SELECT paramid, value FROM user_additional_params WHERE userid='45'
?Debug : Май 10 10:16:41 2008 RPCConn<set@10.0.0.147>: Call 0xffffbffa (__rpcs_get_user_info) finished...
?Debug : Май 10 10:16:41 2008 RPCConn<set@10.0.0.147>: Stream cleared
?Debug : Май 10 10:16:41 2008 RPCConn<set@10.0.0.147>: Call: 0xffffbfab (__rpcs_user5_get_accounts)
?Debug : Май 10 10:16:41 2008 RPCConn<set@10.0.0.147>: Real Call: 0xffffbfab (__rpcs_user5_get_accounts)
?Debug : Май 10 10:16:41 2008 RPCConn<set@10.0.0.147>: Call 0xffffbfab (__rpcs_user5_get_accounts) finished...
?Debug : Май 10 10:16:41 2008 RPCConn<set@10.0.0.147>: Stream cleared
Info : Май 10 10:16:41 2008 RPCConn<set@10.0.0.147>: Connection terminated by peer
?Debug : Май 10 10:16:41 2008 RPCConn<set@10.0.0.147>: Session stored for UID 45 and IP 9300000a
?Debug : Май 10 10:16:41 2008 RPCConn<set@10.0.0.147>: Session closed...
?Debug : Май 10 10:16:58 2008 FW@127.0.0.1: Ping reply received
?Debug : Май 10 10:17:28 2008 FW@127.0.0.1: Ping reply received
?Debug : Май 10 10:17:58 2008 FW@127.0.0.1: Ping reply received
?Debug : Май 10 10:18:28 2008 FW@127.0.0.1: Ping reply received
?Debug : Май 10 10:19:02 2008 RPCConn<init@10.0.0.2>: Call: 0x2011 (rpcf_get_users_count)
?Debug : Май 10 10:19:02 2008 RPCConn<init@10.0.0.2>: Real Call: 0x2011 (rpcf_get_users_count)
?Debug : Май 10 10:19:02 2008 RPCConn<init@10.0.0.2>: Call 0x2011 (rpcf_get_users_count) finished...
?Debug : Май 10 10:19:02 2008 RPCConn<init@10.0.0.2>: Stream cleared
?Debug : Май 10 10:19:02 2008 RPCConn<init@10.0.0.2>: Call: 0x2400 (rpcf_get_groups_list)
?Debug : Май 10 10:19:02 2008 RPCConn<init@10.0.0.2>: Real Call: 0x2400 (rpcf_get_groups_list)
?Debug : Май 10 10:19:02 2008 DBA:Ctx: Looking for free context
?Debug : Май 10 10:19:02 2008 DBCtx: SQL SELECT query: SELECT id, group_name FROM groups
?Debug : Май 10 10:19:02 2008 DBA:Ctx: Pushing back free context
-Stats : Май 10 10:19:02 2008 DBA Groups: Stats: Uptime: 00:00:00. Events: 0; Errors: 0
?Debug : Май 10 10:19:02 2008 RPCConn<init@10.0.0.2>: Call 0x2400 (rpcf_get_groups_list) finished...
?Debug : Май 10 10:19:02 2008 RPCConn<init@10.0.0.2>: Stream cleared
?Debug : Май 10 10:19:02 2008 RPCConn<init@10.0.0.2>: Call: 0x2001 (rpcf_get_users_list)
?Debug : Май 10 10:19:02 2008 RPCConn<init@10.0.0.2>: Real Call: 0x2001 (rpcf_get_users_list)

PEBA
Сообщения: 15
Зарегистрирован: Вт май 06, 2008 22:44

Сообщение PEBA »

XoRe писал(а):2PEBA:


Постоянные зависания ядра системы (в логи ничего не пишет), при чем очень странно. Помогает лишь перезапуск сервера полностью.
А что видно без перезагрузки?
Т.е. когда ядро зависает, вы его убиваете и просто снова пытаетесь запустить?
То что просили, ядро остановить не получается....

BillingGate1:/netup/utm5/log# service utm5_core stop
Stopping utm5_core
/usr/sbin/invoke-rc.d: line 437: 683 User defined signal 1 "${INITDPREFIX}${INITSCRIPTID}" "${saction}" "$@"
BillingGate1:/netup/utm5/log# service utm5_core stop
Stopping utm5_core
/usr/sbin/invoke-rc.d: line 437: 704 User defined signal 1 "${INITDPREFIX}${INITSCRIPTID}" "${saction}" "$@"
BillingGate1:/netup/utm5/log# service utm5_core stop
Stopping utm5_core
/usr/sbin/invoke-rc.d: line 437: 730 User defined signal 1 "${INITDPREFIX}${INITSCRIPTID}" "${saction}" "$@"

BillingGate1:/netup/utm5/log# ps -x|grep utm5
Warning: bad ps syntax, perhaps a bogus '-'? See http://procps.sf.net/faq.html
4721 ? S 0:00 /bin/sh /netup/utm5/bin/safe_utm5_rfw start
4749 ? S 0:00 /bin/sh /netup/utm5/bin/safe_utm5_radius start
4819 ? Sl 2:30 /netup/utm5/bin/utm5_radius -c /netup/utm5/radius5.cfg
4850 ? S 0:00 /usr/bin/ndsad -d -w -c /netup/utm5/ndsad.cfg
4854 ? Sl 56:34 /usr/bin/ndsad -d -w -c /netup/utm5/ndsad.cfg
21629 ? S 0:00 /bin/sh /netup/utm5/bin/safe_utm5_core start
21631 ? Sl 19:59 /netup/utm5/bin/utm5_core
26234 ? Sl 0:01 /netup/utm5/bin/utm5_rfw -f
734 pts/155 S+ 0:00 grep utm5


даже так

BillingGate1:/netup/utm5/log# kill 21631
BillingGate1:/netup/utm5/log# ps -x|grep utm5
Warning: bad ps syntax, perhaps a bogus '-'? See http://procps.sf.net/faq.html
4721 ? S 0:00 /bin/sh /netup/utm5/bin/safe_utm5_rfw start
4749 ? S 0:00 /bin/sh /netup/utm5/bin/safe_utm5_radius start
4819 ? Sl 2:30 /netup/utm5/bin/utm5_radius -c /netup/utm5/radius5.cfg
4850 ? S 0:00 /usr/bin/ndsad -d -w -c /netup/utm5/ndsad.cfg
4854 ? Sl 56:36 /usr/bin/ndsad -d -w -c /netup/utm5/ndsad.cfg
21629 ? S 0:00 /bin/sh /netup/utm5/bin/safe_utm5_core start
21631 ? Sl 19:59 /netup/utm5/bin/utm5_core
26234 ? Sl 0:01 /netup/utm5/bin/utm5_rfw -f
964 pts/155 S+ 0:00 grep utm5

Аватара пользователя
Lex
NetUP Team
Сообщения: 623
Зарегистрирован: Ср мар 09, 2005 12:12
Откуда: НетАП
Контактная информация:

Сообщение Lex »

Подключитесь к работающему ядру отладчиком gdb в тот момент, когда оно висит и снимите стектрейс со всех тредов.

gdb /netup/utm5/bin/utm5_core <PID>

в приглашении thr a a bt

Аватара пользователя
XoRe
Сообщения: 458
Зарегистрирован: Ср янв 10, 2007 16:04

Сообщение XoRe »

/usr/sbin/invoke-rc.d: line 437: 730 User defined signal 1 "${INITDPREFIX}${INITSCRIPTID}" "${saction}" "$@"
Это смахивает на баг в скриптах, которые стартуют/стопорят процессы.
Я бы посоветовал сделать diff скриптов со скриптами в дистрибутиве или в исходниках.

Попробуйте kill -9, чтоб убивать процесс.

mikkey finn
Сообщения: 1612
Зарегистрирован: Пт ноя 10, 2006 15:23

Сообщение mikkey finn »

слова Лекса показывают, что таки есть подозрения на колорадский жук.

PEBA
Сообщения: 15
Зарегистрирован: Вт май 06, 2008 22:44

Сообщение PEBA »

XoRe писал(а):
/usr/sbin/invoke-rc.d: line 437: 730 User defined signal 1 "${INITDPREFIX}${INITSCRIPTID}" "${saction}" "$@"
Это смахивает на баг в скриптах, которые стартуют/стопорят процессы.
Я бы посоветовал сделать diff скриптов со скриптами в дистрибутиве или в исходниках.

Попробуйте kill -9, чтоб убивать процесс.
в не повисшем состоянии все нормально останавливается, и запускается, так что дыры в скриптах запуска я бы вычеркнул, даже если бы там были косяки - они были бы не причем к зависанию ядра...

Аватара пользователя
XoRe
Сообщения: 458
Зарегистрирован: Ср янв 10, 2007 16:04

Сообщение XoRe »

поставим вопрос подругому:
у кого утм нормально работает на дебияне?

Закрыто