qkAcXjFT

1SLF4J: Class path contains multiple SLF4J bindings.
2SLF4J: Found binding in [jar:file:/opt/tomcat6/webapps/cpgu/WEB-INF/lib/logback-classic-1.0.13.jar!/org/slf4j/impl/StaticLoggerBinder.class]
3SLF4J: Found binding in [jar:file:/opt/tomcat6/webapps/cpgu/WEB-INF/lib/slf4j-simple-1.7.5.jar!/org/slf4j/impl/StaticLoggerBinder.class]
4SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation.
523:26:54,708 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [/opt/tomcat6/conf/logback.xml] at [file:/opt/tomcat6/conf/logback.xml]
623:26:55,102 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - debug attribute not set
723:26:55,253 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
823:26:55,278 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [FILE]
923:26:55,466 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@11:24 - no applicable action for [totalSizeCap], current ElementPath  is [[configuration][appender][rollingPolicy][totalSizeCap]]
1023:26:55,474 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy - Will use gz compression
1123:26:55,477 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy - Will use the pattern /opt/tomcat6/logs/cpgu.%d{yyyy-MM-dd}.log for the active file
1223:26:55,487 |-INFO in c.q.l.core.rolling.DefaultTimeBasedFileNamingAndTriggeringPolicy - The date pattern is 'yyyy-MM-dd' from file name pattern '/opt/tomcat6/logs/cpgu.%d{yyyy-MM-dd}.log.gz'.
1323:26:55,488 |-INFO in c.q.l.core.rolling.DefaultTimeBasedFileNamingAndTriggeringPolicy - Roll-over at midnight.
1423:26:55,493 |-INFO in c.q.l.core.rolling.DefaultTimeBasedFileNamingAndTriggeringPolicy - Setting initial period to Tue Oct 02 23:26:55 NOVT 2018
1523:26:55,496 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Active log file name: /opt/tomcat6/logs/cpgu.2018-10-02.log
1623:26:55,496 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - File property is set to [null]
1723:26:55,499 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.atcsibir.cpgu] to DEBUG
1823:26:55,500 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.googlecode.flyway] to INFO
1923:26:55,500 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [db.migration] to DEBUG
2023:26:55,500 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.sc] to DEBUG
2123:26:55,500 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.atcsibir.cpgu.autologon.activedirectory] to INFO
2223:26:55,500 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to WARN
2323:26:55,500 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [FILE] to Logger[ROOT]
2423:26:55,502 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - End of configuration.
2523:26:55,504 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@7027413a - Registering current configuration as safe fallback point
26
27SLF4J: Actual binding is of type [ch.qos.logback.classic.util.ContextSelectorStaticBinder]
28Oct 02, 2018 11:26:55 PM org.apache.catalina.core.ApplicationContext log
29INFO: Initializing Spring root WebApplicationContext
302018-10-02T23:26:57.188+0700: 15.227: [GC 524288K->86323K(2009792K), 0.1960090 secs]
312018-10-02T23:27:01.294+0700: 19.334: [GC 610611K->37931K(2534080K), 0.1130370 secs]
322018-10-02T23:27:06.831+0700: 24.871: [GC 1086507K->69194K(2534080K), 0.2295770 secs]
33Oct 02, 2018 11:27:10 PM org.apache.catalina.core.StandardContext listenerStart
34SEVERE: Exception sending context initialized event to listener instance of class org.springframework.web.context.ContextLoaderListener
35org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'org.springframework.dao.annotation.PersistenceExceptionTranslationPostProcessor#0': Initialization of bean failed; nested exception is org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'dbMigrationManager' defined in URL [jar:file:/opt/tomcat6/webapps/cpgu/WEB-INF/lib/cpgu-model-1.0-SNAPSHOT.jar!/META-INF/spring/cpgu-model-app-context.xml]: Invocation of init method failed; nested exception is com.googlecode.flyway.core.command.FlywaySqlScriptException: Error executing statement at line 2: ALTER TABLE cpgu_mfc DROP CONSTRAINT IF EXISTS calendar_fk
36	at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:527)
37	at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:456)
38	at org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:294)
39	at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:225)
40	at org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:291)
41	at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:197)
42	at org.springframework.context.support.AbstractApplicationContext.registerBeanPostProcessors(AbstractApplicationContext.java:734)
43	at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:457)
44	at org.springframework.web.context.ContextLoader.configureAndRefreshWebApplicationContext(ContextLoader.java:383)
45	at org.springframework.web.context.ContextLoader.initWebApplicationContext(ContextLoader.java:283)
46	at org.springframework.web.context.ContextLoaderListener.contextInitialized(ContextLoaderListener.java:111)
47	at org.apache.catalina.core.StandardContext.listenerStart(StandardContext.java:4276)
48	at org.apache.catalina.core.StandardContext.start(StandardContext.java:4779)
49	at org.apache.catalina.core.ContainerBase.addChildInternal(ContainerBase.java:803)
50	at org.apache.catalina.core.ContainerBase.addChild(ContainerBase.java:780)
51	at org.apache.catalina.core.StandardHost.addChild(StandardHost.java:583)
52	at org.apache.catalina.startup.HostConfig.deployWAR(HostConfig.java:944)
53	at org.apache.catalina.startup.HostConfig.deployWARs(HostConfig.java:779)
54	at org.apache.catalina.startup.HostConfig.deployApps(HostConfig.java:505)
55	at org.apache.catalina.startup.HostConfig.start(HostConfig.java:1322)
56	at org.apache.catalina.startup.HostConfig.lifecycleEvent(HostConfig.java:325)
57	at org.apache.catalina.util.LifecycleSupport.fireLifecycleEvent(LifecycleSupport.java:142)
58	at org.apache.catalina.core.ContainerBase.start(ContainerBase.java:1069)
59	at org.apache.catalina.core.StandardHost.start(StandardHost.java:822)
60	at org.apache.catalina.core.ContainerBase.start(ContainerBase.java:1061)
61	at org.apache.catalina.core.StandardEngine.start(StandardEngine.java:463)
62	at org.apache.catalina.core.StandardService.start(StandardService.java:525)
63	at org.apache.catalina.core.StandardServer.start(StandardServer.java:761)
64	at org.apache.catalina.startup.Catalina.start(Catalina.java:595)
65	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
66	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
67	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
68	at java.lang.reflect.Method.invoke(Method.java:601)
69	at org.apache.catalina.startup.Bootstrap.start(Bootstrap.java:289)
70	at org.apache.catalina.startup.Bootstrap.main(Bootstrap.java:414)
71Caused by: org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'dbMigrationManager' defined in URL [jar:file:/opt/tomcat6/webapps/cpgu/WEB-INF/lib/cpgu-model-1.0-SNAPSHOT.jar!/META-INF/spring/cpgu-model-app-context.xml]: Invocation of init method failed; nested exception is com.googlecode.flyway.core.command.FlywaySqlScriptException: Error executing statement at line 2: ALTER TABLE cpgu_mfc DROP CONSTRAINT IF EXISTS calendar_fk
72	at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1455)
73	at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:519)
74	at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:456)
75	at org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:294)
76	at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:225)
77	at org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:291)
78	at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:193)
79	at org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:284)
80	at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:197)
81	at org.springframework.beans.factory.support.DefaultListableBeanFactory.getBeansOfType(DefaultListableBeanFactory.java:420)
82	at org.springframework.beans.factory.BeanFactoryUtils.beansOfTypeIncludingAncestors(BeanFactoryUtils.java:277)
83	at org.springframework.dao.support.PersistenceExceptionTranslationInterceptor.detectPersistenceExceptionTranslators(PersistenceExceptionTranslationInterceptor.java:139)
84	at org.springframework.dao.support.PersistenceExceptionTranslationInterceptor.<init>(PersistenceExceptionTranslationInterceptor.java:79)
85	at org.springframework.dao.annotation.PersistenceExceptionTranslationAdvisor.<init>(PersistenceExceptionTranslationAdvisor.java:70)
86	at org.springframework.dao.annotation.PersistenceExceptionTranslationPostProcessor.setBeanFactory(PersistenceExceptionTranslationPostProcessor.java:103)
87	at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeAwareMethods(AbstractAutowireCapableBeanFactory.java:1475)
88	at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1443)
89	at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:519)
90	... 34 more
91Caused by: com.googlecode.flyway.core.command.FlywaySqlScriptException: Error executing statement at line 2: ALTER TABLE cpgu_mfc DROP CONSTRAINT IF EXISTS calendar_fk
92	at com.googlecode.flyway.core.dbsupport.SqlScript.execute(SqlScript.java:92)
93	at com.googlecode.flyway.core.resolver.sql.SqlMigrationExecutor.execute(SqlMigrationExecutor.java:72)
94	at com.googlecode.flyway.core.command.DbMigrate$2.doInTransaction(DbMigrate.java:243)
95	at com.googlecode.flyway.core.command.DbMigrate$2.doInTransaction(DbMigrate.java:241)
96	at com.googlecode.flyway.core.util.jdbc.TransactionTemplate.execute(TransactionTemplate.java:72)
97	at com.googlecode.flyway.core.command.DbMigrate.applyMigration(DbMigrate.java:241)
98	at com.googlecode.flyway.core.command.DbMigrate.access$700(DbMigrate.java:44)
99	at com.googlecode.flyway.core.command.DbMigrate$1.doInTransaction(DbMigrate.java:186)
100	at com.googlecode.flyway.core.command.DbMigrate$1.doInTransaction(DbMigrate.java:135)
101	at com.googlecode.flyway.core.util.jdbc.TransactionTemplate.execute(TransactionTemplate.java:72)
102	at com.googlecode.flyway.core.command.DbMigrate.migrate(DbMigrate.java:135)
103	at com.googlecode.flyway.core.Flyway$1.execute(Flyway.java:872)
104	at com.googlecode.flyway.core.Flyway$1.execute(Flyway.java:819)
105	at com.googlecode.flyway.core.Flyway.execute(Flyway.java:1200)
106	at com.googlecode.flyway.core.Flyway.migrate(Flyway.java:819)
107	at com.atcsibir.cpgu.configuration.DbMigrationManager.manageMigrations(DbMigrationManager.java:32)
108	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
109	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
110	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
111	at java.lang.reflect.Method.invoke(Method.java:601)
112	at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeCustomInitMethod(AbstractAutowireCapableBeanFactory.java:1581)
113	at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeInitMethods(AbstractAutowireCapableBeanFactory.java:1522)
114	at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1452)
115	... 51 more
116Caused by: org.postgresql.util.PSQLException: ERROR: syntax error at or near "EXISTS"
117  Position: 41
118	at org.postgresql.core.v3.QueryExecutorImpl.receiveErrorResponse(QueryExecutorImpl.java:2062)
119	at org.postgresql.core.v3.QueryExecutorImpl.processResults(QueryExecutorImpl.java:1795)
120	at org.postgresql.core.v3.QueryExecutorImpl.execute(QueryExecutorImpl.java:257)
121	at org.postgresql.jdbc2.AbstractJdbc2Statement.execute(AbstractJdbc2Statement.java:479)
122	at org.postgresql.jdbc2.AbstractJdbc2Statement.executeWithFlags(AbstractJdbc2Statement.java:353)
123	at org.postgresql.jdbc2.AbstractJdbc2Statement.execute(AbstractJdbc2Statement.java:345)
124	at com.googlecode.flyway.core.dbsupport.JdbcTemplate.executeStatement(JdbcTemplate.java:230)
125	at com.googlecode.flyway.core.dbsupport.SqlScript.execute(SqlScript.java:90)
126	... 73 more
127
128Oct 02, 2018 11:27:10 PM org.apache.catalina.core.StandardContext start
129SEVERE: Error listenerStart
130Oct 02, 2018 11:27:10 PM org.apache.catalina.core.StandardContext start
131SEVERE: Context [/cpgu] startup failed due to previous errors
132Oct 02, 2018 11:27:10 PM org.apache.catalina.core.ApplicationContext log
133INFO: Closing Spring root WebApplicationContext
134Oct 02, 2018 11:27:10 PM org.apache.catalina.loader.WebappClassLoader clearReferencesJdbc
135SEVERE: The web application [/cpgu] registered the JDBC driver [org.postgresql.Driver] but failed to unregister it when the web application was stopped. To prevent a memory leak, the JDBC Driver has been forcibly unregistered.
136Oct 02, 2018 11:27:10 PM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
137SEVERE: The web application [/cpgu] appears to have started a thread named [PoolCleaner[484101640:1538497628092]] but has failed to stop it. This is very likely to create a memory leak.
138Oct 02, 2018 11:27:11 PM org.apache.catalina.startup.HostConfig deployWAR
139INFO: Deploying web application archive gateway.war
140[CPGU] Initializing log4j...
141[CPGU] Ready to go!
142Oct 02, 2018 11:27:11 PM org.apache.catalina.startup.HostConfig deployDirectory
143INFO: Deploying web application directory status-viewer
14423:27:12,181 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [/opt/tomcat6/conf/logback.xml] at [file:/opt/tomcat6/conf/logback.xml]
14523:27:12,268 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - debug attribute not set
14623:27:12,409 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
14723:27:12,425 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [FILE]
14823:27:12,536 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@11:24 - no applicable action for [totalSizeCap], current ElementPath  is [[configuration][appender][rollingPolicy][totalSizeCap]]
14923:27:12,541 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy - Will use gz compression
15023:27:12,544 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy - Will use the pattern /opt/tomcat6/logs/cpgu.%d{yyyy-MM-dd}.log for the active file
15123:27:12,550 |-INFO in c.q.l.core.rolling.DefaultTimeBasedFileNamingAndTriggeringPolicy - The date pattern is 'yyyy-MM-dd' from file name pattern '/opt/tomcat6/logs/cpgu.%d{yyyy-MM-dd}.log.gz'.
15223:27:12,550 |-INFO in c.q.l.core.rolling.DefaultTimeBasedFileNamingAndTriggeringPolicy - Roll-over at midnight.
15323:27:12,550 |-INFO in c.q.l.core.rolling.DefaultTimeBasedFileNamingAndTriggeringPolicy - Setting initial period to Tue Oct 02 23:27:12 NOVT 2018
15423:27:12,552 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Active log file name: /opt/tomcat6/logs/cpgu.2018-10-02.log
15523:27:12,552 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - File property is set to [null]
15623:27:12,555 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.atcsibir.cpgu] to DEBUG
15723:27:12,555 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.googlecode.flyway] to INFO
15823:27:12,555 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [db.migration] to DEBUG
15923:27:12,555 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.sc] to DEBUG
16023:27:12,555 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.atcsibir.cpgu.autologon.activedirectory] to INFO
16123:27:12,555 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to WARN
16223:27:12,556 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [FILE] to Logger[ROOT]
16323:27:12,557 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - End of configuration.
16423:27:12,558 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@73f60642 - Registering current configuration as safe fallback point
165
166Oct 02, 2018 11:27:12 PM org.apache.catalina.core.ApplicationContext log
167INFO: Initializing Spring root WebApplicationContext
168Oct 02, 2018 11:27:13 PM org.apache.coyote.http11.Http11Protocol start
169INFO: Starting Coyote HTTP/1.1 on http-8080
170Oct 02, 2018 11:27:13 PM org.apache.jk.common.ChannelSocket init
171INFO: JK: ajp13 listening on /0.0.0.0:8009
172Oct 02, 2018 11:27:13 PM org.apache.jk.server.JkMain start
173INFO: Jk running ID=0 time=0/23  config=null
174Oct 02, 2018 11:27:13 PM org.apache.catalina.startup.Catalina start
175INFO: Server startup in 29904 ms
176Oct 02, 2018 11:27:38 PM org.apache.catalina.loader.WebappClassLoader loadClass
177INFO: Illegal access: this web application instance has been stopped already.  Could not load org.apache.tomcat.jdbc.pool.FairBlockingQueue$FairIterator.  The eventual following stack trace is caused by an error thrown for debugging purposes as well as to attempt to terminate the thread which caused the illegal access, and has no functional impact.
178java.lang.IllegalStateException
179	at org.apache.catalina.loader.WebappClassLoader.loadClass(WebappClassLoader.java:1584)
180	at org.apache.catalina.loader.WebappClassLoader.loadClass(WebappClassLoader.java:1544)
181	at org.apache.tomcat.jdbc.pool.FairBlockingQueue.iterator(FairBlockingQueue.java:233)
182	at org.apache.tomcat.jdbc.pool.ConnectionPool.testAllIdle(ConnectionPool.java:1031)
183	at org.apache.tomcat.jdbc.pool.ConnectionPool$PoolCleaner.run(ConnectionPool.java:1350)
184	at java.util.TimerThread.mainLoop(Timer.java:555)
185	at java.util.TimerThread.run(Timer.java:505)
186
187Exception in thread "PoolCleaner[484101640:1538497628092]" java.lang.NoClassDefFoundError: org/apache/tomcat/jdbc/pool/FairBlockingQueue$FairIterator
188	at org.apache.tomcat.jdbc.pool.FairBlockingQueue.iterator(FairBlockingQueue.java:233)
189	at org.apache.tomcat.jdbc.pool.ConnectionPool.testAllIdle(ConnectionPool.java:1031)
190	at org.apache.tomcat.jdbc.pool.ConnectionPool$PoolCleaner.run(ConnectionPool.java:1350)
191	at java.util.TimerThread.mainLoop(Timer.java:555)
192	at java.util.TimerThread.run(Timer.java:505)
193Caused by: java.lang.ClassNotFoundException: org.apache.tomcat.jdbc.pool.FairBlockingQueue$FairIterator
194	at org.apache.catalina.loader.WebappClassLoader.loadClass(WebappClassLoader.java:1698)
195	at org.apache.catalina.loader.WebappClassLoader.loadClass(WebappClassLoader.java:1544)
196	... 5 more