[jboss-osgi-issues] [JBoss JIRA] Updated: (JBOSGI-294) WebApp Extender fails on embedded Equinox

[ https://jira.jboss.org/jira/browse/JBOSGI-294?page=com.atlassian.jira.plu... ] Thomas Diesler updated JBOSGI-294: ---------------------------------- Description: We have an intermittent failure with Equinox where the registered endpoint is not available. In the logfile http://jbmuc.dyndns.org:8280/hudson/job/jbossosgi-matrix-embedded/framewo... I see 2010-02-23 00:10:41,947 DEBUG [org.ops4j.pax.web.extender.war.internal.Activator] Pax Web WAR Extender - Started 2010-02-23 00:10:41,947 DEBUG [org.ops4j.pax.swissbox.extender.BundleWatcher] Scanning bundle [org.ops4j.pax.web.pax-web-extender-war] 2010-02-23 00:10:41,948 DEBUG [org.jboss.osgi.spi.util.ExportedPackageHelper] Exported-Packages: org.ops4j.pax.web.pax-web-extender-war 2010-02-23 00:10:41,958 DEBUG [org.ops4j.pax.swissbox.extender.BundleWatcher] Scanning bundle [example-webapp] 2010-02-23 00:10:41,962 DEBUG [org.ops4j.pax.swissbox.extender.BundleWatcher] Found resources [bundleentry://9.fwk11165301/WEB-INF/web.xml] 2010-02-23 00:10:41,964 DEBUG [org.ops4j.pax.web.extender.war.internal.WebXmlObserver] Parsing a web application from [bundleentry://9.fwk11165301/WEB-INF/web.xml] 2010-02-23 00:10:41,969 DEBUG [org.ops4j.pax.web.service.internal.ConfigurationImpl] Reading configuration property org.ops4j.pax.web.session.timeout has failed 2010-02-23 00:10:41,970 DEBUG [org.ops4j.pax.web.service.jetty.internal.ServerControllerImpl] Configuring server [ServerControllerImpl{state=UNCONFIGURED}] -> [ConfigurationImpl{http enabled=true,http port=8090,http secure enabled=false,http secure port=8443,ssl keystore=/home/hudson/.keystore,ssl keystoreType=null,session timeout=null,session url=null,session cookie=null,worker name=null,listening addresses=[Ljava.lang.String;@89a2d9}] 2010-02-23 00:10:41,972 DEBUG [org.ops4j.pax.web.service.jetty.internal.ServerControllerImpl] Starting server [ServerControllerImpl{state=STOPPED}] 2010-02-23 00:10:41,992 DEBUG [org.ops4j.pax.web.extender.war.internal.WebXmlObserver] Parsed web app [WebApp{displayName=WebApp Sample,contextName=null}] 2010-02-23 00:10:41,993 DEBUG [org.ops4j.pax.web.extender.war.internal.WebXmlObserver] No 'Webapp-Context' manifest attribute specified 2010-02-23 00:10:41,993 DEBUG [org.ops4j.pax.web.extender.war.internal.WebXmlObserver] Using bundle symbolic name [example-webapp] as context name 2010-02-23 00:10:41,993 INFO [org.ops4j.pax.web.extender.war.internal.WebXmlObserver] Using [example-webapp] as web application context name 2010-02-23 00:10:41,993 DEBUG [org.ops4j.pax.web.extender.war.internal.WebAppPublisher] Publishing web application [WebApp{displayName=WebApp Sample,contextName=example-webapp}] 2010-02-23 00:10:41,999 DEBUG [org.ops4j.pax.swissbox.tracker.ReplaceableService] Creating replaceable service for [interface org.osgi.service.http.HttpService] 2010-02-23 00:10:42,003 DEBUG [org.ops4j.pax.swissbox.tracker.ServiceCollection] Creating service collection for [interface org.osgi.service.http.HttpService] 2010-02-23 00:10:42,005 DEBUG [org.jboss.osgi.spi.util.ExportedPackageHelper] Exported-Packages: example-webapp 2010-02-23 00:10:42,007 DEBUG [org.jboss.osgi.testing.OSGiTest] ### START org.jboss.test.osgi.example.webapp.WebAppExtenderTestCase 2010-02-23 00:10:42,018 DEBUG [org.ops4j.pax.web.service.internal.ConfigurationImpl] Reading configuration property org.ops4j.pax.web.session.timeout has failed 2010-02-23 00:10:42,019 DEBUG [org.ops4j.pax.web.service.jetty.internal.JettyServerImpl] Starting JettyServerImpl{} 2010-02-23 00:10:42,019 DEBUG [org.mortbay.jetty] jetty-6.1.x 2010-02-23 00:10:42,044 DEBUG [org.mortbay.jetty] Container JettyServerWrapper@1fa12f6 + org.mortbay.thread.QueuedThreadPool@11c7f8d as threadpool 2010-02-23 00:10:42,048 DEBUG [org.mortbay.jetty] started org.mortbay.thread.QueuedThreadPool@11c7f8d 2010-02-23 00:10:42,048 DEBUG [org.mortbay.jetty] starting JettyServerWrapper@1fa12f6 2010-02-23 00:10:42,050 DEBUG [org.mortbay.jetty] started JettyServerWrapper@1fa12f6 2010-02-23 00:10:42,063 INFO [org.ops4j.pax.web.service.jetty.internal.JettyServerImpl] Pax Web available at [0.0.0.0]:[8090] 2010-02-23 00:10:42,064 DEBUG [org.mortbay.jetty] Container JettyServerWrapper@1fa12f6 + NIOSocketConnectorWrapper@0.0.0.0:8090 as connector 2010-02-23 00:10:42,074 DEBUG [org.mortbay.jetty] started org.mortbay.jetty.nio.SelectChannelConnector$1@54c2b8 2010-02-23 00:10:42,078 DEBUG [org.mortbay.jetty] Started NIOSocketConnectorWrapper@0.0.0.0:8090 2010-02-23 00:10:42,079 DEBUG [org.mortbay.jetty] started NIOSocketConnectorWrapper@0.0.0.0:8090 2010-02-23 00:10:42,080 DEBUG [org.ops4j.pax.web.service.internal.ConfigurationImpl] Reading configuration property org.ops4j.pax.web.session.timeout has failed 2010-02-23 00:10:42,084 DEBUG [org.ops4j.pax.web.service.internal.ConfigurationImpl] Reading configuration property org.ops4j.pax.web.session.timeout has failed 2010-02-23 00:10:42,087 DEBUG [org.ops4j.pax.web.service.jetty.internal.ServerControllerImpl] Configuring server [ServerControllerImpl{state=STARTED}] -> [ConfigurationImpl{http enabled=true,http port=8090,http secure enabled=false,http secure port=8443,ssl keystore=/home/hudson/.keystore,ssl keystoreType=null,session timeout=null,session url=null,session cookie=null,worker name=null,listening addresses=[Ljava.lang.String;@a17378}] 2010-02-23 00:10:42,088 DEBUG [org.ops4j.pax.web.service.jetty.internal.ServerControllerImpl] Stopping server [ServerControllerImpl{state=STARTED}] 2010-02-23 00:10:42,088 DEBUG [org.ops4j.pax.web.service.jetty.internal.JettyServerImpl] Stopping JettyServerImpl{} 2010-02-23 00:10:42,090 DEBUG [org.mortbay.jetty] stopped org.mortbay.jetty.nio.SelectChannelConnector$1@54c2b8 2010-02-23 00:10:42,091 DEBUG [org.mortbay.jetty] stopped NIOSocketConnectorWrapper@0.0.0.0:8090 2010-02-23 00:10:42,091 DEBUG [org.mortbay.jetty] stopping JettyServerWrapper@1fa12f6 2010-02-23 00:10:42,095 DEBUG [org.ops4j.pax.swissbox.tracker.ServiceCollection] Added service with reference [{org.osgi.service.http.HttpService, org.ops4j.pax.web.service.WebContainer}={org.ops4j.pax.web.ssl.keystore=/home/hudson/.keystore, org.osgi.service.http.port.secure=8443, org.ops4j.pax.web.listening.addresses=, org.osgi.service.http.port=8090, org.ops4j.pax.web.ssl.clientauthneeded=false, org.osgi.service.http.useNIO=true, org.osgi.service.http.enabled=true, org.osgi.service.http.secure.enabled=true, org.ops4j.pax.web.ssl.clientauthwanted=false, javax.servlet.context.tempdir=/tmp/.paxweb1233425339357219478, service.id=35}] 2010-02-23 00:10:42,096 INFO [org.ops4j.pax.web.service.internal.HttpServiceFactoryImpl] Binding bundle: [example-webapp_0.0.0 [9]] to http service 2010-02-23 00:10:42,105 DEBUG [org.ops4j.pax.web.service.internal.HttpServiceStarted] Creating http service for: example-webapp_0.0.0 [9] Why is Jetty being stopped? 2010-02-23 00:10:42,088 DEBUG [org.ops4j.pax.web.service.jetty.internal.ServerControllerImpl] Stopping server [ServerControllerImpl{state=STARTED}] was: We have an intermittent failure with Equinox where the registered endpoint is not available. In the logfile I see 2010-02-23 00:10:41,947 DEBUG [org.ops4j.pax.web.extender.war.internal.Activator] Pax Web WAR Extender - Started 2010-02-23 00:10:41,947 DEBUG [org.ops4j.pax.swissbox.extender.BundleWatcher] Scanning bundle [org.ops4j.pax.web.pax-web-extender-war] 2010-02-23 00:10:41,948 DEBUG [org.jboss.osgi.spi.util.ExportedPackageHelper] Exported-Packages: org.ops4j.pax.web.pax-web-extender-war 2010-02-23 00:10:41,958 DEBUG [org.ops4j.pax.swissbox.extender.BundleWatcher] Scanning bundle [example-webapp] 2010-02-23 00:10:41,962 DEBUG [org.ops4j.pax.swissbox.extender.BundleWatcher] Found resources [bundleentry://9.fwk11165301/WEB-INF/web.xml] 2010-02-23 00:10:41,964 DEBUG [org.ops4j.pax.web.extender.war.internal.WebXmlObserver] Parsing a web application from [bundleentry://9.fwk11165301/WEB-INF/web.xml] 2010-02-23 00:10:41,969 DEBUG [org.ops4j.pax.web.service.internal.ConfigurationImpl] Reading configuration property org.ops4j.pax.web.session.timeout has failed 2010-02-23 00:10:41,970 DEBUG [org.ops4j.pax.web.service.jetty.internal.ServerControllerImpl] Configuring server [ServerControllerImpl{state=UNCONFIGURED}] -> [ConfigurationImpl{http enabled=true,http port=8090,http secure enabled=false,http secure port=8443,ssl keystore=/home/hudson/.keystore,ssl keystoreType=null,session timeout=null,session url=null,session cookie=null,worker name=null,listening addresses=[Ljava.lang.String;@89a2d9}] 2010-02-23 00:10:41,972 DEBUG [org.ops4j.pax.web.service.jetty.internal.ServerControllerImpl] Starting server [ServerControllerImpl{state=STOPPED}] 2010-02-23 00:10:41,992 DEBUG [org.ops4j.pax.web.extender.war.internal.WebXmlObserver] Parsed web app [WebApp{displayName=WebApp Sample,contextName=null}] 2010-02-23 00:10:41,993 DEBUG [org.ops4j.pax.web.extender.war.internal.WebXmlObserver] No 'Webapp-Context' manifest attribute specified 2010-02-23 00:10:41,993 DEBUG [org.ops4j.pax.web.extender.war.internal.WebXmlObserver] Using bundle symbolic name [example-webapp] as context name 2010-02-23 00:10:41,993 INFO [org.ops4j.pax.web.extender.war.internal.WebXmlObserver] Using [example-webapp] as web application context name 2010-02-23 00:10:41,993 DEBUG [org.ops4j.pax.web.extender.war.internal.WebAppPublisher] Publishing web application [WebApp{displayName=WebApp Sample,contextName=example-webapp}] 2010-02-23 00:10:41,999 DEBUG [org.ops4j.pax.swissbox.tracker.ReplaceableService] Creating replaceable service for [interface org.osgi.service.http.HttpService] 2010-02-23 00:10:42,003 DEBUG [org.ops4j.pax.swissbox.tracker.ServiceCollection] Creating service collection for [interface org.osgi.service.http.HttpService] 2010-02-23 00:10:42,005 DEBUG [org.jboss.osgi.spi.util.ExportedPackageHelper] Exported-Packages: example-webapp 2010-02-23 00:10:42,007 DEBUG [org.jboss.osgi.testing.OSGiTest] ### START org.jboss.test.osgi.example.webapp.WebAppExtenderTestCase 2010-02-23 00:10:42,018 DEBUG [org.ops4j.pax.web.service.internal.ConfigurationImpl] Reading configuration property org.ops4j.pax.web.session.timeout has failed 2010-02-23 00:10:42,019 DEBUG [org.ops4j.pax.web.service.jetty.internal.JettyServerImpl] Starting JettyServerImpl{} 2010-02-23 00:10:42,019 DEBUG [org.mortbay.jetty] jetty-6.1.x 2010-02-23 00:10:42,044 DEBUG [org.mortbay.jetty] Container JettyServerWrapper@1fa12f6 + org.mortbay.thread.QueuedThreadPool@11c7f8d as threadpool 2010-02-23 00:10:42,048 DEBUG [org.mortbay.jetty] started org.mortbay.thread.QueuedThreadPool@11c7f8d 2010-02-23 00:10:42,048 DEBUG [org.mortbay.jetty] starting JettyServerWrapper@1fa12f6 2010-02-23 00:10:42,050 DEBUG [org.mortbay.jetty] started JettyServerWrapper@1fa12f6 2010-02-23 00:10:42,063 INFO [org.ops4j.pax.web.service.jetty.internal.JettyServerImpl] Pax Web available at [0.0.0.0]:[8090] 2010-02-23 00:10:42,064 DEBUG [org.mortbay.jetty] Container JettyServerWrapper@1fa12f6 + NIOSocketConnectorWrapper@0.0.0.0:8090 as connector 2010-02-23 00:10:42,074 DEBUG [org.mortbay.jetty] started org.mortbay.jetty.nio.SelectChannelConnector$1@54c2b8 2010-02-23 00:10:42,078 DEBUG [org.mortbay.jetty] Started NIOSocketConnectorWrapper@0.0.0.0:8090 2010-02-23 00:10:42,079 DEBUG [org.mortbay.jetty] started NIOSocketConnectorWrapper@0.0.0.0:8090 2010-02-23 00:10:42,080 DEBUG [org.ops4j.pax.web.service.internal.ConfigurationImpl] Reading configuration property org.ops4j.pax.web.session.timeout has failed 2010-02-23 00:10:42,084 DEBUG [org.ops4j.pax.web.service.internal.ConfigurationImpl] Reading configuration property org.ops4j.pax.web.session.timeout has failed 2010-02-23 00:10:42,087 DEBUG [org.ops4j.pax.web.service.jetty.internal.ServerControllerImpl] Configuring server [ServerControllerImpl{state=STARTED}] -> [ConfigurationImpl{http enabled=true,http port=8090,http secure enabled=false,http secure port=8443,ssl keystore=/home/hudson/.keystore,ssl keystoreType=null,session timeout=null,session url=null,session cookie=null,worker name=null,listening addresses=[Ljava.lang.String;@a17378}] 2010-02-23 00:10:42,088 DEBUG [org.ops4j.pax.web.service.jetty.internal.ServerControllerImpl] Stopping server [ServerControllerImpl{state=STARTED}] 2010-02-23 00:10:42,088 DEBUG [org.ops4j.pax.web.service.jetty.internal.JettyServerImpl] Stopping JettyServerImpl{} 2010-02-23 00:10:42,090 DEBUG [org.mortbay.jetty] stopped org.mortbay.jetty.nio.SelectChannelConnector$1@54c2b8 2010-02-23 00:10:42,091 DEBUG [org.mortbay.jetty] stopped NIOSocketConnectorWrapper@0.0.0.0:8090 2010-02-23 00:10:42,091 DEBUG [org.mortbay.jetty] stopping JettyServerWrapper@1fa12f6 2010-02-23 00:10:42,095 DEBUG [org.ops4j.pax.swissbox.tracker.ServiceCollection] Added service with reference [{org.osgi.service.http.HttpService, org.ops4j.pax.web.service.WebContainer}={org.ops4j.pax.web.ssl.keystore=/home/hudson/.keystore, org.osgi.service.http.port.secure=8443, org.ops4j.pax.web.listening.addresses=, org.osgi.service.http.port=8090, org.ops4j.pax.web.ssl.clientauthneeded=false, org.osgi.service.http.useNIO=true, org.osgi.service.http.enabled=true, org.osgi.service.http.secure.enabled=true, org.ops4j.pax.web.ssl.clientauthwanted=false, javax.servlet.context.tempdir=/tmp/.paxweb1233425339357219478, service.id=35}] 2010-02-23 00:10:42,096 INFO [org.ops4j.pax.web.service.internal.HttpServiceFactoryImpl] Binding bundle: [example-webapp_0.0.0 [9]] to http service 2010-02-23 00:10:42,105 DEBUG [org.ops4j.pax.web.service.internal.HttpServiceStarted] Creating http service for: example-webapp_0.0.0 [9] Why is Jetty being stopped? 2010-02-23 00:10:42,088 DEBUG [org.ops4j.pax.web.service.jetty.internal.ServerControllerImpl] Stopping server [ServerControllerImpl{state=STARTED}] -- 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