Skip to content
Success

Console Output

Skipping 4,478 KB.. Full Log
08:45:24,428 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
08:45:24,428 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
08:45:24,429 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
08:45:24,429 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
08:45:24,429 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@dd0c991 - End of configuration.
08:45:24,429 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@5f16132a - Registering current configuration as safe fallback point
08:45:24,429 |-INFO in ch.qos.logback.classic.util.ContextInitializer@71c3b41 - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 69 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY

DataDir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8189
CreateLearningSpaceRequest(url=http://37.27.227.212:8189/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8189
[Passed] 001_004_admin_can_move_content (6m 31s)
TestServerController: start server requested
TestServerController: exec /usr/bin/java -Dlogs_dir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8034/log -jar build/libs/ustad-server-all.jar runserver -config=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../app-ktor-server/src/main/resources/application.conf -P:ktor.deployment.port=8034 -P:ktor.ustad.datadir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8034 -P:ktor.ustad.jsDevServer=
http://37.27.227.212:8034/api/centralappconfig/learningspace/getAll ready
08:51:40,203 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
08:51:40,203 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - No custom configurators were discovered as a service.
08:51:40,203 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
08:51:40,204 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
08:51:40,207 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
08:51:40,207 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
08:51:40,211 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 3 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
08:51:40,211 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
08:51:40,211 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
08:51:40,212 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
08:51:40,213 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml]
08:51:40,215 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@157853da - URL [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml] is not of type file
08:51:40,255 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
08:51:40,255 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
08:51:40,268 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - No compression will be used
08:51:40,268 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - Will use the pattern /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8034/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
08:51:40,277 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - The date pattern is 'yyyy-MM-dd' from file name pattern '/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8034/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
08:51:40,277 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Roll-over at midnight.
08:51:40,279 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Setting initial period to 2025-03-18T07:51:40.059Z
08:51:40,280 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
08:51:40,280 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
08:51:40,281 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
08:51:40,285 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Active log file name: /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8034/log/ustad-server.log
08:51:40,285 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - File property is set to [/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8034/log/ustad-server.log]
08:51:40,286 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
08:51:40,286 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
08:51:40,286 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
08:51:40,286 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
08:51:40,286 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@3cc1435c - End of configuration.
08:51:40,286 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@6bf0219d - Registering current configuration as safe fallback point
08:51:40,286 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 75 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY

DataDir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8034
CreateLearningSpaceRequest(url=http://37.27.227.212:8034/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8034
[Passed] 003_007_all_user_able_to_open_text_block (8m 25s)
TestServerController: start server requested
TestServerController: exec /usr/bin/java -Dlogs_dir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8963/log -jar build/libs/ustad-server-all.jar runserver -config=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../app-ktor-server/src/main/resources/application.conf -P:ktor.deployment.port=8963 -P:ktor.ustad.datadir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8963 -P:ktor.ustad.jsDevServer=
http://37.27.227.212:8963/api/centralappconfig/learningspace/getAll ready
09:00:17,285 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
09:00:17,286 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - No custom configurators were discovered as a service.
09:00:17,286 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
09:00:17,286 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
09:00:17,290 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
09:00:17,290 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
09:00:17,294 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 4 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
09:00:17,294 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
09:00:17,294 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
09:00:17,295 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
09:00:17,296 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml]
09:00:17,298 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@157853da - URL [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml] is not of type file
09:00:17,341 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
09:00:17,341 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
09:00:17,353 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - No compression will be used
09:00:17,353 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - Will use the pattern /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8963/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
09:00:17,362 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - The date pattern is 'yyyy-MM-dd' from file name pattern '/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8963/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
09:00:17,362 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Roll-over at midnight.
09:00:17,365 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Setting initial period to 2025-03-18T08:00:17.133Z
09:00:17,365 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
09:00:17,365 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
09:00:17,366 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
09:00:17,370 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Active log file name: /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8963/log/ustad-server.log
09:00:17,371 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - File property is set to [/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8963/log/ustad-server.log]
09:00:17,371 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
09:00:17,371 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
09:00:17,371 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
09:00:17,371 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
09:00:17,371 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@3cc1435c - End of configuration.
09:00:17,372 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@6bf0219d - Registering current configuration as safe fallback point
09:00:17,372 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 78 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY

DataDir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8963
CreateLearningSpaceRequest(url=http://37.27.227.212:8963/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8963
[Passed] 004_003_multiple_submission_possible_for_student (19m 21s)
TestServerController: start server requested
TestServerController: exec /usr/bin/java -Dlogs_dir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8308/log -jar build/libs/ustad-server-all.jar runserver -config=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../app-ktor-server/src/main/resources/application.conf -P:ktor.deployment.port=8308 -P:ktor.ustad.datadir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8308 -P:ktor.ustad.jsDevServer=
http://37.27.227.212:8308/api/centralappconfig/learningspace/getAll ready
09:19:59,885 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
09:19:59,886 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - No custom configurators were discovered as a service.
09:19:59,886 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
09:19:59,886 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
09:19:59,889 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
09:19:59,889 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
09:19:59,893 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 3 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
09:19:59,893 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
09:19:59,893 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
09:19:59,893 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
09:19:59,895 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml]
09:19:59,896 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@157853da - URL [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml] is not of type file
09:19:59,933 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
09:19:59,933 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
09:19:59,945 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - No compression will be used
09:19:59,945 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - Will use the pattern /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8308/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
09:19:59,955 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - The date pattern is 'yyyy-MM-dd' from file name pattern '/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8308/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
09:19:59,955 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Roll-over at midnight.
09:19:59,957 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Setting initial period to 2025-03-18T08:19:59.723Z
09:19:59,957 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
09:19:59,957 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
09:19:59,958 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
09:19:59,963 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Active log file name: /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8308/log/ustad-server.log
09:19:59,963 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - File property is set to [/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8308/log/ustad-server.log]
09:19:59,963 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
09:19:59,963 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
09:19:59,964 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
09:19:59,964 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
09:19:59,964 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@3cc1435c - End of configuration.
09:19:59,964 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@6bf0219d - Registering current configuration as safe fallback point
09:19:59,964 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 71 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY

DataDir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8308
CreateLearningSpaceRequest(url=http://37.27.227.212:8308/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8308
[Passed] 001_001_admin_can_add_content_002-epub (7m 22s)
TestServerController: start server requested
TestServerController: exec /usr/bin/java -Dlogs_dir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8111/log -jar build/libs/ustad-server-all.jar runserver -config=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../app-ktor-server/src/main/resources/application.conf -P:ktor.deployment.port=8111 -P:ktor.ustad.datadir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8111 -P:ktor.ustad.jsDevServer=
http://37.27.227.212:8111/api/centralappconfig/learningspace/getAll ready
09:27:32,862 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
09:27:32,862 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - No custom configurators were discovered as a service.
09:27:32,862 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
09:27:32,862 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
09:27:32,865 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
09:27:32,865 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
09:27:32,869 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 3 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
09:27:32,869 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
09:27:32,869 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
09:27:32,869 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
09:27:32,870 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml]
09:27:32,872 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@157853da - URL [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml] is not of type file
09:27:32,907 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
09:27:32,907 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
09:27:32,919 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - No compression will be used
09:27:32,919 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - Will use the pattern /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8111/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
09:27:32,928 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - The date pattern is 'yyyy-MM-dd' from file name pattern '/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8111/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
09:27:32,928 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Roll-over at midnight.
09:27:32,931 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Setting initial period to 2025-03-18T08:27:32.698Z
09:27:32,931 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
09:27:32,931 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
09:27:32,932 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
09:27:32,936 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Active log file name: /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8111/log/ustad-server.log
09:27:32,937 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - File property is set to [/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8111/log/ustad-server.log]
09:27:32,937 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
09:27:32,937 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
09:27:32,937 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
09:27:32,937 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
09:27:32,937 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@3cc1435c - End of configuration.
09:27:32,938 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@6bf0219d - Registering current configuration as safe fallback point
09:27:32,938 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 69 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY

DataDir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8111
CreateLearningSpaceRequest(url=http://37.27.227.212:8111/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8111
[Passed] 003_005_add_new_content_block_inside_course (8m 24s)
TestServerController: start server requested
TestServerController: exec /usr/bin/java -Dlogs_dir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8460/log -jar build/libs/ustad-server-all.jar runserver -config=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../app-ktor-server/src/main/resources/application.conf -P:ktor.deployment.port=8460 -P:ktor.ustad.datadir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8460 -P:ktor.ustad.jsDevServer=
http://37.27.227.212:8460/api/centralappconfig/learningspace/getAll ready
09:36:04,236 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
09:36:04,236 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - No custom configurators were discovered as a service.
09:36:04,236 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
09:36:04,237 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
09:36:04,240 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
09:36:04,240 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
09:36:04,243 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 3 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
09:36:04,243 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
09:36:04,243 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
09:36:04,244 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
09:36:04,245 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml]
09:36:04,246 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@157853da - URL [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml] is not of type file
09:36:04,282 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
09:36:04,282 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
09:36:04,294 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - No compression will be used
09:36:04,295 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - Will use the pattern /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8460/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
09:36:04,304 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - The date pattern is 'yyyy-MM-dd' from file name pattern '/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8460/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
09:36:04,304 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Roll-over at midnight.
09:36:04,306 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Setting initial period to 2025-03-18T08:36:04.086Z
09:36:04,306 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
09:36:04,306 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
09:36:04,308 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
09:36:04,312 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Active log file name: /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8460/log/ustad-server.log
09:36:04,312 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - File property is set to [/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8460/log/ustad-server.log]
09:36:04,313 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
09:36:04,313 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
09:36:04,313 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
09:36:04,313 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
09:36:04,313 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@3cc1435c - End of configuration.
09:36:04,313 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@6bf0219d - Registering current configuration as safe fallback point
09:36:04,313 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 70 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY

DataDir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8460
CreateLearningSpaceRequest(url=http://37.27.227.212:8460/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8460
[Passed] 001_003_admin_can_permanently_delete_the_content_002 (8m 14s)
TestServerController: start server requested
TestServerController: exec /usr/bin/java -Dlogs_dir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8449/log -jar build/libs/ustad-server-all.jar runserver -config=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../app-ktor-server/src/main/resources/application.conf -P:ktor.deployment.port=8449 -P:ktor.ustad.datadir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8449 -P:ktor.ustad.jsDevServer=
http://37.27.227.212:8449/api/centralappconfig/learningspace/getAll ready
09:44:42,221 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
09:44:42,222 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - No custom configurators were discovered as a service.
09:44:42,222 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
09:44:42,222 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
09:44:42,225 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
09:44:42,225 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
09:44:42,229 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 3 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
09:44:42,229 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
09:44:42,229 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
09:44:42,230 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
09:44:42,231 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml]
09:44:42,233 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@157853da - URL [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml] is not of type file
09:44:42,270 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
09:44:42,270 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
09:44:42,282 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - No compression will be used
09:44:42,282 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - Will use the pattern /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8449/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
09:44:42,291 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - The date pattern is 'yyyy-MM-dd' from file name pattern '/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8449/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
09:44:42,291 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Roll-over at midnight.
09:44:42,294 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Setting initial period to 2025-03-18T08:44:42.051Z
09:44:42,294 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
09:44:42,294 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
09:44:42,295 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
09:44:42,299 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Active log file name: /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8449/log/ustad-server.log
09:44:42,299 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - File property is set to [/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8449/log/ustad-server.log]
09:44:42,300 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
09:44:42,300 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
09:44:42,300 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
09:44:42,300 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
09:44:42,300 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@3cc1435c - End of configuration.
09:44:42,300 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@6bf0219d - Registering current configuration as safe fallback point
09:44:42,300 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 71 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY

DataDir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8449
CreateLearningSpaceRequest(url=http://37.27.227.212:8449/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8449
[Passed] 005_002_users_can_add_post_on_discussion_board (7m 33s)
TestServerController: start server requested
TestServerController: exec /usr/bin/java -Dlogs_dir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8588/log -jar build/libs/ustad-server-all.jar runserver -config=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../app-ktor-server/src/main/resources/application.conf -P:ktor.deployment.port=8588 -P:ktor.ustad.datadir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8588 -P:ktor.ustad.jsDevServer=
http://37.27.227.212:8588/api/centralappconfig/learningspace/getAll ready
09:52:04,564 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
09:52:04,564 |-INFO in ch.qos.logback.classic.util.ContextInitializer@71c3b41 - No custom configurators were discovered as a service.
09:52:04,564 |-INFO in ch.qos.logback.classic.util.ContextInitializer@71c3b41 - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
09:52:04,565 |-INFO in ch.qos.logback.classic.util.ContextInitializer@71c3b41 - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
09:52:04,567 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
09:52:04,567 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
09:52:04,571 |-INFO in ch.qos.logback.classic.util.ContextInitializer@71c3b41 - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 2 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
09:52:04,571 |-INFO in ch.qos.logback.classic.util.ContextInitializer@71c3b41 - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
09:52:04,571 |-INFO in ch.qos.logback.classic.util.ContextInitializer@71c3b41 - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
09:52:04,571 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
09:52:04,572 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml]
09:52:04,574 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@236e3f4e - URL [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml] is not of type file
09:52:04,610 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
09:52:04,610 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
09:52:04,622 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@1019298652 - No compression will be used
09:52:04,623 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@1019298652 - Will use the pattern /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8588/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
09:52:04,632 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@6bf0219d - The date pattern is 'yyyy-MM-dd' from file name pattern '/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8588/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
09:52:04,632 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@6bf0219d - Roll-over at midnight.
09:52:04,634 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@6bf0219d - Setting initial period to 2025-03-18T08:52:04.403Z
09:52:04,634 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@6bf0219d - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
09:52:04,634 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@6bf0219d - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
09:52:04,635 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
09:52:04,640 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Active log file name: /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8588/log/ustad-server.log
09:52:04,640 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - File property is set to [/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8588/log/ustad-server.log]
09:52:04,640 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
09:52:04,641 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
09:52:04,641 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
09:52:04,641 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
09:52:04,641 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@dd0c991 - End of configuration.
09:52:04,641 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@5f16132a - Registering current configuration as safe fallback point
09:52:04,641 |-INFO in ch.qos.logback.classic.util.ContextInitializer@71c3b41 - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 70 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY

DataDir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8588
CreateLearningSpaceRequest(url=http://37.27.227.212:8588/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8588
[Passed] 005_004_users_can_add_external_links_as_post_on_discussion_board (7m 53s)
TestServerController: start server requested
TestServerController: exec /usr/bin/java -Dlogs_dir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8729/log -jar build/libs/ustad-server-all.jar runserver -config=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../app-ktor-server/src/main/resources/application.conf -P:ktor.deployment.port=8729 -P:ktor.ustad.datadir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8729 -P:ktor.ustad.jsDevServer=
http://37.27.227.212:8729/api/centralappconfig/learningspace/getAll ready
10:00:06,337 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
10:00:06,337 |-INFO in ch.qos.logback.classic.util.ContextInitializer@71c3b41 - No custom configurators were discovered as a service.
10:00:06,337 |-INFO in ch.qos.logback.classic.util.ContextInitializer@71c3b41 - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
10:00:06,337 |-INFO in ch.qos.logback.classic.util.ContextInitializer@71c3b41 - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
10:00:06,340 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
10:00:06,341 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
10:00:06,344 |-INFO in ch.qos.logback.classic.util.ContextInitializer@71c3b41 - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 4 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
10:00:06,344 |-INFO in ch.qos.logback.classic.util.ContextInitializer@71c3b41 - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
10:00:06,345 |-INFO in ch.qos.logback.classic.util.ContextInitializer@71c3b41 - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
10:00:06,345 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
10:00:06,346 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml]
10:00:06,348 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@236e3f4e - URL [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml] is not of type file
10:00:06,385 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
10:00:06,385 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
10:00:06,397 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@1019298652 - No compression will be used
10:00:06,397 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@1019298652 - Will use the pattern /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8729/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
10:00:06,406 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@6bf0219d - The date pattern is 'yyyy-MM-dd' from file name pattern '/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8729/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
10:00:06,406 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@6bf0219d - Roll-over at midnight.
10:00:06,409 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@6bf0219d - Setting initial period to 2025-03-18T09:00:06.173Z
10:00:06,409 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@6bf0219d - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
10:00:06,409 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@6bf0219d - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
10:00:06,410 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
10:00:06,414 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Active log file name: /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8729/log/ustad-server.log
10:00:06,415 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - File property is set to [/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8729/log/ustad-server.log]
10:00:06,415 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
10:00:06,415 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
10:00:06,415 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
10:00:06,415 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
10:00:06,415 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@dd0c991 - End of configuration.
10:00:06,416 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@5f16132a - Registering current configuration as safe fallback point
10:00:06,416 |-INFO in ch.qos.logback.classic.util.ContextInitializer@71c3b41 - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 71 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY

DataDir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8729
CreateLearningSpaceRequest(url=http://37.27.227.212:8729/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8729
[Passed] 004_001_assignment_creation_submission_grading (12m 41s)
TestServerController: start server requested
TestServerController: exec /usr/bin/java -Dlogs_dir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8654/log -jar build/libs/ustad-server-all.jar runserver -config=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../app-ktor-server/src/main/resources/application.conf -P:ktor.deployment.port=8654 -P:ktor.ustad.datadir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8654 -P:ktor.ustad.jsDevServer=
http://37.27.227.212:8654/api/centralappconfig/learningspace/getAll ready
10:13:13,427 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
10:13:13,427 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - No custom configurators were discovered as a service.
10:13:13,427 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
10:13:13,428 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
10:13:13,431 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
10:13:13,431 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
10:13:13,435 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 3 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
10:13:13,435 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
10:13:13,435 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
10:13:13,436 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
10:13:13,437 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml]
10:13:13,439 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@157853da - URL [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml] is not of type file
10:13:13,479 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
10:13:13,479 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
10:13:13,491 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - No compression will be used
10:13:13,492 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - Will use the pattern /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8654/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
10:13:13,500 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - The date pattern is 'yyyy-MM-dd' from file name pattern '/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8654/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
10:13:13,500 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Roll-over at midnight.
10:13:13,503 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Setting initial period to 2025-03-18T09:13:13.259Z
10:13:13,503 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
10:13:13,503 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
10:13:13,504 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
10:13:13,509 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Active log file name: /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8654/log/ustad-server.log
10:13:13,509 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - File property is set to [/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8654/log/ustad-server.log]
10:13:13,509 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
10:13:13,509 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
10:13:13,509 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
10:13:13,510 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
10:13:13,510 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@3cc1435c - End of configuration.
10:13:13,510 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@6bf0219d - Registering current configuration as safe fallback point
10:13:13,510 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 75 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY

DataDir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8654
CreateLearningSpaceRequest(url=http://37.27.227.212:8654/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8654
[Passed] 001_003_admin_can_delete_and_restore_content_001 (8m 14s)
TestServerController: start server requested
TestServerController: exec /usr/bin/java -Dlogs_dir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8002/log -jar build/libs/ustad-server-all.jar runserver -config=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../app-ktor-server/src/main/resources/application.conf -P:ktor.deployment.port=8002 -P:ktor.ustad.datadir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8002 -P:ktor.ustad.jsDevServer=
http://37.27.227.212:8002/api/centralappconfig/learningspace/getAll ready
10:21:31,284 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
10:21:31,284 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - No custom configurators were discovered as a service.
10:21:31,284 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
10:21:31,285 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
10:21:31,288 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
10:21:31,288 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
10:21:31,292 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 4 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
10:21:31,292 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
10:21:31,293 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
10:21:31,293 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
10:21:31,294 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml]
10:21:31,296 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@157853da - URL [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml] is not of type file
10:21:31,336 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
10:21:31,336 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
10:21:31,348 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - No compression will be used
10:21:31,349 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - Will use the pattern /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8002/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
10:21:31,359 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - The date pattern is 'yyyy-MM-dd' from file name pattern '/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8002/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
10:21:31,359 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Roll-over at midnight.
10:21:31,362 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Setting initial period to 2025-03-18T09:21:31.138Z
10:21:31,362 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
10:21:31,362 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
10:21:31,364 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
10:21:31,368 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Active log file name: /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8002/log/ustad-server.log
10:21:31,368 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - File property is set to [/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8002/log/ustad-server.log]
10:21:31,368 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
10:21:31,369 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
10:21:31,369 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
10:21:31,369 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
10:21:31,369 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@3cc1435c - End of configuration.
10:21:31,369 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@6bf0219d - Registering current configuration as safe fallback point
10:21:31,369 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 76 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY

DataDir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8002
CreateLearningSpaceRequest(url=http://37.27.227.212:8002/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8002
[Passed] 002_003_teacher_record_attendance (5m 9s)
TestServerController: start server requested
TestServerController: exec /usr/bin/java -Dlogs_dir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8369/log -jar build/libs/ustad-server-all.jar runserver -config=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../app-ktor-server/src/main/resources/application.conf -P:ktor.deployment.port=8369 -P:ktor.ustad.datadir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8369 -P:ktor.ustad.jsDevServer=
http://37.27.227.212:8369/api/centralappconfig/learningspace/getAll ready
10:26:45,616 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
10:26:45,616 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - No custom configurators were discovered as a service.
10:26:45,616 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
10:26:45,616 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
10:26:45,619 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
10:26:45,619 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
10:26:45,623 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 4 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
10:26:45,623 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
10:26:45,623 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
10:26:45,623 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
10:26:45,625 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml]
10:26:45,626 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@157853da - URL [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml] is not of type file
10:26:45,662 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
10:26:45,662 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
10:26:45,675 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - No compression will be used
10:26:45,675 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - Will use the pattern /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8369/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
10:26:45,685 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - The date pattern is 'yyyy-MM-dd' from file name pattern '/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8369/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
10:26:45,685 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Roll-over at midnight.
10:26:45,687 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Setting initial period to 2025-03-18T09:26:45.451Z
10:26:45,687 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
10:26:45,687 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
10:26:45,688 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
10:26:45,693 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Active log file name: /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8369/log/ustad-server.log
10:26:45,693 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - File property is set to [/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8369/log/ustad-server.log]
10:26:45,693 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
10:26:45,694 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
10:26:45,694 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
10:26:45,694 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
10:26:45,694 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@3cc1435c - End of configuration.
10:26:45,694 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@6bf0219d - Registering current configuration as safe fallback point
10:26:45,694 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 71 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY

DataDir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8369
CreateLearningSpaceRequest(url=http://37.27.227.212:8369/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8369
[Passed] 004_004_assignment_after_deadline_and_before_grace_Period (10m 17s)
TestServerController: start server requested
TestServerController: exec /usr/bin/java -Dlogs_dir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8842/log -jar build/libs/ustad-server-all.jar runserver -config=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../app-ktor-server/src/main/resources/application.conf -P:ktor.deployment.port=8842 -P:ktor.ustad.datadir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8842 -P:ktor.ustad.jsDevServer=
http://37.27.227.212:8842/api/centralappconfig/learningspace/getAll ready
10:37:09,349 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
10:37:09,349 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - No custom configurators were discovered as a service.
10:37:09,349 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
10:37:09,350 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
10:37:09,353 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
10:37:09,353 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
10:37:09,357 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 3 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
10:37:09,357 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
10:37:09,357 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
10:37:09,357 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
10:37:09,359 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml]
10:37:09,360 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@157853da - URL [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml] is not of type file
10:37:09,398 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
10:37:09,398 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
10:37:09,410 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - No compression will be used
10:37:09,411 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - Will use the pattern /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8842/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
10:37:09,420 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - The date pattern is 'yyyy-MM-dd' from file name pattern '/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8842/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
10:37:09,420 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Roll-over at midnight.
10:37:09,422 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Setting initial period to 2025-03-18T09:37:09.204Z
10:37:09,422 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
10:37:09,422 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
10:37:09,424 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
10:37:09,428 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Active log file name: /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8842/log/ustad-server.log
10:37:09,428 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - File property is set to [/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8842/log/ustad-server.log]
10:37:09,429 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
10:37:09,429 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
10:37:09,429 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
10:37:09,429 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
10:37:09,429 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@3cc1435c - End of configuration.
10:37:09,429 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@6bf0219d - Registering current configuration as safe fallback point
10:37:09,429 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 72 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY

DataDir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8842
CreateLearningSpaceRequest(url=http://37.27.227.212:8842/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8842
[Passed] 003_001_add_or_edit_course_permission_test (5m 50s)
TestServerController: start server requested
TestServerController: exec /usr/bin/java -Dlogs_dir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8807/log -jar build/libs/ustad-server-all.jar runserver -config=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../app-ktor-server/src/main/resources/application.conf -P:ktor.deployment.port=8807 -P:ktor.ustad.datadir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8807 -P:ktor.ustad.jsDevServer=
http://37.27.227.212:8807/api/centralappconfig/learningspace/getAll ready
10:43:03,434 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
10:43:03,435 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - No custom configurators were discovered as a service.
10:43:03,435 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
10:43:03,435 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
10:43:03,438 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
10:43:03,438 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
10:43:03,442 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 3 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
10:43:03,442 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
10:43:03,442 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
10:43:03,442 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
10:43:03,443 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml]
10:43:03,445 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@157853da - URL [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml] is not of type file
10:43:03,480 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
10:43:03,480 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
10:43:03,492 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - No compression will be used
10:43:03,493 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - Will use the pattern /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8807/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
10:43:03,502 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - The date pattern is 'yyyy-MM-dd' from file name pattern '/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8807/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
10:43:03,502 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Roll-over at midnight.
10:43:03,504 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Setting initial period to 2025-03-18T09:43:03.276Z
10:43:03,505 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
10:43:03,505 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
10:43:03,506 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
10:43:03,510 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Active log file name: /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8807/log/ustad-server.log
10:43:03,510 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - File property is set to [/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8807/log/ustad-server.log]
10:43:03,511 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
10:43:03,511 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
10:43:03,511 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
10:43:03,511 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
10:43:03,511 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@3cc1435c - End of configuration.
10:43:03,511 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@6bf0219d - Registering current configuration as safe fallback point
10:43:03,511 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 69 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY

DataDir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8807
CreateLearningSpaceRequest(url=http://37.27.227.212:8807/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8807
[Passed] 007_001_admin_enable_or_disable_user_registration (8m 55s)
TestServerController: start server requested
TestServerController: exec /usr/bin/java -Dlogs_dir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8085/log -jar build/libs/ustad-server-all.jar runserver -config=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../app-ktor-server/src/main/resources/application.conf -P:ktor.deployment.port=8085 -P:ktor.ustad.datadir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8085 -P:ktor.ustad.jsDevServer=
http://37.27.227.212:8085/api/centralappconfig/learningspace/getAll ready
10:52:05,716 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
10:52:05,716 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - No custom configurators were discovered as a service.
10:52:05,716 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
10:52:05,716 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
10:52:05,719 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
10:52:05,720 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
10:52:05,723 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 4 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
10:52:05,723 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
10:52:05,723 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
10:52:05,723 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
10:52:05,725 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml]
10:52:05,726 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@157853da - URL [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml] is not of type file
10:52:05,764 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
10:52:05,764 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
10:52:05,776 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - No compression will be used
10:52:05,777 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - Will use the pattern /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8085/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
10:52:05,786 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - The date pattern is 'yyyy-MM-dd' from file name pattern '/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8085/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
10:52:05,786 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Roll-over at midnight.
10:52:05,789 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Setting initial period to 2025-03-18T09:52:05.568Z
10:52:05,789 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
10:52:05,789 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
10:52:05,790 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
10:52:05,795 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Active log file name: /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8085/log/ustad-server.log
10:52:05,795 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - File property is set to [/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8085/log/ustad-server.log]
10:52:05,796 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
10:52:05,796 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
10:52:05,796 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
10:52:05,796 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
10:52:05,796 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@3cc1435c - End of configuration.
10:52:05,796 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@6bf0219d - Registering current configuration as safe fallback point
10:52:05,796 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 73 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY

DataDir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8085
CreateLearningSpaceRequest(url=http://37.27.227.212:8085/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8085
[Passed] 001_001_admin_can_add_content_001-h5p (7m 53s)
TestServerController: start server requested
TestServerController: exec /usr/bin/java -Dlogs_dir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8144/log -jar build/libs/ustad-server-all.jar runserver -config=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../app-ktor-server/src/main/resources/application.conf -P:ktor.deployment.port=8144 -P:ktor.ustad.datadir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8144 -P:ktor.ustad.jsDevServer=
http://37.27.227.212:8144/api/centralappconfig/learningspace/getAll ready
11:00:28,676 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
11:00:28,676 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - No custom configurators were discovered as a service.
11:00:28,676 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
11:00:28,677 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
11:00:28,680 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
11:00:28,680 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
11:00:28,684 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 3 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
11:00:28,684 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
11:00:28,684 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
11:00:28,684 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
11:00:28,686 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml]
11:00:28,687 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@157853da - URL [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml] is not of type file
11:00:28,726 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
11:00:28,726 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
11:00:28,738 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - No compression will be used
11:00:28,739 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - Will use the pattern /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8144/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
11:00:28,748 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - The date pattern is 'yyyy-MM-dd' from file name pattern '/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8144/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
11:00:28,748 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Roll-over at midnight.
11:00:28,751 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Setting initial period to 2025-03-18T10:00:28.531Z
11:00:28,751 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
11:00:28,751 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
11:00:28,752 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
11:00:28,756 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Active log file name: /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8144/log/ustad-server.log
11:00:28,757 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - File property is set to [/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8144/log/ustad-server.log]
11:00:28,757 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
11:00:28,757 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
11:00:28,757 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
11:00:28,757 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
11:00:28,757 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@3cc1435c - End of configuration.
11:00:28,758 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@6bf0219d - Registering current configuration as safe fallback point
11:00:28,758 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 74 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY

DataDir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8144
CreateLearningSpaceRequest(url=http://37.27.227.212:8144/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8144
[Passed] 002_005_admin_grant_permissions_test (7m 1s)
TestServerController: start server requested
TestServerController: exec /usr/bin/java -Dlogs_dir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8972/log -jar build/libs/ustad-server-all.jar runserver -config=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../app-ktor-server/src/main/resources/application.conf -P:ktor.deployment.port=8972 -P:ktor.ustad.datadir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8972 -P:ktor.ustad.jsDevServer=
http://37.27.227.212:8972/api/centralappconfig/learningspace/getAll ready
11:07:48,382 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
11:07:48,382 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - No custom configurators were discovered as a service.
11:07:48,382 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
11:07:48,382 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
11:07:48,385 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
11:07:48,385 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
11:07:48,388 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 3 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
11:07:48,388 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
11:07:48,389 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
11:07:48,389 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
11:07:48,390 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml]
11:07:48,391 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@157853da - URL [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml] is not of type file
11:07:48,428 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
11:07:48,428 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
11:07:48,440 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - No compression will be used
11:07:48,440 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - Will use the pattern /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8972/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
11:07:48,449 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - The date pattern is 'yyyy-MM-dd' from file name pattern '/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8972/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
11:07:48,449 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Roll-over at midnight.
11:07:48,451 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Setting initial period to 2025-03-18T10:07:48.219Z
11:07:48,452 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
11:07:48,452 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
11:07:48,453 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
11:07:48,457 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Active log file name: /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8972/log/ustad-server.log
11:07:48,457 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - File property is set to [/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8972/log/ustad-server.log]
11:07:48,458 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
11:07:48,458 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
11:07:48,458 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
11:07:48,458 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
11:07:48,458 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@3cc1435c - End of configuration.
11:07:48,458 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@6bf0219d - Registering current configuration as safe fallback point
11:07:48,458 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 69 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY

DataDir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8972
CreateLearningSpaceRequest(url=http://37.27.227.212:8972/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8972
[Passed] 007_006_admin_enable_or_disable_guest_login (7m 22s)
TestServerController: start server requested
TestServerController: exec /usr/bin/java -Dlogs_dir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8101/log -jar build/libs/ustad-server-all.jar runserver -config=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../app-ktor-server/src/main/resources/application.conf -P:ktor.deployment.port=8101 -P:ktor.ustad.datadir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8101 -P:ktor.ustad.jsDevServer=
http://37.27.227.212:8101/api/centralappconfig/learningspace/getAll ready
11:15:24,759 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
11:15:24,759 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - No custom configurators were discovered as a service.
11:15:24,759 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
11:15:24,760 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
11:15:24,763 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
11:15:24,763 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
11:15:24,766 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 3 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
11:15:24,766 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
11:15:24,766 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
11:15:24,767 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
11:15:24,768 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml]
11:15:24,770 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@157853da - URL [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml] is not of type file
11:15:24,811 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
11:15:24,811 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
11:15:24,824 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - No compression will be used
11:15:24,824 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - Will use the pattern /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8101/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
11:15:24,834 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - The date pattern is 'yyyy-MM-dd' from file name pattern '/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8101/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
11:15:24,834 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Roll-over at midnight.
11:15:24,837 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Setting initial period to 2025-03-18T10:15:24.601Z
11:15:24,838 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
11:15:24,838 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
11:15:24,839 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
11:15:24,844 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Active log file name: /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8101/log/ustad-server.log
11:15:24,845 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - File property is set to [/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8101/log/ustad-server.log]
11:15:24,845 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
11:15:24,845 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
11:15:24,845 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
11:15:24,845 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
11:15:24,845 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@3cc1435c - End of configuration.
11:15:24,846 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@6bf0219d - Registering current configuration as safe fallback point
11:15:24,846 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 80 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY

DataDir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8101
CreateLearningSpaceRequest(url=http://37.27.227.212:8101/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8101
[Passed] 002_002_student_joining_course_using_code (8m 24s)
TestServerController: start server requested
TestServerController: exec /usr/bin/java -Dlogs_dir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8691/log -jar build/libs/ustad-server-all.jar runserver -config=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../app-ktor-server/src/main/resources/application.conf -P:ktor.deployment.port=8691 -P:ktor.ustad.datadir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8691 -P:ktor.ustad.jsDevServer=
http://37.27.227.212:8691/api/centralappconfig/learningspace/getAll ready
11:23:50,297 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
11:23:50,298 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - No custom configurators were discovered as a service.
11:23:50,298 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
11:23:50,298 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
11:23:50,301 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
11:23:50,301 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
11:23:50,305 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 3 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
11:23:50,305 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
11:23:50,305 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
11:23:50,305 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
11:23:50,307 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml]
11:23:50,308 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@157853da - URL [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml] is not of type file
11:23:50,346 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
11:23:50,346 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
11:23:50,358 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - No compression will be used
11:23:50,358 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - Will use the pattern /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8691/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
11:23:50,367 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - The date pattern is 'yyyy-MM-dd' from file name pattern '/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8691/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
11:23:50,367 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Roll-over at midnight.
11:23:50,369 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Setting initial period to 2025-03-18T10:23:50.152Z
11:23:50,370 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
11:23:50,370 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
11:23:50,371 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
11:23:50,375 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Active log file name: /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8691/log/ustad-server.log
11:23:50,375 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - File property is set to [/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8691/log/ustad-server.log]
11:23:50,376 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
11:23:50,376 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
11:23:50,376 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
11:23:50,376 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
11:23:50,376 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@3cc1435c - End of configuration.
11:23:50,376 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@6bf0219d - Registering current configuration as safe fallback point
11:23:50,376 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 71 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY

DataDir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8691
CreateLearningSpaceRequest(url=http://37.27.227.212:8691/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8691
[Passed] 001_001_admin_can_add_content_003-video (7m 22s)
TestServerController: start server requested
TestServerController: exec /usr/bin/java -Dlogs_dir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8471/log -jar build/libs/ustad-server-all.jar runserver -config=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../app-ktor-server/src/main/resources/application.conf -P:ktor.deployment.port=8471 -P:ktor.ustad.datadir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8471 -P:ktor.ustad.jsDevServer=
http://37.27.227.212:8471/api/centralappconfig/learningspace/getAll ready
11:31:19,350 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
11:31:19,350 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - No custom configurators were discovered as a service.
11:31:19,350 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
11:31:19,350 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
11:31:19,353 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
11:31:19,353 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
11:31:19,356 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 3 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
11:31:19,356 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
11:31:19,357 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
11:31:19,357 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
11:31:19,358 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml]
11:31:19,360 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@157853da - URL [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml] is not of type file
11:31:19,396 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
11:31:19,396 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
11:31:19,408 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - No compression will be used
11:31:19,409 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - Will use the pattern /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8471/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
11:31:19,418 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - The date pattern is 'yyyy-MM-dd' from file name pattern '/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8471/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
11:31:19,418 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Roll-over at midnight.
11:31:19,420 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Setting initial period to 2025-03-18T10:31:19.209Z
11:31:19,420 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
11:31:19,420 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
11:31:19,421 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
11:31:19,426 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Active log file name: /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8471/log/ustad-server.log
11:31:19,426 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - File property is set to [/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8471/log/ustad-server.log]
11:31:19,426 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
11:31:19,426 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
11:31:19,427 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
11:31:19,427 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
11:31:19,427 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@3cc1435c - End of configuration.
11:31:19,427 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@6bf0219d - Registering current configuration as safe fallback point
11:31:19,427 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 70 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY

DataDir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8471
CreateLearningSpaceRequest(url=http://37.27.227.212:8471/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8471
[Passed] 001_001_admin_can_add_content_004-pdf (7m 1s)
TestServerController: start server requested
TestServerController: exec /usr/bin/java -Dlogs_dir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8509/log -jar build/libs/ustad-server-all.jar runserver -config=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../app-ktor-server/src/main/resources/application.conf -P:ktor.deployment.port=8509 -P:ktor.ustad.datadir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8509 -P:ktor.ustad.jsDevServer=
http://37.27.227.212:8509/api/centralappconfig/learningspace/getAll ready
11:38:25,432 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
11:38:25,433 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - No custom configurators were discovered as a service.
11:38:25,433 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
11:38:25,433 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
11:38:25,436 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
11:38:25,436 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
11:38:25,439 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 3 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
11:38:25,439 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
11:38:25,439 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
11:38:25,440 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
11:38:25,441 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml]
11:38:25,442 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@157853da - URL [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml] is not of type file
11:38:25,478 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
11:38:25,478 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
11:38:25,490 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - No compression will be used
11:38:25,491 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - Will use the pattern /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8509/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
11:38:25,500 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - The date pattern is 'yyyy-MM-dd' from file name pattern '/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8509/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
11:38:25,500 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Roll-over at midnight.
11:38:25,502 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Setting initial period to 2025-03-18T10:38:25.294Z
11:38:25,502 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
11:38:25,502 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
11:38:25,503 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
11:38:25,508 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Active log file name: /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8509/log/ustad-server.log
11:38:25,508 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - File property is set to [/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8509/log/ustad-server.log]
11:38:25,508 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
11:38:25,509 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
11:38:25,509 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
11:38:25,509 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
11:38:25,509 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@3cc1435c - End of configuration.
11:38:25,509 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@6bf0219d - Registering current configuration as safe fallback point
11:38:25,509 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 70 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY

DataDir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8509
CreateLearningSpaceRequest(url=http://37.27.227.212:8509/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8509
[Passed] 005_005_users_can_delete_post_on_discussion_board (8m 13s)
TestServerController: start server requested
TestServerController: exec /usr/bin/java -Dlogs_dir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8710/log -jar build/libs/ustad-server-all.jar runserver -config=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../app-ktor-server/src/main/resources/application.conf -P:ktor.deployment.port=8710 -P:ktor.ustad.datadir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8710 -P:ktor.ustad.jsDevServer=
http://37.27.227.212:8710/api/centralappconfig/learningspace/getAll ready
11:46:38,455 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
11:46:38,456 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - No custom configurators were discovered as a service.
11:46:38,456 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
11:46:38,456 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
11:46:38,459 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
11:46:38,459 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
11:46:38,463 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 3 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
11:46:38,463 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
11:46:38,463 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
11:46:38,463 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
11:46:38,465 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml]
11:46:38,467 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@157853da - URL [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml] is not of type file
11:46:38,504 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
11:46:38,504 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
11:46:38,516 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - No compression will be used
11:46:38,516 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - Will use the pattern /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8710/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
11:46:38,525 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - The date pattern is 'yyyy-MM-dd' from file name pattern '/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8710/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
11:46:38,525 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Roll-over at midnight.
11:46:38,527 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Setting initial period to 2025-03-18T10:46:38.283Z
11:46:38,528 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
11:46:38,528 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
11:46:38,529 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
11:46:38,533 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Active log file name: /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8710/log/ustad-server.log
11:46:38,533 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - File property is set to [/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8710/log/ustad-server.log]
11:46:38,534 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
11:46:38,534 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
11:46:38,534 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
11:46:38,534 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
11:46:38,534 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@3cc1435c - End of configuration.
11:46:38,534 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@6bf0219d - Registering current configuration as safe fallback point
11:46:38,535 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 72 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY

DataDir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8710
CreateLearningSpaceRequest(url=http://37.27.227.212:8710/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8710
[Passed] 004_005_assignment_grace_period_finished (6m 41s)
TestServerController: start server requested
TestServerController: exec /usr/bin/java -Dlogs_dir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8078/log -jar build/libs/ustad-server-all.jar runserver -config=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../app-ktor-server/src/main/resources/application.conf -P:ktor.deployment.port=8078 -P:ktor.ustad.datadir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8078 -P:ktor.ustad.jsDevServer=
http://37.27.227.212:8078/api/centralappconfig/learningspace/getAll ready
11:53:36,077 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
11:53:36,077 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - No custom configurators were discovered as a service.
11:53:36,077 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
11:53:36,078 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
11:53:36,081 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
11:53:36,081 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
11:53:36,085 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 3 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
11:53:36,085 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
11:53:36,085 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
11:53:36,085 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
11:53:36,087 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml]
11:53:36,088 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@157853da - URL [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml] is not of type file
11:53:36,125 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
11:53:36,125 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
11:53:36,138 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - No compression will be used
11:53:36,138 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - Will use the pattern /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8078/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
11:53:36,147 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - The date pattern is 'yyyy-MM-dd' from file name pattern '/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8078/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
11:53:36,147 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Roll-over at midnight.
11:53:36,150 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Setting initial period to 2025-03-18T10:53:35.912Z
11:53:36,150 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
11:53:36,150 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
11:53:36,151 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
11:53:36,156 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Active log file name: /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8078/log/ustad-server.log
11:53:36,156 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - File property is set to [/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8078/log/ustad-server.log]
11:53:36,156 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
11:53:36,156 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
11:53:36,157 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
11:53:36,157 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
11:53:36,157 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@3cc1435c - End of configuration.
11:53:36,157 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@6bf0219d - Registering current configuration as safe fallback point
11:53:36,157 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 72 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY

DataDir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8078
CreateLearningSpaceRequest(url=http://37.27.227.212:8078/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8078
[Passed] 007_004_username_validation_and_add_profile_pic (9m 46s)
TestServerController: start server requested
TestServerController: exec /usr/bin/java -Dlogs_dir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8541/log -jar build/libs/ustad-server-all.jar runserver -config=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../app-ktor-server/src/main/resources/application.conf -P:ktor.deployment.port=8541 -P:ktor.ustad.datadir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8541 -P:ktor.ustad.jsDevServer=
http://37.27.227.212:8541/api/centralappconfig/learningspace/getAll ready
12:03:23,264 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
12:03:23,264 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - No custom configurators were discovered as a service.
12:03:23,264 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
12:03:23,265 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
12:03:23,268 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
12:03:23,268 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
12:03:23,271 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 3 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
12:03:23,271 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
12:03:23,271 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
12:03:23,272 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
12:03:23,273 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml]
12:03:23,274 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@157853da - URL [jar:file:/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/app-ktor-server/build/libs/ustad-server-all.jar!/logback.xml] is not of type file
12:03:23,310 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
12:03:23,310 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
12:03:23,322 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - No compression will be used
12:03:23,322 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@119290689 - Will use the pattern /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8541/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
12:03:23,331 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - The date pattern is 'yyyy-MM-dd' from file name pattern '/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8541/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
12:03:23,331 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Roll-over at midnight.
12:03:23,334 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - Setting initial period to 2025-03-18T11:03:23.099Z
12:03:23,334 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
12:03:23,334 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@236e3f4e - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
12:03:23,335 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
12:03:23,340 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Active log file name: /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8541/log/ustad-server.log
12:03:23,340 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - File property is set to [/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8541/log/ustad-server.log]
12:03:23,340 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
12:03:23,340 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
12:03:23,340 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
12:03:23,341 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
12:03:23,341 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@3cc1435c - End of configuration.
12:03:23,341 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@6bf0219d - Registering current configuration as safe fallback point
12:03:23,341 |-INFO in ch.qos.logback.classic.util.ContextInitializer@343570b7 - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 70 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY

DataDir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/android-maestro/../../testserver-controller/build/data/server-8541
CreateLearningSpaceRequest(url=http://37.27.227.212:8541/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8541
[Passed] 003_006_course_view_and_modules_can_expand_collapse (6m 41s)

32/32 Flows Passed

==== View details in the console ====

https://app.robintest.com/project/proj_01jjbq65hrff8a3jkm7v2s0ty8/maestro-test/app/app_01jjbx8fgxf4fbbfm8gwh990zz/upload/mupload_01jpkzreqhek1992at1dk8snxk


Process will exit with code 0 (SUCCESS)
[htmlpublisher] Archiving HTML reports...
Recording test results
[Checks API] No suitable checks publisher found.
[Slack Notifications] found #34 as previous completed, non-aborted build
Finished: SUCCESS