Running application on web start

Hi guys!!! I'm from Brazil.

I'm developing a web start desktop application with hibernate, spring and mysql.
when I run local (without jboss), everything works fine, I run the queries in the database normally.
when I deploy in jboss (jboss-5.1.0.GA) and run the webstart, the queries in database returns the following error:
org.hibernate.hql.ast.QuerySyntaxException: Empresa is not mapped [ select distinct e from Empresa e left join fetch e.ambientes a where 1=1 order by e.nome ]

I'm trying to figure out the problem to a long time, but without success. I do not know what to do.

Can someone help me, please ?

I thank everyone in advance

**********************************************************************************
<<server.log>>
 
 
 
 
2011-07-18 09:29:42,885 INFO  [org.jboss.web.WebService] (main) Using RMI server codebase: http://mi162831:8083/
2011-07-18 09:29:47,135 INFO  [org.jboss.wsf.stack.jbws.NativeServerConfig] (main) JBoss Web Services - Stack Native Core
2011-07-18 09:29:47,135 INFO  [org.jboss.wsf.stack.jbws.NativeServerConfig] (main) 3.1.2.GA
2011-07-18 09:29:47,479 INFO  [org.jboss.dependency.plugins.AttributeCallbackItem] (main) Owner callback not implemented.
2011-07-18 09:29:48,244 INFO  [org.jboss.logbridge.LogNotificationListener] (main) Adding notification listener for logging mbean "jboss.system:service=Logging,type=Log4jService" to server org.jboss.mx.server.MBeanServerImpl@bd4e3c[ defaultDomain='jboss' ]
2011-07-18 09:30:11,417 INFO  [org.jboss.ejb3.deployers.Ejb3DependenciesDeployer] (main) Encountered deployment AbstractVFSDeploymentContext@16957111{vfsfile:/C:/jboss-5.1.0.GA/server/default/deploy/profileservice-secured.jar/}
2011-07-18 09:30:11,417 INFO  [org.jboss.ejb3.deployers.Ejb3DependenciesDeployer] (main) Encountered deployment AbstractVFSDeploymentContext@16957111{vfsfile:/C:/jboss-5.1.0.GA/server/default/deploy/profileservice-secured.jar/}
2011-07-18 09:30:11,417 INFO  [org.jboss.ejb3.deployers.Ejb3DependenciesDeployer] (main) Encountered deployment AbstractVFSDeploymentContext@16957111{vfsfile:/C:/jboss-5.1.0.GA/server/default/deploy/profileservice-secured.jar/}
2011-07-18 09:30:11,417 INFO  [org.jboss.ejb3.deployers.Ejb3DependenciesDeployer] (main) Encountered deployment AbstractVFSDeploymentContext@16957111{vfsfile:/C:/jboss-5.1.0.GA/server/default/deploy/profileservice-secured.jar/}
2011-07-18 09:30:13,448 INFO  [org.jboss.mx.remoting.service.JMXConnectorServerService] (main) JMX Connector server: service:jmx:rmi://mi162831/jndi/rmi://mi162831:1090/jmxconnector
2011-07-18 09:30:13,557 INFO  [org.jboss.mail.MailService] (main) Mail Service bound to java:/Mail
2011-07-18 09:30:15,917 WARN  [org.jboss.jms.server.jbosssx.JBossASSecurityMetadataStore] (main) WARNING! POTENTIAL SECURITY RISK. It has been detected that the MessageSucker component which sucks messages from one node to another has not had its password changed from the installation default. Please see the JBoss Messaging user guide for instructions on how to do this.
2011-07-18 09:30:15,917 WARN  [org.jboss.annotation.factory.AnnotationCreator] (main) No ClassLoader provided, using TCCL: org.jboss.managed.api.annotation.ManagementComponent
2011-07-18 09:30:15,979 WARN  [org.jboss.annotation.factory.AnnotationCreator] (main) No ClassLoader provided, using TCCL: org.jboss.managed.api.annotation.ManagementComponent
2011-07-18 09:30:16,026 INFO  [com.arjuna.ats.jbossatx.jta.TransactionManagerService] (main) JBossTS Transaction Service (JTA version - tag:JBOSSTS_4_6_1_GA) - JBoss Inc.
2011-07-18 09:30:16,026 INFO  [com.arjuna.ats.jbossatx.jta.TransactionManagerService] (main) Setting up property manager MBean and JMX layer
2011-07-18 09:30:16,198 INFO  [com.arjuna.ats.jbossatx.jta.TransactionManagerService] (main) Initializing recovery manager
2011-07-18 09:30:16,292 INFO  [com.arjuna.ats.jbossatx.jta.TransactionManagerService] (main) Recovery manager configured
2011-07-18 09:30:16,292 INFO  [com.arjuna.ats.jbossatx.jta.TransactionManagerService] (main) Binding TransactionManager JNDI Reference
2011-07-18 09:30:16,308 INFO  [com.arjuna.ats.jbossatx.jta.TransactionManagerService] (main) Starting transaction recovery manager
2011-07-18 09:30:16,589 INFO  [org.apache.catalina.core.AprLifecycleListener] (main) The Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path: J:\jdk1.6.0_20\bin;.;C:\WINDOWS\Sun\Java\bin;C:\WINDOWS\system32;C:\WINDOWS;C:\oraclexe\app\oracle\product\10.2.0\server\bin;C:\Inprise\vbroker\bin;D:\oracle\product\10.2.0\client_1\bin;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\System32\Wbem;C:\Arquivos de programas\Arquivos comuns\Autodesk Shared\;C:\Arquivos de programas\Autodesk\DWG TrueView\;C:\Arquivos de programas\Rational\common;C:\Arquivos de programas\Rational\ClearCase\bin;C:\ARQUIV~1\Borland\Delphi6\Bin;C:\ARQUIV~1\Borland\Delphi6\Projects\Bpl;C:\Arquivos de programas\Java\jdk1.5.0_06\bin;C:\apache-ant-1.7.1\bin;Z:\GUPTA2005;C:\WINDOWS\system32\WindowsPowerShell\v1.0;C:\apache-maven-2.2.1\bin;C:\Arquivos de programas\Borland\Delphi6\Bin;C:\Arquivos de programas\Borland\Delphi6\Lib;C:\Arquivos de programas\Windows Imaging\;J:\apache-maven-2.2.1\bin;J:\jdk1.6.0_20\bin
2011-07-18 09:30:16,636 INFO  [org.apache.coyote.http11.Http11Protocol] (main) Initializing Coyote HTTP/1.1 on http-0.0.0.0-8080
2011-07-18 09:30:16,636 INFO  [org.apache.coyote.ajp.AjpProtocol] (main) Initializing Coyote AJP/1.3 on ajp-0.0.0.0-8009
2011-07-18 09:30:16,651 INFO  [org.apache.catalina.core.StandardService] (main) Starting service jboss.web
2011-07-18 09:30:16,651 INFO  [org.apache.catalina.core.StandardEngine] (main) Starting Servlet Engine: JBoss Web/2.1.3.GA
2011-07-18 09:30:16,683 INFO  [org.apache.catalina.startup.Catalina] (main) Server startup in 50 ms
2011-07-18 09:30:16,698 INFO  [org.jboss.web.tomcat.service.deployers.TomcatDeployment] (main) deploy, ctxPath=/jbossws
2011-07-18 09:30:17,011 INFO  [org.jboss.web.tomcat.service.deployers.TomcatDeployment] (main) deploy, ctxPath=/invoker
2011-07-18 09:30:17,058 INFO  [org.jboss.web.tomcat.service.deployers.TomcatDeployment] (main) deploy, ctxPath=/web-console
2011-07-18 09:30:17,308 INFO  [org.jboss.resource.deployers.RARDeployment] (main) Required license terms exist, view vfszip:/C:/jboss-5.1.0.GA/server/default/deploy/jboss-local-jdbc.rar/META-INF/ra.xml
2011-07-18 09:30:17,308 INFO  [org.jboss.resource.deployers.RARDeployment] (main) Required license terms exist, view vfszip:/C:/jboss-5.1.0.GA/server/default/deploy/jboss-xa-jdbc.rar/META-INF/ra.xml
2011-07-18 09:30:17,323 INFO  [org.jboss.resource.deployers.RARDeployment] (main) Required license terms exist, view vfszip:/C:/jboss-5.1.0.GA/server/default/deploy/jms-ra.rar/META-INF/ra.xml
2011-07-18 09:30:17,339 INFO  [org.jboss.resource.deployers.RARDeployment] (main) Required license terms exist, view vfszip:/C:/jboss-5.1.0.GA/server/default/deploy/mail-ra.rar/META-INF/ra.xml
2011-07-18 09:30:17,354 INFO  [org.jboss.resource.deployers.RARDeployment] (main) Required license terms exist, view vfszip:/C:/jboss-5.1.0.GA/server/default/deploy/quartz-ra.rar/META-INF/ra.xml
2011-07-18 09:30:17,401 INFO  [org.quartz.simpl.SimpleThreadPool] (main) Job execution threads will use class loader of thread: main
2011-07-18 09:30:17,479 INFO  [org.quartz.core.QuartzScheduler] (main) Quartz Scheduler v.1.5.2 created.
2011-07-18 09:30:17,479 INFO  [org.quartz.simpl.RAMJobStore] (main) RAMJobStore initialized.
2011-07-18 09:30:17,479 INFO  [org.quartz.impl.StdSchedulerFactory] (main) Quartz scheduler 'DefaultQuartzScheduler' initialized from default resource file in Quartz package: 'quartz.properties'
2011-07-18 09:30:17,479 INFO  [org.quartz.impl.StdSchedulerFactory] (main) Quartz scheduler version: 1.5.2
2011-07-18 09:30:17,479 INFO  [org.quartz.core.QuartzScheduler] (main) Scheduler DefaultQuartzScheduler_$_NON_CLUSTERED started.
2011-07-18 09:30:17,573 INFO  [org.jboss.resource.connectionmanager.ConnectionFactoryBindingService] (main) Bound ConnectionManager 'jboss.jca:service=DataSourceBinding,name=MySqlCADS' to JNDI name 'java:MySqlCADS'
2011-07-18 09:30:17,886 INFO  [org.jboss.resource.connectionmanager.ConnectionFactoryBindingService] (main) Bound ConnectionManager 'jboss.jca:service=DataSourceBinding,name=DefaultDS' to JNDI name 'java:DefaultDS'
2011-07-18 09:30:18,245 INFO  [org.jboss.jms.server.ServerPeer] (main) JBoss Messaging 1.4.3.GA server [0] started
2011-07-18 09:30:18,339 INFO  [org.jboss.jms.server.connectionfactory.ConnectionFactory] (main) Connector bisocket://mi162831:4457 has leasing enabled, lease period 10000 milliseconds
2011-07-18 09:30:18,339 INFO  [org.jboss.jms.server.connectionfactory.ConnectionFactory] (main) org.jboss.jms.server.connectionfactory.ConnectionFactory@1ef6570 started
2011-07-18 09:30:18,354 INFO  [org.jboss.jms.server.destination.QueueService] (main) Queue[/queue/ExpiryQueue] started, fullSize=200000, pageSize=2000, downCacheSize=2000
2011-07-18 09:30:18,354 INFO  [org.jboss.jms.server.destination.QueueService] (main) Queue[/queue/DLQ] started, fullSize=200000, pageSize=2000, downCacheSize=2000
2011-07-18 09:30:18,354 INFO  [org.jboss.jms.server.connectionfactory.ConnectionFactory] (main) Connector bisocket://mi162831:4457 has leasing enabled, lease period 10000 milliseconds
2011-07-18 09:30:18,354 INFO  [org.jboss.jms.server.connectionfactory.ConnectionFactory] (main) org.jboss.jms.server.connectionfactory.ConnectionFactory@1f28c started
2011-07-18 09:30:18,354 INFO  [org.jboss.jms.server.connectionfactory.ConnectionFactoryJNDIMapper] (main) supportsFailover attribute is true on connection factory: jboss.messaging.connectionfactory:service=ClusteredConnectionFactory but post office is non clustered. So connection factory will *not* support failover
2011-07-18 09:30:18,354 INFO  [org.jboss.jms.server.connectionfactory.ConnectionFactoryJNDIMapper] (main) supportsLoadBalancing attribute is true on connection factory: jboss.messaging.connectionfactory:service=ClusteredConnectionFactory but post office is non clustered. So connection factory will *not* support load balancing
2011-07-18 09:30:18,354 INFO  [org.jboss.jms.server.connectionfactory.ConnectionFactory] (main) Connector bisocket://mi162831:4457 has leasing enabled, lease period 10000 milliseconds
2011-07-18 09:30:18,354 INFO  [org.jboss.jms.server.connectionfactory.ConnectionFactory] (main) org.jboss.jms.server.connectionfactory.ConnectionFactory@865ba9 started
2011-07-18 09:30:18,542 INFO  [org.jboss.resource.connectionmanager.ConnectionFactoryBindingService] (main) Bound ConnectionManager 'jboss.jca:service=ConnectionFactoryBinding,name=JmsXA' to JNDI name 'java:JmsXA'
2011-07-18 09:30:18,886 INFO  [org.jboss.ejb3.deployers.JBossASKernel] (main) Created KernelDeployment for: profileservice-secured.jar
2011-07-18 09:30:18,901 INFO  [org.jboss.ejb3.deployers.JBossASKernel] (main) installing bean: jboss.j2ee:jar=profileservice-secured.jar,name=SecureProfileService,service=EJB3
2011-07-18 09:30:18,901 INFO  [org.jboss.ejb3.deployers.JBossASKernel] (main)   with dependencies:
2011-07-18 09:30:18,901 INFO  [org.jboss.ejb3.deployers.JBossASKernel] (main)   and demands:
2011-07-18 09:30:18,901 INFO  [org.jboss.ejb3.deployers.JBossASKernel] (main)           jndi:SecureManagementView/remote-org.jboss.deployers.spi.management.ManagementView
2011-07-18 09:30:18,901 INFO  [org.jboss.ejb3.deployers.JBossASKernel] (main)           jboss.ejb:service=EJBTimerService
2011-07-18 09:30:18,901 INFO  [org.jboss.ejb3.deployers.JBossASKernel] (main)   and supplies:
2011-07-18 09:30:18,901 INFO  [org.jboss.ejb3.deployers.JBossASKernel] (main)           Class:org.jboss.profileservice.spi.ProfileService
2011-07-18 09:30:18,901 INFO  [org.jboss.ejb3.deployers.JBossASKernel] (main)           jndi:SecureProfileService/remote
2011-07-18 09:30:18,901 INFO  [org.jboss.ejb3.deployers.JBossASKernel] (main)           jndi:SecureProfileService/remote-org.jboss.profileservice.spi.ProfileService
2011-07-18 09:30:18,901 INFO  [org.jboss.ejb3.deployers.JBossASKernel] (main) Added bean(jboss.j2ee:jar=profileservice-secured.jar,name=SecureProfileService,service=EJB3) to KernelDeployment of: profileservice-secured.jar
2011-07-18 09:30:18,901 INFO  [org.jboss.ejb3.deployers.JBossASKernel] (main) installing bean: jboss.j2ee:jar=profileservice-secured.jar,name=SecureDeploymentManager,service=EJB3
2011-07-18 09:30:18,901 INFO  [org.jboss.ejb3.deployers.JBossASKernel] (main)   with dependencies:
2011-07-18 09:30:18,901 INFO  [org.jboss.ejb3.deployers.JBossASKernel] (main)   and demands:
2011-07-18 09:30:18,901 INFO  [org.jboss.ejb3.deployers.JBossASKernel] (main)           jboss.ejb:service=EJBTimerService
2011-07-18 09:30:18,901 INFO  [org.jboss.ejb3.deployers.JBossASKernel] (main)   and supplies:
2011-07-18 09:30:18,901 INFO  [org.jboss.ejb3.deployers.JBossASKernel] (main)           jndi:SecureDeploymentManager/remote-org.jboss.deployers.spi.management.deploy.DeploymentManager
2011-07-18 09:30:18,901 INFO  [org.jboss.ejb3.deployers.JBossASKernel] (main)           Class:org.jboss.deployers.spi.management.deploy.DeploymentManager
2011-07-18 09:30:18,901 INFO  [org.jboss.ejb3.deployers.JBossASKernel] (main)           jndi:SecureDeploymentManager/remote
2011-07-18 09:30:18,901 INFO  [org.jboss.ejb3.deployers.JBossASKernel] (main) Added bean(jboss.j2ee:jar=profileservice-secured.jar,name=SecureDeploymentManager,service=EJB3) to KernelDeployment of: profileservice-secured.jar
2011-07-18 09:30:18,901 INFO  [org.jboss.ejb3.deployers.JBossASKernel] (main) installing bean: jboss.j2ee:jar=profileservice-secured.jar,name=SecureManagementView,service=EJB3
2011-07-18 09:30:18,901 INFO  [org.jboss.ejb3.deployers.JBossASKernel] (main)   with dependencies:
2011-07-18 09:30:18,901 INFO  [org.jboss.ejb3.deployers.JBossASKernel] (main)   and demands:
2011-07-18 09:30:18,901 INFO  [org.jboss.ejb3.deployers.JBossASKernel] (main)           jboss.ejb:service=EJBTimerService
2011-07-18 09:30:18,901 INFO  [org.jboss.ejb3.deployers.JBossASKernel] (main)   and supplies:
2011-07-18 09:30:18,901 INFO  [org.jboss.ejb3.deployers.JBossASKernel] (main)           jndi:SecureManagementView/remote-org.jboss.deployers.spi.management.ManagementView
2011-07-18 09:30:18,901 INFO  [org.jboss.ejb3.deployers.JBossASKernel] (main)           Class:org.jboss.deployers.spi.management.ManagementView
2011-07-18 09:30:18,901 INFO  [org.jboss.ejb3.deployers.JBossASKernel] (main)           jndi:SecureManagementView/remote
2011-07-18 09:30:18,901 INFO  [org.jboss.ejb3.deployers.JBossASKernel] (main) Added bean(jboss.j2ee:jar=profileservice-secured.jar,name=SecureManagementView,service=EJB3) to KernelDeployment of: profileservice-secured.jar
2011-07-18 09:30:18,901 INFO  [org.jboss.ejb3.endpoint.deployers.EJB3EndpointDeployer] (main) Deploy AbstractBeanMetaData@1c514a7{name=jboss.j2ee:jar=profileservice-secured.jar,name=SecureProfileService,service=EJB3_endpoint bean=org.jboss.ejb3.endpoint.deployers.impl.EndpointImpl properties=[container] constructor=null autowireCandidate=true}
2011-07-18 09:30:18,901 INFO  [org.jboss.ejb3.endpoint.deployers.EJB3EndpointDeployer] (main) Deploy AbstractBeanMetaData@19ec220{name=jboss.j2ee:jar=profileservice-secured.jar,name=SecureDeploymentManager,service=EJB3_endpoint bean=org.jboss.ejb3.endpoint.deployers.impl.EndpointImpl properties=[container] constructor=null autowireCandidate=true}
2011-07-18 09:30:18,901 INFO  [org.jboss.ejb3.endpoint.deployers.EJB3EndpointDeployer] (main) Deploy AbstractBeanMetaData@1fa3d95{name=jboss.j2ee:jar=profileservice-secured.jar,name=SecureManagementView,service=EJB3_endpoint bean=org.jboss.ejb3.endpoint.deployers.impl.EndpointImpl properties=[container] constructor=null autowireCandidate=true}
2011-07-18 09:30:18,964 INFO  [org.jboss.ejb3.session.SessionSpecContainer] (main) Starting jboss.j2ee:jar=profileservice-secured.jar,name=SecureDeploymentManager,service=EJB3
2011-07-18 09:30:18,964 INFO  [org.jboss.ejb3.EJBContainer] (main) STARTED EJB: org.jboss.profileservice.ejb.SecureDeploymentManager ejbName: SecureDeploymentManager
2011-07-18 09:30:19,011 INFO  [org.jboss.ejb3.proxy.impl.jndiregistrar.JndiSessionRegistrarBase] (main) Binding the following Entries in Global JNDI:
 
 
          SecureDeploymentManager/remote - EJB3.x Default Remote Business Interface
          SecureDeploymentManager/remote-org.jboss.deployers.spi.management.deploy.DeploymentManager - EJB3.x Remote Business Interface
 
 
2011-07-18 09:30:19,058 INFO  [org.jboss.ejb3.session.SessionSpecContainer] (main) Starting jboss.j2ee:jar=profileservice-secured.jar,name=SecureManagementView,service=EJB3
2011-07-18 09:30:19,058 INFO  [org.jboss.ejb3.EJBContainer] (main) STARTED EJB: org.jboss.profileservice.ejb.SecureManagementView ejbName: SecureManagementView
2011-07-18 09:30:19,073 INFO  [org.jboss.ejb3.proxy.impl.jndiregistrar.JndiSessionRegistrarBase] (main) Binding the following Entries in Global JNDI:
 
 
          SecureManagementView/remote - EJB3.x Default Remote Business Interface
          SecureManagementView/remote-org.jboss.deployers.spi.management.ManagementView - EJB3.x Remote Business Interface
 
 
2011-07-18 09:30:19,089 INFO  [org.jboss.ejb3.session.SessionSpecContainer] (main) Starting jboss.j2ee:jar=profileservice-secured.jar,name=SecureProfileService,service=EJB3
2011-07-18 09:30:19,104 INFO  [org.jboss.ejb3.EJBContainer] (main) STARTED EJB: org.jboss.profileservice.ejb.SecureProfileServiceBean ejbName: SecureProfileService
2011-07-18 09:30:19,104 INFO  [org.jboss.ejb3.proxy.impl.jndiregistrar.JndiSessionRegistrarBase] (main) Binding the following Entries in Global JNDI:
 
 
          SecureProfileService/remote - EJB3.x Default Remote Business Interface
          SecureProfileService/remote-org.jboss.profileservice.spi.ProfileService - EJB3.x Remote Business Interface
 
 
2011-07-18 09:30:19,198 INFO  [org.jboss.web.tomcat.service.deployers.TomcatDeployment] (main) deploy, ctxPath=/admin-console
2011-07-18 09:30:19,261 INFO  [javax.enterprise.resource.webcontainer.jsf.config] (main) Initializing Mojarra (1.2_12-b01-FCS) for context '/admin-console'
2011-07-18 09:30:21,198 INFO  [org.jboss.web.tomcat.service.deployers.TomcatDeployment] (main) deploy, ctxPath=/
2011-07-18 09:30:21,308 INFO  [org.jboss.web.tomcat.service.deployers.TomcatDeployment] (main) deploy, ctxPath=/jmx-console
2011-07-18 09:30:41,902 INFO  [org.jboss.web.tomcat.service.deployers.TomcatDeployment] (main) deploy, ctxPath=/kitca
2011-07-18 09:30:42,105 ERROR [STDERR] (main) SLF4J: Class path contains multiple SLF4J bindings.
2011-07-18 09:30:42,105 ERROR [STDERR] (main) SLF4J: Found binding in [vfszip:/C:/jboss-5.1.0.GA/server/default/deploy/kitca.war/WEB-INF/lib/slf4j-log4j12-1.6.1.jar/org/slf4j/impl/StaticLoggerBinder.class]
2011-07-18 09:30:42,105 ERROR [STDERR] (main) SLF4J: Found binding in [vfszip:/C:/jboss-5.1.0.GA/common/lib/slf4j-jboss-logging.jar/org/slf4j/impl/StaticLoggerBinder.class]
2011-07-18 09:30:42,105 ERROR [STDERR] (main) SLF4J: Found binding in [vfszip:/C:/jboss-5.1.0.GA/server/default/deploy/kitca.war/WEB-INF/lib/logback-classic-0.9.24.jar/org/slf4j/impl/StaticLoggerBinder.class]
2011-07-18 09:30:42,105 ERROR [STDERR] (main) SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation.
2011-07-18 09:30:42,199 INFO  [org.apache.catalina.core.ContainerBase.[jboss.web].[localhost].[/kitca]] (main) Initializing Spring root WebApplicationContext
2011-07-18 09:30:42,199 INFO  [STDOUT] (main) 09:30:42.199 [main] INFO  o.s.web.context.ContextLoader - Root WebApplicationContext: initialization started
2011-07-18 09:30:42,230 INFO  [STDOUT] (main) 09:30:42.230 [main] INFO  o.s.w.c.s.XmlWebApplicationContext - Refreshing org.springframework.web.context.support.XmlWebApplicationContext@79e5e7: display name [Root WebApplicationContext]; startup date [Mon Jul 18 09:30:42 GMT-03:00 2011]; root of context hierarchy
2011-07-18 09:30:42,277 INFO  [STDOUT] (main) 09:30:42.277 [main] INFO  o.s.b.f.xml.XmlBeanDefinitionReader - Loading XML bean definitions from ServletContext resource [/WEB-INF/resources/applicationContext.xml]
2011-07-18 09:30:42,277 INFO  [STDOUT] (main) 09:30:42.277 [main] DEBUG o.s.b.f.xml.DefaultDocumentLoader - Using JAXP provider [org.apache.xerces.jaxp.DocumentBuilderFactoryImpl]
2011-07-18 09:30:42,277 INFO  [STDOUT] (main) 09:30:42.277 [main] DEBUG o.s.b.f.xml.PluggableSchemaResolver - Loading schema mappings from [META-INF/spring.schemas]
2011-07-18 09:30:42,277 INFO  [STDOUT] (main) 09:30:42.277 [main] DEBUG o.s.b.f.xml.PluggableSchemaResolver - Loaded schema mappings: {http://www.springframework.org/schema/lang/spring-lang-2.5.xsd=org/springframework/scripting/config/spring-lang-2.5.xsd, http://www.springframework.org/schema/lang/spring-lang.xsd=org/springframework/scripting/config/spring-lang-2.5.xsd, http://www.springframework.org/schema/context/spring-context-2.5.xsd=org/springframework/context/config/spring-context-2.5.xsd, http://www.springframework.org/schema/aop/spring-aop.xsd=org/springframework/aop/config/spring-aop-2.5.xsd, http://www.springframework.org/schema/context/spring-context.xsd=org/springframework/context/config/spring-context-2.5.xsd, http://www.springframework.org/schema/util/spring-util-2.0.xsd=org/springframework/beans/factory/xml/spring-util-2.0.xsd, http://www.springframework.org/schema/util/spring-util-2.5.xsd=org/springframework/beans/factory/xml/spring-util-2.5.xsd, http://www.springframework.org/schema/tool/spring-tool-2.0.xsd=org/springframework/beans/factory/xml/spring-tool-2.0.xsd, http://www.springframework.org/schema/tx/spring-tx-2.0.xsd=org/springframework/transaction/config/spring-tx-2.0.xsd, http://www.springframework.org/schema/beans/spring-beans-2.0.xsd=org/springframework/beans/factory/xml/spring-beans-2.0.xsd, http://www.springframework.org/schema/tool/spring-tool-2.5.xsd=org/springframework/beans/factory/xml/spring-tool-2.5.xsd, http://www.springframework.org/schema/tx/spring-tx-2.5.xsd=org/springframework/transaction/config/spring-tx-2.5.xsd, http://www.springframework.org/schema/beans/spring-beans-2.5.xsd=org/springframework/beans/factory/xml/spring-beans-2.5.xsd, http://www.springframework.org/schema/jee/spring-jee.xsd=org/springframework/ejb/config/spring-jee-2.5.xsd, http://www.springframework.org/schema/beans/spring-beans.xsd=org/springframework/beans/factory/xml/spring-beans-2.5.xsd, http://www.springframework.org/schema/tool/spring-tool.xsd=org/springframework/beans/factory/xml/spring-tool-2.5.xsd, http://www.springframework.org/schema/tx/spring-tx.xsd=org/springframework/transaction/config/spring-tx-2.5.xsd, http://www.springframework.org/schema/aop/spring-aop-2.0.xsd=org/springframework/aop/config/spring-aop-2.0.xsd, http://www.springframework.org/schema/jee/spring-jee-2.0.xsd=org/springframework/ejb/config/spring-jee-2.0.xsd, http://www.springframework.org/schema/aop/spring-aop-2.5.xsd=org/springframework/aop/config/spring-aop-2.5.xsd, http://www.springframework.org/schema/jee/spring-jee-2.5.xsd=org/springframework/ejb/config/spring-jee-2.5.xsd, http://www.springframework.org/schema/lang/spring-lang-2.0.xsd=org/springframework/scripting/config/spring-lang-2.0.xsd, http://www.springframework.org/schema/util/spring-util.xsd=org/springframework/beans/factory/xml/spring-util-2.5.xsd}
2011-07-18 09:30:42,277 INFO  [STDOUT] (main) 09:30:42.277 [main] DEBUG o.s.b.f.xml.PluggableSchemaResolver - Found XML schema [http://www.springframework.org/schema/beans/spring-beans-2.0.xsd] in classpath: org/springframework/beans/factory/xml/spring-beans-2.0.xsd
2011-07-18 09:30:42,292 INFO  [STDOUT] (main) 09:30:42.292 [main] DEBUG o.s.b.f.xml.PluggableSchemaResolver - Found XML schema [http://www.springframework.org/schema/tx/spring-tx-2.0.xsd] in classpath: org/springframework/transaction/config/spring-tx-2.0.xsd
2011-07-18 09:30:42,292 INFO  [STDOUT] (main) 09:30:42.292 [main] DEBUG o.s.b.f.xml.PluggableSchemaResolver - Found XML schema [http://www.springframework.org/schema/aop/spring-aop-2.0.xsd] in classpath: org/springframework/aop/config/spring-aop-2.0.xsd
2011-07-18 09:30:42,292 INFO  [STDOUT] (main) 09:30:42.292 [main] DEBUG o.s.b.f.x.DefaultBeanDefinitionDocumentReader - Loading bean definitions
2011-07-18 09:30:42,324 INFO  [STDOUT] (main) 09:30:42.324 [main] DEBUG o.s.b.f.x.DefaultNamespaceHandlerResolver - Loaded mappings [{http://www.springframework.org/schema/p=org.springframework.beans.factory.xml.SimplePropertyNamespaceHandler, http://www.springframework.org/schema/lang=org.springframework.scripting.config.LangNamespaceHandler, http://www.springframework.org/schema/jee=org.springframework.ejb.config.JeeNamespaceHandler, http://www.springframework.org/schema/aop=org.springframework.aop.config.AopNamespaceHandler, http://www.springframework.org/schema/util=org.springframework.beans.factory.xml.UtilNamespaceHandler, http://www.springframework.org/schema/tx=org.springframework.transaction.config.TxNamespaceHandler, http://www.springframework.org/schema/context=org.springframework.context.config.ContextNamespaceHandler}]
2011-07-18 09:30:42,386 INFO  [STDOUT] (main) 09:30:42.386 [main] DEBUG o.s.b.f.x.BeanDefinitionParserDelegate - Neither XML 'id' nor 'name' specified - using generated bean name [br.com.petrobras.framework.module.i18n.SpringLocaleStore#16352a5]
2011-07-18 09:30:42,386 INFO  [STDOUT] (main) 09:30:42.386 [main] DEBUG o.s.b.f.x.BeanDefinitionParserDelegate - Neither XML 'id' nor 'name' specified - using generated bean name [br.com.petrobras.framework.module.i18n.SimpleBundleNameStore#1c6e0c9]
2011-07-18 09:30:42,386 INFO  [STDOUT] (main) 09:30:42.386 [main] DEBUG o.s.b.f.x.BeanDefinitionParserDelegate - Neither XML 'id' nor 'name' specified - using generated bean name [java.util.Locale#12dab2]
2011-07-18 09:30:42,386 INFO  [STDOUT] (main) 09:30:42.386 [main] DEBUG o.s.b.f.xml.XmlBeanDefinitionReader - Loaded 25 bean definitions from location pattern [/WEB-INF/resources/applicationContext.xml]
2011-07-18 09:30:42,386 INFO  [STDOUT] (main) 09:30:42.386 [main] INFO  o.s.w.c.s.XmlWebApplicationContext - Bean factory for application context [org.springframework.web.context.support.XmlWebApplicationContext@79e5e7]: org.springframework.beans.factory.support.DefaultListableBeanFactory@1d3e355
2011-07-18 09:30:42,386 INFO  [STDOUT] (main) 09:30:42.386 [main] DEBUG o.s.w.c.s.XmlWebApplicationContext - 25 beans defined in org.springframework.web.context.support.XmlWebApplicationContext@79e5e7: display name [Root WebApplicationContext]; startup date [Mon Jul 18 09:30:42 GMT-03:00 2011]; root of context hierarchy
2011-07-18 09:30:42,433 INFO  [STDOUT] (main) 09:30:42.433 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating shared instance of singleton bean 'propertyConfigurer1'
2011-07-18 09:30:42,433 INFO  [STDOUT] (main) 09:30:42.433 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean 'propertyConfigurer1'
2011-07-18 09:30:42,449 INFO  [STDOUT] (main) 09:30:42.449 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Eagerly caching bean 'propertyConfigurer1' to allow for resolving potential circular references
2011-07-18 09:30:42,464 INFO  [STDOUT] (main) 09:30:42.464 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean 'propertyConfigurer1'
2011-07-18 09:30:42,464 INFO  [STDOUT] (main) 09:30:42.464 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating shared instance of singleton bean 'propertyConfigurer2'
2011-07-18 09:30:42,464 INFO  [STDOUT] (main) 09:30:42.464 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean 'propertyConfigurer2'
2011-07-18 09:30:42,464 INFO  [STDOUT] (main) 09:30:42.464 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Eagerly caching bean 'propertyConfigurer2' to allow for resolving potential circular references
2011-07-18 09:30:42,464 INFO  [STDOUT] (main) 09:30:42.464 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean 'propertyConfigurer2'
2011-07-18 09:30:42,464 INFO  [STDOUT] (main) 09:30:42.464 [main] INFO  o.s.b.f.c.PropertyPlaceholderConfigurer - Loading properties file from class path resource [kitca/config.properties]
2011-07-18 09:30:42,480 INFO  [STDOUT] (main) 09:30:42.480 [main] INFO  o.s.b.f.c.PropertyPlaceholderConfigurer - Loading properties file from class path resource [kitca/kitca.properties]
2011-07-18 09:30:42,480 INFO  [STDOUT] (main) 09:30:42.480 [main] INFO  o.s.b.f.c.PropertyPlaceholderConfigurer - Loading properties file from class path resource [kitca/acessocorp.properties]
2011-07-18 09:30:42,480 INFO  [STDOUT] (main) 09:30:42.480 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating shared instance of singleton bean 'org.springframework.aop.config.internalAutoProxyCreator'
2011-07-18 09:30:42,480 INFO  [STDOUT] (main) 09:30:42.480 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean 'org.springframework.aop.config.internalAutoProxyCreator'
2011-07-18 09:30:42,480 INFO  [STDOUT] (main) 09:30:42.480 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Eagerly caching bean 'org.springframework.aop.config.internalAutoProxyCreator' to allow for resolving potential circular references
2011-07-18 09:30:42,480 INFO  [STDOUT] (main) 09:30:42.480 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean 'org.springframework.aop.config.internalAutoProxyCreator'
2011-07-18 09:30:42,496 INFO  [STDOUT] (main) 09:30:42.496 [main] DEBUG o.s.w.c.s.XmlWebApplicationContext - Unable to locate MessageSource with name 'messageSource': using default [org.springframework.context.support.DelegatingMessageSource@7cbb68]
2011-07-18 09:30:42,496 INFO  [STDOUT] (main) 09:30:42.496 [main] DEBUG o.s.w.c.s.XmlWebApplicationContext - Unable to locate ApplicationEventMulticaster with name 'applicationEventMulticaster': using default [org.springframework.context.event.SimpleApplicationEventMulticaster@1f42872]
2011-07-18 09:30:42,496 INFO  [STDOUT] (main) 09:30:42.496 [main] DEBUG o.s.u.c.s.UiApplicationContextUtils - Unable to locate ThemeSource with name 'themeSource': using default [org.springframework.ui.context.support.ResourceBundleThemeSource@ed489f]
2011-07-18 09:30:42,496 INFO  [STDOUT] (main) 09:30:42.496 [main] INFO  o.s.b.f.s.DefaultListableBeanFactory - Pre-instantiating singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@1d3e355: defining beans [log4jInitialization,propertyConfigurer1,propertyConfigurer2,dataSource,sessionFactory,transactionManager,org.springframework.aop.config.internalAutoProxyCreator,org.springframework.transaction.annotation.AnnotationTransactionAttributeSource#0,org.springframework.transaction.interceptor.TransactionInterceptor#0,org.springframework.transaction.config.internalTransactionAdvisor,dao,securityServiceFactory,scopedTarget.dadosAutenticacao,dadosAutenticacao,i18nConfigurer,locale,baseService,acessoService,empresaService,ambienteService,sistemaService,securityInterceptor,exceptionInterceptor,delegationInterceptor,kitcaService]; root of factory hierarchy
2011-07-18 09:30:42,496 INFO  [STDOUT] (main) 09:30:42.496 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating shared instance of singleton bean 'log4jInitialization'
2011-07-18 09:30:42,496 INFO  [STDOUT] (main) 09:30:42.496 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean 'log4jInitialization'
2011-07-18 09:30:42,496 INFO  [STDOUT] (main) 09:30:42.496 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Eagerly caching bean 'log4jInitialization' to allow for resolving potential circular references
2011-07-18 09:30:42,511 INFO  [STDOUT] (main) 09:30:42.511 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Invoking afterPropertiesSet() on bean with name 'log4jInitialization'
2011-07-18 09:30:42,527 ERROR [STDERR] (main) log4j:ERROR A "org.jboss.logging.appender.FileAppender" object is not assignable to a "org.apache.log4j.Appender" variable.
2011-07-18 09:30:42,527 ERROR [STDERR] (main) log4j:ERROR The class "org.apache.log4j.Appender" was loaded by
2011-07-18 09:30:42,527 ERROR [STDERR] (main) log4j:ERROR [BaseClassLoader@1eac903{vfszip:/C:/jboss-5.1.0.GA/server/default/deploy/kitca.war/}] whereas object of type
2011-07-18 09:30:42,527 ERROR [STDERR] (main) log4j:ERROR "org.jboss.logging.appender.FileAppender" was loaded by [org.jboss.bootstrap.NoAnnotationURLClassLoader@b166b5].
2011-07-18 09:30:42,527 ERROR [STDERR] (main) log4j:ERROR Could not instantiate appender named "FILE".
2011-07-18 09:30:42,558 INFO  [STDOUT] (main) 09:30:42.558 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating shared instance of singleton bean 'org.springframework.transaction.config.internalTransactionAdvisor'
2011-07-18 09:30:42,558 INFO  [STDOUT] (main) 09:30:42.558 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean 'org.springframework.transaction.config.internalTransactionAdvisor'
2011-07-18 09:30:42,558 INFO  [STDOUT] (main) 09:30:42.558 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Eagerly caching bean 'org.springframework.transaction.config.internalTransactionAdvisor' to allow for resolving potential circular references
2011-07-18 09:30:42,558 INFO  [STDOUT] (main) 09:30:42.558 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating shared instance of singleton bean 'org.springframework.transaction.annotation.AnnotationTransactionAttributeSource#0'
2011-07-18 09:30:42,558 INFO  [STDOUT] (main) 09:30:42.558 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean 'org.springframework.transaction.annotation.AnnotationTransactionAttributeSource#0'
2011-07-18 09:30:42,558 INFO  [STDOUT] (main) 09:30:42.558 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Eagerly caching bean 'org.springframework.transaction.annotation.AnnotationTransactionAttributeSource#0' to allow for resolving potential circular references
2011-07-18 09:30:42,574 INFO  [STDOUT] (main) 09:30:42.574 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean 'org.springframework.transaction.annotation.AnnotationTransactionAttributeSource#0'
2011-07-18 09:30:42,574 INFO  [STDOUT] (main) 09:30:42.574 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean 'org.springframework.transaction.config.internalTransactionAdvisor'
2011-07-18 09:30:42,574 INFO  [STDOUT] (main) 09:30:42.574 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean 'log4jInitialization'
2011-07-18 09:30:42,574 INFO  [STDOUT] (main) 09:30:42.574 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'propertyConfigurer1'
2011-07-18 09:30:42,574 INFO  [STDOUT] (main) 09:30:42.574 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'propertyConfigurer2'
2011-07-18 09:30:42,574 INFO  [STDOUT] (main) 09:30:42.574 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating shared instance of singleton bean 'dataSource'
2011-07-18 09:30:42,574 INFO  [STDOUT] (main) 09:30:42.574 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean 'dataSource'
2011-07-18 09:30:42,574 INFO  [STDOUT] (main) 09:30:42.574 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Eagerly caching bean 'dataSource' to allow for resolving potential circular references
2011-07-18 09:30:42,574 INFO  [STDOUT] (main) 09:30:42.574 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Invoking afterPropertiesSet() on bean with name 'dataSource'
2011-07-18 09:30:42,574 INFO  [STDOUT] (main) 09:30:42.574 [main] DEBUG o.springframework.jndi.JndiTemplate - Looking up JNDI object with name [java:/MySqlCADS]
2011-07-18 09:30:42,574 INFO  [STDOUT] (main) 09:30:42.574 [main] DEBUG o.s.jndi.JndiObjectFactoryBean - Located object with JNDI name [java:/MySqlCADS]
2011-07-18 09:30:42,574 INFO  [STDOUT] (main) 09:30:42.574 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.transaction.config.internalTransactionAdvisor'
2011-07-18 09:30:42,574 INFO  [STDOUT] (main) 09:30:42.574 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean 'dataSource'
2011-07-18 09:30:42,574 INFO  [STDOUT] (main) 09:30:42.574 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating shared instance of singleton bean 'sessionFactory'
2011-07-18 09:30:42,574 INFO  [STDOUT] (main) 09:30:42.574 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean 'sessionFactory'
2011-07-18 09:30:42,605 INFO  [STDOUT] (main) 09:30:42.605 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Eagerly caching bean 'sessionFactory' to allow for resolving potential circular references
2011-07-18 09:30:42,621 INFO  [STDOUT] (main) 09:30:42.621 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'dataSource'
2011-07-18 09:30:42,621 INFO  [STDOUT] (main) 09:30:42.621 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.transaction.config.internalTransactionAdvisor'
2011-07-18 09:30:42,621 INFO  [STDOUT] (main) 09:30:42.621 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Invoking afterPropertiesSet() on bean with name 'sessionFactory'
2011-07-18 09:30:42,636 INFO  [org.hibernate.cfg.annotations.Version] (main) Hibernate Annotations 3.4.0.GA
2011-07-18 09:30:42,652 INFO  [org.hibernate.cfg.Environment] (main) Hibernate 3.3.1.GA
2011-07-18 09:30:42,652 INFO  [org.hibernate.cfg.Environment] (main) hibernate.properties not found
2011-07-18 09:30:42,652 INFO  [org.hibernate.cfg.Environment] (main) Bytecode provider name : javassist
2011-07-18 09:30:42,652 INFO  [org.hibernate.cfg.Environment] (main) using JDK 1.4 java.sql.Timestamp handling
2011-07-18 09:30:43,371 INFO  [org.hibernate.annotations.common.Version] (main) Hibernate Commons Annotations 3.1.0.GA
2011-07-18 09:30:43,433 INFO  [STDOUT] (main) 09:30:43.433 [main] INFO  o.s.o.h.a.AnnotationSessionFactoryBean - Building new Hibernate SessionFactory
2011-07-18 09:30:43,433 INFO  [org.hibernate.cfg.search.HibernateSearchEventListenerRegister] (main) Unable to find org.hibernate.search.event.FullTextIndexEventListener on the classpath. Hibernate Search is not enabled.
2011-07-18 09:30:43,433 INFO  [org.hibernate.connection.ConnectionProviderFactory] (main) Initializing connection provider: org.springframework.orm.hibernate3.LocalDataSourceConnectionProvider
2011-07-18 09:30:43,652 INFO  [org.hibernate.cfg.SettingsFactory] (main) RDBMS: MySQL, version: 5.5.14
2011-07-18 09:30:43,652 INFO  [org.hibernate.cfg.SettingsFactory] (main) JDBC driver: MySQL-AB JDBC Driver, version: mysql-connector-java-5.1.16 ( Revision: ${bzr.revision-id} )
2011-07-18 09:30:43,667 INFO  [org.hibernate.dialect.Dialect] (main) Using dialect: org.hibernate.dialect.MySQLDialect
2011-07-18 09:30:43,714 INFO  [org.hibernate.transaction.TransactionFactoryFactory] (main) Transaction strategy: org.springframework.orm.hibernate3.SpringTransactionFactory
2011-07-18 09:30:43,714 INFO  [org.hibernate.transaction.TransactionManagerLookupFactory] (main) No TransactionManagerLookup configured (in JTA environment, use of read-write or transactional second-level cache is not recommended)
2011-07-18 09:30:43,714 INFO  [org.hibernate.cfg.SettingsFactory] (main) Automatic flush during beforeCompletion(): disabled
2011-07-18 09:30:43,714 INFO  [org.hibernate.cfg.SettingsFactory] (main) Automatic session close at end of transaction: disabled
2011-07-18 09:30:43,714 INFO  [org.hibernate.cfg.SettingsFactory] (main) JDBC batch size: 15
2011-07-18 09:30:43,714 INFO  [org.hibernate.cfg.SettingsFactory] (main) JDBC batch updates for versioned data: disabled
2011-07-18 09:30:43,714 INFO  [org.hibernate.cfg.SettingsFactory] (main) Scrollable result sets: enabled
2011-07-18 09:30:43,714 INFO  [org.hibernate.cfg.SettingsFactory] (main) JDBC3 getGeneratedKeys(): enabled
2011-07-18 09:30:43,714 INFO  [org.hibernate.cfg.SettingsFactory] (main) Connection release mode: auto
2011-07-18 09:30:43,714 INFO  [org.hibernate.cfg.SettingsFactory] (main) Maximum outer join fetch depth: 1
2011-07-18 09:30:43,714 INFO  [org.hibernate.cfg.SettingsFactory] (main) Default batch fetch size: 1
2011-07-18 09:30:43,714 INFO  [org.hibernate.cfg.SettingsFactory] (main) Generate SQL with comments: disabled
2011-07-18 09:30:43,714 INFO  [org.hibernate.cfg.SettingsFactory] (main) Order SQL updates by primary key: disabled
2011-07-18 09:30:43,714 INFO  [org.hibernate.cfg.SettingsFactory] (main) Order SQL inserts for batching: disabled
2011-07-18 09:30:43,714 INFO  [org.hibernate.cfg.SettingsFactory] (main) Query translator: org.hibernate.hql.ast.ASTQueryTranslatorFactory
2011-07-18 09:30:43,714 INFO  [org.hibernate.hql.ast.ASTQueryTranslatorFactory] (main) Using ASTQueryTranslatorFactory
2011-07-18 09:30:43,714 INFO  [org.hibernate.cfg.SettingsFactory] (main) Query language substitutions: {}
2011-07-18 09:30:43,714 INFO  [org.hibernate.cfg.SettingsFactory] (main) JPA-QL strict compliance: disabled
2011-07-18 09:30:43,714 INFO  [org.hibernate.cfg.SettingsFactory] (main) Second-level cache: enabled
2011-07-18 09:30:43,714 INFO  [org.hibernate.cfg.SettingsFactory] (main) Query cache: disabled
2011-07-18 09:30:43,730 INFO  [org.hibernate.cfg.SettingsFactory] (main) Cache region factory : org.hibernate.cache.impl.bridge.RegionFactoryCacheProviderBridge
2011-07-18 09:30:43,730 INFO  [org.hibernate.cache.impl.bridge.RegionFactoryCacheProviderBridge] (main) Cache provider: org.hibernate.cache.NoCacheProvider
2011-07-18 09:30:43,730 INFO  [org.hibernate.cfg.SettingsFactory] (main) Optimize cache for minimal puts: disabled
2011-07-18 09:30:43,730 INFO  [org.hibernate.cfg.SettingsFactory] (main) Structured second-level cache entries: disabled
2011-07-18 09:30:43,730 INFO  [org.hibernate.cfg.SettingsFactory] (main) Statistics: disabled
2011-07-18 09:30:43,730 INFO  [org.hibernate.cfg.SettingsFactory] (main) Deleted entity synthetic identifier rollback: disabled
2011-07-18 09:30:43,730 INFO  [org.hibernate.cfg.SettingsFactory] (main) Default entity-mode: pojo
2011-07-18 09:30:43,730 INFO  [org.hibernate.cfg.SettingsFactory] (main) Named query checking : enabled
2011-07-18 09:30:43,777 INFO  [org.hibernate.impl.SessionFactoryImpl] (main) building session factory
2011-07-18 09:30:43,777 INFO  [org.hibernate.impl.SessionFactoryObjectFactory] (main) Not binding factory to JNDI, no JNDI name configured
2011-07-18 09:30:43,777 INFO  [STDOUT] (main) 09:30:43.777 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.transaction.config.internalTransactionAdvisor'
2011-07-18 09:30:43,792 INFO  [STDOUT] (main) 09:30:43.792 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean 'sessionFactory'
2011-07-18 09:30:43,792 INFO  [STDOUT] (main) 09:30:43.792 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating shared instance of singleton bean 'transactionManager'
2011-07-18 09:30:43,792 INFO  [STDOUT] (main) 09:30:43.792 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean 'transactionManager'
2011-07-18 09:30:43,792 INFO  [STDOUT] (main) 09:30:43.792 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Eagerly caching bean 'transactionManager' to allow for resolving potential circular references
2011-07-18 09:30:43,792 INFO  [STDOUT] (main) 09:30:43.792 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'sessionFactory'
2011-07-18 09:30:43,792 INFO  [STDOUT] (main) 09:30:43.792 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.transaction.config.internalTransactionAdvisor'
2011-07-18 09:30:43,808 INFO  [STDOUT] (main) 09:30:43.808 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Invoking afterPropertiesSet() on bean with name 'transactionManager'
2011-07-18 09:30:43,808 INFO  [STDOUT] (main) 09:30:43.808 [main] INFO  o.s.o.h.HibernateTransactionManager - Using DataSource [org.jboss.resource.adapter.jdbc.WrapperDataSource@c71fda] of Hibernate SessionFactory for HibernateTransactionManager
2011-07-18 09:30:43,808 INFO  [STDOUT] (main) 09:30:43.808 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.transaction.config.internalTransactionAdvisor'
2011-07-18 09:30:43,808 INFO  [STDOUT] (main) 09:30:43.808 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean 'transactionManager'
2011-07-18 09:30:43,808 INFO  [STDOUT] (main) 09:30:43.808 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.aop.config.internalAutoProxyCreator'
2011-07-18 09:30:43,808 INFO  [STDOUT] (main) 09:30:43.808 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.transaction.annotation.AnnotationTransactionAttributeSource#0'
2011-07-18 09:30:43,808 INFO  [STDOUT] (main) 09:30:43.808 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating shared instance of singleton bean 'org.springframework.transaction.interceptor.TransactionInterceptor#0'
2011-07-18 09:30:43,824 INFO  [STDOUT] (main) 09:30:43.808 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean 'org.springframework.transaction.interceptor.TransactionInterceptor#0'
2011-07-18 09:30:43,824 INFO  [STDOUT] (main) 09:30:43.824 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Eagerly caching bean 'org.springframework.transaction.interceptor.TransactionInterceptor#0' to allow for resolving potential circular references
2011-07-18 09:30:43,824 INFO  [STDOUT] (main) 09:30:43.824 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'transactionManager'
2011-07-18 09:30:43,824 INFO  [STDOUT] (main) 09:30:43.824 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.transaction.annotation.AnnotationTransactionAttributeSource#0'
2011-07-18 09:30:43,824 INFO  [STDOUT] (main) 09:30:43.824 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Invoking afterPropertiesSet() on bean with name 'org.springframework.transaction.interceptor.TransactionInterceptor#0'
2011-07-18 09:30:43,824 INFO  [STDOUT] (main) 09:30:43.824 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean 'org.springframework.transaction.interceptor.TransactionInterceptor#0'
2011-07-18 09:30:43,824 INFO  [STDOUT] (main) 09:30:43.824 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.transaction.config.internalTransactionAdvisor'
2011-07-18 09:30:43,824 INFO  [STDOUT] (main) 09:30:43.824 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating shared instance of singleton bean 'dao'
2011-07-18 09:30:43,824 INFO  [STDOUT] (main) 09:30:43.824 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean 'dao'
2011-07-18 09:30:43,824 INFO  [STDOUT] (main) 09:30:43.824 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Eagerly caching bean 'dao' to allow for resolving potential circular references
2011-07-18 09:30:43,824 INFO  [STDOUT] (main) 09:30:43.824 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'sessionFactory'
2011-07-18 09:30:43,824 INFO  [STDOUT] (main) 09:30:43.824 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'transactionManager'
2011-07-18 09:30:43,824 INFO  [STDOUT] (main) 09:30:43.824 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.transaction.config.internalTransactionAdvisor'
2011-07-18 09:30:43,824 INFO  [STDOUT] (main) 09:30:43.824 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean 'dao'
2011-07-18 09:30:43,824 INFO  [STDOUT] (main) 09:30:43.824 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating shared instance of singleton bean 'securityServiceFactory'
2011-07-18 09:30:43,824 INFO  [STDOUT] (main) 09:30:43.824 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean 'securityServiceFactory'
2011-07-18 09:30:43,824 INFO  [STDOUT] (main) 09:30:43.824 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Eagerly caching bean 'securityServiceFactory' to allow for resolving potential circular references
2011-07-18 09:30:43,824 INFO  [STDOUT] (main) 09:30:43.824 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.transaction.config.internalTransactionAdvisor'
2011-07-18 09:30:43,839 INFO  [STDOUT] (main) 09:30:43.839 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean 'securityServiceFactory'
2011-07-18 09:30:43,839 INFO  [STDOUT] (main) 09:30:43.839 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating shared instance of singleton bean 'dadosAutenticacao'
2011-07-18 09:30:43,839 INFO  [STDOUT] (main) 09:30:43.839 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean 'dadosAutenticacao'
2011-07-18 09:30:43,839 INFO  [STDOUT] (main) 09:30:43.839 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Eagerly caching bean 'dadosAutenticacao' to allow for resolving potential circular references
2011-07-18 09:30:43,855 INFO  [STDOUT] (main) 09:30:43.855 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Creating CGLIB2 proxy: target source is SimpleBeanTargetSource for target bean 'scopedTarget.dadosAutenticacao' of type [br.com.petrobras.snarf.common.security.DefaultAuthenticationData]
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Unable to apply any optimisations to advised method: public java.lang.Object br.com.petrobras.snarf.common.security.DefaultAuthenticationData.get(java.lang.String)
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Unable to apply any optimisations to advised method: public java.lang.String br.com.petrobras.snarf.common.security.DefaultAuthenticationData.toString()
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Unable to apply any optimisations to advised method: public java.lang.Object br.com.petrobras.snarf.common.security.DefaultAuthenticationData.clone() throws java.lang.CloneNotSupportedException
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Unable to apply any optimisations to advised method: public br.com.petrobras.snarf.common.security.AuthenticationData br.com.petrobras.snarf.common.security.DefaultAuthenticationData.clone()
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Unable to apply any optimisations to advised method: public void br.com.petrobras.snarf.common.security.DefaultAuthenticationData.store(java.lang.String,java.lang.Object)
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Unable to apply any optimisations to advised method: public java.lang.String br.com.petrobras.snarf.common.security.DefaultAuthenticationData.getUsername()
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Unable to apply any optimisations to advised method: public void br.com.petrobras.snarf.common.security.DefaultAuthenticationData.setUsername(java.lang.String)
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Unable to apply any optimisations to advised method: public boolean br.com.petrobras.snarf.common.security.DefaultAuthenticationData.isAuthenticated()
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Unable to apply any optimisations to advised method: public void br.com.petrobras.snarf.common.security.DefaultAuthenticationData.clearAllData()
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Unable to apply any optimisations to advised method: public java.util.Set br.com.petrobras.snarf.common.security.DefaultAuthenticationData.getSecurityObjects()
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Unable to apply any optimisations to advised method: public void br.com.petrobras.snarf.common.security.DefaultAuthenticationData.addSecurityObject(java.lang.String)
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Unable to apply any optimisations to advised method: public boolean br.com.petrobras.snarf.common.security.DefaultAuthenticationData.verifyAnyObject(java.util.Collection)
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Unable to apply any optimisations to advised method: public boolean br.com.petrobras.snarf.common.security.DefaultAuthenticationData.verifyObject(java.lang.String)
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Found finalize() method - using NO_OVERRIDE
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Found 'equals' method: public boolean java.lang.Object.equals(java.lang.Object)
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Found 'hashCode' method: public native int java.lang.Object.hashCode()
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Unable to apply any optimisations to advised method: public abstract java.lang.Object org.springframework.aop.scope.ScopedObject.getTargetObject()
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Unable to apply any optimisations to advised method: public abstract void org.springframework.aop.scope.ScopedObject.removeFromScope()
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Method is declared on Advised interface: public abstract int org.springframework.aop.framework.Advised.indexOf(org.aopalliance.aop.Advice)
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Method is declared on Advised interface: public abstract int org.springframework.aop.framework.Advised.indexOf(org.springframework.aop.Advisor)
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Method is declared on Advised interface: public abstract boolean org.springframework.aop.framework.Advised.isFrozen()
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Method is declared on Advised interface: public abstract org.springframework.aop.Advisor[] org.springframework.aop.framework.Advised.getAdvisors()
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Method is declared on Advised interface: public abstract void org.springframework.aop.framework.Advised.addAdvisor(org.springframework.aop.Advisor) throws org.springframework.aop.framework.AopConfigException
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Method is declared on Advised interface: public abstract void org.springframework.aop.framework.Advised.addAdvisor(int,org.springframework.aop.Advisor) throws org.springframework.aop.framework.AopConfigException
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Method is declared on Advised interface: public abstract boolean org.springframework.aop.framework.Advised.removeAdvisor(org.springframework.aop.Advisor)
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Method is declared on Advised interface: public abstract void org.springframework.aop.framework.Advised.removeAdvisor(int) throws org.springframework.aop.framework.AopConfigException
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Method is declared on Advised interface: public abstract org.springframework.aop.TargetSource org.springframework.aop.framework.Advised.getTargetSource()
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Method is declared on Advised interface: public abstract void org.springframework.aop.framework.Advised.setTargetSource(org.springframework.aop.TargetSource)
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Method is declared on Advised interface: public abstract void org.springframework.aop.framework.Advised.setPreFiltered(boolean)
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Method is declared on Advised interface: public abstract boolean org.springframework.aop.framework.Advised.isProxyTargetClass()
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Method is declared on Advised interface: public abstract void org.springframework.aop.framework.Advised.setExposeProxy(boolean)
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Method is declared on Advised interface: public abstract boolean org.springframework.aop.framework.Advised.isExposeProxy()
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Method is declared on Advised interface: public abstract void org.springframework.aop.framework.Advised.addAdvice(int,org.aopalliance.aop.Advice) throws org.springframework.aop.framework.AopConfigException
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Method is declared on Advised interface: public abstract void org.springframework.aop.framework.Advised.addAdvice(org.aopalliance.aop.Advice) throws org.springframework.aop.framework.AopConfigException
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Method is declared on Advised interface: public abstract java.lang.Class[] org.springframework.aop.framework.Advised.getProxiedInterfaces()
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Method is declared on Advised interface: public abstract boolean org.springframework.aop.framework.Advised.isPreFiltered()
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Method is declared on Advised interface: public abstract boolean org.springframework.aop.framework.Advised.isInterfaceProxied(java.lang.Class)
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Method is declared on Advised interface: public abstract boolean org.springframework.aop.framework.Advised.replaceAdvisor(org.springframework.aop.Advisor,org.springframework.aop.Advisor) throws org.springframework.aop.framework.AopConfigException
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Method is declared on Advised interface: public abstract boolean org.springframework.aop.framework.Advised.removeAdvice(org.aopalliance.aop.Advice)
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Method is declared on Advised interface: public abstract java.lang.String org.springframework.aop.framework.Advised.toProxyConfigString()
2011-07-18 09:30:43,917 INFO  [STDOUT] (main) 09:30:43.917 [main] DEBUG o.s.aop.framework.Cglib2AopProxy - Method is declared on Advised interface: public abstract java.lang.Class org.springframework.aop.TargetClassAware.getTargetClass()
2011-07-18 09:30:43,980 INFO  [STDOUT] (main) 09:30:43.980 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.transaction.config.internalTransactionAdvisor'
2011-07-18 09:30:43,980 INFO  [STDOUT] (main) 09:30:43.980 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean 'dadosAutenticacao'
2011-07-18 09:30:43,980 INFO  [STDOUT] (main) 09:30:43.980 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating shared instance of singleton bean 'i18nConfigurer'
2011-07-18 09:30:43,980 INFO  [STDOUT] (main) 09:30:43.980 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean 'i18nConfigurer'
2011-07-18 09:30:43,980 INFO  [STDOUT] (main) 09:30:43.980 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Eagerly caching bean 'i18nConfigurer' to allow for resolving potential circular references
2011-07-18 09:30:43,980 INFO  [STDOUT] (main) 09:30:43.980 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean 'br.com.petrobras.framework.module.i18n.SpringLocaleStore#16352a5'
2011-07-18 09:30:43,980 INFO  [STDOUT] (main) 09:30:43.980 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.transaction.config.internalTransactionAdvisor'
2011-07-18 09:30:43,980 INFO  [STDOUT] (main) 09:30:43.980 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean 'br.com.petrobras.framework.module.i18n.SpringLocaleStore#16352a5'
2011-07-18 09:30:43,980 INFO  [STDOUT] (main) 09:30:43.980 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean 'br.com.petrobras.framework.module.i18n.SimpleBundleNameStore#1c6e0c9'
2011-07-18 09:30:43,980 INFO  [STDOUT] (main) 09:30:43.980 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.transaction.config.internalTransactionAdvisor'
2011-07-18 09:30:43,980 INFO  [STDOUT] (main) 09:30:43.980 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean 'br.com.petrobras.framework.module.i18n.SimpleBundleNameStore#1c6e0c9'
2011-07-18 09:30:43,996 INFO  [STDOUT] (main) 09:30:43.996 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.transaction.config.internalTransactionAdvisor'
2011-07-18 09:30:43,996 INFO  [STDOUT] (main) 09:30:43.996 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean 'i18nConfigurer'
2011-07-18 09:30:43,996 INFO  [STDOUT] (main) 09:30:43.996 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating shared instance of singleton bean 'acessoService'
2011-07-18 09:30:43,996 INFO  [STDOUT] (main) 09:30:43.996 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean 'acessoService'
2011-07-18 09:30:43,996 INFO  [STDOUT] (main) 09:30:43.996 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Eagerly caching bean 'acessoService' to allow for resolving potential circular references
2011-07-18 09:30:43,996 INFO  [STDOUT] (main) 09:30:43.996 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'dadosAutenticacao'
2011-07-18 09:30:43,996 INFO  [STDOUT] (main) 09:30:43.996 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'dao'
2011-07-18 09:30:43,996 INFO  [STDOUT] (main) 09:30:43.996 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'securityServiceFactory'
2011-07-18 09:30:43,996 INFO  [STDOUT] (main) 09:30:43.996 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.transaction.config.internalTransactionAdvisor'
2011-07-18 09:30:43,996 INFO  [STDOUT] (main) 09:30:43.996 [main] DEBUG o.s.t.a.AnnotationTransactionAttributeSource - Adding transactional method [logon] with attribute [PROPAGATION_REQUIRED,ISOLATION_DEFAULT]
2011-07-18 09:30:43,996 INFO  [STDOUT] (main) 09:30:43.996 [main] DEBUG o.s.a.f.a.InfrastructureAdvisorAutoProxyCreator - Creating implicit proxy for bean 'acessoService' with 0 common interceptors and 1 specific interceptors
2011-07-18 09:30:43,996 INFO  [STDOUT] (main) 09:30:43.996 [main] DEBUG o.s.aop.framework.JdkDynamicAopProxy - Creating JDK dynamic proxy: target source is SingletonTargetSource for target object [br.com.tito.kitca.service.business.AcessoServiceImpl@ccecbb]
2011-07-18 09:30:43,996 INFO  [STDOUT] (main) 09:30:43.996 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean 'acessoService'
2011-07-18 09:30:43,996 INFO  [STDOUT] (main) 09:30:43.996 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating shared instance of singleton bean 'empresaService'
2011-07-18 09:30:43,996 INFO  [STDOUT] (main) 09:30:43.996 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean 'empresaService'
2011-07-18 09:30:43,996 INFO  [STDOUT] (main) 09:30:43.996 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Eagerly caching bean 'empresaService' to allow for resolving potential circular references
2011-07-18 09:30:44,011 INFO  [STDOUT] (main) 09:30:44.011 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'dadosAutenticacao'
2011-07-18 09:30:44,011 INFO  [STDOUT] (main) 09:30:44.011 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'dao'
2011-07-18 09:30:44,011 INFO  [STDOUT] (main) 09:30:44.011 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'securityServiceFactory'
2011-07-18 09:30:44,011 INFO  [STDOUT] (main) 09:30:44.011 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.transaction.config.internalTransactionAdvisor'
2011-07-18 09:30:44,011 INFO  [STDOUT] (main) 09:30:44.011 [main] DEBUG o.s.t.a.AnnotationTransactionAttributeSource - Adding transactional method [salvarEmpresa] with attribute [PROPAGATION_REQUIRED,ISOLATION_DEFAULT]
2011-07-18 09:30:44,011 INFO  [STDOUT] (main) 09:30:44.011 [main] DEBUG o.s.a.f.a.InfrastructureAdvisorAutoProxyCreator - Creating implicit proxy for bean 'empresaService' with 0 common interceptors and 1 specific interceptors
2011-07-18 09:30:44,011 INFO  [STDOUT] (main) 09:30:44.011 [main] DEBUG o.s.aop.framework.JdkDynamicAopProxy - Creating JDK dynamic proxy: target source is SingletonTargetSource for target object [br.com.tito.kitca.service.business.EmpresaServiceImpl@d7606]
2011-07-18 09:30:44,027 INFO  [STDOUT] (main) 09:30:44.027 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean 'empresaService'
2011-07-18 09:30:44,027 INFO  [STDOUT] (main) 09:30:44.027 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating shared instance of singleton bean 'ambienteService'
2011-07-18 09:30:44,027 INFO  [STDOUT] (main) 09:30:44.027 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean 'ambienteService'
2011-07-18 09:30:44,027 INFO  [STDOUT] (main) 09:30:44.027 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Eagerly caching bean 'ambienteService' to allow for resolving potential circular references
2011-07-18 09:30:44,027 INFO  [STDOUT] (main) 09:30:44.027 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'dadosAutenticacao'
2011-07-18 09:30:44,027 INFO  [STDOUT] (main) 09:30:44.027 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'dao'
2011-07-18 09:30:44,027 INFO  [STDOUT] (main) 09:30:44.027 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'securityServiceFactory'
2011-07-18 09:30:44,027 INFO  [STDOUT] (main) 09:30:44.027 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.transaction.config.internalTransactionAdvisor'
2011-07-18 09:30:44,027 INFO  [STDOUT] (main) 09:30:44.027 [main] DEBUG o.s.t.a.AnnotationTransactionAttributeSource - Adding transactional method [salvarAmbiente] with attribute [PROPAGATION_REQUIRED,ISOLATION_DEFAULT]
2011-07-18 09:30:44,027 INFO  [STDOUT] (main) 09:30:44.027 [main] DEBUG o.s.a.f.a.InfrastructureAdvisorAutoProxyCreator - Creating implicit proxy for bean 'ambienteService' with 0 common interceptors and 1 specific interceptors
2011-07-18 09:30:44,027 INFO  [STDOUT] (main) 09:30:44.027 [main] DEBUG o.s.aop.framework.JdkDynamicAopProxy - Creating JDK dynamic proxy: target source is SingletonTargetSource for target object [br.com.tito.kitca.service.business.AmbienteServiceImpl@de38]
2011-07-18 09:30:44,027 INFO  [STDOUT] (main) 09:30:44.027 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean 'ambienteService'
2011-07-18 09:30:44,027 INFO  [STDOUT] (main) 09:30:44.027 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating shared instance of singleton bean 'sistemaService'
2011-07-18 09:30:44,027 INFO  [STDOUT] (main) 09:30:44.027 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean 'sistemaService'
2011-07-18 09:30:44,027 INFO  [STDOUT] (main) 09:30:44.027 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Eagerly caching bean 'sistemaService' to allow for resolving potential circular references
2011-07-18 09:30:44,027 INFO  [STDOUT] (main) 09:30:44.027 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'dadosAutenticacao'
2011-07-18 09:30:44,027 INFO  [STDOUT] (main) 09:30:44.027 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'dao'
2011-07-18 09:30:44,027 INFO  [STDOUT] (main) 09:30:44.027 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'securityServiceFactory'
2011-07-18 09:30:44,027 INFO  [STDOUT] (main) 09:30:44.027 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.transaction.config.internalTransactionAdvisor'
2011-07-18 09:30:44,027 INFO  [STDOUT] (main) 09:30:44.027 [main] DEBUG o.s.t.a.AnnotationTransactionAttributeSource - Adding transactional method [salvarSistema] with attribute [PROPAGATION_REQUIRED,ISOLATION_DEFAULT]
2011-07-18 09:30:44,027 INFO  [STDOUT] (main) 09:30:44.027 [main] DEBUG o.s.a.f.a.InfrastructureAdvisorAutoProxyCreator - Creating implicit proxy for bean 'sistemaService' with 0 common interceptors and 1 specific interceptors
2011-07-18 09:30:44,027 INFO  [STDOUT] (main) 09:30:44.027 [main] DEBUG o.s.aop.framework.JdkDynamicAopProxy - Creating JDK dynamic proxy: target source is SingletonTargetSource for target object [br.com.tito.kitca.service.business.SistemaServiceImpl@1bc0e73]
2011-07-18 09:30:44,042 INFO  [STDOUT] (main) 09:30:44.042 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean 'sistemaService'
2011-07-18 09:30:44,042 INFO  [STDOUT] (main) 09:30:44.042 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating shared instance of singleton bean 'securityInterceptor'
2011-07-18 09:30:44,042 INFO  [STDOUT] (main) 09:30:44.042 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean 'securityInterceptor'
2011-07-18 09:30:44,042 INFO  [STDOUT] (main) 09:30:44.042 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Eagerly caching bean 'securityInterceptor' to allow for resolving potential circular references
2011-07-18 09:30:44,042 INFO  [STDOUT] (main) 09:30:44.042 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'dadosAutenticacao'
2011-07-18 09:30:44,042 INFO  [STDOUT] (main) 09:30:44.042 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean 'securityInterceptor'
2011-07-18 09:30:44,042 INFO  [STDOUT] (main) 09:30:44.042 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating shared instance of singleton bean 'exceptionInterceptor'
2011-07-18 09:30:44,042 INFO  [STDOUT] (main) 09:30:44.042 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean 'exceptionInterceptor'
2011-07-18 09:30:44,042 INFO  [STDOUT] (main) 09:30:44.042 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Eagerly caching bean 'exceptionInterceptor' to allow for resolving potential circular references
2011-07-18 09:30:44,042 INFO  [STDOUT] (main) 09:30:44.042 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean 'exceptionInterceptor'
2011-07-18 09:30:44,042 INFO  [STDOUT] (main) 09:30:44.042 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating shared instance of singleton bean 'delegationInterceptor'
2011-07-18 09:30:44,042 INFO  [STDOUT] (main) 09:30:44.042 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean 'delegationInterceptor'
2011-07-18 09:30:44,042 INFO  [STDOUT] (main) 09:30:44.042 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Eagerly caching bean 'delegationInterceptor' to allow for resolving potential circular references
2011-07-18 09:30:44,042 INFO  [STDOUT] (main) 09:30:44.042 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating shared instance of singleton bean 'kitcaService'
2011-07-18 09:30:44,042 INFO  [STDOUT] (main) 09:30:44.042 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean 'kitcaService'
2011-07-18 09:30:44,042 INFO  [STDOUT] (main) 09:30:44.042 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Eagerly caching bean 'kitcaService' to allow for resolving potential circular references
2011-07-18 09:30:44,058 INFO  [STDOUT] (main) 09:30:44.058 [main] DEBUG o.s.aop.framework.ProxyFactoryBean - Advice has changed; recaching singleton instance
2011-07-18 09:30:44,058 INFO  [STDOUT] (main) 09:30:44.058 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.transaction.config.internalTransactionAdvisor'
2011-07-18 09:30:44,058 INFO  [STDOUT] (main) 09:30:44.058 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean 'kitcaService'
2011-07-18 09:30:44,058 INFO  [STDOUT] (main) 09:30:44.058 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'acessoService'
2011-07-18 09:30:44,058 INFO  [STDOUT] (main) 09:30:44.058 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'empresaService'
2011-07-18 09:30:44,058 INFO  [STDOUT] (main) 09:30:44.058 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'ambienteService'
2011-07-18 09:30:44,058 INFO  [STDOUT] (main) 09:30:44.058 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'sistemaService'
2011-07-18 09:30:44,058 INFO  [STDOUT] (main) 09:30:44.058 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean 'delegationInterceptor'
2011-07-18 09:30:44,058 INFO  [STDOUT] (main) 09:30:44.058 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'kitcaService'
2011-07-18 09:30:44,058 INFO  [STDOUT] (main) 09:30:44.058 [main] DEBUG o.s.web.context.ContextLoader - Published root WebApplicationContext as ServletContext attribute with name [org.springframework.web.context.WebApplicationContext.ROOT]
2011-07-18 09:30:44,058 INFO  [STDOUT] (main) 09:30:44.058 [main] INFO  o.s.web.context.ContextLoader - Root WebApplicationContext: initialization completed in 1859 ms
2011-07-18 09:30:44,074 INFO  [STDOUT] (main) 09:30:44.074 [main] DEBUG o.s.web.servlet.DispatcherServlet - Initializing servlet 'remoting'
2011-07-18 09:30:44,089 INFO  [org.apache.catalina.core.ContainerBase.[jboss.web].[localhost].[/kitca]] (main) Initializing Spring FrameworkServlet 'remoting'
2011-07-18 09:30:44,089 INFO  [STDOUT] (main) 09:30:44.089 [main] INFO  o.s.web.servlet.DispatcherServlet - FrameworkServlet 'remoting': initialization started
2011-07-18 09:30:44,089 INFO  [STDOUT] (main) 09:30:44.089 [main] DEBUG o.s.web.servlet.DispatcherServlet - Servlet with name 'remoting' will try to create custom WebApplicationContext context of class 'org.springframework.web.context.support.XmlWebApplicationContext', using parent context [org.springframework.web.context.support.XmlWebApplicationContext@79e5e7: display name [Root WebApplicationContext]; startup date [Mon Jul 18 09:30:42 GMT-03:00 2011]; root of context hierarchy]
2011-07-18 09:30:44,089 INFO  [STDOUT] (main) 09:30:44.089 [main] INFO  o.s.w.c.s.XmlWebApplicationContext - Refreshing org.springframework.web.context.support.XmlWebApplicationContext@17dec37: display name [WebApplicationContext for namespace 'remoting-servlet']; startup date [Mon Jul 18 09:30:44 GMT-03:00 2011]; parent: org.springframework.web.context.support.XmlWebApplicationContext@79e5e7
2011-07-18 09:30:44,089 INFO  [STDOUT] (main) 09:30:44.089 [main] INFO  o.s.b.f.xml.XmlBeanDefinitionReader - Loading XML bean definitions from ServletContext resource [/WEB-INF/resources/remoting-servlet.xml]
2011-07-18 09:30:44,089 INFO  [STDOUT] (main) 09:30:44.089 [main] DEBUG o.s.b.f.xml.DefaultDocumentLoader - Using JAXP provider [org.apache.xerces.jaxp.DocumentBuilderFactoryImpl]
2011-07-18 09:30:44,089 INFO  [STDOUT] (main) 09:30:44.089 [main] DEBUG o.s.b.f.xml.PluggableSchemaResolver - Loading schema mappings from [META-INF/spring.schemas]
2011-07-18 09:30:44,089 INFO  [STDOUT] (main) 09:30:44.089 [main] DEBUG o.s.b.f.xml.PluggableSchemaResolver - Loaded schema mappings: {http://www.springframework.org/schema/lang/spring-lang-2.5.xsd=org/springframework/scripting/config/spring-lang-2.5.xsd, http://www.springframework.org/schema/lang/spring-lang.xsd=org/springframework/scripting/config/spring-lang-2.5.xsd, http://www.springframework.org/schema/context/spring-context-2.5.xsd=org/springframework/context/config/spring-context-2.5.xsd, http://www.springframework.org/schema/aop/spring-aop.xsd=org/springframework/aop/config/spring-aop-2.5.xsd, http://www.springframework.org/schema/context/spring-context.xsd=org/springframework/context/config/spring-context-2.5.xsd, http://www.springframework.org/schema/util/spring-util-2.0.xsd=org/springframework/beans/factory/xml/spring-util-2.0.xsd, http://www.springframework.org/schema/util/spring-util-2.5.xsd=org/springframework/beans/factory/xml/spring-util-2.5.xsd, http://www.springframework.org/schema/tool/spring-tool-2.0.xsd=org/springframework/beans/factory/xml/spring-tool-2.0.xsd, http://www.springframework.org/schema/tx/spring-tx-2.0.xsd=org/springframework/transaction/config/spring-tx-2.0.xsd, http://www.springframework.org/schema/beans/spring-beans-2.0.xsd=org/springframework/beans/factory/xml/spring-beans-2.0.xsd, http://www.springframework.org/schema/tool/spring-tool-2.5.xsd=org/springframework/beans/factory/xml/spring-tool-2.5.xsd, http://www.springframework.org/schema/tx/spring-tx-2.5.xsd=org/springframework/transaction/config/spring-tx-2.5.xsd, http://www.springframework.org/schema/beans/spring-beans-2.5.xsd=org/springframework/beans/factory/xml/spring-beans-2.5.xsd, http://www.springframework.org/schema/jee/spring-jee.xsd=org/springframework/ejb/config/spring-jee-2.5.xsd, http://www.springframework.org/schema/beans/spring-beans.xsd=org/springframework/beans/factory/xml/spring-beans-2.5.xsd, http://www.springframework.org/schema/tool/spring-tool.xsd=org/springframework/beans/factory/xml/spring-tool-2.5.xsd, http://www.springframework.org/schema/tx/spring-tx.xsd=org/springframework/transaction/config/spring-tx-2.5.xsd, http://www.springframework.org/schema/aop/spring-aop-2.0.xsd=org/springframework/aop/config/spring-aop-2.0.xsd, http://www.springframework.org/schema/jee/spring-jee-2.0.xsd=org/springframework/ejb/config/spring-jee-2.0.xsd, http://www.springframework.org/schema/aop/spring-aop-2.5.xsd=org/springframework/aop/config/spring-aop-2.5.xsd, http://www.springframework.org/schema/jee/spring-jee-2.5.xsd=org/springframework/ejb/config/spring-jee-2.5.xsd, http://www.springframework.org/schema/lang/spring-lang-2.0.xsd=org/springframework/scripting/config/spring-lang-2.0.xsd, http://www.springframework.org/schema/util/spring-util.xsd=org/springframework/beans/factory/xml/spring-util-2.5.xsd}
2011-07-18 09:30:44,089 INFO  [STDOUT] (main) 09:30:44.089 [main] DEBUG o.s.b.f.xml.PluggableSchemaResolver - Found XML schema [http://www.springframework.org/schema/beans/spring-beans-2.0.xsd] in classpath: org/springframework/beans/factory/xml/spring-beans-2.0.xsd
2011-07-18 09:30:44,121 INFO  [STDOUT] (main) 09:30:44.121 [main] DEBUG o.s.b.f.x.DefaultBeanDefinitionDocumentReader - Loading bean definitions
2011-07-18 09:30:44,121 INFO  [STDOUT] (main) 09:30:44.121 [main] DEBUG o.s.b.f.x.BeanDefinitionParserDelegate - No XML 'id' specified - using '/KITCAService.svlt' as bean name and [] as aliases
2011-07-18 09:30:44,121 INFO  [STDOUT] (main) 09:30:44.121 [main] DEBUG o.s.b.f.xml.XmlBeanDefinitionReader - Loaded 1 bean definitions from location pattern [/WEB-INF/resources/remoting-servlet.xml]
2011-07-18 09:30:44,121 INFO  [STDOUT] (main) 09:30:44.121 [main] INFO  o.s.w.c.s.XmlWebApplicationContext - Bean factory for application context [org.springframework.web.context.support.XmlWebApplicationContext@17dec37]: org.springframework.beans.factory.support.DefaultListableBeanFactory@1eb7ecf
2011-07-18 09:30:44,121 INFO  [STDOUT] (main) 09:30:44.121 [main] DEBUG o.s.w.c.s.XmlWebApplicationContext - 1 beans defined in org.springframework.web.context.support.XmlWebApplicationContext@17dec37: display name [WebApplicationContext for namespace 'remoting-servlet']; startup date [Mon Jul 18 09:30:44 GMT-03:00 2011]; parent: org.springframework.web.context.support.XmlWebApplicationContext@79e5e7
2011-07-18 09:30:44,121 INFO  [STDOUT] (main) 09:30:44.121 [main] DEBUG o.s.w.c.s.XmlWebApplicationContext - Unable to locate MessageSource with name 'messageSource': using default [org.springframework.context.support.DelegatingMessageSource@18eedc2]
2011-07-18 09:30:44,121 INFO  [STDOUT] (main) 09:30:44.121 [main] DEBUG o.s.w.c.s.XmlWebApplicationContext - Unable to locate ApplicationEventMulticaster with name 'applicationEventMulticaster': using default [org.springframework.context.event.SimpleApplicationEventMulticaster@9b780d]
2011-07-18 09:30:44,121 INFO  [STDOUT] (main) 09:30:44.121 [main] DEBUG o.s.u.c.s.UiApplicationContextUtils - Unable to locate ThemeSource with name 'themeSource': using default [org.springframework.ui.context.support.DelegatingThemeSource@e6a1e5]
2011-07-18 09:30:44,121 INFO  [STDOUT] (main) 09:30:44.121 [main] INFO  o.s.b.f.s.DefaultListableBeanFactory - Pre-instantiating singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@1eb7ecf: defining beans [/KITCAService.svlt]; parent: org.springframework.beans.factory.support.DefaultListableBeanFactory@1d3e355
2011-07-18 09:30:44,121 INFO  [STDOUT] (main) 09:30:44.121 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating shared instance of singleton bean '/KITCAService.svlt'
2011-07-18 09:30:44,121 INFO  [STDOUT] (main) 09:30:44.121 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean '/KITCAService.svlt'
2011-07-18 09:30:44,136 INFO  [STDOUT] (main) 09:30:44.136 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Eagerly caching bean '/KITCAService.svlt' to allow for resolving potential circular references
2011-07-18 09:30:44,136 INFO  [STDOUT] (main) 09:30:44.136 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'kitcaService'
2011-07-18 09:30:44,136 INFO  [STDOUT] (main) 09:30:44.136 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'securityInterceptor'
2011-07-18 09:30:44,136 INFO  [STDOUT] (main) 09:30:44.136 [main] DEBUG o.s.aop.framework.ProxyFactoryBean - Advice has changed; recaching singleton instance
2011-07-18 09:30:44,136 INFO  [STDOUT] (main) 09:30:44.136 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'exceptionInterceptor'
2011-07-18 09:30:44,136 INFO  [STDOUT] (main) 09:30:44.136 [main] DEBUG o.s.aop.framework.ProxyFactoryBean - Advice has changed; recaching singleton instance
2011-07-18 09:30:44,136 INFO  [STDOUT] (main) 09:30:44.136 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'delegationInterceptor'
2011-07-18 09:30:44,136 INFO  [STDOUT] (main) 09:30:44.136 [main] DEBUG o.s.aop.framework.ProxyFactoryBean - Advice has changed; recaching singleton instance
2011-07-18 09:30:44,136 INFO  [STDOUT] (main) 09:30:44.136 [main] DEBUG o.s.aop.framework.JdkDynamicAopProxy - Creating JDK dynamic proxy: target source is EmptyTargetSource: no target class, static
2011-07-18 09:30:44,136 INFO  [STDOUT] (main) 09:30:44.136 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.transaction.config.internalTransactionAdvisor'
2011-07-18 09:30:44,152 INFO  [STDOUT] (main) 09:30:44.152 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Invoking afterPropertiesSet() on bean with name '/KITCAService.svlt'
2011-07-18 09:30:44,152 INFO  [STDOUT] (main) 09:30:44.152 [main] DEBUG o.s.aop.framework.JdkDynamicAopProxy - Creating JDK dynamic proxy: target source is SingletonTargetSource for target object [$Proxy289@1662318]
2011-07-18 09:30:44,152 INFO  [STDOUT] (main) 09:30:44.152 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean '/KITCAService.svlt'
2011-07-18 09:30:44,152 INFO  [STDOUT] (main) 09:30:44.152 [main] DEBUG o.s.web.servlet.DispatcherServlet - Unable to locate MultipartResolver with name 'multipartResolver': no multipart request handling provided
2011-07-18 09:30:44,152 INFO  [STDOUT] (main) 09:30:44.152 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean 'org.springframework.web.servlet.i18n.AcceptHeaderLocaleResolver'
2011-07-18 09:30:44,152 INFO  [STDOUT] (main) 09:30:44.152 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean 'org.springframework.web.servlet.i18n.AcceptHeaderLocaleResolver'
2011-07-18 09:30:44,152 INFO  [STDOUT] (main) 09:30:44.152 [main] DEBUG o.s.web.servlet.DispatcherServlet - Unable to locate LocaleResolver with name 'localeResolver': using default [org.springframework.web.servlet.i18n.AcceptHeaderLocaleResolver@eb1198]
2011-07-18 09:30:44,152 INFO  [STDOUT] (main) 09:30:44.152 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean 'org.springframework.web.servlet.theme.FixedThemeResolver'
2011-07-18 09:30:44,152 INFO  [STDOUT] (main) 09:30:44.152 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean 'org.springframework.web.servlet.theme.FixedThemeResolver'
2011-07-18 09:30:44,152 INFO  [STDOUT] (main) 09:30:44.152 [main] DEBUG o.s.web.servlet.DispatcherServlet - Unable to locate ThemeResolver with name 'themeResolver': using default [org.springframework.web.servlet.theme.FixedThemeResolver@8f329f]
2011-07-18 09:30:44,152 INFO  [STDOUT] (main) 09:30:44.152 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean 'org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping'
2011-07-18 09:30:44,167 INFO  [STDOUT] (main) 09:30:44.167 [main] DEBUG o.s.w.s.h.BeanNameUrlHandlerMapping - Looking for URL mappings in application context: org.springframework.web.context.support.XmlWebApplicationContext@17dec37: display name [WebApplicationContext for namespace 'remoting-servlet']; startup date [Mon Jul 18 09:30:44 GMT-03:00 2011]; parent: org.springframework.web.context.support.XmlWebApplicationContext@79e5e7
2011-07-18 09:30:44,167 INFO  [STDOUT] (main) 09:30:44.167 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean '/KITCAService.svlt'
2011-07-18 09:30:44,167 INFO  [STDOUT] (main) 09:30:44.167 [main] DEBUG o.s.w.s.h.BeanNameUrlHandlerMapping - Mapped URL path [/KITCAService.svlt] onto handler [org.springframework.remoting.httpinvoker.HttpInvokerServiceExporter@7f7d2b]
2011-07-18 09:30:44,167 INFO  [STDOUT] (main) 09:30:44.167 [main] DEBUG o.s.w.s.h.BeanNameUrlHandlerMapping - Rejected bean name 'messageSource': no URL paths identified
2011-07-18 09:30:44,167 INFO  [STDOUT] (main) 09:30:44.167 [main] DEBUG o.s.w.s.h.BeanNameUrlHandlerMapping - Rejected bean name 'applicationEventMulticaster': no URL paths identified
2011-07-18 09:30:44,167 INFO  [STDOUT] (main) 09:30:44.167 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean 'org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping'
2011-07-18 09:30:44,167 INFO  [STDOUT] (main) 09:30:44.167 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean 'org.springframework.web.servlet.mvc.annotation.DefaultAnnotationHandlerMapping'
2011-07-18 09:30:44,167 INFO  [STDOUT] (main) 09:30:44.167 [main] DEBUG o.s.w.s.m.a.DefaultAnnotationHandlerMapping - Looking for URL mappings in application context: org.springframework.web.context.support.XmlWebApplicationContext@17dec37: display name [WebApplicationContext for namespace 'remoting-servlet']; startup date [Mon Jul 18 09:30:44 GMT-03:00 2011]; parent: org.springframework.web.context.support.XmlWebApplicationContext@79e5e7
2011-07-18 09:30:44,167 INFO  [STDOUT] (main) 09:30:44.167 [main] DEBUG o.s.w.s.m.a.DefaultAnnotationHandlerMapping - Rejected bean name '/KITCAService.svlt': no URL paths identified
2011-07-18 09:30:44,167 INFO  [STDOUT] (main) 09:30:44.167 [main] DEBUG o.s.w.s.m.a.DefaultAnnotationHandlerMapping - Rejected bean name 'messageSource': no URL paths identified
2011-07-18 09:30:44,167 INFO  [STDOUT] (main) 09:30:44.167 [main] DEBUG o.s.w.s.m.a.DefaultAnnotationHandlerMapping - Rejected bean name 'applicationEventMulticaster': no URL paths identified
2011-07-18 09:30:44,167 INFO  [STDOUT] (main) 09:30:44.167 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean 'org.springframework.web.servlet.mvc.annotation.DefaultAnnotationHandlerMapping'
2011-07-18 09:30:44,167 INFO  [STDOUT] (main) 09:30:44.167 [main] DEBUG o.s.web.servlet.DispatcherServlet - No HandlerMappings found in servlet 'remoting': using default
2011-07-18 09:30:44,167 INFO  [STDOUT] (main) 09:30:44.167 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean 'org.springframework.web.servlet.mvc.HttpRequestHandlerAdapter'
2011-07-18 09:30:44,167 INFO  [STDOUT] (main) 09:30:44.167 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean 'org.springframework.web.servlet.mvc.HttpRequestHandlerAdapter'
2011-07-18 09:30:44,167 INFO  [STDOUT] (main) 09:30:44.167 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean 'org.springframework.web.servlet.mvc.SimpleControllerHandlerAdapter'
2011-07-18 09:30:44,167 INFO  [STDOUT] (main) 09:30:44.167 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean 'org.springframework.web.servlet.mvc.SimpleControllerHandlerAdapter'
2011-07-18 09:30:44,167 INFO  [STDOUT] (main) 09:30:44.167 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean 'org.springframework.web.servlet.mvc.throwaway.ThrowawayControllerHandlerAdapter'
2011-07-18 09:30:44,183 INFO  [STDOUT] (main) 09:30:44.183 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean 'org.springframework.web.servlet.mvc.throwaway.ThrowawayControllerHandlerAdapter'
2011-07-18 09:30:44,183 INFO  [STDOUT] (main) 09:30:44.183 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean 'org.springframework.web.servlet.mvc.annotation.AnnotationMethodHandlerAdapter'
2011-07-18 09:30:44,199 INFO  [STDOUT] (main) 09:30:44.199 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean 'org.springframework.web.servlet.mvc.annotation.AnnotationMethodHandlerAdapter'
2011-07-18 09:30:44,199 INFO  [STDOUT] (main) 09:30:44.199 [main] DEBUG o.s.web.servlet.DispatcherServlet - No HandlerAdapters found in servlet 'remoting': using default
2011-07-18 09:30:44,199 INFO  [STDOUT] (main) 09:30:44.199 [main] DEBUG o.s.web.servlet.DispatcherServlet - No HandlerExceptionResolvers found in servlet 'remoting': using default
2011-07-18 09:30:44,199 INFO  [STDOUT] (main) 09:30:44.199 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean 'org.springframework.web.servlet.view.DefaultRequestToViewNameTranslator'
2011-07-18 09:30:44,199 INFO  [STDOUT] (main) 09:30:44.199 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean 'org.springframework.web.servlet.view.DefaultRequestToViewNameTranslator'
2011-07-18 09:30:44,199 INFO  [STDOUT] (main) 09:30:44.199 [main] DEBUG o.s.web.servlet.DispatcherServlet - Unable to locate RequestToViewNameTranslator with name 'viewNameTranslator': using default [org.springframework.web.servlet.view.DefaultRequestToViewNameTranslator@16fdd71]
2011-07-18 09:30:44,199 INFO  [STDOUT] (main) 09:30:44.199 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean 'org.springframework.web.servlet.view.InternalResourceViewResolver'
2011-07-18 09:30:44,214 INFO  [STDOUT] (main) 09:30:44.214 [main] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean 'org.springframework.web.servlet.view.InternalResourceViewResolver'
2011-07-18 09:30:44,214 INFO  [STDOUT] (main) 09:30:44.214 [main] DEBUG o.s.web.servlet.DispatcherServlet - No ViewResolvers found in servlet 'remoting': using default
2011-07-18 09:30:44,214 INFO  [STDOUT] (main) 09:30:44.214 [main] DEBUG o.s.web.servlet.DispatcherServlet - Published WebApplicationContext of servlet 'remoting' as ServletContext attribute with name [org.springframework.web.servlet.FrameworkServlet.CONTEXT.remoting]
2011-07-18 09:30:44,214 INFO  [STDOUT] (main) 09:30:44.214 [main] INFO  o.s.web.servlet.DispatcherServlet - FrameworkServlet 'remoting': initialization completed in 125 ms
2011-07-18 09:30:44,214 INFO  [STDOUT] (main) 09:30:44.214 [main] DEBUG o.s.web.servlet.DispatcherServlet - Servlet 'remoting' configured successfully
2011-07-18 09:30:44,246 WARN  [org.jboss.web.tomcat.service.deployers.TomcatDeployment] (main) Failed to setup clustering, clustering disabled. NoClassDefFoundError: org/jboss/cache/pojo/jmx/PojoCacheJmxWrapperMBean
2011-07-18 09:30:44,277 INFO  [org.apache.coyote.http11.Http11Protocol] (main) Starting Coyote HTTP/1.1 on http-0.0.0.0-8080
2011-07-18 09:30:44,292 INFO  [org.apache.coyote.ajp.AjpProtocol] (main) Starting Coyote AJP/1.3 on ajp-0.0.0.0-8009
2011-07-18 09:30:44,292 INFO  [org.jboss.bootstrap.microcontainer.ServerImpl] (main) JBoss (Microcontainer) [5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)] Started in 1m:6s:313ms
2011-07-18 09:32:12,154 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:12.154 [http-0.0.0.0-8080-1] DEBUG o.s.web.servlet.DispatcherServlet - DispatcherServlet with name 'remoting' processing request for [/kitca/KITCAService.svlt]
2011-07-18 09:32:12,169 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:12.169 [http-0.0.0.0-8080-1] DEBUG o.s.w.s.h.BeanNameUrlHandlerMapping - Mapping [/KITCAService.svlt] to handler 'org.springframework.remoting.httpinvoker.HttpInvokerServiceExporter@7f7d2b'
2011-07-18 09:32:12,169 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:12.169 [http-0.0.0.0-8080-1] DEBUG o.s.r.s.RemoteInvocationTraceInterceptor - Incoming HttpInvokerServiceExporter remote call: br.com.tito.kitca.common.business.AcessoService.logon
2011-07-18 09:32:12,185 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:12.185 [http-0.0.0.0-8080-1] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Creating instance of bean 'scopedTarget.dadosAutenticacao'
2011-07-18 09:32:12,185 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:12.185 [http-0.0.0.0-8080-1] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.transaction.config.internalTransactionAdvisor'
2011-07-18 09:32:12,185 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:12.185 [http-0.0.0.0-8080-1] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Finished creating instance of bean 'scopedTarget.dadosAutenticacao'
2011-07-18 09:32:12,185 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:12.185 [http-0.0.0.0-8080-1] INFO  b.c.t.k.c.business.AcessoService - [null] executa 'logon'
2011-07-18 09:32:12,185 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:12.185 [http-0.0.0.0-8080-1] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.transaction.interceptor.TransactionInterceptor#0'
2011-07-18 09:32:12,185 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:12.185 [http-0.0.0.0-8080-1] DEBUG o.s.t.a.AnnotationTransactionAttributeSource - Adding transactional method [logon] with attribute [PROPAGATION_REQUIRED,ISOLATION_DEFAULT]
2011-07-18 09:32:12,200 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:12.200 [http-0.0.0.0-8080-1] DEBUG o.s.o.h.HibernateTransactionManager - Creating new transaction with name [br.com.tito.kitca.common.business.AcessoService.logon]: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
2011-07-18 09:32:12,279 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:12.279 [http-0.0.0.0-8080-1] DEBUG o.s.o.h.HibernateTransactionManager - Opened new Session [org.hibernate.impl.SessionImpl@486d9f] for Hibernate transaction
2011-07-18 09:32:12,279 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:12.279 [http-0.0.0.0-8080-1] DEBUG o.s.o.h.HibernateTransactionManager - Preparing JDBC Connection of Hibernate Session [org.hibernate.impl.SessionImpl@486d9f]
2011-07-18 09:32:12,294 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:12.294 [http-0.0.0.0-8080-1] DEBUG o.s.o.h.HibernateTransactionManager - Exposing Hibernate transaction as JDBC transaction [org.jboss.resource.adapter.jdbc.jdk6.WrappedConnectionJDK6@90b907]
2011-07-18 09:32:12,294 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:12.294 [http-0.0.0.0-8080-1] DEBUG o.s.o.h.HibernateTransactionManager - Initiating transaction commit
2011-07-18 09:32:12,294 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:12.294 [http-0.0.0.0-8080-1] DEBUG o.s.o.h.HibernateTransactionManager - Committing Hibernate transaction on Session [org.hibernate.impl.SessionImpl@486d9f]
2011-07-18 09:32:12,310 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:12.310 [http-0.0.0.0-8080-1] DEBUG o.s.o.h.HibernateTransactionManager - Closing Hibernate Session [org.hibernate.impl.SessionImpl@486d9f] after transaction
2011-07-18 09:32:12,310 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:12.310 [http-0.0.0.0-8080-1] DEBUG o.s.o.hibernate3.SessionFactoryUtils - Closing Hibernate Session
2011-07-18 09:32:12,310 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:12.310 [http-0.0.0.0-8080-1] DEBUG o.s.r.s.RemoteInvocationTraceInterceptor - Finished processing of HttpInvokerServiceExporter remote call: br.com.tito.kitca.common.business.AcessoService.logon
2011-07-18 09:32:12,310 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:12.310 [http-0.0.0.0-8080-1] DEBUG o.s.web.servlet.DispatcherServlet - Null ModelAndView returned to DispatcherServlet with name 'remoting': assuming HandlerAdapter completed request handling
2011-07-18 09:32:12,310 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:12.310 [http-0.0.0.0-8080-1] DEBUG o.s.web.servlet.DispatcherServlet - Successfully completed request
2011-07-18 09:32:15,513 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:15.513 [http-0.0.0.0-8080-1] DEBUG o.s.web.servlet.DispatcherServlet - DispatcherServlet with name 'remoting' processing request for [/kitca/KITCAService.svlt]
2011-07-18 09:32:15,513 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:15.513 [http-0.0.0.0-8080-1] DEBUG o.s.w.s.h.BeanNameUrlHandlerMapping - Mapping [/KITCAService.svlt] to handler 'org.springframework.remoting.httpinvoker.HttpInvokerServiceExporter@7f7d2b'
2011-07-18 09:32:15,513 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:15.513 [http-0.0.0.0-8080-1] DEBUG o.s.r.s.RemoteInvocationTraceInterceptor - Incoming HttpInvokerServiceExporter remote call: br.com.tito.kitca.common.business.EmpresaService.buscarEmpresas
2011-07-18 09:32:15,513 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:15.513 [http-0.0.0.0-8080-1] INFO  b.c.t.k.c.business.EmpresaService - [x4ij] executa 'buscarEmpresas'
2011-07-18 09:32:15,513 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:15.513 [http-0.0.0.0-8080-1] DEBUG o.s.t.a.AnnotationTransactionAttributeSource - Adding transactional method [buscarEmpresas] with attribute [PROPAGATION_REQUIRED,ISOLATION_DEFAULT,readOnly]
2011-07-18 09:32:15,513 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:15.513 [http-0.0.0.0-8080-1] DEBUG o.s.o.h.HibernateTransactionManager - Creating new transaction with name [br.com.tito.kitca.common.business.EmpresaService.buscarEmpresas]: PROPAGATION_REQUIRED,ISOLATION_DEFAULT,readOnly
2011-07-18 09:32:15,513 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:15.513 [http-0.0.0.0-8080-1] DEBUG o.s.o.h.HibernateTransactionManager - Opened new Session [org.hibernate.impl.SessionImpl@1619950] for Hibernate transaction
2011-07-18 09:32:15,513 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:15.513 [http-0.0.0.0-8080-1] DEBUG o.s.o.h.HibernateTransactionManager - Preparing JDBC Connection of Hibernate Session [org.hibernate.impl.SessionImpl@1619950]
2011-07-18 09:32:15,513 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:15.513 [http-0.0.0.0-8080-1] DEBUG o.s.jdbc.datasource.DataSourceUtils - Setting JDBC Connection [org.jboss.resource.adapter.jdbc.jdk6.WrappedConnectionJDK6@988e5e] read-only
2011-07-18 09:32:15,513 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:15.513 [http-0.0.0.0-8080-1] DEBUG o.s.o.h.HibernateTransactionManager - Exposing Hibernate transaction as JDBC transaction [org.jboss.resource.adapter.jdbc.jdk6.WrappedConnectionJDK6@988e5e]
2011-07-18 09:32:15,732 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:15.732 [http-0.0.0.0-8080-1] DEBUG o.s.o.h.HibernateTransactionManager - Initiating transaction rollback
2011-07-18 09:32:15,732 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:15.732 [http-0.0.0.0-8080-1] DEBUG o.s.o.h.HibernateTransactionManager - Rolling back Hibernate transaction on Session [org.hibernate.impl.SessionImpl@1619950]
2011-07-18 09:32:15,732 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:15.732 [http-0.0.0.0-8080-1] DEBUG o.s.jdbc.datasource.DataSourceUtils - Resetting read-only flag of JDBC Connection [org.jboss.resource.adapter.jdbc.jdk6.WrappedConnectionJDK6@988e5e]
2011-07-18 09:32:15,732 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:15.732 [http-0.0.0.0-8080-1] DEBUG o.s.o.h.HibernateTransactionManager - Closing Hibernate Session [org.hibernate.impl.SessionImpl@1619950] after transaction
2011-07-18 09:32:15,732 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:15.732 [http-0.0.0.0-8080-1] DEBUG o.s.o.hibernate3.SessionFactoryUtils - Closing Hibernate Session
2011-07-18 09:32:15,779 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:15.732 [http-0.0.0.0-8080-1] ERROR b.c.t.k.c.business.EmpresaService - Empresa is not mapped [ select distinct e from Empresa e  left join fetch e.ambientes a  where 1=1  order by e.nome ]
java.lang.reflect.InvocationTargetException: null
          at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.6.0_20]
          at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) ~[na:1.6.0_20]
          at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) ~[na:1.6.0_20]
          at java.lang.reflect.Method.invoke(Method.java:597) ~[na:1.6.0_20]
          at br.com.petrobras.snarf.service.interceptor.DelegationInterceptor.invoke(DelegationInterceptor.java:52) ~[snarf-service-1.4.jar:na]
          at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:171) [spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at br.com.petrobras.snarf.service.interceptor.ExceptionInterceptor.invoke(ExceptionInterceptor.java:115) ~[snarf-service-1.4.jar:na]
          at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:171) [spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at br.com.petrobras.snarf.service.interceptor.SecurityInterceptor.invoke(SecurityInterceptor.java:62) [snarf-service-1.4.jar:na]
          at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:171) [spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:204) [spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at $Proxy289.buscarEmpresas(Unknown Source) [na:na]
          at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.6.0_20]
          at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) ~[na:1.6.0_20]
          at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) ~[na:1.6.0_20]
          at java.lang.reflect.Method.invoke(Method.java:597) ~[na:1.6.0_20]
          at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:307) [spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:182) [spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:149) [spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.remoting.support.RemoteInvocationTraceInterceptor.invoke(RemoteInvocationTraceInterceptor.java:77) [spring-context-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:171) [spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:204) [spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at $Proxy289.buscarEmpresas(Unknown Source) [na:na]
          at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.6.0_20]
          at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) ~[na:1.6.0_20]
          at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) ~[na:1.6.0_20]
          at java.lang.reflect.Method.invoke(Method.java:597) ~[na:1.6.0_20]
          at org.springframework.remoting.support.RemoteInvocation.invoke(RemoteInvocation.java:205) [spring-context-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.remoting.support.DefaultRemoteInvocationExecutor.invoke(DefaultRemoteInvocationExecutor.java:38) [spring-context-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.remoting.support.RemoteInvocationBasedExporter.invoke(RemoteInvocationBasedExporter.java:78) [spring-context-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.remoting.support.RemoteInvocationBasedExporter.invokeAndCreateResult(RemoteInvocationBasedExporter.java:114) [spring-context-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.remoting.httpinvoker.HttpInvokerServiceExporter.handleRequest(HttpInvokerServiceExporter.java:74) [spring-web-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.web.servlet.mvc.HttpRequestHandlerAdapter.handle(HttpRequestHandlerAdapter.java:49) [spring-webmvc-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:875) [spring-webmvc-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:807) [spring-webmvc-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:571) [spring-webmvc-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.web.servlet.FrameworkServlet.doPost(FrameworkServlet.java:511) [spring-webmvc-2.5.6.SEC02.jar:2.5.6.SEC02]
          at javax.servlet.http.HttpServlet.service(HttpServlet.java:637) [servlet-api.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at javax.servlet.http.HttpServlet.service(HttpServlet.java:717) [servlet-api.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:290) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.jboss.web.tomcat.filters.ReplyHeaderFilter.doFilter(ReplyHeaderFilter.java:96) [jboss-web-service.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:235) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:235) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:191) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.jboss.web.tomcat.security.SecurityAssociationValve.invoke(SecurityAssociationValve.java:190) [jboss-web-service.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.jboss.web.tomcat.security.JaccContextValve.invoke(JaccContextValve.java:92) [jboss-web-service.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.jboss.web.tomcat.security.SecurityContextEstablishmentValve.process(SecurityContextEstablishmentValve.java:126) [jboss-web-service.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.jboss.web.tomcat.security.SecurityContextEstablishmentValve.invoke(SecurityContextEstablishmentValve.java:70) [jboss-web-service.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:102) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.jboss.web.tomcat.service.jca.CachedConnectionValve.invoke(CachedConnectionValve.java:158) [jboss-web-service.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:109) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:330) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:829) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:598) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:447) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at java.lang.Thread.run(Thread.java:619) [na:1.6.0_20]
Caused by: org.hibernate.hql.ast.QuerySyntaxException: Empresa is not mapped [ select distinct e from Empresa e  left join fetch e.ambientes a  where 1=1  order by e.nome ]
          at org.hibernate.hql.ast.util.SessionFactoryHelper.requireClassPersister(SessionFactoryHelper.java:181) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.ast.tree.FromElementFactory.addFromElement(FromElementFactory.java:110) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.ast.tree.FromClause.addFromElement(FromClause.java:93) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.ast.HqlSqlWalker.createFromElement(HqlSqlWalker.java:277) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.antlr.HqlSqlBaseWalker.fromElement(HqlSqlBaseWalker.java:3056) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.antlr.HqlSqlBaseWalker.fromElementList(HqlSqlBaseWalker.java:2945) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.antlr.HqlSqlBaseWalker.fromClause(HqlSqlBaseWalker.java:688) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.antlr.HqlSqlBaseWalker.query(HqlSqlBaseWalker.java:544) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.antlr.HqlSqlBaseWalker.selectStatement(HqlSqlBaseWalker.java:281) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.antlr.HqlSqlBaseWalker.statement(HqlSqlBaseWalker.java:229) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.ast.QueryTranslatorImpl.analyze(QueryTranslatorImpl.java:251) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.ast.QueryTranslatorImpl.doCompile(QueryTranslatorImpl.java:183) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.ast.QueryTranslatorImpl.compile(QueryTranslatorImpl.java:134) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.engine.query.HQLQueryPlan.<init>(HQLQueryPlan.java:101) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.engine.query.HQLQueryPlan.<init>(HQLQueryPlan.java:80) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.engine.query.QueryPlanCache.getHQLQueryPlan(QueryPlanCache.java:94) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.impl.AbstractSessionImpl.getHQLQueryPlan(AbstractSessionImpl.java:156) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.impl.AbstractSessionImpl.createQuery(AbstractSessionImpl.java:135) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.impl.SessionImpl.createQuery(SessionImpl.java:1650) ~[hibernate-core.jar!/:3.3.1.GA]
          at br.com.petrobras.snarf.service.persistence.BusinessTextQuery.buildQuery(BusinessTextQuery.java:212) ~[snarf-service-1.4.jar:na]
          at br.com.petrobras.snarf.service.persistence.BusinessTextQuery.setText(BusinessTextQuery.java:74) ~[snarf-service-1.4.jar:na]
          at br.com.tito.kitca.service.query.ConsultaEmpresasPorNome.<init>(ConsultaEmpresasPorNome.java:42) ~[kitca-service-1.0.0.jar:na]
          at br.com.tito.kitca.service.business.EmpresaServiceImpl.buscarEmpresas(EmpresaServiceImpl.java:29) ~[kitca-service-1.0.0.jar:na]
          at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.6.0_20]
          at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) ~[na:1.6.0_20]
          at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) ~[na:1.6.0_20]
          at java.lang.reflect.Method.invoke(Method.java:597) ~[na:1.6.0_20]
          at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:307) [spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:182) [spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:149) [spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:106) ~[spring-tx-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:171) [spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:204) [spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at $Proxy286.buscarEmpresas(Unknown Source) ~[na:na]
          ... 59 common frames omitted
2011-07-18 09:32:15,794 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:15.794 [http-0.0.0.0-8080-1] WARN  o.s.r.s.RemoteInvocationTraceInterceptor - Processing of HttpInvokerServiceExporter remote call resulted in fatal exception: br.com.tito.kitca.common.business.EmpresaService.buscarEmpresas
br.com.petrobras.snarf.common.exception.SystemException: snarf.exception.dataBaseError
          at br.com.petrobras.snarf.common.exception.SystemException.unknown(SystemException.java:22) ~[snarf-common-1.4.jar:na]
          at br.com.petrobras.snarf.service.interceptor.ExceptionInterceptor.handleException(ExceptionInterceptor.java:93) ~[snarf-service-1.4.jar:na]
          at br.com.petrobras.snarf.service.interceptor.ExceptionInterceptor.invoke(ExceptionInterceptor.java:117) ~[snarf-service-1.4.jar:na]
          at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:171) [spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at br.com.petrobras.snarf.service.interceptor.SecurityInterceptor.invoke(SecurityInterceptor.java:62) ~[snarf-service-1.4.jar:na]
          at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:171) [spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:204) [spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at $Proxy289.buscarEmpresas(Unknown Source) [na:na]
          at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.6.0_20]
          at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) ~[na:1.6.0_20]
          at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) ~[na:1.6.0_20]
          at java.lang.reflect.Method.invoke(Method.java:597) ~[na:1.6.0_20]
          at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:307) ~[spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:182) [spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:149) [spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.remoting.support.RemoteInvocationTraceInterceptor.invoke(RemoteInvocationTraceInterceptor.java:77) ~[spring-context-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:171) [spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:204) [spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at $Proxy289.buscarEmpresas(Unknown Source) [na:na]
          at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.6.0_20]
          at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) ~[na:1.6.0_20]
          at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) ~[na:1.6.0_20]
          at java.lang.reflect.Method.invoke(Method.java:597) ~[na:1.6.0_20]
          at org.springframework.remoting.support.RemoteInvocation.invoke(RemoteInvocation.java:205) [spring-context-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.remoting.support.DefaultRemoteInvocationExecutor.invoke(DefaultRemoteInvocationExecutor.java:38) [spring-context-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.remoting.support.RemoteInvocationBasedExporter.invoke(RemoteInvocationBasedExporter.java:78) [spring-context-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.remoting.support.RemoteInvocationBasedExporter.invokeAndCreateResult(RemoteInvocationBasedExporter.java:114) [spring-context-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.remoting.httpinvoker.HttpInvokerServiceExporter.handleRequest(HttpInvokerServiceExporter.java:74) [spring-web-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.web.servlet.mvc.HttpRequestHandlerAdapter.handle(HttpRequestHandlerAdapter.java:49) [spring-webmvc-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:875) [spring-webmvc-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:807) [spring-webmvc-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:571) [spring-webmvc-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.web.servlet.FrameworkServlet.doPost(FrameworkServlet.java:511) [spring-webmvc-2.5.6.SEC02.jar:2.5.6.SEC02]
          at javax.servlet.http.HttpServlet.service(HttpServlet.java:637) [servlet-api.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at javax.servlet.http.HttpServlet.service(HttpServlet.java:717) [servlet-api.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:290) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.jboss.web.tomcat.filters.ReplyHeaderFilter.doFilter(ReplyHeaderFilter.java:96) [jboss-web-service.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:235) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:235) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:191) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.jboss.web.tomcat.security.SecurityAssociationValve.invoke(SecurityAssociationValve.java:190) [jboss-web-service.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.jboss.web.tomcat.security.JaccContextValve.invoke(JaccContextValve.java:92) [jboss-web-service.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.jboss.web.tomcat.security.SecurityContextEstablishmentValve.process(SecurityContextEstablishmentValve.java:126) [jboss-web-service.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.jboss.web.tomcat.security.SecurityContextEstablishmentValve.invoke(SecurityContextEstablishmentValve.java:70) [jboss-web-service.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:102) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.jboss.web.tomcat.service.jca.CachedConnectionValve.invoke(CachedConnectionValve.java:158) [jboss-web-service.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:109) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:330) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:829) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:598) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:447) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at java.lang.Thread.run(Thread.java:619) [na:1.6.0_20]
Caused by: org.hibernate.hql.ast.QuerySyntaxException: Empresa is not mapped [ select distinct e from Empresa e  left join fetch e.ambientes a  where 1=1  order by e.nome ]
          at org.hibernate.hql.ast.util.SessionFactoryHelper.requireClassPersister(SessionFactoryHelper.java:181) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.ast.tree.FromElementFactory.addFromElement(FromElementFactory.java:110) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.ast.tree.FromClause.addFromElement(FromClause.java:93) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.ast.HqlSqlWalker.createFromElement(HqlSqlWalker.java:277) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.antlr.HqlSqlBaseWalker.fromElement(HqlSqlBaseWalker.java:3056) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.antlr.HqlSqlBaseWalker.fromElementList(HqlSqlBaseWalker.java:2945) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.antlr.HqlSqlBaseWalker.fromClause(HqlSqlBaseWalker.java:688) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.antlr.HqlSqlBaseWalker.query(HqlSqlBaseWalker.java:544) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.antlr.HqlSqlBaseWalker.selectStatement(HqlSqlBaseWalker.java:281) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.antlr.HqlSqlBaseWalker.statement(HqlSqlBaseWalker.java:229) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.ast.QueryTranslatorImpl.analyze(QueryTranslatorImpl.java:251) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.ast.QueryTranslatorImpl.doCompile(QueryTranslatorImpl.java:183) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.ast.QueryTranslatorImpl.compile(QueryTranslatorImpl.java:134) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.engine.query.HQLQueryPlan.<init>(HQLQueryPlan.java:101) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.engine.query.HQLQueryPlan.<init>(HQLQueryPlan.java:80) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.engine.query.QueryPlanCache.getHQLQueryPlan(QueryPlanCache.java:94) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.impl.AbstractSessionImpl.getHQLQueryPlan(AbstractSessionImpl.java:156) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.impl.AbstractSessionImpl.createQuery(AbstractSessionImpl.java:135) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.impl.SessionImpl.createQuery(SessionImpl.java:1650) ~[hibernate-core.jar!/:3.3.1.GA]
          at br.com.petrobras.snarf.service.persistence.BusinessTextQuery.buildQuery(BusinessTextQuery.java:212) ~[snarf-service-1.4.jar:na]
          at br.com.petrobras.snarf.service.persistence.BusinessTextQuery.setText(BusinessTextQuery.java:74) ~[snarf-service-1.4.jar:na]
          at br.com.tito.kitca.service.query.ConsultaEmpresasPorNome.<init>(ConsultaEmpresasPorNome.java:42) ~[kitca-service-1.0.0.jar:na]
          at br.com.tito.kitca.service.business.EmpresaServiceImpl.buscarEmpresas(EmpresaServiceImpl.java:29) ~[kitca-service-1.0.0.jar:na]
          at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.6.0_20]
          at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) ~[na:1.6.0_20]
          at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) ~[na:1.6.0_20]
          at java.lang.reflect.Method.invoke(Method.java:597) ~[na:1.6.0_20]
          at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:307) ~[spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:182) [spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:149) [spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:106) ~[spring-tx-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:171) [spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:204) [spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at $Proxy286.buscarEmpresas(Unknown Source) ~[na:na]
          at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.6.0_20]
          at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) ~[na:1.6.0_20]
          at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) ~[na:1.6.0_20]
          at java.lang.reflect.Method.invoke(Method.java:597) ~[na:1.6.0_20]
          at br.com.petrobras.snarf.service.interceptor.DelegationInterceptor.invoke(DelegationInterceptor.java:52) ~[snarf-service-1.4.jar:na]
          at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:171) [spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at br.com.petrobras.snarf.service.interceptor.ExceptionInterceptor.invoke(ExceptionInterceptor.java:115) ~[snarf-service-1.4.jar:na]
          ... 52 common frames omitted
2011-07-18 09:32:15,810 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:15.810 [http-0.0.0.0-8080-1] DEBUG o.s.r.h.HttpInvokerServiceExporter - Target method failed for RemoteInvocation: method name 'buscarEmpresas'; parameter types [java.lang.String]
br.com.petrobras.snarf.common.exception.SystemException: snarf.exception.dataBaseError
          at br.com.petrobras.snarf.common.exception.SystemException.unknown(SystemException.java:22) ~[snarf-common-1.4.jar:na]
          at br.com.petrobras.snarf.service.interceptor.ExceptionInterceptor.handleException(ExceptionInterceptor.java:93) ~[snarf-service-1.4.jar:na]
          at br.com.petrobras.snarf.service.interceptor.ExceptionInterceptor.invoke(ExceptionInterceptor.java:117) ~[snarf-service-1.4.jar:na]
          at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:171) ~[spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at br.com.petrobras.snarf.service.interceptor.SecurityInterceptor.invoke(SecurityInterceptor.java:62) ~[snarf-service-1.4.jar:na]
          at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:171) ~[spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:204) ~[spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at $Proxy289.buscarEmpresas(Unknown Source) ~[na:na]
          at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.6.0_20]
          at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) ~[na:1.6.0_20]
          at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) ~[na:1.6.0_20]
          at java.lang.reflect.Method.invoke(Method.java:597) ~[na:1.6.0_20]
          at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:307) ~[spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:182) ~[spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:149) ~[spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.remoting.support.RemoteInvocationTraceInterceptor.invoke(RemoteInvocationTraceInterceptor.java:77) ~[spring-context-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:171) ~[spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:204) ~[spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at $Proxy289.buscarEmpresas(Unknown Source) ~[na:na]
          at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.6.0_20]
          at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) ~[na:1.6.0_20]
          at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) ~[na:1.6.0_20]
          at java.lang.reflect.Method.invoke(Method.java:597) ~[na:1.6.0_20]
          at org.springframework.remoting.support.RemoteInvocation.invoke(RemoteInvocation.java:205) ~[spring-context-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.remoting.support.DefaultRemoteInvocationExecutor.invoke(DefaultRemoteInvocationExecutor.java:38) ~[spring-context-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.remoting.support.RemoteInvocationBasedExporter.invoke(RemoteInvocationBasedExporter.java:78) [spring-context-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.remoting.support.RemoteInvocationBasedExporter.invokeAndCreateResult(RemoteInvocationBasedExporter.java:114) [spring-context-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.remoting.httpinvoker.HttpInvokerServiceExporter.handleRequest(HttpInvokerServiceExporter.java:74) [spring-web-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.web.servlet.mvc.HttpRequestHandlerAdapter.handle(HttpRequestHandlerAdapter.java:49) [spring-webmvc-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:875) [spring-webmvc-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:807) [spring-webmvc-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:571) [spring-webmvc-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.web.servlet.FrameworkServlet.doPost(FrameworkServlet.java:511) [spring-webmvc-2.5.6.SEC02.jar:2.5.6.SEC02]
          at javax.servlet.http.HttpServlet.service(HttpServlet.java:637) [servlet-api.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at javax.servlet.http.HttpServlet.service(HttpServlet.java:717) [servlet-api.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:290) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.jboss.web.tomcat.filters.ReplyHeaderFilter.doFilter(ReplyHeaderFilter.java:96) [jboss-web-service.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:235) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:235) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:191) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.jboss.web.tomcat.security.SecurityAssociationValve.invoke(SecurityAssociationValve.java:190) [jboss-web-service.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.jboss.web.tomcat.security.JaccContextValve.invoke(JaccContextValve.java:92) [jboss-web-service.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.jboss.web.tomcat.security.SecurityContextEstablishmentValve.process(SecurityContextEstablishmentValve.java:126) [jboss-web-service.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.jboss.web.tomcat.security.SecurityContextEstablishmentValve.invoke(SecurityContextEstablishmentValve.java:70) [jboss-web-service.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:102) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.jboss.web.tomcat.service.jca.CachedConnectionValve.invoke(CachedConnectionValve.java:158) [jboss-web-service.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:109) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:330) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:829) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:598) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:447) [jbossweb.jar!/:5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221634)]
          at java.lang.Thread.run(Thread.java:619) [na:1.6.0_20]
Caused by: org.hibernate.hql.ast.QuerySyntaxException: Empresa is not mapped [ select distinct e from Empresa e  left join fetch e.ambientes a  where 1=1  order by e.nome ]
          at org.hibernate.hql.ast.util.SessionFactoryHelper.requireClassPersister(SessionFactoryHelper.java:181) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.ast.tree.FromElementFactory.addFromElement(FromElementFactory.java:110) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.ast.tree.FromClause.addFromElement(FromClause.java:93) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.ast.HqlSqlWalker.createFromElement(HqlSqlWalker.java:277) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.antlr.HqlSqlBaseWalker.fromElement(HqlSqlBaseWalker.java:3056) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.antlr.HqlSqlBaseWalker.fromElementList(HqlSqlBaseWalker.java:2945) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.antlr.HqlSqlBaseWalker.fromClause(HqlSqlBaseWalker.java:688) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.antlr.HqlSqlBaseWalker.query(HqlSqlBaseWalker.java:544) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.antlr.HqlSqlBaseWalker.selectStatement(HqlSqlBaseWalker.java:281) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.antlr.HqlSqlBaseWalker.statement(HqlSqlBaseWalker.java:229) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.ast.QueryTranslatorImpl.analyze(QueryTranslatorImpl.java:251) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.ast.QueryTranslatorImpl.doCompile(QueryTranslatorImpl.java:183) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.hql.ast.QueryTranslatorImpl.compile(QueryTranslatorImpl.java:134) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.engine.query.HQLQueryPlan.<init>(HQLQueryPlan.java:101) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.engine.query.HQLQueryPlan.<init>(HQLQueryPlan.java:80) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.engine.query.QueryPlanCache.getHQLQueryPlan(QueryPlanCache.java:94) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.impl.AbstractSessionImpl.getHQLQueryPlan(AbstractSessionImpl.java:156) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.impl.AbstractSessionImpl.createQuery(AbstractSessionImpl.java:135) ~[hibernate-core.jar!/:3.3.1.GA]
          at org.hibernate.impl.SessionImpl.createQuery(SessionImpl.java:1650) ~[hibernate-core.jar!/:3.3.1.GA]
          at br.com.petrobras.snarf.service.persistence.BusinessTextQuery.buildQuery(BusinessTextQuery.java:212) ~[snarf-service-1.4.jar:na]
          at br.com.petrobras.snarf.service.persistence.BusinessTextQuery.setText(BusinessTextQuery.java:74) ~[snarf-service-1.4.jar:na]
          at br.com.tito.kitca.service.query.ConsultaEmpresasPorNome.<init>(ConsultaEmpresasPorNome.java:42) ~[kitca-service-1.0.0.jar:na]
          at br.com.tito.kitca.service.business.EmpresaServiceImpl.buscarEmpresas(EmpresaServiceImpl.java:29) ~[kitca-service-1.0.0.jar:na]
          at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.6.0_20]
          at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) ~[na:1.6.0_20]
          at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) ~[na:1.6.0_20]
          at java.lang.reflect.Method.invoke(Method.java:597) ~[na:1.6.0_20]
          at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:307) ~[spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:182) ~[spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:149) ~[spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:106) ~[spring-tx-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:171) ~[spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:204) ~[spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at $Proxy286.buscarEmpresas(Unknown Source) ~[na:na]
          at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.6.0_20]
          at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) ~[na:1.6.0_20]
          at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) ~[na:1.6.0_20]
          at java.lang.reflect.Method.invoke(Method.java:597) ~[na:1.6.0_20]
          at br.com.petrobras.snarf.service.interceptor.DelegationInterceptor.invoke(DelegationInterceptor.java:52) ~[snarf-service-1.4.jar:na]
          at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:171) ~[spring-aop-2.5.6.SEC02.jar:2.5.6.SEC02]
          at br.com.petrobras.snarf.service.interceptor.ExceptionInterceptor.invoke(ExceptionInterceptor.java:115) ~[snarf-service-1.4.jar:na]
          ... 52 common frames omitted
2011-07-18 09:32:15,825 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:15.825 [http-0.0.0.0-8080-1] DEBUG o.s.web.servlet.DispatcherServlet - Null ModelAndView returned to DispatcherServlet with name 'remoting': assuming HandlerAdapter completed request handling
2011-07-18 09:32:15,825 INFO  [STDOUT] (http-0.0.0.0-8080-1) 09:32:15.825 [http-0.0.0.0-8080-1] DEBUG o.s.web.servlet.DispatcherServlet - Successfully completed request
 
 
**********************************************************************************
 
 
 
 
**********************************************************************************
<<ApplicationContext.xml>>
 
 
<?xml version="1.0" encoding="UTF-8"?>
<beans xmlns="http://www.springframework.org/schema/beans"
       xmlns:aop="http://www.springframework.org/schema/aop"
       xmlns:tx="http://www.springframework.org/schema/tx"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
             xsi:schemaLocation="http://www.springframework.org/schema/beans http://www.springframework.org/schema/beans/spring-beans-2.0.xsd                          
                           http://www.springframework.org/schema/aop http://www.springframework.org/schema/aop/spring-aop-2.0.xsd
                           http://www.springframework.org/schema/tx http://www.springframework.org/schema/tx/spring-tx-2.0.xsd">
 
 
    
    <bean id="log4jInitialization" class="org.springframework.beans.factory.config.MethodInvokingFactoryBean">
        <property name="targetClass" value="org.springframework.util.Log4jConfigurer" />
        <property name="targetMethod" value="initLogging" />
        <property name="arguments">
            <list>
                <value>classpath:kitca/log4j.properties</value>
            </list>
        </property>
    </bean>
   
    
    <bean id="propertyConfigurer1" class="org.springframework.beans.factory.config.PropertyPlaceholderConfigurer">
        <property name="location">
            <value>classpath:kitca/config.properties</value>
        </property>
        <property name="placeholderPrefix" value="$[" />
        <property name="placeholderSuffix" value="]" />
    </bean>
   
    
    <bean id="propertyConfigurer2" class="org.springframework.beans.factory.config.PropertyPlaceholderConfigurer">
        <property name="locations">
            <list>
                <value>classpath:kitca/kitca.properties</value>
                <value>classpath:kitca/acessocorp.properties</value>
            </list>
        </property>
        <property name="placeholderPrefix" value="${" />
        <property name="placeholderSuffix" value="}" />
    </bean>
   
    
    <bean id="dataSource" class="org.springframework.jndi.JndiObjectFactoryBean">
        <property name="jndiName">
            <value>$[dsname]</value>
        </property>
    </bean>
 
 
    
    <bean id="sessionFactory" class="org.springframework.orm.hibernate3.annotation.AnnotationSessionFactoryBean">
        <property name="dataSource" ref="dataSource"/>
        <property name="hibernateProperties">
           <props>
                <prop key="hibernate.dialect">${hibernate.dialect}</prop>
                <prop key="hibernate.cache.provider_class">${hibernate.cache.provider_class}</prop>
                <prop key="hibernate.max_fetch_depth">${hibernate.max_fetch_depth}</prop>
                
          </props>
        </property>
        
        <property name="annotatedClasses">
            <list>
               <value>br.com.tito.kitca.common.entity.Administrador</value>
               <value>br.com.tito.kitca.common.entity.Ambiente</value>
               <value>br.com.tito.kitca.common.entity.Empresa</value>
               <value>br.com.tito.kitca.common.entity.Sistema</value>
               <value>br.com.tito.kitca.common.entity.SistemaAmbiente</value>
               <value>br.com.tito.kitca.common.entity.Usuario</value>
            </list>
        </property>
 
 
    </bean>
   
    
    <bean id="transactionManager" class="org.springframework.orm.hibernate3.HibernateTransactionManager">
      <property name="sessionFactory" ref="sessionFactory"/>
    </bean>
 
 
    <tx:annotation-driven transaction-manager="transactionManager"/>
 
 
  
 
 
    ... more...
 
 
 
</beans>
 
 
 
 
********************************************************************************************************
 
 
*******************************************************************************************************
<<Empresa.java>>
 
 
 
 
 
 
package br.com.tito.kitca.common.entity;
 
 
 
 
import java.io.Serializable;
import java.util.HashSet;
import java.util.List;
import java.util.Set;
import javax.persistence.Column;
import javax.persistence.Entity;
import javax.persistence.FetchType;
import javax.persistence.GeneratedValue;
import javax.persistence.GenerationType;
import javax.persistence.Id;
import javax.persistence.OneToMany;
import javax.persistence.Table;
 
 
 
 
@Entity
@Table(name = "EMPRESA", schema = "CA")
public class Empresa implements Serializable {
 
 
   
    private static final long serialVersionUID = 1L;
    public static final String PROPRIEDADE_ID = "id";
    public static final String PROPRIEDADE_NOME = "nome";
    public static final String PROPRIEDADE_DESCRICAO = "descricao";
    public static final String PROPRIEDADE_AMBIENTES = "ambientes";
    public static final String PROPRIEDADE_USUARIOS = "usuarios";
  
    @Id
    @GeneratedValue(strategy = GenerationType.IDENTITY)
    @Column(name="EMPR_SQ_EMPRESA", nullable=false)
    private Long id;
 
 
    @Column(name="EMPR_DS_NOME", nullable=false)
    private String nome;
 
 
    @Column(name="EMPR_DS_DESCRICAO", nullable=false)
    private String descricao;
 
 
    @OneToMany(mappedBy = Ambiente.PROPRIEDADE_EMPRESA, fetch=FetchType.LAZY)
    private Set<Ambiente> ambientes;
 
 
    @OneToMany(mappedBy = Usuario.PROPRIEDADE_EMPRESA, fetch=FetchType.LAZY)
    private Set<Usuario> usuarios;
   
    // <editor-fold defaultstate="collapsed" desc="Getters">
 
 
    public Long getId() {
        return id;
    }
 
 
    public String getNome() {
        return nome;
    }
 
 
    public String getDescricao() {
        return descricao;
    }
 
 
    public List<Ambiente> getAmbientes() {
        return setToList(ambientes);
    }
 
 
    public List<Usuario> getUsuarios() {
        return setToList(usuarios);
    }
 
 
    // </editor-fold>
 
 
    // <editor-fold defaultstate="collapsed" desc="Setters">
 
 
    public void setNome(String nome) {
        Object old = this.nome;
        this.nome = nome;
        firePropertyChange(PROPRIEDADE_NOME, old, this.nome);
    }
 
 
    public void setDescricao(String descricao) {
        Object old = this.descricao;
        this.descricao = descricao;
        firePropertyChange(PROPRIEDADE_DESCRICAO, old, this.descricao);
    }
 
 
 
 
    // </editor-fold>
 
 
    // <editor-fold defaultstate="collapsed" desc="Metodos adicionar e remover">
 
 
    public void adicionarAmbiente(Ambiente a) {
        if (a==null)
            return;
        if (ambientes==null)
            ambientes = new HashSet();
        ambientes.add(a);
        firePropertyChange(PROPRIEDADE_AMBIENTES, null, getAmbientes());
    }
 
 
    public void removerAmbiente(Ambiente a) {
        if (a==null)
            return;
        if (ambientes==null)
            ambientes = new HashSet();
        ambientes.remove(a);
        firePropertyChange(PROPRIEDADE_AMBIENTES, null, getAmbientes());
    }
 
 
    public void adicionarUsuario(Usuario u) {
        if (u==null)
            return;
        if (usuarios==null)
            usuarios = new HashSet();
        usuarios.add(u);
        firePropertyChange(PROPRIEDADE_USUARIOS, null, getUsuarios());
    }
 
 
    public void removerUsuario(Usuario u) {
        if (u==null)
            return;
        if (usuarios==null)
            usuarios = new HashSet();
        usuarios.remove(u);
        firePropertyChange(PROPRIEDADE_USUARIOS, null, getUsuarios());
    }
 
 
 
 
    // </editor-fold>
 
 
    @Override
    public String toString() {
        return nome;
    }
 
 
}
 
 
*******************************************************************************************************
 
 
*******************************************************************************************************
<<the querie>>
 
 
 
 
 
 
package br.com.tito.kitca.service.query;
 
 
 
 
import br.com.petrobras.snarf.service.persistence.BusinessTextQuery;
import br.com.petrobras.snarf.service.persistence.GenericSimpleDAO;
import br.com.tito.kitca.common.entity.Empresa;
import java.util.HashMap;
import java.util.Map;
 
 
/**
* Retorna a lista de Produto cadastrados filtrados pelo nome
* @author x4rb
*/
public class ConsultaEmpresasPorNome extends BusinessTextQuery<Empresa> {
   
    public ConsultaEmpresasPorNome(GenericSimpleDAO dao, String nome) {
 
 
        super(dao);
 
 
        Map<String, Object> map = new HashMap<String, Object>();
 
 
        StringBuilder texto = new StringBuilder();
 
 
        texto
                .append(" select distinct e from {Empresa} e ")
                .append(" left join fetch e.{ambientes} a ")
                .append(" where 1=1 ");
 
 
        if (nome!=null && !nome.equals("")) {
            texto.append(" and upper(e.{nome}) like '%'|| :nome ||'%' ");
            map.put("nome", nome);
        }
 
 
        texto.append(" order by e.{nome} ");
 
 
        String hql = texto.toString();
 
 
        hql = hql.replace("{Empresa}", Empresa.class.getSimpleName())
                 .replace("{ambientes}", Empresa.PROPRIEDADE_AMBIENTES)
                 .replace("{nome}", Empresa.PROPRIEDADE_NOME);
 
 
        this.setText(hql);
        setParameters(map);
       
    }
}