Console Output

08:17:28,997 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - 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-8536
CreateLearningSpaceRequest(url=http://37.27.227.212:8536/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


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-8365/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=8365 -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-8365 -P:ktor.ustad.jsDevServer= -P:ktor.ustad.useMockEmail=true
http://37.27.227.212:8365/api/centralappconfig/learningspace/getAll ready
08:18:42,258 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
08:18:42,258 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - No custom configurators were discovered as a service.
08:18:42,258 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
08:18:42,259 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
08:18:42,262 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
08:18:42,262 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
08:18:42,266 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 4 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
08:18:42,266 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
08:18:42,266 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
08:18:42,266 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
08:18:42,267 |-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:18:42,269 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@71c3b41 - 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:18:42,307 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
08:18:42,307 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
08:18:42,319 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - No compression will be used
08:18:42,319 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - 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-8365/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
08:18:42,328 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - 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-8365/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
08:18:42,328 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Roll-over at midnight.
08:18:42,331 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Setting initial period to 2025-06-01T06:18:42.090Z
08:18:42,331 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
08:18:42,331 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
08:18:42,332 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
08:18:42,336 |-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-8365/log/ustad-server.log
08:18:42,337 |-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-8365/log/ustad-server.log]
08:18:42,337 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
08:18:42,337 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
08:18:42,337 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
08:18:42,337 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
08:18:42,337 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@6bf0219d - End of configuration.
08:18:42,338 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@dd0c991 - Registering current configuration as safe fallback point
08:18:42,338 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - 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-8365
CreateLearningSpaceRequest(url=http://37.27.227.212:8365/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8365
[Passed] 001_001_admin_can_add_content_005_using_link (6m 41s)
TestServerController: stopping server on port: 8536
[Passed] 002_002_student_joining_course_using_code (8m 45s)
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-8695/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=8695 -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-8695 -P:ktor.ustad.jsDevServer= -P:ktor.ustad.useMockEmail=true
http://37.27.227.212:8695/api/centralappconfig/learningspace/getAll ready
08:25:44,112 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
08:25:44,112 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - No custom configurators were discovered as a service.
08:25:44,112 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
08:25:44,113 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
08:25:44,116 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
08:25:44,116 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
08:25:44,120 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 3 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
08:25:44,120 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
08:25:44,120 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
08:25:44,121 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
08:25:44,122 |-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:25:44,124 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@71c3b41 - 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:25:44,167 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
08:25:44,167 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
08:25:44,180 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - No compression will be used
08:25:44,180 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - 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-8695/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
08:25:44,190 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - 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-8695/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
08:25:44,190 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Roll-over at midnight.
08:25:44,192 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Setting initial period to 2025-06-01T06:25:43.950Z
08:25:44,193 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
08:25:44,193 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
08:25:44,194 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
08:25:44,198 |-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-8695/log/ustad-server.log
08:25:44,198 |-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-8695/log/ustad-server.log]
08:25:44,199 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
08:25:44,199 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
08:25:44,199 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
08:25:44,199 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
08:25:44,199 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@6bf0219d - End of configuration.
08:25:44,199 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@dd0c991 - Registering current configuration as safe fallback point
08:25:44,199 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 79 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-8695
CreateLearningSpaceRequest(url=http://37.27.227.212:8695/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


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-8236/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=8236 -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-8236 -P:ktor.ustad.jsDevServer= -P:ktor.ustad.useMockEmail=true
http://37.27.227.212:8236/api/centralappconfig/learningspace/getAll ready
08:26:09,532 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
08:26:09,532 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - No custom configurators were discovered as a service.
08:26:09,532 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
08:26:09,532 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
08:26:09,536 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
08:26:09,536 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
08:26:09,540 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 4 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
08:26:09,540 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
08:26:09,540 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
08:26:09,540 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
08:26:09,542 |-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:26:09,543 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@71c3b41 - 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:26:09,581 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
08:26:09,581 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
08:26:09,593 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - No compression will be used
08:26:09,593 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - 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-8236/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
08:26:09,602 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - 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-8236/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
08:26:09,602 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Roll-over at midnight.
08:26:09,605 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Setting initial period to 2025-06-01T06:26:09.371Z
08:26:09,605 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
08:26:09,605 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
08:26:09,606 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
08:26:09,611 |-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-8236/log/ustad-server.log
08:26:09,611 |-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-8236/log/ustad-server.log]
08:26:09,611 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
08:26:09,611 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
08:26:09,612 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
08:26:09,612 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
08:26:09,612 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@6bf0219d - End of configuration.
08:26:09,612 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@dd0c991 - Registering current configuration as safe fallback point
08:26:09,612 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - 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-8236
CreateLearningSpaceRequest(url=http://37.27.227.212:8236/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8695
[Passed] 002_005_admin_grant_permissions_test (7m 2s)
TestServerController: stopping server on port: 8236
[Passed] 004_005_assignment_grace_period_finished (7m 2s)
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-8646/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=8646 -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-8646 -P:ktor.ustad.jsDevServer= -P:ktor.ustad.useMockEmail=true
http://37.27.227.212:8646/api/centralappconfig/learningspace/getAll ready
08:32:57,155 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
08:32:57,155 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - No custom configurators were discovered as a service.
08:32:57,155 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
08:32:57,156 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
08:32:57,159 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
08:32:57,159 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
08:32:57,164 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 4 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
08:32:57,164 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
08:32:57,164 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
08:32:57,165 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
08:32:57,166 |-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:32:57,168 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@71c3b41 - 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:32:57,207 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
08:32:57,207 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
08:32:57,219 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - No compression will be used
08:32:57,219 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - 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-8646/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
08:32:57,228 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - 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-8646/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
08:32:57,229 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Roll-over at midnight.
08:32:57,231 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Setting initial period to 2025-06-01T06:32:56.993Z
08:32:57,231 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
08:32:57,231 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
08:32:57,232 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
08:32:57,237 |-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-8646/log/ustad-server.log
08:32:57,237 |-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-8646/log/ustad-server.log]
08:32:57,237 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
08:32:57,237 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
08:32:57,238 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
08:32:57,238 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
08:32:57,238 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@6bf0219d - End of configuration.
08:32:57,238 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@dd0c991 - Registering current configuration as safe fallback point
08:32:57,238 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - 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-8646
CreateLearningSpaceRequest(url=http://37.27.227.212:8646/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


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-8400/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=8400 -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-8400 -P:ktor.ustad.jsDevServer= -P:ktor.ustad.useMockEmail=true
http://37.27.227.212:8400/api/centralappconfig/learningspace/getAll ready
08:33:40,256 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
08:33:40,256 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - No custom configurators were discovered as a service.
08:33:40,256 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
08:33:40,257 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
08:33:40,260 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
08:33:40,260 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
08:33:40,263 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 3 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
08:33:40,263 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
08:33:40,264 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
08:33:40,264 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
08:33:40,265 |-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:33:40,267 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@71c3b41 - 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:33:40,303 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
08:33:40,303 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
08:33:40,315 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - No compression will be used
08:33:40,315 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - 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-8400/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
08:33:40,324 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - 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-8400/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
08:33:40,324 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Roll-over at midnight.
08:33:40,327 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Setting initial period to 2025-06-01T06:33:40.093Z
08:33:40,327 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
08:33:40,327 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
08:33:40,328 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
08:33:40,333 |-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-8400/log/ustad-server.log
08:33:40,333 |-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-8400/log/ustad-server.log]
08:33:40,333 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
08:33:40,333 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
08:33:40,333 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
08:33:40,333 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
08:33:40,333 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@6bf0219d - End of configuration.
08:33:40,334 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@dd0c991 - Registering current configuration as safe fallback point
08:33:40,334 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - 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-8400
CreateLearningSpaceRequest(url=http://37.27.227.212:8400/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8400
[Passed] 003_005_course_view_and_modules_can_expand_collapse (7m 12s)
TestServerController: stopping server on port: 8646
[Passed] 001_003_admin_can_delete_and_restore_content_001 (8m 4s)
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-8586/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=8586 -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-8586 -P:ktor.ustad.jsDevServer= -P:ktor.ustad.useMockEmail=true
http://37.27.227.212:8586/api/centralappconfig/learningspace/getAll ready
08:40:50,581 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
08:40:50,582 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - No custom configurators were discovered as a service.
08:40:50,582 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
08:40:50,582 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
08:40:50,586 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
08:40:50,586 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
08:40:50,590 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 4 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
08:40:50,590 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
08:40:50,590 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
08:40:50,590 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
08:40:50,592 |-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:40:50,593 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@71c3b41 - 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:40:50,637 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
08:40:50,637 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
08:40:50,650 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - No compression will be used
08:40:50,651 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - 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-8586/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
08:40:50,660 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - 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-8586/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
08:40:50,660 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Roll-over at midnight.
08:40:50,663 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Setting initial period to 2025-06-01T06:40:50.437Z
08:40:50,663 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
08:40:50,663 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
08:40:50,664 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
08:40:50,669 |-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-8586/log/ustad-server.log
08:40:50,669 |-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-8586/log/ustad-server.log]
08:40:50,669 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
08:40:50,669 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
08:40:50,670 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
08:40:50,670 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
08:40:50,670 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@6bf0219d - End of configuration.
08:40:50,670 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@dd0c991 - Registering current configuration as safe fallback point
08:40:50,670 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - 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-8586
CreateLearningSpaceRequest(url=http://37.27.227.212:8586/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


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-8453/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=8453 -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-8453 -P:ktor.ustad.jsDevServer= -P:ktor.ustad.useMockEmail=true
http://37.27.227.212:8453/api/centralappconfig/learningspace/getAll ready
08:41:24,990 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
08:41:24,990 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - No custom configurators were discovered as a service.
08:41:24,990 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
08:41:24,991 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
08:41:24,994 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
08:41:24,994 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
08:41:24,998 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 4 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
08:41:24,998 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
08:41:24,998 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
08:41:24,998 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
08:41:25,000 |-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:41:25,002 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@71c3b41 - 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:41:25,040 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
08:41:25,041 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
08:41:25,053 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - No compression will be used
08:41:25,053 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - 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-8453/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
08:41:25,062 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - 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-8453/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
08:41:25,062 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Roll-over at midnight.
08:41:25,065 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Setting initial period to 2025-06-01T06:41:24.823Z
08:41:25,065 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
08:41:25,065 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
08:41:25,066 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
08:41:25,070 |-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-8453/log/ustad-server.log
08:41:25,070 |-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-8453/log/ustad-server.log]
08:41:25,071 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
08:41:25,071 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
08:41:25,071 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
08:41:25,071 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
08:41:25,071 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@6bf0219d - End of configuration.
08:41:25,072 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@dd0c991 - Registering current configuration as safe fallback point
08:41:25,072 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - 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-8453
CreateLearningSpaceRequest(url=http://37.27.227.212:8453/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8453
[Passed] 007_007a_admin_send_group_invitation_to_join_course_via_username (6m 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-8998/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=8998 -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-8998 -P:ktor.ustad.jsDevServer= -P:ktor.ustad.useMockEmail=true
http://37.27.227.212:8998/api/centralappconfig/learningspace/getAll ready
08:48:07,266 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
08:48:07,266 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - No custom configurators were discovered as a service.
08:48:07,266 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
08:48:07,266 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
08:48:07,270 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
08:48:07,270 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
08:48:07,274 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 4 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
08:48:07,274 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
08:48:07,274 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
08:48:07,274 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
08:48:07,276 |-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:48:07,277 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@71c3b41 - 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:48:07,314 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
08:48:07,315 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
08:48:07,326 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - No compression will be used
08:48:07,327 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - 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-8998/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
08:48:07,335 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - 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-8998/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
08:48:07,336 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Roll-over at midnight.
08:48:07,338 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Setting initial period to 2025-06-01T06:48:07.126Z
08:48:07,338 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
08:48:07,338 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
08:48:07,339 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
08:48:07,344 |-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-8998/log/ustad-server.log
08:48:07,344 |-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-8998/log/ustad-server.log]
08:48:07,344 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
08:48:07,344 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
08:48:07,345 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
08:48:07,345 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
08:48:07,345 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@6bf0219d - End of configuration.
08:48:07,345 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@dd0c991 - Registering current configuration as safe fallback point
08:48:07,345 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - 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-8998
CreateLearningSpaceRequest(url=http://37.27.227.212:8998/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8998
[Passed] 001_001_admin_can_add_content_004-pdf (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-8213/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=8213 -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-8213 -P:ktor.ustad.jsDevServer= -P:ktor.ustad.useMockEmail=true
http://37.27.227.212:8213/api/centralappconfig/learningspace/getAll ready
08:55:56,499 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
08:55:56,499 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - No custom configurators were discovered as a service.
08:55:56,499 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
08:55:56,499 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
08:55:56,502 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
08:55:56,502 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
08:55:56,506 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 3 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
08:55:56,506 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
08:55:56,506 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
08:55:56,506 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
08:55:56,507 |-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:55:56,509 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@71c3b41 - 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:55:56,548 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
08:55:56,548 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
08:55:56,560 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - No compression will be used
08:55:56,560 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - 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-8213/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
08:55:56,569 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - 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-8213/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
08:55:56,569 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Roll-over at midnight.
08:55:56,572 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Setting initial period to 2025-06-01T06:55:56.357Z
08:55:56,572 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
08:55:56,572 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
08:55:56,573 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
08:55:56,578 |-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-8213/log/ustad-server.log
08:55:56,578 |-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-8213/log/ustad-server.log]
08:55:56,578 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
08:55:56,578 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
08:55:56,579 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
08:55:56,579 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
08:55:56,579 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@6bf0219d - End of configuration.
08:55:56,579 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@dd0c991 - Registering current configuration as safe fallback point
08:55:56,579 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - 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-8213
CreateLearningSpaceRequest(url=http://37.27.227.212:8213/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8586
[Passed] 003_003_add_content_as_block_in_course (19m 13s)
TestServerController: stopping server on port: 8213
[Passed] 005_002_users_can_add_post_on_discussion_board (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-8684/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=8684 -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-8684 -P:ktor.ustad.jsDevServer= -P:ktor.ustad.useMockEmail=true
http://37.27.227.212:8684/api/centralappconfig/learningspace/getAll ready
09:00:28,772 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
09:00:28,772 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - No custom configurators were discovered as a service.
09:00:28,772 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
09:00:28,773 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
09:00:28,776 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
09:00:28,776 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
09:00:28,780 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 3 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
09:00:28,780 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
09:00:28,780 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
09:00:28,780 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
09:00:28,781 |-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:28,783 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@71c3b41 - 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:28,820 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
09:00:28,820 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
09:00:28,832 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - No compression will be used
09:00:28,832 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - 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-8684/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
09:00:28,841 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - 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-8684/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
09:00:28,841 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Roll-over at midnight.
09:00:28,843 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Setting initial period to 2025-06-01T07:00:28.632Z
09:00:28,843 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
09:00:28,843 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
09:00:28,845 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
09:00:28,849 |-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-8684/log/ustad-server.log
09:00:28,849 |-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-8684/log/ustad-server.log]
09:00:28,850 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
09:00:28,850 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
09:00:28,850 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
09:00:28,850 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
09:00:28,850 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@6bf0219d - End of configuration.
09:00:28,850 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@dd0c991 - Registering current configuration as safe fallback point
09:00:28,850 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - 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-8684
CreateLearningSpaceRequest(url=http://37.27.227.212:8684/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8684
[Passed] 005_001_add_discussionBoard (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-8938/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=8938 -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-8938 -P:ktor.ustad.jsDevServer= -P:ktor.ustad.useMockEmail=true
http://37.27.227.212:8938/api/centralappconfig/learningspace/getAll ready
09:03:33,283 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
09:03:33,283 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - No custom configurators were discovered as a service.
09:03:33,283 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
09:03:33,284 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
09:03:33,287 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
09:03:33,287 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
09:03:33,291 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 3 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
09:03:33,291 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
09:03:33,291 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
09:03:33,292 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
09:03:33,293 |-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:03:33,295 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@71c3b41 - 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:03:33,337 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
09:03:33,337 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
09:03:33,350 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - No compression will be used
09:03:33,350 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - 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-8938/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
09:03:33,359 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - 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-8938/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
09:03:33,359 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Roll-over at midnight.
09:03:33,361 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Setting initial period to 2025-06-01T07:03:33.116Z
09:03:33,361 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
09:03:33,361 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
09:03:33,363 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
09:03:33,367 |-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-8938/log/ustad-server.log
09:03:33,367 |-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-8938/log/ustad-server.log]
09:03:33,368 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
09:03:33,368 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
09:03:33,368 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
09:03:33,368 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
09:03:33,368 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@6bf0219d - End of configuration.
09:03:33,368 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@dd0c991 - Registering current configuration as safe fallback point
09:03:33,368 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 77 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-8938
CreateLearningSpaceRequest(url=http://37.27.227.212:8938/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


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-8742/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=8742 -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-8742 -P:ktor.ustad.jsDevServer= -P:ktor.ustad.useMockEmail=true
http://37.27.227.212:8742/api/centralappconfig/learningspace/getAll ready
09:06:29,014 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
09:06:29,014 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - No custom configurators were discovered as a service.
09:06:29,014 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
09:06:29,014 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
09:06:29,017 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
09:06:29,017 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
09:06:29,021 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 3 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
09:06:29,021 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
09:06:29,021 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
09:06:29,021 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
09:06:29,023 |-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:06:29,024 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@71c3b41 - 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:06:29,060 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
09:06:29,060 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
09:06:29,072 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - No compression will be used
09:06:29,073 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - 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-8742/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
09:06:29,081 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - 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-8742/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
09:06:29,081 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Roll-over at midnight.
09:06:29,084 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Setting initial period to 2025-06-01T07:06:28.849Z
09:06:29,084 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
09:06:29,084 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
09:06:29,085 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
09:06:29,090 |-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-8742/log/ustad-server.log
09:06:29,090 |-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-8742/log/ustad-server.log]
09:06:29,090 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
09:06:29,090 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
09:06:29,091 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
09:06:29,091 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
09:06:29,091 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@6bf0219d - End of configuration.
09:06:29,091 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@dd0c991 - Registering current configuration as safe fallback point
09:06:29,091 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - 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-8742
CreateLearningSpaceRequest(url=http://37.27.227.212:8742/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8742
[Passed] 005_005_users_can_delete_post_on_discussion_board (8m 15s)
TestServerController: stopping server on port: 8938
[Passed] 002_001_admin_add_new_course_and_teacher (11m 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-8873/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=8873 -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-8873 -P:ktor.ustad.jsDevServer= -P:ktor.ustad.useMockEmail=true
http://37.27.227.212:8873/api/centralappconfig/learningspace/getAll ready
09:15:40,994 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
09:15:40,994 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - No custom configurators were discovered as a service.
09:15:40,994 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
09:15:40,994 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
09:15:40,998 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
09:15:40,998 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
09:15:41,002 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 4 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
09:15:41,002 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
09:15:41,002 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
09:15:41,002 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
09:15:41,004 |-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:15:41,006 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@71c3b41 - 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:15:41,045 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
09:15:41,045 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
09:15:41,057 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - No compression will be used
09:15:41,057 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - 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-8873/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
09:15:41,066 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - 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-8873/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
09:15:41,066 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Roll-over at midnight.
09:15:41,069 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Setting initial period to 2025-06-01T07:15:40.825Z
09:15:41,069 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
09:15:41,069 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
09:15:41,070 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
09:15:41,074 |-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-8873/log/ustad-server.log
09:15:41,074 |-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-8873/log/ustad-server.log]
09:15:41,075 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
09:15:41,075 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
09:15:41,075 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
09:15:41,075 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
09:15:41,075 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@6bf0219d - End of configuration.
09:15:41,076 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@dd0c991 - Registering current configuration as safe fallback point
09:15:41,076 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - 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-8873
CreateLearningSpaceRequest(url=http://37.27.227.212:8873/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


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-8384/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=8384 -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-8384 -P:ktor.ustad.jsDevServer= -P:ktor.ustad.useMockEmail=true
http://37.27.227.212:8384/api/centralappconfig/learningspace/getAll ready
09:16:16,546 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
09:16:16,546 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - No custom configurators were discovered as a service.
09:16:16,546 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
09:16:16,546 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
09:16:16,550 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
09:16:16,550 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
09:16:16,554 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 4 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
09:16:16,554 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
09:16:16,554 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
09:16:16,554 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
09:16:16,556 |-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:16:16,558 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@71c3b41 - 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:16:16,602 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
09:16:16,602 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
09:16:16,615 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - No compression will be used
09:16:16,615 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - 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-8384/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
09:16:16,624 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - 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-8384/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
09:16:16,624 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Roll-over at midnight.
09:16:16,627 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Setting initial period to 2025-06-01T07:16:16.402Z
09:16:16,627 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
09:16:16,627 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
09:16:16,628 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
09:16:16,633 |-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-8384/log/ustad-server.log
09:16:16,633 |-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-8384/log/ustad-server.log]
09:16:16,633 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
09:16:16,633 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
09:16:16,634 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
09:16:16,634 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
09:16:16,634 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@6bf0219d - End of configuration.
09:16:16,634 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@dd0c991 - Registering current configuration as safe fallback point
09:16:16,634 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - 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-8384
CreateLearningSpaceRequest(url=http://37.27.227.212:8384/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8873
[Passed] 007_005_student_registered_by_admin_or_teacher_dont_need_parentConsent (6m 31s)
TestServerController: stopping server on port: 8384
[Passed] 001_003_admin_can_permanently_delete_the_content_002 (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-8627/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=8627 -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-8627 -P:ktor.ustad.jsDevServer= -P:ktor.ustad.useMockEmail=true
http://37.27.227.212:8627/api/centralappconfig/learningspace/getAll ready
09:22:17,353 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
09:22:17,353 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - No custom configurators were discovered as a service.
09:22:17,353 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
09:22:17,354 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
09:22:17,357 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
09:22:17,357 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
09:22:17,361 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 3 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
09:22:17,361 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
09:22:17,361 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
09:22:17,361 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
09:22:17,363 |-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:22:17,364 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@71c3b41 - 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:22:17,402 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
09:22:17,402 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
09:22:17,414 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - No compression will be used
09:22:17,414 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - 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-8627/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
09:22:17,423 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - 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-8627/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
09:22:17,423 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Roll-over at midnight.
09:22:17,426 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Setting initial period to 2025-06-01T07:22:17.187Z
09:22:17,426 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
09:22:17,426 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
09:22:17,427 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
09:22:17,431 |-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-8627/log/ustad-server.log
09:22:17,431 |-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-8627/log/ustad-server.log]
09:22:17,432 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
09:22:17,432 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
09:22:17,432 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
09:22:17,432 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
09:22:17,432 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@6bf0219d - End of configuration.
09:22:17,432 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@dd0c991 - Registering current configuration as safe fallback point
09:22:17,432 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - 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-8627
CreateLearningSpaceRequest(url=http://37.27.227.212:8627/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


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-8860/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=8860 -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-8860 -P:ktor.ustad.jsDevServer= -P:ktor.ustad.useMockEmail=true
http://37.27.227.212:8860/api/centralappconfig/learningspace/getAll ready
09:24:27,547 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
09:24:27,548 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - No custom configurators were discovered as a service.
09:24:27,548 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
09:24:27,548 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
09:24:27,551 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
09:24:27,551 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
09:24:27,556 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 4 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
09:24:27,556 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
09:24:27,556 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
09:24:27,556 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
09:24:27,558 |-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:24:27,559 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@71c3b41 - 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:24:27,600 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
09:24:27,600 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
09:24:27,611 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - No compression will be used
09:24:27,612 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - 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-8860/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
09:24:27,621 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - 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-8860/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
09:24:27,621 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Roll-over at midnight.
09:24:27,623 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Setting initial period to 2025-06-01T07:24:27.404Z
09:24:27,623 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
09:24:27,623 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
09:24:27,624 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
09:24:27,629 |-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-8860/log/ustad-server.log
09:24:27,629 |-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-8860/log/ustad-server.log]
09:24:27,629 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
09:24:27,630 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
09:24:27,630 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
09:24:27,630 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
09:24:27,630 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@6bf0219d - End of configuration.
09:24:27,630 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@dd0c991 - Registering current configuration as safe fallback point
09:24:27,630 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - 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-8860
CreateLearningSpaceRequest(url=http://37.27.227.212:8860/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8860
[Passed] 002_003_teacher_record_attendance (5m 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-8715/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=8715 -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-8715 -P:ktor.ustad.jsDevServer= -P:ktor.ustad.useMockEmail=true
http://37.27.227.212:8715/api/centralappconfig/learningspace/getAll ready
09:30:00,940 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
09:30:00,940 |-INFO in ch.qos.logback.classic.util.ContextInitializer@236e3f4e - No custom configurators were discovered as a service.
09:30:00,940 |-INFO in ch.qos.logback.classic.util.ContextInitializer@236e3f4e - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
09:30:00,940 |-INFO in ch.qos.logback.classic.util.ContextInitializer@236e3f4e - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
09:30:00,943 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
09:30:00,943 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
09:30:00,947 |-INFO in ch.qos.logback.classic.util.ContextInitializer@236e3f4e - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 3 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
09:30:00,947 |-INFO in ch.qos.logback.classic.util.ContextInitializer@236e3f4e - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
09:30:00,947 |-INFO in ch.qos.logback.classic.util.ContextInitializer@236e3f4e - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
09:30:00,947 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
09:30:00,949 |-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:30:00,950 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@3cc1435c - 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:30:00,987 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
09:30:00,987 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
09:30:00,999 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@1810899357 - No compression will be used
09:30:00,999 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@1810899357 - 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-8715/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
09:30:01,008 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@dd0c991 - 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-8715/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
09:30:01,008 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@dd0c991 - Roll-over at midnight.
09:30:01,011 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@dd0c991 - Setting initial period to 2025-06-01T07:30:00.815Z
09:30:01,011 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@dd0c991 - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
09:30:01,011 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@dd0c991 - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
09:30:01,012 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
09:30:01,016 |-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-8715/log/ustad-server.log
09:30:01,017 |-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-8715/log/ustad-server.log]
09:30:01,017 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
09:30:01,017 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
09:30:01,017 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
09:30:01,017 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
09:30:01,017 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@5f16132a - End of configuration.
09:30:01,018 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@69fb6037 - Registering current configuration as safe fallback point
09:30:01,018 |-INFO in ch.qos.logback.classic.util.ContextInitializer@236e3f4e - 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-8715
CreateLearningSpaceRequest(url=http://37.27.227.212:8715/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8627
[Passed] 004_004_assignment_after_deadline_and_before_grace_Period (11m)
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-8464/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=8464 -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-8464 -P:ktor.ustad.jsDevServer= -P:ktor.ustad.useMockEmail=true
http://37.27.227.212:8464/api/centralappconfig/learningspace/getAll ready
09:33:48,962 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
09:33:48,963 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - No custom configurators were discovered as a service.
09:33:48,963 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
09:33:48,963 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
09:33:48,967 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
09:33:48,967 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
09:33:48,971 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 4 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
09:33:48,971 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
09:33:48,971 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
09:33:48,971 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
09:33:48,973 |-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:33:48,975 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@71c3b41 - 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:33:49,014 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
09:33:49,014 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
09:33:49,025 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - No compression will be used
09:33:49,026 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - 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-8464/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
09:33:49,035 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - 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-8464/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
09:33:49,035 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Roll-over at midnight.
09:33:49,037 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Setting initial period to 2025-06-01T07:33:48.794Z
09:33:49,037 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
09:33:49,037 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
09:33:49,039 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
09:33:49,043 |-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-8464/log/ustad-server.log
09:33:49,043 |-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-8464/log/ustad-server.log]
09:33:49,044 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
09:33:49,044 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
09:33:49,044 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
09:33:49,044 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
09:33:49,044 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@6bf0219d - End of configuration.
09:33:49,044 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@dd0c991 - Registering current configuration as safe fallback point
09:33:49,044 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - 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-8464
CreateLearningSpaceRequest(url=http://37.27.227.212:8464/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8715
[Passed] 003_006_all_user_able_to_open_text_block (8m 56s)
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-8824/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=8824 -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-8824 -P:ktor.ustad.jsDevServer= -P:ktor.ustad.useMockEmail=true
http://37.27.227.212:8824/api/centralappconfig/learningspace/getAll ready
09:39:03,299 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
09:39:03,300 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - No custom configurators were discovered as a service.
09:39:03,300 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
09:39:03,300 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
09:39:03,303 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
09:39:03,303 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
09:39:03,306 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 3 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
09:39:03,306 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
09:39:03,306 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
09:39:03,307 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
09:39:03,308 |-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:39:03,309 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@71c3b41 - 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:39:03,345 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
09:39:03,345 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
09:39:03,357 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - No compression will be used
09:39:03,357 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - 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-8824/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
09:39:03,366 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - 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-8824/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
09:39:03,366 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Roll-over at midnight.
09:39:03,369 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Setting initial period to 2025-06-01T07:39:03.178Z
09:39:03,369 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
09:39:03,369 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
09:39:03,370 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
09:39:03,374 |-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-8824/log/ustad-server.log
09:39:03,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-8824/log/ustad-server.log]
09:39:03,375 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
09:39:03,375 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
09:39:03,375 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
09:39:03,375 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
09:39:03,375 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@6bf0219d - End of configuration.
09:39:03,376 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@dd0c991 - Registering current configuration as safe fallback point
09:39:03,376 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - 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-8824
CreateLearningSpaceRequest(url=http://37.27.227.212:8824/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8824
[Passed] 005_004_users_can_add_external_links_as_post_on_discussion_board (7m 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-8522/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=8522 -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-8522 -P:ktor.ustad.jsDevServer= -P:ktor.ustad.useMockEmail=true
http://37.27.227.212:8522/api/centralappconfig/learningspace/getAll ready
09:47:18,509 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
09:47:18,509 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - No custom configurators were discovered as a service.
09:47:18,509 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
09:47:18,510 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
09:47:18,513 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
09:47:18,513 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
09:47:18,517 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 3 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
09:47:18,517 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
09:47:18,517 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
09:47:18,517 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
09:47:18,519 |-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:47:18,520 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@71c3b41 - 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:47:18,557 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
09:47:18,558 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
09:47:18,569 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - No compression will be used
09:47:18,570 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - 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-8522/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
09:47:18,579 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - 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-8522/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
09:47:18,579 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Roll-over at midnight.
09:47:18,581 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Setting initial period to 2025-06-01T07:47:18.346Z
09:47:18,581 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
09:47:18,581 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
09:47:18,583 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
09:47:18,587 |-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-8522/log/ustad-server.log
09:47:18,587 |-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-8522/log/ustad-server.log]
09:47:18,587 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
09:47:18,588 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
09:47:18,588 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
09:47:18,588 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
09:47:18,588 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@6bf0219d - End of configuration.
09:47:18,588 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@dd0c991 - Registering current configuration as safe fallback point
09:47:18,588 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - 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-8522
CreateLearningSpaceRequest(url=http://37.27.227.212:8522/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8464
[Passed] 004_003_multiple_submission_possible_for_student (19m 50s)
TestServerController: stopping server on port: 8522
[Passed] 007_002b_user_registration_above_age_13_join_learning_space_username_password (6m 34s)
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-8854/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=8854 -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-8854 -P:ktor.ustad.jsDevServer= -P:ktor.ustad.useMockEmail=true
http://37.27.227.212:8854/api/centralappconfig/learningspace/getAll ready
09:53:57,686 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
09:53:57,687 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - No custom configurators were discovered as a service.
09:53:57,687 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
09:53:57,687 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
09:53:57,690 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
09:53:57,690 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
09:53:57,694 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 3 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
09:53:57,694 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
09:53:57,694 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
09:53:57,695 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
09:53:57,696 |-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:53:57,698 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@71c3b41 - 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:53:57,737 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
09:53:57,737 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
09:53:57,749 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - No compression will be used
09:53:57,750 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - 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-8854/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
09:53:57,759 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - 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-8854/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
09:53:57,759 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Roll-over at midnight.
09:53:57,761 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Setting initial period to 2025-06-01T07:53:57.523Z
09:53:57,761 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
09:53:57,761 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
09:53:57,762 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
09:53:57,767 |-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-8854/log/ustad-server.log
09:53:57,767 |-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-8854/log/ustad-server.log]
09:53:57,768 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
09:53:57,768 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
09:53:57,768 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
09:53:57,768 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
09:53:57,768 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@6bf0219d - End of configuration.
09:53:57,768 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@dd0c991 - Registering current configuration as safe fallback point
09:53:57,768 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - 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-8854
CreateLearningSpaceRequest(url=http://37.27.227.212:8854/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


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-8059/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=8059 -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-8059 -P:ktor.ustad.jsDevServer= -P:ktor.ustad.useMockEmail=true
http://37.27.227.212:8059/api/centralappconfig/learningspace/getAll ready
09:54:05,958 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
09:54:05,959 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - No custom configurators were discovered as a service.
09:54:05,959 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
09:54:05,959 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
09:54:05,962 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
09:54:05,962 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
09:54:05,966 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 3 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
09:54:05,966 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
09:54:05,967 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
09:54:05,967 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
09:54:05,968 |-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:54:05,970 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@71c3b41 - 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:54:06,010 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
09:54:06,010 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
09:54:06,022 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - No compression will be used
09:54:06,023 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - 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-8059/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
09:54:06,032 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - 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-8059/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
09:54:06,032 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Roll-over at midnight.
09:54:06,034 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Setting initial period to 2025-06-01T07:54:05.797Z
09:54:06,034 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
09:54:06,034 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
09:54:06,035 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
09:54:06,040 |-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-8059/log/ustad-server.log
09:54:06,040 |-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-8059/log/ustad-server.log]
09:54:06,040 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
09:54:06,040 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
09:54:06,041 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
09:54:06,041 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
09:54:06,041 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@6bf0219d - End of configuration.
09:54:06,041 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@dd0c991 - Registering current configuration as safe fallback point
09:54:06,041 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - 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-8059
CreateLearningSpaceRequest(url=http://37.27.227.212:8059/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8059
[Passed] 001_004_admin_can_move_content (6m 34s)
TestServerController: stopping server on port: 8854
[Passed] 007_001_admin_enable_or_disable_user_registration (9m 10s)
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-8995/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=8995 -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-8995 -P:ktor.ustad.jsDevServer= -P:ktor.ustad.useMockEmail=true
http://37.27.227.212:8995/api/centralappconfig/learningspace/getAll ready
10:01:02,196 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
10:01:02,197 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - No custom configurators were discovered as a service.
10:01:02,197 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
10:01:02,197 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
10:01:02,200 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
10:01:02,200 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
10:01:02,204 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 3 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
10:01:02,204 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
10:01:02,204 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
10:01:02,204 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
10:01:02,206 |-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:01:02,207 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@71c3b41 - 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:01:02,244 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
10:01:02,244 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
10:01:02,256 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - No compression will be used
10:01:02,256 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - 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-8995/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
10:01:02,265 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - 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-8995/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
10:01:02,265 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Roll-over at midnight.
10:01:02,268 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Setting initial period to 2025-06-01T08:01:02.029Z
10:01:02,268 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
10:01:02,268 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
10:01:02,269 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
10:01:02,274 |-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-8995/log/ustad-server.log
10:01:02,274 |-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-8995/log/ustad-server.log]
10:01:02,274 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
10:01:02,274 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
10:01:02,274 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
10:01:02,274 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
10:01:02,274 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@6bf0219d - End of configuration.
10:01:02,275 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@dd0c991 - Registering current configuration as safe fallback point
10:01:02,275 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - 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-8995
CreateLearningSpaceRequest(url=http://37.27.227.212:8995/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


TestServerController: stopping server on port: 8995
[Passed] 004_001_assignment_creation_submission_grading (13m 6s)

32/32 Flows Passed

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

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


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