2026-09-14 16:06:39.181 [main] INFO Application - Autoreload is disabled because the development mode is off. 2026-09-14 16:06:39.317 [main] INFO Application - Application started in 0.212 seconds. 2026-09-14 16:06:39.376 [DefaultDispatcher-worker-1] INFO Application - Responding at http://0.0.0.0:8070 2026-09-14 16:07:25.204 [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-09-14 16:07:25.216 [eventLoopGroupProxy-4-2] INFO Application - TestServerRunner: port=8062 starting using command: /home/jenkins/.jenkins/workspace/fix-assignment-error-handling-end-to-end/ci-run-test-server.sh (workingDir=/home/jenkins/.jenkins/workspace/fix-assignment-error-handling-end-to-end/build/ci-e2e/workspace/001_001_invite_users_using_qr_code_or_link_test_20260914_167_25) 2026-09-14 16:07:26.775 [eventLoopGroupProxy-4-2] INFO Application - TestServerRunner: port=8062 process started PID=342176 (saved to /home/jenkins/.jenkins/workspace/fix-assignment-error-handling-end-to-end/build/ci-e2e/workspace/001_001_invite_users_using_qr_code_or_link_test_20260914_167_25/process.pid} 2026-09-14 16:07:27.168 [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-09-14 16:07:27.169 [eventLoopGroupProxy-4-3] INFO Application - TestServerRunner: port=8065 starting using command: /home/jenkins/.jenkins/workspace/fix-assignment-error-handling-end-to-end/ci-run-test-server.sh (workingDir=/home/jenkins/.jenkins/workspace/fix-assignment-error-handling-end-to-end/build/ci-e2e/workspace/002_browse_lessons_test_20260914_167_27) 2026-09-14 16:07:28.615 [eventLoopGroupProxy-4-3] INFO Application - TestServerRunner: port=8065 process started PID=342276 (saved to /home/jenkins/.jenkins/workspace/fix-assignment-error-handling-end-to-end/build/ci-e2e/workspace/002_browse_lessons_test_20260914_167_27/process.pid} 2026-09-14 16:07:28.802 [eventLoopGroupProxy-4-2] INFO Application - 200 OK: GET - /testcontroller/start in 3604ms 2026-09-14 16:07:30.617 [eventLoopGroupProxy-4-3] INFO Application - 200 OK: GET - /testcontroller/start in 3449ms 2026-09-14 16:09:46.881 [eventLoopGroupProxy-4-4] TRACE io.ktor.server.routing.Routing - Trace for [testcontroller, stop] /, 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:1 -> FAILURE "Selector didn't match" @ /testcontroller/start /testcontroller/stop, segment:2 -> SUCCESS @ /testcontroller/stop /testcontroller/stop/(method:GET), segment:2 -> SUCCESS @ /testcontroller/stop/(method:GET) Matched routes: "" -> "testcontroller" -> "stop" -> "(method:GET)" Routing resolve result: SUCCESS @ /testcontroller/stop/(method:GET) 2026-09-14 16:09:46.882 [eventLoopGroupProxy-4-4] INFO Application - TestServerRunner: stopping server on port=8065 2026-09-14 16:09:48.891 [eventLoopGroupProxy-4-4] INFO Application - TestServerRunner: stopping server on port 8065 pid=342276 2026-09-14 16:09:58.913 [eventLoopGroupProxy-4-4] INFO Application - TestServerController: killed process 342276 2026-09-14 16:10:04.017 [eventLoopGroupProxy-4-4] INFO Application - TestServerController: killed descendent 342283 2026-09-14 16:10:06.551 [eventLoopGroupProxy-4-4] INFO Application - TestServerRunner: killed pid #342283 (/home/jenkins/.jenkins/workspace/fix-assignment-error-handling-end-to-end/build/ci-e2e/workspace/002_browse_lessons_test_20260914_167_27/server.pid) 2026-09-14 16:10:06.553 [eventLoopGroupProxy-4-4] INFO Application - 200 OK: GET - /testcontroller/stop in 19672ms 2026-09-14 16:10:54.570 [eventLoopGroupProxy-4-5] 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-09-14 16:10:54.570 [eventLoopGroupProxy-4-5] INFO Application - TestServerRunner: port=8060 starting using command: /home/jenkins/.jenkins/workspace/fix-assignment-error-handling-end-to-end/ci-run-test-server.sh (workingDir=/home/jenkins/.jenkins/workspace/fix-assignment-error-handling-end-to-end/build/ci-e2e/workspace/001_003_login_using_school_link_test_20260914_1610_54) 2026-09-14 16:10:55.737 [eventLoopGroupProxy-4-5] INFO Application - TestServerRunner: port=8060 process started PID=342817 (saved to /home/jenkins/.jenkins/workspace/fix-assignment-error-handling-end-to-end/build/ci-e2e/workspace/001_003_login_using_school_link_test_20260914_1610_54/process.pid} 2026-09-14 16:10:57.739 [eventLoopGroupProxy-4-5] INFO Application - 200 OK: GET - /testcontroller/start in 3169ms 2026-09-14 16:12:29.564 [eventLoopGroupProxy-4-6] TRACE io.ktor.server.routing.Routing - Trace for [testcontroller, stop] /, 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:1 -> FAILURE "Selector didn't match" @ /testcontroller/start /testcontroller/stop, segment:2 -> SUCCESS @ /testcontroller/stop /testcontroller/stop/(method:GET), segment:2 -> SUCCESS @ /testcontroller/stop/(method:GET) Matched routes: "" -> "testcontroller" -> "stop" -> "(method:GET)" Routing resolve result: SUCCESS @ /testcontroller/stop/(method:GET) 2026-09-14 16:12:29.564 [eventLoopGroupProxy-4-6] INFO Application - TestServerRunner: stopping server on port=8060 2026-09-14 16:12:31.571 [eventLoopGroupProxy-4-6] INFO Application - TestServerRunner: stopping server on port 8060 pid=342817 2026-09-14 16:12:41.580 [eventLoopGroupProxy-4-6] INFO Application - TestServerController: killed process 342817 2026-09-14 16:12:46.685 [eventLoopGroupProxy-4-6] INFO Application - TestServerController: killed descendent 342827 2026-09-14 16:12:48.781 [eventLoopGroupProxy-4-6] INFO Application - TestServerRunner: killed pid #342827 (/home/jenkins/.jenkins/workspace/fix-assignment-error-handling-end-to-end/build/ci-e2e/workspace/001_003_login_using_school_link_test_20260914_1610_54/server.pid) 2026-09-14 16:12:48.782 [eventLoopGroupProxy-4-6] INFO Application - 200 OK: GET - /testcontroller/stop in 19218ms 2026-09-14 16:13:05.426 [eventLoopGroupProxy-4-7] TRACE io.ktor.server.routing.Routing - Trace for [testcontroller, stop] /, 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:1 -> FAILURE "Selector didn't match" @ /testcontroller/start /testcontroller/stop, segment:2 -> SUCCESS @ /testcontroller/stop /testcontroller/stop/(method:GET), segment:2 -> SUCCESS @ /testcontroller/stop/(method:GET) Matched routes: "" -> "testcontroller" -> "stop" -> "(method:GET)" Routing resolve result: SUCCESS @ /testcontroller/stop/(method:GET) 2026-09-14 16:13:05.427 [eventLoopGroupProxy-4-7] INFO Application - TestServerRunner: stopping server on port=8062 2026-09-14 16:13:07.434 [eventLoopGroupProxy-4-7] INFO Application - TestServerRunner: stopping server on port 8062 pid=342176 2026-09-14 16:13:17.444 [eventLoopGroupProxy-4-7] INFO Application - TestServerController: killed process 342176 2026-09-14 16:13:22.549 [eventLoopGroupProxy-4-7] INFO Application - TestServerController: killed descendent 342189 2026-09-14 16:13:24.645 [eventLoopGroupProxy-4-7] INFO Application - TestServerRunner: killed pid #342189 (/home/jenkins/.jenkins/workspace/fix-assignment-error-handling-end-to-end/build/ci-e2e/workspace/001_001_invite_users_using_qr_code_or_link_test_20260914_167_25/server.pid) 2026-09-14 16:13:24.646 [eventLoopGroupProxy-4-7] INFO Application - 200 OK: GET - /testcontroller/stop in 19220ms 2026-09-14 16:13:33.213 [eventLoopGroupProxy-4-8] 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-09-14 16:13:33.213 [eventLoopGroupProxy-4-8] INFO Application - TestServerRunner: port=8068 starting using command: /home/jenkins/.jenkins/workspace/fix-assignment-error-handling-end-to-end/ci-run-test-server.sh (workingDir=/home/jenkins/.jenkins/workspace/fix-assignment-error-handling-end-to-end/build/ci-e2e/workspace/003_admin_user_assigns_assignment_to_a_class_test_20260914_1613_33) 2026-09-14 16:13:34.369 [eventLoopGroupProxy-4-8] INFO Application - TestServerRunner: port=8068 process started PID=343232 (saved to /home/jenkins/.jenkins/workspace/fix-assignment-error-handling-end-to-end/build/ci-e2e/workspace/003_admin_user_assigns_assignment_to_a_class_test_20260914_1613_33/process.pid} 2026-09-14 16:13:36.371 [eventLoopGroupProxy-4-8] INFO Application - 200 OK: GET - /testcontroller/start in 3158ms 2026-09-14 16:14:25.868 [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-09-14 16:14:25.869 [eventLoopGroupProxy-4-9] INFO Application - TestServerRunner: port=8063 starting using command: /home/jenkins/.jenkins/workspace/fix-assignment-error-handling-end-to-end/ci-run-test-server.sh (workingDir=/home/jenkins/.jenkins/workspace/fix-assignment-error-handling-end-to-end/build/ci-e2e/workspace/001_002_add_user_direct_test_20260914_1614_25) 2026-09-14 16:14:27.006 [eventLoopGroupProxy-4-9] INFO Application - TestServerRunner: port=8063 process started PID=343373 (saved to /home/jenkins/.jenkins/workspace/fix-assignment-error-handling-end-to-end/build/ci-e2e/workspace/001_002_add_user_direct_test_20260914_1614_25/process.pid} 2026-09-14 16:14:29.008 [eventLoopGroupProxy-4-9] INFO Application - 200 OK: GET - /testcontroller/start in 3140ms 2026-09-14 16:24:19.686 [eventLoopGroupProxy-4-10] TRACE io.ktor.server.routing.Routing - Trace for [testcontroller, stop] /, 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:1 -> FAILURE "Selector didn't match" @ /testcontroller/start /testcontroller/stop, segment:2 -> SUCCESS @ /testcontroller/stop /testcontroller/stop/(method:GET), segment:2 -> SUCCESS @ /testcontroller/stop/(method:GET) Matched routes: "" -> "testcontroller" -> "stop" -> "(method:GET)" Routing resolve result: SUCCESS @ /testcontroller/stop/(method:GET) 2026-09-14 16:24:19.686 [eventLoopGroupProxy-4-10] INFO Application - TestServerRunner: stopping server on port=8063 2026-09-14 16:24:21.695 [eventLoopGroupProxy-4-10] INFO Application - TestServerRunner: stopping server on port 8063 pid=343373 2026-09-14 16:24:31.707 [eventLoopGroupProxy-4-10] INFO Application - TestServerController: killed process 343373 2026-09-14 16:24:36.814 [eventLoopGroupProxy-4-10] INFO Application - TestServerController: killed descendent 343379 2026-09-14 16:24:39.325 [eventLoopGroupProxy-4-10] INFO Application - TestServerRunner: killed pid #343379 (/home/jenkins/.jenkins/workspace/fix-assignment-error-handling-end-to-end/build/ci-e2e/workspace/001_002_add_user_direct_test_20260914_1614_25/server.pid) 2026-09-14 16:24:39.325 [eventLoopGroupProxy-4-10] INFO Application - 200 OK: GET - /testcontroller/stop in 19640ms 2026-09-14 16:24:43.945 [eventLoopGroupProxy-4-11] TRACE io.ktor.server.routing.Routing - Trace for [testcontroller, stop] /, 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:1 -> FAILURE "Selector didn't match" @ /testcontroller/start /testcontroller/stop, segment:2 -> SUCCESS @ /testcontroller/stop /testcontroller/stop/(method:GET), segment:2 -> SUCCESS @ /testcontroller/stop/(method:GET) Matched routes: "" -> "testcontroller" -> "stop" -> "(method:GET)" Routing resolve result: SUCCESS @ /testcontroller/stop/(method:GET) 2026-09-14 16:24:43.945 [eventLoopGroupProxy-4-11] INFO Application - TestServerRunner: stopping server on port=8068 2026-09-14 16:24:45.951 [eventLoopGroupProxy-4-11] INFO Application - TestServerRunner: stopping server on port 8068 pid=343232 2026-09-14 16:24:55.960 [eventLoopGroupProxy-4-11] INFO Application - TestServerController: killed process 343232 2026-09-14 16:25:01.065 [eventLoopGroupProxy-4-11] INFO Application - TestServerController: killed descendent 343239 2026-09-14 16:25:03.166 [eventLoopGroupProxy-4-11] INFO Application - TestServerRunner: killed pid #343239 (/home/jenkins/.jenkins/workspace/fix-assignment-error-handling-end-to-end/build/ci-e2e/workspace/003_admin_user_assigns_assignment_to_a_class_test_20260914_1613_33/server.pid) 2026-09-14 16:25:03.166 [eventLoopGroupProxy-4-11] INFO Application - 200 OK: GET - /testcontroller/stop in 19221ms 2026-09-14 16:27:30.297 [KtorShutdownHook] INFO Application - Server is stopped