2020-06-29 11:34:15,669 DEBUG -> (main) [org.jnp.server.NamingBeanImpl] Using NamingServer: org.jnp.server.NamingServer@53bf851d
2020-06-29 11:34:15,670 DEBUG -> (main) [org.jnp.server.NamingBeanImpl] Installed global NamingServer: org.jnp.server.NamingServer@53bf851d
2020-06-29 11:34:15,770 DEBUG -> (main) [org.jnp.server.NamingBeanImpl] InitialContext Environment: 
2020-06-29 11:34:15,770 DEBUG -> (main) [org.jnp.server.NamingBeanImpl] key=java.naming.factory.initial, value(java.lang.String)=org.jnp.interfaces.NamingContextFactory
2020-06-29 11:34:15,770 DEBUG -> (main) [org.jnp.server.NamingBeanImpl] key=java.naming.factory.url.pkgs, value(java.lang.String)=org.jboss.naming:org.jnp.interfaces
2020-06-29 11:34:18,482 INFO  -> (main) [com.arjuna.ats.jbossatx.jta.TransactionManagerService] JBossTS Transaction Service (JTA version) - JBoss Inc.
2020-06-29 11:34:18,482 INFO  -> (main) [com.arjuna.ats.jbossatx.jta.TransactionManagerService] Setting up property manager MBean and JMX layer
2020-06-29 11:34:18,920 INFO  -> (main) [com.arjuna.ats.jbossatx.jta.TransactionManagerService] Starting recovery manager
2020-06-29 11:34:19,058 INFO  -> (main) [com.arjuna.ats.jbossatx.jta.TransactionManagerService] Recovery manager started
2020-06-29 11:34:19,058 INFO  -> (main) [com.arjuna.ats.jbossatx.jta.TransactionManagerService] Binding TransactionManager JNDI Reference
2020-06-29 11:34:22,306 INFO  -> (main) [org.jboss.ejb3.EJB3Deployer] Starting java:comp multiplexer
2020-06-29 11:34:24,226 INFO  -> (main) [org.jboss.wsf.stack.jbws.NativeServerConfig] JBoss Web Services - Native
2020-06-29 11:34:24,226 INFO  -> (main) [org.jboss.wsf.stack.jbws.NativeServerConfig] jbossws-3.0.1-native-2.0.4.GA (build=200803312044)
2020-06-29 11:34:33,680 WARN  -> (main) [org.jboss.mx.server.registry.BasicMBeanRegistry] javax.management.MBeanRegistrationException: preRegister() failed: [ObjectName='dcm4chee.archive:service=WADOService', Class=org.dcm4chex.wado.mbean.WADOService (org.dcm4chex.wado.mbean.WADOService@3f9b663b)]
2020-06-29 11:34:33,680 INFO  -> (main) [org.dcm4chex.wado.mbean.WADOService] Registration is not done -> stop
2020-06-29 11:34:33,690 ERROR -> (main) [org.jboss.deployment.MainDeployer] Could not create deployment: file:/var/lib/bahmni/dcm4chee-2.18.1-psql/server/default/deploy/dcm4chee-wado-service.xml
org.jboss.deployment.DeploymentException: - nested throwable: (java.lang.reflect.InvocationTargetException)
	at org.jboss.system.ServiceConfigurator.install(ServiceConfigurator.java:196)
	at org.jboss.system.ServiceController.install(ServiceController.java:226)
	at sun.reflect.GeneratedMethodAccessor19.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
	at java.lang.reflect.Method.invoke(Unknown Source)
	at org.jboss.mx.interceptor.ReflectedDispatcher.invoke(ReflectedDispatcher.java:155)
	at org.jboss.mx.server.Invocation.dispatch(Invocation.java:94)
	at org.jboss.mx.server.Invocation.invoke(Invocation.java:86)
	at org.jboss.mx.server.AbstractMBeanInvoker.invoke(AbstractMBeanInvoker.java:264)
	at org.jboss.mx.server.MBeanServerImpl.invoke(MBeanServerImpl.java:659)
	at org.jboss.mx.util.MBeanProxyExt.invoke(MBeanProxyExt.java:210)
	at com.sun.proxy.$Proxy4.install(Unknown Source)
	at org.jboss.deployment.SARDeployer.create(SARDeployer.java:251)
	at org.jboss.deployment.MainDeployer.create(MainDeployer.java:969)
	at org.jboss.deployment.MainDeployer.deploy(MainDeployer.java:818)
	at org.jboss.deployment.MainDeployer.deploy(MainDeployer.java:782)
	at sun.reflect.GeneratedMethodAccessor24.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
	at java.lang.reflect.Method.invoke(Unknown Source)
	at org.jboss.mx.interceptor.ReflectedDispatcher.invoke(ReflectedDispatcher.java:155)
	at org.jboss.mx.server.Invocation.dispatch(Invocation.java:94)
	at org.jboss.mx.interceptor.AbstractInterceptor.invoke(AbstractInterceptor.java:133)
	at org.jboss.mx.server.Invocation.invoke(Invocation.java:88)
	at org.jboss.mx.interceptor.ModelMBeanOperationInterceptor.invoke(ModelMBeanOperationInterceptor.java:142)
	at org.jboss.mx.server.Invocation.invoke(Invocation.java:88)
	at org.jboss.mx.server.AbstractMBeanInvoker.invoke(AbstractMBeanInvoker.java:264)
	at org.jboss.mx.server.MBeanServerImpl.invoke(MBeanServerImpl.java:659)
	at org.jboss.mx.util.MBeanProxyExt.invoke(MBeanProxyExt.java:210)
	at com.sun.proxy.$Proxy9.deploy(Unknown Source)
	at org.jboss.deployment.scanner.URLDeploymentScanner.deploy(URLDeploymentScanner.java:421)
	at org.jboss.deployment.scanner.URLDeploymentScanner.scan(URLDeploymentScanner.java:634)
	at org.jboss.deployment.scanner.AbstractDeploymentScanner$ScannerThread.doScan(AbstractDeploymentScanner.java:263)
	at org.jboss.deployment.scanner.AbstractDeploymentScanner.startService(AbstractDeploymentScanner.java:336)
	at org.jboss.system.ServiceMBeanSupport.jbossInternalStart(ServiceMBeanSupport.java:289)
	at org.jboss.system.ServiceMBeanSupport.jbossInternalLifecycle(ServiceMBeanSupport.java:245)
	at sun.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
	at java.lang.reflect.Method.invoke(Unknown Source)
	at org.jboss.mx.interceptor.ReflectedDispatcher.invoke(ReflectedDispatcher.java:155)
	at org.jboss.mx.server.Invocation.dispatch(Invocation.java:94)
	at org.jboss.mx.server.Invocation.invoke(Invocation.java:86)
	at org.jboss.mx.server.AbstractMBeanInvoker.invoke(AbstractMBeanInvoker.java:264)
	at org.jboss.mx.server.MBeanServerImpl.invoke(MBeanServerImpl.java:659)
	at org.jboss.system.ServiceController$ServiceProxy.invoke(ServiceController.java:978)
	at com.sun.proxy.$Proxy0.start(Unknown Source)
	at org.jboss.system.ServiceController.start(ServiceController.java:417)
	at sun.reflect.GeneratedMethodAccessor10.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
	at java.lang.reflect.Method.invoke(Unknown Source)
	at org.jboss.mx.interceptor.ReflectedDispatcher.invoke(ReflectedDispatcher.java:155)
	at org.jboss.mx.server.Invocation.dispatch(Invocation.java:94)
	at org.jboss.mx.server.Invocation.invoke(Invocation.java:86)
	at org.jboss.mx.server.AbstractMBeanInvoker.invoke(AbstractMBeanInvoker.java:264)
	at org.jboss.mx.server.MBeanServerImpl.invoke(MBeanServerImpl.java:659)
	at org.jboss.mx.util.MBeanProxyExt.invoke(MBeanProxyExt.java:210)
	at com.sun.proxy.$Proxy4.start(Unknown Source)
	at org.jboss.deployment.SARDeployer.start(SARDeployer.java:304)
	at org.jboss.deployment.MainDeployer.start(MainDeployer.java:1025)
	at org.jboss.deployment.MainDeployer.deploy(MainDeployer.java:819)
	at org.jboss.deployment.MainDeployer.deploy(MainDeployer.java:782)
	at org.jboss.deployment.MainDeployer.deploy(MainDeployer.java:766)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
	at java.lang.reflect.Method.invoke(Unknown Source)
	at org.jboss.mx.interceptor.ReflectedDispatcher.invoke(ReflectedDispatcher.java:155)
	at org.jboss.mx.server.Invocation.dispatch(Invocation.java:94)
	at org.jboss.mx.interceptor.AbstractInterceptor.invoke(AbstractInterceptor.java:133)
	at org.jboss.mx.server.Invocation.invoke(Invocation.java:88)
	at org.jboss.mx.interceptor.ModelMBeanOperationInterceptor.invoke(ModelMBeanOperationInterceptor.java:142)
	at org.jboss.mx.server.Invocation.invoke(Invocation.java:88)
	at org.jboss.mx.server.AbstractMBeanInvoker.invoke(AbstractMBeanInvoker.java:264)
	at org.jboss.mx.server.MBeanServerImpl.invoke(MBeanServerImpl.java:659)
	at org.jboss.mx.util.MBeanProxyExt.invoke(MBeanProxyExt.java:210)
	at com.sun.proxy.$Proxy5.deploy(Unknown Source)
	at org.jboss.system.server.ServerImpl.doStart(ServerImpl.java:482)
	at org.jboss.system.server.ServerImpl.start(ServerImpl.java:362)
	at org.jboss.Main.boot(Main.java:200)
	at org.jboss.Main$1.run(Main.java:508)
	at java.lang.Thread.run(Unknown Source)
Caused by: java.lang.reflect.InvocationTargetException
	at org.jboss.mx.server.MBeanServerImpl.registerMBean(MBeanServerImpl.java:1451)
	at org.jboss.mx.server.MBeanServerImpl.registerMBean(MBeanServerImpl.java:1350)
	at org.jboss.mx.server.MBeanServerImpl.createMBean(MBeanServerImpl.java:345)
	at org.jboss.system.ServiceCreator.install(ServiceCreator.java:212)
	at org.jboss.system.ServiceConfigurator.internalInstall(ServiceConfigurator.java:451)
	at org.jboss.system.ServiceConfigurator.install(ServiceConfigurator.java:171)
	... 79 more
Caused by: javax.management.MBeanException
	at org.jboss.mx.interceptor.ReflectedDispatcher.handleInvocationExceptions(ReflectedDispatcher.java:180)
	at org.jboss.mx.interceptor.ReflectedDispatcher.invoke(ReflectedDispatcher.java:163)
	at org.jboss.mx.server.Invocation.dispatch(Invocation.java:94)
	at org.jboss.mx.interceptor.AbstractInterceptor.invoke(AbstractInterceptor.java:133)
	at org.jboss.mx.server.Invocation.invoke(Invocation.java:88)
	at org.jboss.mx.interceptor.ModelMBeanOperationInterceptor.invoke(ModelMBeanOperationInterceptor.java:142)
	at org.jboss.mx.server.Invocation.invoke(Invocation.java:88)
	at org.jboss.mx.server.AbstractMBeanInvoker.invoke(AbstractMBeanInvoker.java:264)
	at org.jboss.mx.server.MBeanServerImpl.invoke(MBeanServerImpl.java:659)
	at org.jboss.mx.server.MBeanServerImpl$3.run(MBeanServerImpl.java:1422)
	at java.security.AccessController.doPrivileged(Native Method)
	at org.jboss.mx.server.MBeanServerImpl.registerMBean(MBeanServerImpl.java:1417)
	... 84 more
Caused by: javax.management.MBeanRegistrationException: preRegister() failed: [ObjectName='dcm4chee.archive:service=WADOService', Class=org.dcm4chex.wado.mbean.WADOService (org.dcm4chex.wado.mbean.WADOService@3f9b663b)]
	at org.jboss.mx.server.registry.BasicMBeanRegistry.invokePreRegister(BasicMBeanRegistry.java:713)
	at org.jboss.mx.server.registry.BasicMBeanRegistry.registerMBean(BasicMBeanRegistry.java:211)
	at sun.reflect.GeneratedMethodAccessor1.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
	at java.lang.reflect.Method.invoke(Unknown Source)
	at org.jboss.mx.interceptor.ReflectedDispatcher.invoke(ReflectedDispatcher.java:155)
	... 94 more
Caused by: javax.management.RuntimeMBeanException
	at org.jboss.mx.interceptor.ReflectedDispatcher.handleInvocationExceptions(ReflectedDispatcher.java:176)
	at org.jboss.mx.interceptor.AttributeDispatcher.invoke(AttributeDispatcher.java:140)
	at org.jboss.mx.server.Invocation.dispatch(Invocation.java:94)
	at org.jboss.mx.server.Invocation.invoke(Invocation.java:86)
	at org.jboss.mx.interceptor.ModelMBeanAttributeInterceptor.invoke(ModelMBeanAttributeInterceptor.java:103)
	at org.jboss.mx.interceptor.PersistenceInterceptor.invoke(PersistenceInterceptor.java:76)
	at org.jboss.mx.server.Invocation.invoke(Invocation.java:88)
	at org.jboss.mx.server.AbstractMBeanInvoker.setAttribute(AbstractMBeanInvoker.java:461)
	at org.jboss.mx.modelmbean.ModelMBeanInvoker.setValuesFromMBeanInfo(ModelMBeanInvoker.java:807)
	at org.jboss.mx.modelmbean.ModelMBeanInvoker.init(ModelMBeanInvoker.java:518)
	at org.jboss.mx.modelmbean.ModelMBeanInvoker.invokePreRegister(ModelMBeanInvoker.java:486)
	at org.jboss.mx.server.AbstractMBeanInvoker.preRegister(AbstractMBeanInvoker.java:654)
	at org.jboss.mx.server.registry.BasicMBeanRegistry.invokePreRegister(BasicMBeanRegistry.java:697)
	... 99 more
Caused by: org.dcm4chex.archive.exceptions.ConfigurationException: No such ImageWriter - com.sun.media.imageioimpl.plugins.jpeg.CLibJPEGImageWriter
	at org.dcm4chex.wado.mbean.cache.WADOCacheImpl.getImageWriterWriter(WADOCacheImpl.java:742)
	at org.dcm4chex.wado.mbean.cache.WADOCacheImpl.setImageWriterClass(WADOCacheImpl.java:223)
	at org.dcm4chex.wado.mbean.cache.WADOCacheImplSun.setImageWriterClass(WADOCacheImplSun.java:30)
	at org.dcm4chex.wado.mbean.WADOService.setImageWriterClass(WADOService.java:140)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
	at java.lang.reflect.Method.invoke(Unknown Source)
	at org.jboss.mx.interceptor.AttributeDispatcher.invoke(AttributeDispatcher.java:136)
	... 110 more
2020-06-29 11:34:34,044 ERROR -> (main) [STDERR] Warning: org.apache.xerces.jaxp.SAXParserImpl$JAXPSAXParser: Property 'http://www.oracle.com/xml/jaxp/properties/entityExpansionLimit' is not recognized.
2020-06-29 11:34:34,350 ERROR -> (main) [STDERR] Compiler warnings:
2020-06-29 11:34:34,350 ERROR -> (main) [STDERR]   WARNING:  'org.apache.xerces.jaxp.SAXParserImpl: Property 'http://javax.xml.XMLConstants/property/accessExternalDTD' is not recognized.'
2020-06-29 11:34:34,451 INFO  -> (main) [org.apache.catalina.startup.Embedded] Catalina naming disabled
2020-06-29 11:34:34,616 INFO  -> (main) [org.apache.catalina.core.AprLifecycleListener] The Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path: /var/lib/bahmni/dcm4chee-2.18.1-psql/bin/native
2020-06-29 11:34:34,682 INFO  -> (main) [org.apache.coyote.http11.Http11Protocol] Initializing Coyote HTTP/1.1 on http-0.0.0.0-8055
2020-06-29 11:34:34,987 INFO  -> (main) [org.apache.coyote.http11.Http11Protocol] Initializing Coyote HTTP/1.1 on http-8443
2020-06-29 11:34:34,988 INFO  -> (main) [org.apache.coyote.ajp.AjpProtocol] Initializing Coyote AJP/1.3 on ajp-0.0.0.0-8056
2020-06-29 11:34:34,988 INFO  -> (main) [org.apache.catalina.startup.Catalina] Initialization processed in 536 ms
2020-06-29 11:34:34,988 INFO  -> (main) [org.apache.catalina.core.StandardService] Starting service jboss.web
2020-06-29 11:34:34,990 INFO  -> (main) [org.apache.catalina.core.StandardEngine] Starting Servlet Engine: JBossWeb/2.0.1.GA
2020-06-29 11:34:36,852 WARN  -> (main) [javax.enterprise.resource.webcontainer.jsf.config] Unable to process deployment descriptor for context '/conf'
2020-06-29 11:34:38,614 WARN  -> (main) [javax.enterprise.resource.webcontainer.jsf.config] Unable to process deployment descriptor for context '/deploy'
2020-06-29 11:34:38,803 WARN  -> (main) [javax.enterprise.resource.webcontainer.jsf.config] Unable to process deployment descriptor for context '/lib'
2020-06-29 11:34:38,938 WARN  -> (main) [javax.enterprise.resource.webcontainer.jsf.config] Unable to process deployment descriptor for context '/work'
2020-06-29 11:34:39,022 WARN  -> (main) [javax.enterprise.resource.webcontainer.jsf.config] Unable to process deployment descriptor for context '/archive'
2020-06-29 11:34:39,186 WARN  -> (main) [javax.enterprise.resource.webcontainer.jsf.config] Unable to process deployment descriptor for context '/log'
2020-06-29 11:34:39,260 WARN  -> (main) [javax.enterprise.resource.webcontainer.jsf.config] Unable to process deployment descriptor for context '/tmp'
2020-06-29 11:34:39,424 WARN  -> (main) [javax.enterprise.resource.webcontainer.jsf.config] Unable to process deployment descriptor for context '/data'
2020-06-29 11:34:39,542 WARN  -> (main) [javax.enterprise.resource.webcontainer.jsf.config] Unable to process deployment descriptor for context '/tar-extracted-journal'
2020-06-29 11:34:39,619 WARN  -> (main) [javax.enterprise.resource.webcontainer.jsf.config] Unable to process deployment descriptor for context '/tar-extracted'
2020-06-29 11:34:39,759 WARN  -> (main) [javax.enterprise.resource.webcontainer.jsf.config] Unable to process deployment descriptor for context '/wadocachejournal'
2020-06-29 11:34:39,853 INFO  -> (main) [org.apache.catalina.startup.Catalina] Server startup in 4864 ms
2020-06-29 11:34:40,002 INFO  -> (main) [org.jboss.web.tomcat.service.TomcatDeployer] deploy, ctxPath=/, warUrl=.../deploy/jboss-web.deployer/ROOT.war/
2020-06-29 11:34:40,488 INFO  -> (main) [org.jboss.web.tomcat.service.TomcatDeployer] deploy, ctxPath=/invoker, warUrl=.../deploy/http-invoker.sar/invoker.war/
2020-06-29 11:34:40,701 INFO  -> (main) [org.jboss.web.tomcat.service.TomcatDeployer] deploy, ctxPath=/jbossws, warUrl=.../deploy/jbossws.sar/jbossws-context.war/
2020-06-29 11:34:41,126 INFO  -> (main) [org.jboss.web.tomcat.service.TomcatDeployer] deploy, ctxPath=/web-console, warUrl=.../deploy/management/console-mgr.sar/web-console.war/
2020-06-29 11:34:42,112 INFO  -> (main) [org.jboss.mail.MailService] Mail Service bound to java:/Mail
2020-06-29 11:34:42,279 INFO  -> (main) [org.jboss.resource.deployment.RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/jboss-ha-local-jdbc.rar
2020-06-29 11:34:42,311 INFO  -> (main) [org.jboss.resource.deployment.RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/jboss-ha-xa-jdbc.rar
2020-06-29 11:34:42,335 INFO  -> (main) [org.jboss.resource.deployment.RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/jboss-local-jdbc.rar
2020-06-29 11:34:42,376 INFO  -> (main) [org.jboss.resource.deployment.RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/jboss-xa-jdbc.rar
2020-06-29 11:34:42,454 INFO  -> (main) [org.jboss.resource.deployment.RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/jms-ra.rar
2020-06-29 11:34:42,486 INFO  -> (main) [org.jboss.resource.deployment.RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/quartz-ra.rar
2020-06-29 11:34:42,518 INFO  -> (main) [org.jboss.resource.adapter.quartz.inflow.QuartzResourceAdapter] start quartz!!!
2020-06-29 11:34:42,652 INFO  -> (main) [org.quartz.simpl.SimpleThreadPool] Job execution threads will use class loader of thread: main
2020-06-29 11:34:42,885 INFO  -> (main) [org.quartz.core.QuartzScheduler] Quartz Scheduler v.1.5.2 created.
2020-06-29 11:34:42,889 INFO  -> (main) [org.quartz.simpl.RAMJobStore] RAMJobStore initialized.
2020-06-29 11:34:42,890 INFO  -> (main) [org.quartz.impl.StdSchedulerFactory] Quartz scheduler 'DefaultQuartzScheduler' initialized from default resource file in Quartz package: 'quartz.properties'
2020-06-29 11:34:42,890 INFO  -> (main) [org.quartz.impl.StdSchedulerFactory] Quartz scheduler version: 1.5.2
2020-06-29 11:34:42,890 INFO  -> (main) [org.quartz.core.QuartzScheduler] Scheduler DefaultQuartzScheduler_$_NON_CLUSTERED started.
2020-06-29 11:34:44,623 INFO  -> (main) [org.jboss.resource.connectionmanager.ConnectionFactoryBindingService] Bound ConnectionManager 'jboss.jca:service=ConnectionFactoryBinding,name=JmsXA' to JNDI name 'java:JmsXA'
2020-06-29 11:34:44,804 INFO  -> (main) [org.jboss.resource.connectionmanager.ConnectionFactoryBindingService] Bound ConnectionManager 'jboss.jca:service=DataSourceBinding,name=pacsDS' to JNDI name 'java:pacsDS'
2020-06-29 11:34:49,898 WARN  -> (main) [org.jboss.jms.server.security.SecurityMetadataStore] WARNING! POTENTIAL SECURITY RISK. It has been detected that the MessageSucker component which sucks messages from one node to another has not had its password changed from the installation default. Please see the JBoss Messaging user guide for instructions on how to do this.
2020-06-29 11:34:50,071 INFO  -> (main) [org.jboss.jms.server.ServerPeer] JBoss Messaging 1.4.2.GA server [0] started
2020-06-29 11:34:50,563 INFO  -> (main) [org.jboss.jms.server.connectionfactory.ConnectionFactory] Connector bisocket://localhost:4457 has leasing enabled, lease period 10000 milliseconds
2020-06-29 11:34:50,563 INFO  -> (main) [org.jboss.jms.server.connectionfactory.ConnectionFactory] org.jboss.jms.server.connectionfactory.ConnectionFactory@5a84f810 started
2020-06-29 11:34:50,564 WARN  -> (main) [org.jboss.jms.server.connectionfactory.ConnectionFactoryJNDIMapper] supportsFailover attribute is true on connection factory: jboss.messaging.connectionfactory:service=ClusteredConnectionFactory but post office is non clustered. So connection factory will *not* support failover
2020-06-29 11:34:50,564 WARN  -> (main) [org.jboss.jms.server.connectionfactory.ConnectionFactoryJNDIMapper] supportsLoadBalancing attribute is true on connection factory: jboss.messaging.connectionfactory:service=ClusteredConnectionFactory but post office is non clustered. So connection factory will *not* support load balancing
2020-06-29 11:34:50,567 INFO  -> (main) [org.jboss.jms.server.connectionfactory.ConnectionFactory] Connector bisocket://localhost:4457 has leasing enabled, lease period 10000 milliseconds
2020-06-29 11:34:50,567 INFO  -> (main) [org.jboss.jms.server.connectionfactory.ConnectionFactory] org.jboss.jms.server.connectionfactory.ConnectionFactory@223f0609 started
2020-06-29 11:34:50,567 INFO  -> (main) [org.jboss.jms.server.connectionfactory.ConnectionFactory] Connector bisocket://localhost:4457 has leasing enabled, lease period 10000 milliseconds
2020-06-29 11:34:50,568 INFO  -> (main) [org.jboss.jms.server.connectionfactory.ConnectionFactory] org.jboss.jms.server.connectionfactory.ConnectionFactory@644855fc started
2020-06-29 11:34:50,762 INFO  -> (main) [org.jboss.jms.server.destination.QueueService] Queue[/queue/DLQ] started, fullSize=200000, pageSize=2000, downCacheSize=2000
2020-06-29 11:34:50,777 INFO  -> (main) [org.jboss.jms.server.destination.QueueService] Queue[/queue/ExpiryQueue] started, fullSize=200000, pageSize=2000, downCacheSize=2000
2020-06-29 11:34:50,785 INFO  -> (main) [org.jboss.jms.server.destination.QueueService] Queue[/queue/AttributesModificationScu] started, fullSize=500, pageSize=100, downCacheSize=100
2020-06-29 11:34:50,790 INFO  -> (main) [org.jboss.jms.server.destination.QueueService] Queue[/queue/DeleteStudy] started, fullSize=500, pageSize=100, downCacheSize=100
2020-06-29 11:34:50,810 INFO  -> (main) [org.jboss.jms.server.destination.QueueService] Queue[/queue/ExportManager] started, fullSize=500, pageSize=100, downCacheSize=100
2020-06-29 11:34:50,814 INFO  -> (main) [org.jboss.jms.server.destination.QueueService] Queue[/queue/FileCopy] started, fullSize=500, pageSize=100, downCacheSize=100
2020-06-29 11:34:50,817 INFO  -> (main) [org.jboss.jms.server.destination.QueueService] Queue[/queue/FileMove] started, fullSize=500, pageSize=100, downCacheSize=100
2020-06-29 11:34:50,831 INFO  -> (main) [org.jboss.jms.server.destination.QueueService] Queue[/queue/HL7Send] started, fullSize=500, pageSize=100, downCacheSize=100
2020-06-29 11:34:50,835 INFO  -> (main) [org.jboss.jms.server.destination.QueueService] Queue[/queue/IANScu] started, fullSize=500, pageSize=100, downCacheSize=100
2020-06-29 11:34:50,839 INFO  -> (main) [org.jboss.jms.server.destination.QueueService] Queue[/queue/MCMScu] started, fullSize=500, pageSize=100, downCacheSize=100
2020-06-29 11:34:50,852 INFO  -> (main) [org.jboss.jms.server.destination.QueueService] Queue[/queue/MoveScu] started, fullSize=500, pageSize=100, downCacheSize=100
2020-06-29 11:34:50,867 INFO  -> (main) [org.jboss.jms.server.destination.QueueService] Queue[/queue/MPPSScu] started, fullSize=500, pageSize=100, downCacheSize=100
2020-06-29 11:34:50,870 INFO  -> (main) [org.jboss.jms.server.destination.QueueService] Queue[/queue/PPSExceptionMgt] started, fullSize=500, pageSize=100, downCacheSize=100
2020-06-29 11:34:50,873 INFO  -> (main) [org.jboss.jms.server.destination.QueueService] Queue[/queue/PPSScu] started, fullSize=500, pageSize=100, downCacheSize=100
2020-06-29 11:34:50,877 INFO  -> (main) [org.jboss.jms.server.destination.QueueService] Queue[/queue/Prefetch] started, fullSize=500, pageSize=100, downCacheSize=100
2020-06-29 11:34:50,880 INFO  -> (main) [org.jboss.jms.server.destination.QueueService] Queue[/queue/RejectionNoteStored] started, fullSize=500, pageSize=100, downCacheSize=100
2020-06-29 11:34:50,884 INFO  -> (main) [org.jboss.jms.server.destination.QueueService] Queue[/queue/Sendmail] started, fullSize=500, pageSize=100, downCacheSize=100
2020-06-29 11:34:52,422 INFO  -> (main) [org.jboss.jms.server.destination.QueueService] Queue[/queue/StgCmtScuScp] started, fullSize=500, pageSize=100, downCacheSize=100
2020-06-29 11:34:52,438 INFO  -> (main) [org.jboss.jms.server.destination.QueueService] Queue[/queue/StudyMgtScu] started, fullSize=500, pageSize=100, downCacheSize=100
2020-06-29 11:34:52,451 INFO  -> (main) [org.jboss.jms.server.destination.QueueService] Queue[/queue/UpgradeToEnhancedMF] started, fullSize=500, pageSize=100, downCacheSize=100
2020-06-29 11:34:52,454 INFO  -> (main) [org.jboss.jms.server.destination.QueueService] Queue[/queue/UPSScp] started, fullSize=500, pageSize=100, downCacheSize=100
2020-06-29 11:34:52,458 INFO  -> (main) [org.jboss.jms.server.destination.QueueService] Queue[/queue/WadoPrefetch] started, fullSize=500, pageSize=100, downCacheSize=100
2020-06-29 11:34:53,613 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying PrivateInstance
2020-06-29 11:34:53,837 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying MWLItem
2020-06-29 11:34:53,843 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying VerifyingObserver
2020-06-29 11:34:53,848 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying Device
2020-06-29 11:34:53,855 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying UPSRelatedPS
2020-06-29 11:34:53,860 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying PrivateFile
2020-06-29 11:34:53,865 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying Media
2020-06-29 11:34:53,870 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying PrivateStudy
2020-06-29 11:34:53,875 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying PrivatePatient
2020-06-29 11:34:53,879 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying Code
2020-06-29 11:34:53,888 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying HP
2020-06-29 11:34:53,893 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying MPPS
2020-06-29 11:34:53,899 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying Patient
2020-06-29 11:34:53,916 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying Instance
2020-06-29 11:34:53,922 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying StudyPermission
2020-06-29 11:34:53,926 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying AE
2020-06-29 11:34:53,935 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying UPSSubscription
2020-06-29 11:34:53,953 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying FileSystem
2020-06-29 11:34:53,960 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying UPSGlobalSubscription
2020-06-29 11:34:53,965 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying GPSPSPerformer
2020-06-29 11:34:53,969 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying OtherPatientID
2020-06-29 11:34:53,975 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying Series
2020-06-29 11:34:53,982 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying StudyOnFileSystem
2020-06-29 11:34:53,987 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying UPSRequest
2020-06-29 11:34:53,994 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying UPSReplacedPS
2020-06-29 11:34:54,000 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying File
2020-06-29 11:34:54,005 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying SeriesRequest
2020-06-29 11:34:54,010 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying HPDefinition
2020-06-29 11:34:54,016 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying PublishedStudy
2020-06-29 11:34:54,022 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying PrivateSeries
2020-06-29 11:34:54,028 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying GPSPSRequest
2020-06-29 11:34:54,033 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying UPS
2020-06-29 11:34:54,038 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying GPSPS
2020-06-29 11:34:54,045 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying ContentItem
2020-06-29 11:34:54,051 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying Study
2020-06-29 11:34:54,055 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying GPPPS
2020-06-29 11:34:54,060 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying Issuer
2020-06-29 11:34:54,067 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying GPPPSManager
2020-06-29 11:34:54,085 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying GPWLManager
2020-06-29 11:34:54,091 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying StudyMgt
2020-06-29 11:34:54,096 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying PIXQuery
2020-06-29 11:34:54,102 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying UpdateAttributes
2020-06-29 11:34:54,106 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying HPStorage
2020-06-29 11:34:54,113 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying MWLManager
2020-06-29 11:34:54,118 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying UPSManager
2020-06-29 11:34:54,123 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying AvailabilityUpdate
2020-06-29 11:34:54,128 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying ConsistencyCheck
2020-06-29 11:34:54,140 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying StudyPermissionManager
2020-06-29 11:34:54,145 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying UserManager
2020-06-29 11:34:54,149 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying MPPSManager
2020-06-29 11:34:54,152 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying MediaComposer
2020-06-29 11:34:54,156 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying ContentEdit
2020-06-29 11:34:54,160 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying ContentManager
2020-06-29 11:34:54,165 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying SoundexUpdate
2020-06-29 11:34:54,169 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying PrivateManager
2020-06-29 11:34:54,174 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying StudyReconciliation
2020-06-29 11:34:54,177 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying CodeToDeviceMapping
2020-06-29 11:34:54,180 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying MPPSEmulator
2020-06-29 11:34:54,183 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying AttributesModification
2020-06-29 11:34:54,187 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying PatientUpdate
2020-06-29 11:34:54,191 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying FixPatientAttributes
2020-06-29 11:34:54,195 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying FileSystemMgt2
2020-06-29 11:34:54,199 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying Storage
2020-06-29 11:34:54,203 INFO  -> (main) [org.jboss.ejb.EjbModule] Deploying AEManager
2020-06-29 11:34:54,932 DEBUG -> (main) [PrivateInstance] created-time: [JDBCCMPFieldMetaData : fieldName=createdTime, [JDBCEntityMetaData : entityName=PrivateInstance]]
2020-06-29 11:34:54,933 DEBUG -> (main) [MWLItem] created-time: [JDBCCMPFieldMetaData : fieldName=createdTime, [JDBCEntityMetaData : entityName=MWLItem]]
2020-06-29 11:34:54,933 DEBUG -> (main) [MWLItem] updated-time: [JDBCCMPFieldMetaData : fieldName=updatedTime, [JDBCEntityMetaData : entityName=MWLItem]]
2020-06-29 11:34:54,938 DEBUG -> (main) [Media] created-time: [JDBCCMPFieldMetaData : fieldName=createdTime, [JDBCEntityMetaData : entityName=Media]]
2020-06-29 11:34:54,938 DEBUG -> (main) [Media] updated-time: [JDBCCMPFieldMetaData : fieldName=updatedTime, [JDBCEntityMetaData : entityName=Media]]
2020-06-29 11:34:54,940 DEBUG -> (main) [MPPS] created-time: [JDBCCMPFieldMetaData : fieldName=createdTime, [JDBCEntityMetaData : entityName=MPPS]]
2020-06-29 11:34:54,940 DEBUG -> (main) [MPPS] updated-time: [JDBCCMPFieldMetaData : fieldName=updatedTime, [JDBCEntityMetaData : entityName=MPPS]]
2020-06-29 11:34:54,941 DEBUG -> (main) [Patient] created-time: [JDBCCMPFieldMetaData : fieldName=createdTime, [JDBCEntityMetaData : entityName=Patient]]
2020-06-29 11:34:54,941 DEBUG -> (main) [Patient] updated-time: [JDBCCMPFieldMetaData : fieldName=updatedTime, [JDBCEntityMetaData : entityName=Patient]]
2020-06-29 11:34:54,964 DEBUG -> (main) [Instance] created-time: [JDBCCMPFieldMetaData : fieldName=createdTime, [JDBCEntityMetaData : entityName=Instance]]
2020-06-29 11:34:54,964 DEBUG -> (main) [Instance] updated-time: [JDBCCMPFieldMetaData : fieldName=updatedTime, [JDBCEntityMetaData : entityName=Instance]]
2020-06-29 11:34:54,970 DEBUG -> (main) [Series] created-time: [JDBCCMPFieldMetaData : fieldName=createdTime, [JDBCEntityMetaData : entityName=Series]]
2020-06-29 11:34:54,970 DEBUG -> (main) [Series] updated-time: [JDBCCMPFieldMetaData : fieldName=updatedTime, [JDBCEntityMetaData : entityName=Series]]
2020-06-29 11:34:54,973 DEBUG -> (main) [File] created-time: [JDBCCMPFieldMetaData : fieldName=createdTime, [JDBCEntityMetaData : entityName=File]]
2020-06-29 11:34:54,992 DEBUG -> (main) [PublishedStudy] created-time: [JDBCCMPFieldMetaData : fieldName=createdTime, [JDBCEntityMetaData : entityName=PublishedStudy]]
2020-06-29 11:34:54,992 DEBUG -> (main) [PublishedStudy] updated-time: [JDBCCMPFieldMetaData : fieldName=updatedTime, [JDBCEntityMetaData : entityName=PublishedStudy]]
2020-06-29 11:34:54,993 DEBUG -> (main) [UPS] created-time: [JDBCCMPFieldMetaData : fieldName=createdTime, [JDBCEntityMetaData : entityName=UPS]]
2020-06-29 11:34:54,993 DEBUG -> (main) [UPS] updated-time: [JDBCCMPFieldMetaData : fieldName=updatedTime, [JDBCEntityMetaData : entityName=UPS]]
2020-06-29 11:34:55,004 DEBUG -> (main) [Study] created-time: [JDBCCMPFieldMetaData : fieldName=createdTime, [JDBCEntityMetaData : entityName=Study]]
2020-06-29 11:34:55,004 DEBUG -> (main) [Study] updated-time: [JDBCCMPFieldMetaData : fieldName=updatedTime, [JDBCEntityMetaData : entityName=Study]]
2020-06-29 11:34:55,005 DEBUG -> (main) [GPPPS] created-time: [JDBCCMPFieldMetaData : fieldName=createdTime, [JDBCEntityMetaData : entityName=GPPPS]]
2020-06-29 11:34:55,005 DEBUG -> (main) [GPPPS] updated-time: [JDBCCMPFieldMetaData : fieldName=updatedTime, [JDBCEntityMetaData : entityName=GPPPS]]
2020-06-29 11:34:56,838 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'PrivateInstance' to jndi 'ejb/PrivateInstance'
2020-06-29 11:34:56,908 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'MWLItem' to jndi 'ejb/MWLItem'
2020-06-29 11:34:56,912 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'VerifyingObserver' to jndi 'ejb/VerifyingObserver'
2020-06-29 11:34:56,917 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'Device' to jndi 'ejb/Device'
2020-06-29 11:34:56,926 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'UPSRelatedPS' to jndi 'ejb/UPSRelatedPS'
2020-06-29 11:34:56,933 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'PrivateFile' to jndi 'ejb/PrivateFile'
2020-06-29 11:34:56,957 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'Media' to jndi 'ejb/Media'
2020-06-29 11:34:56,961 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'PrivateStudy' to jndi 'ejb/PrivateStudy'
2020-06-29 11:34:56,977 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'PrivatePatient' to jndi 'ejb/PrivatePatient'
2020-06-29 11:34:56,982 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'Code' to jndi 'ejb/Code'
2020-06-29 11:34:56,998 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'HP' to jndi 'ejb/HP'
2020-06-29 11:34:57,004 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'MPPS' to jndi 'ejb/MPPS'
2020-06-29 11:34:57,011 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'Patient' to jndi 'ejb/Patient'
2020-06-29 11:34:57,053 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'Instance' to jndi 'ejb/Instance'
2020-06-29 11:34:57,058 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'StudyPermission' to jndi 'ejb/StudyPermission'
2020-06-29 11:34:57,064 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'AE' to jndi 'ejb/AE'
2020-06-29 11:34:57,068 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'UPSSubscription' to jndi 'ejb/UPSSubscription'
2020-06-29 11:34:57,074 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'FileSystem' to jndi 'ejb/FileSystem'
2020-06-29 11:34:57,078 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'UPSGlobalSubscription' to jndi 'ejb/UPSGlobalSubscription'
2020-06-29 11:34:57,082 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'GPSPSPerformer' to jndi 'ejb/GPSPSPerformer'
2020-06-29 11:34:57,085 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'OtherPatientID' to jndi 'ejb/OtherPatientID'
2020-06-29 11:34:57,092 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'Series' to jndi 'ejb/Series'
2020-06-29 11:34:57,096 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'StudyOnFileSystem' to jndi 'ejb/StudyOnFileSystem'
2020-06-29 11:34:57,100 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'UPSRequest' to jndi 'ejb/UPSRequest'
2020-06-29 11:34:57,104 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'UPSReplacedPS' to jndi 'ejb/UPSReplacedPS'
2020-06-29 11:34:57,109 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'File' to jndi 'ejb/File'
2020-06-29 11:34:57,113 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'SeriesRequest' to jndi 'ejb/SeriesRequest'
2020-06-29 11:34:57,118 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'HPDefinition' to jndi 'ejb/HPDefinition'
2020-06-29 11:34:57,123 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'PublishedStudy' to jndi 'ejb/PublishedStudy'
2020-06-29 11:34:57,127 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'PrivateSeries' to jndi 'ejb/PrivateSeries'
2020-06-29 11:34:57,131 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'GPSPSRequest' to jndi 'ejb/GPSPSRequest'
2020-06-29 11:34:57,137 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'UPS' to jndi 'ejb/UPS'
2020-06-29 11:34:57,143 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'GPSPS' to jndi 'ejb/GPSPS'
2020-06-29 11:34:57,146 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'ContentItem' to jndi 'ejb/ContentItem'
2020-06-29 11:34:57,154 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'Study' to jndi 'ejb/Study'
2020-06-29 11:34:57,160 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'GPPPS' to jndi 'ejb/GPPPS'
2020-06-29 11:34:57,163 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'Issuer' to jndi 'ejb/Issuer'
2020-06-29 11:34:57,197 INFO  -> (main) [org.jboss.proxy.ejb.ProxyFactory] Bound EJB Home 'GPPPSManager' to jndi 'ejb/GPPPSManager'
2020-06-29 11:34:57,205 INFO  -> (main) [org.jboss.proxy.ejb.ProxyFactory] Bound EJB Home 'GPWLManager' to jndi 'ejb/GPWLManager'
2020-06-29 11:34:57,212 INFO  -> (main) [org.jboss.proxy.ejb.ProxyFactory] Bound EJB Home 'StudyMgt' to jndi 'ejb/StudyMgt'
2020-06-29 11:34:57,220 INFO  -> (main) [org.jboss.proxy.ejb.ProxyFactory] Bound EJB Home 'PIXQuery' to jndi 'ejb/PIXQuery'
2020-06-29 11:34:57,229 INFO  -> (main) [org.jboss.proxy.ejb.ProxyFactory] Bound EJB Home 'UpdateAttributes' to jndi 'ejb/UpdateAttributes'
2020-06-29 11:34:57,236 INFO  -> (main) [org.jboss.proxy.ejb.ProxyFactory] Bound EJB Home 'HPStorage' to jndi 'ejb/HPStorage'
2020-06-29 11:34:57,244 INFO  -> (main) [org.jboss.proxy.ejb.ProxyFactory] Bound EJB Home 'MWLManager' to jndi 'ejb/MWLManager'
2020-06-29 11:34:57,253 INFO  -> (main) [org.jboss.proxy.ejb.ProxyFactory] Bound EJB Home 'UPSManager' to jndi 'ejb/UPSManager'
2020-06-29 11:34:57,260 INFO  -> (main) [org.jboss.proxy.ejb.ProxyFactory] Bound EJB Home 'AvailabilityUpdate' to jndi 'ejb/AvailabilityUpdate'
2020-06-29 11:34:57,267 INFO  -> (main) [org.jboss.proxy.ejb.ProxyFactory] Bound EJB Home 'ConsistencyCheck' to jndi 'ejb/ConsistencyCheck'
2020-06-29 11:34:57,276 INFO  -> (main) [org.jboss.proxy.ejb.ProxyFactory] Bound EJB Home 'StudyPermissionManager' to jndi 'ejb/StudyPermissionManager'
2020-06-29 11:34:57,283 INFO  -> (main) [org.jboss.proxy.ejb.ProxyFactory] Bound EJB Home 'UserManager' to jndi 'ejb/UserManager'
2020-06-29 11:34:57,291 INFO  -> (main) [org.jboss.proxy.ejb.ProxyFactory] Bound EJB Home 'MPPSManager' to jndi 'ejb/MPPSManager'
2020-06-29 11:34:57,300 INFO  -> (main) [org.jboss.proxy.ejb.ProxyFactory] Bound EJB Home 'MediaComposer' to jndi 'ejb/MediaComposer'
2020-06-29 11:34:57,317 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'ContentEdit' to jndi 'ContentEditLocal'
2020-06-29 11:34:57,332 INFO  -> (main) [org.jboss.proxy.ejb.ProxyFactory] Bound EJB Home 'ContentEdit' to jndi 'ejb/ContentEdit'
2020-06-29 11:34:57,349 INFO  -> (main) [org.jboss.proxy.ejb.ProxyFactory] Bound EJB Home 'ContentManager' to jndi 'ejb/ContentManager'
2020-06-29 11:34:57,357 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'SoundexUpdate' to jndi 'SoundexUpdateLocal'
2020-06-29 11:34:57,361 INFO  -> (main) [org.jboss.proxy.ejb.ProxyFactory] Bound EJB Home 'SoundexUpdate' to jndi 'ejb/SoundexUpdate'
2020-06-29 11:34:57,369 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'PrivateManager' to jndi 'PrivateManagerLocal'
2020-06-29 11:34:57,376 INFO  -> (main) [org.jboss.proxy.ejb.ProxyFactory] Bound EJB Home 'PrivateManager' to jndi 'ejb/PrivateManager'
2020-06-29 11:34:57,384 INFO  -> (main) [org.jboss.proxy.ejb.ProxyFactory] Bound EJB Home 'StudyReconciliation' to jndi 'ejb/StudyReconciliation'
2020-06-29 11:34:57,391 INFO  -> (main) [org.jboss.proxy.ejb.ProxyFactory] Bound EJB Home 'CodeToDeviceMapping' to jndi 'ejb/CodeToDeviceMapping'
2020-06-29 11:34:57,419 INFO  -> (main) [org.jboss.proxy.ejb.ProxyFactory] Bound EJB Home 'MPPSEmulator' to jndi 'ejb/MPPSEmulator'
2020-06-29 11:34:57,433 INFO  -> (main) [org.jboss.proxy.ejb.ProxyFactory] Bound EJB Home 'AttributesModification' to jndi 'ejb/AttributesModification'
2020-06-29 11:34:57,439 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'PatientUpdate' to jndi 'PatientUpdateLocal'
2020-06-29 11:34:57,444 INFO  -> (main) [org.jboss.proxy.ejb.ProxyFactory] Bound EJB Home 'PatientUpdate' to jndi 'ejb/PatientUpdate'
2020-06-29 11:34:57,472 INFO  -> (main) [org.jboss.proxy.ejb.ProxyFactory] Bound EJB Home 'FixPatientAttributes' to jndi 'ejb/FixPatientAttributes'
2020-06-29 11:34:57,489 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'FileSystemMgt2' to jndi 'FileSystemMgt2Local'
2020-06-29 11:34:57,539 INFO  -> (main) [org.jboss.proxy.ejb.ProxyFactory] Bound EJB Home 'FileSystemMgt2' to jndi 'ejb/FileSystemMgt2'
2020-06-29 11:34:57,566 INFO  -> (main) [org.jboss.ejb.plugins.local.BaseLocalProxyFactory] Bound EJB LocalHome 'Storage' to jndi 'StorageLocal'
2020-06-29 11:34:57,574 INFO  -> (main) [org.jboss.proxy.ejb.ProxyFactory] Bound EJB Home 'Storage' to jndi 'ejb/Storage'
2020-06-29 11:34:57,583 INFO  -> (main) [org.jboss.proxy.ejb.ProxyFactory] Bound EJB Home 'AEManager' to jndi 'ejb/AEManager'
2020-06-29 11:34:57,941 INFO  -> (main) [org.dcm4chex.archive.mbean.SchedulerService] Start Scheduler CheckPendingSeriesStored with period of 60000ms in 1 s.
2020-06-29 11:34:57,953 INFO  -> (main) [org.dcm4chex.archive.mbean.SchedulerService] Start Scheduler DeleteOrphanedPrivateFiles with period of 60000ms in 1 s.
2020-06-29 11:34:57,953 INFO  -> (main) [org.dcm4chex.archive.mbean.SchedulerService] Start Scheduler DeleteOrphanedPrivateFiles with period of 60000ms in 1 s.
2020-06-29 11:34:58,089 INFO  -> (main) [org.jboss.ejb.EJBDeployer] Deployed: file:/var/lib/bahmni/dcm4chee-2.18.1-psql/server/default/deploy/dcm4chee-ejb-psql.jar
2020-06-29 11:34:58,394 INFO  -> (main) [org.jboss.web.tomcat.service.TomcatDeployer] deploy, ctxPath=/rid, warUrl=.../tmp/deploy/tmp844381724355167168dcm4chee-rid-exp.war/
2020-06-29 11:34:58,959 INFO  -> (main) [org.dcm4chex.rid.web.RIDServiceDelegate] RIDServiceDelegate initialized
2020-06-29 11:34:58,960 INFO  -> (main) [org.dcm4chex.rid.web.RIDServiceDelegate] RIDServiceDelegate initialized
2020-06-29 11:34:58,982 INFO  -> (Thread-19) [org.dcm4chex.archive.mbean.FileSystemMgt2Service] Check file system group ONLINE_STORAGE for deletion of orphaned private files
2020-06-29 11:34:59,009 INFO  -> (main) [org.jboss.web.tomcat.service.TomcatDeployer] deploy, ctxPath=/wado, warUrl=.../tmp/deploy/tmp2134418717163876757dcm4chee-wado-exp.war/
2020-06-29 11:34:59,011 INFO  -> (Thread-20) [org.dcm4chex.archive.mbean.FileSystemMgt2Service] Check file system group LOSSY_STORAGE for deletion of orphaned private files
2020-06-29 11:34:59,511 INFO  -> (main) [org.jboss.web.tomcat.service.TomcatDeployer] deploy, ctxPath=/jmx-console, warUrl=.../deploy/jmx-console.war/
2020-06-29 11:35:01,838 WARN  -> (main) [org.jboss.wsf.container.jboss42.JAXWSDeployerHookPreJSE] Cannot load servlet class: in.raster.oviyam.servlet.ConfigServlet
2020-06-29 11:35:02,097 INFO  -> (main) [org.jboss.web.tomcat.service.TomcatDeployer] deploy, ctxPath=/oviyam2, warUrl=.../deploy/oviyam2.war/
2020-06-29 11:35:03,552 INFO  -> (main) [org.jboss.deployment.EARDeployer] Init J2EE application: file:/var/lib/bahmni/dcm4chee-2.18.1-psql/server/default/deploy/dcm4chee-web-ear-3.0.5-psql.ear
2020-06-29 11:35:10,552 ERROR -> (main) [STDERR] Compiler warnings:
2020-06-29 11:35:10,587 ERROR -> (main) [STDERR]   WARNING:  'org.apache.xerces.jaxp.SAXParserImpl: Property 'http://javax.xml.XMLConstants/property/accessExternalDTD' is not recognized.'
2020-06-29 11:35:10,687 ERROR -> (main) [STDERR] Compiler warnings:
2020-06-29 11:35:10,687 ERROR -> (main) [STDERR]   WARNING:  'org.apache.xerces.jaxp.SAXParserImpl: Property 'http://javax.xml.XMLConstants/property/accessExternalDTD' is not recognized.'
2020-06-29 11:35:10,727 ERROR -> (main) [STDERR] Compiler warnings:
2020-06-29 11:35:10,728 ERROR -> (main) [STDERR]   WARNING:  'org.apache.xerces.jaxp.SAXParserImpl: Property 'http://javax.xml.XMLConstants/property/accessExternalDTD' is not recognized.'
2020-06-29 11:35:10,737 ERROR -> (main) [STDERR] Compiler warnings:
2020-06-29 11:35:10,737 ERROR -> (main) [STDERR]   WARNING:  'org.apache.xerces.jaxp.SAXParserImpl: Property 'http://javax.xml.XMLConstants/property/accessExternalDTD' is not recognized.'
2020-06-29 11:35:10,825 INFO  -> (main) [org.dcm4chee.web.service.echo.EchoService] SCU Devicename:EchoService
2020-06-29 11:35:10,979 ERROR -> (main) [STDERR] Compiler warnings:
2020-06-29 11:35:10,979 ERROR -> (main) [STDERR]   WARNING:  'org.apache.xerces.jaxp.SAXParserImpl: Property 'http://javax.xml.XMLConstants/property/accessExternalDTD' is not recognized.'
2020-06-29 11:35:11,007 ERROR -> (main) [STDERR] Compiler warnings:
2020-06-29 11:35:11,007 ERROR -> (main) [STDERR]   WARNING:  'org.apache.xerces.jaxp.SAXParserImpl: Property 'http://javax.xml.XMLConstants/property/accessExternalDTD' is not recognized.'
2020-06-29 11:35:11,041 INFO  -> (main) [org.dcm4chee.web.service.ian.IANScuService] SCU Devicename:IANScuService
2020-06-29 11:35:11,110 INFO  -> (main) [org.dcm4chee.web.service.modify.AttributesModificationScuService] SCU Devicename:AttributesModificationScuService
2020-06-29 11:35:11,204 INFO  -> (main) [org.dcm4chee.web.service.movescu.MoveScuService] SCU Devicename:MoveScuService
2020-06-29 11:35:11,283 INFO  -> (main) [org.dcm4chee.web.service.mppsforward.MppsForwardService] SCU Devicename:MppsForwardService
2020-06-29 11:35:11,296 INFO  -> (main) [org.dcm4chee.web.service.mwl.MwlScuService] SCU Devicename:MwlScuService
2020-06-29 11:35:11,435 INFO  -> (main) [org.dcm4chee.web.service.rejnote.RejectionNoteScuService] SCU Devicename:RejectionNoteScuService
2020-06-29 11:35:11,545 INFO  -> (main) [org.dcm4chee.web.service.store.StoreScuService] SCU Devicename:StoreScuService
2020-06-29 11:35:13,666 INFO  -> (main) [org.jboss.jms.server.destination.QueueService] Queue[/queue/HL7SendV2] started, fullSize=200000, pageSize=2000, downCacheSize=2000
2020-06-29 11:35:13,676 INFO  -> (main) [org.jboss.jms.server.destination.QueueService] Queue[/queue/IANSCU_web] started, fullSize=200000, pageSize=2000, downCacheSize=2000
2020-06-29 11:35:13,701 INFO  -> (main) [org.jboss.jms.server.destination.QueueService] Queue[/queue/AttributesModification_web] started, fullSize=200000, pageSize=2000, downCacheSize=2000
2020-06-29 11:35:13,717 INFO  -> (main) [org.jboss.jms.server.destination.QueueService] Queue[/queue/MoveScu_web] started, fullSize=200000, pageSize=2000, downCacheSize=2000
2020-06-29 11:35:13,741 INFO  -> (main) [org.jboss.jms.server.destination.QueueService] Queue[/queue/RejectionNoteSCU] started, fullSize=200000, pageSize=2000, downCacheSize=2000
2020-06-29 11:35:13,772 INFO  -> (main) [org.jboss.jms.server.destination.QueueService] Queue[/queue/TCStoreScu] started, fullSize=200000, pageSize=2000, downCacheSize=2000
2020-06-29 11:35:13,939 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.entity.PersistenceUnitDeployment
2020-06-29 11:35:13,977 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] installing MBean: persistence.units:ear=dcm4chee-web-ear-3.0.5-psql.ear,unitName=dcm4chee-arc with dependencies:
2020-06-29 11:35:13,978 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] 	jboss.jca:name=pacsDS,service=DataSourceBinding
2020-06-29 11:35:13,980 INFO  -> (main) [org.jboss.ejb3.entity.PersistenceUnitDeployment] Starting persistence unit persistence.units:ear=dcm4chee-web-ear-3.0.5-psql.ear,unitName=dcm4chee-arc
2020-06-29 11:35:14,299 INFO  -> (main) [org.hibernate.ejb.Version] Hibernate EntityManager 3.2.1.GA
2020-06-29 11:35:14,429 INFO  -> (main) [org.hibernate.cfg.annotations.Version] Hibernate Annotations 3.2.1.GA
2020-06-29 11:35:14,567 INFO  -> (main) [org.hibernate.cfg.Environment] Hibernate 3.2.4.sp1
2020-06-29 11:35:14,576 INFO  -> (main) [org.hibernate.cfg.Environment] hibernate.properties not found
2020-06-29 11:35:14,580 INFO  -> (main) [org.hibernate.cfg.Environment] Bytecode provider name : javassist
2020-06-29 11:35:14,585 INFO  -> (main) [org.hibernate.cfg.Environment] using JDK 1.4 java.sql.Timestamp handling
2020-06-29 11:35:14,749 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] Processing PersistenceUnitInfo [
	name: dcm4chee-arc
	...]
2020-06-29 11:35:14,770 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.AE
2020-06-29 11:35:14,772 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 @MappedSuperclass: org.dcm4chee.archive.entity.BaseEntity
2020-06-29 11:35:14,773 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.Code
2020-06-29 11:35:14,775 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.ContentItem
2020-06-29 11:35:14,778 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.Device
2020-06-29 11:35:14,780 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.File
2020-06-29 11:35:14,781 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.FileSystem
2020-06-29 11:35:14,783 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.GPPPS
2020-06-29 11:35:14,785 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.GPSPS
2020-06-29 11:35:14,788 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.GPSPSPerformer
2020-06-29 11:35:14,790 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.GPSPSRequest
2020-06-29 11:35:14,791 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.HangingProtocol
2020-06-29 11:35:14,792 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.HPDefinition
2020-06-29 11:35:14,796 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.Instance
2020-06-29 11:35:14,796 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.Issuer
2020-06-29 11:35:14,799 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.Media
2020-06-29 11:35:14,800 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.MPPS
2020-06-29 11:35:14,802 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.MWLItem
2020-06-29 11:35:14,803 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.OtherPatientID
2020-06-29 11:35:14,807 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.Patient
2020-06-29 11:35:14,808 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.PrivateFile
2020-06-29 11:35:14,810 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.PrivateInstance
2020-06-29 11:35:14,812 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.PrivatePatient
2020-06-29 11:35:14,813 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.PrivateSeries
2020-06-29 11:35:14,814 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.PrivateStudy
2020-06-29 11:35:14,815 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.PublishedStudy
2020-06-29 11:35:14,816 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.RequestAttributes
2020-06-29 11:35:14,821 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.Series
2020-06-29 11:35:14,825 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.Study
2020-06-29 11:35:14,831 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.StudyOnFileSystem
2020-06-29 11:35:14,832 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.StudyPermission
2020-06-29 11:35:14,834 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.UPS
2020-06-29 11:35:14,835 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.UPSRelatedPS
2020-06-29 11:35:14,835 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.UPSReplacedPS
2020-06-29 11:35:14,837 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.UPSRequest
2020-06-29 11:35:14,837 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.UPSSubscription
2020-06-29 11:35:14,840 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.VerifyingObserver
2020-06-29 11:35:15,051 INFO  -> (main) [org.hibernate.cfg.Configuration] Reading mappings from resource : META-INF/orm.xml
2020-06-29 11:35:15,650 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] [PersistenceUnit: dcm4chee-arc] META-INF/orm.xml found
2020-06-29 11:35:15,973 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.AE
2020-06-29 11:35:15,985 INFO  -> (main) [org.hibernate.cfg.annotations.QueryBinder] Binding Named query: AE.findByTitle => select ae from AE ae where title = :title
2020-06-29 11:35:16,060 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.AE on table ae
2020-06-29 11:35:16,151 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Code
2020-06-29 11:35:16,152 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.Code on table code
2020-06-29 11:35:16,158 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.ContentItem
2020-06-29 11:35:16,159 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.ContentItem on table content_item
2020-06-29 11:35:16,181 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Device
2020-06-29 11:35:16,181 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.Device on table device
2020-06-29 11:35:16,245 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.File
2020-06-29 11:35:16,245 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.File on table files
2020-06-29 11:35:16,259 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.FileSystem
2020-06-29 11:35:16,260 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.FileSystem on table filesystem
2020-06-29 11:35:16,280 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.GPPPS
2020-06-29 11:35:16,280 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.GPPPS on table gppps
2020-06-29 11:35:16,290 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.GPSPS
2020-06-29 11:35:16,290 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.GPSPS on table gpsps
2020-06-29 11:35:16,314 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.GPSPSPerformer
2020-06-29 11:35:16,314 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.GPSPSPerformer on table gpsps_perf
2020-06-29 11:35:16,317 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.GPSPSRequest
2020-06-29 11:35:16,317 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.GPSPSRequest on table gpsps_req
2020-06-29 11:35:16,322 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.HangingProtocol
2020-06-29 11:35:16,322 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.HangingProtocol on table hp
2020-06-29 11:35:16,328 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.HPDefinition
2020-06-29 11:35:16,329 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.HPDefinition on table hpdef
2020-06-29 11:35:16,351 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Instance
2020-06-29 11:35:16,351 INFO  -> (main) [org.hibernate.cfg.annotations.QueryBinder] Binding Named query: Instance.findByIUID => select object(i) from Instance i where sopInstanceUID = :iuid
2020-06-29 11:35:16,351 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.Instance on table instance
2020-06-29 11:35:16,371 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Issuer
2020-06-29 11:35:16,372 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.Issuer on table issuer
2020-06-29 11:35:16,377 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Media
2020-06-29 11:35:16,377 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.Media on table media
2020-06-29 11:35:16,381 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.MPPS
2020-06-29 11:35:16,381 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.MPPS on table mpps
2020-06-29 11:35:16,399 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.MWLItem
2020-06-29 11:35:16,400 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.MWLItem on table mwl_item
2020-06-29 11:35:16,417 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.OtherPatientID
2020-06-29 11:35:16,417 INFO  -> (main) [org.hibernate.cfg.annotations.QueryBinder] Binding Named query: OtherPatientID.findByPatientIdAndIssuer => select opid from OtherPatientID opid where patientID = :pid and issuerOfPatientID = :issuer
2020-06-29 11:35:16,417 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.OtherPatientID on table other_pid
2020-06-29 11:35:16,421 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Patient
2020-06-29 11:35:16,421 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.Patient on table patient
2020-06-29 11:35:16,436 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.PrivateFile
2020-06-29 11:35:16,437 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.PrivateFile on table priv_file
2020-06-29 11:35:16,448 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.PrivateInstance
2020-06-29 11:35:16,448 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.PrivateInstance on table priv_instance
2020-06-29 11:35:16,452 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.PrivatePatient
2020-06-29 11:35:16,452 INFO  -> (main) [org.hibernate.cfg.annotations.QueryBinder] Binding Named query: PrivatePatient.findByIdAndIssuer => select object(p) from PrivatePatient p where patientID = :patId and issuerOfPatientID = :issuer
2020-06-29 11:35:16,452 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.PrivatePatient on table priv_patient
2020-06-29 11:35:16,465 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.PrivateSeries
2020-06-29 11:35:16,465 INFO  -> (main) [org.hibernate.cfg.annotations.QueryBinder] Binding Named query: PrivateSeries.findByIUID => select object(pi) from PrivateSeries pi where seriesInstanceUID = :iuid
2020-06-29 11:35:16,465 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.PrivateSeries on table priv_series
2020-06-29 11:35:16,473 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.PrivateStudy
2020-06-29 11:35:16,473 INFO  -> (main) [org.hibernate.cfg.annotations.QueryBinder] Binding Named query: PrivateStudy.findByIUID => select object(ps) from PrivateStudy ps where studyInstanceUID = :iuid
2020-06-29 11:35:16,474 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.PrivateStudy on table priv_study
2020-06-29 11:35:16,476 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.PublishedStudy
2020-06-29 11:35:16,476 INFO  -> (main) [org.hibernate.cfg.annotations.QueryBinder] Binding Named query: PublishedStudy.findByStudyPkAndStatus => select object(s) from PublishedStudy s where s.study.pk = :studyPk and s.status = :status
2020-06-29 11:35:16,476 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.PublishedStudy on table published_study
2020-06-29 11:35:16,490 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.RequestAttributes
2020-06-29 11:35:16,490 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.RequestAttributes on table series_req
2020-06-29 11:35:16,502 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Series
2020-06-29 11:35:16,503 INFO  -> (main) [org.hibernate.cfg.annotations.QueryBinder] Binding Named query: Series.findByIUID => select object(s) from Series s where seriesInstanceUID = :iuid
2020-06-29 11:35:16,503 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.Series on table series
2020-06-29 11:35:16,529 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Study
2020-06-29 11:35:16,529 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.Study on table study
2020-06-29 11:35:16,553 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.StudyOnFileSystem
2020-06-29 11:35:16,553 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.StudyOnFileSystem on table study_on_fs
2020-06-29 11:35:16,555 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.StudyPermission
2020-06-29 11:35:16,555 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.StudyPermission on table study_permission
2020-06-29 11:35:16,556 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.UPS
2020-06-29 11:35:16,556 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.UPS on table ups
2020-06-29 11:35:16,575 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.UPSRelatedPS
2020-06-29 11:35:16,579 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.UPSRelatedPS on table ups_rel_ps
2020-06-29 11:35:16,581 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.UPSReplacedPS
2020-06-29 11:35:16,581 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.UPSReplacedPS on table ups_repl_ps
2020-06-29 11:35:16,583 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.UPSRequest
2020-06-29 11:35:16,583 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.UPSRequest on table ups_req
2020-06-29 11:35:16,585 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.UPSSubscription
2020-06-29 11:35:16,585 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.UPSSubscription on table ups_subscr
2020-06-29 11:35:16,596 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.VerifyingObserver
2020-06-29 11:35:16,597 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.VerifyingObserver on table verify_observer
2020-06-29 11:35:16,726 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.GPSPS.referencedRequests -> gpsps_req
2020-06-29 11:35:16,726 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.GPSPS.scheduledHumanPerformers -> gpsps_perf
2020-06-29 11:35:16,727 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.HangingProtocol.definitions -> hpdef
2020-06-29 11:35:16,727 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Instance.verifyingObservers -> verify_observer
2020-06-29 11:35:16,727 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Instance.files -> files
2020-06-29 11:35:16,727 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Instance.contentItems -> content_item
2020-06-29 11:35:16,727 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Media.instances -> instance
2020-06-29 11:35:16,727 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.MPPS.series -> series
2020-06-29 11:35:16,728 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.previous -> patient
2020-06-29 11:35:16,728 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.studies -> study
2020-06-29 11:35:16,728 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.modalityWorklistItems -> mwl_item
2020-06-29 11:35:16,729 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.modalityPerformedProcedureSteps -> mpps
2020-06-29 11:35:16,729 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.generalPurposeScheduledProcedureSteps -> gpsps
2020-06-29 11:35:16,729 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.generalPurposePerformedProcedureSteps -> gppps
2020-06-29 11:35:16,729 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.unifiedProcedureSteps -> ups
2020-06-29 11:35:16,729 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.PrivateInstance.files -> priv_file
2020-06-29 11:35:16,730 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.PrivatePatient.studies -> priv_study
2020-06-29 11:35:16,730 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.PrivateSeries.instances -> priv_instance
2020-06-29 11:35:16,730 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.PrivateStudy.series -> priv_series
2020-06-29 11:35:16,730 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Series.requestAttributes -> series_req
2020-06-29 11:35:16,730 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Series.instances -> instance
2020-06-29 11:35:16,730 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Study.series -> series
2020-06-29 11:35:16,731 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.UPS.refRequests -> ups_req
2020-06-29 11:35:16,731 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.UPS.relatedProcedureSteps -> ups_rel_ps
2020-06-29 11:35:16,731 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.UPS.replacedProcedureSteps -> ups_repl_ps
2020-06-29 11:35:16,731 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.UPS.subscriptions -> ups_subscr
2020-06-29 11:35:17,942 INFO  -> (main) [org.hibernate.connection.ConnectionProviderFactory] Initializing connection provider: org.hibernate.ejb.connection.InjectedDataSourceConnectionProvider
2020-06-29 11:35:17,952 INFO  -> (main) [org.hibernate.ejb.connection.InjectedDataSourceConnectionProvider] Using provided datasource
2020-06-29 11:35:18,365 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] RDBMS: PostgreSQL, version: 9.6.18
2020-06-29 11:35:18,365 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] JDBC driver: PostgreSQL Native Driver, version: PostgreSQL 9.1 JDBC4 (build 901)
2020-06-29 11:35:18,391 INFO  -> (main) [org.hibernate.dialect.Dialect] Using dialect: org.hibernate.dialect.PostgreSQLDialect
2020-06-29 11:35:18,400 INFO  -> (main) [org.hibernate.transaction.TransactionFactoryFactory] Transaction strategy: org.hibernate.ejb.transaction.JoinableCMTTransactionFactory
2020-06-29 11:35:18,405 INFO  -> (main) [org.hibernate.transaction.TransactionManagerLookupFactory] instantiating TransactionManagerLookup: org.hibernate.transaction.JBossTransactionManagerLookup
2020-06-29 11:35:18,408 INFO  -> (main) [org.hibernate.transaction.TransactionManagerLookupFactory] instantiated TransactionManagerLookup
2020-06-29 11:35:18,408 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Automatic flush during beforeCompletion(): disabled
2020-06-29 11:35:18,408 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Automatic session close at end of transaction: disabled
2020-06-29 11:35:18,409 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] JDBC batch size: 15
2020-06-29 11:35:18,409 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] JDBC batch updates for versioned data: disabled
2020-06-29 11:35:18,410 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Scrollable result sets: enabled
2020-06-29 11:35:18,410 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] JDBC3 getGeneratedKeys(): disabled
2020-06-29 11:35:18,410 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] JDBC result set fetch size: 50
2020-06-29 11:35:18,410 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Connection release mode: auto
2020-06-29 11:35:18,411 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Default batch fetch size: 1
2020-06-29 11:35:18,411 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Generate SQL with comments: disabled
2020-06-29 11:35:18,411 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Order SQL updates by primary key: disabled
2020-06-29 11:35:18,411 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Order SQL inserts for batching: disabled
2020-06-29 11:35:18,412 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Query translator: org.hibernate.hql.ast.ASTQueryTranslatorFactory
2020-06-29 11:35:18,415 INFO  -> (main) [org.hibernate.hql.ast.ASTQueryTranslatorFactory] Using ASTQueryTranslatorFactory
2020-06-29 11:35:18,415 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Query language substitutions: {}
2020-06-29 11:35:18,415 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] JPA-QL strict compliance: enabled
2020-06-29 11:35:18,415 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Second-level cache: enabled
2020-06-29 11:35:18,415 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Query cache: disabled
2020-06-29 11:35:18,415 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Cache provider: org.hibernate.cache.HashtableCacheProvider
2020-06-29 11:35:18,417 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Optimize cache for minimal puts: disabled
2020-06-29 11:35:18,417 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Cache region prefix: dcm4chee-web-ear-3_0_5-psql_ear,dcm4chee-arc
2020-06-29 11:35:18,417 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Structured second-level cache entries: disabled
2020-06-29 11:35:18,426 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Statistics: disabled
2020-06-29 11:35:18,426 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Deleted entity synthetic identifier rollback: disabled
2020-06-29 11:35:18,428 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Default entity-mode: pojo
2020-06-29 11:35:18,428 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Named query checking : enabled
2020-06-29 11:35:18,700 INFO  -> (main) [org.hibernate.impl.SessionFactoryImpl] building session factory
2020-06-29 11:35:20,101 INFO  -> (main) [org.hibernate.impl.SessionFactoryObjectFactory] Factory name: persistence.units:ear=dcm4chee-web-ear-3.0.5-psql.ear,unitName=dcm4chee-arc
2020-06-29 11:35:20,104 INFO  -> (main) [org.hibernate.util.NamingHelper] JNDI InitialContext properties:{java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces}
2020-06-29 11:35:20,151 INFO  -> (main) [org.hibernate.impl.SessionFactoryObjectFactory] Bound factory to JNDI name: persistence.units:ear=dcm4chee-web-ear-3.0.5-psql.ear,unitName=dcm4chee-arc
2020-06-29 11:35:20,185 WARN  -> (main) [org.hibernate.impl.SessionFactoryObjectFactory] InitialContext did not implement EventContext
2020-06-29 11:35:20,190 INFO  -> (main) [org.hibernate.tool.hbm2ddl.SchemaValidator] Running schema validator
2020-06-29 11:35:20,190 INFO  -> (main) [org.hibernate.tool.hbm2ddl.SchemaValidator] fetching database metadata
2020-06-29 11:35:21,755 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.ae
2020-06-29 11:35:21,756 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [ae_group, station_name, installed, acc_no_issuer, vendor_data, cipher_suites, aet, institution, hostname, pat_id_issuer, ae_desc, wado_url, port, user_id, passwd, pk, department, fs_group_id]
2020-06-29 11:35:21,843 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.code
2020-06-29 11:35:21,843 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [code_version, code_value, code_designator, pk, code_meaning]
2020-06-29 11:35:21,853 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.content_item
2020-06-29 11:35:21,853 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [text_value, code_fk, rel_type, instance_fk, pk, name_fk]
2020-06-29 11:35:21,863 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.device
2020-06-29 11:35:21,864 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [station_name, modality, station_aet, pk]
2020-06-29 11:35:21,924 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.files
2020-06-29 11:35:21,924 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [created_time, file_tsuid, filepath, file_status, file_md5, instance_fk, filesystem_fk, pk, md5_check_time, file_size]
2020-06-29 11:35:21,931 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.filesystem
2020-06-29 11:35:21,931 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [retrieve_aet, dirpath, user_info, next_fk, pk, availability, fs_group_id, fs_status]
2020-06-29 11:35:21,949 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.gppps
2020-06-29 11:35:21,949 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [pps_start, created_time, updated_time, pps_iuid, pps_status, pk, patient_fk, pps_attrs]
2020-06-29 11:35:22,042 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.gpsps
2020-06-29 11:35:22,043 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [gpsps_tuid, code_fk, start_datetime, end_datetime, gpsps_prior, pk, patient_fk, gpsps_iuid, gpsps_status, in_availability, item_attrs]
2020-06-29 11:35:22,107 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.gpsps_perf
2020-06-29 11:35:22,107 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [hum_perf_i_name, code_fk, human_perf_name, gpsps_fk, hum_perf_fn_sx, pk, hum_perf_gn_sx, hum_perf_p_name]
2020-06-29 11:35:22,119 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.gpsps_req
2020-06-29 11:35:22,119 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [req_proc_id, gpsps_fk, pk, accession_no]
2020-06-29 11:35:22,139 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.hp
2020-06-29 11:35:22,139 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [user_fk, hp_cuid, num_screens, hp_attrs, hp_name, hp_group, pk, hp_iuid, num_priors, hp_level]
2020-06-29 11:35:22,150 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.hpdef
2020-06-29 11:35:22,150 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [hp_fk, modality, pk, laterality]
2020-06-29 11:35:22,183 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.instance
2020-06-29 11:35:22,183 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [series_fk, created_time, updated_time, sr_complete, inst_attrs, inst_custom2, inst_custom3, content_datetime, commitment, inst_custom1, retrieve_aets, availability, media_fk, archived, all_attrs, inst_no, inst_status, sop_iuid, ext_retr_aet, pk, sop_cuid, sr_verified, srcode_fk]
2020-06-29 11:35:22,232 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.issuer
2020-06-29 11:35:22,232 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [entity_uid, entity_uid_type, pk, entity_id]
2020-06-29 11:35:22,241 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.media
2020-06-29 11:35:22,242 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [created_time, updated_time, media_status, media_rq_iuid, media_usage, pk, fileset_iuid, media_status_info, fileset_id]
2020-06-29 11:35:22,251 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.mpps
2020-06-29 11:35:22,251 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [pps_start, created_time, updated_time, modality, mpps_attrs, station_aet, mpps_iuid, pk, accession_no, patient_fk, mpps_status, drcode_fk]
2020-06-29 11:35:22,261 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.mwl_item
2020-06-29 11:35:22,261 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [station_name, req_proc_id, created_time, updated_time, study_iuid, modality, perf_phys_gn_sx, start_datetime, sps_status, station_aet, accession_no, perf_phys_i_name, perf_physician, perf_phys_fn_sx, perf_phys_p_name, sps_id, pk, patient_fk, item_attrs]
2020-06-29 11:35:22,285 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.other_pid
2020-06-29 11:35:22,285 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [pat_id_issuer, pk, pat_id]
2020-06-29 11:35:22,296 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.patient
2020-06-29 11:35:22,296 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [created_time, updated_time, pat_fn_sx, pat_p_name, pat_birthdate, pat_sex, pat_name, pat_custom3, pat_custom1, pat_custom2, pat_gn_sx, pat_id_issuer, merge_fk, pat_attrs, pk, pat_id, pat_i_name]
2020-06-29 11:35:22,319 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.priv_file
2020-06-29 11:35:22,319 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [file_tsuid, filepath, file_status, file_md5, instance_fk, filesystem_fk, pk, file_size]
2020-06-29 11:35:22,334 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.priv_instance
2020-06-29 11:35:22,334 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [series_fk, created_time, inst_attrs, sop_iuid, pk, priv_type]
2020-06-29 11:35:22,345 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.priv_patient
2020-06-29 11:35:22,345 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [pat_id_issuer, pat_name, pat_attrs, pk, priv_type, pat_id]
2020-06-29 11:35:22,353 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.priv_series
2020-06-29 11:35:22,353 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [series_attrs, study_fk, src_aet, series_iuid, pk, priv_type]
2020-06-29 11:35:22,373 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.priv_study
2020-06-29 11:35:22,374 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [study_iuid, study_attrs, pk, priv_type, accession_no, patient_fk]
2020-06-29 11:35:22,388 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.published_study
2020-06-29 11:35:22,388 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [doc_uid, study_fk, created_time, updated_time, repository_uid, pk, docentry_uid, status]
2020-06-29 11:35:22,399 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.rel_dev_proto
2020-06-29 11:35:22,400 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [prcode_fk, device_fk]
2020-06-29 11:35:22,414 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.rel_gpsps_appcode
2020-06-29 11:35:22,414 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [gpsps_fk, appcode_fk]
2020-06-29 11:35:22,421 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.rel_gpsps_devclass
2020-06-29 11:35:22,422 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [devclass_fk, gpsps_fk]
2020-06-29 11:35:22,438 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.rel_gpsps_devloc
2020-06-29 11:35:22,439 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [gpsps_fk, devloc_fk]
2020-06-29 11:35:22,454 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.rel_gpsps_devname
2020-06-29 11:35:22,454 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [gpsps_fk, devname_fk]
2020-06-29 11:35:22,465 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.rel_gpsps_gppps
2020-06-29 11:35:22,465 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [gpsps_fk, gppps_fk]
2020-06-29 11:35:22,472 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.rel_hpdef_proc
2020-06-29 11:35:22,472 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [hpdef_fk, proc_fk]
2020-06-29 11:35:22,482 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.rel_hpdef_reason
2020-06-29 11:35:22,482 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [hpdef_fk, reason_fk]
2020-06-29 11:35:22,491 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.rel_hpdef_region
2020-06-29 11:35:22,491 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [hpdef_fk, region_fk]
2020-06-29 11:35:22,500 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.rel_pat_other_pid
2020-06-29 11:35:22,500 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [other_pid_fk, patient_fk]
2020-06-29 11:35:22,510 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.rel_study_pcode
2020-06-29 11:35:22,510 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [pcode_fk, study_fk]
2020-06-29 11:35:22,524 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.rel_ups_appcode
2020-06-29 11:35:22,524 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [ups_fk, appcode_fk]
2020-06-29 11:35:22,532 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.rel_ups_devclass
2020-06-29 11:35:22,532 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [devclass_fk, ups_fk]
2020-06-29 11:35:22,539 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.rel_ups_devloc
2020-06-29 11:35:22,540 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [ups_fk, devloc_fk]
2020-06-29 11:35:22,547 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.rel_ups_devname
2020-06-29 11:35:22,547 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [devname_fk, ups_fk]
2020-06-29 11:35:22,557 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.rel_ups_performer
2020-06-29 11:35:22,557 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [ups_fk, performer_fk]
2020-06-29 11:35:22,571 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.series
2020-06-29 11:35:22,571 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [updated_time, modality, series_no, series_iuid, inst_code_fk, retrieve_aets, availability, laterality, institution, perf_phys_fn_sx, pps_start, perf_phys_p_name, ext_retr_aet, department, body_part, series_desc, num_instances, station_name, series_attrs, study_fk, src_aet, created_time, perf_phys_gn_sx, series_custom3, series_custom1, series_custom2, fileset_iuid, perf_phys_i_name, perf_physician, pps_iuid, series_status, mpps_fk, pk, fileset_id]
2020-06-29 11:35:22,589 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.series_req
2020-06-29 11:35:22,589 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [series_fk, req_proc_id, study_iuid, req_phys_fn_sx, accno_issuer_fk, accession_no, req_phys_i_name, req_service, req_phys_gn_sx, sps_id, req_physician, pk, req_phys_p_name]
2020-06-29 11:35:22,600 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.study
2020-06-29 11:35:22,600 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [ref_physician, updated_time, study_iuid, mods_in_study, ref_phys_i_name, study_id, accession_no, retrieve_aets, availability, study_status, ext_retr_aet, study_attrs, study_custom2, study_custom1, study_status_id, patient_fk, ref_phys_gn_sx, study_custom3, num_instances, created_time, cuids_in_study, ref_phys_fn_sx, accno_issuer_fk, fileset_iuid, ref_phys_p_name, checked_time, num_series, pk, study_desc, study_datetime, fileset_id]
2020-06-29 11:35:22,610 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.study_on_fs
2020-06-29 11:35:22,610 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [study_fk, filesystem_fk, pk, access_time, mark_to_delete]
2020-06-29 11:35:22,617 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.study_permission
2020-06-29 11:35:22,617 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [study_iuid, roles, action, pk]
2020-06-29 11:35:22,626 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.ups
2020-06-29 11:35:22,626 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [created_time, updated_time, ups_iuid, adm_id_issuer_uid, ups_start_time, adm_id, uwl_label, ups_prior, ups_tuid, ups_compl_time, code_fk, ups_state, pk, ups_attrs, patient_fk, adm_id_issuer_id, ups_label]
2020-06-29 11:35:22,641 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.ups_rel_ps
2020-06-29 11:35:22,641 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [sop_iuid, pk, ups_fk, sop_cuid]
2020-06-29 11:35:22,649 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.ups_repl_ps
2020-06-29 11:35:22,649 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [sop_iuid, pk, ups_fk, sop_cuid]
2020-06-29 11:35:22,657 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.ups_req
2020-06-29 11:35:22,657 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [req_proc_id, confidentiality, pk, ups_fk, accession_no, req_service]
2020-06-29 11:35:22,681 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.ups_subscr
2020-06-29 11:35:22,682 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [aet, deletion_lock, pk, ups_fk]
2020-06-29 11:35:22,691 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.verify_observer
2020-06-29 11:35:22,691 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [observer_name, observer_p_name, observer_i_name, observer_gn_sx, observer_fn_sx, instance_fk, pk, verify_datetime]
2020-06-29 11:35:22,694 INFO  -> (main) [org.hibernate.util.NamingHelper] JNDI InitialContext properties:{java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces}
2020-06-29 11:35:23,277 INFO  -> (main) [org.jboss.ejb3.EJB3Deployer] Deployed: file:/var/lib/bahmni/dcm4chee-2.18.1-psql/server/default/tmp/deploy/tmp7983209538211635377dcm4chee-web-ear-3.0.5-psql.ear-contents/dcm4chee-arc-entities-3.0.5-psql.jar
2020-06-29 11:35:23,878 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
2020-06-29 11:35:23,882 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-web-ear-3.0.5-psql.ear,jar=dcm4chee-usr-dao-3.0.5.jar,name=UserAccessBean,service=EJB3 with dependencies:
2020-06-29 11:35:23,882 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] 	persistence.units:ear=dcm4chee-web-ear-3.0.5-psql.ear,unitName=dcm4chee-usr
2020-06-29 11:35:23,883 INFO  -> (main) [org.jboss.ejb3.EJB3Deployer] Deployed: file:/var/lib/bahmni/dcm4chee-2.18.1-psql/server/default/tmp/deploy/tmp7983209538211635377dcm4chee-web-ear-3.0.5-psql.ear-contents/dcm4chee-usr-dao-3.0.5.jar
2020-06-29 11:35:23,884 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.entity.PersistenceUnitDeployment
2020-06-29 11:35:23,884 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] installing MBean: persistence.units:ear=dcm4chee-web-ear-3.0.5-psql.ear,unitName=dcm4chee-usr with dependencies:
2020-06-29 11:35:23,884 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] 	jboss.jca:name=pacsDS,service=DataSourceBinding
2020-06-29 11:35:23,885 INFO  -> (main) [org.jboss.ejb3.entity.PersistenceUnitDeployment] Starting persistence unit persistence.units:ear=dcm4chee-web-ear-3.0.5-psql.ear,unitName=dcm4chee-usr
2020-06-29 11:35:23,889 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] Processing PersistenceUnitInfo [
	name: dcm4chee-usr
	...]
2020-06-29 11:35:23,889 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.usr.entity.User
2020-06-29 11:35:23,890 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.usr.entity.UserRoleAssignment
2020-06-29 11:35:23,913 INFO  -> (main) [org.hibernate.cfg.Configuration] Reading mappings from resource : META-INF/orm.xml
2020-06-29 11:35:23,995 INFO  -> (main) [org.hibernate.ejb.Ejb3Configuration] [PersistenceUnit: dcm4chee-usr] META-INF/orm.xml found
2020-06-29 11:35:24,004 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.usr.entity.User
2020-06-29 11:35:24,004 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.usr.entity.User on table users
2020-06-29 11:35:24,007 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.usr.entity.UserRoleAssignment
2020-06-29 11:35:24,007 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.usr.entity.UserRoleAssignment on table roles
2020-06-29 11:35:24,112 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.AE
2020-06-29 11:35:24,112 INFO  -> (main) [org.hibernate.cfg.annotations.QueryBinder] Binding Named query: AE.findByTitle => select ae from AE ae where title = :title
2020-06-29 11:35:24,112 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.AE on table ae
2020-06-29 11:35:24,115 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Code
2020-06-29 11:35:24,115 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.Code on table code
2020-06-29 11:35:24,116 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Device
2020-06-29 11:35:24,116 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.Device on table device
2020-06-29 11:35:24,117 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.File
2020-06-29 11:35:24,117 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.File on table files
2020-06-29 11:35:24,120 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.FileSystem
2020-06-29 11:35:24,120 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.FileSystem on table filesystem
2020-06-29 11:35:24,121 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.GPPPS
2020-06-29 11:35:24,122 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.GPPPS on table gppps
2020-06-29 11:35:24,123 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.GPSPS
2020-06-29 11:35:24,123 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.GPSPS on table gpsps
2020-06-29 11:35:24,128 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.GPSPSPerformer
2020-06-29 11:35:24,128 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.GPSPSPerformer on table gpsps_perf
2020-06-29 11:35:24,130 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.GPSPSRequest
2020-06-29 11:35:24,130 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.GPSPSRequest on table gpsps_req
2020-06-29 11:35:24,131 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.HangingProtocol
2020-06-29 11:35:24,131 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.HangingProtocol on table hp
2020-06-29 11:35:24,133 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.HPDefinition
2020-06-29 11:35:24,133 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.HPDefinition on table hpdef
2020-06-29 11:35:24,135 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Instance
2020-06-29 11:35:24,135 INFO  -> (main) [org.hibernate.cfg.annotations.QueryBinder] Binding Named query: Instance.findByIUID => select object(i) from Instance i where sopInstanceUID = :iuid
2020-06-29 11:35:24,135 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.Instance on table instance
2020-06-29 11:35:24,139 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Media
2020-06-29 11:35:24,139 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.Media on table media
2020-06-29 11:35:24,140 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.MPPS
2020-06-29 11:35:24,141 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.MPPS on table mpps
2020-06-29 11:35:24,143 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.MWLItem
2020-06-29 11:35:24,143 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.MWLItem on table mwl_item
2020-06-29 11:35:24,146 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.OtherPatientID
2020-06-29 11:35:24,146 INFO  -> (main) [org.hibernate.cfg.annotations.QueryBinder] Binding Named query: OtherPatientID.findByPatientIdAndIssuer => select opid from OtherPatientID opid where patientID = :pid and issuerOfPatientID = :issuer
2020-06-29 11:35:24,147 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.OtherPatientID on table other_pid
2020-06-29 11:35:24,148 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Patient
2020-06-29 11:35:24,148 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.Patient on table patient
2020-06-29 11:35:24,152 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.PrivateFile
2020-06-29 11:35:24,152 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.PrivateFile on table priv_file
2020-06-29 11:35:24,153 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.PrivateInstance
2020-06-29 11:35:24,153 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.PrivateInstance on table priv_instance
2020-06-29 11:35:24,154 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.PrivatePatient
2020-06-29 11:35:24,154 INFO  -> (main) [org.hibernate.cfg.annotations.QueryBinder] Binding Named query: PrivatePatient.findByIdAndIssuer => select object(p) from PrivatePatient p where patientID = :patId and issuerOfPatientID = :issuer
2020-06-29 11:35:24,154 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.PrivatePatient on table priv_patient
2020-06-29 11:35:24,155 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.PrivateSeries
2020-06-29 11:35:24,156 INFO  -> (main) [org.hibernate.cfg.annotations.QueryBinder] Binding Named query: PrivateSeries.findByIUID => select object(pi) from PrivateSeries pi where seriesInstanceUID = :iuid
2020-06-29 11:35:24,156 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.PrivateSeries on table priv_series
2020-06-29 11:35:24,157 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.PrivateStudy
2020-06-29 11:35:24,157 INFO  -> (main) [org.hibernate.cfg.annotations.QueryBinder] Binding Named query: PrivateStudy.findByIUID => select object(ps) from PrivateStudy ps where studyInstanceUID = :iuid
2020-06-29 11:35:24,157 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.PrivateStudy on table priv_study
2020-06-29 11:35:24,159 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.RequestAttributes
2020-06-29 11:35:24,159 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.RequestAttributes on table series_req
2020-06-29 11:35:24,162 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Series
2020-06-29 11:35:24,162 INFO  -> (main) [org.hibernate.cfg.annotations.QueryBinder] Binding Named query: Series.findByIUID => select object(s) from Series s where seriesInstanceUID = :iuid
2020-06-29 11:35:24,162 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.Series on table series
2020-06-29 11:35:24,166 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Study
2020-06-29 11:35:24,167 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.Study on table study
2020-06-29 11:35:24,175 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.StudyOnFileSystem
2020-06-29 11:35:24,175 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.StudyOnFileSystem on table study_on_fs
2020-06-29 11:35:24,176 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.StudyPermission
2020-06-29 11:35:24,177 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.StudyPermission on table study_permission
2020-06-29 11:35:24,177 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.VerifyingObserver
2020-06-29 11:35:24,177 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.VerifyingObserver on table verify_observer
2020-06-29 11:35:24,178 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Issuer
2020-06-29 11:35:24,179 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.Issuer on table issuer
2020-06-29 11:35:24,179 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.ContentItem
2020-06-29 11:35:24,180 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.ContentItem on table content_item
2020-06-29 11:35:24,180 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.UPS
2020-06-29 11:35:24,181 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.UPS on table ups
2020-06-29 11:35:24,186 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.UPSRequest
2020-06-29 11:35:24,186 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.UPSRequest on table ups_req
2020-06-29 11:35:24,187 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.UPSRelatedPS
2020-06-29 11:35:24,187 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.UPSRelatedPS on table ups_rel_ps
2020-06-29 11:35:24,188 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.UPSReplacedPS
2020-06-29 11:35:24,188 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.UPSReplacedPS on table ups_repl_ps
2020-06-29 11:35:24,189 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.UPSSubscription
2020-06-29 11:35:24,189 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.UPSSubscription on table ups_subscr
2020-06-29 11:35:24,190 INFO  -> (main) [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.PublishedStudy
2020-06-29 11:35:24,190 INFO  -> (main) [org.hibernate.cfg.annotations.QueryBinder] Binding Named query: PublishedStudy.findByStudyPkAndStatus => select object(s) from PublishedStudy s where s.study.pk = :studyPk and s.status = :status
2020-06-29 11:35:24,190 INFO  -> (main) [org.hibernate.cfg.annotations.EntityBinder] Bind entity org.dcm4chee.archive.entity.PublishedStudy on table published_study
2020-06-29 11:35:24,197 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.usr.entity.User.roles -> roles
2020-06-29 11:35:24,197 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.GPSPS.referencedRequests -> gpsps_req
2020-06-29 11:35:24,197 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.GPSPS.scheduledHumanPerformers -> gpsps_perf
2020-06-29 11:35:24,198 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.HangingProtocol.definitions -> hpdef
2020-06-29 11:35:24,198 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Instance.verifyingObservers -> verify_observer
2020-06-29 11:35:24,198 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Instance.files -> files
2020-06-29 11:35:24,198 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Instance.contentItems -> content_item
2020-06-29 11:35:24,198 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Media.instances -> instance
2020-06-29 11:35:24,198 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.MPPS.series -> series
2020-06-29 11:35:24,198 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.previous -> patient
2020-06-29 11:35:24,198 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.studies -> study
2020-06-29 11:35:24,198 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.modalityWorklistItems -> mwl_item
2020-06-29 11:35:24,199 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.modalityPerformedProcedureSteps -> mpps
2020-06-29 11:35:24,199 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.generalPurposeScheduledProcedureSteps -> gpsps
2020-06-29 11:35:24,199 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.generalPurposePerformedProcedureSteps -> gppps
2020-06-29 11:35:24,199 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.unifiedProcedureSteps -> ups
2020-06-29 11:35:24,199 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.PrivateInstance.files -> priv_file
2020-06-29 11:35:24,199 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.PrivatePatient.studies -> priv_study
2020-06-29 11:35:24,199 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.PrivateSeries.instances -> priv_instance
2020-06-29 11:35:24,199 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.PrivateStudy.series -> priv_series
2020-06-29 11:35:24,199 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Series.requestAttributes -> series_req
2020-06-29 11:35:24,199 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Series.instances -> instance
2020-06-29 11:35:24,200 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Study.series -> series
2020-06-29 11:35:24,200 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.UPS.refRequests -> ups_req
2020-06-29 11:35:24,200 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.UPS.relatedProcedureSteps -> ups_rel_ps
2020-06-29 11:35:24,200 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.UPS.replacedProcedureSteps -> ups_repl_ps
2020-06-29 11:35:24,200 INFO  -> (main) [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.UPS.subscriptions -> ups_subscr
2020-06-29 11:35:24,433 INFO  -> (main) [org.hibernate.connection.ConnectionProviderFactory] Initializing connection provider: org.hibernate.ejb.connection.InjectedDataSourceConnectionProvider
2020-06-29 11:35:24,434 INFO  -> (main) [org.hibernate.ejb.connection.InjectedDataSourceConnectionProvider] Using provided datasource
2020-06-29 11:35:24,434 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] RDBMS: PostgreSQL, version: 9.6.18
2020-06-29 11:35:24,434 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] JDBC driver: PostgreSQL Native Driver, version: PostgreSQL 9.1 JDBC4 (build 901)
2020-06-29 11:35:24,434 INFO  -> (main) [org.hibernate.dialect.Dialect] Using dialect: org.hibernate.dialect.PostgreSQLDialect
2020-06-29 11:35:24,434 INFO  -> (main) [org.hibernate.transaction.TransactionFactoryFactory] Transaction strategy: org.hibernate.ejb.transaction.JoinableCMTTransactionFactory
2020-06-29 11:35:24,434 INFO  -> (main) [org.hibernate.transaction.TransactionManagerLookupFactory] instantiating TransactionManagerLookup: org.hibernate.transaction.JBossTransactionManagerLookup
2020-06-29 11:35:24,434 INFO  -> (main) [org.hibernate.transaction.TransactionManagerLookupFactory] instantiated TransactionManagerLookup
2020-06-29 11:35:24,434 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Automatic flush during beforeCompletion(): disabled
2020-06-29 11:35:24,434 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Automatic session close at end of transaction: disabled
2020-06-29 11:35:24,434 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] JDBC batch size: 15
2020-06-29 11:35:24,434 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] JDBC batch updates for versioned data: disabled
2020-06-29 11:35:24,434 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Scrollable result sets: enabled
2020-06-29 11:35:24,434 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] JDBC3 getGeneratedKeys(): disabled
2020-06-29 11:35:24,434 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Connection release mode: auto
2020-06-29 11:35:24,434 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Default batch fetch size: 1
2020-06-29 11:35:24,434 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Generate SQL with comments: disabled
2020-06-29 11:35:24,434 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Order SQL updates by primary key: disabled
2020-06-29 11:35:24,434 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Order SQL inserts for batching: disabled
2020-06-29 11:35:24,434 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Query translator: org.hibernate.hql.ast.ASTQueryTranslatorFactory
2020-06-29 11:35:24,434 INFO  -> (main) [org.hibernate.hql.ast.ASTQueryTranslatorFactory] Using ASTQueryTranslatorFactory
2020-06-29 11:35:24,434 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Query language substitutions: {}
2020-06-29 11:35:24,434 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] JPA-QL strict compliance: enabled
2020-06-29 11:35:24,434 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Second-level cache: enabled
2020-06-29 11:35:24,434 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Query cache: disabled
2020-06-29 11:35:24,434 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Cache provider: org.hibernate.cache.HashtableCacheProvider
2020-06-29 11:35:24,434 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Optimize cache for minimal puts: disabled
2020-06-29 11:35:24,434 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Cache region prefix: dcm4chee-web-ear-3_0_5-psql_ear,dcm4chee-usr
2020-06-29 11:35:24,434 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Structured second-level cache entries: disabled
2020-06-29 11:35:24,434 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Statistics: disabled
2020-06-29 11:35:24,434 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Deleted entity synthetic identifier rollback: disabled
2020-06-29 11:35:24,434 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Default entity-mode: pojo
2020-06-29 11:35:24,434 INFO  -> (main) [org.hibernate.cfg.SettingsFactory] Named query checking : enabled
2020-06-29 11:35:24,461 INFO  -> (main) [org.hibernate.impl.SessionFactoryImpl] building session factory
2020-06-29 11:35:24,693 INFO  -> (main) [org.hibernate.impl.SessionFactoryObjectFactory] Factory name: persistence.units:ear=dcm4chee-web-ear-3.0.5-psql.ear,unitName=dcm4chee-usr
2020-06-29 11:35:24,693 INFO  -> (main) [org.hibernate.util.NamingHelper] JNDI InitialContext properties:{java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces}
2020-06-29 11:35:24,693 INFO  -> (main) [org.hibernate.impl.SessionFactoryObjectFactory] Bound factory to JNDI name: persistence.units:ear=dcm4chee-web-ear-3.0.5-psql.ear,unitName=dcm4chee-usr
2020-06-29 11:35:24,693 WARN  -> (main) [org.hibernate.impl.SessionFactoryObjectFactory] InitialContext did not implement EventContext
2020-06-29 11:35:24,693 INFO  -> (main) [org.hibernate.tool.hbm2ddl.SchemaValidator] Running schema validator
2020-06-29 11:35:24,693 INFO  -> (main) [org.hibernate.tool.hbm2ddl.SchemaValidator] fetching database metadata
2020-06-29 11:35:24,734 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.ae
2020-06-29 11:35:24,734 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [ae_group, station_name, installed, acc_no_issuer, vendor_data, cipher_suites, aet, institution, hostname, pat_id_issuer, ae_desc, wado_url, port, user_id, passwd, pk, department, fs_group_id]
2020-06-29 11:35:24,742 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.code
2020-06-29 11:35:24,742 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [code_version, code_value, code_designator, pk, code_meaning]
2020-06-29 11:35:24,752 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.content_item
2020-06-29 11:35:24,752 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [text_value, code_fk, rel_type, instance_fk, pk, name_fk]
2020-06-29 11:35:24,762 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.device
2020-06-29 11:35:24,762 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [station_name, modality, station_aet, pk]
2020-06-29 11:35:24,770 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.files
2020-06-29 11:35:24,770 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [created_time, file_tsuid, filepath, file_status, file_md5, instance_fk, filesystem_fk, pk, md5_check_time, file_size]
2020-06-29 11:35:24,778 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.filesystem
2020-06-29 11:35:24,778 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [retrieve_aet, dirpath, user_info, next_fk, pk, availability, fs_group_id, fs_status]
2020-06-29 11:35:24,785 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.gppps
2020-06-29 11:35:24,785 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [pps_start, created_time, updated_time, pps_iuid, pps_status, pk, patient_fk, pps_attrs]
2020-06-29 11:35:24,791 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.gpsps
2020-06-29 11:35:24,792 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [gpsps_tuid, code_fk, start_datetime, end_datetime, gpsps_prior, pk, patient_fk, gpsps_iuid, gpsps_status, in_availability, item_attrs]
2020-06-29 11:35:24,800 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.gpsps_perf
2020-06-29 11:35:24,800 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [hum_perf_i_name, code_fk, human_perf_name, gpsps_fk, hum_perf_fn_sx, pk, hum_perf_gn_sx, hum_perf_p_name]
2020-06-29 11:35:24,808 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.gpsps_req
2020-06-29 11:35:24,808 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [req_proc_id, gpsps_fk, pk, accession_no]
2020-06-29 11:35:24,816 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.hp
2020-06-29 11:35:24,816 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [user_fk, hp_cuid, num_screens, hp_attrs, hp_name, hp_group, pk, hp_iuid, num_priors, hp_level]
2020-06-29 11:35:24,827 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.hpdef
2020-06-29 11:35:24,827 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [hp_fk, modality, pk, laterality]
2020-06-29 11:35:24,836 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.instance
2020-06-29 11:35:24,836 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [series_fk, created_time, updated_time, sr_complete, inst_attrs, inst_custom2, inst_custom3, content_datetime, commitment, inst_custom1, retrieve_aets, availability, media_fk, archived, all_attrs, inst_no, inst_status, sop_iuid, ext_retr_aet, pk, sop_cuid, sr_verified, srcode_fk]
2020-06-29 11:35:24,845 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.issuer
2020-06-29 11:35:24,845 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [entity_uid, entity_uid_type, pk, entity_id]
2020-06-29 11:35:24,854 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.media
2020-06-29 11:35:24,854 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [created_time, updated_time, media_status, media_rq_iuid, media_usage, pk, fileset_iuid, media_status_info, fileset_id]
2020-06-29 11:35:24,861 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.mpps
2020-06-29 11:35:24,862 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [pps_start, created_time, updated_time, modality, mpps_attrs, station_aet, mpps_iuid, pk, accession_no, patient_fk, mpps_status, drcode_fk]
2020-06-29 11:35:24,870 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.mwl_item
2020-06-29 11:35:24,870 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [station_name, req_proc_id, created_time, updated_time, study_iuid, modality, perf_phys_gn_sx, start_datetime, sps_status, station_aet, accession_no, perf_phys_i_name, perf_physician, perf_phys_fn_sx, perf_phys_p_name, sps_id, pk, patient_fk, item_attrs]
2020-06-29 11:35:24,879 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.other_pid
2020-06-29 11:35:24,879 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [pat_id_issuer, pk, pat_id]
2020-06-29 11:35:24,888 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.patient
2020-06-29 11:35:24,888 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [created_time, updated_time, pat_fn_sx, pat_p_name, pat_birthdate, pat_sex, pat_name, pat_custom3, pat_custom1, pat_custom2, pat_gn_sx, pat_id_issuer, merge_fk, pat_attrs, pk, pat_id, pat_i_name]
2020-06-29 11:35:24,900 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.priv_file
2020-06-29 11:35:24,900 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [file_tsuid, filepath, file_status, file_md5, instance_fk, filesystem_fk, pk, file_size]
2020-06-29 11:35:24,907 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.priv_instance
2020-06-29 11:35:24,907 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [series_fk, created_time, inst_attrs, sop_iuid, pk, priv_type]
2020-06-29 11:35:24,915 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.priv_patient
2020-06-29 11:35:24,915 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [pat_id_issuer, pat_name, pat_attrs, pk, priv_type, pat_id]
2020-06-29 11:35:24,923 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.priv_series
2020-06-29 11:35:24,923 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [series_attrs, study_fk, src_aet, series_iuid, pk, priv_type]
2020-06-29 11:35:24,931 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.priv_study
2020-06-29 11:35:24,931 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [study_iuid, study_attrs, pk, priv_type, accession_no, patient_fk]
2020-06-29 11:35:24,945 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.published_study
2020-06-29 11:35:24,945 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [doc_uid, study_fk, created_time, updated_time, repository_uid, pk, docentry_uid, status]
2020-06-29 11:35:24,973 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.rel_dev_proto
2020-06-29 11:35:24,973 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [prcode_fk, device_fk]
2020-06-29 11:35:24,984 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.rel_gpsps_appcode
2020-06-29 11:35:24,984 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [gpsps_fk, appcode_fk]
2020-06-29 11:35:24,992 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.rel_gpsps_devclass
2020-06-29 11:35:24,992 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [devclass_fk, gpsps_fk]
2020-06-29 11:35:25,002 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.rel_gpsps_devloc
2020-06-29 11:35:25,002 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [gpsps_fk, devloc_fk]
2020-06-29 11:35:25,024 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.rel_gpsps_devname
2020-06-29 11:35:25,024 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [gpsps_fk, devname_fk]
2020-06-29 11:35:25,032 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.rel_gpsps_gppps
2020-06-29 11:35:25,033 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [gpsps_fk, gppps_fk]
2020-06-29 11:35:25,042 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.rel_hpdef_proc
2020-06-29 11:35:25,042 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [hpdef_fk, proc_fk]
2020-06-29 11:35:25,055 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.rel_hpdef_reason
2020-06-29 11:35:25,055 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [hpdef_fk, reason_fk]
2020-06-29 11:35:25,065 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.rel_hpdef_region
2020-06-29 11:35:25,065 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [hpdef_fk, region_fk]
2020-06-29 11:35:25,081 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.rel_pat_other_pid
2020-06-29 11:35:25,081 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [other_pid_fk, patient_fk]
2020-06-29 11:35:25,090 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.rel_study_pcode
2020-06-29 11:35:25,090 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [pcode_fk, study_fk]
2020-06-29 11:35:25,101 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.rel_ups_appcode
2020-06-29 11:35:25,101 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [ups_fk, appcode_fk]
2020-06-29 11:35:25,107 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.rel_ups_devclass
2020-06-29 11:35:25,107 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [devclass_fk, ups_fk]
2020-06-29 11:35:25,115 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.rel_ups_devloc
2020-06-29 11:35:25,115 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [ups_fk, devloc_fk]
2020-06-29 11:35:25,124 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.rel_ups_devname
2020-06-29 11:35:25,124 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [devname_fk, ups_fk]
2020-06-29 11:35:25,132 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.rel_ups_performer
2020-06-29 11:35:25,132 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [ups_fk, performer_fk]
2020-06-29 11:35:25,140 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.roles
2020-06-29 11:35:25,140 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [user_id, roles]
2020-06-29 11:35:25,148 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.series
2020-06-29 11:35:25,148 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [updated_time, modality, series_no, series_iuid, inst_code_fk, retrieve_aets, availability, laterality, institution, perf_phys_fn_sx, pps_start, perf_phys_p_name, ext_retr_aet, department, body_part, series_desc, num_instances, station_name, series_attrs, study_fk, src_aet, created_time, perf_phys_gn_sx, series_custom3, series_custom1, series_custom2, fileset_iuid, perf_phys_i_name, perf_physician, pps_iuid, series_status, mpps_fk, pk, fileset_id]
2020-06-29 11:35:25,154 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.series_req
2020-06-29 11:35:25,154 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [series_fk, req_proc_id, study_iuid, req_phys_fn_sx, accno_issuer_fk, accession_no, req_phys_i_name, req_service, req_phys_gn_sx, sps_id, req_physician, pk, req_phys_p_name]
2020-06-29 11:35:25,161 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.study
2020-06-29 11:35:25,161 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [ref_physician, updated_time, study_iuid, mods_in_study, ref_phys_i_name, study_id, accession_no, retrieve_aets, availability, study_status, ext_retr_aet, study_attrs, study_custom2, study_custom1, study_status_id, patient_fk, ref_phys_gn_sx, study_custom3, num_instances, created_time, cuids_in_study, ref_phys_fn_sx, accno_issuer_fk, fileset_iuid, ref_phys_p_name, checked_time, num_series, pk, study_desc, study_datetime, fileset_id]
2020-06-29 11:35:25,167 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.study_on_fs
2020-06-29 11:35:25,167 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [study_fk, filesystem_fk, pk, access_time, mark_to_delete]
2020-06-29 11:35:25,173 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.study_permission
2020-06-29 11:35:25,174 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [study_iuid, roles, action, pk]
2020-06-29 11:35:25,181 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.ups
2020-06-29 11:35:25,181 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [created_time, updated_time, ups_iuid, adm_id_issuer_uid, ups_start_time, adm_id, uwl_label, ups_prior, ups_tuid, ups_compl_time, code_fk, ups_state, pk, ups_attrs, patient_fk, adm_id_issuer_id, ups_label]
2020-06-29 11:35:25,187 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.ups_rel_ps
2020-06-29 11:35:25,187 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [sop_iuid, pk, ups_fk, sop_cuid]
2020-06-29 11:35:25,195 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.ups_repl_ps
2020-06-29 11:35:25,195 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [sop_iuid, pk, ups_fk, sop_cuid]
2020-06-29 11:35:25,202 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.ups_req
2020-06-29 11:35:25,202 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [req_proc_id, confidentiality, pk, ups_fk, accession_no, req_service]
2020-06-29 11:35:25,211 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.ups_subscr
2020-06-29 11:35:25,211 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [aet, deletion_lock, pk, ups_fk]
2020-06-29 11:35:25,217 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.users
2020-06-29 11:35:25,217 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [user_id, passwd]
2020-06-29 11:35:25,224 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] table found: public.verify_observer
2020-06-29 11:35:25,224 INFO  -> (main) [org.hibernate.tool.hbm2ddl.TableMetadata] columns: [observer_name, observer_p_name, observer_i_name, observer_gn_sx, observer_fn_sx, instance_fk, pk, verify_datetime]
2020-06-29 11:35:25,225 INFO  -> (main) [org.hibernate.util.NamingHelper] JNDI InitialContext properties:{java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces}
2020-06-29 11:35:25,462 INFO  -> (main) [org.jboss.ejb3.EJBContainer] STARTED EJB: org.dcm4chee.usr.dao.UserAccessBean ejbName: UserAccessBean
2020-06-29 11:35:25,513 INFO  -> (main) [org.jboss.ejb3.EJB3Deployer] Deployed: file:/var/lib/bahmni/dcm4chee-2.18.1-psql/server/default/tmp/deploy/tmp7983209538211635377dcm4chee-web-ear-3.0.5-psql.ear-contents/dcm4chee-usr-entity-3.0.5-psql.jar
2020-06-29 11:35:25,662 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
2020-06-29 11:35:25,662 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-web-ear-3.0.5-psql.ear,jar=dcm4chee-web-ejb-3.0.5.jar,name=AEHomeBean,service=EJB3 with dependencies:
2020-06-29 11:35:25,662 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] 	persistence.units:ear=dcm4chee-web-ear-3.0.5-psql.ear,unitName=dcm4chee-arc
2020-06-29 11:35:25,665 INFO  -> (main) [org.jboss.ejb3.EJBContainer] STARTED EJB: org.dcm4chee.web.dao.ae.AEHomeBean ejbName: AEHomeBean
2020-06-29 11:35:25,673 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
2020-06-29 11:35:25,673 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-web-ear-3.0.5-psql.ear,jar=dcm4chee-web-ejb-3.0.5.jar,name=DicomEditBean,service=EJB3 with dependencies:
2020-06-29 11:35:25,673 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] 	persistence.units:ear=dcm4chee-web-ear-3.0.5-psql.ear,unitName=dcm4chee-arc
2020-06-29 11:35:25,696 INFO  -> (main) [org.jboss.ejb3.EJBContainer] STARTED EJB: org.dcm4chee.web.dao.common.DicomEditBean ejbName: DicomEditBean
2020-06-29 11:35:25,728 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
2020-06-29 11:35:25,728 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-web-ear-3.0.5-psql.ear,jar=dcm4chee-web-ejb-3.0.5.jar,name=MppsToMwlLinkBean,service=EJB3 with dependencies:
2020-06-29 11:35:25,728 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] 	persistence.units:ear=dcm4chee-web-ear-3.0.5-psql.ear,unitName=dcm4chee-arc
2020-06-29 11:35:25,732 INFO  -> (main) [org.jboss.ejb3.EJBContainer] STARTED EJB: org.dcm4chee.web.dao.folder.MppsToMwlLinkBean ejbName: MppsToMwlLinkBean
2020-06-29 11:35:25,746 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
2020-06-29 11:35:25,746 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-web-ear-3.0.5-psql.ear,jar=dcm4chee-web-ejb-3.0.5.jar,name=StudyListBean,service=EJB3 with dependencies:
2020-06-29 11:35:25,746 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] 	persistence.units:ear=dcm4chee-web-ear-3.0.5-psql.ear,unitName=dcm4chee-arc
2020-06-29 11:35:25,753 INFO  -> (main) [org.jboss.ejb3.EJBContainer] STARTED EJB: org.dcm4chee.web.dao.folder.StudyListBean ejbName: StudyListBean
2020-06-29 11:35:25,765 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
2020-06-29 11:35:25,765 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-web-ear-3.0.5-psql.ear,jar=dcm4chee-web-ejb-3.0.5.jar,name=StudyPermissionsBean,service=EJB3 with dependencies:
2020-06-29 11:35:25,766 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] 	persistence.units:ear=dcm4chee-web-ear-3.0.5-psql.ear,unitName=dcm4chee-arc
2020-06-29 11:35:25,770 INFO  -> (main) [org.jboss.ejb3.EJBContainer] STARTED EJB: org.dcm4chee.web.dao.folder.StudyPermissionsBean ejbName: StudyPermissionsBean
2020-06-29 11:35:25,790 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
2020-06-29 11:35:25,790 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-web-ear-3.0.5-psql.ear,jar=dcm4chee-web-ejb-3.0.5.jar,name=FileSystemHomeBean,service=EJB3 with dependencies:
2020-06-29 11:35:25,790 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] 	persistence.units:ear=dcm4chee-web-ear-3.0.5-psql.ear,unitName=dcm4chee-arc
2020-06-29 11:35:25,793 INFO  -> (main) [org.jboss.ejb3.EJBContainer] STARTED EJB: org.dcm4chee.web.dao.fs.FileSystemHomeBean ejbName: FileSystemHomeBean
2020-06-29 11:35:25,801 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
2020-06-29 11:35:25,801 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-web-ear-3.0.5-psql.ear,jar=dcm4chee-web-ejb-3.0.5.jar,name=TCQueryBean,service=EJB3 with dependencies:
2020-06-29 11:35:25,802 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] 	persistence.units:ear=dcm4chee-web-ear-3.0.5-psql.ear,unitName=dcm4chee-arc
2020-06-29 11:35:25,805 INFO  -> (main) [org.jboss.ejb3.EJBContainer] STARTED EJB: org.dcm4chee.web.dao.tc.TCQueryBean ejbName: TCQueryBean
2020-06-29 11:35:25,817 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
2020-06-29 11:35:25,817 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-web-ear-3.0.5-psql.ear,jar=dcm4chee-web-ejb-3.0.5.jar,name=TrashCleanerBean,service=EJB3 with dependencies:
2020-06-29 11:35:25,817 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] 	persistence.units:ear=dcm4chee-web-ear-3.0.5-psql.ear,unitName=dcm4chee-arc
2020-06-29 11:35:25,820 INFO  -> (main) [org.jboss.ejb3.EJBContainer] STARTED EJB: org.dcm4chee.web.dao.trash.TrashCleanerBean ejbName: TrashCleanerBean
2020-06-29 11:35:25,837 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
2020-06-29 11:35:25,837 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-web-ear-3.0.5-psql.ear,jar=dcm4chee-web-ejb-3.0.5.jar,name=TrashListBean,service=EJB3 with dependencies:
2020-06-29 11:35:25,837 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] 	persistence.units:ear=dcm4chee-web-ear-3.0.5-psql.ear,unitName=dcm4chee-arc
2020-06-29 11:35:25,842 INFO  -> (main) [org.jboss.ejb3.EJBContainer] STARTED EJB: org.dcm4chee.web.dao.trash.TrashListBean ejbName: TrashListBean
2020-06-29 11:35:25,863 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
2020-06-29 11:35:25,863 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-web-ear-3.0.5-psql.ear,jar=dcm4chee-web-ejb-3.0.5.jar,name=ModalityWorklistBean,service=EJB3 with dependencies:
2020-06-29 11:35:25,863 INFO  -> (main) [org.jboss.ejb3.JmxKernelAbstraction] 	persistence.units:ear=dcm4chee-web-ear-3.0.5-psql.ear,unitName=dcm4chee-arc
2020-06-29 11:35:25,867 INFO  -> (main) [org.jboss.ejb3.EJBContainer] STARTED EJB: org.dcm4chee.web.dao.worklist.modality.ModalityWorklistBean ejbName: ModalityWorklistBean
2020-06-29 11:35:25,890 INFO  -> (main) [org.jboss.ejb3.EJB3Deployer] Deployed: file:/var/lib/bahmni/dcm4chee-2.18.1-psql/server/default/tmp/deploy/tmp7983209538211635377dcm4chee-web-ear-3.0.5-psql.ear-contents/dcm4chee-web-ejb-3.0.5.jar
2020-06-29 11:35:25,918 INFO  -> (main) [org.jboss.web.tomcat.service.TomcatDeployer] deploy, ctxPath=/dcm4chee-web3-dicom, warUrl=.../tmp/deploy/tmp7983209538211635377dcm4chee-web-ear-3.0.5-psql.ear-contents/dcm4chee-web-dicom-3.0.5-exp.war/
2020-06-29 11:35:27,745 INFO  -> (main) [org.jboss.web.tomcat.service.TomcatDeployer] deploy, ctxPath=/dcm4chee-web3, warUrl=.../tmp/deploy/tmp7983209538211635377dcm4chee-web-ear-3.0.5-psql.ear-contents/dcm4chee-web-war-3.0.5-exp.war/
2020-06-29 11:35:33,496 INFO  -> (main) [org.apache.wicket.Application] [WicketApplication] init: Wicket extensions initializer
2020-06-29 11:35:33,656 INFO  -> (main) [org.apache.wicket.Application] [WicketApplication] init: Wicket extensions initializer
2020-06-29 11:35:33,656 INFO  -> (main) [org.apache.wicket.Application] [WicketApplication] init: Wicket core library initializer
2020-06-29 11:35:33,658 INFO  -> (main) [org.apache.wicket.RequestListenerInterface] registered listener interface [RequestListenerInterface name=IBehaviorListener, method=public abstract void org.apache.wicket.behavior.IBehaviorListener.onRequest()]
2020-06-29 11:35:33,658 INFO  -> (main) [org.apache.wicket.RequestListenerInterface] registered listener interface [RequestListenerInterface name=IBehaviorListener, method=public abstract void org.apache.wicket.behavior.IBehaviorListener.onRequest()]
2020-06-29 11:35:33,666 INFO  -> (main) [org.apache.wicket.RequestListenerInterface] registered listener interface [RequestListenerInterface name=IFormSubmitListener, method=public abstract void org.apache.wicket.markup.html.form.IFormSubmitListener.onFormSubmitted()]
2020-06-29 11:35:33,666 INFO  -> (main) [org.apache.wicket.RequestListenerInterface] registered listener interface [RequestListenerInterface name=IFormSubmitListener, method=public abstract void org.apache.wicket.markup.html.form.IFormSubmitListener.onFormSubmitted()]
2020-06-29 11:35:33,667 INFO  -> (main) [org.apache.wicket.RequestListenerInterface] registered listener interface [RequestListenerInterface name=ILinkListener, method=public abstract void org.apache.wicket.markup.html.link.ILinkListener.onLinkClicked()]
2020-06-29 11:35:33,667 INFO  -> (main) [org.apache.wicket.RequestListenerInterface] registered listener interface [RequestListenerInterface name=ILinkListener, method=public abstract void org.apache.wicket.markup.html.link.ILinkListener.onLinkClicked()]
2020-06-29 11:35:33,668 INFO  -> (main) [org.apache.wicket.RequestListenerInterface] registered listener interface [RequestListenerInterface name=IOnChangeListener, method=public abstract void org.apache.wicket.markup.html.form.IOnChangeListener.onSelectionChanged()]
2020-06-29 11:35:33,668 INFO  -> (main) [org.apache.wicket.RequestListenerInterface] registered listener interface [RequestListenerInterface name=IOnChangeListener, method=public abstract void org.apache.wicket.markup.html.form.IOnChangeListener.onSelectionChanged()]
2020-06-29 11:35:33,668 INFO  -> (main) [org.apache.wicket.RequestListenerInterface] registered listener interface [RequestListenerInterface name=IRedirectListener, method=public abstract void org.apache.wicket.IRedirectListener.onRedirect()]
2020-06-29 11:35:33,668 INFO  -> (main) [org.apache.wicket.RequestListenerInterface] registered listener interface [RequestListenerInterface name=IRedirectListener, method=public abstract void org.apache.wicket.IRedirectListener.onRedirect()]
2020-06-29 11:35:33,668 INFO  -> (main) [org.apache.wicket.RequestListenerInterface] registered listener interface [RequestListenerInterface name=IResourceListener, method=public abstract void org.apache.wicket.IResourceListener.onResourceRequested()]
2020-06-29 11:35:33,668 INFO  -> (main) [org.apache.wicket.RequestListenerInterface] registered listener interface [RequestListenerInterface name=IResourceListener, method=public abstract void org.apache.wicket.IResourceListener.onResourceRequested()]
2020-06-29 11:35:33,675 INFO  -> (main) [org.apache.wicket.RequestListenerInterface] registered listener interface [RequestListenerInterface name=IActivePageBehaviorListener, method=public abstract void org.apache.wicket.behavior.IBehaviorListener.onRequest()]
2020-06-29 11:35:33,676 INFO  -> (main) [org.apache.wicket.RequestListenerInterface] registered listener interface [RequestListenerInterface name=IActivePageBehaviorListener, method=public abstract void org.apache.wicket.behavior.IBehaviorListener.onRequest()]
2020-06-29 11:35:33,676 INFO  -> (main) [org.apache.wicket.Application] [WicketApplication] init: Wicket core library initializer
2020-06-29 11:35:33,676 INFO  -> (main) [org.apache.wicket.RequestListenerInterface] registered listener interface [RequestListenerInterface name=IBehaviorListener, method=public abstract void org.apache.wicket.behavior.IBehaviorListener.onRequest()]
2020-06-29 11:35:33,676 INFO  -> (main) [org.apache.wicket.RequestListenerInterface] registered listener interface [RequestListenerInterface name=IFormSubmitListener, method=public abstract void org.apache.wicket.markup.html.form.IFormSubmitListener.onFormSubmitted()]
2020-06-29 11:35:33,676 INFO  -> (main) [org.apache.wicket.RequestListenerInterface] registered listener interface [RequestListenerInterface name=ILinkListener, method=public abstract void org.apache.wicket.markup.html.link.ILinkListener.onLinkClicked()]
2020-06-29 11:35:33,676 INFO  -> (main) [org.apache.wicket.RequestListenerInterface] registered listener interface [RequestListenerInterface name=IOnChangeListener, method=public abstract void org.apache.wicket.markup.html.form.IOnChangeListener.onSelectionChanged()]
2020-06-29 11:35:33,676 INFO  -> (main) [org.apache.wicket.RequestListenerInterface] registered listener interface [RequestListenerInterface name=IRedirectListener, method=public abstract void org.apache.wicket.IRedirectListener.onRedirect()]
2020-06-29 11:35:33,676 INFO  -> (main) [org.apache.wicket.RequestListenerInterface] registered listener interface [RequestListenerInterface name=IResourceListener, method=public abstract void org.apache.wicket.IResourceListener.onResourceRequested()]
2020-06-29 11:35:33,676 INFO  -> (main) [org.apache.wicket.RequestListenerInterface] registered listener interface [RequestListenerInterface name=IActivePageBehaviorListener, method=public abstract void org.apache.wicket.behavior.IBehaviorListener.onRequest()]
2020-06-29 11:35:33,676 INFO  -> (main) [org.apache.wicket.protocol.http.WebApplication] [WicketApplication] Started Wicket version 1.4.22 in deployment mode
2020-06-29 11:35:34,097 INFO  -> (main) [org.jboss.deployment.EARDeployer] Started J2EE application: file:/var/lib/bahmni/dcm4chee-2.18.1-psql/server/default/deploy/dcm4chee-web-ear-3.0.5-psql.ear
2020-06-29 11:35:34,098 ERROR -> (main) [org.jboss.deployment.scanner.URLDeploymentScanner] Incomplete Deployment listing:

--- Incompletely deployed packages ---
org.jboss.deployment.DeploymentInfo@227cf6f8 { url=file:/var/lib/bahmni/dcm4chee-2.18.1-psql/server/default/deploy/dcm4chee-wado-service.xml }
  deployer: org.jboss.deployment.SARDeployer@4b63a472
  status: Deployment FAILED reason: - nested throwable: (java.lang.reflect.InvocationTargetException)
  state: FAILED
  watch: file:/var/lib/bahmni/dcm4chee-2.18.1-psql/server/default/deploy/dcm4chee-wado-service.xml
  altDD: null
  lastDeployed: 1593408873515
  lastModified: 1593408873000
  mbeans:


2020-06-29 11:35:34,586 INFO  -> (main) [org.apache.coyote.http11.Http11Protocol] Starting Coyote HTTP/1.1 on http-0.0.0.0-8055
2020-06-29 11:35:34,615 INFO  -> (main) [org.apache.coyote.http11.Http11Protocol] Starting Coyote HTTP/1.1 on http-8443
2020-06-29 11:35:34,641 INFO  -> (main) [org.apache.coyote.ajp.AjpProtocol] Starting Coyote AJP/1.3 on ajp-0.0.0.0-8056
2020-06-29 11:35:34,653 INFO  -> (main) [org.dcm4cheri.server.ServerImpl] Start Server listening on 0.0.0.0:11112
2020-06-29 11:35:34,681 INFO  -> (main) [org.dcm4cheri.server.ServerImpl] Start Server listening on 0.0.0.0:2575
2020-06-29 11:35:34,683 INFO  -> (main) [org.jboss.system.server.Server] JBoss (MX MicroKernel) [4.2.3.GA (build: SVNTag=JBoss_4_2_3_GA date=200807181439)] Started in 4m:19s:251ms
2020-06-29 11:35:58,977 INFO  -> (Thread-22) [org.dcm4chex.archive.mbean.FileSystemMgt2Service] Check file system group ONLINE_STORAGE for deletion of orphaned private files
2020-06-29 11:35:58,978 INFO  -> (Thread-23) [org.dcm4chex.archive.mbean.FileSystemMgt2Service] Check file system group LOSSY_STORAGE for deletion of orphaned private files