Configs and basic unit test for replicating possible Spring bug
[java-idp.git] / velocity.log.1
1 2007-09-02 13:17:04,032 - Log4JLogChute initialized using file 'velocity.log'
2 2007-09-02 13:17:04,033 - Starting Apache Velocity v1.5 (compiled: 2007-02-22 08:52:29)
3 2007-09-02 13:17:04,033 - Default Properties File: org/apache/velocity/runtime/defaults/velocity.properties
4 2007-09-02 13:17:04,033 - Trying to use logger class org.apache.velocity.runtime.log.AvalonLogChute
5 2007-09-02 13:17:04,034 - Couldn't find class org.apache.velocity.runtime.log.AvalonLogChute or necessary supporting classes in classpath.
6 java.lang.NoClassDefFoundError: org/apache/log/format/Formatter
7         at java.lang.Class.forName0(Native Method)
8         at java.lang.Class.forName(Class.java:242)
9         at org.apache.velocity.util.ClassUtils.getClass(ClassUtils.java:63)
10         at org.apache.velocity.util.ClassUtils.getNewInstance(ClassUtils.java:95)
11         at org.apache.velocity.runtime.log.LogManager.createLogChute(LogManager.java:147)
12         at org.apache.velocity.runtime.log.LogManager.updateLog(LogManager.java:208)
13         at org.apache.velocity.runtime.RuntimeInstance.initializeLog(RuntimeInstance.java:728)
14         at org.apache.velocity.runtime.RuntimeInstance.init(RuntimeInstance.java:240)
15         at org.apache.velocity.runtime.RuntimeSingleton.init(RuntimeSingleton.java:113)
16         at org.apache.velocity.app.Velocity.init(Velocity.java:83)
17         at org.opensaml.DefaultBootstrap.initializeVelocity(DefaultBootstrap.java:116)
18         at org.opensaml.DefaultBootstrap.bootstrap(DefaultBootstrap.java:71)
19         at edu.internet2.middleware.shibboleth.common.config.OpensamlConfigBean.afterPropertiesSet(OpensamlConfigBean.java:49)
20         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeInitMethods(AbstractAutowireCapableBeanFactory.java:1202)
21         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1172)
22         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:428)
23         at org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:251)
24         at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:156)
25         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:248)
26         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:160)
27         at org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:287)
28         at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:352)
29         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:105)
30         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:90)
31         at edu.internet2.middleware.shibboleth.idp.system.conf1.BaseConf1TestCase.setUp(BaseConf1TestCase.java:21)
32         at junit.framework.TestCase.runBare(TestCase.java:125)
33         at junit.framework.TestResult$1.protect(TestResult.java:106)
34         at junit.framework.TestResult.runProtected(TestResult.java:124)
35         at junit.framework.TestResult.run(TestResult.java:109)
36         at junit.framework.TestCase.run(TestCase.java:118)
37         at junit.framework.TestSuite.runTest(TestSuite.java:208)
38         at junit.framework.TestSuite.run(TestSuite.java:203)
39         at org.eclipse.jdt.internal.junit.runner.junit3.JUnit3TestReference.run(JUnit3TestReference.java:128)
40         at org.eclipse.jdt.internal.junit.runner.TestExecution.run(TestExecution.java:38)
41         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:460)
42         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:673)
43         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.run(RemoteTestRunner.java:386)
44         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.main(RemoteTestRunner.java:196)
45 2007-09-02 13:17:04,035 - Trying to use logger class org.apache.velocity.runtime.log.Log4JLogChute
46 2007-09-02 13:17:04,035 - Using logger class org.apache.velocity.runtime.log.Log4JLogChute
47 2007-09-02 13:17:04,037 - Default ResourceManager initializing. (class org.apache.velocity.runtime.resource.ResourceManagerImpl)
48 2007-09-02 13:17:04,039 - ResourceLoader instantiated: org.apache.velocity.runtime.resource.loader.ClasspathResourceLoader
49 2007-09-02 13:17:04,050 - ResourceCache: initialized (class org.apache.velocity.runtime.resource.ResourceCacheImpl)
50 2007-09-02 13:17:04,051 - Loaded System Directive: org.apache.velocity.runtime.directive.Literal
51 2007-09-02 13:17:04,053 - Loaded System Directive: org.apache.velocity.runtime.directive.Macro
52 2007-09-02 13:17:04,054 - Loaded System Directive: org.apache.velocity.runtime.directive.Parse
53 2007-09-02 13:17:04,055 - Loaded System Directive: org.apache.velocity.runtime.directive.Include
54 2007-09-02 13:17:04,056 - Loaded System Directive: org.apache.velocity.runtime.directive.Foreach
55 2007-09-02 13:17:04,142 - Created '20' parsers.
56 2007-09-02 13:17:04,150 - Velocimacro : "velocimacro.library" is not set.  Trying default library: VM_global_library.vm
57 2007-09-02 13:17:04,150 - Velocimacro : Default library not found.
58 2007-09-02 13:17:04,150 - Velocimacro : allowInline = true : VMs can be defined inline in templates
59 2007-09-02 13:17:04,150 - Velocimacro : allowInlineToOverride = false : VMs defined inline may NOT replace previous VM definitions
60 2007-09-02 13:17:04,150 - Velocimacro : allowInlineLocal = false : VMs defined inline will be global in scope if allowed.
61 2007-09-02 13:17:04,150 - Velocimacro : autoload off : VM system will not automatically reload global library macros
62 2007-09-02 13:17:37,312 - Log4JLogChute initialized using file 'velocity.log'
63 2007-09-02 13:17:37,312 - Starting Apache Velocity v1.5 (compiled: 2007-02-22 08:52:29)
64 2007-09-02 13:17:37,312 - Default Properties File: org/apache/velocity/runtime/defaults/velocity.properties
65 2007-09-02 13:17:37,312 - Trying to use logger class org.apache.velocity.runtime.log.AvalonLogChute
66 2007-09-02 13:17:37,313 - Couldn't find class org.apache.velocity.runtime.log.AvalonLogChute or necessary supporting classes in classpath.
67 java.lang.NoClassDefFoundError: org/apache/log/format/Formatter
68         at java.lang.Class.forName0(Native Method)
69         at java.lang.Class.forName(Class.java:242)
70         at org.apache.velocity.util.ClassUtils.getClass(ClassUtils.java:63)
71         at org.apache.velocity.util.ClassUtils.getNewInstance(ClassUtils.java:95)
72         at org.apache.velocity.runtime.log.LogManager.createLogChute(LogManager.java:147)
73         at org.apache.velocity.runtime.log.LogManager.updateLog(LogManager.java:208)
74         at org.apache.velocity.runtime.RuntimeInstance.initializeLog(RuntimeInstance.java:728)
75         at org.apache.velocity.runtime.RuntimeInstance.init(RuntimeInstance.java:240)
76         at org.apache.velocity.runtime.RuntimeSingleton.init(RuntimeSingleton.java:113)
77         at org.apache.velocity.app.Velocity.init(Velocity.java:83)
78         at org.opensaml.DefaultBootstrap.initializeVelocity(DefaultBootstrap.java:116)
79         at org.opensaml.DefaultBootstrap.bootstrap(DefaultBootstrap.java:71)
80         at edu.internet2.middleware.shibboleth.common.config.OpensamlConfigBean.afterPropertiesSet(OpensamlConfigBean.java:49)
81         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeInitMethods(AbstractAutowireCapableBeanFactory.java:1202)
82         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1172)
83         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:428)
84         at org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:251)
85         at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:156)
86         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:248)
87         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:160)
88         at org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:287)
89         at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:352)
90         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:105)
91         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:90)
92         at edu.internet2.middleware.shibboleth.idp.system.conf1.BaseConf1TestCase.setUp(BaseConf1TestCase.java:21)
93         at junit.framework.TestCase.runBare(TestCase.java:125)
94         at junit.framework.TestResult$1.protect(TestResult.java:106)
95         at junit.framework.TestResult.runProtected(TestResult.java:124)
96         at junit.framework.TestResult.run(TestResult.java:109)
97         at junit.framework.TestCase.run(TestCase.java:118)
98         at junit.framework.TestSuite.runTest(TestSuite.java:208)
99         at junit.framework.TestSuite.run(TestSuite.java:203)
100         at org.eclipse.jdt.internal.junit.runner.junit3.JUnit3TestReference.run(JUnit3TestReference.java:128)
101         at org.eclipse.jdt.internal.junit.runner.TestExecution.run(TestExecution.java:38)
102         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:460)
103         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:673)
104         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.run(RemoteTestRunner.java:386)
105         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.main(RemoteTestRunner.java:196)
106 2007-09-02 13:17:37,314 - Trying to use logger class org.apache.velocity.runtime.log.Log4JLogChute
107 2007-09-02 13:17:37,314 - Using logger class org.apache.velocity.runtime.log.Log4JLogChute
108 2007-09-02 13:17:37,316 - Default ResourceManager initializing. (class org.apache.velocity.runtime.resource.ResourceManagerImpl)
109 2007-09-02 13:17:37,318 - ResourceLoader instantiated: org.apache.velocity.runtime.resource.loader.ClasspathResourceLoader
110 2007-09-02 13:17:37,364 - ResourceCache: initialized (class org.apache.velocity.runtime.resource.ResourceCacheImpl)
111 2007-09-02 13:17:37,365 - Loaded System Directive: org.apache.velocity.runtime.directive.Literal
112 2007-09-02 13:17:37,366 - Loaded System Directive: org.apache.velocity.runtime.directive.Macro
113 2007-09-02 13:17:37,368 - Loaded System Directive: org.apache.velocity.runtime.directive.Parse
114 2007-09-02 13:17:37,369 - Loaded System Directive: org.apache.velocity.runtime.directive.Include
115 2007-09-02 13:17:37,370 - Loaded System Directive: org.apache.velocity.runtime.directive.Foreach
116 2007-09-02 13:17:37,448 - Created '20' parsers.
117 2007-09-02 13:17:37,455 - Velocimacro : "velocimacro.library" is not set.  Trying default library: VM_global_library.vm
118 2007-09-02 13:17:37,455 - Velocimacro : Default library not found.
119 2007-09-02 13:17:37,455 - Velocimacro : allowInline = true : VMs can be defined inline in templates
120 2007-09-02 13:17:37,455 - Velocimacro : allowInlineToOverride = false : VMs defined inline may NOT replace previous VM definitions
121 2007-09-02 13:17:37,455 - Velocimacro : allowInlineLocal = false : VMs defined inline will be global in scope if allowed.
122 2007-09-02 13:17:37,455 - Velocimacro : autoload off : VM system will not automatically reload global library macros
123 2007-09-02 13:18:22,514 - Log4JLogChute initialized using file 'velocity.log'
124 2007-09-02 13:18:22,514 - Starting Apache Velocity v1.5 (compiled: 2007-02-22 08:52:29)
125 2007-09-02 13:18:22,514 - Default Properties File: org/apache/velocity/runtime/defaults/velocity.properties
126 2007-09-02 13:18:22,514 - Trying to use logger class org.apache.velocity.runtime.log.AvalonLogChute
127 2007-09-02 13:18:22,514 - Couldn't find class org.apache.velocity.runtime.log.AvalonLogChute or necessary supporting classes in classpath.
128 java.lang.NoClassDefFoundError: org/apache/log/format/Formatter
129         at java.lang.Class.forName0(Native Method)
130         at java.lang.Class.forName(Class.java:242)
131         at org.apache.velocity.util.ClassUtils.getClass(ClassUtils.java:63)
132         at org.apache.velocity.util.ClassUtils.getNewInstance(ClassUtils.java:95)
133         at org.apache.velocity.runtime.log.LogManager.createLogChute(LogManager.java:147)
134         at org.apache.velocity.runtime.log.LogManager.updateLog(LogManager.java:208)
135         at org.apache.velocity.runtime.RuntimeInstance.initializeLog(RuntimeInstance.java:728)
136         at org.apache.velocity.runtime.RuntimeInstance.init(RuntimeInstance.java:240)
137         at org.apache.velocity.runtime.RuntimeSingleton.init(RuntimeSingleton.java:113)
138         at org.apache.velocity.app.Velocity.init(Velocity.java:83)
139         at org.opensaml.DefaultBootstrap.initializeVelocity(DefaultBootstrap.java:116)
140         at org.opensaml.DefaultBootstrap.bootstrap(DefaultBootstrap.java:71)
141         at edu.internet2.middleware.shibboleth.common.config.OpensamlConfigBean.afterPropertiesSet(OpensamlConfigBean.java:49)
142         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeInitMethods(AbstractAutowireCapableBeanFactory.java:1202)
143         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1172)
144         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:428)
145         at org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:251)
146         at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:156)
147         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:248)
148         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:160)
149         at org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:287)
150         at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:352)
151         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:105)
152         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:90)
153         at edu.internet2.middleware.shibboleth.idp.system.conf1.BaseConf1TestCase.setUp(BaseConf1TestCase.java:21)
154         at junit.framework.TestCase.runBare(TestCase.java:125)
155         at junit.framework.TestResult$1.protect(TestResult.java:106)
156         at junit.framework.TestResult.runProtected(TestResult.java:124)
157         at junit.framework.TestResult.run(TestResult.java:109)
158         at junit.framework.TestCase.run(TestCase.java:118)
159         at junit.framework.TestSuite.runTest(TestSuite.java:208)
160         at junit.framework.TestSuite.run(TestSuite.java:203)
161         at org.eclipse.jdt.internal.junit.runner.junit3.JUnit3TestReference.run(JUnit3TestReference.java:128)
162         at org.eclipse.jdt.internal.junit.runner.TestExecution.run(TestExecution.java:38)
163         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:460)
164         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:673)
165         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.run(RemoteTestRunner.java:386)
166         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.main(RemoteTestRunner.java:196)
167 2007-09-02 13:18:22,517 - Trying to use logger class org.apache.velocity.runtime.log.Log4JLogChute
168 2007-09-02 13:18:22,517 - Using logger class org.apache.velocity.runtime.log.Log4JLogChute
169 2007-09-02 13:18:22,519 - Default ResourceManager initializing. (class org.apache.velocity.runtime.resource.ResourceManagerImpl)
170 2007-09-02 13:18:22,521 - ResourceLoader instantiated: org.apache.velocity.runtime.resource.loader.ClasspathResourceLoader
171 2007-09-02 13:18:22,531 - ResourceCache: initialized (class org.apache.velocity.runtime.resource.ResourceCacheImpl)
172 2007-09-02 13:18:22,532 - Loaded System Directive: org.apache.velocity.runtime.directive.Literal
173 2007-09-02 13:18:22,535 - Loaded System Directive: org.apache.velocity.runtime.directive.Macro
174 2007-09-02 13:18:22,536 - Loaded System Directive: org.apache.velocity.runtime.directive.Parse
175 2007-09-02 13:18:22,537 - Loaded System Directive: org.apache.velocity.runtime.directive.Include
176 2007-09-02 13:18:22,538 - Loaded System Directive: org.apache.velocity.runtime.directive.Foreach
177 2007-09-02 13:18:22,612 - Created '20' parsers.
178 2007-09-02 13:18:22,621 - Velocimacro : "velocimacro.library" is not set.  Trying default library: VM_global_library.vm
179 2007-09-02 13:18:22,622 - Velocimacro : Default library not found.
180 2007-09-02 13:18:22,622 - Velocimacro : allowInline = true : VMs can be defined inline in templates
181 2007-09-02 13:18:22,622 - Velocimacro : allowInlineToOverride = false : VMs defined inline may NOT replace previous VM definitions
182 2007-09-02 13:18:22,622 - Velocimacro : allowInlineLocal = false : VMs defined inline will be global in scope if allowed.
183 2007-09-02 13:18:22,622 - Velocimacro : autoload off : VM system will not automatically reload global library macros
184 2007-09-02 13:22:52,852 - Log4JLogChute initialized using file 'velocity.log'
185 2007-09-02 13:22:52,852 - Starting Apache Velocity v1.5 (compiled: 2007-02-22 08:52:29)
186 2007-09-02 13:22:52,852 - Default Properties File: org/apache/velocity/runtime/defaults/velocity.properties
187 2007-09-02 13:22:52,852 - Trying to use logger class org.apache.velocity.runtime.log.AvalonLogChute
188 2007-09-02 13:22:52,852 - Couldn't find class org.apache.velocity.runtime.log.AvalonLogChute or necessary supporting classes in classpath.
189 java.lang.NoClassDefFoundError: org/apache/log/format/Formatter
190         at java.lang.Class.forName0(Native Method)
191         at java.lang.Class.forName(Class.java:242)
192         at org.apache.velocity.util.ClassUtils.getClass(ClassUtils.java:63)
193         at org.apache.velocity.util.ClassUtils.getNewInstance(ClassUtils.java:95)
194         at org.apache.velocity.runtime.log.LogManager.createLogChute(LogManager.java:147)
195         at org.apache.velocity.runtime.log.LogManager.updateLog(LogManager.java:208)
196         at org.apache.velocity.runtime.RuntimeInstance.initializeLog(RuntimeInstance.java:728)
197         at org.apache.velocity.runtime.RuntimeInstance.init(RuntimeInstance.java:240)
198         at org.apache.velocity.runtime.RuntimeSingleton.init(RuntimeSingleton.java:113)
199         at org.apache.velocity.app.Velocity.init(Velocity.java:83)
200         at org.opensaml.DefaultBootstrap.initializeVelocity(DefaultBootstrap.java:116)
201         at org.opensaml.DefaultBootstrap.bootstrap(DefaultBootstrap.java:71)
202         at edu.internet2.middleware.shibboleth.common.config.OpensamlConfigBean.afterPropertiesSet(OpensamlConfigBean.java:49)
203         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeInitMethods(AbstractAutowireCapableBeanFactory.java:1202)
204         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1172)
205         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:428)
206         at org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:251)
207         at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:156)
208         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:248)
209         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:160)
210         at org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:287)
211         at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:352)
212         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:105)
213         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:90)
214         at edu.internet2.middleware.shibboleth.idp.system.conf1.BaseConf1TestCase.setUp(BaseConf1TestCase.java:21)
215         at junit.framework.TestCase.runBare(TestCase.java:125)
216         at junit.framework.TestResult$1.protect(TestResult.java:106)
217         at junit.framework.TestResult.runProtected(TestResult.java:124)
218         at junit.framework.TestResult.run(TestResult.java:109)
219         at junit.framework.TestCase.run(TestCase.java:118)
220         at junit.framework.TestSuite.runTest(TestSuite.java:208)
221         at junit.framework.TestSuite.run(TestSuite.java:203)
222         at org.eclipse.jdt.internal.junit.runner.junit3.JUnit3TestReference.run(JUnit3TestReference.java:128)
223         at org.eclipse.jdt.internal.junit.runner.TestExecution.run(TestExecution.java:38)
224         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:460)
225         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:673)
226         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.run(RemoteTestRunner.java:386)
227         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.main(RemoteTestRunner.java:196)
228 2007-09-02 13:22:52,854 - Trying to use logger class org.apache.velocity.runtime.log.Log4JLogChute
229 2007-09-02 13:22:52,854 - Using logger class org.apache.velocity.runtime.log.Log4JLogChute
230 2007-09-02 13:22:52,856 - Default ResourceManager initializing. (class org.apache.velocity.runtime.resource.ResourceManagerImpl)
231 2007-09-02 13:22:52,858 - ResourceLoader instantiated: org.apache.velocity.runtime.resource.loader.ClasspathResourceLoader
232 2007-09-02 13:22:52,869 - ResourceCache: initialized (class org.apache.velocity.runtime.resource.ResourceCacheImpl)
233 2007-09-02 13:22:52,870 - Loaded System Directive: org.apache.velocity.runtime.directive.Literal
234 2007-09-02 13:22:52,907 - Loaded System Directive: org.apache.velocity.runtime.directive.Macro
235 2007-09-02 13:22:52,908 - Loaded System Directive: org.apache.velocity.runtime.directive.Parse
236 2007-09-02 13:22:52,909 - Loaded System Directive: org.apache.velocity.runtime.directive.Include
237 2007-09-02 13:22:52,910 - Loaded System Directive: org.apache.velocity.runtime.directive.Foreach
238 2007-09-02 13:22:52,985 - Created '20' parsers.
239 2007-09-02 13:22:52,993 - Velocimacro : "velocimacro.library" is not set.  Trying default library: VM_global_library.vm
240 2007-09-02 13:22:52,994 - Velocimacro : Default library not found.
241 2007-09-02 13:22:52,994 - Velocimacro : allowInline = true : VMs can be defined inline in templates
242 2007-09-02 13:22:52,994 - Velocimacro : allowInlineToOverride = false : VMs defined inline may NOT replace previous VM definitions
243 2007-09-02 13:22:52,994 - Velocimacro : allowInlineLocal = false : VMs defined inline will be global in scope if allowed.
244 2007-09-02 13:22:52,994 - Velocimacro : autoload off : VM system will not automatically reload global library macros
245 2007-09-02 13:25:22,948 - Log4JLogChute initialized using file 'velocity.log'
246 2007-09-02 13:25:22,948 - Starting Apache Velocity v1.5 (compiled: 2007-02-22 08:52:29)
247 2007-09-02 13:25:22,949 - Default Properties File: org/apache/velocity/runtime/defaults/velocity.properties
248 2007-09-02 13:25:22,949 - Trying to use logger class org.apache.velocity.runtime.log.AvalonLogChute
249 2007-09-02 13:25:22,949 - Couldn't find class org.apache.velocity.runtime.log.AvalonLogChute or necessary supporting classes in classpath.
250 java.lang.NoClassDefFoundError: org/apache/log/format/Formatter
251         at java.lang.Class.forName0(Native Method)
252         at java.lang.Class.forName(Class.java:242)
253         at org.apache.velocity.util.ClassUtils.getClass(ClassUtils.java:63)
254         at org.apache.velocity.util.ClassUtils.getNewInstance(ClassUtils.java:95)
255         at org.apache.velocity.runtime.log.LogManager.createLogChute(LogManager.java:147)
256         at org.apache.velocity.runtime.log.LogManager.updateLog(LogManager.java:208)
257         at org.apache.velocity.runtime.RuntimeInstance.initializeLog(RuntimeInstance.java:728)
258         at org.apache.velocity.runtime.RuntimeInstance.init(RuntimeInstance.java:240)
259         at org.apache.velocity.runtime.RuntimeSingleton.init(RuntimeSingleton.java:113)
260         at org.apache.velocity.app.Velocity.init(Velocity.java:83)
261         at org.opensaml.DefaultBootstrap.initializeVelocity(DefaultBootstrap.java:116)
262         at org.opensaml.DefaultBootstrap.bootstrap(DefaultBootstrap.java:71)
263         at edu.internet2.middleware.shibboleth.common.config.OpensamlConfigBean.afterPropertiesSet(OpensamlConfigBean.java:49)
264         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeInitMethods(AbstractAutowireCapableBeanFactory.java:1202)
265         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1172)
266         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:428)
267         at org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:251)
268         at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:156)
269         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:248)
270         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:160)
271         at org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:287)
272         at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:352)
273         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:105)
274         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:90)
275         at edu.internet2.middleware.shibboleth.idp.system.conf1.BaseConf1TestCase.setUp(BaseConf1TestCase.java:21)
276         at junit.framework.TestCase.runBare(TestCase.java:125)
277         at junit.framework.TestResult$1.protect(TestResult.java:106)
278         at junit.framework.TestResult.runProtected(TestResult.java:124)
279         at junit.framework.TestResult.run(TestResult.java:109)
280         at junit.framework.TestCase.run(TestCase.java:118)
281         at junit.framework.TestSuite.runTest(TestSuite.java:208)
282         at junit.framework.TestSuite.run(TestSuite.java:203)
283         at org.eclipse.jdt.internal.junit.runner.junit3.JUnit3TestReference.run(JUnit3TestReference.java:128)
284         at org.eclipse.jdt.internal.junit.runner.TestExecution.run(TestExecution.java:38)
285         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:460)
286         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:673)
287         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.run(RemoteTestRunner.java:386)
288         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.main(RemoteTestRunner.java:196)
289 2007-09-02 13:25:22,951 - Trying to use logger class org.apache.velocity.runtime.log.Log4JLogChute
290 2007-09-02 13:25:22,951 - Using logger class org.apache.velocity.runtime.log.Log4JLogChute
291 2007-09-02 13:25:22,957 - Default ResourceManager initializing. (class org.apache.velocity.runtime.resource.ResourceManagerImpl)
292 2007-09-02 13:25:22,960 - ResourceLoader instantiated: org.apache.velocity.runtime.resource.loader.ClasspathResourceLoader
293 2007-09-02 13:25:22,979 - ResourceCache: initialized (class org.apache.velocity.runtime.resource.ResourceCacheImpl)
294 2007-09-02 13:25:22,981 - Loaded System Directive: org.apache.velocity.runtime.directive.Literal
295 2007-09-02 13:25:22,986 - Loaded System Directive: org.apache.velocity.runtime.directive.Macro
296 2007-09-02 13:25:22,988 - Loaded System Directive: org.apache.velocity.runtime.directive.Parse
297 2007-09-02 13:25:22,990 - Loaded System Directive: org.apache.velocity.runtime.directive.Include
298 2007-09-02 13:25:22,991 - Loaded System Directive: org.apache.velocity.runtime.directive.Foreach
299 2007-09-02 13:25:23,079 - Created '20' parsers.
300 2007-09-02 13:25:23,101 - Velocimacro : "velocimacro.library" is not set.  Trying default library: VM_global_library.vm
301 2007-09-02 13:25:23,102 - Velocimacro : Default library not found.
302 2007-09-02 13:25:23,102 - Velocimacro : allowInline = true : VMs can be defined inline in templates
303 2007-09-02 13:25:23,102 - Velocimacro : allowInlineToOverride = false : VMs defined inline may NOT replace previous VM definitions
304 2007-09-02 13:25:23,102 - Velocimacro : allowInlineLocal = false : VMs defined inline will be global in scope if allowed.
305 2007-09-02 13:25:23,102 - Velocimacro : autoload off : VM system will not automatically reload global library macros
306 2007-09-02 13:39:19,842 - Log4JLogChute initialized using file 'velocity.log'
307 2007-09-02 13:39:19,842 - Starting Apache Velocity v1.5 (compiled: 2007-02-22 08:52:29)
308 2007-09-02 13:39:19,842 - Default Properties File: org/apache/velocity/runtime/defaults/velocity.properties
309 2007-09-02 13:39:19,842 - Trying to use logger class org.apache.velocity.runtime.log.AvalonLogChute
310 2007-09-02 13:39:19,843 - Couldn't find class org.apache.velocity.runtime.log.AvalonLogChute or necessary supporting classes in classpath.
311 java.lang.NoClassDefFoundError: org/apache/log/format/Formatter
312         at java.lang.Class.forName0(Native Method)
313         at java.lang.Class.forName(Class.java:242)
314         at org.apache.velocity.util.ClassUtils.getClass(ClassUtils.java:63)
315         at org.apache.velocity.util.ClassUtils.getNewInstance(ClassUtils.java:95)
316         at org.apache.velocity.runtime.log.LogManager.createLogChute(LogManager.java:147)
317         at org.apache.velocity.runtime.log.LogManager.updateLog(LogManager.java:208)
318         at org.apache.velocity.runtime.RuntimeInstance.initializeLog(RuntimeInstance.java:728)
319         at org.apache.velocity.runtime.RuntimeInstance.init(RuntimeInstance.java:240)
320         at org.apache.velocity.runtime.RuntimeSingleton.init(RuntimeSingleton.java:113)
321         at org.apache.velocity.app.Velocity.init(Velocity.java:83)
322         at org.opensaml.DefaultBootstrap.initializeVelocity(DefaultBootstrap.java:116)
323         at org.opensaml.DefaultBootstrap.bootstrap(DefaultBootstrap.java:71)
324         at edu.internet2.middleware.shibboleth.common.config.OpensamlConfigBean.afterPropertiesSet(OpensamlConfigBean.java:49)
325         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeInitMethods(AbstractAutowireCapableBeanFactory.java:1202)
326         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1172)
327         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:428)
328         at org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:251)
329         at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:156)
330         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:248)
331         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:160)
332         at org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:287)
333         at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:352)
334         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:105)
335         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:90)
336         at edu.internet2.middleware.shibboleth.idp.system.conf1.BaseConf1TestCase.setUp(BaseConf1TestCase.java:21)
337         at junit.framework.TestCase.runBare(TestCase.java:125)
338         at junit.framework.TestResult$1.protect(TestResult.java:106)
339         at junit.framework.TestResult.runProtected(TestResult.java:124)
340         at junit.framework.TestResult.run(TestResult.java:109)
341         at junit.framework.TestCase.run(TestCase.java:118)
342         at junit.framework.TestSuite.runTest(TestSuite.java:208)
343         at junit.framework.TestSuite.run(TestSuite.java:203)
344         at org.eclipse.jdt.internal.junit.runner.junit3.JUnit3TestReference.run(JUnit3TestReference.java:128)
345         at org.eclipse.jdt.internal.junit.runner.TestExecution.run(TestExecution.java:38)
346         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:460)
347         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:673)
348         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.run(RemoteTestRunner.java:386)
349         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.main(RemoteTestRunner.java:196)
350 2007-09-02 13:39:19,844 - Trying to use logger class org.apache.velocity.runtime.log.Log4JLogChute
351 2007-09-02 13:39:19,844 - Using logger class org.apache.velocity.runtime.log.Log4JLogChute
352 2007-09-02 13:39:19,846 - Default ResourceManager initializing. (class org.apache.velocity.runtime.resource.ResourceManagerImpl)
353 2007-09-02 13:39:19,849 - ResourceLoader instantiated: org.apache.velocity.runtime.resource.loader.ClasspathResourceLoader
354 2007-09-02 13:39:19,859 - ResourceCache: initialized (class org.apache.velocity.runtime.resource.ResourceCacheImpl)
355 2007-09-02 13:39:19,861 - Loaded System Directive: org.apache.velocity.runtime.directive.Literal
356 2007-09-02 13:39:19,862 - Loaded System Directive: org.apache.velocity.runtime.directive.Macro
357 2007-09-02 13:39:19,863 - Loaded System Directive: org.apache.velocity.runtime.directive.Parse
358 2007-09-02 13:39:19,864 - Loaded System Directive: org.apache.velocity.runtime.directive.Include
359 2007-09-02 13:39:19,865 - Loaded System Directive: org.apache.velocity.runtime.directive.Foreach
360 2007-09-02 13:39:19,945 - Created '20' parsers.
361 2007-09-02 13:39:19,954 - Velocimacro : "velocimacro.library" is not set.  Trying default library: VM_global_library.vm
362 2007-09-02 13:39:19,954 - Velocimacro : Default library not found.
363 2007-09-02 13:39:19,955 - Velocimacro : allowInline = true : VMs can be defined inline in templates
364 2007-09-02 13:39:19,955 - Velocimacro : allowInlineToOverride = false : VMs defined inline may NOT replace previous VM definitions
365 2007-09-02 13:39:19,955 - Velocimacro : allowInlineLocal = false : VMs defined inline will be global in scope if allowed.
366 2007-09-02 13:39:19,955 - Velocimacro : autoload off : VM system will not automatically reload global library macros
367 2007-09-02 13:40:56,437 - Log4JLogChute initialized using file 'velocity.log'
368 2007-09-02 13:40:56,437 - Starting Apache Velocity v1.5 (compiled: 2007-02-22 08:52:29)
369 2007-09-02 13:40:56,437 - Default Properties File: org/apache/velocity/runtime/defaults/velocity.properties
370 2007-09-02 13:40:56,437 - Trying to use logger class org.apache.velocity.runtime.log.AvalonLogChute
371 2007-09-02 13:40:56,439 - Couldn't find class org.apache.velocity.runtime.log.AvalonLogChute or necessary supporting classes in classpath.
372 java.lang.NoClassDefFoundError: org/apache/log/format/Formatter
373         at java.lang.Class.forName0(Native Method)
374         at java.lang.Class.forName(Class.java:242)
375         at org.apache.velocity.util.ClassUtils.getClass(ClassUtils.java:63)
376         at org.apache.velocity.util.ClassUtils.getNewInstance(ClassUtils.java:95)
377         at org.apache.velocity.runtime.log.LogManager.createLogChute(LogManager.java:147)
378         at org.apache.velocity.runtime.log.LogManager.updateLog(LogManager.java:208)
379         at org.apache.velocity.runtime.RuntimeInstance.initializeLog(RuntimeInstance.java:728)
380         at org.apache.velocity.runtime.RuntimeInstance.init(RuntimeInstance.java:240)
381         at org.apache.velocity.runtime.RuntimeSingleton.init(RuntimeSingleton.java:113)
382         at org.apache.velocity.app.Velocity.init(Velocity.java:83)
383         at org.opensaml.DefaultBootstrap.initializeVelocity(DefaultBootstrap.java:116)
384         at org.opensaml.DefaultBootstrap.bootstrap(DefaultBootstrap.java:71)
385         at edu.internet2.middleware.shibboleth.common.config.OpensamlConfigBean.afterPropertiesSet(OpensamlConfigBean.java:49)
386         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeInitMethods(AbstractAutowireCapableBeanFactory.java:1202)
387         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1172)
388         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:428)
389         at org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:251)
390         at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:156)
391         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:248)
392         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:160)
393         at org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:287)
394         at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:352)
395         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:105)
396         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:90)
397         at edu.internet2.middleware.shibboleth.idp.system.conf1.BaseConf1TestCase.setUp(BaseConf1TestCase.java:21)
398         at junit.framework.TestCase.runBare(TestCase.java:125)
399         at junit.framework.TestResult$1.protect(TestResult.java:106)
400         at junit.framework.TestResult.runProtected(TestResult.java:124)
401         at junit.framework.TestResult.run(TestResult.java:109)
402         at junit.framework.TestCase.run(TestCase.java:118)
403         at junit.framework.TestSuite.runTest(TestSuite.java:208)
404         at junit.framework.TestSuite.run(TestSuite.java:203)
405         at org.eclipse.jdt.internal.junit.runner.junit3.JUnit3TestReference.run(JUnit3TestReference.java:128)
406         at org.eclipse.jdt.internal.junit.runner.TestExecution.run(TestExecution.java:38)
407         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:460)
408         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:673)
409         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.run(RemoteTestRunner.java:386)
410         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.main(RemoteTestRunner.java:196)
411 2007-09-02 13:40:56,440 - Trying to use logger class org.apache.velocity.runtime.log.Log4JLogChute
412 2007-09-02 13:40:56,440 - Using logger class org.apache.velocity.runtime.log.Log4JLogChute
413 2007-09-02 13:40:56,443 - Default ResourceManager initializing. (class org.apache.velocity.runtime.resource.ResourceManagerImpl)
414 2007-09-02 13:40:56,447 - ResourceLoader instantiated: org.apache.velocity.runtime.resource.loader.ClasspathResourceLoader
415 2007-09-02 13:40:56,466 - ResourceCache: initialized (class org.apache.velocity.runtime.resource.ResourceCacheImpl)
416 2007-09-02 13:40:56,470 - Loaded System Directive: org.apache.velocity.runtime.directive.Literal
417 2007-09-02 13:40:56,472 - Loaded System Directive: org.apache.velocity.runtime.directive.Macro
418 2007-09-02 13:40:56,473 - Loaded System Directive: org.apache.velocity.runtime.directive.Parse
419 2007-09-02 13:40:56,475 - Loaded System Directive: org.apache.velocity.runtime.directive.Include
420 2007-09-02 13:40:56,476 - Loaded System Directive: org.apache.velocity.runtime.directive.Foreach
421 2007-09-02 13:40:56,565 - Created '20' parsers.
422 2007-09-02 13:40:56,580 - Velocimacro : "velocimacro.library" is not set.  Trying default library: VM_global_library.vm
423 2007-09-02 13:40:56,583 - Velocimacro : Default library not found.
424 2007-09-02 13:40:56,583 - Velocimacro : allowInline = true : VMs can be defined inline in templates
425 2007-09-02 13:40:56,583 - Velocimacro : allowInlineToOverride = false : VMs defined inline may NOT replace previous VM definitions
426 2007-09-02 13:40:56,583 - Velocimacro : allowInlineLocal = false : VMs defined inline will be global in scope if allowed.
427 2007-09-02 13:40:56,583 - Velocimacro : autoload off : VM system will not automatically reload global library macros
428 2007-09-02 13:47:15,632 - Log4JLogChute initialized using file 'velocity.log'
429 2007-09-02 13:47:15,633 - Starting Apache Velocity v1.5 (compiled: 2007-02-22 08:52:29)
430 2007-09-02 13:47:15,633 - Default Properties File: org/apache/velocity/runtime/defaults/velocity.properties
431 2007-09-02 13:47:15,633 - Trying to use logger class org.apache.velocity.runtime.log.AvalonLogChute
432 2007-09-02 13:47:15,634 - Couldn't find class org.apache.velocity.runtime.log.AvalonLogChute or necessary supporting classes in classpath.
433 java.lang.NoClassDefFoundError: org/apache/log/format/Formatter
434         at java.lang.Class.forName0(Native Method)
435         at java.lang.Class.forName(Class.java:242)
436         at org.apache.velocity.util.ClassUtils.getClass(ClassUtils.java:63)
437         at org.apache.velocity.util.ClassUtils.getNewInstance(ClassUtils.java:95)
438         at org.apache.velocity.runtime.log.LogManager.createLogChute(LogManager.java:147)
439         at org.apache.velocity.runtime.log.LogManager.updateLog(LogManager.java:208)
440         at org.apache.velocity.runtime.RuntimeInstance.initializeLog(RuntimeInstance.java:728)
441         at org.apache.velocity.runtime.RuntimeInstance.init(RuntimeInstance.java:240)
442         at org.apache.velocity.runtime.RuntimeSingleton.init(RuntimeSingleton.java:113)
443         at org.apache.velocity.app.Velocity.init(Velocity.java:83)
444         at org.opensaml.DefaultBootstrap.initializeVelocity(DefaultBootstrap.java:116)
445         at org.opensaml.DefaultBootstrap.bootstrap(DefaultBootstrap.java:71)
446         at edu.internet2.middleware.shibboleth.common.config.OpensamlConfigBean.afterPropertiesSet(OpensamlConfigBean.java:49)
447         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeInitMethods(AbstractAutowireCapableBeanFactory.java:1202)
448         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1172)
449         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:428)
450         at org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:251)
451         at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:156)
452         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:248)
453         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:160)
454         at org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:287)
455         at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:352)
456         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:105)
457         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:90)
458         at edu.internet2.middleware.shibboleth.idp.system.conf1.BaseConf1TestCase.setUp(BaseConf1TestCase.java:21)
459         at junit.framework.TestCase.runBare(TestCase.java:125)
460         at junit.framework.TestResult$1.protect(TestResult.java:106)
461         at junit.framework.TestResult.runProtected(TestResult.java:124)
462         at junit.framework.TestResult.run(TestResult.java:109)
463         at junit.framework.TestCase.run(TestCase.java:118)
464         at junit.framework.TestSuite.runTest(TestSuite.java:208)
465         at junit.framework.TestSuite.run(TestSuite.java:203)
466         at org.eclipse.jdt.internal.junit.runner.junit3.JUnit3TestReference.run(JUnit3TestReference.java:128)
467         at org.eclipse.jdt.internal.junit.runner.TestExecution.run(TestExecution.java:38)
468         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:460)
469         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:673)
470         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.run(RemoteTestRunner.java:386)
471         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.main(RemoteTestRunner.java:196)
472 2007-09-02 13:47:15,635 - Trying to use logger class org.apache.velocity.runtime.log.Log4JLogChute
473 2007-09-02 13:47:15,635 - Using logger class org.apache.velocity.runtime.log.Log4JLogChute
474 2007-09-02 13:47:15,639 - Default ResourceManager initializing. (class org.apache.velocity.runtime.resource.ResourceManagerImpl)
475 2007-09-02 13:47:15,646 - ResourceLoader instantiated: org.apache.velocity.runtime.resource.loader.ClasspathResourceLoader
476 2007-09-02 13:47:15,662 - ResourceCache: initialized (class org.apache.velocity.runtime.resource.ResourceCacheImpl)
477 2007-09-02 13:47:15,667 - Loaded System Directive: org.apache.velocity.runtime.directive.Literal
478 2007-09-02 13:47:15,669 - Loaded System Directive: org.apache.velocity.runtime.directive.Macro
479 2007-09-02 13:47:15,671 - Loaded System Directive: org.apache.velocity.runtime.directive.Parse
480 2007-09-02 13:47:15,672 - Loaded System Directive: org.apache.velocity.runtime.directive.Include
481 2007-09-02 13:47:15,673 - Loaded System Directive: org.apache.velocity.runtime.directive.Foreach
482 2007-09-02 13:47:15,762 - Created '20' parsers.
483 2007-09-02 13:47:15,777 - Velocimacro : "velocimacro.library" is not set.  Trying default library: VM_global_library.vm
484 2007-09-02 13:47:15,782 - Velocimacro : Default library not found.
485 2007-09-02 13:47:15,783 - Velocimacro : allowInline = true : VMs can be defined inline in templates
486 2007-09-02 13:47:15,783 - Velocimacro : allowInlineToOverride = false : VMs defined inline may NOT replace previous VM definitions
487 2007-09-02 13:47:15,783 - Velocimacro : allowInlineLocal = false : VMs defined inline will be global in scope if allowed.
488 2007-09-02 13:47:15,783 - Velocimacro : autoload off : VM system will not automatically reload global library macros
489 2007-09-02 14:12:34,225 - Log4JLogChute initialized using file 'velocity.log'
490 2007-09-02 14:12:34,225 - Starting Apache Velocity v1.5 (compiled: 2007-02-22 08:52:29)
491 2007-09-02 14:12:34,225 - Default Properties File: org/apache/velocity/runtime/defaults/velocity.properties
492 2007-09-02 14:12:34,225 - Trying to use logger class org.apache.velocity.runtime.log.AvalonLogChute
493 2007-09-02 14:12:34,226 - Couldn't find class org.apache.velocity.runtime.log.AvalonLogChute or necessary supporting classes in classpath.
494 java.lang.NoClassDefFoundError: org/apache/log/format/Formatter
495         at java.lang.Class.forName0(Native Method)
496         at java.lang.Class.forName(Class.java:242)
497         at org.apache.velocity.util.ClassUtils.getClass(ClassUtils.java:63)
498         at org.apache.velocity.util.ClassUtils.getNewInstance(ClassUtils.java:95)
499         at org.apache.velocity.runtime.log.LogManager.createLogChute(LogManager.java:147)
500         at org.apache.velocity.runtime.log.LogManager.updateLog(LogManager.java:208)
501         at org.apache.velocity.runtime.RuntimeInstance.initializeLog(RuntimeInstance.java:728)
502         at org.apache.velocity.runtime.RuntimeInstance.init(RuntimeInstance.java:240)
503         at org.apache.velocity.runtime.RuntimeSingleton.init(RuntimeSingleton.java:113)
504         at org.apache.velocity.app.Velocity.init(Velocity.java:83)
505         at org.opensaml.DefaultBootstrap.initializeVelocity(DefaultBootstrap.java:116)
506         at org.opensaml.DefaultBootstrap.bootstrap(DefaultBootstrap.java:71)
507         at edu.internet2.middleware.shibboleth.common.config.OpensamlConfigBean.afterPropertiesSet(OpensamlConfigBean.java:49)
508         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeInitMethods(AbstractAutowireCapableBeanFactory.java:1201)
509         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1171)
510         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:425)
511         at org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:251)
512         at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:156)
513         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:248)
514         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:160)
515         at org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:287)
516         at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:352)
517         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:105)
518         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:90)
519         at edu.internet2.middleware.shibboleth.idp.system.conf1.BaseConf1TestCase.setUp(BaseConf1TestCase.java:21)
520         at junit.framework.TestCase.runBare(TestCase.java:125)
521         at junit.framework.TestResult$1.protect(TestResult.java:106)
522         at junit.framework.TestResult.runProtected(TestResult.java:124)
523         at junit.framework.TestResult.run(TestResult.java:109)
524         at junit.framework.TestCase.run(TestCase.java:118)
525         at junit.framework.TestSuite.runTest(TestSuite.java:208)
526         at junit.framework.TestSuite.run(TestSuite.java:203)
527         at org.eclipse.jdt.internal.junit.runner.junit3.JUnit3TestReference.run(JUnit3TestReference.java:128)
528         at org.eclipse.jdt.internal.junit.runner.TestExecution.run(TestExecution.java:38)
529         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:460)
530         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:673)
531         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.run(RemoteTestRunner.java:386)
532         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.main(RemoteTestRunner.java:196)
533 2007-09-02 14:12:34,228 - Trying to use logger class org.apache.velocity.runtime.log.Log4JLogChute
534 2007-09-02 14:12:34,228 - Using logger class org.apache.velocity.runtime.log.Log4JLogChute
535 2007-09-02 14:12:34,230 - Default ResourceManager initializing. (class org.apache.velocity.runtime.resource.ResourceManagerImpl)
536 2007-09-02 14:12:34,239 - ResourceLoader instantiated: org.apache.velocity.runtime.resource.loader.ClasspathResourceLoader
537 2007-09-02 14:12:34,255 - ResourceCache: initialized (class org.apache.velocity.runtime.resource.ResourceCacheImpl)
538 2007-09-02 14:12:34,260 - Loaded System Directive: org.apache.velocity.runtime.directive.Literal
539 2007-09-02 14:12:34,262 - Loaded System Directive: org.apache.velocity.runtime.directive.Macro
540 2007-09-02 14:12:34,263 - Loaded System Directive: org.apache.velocity.runtime.directive.Parse
541 2007-09-02 14:12:34,265 - Loaded System Directive: org.apache.velocity.runtime.directive.Include
542 2007-09-02 14:12:34,266 - Loaded System Directive: org.apache.velocity.runtime.directive.Foreach
543 2007-09-02 14:12:34,359 - Created '20' parsers.
544 2007-09-02 14:12:34,375 - Velocimacro : "velocimacro.library" is not set.  Trying default library: VM_global_library.vm
545 2007-09-02 14:12:34,380 - Velocimacro : Default library not found.
546 2007-09-02 14:12:34,380 - Velocimacro : allowInline = true : VMs can be defined inline in templates
547 2007-09-02 14:12:34,380 - Velocimacro : allowInlineToOverride = false : VMs defined inline may NOT replace previous VM definitions
548 2007-09-02 14:12:34,380 - Velocimacro : allowInlineLocal = false : VMs defined inline will be global in scope if allowed.
549 2007-09-02 14:12:34,380 - Velocimacro : autoload off : VM system will not automatically reload global library macros
550 2007-09-02 14:15:50,508 - Log4JLogChute initialized using file 'velocity.log'
551 2007-09-02 14:15:50,508 - Starting Apache Velocity v1.5 (compiled: 2007-02-22 08:52:29)
552 2007-09-02 14:15:50,509 - Default Properties File: org/apache/velocity/runtime/defaults/velocity.properties
553 2007-09-02 14:15:50,509 - Trying to use logger class org.apache.velocity.runtime.log.AvalonLogChute
554 2007-09-02 14:15:50,510 - Couldn't find class org.apache.velocity.runtime.log.AvalonLogChute or necessary supporting classes in classpath.
555 java.lang.NoClassDefFoundError: org/apache/log/format/Formatter
556         at java.lang.Class.forName0(Native Method)
557         at java.lang.Class.forName(Class.java:242)
558         at org.apache.velocity.util.ClassUtils.getClass(ClassUtils.java:63)
559         at org.apache.velocity.util.ClassUtils.getNewInstance(ClassUtils.java:95)
560         at org.apache.velocity.runtime.log.LogManager.createLogChute(LogManager.java:147)
561         at org.apache.velocity.runtime.log.LogManager.updateLog(LogManager.java:208)
562         at org.apache.velocity.runtime.RuntimeInstance.initializeLog(RuntimeInstance.java:728)
563         at org.apache.velocity.runtime.RuntimeInstance.init(RuntimeInstance.java:240)
564         at org.apache.velocity.runtime.RuntimeSingleton.init(RuntimeSingleton.java:113)
565         at org.apache.velocity.app.Velocity.init(Velocity.java:83)
566         at org.opensaml.DefaultBootstrap.initializeVelocity(DefaultBootstrap.java:116)
567         at org.opensaml.DefaultBootstrap.bootstrap(DefaultBootstrap.java:71)
568         at edu.internet2.middleware.shibboleth.common.config.OpensamlConfigBean.afterPropertiesSet(OpensamlConfigBean.java:49)
569         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeInitMethods(AbstractAutowireCapableBeanFactory.java:1201)
570         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1171)
571         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:425)
572         at org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:251)
573         at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:156)
574         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:248)
575         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:160)
576         at org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:287)
577         at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:352)
578         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:105)
579         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:90)
580         at edu.internet2.middleware.shibboleth.idp.system.conf1.BaseConf1TestCase.setUp(BaseConf1TestCase.java:21)
581         at junit.framework.TestCase.runBare(TestCase.java:125)
582         at junit.framework.TestResult$1.protect(TestResult.java:106)
583         at junit.framework.TestResult.runProtected(TestResult.java:124)
584         at junit.framework.TestResult.run(TestResult.java:109)
585         at junit.framework.TestCase.run(TestCase.java:118)
586         at junit.framework.TestSuite.runTest(TestSuite.java:208)
587         at junit.framework.TestSuite.run(TestSuite.java:203)
588         at org.eclipse.jdt.internal.junit.runner.junit3.JUnit3TestReference.run(JUnit3TestReference.java:128)
589         at org.eclipse.jdt.internal.junit.runner.TestExecution.run(TestExecution.java:38)
590         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:460)
591         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:673)
592         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.run(RemoteTestRunner.java:386)
593         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.main(RemoteTestRunner.java:196)
594 2007-09-02 14:15:50,511 - Trying to use logger class org.apache.velocity.runtime.log.Log4JLogChute
595 2007-09-02 14:15:50,511 - Using logger class org.apache.velocity.runtime.log.Log4JLogChute
596 2007-09-02 14:15:50,514 - Default ResourceManager initializing. (class org.apache.velocity.runtime.resource.ResourceManagerImpl)
597 2007-09-02 14:15:50,522 - ResourceLoader instantiated: org.apache.velocity.runtime.resource.loader.ClasspathResourceLoader
598 2007-09-02 14:15:50,537 - ResourceCache: initialized (class org.apache.velocity.runtime.resource.ResourceCacheImpl)
599 2007-09-02 14:15:50,542 - Loaded System Directive: org.apache.velocity.runtime.directive.Literal
600 2007-09-02 14:15:50,543 - Loaded System Directive: org.apache.velocity.runtime.directive.Macro
601 2007-09-02 14:15:50,545 - Loaded System Directive: org.apache.velocity.runtime.directive.Parse
602 2007-09-02 14:15:50,547 - Loaded System Directive: org.apache.velocity.runtime.directive.Include
603 2007-09-02 14:15:50,548 - Loaded System Directive: org.apache.velocity.runtime.directive.Foreach
604 2007-09-02 14:15:50,638 - Created '20' parsers.
605 2007-09-02 14:15:50,656 - Velocimacro : "velocimacro.library" is not set.  Trying default library: VM_global_library.vm
606 2007-09-02 14:15:50,659 - Velocimacro : Default library not found.
607 2007-09-02 14:15:50,659 - Velocimacro : allowInline = true : VMs can be defined inline in templates
608 2007-09-02 14:15:50,659 - Velocimacro : allowInlineToOverride = false : VMs defined inline may NOT replace previous VM definitions
609 2007-09-02 14:15:50,659 - Velocimacro : allowInlineLocal = false : VMs defined inline will be global in scope if allowed.
610 2007-09-02 14:15:50,659 - Velocimacro : autoload off : VM system will not automatically reload global library macros
611 2007-09-02 14:19:14,513 - Log4JLogChute initialized using file 'velocity.log'
612 2007-09-02 14:19:14,514 - Starting Apache Velocity v1.5 (compiled: 2007-02-22 08:52:29)
613 2007-09-02 14:19:14,514 - Default Properties File: org/apache/velocity/runtime/defaults/velocity.properties
614 2007-09-02 14:19:14,514 - Trying to use logger class org.apache.velocity.runtime.log.AvalonLogChute
615 2007-09-02 14:19:14,515 - Couldn't find class org.apache.velocity.runtime.log.AvalonLogChute or necessary supporting classes in classpath.
616 java.lang.NoClassDefFoundError: org/apache/log/format/Formatter
617         at java.lang.Class.forName0(Native Method)
618         at java.lang.Class.forName(Class.java:242)
619         at org.apache.velocity.util.ClassUtils.getClass(ClassUtils.java:63)
620         at org.apache.velocity.util.ClassUtils.getNewInstance(ClassUtils.java:95)
621         at org.apache.velocity.runtime.log.LogManager.createLogChute(LogManager.java:147)
622         at org.apache.velocity.runtime.log.LogManager.updateLog(LogManager.java:208)
623         at org.apache.velocity.runtime.RuntimeInstance.initializeLog(RuntimeInstance.java:728)
624         at org.apache.velocity.runtime.RuntimeInstance.init(RuntimeInstance.java:240)
625         at org.apache.velocity.runtime.RuntimeSingleton.init(RuntimeSingleton.java:113)
626         at org.apache.velocity.app.Velocity.init(Velocity.java:83)
627         at org.opensaml.DefaultBootstrap.initializeVelocity(DefaultBootstrap.java:116)
628         at org.opensaml.DefaultBootstrap.bootstrap(DefaultBootstrap.java:71)
629         at edu.internet2.middleware.shibboleth.common.config.OpensamlConfigBean.afterPropertiesSet(OpensamlConfigBean.java:49)
630         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeInitMethods(AbstractAutowireCapableBeanFactory.java:1201)
631         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1171)
632         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:425)
633         at org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:251)
634         at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:156)
635         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:248)
636         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:160)
637         at org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:287)
638         at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:352)
639         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:105)
640         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:90)
641         at edu.internet2.middleware.shibboleth.idp.system.conf1.BaseConf1TestCase.setUp(BaseConf1TestCase.java:21)
642         at junit.framework.TestCase.runBare(TestCase.java:125)
643         at junit.framework.TestResult$1.protect(TestResult.java:106)
644         at junit.framework.TestResult.runProtected(TestResult.java:124)
645         at junit.framework.TestResult.run(TestResult.java:109)
646         at junit.framework.TestCase.run(TestCase.java:118)
647         at junit.framework.TestSuite.runTest(TestSuite.java:208)
648         at junit.framework.TestSuite.run(TestSuite.java:203)
649         at org.eclipse.jdt.internal.junit.runner.junit3.JUnit3TestReference.run(JUnit3TestReference.java:128)
650         at org.eclipse.jdt.internal.junit.runner.TestExecution.run(TestExecution.java:38)
651         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:460)
652         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:673)
653         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.run(RemoteTestRunner.java:386)
654         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.main(RemoteTestRunner.java:196)
655 2007-09-02 14:19:14,516 - Trying to use logger class org.apache.velocity.runtime.log.Log4JLogChute
656 2007-09-02 14:19:14,516 - Using logger class org.apache.velocity.runtime.log.Log4JLogChute
657 2007-09-02 14:19:14,519 - Default ResourceManager initializing. (class org.apache.velocity.runtime.resource.ResourceManagerImpl)
658 2007-09-02 14:19:14,527 - ResourceLoader instantiated: org.apache.velocity.runtime.resource.loader.ClasspathResourceLoader
659 2007-09-02 14:19:14,542 - ResourceCache: initialized (class org.apache.velocity.runtime.resource.ResourceCacheImpl)
660 2007-09-02 14:19:14,547 - Loaded System Directive: org.apache.velocity.runtime.directive.Literal
661 2007-09-02 14:19:14,549 - Loaded System Directive: org.apache.velocity.runtime.directive.Macro
662 2007-09-02 14:19:14,551 - Loaded System Directive: org.apache.velocity.runtime.directive.Parse
663 2007-09-02 14:19:14,552 - Loaded System Directive: org.apache.velocity.runtime.directive.Include
664 2007-09-02 14:19:14,553 - Loaded System Directive: org.apache.velocity.runtime.directive.Foreach
665 2007-09-02 14:19:14,641 - Created '20' parsers.
666 2007-09-02 14:19:14,656 - Velocimacro : "velocimacro.library" is not set.  Trying default library: VM_global_library.vm
667 2007-09-02 14:19:14,661 - Velocimacro : Default library not found.
668 2007-09-02 14:19:14,661 - Velocimacro : allowInline = true : VMs can be defined inline in templates
669 2007-09-02 14:19:14,661 - Velocimacro : allowInlineToOverride = false : VMs defined inline may NOT replace previous VM definitions
670 2007-09-02 14:19:14,661 - Velocimacro : allowInlineLocal = false : VMs defined inline will be global in scope if allowed.
671 2007-09-02 14:19:14,661 - Velocimacro : autoload off : VM system will not automatically reload global library macros
672 2007-09-03 09:20:00,197 - Log4JLogChute initialized using file 'velocity.log'
673 2007-09-03 09:20:00,209 - Starting Apache Velocity v1.5 (compiled: 2007-02-22 08:52:29)
674 2007-09-03 09:20:00,209 - Default Properties File: org/apache/velocity/runtime/defaults/velocity.properties
675 2007-09-03 09:20:00,209 - Trying to use logger class org.apache.velocity.runtime.log.AvalonLogChute
676 2007-09-03 09:20:00,210 - Couldn't find class org.apache.velocity.runtime.log.AvalonLogChute or necessary supporting classes in classpath.
677 java.lang.NoClassDefFoundError: org/apache/log/format/Formatter
678         at java.lang.Class.forName0(Native Method)
679         at java.lang.Class.forName(Class.java:242)
680         at org.apache.velocity.util.ClassUtils.getClass(ClassUtils.java:63)
681         at org.apache.velocity.util.ClassUtils.getNewInstance(ClassUtils.java:95)
682         at org.apache.velocity.runtime.log.LogManager.createLogChute(LogManager.java:147)
683         at org.apache.velocity.runtime.log.LogManager.updateLog(LogManager.java:208)
684         at org.apache.velocity.runtime.RuntimeInstance.initializeLog(RuntimeInstance.java:728)
685         at org.apache.velocity.runtime.RuntimeInstance.init(RuntimeInstance.java:240)
686         at org.apache.velocity.runtime.RuntimeSingleton.init(RuntimeSingleton.java:113)
687         at org.apache.velocity.app.Velocity.init(Velocity.java:83)
688         at org.opensaml.DefaultBootstrap.initializeVelocity(DefaultBootstrap.java:116)
689         at org.opensaml.DefaultBootstrap.bootstrap(DefaultBootstrap.java:71)
690         at edu.internet2.middleware.shibboleth.common.config.OpensamlConfigBean.afterPropertiesSet(OpensamlConfigBean.java:49)
691         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeInitMethods(AbstractAutowireCapableBeanFactory.java:1201)
692         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1171)
693         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:425)
694         at org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:251)
695         at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:156)
696         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:248)
697         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:160)
698         at org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:287)
699         at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:352)
700         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:105)
701         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:90)
702         at edu.internet2.middleware.shibboleth.idp.system.conf1.BaseConf1TestCase.setUp(BaseConf1TestCase.java:21)
703         at junit.framework.TestCase.runBare(TestCase.java:125)
704         at junit.framework.TestResult$1.protect(TestResult.java:106)
705         at junit.framework.TestResult.runProtected(TestResult.java:124)
706         at junit.framework.TestResult.run(TestResult.java:109)
707         at junit.framework.TestCase.run(TestCase.java:118)
708         at junit.framework.TestSuite.runTest(TestSuite.java:208)
709         at junit.framework.TestSuite.run(TestSuite.java:203)
710         at org.eclipse.jdt.internal.junit.runner.junit3.JUnit3TestReference.run(JUnit3TestReference.java:128)
711         at org.eclipse.jdt.internal.junit.runner.TestExecution.run(TestExecution.java:38)
712         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:460)
713         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:673)
714         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.run(RemoteTestRunner.java:386)
715         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.main(RemoteTestRunner.java:196)
716 2007-09-03 09:20:00,211 - Trying to use logger class org.apache.velocity.runtime.log.Log4JLogChute
717 2007-09-03 09:20:00,211 - Using logger class org.apache.velocity.runtime.log.Log4JLogChute
718 2007-09-03 09:20:00,214 - Default ResourceManager initializing. (class org.apache.velocity.runtime.resource.ResourceManagerImpl)
719 2007-09-03 09:20:00,217 - ResourceLoader instantiated: org.apache.velocity.runtime.resource.loader.ClasspathResourceLoader
720 2007-09-03 09:20:00,227 - ResourceCache: initialized (class org.apache.velocity.runtime.resource.ResourceCacheImpl)
721 2007-09-03 09:20:00,228 - Loaded System Directive: org.apache.velocity.runtime.directive.Literal
722 2007-09-03 09:20:00,229 - Loaded System Directive: org.apache.velocity.runtime.directive.Macro
723 2007-09-03 09:20:00,231 - Loaded System Directive: org.apache.velocity.runtime.directive.Parse
724 2007-09-03 09:20:00,232 - Loaded System Directive: org.apache.velocity.runtime.directive.Include
725 2007-09-03 09:20:00,233 - Loaded System Directive: org.apache.velocity.runtime.directive.Foreach
726 2007-09-03 09:20:00,307 - Created '20' parsers.
727 2007-09-03 09:20:00,315 - Velocimacro : "velocimacro.library" is not set.  Trying default library: VM_global_library.vm
728 2007-09-03 09:20:00,316 - Velocimacro : Default library not found.
729 2007-09-03 09:20:00,316 - Velocimacro : allowInline = true : VMs can be defined inline in templates
730 2007-09-03 09:20:00,316 - Velocimacro : allowInlineToOverride = false : VMs defined inline may NOT replace previous VM definitions
731 2007-09-03 09:20:00,316 - Velocimacro : allowInlineLocal = false : VMs defined inline will be global in scope if allowed.
732 2007-09-03 09:20:00,316 - Velocimacro : autoload off : VM system will not automatically reload global library macros
733 2007-09-03 09:24:41,067 - Log4JLogChute initialized using file 'velocity.log'
734 2007-09-03 09:24:41,067 - Starting Apache Velocity v1.5 (compiled: 2007-02-22 08:52:29)
735 2007-09-03 09:24:41,067 - Default Properties File: org/apache/velocity/runtime/defaults/velocity.properties
736 2007-09-03 09:24:41,067 - Trying to use logger class org.apache.velocity.runtime.log.AvalonLogChute
737 2007-09-03 09:24:41,068 - Couldn't find class org.apache.velocity.runtime.log.AvalonLogChute or necessary supporting classes in classpath.
738 java.lang.NoClassDefFoundError: org/apache/log/format/Formatter
739         at java.lang.Class.forName0(Native Method)
740         at java.lang.Class.forName(Class.java:242)
741         at org.apache.velocity.util.ClassUtils.getClass(ClassUtils.java:63)
742         at org.apache.velocity.util.ClassUtils.getNewInstance(ClassUtils.java:95)
743         at org.apache.velocity.runtime.log.LogManager.createLogChute(LogManager.java:147)
744         at org.apache.velocity.runtime.log.LogManager.updateLog(LogManager.java:208)
745         at org.apache.velocity.runtime.RuntimeInstance.initializeLog(RuntimeInstance.java:728)
746         at org.apache.velocity.runtime.RuntimeInstance.init(RuntimeInstance.java:240)
747         at org.apache.velocity.runtime.RuntimeSingleton.init(RuntimeSingleton.java:113)
748         at org.apache.velocity.app.Velocity.init(Velocity.java:83)
749         at org.opensaml.DefaultBootstrap.initializeVelocity(DefaultBootstrap.java:116)
750         at org.opensaml.DefaultBootstrap.bootstrap(DefaultBootstrap.java:71)
751         at edu.internet2.middleware.shibboleth.common.config.OpensamlConfigBean.afterPropertiesSet(OpensamlConfigBean.java:49)
752         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeInitMethods(AbstractAutowireCapableBeanFactory.java:1201)
753         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1171)
754         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:425)
755         at org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:251)
756         at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:156)
757         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:248)
758         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:160)
759         at org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:287)
760         at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:352)
761         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:105)
762         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:90)
763         at edu.internet2.middleware.shibboleth.idp.system.conf1.BaseConf1TestCase.setUp(BaseConf1TestCase.java:21)
764         at junit.framework.TestCase.runBare(TestCase.java:125)
765         at junit.framework.TestResult$1.protect(TestResult.java:106)
766         at junit.framework.TestResult.runProtected(TestResult.java:124)
767         at junit.framework.TestResult.run(TestResult.java:109)
768         at junit.framework.TestCase.run(TestCase.java:118)
769         at junit.framework.TestSuite.runTest(TestSuite.java:208)
770         at junit.framework.TestSuite.run(TestSuite.java:203)
771         at org.eclipse.jdt.internal.junit.runner.junit3.JUnit3TestReference.run(JUnit3TestReference.java:128)
772         at org.eclipse.jdt.internal.junit.runner.TestExecution.run(TestExecution.java:38)
773         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:460)
774         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:673)
775         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.run(RemoteTestRunner.java:386)
776         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.main(RemoteTestRunner.java:196)
777 2007-09-03 09:24:41,069 - Trying to use logger class org.apache.velocity.runtime.log.Log4JLogChute
778 2007-09-03 09:24:41,069 - Using logger class org.apache.velocity.runtime.log.Log4JLogChute
779 2007-09-03 09:24:41,071 - Default ResourceManager initializing. (class org.apache.velocity.runtime.resource.ResourceManagerImpl)
780 2007-09-03 09:24:41,074 - ResourceLoader instantiated: org.apache.velocity.runtime.resource.loader.ClasspathResourceLoader
781 2007-09-03 09:24:41,118 - ResourceCache: initialized (class org.apache.velocity.runtime.resource.ResourceCacheImpl)
782 2007-09-03 09:24:41,119 - Loaded System Directive: org.apache.velocity.runtime.directive.Literal
783 2007-09-03 09:24:41,121 - Loaded System Directive: org.apache.velocity.runtime.directive.Macro
784 2007-09-03 09:24:41,122 - Loaded System Directive: org.apache.velocity.runtime.directive.Parse
785 2007-09-03 09:24:41,123 - Loaded System Directive: org.apache.velocity.runtime.directive.Include
786 2007-09-03 09:24:41,124 - Loaded System Directive: org.apache.velocity.runtime.directive.Foreach
787 2007-09-03 09:24:41,200 - Created '20' parsers.
788 2007-09-03 09:24:41,209 - Velocimacro : "velocimacro.library" is not set.  Trying default library: VM_global_library.vm
789 2007-09-03 09:24:41,209 - Velocimacro : Default library not found.
790 2007-09-03 09:24:41,209 - Velocimacro : allowInline = true : VMs can be defined inline in templates
791 2007-09-03 09:24:41,209 - Velocimacro : allowInlineToOverride = false : VMs defined inline may NOT replace previous VM definitions
792 2007-09-03 09:24:41,209 - Velocimacro : allowInlineLocal = false : VMs defined inline will be global in scope if allowed.
793 2007-09-03 09:24:41,209 - Velocimacro : autoload off : VM system will not automatically reload global library macros
794 2007-09-03 09:24:54,417 - Log4JLogChute initialized using file 'velocity.log'
795 2007-09-03 09:24:54,417 - Starting Apache Velocity v1.5 (compiled: 2007-02-22 08:52:29)
796 2007-09-03 09:24:54,418 - Default Properties File: org/apache/velocity/runtime/defaults/velocity.properties
797 2007-09-03 09:24:54,418 - Trying to use logger class org.apache.velocity.runtime.log.AvalonLogChute
798 2007-09-03 09:24:54,419 - Couldn't find class org.apache.velocity.runtime.log.AvalonLogChute or necessary supporting classes in classpath.
799 java.lang.NoClassDefFoundError: org/apache/log/format/Formatter
800         at java.lang.Class.forName0(Native Method)
801         at java.lang.Class.forName(Class.java:242)
802         at org.apache.velocity.util.ClassUtils.getClass(ClassUtils.java:63)
803         at org.apache.velocity.util.ClassUtils.getNewInstance(ClassUtils.java:95)
804         at org.apache.velocity.runtime.log.LogManager.createLogChute(LogManager.java:147)
805         at org.apache.velocity.runtime.log.LogManager.updateLog(LogManager.java:208)
806         at org.apache.velocity.runtime.RuntimeInstance.initializeLog(RuntimeInstance.java:728)
807         at org.apache.velocity.runtime.RuntimeInstance.init(RuntimeInstance.java:240)
808         at org.apache.velocity.runtime.RuntimeSingleton.init(RuntimeSingleton.java:113)
809         at org.apache.velocity.app.Velocity.init(Velocity.java:83)
810         at org.opensaml.DefaultBootstrap.initializeVelocity(DefaultBootstrap.java:116)
811         at org.opensaml.DefaultBootstrap.bootstrap(DefaultBootstrap.java:71)
812         at edu.internet2.middleware.shibboleth.common.config.OpensamlConfigBean.afterPropertiesSet(OpensamlConfigBean.java:49)
813         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeInitMethods(AbstractAutowireCapableBeanFactory.java:1201)
814         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1171)
815         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:425)
816         at org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:251)
817         at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:156)
818         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:248)
819         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:160)
820         at org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:287)
821         at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:352)
822         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:105)
823         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:90)
824         at edu.internet2.middleware.shibboleth.idp.system.conf1.BaseConf1TestCase.setUp(BaseConf1TestCase.java:21)
825         at junit.framework.TestCase.runBare(TestCase.java:125)
826         at junit.framework.TestResult$1.protect(TestResult.java:106)
827         at junit.framework.TestResult.runProtected(TestResult.java:124)
828         at junit.framework.TestResult.run(TestResult.java:109)
829         at junit.framework.TestCase.run(TestCase.java:118)
830         at junit.framework.TestSuite.runTest(TestSuite.java:208)
831         at junit.framework.TestSuite.run(TestSuite.java:203)
832         at org.eclipse.jdt.internal.junit.runner.junit3.JUnit3TestReference.run(JUnit3TestReference.java:128)
833         at org.eclipse.jdt.internal.junit.runner.TestExecution.run(TestExecution.java:38)
834         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:460)
835         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:673)
836         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.run(RemoteTestRunner.java:386)
837         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.main(RemoteTestRunner.java:196)
838 2007-09-03 09:24:54,420 - Trying to use logger class org.apache.velocity.runtime.log.Log4JLogChute
839 2007-09-03 09:24:54,420 - Using logger class org.apache.velocity.runtime.log.Log4JLogChute
840 2007-09-03 09:24:54,422 - Default ResourceManager initializing. (class org.apache.velocity.runtime.resource.ResourceManagerImpl)
841 2007-09-03 09:24:54,426 - ResourceLoader instantiated: org.apache.velocity.runtime.resource.loader.ClasspathResourceLoader
842 2007-09-03 09:24:54,473 - ResourceCache: initialized (class org.apache.velocity.runtime.resource.ResourceCacheImpl)
843 2007-09-03 09:24:54,474 - Loaded System Directive: org.apache.velocity.runtime.directive.Literal
844 2007-09-03 09:24:54,475 - Loaded System Directive: org.apache.velocity.runtime.directive.Macro
845 2007-09-03 09:24:54,477 - Loaded System Directive: org.apache.velocity.runtime.directive.Parse
846 2007-09-03 09:24:54,478 - Loaded System Directive: org.apache.velocity.runtime.directive.Include
847 2007-09-03 09:24:54,479 - Loaded System Directive: org.apache.velocity.runtime.directive.Foreach
848 2007-09-03 09:24:54,554 - Created '20' parsers.
849 2007-09-03 09:24:54,563 - Velocimacro : "velocimacro.library" is not set.  Trying default library: VM_global_library.vm
850 2007-09-03 09:24:54,563 - Velocimacro : Default library not found.
851 2007-09-03 09:24:54,563 - Velocimacro : allowInline = true : VMs can be defined inline in templates
852 2007-09-03 09:24:54,563 - Velocimacro : allowInlineToOverride = false : VMs defined inline may NOT replace previous VM definitions
853 2007-09-03 09:24:54,563 - Velocimacro : allowInlineLocal = false : VMs defined inline will be global in scope if allowed.
854 2007-09-03 09:24:54,563 - Velocimacro : autoload off : VM system will not automatically reload global library macros
855 2007-09-03 09:25:47,588 - Log4JLogChute initialized using file 'velocity.log'
856 2007-09-03 09:25:47,589 - Starting Apache Velocity v1.5 (compiled: 2007-02-22 08:52:29)
857 2007-09-03 09:25:47,589 - Default Properties File: org/apache/velocity/runtime/defaults/velocity.properties
858 2007-09-03 09:25:47,589 - Trying to use logger class org.apache.velocity.runtime.log.AvalonLogChute
859 2007-09-03 09:25:47,590 - Couldn't find class org.apache.velocity.runtime.log.AvalonLogChute or necessary supporting classes in classpath.
860 java.lang.NoClassDefFoundError: org/apache/log/format/Formatter
861         at java.lang.Class.forName0(Native Method)
862         at java.lang.Class.forName(Class.java:242)
863         at org.apache.velocity.util.ClassUtils.getClass(ClassUtils.java:63)
864         at org.apache.velocity.util.ClassUtils.getNewInstance(ClassUtils.java:95)
865         at org.apache.velocity.runtime.log.LogManager.createLogChute(LogManager.java:147)
866         at org.apache.velocity.runtime.log.LogManager.updateLog(LogManager.java:208)
867         at org.apache.velocity.runtime.RuntimeInstance.initializeLog(RuntimeInstance.java:728)
868         at org.apache.velocity.runtime.RuntimeInstance.init(RuntimeInstance.java:240)
869         at org.apache.velocity.runtime.RuntimeSingleton.init(RuntimeSingleton.java:113)
870         at org.apache.velocity.app.Velocity.init(Velocity.java:83)
871         at org.opensaml.DefaultBootstrap.initializeVelocity(DefaultBootstrap.java:116)
872         at org.opensaml.DefaultBootstrap.bootstrap(DefaultBootstrap.java:71)
873         at edu.internet2.middleware.shibboleth.common.config.OpensamlConfigBean.afterPropertiesSet(OpensamlConfigBean.java:49)
874         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeInitMethods(AbstractAutowireCapableBeanFactory.java:1201)
875         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1171)
876         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:425)
877         at org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:251)
878         at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:156)
879         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:248)
880         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:160)
881         at org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:287)
882         at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:352)
883         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:105)
884         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:90)
885         at edu.internet2.middleware.shibboleth.idp.system.conf1.BaseConf1TestCase.setUp(BaseConf1TestCase.java:21)
886         at junit.framework.TestCase.runBare(TestCase.java:125)
887         at junit.framework.TestResult$1.protect(TestResult.java:106)
888         at junit.framework.TestResult.runProtected(TestResult.java:124)
889         at junit.framework.TestResult.run(TestResult.java:109)
890         at junit.framework.TestCase.run(TestCase.java:118)
891         at junit.framework.TestSuite.runTest(TestSuite.java:208)
892         at junit.framework.TestSuite.run(TestSuite.java:203)
893         at org.eclipse.jdt.internal.junit.runner.junit3.JUnit3TestReference.run(JUnit3TestReference.java:128)
894         at org.eclipse.jdt.internal.junit.runner.TestExecution.run(TestExecution.java:38)
895         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:460)
896         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:673)
897         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.run(RemoteTestRunner.java:386)
898         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.main(RemoteTestRunner.java:196)
899 2007-09-03 09:25:47,591 - Trying to use logger class org.apache.velocity.runtime.log.Log4JLogChute
900 2007-09-03 09:25:47,591 - Using logger class org.apache.velocity.runtime.log.Log4JLogChute
901 2007-09-03 09:25:47,594 - Default ResourceManager initializing. (class org.apache.velocity.runtime.resource.ResourceManagerImpl)
902 2007-09-03 09:25:47,601 - ResourceLoader instantiated: org.apache.velocity.runtime.resource.loader.ClasspathResourceLoader
903 2007-09-03 09:25:47,616 - ResourceCache: initialized (class org.apache.velocity.runtime.resource.ResourceCacheImpl)
904 2007-09-03 09:25:47,620 - Loaded System Directive: org.apache.velocity.runtime.directive.Literal
905 2007-09-03 09:25:47,622 - Loaded System Directive: org.apache.velocity.runtime.directive.Macro
906 2007-09-03 09:25:47,624 - Loaded System Directive: org.apache.velocity.runtime.directive.Parse
907 2007-09-03 09:25:47,625 - Loaded System Directive: org.apache.velocity.runtime.directive.Include
908 2007-09-03 09:25:47,626 - Loaded System Directive: org.apache.velocity.runtime.directive.Foreach
909 2007-09-03 09:25:47,714 - Created '20' parsers.
910 2007-09-03 09:25:47,729 - Velocimacro : "velocimacro.library" is not set.  Trying default library: VM_global_library.vm
911 2007-09-03 09:25:47,734 - Velocimacro : Default library not found.
912 2007-09-03 09:25:47,734 - Velocimacro : allowInline = true : VMs can be defined inline in templates
913 2007-09-03 09:25:47,734 - Velocimacro : allowInlineToOverride = false : VMs defined inline may NOT replace previous VM definitions
914 2007-09-03 09:25:47,734 - Velocimacro : allowInlineLocal = false : VMs defined inline will be global in scope if allowed.
915 2007-09-03 09:25:47,734 - Velocimacro : autoload off : VM system will not automatically reload global library macros
916 2007-09-03 09:27:56,646 - Log4JLogChute initialized using file 'velocity.log'
917 2007-09-03 09:27:56,647 - Starting Apache Velocity v1.5 (compiled: 2007-02-22 08:52:29)
918 2007-09-03 09:27:56,647 - Default Properties File: org/apache/velocity/runtime/defaults/velocity.properties
919 2007-09-03 09:27:56,647 - Trying to use logger class org.apache.velocity.runtime.log.AvalonLogChute
920 2007-09-03 09:27:56,648 - Couldn't find class org.apache.velocity.runtime.log.AvalonLogChute or necessary supporting classes in classpath.
921 java.lang.NoClassDefFoundError: org/apache/log/format/Formatter
922         at java.lang.Class.forName0(Native Method)
923         at java.lang.Class.forName(Class.java:242)
924         at org.apache.velocity.util.ClassUtils.getClass(ClassUtils.java:63)
925         at org.apache.velocity.util.ClassUtils.getNewInstance(ClassUtils.java:95)
926         at org.apache.velocity.runtime.log.LogManager.createLogChute(LogManager.java:147)
927         at org.apache.velocity.runtime.log.LogManager.updateLog(LogManager.java:208)
928         at org.apache.velocity.runtime.RuntimeInstance.initializeLog(RuntimeInstance.java:728)
929         at org.apache.velocity.runtime.RuntimeInstance.init(RuntimeInstance.java:240)
930         at org.apache.velocity.runtime.RuntimeSingleton.init(RuntimeSingleton.java:113)
931         at org.apache.velocity.app.Velocity.init(Velocity.java:83)
932         at org.opensaml.DefaultBootstrap.initializeVelocity(DefaultBootstrap.java:116)
933         at org.opensaml.DefaultBootstrap.bootstrap(DefaultBootstrap.java:71)
934         at edu.internet2.middleware.shibboleth.common.config.OpensamlConfigBean.afterPropertiesSet(OpensamlConfigBean.java:49)
935         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeInitMethods(AbstractAutowireCapableBeanFactory.java:1201)
936         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1171)
937         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:425)
938         at org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:251)
939         at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:156)
940         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:248)
941         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:160)
942         at org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:287)
943         at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:352)
944         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:105)
945         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:90)
946         at edu.internet2.middleware.shibboleth.idp.system.conf1.BaseConf1TestCase.setUp(BaseConf1TestCase.java:21)
947         at junit.framework.TestCase.runBare(TestCase.java:125)
948         at junit.framework.TestResult$1.protect(TestResult.java:106)
949         at junit.framework.TestResult.runProtected(TestResult.java:124)
950         at junit.framework.TestResult.run(TestResult.java:109)
951         at junit.framework.TestCase.run(TestCase.java:118)
952         at junit.framework.TestSuite.runTest(TestSuite.java:208)
953         at junit.framework.TestSuite.run(TestSuite.java:203)
954         at org.eclipse.jdt.internal.junit.runner.junit3.JUnit3TestReference.run(JUnit3TestReference.java:128)
955         at org.eclipse.jdt.internal.junit.runner.TestExecution.run(TestExecution.java:38)
956         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:460)
957         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:673)
958         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.run(RemoteTestRunner.java:386)
959         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.main(RemoteTestRunner.java:196)
960 2007-09-03 09:27:56,649 - Trying to use logger class org.apache.velocity.runtime.log.Log4JLogChute
961 2007-09-03 09:27:56,649 - Using logger class org.apache.velocity.runtime.log.Log4JLogChute
962 2007-09-03 09:27:56,652 - Default ResourceManager initializing. (class org.apache.velocity.runtime.resource.ResourceManagerImpl)
963 2007-09-03 09:27:56,660 - ResourceLoader instantiated: org.apache.velocity.runtime.resource.loader.ClasspathResourceLoader
964 2007-09-03 09:27:56,676 - ResourceCache: initialized (class org.apache.velocity.runtime.resource.ResourceCacheImpl)
965 2007-09-03 09:27:56,680 - Loaded System Directive: org.apache.velocity.runtime.directive.Literal
966 2007-09-03 09:27:56,682 - Loaded System Directive: org.apache.velocity.runtime.directive.Macro
967 2007-09-03 09:27:56,683 - Loaded System Directive: org.apache.velocity.runtime.directive.Parse
968 2007-09-03 09:27:56,685 - Loaded System Directive: org.apache.velocity.runtime.directive.Include
969 2007-09-03 09:27:56,686 - Loaded System Directive: org.apache.velocity.runtime.directive.Foreach
970 2007-09-03 09:27:56,777 - Created '20' parsers.
971 2007-09-03 09:27:56,793 - Velocimacro : "velocimacro.library" is not set.  Trying default library: VM_global_library.vm
972 2007-09-03 09:27:56,799 - Velocimacro : Default library not found.
973 2007-09-03 09:27:56,799 - Velocimacro : allowInline = true : VMs can be defined inline in templates
974 2007-09-03 09:27:56,799 - Velocimacro : allowInlineToOverride = false : VMs defined inline may NOT replace previous VM definitions
975 2007-09-03 09:27:56,799 - Velocimacro : allowInlineLocal = false : VMs defined inline will be global in scope if allowed.
976 2007-09-03 09:27:56,799 - Velocimacro : autoload off : VM system will not automatically reload global library macros
977 2007-09-03 09:33:06,689 - Log4JLogChute initialized using file 'velocity.log'
978 2007-09-03 09:33:06,689 - Starting Apache Velocity v1.5 (compiled: 2007-02-22 08:52:29)
979 2007-09-03 09:33:06,689 - Default Properties File: org/apache/velocity/runtime/defaults/velocity.properties
980 2007-09-03 09:33:06,689 - Trying to use logger class org.apache.velocity.runtime.log.AvalonLogChute
981 2007-09-03 09:33:06,690 - Couldn't find class org.apache.velocity.runtime.log.AvalonLogChute or necessary supporting classes in classpath.
982 java.lang.NoClassDefFoundError: org/apache/log/format/Formatter
983         at java.lang.Class.forName0(Native Method)
984         at java.lang.Class.forName(Class.java:242)
985         at org.apache.velocity.util.ClassUtils.getClass(ClassUtils.java:63)
986         at org.apache.velocity.util.ClassUtils.getNewInstance(ClassUtils.java:95)
987         at org.apache.velocity.runtime.log.LogManager.createLogChute(LogManager.java:147)
988         at org.apache.velocity.runtime.log.LogManager.updateLog(LogManager.java:208)
989         at org.apache.velocity.runtime.RuntimeInstance.initializeLog(RuntimeInstance.java:728)
990         at org.apache.velocity.runtime.RuntimeInstance.init(RuntimeInstance.java:240)
991         at org.apache.velocity.runtime.RuntimeSingleton.init(RuntimeSingleton.java:113)
992         at org.apache.velocity.app.Velocity.init(Velocity.java:83)
993         at org.opensaml.DefaultBootstrap.initializeVelocity(DefaultBootstrap.java:116)
994         at org.opensaml.DefaultBootstrap.bootstrap(DefaultBootstrap.java:71)
995         at edu.internet2.middleware.shibboleth.common.config.OpensamlConfigBean.afterPropertiesSet(OpensamlConfigBean.java:49)
996         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeInitMethods(AbstractAutowireCapableBeanFactory.java:1201)
997         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1171)
998         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:425)
999         at org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:251)
1000         at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:156)
1001         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:248)
1002         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:160)
1003         at org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:287)
1004         at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:352)
1005         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:105)
1006         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:90)
1007         at edu.internet2.middleware.shibboleth.idp.system.conf1.BaseConf1TestCase.setUp(BaseConf1TestCase.java:21)
1008         at junit.framework.TestCase.runBare(TestCase.java:125)
1009         at junit.framework.TestResult$1.protect(TestResult.java:106)
1010         at junit.framework.TestResult.runProtected(TestResult.java:124)
1011         at junit.framework.TestResult.run(TestResult.java:109)
1012         at junit.framework.TestCase.run(TestCase.java:118)
1013         at junit.framework.TestSuite.runTest(TestSuite.java:208)
1014         at junit.framework.TestSuite.run(TestSuite.java:203)
1015         at org.eclipse.jdt.internal.junit.runner.junit3.JUnit3TestReference.run(JUnit3TestReference.java:128)
1016         at org.eclipse.jdt.internal.junit.runner.TestExecution.run(TestExecution.java:38)
1017         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:460)
1018         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:673)
1019         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.run(RemoteTestRunner.java:386)
1020         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.main(RemoteTestRunner.java:196)
1021 2007-09-03 09:33:06,692 - Trying to use logger class org.apache.velocity.runtime.log.Log4JLogChute
1022 2007-09-03 09:33:06,692 - Using logger class org.apache.velocity.runtime.log.Log4JLogChute
1023 2007-09-03 09:33:06,694 - Default ResourceManager initializing. (class org.apache.velocity.runtime.resource.ResourceManagerImpl)
1024 2007-09-03 09:33:06,702 - ResourceLoader instantiated: org.apache.velocity.runtime.resource.loader.ClasspathResourceLoader
1025 2007-09-03 09:33:06,718 - ResourceCache: initialized (class org.apache.velocity.runtime.resource.ResourceCacheImpl)
1026 2007-09-03 09:33:06,722 - Loaded System Directive: org.apache.velocity.runtime.directive.Literal
1027 2007-09-03 09:33:06,724 - Loaded System Directive: org.apache.velocity.runtime.directive.Macro
1028 2007-09-03 09:33:06,725 - Loaded System Directive: org.apache.velocity.runtime.directive.Parse
1029 2007-09-03 09:33:06,727 - Loaded System Directive: org.apache.velocity.runtime.directive.Include
1030 2007-09-03 09:33:06,728 - Loaded System Directive: org.apache.velocity.runtime.directive.Foreach
1031 2007-09-03 09:33:06,814 - Created '20' parsers.
1032 2007-09-03 09:33:06,829 - Velocimacro : "velocimacro.library" is not set.  Trying default library: VM_global_library.vm
1033 2007-09-03 09:33:06,835 - Velocimacro : Default library not found.
1034 2007-09-03 09:33:06,835 - Velocimacro : allowInline = true : VMs can be defined inline in templates
1035 2007-09-03 09:33:06,835 - Velocimacro : allowInlineToOverride = false : VMs defined inline may NOT replace previous VM definitions
1036 2007-09-03 09:33:06,835 - Velocimacro : allowInlineLocal = false : VMs defined inline will be global in scope if allowed.
1037 2007-09-03 09:33:06,835 - Velocimacro : autoload off : VM system will not automatically reload global library macros
1038 2007-09-03 09:38:39,956 - Log4JLogChute initialized using file 'velocity.log'
1039 2007-09-03 09:38:39,956 - Starting Apache Velocity v1.5 (compiled: 2007-02-22 08:52:29)
1040 2007-09-03 09:38:39,956 - Default Properties File: org/apache/velocity/runtime/defaults/velocity.properties
1041 2007-09-03 09:38:39,956 - Trying to use logger class org.apache.velocity.runtime.log.AvalonLogChute
1042 2007-09-03 09:38:39,957 - Couldn't find class org.apache.velocity.runtime.log.AvalonLogChute or necessary supporting classes in classpath.
1043 java.lang.NoClassDefFoundError: org/apache/log/format/Formatter
1044         at java.lang.Class.forName0(Native Method)
1045         at java.lang.Class.forName(Class.java:242)
1046         at org.apache.velocity.util.ClassUtils.getClass(ClassUtils.java:63)
1047         at org.apache.velocity.util.ClassUtils.getNewInstance(ClassUtils.java:95)
1048         at org.apache.velocity.runtime.log.LogManager.createLogChute(LogManager.java:147)
1049         at org.apache.velocity.runtime.log.LogManager.updateLog(LogManager.java:208)
1050         at org.apache.velocity.runtime.RuntimeInstance.initializeLog(RuntimeInstance.java:728)
1051         at org.apache.velocity.runtime.RuntimeInstance.init(RuntimeInstance.java:240)
1052         at org.apache.velocity.runtime.RuntimeSingleton.init(RuntimeSingleton.java:113)
1053         at org.apache.velocity.app.Velocity.init(Velocity.java:83)
1054         at org.opensaml.DefaultBootstrap.initializeVelocity(DefaultBootstrap.java:116)
1055         at org.opensaml.DefaultBootstrap.bootstrap(DefaultBootstrap.java:71)
1056         at edu.internet2.middleware.shibboleth.common.config.OpensamlConfigBean.afterPropertiesSet(OpensamlConfigBean.java:49)
1057         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeInitMethods(AbstractAutowireCapableBeanFactory.java:1201)
1058         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1171)
1059         at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:425)
1060         at org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:251)
1061         at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:156)
1062         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:248)
1063         at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:160)
1064         at org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:287)
1065         at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:352)
1066         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:105)
1067         at edu.internet2.middleware.shibboleth.idp.BaseIdPTestCase.createSpringContext(BaseIdPTestCase.java:90)
1068         at edu.internet2.middleware.shibboleth.idp.system.conf1.BaseConf1TestCase.setUp(BaseConf1TestCase.java:21)
1069         at junit.framework.TestCase.runBare(TestCase.java:125)
1070         at junit.framework.TestResult$1.protect(TestResult.java:106)
1071         at junit.framework.TestResult.runProtected(TestResult.java:124)
1072         at junit.framework.TestResult.run(TestResult.java:109)
1073         at junit.framework.TestCase.run(TestCase.java:118)
1074         at junit.framework.TestSuite.runTest(TestSuite.java:208)
1075         at junit.framework.TestSuite.run(TestSuite.java:203)
1076         at org.eclipse.jdt.internal.junit.runner.junit3.JUnit3TestReference.run(JUnit3TestReference.java:128)
1077         at org.eclipse.jdt.internal.junit.runner.TestExecution.run(TestExecution.java:38)
1078         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:460)
1079         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:673)
1080         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.run(RemoteTestRunner.java:386)
1081         at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.main(RemoteTestRunner.java:196)