2025-11-13 10:59:53.049 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 10:59:53.170 [Test worker] INFO  io.ktor.server.Application - Application started in 0.273 seconds.
2025-11-13 10:59:53.293 [DefaultDispatcher-worker-1 @coroutine#2] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:42437
2025-11-13 10:59:53.675 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42437/resources/index.json
2025-11-13 10:59:53.676 [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:42437/resources/index.json.
2025-11-13 10:59:53.676 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42437/resources/index.json
2025-11-13 10:59:54.048 [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-11-13 10:59:54.118 [DefaultDispatcher-worker-2 @call-handler#12] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 79ms
2025-11-13 10:59:54.123 [DefaultDispatcher-worker-2 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42437/resources/index.json
2025-11-13 10:59:54.125 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42437/resources/index.json
2025-11-13 10:59:54.126 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42437/resources/index.json
2025-11-13 10:59:54.148 [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:42437/resources/index.json.
2025-11-13 10:59:54.187 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42437/resources/index.json
2025-11-13 10:59:54.187 [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:42437/resources/index.json.
2025-11-13 10:59:54.187 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42437/resources/index.json
2025-11-13 10:59:54.190 [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-11-13 10:59:54.191 [eventLoopGroupProxy-4-1 @call-handler#22] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 2ms
2025-11-13 10:59:54.192 [DefaultDispatcher-worker-1 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42437/resources/index.json
2025-11-13 10:59:54.192 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42437/resources/index.json
2025-11-13 10:59:54.192 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42437/resources/index.json
2025-11-13 10:59:56.206 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 10:59:56.207 [Test worker] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2025-11-13 10:59:56.211 [DefaultDispatcher-worker-1 @coroutine#26] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:40747
2025-11-13 10:59:56.252 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40747/resources/index.json
2025-11-13 10:59:56.252 [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:40747/resources/index.json.
2025-11-13 10:59:56.252 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40747/resources/index.json
2025-11-13 10:59:56.256 [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-11-13 10:59:56.257 [DefaultDispatcher-worker-2 @call-handler#35] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 1ms
2025-11-13 10:59:56.257 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40747/resources/index.json
2025-11-13 10:59:56.258 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40747/resources/index.json
2025-11-13 10:59:56.258 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40747/resources/index.json
2025-11-13 10:59:56.258 [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:40747/resources/index.json.
2025-11-13 10:59:56.262 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40747/resources/index.json
2025-11-13 10:59:56.263 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:40747/resources/index.json.
2025-11-13 10:59:56.263 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40747/resources/index.json
2025-11-13 10:59:56.264 [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-11-13 10:59:56.265 [eventLoopGroupProxy-7-1 @call-handler#45] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms
2025-11-13 10:59:56.265 [DefaultDispatcher-worker-2 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40747/resources/index.json
2025-11-13 10:59:56.265 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40747/resources/index.json
2025-11-13 10:59:56.265 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40747/resources/index.json
2025-11-13 10:59:58.279 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 10:59:58.280 [Test worker] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2025-11-13 10:59:58.284 [DefaultDispatcher-worker-2 @coroutine#49] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:41957
2025-11-13 10:59:58.294 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41957/resources/lesson001.json
2025-11-13 10:59:58.295 [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:41957/resources/lesson001.json.
2025-11-13 10:59:58.295 [Test worker @coroutine#52] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41957/resources/lesson001.json
2025-11-13 10:59:58.302 [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-11-13 10:59:58.305 [DefaultDispatcher-worker-2 @call-handler#56] INFO  io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 3ms
2025-11-13 10:59:58.312 [DefaultDispatcher-worker-3 @coroutine#52] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41957/resources/lesson001.json
2025-11-13 10:59:58.313 [DefaultDispatcher-worker-3 @coroutine#52] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41957/resources/lesson001.json
2025-11-13 10:59:58.313 [DefaultDispatcher-worker-3 @coroutine#52] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41957/resources/lesson001.json
2025-11-13 10:59:58.387 [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:41957/resources/lesson001.json.
2025-11-13 11:00:00.898 [Test worker @coroutine#61] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 11:00:00.908 [Test worker @coroutine#61] INFO  io.ktor.server.Application - Application started in 0.452 seconds.
2025-11-13 11:00:00.910 [DefaultDispatcher-worker-3 @coroutine#67] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:35983
2025-11-13 11:00:00.990 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35983/api/school/respect/person?includeRelated=false
2025-11-13 11:00:00.990 [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:35983/api/school/respect/person?includeRelated=false.
2025-11-13 11:00:00.991 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35983/api/school/respect/person?includeRelated=false
2025-11-13 11:00:00.996 [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-11-13 11:00:01.025 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35983/api/school/respect/person?includeRelated=false
2025-11-13 11:00:01.025 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35983/api/school/respect/person?includeRelated=false
2025-11-13 11:00:01.025 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35983/api/school/respect/person?includeRelated=false
2025-11-13 11:00:01.027 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:35983/api/school/respect/person?includeRelated=false.
2025-11-13 11:00:01.062 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35983/api/school/respect/person?includeRelated=false
2025-11-13 11:00:01.063 [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:35983/api/school/respect/person?includeRelated=false.
2025-11-13 11:00:01.063 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35983/api/school/respect/person?includeRelated=false
2025-11-13 11:00:01.064 [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-11-13 11:00:01.066 [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-11-13 11:00:01.067 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35983/api/school/respect/person?includeRelated=false
2025-11-13 11:00:01.068 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35983/api/school/respect/person?includeRelated=false
2025-11-13 11:00:01.068 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35983/api/school/respect/person?includeRelated=false
2025-11-13 11:00:03.200 [Test worker @coroutine#82] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 11:00:03.203 [Test worker @coroutine#82] INFO  io.ktor.server.Application - Application started in 0.062 seconds.
2025-11-13 11:00:03.208 [DefaultDispatcher-worker-4 @coroutine#88] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:40479
2025-11-13 11:00:03.326 [DefaultDispatcher-worker-2 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40479/api/school/respect/person?includeRelated=false&offset=0&limit=100
2025-11-13 11:00:03.333 [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:40479/api/school/respect/person?includeRelated=false&offset=0&limit=100.
2025-11-13 11:00:03.333 [DefaultDispatcher-worker-2 @coroutine#91] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40479/api/school/respect/person?includeRelated=false&offset=0&limit=100
2025-11-13 11:00:03.354 [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-11-13 11:00:03.362 [DefaultDispatcher-worker-1 @coroutine#91] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40479/api/school/respect/person?includeRelated=false&offset=0&limit=100
2025-11-13 11:00:03.370 [DefaultDispatcher-worker-6 @coroutine#91] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40479/api/school/respect/person?includeRelated=false&offset=0&limit=100
2025-11-13 11:00:03.370 [DefaultDispatcher-worker-6 @coroutine#91] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40479/api/school/respect/person?includeRelated=false&offset=0&limit=100
2025-11-13 11:00:03.373 [DefaultDispatcher-worker-6 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:40479/api/school/respect/person?includeRelated=false&offset=0&limit=100.
2025-11-13 11:00:05.578 [Test worker @coroutine#102] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 11:00:05.578 [Test worker @coroutine#102] INFO  io.ktor.server.Application - Application started in 0.093 seconds.
2025-11-13 11:00:05.580 [DefaultDispatcher-worker-3 @coroutine#108] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:34261
2025-11-13 11:00:05.675 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34261/api/school/respect/person?includeRelated=false
2025-11-13 11:00:05.676 [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:34261/api/school/respect/person?includeRelated=false.
2025-11-13 11:00:05.676 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34261/api/school/respect/person?includeRelated=false
2025-11-13 11:00:05.696 [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-11-13 11:00:05.701 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34261/api/school/respect/person?includeRelated=false
2025-11-13 11:00:05.702 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34261/api/school/respect/person?includeRelated=false
2025-11-13 11:00:05.702 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34261/api/school/respect/person?includeRelated=false
2025-11-13 11:00:05.702 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34261/api/school/respect/person?includeRelated=false.
2025-11-13 11:00:05.867 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34261/api/school/respect/person?since=2025-11-13T10%3A00%3A05.696Z&includeRelated=false
2025-11-13 11:00:05.867 [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:34261/api/school/respect/person?since=2025-11-13T10%3A00%3A05.696Z&includeRelated=false.
2025-11-13 11:00:05.867 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34261/api/school/respect/person?since=2025-11-13T10%3A00%3A05.696Z&includeRelated=false
2025-11-13 11:00:05.883 [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-11-13 11:00:05.893 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34261/api/school/respect/person?since=2025-11-13T10%3A00%3A05.696Z&includeRelated=false
2025-11-13 11:00:05.895 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34261/api/school/respect/person?since=2025-11-13T10%3A00%3A05.696Z&includeRelated=false
2025-11-13 11:00:05.895 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34261/api/school/respect/person?since=2025-11-13T10%3A00%3A05.696Z&includeRelated=false
2025-11-13 11:00:05.897 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34261/api/school/respect/person?since=2025-11-13T10%3A00%3A05.696Z&includeRelated=false.
2025-11-13 11:00:08.013 [Test worker @coroutine#124] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 11:00:08.013 [Test worker @coroutine#124] INFO  io.ktor.server.Application - Application started in 0.056 seconds.
2025-11-13 11:00:08.015 [DefaultDispatcher-worker-6 @coroutine#130] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:37019
2025-11-13 11:00:08.079 [DefaultDispatcher-worker-8 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37019/api/school/respect/person
2025-11-13 11:00:08.079 [DefaultDispatcher-worker-8 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@7e432568 for http://localhost:37019/api/school/respect/person
2025-11-13 11:00:08.079 [DefaultDispatcher-worker-8 @coroutine#128] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37019/api/school/respect/person
2025-11-13 11:00:08.080 [DefaultDispatcher-worker-8 @coroutine#128] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:37019/api/school/respect/person from class io.ktor.http.content.TextContent
2025-11-13 11:00:08.084 [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-11-13 11:00:08.090 [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<world.respect.datalayer.school.model.Person>) for call /api/school/respect/person
2025-11-13 11:00:08.119 [DefaultDispatcher-worker-8 @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-11-13 11:00:08.120 [DefaultDispatcher-worker-3 @coroutine#128] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37019/api/school/respect/person
2025-11-13 11:00:08.120 [DefaultDispatcher-worker-3 @coroutine#128] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37019/api/school/respect/person
2025-11-13 11:00:08.120 [DefaultDispatcher-worker-3 @coroutine#128] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37019/api/school/respect/person
2025-11-13 11:00:10.201 [Test worker @coroutine#143] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 11:00:10.202 [Test worker @coroutine#143] INFO  io.ktor.server.Application - Application started in 0.061 seconds.
2025-11-13 11:00:10.203 [DefaultDispatcher-worker-2 @coroutine#149] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:44187
2025-11-13 11:00:10.234 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44187/api/school/respect/person?includeRelated=false
2025-11-13 11:00:10.235 [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:44187/api/school/respect/person?includeRelated=false.
2025-11-13 11:00:10.235 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44187/api/school/respect/person?includeRelated=false
2025-11-13 11:00:10.237 [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-11-13 11:00:10.241 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44187/api/school/respect/person?includeRelated=false
2025-11-13 11:00:10.241 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44187/api/school/respect/person?includeRelated=false
2025-11-13 11:00:10.241 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44187/api/school/respect/person?includeRelated=false
2025-11-13 11:00:10.241 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44187/api/school/respect/person?includeRelated=false.
2025-11-13 11:00:12.285 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44187/api/school/respect/person?includeRelated=false
2025-11-13 11:00:12.286 [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:44187/api/school/respect/person?includeRelated=false.
2025-11-13 11:00:12.286 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44187/api/school/respect/person?includeRelated=false
2025-11-13 11:00:12.291 [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-11-13 11:00:12.295 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44187/api/school/respect/person?includeRelated=false
2025-11-13 11:00:12.295 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44187/api/school/respect/person?includeRelated=false
2025-11-13 11:00:12.295 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44187/api/school/respect/person?includeRelated=false
2025-11-13 11:00:12.296 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44187/api/school/respect/person?includeRelated=false.
2025-11-13 11:00:14.383 [Test worker @coroutine#167] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 11:00:14.384 [Test worker @coroutine#167] INFO  io.ktor.server.Application - Application started in 0.073 seconds.
2025-11-13 11:00:14.385 [DefaultDispatcher-worker-5 @coroutine#173] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:41897
2025-11-13 11:00:14.421 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41897/api/school/respect/person?includeRelated=false
2025-11-13 11:00:14.421 [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:41897/api/school/respect/person?includeRelated=false.
2025-11-13 11:00:14.421 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41897/api/school/respect/person?includeRelated=false
2025-11-13 11:00:14.423 [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-11-13 11:00:14.427 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41897/api/school/respect/person?includeRelated=false
2025-11-13 11:00:14.427 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41897/api/school/respect/person?includeRelated=false
2025-11-13 11:00:14.427 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41897/api/school/respect/person?includeRelated=false
2025-11-13 11:00:14.427 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41897/api/school/respect/person?includeRelated=false.
2025-11-13 11:00:14.459 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41897/api/school/respect/person?since=2025-11-13T10%3A00%3A14.424Z&includeRelated=false
2025-11-13 11:00:14.459 [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:41897/api/school/respect/person?since=2025-11-13T10%3A00%3A14.424Z&includeRelated=false.
2025-11-13 11:00:14.459 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41897/api/school/respect/person?since=2025-11-13T10%3A00%3A14.424Z&includeRelated=false
2025-11-13 11:00:14.461 [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-11-13 11:00:14.467 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41897/api/school/respect/person?since=2025-11-13T10%3A00%3A14.424Z&includeRelated=false
2025-11-13 11:00:14.468 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41897/api/school/respect/person?since=2025-11-13T10%3A00%3A14.424Z&includeRelated=false
2025-11-13 11:00:14.468 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41897/api/school/respect/person?since=2025-11-13T10%3A00%3A14.424Z&includeRelated=false
2025-11-13 11:00:14.468 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41897/api/school/respect/person?since=2025-11-13T10%3A00%3A14.424Z&includeRelated=false.
2025-11-13 14:21:29.409 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 14:21:29.535 [Test worker] INFO  io.ktor.server.Application - Application started in 0.328 seconds.
2025-11-13 14:21:29.692 [DefaultDispatcher-worker-1 @coroutine#2] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:44009
2025-11-13 14:21:29.991 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44009/resources/index.json
2025-11-13 14:21:29.991 [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:44009/resources/index.json.
2025-11-13 14:21:29.991 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44009/resources/index.json
2025-11-13 14:21:30.172 [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-11-13 14:21:30.226 [eventLoopGroupProxy-4-1 @call-handler#12] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 60ms
2025-11-13 14:21:30.231 [DefaultDispatcher-worker-2 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44009/resources/index.json
2025-11-13 14:21:30.233 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44009/resources/index.json
2025-11-13 14:21:30.234 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44009/resources/index.json
2025-11-13 14:21:30.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:44009/resources/index.json.
2025-11-13 14:21:30.346 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44009/resources/index.json
2025-11-13 14:21:30.346 [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:44009/resources/index.json.
2025-11-13 14:21:30.346 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44009/resources/index.json
2025-11-13 14:21:30.358 [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-11-13 14:21:30.364 [eventLoopGroupProxy-4-1 @call-handler#22] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 6ms
2025-11-13 14:21:30.373 [DefaultDispatcher-worker-1 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44009/resources/index.json
2025-11-13 14:21:30.374 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44009/resources/index.json
2025-11-13 14:21:30.374 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44009/resources/index.json
2025-11-13 14:21:32.416 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 14:21:32.417 [Test worker] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2025-11-13 14:21:32.419 [DefaultDispatcher-worker-1 @coroutine#26] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:33805
2025-11-13 14:21:32.476 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33805/resources/index.json
2025-11-13 14:21:32.477 [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:33805/resources/index.json.
2025-11-13 14:21:32.477 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33805/resources/index.json
2025-11-13 14:21:32.481 [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-11-13 14:21:32.482 [eventLoopGroupProxy-7-1 @call-handler#35] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 1ms
2025-11-13 14:21:32.486 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33805/resources/index.json
2025-11-13 14:21:32.486 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33805/resources/index.json
2025-11-13 14:21:32.486 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33805/resources/index.json
2025-11-13 14:21:32.487 [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:33805/resources/index.json.
2025-11-13 14:21:32.494 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33805/resources/index.json
2025-11-13 14:21:32.495 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:33805/resources/index.json.
2025-11-13 14:21:32.495 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33805/resources/index.json
2025-11-13 14:21:32.499 [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-11-13 14:21:32.500 [eventLoopGroupProxy-7-1 @call-handler#45] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 2ms
2025-11-13 14:21:32.501 [DefaultDispatcher-worker-1 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33805/resources/index.json
2025-11-13 14:21:32.502 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33805/resources/index.json
2025-11-13 14:21:32.502 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33805/resources/index.json
2025-11-13 14:21:34.517 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 14:21:34.518 [Test worker] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2025-11-13 14:21:34.519 [DefaultDispatcher-worker-1 @coroutine#49] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:33563
2025-11-13 14:21:34.525 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33563/resources/lesson001.json
2025-11-13 14:21:34.525 [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:33563/resources/lesson001.json.
2025-11-13 14:21:34.525 [Test worker @coroutine#52] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33563/resources/lesson001.json
2025-11-13 14:21:34.529 [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-11-13 14:21:34.531 [eventLoopGroupProxy-10-1 @call-handler#56] INFO  io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 2ms
2025-11-13 14:21:34.532 [DefaultDispatcher-worker-3 @coroutine#52] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33563/resources/lesson001.json
2025-11-13 14:21:34.533 [DefaultDispatcher-worker-3 @coroutine#52] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33563/resources/lesson001.json
2025-11-13 14:21:34.533 [DefaultDispatcher-worker-3 @coroutine#52] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33563/resources/lesson001.json
2025-11-13 14:21:34.555 [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:33563/resources/lesson001.json.
2025-11-13 14:21:37.636 [Test worker @coroutine#61] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 14:21:37.651 [Test worker @coroutine#61] INFO  io.ktor.server.Application - Application started in 1.022 seconds.
2025-11-13 14:21:37.657 [DefaultDispatcher-worker-1 @coroutine#67] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:42687
2025-11-13 14:21:37.920 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42687/api/school/respect/person?includeRelated=false
2025-11-13 14:21:37.921 [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:42687/api/school/respect/person?includeRelated=false.
2025-11-13 14:21:37.924 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42687/api/school/respect/person?includeRelated=false
2025-11-13 14:21:37.946 [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-11-13 14:21:38.005 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42687/api/school/respect/person?includeRelated=false
2025-11-13 14:21:38.006 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42687/api/school/respect/person?includeRelated=false
2025-11-13 14:21:38.006 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42687/api/school/respect/person?includeRelated=false
2025-11-13 14:21:38.009 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:42687/api/school/respect/person?includeRelated=false.
2025-11-13 14:21:38.072 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42687/api/school/respect/person?includeRelated=false
2025-11-13 14:21:38.072 [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:42687/api/school/respect/person?includeRelated=false.
2025-11-13 14:21:38.072 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42687/api/school/respect/person?includeRelated=false
2025-11-13 14:21:38.075 [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-11-13 14:21:38.077 [DefaultDispatcher-worker-3 @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-11-13 14:21:38.079 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42687/api/school/respect/person?includeRelated=false
2025-11-13 14:21:38.079 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42687/api/school/respect/person?includeRelated=false
2025-11-13 14:21:38.079 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42687/api/school/respect/person?includeRelated=false
2025-11-13 14:21:40.166 [Test worker @coroutine#82] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 14:21:40.167 [Test worker @coroutine#82] INFO  io.ktor.server.Application - Application started in 0.06 seconds.
2025-11-13 14:21:40.168 [DefaultDispatcher-worker-2 @coroutine#88] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:38851
2025-11-13 14:21:40.232 [DefaultDispatcher-worker-3 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38851/api/school/respect/person?includeRelated=false&offset=0&limit=100
2025-11-13 14:21:40.232 [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:38851/api/school/respect/person?includeRelated=false&offset=0&limit=100.
2025-11-13 14:21:40.232 [DefaultDispatcher-worker-3 @coroutine#91] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38851/api/school/respect/person?includeRelated=false&offset=0&limit=100
2025-11-13 14:21:40.235 [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-11-13 14:21:40.238 [DefaultDispatcher-worker-1 @coroutine#91] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38851/api/school/respect/person?includeRelated=false&offset=0&limit=100
2025-11-13 14:21:40.238 [DefaultDispatcher-worker-1 @coroutine#91] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38851/api/school/respect/person?includeRelated=false&offset=0&limit=100
2025-11-13 14:21:40.238 [DefaultDispatcher-worker-1 @coroutine#91] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38851/api/school/respect/person?includeRelated=false&offset=0&limit=100
2025-11-13 14:21:40.238 [DefaultDispatcher-worker-1 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:38851/api/school/respect/person?includeRelated=false&offset=0&limit=100.
2025-11-13 14:21:42.356 [Test worker @coroutine#102] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 14:21:42.359 [Test worker @coroutine#102] INFO  io.ktor.server.Application - Application started in 0.065 seconds.
2025-11-13 14:21:42.367 [DefaultDispatcher-worker-1 @coroutine#108] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:41349
2025-11-13 14:21:42.409 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41349/api/school/respect/person?includeRelated=false
2025-11-13 14:21:42.410 [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:41349/api/school/respect/person?includeRelated=false.
2025-11-13 14:21:42.410 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41349/api/school/respect/person?includeRelated=false
2025-11-13 14:21:42.426 [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-11-13 14:21:42.434 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41349/api/school/respect/person?includeRelated=false
2025-11-13 14:21:42.435 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41349/api/school/respect/person?includeRelated=false
2025-11-13 14:21:42.435 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41349/api/school/respect/person?includeRelated=false
2025-11-13 14:21:42.436 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41349/api/school/respect/person?includeRelated=false.
2025-11-13 14:21:42.514 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41349/api/school/respect/person?since=2025-11-13T13%3A21%3A42.427Z&includeRelated=false
2025-11-13 14:21:42.514 [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:41349/api/school/respect/person?since=2025-11-13T13%3A21%3A42.427Z&includeRelated=false.
2025-11-13 14:21:42.514 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41349/api/school/respect/person?since=2025-11-13T13%3A21%3A42.427Z&includeRelated=false
2025-11-13 14:21:42.517 [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-11-13 14:21:42.521 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41349/api/school/respect/person?since=2025-11-13T13%3A21%3A42.427Z&includeRelated=false
2025-11-13 14:21:42.522 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41349/api/school/respect/person?since=2025-11-13T13%3A21%3A42.427Z&includeRelated=false
2025-11-13 14:21:42.522 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41349/api/school/respect/person?since=2025-11-13T13%3A21%3A42.427Z&includeRelated=false
2025-11-13 14:21:42.522 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41349/api/school/respect/person?since=2025-11-13T13%3A21%3A42.427Z&includeRelated=false.
2025-11-13 14:21:44.646 [Test worker @coroutine#124] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 14:21:44.647 [Test worker @coroutine#124] INFO  io.ktor.server.Application - Application started in 0.05 seconds.
2025-11-13 14:21:44.649 [DefaultDispatcher-worker-3 @coroutine#130] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:33531
2025-11-13 14:21:44.702 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33531/api/school/respect/person
2025-11-13 14:21:44.703 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@6b929baa for http://localhost:33531/api/school/respect/person
2025-11-13 14:21:44.703 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33531/api/school/respect/person
2025-11-13 14:21:44.703 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:33531/api/school/respect/person from class io.ktor.http.content.TextContent
2025-11-13 14:21:44.714 [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-11-13 14:21:44.734 [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<world.respect.datalayer.school.model.Person>) for call /api/school/respect/person
2025-11-13 14:21:44.741 [eventLoopGroupProxy-22-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-11-13 14:21:44.745 [DefaultDispatcher-worker-2 @coroutine#128] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33531/api/school/respect/person
2025-11-13 14:21:44.752 [DefaultDispatcher-worker-8 @coroutine#128] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33531/api/school/respect/person
2025-11-13 14:21:44.754 [DefaultDispatcher-worker-8 @coroutine#128] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33531/api/school/respect/person
2025-11-13 14:21:46.863 [Test worker @coroutine#143] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 14:21:46.864 [Test worker @coroutine#143] INFO  io.ktor.server.Application - Application started in 0.069 seconds.
2025-11-13 14:21:46.865 [DefaultDispatcher-worker-3 @coroutine#149] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:34033
2025-11-13 14:21:46.900 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34033/api/school/respect/person?includeRelated=false
2025-11-13 14:21:46.901 [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:34033/api/school/respect/person?includeRelated=false.
2025-11-13 14:21:46.901 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34033/api/school/respect/person?includeRelated=false
2025-11-13 14:21:46.904 [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-11-13 14:21:46.908 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34033/api/school/respect/person?includeRelated=false
2025-11-13 14:21:46.908 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34033/api/school/respect/person?includeRelated=false
2025-11-13 14:21:46.908 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34033/api/school/respect/person?includeRelated=false
2025-11-13 14:21:46.909 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34033/api/school/respect/person?includeRelated=false.
2025-11-13 14:21:48.946 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34033/api/school/respect/person?includeRelated=false
2025-11-13 14:21:48.946 [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:34033/api/school/respect/person?includeRelated=false.
2025-11-13 14:21:48.946 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34033/api/school/respect/person?includeRelated=false
2025-11-13 14:21:48.948 [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-11-13 14:21:48.974 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34033/api/school/respect/person?includeRelated=false
2025-11-13 14:21:48.975 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34033/api/school/respect/person?includeRelated=false
2025-11-13 14:21:48.975 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34033/api/school/respect/person?includeRelated=false
2025-11-13 14:21:48.977 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34033/api/school/respect/person?includeRelated=false.
2025-11-13 14:21:51.034 [Test worker @coroutine#167] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 14:21:51.035 [Test worker @coroutine#167] INFO  io.ktor.server.Application - Application started in 0.039 seconds.
2025-11-13 14:21:51.036 [DefaultDispatcher-worker-3 @coroutine#173] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:46165
2025-11-13 14:21:51.096 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46165/api/school/respect/person?includeRelated=false
2025-11-13 14:21:51.096 [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:46165/api/school/respect/person?includeRelated=false.
2025-11-13 14:21:51.096 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46165/api/school/respect/person?includeRelated=false
2025-11-13 14:21:51.119 [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-11-13 14:21:51.124 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46165/api/school/respect/person?includeRelated=false
2025-11-13 14:21:51.124 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46165/api/school/respect/person?includeRelated=false
2025-11-13 14:21:51.124 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46165/api/school/respect/person?includeRelated=false
2025-11-13 14:21:51.125 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:46165/api/school/respect/person?includeRelated=false.
2025-11-13 14:21:51.185 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46165/api/school/respect/person?since=2025-11-13T13%3A21%3A51.119Z&includeRelated=false
2025-11-13 14:21:51.185 [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:46165/api/school/respect/person?since=2025-11-13T13%3A21%3A51.119Z&includeRelated=false.
2025-11-13 14:21:51.185 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46165/api/school/respect/person?since=2025-11-13T13%3A21%3A51.119Z&includeRelated=false
2025-11-13 14:21:51.190 [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-11-13 14:21:51.199 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46165/api/school/respect/person?since=2025-11-13T13%3A21%3A51.119Z&includeRelated=false
2025-11-13 14:21:51.199 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46165/api/school/respect/person?since=2025-11-13T13%3A21%3A51.119Z&includeRelated=false
2025-11-13 14:21:51.199 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46165/api/school/respect/person?since=2025-11-13T13%3A21%3A51.119Z&includeRelated=false
2025-11-13 14:21:51.200 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:46165/api/school/respect/person?since=2025-11-13T13%3A21%3A51.119Z&includeRelated=false.
2025-11-13 14:24:25.954 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 14:24:26.093 [Test worker] INFO  io.ktor.server.Application - Application started in 0.327 seconds.
2025-11-13 14:24:26.241 [DefaultDispatcher-worker-1 @coroutine#2] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:43515
2025-11-13 14:24:26.585 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43515/resources/index.json
2025-11-13 14:24:26.585 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:43515/resources/index.json.
2025-11-13 14:24:26.586 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43515/resources/index.json
2025-11-13 14:24:26.780 [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-11-13 14:24:26.834 [DefaultDispatcher-worker-4 @call-handler#12] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 62ms
2025-11-13 14:24:26.840 [DefaultDispatcher-worker-4 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43515/resources/index.json
2025-11-13 14:24:26.843 [DefaultDispatcher-worker-4 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43515/resources/index.json
2025-11-13 14:24:26.843 [DefaultDispatcher-worker-4 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43515/resources/index.json
2025-11-13 14:24:26.866 [DefaultDispatcher-worker-4 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsFeed for http://localhost:43515/resources/index.json.
2025-11-13 14:24:26.910 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43515/resources/index.json
2025-11-13 14:24:26.910 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:43515/resources/index.json.
2025-11-13 14:24:26.910 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43515/resources/index.json
2025-11-13 14:24:26.923 [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-11-13 14:24:26.928 [eventLoopGroupProxy-4-1 @call-handler#22] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 8ms
2025-11-13 14:24:26.937 [DefaultDispatcher-worker-5 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43515/resources/index.json
2025-11-13 14:24:26.938 [DefaultDispatcher-worker-5 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43515/resources/index.json
2025-11-13 14:24:26.938 [DefaultDispatcher-worker-5 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43515/resources/index.json
2025-11-13 14:24:29.000 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 14:24:29.001 [Test worker] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2025-11-13 14:24:29.003 [DefaultDispatcher-worker-5 @coroutine#26] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:42339
2025-11-13 14:24:29.071 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42339/resources/index.json
2025-11-13 14:24:29.071 [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:42339/resources/index.json.
2025-11-13 14:24:29.071 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42339/resources/index.json
2025-11-13 14:24:29.079 [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-11-13 14:24:29.082 [DefaultDispatcher-worker-5 @call-handler#35] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 3ms
2025-11-13 14:24:29.083 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42339/resources/index.json
2025-11-13 14:24:29.084 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42339/resources/index.json
2025-11-13 14:24:29.084 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42339/resources/index.json
2025-11-13 14:24:29.086 [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:42339/resources/index.json.
2025-11-13 14:24:29.093 [DefaultDispatcher-worker-6 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42339/resources/index.json
2025-11-13 14:24:29.094 [DefaultDispatcher-worker-6 @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:42339/resources/index.json.
2025-11-13 14:24:29.094 [DefaultDispatcher-worker-6 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42339/resources/index.json
2025-11-13 14:24:29.096 [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-11-13 14:24:29.097 [eventLoopGroupProxy-7-1 @call-handler#45] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms
2025-11-13 14:24:29.098 [DefaultDispatcher-worker-5 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42339/resources/index.json
2025-11-13 14:24:29.098 [DefaultDispatcher-worker-5 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42339/resources/index.json
2025-11-13 14:24:29.098 [DefaultDispatcher-worker-5 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42339/resources/index.json
2025-11-13 14:24:31.108 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 14:24:31.109 [Test worker] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2025-11-13 14:24:31.111 [DefaultDispatcher-worker-5 @coroutine#49] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:42101
2025-11-13 14:24:31.116 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42101/resources/lesson001.json
2025-11-13 14:24:31.116 [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:42101/resources/lesson001.json.
2025-11-13 14:24:31.116 [Test worker @coroutine#52] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42101/resources/lesson001.json
2025-11-13 14:24:31.120 [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-11-13 14:24:31.121 [DefaultDispatcher-worker-5 @call-handler#56] INFO  io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 2ms
2025-11-13 14:24:31.122 [DefaultDispatcher-worker-5 @coroutine#52] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42101/resources/lesson001.json
2025-11-13 14:24:31.122 [DefaultDispatcher-worker-5 @coroutine#52] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42101/resources/lesson001.json
2025-11-13 14:24:31.122 [DefaultDispatcher-worker-5 @coroutine#52] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42101/resources/lesson001.json
2025-11-13 14:24:31.144 [DefaultDispatcher-worker-5 @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsPublication for http://localhost:42101/resources/lesson001.json.
2025-11-13 14:24:34.209 [Test worker @coroutine#61] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 14:24:34.227 [Test worker @coroutine#61] INFO  io.ktor.server.Application - Application started in 1.008 seconds.
2025-11-13 14:24:34.235 [DefaultDispatcher-worker-6 @coroutine#67] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:37285
2025-11-13 14:24:34.478 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37285/api/school/respect/person?includeRelated=false
2025-11-13 14:24:34.479 [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:37285/api/school/respect/person?includeRelated=false.
2025-11-13 14:24:34.479 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37285/api/school/respect/person?includeRelated=false
2025-11-13 14:24:34.510 [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-11-13 14:24:34.583 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37285/api/school/respect/person?includeRelated=false
2025-11-13 14:24:34.583 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37285/api/school/respect/person?includeRelated=false
2025-11-13 14:24:34.583 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37285/api/school/respect/person?includeRelated=false
2025-11-13 14:24:34.586 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:37285/api/school/respect/person?includeRelated=false.
2025-11-13 14:24:34.646 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37285/api/school/respect/person?includeRelated=false
2025-11-13 14:24:34.647 [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:37285/api/school/respect/person?includeRelated=false.
2025-11-13 14:24:34.647 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37285/api/school/respect/person?includeRelated=false
2025-11-13 14:24:34.650 [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-11-13 14:24:34.652 [DefaultDispatcher-worker-3 @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-11-13 14:24:34.654 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37285/api/school/respect/person?includeRelated=false
2025-11-13 14:24:34.655 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37285/api/school/respect/person?includeRelated=false
2025-11-13 14:24:34.655 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37285/api/school/respect/person?includeRelated=false
2025-11-13 14:24:36.735 [Test worker @coroutine#82] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 14:24:36.736 [Test worker @coroutine#82] INFO  io.ktor.server.Application - Application started in 0.054 seconds.
2025-11-13 14:24:36.737 [DefaultDispatcher-worker-5 @coroutine#88] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:43645
2025-11-13 14:24:36.808 [DefaultDispatcher-worker-6 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43645/api/school/respect/person?includeRelated=false&offset=0&limit=100
2025-11-13 14:24:36.809 [DefaultDispatcher-worker-6 @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:43645/api/school/respect/person?includeRelated=false&offset=0&limit=100.
2025-11-13 14:24:36.809 [DefaultDispatcher-worker-6 @coroutine#91] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43645/api/school/respect/person?includeRelated=false&offset=0&limit=100
2025-11-13 14:24:36.811 [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-11-13 14:24:36.815 [DefaultDispatcher-worker-1 @coroutine#91] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43645/api/school/respect/person?includeRelated=false&offset=0&limit=100
2025-11-13 14:24:36.815 [DefaultDispatcher-worker-1 @coroutine#91] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43645/api/school/respect/person?includeRelated=false&offset=0&limit=100
2025-11-13 14:24:36.815 [DefaultDispatcher-worker-1 @coroutine#91] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43645/api/school/respect/person?includeRelated=false&offset=0&limit=100
2025-11-13 14:24:36.815 [DefaultDispatcher-worker-1 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:43645/api/school/respect/person?includeRelated=false&offset=0&limit=100.
2025-11-13 14:24:38.973 [Test worker @coroutine#102] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 14:24:38.975 [Test worker @coroutine#102] INFO  io.ktor.server.Application - Application started in 0.072 seconds.
2025-11-13 14:24:38.977 [DefaultDispatcher-worker-1 @coroutine#108] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:46273
2025-11-13 14:24:39.034 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46273/api/school/respect/person?includeRelated=false
2025-11-13 14:24:39.034 [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:46273/api/school/respect/person?includeRelated=false.
2025-11-13 14:24:39.034 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46273/api/school/respect/person?includeRelated=false
2025-11-13 14:24:39.038 [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-11-13 14:24:39.043 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46273/api/school/respect/person?includeRelated=false
2025-11-13 14:24:39.044 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46273/api/school/respect/person?includeRelated=false
2025-11-13 14:24:39.044 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46273/api/school/respect/person?includeRelated=false
2025-11-13 14:24:39.044 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:46273/api/school/respect/person?includeRelated=false.
2025-11-13 14:24:39.148 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46273/api/school/respect/person?since=2025-11-13T13%3A24%3A39.039Z&includeRelated=false
2025-11-13 14:24:39.151 [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:46273/api/school/respect/person?since=2025-11-13T13%3A24%3A39.039Z&includeRelated=false.
2025-11-13 14:24:39.152 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46273/api/school/respect/person?since=2025-11-13T13%3A24%3A39.039Z&includeRelated=false
2025-11-13 14:24:39.164 [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-11-13 14:24:39.187 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46273/api/school/respect/person?since=2025-11-13T13%3A24%3A39.039Z&includeRelated=false
2025-11-13 14:24:39.188 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46273/api/school/respect/person?since=2025-11-13T13%3A24%3A39.039Z&includeRelated=false
2025-11-13 14:24:39.190 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46273/api/school/respect/person?since=2025-11-13T13%3A24%3A39.039Z&includeRelated=false
2025-11-13 14:24:39.191 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:46273/api/school/respect/person?since=2025-11-13T13%3A24%3A39.039Z&includeRelated=false.
2025-11-13 14:24:41.321 [Test worker @coroutine#124] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 14:24:41.330 [Test worker @coroutine#124] INFO  io.ktor.server.Application - Application started in 0.07 seconds.
2025-11-13 14:24:41.338 [DefaultDispatcher-worker-6 @coroutine#130] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:39875
2025-11-13 14:24:41.386 [DefaultDispatcher-worker-6 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39875/api/school/respect/person
2025-11-13 14:24:41.387 [DefaultDispatcher-worker-6 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@4f0d6d21 for http://localhost:39875/api/school/respect/person
2025-11-13 14:24:41.387 [DefaultDispatcher-worker-6 @coroutine#128] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39875/api/school/respect/person
2025-11-13 14:24:41.387 [DefaultDispatcher-worker-6 @coroutine#128] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:39875/api/school/respect/person from class io.ktor.http.content.TextContent
2025-11-13 14:24:41.392 [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-11-13 14:24:41.401 [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<world.respect.datalayer.school.model.Person>) for call /api/school/respect/person
2025-11-13 14:24:41.428 [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-11-13 14:24:41.437 [DefaultDispatcher-worker-8 @coroutine#128] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39875/api/school/respect/person
2025-11-13 14:24:41.451 [DefaultDispatcher-worker-19 @coroutine#128] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39875/api/school/respect/person
2025-11-13 14:24:41.452 [DefaultDispatcher-worker-19 @coroutine#128] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39875/api/school/respect/person
2025-11-13 14:24:43.561 [Test worker @coroutine#143] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 14:24:43.562 [Test worker @coroutine#143] INFO  io.ktor.server.Application - Application started in 0.076 seconds.
2025-11-13 14:24:43.564 [DefaultDispatcher-worker-19 @coroutine#149] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:35187
2025-11-13 14:24:43.609 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35187/api/school/respect/person?includeRelated=false
2025-11-13 14:24:43.610 [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:35187/api/school/respect/person?includeRelated=false.
2025-11-13 14:24:43.610 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35187/api/school/respect/person?includeRelated=false
2025-11-13 14:24:43.613 [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-11-13 14:24:43.617 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35187/api/school/respect/person?includeRelated=false
2025-11-13 14:24:43.617 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35187/api/school/respect/person?includeRelated=false
2025-11-13 14:24:43.617 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35187/api/school/respect/person?includeRelated=false
2025-11-13 14:24:43.617 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:35187/api/school/respect/person?includeRelated=false.
2025-11-13 14:24:45.665 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35187/api/school/respect/person?includeRelated=false
2025-11-13 14:24:45.666 [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:35187/api/school/respect/person?includeRelated=false.
2025-11-13 14:24:45.666 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35187/api/school/respect/person?includeRelated=false
2025-11-13 14:24:45.677 [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-11-13 14:24:45.681 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35187/api/school/respect/person?includeRelated=false
2025-11-13 14:24:45.682 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35187/api/school/respect/person?includeRelated=false
2025-11-13 14:24:45.682 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35187/api/school/respect/person?includeRelated=false
2025-11-13 14:24:45.682 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:35187/api/school/respect/person?includeRelated=false.
2025-11-13 14:24:47.748 [Test worker @coroutine#167] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 14:24:47.749 [Test worker @coroutine#167] INFO  io.ktor.server.Application - Application started in 0.05 seconds.
2025-11-13 14:24:47.750 [DefaultDispatcher-worker-8 @coroutine#173] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:45951
2025-11-13 14:24:47.783 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45951/api/school/respect/person?includeRelated=false
2025-11-13 14:24:47.783 [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:45951/api/school/respect/person?includeRelated=false.
2025-11-13 14:24:47.783 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45951/api/school/respect/person?includeRelated=false
2025-11-13 14:24:47.786 [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-11-13 14:24:47.789 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45951/api/school/respect/person?includeRelated=false
2025-11-13 14:24:47.789 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45951/api/school/respect/person?includeRelated=false
2025-11-13 14:24:47.789 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45951/api/school/respect/person?includeRelated=false
2025-11-13 14:24:47.790 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:45951/api/school/respect/person?includeRelated=false.
2025-11-13 14:24:47.841 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45951/api/school/respect/person?since=2025-11-13T13%3A24%3A47.786Z&includeRelated=false
2025-11-13 14:24:47.842 [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:45951/api/school/respect/person?since=2025-11-13T13%3A24%3A47.786Z&includeRelated=false.
2025-11-13 14:24:47.842 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45951/api/school/respect/person?since=2025-11-13T13%3A24%3A47.786Z&includeRelated=false
2025-11-13 14:24:47.849 [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-11-13 14:24:47.855 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45951/api/school/respect/person?since=2025-11-13T13%3A24%3A47.786Z&includeRelated=false
2025-11-13 14:24:47.855 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45951/api/school/respect/person?since=2025-11-13T13%3A24%3A47.786Z&includeRelated=false
2025-11-13 14:24:47.855 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45951/api/school/respect/person?since=2025-11-13T13%3A24%3A47.786Z&includeRelated=false
2025-11-13 14:24:47.856 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:45951/api/school/respect/person?since=2025-11-13T13%3A24%3A47.786Z&includeRelated=false.
2025-11-13 21:09:40.604 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 21:09:40.696 [Test worker] INFO  io.ktor.server.Application - Application started in 0.231 seconds.
2025-11-13 21:09:40.788 [DefaultDispatcher-worker-2 @coroutine#2] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:42363
2025-11-13 21:09:41.074 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42363/resources/index.json
2025-11-13 21:09:41.075 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:42363/resources/index.json.
2025-11-13 21:09:41.075 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42363/resources/index.json
2025-11-13 21:09:41.231 [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-11-13 21:09:41.275 [eventLoopGroupProxy-4-1 @call-handler#12] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 48ms
2025-11-13 21:09:41.279 [DefaultDispatcher-worker-1 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42363/resources/index.json
2025-11-13 21:09:41.281 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42363/resources/index.json
2025-11-13 21:09:41.281 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42363/resources/index.json
2025-11-13 21:09:41.304 [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:42363/resources/index.json.
2025-11-13 21:09:41.339 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42363/resources/index.json
2025-11-13 21:09:41.339 [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:42363/resources/index.json.
2025-11-13 21:09:41.339 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42363/resources/index.json
2025-11-13 21:09:41.342 [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-11-13 21:09:41.344 [eventLoopGroupProxy-4-1 @call-handler#22] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 2ms
2025-11-13 21:09:41.344 [DefaultDispatcher-worker-2 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42363/resources/index.json
2025-11-13 21:09:41.344 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42363/resources/index.json
2025-11-13 21:09:41.345 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42363/resources/index.json
2025-11-13 21:09:43.360 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 21:09:43.360 [Test worker] INFO  io.ktor.server.Application - Application started in 0.0 seconds.
2025-11-13 21:09:43.362 [DefaultDispatcher-worker-1 @coroutine#26] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:40621
2025-11-13 21:09:43.404 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40621/resources/index.json
2025-11-13 21:09:43.404 [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:40621/resources/index.json.
2025-11-13 21:09:43.404 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40621/resources/index.json
2025-11-13 21:09:43.407 [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-11-13 21:09:43.408 [eventLoopGroupProxy-7-1 @call-handler#35] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 1ms
2025-11-13 21:09:43.409 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40621/resources/index.json
2025-11-13 21:09:43.409 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40621/resources/index.json
2025-11-13 21:09:43.409 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40621/resources/index.json
2025-11-13 21:09:43.409 [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:40621/resources/index.json.
2025-11-13 21:09:43.413 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40621/resources/index.json
2025-11-13 21:09:43.413 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:40621/resources/index.json.
2025-11-13 21:09:43.413 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40621/resources/index.json
2025-11-13 21:09:43.414 [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-11-13 21:09:43.415 [eventLoopGroupProxy-7-1 @call-handler#45] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms
2025-11-13 21:09:43.415 [DefaultDispatcher-worker-5 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40621/resources/index.json
2025-11-13 21:09:43.415 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40621/resources/index.json
2025-11-13 21:09:43.415 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40621/resources/index.json
2025-11-13 21:09:45.425 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 21:09:45.426 [Test worker] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2025-11-13 21:09:45.427 [DefaultDispatcher-worker-2 @coroutine#49] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:33791
2025-11-13 21:09:45.430 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33791/resources/lesson001.json
2025-11-13 21:09:45.430 [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:33791/resources/lesson001.json.
2025-11-13 21:09:45.430 [Test worker @coroutine#52] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33791/resources/lesson001.json
2025-11-13 21:09:45.433 [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-11-13 21:09:45.434 [DefaultDispatcher-worker-5 @call-handler#56] INFO  io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 1ms
2025-11-13 21:09:45.434 [DefaultDispatcher-worker-1 @coroutine#52] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33791/resources/lesson001.json
2025-11-13 21:09:45.435 [DefaultDispatcher-worker-1 @coroutine#52] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33791/resources/lesson001.json
2025-11-13 21:09:45.435 [DefaultDispatcher-worker-1 @coroutine#52] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33791/resources/lesson001.json
2025-11-13 21:09:45.451 [DefaultDispatcher-worker-1 @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsPublication for http://localhost:33791/resources/lesson001.json.
2025-11-13 21:09:47.950 [Test worker @coroutine#61] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 21:09:47.959 [Test worker @coroutine#61] INFO  io.ktor.server.Application - Application started in 0.484 seconds.
2025-11-13 21:09:47.962 [DefaultDispatcher-worker-1 @coroutine#67] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:34429
2025-11-13 21:09:48.043 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34429/api/school/respect/person?includeRelated=false
2025-11-13 21:09:48.043 [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:34429/api/school/respect/person?includeRelated=false.
2025-11-13 21:09:48.043 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34429/api/school/respect/person?includeRelated=false
2025-11-13 21:09:48.049 [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-11-13 21:09:48.077 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34429/api/school/respect/person?includeRelated=false
2025-11-13 21:09:48.077 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34429/api/school/respect/person?includeRelated=false
2025-11-13 21:09:48.077 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34429/api/school/respect/person?includeRelated=false
2025-11-13 21:09:48.078 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34429/api/school/respect/person?includeRelated=false.
2025-11-13 21:09:48.119 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34429/api/school/respect/person?includeRelated=false
2025-11-13 21:09:48.119 [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:34429/api/school/respect/person?includeRelated=false.
2025-11-13 21:09:48.119 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34429/api/school/respect/person?includeRelated=false
2025-11-13 21:09:48.121 [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-11-13 21:09:48.122 [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-11-13 21:09:48.123 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34429/api/school/respect/person?includeRelated=false
2025-11-13 21:09:48.124 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34429/api/school/respect/person?includeRelated=false
2025-11-13 21:09:48.124 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34429/api/school/respect/person?includeRelated=false
2025-11-13 21:09:50.177 [Test worker @coroutine#82] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 21:09:50.178 [Test worker @coroutine#82] INFO  io.ktor.server.Application - Application started in 0.046 seconds.
2025-11-13 21:09:50.180 [DefaultDispatcher-worker-3 @coroutine#88] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:32963
2025-11-13 21:09:50.252 [DefaultDispatcher-worker-3 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:32963/api/school/respect/person?includeRelated=false&offset=0&limit=100
2025-11-13 21:09:50.252 [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:32963/api/school/respect/person?includeRelated=false&offset=0&limit=100.
2025-11-13 21:09:50.252 [DefaultDispatcher-worker-3 @coroutine#91] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:32963/api/school/respect/person?includeRelated=false&offset=0&limit=100
2025-11-13 21:09:50.255 [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-11-13 21:09:50.258 [DefaultDispatcher-worker-1 @coroutine#91] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:32963/api/school/respect/person?includeRelated=false&offset=0&limit=100
2025-11-13 21:09:50.258 [DefaultDispatcher-worker-1 @coroutine#91] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:32963/api/school/respect/person?includeRelated=false&offset=0&limit=100
2025-11-13 21:09:50.258 [DefaultDispatcher-worker-1 @coroutine#91] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:32963/api/school/respect/person?includeRelated=false&offset=0&limit=100
2025-11-13 21:09:50.259 [DefaultDispatcher-worker-1 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:32963/api/school/respect/person?includeRelated=false&offset=0&limit=100.
2025-11-13 21:09:52.342 [Test worker @coroutine#102] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 21:09:52.343 [Test worker @coroutine#102] INFO  io.ktor.server.Application - Application started in 0.07 seconds.
2025-11-13 21:09:52.344 [DefaultDispatcher-worker-3 @coroutine#108] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:38763
2025-11-13 21:09:52.380 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38763/api/school/respect/person?includeRelated=false
2025-11-13 21:09:52.380 [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:38763/api/school/respect/person?includeRelated=false.
2025-11-13 21:09:52.380 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38763/api/school/respect/person?includeRelated=false
2025-11-13 21:09:52.383 [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-11-13 21:09:52.386 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38763/api/school/respect/person?includeRelated=false
2025-11-13 21:09:52.386 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38763/api/school/respect/person?includeRelated=false
2025-11-13 21:09:52.386 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38763/api/school/respect/person?includeRelated=false
2025-11-13 21:09:52.386 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:38763/api/school/respect/person?includeRelated=false.
2025-11-13 21:09:52.431 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38763/api/school/respect/person?since=2025-11-13T20%3A09%3A52.383Z&includeRelated=false
2025-11-13 21:09:52.432 [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:38763/api/school/respect/person?since=2025-11-13T20%3A09%3A52.383Z&includeRelated=false.
2025-11-13 21:09:52.432 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38763/api/school/respect/person?since=2025-11-13T20%3A09%3A52.383Z&includeRelated=false
2025-11-13 21:09:52.433 [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-11-13 21:09:52.436 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38763/api/school/respect/person?since=2025-11-13T20%3A09%3A52.383Z&includeRelated=false
2025-11-13 21:09:52.436 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38763/api/school/respect/person?since=2025-11-13T20%3A09%3A52.383Z&includeRelated=false
2025-11-13 21:09:52.436 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38763/api/school/respect/person?since=2025-11-13T20%3A09%3A52.383Z&includeRelated=false
2025-11-13 21:09:52.436 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:38763/api/school/respect/person?since=2025-11-13T20%3A09%3A52.383Z&includeRelated=false.
2025-11-13 21:09:54.496 [Test worker @coroutine#124] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 21:09:54.497 [Test worker @coroutine#124] INFO  io.ktor.server.Application - Application started in 0.051 seconds.
2025-11-13 21:09:54.498 [DefaultDispatcher-worker-4 @coroutine#130] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:36715
2025-11-13 21:09:54.532 [DefaultDispatcher-worker-1 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36715/api/school/respect/person
2025-11-13 21:09:54.532 [DefaultDispatcher-worker-1 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@70bcb6c for http://localhost:36715/api/school/respect/person
2025-11-13 21:09:54.532 [DefaultDispatcher-worker-1 @coroutine#128] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36715/api/school/respect/person
2025-11-13 21:09:54.532 [DefaultDispatcher-worker-1 @coroutine#128] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:36715/api/school/respect/person from class io.ktor.http.content.TextContent
2025-11-13 21:09:54.536 [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-11-13 21:09:54.541 [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<world.respect.datalayer.school.model.Person>) for call /api/school/respect/person
2025-11-13 21:09:54.565 [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-11-13 21:09:54.566 [DefaultDispatcher-worker-4 @coroutine#128] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36715/api/school/respect/person
2025-11-13 21:09:54.566 [DefaultDispatcher-worker-4 @coroutine#128] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36715/api/school/respect/person
2025-11-13 21:09:54.566 [DefaultDispatcher-worker-4 @coroutine#128] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36715/api/school/respect/person
2025-11-13 21:09:56.620 [Test worker @coroutine#143] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 21:09:56.621 [Test worker @coroutine#143] INFO  io.ktor.server.Application - Application started in 0.048 seconds.
2025-11-13 21:09:56.622 [DefaultDispatcher-worker-3 @coroutine#149] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:44899
2025-11-13 21:09:56.658 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44899/api/school/respect/person?includeRelated=false
2025-11-13 21:09:56.658 [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:44899/api/school/respect/person?includeRelated=false.
2025-11-13 21:09:56.658 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44899/api/school/respect/person?includeRelated=false
2025-11-13 21:09:56.660 [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-11-13 21:09:56.663 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44899/api/school/respect/person?includeRelated=false
2025-11-13 21:09:56.664 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44899/api/school/respect/person?includeRelated=false
2025-11-13 21:09:56.664 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44899/api/school/respect/person?includeRelated=false
2025-11-13 21:09:56.664 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44899/api/school/respect/person?includeRelated=false.
2025-11-13 21:09:58.701 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44899/api/school/respect/person?includeRelated=false
2025-11-13 21:09:58.701 [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:44899/api/school/respect/person?includeRelated=false.
2025-11-13 21:09:58.701 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44899/api/school/respect/person?includeRelated=false
2025-11-13 21:09:58.703 [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-11-13 21:09:58.705 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44899/api/school/respect/person?includeRelated=false
2025-11-13 21:09:58.705 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44899/api/school/respect/person?includeRelated=false
2025-11-13 21:09:58.705 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44899/api/school/respect/person?includeRelated=false
2025-11-13 21:09:58.706 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44899/api/school/respect/person?includeRelated=false.
2025-11-13 21:10:00.763 [Test worker @coroutine#167] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-11-13 21:10:00.764 [Test worker @coroutine#167] INFO  io.ktor.server.Application - Application started in 0.05 seconds.
2025-11-13 21:10:00.765 [DefaultDispatcher-worker-3 @coroutine#173] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:34359
2025-11-13 21:10:00.793 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34359/api/school/respect/person?includeRelated=false
2025-11-13 21:10:00.794 [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:34359/api/school/respect/person?includeRelated=false.
2025-11-13 21:10:00.794 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34359/api/school/respect/person?includeRelated=false
2025-11-13 21:10:00.796 [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-11-13 21:10:00.799 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34359/api/school/respect/person?includeRelated=false
2025-11-13 21:10:00.799 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34359/api/school/respect/person?includeRelated=false
2025-11-13 21:10:00.799 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34359/api/school/respect/person?includeRelated=false
2025-11-13 21:10:00.799 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34359/api/school/respect/person?includeRelated=false.
2025-11-13 21:10:00.830 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34359/api/school/respect/person?since=2025-11-13T20%3A10%3A00.796Z&includeRelated=false
2025-11-13 21:10:00.830 [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:34359/api/school/respect/person?since=2025-11-13T20%3A10%3A00.796Z&includeRelated=false.
2025-11-13 21:10:00.830 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34359/api/school/respect/person?since=2025-11-13T20%3A10%3A00.796Z&includeRelated=false
2025-11-13 21:10:00.831 [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-11-13 21:10:00.833 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34359/api/school/respect/person?since=2025-11-13T20%3A10%3A00.796Z&includeRelated=false
2025-11-13 21:10:00.833 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34359/api/school/respect/person?since=2025-11-13T20%3A10%3A00.796Z&includeRelated=false
2025-11-13 21:10:00.833 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34359/api/school/respect/person?since=2025-11-13T20%3A10%3A00.796Z&includeRelated=false
2025-11-13 21:10:00.833 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34359/api/school/respect/person?since=2025-11-13T20%3A10%3A00.796Z&includeRelated=false.