forum.bitel.ru • Просмотр темы - [BGScheduler] Не удалось запустить периодическую задачу

Сообщения без ответов | Активные темы

Список форумов » BGBilling » Ядро системы

Часовой пояс: UTC + 5 часов [ Летнее время ]

[BGScheduler] Не удалось запустить периодическую задачу

Страница 1 из 1

[ Сообщений: 19 ]

Версия для печати

Пред. тема | След. тема

Автор

Сообщение

jack7

Заголовок сообщения: [BGScheduler] Не удалось запустить периодическую задачу

Добавлено: 14 ноя 2011, 16:39

Код:

Сервер: вер. 5.1 сборка 690 от 11.07.2011 18:42:40
os:Linux; java:Sun Microsystems Inc., v.1.6.0_27

Код:

./scheduler.sh  -estatus
Sending 'status' on 127.0.0.1:9066
Result: TaskExecuter working
Started: 10.11.2011 14:27:53    Uptime: 4 d 02:08:24
Memory total: 278 396 928; max: 3 817 799 680; free: 250 656 160
Memory pools:
Non-heap memory[Code Cache]: max: 50 331 648; used: 3 763 392; peek: 3 859 008
Heap memory[PS Eden Space]: max: 1 425 735 680; used: 21 563 440; peek: 147 849 216
Heap memory[PS Survivor Space]: max: 2 883 584; used: 0; peek: 4 717 088
Heap memory[PS Old Gen]: max: 2 863 333 376; used: 6 180 256; peek: 9 319 920
Non-heap memory[PS Perm Gen]: max: 85 983 232; used: 26 247 176; peek: 26 247 176
Thread count: 1018
Trees in cache: 3
Periodic tasks executed: 1710; active: 0
Urgent tasks executed: 1; active: 0
Connections pool to Master status Idle: 11; Active: 0; maxActive: 10000; maxIdle: 5000

Постоянно прилетают письма с таким содержанием

Код:

ID события: scheduler.periodic.task.run.skip
Время регистрации события: 14.11.2011 15:30:03

В рамках отведенного переменной scheduler.periodic.thread.count максимального числа одновременно запущенных потоков планировщик не смог запустить периодическую задачу с кодом 1.
Необходимо выяснить причину медленного завершения периодических задач, запущенных ранее

код 1 это рассыльщик почты

лог scheduler.error.log пуст

scheduller.log

Код:

11-14/16:30:03  INFO [Thread-8] LoggingPrintStream - Executing status
11-14/16:30:03  INFO [Thread-6] TaskExecuter - Starting periodic task ID: 1 bitel.billing.server.mail.MailSender
11-14/16:30:03  INFO [Thread-6] TaskExecuter - Starting periodic task ID: 3 bitel.billing.server.ipn.IPNTestGates
11-14/16:30:03  INFO [Thread-6] TaskExecuter - Starting periodic task ID: 6 ru.bitel.bgbilling.plugins.helpdesk.server.task.NewMessageChecker
11-14/16:30:03  INFO [Thread-6] TaskExecuter - Starting periodic task ID: 7 ru.bitel.bgbilling.plugins.helpdesk.server.task.TopicAvtoClosedTask
11-14/16:30:03  INFO [Thread-6] TaskExecuter - Starting periodic task ID: 11 bitel.billing.server.ipn.LogCalculator
11-14/16:30:03  INFO [pool-2-thread-708] NewMessageChecker - Task finished time=3 ms.
11-14/16:30:03  INFO [pool-2-thread-710] TopicAvtoClosedTask - Task finished time=3 ms.
11-14/16:30:03  INFO [pool-2-thread-704] MailSender - Task finished time=13 ms.
11-14/16:30:03  INFO [pool-2-thread-709] LogCalculator - Difficult mode INIT
11-14/16:30:03  INFO [pool-2-thread-705] IPNTestGates - Locked clients:
11-14/16:30:03  INFO [pool-2-thread-705] IPNTestGates - 
11-14/16:30:03  INFO [pool-2-thread-705] IPNTestGates - Task finished time=128 ms.
11-14/16:30:03 ERROR [pool-2-thread-709] LogCalculator - Tree not found for contract id: 11354
11-14/16:30:03 ERROR [pool-2-thread-709] LogCalculator - Tree not found for contract id: 11354
11-14/16:30:03 ERROR [pool-2-thread-709] LogCalculator - Tree not found for contract id: 11354
11-14/16:30:03 ERROR [pool-2-thread-709] LogCalculator - Tree not found for contract id: 11354
11-14/16:30:03 ERROR [pool-2-thread-709] LogCalculator - Tree not found for contract id: 11354
11-14/16:30:03 ERROR [pool-2-thread-709] LogCalculator - Tree not found for contract id: 11354
11-14/16:30:03 ERROR [pool-2-thread-709] LogCalculator - Tree not found for contract id: 11354
11-14/16:30:03 ERROR [pool-2-thread-709] LogCalculator - Tree not found for contract id: 11354
11-14/16:30:03 ERROR [pool-2-thread-709] LogCalculator - Tree not found for contract id: 11354
11-14/16:30:03  INFO [pool-2-thread-709] LogCalculator - Init time => 221 ms
11-14/16:30:03  INFO [pool-2-thread-709] LogCalculator - Processing..
11-14/16:30:03  INFO [pool-2-thread-709] LogCalculator - Select records time=6 ms.
11-14/16:30:04  INFO [pool-2-thread-709] LogCalculator - Records processing time=126 ms.
11-14/16:30:04 ERROR [pool-2-thread-709] LogCalculator - Detected errors => 1409
11-14/16:30:04  INFO [pool-2-thread-709] LogCalculator - Setting balances for independ and subs..
11-14/16:30:04  INFO [pool-2-thread-709] LogCalculator - Task finished time=638 ms.
11-14/16:36:18  INFO [Thread-8] LoggingPrintStream - Executing status

Вернуться к началу

dimOn

Заголовок сообщения: Re: [BGScheduler] Не удалось запустить периодическую задачу

Добавлено: 14 ноя 2011, 18:30

Зарегистрирован: 30 май 2008, 15:51
Сообщения: 6055
Карма: 244

Не уверен имеет ли это какое-либо отношение к обсуждаемому, но в одном из

Цитата:

Время регистрации события: 14.11.2011 15:30:03

Цитата:

11-14/16:30:03 INFO

направильно настроены таймзоны

_________________
I'm clever. I've got a computer.

Вернуться к началу

jack7

Заголовок сообщения: Re: [BGScheduler] Не удалось запустить периодическую задачу

Добавлено: 14 ноя 2011, 19:20

Цитата:

# date
Пнд Ноя 14 19:17:41 YEKT 2011
# ./radius.sh status
version 5.1 build 243 from 06.12.2010 12:22:10
14.11.2011 19:17:48 5558 5558 0 0
Request accounts per minute start: 81; stop: 164; update: 5647
Request auths per minute accept: 81; reject: 56
Netfow packets per minute: 65617
Ignore per minute auth: 0; update: 0
Antispam ban count: 1; used per minute: 25
FlowListener: queue_size: 0; threads_active: 0; largest: 100; core: 100; pool_size: 100; recv_socket_buf_size: 131 071; recv_buf_size: 8 388 608; packets: 0
FlowListener: queue_size: 0; threads_active: 0; largest: 100; core: 100; pool_size: 100; recv_socket_buf_size: 131 071; recv_buf_size: 8 388 608; packets: 0
FlowListener: queue_size: 0; threads_active: 0; largest: 100; core: 100; pool_size: 100; recv_socket_buf_size: 131 071; recv_buf_size: 8 388 608; packets: 0
FlowListener: queue_size: 0; threads_active: 0; largest: 100; core: 100; pool_size: 100; recv_socket_buf_size: 131 071; recv_buf_size: 8 388 608; packets: 21850
Started: 31.10.2011 13:42:10 Uptime: 14 d 05:35:37
Memory total: 290 521 088; max: 3 817 799 680; free: 18 474 952
Memory pools:
Non-heap memory[Code Cache]: max: 50 331 648; used: 10 828 352; peek: 10 838 976
Heap memory[PS Eden Space]: max: 1 423 245 312; used: 67 669 592; peek: 1 407 909 888
Heap memory[PS Survivor Space]: max: 4 128 768; used: 3 686 448; peek: 52 810 000
Heap memory[PS Old Gen]: max: 2 863 333 376; used: 200 690 096; peek: 395 961 864
Non-heap memory[PS Perm Gen]: max: 85 983 232; used: 26 776 872; peek: 26 866 688
Thread count: 671
Trees in cache: 15
Connections pool to Master status Idle: 194; Active: 0; maxActive: 10000; maxIdle: 5000
# echo $JAVA_HOME
/opt/java/jre
#

JAVA_HOME везде в скриптах используется
патч ставил для java еще в октябре

где у меня может быть неправильно?

Вернуться к началу

stark

Заголовок сообщения: Re: [BGScheduler] Не удалось запустить периодическую задачу

Добавлено: 14 ноя 2011, 19:43

Разработчик

Зарегистрирован: 08 ноя 2007, 01:05
Сообщения: 8343
Откуда: Уфа
Карма: 238

Если такое случиться, вызовите jstack(входит в jdk) для процесса шедулера и результат покажите тут . B еще в клиенте есть вкладка - состояние планировщика , можно посмотреть какие задачи сейчас запущены.

Вернуться к началу

stark

Заголовок сообщения: Re: [BGScheduler] Не удалось запустить периодическую задачу

Добавлено: 14 ноя 2011, 19:45

Разработчик

Зарегистрирован: 08 ноя 2007, 01:05
Сообщения: 8343
Откуда: Уфа
Карма: 238

jack7 писал(а):

Цитата:

JAVA_HOME везде в скриптах используется
патч ставил для java еще в октябре

где у меня может быть неправильно?

Логи из планировщика , а статус радиуса ..Причем он работает 14 дней . Вы тогда уж статус планировщика покажите и перезагружали ли вы его с 31-го числа ?

Вернуться к началу

jack7

Заголовок сообщения: Re: [BGScheduler] Не удалось запустить периодическую задачу

Добавлено: 14 ноя 2011, 20:02

Цитата:

# date
Пнд Ноя 14 20:00:28 YEKT 2011
# ./scheduler.sh -estop
Sending 'stop' on 127.0.0.1:9066
Result: ok
# ./scheduler.sh -estart
# ./scheduler.sh -estatus
Sending 'status' on 127.0.0.1:9066
Result: TaskExecuter working
Started: 14.11.2011 20:00:59 Uptime: 0 d 00:00:18
Memory total: 252 575 744; max: 3 817 799 680; free: 214 230 152
Memory pools:
Non-heap memory[Code Cache]: max: 50 331 648; used: 730 176; peek: 736 000
Heap memory[PS Eden Space]: max: 1 409 744 896; used: 38 345 592; peek: 38 345 592
Heap memory[PS Survivor Space]: max: 10 944 512; used: 0; peek: 0
Heap memory[PS Old Gen]: max: 2 863 333 376; used: 0; peek: 0
Non-heap memory[PS Perm Gen]: max: 85 983 232; used: 14 777 760; peek: 14 777 760
Thread count: 13
Trees in cache: 0
Periodic tasks executed: 0; active: 0
Urgent tasks executed: 0; active: 0
Connections pool to Master status Idle: 2; Active: 0; maxActive: 10000; maxIdle: 5000

Вернуться к началу

jack7

Заголовок сообщения: Re: [BGScheduler] Не удалось запустить периодическую задачу

Добавлено: 14 ноя 2011, 20:34

Цитата:

2011-11-14 20:31:45
Full thread dump Java HotSpot(TM) 64-Bit Server VM (20.2-b06 mixed mode):

"Attach Listener" daemon prio=10 tid=0x0000000041339000 nid=0x4c5c waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE

"InactivityMonitor Async Task: java.util.concurrent.ThreadPoolExecutor$Worker@67ee75a5" daemon prio=10 tid=0x00007fcde4159000 nid=0x4c37 waiting on condition [0x00007fcdeb8f7000]
java.lang.Thread.State: TIMED_WAITING (parking)
at sun.misc.Unsafe.park(Native Method)
- parking to wait for <0x00000007002cf310> (a java.util.concurrent.SynchronousQueue$TransferStack)
at java.util.concurrent.locks.LockSupport.parkNanos(Unknown Source)
at java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(Unknown Source)
at java.util.concurrent.SynchronousQueue$TransferStack.transfer(Unknown Source)
at java.util.concurrent.SynchronousQueue.poll(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor.getTask(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
at java.lang.Thread.run(Unknown Source)

"pool-2-thread-8" prio=10 tid=0x000000004133d000 nid=0x4a4f waiting on condition [0x00007fcdebaf9000]
java.lang.Thread.State: WAITING (parking)
at sun.misc.Unsafe.park(Native Method)
- parking to wait for <0x0000000700007d00> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
at java.util.concurrent.locks.LockSupport.park(Unknown Source)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(Unknown Source)
at java.util.concurrent.LinkedBlockingQueue.take(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor.getTask(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
at java.lang.Thread.run(Unknown Source)

"pool-2-thread-7" prio=10 tid=0x000000004127c000 nid=0x4a4e waiting on condition [0x00007fcdebbfa000]
java.lang.Thread.State: WAITING (parking)
at sun.misc.Unsafe.park(Native Method)
- parking to wait for <0x0000000700007d00> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
at java.util.concurrent.locks.LockSupport.park(Unknown Source)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(Unknown Source)
at java.util.concurrent.LinkedBlockingQueue.take(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor.getTask(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
at java.lang.Thread.run(Unknown Source)

"pool-2-thread-6" prio=10 tid=0x0000000041832800 nid=0x4a4d waiting on condition [0x00007fcdf04ac000]
java.lang.Thread.State: WAITING (parking)
at sun.misc.Unsafe.park(Native Method)
- parking to wait for <0x0000000700007d00> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
at java.util.concurrent.locks.LockSupport.park(Unknown Source)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(Unknown Source)
at java.util.concurrent.LinkedBlockingQueue.take(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor.getTask(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
at java.lang.Thread.run(Unknown Source)

"pool-2-thread-5" prio=10 tid=0x0000000041780800 nid=0x4a4c waiting on condition [0x00007fcdf03ab000]
java.lang.Thread.State: WAITING (parking)
at sun.misc.Unsafe.park(Native Method)
- parking to wait for <0x0000000700007d00> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
at java.util.concurrent.locks.LockSupport.park(Unknown Source)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(Unknown Source)
at java.util.concurrent.LinkedBlockingQueue.take(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor.getTask(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
at java.lang.Thread.run(Unknown Source)

"pool-2-thread-4" prio=10 tid=0x0000000041779800 nid=0x4a4b waiting on condition [0x00007fcdebcfb000]
java.lang.Thread.State: WAITING (parking)
at sun.misc.Unsafe.park(Native Method)
- parking to wait for <0x0000000700007d00> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
at java.util.concurrent.locks.LockSupport.park(Unknown Source)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(Unknown Source)
at java.util.concurrent.LinkedBlockingQueue.take(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor.getTask(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
at java.lang.Thread.run(Unknown Source)

"ActiveMQ Scheduler" daemon prio=10 tid=0x00007fcde406c800 nid=0x4256 in Object.wait() [0x00007fcdebffe000]
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0x0000000700000108> (a java.util.TaskQueue)
at java.lang.Object.wait(Object.java:485)
at java.util.TimerThread.mainLoop(Unknown Source)
- locked <0x0000000700000108> (a java.util.TaskQueue)
at java.util.TimerThread.run(Unknown Source)

"InactivityMonitor WriteCheck" daemon prio=10 tid=0x0000000041281000 nid=0x424f in Object.wait() [0x00007fcdebdfc000]
java.lang.Thread.State: TIMED_WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0x0000000700007c40> (a java.util.TaskQueue)
at java.util.TimerThread.mainLoop(Unknown Source)
- locked <0x0000000700007c40> (a java.util.TaskQueue)
at java.util.TimerThread.run(Unknown Source)

"InactivityMonitor ReadCheck" daemon prio=10 tid=0x000000004123d800 nid=0x424e in Object.wait() [0x00007fcdebefd000]
java.lang.Thread.State: TIMED_WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0x0000000700000240> (a java.util.TaskQueue)
at java.util.TimerThread.mainLoop(Unknown Source)
- locked <0x0000000700000240> (a java.util.TaskQueue)
at java.util.TimerThread.run(Unknown Source)

"Selector Worker: 0" daemon prio=10 tid=0x00000000417a9800 nid=0x4249 runnable [0x00007fcdf01a2000]
java.lang.Thread.State: RUNNABLE
at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method)
at sun.nio.ch.EPollArrayWrapper.poll(Unknown Source)
at sun.nio.ch.EPollSelectorImpl.doSelect(Unknown Source)
at sun.nio.ch.SelectorImpl.lockAndDoSelect(Unknown Source)
- locked <0x0000000700000380> (a sun.nio.ch.Util$2)
- locked <0x0000000700000390> (a java.util.Collections$UnmodifiableSet)
- locked <0x0000000700000338> (a sun.nio.ch.EPollSelectorImpl)
at sun.nio.ch.SelectorImpl.select(Unknown Source)
at org.apache.activemq.transport.nio.SelectorWorker.run(SelectorWorker.java:93)
at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
at java.lang.Thread.run(Unknown Source)

"pool-2-thread-3" prio=10 tid=0x00000000417d8000 nid=0x41ba waiting on condition [0x00007fcdf05ad000]
java.lang.Thread.State: WAITING (parking)
at sun.misc.Unsafe.park(Native Method)
- parking to wait for <0x0000000700007d00> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
at java.util.concurrent.locks.LockSupport.park(Unknown Source)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(Unknown Source)
at java.util.concurrent.LinkedBlockingQueue.take(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor.getTask(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
at java.lang.Thread.run(Unknown Source)

"pool-2-thread-2" prio=10 tid=0x00000000417f2800 nid=0x41b9 waiting on condition [0x00007fcdf06ae000]
java.lang.Thread.State: WAITING (parking)
at sun.misc.Unsafe.park(Native Method)
- parking to wait for <0x0000000700007d00> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
at java.util.concurrent.locks.LockSupport.park(Unknown Source)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(Unknown Source)
at java.util.concurrent.LinkedBlockingQueue.take(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor.getTask(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
at java.lang.Thread.run(Unknown Source)

"pool-2-thread-1" prio=10 tid=0x000000004119d000 nid=0x41b8 waiting on condition [0x00007fcdf07af000]
java.lang.Thread.State: WAITING (parking)
at sun.misc.Unsafe.park(Native Method)
- parking to wait for <0x0000000700007d00> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
at java.util.concurrent.locks.LockSupport.park(Unknown Source)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(Unknown Source)
at java.util.concurrent.LinkedBlockingQueue.take(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor.getTask(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
at java.lang.Thread.run(Unknown Source)

"DestroyJavaVM" prio=10 tid=0x00007fcde4069800 nid=0x3a18 waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE

"Thread-13" prio=10 tid=0x00007fcde4067800 nid=0x3a32 waiting on condition [0x00007fcdf08b0000]
java.lang.Thread.State: TIMED_WAITING (sleeping)
at java.lang.Thread.sleep(Native Method)
at bitel.billing.server.admin.eventbus.BillingEventBus$ListenerThread.run(BillingEventBus.java:242)

"Thread-12" prio=10 tid=0x00007fcde4200800 nid=0x3a31 waiting on condition [0x00007fcdf09b1000]
java.lang.Thread.State: TIMED_WAITING (sleeping)
at java.lang.Thread.sleep(Native Method)
at bitel.billing.server.admin.eventbus.BillingEventBus$PublishThread.run(BillingEventBus.java:101)

"Thread-6" prio=10 tid=0x00000000417e5800 nid=0x3a30 waiting on condition [0x00007fcdf0ab2000]
java.lang.Thread.State: TIMED_WAITING (sleeping)
at java.lang.Thread.sleep(Native Method)
at bitel.billing.server.TaskExecuter.run(TaskExecuter.java:202)

"Thread-11" prio=10 tid=0x00000000417a1000 nid=0x3a2f waiting on condition [0x00007fcdf0bb3000]
java.lang.Thread.State: TIMED_WAITING (sleeping)
at java.lang.Thread.sleep(Native Method)
at bitel.billing.server.admin.errorlog.AlarmSender.run(AlarmSender.java:222)

"Thread-10" prio=10 tid=0x000000004184c000 nid=0x3a2e waiting on condition [0x00007fcdf0dbb000]
java.lang.Thread.State: TIMED_WAITING (sleeping)
at java.lang.Thread.sleep(Native Method)
at bitel.billing.server.task.TaskRunProcessor.run(TaskRunProcessor.java:68)

"Thread-8" prio=10 tid=0x00000000417f4800 nid=0x3a2d runnable [0x00007fcdf0ebc000]
java.lang.Thread.State: RUNNABLE
at java.net.PlainSocketImpl.socketAccept(Native Method)
at java.net.PlainSocketImpl.accept(Unknown Source)
- locked <0x0000000700047890> (a java.net.SocksSocketImpl)
at java.net.ServerSocket.implAccept(Unknown Source)
at java.net.ServerSocket.accept(Unknown Source)
at bitel.billing.server.util.manager.ProcessManager.run(ProcessManager.java:39)

"MySQL Statement Cancellation Timer" daemon prio=10 tid=0x0000000041774000 nid=0x3a2c in Object.wait() [0x00007fcdf0fbd000]
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0x0000000700047a30> (a java.util.TaskQueue)
at java.lang.Object.wait(Object.java:485)
at java.util.TimerThread.mainLoop(Unknown Source)
- locked <0x0000000700047a30> (a java.util.TaskQueue)
at java.util.TimerThread.run(Unknown Source)

"Thread-3" daemon prio=10 tid=0x00000000416fc800 nid=0x3a2b waiting on condition [0x00007fcdf14dd000]
java.lang.Thread.State: TIMED_WAITING (sleeping)
at java.lang.Thread.sleep(Native Method)
at org.apache.log4j.helpers.FileWatchdog.run(FileWatchdog.java:104)

"Dispatcher-Thread-4" daemon prio=10 tid=0x00000000416ca800 nid=0x3a2a waiting on condition [0x00007fcdf15de000]
java.lang.Thread.State: TIMED_WAITING (parking)
at sun.misc.Unsafe.park(Native Method)
- parking to wait for <0x0000000700047b60> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
at java.util.concurrent.locks.LockSupport.parkNanos(Unknown Source)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(Unknown Source)
at java.util.concurrent.LinkedBlockingQueue.poll(Unknown Source)
at ru.bitel.common.logging.Dispatcher.run(Log4jAsyncAppender.java:293)

"Low Memory Detector" daemon prio=10 tid=0x0000000041229000 nid=0x3a27 runnable [0x0000000000000000]
java.lang.Thread.State: RUNNABLE

"C2 CompilerThread1" daemon prio=10 tid=0x00007fcdec009800 nid=0x3a26 waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE

"C2 CompilerThread0" daemon prio=10 tid=0x00007fcdec006800 nid=0x3a25 waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE

"Signal Dispatcher" daemon prio=10 tid=0x0000000041225800 nid=0x3a24 runnable [0x0000000000000000]
java.lang.Thread.State: RUNNABLE

"Finalizer" daemon prio=10 tid=0x000000004120b800 nid=0x3a23 in Object.wait() [0x00007fcdf1fc5000]
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0x000000070004a5d0> (a java.lang.ref.ReferenceQueue$Lock)
at java.lang.ref.ReferenceQueue.remove(Unknown Source)
- locked <0x000000070004a5d0> (a java.lang.ref.ReferenceQueue$Lock)
at java.lang.ref.ReferenceQueue.remove(Unknown Source)
at java.lang.ref.Finalizer$FinalizerThread.run(Unknown Source)

"Reference Handler" daemon prio=10 tid=0x0000000041209000 nid=0x3a22 in Object.wait() [0x00007fcdf20c6000]
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0x00000007000006c0> (a java.lang.ref.Reference$Lock)
at java.lang.Object.wait(Object.java:485)
at java.lang.ref.Reference$ReferenceHandler.run(Unknown Source)
- locked <0x00000007000006c0> (a java.lang.ref.Reference$Lock)

"VM Thread" prio=10 tid=0x0000000041202800 nid=0x3a21 runnable

"GC task thread#0 (ParallelGC)" prio=10 tid=0x00000000411b0000 nid=0x3a19 runnable

"GC task thread#1 (ParallelGC)" prio=10 tid=0x00000000411b1800 nid=0x3a1a runnable

"GC task thread#2 (ParallelGC)" prio=10 tid=0x00000000411b3800 nid=0x3a1b runnable

"GC task thread#3 (ParallelGC)" prio=10 tid=0x00000000411b5800 nid=0x3a1c runnable

"GC task thread#4 (ParallelGC)" prio=10 tid=0x00000000411b7000 nid=0x3a1d runnable

"GC task thread#5 (ParallelGC)" prio=10 tid=0x00000000411b9000 nid=0x3a1e runnable

"GC task thread#6 (ParallelGC)" prio=10 tid=0x00000000411bb000 nid=0x3a1f runnable

"GC task thread#7 (ParallelGC)" prio=10 tid=0x00000000411bd000 nid=0x3a20 runnable

"VM Periodic Task Thread" prio=10 tid=0x0000000041233800 nid=0x3a28 waiting on condition

JNI global references: 1224

Вернуться к началу

jack7

Заголовок сообщения: Re: [BGScheduler] Не удалось запустить периодическую задачу

Добавлено: 14 ноя 2011, 22:56

в письме приходит некорректное время (на час запаздывает)

Цитата:

ID события: scheduler.periodic.task.run.skip
Время регистрации события: 14.11.2011 20:30:04

простой класс для проверки времени

Код:

$ cat DatePrint.java
import java.text.SimpleDateFormat;
import java.util.Date;
import java.util.*;

public class DatePrint {
    public static void main(String[] args) {
    Date dtn = new Date();
    SimpleDateFormat formatter1 = new SimpleDateFormat(
        "dd.MM.yyyy HH:mm:ss");
    String dt1=formatter1.format(dtn);
    System.out.println( dt1);
    }
}
$ javac DatePrint.java
$ echo $JAVA_HOME
/opt/java/jre
$ /opt/java/jre/bin/java DatePrint
14.11.2011 22:51:38
$ date
Пнд Ноя 14 22:51:40 YEKT 2011
$ 

в биллинге для это используется класс TimeUtils

Цитата:

/* 213 */ StringBuilder text = new StringBuilder(200);
/* 214 */ text.append("ID события: ");
/* 215 */ text.append(message.getKey());
/* 216 */ text.append("\n");
/* 217 */ text.append("Время регистрации события: ");
/* 218 */ text.append(TimeUtils.format(message.getRegistrationTime(), "dd.MM.yyyy HH:mm:ss"));
/* 219 */ text.append("\n\n");
/* 220 */ text.append(message.getText());

при этом в scheduler.log время корректное

Код:

$ cat log/scheduler.log  | grep "21:30"
11-14/21:30:01  INFO [Thread-6] TaskExecuter - Starting periodic task ID: 1 bitel.billing.server.mail.MailSender
11-14/21:30:01  INFO [Thread-6] TaskExecuter - Starting periodic task ID: 3 bitel.billing.server.ipn.IPNTestGates
11-14/21:30:01  INFO [Thread-6] TaskExecuter - Starting periodic task ID: 6 ru.bitel.bgbilling.plugins.helpdesk.server.task.NewMessageChecker
11-14/21:30:01  INFO [Thread-6] TaskExecuter - Starting periodic task ID: 7 ru.bitel.bgbilling.plugins.helpdesk.server.task.TopicAvtoClosedTask
11-14/21:30:01  INFO [Thread-6] TaskExecuter - Starting periodic task ID: 11 bitel.billing.server.ipn.LogCalculator
11-14/21:30:01  INFO [pool-2-thread-23] NewMessageChecker - Task finished time=3 ms.
11-14/21:30:01  INFO [pool-2-thread-24] TopicAvtoClosedTask - Task finished time=5 ms.
11-14/21:30:01  INFO [pool-2-thread-21] MailSender - Task finished time=10 ms.
11-14/21:30:01  INFO [pool-2-thread-22] IPNTestGates - Locked clients:
11-14/21:30:01  INFO [pool-2-thread-22] IPNTestGates - 
11-14/21:30:01  INFO [pool-2-thread-25] LogCalculator - Difficult mode INIT
11-14/21:30:01  INFO [pool-2-thread-22] IPNTestGates - Task finished time=83 ms.
11-14/21:30:01 ERROR [pool-2-thread-25] LogCalculator - Tree not found for contract id: 11354
11-14/21:30:01 ERROR [pool-2-thread-25] LogCalculator - Tree not found for contract id: 11354
11-14/21:30:01 ERROR [pool-2-thread-25] LogCalculator - Tree not found for contract id: 11354
11-14/21:30:01 ERROR [pool-2-thread-25] LogCalculator - Tree not found for contract id: 11354
11-14/21:30:01 ERROR [pool-2-thread-25] LogCalculator - Tree not found for contract id: 11354
11-14/21:30:01 ERROR [pool-2-thread-25] LogCalculator - Tree not found for contract id: 11354
11-14/21:30:01 ERROR [pool-2-thread-25] LogCalculator - Tree not found for contract id: 11354
11-14/21:30:01 ERROR [pool-2-thread-25] LogCalculator - Tree not found for contract id: 11354
11-14/21:30:01 ERROR [pool-2-thread-25] LogCalculator - Tree not found for contract id: 11354
11-14/21:30:01  INFO [pool-2-thread-25] LogCalculator - Init time => 179 ms
11-14/21:30:01  INFO [pool-2-thread-25] LogCalculator - Processing..
11-14/21:30:01  INFO [pool-2-thread-25] LogCalculator - Select records time=4 ms.
11-14/21:30:01  INFO [pool-2-thread-25] LogCalculator - Records processing time=138 ms.
11-14/21:30:01 ERROR [pool-2-thread-25] LogCalculator - Detected errors => 1429
11-14/21:30:02  INFO [pool-2-thread-25] LogCalculator - Setting balances for independ and subs..
11-14/21:30:02  INFO [pool-2-thread-25] LogCalculator - Task finished time=869 ms.
11-14/21:30:04  INFO [Thread-8] LoggingPrintStream - Executing status

Вернуться к началу

jack7

Заголовок сообщения: Re: [BGScheduler] Не удалось запустить периодическую задачу

Добавлено: 15 ноя 2011, 01:37

можно проверить через action ЛК такой

Код:

package bitel.billing.server.contract.action.web;

import java.io.*;
import java.util.*;
import java.sql.ResultSet;
import bitel.billing.common.TimeUtils;
import bitel.billing.server.contract.bean.*;
import bitel.billing.server.script.bean.event.Event.*;
import bitel.billing.server.contract.action.base.ActionBase;
import java.text.SimpleDateFormat;

public final class ActionDate extends ActionBase
{
    public void doAction()
    {  
        Date dtn = new Date();
        SimpleDateFormat formatter1 = new SimpleDateFormat(
               "dd.MM.yyyy HH:mm:ss");
        String dt1=formatter1.format(dtn);
        System.out.println( dt1);
    };
};

делаю запрос с action=Date и вижу в логах

Код:

# tail -1 server.log
11-15/01:32:56  INFO [http-8080-43] LoggingPrintStream - 15.11.2011 01:32:56
# date
Втр Ноя 15 01:33:03 YEKT 2011
# 

Вернуться к началу

dimOn

Заголовок сообщения: Re: [BGScheduler] Не удалось запустить периодическую задачу

Добавлено: 15 ноя 2011, 14:19

Зарегистрирован: 30 май 2008, 15:51
Сообщения: 6055
Карма: 244

так почему тогда время то отличается? вывод - при форматировании таймзона берётся некорректная!

_________________
I'm clever. I've got a computer.

Вернуться к началу

jack7

Заголовок сообщения: Re: [BGScheduler] Не удалось запустить периодическую задачу

Добавлено: 15 ноя 2011, 14:38

1) в моем случае сервер синхронизирован по времени с помощью ntpdate
руками время не ставил - если зона выставлена неверно, то при каждой синхронизации время слетало бы по поясу - у меня этого нет

2) откуда берет настройку зоны класс TimeUtils, если стандартный класс (в примере выше показан) показывает время идентичное с системным?

3) разница в 1 час всплывает только в письмах от планировщика, в клиенте, логах всех служб биллинга (в том числе и в логе планировщика) время идентично системному

понимаю что возможно достал глупыми вопросами (извините в таком случае) - но для меня важно найти решение своей проблемы

Вернуться к началу

dimOn

Заголовок сообщения: Re: [BGScheduler] Не удалось запустить периодическую задачу

Добавлено: 15 ноя 2011, 16:05

Зарегистрирован: 30 май 2008, 15:51
Сообщения: 6055
Карма: 244

класс TimeUtils форматирует дату и время точно таким же кодом, как у вас в примерах, через SimpleDateFormat итд. То есть буерутся обычные tz из явы.
А под нужной явой точно запускаете приложение и ваши примеры?

_________________
I'm clever. I've got a computer.

Вернуться к началу

jack7

Заголовок сообщения: Re: [BGScheduler] Не удалось запустить периодическую задачу

Добавлено: 15 ноя 2011, 17:17

все примеры и биллинг запускаются через JAVA_HOME (в постах показано)

Вернуться к началу

skyb

Заголовок сообщения: Re: [BGScheduler] Не удалось запустить периодическую задачу

Добавлено: 15 ноя 2011, 17:19

Клиент

Зарегистрирован: 03 авг 2009, 18:42
Сообщения: 7166
Откуда: Благовещенск
Карма: 241

А шедулер ребутили после обновлении явы?

_________________

Код:

  Клиент: вер. 6.2.714 / 25.05.2015 17:27:15
    os: Linux; java: Java HotSpot(TM) 64-Bit Server VM, v.1.8.0_45
  Сервер: вер. 6.2.881 / 22.05.2015 17:56:55
    os: Linux; java: Java HotSpot(TM) 64-Bit Server VM, v.1.8.0_45

Помощь по администрированию bgbilling в jabber конференции или Группа в telegram
Стиль программирования - пьяный мастерстер
Разработка мобильных приложений

Вернуться к началу

jack7

Заголовок сообщения: Re: [BGScheduler] Не удалось запустить периодическую задачу

Добавлено: 15 ноя 2011, 17:22

skyb писал(а):

А шедулер ребутили после обновлении явы?

это первое, что я попробовал

Вернуться к началу

jack7

Заголовок сообщения: Re: [BGScheduler] Не удалось запустить периодическую задачу

Добавлено: 15 ноя 2011, 17:34

вот к примеру

запускаю простой класс с выводом даты

Код:

$ /opt/java/jre/bin/java -verbose DatePrint | grep Date
[Loaded DatePrint from file:/home/j4ck/scripts/]
[Loaded java.util.Date from /opt/java/jre1.6.0_27/lib/rt.jar]
[Loaded java.text.DateFormat from /opt/java/jre1.6.0_27/lib/rt.jar]
[Loaded java.text.SimpleDateFormat from /opt/java/jre1.6.0_27/lib/rt.jar]
[Loaded java.text.DateFormat$Field from /opt/java/jre1.6.0_27/lib/rt.jar]
[Loaded sun.util.calendar.CalendarDate from /opt/java/jre1.6.0_27/lib/rt.jar]
[Loaded sun.util.calendar.BaseCalendar$Date from /opt/java/jre1.6.0_27/lib/rt.jar]
[Loaded sun.util.calendar.Gregorian$Date from /opt/java/jre1.6.0_27/lib/rt.jar]
[Loaded java.text.DateFormatSymbols from /opt/java/jre1.6.0_27/lib/rt.jar]
[Loaded java.text.spi.DateFormatSymbolsProvider from /opt/java/jre1.6.0_27/lib/rt.jar]

теперь где лежит ява

Код:

$ echo $JAVA_HOME
/opt/java/jre
$ ls -la /opt/java/
итого 16
drwxr-xr-x 3 root root 4096 Сен 16 21:54 .
drwxr-xr-x 5 root root 4096 Авг 22 13:12 ..
lrwxrwxrwx 1 root root   11 Сен 16 21:54 jre -> jre1.6.0_27
drwxr-xr-x 8 root root 4096 Сен 15 11:14 jre1.6.0_27

шедулер запускается также через JAVA_HOME

Код:

$ nohup  ${JAVA_HOME}/bin/java -Dapp.name=BGScheduler -Xmx4096m -cp ${CLASSPATH} ru.bitel.common.bootstrap.Boot bitel.billing.server.TaskExecuter $1 $2 $3 > ./log/scheduler.out 2>&1 & echo $! > .run/bgscheduler.pid 

как видно ява используется одна

Вернуться к началу

jack7

Заголовок сообщения: Re: [BGScheduler] Не удалось запустить периодическую задачу

Добавлено: 16 ноя 2011, 11:38

проблема скрывалась в настройках java (может кому-нибудь поможет)
специфично для дистрибутива Debian Linux

в системе установлено две java: JDK и JRE
в JAVA_HOME указан путь до JRE, он же указан во всех скриптах биллинга
в системе используется update-alterantives (для выбора нескольких вариантов ПО)
если java запускать без указания полного пути запускается java из JDK
перенастроил для использования по умолчанию java из JRE, перезапустил планировщик и время в письмах и в логах планировщика стало совпадать.

Вернуться к началу

dimOn

Заголовок сообщения: Re: [BGScheduler] Не удалось запустить периодическую задачу

Добавлено: 16 ноя 2011, 11:59

Зарегистрирован: 30 май 2008, 15:51
Сообщения: 6055
Карма: 244

Ну вот и решение всё же, так и оказалось.

А alterantives используется не только в debian, а также в федоре и многих других, потому и сказано, что пользоваться не какой-то там "системной без пути", а напрямую всё прописывать до нужной JRE!

_________________
I'm clever. I've got a computer.

Вернуться к началу

jack7

Заголовок сообщения: Re: [BGScheduler] Не удалось запустить периодическую задачу

Добавлено: 16 ноя 2011, 14:51

dimOn, загвоздка в том что во всех скриптах установлена JAVA_HOME как начало запускаемой программы

Код:

${JAVA_HOME}/bin/java

а JAVA_HOME имеет абсолютный путь /opt/java/jre
а относительным путем никогда не пользовался

Вернуться к началу

Страница 1 из 1

[ Сообщений: 19 ]

Список форумов » BGBilling » Ядро системы

Часовой пояс: UTC + 5 часов [ Летнее время ]

Кто сейчас на конференции

Сейчас этот форум просматривают: нет зарегистрированных пользователей и гости: 1

Вы не можете начинать темы
Вы не можете отвечать на сообщения
Вы не можете редактировать свои сообщения
Вы не можете удалять свои сообщения
Вы не можете добавлять вложения

Перейти:

BiTel

[BGScheduler] Не удалось запустить периодическую задачу

Кто сейчас на конференции