2025-12-24 03:56:22.680 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 03:56:22.795 [Test worker] INFO io.ktor.server.Application - Application started in 0.258 seconds. 2025-12-24 03:56:22.911 [DefaultDispatcher-worker-1 @coroutine#2] INFO io.ktor.server.Application - Responding at http://0.0.0.0:46581 2025-12-24 03:56:23.211 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46581/resources/index.json 2025-12-24 03:56:23.212 [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:46581/resources/index.json. 2025-12-24 03:56:23.212 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46581/resources/index.json 2025-12-24 03:56:23.359 [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) 2025-12-24 03:56:23.402 [DefaultDispatcher-worker-1 @call-handler#12] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 48ms 2025-12-24 03:56:23.405 [DefaultDispatcher-worker-2 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46581/resources/index.json 2025-12-24 03:56:23.407 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46581/resources/index.json 2025-12-24 03:56:23.408 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46581/resources/index.json 2025-12-24 03:56:23.431 [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:46581/resources/index.json. 2025-12-24 03:56:23.469 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46581/resources/index.json 2025-12-24 03:56:23.470 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:46581/resources/index.json. 2025-12-24 03:56:23.470 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46581/resources/index.json 2025-12-24 03:56:23.473 [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) 2025-12-24 03:56:23.474 [eventLoopGroupProxy-4-1 @call-handler#22] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 2ms 2025-12-24 03:56:23.475 [DefaultDispatcher-worker-2 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46581/resources/index.json 2025-12-24 03:56:23.475 [DefaultDispatcher-worker-5 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46581/resources/index.json 2025-12-24 03:56:23.475 [DefaultDispatcher-worker-5 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46581/resources/index.json 2025-12-24 03:56:25.489 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 03:56:25.489 [Test worker] INFO io.ktor.server.Application - Application started in 0.0 seconds. 2025-12-24 03:56:25.490 [DefaultDispatcher-worker-5 @coroutine#26] INFO io.ktor.server.Application - Responding at http://0.0.0.0:42913 2025-12-24 03:56:25.533 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42913/resources/index.json 2025-12-24 03:56:25.533 [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:42913/resources/index.json. 2025-12-24 03:56:25.533 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42913/resources/index.json 2025-12-24 03:56:25.536 [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) 2025-12-24 03:56:25.537 [eventLoopGroupProxy-7-1 @call-handler#35] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 1ms 2025-12-24 03:56:25.538 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42913/resources/index.json 2025-12-24 03:56:25.538 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42913/resources/index.json 2025-12-24 03:56:25.538 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42913/resources/index.json 2025-12-24 03:56:25.538 [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:42913/resources/index.json. 2025-12-24 03:56:25.542 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42913/resources/index.json 2025-12-24 03:56:25.543 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:42913/resources/index.json. 2025-12-24 03:56:25.543 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42913/resources/index.json 2025-12-24 03:56:25.544 [eventLoopGroupProxy-7-1 @call-handler#45] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json] /, segment:0 -> SUCCESS @ / /(staticContent), segment:0 -> SUCCESS @ /(staticContent) /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...} /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET) Matched routes: "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)" Routing resolve result: SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET) 2025-12-24 03:56:25.545 [eventLoopGroupProxy-7-1 @call-handler#45] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms 2025-12-24 03:56:25.545 [DefaultDispatcher-worker-3 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42913/resources/index.json 2025-12-24 03:56:25.545 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42913/resources/index.json 2025-12-24 03:56:25.545 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42913/resources/index.json 2025-12-24 03:56:27.552 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 03:56:27.553 [Test worker] INFO io.ktor.server.Application - Application started in 0.001 seconds. 2025-12-24 03:56:27.554 [DefaultDispatcher-worker-2 @coroutine#49] INFO io.ktor.server.Application - Responding at http://0.0.0.0:34219 2025-12-24 03:56:27.557 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34219/resources/lesson001.json 2025-12-24 03:56:27.557 [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:34219/resources/lesson001.json. 2025-12-24 03:56:27.557 [Test worker @coroutine#52] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34219/resources/lesson001.json 2025-12-24 03:56:27.560 [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) 2025-12-24 03:56:27.560 [eventLoopGroupProxy-10-1 @call-handler#56] INFO io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 1ms 2025-12-24 03:56:27.561 [DefaultDispatcher-worker-2 @coroutine#52] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34219/resources/lesson001.json 2025-12-24 03:56:27.561 [DefaultDispatcher-worker-2 @coroutine#52] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34219/resources/lesson001.json 2025-12-24 03:56:27.561 [DefaultDispatcher-worker-2 @coroutine#52] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34219/resources/lesson001.json 2025-12-24 03:56:27.580 [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:34219/resources/lesson001.json. 2025-12-24 03:56:30.056 [Test worker @coroutine#61] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 03:56:30.064 [Test worker @coroutine#61] INFO io.ktor.server.Application - Application started in 0.461 seconds. 2025-12-24 03:56:30.067 [DefaultDispatcher-worker-2 @coroutine#67] INFO io.ktor.server.Application - Responding at http://0.0.0.0:45851 2025-12-24 03:56:30.149 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45851/api/school/respect/person?includeRelated=false 2025-12-24 03:56:30.150 [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:45851/api/school/respect/person?includeRelated=false. 2025-12-24 03:56:30.150 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45851/api/school/respect/person?includeRelated=false 2025-12-24 03:56:30.156 [eventLoopGroupProxy-13-1 @call-handler#72] 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) 2025-12-24 03:56:30.186 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45851/api/school/respect/person?includeRelated=false 2025-12-24 03:56:30.186 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45851/api/school/respect/person?includeRelated=false 2025-12-24 03:56:30.186 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45851/api/school/respect/person?includeRelated=false 2025-12-24 03:56:30.188 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:45851/api/school/respect/person?includeRelated=false. 2025-12-24 03:56:30.233 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45851/api/school/respect/person?includeRelated=false 2025-12-24 03:56:30.234 [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:45851/api/school/respect/person?includeRelated=false. 2025-12-24 03:56:30.234 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45851/api/school/respect/person?includeRelated=false 2025-12-24 03:56:30.236 [eventLoopGroupProxy-13-1 @call-handler#78] 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) 2025-12-24 03:56:30.238 [DefaultDispatcher-worker-2 @call-handler#78] 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]. 2025-12-24 03:56:30.239 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45851/api/school/respect/person?includeRelated=false 2025-12-24 03:56:30.239 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45851/api/school/respect/person?includeRelated=false 2025-12-24 03:56:30.239 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45851/api/school/respect/person?includeRelated=false 2025-12-24 03:56:32.297 [Test worker @coroutine#82] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 03:56:32.298 [Test worker @coroutine#82] INFO io.ktor.server.Application - Application started in 0.049 seconds. 2025-12-24 03:56:32.299 [DefaultDispatcher-worker-2 @coroutine#88] INFO io.ktor.server.Application - Responding at http://0.0.0.0:42291 2025-12-24 03:56:32.362 [DefaultDispatcher-worker-3 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42291/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2025-12-24 03:56:32.362 [DefaultDispatcher-worker-3 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:42291/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100. 2025-12-24 03:56:32.362 [DefaultDispatcher-worker-3 @coroutine#91] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42291/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2025-12-24 03:56:32.365 [eventLoopGroupProxy-16-1 @call-handler#97] 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) 2025-12-24 03:56:32.368 [DefaultDispatcher-worker-8 @coroutine#91] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42291/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2025-12-24 03:56:32.368 [DefaultDispatcher-worker-8 @coroutine#91] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42291/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2025-12-24 03:56:32.369 [DefaultDispatcher-worker-8 @coroutine#91] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42291/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2025-12-24 03:56:32.369 [DefaultDispatcher-worker-8 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:42291/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100. 2025-12-24 03:56:34.442 [Test worker @coroutine#102] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 03:56:34.445 [Test worker @coroutine#102] INFO io.ktor.server.Application - Application started in 0.061 seconds. 2025-12-24 03:56:34.446 [DefaultDispatcher-worker-2 @coroutine#108] INFO io.ktor.server.Application - Responding at http://0.0.0.0:35403 2025-12-24 03:56:34.477 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35403/api/school/respect/person?includeRelated=false 2025-12-24 03:56:34.477 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:35403/api/school/respect/person?includeRelated=false. 2025-12-24 03:56:34.477 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35403/api/school/respect/person?includeRelated=false 2025-12-24 03:56:34.480 [eventLoopGroupProxy-19-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) Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2025-12-24 03:56:34.482 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35403/api/school/respect/person?includeRelated=false 2025-12-24 03:56:34.482 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35403/api/school/respect/person?includeRelated=false 2025-12-24 03:56:34.482 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35403/api/school/respect/person?includeRelated=false 2025-12-24 03:56:34.483 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:35403/api/school/respect/person?includeRelated=false. 2025-12-24 03:56:34.522 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35403/api/school/respect/person?since=2025-12-24T02%3A56%3A34.480Z&includeRelated=false 2025-12-24 03:56:34.523 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:35403/api/school/respect/person?since=2025-12-24T02%3A56%3A34.480Z&includeRelated=false. 2025-12-24 03:56:34.523 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35403/api/school/respect/person?since=2025-12-24T02%3A56%3A34.480Z&includeRelated=false 2025-12-24 03:56:34.524 [eventLoopGroupProxy-19-1 @call-handler#119] 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) 2025-12-24 03:56:34.527 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35403/api/school/respect/person?since=2025-12-24T02%3A56%3A34.480Z&includeRelated=false 2025-12-24 03:56:34.527 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35403/api/school/respect/person?since=2025-12-24T02%3A56%3A34.480Z&includeRelated=false 2025-12-24 03:56:34.527 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35403/api/school/respect/person?since=2025-12-24T02%3A56%3A34.480Z&includeRelated=false 2025-12-24 03:56:34.527 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:35403/api/school/respect/person?since=2025-12-24T02%3A56%3A34.480Z&includeRelated=false. 2025-12-24 03:56:36.585 [Test worker @coroutine#124] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 03:56:36.586 [Test worker @coroutine#124] INFO io.ktor.server.Application - Application started in 0.048 seconds. 2025-12-24 03:56:36.587 [DefaultDispatcher-worker-3 @coroutine#130] INFO io.ktor.server.Application - Responding at http://0.0.0.0:33647 2025-12-24 03:56:36.620 [DefaultDispatcher-worker-8 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33647/api/school/respect/person 2025-12-24 03:56:36.620 [DefaultDispatcher-worker-8 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@45bfeccc for http://localhost:33647/api/school/respect/person 2025-12-24 03:56:36.621 [DefaultDispatcher-worker-8 @coroutine#128] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33647/api/school/respect/person 2025-12-24 03:56:36.621 [DefaultDispatcher-worker-8 @coroutine#128] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:33647/api/school/respect/person from class io.ktor.http.content.TextContent 2025-12-24 03:56:36.624 [eventLoopGroupProxy-22-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 -> 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) 2025-12-24 03:56:36.629 [eventLoopGroupProxy-22-1 @call-handler#138] 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 2025-12-24 03:56:36.656 [DefaultDispatcher-worker-7 @call-handler#138] 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]. 2025-12-24 03:56:36.657 [DefaultDispatcher-worker-5 @coroutine#128] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33647/api/school/respect/person 2025-12-24 03:56:36.657 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33647/api/school/respect/person 2025-12-24 03:56:36.657 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33647/api/school/respect/person 2025-12-24 03:56:38.712 [Test worker @coroutine#143] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 03:56:38.713 [Test worker @coroutine#143] INFO io.ktor.server.Application - Application started in 0.049 seconds. 2025-12-24 03:56:38.714 [DefaultDispatcher-worker-8 @coroutine#149] INFO io.ktor.server.Application - Responding at http://0.0.0.0:41317 2025-12-24 03:56:38.748 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41317/api/school/respect/person?includeRelated=false 2025-12-24 03:56:38.748 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41317/api/school/respect/person?includeRelated=false. 2025-12-24 03:56:38.748 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41317/api/school/respect/person?includeRelated=false 2025-12-24 03:56:38.750 [eventLoopGroupProxy-25-1 @call-handler#154] 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) 2025-12-24 03:56:38.753 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41317/api/school/respect/person?includeRelated=false 2025-12-24 03:56:38.753 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41317/api/school/respect/person?includeRelated=false 2025-12-24 03:56:38.753 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41317/api/school/respect/person?includeRelated=false 2025-12-24 03:56:38.753 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41317/api/school/respect/person?includeRelated=false. 2025-12-24 03:56:40.792 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41317/api/school/respect/person?includeRelated=false 2025-12-24 03:56:40.792 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41317/api/school/respect/person?includeRelated=false. 2025-12-24 03:56:40.792 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41317/api/school/respect/person?includeRelated=false 2025-12-24 03:56:40.794 [eventLoopGroupProxy-25-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 -> 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) 2025-12-24 03:56:40.796 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41317/api/school/respect/person?includeRelated=false 2025-12-24 03:56:40.796 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41317/api/school/respect/person?includeRelated=false 2025-12-24 03:56:40.796 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41317/api/school/respect/person?includeRelated=false 2025-12-24 03:56:40.797 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41317/api/school/respect/person?includeRelated=false. 2025-12-24 03:56:42.860 [Test worker @coroutine#167] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 03:56:42.861 [Test worker @coroutine#167] INFO io.ktor.server.Application - Application started in 0.054 seconds. 2025-12-24 03:56:42.862 [DefaultDispatcher-worker-5 @coroutine#173] INFO io.ktor.server.Application - Responding at http://0.0.0.0:45407 2025-12-24 03:56:42.891 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45407/api/school/respect/person?includeRelated=false 2025-12-24 03:56:42.892 [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:45407/api/school/respect/person?includeRelated=false. 2025-12-24 03:56:42.892 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45407/api/school/respect/person?includeRelated=false 2025-12-24 03:56:42.894 [eventLoopGroupProxy-28-1 @call-handler#178] 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) 2025-12-24 03:56:42.897 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45407/api/school/respect/person?includeRelated=false 2025-12-24 03:56:42.897 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45407/api/school/respect/person?includeRelated=false 2025-12-24 03:56:42.897 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45407/api/school/respect/person?includeRelated=false 2025-12-24 03:56:42.897 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:45407/api/school/respect/person?includeRelated=false. 2025-12-24 03:56:42.927 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45407/api/school/respect/person?since=2025-12-24T02%3A56%3A42.894Z&includeRelated=false 2025-12-24 03:56:42.927 [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:45407/api/school/respect/person?since=2025-12-24T02%3A56%3A42.894Z&includeRelated=false. 2025-12-24 03:56:42.927 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45407/api/school/respect/person?since=2025-12-24T02%3A56%3A42.894Z&includeRelated=false 2025-12-24 03:56:42.928 [eventLoopGroupProxy-28-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) Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2025-12-24 03:56:42.930 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45407/api/school/respect/person?since=2025-12-24T02%3A56%3A42.894Z&includeRelated=false 2025-12-24 03:56:42.930 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45407/api/school/respect/person?since=2025-12-24T02%3A56%3A42.894Z&includeRelated=false 2025-12-24 03:56:42.930 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45407/api/school/respect/person?since=2025-12-24T02%3A56%3A42.894Z&includeRelated=false 2025-12-24 03:56:42.931 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:45407/api/school/respect/person?since=2025-12-24T02%3A56%3A42.894Z&includeRelated=false. 2025-12-24 09:37:08.521 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 09:37:08.616 [Test worker] INFO io.ktor.server.Application - Application started in 0.212 seconds. 2025-12-24 09:37:08.699 [DefaultDispatcher-worker-1 @coroutine#2] INFO io.ktor.server.Application - Responding at http://0.0.0.0:42449 2025-12-24 09:37:08.961 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42449/resources/index.json 2025-12-24 09:37:08.962 [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:42449/resources/index.json. 2025-12-24 09:37:08.962 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42449/resources/index.json 2025-12-24 09:37:09.108 [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) 2025-12-24 09:37:09.146 [DefaultDispatcher-worker-1 @call-handler#12] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 43ms 2025-12-24 09:37:09.151 [DefaultDispatcher-worker-1 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42449/resources/index.json 2025-12-24 09:37:09.153 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42449/resources/index.json 2025-12-24 09:37:09.153 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42449/resources/index.json 2025-12-24 09:37:09.171 [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:42449/resources/index.json. 2025-12-24 09:37:09.204 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42449/resources/index.json 2025-12-24 09:37:09.204 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:42449/resources/index.json. 2025-12-24 09:37:09.204 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42449/resources/index.json 2025-12-24 09:37:09.206 [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) 2025-12-24 09:37:09.208 [eventLoopGroupProxy-4-1 @call-handler#22] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 2ms 2025-12-24 09:37:09.209 [DefaultDispatcher-worker-2 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42449/resources/index.json 2025-12-24 09:37:09.209 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42449/resources/index.json 2025-12-24 09:37:09.209 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42449/resources/index.json 2025-12-24 09:37:11.228 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 09:37:11.228 [Test worker] INFO io.ktor.server.Application - Application started in 0.0 seconds. 2025-12-24 09:37:11.229 [DefaultDispatcher-worker-2 @coroutine#26] INFO io.ktor.server.Application - Responding at http://0.0.0.0:44189 2025-12-24 09:37:11.289 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44189/resources/index.json 2025-12-24 09:37:11.290 [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:44189/resources/index.json. 2025-12-24 09:37:11.290 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44189/resources/index.json 2025-12-24 09:37:11.293 [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) 2025-12-24 09:37:11.294 [DefaultDispatcher-worker-3 @call-handler#35] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 1ms 2025-12-24 09:37:11.295 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44189/resources/index.json 2025-12-24 09:37:11.295 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44189/resources/index.json 2025-12-24 09:37:11.295 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44189/resources/index.json 2025-12-24 09:37:11.295 [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:44189/resources/index.json. 2025-12-24 09:37:11.299 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44189/resources/index.json 2025-12-24 09:37:11.299 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:44189/resources/index.json. 2025-12-24 09:37:11.299 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44189/resources/index.json 2025-12-24 09:37:11.301 [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) 2025-12-24 09:37:11.301 [eventLoopGroupProxy-7-1 @call-handler#45] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 0ms 2025-12-24 09:37:11.302 [DefaultDispatcher-worker-2 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44189/resources/index.json 2025-12-24 09:37:11.302 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44189/resources/index.json 2025-12-24 09:37:11.302 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44189/resources/index.json 2025-12-24 09:37:13.308 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 09:37:13.308 [Test worker] INFO io.ktor.server.Application - Application started in 0.0 seconds. 2025-12-24 09:37:13.309 [DefaultDispatcher-worker-2 @coroutine#49] INFO io.ktor.server.Application - Responding at http://0.0.0.0:38811 2025-12-24 09:37:13.312 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38811/resources/lesson001.json 2025-12-24 09:37:13.312 [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:38811/resources/lesson001.json. 2025-12-24 09:37:13.312 [Test worker @coroutine#52] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38811/resources/lesson001.json 2025-12-24 09:37:13.315 [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) 2025-12-24 09:37:13.316 [DefaultDispatcher-worker-3 @call-handler#56] INFO io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 2ms 2025-12-24 09:37:13.316 [DefaultDispatcher-worker-2 @coroutine#52] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38811/resources/lesson001.json 2025-12-24 09:37:13.316 [DefaultDispatcher-worker-2 @coroutine#52] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38811/resources/lesson001.json 2025-12-24 09:37:13.316 [DefaultDispatcher-worker-2 @coroutine#52] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38811/resources/lesson001.json 2025-12-24 09:37:13.334 [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:38811/resources/lesson001.json. 2025-12-24 09:37:15.818 [Test worker @coroutine#61] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 09:37:15.827 [Test worker @coroutine#61] INFO io.ktor.server.Application - Application started in 0.469 seconds. 2025-12-24 09:37:15.830 [DefaultDispatcher-worker-2 @coroutine#67] INFO io.ktor.server.Application - Responding at http://0.0.0.0:33877 2025-12-24 09:37:15.917 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33877/api/school/respect/person?includeRelated=false 2025-12-24 09:37:15.917 [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:33877/api/school/respect/person?includeRelated=false. 2025-12-24 09:37:15.917 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33877/api/school/respect/person?includeRelated=false 2025-12-24 09:37:15.923 [eventLoopGroupProxy-13-1 @call-handler#72] 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) 2025-12-24 09:37:15.952 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33877/api/school/respect/person?includeRelated=false 2025-12-24 09:37:15.953 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33877/api/school/respect/person?includeRelated=false 2025-12-24 09:37:15.953 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33877/api/school/respect/person?includeRelated=false 2025-12-24 09:37:15.954 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:33877/api/school/respect/person?includeRelated=false. 2025-12-24 09:37:15.993 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33877/api/school/respect/person?includeRelated=false 2025-12-24 09:37:15.993 [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:33877/api/school/respect/person?includeRelated=false. 2025-12-24 09:37:15.993 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33877/api/school/respect/person?includeRelated=false 2025-12-24 09:37:15.995 [eventLoopGroupProxy-13-1 @call-handler#78] 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) 2025-12-24 09:37:15.997 [DefaultDispatcher-worker-4 @call-handler#78] 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]. 2025-12-24 09:37:15.998 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33877/api/school/respect/person?includeRelated=false 2025-12-24 09:37:15.998 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33877/api/school/respect/person?includeRelated=false 2025-12-24 09:37:15.998 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33877/api/school/respect/person?includeRelated=false 2025-12-24 09:37:18.048 [Test worker @coroutine#82] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 09:37:18.049 [Test worker @coroutine#82] INFO io.ktor.server.Application - Application started in 0.042 seconds. 2025-12-24 09:37:18.050 [DefaultDispatcher-worker-2 @coroutine#88] INFO io.ktor.server.Application - Responding at http://0.0.0.0:45581 2025-12-24 09:37:18.134 [DefaultDispatcher-worker-2 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45581/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2025-12-24 09:37:18.135 [DefaultDispatcher-worker-2 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45581/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100. 2025-12-24 09:37:18.135 [DefaultDispatcher-worker-2 @coroutine#91] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45581/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2025-12-24 09:37:18.138 [eventLoopGroupProxy-16-1 @call-handler#97] 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) 2025-12-24 09:37:18.141 [DefaultDispatcher-worker-3 @coroutine#91] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45581/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2025-12-24 09:37:18.141 [DefaultDispatcher-worker-3 @coroutine#91] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45581/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2025-12-24 09:37:18.141 [DefaultDispatcher-worker-3 @coroutine#91] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45581/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2025-12-24 09:37:18.141 [DefaultDispatcher-worker-3 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:45581/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100. 2025-12-24 09:37:20.196 [Test worker @coroutine#102] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 09:37:20.196 [Test worker @coroutine#102] INFO io.ktor.server.Application - Application started in 0.039 seconds. 2025-12-24 09:37:20.197 [DefaultDispatcher-worker-3 @coroutine#108] INFO io.ktor.server.Application - Responding at http://0.0.0.0:42217 2025-12-24 09:37:20.232 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42217/api/school/respect/person?includeRelated=false 2025-12-24 09:37:20.232 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:42217/api/school/respect/person?includeRelated=false. 2025-12-24 09:37:20.232 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42217/api/school/respect/person?includeRelated=false 2025-12-24 09:37:20.235 [eventLoopGroupProxy-19-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) Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2025-12-24 09:37:20.238 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42217/api/school/respect/person?includeRelated=false 2025-12-24 09:37:20.238 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42217/api/school/respect/person?includeRelated=false 2025-12-24 09:37:20.238 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42217/api/school/respect/person?includeRelated=false 2025-12-24 09:37:20.238 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:42217/api/school/respect/person?includeRelated=false. 2025-12-24 09:37:20.283 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42217/api/school/respect/person?since=2025-12-24T08%3A37%3A20.235Z&includeRelated=false 2025-12-24 09:37:20.284 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:42217/api/school/respect/person?since=2025-12-24T08%3A37%3A20.235Z&includeRelated=false. 2025-12-24 09:37:20.284 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42217/api/school/respect/person?since=2025-12-24T08%3A37%3A20.235Z&includeRelated=false 2025-12-24 09:37:20.286 [eventLoopGroupProxy-19-1 @call-handler#119] 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) 2025-12-24 09:37:20.288 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42217/api/school/respect/person?since=2025-12-24T08%3A37%3A20.235Z&includeRelated=false 2025-12-24 09:37:20.288 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42217/api/school/respect/person?since=2025-12-24T08%3A37%3A20.235Z&includeRelated=false 2025-12-24 09:37:20.288 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42217/api/school/respect/person?since=2025-12-24T08%3A37%3A20.235Z&includeRelated=false 2025-12-24 09:37:20.289 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:42217/api/school/respect/person?since=2025-12-24T08%3A37%3A20.235Z&includeRelated=false. 2025-12-24 09:37:22.337 [Test worker @coroutine#124] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 09:37:22.338 [Test worker @coroutine#124] INFO io.ktor.server.Application - Application started in 0.039 seconds. 2025-12-24 09:37:22.339 [DefaultDispatcher-worker-5 @coroutine#130] INFO io.ktor.server.Application - Responding at http://0.0.0.0:43667 2025-12-24 09:37:22.373 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43667/api/school/respect/person 2025-12-24 09:37:22.373 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@1d410e5b for http://localhost:43667/api/school/respect/person 2025-12-24 09:37:22.373 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43667/api/school/respect/person 2025-12-24 09:37:22.373 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:43667/api/school/respect/person from class io.ktor.http.content.TextContent 2025-12-24 09:37:22.377 [eventLoopGroupProxy-22-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 -> 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) 2025-12-24 09:37:22.382 [eventLoopGroupProxy-22-1 @call-handler#138] 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 2025-12-24 09:37:22.406 [DefaultDispatcher-worker-2 @call-handler#138] 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]. 2025-12-24 09:37:22.406 [DefaultDispatcher-worker-5 @coroutine#128] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43667/api/school/respect/person 2025-12-24 09:37:22.407 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43667/api/school/respect/person 2025-12-24 09:37:22.407 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43667/api/school/respect/person 2025-12-24 09:37:24.465 [Test worker @coroutine#143] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 09:37:24.465 [Test worker @coroutine#143] INFO io.ktor.server.Application - Application started in 0.049 seconds. 2025-12-24 09:37:24.466 [DefaultDispatcher-worker-3 @coroutine#149] INFO io.ktor.server.Application - Responding at http://0.0.0.0:40517 2025-12-24 09:37:24.502 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40517/api/school/respect/person?includeRelated=false 2025-12-24 09:37:24.503 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:40517/api/school/respect/person?includeRelated=false. 2025-12-24 09:37:24.503 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40517/api/school/respect/person?includeRelated=false 2025-12-24 09:37:24.505 [eventLoopGroupProxy-25-1 @call-handler#154] 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) 2025-12-24 09:37:24.508 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40517/api/school/respect/person?includeRelated=false 2025-12-24 09:37:24.508 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40517/api/school/respect/person?includeRelated=false 2025-12-24 09:37:24.508 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40517/api/school/respect/person?includeRelated=false 2025-12-24 09:37:24.509 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:40517/api/school/respect/person?includeRelated=false. 2025-12-24 09:37:26.547 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40517/api/school/respect/person?includeRelated=false 2025-12-24 09:37:26.548 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:40517/api/school/respect/person?includeRelated=false. 2025-12-24 09:37:26.548 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40517/api/school/respect/person?includeRelated=false 2025-12-24 09:37:26.549 [eventLoopGroupProxy-25-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 -> 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) 2025-12-24 09:37:26.551 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40517/api/school/respect/person?includeRelated=false 2025-12-24 09:37:26.552 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40517/api/school/respect/person?includeRelated=false 2025-12-24 09:37:26.552 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40517/api/school/respect/person?includeRelated=false 2025-12-24 09:37:26.552 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:40517/api/school/respect/person?includeRelated=false. 2025-12-24 09:37:28.615 [Test worker @coroutine#167] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 09:37:28.616 [Test worker @coroutine#167] INFO io.ktor.server.Application - Application started in 0.054 seconds. 2025-12-24 09:37:28.617 [DefaultDispatcher-worker-2 @coroutine#173] INFO io.ktor.server.Application - Responding at http://0.0.0.0:41797 2025-12-24 09:37:28.652 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41797/api/school/respect/person?includeRelated=false 2025-12-24 09:37:28.652 [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:41797/api/school/respect/person?includeRelated=false. 2025-12-24 09:37:28.652 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41797/api/school/respect/person?includeRelated=false 2025-12-24 09:37:28.654 [eventLoopGroupProxy-28-1 @call-handler#178] 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) 2025-12-24 09:37:28.657 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41797/api/school/respect/person?includeRelated=false 2025-12-24 09:37:28.657 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41797/api/school/respect/person?includeRelated=false 2025-12-24 09:37:28.657 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41797/api/school/respect/person?includeRelated=false 2025-12-24 09:37:28.657 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41797/api/school/respect/person?includeRelated=false. 2025-12-24 09:37:28.688 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41797/api/school/respect/person?since=2025-12-24T08%3A37%3A28.654Z&includeRelated=false 2025-12-24 09:37:28.688 [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:41797/api/school/respect/person?since=2025-12-24T08%3A37%3A28.654Z&includeRelated=false. 2025-12-24 09:37:28.688 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41797/api/school/respect/person?since=2025-12-24T08%3A37%3A28.654Z&includeRelated=false 2025-12-24 09:37:28.689 [eventLoopGroupProxy-28-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) Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2025-12-24 09:37:28.691 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41797/api/school/respect/person?since=2025-12-24T08%3A37%3A28.654Z&includeRelated=false 2025-12-24 09:37:28.692 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41797/api/school/respect/person?since=2025-12-24T08%3A37%3A28.654Z&includeRelated=false 2025-12-24 09:37:28.692 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41797/api/school/respect/person?since=2025-12-24T08%3A37%3A28.654Z&includeRelated=false 2025-12-24 09:37:28.692 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41797/api/school/respect/person?since=2025-12-24T08%3A37%3A28.654Z&includeRelated=false. 2025-12-24 09:57:21.042 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 09:57:21.169 [Test worker] INFO io.ktor.server.Application - Application started in 0.372 seconds. 2025-12-24 09:57:21.317 [DefaultDispatcher-worker-2 @coroutine#2] INFO io.ktor.server.Application - Responding at http://0.0.0.0:39389 2025-12-24 09:57:21.724 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39389/resources/index.json 2025-12-24 09:57:21.725 [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:39389/resources/index.json. 2025-12-24 09:57:21.726 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39389/resources/index.json 2025-12-24 09:57:21.920 [eventLoopGroupProxy-4-1 @call-handler#12] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json] /, segment:0 -> SUCCESS @ / /(staticContent), segment:0 -> SUCCESS @ /(staticContent) /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...} /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET) Matched routes: "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)" Routing resolve result: SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET) 2025-12-24 09:57:21.982 [eventLoopGroupProxy-4-1 @call-handler#12] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 70ms 2025-12-24 09:57:21.987 [DefaultDispatcher-worker-2 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39389/resources/index.json 2025-12-24 09:57:21.989 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39389/resources/index.json 2025-12-24 09:57:21.990 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39389/resources/index.json 2025-12-24 09:57:22.013 [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:39389/resources/index.json. 2025-12-24 09:57:22.096 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39389/resources/index.json 2025-12-24 09:57:22.098 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:39389/resources/index.json. 2025-12-24 09:57:22.098 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39389/resources/index.json 2025-12-24 09:57:22.113 [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) 2025-12-24 09:57:22.120 [eventLoopGroupProxy-4-1 @call-handler#22] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 8ms 2025-12-24 09:57:22.123 [DefaultDispatcher-worker-1 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39389/resources/index.json 2025-12-24 09:57:22.123 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39389/resources/index.json 2025-12-24 09:57:22.124 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39389/resources/index.json 2025-12-24 09:57:24.198 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 09:57:24.199 [Test worker] INFO io.ktor.server.Application - Application started in 0.001 seconds. 2025-12-24 09:57:24.203 [DefaultDispatcher-worker-4 @coroutine#26] INFO io.ktor.server.Application - Responding at http://0.0.0.0:46677 2025-12-24 09:57:24.313 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46677/resources/index.json 2025-12-24 09:57:24.313 [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:46677/resources/index.json. 2025-12-24 09:57:24.313 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46677/resources/index.json 2025-12-24 09:57:24.318 [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) 2025-12-24 09:57:24.320 [DefaultDispatcher-worker-1 @call-handler#35] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 2ms 2025-12-24 09:57:24.321 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46677/resources/index.json 2025-12-24 09:57:24.321 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46677/resources/index.json 2025-12-24 09:57:24.321 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46677/resources/index.json 2025-12-24 09:57:24.322 [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:46677/resources/index.json. 2025-12-24 09:57:24.341 [DefaultDispatcher-worker-4 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46677/resources/index.json 2025-12-24 09:57:24.342 [DefaultDispatcher-worker-4 @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:46677/resources/index.json. 2025-12-24 09:57:24.342 [DefaultDispatcher-worker-4 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46677/resources/index.json 2025-12-24 09:57:24.347 [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) 2025-12-24 09:57:24.348 [eventLoopGroupProxy-7-1 @call-handler#45] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms 2025-12-24 09:57:24.348 [DefaultDispatcher-worker-7 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46677/resources/index.json 2025-12-24 09:57:24.349 [DefaultDispatcher-worker-7 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46677/resources/index.json 2025-12-24 09:57:24.349 [DefaultDispatcher-worker-7 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46677/resources/index.json 2025-12-24 09:57:26.360 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 09:57:26.361 [Test worker] INFO io.ktor.server.Application - Application started in 0.001 seconds. 2025-12-24 09:57:26.363 [DefaultDispatcher-worker-7 @coroutine#49] INFO io.ktor.server.Application - Responding at http://0.0.0.0:37337 2025-12-24 09:57:26.369 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37337/resources/lesson001.json 2025-12-24 09:57:26.369 [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:37337/resources/lesson001.json. 2025-12-24 09:57:26.369 [Test worker @coroutine#52] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37337/resources/lesson001.json 2025-12-24 09:57:26.372 [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) 2025-12-24 09:57:26.374 [DefaultDispatcher-worker-7 @call-handler#56] INFO io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 2ms 2025-12-24 09:57:26.375 [DefaultDispatcher-worker-7 @coroutine#52] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37337/resources/lesson001.json 2025-12-24 09:57:26.375 [DefaultDispatcher-worker-3 @coroutine#52] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37337/resources/lesson001.json 2025-12-24 09:57:26.375 [DefaultDispatcher-worker-3 @coroutine#52] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37337/resources/lesson001.json 2025-12-24 09:57:26.396 [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:37337/resources/lesson001.json. 2025-12-24 09:57:29.606 [Test worker @coroutine#61] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 09:57:29.672 [Test worker @coroutine#61] INFO io.ktor.server.Application - Application started in 1.194 seconds. 2025-12-24 09:57:29.714 [DefaultDispatcher-worker-7 @coroutine#67] INFO io.ktor.server.Application - Responding at http://0.0.0.0:33891 2025-12-24 09:57:30.098 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33891/api/school/respect/person?includeRelated=false 2025-12-24 09:57:30.099 [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:33891/api/school/respect/person?includeRelated=false. 2025-12-24 09:57:30.105 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33891/api/school/respect/person?includeRelated=false 2025-12-24 09:57:30.150 [eventLoopGroupProxy-13-1 @call-handler#72] 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) 2025-12-24 09:57:30.298 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33891/api/school/respect/person?includeRelated=false 2025-12-24 09:57:30.299 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33891/api/school/respect/person?includeRelated=false 2025-12-24 09:57:30.299 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33891/api/school/respect/person?includeRelated=false 2025-12-24 09:57:30.303 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:33891/api/school/respect/person?includeRelated=false. 2025-12-24 09:57:30.394 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33891/api/school/respect/person?includeRelated=false 2025-12-24 09:57:30.394 [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:33891/api/school/respect/person?includeRelated=false. 2025-12-24 09:57:30.394 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33891/api/school/respect/person?includeRelated=false 2025-12-24 09:57:30.404 [eventLoopGroupProxy-13-1 @call-handler#78] 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) 2025-12-24 09:57:30.408 [DefaultDispatcher-worker-7 @call-handler#78] 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]. 2025-12-24 09:57:30.414 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33891/api/school/respect/person?includeRelated=false 2025-12-24 09:57:30.417 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33891/api/school/respect/person?includeRelated=false 2025-12-24 09:57:30.417 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33891/api/school/respect/person?includeRelated=false 2025-12-24 09:57:32.534 [Test worker @coroutine#82] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 09:57:32.536 [Test worker @coroutine#82] INFO io.ktor.server.Application - Application started in 0.071 seconds. 2025-12-24 09:57:32.546 [DefaultDispatcher-worker-8 @coroutine#88] INFO io.ktor.server.Application - Responding at http://0.0.0.0:45885 2025-12-24 09:57:32.637 [DefaultDispatcher-worker-8 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45885/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2025-12-24 09:57:32.637 [DefaultDispatcher-worker-8 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45885/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100. 2025-12-24 09:57:32.637 [DefaultDispatcher-worker-8 @coroutine#91] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45885/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2025-12-24 09:57:32.647 [eventLoopGroupProxy-16-1 @call-handler#97] 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) 2025-12-24 09:57:32.653 [DefaultDispatcher-worker-5 @coroutine#91] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45885/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2025-12-24 09:57:32.653 [DefaultDispatcher-worker-6 @coroutine#91] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45885/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2025-12-24 09:57:32.653 [DefaultDispatcher-worker-6 @coroutine#91] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45885/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2025-12-24 09:57:32.654 [DefaultDispatcher-worker-6 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:45885/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100. 2025-12-24 09:57:33.676 [eventLoopGroupProxy-15-1] WARN i.n.u.c.AbstractEventExecutor - A task raised an exception. Task: io.netty.channel.AbstractChannel$AbstractUnsafe$8@2e2eba91 java.util.concurrent.RejectedExecutionException: event executor terminated at io.netty.util.concurrent.SingleThreadEventExecutor.reject(SingleThreadEventExecutor.java:1005) at io.netty.util.concurrent.SingleThreadEventExecutor.offerTask(SingleThreadEventExecutor.java:388) at io.netty.util.concurrent.SingleThreadEventExecutor.addTask(SingleThreadEventExecutor.java:381) at io.netty.util.concurrent.SingleThreadEventExecutor.execute(SingleThreadEventExecutor.java:907) at io.netty.util.concurrent.SingleThreadEventExecutor.execute0(SingleThreadEventExecutor.java:873) at io.netty.util.concurrent.SingleThreadEventExecutor.execute(SingleThreadEventExecutor.java:863) at io.netty.channel.DefaultChannelPipeline.destroyUp(DefaultChannelPipeline.java:816) at io.netty.channel.DefaultChannelPipeline.destroy(DefaultChannelPipeline.java:801) at io.netty.channel.DefaultChannelPipeline.access$700(DefaultChannelPipeline.java:45) at io.netty.channel.DefaultChannelPipeline$HeadContext.channelUnregistered(DefaultChannelPipeline.java:1411) at io.netty.channel.DefaultChannelPipeline.fireChannelUnregistered(DefaultChannelPipeline.java:780) at io.netty.channel.AbstractChannel$AbstractUnsafe$8.run(AbstractChannel.java:692) at io.netty.util.concurrent.AbstractEventExecutor.runTask(AbstractEventExecutor.java:148) at io.netty.util.concurrent.AbstractEventExecutor.safeExecute(AbstractEventExecutor.java:141) at io.netty.util.concurrent.SingleThreadEventExecutor.runAllTasks(SingleThreadEventExecutor.java:507) at io.netty.channel.SingleThreadIoEventLoop.run(SingleThreadIoEventLoop.java:183) at io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:1073) at io.netty.util.internal.ThreadExecutorMap$2.run(ThreadExecutorMap.java:74) at io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30) at java.base/java.lang.Thread.run(Thread.java:1583) 2025-12-24 09:57:34.793 [Test worker @coroutine#102] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 09:57:34.795 [Test worker @coroutine#102] INFO io.ktor.server.Application - Application started in 0.077 seconds. 2025-12-24 09:57:34.799 [DefaultDispatcher-worker-6 @coroutine#108] INFO io.ktor.server.Application - Responding at http://0.0.0.0:33187 2025-12-24 09:57:34.831 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33187/api/school/respect/person?includeRelated=false 2025-12-24 09:57:34.832 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:33187/api/school/respect/person?includeRelated=false. 2025-12-24 09:57:34.832 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33187/api/school/respect/person?includeRelated=false 2025-12-24 09:57:34.842 [eventLoopGroupProxy-19-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) Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2025-12-24 09:57:34.849 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33187/api/school/respect/person?includeRelated=false 2025-12-24 09:57:34.851 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33187/api/school/respect/person?includeRelated=false 2025-12-24 09:57:34.851 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33187/api/school/respect/person?includeRelated=false 2025-12-24 09:57:34.852 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:33187/api/school/respect/person?includeRelated=false. 2025-12-24 09:57:34.951 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33187/api/school/respect/person?since=2025-12-24T08%3A57%3A34.844Z&includeRelated=false 2025-12-24 09:57:34.951 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:33187/api/school/respect/person?since=2025-12-24T08%3A57%3A34.844Z&includeRelated=false. 2025-12-24 09:57:34.951 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33187/api/school/respect/person?since=2025-12-24T08%3A57%3A34.844Z&includeRelated=false 2025-12-24 09:57:34.956 [eventLoopGroupProxy-19-1 @call-handler#119] 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) 2025-12-24 09:57:34.978 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33187/api/school/respect/person?since=2025-12-24T08%3A57%3A34.844Z&includeRelated=false 2025-12-24 09:57:34.978 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33187/api/school/respect/person?since=2025-12-24T08%3A57%3A34.844Z&includeRelated=false 2025-12-24 09:57:34.978 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33187/api/school/respect/person?since=2025-12-24T08%3A57%3A34.844Z&includeRelated=false 2025-12-24 09:57:34.981 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:33187/api/school/respect/person?since=2025-12-24T08%3A57%3A34.844Z&includeRelated=false. 2025-12-24 09:57:37.129 [Test worker @coroutine#124] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 09:57:37.131 [Test worker @coroutine#124] INFO io.ktor.server.Application - Application started in 0.067 seconds. 2025-12-24 09:57:37.140 [DefaultDispatcher-worker-3 @coroutine#130] INFO io.ktor.server.Application - Responding at http://0.0.0.0:32963 2025-12-24 09:57:37.216 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:32963/api/school/respect/person 2025-12-24 09:57:37.217 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@68088fb5 for http://localhost:32963/api/school/respect/person 2025-12-24 09:57:37.217 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:32963/api/school/respect/person 2025-12-24 09:57:37.217 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:32963/api/school/respect/person from class io.ktor.http.content.TextContent 2025-12-24 09:57:37.243 [eventLoopGroupProxy-22-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 -> 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) 2025-12-24 09:57:37.264 [eventLoopGroupProxy-22-1 @call-handler#138] 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 2025-12-24 09:57:37.267 [DefaultDispatcher-worker-5 @call-handler#138] 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]. 2025-12-24 09:57:37.272 [DefaultDispatcher-worker-3 @coroutine#128] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:32963/api/school/respect/person 2025-12-24 09:57:37.272 [DefaultDispatcher-worker-3 @coroutine#128] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:32963/api/school/respect/person 2025-12-24 09:57:37.272 [DefaultDispatcher-worker-3 @coroutine#128] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:32963/api/school/respect/person 2025-12-24 09:57:39.404 [Test worker @coroutine#143] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 09:57:39.405 [Test worker @coroutine#143] INFO io.ktor.server.Application - Application started in 0.058 seconds. 2025-12-24 09:57:39.406 [DefaultDispatcher-worker-3 @coroutine#149] INFO io.ktor.server.Application - Responding at http://0.0.0.0:45271 2025-12-24 09:57:39.453 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45271/api/school/respect/person?includeRelated=false 2025-12-24 09:57:39.457 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45271/api/school/respect/person?includeRelated=false. 2025-12-24 09:57:39.457 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45271/api/school/respect/person?includeRelated=false 2025-12-24 09:57:39.469 [eventLoopGroupProxy-25-1 @call-handler#154] 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) 2025-12-24 09:57:39.485 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45271/api/school/respect/person?includeRelated=false 2025-12-24 09:57:39.488 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45271/api/school/respect/person?includeRelated=false 2025-12-24 09:57:39.488 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45271/api/school/respect/person?includeRelated=false 2025-12-24 09:57:39.489 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:45271/api/school/respect/person?includeRelated=false. 2025-12-24 09:57:41.525 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45271/api/school/respect/person?includeRelated=false 2025-12-24 09:57:41.525 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45271/api/school/respect/person?includeRelated=false. 2025-12-24 09:57:41.525 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45271/api/school/respect/person?includeRelated=false 2025-12-24 09:57:41.527 [eventLoopGroupProxy-25-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 -> 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) 2025-12-24 09:57:41.530 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45271/api/school/respect/person?includeRelated=false 2025-12-24 09:57:41.530 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45271/api/school/respect/person?includeRelated=false 2025-12-24 09:57:41.530 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45271/api/school/respect/person?includeRelated=false 2025-12-24 09:57:41.531 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:45271/api/school/respect/person?includeRelated=false. 2025-12-24 09:57:43.622 [Test worker @coroutine#167] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 09:57:43.623 [Test worker @coroutine#167] INFO io.ktor.server.Application - Application started in 0.071 seconds. 2025-12-24 09:57:43.624 [DefaultDispatcher-worker-3 @coroutine#173] INFO io.ktor.server.Application - Responding at http://0.0.0.0:44031 2025-12-24 09:57:43.666 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44031/api/school/respect/person?includeRelated=false 2025-12-24 09:57:43.666 [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:44031/api/school/respect/person?includeRelated=false. 2025-12-24 09:57:43.666 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44031/api/school/respect/person?includeRelated=false 2025-12-24 09:57:43.669 [eventLoopGroupProxy-28-1 @call-handler#178] 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) 2025-12-24 09:57:43.672 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44031/api/school/respect/person?includeRelated=false 2025-12-24 09:57:43.672 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44031/api/school/respect/person?includeRelated=false 2025-12-24 09:57:43.672 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44031/api/school/respect/person?includeRelated=false 2025-12-24 09:57:43.673 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44031/api/school/respect/person?includeRelated=false. 2025-12-24 09:57:43.718 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44031/api/school/respect/person?since=2025-12-24T08%3A57%3A43.669Z&includeRelated=false 2025-12-24 09:57:43.718 [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:44031/api/school/respect/person?since=2025-12-24T08%3A57%3A43.669Z&includeRelated=false. 2025-12-24 09:57:43.718 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44031/api/school/respect/person?since=2025-12-24T08%3A57%3A43.669Z&includeRelated=false 2025-12-24 09:57:43.719 [eventLoopGroupProxy-28-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) Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2025-12-24 09:57:43.722 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44031/api/school/respect/person?since=2025-12-24T08%3A57%3A43.669Z&includeRelated=false 2025-12-24 09:57:43.722 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44031/api/school/respect/person?since=2025-12-24T08%3A57%3A43.669Z&includeRelated=false 2025-12-24 09:57:43.722 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44031/api/school/respect/person?since=2025-12-24T08%3A57%3A43.669Z&includeRelated=false 2025-12-24 09:57:43.723 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44031/api/school/respect/person?since=2025-12-24T08%3A57%3A43.669Z&includeRelated=false. 2025-12-24 10:22:17.828 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 10:22:17.970 [Test worker] INFO io.ktor.server.Application - Application started in 0.36 seconds. 2025-12-24 10:22:18.115 [DefaultDispatcher-worker-1 @coroutine#2] INFO io.ktor.server.Application - Responding at http://0.0.0.0:41757 2025-12-24 10:22:18.501 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41757/resources/index.json 2025-12-24 10:22:18.504 [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:41757/resources/index.json. 2025-12-24 10:22:18.504 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41757/resources/index.json 2025-12-24 10:22:18.754 [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) 2025-12-24 10:22:18.857 [DefaultDispatcher-worker-2 @call-handler#12] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 107ms 2025-12-24 10:22:18.861 [DefaultDispatcher-worker-1 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41757/resources/index.json 2025-12-24 10:22:18.866 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41757/resources/index.json 2025-12-24 10:22:18.866 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41757/resources/index.json 2025-12-24 10:22:18.897 [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:41757/resources/index.json. 2025-12-24 10:22:18.995 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41757/resources/index.json 2025-12-24 10:22:18.995 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41757/resources/index.json. 2025-12-24 10:22:18.995 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41757/resources/index.json 2025-12-24 10:22:19.001 [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) 2025-12-24 10:22:19.016 [eventLoopGroupProxy-4-1 @call-handler#22] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 16ms 2025-12-24 10:22:19.021 [DefaultDispatcher-worker-2 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41757/resources/index.json 2025-12-24 10:22:19.021 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41757/resources/index.json 2025-12-24 10:22:19.021 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41757/resources/index.json 2025-12-24 10:22:21.080 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 10:22:21.081 [Test worker] INFO io.ktor.server.Application - Application started in 0.001 seconds. 2025-12-24 10:22:21.083 [DefaultDispatcher-worker-2 @coroutine#26] INFO io.ktor.server.Application - Responding at http://0.0.0.0:46579 2025-12-24 10:22:21.157 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46579/resources/index.json 2025-12-24 10:22:21.158 [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:46579/resources/index.json. 2025-12-24 10:22:21.158 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46579/resources/index.json 2025-12-24 10:22:21.166 [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) 2025-12-24 10:22:21.168 [DefaultDispatcher-worker-6 @call-handler#35] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 2ms 2025-12-24 10:22:21.169 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46579/resources/index.json 2025-12-24 10:22:21.170 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46579/resources/index.json 2025-12-24 10:22:21.170 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46579/resources/index.json 2025-12-24 10:22:21.170 [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:46579/resources/index.json. 2025-12-24 10:22:21.178 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46579/resources/index.json 2025-12-24 10:22:21.178 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:46579/resources/index.json. 2025-12-24 10:22:21.178 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46579/resources/index.json 2025-12-24 10:22:21.181 [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) 2025-12-24 10:22:21.182 [eventLoopGroupProxy-7-1 @call-handler#45] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms 2025-12-24 10:22:21.183 [DefaultDispatcher-worker-4 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46579/resources/index.json 2025-12-24 10:22:21.183 [DefaultDispatcher-worker-4 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46579/resources/index.json 2025-12-24 10:22:21.183 [DefaultDispatcher-worker-4 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46579/resources/index.json 2025-12-24 10:22:23.197 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 10:22:23.197 [Test worker] INFO io.ktor.server.Application - Application started in 0.0 seconds. 2025-12-24 10:22:23.202 [DefaultDispatcher-worker-4 @coroutine#49] INFO io.ktor.server.Application - Responding at http://0.0.0.0:46479 2025-12-24 10:22:23.207 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46479/resources/lesson001.json 2025-12-24 10:22:23.207 [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:46479/resources/lesson001.json. 2025-12-24 10:22:23.207 [Test worker @coroutine#52] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46479/resources/lesson001.json 2025-12-24 10:22:23.210 [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) 2025-12-24 10:22:23.212 [DefaultDispatcher-worker-10 @call-handler#56] INFO io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 2ms 2025-12-24 10:22:23.212 [DefaultDispatcher-worker-4 @coroutine#52] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46479/resources/lesson001.json 2025-12-24 10:22:23.213 [DefaultDispatcher-worker-9 @coroutine#52] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46479/resources/lesson001.json 2025-12-24 10:22:23.213 [DefaultDispatcher-worker-9 @coroutine#52] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46479/resources/lesson001.json 2025-12-24 10:22:23.248 [DefaultDispatcher-worker-9 @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsPublication for http://localhost:46479/resources/lesson001.json. 2025-12-24 10:22:26.501 [Test worker @coroutine#61] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 10:22:26.553 [Test worker @coroutine#61] INFO io.ktor.server.Application - Application started in 1.227 seconds. 2025-12-24 10:22:26.562 [DefaultDispatcher-worker-9 @coroutine#67] INFO io.ktor.server.Application - Responding at http://0.0.0.0:46309 2025-12-24 10:22:26.715 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46309/api/school/respect/person?includeRelated=false 2025-12-24 10:22:26.720 [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:46309/api/school/respect/person?includeRelated=false. 2025-12-24 10:22:26.724 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46309/api/school/respect/person?includeRelated=false 2025-12-24 10:22:26.779 [eventLoopGroupProxy-13-1 @call-handler#72] 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) 2025-12-24 10:22:26.885 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46309/api/school/respect/person?includeRelated=false 2025-12-24 10:22:26.887 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46309/api/school/respect/person?includeRelated=false 2025-12-24 10:22:26.887 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46309/api/school/respect/person?includeRelated=false 2025-12-24 10:22:26.892 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:46309/api/school/respect/person?includeRelated=false. 2025-12-24 10:22:26.963 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46309/api/school/respect/person?includeRelated=false 2025-12-24 10:22:26.963 [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:46309/api/school/respect/person?includeRelated=false. 2025-12-24 10:22:26.963 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46309/api/school/respect/person?includeRelated=false 2025-12-24 10:22:26.967 [eventLoopGroupProxy-13-1 @call-handler#78] 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) 2025-12-24 10:22:26.972 [DefaultDispatcher-worker-10 @call-handler#78] 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]. 2025-12-24 10:22:26.974 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46309/api/school/respect/person?includeRelated=false 2025-12-24 10:22:26.974 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46309/api/school/respect/person?includeRelated=false 2025-12-24 10:22:26.974 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46309/api/school/respect/person?includeRelated=false 2025-12-24 10:22:29.063 [Test worker @coroutine#82] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 10:22:29.064 [Test worker @coroutine#82] INFO io.ktor.server.Application - Application started in 0.035 seconds. 2025-12-24 10:22:29.066 [DefaultDispatcher-worker-10 @coroutine#88] INFO io.ktor.server.Application - Responding at http://0.0.0.0:43965 2025-12-24 10:22:29.131 [DefaultDispatcher-worker-10 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43965/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2025-12-24 10:22:29.132 [DefaultDispatcher-worker-10 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:43965/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100. 2025-12-24 10:22:29.132 [DefaultDispatcher-worker-10 @coroutine#91] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43965/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2025-12-24 10:22:29.135 [eventLoopGroupProxy-16-1 @call-handler#97] 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) 2025-12-24 10:22:29.138 [DefaultDispatcher-worker-3 @coroutine#91] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43965/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2025-12-24 10:22:29.139 [DefaultDispatcher-worker-3 @coroutine#91] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43965/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2025-12-24 10:22:29.139 [DefaultDispatcher-worker-3 @coroutine#91] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43965/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2025-12-24 10:22:29.139 [DefaultDispatcher-worker-3 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:43965/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100. 2025-12-24 10:22:31.248 [Test worker @coroutine#102] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 10:22:31.259 [Test worker @coroutine#102] INFO io.ktor.server.Application - Application started in 0.083 seconds. 2025-12-24 10:22:31.261 [DefaultDispatcher-worker-3 @coroutine#108] INFO io.ktor.server.Application - Responding at http://0.0.0.0:43811 2025-12-24 10:22:31.305 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43811/api/school/respect/person?includeRelated=false 2025-12-24 10:22:31.306 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:43811/api/school/respect/person?includeRelated=false. 2025-12-24 10:22:31.306 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43811/api/school/respect/person?includeRelated=false 2025-12-24 10:22:31.314 [eventLoopGroupProxy-19-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) Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2025-12-24 10:22:31.322 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43811/api/school/respect/person?includeRelated=false 2025-12-24 10:22:31.322 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43811/api/school/respect/person?includeRelated=false 2025-12-24 10:22:31.322 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43811/api/school/respect/person?includeRelated=false 2025-12-24 10:22:31.324 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:43811/api/school/respect/person?includeRelated=false. 2025-12-24 10:22:31.444 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43811/api/school/respect/person?since=2025-12-24T09%3A22%3A31.315Z&includeRelated=false 2025-12-24 10:22:31.445 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:43811/api/school/respect/person?since=2025-12-24T09%3A22%3A31.315Z&includeRelated=false. 2025-12-24 10:22:31.445 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43811/api/school/respect/person?since=2025-12-24T09%3A22%3A31.315Z&includeRelated=false 2025-12-24 10:22:31.459 [eventLoopGroupProxy-19-1 @call-handler#119] 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) 2025-12-24 10:22:31.470 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43811/api/school/respect/person?since=2025-12-24T09%3A22%3A31.315Z&includeRelated=false 2025-12-24 10:22:31.471 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43811/api/school/respect/person?since=2025-12-24T09%3A22%3A31.315Z&includeRelated=false 2025-12-24 10:22:31.471 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43811/api/school/respect/person?since=2025-12-24T09%3A22%3A31.315Z&includeRelated=false 2025-12-24 10:22:31.473 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:43811/api/school/respect/person?since=2025-12-24T09%3A22%3A31.315Z&includeRelated=false. 2025-12-24 10:22:33.654 [Test worker @coroutine#124] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 10:22:33.655 [Test worker @coroutine#124] INFO io.ktor.server.Application - Application started in 0.093 seconds. 2025-12-24 10:22:33.661 [DefaultDispatcher-worker-5 @coroutine#130] INFO io.ktor.server.Application - Responding at http://0.0.0.0:37875 2025-12-24 10:22:33.758 [DefaultDispatcher-worker-4 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37875/api/school/respect/person 2025-12-24 10:22:33.759 [DefaultDispatcher-worker-4 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@44ca8ed3 for http://localhost:37875/api/school/respect/person 2025-12-24 10:22:33.759 [DefaultDispatcher-worker-4 @coroutine#128] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37875/api/school/respect/person 2025-12-24 10:22:33.760 [DefaultDispatcher-worker-4 @coroutine#128] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:37875/api/school/respect/person from class io.ktor.http.content.TextContent 2025-12-24 10:22:33.779 [eventLoopGroupProxy-22-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 -> 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) 2025-12-24 10:22:33.791 [eventLoopGroupProxy-22-1 @call-handler#138] 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 2025-12-24 10:22:33.814 [DefaultDispatcher-worker-4 @call-handler#138] 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]. 2025-12-24 10:22:33.816 [DefaultDispatcher-worker-2 @coroutine#128] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37875/api/school/respect/person 2025-12-24 10:22:33.816 [DefaultDispatcher-worker-2 @coroutine#128] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37875/api/school/respect/person 2025-12-24 10:22:33.816 [DefaultDispatcher-worker-2 @coroutine#128] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37875/api/school/respect/person 2025-12-24 10:22:35.927 [Test worker @coroutine#143] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 10:22:35.930 [Test worker @coroutine#143] INFO io.ktor.server.Application - Application started in 0.069 seconds. 2025-12-24 10:22:35.934 [DefaultDispatcher-worker-9 @coroutine#149] INFO io.ktor.server.Application - Responding at http://0.0.0.0:43277 2025-12-24 10:22:35.992 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43277/api/school/respect/person?includeRelated=false 2025-12-24 10:22:35.992 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:43277/api/school/respect/person?includeRelated=false. 2025-12-24 10:22:35.992 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43277/api/school/respect/person?includeRelated=false 2025-12-24 10:22:35.995 [eventLoopGroupProxy-25-1 @call-handler#154] 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) 2025-12-24 10:22:36.001 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43277/api/school/respect/person?includeRelated=false 2025-12-24 10:22:36.002 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43277/api/school/respect/person?includeRelated=false 2025-12-24 10:22:36.002 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43277/api/school/respect/person?includeRelated=false 2025-12-24 10:22:36.002 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:43277/api/school/respect/person?includeRelated=false. 2025-12-24 10:22:38.053 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43277/api/school/respect/person?includeRelated=false 2025-12-24 10:22:38.053 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:43277/api/school/respect/person?includeRelated=false. 2025-12-24 10:22:38.053 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43277/api/school/respect/person?includeRelated=false 2025-12-24 10:22:38.054 [eventLoopGroupProxy-25-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 -> 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) 2025-12-24 10:22:38.057 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43277/api/school/respect/person?includeRelated=false 2025-12-24 10:22:38.057 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43277/api/school/respect/person?includeRelated=false 2025-12-24 10:22:38.057 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43277/api/school/respect/person?includeRelated=false 2025-12-24 10:22:38.057 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:43277/api/school/respect/person?includeRelated=false. 2025-12-24 10:22:40.170 [Test worker @coroutine#167] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 10:22:40.171 [Test worker @coroutine#167] INFO io.ktor.server.Application - Application started in 0.05 seconds. 2025-12-24 10:22:40.172 [DefaultDispatcher-worker-9 @coroutine#173] INFO io.ktor.server.Application - Responding at http://0.0.0.0:34049 2025-12-24 10:22:40.208 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34049/api/school/respect/person?includeRelated=false 2025-12-24 10:22:40.209 [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:34049/api/school/respect/person?includeRelated=false. 2025-12-24 10:22:40.209 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34049/api/school/respect/person?includeRelated=false 2025-12-24 10:22:40.211 [eventLoopGroupProxy-28-1 @call-handler#178] 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) 2025-12-24 10:22:40.215 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34049/api/school/respect/person?includeRelated=false 2025-12-24 10:22:40.215 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34049/api/school/respect/person?includeRelated=false 2025-12-24 10:22:40.215 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34049/api/school/respect/person?includeRelated=false 2025-12-24 10:22:40.216 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34049/api/school/respect/person?includeRelated=false. 2025-12-24 10:22:40.249 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34049/api/school/respect/person?since=2025-12-24T09%3A22%3A40.212Z&includeRelated=false 2025-12-24 10:22:40.249 [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:34049/api/school/respect/person?since=2025-12-24T09%3A22%3A40.212Z&includeRelated=false. 2025-12-24 10:22:40.249 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34049/api/school/respect/person?since=2025-12-24T09%3A22%3A40.212Z&includeRelated=false 2025-12-24 10:22:40.250 [eventLoopGroupProxy-28-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) Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2025-12-24 10:22:40.253 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34049/api/school/respect/person?since=2025-12-24T09%3A22%3A40.212Z&includeRelated=false 2025-12-24 10:22:40.253 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34049/api/school/respect/person?since=2025-12-24T09%3A22%3A40.212Z&includeRelated=false 2025-12-24 10:22:40.253 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34049/api/school/respect/person?since=2025-12-24T09%3A22%3A40.212Z&includeRelated=false 2025-12-24 10:22:40.253 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34049/api/school/respect/person?since=2025-12-24T09%3A22%3A40.212Z&includeRelated=false. 2025-12-24 12:36:31.592 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 12:36:31.675 [Test worker] INFO io.ktor.server.Application - Application started in 0.195 seconds. 2025-12-24 12:36:31.765 [DefaultDispatcher-worker-1 @coroutine#2] INFO io.ktor.server.Application - Responding at http://0.0.0.0:45415 2025-12-24 12:36:32.052 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45415/resources/index.json 2025-12-24 12:36:32.052 [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:45415/resources/index.json. 2025-12-24 12:36:32.052 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45415/resources/index.json 2025-12-24 12:36:32.192 [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) 2025-12-24 12:36:32.232 [eventLoopGroupProxy-4-1 @call-handler#12] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 46ms 2025-12-24 12:36:32.236 [DefaultDispatcher-worker-2 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45415/resources/index.json 2025-12-24 12:36:32.238 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45415/resources/index.json 2025-12-24 12:36:32.238 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45415/resources/index.json 2025-12-24 12:36:32.256 [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:45415/resources/index.json. 2025-12-24 12:36:32.287 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45415/resources/index.json 2025-12-24 12:36:32.287 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45415/resources/index.json. 2025-12-24 12:36:32.288 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45415/resources/index.json 2025-12-24 12:36:32.290 [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) 2025-12-24 12:36:32.291 [eventLoopGroupProxy-4-1 @call-handler#22] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms 2025-12-24 12:36:32.292 [DefaultDispatcher-worker-2 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45415/resources/index.json 2025-12-24 12:36:32.293 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45415/resources/index.json 2025-12-24 12:36:32.293 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45415/resources/index.json 2025-12-24 12:36:34.307 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 12:36:34.307 [Test worker] INFO io.ktor.server.Application - Application started in 0.0 seconds. 2025-12-24 12:36:34.308 [DefaultDispatcher-worker-2 @coroutine#26] INFO io.ktor.server.Application - Responding at http://0.0.0.0:41141 2025-12-24 12:36:34.366 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41141/resources/index.json 2025-12-24 12:36:34.366 [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:41141/resources/index.json. 2025-12-24 12:36:34.366 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41141/resources/index.json 2025-12-24 12:36:34.369 [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) 2025-12-24 12:36:34.370 [eventLoopGroupProxy-7-1 @call-handler#35] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 1ms 2025-12-24 12:36:34.371 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41141/resources/index.json 2025-12-24 12:36:34.371 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41141/resources/index.json 2025-12-24 12:36:34.371 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41141/resources/index.json 2025-12-24 12:36:34.371 [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:41141/resources/index.json. 2025-12-24 12:36:34.375 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41141/resources/index.json 2025-12-24 12:36:34.375 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41141/resources/index.json. 2025-12-24 12:36:34.375 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41141/resources/index.json 2025-12-24 12:36:34.376 [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) 2025-12-24 12:36:34.376 [eventLoopGroupProxy-7-1 @call-handler#45] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 0ms 2025-12-24 12:36:34.376 [DefaultDispatcher-worker-1 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41141/resources/index.json 2025-12-24 12:36:34.377 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41141/resources/index.json 2025-12-24 12:36:34.377 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41141/resources/index.json 2025-12-24 12:36:36.383 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 12:36:36.384 [Test worker] INFO io.ktor.server.Application - Application started in 0.001 seconds. 2025-12-24 12:36:36.385 [DefaultDispatcher-worker-1 @coroutine#49] INFO io.ktor.server.Application - Responding at http://0.0.0.0:45323 2025-12-24 12:36:36.388 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45323/resources/lesson001.json 2025-12-24 12:36:36.388 [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:45323/resources/lesson001.json. 2025-12-24 12:36:36.388 [Test worker @coroutine#52] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45323/resources/lesson001.json 2025-12-24 12:36:36.390 [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) 2025-12-24 12:36:36.391 [DefaultDispatcher-worker-2 @call-handler#56] INFO io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 1ms 2025-12-24 12:36:36.391 [DefaultDispatcher-worker-2 @coroutine#52] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45323/resources/lesson001.json 2025-12-24 12:36:36.392 [DefaultDispatcher-worker-2 @coroutine#52] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45323/resources/lesson001.json 2025-12-24 12:36:36.392 [DefaultDispatcher-worker-2 @coroutine#52] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45323/resources/lesson001.json 2025-12-24 12:36:36.408 [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:45323/resources/lesson001.json. 2025-12-24 12:36:38.879 [Test worker @coroutine#61] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 12:36:38.888 [Test worker @coroutine#61] INFO io.ktor.server.Application - Application started in 0.454 seconds. 2025-12-24 12:36:38.891 [DefaultDispatcher-worker-2 @coroutine#67] INFO io.ktor.server.Application - Responding at http://0.0.0.0:39883 2025-12-24 12:36:38.967 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39883/api/school/respect/person?includeRelated=false 2025-12-24 12:36:38.967 [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:39883/api/school/respect/person?includeRelated=false. 2025-12-24 12:36:38.967 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39883/api/school/respect/person?includeRelated=false 2025-12-24 12:36:38.974 [eventLoopGroupProxy-13-1 @call-handler#72] 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) 2025-12-24 12:36:39.005 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39883/api/school/respect/person?includeRelated=false 2025-12-24 12:36:39.006 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39883/api/school/respect/person?includeRelated=false 2025-12-24 12:36:39.006 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39883/api/school/respect/person?includeRelated=false 2025-12-24 12:36:39.007 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:39883/api/school/respect/person?includeRelated=false. 2025-12-24 12:36:39.043 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39883/api/school/respect/person?includeRelated=false 2025-12-24 12:36:39.044 [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:39883/api/school/respect/person?includeRelated=false. 2025-12-24 12:36:39.044 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39883/api/school/respect/person?includeRelated=false 2025-12-24 12:36:39.046 [eventLoopGroupProxy-13-1 @call-handler#78] 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) 2025-12-24 12:36:39.048 [DefaultDispatcher-worker-1 @call-handler#78] 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]. 2025-12-24 12:36:39.049 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39883/api/school/respect/person?includeRelated=false 2025-12-24 12:36:39.049 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39883/api/school/respect/person?includeRelated=false 2025-12-24 12:36:39.049 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39883/api/school/respect/person?includeRelated=false 2025-12-24 12:36:41.099 [Test worker @coroutine#82] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 12:36:41.100 [Test worker @coroutine#82] INFO io.ktor.server.Application - Application started in 0.04 seconds. 2025-12-24 12:36:41.102 [DefaultDispatcher-worker-2 @coroutine#88] INFO io.ktor.server.Application - Responding at http://0.0.0.0:44401 2025-12-24 12:36:41.186 [DefaultDispatcher-worker-2 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44401/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2025-12-24 12:36:41.187 [DefaultDispatcher-worker-2 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:44401/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100. 2025-12-24 12:36:41.187 [DefaultDispatcher-worker-2 @coroutine#91] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44401/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2025-12-24 12:36:41.190 [eventLoopGroupProxy-16-1 @call-handler#97] 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) 2025-12-24 12:36:41.193 [DefaultDispatcher-worker-3 @coroutine#91] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44401/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2025-12-24 12:36:41.193 [DefaultDispatcher-worker-3 @coroutine#91] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44401/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2025-12-24 12:36:41.193 [DefaultDispatcher-worker-3 @coroutine#91] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44401/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100 2025-12-24 12:36:41.193 [DefaultDispatcher-worker-3 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44401/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100. 2025-12-24 12:36:43.271 [Test worker @coroutine#102] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 12:36:43.272 [Test worker @coroutine#102] INFO io.ktor.server.Application - Application started in 0.062 seconds. 2025-12-24 12:36:43.273 [DefaultDispatcher-worker-5 @coroutine#108] INFO io.ktor.server.Application - Responding at http://0.0.0.0:41305 2025-12-24 12:36:43.326 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41305/api/school/respect/person?includeRelated=false 2025-12-24 12:36:43.326 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41305/api/school/respect/person?includeRelated=false. 2025-12-24 12:36:43.326 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41305/api/school/respect/person?includeRelated=false 2025-12-24 12:36:43.329 [eventLoopGroupProxy-19-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) Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2025-12-24 12:36:43.332 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41305/api/school/respect/person?includeRelated=false 2025-12-24 12:36:43.332 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41305/api/school/respect/person?includeRelated=false 2025-12-24 12:36:43.332 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41305/api/school/respect/person?includeRelated=false 2025-12-24 12:36:43.332 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41305/api/school/respect/person?includeRelated=false. 2025-12-24 12:36:43.379 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41305/api/school/respect/person?since=2025-12-24T11%3A36%3A43.329Z&includeRelated=false 2025-12-24 12:36:43.379 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41305/api/school/respect/person?since=2025-12-24T11%3A36%3A43.329Z&includeRelated=false. 2025-12-24 12:36:43.379 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41305/api/school/respect/person?since=2025-12-24T11%3A36%3A43.329Z&includeRelated=false 2025-12-24 12:36:43.381 [eventLoopGroupProxy-19-1 @call-handler#119] 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) 2025-12-24 12:36:43.383 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41305/api/school/respect/person?since=2025-12-24T11%3A36%3A43.329Z&includeRelated=false 2025-12-24 12:36:43.383 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41305/api/school/respect/person?since=2025-12-24T11%3A36%3A43.329Z&includeRelated=false 2025-12-24 12:36:43.383 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41305/api/school/respect/person?since=2025-12-24T11%3A36%3A43.329Z&includeRelated=false 2025-12-24 12:36:43.383 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41305/api/school/respect/person?since=2025-12-24T11%3A36%3A43.329Z&includeRelated=false. 2025-12-24 12:36:45.442 [Test worker @coroutine#124] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 12:36:45.443 [Test worker @coroutine#124] INFO io.ktor.server.Application - Application started in 0.049 seconds. 2025-12-24 12:36:45.444 [DefaultDispatcher-worker-3 @coroutine#130] INFO io.ktor.server.Application - Responding at http://0.0.0.0:38771 2025-12-24 12:36:45.478 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38771/api/school/respect/person 2025-12-24 12:36:45.478 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@39fc220e for http://localhost:38771/api/school/respect/person 2025-12-24 12:36:45.478 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38771/api/school/respect/person 2025-12-24 12:36:45.478 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:38771/api/school/respect/person from class io.ktor.http.content.TextContent 2025-12-24 12:36:45.481 [eventLoopGroupProxy-22-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 -> 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) 2025-12-24 12:36:45.487 [eventLoopGroupProxy-22-1 @call-handler#138] 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 2025-12-24 12:36:45.510 [DefaultDispatcher-worker-1 @call-handler#138] 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]. 2025-12-24 12:36:45.511 [DefaultDispatcher-worker-2 @coroutine#128] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38771/api/school/respect/person 2025-12-24 12:36:45.511 [DefaultDispatcher-worker-2 @coroutine#128] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38771/api/school/respect/person 2025-12-24 12:36:45.511 [DefaultDispatcher-worker-2 @coroutine#128] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38771/api/school/respect/person 2025-12-24 12:36:47.566 [Test worker @coroutine#143] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 12:36:47.566 [Test worker @coroutine#143] INFO io.ktor.server.Application - Application started in 0.048 seconds. 2025-12-24 12:36:47.567 [DefaultDispatcher-worker-4 @coroutine#149] INFO io.ktor.server.Application - Responding at http://0.0.0.0:33415 2025-12-24 12:36:47.602 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33415/api/school/respect/person?includeRelated=false 2025-12-24 12:36:47.602 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:33415/api/school/respect/person?includeRelated=false. 2025-12-24 12:36:47.602 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33415/api/school/respect/person?includeRelated=false 2025-12-24 12:36:47.604 [eventLoopGroupProxy-25-1 @call-handler#154] 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) 2025-12-24 12:36:47.607 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33415/api/school/respect/person?includeRelated=false 2025-12-24 12:36:47.607 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33415/api/school/respect/person?includeRelated=false 2025-12-24 12:36:47.607 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33415/api/school/respect/person?includeRelated=false 2025-12-24 12:36:47.608 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:33415/api/school/respect/person?includeRelated=false. 2025-12-24 12:36:49.640 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33415/api/school/respect/person?includeRelated=false 2025-12-24 12:36:49.641 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:33415/api/school/respect/person?includeRelated=false. 2025-12-24 12:36:49.641 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33415/api/school/respect/person?includeRelated=false 2025-12-24 12:36:49.642 [eventLoopGroupProxy-25-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 -> 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) 2025-12-24 12:36:49.645 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33415/api/school/respect/person?includeRelated=false 2025-12-24 12:36:49.645 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33415/api/school/respect/person?includeRelated=false 2025-12-24 12:36:49.645 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33415/api/school/respect/person?includeRelated=false 2025-12-24 12:36:49.645 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:33415/api/school/respect/person?includeRelated=false. 2025-12-24 12:36:51.693 [Test worker @coroutine#167] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-12-24 12:36:51.694 [Test worker @coroutine#167] INFO io.ktor.server.Application - Application started in 0.039 seconds. 2025-12-24 12:36:51.695 [DefaultDispatcher-worker-4 @coroutine#173] INFO io.ktor.server.Application - Responding at http://0.0.0.0:34683 2025-12-24 12:36:51.730 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34683/api/school/respect/person?includeRelated=false 2025-12-24 12:36:51.731 [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:34683/api/school/respect/person?includeRelated=false. 2025-12-24 12:36:51.731 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34683/api/school/respect/person?includeRelated=false 2025-12-24 12:36:51.733 [eventLoopGroupProxy-28-1 @call-handler#178] 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) 2025-12-24 12:36:51.736 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34683/api/school/respect/person?includeRelated=false 2025-12-24 12:36:51.736 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34683/api/school/respect/person?includeRelated=false 2025-12-24 12:36:51.736 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34683/api/school/respect/person?includeRelated=false 2025-12-24 12:36:51.736 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34683/api/school/respect/person?includeRelated=false. 2025-12-24 12:36:51.767 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34683/api/school/respect/person?since=2025-12-24T11%3A36%3A51.733Z&includeRelated=false 2025-12-24 12:36:51.767 [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:34683/api/school/respect/person?since=2025-12-24T11%3A36%3A51.733Z&includeRelated=false. 2025-12-24 12:36:51.767 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34683/api/school/respect/person?since=2025-12-24T11%3A36%3A51.733Z&includeRelated=false 2025-12-24 12:36:51.768 [eventLoopGroupProxy-28-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) Matched routes: "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)" Routing resolve result: SUCCESS @ /api/school/respect/person/(method:GET) 2025-12-24 12:36:51.770 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34683/api/school/respect/person?since=2025-12-24T11%3A36%3A51.733Z&includeRelated=false 2025-12-24 12:36:51.770 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34683/api/school/respect/person?since=2025-12-24T11%3A36%3A51.733Z&includeRelated=false 2025-12-24 12:36:51.770 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34683/api/school/respect/person?since=2025-12-24T11%3A36%3A51.733Z&includeRelated=false 2025-12-24 12:36:51.771 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34683/api/school/respect/person?since=2025-12-24T11%3A36%3A51.733Z&includeRelated=false.