[Shib-Users] IdP 2.2.1 startup error if missing backup metadata

78 views

Skip to first unread message

Ivan Novakov

unread,

Feb 1, 2011, 7:34:30 AM2/1/11

to shibbole...@internet2.edu

Hi,

while testing the new metadata provider settings in IdP 2.2 I discovered
the following problem - if the initial metadata retrieval is
unsuccessful (timeout) and there is no corresponding backup metadata
file, the IdP ends with an error. If I create a dummy metadata backup
file, everything is fine.

The log:

13:29:39.135 - ERROR
[org.opensaml.saml2.metadata.provider.HTTPMetadataProvider:261] - Error
retrieving metadata from
https://login.terena.org/wayf/module.php/saml/sp/metadata.php/default-sp
org.apache.commons.httpclient.ConnectTimeoutException: The host did not
accept the connection within timeout of 5000 ms
at
org.apache.commons.httpclient.protocol.ReflectionSocketFactory.createSocket(ReflectionSocketFactory.java:155)
~[commons-httpclient-3.1.jar:na]
at
org.apache.commons.httpclient.protocol.SSLProtocolSocketFactory.createSocket(SSLProtocolSocketFactory.java:130)
~[commons-httpclient-3.1.jar:na]
at
org.apache.commons.httpclient.HttpConnection.open(HttpConnection.java:707)
~[commons-httpclient-3.1.jar:na]
at
org.apache.commons.httpclient.MultiThreadedHttpConnectionManager$HttpConnectionAdapter.open(MultiThreadedHttpConnectionManager.java:1361)
~[commons-httpclient-3.1.jar:na]
at
org.apache.commons.httpclient.HttpMethodDirector.executeWithRetry(HttpMethodDirector.java:387)
~[commons-httpclient-3.1.jar:na]
at
org.apache.commons.httpclient.HttpMethodDirector.executeMethod(HttpMethodDirector.java:171)
~[commons-httpclient-3.1.jar:na]
at
org.apache.commons.httpclient.HttpClient.executeMethod(HttpClient.java:397)
~[commons-httpclient-3.1.jar:na]
at
org.apache.commons.httpclient.HttpClient.executeMethod(HttpClient.java:323)
~[commons-httpclient-3.1.jar:na]
at
org.opensaml.saml2.metadata.provider.HTTPMetadataProvider.fetchMetadata(HTTPMetadataProvider.java:238)
~[opensaml-2.4.1.jar:na]
at
org.opensaml.saml2.metadata.provider.FileBackedHTTPMetadataProvider.fetchMetadata(FileBackedHTTPMetadataProvider.java:121)
[opensaml-2.4.1.jar:na]
at
org.opensaml.saml2.metadata.provider.AbstractReloadingMetadataProvider.refresh(AbstractReloadingMetadataProvider.java:233)
[opensaml-2.4.1.jar:na]
at
org.opensaml.saml2.metadata.provider.AbstractReloadingMetadataProvider.doInitialization(AbstractReloadingMetadataProvider.java:219)
[opensaml-2.4.1.jar:na]
at
org.opensaml.saml2.metadata.provider.AbstractMetadataProvider.initialize(AbstractMetadataProvider.java:407)
[opensaml-2.4.1.jar:na]
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
~[na:1.6.0_22]
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
~[na:1.6.0_22]
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
~[na:1.6.0_22]
at java.lang.reflect.Method.invoke(Method.java:597) ~[na:1.6.0_22]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeCustomInitMethod(AbstractAutowireCapableBeanFactory.java:1414)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeInitMethods(AbstractAutowireCapableBeanFactory.java:1375)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1335)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:473)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory$1.run(AbstractAutowireCapableBeanFactory.java:409)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at java.security.AccessController.doPrivileged(Native Method)
[na:1.6.0_22]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:380)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:264)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:222)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:261)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:185)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:164)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:429)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.context.support.AbstractApplicationContext.finishBeanFactoryInitialization(AbstractApplicationContext.java:728)
[spring-context-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:380)
[spring-context-2.5.6.SEC02.jar:2.5.6.SEC02]
at
edu.internet2.middleware.shibboleth.common.config.BaseService.loadContext(BaseService.java:170)
[shibboleth-common-1.2.1.jar:na]
at
edu.internet2.middleware.shibboleth.common.config.BaseReloadableService.initialize(BaseReloadableService.java:147)
[shibboleth-common-1.2.1.jar:na]
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
~[na:1.6.0_22]
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
~[na:1.6.0_22]
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
~[na:1.6.0_22]
at java.lang.reflect.Method.invoke(Method.java:597) ~[na:1.6.0_22]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeCustomInitMethod(AbstractAutowireCapableBeanFactory.java:1414)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeInitMethods(AbstractAutowireCapableBeanFactory.java:1375)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1335)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:473)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory$1.run(AbstractAutowireCapableBeanFactory.java:409)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at java.security.AccessController.doPrivileged(Native Method)
[na:1.6.0_22]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:380)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:264)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:222)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:261)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:185)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:164)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:429)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.context.support.AbstractApplicationContext.finishBeanFactoryInitialization(AbstractApplicationContext.java:728)
[spring-context-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:380)
[spring-context-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.web.context.ContextLoader.createWebApplicationContext(ContextLoader.java:255)
[spring-web-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.web.context.ContextLoader.initWebApplicationContext(ContextLoader.java:199)
[spring-web-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.web.context.ContextLoaderListener.contextInitialized(ContextLoaderListener.java:45)
[spring-web-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.apache.catalina.core.StandardContext.listenerStart(StandardContext.java:4135)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.core.StandardContext.start(StandardContext.java:4630) [catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.core.ContainerBase.addChildInternal(ContainerBase.java:791)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.core.ContainerBase.addChild(ContainerBase.java:771)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.core.StandardHost.addChild(StandardHost.java:546)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.startup.HostConfig.deployDescriptor(HostConfig.java:637)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.startup.HostConfig.deployDescriptors(HostConfig.java:563)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.startup.HostConfig.deployApps(HostConfig.java:498)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.startup.HostConfig.start(HostConfig.java:1277)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.startup.HostConfig.lifecycleEvent(HostConfig.java:321)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.util.LifecycleSupport.fireLifecycleEvent(LifecycleSupport.java:119)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.core.ContainerBase.start(ContainerBase.java:1053)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.core.StandardHost.start(StandardHost.java:785)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.core.ContainerBase.start(ContainerBase.java:1045)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.core.StandardEngine.start(StandardEngine.java:445)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.core.StandardService.start(StandardService.java:519)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.core.StandardServer.start(StandardServer.java:710)
[catalina-6.0.28.jar:6.0.28]
at org.apache.catalina.startup.Catalina.start(Catalina.java:581)
[catalina-6.0.28.jar:6.0.28]
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
~[na:1.6.0_22]
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
~[na:1.6.0_22]
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
~[na:1.6.0_22]
at java.lang.reflect.Method.invoke(Method.java:597) ~[na:1.6.0_22]
at org.apache.catalina.startup.Bootstrap.start(Bootstrap.java:289)
[bootstrap.jar:6.0.28]
at org.apache.catalina.startup.Bootstrap.main(Bootstrap.java:414)
[bootstrap.jar:6.0.28]
Caused by: java.net.SocketTimeoutException: connect timed out
at java.net.PlainSocketImpl.socketConnect(Native Method) ~[na:1.6.0_22]
at java.net.PlainSocketImpl.doConnect(PlainSocketImpl.java:333)
~[na:1.6.0_22]
at
java.net.PlainSocketImpl.connectToAddress(PlainSocketImpl.java:195)
~[na:1.6.0_22]
at java.net.PlainSocketImpl.connect(PlainSocketImpl.java:182)
~[na:1.6.0_22]
at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:366)
~[na:1.6.0_22]
at java.net.Socket.connect(Socket.java:529) ~[na:1.6.0_22]
at
com.sun.net.ssl.internal.ssl.SSLSocketImpl.connect(SSLSocketImpl.java:559)
~[na:1.6]
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
~[na:1.6.0_22]
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
~[na:1.6.0_22]
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
~[na:1.6.0_22]
at java.lang.reflect.Method.invoke(Method.java:597) ~[na:1.6.0_22]
at
org.apache.commons.httpclient.protocol.ReflectionSocketFactory.createSocket(ReflectionSocketFactory.java:140)
~[commons-httpclient-3.1.jar:na]
... 79 common frames omitted
13:29:39.143 - ERROR
[org.opensaml.saml2.metadata.provider.AbstractReloadingMetadataProvider:284]
- Unable to unmarshall metadata
org.opensaml.xml.io.UnmarshallingException:
org.opensaml.xml.parse.XMLParserException: Invalid XML
at
org.opensaml.saml2.metadata.provider.AbstractMetadataProvider.unmarshallMetadata(AbstractMetadataProvider.java:462)
[opensaml-2.4.1.jar:na]
at
org.opensaml.saml2.metadata.provider.AbstractReloadingMetadataProvider.unmarshallMetadata(AbstractReloadingMetadataProvider.java:281)
[opensaml-2.4.1.jar:na]
at
org.opensaml.saml2.metadata.provider.AbstractReloadingMetadataProvider.processNewMetadata(AbstractReloadingMetadataProvider.java:324)
[opensaml-2.4.1.jar:na]
at
org.opensaml.saml2.metadata.provider.AbstractReloadingMetadataProvider.refresh(AbstractReloadingMetadataProvider.java:242)
[opensaml-2.4.1.jar:na]
at
org.opensaml.saml2.metadata.provider.AbstractReloadingMetadataProvider.doInitialization(AbstractReloadingMetadataProvider.java:219)
[opensaml-2.4.1.jar:na]
at
org.opensaml.saml2.metadata.provider.AbstractMetadataProvider.initialize(AbstractMetadataProvider.java:407)
[opensaml-2.4.1.jar:na]
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
~[na:1.6.0_22]
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
~[na:1.6.0_22]
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
~[na:1.6.0_22]
at java.lang.reflect.Method.invoke(Method.java:597) ~[na:1.6.0_22]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeCustomInitMethod(AbstractAutowireCapableBeanFactory.java:1414)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeInitMethods(AbstractAutowireCapableBeanFactory.java:1375)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1335)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:473)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory$1.run(AbstractAutowireCapableBeanFactory.java:409)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at java.security.AccessController.doPrivileged(Native Method)
[na:1.6.0_22]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:380)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:264)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:222)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:261)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:185)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:164)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:429)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.context.support.AbstractApplicationContext.finishBeanFactoryInitialization(AbstractApplicationContext.java:728)
[spring-context-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:380)
[spring-context-2.5.6.SEC02.jar:2.5.6.SEC02]
at
edu.internet2.middleware.shibboleth.common.config.BaseService.loadContext(BaseService.java:170)
[shibboleth-common-1.2.1.jar:na]
at
edu.internet2.middleware.shibboleth.common.config.BaseReloadableService.initialize(BaseReloadableService.java:147)
[shibboleth-common-1.2.1.jar:na]
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
~[na:1.6.0_22]
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
~[na:1.6.0_22]
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
~[na:1.6.0_22]
at java.lang.reflect.Method.invoke(Method.java:597) ~[na:1.6.0_22]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeCustomInitMethod(AbstractAutowireCapableBeanFactory.java:1414)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeInitMethods(AbstractAutowireCapableBeanFactory.java:1375)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1335)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:473)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory$1.run(AbstractAutowireCapableBeanFactory.java:409)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at java.security.AccessController.doPrivileged(Native Method)
[na:1.6.0_22]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:380)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:264)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:222)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:261)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:185)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:164)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:429)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.context.support.AbstractApplicationContext.finishBeanFactoryInitialization(AbstractApplicationContext.java:728)
[spring-context-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:380)
[spring-context-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.web.context.ContextLoader.createWebApplicationContext(ContextLoader.java:255)
[spring-web-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.web.context.ContextLoader.initWebApplicationContext(ContextLoader.java:199)
[spring-web-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.web.context.ContextLoaderListener.contextInitialized(ContextLoaderListener.java:45)
[spring-web-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.apache.catalina.core.StandardContext.listenerStart(StandardContext.java:4135)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.core.StandardContext.start(StandardContext.java:4630) [catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.core.ContainerBase.addChildInternal(ContainerBase.java:791)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.core.ContainerBase.addChild(ContainerBase.java:771)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.core.StandardHost.addChild(StandardHost.java:546)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.startup.HostConfig.deployDescriptor(HostConfig.java:637)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.startup.HostConfig.deployDescriptors(HostConfig.java:563)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.startup.HostConfig.deployApps(HostConfig.java:498)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.startup.HostConfig.start(HostConfig.java:1277)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.startup.HostConfig.lifecycleEvent(HostConfig.java:321)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.util.LifecycleSupport.fireLifecycleEvent(LifecycleSupport.java:119)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.core.ContainerBase.start(ContainerBase.java:1053)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.core.StandardHost.start(StandardHost.java:785)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.core.ContainerBase.start(ContainerBase.java:1045)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.core.StandardEngine.start(StandardEngine.java:445)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.core.StandardService.start(StandardService.java:519)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.core.StandardServer.start(StandardServer.java:710)
[catalina-6.0.28.jar:6.0.28]
at org.apache.catalina.startup.Catalina.start(Catalina.java:581)
[catalina-6.0.28.jar:6.0.28]
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
~[na:1.6.0_22]
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
~[na:1.6.0_22]
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
~[na:1.6.0_22]
at java.lang.reflect.Method.invoke(Method.java:597) ~[na:1.6.0_22]
at org.apache.catalina.startup.Bootstrap.start(Bootstrap.java:289)
[bootstrap.jar:6.0.28]
at org.apache.catalina.startup.Bootstrap.main(Bootstrap.java:414)
[bootstrap.jar:6.0.28]
Caused by: org.opensaml.xml.parse.XMLParserException: Invalid XML
at
org.opensaml.xml.parse.StaticBasicParserPool.parse(StaticBasicParserPool.java:234)
~[xmltooling-1.3.1.jar:na]
at
org.opensaml.saml2.metadata.provider.AbstractMetadataProvider.unmarshallMetadata(AbstractMetadataProvider.java:449)
[opensaml-2.4.1.jar:na]
... 72 common frames omitted
Caused by: org.xml.sax.SAXParseException: Premature end of file.
at org.apache.xerces.parsers.DOMParser.parse(Unknown Source) ~[na:na]
at org.apache.xerces.jaxp.DocumentBuilderImpl.parse(Unknown Source)
~[na:na]
at javax.xml.parsers.DocumentBuilder.parse(Unknown Source) ~[na:1.4.01]
at
org.opensaml.xml.parse.StaticBasicParserPool$DocumentBuilderProxy.parse(StaticBasicParserPool.java:648)
~[xmltooling-1.3.1.jar:na]
at
org.opensaml.xml.parse.StaticBasicParserPool.parse(StaticBasicParserPool.java:231)
~[xmltooling-1.3.1.jar:na]
... 73 common frames omitted
13:29:39.147 - ERROR
[org.opensaml.saml2.metadata.provider.AbstractMetadataProvider:411] -
Metadata provider failed to properly initializing, halting
org.opensaml.saml2.metadata.provider.MetadataProviderException:
org.opensaml.saml2.metadata.provider.MetadataProviderException: Unable
to unmarshall metadata
at
org.opensaml.saml2.metadata.provider.AbstractReloadingMetadataProvider.refresh(AbstractReloadingMetadataProvider.java:248)
~[opensaml-2.4.1.jar:na]
at
org.opensaml.saml2.metadata.provider.AbstractReloadingMetadataProvider.doInitialization(AbstractReloadingMetadataProvider.java:219)
~[opensaml-2.4.1.jar:na]
at
org.opensaml.saml2.metadata.provider.AbstractMetadataProvider.initialize(AbstractMetadataProvider.java:407)
~[opensaml-2.4.1.jar:na]
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
~[na:1.6.0_22]
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
~[na:1.6.0_22]
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
~[na:1.6.0_22]
at java.lang.reflect.Method.invoke(Method.java:597) ~[na:1.6.0_22]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeCustomInitMethod(AbstractAutowireCapableBeanFactory.java:1414)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeInitMethods(AbstractAutowireCapableBeanFactory.java:1375)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1335)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:473)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory$1.run(AbstractAutowireCapableBeanFactory.java:409)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at java.security.AccessController.doPrivileged(Native Method)
[na:1.6.0_22]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:380)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:264)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:222)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:261)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:185)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:164)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:429)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.context.support.AbstractApplicationContext.finishBeanFactoryInitialization(AbstractApplicationContext.java:728)
[spring-context-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:380)
[spring-context-2.5.6.SEC02.jar:2.5.6.SEC02]
at
edu.internet2.middleware.shibboleth.common.config.BaseService.loadContext(BaseService.java:170)
[shibboleth-common-1.2.1.jar:na]
at
edu.internet2.middleware.shibboleth.common.config.BaseReloadableService.initialize(BaseReloadableService.java:147)
[shibboleth-common-1.2.1.jar:na]
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
~[na:1.6.0_22]
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
~[na:1.6.0_22]
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
~[na:1.6.0_22]
at java.lang.reflect.Method.invoke(Method.java:597) ~[na:1.6.0_22]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeCustomInitMethod(AbstractAutowireCapableBeanFactory.java:1414)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeInitMethods(AbstractAutowireCapableBeanFactory.java:1375)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1335)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:473)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory$1.run(AbstractAutowireCapableBeanFactory.java:409)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at java.security.AccessController.doPrivileged(Native Method)
[na:1.6.0_22]
at
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:380)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:264)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:222)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:261)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:185)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:164)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:429)
[spring-beans-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.context.support.AbstractApplicationContext.finishBeanFactoryInitialization(AbstractApplicationContext.java:728)
[spring-context-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:380)
[spring-context-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.web.context.ContextLoader.createWebApplicationContext(ContextLoader.java:255)
[spring-web-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.web.context.ContextLoader.initWebApplicationContext(ContextLoader.java:199)
[spring-web-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.springframework.web.context.ContextLoaderListener.contextInitialized(ContextLoaderListener.java:45)
[spring-web-2.5.6.SEC02.jar:2.5.6.SEC02]
at
org.apache.catalina.core.StandardContext.listenerStart(StandardContext.java:4135)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.core.StandardContext.start(StandardContext.java:4630) [catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.core.ContainerBase.addChildInternal(ContainerBase.java:791)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.core.ContainerBase.addChild(ContainerBase.java:771)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.core.StandardHost.addChild(StandardHost.java:546)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.startup.HostConfig.deployDescriptor(HostConfig.java:637)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.startup.HostConfig.deployDescriptors(HostConfig.java:563)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.startup.HostConfig.deployApps(HostConfig.java:498)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.startup.HostConfig.start(HostConfig.java:1277)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.startup.HostConfig.lifecycleEvent(HostConfig.java:321)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.util.LifecycleSupport.fireLifecycleEvent(LifecycleSupport.java:119)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.core.ContainerBase.start(ContainerBase.java:1053)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.core.StandardHost.start(StandardHost.java:785)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.core.ContainerBase.start(ContainerBase.java:1045)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.core.StandardEngine.start(StandardEngine.java:445)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.core.StandardService.start(StandardService.java:519)
[catalina-6.0.28.jar:6.0.28]
at
org.apache.catalina.core.StandardServer.start(StandardServer.java:710)
[catalina-6.0.28.jar:6.0.28]
at org.apache.catalina.startup.Catalina.start(Catalina.java:581)
[catalina-6.0.28.jar:6.0.28]
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
~[na:1.6.0_22]
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
~[na:1.6.0_22]
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
~[na:1.6.0_22]
at java.lang.reflect.Method.invoke(Method.java:597) ~[na:1.6.0_22]
at org.apache.catalina.startup.Bootstrap.start(Bootstrap.java:289)
[bootstrap.jar:6.0.28]
at org.apache.catalina.startup.Bootstrap.main(Bootstrap.java:414)
[bootstrap.jar:6.0.28]
Caused by:
org.opensaml.saml2.metadata.provider.MetadataProviderException: Unable
to unmarshall metadata
at
org.opensaml.saml2.metadata.provider.AbstractReloadingMetadataProvider.unmarshallMetadata(AbstractReloadingMetadataProvider.java:285)
~[opensaml-2.4.1.jar:na]
at
org.opensaml.saml2.metadata.provider.AbstractReloadingMetadataProvider.processNewMetadata(AbstractReloadingMetadataProvider.java:324)
~[opensaml-2.4.1.jar:na]
at
org.opensaml.saml2.metadata.provider.AbstractReloadingMetadataProvider.refresh(AbstractReloadingMetadataProvider.java:242)
~[opensaml-2.4.1.jar:na]
... 69 common frames omitted
Caused by: org.opensaml.xml.io.UnmarshallingException:
org.opensaml.xml.parse.XMLParserException: Invalid XML
at
org.opensaml.saml2.metadata.provider.AbstractMetadataProvider.unmarshallMetadata(AbstractMetadataProvider.java:462)
~[opensaml-2.4.1.jar:na]
at
org.opensaml.saml2.metadata.provider.AbstractReloadingMetadataProvider.unmarshallMetadata(AbstractReloadingMetadataProvider.java:281)
~[opensaml-2.4.1.jar:na]
... 71 common frames omitted
Caused by: org.opensaml.xml.parse.XMLParserException: Invalid XML
at
org.opensaml.xml.parse.StaticBasicParserPool.parse(StaticBasicParserPool.java:234)
~[xmltooling-1.3.1.jar:na]
at
org.opensaml.saml2.metadata.provider.AbstractMetadataProvider.unmarshallMetadata(AbstractMetadataProvider.java:449)
~[opensaml-2.4.1.jar:na]
... 72 common frames omitted
Caused by: org.xml.sax.SAXParseException: Premature end of file.
at org.apache.xerces.parsers.DOMParser.parse(Unknown Source) ~[na:na]
at org.apache.xerces.jaxp.DocumentBuilderImpl.parse(Unknown Source)
~[na:na]
at javax.xml.parsers.DocumentBuilder.parse(Unknown Source) ~[na:1.4.01]
at
org.opensaml.xml.parse.StaticBasicParserPool$DocumentBuilderProxy.parse(StaticBasicParserPool.java:648)
~[xmltooling-1.3.1.jar:na]
at
org.opensaml.xml.parse.StaticBasicParserPool.parse(StaticBasicParserPool.java:231)
~[xmltooling-1.3.1.jar:na]
... 73 common frames omitted
13:29:39.151 - ERROR
[edu.internet2.middleware.shibboleth.common.config.BaseService:187] -
Configuration was not loaded for
shibboleth.RelyingPartyConfigurationManager service, error creating
components. The root cause of this error was:
org.xml.sax.SAXParseException: Premature end of file.

--
-----------------------------------------------------------
Ing. Ivan Novakov<nov...@fel.cvut.cz>

Faculty of Electrical Engineering CTU in Prague
http://www.fel.cvut.cz/
-----------------------------------------------------------

Cantor, Scott E.

unread,

Feb 1, 2011, 9:58:57 AM2/1/11

to shibbole...@internet2.edu

> while testing the new metadata provider settings in IdP 2.2 I discovered
> the following problem - if the initial metadata retrieval is
> unsuccessful (timeout) and there is no corresponding backup metadata
> file, the IdP ends with an error. If I create a dummy metadata backup
> file, everything is fine.

That's by design, I believe, with an option to control it.

-- Scott

Ivan Novakov

unread,

Feb 1, 2011, 10:09:40 AM2/1/11

to shibbole...@internet2.edu

Oh, thanks. I must have overlooked (*failFastInitialization)*it even
though it's first on the list :).

Reply all

Reply to author

Forward

0 new messages