C:\apps86\jenkins\jobs\calypso-ui-tests\workspace>REM @echo off C:\apps86\jenkins\jobs\calypso-ui-tests\workspace>"C:\Program Files\jubula_8.4.1.123\ite\testexec.exe" -c calypsoTestsConfig.xml -port 52933 -dburl jdbc:h2:c:\DEVROOT\jubula\database\embedded;MVCC=TRUE;AUTO_SERVER=TRUE;DB_CLOSE_ON_EXIT=FALSE 21/07/17 10:57:25 AM - Using configuration file: C:\apps86\jenkins\jobs\calypso-ui-tests\workspace\calypsoTestsConfig.xml 21/07/17 10:57:25 AM - Start of embedded AUT Agent on port 52933. 21/07/17 10:57:25 AM - AUT Agent: Connecting to "localhost:52933" ... 21/07/17 10:57:26 AM - AUT Agent: connection established. 21/07/17 10:57:26 AM - Database: Connecting as "sa" to "jdbc:h2:c:\DEVROOT\jubula\database\embedded;MVCC=TRUE;AUTO_SERVER=TRUE;DB_CLOSE_ON_EXIT=FALSE"... 21/07/17 10:57:29 AM - Database: Connection established. 21/07/17 10:57:29 AM - Database: Loading project "Calypso Tests" in version "1.0"... 21/07/17 10:57:30 AM - Database: Project loading completed. 21/07/17 10:57:30 AM - Project: Checking completeness 21/07/17 10:57:30 AM - Checking completeness of Test Suite "Menus"... 21/07/17 10:57:30 AM - ... passed. 21/07/17 10:57:30 AM - AUT: Starting AUT: "Calypso Tests" via configuration "Calypso Tests@localhost"... AUTs sysout: 10:57:39,965 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.groovy] AUTs sysout: 10:57:39,965 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml] AUTs sysout: 10:57:39,965 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [bundleresource://11210.fwk5592464:19/logback.xml] AUTs sysout: 10:57:39,965 |-WARN in ch.qos.logback.classic.LoggerContext[default] - Resource [logback.xml] occurs multiple times on the classpath. AUTs sysout: 10:57:39,965 |-WARN in ch.qos.logback.classic.LoggerContext[default] - Resource [logback.xml] occurs at [bundleresource://11211.fwk5592464:1/logback.xml] AUTs sysout: 10:57:39,965 |-WARN in ch.qos.logback.classic.LoggerContext[default] - Resource [logback.xml] occurs at [bundleresource://11210.fwk5592464:19/logback.xml] AUTs sysout: 10:57:39,981 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@2299ab - URL [bundleresource://11210.fwk5592464:19/logback.xml] is not of type file AUTs sysout: 10:57:40,012 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - debug attribute not set AUTs sysout: 10:57:40,027 |-INFO in ReconfigureOnChangeFilter{invocationCounter=0} - Will scan for changes in [[]] every 60 seconds. AUTs sysout: 10:57:40,027 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - Adding ReconfigureOnChangeFilter as a turbo filter AUTs sysout: 10:57:40,027 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender] AUTs sysout: 10:57:40,027 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [STDOUT] AUTs sysout: 10:57:40,121 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property AUTs sysout: 10:57:40,199 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender] AUTs sysout: 10:57:40,199 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [FILE] AUTs sysout: 10:57:40,215 |-INFO in ch.qos.logback.core.rolling.FixedWindowRollingPolicy@d69e55 - Will use zip compression AUTs sysout: 10:57:40,231 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property AUTs sysout: 10:57:40,231 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Active log file name: C:\Users\jenkinssrvaccount/.jubula/logs/rc_rcp.log AUTs sysout: 10:57:40,231 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - File property is set to [C:\Users\jenkinssrvaccount/.jubula/logs/rc_rcp.log] AUTs sysout: 10:57:40,231 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender] AUTs sysout: 10:57:40,231 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [CAP-FILE] AUTs sysout: 10:57:40,231 |-INFO in ch.qos.logback.core.rolling.FixedWindowRollingPolicy@1db0cf0 - Will use zip compression AUTs sysout: 10:57:40,231 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property AUTs sysout: 10:57:40,231 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[CAP-FILE] - Active log file name: C:\Users\jenkinssrvaccount/.jubula/logs/rc_rcp_ExecutedCaps.log AUTs sysout: 10:57:40,231 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[CAP-FILE] - File property is set to [C:\Users\jenkinssrvaccount/.jubula/logs/rc_rcp_ExecutedCaps.log] AUTs sysout: 10:57:40,231 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to WARN AUTs sysout: 10:57:40,231 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [FILE] to Logger[ROOT] AUTs sysout: 10:57:40,231 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [CAP] to DEBUG AUTs sysout: 10:57:40,231 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting additivity of logger [CAP] to false AUTs sysout: 10:57:40,231 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [CAP-FILE] to Logger[CAP] AUTs sysout: 10:57:40,231 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - End of configuration. AUTs sysout: 10:57:40,231 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@66e6f5 - Registering current configuration as safe fallback point AUTs sysout: AUTs syserr: Jul 21, 2017 10:57:41 AM org.springframework.context.annotation.AnnotationConfigApplicationContext prepareRefresh AUTs syserr: INFO: Refreshing org.springframework.context.annotation.AnnotationConfigApplicationContext@91d63f: startup date [Fri Jul 21 10:57:41 AEST 2017]; root of context hierarchy AUTs syserr: Jul 21, 2017 10:57:43 AM org.springframework.context.support.PostProcessorRegistrationDelegate$BeanPostProcessorChecker postProcessAfterInitialization AUTs syserr: INFO: Bean 'coreConfig' of type [class au.com.morgans.rcp.core.CoreConfig$$EnhancerBySpringCGLIB$$8eee1b] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) AUTs syserr: log4j:WARN No appenders could be found for logger (au.com.morgans.rcp.core.bus.EventBusBeanPostProcessor). AUTs syserr: log4j:WARN Please initialize the log4j system properly. AUTs sysout: WARN: No error handler configured to handle exceptions during publication. AUTs sysout: Error handlers can be added to any instance of AbstractPubSubSupport or via BusConfiguration. AUTs sysout: Falling back to console logger. 21/07/17 10:57:58 AM - Start working with Test Suite: Menus 21/07/17 10:57:58 AM - Start working with Test Suite: Menus 21/07/17 10:57:58 AM - AUT: Connecting to "Calypso Tests"... 21/07/17 10:57:58 AM - AUT OK: Connection to AUT: "Calypso Tests" established... 21/07/17 10:57:59 AM - AUT OK: Extension Status... 21/07/17 10:58:00 AM - AUT: Connection established. 21/07/17 10:58:00 AM - Resolving predefined variables 21/07/17 10:58:01 AM - Resolving Test Steps to execute... 21/07/17 10:58:01 AM - Building test execution tree 21/07/17 10:58:01 AM - Activating AUT... 21/07/17 10:58:01 AM - Start Test Suite execution: Menus 21/07/17 10:58:01 AM - Test Case: 21/07/17 10:58:01 AM - Test Case: 21/07/17 10:58:01 AM - Step: Select Menu Entry by Textpath 21/07/17 10:58:03 AM - Step: Wait for Window 21/07/17 10:58:04 AM - Test Case: 21/07/17 10:58:04 AM - Step: Click on Cancel Button 21/07/17 10:58:05 AM - Step: Wait for Window to Close 21/07/17 10:58:05 AM - Test Case: 21/07/17 10:58:05 AM - Test Case: 21/07/17 10:58:05 AM - Step: Select Menu Entry by Textpath on newWizardDropDown 21/07/17 10:58:06 AM - Step: Wait for Window 21/07/17 10:58:07 AM - Test Case: 21/07/17 10:58:07 AM - Step: Click on Cancel Button 21/07/17 10:58:07 AM - Step: Wait for Window to Close 21/07/17 10:58:08 AM - Finished working with Test Suite 21/07/17 10:58:08 AM - Writing Report to Database 21/07/17 10:58:08 AM - AUT: Disconnected. 21/07/17 10:58:08 AM - AUT Agent: connection closed. 21/07/17 10:58:09 AM - Exit: Code 0