2026-02-19 05:57:57.822 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-19 05:57:58.027 [Test worker] INFO io.ktor.server.Application - Application started in 0.617 seconds. 2026-02-19 05:57:58.277 [DefaultDispatcher-worker-2 @coroutine#2] INFO io.ktor.server.Application - Responding at http://0.0.0.0:33177 2026-02-19 05:57:58.931 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33177/resources/index.json 2026-02-19 05:57:58.938 [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:33177/resources/index.json. 2026-02-19 05:57:58.938 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33177/resources/index.json 2026-02-19 05:57:59.377 [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-19 05:57:59.459 [eventLoopGroupProxy-4-1 @call-handler#12] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 90ms 2026-02-19 05:57:59.467 [DefaultDispatcher-worker-2 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33177/resources/index.json 2026-02-19 05:57:59.471 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33177/resources/index.json 2026-02-19 05:57:59.473 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33177/resources/index.json 2026-02-19 05:57:59.507 [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:33177/resources/index.json. 2026-02-19 05:57:59.638 [DefaultDispatcher-worker-4 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33177/resources/index.json 2026-02-19 05:57:59.642 [DefaultDispatcher-worker-4 @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:33177/resources/index.json. 2026-02-19 05:57:59.643 [DefaultDispatcher-worker-4 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33177/resources/index.json 2026-02-19 05:57:59.658 [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-19 05:57:59.666 [eventLoopGroupProxy-4-1 @call-handler#22] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 10ms 2026-02-19 05:57:59.668 [DefaultDispatcher-worker-1 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33177/resources/index.json 2026-02-19 05:57:59.669 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33177/resources/index.json 2026-02-19 05:57:59.669 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33177/resources/index.json 2026-02-19 05:58:01.792 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-19 05:58:01.796 [Test worker] INFO io.ktor.server.Application - Application started in 0.004 seconds. 2026-02-19 05:58:01.804 [DefaultDispatcher-worker-1 @coroutine#26] INFO io.ktor.server.Application - Responding at http://0.0.0.0:41305 2026-02-19 05:58:01.911 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41305/resources/index.json 2026-02-19 05:58:01.915 [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:41305/resources/index.json. 2026-02-19 05:58:01.915 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41305/resources/index.json 2026-02-19 05:58:01.923 [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-19 05:58:01.927 [DefaultDispatcher-worker-4 @call-handler#35] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 4ms 2026-02-19 05:58:01.933 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41305/resources/index.json 2026-02-19 05:58:01.934 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41305/resources/index.json 2026-02-19 05:58:01.934 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41305/resources/index.json 2026-02-19 05:58:01.937 [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:41305/resources/index.json. 2026-02-19 05:58:01.952 [DefaultDispatcher-worker-8 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41305/resources/index.json 2026-02-19 05:58:01.953 [DefaultDispatcher-worker-8 @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:41305/resources/index.json. 2026-02-19 05:58:01.956 [DefaultDispatcher-worker-8 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41305/resources/index.json 2026-02-19 05:58:01.961 [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-19 05:58:01.962 [eventLoopGroupProxy-7-1 @call-handler#45] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms 2026-02-19 05:58:01.967 [DefaultDispatcher-worker-3 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41305/resources/index.json 2026-02-19 05:58:01.967 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41305/resources/index.json 2026-02-19 05:58:01.968 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41305/resources/index.json 2026-02-19 05:58:03.987 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-19 05:58:03.987 [Test worker] INFO io.ktor.server.Application - Application started in 0.0 seconds. 2026-02-19 05:58:03.988 [DefaultDispatcher-worker-3 @coroutine#49] INFO io.ktor.server.Application - Responding at http://0.0.0.0:34869 2026-02-19 05:58:03.992 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34869/resources/lesson001.json 2026-02-19 05:58:03.992 [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:34869/resources/lesson001.json. 2026-02-19 05:58:03.992 [Test worker @coroutine#52] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34869/resources/lesson001.json 2026-02-19 05:58:03.994 [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-19 05:58:03.995 [eventLoopGroupProxy-10-1 @call-handler#56] INFO io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 1ms 2026-02-19 05:58:03.996 [DefaultDispatcher-worker-3 @coroutine#52] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34869/resources/lesson001.json 2026-02-19 05:58:03.996 [DefaultDispatcher-worker-7 @coroutine#52] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34869/resources/lesson001.json 2026-02-19 05:58:03.996 [DefaultDispatcher-worker-7 @coroutine#52] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34869/resources/lesson001.json 2026-02-19 05:58:04.013 [DefaultDispatcher-worker-7 @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsPublication for http://localhost:34869/resources/lesson001.json. 2026-02-19 05:58:06.521 [Test worker @coroutine#61] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-19 05:58:06.530 [Test worker @coroutine#61] INFO io.ktor.server.Application - Application started in 0.426 seconds. 2026-02-19 05:58:06.534 [DefaultDispatcher-worker-3 @coroutine#70] INFO io.ktor.server.Application - Responding at http://0.0.0.0:44717 2026-02-19 05:58:06.544 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44717/api/school/respect/schoolpermissiongrant 2026-02-19 05:58:06.544 [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:44717/api/school/respect/schoolpermissiongrant. 2026-02-19 05:58:06.544 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44717/api/school/respect/schoolpermissiongrant 2026-02-19 05:58:06.551 [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-19 05:58:06.566 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44717/api/school/respect/schoolpermissiongrant 2026-02-19 05:58:06.566 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44717/api/school/respect/schoolpermissiongrant 2026-02-19 05:58:06.566 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44717/api/school/respect/schoolpermissiongrant 2026-02-19 05:58:06.568 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44717/api/school/respect/schoolpermissiongrant. 2026-02-19 05:58:06.651 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44717/api/school/respect/person?includeRelated=false 2026-02-19 05:58:06.652 [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:44717/api/school/respect/person?includeRelated=false. 2026-02-19 05:58:06.653 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44717/api/school/respect/person?includeRelated=false 2026-02-19 05:58:06.656 [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-19 05:58:06.686 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44717/api/school/respect/person?includeRelated=false 2026-02-19 05:58:06.687 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44717/api/school/respect/person?includeRelated=false 2026-02-19 05:58:06.687 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44717/api/school/respect/person?includeRelated=false 2026-02-19 05:58:06.689 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44717/api/school/respect/person?includeRelated=false. 2026-02-19 05:58:06.697 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44717/api/school/respect/person?includeRelated=false 2026-02-19 05:58:06.698 [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:44717/api/school/respect/person?includeRelated=false. 2026-02-19 05:58:06.698 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44717/api/school/respect/person?includeRelated=false 2026-02-19 05:58:06.700 [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-19 05:58:06.702 [DefaultDispatcher-worker-3 @call-handler#86] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the GET /api/school/respect/person?includeRelated=false request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType]. 2026-02-19 05:58:06.704 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44717/api/school/respect/person?includeRelated=false 2026-02-19 05:58:06.704 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44717/api/school/respect/person?includeRelated=false 2026-02-19 05:58:06.704 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44717/api/school/respect/person?includeRelated=false 2026-02-19 05:58:08.935 [Test worker @coroutine#90] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-19 05:58:08.944 [Test worker @coroutine#90] INFO io.ktor.server.Application - Application started in 0.083 seconds. 2026-02-19 05:58:08.955 [DefaultDispatcher-worker-8 @coroutine#98] INFO io.ktor.server.Application - Responding at http://0.0.0.0:40437 2026-02-19 05:58:08.958 [Test worker @coroutine#90] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40437/api/school/respect/schoolpermissiongrant 2026-02-19 05:58:08.959 [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:40437/api/school/respect/schoolpermissiongrant. 2026-02-19 05:58:08.959 [Test worker @coroutine#90] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40437/api/school/respect/schoolpermissiongrant 2026-02-19 05:58:08.969 [eventLoopGroupProxy-16-1 @call-handler#102] 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-19 05:58:08.975 [Test worker @coroutine#90] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40437/api/school/respect/schoolpermissiongrant 2026-02-19 05:58:08.977 [Test worker @coroutine#90] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40437/api/school/respect/schoolpermissiongrant 2026-02-19 05:58:08.977 [Test worker @coroutine#90] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40437/api/school/respect/schoolpermissiongrant 2026-02-19 05:58:08.981 [Test worker @coroutine#90] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:40437/api/school/respect/schoolpermissiongrant. 2026-02-19 05:58:09.102 [DefaultDispatcher-worker-2 @coroutine#108] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40437/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-02-19 05:58:09.103 [DefaultDispatcher-worker-2 @coroutine#108] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:40437/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100. 2026-02-19 05:58:09.103 [DefaultDispatcher-worker-2 @coroutine#108] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40437/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-02-19 05:58:09.114 [eventLoopGroupProxy-16-1 @call-handler#112] 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-19 05:58:09.132 [DefaultDispatcher-worker-8 @coroutine#108] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40437/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-02-19 05:58:09.133 [DefaultDispatcher-worker-4 @coroutine#108] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40437/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-02-19 05:58:09.135 [DefaultDispatcher-worker-4 @coroutine#108] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40437/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-02-19 05:58:09.137 [DefaultDispatcher-worker-4 @coroutine#108] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:40437/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100. 2026-02-19 05:58:11.354 [Test worker @coroutine#117] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-19 05:58:11.355 [Test worker @coroutine#117] INFO io.ktor.server.Application - Application started in 0.061 seconds. 2026-02-19 05:58:11.362 [DefaultDispatcher-worker-4 @coroutine#126] INFO io.ktor.server.Application - Responding at http://0.0.0.0:43601 2026-02-19 05:58:11.376 [Test worker @coroutine#117] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43601/api/school/respect/person?includeRelated=false 2026-02-19 05:58:11.376 [Test worker @coroutine#117] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:43601/api/school/respect/person?includeRelated=false. 2026-02-19 05:58:11.376 [Test worker @coroutine#117] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43601/api/school/respect/person?includeRelated=false 2026-02-19 05:58:11.390 [eventLoopGroupProxy-19-1 @call-handler#131] 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-19 05:58:11.405 [Test worker @coroutine#117] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43601/api/school/respect/person?includeRelated=false 2026-02-19 05:58:11.406 [Test worker @coroutine#117] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43601/api/school/respect/person?includeRelated=false 2026-02-19 05:58:11.406 [Test worker @coroutine#117] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43601/api/school/respect/person?includeRelated=false 2026-02-19 05:58:11.411 [Test worker @coroutine#117] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:43601/api/school/respect/person?includeRelated=false. 2026-02-19 05:58:11.551 [Test worker @coroutine#117] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43601/api/school/respect/person?since=2026-02-19T04%3A58%3A11.391057566Z&includeRelated=false 2026-02-19 05:58:11.551 [Test worker @coroutine#117] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:43601/api/school/respect/person?since=2026-02-19T04%3A58%3A11.391057566Z&includeRelated=false. 2026-02-19 05:58:11.551 [Test worker @coroutine#117] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43601/api/school/respect/person?since=2026-02-19T04%3A58%3A11.391057566Z&includeRelated=false 2026-02-19 05:58:11.568 [eventLoopGroupProxy-19-1 @call-handler#137] 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-19 05:58:11.576 [Test worker @coroutine#117] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43601/api/school/respect/person?since=2026-02-19T04%3A58%3A11.391057566Z&includeRelated=false 2026-02-19 05:58:11.576 [Test worker @coroutine#117] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43601/api/school/respect/person?since=2026-02-19T04%3A58%3A11.391057566Z&includeRelated=false 2026-02-19 05:58:11.576 [Test worker @coroutine#117] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43601/api/school/respect/person?since=2026-02-19T04%3A58%3A11.391057566Z&includeRelated=false 2026-02-19 05:58:11.577 [Test worker @coroutine#117] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:43601/api/school/respect/person?since=2026-02-19T04%3A58%3A11.391057566Z&includeRelated=false. 2026-02-19 05:58:13.808 [Test worker @coroutine#143] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-19 05:58:13.814 [Test worker @coroutine#143] INFO io.ktor.server.Application - Application started in 0.068 seconds. 2026-02-19 05:58:13.824 [DefaultDispatcher-worker-8 @coroutine#151] INFO io.ktor.server.Application - Responding at http://0.0.0.0:46009 2026-02-19 05:58:13.910 [DefaultDispatcher-worker-6 @coroutine#149] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46009/api/school/respect/person 2026-02-19 05:58:13.911 [DefaultDispatcher-worker-6 @coroutine#149] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@cc82287 for http://localhost:46009/api/school/respect/person 2026-02-19 05:58:13.911 [DefaultDispatcher-worker-6 @coroutine#149] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46009/api/school/respect/person 2026-02-19 05:58:13.912 [DefaultDispatcher-worker-6 @coroutine#149] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:46009/api/school/respect/person from class io.ktor.http.content.TextContent 2026-02-19 05:58:13.929 [eventLoopGroupProxy-22-1 @call-handler#161] 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-19 05:58:13.947 [eventLoopGroupProxy-22-1 @call-handler#161] 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-19 05:58:13.954 [eventLoopGroupProxy-22-1 @call-handler#161] 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-19 05:58:13.961 [DefaultDispatcher-worker-7 @coroutine#149] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46009/api/school/respect/person 2026-02-19 05:58:13.961 [DefaultDispatcher-worker-7 @coroutine#149] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46009/api/school/respect/person 2026-02-19 05:58:13.961 [DefaultDispatcher-worker-7 @coroutine#149] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46009/api/school/respect/person 2026-02-19 05:58:16.200 [Test worker @coroutine#166] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-19 05:58:16.201 [Test worker @coroutine#166] INFO io.ktor.server.Application - Application started in 0.067 seconds. 2026-02-19 05:58:16.203 [DefaultDispatcher-worker-11 @coroutine#175] INFO io.ktor.server.Application - Responding at http://0.0.0.0:39313 2026-02-19 05:58:16.204 [Test worker @coroutine#166] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39313/api/school/respect/schoolpermissiongrant 2026-02-19 05:58:16.204 [Test worker @coroutine#166] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:39313/api/school/respect/schoolpermissiongrant. 2026-02-19 05:58:16.204 [Test worker @coroutine#166] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39313/api/school/respect/schoolpermissiongrant 2026-02-19 05:58:16.207 [eventLoopGroupProxy-25-1 @call-handler#179] 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-19 05:58:16.213 [Test worker @coroutine#166] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39313/api/school/respect/schoolpermissiongrant 2026-02-19 05:58:16.217 [Test worker @coroutine#166] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39313/api/school/respect/schoolpermissiongrant 2026-02-19 05:58:16.217 [Test worker @coroutine#166] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39313/api/school/respect/schoolpermissiongrant 2026-02-19 05:58:16.218 [Test worker @coroutine#166] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:39313/api/school/respect/schoolpermissiongrant. 2026-02-19 05:58:16.268 [Test worker @coroutine#166] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39313/api/school/respect/person?includeRelated=false 2026-02-19 05:58:16.268 [Test worker @coroutine#166] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:39313/api/school/respect/person?includeRelated=false. 2026-02-19 05:58:16.268 [Test worker @coroutine#166] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39313/api/school/respect/person?includeRelated=false 2026-02-19 05:58:16.270 [eventLoopGroupProxy-25-1 @call-handler#185] 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-19 05:58:16.278 [Test worker @coroutine#166] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39313/api/school/respect/person?includeRelated=false 2026-02-19 05:58:16.279 [Test worker @coroutine#166] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39313/api/school/respect/person?includeRelated=false 2026-02-19 05:58:16.279 [Test worker @coroutine#166] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39313/api/school/respect/person?includeRelated=false 2026-02-19 05:58:16.280 [Test worker @coroutine#166] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:39313/api/school/respect/person?includeRelated=false. 2026-02-19 05:58:18.286 [Test worker @coroutine#166] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39313/api/school/respect/person?includeRelated=false 2026-02-19 05:58:18.286 [Test worker @coroutine#166] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:39313/api/school/respect/person?includeRelated=false. 2026-02-19 05:58:18.286 [Test worker @coroutine#166] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39313/api/school/respect/person?includeRelated=false 2026-02-19 05:58:18.288 [eventLoopGroupProxy-25-1 @call-handler#192] 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-19 05:58:18.291 [Test worker @coroutine#166] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39313/api/school/respect/person?includeRelated=false 2026-02-19 05:58:18.291 [Test worker @coroutine#166] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39313/api/school/respect/person?includeRelated=false 2026-02-19 05:58:18.291 [Test worker @coroutine#166] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39313/api/school/respect/person?includeRelated=false 2026-02-19 05:58:18.292 [Test worker @coroutine#166] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:39313/api/school/respect/person?includeRelated=false. 2026-02-19 05:58:20.405 [Test worker @coroutine#198] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-19 05:58:20.406 [Test worker @coroutine#198] INFO io.ktor.server.Application - Application started in 0.039 seconds. 2026-02-19 05:58:20.407 [DefaultDispatcher-worker-7 @coroutine#207] INFO io.ktor.server.Application - Responding at http://0.0.0.0:40207 2026-02-19 05:58:20.410 [Test worker @coroutine#198] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40207/api/school/respect/person?includeRelated=false 2026-02-19 05:58:20.410 [Test worker @coroutine#198] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:40207/api/school/respect/person?includeRelated=false. 2026-02-19 05:58:20.410 [Test worker @coroutine#198] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40207/api/school/respect/person?includeRelated=false 2026-02-19 05:58:20.412 [eventLoopGroupProxy-28-1 @call-handler#212] 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-19 05:58:20.416 [Test worker @coroutine#198] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40207/api/school/respect/person?includeRelated=false 2026-02-19 05:58:20.416 [Test worker @coroutine#198] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40207/api/school/respect/person?includeRelated=false 2026-02-19 05:58:20.416 [Test worker @coroutine#198] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40207/api/school/respect/person?includeRelated=false 2026-02-19 05:58:20.417 [Test worker @coroutine#198] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:40207/api/school/respect/person?includeRelated=false. 2026-02-19 05:58:20.457 [Test worker @coroutine#198] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40207/api/school/respect/person?since=2026-02-19T04%3A58%3A20.412669745Z&includeRelated=false 2026-02-19 05:58:20.457 [Test worker @coroutine#198] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:40207/api/school/respect/person?since=2026-02-19T04%3A58%3A20.412669745Z&includeRelated=false. 2026-02-19 05:58:20.457 [Test worker @coroutine#198] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40207/api/school/respect/person?since=2026-02-19T04%3A58%3A20.412669745Z&includeRelated=false 2026-02-19 05:58:20.458 [eventLoopGroupProxy-28-1 @call-handler#219] 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-19 05:58:20.461 [Test worker @coroutine#198] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40207/api/school/respect/person?since=2026-02-19T04%3A58%3A20.412669745Z&includeRelated=false 2026-02-19 05:58:20.461 [Test worker @coroutine#198] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40207/api/school/respect/person?since=2026-02-19T04%3A58%3A20.412669745Z&includeRelated=false 2026-02-19 05:58:20.461 [Test worker @coroutine#198] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40207/api/school/respect/person?since=2026-02-19T04%3A58%3A20.412669745Z&includeRelated=false 2026-02-19 05:58:20.462 [Test worker @coroutine#198] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:40207/api/school/respect/person?since=2026-02-19T04%3A58%3A20.412669745Z&includeRelated=false. 2026-02-19 16:29:58.009 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-19 16:29:58.196 [Test worker] INFO io.ktor.server.Application - Application started in 0.472 seconds. 2026-02-19 16:29:58.327 [DefaultDispatcher-worker-1 @coroutine#2] INFO io.ktor.server.Application - Responding at http://0.0.0.0:34665 2026-02-19 16:29:58.863 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34665/resources/index.json 2026-02-19 16:29:58.864 [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:34665/resources/index.json. 2026-02-19 16:29:58.864 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34665/resources/index.json 2026-02-19 16:29:59.138 [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-19 16:29:59.223 [DefaultDispatcher-worker-1 @call-handler#12] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 92ms 2026-02-19 16:29:59.232 [DefaultDispatcher-worker-1 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34665/resources/index.json 2026-02-19 16:29:59.237 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34665/resources/index.json 2026-02-19 16:29:59.237 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34665/resources/index.json 2026-02-19 16:29:59.266 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsFeed for http://localhost:34665/resources/index.json. 2026-02-19 16:29:59.380 [DefaultDispatcher-worker-4 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34665/resources/index.json 2026-02-19 16:29:59.381 [DefaultDispatcher-worker-4 @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:34665/resources/index.json. 2026-02-19 16:29:59.381 [DefaultDispatcher-worker-4 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34665/resources/index.json 2026-02-19 16:29:59.391 [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-19 16:29:59.399 [eventLoopGroupProxy-4-1 @call-handler#22] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 9ms 2026-02-19 16:29:59.404 [DefaultDispatcher-worker-3 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34665/resources/index.json 2026-02-19 16:29:59.405 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34665/resources/index.json 2026-02-19 16:29:59.405 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34665/resources/index.json 2026-02-19 16:30:01.510 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-19 16:30:01.512 [Test worker] INFO io.ktor.server.Application - Application started in 0.002 seconds. 2026-02-19 16:30:01.534 [DefaultDispatcher-worker-5 @coroutine#26] INFO io.ktor.server.Application - Responding at http://0.0.0.0:36581 2026-02-19 16:30:01.606 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36581/resources/index.json 2026-02-19 16:30:01.607 [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:36581/resources/index.json. 2026-02-19 16:30:01.607 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36581/resources/index.json 2026-02-19 16:30:01.632 [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-19 16:30:01.634 [eventLoopGroupProxy-7-1 @call-handler#35] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 2ms 2026-02-19 16:30:01.640 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36581/resources/index.json 2026-02-19 16:30:01.640 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36581/resources/index.json 2026-02-19 16:30:01.640 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36581/resources/index.json 2026-02-19 16:30:01.647 [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:36581/resources/index.json. 2026-02-19 16:30:01.660 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36581/resources/index.json 2026-02-19 16:30:01.661 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:36581/resources/index.json. 2026-02-19 16:30:01.661 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36581/resources/index.json 2026-02-19 16:30:01.665 [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-19 16:30:01.666 [eventLoopGroupProxy-7-1 @call-handler#45] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms 2026-02-19 16:30:01.672 [DefaultDispatcher-worker-1 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36581/resources/index.json 2026-02-19 16:30:01.672 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36581/resources/index.json 2026-02-19 16:30:01.672 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36581/resources/index.json 2026-02-19 16:30:03.747 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-19 16:30:03.748 [Test worker] INFO io.ktor.server.Application - Application started in 0.001 seconds. 2026-02-19 16:30:03.752 [DefaultDispatcher-worker-2 @coroutine#49] INFO io.ktor.server.Application - Responding at http://0.0.0.0:39857 2026-02-19 16:30:03.760 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39857/resources/lesson001.json 2026-02-19 16:30:03.760 [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:39857/resources/lesson001.json. 2026-02-19 16:30:03.761 [Test worker @coroutine#52] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39857/resources/lesson001.json 2026-02-19 16:30:03.767 [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-19 16:30:03.771 [eventLoopGroupProxy-10-1 @call-handler#56] INFO io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 4ms 2026-02-19 16:30:03.772 [DefaultDispatcher-worker-2 @coroutine#52] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39857/resources/lesson001.json 2026-02-19 16:30:03.772 [DefaultDispatcher-worker-2 @coroutine#52] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39857/resources/lesson001.json 2026-02-19 16:30:03.772 [DefaultDispatcher-worker-2 @coroutine#52] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39857/resources/lesson001.json 2026-02-19 16:30:03.832 [DefaultDispatcher-worker-2 @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsPublication for http://localhost:39857/resources/lesson001.json. 2026-02-19 16:30:07.232 [Test worker @coroutine#61] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-19 16:30:07.293 [Test worker @coroutine#61] INFO io.ktor.server.Application - Application started in 1.289 seconds. 2026-02-19 16:30:07.314 [DefaultDispatcher-worker-3 @coroutine#70] INFO io.ktor.server.Application - Responding at http://0.0.0.0:46295 2026-02-19 16:30:07.363 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46295/api/school/respect/schoolpermissiongrant 2026-02-19 16:30:07.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:46295/api/school/respect/schoolpermissiongrant. 2026-02-19 16:30:07.364 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46295/api/school/respect/schoolpermissiongrant 2026-02-19 16:30:07.382 [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-19 16:30:07.480 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46295/api/school/respect/schoolpermissiongrant 2026-02-19 16:30:07.482 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46295/api/school/respect/schoolpermissiongrant 2026-02-19 16:30:07.484 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46295/api/school/respect/schoolpermissiongrant 2026-02-19 16:30:07.493 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:46295/api/school/respect/schoolpermissiongrant. 2026-02-19 16:30:07.727 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46295/api/school/respect/person?includeRelated=false 2026-02-19 16:30:07.728 [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:46295/api/school/respect/person?includeRelated=false. 2026-02-19 16:30:07.728 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46295/api/school/respect/person?includeRelated=false 2026-02-19 16:30:07.739 [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-19 16:30:07.813 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46295/api/school/respect/person?includeRelated=false 2026-02-19 16:30:07.814 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46295/api/school/respect/person?includeRelated=false 2026-02-19 16:30:07.814 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46295/api/school/respect/person?includeRelated=false 2026-02-19 16:30:07.817 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:46295/api/school/respect/person?includeRelated=false. 2026-02-19 16:30:07.837 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46295/api/school/respect/person?includeRelated=false 2026-02-19 16:30:07.837 [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:46295/api/school/respect/person?includeRelated=false. 2026-02-19 16:30:07.837 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46295/api/school/respect/person?includeRelated=false 2026-02-19 16:30:07.848 [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-19 16:30:07.855 [DefaultDispatcher-worker-4 @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-19 16:30:07.857 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46295/api/school/respect/person?includeRelated=false 2026-02-19 16:30:07.857 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46295/api/school/respect/person?includeRelated=false 2026-02-19 16:30:07.857 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46295/api/school/respect/person?includeRelated=false 2026-02-19 16:30:10.135 [Test worker @coroutine#90] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-19 16:30:10.147 [Test worker @coroutine#90] INFO io.ktor.server.Application - Application started in 0.101 seconds. 2026-02-19 16:30:10.157 [DefaultDispatcher-worker-7 @coroutine#99] INFO io.ktor.server.Application - Responding at http://0.0.0.0:35671 2026-02-19 16:30:10.164 [Test worker @coroutine#90] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35671/api/school/respect/schoolpermissiongrant 2026-02-19 16:30:10.164 [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:35671/api/school/respect/schoolpermissiongrant. 2026-02-19 16:30:10.164 [Test worker @coroutine#90] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35671/api/school/respect/schoolpermissiongrant 2026-02-19 16:30:10.185 [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-19 16:30:10.191 [Test worker @coroutine#90] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35671/api/school/respect/schoolpermissiongrant 2026-02-19 16:30:10.192 [Test worker @coroutine#90] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35671/api/school/respect/schoolpermissiongrant 2026-02-19 16:30:10.192 [Test worker @coroutine#90] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35671/api/school/respect/schoolpermissiongrant 2026-02-19 16:30:10.193 [Test worker @coroutine#90] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:35671/api/school/respect/schoolpermissiongrant. 2026-02-19 16:30:10.325 [DefaultDispatcher-worker-2 @coroutine#109] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35671/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-02-19 16:30:10.325 [DefaultDispatcher-worker-2 @coroutine#109] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:35671/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100. 2026-02-19 16:30:10.326 [DefaultDispatcher-worker-2 @coroutine#109] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35671/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-02-19 16:30:10.336 [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-19 16:30:10.359 [DefaultDispatcher-worker-2 @coroutine#109] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35671/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-02-19 16:30:10.360 [DefaultDispatcher-worker-2 @coroutine#109] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35671/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-02-19 16:30:10.360 [DefaultDispatcher-worker-2 @coroutine#109] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35671/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-02-19 16:30:10.362 [DefaultDispatcher-worker-2 @coroutine#109] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:35671/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100. 2026-02-19 16:30:12.642 [Test worker @coroutine#118] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-19 16:30:12.649 [Test worker @coroutine#118] INFO io.ktor.server.Application - Application started in 0.08 seconds. 2026-02-19 16:30:12.662 [DefaultDispatcher-worker-1 @coroutine#127] INFO io.ktor.server.Application - Responding at http://0.0.0.0:37549 2026-02-19 16:30:12.673 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37549/api/school/respect/person?includeRelated=false 2026-02-19 16:30:12.674 [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:37549/api/school/respect/person?includeRelated=false. 2026-02-19 16:30:12.674 [Test worker @coroutine#118] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37549/api/school/respect/person?includeRelated=false 2026-02-19 16:30:12.696 [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-19 16:30:12.722 [Test worker @coroutine#118] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37549/api/school/respect/person?includeRelated=false 2026-02-19 16:30:12.723 [Test worker @coroutine#118] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37549/api/school/respect/person?includeRelated=false 2026-02-19 16:30:12.723 [Test worker @coroutine#118] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37549/api/school/respect/person?includeRelated=false 2026-02-19 16:30:12.729 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:37549/api/school/respect/person?includeRelated=false. 2026-02-19 16:30:12.835 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37549/api/school/respect/person?since=2026-02-19T12%3A30%3A12.699585553Z&includeRelated=false 2026-02-19 16:30:12.835 [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:37549/api/school/respect/person?since=2026-02-19T12%3A30%3A12.699585553Z&includeRelated=false. 2026-02-19 16:30:12.835 [Test worker @coroutine#118] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37549/api/school/respect/person?since=2026-02-19T12%3A30%3A12.699585553Z&includeRelated=false 2026-02-19 16:30:12.844 [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-19 16:30:12.877 [Test worker @coroutine#118] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37549/api/school/respect/person?since=2026-02-19T12%3A30%3A12.699585553Z&includeRelated=false 2026-02-19 16:30:12.877 [Test worker @coroutine#118] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37549/api/school/respect/person?since=2026-02-19T12%3A30%3A12.699585553Z&includeRelated=false 2026-02-19 16:30:12.877 [Test worker @coroutine#118] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37549/api/school/respect/person?since=2026-02-19T12%3A30%3A12.699585553Z&includeRelated=false 2026-02-19 16:30:12.881 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:37549/api/school/respect/person?since=2026-02-19T12%3A30%3A12.699585553Z&includeRelated=false. 2026-02-19 16:30:15.308 [Test worker @coroutine#144] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-19 16:30:15.311 [Test worker @coroutine#144] INFO io.ktor.server.Application - Application started in 0.111 seconds. 2026-02-19 16:30:15.319 [DefaultDispatcher-worker-1 @coroutine#153] INFO io.ktor.server.Application - Responding at http://0.0.0.0:35057 2026-02-19 16:30:15.446 [DefaultDispatcher-worker-3 @coroutine#151] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35057/api/school/respect/person 2026-02-19 16:30:15.446 [DefaultDispatcher-worker-3 @coroutine#151] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@70bdaae1 for http://localhost:35057/api/school/respect/person 2026-02-19 16:30:15.446 [DefaultDispatcher-worker-3 @coroutine#151] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35057/api/school/respect/person 2026-02-19 16:30:15.447 [DefaultDispatcher-worker-3 @coroutine#151] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:35057/api/school/respect/person from class io.ktor.http.content.TextContent 2026-02-19 16:30:15.469 [eventLoopGroupProxy-22-1 @call-handler#162] 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-19 16:30:15.492 [eventLoopGroupProxy-22-1 @call-handler#162] 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-19 16:30:15.505 [DefaultDispatcher-worker-3 @call-handler#162] 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-19 16:30:15.522 [DefaultDispatcher-worker-6 @coroutine#151] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35057/api/school/respect/person 2026-02-19 16:30:15.522 [DefaultDispatcher-worker-6 @coroutine#151] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35057/api/school/respect/person 2026-02-19 16:30:15.522 [DefaultDispatcher-worker-6 @coroutine#151] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35057/api/school/respect/person 2026-02-19 16:30:17.700 [Test worker @coroutine#167] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-19 16:30:17.706 [Test worker @coroutine#167] INFO io.ktor.server.Application - Application started in 0.062 seconds. 2026-02-19 16:30:17.730 [DefaultDispatcher-worker-7 @coroutine#176] INFO io.ktor.server.Application - Responding at http://0.0.0.0:37605 2026-02-19 16:30:17.731 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37605/api/school/respect/schoolpermissiongrant 2026-02-19 16:30:17.732 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:37605/api/school/respect/schoolpermissiongrant. 2026-02-19 16:30:17.732 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37605/api/school/respect/schoolpermissiongrant 2026-02-19 16:30:17.740 [eventLoopGroupProxy-25-1 @call-handler#180] 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-19 16:30:17.749 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37605/api/school/respect/schoolpermissiongrant 2026-02-19 16:30:17.750 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37605/api/school/respect/schoolpermissiongrant 2026-02-19 16:30:17.751 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37605/api/school/respect/schoolpermissiongrant 2026-02-19 16:30:17.753 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:37605/api/school/respect/schoolpermissiongrant. 2026-02-19 16:30:17.822 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37605/api/school/respect/person?includeRelated=false 2026-02-19 16:30:17.822 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:37605/api/school/respect/person?includeRelated=false. 2026-02-19 16:30:17.822 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37605/api/school/respect/person?includeRelated=false 2026-02-19 16:30:17.832 [eventLoopGroupProxy-25-1 @call-handler#186] 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-19 16:30:17.865 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37605/api/school/respect/person?includeRelated=false 2026-02-19 16:30:17.867 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37605/api/school/respect/person?includeRelated=false 2026-02-19 16:30:17.867 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37605/api/school/respect/person?includeRelated=false 2026-02-19 16:30:17.869 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:37605/api/school/respect/person?includeRelated=false. 2026-02-19 16:30:19.905 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37605/api/school/respect/person?includeRelated=false 2026-02-19 16:30:19.906 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:37605/api/school/respect/person?includeRelated=false. 2026-02-19 16:30:19.906 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37605/api/school/respect/person?includeRelated=false 2026-02-19 16:30:19.910 [eventLoopGroupProxy-25-1 @call-handler#193] 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-19 16:30:19.918 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37605/api/school/respect/person?includeRelated=false 2026-02-19 16:30:19.919 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37605/api/school/respect/person?includeRelated=false 2026-02-19 16:30:19.921 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37605/api/school/respect/person?includeRelated=false 2026-02-19 16:30:19.922 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:37605/api/school/respect/person?includeRelated=false. 2026-02-19 16:30:22.244 [Test worker @coroutine#199] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-19 16:30:22.253 [Test worker @coroutine#199] INFO io.ktor.server.Application - Application started in 0.078 seconds. 2026-02-19 16:30:22.264 [DefaultDispatcher-worker-9 @coroutine#208] INFO io.ktor.server.Application - Responding at http://0.0.0.0:44597 2026-02-19 16:30:22.290 [Test worker @coroutine#199] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44597/api/school/respect/person?includeRelated=false 2026-02-19 16:30:22.291 [Test worker @coroutine#199] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:44597/api/school/respect/person?includeRelated=false. 2026-02-19 16:30:22.291 [Test worker @coroutine#199] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44597/api/school/respect/person?includeRelated=false 2026-02-19 16:30:22.312 [eventLoopGroupProxy-28-1 @call-handler#213] 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-19 16:30:22.321 [Test worker @coroutine#199] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44597/api/school/respect/person?includeRelated=false 2026-02-19 16:30:22.321 [Test worker @coroutine#199] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44597/api/school/respect/person?includeRelated=false 2026-02-19 16:30:22.321 [Test worker @coroutine#199] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44597/api/school/respect/person?includeRelated=false 2026-02-19 16:30:22.327 [Test worker @coroutine#199] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44597/api/school/respect/person?includeRelated=false. 2026-02-19 16:30:22.423 [Test worker @coroutine#199] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44597/api/school/respect/person?since=2026-02-19T12%3A30%3A22.313108222Z&includeRelated=false 2026-02-19 16:30:22.423 [Test worker @coroutine#199] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:44597/api/school/respect/person?since=2026-02-19T12%3A30%3A22.313108222Z&includeRelated=false. 2026-02-19 16:30:22.423 [Test worker @coroutine#199] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44597/api/school/respect/person?since=2026-02-19T12%3A30%3A22.313108222Z&includeRelated=false 2026-02-19 16:30:22.426 [eventLoopGroupProxy-28-1 @call-handler#220] 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-19 16:30:22.435 [Test worker @coroutine#199] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44597/api/school/respect/person?since=2026-02-19T12%3A30%3A22.313108222Z&includeRelated=false 2026-02-19 16:30:22.436 [Test worker @coroutine#199] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44597/api/school/respect/person?since=2026-02-19T12%3A30%3A22.313108222Z&includeRelated=false 2026-02-19 16:30:22.436 [Test worker @coroutine#199] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44597/api/school/respect/person?since=2026-02-19T12%3A30%3A22.313108222Z&includeRelated=false 2026-02-19 16:30:22.437 [Test worker @coroutine#199] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44597/api/school/respect/person?since=2026-02-19T12%3A30%3A22.313108222Z&includeRelated=false. 2026-02-19 20:50:30.347 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-19 20:50:30.430 [Test worker] INFO io.ktor.server.Application - Application started in 0.202 seconds. 2026-02-19 20:50:30.518 [DefaultDispatcher-worker-2 @coroutine#2] INFO io.ktor.server.Application - Responding at http://0.0.0.0:35179 2026-02-19 20:50:30.777 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35179/resources/index.json 2026-02-19 20:50:30.778 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:35179/resources/index.json. 2026-02-19 20:50:30.778 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35179/resources/index.json 2026-02-19 20:50:30.913 [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-19 20:50:30.955 [DefaultDispatcher-worker-2 @call-handler#12] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 48ms 2026-02-19 20:50:30.960 [DefaultDispatcher-worker-2 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35179/resources/index.json 2026-02-19 20:50:30.962 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35179/resources/index.json 2026-02-19 20:50:30.963 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35179/resources/index.json 2026-02-19 20:50:30.984 [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:35179/resources/index.json. 2026-02-19 20:50:31.014 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35179/resources/index.json 2026-02-19 20:50:31.014 [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:35179/resources/index.json. 2026-02-19 20:50:31.014 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35179/resources/index.json 2026-02-19 20:50:31.017 [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-19 20:50:31.018 [eventLoopGroupProxy-4-1 @call-handler#22] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms 2026-02-19 20:50:31.019 [DefaultDispatcher-worker-3 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35179/resources/index.json 2026-02-19 20:50:31.019 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35179/resources/index.json 2026-02-19 20:50:31.019 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35179/resources/index.json 2026-02-19 20:50:33.030 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-19 20:50:33.030 [Test worker] INFO io.ktor.server.Application - Application started in 0.0 seconds. 2026-02-19 20:50:33.033 [DefaultDispatcher-worker-3 @coroutine#26] INFO io.ktor.server.Application - Responding at http://0.0.0.0:44715 2026-02-19 20:50:33.108 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44715/resources/index.json 2026-02-19 20:50:33.108 [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:44715/resources/index.json. 2026-02-19 20:50:33.108 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44715/resources/index.json 2026-02-19 20:50:33.111 [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-19 20:50:33.112 [DefaultDispatcher-worker-3 @call-handler#35] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 1ms 2026-02-19 20:50:33.113 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44715/resources/index.json 2026-02-19 20:50:33.113 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44715/resources/index.json 2026-02-19 20:50:33.113 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44715/resources/index.json 2026-02-19 20:50:33.114 [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:44715/resources/index.json. 2026-02-19 20:50:33.118 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44715/resources/index.json 2026-02-19 20:50:33.118 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:44715/resources/index.json. 2026-02-19 20:50:33.118 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44715/resources/index.json 2026-02-19 20:50:33.119 [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-19 20:50:33.120 [eventLoopGroupProxy-7-1 @call-handler#45] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms 2026-02-19 20:50:33.120 [DefaultDispatcher-worker-3 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44715/resources/index.json 2026-02-19 20:50:33.120 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44715/resources/index.json 2026-02-19 20:50:33.120 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44715/resources/index.json 2026-02-19 20:50:35.125 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-19 20:50:35.126 [Test worker] INFO io.ktor.server.Application - Application started in 0.001 seconds. 2026-02-19 20:50:35.127 [DefaultDispatcher-worker-3 @coroutine#49] INFO io.ktor.server.Application - Responding at http://0.0.0.0:39179 2026-02-19 20:50:35.130 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39179/resources/lesson001.json 2026-02-19 20:50:35.130 [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:39179/resources/lesson001.json. 2026-02-19 20:50:35.130 [Test worker @coroutine#52] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39179/resources/lesson001.json 2026-02-19 20:50:35.133 [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-19 20:50:35.134 [DefaultDispatcher-worker-1 @call-handler#56] INFO io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 2ms 2026-02-19 20:50:35.135 [DefaultDispatcher-worker-1 @coroutine#52] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39179/resources/lesson001.json 2026-02-19 20:50:35.135 [DefaultDispatcher-worker-3 @coroutine#52] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39179/resources/lesson001.json 2026-02-19 20:50:35.135 [DefaultDispatcher-worker-3 @coroutine#52] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39179/resources/lesson001.json 2026-02-19 20:50:35.154 [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:39179/resources/lesson001.json. 2026-02-19 20:50:37.715 [Test worker @coroutine#61] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-19 20:50:37.724 [Test worker @coroutine#61] INFO io.ktor.server.Application - Application started in 0.473 seconds. 2026-02-19 20:50:37.727 [DefaultDispatcher-worker-5 @coroutine#70] INFO io.ktor.server.Application - Responding at http://0.0.0.0:34125 2026-02-19 20:50:37.739 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34125/api/school/respect/schoolpermissiongrant 2026-02-19 20:50:37.739 [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:34125/api/school/respect/schoolpermissiongrant. 2026-02-19 20:50:37.739 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34125/api/school/respect/schoolpermissiongrant 2026-02-19 20:50:37.747 [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-19 20:50:37.765 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34125/api/school/respect/schoolpermissiongrant 2026-02-19 20:50:37.765 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34125/api/school/respect/schoolpermissiongrant 2026-02-19 20:50:37.765 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34125/api/school/respect/schoolpermissiongrant 2026-02-19 20:50:37.767 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34125/api/school/respect/schoolpermissiongrant. 2026-02-19 20:50:37.842 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34125/api/school/respect/person?includeRelated=false 2026-02-19 20:50:37.842 [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:34125/api/school/respect/person?includeRelated=false. 2026-02-19 20:50:37.842 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34125/api/school/respect/person?includeRelated=false 2026-02-19 20:50:37.844 [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-19 20:50:37.863 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34125/api/school/respect/person?includeRelated=false 2026-02-19 20:50:37.863 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34125/api/school/respect/person?includeRelated=false 2026-02-19 20:50:37.863 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34125/api/school/respect/person?includeRelated=false 2026-02-19 20:50:37.864 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34125/api/school/respect/person?includeRelated=false. 2026-02-19 20:50:37.870 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34125/api/school/respect/person?includeRelated=false 2026-02-19 20:50:37.870 [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:34125/api/school/respect/person?includeRelated=false. 2026-02-19 20:50:37.870 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34125/api/school/respect/person?includeRelated=false 2026-02-19 20:50:37.872 [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-19 20:50:37.874 [DefaultDispatcher-worker-1 @call-handler#86] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the GET /api/school/respect/person?includeRelated=false request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType]. 2026-02-19 20:50:37.875 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34125/api/school/respect/person?includeRelated=false 2026-02-19 20:50:37.875 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34125/api/school/respect/person?includeRelated=false 2026-02-19 20:50:37.875 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34125/api/school/respect/person?includeRelated=false 2026-02-19 20:50:40.000 [Test worker @coroutine#90] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-19 20:50:40.001 [Test worker @coroutine#90] INFO io.ktor.server.Application - Application started in 0.044 seconds. 2026-02-19 20:50:40.002 [DefaultDispatcher-worker-1 @coroutine#99] INFO io.ktor.server.Application - Responding at http://0.0.0.0:35345 2026-02-19 20:50:40.003 [Test worker @coroutine#90] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35345/api/school/respect/schoolpermissiongrant 2026-02-19 20:50:40.004 [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:35345/api/school/respect/schoolpermissiongrant. 2026-02-19 20:50:40.004 [Test worker @coroutine#90] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35345/api/school/respect/schoolpermissiongrant 2026-02-19 20:50:40.007 [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-19 20:50:40.009 [Test worker @coroutine#90] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35345/api/school/respect/schoolpermissiongrant 2026-02-19 20:50:40.009 [Test worker @coroutine#90] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35345/api/school/respect/schoolpermissiongrant 2026-02-19 20:50:40.009 [Test worker @coroutine#90] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35345/api/school/respect/schoolpermissiongrant 2026-02-19 20:50:40.009 [Test worker @coroutine#90] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:35345/api/school/respect/schoolpermissiongrant. 2026-02-19 20:50:40.069 [DefaultDispatcher-worker-1 @coroutine#109] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35345/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-02-19 20:50:40.070 [DefaultDispatcher-worker-1 @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:35345/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100. 2026-02-19 20:50:40.070 [DefaultDispatcher-worker-1 @coroutine#109] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35345/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-02-19 20:50:40.071 [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-19 20:50:40.074 [DefaultDispatcher-worker-5 @coroutine#109] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35345/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-02-19 20:50:40.074 [DefaultDispatcher-worker-5 @coroutine#109] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35345/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-02-19 20:50:40.074 [DefaultDispatcher-worker-5 @coroutine#109] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35345/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2026-02-19 20:50:40.075 [DefaultDispatcher-worker-5 @coroutine#109] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:35345/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100. 2026-02-19 20:50:42.208 [Test worker @coroutine#118] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-19 20:50:42.208 [Test worker @coroutine#118] INFO io.ktor.server.Application - Application started in 0.055 seconds. 2026-02-19 20:50:42.210 [DefaultDispatcher-worker-2 @coroutine#127] INFO io.ktor.server.Application - Responding at http://0.0.0.0:40011 2026-02-19 20:50:42.212 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40011/api/school/respect/person?includeRelated=false 2026-02-19 20:50:42.212 [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:40011/api/school/respect/person?includeRelated=false. 2026-02-19 20:50:42.212 [Test worker @coroutine#118] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40011/api/school/respect/person?includeRelated=false 2026-02-19 20:50:42.215 [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-19 20:50:42.219 [Test worker @coroutine#118] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40011/api/school/respect/person?includeRelated=false 2026-02-19 20:50:42.219 [Test worker @coroutine#118] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40011/api/school/respect/person?includeRelated=false 2026-02-19 20:50:42.219 [Test worker @coroutine#118] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40011/api/school/respect/person?includeRelated=false 2026-02-19 20:50:42.220 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:40011/api/school/respect/person?includeRelated=false. 2026-02-19 20:50:42.270 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40011/api/school/respect/person?since=2026-02-19T16%3A50%3A42.215747630Z&includeRelated=false 2026-02-19 20:50:42.270 [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:40011/api/school/respect/person?since=2026-02-19T16%3A50%3A42.215747630Z&includeRelated=false. 2026-02-19 20:50:42.270 [Test worker @coroutine#118] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40011/api/school/respect/person?since=2026-02-19T16%3A50%3A42.215747630Z&includeRelated=false 2026-02-19 20:50:42.271 [eventLoopGroupProxy-19-1 @call-handler#138] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET) /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST) Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2026-02-19 20:50:42.274 [Test worker @coroutine#118] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40011/api/school/respect/person?since=2026-02-19T16%3A50%3A42.215747630Z&includeRelated=false 2026-02-19 20:50:42.274 [Test worker @coroutine#118] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40011/api/school/respect/person?since=2026-02-19T16%3A50%3A42.215747630Z&includeRelated=false 2026-02-19 20:50:42.274 [Test worker @coroutine#118] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40011/api/school/respect/person?since=2026-02-19T16%3A50%3A42.215747630Z&includeRelated=false 2026-02-19 20:50:42.275 [Test worker @coroutine#118] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:40011/api/school/respect/person?since=2026-02-19T16%3A50%3A42.215747630Z&includeRelated=false. 2026-02-19 20:50:44.399 [Test worker @coroutine#144] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-19 20:50:44.400 [Test worker @coroutine#144] INFO io.ktor.server.Application - Application started in 0.048 seconds. 2026-02-19 20:50:44.401 [DefaultDispatcher-worker-4 @coroutine#153] INFO io.ktor.server.Application - Responding at http://0.0.0.0:35399 2026-02-19 20:50:44.449 [DefaultDispatcher-worker-4 @coroutine#151] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35399/api/school/respect/person 2026-02-19 20:50:44.450 [DefaultDispatcher-worker-4 @coroutine#151] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@6ee3fbe0 for http://localhost:35399/api/school/respect/person 2026-02-19 20:50:44.450 [DefaultDispatcher-worker-4 @coroutine#151] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35399/api/school/respect/person 2026-02-19 20:50:44.450 [DefaultDispatcher-worker-4 @coroutine#151] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:35399/api/school/respect/person from class io.ktor.http.content.TextContent 2026-02-19 20:50:44.453 [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-19 20:50:44.458 [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-19 20:50:44.459 [DefaultDispatcher-worker-4 @call-handler#163] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the POST /api/school/respect/person request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType]. 2026-02-19 20:50:44.460 [DefaultDispatcher-worker-1 @coroutine#151] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35399/api/school/respect/person 2026-02-19 20:50:44.460 [DefaultDispatcher-worker-1 @coroutine#151] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35399/api/school/respect/person 2026-02-19 20:50:44.460 [DefaultDispatcher-worker-1 @coroutine#151] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35399/api/school/respect/person 2026-02-19 20:50:46.566 [Test worker @coroutine#168] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-19 20:50:46.567 [Test worker @coroutine#168] INFO io.ktor.server.Application - Application started in 0.048 seconds. 2026-02-19 20:50:46.568 [DefaultDispatcher-worker-2 @coroutine#177] INFO io.ktor.server.Application - Responding at http://0.0.0.0:46093 2026-02-19 20:50:46.569 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46093/api/school/respect/schoolpermissiongrant 2026-02-19 20:50:46.569 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:46093/api/school/respect/schoolpermissiongrant. 2026-02-19 20:50:46.569 [Test worker @coroutine#168] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46093/api/school/respect/schoolpermissiongrant 2026-02-19 20:50:46.572 [eventLoopGroupProxy-25-1 @call-handler#181] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, schoolpermissiongrant] /, segment:0 -> SUCCESS @ / /api, segment:1 -> SUCCESS @ /api /api/school, segment:2 -> SUCCESS @ /api/school /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect /api/school/respect/person, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/person /api/school/respect/schoolpermissiongrant, segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant /api/school/respect/schoolpermissiongrant/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET) Matched routes: "" -> "api" -> "school" -> "respect" -> "schoolpermissiongrant" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET) 2026-02-19 20:50:46.573 [Test worker @coroutine#168] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46093/api/school/respect/schoolpermissiongrant 2026-02-19 20:50:46.574 [Test worker @coroutine#168] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46093/api/school/respect/schoolpermissiongrant 2026-02-19 20:50:46.574 [Test worker @coroutine#168] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46093/api/school/respect/schoolpermissiongrant 2026-02-19 20:50:46.574 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:46093/api/school/respect/schoolpermissiongrant. 2026-02-19 20:50:46.620 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46093/api/school/respect/person?includeRelated=false 2026-02-19 20:50:46.620 [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:46093/api/school/respect/person?includeRelated=false. 2026-02-19 20:50:46.620 [Test worker @coroutine#168] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46093/api/school/respect/person?includeRelated=false 2026-02-19 20:50:46.621 [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-19 20:50:46.626 [Test worker @coroutine#168] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46093/api/school/respect/person?includeRelated=false 2026-02-19 20:50:46.627 [Test worker @coroutine#168] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46093/api/school/respect/person?includeRelated=false 2026-02-19 20:50:46.627 [Test worker @coroutine#168] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46093/api/school/respect/person?includeRelated=false 2026-02-19 20:50:46.627 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:46093/api/school/respect/person?includeRelated=false. 2026-02-19 20:50:48.632 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46093/api/school/respect/person?includeRelated=false 2026-02-19 20:50:48.633 [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:46093/api/school/respect/person?includeRelated=false. 2026-02-19 20:50:48.633 [Test worker @coroutine#168] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46093/api/school/respect/person?includeRelated=false 2026-02-19 20:50:48.634 [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-19 20:50:48.637 [Test worker @coroutine#168] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46093/api/school/respect/person?includeRelated=false 2026-02-19 20:50:48.637 [Test worker @coroutine#168] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46093/api/school/respect/person?includeRelated=false 2026-02-19 20:50:48.637 [Test worker @coroutine#168] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46093/api/school/respect/person?includeRelated=false 2026-02-19 20:50:48.638 [Test worker @coroutine#168] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:46093/api/school/respect/person?includeRelated=false. 2026-02-19 20:50:50.768 [Test worker @coroutine#200] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2026-02-19 20:50:50.769 [Test worker @coroutine#200] INFO io.ktor.server.Application - Application started in 0.046 seconds. 2026-02-19 20:50:50.770 [DefaultDispatcher-worker-2 @coroutine#209] INFO io.ktor.server.Application - Responding at http://0.0.0.0:34241 2026-02-19 20:50:50.773 [Test worker @coroutine#200] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34241/api/school/respect/person?includeRelated=false 2026-02-19 20:50:50.773 [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:34241/api/school/respect/person?includeRelated=false. 2026-02-19 20:50:50.773 [Test worker @coroutine#200] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34241/api/school/respect/person?includeRelated=false 2026-02-19 20:50:50.775 [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-19 20:50:50.778 [Test worker @coroutine#200] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34241/api/school/respect/person?includeRelated=false 2026-02-19 20:50:50.778 [Test worker @coroutine#200] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34241/api/school/respect/person?includeRelated=false 2026-02-19 20:50:50.778 [Test worker @coroutine#200] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34241/api/school/respect/person?includeRelated=false 2026-02-19 20:50:50.779 [Test worker @coroutine#200] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34241/api/school/respect/person?includeRelated=false. 2026-02-19 20:50:50.829 [Test worker @coroutine#200] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34241/api/school/respect/person?since=2026-02-19T16%3A50%3A50.775545174Z&includeRelated=false 2026-02-19 20:50:50.829 [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:34241/api/school/respect/person?since=2026-02-19T16%3A50%3A50.775545174Z&includeRelated=false. 2026-02-19 20:50:50.829 [Test worker @coroutine#200] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34241/api/school/respect/person?since=2026-02-19T16%3A50%3A50.775545174Z&includeRelated=false 2026-02-19 20:50:50.830 [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-19 20:50:50.833 [Test worker @coroutine#200] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34241/api/school/respect/person?since=2026-02-19T16%3A50%3A50.775545174Z&includeRelated=false 2026-02-19 20:50:50.833 [Test worker @coroutine#200] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34241/api/school/respect/person?since=2026-02-19T16%3A50%3A50.775545174Z&includeRelated=false 2026-02-19 20:50:50.833 [Test worker @coroutine#200] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34241/api/school/respect/person?since=2026-02-19T16%3A50%3A50.775545174Z&includeRelated=false 2026-02-19 20:50:50.834 [Test worker @coroutine#200] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34241/api/school/respect/person?since=2026-02-19T16%3A50%3A50.775545174Z&includeRelated=false.