Announcement

Collapse
No announcement yet.
X
Collapse
  • Page of 1
  • Filter
  • Time
Clear All
new posts
Previous template Next
    #1

    Error Running SmartGWT + Spring Security App in 6.0p

    Hi Isomorphic.

    I upgraded my application (SmartGWT + Spring Security 4) to use 6.0p 20160330 (which seems to be the latest version for what I can see here. After the upgrade I get this error when trying to publish the app to my Glassfish 4 server. This is the whole error message:

    cannot Deploy visualbuilder
    deploy is failing=Error occurred during deployment: Exception while loading the app : java.lang.IllegalStateException: ContainerBase.addChild: start: org.apache.catalina.LifecycleException: org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'org.springframework.security.filterChains': Cannot resolve reference to bean 'org.springframework.security.web.DefaultSecurityFilterChain#0' while setting bean property 'sourceList' with key [0]; nested exception is org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'org.springframework.security.web.DefaultSecurityFilterChain#0': Cannot resolve reference to bean 'org.springframework.security.web.authentication.UsernamePasswordAuthenticationFilter#0' while setting constructor argument with key [4]; nested exception is org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'org.springframework.security.web.authentication.UsernamePasswordAuthenticationFilter#0': Cannot resolve reference to bean 'org.springframework.security.authentication.ProviderManager#0' while setting bean property 'authenticationManager'; nested exception is org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'org.springframework.security.authentication.ProviderManager#0': Cannot resolve reference to bean 'org.springframework.security.config.authentication.AuthenticationManagerFactoryBean#0' while setting constructor argument; nested exception is org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'org.springframework.security.config.authentication.AuthenticationManagerFactoryBean#0': FactoryBean threw exception on object creation; nested exception is org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'org.springframework.security.authenticationManager': Cannot resolve reference to bean 'org.springframework.security.authentication.dao.DaoAuthenticationProvider#0' while setting constructor argument with key [0]; nested exception is org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'org.springframework.security.authentication.dao.DaoAuthenticationProvider#0': Cannot resolve reference to bean 'org.springframework.security.provisioning.JdbcUserDetailsManager#0' while setting bean property 'userDetailsService'; nested exception is org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'org.springframework.security.provisioning.JdbcUserDetailsManager#0': Cannot resolve reference to bean 'dataSource' while setting bean property 'dataSource'; nested exception is org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'dataSource': Invocation of init method failed; nested exception is javax.naming.NameNotFoundException: JNDI object with [jdbc/BMSim] not found: JNDI implementation returned null. Please see server.log for more details.
    Some notes on my part:
    1. I can't see any apparent reason for this, as the jdbc/BMSim is present and working (just downgrading the app to 5.1p 20160402 makes it work correctly again).
    2. Also, the error references a servlet I have (UserDetails) to return the user credentials to the client side using DMI, and the servlet is indeed included in the classpath, and when I check the deployed application folder, I can the class is present where it should be.
    3. If I try to reproduce the same behavior in a simpler app I have for testing purposes, it also happens. The app is a simple PortalLayout that also uses Spring Security for authentication.
    Even though the error messages seem related to Spring Security, it's weird that this all works fine in 5.1p, which is why I wanted to ask if you have any idea why this can be happening?

    Thanks in advance for any help and guidance you can provide!

    ps. I run the app in Chrome 49.0.2623.110 m.
    Last edited by carlossierra; 3 Apr 2016, 09:59.
    Tags: None
    #2
    Can you share the bit of your applicationContext.xml that configures the JDNI endpoint?

    Comment

      #3
      Glad to...

      Code:
          <jee:jndi-lookup id="dataSource" jndi-name="jdbc/BMSim" expected-type="javax.sql.DataSource" />
    <authentication-manager>
        <authentication-provider>
            <jdbc-user-service data-source-ref="dataSource"
                  users-by-username-query="select username,password, enabled from users where username=?"
                  authorities-by-username-query="select username, authority from authorities where username =?  " />
        </authentication-provider>
    </authentication-manager>
      Please let me know any other relevant details I can share with you!

      Comment

        #4
        That looks reasonable. The error pretty clearly identifies JNDI having no concept of the name you supply here. It also mentions a "server.log" - is there any other error in there (or any other log, like the app server startup log or something) that indicates a failure to register the actual jdbc/BMSim name with JNDI?

        Which container are you using? What does the JNDI configuration look like there? It's definitely strange that apparently the exact same config works with 5.1 (spring 3) but breaks with 6.0 (spring 4.1). But maybe there's a jar conflict or something that the container complains about in another log or maybe right on startup in the same log...

        Comment

          #5
          Hi Isomorphic. Thanks for replying. I am attaching the full Glassfish4 (that is my container) log. Sorry in advance for the long post, but I wanted to include the full log as per your previous comment.

          Trying to isolate the problem, I went ahead and disabled my UserDetails servlet (and removed all references to it). As you can see below, the problem isn't related to this servlet either, because I still can't publish my app, and now that servlet isn't being used. I can't seem to find any other error messages to explain this behavior. I will explain the process I follow below. What I find curious is that the Spring Security part of the application seems to be working properly with my jdbc/BMSim resource (more details below).

          First part: just start Glassfish. Nothing suspicious here (I think).
          2016-04-07T15:05:14.141-0500|Info: Running GlassFish Version: GlassFish Server Open Source Edition 4.1 (build 13)
          2016-04-07T15:05:14.147-0500|Info: Server log file is using Formatter class: com.sun.enterprise.server.logging.ODLLogFormatter
          2016-04-07T15:05:14.358-0500|Info: Realm [admin-realm] of classtype [com.sun.enterprise.security.auth.realm.file.FileRealm] successfully created.
          2016-04-07T15:05:14.360-0500|Info: Realm [file] of classtype [com.sun.enterprise.security.auth.realm.file.FileRealm] successfully created.
          2016-04-07T15:05:14.366-0500|Info: Realm [certificate] of classtype [com.sun.enterprise.security.auth.realm.certificate.CertificateRealm] successfully created.
          2016-04-07T15:05:14.622-0500|Info: Authorization Service has successfully initialized.
          2016-04-07T15:05:14.903-0500|Info: Registered org.glassfish.ha.store.adapter.cache.ShoalBackingStoreProxy for persistence-type = replicated in BackingStoreFactoryRegistry
          2016-04-07T15:05:15.067-0500|Info: Grizzly Framework 2.3.15 started in: 33ms - bound to [/0.0.0.0:8082]
          2016-04-07T15:05:15.100-0500|Info: Grizzly Framework 2.3.15 started in: 3ms - bound to [/0.0.0.0:8181]
          2016-04-07T15:05:15.111-0500|Info: Grizzly Framework 2.3.15 started in: 2ms - bound to [/0.0.0.0:4842]
          2016-04-07T15:05:15.183-0500|Info: Grizzly Framework 2.3.15 started in: 2ms - bound to [/0.0.0.0:3700]
          2016-04-07T15:05:15.184-0500|Info: GlassFish Server Open Source Edition 4.1 (13) startup time : Felix (2.856ms), startup services(1.243ms), total(4.099ms)
          2016-04-07T15:05:15.506-0500|Info: JMXStartupService has started JMXConnector on JMXService URL service:jmx:rmi://PCCS:8686/jndi/rmi://PCCS:8686/jmxrmi
          2016-04-07T15:05:15.593-0500|Info: Grizzly Framework 2.3.15 started in: 3ms - bound to [/0.0.0.0:7676]
          2016-04-07T15:05:17.245-0500|Info: HV000001: Hibernate Validator 5.0.0.Final
          2016-04-07T15:05:18.108-0500|Info: Initiating Jersey application, version Jersey: 2.10.4 2014-08-08 15:09:00...
          2016-04-07T15:05:19.027-0500|Info: Listening to REST requests at context: /management/domain.
          2016-04-07T15:05:19.532-0500|Info: Registered com.sun.enterprise.glassfish.bootstrap.osgi.EmbeddedOSGiGlassFishImpl@dd4aec3 as OSGi service registration: org.apache.felix.framework.ServiceRegistrationImpl@78d71df1.
          2016-04-07T15:05:20.002-0500|Info: visiting unvisited references
          2016-04-07T15:05:21.579-0500|Info: Created HTTP listener http-listener-1 on host/port 0.0.0.0:8082
          2016-04-07T15:05:21.588-0500|Info: Created HTTP listener http-listener-2 on host/port 0.0.0.0:8181
          2016-04-07T15:05:21.592-0500|Info: Created HTTP listener admin-listener on host/port 0.0.0.0:4842
          2016-04-07T15:05:21.662-0500|Info: Created virtual server server
          2016-04-07T15:05:21.664-0500|Info: Created virtual server __asadmin
          2016-04-07T15:05:22.116-0500|Info: Setting JAAS app name glassfish-web
          2016-04-07T15:05:22.117-0500|Info: Virtual server server loaded default web module
          2016-04-07T15:05:22.645-0500|Info: Java security manager is disabled.
          2016-04-07T15:05:22.645-0500|Info: Entering Security Startup Service.
          2016-04-07T15:05:22.649-0500|Info: Loading policy provider com.sun.enterprise.security.provider.PolicyWrapper.
          2016-04-07T15:05:22.726-0500|Info: Security Service(s) started successfully.
          2016-04-07T15:05:23.084-0500|Info: visiting unvisited references
          2016-04-07T15:05:23.125-0500|Info: visiting unvisited references
          2016-04-07T15:05:23.128-0500|Info: visiting unvisited references
          2016-04-07T15:05:26.566-0500|Info: Initializing Mojarra 2.2.7 ( 20140610-1547 https://svn.java.net/svn/mojarra~svn/tags/2.2.7@13362) for context ''
          2016-04-07T15:05:28.757-0500|Info: Loading application [__admingui] at [/]
          2016-04-07T15:05:28.759-0500|Info: Loading application __admingui done in 9.227 ms
          Second part: after Glassfish is up, I start to compile BMSim. When the process ends, I deploy the application (Glassfish - Add and Remove - select BMSim and publish). No errors here. Everything works as expected. I can then launch the application using the SuperDevMode generated link, and my login.jsp page is displayed in Chrome correctly.
          2016-04-07T15:07:07.212-0500|Info: visiting unvisited references (repeated 54 times)
          ...
          2016-04-07T15:07:11.584-0500|Info: WebModule[null] ServletContext.log():No Spring WebApplicationInitializer types detected on classpath
          2016-04-07T15:07:11.765-0500|Info: Initializing Mojarra 2.2.7 ( 20140610-1547 https://svn.java.net/svn/mojarra~svn/tags/2.2.7@13362) for context '/BMSim'
          2016-04-07T15:07:13.003-0500|Info: WebModule[null] ServletContext.log():Initializing Spring root WebApplicationContext
          2016-04-07T15:07:13.008-0500|Severe: log4j:WARN No appenders could be found for logger (org.springframework.web.context.ContextLoader).
          2016-04-07T15:07:13.008-0500|Severe: log4j:WARN Please initialize the log4j system properly.
          2016-04-07T15:07:13.008-0500|Severe: log4j:WARN See http://logging.apache.org/log4j/1.2/faq.html#noconfig for more info.
          2016-04-07T15:07:16.133-0500|Info: visiting unvisited references
          2016-04-07T15:07:17.642-0500|Info: ISC: Configuring log4j from: file:/D:/Dropbox/Apps/Glassfish4/glassfish/domains/BMSim/eclipseApps/BMSim/WEB-INF/classes/log4j.isc.config.xml
          2016-04-07T15:07:17.824-0500|Info: === 2016-04-07 15:07:17,824 [r(2)] INFO ISCInit - Isomorphic SmartClient/SmartGWT Framework - Initializing
          2016-04-07T15:07:17.853-0500|Info: === 2016-04-07 15:07:17,853 [r(2)] INFO ConfigLoader - Attempting to load framework.properties from CLASSPATH
          2016-04-07T15:07:18.070-0500|Info: === 2016-04-07 15:07:18,070 [r(2)] INFO ConfigLoader - Successfully loaded framework.properties from CLASSPATH at location: jar:file:/D:/Dropbox/Apps/Glassfish4/glassfish/domains/BMSim/eclipseApps/BMSim/WEB-INF/lib/isomorphic-core-rpc-6.0-p20160407.jar!/framework.properties
          2016-04-07T15:07:18.073-0500|Info: === 2016-04-07 15:07:18,073 [r(2)] INFO ConfigLoader - Attempting to load project.properties from CLASSPATH
          2016-04-07T15:07:18.074-0500|Info: === 2016-04-07 15:07:18,074 [r(2)] INFO ConfigLoader - Unable to locate project.properties in CLASSPATH
          2016-04-07T15:07:18.081-0500|Info: === 2016-04-07 15:07:18,081 [r(2)] INFO ConfigLoader - Successfully loaded isc_interfaces.properties from CLASSPATH at location: jar:file:/D:/Dropbox/Apps/Glassfish4/glassfish/domains/BMSim/eclipseApps/BMSim/WEB-INF/lib/isomorphic-core-rpc-6.0-p20160407.jar!/isc_interfaces.properties
          2016-04-07T15:07:18.081-0500|Info: === 2016-04-07 15:07:18,081 [r(2)] INFO ConfigLoader - Attempting to load server.properties from CLASSPATH
          2016-04-07T15:07:18.085-0500|Info: === 2016-04-07 15:07:18,085 [r(2)] INFO ConfigLoader - Successfully loaded server.properties from CLASSPATH at location: file:/D:/Dropbox/Apps/Glassfish4/glassfish/domains/BMSim/eclipseApps/BMSim/WEB-INF/classes/server.properties
          2016-04-07T15:07:18.106-0500|Info: === 2016-04-07 15:07:18,106 [r(2)] INFO Logger - Logging system started.
          2016-04-07T15:07:18.127-0500|Info: === 2016-04-07 15:07:18,127 [r(2)] DEBUG ConfigParser - Matched var name: gwtModuleName
          2016-04-07T15:07:18.128-0500|Info: === 2016-04-07 15:07:18,128 [r(2)] DEBUG ConfigParser - value after substitution: bmsim/sc
          2016-04-07T15:07:18.128-0500|Info: === 2016-04-07 15:07:18,128 [r(2)] INFO ISCInit - Auto-detected webRoot - using: D:\Dropbox\Apps\Glassfish4\glassfish\domains\BMSim\eclipseApps\BMSim
          2016-04-07T15:07:18.170-0500|Info: === 2016-04-07 15:07:18,170 [r(2)] INFO ISCInit - Isomorphic SmartClient/SmartGWT Framework (v11.0p_2016-04-07/Pro Deployment 2016-04-07) - Initialization Complete
          2016-04-07T15:07:18.247-0500|Info: Loading application [BMSim] at [/BMSim]
          2016-04-07T15:07:18.368-0500|Info: BMSim was successfully deployed in 13.489 milliseconds.
          Third part: notice that up to this part it looks like Spring Security is working correctly against my jdbc/BMSim resource, as I can log in to the app correctly, using the credentials stored in the DB (accessed with the JNDI config shown in a previous post). After I login, I am redirected to the main app page: BMSim.html and a new compilation process starts. When that finishes, Glassfish detects the changes and tries to publish the app again, and here is when the errors start to appear. I highlighted in bold the specific error messages being thrown...
          2016-04-07T15:09:30.853-0500|Info: === 2016-04-07 15:09:30,852 [1(5)] DEBUG ConfigParser - Matched var name: debug
          2016-04-07T15:09:30.854-0500|Info: === 2016-04-07 15:09:30,854 [1(5)] DEBUG ConfigParser - value after substitution: true
          2016-04-07T15:09:30.857-0500|Info: === 2016-04-07 15:09:30,857 [1(5)] INFO RequestContext - URL: '/BMSim/bmsim/sc/DataSourceLoader', User-Agent: 'Mozilla/5.0 (Windows NT 10.0; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/49.0.2623.110 Safari/537.36': Safari with Accept-Encoding header
          2016-04-07T15:09:30.857-0500|Info: === 2016-04-07 15:09:30,857 [1(3)] INFO RequestContext - URL: '/BMSim/bmsim/sc/skins/Enterprise/load_skin.js', User-Agent: 'Mozilla/5.0 (Windows NT 10.0; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/49.0.2623.110 Safari/537.36': Safari with Accept-Encoding header
          2016-04-07T15:09:30.910-0500|Info: === 2016-04-07 15:09:30,910 [1(3)] INFO Download - done streaming: D:/Dropbox/Apps/Glassfish4/glassfish/domains/BMSim/eclipseApps/BMSim/bmsim/sc/skins/Enterprise/load_skin.js
          2016-04-07T15:09:31.071-0500|Info: === 2016-04-07 15:09:31,071 [1(5)] DEBUG ConfigParser - Matched var name: isomorphicDir
          2016-04-07T15:09:31.071-0500|Info: === 2016-04-07 15:09:31,071 [1(5)] DEBUG ConfigParser - Matched var name: isomorphicPathRootRelative
          2016-04-07T15:09:31.072-0500|Info: === 2016-04-07 15:09:31,072 [1(5)] DEBUG ConfigParser - Matched var name: gwtModuleName
          2016-04-07T15:09:31.072-0500|Info: === 2016-04-07 15:09:31,072 [1(5)] DEBUG ConfigParser - value after substitution: bmsim/sc
          2016-04-07T15:09:31.072-0500|Info: === 2016-04-07 15:09:31,072 [1(5)] DEBUG ConfigParser - value after substitution: bmsim/sc
          2016-04-07T15:09:31.073-0500|Info: === 2016-04-07 15:09:31,072 [1(5)] DEBUG ConfigParser - Matched var name: webRoot
          2016-04-07T15:09:31.073-0500|Info: === 2016-04-07 15:09:31,073 [1(5)] DEBUG ConfigParser - value after substitution: D:/Dropbox/Apps/Glassfish4/glassfish/domains/BMSim/eclipseApps/BMSim/bmsim/sc
          2016-04-07T15:09:31.073-0500|Info: === 2016-04-07 15:09:31,073 [1(5)] DEBUG ConfigParser - value after substitution: D:/Dropbox/Apps/Glassfish4/glassfish/domains/BMSim/eclipseApps/BMSim/bmsim/sc/system/schema
          2016-04-07T15:09:31.137-0500|Info: === 2016-04-07 15:09:31,137 [1(5)] DEBUG XML - Parsed XML from D:\Dropbox\Apps\Glassfish4\glassfish\domains\BMSim\eclipseApps\BMSim\bmsim\sc\system\schema\builtinTypes.xml: 12ms
          2016-04-07T15:09:31.233-0500|Info: === 2016-04-07 15:09:31,233 [1(5)] INFO PoolManager - SmartClient pooling started for 'simpleTypes' objects
          2016-04-07T15:09:31.233-0500|Info: === 2016-04-07 15:09:31,233 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'simpleTypes'
          2016-04-07T15:09:31.244-0500|Info: === 2016-04-07 15:09:31,244 [1(5)] DEBUG ConfigParser - Matched var name: webRoot
          2016-04-07T15:09:31.244-0500|Info: === 2016-04-07 15:09:31,244 [1(5)] DEBUG ConfigParser - value after substitution: D:/Dropbox/Apps/Glassfish4/glassfish/domains/BMSim/eclipseApps/BMSim/resources/ds
          2016-04-07T15:09:31.249-0500|Info: === 2016-04-07 15:09:31,249 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'simpleTypes' but null was returned
          2016-04-07T15:09:31.249-0500|Info: === 2016-04-07 15:09:31,249 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'simpleTypes' in the pooling flow
          2016-04-07T15:09:31.255-0500|Info: === 2016-04-07 15:09:31,255 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'Object'
          2016-04-07T15:09:31.290-0500|Info: === 2016-04-07 15:09:31,290 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource 1 of type 'Object' and assigned it to thread http-listener-1(5)
          2016-04-07T15:09:31.290-0500|Info: === 2016-04-07 15:09:31,290 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource 1 of type 'Object' in the pooling flow
          2016-04-07T15:09:31.290-0500|Info: === 2016-04-07 15:09:31,290 [1(5)] DEBUG PoolableDataSourceFactory - Activated DataSource 1 of type 'Object'
          2016-04-07T15:09:31.296-0500|Info: === 2016-04-07 15:09:31,296 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'any'
          2016-04-07T15:09:31.297-0500|Info: === 2016-04-07 15:09:31,297 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'any' but null was returned
          2016-04-07T15:09:31.297-0500|Info: === 2016-04-07 15:09:31,297 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'any' in the pooling flow
          2016-04-07T15:09:31.344-0500|Info: === 2016-04-07 15:09:31,344 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'boolean'
          2016-04-07T15:09:31.345-0500|Info: === 2016-04-07 15:09:31,345 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'boolean' but null was returned
          2016-04-07T15:09:31.345-0500|Info: === 2016-04-07 15:09:31,345 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'boolean' in the pooling flow
          2016-04-07T15:09:31.346-0500|Info: === 2016-04-07 15:09:31,346 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'integer'
          2016-04-07T15:09:31.346-0500|Info: === 2016-04-07 15:09:31,346 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'integer' but null was returned
          2016-04-07T15:09:31.346-0500|Info: === 2016-04-07 15:09:31,346 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'integer' in the pooling flow
          2016-04-07T15:09:31.347-0500|Info: === 2016-04-07 15:09:31,347 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'float'
          2016-04-07T15:09:31.348-0500|Info: === 2016-04-07 15:09:31,348 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'float' but null was returned
          2016-04-07T15:09:31.348-0500|Info: === 2016-04-07 15:09:31,348 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'float' in the pooling flow
          2016-04-07T15:09:31.349-0500|Info: === 2016-04-07 15:09:31,349 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'date'
          2016-04-07T15:09:31.349-0500|Info: === 2016-04-07 15:09:31,349 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'date' but null was returned
          2016-04-07T15:09:31.350-0500|Info: === 2016-04-07 15:09:31,349 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'date' in the pooling flow
          2016-04-07T15:09:31.350-0500|Info: === 2016-04-07 15:09:31,350 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'time'
          2016-04-07T15:09:31.351-0500|Info: === 2016-04-07 15:09:31,351 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'time' but null was returned
          2016-04-07T15:09:31.351-0500|Info: === 2016-04-07 15:09:31,351 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'time' in the pooling flow
          2016-04-07T15:09:31.352-0500|Info: === 2016-04-07 15:09:31,352 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'text'
          2016-04-07T15:09:31.353-0500|Info: === 2016-04-07 15:09:31,353 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'text' but null was returned
          2016-04-07T15:09:31.353-0500|Info: === 2016-04-07 15:09:31,353 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'text' in the pooling flow
          2016-04-07T15:09:31.353-0500|Info: === 2016-04-07 15:09:31,353 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'string'
          2016-04-07T15:09:31.354-0500|Info: === 2016-04-07 15:09:31,354 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'string' but null was returned
          2016-04-07T15:09:31.354-0500|Info: === 2016-04-07 15:09:31,354 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'string' in the pooling flow
          2016-04-07T15:09:31.355-0500|Info: === 2016-04-07 15:09:31,355 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'link'
          2016-04-07T15:09:31.356-0500|Info: === 2016-04-07 15:09:31,356 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'link' but null was returned
          2016-04-07T15:09:31.356-0500|Info: === 2016-04-07 15:09:31,356 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'link' in the pooling flow
          2016-04-07T15:09:31.357-0500|Info: === 2016-04-07 15:09:31,356 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'int'
          2016-04-07T15:09:31.357-0500|Info: === 2016-04-07 15:09:31,357 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'int' but null was returned
          2016-04-07T15:09:31.357-0500|Info: === 2016-04-07 15:09:31,357 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'int' in the pooling flow
          2016-04-07T15:09:31.358-0500|Info: === 2016-04-07 15:09:31,358 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'long'
          2016-04-07T15:09:31.359-0500|Info: === 2016-04-07 15:09:31,359 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'long' but null was returned
          2016-04-07T15:09:31.359-0500|Info: === 2016-04-07 15:09:31,359 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'long' in the pooling flow
          2016-04-07T15:09:31.360-0500|Info: === 2016-04-07 15:09:31,359 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'number'
          2016-04-07T15:09:31.360-0500|Info: === 2016-04-07 15:09:31,360 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'number' but null was returned
          2016-04-07T15:09:31.361-0500|Info: === 2016-04-07 15:09:31,361 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'number' in the pooling flow
          2016-04-07T15:09:31.362-0500|Info: === 2016-04-07 15:09:31,362 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'decimal'
          2016-04-07T15:09:31.363-0500|Info: === 2016-04-07 15:09:31,362 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'decimal' but null was returned
          2016-04-07T15:09:31.363-0500|Info: === 2016-04-07 15:09:31,363 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'decimal' in the pooling flow
          2016-04-07T15:09:31.363-0500|Info: === 2016-04-07 15:09:31,363 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'double'
          2016-04-07T15:09:31.364-0500|Info: === 2016-04-07 15:09:31,364 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'double' but null was returned
          2016-04-07T15:09:31.364-0500|Info: === 2016-04-07 15:09:31,364 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'double' in the pooling flow
          2016-04-07T15:09:31.365-0500|Info: === 2016-04-07 15:09:31,365 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'dateTime'
          2016-04-07T15:09:31.366-0500|Info: === 2016-04-07 15:09:31,366 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'dateTime' but null was returned
          2016-04-07T15:09:31.366-0500|Info: === 2016-04-07 15:09:31,366 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'dateTime' in the pooling flow
          2016-04-07T15:09:31.367-0500|Info: === 2016-04-07 15:09:31,367 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'datetime'
          2016-04-07T15:09:31.368-0500|Info: === 2016-04-07 15:09:31,368 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'datetime' but null was returned
          2016-04-07T15:09:31.368-0500|Info: === 2016-04-07 15:09:31,368 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'datetime' in the pooling flow
          2016-04-07T15:09:31.369-0500|Info: === 2016-04-07 15:09:31,368 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'validators'
          2016-04-07T15:09:31.370-0500|Info: === 2016-04-07 15:09:31,370 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'validators' but null was returned
          2016-04-07T15:09:31.370-0500|Info: === 2016-04-07 15:09:31,370 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'validators' in the pooling flow
          2016-04-07T15:09:31.370-0500|Info: === 2016-04-07 15:09:31,370 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'positiveInteger'
          2016-04-07T15:09:31.372-0500|Info: === 2016-04-07 15:09:31,372 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'positiveInteger' but null was returned
          2016-04-07T15:09:31.372-0500|Info: === 2016-04-07 15:09:31,372 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'positiveInteger' in the pooling flow
          2016-04-07T15:09:31.373-0500|Info: === 2016-04-07 15:09:31,373 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'integerPercent'
          2016-04-07T15:09:31.375-0500|Info: === 2016-04-07 15:09:31,375 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'integerPercent' but null was returned
          2016-04-07T15:09:31.375-0500|Info: === 2016-04-07 15:09:31,375 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'integerPercent' in the pooling flow
          2016-04-07T15:09:31.376-0500|Info: === 2016-04-07 15:09:31,376 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'percent'
          2016-04-07T15:09:31.377-0500|Info: === 2016-04-07 15:09:31,377 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'percent' but null was returned
          2016-04-07T15:09:31.377-0500|Info: === 2016-04-07 15:09:31,377 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'percent' in the pooling flow
          2016-04-07T15:09:31.377-0500|Info: === 2016-04-07 15:09:31,377 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'sequence'
          2016-04-07T15:09:31.378-0500|Info: === 2016-04-07 15:09:31,378 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'sequence' but null was returned
          2016-04-07T15:09:31.379-0500|Info: === 2016-04-07 15:09:31,379 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'sequence' in the pooling flow
          2016-04-07T15:09:31.379-0500|Info: === 2016-04-07 15:09:31,379 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'enum'
          2016-04-07T15:09:31.380-0500|Info: === 2016-04-07 15:09:31,380 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'enum' but null was returned
          2016-04-07T15:09:31.380-0500|Info: === 2016-04-07 15:09:31,380 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'enum' in the pooling flow
          2016-04-07T15:09:31.381-0500|Info: === 2016-04-07 15:09:31,381 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'intEnum'
          2016-04-07T15:09:31.382-0500|Info: === 2016-04-07 15:09:31,382 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'intEnum' but null was returned
          2016-04-07T15:09:31.382-0500|Info: === 2016-04-07 15:09:31,382 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'intEnum' in the pooling flow
          2016-04-07T15:09:31.383-0500|Info: === 2016-04-07 15:09:31,383 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'char'
          2016-04-07T15:09:31.383-0500|Info: === 2016-04-07 15:09:31,383 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'char' but null was returned
          2016-04-07T15:09:31.383-0500|Info: === 2016-04-07 15:09:31,383 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'char' in the pooling flow
          2016-04-07T15:09:31.384-0500|Info: === 2016-04-07 15:09:31,384 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'ntext'
          2016-04-07T15:09:31.385-0500|Info: === 2016-04-07 15:09:31,385 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'ntext' but null was returned
          2016-04-07T15:09:31.385-0500|Info: === 2016-04-07 15:09:31,385 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'ntext' in the pooling flow
          2016-04-07T15:09:31.385-0500|Info: === 2016-04-07 15:09:31,385 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'password'
          2016-04-07T15:09:31.386-0500|Info: === 2016-04-07 15:09:31,386 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'password' but null was returned
          2016-04-07T15:09:31.386-0500|Info: === 2016-04-07 15:09:31,386 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'password' in the pooling flow
          2016-04-07T15:09:31.387-0500|Info: === 2016-04-07 15:09:31,387 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'localeInt'
          2016-04-07T15:09:31.388-0500|Info: === 2016-04-07 15:09:31,388 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'localeInt' but null was returned
          2016-04-07T15:09:31.388-0500|Info: === 2016-04-07 15:09:31,388 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'localeInt' in the pooling flow
          2016-04-07T15:09:31.389-0500|Info: === 2016-04-07 15:09:31,389 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'localeFloat'
          2016-04-07T15:09:31.390-0500|Info: === 2016-04-07 15:09:31,390 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'localeFloat' but null was returned
          2016-04-07T15:09:31.390-0500|Info: === 2016-04-07 15:09:31,390 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'localeFloat' in the pooling flow
          2016-04-07T15:09:31.390-0500|Info: === 2016-04-07 15:09:31,390 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'localeCurrency'
          2016-04-07T15:09:31.391-0500|Info: === 2016-04-07 15:09:31,391 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'localeCurrency' but null was returned
          2016-04-07T15:09:31.391-0500|Info: === 2016-04-07 15:09:31,391 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'localeCurrency' in the pooling flow
          2016-04-07T15:09:31.392-0500|Info: === 2016-04-07 15:09:31,392 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'phoneNumber'
          2016-04-07T15:09:31.393-0500|Info: === 2016-04-07 15:09:31,393 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'phoneNumber' but null was returned
          2016-04-07T15:09:31.393-0500|Info: === 2016-04-07 15:09:31,393 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'phoneNumber' in the pooling flow
          2016-04-07T15:09:31.394-0500|Info: === 2016-04-07 15:09:31,393 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'regexp'
          2016-04-07T15:09:31.394-0500|Info: === 2016-04-07 15:09:31,394 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'regexp' but null was returned
          2016-04-07T15:09:31.394-0500|Info: === 2016-04-07 15:09:31,394 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'regexp' in the pooling flow
          2016-04-07T15:09:31.395-0500|Info: === 2016-04-07 15:09:31,395 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'identifier'
          2016-04-07T15:09:31.396-0500|Info: === 2016-04-07 15:09:31,396 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'identifier' but null was returned
          2016-04-07T15:09:31.396-0500|Info: === 2016-04-07 15:09:31,396 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'identifier' in the pooling flow
          2016-04-07T15:09:31.396-0500|Info: === 2016-04-07 15:09:31,396 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'URL'
          2016-04-07T15:09:31.397-0500|Info: === 2016-04-07 15:09:31,397 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'URL' but null was returned
          2016-04-07T15:09:31.397-0500|Info: === 2016-04-07 15:09:31,397 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'URL' in the pooling flow
          2016-04-07T15:09:31.398-0500|Info: === 2016-04-07 15:09:31,398 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'url'
          2016-04-07T15:09:31.399-0500|Info: === 2016-04-07 15:09:31,399 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'url' but null was returned
          2016-04-07T15:09:31.399-0500|Info: === 2016-04-07 15:09:31,399 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'url' in the pooling flow
          2016-04-07T15:09:31.399-0500|Info: === 2016-04-07 15:09:31,399 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'XPath'
          2016-04-07T15:09:31.400-0500|Info: === 2016-04-07 15:09:31,400 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'XPath' but null was returned
          2016-04-07T15:09:31.400-0500|Info: === 2016-04-07 15:09:31,400 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'XPath' in the pooling flow
          2016-04-07T15:09:31.401-0500|Info: === 2016-04-07 15:09:31,401 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'HTMLString'
          2016-04-07T15:09:31.401-0500|Info: === 2016-04-07 15:09:31,401 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'HTMLString' but null was returned
          2016-04-07T15:09:31.401-0500|Info: === 2016-04-07 15:09:31,401 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'HTMLString' in the pooling flow
          2016-04-07T15:09:31.402-0500|Info: === 2016-04-07 15:09:31,402 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'HTML'
          2016-04-07T15:09:31.403-0500|Info: === 2016-04-07 15:09:31,403 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'HTML' but null was returned
          2016-04-07T15:09:31.403-0500|Info: === 2016-04-07 15:09:31,403 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'HTML' in the pooling flow
          2016-04-07T15:09:31.404-0500|Info: === 2016-04-07 15:09:31,404 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'html'
          2016-04-07T15:09:31.405-0500|Info: === 2016-04-07 15:09:31,405 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'html' but null was returned
          2016-04-07T15:09:31.405-0500|Info: === 2016-04-07 15:09:31,405 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'html' in the pooling flow
          2016-04-07T15:09:31.406-0500|Info: === 2016-04-07 15:09:31,406 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'measure'
          2016-04-07T15:09:31.406-0500|Info: === 2016-04-07 15:09:31,406 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'measure' but null was returned
          2016-04-07T15:09:31.406-0500|Info: === 2016-04-07 15:09:31,406 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'measure' in the pooling flow
          2016-04-07T15:09:31.407-0500|Info: === 2016-04-07 15:09:31,406 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'integerOrAuto'
          2016-04-07T15:09:31.407-0500|Info: === 2016-04-07 15:09:31,407 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'integerOrAuto' but null was returned
          2016-04-07T15:09:31.407-0500|Info: === 2016-04-07 15:09:31,407 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'integerOrAuto' in the pooling flow
          2016-04-07T15:09:31.407-0500|Info: === 2016-04-07 15:09:31,407 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'integerOrIdentifier'
          2016-04-07T15:09:31.408-0500|Info: === 2016-04-07 15:09:31,408 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'integerOrIdentifier' but null was returned
          2016-04-07T15:09:31.408-0500|Info: === 2016-04-07 15:09:31,408 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'integerOrIdentifier' in the pooling flow
          2016-04-07T15:09:31.408-0500|Info: === 2016-04-07 15:09:31,408 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'handler'
          2016-04-07T15:09:31.409-0500|Info: === 2016-04-07 15:09:31,409 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'handler' but null was returned
          2016-04-07T15:09:31.409-0500|Info: === 2016-04-07 15:09:31,409 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'handler' in the pooling flow
          2016-04-07T15:09:31.410-0500|Info: === 2016-04-07 15:09:31,410 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'callback'
          2016-04-07T15:09:31.410-0500|Info: === 2016-04-07 15:09:31,410 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'callback' but null was returned
          2016-04-07T15:09:31.410-0500|Info: === 2016-04-07 15:09:31,410 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'callback' in the pooling flow
          2016-04-07T15:09:31.411-0500|Info: === 2016-04-07 15:09:31,411 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'action'
          2016-04-07T15:09:31.411-0500|Info: === 2016-04-07 15:09:31,411 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'action' but null was returned
          2016-04-07T15:09:31.412-0500|Info: === 2016-04-07 15:09:31,412 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'action' in the pooling flow
          2016-04-07T15:09:31.412-0500|Info: === 2016-04-07 15:09:31,412 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'setter'
          2016-04-07T15:09:31.412-0500|Info: === 2016-04-07 15:09:31,412 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'setter' but null was returned
          2016-04-07T15:09:31.413-0500|Info: === 2016-04-07 15:09:31,412 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'setter' in the pooling flow
          2016-04-07T15:09:31.413-0500|Info: === 2016-04-07 15:09:31,413 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'getter'
          2016-04-07T15:09:31.413-0500|Info: === 2016-04-07 15:09:31,413 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'getter' but null was returned
          2016-04-07T15:09:31.414-0500|Info: === 2016-04-07 15:09:31,413 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'getter' in the pooling flow
          2016-04-07T15:09:31.414-0500|Info: === 2016-04-07 15:09:31,414 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'tester'
          2016-04-07T15:09:31.414-0500|Info: === 2016-04-07 15:09:31,414 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'tester' but null was returned
          2016-04-07T15:09:31.414-0500|Info: === 2016-04-07 15:09:31,414 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'tester' in the pooling flow
          2016-04-07T15:09:31.415-0500|Info: === 2016-04-07 15:09:31,415 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'method'
          2016-04-07T15:09:31.415-0500|Info: === 2016-04-07 15:09:31,415 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'method' but null was returned
          2016-04-07T15:09:31.415-0500|Info: === 2016-04-07 15:09:31,415 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'method' in the pooling flow
          2016-04-07T15:09:31.416-0500|Info: === 2016-04-07 15:09:31,416 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'function'
          2016-04-07T15:09:31.416-0500|Info: === 2016-04-07 15:09:31,416 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'function' but null was returned
          2016-04-07T15:09:31.416-0500|Info: === 2016-04-07 15:09:31,416 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'function' in the pooling flow
          2016-04-07T15:09:31.417-0500|Info: === 2016-04-07 15:09:31,417 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'expression'
          2016-04-07T15:09:31.417-0500|Info: === 2016-04-07 15:09:31,417 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'expression' but null was returned
          2016-04-07T15:09:31.417-0500|Info: === 2016-04-07 15:09:31,417 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'expression' in the pooling flow
          2016-04-07T15:09:31.418-0500|Info: === 2016-04-07 15:09:31,418 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'className'
          2016-04-07T15:09:31.418-0500|Info: === 2016-04-07 15:09:31,418 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'className' but null was returned
          2016-04-07T15:09:31.418-0500|Info: === 2016-04-07 15:09:31,418 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'className' in the pooling flow
          2016-04-07T15:09:31.419-0500|Info: === 2016-04-07 15:09:31,419 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'valueMap'
          2016-04-07T15:09:31.419-0500|Info: === 2016-04-07 15:09:31,419 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'valueMap' but null was returned
          2016-04-07T15:09:31.419-0500|Info: === 2016-04-07 15:09:31,419 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'valueMap' in the pooling flow
          2016-04-07T15:09:31.420-0500|Info: === 2016-04-07 15:09:31,420 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'valignEnum'
          2016-04-07T15:09:31.420-0500|Info: === 2016-04-07 15:09:31,420 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'valignEnum' but null was returned
          2016-04-07T15:09:31.420-0500|Info: === 2016-04-07 15:09:31,420 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'valignEnum' in the pooling flow
          2016-04-07T15:09:31.421-0500|Info: === 2016-04-07 15:09:31,421 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'alignEnum'
          2016-04-07T15:09:31.421-0500|Info: === 2016-04-07 15:09:31,421 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'alignEnum' but null was returned
          2016-04-07T15:09:31.421-0500|Info: === 2016-04-07 15:09:31,421 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'alignEnum' in the pooling flow
          2016-04-07T15:09:31.422-0500|Info: === 2016-04-07 15:09:31,422 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'sideEnum'
          2016-04-07T15:09:31.422-0500|Info: === 2016-04-07 15:09:31,422 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'sideEnum' but null was returned
          2016-04-07T15:09:31.422-0500|Info: === 2016-04-07 15:09:31,422 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'sideEnum' in the pooling flow
          2016-04-07T15:09:31.423-0500|Info: === 2016-04-07 15:09:31,423 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'color'
          2016-04-07T15:09:31.423-0500|Info: === 2016-04-07 15:09:31,423 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'color' but null was returned
          2016-04-07T15:09:31.423-0500|Info: === 2016-04-07 15:09:31,423 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'color' in the pooling flow
          2016-04-07T15:09:31.424-0500|Info: === 2016-04-07 15:09:31,424 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'cssClass'
          2016-04-07T15:09:31.424-0500|Info: === 2016-04-07 15:09:31,424 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'cssClass' but null was returned
          2016-04-07T15:09:31.424-0500|Info: === 2016-04-07 15:09:31,424 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'cssClass' in the pooling flow
          2016-04-07T15:09:31.425-0500|Info: === 2016-04-07 15:09:31,425 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'modifier'
          2016-04-07T15:09:31.425-0500|Info: === 2016-04-07 15:09:31,425 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'modifier' but null was returned
          2016-04-07T15:09:31.425-0500|Info: === 2016-04-07 15:09:31,425 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'modifier' in the pooling flow
          2016-04-07T15:09:31.426-0500|Info: === 2016-04-07 15:09:31,426 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'modifierTimestamp'
          2016-04-07T15:09:31.427-0500|Info: === 2016-04-07 15:09:31,427 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'modifierTimestamp' but null was returned
          2016-04-07T15:09:31.427-0500|Info: === 2016-04-07 15:09:31,427 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'modifierTimestamp' in the pooling flow
          2016-04-07T15:09:31.428-0500|Info: === 2016-04-07 15:09:31,428 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'creator'
          2016-04-07T15:09:31.428-0500|Info: === 2016-04-07 15:09:31,428 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'creator' but null was returned
          2016-04-07T15:09:31.428-0500|Info: === 2016-04-07 15:09:31,428 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'creator' in the pooling flow
          2016-04-07T15:09:31.429-0500|Info: === 2016-04-07 15:09:31,429 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'creatorTimestamp'
          2016-04-07T15:09:31.430-0500|Info: === 2016-04-07 15:09:31,430 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'creatorTimestamp' but null was returned
          2016-04-07T15:09:31.430-0500|Info: === 2016-04-07 15:09:31,430 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'creatorTimestamp' in the pooling flow
          2016-04-07T15:09:31.430-0500|Info: === 2016-04-07 15:09:31,430 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'binary'
          2016-04-07T15:09:31.431-0500|Info: === 2016-04-07 15:09:31,431 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'binary' but null was returned
          2016-04-07T15:09:31.431-0500|Info: === 2016-04-07 15:09:31,431 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'binary' in the pooling flow
          2016-04-07T15:09:31.432-0500|Info: === 2016-04-07 15:09:31,432 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'imageFile'
          2016-04-07T15:09:31.432-0500|Info: === 2016-04-07 15:09:31,432 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'imageFile' but null was returned
          2016-04-07T15:09:31.432-0500|Info: === 2016-04-07 15:09:31,432 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'imageFile' in the pooling flow
          2016-04-07T15:09:31.433-0500|Info: === 2016-04-07 15:09:31,432 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'blob'
          2016-04-07T15:09:31.433-0500|Info: === 2016-04-07 15:09:31,433 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'blob' but null was returned
          2016-04-07T15:09:31.433-0500|Info: === 2016-04-07 15:09:31,433 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'blob' in the pooling flow
          2016-04-07T15:09:31.433-0500|Info: === 2016-04-07 15:09:31,433 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'clob'
          2016-04-07T15:09:31.434-0500|Info: === 2016-04-07 15:09:31,434 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'clob' but null was returned
          2016-04-07T15:09:31.434-0500|Info: === 2016-04-07 15:09:31,434 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'clob' in the pooling flow
          2016-04-07T15:09:31.434-0500|Info: === 2016-04-07 15:09:31,434 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'image'
          2016-04-07T15:09:31.434-0500|Info: === 2016-04-07 15:09:31,434 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'image' but null was returned
          2016-04-07T15:09:31.434-0500|Info: === 2016-04-07 15:09:31,434 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'image' in the pooling flow
          2016-04-07T15:09:31.677-0500|Info: === 2016-04-07 15:09:31,677 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'users'
          2016-04-07T15:09:31.682-0500|Info: === 2016-04-07 15:09:31,682 [1(5)] DEBUG XML - Parsed XML from D:\Dropbox\Apps\Glassfish4\glassfish\domains\BMSim\eclipseApps\BMSim\resources\ds\users.ds.xml: 3ms
          2016-04-07T15:09:31.682-0500|Info: === 2016-04-07 15:09:31,682 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'DataSource'
          2016-04-07T15:09:31.688-0500|Info: === 2016-04-07 15:09:31,688 [1(5)] DEBUG XML - Parsed XML from D:\Dropbox\Apps\Glassfish4\glassfish\domains\BMSim\eclipseApps\BMSim\bmsim\sc\system\schema\DataSource.ds.xml: 5ms
          2016-04-07T15:09:31.688-0500|Info: === 2016-04-07 15:09:31,688 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'Object'
          2016-04-07T15:09:31.689-0500|Info: === 2016-04-07 15:09:31,689 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource 2 of type 'Object' and assigned it to thread http-listener-1(5)
          2016-04-07T15:09:31.690-0500|Info: === 2016-04-07 15:09:31,689 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource 2 of type 'Object' in the pooling flow
          2016-04-07T15:09:31.691-0500|Info: === 2016-04-07 15:09:31,691 [1(5)] DEBUG PoolableDataSourceFactory - Activated DataSource 2 of type 'Object'
          2016-04-07T15:09:31.691-0500|Info: === 2016-04-07 15:09:31,691 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'fields'
          2016-04-07T15:09:31.692-0500|Info: === 2016-04-07 15:09:31,692 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'fields' but null was returned
          2016-04-07T15:09:31.692-0500|Info: === 2016-04-07 15:09:31,692 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'fields' in the pooling flow
          2016-04-07T15:09:31.694-0500|Info: === 2016-04-07 15:09:31,694 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'ID'
          2016-04-07T15:09:31.694-0500|Info: === 2016-04-07 15:09:31,694 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'ID' but null was returned
          2016-04-07T15:09:31.694-0500|Info: === 2016-04-07 15:09:31,694 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'ID' in the pooling flow
          2016-04-07T15:09:31.695-0500|Info: === 2016-04-07 15:09:31,695 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'autoIdField'
          2016-04-07T15:09:31.695-0500|Info: === 2016-04-07 15:09:31,695 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'autoIdField' but null was returned
          2016-04-07T15:09:31.695-0500|Info: === 2016-04-07 15:09:31,695 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'autoIdField' in the pooling flow
          2016-04-07T15:09:31.696-0500|Info: === 2016-04-07 15:09:31,696 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'inheritsFrom'
          2016-04-07T15:09:31.696-0500|Info: === 2016-04-07 15:09:31,696 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'inheritsFrom' but null was returned
          2016-04-07T15:09:31.696-0500|Info: === 2016-04-07 15:09:31,696 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'inheritsFrom' in the pooling flow
          2016-04-07T15:09:31.697-0500|Info: === 2016-04-07 15:09:31,697 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'useParentFieldOrder'
          2016-04-07T15:09:31.697-0500|Info: === 2016-04-07 15:09:31,697 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'useParentFieldOrder' but null was returned
          2016-04-07T15:09:31.697-0500|Info: === 2016-04-07 15:09:31,697 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'useParentFieldOrder' in the pooling flow
          2016-04-07T15:09:31.698-0500|Info: === 2016-04-07 15:09:31,698 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'useLocalFieldsOnly'
          2016-04-07T15:09:31.698-0500|Info: === 2016-04-07 15:09:31,698 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'useLocalFieldsOnly' but null was returned
          2016-04-07T15:09:31.698-0500|Info: === 2016-04-07 15:09:31,698 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'useLocalFieldsOnly' in the pooling flow
          2016-04-07T15:09:31.698-0500|Info: === 2016-04-07 15:09:31,698 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'restrictToParentFields'
          2016-04-07T15:09:31.699-0500|Info: === 2016-04-07 15:09:31,699 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'restrictToParentFields' but null was returned
          2016-04-07T15:09:31.699-0500|Info: === 2016-04-07 15:09:31,699 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'restrictToParentFields' in the pooling flow
          2016-04-07T15:09:31.699-0500|Info: === 2016-04-07 15:09:31,699 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'valueMap'
          2016-04-07T15:09:31.700-0500|Info: === 2016-04-07 15:09:31,700 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'valueMap' but null was returned
          2016-04-07T15:09:31.700-0500|Info: === 2016-04-07 15:09:31,700 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'valueMap' in the pooling flow
          2016-04-07T15:09:31.700-0500|Info: === 2016-04-07 15:09:31,700 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'dataFormat'
          2016-04-07T15:09:31.700-0500|Info: === 2016-04-07 15:09:31,700 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'dataFormat' but null was returned
          2016-04-07T15:09:31.700-0500|Info: === 2016-04-07 15:09:31,700 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'dataFormat' in the pooling flow
          2016-04-07T15:09:31.701-0500|Info: === 2016-04-07 15:09:31,701 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'useStrictJSON'
          2016-04-07T15:09:31.701-0500|Info: === 2016-04-07 15:09:31,701 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'useStrictJSON' but null was returned
          2016-04-07T15:09:31.701-0500|Info: === 2016-04-07 15:09:31,701 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'useStrictJSON' in the pooling flow
          2016-04-07T15:09:31.702-0500|Info: === 2016-04-07 15:09:31,702 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'noAutoFetch'
          2016-04-07T15:09:31.702-0500|Info: === 2016-04-07 15:09:31,702 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'noAutoFetch' but null was returned
          2016-04-07T15:09:31.702-0500|Info: === 2016-04-07 15:09:31,702 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'noAutoFetch' in the pooling flow
          2016-04-07T15:09:31.703-0500|Info: === 2016-04-07 15:09:31,703 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'serverType'
          2016-04-07T15:09:31.703-0500|Info: === 2016-04-07 15:09:31,703 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'serverType' but null was returned
          2016-04-07T15:09:31.703-0500|Info: === 2016-04-07 15:09:31,703 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'serverType' in the pooling flow
          2016-04-07T15:09:31.704-0500|Info: === 2016-04-07 15:09:31,704 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'schemaBean'
          2016-04-07T15:09:31.704-0500|Info: === 2016-04-07 15:09:31,704 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'schemaBean' but null was returned
          2016-04-07T15:09:31.704-0500|Info: === 2016-04-07 15:09:31,704 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'schemaBean' in the pooling flow
          2016-04-07T15:09:31.705-0500|Info: === 2016-04-07 15:09:31,705 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'callbackParam'
          2016-04-07T15:09:31.705-0500|Info: === 2016-04-07 15:09:31,705 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'callbackParam' but null was returned
          2016-04-07T15:09:31.705-0500|Info: === 2016-04-07 15:09:31,705 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'callbackParam' in the pooling flow
          2016-04-07T15:09:31.705-0500|Info: === 2016-04-07 15:09:31,705 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'requestProperties'
          2016-04-07T15:09:31.706-0500|Info: === 2016-04-07 15:09:31,706 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'requestProperties' but null was returned
          2016-04-07T15:09:31.706-0500|Info: === 2016-04-07 15:09:31,706 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'requestProperties' in the pooling flow
          2016-04-07T15:09:31.706-0500|Info: === 2016-04-07 15:09:31,706 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'addGlobalId'
          2016-04-07T15:09:31.707-0500|Info: === 2016-04-07 15:09:31,707 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'addGlobalId' but null was returned
          2016-04-07T15:09:31.707-0500|Info: === 2016-04-07 15:09:31,707 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'addGlobalId' in the pooling flow
          2016-04-07T15:09:31.707-0500|Info: === 2016-04-07 15:09:31,707 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'showPrompt'
          2016-04-07T15:09:31.710-0500|Info: === 2016-04-07 15:09:31,710 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'showPrompt' but null was returned
          2016-04-07T15:09:31.710-0500|Info: === 2016-04-07 15:09:31,710 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'showPrompt' in the pooling flow
          2016-04-07T15:09:31.710-0500|Info: === 2016-04-07 15:09:31,710 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'dataSourceVersion'
          2016-04-07T15:09:31.711-0500|Info: === 2016-04-07 15:09:31,711 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'dataSourceVersion' but null was returned
          2016-04-07T15:09:31.711-0500|Info: === 2016-04-07 15:09:31,711 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'dataSourceVersion' in the pooling flow
          2016-04-07T15:09:31.712-0500|Info: === 2016-04-07 15:09:31,712 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'dbName'
          2016-04-07T15:09:31.712-0500|Info: === 2016-04-07 15:09:31,712 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'dbName' but null was returned
          2016-04-07T15:09:31.712-0500|Info: === 2016-04-07 15:09:31,712 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'dbName' in the pooling flow
          2016-04-07T15:09:31.714-0500|Info: === 2016-04-07 15:09:31,714 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'schema'
          2016-04-07T15:09:31.714-0500|Info: === 2016-04-07 15:09:31,714 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'schema' but null was returned
          2016-04-07T15:09:31.715-0500|Info: === 2016-04-07 15:09:31,714 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'schema' in the pooling flow
          2016-04-07T15:09:31.715-0500|Info: === 2016-04-07 15:09:31,715 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'tableName'
          2016-04-07T15:09:31.716-0500|Info: === 2016-04-07 15:09:31,716 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'tableName' but null was returned
          2016-04-07T15:09:31.717-0500|Info: === 2016-04-07 15:09:31,717 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'tableName' in the pooling flow
          2016-04-07T15:09:31.719-0500|Info: === 2016-04-07 15:09:31,719 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'quoteTableName'
          2016-04-07T15:09:31.720-0500|Info: === 2016-04-07 15:09:31,720 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'quoteTableName' but null was returned
          2016-04-07T15:09:31.720-0500|Info: === 2016-04-07 15:09:31,720 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'quoteTableName' in the pooling flow
          2016-04-07T15:09:31.721-0500|Info: === 2016-04-07 15:09:31,721 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'tableCode'
          2016-04-07T15:09:31.722-0500|Info: === 2016-04-07 15:09:31,722 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'tableCode' but null was returned
          2016-04-07T15:09:31.722-0500|Info: === 2016-04-07 15:09:31,722 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'tableCode' in the pooling flow
          2016-04-07T15:09:31.723-0500|Info: === 2016-04-07 15:09:31,723 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'strictSQLFiltering'
          2016-04-07T15:09:31.724-0500|Info: === 2016-04-07 15:09:31,724 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'strictSQLFiltering' but null was returned
          2016-04-07T15:09:31.724-0500|Info: === 2016-04-07 15:09:31,724 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'strictSQLFiltering' in the pooling flow
          2016-04-07T15:09:31.724-0500|Info: === 2016-04-07 15:09:31,724 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'serverObject'
          2016-04-07T15:09:31.727-0500|Info: === 2016-04-07 15:09:31,727 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'serverObject' but null was returned
          2016-04-07T15:09:31.727-0500|Info: === 2016-04-07 15:09:31,727 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'serverObject' in the pooling flow
          2016-04-07T15:09:31.730-0500|Info: === 2016-04-07 15:09:31,730 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'serverConstructor'
          2016-04-07T15:09:31.731-0500|Info: === 2016-04-07 15:09:31,731 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'serverConstructor' but null was returned
          2016-04-07T15:09:31.731-0500|Info: === 2016-04-07 15:09:31,731 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'serverConstructor' in the pooling flow
          2016-04-07T15:09:31.732-0500|Info: === 2016-04-07 15:09:31,731 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'operationBindings'
          2016-04-07T15:09:31.732-0500|Info: === 2016-04-07 15:09:31,732 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'operationBindings' but null was returned
          2016-04-07T15:09:31.732-0500|Info: === 2016-04-07 15:09:31,732 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'operationBindings' in the pooling flow
          2016-04-07T15:09:31.733-0500|Info: === 2016-04-07 15:09:31,733 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'field'
          2016-04-07T15:09:31.733-0500|Info: === 2016-04-07 15:09:31,733 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'field' but null was returned
          2016-04-07T15:09:31.733-0500|Info: === 2016-04-07 15:09:31,733 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'field' in the pooling flow
          2016-04-07T15:09:31.734-0500|Info: === 2016-04-07 15:09:31,734 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'operationBinding'
          2016-04-07T15:09:31.735-0500|Info: === 2016-04-07 15:09:31,735 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'operationBinding' but null was returned
          2016-04-07T15:09:31.735-0500|Info: === 2016-04-07 15:09:31,735 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'operationBinding' in the pooling flow
          2016-04-07T15:09:31.735-0500|Info: === 2016-04-07 15:09:31,735 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'serviceNamespace'
          2016-04-07T15:09:31.736-0500|Info: === 2016-04-07 15:09:31,736 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'serviceNamespace' but null was returned
          2016-04-07T15:09:31.736-0500|Info: === 2016-04-07 15:09:31,736 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'serviceNamespace' in the pooling flow
          2016-04-07T15:09:31.739-0500|Info: === 2016-04-07 15:09:31,739 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'dataURL'
          2016-04-07T15:09:31.740-0500|Info: === 2016-04-07 15:09:31,740 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'dataURL' but null was returned
          2016-04-07T15:09:31.741-0500|Info: === 2016-04-07 15:09:31,741 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'dataURL' in the pooling flow
          2016-04-07T15:09:31.741-0500|Info: === 2016-04-07 15:09:31,741 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'dataProtocol'
          2016-04-07T15:09:31.742-0500|Info: === 2016-04-07 15:09:31,742 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'dataProtocol' but null was returned
          2016-04-07T15:09:31.742-0500|Info: === 2016-04-07 15:09:31,742 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'dataProtocol' in the pooling flow
          2016-04-07T15:09:31.742-0500|Info: === 2016-04-07 15:09:31,742 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'dataTransport'
          2016-04-07T15:09:31.743-0500|Info: === 2016-04-07 15:09:31,743 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'dataTransport' but null was returned
          2016-04-07T15:09:31.743-0500|Info: === 2016-04-07 15:09:31,743 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'dataTransport' in the pooling flow
          2016-04-07T15:09:31.744-0500|Info: === 2016-04-07 15:09:31,744 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'defaultParams'
          2016-04-07T15:09:31.745-0500|Info: === 2016-04-07 15:09:31,745 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'defaultParams' but null was returned
          2016-04-07T15:09:31.745-0500|Info: === 2016-04-07 15:09:31,745 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'defaultParams' in the pooling flow
          2016-04-07T15:09:31.747-0500|Info: === 2016-04-07 15:09:31,747 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'soapAction'
          2016-04-07T15:09:31.748-0500|Info: === 2016-04-07 15:09:31,748 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'soapAction' but null was returned
          2016-04-07T15:09:31.749-0500|Info: === 2016-04-07 15:09:31,749 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'soapAction' in the pooling flow
          2016-04-07T15:09:31.751-0500|Info: === 2016-04-07 15:09:31,750 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'jsonPrefix'
          2016-04-07T15:09:31.751-0500|Info: === 2016-04-07 15:09:31,751 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'jsonPrefix' but null was returned
          2016-04-07T15:09:31.751-0500|Info: === 2016-04-07 15:09:31,751 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'jsonPrefix' in the pooling flow
          2016-04-07T15:09:31.752-0500|Info: === 2016-04-07 15:09:31,752 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'jsonSuffix'
          2016-04-07T15:09:31.752-0500|Info: === 2016-04-07 15:09:31,752 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'jsonSuffix' but null was returned
          2016-04-07T15:09:31.752-0500|Info: === 2016-04-07 15:09:31,752 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'jsonSuffix' in the pooling flow
          2016-04-07T15:09:31.753-0500|Info: === 2016-04-07 15:09:31,753 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'messageTemplate'
          2016-04-07T15:09:31.753-0500|Info: === 2016-04-07 15:09:31,753 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'messageTemplate' but null was returned
          2016-04-07T15:09:31.754-0500|Info: === 2016-04-07 15:09:31,754 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'messageTemplate' in the pooling flow
          2016-04-07T15:09:31.754-0500|Info: === 2016-04-07 15:09:31,754 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'defaultCriteria'
          2016-04-07T15:09:31.755-0500|Info: === 2016-04-07 15:09:31,755 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'defaultCriteria' but null was returned
          2016-04-07T15:09:31.756-0500|Info: === 2016-04-07 15:09:31,756 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'defaultCriteria' in the pooling flow
          2016-04-07T15:09:31.757-0500|Info: === 2016-04-07 15:09:31,757 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'tagName'
          2016-04-07T15:09:31.760-0500|Info: === 2016-04-07 15:09:31,760 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'tagName' but null was returned
          2016-04-07T15:09:31.760-0500|Info: === 2016-04-07 15:09:31,760 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'tagName' in the pooling flow
          2016-04-07T15:09:31.761-0500|Info: === 2016-04-07 15:09:31,761 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'recordXPath'
          2016-04-07T15:09:31.762-0500|Info: === 2016-04-07 15:09:31,762 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'recordXPath' but null was returned
          2016-04-07T15:09:31.763-0500|Info: === 2016-04-07 15:09:31,763 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'recordXPath' in the pooling flow
          2016-04-07T15:09:31.763-0500|Info: === 2016-04-07 15:09:31,763 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'recordName'
          2016-04-07T15:09:31.764-0500|Info: === 2016-04-07 15:09:31,764 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'recordName' but null was returned
          2016-04-07T15:09:31.766-0500|Info: === 2016-04-07 15:09:31,765 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'recordName' in the pooling flow
          2016-04-07T15:09:31.768-0500|Info: === 2016-04-07 15:09:31,768 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'xmlNamespaces'
          2016-04-07T15:09:31.769-0500|Info: === 2016-04-07 15:09:31,769 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'xmlNamespaces' but null was returned
          2016-04-07T15:09:31.769-0500|Info: === 2016-04-07 15:09:31,769 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'xmlNamespaces' in the pooling flow
          2016-04-07T15:09:31.770-0500|Info: === 2016-04-07 15:09:31,770 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'dropExtraFields'
          2016-04-07T15:09:31.770-0500|Info: === 2016-04-07 15:09:31,770 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'dropExtraFields' but null was returned
          2016-04-07T15:09:31.771-0500|Info: === 2016-04-07 15:09:31,770 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'dropExtraFields' in the pooling flow
          2016-04-07T15:09:31.772-0500|Info: === 2016-04-07 15:09:31,772 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'schemaNamespace'
          2016-04-07T15:09:31.773-0500|Info: === 2016-04-07 15:09:31,773 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'schemaNamespace' but null was returned
          2016-04-07T15:09:31.773-0500|Info: === 2016-04-07 15:09:31,773 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'schemaNamespace' in the pooling flow
          2016-04-07T15:09:31.774-0500|Info: === 2016-04-07 15:09:31,774 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'mustQualify'
          2016-04-07T15:09:31.775-0500|Info: === 2016-04-07 15:09:31,775 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'mustQualify' but null was returned
          2016-04-07T15:09:31.775-0500|Info: === 2016-04-07 15:09:31,775 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'mustQualify' in the pooling flow
          2016-04-07T15:09:31.776-0500|Info: === 2016-04-07 15:09:31,776 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'xsdSimpleContent'
          2016-04-07T15:09:31.776-0500|Info: === 2016-04-07 15:09:31,776 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'xsdSimpleContent' but null was returned
          2016-04-07T15:09:31.778-0500|Info: === 2016-04-07 15:09:31,776 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'xsdSimpleContent' in the pooling flow
          2016-04-07T15:09:31.780-0500|Info: === 2016-04-07 15:09:31,779 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'xsdAnyElement'
          2016-04-07T15:09:31.780-0500|Info: === 2016-04-07 15:09:31,780 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'xsdAnyElement' but null was returned
          2016-04-07T15:09:31.780-0500|Info: === 2016-04-07 15:09:31,780 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'xsdAnyElement' in the pooling flow
          2016-04-07T15:09:31.781-0500|Info: === 2016-04-07 15:09:31,781 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'xsdAbstract'
          2016-04-07T15:09:31.784-0500|Info: === 2016-04-07 15:09:31,784 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'xsdAbstract' but null was returned
          2016-04-07T15:09:31.785-0500|Info: === 2016-04-07 15:09:31,785 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'xsdAbstract' in the pooling flow
          2016-04-07T15:09:31.786-0500|Info: === 2016-04-07 15:09:31,786 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'title'
          2016-04-07T15:09:31.788-0500|Info: === 2016-04-07 15:09:31,788 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'title' but null was returned
          2016-04-07T15:09:31.788-0500|Info: === 2016-04-07 15:09:31,788 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'title' in the pooling flow
          2016-04-07T15:09:31.789-0500|Info: === 2016-04-07 15:09:31,789 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'titleField'
          2016-04-07T15:09:31.790-0500|Info: === 2016-04-07 15:09:31,789 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'titleField' but null was returned
          2016-04-07T15:09:31.790-0500|Info: === 2016-04-07 15:09:31,790 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'titleField' in the pooling flow
          2016-04-07T15:09:31.791-0500|Info: === 2016-04-07 15:09:31,791 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'pluralTitle'
          2016-04-07T15:09:31.791-0500|Info: === 2016-04-07 15:09:31,791 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'pluralTitle' but null was returned
          2016-04-07T15:09:31.791-0500|Info: === 2016-04-07 15:09:31,791 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'pluralTitle' in the pooling flow
          2016-04-07T15:09:31.792-0500|Info: === 2016-04-07 15:09:31,792 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'clientOnly'
          2016-04-07T15:09:31.792-0500|Info: === 2016-04-07 15:09:31,792 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'clientOnly' but null was returned
          2016-04-07T15:09:31.792-0500|Info: === 2016-04-07 15:09:31,792 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'clientOnly' in the pooling flow
          2016-04-07T15:09:31.793-0500|Info: === 2016-04-07 15:09:31,793 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'testFileName'
          2016-04-07T15:09:31.794-0500|Info: === 2016-04-07 15:09:31,794 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'testFileName' but null was returned
          2016-04-07T15:09:31.794-0500|Info: === 2016-04-07 15:09:31,794 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'testFileName' in the pooling flow
          2016-04-07T15:09:31.794-0500|Info: === 2016-04-07 15:09:31,794 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'dbImportFileName'
          2016-04-07T15:09:31.795-0500|Info: === 2016-04-07 15:09:31,795 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'dbImportFileName' but null was returned
          2016-04-07T15:09:31.795-0500|Info: === 2016-04-07 15:09:31,795 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'dbImportFileName' in the pooling flow
          2016-04-07T15:09:31.796-0500|Info: === 2016-04-07 15:09:31,796 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'testData'
          2016-04-07T15:09:31.796-0500|Info: === 2016-04-07 15:09:31,796 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'testData' but null was returned
          2016-04-07T15:09:31.796-0500|Info: === 2016-04-07 15:09:31,796 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'testData' in the pooling flow
          2016-04-07T15:09:31.798-0500|Info: === 2016-04-07 15:09:31,798 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'cacheData'
          2016-04-07T15:09:31.798-0500|Info: === 2016-04-07 15:09:31,798 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'cacheData' but null was returned
          2016-04-07T15:09:31.798-0500|Info: === 2016-04-07 15:09:31,798 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'cacheData' in the pooling flow
          2016-04-07T15:09:31.799-0500|Info: === 2016-04-07 15:09:31,799 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'cacheAllData'
          2016-04-07T15:09:31.799-0500|Info: === 2016-04-07 15:09:31,799 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'cacheAllData' but null was returned
          2016-04-07T15:09:31.799-0500|Info: === 2016-04-07 15:09:31,799 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'cacheAllData' in the pooling flow
          2016-04-07T15:09:31.800-0500|Info: === 2016-04-07 15:09:31,800 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'cacheAcrossOperationIds'
          2016-04-07T15:09:31.800-0500|Info: === 2016-04-07 15:09:31,800 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'cacheAcrossOperationIds' but null was returned
          2016-04-07T15:09:31.800-0500|Info: === 2016-04-07 15:09:31,800 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'cacheAcrossOperationIds' in the pooling flow
          2016-04-07T15:09:31.801-0500|Info: === 2016-04-07 15:09:31,801 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'types'
          2016-04-07T15:09:31.802-0500|Info: === 2016-04-07 15:09:31,802 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'types' but null was returned
          2016-04-07T15:09:31.802-0500|Info: === 2016-04-07 15:09:31,802 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'types' in the pooling flow
          2016-04-07T15:09:31.802-0500|Info: === 2016-04-07 15:09:31,802 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'groups'
          2016-04-07T15:09:31.802-0500|Info: === 2016-04-07 15:09:31,802 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'groups' but null was returned
          2016-04-07T15:09:31.803-0500|Info: === 2016-04-07 15:09:31,803 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'groups' in the pooling flow
          2016-04-07T15:09:31.803-0500|Info: === 2016-04-07 15:09:31,803 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'methods'
          2016-04-07T15:09:31.803-0500|Info: === 2016-04-07 15:09:31,803 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'methods' but null was returned
          2016-04-07T15:09:31.803-0500|Info: === 2016-04-07 15:09:31,803 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'methods' in the pooling flow
          2016-04-07T15:09:31.804-0500|Info: === 2016-04-07 15:09:31,804 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'showSuperClassActions'
          2016-04-07T15:09:31.804-0500|Info: === 2016-04-07 15:09:31,804 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'showSuperClassActions' but null was returned
          2016-04-07T15:09:31.804-0500|Info: === 2016-04-07 15:09:31,804 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'showSuperClassActions' in the pooling flow
          2016-04-07T15:09:31.805-0500|Info: === 2016-04-07 15:09:31,805 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'createStandalone'
          2016-04-07T15:09:31.805-0500|Info: === 2016-04-07 15:09:31,805 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'createStandalone' but null was returned
          2016-04-07T15:09:31.805-0500|Info: === 2016-04-07 15:09:31,805 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'createStandalone' in the pooling flow
          2016-04-07T15:09:31.805-0500|Info: === 2016-04-07 15:09:31,805 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'useFlatFields'
          2016-04-07T15:09:31.806-0500|Info: === 2016-04-07 15:09:31,806 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'useFlatFields' but null was returned
          2016-04-07T15:09:31.806-0500|Info: === 2016-04-07 15:09:31,806 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'useFlatFields' in the pooling flow
          2016-04-07T15:09:31.806-0500|Info: === 2016-04-07 15:09:31,806 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'showLocalFieldsOnly'
          2016-04-07T15:09:31.806-0500|Info: === 2016-04-07 15:09:31,806 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'showLocalFieldsOnly' but null was returned
          2016-04-07T15:09:31.806-0500|Info: === 2016-04-07 15:09:31,806 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'showLocalFieldsOnly' in the pooling flow
          2016-04-07T15:09:31.807-0500|Info: === 2016-04-07 15:09:31,807 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'showSuperClassEvents'
          2016-04-07T15:09:31.807-0500|Info: === 2016-04-07 15:09:31,807 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'showSuperClassEvents' but null was returned
          2016-04-07T15:09:31.807-0500|Info: === 2016-04-07 15:09:31,807 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'showSuperClassEvents' in the pooling flow
          2016-04-07T15:09:31.807-0500|Info: === 2016-04-07 15:09:31,807 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'globalNamespaces'
          2016-04-07T15:09:31.808-0500|Info: === 2016-04-07 15:09:31,808 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'globalNamespaces' but null was returned
          2016-04-07T15:09:31.808-0500|Info: === 2016-04-07 15:09:31,808 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'globalNamespaces' in the pooling flow
          2016-04-07T15:09:31.808-0500|Info: === 2016-04-07 15:09:31,808 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'autoDeriveSchema'
          2016-04-07T15:09:31.808-0500|Info: === 2016-04-07 15:09:31,808 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'autoDeriveSchema' but null was returned
          2016-04-07T15:09:31.808-0500|Info: === 2016-04-07 15:09:31,808 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'autoDeriveSchema' in the pooling flow
          2016-04-07T15:09:31.809-0500|Info: === 2016-04-07 15:09:31,809 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'autoDeriveFKs'
          2016-04-07T15:09:31.809-0500|Info: === 2016-04-07 15:09:31,809 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'autoDeriveFKs' but null was returned
          2016-04-07T15:09:31.809-0500|Info: === 2016-04-07 15:09:31,809 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'autoDeriveFKs' in the pooling flow
          2016-04-07T15:09:31.809-0500|Info: === 2016-04-07 15:09:31,809 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'useLocalValidators'
          2016-04-07T15:09:31.810-0500|Info: === 2016-04-07 15:09:31,810 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'useLocalValidators' but null was returned
          2016-04-07T15:09:31.810-0500|Info: === 2016-04-07 15:09:31,810 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'useLocalValidators' in the pooling flow
          2016-04-07T15:09:31.810-0500|Info: === 2016-04-07 15:09:31,810 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'autoDeriveTitles'
          2016-04-07T15:09:31.810-0500|Info: === 2016-04-07 15:09:31,810 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'autoDeriveTitles' but null was returned
          2016-04-07T15:09:31.810-0500|Info: === 2016-04-07 15:09:31,810 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'autoDeriveTitles' in the pooling flow
          2016-04-07T15:09:31.811-0500|Info: === 2016-04-07 15:09:31,811 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'qualifyColumnNames'
          2016-04-07T15:09:31.811-0500|Info: === 2016-04-07 15:09:31,811 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'qualifyColumnNames' but null was returned
          2016-04-07T15:09:31.811-0500|Info: === 2016-04-07 15:09:31,811 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'qualifyColumnNames' in the pooling flow
          2016-04-07T15:09:31.811-0500|Info: === 2016-04-07 15:09:31,811 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'validateRelatedRecords'
          2016-04-07T15:09:31.811-0500|Info: === 2016-04-07 15:09:31,811 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'validateRelatedRecords' but null was returned
          2016-04-07T15:09:31.811-0500|Info: === 2016-04-07 15:09:31,811 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'validateRelatedRecords' in the pooling flow
          2016-04-07T15:09:31.812-0500|Info: === 2016-04-07 15:09:31,812 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'requiresAuthentication'
          2016-04-07T15:09:31.812-0500|Info: === 2016-04-07 15:09:31,812 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'requiresAuthentication' but null was returned
          2016-04-07T15:09:31.812-0500|Info: === 2016-04-07 15:09:31,812 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'requiresAuthentication' in the pooling flow
          2016-04-07T15:09:31.812-0500|Info: === 2016-04-07 15:09:31,812 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'requiresRole'
          2016-04-07T15:09:31.813-0500|Info: === 2016-04-07 15:09:31,813 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'requiresRole' but null was returned
          2016-04-07T15:09:31.813-0500|Info: === 2016-04-07 15:09:31,813 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'requiresRole' in the pooling flow
          2016-04-07T15:09:31.813-0500|Info: === 2016-04-07 15:09:31,813 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'requires'
          2016-04-07T15:09:31.813-0500|Info: === 2016-04-07 15:09:31,813 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'requires' but null was returned
          2016-04-07T15:09:31.813-0500|Info: === 2016-04-07 15:09:31,813 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'requires' in the pooling flow
          2016-04-07T15:09:31.814-0500|Info: === 2016-04-07 15:09:31,814 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'ownerIdField'
          2016-04-07T15:09:31.814-0500|Info: === 2016-04-07 15:09:31,814 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'ownerIdField' but null was returned
          2016-04-07T15:09:31.814-0500|Info: === 2016-04-07 15:09:31,814 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'ownerIdField' in the pooling flow
          2016-04-07T15:09:31.814-0500|Info: === 2016-04-07 15:09:31,814 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'guestUserId'
          2016-04-07T15:09:31.814-0500|Info: === 2016-04-07 15:09:31,814 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'guestUserId' but null was returned
          2016-04-07T15:09:31.814-0500|Info: === 2016-04-07 15:09:31,814 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'guestUserId' in the pooling flow
          2016-04-07T15:09:31.815-0500|Info: === 2016-04-07 15:09:31,815 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'beanClassName'
          2016-04-07T15:09:31.815-0500|Info: === 2016-04-07 15:09:31,815 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'beanClassName' but null was returned
          2016-04-07T15:09:31.815-0500|Info: === 2016-04-07 15:09:31,815 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'beanClassName' in the pooling flow
          2016-04-07T15:09:31.815-0500|Info: === 2016-04-07 15:09:31,815 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'autoJoinTransactions'
          2016-04-07T15:09:31.816-0500|Info: === 2016-04-07 15:09:31,816 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'autoJoinTransactions' but null was returned
          2016-04-07T15:09:31.816-0500|Info: === 2016-04-07 15:09:31,816 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'autoJoinTransactions' in the pooling flow
          2016-04-07T15:09:31.816-0500|Info: === 2016-04-07 15:09:31,816 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'useAnsiJoins'
          2016-04-07T15:09:31.816-0500|Info: === 2016-04-07 15:09:31,816 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'useAnsiJoins' but null was returned
          2016-04-07T15:09:31.816-0500|Info: === 2016-04-07 15:09:31,816 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'useAnsiJoins' in the pooling flow
          2016-04-07T15:09:31.817-0500|Info: === 2016-04-07 15:09:31,817 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'useSpringTransaction'
          2016-04-07T15:09:31.817-0500|Info: === 2016-04-07 15:09:31,817 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'useSpringTransaction' but null was returned
          2016-04-07T15:09:31.817-0500|Info: === 2016-04-07 15:09:31,817 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'useSpringTransaction' in the pooling flow
          2016-04-07T15:09:31.817-0500|Info: === 2016-04-07 15:09:31,817 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'sparseUpdates'
          2016-04-07T15:09:31.817-0500|Info: === 2016-04-07 15:09:31,817 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'sparseUpdates' but null was returned
          2016-04-07T15:09:31.818-0500|Info: === 2016-04-07 15:09:31,818 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'sparseUpdates' in the pooling flow
          2016-04-07T15:09:31.818-0500|Info: === 2016-04-07 15:09:31,818 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'noNullUpdates'
          2016-04-07T15:09:31.818-0500|Info: === 2016-04-07 15:09:31,818 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'noNullUpdates' but null was returned
          2016-04-07T15:09:31.818-0500|Info: === 2016-04-07 15:09:31,818 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'noNullUpdates' in the pooling flow
          2016-04-07T15:09:31.818-0500|Info: === 2016-04-07 15:09:31,818 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'canExport'
          2016-04-07T15:09:31.819-0500|Info: === 2016-04-07 15:09:31,819 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'canExport' but null was returned
          2016-04-07T15:09:31.819-0500|Info: === 2016-04-07 15:09:31,819 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'canExport' in the pooling flow
          2016-04-07T15:09:31.819-0500|Info: === 2016-04-07 15:09:31,819 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'progressiveLoading'
          2016-04-07T15:09:31.819-0500|Info: === 2016-04-07 15:09:31,819 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'progressiveLoading' but null was returned
          2016-04-07T15:09:31.819-0500|Info: === 2016-04-07 15:09:31,819 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'progressiveLoading' in the pooling flow
          2016-04-07T15:09:31.820-0500|Info: === 2016-04-07 15:09:31,820 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'autoConvertRelativeDates'
          2016-04-07T15:09:31.820-0500|Info: === 2016-04-07 15:09:31,820 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'autoConvertRelativeDates' but null was returned
          2016-04-07T15:09:31.820-0500|Info: === 2016-04-07 15:09:31,820 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'autoConvertRelativeDates' in the pooling flow
          2016-04-07T15:09:31.820-0500|Info: === 2016-04-07 15:09:31,820 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'allowAdvancedCriteria'
          2016-04-07T15:09:31.821-0500|Info: === 2016-04-07 15:09:31,821 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'allowAdvancedCriteria' but null was returned
          2016-04-07T15:09:31.821-0500|Info: === 2016-04-07 15:09:31,821 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'allowAdvancedCriteria' in the pooling flow
          2016-04-07T15:09:31.821-0500|Info: === 2016-04-07 15:09:31,821 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'scriptImport'
          2016-04-07T15:09:31.821-0500|Info: === 2016-04-07 15:09:31,821 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'scriptImport' but null was returned
          2016-04-07T15:09:31.821-0500|Info: === 2016-04-07 15:09:31,821 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'scriptImport' in the pooling flow
          2016-04-07T15:09:31.821-0500|Info: === 2016-04-07 15:09:31,821 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'script'
          2016-04-07T15:09:31.822-0500|Info: === 2016-04-07 15:09:31,822 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'script' but null was returned
          2016-04-07T15:09:31.822-0500|Info: === 2016-04-07 15:09:31,822 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'script' in the pooling flow
          2016-04-07T15:09:31.822-0500|Info: === 2016-04-07 15:09:31,822 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'allowClientRequestedSummaries'
          2016-04-07T15:09:31.822-0500|Info: === 2016-04-07 15:09:31,822 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'allowClientRequestedSummaries' but null was returned
          2016-04-07T15:09:31.822-0500|Info: === 2016-04-07 15:09:31,822 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'allowClientRequestedSummaries' in the pooling flow
          2016-04-07T15:09:31.829-0500|Info: === 2016-04-07 15:09:31,829 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'patternMultiWildcard'
          2016-04-07T15:09:31.829-0500|Info: === 2016-04-07 15:09:31,829 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'patternMultiWildcard' but null was returned
          2016-04-07T15:09:31.829-0500|Info: === 2016-04-07 15:09:31,829 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'patternMultiWildcard' in the pooling flow
          2016-04-07T15:09:31.830-0500|Info: === 2016-04-07 15:09:31,830 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'patternSingleWildcard'
          2016-04-07T15:09:31.830-0500|Info: === 2016-04-07 15:09:31,830 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'patternSingleWildcard' but null was returned
          2016-04-07T15:09:31.830-0500|Info: === 2016-04-07 15:09:31,830 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'patternSingleWildcard' in the pooling flow
          2016-04-07T15:09:31.831-0500|Info: === 2016-04-07 15:09:31,831 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'criteriaPolicy'
          2016-04-07T15:09:31.831-0500|Info: === 2016-04-07 15:09:31,831 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'criteriaPolicy' but null was returned
          2016-04-07T15:09:31.831-0500|Info: === 2016-04-07 15:09:31,831 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'criteriaPolicy' in the pooling flow
          2016-04-07T15:09:31.832-0500|Info: === 2016-04-07 15:09:31,832 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'substituteClasses'
          2016-04-07T15:09:31.832-0500|Info: === 2016-04-07 15:09:31,832 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'substituteClasses' but null was returned
          2016-04-07T15:09:31.832-0500|Info: === 2016-04-07 15:09:31,832 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'substituteClasses' in the pooling flow
          2016-04-07T15:09:31.832-0500|Info: === 2016-04-07 15:09:31,832 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'idClassName'
          2016-04-07T15:09:31.833-0500|Info: === 2016-04-07 15:09:31,833 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'idClassName' but null was returned
          2016-04-07T15:09:31.833-0500|Info: === 2016-04-07 15:09:31,833 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'idClassName' in the pooling flow
          2016-04-07T15:09:31.833-0500|Info: === 2016-04-07 15:09:31,833 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'supportTransactions'
          2016-04-07T15:09:31.834-0500|Info: === 2016-04-07 15:09:31,834 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'supportTransactions' but null was returned
          2016-04-07T15:09:31.834-0500|Info: === 2016-04-07 15:09:31,834 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'supportTransactions' in the pooling flow
          2016-04-07T15:09:31.834-0500|Info: === 2016-04-07 15:09:31,834 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'creatorOverrides'
          2016-04-07T15:09:31.835-0500|Info: === 2016-04-07 15:09:31,835 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'creatorOverrides' but null was returned
          2016-04-07T15:09:31.835-0500|Info: === 2016-04-07 15:09:31,835 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'creatorOverrides' in the pooling flow
          2016-04-07T15:09:31.835-0500|Info: === 2016-04-07 15:09:31,835 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'loadParents'
          2016-04-07T15:09:31.836-0500|Info: === 2016-04-07 15:09:31,836 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'loadParents' but null was returned
          2016-04-07T15:09:31.836-0500|Info: === 2016-04-07 15:09:31,836 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'loadParents' in the pooling flow
          2016-04-07T15:09:31.836-0500|Info: === 2016-04-07 15:09:31,836 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'loadID'
          2016-04-07T15:09:31.837-0500|Info: === 2016-04-07 15:09:31,837 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'loadID' but null was returned
          2016-04-07T15:09:31.837-0500|Info: === 2016-04-07 15:09:31,837 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'loadID' in the pooling flow
          2016-04-07T15:09:31.837-0500|Info: === 2016-04-07 15:09:31,837 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'audit'
          2016-04-07T15:09:31.837-0500|Info: === 2016-04-07 15:09:31,837 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'audit' but null was returned
          2016-04-07T15:09:31.837-0500|Info: === 2016-04-07 15:09:31,837 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'audit' in the pooling flow
          2016-04-07T15:09:31.838-0500|Info: === 2016-04-07 15:09:31,838 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'auditDataSourceID'
          2016-04-07T15:09:31.838-0500|Info: === 2016-04-07 15:09:31,838 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'auditDataSourceID' but null was returned
          2016-04-07T15:09:31.838-0500|Info: === 2016-04-07 15:09:31,838 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'auditDataSourceID' in the pooling flow
          2016-04-07T15:09:31.839-0500|Info: === 2016-04-07 15:09:31,839 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'auditDSConstructor'
          2016-04-07T15:09:31.839-0500|Info: === 2016-04-07 15:09:31,839 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'auditDSConstructor' but null was returned
          2016-04-07T15:09:31.839-0500|Info: === 2016-04-07 15:09:31,839 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'auditDSConstructor' in the pooling flow
          2016-04-07T15:09:31.840-0500|Info: === 2016-04-07 15:09:31,840 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'auditRevisionFieldName'
          2016-04-07T15:09:31.840-0500|Info: === 2016-04-07 15:09:31,840 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'auditRevisionFieldName' but null was returned
          2016-04-07T15:09:31.840-0500|Info: === 2016-04-07 15:09:31,840 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'auditRevisionFieldName' in the pooling flow
          2016-04-07T15:09:31.840-0500|Info: === 2016-04-07 15:09:31,840 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'auditTimeStampFieldName'
          2016-04-07T15:09:31.841-0500|Info: === 2016-04-07 15:09:31,841 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'auditTimeStampFieldName' but null was returned
          2016-04-07T15:09:31.841-0500|Info: === 2016-04-07 15:09:31,841 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'auditTimeStampFieldName' in the pooling flow
          2016-04-07T15:09:31.841-0500|Info: === 2016-04-07 15:09:31,841 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'auditTypeFieldName'
          2016-04-07T15:09:31.842-0500|Info: === 2016-04-07 15:09:31,842 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'auditTypeFieldName' but null was returned
          2016-04-07T15:09:31.842-0500|Info: === 2016-04-07 15:09:31,842 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'auditTypeFieldName' in the pooling flow
          2016-04-07T15:09:31.842-0500|Info: === 2016-04-07 15:09:31,842 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'auditUserFieldName'
          2016-04-07T15:09:31.842-0500|Info: === 2016-04-07 15:09:31,842 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'auditUserFieldName' but null was returned
          2016-04-07T15:09:31.842-0500|Info: === 2016-04-07 15:09:31,842 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'auditUserFieldName' in the pooling flow
          2016-04-07T15:09:31.843-0500|Info: === 2016-04-07 15:09:31,843 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'autoCreateAuditTable'
          2016-04-07T15:09:31.843-0500|Info: === 2016-04-07 15:09:31,843 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'autoCreateAuditTable' but null was returned
          2016-04-07T15:09:31.843-0500|Info: === 2016-04-07 15:09:31,843 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'autoCreateAuditTable' in the pooling flow
          2016-04-07T15:09:31.843-0500|Info: === 2016-04-07 15:09:31,843 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'inheritanceMode'
          2016-04-07T15:09:31.844-0500|Info: === 2016-04-07 15:09:31,844 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'inheritanceMode' but null was returned
          2016-04-07T15:09:31.844-0500|Info: === 2016-04-07 15:09:31,844 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'inheritanceMode' in the pooling flow
          2016-04-07T15:09:31.844-0500|Info: === 2016-04-07 15:09:31,844 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'quoteColumnNames'
          2016-04-07T15:09:31.845-0500|Info: === 2016-04-07 15:09:31,845 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'quoteColumnNames' but null was returned
          2016-04-07T15:09:31.845-0500|Info: === 2016-04-07 15:09:31,845 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'quoteColumnNames' in the pooling flow
          2016-04-07T15:09:31.845-0500|Info: === 2016-04-07 15:09:31,845 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'generatedBy'
          2016-04-07T15:09:31.846-0500|Info: === 2016-04-07 15:09:31,846 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'generatedBy' but null was returned
          2016-04-07T15:09:31.846-0500|Info: === 2016-04-07 15:09:31,846 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'generatedBy' in the pooling flow
          2016-04-07T15:09:31.846-0500|Info: === 2016-04-07 15:09:31,846 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'useUTCDateTimes'
          2016-04-07T15:09:31.846-0500|Info: === 2016-04-07 15:09:31,846 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'useUTCDateTimes' but null was returned
          2016-04-07T15:09:31.847-0500|Info: === 2016-04-07 15:09:31,846 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'useUTCDateTimes' in the pooling flow
          2016-04-07T15:09:31.847-0500|Info: === 2016-04-07 15:09:31,847 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'useOfflineStorage'
          2016-04-07T15:09:31.847-0500|Info: === 2016-04-07 15:09:31,847 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'useOfflineStorage' but null was returned
          2016-04-07T15:09:31.847-0500|Info: === 2016-04-07 15:09:31,847 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'useOfflineStorage' in the pooling flow
          2016-04-07T15:09:31.848-0500|Info: === 2016-04-07 15:09:31,848 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'enumOrdinalProperty'
          2016-04-07T15:09:31.848-0500|Info: === 2016-04-07 15:09:31,848 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'enumOrdinalProperty' but null was returned
          2016-04-07T15:09:31.848-0500|Info: === 2016-04-07 15:09:31,848 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'enumOrdinalProperty' in the pooling flow
          2016-04-07T15:09:31.849-0500|Info: === 2016-04-07 15:09:31,849 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'enumTranslateStrategy'
          2016-04-07T15:09:31.849-0500|Info: === 2016-04-07 15:09:31,849 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'enumTranslateStrategy' but null was returned
          2016-04-07T15:09:31.849-0500|Info: === 2016-04-07 15:09:31,849 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'enumTranslateStrategy' in the pooling flow
          2016-04-07T15:09:31.850-0500|Info: === 2016-04-07 15:09:31,850 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'xmlFromConfig'
          2016-04-07T15:09:31.850-0500|Info: === 2016-04-07 15:09:31,850 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'xmlFromConfig' but null was returned
          2016-04-07T15:09:31.850-0500|Info: === 2016-04-07 15:09:31,850 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'xmlFromConfig' in the pooling flow
          2016-04-07T15:09:31.851-0500|Info: === 2016-04-07 15:09:31,851 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'translatePatternOperators'
          2016-04-07T15:09:31.851-0500|Info: === 2016-04-07 15:09:31,851 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'translatePatternOperators' but null was returned
          2016-04-07T15:09:31.851-0500|Info: === 2016-04-07 15:09:31,851 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'translatePatternOperators' in the pooling flow
          2016-04-07T15:09:31.852-0500|Info: === 2016-04-07 15:09:31,851 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'fileNameField'
          2016-04-07T15:09:31.852-0500|Info: === 2016-04-07 15:09:31,852 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'fileNameField' but null was returned
          2016-04-07T15:09:31.852-0500|Info: === 2016-04-07 15:09:31,852 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'fileNameField' in the pooling flow
          2016-04-07T15:09:31.852-0500|Info: === 2016-04-07 15:09:31,852 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'fileTypeField'
          2016-04-07T15:09:31.853-0500|Info: === 2016-04-07 15:09:31,853 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'fileTypeField' but null was returned
          2016-04-07T15:09:31.853-0500|Info: === 2016-04-07 15:09:31,853 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'fileTypeField' in the pooling flow
          2016-04-07T15:09:31.853-0500|Info: === 2016-04-07 15:09:31,853 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'fileFormatField'
          2016-04-07T15:09:31.853-0500|Info: === 2016-04-07 15:09:31,853 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'fileFormatField' but null was returned
          2016-04-07T15:09:31.853-0500|Info: === 2016-04-07 15:09:31,853 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'fileFormatField' in the pooling flow
          2016-04-07T15:09:31.854-0500|Info: === 2016-04-07 15:09:31,854 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'fileSizeField'
          2016-04-07T15:09:31.854-0500|Info: === 2016-04-07 15:09:31,854 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'fileSizeField' but null was returned
          2016-04-07T15:09:31.854-0500|Info: === 2016-04-07 15:09:31,854 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'fileSizeField' in the pooling flow
          2016-04-07T15:09:31.855-0500|Info: === 2016-04-07 15:09:31,855 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'fileLastModifiedField'
          2016-04-07T15:09:31.856-0500|Info: === 2016-04-07 15:09:31,856 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'fileLastModifiedField' but null was returned
          2016-04-07T15:09:31.856-0500|Info: === 2016-04-07 15:09:31,856 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'fileLastModifiedField' in the pooling flow
          2016-04-07T15:09:31.856-0500|Info: === 2016-04-07 15:09:31,856 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'fileContentsField'
          2016-04-07T15:09:31.857-0500|Info: === 2016-04-07 15:09:31,857 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'fileContentsField' but null was returned
          2016-04-07T15:09:31.857-0500|Info: === 2016-04-07 15:09:31,857 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'fileContentsField' in the pooling flow
          2016-04-07T15:09:31.857-0500|Info: === 2016-04-07 15:09:31,857 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'projectFileKey'
          2016-04-07T15:09:31.857-0500|Info: === 2016-04-07 15:09:31,857 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'projectFileKey' but null was returned
          2016-04-07T15:09:31.857-0500|Info: === 2016-04-07 15:09:31,857 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'projectFileKey' in the pooling flow
          2016-04-07T15:09:31.858-0500|Info: === 2016-04-07 15:09:31,858 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'projectFileLocations'
          2016-04-07T15:09:31.858-0500|Info: === 2016-04-07 15:09:31,858 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'projectFileLocations' but null was returned
          2016-04-07T15:09:31.858-0500|Info: === 2016-04-07 15:09:31,858 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'projectFileLocations' in the pooling flow
          2016-04-07T15:09:31.859-0500|Info: === 2016-04-07 15:09:31,859 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'defaultTextMatchStyle'
          2016-04-07T15:09:31.859-0500|Info: === 2016-04-07 15:09:31,859 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'defaultTextMatchStyle' but null was returned
          2016-04-07T15:09:31.859-0500|Info: === 2016-04-07 15:09:31,859 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'defaultTextMatchStyle' in the pooling flow
          2016-04-07T15:09:31.859-0500|Info: === 2016-04-07 15:09:31,859 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'ignoreTextMatchStyleCaseSensitive'
          2016-04-07T15:09:31.860-0500|Info: === 2016-04-07 15:09:31,860 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'ignoreTextMatchStyleCaseSensitive' but null was returned
          2016-04-07T15:09:31.860-0500|Info: === 2016-04-07 15:09:31,860 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'ignoreTextMatchStyleCaseSensitive' in the pooling flow
          2016-04-07T15:09:31.860-0500|Info: === 2016-04-07 15:09:31,860 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'defaultMultiUpdatePolicy'
          2016-04-07T15:09:31.861-0500|Info: === 2016-04-07 15:09:31,861 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'defaultMultiUpdatePolicy' but null was returned
          2016-04-07T15:09:31.861-0500|Info: === 2016-04-07 15:09:31,861 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'defaultMultiUpdatePolicy' in the pooling flow
          2016-04-07T15:09:31.878-0500|Info: === 2016-04-07 15:09:31,878 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource 3 of type 'DataSource' and assigned it to thread http-listener-1(5)
          2016-04-07T15:09:31.878-0500|Info: === 2016-04-07 15:09:31,878 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource 3 of type 'DataSource' in the pooling flow
          2016-04-07T15:09:31.878-0500|Info: === 2016-04-07 15:09:31,878 [1(5)] DEBUG PoolableDataSourceFactory - Activated DataSource 3 of type 'DataSource'
          2016-04-07T15:09:32.138-0500|Info: === 2016-04-07 15:09:32,138 [1(4)] INFO RequestContext - URL: '/BMSim/bmsim/sc/skins/Enterprise/skin_styles.css', User-Agent: 'Mozilla/5.0 (Windows NT 10.0; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/49.0.2623.110 Safari/537.36': Safari with Accept-Encoding header
          2016-04-07T15:09:32.148-0500|Info: === 2016-04-07 15:09:32,147 [1(4)] INFO Download - done streaming: D:/Dropbox/Apps/Glassfish4/glassfish/domains/BMSim/eclipseApps/BMSim/bmsim/sc/skins/Enterprise/skin_styles.css
          2016-04-07T15:09:32.154-0500|Info: === 2016-04-07 15:09:32,154 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'Object'
          2016-04-07T15:09:32.155-0500|Info: === 2016-04-07 15:09:32,155 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource 4 of type 'Object' and assigned it to thread http-listener-1(5)
          2016-04-07T15:09:32.155-0500|Info: === 2016-04-07 15:09:32,155 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource 4 of type 'Object' in the pooling flow
          2016-04-07T15:09:32.155-0500|Info: === 2016-04-07 15:09:32,155 [1(5)] DEBUG PoolableDataSourceFactory - Activated DataSource 4 of type 'Object'
          2016-04-07T15:09:32.155-0500|Info: === 2016-04-07 15:09:32,155 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'fmt:bundle'
          2016-04-07T15:09:32.156-0500|Info: === 2016-04-07 15:09:32,156 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'fmt:bundle' but null was returned
          2016-04-07T15:09:32.156-0500|Info: === 2016-04-07 15:09:32,156 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'fmt:bundle' in the pooling flow
          2016-04-07T15:09:32.157-0500|Info: === 2016-04-07 15:09:32,157 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'DataSourceField'
          2016-04-07T15:09:32.162-0500|Info: === 2016-04-07 15:09:32,162 [1(5)] DEBUG XML - Parsed XML from D:\Dropbox\Apps\Glassfish4\glassfish\domains\BMSim\eclipseApps\BMSim\bmsim\sc\system\schema\DataSourceField.ds.xml: 4ms
          2016-04-07T15:09:32.163-0500|Info: === 2016-04-07 15:09:32,163 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'Object'
          2016-04-07T15:09:32.163-0500|Info: === 2016-04-07 15:09:32,163 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource 5 of type 'Object' and assigned it to thread http-listener-1(5)
          2016-04-07T15:09:32.164-0500|Info: === 2016-04-07 15:09:32,164 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource 5 of type 'Object' in the pooling flow
          2016-04-07T15:09:32.164-0500|Info: === 2016-04-07 15:09:32,164 [1(5)] DEBUG PoolableDataSourceFactory - Activated DataSource 5 of type 'Object'
          2016-04-07T15:09:32.164-0500|Info: === 2016-04-07 15:09:32,164 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'fields'
          2016-04-07T15:09:32.165-0500|Info: === 2016-04-07 15:09:32,165 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'fields' but null was returned
          2016-04-07T15:09:32.165-0500|Info: === 2016-04-07 15:09:32,165 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'fields' in the pooling flow
          2016-04-07T15:09:32.166-0500|Info: === 2016-04-07 15:09:32,166 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'name'
          2016-04-07T15:09:32.166-0500|Info: === 2016-04-07 15:09:32,166 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'name' but null was returned
          2016-04-07T15:09:32.166-0500|Info: === 2016-04-07 15:09:32,166 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'name' in the pooling flow
          2016-04-07T15:09:32.167-0500|Info: === 2016-04-07 15:09:32,167 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'type'
          2016-04-07T15:09:32.168-0500|Info: === 2016-04-07 15:09:32,167 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'type' but null was returned
          2016-04-07T15:09:32.169-0500|Info: === 2016-04-07 15:09:32,169 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'type' in the pooling flow
          2016-04-07T15:09:32.170-0500|Info: === 2016-04-07 15:09:32,170 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'disabled'
          2016-04-07T15:09:32.170-0500|Info: === 2016-04-07 15:09:32,170 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'disabled' but null was returned
          2016-04-07T15:09:32.170-0500|Info: === 2016-04-07 15:09:32,170 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'disabled' in the pooling flow
          2016-04-07T15:09:32.171-0500|Info: === 2016-04-07 15:09:32,171 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'idAllowed'
          2016-04-07T15:09:32.171-0500|Info: === 2016-04-07 15:09:32,171 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'idAllowed' but null was returned
          2016-04-07T15:09:32.171-0500|Info: === 2016-04-07 15:09:32,171 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'idAllowed' in the pooling flow
          2016-04-07T15:09:32.172-0500|Info: === 2016-04-07 15:09:32,172 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'required'
          2016-04-07T15:09:32.173-0500|Info: === 2016-04-07 15:09:32,172 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'required' but null was returned
          2016-04-07T15:09:32.173-0500|Info: === 2016-04-07 15:09:32,173 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'required' in the pooling flow
          2016-04-07T15:09:32.173-0500|Info: === 2016-04-07 15:09:32,173 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'valueMap'
          2016-04-07T15:09:32.175-0500|Info: === 2016-04-07 15:09:32,175 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'valueMap' but null was returned
          2016-04-07T15:09:32.175-0500|Info: === 2016-04-07 15:09:32,175 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'valueMap' in the pooling flow
          2016-04-07T15:09:32.176-0500|Info: === 2016-04-07 15:09:32,176 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'validators'
          2016-04-07T15:09:32.176-0500|Info: === 2016-04-07 15:09:32,176 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'validators' but null was returned
          2016-04-07T15:09:32.176-0500|Info: === 2016-04-07 15:09:32,176 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'validators' in the pooling flow
          2016-04-07T15:09:32.177-0500|Info: === 2016-04-07 15:09:32,177 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'length'
          2016-04-07T15:09:32.178-0500|Info: === 2016-04-07 15:09:32,177 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'length' but null was returned
          2016-04-07T15:09:32.178-0500|Info: === 2016-04-07 15:09:32,178 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'length' in the pooling flow
          2016-04-07T15:09:32.180-0500|Info: === 2016-04-07 15:09:32,180 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'decimalPad'
          2016-04-07T15:09:32.181-0500|Info: === 2016-04-07 15:09:32,181 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'decimalPad' but null was returned
          2016-04-07T15:09:32.181-0500|Info: === 2016-04-07 15:09:32,181 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'decimalPad' in the pooling flow
          2016-04-07T15:09:32.182-0500|Info: === 2016-04-07 15:09:32,182 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'decimalPrecision'
          2016-04-07T15:09:32.183-0500|Info: === 2016-04-07 15:09:32,183 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'decimalPrecision' but null was returned
          2016-04-07T15:09:32.183-0500|Info: === 2016-04-07 15:09:32,183 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'decimalPrecision' in the pooling flow
          2016-04-07T15:09:32.184-0500|Info: === 2016-04-07 15:09:32,184 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'xmlRequired'
          2016-04-07T15:09:32.184-0500|Info: === 2016-04-07 15:09:32,184 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'xmlRequired' but null was returned
          2016-04-07T15:09:32.184-0500|Info: === 2016-04-07 15:09:32,184 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'xmlRequired' in the pooling flow
          2016-04-07T15:09:32.185-0500|Info: === 2016-04-07 15:09:32,185 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'xmlMaxOccurs'
          2016-04-07T15:09:32.185-0500|Info: === 2016-04-07 15:09:32,185 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'xmlMaxOccurs' but null was returned
          2016-04-07T15:09:32.185-0500|Info: === 2016-04-07 15:09:32,185 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'xmlMaxOccurs' in the pooling flow
          2016-04-07T15:09:32.186-0500|Info: === 2016-04-07 15:09:32,186 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'xmlMinOccurs'
          2016-04-07T15:09:32.187-0500|Info: === 2016-04-07 15:09:32,187 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'xmlMinOccurs' but null was returned
          2016-04-07T15:09:32.187-0500|Info: === 2016-04-07 15:09:32,187 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'xmlMinOccurs' in the pooling flow
          2016-04-07T15:09:32.187-0500|Info: === 2016-04-07 15:09:32,187 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'xmlNonEmpty'
          2016-04-07T15:09:32.187-0500|Info: === 2016-04-07 15:09:32,187 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'xmlNonEmpty' but null was returned
          2016-04-07T15:09:32.187-0500|Info: === 2016-04-07 15:09:32,187 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'xmlNonEmpty' in the pooling flow
          2016-04-07T15:09:32.188-0500|Info: === 2016-04-07 15:09:32,188 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'xsElementRef'
          2016-04-07T15:09:32.188-0500|Info: === 2016-04-07 15:09:32,188 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'xsElementRef' but null was returned
          2016-04-07T15:09:32.188-0500|Info: === 2016-04-07 15:09:32,188 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'xsElementRef' in the pooling flow
          2016-04-07T15:09:32.189-0500|Info: === 2016-04-07 15:09:32,189 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'canHide'
          2016-04-07T15:09:32.189-0500|Info: === 2016-04-07 15:09:32,189 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'canHide' but null was returned
          2016-04-07T15:09:32.189-0500|Info: === 2016-04-07 15:09:32,189 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'canHide' in the pooling flow
          2016-04-07T15:09:32.190-0500|Info: === 2016-04-07 15:09:32,190 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'xmlAttribute'
          2016-04-07T15:09:32.190-0500|Info: === 2016-04-07 15:09:32,190 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'xmlAttribute' but null was returned
          2016-04-07T15:09:32.190-0500|Info: === 2016-04-07 15:09:32,190 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'xmlAttribute' in the pooling flow
          2016-04-07T15:09:32.190-0500|Info: === 2016-04-07 15:09:32,190 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'mustQualify'
          2016-04-07T15:09:32.190-0500|Info: === 2016-04-07 15:09:32,190 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'mustQualify' but null was returned
          2016-04-07T15:09:32.190-0500|Info: === 2016-04-07 15:09:32,190 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'mustQualify' in the pooling flow
          2016-04-07T15:09:32.191-0500|Info: === 2016-04-07 15:09:32,191 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'xmlExplicitTypes'
          2016-04-07T15:09:32.191-0500|Info: === 2016-04-07 15:09:32,191 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'xmlExplicitTypes' but null was returned
          2016-04-07T15:09:32.191-0500|Info: === 2016-04-07 15:09:32,191 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'xmlExplicitTypes' in the pooling flow
          2016-04-07T15:09:32.191-0500|Info: === 2016-04-07 15:09:32,191 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'valueXPath'
          2016-04-07T15:09:32.192-0500|Info: === 2016-04-07 15:09:32,192 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'valueXPath' but null was returned
          2016-04-07T15:09:32.192-0500|Info: === 2016-04-07 15:09:32,192 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'valueXPath' in the pooling flow
          2016-04-07T15:09:32.192-0500|Info: === 2016-04-07 15:09:32,192 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'childrenProperty'
          2016-04-07T15:09:32.193-0500|Info: === 2016-04-07 15:09:32,193 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'childrenProperty' but null was returned
          2016-04-07T15:09:32.193-0500|Info: === 2016-04-07 15:09:32,193 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'childrenProperty' in the pooling flow
          2016-04-07T15:09:32.193-0500|Info: === 2016-04-07 15:09:32,193 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'title'
          2016-04-07T15:09:32.194-0500|Info: === 2016-04-07 15:09:32,194 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'title' but null was returned
          2016-04-07T15:09:32.194-0500|Info: === 2016-04-07 15:09:32,194 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'title' in the pooling flow
          2016-04-07T15:09:32.194-0500|Info: === 2016-04-07 15:09:32,194 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'prompt'
          2016-04-07T15:09:32.195-0500|Info: === 2016-04-07 15:09:32,195 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'prompt' but null was returned
          2016-04-07T15:09:32.195-0500|Info: === 2016-04-07 15:09:32,195 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'prompt' in the pooling flow
          2016-04-07T15:09:32.195-0500|Info: === 2016-04-07 15:09:32,195 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'detail'
          2016-04-07T15:09:32.196-0500|Info: === 2016-04-07 15:09:32,196 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'detail' but null was returned
          2016-04-07T15:09:32.196-0500|Info: === 2016-04-07 15:09:32,196 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'detail' in the pooling flow
          2016-04-07T15:09:32.196-0500|Info: === 2016-04-07 15:09:32,196 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'canEdit'
          2016-04-07T15:09:32.197-0500|Info: === 2016-04-07 15:09:32,197 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'canEdit' but null was returned
          2016-04-07T15:09:32.197-0500|Info: === 2016-04-07 15:09:32,197 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'canEdit' in the pooling flow
          2016-04-07T15:09:32.198-0500|Info: === 2016-04-07 15:09:32,198 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'canSave'
          2016-04-07T15:09:32.198-0500|Info: === 2016-04-07 15:09:32,198 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'canSave' but null was returned
          2016-04-07T15:09:32.199-0500|Info: === 2016-04-07 15:09:32,199 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'canSave' in the pooling flow
          2016-04-07T15:09:32.199-0500|Info: === 2016-04-07 15:09:32,199 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'canView'
          2016-04-07T15:09:32.200-0500|Info: === 2016-04-07 15:09:32,200 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'canView' but null was returned
          2016-04-07T15:09:32.201-0500|Info: === 2016-04-07 15:09:32,201 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'canView' in the pooling flow
          2016-04-07T15:09:32.201-0500|Info: === 2016-04-07 15:09:32,201 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'inapplicable'
          2016-04-07T15:09:32.202-0500|Info: === 2016-04-07 15:09:32,202 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'inapplicable' but null was returned
          2016-04-07T15:09:32.202-0500|Info: === 2016-04-07 15:09:32,202 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'inapplicable' in the pooling flow
          2016-04-07T15:09:32.202-0500|Info: === 2016-04-07 15:09:32,202 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'advanced'
          2016-04-07T15:09:32.202-0500|Info: === 2016-04-07 15:09:32,202 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'advanced' but null was returned
          2016-04-07T15:09:32.202-0500|Info: === 2016-04-07 15:09:32,202 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'advanced' in the pooling flow
          2016-04-07T15:09:32.203-0500|Info: === 2016-04-07 15:09:32,203 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'visibility'
          2016-04-07T15:09:32.203-0500|Info: === 2016-04-07 15:09:32,203 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'visibility' but null was returned
          2016-04-07T15:09:32.203-0500|Info: === 2016-04-07 15:09:32,203 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'visibility' in the pooling flow
          2016-04-07T15:09:32.203-0500|Info: === 2016-04-07 15:09:32,203 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'hidden'
          2016-04-07T15:09:32.204-0500|Info: === 2016-04-07 15:09:32,204 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'hidden' but null was returned
          2016-04-07T15:09:32.204-0500|Info: === 2016-04-07 15:09:32,204 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'hidden' in the pooling flow
          2016-04-07T15:09:32.204-0500|Info: === 2016-04-07 15:09:32,204 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'isRuleCriteria'
          2016-04-07T15:09:32.204-0500|Info: === 2016-04-07 15:09:32,204 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'isRuleCriteria' but null was returned
          2016-04-07T15:09:32.204-0500|Info: === 2016-04-07 15:09:32,204 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'isRuleCriteria' in the pooling flow
          2016-04-07T15:09:32.205-0500|Info: === 2016-04-07 15:09:32,205 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'primaryKey'
          2016-04-07T15:09:32.205-0500|Info: === 2016-04-07 15:09:32,205 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'primaryKey' but null was returned
          2016-04-07T15:09:32.205-0500|Info: === 2016-04-07 15:09:32,205 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'primaryKey' in the pooling flow
          2016-04-07T15:09:32.206-0500|Info: === 2016-04-07 15:09:32,206 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'foreignKey'
          2016-04-07T15:09:32.207-0500|Info: === 2016-04-07 15:09:32,207 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'foreignKey' but null was returned
          2016-04-07T15:09:32.207-0500|Info: === 2016-04-07 15:09:32,207 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'foreignKey' in the pooling flow
          2016-04-07T15:09:32.209-0500|Info: === 2016-04-07 15:09:32,209 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'joinType'
          2016-04-07T15:09:32.209-0500|Info: === 2016-04-07 15:09:32,209 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'joinType' but null was returned
          2016-04-07T15:09:32.209-0500|Info: === 2016-04-07 15:09:32,209 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'joinType' in the pooling flow
          2016-04-07T15:09:32.210-0500|Info: === 2016-04-07 15:09:32,210 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'rootValue'
          2016-04-07T15:09:32.211-0500|Info: === 2016-04-07 15:09:32,211 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'rootValue' but null was returned
          2016-04-07T15:09:32.211-0500|Info: === 2016-04-07 15:09:32,211 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'rootValue' in the pooling flow
          2016-04-07T15:09:32.211-0500|Info: === 2016-04-07 15:09:32,211 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'includeFrom'
          2016-04-07T15:09:32.212-0500|Info: === 2016-04-07 15:09:32,212 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'includeFrom' but null was returned
          2016-04-07T15:09:32.212-0500|Info: === 2016-04-07 15:09:32,212 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'includeFrom' in the pooling flow
          2016-04-07T15:09:32.212-0500|Info: === 2016-04-07 15:09:32,212 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'includeVia'
          2016-04-07T15:09:32.212-0500|Info: === 2016-04-07 15:09:32,212 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'includeVia' but null was returned
          2016-04-07T15:09:32.212-0500|Info: === 2016-04-07 15:09:32,212 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'includeVia' in the pooling flow
          2016-04-07T15:09:32.213-0500|Info: === 2016-04-07 15:09:32,213 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'relatedTableAlias'
          2016-04-07T15:09:32.214-0500|Info: === 2016-04-07 15:09:32,213 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'relatedTableAlias' but null was returned
          2016-04-07T15:09:32.214-0500|Info: === 2016-04-07 15:09:32,214 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'relatedTableAlias' in the pooling flow
          2016-04-07T15:09:32.215-0500|Info: === 2016-04-07 15:09:32,215 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'showFileInline'
          2016-04-07T15:09:32.215-0500|Info: === 2016-04-07 15:09:32,215 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'showFileInline' but null was returned
          2016-04-07T15:09:32.215-0500|Info: === 2016-04-07 15:09:32,215 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'showFileInline' in the pooling flow
          2016-04-07T15:09:32.216-0500|Info: === 2016-04-07 15:09:32,216 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'escapeHTML'
          2016-04-07T15:09:32.216-0500|Info: === 2016-04-07 15:09:32,216 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'escapeHTML' but null was returned
          2016-04-07T15:09:32.216-0500|Info: === 2016-04-07 15:09:32,216 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'escapeHTML' in the pooling flow
          2016-04-07T15:09:32.218-0500|Info: === 2016-04-07 15:09:32,218 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'imageWidth'
          2016-04-07T15:09:32.218-0500|Info: === 2016-04-07 15:09:32,218 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'imageWidth' but null was returned
          2016-04-07T15:09:32.218-0500|Info: === 2016-04-07 15:09:32,218 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'imageWidth' in the pooling flow
          2016-04-07T15:09:32.219-0500|Info: === 2016-04-07 15:09:32,219 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'imageHeight'
          2016-04-07T15:09:32.219-0500|Info: === 2016-04-07 15:09:32,219 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'imageHeight' but null was returned
          2016-04-07T15:09:32.219-0500|Info: === 2016-04-07 15:09:32,219 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'imageHeight' in the pooling flow
          2016-04-07T15:09:32.220-0500|Info: === 2016-04-07 15:09:32,220 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'nativeName'
          2016-04-07T15:09:32.221-0500|Info: === 2016-04-07 15:09:32,221 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'nativeName' but null was returned
          2016-04-07T15:09:32.221-0500|Info: === 2016-04-07 15:09:32,221 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'nativeName' in the pooling flow
          2016-04-07T15:09:32.222-0500|Info: === 2016-04-07 15:09:32,222 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'nativeFK'
          2016-04-07T15:09:32.222-0500|Info: === 2016-04-07 15:09:32,222 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'nativeFK' but null was returned
          2016-04-07T15:09:32.223-0500|Info: === 2016-04-07 15:09:32,222 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'nativeFK' in the pooling flow
          2016-04-07T15:09:32.223-0500|Info: === 2016-04-07 15:09:32,223 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'autoDeriveFKs'
          2016-04-07T15:09:32.224-0500|Info: === 2016-04-07 15:09:32,224 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'autoDeriveFKs' but null was returned
          2016-04-07T15:09:32.224-0500|Info: === 2016-04-07 15:09:32,224 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'autoDeriveFKs' in the pooling flow
          2016-04-07T15:09:32.225-0500|Info: === 2016-04-07 15:09:32,225 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'fieldName'
          2016-04-07T15:09:32.225-0500|Info: === 2016-04-07 15:09:32,225 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'fieldName' but null was returned
          2016-04-07T15:09:32.226-0500|Info: === 2016-04-07 15:09:32,226 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'fieldName' in the pooling flow
          2016-04-07T15:09:32.227-0500|Info: === 2016-04-07 15:09:32,227 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'multiple'
          2016-04-07T15:09:32.227-0500|Info: === 2016-04-07 15:09:32,227 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'multiple' but null was returned
          2016-04-07T15:09:32.227-0500|Info: === 2016-04-07 15:09:32,227 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'multiple' in the pooling flow
          2016-04-07T15:09:32.229-0500|Info: === 2016-04-07 15:09:32,229 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'validateEachItem'
          2016-04-07T15:09:32.229-0500|Info: === 2016-04-07 15:09:32,229 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'validateEachItem' but null was returned
          2016-04-07T15:09:32.229-0500|Info: === 2016-04-07 15:09:32,229 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'validateEachItem' in the pooling flow
          2016-04-07T15:09:32.230-0500|Info: === 2016-04-07 15:09:32,230 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'pickListFields'
          2016-04-07T15:09:32.233-0500|Info: === 2016-04-07 15:09:32,232 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'pickListFields' but null was returned
          2016-04-07T15:09:32.233-0500|Info: === 2016-04-07 15:09:32,233 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'pickListFields' in the pooling flow
          2016-04-07T15:09:32.234-0500|Info: === 2016-04-07 15:09:32,233 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'multipleStorage'
          2016-04-07T15:09:32.234-0500|Info: === 2016-04-07 15:09:32,234 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'multipleStorage' but null was returned
          2016-04-07T15:09:32.234-0500|Info: === 2016-04-07 15:09:32,234 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'multipleStorage' in the pooling flow
          2016-04-07T15:09:32.235-0500|Info: === 2016-04-07 15:09:32,235 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'canFilter'
          2016-04-07T15:09:32.236-0500|Info: === 2016-04-07 15:09:32,236 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'canFilter' but null was returned
          2016-04-07T15:09:32.236-0500|Info: === 2016-04-07 15:09:32,236 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'canFilter' in the pooling flow
          2016-04-07T15:09:32.236-0500|Info: === 2016-04-07 15:09:32,236 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'ignore'
          2016-04-07T15:09:32.237-0500|Info: === 2016-04-07 15:09:32,237 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'ignore' but null was returned
          2016-04-07T15:09:32.237-0500|Info: === 2016-04-07 15:09:32,237 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'ignore' in the pooling flow
          2016-04-07T15:09:32.237-0500|Info: === 2016-04-07 15:09:32,237 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'unknownType'
          2016-04-07T15:09:32.239-0500|Info: === 2016-04-07 15:09:32,239 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'unknownType' but null was returned
          2016-04-07T15:09:32.239-0500|Info: === 2016-04-07 15:09:32,239 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'unknownType' in the pooling flow
          2016-04-07T15:09:32.240-0500|Info: === 2016-04-07 15:09:32,240 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'canSortClientOnly'
          2016-04-07T15:09:32.240-0500|Info: === 2016-04-07 15:09:32,240 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'canSortClientOnly' but null was returned
          2016-04-07T15:09:32.241-0500|Info: === 2016-04-07 15:09:32,241 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'canSortClientOnly' in the pooling flow
          2016-04-07T15:09:32.242-0500|Info: === 2016-04-07 15:09:32,242 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'childTagName'
          2016-04-07T15:09:32.243-0500|Info: === 2016-04-07 15:09:32,243 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'childTagName' but null was returned
          2016-04-07T15:09:32.243-0500|Info: === 2016-04-07 15:09:32,243 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'childTagName' in the pooling flow
          2016-04-07T15:09:32.243-0500|Info: === 2016-04-07 15:09:32,243 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'basic'
          2016-04-07T15:09:32.244-0500|Info: === 2016-04-07 15:09:32,244 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'basic' but null was returned
          2016-04-07T15:09:32.244-0500|Info: === 2016-04-07 15:09:32,244 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'basic' in the pooling flow
          2016-04-07T15:09:32.244-0500|Info: === 2016-04-07 15:09:32,244 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'maxFileSize'
          2016-04-07T15:09:32.245-0500|Info: === 2016-04-07 15:09:32,245 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'maxFileSize' but null was returned
          2016-04-07T15:09:32.245-0500|Info: === 2016-04-07 15:09:32,245 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'maxFileSize' in the pooling flow
          2016-04-07T15:09:32.249-0500|Info: === 2016-04-07 15:09:32,247 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'frozen'
          2016-04-07T15:09:32.250-0500|Info: === 2016-04-07 15:09:32,250 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'frozen' but null was returned
          2016-04-07T15:09:32.250-0500|Info: === 2016-04-07 15:09:32,250 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'frozen' in the pooling flow
          2016-04-07T15:09:32.251-0500|Info: === 2016-04-07 15:09:32,251 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'canExport'
          2016-04-07T15:09:32.251-0500|Info: === 2016-04-07 15:09:32,251 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'canExport' but null was returned
          2016-04-07T15:09:32.252-0500|Info: === 2016-04-07 15:09:32,252 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'canExport' in the pooling flow
          2016-04-07T15:09:32.253-0500|Info: === 2016-04-07 15:09:32,253 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'exportTitle'
          2016-04-07T15:09:32.253-0500|Info: === 2016-04-07 15:09:32,253 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'exportTitle' but null was returned
          2016-04-07T15:09:32.253-0500|Info: === 2016-04-07 15:09:32,253 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'exportTitle' in the pooling flow
          2016-04-07T15:09:32.254-0500|Info: === 2016-04-07 15:09:32,254 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'sqlStorageStrategy'
          2016-04-07T15:09:32.255-0500|Info: === 2016-04-07 15:09:32,255 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'sqlStorageStrategy' but null was returned
          2016-04-07T15:09:32.255-0500|Info: === 2016-04-07 15:09:32,255 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'sqlStorageStrategy' in the pooling flow
          2016-04-07T15:09:32.255-0500|Info: === 2016-04-07 15:09:32,255 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'encodeInResponse'
          2016-04-07T15:09:32.257-0500|Info: === 2016-04-07 15:09:32,257 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'encodeInResponse' but null was returned
          2016-04-07T15:09:32.259-0500|Info: === 2016-04-07 15:09:32,259 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'encodeInResponse' in the pooling flow
          2016-04-07T15:09:32.260-0500|Info: === 2016-04-07 15:09:32,260 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'mimeType'
          2016-04-07T15:09:32.261-0500|Info: === 2016-04-07 15:09:32,261 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'mimeType' but null was returned
          2016-04-07T15:09:32.261-0500|Info: === 2016-04-07 15:09:32,261 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'mimeType' in the pooling flow
          2016-04-07T15:09:32.262-0500|Info: === 2016-04-07 15:09:32,262 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'ignoreTextMatchStyle'
          2016-04-07T15:09:32.263-0500|Info: === 2016-04-07 15:09:32,263 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'ignoreTextMatchStyle' but null was returned
          2016-04-07T15:09:32.263-0500|Info: === 2016-04-07 15:09:32,263 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'ignoreTextMatchStyle' in the pooling flow
          2016-04-07T15:09:32.263-0500|Info: === 2016-04-07 15:09:32,263 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'lenientXPath'
          2016-04-07T15:09:32.265-0500|Info: === 2016-04-07 15:09:32,265 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'lenientXPath' but null was returned
          2016-04-07T15:09:32.266-0500|Info: === 2016-04-07 15:09:32,266 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'lenientXPath' in the pooling flow
          2016-04-07T15:09:32.267-0500|Info: === 2016-04-07 15:09:32,267 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'summaryFunction'
          2016-04-07T15:09:32.269-0500|Info: === 2016-04-07 15:09:32,269 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'summaryFunction' but null was returned
          2016-04-07T15:09:32.269-0500|Info: === 2016-04-07 15:09:32,269 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'summaryFunction' in the pooling flow
          2016-04-07T15:09:32.270-0500|Info: === 2016-04-07 15:09:32,270 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'includeSummaryFunction'
          2016-04-07T15:09:32.270-0500|Info: === 2016-04-07 15:09:32,270 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'includeSummaryFunction' but null was returned
          2016-04-07T15:09:32.270-0500|Info: === 2016-04-07 15:09:32,270 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'includeSummaryFunction' in the pooling flow
          2016-04-07T15:09:32.272-0500|Info: === 2016-04-07 15:09:32,271 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'joinString'
          2016-04-07T15:09:32.273-0500|Info: === 2016-04-07 15:09:32,273 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'joinString' but null was returned
          2016-04-07T15:09:32.273-0500|Info: === 2016-04-07 15:09:32,273 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'joinString' in the pooling flow
          2016-04-07T15:09:32.273-0500|Info: === 2016-04-07 15:09:32,273 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'joinPrefix'
          2016-04-07T15:09:32.274-0500|Info: === 2016-04-07 15:09:32,273 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'joinPrefix' but null was returned
          2016-04-07T15:09:32.274-0500|Info: === 2016-04-07 15:09:32,274 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'joinPrefix' in the pooling flow
          2016-04-07T15:09:32.278-0500|Info: === 2016-04-07 15:09:32,278 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'joinSuffix'
          2016-04-07T15:09:32.278-0500|Info: === 2016-04-07 15:09:32,278 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'joinSuffix' but null was returned
          2016-04-07T15:09:32.278-0500|Info: === 2016-04-07 15:09:32,278 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'joinSuffix' in the pooling flow
          2016-04-07T15:09:32.280-0500|Info: === 2016-04-07 15:09:32,280 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'allowClientRequestedSummaries'
          2016-04-07T15:09:32.280-0500|Info: === 2016-04-07 15:09:32,280 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'allowClientRequestedSummaries' but null was returned
          2016-04-07T15:09:32.280-0500|Info: === 2016-04-07 15:09:32,280 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'allowClientRequestedSummaries' in the pooling flow
          2016-04-07T15:09:32.280-0500|Info: === 2016-04-07 15:09:32,280 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'defaultValue'
          2016-04-07T15:09:32.281-0500|Info: === 2016-04-07 15:09:32,281 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'defaultValue' but null was returned
          2016-04-07T15:09:32.281-0500|Info: === 2016-04-07 15:09:32,281 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'defaultValue' in the pooling flow
          2016-04-07T15:09:32.282-0500|Info: === 2016-04-07 15:09:32,282 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'group'
          2016-04-07T15:09:32.282-0500|Info: === 2016-04-07 15:09:32,282 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'group' but null was returned
          2016-04-07T15:09:32.282-0500|Info: === 2016-04-07 15:09:32,282 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'group' in the pooling flow
          2016-04-07T15:09:32.283-0500|Info: === 2016-04-07 15:09:32,283 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'ID'
          2016-04-07T15:09:32.283-0500|Info: === 2016-04-07 15:09:32,283 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'ID' but null was returned
          2016-04-07T15:09:32.283-0500|Info: === 2016-04-07 15:09:32,283 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'ID' in the pooling flow
          2016-04-07T15:09:32.284-0500|Info: === 2016-04-07 15:09:32,284 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'inheritsFrom'
          2016-04-07T15:09:32.284-0500|Info: === 2016-04-07 15:09:32,284 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'inheritsFrom' but null was returned
          2016-04-07T15:09:32.284-0500|Info: === 2016-04-07 15:09:32,284 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'inheritsFrom' in the pooling flow
          2016-04-07T15:09:32.284-0500|Info: === 2016-04-07 15:09:32,284 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'javaClass'
          2016-04-07T15:09:32.285-0500|Info: === 2016-04-07 15:09:32,285 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'javaClass' but null was returned
          2016-04-07T15:09:32.285-0500|Info: === 2016-04-07 15:09:32,285 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'javaClass' in the pooling flow
          2016-04-07T15:09:32.285-0500|Info: === 2016-04-07 15:09:32,285 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'javaCollectionClass'
          2016-04-07T15:09:32.285-0500|Info: === 2016-04-07 15:09:32,285 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'javaCollectionClass' but null was returned
          2016-04-07T15:09:32.285-0500|Info: === 2016-04-07 15:09:32,285 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'javaCollectionClass' in the pooling flow
          2016-04-07T15:09:32.286-0500|Info: === 2016-04-07 15:09:32,286 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'javaKeyClass'
          2016-04-07T15:09:32.286-0500|Info: === 2016-04-07 15:09:32,286 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'javaKeyClass' but null was returned
          2016-04-07T15:09:32.286-0500|Info: === 2016-04-07 15:09:32,286 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'javaKeyClass' in the pooling flow
          2016-04-07T15:09:32.286-0500|Info: === 2016-04-07 15:09:32,286 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'storeWithHash'
          2016-04-07T15:09:32.287-0500|Info: === 2016-04-07 15:09:32,287 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'storeWithHash' but null was returned
          2016-04-07T15:09:32.287-0500|Info: === 2016-04-07 15:09:32,287 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'storeWithHash' in the pooling flow
          2016-04-07T15:09:32.287-0500|Info: === 2016-04-07 15:09:32,287 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'sqlDateFormat'
          2016-04-07T15:09:32.288-0500|Info: === 2016-04-07 15:09:32,288 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'sqlDateFormat' but null was returned
          2016-04-07T15:09:32.288-0500|Info: === 2016-04-07 15:09:32,288 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'sqlDateFormat' in the pooling flow
          2016-04-07T15:09:32.288-0500|Info: === 2016-04-07 15:09:32,288 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'storeMilliseconds'
          2016-04-07T15:09:32.288-0500|Info: === 2016-04-07 15:09:32,288 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'storeMilliseconds' but null was returned
          2016-04-07T15:09:32.288-0500|Info: === 2016-04-07 15:09:32,288 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'storeMilliseconds' in the pooling flow
          2016-04-07T15:09:32.289-0500|Info: === 2016-04-07 15:09:32,289 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'initRequiresAuthentication'
          2016-04-07T15:09:32.289-0500|Info: === 2016-04-07 15:09:32,289 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'initRequiresAuthentication' but null was returned
          2016-04-07T15:09:32.289-0500|Info: === 2016-04-07 15:09:32,289 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'initRequiresAuthentication' in the pooling flow
          2016-04-07T15:09:32.290-0500|Info: === 2016-04-07 15:09:32,290 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'viewRequiresAuthentication'
          2016-04-07T15:09:32.290-0500|Info: === 2016-04-07 15:09:32,290 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'viewRequiresAuthentication' but null was returned
          2016-04-07T15:09:32.290-0500|Info: === 2016-04-07 15:09:32,290 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'viewRequiresAuthentication' in the pooling flow
          2016-04-07T15:09:32.291-0500|Info: === 2016-04-07 15:09:32,291 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'editRequiresAuthentication'
          2016-04-07T15:09:32.291-0500|Info: === 2016-04-07 15:09:32,291 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'editRequiresAuthentication' but null was returned
          2016-04-07T15:09:32.291-0500|Info: === 2016-04-07 15:09:32,291 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'editRequiresAuthentication' in the pooling flow
          2016-04-07T15:09:32.291-0500|Info: === 2016-04-07 15:09:32,291 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'updateRequiresAuthentication'
          2016-04-07T15:09:32.292-0500|Info: === 2016-04-07 15:09:32,292 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'updateRequiresAuthentication' but null was returned
          2016-04-07T15:09:32.292-0500|Info: === 2016-04-07 15:09:32,292 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'updateRequiresAuthentication' in the pooling flow
          2016-04-07T15:09:32.292-0500|Info: === 2016-04-07 15:09:32,292 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'initRequiresRole'
          2016-04-07T15:09:32.292-0500|Info: === 2016-04-07 15:09:32,292 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'initRequiresRole' but null was returned
          2016-04-07T15:09:32.292-0500|Info: === 2016-04-07 15:09:32,292 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'initRequiresRole' in the pooling flow
          2016-04-07T15:09:32.293-0500|Info: === 2016-04-07 15:09:32,293 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'viewRequiresRole'
          2016-04-07T15:09:32.293-0500|Info: === 2016-04-07 15:09:32,293 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'viewRequiresRole' but null was returned
          2016-04-07T15:09:32.293-0500|Info: === 2016-04-07 15:09:32,293 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'viewRequiresRole' in the pooling flow
          2016-04-07T15:09:32.293-0500|Info: === 2016-04-07 15:09:32,293 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'editRequiresRole'
          2016-04-07T15:09:32.293-0500|Info: === 2016-04-07 15:09:32,293 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'editRequiresRole' but null was returned
          2016-04-07T15:09:32.293-0500|Info: === 2016-04-07 15:09:32,293 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'editRequiresRole' in the pooling flow
          2016-04-07T15:09:32.294-0500|Info: === 2016-04-07 15:09:32,294 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'updateRequiresRole'
          2016-04-07T15:09:32.294-0500|Info: === 2016-04-07 15:09:32,294 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'updateRequiresRole' but null was returned
          2016-04-07T15:09:32.294-0500|Info: === 2016-04-07 15:09:32,294 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'updateRequiresRole' in the pooling flow
          2016-04-07T15:09:32.294-0500|Info: === 2016-04-07 15:09:32,294 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'initRequires'
          2016-04-07T15:09:32.294-0500|Info: === 2016-04-07 15:09:32,294 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'initRequires' but null was returned
          2016-04-07T15:09:32.294-0500|Info: === 2016-04-07 15:09:32,294 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'initRequires' in the pooling flow
          2016-04-07T15:09:32.295-0500|Info: === 2016-04-07 15:09:32,295 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'viewRequires'
          2016-04-07T15:09:32.295-0500|Info: === 2016-04-07 15:09:32,295 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'viewRequires' but null was returned
          2016-04-07T15:09:32.295-0500|Info: === 2016-04-07 15:09:32,295 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'viewRequires' in the pooling flow
          2016-04-07T15:09:32.295-0500|Info: === 2016-04-07 15:09:32,295 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'editRequires'
          2016-04-07T15:09:32.295-0500|Info: === 2016-04-07 15:09:32,295 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'editRequires' but null was returned
          2016-04-07T15:09:32.295-0500|Info: === 2016-04-07 15:09:32,295 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'editRequires' in the pooling flow
          2016-04-07T15:09:32.296-0500|Info: === 2016-04-07 15:09:32,296 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'updateRequires'
          2016-04-07T15:09:32.296-0500|Info: === 2016-04-07 15:09:32,296 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'updateRequires' but null was returned
          2016-04-07T15:09:32.296-0500|Info: === 2016-04-07 15:09:32,296 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'updateRequires' in the pooling flow
          2016-04-07T15:09:32.296-0500|Info: === 2016-04-07 15:09:32,296 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'customSelectExpression'
          2016-04-07T15:09:32.296-0500|Info: === 2016-04-07 15:09:32,296 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'customSelectExpression' but null was returned
          2016-04-07T15:09:32.296-0500|Info: === 2016-04-07 15:09:32,296 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'customSelectExpression' in the pooling flow
          2016-04-07T15:09:32.297-0500|Info: === 2016-04-07 15:09:32,297 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'customCriteriaExpression'
          2016-04-07T15:09:32.297-0500|Info: === 2016-04-07 15:09:32,297 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'customCriteriaExpression' but null was returned
          2016-04-07T15:09:32.297-0500|Info: === 2016-04-07 15:09:32,297 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'customCriteriaExpression' in the pooling flow
          2016-04-07T15:09:32.297-0500|Info: === 2016-04-07 15:09:32,297 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'customInsertExpression'
          2016-04-07T15:09:32.298-0500|Info: === 2016-04-07 15:09:32,298 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'customInsertExpression' but null was returned
          2016-04-07T15:09:32.298-0500|Info: === 2016-04-07 15:09:32,298 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'customInsertExpression' in the pooling flow
          2016-04-07T15:09:32.298-0500|Info: === 2016-04-07 15:09:32,298 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'customUpdateExpression'
          2016-04-07T15:09:32.298-0500|Info: === 2016-04-07 15:09:32,298 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'customUpdateExpression' but null was returned
          2016-04-07T15:09:32.298-0500|Info: === 2016-04-07 15:09:32,298 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'customUpdateExpression' in the pooling flow
          2016-04-07T15:09:32.298-0500|Info: === 2016-04-07 15:09:32,298 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'customSQL'
          2016-04-07T15:09:32.299-0500|Info: === 2016-04-07 15:09:32,299 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'customSQL' but null was returned
          2016-04-07T15:09:32.299-0500|Info: === 2016-04-07 15:09:32,299 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'customSQL' in the pooling flow
          2016-04-07T15:09:32.299-0500|Info: === 2016-04-07 15:09:32,299 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'autoQuoteCustomExpressions'
          2016-04-07T15:09:32.299-0500|Info: === 2016-04-07 15:09:32,299 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'autoQuoteCustomExpressions' but null was returned
          2016-04-07T15:09:32.299-0500|Info: === 2016-04-07 15:09:32,299 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'autoQuoteCustomExpressions' in the pooling flow
          2016-04-07T15:09:32.300-0500|Info: === 2016-04-07 15:09:32,300 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'creatorOverrides'
          2016-04-07T15:09:32.300-0500|Info: === 2016-04-07 15:09:32,300 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'creatorOverrides' but null was returned
          2016-04-07T15:09:32.300-0500|Info: === 2016-04-07 15:09:32,300 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'creatorOverrides' in the pooling flow
          2016-04-07T15:09:32.300-0500|Info: === 2016-04-07 15:09:32,300 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'valueWriteXPath'
          2016-04-07T15:09:32.300-0500|Info: === 2016-04-07 15:09:32,300 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'valueWriteXPath' but null was returned
          2016-04-07T15:09:32.300-0500|Info: === 2016-04-07 15:09:32,300 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'valueWriteXPath' in the pooling flow
          2016-04-07T15:09:32.301-0500|Info: === 2016-04-07 15:09:32,301 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'useJoin'
          2016-04-07T15:09:32.301-0500|Info: === 2016-04-07 15:09:32,301 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'useJoin' but null was returned
          2016-04-07T15:09:32.301-0500|Info: === 2016-04-07 15:09:32,301 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'useJoin' in the pooling flow
          2016-04-07T15:09:32.301-0500|Info: === 2016-04-07 15:09:32,301 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'tableName'
          2016-04-07T15:09:32.301-0500|Info: === 2016-04-07 15:09:32,301 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'tableName' but null was returned
          2016-04-07T15:09:32.302-0500|Info: === 2016-04-07 15:09:32,302 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'tableName' in the pooling flow
          2016-04-07T15:09:32.302-0500|Info: === 2016-04-07 15:09:32,302 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'multipleStorageSeparator'
          2016-04-07T15:09:32.302-0500|Info: === 2016-04-07 15:09:32,302 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'multipleStorageSeparator' but null was returned
          2016-04-07T15:09:32.302-0500|Info: === 2016-04-07 15:09:32,302 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'multipleStorageSeparator' in the pooling flow
          2016-04-07T15:09:32.303-0500|Info: === 2016-04-07 15:09:32,303 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'defineSQLColumnAsNotNull'
          2016-04-07T15:09:32.303-0500|Info: === 2016-04-07 15:09:32,303 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'defineSQLColumnAsNotNull' but null was returned
          2016-04-07T15:09:32.303-0500|Info: === 2016-04-07 15:09:32,303 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'defineSQLColumnAsNotNull' in the pooling flow
          2016-04-07T15:09:32.303-0500|Info: === 2016-04-07 15:09:32,303 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'valueMapEnum'
          2016-04-07T15:09:32.303-0500|Info: === 2016-04-07 15:09:32,303 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'valueMapEnum' but null was returned
          2016-04-07T15:09:32.303-0500|Info: === 2016-04-07 15:09:32,303 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'valueMapEnum' in the pooling flow
          2016-04-07T15:09:32.304-0500|Info: === 2016-04-07 15:09:32,304 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'sqlFalseValue'
          2016-04-07T15:09:32.304-0500|Info: === 2016-04-07 15:09:32,304 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'sqlFalseValue' but null was returned
          2016-04-07T15:09:32.304-0500|Info: === 2016-04-07 15:09:32,304 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'sqlFalseValue' in the pooling flow
          2016-04-07T15:09:32.304-0500|Info: === 2016-04-07 15:09:32,304 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'sqlTrueValue'
          2016-04-07T15:09:32.305-0500|Info: === 2016-04-07 15:09:32,305 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'sqlTrueValue' but null was returned
          2016-04-07T15:09:32.305-0500|Info: === 2016-04-07 15:09:32,305 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'sqlTrueValue' in the pooling flow
          2016-04-07T15:09:32.305-0500|Info: === 2016-04-07 15:09:32,305 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'sortByField'
          2016-04-07T15:09:32.305-0500|Info: === 2016-04-07 15:09:32,305 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'sortByField' but null was returned
          2016-04-07T15:09:32.305-0500|Info: === 2016-04-07 15:09:32,305 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'sortByField' in the pooling flow
          2016-04-07T15:09:32.305-0500|Info: === 2016-04-07 15:09:32,305 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'columnCode'
          2016-04-07T15:09:32.306-0500|Info: === 2016-04-07 15:09:32,306 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'columnCode' but null was returned
          2016-04-07T15:09:32.306-0500|Info: === 2016-04-07 15:09:32,306 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'columnCode' in the pooling flow
          2016-04-07T15:09:32.306-0500|Info: === 2016-04-07 15:09:32,306 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'stringInBrowser'
          2016-04-07T15:09:32.306-0500|Info: === 2016-04-07 15:09:32,306 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'stringInBrowser' but null was returned
          2016-04-07T15:09:32.306-0500|Info: === 2016-04-07 15:09:32,306 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'stringInBrowser' in the pooling flow
          2016-04-07T15:09:32.307-0500|Info: === 2016-04-07 15:09:32,307 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'nillable'
          2016-04-07T15:09:32.307-0500|Info: === 2016-04-07 15:09:32,307 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'nillable' but null was returned
          2016-04-07T15:09:32.307-0500|Info: === 2016-04-07 15:09:32,307 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'nillable' in the pooling flow
          2016-04-07T15:09:32.307-0500|Info: === 2016-04-07 15:09:32,307 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'validOperators'
          2016-04-07T15:09:32.308-0500|Info: === 2016-04-07 15:09:32,307 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'validOperators' but null was returned
          2016-04-07T15:09:32.308-0500|Info: === 2016-04-07 15:09:32,308 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'validOperators' in the pooling flow
          2016-04-07T15:09:32.308-0500|Info: === 2016-04-07 15:09:32,308 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'fieldTypeProperty'
          2016-04-07T15:09:32.308-0500|Info: === 2016-04-07 15:09:32,308 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'fieldTypeProperty' but null was returned
          2016-04-07T15:09:32.308-0500|Info: === 2016-04-07 15:09:32,308 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'fieldTypeProperty' in the pooling flow
          2016-04-07T15:09:32.308-0500|Info: === 2016-04-07 15:09:32,308 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'moveTo'
          2016-04-07T15:09:32.309-0500|Info: === 2016-04-07 15:09:32,309 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'moveTo' but null was returned
          2016-04-07T15:09:32.309-0500|Info: === 2016-04-07 15:09:32,309 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'moveTo' in the pooling flow
          2016-04-07T15:09:32.312-0500|Info: === 2016-04-07 15:09:32,312 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource 6 of type 'DataSourceField' and assigned it to thread http-listener-1(5)
          2016-04-07T15:09:32.312-0500|Info: === 2016-04-07 15:09:32,312 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource 6 of type 'DataSourceField' in the pooling flow
          2016-04-07T15:09:32.312-0500|Info: === 2016-04-07 15:09:32,312 [1(5)] DEBUG PoolableDataSourceFactory - Activated DataSource 6 of type 'DataSourceField'
          2016-04-07T15:09:32.312-0500|Info: === 2016-04-07 15:09:32,312 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'field'
          2016-04-07T15:09:32.313-0500|Info: === 2016-04-07 15:09:32,313 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'field' but null was returned
          2016-04-07T15:09:32.313-0500|Info: === 2016-04-07 15:09:32,313 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'field' in the pooling flow
          2016-04-07T15:09:32.314-0500|Info: === 2016-04-07 15:09:32,314 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'fmt:message'
          2016-04-07T15:09:32.314-0500|Info: === 2016-04-07 15:09:32,314 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'fmt:message' but null was returned
          2016-04-07T15:09:32.315-0500|Info: === 2016-04-07 15:09:32,314 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'fmt:message' in the pooling flow
          2016-04-07T15:09:32.421-0500|Info: === 2016-04-07 15:09:32,421 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'Validator'
          2016-04-07T15:09:32.424-0500|Info: === 2016-04-07 15:09:32,424 [1(5)] DEBUG XML - Parsed XML from D:\Dropbox\Apps\Glassfish4\glassfish\domains\BMSim\eclipseApps\BMSim\bmsim\sc\system\schema\Validator.ds.xml: 2ms
          2016-04-07T15:09:32.425-0500|Info: === 2016-04-07 15:09:32,425 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'Object'
          2016-04-07T15:09:32.425-0500|Info: === 2016-04-07 15:09:32,425 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource 7 of type 'Object' and assigned it to thread http-listener-1(5)
          2016-04-07T15:09:32.425-0500|Info: === 2016-04-07 15:09:32,425 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource 7 of type 'Object' in the pooling flow
          2016-04-07T15:09:32.425-0500|Info: === 2016-04-07 15:09:32,425 [1(5)] DEBUG PoolableDataSourceFactory - Activated DataSource 7 of type 'Object'
          2016-04-07T15:09:32.425-0500|Info: === 2016-04-07 15:09:32,425 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'fields'
          2016-04-07T15:09:32.425-0500|Info: === 2016-04-07 15:09:32,425 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'fields' but null was returned
          2016-04-07T15:09:32.425-0500|Info: === 2016-04-07 15:09:32,425 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'fields' in the pooling flow
          2016-04-07T15:09:32.426-0500|Info: === 2016-04-07 15:09:32,426 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'type'
          2016-04-07T15:09:32.426-0500|Info: === 2016-04-07 15:09:32,426 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'type' but null was returned
          2016-04-07T15:09:32.426-0500|Info: === 2016-04-07 15:09:32,426 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'type' in the pooling flow
          2016-04-07T15:09:32.426-0500|Info: === 2016-04-07 15:09:32,426 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'name'
          2016-04-07T15:09:32.426-0500|Info: === 2016-04-07 15:09:32,426 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'name' but null was returned
          2016-04-07T15:09:32.426-0500|Info: === 2016-04-07 15:09:32,426 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'name' in the pooling flow
          2016-04-07T15:09:32.427-0500|Info: === 2016-04-07 15:09:32,427 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'description'
          2016-04-07T15:09:32.427-0500|Info: === 2016-04-07 15:09:32,427 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'description' but null was returned
          2016-04-07T15:09:32.427-0500|Info: === 2016-04-07 15:09:32,427 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'description' in the pooling flow
          2016-04-07T15:09:32.427-0500|Info: === 2016-04-07 15:09:32,427 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'stopIfFalse'
          2016-04-07T15:09:32.427-0500|Info: === 2016-04-07 15:09:32,427 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'stopIfFalse' but null was returned
          2016-04-07T15:09:32.427-0500|Info: === 2016-04-07 15:09:32,427 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'stopIfFalse' in the pooling flow
          2016-04-07T15:09:32.428-0500|Info: === 2016-04-07 15:09:32,428 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'stopOnError'
          2016-04-07T15:09:32.428-0500|Info: === 2016-04-07 15:09:32,428 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'stopOnError' but null was returned
          2016-04-07T15:09:32.428-0500|Info: === 2016-04-07 15:09:32,428 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'stopOnError' in the pooling flow
          2016-04-07T15:09:32.428-0500|Info: === 2016-04-07 15:09:32,428 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'validateOnChange'
          2016-04-07T15:09:32.428-0500|Info: === 2016-04-07 15:09:32,428 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'validateOnChange' but null was returned
          2016-04-07T15:09:32.428-0500|Info: === 2016-04-07 15:09:32,428 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'validateOnChange' in the pooling flow
          2016-04-07T15:09:32.429-0500|Info: === 2016-04-07 15:09:32,429 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'clientOnly'
          2016-04-07T15:09:32.429-0500|Info: === 2016-04-07 15:09:32,429 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'clientOnly' but null was returned
          2016-04-07T15:09:32.429-0500|Info: === 2016-04-07 15:09:32,429 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'clientOnly' in the pooling flow
          2016-04-07T15:09:32.429-0500|Info: === 2016-04-07 15:09:32,429 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'errorMessage'
          2016-04-07T15:09:32.429-0500|Info: === 2016-04-07 15:09:32,429 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'errorMessage' but null was returned
          2016-04-07T15:09:32.429-0500|Info: === 2016-04-07 15:09:32,429 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'errorMessage' in the pooling flow
          2016-04-07T15:09:32.430-0500|Info: === 2016-04-07 15:09:32,430 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'max'
          2016-04-07T15:09:32.430-0500|Info: === 2016-04-07 15:09:32,430 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'max' but null was returned
          2016-04-07T15:09:32.430-0500|Info: === 2016-04-07 15:09:32,430 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'max' in the pooling flow
          2016-04-07T15:09:32.430-0500|Info: === 2016-04-07 15:09:32,430 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'min'
          2016-04-07T15:09:32.430-0500|Info: === 2016-04-07 15:09:32,430 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'min' but null was returned
          2016-04-07T15:09:32.430-0500|Info: === 2016-04-07 15:09:32,430 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'min' in the pooling flow
          2016-04-07T15:09:32.431-0500|Info: === 2016-04-07 15:09:32,431 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'exclusive'
          2016-04-07T15:09:32.431-0500|Info: === 2016-04-07 15:09:32,431 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'exclusive' but null was returned
          2016-04-07T15:09:32.431-0500|Info: === 2016-04-07 15:09:32,431 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'exclusive' in the pooling flow
          2016-04-07T15:09:32.431-0500|Info: === 2016-04-07 15:09:32,431 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'mask'
          2016-04-07T15:09:32.431-0500|Info: === 2016-04-07 15:09:32,431 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'mask' but null was returned
          2016-04-07T15:09:32.431-0500|Info: === 2016-04-07 15:09:32,431 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'mask' in the pooling flow
          2016-04-07T15:09:32.432-0500|Info: === 2016-04-07 15:09:32,432 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'transformTo'
          2016-04-07T15:09:32.432-0500|Info: === 2016-04-07 15:09:32,432 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'transformTo' but null was returned
          2016-04-07T15:09:32.432-0500|Info: === 2016-04-07 15:09:32,432 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'transformTo' in the pooling flow
          2016-04-07T15:09:32.432-0500|Info: === 2016-04-07 15:09:32,432 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'precision'
          2016-04-07T15:09:32.432-0500|Info: === 2016-04-07 15:09:32,432 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'precision' but null was returned
          2016-04-07T15:09:32.432-0500|Info: === 2016-04-07 15:09:32,432 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'precision' in the pooling flow
          2016-04-07T15:09:32.433-0500|Info: === 2016-04-07 15:09:32,433 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'otherField'
          2016-04-07T15:09:32.433-0500|Info: === 2016-04-07 15:09:32,433 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'otherField' but null was returned
          2016-04-07T15:09:32.433-0500|Info: === 2016-04-07 15:09:32,433 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'otherField' in the pooling flow
          2016-04-07T15:09:32.433-0500|Info: === 2016-04-07 15:09:32,433 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'list'
          2016-04-07T15:09:32.433-0500|Info: === 2016-04-07 15:09:32,433 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'list' but null was returned
          2016-04-07T15:09:32.433-0500|Info: === 2016-04-07 15:09:32,433 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'list' in the pooling flow
          2016-04-07T15:09:32.433-0500|Info: === 2016-04-07 15:09:32,433 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'valueMap'
          2016-04-07T15:09:32.434-0500|Info: === 2016-04-07 15:09:32,434 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'valueMap' but null was returned
          2016-04-07T15:09:32.434-0500|Info: === 2016-04-07 15:09:32,434 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'valueMap' in the pooling flow
          2016-04-07T15:09:32.434-0500|Info: === 2016-04-07 15:09:32,434 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'substring'
          2016-04-07T15:09:32.434-0500|Info: === 2016-04-07 15:09:32,434 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'substring' but null was returned
          2016-04-07T15:09:32.434-0500|Info: === 2016-04-07 15:09:32,434 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'substring' in the pooling flow
          2016-04-07T15:09:32.434-0500|Info: === 2016-04-07 15:09:32,434 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'operator'
          2016-04-07T15:09:32.434-0500|Info: === 2016-04-07 15:09:32,434 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'operator' but null was returned
          2016-04-07T15:09:32.434-0500|Info: === 2016-04-07 15:09:32,434 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'operator' in the pooling flow
          2016-04-07T15:09:32.435-0500|Info: === 2016-04-07 15:09:32,435 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'count'
          2016-04-07T15:09:32.435-0500|Info: === 2016-04-07 15:09:32,435 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'count' but null was returned
          2016-04-07T15:09:32.435-0500|Info: === 2016-04-07 15:09:32,435 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'count' in the pooling flow
          2016-04-07T15:09:32.435-0500|Info: === 2016-04-07 15:09:32,435 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'applyWhen'
          2016-04-07T15:09:32.435-0500|Info: === 2016-04-07 15:09:32,435 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'applyWhen' but null was returned
          2016-04-07T15:09:32.435-0500|Info: === 2016-04-07 15:09:32,435 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'applyWhen' in the pooling flow
          2016-04-07T15:09:32.436-0500|Info: === 2016-04-07 15:09:32,436 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'dependentFields'
          2016-04-07T15:09:32.436-0500|Info: === 2016-04-07 15:09:32,436 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'dependentFields' but null was returned
          2016-04-07T15:09:32.436-0500|Info: === 2016-04-07 15:09:32,436 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'dependentFields' in the pooling flow
          2016-04-07T15:09:32.436-0500|Info: === 2016-04-07 15:09:32,436 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'scriptImport'
          2016-04-07T15:09:32.436-0500|Info: === 2016-04-07 15:09:32,436 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'scriptImport' but null was returned
          2016-04-07T15:09:32.436-0500|Info: === 2016-04-07 15:09:32,436 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'scriptImport' in the pooling flow
          2016-04-07T15:09:32.437-0500|Info: === 2016-04-07 15:09:32,437 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'serverCondition'
          2016-04-07T15:09:32.437-0500|Info: === 2016-04-07 15:09:32,437 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'serverCondition' but null was returned
          2016-04-07T15:09:32.437-0500|Info: === 2016-04-07 15:09:32,437 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'serverCondition' in the pooling flow
          2016-04-07T15:09:32.437-0500|Info: === 2016-04-07 15:09:32,437 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'serverObject'
          2016-04-07T15:09:32.437-0500|Info: === 2016-04-07 15:09:32,437 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'serverObject' but null was returned
          2016-04-07T15:09:32.437-0500|Info: === 2016-04-07 15:09:32,437 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'serverObject' in the pooling flow
          2016-04-07T15:09:32.438-0500|Info: === 2016-04-07 15:09:32,438 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'fieldName'
          2016-04-07T15:09:32.438-0500|Info: === 2016-04-07 15:09:32,438 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'fieldName' but null was returned
          2016-04-07T15:09:32.438-0500|Info: === 2016-04-07 15:09:32,438 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'fieldName' in the pooling flow
          2016-04-07T15:09:32.438-0500|Info: === 2016-04-07 15:09:32,438 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'triggerEvent'
          2016-04-07T15:09:32.438-0500|Info: === 2016-04-07 15:09:32,438 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'triggerEvent' but null was returned
          2016-04-07T15:09:32.438-0500|Info: === 2016-04-07 15:09:32,438 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'triggerEvent' in the pooling flow
          2016-04-07T15:09:32.439-0500|Info: === 2016-04-07 15:09:32,439 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'message'
          2016-04-07T15:09:32.439-0500|Info: === 2016-04-07 15:09:32,439 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'message' but null was returned
          2016-04-07T15:09:32.439-0500|Info: === 2016-04-07 15:09:32,439 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'message' in the pooling flow
          2016-04-07T15:09:32.439-0500|Info: === 2016-04-07 15:09:32,439 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'severity'
          2016-04-07T15:09:32.440-0500|Info: === 2016-04-07 15:09:32,440 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'severity' but null was returned
          2016-04-07T15:09:32.440-0500|Info: === 2016-04-07 15:09:32,440 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'severity' in the pooling flow
          2016-04-07T15:09:32.440-0500|Info: === 2016-04-07 15:09:32,440 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'displayMode'
          2016-04-07T15:09:32.440-0500|Info: === 2016-04-07 15:09:32,440 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'displayMode' but null was returned
          2016-04-07T15:09:32.441-0500|Info: === 2016-04-07 15:09:32,441 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'displayMode' in the pooling flow
          2016-04-07T15:09:32.441-0500|Info: === 2016-04-07 15:09:32,441 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'duration'
          2016-04-07T15:09:32.441-0500|Info: === 2016-04-07 15:09:32,441 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'duration' but null was returned
          2016-04-07T15:09:32.441-0500|Info: === 2016-04-07 15:09:32,441 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'duration' in the pooling flow
          2016-04-07T15:09:32.442-0500|Info: === 2016-04-07 15:09:32,442 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'formula'
          2016-04-07T15:09:32.442-0500|Info: === 2016-04-07 15:09:32,442 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'formula' but null was returned
          2016-04-07T15:09:32.442-0500|Info: === 2016-04-07 15:09:32,442 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'formula' in the pooling flow
          2016-04-07T15:09:32.442-0500|Info: === 2016-04-07 15:09:32,442 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'formulaVars'
          2016-04-07T15:09:32.443-0500|Info: === 2016-04-07 15:09:32,443 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'formulaVars' but null was returned
          2016-04-07T15:09:32.443-0500|Info: === 2016-04-07 15:09:32,443 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'formulaVars' in the pooling flow
          2016-04-07T15:09:32.444-0500|Info: === 2016-04-07 15:09:32,444 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource 8 of type 'Validator' and assigned it to thread http-listener-1(5)
          2016-04-07T15:09:32.444-0500|Info: === 2016-04-07 15:09:32,444 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource 8 of type 'Validator' in the pooling flow
          2016-04-07T15:09:32.444-0500|Info: === 2016-04-07 15:09:32,444 [1(5)] DEBUG PoolableDataSourceFactory - Activated DataSource 8 of type 'Validator'
          2016-04-07T15:09:32.445-0500|Info: === 2016-04-07 15:09:32,445 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'validator'
          2016-04-07T15:09:32.445-0500|Info: === 2016-04-07 15:09:32,445 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'validator' but null was returned
          2016-04-07T15:09:32.445-0500|Info: === 2016-04-07 15:09:32,445 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'validator' in the pooling flow
          2016-04-07T15:09:32.458-0500|Info: === 2016-04-07 15:09:32,458 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'ValueMap'
          2016-04-07T15:09:32.461-0500|Info: === 2016-04-07 15:09:32,461 [1(5)] DEBUG XML - Parsed XML from D:\Dropbox\Apps\Glassfish4\glassfish\domains\BMSim\eclipseApps\BMSim\bmsim\sc\system\schema\ValueMap.ds.xml: 2ms
          2016-04-07T15:09:32.461-0500|Info: === 2016-04-07 15:09:32,461 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'Object'
          2016-04-07T15:09:32.462-0500|Info: === 2016-04-07 15:09:32,462 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource 9 of type 'Object' and assigned it to thread http-listener-1(5)
          2016-04-07T15:09:32.462-0500|Info: === 2016-04-07 15:09:32,462 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource 9 of type 'Object' in the pooling flow
          2016-04-07T15:09:32.462-0500|Info: === 2016-04-07 15:09:32,462 [1(5)] DEBUG PoolableDataSourceFactory - Activated DataSource 9 of type 'Object'
          2016-04-07T15:09:32.468-0500|Info: === 2016-04-07 15:09:32,468 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource 10 of type 'ValueMap' and assigned it to thread http-listener-1(5)
          2016-04-07T15:09:32.468-0500|Info: === 2016-04-07 15:09:32,468 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource 10 of type 'ValueMap' in the pooling flow
          2016-04-07T15:09:32.468-0500|Info: === 2016-04-07 15:09:32,468 [1(5)] DEBUG PoolableDataSourceFactory - Activated DataSource 10 of type 'ValueMap'
          2016-04-07T15:09:32.573-0500|Info: === 2016-04-07 15:09:32,573 [1(5)] DEBUG SQLDataSource - DataSource 11 acquired SQLDriver instance 61517850 during initialization
          2016-04-07T15:09:32.573-0500|Info: === 2016-04-07 15:09:32,573 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource 11 of type 'users' and assigned it to thread http-listener-1(5)
          2016-04-07T15:09:32.573-0500|Info: === 2016-04-07 15:09:32,573 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource 11 of type 'users' in the pooling flow
          2016-04-07T15:09:32.573-0500|Info: === 2016-04-07 15:09:32,573 [1(5)] DEBUG PoolableDataSourceFactory - Activated DataSource 11 of type 'users'
          2016-04-07T15:09:32.573-0500|Info: === 2016-04-07 15:09:32,573 [1(5)] DEBUG DataSourceLoader - For DataSource 'users', got instanceId 11
          2016-04-07T15:09:32.629-0500|Info: === 2016-04-07 15:09:32,629 [1(5)] DEBUG LocaleMessage - No Properties in cache for props file co.focuss.bmsim.shared.model.i18n.BMSimResources_en_US - returning null
          2016-04-07T15:09:32.630-0500|Info: === 2016-04-07 15:09:32,630 [1(5)] DEBUG LocaleMessage - Escaped ASCII properties: # login.jsp
          login_login = User Login
          login_userName = User
          login_password = Password
          login_submit = Login
          login_wrongLogin = Wrong user or password!
          login_logoutSuccessfull = Successful logout!
          # users.ds.xml
          users_userName = User
          users_password = Password
          users_passwordMinimumLenghtValidator = Password length must be 6 or more characters.
          users_passwordMaximumLenghtValidator = Password length must be 20 or less characters.
          users_language = Simulator Language
          users_languageEnglish = English
          users_languageSpanish = Spanish
          # families.ds.xml
          families_family = Family
          families_description = Description
          families_baMode = BA Mode
          families_baModeAuto = Auto
          families_baModeManual = Manual
          families_baModeInactive = Inactive
          families_replenishmentMode = Replenishment Mode
          families_replenishmentModeAutoAll = Auto All
          families_replenishmentModeAutoIntermediate = Auto Intermediate
          families_replenishmentModeAutoUrgencies = Auto Urgencies
          families_replenishmentModeManual = Manual
          families_replenishmentModeInactive = Inactive
          families_replenishmentRoundingMode = Replenishment Rounding Mode
          families_replenishmentRoundingModeMaximizeAvailability = Maximize Availability
          families_replenishmentRoundingModeMinimizeInventory = Minimize Inventory
          families_yellowZoneStart = Yellow Zone Start (%)
          families_yellowZoneStartInvalid = Value must be between 0% and 100% (including), and less than Red Zone Start.
          families_redZoneStart = Red Zone Start (%)
          families_redZoneStartInvalid = Value must be between 0% and 100% (including), and greater than Yellow Zone Start.
          families_timeBetweenBufferRecalculations = Time Between Buffer Recalculations
          families_timeBetweenBufferRecalculationsInvalid = Value must be a positive integer.
          families_bufferDecreaseThreshold = Buffer Decrease Threshold (%)
          families_bufferDecreaseThresholdInvalid = Value must be between 1% and 100%.
          families_bufferIncreaseThreshold = Buffer Increase Threshold (%)
          families_bufferIncreaseThresholdInvalid = Value must equal or greater than 1%.
          families_movingSumsForRecalculations = Moving Sums for Recalculations
          families_movingSumsForRecalculationsInvalid = Value must be an integer equal or greater than 7.
          families_initialReplenishmentCoefficient = Initial Replenishment Coefficient
          families_initialReplenishmentCoefficientInvalid = Value must be 1.50, 1.75 or 2.00.
          families_inactivityWindow = Inactivity Window
          families_inactivityWindowInvalid = Value must be a positive integer.
          families_timeBetweenOrders = Time Between Orders
          families_timeBetweenOrdersInvalid = Value must be a positive integer.
          families_bufferIncreaseTrigger = Buffer Increase Trigger (%)
          families_bufferIncreaseTriggerInvalid = Value must be greater than 0%.
          families_bufferDecreaseTrigger = Buffer Decrease Trigger (%)
          families_bufferDecreaseTriggerInvalid = Value must be greater than 0%.
          families_bufferIncreaseFactor = Buffer Increase Factor (%)
          families_bufferIncreaseFactorInvalid = Value must be equal or greater than 0%.
          families_bufferDecreaseFactor = Buffer Decrease Factor (%)
          families_bufferDecreaseFactorInvalid = Value must be equal or greater than 0%.
          families_consecutiveConsumptionsWindow = Consecutive Consumption Window
          families_consecutiveConsumptionsWindowInvalid = Value must be a positive integer.
          # buffer_bank.ds.xml
          bufferbank_sku = SKU
          bufferbank_location = Location
          bufferbank_family = Family
          bufferbank_originLocation = Origin Location
          bufferbank_units = Unit
          bufferbank_unitsUN = Unit
          bufferbank_unitsBX = Box
          bufferbank_unitsDZ = Dozen
          bufferbank_unitsTN = Ton
          bufferbank_unitsKG = Kilo
          bufferbank_unitsGR = Gram
          bufferbank_unitsMT = Meter
          bufferbank_unitsFT = Feet
          bufferbank_deliveryTime = Delivery Time
          bufferbank_deliveryTimeInvalid = Value must be a positive integer.
          bufferbank_bufferSize = Buffer Size
          bufferbank_bufferSizeInvalid = Value must be zero or positive decimal and equal or greater than Minimum Buffer Size.
          bufferbank_minimumBufferSize = Minimum Buffer Size
          bufferbank_minimumBufferSizeInvalid = Value must be zero or positive decimal and equal or less than Buffer Size.
          bufferbank_safetyStock = Safety Stock
          bufferbank_safetyStockInvalid = Value must be zero or positive decimal.
          bufferbank_minimumReplenishment = Minimum Replenishment
          bufferbank_minimumReplenishmentInvalidType = Value must be a positive decimal.
          bufferbank_minimumReplenishmentInvalidMultiplier = Value must be multiple of Packaging Unit.
          bufferbank_minimumReplenishmentInvalidConstraint = Value must be equal or less than Buffer Size plus Safety Stock (because Replenishment Rounding Mode is 'MI').
          bufferbank_packagingUnit = Packaging Unit
          bufferbank_packagingUnitInvalid = Value must be a positive decimal.
          bufferbank_packagingUnitInvalidMultiplier = Value must be divisor of Minimum Replenishment.
          bufferbank_unitPrice = Unit Price
          bufferbank_unitPriceInvalid = Value must be a positive decimal.
          bufferbank_tvc = TVC
          bufferbank_tvcInvalid = Value must be zero or positive decimal.
          bufferbank_consolidatedReplenishments = Consolidated Replenishments
          bufferbank_consolidatedReplenishmentsInvalid = Value must be zero or positive decimal.
          bufferbank_positiveAdjustments = Positive Adjustments
          bufferbank_positiveAdjustmentsInvalid = Value must be zero or positive decimal.
          bufferbank_consolidatedConsumptions = Consolidated Consumptions
          bufferbank_consolidatedConsumptionsInvalid = Value must be zero or positive decimal.
          bufferbank_negativeAdjustments = Negative Adjustments
          bufferbank_negativeAdjustmentsInvalid = Value must be zero or positive decimal.
          bufferbank_totalInventoryOnSite = Total Inventory On Site
          bufferbank_totalInventoryOnSiteInvalid = Value must be zero or positive decimal.
          bufferbank_totalInventoryOnTransit = Total Inventory On Transit
          bufferbank_totalInventoryOnTransitInvalid = Value must be zero or positive decimal.
          bufferbank_totalInventoryOnPurchasing = Total Inventory On Purchasing
          bufferbank_totalInventoryOnPurchasingInvalid = Value must be zero or positive decimal.
          bufferbank_totalInventoryOnProduction = Total Inventory On Production
          bufferbank_totalInventoryOnProductionInvalid = Value must be zero or positive decimal.
          bufferbank_movementsUpdateDate = Movements Update Date
          # bank_load.ds.xml
          bankload_loadFile = Load File
          bankload_fileSizeInvalid = File size must be 20MB or less.
          2016-04-07T15:09:32.631-0500|Info: === 2016-04-07 15:09:32,631 [1(5)] DEBUG LocaleMessage - Escaped ASCII properties: # login.jsp
          login_login = User Login
          login_userName = User
          login_password = Password
          login_submit = Login
          login_wrongLogin = Wrong user or password!
          login_logoutSuccessfull = Successful logout!
          # users.ds.xml
          users_userName = User
          users_password = Password
          users_passwordMinimumLenghtValidator = Password length must be 6 or more characters.
          users_passwordMaximumLenghtValidator = Password length must be 20 or less characters.
          users_language = Simulator Language
          users_languageEnglish = English
          users_languageSpanish = Spanish
          # families.ds.xml
          families_family = Family
          families_description = Description
          families_baMode = BA Mode
          families_baModeAuto = Auto
          families_baModeManual = Manual
          families_baModeInactive = Inactive
          families_replenishmentMode = Replenishment Mode
          families_replenishmentModeAutoAll = Auto All
          families_replenishmentModeAutoIntermediate = Auto Intermediate
          families_replenishmentModeAutoUrgencies = Auto Urgencies
          families_replenishmentModeManual = Manual
          families_replenishmentModeInactive = Inactive
          families_replenishmentRoundingMode = Replenishment Rounding Mode
          families_replenishmentRoundingModeMaximizeAvailability = Maximize Availability
          families_replenishmentRoundingModeMinimizeInventory = Minimize Inventory
          families_yellowZoneStart = Yellow Zone Start (%)
          families_yellowZoneStartInvalid = Value must be between 0% and 100% (including), and less than Red Zone Start.
          families_redZoneStart = Red Zone Start (%)
          families_redZoneStartInvalid = Value must be between 0% and 100% (including), and greater than Yellow Zone Start.
          families_timeBetweenBufferRecalculations = Time Between Buffer Recalculations
          families_timeBetweenBufferRecalculationsInvalid = Value must be a positive integer.
          families_bufferDecreaseThreshold = Buffer Decrease Threshold (%)
          families_bufferDecreaseThresholdInvalid = Value must be between 1% and 100%.
          families_bufferIncreaseThreshold = Buffer Increase Threshold (%)
          families_bufferIncreaseThresholdInvalid = Value must equal or greater than 1%.
          families_movingSumsForRecalculations = Moving Sums for Recalculations
          families_movingSumsForRecalculationsInvalid = Value must be an integer equal or greater than 7.
          families_initialReplenishmentCoefficient = Initial Replenishment Coefficient
          families_initialReplenishmentCoefficientInvalid = Value must be 1.50, 1.75 or 2.00.
          families_inactivityWindow = Inactivity Window
          families_inactivityWindowInvalid = Value must be a positive integer.
          families_timeBetweenOrders = Time Between Orders
          families_timeBetweenOrdersInvalid = Value must be a positive integer.
          families_bufferIncreaseTrigger = Buffer Increase Trigger (%)
          families_bufferIncreaseTriggerInvalid = Value must be greater than 0%.
          families_bufferDecreaseTrigger = Buffer Decrease Trigger (%)
          families_bufferDecreaseTriggerInvalid = Value must be greater than 0%.
          families_bufferIncreaseFactor = Buffer Increase Factor (%)
          families_bufferIncreaseFactorInvalid = Value must be equal or greater than 0%.
          families_bufferDecreaseFactor = Buffer Decrease Factor (%)
          families_bufferDecreaseFactorInvalid = Value must be equal or greater than 0%.
          families_consecutiveConsumptionsWindow = Consecutive Consumption Window
          families_consecutiveConsumptionsWindowInvalid = Value must be a positive integer.
          # buffer_bank.ds.xml
          bufferbank_sku = SKU
          bufferbank_location = Location
          bufferbank_family = Family
          bufferbank_originLocation = Origin Location
          bufferbank_units = Unit
          bufferbank_unitsUN = Unit
          bufferbank_unitsBX = Box
          bufferbank_unitsDZ = Dozen
          bufferbank_unitsTN = Ton
          bufferbank_unitsKG = Kilo
          bufferbank_unitsGR = Gram
          bufferbank_unitsMT = Meter
          bufferbank_unitsFT = Feet
          bufferbank_deliveryTime = Delivery Time
          bufferbank_deliveryTimeInvalid = Value must be a positive integer.
          bufferbank_bufferSize = Buffer Size
          bufferbank_bufferSizeInvalid = Value must be zero or positive decimal and equal or greater than Minimum Buffer Size.
          bufferbank_minimumBufferSize = Minimum Buffer Size
          bufferbank_minimumBufferSizeInvalid = Value must be zero or positive decimal and equal or less than Buffer Size.
          bufferbank_safetyStock = Safety Stock
          bufferbank_safetyStockInvalid = Value must be zero or positive decimal.
          bufferbank_minimumReplenishment = Minimum Replenishment
          bufferbank_minimumReplenishmentInvalidType = Value must be a positive decimal.
          bufferbank_minimumReplenishmentInvalidMultiplier = Value must be multiple of Packaging Unit.
          bufferbank_minimumReplenishmentInvalidConstraint = Value must be equal or less than Buffer Size plus Safety Stock (because Replenishment Rounding Mode is 'MI').
          bufferbank_packagingUnit = Packaging Unit
          bufferbank_packagingUnitInvalid = Value must be a positive decimal.
          bufferbank_packagingUnitInvalidMultiplier = Value must be divisor of Minimum Replenishment.
          bufferbank_unitPrice = Unit Price
          bufferbank_unitPriceInvalid = Value must be a positive decimal.
          bufferbank_tvc = TVC
          bufferbank_tvcInvalid = Value must be zero or positive decimal.
          bufferbank_consolidatedReplenishments = Consolidated Replenishments
          bufferbank_consolidatedReplenishmentsInvalid = Value must be zero or positive decimal.
          bufferbank_positiveAdjustments = Positive Adjustments
          bufferbank_positiveAdjustmentsInvalid = Value must be zero or positive decimal.
          bufferbank_consolidatedConsumptions = Consolidated Consumptions
          bufferbank_consolidatedConsumptionsInvalid = Value must be zero or positive decimal.
          bufferbank_negativeAdjustments = Negative Adjustments
          bufferbank_negativeAdjustmentsInvalid = Value must be zero or positive decimal.
          bufferbank_totalInventoryOnSite = Total Inventory On Site
          bufferbank_totalInventoryOnSiteInvalid = Value must be zero or positive decimal.
          bufferbank_totalInventoryOnTransit = Total Inventory On Transit
          bufferbank_totalInventoryOnTransitInvalid = Value must be zero or positive decimal.
          bufferbank_totalInventoryOnPurchasing = Total Inventory On Purchasing
          bufferbank_totalInventoryOnPurchasingInvalid = Value must be zero or positive decimal.
          bufferbank_totalInventoryOnProduction = Total Inventory On Production
          bufferbank_totalInventoryOnProductionInvalid = Value must be zero or positive decimal.
          bufferbank_movementsUpdateDate = Movements Update Date
          # bank_load.ds.xml
          bankload_loadFile = Load File
          bankload_fileSizeInvalid = File size must be 20MB or less.
          2016-04-07T15:09:32.632-0500|Info: === 2016-04-07 15:09:32,632 [1(5)] DEBUG LocaleMessage - Unable to locate file co/focuss/bmsim/shared/model/i18n/BMSimResources_en_US.properties while doing manual UTF-8 parsing
          2016-04-07T15:09:32.632-0500|Info: === 2016-04-07 15:09:32,632 [1(5)] DEBUG LocaleMessage - Caching ResourceBundle for props file co.focuss.bmsim.shared.model.i18n.BMSimResources_en_US
          2016-04-07T15:09:32.632-0500|Info: === 2016-04-07 15:09:32,632 [1(5)] DEBUG LocaleMessage - Returning Properties from cache for props file co.focuss.bmsim.shared.model.i18n.BMSimResources_en_US
          2016-04-07T15:09:32.633-0500|Info: === 2016-04-07 15:09:32,633 [1(5)] DEBUG LocaleMessage - Returning Properties from cache for props file co.focuss.bmsim.shared.model.i18n.BMSimResources_en_US
          2016-04-07T15:09:32.633-0500|Info: === 2016-04-07 15:09:32,633 [1(5)] DEBUG LocaleMessage - Returning Properties from cache for props file co.focuss.bmsim.shared.model.i18n.BMSimResources_en_US
          2016-04-07T15:09:32.633-0500|Info: === 2016-04-07 15:09:32,633 [1(5)] DEBUG LocaleMessage - Returning Properties from cache for props file co.focuss.bmsim.shared.model.i18n.BMSimResources_en_US
          2016-04-07T15:09:32.633-0500|Info: === 2016-04-07 15:09:32,633 [1(5)] DEBUG LocaleMessage - Returning Properties from cache for props file co.focuss.bmsim.shared.model.i18n.BMSimResources_en_US
          2016-04-07T15:09:32.633-0500|Info: === 2016-04-07 15:09:32,633 [1(5)] DEBUG LocaleMessage - Returning Properties from cache for props file co.focuss.bmsim.shared.model.i18n.BMSimResources_en_US
          2016-04-07T15:09:32.633-0500|Info: === 2016-04-07 15:09:32,633 [1(5)] DEBUG SQLDataSource - About to clear SQLDriver state for DS instance 11
          2016-04-07T15:09:32.634-0500|Info: === 2016-04-07 15:09:32,634 [1(5)] DEBUG SQLDataSource - About to clear SQLDriver state for DS instance 11
          2016-04-07T15:09:32.634-0500|Info: === 2016-04-07 15:09:32,634 [1(5)] DEBUG PoolableDataSourceFactory - Cleared and passivated DataSource 11 of type 'users'
          2016-04-07T15:09:32.634-0500|Info: === 2016-04-07 15:09:32,634 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'families'
          2016-04-07T15:09:32.637-0500|Info: === 2016-04-07 15:09:32,637 [1(5)] DEBUG XML - Parsed XML from D:\Dropbox\Apps\Glassfish4\glassfish\domains\BMSim\eclipseApps\BMSim\resources\ds\families.ds.xml: 3ms
          2016-04-07T15:09:32.637-0500|Info: === 2016-04-07 15:09:32,637 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'DataSource'
          2016-04-07T15:09:32.640-0500|Info: === 2016-04-07 15:09:32,640 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource 12 of type 'DataSource' and assigned it to thread http-listener-1(5)
          2016-04-07T15:09:32.640-0500|Info: === 2016-04-07 15:09:32,640 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource 12 of type 'DataSource' in the pooling flow
          2016-04-07T15:09:32.640-0500|Info: === 2016-04-07 15:09:32,640 [1(5)] DEBUG PoolableDataSourceFactory - Activated DataSource 12 of type 'DataSource'
          2016-04-07T15:09:32.641-0500|Info: === 2016-04-07 15:09:32,641 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'Object'
          2016-04-07T15:09:32.641-0500|Info: === 2016-04-07 15:09:32,641 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource 13 of type 'Object' and assigned it to thread http-listener-1(5)
          2016-04-07T15:09:32.641-0500|Info: === 2016-04-07 15:09:32,641 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource 13 of type 'Object' in the pooling flow
          2016-04-07T15:09:32.641-0500|Info: === 2016-04-07 15:09:32,641 [1(5)] DEBUG PoolableDataSourceFactory - Activated DataSource 13 of type 'Object'
          2016-04-07T15:09:32.641-0500|Info: === 2016-04-07 15:09:32,641 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'fmt:bundle'
          2016-04-07T15:09:32.641-0500|Info: === 2016-04-07 15:09:32,641 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'fmt:bundle' but null was returned
          2016-04-07T15:09:32.641-0500|Info: === 2016-04-07 15:09:32,641 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'fmt:bundle' in the pooling flow
          2016-04-07T15:09:32.642-0500|Info: === 2016-04-07 15:09:32,642 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'DataSourceField'
          2016-04-07T15:09:32.644-0500|Info: === 2016-04-07 15:09:32,644 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource 14 of type 'DataSourceField' and assigned it to thread http-listener-1(5)
          2016-04-07T15:09:32.644-0500|Info: === 2016-04-07 15:09:32,644 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource 14 of type 'DataSourceField' in the pooling flow
          2016-04-07T15:09:32.644-0500|Info: === 2016-04-07 15:09:32,644 [1(5)] DEBUG PoolableDataSourceFactory - Activated DataSource 14 of type 'DataSourceField'
          2016-04-07T15:09:32.645-0500|Info: === 2016-04-07 15:09:32,645 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'field'
          2016-04-07T15:09:32.645-0500|Info: === 2016-04-07 15:09:32,645 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'field' but null was returned
          2016-04-07T15:09:32.645-0500|Info: === 2016-04-07 15:09:32,645 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'field' in the pooling flow
          2016-04-07T15:09:32.645-0500|Info: === 2016-04-07 15:09:32,645 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'fmt:message'
          2016-04-07T15:09:32.646-0500|Info: === 2016-04-07 15:09:32,646 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'fmt:message' but null was returned
          2016-04-07T15:09:32.646-0500|Info: === 2016-04-07 15:09:32,646 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'fmt:message' in the pooling flow
          2016-04-07T15:09:32.651-0500|Info: === 2016-04-07 15:09:32,651 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'ValueMap'
          2016-04-07T15:09:32.652-0500|Info: === 2016-04-07 15:09:32,652 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource 15 of type 'ValueMap' and assigned it to thread http-listener-1(5)
          2016-04-07T15:09:32.652-0500|Info: === 2016-04-07 15:09:32,652 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource 15 of type 'ValueMap' in the pooling flow
          2016-04-07T15:09:32.652-0500|Info: === 2016-04-07 15:09:32,652 [1(5)] DEBUG PoolableDataSourceFactory - Activated DataSource 15 of type 'ValueMap'
          2016-04-07T15:09:32.658-0500|Info: === 2016-04-07 15:09:32,658 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'Validator'
          2016-04-07T15:09:32.660-0500|Info: === 2016-04-07 15:09:32,660 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource 16 of type 'Validator' and assigned it to thread http-listener-1(5)
          2016-04-07T15:09:32.660-0500|Info: === 2016-04-07 15:09:32,660 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource 16 of type 'Validator' in the pooling flow
          2016-04-07T15:09:32.660-0500|Info: === 2016-04-07 15:09:32,660 [1(5)] DEBUG PoolableDataSourceFactory - Activated DataSource 16 of type 'Validator'
          2016-04-07T15:09:32.660-0500|Info: === 2016-04-07 15:09:32,660 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'validator'
          2016-04-07T15:09:32.660-0500|Info: === 2016-04-07 15:09:32,660 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'validator' but null was returned
          2016-04-07T15:09:32.660-0500|Info: === 2016-04-07 15:09:32,660 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'validator' in the pooling flow
          2016-04-07T15:09:32.663-0500|Info: === 2016-04-07 15:09:32,663 [1(5)] DEBUG ISCKeyedObjectPool - Borrowing object for 'serverCondition'
          2016-04-07T15:09:32.663-0500|Info: === 2016-04-07 15:09:32,663 [1(5)] DEBUG PoolableDataSourceFactory - Tried to create DataSource of type 'serverCondition' but null was returned
          2016-04-07T15:09:32.663-0500|Info: === 2016-04-07 15:09:32,663 [1(5)] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'serverCondition' in the pooling flow
          2016-04-07T15:09:32.740-0500|Info: === 2016-04-07 15:09:32,740 [1(5)] INFO SQLDataSource - Deriving dataSource families from table: families
          2016-04-07T15:09:33.124-0500|Info: === 2016-04-07 15:09:33,124 [1(5)] INFO PoolManager - SmartClient pooling disabled for 'SQLServer' objects
          2016-04-07T15:09:33.124-0500|Info: === 2016-04-07 15:09:33,124 [1(5)] DEBUG PoolableSQLConnectionFactory - Initializing SQL config for 'SQLServer' via JNDI
          2016-04-07T15:09:33.154-0500|Info: === 2016-04-07 15:09:33,134 [1(5)] ERROR SQLConnectionManager - Caught exception
          java.lang.NullPointerException
          at com.isomorphic.sql.PoolableSQLConnectionFactory.makeUnpooledObject(PoolableSQLConnectionFactory.java:309)
          at com.isomorphic.sql.PoolableSQLConnectionFactory.makeObject(PoolableSQLConnectionFactory.java:397)
          at com.isomorphic.pool.PoolManager.borrowObject(PoolManager.java:99)
          at com.isomorphic.pool.PoolManager.borrowObject(PoolManager.java:76)
          at com.isomorphic.sql.SQLConnectionManager.getConnection(SQLConnectionManager.java:176)
          at com.isomorphic.sql.SQLDSGenerator.generate(SQLDSGenerator.java:169)
          at com.isomorphic.sql.SQLDataSource.getConfigFromTable(SQLDataSource.java:4122)
          at com.isomorphic.sql.SQLDataSource.fromTable(SQLDataSource.java:4066)
          at com.isomorphic.sql.SQLDataSource.fromTable(SQLDataSource.java:4047)
          at com.isomorphic.sql.SQLDataSource.init(SQLDataSource.java:240)
          at com.isomorphic.datasource.DataSource.initialize(DataSource.java:936)
          at com.isomorphic.datasource.BasicDataSource.fromConfig(BasicDataSource.java:209)
          at com.isomorphic.datasource.DataSource.fromConfig(DataSource.java:921)
          at com.isomorphic.datasource.DataSource.loadDS(DataSource.java:540)
          at com.isomorphic.datasource.DataSource.forName(DataSource.java:468)
          at com.isomorphic.datasource.PoolableDataSourceFactory.makeUnpooledObject(PoolableDataSourceFactory.java:130)
          at com.isomorphic.datasource.PoolableDataSourceFactory.makeObject(PoolableDataSourceFactory.java:146)
          at org.apache.commons.pool.impl.GenericKeyedObjectPool.borrowObject(GenericKeyedObjectPool.java:1179)
          at com.isomorphic.pool.ISCKeyedObjectPool.borrowObject(ISCKeyedObjectPool.java:106)
          at com.isomorphic.pool.PoolManager.borrowObject(PoolManager.java:90)
          at com.isomorphic.datasource.DataSourceManager.getDataSource(DataSourceManager.java:157)
          at com.isomorphic.datasource.DataSourceManager.getDataSource(DataSourceManager.java:107)
          at com.isomorphic.servlet.DataSourceLoader.processRequest(DataSourceLoader.java:186)
          at com.isomorphic.servlet.DataSourceLoader.doGet(DataSourceLoader.java:107)
          at javax.servlet.http.HttpServlet.service(HttpServlet.java:687)
          at com.isomorphic.servlet.BaseServlet.service(BaseServlet.java:162)
          at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
          at org.apache.catalina.core.StandardWrapper.service(StandardWrapper.java:1682)
          at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:344)
          at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:214)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:316)
          at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.invoke(FilterSecurityInterceptor.java:126)
          at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.doFilter(FilterSecurityInterceptor.java:90)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.access.ExceptionTranslationFilter.doFilter(ExceptionTranslationFilter.java:114)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.session.SessionManagementFilter.doFilter(SessionManagementFilter.java:122)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.authentication.AnonymousAuthenticationFilter.doFilter(AnonymousAuthenticationFilter.java:111)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter.doFilter(SecurityContextHolderAwareRequestFilter.java:169)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.savedrequest.RequestCacheAwareFilter.doFilter(RequestCacheAwareFilter.java:48)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.authentication.http://www.BasicAuthenticationFilter...ilter.java:158)
          at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:107)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.authentication.AbstractAuthenticationProcessingFilter.doFilter(AbstractAuthenticationProcessingFilter.java:205)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.authentication.logout.LogoutFilter.doFilter(LogoutFilter.java:120)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.header.HeaderWriterFilter.doFilterInternal(HeaderWriterFilter.java:64)
          at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:107)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.context.request.async.WebAsyncManagerIntegrationFilter.doFilterInternal(WebAsyncManagerIntegrationFilter.java:53)
          at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:107)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.context.SecurityContextPersistenceFilter.doFilter(SecurityContextPersistenceFilter.java:91)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.FilterChainProxy.doFilterInternal(FilterChainProxy.java:213)
          at org.springframework.security.web.FilterChainProxy.doFilter(FilterChainProxy.java:176)
          at org.springframework.web.filter.DelegatingFilterProxy.invokeDelegate(DelegatingFilterProxy.java:346)
          at org.springframework.web.filter.DelegatingFilterProxy.doFilter(DelegatingFilterProxy.java:262)
          at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:256)
          at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:214)
          at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:316)
          at org.apache.catalina.core.StandardContextValve.__invoke(StandardContextValve.java:160)
          at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java)
          at org.apache.catalina.core.StandardPipeline.doInvoke(StandardPipeline.java:734)
          at org.apache.catalina.core.StandardPipeline.invoke(StandardPipeline.java:673)
          at com.sun.enterprise.web.WebPipeline.invoke(WebPipeline.java:99)
          at org.apache.catalina.core.StandardHostValve.__invoke(StandardHostValve.java:174)
          at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java)
          at org.apache.catalina.connector.CoyoteAdapter.doService(CoyoteAdapter.java:415)
          at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:282)
          at com.sun.enterprise.v3.services.impl.ContainerMapper$HttpHandlerCallable.call(ContainerMapper.java:459)
          at com.sun.enterprise.v3.services.impl.ContainerMapper.service(ContainerMapper.java:167)
          at org.glassfish.grizzly.http.server.HttpHandler.runService(HttpHandler.java:201)
          at org.glassfish.grizzly.http.server.HttpHandler.doHandle(HttpHandler.java:175)
          at org.glassfish.grizzly.http.server.HttpServerFilter.handleRead(HttpServerFilter.java:235)
          at org.glassfish.grizzly.filterchain.ExecutorResolver$9.execute(ExecutorResolver.java:119)
          at org.glassfish.grizzly.filterchain.DefaultFilterChain.executeFilter(DefaultFilterChain.java:284)
          at org.glassfish.grizzly.filterchain.DefaultFilterChain.executeChainPart(DefaultFilterChain.java:201)
          at org.glassfish.grizzly.filter
          2016-04-07T15:09:33.154-0500|Info: chain.DefaultFilterChain.execute(DefaultFilterChain.java:133)
          at org.glassfish.grizzly.filterchain.DefaultFilterChain.process(DefaultFilterChain.java:112)
          at org.glassfish.grizzly.ProcessorExecutor.execute(ProcessorExecutor.java:77)
          at org.glassfish.grizzly.nio.transport.TCPNIOTransport.fireIOEvent(TCPNIOTransport.java:561)
          at org.glassfish.grizzly.strategies.AbstractIOStrategy.fireIOEvent(AbstractIOStrategy.java:112)
          at org.glassfish.grizzly.strategies.WorkerThreadIOStrategy.run0(WorkerThreadIOStrategy.java:117)
          at org.glassfish.grizzly.strategies.WorkerThreadIOStrategy.access$100(WorkerThreadIOStrategy.java:56)
          at org.glassfish.grizzly.strategies.WorkerThreadIOStrategy$WorkerThreadRunnable.run(WorkerThreadIOStrategy.java:137)
          at org.glassfish.grizzly.threadpool.AbstractThreadPool$Worker.doWork(AbstractThreadPool.java:565)
          at org.glassfish.grizzly.threadpool.AbstractThreadPool$Worker.run(AbstractThreadPool.java:545)
          at java.lang.Thread.run(Thread.java:745)
          2016-04-07T15:09:33.213-0500|Info: === 2016-04-07 15:09:33,211 [1(5)] ERROR DataSourceLoader - Exception while attempting to load a DataSource
          java.sql.SQLException: java.lang.NullPointerException
          at com.isomorphic.sql.SQLConnectionManager.getConnection(SQLConnectionManager.java:194)
          at com.isomorphic.sql.SQLDSGenerator.generate(SQLDSGenerator.java:169)
          at com.isomorphic.sql.SQLDataSource.getConfigFromTable(SQLDataSource.java:4122)
          at com.isomorphic.sql.SQLDataSource.fromTable(SQLDataSource.java:4066)
          at com.isomorphic.sql.SQLDataSource.fromTable(SQLDataSource.java:4047)
          at com.isomorphic.sql.SQLDataSource.init(SQLDataSource.java:240)
          at com.isomorphic.datasource.DataSource.initialize(DataSource.java:936)
          at com.isomorphic.datasource.BasicDataSource.fromConfig(BasicDataSource.java:209)
          at com.isomorphic.datasource.DataSource.fromConfig(DataSource.java:921)
          at com.isomorphic.datasource.DataSource.loadDS(DataSource.java:540)
          at com.isomorphic.datasource.DataSource.forName(DataSource.java:468)
          at com.isomorphic.datasource.PoolableDataSourceFactory.makeUnpooledObject(PoolableDataSourceFactory.java:130)
          at com.isomorphic.datasource.PoolableDataSourceFactory.makeObject(PoolableDataSourceFactory.java:146)
          at org.apache.commons.pool.impl.GenericKeyedObjectPool.borrowObject(GenericKeyedObjectPool.java:1179)
          at com.isomorphic.pool.ISCKeyedObjectPool.borrowObject(ISCKeyedObjectPool.java:106)
          at com.isomorphic.pool.PoolManager.borrowObject(PoolManager.java:90)
          at com.isomorphic.datasource.DataSourceManager.getDataSource(DataSourceManager.java:157)
          at com.isomorphic.datasource.DataSourceManager.getDataSource(DataSourceManager.java:107)
          at com.isomorphic.servlet.DataSourceLoader.processRequest(DataSourceLoader.java:186)
          at com.isomorphic.servlet.DataSourceLoader.doGet(DataSourceLoader.java:107)
          at javax.servlet.http.HttpServlet.service(HttpServlet.java:687)
          at com.isomorphic.servlet.BaseServlet.service(BaseServlet.java:162)
          at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
          at org.apache.catalina.core.StandardWrapper.service(StandardWrapper.java:1682)
          at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:344)
          at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:214)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:316)
          at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.invoke(FilterSecurityInterceptor.java:126)
          at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.doFilter(FilterSecurityInterceptor.java:90)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.access.ExceptionTranslationFilter.doFilter(ExceptionTranslationFilter.java:114)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.session.SessionManagementFilter.doFilter(SessionManagementFilter.java:122)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.authentication.AnonymousAuthenticationFilter.doFilter(AnonymousAuthenticationFilter.java:111)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter.doFilter(SecurityContextHolderAwareRequestFilter.java:169)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.savedrequest.RequestCacheAwareFilter.doFilter(RequestCacheAwareFilter.java:48)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.authentication.http://www.BasicAuthenticationFilter...ilter.java:158)
          at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:107)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.authentication.AbstractAuthenticationProcessingFilter.doFilter(AbstractAuthenticationProcessingFilter.java:205)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.authentication.logout.LogoutFilter.doFilter(LogoutFilter.java:120)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.header.HeaderWriterFilter.doFilterInternal(HeaderWriterFilter.java:64)
          at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:107)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.context.request.async.WebAsyncManagerIntegrationFilter.doFilterInternal(WebAsyncManagerIntegrationFilter.java:53)
          at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:107)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.context.SecurityContextPersistenceFilter.doFilter(SecurityContextPersistenceFilter.java:91)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.FilterChainProxy.doFilterInternal(FilterChainProxy.java:213)
          at org.springframework.security.web.FilterChainProxy.doFilter(FilterChainProxy.java:176)
          at org.springframework.web.filter.DelegatingFilterProxy.invokeDelegate(DelegatingFilterProxy.java:346)
          at org.springframework.web.filter.DelegatingFilterProxy.doFilter(DelegatingFilterProxy.java:262)
          at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:256)
          at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:214)
          at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:316)
          at org.apache.catalina.core.StandardContextValve.__invoke(StandardContextValve.java:160)
          at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java)
          at org.apache.catalina.core.StandardPipeline.doInvoke(StandardPipeline.java:734)
          at org.apache.catalina.core.StandardPipeline.invoke(StandardPipeline.java:673)
          at com.sun.enterprise.web.WebPipeline.invoke(WebPipeline.java:99)
          at org.apache.catalina.core.StandardHostValve.__invoke(StandardHostValve.java:174)
          at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java)
          at org.apache.catalina.connector.CoyoteAdapter.doService(CoyoteAdapter.java:415)
          at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:282)
          at com.sun.enterprise.v3.services.impl.ContainerMapper$HttpHandlerCallable.call(ContainerMapper.java:459)
          at com.sun.enterprise.v3.services.impl.ContainerMapper.service(ContainerMapper.java:167)
          at org.glassfish.grizzly.http.server.HttpHandler.runService(HttpHandler.java:201)
          at org.glassfish.grizzly.http.server.HttpHandler.doHandle(HttpHandler.java:175)
          at org.glassfish.grizzly.http.server.HttpServerFilter.handleRead(HttpServerFilter.java:235)
          at org.glassfish.grizzly.filterchain.ExecutorResolver$9.execute(ExecutorResolver.java:119)
          at org.glassfish.grizzly.filterchain.DefaultFilterChain.executeFilter(DefaultFilterChain.java:284)
          at org.glassfish.grizzly.filterchain.DefaultFilterChain.executeChainPart(DefaultFilterChain.java:201)
          at org.glassfish.grizzly.filterchain.DefaultFilterChain.execute(DefaultFilterChain.java:133)
          at org.glassfish.grizzly.filterchain.DefaultFilterChain.process(DefaultFilterChain.java:112)
          at org.glassfish.grizzly.ProcessorExecutor.execute(ProcessorExecutor.java:77)
          at org.glassfish.grizzly.nio.transport.TCPNIOTransport.fireIOEvent(
          2016-04-07T15:09:33.213-0500|Info: TCPNIOTransport.java:561)
          at org.glassfish.grizzly.strategies.AbstractIOStrategy.fireIOEvent(AbstractIOStrategy.java:112)
          at org.glassfish.grizzly.strategies.WorkerThreadIOStrategy.run0(WorkerThreadIOStrategy.java:117)
          at org.glassfish.grizzly.strategies.WorkerThreadIOStrategy.access$100(WorkerThreadIOStrategy.java:56)
          at org.glassfish.grizzly.strategies.WorkerThreadIOStrategy$WorkerThreadRunnable.run(WorkerThreadIOStrategy.java:137)
          at org.glassfish.grizzly.threadpool.AbstractThreadPool$Worker.doWork(AbstractThreadPool.java:565)
          at org.glassfish.grizzly.threadpool.AbstractThreadPool$Worker.run(AbstractThreadPool.java:545)
          at java.lang.Thread.run(Thread.java:745)
          2016-04-07T15:09:33.215-0500|Info: === 2016-04-07 15:09:33,214 [1(5)] ERROR DataSourceLoader - BaseServlet Global Exception
          javax.servlet.ServletException: DataSource 'families' failed to load due to an exception on the server:
          java.lang.NullPointerException
          See the server-side log for additional details.
          at com.isomorphic.servlet.DataSourceLoader.processRequest(DataSourceLoader.java:289)
          at com.isomorphic.servlet.DataSourceLoader.doGet(DataSourceLoader.java:107)
          at javax.servlet.http.HttpServlet.service(HttpServlet.java:687)
          at com.isomorphic.servlet.BaseServlet.service(BaseServlet.java:162)
          at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
          at org.apache.catalina.core.StandardWrapper.service(StandardWrapper.java:1682)
          at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:344)
          at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:214)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:316)
          at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.invoke(FilterSecurityInterceptor.java:126)
          at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.doFilter(FilterSecurityInterceptor.java:90)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.access.ExceptionTranslationFilter.doFilter(ExceptionTranslationFilter.java:114)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.session.SessionManagementFilter.doFilter(SessionManagementFilter.java:122)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.authentication.AnonymousAuthenticationFilter.doFilter(AnonymousAuthenticationFilter.java:111)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter.doFilter(SecurityContextHolderAwareRequestFilter.java:169)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.savedrequest.RequestCacheAwareFilter.doFilter(RequestCacheAwareFilter.java:48)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.authentication.http://www.BasicAuthenticationFilter...ilter.java:158)
          at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:107)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.authentication.AbstractAuthenticationProcessingFilter.doFilter(AbstractAuthenticationProcessingFilter.java:205)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.authentication.logout.LogoutFilter.doFilter(LogoutFilter.java:120)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.header.HeaderWriterFilter.doFilterInternal(HeaderWriterFilter.java:64)
          at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:107)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.context.request.async.WebAsyncManagerIntegrationFilter.doFilterInternal(WebAsyncManagerIntegrationFilter.java:53)
          at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:107)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.context.SecurityContextPersistenceFilter.doFilter(SecurityContextPersistenceFilter.java:91)
          at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
          at org.springframework.security.web.FilterChainProxy.doFilterInternal(FilterChainProxy.java:213)
          at org.springframework.security.web.FilterChainProxy.doFilter(FilterChainProxy.java:176)
          at org.springframework.web.filter.DelegatingFilterProxy.invokeDelegate(DelegatingFilterProxy.java:346)
          at org.springframework.web.filter.DelegatingFilterProxy.doFilter(DelegatingFilterProxy.java:262)
          at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:256)
          at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:214)
          at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:316)
          at org.apache.catalina.core.StandardContextValve.__invoke(StandardContextValve.java:160)
          at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java)
          at org.apache.catalina.core.StandardPipeline.doInvoke(StandardPipeline.java:734)
          at org.apache.catalina.core.StandardPipeline.invoke(StandardPipeline.java:673)
          at com.sun.enterprise.web.WebPipeline.invoke(WebPipeline.java:99)
          at org.apache.catalina.core.StandardHostValve.__invoke(StandardHostValve.java:174)
          at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java)
          at org.apache.catalina.connector.CoyoteAdapter.doService(CoyoteAdapter.java:415)
          at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:282)
          at com.sun.enterprise.v3.services.impl.ContainerMapper$HttpHandlerCallable.call(ContainerMapper.java:459)
          at com.sun.enterprise.v3.services.impl.ContainerMapper.service(ContainerMapper.java:167)
          at org.glassfish.grizzly.http.server.HttpHandler.runService(HttpHandler.java:201)
          at org.glassfish.grizzly.http.server.HttpHandler.doHandle(HttpHandler.java:175)
          at org.glassfish.grizzly.http.server.HttpServerFilter.handleRead(HttpServerFilter.java:235)
          at org.glassfish.grizzly.filterchain.ExecutorResolver$9.execute(ExecutorResolver.java:119)
          at org.glassfish.grizzly.filterchain.DefaultFilterChain.executeFilter(DefaultFilterChain.java:284)
          at org.glassfish.grizzly.filterchain.DefaultFilterChain.executeChainPart(DefaultFilterChain.java:201)
          at org.glassfish.grizzly.filterchain.DefaultFilterChain.execute(DefaultFilterChain.java:133)
          at org.glassfish.grizzly.filterchain.DefaultFilterChain.process(DefaultFilterChain.java:112)
          at org.glassfish.grizzly.ProcessorExecutor.execute(ProcessorExecutor.java:77)
          at org.glassfish.grizzly.nio.transport.TCPNIOTransport.fireIOEvent(TCPNIOTransport.java:561)
          at org.glassfish.grizzly.strategies.AbstractIOStrategy.fireIOEvent(AbstractIOStrategy.java:112)
          at org.glassfish.grizzly.strategies.WorkerThreadIOStrategy.run0(WorkerThreadIOStrategy.java:117)
          at org.glassfish.grizzly.strategies.WorkerThreadIOStrategy.access$100(WorkerThreadIOStrategy.java:56)
          at org.glassfish.grizzly.strategies.WorkerThreadIOStrategy$WorkerThreadRunnable.run(WorkerThreadIOStrategy.java:137)
          at org.glassfish.grizzly.threadpool.AbstractThreadPool$Worker.doWork(AbstractThreadPool.java:565)
          at org.glassfish.grizzly.threadpool.AbstractThreadPool$Worker.run(AbstractThreadPool.java:545)
          at java.lang.Thread.run(Thread.java:745)
          2016-04-07T15:09:33.217-0500|Info: === 2016-04-07 15:09:33,217 [1(5)] DEBUG ConfigParser - Matched var name: debug
          2016-04-07T15:09:33.217-0500|Info: === 2016-04-07 15:09:33,217 [1(5)] DEBUG ConfigParser - value after substitution: true
          2016-04-07T15:10:20.946-0500|Info: === 2016-04-07 15:10:20,946 [1(1)] INFO RequestContext - URL: '/BMSim/bmsim/sc/skins/Enterprise/images/blank.gif', User-Agent: 'Mozilla/5.0 (Windows NT 10.0; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/49.0.2623.110 Safari/537.36': Safari with Accept-Encoding header
          2016-04-07T15:10:20.948-0500|Info: === 2016-04-07 15:10:20,948 [1(1)] INFO Download - done streaming: D:/Dropbox/Apps/Glassfish4/glassfish/domains/BMSim/eclipseApps/BMSim/bmsim/sc/skins/Enterprise/images/blank.gif
          2016-04-07T15:10:22.310-0500|Info: === 2016-04-07 15:10:22,310 [1(2)] INFO RequestContext - URL: '/BMSim/bmsim/sc/skins/Enterprise/images/RecordEditor/filter.png', User-Agent: 'Mozilla/5.0 (Windows NT 10.0; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/49.0.2623.110 Safari/537.36': Safari with Accept-Encoding header
          2016-04-07T15:10:22.312-0500|Info: === 2016-04-07 15:10:22,312 [1(2)] INFO Download - done streaming: D:/Dropbox/Apps/Glassfish4/glassfish/domains/BMSim/eclipseApps/BMSim/bmsim/sc/skins/Enterprise/images/RecordEditor/filter.png
          2016-04-07T15:10:22.320-0500|Info: === 2016-04-07 15:10:22,320 [1(3)] INFO RequestContext - URL: '/BMSim/bmsim/sc/skins/Enterprise/images/SectionHeader/opener_opened.png', User-Agent: 'Mozilla/5.0 (Windows NT 10.0; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/49.0.2623.110 Safari/537.36': Safari with Accept-Encoding header
          2016-04-07T15:10:22.322-0500|Info: === 2016-04-07 15:10:22,322 [1(3)] INFO Download - done streaming: D:/Dropbox/Apps/Glassfish4/glassfish/domains/BMSim/eclipseApps/BMSim/bmsim/sc/skins/Enterprise/images/SectionHeader/opener_opened.png
          2016-04-07T15:10:36.254-0500|Info: === 2016-04-07 15:10:36,254 [1(1)] INFO RequestContext - URL: '/BMSim/bmsim/sc/skins/Enterprise/images/SectionHeader/opener_opened.png', User-Agent: 'Mozilla/5.0 (Windows NT 10.0; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/49.0.2623.110 Safari/537.36': Safari with Accept-Encoding header
          2016-04-07T15:10:36.255-0500|Info: === 2016-04-07 15:10:36,255 [1(1)] INFO Download - done streaming: D:/Dropbox/Apps/Glassfish4/glassfish/domains/BMSim/eclipseApps/BMSim/bmsim/sc/skins/Enterprise/images/SectionHeader/opener_opened.png
          2016-04-07T15:10:38.084-0500|Info: === 2016-04-07 15:10:38,084 [1(4)] INFO RequestContext - URL: '/BMSim/bmsim/sc/skins/Enterprise/images/RecordEditor/filter.png', User-Agent: 'Mozilla/5.0 (Windows NT 10.0; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/49.0.2623.110 Safari/537.36': Safari with Accept-Encoding header
          2016-04-07T15:10:38.085-0500|Info: === 2016-04-07 15:10:38,085 [1(4)] INFO Download - done streaming: D:/Dropbox/Apps/Glassfish4/glassfish/domains/BMSim/eclipseApps/BMSim/bmsim/sc/skins/Enterprise/images/RecordEditor/filter.png
          2016-04-07T15:10:38.091-0500|Info: === 2016-04-07 15:10:38,091 [1(5)] INFO RequestContext - URL: '/BMSim/bmsim/sc/skins/Enterprise/images/blank.gif', User-Agent: 'Mozilla/5.0 (Windows NT 10.0; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/49.0.2623.110 Safari/537.36': Safari with Accept-Encoding header
          2016-04-07T15:10:38.092-0500|Info: === 2016-04-07 15:10:38,092 [1(5)] INFO Download - done streaming: D:/Dropbox/Apps/Glassfish4/glassfish/domains/BMSim/eclipseApps/BMSim/bmsim/sc/skins/Enterprise/images/blank.gif

          Comment

            #6
            Hi Isomorphic. I confirm that this is fixed in 6.0p 2016-04-12. Thanks!
            ps. In case someone sees this post, it wasn't related to Spring but to this bug in SmartGWT.

            Comment

            Previous template Next
            Working...
            X