2026-04-28 16:07:30.434 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-04-28 16:07:30.575 [Test worker] INFO io.ktor.server.Application - Application started in 0.317 seconds. 2026-04-28 16:07:30.703 [DefaultDispatcher-worker-1 @coroutine#2] INFO io.ktor.server.Application - Responding at http://0.0.0.0:33175 2026-04-28 16:07:31.779 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33175/resources/index.json 2026-04-28 16:07:31.780 [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:33175/resources/index.json. 2026-04-28 16:07:31.780 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33175/resources/index.json 2026-04-28 16:07:32.215 [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-04-28 16:07:32.284 [DefaultDispatcher-worker-4 @call-handler#12] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 78ms 2026-04-28 16:07:32.288 [DefaultDispatcher-worker-2 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33175/resources/index.json 2026-04-28 16:07:32.291 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33175/resources/index.json 2026-04-28 16:07:32.291 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33175/resources/index.json 2026-04-28 16:07:32.324 [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:33175/resources/index.json. 2026-04-28 16:07:32.399 [DefaultDispatcher-worker-9 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33175/resources/index.json 2026-04-28 16:07:32.402 [DefaultDispatcher-worker-9 @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:33175/resources/index.json. 2026-04-28 16:07:32.402 [DefaultDispatcher-worker-9 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33175/resources/index.json 2026-04-28 16:07:32.407 [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-04-28 16:07:32.417 [eventLoopGroupProxy-4-1 @call-handler#22] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 10ms 2026-04-28 16:07:32.419 [DefaultDispatcher-worker-9 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33175/resources/index.json 2026-04-28 16:07:32.419 [DefaultDispatcher-worker-9 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33175/resources/index.json 2026-04-28 16:07:32.419 [DefaultDispatcher-worker-9 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33175/resources/index.json 2026-04-28 16:07:34.454 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-04-28 16:07:34.455 [Test worker] INFO io.ktor.server.Application - Application started in 0.001 seconds. 2026-04-28 16:07:34.457 [DefaultDispatcher-worker-9 @coroutine#26] INFO io.ktor.server.Application - Responding at http://0.0.0.0:44861 2026-04-28 16:07:34.529 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44861/resources/index.json 2026-04-28 16:07:34.529 [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:44861/resources/index.json. 2026-04-28 16:07:34.529 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44861/resources/index.json 2026-04-28 16:07:34.533 [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-04-28 16:07:34.534 [DefaultDispatcher-worker-9 @call-handler#35] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 1ms 2026-04-28 16:07:34.535 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44861/resources/index.json 2026-04-28 16:07:34.535 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44861/resources/index.json 2026-04-28 16:07:34.535 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44861/resources/index.json 2026-04-28 16:07:34.536 [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:44861/resources/index.json. 2026-04-28 16:07:34.542 [DefaultDispatcher-worker-5 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44861/resources/index.json 2026-04-28 16:07:34.542 [DefaultDispatcher-worker-5 @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:44861/resources/index.json. 2026-04-28 16:07:34.542 [DefaultDispatcher-worker-5 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44861/resources/index.json 2026-04-28 16:07:34.544 [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-04-28 16:07:34.545 [eventLoopGroupProxy-7-1 @call-handler#45] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms 2026-04-28 16:07:34.546 [DefaultDispatcher-worker-9 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44861/resources/index.json 2026-04-28 16:07:34.546 [DefaultDispatcher-worker-9 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44861/resources/index.json 2026-04-28 16:07:34.546 [DefaultDispatcher-worker-9 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44861/resources/index.json 2026-04-28 16:07:36.554 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-04-28 16:07:36.555 [Test worker] INFO io.ktor.server.Application - Application started in 0.001 seconds. 2026-04-28 16:07:36.556 [DefaultDispatcher-worker-9 @coroutine#49] INFO io.ktor.server.Application - Responding at http://0.0.0.0:41431 2026-04-28 16:07:36.561 [Test worker @coroutine#55] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41431/resources/lesson001.json 2026-04-28 16:07:36.561 [Test worker @coroutine#55] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41431/resources/lesson001.json. 2026-04-28 16:07:36.561 [Test worker @coroutine#55] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41431/resources/lesson001.json 2026-04-28 16:07:36.564 [eventLoopGroupProxy-10-1 @call-handler#59] 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-04-28 16:07:36.565 [DefaultDispatcher-worker-2 @call-handler#59] INFO io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 1ms 2026-04-28 16:07:36.566 [DefaultDispatcher-worker-8 @coroutine#55] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41431/resources/lesson001.json 2026-04-28 16:07:36.566 [DefaultDispatcher-worker-4 @coroutine#55] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41431/resources/lesson001.json 2026-04-28 16:07:36.566 [DefaultDispatcher-worker-4 @coroutine#55] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41431/resources/lesson001.json 2026-04-28 16:07:36.569 [DefaultDispatcher-worker-4 @coroutine#55] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class kotlinx.serialization.json.JsonObject for http://localhost:41431/resources/lesson001.json. 2026-04-28 16:07:39.182 [Test worker @coroutine#65] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-04-28 16:07:39.218 [Test worker @coroutine#65] INFO io.ktor.server.Application - Application started in 0.364 seconds. 2026-04-28 16:07:39.240 [DefaultDispatcher-worker-8 @coroutine#74] INFO io.ktor.server.Application - Responding at http://0.0.0.0:37161 2026-04-28 16:07:39.274 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37161/api/school/respect/schoolpermissiongrant 2026-04-28 16:07:39.274 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:37161/api/school/respect/schoolpermissiongrant. 2026-04-28 16:07:39.274 [Test worker @coroutine#65] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37161/api/school/respect/schoolpermissiongrant 2026-04-28 16:07:39.302 [eventLoopGroupProxy-13-1 @call-handler#78] 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-04-28 16:07:39.374 [Test worker @coroutine#65] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37161/api/school/respect/schoolpermissiongrant 2026-04-28 16:07:39.374 [Test worker @coroutine#65] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37161/api/school/respect/schoolpermissiongrant 2026-04-28 16:07:39.374 [Test worker @coroutine#65] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37161/api/school/respect/schoolpermissiongrant 2026-04-28 16:07:39.377 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:37161/api/school/respect/schoolpermissiongrant. 2026-04-28 16:07:39.559 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37161/api/school/respect/person?includeRelated=false 2026-04-28 16:07:39.562 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:37161/api/school/respect/person?includeRelated=false. 2026-04-28 16:07:39.562 [Test worker @coroutine#65] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37161/api/school/respect/person?includeRelated=false 2026-04-28 16:07:39.569 [eventLoopGroupProxy-13-1 @call-handler#84] 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-04-28 16:07:39.614 [Test worker @coroutine#65] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37161/api/school/respect/person?includeRelated=false 2026-04-28 16:07:39.614 [Test worker @coroutine#65] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37161/api/school/respect/person?includeRelated=false 2026-04-28 16:07:39.614 [Test worker @coroutine#65] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37161/api/school/respect/person?includeRelated=false 2026-04-28 16:07:39.620 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:37161/api/school/respect/person?includeRelated=false. 2026-04-28 16:07:39.659 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37161/api/school/respect/person?includeRelated=false 2026-04-28 16:07:39.660 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:37161/api/school/respect/person?includeRelated=false. 2026-04-28 16:07:39.660 [Test worker @coroutine#65] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37161/api/school/respect/person?includeRelated=false 2026-04-28 16:07:39.671 [eventLoopGroupProxy-13-1 @call-handler#90] 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-04-28 16:07:39.679 [DefaultDispatcher-worker-4 @call-handler#90] 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-04-28 16:07:39.684 [Test worker @coroutine#65] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37161/api/school/respect/person?includeRelated=false 2026-04-28 16:07:39.684 [Test worker @coroutine#65] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37161/api/school/respect/person?includeRelated=false 2026-04-28 16:07:39.684 [Test worker @coroutine#65] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37161/api/school/respect/person?includeRelated=false 2026-04-28 16:07:41.908 [Test worker @coroutine#94] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-04-28 16:07:41.909 [Test worker @coroutine#94] INFO io.ktor.server.Application - Application started in 0.057 seconds. 2026-04-28 16:07:41.910 [DefaultDispatcher-worker-3 @coroutine#102] INFO io.ktor.server.Application - Responding at http://0.0.0.0:46651 2026-04-28 16:07:41.911 [Test worker @coroutine#94] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46651/api/school/respect/schoolpermissiongrant 2026-04-28 16:07:41.911 [Test worker @coroutine#94] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:46651/api/school/respect/schoolpermissiongrant. 2026-04-28 16:07:41.911 [Test worker @coroutine#94] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46651/api/school/respect/schoolpermissiongrant 2026-04-28 16:07:41.914 [eventLoopGroupProxy-16-1 @call-handler#106] 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-04-28 16:07:41.915 [Test worker @coroutine#94] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46651/api/school/respect/schoolpermissiongrant 2026-04-28 16:07:41.916 [Test worker @coroutine#94] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46651/api/school/respect/schoolpermissiongrant 2026-04-28 16:07:41.916 [Test worker @coroutine#94] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46651/api/school/respect/schoolpermissiongrant 2026-04-28 16:07:41.916 [Test worker @coroutine#94] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:46651/api/school/respect/schoolpermissiongrant. 2026-04-28 16:07:41.971 [DefaultDispatcher-worker-9 @coroutine#112] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46651/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-04-28 16:07:41.972 [DefaultDispatcher-worker-9 @coroutine#112] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:46651/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100. 2026-04-28 16:07:41.972 [DefaultDispatcher-worker-9 @coroutine#112] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46651/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-04-28 16:07:41.973 [eventLoopGroupProxy-16-1 @call-handler#116] 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-04-28 16:07:41.977 [DefaultDispatcher-worker-3 @coroutine#112] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46651/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-04-28 16:07:41.977 [DefaultDispatcher-worker-3 @coroutine#112] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46651/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-04-28 16:07:41.977 [DefaultDispatcher-worker-3 @coroutine#112] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46651/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-04-28 16:07:41.978 [DefaultDispatcher-worker-3 @coroutine#112] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:46651/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100. 2026-04-28 16:07:44.169 [Test worker @coroutine#121] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-04-28 16:07:44.170 [Test worker @coroutine#121] INFO io.ktor.server.Application - Application started in 0.065 seconds. 2026-04-28 16:07:44.173 [DefaultDispatcher-worker-9 @coroutine#130] INFO io.ktor.server.Application - Responding at http://0.0.0.0:34645 2026-04-28 16:07:44.180 [Test worker @coroutine#121] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34645/api/school/respect/person?includeRelated=false 2026-04-28 16:07:44.180 [Test worker @coroutine#121] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:34645/api/school/respect/person?includeRelated=false. 2026-04-28 16:07:44.180 [Test worker @coroutine#121] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34645/api/school/respect/person?includeRelated=false 2026-04-28 16:07:44.196 [eventLoopGroupProxy-19-1 @call-handler#135] 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-04-28 16:07:44.209 [Test worker @coroutine#121] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34645/api/school/respect/person?includeRelated=false 2026-04-28 16:07:44.209 [Test worker @coroutine#121] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34645/api/school/respect/person?includeRelated=false 2026-04-28 16:07:44.210 [Test worker @coroutine#121] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34645/api/school/respect/person?includeRelated=false 2026-04-28 16:07:44.213 [Test worker @coroutine#121] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34645/api/school/respect/person?includeRelated=false. 2026-04-28 16:07:44.294 [Test worker @coroutine#121] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34645/api/school/respect/person?since=2026-04-28T12%3A07%3A44.198708104Z&includeRelated=false 2026-04-28 16:07:44.295 [Test worker @coroutine#121] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:34645/api/school/respect/person?since=2026-04-28T12%3A07%3A44.198708104Z&includeRelated=false. 2026-04-28 16:07:44.295 [Test worker @coroutine#121] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34645/api/school/respect/person?since=2026-04-28T12%3A07%3A44.198708104Z&includeRelated=false 2026-04-28 16:07:44.297 [eventLoopGroupProxy-19-1 @call-handler#141] 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-04-28 16:07:44.301 [Test worker @coroutine#121] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34645/api/school/respect/person?since=2026-04-28T12%3A07%3A44.198708104Z&includeRelated=false 2026-04-28 16:07:44.302 [Test worker @coroutine#121] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34645/api/school/respect/person?since=2026-04-28T12%3A07%3A44.198708104Z&includeRelated=false 2026-04-28 16:07:44.302 [Test worker @coroutine#121] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34645/api/school/respect/person?since=2026-04-28T12%3A07%3A44.198708104Z&includeRelated=false 2026-04-28 16:07:44.303 [Test worker @coroutine#121] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34645/api/school/respect/person?since=2026-04-28T12%3A07%3A44.198708104Z&includeRelated=false. 2026-04-28 16:07:46.556 [Test worker @coroutine#147] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-04-28 16:07:46.557 [Test worker @coroutine#147] INFO io.ktor.server.Application - Application started in 0.067 seconds. 2026-04-28 16:07:46.558 [DefaultDispatcher-worker-2 @coroutine#156] INFO io.ktor.server.Application - Responding at http://0.0.0.0:41051 2026-04-28 16:07:46.640 [DefaultDispatcher-worker-3 @coroutine#154] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41051/api/school/respect/person 2026-04-28 16:07:46.640 [DefaultDispatcher-worker-3 @coroutine#154] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@2b0b82a for http://localhost:41051/api/school/respect/person 2026-04-28 16:07:46.640 [DefaultDispatcher-worker-3 @coroutine#154] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41051/api/school/respect/person 2026-04-28 16:07:46.640 [DefaultDispatcher-worker-3 @coroutine#154] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:41051/api/school/respect/person from class io.ktor.http.content.TextContent 2026-04-28 16:07:46.663 [eventLoopGroupProxy-22-1 @call-handler#166] 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-04-28 16:07:46.678 [eventLoopGroupProxy-22-1 @call-handler#166] 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-04-28 16:07:46.681 [eventLoopGroupProxy-22-1 @call-handler#166] 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-04-28 16:07:46.683 [DefaultDispatcher-worker-9 @coroutine#154] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41051/api/school/respect/person 2026-04-28 16:07:46.683 [DefaultDispatcher-worker-9 @coroutine#154] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41051/api/school/respect/person 2026-04-28 16:07:46.683 [DefaultDispatcher-worker-9 @coroutine#154] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41051/api/school/respect/person 2026-04-28 16:07:48.929 [Test worker @coroutine#171] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-04-28 16:07:48.931 [Test worker @coroutine#171] INFO io.ktor.server.Application - Application started in 0.067 seconds. 2026-04-28 16:07:48.934 [DefaultDispatcher-worker-12 @coroutine#180] INFO io.ktor.server.Application - Responding at http://0.0.0.0:38283 2026-04-28 16:07:48.935 [Test worker @coroutine#171] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38283/api/school/respect/schoolpermissiongrant 2026-04-28 16:07:48.935 [Test worker @coroutine#171] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:38283/api/school/respect/schoolpermissiongrant. 2026-04-28 16:07:48.936 [Test worker @coroutine#171] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38283/api/school/respect/schoolpermissiongrant 2026-04-28 16:07:48.944 [eventLoopGroupProxy-25-1 @call-handler#184] 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-04-28 16:07:48.949 [Test worker @coroutine#171] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38283/api/school/respect/schoolpermissiongrant 2026-04-28 16:07:48.949 [Test worker @coroutine#171] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38283/api/school/respect/schoolpermissiongrant 2026-04-28 16:07:48.949 [Test worker @coroutine#171] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38283/api/school/respect/schoolpermissiongrant 2026-04-28 16:07:48.950 [Test worker @coroutine#171] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:38283/api/school/respect/schoolpermissiongrant. 2026-04-28 16:07:49.020 [Test worker @coroutine#171] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38283/api/school/respect/person?includeRelated=false 2026-04-28 16:07:49.020 [Test worker @coroutine#171] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:38283/api/school/respect/person?includeRelated=false. 2026-04-28 16:07:49.020 [Test worker @coroutine#171] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38283/api/school/respect/person?includeRelated=false 2026-04-28 16:07:49.021 [eventLoopGroupProxy-25-1 @call-handler#190] 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-04-28 16:07:49.029 [Test worker @coroutine#171] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38283/api/school/respect/person?includeRelated=false 2026-04-28 16:07:49.029 [Test worker @coroutine#171] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38283/api/school/respect/person?includeRelated=false 2026-04-28 16:07:49.029 [Test worker @coroutine#171] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38283/api/school/respect/person?includeRelated=false 2026-04-28 16:07:49.030 [Test worker @coroutine#171] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:38283/api/school/respect/person?includeRelated=false. 2026-04-28 16:07:51.043 [Test worker @coroutine#171] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38283/api/school/respect/person?includeRelated=false 2026-04-28 16:07:51.043 [Test worker @coroutine#171] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:38283/api/school/respect/person?includeRelated=false. 2026-04-28 16:07:51.043 [Test worker @coroutine#171] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38283/api/school/respect/person?includeRelated=false 2026-04-28 16:07:51.045 [eventLoopGroupProxy-25-1 @call-handler#197] 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-04-28 16:07:51.049 [Test worker @coroutine#171] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38283/api/school/respect/person?includeRelated=false 2026-04-28 16:07:51.050 [Test worker @coroutine#171] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38283/api/school/respect/person?includeRelated=false 2026-04-28 16:07:51.050 [Test worker @coroutine#171] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38283/api/school/respect/person?includeRelated=false 2026-04-28 16:07:51.051 [Test worker @coroutine#171] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:38283/api/school/respect/person?includeRelated=false. 2026-04-28 16:07:53.226 [Test worker @coroutine#203] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-04-28 16:07:53.227 [Test worker @coroutine#203] INFO io.ktor.server.Application - Application started in 0.051 seconds. 2026-04-28 16:07:53.228 [DefaultDispatcher-worker-7 @coroutine#212] INFO io.ktor.server.Application - Responding at http://0.0.0.0:36779 2026-04-28 16:07:53.231 [Test worker @coroutine#203] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36779/api/school/respect/person?includeRelated=false 2026-04-28 16:07:53.231 [Test worker @coroutine#203] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:36779/api/school/respect/person?includeRelated=false. 2026-04-28 16:07:53.231 [Test worker @coroutine#203] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36779/api/school/respect/person?includeRelated=false 2026-04-28 16:07:53.235 [eventLoopGroupProxy-28-1 @call-handler#217] 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-04-28 16:07:53.240 [Test worker @coroutine#203] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36779/api/school/respect/person?includeRelated=false 2026-04-28 16:07:53.240 [Test worker @coroutine#203] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36779/api/school/respect/person?includeRelated=false 2026-04-28 16:07:53.240 [Test worker @coroutine#203] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36779/api/school/respect/person?includeRelated=false 2026-04-28 16:07:53.241 [Test worker @coroutine#203] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:36779/api/school/respect/person?includeRelated=false. 2026-04-28 16:07:53.307 [Test worker @coroutine#203] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36779/api/school/respect/person?since=2026-04-28T12%3A07%3A53.236093218Z&includeRelated=false 2026-04-28 16:07:53.308 [Test worker @coroutine#203] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:36779/api/school/respect/person?since=2026-04-28T12%3A07%3A53.236093218Z&includeRelated=false. 2026-04-28 16:07:53.308 [Test worker @coroutine#203] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36779/api/school/respect/person?since=2026-04-28T12%3A07%3A53.236093218Z&includeRelated=false 2026-04-28 16:07:53.311 [eventLoopGroupProxy-28-1 @call-handler#224] 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-04-28 16:07:53.315 [Test worker @coroutine#203] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36779/api/school/respect/person?since=2026-04-28T12%3A07%3A53.236093218Z&includeRelated=false 2026-04-28 16:07:53.315 [Test worker @coroutine#203] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36779/api/school/respect/person?since=2026-04-28T12%3A07%3A53.236093218Z&includeRelated=false 2026-04-28 16:07:53.315 [Test worker @coroutine#203] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36779/api/school/respect/person?since=2026-04-28T12%3A07%3A53.236093218Z&includeRelated=false 2026-04-28 16:07:53.316 [Test worker @coroutine#203] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:36779/api/school/respect/person?since=2026-04-28T12%3A07%3A53.236093218Z&includeRelated=false. 2026-04-28 16:07:55.461 [Test worker @coroutine#230] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-04-28 16:07:55.463 [Test worker @coroutine#230] INFO io.ktor.server.Application - Application started in 0.053 seconds. 2026-04-28 16:07:55.464 [DefaultDispatcher-worker-7 @coroutine#240] INFO io.ktor.server.Application - Responding at http://0.0.0.0:41479 2026-04-28 16:07:55.465 [Test worker @coroutine#230] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41479/playlist/cb8646c4-a6f3-4078-ba4c-7cb982eb7b23 2026-04-28 16:07:55.465 [Test worker @coroutine#230] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41479/playlist/cb8646c4-a6f3-4078-ba4c-7cb982eb7b23. 2026-04-28 16:07:55.465 [Test worker @coroutine#230] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41479/playlist/cb8646c4-a6f3-4078-ba4c-7cb982eb7b23 2026-04-28 16:07:55.468 [eventLoopGroupProxy-31-1 @call-handler#244] TRACE io.ktor.server.routing.Routing - Trace for [playlist, cb8646c4-a6f3-4078-ba4c-7cb982eb7b23] /, segment:0 -> SUCCESS @ / /playlist, segment:1 -> SUCCESS @ /playlist /playlist/{uuid}, segment:2 -> SUCCESS; Parameters [uuid=[cb8646c4-a6f3-4078-ba4c-7cb982eb7b23]] @ /playlist/{uuid} /playlist/{uuid}/(method:GET), segment:2 -> SUCCESS @ /playlist/{uuid}/(method:GET) /playlist/{uuid}/(method:POST), segment:2 -> FAILURE "Selector didn't match" @ /playlist/{uuid}/(method:POST) Matched routes: "" -> "playlist" -> "{uuid}" -> "(method:GET)" Routing resolve result: SUCCESS; Parameters [uuid=[cb8646c4-a6f3-4078-ba4c-7cb982eb7b23]] @ /playlist/{uuid}/(method:GET) 2026-04-28 16:07:55.474 [Test worker @coroutine#230] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41479/playlist/cb8646c4-a6f3-4078-ba4c-7cb982eb7b23 2026-04-28 16:07:55.474 [Test worker @coroutine#230] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41479/playlist/cb8646c4-a6f3-4078-ba4c-7cb982eb7b23 2026-04-28 16:07:55.474 [Test worker @coroutine#230] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41479/playlist/cb8646c4-a6f3-4078-ba4c-7cb982eb7b23 2026-04-28 16:07:55.475 [Test worker @coroutine#230] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsFeed for http://localhost:41479/playlist/cb8646c4-a6f3-4078-ba4c-7cb982eb7b23. 2026-04-28 16:07:57.633 [Test worker @coroutine#248] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-04-28 16:07:57.634 [Test worker @coroutine#248] INFO io.ktor.server.Application - Application started in 0.038 seconds. 2026-04-28 16:07:57.635 [DefaultDispatcher-worker-2 @coroutine#257] INFO io.ktor.server.Application - Responding at http://0.0.0.0:34661 2026-04-28 16:07:57.674 [DefaultDispatcher-worker-12 @coroutine#255] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34661/playlist/a1ae2365-fe4c-4e33-9780-1e5481a3bacb 2026-04-28 16:07:57.674 [DefaultDispatcher-worker-12 @coroutine#255] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@480a6a46 for http://localhost:34661/playlist/a1ae2365-fe4c-4e33-9780-1e5481a3bacb 2026-04-28 16:07:57.674 [DefaultDispatcher-worker-12 @coroutine#255] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34661/playlist/a1ae2365-fe4c-4e33-9780-1e5481a3bacb 2026-04-28 16:07:57.674 [DefaultDispatcher-worker-12 @coroutine#255] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:34661/playlist/a1ae2365-fe4c-4e33-9780-1e5481a3bacb from class io.ktor.http.content.TextContent 2026-04-28 16:07:57.676 [eventLoopGroupProxy-34-1 @call-handler#265] TRACE io.ktor.server.routing.Routing - Trace for [playlist, a1ae2365-fe4c-4e33-9780-1e5481a3bacb] /, segment:0 -> SUCCESS @ / /playlist, segment:1 -> SUCCESS @ /playlist /playlist/{uuid}, segment:2 -> SUCCESS; Parameters [uuid=[a1ae2365-fe4c-4e33-9780-1e5481a3bacb]] @ /playlist/{uuid} /playlist/{uuid}/(method:GET), segment:2 -> FAILURE "Selector didn't match" @ /playlist/{uuid}/(method:GET) /playlist/{uuid}/(method:POST), segment:2 -> SUCCESS @ /playlist/{uuid}/(method:POST) Matched routes: "" -> "playlist" -> "{uuid}" -> "(method:POST)" Routing resolve result: SUCCESS; Parameters [uuid=[a1ae2365-fe4c-4e33-9780-1e5481a3bacb]] @ /playlist/{uuid}/(method:POST) 2026-04-28 16:07:57.677 [eventLoopGroupProxy-34-1 @call-handler#265] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(world.respect.lib.opds.model.OpdsFeed) for call /playlist/a1ae2365-fe4c-4e33-9780-1e5481a3bacb 2026-04-28 16:07:57.678 [DefaultDispatcher-worker-12 @call-handler#265] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the POST /playlist/a1ae2365-fe4c-4e33-9780-1e5481a3bacb request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType]. 2026-04-28 16:07:57.678 [DefaultDispatcher-worker-7 @coroutine#255] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34661/playlist/a1ae2365-fe4c-4e33-9780-1e5481a3bacb 2026-04-28 16:07:57.678 [DefaultDispatcher-worker-7 @coroutine#255] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34661/playlist/a1ae2365-fe4c-4e33-9780-1e5481a3bacb 2026-04-28 16:07:57.678 [DefaultDispatcher-worker-7 @coroutine#255] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34661/playlist/a1ae2365-fe4c-4e33-9780-1e5481a3bacb