2026-02-02 10:50:48.327 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-02 10:50:48.430 [Test worker] INFO io.ktor.server.Application - Application started in 0.251 seconds. 2026-02-02 10:50:48.503 [DefaultDispatcher-worker-1 @coroutine#2] INFO io.ktor.server.Application - Responding at http://0.0.0.0:43021 2026-02-02 10:50:48.741 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43021/resources/index.json 2026-02-02 10:50:48.742 [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:43021/resources/index.json. 2026-02-02 10:50:48.742 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43021/resources/index.json 2026-02-02 10:50:48.846 [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-02-02 10:50:48.878 [eventLoopGroupProxy-4-1 @call-handler#12] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 36ms 2026-02-02 10:50:48.882 [DefaultDispatcher-worker-2 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43021/resources/index.json 2026-02-02 10:50:48.884 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43021/resources/index.json 2026-02-02 10:50:48.884 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43021/resources/index.json 2026-02-02 10:50:48.901 [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:43021/resources/index.json. 2026-02-02 10:50:48.926 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43021/resources/index.json 2026-02-02 10:50:48.926 [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:43021/resources/index.json. 2026-02-02 10:50:48.926 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43021/resources/index.json 2026-02-02 10:50:48.928 [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-02-02 10:50:48.929 [eventLoopGroupProxy-4-1 @call-handler#22] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms 2026-02-02 10:50:48.930 [DefaultDispatcher-worker-3 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43021/resources/index.json 2026-02-02 10:50:48.930 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43021/resources/index.json 2026-02-02 10:50:48.930 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43021/resources/index.json 2026-02-02 10:50:50.942 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-02 10:50:50.942 [Test worker] INFO io.ktor.server.Application - Application started in 0.0 seconds. 2026-02-02 10:50:50.946 [DefaultDispatcher-worker-2 @coroutine#26] INFO io.ktor.server.Application - Responding at http://0.0.0.0:38325 2026-02-02 10:50:50.990 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38325/resources/index.json 2026-02-02 10:50:50.990 [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:38325/resources/index.json. 2026-02-02 10:50:50.990 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38325/resources/index.json 2026-02-02 10:50:50.993 [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-02-02 10:50:50.994 [DefaultDispatcher-worker-2 @call-handler#35] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 1ms 2026-02-02 10:50:50.995 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38325/resources/index.json 2026-02-02 10:50:50.995 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38325/resources/index.json 2026-02-02 10:50:50.995 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38325/resources/index.json 2026-02-02 10:50:50.996 [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:38325/resources/index.json. 2026-02-02 10:50:50.999 [DefaultDispatcher-worker-5 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38325/resources/index.json 2026-02-02 10:50:51.000 [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:38325/resources/index.json. 2026-02-02 10:50:51.000 [DefaultDispatcher-worker-5 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38325/resources/index.json 2026-02-02 10:50:51.001 [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-02-02 10:50:51.001 [eventLoopGroupProxy-7-1 @call-handler#45] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 0ms 2026-02-02 10:50:51.002 [DefaultDispatcher-worker-4 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38325/resources/index.json 2026-02-02 10:50:51.002 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38325/resources/index.json 2026-02-02 10:50:51.002 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38325/resources/index.json 2026-02-02 10:50:53.008 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-02 10:50:53.008 [Test worker] INFO io.ktor.server.Application - Application started in 0.0 seconds. 2026-02-02 10:50:53.009 [DefaultDispatcher-worker-1 @coroutine#49] INFO io.ktor.server.Application - Responding at http://0.0.0.0:44113 2026-02-02 10:50:53.013 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44113/resources/lesson001.json 2026-02-02 10:50:53.014 [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:44113/resources/lesson001.json. 2026-02-02 10:50:53.014 [Test worker @coroutine#52] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44113/resources/lesson001.json 2026-02-02 10:50:53.016 [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-02-02 10:50:53.018 [eventLoopGroupProxy-10-1 @call-handler#56] INFO io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 2ms 2026-02-02 10:50:53.018 [DefaultDispatcher-worker-1 @coroutine#52] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44113/resources/lesson001.json 2026-02-02 10:50:53.019 [DefaultDispatcher-worker-4 @coroutine#52] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44113/resources/lesson001.json 2026-02-02 10:50:53.019 [DefaultDispatcher-worker-4 @coroutine#52] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44113/resources/lesson001.json 2026-02-02 10:50:53.039 [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:44113/resources/lesson001.json. 2026-02-02 10:50:55.594 [Test worker @coroutine#61] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-02 10:50:55.606 [Test worker @coroutine#61] INFO io.ktor.server.Application - Application started in 0.445 seconds. 2026-02-02 10:50:55.610 [DefaultDispatcher-worker-1 @coroutine#70] INFO io.ktor.server.Application - Responding at http://0.0.0.0:38027 2026-02-02 10:50:55.624 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38027/api/school/respect/schoolpermissiongrant 2026-02-02 10:50:55.624 [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:38027/api/school/respect/schoolpermissiongrant. 2026-02-02 10:50:55.624 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38027/api/school/respect/schoolpermissiongrant 2026-02-02 10:50:55.632 [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-02-02 10:50:55.648 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38027/api/school/respect/schoolpermissiongrant 2026-02-02 10:50:55.649 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38027/api/school/respect/schoolpermissiongrant 2026-02-02 10:50:55.649 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38027/api/school/respect/schoolpermissiongrant 2026-02-02 10:50:55.652 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:38027/api/school/respect/schoolpermissiongrant. 2026-02-02 10:50:55.764 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38027/api/school/respect/person?includeRelated=false 2026-02-02 10:50:55.764 [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:38027/api/school/respect/person?includeRelated=false. 2026-02-02 10:50:55.764 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38027/api/school/respect/person?includeRelated=false 2026-02-02 10:50:55.766 [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-02-02 10:50:55.785 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38027/api/school/respect/person?includeRelated=false 2026-02-02 10:50:55.786 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38027/api/school/respect/person?includeRelated=false 2026-02-02 10:50:55.786 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38027/api/school/respect/person?includeRelated=false 2026-02-02 10:50:55.788 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:38027/api/school/respect/person?includeRelated=false. 2026-02-02 10:50:55.794 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38027/api/school/respect/person?includeRelated=false 2026-02-02 10:50:55.794 [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:38027/api/school/respect/person?includeRelated=false. 2026-02-02 10:50:55.794 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38027/api/school/respect/person?includeRelated=false 2026-02-02 10:50:55.796 [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-02-02 10:50:55.799 [DefaultDispatcher-worker-5 @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-02-02 10:50:55.800 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38027/api/school/respect/person?includeRelated=false 2026-02-02 10:50:55.800 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38027/api/school/respect/person?includeRelated=false 2026-02-02 10:50:55.800 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38027/api/school/respect/person?includeRelated=false 2026-02-02 10:50:57.923 [Test worker @coroutine#90] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-02 10:50:57.925 [Test worker @coroutine#90] INFO io.ktor.server.Application - Application started in 0.048 seconds. 2026-02-02 10:50:57.927 [DefaultDispatcher-worker-4 @coroutine#99] INFO io.ktor.server.Application - Responding at http://0.0.0.0:40783 2026-02-02 10:50:57.930 [Test worker @coroutine#90] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40783/api/school/respect/schoolpermissiongrant 2026-02-02 10:50:57.930 [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:40783/api/school/respect/schoolpermissiongrant. 2026-02-02 10:50:57.930 [Test worker @coroutine#90] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40783/api/school/respect/schoolpermissiongrant 2026-02-02 10:50:57.938 [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-02-02 10:50:57.941 [Test worker @coroutine#90] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40783/api/school/respect/schoolpermissiongrant 2026-02-02 10:50:57.941 [Test worker @coroutine#90] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40783/api/school/respect/schoolpermissiongrant 2026-02-02 10:50:57.941 [Test worker @coroutine#90] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40783/api/school/respect/schoolpermissiongrant 2026-02-02 10:50:57.942 [Test worker @coroutine#90] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:40783/api/school/respect/schoolpermissiongrant. 2026-02-02 10:50:58.008 [DefaultDispatcher-worker-5 @coroutine#109] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40783/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-02-02 10:50:58.008 [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:40783/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100. 2026-02-02 10:50:58.008 [DefaultDispatcher-worker-5 @coroutine#109] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40783/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-02-02 10:50:58.011 [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-02-02 10:50:58.015 [DefaultDispatcher-worker-3 @coroutine#109] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40783/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-02-02 10:50:58.016 [DefaultDispatcher-worker-3 @coroutine#109] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40783/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-02-02 10:50:58.016 [DefaultDispatcher-worker-3 @coroutine#109] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40783/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-02-02 10:50:58.017 [DefaultDispatcher-worker-3 @coroutine#109] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:40783/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100. 2026-02-02 10:51:00.179 [Test worker @coroutine#118] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-02 10:51:00.182 [Test worker @coroutine#118] INFO io.ktor.server.Application - Application started in 0.054 seconds. 2026-02-02 10:51:00.186 [DefaultDispatcher-worker-5 @coroutine#127] INFO io.ktor.server.Application - Responding at http://0.0.0.0:34713 2026-02-02 10:51:00.196 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34713/api/school/respect/person?includeRelated=false 2026-02-02 10:51:00.196 [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:34713/api/school/respect/person?includeRelated=false. 2026-02-02 10:51:00.196 [Test worker @coroutine#118] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34713/api/school/respect/person?includeRelated=false 2026-02-02 10:51:00.207 [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-02-02 10:51:00.220 [Test worker @coroutine#118] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34713/api/school/respect/person?includeRelated=false 2026-02-02 10:51:00.220 [Test worker @coroutine#118] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34713/api/school/respect/person?includeRelated=false 2026-02-02 10:51:00.220 [Test worker @coroutine#118] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34713/api/school/respect/person?includeRelated=false 2026-02-02 10:51:00.232 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34713/api/school/respect/person?includeRelated=false. 2026-02-02 10:51:00.327 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34713/api/school/respect/person?since=2026-02-02T09%3A51%3A00.208576690Z&includeRelated=false 2026-02-02 10:51:00.328 [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:34713/api/school/respect/person?since=2026-02-02T09%3A51%3A00.208576690Z&includeRelated=false. 2026-02-02 10:51:00.328 [Test worker @coroutine#118] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34713/api/school/respect/person?since=2026-02-02T09%3A51%3A00.208576690Z&includeRelated=false 2026-02-02 10:51:00.341 [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-02-02 10:51:00.349 [Test worker @coroutine#118] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34713/api/school/respect/person?since=2026-02-02T09%3A51%3A00.208576690Z&includeRelated=false 2026-02-02 10:51:00.349 [Test worker @coroutine#118] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34713/api/school/respect/person?since=2026-02-02T09%3A51%3A00.208576690Z&includeRelated=false 2026-02-02 10:51:00.349 [Test worker @coroutine#118] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34713/api/school/respect/person?since=2026-02-02T09%3A51%3A00.208576690Z&includeRelated=false 2026-02-02 10:51:00.351 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34713/api/school/respect/person?since=2026-02-02T09%3A51%3A00.208576690Z&includeRelated=false. 2026-02-02 10:51:02.528 [Test worker @coroutine#144] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-02 10:51:02.530 [Test worker @coroutine#144] INFO io.ktor.server.Application - Application started in 0.052 seconds. 2026-02-02 10:51:02.532 [DefaultDispatcher-worker-4 @coroutine#153] INFO io.ktor.server.Application - Responding at http://0.0.0.0:43307 2026-02-02 10:51:02.573 [DefaultDispatcher-worker-5 @coroutine#151] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43307/api/school/respect/person 2026-02-02 10:51:02.577 [DefaultDispatcher-worker-5 @coroutine#151] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@6055366f for http://localhost:43307/api/school/respect/person 2026-02-02 10:51:02.577 [DefaultDispatcher-worker-5 @coroutine#151] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43307/api/school/respect/person 2026-02-02 10:51:02.577 [DefaultDispatcher-worker-5 @coroutine#151] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:43307/api/school/respect/person from class io.ktor.http.content.TextContent 2026-02-02 10:51:02.584 [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-02-02 10:51:02.592 [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-02-02 10:51:02.595 [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-02-02 10:51:02.597 [DefaultDispatcher-worker-3 @coroutine#151] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43307/api/school/respect/person 2026-02-02 10:51:02.599 [DefaultDispatcher-worker-3 @coroutine#151] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43307/api/school/respect/person 2026-02-02 10:51:02.599 [DefaultDispatcher-worker-3 @coroutine#151] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43307/api/school/respect/person 2026-02-02 10:51:04.741 [Test worker @coroutine#168] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-02 10:51:04.742 [Test worker @coroutine#168] INFO io.ktor.server.Application - Application started in 0.046 seconds. 2026-02-02 10:51:04.745 [DefaultDispatcher-worker-8 @coroutine#177] INFO io.ktor.server.Application - Responding at http://0.0.0.0:33095 2026-02-02 10:51:04.747 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33095/api/school/respect/schoolpermissiongrant 2026-02-02 10:51:04.747 [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:33095/api/school/respect/schoolpermissiongrant. 2026-02-02 10:51:04.747 [Test worker @coroutine#168] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33095/api/school/respect/schoolpermissiongrant 2026-02-02 10:51:04.751 [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-02-02 10:51:04.756 [Test worker @coroutine#168] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33095/api/school/respect/schoolpermissiongrant 2026-02-02 10:51:04.757 [Test worker @coroutine#168] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33095/api/school/respect/schoolpermissiongrant 2026-02-02 10:51:04.758 [Test worker @coroutine#168] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33095/api/school/respect/schoolpermissiongrant 2026-02-02 10:51:04.758 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:33095/api/school/respect/schoolpermissiongrant. 2026-02-02 10:51:04.816 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33095/api/school/respect/person?includeRelated=false 2026-02-02 10:51:04.816 [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:33095/api/school/respect/person?includeRelated=false. 2026-02-02 10:51:04.816 [Test worker @coroutine#168] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33095/api/school/respect/person?includeRelated=false 2026-02-02 10:51:04.822 [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-02-02 10:51:04.834 [Test worker @coroutine#168] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33095/api/school/respect/person?includeRelated=false 2026-02-02 10:51:04.834 [Test worker @coroutine#168] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33095/api/school/respect/person?includeRelated=false 2026-02-02 10:51:04.834 [Test worker @coroutine#168] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33095/api/school/respect/person?includeRelated=false 2026-02-02 10:51:04.836 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:33095/api/school/respect/person?includeRelated=false. 2026-02-02 10:51:06.857 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33095/api/school/respect/person?includeRelated=false 2026-02-02 10:51:06.857 [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:33095/api/school/respect/person?includeRelated=false. 2026-02-02 10:51:06.857 [Test worker @coroutine#168] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33095/api/school/respect/person?includeRelated=false 2026-02-02 10:51:06.860 [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-02-02 10:51:06.870 [Test worker @coroutine#168] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33095/api/school/respect/person?includeRelated=false 2026-02-02 10:51:06.871 [Test worker @coroutine#168] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33095/api/school/respect/person?includeRelated=false 2026-02-02 10:51:06.871 [Test worker @coroutine#168] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33095/api/school/respect/person?includeRelated=false 2026-02-02 10:51:06.879 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:33095/api/school/respect/person?includeRelated=false. 2026-02-02 10:51:09.029 [Test worker @coroutine#200] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-02 10:51:09.034 [Test worker @coroutine#200] INFO io.ktor.server.Application - Application started in 0.038 seconds. 2026-02-02 10:51:09.044 [DefaultDispatcher-worker-7 @coroutine#209] INFO io.ktor.server.Application - Responding at http://0.0.0.0:37713 2026-02-02 10:51:09.064 [Test worker @coroutine#200] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37713/api/school/respect/person?includeRelated=false 2026-02-02 10:51:09.064 [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:37713/api/school/respect/person?includeRelated=false. 2026-02-02 10:51:09.064 [Test worker @coroutine#200] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37713/api/school/respect/person?includeRelated=false 2026-02-02 10:51:09.078 [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-02-02 10:51:09.086 [Test worker @coroutine#200] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37713/api/school/respect/person?includeRelated=false 2026-02-02 10:51:09.086 [Test worker @coroutine#200] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37713/api/school/respect/person?includeRelated=false 2026-02-02 10:51:09.086 [Test worker @coroutine#200] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37713/api/school/respect/person?includeRelated=false 2026-02-02 10:51:09.087 [Test worker @coroutine#200] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:37713/api/school/respect/person?includeRelated=false. 2026-02-02 10:51:09.139 [Test worker @coroutine#200] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37713/api/school/respect/person?since=2026-02-02T09%3A51%3A09.079257404Z&includeRelated=false 2026-02-02 10:51:09.139 [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:37713/api/school/respect/person?since=2026-02-02T09%3A51%3A09.079257404Z&includeRelated=false. 2026-02-02 10:51:09.139 [Test worker @coroutine#200] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37713/api/school/respect/person?since=2026-02-02T09%3A51%3A09.079257404Z&includeRelated=false 2026-02-02 10:51:09.142 [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-02-02 10:51:09.149 [Test worker @coroutine#200] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37713/api/school/respect/person?since=2026-02-02T09%3A51%3A09.079257404Z&includeRelated=false 2026-02-02 10:51:09.149 [Test worker @coroutine#200] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37713/api/school/respect/person?since=2026-02-02T09%3A51%3A09.079257404Z&includeRelated=false 2026-02-02 10:51:09.149 [Test worker @coroutine#200] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37713/api/school/respect/person?since=2026-02-02T09%3A51%3A09.079257404Z&includeRelated=false 2026-02-02 10:51:09.151 [Test worker @coroutine#200] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:37713/api/school/respect/person?since=2026-02-02T09%3A51%3A09.079257404Z&includeRelated=false. 2026-02-02 11:15:55.459 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-02 11:15:55.562 [Test worker] INFO io.ktor.server.Application - Application started in 0.225 seconds. 2026-02-02 11:15:55.645 [DefaultDispatcher-worker-1 @coroutine#2] INFO io.ktor.server.Application - Responding at http://0.0.0.0:33185 2026-02-02 11:15:55.828 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33185/resources/index.json 2026-02-02 11:15:55.828 [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:33185/resources/index.json. 2026-02-02 11:15:55.828 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33185/resources/index.json 2026-02-02 11:15:55.920 [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-02-02 11:15:55.950 [eventLoopGroupProxy-4-1 @call-handler#12] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 34ms 2026-02-02 11:15:55.954 [DefaultDispatcher-worker-2 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33185/resources/index.json 2026-02-02 11:15:55.955 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33185/resources/index.json 2026-02-02 11:15:55.955 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33185/resources/index.json 2026-02-02 11:15:55.969 [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:33185/resources/index.json. 2026-02-02 11:15:55.991 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33185/resources/index.json 2026-02-02 11:15:55.991 [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:33185/resources/index.json. 2026-02-02 11:15:55.992 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33185/resources/index.json 2026-02-02 11:15:55.993 [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-02-02 11:15:55.994 [eventLoopGroupProxy-4-1 @call-handler#22] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms 2026-02-02 11:15:55.995 [DefaultDispatcher-worker-3 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33185/resources/index.json 2026-02-02 11:15:55.995 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33185/resources/index.json 2026-02-02 11:15:55.995 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33185/resources/index.json 2026-02-02 11:15:58.006 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-02 11:15:58.006 [Test worker] INFO io.ktor.server.Application - Application started in 0.0 seconds. 2026-02-02 11:15:58.010 [DefaultDispatcher-worker-2 @coroutine#26] INFO io.ktor.server.Application - Responding at http://0.0.0.0:32825 2026-02-02 11:15:58.073 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:32825/resources/index.json 2026-02-02 11:15:58.073 [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:32825/resources/index.json. 2026-02-02 11:15:58.073 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:32825/resources/index.json 2026-02-02 11:15:58.076 [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-02-02 11:15:58.077 [DefaultDispatcher-worker-3 @call-handler#35] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 1ms 2026-02-02 11:15:58.078 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:32825/resources/index.json 2026-02-02 11:15:58.078 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:32825/resources/index.json 2026-02-02 11:15:58.078 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:32825/resources/index.json 2026-02-02 11:15:58.079 [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:32825/resources/index.json. 2026-02-02 11:15:58.083 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:32825/resources/index.json 2026-02-02 11:15:58.083 [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:32825/resources/index.json. 2026-02-02 11:15:58.083 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:32825/resources/index.json 2026-02-02 11:15:58.084 [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-02-02 11:15:58.085 [eventLoopGroupProxy-7-1 @call-handler#45] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms 2026-02-02 11:15:58.085 [DefaultDispatcher-worker-2 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:32825/resources/index.json 2026-02-02 11:15:58.085 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:32825/resources/index.json 2026-02-02 11:15:58.085 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:32825/resources/index.json 2026-02-02 11:16:00.093 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-02 11:16:00.094 [Test worker] INFO io.ktor.server.Application - Application started in 0.001 seconds. 2026-02-02 11:16:00.095 [DefaultDispatcher-worker-2 @coroutine#49] INFO io.ktor.server.Application - Responding at http://0.0.0.0:45203 2026-02-02 11:16:00.099 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45203/resources/lesson001.json 2026-02-02 11:16:00.099 [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:45203/resources/lesson001.json. 2026-02-02 11:16:00.099 [Test worker @coroutine#52] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45203/resources/lesson001.json 2026-02-02 11:16:00.101 [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-02-02 11:16:00.102 [eventLoopGroupProxy-10-1 @call-handler#56] INFO io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 1ms 2026-02-02 11:16:00.103 [DefaultDispatcher-worker-2 @coroutine#52] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45203/resources/lesson001.json 2026-02-02 11:16:00.103 [DefaultDispatcher-worker-3 @coroutine#52] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45203/resources/lesson001.json 2026-02-02 11:16:00.103 [DefaultDispatcher-worker-3 @coroutine#52] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45203/resources/lesson001.json 2026-02-02 11:16:00.123 [DefaultDispatcher-worker-3 @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsPublication for http://localhost:45203/resources/lesson001.json. 2026-02-02 11:16:02.687 [Test worker @coroutine#61] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-02 11:16:02.698 [Test worker @coroutine#61] INFO io.ktor.server.Application - Application started in 0.472 seconds. 2026-02-02 11:16:02.701 [DefaultDispatcher-worker-3 @coroutine#70] INFO io.ktor.server.Application - Responding at http://0.0.0.0:38055 2026-02-02 11:16:02.716 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38055/api/school/respect/schoolpermissiongrant 2026-02-02 11:16:02.716 [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:38055/api/school/respect/schoolpermissiongrant. 2026-02-02 11:16:02.716 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38055/api/school/respect/schoolpermissiongrant 2026-02-02 11:16:02.724 [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-02-02 11:16:02.746 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38055/api/school/respect/schoolpermissiongrant 2026-02-02 11:16:02.747 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38055/api/school/respect/schoolpermissiongrant 2026-02-02 11:16:02.747 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38055/api/school/respect/schoolpermissiongrant 2026-02-02 11:16:02.749 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:38055/api/school/respect/schoolpermissiongrant. 2026-02-02 11:16:02.836 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38055/api/school/respect/person?includeRelated=false 2026-02-02 11:16:02.836 [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:38055/api/school/respect/person?includeRelated=false. 2026-02-02 11:16:02.836 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38055/api/school/respect/person?includeRelated=false 2026-02-02 11:16:02.838 [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-02-02 11:16:02.863 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38055/api/school/respect/person?includeRelated=false 2026-02-02 11:16:02.863 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38055/api/school/respect/person?includeRelated=false 2026-02-02 11:16:02.863 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38055/api/school/respect/person?includeRelated=false 2026-02-02 11:16:02.865 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:38055/api/school/respect/person?includeRelated=false. 2026-02-02 11:16:02.872 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38055/api/school/respect/person?includeRelated=false 2026-02-02 11:16:02.872 [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:38055/api/school/respect/person?includeRelated=false. 2026-02-02 11:16:02.872 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38055/api/school/respect/person?includeRelated=false 2026-02-02 11:16:02.874 [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-02-02 11:16:02.877 [DefaultDispatcher-worker-5 @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-02-02 11:16:02.878 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38055/api/school/respect/person?includeRelated=false 2026-02-02 11:16:02.878 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38055/api/school/respect/person?includeRelated=false 2026-02-02 11:16:02.878 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38055/api/school/respect/person?includeRelated=false 2026-02-02 11:16:04.988 [Test worker @coroutine#90] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-02 11:16:04.989 [Test worker @coroutine#90] INFO io.ktor.server.Application - Application started in 0.043 seconds. 2026-02-02 11:16:04.990 [DefaultDispatcher-worker-4 @coroutine#99] INFO io.ktor.server.Application - Responding at http://0.0.0.0:43689 2026-02-02 11:16:04.991 [Test worker @coroutine#90] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43689/api/school/respect/schoolpermissiongrant 2026-02-02 11:16:04.991 [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:43689/api/school/respect/schoolpermissiongrant. 2026-02-02 11:16:04.991 [Test worker @coroutine#90] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43689/api/school/respect/schoolpermissiongrant 2026-02-02 11:16:04.994 [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-02-02 11:16:04.996 [Test worker @coroutine#90] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43689/api/school/respect/schoolpermissiongrant 2026-02-02 11:16:04.996 [Test worker @coroutine#90] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43689/api/school/respect/schoolpermissiongrant 2026-02-02 11:16:04.996 [Test worker @coroutine#90] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43689/api/school/respect/schoolpermissiongrant 2026-02-02 11:16:04.997 [Test worker @coroutine#90] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:43689/api/school/respect/schoolpermissiongrant. 2026-02-02 11:16:05.049 [DefaultDispatcher-worker-3 @coroutine#109] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43689/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-02-02 11:16:05.049 [DefaultDispatcher-worker-3 @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:43689/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100. 2026-02-02 11:16:05.049 [DefaultDispatcher-worker-3 @coroutine#109] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43689/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-02-02 11:16:05.050 [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-02-02 11:16:05.053 [DefaultDispatcher-worker-2 @coroutine#109] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43689/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-02-02 11:16:05.053 [DefaultDispatcher-worker-2 @coroutine#109] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43689/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-02-02 11:16:05.053 [DefaultDispatcher-worker-2 @coroutine#109] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43689/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-02-02 11:16:05.054 [DefaultDispatcher-worker-2 @coroutine#109] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:43689/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100. 2026-02-02 11:16:07.175 [Test worker @coroutine#118] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-02 11:16:07.175 [Test worker @coroutine#118] INFO io.ktor.server.Application - Application started in 0.05 seconds. 2026-02-02 11:16:07.176 [DefaultDispatcher-worker-3 @coroutine#127] INFO io.ktor.server.Application - Responding at http://0.0.0.0:40935 2026-02-02 11:16:07.179 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40935/api/school/respect/person?includeRelated=false 2026-02-02 11:16:07.179 [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:40935/api/school/respect/person?includeRelated=false. 2026-02-02 11:16:07.179 [Test worker @coroutine#118] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40935/api/school/respect/person?includeRelated=false 2026-02-02 11:16:07.181 [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-02-02 11:16:07.185 [Test worker @coroutine#118] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40935/api/school/respect/person?includeRelated=false 2026-02-02 11:16:07.185 [Test worker @coroutine#118] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40935/api/school/respect/person?includeRelated=false 2026-02-02 11:16:07.185 [Test worker @coroutine#118] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40935/api/school/respect/person?includeRelated=false 2026-02-02 11:16:07.186 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:40935/api/school/respect/person?includeRelated=false. 2026-02-02 11:16:07.236 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40935/api/school/respect/person?since=2026-02-02T10%3A16%3A07.182106681Z&includeRelated=false 2026-02-02 11:16:07.236 [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:40935/api/school/respect/person?since=2026-02-02T10%3A16%3A07.182106681Z&includeRelated=false. 2026-02-02 11:16:07.236 [Test worker @coroutine#118] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40935/api/school/respect/person?since=2026-02-02T10%3A16%3A07.182106681Z&includeRelated=false 2026-02-02 11:16:07.237 [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-02-02 11:16:07.241 [Test worker @coroutine#118] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40935/api/school/respect/person?since=2026-02-02T10%3A16%3A07.182106681Z&includeRelated=false 2026-02-02 11:16:07.241 [Test worker @coroutine#118] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40935/api/school/respect/person?since=2026-02-02T10%3A16%3A07.182106681Z&includeRelated=false 2026-02-02 11:16:07.241 [Test worker @coroutine#118] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40935/api/school/respect/person?since=2026-02-02T10%3A16%3A07.182106681Z&includeRelated=false 2026-02-02 11:16:07.242 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:40935/api/school/respect/person?since=2026-02-02T10%3A16%3A07.182106681Z&includeRelated=false. 2026-02-02 11:16:09.359 [Test worker @coroutine#144] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-02 11:16:09.359 [Test worker @coroutine#144] INFO io.ktor.server.Application - Application started in 0.047 seconds. 2026-02-02 11:16:09.360 [DefaultDispatcher-worker-3 @coroutine#153] INFO io.ktor.server.Application - Responding at http://0.0.0.0:38533 2026-02-02 11:16:09.409 [DefaultDispatcher-worker-3 @coroutine#151] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38533/api/school/respect/person 2026-02-02 11:16:09.409 [DefaultDispatcher-worker-3 @coroutine#151] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@4a3fe39 for http://localhost:38533/api/school/respect/person 2026-02-02 11:16:09.409 [DefaultDispatcher-worker-3 @coroutine#151] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38533/api/school/respect/person 2026-02-02 11:16:09.409 [DefaultDispatcher-worker-3 @coroutine#151] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:38533/api/school/respect/person from class io.ktor.http.content.TextContent 2026-02-02 11:16:09.412 [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-02-02 11:16:09.418 [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-02-02 11:16:09.419 [DefaultDispatcher-worker-2 @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-02-02 11:16:09.420 [DefaultDispatcher-worker-3 @coroutine#151] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38533/api/school/respect/person 2026-02-02 11:16:09.420 [DefaultDispatcher-worker-3 @coroutine#151] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38533/api/school/respect/person 2026-02-02 11:16:09.420 [DefaultDispatcher-worker-3 @coroutine#151] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38533/api/school/respect/person 2026-02-02 11:16:11.539 [Test worker @coroutine#168] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-02 11:16:11.539 [Test worker @coroutine#168] INFO io.ktor.server.Application - Application started in 0.048 seconds. 2026-02-02 11:16:11.541 [DefaultDispatcher-worker-5 @coroutine#177] INFO io.ktor.server.Application - Responding at http://0.0.0.0:34391 2026-02-02 11:16:11.541 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34391/api/school/respect/schoolpermissiongrant 2026-02-02 11:16:11.541 [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:34391/api/school/respect/schoolpermissiongrant. 2026-02-02 11:16:11.542 [Test worker @coroutine#168] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34391/api/school/respect/schoolpermissiongrant 2026-02-02 11:16:11.544 [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-02-02 11:16:11.546 [Test worker @coroutine#168] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34391/api/school/respect/schoolpermissiongrant 2026-02-02 11:16:11.546 [Test worker @coroutine#168] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34391/api/school/respect/schoolpermissiongrant 2026-02-02 11:16:11.546 [Test worker @coroutine#168] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34391/api/school/respect/schoolpermissiongrant 2026-02-02 11:16:11.546 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34391/api/school/respect/schoolpermissiongrant. 2026-02-02 11:16:11.586 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34391/api/school/respect/person?includeRelated=false 2026-02-02 11:16:11.586 [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:34391/api/school/respect/person?includeRelated=false. 2026-02-02 11:16:11.586 [Test worker @coroutine#168] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34391/api/school/respect/person?includeRelated=false 2026-02-02 11:16:11.587 [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-02-02 11:16:11.592 [Test worker @coroutine#168] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34391/api/school/respect/person?includeRelated=false 2026-02-02 11:16:11.592 [Test worker @coroutine#168] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34391/api/school/respect/person?includeRelated=false 2026-02-02 11:16:11.592 [Test worker @coroutine#168] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34391/api/school/respect/person?includeRelated=false 2026-02-02 11:16:11.593 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34391/api/school/respect/person?includeRelated=false. 2026-02-02 11:16:13.598 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34391/api/school/respect/person?includeRelated=false 2026-02-02 11:16:13.598 [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:34391/api/school/respect/person?includeRelated=false. 2026-02-02 11:16:13.598 [Test worker @coroutine#168] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34391/api/school/respect/person?includeRelated=false 2026-02-02 11:16:13.600 [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-02-02 11:16:13.604 [Test worker @coroutine#168] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34391/api/school/respect/person?includeRelated=false 2026-02-02 11:16:13.604 [Test worker @coroutine#168] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34391/api/school/respect/person?includeRelated=false 2026-02-02 11:16:13.604 [Test worker @coroutine#168] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34391/api/school/respect/person?includeRelated=false 2026-02-02 11:16:13.604 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34391/api/school/respect/person?includeRelated=false. 2026-02-02 11:16:15.717 [Test worker @coroutine#200] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-02 11:16:15.718 [Test worker @coroutine#200] INFO io.ktor.server.Application - Application started in 0.039 seconds. 2026-02-02 11:16:15.719 [DefaultDispatcher-worker-5 @coroutine#209] INFO io.ktor.server.Application - Responding at http://0.0.0.0:39605 2026-02-02 11:16:15.721 [Test worker @coroutine#200] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39605/api/school/respect/person?includeRelated=false 2026-02-02 11:16:15.721 [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:39605/api/school/respect/person?includeRelated=false. 2026-02-02 11:16:15.721 [Test worker @coroutine#200] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39605/api/school/respect/person?includeRelated=false 2026-02-02 11:16:15.723 [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-02-02 11:16:15.727 [Test worker @coroutine#200] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39605/api/school/respect/person?includeRelated=false 2026-02-02 11:16:15.727 [Test worker @coroutine#200] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39605/api/school/respect/person?includeRelated=false 2026-02-02 11:16:15.727 [Test worker @coroutine#200] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39605/api/school/respect/person?includeRelated=false 2026-02-02 11:16:15.728 [Test worker @coroutine#200] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:39605/api/school/respect/person?includeRelated=false. 2026-02-02 11:16:15.776 [Test worker @coroutine#200] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39605/api/school/respect/person?since=2026-02-02T10%3A16%3A15.724050370Z&includeRelated=false 2026-02-02 11:16:15.776 [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:39605/api/school/respect/person?since=2026-02-02T10%3A16%3A15.724050370Z&includeRelated=false. 2026-02-02 11:16:15.776 [Test worker @coroutine#200] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39605/api/school/respect/person?since=2026-02-02T10%3A16%3A15.724050370Z&includeRelated=false 2026-02-02 11:16:15.778 [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-02-02 11:16:15.780 [Test worker @coroutine#200] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39605/api/school/respect/person?since=2026-02-02T10%3A16%3A15.724050370Z&includeRelated=false 2026-02-02 11:16:15.781 [Test worker @coroutine#200] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39605/api/school/respect/person?since=2026-02-02T10%3A16%3A15.724050370Z&includeRelated=false 2026-02-02 11:16:15.781 [Test worker @coroutine#200] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39605/api/school/respect/person?since=2026-02-02T10%3A16%3A15.724050370Z&includeRelated=false 2026-02-02 11:16:15.781 [Test worker @coroutine#200] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:39605/api/school/respect/person?since=2026-02-02T10%3A16%3A15.724050370Z&includeRelated=false. 2026-02-02 20:59:24.847 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-02 20:59:24.951 [Test worker] INFO io.ktor.server.Application - Application started in 0.249 seconds. 2026-02-02 20:59:25.044 [DefaultDispatcher-worker-1 @coroutine#2] INFO io.ktor.server.Application - Responding at http://0.0.0.0:36633 2026-02-02 20:59:25.308 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36633/resources/index.json 2026-02-02 20:59:25.309 [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:36633/resources/index.json. 2026-02-02 20:59:25.309 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36633/resources/index.json 2026-02-02 20:59:25.429 [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-02-02 20:59:25.463 [DefaultDispatcher-worker-1 @call-handler#12] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 38ms 2026-02-02 20:59:25.468 [DefaultDispatcher-worker-2 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36633/resources/index.json 2026-02-02 20:59:25.470 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36633/resources/index.json 2026-02-02 20:59:25.470 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36633/resources/index.json 2026-02-02 20:59:25.489 [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:36633/resources/index.json. 2026-02-02 20:59:25.518 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36633/resources/index.json 2026-02-02 20:59:25.518 [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:36633/resources/index.json. 2026-02-02 20:59:25.518 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36633/resources/index.json 2026-02-02 20:59:25.520 [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-02-02 20:59:25.522 [eventLoopGroupProxy-4-1 @call-handler#22] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 2ms 2026-02-02 20:59:25.522 [DefaultDispatcher-worker-2 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36633/resources/index.json 2026-02-02 20:59:25.522 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36633/resources/index.json 2026-02-02 20:59:25.523 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36633/resources/index.json 2026-02-02 20:59:27.537 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-02 20:59:27.538 [Test worker] INFO io.ktor.server.Application - Application started in 0.001 seconds. 2026-02-02 20:59:27.539 [DefaultDispatcher-worker-2 @coroutine#26] INFO io.ktor.server.Application - Responding at http://0.0.0.0:43187 2026-02-02 20:59:27.617 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43187/resources/index.json 2026-02-02 20:59:27.617 [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:43187/resources/index.json. 2026-02-02 20:59:27.617 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43187/resources/index.json 2026-02-02 20:59:27.620 [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-02-02 20:59:27.620 [eventLoopGroupProxy-7-1 @call-handler#35] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 0ms 2026-02-02 20:59:27.621 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43187/resources/index.json 2026-02-02 20:59:27.621 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43187/resources/index.json 2026-02-02 20:59:27.621 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43187/resources/index.json 2026-02-02 20:59:27.622 [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:43187/resources/index.json. 2026-02-02 20:59:27.626 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43187/resources/index.json 2026-02-02 20:59:27.626 [DefaultDispatcher-worker-2 @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:43187/resources/index.json. 2026-02-02 20:59:27.626 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43187/resources/index.json 2026-02-02 20:59:27.627 [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-02-02 20:59:27.628 [eventLoopGroupProxy-7-1 @call-handler#45] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms 2026-02-02 20:59:27.628 [DefaultDispatcher-worker-3 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43187/resources/index.json 2026-02-02 20:59:27.628 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43187/resources/index.json 2026-02-02 20:59:27.628 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43187/resources/index.json 2026-02-02 20:59:29.636 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-02 20:59:29.636 [Test worker] INFO io.ktor.server.Application - Application started in 0.0 seconds. 2026-02-02 20:59:29.637 [DefaultDispatcher-worker-3 @coroutine#49] INFO io.ktor.server.Application - Responding at http://0.0.0.0:34947 2026-02-02 20:59:29.641 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34947/resources/lesson001.json 2026-02-02 20:59:29.641 [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:34947/resources/lesson001.json. 2026-02-02 20:59:29.641 [Test worker @coroutine#52] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34947/resources/lesson001.json 2026-02-02 20:59:29.644 [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-02-02 20:59:29.645 [DefaultDispatcher-worker-2 @call-handler#56] INFO io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 2ms 2026-02-02 20:59:29.645 [DefaultDispatcher-worker-2 @coroutine#52] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34947/resources/lesson001.json 2026-02-02 20:59:29.645 [DefaultDispatcher-worker-3 @coroutine#52] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34947/resources/lesson001.json 2026-02-02 20:59:29.645 [DefaultDispatcher-worker-3 @coroutine#52] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34947/resources/lesson001.json 2026-02-02 20:59:29.667 [DefaultDispatcher-worker-3 @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsPublication for http://localhost:34947/resources/lesson001.json. 2026-02-02 20:59:32.208 [Test worker @coroutine#61] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-02 20:59:32.217 [Test worker @coroutine#61] INFO io.ktor.server.Application - Application started in 0.483 seconds. 2026-02-02 20:59:32.220 [DefaultDispatcher-worker-3 @coroutine#70] INFO io.ktor.server.Application - Responding at http://0.0.0.0:32951 2026-02-02 20:59:32.232 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:32951/api/school/respect/schoolpermissiongrant 2026-02-02 20:59:32.232 [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:32951/api/school/respect/schoolpermissiongrant. 2026-02-02 20:59:32.232 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:32951/api/school/respect/schoolpermissiongrant 2026-02-02 20:59:32.239 [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-02-02 20:59:32.254 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:32951/api/school/respect/schoolpermissiongrant 2026-02-02 20:59:32.254 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:32951/api/school/respect/schoolpermissiongrant 2026-02-02 20:59:32.254 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:32951/api/school/respect/schoolpermissiongrant 2026-02-02 20:59:32.256 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:32951/api/school/respect/schoolpermissiongrant. 2026-02-02 20:59:32.334 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:32951/api/school/respect/person?includeRelated=false 2026-02-02 20:59:32.334 [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:32951/api/school/respect/person?includeRelated=false. 2026-02-02 20:59:32.334 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:32951/api/school/respect/person?includeRelated=false 2026-02-02 20:59:32.336 [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-02-02 20:59:32.356 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:32951/api/school/respect/person?includeRelated=false 2026-02-02 20:59:32.356 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:32951/api/school/respect/person?includeRelated=false 2026-02-02 20:59:32.356 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:32951/api/school/respect/person?includeRelated=false 2026-02-02 20:59:32.358 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:32951/api/school/respect/person?includeRelated=false. 2026-02-02 20:59:32.364 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:32951/api/school/respect/person?includeRelated=false 2026-02-02 20:59:32.364 [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:32951/api/school/respect/person?includeRelated=false. 2026-02-02 20:59:32.364 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:32951/api/school/respect/person?includeRelated=false 2026-02-02 20:59:32.367 [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-02-02 20:59:32.369 [DefaultDispatcher-worker-8 @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-02-02 20:59:32.370 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:32951/api/school/respect/person?includeRelated=false 2026-02-02 20:59:32.370 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:32951/api/school/respect/person?includeRelated=false 2026-02-02 20:59:32.370 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:32951/api/school/respect/person?includeRelated=false 2026-02-02 20:59:34.456 [Test worker @coroutine#90] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-02 20:59:34.457 [Test worker @coroutine#90] INFO io.ktor.server.Application - Application started in 0.029 seconds. 2026-02-02 20:59:34.458 [DefaultDispatcher-worker-2 @coroutine#99] INFO io.ktor.server.Application - Responding at http://0.0.0.0:39877 2026-02-02 20:59:34.459 [Test worker @coroutine#90] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39877/api/school/respect/schoolpermissiongrant 2026-02-02 20:59:34.459 [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:39877/api/school/respect/schoolpermissiongrant. 2026-02-02 20:59:34.459 [Test worker @coroutine#90] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39877/api/school/respect/schoolpermissiongrant 2026-02-02 20:59:34.462 [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-02-02 20:59:34.464 [Test worker @coroutine#90] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39877/api/school/respect/schoolpermissiongrant 2026-02-02 20:59:34.464 [Test worker @coroutine#90] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39877/api/school/respect/schoolpermissiongrant 2026-02-02 20:59:34.464 [Test worker @coroutine#90] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39877/api/school/respect/schoolpermissiongrant 2026-02-02 20:59:34.464 [Test worker @coroutine#90] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:39877/api/school/respect/schoolpermissiongrant. 2026-02-02 20:59:34.511 [DefaultDispatcher-worker-3 @coroutine#109] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39877/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-02-02 20:59:34.511 [DefaultDispatcher-worker-3 @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:39877/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100. 2026-02-02 20:59:34.511 [DefaultDispatcher-worker-3 @coroutine#109] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39877/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-02-02 20:59:34.513 [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-02-02 20:59:34.516 [DefaultDispatcher-worker-3 @coroutine#109] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39877/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-02-02 20:59:34.516 [DefaultDispatcher-worker-3 @coroutine#109] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39877/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-02-02 20:59:34.516 [DefaultDispatcher-worker-3 @coroutine#109] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39877/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-02-02 20:59:34.517 [DefaultDispatcher-worker-3 @coroutine#109] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:39877/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100. 2026-02-02 20:59:36.619 [Test worker @coroutine#118] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-02 20:59:36.620 [Test worker @coroutine#118] INFO io.ktor.server.Application - Application started in 0.035 seconds. 2026-02-02 20:59:36.621 [DefaultDispatcher-worker-3 @coroutine#127] INFO io.ktor.server.Application - Responding at http://0.0.0.0:39517 2026-02-02 20:59:36.624 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39517/api/school/respect/person?includeRelated=false 2026-02-02 20:59:36.624 [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:39517/api/school/respect/person?includeRelated=false. 2026-02-02 20:59:36.624 [Test worker @coroutine#118] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39517/api/school/respect/person?includeRelated=false 2026-02-02 20:59:36.626 [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-02-02 20:59:36.630 [Test worker @coroutine#118] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39517/api/school/respect/person?includeRelated=false 2026-02-02 20:59:36.630 [Test worker @coroutine#118] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39517/api/school/respect/person?includeRelated=false 2026-02-02 20:59:36.630 [Test worker @coroutine#118] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39517/api/school/respect/person?includeRelated=false 2026-02-02 20:59:36.631 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:39517/api/school/respect/person?includeRelated=false. 2026-02-02 20:59:36.672 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39517/api/school/respect/person?since=2026-02-02T19%3A59%3A36.627210975Z&includeRelated=false 2026-02-02 20:59:36.672 [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:39517/api/school/respect/person?since=2026-02-02T19%3A59%3A36.627210975Z&includeRelated=false. 2026-02-02 20:59:36.672 [Test worker @coroutine#118] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39517/api/school/respect/person?since=2026-02-02T19%3A59%3A36.627210975Z&includeRelated=false 2026-02-02 20:59:36.674 [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-02-02 20:59:36.677 [Test worker @coroutine#118] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39517/api/school/respect/person?since=2026-02-02T19%3A59%3A36.627210975Z&includeRelated=false 2026-02-02 20:59:36.677 [Test worker @coroutine#118] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39517/api/school/respect/person?since=2026-02-02T19%3A59%3A36.627210975Z&includeRelated=false 2026-02-02 20:59:36.677 [Test worker @coroutine#118] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39517/api/school/respect/person?since=2026-02-02T19%3A59%3A36.627210975Z&includeRelated=false 2026-02-02 20:59:36.678 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:39517/api/school/respect/person?since=2026-02-02T19%3A59%3A36.627210975Z&includeRelated=false. 2026-02-02 20:59:38.765 [Test worker @coroutine#144] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-02 20:59:38.766 [Test worker @coroutine#144] INFO io.ktor.server.Application - Application started in 0.029 seconds. 2026-02-02 20:59:38.767 [DefaultDispatcher-worker-3 @coroutine#153] INFO io.ktor.server.Application - Responding at http://0.0.0.0:33103 2026-02-02 20:59:38.799 [DefaultDispatcher-worker-2 @coroutine#151] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33103/api/school/respect/person 2026-02-02 20:59:38.799 [DefaultDispatcher-worker-2 @coroutine#151] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@6d6bb09a for http://localhost:33103/api/school/respect/person 2026-02-02 20:59:38.799 [DefaultDispatcher-worker-2 @coroutine#151] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33103/api/school/respect/person 2026-02-02 20:59:38.799 [DefaultDispatcher-worker-2 @coroutine#151] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:33103/api/school/respect/person from class io.ktor.http.content.TextContent 2026-02-02 20:59:38.803 [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-02-02 20:59:38.808 [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-02-02 20:59:38.810 [DefaultDispatcher-worker-2 @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-02-02 20:59:38.811 [DefaultDispatcher-worker-1 @coroutine#151] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33103/api/school/respect/person 2026-02-02 20:59:38.811 [DefaultDispatcher-worker-1 @coroutine#151] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33103/api/school/respect/person 2026-02-02 20:59:38.811 [DefaultDispatcher-worker-1 @coroutine#151] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33103/api/school/respect/person 2026-02-02 20:59:40.896 [Test worker @coroutine#168] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-02 20:59:40.896 [Test worker @coroutine#168] INFO io.ktor.server.Application - Application started in 0.029 seconds. 2026-02-02 20:59:40.897 [DefaultDispatcher-worker-7 @coroutine#177] INFO io.ktor.server.Application - Responding at http://0.0.0.0:35929 2026-02-02 20:59:40.898 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35929/api/school/respect/schoolpermissiongrant 2026-02-02 20:59:40.898 [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:35929/api/school/respect/schoolpermissiongrant. 2026-02-02 20:59:40.898 [Test worker @coroutine#168] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35929/api/school/respect/schoolpermissiongrant 2026-02-02 20:59:40.900 [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-02-02 20:59:40.902 [Test worker @coroutine#168] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35929/api/school/respect/schoolpermissiongrant 2026-02-02 20:59:40.902 [Test worker @coroutine#168] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35929/api/school/respect/schoolpermissiongrant 2026-02-02 20:59:40.902 [Test worker @coroutine#168] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35929/api/school/respect/schoolpermissiongrant 2026-02-02 20:59:40.903 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:35929/api/school/respect/schoolpermissiongrant. 2026-02-02 20:59:40.942 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35929/api/school/respect/person?includeRelated=false 2026-02-02 20:59:40.942 [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:35929/api/school/respect/person?includeRelated=false. 2026-02-02 20:59:40.942 [Test worker @coroutine#168] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35929/api/school/respect/person?includeRelated=false 2026-02-02 20:59:40.943 [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-02-02 20:59:40.949 [Test worker @coroutine#168] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35929/api/school/respect/person?includeRelated=false 2026-02-02 20:59:40.950 [Test worker @coroutine#168] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35929/api/school/respect/person?includeRelated=false 2026-02-02 20:59:40.950 [Test worker @coroutine#168] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35929/api/school/respect/person?includeRelated=false 2026-02-02 20:59:40.950 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:35929/api/school/respect/person?includeRelated=false. 2026-02-02 20:59:42.956 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35929/api/school/respect/person?includeRelated=false 2026-02-02 20:59:42.956 [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:35929/api/school/respect/person?includeRelated=false. 2026-02-02 20:59:42.956 [Test worker @coroutine#168] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35929/api/school/respect/person?includeRelated=false 2026-02-02 20:59:42.957 [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-02-02 20:59:42.960 [Test worker @coroutine#168] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35929/api/school/respect/person?includeRelated=false 2026-02-02 20:59:42.960 [Test worker @coroutine#168] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35929/api/school/respect/person?includeRelated=false 2026-02-02 20:59:42.960 [Test worker @coroutine#168] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35929/api/school/respect/person?includeRelated=false 2026-02-02 20:59:42.961 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:35929/api/school/respect/person?includeRelated=false. 2026-02-02 20:59:45.048 [Test worker @coroutine#200] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-02 20:59:45.048 [Test worker @coroutine#200] INFO io.ktor.server.Application - Application started in 0.028 seconds. 2026-02-02 20:59:45.049 [DefaultDispatcher-worker-8 @coroutine#209] INFO io.ktor.server.Application - Responding at http://0.0.0.0:34939 2026-02-02 20:59:45.052 [Test worker @coroutine#200] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34939/api/school/respect/person?includeRelated=false 2026-02-02 20:59:45.052 [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:34939/api/school/respect/person?includeRelated=false. 2026-02-02 20:59:45.052 [Test worker @coroutine#200] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34939/api/school/respect/person?includeRelated=false 2026-02-02 20:59:45.054 [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-02-02 20:59:45.058 [Test worker @coroutine#200] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34939/api/school/respect/person?includeRelated=false 2026-02-02 20:59:45.058 [Test worker @coroutine#200] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34939/api/school/respect/person?includeRelated=false 2026-02-02 20:59:45.058 [Test worker @coroutine#200] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34939/api/school/respect/person?includeRelated=false 2026-02-02 20:59:45.059 [Test worker @coroutine#200] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34939/api/school/respect/person?includeRelated=false. 2026-02-02 20:59:45.089 [Test worker @coroutine#200] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34939/api/school/respect/person?since=2026-02-02T19%3A59%3A45.055117131Z&includeRelated=false 2026-02-02 20:59:45.089 [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:34939/api/school/respect/person?since=2026-02-02T19%3A59%3A45.055117131Z&includeRelated=false. 2026-02-02 20:59:45.089 [Test worker @coroutine#200] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34939/api/school/respect/person?since=2026-02-02T19%3A59%3A45.055117131Z&includeRelated=false 2026-02-02 20:59:45.091 [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-02-02 20:59:45.093 [Test worker @coroutine#200] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34939/api/school/respect/person?since=2026-02-02T19%3A59%3A45.055117131Z&includeRelated=false 2026-02-02 20:59:45.093 [Test worker @coroutine#200] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34939/api/school/respect/person?since=2026-02-02T19%3A59%3A45.055117131Z&includeRelated=false 2026-02-02 20:59:45.093 [Test worker @coroutine#200] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34939/api/school/respect/person?since=2026-02-02T19%3A59%3A45.055117131Z&includeRelated=false 2026-02-02 20:59:45.094 [Test worker @coroutine#200] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34939/api/school/respect/person?since=2026-02-02T19%3A59%3A45.055117131Z&includeRelated=false.