[ https://jira.jboss.org/jira/browse/JBAS-6140?page=com.atlassian.jira.plug... ] Stan Silvert reassigned JBAS-6140: ---------------------------------- Assignee: Shelly McGowan (was: Stan Silvert) Shelly, This test sends http requests to the JMX console. Is the JMX console enabled in your test environment? If it is locked down with a password then the test will fail. -- This message is automatically generated by JIRA. - If you think it was sent incorrectly contact one of the administrators: https://jira.jboss.org/jira/secure/Administrators.jspa - For more information on JIRA, see: http://www.atlassian.com/software/jira

[ https://jira.jboss.org/jira/browse/JBAS-6140?page=com.atlassian.jira.plug... ] Shelly McGowan updated JBAS-6140: --------------------------------- I've started looking into this issue again so we can certify the next EAP CP. The test will pass with OpenJDK 6 when the test is run outside of the test framework either using one-test or manually deploying the .war and hitting the browser. When the test passes, the following is seen in the server.log: 2009-01-08 14:43:35,141 DEBUG [javax.enterprise.resource.webcontainer.jsf.timing] [TIMING] - [310ms] : Parse jar:file:/home/smcgowan2/workspace4/Branch_4_2/build/output/jboss-4.2.4.GA/server/all/tmp/deploy/tmp23644jsf-impl.jar!/com/sun/faces/jsf-ri-runtime.xml 2009-01-08 14:43:35,144 DEBUG [javax.enterprise.resource.webcontainer.jsf.timing] [TIMING] - [27ms] : Parse jndi:/localhost/jbosstest-jsf/WEB-INF/faces-config.xml 2009-01-08 14:43:35,209 DEBUG [javax.enterprise.resource.webcontainer.jsf.lifecycle] Created Default Lifecycle 2009-01-08 14:43:35,244 DEBUG [javax.enterprise.resource.webcontainer.jsf.lifecycle] getLifecycle: DEFAULT com.sun.faces.lifecycle.LifecycleImpl@182ab3e 2009-01-08 14:43:35,246 DEBUG [javax.enterprise.resource.webcontainer.jsf.lifecycle] addPhaseListener(ANY 0,com.sun.faces.lifecycle.ELResolverInitPhaseListener) 2009-01-08 14:43:35,248 DEBUG [javax.enterprise.resource.webcontainer.jsf.lifecycle] getLifecycle: DEFAULT com.sun.faces.lifecycle.LifecycleImpl@182ab3e 2009-01-08 14:43:35,249 DEBUG [javax.enterprise.resource.webcontainer.jsf.lifecycle] addPhaseListener(RESTORE_VIEW 1,com.sun.faces.renderkit.JsfJsResourcePhaseListener) 2009-01-08 14:43:35,436 DEBUG [javax.enterprise.resource.webcontainer.jsf.timing] [TIMING] - [1107ms] : Initialization of context /jbosstest-jsf 2009-01-08 14:43:35,437 DEBUG [org.jboss.web.tomcat.filters.ReplyHeaderFilter] Adding header name: X-Powered-By='Servlet 2.4; JBoss-4.2.4.GA (build: SVNTag=JBoss_4_2_4_GA date=200901081411)/JBossWeb-2.0' 2009-01-08 14:43:35,440 DEBUG [javax.enterprise.resource.webcontainer.jsf.lifecycle] getLifecycle: DEFAULT com.sun.faces.lifecycle.LifecycleImpl@182ab3e However, when the test fails, there is no lifecycle created: 2009-01-08 15:00:38,172 DEBUG [javax.enterprise.resource.webcontainer.jsf.timing] [TIMING] - [32ms] : Parse jar:file:/home/smcgowan2/workspace4/Branch_4_2/build/output/jboss-4.2.4.GA/server/all/tmp/deploy/tmp14116jsf-impl.jar!/com/sun/faces/jsf-ri-runtime.xml 2009-01-08 15:00:38,185 DEBUG [javax.enterprise.resource.webcontainer.jsf.timing] [TIMING] - [45ms] : Parse jndi:/localhost/jbosstest-jsf/WEB-INF/faces-config.xml 2009-01-08 15:00:38,542 DEBUG [javax.enterprise.resource.webcontainer.jsf.timing] [TIMING] - [1236ms] : Initialization of context /jbosstest-jsf 2009-01-08 15:00:38,543 DEBUG [org.jboss.web.tomcat.filters.ReplyHeaderFilter] Adding header name: X-Powered-By='Servlet 2.4; JBoss-4.2.4.GA (build: SVNTag=JBoss_4_2_4_GA date=200901081411)/JBossWeb-2.0' 2009-01-08 15:00:38,551 DEBUG [org.jboss.web.tomcat.service.TomcatDeployer] Initialized: {WebApplication: /home/smcgowan2/workspace4/Branch_4_2/build/output/jboss-4.2.4.GA/server/all/tmp/deploy/tmp14178jbosstest-jsf-exp.war/, URL: file:/home/smcgowan2/workspace4/Branch_4_2/build/output/jboss-4.2.4.GA/server/all/tmp/deploy/tmp14178jbosstest-jsf-exp.war/, classLoader: java.net.FactoryURLClassLoader@1ae9565:28218725} jboss.web:j2eeType=WebModule,name=//localhost/jbosstest-jsf,J2EEApplication=none,J2EEServer=none -- This message is automatically generated by JIRA. - If you think it was sent incorrectly contact one of the administrators: https://jira.jboss.org/jira/secure/Administrators.jspa - For more information on JIRA, see: http://www.atlassian.com/software/jira

[ https://jira.jboss.org/jira/browse/JBAS-6140?page=com.atlassian.jira.plug... ] Shelly McGowan updated JBAS-6140: --------------------------------- Yes, I do see those however I see those if the tests pass or fail. The information above was the diffs in the log output. The error seen when the test fails is below which made me think the lifecycle was relevant. 2009-01-08 15:00:38,920 ERROR [org.apache.catalina.core.ContainerBase.[jboss.web].[localhost].[/jbosstest-jsf].[jsp]] Servlet.service() for servlet jsp threw exception java.lang.RuntimeException: javax.enterprise.resource.webcontainer.jsf.renderkit should not be loggable for SEVERE. at org.jboss.test.jsf.webapp.LoggingTest.sendLogMessages(LoggingTest.java:63) at org.apache.jsp.index_jsp._jspService(index_jsp.java:162) at org.apache.jasper.runtime.HttpJspBase.service(HttpJspBase.java:70) at javax.servlet.http.HttpServlet.service(HttpServlet.java:803) at org.apache.jasper.servlet.JspServletWrapper.service(JspServletWrapper.java:373) at org.apache.jasper.servlet.JspServlet.serviceJspFile(JspServlet.java:336) at org.apache.jasper.servlet.JspServlet.service(JspServlet.java:265) at javax.servlet.http.HttpServlet.service(HttpServlet.java:803) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:290) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206) at org.apache.catalina.core.ApplicationDispatcher.invoke(ApplicationDispatcher.java:654) at org.apache.catalina.core.ApplicationDispatcher.processRequest(ApplicationDispatcher.java:445) at org.apache.catalina.core.ApplicationDispatcher.doForward(ApplicationDispatcher.java:379) at org.apache.catalina.core.ApplicationDispatcher.forward(ApplicationDispatcher.java:292) at com.sun.faces.context.ExternalContextImpl.dispatch(ExternalContextImpl.java:410) at com.sun.faces.application.ViewHandlerImpl.executePageToBuildView(ViewHandlerImpl.java:468) at com.sun.faces.application.ViewHandlerImpl.renderView(ViewHandlerImpl.java:140) at com.sun.faces.lifecycle.RenderResponsePhase.execute(RenderResponsePhase.java:110) at com.sun.faces.lifecycle.Phase.doPhase(Phase.java:100) at com.sun.faces.lifecycle.LifecycleImpl.render(LifecycleImpl.java:139) at javax.faces.webapp.FacesServlet.service(FacesServlet.java:266) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:290) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206) at org.jboss.web.tomcat.filters.ReplyHeaderFilter.doFilter(ReplyHeaderFilter.java:96) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:235) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:175) at org.jboss.web.tomcat.security.SecurityAssociationValve.invoke(SecurityAssociationValve.java:182) at org.jboss.web.tomcat.security.JaccContextValve.invoke(JaccContextValve.java:84) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:102) at org.jboss.web.tomcat.service.jca.CachedConnectionValve.invoke(CachedConnectionValve.java:157) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:109) at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:262) at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:844) at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:583) at org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:446) at java.lang.Thread.run(Thread.java:636) 2009-01-08 15:00:38,926 ERROR [STDERR] Jan 8, 2009 3:00:38 PM com.sun.faces.lifecycle.Phase doPhase SEVERE: JSF1054: (Phase ID: RENDER_RESPONSE 6, View ID: /index.jsp) Exception thrown during phase execution: javax.faces.event.PhaseEvent[source=com.sun.faces.lifecycle.LifecycleImpl@1e9c245] 2009-01-08 15:00:38,926 DEBUG [javax.enterprise.resource.webcontainer.jsf.timing] [TIMING] - [246ms] : Execution time for phase (including any PhaseListeners) -> RENDER_RESPONSE 6 -- This message is automatically generated by JIRA. - If you think it was sent incorrectly contact one of the administrators: https://jira.jboss.org/jira/secure/Administrators.jspa - For more information on JIRA, see: http://www.atlassian.com/software/jira

[ https://jira.jboss.org/jira/browse/JBAS-6140?page=com.atlassian.jira.plug... ] Stan Silvert commented on JBAS-6140: ------------------------------------ I've come to the conclusion that JDK logging is royally screwed in OpenJDK. If you look at both the pass and fail logs attached to this jira you will see: 2009-01-08 14:43:17,337 DEBUG [javax.enterprise.resource.webcontainer.jsf.config] JSF1021: [] Configuration option 'com.sun.faces.displayConfiguration' - DISABLED 2009-01-08 14:43:17,338 DEBUG [javax.enterprise.resource.webcontainer.jsf.config] JSF1021: [] Configuration option 'com.sun.faces.validateXml' - DISABLED 2009-01-08 14:43:17,338 DEBUG [javax.enterprise.resource.webcontainer.jsf.config] JSF1021: [] Configuration option 'com.sun.faces.verifyObjects' - DISABLED 2009-01-08 14:43:17,338 DEBUG [javax.enterprise.resource.webcontainer.jsf.config] JSF1021: [] Configuration option 'com.sun.faces.forceLoadConfiguration' - DISABLED 2009-01-08 14:43:17,338 DEBUG [javax.enterprise.resource.webcontainer.jsf.config] JSF1021: [] Configuration option 'com.sun.faces.enableHtmlTagLibValidator' - DISABLED 2009-01-08 14:43:17,338 DEBUG [javax.enterprise.resource.webcontainer.jsf.config] JSF1021: [] Configuration option 'com.sun.faces.preferXHTML' - DISABLED 2009-01-08 14:43:17,338 DEBUG [javax.enterprise.resource.webcontainer.jsf.config] JSF1021: [] Configuration option 'com.sun.faces.compressViewState' - ENABLED 2009-01-08 14:43:17,338 DEBUG [javax.enterprise.resource.webcontainer.jsf.config] JSF1021: [] Configuration option 'com.sun.faces.compressJavaScript' - ENABLED 2009-01-08 14:43:17,338 DEBUG [javax.enterprise.resource.webcontainer.jsf.config] JSF1021: [] Configuration option 'com.sun.faces.externalizeJavaScript' - DISABLED 2009-01-08 14:43:17,338 DEBUG [javax.enterprise.resource.webcontainer.jsf.config] JSF1021: [] Configuration option 'com.sun.faces.sendPoweredByHeader' - ENABLED 2009-01-08 14:43:17,338 DEBUG [javax.enterprise.resource.webcontainer.jsf.config] JSF1021: [] Configuration option 'com.sun.faces.enableJSStyleHiding' - DISABLED 2009-01-08 14:43:17,339 DEBUG [javax.enterprise.resource.webcontainer.jsf.config] JSF1021: [] Configuration option 'com.sun.faces.enableScriptsInAttributeValues' - ENABLED 2009-01-08 14:43:17,339 DEBUG [javax.enterprise.resource.webcontainer.jsf.config] JSF1021: [] Configuration option 'com.sun.faces.writeStateAtFormEnd' - ENABLED 2009-01-08 14:43:17,339 DEBUG [javax.enterprise.resource.webcontainer.jsf.config] JSF1021: [] Configuration option 'com.sun.faces.enableLazyBeanValidation' - ENABLED 2009-01-08 14:43:17,339 DEBUG [javax.enterprise.resource.webcontainer.jsf.config] JSF1021: [] Configuration option 'com.sun.faces.enabledLoadBundle11Compatibility' - DISABLED 2009-01-08 14:43:17,339 DEBUG [javax.enterprise.resource.webcontainer.jsf.config] JSF1021: [] Configuration option 'com.sun.faces.enableRestoreView11Compatibility' - DISABLED 2009-01-08 14:43:17,339 DEBUG [javax.enterprise.resource.webcontainer.jsf.config] JSF1021: [] Configuration option 'com.sun.faces.serializeServerState' - DISABLED 2009-01-08 14:43:17,339 DEBUG [javax.enterprise.resource.webcontainer.jsf.config] JSF1021: [] Configuration option 'com.sun.faces.enableViewStateIdRendering' - ENABLED 2009-01-08 14:43:17,339 DEBUG [javax.enterprise.resource.webcontainer.jsf.config] JSF1021: [] Configuration option 'com.sun.faces.registerConverterPropertyEditors' - DISABLED 2009-01-08 14:43:17,339 DEBUG [javax.enterprise.resource.webcontainer.jsf.config] JSF1021: [] Configuration option 'com.sun.faces.developmentMode' - DISABLED 2009-01-08 14:43:17,340 DEBUG [javax.enterprise.resource.webcontainer.jsf.config] JSF1018: [] Configuration option 'javax.faces.STATE_SAVING_METHOD' set to 'server' 2009-01-08 14:43:17,340 DEBUG [javax.enterprise.resource.webcontainer.jsf.config] JSF1018: [] Configuration option 'javax.faces.DEFAULT_SUFFIX' set to '.jsp' 2009-01-08 14:43:17,340 DEBUG [javax.enterprise.resource.webcontainer.jsf.config] JSF1018: [] Configuration option 'com.sun.faces.numberOfViewsInSession' set to '15' 2009-01-08 14:43:17,340 DEBUG [javax.enterprise.resource.webcontainer.jsf.config] JSF1018: [] Configuration option 'com.sun.faces.numberOfLogicalViews' set to '15' 2009-01-08 14:43:17,340 DEBUG [javax.enterprise.resource.webcontainer.jsf.config] JSF1018: [] Configuration option 'com.sun.faces.injectionProvider' set to 'org.jboss.web.jsf.integration.injection.JBossInjectionProvider' 2009-01-08 14:43:17,341 DEBUG [javax.enterprise.resource.webcontainer.jsf.config] JSF1018: [] Configuration option 'com.sun.faces.responseBufferSize' set to '1024' 2009-01-08 14:43:17,341 DEBUG [javax.enterprise.resource.webcontainer.jsf.config] JSF1018: [] Configuration option 'com.sun.faces.clientStateWriteBufferSize' set to '8192' 2009-01-08 14:43:17,341 DEBUG [javax.enterprise.resource.webcontainer.jsf.config] JSF1018: [] Configuration option 'com.sun.faces.expressionFactory' set to 'com.sun.el.ExpressionFactoryImpl' 2009-01-08 14:43:17,341 DEBUG [javax.enterprise.resource.webcontainer.jsf.config] JSF1018: [] Configuration option 'com.sun.faces.disableUnicodeEscaping' set to 'false' Those messages are logged to the JDK (using java.util.logging) if you set this context param in web.xml: <context-param> <param-name>com.sun.faces.displayConfiguration</param-name> <param-value>true</param-value> </context-param> Now look back at the first message. It reports the value for "com.sun.faces.displayConfiguration" as DISABLED! That should never happen. The only time you should see any of the above messages is if it is enabled with the context param. Note again that this problem happens for both "one-test" and for "tests-standard-unit". BTW, I don't know the difference in running "one-test" vs. running the "tests-standard-unit" target. What does "tests-standard-unit" do differently? -- This message is automatically generated by JIRA. - If you think it was sent incorrectly contact one of the administrators: https://jira.jboss.org/jira/secure/Administrators.jspa - For more information on JIRA, see: http://www.atlassian.com/software/jira

[ https://jira.jboss.org/jira/browse/JBAS-6140?page=com.atlassian.jira.plug... ] Shelly McGowan reassigned JBAS-6140: ------------------------------------ Assignee: Stan Silvert (was: Shelly McGowan) Not sure who else should look at this but I have run out of things to try. -- This message is automatically generated by JIRA. - If you think it was sent incorrectly contact one of the administrators: https://jira.jboss.org/jira/secure/Administrators.jspa - For more information on JIRA, see: http://www.atlassian.com/software/jira

[ https://jira.jboss.org/jira/browse/JBAS-6140?page=com.atlassian.jira.plug... ] Stan Silvert commented on JBAS-6140: ------------------------------------ What is the server manager? Yes, getting someone from openjdk to look at it would be helpful. Preferably, it would be someone who knows about the internals of the java.util.logging package. -- This message is automatically generated by JIRA. - If you think it was sent incorrectly contact one of the administrators: https://jira.jboss.org/jira/secure/Administrators.jspa - For more information on JIRA, see: http://www.atlassian.com/software/jira

[ https://jira.jboss.org/jira/browse/JBAS-6140?page=com.atlassian.jira.plug... ] Shelly McGowan updated JBAS-6140: --------------------------------- Parent: (was: JBAS-5834) Issue Type: Bug (was: Sub-task) -- This message is automatically generated by JIRA. - If you think it was sent incorrectly contact one of the administrators: https://jira.jboss.org/jira/secure/Administrators.jspa - For more information on JIRA, see: http://www.atlassian.com/software/jira

[ https://jira.jboss.org/jira/browse/JBAS-6140?page=com.atlassian.jira.plug... ] Shelly McGowan updated JBAS-6140: --------------------------------- As you can see from the linked issue, this is still an issue when running the testsuite against the EAP 4.x series with OpenJDK 6. It is not resolved. -- This message is automatically generated by JIRA. - If you think it was sent incorrectly contact one of the administrators: https://jira.jboss.org/jira/secure/Administrators.jspa - For more information on JIRA, see: http://www.atlassian.com/software/jira