Skip to content
[Jenkins]Jenkins
log in
Failed

Console Output

Download View as plain text
This log is too long to show here, 4,399 KB has been skipped — click to see the complete log 
07:41:15,874 |-INFO in ch.qos.logback.classic.util.ContextInitializer@236e3f4e - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
07:41:15,874 |-INFO in ch.qos.logback.classic.util.ContextInitializer@236e3f4e - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
07:41:15,874 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
07:41:15,875 |-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]
07:41:15,877 |-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
07:41:15,916 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
07:41:15,916 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
07:41:15,929 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@1810899357 - No compression will be used
07:41:15,930 |-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/webapp-cypress/../../testserver-controller/build/data/server-5436/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
07:41:15,940 |-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/webapp-cypress/../../testserver-controller/build/data/server-5436/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
07:41:15,940 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@dd0c991 - Roll-over at midnight.
07:41:15,943 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@dd0c991 - Setting initial period to 2025-05-31T05:41:15.724Z
07:41:15,943 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@dd0c991 - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
07:41:15,943 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@dd0c991 - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
07:41:15,944 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
07:41:15,949 |-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/webapp-cypress/../../testserver-controller/build/data/server-5436/log/ustad-server.log
07:41:15,949 |-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/webapp-cypress/../../testserver-controller/build/data/server-5436/log/ustad-server.log]
07:41:15,950 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
07:41:15,950 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
07:41:15,950 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
07:41:15,950 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
07:41:15,951 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@5f16132a - End of configuration.
07:41:15,951 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@69fb6037 - Registering current configuration as safe fallback point
07:41:15,951 |-INFO in ch.qos.logback.classic.util.ContextInitializer@236e3f4e - 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/webapp-cypress/../../testserver-controller/build/data/server-5436
CreateLearningSpaceRequest(url=http://37.27.227.212:8070/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


          cy:log ✱  Clearing IndexedDB: 37_27_227_212_8070
      cy:command ✔  delete	IDBDatabase - 37_27_227_212_8070
      cy:command ✔  visit	/ -> 302: http://37.27.227.212:8070/umapp/
        cons:log ✱  DEBUG NoTag : Index: Window.onLoad
      cy:command ✔  contains	button[class*="MuiButton-outlinedPrimary"], New user
       cons:info ✱  INFO DoorLog : DatabaseBuilderJs: Creating database sqlite:37_27_227_212_8070
                    
       cons:info ✱  INFO DoorLog : DatabaseBuilderJs: creating door triggers and receive views sqlite:37_27_227_212_8070
                    
       cons:info ✱  INFO DoorLog : Built database for: sqlite:37_27_227_212_8070
                    
        cons:log ✱  DEBUG NoTag : Built UmAppDatabase
        cons:log ✱  Learning Space URL = http://37.27.227.212:8070/ (location.href = http://37.27.227.212:8070/umapp/
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  [object Object]
        cons:log ✱  DEBUG NoTag : Creating ViewModel: RedirectViewModel
        cons:log ✱  NavHost: key = default
        cons:log ✱  VERBOSE NoTag : NavHost: useEffect check: key = default current viewname =  popUpToTarget = undefined navtoAfterPop = undefined popUpToInclusive = false clearStack = false clearStackHitPlaceholder = false popUpToHitDestination = false
        cons:log ✱  VERBOSE NoTag : NavHost: action: no pop or other operation pending, show children
      cons:debug ⚈  TRACE: Adding Accept=application header for http://37.27.227.212:8070/UmAppDatabase/replication/ackAndGetPendingReplications
      cons:debug ⚈  TRACE: Body type class TextContent is in ignored types. Skipping ContentNegotiation for http://37.27.227.212:8070/UmAppDatabase/replication/ackAndGetPendingReplications.
      cons:debug ⚈  TRACE: Adding Accept-Charset=UTF-8 to http://37.27.227.212:8070/UmAppDatabase/replication/ackAndGetPendingReplications
      cons:debug ⚈  TRACE: Transformed with default transformers request body for http://37.27.227.212:8070/UmAppDatabase/replication/ackAndGetPendingReplications from class TextContent
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cy:fetch ➟  POST http://37.27.227.212:8070/UmAppDatabase/replication/ackAndGetPendingReplications
                    Status: 204
      cons:debug ⚈  TRACE: Validating response for request http://37.27.227.212:8070/UmAppDatabase/replication/ackAndGetPendingReplications
      cons:debug ⚈  TRACE: Skipping default response validation for http://37.27.227.212:8070/UmAppDatabase/replication/ackAndGetPendingReplications
      cons:debug ⚈  TRACE: Adding Accept=application header for http://37.27.227.212:8070/UmAppDatabase/SiteDao/getSiteAsync
      cons:debug ⚈  TRACE: Body type class EmptyContent is in ignored types. Skipping ContentNegotiation for http://37.27.227.212:8070/UmAppDatabase/SiteDao/getSiteAsync.
      cons:debug ⚈  TRACE: Adding Accept-Charset=UTF-8 to http://37.27.227.212:8070/UmAppDatabase/SiteDao/getSiteAsync
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cy:fetch ➟  GET http://37.27.227.212:8070/UmAppDatabase/SiteDao/getSiteAsync
                    Status: 200
      cons:debug ⚈  TRACE: Validating response for request http://37.27.227.212:8070/UmAppDatabase/SiteDao/getSiteAsync
      cons:debug ⚈  TRACE: Skipping default response validation for http://37.27.227.212:8070/UmAppDatabase/SiteDao/getSiteAsync
      cons:debug ⚈  TRACE: Response body is already transformed. Skipping ContentNegotiation for http://37.27.227.212:8070/UmAppDatabase/SiteDao/getSiteAsync.
      cons:debug ⚈  TRACE: Transformed with default transformers response body for http://37.27.227.212:8070/UmAppDatabase/SiteDao/getSiteAsync to class ByteReadPacket
      cons:debug ⚈  TRACE: Adding Accept=application header for http://37.27.227.212:8070/UmAppDatabase/replication/nodeId
      cons:debug ⚈  TRACE: Body type class EmptyContent is in ignored types. Skipping ContentNegotiation for http://37.27.227.212:8070/UmAppDatabase/replication/nodeId.
      cons:debug ⚈  TRACE: Adding Accept-Charset=UTF-8 to http://37.27.227.212:8070/UmAppDatabase/replication/nodeId
        cy:fetch ➟  GET http://37.27.227.212:8070/UmAppDatabase/replication/nodeId
                    Status: 204
      cons:debug ⚈  TRACE: Validating response for request http://37.27.227.212:8070/UmAppDatabase/replication/nodeId
      cons:debug ⚈  TRACE: Skipping default response validation for http://37.27.227.212:8070/UmAppDatabase/replication/nodeId
        cons:log ✱  DEBUG NoTag : useNavControllerEffect: collect command: NavigateNavCommand(viewName=AddAccountSelectNewOrExisting, args={next=CourseListHome, noSessionChange=false, learningSpaceUrl=http://37.27.227.212:8070/}, goOptions=UstadGoOptions(popUpToViewName=null, popUpToInclusive=false, clearStack=false, serializer=null))
        cons:log ✱  DEBUG NoTag : NavHostFunction: go to /AddAccountSelectNewOrExisting?next=CourseListHome&noSessionChange=false&learningSpaceUrl=http%3A%2F%2F37.27.227.212%3A8070%2F
      cy:command ✔  new url	http://37.27.227.212:8070/umapp/#/AddAccountSelectNewOrExisting?next=CourseListHome&noSessionChange=false&learningSpaceUrl=http%3A%2F%2F37.27.227.212%3A8070%2F
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  DEBUG NoTag : Creating ViewModel: AddAccountSelectNewOrExistingViewModel
        cons:log ✱  DEBUG NoTag : Close ViewModel: RedirectViewModel
        cons:log ✱  NavHost: key = ugwhwwnd
        cons:log ✱  VERBOSE NoTag : NavHost: useEffect check: key = ugwhwwnd current viewname = AddAccountSelectNewOrExisting popUpToTarget = undefined navtoAfterPop = undefined popUpToInclusive = false clearStack = false clearStackHitPlaceholder = false popUpToHitDestination = false
        cons:log ✱  VERBOSE NoTag : NavHost: action: no pop or other operation pending, show children
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
      cy:command ✔  click	
        cons:log ✱  DEBUG NoTag : useNavControllerEffect: collect command: NavigateNavCommand(viewName=RegisterAgeRedirect, args={learningSpaceUrl=http://37.27.227.212:8070/, next=CourseListHome, newOrExisting=new}, goOptions=UstadGoOptions(popUpToViewName=null, popUpToInclusive=false, clearStack=false, serializer=null))
        cons:log ✱  DEBUG NoTag : NavHostFunction: go to /RegisterAgeRedirect?learningSpaceUrl=http%3A%2F%2F37.27.227.212%3A8070%2F&next=CourseListHome&newOrExisting=new
      cy:command ✔  new url	http://37.27.227.212:8070/umapp/#/RegisterAgeRedirect?learningSpaceUrl=http%3A%2F%2F37.27.227.212%3A8070%2F&next=CourseListHome&newOrExisting=new
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  DEBUG NoTag : Creating ViewModel: RegisterAgeRedirectViewModel
        cons:log ✱  DEBUG NoTag : Close ViewModel: AddAccountSelectNewOrExistingViewModel
        cons:log ✱  NavHost: key = i74wr27l
        cons:log ✱  VERBOSE NoTag : NavHost: useEffect check: key = i74wr27l current viewname = RegisterAgeRedirect popUpToTarget = undefined navtoAfterPop = undefined popUpToInclusive = false clearStack = false clearStackHitPlaceholder = false popUpToHitDestination = false
        cons:log ✱  VERBOSE NoTag : NavHost: action: no pop or other operation pending, show children
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
      cy:command ✔  get	#age_date_of_birth
      cy:command ✔  assert	expected **<input#age_date_of_birth.MuiInputBase-input.MuiOutlinedInput-input.css-1x5jdmq>** to be **visible**
      cy:command ✔  contains	button, Next
      cy:command ✔  click	
      cy:command ✔  contains	This field is required
      cy:command ✔  assert	expected **<p#age_date_of_birth-helper-text.MuiFormHelperText-root.Mui-error.MuiFormHelperText-sizeMedium.MuiFormHelperText-contained.css-v7esy>** to be **visible**
      cy:command ✔  get	#age_date_of_birth
      cy:command ✔  type	2010-06-01
       cons:info ✱  INFO DoorLog : [SQLiteDataSourceJs - 37_27_227_212_8070] Saved to IndexedDb: 37_27_227_212_8070
        cons:log ✱  onChange: 2010-06-01
      cy:command ✔  contains	button, Next
      cy:command ✔  click	
        cons:log ✱  DEBUG NoTag : useNavControllerEffect: collect command: NavigateNavCommand(viewName=Terms, args={learningSpaceUrl=http://37.27.227.212:8070/, newOrExisting=new, next=CourseListHome, showAccept=true, DateOfBirth=1275350400000}, goOptions=UstadGoOptions(popUpToViewName=null, popUpToInclusive=false, clearStack=false, serializer=null))
        cons:log ✱  DEBUG NoTag : NavHostFunction: go to /Terms?learningSpaceUrl=http%3A%2F%2F37.27.227.212%3A8070%2F&newOrExisting=new&next=CourseListHome&showAccept=true&DateOfBirth=1275350400000
      cy:command ✔  new url	http://37.27.227.212:8070/umapp/#/Terms?learningSpaceUrl=http%3A%2F%2F37.27.227.212%3A8070%2F&newOrExisting=new&next=CourseListHome&showAccept=true&DateOfBirth=1275350400000
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
      cons:debug ⚈  TRACE: Adding Accept=application header for http://37.27.227.212:8070/UmAppDatabase/SiteTermsDao/findAvailableSiteTermLanguages?active=1
      cons:debug ⚈  TRACE: Body type class EmptyContent is in ignored types. Skipping ContentNegotiation for http://37.27.227.212:8070/UmAppDatabase/SiteTermsDao/findAvailableSiteTermLanguages?active=1.
      cons:debug ⚈  TRACE: Adding Accept-Charset=UTF-8 to http://37.27.227.212:8070/UmAppDatabase/SiteTermsDao/findAvailableSiteTermLanguages?active=1
        cons:log ✱  DEBUG NoTag : Creating ViewModel: SiteTermsDetailViewModel
        cons:log ✱  DEBUG NoTag : Close ViewModel: RegisterAgeRedirectViewModel
        cons:log ✱  button height = 0
        cons:log ✱  NavHost: key = 8qndr8xd
        cons:log ✱  VERBOSE NoTag : NavHost: useEffect check: key = 8qndr8xd current viewname = Terms popUpToTarget = undefined navtoAfterPop = undefined popUpToInclusive = false clearStack = false clearStackHitPlaceholder = false popUpToHitDestination = false
        cons:log ✱  VERBOSE NoTag : NavHost: action: no pop or other operation pending, show children
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  button height = 0
        cy:fetch ➟  GET http://37.27.227.212:8070/UmAppDatabase/SiteTermsDao/findAvailableSiteTermLanguages?active=1
                    Status: 200
      cons:debug ⚈  TRACE: Validating response for request http://37.27.227.212:8070/UmAppDatabase/SiteTermsDao/findAvailableSiteTermLanguages?active=1
      cons:debug ⚈  TRACE: Skipping default response validation for http://37.27.227.212:8070/UmAppDatabase/SiteTermsDao/findAvailableSiteTermLanguages?active=1
      cons:debug ⚈  TRACE: Response body is already transformed. Skipping ContentNegotiation for http://37.27.227.212:8070/UmAppDatabase/SiteTermsDao/findAvailableSiteTermLanguages?active=1.
      cons:debug ⚈  TRACE: Transformed with default transformers response body for http://37.27.227.212:8070/UmAppDatabase/SiteTermsDao/findAvailableSiteTermLanguages?active=1 to class ByteReadPacket
        cons:log ✱  button height = 37
        cons:log ✱  button height = 37
      cy:command ✔  contains	New Terms
      cy:command ✔  assert	expected **<p>** to be **visible**
      cy:command ✔  get	#accept_button
      cy:command ✔  click	
        cons:log ✱  DEBUG NoTag : useNavControllerEffect: collect command: NavigateNavCommand(viewName=SignUp, args={learningSpaceUrl=http://37.27.227.212:8070/, showAccept=true, DateOfBirth=1275350400000, newOrExisting=new, next=CourseListHome}, goOptions=UstadGoOptions(popUpToViewName=null, popUpToInclusive=false, clearStack=false, serializer=null))
        cons:log ✱  DEBUG NoTag : NavHostFunction: go to /SignUp?learningSpaceUrl=http%3A%2F%2F37.27.227.212%3A8070%2F&showAccept=true&DateOfBirth=1275350400000&newOrExisting=new&next=CourseListHome
      cy:command ✔  new url	http://37.27.227.212:8070/umapp/#/SignUp?learningSpaceUrl=http%3A%2F%2F37.27.227.212%3A8070%2F&showAccept=true&DateOfBirth=1275350400000&newOrExisting=new&next=CourseListHome
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  DEBUG NoTag : Creating ViewModel: SignUpViewModel
        cons:log ✱  DEBUG NoTag : Close ViewModel: SiteTermsDetailViewModel
        cons:log ✱  NavHost: key = wztpqtvs
        cons:log ✱  VERBOSE NoTag : NavHost: useEffect check: key = wztpqtvs current viewname = SignUp popUpToTarget = undefined navtoAfterPop = undefined popUpToInclusive = false clearStack = false clearStackHitPlaceholder = false popUpToHitDestination = false
        cons:log ✱  VERBOSE NoTag : NavHost: action: no pop or other operation pending, show children
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
      cy:command ✔  contains	label, Full name*
      cy:command ✔  assert	expected **<label#:r2:-label.MuiFormLabel-root.MuiInputLabel-root.MuiInputLabel-formControl.MuiInputLabel-animated.MuiInputLabel-sizeMedium.MuiInputLabel-outlined.MuiFormLabel-colorPrimary.MuiInputLabel-root.MuiInputLabel-formControl.MuiInputLabel-animated.MuiInputLabel-sizeMedium.MuiInputLabel-outlined.css-uwskvk>** to be **visible**
      cy:command ✔  contains	button, Next
      cy:command ✔  click	
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
      cy:command ✔  contains	This field is required
      cy:command ✔  assert	expected **<p#:r2:-helper-text.MuiFormHelperText-root.Mui-error.MuiFormHelperText-sizeMedium.MuiFormHelperText-contained.css-v7esy>** to be **visible**
      cy:command ✔  get	.Mui-error
      cy:command ✔  contains	Full name*
      cy:command ✔  assert	expected **<span>** to exist in the DOM
                    Actual: 	"<span>"
                    Expected: 	"<span>"
      cy:command ✔  get	.Mui-error
      cy:command ✔  contains	Gender*
      cy:command ✔  assert	expected **<label#gender_label.MuiFormLabel-root.MuiInputLabel-root.MuiInputLabel-formControl.MuiInputLabel-animated.MuiInputLabel-shrink.MuiInputLabel-sizeMedium.MuiInputLabel-outlined.MuiFormLabel-colorPrimary.Mui-error.MuiFormLabel-filled.MuiInputLabel-root.MuiInputLabel-formControl.MuiInputLabel-animated.MuiInputLabel-shrink.MuiInputLabel-sizeMedium.MuiInputLabel-outlined.css-1swc9nw>** to exist in the DOM
                    Actual: 	"<label#gender_label.MuiFormLabel-root.MuiInputLabel-root.MuiInputLabel-formControl.MuiInputLabel-animated.MuiInputLabel-shrink.MuiInputLabel-sizeMedium.MuiInputLabel-outlined.MuiFormLabel-colorPrimary.Mui-error.MuiFormLabel-filled.MuiInputLabel-root.MuiInputLabel-formControl.MuiInputLabel-animated.MuiInputLabel-shrink.MuiInputLabel-sizeMedium.MuiInputLabel-outlined.c ...
      cy:command ✔  contains	label, Full name*
      cy:command ✔  parent	
      cy:command ✔  find	input
      cy:command ✔  clear	
       cons:info ✱  INFO DoorLog : [SQLiteDataSourceJs - 37_27_227_212_8070] Saved to IndexedDb: 37_27_227_212_8070
      cy:command ✔  type	New User
      cy:command ✔  get	div[id="gender"]
      cy:command ✔  click	
      cons:debug ⚈  TRACE: Adding Accept=application header for http://37.27.227.212:8070/api/username/getsuggestion?name=New+User
      cons:debug ⚈  TRACE: Body type class EmptyContent is in ignored types. Skipping ContentNegotiation for http://37.27.227.212:8070/api/username/getsuggestion?name=New+User.
      cons:debug ⚈  TRACE: Adding Accept-Charset=UTF-8 to http://37.27.227.212:8070/api/username/getsuggestion?name=New+User
        cy:fetch ➟  POST http://37.27.227.212:8070/api/username/getsuggestion?name=New+User
                    Status: 200
      cons:debug ⚈  TRACE: Validating response for request http://37.27.227.212:8070/api/username/getsuggestion?name=New+User
      cons:debug ⚈  TRACE: Skipping default response validation for http://37.27.227.212:8070/api/username/getsuggestion?name=New+User
      cons:debug ⚈  TRACE: Response body is already transformed. Skipping ContentNegotiation for http://37.27.227.212:8070/api/username/getsuggestion?name=New+User.
      cons:debug ⚈  TRACE: Transformed with default transformers response body for http://37.27.227.212:8070/api/username/getsuggestion?name=New+User to class ByteReadPacket
        cons:log ✱  DEBUG NoTag : GetUsernameSuggestionUseCase:  newuser
      cy:command ✔  contains	li, Female
      cy:command ✔  click	
      cy:command ✔  contains	button, Next
      cy:command ✔  click	
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  DEBUG NoTag : useNavControllerEffect: collect command: NavigateNavCommand(viewName=SignupEnterUsernamePassword, args={learningSpaceUrl=http://37.27.227.212:8070/, showAccept=true, DateOfBirth=1275350400000, newOrExisting=new, next=CourseListHome, otheroptionperson={"personUid":733723359214125056,"username":"newuser","firstNames":"New","lastName":"User","emailAddr":null,"phoneNum":null,"gender":1,"active":true,"isPersonalAccount":false,"dateOfBirth":0,"personAddress":null,"personOrgId":null,"personGroupUid":0,"personLct":0,"personCountry":null,"personType":0,"personMasterChangeSeqNum":0,"personLocalChangeSeqNum":0,"personLastChangedBy":0,"admin":false,"personNotes":null,"fatherName":null,"fatherNumber":null,"motherName":null,"motherNum":null}, otheroptionpersonprofilepic={"personPictureUid" ...
        cons:log ✱  DEBUG NoTag : NavHostFunction: go to /SignupEnterUsernamePassword?learningSpaceUrl=http%3A%2F%2F37.27.227.212%3A8070%2F&showAccept=true&DateOfBirth=1275350400000&newOrExisting=new&next=CourseListHome&otheroptionperson=%7B%22personUid%22%3A733723359214125056%2C%22username%22%3A%22newuser%22%2C%22firstNames%22%3A%22New%22%2C%22lastName%22%3A%22User%22%2C%22emailAddr%22%3Anull%2C%22phoneNum%22%3Anull%2C%22gender%22%3A1%2C%22active%22%3Atrue%2C%22isPersonalAccount%22%3Afalse%2C%22dateOfBirth%22%3A0%2C%22personAddress%22%3Anull%2C%22personOrgId%22%3Anull%2C%22personGroupUid%22%3A0%2C%22personLct%22%3A0%2C%22personCountry%22%3Anull%2C%22personType%22%3A0%2C%22personMasterChangeSeqNum%22%3A0%2C%22personLocalChangeSeqNum%22%3A0%2C%22personLastChangedBy%22%3A0%2C%22admin%22%3Afalse%2C%22personNotes ...
      cy:command ✔  new url	http://37.27.227.212:8070/umapp/#/SignupEnterUsernamePassword?learningSpaceUrl=http%3A%2F%2F37.27.227.212%3A8070%2F&showAccept=true&DateOfBirth=1275350400000&newOrExisting=new&next=CourseListHome&otheroptionperson=%7B%22personUid%22%3A733723359214125056%2C%22username%22%3A%22newuser%22%2C%22firstNames%22%3A%22New%22%2C%22lastName%22%3A%22User%22%2C%22emailAddr%22%3Anull%2C%22phoneNum%22%3Anull%2C%22gender%22%3A1%2C%22active%22%3Atrue%2C%22isPersonalAccount%22%3Afalse%2C%22dateOfBirth%22%3A0%2C%22personAddress%22%3Anull%2C%22personOrgId%22%3Anull%2C%22personGroupUid%22%3A0%2C%22personLct%22%3A0%2C%22personCountry%22%3Anull%2C%22personType%22%3A0%2C%22personMasterChangeSeqNum%22%3A0%2C%22personLocalChangeSeqNum%22%3A0%2C%22personLastChangedBy%22%3A0%2C%22admin%22%3Afalse%2C%22personN ...
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  DEBUG NoTag : Creating ViewModel: SignupEnterUsernamePasswordViewModel
        cons:log ✱  DEBUG NoTag : Close ViewModel: SignUpViewModel
        cons:log ✱  NavHost: key = yodwpcgr
        cons:log ✱  VERBOSE NoTag : NavHost: useEffect check: key = yodwpcgr current viewname = SignupEnterUsernamePassword popUpToTarget = undefined navtoAfterPop = undefined popUpToInclusive = false clearStack = false clearStackHitPlaceholder = false popUpToHitDestination = false
        cons:log ✱  VERBOSE NoTag : NavHost: action: no pop or other operation pending, show children
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
      cy:command ✘  contains	label, Username
      cy:command ✘  assert	expected **subject** to be **visible**
                    Actual: 	"subject"
                    Expected: 	"visible"


cypress-terminal-report: Wrote custom logs to cypress-logs. (25ms)
cypress-terminal-report: Wrote custom logs to cypress-logs. (26ms)

  (Results)

  ┌────────────────────────────────────────────────────────────────────────────────────────────────┐
  │ Tests:        4                                                                                │
  │ Passing:      3                                                                                │
  │ Failing:      1                                                                                │
  │ Pending:      0                                                                                │
  │ Skipped:      0                                                                                │
  │ Screenshots:  1                                                                                │
  │ Video:        true                                                                             │
  │ Duration:     16 seconds                                                                       │
  │ Spec Ran:     WEB_007_001_admin_enable_or_disable_user_registration.cy.js                      │
  └────────────────────────────────────────────────────────────────────────────────────────────────┘


  (Screenshots)

  -  /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test     (1280x720)
     -end-to-end/webapp-cypress/cypress/screenshots/WEB_007_001_admin_enable_or_disab               
     le_user_registration.cy.js/WEB_007_001_admin_enable_or_disable_user_registration               
      -- Verify New user registration is enabled and mandatory fields are filled (fai               
     led).png                                                                                       


  (Video)

  -  Video output: /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/webapp-cypress/cypress/videos/WEB_007_001_admin_enable_or_disable_user_registration.cy.js.mp4


────────────────────────────────────────────────────────────────────────────────────────────────────
                                                                                                    
  Running:  WEB_007_002b_user_registration_above_age_13_join_learning_space_user          (25 of 28)
            name_password.cy.js                                                                     
TestServerController: start server requested
TestServerController: stopping all servers
TestServerController: stopping server on port: 5436
TestServerController: all stopped
TestServerController: exec /usr/bin/java -Dlogs_dir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/webapp-cypress/../../testserver-controller/build/data/server-33396/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/webapp-cypress/../../app-ktor-server/src/main/resources/application.conf -P:ktor.deployment.port=33396 -P:ktor.ustad.datadir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/webapp-cypress/../../testserver-controller/build/data/server-33396 -P:ktor.ustad.jsDevServer=
http://37.27.227.212:8070/umapp/ ready
07:41:34,230 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
07:41:34,230 |-INFO in ch.qos.logback.classic.util.ContextInitializer@236e3f4e - No custom configurators were discovered as a service.
07:41:34,230 |-INFO in ch.qos.logback.classic.util.ContextInitializer@236e3f4e - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
07:41:34,230 |-INFO in ch.qos.logback.classic.util.ContextInitializer@236e3f4e - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
07:41:34,233 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
07:41:34,233 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
07:41:34,237 |-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
07:41:34,237 |-INFO in ch.qos.logback.classic.util.ContextInitializer@236e3f4e - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
07:41:34,238 |-INFO in ch.qos.logback.classic.util.ContextInitializer@236e3f4e - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
07:41:34,238 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
07:41:34,239 |-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]
07:41:34,241 |-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
07:41:34,280 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
07:41:34,280 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
07:41:34,294 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@1810899357 - No compression will be used
07:41:34,294 |-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/webapp-cypress/../../testserver-controller/build/data/server-33396/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
07:41:34,304 |-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/webapp-cypress/../../testserver-controller/build/data/server-33396/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
07:41:34,304 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@dd0c991 - Roll-over at midnight.
07:41:34,306 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@dd0c991 - Setting initial period to 2025-05-31T05:41:34.091Z
07:41:34,306 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@dd0c991 - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
07:41:34,306 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@dd0c991 - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
07:41:34,308 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
07:41:34,312 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Active log file name: /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/webapp-cypress/../../testserver-controller/build/data/server-33396/log/ustad-server.log
07:41:34,313 |-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/webapp-cypress/../../testserver-controller/build/data/server-33396/log/ustad-server.log]
07:41:34,313 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
07:41:34,313 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
07:41:34,313 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
07:41:34,313 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
07:41:34,314 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@5f16132a - End of configuration.
07:41:34,314 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@69fb6037 - Registering current configuration as safe fallback point
07:41:34,314 |-INFO in ch.qos.logback.classic.util.ContextInitializer@236e3f4e - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 76 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY

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


          cy:log ✱  Clearing IndexedDB: 37_27_227_212_8070
      cy:command ✔  delete	IDBDatabase - 37_27_227_212_8070
      cy:command ✔  visit	/ -> 302: http://37.27.227.212:8070/umapp/
        cons:log ✱  DEBUG NoTag : Index: Window.onLoad
      cy:command ✔  contains	button[class*="MuiButton-outlinedPrimary"], New user
       cons:info ✱  INFO DoorLog : DatabaseBuilderJs: Creating database sqlite:37_27_227_212_8070
                    
       cons:info ✱  INFO DoorLog : DatabaseBuilderJs: creating door triggers and receive views sqlite:37_27_227_212_8070
                    
       cons:info ✱  INFO DoorLog : Built database for: sqlite:37_27_227_212_8070
                    
        cons:log ✱  DEBUG NoTag : Built UmAppDatabase
        cons:log ✱  Learning Space URL = http://37.27.227.212:8070/ (location.href = http://37.27.227.212:8070/umapp/
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  [object Object]
        cons:log ✱  DEBUG NoTag : Creating ViewModel: RedirectViewModel
        cons:log ✱  NavHost: key = default
        cons:log ✱  VERBOSE NoTag : NavHost: useEffect check: key = default current viewname =  popUpToTarget = undefined navtoAfterPop = undefined popUpToInclusive = false clearStack = false clearStackHitPlaceholder = false popUpToHitDestination = false
        cons:log ✱  VERBOSE NoTag : NavHost: action: no pop or other operation pending, show children
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
      cons:debug ⚈  TRACE: Adding Accept=application header for http://37.27.227.212:8070/UmAppDatabase/replication/ackAndGetPendingReplications
      cons:debug ⚈  TRACE: Body type class TextContent is in ignored types. Skipping ContentNegotiation for http://37.27.227.212:8070/UmAppDatabase/replication/ackAndGetPendingReplications.
      cons:debug ⚈  TRACE: Adding Accept-Charset=UTF-8 to http://37.27.227.212:8070/UmAppDatabase/replication/ackAndGetPendingReplications
      cons:debug ⚈  TRACE: Transformed with default transformers request body for http://37.27.227.212:8070/UmAppDatabase/replication/ackAndGetPendingReplications from class TextContent
        cy:fetch ➟  POST http://37.27.227.212:8070/UmAppDatabase/replication/ackAndGetPendingReplications
                    Status: 204
      cons:debug ⚈  TRACE: Adding Accept=application header for http://37.27.227.212:8070/UmAppDatabase/SiteDao/getSiteAsync
      cons:debug ⚈  TRACE: Body type class EmptyContent is in ignored types. Skipping ContentNegotiation for http://37.27.227.212:8070/UmAppDatabase/SiteDao/getSiteAsync.
      cons:debug ⚈  TRACE: Adding Accept-Charset=UTF-8 to http://37.27.227.212:8070/UmAppDatabase/SiteDao/getSiteAsync
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
      cons:debug ⚈  TRACE: Validating response for request http://37.27.227.212:8070/UmAppDatabase/replication/ackAndGetPendingReplications
      cons:debug ⚈  TRACE: Skipping default response validation for http://37.27.227.212:8070/UmAppDatabase/replication/ackAndGetPendingReplications
        cy:fetch ➟  GET http://37.27.227.212:8070/UmAppDatabase/SiteDao/getSiteAsync
                    Status: 200
      cons:debug ⚈  TRACE: Validating response for request http://37.27.227.212:8070/UmAppDatabase/SiteDao/getSiteAsync
      cons:debug ⚈  TRACE: Skipping default response validation for http://37.27.227.212:8070/UmAppDatabase/SiteDao/getSiteAsync
      cons:debug ⚈  TRACE: Response body is already transformed. Skipping ContentNegotiation for http://37.27.227.212:8070/UmAppDatabase/SiteDao/getSiteAsync.
      cons:debug ⚈  TRACE: Transformed with default transformers response body for http://37.27.227.212:8070/UmAppDatabase/SiteDao/getSiteAsync to class ByteReadPacket
      cons:debug ⚈  TRACE: Adding Accept=application header for http://37.27.227.212:8070/UmAppDatabase/replication/nodeId
      cons:debug ⚈  TRACE: Body type class EmptyContent is in ignored types. Skipping ContentNegotiation for http://37.27.227.212:8070/UmAppDatabase/replication/nodeId.
      cons:debug ⚈  TRACE: Adding Accept-Charset=UTF-8 to http://37.27.227.212:8070/UmAppDatabase/replication/nodeId
        cy:fetch ➟  GET http://37.27.227.212:8070/UmAppDatabase/replication/nodeId
                    Status: 204
      cons:debug ⚈  TRACE: Validating response for request http://37.27.227.212:8070/UmAppDatabase/replication/nodeId
      cons:debug ⚈  TRACE: Skipping default response validation for http://37.27.227.212:8070/UmAppDatabase/replication/nodeId
        cons:log ✱  DEBUG NoTag : useNavControllerEffect: collect command: NavigateNavCommand(viewName=AddAccountSelectNewOrExisting, args={next=CourseListHome, noSessionChange=false, learningSpaceUrl=http://37.27.227.212:8070/}, goOptions=UstadGoOptions(popUpToViewName=null, popUpToInclusive=false, clearStack=false, serializer=null))
        cons:log ✱  DEBUG NoTag : NavHostFunction: go to /AddAccountSelectNewOrExisting?next=CourseListHome&noSessionChange=false&learningSpaceUrl=http%3A%2F%2F37.27.227.212%3A8070%2F
      cy:command ✔  new url	http://37.27.227.212:8070/umapp/#/AddAccountSelectNewOrExisting?next=CourseListHome&noSessionChange=false&learningSpaceUrl=http%3A%2F%2F37.27.227.212%3A8070%2F
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  DEBUG NoTag : Creating ViewModel: AddAccountSelectNewOrExistingViewModel
        cons:log ✱  DEBUG NoTag : Close ViewModel: RedirectViewModel
        cons:log ✱  NavHost: key = x1uhcpyy
        cons:log ✱  VERBOSE NoTag : NavHost: useEffect check: key = x1uhcpyy current viewname = AddAccountSelectNewOrExisting popUpToTarget = undefined navtoAfterPop = undefined popUpToInclusive = false clearStack = false clearStackHitPlaceholder = false popUpToHitDestination = false
        cons:log ✱  VERBOSE NoTag : NavHost: action: no pop or other operation pending, show children
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
      cy:command ✔  click	
        cons:log ✱  DEBUG NoTag : useNavControllerEffect: collect command: NavigateNavCommand(viewName=RegisterAgeRedirect, args={learningSpaceUrl=http://37.27.227.212:8070/, next=CourseListHome, newOrExisting=new}, goOptions=UstadGoOptions(popUpToViewName=null, popUpToInclusive=false, clearStack=false, serializer=null))
        cons:log ✱  DEBUG NoTag : NavHostFunction: go to /RegisterAgeRedirect?learningSpaceUrl=http%3A%2F%2F37.27.227.212%3A8070%2F&next=CourseListHome&newOrExisting=new
      cy:command ✔  new url	http://37.27.227.212:8070/umapp/#/RegisterAgeRedirect?learningSpaceUrl=http%3A%2F%2F37.27.227.212%3A8070%2F&next=CourseListHome&newOrExisting=new
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  DEBUG NoTag : Creating ViewModel: RegisterAgeRedirectViewModel
        cons:log ✱  DEBUG NoTag : Close ViewModel: AddAccountSelectNewOrExistingViewModel
        cons:log ✱  NavHost: key = q3grs24v
        cons:log ✱  VERBOSE NoTag : NavHost: useEffect check: key = q3grs24v current viewname = RegisterAgeRedirect popUpToTarget = undefined navtoAfterPop = undefined popUpToInclusive = false clearStack = false clearStackHitPlaceholder = false popUpToHitDestination = false
        cons:log ✱  VERBOSE NoTag : NavHost: action: no pop or other operation pending, show children
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
      cy:command ✔  get	#age_date_of_birth
      cy:command ✔  type	2010-06-01
       cons:info ✱  INFO DoorLog : [SQLiteDataSourceJs - 37_27_227_212_8070] Saved to IndexedDb: 37_27_227_212_8070
        cons:log ✱  onChange: 2010-06-01
      cy:command ✔  contains	button, Next
      cy:command ✔  click	
        cons:log ✱  DEBUG NoTag : useNavControllerEffect: collect command: NavigateNavCommand(viewName=Terms, args={learningSpaceUrl=http://37.27.227.212:8070/, newOrExisting=new, next=CourseListHome, showAccept=true, DateOfBirth=1275350400000}, goOptions=UstadGoOptions(popUpToViewName=null, popUpToInclusive=false, clearStack=false, serializer=null))
        cons:log ✱  DEBUG NoTag : NavHostFunction: go to /Terms?learningSpaceUrl=http%3A%2F%2F37.27.227.212%3A8070%2F&newOrExisting=new&next=CourseListHome&showAccept=true&DateOfBirth=1275350400000
      cy:command ✔  new url	http://37.27.227.212:8070/umapp/#/Terms?learningSpaceUrl=http%3A%2F%2F37.27.227.212%3A8070%2F&newOrExisting=new&next=CourseListHome&showAccept=true&DateOfBirth=1275350400000
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
      cons:debug ⚈  TRACE: Adding Accept=application header for http://37.27.227.212:8070/UmAppDatabase/SiteTermsDao/findAvailableSiteTermLanguages?active=1
      cons:debug ⚈  TRACE: Body type class EmptyContent is in ignored types. Skipping ContentNegotiation for http://37.27.227.212:8070/UmAppDatabase/SiteTermsDao/findAvailableSiteTermLanguages?active=1.
      cons:debug ⚈  TRACE: Adding Accept-Charset=UTF-8 to http://37.27.227.212:8070/UmAppDatabase/SiteTermsDao/findAvailableSiteTermLanguages?active=1
        cons:log ✱  DEBUG NoTag : Creating ViewModel: SiteTermsDetailViewModel
        cons:log ✱  DEBUG NoTag : Close ViewModel: RegisterAgeRedirectViewModel
        cons:log ✱  button height = 0
        cons:log ✱  NavHost: key = g9axex5j
        cons:log ✱  VERBOSE NoTag : NavHost: useEffect check: key = g9axex5j current viewname = Terms popUpToTarget = undefined navtoAfterPop = undefined popUpToInclusive = false clearStack = false clearStackHitPlaceholder = false popUpToHitDestination = false
        cons:log ✱  VERBOSE NoTag : NavHost: action: no pop or other operation pending, show children
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  button height = 0
        cy:fetch ➟  GET http://37.27.227.212:8070/UmAppDatabase/SiteTermsDao/findAvailableSiteTermLanguages?active=1
                    Status: 200
      cons:debug ⚈  TRACE: Validating response for request http://37.27.227.212:8070/UmAppDatabase/SiteTermsDao/findAvailableSiteTermLanguages?active=1
      cons:debug ⚈  TRACE: Skipping default response validation for http://37.27.227.212:8070/UmAppDatabase/SiteTermsDao/findAvailableSiteTermLanguages?active=1
      cons:debug ⚈  TRACE: Response body is already transformed. Skipping ContentNegotiation for http://37.27.227.212:8070/UmAppDatabase/SiteTermsDao/findAvailableSiteTermLanguages?active=1.
      cons:debug ⚈  TRACE: Transformed with default transformers response body for http://37.27.227.212:8070/UmAppDatabase/SiteTermsDao/findAvailableSiteTermLanguages?active=1 to class ByteReadPacket
        cons:log ✱  button height = 37
        cons:log ✱  button height = 37
      cy:command ✔  contains	New Terms
      cy:command ✔  assert	expected **<p>** to be **visible**
      cy:command ✔  get	#accept_button
      cy:command ✔  click	
        cons:log ✱  DEBUG NoTag : useNavControllerEffect: collect command: NavigateNavCommand(viewName=SignUp, args={learningSpaceUrl=http://37.27.227.212:8070/, showAccept=true, DateOfBirth=1275350400000, newOrExisting=new, next=CourseListHome}, goOptions=UstadGoOptions(popUpToViewName=null, popUpToInclusive=false, clearStack=false, serializer=null))
        cons:log ✱  DEBUG NoTag : NavHostFunction: go to /SignUp?learningSpaceUrl=http%3A%2F%2F37.27.227.212%3A8070%2F&showAccept=true&DateOfBirth=1275350400000&newOrExisting=new&next=CourseListHome
      cy:command ✔  new url	http://37.27.227.212:8070/umapp/#/SignUp?learningSpaceUrl=http%3A%2F%2F37.27.227.212%3A8070%2F&showAccept=true&DateOfBirth=1275350400000&newOrExisting=new&next=CourseListHome
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  DEBUG NoTag : Creating ViewModel: SignUpViewModel
        cons:log ✱  DEBUG NoTag : Close ViewModel: SiteTermsDetailViewModel
        cons:log ✱  NavHost: key = y9h8utwl
        cons:log ✱  VERBOSE NoTag : NavHost: useEffect check: key = y9h8utwl current viewname = SignUp popUpToTarget = undefined navtoAfterPop = undefined popUpToInclusive = false clearStack = false clearStackHitPlaceholder = false popUpToHitDestination = false
        cons:log ✱  VERBOSE NoTag : NavHost: action: no pop or other operation pending, show children
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
      cy:command ✔  contains	label, Full name*
      cy:command ✔  parent	
      cy:command ✔  find	input
      cy:command ✔  clear	
       cons:info ✱  INFO DoorLog : [SQLiteDataSourceJs - 37_27_227_212_8070] Saved to IndexedDb: 37_27_227_212_8070
      cy:command ✔  type	New User
      cy:command ✔  get	div[id="gender"]
      cy:command ✔  click	
      cons:debug ⚈  TRACE: Adding Accept=application header for http://37.27.227.212:8070/api/username/getsuggestion?name=New+User
      cons:debug ⚈  TRACE: Body type class EmptyContent is in ignored types. Skipping ContentNegotiation for http://37.27.227.212:8070/api/username/getsuggestion?name=New+User.
      cons:debug ⚈  TRACE: Adding Accept-Charset=UTF-8 to http://37.27.227.212:8070/api/username/getsuggestion?name=New+User
        cy:fetch ➟  POST http://37.27.227.212:8070/api/username/getsuggestion?name=New+User
                    Status: 200
      cons:debug ⚈  TRACE: Validating response for request http://37.27.227.212:8070/api/username/getsuggestion?name=New+User
      cons:debug ⚈  TRACE: Skipping default response validation for http://37.27.227.212:8070/api/username/getsuggestion?name=New+User
      cons:debug ⚈  TRACE: Response body is already transformed. Skipping ContentNegotiation for http://37.27.227.212:8070/api/username/getsuggestion?name=New+User.
      cons:debug ⚈  TRACE: Transformed with default transformers response body for http://37.27.227.212:8070/api/username/getsuggestion?name=New+User to class ByteReadPacket
        cons:log ✱  DEBUG NoTag : GetUsernameSuggestionUseCase:  newuser
      cy:command ✔  contains	li, Female
      cy:command ✔  click	
      cy:command ✔  contains	button, Next
      cy:command ✔  click	
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  DEBUG NoTag : useNavControllerEffect: collect command: NavigateNavCommand(viewName=SignupEnterUsernamePassword, args={learningSpaceUrl=http://37.27.227.212:8070/, showAccept=true, DateOfBirth=1275350400000, newOrExisting=new, next=CourseListHome, otheroptionperson={"personUid":733723434011418624,"username":"newuser","firstNames":"New","lastName":"User","emailAddr":null,"phoneNum":null,"gender":1,"active":true,"isPersonalAccount":false,"dateOfBirth":0,"personAddress":null,"personOrgId":null,"personGroupUid":0,"personLct":0,"personCountry":null,"personType":0,"personMasterChangeSeqNum":0,"personLocalChangeSeqNum":0,"personLastChangedBy":0,"admin":false,"personNotes":null,"fatherName":null,"fatherNumber":null,"motherName":null,"motherNum":null}, otheroptionpersonprofilepic={"personPictureUid" ...
        cons:log ✱  DEBUG NoTag : NavHostFunction: go to /SignupEnterUsernamePassword?learningSpaceUrl=http%3A%2F%2F37.27.227.212%3A8070%2F&showAccept=true&DateOfBirth=1275350400000&newOrExisting=new&next=CourseListHome&otheroptionperson=%7B%22personUid%22%3A733723434011418624%2C%22username%22%3A%22newuser%22%2C%22firstNames%22%3A%22New%22%2C%22lastName%22%3A%22User%22%2C%22emailAddr%22%3Anull%2C%22phoneNum%22%3Anull%2C%22gender%22%3A1%2C%22active%22%3Atrue%2C%22isPersonalAccount%22%3Afalse%2C%22dateOfBirth%22%3A0%2C%22personAddress%22%3Anull%2C%22personOrgId%22%3Anull%2C%22personGroupUid%22%3A0%2C%22personLct%22%3A0%2C%22personCountry%22%3Anull%2C%22personType%22%3A0%2C%22personMasterChangeSeqNum%22%3A0%2C%22personLocalChangeSeqNum%22%3A0%2C%22personLastChangedBy%22%3A0%2C%22admin%22%3Afalse%2C%22personNotes ...
      cy:command ✔  new url	http://37.27.227.212:8070/umapp/#/SignupEnterUsernamePassword?learningSpaceUrl=http%3A%2F%2F37.27.227.212%3A8070%2F&showAccept=true&DateOfBirth=1275350400000&newOrExisting=new&next=CourseListHome&otheroptionperson=%7B%22personUid%22%3A733723434011418624%2C%22username%22%3A%22newuser%22%2C%22firstNames%22%3A%22New%22%2C%22lastName%22%3A%22User%22%2C%22emailAddr%22%3Anull%2C%22phoneNum%22%3Anull%2C%22gender%22%3A1%2C%22active%22%3Atrue%2C%22isPersonalAccount%22%3Afalse%2C%22dateOfBirth%22%3A0%2C%22personAddress%22%3Anull%2C%22personOrgId%22%3Anull%2C%22personGroupUid%22%3A0%2C%22personLct%22%3A0%2C%22personCountry%22%3Anull%2C%22personType%22%3A0%2C%22personMasterChangeSeqNum%22%3A0%2C%22personLocalChangeSeqNum%22%3A0%2C%22personLastChangedBy%22%3A0%2C%22admin%22%3Afalse%2C%22personN ...
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  DEBUG NoTag : Creating ViewModel: SignupEnterUsernamePasswordViewModel
        cons:log ✱  DEBUG NoTag : Close ViewModel: SignUpViewModel
        cons:log ✱  NavHost: key = ai39r2ei
        cons:log ✱  VERBOSE NoTag : NavHost: useEffect check: key = ai39r2ei current viewname = SignupEnterUsernamePassword popUpToTarget = undefined navtoAfterPop = undefined popUpToInclusive = false clearStack = false clearStackHitPlaceholder = false popUpToHitDestination = false
        cons:log ✱  VERBOSE NoTag : NavHost: action: no pop or other operation pending, show children
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
        cons:log ✱  ClickLinkProvider accountMAnager=[object Object] linkUseCase=[object Object]
      cy:command ✘  contains	label, Username


cypress-terminal-report: Wrote custom logs to cypress-logs. (25ms)
cypress-terminal-report: Wrote custom logs to cypress-logs. (26ms)

  (Results)

  ┌────────────────────────────────────────────────────────────────────────────────────────────────┐
  │ Tests:        2                                                                                │
  │ Passing:      1                                                                                │
  │ Failing:      1                                                                                │
  │ Pending:      0                                                                                │
  │ Skipped:      0                                                                                │
  │ Screenshots:  1                                                                                │
  │ Video:        true                                                                             │
  │ Duration:     13 seconds                                                                       │
  │ Spec Ran:     WEB_007_002b_user_registration_above_age_13_join_learning_space_username_passwor │
  │               d.cy.js                                                                          │
  └────────────────────────────────────────────────────────────────────────────────────────────────┘


  (Screenshots)

  -  /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test     (1280x720)
     -end-to-end/webapp-cypress/cypress/screenshots/WEB_007_002b_user_registration_ab               
     ove_age_13_join_learning_space_username_password.cy.js/WEB_007_002b_user_registr               
     ation_above_age_13_join_learning_space_username_password -- User age above 13 re               
     gister as a new user (failed).png                                                              


  (Video)

  -  Video output: /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/webapp-cypress/cypress/videos/WEB_007_002b_user_registration_above_age_13_join_learning_space_username_password.cy.js.mp4


────────────────────────────────────────────────────────────────────────────────────────────────────
                                                                                                    
  Running:  WEB_007_004_username_validation_and_add_profile_pic.cy.js                     (26 of 28)
TestServerController: start server requested
TestServerController: stopping all servers
TestServerController: stopping server on port: 33396
TestServerController: all stopped
TestServerController: exec /usr/bin/java -Dlogs_dir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/webapp-cypress/../../testserver-controller/build/data/server-1723/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/webapp-cypress/../../app-ktor-server/src/main/resources/application.conf -P:ktor.deployment.port=1723 -P:ktor.ustad.datadir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/webapp-cypress/../../testserver-controller/build/data/server-1723 -P:ktor.ustad.jsDevServer=
http://37.27.227.212:8070/umapp/ ready
07:41:49,395 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
07:41:49,395 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - No custom configurators were discovered as a service.
07:41:49,395 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
07:41:49,396 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
07:41:49,399 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
07:41:49,399 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
07:41:49,402 |-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
07:41:49,402 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
07:41:49,403 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
07:41:49,403 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
07:41:49,404 |-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]
07:41:49,406 |-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
07:41:49,445 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
07:41:49,445 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
07:41:49,458 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@594427726 - No compression will be used
07:41:49,459 |-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/webapp-cypress/../../testserver-controller/build/data/server-1723/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
07:41:49,468 |-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/webapp-cypress/../../testserver-controller/build/data/server-1723/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
07:41:49,468 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Roll-over at midnight.
07:41:49,471 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - Setting initial period to 2025-05-31T05:41:49.260Z
07:41:49,471 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
07:41:49,471 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cc1435c - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
07:41:49,472 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
07:41:49,477 |-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/webapp-cypress/../../testserver-controller/build/data/server-1723/log/ustad-server.log
07:41:49,477 |-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/webapp-cypress/../../testserver-controller/build/data/server-1723/log/ustad-server.log]
07:41:49,478 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
07:41:49,478 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
07:41:49,478 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
07:41:49,478 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
07:41:49,478 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@6bf0219d - End of configuration.
07:41:49,479 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@dd0c991 - Registering current configuration as safe fallback point
07:41:49,479 |-INFO in ch.qos.logback.classic.util.ContextInitializer@157853da - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 76 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY

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


cypress-terminal-report: Wrote custom logs to cypress-logs. (25ms)
cypress-terminal-report: Wrote custom logs to cypress-logs. (27ms)

  (Results)

  ┌────────────────────────────────────────────────────────────────────────────────────────────────┐
  │ Tests:        3                                                                                │
  │ Passing:      3                                                                                │
  │ Failing:      0                                                                                │
  │ Pending:      0                                                                                │
  │ Skipped:      0                                                                                │
  │ Screenshots:  0                                                                                │
  │ Video:        true                                                                             │
  │ Duration:     14 seconds                                                                       │
  │ Spec Ran:     WEB_007_004_username_validation_and_add_profile_pic.cy.js                        │
  └────────────────────────────────────────────────────────────────────────────────────────────────┘


  (Video)

  -  Video output: /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/webapp-cypress/cypress/videos/WEB_007_004_username_validation_and_add_profile_pic.cy.js.mp4


────────────────────────────────────────────────────────────────────────────────────────────────────
                                                                                                    
  Running:  WEB_007_005_student_registered_by_admin_or_teacher_dont_need_parentC          (27 of 28)
            onsent.cy.js                                                                            
TestServerController: start server requested
TestServerController: stopping all servers
TestServerController: stopping server on port: 1723
TestServerController: all stopped
TestServerController: exec /usr/bin/java -Dlogs_dir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/webapp-cypress/../../testserver-controller/build/data/server-21917/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/webapp-cypress/../../app-ktor-server/src/main/resources/application.conf -P:ktor.deployment.port=21917 -P:ktor.ustad.datadir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/webapp-cypress/../../testserver-controller/build/data/server-21917 -P:ktor.ustad.jsDevServer=
http://37.27.227.212:8070/umapp/ ready
07:42:06,330 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
07:42:06,330 |-INFO in ch.qos.logback.classic.util.ContextInitializer@236e3f4e - No custom configurators were discovered as a service.
07:42:06,330 |-INFO in ch.qos.logback.classic.util.ContextInitializer@236e3f4e - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
07:42:06,330 |-INFO in ch.qos.logback.classic.util.ContextInitializer@236e3f4e - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
07:42:06,333 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
07:42:06,334 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
07:42:06,337 |-INFO in ch.qos.logback.classic.util.ContextInitializer@236e3f4e - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 4 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY
07:42:06,337 |-INFO in ch.qos.logback.classic.util.ContextInitializer@236e3f4e - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
07:42:06,337 |-INFO in ch.qos.logback.classic.util.ContextInitializer@236e3f4e - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
07:42:06,338 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
07:42:06,339 |-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]
07:42:06,340 |-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
07:42:06,378 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
07:42:06,378 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
07:42:06,391 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@1810899357 - No compression will be used
07:42:06,391 |-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/webapp-cypress/../../testserver-controller/build/data/server-21917/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
07:42:06,401 |-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/webapp-cypress/../../testserver-controller/build/data/server-21917/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
07:42:06,401 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@dd0c991 - Roll-over at midnight.
07:42:06,404 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@dd0c991 - Setting initial period to 2025-05-31T05:42:06.191Z
07:42:06,404 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@dd0c991 - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
07:42:06,404 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@dd0c991 - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
07:42:06,405 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
07:42:06,410 |-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/webapp-cypress/../../testserver-controller/build/data/server-21917/log/ustad-server.log
07:42:06,410 |-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/webapp-cypress/../../testserver-controller/build/data/server-21917/log/ustad-server.log]
07:42:06,411 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
07:42:06,411 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
07:42:06,411 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
07:42:06,411 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
07:42:06,411 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@5f16132a - End of configuration.
07:42:06,411 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@69fb6037 - Registering current configuration as safe fallback point
07:42:06,411 |-INFO in ch.qos.logback.classic.util.ContextInitializer@236e3f4e - 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/webapp-cypress/../../testserver-controller/build/data/server-21917
CreateLearningSpaceRequest(url=http://37.27.227.212:8070/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


cypress-terminal-report: Wrote custom logs to cypress-logs. (26ms)
cypress-terminal-report: Wrote custom logs to cypress-logs. (28ms)

  (Results)

  ┌────────────────────────────────────────────────────────────────────────────────────────────────┐
  │ Tests:        2                                                                                │
  │ Passing:      2                                                                                │
  │ Failing:      0                                                                                │
  │ Pending:      0                                                                                │
  │ Skipped:      0                                                                                │
  │ Screenshots:  0                                                                                │
  │ Video:        true                                                                             │
  │ Duration:     12 seconds                                                                       │
  │ Spec Ran:     WEB_007_005_student_registered_by_admin_or_teacher_dont_need_parentConsent.cy.js │
  └────────────────────────────────────────────────────────────────────────────────────────────────┘


  (Video)

  -  Video output: /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/webapp-cypress/cypress/videos/WEB_007_005_student_registered_by_admin_or_teacher_dont_need_parentConsent.cy.js.mp4


────────────────────────────────────────────────────────────────────────────────────────────────────
                                                                                                    
  Running:  WEB_007_006_admin_enable_or_disable_guest_login.cy.js                         (28 of 28)
TestServerController: start server requested
TestServerController: stopping all servers
TestServerController: stopping server on port: 21917
TestServerController: all stopped
TestServerController: exec /usr/bin/java -Dlogs_dir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/webapp-cypress/../../testserver-controller/build/data/server-22493/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/webapp-cypress/../../app-ktor-server/src/main/resources/application.conf -P:ktor.deployment.port=22493 -P:ktor.ustad.datadir=/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/webapp-cypress/../../testserver-controller/build/data/server-22493 -P:ktor.ustad.jsDevServer=
http://37.27.227.212:8070/umapp/ ready
07:42:21,146 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version ?
07:42:21,147 |-INFO in ch.qos.logback.classic.util.ContextInitializer@236e3f4e - No custom configurators were discovered as a service.
07:42:21,147 |-INFO in ch.qos.logback.classic.util.ContextInitializer@236e3f4e - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator
07:42:21,147 |-INFO in ch.qos.logback.classic.util.ContextInitializer@236e3f4e - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator
07:42:21,150 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo]
07:42:21,150 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo]
07:42:21,154 |-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
07:42:21,154 |-INFO in ch.qos.logback.classic.util.ContextInitializer@236e3f4e - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator
07:42:21,154 |-INFO in ch.qos.logback.classic.util.ContextInitializer@236e3f4e - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator
07:42:21,154 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
07:42:21,155 |-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]
07:42:21,157 |-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
07:42:21,196 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE]
07:42:21,196 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
07:42:21,210 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@1810899357 - No compression will be used
07:42:21,210 |-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/webapp-cypress/../../testserver-controller/build/data/server-22493/log/ustad-server.%d{yyyy-MM-dd}.%i.log for the active file
07:42:21,220 |-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/webapp-cypress/../../testserver-controller/build/data/server-22493/log/ustad-server.%d{yyyy-MM-dd}.%i.log'.
07:42:21,220 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@dd0c991 - Roll-over at midnight.
07:42:21,223 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@dd0c991 - Setting initial period to 2025-05-31T05:42:21.005Z
07:42:21,223 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@dd0c991 - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
07:42:21,223 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@dd0c991 - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
07:42:21,224 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
07:42:21,229 |-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/webapp-cypress/../../testserver-controller/build/data/server-22493/log/ustad-server.log
07:42:21,229 |-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/webapp-cypress/../../testserver-controller/build/data/server-22493/log/ustad-server.log]
07:42:21,230 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE
07:42:21,230 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[ROOT]
07:42:21,230 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.eclipse.jetty] to INFO
07:42:21,230 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO
07:42:21,230 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@5f16132a - End of configuration.
07:42:21,231 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@69fb6037 - Registering current configuration as safe fallback point
07:42:21,231 |-INFO in ch.qos.logback.classic.util.ContextInitializer@236e3f4e - 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/webapp-cypress/../../testserver-controller/build/data/server-22493
CreateLearningSpaceRequest(url=http://37.27.227.212:8070/, title=TestLearningSpace, dbUrl=null, dbUsername=, dbPassword=, adminUsername=admin, adminPassword=testpass)
Done: OK


cypress-terminal-report: Wrote custom logs to cypress-logs. (27ms)
cypress-terminal-report: Wrote custom logs to cypress-logs. (28ms)

  (Results)

  ┌────────────────────────────────────────────────────────────────────────────────────────────────┐
  │ Tests:        2                                                                                │
  │ Passing:      2                                                                                │
  │ Failing:      0                                                                                │
  │ Pending:      0                                                                                │
  │ Skipped:      0                                                                                │
  │ Screenshots:  0                                                                                │
  │ Video:        true                                                                             │
  │ Duration:     10 seconds                                                                       │
  │ Spec Ran:     WEB_007_006_admin_enable_or_disable_guest_login.cy.js                            │
  └────────────────────────────────────────────────────────────────────────────────────────────────┘


  (Video)

  -  Video output: /home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/webapp-cypress/cypress/videos/WEB_007_006_admin_enable_or_disable_guest_login.cy.js.mp4


resize:  can't open terminal /dev/tty
tput: No value for $TERM and no -T specified
====================================================================================================

  (Run Finished)


       Spec                                              Tests  Passing  Failing  Pending  Skipped  
  ┌────────────────────────────────────────────────────────────────────────────────────────────────┐
  │ ✔  WEB_001_001_add_content.cy.js            00:36        1        1        -        -        - │
  ├────────────────────────────────────────────────────────────────────────────────────────────────┤
  │ ✔  WEB_001_002_add_invalid_content.cy.      00:07        1        1        -        -        - │
  │    js                                                                                          │
  ├────────────────────────────────────────────────────────────────────────────────────────────────┤
  │ ✔  WEB_001_003_move_content.cy.js           00:11        2        2        -        -        - │
  ├────────────────────────────────────────────────────────────────────────────────────────────────┤
  │ ✔  WEB_002_001_admin_add_new_course_an      00:22        2        2        -        -        - │
  │    d_teacher.cy.js                                                                             │
  ├────────────────────────────────────────────────────────────────────────────────────────────────┤
  │ ✔  WEB_002_003_teacher_record_attendan      00:10        2        2        -        -        - │
  │    ce.cy.js                                                                                    │
  ├────────────────────────────────────────────────────────────────────────────────────────────────┤
  │ ✔  WEB_003_001_add_or_edit_course_perm      00:12        3        3        -        -        - │
  │    ission_test.cy.js                                                                           │
  ├────────────────────────────────────────────────────────────────────────────────────────────────┤
  │ ✔  WEB_003_002_add_module_text_blocks_      00:17        1        1        -        -        - │
  │    and_perform_indent_hide_delete_acti                                                         │
  │    ons.cy.js                                                                                   │
  ├────────────────────────────────────────────────────────────────────────────────────────────────┤
  │ ✔  WEB_003_003_admin_or_teacher_add_co      00:50       10       10        -        -        - │
  │    ntent_via_file.cy.js                                                                        │
  ├────────────────────────────────────────────────────────────────────────────────────────────────┤
  │ ✔  WEB_003_005_user_able_to_expand_and      00:19        1        1        -        -        - │
  │    _collapse_modules.cy.js                                                                     │
  ├────────────────────────────────────────────────────────────────────────────────────────────────┤
  │ ✔  WEB_003_006_user_able_to_open_text_      00:09        1        1        -        -        - │
  │    block.cy.js                                                                                 │
  ├────────────────────────────────────────────────────────────────────────────────────────────────┤
  │ ✔  WEB_004_001_assignment_creation_sub      00:19        4        4        -        -        - │
  │    mission_grading.cy.js                                                                       │
  ├────────────────────────────────────────────────────────────────────────────────────────────────┤
  │ ✔  WEB_004_002_users_add_course_commen      00:16        2        2        -        -        - │
  │    ts.cy.js                                                                                    │
  ├────────────────────────────────────────────────────────────────────────────────────────────────┤
  │ ✔  WEB_004_003_multiple_submission_pos      00:32        6        6        -        -        - │
  │    sible_for_student.cy.js                                                                     │
  ├────────────────────────────────────────────────────────────────────────────────────────────────┤
  │ ✔  WEB_004_005_assignment_grace_period      00:12        2        2        -        -        - │
  │    _finished.cy.js                                                                             │
  ├────────────────────────────────────────────────────────────────────────────────────────────────┤
  │ ✔  WEB_004_006_user_enter_assignment_p      02:30        3        3        -        -        - │
  │    age_before_graceperiod_but_submissi                                                         │
  │    on_after_grace_Period.cy.js                                                                 │
  ├────────────────────────────────────────────────────────────────────────────────────────────────┤
  │ ✔  WEB_004_007_group_users_add_assignm      00:25        4        4        -        -        - │
  │    ent_and_course_comments.cy.js                                                               │
  ├────────────────────────────────────────────────────────────────────────────────────────────────┤
  │ ✔  WEB_004_008_group_users_single_assi      00:18        3        3        -        -        - │
  │    gnment_submission_allowed.cy.js                                                             │
  ├────────────────────────────────────────────────────────────────────────────────────────────────┤
  │ ✔  WEB_004_009_group_users_multiple_as      00:19        3        3        -        -        - │
  │    signment_submission_allowed.cy.js                                                           │
  ├────────────────────────────────────────────────────────────────────────────────────────────────┤
  │ ✔  WEB_004_010_peer_marking_for_indivi      00:21        4        4        -        -        - │
  │    dual_assignment.cy.js                                                                       │
  ├────────────────────────────────────────────────────────────────────────────────────────────────┤
  │ ✔  WEB_004_011_peer_marking_for_group_      00:31        4        4        -        -        - │
  │    assignment.cy.js                                                                            │
  ├────────────────────────────────────────────────────────────────────────────────────────────────┤
  │ ✔  WEB_005_001_teacher_add_discussion_      00:11        1        1        -        -        - │
  │    and_post.cy.js                                                                              │
  ├────────────────────────────────────────────────────────────────────────────────────────────────┤
  │ ✔  WEB_005_002_all_user_add_post_and_r      00:25        3        3        -        -        - │
  │    eply.cy.js                                                                                  │
  ├────────────────────────────────────────────────────────────────────────────────────────────────┤
  │ ✔  WEB_005_004_user_add_external_links      00:15        3        3        -        -        - │
  │    _to_post.cy.js                                                                              │
  ├────────────────────────────────────────────────────────────────────────────────────────────────┤
  │ ✖  WEB_007_001_admin_enable_or_disable      00:16        4        3        1        -        - │
  │    _user_registration.cy.js                                                                    │
  ├────────────────────────────────────────────────────────────────────────────────────────────────┤
  │ ✖  WEB_007_002b_user_registration_abov      00:13        2        1        1        -        - │
  │    e_age_13_join_learning_space_userna                                                         │
  │    me_password.cy.js                                                                           │
  ├────────────────────────────────────────────────────────────────────────────────────────────────┤
  │ ✔  WEB_007_004_username_validation_and      00:14        3        3        -        -        - │
  │    _add_profile_pic.cy.js                                                                      │
  ├────────────────────────────────────────────────────────────────────────────────────────────────┤
  │ ✔  WEB_007_005_student_registered_by_a      00:12        2        2        -        -        - │
  │    dmin_or_teacher_dont_need_parentCon                                                         │
  │    sent.cy.js                                                                                  │
  ├────────────────────────────────────────────────────────────────────────────────────────────────┤
  │ ✔  WEB_007_006_admin_enable_or_disable      00:10        2        2        -        -        - │
  │    _guest_login.cy.js                                                                          │
  └────────────────────────────────────────────────────────────────────────────────────────────────┘
    ✖  2 of 28 failed (7%)                      11:09       79       77        2        -        -  

Error: Command failed with exit code 2: npm run cy:run-ci
    at makeError (/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/webapp-cypress/node_modules/start-server-and-test/node_modules/execa/lib/error.js:60:11)
    at handlePromise (/home/jenkins/.jenkins/workspace/dev-simplified-onboarding-end-to-end-tests/test-end-to-end/webapp-cypress/node_modules/start-server-and-test/node_modules/execa/index.js:118:26)
    at process.processTicksAndRejections (node:internal/process/task_queues:95:5) {
  shortMessage: 'Command failed with exit code 2: npm run cy:run-ci',
  command: 'npm run cy:run-ci',
  escapedCommand: '"npm run cy:run-ci"',
  exitCode: 2,
  signal: undefined,
  signalDescription: undefined,
  stdout: undefined,
  stderr: undefined,
  failed: true,
  timedOut: false,
  isCanceled: false,
  killed: false
}
Build step 'Execute shell' marked build as failure
[htmlpublisher] Archiving HTML reports...
Recording test results
[Checks API] No suitable checks publisher found.
[Slack Notifications] found #113 as previous completed, non-aborted build
[Slack Notifications] will send OnEveryFailureNotification because build matches and user preferences allow it
Finished: FAILURE