HikariPool Shutdown

Hi @wilkinsona thanks for your help, I fixed the issue. !!! You were right, the details of startup failure were not logging, so, to get more details i put my attention in the log4j warning messages:

log4j:WARN No appenders could be found for logger (org.springframework.boot.devtools.settings.DevToolsSettings).
log4j:WARN Please initialize the log4j system properly.
log4j:WARN See http://logging.apache.org/log4j/1.2/faq.html#noconfig for more info.

Then, I added a log4.properties file and put here the settings, instead of in my normal application.properties

# Set root logger level to DEBUG and its only appender to A1.
log4j.rootLogger=INFO, A1

# A1 is set to be a ConsoleAppender.
log4j.appender.A1=org.apache.log4j.ConsoleAppender

# A1 uses PatternLayout.
log4j.appender.A1.layout=org.apache.log4j.PatternLayout
log4j.appender.A1.layout.ConversionPattern=%-4r [%t] %-5p %c %x - %m%n

After this, it worked!!! I think the issue was about it was not able to log something and that was causing the startup failure.

.   ____          _            __ _ _
/\\ / ___'_ __ _ _(_)_ __  __ _ \ \ \ \
( ( )\___ | '_ | '_| | '_ \/ _` | \ \ \ \
\\/  ___)| |_)| | | | | || (_| |  ) ) ) )
 '  |____| .__|_| |_|_| |_\__, | / / / /
=========|_|==============|___/=/_/_/_/
:: Spring Boot ::        (v2.0.3.RELEASE)

0    [restartedMain] INFO  com.ericsson.csdp.bm.webireportscheduler.WebiReportSchedulerApplication  - Starting WebiReportSchedulerApplication on CA00203418 with PID 4008 (C:\Users\egerara\csdp_code_repository\webi-report-scheduler\out\production\classes started by egerara in C:\Users\egerara\csdp_code_repository\webi-report-scheduler)
0    [restartedMain] INFO  com.ericsson.csdp.bm.webireportscheduler.WebiReportSchedulerApplication  - No active profile set, falling back to default profiles: default
140  [restartedMain] INFO  org.springframework.boot.web.servlet.context.AnnotationConfigServletWebServerApplicationContext  - Refreshing org.springframework.boot.web.servlet.context.AnnotationConfigServletWebServerApplicationContext@f5325bb: startup date [Tue Jun 19 10:05:51 EDT 2018]; root of context hierarchy
2018-06-19 10:05:55.146  INFO 4008 --- [  restartedMain] .s.d.r.c.RepositoryConfigurationDelegate : Multiple Spring Data modules found, entering strict repository configuration mode!
2018-06-19 10:05:55.442  INFO 4008 --- [  restartedMain] .s.d.r.c.RepositoryConfigurationDelegate : Multiple Spring Data modules found, entering strict repository configuration mode!
2018-06-19 10:05:55.520  INFO 4008 --- [  restartedMain] .RepositoryConfigurationExtensionSupport : Spring Data Redis - Could not safely identify store assignment for repository candidate interface com.ericsson.csdp.bm.webireportscheduler.repository.NoteRepository.
2018-06-19 10:05:55.520  INFO 4008 --- [  restartedMain] .RepositoryConfigurationExtensionSupport : Spring Data Redis - Could not safely identify store assignment for repository candidate interface com.ericsson.csdp.bm.webireportscheduler.repository.ReportListViewPaginatedRepository.
2018-06-19 10:05:55.520  INFO 4008 --- [  restartedMain] .RepositoryConfigurationExtensionSupport : Spring Data Redis - Could not safely identify store assignment for repository candidate interface com.ericsson.csdp.bm.webireportscheduler.repository.ReportListViewRepository.
2018-06-19 10:05:55.520  INFO 4008 --- [  restartedMain] .RepositoryConfigurationExtensionSupport : Spring Data Redis - Could not safely identify store assignment for repository candidate interface com.ericsson.csdp.bm.webireportscheduler.repository.ReportModelRepository.
2018-06-19 10:05:55.520  INFO 4008 --- [  restartedMain] .RepositoryConfigurationExtensionSupport : Spring Data Redis - Could not safely identify store assignment for repository candidate interface com.ericsson.csdp.bm.webireportscheduler.repository.RequestModelRepository.
4336 [restartedMain] INFO  org.springframework.integration.config.IntegrationRegistrar  - No bean named 'integrationHeaderChannelRegistry' has been explicitly defined. Therefore, a default DefaultHeaderChannelRegistry will be created.
5257 [restartedMain] INFO  org.springframework.integration.config.DefaultConfiguringBeanFactoryPostProcessor  - No bean named 'errorChannel' has been explicitly defined. Therefore, a default PublishSubscribeChannel will be created.
5272 [restartedMain] INFO  org.springframework.integration.config.DefaultConfiguringBeanFactoryPostProcessor  - No bean named 'taskScheduler' has been explicitly defined. Therefore, a default ThreadPoolTaskScheduler will be created.
5538 [restartedMain] INFO  org.springframework.context.support.PostProcessorRegistrationDelegate$BeanPostProcessorChecker  - Bean 'org.springframework.transaction.annotation.ProxyTransactionManagementConfiguration' of type [org.springframework.transaction.annotation.ProxyTransactionManagementConfiguration$$EnhancerBySpringCGLIB$$f68fb255] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying)
5631 [restartedMain] INFO  org.springframework.context.support.PostProcessorRegistrationDelegate$BeanPostProcessorChecker  - Bean 'org.springframework.integration.config.IntegrationManagementConfiguration' of type [org.springframework.integration.config.IntegrationManagementConfiguration$$EnhancerBySpringCGLIB$$61816d84] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying)
5850 [restartedMain] INFO  org.springframework.context.support.PostProcessorRegistrationDelegate$BeanPostProcessorChecker  - Bean 'org.springframework.integration.dsl.context.IntegrationFlowContext' of type [org.springframework.integration.dsl.context.IntegrationFlowContext] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying)
7815 [restartedMain] INFO  org.springframework.boot.web.embedded.tomcat.TomcatWebServer  - Tomcat initialized with port(s): 8081 (http)
2018-06-19 10:05:59.170  INFO 4008 --- [  restartedMain] o.apache.catalina.core.StandardService   : Starting service [Tomcat]
2018-06-19 10:05:59.170  INFO 4008 --- [  restartedMain] org.apache.catalina.core.StandardEngine  : Starting Servlet Engine: Apache Tomcat/8.5.31
2018-06-19 10:05:59.186  INFO 4008 --- [ost-startStop-1] o.a.catalina.core.AprLifecycleListener   : The APR based Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path: [C:\Program Files\Java\jdk1.8.0_171\bin;C:\WINDOWS\Sun\Java\bin;C:\WINDOWS\system32;C:\WINDOWS;C:\Program Files (x86)\Common Files\Oracle\Java\javapath;C:\Program Files (x86)\Intel\iCLS Client\;C:\Program Files\Intel\iCLS Client\;C:\ProgramData\Oracle\Java\javapath;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\System32\Wbem;C:\WINDOWS\System32\WindowsPowerShell\v1.0\;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\System32\Wbem;C:\Program Files (x86)\SQL11\DLL;C:\Program Files (x86)\SQL11\BIN;C:\Program Files\Intel\Intel(R) Management Engine Components\DAL;C:\Program Files\Intel\Intel(R) Management Engine Components\IPT;C:\Program Files (x86)\Intel\Intel(R) Management Engine Components\DAL;C:\Program Files (x86)\Intel\Intel(R) Management Engine Components\IPT;C:\Program Files (x86)\CheckPoint\Endpoint Security\Endpoint Common\bin;C:\Program Files\curl-7.59.0-win64-mingw\bin;C:\Program Files\apache-maven-3.5.3\bin;C:\Program Files\Git\bin;C:\Program Files\gradle-4.7\bin;C:\Program Files\PuTTY\;C:\Program Files\nodejs\;;C:\Program Files\Microsoft VS Code\bin;C:\Users\egerara\AppData\Roaming\npm;.]
2018-06-19 10:05:59.498  INFO 4008 --- [ost-startStop-1] o.a.c.c.C.[Tomcat].[localhost].[/]       : Initializing Spring embedded WebApplicationContext
8174 [localhost-startStop-1] INFO  org.springframework.web.context.ContextLoader  - Root WebApplicationContext: initialization completed in 8049 ms
8502 [localhost-startStop-1] INFO  org.springframework.boot.web.servlet.FilterRegistrationBean  - Mapping filter: 'corsFilter' to: [/*]
8502 [localhost-startStop-1] INFO  org.springframework.boot.web.servlet.FilterRegistrationBean  - Mapping filter: 'characterEncodingFilter' to: [/*]
8502 [localhost-startStop-1] INFO  org.springframework.boot.web.servlet.FilterRegistrationBean  - Mapping filter: 'hiddenHttpMethodFilter' to: [/*]
8502 [localhost-startStop-1] INFO  org.springframework.boot.web.servlet.FilterRegistrationBean  - Mapping filter: 'httpPutFormContentFilter' to: [/*]
8502 [localhost-startStop-1] INFO  org.springframework.boot.web.servlet.FilterRegistrationBean  - Mapping filter: 'requestContextFilter' to: [/*]
8502 [localhost-startStop-1] INFO  org.springframework.boot.web.servlet.DelegatingFilterProxyRegistrationBean  - Mapping filter: 'springSecurityFilterChain' to: [/*]
8502 [localhost-startStop-1] INFO  org.springframework.boot.web.servlet.ServletRegistrationBean  - Servlet dispatcherServlet mapped to [/]
2018-06-19 10:06:00.091  INFO 4008 --- [  restartedMain] com.zaxxer.hikari.HikariDataSource       : HikariPool-1 - Starting...
2018-06-19 10:06:01.526  INFO 4008 --- [  restartedMain] com.zaxxer.hikari.HikariDataSource       : HikariPool-1 - Start completed.
10358 [restartedMain] INFO  org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean  - Building JPA container EntityManagerFactory for persistence unit 'default'
2018-06-19 10:06:01.713  INFO 4008 --- [  restartedMain] o.hibernate.jpa.internal.util.LogHelper  : HHH000204: Processing PersistenceUnitInfo [
   name: default
   ...]
2018-06-19 10:06:01.853  INFO 4008 --- [  restartedMain] org.hibernate.Version                    : HHH000412: Hibernate Core {5.2.17.Final}
2018-06-19 10:06:01.853  INFO 4008 --- [  restartedMain] org.hibernate.cfg.Environment            : HHH000206: hibernate.properties not found
2018-06-19 10:06:01.916  INFO 4008 --- [  restartedMain] o.hibernate.annotations.common.Version   : HCANN000001: Hibernate Commons Annotations {5.0.1.Final}
2018-06-19 10:06:02.368  INFO 4008 --- [  restartedMain] org.hibernate.dialect.Dialect            : HHH000400: Using dialect: org.hibernate.dialect.PostgreSQL95Dialect
2018-06-19 10:06:50.439  INFO 4008 --- [  restartedMain] o.h.e.j.e.i.LobCreatorBuilderImpl        : HHH000421: Disabling contextual LOB creation as hibernate.jdbc.lob.non_contextual_creation is true
2018-06-19 10:06:50.439  INFO 4008 --- [  restartedMain] org.hibernate.type.BasicTypeRegistry     : HHH000270: Type registration [java.util.UUID] overrides previous : org.hibernate.type.UUIDBinaryType@44b3ddc8
2018-06-19 10:06:51.468  INFO 4008 --- [  restartedMain] o.h.h.i.QueryTranslatorFactoryInitiator  : HHH000397: Using ASTQueryTranslatorFactory
60363 [restartedMain] INFO  org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean  - Initialized JPA EntityManagerFactory for persistence unit 'default'
62562 [restartedMain] INFO  org.springframework.security.web.DefaultSecurityFilterChain  - Creating filter chain: Ant [pattern='/webi_report_scheduler/download'], []
62749 [restartedMain] INFO  org.springframework.security.web.DefaultSecurityFilterChain  - Creating filter chain: org.springframework.security.web.util.matcher.AnyRequestMatcher@1, [org.springframework.security.web.context.request.async.WebAsyncManagerIntegrationFilter@229c8f79, org.springframework.security.web.context.SecurityContextPersistenceFilter@63b1fb2a, org.springframework.security.web.header.HeaderWriterFilter@317c3ea, org.springframework.security.web.csrf.CsrfFilter@6b020457, org.springframework.security.web.authentication.logout.LogoutFilter@3b72c492, org.springframework.security.web.authentication.UsernamePasswordAuthenticationFilter@4dbe4a68, org.springframework.security.web.authentication.ui.DefaultLoginPageGeneratingFilter@555f08e, org.springframework.security.web.authentication.www.BasicAuthenticationFilter@1dafbb66, org.springframework.security.web.savedrequest.RequestCacheAwareFilter@5f3cf606, org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter@54dc1b84, org.springframework.security.web.authentication.AnonymousAuthenticationFilter@3422d3d4, org.springframework.security.web.session.SessionManagementFilter@1e01f15f, org.springframework.security.web.access.ExceptionTranslationFilter@4151a89, org.springframework.security.web.access.intercept.FilterSecurityInterceptor@1a9631b2]
62921 [restartedMain] INFO  org.springframework.web.servlet.handler.SimpleUrlHandlerMapping  - Mapped URL path [/**/favicon.ico] onto handler of type [class org.springframework.web.servlet.resource.ResourceHttpRequestHandler]
63249 [restartedMain] INFO  org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter  - Looking for @ControllerAdvice: org.springframework.boot.web.servlet.context.AnnotationConfigServletWebServerApplicationContext@f5325bb: startup date [Tue Jun 19 10:05:51 EDT 2018]; root of context hierarchy
63327 [restartedMain] WARN  org.springframework.boot.autoconfigure.orm.jpa.JpaBaseConfiguration$JpaWebConfiguration$JpaWebMvcConfiguration  - spring.jpa.open-in-view is enabled by default. Therefore, database queries may be performed during view rendering. Explicitly configure spring.jpa.open-in-view to disable this warning
63393 [restartedMain] INFO  org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerMapping  - Mapped "{[/api/notes],methods=[POST]}" onto public com.ericsson.csdp.bm.webireportscheduler.model.Note com.ericsson.csdp.bm.webireportscheduler.controller.NoteController.createNote(com.ericsson.csdp.bm.webireportscheduler.model.Note)
63393 [restartedMain] INFO  org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerMapping  - Mapped "{[/api/notes/{id}],methods=[GET]}" onto public org.springframework.http.ResponseEntity<com.ericsson.csdp.bm.webireportscheduler.model.Note> com.ericsson.csdp.bm.webireportscheduler.controller.NoteController.getNoteById(java.lang.Long)
63393 [restartedMain] INFO  org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerMapping  - Mapped "{[/api/notes],methods=[GET]}" onto public java.util.List<com.ericsson.csdp.bm.webireportscheduler.model.Note> com.ericsson.csdp.bm.webireportscheduler.controller.NoteController.getAllNotes()
63393 [restartedMain] INFO  org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerMapping  - Mapped "{[/api/notes/{id}],methods=[PUT]}" onto public org.springframework.http.ResponseEntity<com.ericsson.csdp.bm.webireportscheduler.model.Note> com.ericsson.csdp.bm.webireportscheduler.controller.NoteController.updateNote(java.lang.Long,com.ericsson.csdp.bm.webireportscheduler.model.Note)
63393 [restartedMain] INFO  org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerMapping  - Mapped "{[/api/notes/{id}],methods=[DELETE]}" onto public org.springframework.http.ResponseEntity<com.ericsson.csdp.bm.webireportscheduler.model.Note> com.ericsson.csdp.bm.webireportscheduler.controller.NoteController.deleteNote(java.lang.Long)
63393 [restartedMain] INFO  org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerMapping  - Mapped "{[/webi_report_scheduler/requests],methods=[POST]}" onto public java.lang.String com.ericsson.csdp.bm.webireportscheduler.controller.ReportingController.create(com.ericsson.csdp.bm.webireportscheduler.model.SimplifiedReportBORequest) throws java.lang.Exception
63393 [restartedMain] INFO  org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerMapping  - Mapped "{[/webi_report_scheduler/reports/pages/{pageNumber}],methods=[GET]}" onto public java.lang.String com.ericsson.csdp.bm.webireportscheduler.controller.ReportingController.getAllReportsPaginated(java.lang.Integer,org.springframework.ui.Model)
63393 [restartedMain] INFO  org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerMapping  - Mapped "{[/webi_report_scheduler/createarchiver],methods=[POST]}" onto public java.lang.String com.ericsson.csdp.bm.webireportscheduler.controller.ReportingController.createFileArchiver(com.ericsson.csdp.bm.webireportscheduler.model.FileDownloaderRequest) throws java.lang.Exception
63393 [restartedMain] INFO  org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerMapping  - Mapped "{[/webi_report_scheduler/report-requests],methods=[POST]}" onto public java.lang.String com.ericsson.csdp.bm.webireportscheduler.controller.ReportingController.reportRequest(com.ericsson.csdp.bm.webireportscheduler.model.RequestDtoControllerBody) throws java.lang.Exception
63393 [restartedMain] INFO  org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerMapping  - Mapped "{[/webi_report_scheduler/reports],methods=[GET]}" onto public java.util.List<com.ericsson.csdp.bm.webireportscheduler.model.RequestModel> com.ericsson.csdp.bm.webireportscheduler.controller.ReportingController.getAllReports()
63393 [restartedMain] INFO  org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerMapping  - Mapped "{[/webi_report_scheduler/reports/{reportid}],methods=[GET]}" onto public org.springframework.http.ResponseEntity<com.ericsson.csdp.bm.webireportscheduler.model.ReportModel> com.ericsson.csdp.bm.webireportscheduler.controller.ReportingController.getReportById(java.lang.Integer)
63393 [restartedMain] INFO  org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerMapping  - Mapped "{[/webi_report_scheduler/reports/{reportid}],methods=[PUT]}" onto public org.springframework.http.ResponseEntity<com.ericsson.csdp.bm.webireportscheduler.model.ReportModel> com.ericsson.csdp.bm.webireportscheduler.controller.ReportingController.updateReport(java.lang.Integer,com.ericsson.csdp.bm.webireportscheduler.model.ReportModelSimplified)
63409 [restartedMain] INFO  org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerMapping  - Mapped "{[/webi_report_scheduler/reports/{id}/{status}],methods=[PUT]}" onto public org.springframework.http.ResponseEntity<com.ericsson.csdp.bm.webireportscheduler.model.ReportModel> com.ericsson.csdp.bm.webireportscheduler.controller.ReportingController.updateReportPath(java.lang.Integer,java.lang.String)
63409 [restartedMain] INFO  org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerMapping  - Mapped "{[/webi_report_scheduler/download],methods=[GET]}" onto public org.springframework.http.ResponseEntity<org.springframework.core.io.Resource> com.ericsson.csdp.bm.webireportscheduler.controller.ReportingController.download(java.lang.String) throws java.io.IOException
63409 [restartedMain] INFO  org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerMapping  - Mapped "{[/error]}" onto public org.springframework.http.ResponseEntity<java.util.Map<java.lang.String, java.lang.Object>> org.springframework.boot.autoconfigure.web.servlet.error.BasicErrorController.error(javax.servlet.http.HttpServletRequest)
63409 [restartedMain] INFO  org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerMapping  - Mapped "{[/error],produces=[text/html]}" onto public org.springframework.web.servlet.ModelAndView org.springframework.boot.autoconfigure.web.servlet.error.BasicErrorController.errorHtml(javax.servlet.http.HttpServletRequest,javax.servlet.http.HttpServletResponse)
63456 [restartedMain] INFO  org.springframework.web.servlet.handler.SimpleUrlHandlerMapping  - Mapped URL path [/webjars/**] onto handler of type [class org.springframework.web.servlet.resource.ResourceHttpRequestHandler]
63456 [restartedMain] INFO  org.springframework.web.servlet.handler.SimpleUrlHandlerMapping  - Mapped URL path [/**] onto handler of type [class org.springframework.web.servlet.resource.ResourceHttpRequestHandler]
64797 [restartedMain] INFO  org.springframework.scheduling.concurrent.ThreadPoolTaskScheduler  - Initializing ExecutorService  'taskScheduler'
65468 [restartedMain] INFO  org.springframework.boot.devtools.autoconfigure.OptionalLiveReloadServer  - LiveReload server is running on port 35729
65624 [restartedMain] INFO  org.springframework.jmx.export.annotation.AnnotationMBeanExporter  - Registering beans for JMX exposure on startup
65624 [restartedMain] INFO  org.springframework.jmx.export.annotation.AnnotationMBeanExporter  - Bean with name 'dataSource' has been autodetected for JMX exposure
65624 [restartedMain] INFO  org.springframework.jmx.export.annotation.AnnotationMBeanExporter  - Located MBean 'dataSource': registering with JMX server as MBean [com.zaxxer.hikari:name=dataSource,type=HikariDataSource]
65640 [restartedMain] INFO  org.springframework.context.support.DefaultLifecycleProcessor  - Starting beans in phase 0
65640 [restartedMain] INFO  org.springframework.integration.endpoint.EventDrivenConsumer  - Adding {logging-channel-adapter:_org.springframework.integration.errorLogger} as a subscriber to the 'errorChannel' channel
65640 [restartedMain] INFO  org.springframework.integration.channel.PublishSubscribeChannel  - Channel 'application.errorChannel' has 1 subscriber(s).
65640 [restartedMain] INFO  org.springframework.integration.endpoint.EventDrivenConsumer  - started _org.springframework.integration.errorLogger
65718 [restartedMain] INFO  org.springframework.boot.web.embedded.tomcat.TomcatWebServer  - Tomcat started on port(s): 8081 (http) with context path ''
65718 [restartedMain] INFO  com.ericsson.csdp.bm.webireportscheduler.WebiReportSchedulerApplication  - Started WebiReportSchedulerApplication in 66.514 seconds (JVM running for 68.094)

Process finished with exit code -1

BR

Thanks. I haven’t been able to reproduce the shutdown problem, but I do now have a better understanding of what’s happening. I’m now pretty sure that the application is shutting down due to a startup failure. The details of the startup failure are not logged due to the presence of Commons Logging (https://github.com/spring-projects/spring-boot/issues/12457).

You should remove your explicit dependency on Commons Logging and also exclude it. You can do so globally with this Gradle config:

configurations {
    all*.exclude group: 'commons-logging', module: 'commons-logging'
}