Console Output
Skipping 1,153 KB..
Full LogxtLoader', parent = [null]]].
2018-05-14 09:27:30,602 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@50a4e4e, testMethod = testDeleteApplicationRoleInvalid@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:30,619 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#209429901 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:30,631 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#2085961313 for site site-2 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:30,642 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#2113807298 for site site-3 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:30,651 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1814266376 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:30,654 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@50a4e4e, testMethod = testDeleteApplicationRoleInvalid@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:30,656 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@77e03d01, testMethod = testDeleteApplicationSiteActive@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [true]
2018-05-14 09:27:30,673 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#400137743 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:30,684 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1709990711 for site site-2 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:30,695 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#552526972 for site site-3 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:30,706 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#2048642993 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:30,715 ERROR [main] org.appng.core.service.CoreService: Cannot delete application with ID 2: bugtracker
2018-05-14 09:27:30,717 INFO [main] org.springframework.test.context.transaction.TransactionContext: Rolled back transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@77e03d01, testMethod = testDeleteApplicationSiteActive@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:30,719 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@3330bdd1, testMethod = testDeleteSite@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:30,739 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1613154132 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:30,753 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#356951433 for site site-2 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:30,765 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#2056967249 for site site-3 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:30,778 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1550208425 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:30,782 INFO [main] org.appng.core.service.CoreService: starting deletion of site site-3
2018-05-14 09:27:30,793 INFO [main] org.appng.core.service.CoreService: unlinking application foobar from site site-3, status of database-connection is NO_DB_SUPPORTED
2018-05-14 09:27:30,793 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform Removed application foobar from site site-3
2018-05-14 09:27:30,804 INFO [main] org.appng.core.service.CoreService: deleting 0 orphaned database connections
2018-05-14 09:27:30,805 INFO [main] org.appng.core.service.CoreService: done deleting site site-3
2018-05-14 09:27:30,808 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.DatasourceConfigurer
2018-05-14 09:27:30,808 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.appendTabId
2018-05-14 09:27:30,808 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.assetsDir
2018-05-14 09:27:30,809 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.authApplication
2018-05-14 09:27:30,809 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.authLoginPage
2018-05-14 09:27:30,809 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.authLoginRef
2018-05-14 09:27:30,810 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.authLogoutActionName
2018-05-14 09:27:30,810 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.authLogoutActionValue
2018-05-14 09:27:30,810 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.authLogoutPage
2018-05-14 09:27:30,811 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.authLogoutRef
2018-05-14 09:27:30,811 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.csrfProtectedMethods
2018-05-14 09:27:30,811 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.csrfProtectedPaths
2018-05-14 09:27:30,812 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.csrfProtectionEnabled
2018-05-14 09:27:30,812 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.defaultApplication
2018-05-14 09:27:30,812 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.defaultPage
2018-05-14 09:27:30,813 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.defaultPageSize
2018-05-14 09:27:30,813 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.documentDir
2018-05-14 09:27:30,813 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.ehcacheBlockingTimeout
2018-05-14 09:27:30,814 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.ehcacheClearOnShutdown
2018-05-14 09:27:30,814 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.ehcacheEnabled
2018-05-14 09:27:30,814 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.ehcacheExceptions
2018-05-14 09:27:30,815 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.ehcacheStatistics
2018-05-14 09:27:30,815 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.encoding
2018-05-14 09:27:30,815 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.enforcePrimaryDomain
2018-05-14 09:27:30,816 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.errorPage
2018-05-14 09:27:30,816 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.errorPages
2018-05-14 09:27:30,816 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.host
2018-05-14 09:27:30,816 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.indexConfig
2018-05-14 09:27:30,817 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.indexDir
2018-05-14 09:27:30,817 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.indexFileSystemQueueSize
2018-05-14 09:27:30,817 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.indexFileTypes
2018-05-14 09:27:30,818 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.indexQueueSize
2018-05-14 09:27:30,818 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.indexTimeout
2018-05-14 09:27:30,818 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.ldapDomain
2018-05-14 09:27:30,819 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.ldapGroupBaseDn
2018-05-14 09:27:30,819 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.ldapHost
2018-05-14 09:27:30,819 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.ldapIdAttribute
2018-05-14 09:27:30,819 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.ldapPassword
2018-05-14 09:27:30,820 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.ldapPrincipalScheme
2018-05-14 09:27:30,820 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.ldapStartTls
2018-05-14 09:27:30,820 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.ldapUser
2018-05-14 09:27:30,821 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.ldapUserBaseDn
2018-05-14 09:27:30,821 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.locale
2018-05-14 09:27:30,821 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.mailDisabled
2018-05-14 09:27:30,822 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.mailHost
2018-05-14 09:27:30,822 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.mailPort
2018-05-14 09:27:30,822 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.manager-path
2018-05-14 09:27:30,823 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.name
2018-05-14 09:27:30,823 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.rewriteConfig
2018-05-14 09:27:30,823 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.searchChunkSize
2018-05-14 09:27:30,823 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.searchMaxHits
2018-05-14 09:27:30,824 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.service-path
2018-05-14 09:27:30,824 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.serviceOutputFormat
2018-05-14 09:27:30,824 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.serviceOutputType
2018-05-14 09:27:30,825 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.siteRootDir
2018-05-14 09:27:30,825 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.supportReloadFile
2018-05-14 09:27:30,825 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.supportedLanguages
2018-05-14 09:27:30,826 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.tagPrefix
2018-05-14 09:27:30,826 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.template
2018-05-14 09:27:30,826 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.timeZone
2018-05-14 09:27:30,826 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.wwwDir
2018-05-14 09:27:30,827 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-3.xssExceptions
2018-05-14 09:27:30,827 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Site site-3
2018-05-14 09:27:30,828 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@3330bdd1, testMethod = testDeleteSite@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:30,841 INFO [Time-limited test] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@5f9d87f9, testMethod = testDeleteSiteWithEnvironment@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:30,885 INFO [Time-limited test] org.appng.api.support.SiteClassLoader: SiteClassLoader#215122300 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:30,903 INFO [Time-limited test] org.appng.api.support.SiteClassLoader: SiteClassLoader#723790107 for site site-2 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:30,920 INFO [Time-limited test] org.appng.api.support.SiteClassLoader: SiteClassLoader#1833864267 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:30,943 INFO [pool-14-thread-1] org.appng.api.messaging.TestReceiver: received org.appng.core.controller.messaging.SiteStateEvent - Origin: test - Site: site-2 - State: STARTING
2018-05-14 09:27:30,991 INFO [pool-14-thread-1] org.appng.api.messaging.TestReceiver: received org.appng.core.controller.messaging.SiteStateEvent - Origin: test - Site: site-2 - State: STARTED
2018-05-14 09:27:30,997 INFO [pool-14-thread-1] org.appng.api.messaging.TestReceiver: received org.appng.core.controller.messaging.NodeEvent - Origin: test - Site: site-2
2018-05-14 09:27:30,997 INFO [pool-14-thread-1] org.appng.api.messaging.TestReceiver: received org.appng.core.controller.messaging.NodeEvent - Origin: test - Site: site-2
2018-05-14 09:27:31,044 INFO [Time-limited test] org.appng.core.service.CoreService: starting deletion of site site-2
2018-05-14 09:27:31,049 INFO [Time-limited test] org.appng.core.service.CoreService: unlinking application bugtracker from site site-2, status of database-connection is NO_DB_SUPPORTED
2018-05-14 09:27:31,050 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform Removed application bugtracker from site site-2
2018-05-14 09:27:31,059 INFO [pool-14-thread-1] org.appng.api.messaging.TestReceiver: received org.appng.core.controller.messaging.SiteStateEvent - Origin: test - Site: site-2 - State: STOPPING
2018-05-14 09:27:31,060 INFO [pool-14-thread-1] org.appng.api.messaging.TestReceiver: received org.appng.core.controller.messaging.NodeEvent - Origin: test - Site: site-2
2018-05-14 09:27:31,061 INFO [Time-limited test] org.appng.core.service.CoreService: destroying site site-2 [STOPPING] (#928550456)
2018-05-14 09:27:31,061 INFO [Time-limited test] org.appng.core.domain.SiteImpl: closing context for site site-2 [STOPPING] (#928550456)
2018-05-14 09:27:31,064 INFO [Time-limited test] org.appng.core.service.CoreService: destroying site site-2 [STOPPING] (#928550456) complete
2018-05-14 09:27:31,070 INFO [pool-14-thread-1] org.appng.api.messaging.TestReceiver: received org.appng.core.controller.messaging.SiteStateEvent - Origin: test - Site: site-2 - State: STOPPED
2018-05-14 09:27:31,071 INFO [pool-14-thread-1] org.appng.api.messaging.TestReceiver: received org.appng.core.controller.messaging.NodeEvent - Origin: test - Site: site-2
2018-05-14 09:27:31,072 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform Shut down site site-2
2018-05-14 09:27:31,074 INFO [Time-limited test] org.appng.core.service.CoreService: deleting 0 orphaned database connections
2018-05-14 09:27:31,077 INFO [Time-limited test] org.appng.core.model.CacheProvider: cleaning /var/lib/jenkins/workspace/appNG_Release/appng/appng-core/target/ROOT/WEB-INF/cache/platform/site-2
2018-05-14 09:27:31,078 INFO [Time-limited test] org.appng.core.model.CacheProvider: cleaning /var/lib/jenkins/workspace/appNG_Release/appng/appng-core/target/ROOT/WEB-INF/cache/application/site-2
2018-05-14 09:27:31,078 INFO [pool-14-thread-1] org.appng.api.messaging.TestReceiver: received org.appng.core.controller.messaging.SiteStateEvent - Origin: test - Site: site-2 - State: DELETED
2018-05-14 09:27:31,080 INFO [pool-14-thread-1] org.appng.api.messaging.TestReceiver: received org.appng.core.controller.messaging.NodeEvent - Origin: test - Site: site-2
2018-05-14 09:27:31,081 INFO [pool-14-thread-1] org.appng.api.messaging.TestReceiver: received org.appng.core.controller.messaging.SiteDeletedEvent - Origin: test - Site: site-2
2018-05-14 09:27:31,081 INFO [pool-14-thread-1] org.appng.core.controller.messaging.SiteDeletedEvent: site site-2 has been deleted, so it will be shut down.
2018-05-14 09:27:31,082 INFO [Time-limited test] org.appng.core.service.CoreService: done deleting site site-2
2018-05-14 09:27:31,086 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.DatasourceConfigurer
2018-05-14 09:27:31,086 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.appendTabId
2018-05-14 09:27:31,086 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.assetsDir
2018-05-14 09:27:31,087 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.authApplication
2018-05-14 09:27:31,087 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.authLoginPage
2018-05-14 09:27:31,087 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.authLoginRef
2018-05-14 09:27:31,088 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.authLogoutActionName
2018-05-14 09:27:31,088 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.authLogoutActionValue
2018-05-14 09:27:31,088 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.authLogoutPage
2018-05-14 09:27:31,089 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.authLogoutRef
2018-05-14 09:27:31,089 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.csrfProtectedMethods
2018-05-14 09:27:31,089 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.csrfProtectedPaths
2018-05-14 09:27:31,090 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.csrfProtectionEnabled
2018-05-14 09:27:31,090 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.defaultApplication
2018-05-14 09:27:31,090 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.defaultPage
2018-05-14 09:27:31,091 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.defaultPageSize
2018-05-14 09:27:31,091 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.documentDir
2018-05-14 09:27:31,091 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.ehcacheBlockingTimeout
2018-05-14 09:27:31,092 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.ehcacheClearOnShutdown
2018-05-14 09:27:31,092 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.ehcacheEnabled
2018-05-14 09:27:31,092 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.ehcacheExceptions
2018-05-14 09:27:31,093 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.ehcacheStatistics
2018-05-14 09:27:31,093 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.encoding
2018-05-14 09:27:31,093 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.enforcePrimaryDomain
2018-05-14 09:27:31,094 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.errorPage
2018-05-14 09:27:31,094 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.errorPages
2018-05-14 09:27:31,094 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.host
2018-05-14 09:27:31,095 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.indexConfig
2018-05-14 09:27:31,095 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.indexDir
2018-05-14 09:27:31,096 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.indexFileSystemQueueSize
2018-05-14 09:27:31,096 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.indexFileTypes
2018-05-14 09:27:31,096 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.indexQueueSize
2018-05-14 09:27:31,097 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.indexTimeout
2018-05-14 09:27:31,097 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.ldapDomain
2018-05-14 09:27:31,097 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.ldapGroupBaseDn
2018-05-14 09:27:31,098 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.ldapHost
2018-05-14 09:27:31,098 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.ldapIdAttribute
2018-05-14 09:27:31,099 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.ldapPassword
2018-05-14 09:27:31,099 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.ldapPrincipalScheme
2018-05-14 09:27:31,099 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.ldapStartTls
2018-05-14 09:27:31,100 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.ldapUser
2018-05-14 09:27:31,100 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.ldapUserBaseDn
2018-05-14 09:27:31,100 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.locale
2018-05-14 09:27:31,101 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.mailDisabled
2018-05-14 09:27:31,101 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.mailHost
2018-05-14 09:27:31,102 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.mailPort
2018-05-14 09:27:31,102 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.manager-path
2018-05-14 09:27:31,102 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.name
2018-05-14 09:27:31,103 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.rewriteConfig
2018-05-14 09:27:31,103 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.searchChunkSize
2018-05-14 09:27:31,103 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.searchMaxHits
2018-05-14 09:27:31,104 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.service-path
2018-05-14 09:27:31,104 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.serviceOutputFormat
2018-05-14 09:27:31,104 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.serviceOutputType
2018-05-14 09:27:31,105 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.siteRootDir
2018-05-14 09:27:31,105 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.supportReloadFile
2018-05-14 09:27:31,105 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.supportedLanguages
2018-05-14 09:27:31,106 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.tagPrefix
2018-05-14 09:27:31,106 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.template
2018-05-14 09:27:31,106 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.timeZone
2018-05-14 09:27:31,107 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.wwwDir
2018-05-14 09:27:31,107 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-2.xssExceptions
2018-05-14 09:27:31,108 INFO [Time-limited test] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Site site-2
2018-05-14 09:27:31,109 INFO [Time-limited test] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@5f9d87f9, testMethod = testDeleteSiteWithEnvironment@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:31,115 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@31caf651, testMethod = testDeleteSubject@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:31,138 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#362222883 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,149 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1987075297 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,154 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Subject john
2018-05-14 09:27:31,155 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@31caf651, testMethod = testDeleteSubject@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:31,156 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@661a5ac0, testMethod = testFindApplicationByName@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:31,178 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1799657969 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,188 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#2063699983 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,192 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@661a5ac0, testMethod = testFindApplicationByName@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:31,194 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@71ad18e6, testMethod = testGetApplicationFolder@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:31,216 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1936782171 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,228 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#414396995 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,230 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@71ad18e6, testMethod = testGetApplicationFolder@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:31,232 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@6d66f9e3, testMethod = testGetApplicationProperties@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:31,255 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#280809141 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,266 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#570793059 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,267 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.foo
2018-05-14 09:27:31,272 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@6d66f9e3, testMethod = testGetApplicationProperties@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:31,273 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@4d1f1b98, testMethod = testGetApplicationRepositories@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:31,296 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#963636917 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,307 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1508413459 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,313 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@4d1f1b98, testMethod = testGetApplicationRepositories@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:31,315 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@102e8217, testMethod = testGetApplicationRolesForApplication@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:31,337 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#726851688 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,348 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1461934131 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,356 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@102e8217, testMethod = testGetApplicationRolesForApplication@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:31,358 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@3c77afeb, testMethod = testGetApplicationRootFolder@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:31,378 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1635674097 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,389 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#946991643 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,391 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@3c77afeb, testMethod = testGetApplicationRootFolder@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:31,393 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@11ef3bee, testMethod = testGetGroupByName@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:31,413 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1060260698 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,423 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1496376144 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,426 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@11ef3bee, testMethod = testGetGroupByName@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:31,428 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@56dc6b33, testMethod = testGetGroups@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:31,449 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#386211764 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,460 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#696542090 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,465 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@56dc6b33, testMethod = testGetGroups@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:31,467 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@284d1c98, testMethod = testGetPropertiesIntegerInteger@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:31,488 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#25239686 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,500 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1263447168 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,504 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@284d1c98, testMethod = testGetPropertiesIntegerInteger@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:31,506 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@5f0a452d, testMethod = testGetPropertiesStringString@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:31,527 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1905377675 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,538 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1380643243 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,544 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@5f0a452d, testMethod = testGetPropertiesStringString@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:31,546 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@54271d08, testMethod = testGetSite@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:31,569 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1074889089 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,581 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#743200295 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,595 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@54271d08, testMethod = testGetSite@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:31,598 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@3e821bba, testMethod = testGetSiteByName@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:31,618 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#59794522 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,628 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#593199410 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,641 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@3e821bba, testMethod = testGetSiteByName@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:31,643 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@47caa1ff, testMethod = testGetSiteIds@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:31,671 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#27226489 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,681 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1040240917 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,683 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@47caa1ff, testMethod = testGetSiteIds@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:31,685 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@2bf833b5, testMethod = testGetSites@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:31,708 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#625686029 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,719 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1202586016 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,724 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@2bf833b5, testMethod = testGetSites@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:31,726 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@713ffca3, testMethod = testGetSubjectByEmail@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:31,748 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#263954506 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,759 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#2021353610 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,766 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@713ffca3, testMethod = testGetSubjectByEmail@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:31,768 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@4e9f4264, testMethod = testGetSubjectById@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:31,790 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#750592901 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,800 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#287491987 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,803 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@4e9f4264, testMethod = testGetSubjectById@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:31,805 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@284c84de, testMethod = testGetSubjectByName@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:31,825 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#869454818 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,835 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#252672164 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,838 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@284c84de, testMethod = testGetSubjectByName@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:31,840 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@1d229476, testMethod = testGetSubjects@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:31,861 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#7969927 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,871 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1355873096 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,875 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@1d229476, testMethod = testGetSubjects@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:31,878 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@2fb3113a, testMethod = testInitSitePropertiesSiteImpl@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:31,898 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#2036981963 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,909 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1519683819 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,923 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@2fb3113a, testMethod = testInitSitePropertiesSiteImpl@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:31,925 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@571bce3, testMethod = testLdapLogin@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:31,944 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#31523331 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,955 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#226956468 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:31,970 INFO [main] org.appng.core.service.LdapService: LDAP Configuration of site 'site-1' neither uses LDAP over SSL ('ldaps://') nor STARTTLS. Credentials will be transmitted as cleartext.
2018-05-14 09:27:32,585 INFO [main] org.appng.core.service.LdapService: LDAP operation failed on host 'ldap(s):<host>:<port>' with principal 'EXAMPLE\subject-2' (javax.naming.NamingException: Cannot parse url: ldap(s):<host>:<port>)
2018-05-14 09:27:32,587 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@571bce3, testMethod = testLdapLogin@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:32,589 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@45ecf220, testMethod = testLdapLoginGroup@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:32,610 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1747790231 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:32,621 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1886494905 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:32,635 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@45ecf220, testMethod = testLdapLoginGroup@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:32,637 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@3f8d5d43, testMethod = testLogin@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:32,657 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1933357348 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:32,668 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1168241104 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:33,548 INFO [main] org.appng.core.service.CoreService: successfully logged in user 'subject-3'
2018-05-14 09:27:33,549 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform logged in
2018-05-14 09:27:33,549 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform logged out
2018-05-14 09:27:33,549 INFO [main] org.appng.core.service.CoreService: 'null' logged out
2018-05-14 09:27:33,552 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject subject-3
2018-05-14 09:27:33,552 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@3f8d5d43, testMethod = testLogin@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:33,556 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@4b47e09b, testMethod = testLoginDigest@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:33,584 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1734338782 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:33,595 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1147761442 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:33,601 INFO [main] org.appng.core.security.DigestValidator: Digest successfully validated.
2018-05-14 09:27:33,601 INFO [main] org.appng.core.service.CoreService: successfully logged in user 'subject-3'
2018-05-14 09:27:33,601 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform logged in
2018-05-14 09:27:33,601 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform logged out
2018-05-14 09:27:33,602 INFO [main] org.appng.core.service.CoreService: 'null' logged out
2018-05-14 09:27:33,603 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@4b47e09b, testMethod = testLoginDigest@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:33,605 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@1688ac20, testMethod = testLoginGroup@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:33,627 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1656230985 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:33,637 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#87228768 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:34,520 INFO [main] org.appng.core.service.CoreService: successfully logged in user 'johndoe'
2018-05-14 09:27:34,520 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform logged in
2018-05-14 09:27:34,526 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform logged out
2018-05-14 09:27:34,526 INFO [main] org.appng.core.service.CoreService: 'null' logged out
2018-05-14 09:27:34,528 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@1688ac20, testMethod = testLoginGroup@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:34,530 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@2441e2d3, testMethod = testLoginPrincipal@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:34,551 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1083006052 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:34,565 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1903887294 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:34,577 INFO [main] org.appng.core.service.CoreService: user subject-2 found
2018-05-14 09:27:34,577 INFO [main] org.appng.core.service.CoreService: successfully logged in user 'subject-2'
2018-05-14 09:27:34,577 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform logged in
2018-05-14 09:27:34,578 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform logged out
2018-05-14 09:27:34,578 INFO [main] org.appng.core.service.CoreService: 'null' logged out
2018-05-14 09:27:34,580 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@2441e2d3, testMethod = testLoginPrincipal@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:34,582 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@89741e2, testMethod = testLoginPrincipalWithGroup@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:34,603 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1888050892 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:34,614 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#708891394 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:34,618 INFO [main] org.appng.core.service.CoreService: Subject authentication failed. Trying to authenticate based on LDAP group membership.
2018-05-14 09:27:34,622 INFO [main] org.appng.core.service.CoreService: user 'null' belongs to group 'subject-1'
2018-05-14 09:27:34,624 INFO [main] org.appng.core.service.CoreService: User "null" successfully authenticated.
2018-05-14 09:27:34,625 INFO [main] org.appng.core.service.CoreService: successfully logged in user 'null'
2018-05-14 09:27:34,625 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform logged in
2018-05-14 09:27:34,625 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform logged out
2018-05-14 09:27:34,625 INFO [main] org.appng.core.service.CoreService: 'null' logged out
2018-05-14 09:27:34,627 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@89741e2, testMethod = testLoginPrincipalWithGroup@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:34,629 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@3995edf5, testMethod = testMigratePassword@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:34,651 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#758846392 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:34,662 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#2136864056 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:34,663 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Subject deve
2018-05-14 09:27:35,547 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Subject deve
2018-05-14 09:27:35,548 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@3995edf5, testMethod = testMigratePassword@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:35,550 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@7f5435ab, testMethod = testProvideApplication@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:35,569 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1110944422 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:35,579 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1484907672 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:35,580 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Repository testrepo
2018-05-14 09:27:35,582 INFO [main] org.appng.core.service.CoreService: retrieving 'demo-application-1.5.2' from repository file:/var/lib/jenkins/workspace/appNG_Release/appng/appng-core/target/test-classes/zip
2018-05-14 09:27:35,618 INFO [main] org.appng.core.service.CoreService: deploying application demo-application-1.5.2
2018-05-14 09:27:35,622 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Application demo-application
2018-05-14 09:27:35,624 INFO [main] org.appng.core.service.CoreService: creating new permission 'debug' for application 'demo-application'
2018-05-14 09:27:35,628 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Permission debug
2018-05-14 09:27:35,628 INFO [main] org.appng.core.service.CoreService: creating new permission 'output-format.html' for application 'demo-application'
2018-05-14 09:27:35,629 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Permission output-format.html
2018-05-14 09:27:35,629 INFO [main] org.appng.core.service.CoreService: creating new permission 'output-type.webgui' for application 'demo-application'
2018-05-14 09:27:35,629 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Permission output-type.webgui
2018-05-14 09:27:35,632 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Role Administrator
2018-05-14 09:27:35,639 INFO [main] org.appng.core.service.CoreService: added permission 'output-format.html' to role 'Administrator'
2018-05-14 09:27:35,641 INFO [main] org.appng.core.service.CoreService: added permission 'output-type.webgui' to role 'Administrator'
2018-05-14 09:27:35,642 WARN [main] org.appng.core.service.CoreService: the role 'Administrator' references permisson 'logViewer' which does not exist!
2018-05-14 09:27:35,642 INFO [main] org.appng.core.service.CoreService: creating new role 'Administrator' for application 'demo-application'
2018-05-14 09:27:35,643 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Role Debugger
2018-05-14 09:27:35,645 INFO [main] org.appng.core.service.CoreService: added permission 'debug' to role 'Debugger'
2018-05-14 09:27:35,645 INFO [main] org.appng.core.service.CoreService: creating new role 'Debugger' for application 'demo-application'
2018-05-14 09:27:35,649 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.application.demo-application.foo
2018-05-14 09:27:35,649 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.application.demo-application.clobValue
2018-05-14 09:27:35,653 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Role Administrator
2018-05-14 09:27:35,653 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Role Debugger
2018-05-14 09:27:35,657 INFO [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'application.xml' for application 'demo-application-1.5.2'
2018-05-14 09:27:35,657 INFO [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'beans.xml' for application 'demo-application-1.5.2'
2018-05-14 09:27:35,657 INFO [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'datasources.xml' for application 'demo-application-1.5.2'
2018-05-14 09:27:35,658 INFO [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'events.xml' for application 'demo-application-1.5.2'
2018-05-14 09:27:35,658 INFO [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'master.xml' for application 'demo-application-1.5.2'
2018-05-14 09:27:35,658 INFO [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'page.xml' for application 'demo-application-1.5.2'
2018-05-14 09:27:35,658 INFO [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'plugin.xml' for application 'demo-application-1.5.2'
2018-05-14 09:27:35,659 INFO [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'messages-demo.properties' for application 'demo-application-1.5.2'
2018-05-14 09:27:35,659 INFO [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'mssql/V1.0_script.sql' for application 'demo-application-1.5.2'
2018-05-14 09:27:35,659 INFO [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'mysql/V1.0_script.sql' for application 'demo-application-1.5.2'
2018-05-14 09:27:35,659 INFO [main] org.appng.core.service.CoreService: extracting filebased application demo-application - 1.5.2 to target/ROOT/applications/demo-application
2018-05-14 09:27:35,667 INFO [main] org.appng.core.service.CoreService: role 'Administrator' already has permission 'output-format.html'
2018-05-14 09:27:35,669 INFO [main] org.appng.core.service.CoreService: role 'Administrator' already has permission 'output-type.webgui'
2018-05-14 09:27:35,670 WARN [main] org.appng.core.service.CoreService: the role 'Administrator' references permisson 'logViewer' which does not exist!
2018-05-14 09:27:35,673 INFO [main] org.appng.core.service.CoreService: role 'Debugger' already has permission 'debug'
2018-05-14 09:27:35,680 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Application demo-application
2018-05-14 09:27:35,681 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@7f5435ab, testMethod = testProvideApplication@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:35,683 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@63796a19, testMethod = testProvideApplicationUpdate@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:35,706 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1073398058 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:35,716 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#2018964967 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:35,765 INFO [main] org.appng.core.model.CacheProvider: cleaning /var/lib/jenkins/workspace/appNG_Release/appng/appng-core/target/ROOT/WEB-INF/cache/platform/site-1/demo-application
2018-05-14 09:27:35,766 INFO [main] org.appng.core.model.CacheProvider: cleaning /var/lib/jenkins/workspace/appNG_Release/appng/appng-core/target/ROOT/WEB-INF/cache/application/site-1/demo-application
2018-05-14 09:27:35,767 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform Assigned application demo-application to site site-1
2018-05-14 09:27:35,771 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.application.demo-application.foo
2018-05-14 09:27:35,771 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.application.demo-application.clobValue
2018-05-14 09:27:35,772 INFO [main] org.appng.core.service.CoreService: retrieving 'demo-application-1.5.3' from repository file:/var/lib/jenkins/workspace/appNG_Release/appng/appng-core/target/test-classes/zip
2018-05-14 09:27:35,783 INFO [main] org.appng.core.service.CoreService: updating application demo-application-1.5.3
2018-05-14 09:27:35,787 INFO [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'application.xml' for application 'demo-application-1.5.3'
2018-05-14 09:27:35,787 INFO [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'beans.xml' for application 'demo-application-1.5.3'
2018-05-14 09:27:35,788 INFO [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'datasources.xml' for application 'demo-application-1.5.3'
2018-05-14 09:27:35,788 INFO [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'events.xml' for application 'demo-application-1.5.3'
2018-05-14 09:27:35,788 INFO [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'master.xml' for application 'demo-application-1.5.3'
2018-05-14 09:27:35,789 INFO [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'page.xml' for application 'demo-application-1.5.3'
2018-05-14 09:27:35,789 INFO [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'plugin.xml' for application 'demo-application-1.5.3'
2018-05-14 09:27:35,789 INFO [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'messages-demo.properties' for application 'demo-application-1.5.3'
2018-05-14 09:27:35,789 INFO [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'mssql/V1.0_script.sql' for application 'demo-application-1.5.3'
2018-05-14 09:27:35,790 INFO [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'mysql/V1.0_script.sql' for application 'demo-application-1.5.3'
2018-05-14 09:27:35,790 INFO [main] org.appng.core.service.CoreService: extracting filebased application demo-application - 1.5.3 to target/ROOT/applications/demo-application
2018-05-14 09:27:35,794 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Application demo-application
2018-05-14 09:27:35,799 INFO [main] org.appng.core.service.CoreService: creating new permission 'testPermission' for application 'demo-application'
2018-05-14 09:27:35,799 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Permission testPermission
2018-05-14 09:27:35,802 INFO [main] org.appng.core.service.CoreService: role 'Administrator' already has permission 'output-format.html'
2018-05-14 09:27:35,804 INFO [main] org.appng.core.service.CoreService: role 'Administrator' already has permission 'output-type.webgui'
2018-05-14 09:27:35,805 WARN [main] org.appng.core.service.CoreService: the role 'Administrator' references permisson 'logViewer' which does not exist!
2018-05-14 09:27:35,808 INFO [main] org.appng.core.service.CoreService: role 'Debugger' already has permission 'debug'
2018-05-14 09:27:35,809 INFO [main] org.appng.core.service.CoreService: added permission 'testPermission' to role 'Debugger'
2018-05-14 09:27:35,811 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Role Debugger
2018-05-14 09:27:35,812 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Role Tester
2018-05-14 09:27:35,814 INFO [main] org.appng.core.service.CoreService: added permission 'testPermission' to role 'Tester'
2018-05-14 09:27:35,814 INFO [main] org.appng.core.service.CoreService: creating new role 'Tester' for application 'demo-application'
2018-05-14 09:27:35,817 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.application.demo-application.bar
2018-05-14 09:27:35,817 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.application.demo-application.bar
2018-05-14 09:27:35,821 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Property platform.application.demo-application.clobValue
2018-05-14 09:27:35,822 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Property platform.application.demo-application.foo
2018-05-14 09:27:35,822 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Property platform.site.site-1.application.demo-application.foo
2018-05-14 09:27:35,823 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Role Tester
2018-05-14 09:27:35,823 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Property platform.application.demo-application.bar
2018-05-14 09:27:35,824 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Property platform.site.site-1.application.demo-application.bar
2018-05-14 09:27:35,827 INFO [main] org.appng.core.service.CoreService: loading properties for application 'demo-application' of site 'site-1'
2018-05-14 09:27:35,829 INFO [main] org.appng.core.service.CoreService: loading properties for application demo-application
2018-05-14 09:27:35,832 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Repository testrepo
2018-05-14 09:27:35,833 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@63796a19, testMethod = testProvideApplicationUpdate@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:35,835 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@38e0ccf3, testMethod = testProvideApplicationUpdateDelete@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:35,859 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#517248810 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:35,869 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1535496246 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:35,881 INFO [main] org.appng.core.service.CoreService: unlinking application demo-application from site site-1, status of database-connection is NO_DB_SUPPORTED
2018-05-14 09:27:35,882 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform Removed application demo-application from site site-1
2018-05-14 09:27:35,883 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-1.application.demo-application.bar
2018-05-14 09:27:35,884 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-1.application.demo-application.clobValue
2018-05-14 09:27:35,884 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-1.application.demo-application.foo
2018-05-14 09:27:35,893 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Role Administrator
2018-05-14 09:27:35,895 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Role Tester
2018-05-14 09:27:35,901 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Role Debugger
2018-05-14 09:27:35,902 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Permission debug
2018-05-14 09:27:35,902 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Permission output-type.webgui
2018-05-14 09:27:35,902 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Permission output-format.html
2018-05-14 09:27:35,903 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Permission testPermission
2018-05-14 09:27:35,903 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.application.demo-application.bar
2018-05-14 09:27:35,904 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.application.demo-application.clobValue
2018-05-14 09:27:35,904 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.application.demo-application.foo
2018-05-14 09:27:35,904 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Application demo-application
2018-05-14 09:27:35,907 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@38e0ccf3, testMethod = testProvideApplicationUpdateDelete@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:35,909 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@4246c643, testMethod = testProvideApplicationWithAdminRole@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:35,929 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#829804056 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:35,939 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#258545788 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:35,940 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Repository testrepo
2018-05-14 09:27:35,942 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Group Administrators
2018-05-14 09:27:35,942 INFO [main] org.appng.core.service.CoreService: retrieving 'demo-application-1.5.4' from repository file:/var/lib/jenkins/workspace/appNG_Release/appng/appng-core/target/test-classes/zip
2018-05-14 09:27:35,975 INFO [main] org.appng.core.service.CoreService: deploying application demo-application-1.5.4
2018-05-14 09:27:35,975 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Application demo-application
2018-05-14 09:27:35,977 INFO [main] org.appng.core.service.CoreService: creating new permission 'debug' for application 'demo-application'
2018-05-14 09:27:35,977 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Permission debug
2018-05-14 09:27:35,978 INFO [main] org.appng.core.service.CoreService: creating new permission 'output-format.html' for application 'demo-application'
2018-05-14 09:27:35,978 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Permission output-format.html
2018-05-14 09:27:35,979 INFO [main] org.appng.core.service.CoreService: creating new permission 'output-type.webgui' for application 'demo-application'
2018-05-14 09:27:35,979 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Permission output-type.webgui
2018-05-14 09:27:35,979 INFO [main] org.appng.core.service.CoreService: creating new permission 'testPermission' for application 'demo-application'
2018-05-14 09:27:35,979 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Permission testPermission
2018-05-14 09:27:35,980 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Role Administrator
2018-05-14 09:27:35,983 INFO [main] org.appng.core.service.CoreService: added permission 'output-format.html' to role 'Administrator'
2018-05-14 09:27:35,984 INFO [main] org.appng.core.service.CoreService: added permission 'output-type.webgui' to role 'Administrator'
2018-05-14 09:27:35,986 WARN [main] org.appng.core.service.CoreService: the role 'Administrator' references permisson 'logViewer' which does not exist!
2018-05-14 09:27:35,986 INFO [main] org.appng.core.service.CoreService: creating new role 'Administrator' for application 'demo-application'
2018-05-14 09:27:35,986 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Role Debugger
2018-05-14 09:27:35,988 INFO [main] org.appng.core.service.CoreService: added permission 'debug' to role 'Debugger'
2018-05-14 09:27:35,990 INFO [main] org.appng.core.service.CoreService: added permission 'testPermission' to role 'Debugger'
2018-05-14 09:27:35,990 INFO [main] org.appng.core.service.CoreService: creating new role 'Debugger' for application 'demo-application'
2018-05-14 09:27:35,990 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Role Tester
2018-05-14 09:27:35,992 INFO [main] org.appng.core.service.CoreService: added permission 'testPermission' to role 'Tester'
2018-05-14 09:27:35,992 INFO [main] org.appng.core.service.CoreService: creating new role 'Tester' for application 'demo-application'
2018-05-14 09:27:35,995 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.application.demo-application.foo
2018-05-14 09:27:35,996 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.application.demo-application.bar
2018-05-14 09:27:35,996 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.application.demo-application.clobValue
2018-05-14 09:27:36,002 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Group Administrators
2018-05-14 09:27:36,003 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Role Administrator
2018-05-14 09:27:36,003 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Role Debugger
2018-05-14 09:27:36,004 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Role Tester
2018-05-14 09:27:36,007 INFO [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'application.xml' for application 'demo-application-1.5.4'
2018-05-14 09:27:36,007 INFO [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'beans.xml' for application 'demo-application-1.5.4'
2018-05-14 09:27:36,007 INFO [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'datasources.xml' for application 'demo-application-1.5.4'
2018-05-14 09:27:36,008 INFO [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'events.xml' for application 'demo-application-1.5.4'
2018-05-14 09:27:36,008 INFO [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'master.xml' for application 'demo-application-1.5.4'
2018-05-14 09:27:36,008 INFO [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'page.xml' for application 'demo-application-1.5.4'
2018-05-14 09:27:36,008 INFO [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'plugin.xml' for application 'demo-application-1.5.4'
2018-05-14 09:27:36,008 INFO [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'messages-demo.properties' for application 'demo-application-1.5.4'
2018-05-14 09:27:36,008 INFO [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'mssql/V1.0_script.sql' for application 'demo-application-1.5.4'
2018-05-14 09:27:36,009 INFO [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'mysql/V1.0_script.sql' for application 'demo-application-1.5.4'
2018-05-14 09:27:36,009 INFO [main] org.appng.core.service.CoreService: extracting filebased application demo-application - 1.5.4 to target/ROOT/applications/demo-application
2018-05-14 09:27:36,018 INFO [main] org.appng.core.service.CoreService: role 'Administrator' already has permission 'output-format.html'
2018-05-14 09:27:36,019 INFO [main] org.appng.core.service.CoreService: role 'Administrator' already has permission 'output-type.webgui'
2018-05-14 09:27:36,021 WARN [main] org.appng.core.service.CoreService: the role 'Administrator' references permisson 'logViewer' which does not exist!
2018-05-14 09:27:36,023 INFO [main] org.appng.core.service.CoreService: role 'Debugger' already has permission 'debug'
2018-05-14 09:27:36,024 INFO [main] org.appng.core.service.CoreService: role 'Debugger' already has permission 'testPermission'
2018-05-14 09:27:36,026 INFO [main] org.appng.core.service.CoreService: role 'Tester' already has permission 'testPermission'
2018-05-14 09:27:36,032 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@4246c643, testMethod = testProvideApplicationWithAdminRole@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:36,034 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@73c3adb8, testMethod = testReloadRepository@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:36,055 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#17051743 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:36,066 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1917017583 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:36,070 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@73c3adb8, testMethod = testReloadRepository@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:36,072 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@57d8308d, testMethod = testResetPassword@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:36,094 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#2144115017 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:36,105 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1570051542 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:36,984 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@57d8308d, testMethod = testResetPassword@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:36,986 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@4f9ff5fb, testMethod = testRestoreSubject@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:37,016 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#227729091 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:37,025 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#2041879325 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:37,030 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@4f9ff5fb, testMethod = testRestoreSubject@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:37,032 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@2f308931, testMethod = testSaveProperties@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:37,056 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#895827311 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:37,066 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1813709148 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:37,067 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property foobaz.a
2018-05-14 09:27:37,069 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property foobaz.b
2018-05-14 09:27:37,072 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@2f308931, testMethod = testSaveProperties@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:37,077 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@38b46854, testMethod = testSaveProperty@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:37,098 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#107737229 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:37,110 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1410111202 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:37,111 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property prop1
2018-05-14 09:27:37,113 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@38b46854, testMethod = testSaveProperty@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:37,115 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@bf0b496, testMethod = testUnlinkApplicationFromSiteIntegerString@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:37,137 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#7469297 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:37,147 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1904761035 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:37,150 INFO [main] org.appng.core.service.CoreService: unlinking application manager from site site-1, status of database-connection is NO_DB_SUPPORTED
2018-05-14 09:27:37,150 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform Removed application manager from site site-1
2018-05-14 09:27:37,151 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-1.application.manager.foo
2018-05-14 09:27:37,152 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-1.application.manager.foobar
2018-05-14 09:27:37,153 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@bf0b496, testMethod = testUnlinkApplicationFromSiteIntegerString@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:37,158 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@381fbf44, testMethod = testUpdatePassword@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@41d0b71d]; rollback [false]
2018-05-14 09:27:37,176 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#2037881941 for site site-1 with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:37,186 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#298615087 for site example with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2018-05-14 09:27:38,098 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject subject-3
2018-05-14 09:27:38,099 INFO [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test context [DefaultTestContext@5f092eaa testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@381fbf44, testMethod = testUpdatePassword@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@6f6d2847 testClass = CoreServiceTest, locations = '{classpath:platformContext.xml}', classes = '{}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
2018-05-14 09:27:38,106 INFO [main] org.springframework.context.support.GenericApplicationContext: Closing org.springframework.context.support.GenericApplicationContext@1dd17c0c: startup date [Mon May 14 09:27:28 CEST 2018]; root of context hierarchy
2018-05-14 09:27:38,108 INFO [main] org.springframework.orm.jpa.LocalEntityManagerFactoryBean: Closing JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2018-05-14 09:27:38,108 INFO [main] org.hibernate.orm.connections.pooling: HHH10001008: Cleaning up connection pool [jdbc:hsqldb:mem:TestInitializer]
[WARNING] Corrupted stdin stream in forked JVM 1. See the dump file /var/lib/jenkins/workspace/appNG_Release/appng/appng-core/target/surefire-reports/2018-05-14T09-23-48_006-jvmRun1.dumpstream
[INFO]
[INFO] Results:
[INFO]
[WARNING] Tests run: 77, Failures: 0, Errors: 0, Skipped: 3
[INFO]
[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO]
[INFO] appNG Parent ....................................... SUCCESS [ 31.505 s]
[INFO] appNG Tools ........................................ SUCCESS [ 31.064 s]
[INFO] appNG Mail ......................................... SUCCESS [ 18.812 s]
[INFO] appNG Forms ........................................ SUCCESS [ 11.827 s]
[INFO] appng Formtags ..................................... SUCCESS [ 8.949 s]
[INFO] appNG XML-API ...................................... SUCCESS [ 14.164 s]
[INFO] appNG public API ................................... SUCCESS [ 32.125 s]
[INFO] appNG testsupport .................................. SUCCESS [ 24.167 s]
[INFO] appNG Persistence-Tools ............................ SUCCESS [ 32.459 s]
[INFO] appNG Search ....................................... SUCCESS [ 20.947 s]
[INFO] appNG Core Library ................................. FAILURE [ 38.159 s]
[INFO] appNG Tomcat 7 ..................................... SKIPPED
[INFO] appNG Tomcat 8 ..................................... SKIPPED
[INFO] appNG Command Line Interface ....................... SKIPPED
[INFO] appNG Tag Library .................................. SKIPPED
[INFO] appNG Application .................................. SKIPPED
[INFO] appNG application BOM .............................. SKIPPED
[INFO] appNG Documentation ................................ SKIPPED
[INFO] appNG Template Assembly Descriptors ................ SKIPPED
[INFO] appNG Template Parent .............................. SKIPPED
[INFO] appng-application-assembly ......................... SKIPPED
[INFO] appNG application parent ........................... SKIPPED
[INFO] Archetype - appng-archetype-application ............ SKIPPED
[INFO] appNGizer JAXB API ................................. SKIPPED
[INFO] appNGizer .......................................... SKIPPED
[INFO] appNG appNGizer Maven Plugin ....................... SKIPPED
[INFO] appNG camunda ...................................... SKIPPED
[INFO] appNG Application, including Camunda BPM process engine libraries SKIPPED
[INFO] appNG Maven Plugin ................................. SKIPPED
[INFO] upNGizr ............................................ SKIPPED
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 04:30 min
[INFO] Finished at: 2018-05-14T09:27:38+02:00
[INFO] Final Memory: 111M/1456M
[INFO] ------------------------------------------------------------------------
[ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.20:test (default-test) on project appng-core: There are test failures.
[ERROR]
[ERROR] Please refer to /var/lib/jenkins/workspace/appNG_Release/appng/appng-core/target/surefire-reports for the individual test results.
[ERROR] Please refer to dump files (if any exist) [date]-jvmRun[N].dump, [date].dumpstream and [date]-jvmRun[N].dumpstream.
[ERROR] The forked VM terminated without properly saying goodbye. VM crash or System.exit called?
[ERROR] Command was /bin/sh -c cd /var/lib/jenkins/workspace/appNG_Release/appng/appng-core && /usr/lib/jvm/jdk-8-oracle-x64/jre/bin/java -Dfile.encoding=UTF-8 -jar /var/lib/jenkins/workspace/appNG_Release/appng/appng-core/target/surefire/surefirebooter2230922815677763261.jar /var/lib/jenkins/workspace/appNG_Release/appng/appng-core/target/surefire 2018-05-14T09-23-48_006-jvmRun1 surefire7940605992273254624tmp surefire_98991025524839817377tmp
[ERROR] Error occurred in starting fork, check output in log
[ERROR] Process Exit Code: 1
[ERROR] org.apache.maven.surefire.booter.SurefireBooterForkException: The forked VM terminated without properly saying goodbye. VM crash or System.exit called?
[ERROR] Command was /bin/sh -c cd /var/lib/jenkins/workspace/appNG_Release/appng/appng-core && /usr/lib/jvm/jdk-8-oracle-x64/jre/bin/java -Dfile.encoding=UTF-8 -jar /var/lib/jenkins/workspace/appNG_Release/appng/appng-core/target/surefire/surefirebooter2230922815677763261.jar /var/lib/jenkins/workspace/appNG_Release/appng/appng-core/target/surefire 2018-05-14T09-23-48_006-jvmRun1 surefire7940605992273254624tmp surefire_98991025524839817377tmp
[ERROR] Error occurred in starting fork, check output in log
[ERROR] Process Exit Code: 1
[ERROR] at org.apache.maven.plugin.surefire.booterclient.ForkStarter.fork(ForkStarter.java:679)
[ERROR] at org.apache.maven.plugin.surefire.booterclient.ForkStarter.fork(ForkStarter.java:533)
[ERROR] at org.apache.maven.plugin.surefire.booterclient.ForkStarter.run(ForkStarter.java:279)
[ERROR] at org.apache.maven.plugin.surefire.booterclient.ForkStarter.run(ForkStarter.java:243)
[ERROR] at org.apache.maven.plugin.surefire.AbstractSurefireMojo.executeProvider(AbstractSurefireMojo.java:1077)
[ERROR] at org.apache.maven.plugin.surefire.AbstractSurefireMojo.executeAfterPreconditionsChecked(AbstractSurefireMojo.java:907)
[ERROR] at org.apache.maven.plugin.surefire.AbstractSurefireMojo.execute(AbstractSurefireMojo.java:785)
[ERROR] at org.apache.maven.plugin.DefaultBuildPluginManager.executeMojo(DefaultBuildPluginManager.java:134)
[ERROR] at org.apache.maven.lifecycle.internal.MojoExecutor.execute(MojoExecutor.java:208)
[ERROR] at org.apache.maven.lifecycle.internal.MojoExecutor.execute(MojoExecutor.java:154)
[ERROR] at org.apache.maven.lifecycle.internal.MojoExecutor.execute(MojoExecutor.java:146)
[ERROR] at org.apache.maven.lifecycle.internal.LifecycleModuleBuilder.buildProject(LifecycleModuleBuilder.java:117)
[ERROR] at org.apache.maven.lifecycle.internal.LifecycleModuleBuilder.buildProject(LifecycleModuleBuilder.java:81)
[ERROR] at org.apache.maven.lifecycle.internal.builder.singlethreaded.SingleThreadedBuilder.build(SingleThreadedBuilder.java:51)
[ERROR] at org.apache.maven.lifecycle.internal.LifecycleStarter.execute(LifecycleStarter.java:128)
[ERROR] at org.apache.maven.DefaultMaven.doExecute(DefaultMaven.java:309)
[ERROR] at org.apache.maven.DefaultMaven.doExecute(DefaultMaven.java:194)
[ERROR] at org.apache.maven.DefaultMaven.execute(DefaultMaven.java:107)
[ERROR] at org.apache.maven.cli.MavenCli.execute(MavenCli.java:993)
[ERROR] at org.apache.maven.cli.MavenCli.doMain(MavenCli.java:345)
[ERROR] at org.apache.maven.cli.MavenCli.main(MavenCli.java:191)
[ERROR] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[ERROR] at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[ERROR] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[ERROR] at java.lang.reflect.Method.invoke(Method.java:498)
[ERROR] at org.codehaus.plexus.classworlds.launcher.Launcher.launchEnhanced(Launcher.java:289)
[ERROR] at org.codehaus.plexus.classworlds.launcher.Launcher.launch(Launcher.java:229)
[ERROR] at org.codehaus.plexus.classworlds.launcher.Launcher.mainWithExitCode(Launcher.java:415)
[ERROR] at org.codehaus.plexus.classworlds.launcher.Launcher.main(Launcher.java:356)
[ERROR]
[ERROR] -> [Help 1]
[ERROR]
[ERROR] To see the full stack trace of the errors, re-run Maven with the -e switch.
[ERROR] Re-run Maven using the -X switch to enable full debug logging.
[ERROR]
[ERROR] For more information about the errors and possible solutions, please read the following articles:
[ERROR] [Help 1] http://cwiki.apache.org/confluence/display/MAVEN/MojoExecutionException
[ERROR]
[ERROR] After correcting the problems, you can resume the build with the command
[ERROR] mvn <goals> -rf :appng-core