2026-03-10 10:18:57.656 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-03-10 10:18:57.739 [Test worker] INFO io.ktor.server.Application - Application started in 0.195 seconds. 2026-03-10 10:18:57.810 [DefaultDispatcher-worker-1 @coroutine#2] INFO io.ktor.server.Application - Responding at http://0.0.0.0:43313 2026-03-10 10:18:58.056 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43313/resources/index.json 2026-03-10 10:18:58.056 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:43313/resources/index.json. 2026-03-10 10:18:58.056 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43313/resources/index.json 2026-03-10 10:18:58.186 [eventLoopGroupProxy-4-1 @call-handler#12] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json] /, segment:0 -> SUCCESS @ / /(staticContent), segment:0 -> SUCCESS @ /(staticContent) /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...} /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET) Matched routes: "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)" Routing resolve result: SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET) 2026-03-10 10:18:58.220 [DefaultDispatcher-worker-1 @call-handler#12] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 39ms 2026-03-10 10:18:58.224 [DefaultDispatcher-worker-2 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43313/resources/index.json 2026-03-10 10:18:58.225 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43313/resources/index.json 2026-03-10 10:18:58.225 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43313/resources/index.json 2026-03-10 10:18:58.243 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsFeed for http://localhost:43313/resources/index.json. 2026-03-10 10:18:58.270 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43313/resources/index.json 2026-03-10 10:18:58.270 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:43313/resources/index.json. 2026-03-10 10:18:58.270 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43313/resources/index.json 2026-03-10 10:18:58.272 [eventLoopGroupProxy-4-1 @call-handler#22] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json] /, segment:0 -> SUCCESS @ / /(staticContent), segment:0 -> SUCCESS @ /(staticContent) /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...} /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET) Matched routes: "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)" Routing resolve result: SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET) 2026-03-10 10:18:58.273 [eventLoopGroupProxy-4-1 @call-handler#22] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms 2026-03-10 10:18:58.274 [DefaultDispatcher-worker-2 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43313/resources/index.json 2026-03-10 10:18:58.274 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43313/resources/index.json 2026-03-10 10:18:58.274 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43313/resources/index.json 2026-03-10 10:19:00.288 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-03-10 10:19:00.289 [Test worker] INFO io.ktor.server.Application - Application started in 0.001 seconds. 2026-03-10 10:19:00.290 [DefaultDispatcher-worker-3 @coroutine#26] INFO io.ktor.server.Application - Responding at http://0.0.0.0:37831 2026-03-10 10:19:00.354 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37831/resources/index.json 2026-03-10 10:19:00.354 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:37831/resources/index.json. 2026-03-10 10:19:00.354 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37831/resources/index.json 2026-03-10 10:19:00.357 [eventLoopGroupProxy-7-1 @call-handler#35] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json] /, segment:0 -> SUCCESS @ / /(staticContent), segment:0 -> SUCCESS @ /(staticContent) /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...} /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET) Matched routes: "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)" Routing resolve result: SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET) 2026-03-10 10:19:00.358 [eventLoopGroupProxy-7-1 @call-handler#35] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 1ms 2026-03-10 10:19:00.359 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37831/resources/index.json 2026-03-10 10:19:00.359 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37831/resources/index.json 2026-03-10 10:19:00.359 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37831/resources/index.json 2026-03-10 10:19:00.360 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsFeed for http://localhost:37831/resources/index.json. 2026-03-10 10:19:00.365 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37831/resources/index.json 2026-03-10 10:19:00.365 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:37831/resources/index.json. 2026-03-10 10:19:00.365 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37831/resources/index.json 2026-03-10 10:19:00.366 [eventLoopGroupProxy-7-1 @call-handler#45] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json] /, segment:0 -> SUCCESS @ / /(staticContent), segment:0 -> SUCCESS @ /(staticContent) /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...} /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET) Matched routes: "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)" Routing resolve result: SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET) 2026-03-10 10:19:00.367 [eventLoopGroupProxy-7-1 @call-handler#45] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms 2026-03-10 10:19:00.368 [DefaultDispatcher-worker-3 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37831/resources/index.json 2026-03-10 10:19:00.368 [DefaultDispatcher-worker-4 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37831/resources/index.json 2026-03-10 10:19:00.368 [DefaultDispatcher-worker-4 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37831/resources/index.json 2026-03-10 10:19:02.374 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-03-10 10:19:02.375 [Test worker] INFO io.ktor.server.Application - Application started in 0.001 seconds. 2026-03-10 10:19:02.376 [DefaultDispatcher-worker-4 @coroutine#49] INFO io.ktor.server.Application - Responding at http://0.0.0.0:39465 2026-03-10 10:19:02.381 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39465/resources/lesson001.json 2026-03-10 10:19:02.381 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:39465/resources/lesson001.json. 2026-03-10 10:19:02.381 [Test worker @coroutine#52] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39465/resources/lesson001.json 2026-03-10 10:19:02.386 [eventLoopGroupProxy-10-1 @call-handler#56] TRACE io.ktor.server.routing.Routing - Trace for [resources, lesson001.json] /, segment:0 -> SUCCESS @ / /(staticContent), segment:0 -> SUCCESS @ /(staticContent) /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[lesson001.json]] @ /(staticContent)/resources/{...} /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET) Matched routes: "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)" Routing resolve result: SUCCESS; Parameters [static-content-path-parameter=[lesson001.json]] @ /(staticContent)/resources/{...}/(method:GET) 2026-03-10 10:19:02.387 [DefaultDispatcher-worker-3 @call-handler#56] INFO io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 2ms 2026-03-10 10:19:02.388 [DefaultDispatcher-worker-4 @coroutine#52] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39465/resources/lesson001.json 2026-03-10 10:19:02.388 [DefaultDispatcher-worker-4 @coroutine#52] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39465/resources/lesson001.json 2026-03-10 10:19:02.388 [DefaultDispatcher-worker-4 @coroutine#52] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39465/resources/lesson001.json 2026-03-10 10:19:02.414 [DefaultDispatcher-worker-4 @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsPublication for http://localhost:39465/resources/lesson001.json. 2026-03-10 10:19:05.002 [Test worker @coroutine#61] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-03-10 10:19:05.012 [Test worker @coroutine#61] INFO io.ktor.server.Application - Application started in 0.501 seconds. 2026-03-10 10:19:05.016 [DefaultDispatcher-worker-4 @coroutine#70] INFO io.ktor.server.Application - Responding at http://0.0.0.0:41737 2026-03-10 10:19:05.027 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41737/api/school/respect/schoolpermissiongrant 2026-03-10 10:19:05.027 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41737/api/school/respect/schoolpermissiongrant. 2026-03-10 10:19:05.027 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41737/api/school/respect/schoolpermissiongrant 2026-03-10 10:19:05.033 [eventLoopGroupProxy-13-1 @call-handler#74] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, schoolpermissiongrant] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/person /api/school/respect/schoolpermissiongrant, segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant /api/school/respect/schoolpermissiongrant/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET) Matched routes: "" -> "api" -> "school" -> "respect" -> "schoolpermissiongrant" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET) 2026-03-10 10:19:05.052 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41737/api/school/respect/schoolpermissiongrant 2026-03-10 10:19:05.053 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41737/api/school/respect/schoolpermissiongrant 2026-03-10 10:19:05.053 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41737/api/school/respect/schoolpermissiongrant 2026-03-10 10:19:05.055 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41737/api/school/respect/schoolpermissiongrant. 2026-03-10 10:19:05.148 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41737/api/school/respect/person?includeRelated=false 2026-03-10 10:19:05.148 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41737/api/school/respect/person?includeRelated=false. 2026-03-10 10:19:05.148 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41737/api/school/respect/person?includeRelated=false 2026-03-10 10:19:05.150 [eventLoopGroupProxy-13-1 @call-handler#80] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET) /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST) /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2026-03-10 10:19:05.172 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41737/api/school/respect/person?includeRelated=false 2026-03-10 10:19:05.173 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41737/api/school/respect/person?includeRelated=false 2026-03-10 10:19:05.173 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41737/api/school/respect/person?includeRelated=false 2026-03-10 10:19:05.174 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41737/api/school/respect/person?includeRelated=false. 2026-03-10 10:19:05.182 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41737/api/school/respect/person?includeRelated=false 2026-03-10 10:19:05.182 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41737/api/school/respect/person?includeRelated=false. 2026-03-10 10:19:05.182 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41737/api/school/respect/person?includeRelated=false 2026-03-10 10:19:05.185 [eventLoopGroupProxy-13-1 @call-handler#86] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET) /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST) /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2026-03-10 10:19:05.187 [DefaultDispatcher-worker-3 @call-handler#86] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the GET /api/school/respect/person?includeRelated=false request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType]. 2026-03-10 10:19:05.188 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41737/api/school/respect/person?includeRelated=false 2026-03-10 10:19:05.188 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41737/api/school/respect/person?includeRelated=false 2026-03-10 10:19:05.189 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41737/api/school/respect/person?includeRelated=false 2026-03-10 10:19:07.314 [Test worker @coroutine#90] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-03-10 10:19:07.315 [Test worker @coroutine#90] INFO io.ktor.server.Application - Application started in 0.041 seconds. 2026-03-10 10:19:07.319 [DefaultDispatcher-worker-4 @coroutine#99] INFO io.ktor.server.Application - Responding at http://0.0.0.0:44069 2026-03-10 10:19:07.320 [Test worker @coroutine#90] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44069/api/school/respect/schoolpermissiongrant 2026-03-10 10:19:07.320 [Test worker @coroutine#90] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:44069/api/school/respect/schoolpermissiongrant. 2026-03-10 10:19:07.320 [Test worker @coroutine#90] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44069/api/school/respect/schoolpermissiongrant 2026-03-10 10:19:07.323 [eventLoopGroupProxy-16-1 @call-handler#103] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, schoolpermissiongrant] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/person /api/school/respect/schoolpermissiongrant, segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant /api/school/respect/schoolpermissiongrant/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET) Matched routes: "" -> "api" -> "school" -> "respect" -> "schoolpermissiongrant" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET) 2026-03-10 10:19:07.326 [Test worker @coroutine#90] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44069/api/school/respect/schoolpermissiongrant 2026-03-10 10:19:07.326 [Test worker @coroutine#90] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44069/api/school/respect/schoolpermissiongrant 2026-03-10 10:19:07.326 [Test worker @coroutine#90] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44069/api/school/respect/schoolpermissiongrant 2026-03-10 10:19:07.327 [Test worker @coroutine#90] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44069/api/school/respect/schoolpermissiongrant. 2026-03-10 10:19:07.385 [DefaultDispatcher-worker-2 @coroutine#109] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44069/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-03-10 10:19:07.385 [DefaultDispatcher-worker-2 @coroutine#109] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:44069/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100. 2026-03-10 10:19:07.385 [DefaultDispatcher-worker-2 @coroutine#109] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44069/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-03-10 10:19:07.386 [eventLoopGroupProxy-16-1 @call-handler#113] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET) /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST) /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2026-03-10 10:19:07.390 [DefaultDispatcher-worker-3 @coroutine#109] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44069/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-03-10 10:19:07.390 [DefaultDispatcher-worker-3 @coroutine#109] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44069/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-03-10 10:19:07.390 [DefaultDispatcher-worker-3 @coroutine#109] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44069/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-03-10 10:19:07.391 [DefaultDispatcher-worker-3 @coroutine#109] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44069/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100. 2026-03-10 10:19:09.534 [Test worker @coroutine#118] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-03-10 10:19:09.535 [Test worker @coroutine#118] INFO io.ktor.server.Application - Application started in 0.05 seconds. 2026-03-10 10:19:09.536 [DefaultDispatcher-worker-4 @coroutine#127] INFO io.ktor.server.Application - Responding at http://0.0.0.0:42355 2026-03-10 10:19:09.540 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42355/api/school/respect/person?includeRelated=false 2026-03-10 10:19:09.540 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:42355/api/school/respect/person?includeRelated=false. 2026-03-10 10:19:09.540 [Test worker @coroutine#118] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42355/api/school/respect/person?includeRelated=false 2026-03-10 10:19:09.544 [eventLoopGroupProxy-19-1 @call-handler#132] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET) /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST) Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2026-03-10 10:19:09.549 [Test worker @coroutine#118] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42355/api/school/respect/person?includeRelated=false 2026-03-10 10:19:09.549 [Test worker @coroutine#118] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42355/api/school/respect/person?includeRelated=false 2026-03-10 10:19:09.549 [Test worker @coroutine#118] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42355/api/school/respect/person?includeRelated=false 2026-03-10 10:19:09.551 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:42355/api/school/respect/person?includeRelated=false. 2026-03-10 10:19:09.668 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42355/api/school/respect/person?since=2026-03-10T06%3A19%3A09.544486710Z&includeRelated=false 2026-03-10 10:19:09.668 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:42355/api/school/respect/person?since=2026-03-10T06%3A19%3A09.544486710Z&includeRelated=false. 2026-03-10 10:19:09.668 [Test worker @coroutine#118] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42355/api/school/respect/person?since=2026-03-10T06%3A19%3A09.544486710Z&includeRelated=false 2026-03-10 10:19:09.670 [eventLoopGroupProxy-19-1 @call-handler#138] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET) /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST) Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2026-03-10 10:19:09.676 [Test worker @coroutine#118] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42355/api/school/respect/person?since=2026-03-10T06%3A19%3A09.544486710Z&includeRelated=false 2026-03-10 10:19:09.676 [Test worker @coroutine#118] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42355/api/school/respect/person?since=2026-03-10T06%3A19%3A09.544486710Z&includeRelated=false 2026-03-10 10:19:09.676 [Test worker @coroutine#118] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42355/api/school/respect/person?since=2026-03-10T06%3A19%3A09.544486710Z&includeRelated=false 2026-03-10 10:19:09.677 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:42355/api/school/respect/person?since=2026-03-10T06%3A19%3A09.544486710Z&includeRelated=false. 2026-03-10 10:19:11.802 [Test worker @coroutine#144] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-03-10 10:19:11.804 [Test worker @coroutine#144] INFO io.ktor.server.Application - Application started in 0.051 seconds. 2026-03-10 10:19:11.805 [DefaultDispatcher-worker-3 @coroutine#153] INFO io.ktor.server.Application - Responding at http://0.0.0.0:45813 2026-03-10 10:19:11.851 [DefaultDispatcher-worker-5 @coroutine#151] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45813/api/school/respect/person 2026-03-10 10:19:11.852 [DefaultDispatcher-worker-5 @coroutine#151] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@5b4814d3 for http://localhost:45813/api/school/respect/person 2026-03-10 10:19:11.852 [DefaultDispatcher-worker-5 @coroutine#151] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45813/api/school/respect/person 2026-03-10 10:19:11.852 [DefaultDispatcher-worker-5 @coroutine#151] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:45813/api/school/respect/person from class io.ktor.http.content.TextContent 2026-03-10 10:19:11.857 [eventLoopGroupProxy-22-1 @call-handler#163] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person /api/school/respect/person/(method:GET), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:GET) /api/school/respect/person/(method:POST), segment:4 -> SUCCESS @ /api/school/respect/person/(method:POST) Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:POST)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:POST) 2026-03-10 10:19:11.863 [eventLoopGroupProxy-22-1 @call-handler#163] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(kotlin.collections.List) for call /api/school/respect/person 2026-03-10 10:19:11.865 [DefaultDispatcher-worker-4 @call-handler#163] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the POST /api/school/respect/person request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType]. 2026-03-10 10:19:11.867 [DefaultDispatcher-worker-2 @coroutine#151] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45813/api/school/respect/person 2026-03-10 10:19:11.867 [DefaultDispatcher-worker-2 @coroutine#151] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45813/api/school/respect/person 2026-03-10 10:19:11.867 [DefaultDispatcher-worker-2 @coroutine#151] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45813/api/school/respect/person 2026-03-10 10:19:14.006 [Test worker @coroutine#168] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-03-10 10:19:14.007 [Test worker @coroutine#168] INFO io.ktor.server.Application - Application started in 0.05 seconds. 2026-03-10 10:19:14.009 [DefaultDispatcher-worker-2 @coroutine#177] INFO io.ktor.server.Application - Responding at http://0.0.0.0:34309 2026-03-10 10:19:14.010 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34309/api/school/respect/schoolpermissiongrant 2026-03-10 10:19:14.010 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:34309/api/school/respect/schoolpermissiongrant. 2026-03-10 10:19:14.010 [Test worker @coroutine#168] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34309/api/school/respect/schoolpermissiongrant 2026-03-10 10:19:14.013 [eventLoopGroupProxy-25-1 @call-handler#181] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, schoolpermissiongrant] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/person /api/school/respect/schoolpermissiongrant, segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant /api/school/respect/schoolpermissiongrant/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET) Matched routes: "" -> "api" -> "school" -> "respect" -> "schoolpermissiongrant" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET) 2026-03-10 10:19:14.015 [Test worker @coroutine#168] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34309/api/school/respect/schoolpermissiongrant 2026-03-10 10:19:14.016 [Test worker @coroutine#168] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34309/api/school/respect/schoolpermissiongrant 2026-03-10 10:19:14.016 [Test worker @coroutine#168] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34309/api/school/respect/schoolpermissiongrant 2026-03-10 10:19:14.016 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34309/api/school/respect/schoolpermissiongrant. 2026-03-10 10:19:14.079 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34309/api/school/respect/person?includeRelated=false 2026-03-10 10:19:14.079 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:34309/api/school/respect/person?includeRelated=false. 2026-03-10 10:19:14.079 [Test worker @coroutine#168] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34309/api/school/respect/person?includeRelated=false 2026-03-10 10:19:14.080 [eventLoopGroupProxy-25-1 @call-handler#187] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET) /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST) /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2026-03-10 10:19:14.089 [Test worker @coroutine#168] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34309/api/school/respect/person?includeRelated=false 2026-03-10 10:19:14.089 [Test worker @coroutine#168] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34309/api/school/respect/person?includeRelated=false 2026-03-10 10:19:14.089 [Test worker @coroutine#168] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34309/api/school/respect/person?includeRelated=false 2026-03-10 10:19:14.090 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34309/api/school/respect/person?includeRelated=false. 2026-03-10 10:19:16.097 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34309/api/school/respect/person?includeRelated=false 2026-03-10 10:19:16.097 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:34309/api/school/respect/person?includeRelated=false. 2026-03-10 10:19:16.097 [Test worker @coroutine#168] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34309/api/school/respect/person?includeRelated=false 2026-03-10 10:19:16.099 [eventLoopGroupProxy-25-1 @call-handler#194] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET) /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST) /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2026-03-10 10:19:16.103 [Test worker @coroutine#168] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34309/api/school/respect/person?includeRelated=false 2026-03-10 10:19:16.103 [Test worker @coroutine#168] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34309/api/school/respect/person?includeRelated=false 2026-03-10 10:19:16.103 [Test worker @coroutine#168] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34309/api/school/respect/person?includeRelated=false 2026-03-10 10:19:16.104 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34309/api/school/respect/person?includeRelated=false. 2026-03-10 10:19:18.261 [Test worker @coroutine#200] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-03-10 10:19:18.262 [Test worker @coroutine#200] INFO io.ktor.server.Application - Application started in 0.068 seconds. 2026-03-10 10:19:18.263 [DefaultDispatcher-worker-4 @coroutine#209] INFO io.ktor.server.Application - Responding at http://0.0.0.0:43519 2026-03-10 10:19:18.267 [Test worker @coroutine#200] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43519/api/school/respect/person?includeRelated=false 2026-03-10 10:19:18.267 [Test worker @coroutine#200] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:43519/api/school/respect/person?includeRelated=false. 2026-03-10 10:19:18.267 [Test worker @coroutine#200] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43519/api/school/respect/person?includeRelated=false 2026-03-10 10:19:18.275 [eventLoopGroupProxy-28-1 @call-handler#214] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET) /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST) Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2026-03-10 10:19:18.283 [Test worker @coroutine#200] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43519/api/school/respect/person?includeRelated=false 2026-03-10 10:19:18.284 [Test worker @coroutine#200] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43519/api/school/respect/person?includeRelated=false 2026-03-10 10:19:18.284 [Test worker @coroutine#200] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43519/api/school/respect/person?includeRelated=false 2026-03-10 10:19:18.285 [Test worker @coroutine#200] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:43519/api/school/respect/person?includeRelated=false. 2026-03-10 10:19:18.337 [Test worker @coroutine#200] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43519/api/school/respect/person?since=2026-03-10T06%3A19%3A18.275910286Z&includeRelated=false 2026-03-10 10:19:18.337 [Test worker @coroutine#200] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:43519/api/school/respect/person?since=2026-03-10T06%3A19%3A18.275910286Z&includeRelated=false. 2026-03-10 10:19:18.337 [Test worker @coroutine#200] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43519/api/school/respect/person?since=2026-03-10T06%3A19%3A18.275910286Z&includeRelated=false 2026-03-10 10:19:18.339 [eventLoopGroupProxy-28-1 @call-handler#221] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET) /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST) Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2026-03-10 10:19:18.342 [Test worker @coroutine#200] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43519/api/school/respect/person?since=2026-03-10T06%3A19%3A18.275910286Z&includeRelated=false 2026-03-10 10:19:18.342 [Test worker @coroutine#200] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43519/api/school/respect/person?since=2026-03-10T06%3A19%3A18.275910286Z&includeRelated=false 2026-03-10 10:19:18.342 [Test worker @coroutine#200] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43519/api/school/respect/person?since=2026-03-10T06%3A19%3A18.275910286Z&includeRelated=false 2026-03-10 10:19:18.343 [Test worker @coroutine#200] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:43519/api/school/respect/person?since=2026-03-10T06%3A19%3A18.275910286Z&includeRelated=false. 2026-03-10 12:24:32.188 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-03-10 12:24:32.318 [Test worker] INFO io.ktor.server.Application - Application started in 0.295 seconds. 2026-03-10 12:24:32.419 [DefaultDispatcher-worker-2 @coroutine#2] INFO io.ktor.server.Application - Responding at http://0.0.0.0:42881 2026-03-10 12:24:32.731 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42881/resources/index.json 2026-03-10 12:24:32.732 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:42881/resources/index.json. 2026-03-10 12:24:32.732 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42881/resources/index.json 2026-03-10 12:24:32.894 [eventLoopGroupProxy-4-1 @call-handler#12] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json] /, segment:0 -> SUCCESS @ / /(staticContent), segment:0 -> SUCCESS @ /(staticContent) /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...} /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET) Matched routes: "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)" Routing resolve result: SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET) 2026-03-10 12:24:32.944 [DefaultDispatcher-worker-2 @call-handler#12] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 56ms 2026-03-10 12:24:32.948 [DefaultDispatcher-worker-1 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42881/resources/index.json 2026-03-10 12:24:32.950 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42881/resources/index.json 2026-03-10 12:24:32.950 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42881/resources/index.json 2026-03-10 12:24:32.977 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsFeed for http://localhost:42881/resources/index.json. 2026-03-10 12:24:33.009 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42881/resources/index.json 2026-03-10 12:24:33.010 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:42881/resources/index.json. 2026-03-10 12:24:33.010 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42881/resources/index.json 2026-03-10 12:24:33.012 [eventLoopGroupProxy-4-1 @call-handler#22] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json] /, segment:0 -> SUCCESS @ / /(staticContent), segment:0 -> SUCCESS @ /(staticContent) /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...} /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET) Matched routes: "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)" Routing resolve result: SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET) 2026-03-10 12:24:33.014 [eventLoopGroupProxy-4-1 @call-handler#22] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 2ms 2026-03-10 12:24:33.015 [DefaultDispatcher-worker-1 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42881/resources/index.json 2026-03-10 12:24:33.015 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42881/resources/index.json 2026-03-10 12:24:33.015 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42881/resources/index.json 2026-03-10 12:24:35.029 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-03-10 12:24:35.030 [Test worker] INFO io.ktor.server.Application - Application started in 0.001 seconds. 2026-03-10 12:24:35.034 [DefaultDispatcher-worker-1 @coroutine#26] INFO io.ktor.server.Application - Responding at http://0.0.0.0:34059 2026-03-10 12:24:35.118 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34059/resources/index.json 2026-03-10 12:24:35.118 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:34059/resources/index.json. 2026-03-10 12:24:35.118 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34059/resources/index.json 2026-03-10 12:24:35.122 [eventLoopGroupProxy-7-1 @call-handler#35] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json] /, segment:0 -> SUCCESS @ / /(staticContent), segment:0 -> SUCCESS @ /(staticContent) /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...} /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET) Matched routes: "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)" Routing resolve result: SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET) 2026-03-10 12:24:35.123 [eventLoopGroupProxy-7-1 @call-handler#35] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 1ms 2026-03-10 12:24:35.123 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34059/resources/index.json 2026-03-10 12:24:35.124 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34059/resources/index.json 2026-03-10 12:24:35.124 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34059/resources/index.json 2026-03-10 12:24:35.124 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsFeed for http://localhost:34059/resources/index.json. 2026-03-10 12:24:35.129 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34059/resources/index.json 2026-03-10 12:24:35.129 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:34059/resources/index.json. 2026-03-10 12:24:35.129 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34059/resources/index.json 2026-03-10 12:24:35.131 [eventLoopGroupProxy-7-1 @call-handler#45] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json] /, segment:0 -> SUCCESS @ / /(staticContent), segment:0 -> SUCCESS @ /(staticContent) /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...} /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET) Matched routes: "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)" Routing resolve result: SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET) 2026-03-10 12:24:35.132 [eventLoopGroupProxy-7-1 @call-handler#45] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms 2026-03-10 12:24:35.132 [DefaultDispatcher-worker-4 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34059/resources/index.json 2026-03-10 12:24:35.132 [DefaultDispatcher-worker-5 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34059/resources/index.json 2026-03-10 12:24:35.132 [DefaultDispatcher-worker-5 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34059/resources/index.json 2026-03-10 12:24:37.139 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-03-10 12:24:37.140 [Test worker] INFO io.ktor.server.Application - Application started in 0.001 seconds. 2026-03-10 12:24:37.141 [DefaultDispatcher-worker-5 @coroutine#49] INFO io.ktor.server.Application - Responding at http://0.0.0.0:35199 2026-03-10 12:24:37.144 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35199/resources/lesson001.json 2026-03-10 12:24:37.144 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:35199/resources/lesson001.json. 2026-03-10 12:24:37.144 [Test worker @coroutine#52] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35199/resources/lesson001.json 2026-03-10 12:24:37.147 [eventLoopGroupProxy-10-1 @call-handler#56] TRACE io.ktor.server.routing.Routing - Trace for [resources, lesson001.json] /, segment:0 -> SUCCESS @ / /(staticContent), segment:0 -> SUCCESS @ /(staticContent) /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[lesson001.json]] @ /(staticContent)/resources/{...} /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET) Matched routes: "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)" Routing resolve result: SUCCESS; Parameters [static-content-path-parameter=[lesson001.json]] @ /(staticContent)/resources/{...}/(method:GET) 2026-03-10 12:24:37.148 [DefaultDispatcher-worker-4 @call-handler#56] INFO io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 1ms 2026-03-10 12:24:37.149 [DefaultDispatcher-worker-4 @coroutine#52] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35199/resources/lesson001.json 2026-03-10 12:24:37.149 [DefaultDispatcher-worker-5 @coroutine#52] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35199/resources/lesson001.json 2026-03-10 12:24:37.149 [DefaultDispatcher-worker-5 @coroutine#52] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35199/resources/lesson001.json 2026-03-10 12:24:37.169 [DefaultDispatcher-worker-5 @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsPublication for http://localhost:35199/resources/lesson001.json. 2026-03-10 12:24:39.727 [Test worker @coroutine#61] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-03-10 12:24:39.736 [Test worker @coroutine#61] INFO io.ktor.server.Application - Application started in 0.462 seconds. 2026-03-10 12:24:39.739 [DefaultDispatcher-worker-5 @coroutine#70] INFO io.ktor.server.Application - Responding at http://0.0.0.0:39783 2026-03-10 12:24:39.750 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39783/api/school/respect/schoolpermissiongrant 2026-03-10 12:24:39.750 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:39783/api/school/respect/schoolpermissiongrant. 2026-03-10 12:24:39.750 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39783/api/school/respect/schoolpermissiongrant 2026-03-10 12:24:39.757 [eventLoopGroupProxy-13-1 @call-handler#74] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, schoolpermissiongrant] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/person /api/school/respect/schoolpermissiongrant, segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant /api/school/respect/schoolpermissiongrant/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET) Matched routes: "" -> "api" -> "school" -> "respect" -> "schoolpermissiongrant" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET) 2026-03-10 12:24:39.772 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39783/api/school/respect/schoolpermissiongrant 2026-03-10 12:24:39.773 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39783/api/school/respect/schoolpermissiongrant 2026-03-10 12:24:39.773 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39783/api/school/respect/schoolpermissiongrant 2026-03-10 12:24:39.775 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:39783/api/school/respect/schoolpermissiongrant. 2026-03-10 12:24:39.864 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39783/api/school/respect/person?includeRelated=false 2026-03-10 12:24:39.864 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:39783/api/school/respect/person?includeRelated=false. 2026-03-10 12:24:39.865 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39783/api/school/respect/person?includeRelated=false 2026-03-10 12:24:39.866 [eventLoopGroupProxy-13-1 @call-handler#80] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET) /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST) /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2026-03-10 12:24:39.883 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39783/api/school/respect/person?includeRelated=false 2026-03-10 12:24:39.884 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39783/api/school/respect/person?includeRelated=false 2026-03-10 12:24:39.884 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39783/api/school/respect/person?includeRelated=false 2026-03-10 12:24:39.885 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:39783/api/school/respect/person?includeRelated=false. 2026-03-10 12:24:39.891 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39783/api/school/respect/person?includeRelated=false 2026-03-10 12:24:39.891 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:39783/api/school/respect/person?includeRelated=false. 2026-03-10 12:24:39.891 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39783/api/school/respect/person?includeRelated=false 2026-03-10 12:24:39.893 [eventLoopGroupProxy-13-1 @call-handler#86] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET) /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST) /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2026-03-10 12:24:39.895 [DefaultDispatcher-worker-1 @call-handler#86] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the GET /api/school/respect/person?includeRelated=false request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType]. 2026-03-10 12:24:39.895 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39783/api/school/respect/person?includeRelated=false 2026-03-10 12:24:39.896 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39783/api/school/respect/person?includeRelated=false 2026-03-10 12:24:39.896 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39783/api/school/respect/person?includeRelated=false 2026-03-10 12:24:42.015 [Test worker @coroutine#90] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-03-10 12:24:42.016 [Test worker @coroutine#90] INFO io.ktor.server.Application - Application started in 0.049 seconds. 2026-03-10 12:24:42.018 [DefaultDispatcher-worker-5 @coroutine#99] INFO io.ktor.server.Application - Responding at http://0.0.0.0:40689 2026-03-10 12:24:42.019 [Test worker @coroutine#90] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40689/api/school/respect/schoolpermissiongrant 2026-03-10 12:24:42.019 [Test worker @coroutine#90] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:40689/api/school/respect/schoolpermissiongrant. 2026-03-10 12:24:42.019 [Test worker @coroutine#90] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40689/api/school/respect/schoolpermissiongrant 2026-03-10 12:24:42.021 [eventLoopGroupProxy-16-1 @call-handler#103] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, schoolpermissiongrant] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/person /api/school/respect/schoolpermissiongrant, segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant /api/school/respect/schoolpermissiongrant/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET) Matched routes: "" -> "api" -> "school" -> "respect" -> "schoolpermissiongrant" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET) 2026-03-10 12:24:42.023 [Test worker @coroutine#90] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40689/api/school/respect/schoolpermissiongrant 2026-03-10 12:24:42.024 [Test worker @coroutine#90] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40689/api/school/respect/schoolpermissiongrant 2026-03-10 12:24:42.024 [Test worker @coroutine#90] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40689/api/school/respect/schoolpermissiongrant 2026-03-10 12:24:42.024 [Test worker @coroutine#90] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:40689/api/school/respect/schoolpermissiongrant. 2026-03-10 12:24:42.071 [DefaultDispatcher-worker-5 @coroutine#109] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40689/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-03-10 12:24:42.071 [DefaultDispatcher-worker-5 @coroutine#109] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:40689/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100. 2026-03-10 12:24:42.071 [DefaultDispatcher-worker-5 @coroutine#109] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40689/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-03-10 12:24:42.072 [eventLoopGroupProxy-16-1 @call-handler#113] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET) /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST) /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2026-03-10 12:24:42.075 [DefaultDispatcher-worker-1 @coroutine#109] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40689/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-03-10 12:24:42.075 [DefaultDispatcher-worker-1 @coroutine#109] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40689/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-03-10 12:24:42.075 [DefaultDispatcher-worker-1 @coroutine#109] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40689/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-03-10 12:24:42.076 [DefaultDispatcher-worker-1 @coroutine#109] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:40689/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100. 2026-03-10 12:24:44.187 [Test worker @coroutine#118] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-03-10 12:24:44.188 [Test worker @coroutine#118] INFO io.ktor.server.Application - Application started in 0.039 seconds. 2026-03-10 12:24:44.189 [DefaultDispatcher-worker-4 @coroutine#127] INFO io.ktor.server.Application - Responding at http://0.0.0.0:35527 2026-03-10 12:24:44.192 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35527/api/school/respect/person?includeRelated=false 2026-03-10 12:24:44.192 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:35527/api/school/respect/person?includeRelated=false. 2026-03-10 12:24:44.192 [Test worker @coroutine#118] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35527/api/school/respect/person?includeRelated=false 2026-03-10 12:24:44.195 [eventLoopGroupProxy-19-1 @call-handler#132] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET) /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST) Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2026-03-10 12:24:44.200 [Test worker @coroutine#118] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35527/api/school/respect/person?includeRelated=false 2026-03-10 12:24:44.200 [Test worker @coroutine#118] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35527/api/school/respect/person?includeRelated=false 2026-03-10 12:24:44.200 [Test worker @coroutine#118] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35527/api/school/respect/person?includeRelated=false 2026-03-10 12:24:44.201 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:35527/api/school/respect/person?includeRelated=false. 2026-03-10 12:24:44.269 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35527/api/school/respect/person?since=2026-03-10T08%3A24%3A44.196077354Z&includeRelated=false 2026-03-10 12:24:44.269 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:35527/api/school/respect/person?since=2026-03-10T08%3A24%3A44.196077354Z&includeRelated=false. 2026-03-10 12:24:44.269 [Test worker @coroutine#118] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35527/api/school/respect/person?since=2026-03-10T08%3A24%3A44.196077354Z&includeRelated=false 2026-03-10 12:24:44.271 [eventLoopGroupProxy-19-1 @call-handler#138] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET) /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST) Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2026-03-10 12:24:44.274 [Test worker @coroutine#118] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35527/api/school/respect/person?since=2026-03-10T08%3A24%3A44.196077354Z&includeRelated=false 2026-03-10 12:24:44.275 [Test worker @coroutine#118] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35527/api/school/respect/person?since=2026-03-10T08%3A24%3A44.196077354Z&includeRelated=false 2026-03-10 12:24:44.275 [Test worker @coroutine#118] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35527/api/school/respect/person?since=2026-03-10T08%3A24%3A44.196077354Z&includeRelated=false 2026-03-10 12:24:44.276 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:35527/api/school/respect/person?since=2026-03-10T08%3A24%3A44.196077354Z&includeRelated=false. 2026-03-10 12:24:46.397 [Test worker @coroutine#144] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-03-10 12:24:46.398 [Test worker @coroutine#144] INFO io.ktor.server.Application - Application started in 0.039 seconds. 2026-03-10 12:24:46.399 [DefaultDispatcher-worker-3 @coroutine#153] INFO io.ktor.server.Application - Responding at http://0.0.0.0:34827 2026-03-10 12:24:46.442 [DefaultDispatcher-worker-5 @coroutine#151] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34827/api/school/respect/person 2026-03-10 12:24:46.442 [DefaultDispatcher-worker-5 @coroutine#151] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@763e1f83 for http://localhost:34827/api/school/respect/person 2026-03-10 12:24:46.442 [DefaultDispatcher-worker-5 @coroutine#151] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34827/api/school/respect/person 2026-03-10 12:24:46.442 [DefaultDispatcher-worker-5 @coroutine#151] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:34827/api/school/respect/person from class io.ktor.http.content.TextContent 2026-03-10 12:24:46.445 [eventLoopGroupProxy-22-1 @call-handler#163] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person /api/school/respect/person/(method:GET), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:GET) /api/school/respect/person/(method:POST), segment:4 -> SUCCESS @ /api/school/respect/person/(method:POST) Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:POST)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:POST) 2026-03-10 12:24:46.451 [eventLoopGroupProxy-22-1 @call-handler#163] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(kotlin.collections.List) for call /api/school/respect/person 2026-03-10 12:24:46.453 [DefaultDispatcher-worker-5 @call-handler#163] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the POST /api/school/respect/person request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType]. 2026-03-10 12:24:46.453 [DefaultDispatcher-worker-3 @coroutine#151] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34827/api/school/respect/person 2026-03-10 12:24:46.453 [DefaultDispatcher-worker-3 @coroutine#151] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34827/api/school/respect/person 2026-03-10 12:24:46.453 [DefaultDispatcher-worker-3 @coroutine#151] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34827/api/school/respect/person 2026-03-10 12:24:48.567 [Test worker @coroutine#168] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-03-10 12:24:48.568 [Test worker @coroutine#168] INFO io.ktor.server.Application - Application started in 0.045 seconds. 2026-03-10 12:24:48.569 [DefaultDispatcher-worker-1 @coroutine#177] INFO io.ktor.server.Application - Responding at http://0.0.0.0:45149 2026-03-10 12:24:48.569 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45149/api/school/respect/schoolpermissiongrant 2026-03-10 12:24:48.569 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45149/api/school/respect/schoolpermissiongrant. 2026-03-10 12:24:48.569 [Test worker @coroutine#168] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45149/api/school/respect/schoolpermissiongrant 2026-03-10 12:24:48.572 [eventLoopGroupProxy-25-1 @call-handler#181] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, schoolpermissiongrant] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/person /api/school/respect/schoolpermissiongrant, segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant /api/school/respect/schoolpermissiongrant/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET) Matched routes: "" -> "api" -> "school" -> "respect" -> "schoolpermissiongrant" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET) 2026-03-10 12:24:48.573 [Test worker @coroutine#168] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45149/api/school/respect/schoolpermissiongrant 2026-03-10 12:24:48.574 [Test worker @coroutine#168] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45149/api/school/respect/schoolpermissiongrant 2026-03-10 12:24:48.574 [Test worker @coroutine#168] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45149/api/school/respect/schoolpermissiongrant 2026-03-10 12:24:48.574 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:45149/api/school/respect/schoolpermissiongrant. 2026-03-10 12:24:48.614 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45149/api/school/respect/person?includeRelated=false 2026-03-10 12:24:48.614 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45149/api/school/respect/person?includeRelated=false. 2026-03-10 12:24:48.614 [Test worker @coroutine#168] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45149/api/school/respect/person?includeRelated=false 2026-03-10 12:24:48.615 [eventLoopGroupProxy-25-1 @call-handler#187] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET) /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST) /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2026-03-10 12:24:48.620 [Test worker @coroutine#168] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45149/api/school/respect/person?includeRelated=false 2026-03-10 12:24:48.620 [Test worker @coroutine#168] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45149/api/school/respect/person?includeRelated=false 2026-03-10 12:24:48.620 [Test worker @coroutine#168] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45149/api/school/respect/person?includeRelated=false 2026-03-10 12:24:48.621 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:45149/api/school/respect/person?includeRelated=false. 2026-03-10 12:24:50.626 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45149/api/school/respect/person?includeRelated=false 2026-03-10 12:24:50.626 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45149/api/school/respect/person?includeRelated=false. 2026-03-10 12:24:50.627 [Test worker @coroutine#168] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45149/api/school/respect/person?includeRelated=false 2026-03-10 12:24:50.628 [eventLoopGroupProxy-25-1 @call-handler#194] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET) /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST) /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2026-03-10 12:24:50.631 [Test worker @coroutine#168] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45149/api/school/respect/person?includeRelated=false 2026-03-10 12:24:50.631 [Test worker @coroutine#168] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45149/api/school/respect/person?includeRelated=false 2026-03-10 12:24:50.631 [Test worker @coroutine#168] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45149/api/school/respect/person?includeRelated=false 2026-03-10 12:24:50.632 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:45149/api/school/respect/person?includeRelated=false. 2026-03-10 12:24:52.746 [Test worker @coroutine#200] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-03-10 12:24:52.746 [Test worker @coroutine#200] INFO io.ktor.server.Application - Application started in 0.037 seconds. 2026-03-10 12:24:52.747 [DefaultDispatcher-worker-2 @coroutine#209] INFO io.ktor.server.Application - Responding at http://0.0.0.0:35429 2026-03-10 12:24:52.749 [Test worker @coroutine#200] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35429/api/school/respect/person?includeRelated=false 2026-03-10 12:24:52.750 [Test worker @coroutine#200] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:35429/api/school/respect/person?includeRelated=false. 2026-03-10 12:24:52.750 [Test worker @coroutine#200] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35429/api/school/respect/person?includeRelated=false 2026-03-10 12:24:52.752 [eventLoopGroupProxy-28-1 @call-handler#214] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET) /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST) Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2026-03-10 12:24:52.755 [Test worker @coroutine#200] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35429/api/school/respect/person?includeRelated=false 2026-03-10 12:24:52.755 [Test worker @coroutine#200] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35429/api/school/respect/person?includeRelated=false 2026-03-10 12:24:52.755 [Test worker @coroutine#200] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35429/api/school/respect/person?includeRelated=false 2026-03-10 12:24:52.756 [Test worker @coroutine#200] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:35429/api/school/respect/person?includeRelated=false. 2026-03-10 12:24:52.797 [Test worker @coroutine#200] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35429/api/school/respect/person?since=2026-03-10T08%3A24%3A52.752439344Z&includeRelated=false 2026-03-10 12:24:52.797 [Test worker @coroutine#200] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:35429/api/school/respect/person?since=2026-03-10T08%3A24%3A52.752439344Z&includeRelated=false. 2026-03-10 12:24:52.797 [Test worker @coroutine#200] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35429/api/school/respect/person?since=2026-03-10T08%3A24%3A52.752439344Z&includeRelated=false 2026-03-10 12:24:52.798 [eventLoopGroupProxy-28-1 @call-handler#221] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET) /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST) Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2026-03-10 12:24:52.800 [Test worker @coroutine#200] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35429/api/school/respect/person?since=2026-03-10T08%3A24%3A52.752439344Z&includeRelated=false 2026-03-10 12:24:52.800 [Test worker @coroutine#200] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35429/api/school/respect/person?since=2026-03-10T08%3A24%3A52.752439344Z&includeRelated=false 2026-03-10 12:24:52.800 [Test worker @coroutine#200] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35429/api/school/respect/person?since=2026-03-10T08%3A24%3A52.752439344Z&includeRelated=false 2026-03-10 12:24:52.801 [Test worker @coroutine#200] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:35429/api/school/respect/person?since=2026-03-10T08%3A24%3A52.752439344Z&includeRelated=false. 2026-03-10 13:41:53.690 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-03-10 13:41:53.761 [Test worker] INFO io.ktor.server.Application - Application started in 0.214 seconds. 2026-03-10 13:41:53.829 [DefaultDispatcher-worker-2 @coroutine#2] INFO io.ktor.server.Application - Responding at http://0.0.0.0:43545 2026-03-10 13:41:54.068 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43545/resources/index.json 2026-03-10 13:41:54.069 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:43545/resources/index.json. 2026-03-10 13:41:54.069 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43545/resources/index.json 2026-03-10 13:41:54.173 [eventLoopGroupProxy-4-1 @call-handler#12] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json] /, segment:0 -> SUCCESS @ / /(staticContent), segment:0 -> SUCCESS @ /(staticContent) /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...} /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET) Matched routes: "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)" Routing resolve result: SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET) 2026-03-10 13:41:54.209 [eventLoopGroupProxy-4-1 @call-handler#12] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 39ms 2026-03-10 13:41:54.212 [DefaultDispatcher-worker-1 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43545/resources/index.json 2026-03-10 13:41:54.213 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43545/resources/index.json 2026-03-10 13:41:54.214 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43545/resources/index.json 2026-03-10 13:41:54.233 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsFeed for http://localhost:43545/resources/index.json. 2026-03-10 13:41:54.266 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43545/resources/index.json 2026-03-10 13:41:54.266 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:43545/resources/index.json. 2026-03-10 13:41:54.266 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43545/resources/index.json 2026-03-10 13:41:54.268 [eventLoopGroupProxy-4-1 @call-handler#22] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json] /, segment:0 -> SUCCESS @ / /(staticContent), segment:0 -> SUCCESS @ /(staticContent) /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...} /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET) Matched routes: "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)" Routing resolve result: SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET) 2026-03-10 13:41:54.269 [eventLoopGroupProxy-4-1 @call-handler#22] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms 2026-03-10 13:41:54.270 [DefaultDispatcher-worker-3 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43545/resources/index.json 2026-03-10 13:41:54.271 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43545/resources/index.json 2026-03-10 13:41:54.271 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43545/resources/index.json 2026-03-10 13:41:56.283 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-03-10 13:41:56.283 [Test worker] INFO io.ktor.server.Application - Application started in 0.0 seconds. 2026-03-10 13:41:56.287 [DefaultDispatcher-worker-3 @coroutine#26] INFO io.ktor.server.Application - Responding at http://0.0.0.0:35647 2026-03-10 13:41:56.349 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35647/resources/index.json 2026-03-10 13:41:56.349 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:35647/resources/index.json. 2026-03-10 13:41:56.349 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35647/resources/index.json 2026-03-10 13:41:56.352 [eventLoopGroupProxy-7-1 @call-handler#35] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json] /, segment:0 -> SUCCESS @ / /(staticContent), segment:0 -> SUCCESS @ /(staticContent) /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...} /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET) Matched routes: "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)" Routing resolve result: SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET) 2026-03-10 13:41:56.353 [DefaultDispatcher-worker-3 @call-handler#35] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 1ms 2026-03-10 13:41:56.354 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35647/resources/index.json 2026-03-10 13:41:56.354 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35647/resources/index.json 2026-03-10 13:41:56.354 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35647/resources/index.json 2026-03-10 13:41:56.355 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsFeed for http://localhost:35647/resources/index.json. 2026-03-10 13:41:56.359 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35647/resources/index.json 2026-03-10 13:41:56.359 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:35647/resources/index.json. 2026-03-10 13:41:56.359 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35647/resources/index.json 2026-03-10 13:41:56.360 [eventLoopGroupProxy-7-1 @call-handler#45] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json] /, segment:0 -> SUCCESS @ / /(staticContent), segment:0 -> SUCCESS @ /(staticContent) /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...} /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET) Matched routes: "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)" Routing resolve result: SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET) 2026-03-10 13:41:56.360 [eventLoopGroupProxy-7-1 @call-handler#45] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 0ms 2026-03-10 13:41:56.361 [DefaultDispatcher-worker-2 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35647/resources/index.json 2026-03-10 13:41:56.361 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35647/resources/index.json 2026-03-10 13:41:56.361 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35647/resources/index.json 2026-03-10 13:41:58.368 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-03-10 13:41:58.368 [Test worker] INFO io.ktor.server.Application - Application started in 0.0 seconds. 2026-03-10 13:41:58.369 [DefaultDispatcher-worker-2 @coroutine#49] INFO io.ktor.server.Application - Responding at http://0.0.0.0:44539 2026-03-10 13:41:58.373 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44539/resources/lesson001.json 2026-03-10 13:41:58.373 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:44539/resources/lesson001.json. 2026-03-10 13:41:58.373 [Test worker @coroutine#52] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44539/resources/lesson001.json 2026-03-10 13:41:58.375 [eventLoopGroupProxy-10-1 @call-handler#56] TRACE io.ktor.server.routing.Routing - Trace for [resources, lesson001.json] /, segment:0 -> SUCCESS @ / /(staticContent), segment:0 -> SUCCESS @ /(staticContent) /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[lesson001.json]] @ /(staticContent)/resources/{...} /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET) Matched routes: "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)" Routing resolve result: SUCCESS; Parameters [static-content-path-parameter=[lesson001.json]] @ /(staticContent)/resources/{...}/(method:GET) 2026-03-10 13:41:58.376 [DefaultDispatcher-worker-3 @call-handler#56] INFO io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 1ms 2026-03-10 13:41:58.377 [DefaultDispatcher-worker-2 @coroutine#52] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44539/resources/lesson001.json 2026-03-10 13:41:58.377 [DefaultDispatcher-worker-1 @coroutine#52] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44539/resources/lesson001.json 2026-03-10 13:41:58.377 [DefaultDispatcher-worker-1 @coroutine#52] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44539/resources/lesson001.json 2026-03-10 13:41:58.398 [DefaultDispatcher-worker-1 @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsPublication for http://localhost:44539/resources/lesson001.json. 2026-03-10 13:42:00.956 [Test worker @coroutine#61] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-03-10 13:42:00.965 [Test worker @coroutine#61] INFO io.ktor.server.Application - Application started in 0.464 seconds. 2026-03-10 13:42:00.968 [DefaultDispatcher-worker-1 @coroutine#70] INFO io.ktor.server.Application - Responding at http://0.0.0.0:45457 2026-03-10 13:42:00.979 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45457/api/school/respect/schoolpermissiongrant 2026-03-10 13:42:00.979 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45457/api/school/respect/schoolpermissiongrant. 2026-03-10 13:42:00.979 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45457/api/school/respect/schoolpermissiongrant 2026-03-10 13:42:00.986 [eventLoopGroupProxy-13-1 @call-handler#74] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, schoolpermissiongrant] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/person /api/school/respect/schoolpermissiongrant, segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant /api/school/respect/schoolpermissiongrant/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET) Matched routes: "" -> "api" -> "school" -> "respect" -> "schoolpermissiongrant" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET) 2026-03-10 13:42:01.004 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45457/api/school/respect/schoolpermissiongrant 2026-03-10 13:42:01.005 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45457/api/school/respect/schoolpermissiongrant 2026-03-10 13:42:01.005 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45457/api/school/respect/schoolpermissiongrant 2026-03-10 13:42:01.007 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:45457/api/school/respect/schoolpermissiongrant. 2026-03-10 13:42:01.090 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45457/api/school/respect/person?includeRelated=false 2026-03-10 13:42:01.090 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45457/api/school/respect/person?includeRelated=false. 2026-03-10 13:42:01.090 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45457/api/school/respect/person?includeRelated=false 2026-03-10 13:42:01.092 [eventLoopGroupProxy-13-1 @call-handler#80] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET) /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST) /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2026-03-10 13:42:01.112 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45457/api/school/respect/person?includeRelated=false 2026-03-10 13:42:01.112 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45457/api/school/respect/person?includeRelated=false 2026-03-10 13:42:01.112 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45457/api/school/respect/person?includeRelated=false 2026-03-10 13:42:01.114 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:45457/api/school/respect/person?includeRelated=false. 2026-03-10 13:42:01.121 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45457/api/school/respect/person?includeRelated=false 2026-03-10 13:42:01.121 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45457/api/school/respect/person?includeRelated=false. 2026-03-10 13:42:01.121 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45457/api/school/respect/person?includeRelated=false 2026-03-10 13:42:01.123 [eventLoopGroupProxy-13-1 @call-handler#86] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET) /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST) /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2026-03-10 13:42:01.126 [DefaultDispatcher-worker-3 @call-handler#86] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the GET /api/school/respect/person?includeRelated=false request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType]. 2026-03-10 13:42:01.127 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45457/api/school/respect/person?includeRelated=false 2026-03-10 13:42:01.127 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45457/api/school/respect/person?includeRelated=false 2026-03-10 13:42:01.127 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45457/api/school/respect/person?includeRelated=false 2026-03-10 13:42:03.259 [Test worker @coroutine#90] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-03-10 13:42:03.260 [Test worker @coroutine#90] INFO io.ktor.server.Application - Application started in 0.04 seconds. 2026-03-10 13:42:03.262 [DefaultDispatcher-worker-4 @coroutine#99] INFO io.ktor.server.Application - Responding at http://0.0.0.0:41305 2026-03-10 13:42:03.263 [Test worker @coroutine#90] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41305/api/school/respect/schoolpermissiongrant 2026-03-10 13:42:03.263 [Test worker @coroutine#90] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41305/api/school/respect/schoolpermissiongrant. 2026-03-10 13:42:03.263 [Test worker @coroutine#90] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41305/api/school/respect/schoolpermissiongrant 2026-03-10 13:42:03.266 [eventLoopGroupProxy-16-1 @call-handler#103] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, schoolpermissiongrant] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/person /api/school/respect/schoolpermissiongrant, segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant /api/school/respect/schoolpermissiongrant/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET) Matched routes: "" -> "api" -> "school" -> "respect" -> "schoolpermissiongrant" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET) 2026-03-10 13:42:03.268 [Test worker @coroutine#90] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41305/api/school/respect/schoolpermissiongrant 2026-03-10 13:42:03.268 [Test worker @coroutine#90] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41305/api/school/respect/schoolpermissiongrant 2026-03-10 13:42:03.268 [Test worker @coroutine#90] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41305/api/school/respect/schoolpermissiongrant 2026-03-10 13:42:03.268 [Test worker @coroutine#90] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41305/api/school/respect/schoolpermissiongrant. 2026-03-10 13:42:03.315 [DefaultDispatcher-worker-4 @coroutine#109] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41305/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-03-10 13:42:03.315 [DefaultDispatcher-worker-4 @coroutine#109] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41305/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100. 2026-03-10 13:42:03.315 [DefaultDispatcher-worker-4 @coroutine#109] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41305/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-03-10 13:42:03.316 [eventLoopGroupProxy-16-1 @call-handler#113] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET) /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST) /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2026-03-10 13:42:03.320 [DefaultDispatcher-worker-1 @coroutine#109] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41305/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-03-10 13:42:03.320 [DefaultDispatcher-worker-1 @coroutine#109] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41305/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-03-10 13:42:03.320 [DefaultDispatcher-worker-1 @coroutine#109] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41305/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-03-10 13:42:03.320 [DefaultDispatcher-worker-1 @coroutine#109] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41305/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100. 2026-03-10 13:42:05.432 [Test worker @coroutine#118] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-03-10 13:42:05.433 [Test worker @coroutine#118] INFO io.ktor.server.Application - Application started in 0.039 seconds. 2026-03-10 13:42:05.434 [DefaultDispatcher-worker-1 @coroutine#127] INFO io.ktor.server.Application - Responding at http://0.0.0.0:40389 2026-03-10 13:42:05.437 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40389/api/school/respect/person?includeRelated=false 2026-03-10 13:42:05.437 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:40389/api/school/respect/person?includeRelated=false. 2026-03-10 13:42:05.437 [Test worker @coroutine#118] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40389/api/school/respect/person?includeRelated=false 2026-03-10 13:42:05.439 [eventLoopGroupProxy-19-1 @call-handler#132] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET) /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST) Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2026-03-10 13:42:05.443 [Test worker @coroutine#118] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40389/api/school/respect/person?includeRelated=false 2026-03-10 13:42:05.443 [Test worker @coroutine#118] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40389/api/school/respect/person?includeRelated=false 2026-03-10 13:42:05.443 [Test worker @coroutine#118] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40389/api/school/respect/person?includeRelated=false 2026-03-10 13:42:05.444 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:40389/api/school/respect/person?includeRelated=false. 2026-03-10 13:42:05.500 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40389/api/school/respect/person?since=2026-03-10T09%3A42%3A05.440182812Z&includeRelated=false 2026-03-10 13:42:05.500 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:40389/api/school/respect/person?since=2026-03-10T09%3A42%3A05.440182812Z&includeRelated=false. 2026-03-10 13:42:05.500 [Test worker @coroutine#118] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40389/api/school/respect/person?since=2026-03-10T09%3A42%3A05.440182812Z&includeRelated=false 2026-03-10 13:42:05.502 [eventLoopGroupProxy-19-1 @call-handler#138] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET) /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST) Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2026-03-10 13:42:05.505 [Test worker @coroutine#118] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40389/api/school/respect/person?since=2026-03-10T09%3A42%3A05.440182812Z&includeRelated=false 2026-03-10 13:42:05.505 [Test worker @coroutine#118] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40389/api/school/respect/person?since=2026-03-10T09%3A42%3A05.440182812Z&includeRelated=false 2026-03-10 13:42:05.505 [Test worker @coroutine#118] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40389/api/school/respect/person?since=2026-03-10T09%3A42%3A05.440182812Z&includeRelated=false 2026-03-10 13:42:05.505 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:40389/api/school/respect/person?since=2026-03-10T09%3A42%3A05.440182812Z&includeRelated=false. 2026-03-10 13:42:07.616 [Test worker @coroutine#144] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-03-10 13:42:07.617 [Test worker @coroutine#144] INFO io.ktor.server.Application - Application started in 0.04 seconds. 2026-03-10 13:42:07.618 [DefaultDispatcher-worker-4 @coroutine#153] INFO io.ktor.server.Application - Responding at http://0.0.0.0:33487 2026-03-10 13:42:07.661 [DefaultDispatcher-worker-5 @coroutine#151] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33487/api/school/respect/person 2026-03-10 13:42:07.661 [DefaultDispatcher-worker-5 @coroutine#151] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@2180fee1 for http://localhost:33487/api/school/respect/person 2026-03-10 13:42:07.661 [DefaultDispatcher-worker-5 @coroutine#151] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33487/api/school/respect/person 2026-03-10 13:42:07.661 [DefaultDispatcher-worker-5 @coroutine#151] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:33487/api/school/respect/person from class io.ktor.http.content.TextContent 2026-03-10 13:42:07.664 [eventLoopGroupProxy-22-1 @call-handler#163] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person /api/school/respect/person/(method:GET), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:GET) /api/school/respect/person/(method:POST), segment:4 -> SUCCESS @ /api/school/respect/person/(method:POST) Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:POST)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:POST) 2026-03-10 13:42:07.670 [eventLoopGroupProxy-22-1 @call-handler#163] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(kotlin.collections.List) for call /api/school/respect/person 2026-03-10 13:42:07.672 [DefaultDispatcher-worker-5 @call-handler#163] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the POST /api/school/respect/person request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType]. 2026-03-10 13:42:07.673 [DefaultDispatcher-worker-2 @coroutine#151] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33487/api/school/respect/person 2026-03-10 13:42:07.673 [DefaultDispatcher-worker-2 @coroutine#151] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33487/api/school/respect/person 2026-03-10 13:42:07.673 [DefaultDispatcher-worker-2 @coroutine#151] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33487/api/school/respect/person 2026-03-10 13:42:09.784 [Test worker @coroutine#168] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-03-10 13:42:09.785 [Test worker @coroutine#168] INFO io.ktor.server.Application - Application started in 0.046 seconds. 2026-03-10 13:42:09.786 [DefaultDispatcher-worker-4 @coroutine#177] INFO io.ktor.server.Application - Responding at http://0.0.0.0:41601 2026-03-10 13:42:09.787 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41601/api/school/respect/schoolpermissiongrant 2026-03-10 13:42:09.787 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41601/api/school/respect/schoolpermissiongrant. 2026-03-10 13:42:09.787 [Test worker @coroutine#168] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41601/api/school/respect/schoolpermissiongrant 2026-03-10 13:42:09.789 [eventLoopGroupProxy-25-1 @call-handler#181] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, schoolpermissiongrant] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/person /api/school/respect/schoolpermissiongrant, segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant /api/school/respect/schoolpermissiongrant/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET) Matched routes: "" -> "api" -> "school" -> "respect" -> "schoolpermissiongrant" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET) 2026-03-10 13:42:09.791 [Test worker @coroutine#168] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41601/api/school/respect/schoolpermissiongrant 2026-03-10 13:42:09.791 [Test worker @coroutine#168] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41601/api/school/respect/schoolpermissiongrant 2026-03-10 13:42:09.791 [Test worker @coroutine#168] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41601/api/school/respect/schoolpermissiongrant 2026-03-10 13:42:09.792 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41601/api/school/respect/schoolpermissiongrant. 2026-03-10 13:42:09.837 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41601/api/school/respect/person?includeRelated=false 2026-03-10 13:42:09.837 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41601/api/school/respect/person?includeRelated=false. 2026-03-10 13:42:09.837 [Test worker @coroutine#168] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41601/api/school/respect/person?includeRelated=false 2026-03-10 13:42:09.838 [eventLoopGroupProxy-25-1 @call-handler#187] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET) /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST) /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2026-03-10 13:42:09.843 [Test worker @coroutine#168] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41601/api/school/respect/person?includeRelated=false 2026-03-10 13:42:09.844 [Test worker @coroutine#168] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41601/api/school/respect/person?includeRelated=false 2026-03-10 13:42:09.844 [Test worker @coroutine#168] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41601/api/school/respect/person?includeRelated=false 2026-03-10 13:42:09.844 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41601/api/school/respect/person?includeRelated=false. 2026-03-10 13:42:11.850 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41601/api/school/respect/person?includeRelated=false 2026-03-10 13:42:11.850 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41601/api/school/respect/person?includeRelated=false. 2026-03-10 13:42:11.850 [Test worker @coroutine#168] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41601/api/school/respect/person?includeRelated=false 2026-03-10 13:42:11.851 [eventLoopGroupProxy-25-1 @call-handler#194] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET) /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST) /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2026-03-10 13:42:11.854 [Test worker @coroutine#168] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41601/api/school/respect/person?includeRelated=false 2026-03-10 13:42:11.854 [Test worker @coroutine#168] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41601/api/school/respect/person?includeRelated=false 2026-03-10 13:42:11.854 [Test worker @coroutine#168] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41601/api/school/respect/person?includeRelated=false 2026-03-10 13:42:11.855 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41601/api/school/respect/person?includeRelated=false. 2026-03-10 13:42:13.976 [Test worker @coroutine#200] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-03-10 13:42:13.977 [Test worker @coroutine#200] INFO io.ktor.server.Application - Application started in 0.039 seconds. 2026-03-10 13:42:13.978 [DefaultDispatcher-worker-5 @coroutine#209] INFO io.ktor.server.Application - Responding at http://0.0.0.0:33359 2026-03-10 13:42:13.980 [Test worker @coroutine#200] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33359/api/school/respect/person?includeRelated=false 2026-03-10 13:42:13.980 [Test worker @coroutine#200] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:33359/api/school/respect/person?includeRelated=false. 2026-03-10 13:42:13.980 [Test worker @coroutine#200] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33359/api/school/respect/person?includeRelated=false 2026-03-10 13:42:13.982 [eventLoopGroupProxy-28-1 @call-handler#214] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET) /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST) Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2026-03-10 13:42:13.986 [Test worker @coroutine#200] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33359/api/school/respect/person?includeRelated=false 2026-03-10 13:42:13.986 [Test worker @coroutine#200] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33359/api/school/respect/person?includeRelated=false 2026-03-10 13:42:13.986 [Test worker @coroutine#200] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33359/api/school/respect/person?includeRelated=false 2026-03-10 13:42:13.987 [Test worker @coroutine#200] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:33359/api/school/respect/person?includeRelated=false. 2026-03-10 13:42:14.038 [Test worker @coroutine#200] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33359/api/school/respect/person?since=2026-03-10T09%3A42%3A13.983157796Z&includeRelated=false 2026-03-10 13:42:14.038 [Test worker @coroutine#200] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:33359/api/school/respect/person?since=2026-03-10T09%3A42%3A13.983157796Z&includeRelated=false. 2026-03-10 13:42:14.038 [Test worker @coroutine#200] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33359/api/school/respect/person?since=2026-03-10T09%3A42%3A13.983157796Z&includeRelated=false 2026-03-10 13:42:14.039 [eventLoopGroupProxy-28-1 @call-handler#221] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET) /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST) Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2026-03-10 13:42:14.042 [Test worker @coroutine#200] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33359/api/school/respect/person?since=2026-03-10T09%3A42%3A13.983157796Z&includeRelated=false 2026-03-10 13:42:14.042 [Test worker @coroutine#200] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33359/api/school/respect/person?since=2026-03-10T09%3A42%3A13.983157796Z&includeRelated=false 2026-03-10 13:42:14.042 [Test worker @coroutine#200] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33359/api/school/respect/person?since=2026-03-10T09%3A42%3A13.983157796Z&includeRelated=false 2026-03-10 13:42:14.043 [Test worker @coroutine#200] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:33359/api/school/respect/person?since=2026-03-10T09%3A42%3A13.983157796Z&includeRelated=false.