[Solved] Web interface don't show study images

[Ramón Retamar]

Hi.
I install the dcm4chee 2.18.0 using MYSQL 5.5.35 in Debian Gnu/Linux (a clean-installation) in a test-PC.

The server gets and retrieve studies without problems from/to GinkgoCADx viewer, the web interface works fine for search and show dicom fields for the patients....but not display images in web interface: show the legend "loading" instead of image.

------------------------------------------------------------------------------------------------

When start dcm4chee, it show this error into log:

10:27:49,446 ERROR [URLDeploymentScanner] Incomplete Deployment listing:

--- Incompletely deployed packages ---
org.jboss.deployment.DeploymentInfo@c4a755d7 { url=file:/opt/dcm4chee-2.18.0-mysql/server/default/deploy/dcm4chee-wado-service.xml }
  deployer: org.jboss.deployment.SARDeployer@48082d37
  status: Deployment FAILED reason: - nested throwable: (java.lang.reflect.InvocationTargetException)
  state: FAILED
  watch: file:/opt/dcm4chee-2.18.0-mysql/server/default/deploy/dcm4chee-wado-service.xml
  altDD: null
  lastDeployed: 1398086857414
  lastModified: 1398086857000
  mbeans:

------------------------------------------------------------------------------------------

When i try to view any images from web interface, the dcm4chee show this:

10:40:10,396 ERROR [WADOServiceDelegate] Exception occured in getWADOObject: dcm4chee.archive:service=WADOService is not registered.
javax.management.InstanceNotFoundException: dcm4chee.archive:service=WADOService is not registered.
    at org.jboss.mx.server.registry.BasicMBeanRegistry.get(BasicMBeanRegistry.java:523)
    at org.jboss.mx.server.MBeanServerImpl.invoke(MBeanServerImpl.java:653)
    at org.dcm4chex.wado.web.WADOServiceDelegate.getWADOObject(WADOServiceDelegate.java:124)
    at org.dcm4chex.wado.web.WADOServlet.doGet(WADOServlet.java:114)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:690)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:803)
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:290)
    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206)
    at org.jboss.web.tomcat.filters.ReplyHeaderFilter.doFilter(ReplyHeaderFilter.java:96)
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:235)
    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206)
    at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:230)
    at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:175)
    at org.jboss.web.tomcat.security.SecurityAssociationValve.invoke(SecurityAssociationValve.java:182)
    at org.jboss.web.tomcat.security.JaccContextValve.invoke(JaccContextValve.java:84)
    at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
    at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:102)
    at org.jboss.web.tomcat.service.jca.CachedConnectionValve.invoke(CachedConnectionValve.java:157)
    at org.apache.catalina.authenticator.SingleSignOn.invoke(SingleSignOn.java:420)
    at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:109)
    at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:262)
    at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:844)
    at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:583)
    at org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:446)
    at java.lang.Thread.run(Thread.java:679)

The complete start-log is:

root@linux:/opt/dcm4chee-2.18.0-mysql/bin# ./run.sh
=========================================================================

  JBoss Bootstrap Environment

  JBOSS_HOME: /opt/dcm4chee-2.18.0-mysql

  JAVA: java

  JAVA_OPTS: -Dprogram.name=run.sh -Xms128m -Xmx512m -XX:MaxPermSize=128m -Dsun.rmi.dgc.client.gcInterval=3600000 -Dsun.rmi.dgc.server.gcInterval=3600000 -Djboss.messaging.ServerPeerID=0 -Djavax.xml.transform.TransformerFactory=com.sun.org.apache.xalan.internal.xsltc.trax.TransformerFactoryImpl -Djava.awt.headless=true -Dapp.name=dcm4chee -Djava.net.preferIPv4Stack=true -Djava.library.path=/opt/dcm4chee-2.18.0-mysql/bin/native

  CLASSPATH: /opt/dcm4chee-2.18.0-mysql/bin/run.jar

=========================================================================

11:20:44,263 INFO  [Server] Starting JBoss (MX MicroKernel)...
11:20:44,264 INFO  [Server] Release ID: JBoss [Trinity] 4.2.3.GA (build: SVNTag=JBoss_4_2_3_GA date=200807181417)
11:20:44,264 INFO  [Server] Home Dir: /opt/dcm4chee-2.18.0-mysql
11:20:44,264 INFO  [Server] Home URL: file:/opt/dcm4chee-2.18.0-mysql/
11:20:44,265 INFO  [Server] Patch URL: null
11:20:44,265 INFO  [Server] Server Name: default
11:20:44,265 INFO  [Server] Server Home Dir: /opt/dcm4chee-2.18.0-mysql/server/default
11:20:44,266 INFO  [Server] Server Home URL: file:/opt/dcm4chee-2.18.0-mysql/server/default/
11:20:44,266 INFO  [Server] Server Log Dir: /opt/dcm4chee-2.18.0-mysql/server/default/log
11:20:44,266 INFO  [Server] Server Temp Dir: /opt/dcm4chee-2.18.0-mysql/server/default/tmp
11:20:44,266 INFO  [Server] Root Deployment Filename: jboss-service.xml
11:20:44,437 INFO  [ServerInfo] Java version: 1.6.0_27,Sun Microsystems Inc.
11:20:44,437 INFO  [ServerInfo] Java VM: OpenJDK 64-Bit Server VM 20.0-b12,Sun Microsystems Inc.
11:20:44,437 INFO  [ServerInfo] OS-System: Linux 3.2.0-4-amd64,amd64
11:20:44,635 INFO  [Server] Core system initialized
11:20:46,132 INFO  [WebService] Using RMI server codebase: http://linux:8083/
11:20:46,133 INFO  [Log4jService$URLWatchTimerTask] Configuring from URL: resource:jboss-log4j.xml
11:20:46,422 INFO  [TransactionManagerService] JBossTS Transaction Service (JTA version) - JBoss Inc.
11:20:46,422 INFO  [TransactionManagerService] Setting up property manager MBean and JMX layer
11:20:46,565 INFO  [TransactionManagerService] Starting recovery manager
11:20:46,619 INFO  [TransactionManagerService] Recovery manager started
11:20:46,620 INFO  [TransactionManagerService] Binding TransactionManager JNDI Reference
11:20:47,863 INFO  [EJB3Deployer] Starting java:comp multiplexer
11:20:49,205 INFO  [NativeServerConfig] JBoss Web Services - Native
11:20:49,205 INFO  [NativeServerConfig] jbossws-3.0.1-native-2.0.4.GA (build=200803312044)
11:20:53,601 WARN  [BasicMBeanRegistry] javax.management.MBeanRegistrationException: preRegister() failed: [ObjectName='dcm4chee.archive:service=WADOService', Class=org.dcm4chex.wado.mbean.WADOService (org.dcm4chex.wado.mbean.WADOService@a32087b)]
11:20:53,602 INFO  [WADOService] Registration is not done -> stop
11:20:53,604 ERROR [MainDeployer] Could not create deployment: file:/opt/dcm4chee-2.18.0-mysql/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(DelegatingMethodAccessorImpl.java:43)
    at java.lang.reflect.Method.invoke(Method.java:616)
    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 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(DelegatingMethodAccessorImpl.java:43)
    at java.lang.reflect.Method.invoke(Method.java:616)
    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 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(DelegatingMethodAccessorImpl.java:43)
    at java.lang.reflect.Method.invoke(Method.java:616)
    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 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(DelegatingMethodAccessorImpl.java:43)
    at java.lang.reflect.Method.invoke(Method.java:616)
    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 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(NativeMethodAccessorImpl.java:57)
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
    at java.lang.reflect.Method.invoke(Method.java:616)
    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 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(Thread.java:679)
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@a32087b)]
    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(DelegatingMethodAccessorImpl.java:43)
    at java.lang.reflect.Method.invoke(Method.java:616)
    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(NativeMethodAccessorImpl.java:57)
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
    at java.lang.reflect.Method.invoke(Method.java:616)
    at org.jboss.mx.interceptor.AttributeDispatcher.invoke(AttributeDispatcher.java:136)
    ... 110 more
11:20:54,035 INFO  [Embedded] Catalina naming disabled
11:20:54,145 INFO  [AprLifecycleListener] The Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path: /opt/dcm4chee-2.18.0-mysql/bin/native
11:20:54,191 INFO  [Http11Protocol] Inicializando Coyote HTTP/1.1 en puerto http-0.0.0.0-8080
11:20:54,371 INFO  [Http11Protocol] Inicializando Coyote HTTP/1.1 en puerto http-8443
11:20:54,372 INFO  [AjpProtocol] Initializing Coyote AJP/1.3 on ajp-0.0.0.0-8009
11:20:54,372 INFO  [Catalina] Initialization processed in 337 ms
11:20:54,372 INFO  [StandardService] Arrancando servicio jboss.web
11:20:54,373 INFO  [StandardEngine] Starting Servlet Engine: JBossWeb/2.0.1.GA
11:20:54,400 INFO  [Catalina] Server startup in 27 ms
11:20:54,460 INFO  [TomcatDeployer] deploy, ctxPath=/, warUrl=.../deploy/jboss-web.deployer/ROOT.war/
11:20:54,727 INFO  [TomcatDeployer] deploy, ctxPath=/invoker, warUrl=.../deploy/http-invoker.sar/invoker.war/
11:20:54,798 INFO  [TomcatDeployer] deploy, ctxPath=/jbossws, warUrl=.../deploy/jbossws.sar/jbossws-context.war/
11:20:54,951 INFO  [TomcatDeployer] deploy, ctxPath=/web-console, warUrl=.../deploy/management/console-mgr.sar/web-console.war/
11:20:55,217 INFO  [MailService] Mail Service bound to java:/Mail
11:20:55,292 INFO  [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/jboss-ha-local-jdbc.rar
11:20:55,310 INFO  [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/jboss-ha-xa-jdbc.rar
11:20:55,326 INFO  [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/jboss-local-jdbc.rar
11:20:55,342 INFO  [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/jboss-xa-jdbc.rar
11:20:55,370 INFO  [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/jms-ra.rar
11:20:55,381 INFO  [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/quartz-ra.rar
11:20:55,386 INFO  [QuartzResourceAdapter] start quartz!!!
11:20:55,418 INFO  [SimpleThreadPool] Job execution threads will use class loader of thread: main
11:20:55,431 INFO  [QuartzScheduler] Quartz Scheduler v.1.5.2 created.
11:20:55,432 INFO  [RAMJobStore] RAMJobStore initialized.
11:20:55,432 INFO  [StdSchedulerFactory] Quartz scheduler 'DefaultQuartzScheduler' initialized from default resource file in Quartz package: 'quartz.properties'
11:20:55,432 INFO  [StdSchedulerFactory] Quartz scheduler version: 1.5.2
11:20:55,432 INFO  [QuartzScheduler] Scheduler DefaultQuartzScheduler_$_NON_CLUSTERED started.
11:20:55,519 INFO  [ConnectionFactoryBindingService] Bound ConnectionManager 'jboss.jca:service=ConnectionFactoryBinding,name=JmsXA' to JNDI name 'java:JmsXA'
11:20:55,561 INFO  [ConnectionFactoryBindingService] Bound ConnectionManager 'jboss.jca:service=DataSourceBinding,name=pacsDS' to JNDI name 'java:pacsDS'
11:20:55,841 WARN  [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.
11:20:55,990 INFO  [ServerPeer] JBoss Messaging 1.4.2.GA server [0] started
11:20:56,199 INFO  [ConnectionFactory] Connector bisocket://linux:4457 has leasing enabled, lease period 10000 milliseconds
11:20:56,200 INFO  [ConnectionFactory] org.jboss.jms.server.connectionfactory.ConnectionFactory@6d330af4 started
11:20:56,201 WARN  [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
11:20:56,201 WARN  [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
11:20:56,203 INFO  [ConnectionFactory] Connector bisocket://linux:4457 has leasing enabled, lease period 10000 milliseconds
11:20:56,203 INFO  [ConnectionFactory] org.jboss.jms.server.connectionfactory.ConnectionFactory@34e6529c started
11:20:56,204 INFO  [ConnectionFactory] Connector bisocket://linux:4457 has leasing enabled, lease period 10000 milliseconds
11:20:56,204 INFO  [ConnectionFactory] org.jboss.jms.server.connectionfactory.ConnectionFactory@666558bb started
11:20:56,214 INFO  [QueueService] Queue[/queue/DLQ] started, fullSize=200000, pageSize=2000, downCacheSize=2000
11:20:56,217 INFO  [QueueService] Queue[/queue/ExpiryQueue] started, fullSize=200000, pageSize=2000, downCacheSize=2000
11:20:56,219 INFO  [QueueService] Queue[/queue/AttributesModificationScu] started, fullSize=500, pageSize=100, downCacheSize=100
11:20:56,222 INFO  [QueueService] Queue[/queue/DeleteStudy] started, fullSize=500, pageSize=100, downCacheSize=100
11:20:56,224 INFO  [QueueService] Queue[/queue/ExportManager] started, fullSize=500, pageSize=100, downCacheSize=100
11:20:56,226 INFO  [QueueService] Queue[/queue/FileCopy] started, fullSize=500, pageSize=100, downCacheSize=100
11:20:56,231 INFO  [QueueService] Queue[/queue/FileMove] started, fullSize=500, pageSize=100, downCacheSize=100
11:20:56,234 INFO  [QueueService] Queue[/queue/HL7Send] started, fullSize=500, pageSize=100, downCacheSize=100
11:20:56,237 INFO  [QueueService] Queue[/queue/IANScu] started, fullSize=500, pageSize=100, downCacheSize=100
11:20:56,243 INFO  [QueueService] Queue[/queue/MCMScu] started, fullSize=500, pageSize=100, downCacheSize=100
11:20:56,245 INFO  [QueueService] Queue[/queue/MoveScu] started, fullSize=500, pageSize=100, downCacheSize=100
11:20:56,248 INFO  [QueueService] Queue[/queue/MPPSScu] started, fullSize=500, pageSize=100, downCacheSize=100
11:20:56,249 INFO  [QueueService] Queue[/queue/PPSExceptionMgt] started, fullSize=500, pageSize=100, downCacheSize=100
11:20:56,251 INFO  [QueueService] Queue[/queue/PPSScu] started, fullSize=500, pageSize=100, downCacheSize=100
11:20:56,253 INFO  [QueueService] Queue[/queue/Prefetch] started, fullSize=500, pageSize=100, downCacheSize=100
11:20:56,255 INFO  [QueueService] Queue[/queue/RejectionNoteStored] started, fullSize=500, pageSize=100, downCacheSize=100
11:20:56,257 INFO  [QueueService] Queue[/queue/Sendmail] started, fullSize=500, pageSize=100, downCacheSize=100
11:20:57,116 INFO  [QueueService] Queue[/queue/StgCmtScuScp] started, fullSize=500, pageSize=100, downCacheSize=100
11:20:57,119 INFO  [QueueService] Queue[/queue/StudyMgtScu] started, fullSize=500, pageSize=100, downCacheSize=100
11:20:57,123 INFO  [QueueService] Queue[/queue/UpgradeToEnhancedMF] started, fullSize=500, pageSize=100, downCacheSize=100
11:20:57,127 INFO  [QueueService] Queue[/queue/UPSScp] started, fullSize=500, pageSize=100, downCacheSize=100
11:20:57,131 INFO  [QueueService] Queue[/queue/WadoPrefetch] started, fullSize=500, pageSize=100, downCacheSize=100
11:20:57,641 INFO  [EjbModule] Deploying PrivateInstance
11:20:57,719 INFO  [EjbModule] Deploying MWLItem
11:20:57,724 INFO  [EjbModule] Deploying VerifyingObserver
11:20:57,728 INFO  [EjbModule] Deploying Device
11:20:57,732 INFO  [EjbModule] Deploying UPSRelatedPS
11:20:57,736 INFO  [EjbModule] Deploying PrivateFile
11:20:57,740 INFO  [EjbModule] Deploying Media
11:20:57,744 INFO  [EjbModule] Deploying PrivateStudy
11:20:57,749 INFO  [EjbModule] Deploying PrivatePatient
11:20:57,753 INFO  [EjbModule] Deploying Code
11:20:57,758 INFO  [EjbModule] Deploying HP
11:20:57,762 INFO  [EjbModule] Deploying MPPS
11:20:57,765 INFO  [EjbModule] Deploying Patient
11:20:57,769 INFO  [EjbModule] Deploying Instance
11:20:57,773 INFO  [EjbModule] Deploying StudyPermission
11:20:57,777 INFO  [EjbModule] Deploying AE
11:20:57,790 INFO  [EjbModule] Deploying UPSSubscription
11:20:57,795 INFO  [EjbModule] Deploying FileSystem
11:20:57,800 INFO  [EjbModule] Deploying UPSGlobalSubscription
11:20:57,804 INFO  [EjbModule] Deploying GPSPSPerformer
11:20:57,808 INFO  [EjbModule] Deploying OtherPatientID
11:20:57,817 INFO  [EjbModule] Deploying Series
11:20:57,824 INFO  [EjbModule] Deploying StudyOnFileSystem
11:20:57,829 INFO  [EjbModule] Deploying UPSRequest
11:20:57,834 INFO  [EjbModule] Deploying UPSReplacedPS
11:20:57,837 INFO  [EjbModule] Deploying File
11:20:57,853 INFO  [EjbModule] Deploying SeriesRequest
11:20:57,857 INFO  [EjbModule] Deploying HPDefinition
11:20:57,862 INFO  [EjbModule] Deploying PublishedStudy
11:20:57,867 INFO  [EjbModule] Deploying PrivateSeries
11:20:57,873 INFO  [EjbModule] Deploying GPSPSRequest
11:20:57,883 INFO  [EjbModule] Deploying UPS
11:20:57,888 INFO  [EjbModule] Deploying GPSPS
11:20:57,891 INFO  [EjbModule] Deploying ContentItem
11:20:57,895 INFO  [EjbModule] Deploying Study
11:20:57,899 INFO  [EjbModule] Deploying GPPPS
11:20:57,906 INFO  [EjbModule] Deploying Issuer
11:20:57,912 INFO  [EjbModule] Deploying GPPPSManager
11:20:57,928 INFO  [EjbModule] Deploying GPWLManager
11:20:57,932 INFO  [EjbModule] Deploying StudyMgt
11:20:57,939 INFO  [EjbModule] Deploying PIXQuery
11:20:57,944 INFO  [EjbModule] Deploying UpdateAttributes
11:20:57,948 INFO  [EjbModule] Deploying HPStorage
11:20:57,952 INFO  [EjbModule] Deploying MWLManager
11:20:57,957 INFO  [EjbModule] Deploying UPSManager
11:20:57,960 INFO  [EjbModule] Deploying AvailabilityUpdate
11:20:57,966 INFO  [EjbModule] Deploying ConsistencyCheck
11:20:57,973 INFO  [EjbModule] Deploying StudyPermissionManager
11:20:57,977 INFO  [EjbModule] Deploying UserManager
11:20:57,982 INFO  [EjbModule] Deploying MPPSManager
11:20:57,985 INFO  [EjbModule] Deploying MediaComposer
11:20:57,989 INFO  [EjbModule] Deploying ContentEdit
11:20:57,993 INFO  [EjbModule] Deploying ContentManager
11:20:58,000 INFO  [EjbModule] Deploying SoundexUpdate
11:20:58,007 INFO  [EjbModule] Deploying PrivateManager
11:20:58,011 INFO  [EjbModule] Deploying StudyReconciliation
11:20:58,015 INFO  [EjbModule] Deploying CodeToDeviceMapping
11:20:58,018 INFO  [EjbModule] Deploying MPPSEmulator
11:20:58,022 INFO  [EjbModule] Deploying AttributesModification
11:20:58,027 INFO  [EjbModule] Deploying PatientUpdate
11:20:58,034 INFO  [EjbModule] Deploying FixPatientAttributes
11:20:58,039 INFO  [EjbModule] Deploying FileSystemMgt2
11:20:58,044 INFO  [EjbModule] Deploying Storage
11:20:58,047 INFO  [EjbModule] Deploying AEManager
11:20:59,344 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'PrivateInstance' to jndi 'ejb/PrivateInstance'
11:20:59,348 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'MWLItem' to jndi 'ejb/MWLItem'
11:20:59,352 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'VerifyingObserver' to jndi 'ejb/VerifyingObserver'
11:20:59,355 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'Device' to jndi 'ejb/Device'
11:20:59,358 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'UPSRelatedPS' to jndi 'ejb/UPSRelatedPS'
11:20:59,362 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'PrivateFile' to jndi 'ejb/PrivateFile'
11:20:59,366 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'Media' to jndi 'ejb/Media'
11:20:59,369 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'PrivateStudy' to jndi 'ejb/PrivateStudy'
11:20:59,375 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'PrivatePatient' to jndi 'ejb/PrivatePatient'
11:20:59,381 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'Code' to jndi 'ejb/Code'
11:20:59,391 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'HP' to jndi 'ejb/HP'
11:20:59,396 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'MPPS' to jndi 'ejb/MPPS'
11:20:59,402 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'Patient' to jndi 'ejb/Patient'
11:20:59,412 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'Instance' to jndi 'ejb/Instance'
11:20:59,416 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'StudyPermission' to jndi 'ejb/StudyPermission'
11:20:59,424 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'AE' to jndi 'ejb/AE'
11:20:59,429 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'UPSSubscription' to jndi 'ejb/UPSSubscription'
11:20:59,434 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'FileSystem' to jndi 'ejb/FileSystem'
11:20:59,441 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'UPSGlobalSubscription' to jndi 'ejb/UPSGlobalSubscription'
11:20:59,447 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'GPSPSPerformer' to jndi 'ejb/GPSPSPerformer'
11:20:59,450 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'OtherPatientID' to jndi 'ejb/OtherPatientID'
11:20:59,456 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'Series' to jndi 'ejb/Series'
11:20:59,459 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'StudyOnFileSystem' to jndi 'ejb/StudyOnFileSystem'
11:20:59,462 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'UPSRequest' to jndi 'ejb/UPSRequest'
11:20:59,465 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'UPSReplacedPS' to jndi 'ejb/UPSReplacedPS'
11:20:59,470 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'File' to jndi 'ejb/File'
11:20:59,474 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'SeriesRequest' to jndi 'ejb/SeriesRequest'
11:20:59,478 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'HPDefinition' to jndi 'ejb/HPDefinition'
11:20:59,481 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'PublishedStudy' to jndi 'ejb/PublishedStudy'
11:20:59,484 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'PrivateSeries' to jndi 'ejb/PrivateSeries'
11:20:59,487 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'GPSPSRequest' to jndi 'ejb/GPSPSRequest'
11:20:59,491 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'UPS' to jndi 'ejb/UPS'
11:20:59,496 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'GPSPS' to jndi 'ejb/GPSPS'
11:20:59,499 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'ContentItem' to jndi 'ejb/ContentItem'
11:20:59,506 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'Study' to jndi 'ejb/Study'
11:20:59,512 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'GPPPS' to jndi 'ejb/GPPPS'
11:20:59,515 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'Issuer' to jndi 'ejb/Issuer'
11:20:59,524 INFO  [ProxyFactory] Bound EJB Home 'GPPPSManager' to jndi 'ejb/GPPPSManager'
11:20:59,530 INFO  [ProxyFactory] Bound EJB Home 'GPWLManager' to jndi 'ejb/GPWLManager'
11:20:59,537 INFO  [ProxyFactory] Bound EJB Home 'StudyMgt' to jndi 'ejb/StudyMgt'
11:20:59,543 INFO  [ProxyFactory] Bound EJB Home 'PIXQuery' to jndi 'ejb/PIXQuery'
11:20:59,548 INFO  [ProxyFactory] Bound EJB Home 'UpdateAttributes' to jndi 'ejb/UpdateAttributes'
11:20:59,553 INFO  [ProxyFactory] Bound EJB Home 'HPStorage' to jndi 'ejb/HPStorage'
11:20:59,561 INFO  [ProxyFactory] Bound EJB Home 'MWLManager' to jndi 'ejb/MWLManager'
11:20:59,571 INFO  [ProxyFactory] Bound EJB Home 'UPSManager' to jndi 'ejb/UPSManager'
11:20:59,577 INFO  [ProxyFactory] Bound EJB Home 'AvailabilityUpdate' to jndi 'ejb/AvailabilityUpdate'
11:20:59,583 INFO  [ProxyFactory] Bound EJB Home 'ConsistencyCheck' to jndi 'ejb/ConsistencyCheck'
11:20:59,595 INFO  [ProxyFactory] Bound EJB Home 'StudyPermissionManager' to jndi 'ejb/StudyPermissionManager'
11:20:59,605 INFO  [ProxyFactory] Bound EJB Home 'UserManager' to jndi 'ejb/UserManager'
11:20:59,613 INFO  [ProxyFactory] Bound EJB Home 'MPPSManager' to jndi 'ejb/MPPSManager'
11:20:59,623 INFO  [ProxyFactory] Bound EJB Home 'MediaComposer' to jndi 'ejb/MediaComposer'
11:20:59,638 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'ContentEdit' to jndi 'ContentEditLocal'
11:20:59,643 INFO  [ProxyFactory] Bound EJB Home 'ContentEdit' to jndi 'ejb/ContentEdit'
11:20:59,656 INFO  [ProxyFactory] Bound EJB Home 'ContentManager' to jndi 'ejb/ContentManager'
11:20:59,663 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'SoundexUpdate' to jndi 'SoundexUpdateLocal'
11:20:59,668 INFO  [ProxyFactory] Bound EJB Home 'SoundexUpdate' to jndi 'ejb/SoundexUpdate'
11:20:59,675 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'PrivateManager' to jndi 'PrivateManagerLocal'
11:20:59,680 INFO  [ProxyFactory] Bound EJB Home 'PrivateManager' to jndi 'ejb/PrivateManager'
11:20:59,692 INFO  [ProxyFactory] Bound EJB Home 'StudyReconciliation' to jndi 'ejb/StudyReconciliation'
11:20:59,698 INFO  [ProxyFactory] Bound EJB Home 'CodeToDeviceMapping' to jndi 'ejb/CodeToDeviceMapping'
11:20:59,704 INFO  [ProxyFactory] Bound EJB Home 'MPPSEmulator' to jndi 'ejb/MPPSEmulator'
11:20:59,710 INFO  [ProxyFactory] Bound EJB Home 'AttributesModification' to jndi 'ejb/AttributesModification'
11:20:59,718 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'PatientUpdate' to jndi 'PatientUpdateLocal'
11:20:59,725 INFO  [ProxyFactory] Bound EJB Home 'PatientUpdate' to jndi 'ejb/PatientUpdate'
11:20:59,739 INFO  [ProxyFactory] Bound EJB Home 'FixPatientAttributes' to jndi 'ejb/FixPatientAttributes'
11:20:59,749 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'FileSystemMgt2' to jndi 'FileSystemMgt2Local'
11:20:59,758 INFO  [ProxyFactory] Bound EJB Home 'FileSystemMgt2' to jndi 'ejb/FileSystemMgt2'
11:20:59,774 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'Storage' to jndi 'StorageLocal'
11:20:59,780 INFO  [ProxyFactory] Bound EJB Home 'Storage' to jndi 'ejb/Storage'
11:20:59,786 INFO  [ProxyFactory] Bound EJB Home 'AEManager' to jndi 'ejb/AEManager'
11:20:59,857 INFO  [SchedulerService] Start Scheduler CheckPendingSeriesStored with period of 60000ms in 1 s.
11:20:59,864 INFO  [SchedulerService] Start Scheduler DeleteOrphanedPrivateFiles with period of 60000ms in 1 s.
11:20:59,864 INFO  [SchedulerService] Start Scheduler DeleteOrphanedPrivateFiles with period of 60000ms in 1 s.
11:20:59,900 INFO  [EJBDeployer] Deployed: file:/opt/dcm4chee-2.18.0-mysql/server/default/deploy/dcm4chee-ejb-mysql.jar
11:20:59,966 INFO  [TomcatDeployer] deploy, ctxPath=/rid, warUrl=.../tmp/deploy/tmp1007826411059615588dcm4chee-rid-exp.war/
11:21:00,012 INFO  [RIDServiceDelegate] RIDServiceDelegate initialized
11:21:00,013 INFO  [RIDServiceDelegate] RIDServiceDelegate initialized
11:21:00,036 INFO  [TomcatDeployer] deploy, ctxPath=/wado, warUrl=.../tmp/deploy/tmp1112543463724938017dcm4chee-wado-exp.war/
11:21:00,095 INFO  [TomcatDeployer] deploy, ctxPath=/jmx-console, warUrl=.../deploy/jmx-console.war/
11:21:00,192 INFO  [EARDeployer] Init J2EE application: file:/opt/dcm4chee-2.18.0-mysql/server/default/deploy/dcm4chee-web-ear-3.0.4-mysql.ear
11:21:00,882 INFO  [FileSystemMgt2Service] Check file system group LOSSY_STORAGE for deletion of orphaned private files
11:21:00,882 INFO  [FileSystemMgt2Service] Check file system group ONLINE_STORAGE for deletion of orphaned private files
11:21:01,356 INFO  [EchoService] SCU Devicename:EchoService
11:21:01,453 INFO  [IANScuService] SCU Devicename:IANScuService
11:21:01,493 INFO  [AttributesModificationScuService] SCU Devicename:AttributesModificationScuService
11:21:01,528 INFO  [MoveScuService] SCU Devicename:MoveScuService
11:21:01,557 INFO  [MppsForwardService] SCU Devicename:MppsForwardService
11:21:01,570 INFO  [MwlScuService] SCU Devicename:MwlScuService
11:21:01,613 INFO  [RejectionNoteScuService] SCU Devicename:RejectionNoteScuService
11:21:01,642 INFO  [StoreScuService] SCU Devicename:StoreScuService
11:21:01,925 INFO  [QueueService] Queue[/queue/HL7SendV2] started, fullSize=200000, pageSize=2000, downCacheSize=2000
11:21:01,930 INFO  [QueueService] Queue[/queue/IANSCU_web] started, fullSize=200000, pageSize=2000, downCacheSize=2000
11:21:01,935 INFO  [QueueService] Queue[/queue/AttributesModification_web] started, fullSize=200000, pageSize=2000, downCacheSize=2000
11:21:01,940 INFO  [QueueService] Queue[/queue/MoveScu_web] started, fullSize=200000, pageSize=2000, downCacheSize=2000
11:21:01,948 INFO  [QueueService] Queue[/queue/RejectionNoteSCU] started, fullSize=200000, pageSize=2000, downCacheSize=2000
11:21:01,954 INFO  [QueueService] Queue[/queue/TCStoreScu] started, fullSize=200000, pageSize=2000, downCacheSize=2000
11:21:01,986 INFO  [JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.entity.PersistenceUnitDeployment
11:21:01,989 INFO  [JmxKernelAbstraction] installing MBean: persistence.units:ear=dcm4chee-web-ear-3.0.4-mysql.ear,unitName=dcm4chee-arc with dependencies:
11:21:01,990 INFO  [JmxKernelAbstraction]     jboss.jca:name=pacsDS,service=DataSourceBinding
11:21:01,991 INFO  [PersistenceUnitDeployment] Starting persistence unit persistence.units:ear=dcm4chee-web-ear-3.0.4-mysql.ear,unitName=dcm4chee-arc
11:21:02,010 INFO  [Version] Hibernate EntityManager 3.2.1.GA
11:21:02,025 INFO  [Version] Hibernate Annotations 3.2.1.GA
11:21:02,031 INFO  [Environment] Hibernate 3.2.4.sp1
11:21:02,036 INFO  [Environment] hibernate.properties not found
11:21:02,038 INFO  [Environment] Bytecode provider name : javassist
11:21:02,041 INFO  [Environment] using JDK 1.4 java.sql.Timestamp handling
11:21:02,129 INFO  [Ejb3Configuration] Processing PersistenceUnitInfo [
    name: dcm4chee-arc
    ...]
11:21:02,144 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.AE
11:21:02,147 INFO  [Ejb3Configuration] found EJB3 @MappedSuperclass: org.dcm4chee.archive.entity.BaseEntity
11:21:02,148 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.Code
11:21:02,149 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.ContentItem
11:21:02,150 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.Device
11:21:02,151 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.File
11:21:02,152 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.FileSystem
11:21:02,153 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.GPPPS
11:21:02,158 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.GPSPS
11:21:02,161 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.GPSPSPerformer
11:21:02,163 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.GPSPSRequest
11:21:02,164 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.HangingProtocol
11:21:02,165 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.HPDefinition
11:21:02,170 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.Instance
11:21:02,171 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.Issuer
11:21:02,172 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.Media
11:21:02,173 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.MPPS
11:21:02,174 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.MWLItem
11:21:02,175 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.OtherPatientID
11:21:02,178 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.Patient
11:21:02,179 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.PrivateFile
11:21:02,180 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.PrivateInstance
11:21:02,181 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.PrivatePatient
11:21:02,181 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.PrivateSeries
11:21:02,182 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.PrivateStudy
11:21:02,183 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.PublishedStudy
11:21:02,184 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.RequestAttributes
11:21:02,188 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.Series
11:21:02,192 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.Study
11:21:02,192 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.StudyOnFileSystem
11:21:02,193 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.StudyPermission
11:21:02,197 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.UPS
11:21:02,198 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.UPSRelatedPS
11:21:02,199 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.UPSReplacedPS
11:21:02,200 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.UPSRequest
11:21:02,200 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.UPSSubscription
11:21:02,201 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.VerifyingObserver
11:21:02,241 INFO  [Configuration] Reading mappings from resource : META-INF/orm.xml
11:21:02,314 INFO  [Ejb3Configuration] [PersistenceUnit: dcm4chee-arc] META-INF/orm.xml found
11:21:02,397 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.AE
11:21:02,404 INFO  [QueryBinder] Binding Named query: AE.findByTitle => select ae from AE ae where title = :title
11:21:02,432 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.AE on table ae
11:21:02,470 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Code
11:21:02,470 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.Code on table code
11:21:02,475 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.ContentItem
11:21:02,476 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.ContentItem on table content_item
11:21:02,486 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Device
11:21:02,486 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.Device on table device
11:21:02,511 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.File
11:21:02,511 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.File on table files
11:21:02,514 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.FileSystem
11:21:02,514 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.FileSystem on table filesystem
11:21:02,527 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.GPPPS
11:21:02,527 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.GPPPS on table gppps
11:21:02,535 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.GPSPS
11:21:02,535 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.GPSPS on table gpsps
11:21:02,548 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.GPSPSPerformer
11:21:02,548 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.GPSPSPerformer on table gpsps_perf
11:21:02,551 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.GPSPSRequest
11:21:02,552 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.GPSPSRequest on table gpsps_req
11:21:02,553 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.HangingProtocol
11:21:02,554 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.HangingProtocol on table hp
11:21:02,559 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.HPDefinition
11:21:02,559 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.HPDefinition on table hpdef
11:21:02,562 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Instance
11:21:02,562 INFO  [QueryBinder] Binding Named query: Instance.findByIUID => select object(i) from Instance i where sopInstanceUID = :iuid
11:21:02,563 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.Instance on table instance
11:21:02,574 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Issuer
11:21:02,574 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.Issuer on table issuer
11:21:02,575 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Media
11:21:02,575 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.Media on table media
11:21:02,578 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.MPPS
11:21:02,578 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.MPPS on table mpps
11:21:02,583 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.MWLItem
11:21:02,584 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.MWLItem on table mwl_item
11:21:02,593 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.OtherPatientID
11:21:02,593 INFO  [QueryBinder] Binding Named query: OtherPatientID.findByPatientIdAndIssuer => select opid from OtherPatientID opid where patientID = :pid and issuerOfPatientID = :issuer
11:21:02,593 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.OtherPatientID on table other_pid
11:21:02,595 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Patient
11:21:02,595 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.Patient on table patient
11:21:02,606 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.PrivateFile
11:21:02,606 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.PrivateFile on table priv_file
11:21:02,608 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.PrivateInstance
11:21:02,608 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.PrivateInstance on table priv_instance
11:21:02,611 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.PrivatePatient
11:21:02,611 INFO  [QueryBinder] Binding Named query: PrivatePatient.findByIdAndIssuer => select object(p) from PrivatePatient p where patientID = :patId and issuerOfPatientID = :issuer
11:21:02,611 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.PrivatePatient on table priv_patient
11:21:02,614 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.PrivateSeries
11:21:02,614 INFO  [QueryBinder] Binding Named query: PrivateSeries.findByIUID => select object(pi) from PrivateSeries pi where seriesInstanceUID = :iuid
11:21:02,614 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.PrivateSeries on table priv_series
11:21:02,617 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.PrivateStudy
11:21:02,617 INFO  [QueryBinder] Binding Named query: PrivateStudy.findByIUID => select object(ps) from PrivateStudy ps where studyInstanceUID = :iuid
11:21:02,617 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.PrivateStudy on table priv_study
11:21:02,620 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.PublishedStudy
11:21:02,620 INFO  [QueryBinder] Binding Named query: PublishedStudy.findByStudyPkAndStatus => select object(s) from PublishedStudy s where s.study.pk = :studyPk and s.status = :status
11:21:02,621 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.PublishedStudy on table published_study
11:21:02,624 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.RequestAttributes
11:21:02,624 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.RequestAttributes on table series_req
11:21:02,628 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Series
11:21:02,628 INFO  [QueryBinder] Binding Named query: Series.findByIUID => select object(s) from Series s where seriesInstanceUID = :iuid
11:21:02,628 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.Series on table series
11:21:02,639 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Study
11:21:02,639 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.Study on table study
11:21:02,653 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.StudyOnFileSystem
11:21:02,653 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.StudyOnFileSystem on table study_on_fs
11:21:02,656 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.StudyPermission
11:21:02,657 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.StudyPermission on table study_permission
11:21:02,658 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.UPS
11:21:02,659 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.UPS on table ups
11:21:02,669 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.UPSRelatedPS
11:21:02,669 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.UPSRelatedPS on table ups_rel_ps
11:21:02,671 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.UPSReplacedPS
11:21:02,672 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.UPSReplacedPS on table ups_repl_ps
11:21:02,674 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.UPSRequest
11:21:02,675 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.UPSRequest on table ups_req
11:21:02,677 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.UPSSubscription
11:21:02,678 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.UPSSubscription on table ups_subscr
11:21:02,679 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.VerifyingObserver
11:21:02,680 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.VerifyingObserver on table verify_observer
11:21:02,770 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.GPSPS.referencedRequests -> gpsps_req
11:21:02,771 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.GPSPS.scheduledHumanPerformers -> gpsps_perf
11:21:02,771 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.HangingProtocol.definitions -> hpdef
11:21:02,771 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Instance.verifyingObservers -> verify_observer
11:21:02,771 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Instance.files -> files
11:21:02,771 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Instance.contentItems -> content_item
11:21:02,771 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Media.instances -> instance
11:21:02,771 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.MPPS.series -> series
11:21:02,771 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.previous -> patient
11:21:02,772 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.studies -> study
11:21:02,772 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.modalityWorklistItems -> mwl_item
11:21:02,772 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.modalityPerformedProcedureSteps -> mpps
11:21:02,772 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.generalPurposeScheduledProcedureSteps -> gpsps
11:21:02,772 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.generalPurposePerformedProcedureSteps -> gppps
11:21:02,772 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.unifiedProcedureSteps -> ups
11:21:02,772 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.PrivateInstance.files -> priv_file
11:21:02,772 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.PrivatePatient.studies -> priv_study
11:21:02,773 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.PrivateSeries.instances -> priv_instance
11:21:02,773 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.PrivateStudy.series -> priv_series
11:21:02,773 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Series.requestAttributes -> series_req
11:21:02,773 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Series.instances -> instance
11:21:02,773 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Study.series -> series
11:21:02,773 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.UPS.refRequests -> ups_req
11:21:02,773 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.UPS.relatedProcedureSteps -> ups_rel_ps
11:21:02,773 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.UPS.replacedProcedureSteps -> ups_repl_ps
11:21:02,773 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.UPS.subscriptions -> ups_subscr
11:21:02,952 INFO  [ConnectionProviderFactory] Initializing connection provider: org.hibernate.ejb.connection.InjectedDataSourceConnectionProvider
11:21:02,955 INFO  [InjectedDataSourceConnectionProvider] Using provided datasource
11:21:02,956 INFO  [SettingsFactory] RDBMS: MySQL, version: 5.5.35-0+wheezy1
11:21:02,956 INFO  [SettingsFactory] JDBC driver: MySQL-AB JDBC Driver, version: mysql-connector-java-5.0.5 ( $Date: 2007-03-01 00:01:06 +0100 (Thu, 01 Mar 2007) $, $Revision: 6329 $ )
11:21:02,972 INFO  [Dialect] Using dialect: org.hibernate.dialect.MySQLInnoDBDialect
11:21:02,976 INFO  [TransactionFactoryFactory] Transaction strategy: org.hibernate.ejb.transaction.JoinableCMTTransactionFactory
11:21:02,978 INFO  [TransactionManagerLookupFactory] instantiating TransactionManagerLookup: org.hibernate.transaction.JBossTransactionManagerLookup
11:21:02,980 INFO  [TransactionManagerLookupFactory] instantiated TransactionManagerLookup
11:21:02,980 INFO  [SettingsFactory] Automatic flush during beforeCompletion(): disabled
11:21:02,981 INFO  [SettingsFactory] Automatic session close at end of transaction: disabled
11:21:02,981 INFO  [SettingsFactory] JDBC batch size: 15
11:21:02,981 INFO  [SettingsFactory] JDBC batch updates for versioned data: disabled
11:21:02,982 INFO  [SettingsFactory] Scrollable result sets: enabled
11:21:02,982 INFO  [SettingsFactory] JDBC3 getGeneratedKeys(): disabled
11:21:02,982 INFO  [SettingsFactory] JDBC result set fetch size: 50
11:21:02,982 INFO  [SettingsFactory] Connection release mode: auto
11:21:02,983 INFO  [SettingsFactory] Maximum outer join fetch depth: 2
11:21:02,983 INFO  [SettingsFactory] Default batch fetch size: 1
11:21:02,983 INFO  [SettingsFactory] Generate SQL with comments: disabled
11:21:02,983 INFO  [SettingsFactory] Order SQL updates by primary key: disabled
11:21:02,984 INFO  [SettingsFactory] Order SQL inserts for batching: disabled
11:21:02,984 INFO  [SettingsFactory] Query translator: org.hibernate.hql.ast.ASTQueryTranslatorFactory
11:21:02,986 INFO  [ASTQueryTranslatorFactory] Using ASTQueryTranslatorFactory
11:21:02,986 INFO  [SettingsFactory] Query language substitutions: {}
11:21:02,986 INFO  [SettingsFactory] JPA-QL strict compliance: enabled
11:21:02,986 INFO  [SettingsFactory] Second-level cache: enabled
11:21:02,987 INFO  [SettingsFactory] Query cache: disabled
11:21:02,987 INFO  [SettingsFactory] Cache provider: org.hibernate.cache.HashtableCacheProvider
11:21:02,988 INFO  [SettingsFactory] Optimize cache for minimal puts: disabled
11:21:02,989 INFO  [SettingsFactory] Cache region prefix: dcm4chee-web-ear-3_0_4-mysql_ear,dcm4chee-arc
11:21:02,989 INFO  [SettingsFactory] Structured second-level cache entries: disabled
11:21:02,994 INFO  [SettingsFactory] Statistics: disabled
11:21:02,994 INFO  [SettingsFactory] Deleted entity synthetic identifier rollback: disabled
11:21:02,995 INFO  [SettingsFactory] Default entity-mode: pojo
11:21:02,995 INFO  [SettingsFactory] Named query checking : enabled
11:21:03,038 INFO  [SessionFactoryImpl] building session factory
11:21:03,386 INFO  [SessionFactoryObjectFactory] Factory name: persistence.units:ear=dcm4chee-web-ear-3.0.4-mysql.ear,unitName=dcm4chee-arc
11:21:03,387 INFO  [NamingHelper] JNDI InitialContext properties:{java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces}
11:21:03,390 INFO  [SessionFactoryObjectFactory] Bound factory to JNDI name: persistence.units:ear=dcm4chee-web-ear-3.0.4-mysql.ear,unitName=dcm4chee-arc
11:21:03,390 WARN  [SessionFactoryObjectFactory] InitialContext did not implement EventContext
11:21:03,393 INFO  [SchemaValidator] Running schema validator
11:21:03,393 INFO  [SchemaValidator] fetching database metadata
11:21:03,417 INFO  [TableMetadata] table found: pacsdb.ae
11:21:03,417 INFO  [TableMetadata] columns: [port, station_name, passwd, installed, department, wado_url, hostname, fs_group_id, ae_desc, cipher_suites, acc_no_issuer, vendor_data, aet, user_id, pat_id_issuer, ae_group, institution, pk]
11:21:03,419 INFO  [TableMetadata] table found: pacsdb.code
11:21:03,419 INFO  [TableMetadata] columns: [code_version, code_designator, code_value, code_meaning, pk]
11:21:03,421 INFO  [TableMetadata] table found: pacsdb.content_item
11:21:03,421 INFO  [TableMetadata] columns: [name_fk, text_value, rel_type, instance_fk, code_fk, pk]
11:21:03,424 INFO  [TableMetadata] table found: pacsdb.device
11:21:03,424 INFO  [TableMetadata] columns: [station_name, modality, station_aet, pk]
11:21:03,426 INFO  [TableMetadata] table found: pacsdb.files
11:21:03,426 INFO  [TableMetadata] columns: [filepath, file_status, file_size, md5_check_time, created_time, filesystem_fk, instance_fk, file_tsuid, file_md5, pk]
11:21:03,428 INFO  [TableMetadata] table found: pacsdb.filesystem
11:21:03,428 INFO  [TableMetadata] columns: [user_info, retrieve_aet, fs_status, fs_group_id, dirpath, next_fk, availability, pk]
11:21:03,431 INFO  [TableMetadata] table found: pacsdb.gppps
11:21:03,431 INFO  [TableMetadata] columns: [pps_attrs, pps_iuid, patient_fk, pps_status, pps_start, created_time, updated_time, pk]
11:21:03,435 INFO  [TableMetadata] table found: pacsdb.gpsps
11:21:03,435 INFO  [TableMetadata] columns: [gpsps_prior, gpsps_tuid, gpsps_status, end_datetime, in_availability, item_attrs, patient_fk, gpsps_iuid, code_fk, start_datetime, pk]
11:21:03,438 INFO  [TableMetadata] table found: pacsdb.gpsps_perf
11:21:03,438 INFO  [TableMetadata] columns: [hum_perf_p_name, hum_perf_gn_sx, gpsps_fk, human_perf_name, hum_perf_i_name, hum_perf_fn_sx, code_fk, pk]
11:21:03,441 INFO  [TableMetadata] table found: pacsdb.gpsps_req
11:21:03,441 INFO  [TableMetadata] columns: [req_proc_id, gpsps_fk, accession_no, pk]
11:21:03,445 INFO  [TableMetadata] table found: pacsdb.hp
11:21:03,445 INFO  [TableMetadata] columns: [user_fk, num_priors, hp_iuid, num_screens, hp_level, hp_attrs, hp_group, hp_cuid, hp_name, pk]
11:21:03,448 INFO  [TableMetadata] table found: pacsdb.hpdef
11:21:03,449 INFO  [TableMetadata] columns: [hp_fk, laterality, modality, pk]
11:21:03,456 INFO  [TableMetadata] table found: pacsdb.instance
11:21:03,456 INFO  [TableMetadata] columns: [inst_attrs, commitment, all_attrs, content_datetime, series_fk, inst_custom1, retrieve_aets, inst_custom2, inst_no, inst_custom3, updated_time, srcode_fk, sr_verified, sop_cuid, sr_complete, archived, sop_iuid, ext_retr_aet, inst_status, media_fk, created_time, availability, pk]
11:21:03,460 INFO  [TableMetadata] table found: pacsdb.issuer
11:21:03,460 INFO  [TableMetadata] columns: [entity_uid_type, entity_id, entity_uid, pk]
11:21:03,464 INFO  [TableMetadata] table found: pacsdb.media
11:21:03,465 INFO  [TableMetadata] columns: [media_status_info, media_rq_iuid, media_status, fileset_id, fileset_iuid, created_time, media_usage, updated_time, pk]
11:21:03,469 INFO  [TableMetadata] table found: pacsdb.mpps
11:21:03,470 INFO  [TableMetadata] columns: [mpps_attrs, drcode_fk, patient_fk, modality, pps_start, created_time, mpps_status, updated_time, accession_no, mpps_iuid, station_aet, pk]
11:21:03,476 INFO  [TableMetadata] table found: pacsdb.mwl_item
11:21:03,476 INFO  [TableMetadata] columns: [req_proc_id, sps_status, sps_id, station_name, study_iuid, perf_physician, perf_phys_fn_sx, perf_phys_gn_sx, updated_time, start_datetime, station_aet, perf_phys_i_name, perf_phys_p_name, item_attrs, patient_fk, modality, created_time, accession_no, pk]
11:21:03,480 INFO  [TableMetadata] table found: pacsdb.other_pid
11:21:03,480 INFO  [TableMetadata] columns: [pat_id, pat_id_issuer, pk]
11:21:03,485 INFO  [TableMetadata] table found: pacsdb.patient
11:21:03,485 INFO  [TableMetadata] columns: [merge_fk, pat_custom2, pat_fn_sx, pat_custom1, pat_custom3, pat_sex, pat_attrs, pat_p_name, updated_time, pat_gn_sx, pat_i_name, pat_birthdate, pat_id, pat_id_issuer, created_time, pat_name, pk]
11:21:03,489 INFO  [TableMetadata] table found: pacsdb.priv_file
11:21:03,490 INFO  [TableMetadata] columns: [filepath, file_status, file_size, filesystem_fk, instance_fk, file_tsuid, file_md5, pk]
11:21:03,493 INFO  [TableMetadata] table found: pacsdb.priv_instance
11:21:03,493 INFO  [TableMetadata] columns: [inst_attrs, priv_type, series_fk, sop_iuid, created_time, pk]
11:21:03,497 INFO  [TableMetadata] table found: pacsdb.priv_patient
11:21:03,497 INFO  [TableMetadata] columns: [priv_type, pat_id, pat_attrs, pat_id_issuer, pat_name, pk]
11:21:03,500 INFO  [TableMetadata] table found: pacsdb.priv_series
11:21:03,500 INFO  [TableMetadata] columns: [priv_type, src_aet, study_fk, series_attrs, series_iuid, pk]
11:21:03,504 INFO  [TableMetadata] table found: pacsdb.priv_study
11:21:03,504 INFO  [TableMetadata] columns: [priv_type, study_iuid, patient_fk, study_attrs, accession_no, pk]
11:21:03,507 INFO  [TableMetadata] table found: pacsdb.published_study
11:21:03,507 INFO  [TableMetadata] columns: [status, doc_uid, study_fk, repository_uid, docentry_uid, created_time, updated_time, pk]
11:21:03,510 INFO  [TableMetadata] table found: pacsdb.rel_dev_proto
11:21:03,510 INFO  [TableMetadata] columns: [prcode_fk, device_fk]
11:21:03,512 INFO  [TableMetadata] table found: pacsdb.rel_gpsps_appcode
11:21:03,513 INFO  [TableMetadata] columns: [appcode_fk, gpsps_fk]
11:21:03,514 INFO  [TableMetadata] table found: pacsdb.rel_gpsps_devclass
11:21:03,515 INFO  [TableMetadata] columns: [devclass_fk, gpsps_fk]
11:21:03,516 INFO  [TableMetadata] table found: pacsdb.rel_gpsps_devloc
11:21:03,516 INFO  [TableMetadata] columns: [devloc_fk, gpsps_fk]
11:21:03,517 INFO  [TableMetadata] table found: pacsdb.rel_gpsps_devname
11:21:03,517 INFO  [TableMetadata] columns: [devname_fk, gpsps_fk]
11:21:03,519 INFO  [TableMetadata] table found: pacsdb.rel_gpsps_gppps
11:21:03,519 INFO  [TableMetadata] columns: [gppps_fk, gpsps_fk]
11:21:03,521 INFO  [TableMetadata] table found: pacsdb.rel_hpdef_proc
11:21:03,521 INFO  [TableMetadata] columns: [proc_fk, hpdef_fk]
11:21:03,523 INFO  [TableMetadata] table found: pacsdb.rel_hpdef_reason
11:21:03,523 INFO  [TableMetadata] columns: [reason_fk, hpdef_fk]
11:21:03,527 INFO  [TableMetadata] table found: pacsdb.rel_hpdef_region
11:21:03,527 INFO  [TableMetadata] columns: [region_fk, hpdef_fk]
11:21:03,531 INFO  [TableMetadata] table found: pacsdb.rel_pat_other_pid
11:21:03,531 INFO  [TableMetadata] columns: [patient_fk, other_pid_fk]
11:21:03,535 INFO  [TableMetadata] table found: pacsdb.rel_study_pcode
11:21:03,535 INFO  [TableMetadata] columns: [study_fk, pcode_fk]
11:21:03,539 INFO  [TableMetadata] table found: pacsdb.rel_ups_appcode
11:21:03,539 INFO  [TableMetadata] columns: [appcode_fk, ups_fk]
11:21:03,543 INFO  [TableMetadata] table found: pacsdb.rel_ups_devclass
11:21:03,544 INFO  [TableMetadata] columns: [devclass_fk, ups_fk]
11:21:03,547 INFO  [TableMetadata] table found: pacsdb.rel_ups_devloc
11:21:03,547 INFO  [TableMetadata] columns: [devloc_fk, ups_fk]
11:21:03,551 INFO  [TableMetadata] table found: pacsdb.rel_ups_devname
11:21:03,551 INFO  [TableMetadata] columns: [devname_fk, ups_fk]
11:21:03,556 INFO  [TableMetadata] table found: pacsdb.rel_ups_performer
11:21:03,556 INFO  [TableMetadata] columns: [performer_fk, ups_fk]
11:21:03,561 INFO  [TableMetadata] table found: pacsdb.series
11:21:03,561 INFO  [TableMetadata] columns: [series_status, inst_code_fk, perf_physician, study_fk, department, retrieve_aets, pps_iuid, pps_start, perf_phys_gn_sx, updated_time, body_part, mpps_fk, ext_retr_aet, laterality, availability, institution, station_name, src_aet, perf_phys_fn_sx, series_custom3, series_attrs, series_custom1, fileset_iuid, series_custom2, series_desc, perf_phys_i_name, perf_phys_p_name, series_iuid, fileset_id, modality, num_instances, created_time, series_no, pk]
11:21:03,566 INFO  [TableMetadata] table found: pacsdb.series_req
11:21:03,566 INFO  [TableMetadata] columns: [accno_issuer_fk, req_proc_id, sps_id, study_iuid, series_fk, req_phys_p_name, req_service, req_phys_gn_sx, req_phys_i_name, req_physician, req_phys_fn_sx, accession_no, pk]
11:21:03,575 INFO  [TableMetadata] table found: pacsdb.study
11:21:03,575 INFO  [TableMetadata] columns: [accno_issuer_fk, study_iuid, study_status, ref_phys_fn_sx, retrieve_aets, updated_time, study_status_id, ref_phys_i_name, checked_time, study_desc, ref_phys_p_name, mods_in_study, num_series, ext_retr_aet, patient_fk, accession_no, availability, study_custom3, study_custom1, study_custom2, ref_phys_gn_sx, fileset_iuid, study_datetime, ref_physician, study_id, cuids_in_study, num_instances, fileset_id, study_attrs, created_time, pk]
11:21:03,579 INFO  [TableMetadata] table found: pacsdb.study_on_fs
11:21:03,579 INFO  [TableMetadata] columns: [study_fk, access_time, filesystem_fk, mark_to_delete, pk]
11:21:03,581 INFO  [TableMetadata] table found: pacsdb.study_permission
11:21:03,582 INFO  [TableMetadata] columns: [study_iuid, roles, action, pk]
11:21:03,587 INFO  [TableMetadata] table found: pacsdb.ups
11:21:03,587 INFO  [TableMetadata] columns: [adm_id_issuer_uid, adm_id, ups_prior, ups_tuid, ups_state, updated_time, adm_id_issuer_id, ups_iuid, ups_start_time, ups_label, ups_attrs, patient_fk, uwl_label, created_time, ups_compl_time, code_fk, pk]
11:21:03,589 INFO  [TableMetadata] table found: pacsdb.ups_rel_ps
11:21:03,589 INFO  [TableMetadata] columns: [sop_cuid, sop_iuid, ups_fk, pk]
11:21:03,591 INFO  [TableMetadata] table found: pacsdb.ups_repl_ps
11:21:03,591 INFO  [TableMetadata] columns: [sop_cuid, sop_iuid, ups_fk, pk]
11:21:03,593 INFO  [TableMetadata] table found: pacsdb.ups_req
11:21:03,593 INFO  [TableMetadata] columns: [req_proc_id, confidentiality, req_service, ups_fk, accession_no, pk]
11:21:03,596 INFO  [TableMetadata] table found: pacsdb.ups_subscr
11:21:03,596 INFO  [TableMetadata] columns: [aet, deletion_lock, ups_fk, pk]
11:21:03,600 INFO  [TableMetadata] table found: pacsdb.verify_observer
11:21:03,601 INFO  [TableMetadata] columns: [observer_i_name, observer_fn_sx, observer_p_name, observer_name, observer_gn_sx, verify_datetime, instance_fk, pk]
11:21:03,604 INFO  [NamingHelper] JNDI InitialContext properties:{java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces}
11:21:03,778 INFO  [EJB3Deployer] Deployed: file:/opt/dcm4chee-2.18.0-mysql/server/default/tmp/deploy/tmp5034663429746265781dcm4chee-web-ear-3.0.4-mysql.ear-contents/dcm4chee-arc-entities-3.0.4-mysql.jar
11:21:03,901 INFO  [JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
11:21:03,904 INFO  [JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-web-ear-3.0.4-mysql.ear,jar=dcm4chee-usr-dao-3.0.4.jar,name=UserAccessBean,service=EJB3 with dependencies:
11:21:03,905 INFO  [JmxKernelAbstraction]     persistence.units:ear=dcm4chee-web-ear-3.0.4-mysql.ear,unitName=dcm4chee-usr
11:21:03,907 INFO  [EJB3Deployer] Deployed: file:/opt/dcm4chee-2.18.0-mysql/server/default/tmp/deploy/tmp5034663429746265781dcm4chee-web-ear-3.0.4-mysql.ear-contents/dcm4chee-usr-dao-3.0.4.jar
11:21:03,908 INFO  [JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.entity.PersistenceUnitDeployment
11:21:03,908 INFO  [JmxKernelAbstraction] installing MBean: persistence.units:ear=dcm4chee-web-ear-3.0.4-mysql.ear,unitName=dcm4chee-usr with dependencies:
11:21:03,908 INFO  [JmxKernelAbstraction]     jboss.jca:name=pacsDS,service=DataSourceBinding
11:21:03,910 INFO  [PersistenceUnitDeployment] Starting persistence unit persistence.units:ear=dcm4chee-web-ear-3.0.4-mysql.ear,unitName=dcm4chee-usr
11:21:03,912 INFO  [Ejb3Configuration] Processing PersistenceUnitInfo [
    name: dcm4chee-usr
    ...]
11:21:03,913 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.usr.entity.User
11:21:03,913 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.usr.entity.UserRoleAssignment
11:21:03,914 INFO  [Configuration] Reading mappings from resource : META-INF/orm.xml
11:21:03,956 INFO  [Ejb3Configuration] [PersistenceUnit: dcm4chee-usr] META-INF/orm.xml found
11:21:03,971 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.usr.entity.User
11:21:03,971 INFO  [EntityBinder] Bind entity org.dcm4chee.usr.entity.User on table users
11:21:03,974 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.usr.entity.UserRoleAssignment
11:21:03,974 INFO  [EntityBinder] Bind entity org.dcm4chee.usr.entity.UserRoleAssignment on table roles
11:21:03,979 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.AE
11:21:03,980 INFO  [QueryBinder] Binding Named query: AE.findByTitle => select ae from AE ae where title = :title
11:21:03,980 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.AE on table ae
11:21:03,984 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Code
11:21:03,984 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.Code on table code
11:21:03,986 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Device
11:21:03,986 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.Device on table device
11:21:03,988 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.File
11:21:03,988 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.File on table files
11:21:03,991 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.FileSystem
11:21:03,991 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.FileSystem on table filesystem
11:21:03,994 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.GPPPS
11:21:03,994 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.GPPPS on table gppps
11:21:03,999 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.GPSPS
11:21:03,999 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.GPSPS on table gpsps
11:21:04,007 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.GPSPSPerformer
11:21:04,008 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.GPSPSPerformer on table gpsps_perf
11:21:04,011 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.GPSPSRequest
11:21:04,011 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.GPSPSRequest on table gpsps_req
11:21:04,013 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.HangingProtocol
11:21:04,013 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.HangingProtocol on table hp
11:21:04,017 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.HPDefinition
11:21:04,017 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.HPDefinition on table hpdef
11:21:04,020 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Instance
11:21:04,021 INFO  [QueryBinder] Binding Named query: Instance.findByIUID => select object(i) from Instance i where sopInstanceUID = :iuid
11:21:04,021 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.Instance on table instance
11:21:04,030 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Media
11:21:04,030 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.Media on table media
11:21:04,033 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.MPPS
11:21:04,033 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.MPPS on table mpps
11:21:04,037 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.MWLItem
11:21:04,038 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.MWLItem on table mwl_item
11:21:04,044 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.OtherPatientID
11:21:04,044 INFO  [QueryBinder] Binding Named query: OtherPatientID.findByPatientIdAndIssuer => select opid from OtherPatientID opid where patientID = :pid and issuerOfPatientID = :issuer
11:21:04,044 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.OtherPatientID on table other_pid
11:21:04,046 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Patient
11:21:04,046 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.Patient on table patient
11:21:04,055 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.PrivateFile
11:21:04,055 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.PrivateFile on table priv_file
11:21:04,058 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.PrivateInstance
11:21:04,059 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.PrivateInstance on table priv_instance
11:21:04,061 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.PrivatePatient
11:21:04,062 INFO  [QueryBinder] Binding Named query: PrivatePatient.findByIdAndIssuer => select object(p) from PrivatePatient p where patientID = :patId and issuerOfPatientID = :issuer
11:21:04,062 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.PrivatePatient on table priv_patient
11:21:04,064 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.PrivateSeries
11:21:04,065 INFO  [QueryBinder] Binding Named query: PrivateSeries.findByIUID => select object(pi) from PrivateSeries pi where seriesInstanceUID = :iuid
11:21:04,065 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.PrivateSeries on table priv_series
11:21:04,068 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.PrivateStudy
11:21:04,068 INFO  [QueryBinder] Binding Named query: PrivateStudy.findByIUID => select object(ps) from PrivateStudy ps where studyInstanceUID = :iuid
11:21:04,069 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.PrivateStudy on table priv_study
11:21:04,071 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.RequestAttributes
11:21:04,071 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.RequestAttributes on table series_req
11:21:04,075 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Series
11:21:04,076 INFO  [QueryBinder] Binding Named query: Series.findByIUID => select object(s) from Series s where seriesInstanceUID = :iuid
11:21:04,076 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.Series on table series
11:21:04,086 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Study
11:21:04,086 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.Study on table study
11:21:04,096 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.StudyOnFileSystem
11:21:04,097 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.StudyOnFileSystem on table study_on_fs
11:21:04,099 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.StudyPermission
11:21:04,099 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.StudyPermission on table study_permission
11:21:04,100 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.VerifyingObserver
11:21:04,100 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.VerifyingObserver on table verify_observer
11:21:04,103 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Issuer
11:21:04,103 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.Issuer on table issuer
11:21:04,105 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.ContentItem
11:21:04,105 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.ContentItem on table content_item
11:21:04,107 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.UPS
11:21:04,107 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.UPS on table ups
11:21:04,116 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.UPSRequest
11:21:04,117 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.UPSRequest on table ups_req
11:21:04,119 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.UPSRelatedPS
11:21:04,120 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.UPSRelatedPS on table ups_rel_ps
11:21:04,121 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.UPSReplacedPS
11:21:04,122 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.UPSReplacedPS on table ups_repl_ps
11:21:04,123 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.UPSSubscription
11:21:04,123 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.UPSSubscription on table ups_subscr
11:21:04,125 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.PublishedStudy
11:21:04,125 INFO  [QueryBinder] Binding Named query: PublishedStudy.findByStudyPkAndStatus => select object(s) from PublishedStudy s where s.study.pk = :studyPk and s.status = :status
11:21:04,125 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.PublishedStudy on table published_study
11:21:04,136 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.usr.entity.User.roles -> roles
11:21:04,136 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.GPSPS.referencedRequests -> gpsps_req
11:21:04,136 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.GPSPS.scheduledHumanPerformers -> gpsps_perf
11:21:04,137 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.HangingProtocol.definitions -> hpdef
11:21:04,137 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Instance.verifyingObservers -> verify_observer
11:21:04,137 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Instance.files -> files
11:21:04,137 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Instance.contentItems -> content_item
11:21:04,137 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Media.instances -> instance
11:21:04,137 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.MPPS.series -> series
11:21:04,137 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.previous -> patient
11:21:04,138 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.studies -> study
11:21:04,138 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.modalityWorklistItems -> mwl_item
11:21:04,138 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.modalityPerformedProcedureSteps -> mpps
11:21:04,138 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.generalPurposeScheduledProcedureSteps -> gpsps
11:21:04,138 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.generalPurposePerformedProcedureSteps -> gppps
11:21:04,138 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.unifiedProcedureSteps -> ups
11:21:04,138 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.PrivateInstance.files -> priv_file
11:21:04,139 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.PrivatePatient.studies -> priv_study
11:21:04,139 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.PrivateSeries.instances -> priv_instance
11:21:04,139 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.PrivateStudy.series -> priv_series
11:21:04,139 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Series.requestAttributes -> series_req
11:21:04,139 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Series.instances -> instance
11:21:04,139 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Study.series -> series
11:21:04,139 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.UPS.refRequests -> ups_req
11:21:04,140 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.UPS.relatedProcedureSteps -> ups_rel_ps
11:21:04,140 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.UPS.replacedProcedureSteps -> ups_repl_ps
11:21:04,140 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.UPS.subscriptions -> ups_subscr
11:21:04,258 INFO  [ConnectionProviderFactory] Initializing connection provider: org.hibernate.ejb.connection.InjectedDataSourceConnectionProvider
11:21:04,258 INFO  [InjectedDataSourceConnectionProvider] Using provided datasource
11:21:04,258 INFO  [SettingsFactory] RDBMS: MySQL, version: 5.5.35-0+wheezy1
11:21:04,258 INFO  [SettingsFactory] JDBC driver: MySQL-AB JDBC Driver, version: mysql-connector-java-5.0.5 ( $Date: 2007-03-01 00:01:06 +0100 (Thu, 01 Mar 2007) $, $Revision: 6329 $ )
11:21:04,258 INFO  [Dialect] Using dialect: org.hibernate.dialect.MySQLInnoDBDialect
11:21:04,259 INFO  [TransactionFactoryFactory] Transaction strategy: org.hibernate.ejb.transaction.JoinableCMTTransactionFactory
11:21:04,259 INFO  [TransactionManagerLookupFactory] instantiating TransactionManagerLookup: org.hibernate.transaction.JBossTransactionManagerLookup
11:21:04,259 INFO  [TransactionManagerLookupFactory] instantiated TransactionManagerLookup
11:21:04,259 INFO  [SettingsFactory] Automatic flush during beforeCompletion(): disabled
11:21:04,259 INFO  [SettingsFactory] Automatic session close at end of transaction: disabled
11:21:04,259 INFO  [SettingsFactory] JDBC batch size: 15
11:21:04,259 INFO  [SettingsFactory] JDBC batch updates for versioned data: disabled
11:21:04,259 INFO  [SettingsFactory] Scrollable result sets: enabled
11:21:04,259 INFO  [SettingsFactory] JDBC3 getGeneratedKeys(): disabled
11:21:04,260 INFO  [SettingsFactory] Connection release mode: auto
11:21:04,260 INFO  [SettingsFactory] Maximum outer join fetch depth: 2
11:21:04,260 INFO  [SettingsFactory] Default batch fetch size: 1
11:21:04,260 INFO  [SettingsFactory] Generate SQL with comments: disabled
11:21:04,260 INFO  [SettingsFactory] Order SQL updates by primary key: disabled
11:21:04,260 INFO  [SettingsFactory] Order SQL inserts for batching: disabled
11:21:04,260 INFO  [SettingsFactory] Query translator: org.hibernate.hql.ast.ASTQueryTranslatorFactory
11:21:04,260 INFO  [ASTQueryTranslatorFactory] Using ASTQueryTranslatorFactory
11:21:04,260 INFO  [SettingsFactory] Query language substitutions: {}
11:21:04,260 INFO  [SettingsFactory] JPA-QL strict compliance: enabled
11:21:04,260 INFO  [SettingsFactory] Second-level cache: enabled
11:21:04,260 INFO  [SettingsFactory] Query cache: disabled
11:21:04,260 INFO  [SettingsFactory] Cache provider: org.hibernate.cache.HashtableCacheProvider
11:21:04,260 INFO  [SettingsFactory] Optimize cache for minimal puts: disabled
11:21:04,260 INFO  [SettingsFactory] Cache region prefix: dcm4chee-web-ear-3_0_4-mysql_ear,dcm4chee-usr
11:21:04,260 INFO  [SettingsFactory] Structured second-level cache entries: disabled
11:21:04,260 INFO  [SettingsFactory] Statistics: disabled
11:21:04,260 INFO  [SettingsFactory] Deleted entity synthetic identifier rollback: disabled
11:21:04,261 INFO  [SettingsFactory] Default entity-mode: pojo
11:21:04,261 INFO  [SettingsFactory] Named query checking : enabled
11:21:04,280 INFO  [SessionFactoryImpl] building session factory
11:21:04,403 INFO  [SessionFactoryObjectFactory] Factory name: persistence.units:ear=dcm4chee-web-ear-3.0.4-mysql.ear,unitName=dcm4chee-usr
11:21:04,403 INFO  [NamingHelper] JNDI InitialContext properties:{java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces}
11:21:04,403 INFO  [SessionFactoryObjectFactory] Bound factory to JNDI name: persistence.units:ear=dcm4chee-web-ear-3.0.4-mysql.ear,unitName=dcm4chee-usr
11:21:04,403 WARN  [SessionFactoryObjectFactory] InitialContext did not implement EventContext
11:21:04,403 INFO  [SchemaValidator] Running schema validator
11:21:04,403 INFO  [SchemaValidator] fetching database metadata
11:21:04,419 INFO  [TableMetadata] table found: pacsdb.ae
11:21:04,419 INFO  [TableMetadata] columns: [port, station_name, passwd, installed, department, wado_url, hostname, fs_group_id, ae_desc, cipher_suites, acc_no_issuer, vendor_data, aet, user_id, pat_id_issuer, ae_group, institution, pk]
11:21:04,422 INFO  [TableMetadata] table found: pacsdb.code
11:21:04,422 INFO  [TableMetadata] columns: [code_version, code_designator, code_value, code_meaning, pk]
11:21:04,424 INFO  [TableMetadata] table found: pacsdb.content_item
11:21:04,424 INFO  [TableMetadata] columns: [name_fk, text_value, rel_type, instance_fk, code_fk, pk]
11:21:04,426 INFO  [TableMetadata] table found: pacsdb.device
11:21:04,426 INFO  [TableMetadata] columns: [station_name, modality, station_aet, pk]
11:21:04,429 INFO  [TableMetadata] table found: pacsdb.files
11:21:04,429 INFO  [TableMetadata] columns: [filepath, file_status, file_size, md5_check_time, created_time, filesystem_fk, instance_fk, file_tsuid, file_md5, pk]
11:21:04,433 INFO  [TableMetadata] table found: pacsdb.filesystem
11:21:04,434 INFO  [TableMetadata] columns: [user_info, retrieve_aet, fs_status, fs_group_id, dirpath, next_fk, availability, pk]
11:21:04,438 INFO  [TableMetadata] table found: pacsdb.gppps
11:21:04,439 INFO  [TableMetadata] columns: [pps_attrs, pps_iuid, patient_fk, pps_status, pps_start, created_time, updated_time, pk]
11:21:04,444 INFO  [TableMetadata] table found: pacsdb.gpsps
11:21:04,445 INFO  [TableMetadata] columns: [gpsps_prior, gpsps_tuid, gpsps_status, end_datetime, in_availability, item_attrs, patient_fk, gpsps_iuid, code_fk, start_datetime, pk]
11:21:04,448 INFO  [TableMetadata] table found: pacsdb.gpsps_perf
11:21:04,448 INFO  [TableMetadata] columns: [hum_perf_p_name, hum_perf_gn_sx, gpsps_fk, human_perf_name, hum_perf_i_name, hum_perf_fn_sx, code_fk, pk]
11:21:04,451 INFO  [TableMetadata] table found: pacsdb.gpsps_req
11:21:04,451 INFO  [TableMetadata] columns: [req_proc_id, gpsps_fk, accession_no, pk]
11:21:04,454 INFO  [TableMetadata] table found: pacsdb.hp
11:21:04,454 INFO  [TableMetadata] columns: [user_fk, num_priors, hp_iuid, num_screens, hp_level, hp_attrs, hp_group, hp_cuid, hp_name, pk]
11:21:04,456 INFO  [TableMetadata] table found: pacsdb.hpdef
11:21:04,456 INFO  [TableMetadata] columns: [hp_fk, laterality, modality, pk]
11:21:04,460 INFO  [TableMetadata] table found: pacsdb.instance
11:21:04,460 INFO  [TableMetadata] columns: [inst_attrs, commitment, all_attrs, content_datetime, series_fk, inst_custom1, retrieve_aets, inst_custom2, inst_no, inst_custom3, updated_time, srcode_fk, sr_verified, sop_cuid, sr_complete, archived, sop_iuid, ext_retr_aet, inst_status, media_fk, created_time, availability, pk]
11:21:04,462 INFO  [TableMetadata] table found: pacsdb.issuer
11:21:04,462 INFO  [TableMetadata] columns: [entity_uid_type, entity_id, entity_uid, pk]
11:21:04,466 INFO  [TableMetadata] table found: pacsdb.media
11:21:04,467 INFO  [TableMetadata] columns: [media_status_info, media_rq_iuid, media_status, fileset_id, fileset_iuid, created_time, media_usage, updated_time, pk]
11:21:04,472 INFO  [TableMetadata] table found: pacsdb.mpps
11:21:04,472 INFO  [TableMetadata] columns: [mpps_attrs, drcode_fk, patient_fk, modality, pps_start, created_time, mpps_status, updated_time, accession_no, mpps_iuid, station_aet, pk]
11:21:04,478 INFO  [TableMetadata] table found: pacsdb.mwl_item
11:21:04,478 INFO  [TableMetadata] columns: [req_proc_id, sps_status, sps_id, station_name, study_iuid, perf_physician, perf_phys_fn_sx, perf_phys_gn_sx, updated_time, start_datetime, station_aet, perf_phys_i_name, perf_phys_p_name, item_attrs, patient_fk, modality, created_time, accession_no, pk]
11:21:04,480 INFO  [TableMetadata] table found: pacsdb.other_pid
11:21:04,481 INFO  [TableMetadata] columns: [pat_id, pat_id_issuer, pk]
11:21:04,484 INFO  [TableMetadata] table found: pacsdb.patient
11:21:04,484 INFO  [TableMetadata] columns: [merge_fk, pat_custom2, pat_fn_sx, pat_custom1, pat_custom3, pat_sex, pat_attrs, pat_p_name, updated_time, pat_gn_sx, pat_i_name, pat_birthdate, pat_id, pat_id_issuer, created_time, pat_name, pk]
11:21:04,488 INFO  [TableMetadata] table found: pacsdb.priv_file
11:21:04,488 INFO  [TableMetadata] columns: [filepath, file_status, file_size, filesystem_fk, instance_fk, file_tsuid, file_md5, pk]
11:21:04,491 INFO  [TableMetadata] table found: pacsdb.priv_instance
11:21:04,491 INFO  [TableMetadata] columns: [inst_attrs, priv_type, series_fk, sop_iuid, created_time, pk]
11:21:04,493 INFO  [TableMetadata] table found: pacsdb.priv_patient
11:21:04,494 INFO  [TableMetadata] columns: [priv_type, pat_id, pat_attrs, pat_id_issuer, pat_name, pk]
11:21:04,500 INFO  [TableMetadata] table found: pacsdb.priv_series
11:21:04,500 INFO  [TableMetadata] columns: [priv_type, src_aet, study_fk, series_attrs, series_iuid, pk]
11:21:04,503 INFO  [TableMetadata] table found: pacsdb.priv_study
11:21:04,503 INFO  [TableMetadata] columns: [priv_type, study_iuid, patient_fk, study_attrs, accession_no, pk]
11:21:04,507 INFO  [TableMetadata] table found: pacsdb.published_study
11:21:04,508 INFO  [TableMetadata] columns: [status, doc_uid, study_fk, repository_uid, docentry_uid, created_time, updated_time, pk]
11:21:04,510 INFO  [TableMetadata] table found: pacsdb.rel_dev_proto
11:21:04,510 INFO  [TableMetadata] columns: [prcode_fk, device_fk]
11:21:04,511 INFO  [TableMetadata] table found: pacsdb.rel_gpsps_appcode
11:21:04,511 INFO  [TableMetadata] columns: [appcode_fk, gpsps_fk]
11:21:04,513 INFO  [TableMetadata] table found: pacsdb.rel_gpsps_devclass
11:21:04,513 INFO  [TableMetadata] columns: [devclass_fk, gpsps_fk]
11:21:04,514 INFO  [TableMetadata] table found: pacsdb.rel_gpsps_devloc
11:21:04,514 INFO  [TableMetadata] columns: [devloc_fk, gpsps_fk]
11:21:04,515 INFO  [TableMetadata] table found: pacsdb.rel_gpsps_devname
11:21:04,515 INFO  [TableMetadata] columns: [devname_fk, gpsps_fk]
11:21:04,517 INFO  [TableMetadata] table found: pacsdb.rel_gpsps_gppps
11:21:04,517 INFO  [TableMetadata] columns: [gppps_fk, gpsps_fk]
11:21:04,518 INFO  [TableMetadata] table found: pacsdb.rel_hpdef_proc
11:21:04,518 INFO  [TableMetadata] columns: [proc_fk, hpdef_fk]
11:21:04,519 INFO  [TableMetadata] table found: pacsdb.rel_hpdef_reason
11:21:04,519 INFO  [TableMetadata] columns: [reason_fk, hpdef_fk]
11:21:04,520 INFO  [TableMetadata] table found: pacsdb.rel_hpdef_region
11:21:04,520 INFO  [TableMetadata] columns: [region_fk, hpdef_fk]
11:21:04,522 INFO  [TableMetadata] table found: pacsdb.rel_pat_other_pid
11:21:04,522 INFO  [TableMetadata] columns: [patient_fk, other_pid_fk]
11:21:04,523 INFO  [TableMetadata] table found: pacsdb.rel_study_pcode
11:21:04,523 INFO  [TableMetadata] columns: [study_fk, pcode_fk]
11:21:04,525 INFO  [TableMetadata] table found: pacsdb.rel_ups_appcode
11:21:04,525 INFO  [TableMetadata] columns: [appcode_fk, ups_fk]
11:21:04,526 INFO  [TableMetadata] table found: pacsdb.rel_ups_devclass
11:21:04,526 INFO  [TableMetadata] columns: [devclass_fk, ups_fk]
11:21:04,528 INFO  [TableMetadata] table found: pacsdb.rel_ups_devloc
11:21:04,528 INFO  [TableMetadata] columns: [devloc_fk, ups_fk]
11:21:04,530 INFO  [TableMetadata] table found: pacsdb.rel_ups_devname
11:21:04,530 INFO  [TableMetadata] columns: [devname_fk, ups_fk]
11:21:04,531 INFO  [TableMetadata] table found: pacsdb.rel_ups_performer
11:21:04,531 INFO  [TableMetadata] columns: [performer_fk, ups_fk]
11:21:04,534 INFO  [TableMetadata] table found: pacsdb.roles
11:21:04,534 INFO  [TableMetadata] columns: [roles, user_id]
11:21:04,540 INFO  [TableMetadata] table found: pacsdb.series
11:21:04,540 INFO  [TableMetadata] columns: [series_status, inst_code_fk, perf_physician, study_fk, department, retrieve_aets, pps_iuid, pps_start, perf_phys_gn_sx, updated_time, body_part, mpps_fk, ext_retr_aet, laterality, availability, institution, station_name, src_aet, perf_phys_fn_sx, series_custom3, series_attrs, series_custom1, fileset_iuid, series_custom2, series_desc, perf_phys_i_name, perf_phys_p_name, series_iuid, fileset_id, modality, num_instances, created_time, series_no, pk]
11:21:04,544 INFO  [TableMetadata] table found: pacsdb.series_req
11:21:04,544 INFO  [TableMetadata] columns: [accno_issuer_fk, req_proc_id, sps_id, study_iuid, series_fk, req_phys_p_name, req_service, req_phys_gn_sx, req_phys_i_name, req_physician, req_phys_fn_sx, accession_no, pk]
11:21:04,549 INFO  [TableMetadata] table found: pacsdb.study
11:21:04,549 INFO  [TableMetadata] columns: [accno_issuer_fk, study_iuid, study_status, ref_phys_fn_sx, retrieve_aets, updated_time, study_status_id, ref_phys_i_name, checked_time, study_desc, ref_phys_p_name, mods_in_study, num_series, ext_retr_aet, patient_fk, accession_no, availability, study_custom3, study_custom1, study_custom2, ref_phys_gn_sx, fileset_iuid, study_datetime, ref_physician, study_id, cuids_in_study, num_instances, fileset_id, study_attrs, created_time, pk]
11:21:04,552 INFO  [TableMetadata] table found: pacsdb.study_on_fs
11:21:04,552 INFO  [TableMetadata] columns: [study_fk, access_time, filesystem_fk, mark_to_delete, pk]
11:21:04,553 INFO  [TableMetadata] table found: pacsdb.study_permission
11:21:04,553 INFO  [TableMetadata] columns: [study_iuid, roles, action, pk]
11:21:04,557 INFO  [TableMetadata] table found: pacsdb.ups
11:21:04,558 INFO  [TableMetadata] columns: [adm_id_issuer_uid, adm_id, ups_prior, ups_tuid, ups_state, updated_time, adm_id_issuer_id, ups_iuid, ups_start_time, ups_label, ups_attrs, patient_fk, uwl_label, created_time, ups_compl_time, code_fk, pk]
11:21:04,562 INFO  [TableMetadata] table found: pacsdb.ups_rel_ps
11:21:04,562 INFO  [TableMetadata] columns: [sop_cuid, sop_iuid, ups_fk, pk]
11:21:04,564 INFO  [TableMetadata] table found: pacsdb.ups_repl_ps
11:21:04,564 INFO  [TableMetadata] columns: [sop_cuid, sop_iuid, ups_fk, pk]
11:21:04,569 INFO  [TableMetadata] table found: pacsdb.ups_req
11:21:04,569 INFO  [TableMetadata] columns: [req_proc_id, confidentiality, req_service, ups_fk, accession_no, pk]
11:21:04,571 INFO  [TableMetadata] table found: pacsdb.ups_subscr
11:21:04,571 INFO  [TableMetadata] columns: [aet, deletion_lock, ups_fk, pk]
11:21:04,573 INFO  [TableMetadata] table found: pacsdb.users
11:21:04,573 INFO  [TableMetadata] columns: [passwd, user_id]
11:21:04,574 INFO  [TableMetadata] table found: pacsdb.verify_observer
11:21:04,574 INFO  [TableMetadata] columns: [observer_i_name, observer_fn_sx, observer_p_name, observer_name, observer_gn_sx, verify_datetime, instance_fk, pk]
11:21:04,575 INFO  [NamingHelper] JNDI InitialContext properties:{java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces}
11:21:04,639 INFO  [EJBContainer] STARTED EJB: org.dcm4chee.usr.dao.UserAccessBean ejbName: UserAccessBean
11:21:04,661 INFO  [EJB3Deployer] Deployed: file:/opt/dcm4chee-2.18.0-mysql/server/default/tmp/deploy/tmp5034663429746265781dcm4chee-web-ear-3.0.4-mysql.ear-contents/dcm4chee-usr-entity-3.0.4-mysql.jar
11:21:04,744 INFO  [JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
11:21:04,745 INFO  [JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-web-ear-3.0.4-mysql.ear,jar=dcm4chee-web-ejb-3.0.4.jar,name=AEHomeBean,service=EJB3 with dependencies:
11:21:04,745 INFO  [JmxKernelAbstraction]     persistence.units:ear=dcm4chee-web-ear-3.0.4-mysql.ear,unitName=dcm4chee-arc
11:21:04,748 INFO  [EJBContainer] STARTED EJB: org.dcm4chee.web.dao.ae.AEHomeBean ejbName: AEHomeBean
11:21:04,753 INFO  [JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
11:21:04,753 INFO  [JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-web-ear-3.0.4-mysql.ear,jar=dcm4chee-web-ejb-3.0.4.jar,name=DicomEditBean,service=EJB3 with dependencies:
11:21:04,753 INFO  [JmxKernelAbstraction]     persistence.units:ear=dcm4chee-web-ear-3.0.4-mysql.ear,unitName=dcm4chee-arc
11:21:04,763 INFO  [EJBContainer] STARTED EJB: org.dcm4chee.web.dao.common.DicomEditBean ejbName: DicomEditBean
11:21:04,769 INFO  [JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
11:21:04,769 INFO  [JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-web-ear-3.0.4-mysql.ear,jar=dcm4chee-web-ejb-3.0.4.jar,name=MppsToMwlLinkBean,service=EJB3 with dependencies:
11:21:04,769 INFO  [JmxKernelAbstraction]     persistence.units:ear=dcm4chee-web-ear-3.0.4-mysql.ear,unitName=dcm4chee-arc
11:21:04,774 INFO  [EJBContainer] STARTED EJB: org.dcm4chee.web.dao.folder.MppsToMwlLinkBean ejbName: MppsToMwlLinkBean
11:21:04,784 INFO  [JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
11:21:04,784 INFO  [JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-web-ear-3.0.4-mysql.ear,jar=dcm4chee-web-ejb-3.0.4.jar,name=StudyListBean,service=EJB3 with dependencies:
11:21:04,784 INFO  [JmxKernelAbstraction]     persistence.units:ear=dcm4chee-web-ear-3.0.4-mysql.ear,unitName=dcm4chee-arc
11:21:04,794 INFO  [EJBContainer] STARTED EJB: org.dcm4chee.web.dao.folder.StudyListBean ejbName: StudyListBean
11:21:04,800 INFO  [JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
11:21:04,801 INFO  [JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-web-ear-3.0.4-mysql.ear,jar=dcm4chee-web-ejb-3.0.4.jar,name=StudyPermissionsBean,service=EJB3 with dependencies:
11:21:04,801 INFO  [JmxKernelAbstraction]     persistence.units:ear=dcm4chee-web-ear-3.0.4-mysql.ear,unitName=dcm4chee-arc
11:21:04,804 INFO  [EJBContainer] STARTED EJB: org.dcm4chee.web.dao.folder.StudyPermissionsBean ejbName: StudyPermissionsBean
11:21:04,810 INFO  [JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
11:21:04,810 INFO  [JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-web-ear-3.0.4-mysql.ear,jar=dcm4chee-web-ejb-3.0.4.jar,name=FileSystemHomeBean,service=EJB3 with dependencies:
11:21:04,810 INFO  [JmxKernelAbstraction]     persistence.units:ear=dcm4chee-web-ear-3.0.4-mysql.ear,unitName=dcm4chee-arc
11:21:04,813 INFO  [EJBContainer] STARTED EJB: org.dcm4chee.web.dao.fs.FileSystemHomeBean ejbName: FileSystemHomeBean
11:21:04,818 INFO  [JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
11:21:04,818 INFO  [JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-web-ear-3.0.4-mysql.ear,jar=dcm4chee-web-ejb-3.0.4.jar,name=TCQueryBean,service=EJB3 with dependencies:
11:21:04,818 INFO  [JmxKernelAbstraction]     persistence.units:ear=dcm4chee-web-ear-3.0.4-mysql.ear,unitName=dcm4chee-arc
11:21:04,823 INFO  [EJBContainer] STARTED EJB: org.dcm4chee.web.dao.tc.TCQueryBean ejbName: TCQueryBean
11:21:04,832 INFO  [JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
11:21:04,833 INFO  [JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-web-ear-3.0.4-mysql.ear,jar=dcm4chee-web-ejb-3.0.4.jar,name=TrashCleanerBean,service=EJB3 with dependencies:
11:21:04,833 INFO  [JmxKernelAbstraction]     persistence.units:ear=dcm4chee-web-ear-3.0.4-mysql.ear,unitName=dcm4chee-arc
11:21:04,837 INFO  [EJBContainer] STARTED EJB: org.dcm4chee.web.dao.trash.TrashCleanerBean ejbName: TrashCleanerBean
11:21:04,844 INFO  [JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
11:21:04,844 INFO  [JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-web-ear-3.0.4-mysql.ear,jar=dcm4chee-web-ejb-3.0.4.jar,name=TrashListBean,service=EJB3 with dependencies:
11:21:04,844 INFO  [JmxKernelAbstraction]     persistence.units:ear=dcm4chee-web-ear-3.0.4-mysql.ear,unitName=dcm4chee-arc
11:21:04,850 INFO  [EJBContainer] STARTED EJB: org.dcm4chee.web.dao.trash.TrashListBean ejbName: TrashListBean
11:21:04,855 INFO  [JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
11:21:04,855 INFO  [JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-web-ear-3.0.4-mysql.ear,jar=dcm4chee-web-ejb-3.0.4.jar,name=ModalityWorklistBean,service=EJB3 with dependencies:
11:21:04,855 INFO  [JmxKernelAbstraction]     persistence.units:ear=dcm4chee-web-ear-3.0.4-mysql.ear,unitName=dcm4chee-arc
11:21:04,859 INFO  [EJBContainer] STARTED EJB: org.dcm4chee.web.dao.worklist.modality.ModalityWorklistBean ejbName: ModalityWorklistBean
11:21:04,864 INFO  [EJB3Deployer] Deployed: file:/opt/dcm4chee-2.18.0-mysql/server/default/tmp/deploy/tmp5034663429746265781dcm4chee-web-ear-3.0.4-mysql.ear-contents/dcm4chee-web-ejb-3.0.4.jar
11:21:04,866 INFO  [TomcatDeployer] deploy, ctxPath=/dcm4chee-web3-dicom, warUrl=.../tmp/deploy/tmp5034663429746265781dcm4chee-web-ear-3.0.4-mysql.ear-contents/dcm4chee-web-dicom-3.0.4-exp.war/
11:21:04,917 INFO  [TomcatDeployer] deploy, ctxPath=/dcm4chee-web3, warUrl=.../tmp/deploy/tmp5034663429746265781dcm4chee-web-ear-3.0.4-mysql.ear-contents/dcm4chee-web-war-3.0.4-exp.war/
11:21:05,590 INFO  [Application] [WicketApplication] init: Wicket core library initializer
11:21:05,592 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IBehaviorListener, method=public abstract void org.apache.wicket.behavior.IBehaviorListener.onRequest()]
11:21:05,592 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IBehaviorListener, method=public abstract void org.apache.wicket.behavior.IBehaviorListener.onRequest()]
11:21:05,593 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IFormSubmitListener, method=public abstract void org.apache.wicket.markup.html.form.IFormSubmitListener.onFormSubmitted()]
11:21:05,593 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IFormSubmitListener, method=public abstract void org.apache.wicket.markup.html.form.IFormSubmitListener.onFormSubmitted()]
11:21:05,593 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=ILinkListener, method=public abstract void org.apache.wicket.markup.html.link.ILinkListener.onLinkClicked()]
11:21:05,593 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=ILinkListener, method=public abstract void org.apache.wicket.markup.html.link.ILinkListener.onLinkClicked()]
11:21:05,593 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IOnChangeListener, method=public abstract void org.apache.wicket.markup.html.form.IOnChangeListener.onSelectionChanged()]
11:21:05,593 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IOnChangeListener, method=public abstract void org.apache.wicket.markup.html.form.IOnChangeListener.onSelectionChanged()]
11:21:05,593 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IRedirectListener, method=public abstract void org.apache.wicket.IRedirectListener.onRedirect()]
11:21:05,593 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IRedirectListener, method=public abstract void org.apache.wicket.IRedirectListener.onRedirect()]
11:21:05,594 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IResourceListener, method=public abstract void org.apache.wicket.IResourceListener.onResourceRequested()]
11:21:05,594 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IResourceListener, method=public abstract void org.apache.wicket.IResourceListener.onResourceRequested()]
11:21:05,595 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IActivePageBehaviorListener, method=public abstract void org.apache.wicket.behavior.IBehaviorListener.onRequest()]
11:21:05,595 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IActivePageBehaviorListener, method=public abstract void org.apache.wicket.behavior.IBehaviorListener.onRequest()]
11:21:05,595 INFO  [Application] [WicketApplication] init: Wicket core library initializer
11:21:05,595 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IBehaviorListener, method=public abstract void org.apache.wicket.behavior.IBehaviorListener.onRequest()]
11:21:05,595 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IFormSubmitListener, method=public abstract void org.apache.wicket.markup.html.form.IFormSubmitListener.onFormSubmitted()]
11:21:05,595 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=ILinkListener, method=public abstract void org.apache.wicket.markup.html.link.ILinkListener.onLinkClicked()]
11:21:05,595 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IOnChangeListener, method=public abstract void org.apache.wicket.markup.html.form.IOnChangeListener.onSelectionChanged()]
11:21:05,595 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IRedirectListener, method=public abstract void org.apache.wicket.IRedirectListener.onRedirect()]
11:21:05,595 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IResourceListener, method=public abstract void org.apache.wicket.IResourceListener.onResourceRequested()]
11:21:05,595 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IActivePageBehaviorListener, method=public abstract void org.apache.wicket.behavior.IBehaviorListener.onRequest()]
11:21:05,595 INFO  [Application] [WicketApplication] init: Wicket extensions initializer
11:21:05,599 INFO  [Application] [WicketApplication] init: Wicket extensions initializer
11:21:05,599 INFO  [WebApplication] [WicketApplication] Started Wicket version 1.4.22 in deployment mode
11:21:05,609 INFO  [EARDeployer] Started J2EE application: file:/opt/dcm4chee-2.18.0-mysql/server/default/deploy/dcm4chee-web-ear-3.0.4-mysql.ear
11:21:05,609 ERROR [URLDeploymentScanner] Incomplete Deployment listing:

--- Incompletely deployed packages ---
org.jboss.deployment.DeploymentInfo@c4a755d7 { url=file:/opt/dcm4chee-2.18.0-mysql/server/default/deploy/dcm4chee-wado-service.xml }
  deployer: org.jboss.deployment.SARDeployer@3747c1db
  status: Deployment FAILED reason: - nested throwable: (java.lang.reflect.InvocationTargetException)
  state: FAILED
  watch: file:/opt/dcm4chee-2.18.0-mysql/server/default/deploy/dcm4chee-wado-service.xml
  altDD: null
  lastDeployed: 1398090053575
  lastModified: 1398090053000
  mbeans:


11:21:05,647 INFO  [ServerImpl] Start Server listening on 0.0.0.0:11112
11:21:05,651 INFO  [ServerImpl] Start Server listening on 0.0.0.0:2575
11:21:05,662 INFO  [Http11Protocol] Arrancando Coyote HTTP/1.1 en puerto http-0.0.0.0-8080
11:21:05,681 INFO  [Http11Protocol] Arrancando Coyote HTTP/1.1 en puerto http-8443
11:21:05,700 INFO  [AjpProtocol] Starting Coyote AJP/1.3 on ajp-0.0.0.0-8009
11:21:05,712 INFO  [Server] JBoss (MX MicroKernel) [4.2.3.GA (build: SVNTag=JBoss_4_2_3_GA date=200807181417)] Started in 21s:444ms


Any idea ?

Thanks

Ramon

[Ramón Retamar]

Solved. :)

Sorry...the Linux is amd64 and i forgott update the lib jai_imageio-1_1-lib-linux-amd64.tar.gz from Sun repository (http://download.java.net/media/jai-imageio/builds/release/1.1/ ).

Once replaced this lib, the wado service init ok, then the web interface show the images correctly....this additional step is only for amd64 compiled distributions.

Thanks !

...

[Prakash Jayaraman]

What about the OS? Is that 64 Bit? If so, please make sure you had downgraded the Java Advanced Imaging linux library file libclib_jiio.so.

On Mon, Apr 21, 2014 at 7:33 PM, Ramón Retamar <ramonr...@gmail.com> wrote:

Hi.
I install the dcm4chee 2.18.0 using MYSQL 5.5.35 in Debian Gnu/Linux (a clean-installation) in a test-PC.

The server gets and retrieve studies without problems from/to GinkgoCADx viewer, the web interface works fine for search and show dicom fields for the patients....but not display images in web interface: show the legend "loading" instrad of image.

When start dcm4chee, it show this error into log:

10:27:49,446 ERROR [URLDeploymentScanner] Incomplete Deployment listing:

--- Incompletely deployed packages ---
org.jboss.deployment.DeploymentInfo@c4a755d7 { url=file:/opt/dcm4chee-2.18.0-mysql/server/default/deploy/dcm4chee-wado-service.xml }
  deployer: org.jboss.deployment.SARDeployer@48082d37
  status: Deployment FAILED reason: - nested throwable: (java.lang.reflect.InvocationTargetException)
  state: FAILED
  watch: file:/opt/dcm4chee-2.18.0-mysql/server/default/deploy/dcm4chee-wado-service.xml
  altDD: null
  lastDeployed: 1398086857414
  lastModified: 1398086857000
  mbeans:

When i try to view any images from web interface, the dcm4chee works this:

Any idea ?

Thanks

Ramon

--
You received this message because you are subscribed to the Google Groups "dcm4che" group.
To unsubscribe from this group and stop receiving emails from it, send an email to dcm4che+u...@googlegroups.com.
To post to this group, send email to dcm...@googlegroups.com.
Visit this group at http://groups.google.com/group/dcm4che.
For more options, visit https://groups.google.com/d/optout.

[Stephane Siewe]

Hi

i use windows 8.1 *64. I tryed your issue but it still doesn't work for me.

Another Idea?

Thx

Stephane