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

  JBoss Bootstrap Environment

  JBOSS_HOME: /dcom/dcm4chee-2.17.1-mysql

  JAVA: java

  JAVA_OPTS: -Dprogram.name=run.sh -server -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=/dcom/dcm4chee-2.17.1-mysql/bin/native

  CLASSPATH: /dcom/dcm4chee-2.17.1-mysql/bin/run.jar

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

23:37:20,479 INFO  [Server] Starting JBoss (MX MicroKernel)...
23:37:20,480 INFO  [Server] Release ID: JBoss [Trinity] 4.2.3.GA (build: SVNTag=JBoss_4_2_3_GA date=200807181417)
23:37:20,480 INFO  [Server] Home Dir: /dcom/dcm4chee-2.17.1-mysql
23:37:20,481 INFO  [Server] Home URL: file:/dcom/dcm4chee-2.17.1-mysql/
23:37:20,481 INFO  [Server] Patch URL: null
23:37:20,481 INFO  [Server] Server Name: default
23:37:20,481 INFO  [Server] Server Home Dir: /dcom/dcm4chee-2.17.1-mysql/server/default
23:37:20,481 INFO  [Server] Server Home URL: file:/dcom/dcm4chee-2.17.1-mysql/server/default/
23:37:20,481 INFO  [Server] Server Log Dir: /dcom/dcm4chee-2.17.1-mysql/server/default/log
23:37:20,482 INFO  [Server] Server Temp Dir: /dcom/dcm4chee-2.17.1-mysql/server/default/tmp
23:37:20,482 INFO  [Server] Root Deployment Filename: jboss-service.xml
23:37:20,661 INFO  [ServerInfo] Java version: 1.6.0_31,Sun Microsystems Inc.
23:37:20,661 INFO  [ServerInfo] Java VM: Java HotSpot(TM) 64-Bit Server VM 20.6-b01,Sun Microsystems Inc.
23:37:20,661 INFO  [ServerInfo] OS-System: Linux 2.6.32-358.el6.x86_64,amd64
23:37:20,861 INFO  [Server] Core system initialized
23:37:22,434 INFO  [WebService] Using RMI server codebase: http://atipacs.cmh.net:8083/
23:37:22,435 INFO  [Log4jService$URLWatchTimerTask] Configuring from URL: resource:jboss-log4j.xml
23:37:22,734 INFO  [TransactionManagerService] JBossTS Transaction Service (JTA version) - JBoss Inc.
23:37:22,734 INFO  [TransactionManagerService] Setting up property manager MBean and JMX layer
23:37:22,845 INFO  [TransactionManagerService] Starting recovery manager
23:37:22,900 INFO  [TransactionManagerService] Recovery manager started
23:37:22,900 INFO  [TransactionManagerService] Binding TransactionManager JNDI Reference
23:37:24,421 INFO  [EJB3Deployer] Starting java:comp multiplexer
23:37:26,306 INFO  [NativeServerConfig] JBoss Web Services - Native
23:37:26,306 INFO  [NativeServerConfig] jbossws-3.0.1-native-2.0.4.GA (build=200803312044)
23:37:35,010 INFO  [Embedded] Catalina naming disabled
23:37:35,102 INFO  [AprLifecycleListener] The Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path: /dcom/dcm4chee-2.17.1-mysql/bin/native
23:37:35,135 INFO  [Http11Protocol] Initializing Coyote HTTP/1.1 on http-0.0.0.0-8080
23:37:35,410 INFO  [Http11Protocol] Initializing Coyote HTTP/1.1 on http-8443
23:37:35,411 INFO  [AjpProtocol] Initializing Coyote AJP/1.3 on ajp-0.0.0.0-8009
23:37:35,411 INFO  [Catalina] Initialization processed in 401 ms
23:37:35,411 INFO  [StandardService] Starting service jboss.web
23:37:35,413 INFO  [StandardEngine] Starting Servlet Engine: JBossWeb/2.0.1.GA
23:37:35,450 INFO  [Catalina] Server startup in 39 ms
23:37:35,771 INFO  [TomcatDeployer] deploy, ctxPath=/, warUrl=.../deploy/jboss-web.deployer/ROOT.war/
23:37:36,109 INFO  [TomcatDeployer] deploy, ctxPath=/invoker, warUrl=.../deploy/http-invoker.sar/invoker.war/
23:37:36,181 INFO  [TomcatDeployer] deploy, ctxPath=/jbossws, warUrl=.../deploy/jbossws.sar/jbossws-context.war/
23:37:36,480 INFO  [TomcatDeployer] deploy, ctxPath=/web-console, warUrl=.../deploy/management/console-mgr.sar/web-console.war/
23:37:37,021 INFO  [MailService] Mail Service bound to java:/Mail
23:37:37,153 INFO  [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/jboss-ha-local-jdbc.rar
23:37:37,191 INFO  [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/jboss-ha-xa-jdbc.rar
23:37:37,210 INFO  [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/jboss-local-jdbc.rar
23:37:37,227 INFO  [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/jboss-xa-jdbc.rar
23:37:37,262 INFO  [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/jms-ra.rar
23:37:37,278 INFO  [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/quartz-ra.rar
23:37:37,284 INFO  [QuartzResourceAdapter] start quartz!!!
23:37:37,351 INFO  [SimpleThreadPool] Job execution threads will use class loader of thread: main
23:37:37,365 INFO  [QuartzScheduler] Quartz Scheduler v.1.5.2 created.
23:37:37,366 INFO  [RAMJobStore] RAMJobStore initialized.
23:37:37,367 INFO  [StdSchedulerFactory] Quartz scheduler 'DefaultQuartzScheduler' initialized from default resource file in Quartz package: 'quartz.properties'
23:37:37,367 INFO  [StdSchedulerFactory] Quartz scheduler version: 1.5.2
23:37:37,367 INFO  [QuartzScheduler] Scheduler DefaultQuartzScheduler_$_NON_CLUSTERED started.
23:37:37,716 INFO  [ConnectionFactoryBindingService] Bound ConnectionManager 'jboss.jca:service=DataSourceBinding,name=arrDS' to JNDI name 'java:arrDS'
23:37:37,776 INFO  [ConnectionFactoryBindingService] Bound ConnectionManager 'jboss.jca:service=ConnectionFactoryBinding,name=JmsXA' to JNDI name 'java:JmsXA'
23:37:37,805 INFO  [ConnectionFactoryBindingService] Bound ConnectionManager 'jboss.jca:service=DataSourceBinding,name=pacsDS' to JNDI name 'java:pacsDS'
23:37:38,179 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.
23:37:38,212 INFO  [ServerPeer] JBoss Messaging 1.4.2.GA server [0] started
23:37:38,450 INFO  [ConnectionFactory] Connector bisocket://atipacs.cmh.net:4457 has leasing enabled, lease period 10000 milliseconds
23:37:38,450 INFO  [ConnectionFactory] org.jboss.jms.server.connectionfactory.ConnectionFactory@547b6d1c started
23:37:38,452 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
23:37:38,452 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
23:37:38,459 INFO  [ConnectionFactory] Connector bisocket://atipacs.cmh.net:4457 has leasing enabled, lease period 10000 milliseconds
23:37:38,459 INFO  [ConnectionFactory] org.jboss.jms.server.connectionfactory.ConnectionFactory@70ee90b1 started
23:37:38,459 INFO  [ConnectionFactory] Connector bisocket://atipacs.cmh.net:4457 has leasing enabled, lease period 10000 milliseconds
23:37:38,459 INFO  [ConnectionFactory] org.jboss.jms.server.connectionfactory.ConnectionFactory@1af6a711 started
23:37:38,487 INFO  [QueueService] Queue[/queue/DLQ] started, fullSize=200000, pageSize=2000, downCacheSize=2000
23:37:38,490 INFO  [QueueService] Queue[/queue/ExpiryQueue] started, fullSize=200000, pageSize=2000, downCacheSize=2000
23:37:38,492 INFO  [QueueService] Queue[/queue/AttributesModificationScu] started, fullSize=500, pageSize=100, downCacheSize=100
23:37:38,494 INFO  [QueueService] Queue[/queue/DeleteStudy] started, fullSize=500, pageSize=100, downCacheSize=100
23:37:38,498 INFO  [QueueService] Queue[/queue/ExportManager] started, fullSize=500, pageSize=100, downCacheSize=100
23:37:38,500 INFO  [QueueService] Queue[/queue/FileCopy] started, fullSize=500, pageSize=100, downCacheSize=100
23:37:38,502 INFO  [QueueService] Queue[/queue/FileMove] started, fullSize=500, pageSize=100, downCacheSize=100
23:37:38,505 INFO  [QueueService] Queue[/queue/HL7Send] started, fullSize=500, pageSize=100, downCacheSize=100
23:37:38,507 INFO  [QueueService] Queue[/queue/IANScu] started, fullSize=500, pageSize=100, downCacheSize=100
23:37:38,509 INFO  [QueueService] Queue[/queue/MCMScu] started, fullSize=500, pageSize=100, downCacheSize=100
23:37:38,511 INFO  [QueueService] Queue[/queue/MoveScu] started, fullSize=500, pageSize=100, downCacheSize=100
23:37:38,514 INFO  [QueueService] Queue[/queue/MPPSScu] started, fullSize=500, pageSize=100, downCacheSize=100
23:37:38,516 INFO  [QueueService] Queue[/queue/PPSExceptionMgt] started, fullSize=500, pageSize=100, downCacheSize=100
23:37:38,518 INFO  [QueueService] Queue[/queue/PPSScu] started, fullSize=500, pageSize=100, downCacheSize=100
23:37:38,521 INFO  [QueueService] Queue[/queue/Prefetch] started, fullSize=500, pageSize=100, downCacheSize=100
23:37:38,523 INFO  [QueueService] Queue[/queue/RejectionNoteStored] started, fullSize=500, pageSize=100, downCacheSize=100
23:37:38,525 INFO  [QueueService] Queue[/queue/Sendmail] started, fullSize=500, pageSize=100, downCacheSize=100
23:37:39,788 INFO  [QueueService] Queue[/queue/StgCmtScuScp] started, fullSize=500, pageSize=100, downCacheSize=100
23:37:39,790 INFO  [QueueService] Queue[/queue/StudyMgtScu] started, fullSize=500, pageSize=100, downCacheSize=100
23:37:39,792 INFO  [QueueService] Queue[/queue/UpgradeToEnhancedMF] started, fullSize=500, pageSize=100, downCacheSize=100
23:37:39,794 INFO  [QueueService] Queue[/queue/UPSScp] started, fullSize=500, pageSize=100, downCacheSize=100
23:37:39,796 INFO  [QueueService] Queue[/queue/WadoPrefetch] started, fullSize=500, pageSize=100, downCacheSize=100
23:37:40,335 INFO  [EjbModule] Deploying PrivateInstance
23:37:40,397 INFO  [EjbModule] Deploying MWLItem
23:37:40,402 INFO  [EjbModule] Deploying VerifyingObserver
23:37:40,407 INFO  [EjbModule] Deploying Device
23:37:40,411 INFO  [EjbModule] Deploying UPSRelatedPS
23:37:40,415 INFO  [EjbModule] Deploying PrivateFile
23:37:40,419 INFO  [EjbModule] Deploying Media
23:37:40,423 INFO  [EjbModule] Deploying PrivateStudy
23:37:40,426 INFO  [EjbModule] Deploying PrivatePatient
23:37:40,430 INFO  [EjbModule] Deploying Code
23:37:40,434 INFO  [EjbModule] Deploying HP
23:37:40,437 INFO  [EjbModule] Deploying MPPS
23:37:40,441 INFO  [EjbModule] Deploying Patient
23:37:40,445 INFO  [EjbModule] Deploying Instance
23:37:40,449 INFO  [EjbModule] Deploying StudyPermission
23:37:40,454 INFO  [EjbModule] Deploying AE
23:37:40,486 INFO  [EjbModule] Deploying UPSSubscription
23:37:40,491 INFO  [EjbModule] Deploying FileSystem
23:37:40,495 INFO  [EjbModule] Deploying UPSGlobalSubscription
23:37:40,500 INFO  [EjbModule] Deploying GPSPSPerformer
23:37:40,504 INFO  [EjbModule] Deploying OtherPatientID
23:37:40,508 INFO  [EjbModule] Deploying Series
23:37:40,513 INFO  [EjbModule] Deploying StudyOnFileSystem
23:37:40,517 INFO  [EjbModule] Deploying UPSRequest
23:37:40,521 INFO  [EjbModule] Deploying UPSReplacedPS
23:37:40,526 INFO  [EjbModule] Deploying File
23:37:40,530 INFO  [EjbModule] Deploying SeriesRequest
23:37:40,534 INFO  [EjbModule] Deploying HPDefinition
23:37:40,538 INFO  [EjbModule] Deploying PrivateSeries
23:37:40,543 INFO  [EjbModule] Deploying GPSPSRequest
23:37:40,546 INFO  [EjbModule] Deploying UPS
23:37:40,551 INFO  [EjbModule] Deploying GPSPS
23:37:40,555 INFO  [EjbModule] Deploying ContentItem
23:37:40,558 INFO  [EjbModule] Deploying Study
23:37:40,563 INFO  [EjbModule] Deploying GPPPS
23:37:40,567 INFO  [EjbModule] Deploying Issuer
23:37:40,571 INFO  [EjbModule] Deploying GPPPSManager
23:37:40,582 INFO  [EjbModule] Deploying GPWLManager
23:37:40,586 INFO  [EjbModule] Deploying StudyMgt
23:37:40,589 INFO  [EjbModule] Deploying PIXQuery
23:37:40,592 INFO  [EjbModule] Deploying UpdateAttributes
23:37:40,596 INFO  [EjbModule] Deploying HPStorage
23:37:40,599 INFO  [EjbModule] Deploying MWLManager
23:37:40,602 INFO  [EjbModule] Deploying UPSManager
23:37:40,605 INFO  [EjbModule] Deploying AvailabilityUpdate
23:37:40,609 INFO  [EjbModule] Deploying ConsistencyCheck
23:37:40,620 INFO  [EjbModule] Deploying StudyPermissionManager
23:37:40,624 INFO  [EjbModule] Deploying UserManager
23:37:40,631 INFO  [EjbModule] Deploying MPPSManager
23:37:40,635 INFO  [EjbModule] Deploying MediaComposer
23:37:40,639 INFO  [EjbModule] Deploying ContentEdit
23:37:40,642 INFO  [EjbModule] Deploying ContentManager
23:37:40,646 INFO  [EjbModule] Deploying SoundexUpdate
23:37:40,650 INFO  [EjbModule] Deploying PrivateManager
23:37:40,654 INFO  [EjbModule] Deploying StudyReconciliation
23:37:40,658 INFO  [EjbModule] Deploying CodeToDeviceMapping
23:37:40,662 INFO  [EjbModule] Deploying MPPSEmulator
23:37:40,673 INFO  [EjbModule] Deploying AttributesModification
23:37:40,681 INFO  [EjbModule] Deploying PatientUpdate
23:37:40,690 INFO  [EjbModule] Deploying FixPatientAttributes
23:37:40,694 INFO  [EjbModule] Deploying FileSystemMgt2
23:37:40,698 INFO  [EjbModule] Deploying Storage
23:37:40,702 INFO  [EjbModule] Deploying AEManager
23:37:43,383 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'PrivateInstance' to jndi 'ejb/PrivateInstance'
23:37:43,398 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'MWLItem' to jndi 'ejb/MWLItem'
23:37:43,408 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'VerifyingObserver' to jndi 'ejb/VerifyingObserver'
23:37:43,413 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'Device' to jndi 'ejb/Device'
23:37:43,421 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'UPSRelatedPS' to jndi 'ejb/UPSRelatedPS'
23:37:43,437 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'PrivateFile' to jndi 'ejb/PrivateFile'
23:37:43,442 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'Media' to jndi 'ejb/Media'
23:37:43,452 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'PrivateStudy' to jndi 'ejb/PrivateStudy'
23:37:43,459 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'PrivatePatient' to jndi 'ejb/PrivatePatient'
23:37:43,468 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'Code' to jndi 'ejb/Code'
23:37:43,484 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'HP' to jndi 'ejb/HP'
23:37:43,495 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'MPPS' to jndi 'ejb/MPPS'
23:37:43,511 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'Patient' to jndi 'ejb/Patient'
23:37:43,519 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'Instance' to jndi 'ejb/Instance'
23:37:43,530 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'StudyPermission' to jndi 'ejb/StudyPermission'
23:37:43,542 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'AE' to jndi 'ejb/AE'
23:37:43,549 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'UPSSubscription' to jndi 'ejb/UPSSubscription'
23:37:43,563 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'FileSystem' to jndi 'ejb/FileSystem'
23:37:43,570 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'UPSGlobalSubscription' to jndi 'ejb/UPSGlobalSubscription'
23:37:43,584 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'GPSPSPerformer' to jndi 'ejb/GPSPSPerformer'
23:37:43,588 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'OtherPatientID' to jndi 'ejb/OtherPatientID'
23:37:43,606 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'Series' to jndi 'ejb/Series'
23:37:43,611 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'StudyOnFileSystem' to jndi 'ejb/StudyOnFileSystem'
23:37:43,619 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'UPSRequest' to jndi 'ejb/UPSRequest'
23:37:43,629 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'UPSReplacedPS' to jndi 'ejb/UPSReplacedPS'
23:37:43,634 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'File' to jndi 'ejb/File'
23:37:43,643 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'SeriesRequest' to jndi 'ejb/SeriesRequest'
23:37:43,654 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'HPDefinition' to jndi 'ejb/HPDefinition'
23:37:43,658 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'PrivateSeries' to jndi 'ejb/PrivateSeries'
23:37:43,667 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'GPSPSRequest' to jndi 'ejb/GPSPSRequest'
23:37:43,678 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'UPS' to jndi 'ejb/UPS'
23:37:43,692 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'GPSPS' to jndi 'ejb/GPSPS'
23:37:43,704 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'ContentItem' to jndi 'ejb/ContentItem'
23:37:43,715 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'Study' to jndi 'ejb/Study'
23:37:43,726 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'GPPPS' to jndi 'ejb/GPPPS'
23:37:43,730 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'Issuer' to jndi 'ejb/Issuer'
23:37:43,766 INFO  [ProxyFactory] Bound EJB Home 'GPPPSManager' to jndi 'ejb/GPPPSManager'
23:37:43,773 INFO  [ProxyFactory] Bound EJB Home 'GPWLManager' to jndi 'ejb/GPWLManager'
23:37:43,781 INFO  [ProxyFactory] Bound EJB Home 'StudyMgt' to jndi 'ejb/StudyMgt'
23:37:43,787 INFO  [ProxyFactory] Bound EJB Home 'PIXQuery' to jndi 'ejb/PIXQuery'
23:37:43,795 INFO  [ProxyFactory] Bound EJB Home 'UpdateAttributes' to jndi 'ejb/UpdateAttributes'
23:37:43,802 INFO  [ProxyFactory] Bound EJB Home 'HPStorage' to jndi 'ejb/HPStorage'
23:37:43,809 INFO  [ProxyFactory] Bound EJB Home 'MWLManager' to jndi 'ejb/MWLManager'
23:37:43,820 INFO  [ProxyFactory] Bound EJB Home 'UPSManager' to jndi 'ejb/UPSManager'
23:37:43,826 INFO  [ProxyFactory] Bound EJB Home 'AvailabilityUpdate' to jndi 'ejb/AvailabilityUpdate'
23:37:43,833 INFO  [ProxyFactory] Bound EJB Home 'ConsistencyCheck' to jndi 'ejb/ConsistencyCheck'
23:37:43,841 INFO  [ProxyFactory] Bound EJB Home 'StudyPermissionManager' to jndi 'ejb/StudyPermissionManager'
23:37:43,849 INFO  [ProxyFactory] Bound EJB Home 'UserManager' to jndi 'ejb/UserManager'
23:37:43,857 INFO  [ProxyFactory] Bound EJB Home 'MPPSManager' to jndi 'ejb/MPPSManager'
23:37:43,866 INFO  [ProxyFactory] Bound EJB Home 'MediaComposer' to jndi 'ejb/MediaComposer'
23:37:43,873 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'ContentEdit' to jndi 'ContentEditLocal'
23:37:43,880 INFO  [ProxyFactory] Bound EJB Home 'ContentEdit' to jndi 'ejb/ContentEdit'
23:37:43,891 INFO  [ProxyFactory] Bound EJB Home 'ContentManager' to jndi 'ejb/ContentManager'
23:37:43,898 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'SoundexUpdate' to jndi 'SoundexUpdateLocal'
23:37:43,902 INFO  [ProxyFactory] Bound EJB Home 'SoundexUpdate' to jndi 'ejb/SoundexUpdate'
23:37:43,911 INFO  [ProxyFactory] Bound EJB Home 'PrivateManager' to jndi 'ejb/PrivateManager'
23:37:43,919 INFO  [ProxyFactory] Bound EJB Home 'StudyReconciliation' to jndi 'ejb/StudyReconciliation'
23:37:43,926 INFO  [ProxyFactory] Bound EJB Home 'CodeToDeviceMapping' to jndi 'ejb/CodeToDeviceMapping'
23:37:43,933 INFO  [ProxyFactory] Bound EJB Home 'MPPSEmulator' to jndi 'ejb/MPPSEmulator'
23:37:43,942 INFO  [ProxyFactory] Bound EJB Home 'AttributesModification' to jndi 'ejb/AttributesModification'
23:37:43,948 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'PatientUpdate' to jndi 'PatientUpdateLocal'
23:37:43,953 INFO  [ProxyFactory] Bound EJB Home 'PatientUpdate' to jndi 'ejb/PatientUpdate'
23:37:43,960 INFO  [ProxyFactory] Bound EJB Home 'FixPatientAttributes' to jndi 'ejb/FixPatientAttributes'
23:37:43,970 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'FileSystemMgt2' to jndi 'FileSystemMgt2Local'
23:37:43,981 INFO  [ProxyFactory] Bound EJB Home 'FileSystemMgt2' to jndi 'ejb/FileSystemMgt2'
23:37:44,005 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'Storage' to jndi 'StorageLocal'
23:37:44,023 INFO  [ProxyFactory] Bound EJB Home 'Storage' to jndi 'ejb/Storage'
23:37:44,037 INFO  [ProxyFactory] Bound EJB Home 'AEManager' to jndi 'ejb/AEManager'
23:37:44,045 INFO  [EJBDeployer] Deployed: file:/dcom/dcm4chee-2.17.1-mysql/server/default/deploy/dcm4chee-ejb-mysql.jar
23:37:44,229 INFO  [TomcatDeployer] deploy, ctxPath=/rid, warUrl=.../tmp/deploy/tmp5152563152950932529dcm4chee-rid-exp.war/
23:37:44,309 INFO  [RIDServiceDelegate] RIDServiceDelegate initialized
23:37:44,316 INFO  [RIDServiceDelegate] RIDServiceDelegate initialized
23:37:44,382 INFO  [TomcatDeployer] deploy, ctxPath=/wado, warUrl=.../tmp/deploy/tmp2942265469558026759dcm4chee-wado-exp.war/
23:37:44,453 INFO  [TomcatDeployer] deploy, ctxPath=/jmx-console, warUrl=.../deploy/jmx-console.war/
23:37:44,562 INFO  [EARDeployer] Init J2EE application: file:/dcom/dcm4chee-2.17.1-mysql/server/default/deploy/dcm4chee-arr-3.0.11-mysql.ear
23:37:46,195 INFO  [QueueService] Queue[/queue/ARRIncoming] started, fullSize=200000, pageSize=2000, downCacheSize=2000
23:37:46,347 INFO  [TCPListener] Started TCP Server listening on /0.0.0.0:6514
23:37:46,361 INFO  [UDPListener] Started UDP Server listening on 0.0.0.0/0.0.0.0:4000
23:37:46,525 INFO  [SchedulerService] Start Scheduler CheckPendingSeriesStored with period of 60000ms in 1 s.
23:37:46,557 INFO  [SchedulerService] Start Scheduler DeleteOrphanedPrivateFiles with period of 60000ms in 1 s.
23:37:46,558 INFO  [SchedulerService] Start Scheduler DeleteOrphanedPrivateFiles with period of 60000ms in 1 s.
23:37:46,651 INFO  [JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.mdb.MDB
23:37:46,655 INFO  [JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-arr-3.0.11-mysql.ear,jar=dcm4chee-arr-listeners-mdb-3.0.11.jar,name=ReceiverMDB,service=EJB3 with dependencies:
23:37:46,656 INFO  [JmxKernelAbstraction] 	persistence.units:ear=dcm4chee-arr-3.0.11-mysql.ear,unitName=dcm4chee-arr
23:37:46,657 INFO  [EJB3Deployer] Deployed: file:/dcom/dcm4chee-2.17.1-mysql/server/default/tmp/deploy/tmp4487493803678035995dcm4chee-arr-3.0.11-mysql.ear-contents/dcm4chee-arr-listeners-mdb-3.0.11.jar
23:37:46,793 INFO  [JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
23:37:46,795 INFO  [JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-arr-3.0.11-mysql.ear,jar=dcm4chee-arr-seam-ejb-3.0.11.jar,name=AuditRecordAccessBean,service=EJB3 with dependencies:
23:37:46,796 INFO  [JmxKernelAbstraction] 	persistence.units:ear=dcm4chee-arr-3.0.11-mysql.ear,unitName=dcm4chee-arr
23:37:46,804 INFO  [JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
23:37:46,804 INFO  [JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-arr-3.0.11-mysql.ear,jar=dcm4chee-arr-seam-ejb-3.0.11.jar,name=AuditRecordQueryBean,service=EJB3 with dependencies:
23:37:46,804 INFO  [JmxKernelAbstraction] 	persistence.units:ear=dcm4chee-arr-3.0.11-mysql.ear,unitName=dcm4chee-arr
23:37:46,804 INFO  [JmxKernelAbstraction] 	jboss.j2ee:ear=dcm4chee-arr-3.0.11-mysql.ear,jar=dcm4chee-arr-seam-ejb-3.0.11.jar,name=AuditLogUsedBean,service=EJB3
23:37:46,805 INFO  [JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
23:37:46,805 INFO  [JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-arr-3.0.11-mysql.ear,jar=dcm4chee-arr-seam-ejb-3.0.11.jar,name=AuditLogUsedBean,service=EJB3 with dependencies:
23:37:46,827 INFO  [EJBContainer] STARTED EJB: org.dcm4chee.arr.seam.ejb.AuditLogUsedBean ejbName: AuditLogUsedBean
23:37:46,845 INFO  [JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateful.StatefulContainer
23:37:46,848 INFO  [JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-arr-3.0.11-mysql.ear,jar=dcm4chee-arr-seam-ejb-3.0.11.jar,name=AuditRecordListAction,service=EJB3 with dependencies:
23:37:46,848 INFO  [JmxKernelAbstraction] 	persistence.units:ear=dcm4chee-arr-3.0.11-mysql.ear,unitName=dcm4chee-arr
23:37:46,848 INFO  [JmxKernelAbstraction] 	jboss.j2ee:ear=dcm4chee-arr-3.0.11-mysql.ear,jar=dcm4chee-arr-seam-ejb-3.0.11.jar,name=AuditLogUsedBean,service=EJB3
23:37:46,849 INFO  [EJB3Deployer] Deployed: file:/dcom/dcm4chee-2.17.1-mysql/server/default/tmp/deploy/tmp4487493803678035995dcm4chee-arr-3.0.11-mysql.ear-contents/dcm4chee-arr-seam-ejb-3.0.11.jar
23:37:46,850 INFO  [JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.entity.PersistenceUnitDeployment
23:37:46,851 INFO  [JmxKernelAbstraction] installing MBean: persistence.units:ear=dcm4chee-arr-3.0.11-mysql.ear,unitName=dcm4chee-arr with dependencies:
23:37:46,851 INFO  [JmxKernelAbstraction] 	jboss.jca:name=arrDS,service=DataSourceBinding
23:37:46,853 INFO  [PersistenceUnitDeployment] Starting persistence unit persistence.units:ear=dcm4chee-arr-3.0.11-mysql.ear,unitName=dcm4chee-arr
23:37:46,874 INFO  [Version] Hibernate EntityManager 3.2.1.GA
23:37:46,888 INFO  [Version] Hibernate Annotations 3.2.1.GA
23:37:46,894 INFO  [Environment] Hibernate 3.2.4.sp1
23:37:46,900 INFO  [Environment] hibernate.properties not found
23:37:46,902 INFO  [Environment] Bytecode provider name : javassist
23:37:46,907 INFO  [Environment] using JDK 1.4 java.sql.Timestamp handling
23:37:47,006 INFO  [Ejb3Configuration] Processing PersistenceUnitInfo [
	name: dcm4chee-arr
	...]
23:37:47,010 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.arr.entities.ActiveParticipant
23:37:47,012 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.arr.entities.ParticipantObject
23:37:47,013 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.arr.entities.Code
23:37:47,014 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.arr.entities.AuditRecord
23:37:47,037 INFO  [Configuration] Reading mappings from resource : META-INF/orm.xml
23:37:47,040 INFO  [Ejb3Configuration] [PersistenceUnit: dcm4chee-arr] no META-INF/orm.xml found
23:37:47,092 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.arr.entities.ActiveParticipant
23:37:47,537 INFO  [EntityBinder] Bind entity org.dcm4chee.arr.entities.ActiveParticipant on table active_part
23:37:47,572 INFO  [FileSystemMgt2Service] Check file system group LOSSY_STORAGE for deletion of orphaned private files
23:37:47,581 INFO  [FileSystemMgt2Service] Check file system group ONLINE_STORAGE for deletion of orphaned private files
23:37:47,697 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.arr.entities.ParticipantObject
23:37:47,698 INFO  [EntityBinder] Bind entity org.dcm4chee.arr.entities.ParticipantObject on table part_obj
23:37:47,701 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.arr.entities.Code
23:37:47,701 INFO  [EntityBinder] Bind entity org.dcm4chee.arr.entities.Code on table code
23:37:47,703 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.arr.entities.AuditRecord
23:37:47,703 INFO  [EntityBinder] Bind entity org.dcm4chee.arr.entities.AuditRecord on table audit_record
23:37:47,814 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.arr.entities.AuditRecord.activeParticipants -> active_part
23:37:47,816 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.arr.entities.AuditRecord.participantObjects -> part_obj
23:37:47,877 INFO  [ConnectionProviderFactory] Initializing connection provider: org.hibernate.ejb.connection.InjectedDataSourceConnectionProvider
23:37:47,884 INFO  [InjectedDataSourceConnectionProvider] Using provided datasource
23:37:47,898 INFO  [SettingsFactory] RDBMS: MySQL, version: 5.5.34
23:37:47,899 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 $ )
23:37:47,917 INFO  [Dialect] Using dialect: org.hibernate.dialect.MySQLInnoDBDialect
23:37:47,921 INFO  [TransactionFactoryFactory] Transaction strategy: org.hibernate.ejb.transaction.JoinableCMTTransactionFactory
23:37:47,923 INFO  [TransactionManagerLookupFactory] instantiating TransactionManagerLookup: org.hibernate.transaction.JBossTransactionManagerLookup
23:37:47,925 INFO  [TransactionManagerLookupFactory] instantiated TransactionManagerLookup
23:37:47,926 INFO  [SettingsFactory] Automatic flush during beforeCompletion(): disabled
23:37:47,926 INFO  [SettingsFactory] Automatic session close at end of transaction: disabled
23:37:47,926 INFO  [SettingsFactory] JDBC batch size: 15
23:37:47,926 INFO  [SettingsFactory] JDBC batch updates for versioned data: disabled
23:37:47,926 INFO  [SettingsFactory] Scrollable result sets: enabled
23:37:47,927 INFO  [SettingsFactory] JDBC3 getGeneratedKeys(): disabled
23:37:47,927 INFO  [SettingsFactory] Connection release mode: auto
23:37:47,928 INFO  [SettingsFactory] Maximum outer join fetch depth: 2
23:37:47,928 INFO  [SettingsFactory] Default batch fetch size: 1
23:37:47,928 INFO  [SettingsFactory] Generate SQL with comments: disabled
23:37:47,928 INFO  [SettingsFactory] Order SQL updates by primary key: disabled
23:37:47,928 INFO  [SettingsFactory] Order SQL inserts for batching: disabled
23:37:47,928 INFO  [SettingsFactory] Query translator: org.hibernate.hql.ast.ASTQueryTranslatorFactory
23:37:47,931 INFO  [ASTQueryTranslatorFactory] Using ASTQueryTranslatorFactory
23:37:47,931 INFO  [SettingsFactory] Query language substitutions: {}
23:37:47,931 INFO  [SettingsFactory] JPA-QL strict compliance: enabled
23:37:47,931 INFO  [SettingsFactory] Second-level cache: enabled
23:37:47,931 INFO  [SettingsFactory] Query cache: disabled
23:37:47,931 INFO  [SettingsFactory] Cache provider: org.hibernate.cache.HashtableCacheProvider
23:37:47,932 INFO  [SettingsFactory] Optimize cache for minimal puts: disabled
23:37:47,933 INFO  [SettingsFactory] Cache region prefix: dcm4chee-arr-3_0_11-mysql_ear,dcm4chee-arr
23:37:47,933 INFO  [SettingsFactory] Structured second-level cache entries: disabled
23:37:47,939 INFO  [SettingsFactory] Statistics: disabled
23:37:47,939 INFO  [SettingsFactory] Deleted entity synthetic identifier rollback: disabled
23:37:47,940 INFO  [SettingsFactory] Default entity-mode: pojo
23:37:47,940 INFO  [SettingsFactory] Named query checking : enabled
23:37:47,964 INFO  [SessionFactoryImpl] building session factory
23:37:48,163 INFO  [SessionFactoryObjectFactory] Factory name: persistence.units:ear=dcm4chee-arr-3.0.11-mysql.ear,unitName=dcm4chee-arr
23:37:48,164 INFO  [NamingHelper] JNDI InitialContext properties:{java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces}
23:37:48,166 INFO  [SessionFactoryObjectFactory] Bound factory to JNDI name: persistence.units:ear=dcm4chee-arr-3.0.11-mysql.ear,unitName=dcm4chee-arr
23:37:48,167 WARN  [SessionFactoryObjectFactory] InitialContext did not implement EventContext
23:37:48,170 INFO  [SchemaUpdate] Running hbm2ddl schema update
23:37:48,170 INFO  [SchemaUpdate] fetching database metadata
23:37:48,171 INFO  [SchemaUpdate] updating schema
23:37:48,189 INFO  [TableMetadata] table found: arrdb.active_part
23:37:48,189 INFO  [TableMetadata] columns: [user_name, net_access_pt_type, alt_user_id, user_id, audit_record_fk, role_id_fk, net_access_pt_id, requestor, pk]
23:37:48,189 INFO  [TableMetadata] foreign keys: [fkc154118c9f9901b4, fkc154118c327533d4]
23:37:48,189 INFO  [TableMetadata] indexes: [fkc154118c9f9901b4, fkc154118c327533d4, primary]
23:37:48,194 INFO  [TableMetadata] table found: arrdb.audit_record
23:37:48,194 INFO  [TableMetadata] columns: [xmldata, event_outcome, event_action, source_id, source_type, site_id, event_type_fk, event_date_time, event_id_fk, receive_date_time, iheyr4, pk]
23:37:48,194 INFO  [TableMetadata] foreign keys: [fkaf55d13517670399, fkaf55d1354d8cc8d8]
23:37:48,194 INFO  [TableMetadata] indexes: [ar_receive_date_ti, primary, ar_event_date_time, fkaf55d13517670399, fkaf55d1354d8cc8d8]
23:37:48,197 INFO  [TableMetadata] table found: arrdb.code
23:37:48,197 INFO  [TableMetadata] columns: [code_designator, code_value, code_meaning, pk]
23:37:48,197 INFO  [TableMetadata] foreign keys: []
23:37:48,197 INFO  [TableMetadata] indexes: [primary, code_value]
23:37:48,201 INFO  [TableMetadata] table found: arrdb.part_obj
23:37:48,201 INFO  [TableMetadata] columns: [obj_id_type_fk, obj_id_type_rfc, name, obj_sensitivity, obj_role, audit_record_fk, obj_id, data_life_cycle, obj_type, pk]
23:37:48,201 INFO  [TableMetadata] foreign keys: [fk46d80eab57a24562, fk46d80eab327533d4]
23:37:48,201 INFO  [TableMetadata] indexes: [primary, fk46d80eab57a24562, fk46d80eab327533d4]
23:37:48,201 INFO  [SchemaUpdate] schema update complete
23:37:48,203 INFO  [NamingHelper] JNDI InitialContext properties:{java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces}
23:37:48,212 INFO  [EJBContainer] STARTED EJB: org.dcm4chee.arr.listeners.mdb.ReceiverMDB ejbName: ReceiverMDB
23:37:48,248 INFO  [EJBContainer] STARTED EJB: org.dcm4chee.arr.seam.ejb.AuditRecordAccessBean ejbName: AuditRecordAccessBean
23:37:48,313 INFO  [EJBContainer] STARTED EJB: org.dcm4chee.arr.seam.ejb.AuditRecordQueryBean ejbName: AuditRecordQueryBean
23:37:48,349 INFO  [EJBContainer] STARTED EJB: org.dcm4chee.arr.seam.ejb.AuditRecordListAction ejbName: AuditRecordListAction
23:37:48,394 INFO  [EJB3Deployer] Deployed: file:/dcom/dcm4chee-2.17.1-mysql/server/default/tmp/deploy/tmp4487493803678035995dcm4chee-arr-3.0.11-mysql.ear-contents/lib/dcm4chee-arr-entities-3.0.11-mysql.jar
23:37:48,430 INFO  [JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
23:37:48,430 INFO  [JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-arr-3.0.11-mysql.ear,jar=jboss-seam-2.1.1.GA.jar,name=TimerServiceDispatcher,service=EJB3 with dependencies:
23:37:48,449 INFO  [EJBContainer] STARTED EJB: org.jboss.seam.async.TimerServiceDispatcher ejbName: TimerServiceDispatcher
23:37:48,480 INFO  [JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateful.StatefulContainer
23:37:48,481 INFO  [JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-arr-3.0.11-mysql.ear,jar=jboss-seam-2.1.1.GA.jar,name=EjbSynchronizations,service=EJB3 with dependencies:
23:37:48,485 INFO  [EJBContainer] STARTED EJB: org.jboss.seam.transaction.EjbSynchronizations ejbName: EjbSynchronizations
23:37:48,488 INFO  [EJB3Deployer] Deployed: file:/dcom/dcm4chee-2.17.1-mysql/server/default/tmp/deploy/tmp4487493803678035995dcm4chee-arr-3.0.11-mysql.ear-contents/lib/jboss-seam-2.1.1.GA.jar
23:37:48,490 INFO  [TomcatDeployer] deploy, ctxPath=/dcm4chee-arr, warUrl=.../tmp/deploy/tmp4487493803678035995dcm4chee-arr-3.0.11-mysql.ear-contents/dcm4chee-arr-seam-web-3.0.11-mysql-exp.war/
23:37:49,719 INFO  [ServletContextListener] Welcome to Seam 2.1.1.GA
23:37:50,718 INFO  [Initialization] Namespace: http://jboss.com/products/seam/async, package: org.jboss.seam.async, prefix: org.jboss.seam.async
23:37:50,719 INFO  [Initialization] Namespace: http://jboss.com/products/seam/framework, package: org.jboss.seam.framework, prefix: org.jboss.seam.core.framework
23:37:50,719 INFO  [Initialization] Namespace: http://jboss.com/products/seam/theme, package: org.jboss.seam.theme, prefix: org.jboss.seam.theme
23:37:50,719 INFO  [Initialization] Namespace: http://jboss.com/products/seam/security, package: org.jboss.seam.security.management, prefix: org.jboss.seam.security
23:37:50,719 INFO  [Initialization] Namespace: http://jboss.com/products/seam/bpm, package: org.jboss.seam.bpm, prefix: org.jboss.seam.bpm
23:37:50,719 INFO  [Initialization] Namespace: http://jboss.com/products/seam/mail, package: org.jboss.seam.mail, prefix: org.jboss.seam.mail
23:37:50,719 INFO  [Initialization] Namespace: http://jboss.com/products/seam/security, package: org.jboss.seam.security, prefix: org.jboss.seam.security
23:37:50,719 INFO  [Initialization] Namespace: http://jboss.com/products/seam/web, package: org.jboss.seam.web, prefix: org.jboss.seam.web
23:37:50,719 INFO  [Initialization] Namespace: http://jboss.com/products/seam/captcha, package: org.jboss.seam.captcha, prefix: org.jboss.seam.captcha
23:37:50,719 INFO  [Initialization] Namespace: http://jboss.com/products/seam/navigation, package: org.jboss.seam.navigation, prefix: org.jboss.seam.navigation
23:37:50,720 INFO  [Initialization] Namespace: http://jboss.com/products/seam/core, package: org.jboss.seam.core, prefix: org.jboss.seam.core
23:37:50,720 INFO  [Initialization] Namespace: http://jboss.com/products/seam/international, package: org.jboss.seam.international, prefix: org.jboss.seam.international
23:37:50,720 INFO  [Initialization] Namespace: http://jboss.com/products/seam/cache, package: org.jboss.seam.cache, prefix: org.jboss.seam.cache
23:37:50,720 INFO  [Initialization] Namespace: http://jboss.com/products/seam/jms, package: org.jboss.seam.jms, prefix: org.jboss.seam.jms
23:37:50,720 INFO  [Initialization] Namespace: http://jboss.com/products/seam/ui, package: org.jboss.seam.ui, prefix: org.jboss.seam.ui
23:37:50,720 INFO  [Initialization] Namespace: http://jboss.com/products/seam/transaction, package: org.jboss.seam.transaction, prefix: org.jboss.seam.transaction
23:37:50,720 INFO  [Initialization] Namespace: http://jboss.com/products/seam/security, package: org.jboss.seam.security.permission, prefix: org.jboss.seam.security
23:37:50,720 INFO  [Initialization] Namespace: http://jboss.com/products/seam/drools, package: org.jboss.seam.drools, prefix: org.jboss.seam.drools
23:37:50,720 INFO  [Initialization] Namespace: http://jboss.com/products/seam/document, package: org.jboss.seam.document, prefix: org.jboss.seam.document
23:37:50,720 INFO  [Initialization] Namespace: http://jboss.com/products/seam/persistence, package: org.jboss.seam.persistence, prefix: org.jboss.seam.persistence
23:37:50,720 INFO  [Initialization] reading /WEB-INF/components.xml
23:37:50,781 INFO  [Initialization] reading properties from: /seam.properties
23:37:50,781 INFO  [Initialization] reading properties from: /jndi.properties
23:37:50,785 INFO  [Initialization] initializing Seam
23:37:50,814 INFO  [Component] Component: org.jboss.seam.core.init, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.core.Init
23:37:50,834 INFO  [Initialization] two components with same name, higher precedence wins: org.jboss.seam.core.expressions
23:37:50,834 INFO  [Initialization] two components with same name, higher precedence wins: org.jboss.seam.core.locale
23:37:50,834 INFO  [Initialization] two components with same name, higher precedence wins: org.jboss.seam.web.isUserInRole
23:37:50,835 INFO  [Initialization] two components with same name, higher precedence wins: org.jboss.seam.web.userPrincipal
23:37:50,835 INFO  [Initialization] two components with same name, higher precedence wins: org.jboss.seam.persistence.persistenceProvider
23:37:50,835 INFO  [Initialization] two components with same name, higher precedence wins: org.jboss.seam.core.manager
23:37:50,835 INFO  [Initialization] two components with same name, higher precedence wins: org.jboss.seam.core.locale
23:37:50,835 INFO  [Initialization] two components with same name, higher precedence wins: org.jboss.seam.core.resourceLoader
23:37:50,835 INFO  [Initialization] two components with same name, higher precedence wins: org.jboss.seam.transaction.synchronizations
23:37:50,835 INFO  [Initialization] two components with same name, higher precedence wins: org.jboss.seam.web.parameters
23:37:50,843 INFO  [Initialization] Installing components...
23:37:50,859 INFO  [Component] Component: auditRecordList, scope: SESSION, type: STATEFUL_SESSION_BEAN, class: org.dcm4chee.arr.seam.ejb.AuditRecordListAction, JNDI: dcm4chee-arr-3.0.11-mysql/AuditRecordListAction/local
23:37:50,887 INFO  [Component] Component: audit_record, scope: EVENT, type: JAVA_BEAN, class: org.dcm4chee.arr.seam.ejb.AuditRecordEntry
23:37:50,895 INFO  [Component] Component: org.jboss.seam.async.asynchronousExceptionHandler, scope: STATELESS, type: JAVA_BEAN, class: org.jboss.seam.async.AsynchronousExceptionHandler
23:37:50,896 INFO  [Component] Component: org.jboss.seam.async.dispatcher, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.async.ThreadPoolDispatcher
23:37:50,909 INFO  [Component] Component: org.jboss.seam.captcha.captcha, scope: SESSION, type: JAVA_BEAN, class: org.jboss.seam.captcha.Captcha
23:37:51,463 INFO  [Component] Component: org.jboss.seam.captcha.captchaImage, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.captcha.CaptchaImage
23:37:51,464 INFO  [Component] Component: org.jboss.seam.core.ConversationIdGenerator, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.core.ConversationIdGenerator
23:37:51,475 INFO  [Component] Component: org.jboss.seam.core.contexts, scope: STATELESS, type: JAVA_BEAN, class: org.jboss.seam.core.Contexts
23:37:51,477 INFO  [Component] Component: org.jboss.seam.core.conversation, scope: CONVERSATION, type: JAVA_BEAN, class: org.jboss.seam.core.Conversation
23:37:51,479 INFO  [Component] Component: org.jboss.seam.core.conversationEntries, scope: SESSION, type: JAVA_BEAN, class: org.jboss.seam.core.ConversationEntries
23:37:51,480 INFO  [Component] Component: org.jboss.seam.core.conversationListFactory, scope: STATELESS, type: JAVA_BEAN, class: org.jboss.seam.core.ConversationList
23:37:51,482 INFO  [Component] Component: org.jboss.seam.core.conversationPropagation, scope: EVENT, type: JAVA_BEAN, class: org.jboss.seam.core.ConversationPropagation
23:37:51,482 INFO  [Component] Component: org.jboss.seam.core.conversationStackFactory, scope: STATELESS, type: JAVA_BEAN, class: org.jboss.seam.core.ConversationStack
23:37:51,483 INFO  [Component] Component: org.jboss.seam.core.events, scope: EVENT, type: JAVA_BEAN, class: org.jboss.seam.core.Events
23:37:51,484 INFO  [Component] Component: org.jboss.seam.core.expressions, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.faces.FacesExpressions
23:37:51,485 INFO  [Component] Component: org.jboss.seam.core.interpolator, scope: STATELESS, type: JAVA_BEAN, class: org.jboss.seam.core.Interpolator
23:37:51,486 INFO  [Component] Component: org.jboss.seam.core.locale, scope: STATELESS, type: JAVA_BEAN, class: org.jboss.seam.international.Locale
23:37:51,490 INFO  [Component] Component: org.jboss.seam.core.manager, scope: EVENT, type: JAVA_BEAN, class: org.jboss.seam.faces.FacesManager
23:37:51,492 INFO  [Component] Component: org.jboss.seam.core.resourceBundle, scope: STATELESS, type: JAVA_BEAN, class: org.jboss.seam.core.ResourceBundle
23:37:51,493 INFO  [Component] Component: org.jboss.seam.core.resourceLoader, scope: STATELESS, type: JAVA_BEAN, class: org.jboss.seam.faces.ResourceLoader
23:37:51,495 INFO  [Component] Component: org.jboss.seam.core.validators, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.core.Validators
23:37:51,496 INFO  [Component] Component: org.jboss.seam.document.documentStore, scope: CONVERSATION, type: JAVA_BEAN, class: org.jboss.seam.document.DocumentStore
23:37:51,506 INFO  [Component] Component: org.jboss.seam.exception.exceptions, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.exception.Exceptions
23:37:51,512 INFO  [Component] Component: org.jboss.seam.faces.dataModels, scope: STATELESS, type: JAVA_BEAN, class: org.jboss.seam.faces.DataModels
23:37:51,513 INFO  [Component] Component: org.jboss.seam.faces.facesContext, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.faces.FacesContext
23:37:51,513 INFO  [Component] Component: org.jboss.seam.faces.facesPage, scope: PAGE, type: JAVA_BEAN, class: org.jboss.seam.faces.FacesPage
23:37:51,514 INFO  [Component] Component: org.jboss.seam.faces.httpError, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.faces.HttpError
23:37:51,514 INFO  [Component] Component: org.jboss.seam.faces.redirect, scope: CONVERSATION, type: JAVA_BEAN, class: org.jboss.seam.faces.Redirect
23:37:51,517 INFO  [Component] Component: org.jboss.seam.faces.renderer, scope: STATELESS, type: JAVA_BEAN, class: org.jboss.seam.ui.facelet.FaceletsRenderer
23:37:51,518 INFO  [Component] Component: org.jboss.seam.faces.switcher, scope: PAGE, type: JAVA_BEAN, class: org.jboss.seam.faces.Switcher
23:37:51,519 INFO  [Component] Component: org.jboss.seam.faces.uiComponent, scope: STATELESS, type: JAVA_BEAN, class: org.jboss.seam.faces.UiComponent
23:37:51,519 INFO  [Component] Component: org.jboss.seam.faces.validation, scope: EVENT, type: JAVA_BEAN, class: org.jboss.seam.faces.Validation
23:37:51,520 INFO  [Component] Component: org.jboss.seam.framework.currentDate, scope: STATELESS, type: JAVA_BEAN, class: org.jboss.seam.framework.CurrentDate
23:37:51,525 INFO  [Component] Component: org.jboss.seam.framework.currentDatetime, scope: STATELESS, type: JAVA_BEAN, class: org.jboss.seam.framework.CurrentDatetime
23:37:51,530 INFO  [Component] Component: org.jboss.seam.framework.currentTime, scope: STATELESS, type: JAVA_BEAN, class: org.jboss.seam.framework.CurrentTime
23:37:51,538 INFO  [Component] Component: org.jboss.seam.graphicImage.image, scope: EVENT, type: JAVA_BEAN, class: org.jboss.seam.ui.graphicImage.Image
23:37:51,540 INFO  [Component] Component: org.jboss.seam.international.localeSelector, scope: SESSION, type: JAVA_BEAN, class: org.jboss.seam.international.LocaleSelector
23:37:51,542 INFO  [Component] Component: org.jboss.seam.international.messagesFactory, scope: STATELESS, type: JAVA_BEAN, class: org.jboss.seam.international.Messages
23:37:51,548 INFO  [Component] Component: org.jboss.seam.international.statusMessages, scope: CONVERSATION, type: JAVA_BEAN, class: org.jboss.seam.faces.FacesMessages
23:37:51,549 INFO  [Component] Component: org.jboss.seam.international.timeZone, scope: STATELESS, type: JAVA_BEAN, class: org.jboss.seam.international.TimeZone
23:37:51,550 INFO  [Component] Component: org.jboss.seam.international.timeZoneSelector, scope: SESSION, type: JAVA_BEAN, class: org.jboss.seam.international.TimeZoneSelector
23:37:51,552 INFO  [Component] Component: org.jboss.seam.mail.mailSession, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.mail.MailSession
23:37:51,560 INFO  [Component] Component: org.jboss.seam.navigation.pages, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.navigation.Pages
23:37:51,566 INFO  [Component] Component: org.jboss.seam.navigation.safeActions, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.navigation.SafeActions
23:37:51,566 INFO  [Component] Component: org.jboss.seam.persistence.persistenceContexts, scope: CONVERSATION, type: JAVA_BEAN, class: org.jboss.seam.persistence.PersistenceContexts
23:37:51,570 INFO  [Component] Component: org.jboss.seam.persistence.persistenceProvider, scope: STATELESS, type: JAVA_BEAN, class: org.jboss.seam.persistence.HibernatePersistenceProvider
23:37:51,573 INFO  [Component] Component: org.jboss.seam.security.configurationFactory, scope: STATELESS, type: JAVA_BEAN, class: org.jboss.seam.security.Configuration
23:37:51,575 INFO  [Component] Component: org.jboss.seam.security.credentials, scope: SESSION, type: JAVA_BEAN, class: org.jboss.seam.security.Credentials
23:37:51,576 INFO  [Component] Component: org.jboss.seam.security.entityPermissionChecker, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.security.EntityPermissionChecker
23:37:51,578 INFO  [Component] Component: org.jboss.seam.security.facesSecurityEvents, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.security.FacesSecurityEvents
23:37:51,580 INFO  [Component] Component: org.jboss.seam.security.identifierPolicy, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.security.permission.IdentifierPolicy
23:37:51,583 INFO  [Component] Component: org.jboss.seam.security.identity, scope: SESSION, type: JAVA_BEAN, class: org.jboss.seam.security.Identity
23:37:51,586 INFO  [Component] Component: org.jboss.seam.security.identityManager, scope: EVENT, type: JAVA_BEAN, class: org.jboss.seam.security.management.IdentityManager
23:37:51,589 INFO  [Component] Component: org.jboss.seam.security.management.roleAction, scope: CONVERSATION, type: JAVA_BEAN, class: org.jboss.seam.security.management.action.RoleAction
23:37:51,596 INFO  [Component] Component: org.jboss.seam.security.management.roleSearch, scope: SESSION, type: JAVA_BEAN, class: org.jboss.seam.security.management.action.RoleSearch
23:37:51,605 INFO  [Component] Component: org.jboss.seam.security.management.userAction, scope: CONVERSATION, type: JAVA_BEAN, class: org.jboss.seam.security.management.action.UserAction
23:37:51,610 INFO  [Component] Component: org.jboss.seam.security.management.userSearch, scope: SESSION, type: JAVA_BEAN, class: org.jboss.seam.security.management.action.UserSearch
23:37:51,615 INFO  [Component] Component: org.jboss.seam.security.passwordHash, scope: STATELESS, type: JAVA_BEAN, class: org.jboss.seam.security.management.PasswordHash
23:37:51,617 INFO  [Component] Component: org.jboss.seam.security.permission.permissionSearch, scope: CONVERSATION, type: JAVA_BEAN, class: org.jboss.seam.security.permission.action.PermissionSearch
23:37:51,623 INFO  [Component] Component: org.jboss.seam.security.permissionManager, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.security.permission.PermissionManager
23:37:51,628 INFO  [Component] Component: org.jboss.seam.security.permissionMapper, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.security.permission.PermissionMapper
23:37:51,629 INFO  [Component] Component: org.jboss.seam.security.persistentPermissionResolver, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.security.permission.PersistentPermissionResolver
23:37:51,631 INFO  [Component] Component: org.jboss.seam.security.rememberMe, scope: SESSION, type: JAVA_BEAN, class: org.jboss.seam.security.RememberMe
23:37:51,633 INFO  [Component] Component: org.jboss.seam.theme.themeFactory, scope: STATELESS, type: JAVA_BEAN, class: org.jboss.seam.theme.Theme
23:37:51,635 INFO  [Component] Component: org.jboss.seam.theme.themeSelector, scope: SESSION, type: JAVA_BEAN, class: org.jboss.seam.theme.ThemeSelector
23:37:51,635 INFO  [Component] Component: org.jboss.seam.transaction.synchronizations, scope: EVENT, type: JAVA_BEAN, class: org.jboss.seam.transaction.SeSynchronizations
23:37:51,636 INFO  [Component] Component: org.jboss.seam.transaction.transaction, scope: EVENT, type: JAVA_BEAN, class: org.jboss.seam.transaction.Transaction
23:37:51,639 INFO  [Component] Component: org.jboss.seam.ui.EntityConverter, scope: CONVERSATION, type: JAVA_BEAN, class: org.jboss.seam.ui.EntityConverter
23:37:51,642 INFO  [Component] Component: org.jboss.seam.ui.entityIdentifierStore, scope: PAGE, type: JAVA_BEAN, class: org.jboss.seam.ui.EntityIdentifierStore
23:37:51,649 INFO  [Component] Component: org.jboss.seam.ui.entityLoader, scope: STATELESS, type: JAVA_BEAN, class: org.jboss.seam.ui.JpaEntityLoader
23:37:51,660 INFO  [Component] Component: org.jboss.seam.ui.facelet.faceletCompiler, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.ui.facelet.FaceletCompiler
23:37:51,662 INFO  [Component] Component: org.jboss.seam.ui.facelet.facesContextFactory, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.ui.facelet.RendererFacesContextFactory
23:37:51,664 INFO  [Component] Component: org.jboss.seam.ui.facelet.mockHttpSession, scope: SESSION, type: JAVA_BEAN, class: org.jboss.seam.ui.facelet.HttpSessionManager
23:37:51,665 INFO  [Component] Component: org.jboss.seam.ui.facelet.mockServletContext, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.ui.facelet.ServletContextManager
23:37:51,666 INFO  [Component] Component: org.jboss.seam.ui.graphicImage.graphicImageResource, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.ui.graphicImage.GraphicImageResource
23:37:51,667 INFO  [Component] Component: org.jboss.seam.ui.graphicImage.graphicImageStore, scope: SESSION, type: JAVA_BEAN, class: org.jboss.seam.ui.graphicImage.GraphicImageStore
23:37:51,669 INFO  [Component] Component: org.jboss.seam.ui.resource.webResource, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.ui.resource.WebResource
23:37:51,673 INFO  [Component] Component: org.jboss.seam.web.exceptionFilter, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.web.ExceptionFilter
23:37:51,675 INFO  [Component] Component: org.jboss.seam.web.identityFilter, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.web.IdentityFilter
23:37:51,675 INFO  [Component] Component: org.jboss.seam.web.isUserInRole, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.faces.IsUserInRole
23:37:51,676 INFO  [Component] Component: org.jboss.seam.web.loggingFilter, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.web.LoggingFilter
23:37:51,677 INFO  [Component] Component: org.jboss.seam.web.multipartFilter, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.web.MultipartFilter
23:37:51,678 INFO  [Component] Component: org.jboss.seam.web.parameters, scope: STATELESS, type: JAVA_BEAN, class: org.jboss.seam.faces.Parameters
23:37:51,678 INFO  [Component] Component: org.jboss.seam.web.redirectFilter, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.web.RedirectFilter
23:37:51,679 INFO  [Component] Component: org.jboss.seam.web.servletContexts, scope: EVENT, type: JAVA_BEAN, class: org.jboss.seam.web.ServletContexts
23:37:51,679 INFO  [Component] Component: org.jboss.seam.web.session, scope: SESSION, type: JAVA_BEAN, class: org.jboss.seam.web.Session
23:37:51,680 INFO  [Component] Component: org.jboss.seam.web.userPrincipal, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.faces.UserPrincipal
23:37:51,680 INFO  [Contexts] starting up: org.jboss.seam.security.persistentPermissionResolver
23:37:51,681 WARN  [PersistentPermissionResolver] no permission store available - please install a PermissionStore with the name 'org.jboss.seam.security.jpaPermissionStore' if persistent permissions are required.
23:37:51,681 INFO  [Contexts] starting up: org.jboss.seam.security.permissionMapper
23:37:51,681 INFO  [Contexts] starting up: org.jboss.seam.navigation.pages
23:37:51,686 INFO  [Contexts] starting up: org.jboss.seam.security.entityPermissionChecker
23:37:51,686 INFO  [Contexts] starting up: org.jboss.seam.security.facesSecurityEvents
23:37:51,687 INFO  [Initialization] done initializing Seam
23:37:51,688 INFO  [SeamFilter] Initializing filter: org.jboss.seam.web.redirectFilter
23:37:51,688 INFO  [SeamFilter] Initializing filter: org.jboss.seam.web.exceptionFilter
23:37:51,688 INFO  [SeamFilter] Initializing filter: org.jboss.seam.web.multipartFilter
23:37:51,688 INFO  [SeamFilter] Initializing filter: org.jboss.seam.web.identityFilter
23:37:51,689 INFO  [SeamFilter] Initializing filter: org.jboss.seam.web.loggingFilter
23:37:51,707 INFO  [EARDeployer] Started J2EE application: file:/dcom/dcm4chee-2.17.1-mysql/server/default/deploy/dcm4chee-arr-3.0.11-mysql.ear
23:37:51,752 INFO  [EARDeployer] Init J2EE application: file:/dcom/dcm4chee-2.17.1-mysql/server/default/deploy/dcm4chee-web-ear-3.0.1-mysql.ear
23:37:52,918 INFO  [EchoService] SCU Devicename:EchoService
23:37:53,063 INFO  [IANScuService] SCU Devicename:IANScuService
23:37:53,127 INFO  [AttributesModificationScuService] SCU Devicename:AttributesModificationScuService
23:37:53,215 INFO  [MoveScuService] SCU Devicename:MoveScuService
23:37:53,249 INFO  [MwlScuService] SCU Devicename:MwlScuService
23:37:53,288 INFO  [RejectionNoteScuService] SCU Devicename:RejectionNoteScuService
23:37:53,444 INFO  [QueueService] Queue[/queue/HL7SendV2] started, fullSize=200000, pageSize=2000, downCacheSize=2000
23:37:53,451 INFO  [QueueService] Queue[/queue/IANSCU_web] started, fullSize=200000, pageSize=2000, downCacheSize=2000
23:37:53,457 INFO  [QueueService] Queue[/queue/AttributesModification_web] started, fullSize=200000, pageSize=2000, downCacheSize=2000
23:37:53,463 INFO  [QueueService] Queue[/queue/MoveScu_web] started, fullSize=200000, pageSize=2000, downCacheSize=2000
23:37:53,472 INFO  [QueueService] Queue[/queue/RejectionNoteSCU] started, fullSize=200000, pageSize=2000, downCacheSize=2000
23:37:53,511 INFO  [JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.entity.PersistenceUnitDeployment
23:37:53,511 INFO  [JmxKernelAbstraction] installing MBean: persistence.units:ear=dcm4chee-web-ear-3.0.1-mysql.ear,unitName=dcm4chee-arc with dependencies:
23:37:53,511 INFO  [JmxKernelAbstraction] 	jboss.jca:name=pacsDS,service=DataSourceBinding
23:37:53,512 INFO  [PersistenceUnitDeployment] Starting persistence unit persistence.units:ear=dcm4chee-web-ear-3.0.1-mysql.ear,unitName=dcm4chee-arc
23:37:53,514 INFO  [Ejb3Configuration] Processing PersistenceUnitInfo [
	name: dcm4chee-arc
	...]
23:37:53,519 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.AE
23:37:53,519 INFO  [Ejb3Configuration] found EJB3 @MappedSuperclass: org.dcm4chee.archive.entity.BaseEntity
23:37:53,520 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.Code
23:37:53,520 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.ContentItem
23:37:53,521 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.Device
23:37:53,522 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.File
23:37:53,522 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.FileSystem
23:37:53,523 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.GPPPS
23:37:53,524 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.GPSPS
23:37:53,524 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.GPSPSPerformer
23:37:53,525 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.GPSPSRequest
23:37:53,525 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.HangingProtocol
23:37:53,526 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.HPDefinition
23:37:53,527 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.Instance
23:37:53,528 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.Issuer
23:37:53,528 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.Media
23:37:53,529 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.MPPS
23:37:53,530 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.MWLItem
23:37:53,530 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.OtherPatientID
23:37:53,532 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.Patient
23:37:53,532 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.PrivateFile
23:37:53,533 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.PrivateInstance
23:37:53,534 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.PrivatePatient
23:37:53,534 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.PrivateSeries
23:37:53,535 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.PrivateStudy
23:37:53,535 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.RequestAttributes
23:37:53,537 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.Series
23:37:53,539 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.Study
23:37:53,539 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.StudyOnFileSystem
23:37:53,539 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.StudyPermission
23:37:53,540 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.UPS
23:37:53,541 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.UPSRelatedPS
23:37:53,541 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.UPSReplacedPS
23:37:53,542 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.UPSRequest
23:37:53,542 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.UPSSubscription
23:37:53,542 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.archive.entity.VerifyingObserver
23:37:53,566 INFO  [Configuration] Reading mappings from resource : META-INF/orm.xml
23:37:53,593 INFO  [Ejb3Configuration] [PersistenceUnit: dcm4chee-arc] META-INF/orm.xml found
23:37:53,621 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.AE
23:37:53,622 INFO  [QueryBinder] Binding Named query: AE.findByTitle => select ae from AE ae where title = :title
23:37:53,622 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.AE on table ae
23:37:53,631 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Code
23:37:53,631 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.Code on table code
23:37:53,633 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.ContentItem
23:37:53,634 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.ContentItem on table content_item
23:37:53,635 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Device
23:37:53,636 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.Device on table device
23:37:53,642 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.File
23:37:53,643 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.File on table files
23:37:53,646 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.FileSystem
23:37:53,646 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.FileSystem on table filesystem
23:37:53,654 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.GPPPS
23:37:53,654 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.GPPPS on table gppps
23:37:53,658 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.GPSPS
23:37:53,658 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.GPSPS on table gpsps
23:37:53,667 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.GPSPSPerformer
23:37:53,668 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.GPSPSPerformer on table gpsps_perf
23:37:53,670 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.GPSPSRequest
23:37:53,670 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.GPSPSRequest on table gpsps_req
23:37:53,671 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.HangingProtocol
23:37:53,671 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.HangingProtocol on table hp
23:37:53,676 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.HPDefinition
23:37:53,676 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.HPDefinition on table hpdef
23:37:53,678 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Instance
23:37:53,679 INFO  [QueryBinder] Binding Named query: Instance.findByIUID => select object(i) from Instance i where sopInstanceUID = :iuid
23:37:53,679 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.Instance on table instance
23:37:53,687 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Issuer
23:37:53,687 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.Issuer on table issuer
23:37:53,689 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Media
23:37:53,689 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.Media on table media
23:37:53,691 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.MPPS
23:37:53,691 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.MPPS on table mpps
23:37:53,695 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.MWLItem
23:37:53,695 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.MWLItem on table mwl_item
23:37:53,732 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.OtherPatientID
23:37:53,732 INFO  [QueryBinder] Binding Named query: OtherPatientID.findByPatientIdAndIssuer => select opid from OtherPatientID opid where patientID = :pid and issuerOfPatientID = :issuer
23:37:53,732 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.OtherPatientID on table other_pid
23:37:53,742 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Patient
23:37:53,742 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.Patient on table patient
23:37:53,762 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.PrivateFile
23:37:53,762 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.PrivateFile on table priv_file
23:37:53,764 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.PrivateInstance
23:37:53,765 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.PrivateInstance on table priv_instance
23:37:53,772 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.PrivatePatient
23:37:53,773 INFO  [QueryBinder] Binding Named query: PrivatePatient.findByIdAndIssuer => select object(p) from PrivatePatient p where patientID = :patId and issuerOfPatientID = :issuer
23:37:53,773 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.PrivatePatient on table priv_patient
23:37:53,775 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.PrivateSeries
23:37:53,775 INFO  [QueryBinder] Binding Named query: PrivateSeries.findByIUID => select object(pi) from PrivateSeries pi where seriesInstanceUID = :iuid
23:37:53,775 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.PrivateSeries on table priv_series
23:37:53,783 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.PrivateStudy
23:37:53,783 INFO  [QueryBinder] Binding Named query: PrivateStudy.findByIUID => select object(ps) from PrivateStudy ps where studyInstanceUID = :iuid
23:37:53,783 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.PrivateStudy on table priv_study
23:37:53,785 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.RequestAttributes
23:37:53,786 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.RequestAttributes on table series_req
23:37:53,794 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Series
23:37:53,795 INFO  [QueryBinder] Binding Named query: Series.findByIUID => select object(s) from Series s where seriesInstanceUID = :iuid
23:37:53,795 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.Series on table series
23:37:53,816 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Study
23:37:53,817 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.Study on table study
23:37:53,831 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.StudyOnFileSystem
23:37:53,837 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.StudyOnFileSystem on table study_on_fs
23:37:53,839 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.StudyPermission
23:37:53,839 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.StudyPermission on table study_permission
23:37:53,840 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.UPS
23:37:53,840 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.UPS on table ups
23:37:53,858 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.UPSRelatedPS
23:37:53,859 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.UPSRelatedPS on table ups_rel_ps
23:37:53,860 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.UPSReplacedPS
23:37:53,861 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.UPSReplacedPS on table ups_repl_ps
23:37:53,862 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.UPSRequest
23:37:53,862 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.UPSRequest on table ups_req
23:37:53,863 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.UPSSubscription
23:37:53,863 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.UPSSubscription on table ups_subscr
23:37:53,864 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.VerifyingObserver
23:37:53,864 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.VerifyingObserver on table verify_observer
23:37:53,876 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.GPSPS.referencedRequests -> gpsps_req
23:37:53,882 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.GPSPS.scheduledHumanPerformers -> gpsps_perf
23:37:53,882 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.HangingProtocol.definitions -> hpdef
23:37:53,883 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Instance.verifyingObservers -> verify_observer
23:37:53,883 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Instance.files -> files
23:37:53,883 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Instance.contentItems -> content_item
23:37:53,883 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Media.instances -> instance
23:37:53,883 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.MPPS.series -> series
23:37:53,883 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.previous -> patient
23:37:53,883 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.studies -> study
23:37:53,884 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.modalityWorklistItems -> mwl_item
23:37:53,884 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.modalityPerformedProcedureSteps -> mpps
23:37:53,884 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.generalPurposeScheduledProcedureSteps -> gpsps
23:37:53,884 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.generalPurposePerformedProcedureSteps -> gppps
23:37:53,884 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.unifiedProcedureSteps -> ups
23:37:53,884 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.PrivateInstance.files -> priv_file
23:37:53,884 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.PrivatePatient.studies -> priv_study
23:37:53,885 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.PrivateSeries.instances -> priv_instance
23:37:53,885 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.PrivateStudy.series -> priv_series
23:37:53,885 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Series.requestAttributes -> series_req
23:37:53,885 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Series.instances -> instance
23:37:53,891 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Study.series -> series
23:37:53,891 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.UPS.refRequests -> ups_req
23:37:53,892 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.UPS.relatedProcedureSteps -> ups_rel_ps
23:37:53,892 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.UPS.replacedProcedureSteps -> ups_repl_ps
23:37:53,892 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.UPS.subscriptions -> ups_subscr
23:37:54,139 INFO  [ConnectionProviderFactory] Initializing connection provider: org.hibernate.ejb.connection.InjectedDataSourceConnectionProvider
23:37:54,146 INFO  [InjectedDataSourceConnectionProvider] Using provided datasource
23:37:54,146 INFO  [SettingsFactory] RDBMS: MySQL, version: 5.5.34
23:37:54,146 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 $ )
23:37:54,147 INFO  [Dialect] Using dialect: org.hibernate.dialect.MySQLInnoDBDialect
23:37:54,147 INFO  [TransactionFactoryFactory] Transaction strategy: org.hibernate.ejb.transaction.JoinableCMTTransactionFactory
23:37:54,147 INFO  [TransactionManagerLookupFactory] instantiating TransactionManagerLookup: org.hibernate.transaction.JBossTransactionManagerLookup
23:37:54,147 INFO  [TransactionManagerLookupFactory] instantiated TransactionManagerLookup
23:37:54,147 INFO  [SettingsFactory] Automatic flush during beforeCompletion(): disabled
23:37:54,147 INFO  [SettingsFactory] Automatic session close at end of transaction: disabled
23:37:54,147 INFO  [SettingsFactory] JDBC batch size: 15
23:37:54,147 INFO  [SettingsFactory] JDBC batch updates for versioned data: disabled
23:37:54,147 INFO  [SettingsFactory] Scrollable result sets: enabled
23:37:54,147 INFO  [SettingsFactory] JDBC3 getGeneratedKeys(): disabled
23:37:54,148 INFO  [SettingsFactory] JDBC result set fetch size: 50
23:37:54,148 INFO  [SettingsFactory] Connection release mode: auto
23:37:54,148 INFO  [SettingsFactory] Maximum outer join fetch depth: 2
23:37:54,148 INFO  [SettingsFactory] Default batch fetch size: 1
23:37:54,148 INFO  [SettingsFactory] Generate SQL with comments: disabled
23:37:54,148 INFO  [SettingsFactory] Order SQL updates by primary key: disabled
23:37:54,148 INFO  [SettingsFactory] Order SQL inserts for batching: disabled
23:37:54,148 INFO  [SettingsFactory] Query translator: org.hibernate.hql.ast.ASTQueryTranslatorFactory
23:37:54,148 INFO  [ASTQueryTranslatorFactory] Using ASTQueryTranslatorFactory
23:37:54,148 INFO  [SettingsFactory] Query language substitutions: {}
23:37:54,148 INFO  [SettingsFactory] JPA-QL strict compliance: enabled
23:37:54,148 INFO  [SettingsFactory] Second-level cache: enabled
23:37:54,148 INFO  [SettingsFactory] Query cache: disabled
23:37:54,148 INFO  [SettingsFactory] Cache provider: org.hibernate.cache.HashtableCacheProvider
23:37:54,149 INFO  [SettingsFactory] Optimize cache for minimal puts: disabled
23:37:54,149 INFO  [SettingsFactory] Cache region prefix: dcm4chee-web-ear-3_0_1-mysql_ear,dcm4chee-arc
23:37:54,149 INFO  [SettingsFactory] Structured second-level cache entries: disabled
23:37:54,149 INFO  [SettingsFactory] Statistics: disabled
23:37:54,149 INFO  [SettingsFactory] Deleted entity synthetic identifier rollback: disabled
23:37:54,149 INFO  [SettingsFactory] Default entity-mode: pojo
23:37:54,149 INFO  [SettingsFactory] Named query checking : enabled
23:37:54,185 INFO  [SessionFactoryImpl] building session factory
23:37:54,461 INFO  [SessionFactoryObjectFactory] Factory name: persistence.units:ear=dcm4chee-web-ear-3.0.1-mysql.ear,unitName=dcm4chee-arc
23:37:54,461 INFO  [NamingHelper] JNDI InitialContext properties:{java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces}
23:37:54,464 INFO  [SessionFactoryObjectFactory] Bound factory to JNDI name: persistence.units:ear=dcm4chee-web-ear-3.0.1-mysql.ear,unitName=dcm4chee-arc
23:37:54,464 WARN  [SessionFactoryObjectFactory] InitialContext did not implement EventContext
23:37:54,466 INFO  [SchemaValidator] Running schema validator
23:37:54,466 INFO  [SchemaValidator] fetching database metadata
23:37:54,483 INFO  [TableMetadata] table found: pacsdb.ae
23:37:54,483 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]
23:37:54,485 INFO  [TableMetadata] table found: pacsdb.code
23:37:54,491 INFO  [TableMetadata] columns: [code_version, code_designator, code_value, code_meaning, pk]
23:37:54,494 INFO  [TableMetadata] table found: pacsdb.content_item
23:37:54,494 INFO  [TableMetadata] columns: [name_fk, text_value, rel_type, instance_fk, code_fk, pk]
23:37:54,496 INFO  [TableMetadata] table found: pacsdb.device
23:37:54,496 INFO  [TableMetadata] columns: [station_name, modality, station_aet, pk]
23:37:54,498 INFO  [TableMetadata] table found: pacsdb.files
23:37:54,498 INFO  [TableMetadata] columns: [filepath, file_status, file_size, md5_check_time, created_time, filesystem_fk, instance_fk, file_tsuid, file_md5, pk]
23:37:54,500 INFO  [TableMetadata] table found: pacsdb.filesystem
23:37:54,500 INFO  [TableMetadata] columns: [user_info, retrieve_aet, fs_status, fs_group_id, dirpath, next_fk, availability, pk]
23:37:54,508 INFO  [TableMetadata] table found: pacsdb.gppps
23:37:54,509 INFO  [TableMetadata] columns: [pps_attrs, pps_iuid, patient_fk, pps_status, pps_start, created_time, updated_time, pk]
23:37:54,517 INFO  [TableMetadata] table found: pacsdb.gpsps
23:37:54,517 INFO  [TableMetadata] columns: [gpsps_prior, gpsps_tuid, gpsps_status, end_datetime, in_availability, item_attrs, patient_fk, gpsps_iuid, code_fk, start_datetime, pk]
23:37:54,521 INFO  [TableMetadata] table found: pacsdb.gpsps_perf
23:37:54,521 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]
23:37:54,524 INFO  [TableMetadata] table found: pacsdb.gpsps_req
23:37:54,524 INFO  [TableMetadata] columns: [req_proc_id, gpsps_fk, accession_no, pk]
23:37:54,533 INFO  [TableMetadata] table found: pacsdb.hp
23:37:54,534 INFO  [TableMetadata] columns: [user_fk, num_priors, hp_iuid, num_screens, hp_level, hp_attrs, hp_group, hp_cuid, hp_name, pk]
23:37:54,536 INFO  [TableMetadata] table found: pacsdb.hpdef
23:37:54,536 INFO  [TableMetadata] columns: [hp_fk, laterality, modality, pk]
23:37:54,540 INFO  [TableMetadata] table found: pacsdb.instance
23:37:54,540 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]
23:37:54,551 INFO  [TableMetadata] table found: pacsdb.issuer
23:37:54,552 INFO  [TableMetadata] columns: [entity_uid_type, entity_id, entity_uid, pk]
23:37:54,555 INFO  [TableMetadata] table found: pacsdb.media
23:37:54,555 INFO  [TableMetadata] columns: [media_status_info, media_rq_iuid, media_status, fileset_id, fileset_iuid, created_time, media_usage, updated_time, pk]
23:37:54,559 INFO  [TableMetadata] table found: pacsdb.mpps
23:37:54,559 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]
23:37:54,571 INFO  [TableMetadata] table found: pacsdb.mwl_item
23:37:54,571 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]
23:37:54,580 INFO  [TableMetadata] table found: pacsdb.other_pid
23:37:54,580 INFO  [TableMetadata] columns: [pat_id, pat_id_issuer, pk]
23:37:54,584 INFO  [TableMetadata] table found: pacsdb.patient
23:37:54,585 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]
23:37:54,593 INFO  [TableMetadata] table found: pacsdb.priv_file
23:37:54,594 INFO  [TableMetadata] columns: [filepath, file_status, file_size, filesystem_fk, instance_fk, file_tsuid, file_md5, pk]
23:37:54,597 INFO  [TableMetadata] table found: pacsdb.priv_instance
23:37:54,597 INFO  [TableMetadata] columns: [inst_attrs, priv_type, series_fk, sop_iuid, created_time, pk]
23:37:54,600 INFO  [TableMetadata] table found: pacsdb.priv_patient
23:37:54,600 INFO  [TableMetadata] columns: [priv_type, pat_id, pat_attrs, pat_id_issuer, pat_name, pk]
23:37:54,602 INFO  [TableMetadata] table found: pacsdb.priv_series
23:37:54,603 INFO  [TableMetadata] columns: [priv_type, src_aet, study_fk, series_attrs, series_iuid, pk]
23:37:54,610 INFO  [TableMetadata] table found: pacsdb.priv_study
23:37:54,610 INFO  [TableMetadata] columns: [priv_type, study_iuid, patient_fk, study_attrs, accession_no, pk]
23:37:54,612 INFO  [TableMetadata] table found: pacsdb.rel_dev_proto
23:37:54,612 INFO  [TableMetadata] columns: [prcode_fk, device_fk]
23:37:54,621 INFO  [TableMetadata] table found: pacsdb.rel_gpsps_appcode
23:37:54,622 INFO  [TableMetadata] columns: [appcode_fk, gpsps_fk]
23:37:54,624 INFO  [TableMetadata] table found: pacsdb.rel_gpsps_devclass
23:37:54,624 INFO  [TableMetadata] columns: [devclass_fk, gpsps_fk]
23:37:54,627 INFO  [TableMetadata] table found: pacsdb.rel_gpsps_devloc
23:37:54,627 INFO  [TableMetadata] columns: [devloc_fk, gpsps_fk]
23:37:54,629 INFO  [TableMetadata] table found: pacsdb.rel_gpsps_devname
23:37:54,629 INFO  [TableMetadata] columns: [devname_fk, gpsps_fk]
23:37:54,632 INFO  [TableMetadata] table found: pacsdb.rel_gpsps_gppps
23:37:54,638 INFO  [TableMetadata] columns: [gppps_fk, gpsps_fk]
23:37:54,640 INFO  [TableMetadata] table found: pacsdb.rel_hpdef_proc
23:37:54,640 INFO  [TableMetadata] columns: [proc_fk, hpdef_fk]
23:37:54,643 INFO  [TableMetadata] table found: pacsdb.rel_hpdef_reason
23:37:54,643 INFO  [TableMetadata] columns: [reason_fk, hpdef_fk]
23:37:54,645 INFO  [TableMetadata] table found: pacsdb.rel_hpdef_region
23:37:54,645 INFO  [TableMetadata] columns: [region_fk, hpdef_fk]
23:37:54,648 INFO  [TableMetadata] table found: pacsdb.rel_pat_other_pid
23:37:54,653 INFO  [TableMetadata] columns: [patient_fk, other_pid_fk]
23:37:54,655 INFO  [TableMetadata] table found: pacsdb.rel_study_pcode
23:37:54,655 INFO  [TableMetadata] columns: [study_fk, pcode_fk]
23:37:54,657 INFO  [TableMetadata] table found: pacsdb.rel_ups_appcode
23:37:54,657 INFO  [TableMetadata] columns: [appcode_fk, ups_fk]
23:37:54,659 INFO  [TableMetadata] table found: pacsdb.rel_ups_devclass
23:37:54,659 INFO  [TableMetadata] columns: [devclass_fk, ups_fk]
23:37:54,663 INFO  [TableMetadata] table found: pacsdb.rel_ups_devloc
23:37:54,663 INFO  [TableMetadata] columns: [devloc_fk, ups_fk]
23:37:54,665 INFO  [TableMetadata] table found: pacsdb.rel_ups_devname
23:37:54,665 INFO  [TableMetadata] columns: [devname_fk, ups_fk]
23:37:54,675 INFO  [TableMetadata] table found: pacsdb.rel_ups_performer
23:37:54,676 INFO  [TableMetadata] columns: [performer_fk, ups_fk]
23:37:54,683 INFO  [TableMetadata] table found: pacsdb.series
23:37:54,683 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]
23:37:54,721 INFO  [TableMetadata] table found: pacsdb.series_req
23:37:54,722 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]
23:37:54,727 INFO  [TableMetadata] table found: pacsdb.study
23:37:54,727 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]
23:37:54,741 INFO  [TableMetadata] table found: pacsdb.study_on_fs
23:37:54,741 INFO  [TableMetadata] columns: [study_fk, access_time, filesystem_fk, mark_to_delete, pk]
23:37:54,754 INFO  [TableMetadata] table found: pacsdb.study_permission
23:37:54,754 INFO  [TableMetadata] columns: [study_iuid, roles, action, pk]
23:37:54,764 INFO  [TableMetadata] table found: pacsdb.ups
23:37:54,773 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]
23:37:54,776 INFO  [TableMetadata] table found: pacsdb.ups_rel_ps
23:37:54,776 INFO  [TableMetadata] columns: [sop_cuid, sop_iuid, ups_fk, pk]
23:37:54,782 INFO  [TableMetadata] table found: pacsdb.ups_repl_ps
23:37:54,786 INFO  [TableMetadata] columns: [sop_cuid, sop_iuid, ups_fk, pk]
23:37:54,797 INFO  [TableMetadata] table found: pacsdb.ups_req
23:37:54,798 INFO  [TableMetadata] columns: [req_proc_id, confidentiality, req_service, ups_fk, accession_no, pk]
23:37:54,807 INFO  [TableMetadata] table found: pacsdb.ups_subscr
23:37:54,807 INFO  [TableMetadata] columns: [aet, deletion_lock, ups_fk, pk]
23:37:54,812 INFO  [TableMetadata] table found: pacsdb.verify_observer
23:37:54,812 INFO  [TableMetadata] columns: [observer_i_name, observer_fn_sx, observer_p_name, observer_name, observer_gn_sx, verify_datetime, instance_fk, pk]
23:37:54,817 INFO  [NamingHelper] JNDI InitialContext properties:{java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces}
23:37:54,845 INFO  [EJB3Deployer] Deployed: file:/dcom/dcm4chee-2.17.1-mysql/server/default/tmp/deploy/tmp3513280368320692665dcm4chee-web-ear-3.0.1-mysql.ear-contents/dcm4chee-arc-entities-3.0.1-mysql.jar
23:37:54,862 INFO  [JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
23:37:54,862 INFO  [JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-web-ear-3.0.1-mysql.ear,jar=dcm4chee-usr-dao-3.0.1.jar,name=UserAccessBean,service=EJB3 with dependencies:
23:37:54,862 INFO  [JmxKernelAbstraction] 	persistence.units:ear=dcm4chee-web-ear-3.0.1-mysql.ear,unitName=dcm4chee-usr
23:37:54,864 INFO  [EJB3Deployer] Deployed: file:/dcom/dcm4chee-2.17.1-mysql/server/default/tmp/deploy/tmp3513280368320692665dcm4chee-web-ear-3.0.1-mysql.ear-contents/dcm4chee-usr-dao-3.0.1.jar
23:37:54,864 INFO  [JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.entity.PersistenceUnitDeployment
23:37:54,864 INFO  [JmxKernelAbstraction] installing MBean: persistence.units:ear=dcm4chee-web-ear-3.0.1-mysql.ear,unitName=dcm4chee-usr with dependencies:
23:37:54,864 INFO  [JmxKernelAbstraction] 	jboss.jca:name=pacsDS,service=DataSourceBinding
23:37:54,865 INFO  [PersistenceUnitDeployment] Starting persistence unit persistence.units:ear=dcm4chee-web-ear-3.0.1-mysql.ear,unitName=dcm4chee-usr
23:37:54,868 INFO  [Ejb3Configuration] Processing PersistenceUnitInfo [
	name: dcm4chee-usr
	...]
23:37:54,869 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.usr.entity.User
23:37:54,871 INFO  [Ejb3Configuration] found EJB3 Entity bean: org.dcm4chee.usr.entity.UserRoleAssignment
23:37:54,873 INFO  [Configuration] Reading mappings from resource : META-INF/orm.xml
23:37:54,901 INFO  [Ejb3Configuration] [PersistenceUnit: dcm4chee-usr] META-INF/orm.xml found
23:37:54,913 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.usr.entity.User
23:37:54,913 INFO  [EntityBinder] Bind entity org.dcm4chee.usr.entity.User on table users
23:37:54,915 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.usr.entity.UserRoleAssignment
23:37:54,916 INFO  [EntityBinder] Bind entity org.dcm4chee.usr.entity.UserRoleAssignment on table roles
23:37:54,920 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.AE
23:37:54,921 INFO  [QueryBinder] Binding Named query: AE.findByTitle => select ae from AE ae where title = :title
23:37:54,921 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.AE on table ae
23:37:54,924 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Code
23:37:54,925 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.Code on table code
23:37:54,926 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Device
23:37:54,926 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.Device on table device
23:37:54,927 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.File
23:37:54,928 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.File on table files
23:37:54,931 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.FileSystem
23:37:54,932 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.FileSystem on table filesystem
23:37:54,933 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.GPPPS
23:37:54,934 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.GPPPS on table gppps
23:37:54,937 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.GPSPS
23:37:54,937 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.GPSPS on table gpsps
23:37:54,941 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.GPSPSPerformer
23:37:54,942 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.GPSPSPerformer on table gpsps_perf
23:37:54,943 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.GPSPSRequest
23:37:54,944 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.GPSPSRequest on table gpsps_req
23:37:54,945 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.HangingProtocol
23:37:54,945 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.HangingProtocol on table hp
23:37:54,948 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.HPDefinition
23:37:54,948 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.HPDefinition on table hpdef
23:37:54,950 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Instance
23:37:54,950 INFO  [QueryBinder] Binding Named query: Instance.findByIUID => select object(i) from Instance i where sopInstanceUID = :iuid
23:37:54,950 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.Instance on table instance
23:37:54,956 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Media
23:37:54,956 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.Media on table media
23:37:54,958 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.MPPS
23:37:54,958 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.MPPS on table mpps
23:37:54,961 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.MWLItem
23:37:54,961 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.MWLItem on table mwl_item
23:37:54,964 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.OtherPatientID
23:37:54,964 INFO  [QueryBinder] Binding Named query: OtherPatientID.findByPatientIdAndIssuer => select opid from OtherPatientID opid where patientID = :pid and issuerOfPatientID = :issuer
23:37:54,965 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.OtherPatientID on table other_pid
23:37:54,966 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Patient
23:37:54,966 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.Patient on table patient
23:37:54,972 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.PrivateFile
23:37:54,972 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.PrivateFile on table priv_file
23:37:54,973 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.PrivateInstance
23:37:54,974 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.PrivateInstance on table priv_instance
23:37:54,976 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.PrivatePatient
23:37:54,976 INFO  [QueryBinder] Binding Named query: PrivatePatient.findByIdAndIssuer => select object(p) from PrivatePatient p where patientID = :patId and issuerOfPatientID = :issuer
23:37:54,976 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.PrivatePatient on table priv_patient
23:37:54,977 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.PrivateSeries
23:37:54,978 INFO  [QueryBinder] Binding Named query: PrivateSeries.findByIUID => select object(pi) from PrivateSeries pi where seriesInstanceUID = :iuid
23:37:54,978 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.PrivateSeries on table priv_series
23:37:54,979 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.PrivateStudy
23:37:54,979 INFO  [QueryBinder] Binding Named query: PrivateStudy.findByIUID => select object(ps) from PrivateStudy ps where studyInstanceUID = :iuid
23:37:54,979 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.PrivateStudy on table priv_study
23:37:54,981 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.RequestAttributes
23:37:54,981 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.RequestAttributes on table series_req
23:37:54,983 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Series
23:37:54,984 INFO  [QueryBinder] Binding Named query: Series.findByIUID => select object(s) from Series s where seriesInstanceUID = :iuid
23:37:54,984 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.Series on table series
23:37:54,993 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Study
23:37:54,994 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.Study on table study
23:37:55,000 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.StudyOnFileSystem
23:37:55,001 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.StudyOnFileSystem on table study_on_fs
23:37:55,002 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.StudyPermission
23:37:55,002 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.StudyPermission on table study_permission
23:37:55,002 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.VerifyingObserver
23:37:55,003 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.VerifyingObserver on table verify_observer
23:37:55,005 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.Issuer
23:37:55,005 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.Issuer on table issuer
23:37:55,006 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.ContentItem
23:37:55,006 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.ContentItem on table content_item
23:37:55,007 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.UPS
23:37:55,007 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.UPS on table ups
23:37:55,013 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.UPSRequest
23:37:55,013 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.UPSRequest on table ups_req
23:37:55,015 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.UPSRelatedPS
23:37:55,015 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.UPSRelatedPS on table ups_rel_ps
23:37:55,016 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.UPSReplacedPS
23:37:55,017 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.UPSReplacedPS on table ups_repl_ps
23:37:55,018 INFO  [AnnotationBinder] Binding entity from annotated class: org.dcm4chee.archive.entity.UPSSubscription
23:37:55,018 INFO  [EntityBinder] Bind entity org.dcm4chee.archive.entity.UPSSubscription on table ups_subscr
23:37:55,022 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.usr.entity.User.roles -> roles
23:37:55,022 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.GPSPS.referencedRequests -> gpsps_req
23:37:55,022 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.GPSPS.scheduledHumanPerformers -> gpsps_perf
23:37:55,023 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.HangingProtocol.definitions -> hpdef
23:37:55,023 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Instance.verifyingObservers -> verify_observer
23:37:55,023 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Instance.files -> files
23:37:55,023 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Instance.contentItems -> content_item
23:37:55,023 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Media.instances -> instance
23:37:55,023 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.MPPS.series -> series
23:37:55,023 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.previous -> patient
23:37:55,023 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.studies -> study
23:37:55,024 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.modalityWorklistItems -> mwl_item
23:37:55,024 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.modalityPerformedProcedureSteps -> mpps
23:37:55,024 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.generalPurposeScheduledProcedureSteps -> gpsps
23:37:55,025 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.generalPurposePerformedProcedureSteps -> gppps
23:37:55,025 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Patient.unifiedProcedureSteps -> ups
23:37:55,025 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.PrivateInstance.files -> priv_file
23:37:55,025 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.PrivatePatient.studies -> priv_study
23:37:55,025 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.PrivateSeries.instances -> priv_instance
23:37:55,025 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.PrivateStudy.series -> priv_series
23:37:55,025 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Series.requestAttributes -> series_req
23:37:55,025 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Series.instances -> instance
23:37:55,026 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.Study.series -> series
23:37:55,026 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.UPS.refRequests -> ups_req
23:37:55,026 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.UPS.relatedProcedureSteps -> ups_rel_ps
23:37:55,026 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.UPS.replacedProcedureSteps -> ups_repl_ps
23:37:55,026 INFO  [CollectionBinder] Mapping collection: org.dcm4chee.archive.entity.UPS.subscriptions -> ups_subscr
23:37:55,132 INFO  [ConnectionProviderFactory] Initializing connection provider: org.hibernate.ejb.connection.InjectedDataSourceConnectionProvider
23:37:55,132 INFO  [InjectedDataSourceConnectionProvider] Using provided datasource
23:37:55,132 INFO  [SettingsFactory] RDBMS: MySQL, version: 5.5.34
23:37:55,133 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 $ )
23:37:55,133 INFO  [Dialect] Using dialect: org.hibernate.dialect.MySQLInnoDBDialect
23:37:55,133 INFO  [TransactionFactoryFactory] Transaction strategy: org.hibernate.ejb.transaction.JoinableCMTTransactionFactory
23:37:55,133 INFO  [TransactionManagerLookupFactory] instantiating TransactionManagerLookup: org.hibernate.transaction.JBossTransactionManagerLookup
23:37:55,133 INFO  [TransactionManagerLookupFactory] instantiated TransactionManagerLookup
23:37:55,133 INFO  [SettingsFactory] Automatic flush during beforeCompletion(): disabled
23:37:55,133 INFO  [SettingsFactory] Automatic session close at end of transaction: disabled
23:37:55,133 INFO  [SettingsFactory] JDBC batch size: 15
23:37:55,133 INFO  [SettingsFactory] JDBC batch updates for versioned data: disabled
23:37:55,133 INFO  [SettingsFactory] Scrollable result sets: enabled
23:37:55,133 INFO  [SettingsFactory] JDBC3 getGeneratedKeys(): disabled
23:37:55,133 INFO  [SettingsFactory] Connection release mode: auto
23:37:55,134 INFO  [SettingsFactory] Maximum outer join fetch depth: 2
23:37:55,134 INFO  [SettingsFactory] Default batch fetch size: 1
23:37:55,134 INFO  [SettingsFactory] Generate SQL with comments: disabled
23:37:55,134 INFO  [SettingsFactory] Order SQL updates by primary key: disabled
23:37:55,134 INFO  [SettingsFactory] Order SQL inserts for batching: disabled
23:37:55,134 INFO  [SettingsFactory] Query translator: org.hibernate.hql.ast.ASTQueryTranslatorFactory
23:37:55,134 INFO  [ASTQueryTranslatorFactory] Using ASTQueryTranslatorFactory
23:37:55,134 INFO  [SettingsFactory] Query language substitutions: {}
23:37:55,134 INFO  [SettingsFactory] JPA-QL strict compliance: enabled
23:37:55,134 INFO  [SettingsFactory] Second-level cache: enabled
23:37:55,134 INFO  [SettingsFactory] Query cache: disabled
23:37:55,134 INFO  [SettingsFactory] Cache provider: org.hibernate.cache.HashtableCacheProvider
23:37:55,134 INFO  [SettingsFactory] Optimize cache for minimal puts: disabled
23:37:55,134 INFO  [SettingsFactory] Cache region prefix: dcm4chee-web-ear-3_0_1-mysql_ear,dcm4chee-usr
23:37:55,134 INFO  [SettingsFactory] Structured second-level cache entries: disabled
23:37:55,134 INFO  [SettingsFactory] Statistics: disabled
23:37:55,134 INFO  [SettingsFactory] Deleted entity synthetic identifier rollback: disabled
23:37:55,134 INFO  [SettingsFactory] Default entity-mode: pojo
23:37:55,135 INFO  [SettingsFactory] Named query checking : enabled
23:37:55,164 INFO  [SessionFactoryImpl] building session factory
23:37:55,392 INFO  [SessionFactoryObjectFactory] Factory name: persistence.units:ear=dcm4chee-web-ear-3.0.1-mysql.ear,unitName=dcm4chee-usr
23:37:55,393 INFO  [NamingHelper] JNDI InitialContext properties:{java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces}
23:37:55,393 INFO  [SessionFactoryObjectFactory] Bound factory to JNDI name: persistence.units:ear=dcm4chee-web-ear-3.0.1-mysql.ear,unitName=dcm4chee-usr
23:37:55,393 WARN  [SessionFactoryObjectFactory] InitialContext did not implement EventContext
23:37:55,393 INFO  [SchemaValidator] Running schema validator
23:37:55,393 INFO  [SchemaValidator] fetching database metadata
23:37:55,423 INFO  [TableMetadata] table found: pacsdb.ae
23:37:55,424 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]
23:37:55,427 INFO  [TableMetadata] table found: pacsdb.code
23:37:55,427 INFO  [TableMetadata] columns: [code_version, code_designator, code_value, code_meaning, pk]
23:37:55,429 INFO  [TableMetadata] table found: pacsdb.content_item
23:37:55,429 INFO  [TableMetadata] columns: [name_fk, text_value, rel_type, instance_fk, code_fk, pk]
23:37:55,434 INFO  [TableMetadata] table found: pacsdb.device
23:37:55,434 INFO  [TableMetadata] columns: [station_name, modality, station_aet, pk]
23:37:55,438 INFO  [TableMetadata] table found: pacsdb.files
23:37:55,438 INFO  [TableMetadata] columns: [filepath, file_status, file_size, md5_check_time, created_time, filesystem_fk, instance_fk, file_tsuid, file_md5, pk]
23:37:55,446 INFO  [TableMetadata] table found: pacsdb.filesystem
23:37:55,447 INFO  [TableMetadata] columns: [user_info, retrieve_aet, fs_status, fs_group_id, dirpath, next_fk, availability, pk]
23:37:55,449 INFO  [TableMetadata] table found: pacsdb.gppps
23:37:55,449 INFO  [TableMetadata] columns: [pps_attrs, pps_iuid, patient_fk, pps_status, pps_start, created_time, updated_time, pk]
23:37:55,452 INFO  [TableMetadata] table found: pacsdb.gpsps
23:37:55,452 INFO  [TableMetadata] columns: [gpsps_prior, gpsps_tuid, gpsps_status, end_datetime, in_availability, item_attrs, patient_fk, gpsps_iuid, code_fk, start_datetime, pk]
23:37:55,454 INFO  [TableMetadata] table found: pacsdb.gpsps_perf
23:37:55,454 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]
23:37:55,458 INFO  [TableMetadata] table found: pacsdb.gpsps_req
23:37:55,464 INFO  [TableMetadata] columns: [req_proc_id, gpsps_fk, accession_no, pk]
23:37:55,467 INFO  [TableMetadata] table found: pacsdb.hp
23:37:55,467 INFO  [TableMetadata] columns: [user_fk, num_priors, hp_iuid, num_screens, hp_level, hp_attrs, hp_group, hp_cuid, hp_name, pk]
23:37:55,469 INFO  [TableMetadata] table found: pacsdb.hpdef
23:37:55,470 INFO  [TableMetadata] columns: [hp_fk, laterality, modality, pk]
23:37:55,473 INFO  [TableMetadata] table found: pacsdb.instance
23:37:55,473 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]
23:37:55,475 INFO  [TableMetadata] table found: pacsdb.issuer
23:37:55,478 INFO  [TableMetadata] columns: [entity_uid_type, entity_id, entity_uid, pk]
23:37:55,481 INFO  [TableMetadata] table found: pacsdb.media
23:37:55,481 INFO  [TableMetadata] columns: [media_status_info, media_rq_iuid, media_status, fileset_id, fileset_iuid, created_time, media_usage, updated_time, pk]
23:37:55,487 INFO  [TableMetadata] table found: pacsdb.mpps
23:37:55,488 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]
23:37:55,491 INFO  [TableMetadata] table found: pacsdb.mwl_item
23:37:55,497 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]
23:37:55,500 INFO  [TableMetadata] table found: pacsdb.other_pid
23:37:55,500 INFO  [TableMetadata] columns: [pat_id, pat_id_issuer, pk]
23:37:55,503 INFO  [TableMetadata] table found: pacsdb.patient
23:37:55,503 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]
23:37:55,506 INFO  [TableMetadata] table found: pacsdb.priv_file
23:37:55,506 INFO  [TableMetadata] columns: [filepath, file_status, file_size, filesystem_fk, instance_fk, file_tsuid, file_md5, pk]
23:37:55,508 INFO  [TableMetadata] table found: pacsdb.priv_instance
23:37:55,510 INFO  [TableMetadata] columns: [inst_attrs, priv_type, series_fk, sop_iuid, created_time, pk]
23:37:55,514 INFO  [TableMetadata] table found: pacsdb.priv_patient
23:37:55,514 INFO  [TableMetadata] columns: [priv_type, pat_id, pat_attrs, pat_id_issuer, pat_name, pk]
23:37:55,516 INFO  [TableMetadata] table found: pacsdb.priv_series
23:37:55,516 INFO  [TableMetadata] columns: [priv_type, src_aet, study_fk, series_attrs, series_iuid, pk]
23:37:55,518 INFO  [TableMetadata] table found: pacsdb.priv_study
23:37:55,518 INFO  [TableMetadata] columns: [priv_type, study_iuid, patient_fk, study_attrs, accession_no, pk]
23:37:55,520 INFO  [TableMetadata] table found: pacsdb.rel_dev_proto
23:37:55,520 INFO  [TableMetadata] columns: [prcode_fk, device_fk]
23:37:55,522 INFO  [TableMetadata] table found: pacsdb.rel_gpsps_appcode
23:37:55,522 INFO  [TableMetadata] columns: [appcode_fk, gpsps_fk]
23:37:55,524 INFO  [TableMetadata] table found: pacsdb.rel_gpsps_devclass
23:37:55,524 INFO  [TableMetadata] columns: [devclass_fk, gpsps_fk]
23:37:55,525 INFO  [TableMetadata] table found: pacsdb.rel_gpsps_devloc
23:37:55,525 INFO  [TableMetadata] columns: [devloc_fk, gpsps_fk]
23:37:55,527 INFO  [TableMetadata] table found: pacsdb.rel_gpsps_devname
23:37:55,527 INFO  [TableMetadata] columns: [devname_fk, gpsps_fk]
23:37:55,529 INFO  [TableMetadata] table found: pacsdb.rel_gpsps_gppps
23:37:55,529 INFO  [TableMetadata] columns: [gppps_fk, gpsps_fk]
23:37:55,530 INFO  [TableMetadata] table found: pacsdb.rel_hpdef_proc
23:37:55,531 INFO  [TableMetadata] columns: [proc_fk, hpdef_fk]
23:37:55,532 INFO  [TableMetadata] table found: pacsdb.rel_hpdef_reason
23:37:55,532 INFO  [TableMetadata] columns: [reason_fk, hpdef_fk]
23:37:55,534 INFO  [TableMetadata] table found: pacsdb.rel_hpdef_region
23:37:55,534 INFO  [TableMetadata] columns: [region_fk, hpdef_fk]
23:37:55,536 INFO  [TableMetadata] table found: pacsdb.rel_pat_other_pid
23:37:55,536 INFO  [TableMetadata] columns: [patient_fk, other_pid_fk]
23:37:55,538 INFO  [TableMetadata] table found: pacsdb.rel_study_pcode
23:37:55,538 INFO  [TableMetadata] columns: [study_fk, pcode_fk]
23:37:55,540 INFO  [TableMetadata] table found: pacsdb.rel_ups_appcode
23:37:55,540 INFO  [TableMetadata] columns: [appcode_fk, ups_fk]
23:37:55,542 INFO  [TableMetadata] table found: pacsdb.rel_ups_devclass
23:37:55,542 INFO  [TableMetadata] columns: [devclass_fk, ups_fk]
23:37:55,543 INFO  [TableMetadata] table found: pacsdb.rel_ups_devloc
23:37:55,543 INFO  [TableMetadata] columns: [devloc_fk, ups_fk]
23:37:55,545 INFO  [TableMetadata] table found: pacsdb.rel_ups_devname
23:37:55,545 INFO  [TableMetadata] columns: [devname_fk, ups_fk]
23:37:55,547 INFO  [TableMetadata] table found: pacsdb.rel_ups_performer
23:37:55,547 INFO  [TableMetadata] columns: [performer_fk, ups_fk]
23:37:55,548 INFO  [TableMetadata] table found: pacsdb.roles
23:37:55,549 INFO  [TableMetadata] columns: [roles, user_id]
23:37:55,552 INFO  [TableMetadata] table found: pacsdb.series
23:37:55,553 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]
23:37:55,555 INFO  [TableMetadata] table found: pacsdb.series_req
23:37:55,555 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]
23:37:55,559 INFO  [TableMetadata] table found: pacsdb.study
23:37:55,559 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]
23:37:55,562 INFO  [TableMetadata] table found: pacsdb.study_on_fs
23:37:55,562 INFO  [TableMetadata] columns: [study_fk, access_time, filesystem_fk, mark_to_delete, pk]
23:37:55,564 INFO  [TableMetadata] table found: pacsdb.study_permission
23:37:55,564 INFO  [TableMetadata] columns: [study_iuid, roles, action, pk]
23:37:55,567 INFO  [TableMetadata] table found: pacsdb.ups
23:37:55,567 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]
23:37:55,569 INFO  [TableMetadata] table found: pacsdb.ups_rel_ps
23:37:55,569 INFO  [TableMetadata] columns: [sop_cuid, sop_iuid, ups_fk, pk]
23:37:55,571 INFO  [TableMetadata] table found: pacsdb.ups_repl_ps
23:37:55,571 INFO  [TableMetadata] columns: [sop_cuid, sop_iuid, ups_fk, pk]
23:37:55,573 INFO  [TableMetadata] table found: pacsdb.ups_req
23:37:55,573 INFO  [TableMetadata] columns: [req_proc_id, confidentiality, req_service, ups_fk, accession_no, pk]
23:37:55,575 INFO  [TableMetadata] table found: pacsdb.ups_subscr
23:37:55,575 INFO  [TableMetadata] columns: [aet, deletion_lock, ups_fk, pk]
23:37:55,576 INFO  [TableMetadata] table found: pacsdb.users
23:37:55,577 INFO  [TableMetadata] columns: [passwd, user_id]
23:37:55,579 INFO  [TableMetadata] table found: pacsdb.verify_observer
23:37:55,579 INFO  [TableMetadata] columns: [observer_i_name, observer_fn_sx, observer_p_name, observer_name, observer_gn_sx, verify_datetime, instance_fk, pk]
23:37:55,579 INFO  [NamingHelper] JNDI InitialContext properties:{java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces}
23:37:55,608 INFO  [EJBContainer] STARTED EJB: org.dcm4chee.usr.dao.UserAccessBean ejbName: UserAccessBean
23:37:55,616 INFO  [EJB3Deployer] Deployed: file:/dcom/dcm4chee-2.17.1-mysql/server/default/tmp/deploy/tmp3513280368320692665dcm4chee-web-ear-3.0.1-mysql.ear-contents/dcm4chee-usr-entity-3.0.1-mysql.jar
23:37:55,713 INFO  [JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
23:37:55,719 INFO  [JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-web-ear-3.0.1-mysql.ear,jar=dcm4chee-web-ejb-3.0.1.jar,name=AEHomeBean,service=EJB3 with dependencies:
23:37:55,719 INFO  [JmxKernelAbstraction] 	persistence.units:ear=dcm4chee-web-ear-3.0.1-mysql.ear,unitName=dcm4chee-arc
23:37:55,723 INFO  [EJBContainer] STARTED EJB: org.dcm4chee.web.dao.ae.AEHomeBean ejbName: AEHomeBean
23:37:55,738 INFO  [JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
23:37:55,739 INFO  [JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-web-ear-3.0.1-mysql.ear,jar=dcm4chee-web-ejb-3.0.1.jar,name=DicomEditBean,service=EJB3 with dependencies:
23:37:55,739 INFO  [JmxKernelAbstraction] 	persistence.units:ear=dcm4chee-web-ear-3.0.1-mysql.ear,unitName=dcm4chee-arc
23:37:55,753 INFO  [EJBContainer] STARTED EJB: org.dcm4chee.web.dao.common.DicomEditBean ejbName: DicomEditBean
23:37:55,773 INFO  [JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
23:37:55,773 INFO  [JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-web-ear-3.0.1-mysql.ear,jar=dcm4chee-web-ejb-3.0.1.jar,name=MppsToMwlLinkBean,service=EJB3 with dependencies:
23:37:55,773 INFO  [JmxKernelAbstraction] 	persistence.units:ear=dcm4chee-web-ear-3.0.1-mysql.ear,unitName=dcm4chee-arc
23:37:55,777 INFO  [EJBContainer] STARTED EJB: org.dcm4chee.web.dao.folder.MppsToMwlLinkBean ejbName: MppsToMwlLinkBean
23:37:55,794 INFO  [JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
23:37:55,794 INFO  [JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-web-ear-3.0.1-mysql.ear,jar=dcm4chee-web-ejb-3.0.1.jar,name=StudyListBean,service=EJB3 with dependencies:
23:37:55,794 INFO  [JmxKernelAbstraction] 	persistence.units:ear=dcm4chee-web-ear-3.0.1-mysql.ear,unitName=dcm4chee-arc
23:37:55,808 INFO  [EJBContainer] STARTED EJB: org.dcm4chee.web.dao.folder.StudyListBean ejbName: StudyListBean
23:37:55,828 INFO  [JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
23:37:55,828 INFO  [JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-web-ear-3.0.1-mysql.ear,jar=dcm4chee-web-ejb-3.0.1.jar,name=StudyPermissionsBean,service=EJB3 with dependencies:
23:37:55,828 INFO  [JmxKernelAbstraction] 	persistence.units:ear=dcm4chee-web-ear-3.0.1-mysql.ear,unitName=dcm4chee-arc
23:37:55,833 INFO  [EJBContainer] STARTED EJB: org.dcm4chee.web.dao.folder.StudyPermissionsBean ejbName: StudyPermissionsBean
23:37:55,855 INFO  [JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
23:37:55,856 INFO  [JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-web-ear-3.0.1-mysql.ear,jar=dcm4chee-web-ejb-3.0.1.jar,name=FileSystemHomeBean,service=EJB3 with dependencies:
23:37:55,856 INFO  [JmxKernelAbstraction] 	persistence.units:ear=dcm4chee-web-ear-3.0.1-mysql.ear,unitName=dcm4chee-arc
23:37:55,859 INFO  [EJBContainer] STARTED EJB: org.dcm4chee.web.dao.fs.FileSystemHomeBean ejbName: FileSystemHomeBean
23:37:55,876 INFO  [JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
23:37:55,877 INFO  [JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-web-ear-3.0.1-mysql.ear,jar=dcm4chee-web-ejb-3.0.1.jar,name=TCQueryBean,service=EJB3 with dependencies:
23:37:55,877 INFO  [JmxKernelAbstraction] 	persistence.units:ear=dcm4chee-web-ear-3.0.1-mysql.ear,unitName=dcm4chee-arc
23:37:55,880 INFO  [EJBContainer] STARTED EJB: org.dcm4chee.web.dao.tc.TCQueryBean ejbName: TCQueryBean
23:37:55,904 INFO  [JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
23:37:55,905 INFO  [JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-web-ear-3.0.1-mysql.ear,jar=dcm4chee-web-ejb-3.0.1.jar,name=TrashCleanerBean,service=EJB3 with dependencies:
23:37:55,905 INFO  [JmxKernelAbstraction] 	persistence.units:ear=dcm4chee-web-ear-3.0.1-mysql.ear,unitName=dcm4chee-arc
23:37:55,908 INFO  [EJBContainer] STARTED EJB: org.dcm4chee.web.dao.trash.TrashCleanerBean ejbName: TrashCleanerBean
23:37:55,926 INFO  [JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
23:37:55,927 INFO  [JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-web-ear-3.0.1-mysql.ear,jar=dcm4chee-web-ejb-3.0.1.jar,name=TrashListBean,service=EJB3 with dependencies:
23:37:55,927 INFO  [JmxKernelAbstraction] 	persistence.units:ear=dcm4chee-web-ear-3.0.1-mysql.ear,unitName=dcm4chee-arc
23:37:55,934 INFO  [EJBContainer] STARTED EJB: org.dcm4chee.web.dao.trash.TrashListBean ejbName: TrashListBean
23:37:55,956 INFO  [JmxKernelAbstraction] creating wrapper delegate for: org.jboss.ejb3.stateless.StatelessContainer
23:37:55,957 INFO  [JmxKernelAbstraction] installing MBean: jboss.j2ee:ear=dcm4chee-web-ear-3.0.1-mysql.ear,jar=dcm4chee-web-ejb-3.0.1.jar,name=ModalityWorklistBean,service=EJB3 with dependencies:
23:37:55,957 INFO  [JmxKernelAbstraction] 	persistence.units:ear=dcm4chee-web-ear-3.0.1-mysql.ear,unitName=dcm4chee-arc
23:37:55,966 INFO  [EJBContainer] STARTED EJB: org.dcm4chee.web.dao.worklist.modality.ModalityWorklistBean ejbName: ModalityWorklistBean
23:37:55,978 INFO  [EJB3Deployer] Deployed: file:/dcom/dcm4chee-2.17.1-mysql/server/default/tmp/deploy/tmp3513280368320692665dcm4chee-web-ear-3.0.1-mysql.ear-contents/dcm4chee-web-ejb-3.0.1.jar
23:37:55,981 INFO  [TomcatDeployer] deploy, ctxPath=/dcm4chee-web3-dicom, warUrl=.../tmp/deploy/tmp3513280368320692665dcm4chee-web-ear-3.0.1-mysql.ear-contents/dcm4chee-web-dicom-3.0.1-exp.war/
23:37:56,075 INFO  [TomcatDeployer] deploy, ctxPath=/dcm4chee-web3, warUrl=.../tmp/deploy/tmp3513280368320692665dcm4chee-web-ear-3.0.1-mysql.ear-contents/dcm4chee-web-war-3.0.1-exp.war/
23:37:57,228 INFO  [Application] [WicketApplication] init: Wicket extensions initializer
23:37:57,245 INFO  [Application] [WicketApplication] init: Wicket core library initializer
23:37:57,247 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IBehaviorListener, method=public abstract void org.apache.wicket.behavior.IBehaviorListener.onRequest()]
23:37:57,247 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IBehaviorListener, method=public abstract void org.apache.wicket.behavior.IBehaviorListener.onRequest()]
23:37:57,248 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IFormSubmitListener, method=public abstract void org.apache.wicket.markup.html.form.IFormSubmitListener.onFormSubmitted()]
23:37:57,248 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IFormSubmitListener, method=public abstract void org.apache.wicket.markup.html.form.IFormSubmitListener.onFormSubmitted()]
23:37:57,248 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=ILinkListener, method=public abstract void org.apache.wicket.markup.html.link.ILinkListener.onLinkClicked()]
23:37:57,248 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=ILinkListener, method=public abstract void org.apache.wicket.markup.html.link.ILinkListener.onLinkClicked()]
23:37:57,248 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IOnChangeListener, method=public abstract void org.apache.wicket.markup.html.form.IOnChangeListener.onSelectionChanged()]
23:37:57,249 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IOnChangeListener, method=public abstract void org.apache.wicket.markup.html.form.IOnChangeListener.onSelectionChanged()]
23:37:57,249 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IRedirectListener, method=public abstract void org.apache.wicket.IRedirectListener.onRedirect()]
23:37:57,249 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IRedirectListener, method=public abstract void org.apache.wicket.IRedirectListener.onRedirect()]
23:37:57,249 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IResourceListener, method=public abstract void org.apache.wicket.IResourceListener.onResourceRequested()]
23:37:57,249 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IResourceListener, method=public abstract void org.apache.wicket.IResourceListener.onResourceRequested()]
23:37:57,250 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IActivePageBehaviorListener, method=public abstract void org.apache.wicket.behavior.IBehaviorListener.onRequest()]
23:37:57,250 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IActivePageBehaviorListener, method=public abstract void org.apache.wicket.behavior.IBehaviorListener.onRequest()]
23:37:57,250 INFO  [Application] [WicketApplication] init: Wicket core library initializer
23:37:57,250 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IBehaviorListener, method=public abstract void org.apache.wicket.behavior.IBehaviorListener.onRequest()]
23:37:57,250 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IFormSubmitListener, method=public abstract void org.apache.wicket.markup.html.form.IFormSubmitListener.onFormSubmitted()]
23:37:57,250 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=ILinkListener, method=public abstract void org.apache.wicket.markup.html.link.ILinkListener.onLinkClicked()]
23:37:57,250 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IOnChangeListener, method=public abstract void org.apache.wicket.markup.html.form.IOnChangeListener.onSelectionChanged()]
23:37:57,250 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IRedirectListener, method=public abstract void org.apache.wicket.IRedirectListener.onRedirect()]
23:37:57,250 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IResourceListener, method=public abstract void org.apache.wicket.IResourceListener.onResourceRequested()]
23:37:57,250 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=IActivePageBehaviorListener, method=public abstract void org.apache.wicket.behavior.IBehaviorListener.onRequest()]
23:37:57,250 INFO  [Application] [WicketApplication] init: Wicket extensions initializer
23:37:57,251 INFO  [WebApplication] [WicketApplication] Started Wicket version 1.4.7 in deployment mode
23:37:57,262 INFO  [EARDeployer] Started J2EE application: file:/dcom/dcm4chee-2.17.1-mysql/server/default/deploy/dcm4chee-web-ear-3.0.1-mysql.ear
23:37:57,347 INFO  [Http11Protocol] Starting Coyote HTTP/1.1 on http-0.0.0.0-8080
23:37:57,400 INFO  [Http11Protocol] Starting Coyote HTTP/1.1 on http-8443
23:37:57,424 INFO  [AjpProtocol] Starting Coyote AJP/1.3 on ajp-0.0.0.0-8009
23:37:57,440 INFO  [ServerImpl] Start Server listening on 0.0.0.0:11112
23:37:57,446 INFO  [ServerImpl] Start Server listening on 0.0.0.0:2575
23:37:57,451 INFO  [Server] JBoss (MX MicroKernel) [4.2.3.GA (build: SVNTag=JBoss_4_2_3_GA date=200807181417)] Started in 36s:967ms
23:38:47,569 INFO  [FileSystemMgt2Service] Check file system group LOSSY_STORAGE for deletion of orphaned private files
23:38:47,579 INFO  [FileSystemMgt2Service] Check file system group ONLINE_STORAGE for deletion of orphaned private files
23:39:47,571 INFO  [FileSystemMgt2Service] Check file system group LOSSY_STORAGE for deletion of orphaned private files
23:39:47,581 INFO  [FileSystemMgt2Service] Check file system group ONLINE_STORAGE for deletion of orphaned private files
23:40:47,573 INFO  [FileSystemMgt2Service] Check file system group LOSSY_STORAGE for deletion of orphaned private files
23:40:47,582 INFO  [FileSystemMgt2Service] Check file system group ONLINE_STORAGE for deletion of orphaned private files
23:41:47,576 INFO  [FileSystemMgt2Service] Check file system group LOSSY_STORAGE for deletion of orphaned private files
23:41:47,583 INFO  [FileSystemMgt2Service] Check file system group ONLINE_STORAGE for deletion of orphaned private files
23:42:47,577 INFO  [FileSystemMgt2Service] Check file system group LOSSY_STORAGE for deletion of orphaned private files
23:42:47,585 INFO  [FileSystemMgt2Service] Check file system group ONLINE_STORAGE for deletion of orphaned private files
23:43:47,579 INFO  [FileSystemMgt2Service] Check file system group LOSSY_STORAGE for deletion of orphaned private files
23:43:47,588 INFO  [FileSystemMgt2Service] Check file system group ONLINE_STORAGE for deletion of orphaned private files
23:44:47,581 INFO  [FileSystemMgt2Service] Check file system group LOSSY_STORAGE for deletion of orphaned private files
23:44:47,588 INFO  [FileSystemMgt2Service] Check file system group ONLINE_STORAGE for deletion of orphaned private files
23:45:47,582 INFO  [FileSystemMgt2Service] Check file system group LOSSY_STORAGE for deletion of orphaned private files
23:45:47,590 INFO  [FileSystemMgt2Service] Check file system group ONLINE_STORAGE for deletion of orphaned private files
23:46:39,527 INFO  [Server] Runtime shutdown hook called, forceHalt: true
23:46:39,531 INFO  [Server] JBoss SHUTDOWN: Undeploying all packages
23:46:39,537 INFO  [TomcatDeployer] undeploy, ctxPath=/dcm4chee-web3, warUrl=.../tmp/deploy/tmp3513280368320692665dcm4chee-web-ear-3.0.1-mysql.ear-contents/dcm4chee-web-war-3.0.1-exp.war/
23:46:39,545 INFO  [MPPSEmulatorService] Check for received series without MPPS
23:46:39,565 INFO  [MPPSEmulatorService] Found 0 studies with missing MPPS for sourceAET:MOD_AET
23:46:39,720 INFO  [RequestListenerInterface] registered listener interface [RequestListenerInterface name=INewBrowserWindowListener, method=public abstract void org.apache.wicket.markup.html.INewBrowserWindowListener.onNewBrowserWindow()]
23:46:39,762 INFO  [TomcatDeployer] undeploy, ctxPath=/dcm4chee-web3-dicom, warUrl=.../tmp/deploy/tmp3513280368320692665dcm4chee-web-ear-3.0.1-mysql.ear-contents/dcm4chee-web-dicom-3.0.1-exp.war/
23:46:39,770 INFO  [EJBContainer] STOPPED EJB: org.dcm4chee.web.dao.ae.AEHomeBean ejbName: AEHomeBean
23:46:39,771 WARN  [JmxKernelAbstraction] jboss.j2ee:ear=dcm4chee-web-ear-3.0.1-mysql.ear,jar=dcm4chee-web-ejb-3.0.1.jar,name=AEHomeBean,service=EJB3 is not registered
23:46:39,772 INFO  [EJBContainer] STOPPED EJB: org.dcm4chee.web.dao.common.DicomEditBean ejbName: DicomEditBean
23:46:39,773 WARN  [JmxKernelAbstraction] jboss.j2ee:ear=dcm4chee-web-ear-3.0.1-mysql.ear,jar=dcm4chee-web-ejb-3.0.1.jar,name=DicomEditBean,service=EJB3 is not registered
23:46:39,774 INFO  [EJBContainer] STOPPED EJB: org.dcm4chee.web.dao.folder.MppsToMwlLinkBean ejbName: MppsToMwlLinkBean
23:46:39,775 WARN  [JmxKernelAbstraction] jboss.j2ee:ear=dcm4chee-web-ear-3.0.1-mysql.ear,jar=dcm4chee-web-ejb-3.0.1.jar,name=MppsToMwlLinkBean,service=EJB3 is not registered
23:46:39,776 INFO  [EJBContainer] STOPPED EJB: org.dcm4chee.web.dao.folder.StudyListBean ejbName: StudyListBean
23:46:39,776 WARN  [JmxKernelAbstraction] jboss.j2ee:ear=dcm4chee-web-ear-3.0.1-mysql.ear,jar=dcm4chee-web-ejb-3.0.1.jar,name=StudyListBean,service=EJB3 is not registered
23:46:39,778 INFO  [EJBContainer] STOPPED EJB: org.dcm4chee.web.dao.folder.StudyPermissionsBean ejbName: StudyPermissionsBean
23:46:39,778 WARN  [JmxKernelAbstraction] jboss.j2ee:ear=dcm4chee-web-ear-3.0.1-mysql.ear,jar=dcm4chee-web-ejb-3.0.1.jar,name=StudyPermissionsBean,service=EJB3 is not registered
23:46:39,779 INFO  [EJBContainer] STOPPED EJB: org.dcm4chee.web.dao.fs.FileSystemHomeBean ejbName: FileSystemHomeBean
23:46:39,780 WARN  [JmxKernelAbstraction] jboss.j2ee:ear=dcm4chee-web-ear-3.0.1-mysql.ear,jar=dcm4chee-web-ejb-3.0.1.jar,name=FileSystemHomeBean,service=EJB3 is not registered
23:46:39,781 INFO  [EJBContainer] STOPPED EJB: org.dcm4chee.web.dao.tc.TCQueryBean ejbName: TCQueryBean
23:46:39,781 WARN  [JmxKernelAbstraction] jboss.j2ee:ear=dcm4chee-web-ear-3.0.1-mysql.ear,jar=dcm4chee-web-ejb-3.0.1.jar,name=TCQueryBean,service=EJB3 is not registered
23:46:39,783 INFO  [EJBContainer] STOPPED EJB: org.dcm4chee.web.dao.trash.TrashCleanerBean ejbName: TrashCleanerBean
23:46:39,783 WARN  [JmxKernelAbstraction] jboss.j2ee:ear=dcm4chee-web-ear-3.0.1-mysql.ear,jar=dcm4chee-web-ejb-3.0.1.jar,name=TrashCleanerBean,service=EJB3 is not registered
23:46:39,785 INFO  [EJBContainer] STOPPED EJB: org.dcm4chee.web.dao.trash.TrashListBean ejbName: TrashListBean
23:46:39,785 WARN  [JmxKernelAbstraction] jboss.j2ee:ear=dcm4chee-web-ear-3.0.1-mysql.ear,jar=dcm4chee-web-ejb-3.0.1.jar,name=TrashListBean,service=EJB3 is not registered
23:46:39,787 INFO  [EJBContainer] STOPPED EJB: org.dcm4chee.web.dao.worklist.modality.ModalityWorklistBean ejbName: ModalityWorklistBean
23:46:39,787 WARN  [JmxKernelAbstraction] jboss.j2ee:ear=dcm4chee-web-ear-3.0.1-mysql.ear,jar=dcm4chee-web-ejb-3.0.1.jar,name=ModalityWorklistBean,service=EJB3 is not registered
23:46:39,789 INFO  [EJBContainer] STOPPED EJB: org.dcm4chee.usr.dao.UserAccessBean ejbName: UserAccessBean
23:46:39,789 INFO  [PersistenceUnitDeployment] Stopping persistence unit persistence.units:ear=dcm4chee-web-ear-3.0.1-mysql.ear,unitName=dcm4chee-usr
23:46:39,789 INFO  [SessionFactoryImpl] closing
23:46:39,789 INFO  [SessionFactoryObjectFactory] Unbinding factory from JNDI name: persistence.units:ear=dcm4chee-web-ear-3.0.1-mysql.ear,unitName=dcm4chee-usr
23:46:39,789 INFO  [NamingHelper] JNDI InitialContext properties:{java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces}
23:46:39,789 INFO  [SessionFactoryObjectFactory] Unbound factory from JNDI name: persistence.units:ear=dcm4chee-web-ear-3.0.1-mysql.ear,unitName=dcm4chee-usr
23:46:39,790 WARN  [JmxKernelAbstraction] persistence.units:ear=dcm4chee-web-ear-3.0.1-mysql.ear,unitName=dcm4chee-usr is not registered
23:46:39,791 WARN  [JmxKernelAbstraction] jboss.j2ee:ear=dcm4chee-web-ear-3.0.1-mysql.ear,jar=dcm4chee-usr-dao-3.0.1.jar,name=UserAccessBean,service=EJB3 is not registered
23:46:39,791 INFO  [PersistenceUnitDeployment] Stopping persistence unit persistence.units:ear=dcm4chee-web-ear-3.0.1-mysql.ear,unitName=dcm4chee-arc
23:46:39,791 INFO  [SessionFactoryImpl] closing
23:46:39,791 INFO  [SessionFactoryObjectFactory] Unbinding factory from JNDI name: persistence.units:ear=dcm4chee-web-ear-3.0.1-mysql.ear,unitName=dcm4chee-arc
23:46:39,792 INFO  [NamingHelper] JNDI InitialContext properties:{java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces}
23:46:39,792 INFO  [SessionFactoryObjectFactory] Unbound factory from JNDI name: persistence.units:ear=dcm4chee-web-ear-3.0.1-mysql.ear,unitName=dcm4chee-arc
23:46:39,792 WARN  [JmxKernelAbstraction] persistence.units:ear=dcm4chee-web-ear-3.0.1-mysql.ear,unitName=dcm4chee-arc is not registered
23:46:39,819 INFO  [QueueService] Queue[/queue/RejectionNoteSCU] stopped
23:46:39,820 INFO  [QueueService] Queue[/queue/MoveScu_web] stopped
23:46:39,820 INFO  [QueueService] Queue[/queue/AttributesModification_web] stopped
23:46:39,820 INFO  [QueueService] Queue[/queue/IANSCU_web] stopped
23:46:39,821 INFO  [QueueService] Queue[/queue/HL7SendV2] stopped
23:46:39,915 INFO  [EARDeployer] Undeploying J2EE application, destroy step: file:/dcom/dcm4chee-2.17.1-mysql/server/default/deploy/dcm4chee-web-ear-3.0.1-mysql.ear
23:46:39,915 INFO  [EARDeployer] Undeployed J2EE application: file:/dcom/dcm4chee-2.17.1-mysql/server/default/deploy/dcm4chee-web-ear-3.0.1-mysql.ear
23:46:39,916 INFO  [TomcatDeployer] undeploy, ctxPath=/dcm4chee-arr, warUrl=.../tmp/deploy/tmp4487493803678035995dcm4chee-arr-3.0.11-mysql.ear-contents/dcm4chee-arr-seam-web-3.0.11-mysql-exp.war/
23:46:39,949 INFO  [EJBContainer] STOPPED EJB: org.jboss.seam.async.TimerServiceDispatcher ejbName: TimerServiceDispatcher
23:46:39,950 WARN  [JmxKernelAbstraction] jboss.j2ee:ear=dcm4chee-arr-3.0.11-mysql.ear,jar=jboss-seam-2.1.1.GA.jar,name=TimerServiceDispatcher,service=EJB3 is not registered
23:46:39,951 INFO  [EJBContainer] STOPPED EJB: org.jboss.seam.transaction.EjbSynchronizations ejbName: EjbSynchronizations
23:46:39,952 WARN  [JmxKernelAbstraction] jboss.j2ee:ear=dcm4chee-arr-3.0.11-mysql.ear,jar=jboss-seam-2.1.1.GA.jar,name=EjbSynchronizations,service=EJB3 is not registered
23:46:39,959 INFO  [EJBContainer] STOPPED EJB: org.dcm4chee.arr.listeners.mdb.ReceiverMDB ejbName: ReceiverMDB
23:46:39,961 INFO  [EJBContainer] STOPPED EJB: org.dcm4chee.arr.seam.ejb.AuditRecordAccessBean ejbName: AuditRecordAccessBean
23:46:39,963 INFO  [EJBContainer] STOPPED EJB: org.dcm4chee.arr.seam.ejb.AuditRecordQueryBean ejbName: AuditRecordQueryBean
23:46:39,963 INFO  [EJBContainer] STOPPED EJB: org.dcm4chee.arr.seam.ejb.AuditRecordListAction ejbName: AuditRecordListAction
23:46:39,963 INFO  [PersistenceUnitDeployment] Stopping persistence unit persistence.units:ear=dcm4chee-arr-3.0.11-mysql.ear,unitName=dcm4chee-arr
23:46:39,963 INFO  [SessionFactoryImpl] closing
23:46:39,963 INFO  [SessionFactoryObjectFactory] Unbinding factory from JNDI name: persistence.units:ear=dcm4chee-arr-3.0.11-mysql.ear,unitName=dcm4chee-arr
23:46:39,963 INFO  [NamingHelper] JNDI InitialContext properties:{java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces}
23:46:39,964 INFO  [SessionFactoryObjectFactory] Unbound factory from JNDI name: persistence.units:ear=dcm4chee-arr-3.0.11-mysql.ear,unitName=dcm4chee-arr
23:46:39,965 WARN  [JmxKernelAbstraction] persistence.units:ear=dcm4chee-arr-3.0.11-mysql.ear,unitName=dcm4chee-arr is not registered
23:46:39,965 WARN  [JmxKernelAbstraction] jboss.j2ee:ear=dcm4chee-arr-3.0.11-mysql.ear,jar=dcm4chee-arr-seam-ejb-3.0.11.jar,name=AuditRecordAccessBean,service=EJB3 is not registered
23:46:39,965 WARN  [JmxKernelAbstraction] jboss.j2ee:ear=dcm4chee-arr-3.0.11-mysql.ear,jar=dcm4chee-arr-seam-ejb-3.0.11.jar,name=AuditRecordQueryBean,service=EJB3 is not registered
23:46:39,968 INFO  [EJBContainer] STOPPED EJB: org.dcm4chee.arr.seam.ejb.AuditLogUsedBean ejbName: AuditLogUsedBean
23:46:39,968 WARN  [JmxKernelAbstraction] jboss.j2ee:ear=dcm4chee-arr-3.0.11-mysql.ear,jar=dcm4chee-arr-seam-ejb-3.0.11.jar,name=AuditLogUsedBean,service=EJB3 is not registered
23:46:39,969 WARN  [JmxKernelAbstraction] jboss.j2ee:ear=dcm4chee-arr-3.0.11-mysql.ear,jar=dcm4chee-arr-seam-ejb-3.0.11.jar,name=AuditRecordListAction,service=EJB3 is not registered
23:46:39,969 WARN  [JmxKernelAbstraction] jboss.j2ee:ear=dcm4chee-arr-3.0.11-mysql.ear,jar=dcm4chee-arr-listeners-mdb-3.0.11.jar,name=ReceiverMDB,service=EJB3 is not registered
23:46:39,993 INFO  [SchedulerService] Stop Scheduler DeleteOrphanedPrivateFiles
23:46:39,994 INFO  [SchedulerService] Stop Scheduler DeleteOrphanedPrivateFiles
23:46:39,996 INFO  [SchedulerService] Stop Scheduler CheckPendingSeriesStored
23:46:40,001 INFO  [ServerImpl] Stop Server listening at port 11112
23:46:40,002 INFO  [ServerImpl] Blocking ServerSocket.accept method canceled
23:46:40,004 INFO  [ServerImpl] Stop Server listening at port 2575
23:46:40,005 INFO  [ServerImpl] Blocking ServerSocket.accept method canceled
23:46:40,039 INFO  [UDPListener] Stopped UDP Server listening on 0.0.0.0/0.0.0.0:4000
23:46:40,042 INFO  [TCPListener] Stopped TCP Server listening on /0.0.0.0:6514
23:46:40,043 INFO  [QueueService] Queue[/queue/ARRIncoming] stopped
23:46:40,067 INFO  [EARDeployer] Undeploying J2EE application, destroy step: file:/dcom/dcm4chee-2.17.1-mysql/server/default/deploy/dcm4chee-arr-3.0.11-mysql.ear
23:46:40,071 INFO  [EARDeployer] Undeployed J2EE application: file:/dcom/dcm4chee-2.17.1-mysql/server/default/deploy/dcm4chee-arr-3.0.11-mysql.ear
23:46:40,074 INFO  [TomcatDeployer] undeploy, ctxPath=/jmx-console, warUrl=.../deploy/jmx-console.war/
23:46:40,081 INFO  [TomcatDeployer] undeploy, ctxPath=/wado, warUrl=.../tmp/deploy/tmp2942265469558026759dcm4chee-wado-exp.war/
23:46:40,097 INFO  [TomcatDeployer] undeploy, ctxPath=/rid, warUrl=.../tmp/deploy/tmp5152563152950932529dcm4chee-rid-exp.war/
23:46:40,101 INFO  [EJBDeployer] Undeploying: file:/dcom/dcm4chee-2.17.1-mysql/server/default/deploy/dcm4chee-ejb-mysql.jar
23:46:40,105 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'Storage' from jndi 'StorageLocal'
23:46:40,109 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'FileSystemMgt2' from jndi 'FileSystemMgt2Local'
23:46:40,114 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'PatientUpdate' from jndi 'PatientUpdateLocal'
23:46:40,128 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'SoundexUpdate' from jndi 'SoundexUpdateLocal'
23:46:40,132 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'ContentEdit' from jndi 'ContentEditLocal'
23:46:40,165 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'Issuer' from jndi 'ejb/Issuer'
23:46:40,167 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'GPPPS' from jndi 'ejb/GPPPS'
23:46:40,170 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'Study' from jndi 'ejb/Study'
23:46:40,172 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'ContentItem' from jndi 'ejb/ContentItem'
23:46:40,174 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'GPSPS' from jndi 'ejb/GPSPS'
23:46:40,177 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'UPS' from jndi 'ejb/UPS'
23:46:40,179 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'GPSPSRequest' from jndi 'ejb/GPSPSRequest'
23:46:40,181 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'PrivateSeries' from jndi 'ejb/PrivateSeries'
23:46:40,183 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'HPDefinition' from jndi 'ejb/HPDefinition'
23:46:40,185 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'SeriesRequest' from jndi 'ejb/SeriesRequest'
23:46:40,187 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'File' from jndi 'ejb/File'
23:46:40,189 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'UPSReplacedPS' from jndi 'ejb/UPSReplacedPS'
23:46:40,192 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'UPSRequest' from jndi 'ejb/UPSRequest'
23:46:40,194 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'StudyOnFileSystem' from jndi 'ejb/StudyOnFileSystem'
23:46:40,196 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'Series' from jndi 'ejb/Series'
23:46:40,198 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'OtherPatientID' from jndi 'ejb/OtherPatientID'
23:46:40,200 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'GPSPSPerformer' from jndi 'ejb/GPSPSPerformer'
23:46:40,203 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'UPSGlobalSubscription' from jndi 'ejb/UPSGlobalSubscription'
23:46:40,205 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'FileSystem' from jndi 'ejb/FileSystem'
23:46:40,207 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'UPSSubscription' from jndi 'ejb/UPSSubscription'
23:46:40,209 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'AE' from jndi 'ejb/AE'
23:46:40,211 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'StudyPermission' from jndi 'ejb/StudyPermission'
23:46:40,213 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'Instance' from jndi 'ejb/Instance'
23:46:40,216 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'Patient' from jndi 'ejb/Patient'
23:46:40,218 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'MPPS' from jndi 'ejb/MPPS'
23:46:40,220 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'HP' from jndi 'ejb/HP'
23:46:40,222 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'Code' from jndi 'ejb/Code'
23:46:40,225 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'PrivatePatient' from jndi 'ejb/PrivatePatient'
23:46:40,227 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'PrivateStudy' from jndi 'ejb/PrivateStudy'
23:46:40,229 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'Media' from jndi 'ejb/Media'
23:46:40,231 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'PrivateFile' from jndi 'ejb/PrivateFile'
23:46:40,233 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'UPSRelatedPS' from jndi 'ejb/UPSRelatedPS'
23:46:40,235 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'Device' from jndi 'ejb/Device'
23:46:40,237 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'VerifyingObserver' from jndi 'ejb/VerifyingObserver'
23:46:40,240 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'MWLItem' from jndi 'ejb/MWLItem'
23:46:40,242 INFO  [BaseLocalProxyFactory] Unbind EJB LocalHome 'PrivateInstance' from jndi 'ejb/PrivateInstance'
23:46:40,247 INFO  [ProxyFactory] Unbind EJB Home 'AEManager' from jndi 'ejb/AEManager'
23:46:40,247 INFO  [EjbModule] Undeployed AEManager
23:46:40,248 INFO  [ProxyFactory] Unbind EJB Home 'Storage' from jndi 'ejb/Storage'
23:46:40,248 INFO  [EjbModule] Undeployed Storage
23:46:40,249 INFO  [ProxyFactory] Unbind EJB Home 'FileSystemMgt2' from jndi 'ejb/FileSystemMgt2'
23:46:40,249 INFO  [EjbModule] Undeployed FileSystemMgt2
23:46:40,249 INFO  [ProxyFactory] Unbind EJB Home 'FixPatientAttributes' from jndi 'ejb/FixPatientAttributes'
23:46:40,250 INFO  [EjbModule] Undeployed FixPatientAttributes
23:46:40,250 INFO  [ProxyFactory] Unbind EJB Home 'PatientUpdate' from jndi 'ejb/PatientUpdate'
23:46:40,250 INFO  [EjbModule] Undeployed PatientUpdate
23:46:40,250 INFO  [ProxyFactory] Unbind EJB Home 'AttributesModification' from jndi 'ejb/AttributesModification'
23:46:40,251 INFO  [EjbModule] Undeployed AttributesModification
23:46:40,251 INFO  [ProxyFactory] Unbind EJB Home 'MPPSEmulator' from jndi 'ejb/MPPSEmulator'
23:46:40,251 INFO  [EjbModule] Undeployed MPPSEmulator
23:46:40,252 INFO  [ProxyFactory] Unbind EJB Home 'CodeToDeviceMapping' from jndi 'ejb/CodeToDeviceMapping'
23:46:40,252 INFO  [EjbModule] Undeployed CodeToDeviceMapping
23:46:40,252 INFO  [ProxyFactory] Unbind EJB Home 'StudyReconciliation' from jndi 'ejb/StudyReconciliation'
23:46:40,252 INFO  [EjbModule] Undeployed StudyReconciliation
23:46:40,253 INFO  [ProxyFactory] Unbind EJB Home 'PrivateManager' from jndi 'ejb/PrivateManager'
23:46:40,253 INFO  [EjbModule] Undeployed PrivateManager
23:46:40,253 INFO  [ProxyFactory] Unbind EJB Home 'SoundexUpdate' from jndi 'ejb/SoundexUpdate'
23:46:40,254 INFO  [EjbModule] Undeployed SoundexUpdate
23:46:40,254 INFO  [ProxyFactory] Unbind EJB Home 'ContentManager' from jndi 'ejb/ContentManager'
23:46:40,254 INFO  [EjbModule] Undeployed ContentManager
23:46:40,254 INFO  [ProxyFactory] Unbind EJB Home 'ContentEdit' from jndi 'ejb/ContentEdit'
23:46:40,255 INFO  [EjbModule] Undeployed ContentEdit
23:46:40,255 INFO  [ProxyFactory] Unbind EJB Home 'MediaComposer' from jndi 'ejb/MediaComposer'
23:46:40,255 INFO  [EjbModule] Undeployed MediaComposer
23:46:40,256 INFO  [ProxyFactory] Unbind EJB Home 'MPPSManager' from jndi 'ejb/MPPSManager'
23:46:40,256 INFO  [EjbModule] Undeployed MPPSManager
23:46:40,257 INFO  [ProxyFactory] Unbind EJB Home 'UserManager' from jndi 'ejb/UserManager'
23:46:40,257 INFO  [EjbModule] Undeployed UserManager
23:46:40,257 INFO  [ProxyFactory] Unbind EJB Home 'StudyPermissionManager' from jndi 'ejb/StudyPermissionManager'
23:46:40,257 INFO  [EjbModule] Undeployed StudyPermissionManager
23:46:40,258 INFO  [ProxyFactory] Unbind EJB Home 'ConsistencyCheck' from jndi 'ejb/ConsistencyCheck'
23:46:40,258 INFO  [EjbModule] Undeployed ConsistencyCheck
23:46:40,258 INFO  [ProxyFactory] Unbind EJB Home 'AvailabilityUpdate' from jndi 'ejb/AvailabilityUpdate'
23:46:40,259 INFO  [EjbModule] Undeployed AvailabilityUpdate
23:46:40,259 INFO  [ProxyFactory] Unbind EJB Home 'UPSManager' from jndi 'ejb/UPSManager'
23:46:40,259 INFO  [EjbModule] Undeployed UPSManager
23:46:40,259 INFO  [ProxyFactory] Unbind EJB Home 'MWLManager' from jndi 'ejb/MWLManager'
23:46:40,260 INFO  [EjbModule] Undeployed MWLManager
23:46:40,260 INFO  [ProxyFactory] Unbind EJB Home 'HPStorage' from jndi 'ejb/HPStorage'
23:46:40,260 INFO  [EjbModule] Undeployed HPStorage
23:46:40,261 INFO  [ProxyFactory] Unbind EJB Home 'UpdateAttributes' from jndi 'ejb/UpdateAttributes'
23:46:40,261 INFO  [EjbModule] Undeployed UpdateAttributes
23:46:40,261 INFO  [ProxyFactory] Unbind EJB Home 'PIXQuery' from jndi 'ejb/PIXQuery'
23:46:40,261 INFO  [EjbModule] Undeployed PIXQuery
23:46:40,262 INFO  [ProxyFactory] Unbind EJB Home 'StudyMgt' from jndi 'ejb/StudyMgt'
23:46:40,262 INFO  [EjbModule] Undeployed StudyMgt
23:46:40,262 INFO  [ProxyFactory] Unbind EJB Home 'GPWLManager' from jndi 'ejb/GPWLManager'
23:46:40,263 INFO  [EjbModule] Undeployed GPWLManager
23:46:40,263 INFO  [ProxyFactory] Unbind EJB Home 'GPPPSManager' from jndi 'ejb/GPPPSManager'
23:46:40,263 INFO  [EjbModule] Undeployed GPPPSManager
23:46:40,264 INFO  [EjbModule] Undeployed Issuer
23:46:40,265 INFO  [EjbModule] Undeployed GPPPS
23:46:40,265 INFO  [EjbModule] Undeployed Study
23:46:40,266 INFO  [EjbModule] Undeployed ContentItem
23:46:40,266 INFO  [EjbModule] Undeployed GPSPS
23:46:40,267 INFO  [EjbModule] Undeployed UPS
23:46:40,267 INFO  [EjbModule] Undeployed GPSPSRequest
23:46:40,268 INFO  [EjbModule] Undeployed PrivateSeries
23:46:40,268 INFO  [EjbModule] Undeployed HPDefinition
23:46:40,269 INFO  [EjbModule] Undeployed SeriesRequest
23:46:40,269 INFO  [EjbModule] Undeployed File
23:46:40,270 INFO  [EjbModule] Undeployed UPSReplacedPS
23:46:40,271 INFO  [EjbModule] Undeployed UPSRequest
23:46:40,271 INFO  [EjbModule] Undeployed StudyOnFileSystem
23:46:40,272 INFO  [EjbModule] Undeployed Series
23:46:40,272 INFO  [EjbModule] Undeployed OtherPatientID
23:46:40,273 INFO  [EjbModule] Undeployed GPSPSPerformer
23:46:40,273 INFO  [EjbModule] Undeployed UPSGlobalSubscription
23:46:40,274 INFO  [EjbModule] Undeployed FileSystem
23:46:40,274 INFO  [EjbModule] Undeployed UPSSubscription
23:46:40,275 INFO  [EjbModule] Undeployed AE
23:46:40,275 INFO  [EjbModule] Undeployed StudyPermission
23:46:40,276 INFO  [EjbModule] Undeployed Instance
23:46:40,276 INFO  [EjbModule] Undeployed Patient
23:46:40,277 INFO  [EjbModule] Undeployed MPPS
23:46:40,277 INFO  [EjbModule] Undeployed HP
23:46:40,278 INFO  [EjbModule] Undeployed Code
23:46:40,278 INFO  [EjbModule] Undeployed PrivatePatient
23:46:40,279 INFO  [EjbModule] Undeployed PrivateStudy
23:46:40,279 INFO  [EjbModule] Undeployed Media
23:46:40,280 INFO  [EjbModule] Undeployed PrivateFile
23:46:40,280 INFO  [EjbModule] Undeployed UPSRelatedPS
23:46:40,281 INFO  [EjbModule] Undeployed Device
23:46:40,281 INFO  [EjbModule] Undeployed VerifyingObserver
23:46:40,282 INFO  [EjbModule] Undeployed MWLItem
23:46:40,282 INFO  [EjbModule] Undeployed PrivateInstance
23:46:40,293 INFO  [ConnectionFactory] org.jboss.jms.server.connectionfactory.ConnectionFactory@547b6d1c undeployed
23:46:40,293 INFO  [ConnectionFactory] org.jboss.jms.server.connectionfactory.ConnectionFactory@70ee90b1 undeployed
23:46:40,293 INFO  [ConnectionFactory] org.jboss.jms.server.connectionfactory.ConnectionFactory@1af6a711 undeployed
23:46:40,294 INFO  [QueueService] Queue[/queue/DLQ] stopped
23:46:40,294 INFO  [QueueService] Queue[/queue/ExpiryQueue] stopped
23:46:40,294 INFO  [QueueService] Queue[/queue/AttributesModificationScu] stopped
23:46:40,295 INFO  [QueueService] Queue[/queue/DeleteStudy] stopped
23:46:40,295 INFO  [QueueService] Queue[/queue/ExportManager] stopped
23:46:40,295 INFO  [QueueService] Queue[/queue/FileCopy] stopped
23:46:40,295 INFO  [QueueService] Queue[/queue/FileMove] stopped
23:46:40,296 INFO  [QueueService] Queue[/queue/HL7Send] stopped
23:46:40,296 INFO  [QueueService] Queue[/queue/IANScu] stopped
23:46:40,296 INFO  [QueueService] Queue[/queue/MCMScu] stopped
23:46:40,296 INFO  [QueueService] Queue[/queue/MoveScu] stopped
23:46:40,296 INFO  [QueueService] Queue[/queue/MPPSScu] stopped
23:46:40,297 INFO  [QueueService] Queue[/queue/PPSExceptionMgt] stopped
23:46:40,297 INFO  [QueueService] Queue[/queue/PPSScu] stopped
23:46:40,297 INFO  [QueueService] Queue[/queue/Prefetch] stopped
23:46:40,297 INFO  [QueueService] Queue[/queue/RejectionNoteStored] stopped
23:46:40,297 INFO  [QueueService] Queue[/queue/Sendmail] stopped
23:46:40,298 INFO  [QueueService] Queue[/queue/StgCmtScuScp] stopped
23:46:40,298 INFO  [QueueService] Queue[/queue/StudyMgtScu] stopped
23:46:40,298 INFO  [QueueService] Queue[/queue/UpgradeToEnhancedMF] stopped
23:46:40,298 INFO  [QueueService] Queue[/queue/UPSScp] stopped
23:46:40,298 INFO  [QueueService] Queue[/queue/WadoPrefetch] stopped
23:46:40,322 INFO  [ServerPeer] JMS ServerPeer[0] stopped
23:46:40,324 INFO  [ConnectionFactoryBindingService] Unbound ConnectionManager 'jboss.jca:service=DataSourceBinding,name=pacsDS' from JNDI name 'java:pacsDS'
23:46:40,344 INFO  [ConnectionFactoryBindingService] Unbound ConnectionManager 'jboss.jca:service=ConnectionFactoryBinding,name=JmsXA' from JNDI name 'java:JmsXA'
23:46:40,348 INFO  [ConnectionFactoryBindingService] Unbound ConnectionManager 'jboss.jca:service=DataSourceBinding,name=arrDS' from JNDI name 'java:arrDS'
23:46:40,351 INFO  [QuartzScheduler] Scheduler DefaultQuartzScheduler_$_NON_CLUSTERED shutting down.
23:46:40,351 INFO  [QuartzScheduler] Scheduler DefaultQuartzScheduler_$_NON_CLUSTERED paused.
23:46:40,353 INFO  [SimpleThreadPool] There are still 38 worker threads active. See javadoc runInThread(Runnable) for a possible explanation
23:46:40,353 INFO  [QuartzScheduler] Scheduler DefaultQuartzScheduler_$_NON_CLUSTERED shutdown complete.
23:46:40,366 INFO  [MailService] Mail service 'java:/Mail' removed from JNDI
23:46:40,369 INFO  [TomcatDeployer] undeploy, ctxPath=/web-console, warUrl=.../deploy/management/console-mgr.sar/web-console.war/
23:46:40,386 INFO  [Http11Protocol] Pausing Coyote HTTP/1.1 on http-0.0.0.0-8080
23:46:40,401 INFO  [Http11Protocol] Pausing Coyote HTTP/1.1 on http-8443
23:46:40,406 INFO  [AjpProtocol] Pausing Coyote AJP/1.3 on ajp-0.0.0.0-8009
23:46:41,410 INFO  [StandardService] Stopping service jboss.web
23:46:41,433 INFO  [Http11Protocol] Stopping Coyote HTTP/1.1 on http-0.0.0.0-8080
23:46:41,434 INFO  [Http11Protocol] Stopping Coyote HTTP/1.1 on http-8443
23:46:41,435 INFO  [AjpProtocol] Stopping Coyote AJP/1.3 on ajp-0.0.0.0-8009
23:46:41,437 INFO  [TomcatDeployer] undeploy, ctxPath=/, warUrl=.../deploy/jboss-web.deployer/ROOT.war/
23:46:41,437 INFO  [TomcatDeployer] undeploy, ctxPath=/invoker, warUrl=.../deploy/http-invoker.sar/invoker.war/
23:46:41,438 INFO  [TomcatDeployer] undeploy, ctxPath=/jbossws, warUrl=.../deploy/jbossws.sar/jbossws-context.war/
23:46:43,532 INFO  [TransactionManagerService] Stopping recovery manager
23:46:43,594 INFO  [Server] Shutdown complete
Shutdown complete
Halting VM