2026-08-20 16:06:23.295 [main] INFO Application - Autoreload is disabled because the development mode is off. 2026-08-20 16:06:23.444 [main] INFO Application - Application started in 0.226 seconds. 2026-08-20 16:06:23.505 [DefaultDispatcher-worker-1] INFO Application - Responding at http://0.0.0.0:8070 2026-08-20 16:06:44.509 [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-08-20 16:06:44.521 [eventLoopGroupProxy-4-2] INFO Application - TestServerRunner: port=8067 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_20260820_166_44) 2026-08-20 16:06:45.611 [eventLoopGroupProxy-4-2] INFO Application - TestServerRunner: port=8067 process started PID=1922101 (saved to /home/jenkins/.jenkins/workspace/fix-assignment-error-handling-end-to-end/build/ci-e2e/workspace/002_browse_lessons_test_20260820_166_44/process.pid} 2026-08-20 16:06:46.069 [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-08-20 16:06:46.070 [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/001_001_invite_users_using_qr_code_or_link_test_20260820_166_46) 2026-08-20 16:06:47.212 [eventLoopGroupProxy-4-3] INFO Application - TestServerRunner: port=8065 process started PID=1922187 (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_20260820_166_46/process.pid} 2026-08-20 16:06:47.629 [eventLoopGroupProxy-4-2] INFO Application - 200 OK: GET - /testcontroller/start in 3126ms 2026-08-20 16:06:49.214 [eventLoopGroupProxy-4-3] INFO Application - 200 OK: GET - /testcontroller/start in 3145ms 2026-08-20 16:08:59.409 [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-08-20 16:08:59.410 [eventLoopGroupProxy-4-4] INFO Application - TestServerRunner: stopping server on port=8067 2026-08-20 16:09:01.419 [eventLoopGroupProxy-4-4] INFO Application - TestServerRunner: stopping server on port 8067 pid=1922101 2026-08-20 16:09:11.433 [eventLoopGroupProxy-4-4] INFO Application - TestServerController: killed process 1922101 2026-08-20 16:09:16.537 [eventLoopGroupProxy-4-4] INFO Application - TestServerController: killed descendent 1922114 2026-08-20 16:09:19.071 [eventLoopGroupProxy-4-4] INFO Application - TestServerRunner: killed pid #1922114 (/home/jenkins/.jenkins/workspace/fix-assignment-error-handling-end-to-end/build/ci-e2e/workspace/002_browse_lessons_test_20260820_166_44/server.pid) 2026-08-20 16:09:19.072 [eventLoopGroupProxy-4-4] INFO Application - 200 OK: GET - /testcontroller/stop in 19663ms 2026-08-20 16:09:37.907 [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-08-20 16:09:37.908 [eventLoopGroupProxy-4-5] INFO Application - TestServerRunner: port=8061 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_20260820_169_37) 2026-08-20 16:09:39.450 [eventLoopGroupProxy-4-5] INFO Application - TestServerRunner: port=8061 process started PID=1922606 (saved to /home/jenkins/.jenkins/workspace/fix-assignment-error-handling-end-to-end/build/ci-e2e/workspace/001_003_login_using_school_link_test_20260820_169_37/process.pid} 2026-08-20 16:09:41.453 [eventLoopGroupProxy-4-5] INFO Application - 200 OK: GET - /testcontroller/start in 3546ms 2026-08-20 16:11:11.289 [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-08-20 16:11:11.289 [eventLoopGroupProxy-4-6] INFO Application - TestServerRunner: stopping server on port=8061 2026-08-20 16:11:13.296 [eventLoopGroupProxy-4-6] INFO Application - TestServerRunner: stopping server on port 8061 pid=1922606 2026-08-20 16:11:23.307 [eventLoopGroupProxy-4-6] INFO Application - TestServerController: killed process 1922606 2026-08-20 16:11:28.412 [eventLoopGroupProxy-4-6] INFO Application - TestServerController: killed descendent 1922613 2026-08-20 16:11:30.529 [eventLoopGroupProxy-4-6] INFO Application - TestServerRunner: killed pid #1922613 (/home/jenkins/.jenkins/workspace/fix-assignment-error-handling-end-to-end/build/ci-e2e/workspace/001_003_login_using_school_link_test_20260820_169_37/server.pid) 2026-08-20 16:11:30.529 [eventLoopGroupProxy-4-6] INFO Application - 200 OK: GET - /testcontroller/stop in 19241ms 2026-08-20 16:11:48.905 [eventLoopGroupProxy-4-7] 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-08-20 16:11:48.906 [eventLoopGroupProxy-4-7] INFO Application - TestServerRunner: port=8066 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_20260820_1611_48) 2026-08-20 16:11:50.368 [eventLoopGroupProxy-4-7] INFO Application - TestServerRunner: port=8066 process started PID=1922840 (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_20260820_1611_48/process.pid} 2026-08-20 16:11:52.371 [eventLoopGroupProxy-4-7] INFO Application - 200 OK: GET - /testcontroller/start in 3466ms 2026-08-20 16:12:20.210 [eventLoopGroupProxy-4-8] 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-08-20 16:12:20.211 [eventLoopGroupProxy-4-8] INFO Application - TestServerRunner: stopping server on port=8065 2026-08-20 16:12:22.218 [eventLoopGroupProxy-4-8] INFO Application - TestServerRunner: stopping server on port 8065 pid=1922187 2026-08-20 16:12:32.229 [eventLoopGroupProxy-4-8] INFO Application - TestServerController: killed process 1922187 2026-08-20 16:12:37.334 [eventLoopGroupProxy-4-8] INFO Application - TestServerController: killed descendent 1922194 2026-08-20 16:12:39.869 [eventLoopGroupProxy-4-8] INFO Application - TestServerRunner: killed pid #1922194 (/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_20260820_166_46/server.pid) 2026-08-20 16:12:39.870 [eventLoopGroupProxy-4-8] INFO Application - 200 OK: GET - /testcontroller/stop in 19660ms 2026-08-20 16:12:57.740 [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-08-20 16:12:57.740 [eventLoopGroupProxy-4-9] INFO Application - TestServerRunner: port=8061 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_20260820_1612_57) 2026-08-20 16:12:59.191 [eventLoopGroupProxy-4-9] INFO Application - TestServerRunner: port=8061 process started PID=1923053 (saved to /home/jenkins/.jenkins/workspace/fix-assignment-error-handling-end-to-end/build/ci-e2e/workspace/001_002_add_user_direct_test_20260820_1612_57/process.pid} 2026-08-20 16:13:01.194 [eventLoopGroupProxy-4-9] INFO Application - 200 OK: GET - /testcontroller/start in 3455ms 2026-08-20 16:19:03.659 [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-08-20 16:19:03.660 [eventLoopGroupProxy-4-10] INFO Application - TestServerRunner: port=8064 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_20260820_1619_3) 2026-08-20 16:19:04.938 [eventLoopGroupProxy-4-10] INFO Application - TestServerRunner: port=8064 process started PID=1923548 (saved to /home/jenkins/.jenkins/workspace/fix-assignment-error-handling-end-to-end/build/ci-e2e/workspace/001_002_add_user_direct_test_20260820_1619_3/process.pid} 2026-08-20 16:19:06.944 [eventLoopGroupProxy-4-10] INFO Application - 200 OK: GET - /testcontroller/start in 3285ms 2026-08-20 16:22:59.845 [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-08-20 16:22:59.845 [eventLoopGroupProxy-4-11] INFO Application - TestServerRunner: stopping server on port=8066 2026-08-20 16:23:01.850 [eventLoopGroupProxy-4-11] INFO Application - TestServerRunner: stopping server on port 8066 pid=1922840 2026-08-20 16:23:11.862 [eventLoopGroupProxy-4-11] INFO Application - TestServerController: killed process 1922840 2026-08-20 16:23:16.966 [eventLoopGroupProxy-4-11] INFO Application - TestServerController: killed descendent 1922850 2026-08-20 16:23:19.472 [eventLoopGroupProxy-4-11] INFO Application - TestServerRunner: killed pid #1922850 (/home/jenkins/.jenkins/workspace/fix-assignment-error-handling-end-to-end/build/ci-e2e/workspace/003_admin_user_assigns_assignment_to_a_class_test_20260820_1611_48/server.pid) 2026-08-20 16:23:19.473 [eventLoopGroupProxy-4-11] INFO Application - 200 OK: GET - /testcontroller/stop in 19629ms 2026-08-20 16:28:51.069 [eventLoopGroupProxy-4-12] 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-08-20 16:28:51.069 [eventLoopGroupProxy-4-12] INFO Application - TestServerRunner: stopping server on port=8064 2026-08-20 16:28:53.076 [eventLoopGroupProxy-4-12] INFO Application - TestServerRunner: stopping server on port 8064 pid=1923548 2026-08-20 16:29:03.087 [eventLoopGroupProxy-4-12] INFO Application - TestServerController: killed process 1923548 2026-08-20 16:29:08.191 [eventLoopGroupProxy-4-12] INFO Application - TestServerController: killed descendent 1923556 2026-08-20 16:29:10.723 [eventLoopGroupProxy-4-12] INFO Application - TestServerRunner: killed pid #1923556 (/home/jenkins/.jenkins/workspace/fix-assignment-error-handling-end-to-end/build/ci-e2e/workspace/001_002_add_user_direct_test_20260820_1619_3/server.pid) 2026-08-20 16:29:10.723 [eventLoopGroupProxy-4-12] INFO Application - 200 OK: GET - /testcontroller/stop in 19654ms 2026-08-20 16:30:59.651 [KtorShutdownHook] INFO Application - Server is stopped 2026-08-20 16:30:59.652 [KtorShutdownHook] INFO Application - TestServerRunner: stopping server on port=8061 2026-08-20 16:31:01.659 [KtorShutdownHook] INFO Application - TestServerRunner: stopping server on port 8061 pid=1923053 2026-08-20 16:31:01.669 [KtorShutdownHook] INFO Application - TestServerController: killed process 1923053 2026-08-20 16:31:08.720 [KtorShutdownHook] INFO Application - TestServerRunner: killed pid #1923059 (/home/jenkins/.jenkins/workspace/fix-assignment-error-handling-end-to-end/build/ci-e2e/workspace/001_002_add_user_direct_test_20260820_1612_57/server.pid)