Discussion:
Problem with Timer Connector
(too old to reply)
Andre Crespo
2017-11-08 19:31:57 UTC
Permalink
Raw Message
I have a problem with timer connector in a AL running as windows service. This is occuring rarely but i can't detect this problem until try to run other AL and receive a message that TDI is already running on port 1099.

Here is the log. The exception is on try to wait the next time to run. The timer connector runs several times with the same problem until I stop/start the windows service and the AL runs ok after that. Anyone already had this problem? I am running TDI 7.2

LOG (portuguese language):

2017-11-08 15:10:05,528 INFO [org.apache.log4j.DailyRollingFileAppender.fe3b421c-617b-419a-a37b-c4e3bf70251c] - CTGDIS967I Linha de Montagem iniciada pelo CE7.
2017-11-08 15:10:05,528 INFO [org.apache.log4j.DailyRollingFileAppender.fe3b421c-617b-419a-a37b-c4e3bf70251c] - CTGDIS255I A Linha de Montagem AssemblyLines/CE7_BAC_Schedule_63ATIVO foi iniciada.
2017-11-08 15:10:05,684 INFO [org.apache.log4j.DailyRollingFileAppender.fe3b421c-617b-419a-a37b-c4e3bf70251c] - [Timer] CTGDIU009I Parâmetro 'schedule' convertido para o formato mascarado: '* * * 22 02'.
2017-11-08 15:10:05,700 INFO [org.apache.log4j.DailyRollingFileAppender.fe3b421c-617b-419a-a37b-c4e3bf70251c] - CTGDIS087I Iterando.
2017-11-08 15:10:05,700 INFO [org.apache.log4j.DailyRollingFileAppender.fe3b421c-617b-419a-a37b-c4e3bf70251c] - [Timer] CTGDIU012I A próxima execução do Conector do Cronômetro será às 'Wed Nov 08 22:02:00 BRST 2017'.
2017-11-08 15:15:13,046 ERROR [org.apache.log4j.DailyRollingFileAppender.fe3b421c-617b-419a-a37b-c4e3bf70251c] - [Timer] CTGDIS810E handleException - não é possível manipular a exceção, get
java.lang.InterruptedException
at java.lang.Thread.sleep(Native Method)
at java.lang.Thread.sleep(Thread.java:904)
at com.ibm.di.connector.TimerConnector.doWait(TimerConnector.java:393)
at com.ibm.di.connector.TimerConnector.calcNextRun(TimerConnector.java:363)
at com.ibm.di.connector.TimerConnector.getNextEntry(TimerConnector.java:143)
at com.ibm.di.server.AssemblyLineComponent.executeOperation(AssemblyLineComponent.java:3372)
at com.ibm.di.server.AssemblyLineComponent.getnext(AssemblyLineComponent.java:932)
at com.ibm.di.server.AssemblyLine.msGetNextIteratorEntry(AssemblyLine.java:3715)
at com.ibm.di.server.AssemblyLine.executeMainStep(AssemblyLine.java:3414)
at com.ibm.di.server.AssemblyLine.executeMainLoop(AssemblyLine.java:3026)
at com.ibm.di.server.AssemblyLine.executeMainLoop(AssemblyLine.java:3009)
at com.ibm.di.server.AssemblyLine.executeAL(AssemblyLine.java:2975)
at com.ibm.di.server.AssemblyLine.run(AssemblyLine.java:1338)
2017-11-08 15:15:13,046 INFO [org.apache.log4j.DailyRollingFileAppender.fe3b421c-617b-419a-a37b-c4e3bf70251c] - CTGDIS100I Imprimindo as estatísticas do Conector.
2017-11-08 15:15:13,046 INFO [org.apache.log4j.DailyRollingFileAppender.fe3b421c-617b-419a-a37b-c4e3bf70251c] - [Timer] Errors:1
2017-11-08 15:15:13,046 INFO [org.apache.log4j.DailyRollingFileAppender.fe3b421c-617b-419a-a37b-c4e3bf70251c] - [Script] Chamadas: 0
2017-11-08 15:15:13,046 INFO [org.apache.log4j.DailyRollingFileAppender.fe3b421c-617b-419a-a37b-c4e3bf70251c] - CTGDIS104I Total: Errors:1.
2017-11-08 15:15:13,046 INFO [org.apache.log4j.DailyRollingFileAppender.fe3b421c-617b-419a-a37b-c4e3bf70251c] - CTGDIS101I Impressão das estatísticas do Conector concluída.
2017-11-08 15:15:13,046 INFO [org.apache.log4j.DailyRollingFileAppender.fe3b421c-617b-419a-a37b-c4e3bf70251c] - CTGDIS080I Terminado com êxito (1 erros).
2017-11-08 15:16:19,219 INFO [org.apache.log4j.DailyRollingFileAppender.779b2faa-4dad-4b5c-9ef0-79d36b409355] - CTGDIS967I Linha de Montagem iniciada pelo CE7.
2017-11-08 15:16:19,219 INFO [org.apache.log4j.DailyRollingFileAppender.779b2faa-4dad-4b5c-9ef0-79d36b409355] - CTGDIS255I A Linha de Montagem AssemblyLines/CE7_BAC_Schedule_63ATIVO foi iniciada.
2017-11-08 15:16:19,422 INFO [org.apache.log4j.DailyRollingFileAppender.779b2faa-4dad-4b5c-9ef0-79d36b409355] - [Timer] CTGDIU009I Parâmetro 'schedule' convertido para o formato mascarado: '* * * 22 02'.
2017-11-08 15:16:19,422 INFO [org.apache.log4j.DailyRollingFileAppender.779b2faa-4dad-4b5c-9ef0-79d36b409355] - CTGDIS087I Iterando.
2017-11-08 15:16:19,422 INFO [org.apache.log4j.DailyRollingFileAppender.779b2faa-4dad-4b5c-9ef0-79d36b409355] - [Timer] CTGDIU012I A próxima execução do Conector do Cronômetro será às 'Wed Nov 08 22:02:00 BRST 2017'.
2017-11-08 16:58:07,145 ERROR [org.apache.log4j.DailyRollingFileAppender.779b2faa-4dad-4b5c-9ef0-79d36b409355] - [Timer] CTGDIS810E handleException - não é possível manipular a exceção, get
java.lang.InterruptedException
at java.lang.Thread.sleep(Native Method)
at java.lang.Thread.sleep(Thread.java:904)
at com.ibm.di.connector.TimerConnector.doWait(TimerConnector.java:393)
at com.ibm.di.connector.TimerConnector.calcNextRun(TimerConnector.java:363)
at com.ibm.di.connector.TimerConnector.getNextEntry(TimerConnector.java:143)
at com.ibm.di.server.AssemblyLineComponent.executeOperation(AssemblyLineComponent.java:3372)
at com.ibm.di.server.AssemblyLineComponent.getnext(AssemblyLineComponent.java:932)
at com.ibm.di.server.AssemblyLine.msGetNextIteratorEntry(AssemblyLine.java:3715)
at com.ibm.di.server.AssemblyLine.executeMainStep(AssemblyLine.java:3414)
at com.ibm.di.server.AssemblyLine.executeMainLoop(AssemblyLine.java:3026)
at com.ibm.di.server.AssemblyLine.executeMainLoop(AssemblyLine.java:3009)
at com.ibm.di.server.AssemblyLine.executeAL(AssemblyLine.java:2975)
at com.ibm.di.server.AssemblyLine.run(AssemblyLine.java:1338)
2017-11-08 16:58:07,145 INFO [org.apache.log4j.DailyRollingFileAppender.779b2faa-4dad-4b5c-9ef0-79d36b409355] - CTGDIS100I Imprimindo as estatísticas do Conector.
2017-11-08 16:58:07,145 INFO [org.apache.log4j.DailyRollingFileAppender.779b2faa-4dad-4b5c-9ef0-79d36b409355] - [Timer] Errors:1
2017-11-08 16:58:07,145 INFO [org.apache.log4j.DailyRollingFileAppender.779b2faa-4dad-4b5c-9ef0-79d36b409355] - [Script] Chamadas: 0
2017-11-08 16:58:07,145 INFO [org.apache.log4j.DailyRollingFileAppender.779b2faa-4dad-4b5c-9ef0-79d36b409355] - CTGDIS104I Total: Errors:1.
2017-11-08 16:58:07,145 INFO [org.apache.log4j.DailyRollingFileAppender.779b2faa-4dad-4b5c-9ef0-79d36b409355] - CTGDIS101I Impressão das estatísticas do Conector concluída.
2017-11-08 16:58:07,145 INFO [org.apache.log4j.DailyRollingFileAppender.779b2faa-4dad-4b5c-9ef0-79d36b409355] - CTGDIS080I Terminado com êxito (1 erros).
2017-11-08 16:59:13,005 INFO [org.apache.log4j.DailyRollingFileAppender.c8465854-e93f-4253-a662-8b1b42ac75f1] - CTGDIS967I Linha de Montagem iniciada pelo CE7.
2017-11-08 16:59:13,005 INFO [org.apache.log4j.DailyRollingFileAppender.c8465854-e93f-4253-a662-8b1b42ac75f1] - CTGDIS255I A Linha de Montagem AssemblyLines/CE7_BAC_Schedule_63ATIVO foi iniciada.
2017-11-08 16:59:13,176 INFO [org.apache.log4j.DailyRollingFileAppender.c8465854-e93f-4253-a662-8b1b42ac75f1] - [Timer] CTGDIU009I Parâmetro 'schedule' convertido para o formato mascarado: '* * * 22 02'.
2017-11-08 16:59:13,176 INFO [org.apache.log4j.DailyRollingFileAppender.c8465854-e93f-4253-a662-8b1b42ac75f1] - CTGDIS087I Iterando.
2017-11-08 16:59:13,176 INFO [org.apache.log4j.DailyRollingFileAppender.c8465854-e93f-4253-a662-8b1b42ac75f1] - [Timer] CTGDIU012I A próxima execução do Conector do Cronômetro será às 'Wed Nov 08 22:02:00 BRST 2017'.
2017-11-08 16:59:26,630 ERROR [org.apache.log4j.DailyRollingFileAppender.c8465854-e93f-4253-a662-8b1b42ac75f1] - [Timer] CTGDIS810E handleException - não é possível manipular a exceção, get
java.lang.InterruptedException
at java.lang.Thread.sleep(Native Method)
at java.lang.Thread.sleep(Thread.java:904)
at com.ibm.di.connector.TimerConnector.doWait(TimerConnector.java:393)
at com.ibm.di.connector.TimerConnector.calcNextRun(TimerConnector.java:363)
at com.ibm.di.connector.TimerConnector.getNextEntry(TimerConnector.java:143)
at com.ibm.di.server.AssemblyLineComponent.executeOperation(AssemblyLineComponent.java:3372)
at com.ibm.di.server.AssemblyLineComponent.getnext(AssemblyLineComponent.java:932)
at com.ibm.di.server.AssemblyLine.msGetNextIteratorEntry(AssemblyLine.java:3715)
at com.ibm.di.server.AssemblyLine.executeMainStep(AssemblyLine.java:3414)
at com.ibm.di.server.AssemblyLine.executeMainLoop(AssemblyLine.java:3026)
at com.ibm.di.server.AssemblyLine.executeMainLoop(AssemblyLine.java:3009)
at com.ibm.di.server.AssemblyLine.executeAL(AssemblyLine.java:2975)
at com.ibm.di.server.AssemblyLine.run(AssemblyLine.java:1338)
2017-11-08 16:59:26,630 INFO [org.apache.log4j.DailyRollingFileAppender.c8465854-e93f-4253-a662-8b1b42ac75f1] - CTGDIS100I Imprimindo as estatísticas do Conector.
2017-11-08 16:59:26,630 INFO [org.apache.log4j.DailyRollingFileAppender.c8465854-e93f-4253-a662-8b1b42ac75f1] - [Timer] Errors:1
2017-11-08 16:59:26,645 INFO [org.apache.log4j.DailyRollingFileAppender.c8465854-e93f-4253-a662-8b1b42ac75f1] - [Script] Chamadas: 0
2017-11-08 16:59:26,645 INFO [org.apache.log4j.DailyRollingFileAppender.c8465854-e93f-4253-a662-8b1b42ac75f1] - CTGDIS104I Total: Errors:1.
2017-11-08 16:59:26,645 INFO [org.apache.log4j.DailyRollingFileAppender.c8465854-e93f-4253-a662-8b1b42ac75f1] - CTGDIS101I Impressão das estatísticas do Conector concluída.
2017-11-08 16:59:26,645 INFO [org.apache.log4j.DailyRollingFileAppender.c8465854-e93f-4253-a662-8b1b42ac75f1] - CTGDIS080I Terminado com êxito (1 erros).
2017-11-08 17:00:32,630 INFO [org.apache.log4j.DailyRollingFileAppender.a5a046cd-212b-48fc-9001-10bea8509267] - CTGDIS967I Linha de Montagem iniciada pelo CE7.
2017-11-08 17:00:32,630 INFO [org.apache.log4j.DailyRollingFileAppender.a5a046cd-212b-48fc-9001-10bea8509267] - CTGDIS255I A Linha de Montagem AssemblyLines/CE7_BAC_Schedule_63ATIVO foi iniciada.
2017-11-08 17:00:32,802 INFO [org.apache.log4j.DailyRollingFileAppender.a5a046cd-212b-48fc-9001-10bea8509267] - [Timer] CTGDIU009I Parâmetro 'schedule' convertido para o formato mascarado: '* * * 22 02'.
2017-11-08 17:00:32,802 INFO [org.apache.log4j.DailyRollingFileAppender.a5a046cd-212b-48fc-9001-10bea8509267] - CTGDIS087I Iterando.
2017-11-08 17:00:32,818 INFO [org.apache.log4j.DailyRollingFileAppender.a5a046cd-212b-48fc-9001-10bea8509267] - [Timer] CTGDIU012I A próxima execução do Conector do Cronômetro será às 'Wed Nov 08 22:02:00 BRST 2017'.
2017-11-08 17:09:48,510 INFO [org.apache.log4j.DailyRollingFileAppender.bc096cca-cb43-4516-acaa-e7d52130e920] - CTGDIS967I Linha de Montagem iniciada pelo CE7.
2017-11-08 17:09:48,510 INFO [org.apache.log4j.DailyRollingFileAppender.bc096cca-cb43-4516-acaa-e7d52130e920] - CTGDIS255I A Linha de Montagem AssemblyLines/CE7_BAC_Schedule_63ATIVO foi iniciada.
2017-11-08 17:09:48,682 INFO [org.apache.log4j.DailyRollingFileAppender.bc096cca-cb43-4516-acaa-e7d52130e920] - [Timer] CTGDIU009I Parâmetro 'schedule' convertido para o formato mascarado: '* * * 22 02'.
2017-11-08 17:09:48,682 INFO [org.apache.log4j.DailyRollingFileAppender.bc096cca-cb43-4516-acaa-e7d52130e920] - CTGDIS087I Iterando.
2017-11-08 17:09:48,682 INFO [org.apache.log4j.DailyRollingFileAppender.bc096cca-cb43-4516-acaa-e7d52130e920] - [Timer] CTGDIU012I A próxima execução do Conector do Cronômetro será às 'Wed Nov 08 22:02:00 BRST 2017'.
2017-11-08 17:10:13,979 ERROR [org.apache.log4j.DailyRollingFileAppender.bc096cca-cb43-4516-acaa-e7d52130e920] - [Timer] CTGDIS810E handleException - não é possível manipular a exceção, get
java.lang.InterruptedException
at java.lang.Thread.sleep(Native Method)
at java.lang.Thread.sleep(Thread.java:904)
at com.ibm.di.connector.TimerConnector.doWait(TimerConnector.java:393)
at com.ibm.di.connector.TimerConnector.calcNextRun(TimerConnector.java:363)
at com.ibm.di.connector.TimerConnector.getNextEntry(TimerConnector.java:143)
at com.ibm.di.server.AssemblyLineComponent.executeOperation(AssemblyLineComponent.java:3372)
at com.ibm.di.server.AssemblyLineComponent.getnext(AssemblyLineComponent.java:932)
at com.ibm.di.server.AssemblyLine.msGetNextIteratorEntry(AssemblyLine.java:3715)
at com.ibm.di.server.AssemblyLine.executeMainStep(AssemblyLine.java:3414)
at com.ibm.di.server.AssemblyLine.executeMainLoop(AssemblyLine.java:3026)
at com.ibm.di.server.AssemblyLine.executeMainLoop(AssemblyLine.java:3009)
at com.ibm.di.server.AssemblyLine.executeAL(AssemblyLine.java:2975)
at com.ibm.di.server.AssemblyLine.run(AssemblyLine.java:1338)
2017-11-08 17:10:13,979 INFO [org.apache.log4j.DailyRollingFileAppender.bc096cca-cb43-4516-acaa-e7d52130e920] - CTGDIS100I Imprimindo as estatísticas do Conector.
2017-11-08 17:10:13,979 INFO [org.apache.log4j.DailyRollingFileAppender.bc096cca-cb43-4516-acaa-e7d52130e920] - [Timer] Errors:1
2017-11-08 17:10:13,979 INFO [org.apache.log4j.DailyRollingFileAppender.bc096cca-cb43-4516-acaa-e7d52130e920] - [Script] Chamadas: 0
2017-11-08 17:10:13,979 INFO [org.apache.log4j.DailyRollingFileAppender.bc096cca-cb43-4516-acaa-e7d52130e920] - CTGDIS104I Total: Errors:1.
2017-11-08 17:10:13,979 INFO [org.apache.log4j.DailyRollingFileAppender.bc096cca-cb43-4516-acaa-e7d52130e920] - CTGDIS101I Impressão das estatísticas do Conector concluída.
2017-11-08 17:10:13,979 INFO [org.apache.log4j.DailyRollingFileAppender.bc096cca-cb43-4516-acaa-e7d52130e920] - CTGDIS080I Terminado com êxito (1 erros).
2017-11-08 17:11:20,589 INFO [org.apache.log4j.DailyRollingFileAppender.769aecaa-7517-47ca-939d-e9519e9b6f4a] - CTGDIS967I Linha de Montagem iniciada pelo CE7.
2017-11-08 17:11:20,604 INFO [org.apache.log4j.DailyRollingFileAppender.769aecaa-7517-47ca-939d-e9519e9b6f4a] - CTGDIS255I A Linha de Montagem AssemblyLines/CE7_BAC_Schedule_63ATIVO foi iniciada.
2017-11-08 17:11:20,776 INFO [org.apache.log4j.DailyRollingFileAppender.769aecaa-7517-47ca-939d-e9519e9b6f4a] - [Timer] CTGDIU009I Parâmetro 'schedule' convertido para o formato mascarado: '* * * 22 02'.
2017-11-08 17:11:20,776 INFO [org.apache.log4j.DailyRollingFileAppender.769aecaa-7517-47ca-939d-e9519e9b6f4a] - CTGDIS087I Iterando.
2017-11-08 17:11:20,776 INFO [org.apache.log4j.DailyRollingFileAppender.769aecaa-7517-47ca-939d-e9519e9b6f4a] - [Timer] CTGDIU012I A próxima execução do Conector do Cronômetro será às 'Wed Nov 08 22:02:00 BRST 2017'.
yn2000
2017-11-09 00:04:06 UTC
Permalink
Raw Message
Pretending I know Portuguese language, but my rookie mistake a long time ago is to leave this cmdoptions=-d line together with a line that define which AL to run (Note: in the ibmdiservice.props file) when building the Windows service. So, try rebuild the Windows service without cmdoptions=-d line
Rgds. YN.
Sufyan Khan
2017-11-09 05:49:08 UTC
Permalink
Raw Message
I cannot understand anything from logs as it is in different language so can you show me how did you configure timer connector also have you configured Autostart for the AL having Timer Connector?
Loading...