Issues running the docker image #896
Description
Hello everyone, I tried running Hapi-FHIR using Docker.
Docker logs shows it's successful but when I navigate to https://localhost:8080, I get the error:
Whitelabel Error Page
This application has no explicit mapping for /error, so you are seeing this as a fallback.
Tue Nov 25 12:25:15 GMT 2025
There was an unexpected error (type=Not Found, status=4
But the following URLs work:
https://localhost:8080/fhir and https://localhost:8080/fhir/meta
Here are the Docker logs:
13:09:07,236 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version 1.5.19
13:09:07,305 |-INFO in ch.qos.logback.classic.util.ContextInitializer@4cf777e8 - Here is a list of configurators discovered as a service, by rank:
13:09:07,306 |-INFO in ch.qos.logback.classic.util.ContextInitializer@4cf777e8 - org.springframework.boot.logging.logback.RootLogLevelConfigurator
13:09:07,306 |-INFO in ch.qos.logback.classic.util.ContextInitializer@4cf777e8 - They will be invoked in order until ExecutionStatus.DO_NOT_INVOKE_NEXT_IF_ANY is returned.
13:09:07,306 |-INFO in ch.qos.logback.classic.util.ContextInitializer@4cf777e8 - Constructed configurator of type class org.springframework.boot.logging.logback.RootLogLevelConfigurator
13:09:07,374 |-INFO in ch.qos.logback.classic.util.ContextInitializer@4cf777e8 - org.springframework.boot.logging.logback.RootLogLevelConfigurator.configure() call lasted 16 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
13:09:07,374 |-INFO in ch.qos.logback.classic.util.ContextInitializer@4cf777e8 - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
13:09:07,440 |-INFO in ch.qos.logback.classic.util.ContextInitializer@4cf777e8 - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
13:09:07,456 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
13:09:07,470 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
13:09:07,470 |-INFO in ch.qos.logback.classic.util.ContextInitializer@4cf777e8 - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 30 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
13:09:07,470 |-INFO in ch.qos.logback.classic.util.ContextInitializer@4cf777e8 - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
13:09:07,475 |-INFO in ch.qos.logback.classic.util.ContextInitializer@4cf777e8 - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
13:09:07,493 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
13:09:07,507 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [jar:file:/app/main.war!/WEB-INF/classes!/logback.xml]
13:09:07,780 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@2f686d1f - URL [jar:file:/app/main.war!/WEB-INF/classes!/logback.xml] is not of type file
13:09:10,636 |-INFO in ch.qos.logback.core.joran.util.ConfigurationWatchListUtil@3fee9989 - Will not add configuration file [jar:file:/app/main.war!/WEB-INF/lib/spring-boot-3.4.11.jar!/org/springframework/boot/logging/logback/defaults.xml] to watch list, because 'jar' protocol is not watchable.
13:09:10,636 |-INFO in ch.qos.logback.core.joran.util.ConfigurationWatchListUtil@3fee9989 - Only the protocols 'file', 'http' and 'https' are watchable.
13:09:10,680 |-INFO in ch.qos.logback.core.model.processor.ConversionRuleModelHandler - registering conversion word applicationName with class [org.springframework.boot.logging.logback.ApplicationNameConverter]
13:09:10,694 |-INFO in ch.qos.logback.core.model.processor.ConversionRuleModelHandler - registering conversion word clr with class [org.springframework.boot.logging.logback.ColorConverter]
13:09:10,694 |-INFO in ch.qos.logback.core.model.processor.ConversionRuleModelHandler - registering conversion word correlationId with class [org.springframework.boot.logging.logback.CorrelationIdConverter]
13:09:10,694 |-INFO in ch.qos.logback.core.model.processor.ConversionRuleModelHandler - registering conversion word esb with class [org.springframework.boot.logging.logback.EnclosedInSquareBracketsConverter]
13:09:10,694 |-INFO in ch.qos.logback.core.model.processor.ConversionRuleModelHandler - registering conversion word wex with class [org.springframework.boot.logging.logback.WhitespaceThrowableProxyConverter]
13:09:10,694 |-INFO in ch.qos.logback.core.model.processor.ConversionRuleModelHandler - registering conversion word wEx with class [org.springframework.boot.logging.logback.ExtendedWhitespaceThrowableProxyConverter]
13:09:10,727 |-INFO in ch.qos.logback.core.model.processor.ModelInterpretationContext@73ad2d6 - value "%clr(%d{yyyy-MM-dd'T'HH:mm:ss.SSSXXX}){faint} %clr(%5p){} %clr(){magenta} %clr(--- %esb(){APPLICATION_NAME}%esb{APPLICATION_GROUP}[%15.15t] ){faint}%clr(%-40.40logger{39}){cyan} %clr(:){faint} %m%n%wEx" substituted for "${CONSOLE_LOG_PATTERN:-%clr(%d{${LOG_DATEFORMAT_PATTERN:-yyyy-MM-dd'T'HH:mm:ss.SSSXXX}}){faint} %clr(${LOG_LEVEL_PATTERN:-%5p}){} %clr(${PID:-}){magenta} %clr(--- %esb(){APPLICATION_NAME}%esb{APPLICATION_GROUP}[%15.15t] ${LOG_CORRELATION_PATTERN:-}){faint}%clr(%-40.40logger{39}){cyan} %clr(:){faint} %m%n${LOG_EXCEPTION_CONVERSION_WORD:-%wEx}}"
13:09:10,732 |-INFO in ch.qos.logback.core.model.processor.ModelInterpretationContext@73ad2d6 - value "UTF-8" substituted for "${CONSOLE_LOG_CHARSET:-${file.encoding:-UTF-8}}"
13:09:10,734 |-INFO in ch.qos.logback.core.model.processor.ModelInterpretationContext@73ad2d6 - value "TRACE" substituted for "${CONSOLE_LOG_THRESHOLD:-TRACE}"
13:09:10,734 |-INFO in ch.qos.logback.core.model.processor.ModelInterpretationContext@73ad2d6 - value "" substituted for "${CONSOLE_LOG_STRUCTURED_FORMAT:-}"
13:09:10,735 |-INFO in ch.qos.logback.core.model.processor.ModelInterpretationContext@73ad2d6 - value "%d{yyyy-MM-dd'T'HH:mm:ss.SSSXXX} %5p --- %esb(){APPLICATION_NAME}%esb{APPLICATION_GROUP}[%t] %-40.40logger{39} : %m%n%wEx" substituted for "${FILE_LOG_PATTERN:-%d{${LOG_DATEFORMAT_PATTERN:-yyyy-MM-dd'T'HH:mm:ss.SSSXXX}} ${LOG_LEVEL_PATTERN:-%5p} ${PID:-} --- %esb(){APPLICATION_NAME}%esb{APPLICATION_GROUP}[%t] ${LOG_CORRELATION_PATTERN:-}%-40.40logger{39} : %m%n${LOG_EXCEPTION_CONVERSION_WORD:-%wEx}}"
13:09:10,743 |-INFO in ch.qos.logback.core.model.processor.ModelInterpretationContext@73ad2d6 - value "UTF-8" substituted for "${FILE_LOG_CHARSET:-${file.encoding:-UTF-8}}"
13:09:10,743 |-INFO in ch.qos.logback.core.model.processor.ModelInterpretationContext@73ad2d6 - value "TRACE" substituted for "${FILE_LOG_THRESHOLD:-TRACE}"
13:09:10,744 |-INFO in ch.qos.logback.core.model.processor.ModelInterpretationContext@73ad2d6 - value "" substituted for "${FILE_LOG_STRUCTURED_FORMAT:-}"
13:09:10,746 |-INFO in ch.qos.logback.core.joran.util.ConfigurationWatchListUtil@3fee9989 - Will not add configuration file [jar:file:/app/main.war!/WEB-INF/lib/spring-boot-3.4.11.jar!/org/springframework/boot/logging/logback/console-appender.xml] to watch list, because 'jar' protocol is not watchable.
13:09:10,746 |-INFO in ch.qos.logback.core.joran.util.ConfigurationWatchListUtil@3fee9989 - Only the protocols 'file', 'http' and 'https' are watchable.
13:09:10,828 |-WARN in ch.qos.logback.classic.model.processor.ConfigurationModelHandlerFull - Missing watchable .xml or .properties files.
13:09:10,828 |-WARN in ch.qos.logback.classic.model.processor.ConfigurationModelHandlerFull - Watching .xml files requires that the main configuration file is reachable as a URL
13:09:10,828 |-INFO in ch.qos.logback.classic.model.processor.ConfigurationModelHandlerFull - Main configuration file URL: jar:file:/app/main.war!/WEB-INF/classes!/logback.xml
13:09:10,836 |-INFO in ch.qos.logback.classic.model.processor.ConfigurationModelHandlerFull - FileWatchList= {}
13:09:10,837 |-INFO in ch.qos.logback.classic.model.processor.ConfigurationModelHandlerFull - URLWatchList= {}
13:09:10,846 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.apache.catalina.startup.DigesterFactory] to ERROR
13:09:10,846 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.apache.catalina.util.LifecycleBase] to ERROR
13:09:10,846 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.apache.coyote.http11.Http11NioProtocol] to WARN
13:09:10,847 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.apache.sshd.common.util.SecurityUtils] to WARN
13:09:10,847 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.apache.tomcat.util.net.NioSelectorPool] to WARN
13:09:10,847 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty.util.component.AbstractLifeCycle] to ERROR
13:09:10,847 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.hibernate.validator.internal.util.Version] to WARN
13:09:10,847 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.springframework.boot.actuate.endpoint.jmx] to WARN
13:09:10,848 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [CONSOLE]
13:09:10,848 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender]
13:09:10,903 |-INFO in ch.qos.logback.core.model.processor.ModelInterpretationContext@73ad2d6 - value "TRACE" substituted for "${CONSOLE_LOG_THRESHOLD}"
13:09:10,907 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
13:09:10,910 |-INFO in ch.qos.logback.core.model.processor.ModelInterpretationContext@73ad2d6 - value "%clr(%d{yyyy-MM-dd'T'HH:mm:ss.SSSXXX}){faint} %clr(%5p){} %clr(){magenta} %clr(--- %esb(){APPLICATION_NAME}%esb{APPLICATION_GROUP}[%15.15t] ){faint}%clr(%-40.40logger{39}){cyan} %clr(:){faint} %m%n%wEx" substituted for "${CONSOLE_LOG_PATTERN}"
13:09:10,910 |-INFO in ch.qos.logback.core.model.processor.ModelInterpretationContext@73ad2d6 - value "UTF-8" substituted for "${CONSOLE_LOG_CHARSET}"
13:09:11,194 |-INFO in ch.qos.logback.core.ConsoleAppender[CONSOLE] - NOTE: Writing to the console can be slow. Try to avoid logging to the
13:09:11,194 |-INFO in ch.qos.logback.core.ConsoleAppender[CONSOLE] - console in production environments, especially in high volume systems.
13:09:11,194 |-INFO in ch.qos.logback.core.ConsoleAppender[CONSOLE] - See also https://logback.qos.ch/codes.html#slowConsole
13:09:11,198 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to INFO
13:09:11,199 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [CONSOLE] to Logger[ROOT]
13:09:11,201 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.opencds.cqf.cql.engine.debug] to DEBUG
13:09:11,201 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@7085bdee - End of configuration.
13:09:11,210 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@1ce92674 - Registering current configuration as safe fallback point
13:09:11,210 |-INFO in ch.qos.logback.classic.util.ContextInitializer@4cf777e8 - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 3735 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY
13:09:13,638 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@7c7b252e - URL [jar:file:/app/main.war!/WEB-INF/classes!/logback.xml] is not of type file
13:09:13,665 |-INFO in ch.qos.logback.core.joran.util.ConfigurationWatchListUtil@3fee9989 - Will not add configuration file [jar:file:/app/main.war!/WEB-INF/lib/spring-boot-3.4.11.jar!/org/springframework/boot/logging/logback/defaults.xml] to watch list, because 'jar' protocol is not watchable.
13:09:13,665 |-INFO in ch.qos.logback.core.joran.util.ConfigurationWatchListUtil@3fee9989 - Only the protocols 'file', 'http' and 'https' are watchable.
13:09:13,680 |-INFO in ch.qos.logback.core.model.processor.ConversionRuleModelHandler - registering conversion word applicationName with class [org.springframework.boot.logging.logback.ApplicationNameConverter]
13:09:13,680 |-INFO in ch.qos.logback.core.model.processor.ConversionRuleModelHandler - registering conversion word clr with class [org.springframework.boot.logging.logback.ColorConverter]
13:09:13,680 |-INFO in ch.qos.logback.core.model.processor.ConversionRuleModelHandler - registering conversion word correlationId with class [org.springframework.boot.logging.logback.CorrelationIdConverter]
13:09:13,680 |-INFO in ch.qos.logback.core.model.processor.ConversionRuleModelHandler - registering conversion word esb with class [org.springframework.boot.logging.logback.EnclosedInSquareBracketsConverter]
13:09:13,680 |-INFO in ch.qos.logback.core.model.processor.ConversionRuleModelHandler - registering conversion word wex with class [org.springframework.boot.logging.logback.WhitespaceThrowableProxyConverter]
13:09:13,680 |-INFO in ch.qos.logback.core.model.processor.ConversionRuleModelHandler - registering conversion word wEx with class [org.springframework.boot.logging.logback.ExtendedWhitespaceThrowableProxyConverter]
13:09:13,680 |-INFO in ch.qos.logback.core.model.processor.ModelInterpretationContext@4d5d943d - value "%clr(%d{yyyy-MM-dd'T'HH:mm:ss.SSSXXX}){faint} %clr(%5p){} %clr(1){magenta} %clr(--- %esb(){APPLICATION_NAME}%esb{APPLICATION_GROUP}[%15.15t] ){faint}%clr(%-40.40logger{39}){cyan} %clr(:){faint} %m%n%wEx" substituted for "${CONSOLE_LOG_PATTERN:-%clr(%d{${LOG_DATEFORMAT_PATTERN:-yyyy-MM-dd'T'HH:mm:ss.SSSXXX}}){faint} %clr(${LOG_LEVEL_PATTERN:-%5p}){} %clr(${PID:-}){magenta} %clr(--- %esb(){APPLICATION_NAME}%esb{APPLICATION_GROUP}[%15.15t] ${LOG_CORRELATION_PATTERN:-}){faint}%clr(%-40.40logger{39}){cyan} %clr(:){faint} %m%n${LOG_EXCEPTION_CONVERSION_WORD:-%wEx}}"
13:09:13,681 |-INFO in ch.qos.logback.core.model.processor.ModelInterpretationContext@4d5d943d - value "UTF-8" substituted for "${CONSOLE_LOG_CHARSET:-${file.encoding:-UTF-8}}"
13:09:13,681 |-INFO in ch.qos.logback.core.model.processor.ModelInterpretationContext@4d5d943d - value "TRACE" substituted for "${CONSOLE_LOG_THRESHOLD:-TRACE}"
13:09:13,681 |-INFO in ch.qos.logback.core.model.processor.ModelInterpretationContext@4d5d943d - value "" substituted for "${CONSOLE_LOG_STRUCTURED_FORMAT:-}"
13:09:13,681 |-INFO in ch.qos.logback.core.model.processor.ModelInterpretationContext@4d5d943d - value "%d{yyyy-MM-dd'T'HH:mm:ss.SSSXXX} %5p 1 --- %esb(){APPLICATION_NAME}%esb{APPLICATION_GROUP}[%t] %-40.40logger{39} : %m%n%wEx" substituted for "${FILE_LOG_PATTERN:-%d{${LOG_DATEFORMAT_PATTERN:-yyyy-MM-dd'T'HH:mm:ss.SSSXXX}} ${LOG_LEVEL_PATTERN:-%5p} ${PID:-} --- %esb(){APPLICATION_NAME}%esb{APPLICATION_GROUP}[%t] ${LOG_CORRELATION_PATTERN:-}%-40.40logger{39} : %m%n${LOG_EXCEPTION_CONVERSION_WORD:-%wEx}}"
13:09:13,681 |-INFO in ch.qos.logback.core.model.processor.ModelInterpretationContext@4d5d943d - value "UTF-8" substituted for "${FILE_LOG_CHARSET:-${file.encoding:-UTF-8}}"
13:09:13,681 |-INFO in ch.qos.logback.core.model.processor.ModelInterpretationContext@4d5d943d - value "TRACE" substituted for "${FILE_LOG_THRESHOLD:-TRACE}"
13:09:13,681 |-INFO in ch.qos.logback.core.model.processor.ModelInterpretationContext@4d5d943d - value "" substituted for "${FILE_LOG_STRUCTURED_FORMAT:-}"
13:09:13,683 |-INFO in ch.qos.logback.core.joran.util.ConfigurationWatchListUtil@3fee9989 - Will not add configuration file [jar:file:/app/main.war!/WEB-INF/lib/spring-boot-3.4.11.jar!/org/springframework/boot/logging/logback/console-appender.xml] to watch list, because 'jar' protocol is not watchable.
13:09:13,683 |-INFO in ch.qos.logback.core.joran.util.ConfigurationWatchListUtil@3fee9989 - Only the protocols 'file', 'http' and 'https' are watchable.
13:09:13,694 |-WARN in ch.qos.logback.classic.model.processor.ConfigurationModelHandlerFull - Missing watchable .xml or .properties files.
13:09:13,694 |-WARN in ch.qos.logback.classic.model.processor.ConfigurationModelHandlerFull - Watching .xml files requires that the main configuration file is reachable as a URL
13:09:13,694 |-INFO in ch.qos.logback.classic.model.processor.ConfigurationModelHandlerFull - Main configuration file URL: jar:file:/app/main.war!/WEB-INF/classes!/logback.xml
13:09:13,694 |-INFO in ch.qos.logback.classic.model.processor.ConfigurationModelHandlerFull - FileWatchList= {}
13:09:13,695 |-INFO in ch.qos.logback.classic.model.processor.ConfigurationModelHandlerFull - URLWatchList= {}
13:09:13,695 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.apache.catalina.startup.DigesterFactory] to ERROR
13:09:13,696 |-INFO in ch.qos.logback.classic.jul.LevelChangePropagator@368f2016 - Propagating ERROR level on Logger[org.apache.catalina.startup.DigesterFactory] onto the JUL framework
13:09:13,699 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.apache.catalina.util.LifecycleBase] to ERROR
13:09:13,699 |-INFO in ch.qos.logback.classic.jul.LevelChangePropagator@368f2016 - Propagating ERROR level on Logger[org.apache.catalina.util.LifecycleBase] onto the JUL framework
13:09:13,699 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.apache.coyote.http11.Http11NioProtocol] to WARN
13:09:13,699 |-INFO in ch.qos.logback.classic.jul.LevelChangePropagator@368f2016 - Propagating WARN level on Logger[org.apache.coyote.http11.Http11NioProtocol] onto the JUL framework
13:09:13,699 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.apache.sshd.common.util.SecurityUtils] to WARN
13:09:13,699 |-INFO in ch.qos.logback.classic.jul.LevelChangePropagator@368f2016 - Propagating WARN level on Logger[org.apache.sshd.common.util.SecurityUtils] onto the JUL framework
13:09:13,699 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.apache.tomcat.util.net.NioSelectorPool] to WARN
13:09:13,699 |-INFO in ch.qos.logback.classic.jul.LevelChangePropagator@368f2016 - Propagating WARN level on Logger[org.apache.tomcat.util.net.NioSelectorPool] onto the JUL framework
13:09:13,699 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty.util.component.AbstractLifeCycle] to ERROR
13:09:13,699 |-INFO in ch.qos.logback.classic.jul.LevelChangePropagator@368f2016 - Propagating ERROR level on Logger[org.eclipse.jetty.util.component.AbstractLifeCycle] onto the JUL framework
13:09:13,700 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.hibernate.validator.internal.util.Version] to WARN
13:09:13,700 |-INFO in ch.qos.logback.classic.jul.LevelChangePropagator@368f2016 - Propagating WARN level on Logger[org.hibernate.validator.internal.util.Version] onto the JUL framework
13:09:13,700 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.springframework.boot.actuate.endpoint.jmx] to WARN
13:09:13,700 |-INFO in ch.qos.logback.classic.jul.LevelChangePropagator@368f2016 - Propagating WARN level on Logger[org.springframework.boot.actuate.endpoint.jmx] onto the JUL framework
13:09:13,700 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [CONSOLE]
13:09:13,700 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender]
13:09:13,703 |-INFO in ch.qos.logback.core.model.processor.ModelInterpretationContext@4d5d943d - value "TRACE" substituted for "${CONSOLE_LOG_THRESHOLD}"
13:09:13,704 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
13:09:13,705 |-INFO in ch.qos.logback.core.model.processor.ModelInterpretationContext@4d5d943d - value "%clr(%d{yyyy-MM-dd'T'HH:mm:ss.SSSXXX}){faint} %clr(%5p){} %clr(1){magenta} %clr(--- %esb(){APPLICATION_NAME}%esb{APPLICATION_GROUP}[%15.15t] ){faint}%clr(%-40.40logger{39}){cyan} %clr(:){faint} %m%n%wEx" substituted for "${CONSOLE_LOG_PATTERN}"
13:09:13,705 |-INFO in ch.qos.logback.core.model.processor.ModelInterpretationContext@4d5d943d - value "UTF-8" substituted for "${CONSOLE_LOG_CHARSET}"
13:09:13,708 |-INFO in ch.qos.logback.core.ConsoleAppender[CONSOLE] - NOTE: Writing to the console can be slow. Try to avoid logging to the
13:09:13,708 |-INFO in ch.qos.logback.core.ConsoleAppender[CONSOLE] - console in production environments, especially in high volume systems.
13:09:13,708 |-INFO in ch.qos.logback.core.ConsoleAppender[CONSOLE] - See also https://logback.qos.ch/codes.html#slowConsole
13:09:13,708 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to INFO
13:09:13,708 |-INFO in ch.qos.logback.classic.jul.LevelChangePropagator@368f2016 - Propagating INFO level on Logger[ROOT] onto the JUL framework
13:09:13,709 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [CONSOLE] to Logger[ROOT]
13:09:13,709 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.opencds.cqf.cql.engine.debug] to DEBUG
13:09:13,709 |-INFO in ch.qos.logback.classic.jul.LevelChangePropagator@368f2016 - Propagating DEBUG level on Logger[org.opencds.cqf.cql.engine.debug] onto the JUL framework
13:09:13,709 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@4c583ecf - End of configuration.
13:09:13,710 |-INFO in org.springframework.boot.logging.logback.SpringBootJoranConfigurator@692f203f - Registering current configuration as safe fallback point
. ____ _ __ _ _
/\\ / ___'_ __ _ _(_)_ __ __ _ \ \ \ \
( ( )\___ | '_ | '_| | '_ \/ _` | \ \ \ \
\\/ ___)| |_)| | | | | || (_| | ) ) ) )
' |____| .__|_| |_|_| |_\__, | / / / /
=========|_|==============|___/=/_/_/_/
:: Spring Boot :: (v3.4.11)
2025-11-25T13:09:14.306Z INFO 1 --- [ main] ca.uhn.fhir.jpa.starter.Application : Starting Application using Java 17.0.17 with PID 1 (/app/main.war started by nonroot in /app)
2025-11-25T13:09:14.316Z INFO 1 --- [ main] ca.uhn.fhir.jpa.starter.Application : No active profile set, falling back to 1 default profile: "default"
2025-11-25T13:09:22.709Z INFO 1 --- [ main] .s.d.r.c.RepositoryConfigurationDelegate : Multiple Spring Data modules found, entering strict repository configuration mode
2025-11-25T13:09:22.709Z INFO 1 --- [ main] .s.d.r.c.RepositoryConfigurationDelegate : Bootstrapping Spring Data JPA repositories in DEFAULT mode.
2025-11-25T13:09:26.430Z INFO 1 --- [ main] .s.d.r.c.RepositoryConfigurationDelegate : Finished Spring Data repository scanning in 3662 ms. Found 56 JPA repository interfaces.
2025-11-25T13:09:33.734Z INFO 1 --- [ main] .s.d.r.c.RepositoryConfigurationDelegate : Multiple Spring Data modules found, entering strict repository configuration mode
2025-11-25T13:09:33.737Z INFO 1 --- [ main] .s.d.r.c.RepositoryConfigurationDelegate : Bootstrapping Spring Data Elasticsearch repositories in DEFAULT mode.
2025-11-25T13:09:33.998Z INFO 1 --- [ main] .s.d.r.c.RepositoryConfigurationDelegate : Finished Spring Data repository scanning in 260 ms. Found 0 Elasticsearch repository interfaces.
2025-11-25T13:09:34.044Z INFO 1 --- [ main] .s.d.r.c.RepositoryConfigurationDelegate : Multiple Spring Data modules found, entering strict repository configuration mode
2025-11-25T13:09:34.050Z INFO 1 --- [ main] .s.d.r.c.RepositoryConfigurationDelegate : Bootstrapping Spring Data Reactive Elasticsearch repositories in DEFAULT mode.
2025-11-25T13:09:34.069Z INFO 1 --- [ main] .s.d.r.c.RepositoryConfigurationDelegate : Finished Spring Data repository scanning in 18 ms. Found 0 Reactive Elasticsearch repository interfaces.
2025-11-25T13:09:37.788Z WARN 1 --- [ main] trationDelegate$BeanPostProcessorChecker : Bean 'ca.uhn.fhir.jpa.config.BeanPostProcessorConfig' of type [ca.uhn.fhir.jpa.config.BeanPostProcessorConfig$$SpringCGLIB$$0] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying). The currently created BeanPostProcessor [persistenceExceptionTranslationPostProcessor] is declared through a non-static factory method on that class; consider declaring it as static instead.
2025-11-25T13:09:38.173Z WARN 1 --- [ main] trationDelegate$BeanPostProcessorChecker : Bean 'org.springframework.ai.mcp.server.common.autoconfigure.annotations.McpServerAnnotationScannerAutoConfiguration' of type [org.springframework.ai.mcp.server.common.autoconfigure.annotations.McpServerAnnotationScannerAutoConfiguration] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying). Is this bean getting eagerly injected/applied to a currently created BeanPostProcessor [serverAnnotatedMethodBeanPostProcessor]? Check the corresponding BeanPostProcessor declaration and its dependencies/advisors. If this bean does not have to be post-processed, declare it with ROLE_INFRASTRUCTURE.
2025-11-25T13:09:38.479Z WARN 1 --- [ main] trationDelegate$BeanPostProcessorChecker : Bean 'serverAnnotatedBeanRegistry' of type [org.springframework.ai.mcp.server.common.autoconfigure.annotations.McpServerAnnotationScannerAutoConfiguration$ServerMcpAnnotatedBeans] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying). Is this bean getting eagerly injected/applied to a currently created BeanPostProcessor [serverAnnotatedMethodBeanPostProcessor]? Check the corresponding BeanPostProcessor declaration and its dependencies/advisors. If this bean does not have to be post-processed, declare it with ROLE_INFRASTRUCTURE.
2025-11-25T13:09:38.604Z WARN 1 --- [ main] trationDelegate$BeanPostProcessorChecker : Bean 'spring.ai.mcp.server.annotation-scanner-org.springframework.ai.mcp.server.common.autoconfigure.annotations.McpServerAnnotationScannerProperties' of type [org.springframework.ai.mcp.server.common.autoconfigure.annotations.McpServerAnnotationScannerProperties] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying). Is this bean getting eagerly injected/applied to a currently created BeanPostProcessor [serverAnnotatedMethodBeanPostProcessor]? Check the corresponding BeanPostProcessor declaration and its dependencies/advisors. If this bean does not have to be post-processed, declare it with ROLE_INFRASTRUCTURE.
2025-11-25T13:09:40.250Z INFO 1 --- [ main] o.s.b.w.embedded.tomcat.TomcatWebServer : Tomcat initialized with port 8080 (http)
2025-11-25T13:09:40.319Z INFO 1 --- [ main] o.apache.catalina.core.StandardService : Starting service [Tomcat]
2025-11-25T13:09:40.320Z INFO 1 --- [ main] o.apache.catalina.core.StandardEngine : Starting Servlet engine: [Apache Tomcat/10.1.48]
2025-11-25T13:09:43.177Z INFO 1 --- [ main] o.a.c.c.C.[Tomcat].[localhost].[/] : Initializing Spring embedded WebApplicationContext
2025-11-25T13:09:43.189Z INFO 1 --- [ main] w.s.c.ServletWebServerApplicationContext : Root WebApplicationContext: initialization completed in 28445 ms
2025-11-25T13:09:43.778Z INFO 1 --- [ main] ca.uhn.fhir.util.VersionUtil : HAPI FHIR version 8.6.0 - Rev 66e4809c55
2025-11-25T13:09:43.811Z INFO 1 --- [ main] ca.uhn.fhir.context.FhirContext : Creating new FHIR context for FHIR version [R4]
2025-11-25T13:09:44.007Z INFO 1 --- [ main] c.u.f.j.s.common.FhirServerConfigCommon : Server configured to allow contains searches
2025-11-25T13:09:44.009Z INFO 1 --- [ main] c.u.f.j.s.common.FhirServerConfigCommon : Server configured to deny multiple deletes
2025-11-25T13:09:44.009Z INFO 1 --- [ main] c.u.f.j.s.common.FhirServerConfigCommon : Server configured to deny external references
2025-11-25T13:09:44.009Z INFO 1 --- [ main] c.u.f.j.s.common.FhirServerConfigCommon : Server configured to enable DAO scheduling
2025-11-25T13:09:44.009Z INFO 1 --- [ main] c.u.f.j.s.common.FhirServerConfigCommon : Server configured to disable delete expunges
2025-11-25T13:09:44.010Z INFO 1 --- [ main] c.u.f.j.s.common.FhirServerConfigCommon : Server configured to enable expunges
2025-11-25T13:09:44.010Z INFO 1 --- [ main] c.u.f.j.s.common.FhirServerConfigCommon : Server configured to allow overriding default search params
2025-11-25T13:09:44.010Z INFO 1 --- [ main] c.u.f.j.s.common.FhirServerConfigCommon : Server configured to disable auto-creating placeholder references
2025-11-25T13:09:44.010Z INFO 1 --- [ main] c.u.f.j.s.common.FhirServerConfigCommon : Server configured to auto-version references at paths []
2025-11-25T13:09:44.011Z INFO 1 --- [ main] c.u.f.j.s.common.FhirServerConfigCommon : Server configured to enable value set pre-expansion
2025-11-25T13:09:44.012Z INFO 1 --- [ main] c.u.f.j.s.common.FhirServerConfigCommon : Server configured to enable value set pre-expansion task
2025-11-25T13:09:44.012Z INFO 1 --- [ main] c.u.f.j.s.common.FhirServerConfigCommon : Server configured for pre-expand value set default count of 1000
2025-11-25T13:09:44.012Z INFO 1 --- [ main] c.u.f.j.s.common.FhirServerConfigCommon : Server configured for pre-expand value set max count of 1000
2025-11-25T13:09:44.012Z INFO 1 --- [ main] c.u.f.j.s.common.FhirServerConfigCommon : Server configured for maximum expansion size of 1000
2025-11-25T13:09:44.236Z INFO 1 --- [ main] c.u.f.j.s.common.FhirServerConfigCommon : Server configured to have a maximum fetch size of 'unlimited'
2025-11-25T13:09:44.237Z INFO 1 --- [ main] c.u.f.j.s.common.FhirServerConfigCommon : Server configured to cache search results for 60000 milliseconds
2025-11-25T13:09:44.238Z INFO 1 --- [ main] c.u.f.j.s.common.FhirServerConfigCommon : Server configured to use 'ALPHANUMERIC' Client ID Strategy
2025-11-25T13:09:44.409Z INFO 1 --- [ main] c.u.f.j.s.common.FhirServerConfigCommon : Partitioning is not enabled on this server
2025-11-25T13:09:44.845Z INFO 1 --- [ main] o.hibernate.jpa.internal.util.LogHelper : HHH000204: Processing PersistenceUnitInfo [name: HAPI_PU]
2025-11-25T13:09:45.287Z INFO 1 --- [ main] org.hibernate.Version : HHH000412: Hibernate ORM core version 6.6.4.Final
2025-11-25T13:10:02.076Z INFO 1 --- [ main] .f.j.l.FilteringSqlLoggerImplContributor : Adding service: SqlStatementFilteringLogger
2025-11-25T13:10:02.152Z INFO 1 --- [ main] o.h.c.internal.RegionFactoryInitiator : HHH000026: Second-level cache disabled
2025-11-25T13:10:02.381Z INFO 1 --- [ main] o.h.e.boot.internal.EnversServiceImpl : Envers integration enabled? : true
2025-11-25T13:10:02.901Z INFO 1 --- [ main] o.s.o.j.p.SpringPersistenceUnitInfo : No LoadTimeWeaver setup: ignoring JPA class transformer
2025-11-25T13:10:02.972Z INFO 1 --- [ main] com.zaxxer.hikari.HikariDataSource : HikariPool-1 - Starting...
2025-11-25T13:10:04.052Z INFO 1 --- [ main] com.zaxxer.hikari.pool.HikariPool : HikariPool-1 - Added connection conn0: url=jdbc:h2:mem:test_mem user=SA
2025-11-25T13:10:04.063Z INFO 1 --- [ main] com.zaxxer.hikari.HikariDataSource : HikariPool-1 - Start completed.
2025-11-25T13:10:04.153Z INFO 1 --- [ main] org.hibernate.orm.connections.pooling : HHH10001005: Database info:
Database JDBC URL [Connecting through datasource 'HikariDataSource (HikariPool-1)']
Database driver: undefined/unknown
Database version: 2.3.232
Autocommit mode: undefined/unknown
Isolation level: undefined/unknown
Minimum pool size: undefined/unknown
Maximum pool size: undefined/unknown
2025-11-25T13:10:06.157Z INFO 1 --- [ main] o.h.e.c.i.m.AuditMetadataGenerator : Adding properties for entity: ca.uhn.fhir.jpa.entity.MdmLink
2025-11-25T13:10:06.237Z INFO 1 --- [ main] b.i.HibernateSearchPreIntegrationService : HSEARCH000034: Hibernate Search version 7.2.1.Final
2025-11-25T13:10:10.545Z INFO 1 --- [ main] o.h.e.t.j.p.i.JtaPlatformInitiator : HHH000489: No JTA platform available (set 'hibernate.transaction.jta.platform' to enable JTA platform integration)
2025-11-25T13:10:10.960Z INFO 1 --- [ main] irLocalContainerEntityManagerFactoryBean : Initialized JPA EntityManagerFactory for persistence unit 'HAPI_PU'
2025-11-25T13:10:13.150Z INFO 1 --- [ main] .u.f.c.s.DefaultProfileValidationSupport : Loading structure definitions from classpath: /org/hl7/fhir/r4/model/profile/profiles-resources.xml
2025-11-25T13:10:13.235Z INFO 1 --- [ main] ca.uhn.fhir.util.XmlUtil : FHIR XML procesing will use StAX implementation 'Woodstox' version '6.4.0'
2025-11-25T13:10:14.986Z INFO 1 --- [ main] .u.f.c.s.DefaultProfileValidationSupport : Loading structure definitions from classpath: /org/hl7/fhir/r4/model/profile/profiles-types.xml
2025-11-25T13:10:15.124Z INFO 1 --- [ main] .u.f.c.s.DefaultProfileValidationSupport : Loading structure definitions from classpath: /org/hl7/fhir/r4/model/profile/profiles-others.xml
2025-11-25T13:10:15.493Z INFO 1 --- [ main] .u.f.c.s.DefaultProfileValidationSupport : Loading structure definitions from classpath: /org/hl7/fhir/r4/model/extension/extension-definitions.xml
2025-11-25T13:10:16.842Z INFO 1 --- [ main] o.s.d.j.r.query.QueryEnhancerFactory : Hibernate is in classpath; If applicable, HQL parser will be used.
2025-11-25T13:10:24.799Z INFO 1 --- [ main] ca.uhn.fhir.context.FhirContext : Creating new FHIR context for FHIR version [DSTU2]
2025-11-25T13:10:24.806Z INFO 1 --- [ main] ca.uhn.fhir.context.FhirContext : Creating new FHIR context for FHIR version [DSTU3]
2025-11-25T13:10:24.811Z INFO 1 --- [ main] ca.uhn.fhir.context.FhirContext : Creating new FHIR context for FHIR version [R4]
2025-11-25T13:10:24.816Z INFO 1 --- [ main] ca.uhn.fhir.context.FhirContext : Creating new FHIR context for FHIR version [R5]
2025-11-25T13:10:24.923Z INFO 1 --- [ main] c.u.f.j.cache.ResourceTypeCacheSvcImpl : Table HFJ_RESOURCE_TYPE is populated with 198 entries.
2025-11-25T13:10:25.033Z INFO 1 --- [ main] c.u.f.j.cache.ResourceTypeCacheSvcImpl : Resource type cache size: 198
2025-11-25T13:10:25.641Z INFO 1 --- [ main] ca.uhn.fhir.context.FhirContext : Creating new FHIR context for FHIR version [R5]
2025-11-25T13:10:26.311Z INFO 1 --- [ main] c.u.f.log.terminology_troubleshooting : Performing initial retrieval for non-expiring cache: org.hl7.fhir.common.hapi.validation.support.ValidationSupportChain$FetchAllKey@4535754f
2025-11-25T13:10:26.313Z INFO 1 --- [ main] c.u.f.log.terminology_troubleshooting : Initial retrieval for non-expiring cache org.hl7.fhir.common.hapi.validation.support.ValidationSupportChain$FetchAllKey@4535754f succeeded in 3ms
2025-11-25T13:10:26.331Z INFO 1 --- [ main] c.u.f.log.terminology_troubleshooting : Performing initial retrieval for non-expiring cache: org.hl7.fhir.common.hapi.validation.support.ValidationSupportChain$FetchAllKey@4535754f
2025-11-25T13:10:26.332Z INFO 1 --- [ main] c.u.f.log.terminology_troubleshooting : Initial retrieval for non-expiring cache org.hl7.fhir.common.hapi.validation.support.ValidationSupportChain$FetchAllKey@4535754f succeeded in 2ms
2025-11-25T13:10:26.335Z INFO 1 --- [ main] c.u.f.log.terminology_troubleshooting : Performing initial retrieval for non-expiring cache: org.hl7.fhir.common.hapi.validation.support.ValidationSupportChain$FetchAllKey@4535754f
2025-11-25T13:10:26.337Z INFO 1 --- [ main] c.u.f.log.terminology_troubleshooting : Initial retrieval for non-expiring cache org.hl7.fhir.common.hapi.validation.support.ValidationSupportChain$FetchAllKey@4535754f succeeded in 2ms
2025-11-25T13:10:26.340Z INFO 1 --- [ main] c.u.f.log.terminology_troubleshooting : Performing initial retrieval for non-expiring cache: org.hl7.fhir.common.hapi.validation.support.ValidationSupportChain$FetchAllKey@4535754f
2025-11-25T13:10:26.342Z INFO 1 --- [ main] c.u.f.log.terminology_troubleshooting : Initial retrieval for non-expiring cache org.hl7.fhir.common.hapi.validation.support.ValidationSupportChain$FetchAllKey@4535754f succeeded in 2ms
2025-11-25T13:10:26.344Z INFO 1 --- [ main] c.u.f.log.terminology_troubleshooting : Performing initial retrieval for non-expiring cache: org.hl7.fhir.common.hapi.validation.support.ValidationSupportChain$FetchAllKey@4535754f
2025-11-25T13:10:26.345Z INFO 1 --- [ main] c.u.f.log.terminology_troubleshooting : Initial retrieval for non-expiring cache org.hl7.fhir.common.hapi.validation.support.ValidationSupportChain$FetchAllKey@4535754f succeeded in 1ms
2025-11-25T13:10:32.579Z INFO 1 --- [ main] ca.uhn.fhir.context.FhirContext : Creating new FHIR context for FHIR version [R4]
2025-11-25T13:10:32.682Z INFO 1 --- [ main] c.u.f.j.starter.common.StarterJpaConfig : CORS is enabled on this server
2025-11-25T13:10:32.687Z INFO 1 --- [ main] c.u.f.j.starter.common.StarterJpaConfig : CORS allows the following origins: *
2025-11-25T13:10:33.432Z INFO 1 --- [ main] ca.uhn.fhir.context.FhirContext : Creating new FHIR context for FHIR version [R4]
2025-11-25T13:10:34.415Z INFO 1 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Creating Local Scheduler
2025-11-25T13:10:34.531Z INFO 1 --- [ main] org.quartz.impl.StdSchedulerFactory : Using default implementation for ThreadExecutor
2025-11-25T13:10:34.567Z INFO 1 --- [ main] org.quartz.core.SchedulerSignalerImpl : Initialized Scheduler Signaller of type: class org.quartz.core.SchedulerSignalerImpl
2025-11-25T13:10:34.568Z INFO 1 --- [ main] org.quartz.core.QuartzScheduler : Quartz Scheduler v.2.3.2 created.
2025-11-25T13:10:34.570Z INFO 1 --- [ main] org.quartz.simpl.RAMJobStore : RAMJobStore initialized.
2025-11-25T13:10:34.576Z INFO 1 --- [ main] org.quartz.core.QuartzScheduler : Scheduler meta-data: Quartz Scheduler (v2.3.2) 'hapi-fhir-jpa-scheduler' with instanceId 'NON_CLUSTERED'
Scheduler class: 'org.quartz.core.QuartzScheduler' - running locally.
NOT STARTED.
Currently in standby mode.
Number of jobs executed: 0
Using thread pool 'org.quartz.simpl.SimpleThreadPool' - with 4 threads.
Using job-store 'org.quartz.simpl.RAMJobStore' - which does not support persistence. and is not clustered.
2025-11-25T13:10:34.576Z INFO 1 --- [ main] org.quartz.impl.StdSchedulerFactory : Quartz scheduler 'hapi-fhir-jpa-scheduler' initialized from an externally provided properties instance.
2025-11-25T13:10:34.577Z INFO 1 --- [ main] org.quartz.impl.StdSchedulerFactory : Quartz scheduler version: 2.3.2
2025-11-25T13:10:34.577Z INFO 1 --- [ main] org.quartz.core.QuartzScheduler : JobFactory set to: ca.uhn.fhir.jpa.sched.AutowiringSpringBeanJobFactory@7f4fb4a3
2025-11-25T13:10:34.579Z INFO 1 --- [ main] org.quartz.core.QuartzScheduler : Scheduler hapi-fhir-jpa-scheduler_$_NON_CLUSTERED paused.
2025-11-25T13:10:34.579Z INFO 1 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Creating Clustered Scheduler
2025-11-25T13:10:34.582Z INFO 1 --- [ main] org.quartz.impl.StdSchedulerFactory : Using default implementation for ThreadExecutor
2025-11-25T13:10:34.585Z INFO 1 --- [ main] org.quartz.core.SchedulerSignalerImpl : Initialized Scheduler Signaller of type: class org.quartz.core.SchedulerSignalerImpl
2025-11-25T13:10:34.585Z INFO 1 --- [ main] org.quartz.core.QuartzScheduler : Quartz Scheduler v.2.3.2 created.
2025-11-25T13:10:34.585Z INFO 1 --- [ main] org.quartz.simpl.RAMJobStore : RAMJobStore initialized.
2025-11-25T13:10:34.586Z INFO 1 --- [ main] org.quartz.core.QuartzScheduler : Scheduler meta-data: Quartz Scheduler (v2.3.2) 'hapi-fhir-jpa-scheduler' with instanceId 'NON_CLUSTERED'
Scheduler class: 'org.quartz.core.QuartzScheduler' - running locally.
NOT STARTED.
Currently in standby mode.
Number of jobs executed: 0
Using thread pool 'org.quartz.simpl.SimpleThreadPool' - with 4 threads.
Using job-store 'org.quartz.simpl.RAMJobStore' - which does not support persistence. and is not clustered.
2025-11-25T13:10:34.586Z INFO 1 --- [ main] org.quartz.impl.StdSchedulerFactory : Quartz scheduler 'hapi-fhir-jpa-scheduler' initialized from an externally provided properties instance.
2025-11-25T13:10:34.586Z INFO 1 --- [ main] org.quartz.impl.StdSchedulerFactory : Quartz scheduler version: 2.3.2
2025-11-25T13:10:34.586Z INFO 1 --- [ main] org.quartz.core.QuartzScheduler : JobFactory set to: ca.uhn.fhir.jpa.sched.AutowiringSpringBeanJobFactory@7f4fb4a3
2025-11-25T13:10:34.586Z INFO 1 --- [ main] org.quartz.core.QuartzScheduler : Scheduler hapi-fhir-jpa-scheduler_$_NON_CLUSTERED paused.
2025-11-25T13:10:34.965Z INFO 1 --- [ main] .s.i.SubscriptionSubmitInterceptorLoader : Subscriptions are disabled on this server. Subscriptions will not be activated and incoming resources will not be matched against subscriptions.
2025-11-25T13:10:35.539Z WARN 1 --- [ main] JpaBaseConfiguration$JpaWebConfiguration : 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
2025-11-25T13:10:37.177Z WARN 1 --- [ main] o.s.m.provider.tool.SyncMcpToolProvider : No tool methods found in the provided tool objects: []
2025-11-25T13:10:37.193Z INFO 1 --- [ main] o.s.a.m.s.c.a.McpServerAutoConfiguration : Enable tools capabilities, notification: true
2025-11-25T13:10:37.197Z INFO 1 --- [ main] o.s.a.m.s.c.a.McpServerAutoConfiguration : Registered tools: 9
2025-11-25T13:10:37.197Z INFO 1 --- [ main] o.s.a.m.s.c.a.McpServerAutoConfiguration : Enable resources capabilities, notification: true
2025-11-25T13:10:37.200Z INFO 1 --- [ main] o.s.a.m.s.c.a.McpServerAutoConfiguration : Enable prompts capabilities, notification: true
2025-11-25T13:10:37.201Z INFO 1 --- [ main] o.s.a.m.s.c.a.McpServerAutoConfiguration : Enable completions capabilities
2025-11-25T13:10:37.736Z INFO 1 --- [ main] org.quartz.impl.StdSchedulerFactory : Using default implementation for ThreadExecutor
2025-11-25T13:10:37.741Z INFO 1 --- [ main] org.quartz.core.SchedulerSignalerImpl : Initialized Scheduler Signaller of type: class org.quartz.core.SchedulerSignalerImpl
2025-11-25T13:10:37.742Z INFO 1 --- [ main] org.quartz.core.QuartzScheduler : Quartz Scheduler v.2.3.2 created.
2025-11-25T13:10:37.742Z INFO 1 --- [ main] org.quartz.simpl.RAMJobStore : RAMJobStore initialized.
2025-11-25T13:10:37.742Z INFO 1 --- [ main] org.quartz.core.QuartzScheduler : Scheduler meta-data: Quartz Scheduler (v2.3.2) 'quartzScheduler' with instanceId 'NON_CLUSTERED'
Scheduler class: 'org.quartz.core.QuartzScheduler' - running locally.
NOT STARTED.
Currently in standby mode.
Number of jobs executed: 0
Using thread pool 'org.quartz.simpl.SimpleThreadPool' - with 10 threads.
Using job-store 'org.quartz.simpl.RAMJobStore' - which does not support persistence. and is not clustered.
2025-11-25T13:10:37.742Z INFO 1 --- [ main] org.quartz.impl.StdSchedulerFactory : Quartz scheduler 'quartzScheduler' initialized from an externally provided properties instance.
2025-11-25T13:10:37.742Z INFO 1 --- [ main] org.quartz.impl.StdSchedulerFactory : Quartz scheduler version: 2.3.2
2025-11-25T13:10:37.742Z INFO 1 --- [ main] org.quartz.core.QuartzScheduler : JobFactory set to: org.springframework.scheduling.quartz.SpringBeanJobFactory@3ca38e3d
2025-11-25T13:10:37.946Z INFO 1 --- [ main] o.s.b.a.e.web.EndpointLinksResolver : Exposing 1 endpoint beneath base path '/actuator'
2025-11-25T13:10:38.230Z INFO 1 --- [ main] ca.uhn.fhir.rest.server.RestfulServer : Initializing HAPI FHIR restful server running in R4 mode
2025-11-25T13:10:38.241Z INFO 1 --- [ main] ca.uhn.fhir.rest.server.RestfulServer : Added 147 resource provider(s). Total 147
2025-11-25T13:10:39.040Z INFO 1 --- [ main] ca.uhn.fhir.rest.server.RestfulServer : Added 5 plain provider(s). Total 5
2025-11-25T13:10:39.059Z INFO 1 --- [ main] ca.uhn.fhir.rest.server.RestfulServer : Removing RESTful methods for: class ca.uhn.fhir.jpa.provider.JpaCapabilityStatementProvider
2025-11-25T13:10:39.061Z INFO 1 --- [ main] ca.uhn.fhir.rest.server.RestfulServer : OperationDefinition binding of ca.uhn.fhir.rest.server.method.ReadMethodBinding@4cdb11a6 was removed
2025-11-25T13:10:39.061Z INFO 1 --- [ main] ca.uhn.fhir.rest.server.RestfulServer : OperationDefinition binding of ca.uhn.fhir.rest.server.method.ReadMethodBinding@79765d4e was removed
2025-11-25T13:10:39.131Z INFO 1 --- [ main] ca.uhn.fhir.rest.server.RestfulServer : A FHIR has been lit on this server
2025-11-25T13:10:39.135Z INFO 1 --- [ main] o.s.b.w.embedded.tomcat.TomcatWebServer : Tomcat started on port 8080 (http) with context path '/'
2025-11-25T13:10:39.140Z INFO 1 --- [ main] o.s.s.quartz.SchedulerFactoryBean : Starting Quartz Scheduler now
2025-11-25T13:10:39.141Z INFO 1 --- [ main] org.quartz.core.QuartzScheduler : Scheduler quartzScheduler_$_NON_CLUSTERED started.
2025-11-25T13:10:39.144Z INFO 1 --- [ main] ca.uhn.fhir.log.batch_troubleshooting : Registering Batch2 Job Definition: BULK_IMPORT_PULL / 1
2025-11-25T13:10:39.145Z INFO 1 --- [ main] ca.uhn.fhir.log.batch_troubleshooting : Registering Batch2 Job Definition: BULK_IMPORT_PULL / 2
2025-11-25T13:10:39.146Z INFO 1 --- [ main] ca.uhn.fhir.log.batch_troubleshooting : Registering Batch2 Job Definition: REINDEX / 1
2025-11-25T13:10:39.146Z INFO 1 --- [ main] ca.uhn.fhir.log.batch_troubleshooting : Registering Batch2 Job Definition: REINDEX / 2
2025-11-25T13:10:39.146Z INFO 1 --- [ main] ca.uhn.fhir.log.batch_troubleshooting : Registering Batch2 Job Definition: DELETE_EXPUNGE / 1
2025-11-25T13:10:39.146Z INFO 1 --- [ main] ca.uhn.fhir.log.batch_troubleshooting : Registering Batch2 Job Definition: BULK_EXPORT / 1
2025-11-25T13:10:39.146Z INFO 1 --- [ main] ca.uhn.fhir.log.batch_troubleshooting : Registering Batch2 Job Definition: BULK_EXPORT / 2
2025-11-25T13:10:39.147Z INFO 1 --- [ main] ca.uhn.fhir.log.batch_troubleshooting : Registering Batch2 Job Definition: termCodeSystemVersionDeleteJob / 1
2025-11-25T13:10:39.147Z INFO 1 --- [ main] ca.uhn.fhir.log.batch_troubleshooting : Registering Batch2 Job Definition: termCodeSystemDeleteJob / 1
2025-11-25T13:10:39.147Z INFO 1 --- [ main] ca.uhn.fhir.log.batch_troubleshooting : Registering Batch2 Job Definition: bulkImportJob / 1
2025-11-25T13:10:39.149Z INFO 1 --- [ main] .j.s.m.m.s.MatchingQueueSubscriberLoader : Subscription Matching Subscriber subscribed to Matching Channel ca.uhn.fhir.broker.jms.SpringMessagingReceiverAdapter with name subscription-matching
2025-11-25T13:10:39.388Z INFO 1 --- [ main] c.u.f.log.terminology_troubleshooting : Performing initial retrieval for non-expiring cache: org.hl7.fhir.common.hapi.validation.support.ValidationSupportChain$FetchAllKey@2adf9cf1
2025-11-25T13:10:39.909Z INFO 1 --- [ main] c.u.f.log.terminology_troubleshooting : Initial retrieval for non-expiring cache org.hl7.fhir.common.hapi.validation.support.ValidationSupportChain$FetchAllKey@2adf9cf1 succeeded in 521ms
2025-11-25T13:10:40.226Z INFO 1 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Scheduling 15 jobs in application
2025-11-25T13:10:40.228Z INFO 1 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Scheduling local job ca.uhn.fhir.jpa.term.TermDeferredStorageSvcImpl$Job with interval 5000ms
2025-11-25T13:10:40.246Z INFO 1 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Scheduling local job ca.uhn.fhir.jpa.cache.ResourceChangeListenerCacheRefresherImpl with interval 00:00:10.000
2025-11-25T13:10:40.249Z INFO 1 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Scheduling clustered job ca.uhn.fhir.jpa.search.reindex.ResourceReindexingSvcImpl with interval 00:00:10.000
2025-11-25T13:10:40.251Z INFO 1 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Scheduling clustered job ca.uhn.fhir.jpa.bulk.export.svc.BulkDataExportJobSchedulingHelperImpl$PurgeExpiredFilesJob with interval 01:00:00
2025-11-25T13:10:40.252Z INFO 1 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Scheduling local job ca.uhn.fhir.jpa.bulk.imprt.svc.BulkDataImportSvcImpl$ActivationJob with interval 00:00:10.000
2025-11-25T13:10:40.254Z INFO 1 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Scheduling clustered job ca.uhn.fhir.jpa.search.warm.CacheWarmingSvcImpl with interval 00:00:10.000
2025-11-25T13:10:40.257Z INFO 1 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Scheduling clustered job ca.uhn.fhir.jpa.term.TermReadSvcImpl with interval 00:10:00
2025-11-25T13:10:40.260Z INFO 1 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Scheduling local job ca.uhn.fhir.jpa.term.TermReindexingSvcImpl with interval 00:01:00.000
2025-11-25T13:10:40.262Z INFO 1 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Scheduling clustered job ca.uhn.fhir.jpa.search.SearchUrlJobMaintenanceSvcImpl$SearchUrlMaintenanceJob with interval 00:10:00
2025-11-25T13:10:40.266Z INFO 1 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Scheduling clustered job ca.uhn.fhir.jpa.search.StaleSearchDeletingSvcImpl with interval 00:01:00.000
2025-11-25T13:10:40.267Z INFO 1 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Scheduling local job ca.uhn.fhir.jpa.util.ResourceCountCache with interval 00:10:00
2025-11-25T13:10:40.270Z INFO 1 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Scheduling local job ca.uhn.fhir.jpa.subscription.triggering.SubscriptionTriggeringSvcImpl with interval 5000ms
2025-11-25T13:10:40.272Z INFO 1 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Scheduling clustered job ca.uhn.fhir.jpa.subscription.async.AsyncResourceModifiedProcessingSchedulerSvc with interval 5000ms
2025-11-25T13:10:40.273Z INFO 1 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Scheduling clustered job ca.uhn.fhir.batch2.coordinator.ReductionStepExecutorServiceImpl$ReductionStepExecutorScheduledJob with interval 00:00:10.000
2025-11-25T13:10:40.273Z INFO 1 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Scheduling clustered job ca.uhn.fhir.batch2.maintenance.JobMaintenanceServiceImpl$JobMaintenanceScheduledJob with interval 00:01:00.000
2025-11-25T13:10:40.273Z INFO 1 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Starting task schedulers for context application
2025-11-25T13:10:40.274Z INFO 1 --- [ main] c.uhn.fhir.jpa.sched.BaseHapiScheduler : Starting scheduler hapi-fhir-jpa-scheduler-local
2025-11-25T13:10:40.276Z INFO 1 --- [ main] org.quartz.core.QuartzScheduler : Scheduler hapi-fhir-jpa-scheduler_$_NON_CLUSTERED started.
2025-11-25T13:10:40.277Z INFO 1 --- [ main] c.uhn.fhir.jpa.sched.BaseHapiScheduler : Starting scheduler hapi-fhir-jpa-scheduler-clustered
2025-11-25T13:10:40.282Z INFO 1 --- [ main] org.quartz.core.QuartzScheduler : Scheduler hapi-fhir-jpa-scheduler_$_NON_CLUSTERED started.
2025-11-25T13:10:40.330Z INFO 1 --- [ main] ca.uhn.fhir.jpa.starter.Application : Started Application in 88.524 seconds (process running for 97.398)
As can be seen, no Errors.