hapi-fhir-jpaserver-starter
hapi-fhir-jpaserver-starter copied to clipboard
hapifhir
Default spring boot fails
With current main branch checked out, the server fails to show the UI at http://localhost:8080
Instead, it yields:
Whitelabel Error Page
This application has no explicit mapping for /error, so you are seeing this as a fallback.
Thu Sep 26 11:32:44 AEST 2024
There was an unexpected error (type=Internal Server Error, status=500).
The execution stack is below. This is on Ubuntu 24.04 with maven as follows:
sue005@annapurna-bh:~/git/hapi-fhir-jpaserver-starter$ mvn --version Apache Maven 3.8.7 Maven home: /usr/share/maven Java version: 21.0.4, vendor: Ubuntu, runtime: /usr/lib/jvm/java-21-openjdk-amd64 Default locale: en_AU, platform encoding: UTF-8 OS name: "linux", version: "6.8.0-45-generic", arch: "amd64", family: "unix"
sue005@annapurna-bh:~/git/hapi-fhir-jpaserver-starter$ mvn clean && mvn spring-boot:run
[INFO] Scanning for projects...
[WARNING] The project ca.uhn.hapi.fhir:hapi-fhir-jpaserver-starter:war:7.4.0 uses prerequisites which is only intended for maven-plugin projects but not for non maven-plugin projects. For such purposes you should use the maven-enforcer-plugin. See https://maven.apache.org/enforcer/enforcer-rules/requireMavenVersion.html
[INFO]
[INFO] ------------< ca.uhn.hapi.fhir:hapi-fhir-jpaserver-starter >------------
[INFO] Building HAPI FHIR JPA Server - Starter Project 7.4.0
[INFO] --------------------------------[ war ]---------------------------------
[INFO]
[INFO] --- maven-clean-plugin:3.1.0:clean (default-clean) @ hapi-fhir-jpaserver-starter ---
[INFO] Deleting /home/sue005/git/hapi-fhir-jpaserver-starter/target
[INFO] ------------------------------------------------------------------------
[INFO] BUILD SUCCESS
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 0.206 s
[INFO] Finished at: 2024-09-26T11:32:15+10:00
[INFO] ------------------------------------------------------------------------
[INFO] Scanning for projects...
[WARNING] The project ca.uhn.hapi.fhir:hapi-fhir-jpaserver-starter:war:7.4.0 uses prerequisites which is only intended for maven-plugin projects but not for non maven-plugin projects. For such purposes you should use the maven-enforcer-plugin. See https://maven.apache.org/enforcer/enforcer-rules/requireMavenVersion.html
[INFO]
[INFO] ------------< ca.uhn.hapi.fhir:hapi-fhir-jpaserver-starter >------------
[INFO] Building HAPI FHIR JPA Server - Starter Project 7.4.0
[INFO] --------------------------------[ war ]---------------------------------
[INFO]
[INFO] >>> spring-boot-maven-plugin:3.2.6:run (default-cli) > test-compile @ hapi-fhir-jpaserver-starter >>>
[INFO]
[INFO] --- maven-enforcer-plugin:3.3.0:enforce (enforce-maven) @ hapi-fhir-jpaserver-starter ---
[INFO] Rule 0: org.apache.maven.enforcer.rules.version.RequireMavenVersion passed
[INFO] Rule 1: org.apache.maven.enforcer.rules.version.RequireJavaVersion passed
[INFO]
[INFO] --- maven-resources-plugin:3.3.0:resources (default-resources) @ hapi-fhir-jpaserver-starter ---
[INFO] Copying 4 resources
[INFO]
[INFO] --- maven-compiler-plugin:3.13.0:compile (default-compile) @ hapi-fhir-jpaserver-starter ---
[INFO] Recompiling the module because of changed source code.
[INFO] Compiling 58 source files with javac [forked debug release 17] to target/classes
[WARNING] Unable to autodetect 'javac' path, using 'javac' from the environment.
...
Did you mean '@Override public void remove(Supplier<Object> theSupplier) {'?
[INFO]
[INFO] --- maven-resources-plugin:3.3.0:testResources (default-testResources) @ hapi-fhir-jpaserver-starter ---
[INFO] Copying 18 resources
[INFO]
[INFO] --- maven-compiler-plugin:3.13.0:testCompile (default-testCompile) @ hapi-fhir-jpaserver-starter ---
[INFO] Recompiling the module because of changed dependency.
[INFO] Compiling 20 source files with javac [forked debug release 17] to target/test-classes
[WARNING] Unable to autodetect 'javac' path, using 'javac' from the environment.
[INFO]
[INFO] <<< spring-boot-maven-plugin:3.2.6:run (default-cli) < test-compile @ hapi-fhir-jpaserver-starter <<<
[INFO]
[INFO]
[INFO] --- spring-boot-maven-plugin:3.2.6:run (default-cli) @ hapi-fhir-jpaserver-starter ---
[INFO] Attaching agents: []
. ____ _ __ _ _
/\\ / ___'_ __ _ _(_)_ __ __ _ \ \ \ \
( ( )\___ | '_ | '_| | '_ \/ _` | \ \ \ \
\\/ ___)| |_)| | | | | || (_| | ) ) ) )
' |____| .__|_| |_|_| |_\__, | / / / /
=========|_|==============|___/=/_/_/_/
:: Spring Boot :: (v3.2.6)
2024-09-26T11:32:22.182+10:00 INFO 184355 --- [ main] ca.uhn.fhir.jpa.starter.Application : Starting Application using Java 21.0.4 with PID 184355 (/home/sue005/git/hapi-fhir-jpaserver-starter/target/classes started by sue005 in /home/sue005/git/hapi-fhir-jpaserver-starter)
2024-09-26T11:32:22.183+10:00 INFO 184355 --- [ main] ca.uhn.fhir.jpa.starter.Application : No active profile set, falling back to 1 default profile: "default"
2024-09-26T11:32:22.618+10:00 INFO 184355 --- [ main] .s.d.r.c.RepositoryConfigurationDelegate : Bootstrapping Spring Data JPA repositories in DEFAULT mode.
2024-09-26T11:32:22.695+10:00 INFO 184355 --- [ main] .s.d.r.c.RepositoryConfigurationDelegate : Finished Spring Data repository scanning in 73 ms. Found 53 JPA repository interfaces.
2024-09-26T11:32:23.422+10:00 WARN 184355 --- [ 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.
2024-09-26T11:32:23.589+10:00 INFO 184355 --- [ main] o.s.b.w.embedded.tomcat.TomcatWebServer : Tomcat initialized with port 8080 (http)
2024-09-26T11:32:23.596+10:00 INFO 184355 --- [ main] o.apache.catalina.core.StandardService : Starting service [Tomcat]
2024-09-26T11:32:23.596+10:00 INFO 184355 --- [ main] o.apache.catalina.core.StandardEngine : Starting Servlet engine: [Apache Tomcat/10.1.24]
2024-09-26T11:32:23.631+10:00 INFO 184355 --- [ main] o.a.c.c.C.[Tomcat].[localhost].[/] : Initializing Spring embedded WebApplicationContext
2024-09-26T11:32:23.631+10:00 INFO 184355 --- [ main] w.s.c.ServletWebServerApplicationContext : Root WebApplicationContext: initialization completed in 1417 ms
2024-09-26T11:32:23.673+10:00 INFO 184355 --- [ main] ca.uhn.fhir.util.VersionUtil : HAPI FHIR version 7.4.0 - Rev 71e9af61cf
2024-09-26T11:32:23.675+10:00 INFO 184355 --- [ main] ca.uhn.fhir.context.FhirContext : Creating new FHIR context for FHIR version [R4]
2024-09-26T11:32:23.688+10:00 INFO 184355 --- [ main] c.u.f.j.s.common.FhirServerConfigCommon : Server configured to allow contains searches
2024-09-26T11:32:23.688+10:00 INFO 184355 --- [ main] c.u.f.j.s.common.FhirServerConfigCommon : Server configured to deny multiple deletes
2024-09-26T11:32:23.688+10:00 INFO 184355 --- [ main] c.u.f.j.s.common.FhirServerConfigCommon : Server configured to deny external references
2024-09-26T11:32:23.688+10:00 INFO 184355 --- [ main] c.u.f.j.s.common.FhirServerConfigCommon : Server configured to enable DAO scheduling
2024-09-26T11:32:23.688+10:00 INFO 184355 --- [ main] c.u.f.j.s.common.FhirServerConfigCommon : Server configured to disable delete expunges
2024-09-26T11:32:23.689+10:00 INFO 184355 --- [ main] c.u.f.j.s.common.FhirServerConfigCommon : Server configured to enable expunges
2024-09-26T11:32:23.689+10:00 INFO 184355 --- [ main] c.u.f.j.s.common.FhirServerConfigCommon : Server configured to allow overriding default search params
2024-09-26T11:32:23.689+10:00 INFO 184355 --- [ main] c.u.f.j.s.common.FhirServerConfigCommon : Server configured to disable auto-creating placeholder references
2024-09-26T11:32:23.689+10:00 INFO 184355 --- [ main] c.u.f.j.s.common.FhirServerConfigCommon : Server configured to auto-version references at paths []
2024-09-26T11:32:23.700+10:00 INFO 184355 --- [ main] c.u.f.j.s.common.FhirServerConfigCommon : Server configured to have a maximum fetch size of 'unlimited'
2024-09-26T11:32:23.701+10:00 INFO 184355 --- [ main] c.u.f.j.s.common.FhirServerConfigCommon : Server configured to cache search results for 60000 milliseconds
2024-09-26T11:32:23.701+10:00 INFO 184355 --- [ main] c.u.f.j.s.common.FhirServerConfigCommon : Server configured to use 'ALPHANUMERIC' Client ID Strategy
2024-09-26T11:32:23.732+10:00 INFO 184355 --- [ main] o.hibernate.jpa.internal.util.LogHelper : HHH000204: Processing PersistenceUnitInfo [name: HAPI_PU]
2024-09-26T11:32:23.783+10:00 INFO 184355 --- [ main] org.hibernate.Version : HHH000412: Hibernate ORM core version 6.4.1.Final
2024-09-26T11:32:23.788+10:00 INFO 184355 --- [ main] .f.j.l.FilteringSqlLoggerImplContributor : Adding service: SqlStatementFilteringLogger
2024-09-26T11:32:23.803+10:00 INFO 184355 --- [ main] o.h.c.internal.RegionFactoryInitiator : HHH000026: Second-level cache disabled
2024-09-26T11:32:23.839+10:00 INFO 184355 --- [ main] o.h.e.boot.internal.EnversServiceImpl : Envers integration enabled? : true
2024-09-26T11:32:23.922+10:00 INFO 184355 --- [ main] o.s.o.j.p.SpringPersistenceUnitInfo : No LoadTimeWeaver setup: ignoring JPA class transformer
2024-09-26T11:32:23.936+10:00 INFO 184355 --- [ main] com.zaxxer.hikari.HikariDataSource : HikariPool-1 - Starting...
2024-09-26T11:32:24.160+10:00 INFO 184355 --- [ main] com.zaxxer.hikari.pool.HikariPool : HikariPool-1 - Added connection conn0: url=jdbc:h2:mem:test_mem user=SA
2024-09-26T11:32:24.161+10:00 INFO 184355 --- [ main] com.zaxxer.hikari.HikariDataSource : HikariPool-1 - Start completed.
2024-09-26T11:32:24.458+10:00 INFO 184355 --- [ main] o.h.e.c.i.m.AuditMetadataGenerator : Adding properties for entity: ca.uhn.fhir.jpa.entity.MdmLink
2024-09-26T11:32:24.478+10:00 INFO 184355 --- [ main] b.i.HibernateSearchPreIntegrationService : HSEARCH000034: Hibernate Search version 7.0.0.Final
2024-09-26T11:32:25.248+10:00 INFO 184355 --- [ main] o.h.e.t.j.p.i.JtaPlatformInitiator : HHH000489: No JTA platform available (set 'hibernate.transaction.jta.platform' to enable JTA platform integration)
2024-09-26T11:32:25.339+10:00 INFO 184355 --- [ main] irLocalContainerEntityManagerFactoryBean : Initialized JPA EntityManagerFactory for persistence unit 'HAPI_PU'
2024-09-26T11:32:25.676+10:00 INFO 184355 --- [ main] .u.f.c.s.DefaultProfileValidationSupport : Loading structure definitions from classpath: /org/hl7/fhir/r4/model/profile/profiles-resources.xml
2024-09-26T11:32:25.686+10:00 INFO 184355 --- [ main] ca.uhn.fhir.util.XmlUtil : FHIR XML procesing will use StAX implementation 'Woodstox' version '6.4.0'
2024-09-26T11:32:26.159+10:00 INFO 184355 --- [ main] .u.f.c.s.DefaultProfileValidationSupport : Loading structure definitions from classpath: /org/hl7/fhir/r4/model/profile/profiles-types.xml
2024-09-26T11:32:26.187+10:00 INFO 184355 --- [ main] .u.f.c.s.DefaultProfileValidationSupport : Loading structure definitions from classpath: /org/hl7/fhir/r4/model/profile/profiles-others.xml
2024-09-26T11:32:26.303+10:00 INFO 184355 --- [ main] .u.f.c.s.DefaultProfileValidationSupport : Loading structure definitions from classpath: /org/hl7/fhir/r4/model/extension/extension-definitions.xml
2024-09-26T11:32:26.642+10:00 INFO 184355 --- [ main] o.s.d.j.r.query.QueryEnhancerFactory : Hibernate is in classpath; If applicable, HQL parser will be used.
2024-09-26T11:32:27.535+10:00 INFO 184355 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Creating Local Scheduler
2024-09-26T11:32:27.550+10:00 INFO 184355 --- [ main] org.quartz.impl.StdSchedulerFactory : Using default implementation for ThreadExecutor
2024-09-26T11:32:27.556+10:00 INFO 184355 --- [ main] org.quartz.core.SchedulerSignalerImpl : Initialized Scheduler Signaller of type: class org.quartz.core.SchedulerSignalerImpl
2024-09-26T11:32:27.556+10:00 INFO 184355 --- [ main] org.quartz.core.QuartzScheduler : Quartz Scheduler v.2.3.2 created.
2024-09-26T11:32:27.556+10:00 INFO 184355 --- [ main] org.quartz.simpl.RAMJobStore : RAMJobStore initialized.
2024-09-26T11:32:27.556+10:00 INFO 184355 --- [ 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.
2024-09-26T11:32:27.556+10:00 INFO 184355 --- [ main] org.quartz.impl.StdSchedulerFactory : Quartz scheduler 'hapi-fhir-jpa-scheduler' initialized from an externally provided properties instance.
2024-09-26T11:32:27.556+10:00 INFO 184355 --- [ main] org.quartz.impl.StdSchedulerFactory : Quartz scheduler version: 2.3.2
2024-09-26T11:32:27.556+10:00 INFO 184355 --- [ main] org.quartz.core.QuartzScheduler : JobFactory set to: ca.uhn.fhir.jpa.sched.AutowiringSpringBeanJobFactory@f51c595
2024-09-26T11:32:27.556+10:00 INFO 184355 --- [ main] org.quartz.core.QuartzScheduler : Scheduler hapi-fhir-jpa-scheduler_$_NON_CLUSTERED paused.
2024-09-26T11:32:27.556+10:00 INFO 184355 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Creating Clustered Scheduler
2024-09-26T11:32:27.557+10:00 INFO 184355 --- [ main] org.quartz.impl.StdSchedulerFactory : Using default implementation for ThreadExecutor
2024-09-26T11:32:27.557+10:00 INFO 184355 --- [ main] org.quartz.core.SchedulerSignalerImpl : Initialized Scheduler Signaller of type: class org.quartz.core.SchedulerSignalerImpl
2024-09-26T11:32:27.557+10:00 INFO 184355 --- [ main] org.quartz.core.QuartzScheduler : Quartz Scheduler v.2.3.2 created.
2024-09-26T11:32:27.557+10:00 INFO 184355 --- [ main] org.quartz.simpl.RAMJobStore : RAMJobStore initialized.
2024-09-26T11:32:27.557+10:00 INFO 184355 --- [ 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.
2024-09-26T11:32:27.557+10:00 INFO 184355 --- [ main] org.quartz.impl.StdSchedulerFactory : Quartz scheduler 'hapi-fhir-jpa-scheduler' initialized from an externally provided properties instance.
2024-09-26T11:32:27.557+10:00 INFO 184355 --- [ main] org.quartz.impl.StdSchedulerFactory : Quartz scheduler version: 2.3.2
2024-09-26T11:32:27.557+10:00 INFO 184355 --- [ main] org.quartz.core.QuartzScheduler : JobFactory set to: ca.uhn.fhir.jpa.sched.AutowiringSpringBeanJobFactory@f51c595
2024-09-26T11:32:27.557+10:00 INFO 184355 --- [ main] org.quartz.core.QuartzScheduler : Scheduler hapi-fhir-jpa-scheduler_$_NON_CLUSTERED paused.
2024-09-26T11:32:27.748+10:00 INFO 184355 --- [ main] ca.uhn.fhir.context.FhirContext : Creating new FHIR context for FHIR version [R4]
2024-09-26T11:32:27.871+10:00 INFO 184355 --- [ main] c.u.f.j.starter.common.StarterJpaConfig : CORS is enabled on this server
2024-09-26T11:32:27.872+10:00 INFO 184355 --- [ main] c.u.f.j.starter.common.StarterJpaConfig : CORS allows the following origins: *
2024-09-26T11:32:31.502+10:00 INFO 184355 --- [ main] ca.uhn.fhir.context.FhirContext : Creating new FHIR context for FHIR version [R4]
2024-09-26T11:32:31.791+10:00 WARN 184355 --- [ 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
2024-09-26T11:32:31.967+10:00 INFO 184355 --- [ main] .s.i.SubscriptionSubmitInterceptorLoader : Subscriptions are disabled on this server. Subscriptions will not be activated and incoming resources will not be matched against subscriptions.
2024-09-26T11:32:32.112+10:00 INFO 184355 --- [ main] c.u.f.j.s.registry.JpaSearchParamCache : Have 0 unique search params
2024-09-26T11:32:32.347+10:00 INFO 184355 --- [ main] org.quartz.impl.StdSchedulerFactory : Using default implementation for ThreadExecutor
2024-09-26T11:32:32.348+10:00 INFO 184355 --- [ main] org.quartz.core.SchedulerSignalerImpl : Initialized Scheduler Signaller of type: class org.quartz.core.SchedulerSignalerImpl
2024-09-26T11:32:32.348+10:00 INFO 184355 --- [ main] org.quartz.core.QuartzScheduler : Quartz Scheduler v.2.3.2 created.
2024-09-26T11:32:32.348+10:00 INFO 184355 --- [ main] org.quartz.simpl.RAMJobStore : RAMJobStore initialized.
2024-09-26T11:32:32.348+10:00 INFO 184355 --- [ 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.
2024-09-26T11:32:32.348+10:00 INFO 184355 --- [ main] org.quartz.impl.StdSchedulerFactory : Quartz scheduler 'quartzScheduler' initialized from an externally provided properties instance.
2024-09-26T11:32:32.348+10:00 INFO 184355 --- [ main] org.quartz.impl.StdSchedulerFactory : Quartz scheduler version: 2.3.2
2024-09-26T11:32:32.348+10:00 INFO 184355 --- [ main] org.quartz.core.QuartzScheduler : JobFactory set to: org.springframework.scheduling.quartz.SpringBeanJobFactory@66413a14
2024-09-26T11:32:32.366+10:00 INFO 184355 --- [ main] o.s.b.a.e.web.EndpointLinksResolver : Exposing 1 endpoint(s) beneath base path '/actuator'
2024-09-26T11:32:32.448+10:00 INFO 184355 --- [ main] ca.uhn.fhir.rest.server.RestfulServer : Initializing HAPI FHIR restful server running in R4 mode
2024-09-26T11:32:32.450+10:00 INFO 184355 --- [ main] ca.uhn.fhir.rest.server.RestfulServer : Added 147 resource provider(s). Total 147
2024-09-26T11:32:32.625+10:00 INFO 184355 --- [ main] ca.uhn.fhir.rest.server.RestfulServer : Added 4 plain provider(s). Total 4
2024-09-26T11:32:32.628+10:00 INFO 184355 --- [ main] ca.uhn.fhir.rest.server.RestfulServer : Removing RESTful methods for: class ca.uhn.fhir.jpa.provider.JpaCapabilityStatementProvider
2024-09-26T11:32:32.628+10:00 INFO 184355 --- [ main] ca.uhn.fhir.rest.server.RestfulServer : OperationDefinition binding of ca.uhn.fhir.rest.server.method.ReadMethodBinding@705bd68c was removed
2024-09-26T11:32:32.628+10:00 INFO 184355 --- [ main] ca.uhn.fhir.rest.server.RestfulServer : OperationDefinition binding of ca.uhn.fhir.rest.server.method.ReadMethodBinding@41d71bec was removed
2024-09-26T11:32:32.640+10:00 INFO 184355 --- [ main] ca.uhn.fhir.rest.server.RestfulServer : A FHIR has been lit on this server
2024-09-26T11:32:32.640+10:00 INFO 184355 --- [ main] o.s.b.w.embedded.tomcat.TomcatWebServer : Tomcat started on port 8080 (http) with context path ''
2024-09-26T11:32:32.642+10:00 INFO 184355 --- [ main] o.s.s.quartz.SchedulerFactoryBean : Starting Quartz Scheduler now
2024-09-26T11:32:32.642+10:00 INFO 184355 --- [ main] org.quartz.core.QuartzScheduler : Scheduler quartzScheduler_$_NON_CLUSTERED started.
2024-09-26T11:32:32.643+10:00 INFO 184355 --- [ main] ca.uhn.fhir.log.batch_troubleshooting : Registering Batch2 Job Definition: BULK_IMPORT_PULL / 1
2024-09-26T11:32:32.644+10:00 INFO 184355 --- [ main] ca.uhn.fhir.log.batch_troubleshooting : Registering Batch2 Job Definition: REINDEX / 1
2024-09-26T11:32:32.644+10:00 INFO 184355 --- [ main] ca.uhn.fhir.log.batch_troubleshooting : Registering Batch2 Job Definition: DELETE_EXPUNGE / 1
2024-09-26T11:32:32.644+10:00 INFO 184355 --- [ main] ca.uhn.fhir.log.batch_troubleshooting : Registering Batch2 Job Definition: BULK_EXPORT / 1
2024-09-26T11:32:32.644+10:00 INFO 184355 --- [ main] ca.uhn.fhir.log.batch_troubleshooting : Registering Batch2 Job Definition: BULK_EXPORT / 2
2024-09-26T11:32:32.644+10:00 INFO 184355 --- [ main] ca.uhn.fhir.log.batch_troubleshooting : Registering Batch2 Job Definition: termCodeSystemVersionDeleteJob / 1
2024-09-26T11:32:32.644+10:00 INFO 184355 --- [ main] ca.uhn.fhir.log.batch_troubleshooting : Registering Batch2 Job Definition: termCodeSystemDeleteJob / 1
2024-09-26T11:32:32.644+10:00 INFO 184355 --- [ main] ca.uhn.fhir.log.batch_troubleshooting : Registering Batch2 Job Definition: bulkImportJob / 1
2024-09-26T11:32:32.644+10:00 INFO 184355 --- [ main] .j.s.m.m.s.MatchingQueueSubscriberLoader : Subscription Matching Subscriber subscribed to Matching Channel ca.uhn.fhir.jpa.subscription.channel.subscription.BroadcastingSubscribableChannelWrapper with name subscription-matching
2024-09-26T11:32:32.652+10:00 INFO 184355 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Scheduling 15 jobs in application
2024-09-26T11:32:32.652+10:00 INFO 184355 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Scheduling local job ca.uhn.fhir.jpa.term.TermDeferredStorageSvcImpl$Job with interval 5000ms
2024-09-26T11:32:32.654+10:00 INFO 184355 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Scheduling local job ca.uhn.fhir.jpa.cache.ResourceChangeListenerCacheRefresherImpl with interval 00:00:10.000
2024-09-26T11:32:32.655+10:00 INFO 184355 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Scheduling clustered job ca.uhn.fhir.jpa.search.reindex.ResourceReindexingSvcImpl with interval 00:00:10.000
2024-09-26T11:32:32.655+10:00 INFO 184355 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Scheduling clustered job ca.uhn.fhir.jpa.bulk.export.svc.BulkDataExportJobSchedulingHelperImpl$PurgeExpiredFilesJob with interval 01:00:00
2024-09-26T11:32:32.655+10:00 INFO 184355 --- [ 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
2024-09-26T11:32:32.655+10:00 INFO 184355 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Scheduling clustered job ca.uhn.fhir.jpa.search.warm.CacheWarmingSvcImpl with interval 00:00:10.000
2024-09-26T11:32:32.655+10:00 INFO 184355 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Scheduling clustered job ca.uhn.fhir.jpa.term.TermReadSvcImpl with interval 00:10:00
2024-09-26T11:32:32.655+10:00 INFO 184355 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Scheduling local job ca.uhn.fhir.jpa.term.TermReindexingSvcImpl with interval 00:01:00.000
2024-09-26T11:32:32.656+10:00 INFO 184355 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Scheduling clustered job ca.uhn.fhir.jpa.search.SearchUrlJobMaintenanceSvcImpl$SearchUrlMaintenanceJob with interval 00:10:00
2024-09-26T11:32:32.656+10:00 INFO 184355 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Scheduling clustered job ca.uhn.fhir.jpa.search.StaleSearchDeletingSvcImpl with interval 00:01:00.000
2024-09-26T11:32:32.656+10:00 INFO 184355 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Scheduling local job ca.uhn.fhir.jpa.util.ResourceCountCache with interval 00:10:00
2024-09-26T11:32:32.656+10:00 INFO 184355 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Scheduling local job ca.uhn.fhir.jpa.subscription.triggering.SubscriptionTriggeringSvcImpl with interval 5000ms
2024-09-26T11:32:32.656+10:00 INFO 184355 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Scheduling clustered job ca.uhn.fhir.jpa.subscription.async.AsyncResourceModifiedProcessingSchedulerSvc with interval 5000ms
2024-09-26T11:32:32.656+10:00 INFO 184355 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Scheduling clustered job ca.uhn.fhir.batch2.coordinator.ReductionStepExecutorServiceImpl$ReductionStepExecutorScheduledJob with interval 00:00:10.000
2024-09-26T11:32:32.656+10:00 INFO 184355 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Scheduling clustered job ca.uhn.fhir.batch2.maintenance.JobMaintenanceServiceImpl$JobMaintenanceScheduledJob with interval 00:01:00.000
2024-09-26T11:32:32.656+10:00 INFO 184355 --- [ main] c.u.f.j.sched.BaseSchedulerServiceImpl : Starting task schedulers for context application
2024-09-26T11:32:32.657+10:00 INFO 184355 --- [ main] c.uhn.fhir.jpa.sched.BaseHapiScheduler : Starting scheduler hapi-fhir-jpa-scheduler-local
2024-09-26T11:32:32.657+10:00 INFO 184355 --- [ main] org.quartz.core.QuartzScheduler : Scheduler hapi-fhir-jpa-scheduler_$_NON_CLUSTERED started.
2024-09-26T11:32:32.657+10:00 INFO 184355 --- [ main] c.uhn.fhir.jpa.sched.BaseHapiScheduler : Starting scheduler hapi-fhir-jpa-scheduler-clustered
2024-09-26T11:32:32.657+10:00 INFO 184355 --- [ main] org.quartz.core.QuartzScheduler : Scheduler hapi-fhir-jpa-scheduler_$_NON_CLUSTERED started.
2024-09-26T11:32:32.659+10:00 INFO 184355 --- [ main] ca.uhn.fhir.jpa.starter.Application : Started Application in 10.675 seconds (process running for 10.929)
2024-09-26T11:32:32.671+10:00 INFO 184355 --- [ler-clustered-1] .s.BulkDataExportJobSchedulingHelperImpl : Finished bulk export job deletion with nothing to do
2024-09-26T11:32:43.497+10:00 INFO 184355 --- [nio-8080-exec-1] o.a.c.c.C.[Tomcat].[localhost].[/] : Initializing Spring DispatcherServlet 'dispatcherServlet'
2024-09-26T11:32:43.497+10:00 INFO 184355 --- [nio-8080-exec-1] o.s.web.servlet.DispatcherServlet : Initializing Servlet 'dispatcherServlet'
2024-09-26T11:32:43.500+10:00 INFO 184355 --- [nio-8080-exec-1] o.s.web.servlet.DispatcherServlet : Completed initialization in 3 ms
2024-09-26T11:32:43.534+10:00 INFO 184355 --- [nio-8080-exec-1] ca.uhn.fhir.context.FhirContext : Creating new FHIR context for FHIR version [R4]
2024-09-26T11:32:44.134+10:00 INFO 184355 --- [nio-8080-exec-2] fhirtest.access : Path[/fhir] Source[] Operation[metadata ] UA[HAPI-FHIR/7.4.0 (FHIR Client; FHIR 4.0.1/R4; apache)] Params[] ResponseEncoding[JSON] Operation[metadata ] UA[HAPI-FHIR/7.4.0 (FHIR Client; FHIR 4.0.1/R4; apache)] Params[] ResponseEncoding[JSON]
2024-09-26T11:32:44.260+10:00 INFO 184355 --- [nio-8080-exec-1] ca.uhn.fhir.context.FhirContext : Creating new FHIR context for FHIR version [R4]
2024-09-26T11:32:44.373+10:00 ERROR 184355 --- [nio-8080-exec-1] org.thymeleaf.TemplateEngine : [THYMELEAF][http-nio-8080-exec-1] Exception processing template "home": An error happened during template parsing (template: "ServletContext resource [/WEB-INF/templates/home.html]")
org.thymeleaf.exceptions.TemplateInputException: An error happened during template parsing (template: "ServletContext resource [/WEB-INF/templates/home.html]")
at org.thymeleaf.templateparser.markup.AbstractMarkupTemplateParser.parse(AbstractMarkupTemplateParser.java:235)
at org.thymeleaf.templateparser.markup.AbstractMarkupTemplateParser.parseStandalone(AbstractMarkupTemplateParser.java:100)
at org.thymeleaf.engine.TemplateManager.parseAndProcess(TemplateManager.java:649)
at org.thymeleaf.TemplateEngine.process(TemplateEngine.java:1103)
at org.thymeleaf.TemplateEngine.process(TemplateEngine.java:1077)
at org.thymeleaf.spring6.view.ThymeleafView.renderFragment(ThymeleafView.java:372)
at org.thymeleaf.spring6.view.ThymeleafView.render(ThymeleafView.java:192)
at org.springframework.web.servlet.DispatcherServlet.render(DispatcherServlet.java:1431)
at org.springframework.web.servlet.DispatcherServlet.processDispatchResult(DispatcherServlet.java:1167)
at org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:1106)
at org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:979)
at org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:1014)
at org.springframework.web.servlet.FrameworkServlet.doGet(FrameworkServlet.java:903)
at jakarta.servlet.http.HttpServlet.service(HttpServlet.java:527)
at org.springframework.web.servlet.FrameworkServlet.service(FrameworkServlet.java:885)
at jakarta.servlet.http.HttpServlet.service(HttpServlet.java:614)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:195)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:140)
at org.apache.tomcat.websocket.server.WsFilter.doFilter(WsFilter.java:51)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:164)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:140)
at org.springframework.web.filter.ServerHttpObservationFilter.doFilterInternal(ServerHttpObservationFilter.java:109)
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:116)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:164)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:140)
at org.springframework.web.filter.CharacterEncodingFilter.doFilterInternal(CharacterEncodingFilter.java:201)
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:116)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:164)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:140)
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:167)
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:90)
at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:482)
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:115)
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:93)
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74)
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:344)
at org.apache.coyote.http11.Http11Processor.service(Http11Processor.java:389)
at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:63)
at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:896)
at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1741)
at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52)
at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1190)
at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659)
at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:63)
at java.base/java.lang.Thread.run(Thread.java:1583)
Caused by: java.io.FileNotFoundException: Could not open ServletContext resource [/WEB-INF/templates/home.html]
at org.springframework.web.context.support.ServletContextResource.getInputStream(ServletContextResource.java:165)
at org.thymeleaf.spring6.templateresource.SpringResourceTemplateResource.reader(SpringResourceTemplateResource.java:103)
at org.thymeleaf.templateparser.markup.AbstractMarkupTemplateParser.parse(AbstractMarkupTemplateParser.java:223)
... 44 common frames omitted
2024-09-26T11:32:44.376+10:00 ERROR 184355 --- [nio-8080-exec-1] o.a.c.c.C.[.[.[/].[dispatcherServlet] : Servlet.service() for servlet [dispatcherServlet] in context with path [] threw exception [Request processing failed: org.thymeleaf.exceptions.TemplateInputException: An error happened during template parsing (template: "ServletContext resource [/WEB-INF/templates/home.html]")] with root cause
java.io.FileNotFoundException: Could not open ServletContext resource [/WEB-INF/templates/home.html]
at org.springframework.web.context.support.ServletContextResource.getInputStream(ServletContextResource.java:165)
at org.thymeleaf.spring6.templateresource.SpringResourceTemplateResource.reader(SpringResourceTemplateResource.java:103)
at org.thymeleaf.templateparser.markup.AbstractMarkupTemplateParser.parse(AbstractMarkupTemplateParser.java:223)
at org.thymeleaf.templateparser.markup.AbstractMarkupTemplateParser.parseStandalone(AbstractMarkupTemplateParser.java:100)
at org.thymeleaf.engine.TemplateManager.parseAndProcess(TemplateManager.java:649)
at org.thymeleaf.TemplateEngine.process(TemplateEngine.java:1103)
at org.thymeleaf.TemplateEngine.process(TemplateEngine.java:1077)
at org.thymeleaf.spring6.view.ThymeleafView.renderFragment(ThymeleafView.java:372)
at org.thymeleaf.spring6.view.ThymeleafView.render(ThymeleafView.java:192)
at org.springframework.web.servlet.DispatcherServlet.render(DispatcherServlet.java:1431)
at org.springframework.web.servlet.DispatcherServlet.processDispatchResult(DispatcherServlet.java:1167)
at org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:1106)
at org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:979)
at org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:1014)
at org.springframework.web.servlet.FrameworkServlet.doGet(FrameworkServlet.java:903)
at jakarta.servlet.http.HttpServlet.service(HttpServlet.java:527)
at org.springframework.web.servlet.FrameworkServlet.service(FrameworkServlet.java:885)
at jakarta.servlet.http.HttpServlet.service(HttpServlet.java:614)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:195)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:140)
at org.apache.tomcat.websocket.server.WsFilter.doFilter(WsFilter.java:51)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:164)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:140)
at org.springframework.web.filter.ServerHttpObservationFilter.doFilterInternal(ServerHttpObservationFilter.java:109)
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:116)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:164)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:140)
at org.springframework.web.filter.CharacterEncodingFilter.doFilterInternal(CharacterEncodingFilter.java:201)
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:116)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:164)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:140)
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:167)
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:90)
at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:482)
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:115)
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:93)
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74)
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:344)
at org.apache.coyote.http11.Http11Processor.service(Http11Processor.java:389)
at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:63)
at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:896)
at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1741)
at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52)
at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1190)
at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659)
at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:63)
at java.base/java.lang.Thread.run(Thread.java:1583)
it work while running the jar.. so, mvn clean install and for running java -jar /target/ROOT.war
@jgsuess - do the step here: https://github.com/hapifhir/hapi-fhir-jpaserver-starter?tab=readme-ov-file#using-spring-boot-1 if you by "fail" mean that the maven overlay fails to load.
