Console Output

Skipping 1,028 KB.. Full Log

reServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-11T10:23:42,966 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@8d37e82, testMethod = testLoginGroup@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@1dd3457f]; rollback [false]
2022-07-11T10:23:42,977 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1687004057 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:42,983 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1354372468 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:43,824 INFO  [main] org.appng.core.service.CoreService: successfully logged in user 'johndoe'
2022-07-11T10:23:43,824 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform logged in
2022-07-11T10:23:43,830 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform logged out
2022-07-11T10:23:43,830 INFO  [main] org.appng.core.service.CoreService: 'null' logged out
2022-07-11T10:23:43,832 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@8d37e82, testMethod = testLoginGroup@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-11T10:23:43,833 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@66fe1186, testMethod = testLoginPrincipal@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@1dd3457f]; rollback [false]
2022-07-11T10:23:43,846 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#947145627 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:43,852 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1903620915 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:43,859 INFO  [main] org.appng.core.service.CoreService: user subject-2 found
2022-07-11T10:23:43,860 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject subject-2
2022-07-11T10:23:43,861 INFO  [main] org.appng.core.service.CoreService: successfully logged in user 'subject-2'
2022-07-11T10:23:43,861 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform logged in
2022-07-11T10:23:43,862 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform logged out
2022-07-11T10:23:43,862 INFO  [main] org.appng.core.service.CoreService: 'null' logged out
2022-07-11T10:23:43,863 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@66fe1186, testMethod = testLoginPrincipal@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-11T10:23:43,864 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@51056f5f, testMethod = testLoginPrincipalWithGroup@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@1dd3457f]; rollback [false]
2022-07-11T10:23:43,876 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#215415062 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:43,882 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#410777865 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:43,889 INFO  [main] org.appng.core.service.CoreService: Subject authentication failed. Trying to authenticate based on LDAP group membership.
2022-07-11T10:23:43,892 INFO  [main] org.appng.core.service.CoreService: user 'null' belongs to group 'subject-1'
2022-07-11T10:23:43,893 INFO  [main] org.appng.core.service.CoreService: User 'null' successfully authenticated.
2022-07-11T10:23:43,893 INFO  [main] org.appng.core.service.CoreService: successfully logged in user 'null'
2022-07-11T10:23:43,893 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform logged in
2022-07-11T10:23:43,894 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform logged out
2022-07-11T10:23:43,894 INFO  [main] org.appng.core.service.CoreService: 'null' logged out
2022-07-11T10:23:43,895 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@51056f5f, testMethod = testLoginPrincipalWithGroup@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-11T10:23:43,897 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@3bfd0522, testMethod = testLoginSubjectIsExpired@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@1dd3457f]; rollback [false]
2022-07-11T10:23:43,909 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#282159672 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:43,920 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1444216837 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:43,923 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject subject-3
2022-07-11T10:23:44,744 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform User subject-3 has been locked because the expiry date has exceeded (Mon Jul 11 10:23:43 CEST 2022).
2022-07-11T10:23:44,747 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject subject-3
2022-07-11T10:23:44,750 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject subject-3
2022-07-11T10:23:44,750 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@3bfd0522, testMethod = testLoginSubjectIsExpired@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-11T10:23:44,751 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@5b7bfd5, testMethod = testLoginSubjectIsInactive@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@1dd3457f]; rollback [false]
2022-07-11T10:23:44,762 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#702446005 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:44,768 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#20605068 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:44,771 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject subject-3
2022-07-11T10:23:45,593 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null WARN appNG platform User subject-3 has been locked due to inactivity (last login was at Mon Apr 11 10:23:44 CEST 2022).
2022-07-11T10:23:45,596 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject subject-3
2022-07-11T10:23:45,600 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject subject-3
2022-07-11T10:23:45,600 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@5b7bfd5, testMethod = testLoginSubjectIsInactive@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-11T10:23:45,602 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@58fa4d30, testMethod = testLoginSubjectIsLocked@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@1dd3457f]; rollback [false]
2022-07-11T10:23:45,618 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#594294224 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:45,626 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#119306016 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:45,630 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject subject-3
2022-07-11T10:23:46,456 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform Rejected login for locked user subject-3.
2022-07-11T10:23:46,460 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject subject-3
2022-07-11T10:23:46,460 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@58fa4d30, testMethod = testLoginSubjectIsLocked@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-11T10:23:46,462 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@2fe2a864, testMethod = testProvideApplication@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@1dd3457f]; rollback [false]
2022-07-11T10:23:46,478 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1819244013 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:46,487 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1747486017 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:46,488 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Repository testrepo
2022-07-11T10:23:46,490 INFO  [main] org.appng.core.service.CoreService: retrieving 'demo-application-1.5.2' from repository file:/var/lib/jenkins/workspace/appNG_2.0.x/appng-core/target/test-classes/zip
2022-07-11T10:23:46,504 INFO  [main] org.appng.core.service.CoreService: deploying application demo-application-1.5.2
2022-07-11T10:23:46,506 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Application demo-application
2022-07-11T10:23:46,508 INFO  [main] org.appng.core.service.CoreService: creating new permission 'debug' for application 'demo-application'
2022-07-11T10:23:46,508 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Permission debug
2022-07-11T10:23:46,509 INFO  [main] org.appng.core.service.CoreService: creating new permission 'output-format.html' for application 'demo-application'
2022-07-11T10:23:46,509 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Permission output-format.html
2022-07-11T10:23:46,510 INFO  [main] org.appng.core.service.CoreService: creating new permission 'output-type.webgui' for application 'demo-application'
2022-07-11T10:23:46,510 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Permission output-type.webgui
2022-07-11T10:23:46,510 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Role Administrator
2022-07-11T10:23:46,515 INFO  [main] org.appng.core.service.CoreService: added permission 'output-format.html' to role 'Administrator'
2022-07-11T10:23:46,517 INFO  [main] org.appng.core.service.CoreService: added permission 'output-type.webgui' to role 'Administrator'
2022-07-11T10:23:46,518 WARN  [main] org.appng.core.service.CoreService: the role 'Administrator' references permisson 'logViewer' which does not exist!
2022-07-11T10:23:46,518 INFO  [main] org.appng.core.service.CoreService: creating new role 'Administrator' for application 'demo-application'
2022-07-11T10:23:46,518 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Role Debugger
2022-07-11T10:23:46,520 INFO  [main] org.appng.core.service.CoreService: added permission 'debug' to role 'Debugger'
2022-07-11T10:23:46,520 INFO  [main] org.appng.core.service.CoreService: creating new role 'Debugger' for application 'demo-application'
2022-07-11T10:23:46,523 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.application.demo-application.foo
2022-07-11T10:23:46,524 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.application.demo-application.clobValue
2022-07-11T10:23:46,526 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Role Administrator
2022-07-11T10:23:46,527 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Role Debugger
2022-07-11T10:23:46,532 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'application.xml' for application 'demo-application-1.5.2'
2022-07-11T10:23:46,532 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'beans.xml' for application 'demo-application-1.5.2'
2022-07-11T10:23:46,533 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'datasources.xml' for application 'demo-application-1.5.2'
2022-07-11T10:23:46,533 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'events.xml' for application 'demo-application-1.5.2'
2022-07-11T10:23:46,533 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'master.xml' for application 'demo-application-1.5.2'
2022-07-11T10:23:46,533 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'page.xml' for application 'demo-application-1.5.2'
2022-07-11T10:23:46,533 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'plugin.xml' for application 'demo-application-1.5.2'
2022-07-11T10:23:46,534 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'messages-demo.properties' for application 'demo-application-1.5.2'
2022-07-11T10:23:46,534 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'mssql/V1.0_script.sql' for application 'demo-application-1.5.2'
2022-07-11T10:23:46,534 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'mysql/V1.0_script.sql' for application 'demo-application-1.5.2'
2022-07-11T10:23:46,534 INFO  [main] org.appng.core.service.CoreService: extracting filebased application demo-application - 1.5.2 to target/ROOT/applications/demo-application
2022-07-11T10:23:46,550 INFO  [main] org.appng.core.service.CoreService: role 'Administrator' already has permission 'output-format.html'
2022-07-11T10:23:46,551 INFO  [main] org.appng.core.service.CoreService: role 'Administrator' already has permission 'output-type.webgui'
2022-07-11T10:23:46,552 WARN  [main] org.appng.core.service.CoreService: the role 'Administrator' references permisson 'logViewer' which does not exist!
2022-07-11T10:23:46,554 INFO  [main] org.appng.core.service.CoreService: role 'Debugger' already has permission 'debug'
2022-07-11T10:23:46,560 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Application demo-application
2022-07-11T10:23:46,560 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@2fe2a864, testMethod = testProvideApplication@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-11T10:23:46,562 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@240502b9, testMethod = testProvideApplicationUpdate@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@1dd3457f]; rollback [false]
2022-07-11T10:23:46,578 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1384494708 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:46,586 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#680384867 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:46,609 INFO  [main] org.appng.core.model.CacheProvider: cleaning /var/lib/jenkins/workspace/appNG_2.0.x/appng-core/target/ROOT/WEB-INF/cache/platform/site-1/demo-application
2022-07-11T10:23:46,609 INFO  [main] org.appng.core.model.CacheProvider: cleaning /var/lib/jenkins/workspace/appNG_2.0.x/appng-core/target/ROOT/WEB-INF/cache/application/site-1/demo-application
2022-07-11T10:23:46,611 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform Assigned application demo-application to site site-1
2022-07-11T10:23:46,613 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.application.demo-application.foo
2022-07-11T10:23:46,613 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.application.demo-application.clobValue
2022-07-11T10:23:46,613 INFO  [main] org.appng.core.service.CoreService: retrieving 'demo-application-1.5.3' from repository file:/var/lib/jenkins/workspace/appNG_2.0.x/appng-core/target/test-classes/zip
2022-07-11T10:23:46,623 INFO  [main] org.appng.core.service.CoreService: updating application demo-application-1.5.3
2022-07-11T10:23:46,630 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'application.xml' for application 'demo-application-1.5.3'
2022-07-11T10:23:46,630 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'beans.xml' for application 'demo-application-1.5.3'
2022-07-11T10:23:46,630 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'datasources.xml' for application 'demo-application-1.5.3'
2022-07-11T10:23:46,630 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'events.xml' for application 'demo-application-1.5.3'
2022-07-11T10:23:46,630 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'master.xml' for application 'demo-application-1.5.3'
2022-07-11T10:23:46,631 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'page.xml' for application 'demo-application-1.5.3'
2022-07-11T10:23:46,631 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'plugin.xml' for application 'demo-application-1.5.3'
2022-07-11T10:23:46,631 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'messages-demo.properties' for application 'demo-application-1.5.3'
2022-07-11T10:23:46,631 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'mssql/V1.0_script.sql' for application 'demo-application-1.5.3'
2022-07-11T10:23:46,631 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'mysql/V1.0_script.sql' for application 'demo-application-1.5.3'
2022-07-11T10:23:46,631 INFO  [main] org.appng.core.service.CoreService: extracting filebased application demo-application - 1.5.3 to target/ROOT/applications/demo-application
2022-07-11T10:23:46,636 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Application demo-application
2022-07-11T10:23:46,640 INFO  [main] org.appng.core.service.CoreService: creating new permission 'testPermission' for application 'demo-application'
2022-07-11T10:23:46,640 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Permission testPermission
2022-07-11T10:23:46,644 INFO  [main] org.appng.core.service.CoreService: role 'Administrator' already has permission 'output-format.html'
2022-07-11T10:23:46,645 INFO  [main] org.appng.core.service.CoreService: role 'Administrator' already has permission 'output-type.webgui'
2022-07-11T10:23:46,646 WARN  [main] org.appng.core.service.CoreService: the role 'Administrator' references permisson 'logViewer' which does not exist!
2022-07-11T10:23:46,648 INFO  [main] org.appng.core.service.CoreService: role 'Debugger' already has permission 'debug'
2022-07-11T10:23:46,649 INFO  [main] org.appng.core.service.CoreService: added permission 'testPermission' to role 'Debugger'
2022-07-11T10:23:46,650 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Role Debugger
2022-07-11T10:23:46,651 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Role Tester
2022-07-11T10:23:46,653 INFO  [main] org.appng.core.service.CoreService: added permission 'testPermission' to role 'Tester'
2022-07-11T10:23:46,653 INFO  [main] org.appng.core.service.CoreService: creating new role 'Tester' for application 'demo-application'
2022-07-11T10:23:46,655 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.application.demo-application.bar
2022-07-11T10:23:46,655 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.application.demo-application.bar
2022-07-11T10:23:46,658 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Property platform.application.demo-application.clobValue
2022-07-11T10:23:46,658 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Property platform.application.demo-application.foo
2022-07-11T10:23:46,658 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Property platform.site.site-1.application.demo-application.foo
2022-07-11T10:23:46,659 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Role Tester
2022-07-11T10:23:46,659 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Property platform.application.demo-application.bar
2022-07-11T10:23:46,660 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Property platform.site.site-1.application.demo-application.bar
2022-07-11T10:23:46,661 INFO  [main] org.appng.core.service.CoreService: loading properties for application 'demo-application' of site 'site-1'
2022-07-11T10:23:46,663 INFO  [main] org.appng.core.service.CoreService: loading properties for application demo-application
2022-07-11T10:23:46,666 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Repository testrepo
2022-07-11T10:23:46,666 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@240502b9, testMethod = testProvideApplicationUpdate@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-11T10:23:46,668 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@709c4712, testMethod = testProvideApplicationUpdateDelete@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@1dd3457f]; rollback [false]
2022-07-11T10:23:46,684 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1390589151 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:46,691 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1441279022 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:46,697 INFO  [main] org.appng.core.service.CoreService: unlinking application demo-application from site site-1, status of database-connection is NO_DB_SUPPORTED
2022-07-11T10:23:46,697 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform Removed application demo-application from site site-1
2022-07-11T10:23:46,698 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-1.application.demo-application.bar
2022-07-11T10:23:46,699 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-1.application.demo-application.clobValue
2022-07-11T10:23:46,699 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-1.application.demo-application.foo
2022-07-11T10:23:46,707 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Role Administrator
2022-07-11T10:23:46,709 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Role Tester
2022-07-11T10:23:46,718 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Role Debugger
2022-07-11T10:23:46,718 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Permission debug
2022-07-11T10:23:46,718 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Permission output-type.webgui
2022-07-11T10:23:46,718 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Permission output-format.html
2022-07-11T10:23:46,719 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Permission testPermission
2022-07-11T10:23:46,719 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.application.demo-application.bar
2022-07-11T10:23:46,719 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.application.demo-application.clobValue
2022-07-11T10:23:46,720 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.application.demo-application.foo
2022-07-11T10:23:46,720 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Application demo-application
2022-07-11T10:23:46,722 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@709c4712, testMethod = testProvideApplicationUpdateDelete@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-11T10:23:46,724 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@5ff25edf, testMethod = testProvideApplicationWithAdminRole@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@1dd3457f]; rollback [false]
2022-07-11T10:23:46,736 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1167817551 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:46,743 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1796665654 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:46,743 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Repository testrepo
2022-07-11T10:23:46,745 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Group Administrators
2022-07-11T10:23:46,745 INFO  [main] org.appng.core.service.CoreService: retrieving 'demo-application-1.5.4' from repository file:/var/lib/jenkins/workspace/appNG_2.0.x/appng-core/target/test-classes/zip
2022-07-11T10:23:46,757 INFO  [main] org.appng.core.service.CoreService: deploying application demo-application-1.5.4
2022-07-11T10:23:46,758 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Application demo-application
2022-07-11T10:23:46,759 INFO  [main] org.appng.core.service.CoreService: creating new permission 'debug' for application 'demo-application'
2022-07-11T10:23:46,759 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Permission debug
2022-07-11T10:23:46,759 INFO  [main] org.appng.core.service.CoreService: creating new permission 'output-format.html' for application 'demo-application'
2022-07-11T10:23:46,759 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Permission output-format.html
2022-07-11T10:23:46,760 INFO  [main] org.appng.core.service.CoreService: creating new permission 'output-type.webgui' for application 'demo-application'
2022-07-11T10:23:46,760 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Permission output-type.webgui
2022-07-11T10:23:46,760 INFO  [main] org.appng.core.service.CoreService: creating new permission 'testPermission' for application 'demo-application'
2022-07-11T10:23:46,760 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Permission testPermission
2022-07-11T10:23:46,761 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Role Administrator
2022-07-11T10:23:46,762 INFO  [main] org.appng.core.service.CoreService: added permission 'output-format.html' to role 'Administrator'
2022-07-11T10:23:46,763 INFO  [main] org.appng.core.service.CoreService: added permission 'output-type.webgui' to role 'Administrator'
2022-07-11T10:23:46,764 WARN  [main] org.appng.core.service.CoreService: the role 'Administrator' references permisson 'logViewer' which does not exist!
2022-07-11T10:23:46,764 INFO  [main] org.appng.core.service.CoreService: creating new role 'Administrator' for application 'demo-application'
2022-07-11T10:23:46,764 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Role Debugger
2022-07-11T10:23:46,765 INFO  [main] org.appng.core.service.CoreService: added permission 'debug' to role 'Debugger'
2022-07-11T10:23:46,766 INFO  [main] org.appng.core.service.CoreService: added permission 'testPermission' to role 'Debugger'
2022-07-11T10:23:46,766 INFO  [main] org.appng.core.service.CoreService: creating new role 'Debugger' for application 'demo-application'
2022-07-11T10:23:46,766 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Role Tester
2022-07-11T10:23:46,768 INFO  [main] org.appng.core.service.CoreService: added permission 'testPermission' to role 'Tester'
2022-07-11T10:23:46,768 INFO  [main] org.appng.core.service.CoreService: creating new role 'Tester' for application 'demo-application'
2022-07-11T10:23:46,770 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.application.demo-application.foo
2022-07-11T10:23:46,771 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.application.demo-application.bar
2022-07-11T10:23:46,771 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.application.demo-application.clobValue
2022-07-11T10:23:46,773 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Group Administrators
2022-07-11T10:23:46,774 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Role Administrator
2022-07-11T10:23:46,774 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Role Debugger
2022-07-11T10:23:46,775 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Role Tester
2022-07-11T10:23:46,778 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'application.xml' for application 'demo-application-1.5.4'
2022-07-11T10:23:46,778 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'beans.xml' for application 'demo-application-1.5.4'
2022-07-11T10:23:46,779 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'datasources.xml' for application 'demo-application-1.5.4'
2022-07-11T10:23:46,779 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'events.xml' for application 'demo-application-1.5.4'
2022-07-11T10:23:46,779 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'master.xml' for application 'demo-application-1.5.4'
2022-07-11T10:23:46,779 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'page.xml' for application 'demo-application-1.5.4'
2022-07-11T10:23:46,779 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'plugin.xml' for application 'demo-application-1.5.4'
2022-07-11T10:23:46,780 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'messages-demo.properties' for application 'demo-application-1.5.4'
2022-07-11T10:23:46,780 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'mssql/V1.0_script.sql' for application 'demo-application-1.5.4'
2022-07-11T10:23:46,780 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'mysql/V1.0_script.sql' for application 'demo-application-1.5.4'
2022-07-11T10:23:46,780 INFO  [main] org.appng.core.service.CoreService: extracting filebased application demo-application - 1.5.4 to target/ROOT/applications/demo-application
2022-07-11T10:23:46,787 INFO  [main] org.appng.core.service.CoreService: role 'Administrator' already has permission 'output-format.html'
2022-07-11T10:23:46,788 INFO  [main] org.appng.core.service.CoreService: role 'Administrator' already has permission 'output-type.webgui'
2022-07-11T10:23:46,788 WARN  [main] org.appng.core.service.CoreService: the role 'Administrator' references permisson 'logViewer' which does not exist!
2022-07-11T10:23:46,790 INFO  [main] org.appng.core.service.CoreService: role 'Debugger' already has permission 'debug'
2022-07-11T10:23:46,791 INFO  [main] org.appng.core.service.CoreService: role 'Debugger' already has permission 'testPermission'
2022-07-11T10:23:46,793 INFO  [main] org.appng.core.service.CoreService: role 'Tester' already has permission 'testPermission'
2022-07-11T10:23:46,797 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@5ff25edf, testMethod = testProvideApplicationWithAdminRole@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-11T10:23:46,799 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@31cd9f40, testMethod = testReloadRepository@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@1dd3457f]; rollback [false]
2022-07-11T10:23:46,810 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#2009710957 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:46,816 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#930047472 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:46,820 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@31cd9f40, testMethod = testReloadRepository@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-11T10:23:46,822 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@65810055, testMethod = testResetPassword@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@1dd3457f]; rollback [false]
2022-07-11T10:23:46,834 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#541275835 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:46,840 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1249154695 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:47,673 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject subject-3
2022-07-11T10:23:47,674 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@65810055, testMethod = testResetPassword@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-11T10:23:47,675 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@74929c6e, testMethod = testRestoreSubject@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@1dd3457f]; rollback [false]
2022-07-11T10:23:47,687 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#305966412 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:47,694 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#84494953 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:47,698 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@74929c6e, testMethod = testRestoreSubject@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-11T10:23:47,700 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@74e344c8, testMethod = testSaveProperties@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@1dd3457f]; rollback [false]
2022-07-11T10:23:47,711 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#470007237 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:47,717 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1679956474 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:47,718 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property foobaz.a
2022-07-11T10:23:47,718 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property foobaz.b
2022-07-11T10:23:47,720 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@74e344c8, testMethod = testSaveProperties@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-11T10:23:47,722 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@319ea6be, testMethod = testSaveProperty@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@1dd3457f]; rollback [false]
2022-07-11T10:23:47,734 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1349035154 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:47,742 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#828225869 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:47,742 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property prop1
2022-07-11T10:23:47,744 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@319ea6be, testMethod = testSaveProperty@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-11T10:23:47,746 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@7f054ad, testMethod = testUnlinkApplicationFromSiteIntegerString@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@1dd3457f]; rollback [false]
2022-07-11T10:23:47,759 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1762032706 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:47,766 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1004052080 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:47,769 INFO  [main] org.appng.core.service.CoreService: unlinking application manager from site site-1, status of database-connection is NO_DB_SUPPORTED
2022-07-11T10:23:47,769 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform Removed application manager from site site-1
2022-07-11T10:23:47,770 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-1.application.manager.foo
2022-07-11T10:23:47,770 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-1.application.manager.foobar
2022-07-11T10:23:47,771 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@7f054ad, testMethod = testUnlinkApplicationFromSiteIntegerString@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-11T10:23:47,773 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@6a79ff4, testMethod = testUpdatePassword@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@1dd3457f]; rollback [false]
2022-07-11T10:23:47,784 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#930616397 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:47,790 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1748443591 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:48,620 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject subject-3
2022-07-11T10:23:48,620 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@6a79ff4, testMethod = testUpdatePassword@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-11T10:23:48,621 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@3291849e, testMethod = testUpdatePasswordFail@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@1dd3457f]; rollback [false]
2022-07-11T10:23:48,633 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1570385458 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:48,639 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1951320915 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:48,641 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@4d376558 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@3291849e, testMethod = testUpdatePasswordFail@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7118d9dc testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-11T10:23:48,643 INFO  [main] org.springframework.orm.jpa.LocalEntityManagerFactoryBean: Closing JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2022-07-11T10:23:48,643 INFO  [main] org.hibernate.orm.connections.pooling: HHH10001008: Cleaning up connection pool [jdbc:hsqldb:mem:hsql-testdb]
[WARNING] Tests run: 84, Failures: 0, Errors: 0, Skipped: 20, Time elapsed: 13.394 s - in org.appng.core.service.CoreServiceTest
[INFO] Running org.appng.core.service.LdapServiceTest
2022-07-11T10:23:48,671 INFO  [main] org.appng.core.service.LdapService: Found 2 member(s) for group 'cn=logingroup,ou=groups,l=egypt'
2022-07-11T10:23:48,675 INFO  [main] org.appng.core.service.LdapService: Unknown keyword 'bogus' in site property 'testLoginUserSucces.ldapPrincipalScheme'. Falling back to plain username 'aziz' as principal.
2022-07-11T10:23:48,681 INFO  [main] org.appng.core.service.LdapService: LDAP operation failed on host 'ldaps://testLoginUserFailure:129' with principal 'aziz' (javax.naming.NamingException: Sorry kiddo. You got the gift, but it looks like you're waiting for something.)
2022-07-11T10:23:48,681 INFO  [main] org.appng.core.service.LdapService: LDAP operation failed on host 'ldaps://testLoginUserFailure:139' with principal 'aziz' (javax.naming.NamingException: Ah ah ah, you didn't say the magic word!)
2022-07-11T10:23:48,683 INFO  [main] org.appng.core.service.LdapService: User 'aziz' (uid=aziz,ou=users,l=egypt) is member of 'cn=logingroup,ou=groups,l=egypt'
2022-07-11T10:23:48,684 INFO  [main] org.appng.core.service.LdapService: User 'aZiZ' (uid=aziz,ou=users,l=egypt) is member of 'cn=logingroup,ou=groups,l=egypt'
2022-07-11T10:23:48,686 INFO  [main] org.appng.core.service.LdapService: User 'aZiZ' (uid=aziz,ou=users,l=egypt) is member of 'cn=logingroup,ou=groups,l=egypt'
[INFO] Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.034 s - in org.appng.core.service.LdapServiceTest
[INFO] Running org.appng.core.service.InitializerServiceTest
2022-07-11T10:23:48,691 INFO  [main] org.springframework.test.context.support.DefaultTestContextBootstrapper: Loaded default TestExecutionListener class names from location [META-INF/spring.factories]: [org.springframework.test.context.web.ServletTestExecutionListener, org.springframework.test.context.support.DirtiesContextBeforeModesTestExecutionListener, org.springframework.test.context.event.ApplicationEventsTestExecutionListener, org.springframework.test.context.support.DependencyInjectionTestExecutionListener, org.springframework.test.context.support.DirtiesContextTestExecutionListener, org.springframework.test.context.transaction.TransactionalTestExecutionListener, org.springframework.test.context.jdbc.SqlScriptsTestExecutionListener, org.springframework.test.context.event.EventPublishingTestExecutionListener]
2022-07-11T10:23:48,691 INFO  [main] org.springframework.test.context.support.DefaultTestContextBootstrapper: Using TestExecutionListeners: [org.springframework.test.context.web.ServletTestExecutionListener@6ba4506d, org.springframework.test.context.support.DirtiesContextBeforeModesTestExecutionListener@4d6dc311, org.springframework.test.context.event.ApplicationEventsTestExecutionListener@298bd15a, org.springframework.test.context.support.DependencyInjectionTestExecutionListener@31ea6273, org.springframework.test.context.support.DirtiesContextTestExecutionListener@78046b1b, org.springframework.test.context.transaction.TransactionalTestExecutionListener@5b525a41, org.springframework.test.context.jdbc.SqlScriptsTestExecutionListener@2ca45170, org.springframework.test.context.event.EventPublishingTestExecutionListener@4ebf476d]
2022-07-11T10:23:48,749 INFO  [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data JPA repositories in DEFAULT mode.
2022-07-11T10:23:48,773 INFO  [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 23 ms. Found 15 JPA repository interfaces.
2022-07-11T10:23:48,774 INFO  [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data JPA repositories in DEFAULT mode.
2022-07-11T10:23:48,794 INFO  [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 20 ms. Found 15 JPA repository interfaces.
2022-07-11T10:23:48,807 INFO  [main] org.hibernate.jpa.internal.util.LogHelper: HHH000204: Processing PersistenceUnitInfo [name: hsql-testdb]
2022-07-11T10:23:48,842 WARN  [main] org.hibernate.orm.connections.pooling: HHH10001002: Using Hibernate built-in connection pool (not for production use!)
2022-07-11T10:23:48,842 INFO  [main] org.hibernate.orm.connections.pooling: HHH10001005: using driver [org.hsqldb.jdbc.JDBCDriver] at URL [jdbc:hsqldb:mem:hsql-testdb]
2022-07-11T10:23:48,842 INFO  [main] org.hibernate.orm.connections.pooling: HHH10001001: Connection properties: {password=****, user=sa}
2022-07-11T10:23:48,842 INFO  [main] org.hibernate.orm.connections.pooling: HHH10001003: Autocommit mode: false
2022-07-11T10:23:48,842 INFO  [main] org.hibernate.engine.jdbc.connections.internal.DriverManagerConnectionProviderImpl: HHH000115: Hibernate connection pool size: 20 (min=1)
2022-07-11T10:23:48,843 INFO  [main] org.hibernate.dialect.Dialect : HHH000400: Using dialect: org.appng.persistence.hibernate.dialect.HSQLDialect
2022-07-11T10:23:48,847 INFO  [main] org.hibernate.envers.boot.internal.EnversServiceImpl: Envers integration enabled? : true
2022-07-11T10:23:49,016 INFO  [main] org.hibernate.orm.connections.access: HHH10001501: Connection obtained from JdbcConnectionAccess [org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess@34166329] for (non-JTA) DDL execution was not in auto-commit mode; the Connection 'local transaction' will be committed and the Connection will be set into auto-commit mode.
2022-07-11T10:23:49,020 INFO  [main] org.hibernate.orm.connections.access: HHH10001501: Connection obtained from JdbcConnectionAccess [org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess@49ebacd0] for (non-JTA) DDL execution was not in auto-commit mode; the Connection 'local transaction' will be committed and the Connection will be set into auto-commit mode.
2022-07-11T10:23:49,036 INFO  [main] org.hibernate.engine.transaction.jta.platform.internal.JtaPlatformInitiator: HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.NoJtaPlatform]
2022-07-11T10:23:49,037 INFO  [main] org.springframework.orm.jpa.LocalEntityManagerFactoryBean: Initialized JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2022-07-11T10:23:49,038 INFO  [main] org.appng.core.domain.PlatformEventListener: Using application context appNG platform context, started on Mon Jul 11 10:23:48 CEST 2022
2022-07-11T10:23:49,454 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@55e26faf testClass = InitializerServiceTest, testInstance = org.appng.core.service.InitializerServiceTest@427e094d, testMethod = testInitPlatform@InitializerServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@15491c2a testClass = InitializerServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.InitializerServiceTest]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@6b82b9e2]; rollback [false]
2022-07-11T10:23:49,456 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1284222754 for site manager with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:49,458 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Subject subject-3
2022-07-11T10:23:49,461 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Site site-1
2022-07-11T10:23:49,461 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Resource application.xml of application application1
2022-07-11T10:23:49,463 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Application application1
2022-07-11T10:23:49,463 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Role dummy
2022-07-11T10:23:49,464 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Permission permission-1
2022-07-11T10:23:49,464 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Group group-1
2022-07-11T10:23:49,481 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.messagingEnabled
2022-07-11T10:23:49,482 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.filebasedDeployment
2022-07-11T10:23:49,482 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.jspFileType
2022-07-11T10:23:49,482 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.repositoryTrustStorePassword
2022-07-11T10:23:49,482 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.platformRootPath
2022-07-11T10:23:49,482 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.manageDatabases
2022-07-11T10:23:49,483 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.inactiveLockPeriod
2022-07-11T10:23:49,483 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.appngData
2022-07-11T10:23:49,483 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.cachePlatformFolder
2022-07-11T10:23:49,483 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.monitoringPath
2022-07-11T10:23:49,483 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.repositoryCert
2022-07-11T10:23:49,483 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.defaultTemplate
2022-07-11T10:23:49,484 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.devMode
2022-07-11T10:23:49,484 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.logfile
2022-07-11T10:23:49,484 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.xssAllowedTags
2022-07-11T10:23:49,484 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.mailDisabled
2022-07-11T10:23:49,484 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.formatOutput
2022-07-11T10:23:49,485 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.cacheConfig
2022-07-11T10:23:49,485 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.sharedSecret
2022-07-11T10:23:49,485 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.repositoryPath
2022-07-11T10:23:49,485 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.repositoryVerifySignature
2022-07-11T10:23:49,485 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.repositorySignature
2022-07-11T10:23:49,486 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.sessionFilter
2022-07-11T10:23:49,486 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.cacheApplicationFolder
2022-07-11T10:23:49,486 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.writeDebugFiles
2022-07-11T10:23:49,486 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.repositoryDefaultDigest
2022-07-11T10:23:49,486 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.monitorPerformance
2022-07-11T10:23:49,486 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.mdcEnabled
2022-07-11T10:23:49,486 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.vHostMode
2022-07-11T10:23:49,487 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.templateFolder
2022-07-11T10:23:49,487 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.maxLoginAttempts
2022-07-11T10:23:49,487 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.locale
2022-07-11T10:23:49,487 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.sessionTimeout
2022-07-11T10:23:49,487 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.cleanTempFolderOnStartup
2022-07-11T10:23:49,487 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.encoding
2022-07-11T10:23:49,488 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.maxUploadSize
2022-07-11T10:23:49,488 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.templatePrefix
2022-07-11T10:23:49,488 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.repositoryTrustStore
2022-07-11T10:23:49,488 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.imageMagickPath
2022-07-11T10:23:49,488 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.databasePrefix
2022-07-11T10:23:49,488 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.cacheFolder
2022-07-11T10:23:49,489 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.messagingGroupAddress
2022-07-11T10:23:49,489 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.xssProtect
2022-07-11T10:23:49,489 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.mailHost
2022-07-11T10:23:49,489 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.timeZone
2022-07-11T10:23:49,489 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.cacheImageFolder
2022-07-11T10:23:49,489 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.messagingReceiver
2022-07-11T10:23:49,489 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.messagingGroupPort
2022-07-11T10:23:49,490 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.csrfFilterEnabled
2022-07-11T10:23:49,490 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.mailPort
2022-07-11T10:23:49,490 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.uploadDir
2022-07-11T10:23:49,490 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.applicationDir
2022-07-11T10:23:49,490 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.databaseValidationPeriod
2022-07-11T10:23:49,491 INFO  [main] org.appng.core.service.InitializerService: Caching uses HazelcastInstance{name='test', node=[10.102.4.103]:5702}
2022-07-11T10:23:49,491 INFO  [main] org.appng.api.messaging.Messaging: messaging is disabled
2022-07-11T10:23:49,491 INFO  [main] org.appng.core.service.InitializerService: applications are located at /var/lib/jenkins/workspace/appNG_2.0.x/appng-core/target/test-classes/applications or in the database
2022-07-11T10:23:49,507 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject subject-3
2022-07-11T10:23:49,508 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Resource application.xml of application application1
2022-07-11T10:23:49,509 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Role dummy
2022-07-11T10:23:49,516 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.ldapPrincipalScheme
2022-07-11T10:23:49,517 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.cacheTimeouts
2022-07-11T10:23:49,517 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.ldapStartTls
2022-07-11T10:23:49,517 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.ldapIdAttribute
2022-07-11T10:23:49,517 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.errorPages
2022-07-11T10:23:49,517 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.host
2022-07-11T10:23:49,517 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.defaultPage
2022-07-11T10:23:49,518 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.csrfProtectedPaths
2022-07-11T10:23:49,518 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.authLogoutActionName
2022-07-11T10:23:49,518 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.ldapDisabled
2022-07-11T10:23:49,518 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.serviceOutputFormat
2022-07-11T10:23:49,518 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.tagPrefix
2022-07-11T10:23:49,518 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.name
2022-07-11T10:23:49,519 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.csrfProtectionEnabled
2022-07-11T10:23:49,519 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.ldapUser
2022-07-11T10:23:49,519 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.timeZone
2022-07-11T10:23:49,519 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.authLogoutRef
2022-07-11T10:23:49,519 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.encoding
2022-07-11T10:23:49,520 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.authApplication
2022-07-11T10:23:49,520 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.cacheEnabled
2022-07-11T10:23:49,520 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.authLoginPage
2022-07-11T10:23:49,520 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.searchChunkSize
2022-07-11T10:23:49,520 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.template
2022-07-11T10:23:49,520 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.cacheTimeoutsAntStyle
2022-07-11T10:23:49,520 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.ldapUserBaseDn
2022-07-11T10:23:49,521 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.serviceOutputType
2022-07-11T10:23:49,521 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.sessionTrackingEnabled
2022-07-11T10:23:49,521 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.supportedLanguages
2022-07-11T10:23:49,521 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.mailPort
2022-07-11T10:23:49,521 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.errorPage
2022-07-11T10:23:49,521 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.service-path
2022-07-11T10:23:49,522 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.indexFileSystemQueueSize
2022-07-11T10:23:49,522 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.siteRootDir
2022-07-11T10:23:49,522 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.cacheTimeToLive
2022-07-11T10:23:49,522 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.indexConfig
2022-07-11T10:23:49,522 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.ldapHost
2022-07-11T10:23:49,523 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.searchMaxHits
2022-07-11T10:23:49,523 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.mailHost
2022-07-11T10:23:49,523 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.cacheClearOnShutdown
2022-07-11T10:23:49,523 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.indexTimeout
2022-07-11T10:23:49,523 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.jdbcLogPerformance
2022-07-11T10:23:49,523 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.DatasourceConfigurer
2022-07-11T10:23:49,524 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.jdbcMaxLifetime
2022-07-11T10:23:49,524 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.cacheExceptions
2022-07-11T10:23:49,524 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.ldapDomain
2022-07-11T10:23:49,524 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.csrfProtectedMethods
2022-07-11T10:23:49,524 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.defaultApplication
2022-07-11T10:23:49,524 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.jdbcValidationTimeout
2022-07-11T10:23:49,525 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.documentDir
2022-07-11T10:23:49,525 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.allowSkipRender
2022-07-11T10:23:49,525 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.defaultPageSize
2022-07-11T10:23:49,525 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.cacheStatistics
2022-07-11T10:23:49,525 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.authLogoutPage
2022-07-11T10:23:49,525 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.ldapPassword
2022-07-11T10:23:49,526 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.indexFileTypes
2022-07-11T10:23:49,526 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.assetsDir
2022-07-11T10:23:49,526 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.authLoginRef
2022-07-11T10:23:49,526 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.locale
2022-07-11T10:23:49,526 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.ldapGroupBaseDn
2022-07-11T10:23:49,526 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.indexDir
2022-07-11T10:23:49,526 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.wwwDir
2022-07-11T10:23:49,527 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.enforcePrimaryDomain
2022-07-11T10:23:49,527 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.supportReloadFile
2022-07-11T10:23:49,527 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.indexQueueSize
2022-07-11T10:23:49,527 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.appendTabId
2022-07-11T10:23:49,527 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.mailDisabled
2022-07-11T10:23:49,527 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.authLogoutActionValue
2022-07-11T10:23:49,528 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.manager-path
2022-07-11T10:23:49,528 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.xssExceptions
2022-07-11T10:23:49,528 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.rewriteConfig
2022-07-11T10:23:49,528 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.jdbcConnectionTimeout
2022-07-11T10:23:49,530 INFO  [main] org.appng.core.service.InitializerService: ==========================================================================================
2022-07-11T10:23:49,534 INFO  [main] org.appng.core.service.InitializerService: loading site site-1 (host-1)
2022-07-11T10:23:49,534 INFO  [main] org.appng.core.service.InitializerService: loading applications for site site-1
2022-07-11T10:23:49,536 INFO  [main] org.appng.core.model.CacheProvider: cleaning /var/lib/jenkins/workspace/appNG_2.0.x/appng-core/target/test-classes/WEB-INF/cache/platform/site-1
2022-07-11T10:23:49,537 INFO  [main] org.appng.core.model.CacheProvider: cleaning /var/lib/jenkins/workspace/appNG_2.0.x/appng-core/target/test-classes/WEB-INF/cache/application/site-1
2022-07-11T10:23:49,559 INFO  [main] org.appng.core.service.TemplateService: copying template from /var/lib/jenkins/workspace/appNG_2.0.x/appng-core/target/test-classes/template/appng to /var/lib/jenkins/workspace/appNG_2.0.x/appng-core/target/test-classes/repository/site-1/www/template
2022-07-11T10:23:49,560 INFO  [main] org.appng.core.service.CacheService: No cache found, can not remove elements starting with /template
2022-07-11T10:23:49,561 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#288725659 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:49,561 INFO  [main] org.appng.core.service.InitializerService: SiteClassLoader#288725659 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156
2022-07-11T10:23:49,562 INFO  [main] org.appng.core.service.InitializerService: started site thread [appng-indexthread-site-1] with runnable of type org.appng.search.indexer.DocumentIndexer
2022-07-11T10:23:49,570 INFO  [main] org.appng.core.service.InitializerService: loading site site-1 completed in 39ms
2022-07-11T10:23:49,570 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform Loaded site site-1
2022-07-11T10:23:49,570 INFO  [main] org.appng.core.service.InitializerService: ==========================================================================================
2022-07-11T10:23:54,590 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@55e26faf testClass = InitializerServiceTest, testInstance = org.appng.core.service.InitializerServiceTest@427e094d, testMethod = testInitPlatform@InitializerServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@15491c2a testClass = InitializerServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.InitializerServiceTest]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-11T10:23:54,592 INFO  [main] org.springframework.orm.jpa.LocalEntityManagerFactoryBean: Closing JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2022-07-11T10:23:54,593 INFO  [main] org.hibernate.orm.connections.pooling: HHH10001008: Cleaning up connection pool [jdbc:hsqldb:mem:hsql-testdb]
[WARNING] Tests run: 2, Failures: 0, Errors: 0, Skipped: 1, Time elapsed: 5.903 s - in org.appng.core.service.InitializerServiceTest
[INFO] Running org.appng.core.service.SubjectMustChangePasswordTest
2022-07-11T10:23:54,597 INFO  [main] org.springframework.test.context.support.DefaultTestContextBootstrapper: Loaded default TestExecutionListener class names from location [META-INF/spring.factories]: [org.springframework.test.context.web.ServletTestExecutionListener, org.springframework.test.context.support.DirtiesContextBeforeModesTestExecutionListener, org.springframework.test.context.event.ApplicationEventsTestExecutionListener, org.springframework.test.context.support.DependencyInjectionTestExecutionListener, org.springframework.test.context.support.DirtiesContextTestExecutionListener, org.springframework.test.context.transaction.TransactionalTestExecutionListener, org.springframework.test.context.jdbc.SqlScriptsTestExecutionListener, org.springframework.test.context.event.EventPublishingTestExecutionListener]
2022-07-11T10:23:54,598 INFO  [main] org.springframework.test.context.support.DefaultTestContextBootstrapper: Using TestExecutionListeners: [org.springframework.test.context.web.ServletTestExecutionListener@7cbe750f, org.springframework.test.context.support.DirtiesContextBeforeModesTestExecutionListener@65c54845, org.springframework.test.context.event.ApplicationEventsTestExecutionListener@5fda057, org.springframework.test.context.support.DependencyInjectionTestExecutionListener@5122ecd8, org.springframework.test.context.support.DirtiesContextTestExecutionListener@5e3bedfe, org.springframework.test.context.transaction.TransactionalTestExecutionListener@11f3111c, org.springframework.test.context.jdbc.SqlScriptsTestExecutionListener@79e4e46d, org.springframework.test.context.event.EventPublishingTestExecutionListener@3f6683a5]
2022-07-11T10:23:54,666 INFO  [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data JPA repositories in DEFAULT mode.
2022-07-11T10:23:54,690 INFO  [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 23 ms. Found 15 JPA repository interfaces.
2022-07-11T10:23:54,691 INFO  [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data JPA repositories in DEFAULT mode.
2022-07-11T10:23:54,711 INFO  [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 20 ms. Found 15 JPA repository interfaces.
2022-07-11T10:23:54,724 INFO  [main] org.hibernate.jpa.internal.util.LogHelper: HHH000204: Processing PersistenceUnitInfo [name: hsql-testdb]
2022-07-11T10:23:54,758 WARN  [main] org.hibernate.orm.connections.pooling: HHH10001002: Using Hibernate built-in connection pool (not for production use!)
2022-07-11T10:23:54,758 INFO  [main] org.hibernate.orm.connections.pooling: HHH10001005: using driver [org.hsqldb.jdbc.JDBCDriver] at URL [jdbc:hsqldb:mem:hsql-testdb]
2022-07-11T10:23:54,759 INFO  [main] org.hibernate.orm.connections.pooling: HHH10001001: Connection properties: {password=****, user=sa}
2022-07-11T10:23:54,759 INFO  [main] org.hibernate.orm.connections.pooling: HHH10001003: Autocommit mode: false
2022-07-11T10:23:54,759 INFO  [main] org.hibernate.engine.jdbc.connections.internal.DriverManagerConnectionProviderImpl: HHH000115: Hibernate connection pool size: 20 (min=1)
2022-07-11T10:23:54,759 INFO  [main] org.hibernate.dialect.Dialect : HHH000400: Using dialect: org.appng.persistence.hibernate.dialect.HSQLDialect
2022-07-11T10:23:54,764 INFO  [main] org.hibernate.envers.boot.internal.EnversServiceImpl: Envers integration enabled? : true
2022-07-11T10:23:54,960 INFO  [main] org.hibernate.orm.connections.access: HHH10001501: Connection obtained from JdbcConnectionAccess [org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess@6dd53f31] for (non-JTA) DDL execution was not in auto-commit mode; the Connection 'local transaction' will be committed and the Connection will be set into auto-commit mode.
2022-07-11T10:23:54,964 INFO  [main] org.hibernate.orm.connections.access: HHH10001501: Connection obtained from JdbcConnectionAccess [org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess@1bb127f8] for (non-JTA) DDL execution was not in auto-commit mode; the Connection 'local transaction' will be committed and the Connection will be set into auto-commit mode.
2022-07-11T10:23:54,981 INFO  [main] org.hibernate.engine.transaction.jta.platform.internal.JtaPlatformInitiator: HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.NoJtaPlatform]
2022-07-11T10:23:54,981 INFO  [main] org.springframework.orm.jpa.LocalEntityManagerFactoryBean: Initialized JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2022-07-11T10:23:54,994 INFO  [main] org.appng.core.domain.PlatformEventListener: Using application context appNG platform context, started on Mon Jul 11 10:23:54 CEST 2022
2022-07-11T10:23:55,545 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@7006fdb8 testClass = SubjectMustChangePasswordTest, testInstance = org.appng.core.service.SubjectMustChangePasswordTest@4b08fbcc, testMethod = testMustChangePassword@SubjectMustChangePasswordTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@66e1c0f0 testClass = SubjectMustChangePasswordTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@1d5819f1]; rollback [false]
2022-07-11T10:23:55,572 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.passwordMaxValidity
2022-07-11T10:23:55,572 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.messagingEnabled
2022-07-11T10:23:55,572 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.filebasedDeployment
2022-07-11T10:23:55,572 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.jspFileType
2022-07-11T10:23:55,572 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.repositoryTrustStorePassword
2022-07-11T10:23:55,573 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.platformRootPath
2022-07-11T10:23:55,573 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.manageDatabases
2022-07-11T10:23:55,573 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.inactiveLockPeriod
2022-07-11T10:23:55,573 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.appngData
2022-07-11T10:23:55,573 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.cachePlatformFolder
2022-07-11T10:23:55,573 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.monitoringPath
2022-07-11T10:23:55,573 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.repositoryCert
2022-07-11T10:23:55,573 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.defaultTemplate
2022-07-11T10:23:55,574 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.devMode
2022-07-11T10:23:55,574 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.logfile
2022-07-11T10:23:55,574 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.xssAllowedTags
2022-07-11T10:23:55,574 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.mailDisabled
2022-07-11T10:23:55,574 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.formatOutput
2022-07-11T10:23:55,574 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.cacheConfig
2022-07-11T10:23:55,574 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.sharedSecret
2022-07-11T10:23:55,575 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.repositoryPath
2022-07-11T10:23:55,575 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.repositoryVerifySignature
2022-07-11T10:23:55,575 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.repositorySignature
2022-07-11T10:23:55,575 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.sessionFilter
2022-07-11T10:23:55,575 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.cacheApplicationFolder
2022-07-11T10:23:55,575 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.writeDebugFiles
2022-07-11T10:23:55,575 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.repositoryDefaultDigest
2022-07-11T10:23:55,576 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.monitorPerformance
2022-07-11T10:23:55,576 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.mdcEnabled
2022-07-11T10:23:55,576 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.vHostMode
2022-07-11T10:23:55,576 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.templateFolder
2022-07-11T10:23:55,576 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.maxLoginAttempts
2022-07-11T10:23:55,576 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.locale
2022-07-11T10:23:55,576 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.sessionTimeout
2022-07-11T10:23:55,576 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.cleanTempFolderOnStartup
2022-07-11T10:23:55,577 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.encoding
2022-07-11T10:23:55,577 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.maxUploadSize
2022-07-11T10:23:55,577 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.templatePrefix
2022-07-11T10:23:55,577 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.repositoryTrustStore
2022-07-11T10:23:55,577 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.imageMagickPath
2022-07-11T10:23:55,577 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.databasePrefix
2022-07-11T10:23:55,577 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.cacheFolder
2022-07-11T10:23:55,577 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.messagingGroupAddress
2022-07-11T10:23:55,577 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.xssProtect
2022-07-11T10:23:55,578 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.mailHost
2022-07-11T10:23:55,578 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.timeZone
2022-07-11T10:23:55,578 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.cacheImageFolder
2022-07-11T10:23:55,578 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.messagingReceiver
2022-07-11T10:23:55,578 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.messagingGroupPort
2022-07-11T10:23:55,578 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.forceChangePassword
2022-07-11T10:23:55,578 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.csrfFilterEnabled
2022-07-11T10:23:55,579 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.mailPort
2022-07-11T10:23:55,579 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.uploadDir
2022-07-11T10:23:55,579 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.applicationDir
2022-07-11T10:23:55,579 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.databaseValidationPeriod
2022-07-11T10:23:55,583 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Subject shady
2022-07-11T10:23:55,599 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject shady
2022-07-11T10:23:55,600 INFO  [main] org.appng.core.service.CoreService: successfully logged in user 'shady'
2022-07-11T10:23:55,600 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform logged in
2022-07-11T10:23:55,602 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject shady
2022-07-11T10:23:55,605 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject shady
2022-07-11T10:23:55,605 INFO  [main] org.appng.core.service.CoreService: successfully logged in user 'shady'
2022-07-11T10:23:55,605 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform logged in
2022-07-11T10:23:55,607 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject shady
2022-07-11T10:23:55,609 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform User shady must change password (has not been changed since more than 3 days).
2022-07-11T10:23:55,610 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject shady
2022-07-11T10:23:55,611 INFO  [main] org.appng.core.service.CoreService: successfully logged in user 'shady'
2022-07-11T10:23:55,611 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform logged in
2022-07-11T10:23:55,613 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@7006fdb8 testClass = SubjectMustChangePasswordTest, testInstance = org.appng.core.service.SubjectMustChangePasswordTest@4b08fbcc, testMethod = testMustChangePassword@SubjectMustChangePasswordTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@66e1c0f0 testClass = SubjectMustChangePasswordTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-11T10:23:55,614 INFO  [main] org.springframework.orm.jpa.LocalEntityManagerFactoryBean: Closing JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2022-07-11T10:23:55,614 INFO  [main] org.hibernate.orm.connections.pooling: HHH10001008: Cleaning up connection pool [jdbc:hsqldb:mem:hsql-testdb]
[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.018 s - in org.appng.core.service.SubjectMustChangePasswordTest
[INFO] Running org.appng.core.service.HsqlStarterTest
2022-07-11T10:23:55,620 INFO  [Time-limited test] org.appng.core.service.HsqlStarter: starting HSQL Server 2.5.0 at /var/lib/jenkins/workspace/appNG_2.0.x/appng-core/target/appNG/WEB-INF/database/appng on port 9001
2022-07-11T10:23:55,642 INFO  [HSQLDB Server @337267d4] hsqldb.db.HSQLDB81EC5B9BF2.ENGINE: Checkpoint start
2022-07-11T10:23:55,642 INFO  [HSQLDB Server @337267d4] hsqldb.db.HSQLDB81EC5B9BF2.ENGINE: checkpointClose start
2022-07-11T10:23:55,660 INFO  [HSQLDB Server @337267d4] hsqldb.db.HSQLDB81EC5B9BF2.ENGINE: checkpointClose synched
2022-07-11T10:23:55,665 INFO  [HSQLDB Server @337267d4] hsqldb.db.HSQLDB81EC5B9BF2.ENGINE: checkpointClose script done
2022-07-11T10:23:55,676 INFO  [HSQLDB Server @337267d4] hsqldb.db.HSQLDB81EC5B9BF2.ENGINE: checkpointClose end
2022-07-11T10:23:55,676 INFO  [HSQLDB Server @337267d4] hsqldb.db.HSQLDB81EC5B9BF2.ENGINE: Checkpoint end - txts: 1
2022-07-11T10:23:55,825 INFO  [Time-limited test] org.appng.core.service.HsqlStarter: shutting down HSQL Server 2.5.0 at /var/lib/jenkins/workspace/appNG_2.0.x/appng-core/target/appNG/WEB-INF/database/appng on port 9001
2022-07-11T10:23:55,955 INFO  [HSQLDB Connection @d94d9d8] hsqldb.db.HSQLDB81EC5B9BF2.ENGINE: Database closed
[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.543 s - in org.appng.core.service.HsqlStarterTest
[INFO] Running org.appng.core.service.SiteClassLoaderBuilderTest
2022-07-11T10:23:56,164 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#245299380 for site localhost with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 s - in org.appng.core.service.SiteClassLoaderBuilderTest
[INFO] Running org.appng.core.service.ApplicationArchiveProcessorTest
2022-07-11T10:23:56,172 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'application.xml' for application 'demo-application-null'
2022-07-11T10:23:56,172 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'beans.xml' for application 'demo-application-null'
2022-07-11T10:23:56,172 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'datasources.xml' for application 'demo-application-null'
2022-07-11T10:23:56,173 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'events.xml' for application 'demo-application-null'
2022-07-11T10:23:56,173 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'master.xml' for application 'demo-application-null'
2022-07-11T10:23:56,173 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'page.xml' for application 'demo-application-null'
2022-07-11T10:23:56,173 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'plugin.xml' for application 'demo-application-null'
2022-07-11T10:23:56,173 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'messages-demo.properties' for application 'demo-application-null'
2022-07-11T10:23:56,173 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'mssql/V1.0_script.sql' for application 'demo-application-null'
2022-07-11T10:23:56,174 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'mysql/V1.0_script.sql' for application 'demo-application-null'
application.xml
beans.xml
datasources.xml
events.xml
master.xml
page.xml
plugin.xml
messages-demo.properties
mssql/V1.0_script.sql
mysql/V1.0_script.sql
[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 s - in org.appng.core.service.ApplicationArchiveProcessorTest
[INFO] Running org.appng.core.service.TemplateServiceTest
2022-07-11T10:23:56,180 INFO  [main] org.springframework.test.context.support.DefaultTestContextBootstrapper: Loaded default TestExecutionListener class names from location [META-INF/spring.factories]: [org.springframework.test.context.web.ServletTestExecutionListener, org.springframework.test.context.support.DirtiesContextBeforeModesTestExecutionListener, org.springframework.test.context.event.ApplicationEventsTestExecutionListener, org.springframework.test.context.support.DependencyInjectionTestExecutionListener, org.springframework.test.context.support.DirtiesContextTestExecutionListener, org.springframework.test.context.transaction.TransactionalTestExecutionListener, org.springframework.test.context.jdbc.SqlScriptsTestExecutionListener, org.springframework.test.context.event.EventPublishingTestExecutionListener]
2022-07-11T10:23:56,182 INFO  [main] org.springframework.test.context.support.DefaultTestContextBootstrapper: Using TestExecutionListeners: [org.springframework.test.context.web.ServletTestExecutionListener@218f0100, org.springframework.test.context.support.DirtiesContextBeforeModesTestExecutionListener@1a673433, org.springframework.test.context.event.ApplicationEventsTestExecutionListener@185e5f3c, org.springframework.test.context.support.DependencyInjectionTestExecutionListener@58c240a5, org.springframework.test.context.support.DirtiesContextTestExecutionListener@19ccdbc, org.springframework.test.context.transaction.TransactionalTestExecutionListener@2279b710, org.springframework.test.context.jdbc.SqlScriptsTestExecutionListener@4834bbdc, org.springframework.test.context.event.EventPublishingTestExecutionListener@2b91d17]
2022-07-11T10:23:56,240 INFO  [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data JPA repositories in DEFAULT mode.
2022-07-11T10:23:56,265 INFO  [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 24 ms. Found 15 JPA repository interfaces.
2022-07-11T10:23:56,266 INFO  [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data JPA repositories in DEFAULT mode.
2022-07-11T10:23:56,288 INFO  [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 22 ms. Found 15 JPA repository interfaces.
2022-07-11T10:23:56,302 INFO  [main] org.hibernate.jpa.internal.util.LogHelper: HHH000204: Processing PersistenceUnitInfo [name: hsql-testdb]
2022-07-11T10:23:56,339 WARN  [main] org.hibernate.orm.connections.pooling: HHH10001002: Using Hibernate built-in connection pool (not for production use!)
2022-07-11T10:23:56,340 INFO  [main] org.hibernate.orm.connections.pooling: HHH10001005: using driver [org.hsqldb.jdbc.JDBCDriver] at URL [jdbc:hsqldb:mem:hsql-testdb]
2022-07-11T10:23:56,340 INFO  [main] org.hibernate.orm.connections.pooling: HHH10001001: Connection properties: {password=****, user=sa}
2022-07-11T10:23:56,340 INFO  [main] org.hibernate.orm.connections.pooling: HHH10001003: Autocommit mode: false
2022-07-11T10:23:56,340 INFO  [main] org.hibernate.engine.jdbc.connections.internal.DriverManagerConnectionProviderImpl: HHH000115: Hibernate connection pool size: 20 (min=1)
2022-07-11T10:23:56,341 INFO  [main] org.hibernate.dialect.Dialect : HHH000400: Using dialect: org.appng.persistence.hibernate.dialect.HSQLDialect
2022-07-11T10:23:56,345 INFO  [main] org.hibernate.envers.boot.internal.EnversServiceImpl: Envers integration enabled? : true
2022-07-11T10:23:56,518 INFO  [main] org.hibernate.orm.connections.access: HHH10001501: Connection obtained from JdbcConnectionAccess [org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess@ec72d7f] for (non-JTA) DDL execution was not in auto-commit mode; the Connection 'local transaction' will be committed and the Connection will be set into auto-commit mode.
2022-07-11T10:23:56,523 INFO  [main] org.hibernate.orm.connections.access: HHH10001501: Connection obtained from JdbcConnectionAccess [org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess@25289be3] for (non-JTA) DDL execution was not in auto-commit mode; the Connection 'local transaction' will be committed and the Connection will be set into auto-commit mode.
2022-07-11T10:23:56,538 INFO  [main] org.hibernate.engine.transaction.jta.platform.internal.JtaPlatformInitiator: HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.NoJtaPlatform]
2022-07-11T10:23:56,539 INFO  [main] org.springframework.orm.jpa.LocalEntityManagerFactoryBean: Initialized JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2022-07-11T10:23:56,540 INFO  [main] org.appng.core.domain.PlatformEventListener: Using application context appNG platform context, started on Mon Jul 11 10:23:56 CEST 2022
2022-07-11T10:23:56,913 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#321463537 for site manager with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:56,926 INFO  [main] org.appng.core.service.TemplateService: added resource assets/favicon.ico
2022-07-11T10:23:56,927 INFO  [main] org.appng.core.service.TemplateService: added resource conf/platform.xml
2022-07-11T10:23:56,927 INFO  [main] org.appng.core.service.TemplateService: added resource resources/dummy.txt
2022-07-11T10:23:56,928 INFO  [main] org.appng.core.service.TemplateService: added resource template.xml
2022-07-11T10:23:56,928 INFO  [main] org.appng.core.service.TemplateService: added resource xsl/platform.xsl
2022-07-11T10:23:56,928 INFO  [main] org.appng.core.service.TemplateService: added resource xsl/utils.xsl
2022-07-11T10:23:56,951 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1154856998 for site manager with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:56,979 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1228326321 for site manager with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-11T10:23:56,996 INFO  [main] org.appng.core.service.TemplateService: added resource assets/favicon.ico
2022-07-11T10:23:56,996 INFO  [main] org.appng.core.service.TemplateService: added resource conf/platform.xml
2022-07-11T10:23:56,996 INFO  [main] org.appng.core.service.TemplateService: added resource resources/dummy.txt
2022-07-11T10:23:56,998 INFO  [main] org.appng.core.service.TemplateService: added resource template.xml
2022-07-11T10:23:56,998 INFO  [main] org.appng.core.service.TemplateService: added resource xsl/platform.xsl
2022-07-11T10:23:56,998 INFO  [main] org.appng.core.service.TemplateService: added resource xsl/utils.xsl
2022-07-11T10:23:57,002 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Template appng-template
2022-07-11T10:23:57,018 INFO  [main] org.springframework.orm.jpa.LocalEntityManagerFactoryBean: Closing JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2022-07-11T10:23:57,018 INFO  [main] org.hibernate.orm.connections.pooling: HHH10001008: Cleaning up connection pool [jdbc:hsqldb:mem:hsql-testdb]
[INFO] Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.841 s - in org.appng.core.service.TemplateServiceTest
[INFO] Running org.appng.core.service.DatabaseServiceTest
2022-07-11T10:23:57,024 INFO  [main] org.springframework.test.context.support.DefaultTestContextBootstrapper: Loaded default TestExecutionListener class names from location [META-INF/spring.factories]: [org.springframework.test.context.web.ServletTestExecutionListener, org.springframework.test.context.support.DirtiesContextBeforeModesTestExecutionListener, org.springframework.test.context.event.ApplicationEventsTestExecutionListener, org.springframework.test.context.support.DependencyInjectionTestExecutionListener, org.springframework.test.context.support.DirtiesContextTestExecutionListener, org.springframework.test.context.transaction.TransactionalTestExecutionListener, org.springframework.test.context.jdbc.SqlScriptsTestExecutionListener, org.springframework.test.context.event.EventPublishingTestExecutionListener]
2022-07-11T10:23:57,025 INFO  [main] org.springframework.test.context.support.DefaultTestContextBootstrapper: Using TestExecutionListeners: [org.springframework.test.context.web.ServletTestExecutionListener@3e8f2bf3, org.springframework.test.context.support.DirtiesContextBeforeModesTestExecutionListener@1014bc6, org.springframework.test.context.event.ApplicationEventsTestExecutionListener@468ac4ab, org.springframework.test.context.support.DependencyInjectionTestExecutionListener@47d499d4, org.springframework.test.context.support.DirtiesContextTestExecutionListener@43f26e, org.springframework.test.context.transaction.TransactionalTestExecutionListener@b17d6db, org.springframework.test.context.jdbc.SqlScriptsTestExecutionListener@1b28e48e, org.springframework.test.context.event.EventPublishingTestExecutionListener@78d1d406]
2022-07-11T10:23:57,080 INFO  [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data JPA repositories in DEFAULT mode.
2022-07-11T10:23:57,105 INFO  [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 25 ms. Found 15 JPA repository interfaces.
2022-07-11T10:23:57,106 INFO  [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data JPA repositories in DEFAULT mode.
2022-07-11T10:23:57,127 INFO  [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 20 ms. Found 15 JPA repository interfaces.
2022-07-11T10:23:57,144 INFO  [main] org.hibernate.jpa.internal.util.LogHelper: HHH000204: Processing PersistenceUnitInfo [name: hsql-testdb]
2022-07-11T10:23:57,200 WARN  [main] org.hibernate.orm.connections.pooling: HHH10001002: Using Hibernate built-in connection pool (not for production use!)
2022-07-11T10:23:57,201 INFO  [main] org.hibernate.orm.connections.pooling: HHH10001005: using driver [org.hsqldb.jdbc.JDBCDriver] at URL [jdbc:hsqldb:mem:hsql-testdb]
2022-07-11T10:23:57,201 INFO  [main] org.hibernate.orm.connections.pooling: HHH10001001: Connection properties: {password=****, user=sa}
2022-07-11T10:23:57,201 INFO  [main] org.hibernate.orm.connections.pooling: HHH10001003: Autocommit mode: false
2022-07-11T10:23:57,201 INFO  [main] org.hibernate.engine.jdbc.connections.internal.DriverManagerConnectionProviderImpl: HHH000115: Hibernate connection pool size: 20 (min=1)
2022-07-11T10:23:57,203 INFO  [main] org.hibernate.dialect.Dialect : HHH000400: Using dialect: org.appng.persistence.hibernate.dialect.HSQLDialect
2022-07-11T10:23:57,209 INFO  [main] org.hibernate.envers.boot.internal.EnversServiceImpl: Envers integration enabled? : true
2022-07-11T10:23:57,378 INFO  [main] org.hibernate.orm.connections.access: HHH10001501: Connection obtained from JdbcConnectionAccess [org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess@3a52fa76] for (non-JTA) DDL execution was not in auto-commit mode; the Connection 'local transaction' will be committed and the Connection will be set into auto-commit mode.
2022-07-11T10:23:57,382 INFO  [main] org.hibernate.orm.connections.access: HHH10001501: Connection obtained from JdbcConnectionAccess [org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess@61ec830b] for (non-JTA) DDL execution was not in auto-commit mode; the Connection 'local transaction' will be committed and the Connection will be set into auto-commit mode.
2022-07-11T10:23:57,401 INFO  [main] org.hibernate.engine.transaction.jta.platform.internal.JtaPlatformInitiator: HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.NoJtaPlatform]
2022-07-11T10:23:57,402 INFO  [main] org.springframework.orm.jpa.LocalEntityManagerFactoryBean: Initialized JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2022-07-11T10:23:57,404 INFO  [main] org.appng.core.domain.PlatformEventListener: Using application context appNG platform context, started on Mon Jul 11 10:23:57 CEST 2022
2022-07-11T10:23:57,773 INFO  [main] org.appng.core.domain.DatabaseConnection: Registered JDBC driver org.hsqldb.jdbc.JDBCDriver
2022-07-11T10:23:57,783 INFO  [main] org.appng.core.service.MigrationService: connected to jdbc:hsqldb:mem:testInitDatabase (HSQL Database Engine 2.5.0)
2022-07-11T10:23:57,784 INFO  [main] org.flywaydb.core.internal.license.VersionPrinter: Flyway Community Edition 8.5.13 by Redgate
2022-07-11T10:23:57,784 INFO  [main] org.flywaydb.core.internal.license.VersionPrinter: See what's new here: https://flywaydb.org/documentation/learnmore/releaseNotes#8.5.13
2022-07-11T10:23:57,785 INFO  [main] org.flywaydb.core.internal.license.VersionPrinter: 
2022-07-11T10:23:57,788 INFO  [main] org.flywaydb.core.internal.database.base.BaseDatabaseType: Database: jdbc:hsqldb:mem:testInitDatabase (HSQL Database Engine 2.5)
2022-07-11T10:23:57,799 INFO  [main] org.appng.core.service.MigrationService: connected to jdbc:hsqldb:mem:testInitDatabase (HSQL Database Engine 2.5.0)
2022-07-11T10:23:57,800 INFO  [main] org.flywaydb.core.internal.license.VersionPrinter: Flyway Community Edition 8.5.13 by Redgate
2022-07-11T10:23:57,800 INFO  [main] org.flywaydb.core.internal.license.VersionPrinter: See what's new here: https://flywaydb.org/documentation/learnmore/releaseNotes#8.5.13
2022-07-11T10:23:57,800 INFO  [main] org.flywaydb.core.internal.license.VersionPrinter: 
2022-07-11T10:23:57,802 INFO  [main] org.flywaydb.core.internal.database.base.BaseDatabaseType: Database: jdbc:hsqldb:mem:testInitDatabase (HSQL Database Engine 2.5)
2022-07-11T10:23:57,812 INFO  [main] org.flywaydb.core.internal.command.DbValidate: Successfully validated 16 migrations (execution time 00:00.008s)
2022-07-11T10:23:57,814 INFO  [main] org.flywaydb.core.internal.schemahistory.JdbcTableSchemaHistory: Creating Schema History table "PUBLIC"."schema_version" ...
2022-07-11T10:23:57,820 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Current version of schema "PUBLIC": << Empty Schema >>
2022-07-11T10:23:57,854 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version "1.0 - appNG initial setup"
2022-07-11T10:23:57,891 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version "1.1 - Quartz initial setup"
2022-07-11T10:23:57,903 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version "1.2 - add template"
2022-07-11T10:23:57,910 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version "1.2.1 - add repository strict"
2022-07-11T10:23:57,916 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version "1.2.2 - add repository digest"
2022-07-11T10:23:57,922 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version "1.2.3 - set resource bytes not null"
2022-07-11T10:23:57,929 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version "1.3.0 - add type to template"
2022-07-11T10:23:57,935 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version "1.3.1 - add global admin role"
2022-07-11T10:23:57,941 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version "1.3.2 - add repository accepted certs"
2022-07-11T10:23:57,948 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version "2.0.0 - add platform event"
2022-07-11T10:23:57,957 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version "4.0.0 - add job execution record"
2022-07-11T10:23:57,964 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version "4.1.0 - change caching properties"
2022-07-11T10:23:57,965 WARN  [main] org.flywaydb.core.internal.sqlscript.DefaultSqlScriptExecutor: DB: no data (SQL State: 02000 - Error Code: -1100)
2022-07-11T10:23:57,965 WARN  [main] org.flywaydb.core.internal.sqlscript.DefaultSqlScriptExecutor: DB: no data (SQL State: 02000 - Error Code: -1100)
2022-07-11T10:23:57,970 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version "4.1.1 - add site reload count"
2022-07-11T10:23:57,976 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version "4.1.2 - add property type"
2022-07-11T10:23:57,984 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version "4.2 - add subject columns"
2022-07-11T10:23:57,986 WARN  [main] org.flywaydb.core.internal.sqlscript.DefaultSqlScriptExecutor: DB: no data (SQL State: 02000 - Error Code: -1100)
2022-07-11T10:23:57,990 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version "4.2.1 - change subject name length"
2022-07-11T10:23:57,993 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Successfully applied 16 migrations to schema "PUBLIC", now at version v4.2.1 (execution time 00:00.174s)
2022-07-11T10:23:57,995 INFO  [main] org.appng.core.service.MigrationService: connected to jdbc:hsqldb:mem:testInitDatabase (HSQL Database Engine 2.5.0)
2022-07-11T10:23:57,996 INFO  [main] org.flywaydb.core.internal.license.VersionPrinter: Flyway Community Edition 8.5.13 by Redgate
2022-07-11T10:23:57,996 INFO  [main] org.flywaydb.core.internal.license.VersionPrinter: See what's new here: https://flywaydb.org/documentation/learnmore/releaseNotes#8.5.13
2022-07-11T10:23:57,996 INFO  [main] org.flywaydb.core.internal.license.VersionPrinter: 
2022-07-11T10:23:57,999 INFO  [main] org.flywaydb.core.internal.database.base.BaseDatabaseType: Database: jdbc:hsqldb:mem:testInitDatabase (HSQL Database Engine 2.5)
2022-07-11T10:23:58,012 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform DatabaseConnection appNG Root Database
2022-07-11T10:23:58,018 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform DatabaseConnection appNG HSQL
2022-07-11T10:23:58,025 INFO  [main] org.appng.core.service.DatabaseService: HSQL jdbc:hsqldb:mem:testInitDatabase (HSQL Database Engine 2.5.0) is active.
2022-07-11T10:23:58,027 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform DatabaseConnection appNG HSQL
2022-07-11T10:23:58,027 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform DatabaseConnection appNG MYSQL
2022-07-11T10:23:58,028 INFO  [main] org.appng.core.domain.DatabaseConnection: Registered JDBC driver com.mysql.cj.jdbc.Driver
2022-07-11T10:23:58,266 WARN  [main] org.appng.core.domain.DatabaseConnection: error while connecting to jdbc:mysql://localhost:3306/appNG MYSQL (org.springframework.jdbc.CannotGetJdbcConnectionException: Failed to obtain JDBC Connection; nested exception is java.sql.SQLException: Access denied for user 'user'@'127.0.0.1' (using password: NO))
2022-07-11T10:23:58,266 INFO  [main] org.appng.core.service.DatabaseService: MYSQL jdbc:mysql://localhost:3306/appNG MYSQL is not working and will be deactivated.
2022-07-11T10:23:58,269 INFO  [main] org.appng.core.domain.DatabaseConnection: Registered JDBC driver com.microsoft.sqlserver.jdbc.SQLServerDriver
2022-07-11T10:23:58,271 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform DatabaseConnection appNG POSTGRESQL
2022-07-11T10:23:58,272 INFO  [main] org.appng.core.domain.DatabaseConnection: Registered JDBC driver org.postgresql.Driver
2022-07-11T10:23:58,290 WARN  [main] org.appng.core.domain.DatabaseConnection: error while connecting to jdbc:postgresql://localhost:5432/appNG POSTGRESQL (org.springframework.jdbc.CannotGetJdbcConnectionException: Failed to obtain JDBC Connection; nested exception is org.postgresql.util.PSQLException: Connection refused. Check that the hostname and port are correct and that the postmaster is accepting TCP/IP connections.)
2022-07-11T10:23:58,290 INFO  [main] org.appng.core.service.DatabaseService: POSTGRESQL jdbc:postgresql://localhost:5432/appNG POSTGRESQL is not working and will be deactivated.
2022-07-11T10:23:58,295 INFO  [main] org.springframework.orm.jpa.LocalEntityManagerFactoryBean: Closing JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2022-07-11T10:23:58,296 INFO  [main] org.hibernate.orm.connections.pooling: HHH10001008: Cleaning up connection pool [jdbc:hsqldb:mem:hsql-testdb]
[WARNING] Tests run: 11, Failures: 0, Errors: 0, Skipped: 9, Time elapsed: 1.274 s - in org.appng.core.service.DatabaseServiceTest
[INFO] Running org.appng.core.service.PropertySupportTest
[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 s - in org.appng.core.service.PropertySupportTest
[INFO] 
[INFO] Results:
[INFO] 
[ERROR] Errors: 
[ERROR]   ApplicationContextTest.test » IllegalState Failed to load ApplicationContext
[ERROR]   ApplicationProviderTest.testCallAction » IllegalState Failed to load Applicati...
[ERROR]   ApplicationProviderTest.testCallActionNotFound » IllegalState Failed to load A...
[ERROR]   ApplicationProviderTest.testCallDataSourceEntities » IllegalState Failed to lo...
[ERROR]   ApplicationProviderTest.testCallDataSourceEntity » IllegalState Failed to load...
[ERROR]   ApplicationProviderTest.testCallDataSourceNotFound » IllegalState Failed to lo...
[ERROR]   ApplicationProviderTest.testCreate » IllegalState Failed to load ApplicationCo...
[ERROR]   ApplicationProviderTest.testEntities » IllegalState Failed to load Application...
[ERROR]   ApplicationProviderTest.testUpdateException » IllegalState Failed to load Appl...
[ERROR]   ApplicationProviderTest.testUpdateExceptionDataSource » IllegalState Failed to...
[ERROR]   ApplicationProviderTest.testUpdateExecute » IllegalState Failed to load Applic...
[ERROR]   ApplicationProviderTest.testUpdateInclude » IllegalState Failed to load Applic...
[ERROR]   ApplicationProviderTest.testUpdateValidationError » IllegalState Failed to loa...
[INFO] 
[ERROR] Tests run: 342, Failures: 0, Errors: 13, Skipped: 30
[INFO] 
[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary for appNG Parent 2.0.0-SNAPSHOT:
[INFO] 
[INFO] appNG Parent ....................................... SUCCESS [  2.784 s]
[INFO] appNG Tools ........................................ SUCCESS [ 17.162 s]
[INFO] appNG Mail ......................................... SUCCESS [  6.496 s]
[INFO] appNG Forms ........................................ SUCCESS [  5.440 s]
[INFO] appng Formtags ..................................... SUCCESS [  5.847 s]
[INFO] appNG XML-API ...................................... SUCCESS [  9.136 s]
[INFO] appNG public API ................................... SUCCESS [ 18.992 s]
[INFO] appNG testsupport .................................. SUCCESS [  8.263 s]
[INFO] appNG REST API ..................................... SUCCESS [  7.433 s]
[INFO] appNG Persistence-Tools ............................ SUCCESS [ 18.519 s]
[INFO] appNG Search ....................................... SUCCESS [ 16.066 s]
[INFO] appNG Core Library ................................. FAILURE [01:19 min]
[INFO] appNG Command Line Interface ....................... SKIPPED
[INFO] appNG Tag Library .................................. SKIPPED
[INFO] appNGizer JAXB API ................................. SKIPPED
[INFO] appNGizer .......................................... 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] 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] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time:  03:16 min
[INFO] Finished at: 2022-07-11T10:23:58+02:00
[INFO] ------------------------------------------------------------------------
[ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:3.0.0-M5:test (default-test) on project appng-core: There are test failures.
[ERROR] 
[ERROR] Please refer to /var/lib/jenkins/workspace/appNG_2.0.x/appng-core/target/surefire-reports for the individual test results.
[ERROR] Please refer to dump files (if any exist) [date].dump, [date]-jvmRun[N].dump and [date].dumpstream.
[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/MojoFailureException
[ERROR] 
[ERROR] After correcting the problems, you can resume the build with the command
[ERROR]   mvn <args> -rf :appng-core