FAIL - Application at context path /idp could not be started

[psy...@nottingham.ac.uk]

Hi all

I am having trouble getting the idp service to load correctly. I have
done the following:

1. Install fresh copy of Windows XP (service pack 3) - I am running it
in Microsoft Virtual PC

2. Run "jdk-6u26-windows-i586.exe" (Java SE Development Kit 6 Update
26) and install to the default location of "C:\Program Files\Java
\jdk1.6.0_26\" and when prompted install JRE into the default location
of "C:\Program Files\Java\jre6\".

3. In My Computer -> Advanced -> Environment Variables under "System
variables" click 'New' and in the variable name type JAVA_HOME and in
the value type in C:\Program Files\Java\jdk1.6.0_26\jre and click
ok(s).

4. Restart Windows XP.

5. Run "shibboleth-identityprovider-2.3.1.msi" and keep pressing
"Next" until the installation begins. I am therefore using the default
options provided in the installation.

6. Browse to https://localhost/idp/status but error: HTTP STATUS 404
(The requested resource () is not available)

7. Updated tomcat-users.xml to allow me to login to tomcat:
<role rolename="manager-gui"/> <user username="test"
password="password" roles="manager-gui"/>

8. Restarted the tomcat service.

9. Went to https://localhost/

10. Logged into Tomcat Manager with username and password

11. Clicked "Start" next to Shibboleth Identity Provider

12. Received error "FAIL - Application at context path /idp could not
be started"

13. Undeployed /idp

14. Deployed idp.war

15. Start /idp again but same error - "FAIL - Application at context
path /idp could not be started"

--
To unsubscribe from this group, send email to
users+un...@shibboleth.net

[Chad La Joie]

That's fine, now go back and read what I told you to make sure you
included when you submitted a question to the user's list.

Chad La Joie
http://itumi.biz
trusted identities, delivered

[Peter Schober]

* psy...@nottingham.ac.uk <psy...@nottingham.ac.uk> [2011-07-22 14:11]:

> 15. Start /idp again but same error - "FAIL - Application at context
> path /idp could not be started"

Check the log file for the Java servlet container (e.g. Tomcat's
catalina.out, assuming the MSI installer is using Tomcat),
There should be ERROR and/or SEVERE log messages,
-peter

[Rod Widdowson]

> 5. Run "shibboleth-identityprovider-2.3.1.msi" and keep pressing
> "Next" until the installation begins. I am therefore using the default
> options provided in the installation.

You cannot do this. The installer can only infer so much. Yes it should fail if something it needs isn't specified (& I'll enter
an RFE).

You need to know (at the very least)
- your GC (we can make a guess at that)
- the FQDN of your host (the guess is mostly wrong)
- A username as password on your AD (Nope)

Failing that look at the logs and start to fill in all that stuff by hand.

[Rod Widdowson]

I meant to add this reference:

https://wiki.shibboleth.net/confluence/display/SHIB2/IdPQuickIInstallUserInput

[psy...@nottingham.ac.uk]

Here is my idp-process.log with DEBUG enabled for IdP in logging.xml:



13:45:14.092 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.OpensamlConfigBean:
79] - Loading OpenSAML configuration file: jar:file:/C:/Program
%20Files/Internet2/CaptiveTomcat%206.0/webapps/idp/WEB-INF/lib/
shibboleth-common-1.3.0.jar!/shibboleth-saml-ext-config.xml
13:45:14.242 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.service.ServletContextAttributeExporter:
84] - Exporting bean shibboleth.SessionManager to servlet context.
13:45:14.252 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.BaseReloadableService:
135] - Initializing shibboleth.AttributeResolver service with
resources: [C:\Program Files\Internet2\Shib2Idp\conf\attribute-
resolver.xml]
13:45:14.252 - INFO
[edu.internet2.middleware.shibboleth.common.config.BaseService:157] -
Loading new configuration for service shibboleth.AttributeResolver
13:45:14.432 - INFO
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
54] - Parsing configuration for PrincipalConnector plugin with ID:
shibTransient
13:45:14.432 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
64] - Dependencies for plugin shibTransient: none
13:45:14.432 - INFO
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
54] - Parsing configuration for PrincipalConnector plugin with ID:
saml1Unspec
13:45:14.432 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
64] - Dependencies for plugin saml1Unspec: none
13:45:14.432 - INFO
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
54] - Parsing configuration for PrincipalConnector plugin with ID:
saml2Transient
13:45:14.432 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
64] - Dependencies for plugin saml2Transient: none
13:45:14.442 - INFO
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
54] - Parsing configuration for DataConnector plugin with ID:
staticAttributes
13:45:14.442 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
64] - Dependencies for plugin staticAttributes: none
13:45:14.442 - INFO
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
54] - Parsing configuration for DataConnector plugin with ID: myLDAP
13:45:14.442 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
64] - Dependencies for plugin myLDAP: none
13:45:14.442 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.dataConnector.LdapDataConnectorBeanDefinitionParser:
94] - Data connector myLDAP LDAP URL: ldap://:389
13:45:14.462 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.dataConnector.LdapDataConnectorBeanDefinitionParser:
101] - Data connector myLDAP connection strategy: ACTIVE_PASSIVE
13:45:14.462 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.dataConnector.LdapDataConnectorBeanDefinitionParser:
106] - Data connector myLDAP base DN: CN=Users,DC=
13:45:14.462 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.dataConnector.LdapDataConnectorBeanDefinitionParser:
114] - Data connector myLDAP authentication type: SIMPLE
13:45:14.462 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.dataConnector.LdapDataConnectorBeanDefinitionParser:
118] - Data connector myLDAP principal: @
13:45:14.462 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.dataConnector.LdapDataConnectorBeanDefinitionParser:
130] - Data connector myLDAP LDAP filter template: (sAMAccountName=
$requestContext.principalName)
13:45:14.462 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.dataConnector.LdapDataConnectorBeanDefinitionParser:
137] - Data connector myLDAP search scope: SUBTREE
13:45:14.462 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.dataConnector.LdapDataConnectorBeanDefinitionParser:
179] - Data connector myLDAP use startTLS: false
13:45:14.462 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.dataConnector.LdapDataConnectorBeanDefinitionParser:
201] - Data connector myLDAP search timeout: 3000ms
13:45:14.462 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.dataConnector.LdapDataConnectorBeanDefinitionParser:
208] - Data connector myLDAP max search result size: 1
13:45:14.462 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.dataConnector.LdapDataConnectorBeanDefinitionParser:
215] - Data connector myLDAP merge results: false
13:45:14.462 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.dataConnector.LdapDataConnectorBeanDefinitionParser:
223] - Data connector myLDAP no results is error: false
13:45:14.462 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.dataConnector.LdapDataConnectorBeanDefinitionParser:
231] - Data connector myLDAP will lower case attribute IDs: false
13:45:14.462 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.dataConnector.LdapDataConnectorBeanDefinitionParser:
71] - Data connector myLDAP LDAP properties:
{java.naming.ldap.attributes.binary=objectSid,
java.naming.referral=follow}
13:45:14.462 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.dataConnector.LdapDataConnectorBeanDefinitionParser:
251] - Data connector myLDAP is pooling connections: false
13:45:14.472 - INFO
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
54] - Parsing configuration for DataConnector plugin with ID:
computedID
13:45:14.472 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
61] - Dependencies for plugin computedID: [myLDAP]
13:45:14.482 - INFO
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
54] - Parsing configuration for AttributeDefinition plugin with ID:
eduPersonAffiliation
13:45:14.482 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
61] - Dependencies for plugin eduPersonAffiliation: [staticAttributes]
13:45:14.482 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.attributeDefinition.BaseAttributeDefinitionBeanDefinitionParser:
57] - Setting source attribute ID for attribute definition
eduPersonAffiliation to: eduPersonAffiliation
13:45:14.482 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.attributeDefinition.BaseAttributeDefinitionBeanDefinitionParser:
81] - Attribute definition eduPersonAffiliation produces attributes
that are only dependencies: false
13:45:14.492 - INFO
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
54] - Parsing configuration for AttributeDefinition plugin with ID:
eduPersonPrincipalName
13:45:14.492 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
61] - Dependencies for plugin eduPersonPrincipalName: [myLDAP]
13:45:14.492 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.attributeDefinition.BaseAttributeDefinitionBeanDefinitionParser:
57] - Setting source attribute ID for attribute definition
eduPersonPrincipalName to: sAMAccountName
13:45:14.492 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.attributeDefinition.BaseAttributeDefinitionBeanDefinitionParser:
81] - Attribute definition eduPersonPrincipalName produces attributes
that are only dependencies: false
13:45:14.492 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.attributeDefinition.ScopedAttributeDefinitionBeanDefinitionParser:
52] - Setting scope of attribute definition eduPersonPrincipalName
to:
13:45:14.492 - INFO
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
54] - Parsing configuration for AttributeDefinition plugin with ID:
eduPersonScopedAffiliation
13:45:14.492 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
61] - Dependencies for plugin eduPersonScopedAffiliation:
[staticAttributes]
13:45:14.492 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.attributeDefinition.BaseAttributeDefinitionBeanDefinitionParser:
57] - Setting source attribute ID for attribute definition
eduPersonScopedAffiliation to: eduPersonAffiliation
13:45:14.502 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.attributeDefinition.BaseAttributeDefinitionBeanDefinitionParser:
81] - Attribute definition eduPersonScopedAffiliation produces
attributes that are only dependencies: false
13:45:14.502 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.attributeDefinition.ScopedAttributeDefinitionBeanDefinitionParser:
52] - Setting scope of attribute definition eduPersonScopedAffiliation
to:
13:45:14.502 - INFO
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
54] - Parsing configuration for AttributeDefinition plugin with ID:
eduPersonTargetedID.old
13:45:14.502 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
61] - Dependencies for plugin eduPersonTargetedID.old: [computedID]
13:45:14.502 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.attributeDefinition.BaseAttributeDefinitionBeanDefinitionParser:
57] - Setting source attribute ID for attribute definition
eduPersonTargetedID.old to: computedID
13:45:14.502 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.attributeDefinition.BaseAttributeDefinitionBeanDefinitionParser:
81] - Attribute definition eduPersonTargetedID.old produces attributes
that are only dependencies: false
13:45:14.502 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.attributeDefinition.ScopedAttributeDefinitionBeanDefinitionParser:
52] - Setting scope of attribute definition eduPersonTargetedID.old
to:
13:45:14.502 - INFO
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
54] - Parsing configuration for AttributeDefinition plugin with ID:
eduPersonTargetedID
13:45:14.502 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
61] - Dependencies for plugin eduPersonTargetedID: [computedID]
13:45:14.502 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.attributeDefinition.BaseAttributeDefinitionBeanDefinitionParser:
57] - Setting source attribute ID for attribute definition
eduPersonTargetedID to: computedID
13:45:14.502 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.attributeDefinition.BaseAttributeDefinitionBeanDefinitionParser:
81] - Attribute definition eduPersonTargetedID produces attributes
that are only dependencies: false
13:45:14.502 - INFO
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
54] - Parsing configuration for AttributeDefinition plugin with ID:
transientId
13:45:14.502 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
64] - Dependencies for plugin transientId: none
13:45:14.502 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.attributeDefinition.BaseAttributeDefinitionBeanDefinitionParser:
57] - Setting source attribute ID for attribute definition transientId
to:
13:45:14.502 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.attributeDefinition.BaseAttributeDefinitionBeanDefinitionParser:
81] - Attribute definition transientId produces attributes that are
only dependencies: false
13:45:14.642 - WARN
[edu.internet2.middleware.shibboleth.common.attribute.resolver.provider.dataConnector.ComputedIDDataConnector:
64] - This data connector is deprecated. The StoredID data connector
should be used in its place.
13:45:14.783 - DEBUG
[edu.internet2.middleware.shibboleth.common.attribute.resolver.provider.ShibbolethAttributeResolver:
502] - Loading 3 data connectors
13:45:14.783 - DEBUG
[edu.internet2.middleware.shibboleth.common.attribute.resolver.provider.ShibbolethAttributeResolver:
512] - Loading 6 attribute definitions
13:45:14.783 - DEBUG
[edu.internet2.middleware.shibboleth.common.attribute.resolver.provider.ShibbolethAttributeResolver:
522] - Loading 3 principal connectors
13:45:16.165 - ERROR [edu.vt.middleware.ldap.pool.DefaultLdapFactory:
109] - unabled to connect to the ldap
javax.naming.CommunicationException: localhost:389
at com.sun.jndi.ldap.Connection.<init>(Connection.java:210) ~[na:
1.6.0_26]
at com.sun.jndi.ldap.LdapClient.<init>(LdapClient.java:118) ~[na:
1.6.0_26]
at com.sun.jndi.ldap.LdapClient.getInstance(LdapClient.java:1580)
~[na:1.6.0_26]
at com.sun.jndi.ldap.LdapCtx.connect(LdapCtx.java:2652) ~[na:
1.6.0_26]
at com.sun.jndi.ldap.LdapCtx.<init>(LdapCtx.java:293) ~[na:1.6.0_26]
at com.sun.jndi.ldap.LdapCtxFactory.getUsingURL(LdapCtxFactory.java:
175) ~[na:1.6.0_26]
at com.sun.jndi.ldap.LdapCtxFactory.getUsingURLs(LdapCtxFactory.java:
193) ~[na:1.6.0_26]
at
com.sun.jndi.ldap.LdapCtxFactory.getLdapCtxInstance(LdapCtxFactory.java:
136) ~[na:1.6.0_26]
at
com.sun.jndi.ldap.LdapCtxFactory.getInitialContext(LdapCtxFactory.java:
66) ~[na:1.6.0_26]
at
javax.naming.spi.NamingManager.getInitialContext(NamingManager.java:
667) ~[na:1.6.0_26]
at javax.naming.InitialContext.getDefaultInitCtx(InitialContext.java:
288) ~[na:1.6.0_26]
at javax.naming.InitialContext.init(InitialContext.java:223) ~[na:
1.6.0_26]
at
javax.naming.ldap.InitialLdapContext.<init>(InitialLdapContext.java:
134) ~[na:1.6.0_26]
at
edu.vt.middleware.ldap.handler.DefaultConnectionHandler.connectInternal(DefaultConnectionHandler.java:
102) ~[vt-ldap-3.3.3.jar:na]
at
edu.vt.middleware.ldap.handler.AbstractConnectionHandler.connect(AbstractConnectionHandler.java:
156) ~[vt-ldap-3.3.3.jar:na]
at edu.vt.middleware.ldap.AbstractLdap.connect(AbstractLdap.java:
1006) ~[vt-ldap-3.3.3.jar:na]
at
edu.vt.middleware.ldap.pool.DefaultLdapFactory.create(DefaultLdapFactory.java:
106) [vt-ldap-3.3.3.jar:na]
at
edu.vt.middleware.ldap.pool.DefaultLdapFactory.create(DefaultLdapFactory.java:
28) [vt-ldap-3.3.3.jar:na]
at
edu.internet2.middleware.shibboleth.common.attribute.resolver.provider.dataConnector.LdapPoolEmptyStrategy.checkOut(LdapPoolEmptyStrategy.java:
52) [shibboleth-common-1.3.0.jar:na]
at
edu.internet2.middleware.shibboleth.common.attribute.resolver.provider.dataConnector.LdapDataConnector.validate(LdapDataConnector.java:
274) [shibboleth-common-1.3.0.jar:na]
at
edu.internet2.middleware.shibboleth.common.attribute.resolver.provider.ShibbolethAttributeResolver.validateDataConnector(ShibbolethAttributeResolver.java:
173) [shibboleth-common-1.3.0.jar:na]
at
edu.internet2.middleware.shibboleth.common.attribute.resolver.provider.ShibbolethAttributeResolver.validate(ShibbolethAttributeResolver.java:
145) [shibboleth-common-1.3.0.jar:na]
at
edu.internet2.middleware.shibboleth.common.attribute.resolver.provider.ShibbolethAttributeResolver.onNewContextCreated(ShibbolethAttributeResolver.java:
532) [shibboleth-common-1.3.0.jar:na]
at
edu.internet2.middleware.shibboleth.common.config.BaseService.loadContext(BaseService.java:
173) [shibboleth-common-1.3.0.jar:na]
at
edu.internet2.middleware.shibboleth.common.config.BaseReloadableService.initialize(BaseReloadableService.java:
147) [shibboleth-common-1.3.0.jar:na]
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:
1.6.0_26]
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:
39) ~[na:1.6.0_26]
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:
25) ~[na:1.6.0_26]
at java.lang.reflect.Method.invoke(Method.java:597) ~[na:1.6.0_26]
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_26]
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:
4205) [catalina.jar:6.0.32]
at
org.apache.catalina.core.StandardContext.start(StandardContext.java:
4704) [catalina.jar:6.0.32]
at
org.apache.catalina.core.ContainerBase.addChildInternal(ContainerBase.java:
799) [catalina.jar:6.0.32]
at org.apache.catalina.core.ContainerBase.addChild(ContainerBase.java:
779) [catalina.jar:6.0.32]
at org.apache.catalina.core.StandardHost.addChild(StandardHost.java:
601) [catalina.jar:6.0.32]
at org.apache.catalina.startup.HostConfig.deployWAR(HostConfig.java:
943) [catalina.jar:6.0.32]
at org.apache.catalina.startup.HostConfig.deployWARs(HostConfig.java:
778) [catalina.jar:6.0.32]
at org.apache.catalina.startup.HostConfig.deployApps(HostConfig.java:
504) [catalina.jar:6.0.32]
at org.apache.catalina.startup.HostConfig.start(HostConfig.java:1315)
[catalina.jar:6.0.32]
at
org.apache.catalina.startup.HostConfig.lifecycleEvent(HostConfig.java:
324) [catalina.jar:6.0.32]
at
org.apache.catalina.util.LifecycleSupport.fireLifecycleEvent(LifecycleSupport.java:
142) [catalina.jar:6.0.32]
at org.apache.catalina.core.ContainerBase.start(ContainerBase.java:
1061) [catalina.jar:6.0.32]
at org.apache.catalina.core.StandardHost.start(StandardHost.java:840)
[catalina.jar:6.0.32]
at org.apache.catalina.core.ContainerBase.start(ContainerBase.java:
1053) [catalina.jar:6.0.32]
at org.apache.catalina.core.StandardEngine.start(StandardEngine.java:
463) [catalina.jar:6.0.32]
at
org.apache.catalina.core.StandardService.start(StandardService.java:
525) [catalina.jar:6.0.32]
at org.apache.catalina.core.StandardServer.start(StandardServer.java:
754) [catalina.jar:6.0.32]
at org.apache.catalina.startup.Catalina.start(Catalina.java:595)
[catalina.jar:6.0.32]
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:
1.6.0_26]
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:
39) ~[na:1.6.0_26]
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:
25) ~[na:1.6.0_26]
at java.lang.reflect.Method.invoke(Method.java:597) ~[na:1.6.0_26]
at org.apache.catalina.startup.Bootstrap.start(Bootstrap.java:289)
[bootstrap.jar:6.0.32]
at org.apache.catalina.startup.Bootstrap.main(Bootstrap.java:414)
[bootstrap.jar:6.0.32]
Caused by: java.net.ConnectException: Connection refused: connect
at java.net.PlainSocketImpl.socketConnect(Native Method) ~[na:
1.6.0_26]
at java.net.PlainSocketImpl.doConnect(PlainSocketImpl.java:351) ~[na:
1.6.0_26]
at java.net.PlainSocketImpl.connectToAddress(PlainSocketImpl.java:
213) ~[na:1.6.0_26]
at java.net.PlainSocketImpl.connect(PlainSocketImpl.java:200) ~[na:
1.6.0_26]
at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:366) ~[na:
1.6.0_26]
at java.net.Socket.connect(Socket.java:529) ~[na:1.6.0_26]
at java.net.Socket.connect(Socket.java:478) ~[na:1.6.0_26]
at java.net.Socket.<init>(Socket.java:375) ~[na:1.6.0_26]
at java.net.Socket.<init>(Socket.java:189) ~[na:1.6.0_26]
at com.sun.jndi.ldap.Connection.createSocket(Connection.java:352)
~[na:1.6.0_26]
at com.sun.jndi.ldap.Connection.<init>(Connection.java:187) ~[na:
1.6.0_26]
... 70 common frames omitted
13:45:16.165 - ERROR
[edu.internet2.middleware.shibboleth.common.attribute.resolver.provider.dataConnector.LdapDataConnector:
276] - Unable to retrieve an LDAP connection
13:45:16.165 - ERROR
[edu.internet2.middleware.shibboleth.common.attribute.resolver.provider.dataConnector.LdapDataConnector:
287] - Could not retrieve Ldap object from pool
edu.internet2.middleware.shibboleth.common.attribute.resolver.AttributeResolutionException:
Unable to retrieve LDAP connection
at
edu.internet2.middleware.shibboleth.common.attribute.resolver.provider.dataConnector.LdapDataConnector.validate(LdapDataConnector.java:
277) ~[shibboleth-common-1.3.0.jar:na]
at
edu.internet2.middleware.shibboleth.common.attribute.resolver.provider.ShibbolethAttributeResolver.validateDataConnector(ShibbolethAttributeResolver.java:
173) [shibboleth-common-1.3.0.jar:na]
at
edu.internet2.middleware.shibboleth.common.attribute.resolver.provider.ShibbolethAttributeResolver.validate(ShibbolethAttributeResolver.java:
145) [shibboleth-common-1.3.0.jar:na]
at
edu.internet2.middleware.shibboleth.common.attribute.resolver.provider.ShibbolethAttributeResolver.onNewContextCreated(ShibbolethAttributeResolver.java:
532) [shibboleth-common-1.3.0.jar:na]
at
edu.internet2.middleware.shibboleth.common.config.BaseService.loadContext(BaseService.java:
173) [shibboleth-common-1.3.0.jar:na]
at
edu.internet2.middleware.shibboleth.common.config.BaseReloadableService.initialize(BaseReloadableService.java:
147) [shibboleth-common-1.3.0.jar:na]
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:
1.6.0_26]
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:
39) ~[na:1.6.0_26]
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:
25) ~[na:1.6.0_26]
at java.lang.reflect.Method.invoke(Method.java:597) ~[na:1.6.0_26]
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_26]
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:
4205) [catalina.jar:6.0.32]
at
org.apache.catalina.core.StandardContext.start(StandardContext.java:
4704) [catalina.jar:6.0.32]
at
org.apache.catalina.core.ContainerBase.addChildInternal(ContainerBase.java:
799) [catalina.jar:6.0.32]
at org.apache.catalina.core.ContainerBase.addChild(ContainerBase.java:
779) [catalina.jar:6.0.32]
at org.apache.catalina.core.StandardHost.addChild(StandardHost.java:
601) [catalina.jar:6.0.32]
at org.apache.catalina.startup.HostConfig.deployWAR(HostConfig.java:
943) [catalina.jar:6.0.32]
at org.apache.catalina.startup.HostConfig.deployWARs(HostConfig.java:
778) [catalina.jar:6.0.32]
at org.apache.catalina.startup.HostConfig.deployApps(HostConfig.java:
504) [catalina.jar:6.0.32]
at org.apache.catalina.startup.HostConfig.start(HostConfig.java:1315)
[catalina.jar:6.0.32]
at
org.apache.catalina.startup.HostConfig.lifecycleEvent(HostConfig.java:
324) [catalina.jar:6.0.32]
at
org.apache.catalina.util.LifecycleSupport.fireLifecycleEvent(LifecycleSupport.java:
142) [catalina.jar:6.0.32]
at org.apache.catalina.core.ContainerBase.start(ContainerBase.java:
1061) [catalina.jar:6.0.32]
at org.apache.catalina.core.StandardHost.start(StandardHost.java:840)
[catalina.jar:6.0.32]
at org.apache.catalina.core.ContainerBase.start(ContainerBase.java:
1053) [catalina.jar:6.0.32]
at org.apache.catalina.core.StandardEngine.start(StandardEngine.java:
463) [catalina.jar:6.0.32]
at
org.apache.catalina.core.StandardService.start(StandardService.java:
525) [catalina.jar:6.0.32]
at org.apache.catalina.core.StandardServer.start(StandardServer.java:
754) [catalina.jar:6.0.32]
at org.apache.catalina.startup.Catalina.start(Catalina.java:595)
[catalina.jar:6.0.32]
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:
1.6.0_26]
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:
39) ~[na:1.6.0_26]
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:
25) ~[na:1.6.0_26]
at java.lang.reflect.Method.invoke(Method.java:597) ~[na:1.6.0_26]
at org.apache.catalina.startup.Bootstrap.start(Bootstrap.java:289)
[bootstrap.jar:6.0.32]
at org.apache.catalina.startup.Bootstrap.main(Bootstrap.java:414)
[bootstrap.jar:6.0.32]
13:45:16.165 - ERROR
[edu.internet2.middleware.shibboleth.common.config.BaseService:187] -
Configuration was not loaded for shibboleth.AttributeResolver service,
error creating components. The root cause of this error was:
edu.internet2.middleware.shibboleth.common.attribute.resolver.AttributeResolutionException:
Unable to retrieve LDAP connection
13:45:26.900 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.OpensamlConfigBean:
79] - Loading OpenSAML configuration file: jar:file:/C:/Program
%20Files/Internet2/CaptiveTomcat%206.0/webapps/idp/WEB-INF/lib/
shibboleth-common-1.3.0.jar!/shibboleth-saml-ext-config.xml
13:45:26.970 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.service.ServletContextAttributeExporter:
84] - Exporting bean shibboleth.SessionManager to servlet context.
13:45:26.980 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.BaseReloadableService:
135] - Initializing shibboleth.AttributeResolver service with
resources: [C:\Program Files\Internet2\Shib2Idp\conf\attribute-
resolver.xml]
13:45:26.980 - INFO
[edu.internet2.middleware.shibboleth.common.config.BaseService:157] -
Loading new configuration for service shibboleth.AttributeResolver
13:45:27.020 - INFO
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
54] - Parsing configuration for PrincipalConnector plugin with ID:
shibTransient
13:45:27.020 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
64] - Dependencies for plugin shibTransient: none
13:45:27.020 - INFO
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
54] - Parsing configuration for PrincipalConnector plugin with ID:
saml1Unspec
13:45:27.020 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
64] - Dependencies for plugin saml1Unspec: none
13:45:27.020 - INFO
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
54] - Parsing configuration for PrincipalConnector plugin with ID:
saml2Transient
13:45:27.020 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
64] - Dependencies for plugin saml2Transient: none
13:45:27.030 - INFO
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
54] - Parsing configuration for DataConnector plugin with ID:
staticAttributes
13:45:27.030 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
64] - Dependencies for plugin staticAttributes: none
13:45:27.030 - INFO
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
54] - Parsing configuration for DataConnector plugin with ID: myLDAP
13:45:27.030 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
64] - Dependencies for plugin myLDAP: none
13:45:27.030 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.dataConnector.LdapDataConnectorBeanDefinitionParser:
94] - Data connector myLDAP LDAP URL: ldap://:389
13:45:27.040 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.dataConnector.LdapDataConnectorBeanDefinitionParser:
101] - Data connector myLDAP connection strategy: ACTIVE_PASSIVE
13:45:27.040 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.dataConnector.LdapDataConnectorBeanDefinitionParser:
106] - Data connector myLDAP base DN: CN=Users,DC=
13:45:27.040 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.dataConnector.LdapDataConnectorBeanDefinitionParser:
114] - Data connector myLDAP authentication type: SIMPLE
13:45:27.040 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.dataConnector.LdapDataConnectorBeanDefinitionParser:
118] - Data connector myLDAP principal: @
13:45:27.040 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.dataConnector.LdapDataConnectorBeanDefinitionParser:
130] - Data connector myLDAP LDAP filter template: (sAMAccountName=
$requestContext.principalName)
13:45:27.040 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.dataConnector.LdapDataConnectorBeanDefinitionParser:
137] - Data connector myLDAP search scope: SUBTREE
13:45:27.040 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.dataConnector.LdapDataConnectorBeanDefinitionParser:
179] - Data connector myLDAP use startTLS: false
13:45:27.040 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.dataConnector.LdapDataConnectorBeanDefinitionParser:
201] - Data connector myLDAP search timeout: 3000ms
13:45:27.040 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.dataConnector.LdapDataConnectorBeanDefinitionParser:
208] - Data connector myLDAP max search result size: 1
13:45:27.040 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.dataConnector.LdapDataConnectorBeanDefinitionParser:
215] - Data connector myLDAP merge results: false
13:45:27.040 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.dataConnector.LdapDataConnectorBeanDefinitionParser:
223] - Data connector myLDAP no results is error: false
13:45:27.040 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.dataConnector.LdapDataConnectorBeanDefinitionParser:
231] - Data connector myLDAP will lower case attribute IDs: false
13:45:27.040 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.dataConnector.LdapDataConnectorBeanDefinitionParser:
71] - Data connector myLDAP LDAP properties:
{java.naming.ldap.attributes.binary=objectSid,
java.naming.referral=follow}
13:45:27.040 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.dataConnector.LdapDataConnectorBeanDefinitionParser:
251] - Data connector myLDAP is pooling connections: false
13:45:27.040 - INFO
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
54] - Parsing configuration for DataConnector plugin with ID:
computedID
13:45:27.040 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
61] - Dependencies for plugin computedID: [myLDAP]
13:45:27.060 - INFO
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
54] - Parsing configuration for AttributeDefinition plugin with ID:
eduPersonAffiliation
13:45:27.060 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
61] - Dependencies for plugin eduPersonAffiliation: [staticAttributes]
13:45:27.060 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.attributeDefinition.BaseAttributeDefinitionBeanDefinitionParser:
57] - Setting source attribute ID for attribute definition
eduPersonAffiliation to: eduPersonAffiliation
13:45:27.060 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.attributeDefinition.BaseAttributeDefinitionBeanDefinitionParser:
81] - Attribute definition eduPersonAffiliation produces attributes
that are only dependencies: false
13:45:27.070 - INFO
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
54] - Parsing configuration for AttributeDefinition plugin with ID:
eduPersonPrincipalName
13:45:27.070 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
61] - Dependencies for plugin eduPersonPrincipalName: [myLDAP]
13:45:27.070 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.attributeDefinition.BaseAttributeDefinitionBeanDefinitionParser:
57] - Setting source attribute ID for attribute definition
eduPersonPrincipalName to: sAMAccountName
13:45:27.070 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.attributeDefinition.BaseAttributeDefinitionBeanDefinitionParser:
81] - Attribute definition eduPersonPrincipalName produces attributes
that are only dependencies: false
13:45:27.070 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.attributeDefinition.ScopedAttributeDefinitionBeanDefinitionParser:
52] - Setting scope of attribute definition eduPersonPrincipalName
to:
13:45:27.070 - INFO
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
54] - Parsing configuration for AttributeDefinition plugin with ID:
eduPersonScopedAffiliation
13:45:27.070 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
61] - Dependencies for plugin eduPersonScopedAffiliation:
[staticAttributes]
13:45:27.070 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.attributeDefinition.BaseAttributeDefinitionBeanDefinitionParser:
57] - Setting source attribute ID for attribute definition
eduPersonScopedAffiliation to: eduPersonAffiliation
13:45:27.070 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.attributeDefinition.BaseAttributeDefinitionBeanDefinitionParser:
81] - Attribute definition eduPersonScopedAffiliation produces
attributes that are only dependencies: false
13:45:27.070 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.attributeDefinition.ScopedAttributeDefinitionBeanDefinitionParser:
52] - Setting scope of attribute definition eduPersonScopedAffiliation
to:
13:45:27.070 - INFO
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
54] - Parsing configuration for AttributeDefinition plugin with ID:
eduPersonTargetedID.old
13:45:27.070 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
61] - Dependencies for plugin eduPersonTargetedID.old: [computedID]
13:45:27.070 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.attributeDefinition.BaseAttributeDefinitionBeanDefinitionParser:
57] - Setting source attribute ID for attribute definition
eduPersonTargetedID.old to: computedID
13:45:27.070 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.attributeDefinition.BaseAttributeDefinitionBeanDefinitionParser:
81] - Attribute definition eduPersonTargetedID.old produces attributes
that are only dependencies: false
13:45:27.070 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.attributeDefinition.ScopedAttributeDefinitionBeanDefinitionParser:
52] - Setting scope of attribute definition eduPersonTargetedID.old
to:
13:45:27.080 - INFO
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
54] - Parsing configuration for AttributeDefinition plugin with ID:
eduPersonTargetedID
13:45:27.080 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
61] - Dependencies for plugin eduPersonTargetedID: [computedID]
13:45:27.080 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.attributeDefinition.BaseAttributeDefinitionBeanDefinitionParser:
57] - Setting source attribute ID for attribute definition
eduPersonTargetedID to: computedID
13:45:27.080 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.attributeDefinition.BaseAttributeDefinitionBeanDefinitionParser:
81] - Attribute definition eduPersonTargetedID produces attributes
that are only dependencies: false
13:45:27.080 - INFO
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
54] - Parsing configuration for AttributeDefinition plugin with ID:
transientId
13:45:27.080 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.AbstractResolutionPlugInBeanDefinitionParser:
64] - Dependencies for plugin transientId: none
13:45:27.080 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.attributeDefinition.BaseAttributeDefinitionBeanDefinitionParser:
57] - Setting source attribute ID for attribute definition transientId
to:
13:45:27.080 - DEBUG
[edu.internet2.middleware.shibboleth.common.config.attribute.resolver.attributeDefinition.BaseAttributeDefinitionBeanDefinitionParser:
81] - Attribute definition transientId produces attributes that are
only dependencies: false
13:45:27.130 - WARN
[edu.internet2.middleware.shibboleth.common.attribute.resolver.provider.dataConnector.ComputedIDDataConnector:
64] - This data connector is deprecated. The StoredID data connector
should be used in its place.
13:45:27.421 - DEBUG
[edu.internet2.middleware.shibboleth.common.attribute.resolver.provider.ShibbolethAttributeResolver:
502] - Loading 3 data connectors
13:45:27.421 - DEBUG
[edu.internet2.middleware.shibboleth.common.attribute.resolver.provider.ShibbolethAttributeResolver:
512] - Loading 6 attribute definitions
13:45:27.421 - DEBUG
[edu.internet2.middleware.shibboleth.common.attribute.resolver.provider.ShibbolethAttributeResolver:
522] - Loading 3 principal connectors
13:45:28.342 - ERROR [edu.vt.middleware.ldap.pool.DefaultLdapFactory:
109] - unabled to connect to the ldap
javax.naming.CommunicationException: localhost:389
at com.sun.jndi.ldap.Connection.<init>(Connection.java:210) ~[na:
1.6.0_26]
at com.sun.jndi.ldap.LdapClient.<init>(LdapClient.java:118) ~[na:
1.6.0_26]
at com.sun.jndi.ldap.LdapClient.getInstance(LdapClient.java:1580)
~[na:1.6.0_26]
at com.sun.jndi.ldap.LdapCtx.connect(LdapCtx.java:2652) ~[na:
1.6.0_26]
at com.sun.jndi.ldap.LdapCtx.<init>(LdapCtx.java:293) ~[na:1.6.0_26]
at com.sun.jndi.ldap.LdapCtxFactory.getUsingURL(LdapCtxFactory.java:
175) ~[na:1.6.0_26]
at com.sun.jndi.ldap.LdapCtxFactory.getUsingURLs(LdapCtxFactory.java:
193) ~[na:1.6.0_26]
at
com.sun.jndi.ldap.LdapCtxFactory.getLdapCtxInstance(LdapCtxFactory.java:
136) ~[na:1.6.0_26]
at
com.sun.jndi.ldap.LdapCtxFactory.getInitialContext(LdapCtxFactory.java:
66) ~[na:1.6.0_26]
at
javax.naming.spi.NamingManager.getInitialContext(NamingManager.java:
667) ~[na:1.6.0_26]
at javax.naming.InitialContext.getDefaultInitCtx(InitialContext.java:
288) ~[na:1.6.0_26]
at javax.naming.InitialContext.init(InitialContext.java:223) ~[na:
1.6.0_26]
at
javax.naming.ldap.InitialLdapContext.<init>(InitialLdapContext.java:
134) ~[na:1.6.0_26]
at
edu.vt.middleware.ldap.handler.DefaultConnectionHandler.connectInternal(DefaultConnectionHandler.java:
102) ~[vt-ldap-3.3.3.jar:na]
at
edu.vt.middleware.ldap.handler.AbstractConnectionHandler.connect(AbstractConnectionHandler.java:
156) ~[vt-ldap-3.3.3.jar:na]
at edu.vt.middleware.ldap.AbstractLdap.connect(AbstractLdap.java:
1006) ~[vt-ldap-3.3.3.jar:na]
at
edu.vt.middleware.ldap.pool.DefaultLdapFactory.create(DefaultLdapFactory.java:
106) [vt-ldap-3.3.3.jar:na]
at
edu.vt.middleware.ldap.pool.DefaultLdapFactory.create(DefaultLdapFactory.java:
28) [vt-ldap-3.3.3.jar:na]
at
edu.internet2.middleware.shibboleth.common.attribute.resolver.provider.dataConnector.LdapPoolEmptyStrategy.checkOut(LdapPoolEmptyStrategy.java:
52) [shibboleth-common-1.3.0.jar:na]
at
edu.internet2.middleware.shibboleth.common.attribute.resolver.provider.dataConnector.LdapDataConnector.validate(LdapDataConnector.java:
274) [shibboleth-common-1.3.0.jar:na]
at
edu.internet2.middleware.shibboleth.common.attribute.resolver.provider.ShibbolethAttributeResolver.validateDataConnector(ShibbolethAttributeResolver.java:
173) [shibboleth-common-1.3.0.jar:na]
at
edu.internet2.middleware.shibboleth.common.attribute.resolver.provider.ShibbolethAttributeResolver.validate(ShibbolethAttributeResolver.java:
145) [shibboleth-common-1.3.0.jar:na]
at
edu.internet2.middleware.shibboleth.common.attribute.resolver.provider.ShibbolethAttributeResolver.onNewContextCreated(ShibbolethAttributeResolver.java:
532) [shibboleth-common-1.3.0.jar:na]
at
edu.internet2.middleware.shibboleth.common.config.BaseService.loadContext(BaseService.java:
173) [shibboleth-common-1.3.0.jar:na]
at
edu.internet2.middleware.shibboleth.common.config.BaseReloadableService.initialize(BaseReloadableService.java:
147) [shibboleth-common-1.3.0.jar:na]
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:
1.6.0_26]
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:
39) ~[na:1.6.0_26]
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:
25) ~[na:1.6.0_26]
at java.lang.reflect.Method.invoke(Method.java:597) ~[na:1.6.0_26]
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_26]
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:
4205) [catalina.jar:6.0.32]
at
org.apache.catalina.core.StandardContext.start(StandardContext.java:
4704) [catalina.jar:6.0.32]
at
org.apache.catalina.manager.ManagerServlet.start(ManagerServlet.java:
1276) [catalina.jar:6.0.32]
at
org.apache.catalina.manager.HTMLManagerServlet.start(HTMLManagerServlet.java:
625) [catalina.jar:6.0.32]
at
org.apache.catalina.manager.HTMLManagerServlet.doGet(HTMLManagerServlet.java:
136) [catalina.jar:6.0.32]
at javax.servlet.http.HttpServlet.service(HttpServlet.java:617)
[servlet-api.jar:na]
at javax.servlet.http.HttpServlet.service(HttpServlet.java:717)
[servlet-api.jar:na]
at
org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:
290) [catalina.jar:6.0.32]
at
org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:
206) [catalina.jar:6.0.32]
at
org.apache.catalina.filters.CsrfPreventionFilter.doFilter(CsrfPreventionFilter.java:
186) [catalina.jar:6.0.32]
at
org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:
235) [catalina.jar:6.0.32]
at
org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:
206) [catalina.jar:6.0.32]
at
org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:
233) [catalina.jar:6.0.32]
at
org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:
191) [catalina.jar:6.0.32]
at
org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:
563) [catalina.jar:6.0.32]
at
org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:
127) [catalina.jar:6.0.32]
at
org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:
102) [catalina.jar:6.0.32]
at
org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:
109) [catalina.jar:6.0.32]
at
org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:
298) [catalina.jar:6.0.32]
at
org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:
859) [tomcat-coyote.jar:6.0.32]
at org.apache.coyote.http11.Http11Protocol
$Http11ConnectionHandler.process(Http11Protocol.java:588) [tomcat-
coyote.jar:6.0.32]
at org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:
489) [tomcat-coyote.jar:6.0.32]
at java.lang.Thread.run(Thread.java:662) [na:1.6.0_26]
Caused by: java.net.ConnectException: Connection refused: connect
at java.net.PlainSocketImpl.socketConnect(Native Method) ~[na:
1.6.0_26]
at java.net.PlainSocketImpl.doConnect(PlainSocketImpl.java:351) ~[na:
1.6.0_26]
at java.net.PlainSocketImpl.connectToAddress(PlainSocketImpl.java:
213) ~[na:1.6.0_26]
at java.net.PlainSocketImpl.connect(PlainSocketImpl.java:200) ~[na:
1.6.0_26]
at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:366) ~[na:
1.6.0_26]
at java.net.Socket.connect(Socket.java:529) ~[na:1.6.0_26]
at java.net.Socket.connect(Socket.java:478) ~[na:1.6.0_26]
at java.net.Socket.<init>(Socket.java:375) ~[na:1.6.0_26]
at java.net.Socket.<init>(Socket.java:189) ~[na:1.6.0_26]
at com.sun.jndi.ldap.Connection.createSocket(Connection.java:352)
~[na:1.6.0_26]
at com.sun.jndi.ldap.Connection.<init>(Connection.java:187) ~[na:
1.6.0_26]
... 69 common frames omitted
13:45:28.342 - ERROR
[edu.internet2.middleware.shibboleth.common.attribute.resolver.provider.dataConnector.LdapDataConnector:
276] - Unable to retrieve an LDAP connection
13:45:28.352 - ERROR
[edu.internet2.middleware.shibboleth.common.attribute.resolver.provider.dataConnector.LdapDataConnector:
287] - Could not retrieve Ldap object from pool
edu.internet2.middleware.shibboleth.common.attribute.resolver.AttributeResolutionException:
Unable to retrieve LDAP connection
at
edu.internet2.middleware.shibboleth.common.attribute.resolver.provider.dataConnector.LdapDataConnector.validate(LdapDataConnector.java:
277) ~[shibboleth-common-1.3.0.jar:na]
at
edu.internet2.middleware.shibboleth.common.attribute.resolver.provider.ShibbolethAttributeResolver.validateDataConnector(ShibbolethAttributeResolver.java:
173) [shibboleth-common-1.3.0.jar:na]
at
edu.internet2.middleware.shibboleth.common.attribute.resolver.provider.ShibbolethAttributeResolver.validate(ShibbolethAttributeResolver.java:
145) [shibboleth-common-1.3.0.jar:na]
at
edu.internet2.middleware.shibboleth.common.attribute.resolver.provider.ShibbolethAttributeResolver.onNewContextCreated(ShibbolethAttributeResolver.java:
532) [shibboleth-common-1.3.0.jar:na]
at
edu.internet2.middleware.shibboleth.common.config.BaseService.loadContext(BaseService.java:
173) [shibboleth-common-1.3.0.jar:na]
at
edu.internet2.middleware.shibboleth.common.config.BaseReloadableService.initialize(BaseReloadableService.java:
147) [shibboleth-common-1.3.0.jar:na]
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:
1.6.0_26]
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:
39) ~[na:1.6.0_26]
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:
25) ~[na:1.6.0_26]
at java.lang.reflect.Method.invoke(Method.java:597) ~[na:1.6.0_26]
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_26]
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:
4205) [catalina.jar:6.0.32]
at
org.apache.catalina.core.StandardContext.start(StandardContext.java:
4704) [catalina.jar:6.0.32]
at
org.apache.catalina.manager.ManagerServlet.start(ManagerServlet.java:
1276) [catalina.jar:6.0.32]
at
org.apache.catalina.manager.HTMLManagerServlet.start(HTMLManagerServlet.java:
625) [catalina.jar:6.0.32]
at
org.apache.catalina.manager.HTMLManagerServlet.doGet(HTMLManagerServlet.java:
136) [catalina.jar:6.0.32]
at javax.servlet.http.HttpServlet.service(HttpServlet.java:617)
[servlet-api.jar:na]
at javax.servlet.http.HttpServlet.service(HttpServlet.java:717)
[servlet-api.jar:na]
at
org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:
290) [catalina.jar:6.0.32]
at
org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:
206) [catalina.jar:6.0.32]
at
org.apache.catalina.filters.CsrfPreventionFilter.doFilter(CsrfPreventionFilter.java:
186) [catalina.jar:6.0.32]
at
org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:
235) [catalina.jar:6.0.32]
at
org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:
206) [catalina.jar:6.0.32]
at
org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:
233) [catalina.jar:6.0.32]
at
org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:
191) [catalina.jar:6.0.32]
at
org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:
563) [catalina.jar:6.0.32]
at
org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:
127) [catalina.jar:6.0.32]
at
org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:
102) [catalina.jar:6.0.32]
at
org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:
109) [catalina.jar:6.0.32]
at
org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:
298) [catalina.jar:6.0.32]
at
org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:
859) [tomcat-coyote.jar:6.0.32]
at org.apache.coyote.http11.Http11Protocol
$Http11ConnectionHandler.process(Http11Protocol.java:588) [tomcat-
coyote.jar:6.0.32]
at org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:
489) [tomcat-coyote.jar:6.0.32]
at java.lang.Thread.run(Thread.java:662) [na:1.6.0_26]
13:45:28.352 - ERROR
[edu.internet2.middleware.shibboleth.common.config.BaseService:187] -
Configuration was not loaded for shibboleth.AttributeResolver service,
error creating components. The root cause of this error was:
edu.internet2.middleware.shibboleth.common.attribute.resolver.AttributeResolutionException:
Unable to retrieve LDAP connection

On Jul 22, 1:20 pm, Chad La Joie <laj...@itumi.biz> wrote:
> That's fine, now go back and read what I told you to make sure you
> included when you submitted a question to the user's list.
>

> On 7/22/11 8:11 AM, psyd...@nottingham.ac.uk wrote:
>
>
>
>
>
>
>
>
>
> > Hi all
>
> > I am having trouble getting the idp service to load correctly. I have
> > done the following:
>
> > 1. Install fresh copy of Windows XP (service pack 3) - I am running it
> > in Microsoft Virtual PC
>
> > 2. Run "jdk-6u26-windows-i586.exe" (Java SE Development Kit 6 Update
> > 26) and install to the default location of "C:\Program Files\Java
> > \jdk1.6.0_26\" and when prompted install JRE into the default location
> > of "C:\Program Files\Java\jre6\".
>
> > 3. In My Computer -> Advanced -> Environment Variables under "System
> > variables" click 'New' and in the variable name type JAVA_HOME and in
> > the value type in C:\Program Files\Java\jdk1.6.0_26\jre and click
> > ok(s).
>
> > 4. Restart Windows XP.
>
> > 5. Run "shibboleth-identityprovider-2.3.1.msi" and keep pressing
> > "Next" until the installation begins. I am therefore using the default
> > options provided in the installation.
>

> > 6. Browse tohttps://localhost/idp/statusbut error: HTTP STATUS 404

> > (The requested resource () is not available)
>
> > 7. Updated tomcat-users.xml to allow me to login to tomcat:
> >  <role rolename="manager-gui"/> <user username="test"
> > password="password" roles="manager-gui"/>
>
> > 8. Restarted the tomcat service.
>

> > 9. Went tohttps://localhost/

>
> > 10. Logged into Tomcat Manager with username and password
>
> > 11. Clicked "Start" next to Shibboleth Identity Provider
>
> > 12. Received error "FAIL - Application at context path /idp could not
> > be started"
>
> > 13. Undeployed /idp
>
> > 14. Deployed idp.war
>
> > 15. Start /idp again but same error - "FAIL - Application at context
> > path /idp could not be started"
>
> --

> Chad La Joiehttp://itumi.biz

[Peter Schober]

* psy...@nottingham.ac.uk <psy...@nottingham.ac.uk> [2011-07-22 14:48]:

> Here is my idp-process.log with DEBUG enabled for IdP in logging.xml:

So we should pick out the line with ERROR for you?
Here's GaaS (Grep as a Service)...

> 13:45:16.165 - ERROR [edu.vt.middleware.ldap.pool.DefaultLdapFactory:
> 109] - unabled to connect to the ldap
> javax.naming.CommunicationException: localhost:389

-peter

[Manuel Haim]

You cannot just run the IdP unconfigured...

According to your log file, the IdP's attribute resolver cannot connect
to the defined LDAP database.

Please have a look at the file attribute-resolver.xml and look for the
<resolver:DataConnector> node. You may also need to edit the
login.config file.

-Manuel

[Arjuna Scagnetto]

Hi all,

today i'm not here begging help but only to share what i've learned ,
hoping that it could be usefull and maybe someone knows a more scalable
solution than the one i've choose.

We fought against Active Directory and dns Round Robin. We know that
Microsoft implementation of X500 Ldap has some issue well reported on
the shibboleth pages.
Endeed if you have to cross the root for searching a user you need to
set the variable referrals to the value "follow" otherwise the default
value "throw" will cause an error.
Setting up referral follow is everything you need to succesfully resolve
and authenticate users. You will encounter more problems if your network
administrator has set a dns roundrobin at the name of the root.
The idp doesn't like a dns round robin if it doesn't expect to see it. I
struggle a lot to find out a solution and this is the configuration we
have to use to give a realiable service to our users.

User's credentials live in 2 OU at the base of the tree let's say the
tree is ds.example.com and the ou are employ and student.

<!-- Connectors ldap with failover Student -->

<resolver:DataConnector id="myLDAPStudent" xsi:type="dc:LDAPDirectory"
ldapURL="ldap://hostnameldap1"
baseDN="ou=student,dc=ds,dc=example,dc=com"
principal="bindcredential"
principalCredential="bindpassword">
<resolver:FailoverDataConnector ref="myLDAPSFailOver"/>
<dc:FilterTemplate>
<![CDATA[(sAMAccountName=$requestContext.principalName)]]>
</dc:FilterTemplate>
<dc:LDAPProperty name="java.naming.derefAliases" value="always"/>
</resolver:DataConnector>

<resolver:DataConnector id="myLDAPSFailOver" xsi:type="dc:LDAPDirectory"
ldapURL="ldap://hostnameldap2"
baseDN="ou=student,dc=ds,dc=example,dc=com"
principal="bindcredential"
principalCredential="bindpassword">
<resolver:FailoverDataConnector ref="myLDAPStudent"/>
<dc:FilterTemplate>
<![CDATA[(sAMAccountName=$requestContext.principalName)]]>
</dc:FilterTemplate>
<dc:LDAPProperty name="java.naming.derefAliases" value="always"/>
</resolver:DataConnector>

<!-- Connectors ldap with failover Employ -->

<resolver:DataConnector id="myLDAPEmploy" xsi:type="dc:LDAPDirectory"
ldapURL="ldap://hostnameldap1"
baseDN="ou=employ,dc=ds,dc=units,dc=it"
principal="bindcredential"
principalCredential="bindpassword">
<resolver:FailoverDataConnector ref="myLDAEPFailOver"/>
<dc:FilterTemplate>
<![CDATA[(sAMAccountName=$requestContext.principalName)]]>
</dc:FilterTemplate>
<dc:LDAPProperty name="java.naming.derefAliases" value="always"/>
</resolver:DataConnector>

<resolver:DataConnector id="myLDAPEFailOver" xsi:type="dc:LDAPDirectory"
ldapURL="ldap://hostnameldap2"
baseDN="ou=employ,dc=ds,dc=units,dc=it"
principal="bindcredential"
principalCredential="bindpassword">
<resolver:FailoverDataConnector ref="myLDAPEmploy"/>
<dc:FilterTemplate>
<![CDATA[(sAMAccountName=$requestContext.principalName)]]>
</dc:FilterTemplate>
<dc:LDAPProperty name="java.naming.derefAliases" value="always"/>
</resolver:DataConnector>

i've tried many attributes and everyone support almost two dependencies
as reference

<resolver:AttributeDefinition xsi:type="ad:Scoped"
id="eduPersonPrincipalName" scope="example.com"
sourceAttributeID="sAMAccountName">
<resolver:Dependency ref="myLDAPStudent" />
<resolver:Dependency ref="myLDAPEmploy" />
<resolver:AttributeEncoder xsi:type="enc:SAML1ScopedString"
name="urn:mace:dir:attribute-def:eduPersonPrincipalName" />
<resolver:AttributeEncoder xsi:type="enc:SAML2ScopedString"
name="urn:oid:1.3.6.1.4.1.5923.1.1.1.6" friendlyName="eduPersonPrincipa$
</resolver:AttributeDefinition>

only StoredID needs only one reference so you can use the
catalog.Setting up a new connector ldap to the catalog

<resolver:DataConnector id="myLDAPCatalog" xsi:type="dc:LDAPDirectory"
ldapURL="ldap://hostnameldap1:3268"
baseDN="dc=ds,dc=example,dc=com"
principal="bindcredential"
principalCredential="bindpassword">
<dc:FilterTemplate>
<![CDATA[(sAMAccountName=$requestContext.principalName)]]>
</dc:FilterTemplate>
<dc:LDAPProperty name="java.naming.derefAliases" value="always"/>
</resolver:DataConnector>


As you see it's neither an elegant solution nor scalable, but it works
fine. If someone has a more beatyfull solution i'll try :)

Bye
Arjuna

[Cantor, Scott E.]

On 7/22/11 9:48 AM, "Arjuna Scagnetto" <ascag...@units.it> wrote:
>
>today i'm not here begging help but only to share what i've learned ,
>hoping that it could be usefull and maybe someone knows a more scalable
>solution than the one i've choose.

If I might suggest, the wiki is a good place for this sort of material.

-- Scott

[Arjuna Scagnetto]

On 22/07/2011 16.24, Cantor, Scott E. wrote:
> On 7/22/11 9:48 AM, "Arjuna Scagnetto" <ascag...@units.it> wrote:
>> today i'm not here begging help but only to share what i've learned ,
>> hoping that it could be usefull and maybe someone knows a more scalable
>> solution than the one i've choose.
> If I might suggest, the wiki is a good place for this sort of material.
>
> -- Scott
>

hmmm realy? maybe i look for it in the wrong way.

Plz give me a link about multiple ou resolution without crossing the
root if you knwo .
i realy didn't find anything suitable for my case.

Thanks
Arjuna

[Cantor, Scott E.]

On 7/22/11 11:09 AM, "Arjuna Scagnetto" <ascag...@units.it> wrote:
>hmmm realy? maybe i look for it in the wrong way.

I didn't say it was in the wiki (I have no idea, LDAP gives me the hives),
I'm saying putting it in the wiki is better than just sending it to the
list.

-- Scott

[Arjuna Scagnetto]

On 22/07/2011 17.17, Cantor, Scott E. wrote:
> On 7/22/11 11:09 AM, "Arjuna Scagnetto" <ascag...@units.it> wrote:
>> hmmm realy? maybe i look for it in the wrong way.
> I didn't say it was in the wiki (I have no idea, LDAP gives me the hives),
> I'm saying putting it in the wiki is better than just sending it to the
> list.
>
> -- Scott
>

ohhh sorry my english is not so good... now i understand . I try .

:)

Arjuna

[Daniel Fisher]

On Fri, Jul 22, 2011 at 9:48 AM, Arjuna Scagnetto <ascag...@units.it> wrote:

We fought against Active Directory and dns Round Robin. We know that
Microsoft implementation of X500 Ldap has some issue well reported on
the shibboleth pages.
Endeed if you have to cross the root for searching a user you need to
set the variable referrals to the value "follow" otherwise the default
value "throw" will cause an error.

The default behavior is to ignore referrals. While it sounds like you have a working a solution you may want to have a look at this: http://code.google.com/p/vt-middleware/wiki/vtldapAD

--Daniel Fisher