2026-04-04 06:15:49.813 [main] INFO  Application - Autoreload is disabled because the development mode is off.
2026-04-04 06:15:49.963 [main] INFO  Application - Application started in 0.155 seconds.
2026-04-04 06:15:50.023 [DefaultDispatcher-worker-1] INFO  Application - Responding at http://0.0.0.0:8070
2026-04-04 06:16:16.326 [eventLoopGroupProxy-4-2] TRACE io.ktor.server.routing.Routing - Trace for [testcontroller, start]
/, segment:0 -> SUCCESS @ /
  /, segment:0 -> SUCCESS @ /
    /(method:GET), segment:0 -> FAILURE "Not all segments matched" @ /(method:GET)
  /testcontroller, segment:1 -> SUCCESS @ /testcontroller
    /testcontroller/start, segment:2 -> SUCCESS @ /testcontroller/start
      /testcontroller/start/(method:GET), segment:2 -> SUCCESS @ /testcontroller/start/(method:GET)
    /testcontroller/stop, segment:1 -> FAILURE "Selector didn't match" @ /testcontroller/stop
Matched routes:
  "" -> "testcontroller" -> "start" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /testcontroller/start/(method:GET)
2026-04-04 06:16:16.326 [eventLoopGroupProxy-4-3] TRACE io.ktor.server.routing.Routing - Trace for [testcontroller, start]
/, segment:0 -> SUCCESS @ /
  /, segment:0 -> SUCCESS @ /
    /(method:GET), segment:0 -> FAILURE "Not all segments matched" @ /(method:GET)
  /testcontroller, segment:1 -> SUCCESS @ /testcontroller
    /testcontroller/start, segment:2 -> SUCCESS @ /testcontroller/start
      /testcontroller/start/(method:GET), segment:2 -> SUCCESS @ /testcontroller/start/(method:GET)
    /testcontroller/stop, segment:1 -> FAILURE "Selector didn't match" @ /testcontroller/stop
Matched routes:
  "" -> "testcontroller" -> "start" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /testcontroller/start/(method:GET)
2026-04-04 06:16:16.335 [eventLoopGroupProxy-4-3] INFO  Application - TestServerRunner: port=8066 starting command /home/jenkins/.jenkins/workspace/dev-playlists-end-to-end-tests/ci-run-test-server.sh (workingDir=/home/jenkins/.jenkins/workspace/dev-playlists-end-to-end-tests/build/testservercontroller/workspace/002_user_add_apps_playlists_bookmarks_test)
2026-04-04 06:16:16.335 [eventLoopGroupProxy-4-2] INFO  Application - TestServerRunner: port=8060 starting command /home/jenkins/.jenkins/workspace/dev-playlists-end-to-end-tests/ci-run-test-server.sh (workingDir=/home/jenkins/.jenkins/workspace/dev-playlists-end-to-end-tests/build/testservercontroller/workspace/001_005_add_school_self_registration_test)
2026-04-04 06:16:16.341 [eventLoopGroupProxy-4-3] INFO  Application - TestServerRunner: port=8066 process started PID=1082259 (saved to /home/jenkins/.jenkins/workspace/dev-playlists-end-to-end-tests/build/testservercontroller/workspace/002_user_add_apps_playlists_bookmarks_test/process.pid}
2026-04-04 06:16:16.341 [eventLoopGroupProxy-4-2] INFO  Application - TestServerRunner: port=8060 process started PID=1082258 (saved to /home/jenkins/.jenkins/workspace/dev-playlists-end-to-end-tests/build/testservercontroller/workspace/001_005_add_school_self_registration_test/process.pid}
2026-04-04 06:16:17.518 [eventLoopGroupProxy-4-3] INFO  Application - 200 OK: GET - /testcontroller/start in 1195ms
2026-04-04 06:16:17.542 [eventLoopGroupProxy-4-2] INFO  Application - 200 OK: GET - /testcontroller/start in 1219ms
2026-04-04 06:17:15.316 [eventLoopGroupProxy-4-4] TRACE io.ktor.server.routing.Routing - Trace for [robots.txt]
/, segment:0 -> SUCCESS @ /
  /, segment:0 -> SUCCESS @ /
    /(method:GET), segment:0 -> FAILURE "Not all segments matched" @ /(method:GET)
  /testcontroller, segment:0 -> FAILURE "Selector didn't match" @ /testcontroller
Matched routes:
  No results
Routing resolve result:
  FAILURE "No matched subtrees found" @ /
2026-04-04 06:17:15.316 [eventLoopGroupProxy-4-4] INFO  Application - 404 Not Found: GET - /robots.txt in 1ms
2026-04-04 06:17:15.440 [eventLoopGroupProxy-4-4] TRACE io.ktor.server.routing.Routing - Trace for [UmAppDatabase, SiteDao, getSiteAsync]
/, segment:0 -> SUCCESS @ /
  /, segment:0 -> SUCCESS @ /
    /(method:GET), segment:0 -> FAILURE "Not all segments matched" @ /(method:GET)
  /testcontroller, segment:0 -> FAILURE "Selector didn't match" @ /testcontroller
Matched routes:
  No results
Routing resolve result:
  FAILURE "No matched subtrees found" @ /
2026-04-04 06:17:15.440 [eventLoopGroupProxy-4-4] INFO  Application - 404 Not Found: GET - /UmAppDatabase/SiteDao/getSiteAsync in 0ms
2026-04-04 06:19:07.301 [eventLoopGroupProxy-4-5] TRACE io.ktor.server.routing.Routing - Trace for [}]
/, segment:0 -> SUCCESS @ /
  /, segment:0 -> SUCCESS @ /
    /(method:GET), segment:0 -> FAILURE "Not all segments matched" @ /(method:GET)
  /testcontroller, segment:0 -> FAILURE "Selector didn't match" @ /testcontroller
Matched routes:
  No results
Routing resolve result:
  FAILURE "No matched subtrees found" @ /
2026-04-04 06:19:07.301 [eventLoopGroupProxy-4-5] INFO  Application - 404 Not Found: GET - /%7D in 0ms
2026-04-04 06:19:09.279 [eventLoopGroupProxy-4-6] TRACE io.ktor.server.routing.Routing - Trace for [testcontroller, start]
/, segment:0 -> SUCCESS @ /
  /, segment:0 -> SUCCESS @ /
    /(method:GET), segment:0 -> FAILURE "Not all segments matched" @ /(method:GET)
  /testcontroller, segment:1 -> SUCCESS @ /testcontroller
    /testcontroller/start, segment:2 -> SUCCESS @ /testcontroller/start
      /testcontroller/start/(method:GET), segment:2 -> SUCCESS @ /testcontroller/start/(method:GET)
    /testcontroller/stop, segment:1 -> FAILURE "Selector didn't match" @ /testcontroller/stop
Matched routes:
  "" -> "testcontroller" -> "start" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /testcontroller/start/(method:GET)
2026-04-04 06:19:09.279 [eventLoopGroupProxy-4-6] INFO  Application - TestServerRunner: port=8060 starting command /home/jenkins/.jenkins/workspace/dev-playlists-end-to-end-tests/ci-run-test-server.sh (workingDir=/home/jenkins/.jenkins/workspace/dev-playlists-end-to-end-tests/build/testservercontroller/workspace/001_001_invite_users_using_qr_code_or_link_testyaml)
2026-04-04 06:19:09.280 [eventLoopGroupProxy-4-6] INFO  Application - TestServerRunner: port=8060 process started PID=1082678 (saved to /home/jenkins/.jenkins/workspace/dev-playlists-end-to-end-tests/build/testservercontroller/workspace/001_001_invite_users_using_qr_code_or_link_testyaml/process.pid}
2026-04-04 06:19:10.322 [eventLoopGroupProxy-4-6] INFO  Application - 200 OK: GET - /testcontroller/start in 1044ms
2026-04-04 06:20:12.721 [eventLoopGroupProxy-4-7] TRACE io.ktor.server.routing.Routing - Trace for [api, username, getsuggestion]
/, segment:0 -> SUCCESS @ /
  /, segment:0 -> SUCCESS @ /
    /(method:GET), segment:0 -> FAILURE "Not all segments matched" @ /(method:GET)
  /testcontroller, segment:0 -> FAILURE "Selector didn't match" @ /testcontroller
Matched routes:
  No results
Routing resolve result:
  FAILURE "No matched subtrees found" @ /
2026-04-04 06:20:12.722 [eventLoopGroupProxy-4-7] INFO  Application - 404 Not Found: GET - /api/username/getsuggestion in 1ms
2026-04-04 06:20:47.273 [eventLoopGroupProxy-4-7] TRACE io.ktor.server.routing.Routing - Trace for [auth, login]
/, segment:0 -> SUCCESS @ /
  /, segment:0 -> SUCCESS @ /
    /(method:GET), segment:0 -> FAILURE "Not all segments matched" @ /(method:GET)
  /testcontroller, segment:0 -> FAILURE "Selector didn't match" @ /testcontroller
Matched routes:
  No results
Routing resolve result:
  FAILURE "No matched subtrees found" @ /
2026-04-04 06:20:47.274 [eventLoopGroupProxy-4-7] INFO  Application - 404 Not Found: GET - /auth/login in 1ms
2026-04-04 06:21:35.318 [eventLoopGroupProxy-4-7] TRACE io.ktor.server.routing.Routing - Trace for [Site, verify]
/, segment:0 -> SUCCESS @ /
  /, segment:0 -> SUCCESS @ /
    /(method:GET), segment:0 -> FAILURE "Not all segments matched" @ /(method:GET)
  /testcontroller, segment:0 -> FAILURE "Selector didn't match" @ /testcontroller
Matched routes:
  No results
Routing resolve result:
  FAILURE "No matched subtrees found" @ /
2026-04-04 06:21:35.318 [eventLoopGroupProxy-4-7] INFO  Application - 404 Not Found: GET - /Site/verify in 1ms
2026-04-04 06:24:01.030 [eventLoopGroupProxy-4-8] TRACE io.ktor.server.routing.Routing - Trace for []
/, segment:0 -> SUCCESS @ /
  /, segment:0 -> SUCCESS @ /
    /(method:GET), segment:0 -> SUCCESS @ /(method:GET)
  /testcontroller, segment:0 -> FAILURE "Selector didn't match" @ /testcontroller
Matched routes:
  "" -> "<slash>" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /(method:GET)
2026-04-04 06:24:01.031 [eventLoopGroupProxy-4-8] INFO  Application - 200 OK: GET - / in 1ms
2026-04-04 06:24:22.373 [eventLoopGroupProxy-4-8] TRACE io.ktor.server.routing.Routing - Trace for [UmAppDatabase, replication, nodeId]
/, segment:0 -> SUCCESS @ /
  /, segment:0 -> SUCCESS @ /
    /(method:GET), segment:0 -> FAILURE "Not all segments matched" @ /(method:GET)
  /testcontroller, segment:0 -> FAILURE "Selector didn't match" @ /testcontroller
Matched routes:
  No results
Routing resolve result:
  FAILURE "No matched subtrees found" @ /
2026-04-04 06:24:22.373 [eventLoopGroupProxy-4-8] INFO  Application - 404 Not Found: GET - /UmAppDatabase/replication/nodeId in 0ms
2026-04-04 06:24:43.153 [eventLoopGroupProxy-4-9] TRACE io.ktor.server.routing.Routing - Trace for [testcontroller, start]
/, segment:0 -> SUCCESS @ /
  /, segment:0 -> SUCCESS @ /
    /(method:GET), segment:0 -> FAILURE "Not all segments matched" @ /(method:GET)
  /testcontroller, segment:1 -> SUCCESS @ /testcontroller
    /testcontroller/start, segment:2 -> SUCCESS @ /testcontroller/start
      /testcontroller/start/(method:GET), segment:2 -> SUCCESS @ /testcontroller/start/(method:GET)
    /testcontroller/stop, segment:1 -> FAILURE "Selector didn't match" @ /testcontroller/stop
Matched routes:
  "" -> "testcontroller" -> "start" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /testcontroller/start/(method:GET)
2026-04-04 06:24:43.153 [eventLoopGroupProxy-4-9] INFO  Application - TestServerRunner: port=8064 starting command /home/jenkins/.jenkins/workspace/dev-playlists-end-to-end-tests/ci-run-test-server.sh (workingDir=/home/jenkins/.jenkins/workspace/dev-playlists-end-to-end-tests/build/testservercontroller/workspace/001_003_login_using_school_link_test)
2026-04-04 06:24:43.155 [eventLoopGroupProxy-4-9] INFO  Application - TestServerRunner: port=8064 process started PID=1083273 (saved to /home/jenkins/.jenkins/workspace/dev-playlists-end-to-end-tests/build/testservercontroller/workspace/001_003_login_using_school_link_test/process.pid}
2026-04-04 06:24:44.268 [eventLoopGroupProxy-4-9] INFO  Application - 200 OK: GET - /testcontroller/start in 1115ms
2026-04-04 06:25:20.792 [eventLoopGroupProxy-4-8] TRACE io.ktor.server.routing.Routing - Trace for [UmAppDatabase, replication, ackAndGetPendingReplications]
/, segment:0 -> SUCCESS @ /
  /, segment:0 -> SUCCESS @ /
    /(method:GET), segment:0 -> FAILURE "Not all segments matched" @ /(method:GET)
  /testcontroller, segment:0 -> FAILURE "Selector didn't match" @ /testcontroller
Matched routes:
  No results
Routing resolve result:
  FAILURE "No matched subtrees found" @ /
2026-04-04 06:25:20.793 [eventLoopGroupProxy-4-8] INFO  Application - 404 Not Found: GET - /UmAppDatabase/replication/ackAndGetPendingReplications in 1ms
2026-04-04 06:26:35.725 [eventLoopGroupProxy-4-10] TRACE io.ktor.server.routing.Routing - Trace for [testcontroller, start]
/, segment:0 -> SUCCESS @ /
  /, segment:0 -> SUCCESS @ /
    /(method:GET), segment:0 -> FAILURE "Not all segments matched" @ /(method:GET)
  /testcontroller, segment:1 -> SUCCESS @ /testcontroller
    /testcontroller/start, segment:2 -> SUCCESS @ /testcontroller/start
      /testcontroller/start/(method:GET), segment:2 -> SUCCESS @ /testcontroller/start/(method:GET)
    /testcontroller/stop, segment:1 -> FAILURE "Selector didn't match" @ /testcontroller/stop
Matched routes:
  "" -> "testcontroller" -> "start" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /testcontroller/start/(method:GET)
2026-04-04 06:26:35.725 [eventLoopGroupProxy-4-10] INFO  Application - TestServerRunner: port=8067 starting command /home/jenkins/.jenkins/workspace/dev-playlists-end-to-end-tests/ci-run-test-server.sh (workingDir=/home/jenkins/.jenkins/workspace/dev-playlists-end-to-end-tests/build/testservercontroller/workspace/003_admin_user_assigns_assignment_to_a_class_test)
2026-04-04 06:26:35.727 [eventLoopGroupProxy-4-10] INFO  Application - TestServerRunner: port=8067 process started PID=1083480 (saved to /home/jenkins/.jenkins/workspace/dev-playlists-end-to-end-tests/build/testservercontroller/workspace/003_admin_user_assigns_assignment_to_a_class_test/process.pid}
2026-04-04 06:26:36.830 [eventLoopGroupProxy-4-10] INFO  Application - 200 OK: GET - /testcontroller/start in 1105ms
2026-04-04 06:26:37.543 [eventLoopGroupProxy-4-11] TRACE io.ktor.server.routing.Routing - Trace for [testcontroller, start]
/, segment:0 -> SUCCESS @ /
  /, segment:0 -> SUCCESS @ /
    /(method:GET), segment:0 -> FAILURE "Not all segments matched" @ /(method:GET)
  /testcontroller, segment:1 -> SUCCESS @ /testcontroller
    /testcontroller/start, segment:2 -> SUCCESS @ /testcontroller/start
      /testcontroller/start/(method:GET), segment:2 -> SUCCESS @ /testcontroller/start/(method:GET)
    /testcontroller/stop, segment:1 -> FAILURE "Selector didn't match" @ /testcontroller/stop
Matched routes:
  "" -> "testcontroller" -> "start" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /testcontroller/start/(method:GET)
2026-04-04 06:26:37.544 [eventLoopGroupProxy-4-11] INFO  Application - TestServerRunner: port=8060 starting command /home/jenkins/.jenkins/workspace/dev-playlists-end-to-end-tests/ci-run-test-server.sh (workingDir=/home/jenkins/.jenkins/workspace/dev-playlists-end-to-end-tests/build/testservercontroller/workspace/001_002_add_user_direct_testyaml)
2026-04-04 06:26:37.545 [eventLoopGroupProxy-4-11] INFO  Application - TestServerRunner: port=8060 process started PID=1083556 (saved to /home/jenkins/.jenkins/workspace/dev-playlists-end-to-end-tests/build/testservercontroller/workspace/001_002_add_user_direct_testyaml/process.pid}
2026-04-04 06:26:40.204 [eventLoopGroupProxy-4-11] INFO  Application - 200 OK: GET - /testcontroller/start in 2661ms
2026-04-04 06:40:52.242 [KtorShutdownHook] INFO  Application - Server is stopped
2026-04-04 06:40:52.242 [KtorShutdownHook] INFO  Application - TestServerRunner: request to stop server on port=8064
2026-04-04 06:40:52.242 [KtorShutdownHook] INFO  Application - TestServerRunner: request to stop server on port=8066
2026-04-04 06:40:52.242 [KtorShutdownHook] INFO  Application - TestServerRunner: request to stop server on port=8067
2026-04-04 06:40:52.242 [KtorShutdownHook] INFO  Application - TestServerRunner: request to stop server on port=8060