11 Replies Latest reply on May 2, 2006 2:03 PM by bsmithjj

    Problem with Injection / Outjection

      Hello,

      I am using Seam 1.0.0.CR1. I am having some difficulty with the @In and @Out annotations. I will explain my 'use case' then I will explain the problem.

      I am developing a prototype Seam web application that is integrated with the CAS http://www.ja-sig.org/products/cas/ Single Sign-On system. What this means is that I am deploying a Filter along with my application that works out the authentication status of the user with the CAS server. Once the the Filter has established that the user is authenticated, it let's the user's requests proceed on to the Seam (web) application that it fronts.

      Once I get to the first page in my Seam, I would like to use a component (a POJO style STATELESS component (not EJB3)) to perform a hibernate query and return some user-specific data. I read in the documentation that I should create a pages.xml file and add something like the following:

      <pages>
       <page view-id="/main.xhtml" action="#{conversation.begin}"/>
      </pages>
      


      so I added this (main.xthml is the page that renders in response to requests for /main.seam). I have snipped the only 'interesting' code from main.xhtml here:

       Welcome #{aNumber} (aNumber)<br/>
       Welcome #{remoteUser} (remoteUser)<br/>
       Welcome #{com$evergreen$sso$SSOData.userPrincipal} (ssoData.userPrincipal)<br/>
       Welcome #{com$evergreen$sso$SSOData.userPrincipal.userid} (com$evergreen$sso$SSOData.userPrincipal.userid)<br/>
       Welcome #{com$evergreen$sso$SSOData.userPrincipal.personName} (com$evergreen$sso$SSOData.userPrincipal.personName)<br/>
      ....
       Conversation.id = #{conversation.id}<br/>
       #{userLinks}
      


      which results in a display like the following:

      Welcome (aNumber)
      Welcome (remoteUser)
      Welcome EvergreenSSOPrincipal{userid=A42........} (ssoData.userPrincipal)
      Welcome A42.... (com$evergreen$sso$SSOData.userPrincipal.userid)
      Welcome B .... Smith (com$evergreen$sso$SSOData.userPrincipal.personName)
      


      where the stuff from com$evergreen$sso$SSOData is supplied in the HttpSession via the Filter class I deployed with the application.

      The first problem here is from #{userLinks}. I have tried to bind this to this bean:

      @Name("userLinkActions")
      @Scope(ScopeType.STATELESS)
      public class UserLinkActions {
      
       private Log log = LogFactory.getLog(UserLinkActions.class);
      
       @In(required = true)
       private Context sessionContext;
      
       @In(value="#{userPrincipal}",required=true)
       private EvergreenSSOPrincipal ssoPrincipal;
      
       @In(create=true)
       private Session appssoDB;
      
       @In(create=true)
       private FacesMessages facesMessages;
      
       @Out(scope=ScopeType.SESSION)
       private User user;
      
       @Out
       private Collection<Link> userLinks;
      
       public UserLinkActions() {log.info("new UserLinkActions()");}
      
       @Factory("userLinks")
       public final void getUserLinks() {
       log.info("getUserLinks() - (in) user = " + user);
       log.info("getUserLinks() - (in) ssoPrincipal = " + ssoPrincipal);
       log.info("getUserLinks() - (in) appssoDB = " + appssoDB);
       log.info("getUserLinks() - (in) sessionContext = " + sessionContext);
       log.info("getUserLinks() - (in) facesMessages = " + facesMessages);
      
       if (ssoPrincipal == null) {
       log.info("Yikes! getUserLinks() - ssoPrincipal is null.");
       userLinks = new ArrayList<Link>();
       return;
       }
       final User currentUser = (User)appssoDB.createQuery("from User where aNumber=:aNumber")
       .setParameter("aNumber",user.getaNumber())
       .uniqueResult();
       log.info("getUserLinks() - (out) currentUser = "+currentUser);
       userLinks = currentUser.getLinks();
       if (userLinks != null) {
       log.info("getUserLinks() - user has "+userLinks.size()+" links.");
       }
       }
      
      }
      


      The server console reports the following when /main.seam (/main.xhtml) is reached:

      15:46:21,934 INFO [User] new User()
      15:46:21,997 INFO [UserLinkActions] new UserLinkActions()
      15:46:21,997 INFO [UserLinkActions] getUserLinks() - (in) user = null
      15:46:21,997 INFO [UserLinkActions] getUserLinks() - (in) ssoPrincipal = null
      15:46:21,997 INFO [UserLinkActions] getUserLinks() - (in) appssoDB = null
      15:46:21,997 INFO [UserLinkActions] getUserLinks() - (in) sessionContext = null
      15:46:21,997 INFO [UserLinkActions] getUserLinks() - (in) facesMessages = null
      15:46:21,997 INFO [UserLinkActions] Yikes! getUserLinks() - ssoPrincipal is null.
      


      Please disregard the hibernate query in the bean based on the User property - I know that won't work in its current state. I am trying to understand why the @In annotations aren't behaving as I expect. I am sure I once again missed something in the documentation, the configuration, are in this forum (yes I have searched and read). I am mainly concerned that the objects, components, parameters I would like injected are not being injected. Help! Any help is appreciated.

      Thanks.

        • 1. Re: Problem with Injection / Outjection

          Can anyone help with this? Again, the problem is that I am displaying this page via GET and my @In annotations do not appear to be 'honored' by Seam. Thus, the userLinks collection which I would like to @Out will never be 'loaded' with data.

          • 2. Re: Problem with Injection / Outjection
            gavin.king

            Things that can help here:

            (1) The startup log of the application
            (2) A stack trace of the call to the UserLinkActions() constructor
            (3) A stack trave of the call to getUserLinks()

            • 3. Re: Problem with Injection / Outjection

              Part 1:

              abbreviated portion of the server startup log (server.log) showing logging related to the deploy of my seam.war (disregard the portal failures - it has no impact on the seam war):

              2006-05-01 09:58:54,437 DEBUG [org.jboss.deployment.MainDeployer] Starting deployment of package: file:/C:/jboss-4.0.4.CR2/server/default/deploy/userlinks.war
              2006-05-01 09:58:54,437 DEBUG [org.jboss.deployment.MainDeployer] Starting deployment (init step) of package at: file:/C:/jboss-4.0.4.CR2/server/default/deploy/userlinks.war
              2006-05-01 09:58:54,437 DEBUG [org.jboss.deployment.MainDeployer] Copying file:/C:/jboss-4.0.4.CR2/server/default/deploy/userlinks.war -> C:\jboss-4.0.4.CR2\server\default\tmp\deploy\tmp33984userlinks.war
              2006-05-01 09:58:54,703 DEBUG [org.jboss.deployment.MainDeployer] using deployer MBeanProxyExt[jboss.web:service=WebServer]
              2006-05-01 09:58:54,703 DEBUG [org.jboss.web.tomcat.tc5.Tomcat5] Begin init
              2006-05-01 09:58:54,718 DEBUG [org.jboss.web.tomcat.tc5.Tomcat5] Unpacking war to: C:\jboss-4.0.4.CR2\server\default\tmp\deploy\tmp33984userlinks-exp.war
              2006-05-01 09:58:56,031 DEBUG [org.jboss.web.tomcat.tc5.Tomcat5] Replaced war with unpacked contents
              2006-05-01 09:58:56,031 DEBUG [org.jboss.web.tomcat.tc5.Tomcat5] Was unable to delete war file
              2006-05-01 09:58:56,031 DEBUG [org.jboss.web.tomcat.tc5.Tomcat5] webContext: null
              2006-05-01 09:58:56,031 DEBUG [org.jboss.web.tomcat.tc5.Tomcat5] warURL: file:/C:/jboss-4.0.4.CR2/server/default/tmp/deploy/tmp33984userlinks-exp.war/
              2006-05-01 09:58:56,046 DEBUG [org.jboss.web.tomcat.tc5.Tomcat5] End init
              2006-05-01 09:58:56,046 DEBUG [org.jboss.deployment.DeploymentInfo] createLoaderRepository from config: LoaderRepositoryConfig(repositoryName: JMImplementation:service=LoaderRepository,name=Default, repositoryClassName: null, configParserClassName: null, repositoryConfig: null)
              2006-05-01 09:58:56,046 DEBUG [org.jboss.mx.loading.UnifiedClassLoader] New jmx UCL with url file:/C:/jboss-4.0.4.CR2/server/default/tmp/deploy/tmp33984userlinks-exp.war/
              2006-05-01 09:58:56,046 DEBUG [org.jboss.mx.loading.RepositoryClassLoader] setRepository, repository=org.jboss.mx.loading.UnifiedLoaderRepository3@79717e, cl=org.jboss.mx.loading.UnifiedClassLoader3@14b9b80{ url=file:/C:/jboss-4.0.4.CR2/server/default/tmp/deploy/tmp33984userlinks-exp.war/ ,addedOrder=0}
              2006-05-01 09:58:56,046 DEBUG [org.jboss.mx.loading.RepositoryClassLoader] setRepository, repository=org.jboss.mx.loading.UnifiedLoaderRepository3@79717e, cl=org.jboss.mx.loading.UnifiedClassLoader3@14b9b80{ url=file:/C:/jboss-4.0.4.CR2/server/default/tmp/deploy/tmp33984userlinks-exp.war/ ,addedOrder=0}
              2006-05-01 09:58:56,046 DEBUG [org.jboss.mx.loading.UnifiedLoaderRepository3] Adding org.jboss.mx.loading.UnifiedClassLoader3@14b9b80{ url=file:/C:/jboss-4.0.4.CR2/server/default/tmp/deploy/tmp33984userlinks-exp.war/ ,addedOrder=0}
              2006-05-01 09:58:56,046 DEBUG [org.jboss.deployment.MainDeployer] found 0 subpackages of file:/C:/jboss-4.0.4.CR2/server/default/deploy/userlinks.war
              2006-05-01 09:58:56,046 DEBUG [org.jboss.deployment.MainDeployer] Watching new file: file:/C:/jboss-4.0.4.CR2/server/default/deploy/userlinks.war
              2006-05-01 09:58:56,046 DEBUG [org.jboss.deployment.MainDeployer] create step for deployment file:/C:/jboss-4.0.4.CR2/server/default/deploy/userlinks.war
              2006-05-01 09:58:56,046 DEBUG [org.jboss.ws.server.WebServiceDeployerJSE] create: file:/C:/jboss-4.0.4.CR2/server/default/deploy/userlinks.war
              2006-05-01 09:58:56,046 DEBUG [org.jboss.web.tomcat.tc5.Tomcat5] create, userlinks.war
              2006-05-01 09:58:56,046 DEBUG [org.jboss.system.ServiceController] Creating service jboss.web.deployment:war=userlinks.war,id=-411270120
              2006-05-01 09:58:56,046 DEBUG [org.jboss.system.ServiceController] adding depends in ServiceController.register: []
              2006-05-01 09:58:56,046 DEBUG [org.jboss.web.WebModule] Creating jboss.web.deployment:war=userlinks.war,id=-411270120
              2006-05-01 09:58:56,046 DEBUG [org.jboss.web.WebModule] Created jboss.web.deployment:war=userlinks.war,id=-411270120
              2006-05-01 09:58:56,046 DEBUG [org.jboss.system.ServiceController] Creating dependent components for: jboss.web.deployment:war=userlinks.war,id=-411270120 dependents are: []
              2006-05-01 09:58:56,046 DEBUG [org.jboss.deployment.MainDeployer] Done with create step of deploying userlinks.war
              2006-05-01 09:58:56,046 DEBUG [org.jboss.deployment.MainDeployer] Begin deployment start file:/C:/jboss-4.0.4.CR2/server/default/deploy/userlinks.war
              2006-05-01 09:58:56,046 DEBUG [org.jboss.ws.server.WebServiceDeployerJSE] start: file:/C:/jboss-4.0.4.CR2/server/default/deploy/userlinks.war
              2006-05-01 09:58:56,046 DEBUG [org.jboss.system.ServiceController] starting service jboss.web.deployment:war=userlinks.war,id=-411270120
              2006-05-01 09:58:56,046 DEBUG [org.jboss.web.WebModule] Starting jboss.web.deployment:war=userlinks.war,id=-411270120
              2006-05-01 09:58:56,046 DEBUG [org.jboss.web.tomcat.tc5.TomcatDeployer] webContext: null
              2006-05-01 09:58:56,046 DEBUG [org.jboss.web.tomcat.tc5.TomcatDeployer] warURL: file:/C:/jboss-4.0.4.CR2/server/default/tmp/deploy/tmp33984userlinks-exp.war/
              2006-05-01 09:58:56,046 DEBUG [org.jboss.web.tomcat.tc5.TomcatDeployer] webAppParser: org.jboss.web.AbstractWebDeployer$DescriptorParser@1e881b6
              2006-05-01 09:58:56,046 DEBUG [org.jboss.web.WebPermissionMapping] Qualified url patterns: {/=PatternInfo[pattern=/,type=3,isOverriden=false,qualifiers=[]]}
              2006-05-01 09:58:56,062 INFO [org.jboss.web.tomcat.tc5.TomcatDeployer] deploy, ctxPath=/userlinks, warUrl=.../tmp/deploy/tmp33984userlinks-exp.war/
              2006-05-01 09:58:56,062 DEBUG [org.jboss.web.tomcat.tc5.TomcatDeployer] AbstractWebContainer.parseWebAppDescriptors, Begin
              2006-05-01 09:58:56,062 DEBUG [org.jboss.web.tomcat.tc5.TomcatDeployer] Creating ENC using ClassLoader: java.net.FactoryURLClassLoader@19bf795
              2006-05-01 09:58:56,062 DEBUG [org.jboss.web.tomcat.tc5.TomcatDeployer] ..org.jboss.mx.loading.UnifiedClassLoader3@14b9b80{ url=file:/C:/jboss-4.0.4.CR2/server/default/tmp/deploy/tmp33984userlinks-exp.war/ ,addedOrder=41}
              2006-05-01 09:58:56,062 DEBUG [org.jboss.web.tomcat.tc5.TomcatDeployer] ..org.jboss.system.server.NoAnnotationURLClassLoader@ab95e6
              2006-05-01 09:58:56,062 DEBUG [org.jboss.web.tomcat.tc5.TomcatDeployer] ..sun.misc.Launcher$AppClassLoader@e39a3e
              2006-05-01 09:58:56,062 DEBUG [org.jboss.web.tomcat.tc5.TomcatDeployer] ..sun.misc.Launcher$ExtClassLoader@a39137
              2006-05-01 09:58:56,062 DEBUG [org.jboss.web.tomcat.tc5.TomcatDeployer] Unable to retrieve orbjavax.management.InstanceNotFoundException: jboss:service=CorbaORB is not registered.
              2006-05-01 09:58:56,062 DEBUG [org.jboss.web.tomcat.tc5.TomcatDeployer] Linked java:comp/UserTransaction to JNDI name: UserTransaction
              2006-05-01 09:58:56,062 DEBUG [org.jboss.web.tomcat.tc5.TomcatDeployer] addEnvEntries
              2006-05-01 09:58:56,062 DEBUG [org.jboss.web.tomcat.tc5.TomcatDeployer] linkResourceEnvRefs
              2006-05-01 09:58:56,062 DEBUG [org.jboss.web.tomcat.tc5.TomcatDeployer] linkResourceRefs
              2006-05-01 09:58:56,062 DEBUG [org.jboss.web.tomcat.tc5.TomcatDeployer] linkMessageDestinationRefs
              2006-05-01 09:58:56,062 DEBUG [org.jboss.web.tomcat.tc5.TomcatDeployer] linkEjbRefs
              2006-05-01 09:58:56,062 DEBUG [org.jboss.web.tomcat.tc5.TomcatDeployer] linkEjbLocalRefs
              2006-05-01 09:58:56,062 DEBUG [org.jboss.web.tomcat.tc5.TomcatDeployer] linkServiceRefs
              2006-05-01 09:58:56,062 DEBUG [org.jboss.web.tomcat.tc5.TomcatDeployer] linkSecurityDomain
              2006-05-01 09:58:56,062 DEBUG [org.jboss.web.tomcat.tc5.TomcatDeployer] No security-domain given, using default: java:/jaas/other
              2006-05-01 09:58:56,062 DEBUG [org.jboss.web.tomcat.tc5.TomcatDeployer] Linking security/securityMgr to JNDI name: java:/jaas/other
              2006-05-01 09:58:56,062 DEBUG [org.jboss.web.tomcat.tc5.TomcatDeployer] AbstractWebContainer.parseWebAppDescriptors, End
              2006-05-01 09:58:56,109 DEBUG [org.jboss.web.tomcat.tc5.TomcatDeployer] Using session cookies default setting
              2006-05-01 09:58:56,218 INFO [org.apache.catalina.loader.WebappClassLoader] validateJarFile(C:\jboss-4.0.4.CR2\server\default\.\tmp\deploy\tmp33984userlinks-exp.war\WEB-INF\lib\servlet-api-2.4.jar) - jar not loaded. See Servlet Spec 2.3, section 9.7.2. Offending class: javax/servlet/Servlet.class
              2006-05-01 09:58:56,484 DEBUG [com.sun.faces.config.ConfigureListener] contextInitialized(null)
              2006-05-01 09:58:56,765 DEBUG [com.sun.faces.config.ConfigureListener] parse(jar:file:/C:/jboss-4.0.4.CR2/server/default/tmp/deploy/tmp33984userlinks-exp.war/WEB-INF/lib/jsf-impl-1.1.01.jar!/com/sun/faces/jsf-ri-runtime.xml)
              2006-05-01 09:58:56,796 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addConverterById(javax.faces.BigDecimal)
              2006-05-01 09:58:56,796 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addConverterById(javax.faces.BigInteger)
              2006-05-01 09:58:56,796 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addConverterById(javax.faces.Boolean)
              2006-05-01 09:58:56,796 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addConverterById(javax.faces.Byte)
              2006-05-01 09:58:56,796 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addConverterById(javax.faces.Character)
              2006-05-01 09:58:56,796 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addConverterById(javax.faces.DateTime)
              2006-05-01 09:58:56,796 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addConverterById(javax.faces.Double)
              2006-05-01 09:58:56,796 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addConverterById(javax.faces.Float)
              2006-05-01 09:58:56,796 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addConverterById(javax.faces.Integer)
              2006-05-01 09:58:56,796 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addConverterById(javax.faces.Long)
              2006-05-01 09:58:56,796 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addConverterById(javax.faces.Number)
              2006-05-01 09:58:56,796 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addConverterById(javax.faces.Short)
              2006-05-01 09:58:56,796 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addConverterByClass(java.math.BigDecimal)
              2006-05-01 09:58:56,796 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addConverterByClass(java.math.BigInteger)
              2006-05-01 09:58:56,796 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addConverterByClass(java.lang.Boolean)
              2006-05-01 09:58:56,796 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addConverterByClass(java.lang.Byte)
              2006-05-01 09:58:56,796 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addConverterByClass(java.lang.Character)
              2006-05-01 09:58:56,796 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addConverterByClass(java.lang.Double)
              2006-05-01 09:58:56,796 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addConverterByClass(java.lang.Float)
              2006-05-01 09:58:56,796 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addConverterByClass(java.lang.Integer)
              2006-05-01 09:58:56,796 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addConverterByClass(java.lang.Long)
              2006-05-01 09:58:56,796 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addConverterByClass(java.lang.Short)
              2006-05-01 09:58:56,796 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addValidator(javax.faces.DoubleRange)
              2006-05-01 09:58:56,796 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addValidator(javax.faces.Length)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addValidator(javax.faces.LongRange)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.Column)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.Command)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.Data)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.Form)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.Graphic)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.Input)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.Message)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.Messages)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.NamingContainer)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.Output)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.Panel)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.Parameter)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.SelectBoolean)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.SelectItem)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.SelectItems)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.SelectMany)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.SelectOne)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.ViewRoot)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.HtmlCommandButton)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.HtmlCommandLink)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.HtmlDataTable)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.HtmlForm)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.HtmlGraphicImage)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.HtmlInputHidden)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.HtmlInputSecret)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.HtmlInputText)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.HtmlInputTextarea)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.HtmlMessage)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.HtmlMessages)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.HtmlOutputFormat)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.HtmlOutputLabel)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.HtmlOutputLink)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.HtmlOutputText)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.HtmlPanelGrid)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.HtmlPanelGroup)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.HtmlSelectBooleanCheckbox)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.HtmlSelectManyCheckbox)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.HtmlSelectManyListbox)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.HtmlSelectManyMenu)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.HtmlSelectOneListbox)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.HtmlSelectOneMenu)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(javax.faces.HtmlSelectOneRadio)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.RenderKitBean] addRenderer(javax.faces.Command,javax.faces.Button)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.RenderKitBean] addRenderer(javax.faces.Command,javax.faces.Link)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.RenderKitBean] addRenderer(javax.faces.Data,javax.faces.Table)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.RenderKitBean] addRenderer(javax.faces.Form,javax.faces.Form)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.RenderKitBean] addRenderer(javax.faces.Graphic,javax.faces.Image)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.RenderKitBean] addRenderer(javax.faces.Input,javax.faces.Hidden)
              2006-05-01 09:58:56,812 DEBUG [com.sun.faces.config.beans.RenderKitBean] addRenderer(javax.faces.Input,javax.faces.Secret)
              2006-05-01 09:58:56,828 DEBUG [com.sun.faces.config.beans.RenderKitBean] addRenderer(javax.faces.Input,javax.faces.Text)
              2006-05-01 09:58:56,828 DEBUG [com.sun.faces.config.beans.RenderKitBean] addRenderer(javax.faces.Input,javax.faces.Textarea)
              2006-05-01 09:58:56,828 DEBUG [com.sun.faces.config.beans.RenderKitBean] addRenderer(javax.faces.Message,javax.faces.Message)
              2006-05-01 09:58:56,828 DEBUG [com.sun.faces.config.beans.RenderKitBean] addRenderer(javax.faces.Messages,javax.faces.Messages)
              2006-05-01 09:58:56,828 DEBUG [com.sun.faces.config.beans.RenderKitBean] addRenderer(javax.faces.Output,javax.faces.Format)
              2006-05-01 09:58:56,828 DEBUG [com.sun.faces.config.beans.RenderKitBean] addRenderer(javax.faces.Output,javax.faces.Label)
              2006-05-01 09:58:56,828 DEBUG [com.sun.faces.config.beans.RenderKitBean] addRenderer(javax.faces.Output,javax.faces.Link)
              2006-05-01 09:58:56,828 DEBUG [com.sun.faces.config.beans.RenderKitBean] addRenderer(javax.faces.Output,javax.faces.Text)
              2006-05-01 09:58:56,828 DEBUG [com.sun.faces.config.beans.RenderKitBean] addRenderer(javax.faces.Panel,javax.faces.Grid)
              2006-05-01 09:58:56,828 DEBUG [com.sun.faces.config.beans.RenderKitBean] addRenderer(javax.faces.Panel,javax.faces.Group)
              2006-05-01 09:58:56,828 DEBUG [com.sun.faces.config.beans.RenderKitBean] addRenderer(javax.faces.SelectBoolean,javax.faces.Checkbox)
              2006-05-01 09:58:56,828 DEBUG [com.sun.faces.config.beans.RenderKitBean] addRenderer(javax.faces.SelectMany,javax.faces.Checkbox)
              2006-05-01 09:58:56,828 DEBUG [com.sun.faces.config.beans.RenderKitBean] addRenderer(javax.faces.SelectMany,javax.faces.Listbox)
              2006-05-01 09:58:56,828 DEBUG [com.sun.faces.config.beans.RenderKitBean] addRenderer(javax.faces.SelectMany,javax.faces.Menu)
              2006-05-01 09:58:56,828 DEBUG [com.sun.faces.config.beans.RenderKitBean] addRenderer(javax.faces.SelectOne,javax.faces.Listbox)
              2006-05-01 09:58:56,828 DEBUG [com.sun.faces.config.beans.RenderKitBean] addRenderer(javax.faces.SelectOne,javax.faces.Menu)
              2006-05-01 09:58:56,828 DEBUG [com.sun.faces.config.beans.RenderKitBean] addRenderer(javax.faces.SelectOne,javax.faces.Radio)
              2006-05-01 09:58:56,828 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addRenderKit(HTML_BASIC)
              2006-05-01 09:58:56,828 DEBUG [com.sun.faces.config.ConfigureListener] parse(jar:file:/C:/jboss-4.0.4.CR2/server/default/tmp/deploy/tmp33984userlinks-exp.war/WEB-INF/lib/jsf-facelets-1.1.5M.jar!/META-INF/faces-config.xml)
              2006-05-01 09:58:56,843 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(facelets.ui.Repeat)
              2006-05-01 09:58:56,843 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(facelets.ui.ComponentRef)
              2006-05-01 09:58:56,843 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(facelets.ui.Debug)
              2006-05-01 09:58:56,843 DEBUG [com.sun.faces.config.beans.RenderKitBean] addRenderer(facelets,facelets.ui.Repeat)
              2006-05-01 09:58:56,843 DEBUG [com.sun.faces.config.beans.RenderKitBean] addRenderer(facelets,facelets.ui.Repeat)
              2006-05-01 09:58:56,843 DEBUG [com.sun.faces.config.ConfigureListener] parse(jar:file:/C:/jboss-4.0.4.CR2/server/default/tmp/deploy/tmp33984userlinks-exp.war/WEB-INF/lib/jboss-seam-ui-1.0.0.CR1.jar!/META-INF/faces-config.xml)
              2006-05-01 09:58:56,843 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(org.jboss.seam.ui.HtmlQueryTable)
              2006-05-01 09:58:56,843 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(org.jboss.seam.ui.UIAction)
              2006-05-01 09:58:56,843 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(org.jboss.seam.ui.UIConversationId)
              2006-05-01 09:58:56,843 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(org.jboss.seam.ui.UIConversationPropagation)
              2006-05-01 09:58:56,843 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(org.jboss.seam.ui.UISelection)
              2006-05-01 09:58:56,859 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(org.jboss.seam.ui.UITaskId)
              2006-05-01 09:58:56,859 DEBUG [com.sun.faces.config.beans.FacesConfigBean] addComponent(org.jboss.seam.ui.HtmlLink)
              2006-05-01 09:58:56,859 DEBUG [com.sun.faces.config.ConfigureListener] parse(jar:file:/C:/jboss-4.0.4.CR2/server/default/tmp/deploy/tmp33984userlinks-exp.war/WEB-INF/lib/jboss-seam-1.0.0.CR1.jar!/META-INF/faces-config.xml)
              2006-05-01 09:58:56,859 DEBUG [com.sun.faces.config.ConfigureListener] parse(jndi:/localhost/userlinks/WEB-INF/faces-config.xml)
              2006-05-01 09:58:56,921 DEBUG [com.sun.faces.application.ApplicationFactoryImpl] Created ApplicationFactory
              2006-05-01 09:58:56,968 DEBUG [com.sun.faces.application.ApplicationImpl] Created Application instance
              2006-05-01 09:58:56,968 DEBUG [com.sun.faces.application.ApplicationFactoryImpl] Created Application instance com.sun.faces.application.ApplicationImpl@9ba632
              2006-05-01 09:58:56,984 DEBUG [com.sun.faces.lifecycle.LifecycleFactoryImpl] Created Default Lifecycle
              2006-05-01 09:58:57,000 DEBUG [com.sun.faces.lifecycle.LifecycleImpl] addPhaseListener(ANY 0,org.jboss.seam.jsf.SeamPhaseListener@169cccc
              2006-05-01 09:58:57,000 DEBUG [com.sun.faces.application.ApplicationImpl] set ActionListener Instance to com.sun.faces.application.ActionListenerImpl@12fb063
              2006-05-01 09:58:57,000 DEBUG [com.sun.faces.application.NavigationHandlerImpl] Created NavigationHandler instance
              2006-05-01 09:58:57,000 DEBUG [com.sun.faces.application.NavigationHandlerImpl] Created NavigationHandler instance
              2006-05-01 09:58:57,000 DEBUG [com.sun.faces.application.ApplicationImpl] set NavigationHandler Instance to com.sun.faces.application.NavigationHandlerImpl@1e55d39
              2006-05-01 09:58:57,000 DEBUG [com.sun.faces.application.ApplicationImpl] set NavigationHandler Instance to org.jboss.seam.jsf.SeamNavigationHandler@c4c05
              2006-05-01 09:58:57,015 DEBUG [com.sun.faces.application.ApplicationImpl] set PropertyResolver Instance to com.sun.faces.el.PropertyResolverImpl@18235a1
              2006-05-01 09:58:57,015 DEBUG [com.sun.faces.application.ApplicationImpl] set StateManager Instance to com.sun.faces.application.StateManagerImpl@30cd64
              2006-05-01 09:58:57,031 DEBUG [com.sun.faces.application.ApplicationImpl] set StateManager Instance to org.jboss.seam.jsf.SeamStateManager@67f797
              2006-05-01 09:58:57,031 DEBUG [com.sun.faces.application.ApplicationImpl] set VariableResolver Instance to com.sun.faces.el.VariableResolverImpl@1b01949
              2006-05-01 09:58:57,031 DEBUG [com.sun.faces.application.ApplicationImpl] set VariableResolver Instance to org.jboss.seam.jsf.SeamVariableResolver@1e8f2a0
              2006-05-01 09:58:57,031 DEBUG [com.sun.faces.application.ViewHandlerImpl] Created ViewHandler instance
              2006-05-01 09:58:57,031 DEBUG [com.sun.faces.application.ApplicationImpl] set ViewHandler Instance to com.sun.faces.application.ViewHandlerImpl@675039
              2006-05-01 09:58:57,031 DEBUG [com.sun.faces.application.ApplicationImpl] set ViewHandler Instance to org.jboss.seam.jsf.SeamViewHandler@7d8bb
              2006-05-01 09:58:57,062 DEBUG [com.sun.faces.application.ApplicationImpl] set ViewHandler Instance to com.sun.facelets.FaceletViewHandler@1a7dd7b
              2006-05-01 09:58:57,250 INFO [javax.servlet.ServletContextListener] Welcome to Seam 1.0 rc1
              2006-05-01 09:58:57,250 INFO [org.jboss.seam.init.Initialization] reading properties from: /seam.properties
              2006-05-01 09:58:57,265 INFO [org.jboss.seam.init.Initialization] reading properties from: /jndi.properties
              2006-05-01 09:58:57,265 INFO [org.jboss.seam.init.Initialization] reading properties from: /seam-jndi.properties
              2006-05-01 09:58:57,265 INFO [org.jboss.seam.init.Initialization] initializing Seam
              2006-05-01 09:58:57,390 INFO [org.jboss.seam.Component] Component: org.jboss.seam.core.init, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.core.Init
              2006-05-01 09:58:57,421 DEBUG [org.jboss.seam.Component] org.jboss.seam.core.init.managedSessions=appssoDB
              2006-05-01 09:58:57,421 DEBUG [org.jboss.seam.Component] org.jboss.seam.core.init.clientSideConversations=true
              2006-05-01 09:58:57,421 DEBUG [org.jboss.seam.Component] org.jboss.seam.core.init.componentClasses=org.jboss.seam.core.Hibernate
              2006-05-01 09:58:58,093 INFO [org.jboss.seam.Component] Component: org.jboss.seam.core.pages, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.core.Pages
              2006-05-01 09:58:58,109 INFO [org.jboss.seam.Component] Component: events, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.core.Events
              2006-05-01 09:58:58,125 INFO [org.jboss.seam.Component] Component: org.jboss.seam.core.manager, scope: EVENT, type: JAVA_BEAN, class: org.jboss.seam.core.Manager
              2006-05-01 09:58:58,125 DEBUG [org.jboss.seam.Component] org.jboss.seam.core.manager.conversationTimeout=120000
              2006-05-01 09:58:58,156 INFO [org.jboss.seam.Component] Component: switcher, scope: PAGE, type: JAVA_BEAN, class: org.jboss.seam.core.Switcher
              2006-05-01 09:58:58,171 INFO [org.jboss.seam.Component] Component: redirect, scope: CONVERSATION, type: JAVA_BEAN, class: org.jboss.seam.core.Redirect
              2006-05-01 09:58:58,187 INFO [org.jboss.seam.Component] Component: httpError, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.core.HttpError
              2006-05-01 09:58:58,203 INFO [org.jboss.seam.Component] Component: userPrincipal, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.core.UserPrincipal
              2006-05-01 09:58:58,218 INFO [org.jboss.seam.Component] Component: isUserInRole, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.core.IsUserInRole
              2006-05-01 09:58:58,234 INFO [org.jboss.seam.Component] Component: conversation, scope: CONVERSATION, type: JAVA_BEAN, class: org.jboss.seam.core.Conversation
              2006-05-01 09:58:58,250 INFO [org.jboss.seam.Component] Component: conversationList, scope: PAGE, type: JAVA_BEAN, class: org.jboss.seam.core.ConversationList
              2006-05-01 09:58:58,250 INFO [org.jboss.seam.Component] Component: conversationStack, scope: PAGE, type: JAVA_BEAN, class: org.jboss.seam.core.ConversationStack
              2006-05-01 09:58:58,281 INFO [org.jboss.seam.Component] Component: facesContext, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.core.FacesContext
              2006-05-01 09:58:58,281 INFO [org.jboss.seam.Component] Component: pageContext, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.core.PageContext
              2006-05-01 09:58:58,328 INFO [org.jboss.seam.Component] Component: eventContext, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.core.EventContext
              2006-05-01 09:58:58,343 INFO [org.jboss.seam.Component] Component: sessionContext, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.core.SessionContext
              2006-05-01 09:58:58,359 INFO [org.jboss.seam.Component] Component: statelessContext, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.core.StatelessContext
              2006-05-01 09:58:58,359 INFO [org.jboss.seam.Component] Component: applicationContext, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.core.ApplicationContext
              2006-05-01 09:58:58,375 INFO [org.jboss.seam.Component] Component: conversationContext, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.core.ConversationContext
              2006-05-01 09:58:58,375 INFO [org.jboss.seam.Component] Component: businessProcessContext, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.core.BusinessProcessContext
              2006-05-01 09:58:58,390 INFO [org.jboss.seam.Component] Component: locale, scope: STATELESS, type: JAVA_BEAN, class: org.jboss.seam.core.Locale
              2006-05-01 09:58:58,406 INFO [org.jboss.seam.Component] Component: messages, scope: SESSION, type: JAVA_BEAN, class: org.jboss.seam.core.Messages
              2006-05-01 09:58:58,406 INFO [org.jboss.seam.Component] Component: facesMessages, scope: CONVERSATION, type: JAVA_BEAN, class: org.jboss.seam.core.FacesMessages
              2006-05-01 09:58:58,437 INFO [org.jboss.seam.Component] Component: resourceBundle, scope: SESSION, type: JAVA_BEAN, class: org.jboss.seam.core.ResourceBundle
              2006-05-01 09:58:58,468 INFO [org.jboss.seam.Component] Component: localeSelector, scope: SESSION, type: JAVA_BEAN, class: org.jboss.seam.core.LocaleSelector
              2006-05-01 09:58:58,484 INFO [org.jboss.seam.Component] Component: uiComponent, scope: STATELESS, type: JAVA_BEAN, class: org.jboss.seam.core.UiComponent
              2006-05-01 09:58:58,500 INFO [org.jboss.seam.Component] Component: org.jboss.seam.debug.introspector, scope: EVENT, type: JAVA_BEAN, class: org.jboss.seam.debug.Introspector
              2006-05-01 09:58:58,609 INFO [org.jboss.seam.Component] Component: org.jboss.seam.debug.contexts, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.debug.Contexts
              2006-05-01 09:58:58,671 INFO [org.jboss.seam.Component] Component: org.jboss.seam.remoting.messaging.subscriptionRegistry, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.remoting.messaging.SubscriptionRegistry
              2006-05-01 09:58:58,687 DEBUG [org.jboss.seam.Component] instantiating Seam component: org.jboss.seam.core.init
              2006-05-01 09:58:58,687 INFO [org.jboss.seam.Component] Component: org.jboss.seam.core.hibernate, scope: APPLICATION, type: JAVA_BEAN, class: org.jboss.seam.core.Hibernate
              2006-05-01 09:58:58,703 INFO [org.jboss.seam.Component] Component: appssoDB, scope: CONVERSATION, type: JAVA_BEAN, class: org.jboss.seam.core.ManagedHibernateSession
              2006-05-01 09:58:58,718 DEBUG [org.jboss.seam.Component] appssoDB.sessionFactoryJndiName=java:/appssoSessionFactory
              2006-05-01 09:58:58,718 INFO [org.jboss.seam.deployment.Scanner] scanning: C:\jboss-4.0.4.CR2\server\default\tmp\deploy\tmp33984userlinks-exp.war\WEB-INF\classes
              2006-05-01 09:58:58,718 DEBUG [org.jboss.seam.deployment.Scanner] directory: C:\jboss-4.0.4.CR2\server\default\tmp\deploy\tmp33984userlinks-exp.war\WEB-INF\classes
              2006-05-01 09:58:58,734 DEBUG [org.jboss.seam.deployment.Scanner] directory: C:\jboss-4.0.4.CR2\server\default\tmp\deploy\tmp33984userlinks-exp.war\WEB-INF\classes\com
              2006-05-01 09:58:58,734 DEBUG [org.jboss.seam.deployment.Scanner] directory: C:\jboss-4.0.4.CR2\server\default\tmp\deploy\tmp33984userlinks-exp.war\WEB-INF\classes\com\evergreen
              2006-05-01 09:58:58,734 DEBUG [org.jboss.seam.deployment.Scanner] directory: C:\jboss-4.0.4.CR2\server\default\tmp\deploy\tmp33984userlinks-exp.war\WEB-INF\classes\com\evergreen\userlinks
              2006-05-01 09:58:58,734 DEBUG [org.jboss.seam.deployment.Scanner] directory: C:\jboss-4.0.4.CR2\server\default\tmp\deploy\tmp33984userlinks-exp.war\WEB-INF\classes\com\evergreen\userlinks\biz
              2006-05-01 09:58:58,734 DEBUG [org.jboss.seam.deployment.Scanner] directory: C:\jboss-4.0.4.CR2\server\default\tmp\deploy\tmp33984userlinks-exp.war\WEB-INF\classes\com\evergreen\userlinks\orm
              2006-05-01 09:58:58,750 DEBUG [org.jboss.seam.deployment.Scanner] directory: C:\jboss-4.0.4.CR2\server\default\tmp\deploy\tmp33984userlinks-exp.war\WEB-INF\classes\META-INF
              2006-05-01 09:58:58,750 INFO [org.jboss.seam.Component] Component: simpleLogin, scope: STATELESS, type: JAVA_BEAN, class: com.evergreen.userlinks.biz.SimpleLogin
              2006-05-01 09:58:58,796 INFO [org.jboss.seam.Component] Component: userLinkActions, scope: STATELESS, type: JAVA_BEAN, class: com.evergreen.userlinks.biz.UserLinkActions
              2006-05-01 09:58:58,859 INFO [org.jboss.seam.Component] Component: user, scope: SESSION, type: ENTITY_BEAN, class: com.evergreen.userlinks.orm.User
              2006-05-01 09:58:58,937 DEBUG [org.jboss.seam.Component] instantiating Seam component: pageContext
              2006-05-01 09:58:58,953 DEBUG [org.jboss.seam.Component] instantiating Seam component: eventContext
              2006-05-01 09:58:58,953 DEBUG [org.jboss.seam.Component] instantiating Seam component: facesContext
              2006-05-01 09:58:58,953 DEBUG [org.jboss.seam.Component] instantiating Seam component: userPrincipal
              2006-05-01 09:58:58,953 DEBUG [org.jboss.seam.Component] instantiating Seam component: org.jboss.seam.core.hibernate
              2006-05-01 09:58:59,015 INFO [org.hibernate.cfg.Environment] Hibernate 3.1.3
              2006-05-01 09:58:59,031 INFO [org.hibernate.cfg.Environment] hibernate.properties not found
              2006-05-01 09:58:59,031 INFO [org.hibernate.cfg.Environment] using CGLIB reflection optimizer
              2006-05-01 09:58:59,031 INFO [org.hibernate.cfg.Environment] using JDK 1.4 java.sql.Timestamp handling
              2006-05-01 09:58:59,234 INFO [org.hibernate.cfg.Configuration] configuring from resource: /hibernate.cfg.xml
              2006-05-01 09:58:59,234 INFO [org.hibernate.cfg.Configuration] Configuration resource: /hibernate.cfg.xml
              2006-05-01 09:58:59,343 DEBUG [org.hibernate.util.DTDEntityResolver] trying to resolve system-id [http://hibernate.sourceforge.net/hibernate-configuration-3.0.dtd]
              2006-05-01 09:58:59,343 DEBUG [org.hibernate.util.DTDEntityResolver] recognized hibernate namespace; attempting to resolve on classpath under org/hibernate/
              2006-05-01 09:58:59,343 DEBUG [org.hibernate.util.DTDEntityResolver] located [http://hibernate.sourceforge.net/hibernate-configuration-3.0.dtd] in classpath
              2006-05-01 09:58:59,406 DEBUG [org.hibernate.cfg.Configuration] hibernate.show_sql=true
              2006-05-01 09:58:59,406 DEBUG [org.hibernate.cfg.Configuration] hibernate.connection.driver_class=com.mysql.jdbc.Driver
              2006-05-01 09:58:59,406 DEBUG [org.hibernate.cfg.Configuration] hibernate.connection.url=jdbc:mysql://localhost/appsso
              2006-05-01 09:58:59,406 DEBUG [org.hibernate.cfg.Configuration] hibernate.connection.username=brad
              2006-05-01 09:58:59,406 DEBUG [org.hibernate.cfg.Configuration] hibernate.connection.password=brad123
              2006-05-01 09:58:59,406 DEBUG [org.hibernate.cfg.Configuration] hibernate.dialect=org.hibernate.dialect.MySQLInnoDBDialect
              2006-05-01 09:58:59,406 DEBUG [org.hibernate.cfg.Configuration] hbm2ddl.auto=update
              2006-05-01 09:58:59,406 DEBUG [org.hibernate.cfg.AnnotationConfiguration] java:/appssoSessionFactory<-org.dom4j.tree.DefaultAttribute@122e0b3 [Attribute: name class value "com.evergreen.userlinks.orm.User"]
              2006-05-01 09:58:59,421 DEBUG [org.hibernate.cfg.AnnotationConfiguration] java:/appssoSessionFactory<-org.dom4j.tree.DefaultAttribute@ce41cc [Attribute: name class value "com.evergreen.userlinks.orm.Link"]
              2006-05-01 09:58:59,421 INFO [org.hibernate.cfg.Configuration] Configured SessionFactory: java:/appssoSessionFactory
              2006-05-01 09:58:59,437 DEBUG [org.hibernate.cfg.Configuration] properties: {java.vendor=Sun Microsystems Inc., catalina.base=C:\jboss-4.0.4.CR2\server\default, hibernate.connection.url=jdbc:mysql://localhost/appsso, sun.management.compiler=HotSpot Client Compiler, catalina.useNaming=false, hbm2ddl.auto=update, os.name=Windows 2000, sun.boot.class.path=C:\jboss-4.0.4.CR2\bin\\..\lib\endorsed\resolver.jar;C:\jboss-4.0.4.CR2\bin\\..\lib\endorsed\serializer.jar;C:\jboss-4.0.4.CR2\bin\\..\lib\endorsed\xalan.jar;C:\jboss-4.0.4.CR2\bin\\..\lib\endorsed\xercesImpl.jar;C:\jboss-4.0.4.CR2\bin\\..\lib\endorsed\xml-apis.jar;C:\Program Files\Java\jdk1.5.0_06\jre\lib\rt.jar;C:\Program Files\Java\jdk1.5.0_06\jre\lib\i18n.jar;C:\Program Files\Java\jdk1.5.0_06\jre\lib\sunrsasign.jar;C:\Program Files\Java\jdk1.5.0_06\jre\lib\jsse.jar;C:\Program Files\Java\jdk1.5.0_06\jre\lib\jce.jar;C:\Program Files\Java\jdk1.5.0_06\jre\lib\charsets.jar;C:\Program Files\Java\jdk1.5.0_06\jre\classes, sun.desktop=windows, java.vm.specification.vendor=Sun Microsystems Inc., java.runtime.version=1.5.0_06-b05, user.name=A428302, shared.loader=${catalina.base}/shared/classes,${catalina.base}/shared/lib/*.jar, jboss.bind.address=0.0.0.0, tomcat.util.buf.StringCache.byte.enabled=true, hibernate.session_factory_name=java:/appssoSessionFactory, jboss.home.dir=C:\jboss-4.0.4.CR2, user.language=en, java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, sun.boot.library.path=C:\Program Files\Java\jdk1.5.0_06\jre\bin, jboss.home.url=file:/C:/jboss-4.0.4.CR2/, java.version=1.5.0_06, user.timezone=America/New_York, jboss.server.home.dir=C:\jboss-4.0.4.CR2\server\default, sun.arch.data.model=32, java.endorsed.dirs=C:\jboss-4.0.4.CR2\bin\\..\lib\endorsed, jboss.server.home.url=file:/C:/jboss-4.0.4.CR2/server/default/, sun.cpu.isalist=, sun.jnu.encoding=Cp1252, file.encoding.pkg=sun.io, package.access=sun.,org.apache.catalina.,org.apache.coyote.,org.apache.tomcat.,org.apache.jasper.,sun.beans., file.separator=\, java.specification.name=Java Platform API Specification, hibernate.cglib.use_reflection_optimizer=true, java.class.version=49.0, jboss.server.config.url=file:/C:/jboss-4.0.4.CR2/server/default/conf/, user.country=US, java.home=C:\Program Files\Java\jdk1.5.0_06\jre, java.vm.info=mixed mode, jboss.lib.url=file:/C:/jboss-4.0.4.CR2/lib/, os.version=5.0, path.separator=;, java.vm.version=1.5.0_06-b05, hibernate.connection.password=brad123, user.variant=, java.protocol.handler.pkgs=org.jboss.net.protocol, java.awt.printerjob=sun.awt.windows.WPrinterJob, sun.io.unicode.encoding=UnicodeLittle, awt.toolkit=sun.awt.windows.WToolkit, hibernate.connection.username=brad, package.definition=sun.,java.,org.apache.catalina.,org.apache.coyote.,org.apache.tomcat.,org.apache.jasper., jboss.server.temp.dir=C:\jboss-4.0.4.CR2\server\default\tmp, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces, user.home=C:\Documents and Settings\A428302, java.rmi.server.RMIClassLoaderSpi=org.jboss.system.JBossRMIClassLoader, java.specification.vendor=Sun Microsystems Inc., hibernate.hbm2ddl.auto=update, java.library.path=C:\Program Files\Java\jdk1.5.0_06\bin;.;C:\WINNT\system32;C:\WINNT;c:\ruby\bin;C:\WINNT\system32;C:\WINNT;C:\WINNT\System32\Wbem;C:\WINNT\system32\nls;C:\WINNT\system32\nls\ENGLISH;C:\Program Files\ATI Technologies\ATI Control Panel;C:\Program Files\Common Files\Roxio Shared\DLLShared;C:\maven-1.1-beta-2\bin;C:\cygwin\bin;C:\j2sdk1.4.2_08\bin;C:\Program Files\Oracle\jre\1.1.8\bin;C:\oracle\ora92\bin\;C:\Program Files\Oracle\jre\1.1.8\bin\;C:\oracle\ora92\bin;C:\apache-ant-1.6.2\bin;C:\Program Files\Common Files\GTK\2.0\bin;C:\Program Files\Microsoft SQL Server\80\Tools\BINN;C:\Program Files\MySQL\MySQL Server 4.1\bin;C:\PROGRA~1\ATT\Graphviz\bin;;C:\Program Files\Subversion\bin;c:\Program Files\Microsoft SQL Server\90\Tools\binn\;C:\Sun\AppServer\bin;C:\DOCUME~1\A428302\LOCALS~1\Temp\sjsas_pe-8_0_0_01-windows.exe2\package;C:\WINNT\system32;C:\WINNT;C:\WINNT\System32\Wbem;C:\WINNT\system32\nls;C:\WINNT\system32\nls\ENGLISH;C:\Program Files\ATI Technologies\ATI Control Panel;C:\Program Files\Common Files\Roxio Shared\DLLShared;C:\maven-1.0.2\bin;C:\cygwin\bin;C:\j2sdk1.4.2_08\bin;C:\Program Files\Oracle\jre\1.1.8\bin;C:\oracle\ora92\bin\;C:\Program Files\Oracle\jre\1.1.8\bin\;C:\oracle\ora92\bin;C:\Program Files\MySQL\MySQL Server 4.1\bin;C:\apache-ant-1.6.2\bin;C:\j2sdk1.4.2_08\bin;C:\Program Files\SSH Communications Security\SSH Secure Shell;C:\Program Files\MySQL\MySQL Server 4.1\bin;%ANT_HOME\bin;C:\cruisecontrol-2.2.1\main\bin;C:\maven-2.0-beta-3\bin;C:\xmlbeans-2.1.0\bin;Z:.;, java.vendor.url=http://java.sun.com/, program.name=run.bat, hibernate.connection.driver_class=com.mysql.jdbc.Driver, java.vm.vendor=Sun Microsystems Inc., hibernate.dialect=org.hibernate.dialect.MySQLInnoDBDialect, common.loader=${catalina.home}/common/classes,${catalina.home}/common/i18n/*.jar,${catalina.home}/common/endorsed/*.jar,${catalina.home}/common/lib/*.jar, java.runtime.name=Java(TM) 2 Runtime Environment, Standard Edition, java.class.path=C:\Program Files\Java\jdk1.5.0_06\lib\tools.jar;C:\jboss-4.0.4.CR2\bin\\run.jar, jboss.server.log.dir=C:\jboss-4.0.4.CR2\server\default\log, jbossmx.loader.repository.class=org.jboss.mx.loading.UnifiedLoaderRepository3, java.vm.specification.name=Java Virtual Machine Specification, java.vm.specification.version=1.0, catalina.home=C:\jboss-4.0.4.CR2\server\default, sun.cpu.endian=little, sun.os.patch.level=Service Pack 4, jboss.server.lib.url=file:/C:/jboss-4.0.4.CR2/server/default/lib/, java.rmi.server.codebase=http://DEIBKST-6KZFT61:8083/, java.io.tmpdir=C:\DOCUME~1\A428302\LOCALS~1\Temp\, java.vendor.url.bug=http://java.sun.com/cgi-bin/bugreport.cgi, server.loader=${catalina.home}/server/classes,${catalina.home}/server/lib/*.jar, jboss.server.data.dir=C:\jboss-4.0.4.CR2\server\default\data, os.arch=x86, java.awt.graphicsenv=sun.awt.Win32GraphicsEnvironment, java.ext.dirs=C:\Program Files\Java\jdk1.5.0_06\jre\lib\ext, user.dir=C:\jboss-4.0.4.CR2\bin, line.separator=
              , java.vm.name=Java HotSpot(TM) Client VM, jboss.server.base.dir=C:\jboss-4.0.4.CR2\server, jboss.server.base.url=file:/C:/jboss-4.0.4.CR2/server/, javax.management.builder.initial=org.jboss.mx.server.MBeanServerBuilderImpl, file.encoding=Cp1252, catalina.ext.dirs=C:\jboss-4.0.4.CR2\server\default\lib, java.specification.version=1.5, jboss.server.name=default, hibernate.show_sql=true}
              2006-05-01 09:58:59,437 DEBUG [org.hibernate.cfg.Configuration] Preparing to build session factory with filters : {}
              2006-05-01 09:58:59,437 DEBUG [org.hibernate.cfg.AnnotationConfiguration] Execute first pass mapping processing
              2006-05-01 09:58:59,437 DEBUG [org.hibernate.cfg.AnnotationConfiguration] Process hbm files
              2006-05-01 09:58:59,437 DEBUG [org.hibernate.cfg.AnnotationConfiguration] Process annotated classes
              2006-05-01 09:58:59,531 INFO [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: com.evergreen.userlinks.orm.User
              2006-05-01 09:58:59,609 DEBUG [org.hibernate.cfg.Ejb3Column] Binding column TYPE unique false
              2006-05-01 09:58:59,656 DEBUG [org.hibernate.cfg.annotations.EntityBinder] Import with entity name=User
              2006-05-01 09:58:59,671 INFO [org.hibernate.cfg.annotations.EntityBinder] Bind entity com.evergreen.userlinks.orm.User on table user
              2006-05-01 09:58:59,687 DEBUG [org.hibernate.cfg.AnnotationBinder] Processing com.evergreen.userlinks.orm.User per property annotation
              2006-05-01 09:58:59,703 DEBUG [org.hibernate.cfg.AnnotationBinder] Processing com.evergreen.userlinks.orm.User per property annotation
              2006-05-01 09:58:59,703 DEBUG [org.hibernate.cfg.AnnotationBinder] Processing annotations of com.evergreen.userlinks.orm.User.id
              2006-05-01 09:58:59,718 DEBUG [org.hibernate.cfg.Ejb3Column] Binding column id unique false
              2006-05-01 09:58:59,718 DEBUG [org.hibernate.cfg.AnnotationBinder] id is an id
              2006-05-01 09:58:59,734 DEBUG [org.hibernate.cfg.annotations.SimpleValueBinder] building SimpleValue for id
              2006-05-01 09:58:59,734 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Building property id
              2006-05-01 09:58:59,750 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Cascading id with null
              2006-05-01 09:58:59,750 DEBUG [org.hibernate.cfg.AnnotationBinder] Bind @Id on id
              2006-05-01 09:58:59,750 DEBUG [org.hibernate.cfg.AnnotationBinder] Processing annotations of com.evergreen.userlinks.orm.User.lastUpdate
              2006-05-01 09:58:59,750 DEBUG [org.hibernate.cfg.Ejb3Column] Binding column update_date unique false
              2006-05-01 09:58:59,750 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] binding property lastUpdate with lazy=false
              2006-05-01 09:58:59,750 DEBUG [org.hibernate.cfg.annotations.SimpleValueBinder] building SimpleValue for lastUpdate
              2006-05-01 09:58:59,750 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Building property lastUpdate
              2006-05-01 09:58:59,750 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Cascading lastUpdate with null
              2006-05-01 09:58:59,750 DEBUG [org.hibernate.cfg.AnnotationBinder] Processing annotations of com.evergreen.userlinks.orm.User.createDate
              2006-05-01 09:58:59,750 DEBUG [org.hibernate.cfg.Ejb3Column] Binding column create_date unique false
              2006-05-01 09:58:59,750 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] binding property createDate with lazy=false
              2006-05-01 09:58:59,750 DEBUG [org.hibernate.cfg.annotations.SimpleValueBinder] building SimpleValue for createDate
              2006-05-01 09:58:59,750 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Building property createDate
              2006-05-01 09:58:59,750 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Cascading createDate with null
              2006-05-01 09:58:59,750 DEBUG [org.hibernate.cfg.AnnotationBinder] Processing annotations of com.evergreen.userlinks.orm.User.links
              2006-05-01 09:58:59,750 DEBUG [org.hibernate.cfg.Ejb3Column] Binding column null unique false
              2006-05-01 09:58:59,750 DEBUG [org.hibernate.cfg.Ejb3Column] Binding column links unique false
              2006-05-01 09:58:59,781 DEBUG [org.hibernate.cfg.Ejb3Column] Binding column null unique false
              2006-05-01 09:58:59,812 DEBUG [org.hibernate.cfg.Ejb3Column] Binding column null unique false
              2006-05-01 09:58:59,812 DEBUG [org.hibernate.cfg.Ejb3Column] Binding column null unique false
              2006-05-01 09:58:59,828 DEBUG [org.hibernate.cfg.annotations.CollectionBinder] Collection role: com.evergreen.userlinks.orm.User.links
              2006-05-01 09:58:59,828 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Building property links
              2006-05-01 09:58:59,828 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Cascading links with all
              2006-05-01 09:58:59,828 DEBUG [org.hibernate.cfg.AnnotationBinder] Processing annotations of com.evergreen.userlinks.orm.User.aNumber
              2006-05-01 09:58:59,828 DEBUG [org.hibernate.cfg.Ejb3Column] Binding column a_number unique true
              2006-05-01 09:58:59,828 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] binding property aNumber with lazy=false
              2006-05-01 09:58:59,828 DEBUG [org.hibernate.cfg.annotations.SimpleValueBinder] building SimpleValue for aNumber
              2006-05-01 09:58:59,828 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Building property aNumber
              2006-05-01 09:58:59,828 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Cascading aNumber with null
              2006-05-01 09:58:59,875 DEBUG [org.hibernate.validator.ClassValidator] ResourceBundle ValidatorMessages not found. Delegate to org.hibernate.validator.resources.DefaultValidatorMessages
              2006-05-01 09:58:59,890 INFO [org.hibernate.cfg.AnnotationBinder] Binding entity from annotated class: com.evergreen.userlinks.orm.Link
              2006-05-01 09:58:59,890 DEBUG [org.hibernate.cfg.Ejb3Column] Binding column TYPE unique false
              2006-05-01 09:58:59,890 DEBUG [org.hibernate.cfg.annotations.EntityBinder] Import with entity name=Link
              2006-05-01 09:58:59,890 INFO [org.hibernate.cfg.annotations.EntityBinder] Bind entity com.evergreen.userlinks.orm.Link on table link
              2006-05-01 09:58:59,890 DEBUG [org.hibernate.cfg.AnnotationBinder] Processing com.evergreen.userlinks.orm.Link per property annotation
              2006-05-01 09:58:59,890 DEBUG [org.hibernate.cfg.AnnotationBinder] Processing com.evergreen.userlinks.orm.Link per property annotation
              2006-05-01 09:58:59,890 DEBUG [org.hibernate.cfg.AnnotationBinder] Processing annotations of com.evergreen.userlinks.orm.Link.id
              2006-05-01 09:58:59,890 DEBUG [org.hibernate.cfg.Ejb3Column] Binding column id unique false
              2006-05-01 09:58:59,890 DEBUG [org.hibernate.cfg.AnnotationBinder] id is an id
              2006-05-01 09:58:59,890 DEBUG [org.hibernate.cfg.annotations.SimpleValueBinder] building SimpleValue for id
              2006-05-01 09:58:59,890 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Building property id
              2006-05-01 09:58:59,890 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Cascading id with null
              2006-05-01 09:58:59,890 DEBUG [org.hibernate.cfg.AnnotationBinder] Bind @Id on id
              2006-05-01 09:58:59,890 DEBUG [org.hibernate.cfg.AnnotationBinder] Processing annotations of com.evergreen.userlinks.orm.Link.lastUpdate
              2006-05-01 09:58:59,890 DEBUG [org.hibernate.cfg.Ejb3Column] Binding column update_date unique false
              2006-05-01 09:58:59,890 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] binding property lastUpdate with lazy=false
              2006-05-01 09:58:59,890 DEBUG [org.hibernate.cfg.annotations.SimpleValueBinder] building SimpleValue for lastUpdate
              2006-05-01 09:58:59,890 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Building property lastUpdate
              2006-05-01 09:58:59,890 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Cascading lastUpdate with null
              2006-05-01 09:58:59,890 DEBUG [org.hibernate.cfg.AnnotationBinder] Processing annotations of com.evergreen.userlinks.orm.Link.createDate
              2006-05-01 09:58:59,890 DEBUG [org.hibernate.cfg.Ejb3Column] Binding column create_date unique false
              2006-05-01 09:58:59,890 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] binding property createDate with lazy=false
              2006-05-01 09:58:59,890 DEBUG [org.hibernate.cfg.annotations.SimpleValueBinder] building SimpleValue for createDate
              2006-05-01 09:58:59,890 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Building property createDate
              2006-05-01 09:58:59,890 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Cascading createDate with null
              2006-05-01 09:58:59,890 DEBUG [org.hibernate.cfg.AnnotationBinder] Processing annotations of com.evergreen.userlinks.orm.Link.URL
              2006-05-01 09:58:59,890 DEBUG [org.hibernate.cfg.Ejb3Column] Binding column url unique false
              2006-05-01 09:58:59,890 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] binding property URL with lazy=false
              2006-05-01 09:58:59,890 DEBUG [org.hibernate.cfg.annotations.SimpleValueBinder] building SimpleValue for URL
              2006-05-01 09:58:59,890 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Building property URL
              2006-05-01 09:58:59,890 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Cascading URL with null
              2006-05-01 09:58:59,890 DEBUG [org.hibernate.cfg.AnnotationBinder] Processing annotations of com.evergreen.userlinks.orm.Link.user
              2006-05-01 09:58:59,906 DEBUG [org.hibernate.cfg.Ejb3Column] Binding column user_id unique false
              2006-05-01 09:58:59,906 DEBUG [org.hibernate.cfg.Ejb3Column] Binding column user unique false
              2006-05-01 09:58:59,906 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Building property user
              2006-05-01 09:58:59,906 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Cascading user with none
              2006-05-01 09:58:59,906 DEBUG [org.hibernate.cfg.AnnotationBinder] Processing annotations of com.evergreen.userlinks.orm.Link.title
              2006-05-01 09:58:59,906 DEBUG [org.hibernate.cfg.Ejb3Column] Binding column title unique false
              2006-05-01 09:58:59,906 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] binding property title with lazy=false
              2006-05-01 09:58:59,906 DEBUG [org.hibernate.cfg.annotations.SimpleValueBinder] building SimpleValue for title
              2006-05-01 09:58:59,906 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Building property title
              2006-05-01 09:58:59,906 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Cascading title with null
              2006-05-01 09:58:59,906 DEBUG [org.hibernate.cfg.AnnotationBinder] Processing annotations of com.evergreen.userlinks.orm.Link.rank
              2006-05-01 09:58:59,906 DEBUG [org.hibernate.cfg.Ejb3Column] Binding column rank unique false
              2006-05-01 09:58:59,906 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] binding property rank with lazy=false
              2006-05-01 09:58:59,906 DEBUG [org.hibernate.cfg.annotations.SimpleValueBinder] building SimpleValue for rank
              2006-05-01 09:58:59,906 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Building property rank
              2006-05-01 09:58:59,906 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Cascading rank with null
              2006-05-01 09:58:59,906 DEBUG [org.hibernate.validator.ClassValidator] ResourceBundle ValidatorMessages not found. Delegate to org.hibernate.validator.resources.DefaultValidatorMessages
              2006-05-01 09:58:59,906 DEBUG [org.hibernate.cfg.AnnotationConfiguration] processing manytoone fk mappings
              2006-05-01 09:59:00,046 DEBUG [org.hibernate.cfg.Configuration] processing extends queue
              2006-05-01 09:59:00,046 DEBUG [org.hibernate.cfg.Configuration] processing collection mappings
              2006-05-01 09:59:00,046 DEBUG [org.hibernate.cfg.CollectionSecondPass] Second pass for collection: com.evergreen.userlinks.orm.User.links
              2006-05-01 09:59:00,046 DEBUG [org.hibernate.cfg.annotations.CollectionBinder] Binding a OneToMany: com.evergreen.userlinks.orm.User.links through a foreign key
              2006-05-01 09:59:00,046 INFO [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: com.evergreen.userlinks.orm.User.links -> link
              2006-05-01 09:59:00,046 DEBUG [org.hibernate.cfg.annotations.TableBinder] Retrieving property com.evergreen.userlinks.orm.Link.user
              2006-05-01 09:59:00,046 DEBUG [org.hibernate.cfg.CollectionSecondPass] Mapped collection key: user_id, one-to-many: com.evergreen.userlinks.orm.Link
              2006-05-01 09:59:00,046 DEBUG [org.hibernate.cfg.Configuration] processing native query and ResultSetMapping mappings
              2006-05-01 09:59:00,046 DEBUG [org.hibernate.cfg.Configuration] processing association property references
              2006-05-01 09:59:00,046 DEBUG [org.hibernate.cfg.Configuration] processing foreign key constraints
              2006-05-01 09:59:00,046 DEBUG [org.hibernate.cfg.Configuration] resolving reference to class: com.evergreen.userlinks.orm.User
              2006-05-01 09:59:00,078 INFO [org.hibernate.connection.DriverManagerConnectionProvider] Using Hibernate built-in connection pool (not for production use!)
              2006-05-01 09:59:00,078 INFO [org.hibernate.connection.DriverManagerConnectionProvider] Hibernate connection pool size: 20
              2006-05-01 09:59:00,078 INFO [org.hibernate.connection.DriverManagerConnectionProvider] autocommit mode: false
              2006-05-01 09:59:00,078 INFO [org.hibernate.connection.DriverManagerConnectionProvider] using driver: com.mysql.jdbc.Driver at URL: jdbc:mysql://localhost/appsso
              2006-05-01 09:59:00,078 INFO [org.hibernate.connection.DriverManagerConnectionProvider] connection properties: {user=brad, password=brad123}
              2006-05-01 09:59:00,078 DEBUG [org.hibernate.connection.DriverManagerConnectionProvider] opening new JDBC connection
              2006-05-01 09:59:00,546 DEBUG [org.hibernate.connection.DriverManagerConnectionProvider] created connection to: jdbc:mysql://localhost/appsso, Isolation Level: 4
              2006-05-01 09:59:00,546 INFO [org.hibernate.cfg.SettingsFactory] RDBMS: MySQL, version: 4.1.14-nt
              2006-05-01 09:59:00,546 INFO [org.hibernate.cfg.SettingsFactory] JDBC driver: MySQL-AB JDBC Driver, version: mysql-connector-java-3.1.12 ( $Date: 2005-11-17 15:53:48 +0100 (Thu, 17 Nov 2005) $, $Revision$ )
              2006-05-01 09:59:00,578 INFO [org.hibernate.dialect.Dialect] Using dialect: org.hibernate.dialect.MySQLInnoDBDialect
              2006-05-01 09:59:00,593 INFO [org.hibernate.transaction.TransactionFactoryFactory] Using default transaction strategy (direct JDBC transactions)
              2006-05-01 09:59:00,609 INFO [org.hibernate.transaction.TransactionManagerLookupFactory] No TransactionManagerLookup configured (in JTA environment, use of read-write or transactional second-level cache is not recommended)
              2006-05-01 09:59:00,609 INFO [org.hibernate.cfg.SettingsFactory] Automatic flush during beforeCompletion(): disabled
              2006-05-01 09:59:00,609 INFO [org.hibernate.cfg.SettingsFactory] Automatic session close at end of transaction: disabled
              2006-05-01 09:59:00,609 INFO [org.hibernate.cfg.SettingsFactory] JDBC batch size: 15
              2006-05-01 09:59:00,609 INFO [org.hibernate.cfg.SettingsFactory] JDBC batch updates for versioned data: disabled
              2006-05-01 09:59:00,609 INFO [org.hibernate.cfg.SettingsFactory] Scrollable result sets: enabled
              2006-05-01 09:59:00,609 DEBUG [org.hibernate.cfg.SettingsFactory] Wrap result sets: disabled
              2006-05-01 09:59:00,609 INFO [org.hibernate.cfg.SettingsFactory] JDBC3 getGeneratedKeys(): enabled
              2006-05-01 09:59:00,609 INFO [org.hibernate.cfg.SettingsFactory] Connection release mode: auto
              2006-05-01 09:59:00,609 INFO [org.hibernate.cfg.SettingsFactory] Maximum outer join fetch depth: 2
              2006-05-01 09:59:00,609 INFO [org.hibernate.cfg.SettingsFactory] Default batch fetch size: 1
              2006-05-01 09:59:00,609 INFO [org.hibernate.cfg.SettingsFactory] Generate SQL with comments: disabled
              2006-05-01 09:59:00,609 INFO [org.hibernate.cfg.SettingsFactory] Order SQL updates by primary key: disabled
              2006-05-01 09:59:00,609 INFO [org.hibernate.cfg.SettingsFactory] Query translator: org.hibernate.hql.ast.ASTQueryTranslatorFactory
              2006-05-01 09:59:00,609 INFO [org.hibernate.hql.ast.ASTQueryTranslatorFactory] Using ASTQueryTranslatorFactory
              2006-05-01 09:59:00,609 INFO [org.hibernate.cfg.SettingsFactory] Query language substitutions: {}
              2006-05-01 09:59:00,609 INFO [org.hibernate.cfg.SettingsFactory] Second-level cache: enabled
              2006-05-01 09:59:00,609 INFO [org.hibernate.cfg.SettingsFactory] Query cache: disabled
              2006-05-01 09:59:00,609 INFO [org.hibernate.cfg.SettingsFactory] Cache provider: org.hibernate.cache.EhCacheProvider
              2006-05-01 09:59:00,625 INFO [org.hibernate.cfg.SettingsFactory] Optimize cache for minimal puts: disabled
              2006-05-01 09:59:00,625 INFO [org.hibernate.cfg.SettingsFactory] Structured second-level cache entries: disabled
              2006-05-01 09:59:00,640 INFO [org.hibernate.cfg.SettingsFactory] Echoing all SQL to stdout
              2006-05-01 09:59:00,640 INFO [org.hibernate.cfg.SettingsFactory] Statistics: disabled
              2006-05-01 09:59:00,640 INFO [org.hibernate.cfg.SettingsFactory] Deleted entity synthetic identifier rollback: disabled
              2006-05-01 09:59:00,640 INFO [org.hibernate.cfg.SettingsFactory] Default entity-mode: pojo
              2006-05-01 09:59:00,718 INFO [org.hibernate.impl.SessionFactoryImpl] building session factory
              2006-05-01 09:59:00,718 DEBUG [org.hibernate.impl.SessionFactoryImpl] Session factory constructed with filter configurations : {}
              2006-05-01 09:59:00,718 DEBUG [org.hibernate.impl.SessionFactoryImpl] instantiating session factory with properties: {java.vendor=Sun Microsystems Inc., catalina.base=C:\jboss-4.0.4.CR2\server\default, hibernate.connection.url=jdbc:mysql://localhost/appsso, sun.management.compiler=HotSpot Client Compiler, catalina.useNaming=false, os.name=Windows 2000, hbm2ddl.auto=update, sun.boot.class.path=C:\jboss-4.0.4.CR2\bin\\..\lib\endorsed\resolver.jar;C:\jboss-4.0.4.CR2\bin\\..\lib\endorsed\serializer.jar;C:\jboss-4.0.4.CR2\bin\\..\lib\endorsed\xalan.jar;C:\jboss-4.0.4.CR2\bin\\..\lib\endorsed\xercesImpl.jar;C:\jboss-4.0.4.CR2\bin\\..\lib\endorsed\xml-apis.jar;C:\Program Files\Java\jdk1.5.0_06\jre\lib\rt.jar;C:\Program Files\Java\jdk1.5.0_06\jre\lib\i18n.jar;C:\Program Files\Java\jdk1.5.0_06\jre\lib\sunrsasign.jar;C:\Program Files\Java\jdk1.5.0_06\jre\lib\jsse.jar;C:\Program Files\Java\jdk1.5.0_06\jre\lib\jce.jar;C:\Program Files\Java\jdk1.5.0_06\jre\lib\charsets.jar;C:\Program Files\Java\jdk1.5.0_06\jre\classes, sun.desktop=windows, java.vm.specification.vendor=Sun Microsystems Inc., java.runtime.version=1.5.0_06-b05, user.name=A428302, shared.loader=${catalina.base}/shared/classes,${catalina.base}/shared/lib/*.jar, jboss.bind.address=0.0.0.0, tomcat.util.buf.StringCache.byte.enabled=true, hibernate.session_factory_name=java:/appssoSessionFactory, jboss.home.dir=C:\jboss-4.0.4.CR2, user.language=en, java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, sun.boot.library.path=C:\Program Files\Java\jdk1.5.0_06\jre\bin, hibernate.jndi.java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, jboss.home.url=file:/C:/jboss-4.0.4.CR2/, java.version=1.5.0_06, user.timezone=America/New_York, jboss.server.home.dir=C:\jboss-4.0.4.CR2\server\default, sun.arch.data.model=32, java.endorsed.dirs=C:\jboss-4.0.4.CR2\bin\\..\lib\endorsed, jboss.server.home.url=file:/C:/jboss-4.0.4.CR2/server/default/, sun.cpu.isalist=, sun.jnu.encoding=Cp1252, file.encoding.pkg=sun.io, package.access=sun.,org.apache.catalina.,org.apache.coyote.,org.apache.tomcat.,org.apache.jasper.,sun.beans., file.separator=\, java.specification.name=Java Platform API Specification, hibernate.cglib.use_reflection_optimizer=true, java.class.version=49.0, jboss.server.config.url=file:/C:/jboss-4.0.4.CR2/server/default/conf/, user.country=US, java.home=C:\Program Files\Java\jdk1.5.0_06\jre, java.vm.info=mixed mode, jboss.lib.url=file:/C:/jboss-4.0.4.CR2/lib/, os.version=5.0, hibernate.jndi.java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces, path.separator=;, java.vm.version=1.5.0_06-b05, hibernate.connection.password=brad123, user.variant=, java.protocol.handler.pkgs=org.jboss.net.protocol, java.awt.printerjob=sun.awt.windows.WPrinterJob, sun.io.unicode.encoding=UnicodeLittle, awt.toolkit=sun.awt.windows.WToolkit, hibernate.connection.username=brad, package.definition=sun.,java.,org.apache.catalina.,org.apache.coyote.,org.apache.tomcat.,org.apache.jasper., jboss.server.temp.dir=C:\jboss-4.0.4.CR2\server\default\tmp, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces, user.home=C:\Documents and Settings\A428302, java.rmi.server.RMIClassLoaderSpi=org.jboss.system.JBossRMIClassLoader, java.specification.vendor=Sun Microsystems Inc., hibernate.hbm2ddl.auto=update, java.library.path=C:\Program Files\Java\jdk1.5.0_06\bin;.;C:\WINNT\system32;C:\WINNT;c:\ruby\bin;C:\WINNT\system32;C:\WINNT;C:\WINNT\System32\Wbem;C:\WINNT\system32\nls;C:\WINNT\system32\nls\ENGLISH;C:\Program Files\ATI Technologies\ATI Control Panel;C:\Program Files\Common Files\Roxio Shared\DLLShared;C:\maven-1.1-beta-2\bin;C:\cygwin\bin;C:\j2sdk1.4.2_08\bin;C:\Program Files\Oracle\jre\1.1.8\bin;C:\oracle\ora92\bin\;C:\Program Files\Oracle\jre\1.1.8\bin\;C:\oracle\ora92\bin;C:\apache-ant-1.6.2\bin;C:\Program Files\Common Files\GTK\2.0\bin;C:\Program Files\Microsoft SQL Server\80\Tools\BINN;C:\Program Files\MySQL\MySQL Server 4.1\bin;C:\PROGRA~1\ATT\Graphviz\bin;;C:\Program Files\Subversion\bin;c:\Program Files\Microsoft SQL Server\90\Tools\binn\;C:\Sun\AppServer\bin;C:\DOCUME~1\A428302\LOCALS~1\Temp\sjsas_pe-8_0_0_01-windows.exe2\package;C:\WINNT\system32;C:\WINNT;C:\WINNT\System32\Wbem;C:\WINNT\system32\nls;C:\WINNT\system32\nls\ENGLISH;C:\Program Files\ATI Technologies\ATI Control Panel;C:\Program Files\Common Files\Roxio Shared\DLLShared;C:\maven-1.0.2\bin;C:\cygwin\bin;C:\j2sdk1.4.2_08\bin;C:\Program Files\Oracle\jre\1.1.8\bin;C:\oracle\ora92\bin\;C:\Program Files\Oracle\jre\1.1.8\bin\;C:\oracle\ora92\bin;C:\Program Files\MySQL\MySQL Server 4.1\bin;C:\apache-ant-1.6.2\bin;C:\j2sdk1.4.2_08\bin;C:\Program Files\SSH Communications Security\SSH Secure Shell;C:\Program Files\MySQL\MySQL Server 4.1\bin;%ANT_HOME\bin;C:\cruisecontrol-2.2.1\main\bin;C:\maven-2.0-beta-3\bin;C:\xmlbeans-2.1.0\bin;Z:.;, java.vendor.url=http://java.sun.com/, program.name=run.bat, hibernate.connection.driver_class=com.mysql.jdbc.Driver, java.vm.vendor=Sun Microsystems Inc., hibernate.dialect=org.hibernate.dialect.MySQLInnoDBDialect, common.loader=${catalina.home}/common/classes,${catalina.home}/common/i18n/*.jar,${catalina.home}/common/endorsed/*.jar,${catalina.home}/common/lib/*.jar, java.runtime.name=Java(TM) 2 Runtime Environment, Standard Edition, java.class.path=C:\Program Files\Java\jdk1.5.0_06\lib\tools.jar;C:\jboss-4.0.4.CR2\bin\\run.jar, jboss.server.log.dir=C:\jboss-4.0.4.CR2\server\default\log, jbossmx.loader.repository.class=org.jboss.mx.loading.UnifiedLoaderRepository3, java.vm.specification.name=Java Virtual Machine Specification, catalina.home=C:\jboss-4.0.4.CR2\server\default, java.vm.specification.version=1.0, jboss.server.lib.url=file:/C:/jboss-4.0.4.CR2/server/default/lib/, sun.os.patch.level=Service Pack 4, sun.cpu.endian=little, java.io.tmpdir=C:\DOCUME~1\A428302\LOCALS~1\Temp\, java.rmi.server.codebase=http://DEIBKST-6KZFT61:8083/, java.vendor.url.bug=http://java.sun.com/cgi-bin/bugreport.cgi, server.loader=${catalina.home}/server/classes,${catalina.home}/server/lib/*.jar, jboss.server.data.dir=C:\jboss-4.0.4.CR2\server\default\data, java.awt.graphicsenv=sun.awt.Win32GraphicsEnvironment, os.arch=x86, java.ext.dirs=C:\Program Files\Java\jdk1.5.0_06\jre\lib\ext, user.dir=C:\jboss-4.0.4.CR2\bin, line.separator=
              , java.vm.name=Java HotSpot(TM) Client VM, jboss.server.base.dir=C:\jboss-4.0.4.CR2\server, jboss.server.base.url=file:/C:/jboss-4.0.4.CR2/server/, javax.management.builder.initial=org.jboss.mx.server.MBeanServerBuilderImpl, file.encoding=Cp1252, catalina.ext.dirs=C:\jboss-4.0.4.CR2\server\default\lib, java.specification.version=1.5, jboss.server.name=default, hibernate.show_sql=true}
              2006-05-01 09:59:00,734 DEBUG [net.sf.ehcache.CacheManager] Creating new CacheManager with default config
              2006-05-01 09:59:00,734 DEBUG [net.sf.ehcache.CacheManager] Configuring ehcache from classpath.
              2006-05-01 09:59:00,750 WARN [net.sf.ehcache.config.Configurator] No configuration found. Configuring ehcache from ehcache-failsafe.xml found in the classpath: jar:file:/C:/jboss-4.0.4.CR2/server/default/tmp/deploy/tm


              • 4. Re: Problem with Injection / Outjection
                gavin.king

                OK, that much looks fine.

                • 5. Re: Problem with Injection / Outjection

                  Part 2)

                  stack trace of the call to the UserLinkActions() constructor

                  and
                  Part 3)
                  A stack trave of the call to getUserLinks()


                  10:08:13,234 INFO [User] new User()
                  10:08:13,296 INFO [UserLinkActions] new UserLinkActions()
                  10:08:13,296 ERROR [STDERR] java.lang.Exception
                  10:08:13,296 ERROR [STDERR] at com.evergreen.userlinks.biz.UserLinkActions.<init>(UserLinkActions.java:56)
                  10:08:13,296 ERROR [STDERR] at com.evergreen.userlinks.biz.UserLinkActions$$EnhancerByCGLIB$$8b2f8ae1.<init>(<generated>)
                  10:08:13,296 ERROR [STDERR] at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
                  10:08:13,296 ERROR [STDERR] at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:39)
                  10:08:13,296 ERROR [STDERR] at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:27)
                  10:08:13,296 ERROR [STDERR] at java.lang.reflect.Constructor.newInstance(Constructor.java:494)
                  10:08:13,296 ERROR [STDERR] at java.lang.Class.newInstance0(Class.java:350)
                  10:08:13,296 ERROR [STDERR] at java.lang.Class.newInstance(Class.java:303)
                  10:08:13,296 ERROR [STDERR] at org.jboss.seam.Component.instantiate(Component.java:670)
                  10:08:13,296 ERROR [STDERR] at org.jboss.seam.Component.newInstance(Component.java:634)
                  10:08:13,296 ERROR [STDERR] at org.jboss.seam.Component.newInstance(Component.java:1156)
                  10:08:13,296 ERROR [STDERR] at org.jboss.seam.Component.getInstance(Component.java:1107)
                  10:08:13,296 ERROR [STDERR] at org.jboss.seam.Component.getInstance(Component.java:1090)
                  10:08:13,296 ERROR [STDERR] at org.jboss.seam.Component.getInstanceFromFactory(Component.java:1140)
                  10:08:13,296 ERROR [STDERR] at org.jboss.seam.Component.getInstance(Component.java:1104)
                  10:08:13,296 ERROR [STDERR] at org.jboss.seam.Component.getInstance(Component.java:1090)
                  10:08:13,296 ERROR [STDERR] at org.jboss.seam.jsf.SeamVariableResolver.resolveVariable(SeamVariableResolver.java:44)
                  10:08:13,312 ERROR [STDERR] at com.sun.facelets.el.LegacyELContext$LegacyELResolver.getValue(LegacyELContext.java:134)
                  10:08:13,312 ERROR [STDERR] at com.sun.el.parser.AstIdentifier.getValue(AstIdentifier.java:65)
                  10:08:13,312 ERROR [STDERR] at com.sun.el.ValueExpressionImpl.getValue(ValueExpressionImpl.java:192)
                  10:08:13,312 ERROR [STDERR] at com.sun.facelets.el.ELText$ELTextVariable.writeText(ELText.java:184)
                  10:08:13,312 ERROR [STDERR] at com.sun.facelets.el.ELText$ELTextComposite.writeText(ELText.java:108)
                  10:08:13,312 ERROR [STDERR] at com.sun.facelets.compiler.TextInstruction.write(TextInstruction.java:45)
                  10:08:13,312 ERROR [STDERR] at com.sun.facelets.compiler.UIInstructions.encodeBegin(UIInstructions.java:39)
                  10:08:13,312 ERROR [STDERR] at com.sun.facelets.tag.jsf.ComponentSupport.encodeRecursive(ComponentSupport.java:232)
                  10:08:13,312 ERROR [STDERR] at com.sun.facelets.tag.jsf.ComponentSupport.encodeRecursive(ComponentSupport.java:239)
                  10:08:13,312 ERROR [STDERR] at com.sun.facelets.FaceletViewHandler.renderView(FaceletViewHandler.java:554)
                  10:08:13,312 ERROR [STDERR] at com.sun.faces.lifecycle.RenderResponsePhase.execute(RenderResponsePhase.java:87)
                  10:08:13,312 ERROR [STDERR] at com.sun.faces.lifecycle.LifecycleImpl.phase(LifecycleImpl.java:200)
                  10:08:13,312 ERROR [STDERR] at com.sun.faces.lifecycle.LifecycleImpl.render(LifecycleImpl.java:117)
                  10:08:13,312 ERROR [STDERR] at javax.faces.webapp.FacesServlet.service(FacesServlet.java:198)
                  10:08:13,312 ERROR [STDERR] at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:252)
                  10:08:13,312 ERROR [STDERR] at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:173)
                  10:08:13,312 ERROR [STDERR] at edu.yale.its.tp.cas.client.filter.CASFilter.doFilter(CASFilter.java:565)
                  10:08:13,312 ERROR [STDERR] at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:202)
                  10:08:13,312 ERROR [STDERR] at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:173)
                  10:08:13,312 ERROR [STDERR] at org.jboss.seam.servlet.SeamExceptionFilter.doFilter(SeamExceptionFilter.java:45)
                  10:08:13,312 ERROR [STDERR] at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:202)
                  10:08:13,328 ERROR [STDERR] at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:173)
                  10:08:13,328 ERROR [STDERR] at org.jboss.seam.servlet.SeamRedirectFilter.doFilter(SeamRedirectFilter.java:23)
                  10:08:13,328 ERROR [STDERR] at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:202)
                  10:08:13,328 ERROR [STDERR] at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:173)
                  10:08:13,328 ERROR [STDERR] at org.jboss.web.tomcat.filters.ReplyHeaderFilter.doFilter(ReplyHeaderFilter.java:96)
                  10:08:13,328 ERROR [STDERR] at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:202)
                  10:08:13,328 ERROR [STDERR] at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:173)
                  10:08:13,328 ERROR [STDERR] at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:213)
                  10:08:13,328 ERROR [STDERR] at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:178)
                  10:08:13,328 ERROR [STDERR] at org.jboss.web.tomcat.security.CustomPrincipalValve.invoke(CustomPrincipalValve.java:54)
                  10:08:13,328 ERROR [STDERR] at org.jboss.web.tomcat.security.SecurityAssociationValve.invoke(SecurityAssociationValve.java:174)
                  10:08:13,328 ERROR [STDERR] at org.jboss.web.tomcat.security.JaccContextValve.invoke(JaccContextValve.java:74)
                  10:08:13,328 ERROR [STDERR] at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:126)
                  10:08:13,328 ERROR [STDERR] at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:105)
                  10:08:13,328 ERROR [STDERR] at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:107)
                  10:08:13,328 ERROR [STDERR] at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:148)
                  10:08:13,328 ERROR [STDERR] at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:869)
                  10:08:13,328 ERROR [STDERR] at org.apache.coyote.http11.Http11BaseProtocol$Http11ConnectionHandler.processConnection(Http11BaseProtocol.java:664)
                  10:08:13,343 ERROR [STDERR] at org.apache.tomcat.util.net.PoolTcpEndpoint.processSocket(PoolTcpEndpoint.java:527)
                  10:08:13,343 ERROR [STDERR] at org.apache.tomcat.util.net.MasterSlaveWorkerThread.run(MasterSlaveWorkerThread.java:112)
                  10:08:13,343 ERROR [STDERR] at java.lang.Thread.run(Thread.java:595)
                  10:08:13,343 INFO [UserLinkActions] getUserLinks() - (in) user = null
                  10:08:13,343 INFO [UserLinkActions] getUserLinks() - (in) ssoPrincipal = null
                  10:08:13,343 INFO [UserLinkActions] getUserLinks() - (in) appssoDB = null
                  10:08:13,343 INFO [UserLinkActions] getUserLinks() - (in) sessionContext = null
                  10:08:13,343 INFO [UserLinkActions] getUserLinks() - (in) facesMessages = null
                  10:08:13,343 ERROR [STDERR] java.lang.Exception
                  10:08:13,343 ERROR [STDERR] at com.evergreen.userlinks.biz.UserLinkActions.getUserLinks(UserLinkActions.java:66)
                  10:08:13,343 ERROR [STDERR] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
                  10:08:13,343 ERROR [STDERR] at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
                  10:08:13,343 ERROR [STDERR] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
                  10:08:13,343 ERROR [STDERR] at java.lang.reflect.Method.invoke(Method.java:585)
                  10:08:13,359 ERROR [STDERR] at org.jboss.seam.util.Reflections.invoke(Reflections.java:13)
                  10:08:13,359 ERROR [STDERR] at org.jboss.seam.util.Reflections.invokeAndWrap(Reflections.java:32)
                  10:08:13,359 ERROR [STDERR] at org.jboss.seam.Component.callComponentMethod(Component.java:1182)
                  10:08:13,359 ERROR [STDERR] at org.jboss.seam.Component.getInstanceFromFactory(Component.java:1141)
                  10:08:13,359 ERROR [STDERR] at org.jboss.seam.Component.getInstance(Component.java:1104)
                  10:08:13,359 ERROR [STDERR] at org.jboss.seam.Component.getInstance(Component.java:1090)
                  10:08:13,359 ERROR [STDERR] at org.jboss.seam.jsf.SeamVariableResolver.resolveVariable(SeamVariableResolver.java:44)
                  10:08:13,359 ERROR [STDERR] at com.sun.facelets.el.LegacyELContext$LegacyELResolver.getValue(LegacyELContext.java:134)
                  10:08:13,359 ERROR [STDERR] at com.sun.el.parser.AstIdentifier.getValue(AstIdentifier.java:65)
                  10:08:13,359 ERROR [STDERR] at com.sun.el.ValueExpressionImpl.getValue(ValueExpressionImpl.java:192)
                  10:08:13,359 ERROR [STDERR] at com.sun.facelets.el.ELText$ELTextVariable.writeText(ELText.java:184)
                  10:08:13,359 ERROR [STDERR] at com.sun.facelets.el.ELText$ELTextComposite.writeText(ELText.java:108)
                  10:08:13,359 ERROR [STDERR] at com.sun.facelets.compiler.TextInstruction.write(TextInstruction.java:45)
                  10:08:13,359 ERROR [STDERR] at com.sun.facelets.compiler.UIInstructions.encodeBegin(UIInstructions.java:39)
                  10:08:13,359 ERROR [STDERR] at com.sun.facelets.tag.jsf.ComponentSupport.encodeRecursive(ComponentSupport.java:232)
                  10:08:13,359 ERROR [STDERR] at com.sun.facelets.tag.jsf.ComponentSupport.encodeRecursive(ComponentSupport.java:239)
                  10:08:13,359 ERROR [STDERR] at com.sun.facelets.FaceletViewHandler.renderView(FaceletViewHandler.java:554)
                  10:08:13,359 ERROR [STDERR] at com.sun.faces.lifecycle.RenderResponsePhase.execute(RenderResponsePhase.java:87)
                  10:08:13,359 ERROR [STDERR] at com.sun.faces.lifecycle.LifecycleImpl.phase(LifecycleImpl.java:200)
                  10:08:13,375 ERROR [STDERR] at com.sun.faces.lifecycle.LifecycleImpl.render(LifecycleImpl.java:117)
                  10:08:13,375 ERROR [STDERR] at javax.faces.webapp.FacesServlet.service(FacesServlet.java:198)
                  10:08:13,375 ERROR [STDERR] at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:252)
                  10:08:13,375 ERROR [STDERR] at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:173)
                  10:08:13,375 ERROR [STDERR] at edu.yale.its.tp.cas.client.filter.CASFilter.doFilter(CASFilter.java:565)
                  10:08:13,375 ERROR [STDERR] at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:202)
                  10:08:13,375 ERROR [STDERR] at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:173)
                  10:08:13,375 ERROR [STDERR] at org.jboss.seam.servlet.SeamExceptionFilter.doFilter(SeamExceptionFilter.java:45)
                  10:08:13,375 ERROR [STDERR] at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:202)
                  10:08:13,375 ERROR [STDERR] at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:173)
                  10:08:13,375 ERROR [STDERR] at org.jboss.seam.servlet.SeamRedirectFilter.doFilter(SeamRedirectFilter.java:23)
                  10:08:13,375 ERROR [STDERR] at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:202)
                  10:08:13,375 ERROR [STDERR] at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:173)
                  10:08:13,375 ERROR [STDERR] at org.jboss.web.tomcat.filters.ReplyHeaderFilter.doFilter(ReplyHeaderFilter.java:96)
                  10:08:13,375 ERROR [STDERR] at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:202)
                  10:08:13,375 ERROR [STDERR] at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:173)
                  10:08:13,375 ERROR [STDERR] at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:213)
                  10:08:13,375 ERROR [STDERR] at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:178)
                  10:08:13,390 ERROR [STDERR] at org.jboss.web.tomcat.security.CustomPrincipalValve.invoke(CustomPrincipalValve.java:54)
                  10:08:13,390 ERROR [STDERR] at org.jboss.web.tomcat.security.SecurityAssociationValve.invoke(SecurityAssociationValve.java:174)
                  10:08:13,390 ERROR [STDERR] at org.jboss.web.tomcat.security.JaccContextValve.invoke(JaccContextValve.java:74)
                  10:08:13,390 ERROR [STDERR] at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:126)
                  10:08:13,390 ERROR [STDERR] at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:105)
                  10:08:13,390 ERROR [STDERR] at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:107)
                  10:08:13,390 ERROR [STDERR] at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:148)
                  10:08:13,390 ERROR [STDERR] at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:869)
                  10:08:13,390 ERROR [STDERR] at org.apache.coyote.http11.Http11BaseProtocol$Http11ConnectionHandler.processConnection(Http11BaseProtocol.java:664)
                  10:08:13,390 ERROR [STDERR] at org.apache.tomcat.util.net.PoolTcpEndpoint.processSocket(PoolTcpEndpoint.java:527)
                  10:08:13,390 ERROR [STDERR] at org.apache.tomcat.util.net.MasterSlaveWorkerThread.run(MasterSlaveWorkerThread.java:112)
                  10:08:13,390 ERROR [STDERR] at java.lang.Thread.run(Thread.java:595)
                  


                  • 6. Re: Problem with GET request and Injection / Outjection

                    this is a better title for this problem...

                    • 7. Re: Problem with Injection / Outjection

                      Another bit of data on this issue....

                      10:37:11,052 INFO [CASFilter] EvergreenSSOPrincipal{userid=A42...}
                      10:37:11,145 INFO [Pages] reading pages.xml
                      10:37:12,302 ERROR [STDERR] May 2, 2006 10:37:12 AM com.sun.facelets.compiler.TagLibraryConfig loadImplicit
                      INFO: Added Library from: jar:file:/C:/jboss-4.0.4.CR2/server/default/tmp/deploy/tmp27602userlinks-exp.war/WEB-INF/lib/jsf-facelets-1.1.5M.jar!/META-INF/jsf-ui.tagl
                      10:37:12,333 ERROR [STDERR] May 2, 2006 10:37:12 AM com.sun.facelets.compiler.TagLibraryConfig loadImplicit
                      INFO: Added Library from: jar:file:/C:/jboss-4.0.4.CR2/server/default/tmp/deploy/tmp27602userlinks-exp.war/WEB-INF/lib/jsf-facelets-1.1.5M.jar!/META-INF/jsf-core.ta
                      10:37:12,348 ERROR [STDERR] May 2, 2006 10:37:12 AM com.sun.facelets.compiler.TagLibraryConfig loadImplicit
                      INFO: Added Library from: jar:file:/C:/jboss-4.0.4.CR2/server/default/tmp/deploy/tmp27602userlinks-exp.war/WEB-INF/lib/jsf-facelets-1.1.5M.jar!/META-INF/jstl-fn.tag
                      10:37:12,380 ERROR [STDERR] May 2, 2006 10:37:12 AM com.sun.facelets.compiler.TagLibraryConfig loadImplicit
                      INFO: Added Library from: jar:file:/C:/jboss-4.0.4.CR2/server/default/tmp/deploy/tmp27602userlinks-exp.war/WEB-INF/lib/jsf-facelets-1.1.5M.jar!/META-INF/jstl-core.t
                      10:37:12,395 ERROR [STDERR] May 2, 2006 10:37:12 AM com.sun.facelets.compiler.TagLibraryConfig loadImplicit
                      INFO: Added Library from: jar:file:/C:/jboss-4.0.4.CR2/server/default/tmp/deploy/tmp27602userlinks-exp.war/WEB-INF/lib/jsf-facelets-1.1.5M.jar!/META-INF/jsf-html.ta
                      10:37:42,709 INFO [UserLinkActions] new UserLinkActions()
                      10:37:42,709 ERROR [STDERR] java.lang.Exception
                      10:37:42,709 ERROR [STDERR] at com.evergreen.userlinks.biz.UserLinkActions.<init>(UserLinkActions.java:57)
                      10:37:42,709 ERROR [STDERR] at com.evergreen.userlinks.biz.UserLinkActions$$EnhancerByCGLIB$$58c91f85.<init>(<generated>)
                      10:37:42,709 ERROR [STDERR] at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
                      10:37:42,709 ERROR [STDERR] at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:39)
                      10:37:42,709 ERROR [STDERR] at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:27)
                      10:37:42,709 ERROR [STDERR] at java.lang.reflect.Constructor.newInstance(Constructor.java:494)
                      10:37:42,709 ERROR [STDERR] at java.lang.Class.newInstance0(Class.java:350)
                      10:37:42,709 ERROR [STDERR] at java.lang.Class.newInstance(Class.java:303)
                      10:37:42,709 ERROR [STDERR] at org.jboss.seam.Component.instantiate(Component.java:640)
                      10:37:42,709 ERROR [STDERR] at org.jboss.seam.Component.newInstance(Component.java:604)
                      10:37:42,709 ERROR [STDERR] at org.jboss.seam.Component.newInstance(Component.java:1117)
                      10:37:42,709 ERROR [STDERR] at org.jboss.seam.Component.getInstance(Component.java:1068)
                      10:37:42,709 ERROR [STDERR] at org.jboss.seam.Component.getInstance(Component.java:1051)
                      10:37:42,709 ERROR [STDERR] at org.jboss.seam.Component.getInstanceFromFactory(Component.java:1101)
                      10:37:42,709 ERROR [STDERR] at org.jboss.seam.Component.getInstance(Component.java:1065)
                      10:37:42,709 ERROR [STDERR] at org.jboss.seam.Component.getInstance(Component.java:1051)
                      10:37:42,709 ERROR [STDERR] at org.jboss.seam.jsf.SeamVariableResolver.resolveVariable(SeamVariableResolver.java:44)
                      10:37:42,709 ERROR [STDERR] at com.sun.facelets.el.LegacyELContext$LegacyELResolver.getValue(LegacyELContext.java:134)
                      10:37:42,709 ERROR [STDERR] at com.sun.el.parser.AstIdentifier.getValue(AstIdentifier.java:65)
                      10:37:42,709 ERROR [STDERR] at com.sun.el.ValueExpressionImpl.getValue(ValueExpressionImpl.java:192)
                      10:37:42,709 ERROR [STDERR] at com.sun.facelets.el.ELText$ELTextVariable.writeText(ELText.java:184)
                      10:37:42,709 ERROR [STDERR] at com.sun.facelets.el.ELText$ELTextComposite.writeText(ELText.java:108)
                      10:37:42,709 ERROR [STDERR] at com.sun.facelets.compiler.TextInstruction.write(TextInstruction.java:45)
                      10:37:42,709 ERROR [STDERR] at com.sun.facelets.compiler.UIInstructions.encodeBegin(UIInstructions.java:39)
                      10:37:42,709 ERROR [STDERR] at com.sun.facelets.tag.jsf.ComponentSupport.encodeRecursive(ComponentSupport.java:232)
                      10:37:42,709 ERROR [STDERR] at com.sun.facelets.tag.jsf.ComponentSupport.encodeRecursive(ComponentSupport.java:239)
                      10:37:42,709 ERROR [STDERR] at com.sun.facelets.FaceletViewHandler.renderView(FaceletViewHandler.java:554)
                      10:37:42,709 ERROR [STDERR] at com.sun.faces.lifecycle.RenderResponsePhase.execute(RenderResponsePhase.java:87)
                      10:37:42,709 ERROR [STDERR] at com.sun.faces.lifecycle.LifecycleImpl.phase(LifecycleImpl.java:200)
                      10:37:42,709 ERROR [STDERR] at com.sun.faces.lifecycle.LifecycleImpl.render(LifecycleImpl.java:117)
                      10:37:42,709 ERROR [STDERR] at javax.faces.webapp.FacesServlet.service(FacesServlet.java:198)
                      10:37:42,709 ERROR [STDERR] at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:252)
                      10:37:42,709 ERROR [STDERR] at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:173)
                      10:37:42,709 ERROR [STDERR] at org.jboss.seam.servlet.SeamExceptionFilter.doFilter(SeamExceptionFilter.java:45)
                      10:37:42,709 ERROR [STDERR] at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:202)
                      10:37:42,709 ERROR [STDERR] at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:173)
                      10:37:42,709 ERROR [STDERR] at org.jboss.seam.servlet.SeamRedirectFilter.doFilter(SeamRedirectFilter.java:23)
                      10:37:42,709 ERROR [STDERR] at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:202)
                      10:37:42,709 ERROR [STDERR] at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:173)
                      10:37:42,709 ERROR [STDERR] at edu.yale.its.tp.cas.client.filter.CASFilter.doFilter(CASFilter.java:441)
                      10:37:42,709 ERROR [STDERR] at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:202)
                      10:37:42,709 ERROR [STDERR] at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:173)
                      10:37:42,709 ERROR [STDERR] at org.jboss.web.tomcat.filters.ReplyHeaderFilter.doFilter(ReplyHeaderFilter.java:96)
                      10:37:42,709 ERROR [STDERR] at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:202)
                      10:37:42,709 ERROR [STDERR] at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:173)
                      10:37:42,709 ERROR [STDERR] at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:213)
                      10:37:42,709 ERROR [STDERR] at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:178)
                      10:37:42,709 ERROR [STDERR] at org.jboss.web.tomcat.security.CustomPrincipalValve.invoke(CustomPrincipalValve.java:54)
                      10:37:42,709 ERROR [STDERR] at org.jboss.web.tomcat.security.SecurityAssociationValve.invoke(SecurityAssociationValve.java:174)
                      10:37:42,709 ERROR [STDERR] at org.jboss.web.tomcat.security.JaccContextValve.invoke(JaccContextValve.java:74)
                      10:37:42,709 ERROR [STDERR] at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:126)
                      10:37:42,709 ERROR [STDERR] at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:105)
                      10:37:42,709 ERROR [STDERR] at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:107)
                      10:37:42,709 ERROR [STDERR] at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:148)
                      10:37:42,709 ERROR [STDERR] at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:869)
                      10:37:42,709 ERROR [STDERR] at org.apache.coyote.http11.Http11BaseProtocol$Http11ConnectionHandler.processConnection(Http11BaseProtocol.java:664)
                      10:37:42,709 ERROR [STDERR] at org.apache.tomcat.util.net.PoolTcpEndpoint.processSocket(PoolTcpEndpoint.java:527)
                      10:37:42,709 ERROR [STDERR] at org.apache.tomcat.util.net.MasterSlaveWorkerThread.run(MasterSlaveWorkerThread.java:112)
                      10:37:42,709 ERROR [STDERR] at java.lang.Thread.run(Thread.java:595)
                      10:37:42,724 INFO [UserLinkActions] @Create -> UserLinkActions.createComponent()
                      10:37:42,724 INFO [UserLinkActions] Object with key 'com.evergreen.sso.SSOData' is not available in SessionContext.
                      10:37:42,724 INFO [UserLinkActions] Context Components:
                      10:37:42,724 INFO [UserLinkActions] Context.isActive -> true
                      10:37:42,724 INFO [UserLinkActions] Context.type -> SESSION
                      10:37:42,724 INFO [UserLinkActions] Name = 'localeSelector', Value = org.jboss.seam.core.LocaleSelector@904497
                      10:37:42,724 INFO [UserLinkActions] getUserLinks() - (in) user = null
                      10:37:42,724 INFO [UserLinkActions] getUserLinks() - (in) ssoPrincipal = null
                      10:37:42,724 INFO [UserLinkActions] getUserLinks() - (in) appssoDB = null
                      10:37:42,724 INFO [UserLinkActions] getUserLinks() - (in) sessionContext = org.jboss.seam.contexts.WebSessionContext@832226
                      10:37:42,724 INFO [UserLinkActions] getUserLinks() - (in) facesMessages = null
                      


                      Here is the sequence of what occurs in this log:

                      1.) CASFilter Processing of request:
                      a.) CASFilter processes all requests ( /* )
                      b.) CASFilter injects an object, SSOData into the HttpSession.
                      c.) CASFilter wraps the ServletRequest (HttpServletRequestWrapper)

                      2.) Request Processing proceeds to FacesServlet and Seam
                      - I have pages.xml setup with action="#{userLinkActions.getUserLinks}" for /main.xhtml

                      - Out of curiosity, I added the @Create annotation to a method; you can see that in the log trace above.
                      - in my (@Create) createComponent() impl, I get a handle to the SessionContext from Contexts and iterate through the attributes of the session. Notice that the only attribute in the session is the localeSelector, but in the CASFilter which took a crack at the request first, I added an object to the session - So where is this object?

                      3.) Furthermore, Seam is still not firing the @In annotations on my component.

                      this is a bit frustrating :-(

                      Thanks,

                      • 8. Re: Problem with Injection / Outjection
                        gavin.king

                        Oh, now I spot the problem. You have made your method "final", which means CGLIB can't intercept it.

                        • 9. Re: Problem with Injection / Outjection

                          How about @In(jection) does the final'ness of methods have an impact on that too?

                          Thanks for catching the final problem.

                          • 10. Re: Problem with Injection / Outjection
                            gavin.king

                            If I can't intercept, I can't inject ;)

                            • 11. Re: Problem with Injection / Outjection

                              Gavin,

                              Thanks for helping me debug this problem. That was more painful than I would have liked normally but the it's been far more educational too ;-).

                              Everything is working great now!

                              Thanks again!