cbcase@CoBRA-Test-Server:/opt/jboss-portal-2.6.3.GA/bin$ sudo ./run.sh ========================================================================= JBoss Bootstrap Environment JBOSS_HOME: /opt/jboss-portal-2.6.3.GA JAVA: java JAVA_OPTS: -Dprogram.name=run.sh -server -Xms128m -Xmx512m -Dsun.rmi.dgc.client.gcInterval=3600000 -Dsun.rmi.dgc.server.gcInterval=3600000 -Djava.net.preferIPv4Stack=true CLASSPATH: /opt/jboss-portal-2.6.3.GA/bin/run.jar ========================================================================= 16:49:43,158 INFO [Server] Starting JBoss (MX MicroKernel)... 16:49:43,158 INFO [Server] Release ID: JBoss [Trinity] 4.2.2.GA (build: SVNTag=JBoss_4_2_2_GA date=200710221139) 16:49:43,159 INFO [Server] Home Dir: /opt/jboss-portal-2.6.3.GA 16:49:43,160 INFO [Server] Home URL: file:/opt/jboss-portal-2.6.3.GA/ 16:49:43,160 INFO [Server] Patch URL: null 16:49:43,160 INFO [Server] Server Name: default 16:49:43,160 INFO [Server] Server Home Dir: /opt/jboss-portal-2.6.3.GA/server/default 16:49:43,161 INFO [Server] Server Home URL: file:/opt/jboss-portal-2.6.3.GA/server/default/ 16:49:43,161 INFO [Server] Server Log Dir: /opt/jboss-portal-2.6.3.GA/server/default/log 16:49:43,161 INFO [Server] Server Temp Dir: /opt/jboss-portal-2.6.3.GA/server/default/tmp 16:49:43,161 INFO [Server] Root Deployment Filename: jboss-service.xml 16:49:43,420 INFO [ServerInfo] Java version: 1.5.0_13,Sun Microsystems Inc. 16:49:43,421 INFO [ServerInfo] Java VM: Java HotSpot(TM) 64-Bit Server VM 1.5.0_13-b05,Sun Microsystems Inc. 16:49:43,421 INFO [ServerInfo] OS-System: Linux 2.6.22-14-generic,amd64 16:49:43,735 INFO [Server] Core system initialized 16:49:45,354 INFO [WebService] Using RMI server codebase: http://127.0.0.1:8083/ 16:49:45,356 INFO [Log4jService$URLWatchTimerTask] Configuring from URL: resource:jboss-log4j.xml 16:49:45,733 INFO [TransactionManagerService] JBossTS Transaction Service (JTA version) - JBoss Inc. 16:49:45,733 INFO [TransactionManagerService] Setting up property manager MBean and JMX layer 16:49:45,882 INFO [TransactionManagerService] Starting recovery manager 16:49:45,952 INFO [TransactionManagerService] Recovery manager started 16:49:45,952 INFO [TransactionManagerService] Binding TransactionManager JNDI Reference 16:49:48,075 INFO [EJB3Deployer] Starting java:comp multiplexer 16:49:54,460 INFO [STDOUT] no object for null 16:49:54,463 INFO [STDOUT] no object for null 16:49:54,481 INFO [STDOUT] no object for null 16:49:54,499 INFO [STDOUT] no object for {urn:jboss:bean-deployer}supplyType 16:49:54,508 INFO [STDOUT] no object for {urn:jboss:bean-deployer}dependsType 16:49:56,083 INFO [NativeServerConfig] JBoss Web Services - Native 16:49:56,083 INFO [NativeServerConfig] jbossws-native-2.0.1.SP2 (build=200710210837) 16:49:56,515 INFO [NativeServiceRefBinderJAXRPC] setupServiceRef [jndi=wsrp-client/service/PortletManagementService] 16:49:56,539 INFO [NativeServiceRefBinderJAXRPC] setupServiceRef [jndi=wsrp-client/service/MarkupService] 16:49:56,541 INFO [NativeServiceRefBinderJAXRPC] setupServiceRef [jndi=wsrp-client/service/ServiceDescriptionService] 16:49:56,544 INFO [NativeServiceRefBinderJAXRPC] setupServiceRef [jndi=wsrp-client/service/RegistrationService] 16:49:56,546 INFO [ClientDeployer] Client ENC bound under: wsrp-client 16:49:56,877 INFO [Embedded] Catalina naming disabled 16:49:57,019 INFO [AprLifecycleListener] The Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path: /usr/lib/jvm/java-1.5.0-sun-1.5.0.13/jre/lib/amd64/server:/usr/lib/jvm/java-1.5.0-sun-1.5.0.13/jre/lib/amd64:/usr/lib/jvm/java-1.5.0-sun-1.5.0.13/jre/../lib/amd64 16:49:57,085 INFO [Http11Protocol] Initializing Coyote HTTP/1.1 on http-127.0.0.1-8080 16:49:57,086 INFO [AjpProtocol] Initializing Coyote AJP/1.3 on ajp-127.0.0.1-8009 16:49:57,086 INFO [Catalina] Initialization processed in 209 ms 16:49:57,086 INFO [StandardService] Starting service jboss.web 16:49:57,088 INFO [StandardEngine] Starting Servlet Engine: JBossWeb/2.0.1.GA 16:49:57,137 INFO [Catalina] Server startup in 50 ms 16:49:57,213 INFO [TomcatDeployer] deploy, ctxPath=/, warUrl=.../deploy/jboss-web.deployer/ROOT.war/ 16:49:57,731 INFO [TomcatDeployer] deploy, ctxPath=/invoker, warUrl=.../deploy/http-invoker.sar/invoker.war/ 16:49:57,844 INFO [TomcatDeployer] deploy, ctxPath=/portal-admin, warUrl=.../deploy/jboss-portal.sar/portal-admin.sar/portal-admin.war/ 16:49:58,029 INFO [FacesConfigurator] Reading standard config org/apache/myfaces/resource/standard-faces-config.xml 16:49:58,090 INFO [FacesConfigurator] Reading config jar:file:/opt/jboss-portal-2.6.3.GA/server/default/./deploy/jboss-portal.sar/portal-admin.sar/portal-admin.war/WEB-INF/lib2/jsf-facelets.jar!/META-INF/faces-config.xml 16:49:58,099 INFO [FacesConfigurator] Reading config /WEB-INF/faces-config.xml 16:49:58,147 INFO [FacesConfigurator] MyFaces-package : myfaces-api not found. 16:49:58,147 INFO [FacesConfigurator] MyFaces-package : myfaces-impl not found. 16:49:58,147 INFO [FacesConfigurator] MyFaces-package : tomahawk-sandbox not found. 16:49:58,148 INFO [FacesConfigurator] MyFaces-package : tomahawk not found. 16:49:58,258 WARN [LocaleUtils] Locale name in faces-config.xml null or empty, setting locale to default locale : en_US 16:49:58,394 INFO [FacesConfigurator] Serialization provider : class org.apache.myfaces.shared_impl.util.serial.DefaultSerialFactory 16:49:58,402 INFO [StartupServletContextListener] ServletContext '/opt/jboss-portal-2.6.3.GA/server/default/./deploy/jboss-portal.sar/portal-admin.sar/portal-admin.war/' initialized. 16:49:58,433 INFO [TomcatDeployer] deploy, ctxPath=/portal-cms, warUrl=.../deploy/jboss-portal.sar/portal-cms.sar/portal-cms.war/ 16:49:58,523 INFO [TomcatDeployer] deploy, ctxPath=/portal-identity, warUrl=.../deploy/jboss-portal.sar/portal-identity.sar/portal-identity.war/ 16:49:58,706 INFO [FacesConfigurator] Reading standard config org/apache/myfaces/resource/standard-faces-config.xml 16:49:58,759 INFO [FacesConfigurator] Reading config jar:file:/opt/jboss-portal-2.6.3.GA/server/default/./deploy/jboss-portal.sar/portal-identity.sar/portal-identity.war/WEB-INF/lib2/jsf-facelets.jar!/META-INF/faces-config.xml 16:49:58,768 INFO [FacesConfigurator] Reading config /WEB-INF/faces-config.xml 16:49:58,808 INFO [FacesConfigurator] MyFaces-package : myfaces-api not found. 16:49:58,808 INFO [FacesConfigurator] MyFaces-package : myfaces-impl not found. 16:49:58,808 INFO [FacesConfigurator] MyFaces-package : tomahawk-sandbox not found. 16:49:58,808 INFO [FacesConfigurator] MyFaces-package : tomahawk not found. 16:49:58,861 WARN [LocaleUtils] Locale name in faces-config.xml null or empty, setting locale to default locale : en_US 16:49:58,989 INFO [FacesConfigurator] Serialization provider : class org.apache.myfaces.shared_impl.util.serial.DefaultSerialFactory 16:49:58,998 INFO [StartupServletContextListener] ServletContext '/opt/jboss-portal-2.6.3.GA/server/default/./deploy/jboss-portal.sar/portal-identity.sar/portal-identity.war/' initialized. 16:49:59,021 INFO [TomcatDeployer] deploy, ctxPath=/portal-wsrp-admin, warUrl=.../deploy/jboss-portal.sar/portal-wsrp.sar/portal-wsrp-admin.war/ 16:49:59,180 INFO [FacesConfigurator] Reading standard config org/apache/myfaces/resource/standard-faces-config.xml 16:49:59,230 INFO [FacesConfigurator] Reading config jar:file:/opt/jboss-portal-2.6.3.GA/server/default/./deploy/jboss-portal.sar/portal-wsrp.sar/portal-wsrp-admin.war/WEB-INF/lib2/jsf-facelets.jar!/META-INF/faces-config.xml 16:49:59,238 INFO [FacesConfigurator] Reading config /WEB-INF/faces-config.xml 16:49:59,258 INFO [FacesConfigurator] MyFaces-package : myfaces-api not found. 16:49:59,258 INFO [FacesConfigurator] MyFaces-package : myfaces-impl not found. 16:49:59,258 INFO [FacesConfigurator] MyFaces-package : tomahawk-sandbox not found. 16:49:59,258 INFO [FacesConfigurator] MyFaces-package : tomahawk not found. 16:49:59,293 WARN [LocaleUtils] Locale name in faces-config.xml null or empty, setting locale to default locale : en_US 16:49:59,394 INFO [FacesConfigurator] Serialization provider : class org.apache.myfaces.shared_impl.util.serial.DefaultSerialFactory 16:49:59,402 INFO [StartupServletContextListener] ServletContext '/opt/jboss-portal-2.6.3.GA/server/default/./deploy/jboss-portal.sar/portal-wsrp.sar/portal-wsrp-admin.war/' initialized. 16:49:59,465 INFO [DefaultEndpointRegistry] register: jboss.ws:context=portal-wsrp,endpoint=ServiceDescriptionService 16:49:59,467 INFO [DefaultEndpointRegistry] register: jboss.ws:context=portal-wsrp,endpoint=MarkupService 16:49:59,468 INFO [DefaultEndpointRegistry] register: jboss.ws:context=portal-wsrp,endpoint=RegistrationService 16:49:59,469 INFO [DefaultEndpointRegistry] register: jboss.ws:context=portal-wsrp,endpoint=PortletManagementService 16:49:59,650 INFO [TomcatDeployer] deploy, ctxPath=/portal-wsrp, warUrl=.../deploy/jboss-portal.sar/portal-wsrp.sar/portal-wsrp.war/ 16:50:01,269 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}Fault 16:50:01,269 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}InvalidCookieFault 16:50:01,270 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}UnsupportedMimeTypeFault 16:50:01,271 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}InconsistentParametersFault 16:50:01,271 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}UnsupportedLocaleFault 16:50:01,271 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}InvalidHandleFault 16:50:01,271 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}InvalidRegistrationFault 16:50:01,271 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}InvalidUserCategoryFault 16:50:01,272 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}PortletStateChangeRequiredFault 16:50:01,272 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}UnsupportedWindowStateFault 16:50:01,272 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}UnsupportedModeFault 16:50:01,272 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}InvalidSessionFault 16:50:01,272 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}MissingParametersFault 16:50:01,272 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}OperationFailedFault 16:50:01,272 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}AccessDeniedFault 16:50:01,442 INFO [WSDLFilePublisher] WSDL published to: file:/opt/jboss-portal-2.6.3.GA/server/default/data/wsdl/portal-wsrp.sar/portal-wsrp.war/wsrp_services.wsdl 16:50:01,501 INFO [TomcatDeployer] deploy, ctxPath=/portal-users-samples, warUrl=.../deploy/jboss-portal.sar/samples/portal-users-samples.sar/portal-users-samples.war/ 16:50:01,575 INFO [TomcatDeployer] deploy, ctxPath=/portal-ajax, warUrl=.../deploy/jboss-portal.sar/portal-ajax.war/ 16:50:01,642 INFO [TomcatDeployer] deploy, ctxPath=/portal-core, warUrl=.../deploy/jboss-portal.sar/portal-core.war/ 16:50:01,723 INFO [TomcatDeployer] deploy, ctxPath=/portal, warUrl=.../deploy/jboss-portal.sar/portal-server.war/ 16:50:01,820 INFO [TomcatDeployer] deploy, ctxPath=/portal-widget-netvibes, warUrl=.../deploy/jboss-portal.sar/portal-widget-netvibes.war/ 16:50:01,907 INFO [TomcatDeployer] deploy, ctxPath=/portal-widget, warUrl=.../deploy/jboss-portal.sar/portal-widget.war/ 16:50:01,996 INFO [TomcatDeployer] deploy, ctxPath=/portal-jsp-samples, warUrl=.../deploy/jboss-portal.sar/samples/portal-jsp-samples.war/ 16:50:02,070 INFO [TomcatDeployer] deploy, ctxPath=/portal-news-samples, warUrl=.../deploy/jboss-portal.sar/samples/portal-news-samples.war/ 16:50:02,168 INFO [TomcatDeployer] deploy, ctxPath=/portal-weather-samples, warUrl=.../deploy/jboss-portal.sar/samples/portal-weather-samples.war/ 16:50:02,258 INFO [TomcatDeployer] deploy, ctxPath=/jbossws, warUrl=.../deploy/jbossws.sar/jbossws-context.war/ 16:50:02,332 INFO [TomcatDeployer] deploy, ctxPath=/jbossmq-httpil, warUrl=.../deploy/jms/jbossmq-httpil.sar/jbossmq-httpil.war/ 16:50:02,910 INFO [TomcatDeployer] deploy, ctxPath=/web-console, warUrl=.../deploy/management/console-mgr.sar/web-console.war/ 16:50:03,315 INFO [MailService] Mail Service bound to java:/Mail 16:50:03,444 INFO [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/jboss-ha-local-jdbc.rar 16:50:03,476 INFO [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/jboss-ha-xa-jdbc.rar 16:50:03,497 INFO [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/jboss-local-jdbc.rar 16:50:03,519 INFO [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/jboss-xa-jdbc.rar 16:50:03,555 INFO [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/jms/jms-ra.rar 16:50:03,579 INFO [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/mail-ra.rar 16:50:03,613 INFO [RARDeployment] Required license terms exist, view META-INF/ra.xml in .../deploy/quartz-ra.rar 16:50:03,623 INFO [QuartzResourceAdapter] start quartz!!! 16:50:03,722 INFO [SimpleThreadPool] Job execution threads will use class loader of thread: main 16:50:03,747 INFO [QuartzScheduler] Quartz Scheduler v.1.5.2 created. 16:50:03,750 INFO [RAMJobStore] RAMJobStore initialized. 16:50:03,750 INFO [StdSchedulerFactory] Quartz scheduler 'DefaultQuartzScheduler' initialized from default resource file in Quartz package: 'quartz.properties' 16:50:03,750 INFO [StdSchedulerFactory] Quartz scheduler version: 1.5.2 16:50:03,751 INFO [QuartzScheduler] Scheduler DefaultQuartzScheduler_$_NON_CLUSTERED started. 16:50:04,336 INFO [ConnectionFactoryBindingService] Bound ConnectionManager 'jboss.jca:service=DataSourceBinding,name=DefaultDS' to JNDI name 'java:DefaultDS' 16:50:04,613 INFO [A] Bound to JNDI name: queue/A 16:50:04,615 INFO [B] Bound to JNDI name: queue/B 16:50:04,616 INFO [C] Bound to JNDI name: queue/C 16:50:04,617 INFO [D] Bound to JNDI name: queue/D 16:50:04,619 INFO [ex] Bound to JNDI name: queue/ex 16:50:04,639 INFO [testTopic] Bound to JNDI name: topic/testTopic 16:50:04,640 INFO [securedTopic] Bound to JNDI name: topic/securedTopic 16:50:04,642 INFO [testDurableTopic] Bound to JNDI name: topic/testDurableTopic 16:50:04,646 INFO [testQueue] Bound to JNDI name: queue/testQueue 16:50:04,697 INFO [UILServerILService] JBossMQ UIL service available at : /127.0.0.1:8093 16:50:04,741 INFO [DLQ] Bound to JNDI name: queue/DLQ 16:50:04,862 INFO [ConnectionFactoryBindingService] Bound ConnectionManager 'jboss.jca:service=ConnectionFactoryBinding,name=JmsXA' to JNDI name 'java:JmsXA' 16:50:04,938 INFO [Environment] Hibernate 3.2.4.sp1 16:50:04,946 INFO [Environment] hibernate.properties not found 16:50:04,948 INFO [Environment] Bytecode provider name : javassist 16:50:04,957 INFO [Environment] using JDK 1.4 java.sql.Timestamp handling 16:50:05,068 INFO [Configuration] configuring from url: file:/opt/jboss-portal-2.6.3.GA/server/default/deploy/jboss-portal.sar/portal-cms.sar/conf/hibernate/cms/hibernate.cfg.xml 16:50:05,080 INFO [Configuration] Reading mappings from resource : conf/hibernate/cms/domain.hbm.xml 16:50:05,194 INFO [HbmBinder] Mapping class: org.jboss.portal.cms.hibernate.state.VersionBinVal -> jbp_cms_version_binval 16:50:05,224 INFO [HbmBinder] Mapping class: org.jboss.portal.cms.hibernate.state.VersionNode -> jbp_cms_version_node 16:50:05,225 INFO [HbmBinder] Mapping class: org.jboss.portal.cms.hibernate.state.VersionProp -> jbp_cms_version_prop 16:50:05,225 INFO [HbmBinder] Mapping class: org.jboss.portal.cms.hibernate.state.VersionRefs -> jbp_cms_version_refs 16:50:05,226 INFO [HbmBinder] Mapping class: org.jboss.portal.cms.hibernate.state.WSPBinVal -> jbp_cms_wsp_binval 16:50:05,226 INFO [HbmBinder] Mapping class: org.jboss.portal.cms.hibernate.state.WSPNode -> jbp_cms_wsp_node 16:50:05,227 INFO [HbmBinder] Mapping class: org.jboss.portal.cms.hibernate.state.WSPProp -> jbp_cms_wsp_prop 16:50:05,228 INFO [HbmBinder] Mapping class: org.jboss.portal.cms.hibernate.state.WSPRefs -> jbp_cms_wsp_refs 16:50:05,228 INFO [HbmBinder] Mapping class: org.jboss.portal.cms.hibernate.CMSEntry -> jbp_cms_cmsentry 16:50:05,229 INFO [HbmBinder] Mapping class: org.jboss.portal.cms.hibernate.RepositoryEntry -> jbp_cms_repositoryentry 16:50:05,230 INFO [HbmBinder] Mapping class: org.jboss.portal.cms.hibernate.VersionEntry -> jbp_cms_versionentry 16:50:05,231 INFO [HbmBinder] Mapping class: org.jboss.portal.cms.security.PermRoleAssoc -> jbp_cms_perm_role 16:50:05,231 INFO [HbmBinder] Mapping class: org.jboss.portal.cms.security.PermUserAssoc -> jbp_cms_perm_user 16:50:05,232 INFO [HbmBinder] Mapping class: org.jboss.portal.cms.security.Criteria -> jbp_cms_perm_criteria 16:50:05,232 INFO [HbmBinder] Mapping class: org.jboss.portal.cms.security.Permission -> jbp_cms_perm 16:50:05,243 INFO [Configuration] Configured SessionFactory: null 16:50:05,247 INFO [GenericTransactionManagerLookup] Found TransactionManager for JBoss, JRun4 16:50:05,352 INFO [Configuration] configuring from url: file:/opt/jboss-portal-2.6.3.GA/server/default/deploy/jboss-portal.sar/conf/hibernate/workflow/hibernate.cfg.xml 16:50:05,359 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/action/Script.hbm.xml 16:50:05,382 INFO [Configuration] Reading mappings from resource : org/jbpm/identity/User.hbm.xml 16:50:05,403 INFO [HbmBinder] Mapping class: org.jbpm.identity.User -> JBPM_ID_USER 16:50:05,422 INFO [HbmBinder] Mapping collection: org.jbpm.identity.User.permissions -> JBPM_ID_PERMISSIONS 16:50:05,422 INFO [Configuration] Reading mappings from resource : org/jbpm/identity/Group.hbm.xml 16:50:05,442 INFO [HbmBinder] Mapping class: org.jbpm.identity.Group -> JBPM_ID_GROUP 16:50:05,571 INFO [HbmBinder] Mapping collection: org.jbpm.identity.Group.permissions -> JBPM_ID_PERMISSIONS 16:50:05,572 INFO [Configuration] Reading mappings from resource : org/jbpm/identity/Membership.hbm.xml 16:50:05,591 INFO [HbmBinder] Mapping class: org.jbpm.identity.Membership -> JBPM_ID_MEMBERSHIP 16:50:05,593 INFO [HbmBinder] Mapping collection: org.jbpm.identity.Membership.permissions -> JBPM_ID_PERMISSIONS 16:50:05,593 INFO [Configuration] Reading mappings from resource : org/jbpm/db/hibernate.queries.hbm.xml 16:50:05,622 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/def/ProcessDefinition.hbm.xml 16:50:05,643 INFO [HbmBinder] Mapping class: org.jbpm.graph.def.ProcessDefinition -> JBPM_PROCESSDEFINITION 16:50:05,679 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/def/Node.hbm.xml 16:50:05,700 INFO [HbmBinder] Mapping class: org.jbpm.graph.def.Node -> JBPM_NODE 16:50:05,713 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/def/Transition.hbm.xml 16:50:05,733 INFO [HbmBinder] Mapping class: org.jbpm.graph.def.Transition -> JBPM_TRANSITION 16:50:05,736 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/def/Event.hbm.xml 16:50:05,756 INFO [HbmBinder] Mapping class: org.jbpm.graph.def.Event -> JBPM_EVENT 16:50:05,758 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/def/Action.hbm.xml 16:50:05,776 INFO [HbmBinder] Mapping class: org.jbpm.graph.def.Action -> JBPM_ACTION 16:50:05,780 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/def/SuperState.hbm.xml 16:50:05,847 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.def.SuperState -> JBPM_NODE 16:50:05,847 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/def/ExceptionHandler.hbm.xml 16:50:05,866 INFO [HbmBinder] Mapping class: org.jbpm.graph.def.ExceptionHandler -> JBPM_EXCEPTIONHANDLER 16:50:05,867 INFO [Configuration] Reading mappings from resource : org/jbpm/instantiation/Delegation.hbm.xml 16:50:05,884 INFO [HbmBinder] Mapping class: org.jbpm.instantiation.Delegation -> JBPM_DELEGATION 16:50:05,886 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/node/StartState.hbm.xml 16:50:05,902 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.node.StartState -> JBPM_NODE 16:50:05,902 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/node/EndState.hbm.xml 16:50:05,917 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.node.EndState -> JBPM_NODE 16:50:05,917 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/node/ProcessState.hbm.xml 16:50:05,933 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.node.ProcessState -> JBPM_NODE 16:50:05,937 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/node/Decision.hbm.xml 16:50:05,954 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.node.Decision -> JBPM_NODE 16:50:05,957 INFO [HbmBinder] Mapping collection: org.jbpm.graph.node.Decision.decisionConditions -> JBPM_DECISIONCONDITIONS 16:50:05,957 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/node/Fork.hbm.xml 16:50:05,973 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.node.Fork -> JBPM_NODE 16:50:05,973 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/node/Join.hbm.xml 16:50:05,988 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.node.Join -> JBPM_NODE 16:50:05,988 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/node/State.hbm.xml 16:50:06,003 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.node.State -> JBPM_NODE 16:50:06,003 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/node/TaskNode.hbm.xml 16:50:06,019 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.node.TaskNode -> JBPM_NODE 16:50:06,029 INFO [Configuration] Reading mappings from resource : org/jbpm/context/def/ContextDefinition.hbm.xml 16:50:06,043 INFO [Configuration] Reading mappings from resource : org/jbpm/context/def/VariableAccess.hbm.xml 16:50:06,058 INFO [HbmBinder] Mapping class: org.jbpm.context.def.VariableAccess -> JBPM_VARIABLEACCESS 16:50:06,061 INFO [Configuration] Reading mappings from resource : org/jbpm/taskmgmt/def/TaskMgmtDefinition.hbm.xml 16:50:06,075 INFO [Configuration] Reading mappings from resource : org/jbpm/taskmgmt/def/Swimlane.hbm.xml 16:50:06,089 INFO [HbmBinder] Mapping class: org.jbpm.taskmgmt.def.Swimlane -> JBPM_SWIMLANE 16:50:06,092 INFO [Configuration] Reading mappings from resource : org/jbpm/taskmgmt/def/Task.hbm.xml 16:50:06,109 INFO [HbmBinder] Mapping class: org.jbpm.taskmgmt.def.Task -> JBPM_TASK 16:50:06,113 INFO [Configuration] Reading mappings from resource : org/jbpm/taskmgmt/def/TaskController.hbm.xml 16:50:06,128 INFO [HbmBinder] Mapping class: org.jbpm.taskmgmt.def.TaskController -> JBPM_TASKCONTROLLER 16:50:06,130 INFO [Configuration] Reading mappings from resource : org/jbpm/module/def/ModuleDefinition.hbm.xml 16:50:06,143 INFO [HbmBinder] Mapping class: org.jbpm.module.def.ModuleDefinition -> JBPM_MODULEDEFINITION 16:50:06,144 INFO [Configuration] Reading mappings from resource : org/jbpm/bytes/ByteArray.hbm.xml 16:50:06,158 INFO [HbmBinder] Mapping class: org.jbpm.bytes.ByteArray -> JBPM_BYTEARRAY 16:50:06,159 INFO [HbmBinder] Mapping collection: org.jbpm.bytes.ByteArray.byteBlocks -> JBPM_BYTEBLOCK 16:50:06,160 INFO [Configuration] Reading mappings from resource : org/jbpm/file/def/FileDefinition.hbm.xml 16:50:06,172 INFO [HbmBinder] Mapping subclass: org.jbpm.file.def.FileDefinition -> JBPM_MODULEDEFINITION 16:50:06,173 INFO [Configuration] Reading mappings from resource : org/jbpm/scheduler/def/CreateTimerAction.hbm.xml 16:50:06,185 INFO [HbmBinder] Mapping subclass: org.jbpm.scheduler.def.CreateTimerAction -> JBPM_ACTION 16:50:06,189 INFO [Configuration] Reading mappings from resource : org/jbpm/scheduler/def/CancelTimerAction.hbm.xml 16:50:06,200 INFO [HbmBinder] Mapping subclass: org.jbpm.scheduler.def.CancelTimerAction -> JBPM_ACTION 16:50:06,202 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/exe/Comment.hbm.xml 16:50:06,214 INFO [HbmBinder] Mapping class: org.jbpm.graph.exe.Comment -> JBPM_COMMENT 16:50:06,216 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/exe/ProcessInstance.hbm.xml 16:50:06,230 INFO [HbmBinder] Mapping class: org.jbpm.graph.exe.ProcessInstance -> JBPM_PROCESSINSTANCE 16:50:06,237 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/exe/Token.hbm.xml 16:50:06,251 INFO [HbmBinder] Mapping class: org.jbpm.graph.exe.Token -> JBPM_TOKEN 16:50:06,258 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/exe/RuntimeAction.hbm.xml 16:50:06,271 INFO [HbmBinder] Mapping class: org.jbpm.graph.exe.RuntimeAction -> JBPM_RUNTIMEACTION 16:50:06,272 INFO [Configuration] Reading mappings from resource : org/jbpm/module/exe/ModuleInstance.hbm.xml 16:50:06,284 INFO [HbmBinder] Mapping class: org.jbpm.module.exe.ModuleInstance -> JBPM_MODULEINSTANCE 16:50:06,285 INFO [Configuration] Reading mappings from resource : org/jbpm/context/exe/ContextInstance.hbm.xml 16:50:06,296 INFO [HbmBinder] Mapping subclass: org.jbpm.context.exe.ContextInstance -> JBPM_MODULEINSTANCE 16:50:06,297 INFO [Configuration] Reading mappings from resource : org/jbpm/context/exe/TokenVariableMap.hbm.xml 16:50:06,307 INFO [HbmBinder] Mapping class: org.jbpm.context.exe.TokenVariableMap -> JBPM_TOKENVARIABLEMAP 16:50:06,313 INFO [Configuration] Reading mappings from resource : org/jbpm/context/exe/VariableInstance.hbm.xml 16:50:06,323 INFO [HbmBinder] Mapping class: org.jbpm.context.exe.VariableInstance -> JBPM_VARIABLEINSTANCE 16:50:06,328 INFO [Configuration] Reading mappings from resource : org/jbpm/context/exe/variableinstance/ByteArrayInstance.hbm.xml 16:50:06,336 INFO [HbmBinder] Mapping subclass: org.jbpm.context.exe.variableinstance.ByteArrayInstance -> JBPM_VARIABLEINSTANCE 16:50:06,337 INFO [Configuration] Reading mappings from resource : org/jbpm/context/exe/variableinstance/DateInstance.hbm.xml 16:50:06,345 INFO [HbmBinder] Mapping subclass: org.jbpm.context.exe.variableinstance.DateInstance -> JBPM_VARIABLEINSTANCE 16:50:06,345 INFO [Configuration] Reading mappings from resource : org/jbpm/context/exe/variableinstance/DoubleInstance.hbm.xml 16:50:06,353 INFO [HbmBinder] Mapping subclass: org.jbpm.context.exe.variableinstance.DoubleInstance -> JBPM_VARIABLEINSTANCE 16:50:06,353 INFO [Configuration] Reading mappings from resource : org/jbpm/context/exe/variableinstance/HibernateLongInstance.hbm.xml 16:50:06,361 INFO [HbmBinder] Mapping subclass: org.jbpm.context.exe.variableinstance.HibernateLongInstance -> JBPM_VARIABLEINSTANCE 16:50:06,362 INFO [Configuration] Reading mappings from resource : org/jbpm/context/exe/variableinstance/HibernateStringInstance.hbm.xml 16:50:06,370 INFO [HbmBinder] Mapping subclass: org.jbpm.context.exe.variableinstance.HibernateStringInstance -> JBPM_VARIABLEINSTANCE 16:50:06,370 INFO [Configuration] Reading mappings from resource : org/jbpm/context/exe/variableinstance/LongInstance.hbm.xml 16:50:06,377 INFO [HbmBinder] Mapping subclass: org.jbpm.context.exe.variableinstance.LongInstance -> JBPM_VARIABLEINSTANCE 16:50:06,378 INFO [Configuration] Reading mappings from resource : org/jbpm/context/exe/variableinstance/NullInstance.hbm.xml 16:50:06,385 INFO [HbmBinder] Mapping subclass: org.jbpm.context.exe.variableinstance.NullInstance -> JBPM_VARIABLEINSTANCE 16:50:06,385 INFO [Configuration] Reading mappings from resource : org/jbpm/context/exe/variableinstance/StringInstance.hbm.xml 16:50:06,393 INFO [HbmBinder] Mapping subclass: org.jbpm.context.exe.variableinstance.StringInstance -> JBPM_VARIABLEINSTANCE 16:50:06,393 INFO [Configuration] Reading mappings from resource : org/jbpm/msg/Message.hbm.xml 16:50:06,402 INFO [HbmBinder] Mapping class: org.jbpm.msg.Message -> JBPM_MESSAGE 16:50:06,404 INFO [Configuration] Reading mappings from resource : org/jbpm/msg/db/TextMessage.hbm.xml 16:50:06,411 INFO [HbmBinder] Mapping subclass: org.jbpm.msg.db.TextMessage -> JBPM_MESSAGE 16:50:06,413 INFO [Configuration] Reading mappings from resource : org/jbpm/command/ExecuteActionCommand.hbm.xml 16:50:06,421 INFO [HbmBinder] Mapping subclass: org.jbpm.command.ExecuteActionCommand -> JBPM_MESSAGE 16:50:06,421 INFO [Configuration] Reading mappings from resource : org/jbpm/command/ExecuteNodeCommand.hbm.xml 16:50:06,429 INFO [HbmBinder] Mapping subclass: org.jbpm.command.ExecuteNodeCommand -> JBPM_MESSAGE 16:50:06,430 INFO [Configuration] Reading mappings from resource : org/jbpm/command/SignalCommand.hbm.xml 16:50:06,438 INFO [HbmBinder] Mapping subclass: org.jbpm.command.SignalCommand -> JBPM_MESSAGE 16:50:06,439 INFO [Configuration] Reading mappings from resource : org/jbpm/command/TaskInstanceEndCommand.hbm.xml 16:50:06,447 INFO [HbmBinder] Mapping subclass: org.jbpm.command.TaskInstanceEndCommand -> JBPM_MESSAGE 16:50:06,449 INFO [Configuration] Reading mappings from resource : org/jbpm/taskmgmt/exe/TaskMgmtInstance.hbm.xml 16:50:06,458 INFO [HbmBinder] Mapping subclass: org.jbpm.taskmgmt.exe.TaskMgmtInstance -> JBPM_MODULEINSTANCE 16:50:06,463 INFO [Configuration] Reading mappings from resource : org/jbpm/taskmgmt/exe/TaskInstance.hbm.xml 16:50:06,475 INFO [HbmBinder] Mapping class: org.jbpm.taskmgmt.exe.TaskInstance -> JBPM_TASKINSTANCE 16:50:06,484 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.exe.TaskInstance.pooledActors -> JBPM_TASKACTORPOOL 16:50:06,484 INFO [Configuration] Reading mappings from resource : org/jbpm/taskmgmt/exe/PooledActor.hbm.xml 16:50:06,494 INFO [HbmBinder] Mapping class: org.jbpm.taskmgmt.exe.PooledActor -> JBPM_POOLEDACTOR 16:50:06,496 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.exe.PooledActor.taskInstances -> JBPM_TASKACTORPOOL 16:50:06,496 INFO [Configuration] Reading mappings from resource : org/jbpm/taskmgmt/exe/SwimlaneInstance.hbm.xml 16:50:06,505 INFO [HbmBinder] Mapping class: org.jbpm.taskmgmt.exe.SwimlaneInstance -> JBPM_SWIMLANEINSTANCE 16:50:06,506 INFO [Configuration] Reading mappings from resource : org/jbpm/scheduler/exe/Timer.hbm.xml 16:50:06,515 INFO [HbmBinder] Mapping class: org.jbpm.scheduler.exe.Timer -> JBPM_TIMER 16:50:06,517 INFO [Configuration] Reading mappings from resource : org/jbpm/logging/log/ProcessLog.hbm.xml 16:50:06,529 INFO [HbmBinder] Mapping class: org.jbpm.logging.log.ProcessLog -> JBPM_LOG 16:50:06,530 INFO [Configuration] Reading mappings from resource : org/jbpm/logging/log/MessageLog.hbm.xml 16:50:06,537 INFO [HbmBinder] Mapping subclass: org.jbpm.logging.log.MessageLog -> JBPM_LOG 16:50:06,537 INFO [Configuration] Reading mappings from resource : org/jbpm/logging/log/CompositeLog.hbm.xml 16:50:06,545 INFO [HbmBinder] Mapping subclass: org.jbpm.logging.log.CompositeLog -> JBPM_LOG 16:50:06,545 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/log/ActionLog.hbm.xml 16:50:06,552 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.log.ActionLog -> JBPM_LOG 16:50:06,552 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/log/NodeLog.hbm.xml 16:50:06,559 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.log.NodeLog -> JBPM_LOG 16:50:06,560 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/log/ProcessInstanceCreateLog.hbm.xml 16:50:06,566 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.log.ProcessInstanceCreateLog -> JBPM_LOG 16:50:06,566 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/log/ProcessInstanceEndLog.hbm.xml 16:50:06,573 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.log.ProcessInstanceEndLog -> JBPM_LOG 16:50:06,573 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/log/ProcessStateLog.hbm.xml 16:50:06,580 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.log.ProcessStateLog -> JBPM_LOG 16:50:06,580 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/log/SignalLog.hbm.xml 16:50:06,587 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.log.SignalLog -> JBPM_LOG 16:50:06,587 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/log/TokenCreateLog.hbm.xml 16:50:06,594 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.log.TokenCreateLog -> JBPM_LOG 16:50:06,594 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/log/TokenEndLog.hbm.xml 16:50:06,600 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.log.TokenEndLog -> JBPM_LOG 16:50:06,601 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/log/TransitionLog.hbm.xml 16:50:06,608 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.log.TransitionLog -> JBPM_LOG 16:50:06,608 INFO [Configuration] Reading mappings from resource : org/jbpm/context/log/VariableLog.hbm.xml 16:50:06,615 INFO [HbmBinder] Mapping subclass: org.jbpm.context.log.VariableLog -> JBPM_LOG 16:50:06,615 INFO [Configuration] Reading mappings from resource : org/jbpm/context/log/VariableCreateLog.hbm.xml 16:50:06,622 INFO [HbmBinder] Mapping subclass: org.jbpm.context.log.VariableCreateLog -> JBPM_LOG 16:50:06,622 INFO [Configuration] Reading mappings from resource : org/jbpm/context/log/VariableDeleteLog.hbm.xml 16:50:06,628 INFO [HbmBinder] Mapping subclass: org.jbpm.context.log.VariableDeleteLog -> JBPM_LOG 16:50:06,628 INFO [Configuration] Reading mappings from resource : org/jbpm/context/log/VariableUpdateLog.hbm.xml 16:50:06,635 INFO [HbmBinder] Mapping subclass: org.jbpm.context.log.VariableUpdateLog -> JBPM_LOG 16:50:06,635 INFO [Configuration] Reading mappings from resource : org/jbpm/context/log/variableinstance/ByteArrayUpdateLog.hbm.xml 16:50:06,641 INFO [HbmBinder] Mapping subclass: org.jbpm.context.log.variableinstance.ByteArrayUpdateLog -> JBPM_LOG 16:50:06,641 INFO [Configuration] Reading mappings from resource : org/jbpm/context/log/variableinstance/DateUpdateLog.hbm.xml 16:50:06,647 INFO [HbmBinder] Mapping subclass: org.jbpm.context.log.variableinstance.DateUpdateLog -> JBPM_LOG 16:50:06,648 INFO [Configuration] Reading mappings from resource : org/jbpm/context/log/variableinstance/DoubleUpdateLog.hbm.xml 16:50:06,654 INFO [HbmBinder] Mapping subclass: org.jbpm.context.log.variableinstance.DoubleUpdateLog -> JBPM_LOG 16:50:06,654 INFO [Configuration] Reading mappings from resource : org/jbpm/context/log/variableinstance/HibernateLongUpdateLog.hbm.xml 16:50:06,660 INFO [HbmBinder] Mapping subclass: org.jbpm.context.log.variableinstance.HibernateLongUpdateLog -> JBPM_LOG 16:50:06,661 INFO [Configuration] Reading mappings from resource : org/jbpm/context/log/variableinstance/HibernateStringUpdateLog.hbm.xml 16:50:06,667 INFO [HbmBinder] Mapping subclass: org.jbpm.context.log.variableinstance.HibernateStringUpdateLog -> JBPM_LOG 16:50:06,667 INFO [Configuration] Reading mappings from resource : org/jbpm/context/log/variableinstance/LongUpdateLog.hbm.xml 16:50:06,673 INFO [HbmBinder] Mapping subclass: org.jbpm.context.log.variableinstance.LongUpdateLog -> JBPM_LOG 16:50:06,673 INFO [Configuration] Reading mappings from resource : org/jbpm/context/log/variableinstance/StringUpdateLog.hbm.xml 16:50:06,679 INFO [HbmBinder] Mapping subclass: org.jbpm.context.log.variableinstance.StringUpdateLog -> JBPM_LOG 16:50:06,680 INFO [Configuration] Reading mappings from resource : org/jbpm/taskmgmt/log/TaskLog.hbm.xml 16:50:06,686 INFO [HbmBinder] Mapping subclass: org.jbpm.taskmgmt.log.TaskLog -> JBPM_LOG 16:50:06,686 INFO [Configuration] Reading mappings from resource : org/jbpm/taskmgmt/log/TaskCreateLog.hbm.xml 16:50:06,692 INFO [HbmBinder] Mapping subclass: org.jbpm.taskmgmt.log.TaskCreateLog -> JBPM_LOG 16:50:06,692 INFO [Configuration] Reading mappings from resource : org/jbpm/taskmgmt/log/TaskAssignLog.hbm.xml 16:50:06,698 INFO [HbmBinder] Mapping subclass: org.jbpm.taskmgmt.log.TaskAssignLog -> JBPM_LOG 16:50:06,699 INFO [Configuration] Reading mappings from resource : org/jbpm/taskmgmt/log/TaskEndLog.hbm.xml 16:50:06,705 INFO [HbmBinder] Mapping subclass: org.jbpm.taskmgmt.log.TaskEndLog -> JBPM_LOG 16:50:06,705 INFO [Configuration] Reading mappings from resource : org/jbpm/taskmgmt/log/SwimlaneLog.hbm.xml 16:50:06,711 INFO [HbmBinder] Mapping subclass: org.jbpm.taskmgmt.log.SwimlaneLog -> JBPM_LOG 16:50:06,711 INFO [Configuration] Reading mappings from resource : org/jbpm/taskmgmt/log/SwimlaneCreateLog.hbm.xml 16:50:06,717 INFO [HbmBinder] Mapping subclass: org.jbpm.taskmgmt.log.SwimlaneCreateLog -> JBPM_LOG 16:50:06,719 INFO [Configuration] Reading mappings from resource : org/jbpm/taskmgmt/log/SwimlaneAssignLog.hbm.xml 16:50:06,725 INFO [HbmBinder] Mapping subclass: org.jbpm.taskmgmt.log.SwimlaneAssignLog -> JBPM_LOG 16:50:06,726 INFO [Configuration] Configured SessionFactory: null 16:50:06,728 INFO [Configuration] configuring from url: file:/opt/jboss-portal-2.6.3.GA/server/default/deploy/jboss-portal.sar/portal-wsrp.sar/conf/hibernate/consumer/hibernate.cfg.xml 16:50:06,731 INFO [Configuration] Reading mappings from resource : conf/hibernate/consumer/domain.hbm.xml 16:50:06,742 INFO [HbmBinder] Mapping class: org.jboss.portal.wsrp.consumer.ProducerInfo -> JBP_PRODUCER_INFO 16:50:06,743 INFO [HbmBinder] Mapping class: org.jboss.portal.wsrp.consumer.EndpointConfigurationInfo -> JBP_ENDPOINT_INFO 16:50:06,743 INFO [HbmBinder] Mapping class: org.jboss.portal.wsrp.consumer.RegistrationInfo -> JBP_REGISTRATION_INFO 16:50:06,744 INFO [HbmBinder] Mapping class: org.jboss.portal.wsrp.consumer.RegistrationProperty -> JBP_REG_PROPERTY 16:50:06,744 INFO [HbmBinder] Mapping class: org.jboss.portal.wsrp.registration.RegistrationPropertyDescription -> JBP_REG_PROP_DESC 16:50:06,747 INFO [HbmBinder] Mapping collection: org.jboss.portal.wsrp.registration.RegistrationPropertyDescription.usages -> JBP_REG_PROP_DESC_USAGES 16:50:06,748 INFO [HbmBinder] Mapping collection: org.jboss.portal.wsrp.registration.RegistrationPropertyDescription.aliases -> JBP_REG_PROP_DESC_ALIASES 16:50:06,748 INFO [Configuration] Configured SessionFactory: null 16:50:06,755 INFO [Configuration] configuring from url: file:/opt/jboss-portal-2.6.3.GA/server/default/deploy/jboss-portal.sar/conf/hibernate/user/hibernate.cfg.xml 16:50:06,759 INFO [Configuration] Reading mappings from resource : conf/hibernate/user/domain.hbm.xml 16:50:06,768 INFO [HbmBinder] Mapping class: org.jboss.portal.identity.db.HibernateUserImpl -> jbp_users 16:50:06,769 INFO [HbmBinder] Mapping collection: org.jboss.portal.identity.db.HibernateUserImpl.dynamic -> jbp_user_prop 16:50:06,769 INFO [HbmBinder] Mapping collection: org.jboss.portal.identity.db.HibernateUserImpl.roles -> jbp_role_membership 16:50:06,770 INFO [HbmBinder] Mapping class: org.jboss.portal.identity.db.HibernateRoleImpl -> jbp_roles 16:50:06,770 INFO [HbmBinder] Mapping collection: org.jboss.portal.identity.db.HibernateRoleImpl.users -> jbp_role_membership 16:50:06,770 INFO [Configuration] Configured SessionFactory: null 16:50:06,778 INFO [Configuration] configuring from url: file:/opt/jboss-portal-2.6.3.GA/server/default/deploy/jboss-portal.sar/conf/hibernate/instance/hibernate.cfg.xml 16:50:06,781 INFO [Configuration] Reading mappings from resource : conf/hibernate/instance/domain.hbm.xml 16:50:06,791 INFO [HbmBinder] Mapping class: org.jboss.portal.core.impl.model.instance.persistent.PersistentInstanceDefinition -> JBP_INSTANCE 16:50:06,796 INFO [HbmBinder] Mapping collection: org.jboss.portal.core.impl.model.instance.persistent.PersistentInstanceDefinition.displayNames -> JBP_INSTANCE_DISPLAY_NAMES 16:50:06,797 INFO [HbmBinder] Mapping class: org.jboss.portal.core.impl.model.instance.persistent.PersistentInstanceCustomization -> JBP_INSTANCE_PER_USER 16:50:06,798 INFO [HbmBinder] Mapping class: org.jboss.portal.core.impl.model.instance.persistent.PersistentRoleSecurityBinding -> JBP_INSTANCE_SECURITY 16:50:06,800 INFO [HbmBinder] Mapping collection: org.jboss.portal.core.impl.model.instance.persistent.PersistentRoleSecurityBinding.actions -> JBP_INSTANCE_SECURITY_ACTIONS 16:50:06,800 INFO [Configuration] Configured SessionFactory: null 16:50:06,803 INFO [Configuration] configuring from url: file:/opt/jboss-portal-2.6.3.GA/server/default/deploy/jboss-portal.sar/conf/hibernate/portal/hibernate.cfg.xml 16:50:06,806 INFO [Configuration] Reading mappings from resource : conf/hibernate/portal/domain.hbm.xml 16:50:06,817 INFO [HbmBinder] Mapping class: org.jboss.portal.core.impl.model.portal.ObjectNode -> JBP_OBJECT_NODE 16:50:06,824 INFO [HbmBinder] Mapping class: org.jboss.portal.core.impl.model.portal.PortalObjectImpl -> JBP_PORTAL_OBJECT 16:50:06,826 INFO [HbmBinder] Mapping collection: org.jboss.portal.core.impl.model.portal.PortalObjectImpl.displayNames -> JBP_PORTAL_OBJECT_DNAMES 16:50:06,826 INFO [HbmBinder] Mapping collection: org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredPropertyMap -> JBP_PORTAL_OBJECT_PROPS 16:50:06,831 INFO [HbmBinder] Mapping joined-subclass: org.jboss.portal.core.impl.model.portal.ContextImpl -> JBP_CONTEXT 16:50:06,831 INFO [HbmBinder] Mapping joined-subclass: org.jboss.portal.core.impl.model.portal.PortalImpl -> JBP_PORTAL 16:50:06,831 INFO [HbmBinder] Mapping collection: org.jboss.portal.core.impl.model.portal.PortalImpl.modes -> JBP_PORTAL_MODE 16:50:06,831 INFO [HbmBinder] Mapping collection: org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates -> JBP_PORTAL_WINDOW_STATE 16:50:06,831 INFO [HbmBinder] Mapping joined-subclass: org.jboss.portal.core.impl.model.portal.PageImpl -> JBP_PAGE 16:50:06,832 INFO [HbmBinder] Mapping joined-subclass: org.jboss.portal.core.impl.model.portal.WindowImpl -> JBP_WINDOW 16:50:06,838 INFO [HbmBinder] Mapping class: org.jboss.portal.core.impl.model.portal.ObjectNodeSecurityConstraint -> JBP_OBJECT_NODE_SEC 16:50:06,840 INFO [HbmBinder] Mapping collection: org.jboss.portal.core.impl.model.portal.ObjectNodeSecurityConstraint.actions -> JBP_OBJECT_NODE_SEC_ACTIONS 16:50:06,840 INFO [Configuration] Configured SessionFactory: null 16:50:06,856 INFO [Configuration] configuring from url: file:/opt/jboss-portal-2.6.3.GA/server/default/deploy/jboss-portal.sar/conf/hibernate/portlet/hibernate.cfg.xml 16:50:06,860 INFO [Configuration] Reading mappings from resource : conf/hibernate/portlet/domain.hbm.xml 16:50:06,871 INFO [HbmBinder] Mapping class: org.jboss.portal.core.impl.portlet.state.PersistentPortletState -> JBP_PORTLET_STATE 16:50:06,876 INFO [HbmBinder] Mapping class: org.jboss.portal.core.impl.portlet.state.PersistentPortletStateEntry -> JBP_PORTLET_STATE_ENTRY 16:50:06,876 INFO [HbmBinder] Mapping collection: org.jboss.portal.core.impl.portlet.state.PersistentPortletStateEntry.strings -> JBP_PORTLET_STATE_ENTRY_VALUE 16:50:06,876 INFO [HbmBinder] Mapping class: org.jboss.portal.core.impl.portlet.state.PersistentConsumerGroup -> JBP_PORTLET_GROUP 16:50:06,877 INFO [HbmBinder] Mapping class: org.jboss.portal.core.impl.portlet.state.PersistentConsumer -> JBP_PORTLET_CONSUMER 16:50:06,878 INFO [HbmBinder] Mapping class: org.jboss.portal.core.impl.portlet.state.PersistentRegistration -> JBP_PORTLET_REG 16:50:06,878 INFO [HbmBinder] Mapping collection: org.jboss.portal.core.impl.portlet.state.PersistentRegistration.persistentProperties -> JBP_PORTLET_REG_PROPERTIES 16:50:06,878 INFO [Configuration] Configured SessionFactory: null 16:50:06,889 INFO [ConnectionFactoryBindingService] Bound ConnectionManager 'jboss.jca:service=DataSourceBinding,name=PortalDS' to JNDI name 'java:PortalDS' 16:50:07,248 INFO [HbmBinder] Mapping collection: org.jboss.portal.cms.security.Permission.criteria -> jbp_cms_perm_criteria 16:50:07,248 INFO [HbmBinder] Mapping collection: org.jboss.portal.cms.security.Permission.roleAssoc -> jbp_cms_perm_role 16:50:07,248 INFO [HbmBinder] Mapping collection: org.jboss.portal.cms.security.Permission.userAssoc -> jbp_cms_perm_user 16:50:07,261 INFO [NamingHelper] JNDI InitialContext properties:{} 16:50:07,262 INFO [DatasourceConnectionProvider] Using datasource: java:PortalDS 16:50:07,262 INFO [SettingsFactory] RDBMS: HSQL Database Engine, version: 1.8.0 16:50:07,262 INFO [SettingsFactory] JDBC driver: HSQL Database Engine Driver, version: 1.8.0 16:50:07,294 INFO [Dialect] Using dialect: org.hibernate.dialect.HSQLDialect 16:50:07,304 INFO [TransactionFactoryFactory] Transaction strategy: org.hibernate.transaction.JTATransactionFactory 16:50:07,308 INFO [NamingHelper] JNDI InitialContext properties:{} 16:50:07,309 INFO [TransactionManagerLookupFactory] instantiating TransactionManagerLookup: org.hibernate.transaction.JBossTransactionManagerLookup 16:50:07,313 INFO [TransactionManagerLookupFactory] instantiated TransactionManagerLookup 16:50:07,313 INFO [TransactionManagerLookupFactory] instantiating TransactionManagerLookup: org.hibernate.transaction.JBossTransactionManagerLookup 16:50:07,313 INFO [TransactionManagerLookupFactory] instantiated TransactionManagerLookup 16:50:07,313 INFO [SettingsFactory] Automatic flush during beforeCompletion(): enabled 16:50:07,313 INFO [SettingsFactory] Automatic session close at end of transaction: disabled 16:50:07,313 INFO [SettingsFactory] JDBC batch size: 15 16:50:07,313 INFO [SettingsFactory] JDBC batch updates for versioned data: disabled 16:50:07,315 INFO [SettingsFactory] Scrollable result sets: enabled 16:50:07,315 INFO [SettingsFactory] JDBC3 getGeneratedKeys(): disabled 16:50:07,315 INFO [SettingsFactory] Connection release mode: auto 16:50:07,316 INFO [SettingsFactory] Default batch fetch size: 1 16:50:07,316 INFO [SettingsFactory] Generate SQL with comments: disabled 16:50:07,316 INFO [SettingsFactory] Order SQL updates by primary key: disabled 16:50:07,316 INFO [SettingsFactory] Order SQL inserts for batching: disabled 16:50:07,316 INFO [SettingsFactory] Query translator: org.hibernate.hql.ast.ASTQueryTranslatorFactory 16:50:07,321 INFO [ASTQueryTranslatorFactory] Using ASTQueryTranslatorFactory 16:50:07,321 INFO [SettingsFactory] Query language substitutions: {} 16:50:07,321 INFO [SettingsFactory] JPA-QL strict compliance: disabled 16:50:07,321 INFO [SettingsFactory] Second-level cache: enabled 16:50:07,321 INFO [SettingsFactory] Query cache: enabled 16:50:07,321 INFO [SettingsFactory] Cache provider: org.hibernate.cache.EhCacheProvider 16:50:07,326 INFO [SettingsFactory] Optimize cache for minimal puts: disabled 16:50:07,326 INFO [SettingsFactory] Structured second-level cache entries: disabled 16:50:07,326 INFO [SettingsFactory] Query cache factory: org.hibernate.cache.StandardQueryCacheFactory 16:50:07,338 INFO [SettingsFactory] Statistics: disabled 16:50:07,338 INFO [SettingsFactory] Deleted entity synthetic identifier rollback: disabled 16:50:07,338 INFO [SettingsFactory] Default entity-mode: pojo 16:50:07,338 INFO [SettingsFactory] Named query checking : enabled 16:50:07,381 INFO [SessionFactoryImpl] building session factory 16:50:07,634 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.cms.security.Criteria]; using defaults. 16:50:07,650 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.cms.security.Permission]; using defaults. 16:50:07,680 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.cms.security.PermUserAssoc]; using defaults. 16:50:07,689 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.cms.security.PermRoleAssoc]; using defaults. 16:50:07,717 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.cms.security.Permission.criteria]; using defaults. 16:50:07,728 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.cms.security.Permission.roleAssoc]; using defaults. 16:50:07,728 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.cms.security.Permission.userAssoc]; using defaults. 16:50:07,812 INFO [SessionFactoryObjectFactory] Factory name: java:/portal/cms/CMSSessionFactory 16:50:07,812 INFO [NamingHelper] JNDI InitialContext properties:{} 16:50:07,813 INFO [NamingHelper] Creating subcontext: portal 16:50:07,813 INFO [NamingHelper] Creating subcontext: cms 16:50:07,814 INFO [SessionFactoryObjectFactory] Bound factory to JNDI name: java:/portal/cms/CMSSessionFactory 16:50:07,814 WARN [SessionFactoryObjectFactory] InitialContext did not implement EventContext 16:50:07,814 INFO [NamingHelper] JNDI InitialContext properties:{} 16:50:07,818 INFO [UpdateTimestampsCache] starting update timestamps cache at region: org.hibernate.cache.UpdateTimestampsCache 16:50:07,818 WARN [EhCacheProvider] Could not find configuration [org.hibernate.cache.UpdateTimestampsCache]; using defaults. 16:50:07,820 INFO [StandardQueryCache] starting query cache at region: org.hibernate.cache.StandardQueryCache 16:50:08,336 WARN [EhCacheProvider] Could not find configuration [org.hibernate.cache.StandardQueryCache]; using defaults. 16:50:08,752 INFO [HbmBinder] Mapping subclass: org.jbpm.context.def.ContextDefinition -> JBPM_MODULEDEFINITION 16:50:08,752 INFO [HbmBinder] Mapping subclass: org.jbpm.taskmgmt.def.TaskMgmtDefinition -> JBPM_MODULEDEFINITION 16:50:08,753 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.action.Script -> JBPM_ACTION 16:50:08,756 INFO [HbmBinder] Mapping collection: org.jbpm.identity.User.memberships -> JBPM_ID_MEMBERSHIP 16:50:08,756 INFO [HbmBinder] Mapping collection: org.jbpm.identity.Group.children -> JBPM_ID_GROUP 16:50:08,756 INFO [HbmBinder] Mapping collection: org.jbpm.identity.Group.memberships -> JBPM_ID_MEMBERSHIP 16:50:08,757 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.ProcessDefinition.events -> JBPM_EVENT 16:50:08,757 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.ProcessDefinition.exceptionHandlers -> JBPM_EXCEPTIONHANDLER 16:50:08,757 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.ProcessDefinition.nodes -> JBPM_NODE 16:50:08,757 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.ProcessDefinition.actions -> JBPM_ACTION 16:50:08,758 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.ProcessDefinition.definitions -> JBPM_MODULEDEFINITION 16:50:08,758 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.Node.events -> JBPM_EVENT 16:50:08,758 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.Node.exceptionHandlers -> JBPM_EXCEPTIONHANDLER 16:50:08,758 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.Node.leavingTransitions -> JBPM_TRANSITION 16:50:08,758 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.Node.arrivingTransitions -> JBPM_TRANSITION 16:50:08,758 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.Transition.events -> JBPM_EVENT 16:50:08,759 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.Transition.exceptionHandlers -> JBPM_EXCEPTIONHANDLER 16:50:08,759 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.Event.actions -> JBPM_ACTION 16:50:08,759 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.SuperState.nodes -> JBPM_NODE 16:50:08,759 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.ExceptionHandler.actions -> JBPM_ACTION 16:50:08,759 INFO [HbmBinder] Mapping collection: org.jbpm.graph.node.ProcessState.variableAccesses -> JBPM_VARIABLEACCESS 16:50:08,761 INFO [HbmBinder] Mapping collection: org.jbpm.graph.node.TaskNode.tasks -> JBPM_TASK 16:50:08,761 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.def.Swimlane.tasks -> JBPM_TASK 16:50:08,761 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.def.Task.events -> JBPM_EVENT 16:50:08,761 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.def.Task.exceptionHandlers -> JBPM_EXCEPTIONHANDLER 16:50:08,762 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.def.TaskController.variableAccesses -> JBPM_VARIABLEACCESS 16:50:08,762 INFO [HbmBinder] Mapping collection: org.jbpm.file.def.FileDefinition.processFiles -> JBPM_BYTEARRAY 16:50:08,762 INFO [HbmBinder] Mapping collection: org.jbpm.graph.exe.ProcessInstance.runtimeActions -> JBPM_RUNTIMEACTION 16:50:08,762 INFO [HbmBinder] Mapping collection: org.jbpm.graph.exe.ProcessInstance.instances -> JBPM_MODULEINSTANCE 16:50:08,763 INFO [HbmBinder] Mapping collection: org.jbpm.graph.exe.Token.children -> JBPM_TOKEN 16:50:08,763 INFO [HbmBinder] Mapping collection: org.jbpm.graph.exe.Token.comments -> JBPM_COMMENT 16:50:08,763 INFO [HbmBinder] Mapping collection: org.jbpm.context.exe.ContextInstance.tokenVariableMaps -> JBPM_TOKENVARIABLEMAP 16:50:08,763 INFO [HbmBinder] Mapping collection: org.jbpm.context.exe.TokenVariableMap.variableInstances -> JBPM_VARIABLEINSTANCE 16:50:08,763 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.exe.TaskMgmtInstance.swimlaneInstances -> JBPM_SWIMLANEINSTANCE 16:50:08,763 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.exe.TaskMgmtInstance.taskInstances -> JBPM_TASKINSTANCE 16:50:08,764 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.exe.TaskInstance.variableInstances -> JBPM_VARIABLEINSTANCE 16:50:08,764 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.exe.TaskInstance.comments -> JBPM_COMMENT 16:50:08,764 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.exe.SwimlaneInstance.pooledActors -> JBPM_POOLEDACTOR 16:50:08,764 INFO [HbmBinder] Mapping collection: org.jbpm.logging.log.CompositeLog.children -> JBPM_LOG 16:50:08,765 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.def.TaskMgmtDefinition.swimlanes -> JBPM_SWIMLANE 16:50:08,765 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.def.TaskMgmtDefinition.tasks -> JBPM_TASK 16:50:08,765 INFO [HbmBinder] Mapping collection: org.jbpm.graph.action.Script.variableAccesses -> JBPM_VARIABLEACCESS 16:50:08,804 INFO [NamingHelper] JNDI InitialContext properties:{} 16:50:08,805 INFO [DatasourceConnectionProvider] Using datasource: java:PortalDS 16:50:08,805 INFO [SettingsFactory] RDBMS: HSQL Database Engine, version: 1.8.0 16:50:08,805 INFO [SettingsFactory] JDBC driver: HSQL Database Engine Driver, version: 1.8.0 16:50:08,805 INFO [Dialect] Using dialect: org.hibernate.dialect.HSQLDialect 16:50:08,806 INFO [TransactionFactoryFactory] Transaction strategy: org.hibernate.transaction.JTATransactionFactory 16:50:08,806 INFO [NamingHelper] JNDI InitialContext properties:{} 16:50:08,806 INFO [TransactionManagerLookupFactory] instantiating TransactionManagerLookup: org.hibernate.transaction.JBossTransactionManagerLookup 16:50:08,806 INFO [TransactionManagerLookupFactory] instantiated TransactionManagerLookup 16:50:08,806 INFO [TransactionManagerLookupFactory] instantiating TransactionManagerLookup: org.hibernate.transaction.JBossTransactionManagerLookup 16:50:08,806 INFO [TransactionManagerLookupFactory] instantiated TransactionManagerLookup 16:50:08,806 INFO [SettingsFactory] Automatic flush during beforeCompletion(): enabled 16:50:08,806 INFO [SettingsFactory] Automatic session close at end of transaction: disabled 16:50:08,806 INFO [SettingsFactory] JDBC batch size: 15 16:50:08,806 INFO [SettingsFactory] JDBC batch updates for versioned data: disabled 16:50:08,806 INFO [SettingsFactory] Scrollable result sets: enabled 16:50:08,807 INFO [SettingsFactory] JDBC3 getGeneratedKeys(): disabled 16:50:08,807 INFO [SettingsFactory] Connection release mode: auto 16:50:08,807 INFO [SettingsFactory] Default batch fetch size: 1 16:50:08,807 INFO [SettingsFactory] Generate SQL with comments: enabled 16:50:08,807 INFO [SettingsFactory] Order SQL updates by primary key: disabled 16:50:08,807 INFO [SettingsFactory] Order SQL inserts for batching: disabled 16:50:08,807 INFO [SettingsFactory] Query translator: org.hibernate.hql.ast.ASTQueryTranslatorFactory 16:50:08,807 INFO [ASTQueryTranslatorFactory] Using ASTQueryTranslatorFactory 16:50:08,807 INFO [SettingsFactory] Query language substitutions: {} 16:50:08,807 INFO [SettingsFactory] JPA-QL strict compliance: disabled 16:50:08,807 INFO [SettingsFactory] Second-level cache: enabled 16:50:08,807 INFO [SettingsFactory] Query cache: enabled 16:50:08,807 INFO [SettingsFactory] Cache provider: org.hibernate.cache.EhCacheProvider 16:50:08,807 INFO [SettingsFactory] Optimize cache for minimal puts: disabled 16:50:08,807 INFO [SettingsFactory] Structured second-level cache entries: disabled 16:50:08,807 INFO [SettingsFactory] Query cache factory: org.hibernate.cache.StandardQueryCacheFactory 16:50:08,807 INFO [SettingsFactory] Statistics: disabled 16:50:08,807 INFO [SettingsFactory] Deleted entity synthetic identifier rollback: disabled 16:50:08,807 INFO [SettingsFactory] Default entity-mode: pojo 16:50:08,807 INFO [SettingsFactory] Named query checking : enabled 16:50:08,810 INFO [SessionFactoryImpl] building session factory 16:50:08,827 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.Node]; using defaults. 16:50:08,854 WARN [EhCacheProvider] Could not find configuration [org.jbpm.instantiation.Delegation]; using defaults. 16:50:08,930 WARN [EhCacheProvider] Could not find configuration [org.jbpm.taskmgmt.def.Task]; using defaults. 16:50:08,997 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.ProcessDefinition]; using defaults. 16:50:09,038 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.ExceptionHandler]; using defaults. 16:50:09,042 WARN [EhCacheProvider] Could not find configuration [org.jbpm.module.def.ModuleDefinition]; using defaults. 16:50:09,168 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.Action]; using defaults. 16:50:09,215 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.Event]; using defaults. 16:50:09,258 WARN [EhCacheProvider] Could not find configuration [org.jbpm.context.def.VariableAccess]; using defaults. 16:50:09,313 INFO [JbpmConfiguration] using jbpm configuration resource 'jbpm.cfg.xml' 16:50:09,379 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.Transition]; using defaults. 16:50:09,466 WARN [EhCacheProvider] Could not find configuration [org.jbpm.taskmgmt.def.TaskController]; using defaults. 16:50:09,480 WARN [EhCacheProvider] Could not find configuration [org.jbpm.taskmgmt.def.TaskMgmtDefinition.tasks]; using defaults. 16:50:09,481 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.node.ProcessState.variableAccesses]; using defaults. 16:50:09,481 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.ProcessDefinition.events]; using defaults. 16:50:09,482 WARN [EhCacheProvider] Could not find configuration [org.jbpm.taskmgmt.def.Swimlane.tasks]; using defaults. 16:50:09,483 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.Node.leavingTransitions]; using defaults. 16:50:09,483 WARN [EhCacheProvider] Could not find configuration [org.jbpm.taskmgmt.def.TaskController.variableAccesses]; using defaults. 16:50:09,484 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.ProcessDefinition.exceptionHandlers]; using defaults. 16:50:09,484 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.node.Decision.decisionConditions]; using defaults. 16:50:09,485 WARN [EhCacheProvider] Could not find configuration [org.jbpm.file.def.FileDefinition.processFiles]; using defaults. 16:50:09,488 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.ProcessDefinition.actions]; using defaults. 16:50:09,488 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.Transition.exceptionHandlers]; using defaults. 16:50:09,489 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.ProcessDefinition.nodes]; using defaults. 16:50:09,489 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.Node.arrivingTransitions]; using defaults. 16:50:09,490 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.node.TaskNode.tasks]; using defaults. 16:50:09,490 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.ProcessDefinition.definitions]; using defaults. 16:50:09,493 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.Event.actions]; using defaults. 16:50:09,494 WARN [EhCacheProvider] Could not find configuration [org.jbpm.taskmgmt.def.Task.events]; using defaults. 16:50:09,494 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.Node.events]; using defaults. 16:50:09,495 WARN [EhCacheProvider] Could not find configuration [org.jbpm.taskmgmt.def.TaskMgmtDefinition.swimlanes]; using defaults. 16:50:09,495 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.SuperState.nodes]; using defaults. 16:50:09,496 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.action.Script.variableAccesses]; using defaults. 16:50:09,496 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.ExceptionHandler.actions]; using defaults. 16:50:09,496 WARN [EhCacheProvider] Could not find configuration [org.jbpm.taskmgmt.def.Task.exceptionHandlers]; using defaults. 16:50:09,497 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.Node.exceptionHandlers]; using defaults. 16:50:09,498 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.Transition.events]; using defaults. 16:50:09,710 INFO [SessionFactoryObjectFactory] Factory name: java:/portal/workflow/WorkFlowSessionFactory 16:50:09,711 INFO [NamingHelper] JNDI InitialContext properties:{} 16:50:09,711 INFO [NamingHelper] Creating subcontext: workflow 16:50:09,711 INFO [SessionFactoryObjectFactory] Bound factory to JNDI name: java:/portal/workflow/WorkFlowSessionFactory 16:50:09,711 WARN [SessionFactoryObjectFactory] InitialContext did not implement EventContext 16:50:09,712 INFO [NamingHelper] JNDI InitialContext properties:{} 16:50:09,712 INFO [UpdateTimestampsCache] starting update timestamps cache at region: org.hibernate.cache.UpdateTimestampsCache 16:50:09,712 WARN [EhCacheProvider] Could not find configuration [org.hibernate.cache.UpdateTimestampsCache]; using defaults. 16:50:09,712 INFO [StandardQueryCache] starting query cache at region: org.hibernate.cache.StandardQueryCache 16:50:09,712 WARN [EhCacheProvider] Could not find configuration [org.hibernate.cache.StandardQueryCache]; using defaults. 16:50:10,232 WARN [HQLQueryPlan] firstResult/maxResults specified on polymorphic query; applying in memory! 16:50:10,383 INFO [HbmBinder] Mapping collection: org.jboss.portal.wsrp.consumer.RegistrationInfo.persistentRegistrationProperties -> JBP_REG_PROPERTY 16:50:10,389 INFO [NamingHelper] JNDI InitialContext properties:{} 16:50:10,389 INFO [DatasourceConnectionProvider] Using datasource: java:PortalDS 16:50:10,389 INFO [SettingsFactory] RDBMS: HSQL Database Engine, version: 1.8.0 16:50:10,389 INFO [SettingsFactory] JDBC driver: HSQL Database Engine Driver, version: 1.8.0 16:50:10,390 INFO [Dialect] Using dialect: org.hibernate.dialect.HSQLDialect 16:50:10,390 INFO [TransactionFactoryFactory] Transaction strategy: org.hibernate.transaction.JTATransactionFactory 16:50:10,390 INFO [NamingHelper] JNDI InitialContext properties:{} 16:50:10,390 INFO [TransactionManagerLookupFactory] instantiating TransactionManagerLookup: org.hibernate.transaction.JBossTransactionManagerLookup 16:50:10,390 INFO [TransactionManagerLookupFactory] instantiated TransactionManagerLookup 16:50:10,390 INFO [TransactionManagerLookupFactory] instantiating TransactionManagerLookup: org.hibernate.transaction.JBossTransactionManagerLookup 16:50:10,390 INFO [TransactionManagerLookupFactory] instantiated TransactionManagerLookup 16:50:10,390 INFO [SettingsFactory] Automatic flush during beforeCompletion(): enabled 16:50:10,391 INFO [SettingsFactory] Automatic session close at end of transaction: disabled 16:50:10,391 INFO [SettingsFactory] JDBC batch size: 15 16:50:10,391 INFO [SettingsFactory] JDBC batch updates for versioned data: disabled 16:50:10,391 INFO [SettingsFactory] Scrollable result sets: enabled 16:50:10,391 INFO [SettingsFactory] JDBC3 getGeneratedKeys(): disabled 16:50:10,391 INFO [SettingsFactory] Connection release mode: auto 16:50:10,391 INFO [SettingsFactory] Default batch fetch size: 1 16:50:10,391 INFO [SettingsFactory] Generate SQL with comments: disabled 16:50:10,391 INFO [SettingsFactory] Order SQL updates by primary key: disabled 16:50:10,391 INFO [SettingsFactory] Order SQL inserts for batching: disabled 16:50:10,391 INFO [SettingsFactory] Query translator: org.hibernate.hql.ast.ASTQueryTranslatorFactory 16:50:10,391 INFO [ASTQueryTranslatorFactory] Using ASTQueryTranslatorFactory 16:50:10,391 INFO [SettingsFactory] Query language substitutions: {} 16:50:10,391 INFO [SettingsFactory] JPA-QL strict compliance: disabled 16:50:10,391 INFO [SettingsFactory] Second-level cache: enabled 16:50:10,391 INFO [SettingsFactory] Query cache: enabled 16:50:10,391 INFO [SettingsFactory] Cache provider: org.hibernate.cache.EhCacheProvider 16:50:10,391 INFO [SettingsFactory] Optimize cache for minimal puts: disabled 16:50:10,391 INFO [SettingsFactory] Structured second-level cache entries: disabled 16:50:10,391 INFO [SettingsFactory] Query cache factory: org.hibernate.cache.StandardQueryCacheFactory 16:50:10,391 INFO [SettingsFactory] Statistics: disabled 16:50:10,391 INFO [SettingsFactory] Deleted entity synthetic identifier rollback: disabled 16:50:10,391 INFO [SettingsFactory] Default entity-mode: pojo 16:50:10,392 INFO [SettingsFactory] Named query checking : enabled 16:50:10,396 INFO [SessionFactoryImpl] building session factory 16:50:10,407 INFO [Configuration] configuring from resource: conf/hibernate/workflow/hibernate.cfg.xml 16:50:10,407 INFO [Configuration] Configuration resource: conf/hibernate/workflow/hibernate.cfg.xml 16:50:10,407 WARN [ConfigurationFactory] No configuration found. Configuring ehcache from ehcache-failsafe.xml found in the classpath: jar:file:/opt/jboss-portal-2.6.3.GA/server/default/tmp/deploy/tmp62827ehcache.jar!/ehcache-failsafe.xml 16:50:10,410 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.wsrp.registration.RegistrationPropertyDescription]; using defaults. 16:50:10,413 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/action/Script.hbm.xml 16:50:10,419 INFO [Configuration] Reading mappings from resource : org/jbpm/identity/User.hbm.xml 16:50:10,426 INFO [HbmBinder] Mapping class: org.jbpm.identity.User -> JBPM_ID_USER 16:50:10,427 INFO [HbmBinder] Mapping collection: org.jbpm.identity.User.permissions -> JBPM_ID_PERMISSIONS 16:50:10,427 INFO [Configuration] Reading mappings from resource : org/jbpm/identity/Group.hbm.xml 16:50:10,434 INFO [HbmBinder] Mapping class: org.jbpm.identity.Group -> JBPM_ID_GROUP 16:50:10,435 INFO [HbmBinder] Mapping collection: org.jbpm.identity.Group.permissions -> JBPM_ID_PERMISSIONS 16:50:10,435 INFO [Configuration] Reading mappings from resource : org/jbpm/identity/Membership.hbm.xml 16:50:10,435 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.wsrp.consumer.RegistrationInfo]; using defaults. 16:50:10,441 INFO [HbmBinder] Mapping class: org.jbpm.identity.Membership -> JBPM_ID_MEMBERSHIP 16:50:10,442 INFO [HbmBinder] Mapping collection: org.jbpm.identity.Membership.permissions -> JBPM_ID_PERMISSIONS 16:50:10,442 INFO [Configuration] Reading mappings from resource : org/jbpm/db/hibernate.queries.hbm.xml 16:50:10,449 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/def/ProcessDefinition.hbm.xml 16:50:10,457 INFO [HbmBinder] Mapping class: org.jbpm.graph.def.ProcessDefinition -> JBPM_PROCESSDEFINITION 16:50:10,458 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.wsrp.consumer.EndpointConfigurationInfo]; using defaults. 16:50:10,458 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/def/Node.hbm.xml 16:50:10,466 INFO [HbmBinder] Mapping class: org.jbpm.graph.def.Node -> JBPM_NODE 16:50:10,467 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/def/Transition.hbm.xml 16:50:10,469 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.wsrp.consumer.RegistrationProperty]; using defaults. 16:50:10,474 INFO [HbmBinder] Mapping class: org.jbpm.graph.def.Transition -> JBPM_TRANSITION 16:50:10,475 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/def/Event.hbm.xml 16:50:10,481 INFO [HbmBinder] Mapping class: org.jbpm.graph.def.Event -> JBPM_EVENT 16:50:10,481 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.wsrp.consumer.ProducerInfo]; using defaults. 16:50:10,482 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/def/Action.hbm.xml 16:50:10,488 INFO [HbmBinder] Mapping class: org.jbpm.graph.def.Action -> JBPM_ACTION 16:50:10,489 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/def/SuperState.hbm.xml 16:50:10,491 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.wsrp.registration.RegistrationPropertyDescription.aliases]; using defaults. 16:50:10,493 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.wsrp.consumer.RegistrationInfo.persistentRegistrationProperties]; using defaults. 16:50:10,494 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.def.SuperState -> JBPM_NODE 16:50:10,494 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/def/ExceptionHandler.hbm.xml 16:50:10,496 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.wsrp.registration.RegistrationPropertyDescription.usages]; using defaults. 16:50:10,501 INFO [HbmBinder] Mapping class: org.jbpm.graph.def.ExceptionHandler -> JBPM_EXCEPTIONHANDLER 16:50:10,501 INFO [Configuration] Reading mappings from resource : org/jbpm/instantiation/Delegation.hbm.xml 16:50:10,507 INFO [SessionFactoryObjectFactory] Factory name: java:/portal/WSRPConsumerSessionFactory 16:50:10,507 INFO [HbmBinder] Mapping class: org.jbpm.instantiation.Delegation -> JBPM_DELEGATION 16:50:10,507 INFO [NamingHelper] JNDI InitialContext properties:{} 16:50:10,508 INFO [SessionFactoryObjectFactory] Bound factory to JNDI name: java:/portal/WSRPConsumerSessionFactory 16:50:10,508 WARN [SessionFactoryObjectFactory] InitialContext did not implement EventContext 16:50:10,508 INFO [NamingHelper] JNDI InitialContext properties:{} 16:50:10,508 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/node/StartState.hbm.xml 16:50:10,508 INFO [UpdateTimestampsCache] starting update timestamps cache at region: org.hibernate.cache.UpdateTimestampsCache 16:50:10,508 WARN [EhCacheProvider] Could not find configuration [org.hibernate.cache.UpdateTimestampsCache]; using defaults. 16:50:10,509 INFO [StandardQueryCache] starting query cache at region: org.hibernate.cache.StandardQueryCache 16:50:10,509 WARN [EhCacheProvider] Could not find configuration [org.hibernate.cache.StandardQueryCache]; using defaults. 16:50:10,512 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.node.StartState -> JBPM_NODE 16:50:10,512 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/node/EndState.hbm.xml 16:50:10,517 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.node.EndState -> JBPM_NODE 16:50:10,517 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/node/ProcessState.hbm.xml 16:50:10,522 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.node.ProcessState -> JBPM_NODE 16:50:10,522 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/node/Decision.hbm.xml 16:50:10,528 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.node.Decision -> JBPM_NODE 16:50:10,528 INFO [HbmBinder] Mapping collection: org.jbpm.graph.node.Decision.decisionConditions -> JBPM_DECISIONCONDITIONS 16:50:10,528 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/node/Fork.hbm.xml 16:50:10,533 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.node.Fork -> JBPM_NODE 16:50:10,533 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/node/Join.hbm.xml 16:50:10,537 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.node.Join -> JBPM_NODE 16:50:10,537 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/node/State.hbm.xml 16:50:10,542 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.node.State -> JBPM_NODE 16:50:10,542 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/node/TaskNode.hbm.xml 16:50:10,547 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.node.TaskNode -> JBPM_NODE 16:50:10,547 INFO [Configuration] Reading mappings from resource : org/jbpm/context/def/ContextDefinition.hbm.xml 16:50:10,552 INFO [Configuration] Reading mappings from resource : org/jbpm/context/def/VariableAccess.hbm.xml 16:50:10,557 INFO [HbmBinder] Mapping class: org.jbpm.context.def.VariableAccess -> JBPM_VARIABLEACCESS 16:50:10,557 INFO [Configuration] Reading mappings from resource : org/jbpm/taskmgmt/def/TaskMgmtDefinition.hbm.xml 16:50:10,562 INFO [Configuration] Reading mappings from resource : org/jbpm/taskmgmt/def/Swimlane.hbm.xml 16:50:10,568 INFO [HbmBinder] Mapping class: org.jbpm.taskmgmt.def.Swimlane -> JBPM_SWIMLANE 16:50:10,569 INFO [Configuration] Reading mappings from resource : org/jbpm/taskmgmt/def/Task.hbm.xml 16:50:10,575 INFO [HbmBinder] Mapping class: org.jbpm.taskmgmt.def.Task -> JBPM_TASK 16:50:10,578 INFO [Configuration] Reading mappings from resource : org/jbpm/taskmgmt/def/TaskController.hbm.xml 16:50:10,583 INFO [HbmBinder] Mapping class: org.jbpm.taskmgmt.def.TaskController -> JBPM_TASKCONTROLLER 16:50:10,584 INFO [Configuration] Reading mappings from resource : org/jbpm/module/def/ModuleDefinition.hbm.xml 16:50:10,589 INFO [HbmBinder] Mapping class: org.jbpm.module.def.ModuleDefinition -> JBPM_MODULEDEFINITION 16:50:10,590 INFO [Configuration] Reading mappings from resource : org/jbpm/bytes/ByteArray.hbm.xml 16:50:10,595 INFO [HbmBinder] Mapping class: org.jbpm.bytes.ByteArray -> JBPM_BYTEARRAY 16:50:10,595 INFO [HbmBinder] Mapping collection: org.jbpm.bytes.ByteArray.byteBlocks -> JBPM_BYTEBLOCK 16:50:10,596 INFO [Configuration] Reading mappings from resource : org/jbpm/file/def/FileDefinition.hbm.xml 16:50:10,600 INFO [HbmBinder] Mapping subclass: org.jbpm.file.def.FileDefinition -> JBPM_MODULEDEFINITION 16:50:10,600 INFO [Configuration] Reading mappings from resource : org/jbpm/scheduler/def/CreateTimerAction.hbm.xml 16:50:10,605 INFO [HbmBinder] Mapping subclass: org.jbpm.scheduler.def.CreateTimerAction -> JBPM_ACTION 16:50:10,606 INFO [Configuration] Reading mappings from resource : org/jbpm/scheduler/def/CancelTimerAction.hbm.xml 16:50:10,611 INFO [HbmBinder] Mapping subclass: org.jbpm.scheduler.def.CancelTimerAction -> JBPM_ACTION 16:50:10,611 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/exe/Comment.hbm.xml 16:50:10,616 INFO [HbmBinder] Mapping class: org.jbpm.graph.exe.Comment -> JBPM_COMMENT 16:50:10,617 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/exe/ProcessInstance.hbm.xml 16:50:10,624 INFO [HbmBinder] Mapping class: org.jbpm.graph.exe.ProcessInstance -> JBPM_PROCESSINSTANCE 16:50:10,625 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/exe/Token.hbm.xml 16:50:10,631 INFO [HbmBinder] Mapping class: org.jbpm.graph.exe.Token -> JBPM_TOKEN 16:50:10,633 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/exe/RuntimeAction.hbm.xml 16:50:10,639 INFO [HbmBinder] Mapping class: org.jbpm.graph.exe.RuntimeAction -> JBPM_RUNTIMEACTION 16:50:10,640 INFO [Configuration] Reading mappings from resource : org/jbpm/module/exe/ModuleInstance.hbm.xml 16:50:10,645 INFO [HbmBinder] Mapping class: org.jbpm.module.exe.ModuleInstance -> JBPM_MODULEINSTANCE 16:50:10,645 INFO [Configuration] Reading mappings from resource : org/jbpm/context/exe/ContextInstance.hbm.xml 16:50:10,650 INFO [HbmBinder] Mapping subclass: org.jbpm.context.exe.ContextInstance -> JBPM_MODULEINSTANCE 16:50:10,650 INFO [Configuration] Reading mappings from resource : org/jbpm/context/exe/TokenVariableMap.hbm.xml 16:50:10,651 INFO [WSRPConsumerImpl] Consumer with id 'self' started 16:50:10,651 INFO [WSRPConsumerImpl] Consumer with id 'self' activated 16:50:10,656 INFO [HbmBinder] Mapping class: org.jbpm.context.exe.TokenVariableMap -> JBPM_TOKENVARIABLEMAP 16:50:10,656 INFO [Configuration] Reading mappings from resource : org/jbpm/context/exe/VariableInstance.hbm.xml 16:50:10,662 INFO [HbmBinder] Mapping class: org.jbpm.context.exe.VariableInstance -> JBPM_VARIABLEINSTANCE 16:50:10,663 INFO [Configuration] Reading mappings from resource : org/jbpm/context/exe/variableinstance/ByteArrayInstance.hbm.xml 16:50:10,668 INFO [HbmBinder] Mapping subclass: org.jbpm.context.exe.variableinstance.ByteArrayInstance -> JBPM_VARIABLEINSTANCE 16:50:10,668 INFO [Configuration] Reading mappings from resource : org/jbpm/context/exe/variableinstance/DateInstance.hbm.xml 16:50:10,672 INFO [HbmBinder] Mapping subclass: org.jbpm.context.exe.variableinstance.DateInstance -> JBPM_VARIABLEINSTANCE 16:50:10,672 INFO [Configuration] Reading mappings from resource : org/jbpm/context/exe/variableinstance/DoubleInstance.hbm.xml 16:50:10,677 INFO [HbmBinder] Mapping subclass: org.jbpm.context.exe.variableinstance.DoubleInstance -> JBPM_VARIABLEINSTANCE 16:50:10,677 INFO [Configuration] Reading mappings from resource : org/jbpm/context/exe/variableinstance/HibernateLongInstance.hbm.xml 16:50:10,681 INFO [HbmBinder] Mapping subclass: org.jbpm.context.exe.variableinstance.HibernateLongInstance -> JBPM_VARIABLEINSTANCE 16:50:10,681 INFO [Configuration] Reading mappings from resource : org/jbpm/context/exe/variableinstance/HibernateStringInstance.hbm.xml 16:50:10,686 INFO [HbmBinder] Mapping subclass: org.jbpm.context.exe.variableinstance.HibernateStringInstance -> JBPM_VARIABLEINSTANCE 16:50:10,686 INFO [Configuration] Reading mappings from resource : org/jbpm/context/exe/variableinstance/LongInstance.hbm.xml 16:50:10,691 INFO [HbmBinder] Mapping subclass: org.jbpm.context.exe.variableinstance.LongInstance -> JBPM_VARIABLEINSTANCE 16:50:10,691 INFO [Configuration] Reading mappings from resource : org/jbpm/context/exe/variableinstance/NullInstance.hbm.xml 16:50:10,691 INFO [WSRPDeploymentFactory] Added consumer for producer 'self' with status: active (loaded from database). 16:50:10,696 INFO [HbmBinder] Mapping subclass: org.jbpm.context.exe.variableinstance.NullInstance -> JBPM_VARIABLEINSTANCE 16:50:10,696 INFO [Configuration] Reading mappings from resource : org/jbpm/context/exe/variableinstance/StringInstance.hbm.xml 16:50:10,697 INFO [NamingHelper] JNDI InitialContext properties:{} 16:50:10,697 INFO [DatasourceConnectionProvider] Using datasource: java:PortalDS 16:50:10,698 INFO [SettingsFactory] RDBMS: HSQL Database Engine, version: 1.8.0 16:50:10,698 INFO [SettingsFactory] JDBC driver: HSQL Database Engine Driver, version: 1.8.0 16:50:10,698 INFO [Dialect] Using dialect: org.hibernate.dialect.HSQLDialect 16:50:10,698 INFO [TransactionFactoryFactory] Transaction strategy: org.hibernate.transaction.JTATransactionFactory 16:50:10,699 INFO [NamingHelper] JNDI InitialContext properties:{} 16:50:10,699 INFO [TransactionManagerLookupFactory] instantiating TransactionManagerLookup: org.hibernate.transaction.JBossTransactionManagerLookup 16:50:10,699 INFO [TransactionManagerLookupFactory] instantiated TransactionManagerLookup 16:50:10,699 INFO [TransactionManagerLookupFactory] instantiating TransactionManagerLookup: org.hibernate.transaction.JBossTransactionManagerLookup 16:50:10,699 INFO [TransactionManagerLookupFactory] instantiated TransactionManagerLookup 16:50:10,699 INFO [SettingsFactory] Automatic flush during beforeCompletion(): enabled 16:50:10,700 INFO [SettingsFactory] Automatic session close at end of transaction: disabled 16:50:10,700 INFO [SettingsFactory] JDBC batch size: 15 16:50:10,700 INFO [SettingsFactory] JDBC batch updates for versioned data: disabled 16:50:10,700 INFO [SettingsFactory] Scrollable result sets: enabled 16:50:10,700 INFO [SettingsFactory] JDBC3 getGeneratedKeys(): disabled 16:50:10,700 INFO [SettingsFactory] Connection release mode: auto 16:50:10,700 INFO [SettingsFactory] Default batch fetch size: 1 16:50:10,700 INFO [SettingsFactory] Generate SQL with comments: disabled 16:50:10,700 INFO [SettingsFactory] Order SQL updates by primary key: disabled 16:50:10,700 INFO [SettingsFactory] Order SQL inserts for batching: disabled 16:50:10,700 INFO [SettingsFactory] Query translator: org.hibernate.hql.ast.ASTQueryTranslatorFactory 16:50:10,700 INFO [ASTQueryTranslatorFactory] Using ASTQueryTranslatorFactory 16:50:10,700 INFO [SettingsFactory] Query language substitutions: {} 16:50:10,701 INFO [SettingsFactory] JPA-QL strict compliance: disabled 16:50:10,701 INFO [SettingsFactory] Second-level cache: enabled 16:50:10,701 INFO [SettingsFactory] Query cache: enabled 16:50:10,701 INFO [SettingsFactory] Cache provider: org.hibernate.cache.EhCacheProvider 16:50:10,701 INFO [SettingsFactory] Optimize cache for minimal puts: disabled 16:50:10,701 INFO [HbmBinder] Mapping subclass: org.jbpm.context.exe.variableinstance.StringInstance -> JBPM_VARIABLEINSTANCE 16:50:10,701 INFO [SettingsFactory] Structured second-level cache entries: disabled 16:50:10,701 INFO [SettingsFactory] Query cache factory: org.hibernate.cache.StandardQueryCacheFactory 16:50:10,701 INFO [SettingsFactory] Statistics: disabled 16:50:10,701 INFO [SettingsFactory] Deleted entity synthetic identifier rollback: disabled 16:50:10,701 INFO [Configuration] Reading mappings from resource : org/jbpm/msg/Message.hbm.xml 16:50:10,701 INFO [SettingsFactory] Default entity-mode: pojo 16:50:10,701 INFO [SettingsFactory] Named query checking : enabled 16:50:10,704 INFO [SessionFactoryImpl] building session factory 16:50:10,706 INFO [HbmBinder] Mapping class: org.jbpm.msg.Message -> JBPM_MESSAGE 16:50:10,707 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.identity.db.HibernateUserImpl]; using defaults. 16:50:10,707 INFO [Configuration] Reading mappings from resource : org/jbpm/msg/db/TextMessage.hbm.xml 16:50:10,712 INFO [HbmBinder] Mapping subclass: org.jbpm.msg.db.TextMessage -> JBPM_MESSAGE 16:50:10,713 INFO [Configuration] Reading mappings from resource : org/jbpm/command/ExecuteActionCommand.hbm.xml 16:50:10,717 INFO [HbmBinder] Mapping subclass: org.jbpm.command.ExecuteActionCommand -> JBPM_MESSAGE 16:50:10,718 INFO [Configuration] Reading mappings from resource : org/jbpm/command/ExecuteNodeCommand.hbm.xml 16:50:10,722 INFO [HbmBinder] Mapping subclass: org.jbpm.command.ExecuteNodeCommand -> JBPM_MESSAGE 16:50:10,723 INFO [Configuration] Reading mappings from resource : org/jbpm/command/SignalCommand.hbm.xml 16:50:10,727 INFO [HbmBinder] Mapping subclass: org.jbpm.command.SignalCommand -> JBPM_MESSAGE 16:50:10,727 INFO [Configuration] Reading mappings from resource : org/jbpm/command/TaskInstanceEndCommand.hbm.xml 16:50:10,729 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.identity.db.HibernateRoleImpl]; using defaults. 16:50:10,732 INFO [HbmBinder] Mapping subclass: org.jbpm.command.TaskInstanceEndCommand -> JBPM_MESSAGE 16:50:10,733 INFO [Configuration] Reading mappings from resource : org/jbpm/taskmgmt/exe/TaskMgmtInstance.hbm.xml 16:50:10,734 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.identity.db.HibernateUserImpl.roles]; using defaults. 16:50:10,735 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.identity.db.HibernateUserImpl.dynamic]; using defaults. 16:50:10,735 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.identity.db.HibernateRoleImpl.users]; using defaults. 16:50:10,738 INFO [SessionFactoryObjectFactory] Factory name: java:/portal/IdentitySessionFactory 16:50:10,738 INFO [NamingHelper] JNDI InitialContext properties:{} 16:50:10,738 INFO [HbmBinder] Mapping subclass: org.jbpm.taskmgmt.exe.TaskMgmtInstance -> JBPM_MODULEINSTANCE 16:50:10,738 INFO [SessionFactoryObjectFactory] Bound factory to JNDI name: java:/portal/IdentitySessionFactory 16:50:10,739 WARN [SessionFactoryObjectFactory] InitialContext did not implement EventContext 16:50:10,739 INFO [Configuration] Reading mappings from resource : org/jbpm/taskmgmt/exe/TaskInstance.hbm.xml 16:50:10,739 INFO [NamingHelper] JNDI InitialContext properties:{} 16:50:10,739 INFO [UpdateTimestampsCache] starting update timestamps cache at region: org.hibernate.cache.UpdateTimestampsCache 16:50:10,739 WARN [EhCacheProvider] Could not find configuration [org.hibernate.cache.UpdateTimestampsCache]; using defaults. 16:50:10,739 INFO [StandardQueryCache] starting query cache at region: org.hibernate.cache.StandardQueryCache 16:50:10,739 WARN [EhCacheProvider] Could not find configuration [org.hibernate.cache.StandardQueryCache]; using defaults. 16:50:10,747 INFO [HbmBinder] Mapping class: org.jbpm.taskmgmt.exe.TaskInstance -> JBPM_TASKINSTANCE 16:50:10,750 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.exe.TaskInstance.pooledActors -> JBPM_TASKACTORPOOL 16:50:10,750 INFO [Configuration] Reading mappings from resource : org/jbpm/taskmgmt/exe/PooledActor.hbm.xml 16:50:10,756 INFO [HbmBinder] Mapping class: org.jbpm.taskmgmt.exe.PooledActor -> JBPM_POOLEDACTOR 16:50:10,756 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.exe.PooledActor.taskInstances -> JBPM_TASKACTORPOOL 16:50:10,756 INFO [Configuration] Reading mappings from resource : org/jbpm/taskmgmt/exe/SwimlaneInstance.hbm.xml 16:50:10,757 INFO [ConfigurationParser] Processing portal identity configuration 16:50:10,762 INFO [HbmBinder] Mapping class: org.jbpm.taskmgmt.exe.SwimlaneInstance -> JBPM_SWIMLANEINSTANCE 16:50:10,763 INFO [Configuration] Reading mappings from resource : org/jbpm/scheduler/exe/Timer.hbm.xml 16:50:10,768 INFO [HbmBinder] Mapping class: org.jbpm.scheduler.exe.Timer -> JBPM_TIMER 16:50:10,770 INFO [Configuration] Reading mappings from resource : org/jbpm/logging/log/ProcessLog.hbm.xml 16:50:10,775 INFO [ConfigurationParser] Processing portal identity configuration 16:50:10,776 INFO [HbmBinder] Mapping class: org.jbpm.logging.log.ProcessLog -> JBPM_LOG 16:50:10,777 INFO [Configuration] Reading mappings from resource : org/jbpm/logging/log/MessageLog.hbm.xml 16:50:10,781 INFO [HbmBinder] Mapping subclass: org.jbpm.logging.log.MessageLog -> JBPM_LOG 16:50:10,782 INFO [Configuration] Reading mappings from resource : org/jbpm/logging/log/CompositeLog.hbm.xml 16:50:10,786 INFO [HbmBinder] Mapping subclass: org.jbpm.logging.log.CompositeLog -> JBPM_LOG 16:50:10,787 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/log/ActionLog.hbm.xml 16:50:10,792 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.log.ActionLog -> JBPM_LOG 16:50:10,792 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/log/NodeLog.hbm.xml 16:50:10,797 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.log.NodeLog -> JBPM_LOG 16:50:10,797 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/log/ProcessInstanceCreateLog.hbm.xml 16:50:10,802 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.log.ProcessInstanceCreateLog -> JBPM_LOG 16:50:10,802 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/log/ProcessInstanceEndLog.hbm.xml 16:50:10,807 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.log.ProcessInstanceEndLog -> JBPM_LOG 16:50:10,807 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/log/ProcessStateLog.hbm.xml 16:50:10,811 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.log.ProcessStateLog -> JBPM_LOG 16:50:10,812 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/log/SignalLog.hbm.xml 16:50:10,816 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.log.SignalLog -> JBPM_LOG 16:50:10,816 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/log/TokenCreateLog.hbm.xml 16:50:10,821 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.log.TokenCreateLog -> JBPM_LOG 16:50:10,821 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/log/TokenEndLog.hbm.xml 16:50:10,826 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.log.TokenEndLog -> JBPM_LOG 16:50:10,826 INFO [Configuration] Reading mappings from resource : org/jbpm/graph/log/TransitionLog.hbm.xml 16:50:10,831 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.log.TransitionLog -> JBPM_LOG 16:50:10,831 INFO [Configuration] Reading mappings from resource : org/jbpm/context/log/VariableLog.hbm.xml 16:50:10,836 INFO [HbmBinder] Mapping subclass: org.jbpm.context.log.VariableLog -> JBPM_LOG 16:50:10,836 INFO [Configuration] Reading mappings from resource : org/jbpm/context/log/VariableCreateLog.hbm.xml 16:50:10,837 INFO [ConfigurationParser] Processing identity profile configuration 16:50:10,840 INFO [HbmBinder] Mapping subclass: org.jbpm.context.log.VariableCreateLog -> JBPM_LOG 16:50:10,841 INFO [Configuration] Reading mappings from resource : org/jbpm/context/log/VariableDeleteLog.hbm.xml 16:50:10,845 INFO [HbmBinder] Mapping subclass: org.jbpm.context.log.VariableDeleteLog -> JBPM_LOG 16:50:10,845 INFO [Configuration] Reading mappings from resource : org/jbpm/context/log/VariableUpdateLog.hbm.xml 16:50:10,853 INFO [HbmBinder] Mapping subclass: org.jbpm.context.log.VariableUpdateLog -> JBPM_LOG 16:50:10,853 INFO [Configuration] Reading mappings from resource : org/jbpm/context/log/variableinstance/ByteArrayUpdateLog.hbm.xml 16:50:10,862 INFO [HbmBinder] Mapping subclass: org.jbpm.context.log.variableinstance.ByteArrayUpdateLog -> JBPM_LOG 16:50:10,862 INFO [Configuration] Reading mappings from resource : org/jbpm/context/log/variableinstance/DateUpdateLog.hbm.xml 16:50:10,870 INFO [HbmBinder] Mapping subclass: org.jbpm.context.log.variableinstance.DateUpdateLog -> JBPM_LOG 16:50:10,870 INFO [Configuration] Reading mappings from resource : org/jbpm/context/log/variableinstance/DoubleUpdateLog.hbm.xml 16:50:10,879 INFO [HbmBinder] Mapping subclass: org.jbpm.context.log.variableinstance.DoubleUpdateLog -> JBPM_LOG 16:50:10,879 INFO [Configuration] Reading mappings from resource : org/jbpm/context/log/variableinstance/HibernateLongUpdateLog.hbm.xml 16:50:10,887 INFO [HbmBinder] Mapping subclass: org.jbpm.context.log.variableinstance.HibernateLongUpdateLog -> JBPM_LOG 16:50:10,888 INFO [Configuration] Reading mappings from resource : org/jbpm/context/log/variableinstance/HibernateStringUpdateLog.hbm.xml 16:50:10,896 INFO [HbmBinder] Mapping subclass: org.jbpm.context.log.variableinstance.HibernateStringUpdateLog -> JBPM_LOG 16:50:10,896 INFO [Configuration] Reading mappings from resource : org/jbpm/context/log/variableinstance/LongUpdateLog.hbm.xml 16:50:10,904 INFO [HbmBinder] Mapping subclass: org.jbpm.context.log.variableinstance.LongUpdateLog -> JBPM_LOG 16:50:10,905 INFO [Configuration] Reading mappings from resource : org/jbpm/context/log/variableinstance/StringUpdateLog.hbm.xml 16:50:10,913 INFO [HbmBinder] Mapping subclass: org.jbpm.context.log.variableinstance.StringUpdateLog -> JBPM_LOG 16:50:10,913 INFO [Configuration] Reading mappings from resource : org/jbpm/taskmgmt/log/TaskLog.hbm.xml 16:50:10,921 INFO [HbmBinder] Mapping subclass: org.jbpm.taskmgmt.log.TaskLog -> JBPM_LOG 16:50:10,922 INFO [Configuration] Reading mappings from resource : org/jbpm/taskmgmt/log/TaskCreateLog.hbm.xml 16:50:10,930 INFO [HbmBinder] Mapping subclass: org.jbpm.taskmgmt.log.TaskCreateLog -> JBPM_LOG 16:50:10,930 INFO [Configuration] Reading mappings from resource : org/jbpm/taskmgmt/log/TaskAssignLog.hbm.xml 16:50:10,938 INFO [HbmBinder] Mapping subclass: org.jbpm.taskmgmt.log.TaskAssignLog -> JBPM_LOG 16:50:10,939 INFO [Configuration] Reading mappings from resource : org/jbpm/taskmgmt/log/TaskEndLog.hbm.xml 16:50:10,947 INFO [HbmBinder] Mapping subclass: org.jbpm.taskmgmt.log.TaskEndLog -> JBPM_LOG 16:50:10,947 INFO [Configuration] Reading mappings from resource : org/jbpm/taskmgmt/log/SwimlaneLog.hbm.xml 16:50:10,955 INFO [HbmBinder] Mapping subclass: org.jbpm.taskmgmt.log.SwimlaneLog -> JBPM_LOG 16:50:10,955 INFO [Configuration] Reading mappings from resource : org/jbpm/taskmgmt/log/SwimlaneCreateLog.hbm.xml 16:50:10,964 INFO [HbmBinder] Mapping subclass: org.jbpm.taskmgmt.log.SwimlaneCreateLog -> JBPM_LOG 16:50:10,964 INFO [Configuration] Reading mappings from resource : org/jbpm/taskmgmt/log/SwimlaneAssignLog.hbm.xml 16:50:10,972 INFO [HbmBinder] Mapping subclass: org.jbpm.taskmgmt.log.SwimlaneAssignLog -> JBPM_LOG 16:50:10,972 INFO [Configuration] Configured SessionFactory: null 16:50:10,972 INFO [HbmBinder] Mapping subclass: org.jbpm.taskmgmt.def.TaskMgmtDefinition -> JBPM_MODULEDEFINITION 16:50:10,973 INFO [HbmBinder] Mapping subclass: org.jbpm.graph.action.Script -> JBPM_ACTION 16:50:10,973 INFO [HbmBinder] Mapping subclass: org.jbpm.context.def.ContextDefinition -> JBPM_MODULEDEFINITION 16:50:10,973 INFO [HbmBinder] Mapping collection: org.jbpm.identity.User.memberships -> JBPM_ID_MEMBERSHIP 16:50:10,974 INFO [HbmBinder] Mapping collection: org.jbpm.identity.Group.children -> JBPM_ID_GROUP 16:50:10,974 INFO [HbmBinder] Mapping collection: org.jbpm.identity.Group.memberships -> JBPM_ID_MEMBERSHIP 16:50:10,974 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.ProcessDefinition.events -> JBPM_EVENT 16:50:10,974 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.ProcessDefinition.exceptionHandlers -> JBPM_EXCEPTIONHANDLER 16:50:10,974 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.ProcessDefinition.nodes -> JBPM_NODE 16:50:10,975 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.ProcessDefinition.actions -> JBPM_ACTION 16:50:10,975 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.ProcessDefinition.definitions -> JBPM_MODULEDEFINITION 16:50:10,975 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.Node.events -> JBPM_EVENT 16:50:10,975 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.Node.exceptionHandlers -> JBPM_EXCEPTIONHANDLER 16:50:10,975 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.Node.leavingTransitions -> JBPM_TRANSITION 16:50:10,975 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.Node.arrivingTransitions -> JBPM_TRANSITION 16:50:10,976 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.Transition.events -> JBPM_EVENT 16:50:10,976 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.Transition.exceptionHandlers -> JBPM_EXCEPTIONHANDLER 16:50:10,976 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.Event.actions -> JBPM_ACTION 16:50:10,976 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.SuperState.nodes -> JBPM_NODE 16:50:10,976 INFO [HbmBinder] Mapping collection: org.jbpm.graph.def.ExceptionHandler.actions -> JBPM_ACTION 16:50:10,976 INFO [HbmBinder] Mapping collection: org.jbpm.graph.node.ProcessState.variableAccesses -> JBPM_VARIABLEACCESS 16:50:10,977 INFO [HbmBinder] Mapping collection: org.jbpm.graph.node.TaskNode.tasks -> JBPM_TASK 16:50:10,980 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.def.Swimlane.tasks -> JBPM_TASK 16:50:10,980 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.def.Task.events -> JBPM_EVENT 16:50:10,980 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.def.Task.exceptionHandlers -> JBPM_EXCEPTIONHANDLER 16:50:10,981 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.def.TaskController.variableAccesses -> JBPM_VARIABLEACCESS 16:50:10,981 INFO [HbmBinder] Mapping collection: org.jbpm.file.def.FileDefinition.processFiles -> JBPM_BYTEARRAY 16:50:10,981 INFO [HbmBinder] Mapping collection: org.jbpm.graph.exe.ProcessInstance.runtimeActions -> JBPM_RUNTIMEACTION 16:50:10,981 INFO [HbmBinder] Mapping collection: org.jbpm.graph.exe.ProcessInstance.instances -> JBPM_MODULEINSTANCE 16:50:10,982 INFO [HbmBinder] Mapping collection: org.jbpm.graph.exe.Token.children -> JBPM_TOKEN 16:50:10,982 INFO [HbmBinder] Mapping collection: org.jbpm.graph.exe.Token.comments -> JBPM_COMMENT 16:50:10,982 INFO [HbmBinder] Mapping collection: org.jbpm.context.exe.ContextInstance.tokenVariableMaps -> JBPM_TOKENVARIABLEMAP 16:50:10,982 INFO [HbmBinder] Mapping collection: org.jbpm.context.exe.TokenVariableMap.variableInstances -> JBPM_VARIABLEINSTANCE 16:50:10,982 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.exe.TaskMgmtInstance.swimlaneInstances -> JBPM_SWIMLANEINSTANCE 16:50:10,982 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.exe.TaskMgmtInstance.taskInstances -> JBPM_TASKINSTANCE 16:50:10,982 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.exe.TaskInstance.variableInstances -> JBPM_VARIABLEINSTANCE 16:50:10,983 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.exe.TaskInstance.comments -> JBPM_COMMENT 16:50:10,983 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.exe.SwimlaneInstance.pooledActors -> JBPM_POOLEDACTOR 16:50:10,983 INFO [HbmBinder] Mapping collection: org.jbpm.logging.log.CompositeLog.children -> JBPM_LOG 16:50:10,983 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.def.TaskMgmtDefinition.swimlanes -> JBPM_SWIMLANE 16:50:10,984 INFO [HbmBinder] Mapping collection: org.jbpm.taskmgmt.def.TaskMgmtDefinition.tasks -> JBPM_TASK 16:50:10,984 INFO [HbmBinder] Mapping collection: org.jbpm.graph.action.Script.variableAccesses -> JBPM_VARIABLEACCESS 16:50:10,992 INFO [NamingHelper] JNDI InitialContext properties:{} 16:50:10,992 INFO [DatasourceConnectionProvider] Using datasource: java:PortalDS 16:50:10,993 INFO [SettingsFactory] RDBMS: HSQL Database Engine, version: 1.8.0 16:50:10,993 INFO [SettingsFactory] JDBC driver: HSQL Database Engine Driver, version: 1.8.0 16:50:10,993 INFO [Dialect] Using dialect: org.hibernate.dialect.HSQLDialect 16:50:10,994 INFO [TransactionFactoryFactory] Transaction strategy: org.hibernate.transaction.JTATransactionFactory 16:50:10,994 INFO [NamingHelper] JNDI InitialContext properties:{} 16:50:10,994 INFO [TransactionManagerLookupFactory] instantiating TransactionManagerLookup: org.hibernate.transaction.JBossTransactionManagerLookup 16:50:10,994 INFO [TransactionManagerLookupFactory] instantiated TransactionManagerLookup 16:50:10,994 INFO [TransactionManagerLookupFactory] instantiating TransactionManagerLookup: org.hibernate.transaction.JBossTransactionManagerLookup 16:50:10,994 INFO [TransactionManagerLookupFactory] instantiated TransactionManagerLookup 16:50:10,994 INFO [SettingsFactory] Automatic flush during beforeCompletion(): disabled 16:50:10,994 INFO [SettingsFactory] Automatic session close at end of transaction: disabled 16:50:10,994 INFO [SettingsFactory] JDBC batch size: 15 16:50:10,994 INFO [SettingsFactory] JDBC batch updates for versioned data: disabled 16:50:10,994 INFO [SettingsFactory] Scrollable result sets: enabled 16:50:10,994 INFO [SettingsFactory] JDBC3 getGeneratedKeys(): disabled 16:50:10,994 INFO [SettingsFactory] Connection release mode: auto 16:50:10,994 INFO [SettingsFactory] Default batch fetch size: 1 16:50:10,994 INFO [SettingsFactory] Generate SQL with comments: enabled 16:50:11,000 INFO [SettingsFactory] Order SQL updates by primary key: disabled 16:50:11,000 INFO [SettingsFactory] Order SQL inserts for batching: disabled 16:50:11,000 INFO [SettingsFactory] Query translator: org.hibernate.hql.ast.ASTQueryTranslatorFactory 16:50:11,000 INFO [ASTQueryTranslatorFactory] Using ASTQueryTranslatorFactory 16:50:11,000 INFO [SettingsFactory] Query language substitutions: {} 16:50:11,000 INFO [SettingsFactory] JPA-QL strict compliance: disabled 16:50:11,000 INFO [SettingsFactory] Second-level cache: enabled 16:50:11,000 INFO [SettingsFactory] Query cache: enabled 16:50:11,000 INFO [SettingsFactory] Cache provider: org.hibernate.cache.EhCacheProvider 16:50:11,001 INFO [SettingsFactory] Optimize cache for minimal puts: disabled 16:50:11,001 INFO [SettingsFactory] Structured second-level cache entries: disabled 16:50:11,001 INFO [SettingsFactory] Query cache factory: org.hibernate.cache.StandardQueryCacheFactory 16:50:11,001 INFO [SettingsFactory] Statistics: disabled 16:50:11,001 INFO [SettingsFactory] Deleted entity synthetic identifier rollback: disabled 16:50:11,001 INFO [SettingsFactory] Default entity-mode: pojo 16:50:11,001 INFO [SettingsFactory] Named query checking : enabled 16:50:11,003 INFO [SessionFactoryImpl] building session factory 16:50:11,005 WARN [CacheManager] Creating a new instance of CacheManager using the diskStorePath "/tmp/workflow" which is already used by an existing CacheManager. The source of the configuration was URL of file:/opt/jboss-portal-2.6.3.GA/server/default/deploy/jboss-portal.sar/conf/hibernate/workflow/ehcache.xml. The diskStore path for this CacheManager will be set to /tmp/workflow/ehcache_auto_created_1202939411005. To avoid this warning consider using the CacheManager factory methods to create a singleton CacheManager or specifying a separate ehcache configuration (ehcache.xml) for each CacheManager instance. 16:50:11,010 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.Node]; using defaults. 16:50:11,015 WARN [EhCacheProvider] Could not find configuration [org.jbpm.instantiation.Delegation]; using defaults. 16:50:11,028 WARN [EhCacheProvider] Could not find configuration [org.jbpm.taskmgmt.def.Task]; using defaults. 16:50:11,041 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.ProcessDefinition]; using defaults. 16:50:11,050 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.ExceptionHandler]; using defaults. 16:50:11,052 WARN [EhCacheProvider] Could not find configuration [org.jbpm.module.def.ModuleDefinition]; using defaults. 16:50:11,081 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.Action]; using defaults. 16:50:11,091 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.Event]; using defaults. 16:50:11,102 WARN [EhCacheProvider] Could not find configuration [org.jbpm.context.def.VariableAccess]; using defaults. 16:50:11,122 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.Transition]; using defaults. 16:50:11,149 WARN [EhCacheProvider] Could not find configuration [org.jbpm.taskmgmt.def.TaskController]; using defaults. 16:50:11,153 WARN [EhCacheProvider] Could not find configuration [org.jbpm.taskmgmt.def.TaskMgmtDefinition.tasks]; using defaults. 16:50:11,153 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.node.ProcessState.variableAccesses]; using defaults. 16:50:11,154 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.ProcessDefinition.events]; using defaults. 16:50:11,154 WARN [EhCacheProvider] Could not find configuration [org.jbpm.taskmgmt.def.Swimlane.tasks]; using defaults. 16:50:11,155 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.Node.leavingTransitions]; using defaults. 16:50:11,155 WARN [EhCacheProvider] Could not find configuration [org.jbpm.taskmgmt.def.TaskController.variableAccesses]; using defaults. 16:50:11,156 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.ProcessDefinition.exceptionHandlers]; using defaults. 16:50:11,157 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.node.Decision.decisionConditions]; using defaults. 16:50:11,157 WARN [EhCacheProvider] Could not find configuration [org.jbpm.file.def.FileDefinition.processFiles]; using defaults. 16:50:11,159 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.ProcessDefinition.actions]; using defaults. 16:50:11,160 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.Transition.exceptionHandlers]; using defaults. 16:50:11,160 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.ProcessDefinition.nodes]; using defaults. 16:50:11,161 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.Node.arrivingTransitions]; using defaults. 16:50:11,161 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.node.TaskNode.tasks]; using defaults. 16:50:11,161 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.ProcessDefinition.definitions]; using defaults. 16:50:11,163 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.Event.actions]; using defaults. 16:50:11,163 WARN [EhCacheProvider] Could not find configuration [org.jbpm.taskmgmt.def.Task.events]; using defaults. 16:50:11,164 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.Node.events]; using defaults. 16:50:11,164 WARN [EhCacheProvider] Could not find configuration [org.jbpm.taskmgmt.def.TaskMgmtDefinition.swimlanes]; using defaults. 16:50:11,165 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.SuperState.nodes]; using defaults. 16:50:11,165 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.action.Script.variableAccesses]; using defaults. 16:50:11,165 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.ExceptionHandler.actions]; using defaults. 16:50:11,166 WARN [EhCacheProvider] Could not find configuration [org.jbpm.taskmgmt.def.Task.exceptionHandlers]; using defaults. 16:50:11,166 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.Node.exceptionHandlers]; using defaults. 16:50:11,167 WARN [EhCacheProvider] Could not find configuration [org.jbpm.graph.def.Transition.events]; using defaults. 16:50:11,331 INFO [SessionFactoryObjectFactory] Not binding factory to JNDI, no JNDI name configured 16:50:11,331 INFO [NamingHelper] JNDI InitialContext properties:{} 16:50:11,332 INFO [UpdateTimestampsCache] starting update timestamps cache at region: org.hibernate.cache.UpdateTimestampsCache 16:50:11,332 WARN [EhCacheProvider] Could not find configuration [org.hibernate.cache.UpdateTimestampsCache]; using defaults. 16:50:11,332 INFO [StandardQueryCache] starting query cache at region: org.hibernate.cache.StandardQueryCache 16:50:11,332 WARN [EhCacheProvider] Could not find configuration [org.hibernate.cache.StandardQueryCache]; using defaults. 16:50:11,519 INFO [ACLInterceptor] AuthorizationManager initialized=org.jboss.portal.cms.security.AuthorizationManagerImpl@4c282f55 16:50:11,541 INFO [JCRCMS] JBossCache Version=1.4.1 16:50:11,542 INFO [JCRCMS] Starting JCR CMS 16:50:11,626 INFO [RepositoryImpl] Starting repository... 16:50:11,882 INFO [JBossCachePersistenceManager] Pre-loading the PersistenceManager Cache in the background (started)....... 16:50:11,903 INFO [JBossCachePersistenceManager] Pre-loading the PersistenceManager Cache for/wsp_ref (finished)....... 16:50:11,938 INFO [JBossCachePersistenceManager] Pre-loading the PersistenceManager Cache for/version_ref (finished)....... 16:50:11,939 INFO [JBossCachePersistenceManager] Pre-loading the PersistenceManager Cache for/wsp_node (finished)....... 16:50:11,993 INFO [JBossCachePersistenceManager] Pre-loading the PersistenceManager Cache for/version_node (finished)....... 16:50:12,088 INFO [JBossCachePersistenceManager] Pre-loading the PersistenceManager Cache for/wsp_prop (finished)....... 16:50:12,204 INFO [JBossCachePersistenceManager] Pre-loading the PersistenceManager Cache for/version_prop (finished)....... 16:50:13,908 INFO [JBossCachePersistenceManager] ------------------------------------------------- 16:50:13,909 INFO [JBossCachePersistenceManager] JBossCachePersistenceManager is fully loaded..... 16:50:13,909 INFO [JBossCachePersistenceManager] ------------------------------------------------- 16:50:13,980 INFO [RepositoryImpl] initializing workspace 'default'... 16:50:14,033 INFO [RepositoryImpl] workspace 'default' initialized 16:50:14,221 INFO [SearchIndex] Index initialized: /opt/jboss-portal-2.6.3.GA/server/default/data/portal/cms/conf/workspaces/default/index 16:50:14,221 INFO [RepositoryImpl] Repository started 16:50:14,221 INFO [JackrabbitJCRService] Repository 'PortalRepository' created 16:50:14,263 INFO [JackrabbitJCRService] The repository has already the CMS node types registered 16:50:14,269 INFO [JCRCMS] Started JCR CMS in: 2s:726ms 16:50:14,355 INFO [IdentityUIConfigurationServiceImpl] not starting jBPM workflow ... 16:50:14,365 INFO [HbmBinder] Mapping collection: org.jboss.portal.core.impl.model.instance.persistent.PersistentInstanceDefinition.relatedSecurityBindings -> JBP_INSTANCE_SECURITY 16:50:14,367 INFO [HbmBinder] Mapping collection: org.jboss.portal.core.impl.model.instance.persistent.PersistentInstanceDefinition.relatedCustomizations -> JBP_INSTANCE_PER_USER 16:50:14,371 INFO [NamingHelper] JNDI InitialContext properties:{} 16:50:14,371 INFO [DatasourceConnectionProvider] Using datasource: java:PortalDS 16:50:14,372 INFO [SettingsFactory] RDBMS: HSQL Database Engine, version: 1.8.0 16:50:14,372 INFO [SettingsFactory] JDBC driver: HSQL Database Engine Driver, version: 1.8.0 16:50:14,372 INFO [Dialect] Using dialect: org.hibernate.dialect.HSQLDialect 16:50:14,372 INFO [TransactionFactoryFactory] Transaction strategy: org.hibernate.transaction.JTATransactionFactory 16:50:14,373 INFO [NamingHelper] JNDI InitialContext properties:{} 16:50:14,373 INFO [TransactionManagerLookupFactory] instantiating TransactionManagerLookup: org.hibernate.transaction.JBossTransactionManagerLookup 16:50:14,373 INFO [TransactionManagerLookupFactory] instantiated TransactionManagerLookup 16:50:14,373 INFO [TransactionManagerLookupFactory] instantiating TransactionManagerLookup: org.hibernate.transaction.JBossTransactionManagerLookup 16:50:14,373 INFO [TransactionManagerLookupFactory] instantiated TransactionManagerLookup 16:50:14,373 INFO [SettingsFactory] Automatic flush during beforeCompletion(): enabled 16:50:14,373 INFO [SettingsFactory] Automatic session close at end of transaction: disabled 16:50:14,373 INFO [SettingsFactory] JDBC batch size: 15 16:50:14,373 INFO [SettingsFactory] JDBC batch updates for versioned data: disabled 16:50:14,373 INFO [SettingsFactory] Scrollable result sets: enabled 16:50:14,373 INFO [SettingsFactory] JDBC3 getGeneratedKeys(): disabled 16:50:14,373 INFO [SettingsFactory] Connection release mode: auto 16:50:14,373 INFO [SettingsFactory] Default batch fetch size: 1 16:50:14,373 INFO [SettingsFactory] Generate SQL with comments: disabled 16:50:14,374 INFO [SettingsFactory] Order SQL updates by primary key: disabled 16:50:14,374 INFO [SettingsFactory] Order SQL inserts for batching: disabled 16:50:14,374 INFO [SettingsFactory] Query translator: org.hibernate.hql.ast.ASTQueryTranslatorFactory 16:50:14,374 INFO [ASTQueryTranslatorFactory] Using ASTQueryTranslatorFactory 16:50:14,374 INFO [SettingsFactory] Query language substitutions: {} 16:50:14,374 INFO [SettingsFactory] JPA-QL strict compliance: disabled 16:50:14,374 INFO [SettingsFactory] Second-level cache: enabled 16:50:14,374 INFO [SettingsFactory] Query cache: enabled 16:50:14,374 INFO [SettingsFactory] Cache provider: org.hibernate.cache.EhCacheProvider 16:50:14,374 INFO [SettingsFactory] Optimize cache for minimal puts: disabled 16:50:14,374 INFO [SettingsFactory] Structured second-level cache entries: disabled 16:50:14,374 INFO [SettingsFactory] Query cache factory: org.hibernate.cache.StandardQueryCacheFactory 16:50:14,374 INFO [SettingsFactory] Statistics: disabled 16:50:14,374 INFO [SettingsFactory] Deleted entity synthetic identifier rollback: disabled 16:50:14,374 INFO [SettingsFactory] Default entity-mode: pojo 16:50:14,374 INFO [SettingsFactory] Named query checking : enabled 16:50:14,377 INFO [SessionFactoryImpl] building session factory 16:50:14,380 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.core.impl.model.instance.persistent.PersistentInstanceCustomization]; using defaults. 16:50:14,393 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.core.impl.model.instance.persistent.PersistentRoleSecurityBinding]; using defaults. 16:50:14,395 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.core.impl.model.instance.persistent.PersistentInstanceDefinition]; using defaults. 16:50:14,401 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.core.impl.model.instance.persistent.PersistentRoleSecurityBinding.actions]; using defaults. 16:50:14,402 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.core.impl.model.instance.persistent.PersistentInstanceDefinition.relatedCustomizations]; using defaults. 16:50:14,402 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.core.impl.model.instance.persistent.PersistentInstanceDefinition.relatedSecurityBindings]; using defaults. 16:50:14,408 INFO [SessionFactoryObjectFactory] Factory name: java:/portal/InstanceSessionFactory 16:50:14,408 INFO [NamingHelper] JNDI InitialContext properties:{} 16:50:14,408 INFO [SessionFactoryObjectFactory] Bound factory to JNDI name: java:/portal/InstanceSessionFactory 16:50:14,408 WARN [SessionFactoryObjectFactory] InitialContext did not implement EventContext 16:50:14,415 INFO [SchemaUpdate] Running hbm2ddl schema update 16:50:14,415 INFO [SchemaUpdate] fetching database metadata 16:50:14,417 INFO [SchemaUpdate] updating schema 16:50:14,461 INFO [TableMetadata] table found: PUBLIC.JBP_INSTANCE 16:50:14,461 INFO [TableMetadata] columns: [modifiable, portlet_ref, ser_state, id, pk] 16:50:14,461 INFO [TableMetadata] foreign keys: [] 16:50:14,461 INFO [TableMetadata] indexes: [sys_idx_384, sys_idx_sys_ct_383_386] 16:50:14,492 INFO [TableMetadata] table found: PUBLIC.JBP_INSTANCE_DISPLAY_NAMES 16:50:14,492 INFO [TableMetadata] columns: [locale, text, instance_pk] 16:50:14,492 INFO [TableMetadata] foreign keys: [fkd64ff928e7e819e7] 16:50:14,492 INFO [TableMetadata] indexes: [sys_idx_387, sys_idx_389] 16:50:14,522 INFO [TableMetadata] table found: PUBLIC.JBP_INSTANCE_PER_USER 16:50:14,522 INFO [TableMetadata] columns: [user_id, portlet_ref, ser_state, pk, instance_pk] 16:50:14,522 INFO [TableMetadata] foreign keys: [fk9349b3d0e7e819e7] 16:50:14,522 INFO [TableMetadata] indexes: [sys_idx_sys_ct_389_393, sys_idx_391, sys_idx_394] 16:50:14,551 INFO [TableMetadata] table found: PUBLIC.JBP_INSTANCE_SECURITY 16:50:14,551 INFO [TableMetadata] columns: [role, pk, instance_pk] 16:50:14,551 INFO [TableMetadata] foreign keys: [fkb0c61d43e7e819e7] 16:50:14,551 INFO [TableMetadata] indexes: [sys_idx_396, sys_idx_398] 16:50:14,580 INFO [TableMetadata] table found: PUBLIC.JBP_INSTANCE_SECURITY_ACTIONS 16:50:14,580 INFO [TableMetadata] columns: [actions, pk] 16:50:14,581 INFO [TableMetadata] foreign keys: [fk8b5da5e188e068d0] 16:50:14,581 INFO [TableMetadata] indexes: [sys_idx_401] 16:50:14,581 INFO [SchemaUpdate] schema update complete 16:50:14,581 INFO [NamingHelper] JNDI InitialContext properties:{} 16:50:14,582 INFO [UpdateTimestampsCache] starting update timestamps cache at region: org.hibernate.cache.UpdateTimestampsCache 16:50:14,582 WARN [EhCacheProvider] Could not find configuration [org.hibernate.cache.UpdateTimestampsCache]; using defaults. 16:50:14,582 INFO [StandardQueryCache] starting query cache at region: org.hibernate.cache.StandardQueryCache 16:50:14,582 WARN [EhCacheProvider] Could not find configuration [org.hibernate.cache.StandardQueryCache]; using defaults. 16:50:14,602 INFO [HbmBinder] Mapping collection: org.jboss.portal.core.impl.model.portal.ObjectNode.children -> JBP_OBJECT_NODE 16:50:14,602 INFO [HbmBinder] Mapping collection: org.jboss.portal.core.impl.model.portal.ObjectNode.securityConstraints -> JBP_OBJECT_NODE_SEC 16:50:14,610 INFO [NamingHelper] JNDI InitialContext properties:{} 16:50:14,610 INFO [DatasourceConnectionProvider] Using datasource: java:PortalDS 16:50:14,611 INFO [SettingsFactory] RDBMS: HSQL Database Engine, version: 1.8.0 16:50:14,611 INFO [SettingsFactory] JDBC driver: HSQL Database Engine Driver, version: 1.8.0 16:50:14,611 INFO [Dialect] Using dialect: org.hibernate.dialect.HSQLDialect 16:50:14,611 INFO [TransactionFactoryFactory] Transaction strategy: org.hibernate.transaction.JTATransactionFactory 16:50:14,611 INFO [NamingHelper] JNDI InitialContext properties:{} 16:50:14,612 INFO [TransactionManagerLookupFactory] instantiating TransactionManagerLookup: org.hibernate.transaction.JBossTransactionManagerLookup 16:50:14,612 INFO [TransactionManagerLookupFactory] instantiated TransactionManagerLookup 16:50:14,612 INFO [TransactionManagerLookupFactory] instantiating TransactionManagerLookup: org.hibernate.transaction.JBossTransactionManagerLookup 16:50:14,612 INFO [TransactionManagerLookupFactory] instantiated TransactionManagerLookup 16:50:14,612 INFO [SettingsFactory] Automatic flush during beforeCompletion(): enabled 16:50:14,612 INFO [SettingsFactory] Automatic session close at end of transaction: disabled 16:50:14,612 INFO [SettingsFactory] JDBC batch size: 15 16:50:14,612 INFO [SettingsFactory] JDBC batch updates for versioned data: disabled 16:50:14,612 INFO [SettingsFactory] Scrollable result sets: enabled 16:50:14,612 INFO [SettingsFactory] JDBC3 getGeneratedKeys(): disabled 16:50:14,612 INFO [SettingsFactory] Connection release mode: auto 16:50:14,612 INFO [SettingsFactory] Default batch fetch size: 1 16:50:14,612 INFO [SettingsFactory] Generate SQL with comments: disabled 16:50:14,612 INFO [SettingsFactory] Order SQL updates by primary key: disabled 16:50:14,612 INFO [SettingsFactory] Order SQL inserts for batching: disabled 16:50:14,612 INFO [SettingsFactory] Query translator: org.hibernate.hql.ast.ASTQueryTranslatorFactory 16:50:14,612 INFO [ASTQueryTranslatorFactory] Using ASTQueryTranslatorFactory 16:50:14,612 INFO [SettingsFactory] Query language substitutions: {} 16:50:14,612 INFO [SettingsFactory] JPA-QL strict compliance: disabled 16:50:14,612 INFO [SettingsFactory] Second-level cache: enabled 16:50:14,612 INFO [SettingsFactory] Query cache: enabled 16:50:14,612 INFO [SettingsFactory] Cache provider: org.hibernate.cache.EhCacheProvider 16:50:14,612 INFO [SettingsFactory] Optimize cache for minimal puts: disabled 16:50:14,612 INFO [SettingsFactory] Structured second-level cache entries: disabled 16:50:14,612 INFO [SettingsFactory] Query cache factory: org.hibernate.cache.StandardQueryCacheFactory 16:50:14,612 INFO [SettingsFactory] Statistics: disabled 16:50:14,612 INFO [SettingsFactory] Deleted entity synthetic identifier rollback: disabled 16:50:14,612 INFO [SettingsFactory] Default entity-mode: pojo 16:50:14,613 INFO [SettingsFactory] Named query checking : enabled 16:50:14,615 INFO [SessionFactoryImpl] building session factory 16:50:14,618 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.core.impl.model.portal.PortalObjectImpl]; using defaults. 16:50:14,650 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.core.impl.model.portal.ObjectNode]; using defaults. 16:50:14,656 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.core.impl.model.portal.ObjectNodeSecurityConstraint]; using defaults. 16:50:14,665 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates]; using defaults. 16:50:14,665 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredPropertyMap]; using defaults. 16:50:14,665 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.core.impl.model.portal.ObjectNodeSecurityConstraint.actions]; using defaults. 16:50:14,666 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.core.impl.model.portal.ObjectNode.children]; using defaults. 16:50:14,666 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.core.impl.model.portal.ObjectNode.securityConstraints]; using defaults. 16:50:14,689 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.core.impl.model.portal.PortalImpl.modes]; using defaults. 16:50:14,701 INFO [SessionFactoryObjectFactory] Factory name: java:/portal/PortalObjectSessionFactory 16:50:14,701 INFO [NamingHelper] JNDI InitialContext properties:{} 16:50:14,702 INFO [SessionFactoryObjectFactory] Bound factory to JNDI name: java:/portal/PortalObjectSessionFactory 16:50:14,702 WARN [SessionFactoryObjectFactory] InitialContext did not implement EventContext 16:50:14,702 INFO [SchemaUpdate] Running hbm2ddl schema update 16:50:14,702 INFO [SchemaUpdate] fetching database metadata 16:50:14,703 INFO [SchemaUpdate] updating schema 16:50:14,733 INFO [TableMetadata] table found: PUBLIC.JBP_CONTEXT 16:50:14,733 INFO [TableMetadata] columns: [pk] 16:50:14,733 INFO [TableMetadata] foreign keys: [fk4a7fee6895cb95c3] 16:50:14,733 INFO [TableMetadata] indexes: [sys_idx_567, sys_idx_403] 16:50:14,760 INFO [TableMetadata] table found: PUBLIC.JBP_OBJECT_NODE 16:50:14,760 INFO [TableMetadata] columns: [parent_key, path, name, pk] 16:50:14,760 INFO [TableMetadata] foreign keys: [fkce6c8f5b8083a928] 16:50:14,760 INFO [TableMetadata] indexes: [sys_idx_407, sys_idx_410, sys_idx_sys_ct_406_409] 16:50:14,787 INFO [TableMetadata] table found: PUBLIC.JBP_OBJECT_NODE_SEC 16:50:14,787 INFO [TableMetadata] columns: [node_key, role, pk] 16:50:14,787 INFO [TableMetadata] foreign keys: [fk9cbbd94dd209e280] 16:50:14,787 INFO [TableMetadata] indexes: [sys_idx_412, sys_idx_414] 16:50:14,814 INFO [TableMetadata] table found: PUBLIC.JBP_OBJECT_NODE_SEC_ACTIONS 16:50:14,814 INFO [TableMetadata] columns: [actions, pk] 16:50:14,814 INFO [TableMetadata] foreign keys: [fkbe83b7ebf2685fb6] 16:50:14,814 INFO [TableMetadata] indexes: [sys_idx_417] 16:50:14,841 INFO [TableMetadata] table found: PUBLIC.JBP_PAGE 16:50:14,841 INFO [TableMetadata] columns: [pk] 16:50:14,841 INFO [TableMetadata] foreign keys: [fk3856045695cb95c3] 16:50:14,841 INFO [TableMetadata] indexes: [sys_idx_569, sys_idx_419] 16:50:14,866 INFO [TableMetadata] table found: PUBLIC.JBP_PORTAL 16:50:14,866 INFO [TableMetadata] columns: [pk] 16:50:14,866 INFO [TableMetadata] foreign keys: [fk7bb0d07395cb95c3] 16:50:14,866 INFO [TableMetadata] indexes: [sys_idx_571, sys_idx_421] 16:50:14,891 INFO [TableMetadata] table found: PUBLIC.JBP_PORTAL_MODE 16:50:14,891 INFO [TableMetadata] columns: [name, pk] 16:50:14,891 INFO [TableMetadata] foreign keys: [fkbed69ef5f8180a4] 16:50:14,891 INFO [TableMetadata] indexes: [sys_idx_424] 16:50:14,914 INFO [TableMetadata] table found: PUBLIC.JBP_PORTAL_OBJECT 16:50:14,914 INFO [TableMetadata] columns: [listener, pk] 16:50:14,914 INFO [TableMetadata] foreign keys: [fkc8efec8b8f1445d9] 16:50:14,914 INFO [TableMetadata] indexes: [sys_idx_428, sys_idx_426] 16:50:14,937 INFO [TableMetadata] table found: PUBLIC.JBP_PORTAL_OBJECT_DNAMES 16:50:14,937 INFO [TableMetadata] columns: [locale, text, instance_pk] 16:50:14,937 INFO [TableMetadata] foreign keys: [fk32b557981881a1ad] 16:50:14,937 INFO [TableMetadata] indexes: [sys_idx_430, sys_idx_432] 16:50:14,960 INFO [TableMetadata] table found: PUBLIC.JBP_PORTAL_OBJECT_PROPS 16:50:14,960 INFO [TableMetadata] columns: [object_key, jbp_value, name] 16:50:14,960 INFO [TableMetadata] foreign keys: [fkb7fb4c9cd5674127] 16:50:14,960 INFO [TableMetadata] indexes: [sys_idx_434, sys_idx_436] 16:50:14,983 INFO [TableMetadata] table found: PUBLIC.JBP_PORTAL_WINDOW_STATE 16:50:14,983 INFO [TableMetadata] columns: [name, pk] 16:50:14,983 INFO [TableMetadata] foreign keys: [fkc21677ae5f8180a4] 16:50:14,983 INFO [TableMetadata] indexes: [sys_idx_439] 16:50:15,006 INFO [TableMetadata] table found: PUBLIC.JBP_WINDOW 16:50:15,006 INFO [TableMetadata] columns: [instance_ref, pk] 16:50:15,006 INFO [TableMetadata] foreign keys: [fk874c23f795cb95c3] 16:50:15,006 INFO [TableMetadata] indexes: [sys_idx_443, sys_idx_441] 16:50:15,007 INFO [SchemaUpdate] schema update complete 16:50:15,007 INFO [NamingHelper] JNDI InitialContext properties:{} 16:50:15,007 INFO [UpdateTimestampsCache] starting update timestamps cache at region: org.hibernate.cache.UpdateTimestampsCache 16:50:15,007 WARN [EhCacheProvider] Could not find configuration [org.hibernate.cache.UpdateTimestampsCache]; using defaults. 16:50:15,008 INFO [StandardQueryCache] starting query cache at region: org.hibernate.cache.StandardQueryCache 16:50:15,008 WARN [EhCacheProvider] Could not find configuration [org.hibernate.cache.StandardQueryCache]; using defaults. 16:50:15,896 INFO [HbmBinder] Mapping collection: org.jboss.portal.core.impl.portlet.state.PersistentPortletState.entries -> JBP_PORTLET_STATE_ENTRY 16:50:15,896 INFO [HbmBinder] Mapping collection: org.jboss.portal.core.impl.portlet.state.PersistentPortletState.children -> JBP_PORTLET_STATE 16:50:15,897 INFO [HbmBinder] Mapping collection: org.jboss.portal.core.impl.portlet.state.PersistentConsumerGroup.relatedConsumers -> JBP_PORTLET_CONSUMER 16:50:15,897 INFO [HbmBinder] Mapping collection: org.jboss.portal.core.impl.portlet.state.PersistentConsumer.relatedRegistrations -> JBP_PORTLET_REG 16:50:15,897 INFO [HbmBinder] Mapping collection: org.jboss.portal.core.impl.portlet.state.PersistentRegistration.relatedPortletStates -> JBP_PORTLET_STATE 16:50:15,901 INFO [NamingHelper] JNDI InitialContext properties:{} 16:50:15,901 INFO [DatasourceConnectionProvider] Using datasource: java:PortalDS 16:50:15,901 INFO [SettingsFactory] RDBMS: HSQL Database Engine, version: 1.8.0 16:50:15,901 INFO [SettingsFactory] JDBC driver: HSQL Database Engine Driver, version: 1.8.0 16:50:15,902 INFO [Dialect] Using dialect: org.hibernate.dialect.HSQLDialect 16:50:15,902 INFO [TransactionFactoryFactory] Transaction strategy: org.hibernate.transaction.JTATransactionFactory 16:50:15,902 INFO [NamingHelper] JNDI InitialContext properties:{} 16:50:15,902 INFO [TransactionManagerLookupFactory] instantiating TransactionManagerLookup: org.hibernate.transaction.JBossTransactionManagerLookup 16:50:15,902 INFO [TransactionManagerLookupFactory] instantiated TransactionManagerLookup 16:50:15,902 INFO [TransactionManagerLookupFactory] instantiating TransactionManagerLookup: org.hibernate.transaction.JBossTransactionManagerLookup 16:50:15,903 INFO [TransactionManagerLookupFactory] instantiated TransactionManagerLookup 16:50:15,903 INFO [SettingsFactory] Automatic flush during beforeCompletion(): enabled 16:50:15,903 INFO [SettingsFactory] Automatic session close at end of transaction: disabled 16:50:15,903 INFO [SettingsFactory] JDBC batch size: 15 16:50:15,903 INFO [SettingsFactory] JDBC batch updates for versioned data: disabled 16:50:15,903 INFO [SettingsFactory] Scrollable result sets: enabled 16:50:15,903 INFO [SettingsFactory] JDBC3 getGeneratedKeys(): disabled 16:50:15,903 INFO [SettingsFactory] Connection release mode: auto 16:50:15,903 INFO [SettingsFactory] Default batch fetch size: 1 16:50:15,903 INFO [SettingsFactory] Generate SQL with comments: disabled 16:50:15,903 INFO [SettingsFactory] Order SQL updates by primary key: disabled 16:50:15,903 INFO [SettingsFactory] Order SQL inserts for batching: disabled 16:50:15,904 INFO [SettingsFactory] Query translator: org.hibernate.hql.ast.ASTQueryTranslatorFactory 16:50:15,904 INFO [ASTQueryTranslatorFactory] Using ASTQueryTranslatorFactory 16:50:15,904 INFO [SettingsFactory] Query language substitutions: {} 16:50:15,904 INFO [SettingsFactory] JPA-QL strict compliance: disabled 16:50:15,904 INFO [SettingsFactory] Second-level cache: enabled 16:50:15,904 INFO [SettingsFactory] Query cache: enabled 16:50:15,904 INFO [SettingsFactory] Cache provider: org.hibernate.cache.EhCacheProvider 16:50:15,904 INFO [SettingsFactory] Optimize cache for minimal puts: disabled 16:50:15,904 INFO [SettingsFactory] Structured second-level cache entries: disabled 16:50:15,904 INFO [SettingsFactory] Query cache factory: org.hibernate.cache.StandardQueryCacheFactory 16:50:15,904 INFO [SettingsFactory] Statistics: disabled 16:50:15,904 INFO [SettingsFactory] Deleted entity synthetic identifier rollback: disabled 16:50:15,904 INFO [SettingsFactory] Default entity-mode: pojo 16:50:15,904 INFO [SettingsFactory] Named query checking : enabled 16:50:15,914 INFO [SessionFactoryImpl] building session factory 16:50:15,917 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.core.impl.portlet.state.PersistentRegistration]; using defaults. 16:50:15,936 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.core.impl.portlet.state.PersistentPortletStateEntry]; using defaults. 16:50:15,942 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.core.impl.portlet.state.PersistentPortletState]; using defaults. 16:50:15,948 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.core.impl.portlet.state.PersistentConsumerGroup]; using defaults. 16:50:15,953 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.core.impl.portlet.state.PersistentConsumer]; using defaults. 16:50:15,963 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.core.impl.portlet.state.PersistentPortletStateEntry.strings]; using defaults. 16:50:15,963 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.core.impl.portlet.state.PersistentRegistration.persistentProperties]; using defaults. 16:50:15,964 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.core.impl.portlet.state.PersistentRegistration.relatedPortletStates]; using defaults. 16:50:15,965 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.core.impl.portlet.state.PersistentConsumer.relatedRegistrations]; using defaults. 16:50:15,965 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.core.impl.portlet.state.PersistentPortletState.entries]; using defaults. 16:50:15,966 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.core.impl.portlet.state.PersistentConsumerGroup.relatedConsumers]; using defaults. 16:50:15,966 WARN [EhCacheProvider] Could not find configuration [org.jboss.portal.core.impl.portlet.state.PersistentPortletState.children]; using defaults. 16:50:15,975 INFO [SessionFactoryObjectFactory] Factory name: java:/portal/PortletSessionFactory 16:50:15,975 INFO [NamingHelper] JNDI InitialContext properties:{} 16:50:15,975 INFO [SessionFactoryObjectFactory] Bound factory to JNDI name: java:/portal/PortletSessionFactory 16:50:15,975 WARN [SessionFactoryObjectFactory] InitialContext did not implement EventContext 16:50:15,976 INFO [NamingHelper] JNDI InitialContext properties:{} 16:50:15,976 INFO [UpdateTimestampsCache] starting update timestamps cache at region: org.hibernate.cache.UpdateTimestampsCache 16:50:15,976 WARN [EhCacheProvider] Could not find configuration [org.hibernate.cache.UpdateTimestampsCache]; using defaults. 16:50:15,976 INFO [StandardQueryCache] starting query cache at region: org.hibernate.cache.StandardQueryCache 16:50:15,976 WARN [EhCacheProvider] Could not find configuration [org.hibernate.cache.StandardQueryCache]; using defaults. 16:50:16,281 INFO [PortletAppDeployment] Parsing /portal-wsrp-admin/jboss-portlet.xml 16:50:16,598 INFO [FacesConfigurator] Reading standard config org/apache/myfaces/resource/standard-faces-config.xml 16:50:16,628 INFO [FacesConfigurator] Reading config jar:file:/opt/jboss-portal-2.6.3.GA/server/default/./deploy/jboss-portal.sar/portal-wsrp.sar/portal-wsrp-admin.war/WEB-INF/lib2/jsf-facelets.jar!/META-INF/faces-config.xml 16:50:16,633 INFO [FacesConfigurator] Reading config /WEB-INF/faces-config.xml 16:50:16,652 INFO [FacesConfigurator] MyFaces-package : myfaces-api not found. 16:50:16,652 INFO [FacesConfigurator] MyFaces-package : myfaces-impl not found. 16:50:16,652 INFO [FacesConfigurator] MyFaces-package : tomahawk-sandbox not found. 16:50:16,652 INFO [FacesConfigurator] MyFaces-package : tomahawk not found. 16:50:16,652 WARN [LocaleUtils] Locale name in faces-config.xml null or empty, setting locale to default locale : en_US 16:50:16,653 INFO [RenderKitFactoryImpl] RenderKit with renderKitId 'HTML_BASIC' was replaced. 16:50:16,654 WARN [FacesConfigurator] More than one managed bean w/ the name of 'beanContext' - only keeping the last 16:50:16,654 WARN [FacesConfigurator] More than one managed bean w/ the name of 'consumersMgr' - only keeping the last 16:50:16,654 WARN [FacesConfigurator] More than one managed bean w/ the name of 'consumer' - only keeping the last 16:50:16,654 WARN [FacesConfigurator] More than one managed bean w/ the name of 'producer' - only keeping the last 16:50:16,654 INFO [FacesConfigurator] Serialization provider : class org.apache.myfaces.shared_impl.util.serial.DefaultSerialFactory 16:50:16,659 INFO [MyFacesGenericPortlet] PortletContext '/opt/jboss-portal-2.6.3.GA/server/default/./deploy/jboss-portal.sar/portal-wsrp.sar/portal-wsrp-admin.war/' initialized. 16:50:16,697 INFO [PortletAppDeployment] Parsing /portal-news-samples/jboss-portlet.xml 16:50:16,801 INFO [PortletAppDeployment] Parsing /portal-admin/jboss-portlet.xml 16:50:16,846 INFO [FacesConfigurator] Reading standard config org/apache/myfaces/resource/standard-faces-config.xml 16:50:16,874 INFO [FacesConfigurator] Reading config jar:file:/opt/jboss-portal-2.6.3.GA/server/default/./deploy/jboss-portal.sar/portal-admin.sar/portal-admin.war/WEB-INF/lib2/jsf-facelets.jar!/META-INF/faces-config.xml 16:50:16,879 INFO [FacesConfigurator] Reading config /WEB-INF/faces-config.xml 16:50:16,904 INFO [FacesConfigurator] MyFaces-package : myfaces-api not found. 16:50:16,904 INFO [FacesConfigurator] MyFaces-package : myfaces-impl not found. 16:50:16,904 INFO [FacesConfigurator] MyFaces-package : tomahawk-sandbox not found. 16:50:16,904 INFO [FacesConfigurator] MyFaces-package : tomahawk not found. 16:50:16,905 WARN [LocaleUtils] Locale name in faces-config.xml null or empty, setting locale to default locale : en_US 16:50:16,906 INFO [RenderKitFactoryImpl] RenderKit with renderKitId 'HTML_BASIC' was replaced. 16:50:16,907 WARN [FacesConfigurator] More than one managed bean w/ the name of 'portalobjectmgr' - only keeping the last 16:50:16,907 WARN [FacesConfigurator] More than one managed bean w/ the name of 'portalAction' - only keeping the last 16:50:16,907 WARN [FacesConfigurator] More than one managed bean w/ the name of 'addPageAction' - only keeping the last 16:50:16,907 WARN [FacesConfigurator] More than one managed bean w/ the name of 'assignContentToWindowAction' - only keeping the last 16:50:16,907 WARN [FacesConfigurator] More than one managed bean w/ the name of 'dashboardmgr' - only keeping the last 16:50:16,907 WARN [FacesConfigurator] More than one managed bean w/ the name of 'instancemgr' - only keeping the last 16:50:16,907 WARN [FacesConfigurator] More than one managed bean w/ the name of 'portletmgr' - only keeping the last 16:50:16,907 WARN [FacesConfigurator] More than one managed bean w/ the name of 'newWindowWizard' - only keeping the last 16:50:16,907 WARN [FacesConfigurator] More than one managed bean w/ the name of 'createInstanceAction' - only keeping the last 16:50:16,907 WARN [FacesConfigurator] More than one managed bean w/ the name of 'dashboard' - only keeping the last 16:50:16,907 WARN [FacesConfigurator] More than one managed bean w/ the name of 'addDashboardPageAction' - only keeping the last 16:50:16,907 WARN [FacesConfigurator] More than one managed bean w/ the name of 'renameAction' - only keeping the last 16:50:16,907 WARN [FacesConfigurator] More than one managed bean w/ the name of 'addDisplayNameAction' - only keeping the last 16:50:16,907 WARN [FacesConfigurator] More than one managed bean w/ the name of 'renameDashboardPageAction' - only keeping the last 16:50:16,907 WARN [FacesConfigurator] More than one managed bean w/ the name of 'PortalObject' - only keeping the last 16:50:16,907 WARN [FacesConfigurator] More than one managed bean w/ the name of 'ControlConstants' - only keeping the last 16:50:16,907 WARN [FacesConfigurator] More than one managed bean w/ the name of 'PropertiesInfo' - only keeping the last 16:50:16,907 WARN [FacesConfigurator] More than one managed bean w/ the name of 'ControlPropertiesBean' - only keeping the last 16:50:16,907 INFO [FacesConfigurator] Serialization provider : class org.apache.myfaces.shared_impl.util.serial.DefaultSerialFactory 16:50:16,910 INFO [MyFacesGenericPortlet] PortletContext '/opt/jboss-portal-2.6.3.GA/server/default/./deploy/jboss-portal.sar/portal-admin.sar/portal-admin.war/' initialized. 16:50:16,911 INFO [MyFacesGenericPortlet] MyFaces already initialized 16:50:16,911 INFO [MyFacesGenericPortlet] PortletContext '/opt/jboss-portal-2.6.3.GA/server/default/./deploy/jboss-portal.sar/portal-admin.sar/portal-admin.war/' initialized. 16:50:16,929 INFO [PortletAppDeployment] Parsing /portal-users-samples/jboss-portlet.xml 16:50:16,983 INFO [PortletAppDeployment] Parsing /portal-weather-samples/jboss-portlet.xml 16:50:17,033 INFO [PortletAppDeployment] Parsing /portal-core/jboss-portlet.xml 16:50:17,130 INFO [PortletAppDeployment] Parsing /portal-cms/jboss-portlet.xml 16:50:17,188 INFO [CMSPortlet] Cannot start CMS portlet search service due to service unavailability 16:50:17,223 INFO [PortletAppDeployment] Parsing /portal-identity/jboss-portlet.xml 16:50:17,322 INFO [FacesConfigurator] Reading standard config org/apache/myfaces/resource/standard-faces-config.xml 16:50:17,350 INFO [FacesConfigurator] Reading config jar:file:/opt/jboss-portal-2.6.3.GA/server/default/./deploy/jboss-portal.sar/portal-identity.sar/portal-identity.war/WEB-INF/lib2/jsf-facelets.jar!/META-INF/faces-config.xml 16:50:17,356 INFO [FacesConfigurator] Reading config /WEB-INF/faces-config.xml 16:50:17,382 INFO [FacesConfigurator] MyFaces-package : myfaces-api not found. 16:50:17,382 INFO [FacesConfigurator] MyFaces-package : myfaces-impl not found. 16:50:17,382 INFO [FacesConfigurator] MyFaces-package : tomahawk-sandbox not found. 16:50:17,382 INFO [FacesConfigurator] MyFaces-package : tomahawk not found. 16:50:17,383 WARN [LocaleUtils] Locale name in faces-config.xml null or empty, setting locale to default locale : en_US 16:50:17,384 INFO [RenderKitFactoryImpl] RenderKit with renderKitId 'HTML_BASIC' was replaced. 16:50:17,385 WARN [FacesConfigurator] More than one managed bean w/ the name of 'configurationbean' - only keeping the last 16:50:17,385 WARN [FacesConfigurator] More than one managed bean w/ the name of 'metadataservice' - only keeping the last 16:50:17,385 WARN [FacesConfigurator] More than one managed bean w/ the name of 'identityrolemgr' - only keeping the last 16:50:17,385 WARN [FacesConfigurator] More than one managed bean w/ the name of 'identityusermgr' - only keeping the last 16:50:17,385 WARN [FacesConfigurator] More than one managed bean w/ the name of 'editprofilemgr' - only keeping the last 16:50:17,385 WARN [FacesConfigurator] More than one managed bean w/ the name of 'userregistermgr' - only keeping the last 16:50:17,385 WARN [FacesConfigurator] More than one managed bean w/ the name of 'assignrolemgr' - only keeping the last 16:50:17,385 WARN [FacesConfigurator] More than one managed bean w/ the name of 'useradministrationbean' - only keeping the last 16:50:17,385 WARN [FacesConfigurator] More than one managed bean w/ the name of 'rolemanagementbean' - only keeping the last 16:50:17,385 WARN [FacesConfigurator] More than one managed bean w/ the name of 'editrolemgr' - only keeping the last 16:50:17,385 WARN [FacesConfigurator] More than one managed bean w/ the name of 'lostpasswordmgr' - only keeping the last 16:50:17,385 WARN [FacesConfigurator] More than one managed bean w/ the name of 'createrolemgr' - only keeping the last 16:50:17,385 INFO [FacesConfigurator] Serialization provider : class org.apache.myfaces.shared_impl.util.serial.DefaultSerialFactory 16:50:17,388 INFO [MyFacesGenericPortlet] PortletContext '/opt/jboss-portal-2.6.3.GA/server/default/./deploy/jboss-portal.sar/portal-identity.sar/portal-identity.war/' initialized. 16:50:17,389 INFO [MyFacesGenericPortlet] MyFaces already initialized 16:50:17,389 INFO [MyFacesGenericPortlet] PortletContext '/opt/jboss-portal-2.6.3.GA/server/default/./deploy/jboss-portal.sar/portal-identity.sar/portal-identity.war/' initialized. 16:50:17,427 INFO [TomcatDeployer] deploy, ctxPath=/jmx-console, warUrl=.../deploy/jmx-console.war/ 16:50:17,592 INFO [Http11Protocol] Starting Coyote HTTP/1.1 on http-127.0.0.1-8080 16:50:17,622 INFO [AjpProtocol] Starting Coyote AJP/1.3 on ajp-127.0.0.1-8009 16:50:17,640 INFO [Server] JBoss (MX MicroKernel) [4.2.2.GA (build: SVNTag=JBoss_4_2_2_GA date=200710221139)] Started in 34s:477ms 16:50:25,460 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}Fault 16:50:25,460 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}InvalidCookieFault 16:50:25,461 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}UnsupportedMimeTypeFault 16:50:25,462 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}InconsistentParametersFault 16:50:25,462 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}UnsupportedLocaleFault 16:50:25,462 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}InvalidHandleFault 16:50:25,462 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}InvalidRegistrationFault 16:50:25,462 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}InvalidUserCategoryFault 16:50:25,462 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}PortletStateChangeRequiredFault 16:50:25,463 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}UnsupportedWindowStateFault 16:50:25,463 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}UnsupportedModeFault 16:50:25,463 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}InvalidSessionFault 16:50:25,463 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}MissingParametersFault 16:50:25,463 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}OperationFailedFault 16:50:25,463 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}AccessDeniedFault 16:50:25,487 WARN [ServiceObjectFactory] Unable to narrow port selection for UnifiedPortComponentRef serviceEndpointInterface=org.jboss.portal.wsrp.core.WSRP_v1_ServiceDescription_PortType portQName=null enableMTOM=false portComponentLink=null callProperties=[] stubProperties=[] configName=null configFile=null 16:50:25,977 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}Fault 16:50:25,977 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}InvalidCookieFault 16:50:25,977 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}UnsupportedMimeTypeFault 16:50:25,978 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}InconsistentParametersFault 16:50:25,979 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}UnsupportedLocaleFault 16:50:25,979 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}InvalidHandleFault 16:50:25,979 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}InvalidRegistrationFault 16:50:25,979 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}InvalidUserCategoryFault 16:50:25,979 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}PortletStateChangeRequiredFault 16:50:25,980 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}UnsupportedWindowStateFault 16:50:25,980 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}UnsupportedModeFault 16:50:25,980 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}InvalidSessionFault 16:50:25,980 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}MissingParametersFault 16:50:25,980 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}OperationFailedFault 16:50:25,980 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}AccessDeniedFault 16:50:26,011 WARN [ServiceObjectFactory] Unable to narrow port selection for UnifiedPortComponentRef serviceEndpointInterface=org.jboss.portal.wsrp.core.WSRP_v1_Markup_PortType portQName=null enableMTOM=false portComponentLink=null callProperties=[] stubProperties=[] configName=null configFile=null 16:50:26,398 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}Fault 16:50:26,398 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}InvalidCookieFault 16:50:26,399 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}UnsupportedMimeTypeFault 16:50:26,400 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}InconsistentParametersFault 16:50:26,400 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}UnsupportedLocaleFault 16:50:26,400 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}InvalidHandleFault 16:50:26,400 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}InvalidRegistrationFault 16:50:26,401 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}InvalidUserCategoryFault 16:50:26,401 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}PortletStateChangeRequiredFault 16:50:26,401 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}UnsupportedWindowStateFault 16:50:26,401 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}UnsupportedModeFault 16:50:26,401 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}InvalidSessionFault 16:50:26,401 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}MissingParametersFault 16:50:26,401 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}OperationFailedFault 16:50:26,401 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}AccessDeniedFault 16:50:26,431 WARN [ServiceObjectFactory] Unable to narrow port selection for UnifiedPortComponentRef serviceEndpointInterface=org.jboss.portal.wsrp.core.WSRP_v1_PortletManagement_PortType portQName=null enableMTOM=false portComponentLink=null callProperties=[] stubProperties=[] configName=null configFile=null 16:50:26,851 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}Fault 16:50:26,851 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}InvalidCookieFault 16:50:26,852 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}UnsupportedMimeTypeFault 16:50:26,852 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}InconsistentParametersFault 16:50:26,853 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}UnsupportedLocaleFault 16:50:26,853 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}InvalidHandleFault 16:50:26,853 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}InvalidRegistrationFault 16:50:26,853 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}InvalidUserCategoryFault 16:50:26,853 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}PortletStateChangeRequiredFault 16:50:26,853 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}UnsupportedWindowStateFault 16:50:26,853 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}UnsupportedModeFault 16:50:26,853 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}InvalidSessionFault 16:50:26,853 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}MissingParametersFault 16:50:26,854 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}OperationFailedFault 16:50:26,854 INFO [STDOUT] no object for {urn:oasis:names:tc:wsrp:v1:types}AccessDeniedFault 16:50:26,881 WARN [ServiceObjectFactory] Unable to narrow port selection for UnifiedPortComponentRef serviceEndpointInterface=org.jboss.portal.wsrp.core.WSRP_v1_Registration_PortType portQName=null enableMTOM=false portComponentLink=null callProperties=[] stubProperties=[] configName=null configFile=null