2025-12-17 03:56:18.863 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 03:56:18.945 [Test worker] INFO  io.ktor.server.Application - Application started in 0.191 seconds.
2025-12-17 03:56:19.031 [DefaultDispatcher-worker-1 @coroutine#2] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:35135
2025-12-17 03:56:19.296 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35135/resources/index.json
2025-12-17 03:56:19.296 [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:35135/resources/index.json.
2025-12-17 03:56:19.296 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35135/resources/index.json
2025-12-17 03:56:19.452 [eventLoopGroupProxy-4-1 @call-handler#12] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2025-12-17 03:56:19.487 [eventLoopGroupProxy-4-1 @call-handler#12] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 40ms
2025-12-17 03:56:19.491 [DefaultDispatcher-worker-2 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35135/resources/index.json
2025-12-17 03:56:19.493 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35135/resources/index.json
2025-12-17 03:56:19.493 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35135/resources/index.json
2025-12-17 03:56:19.514 [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:35135/resources/index.json.
2025-12-17 03:56:19.542 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35135/resources/index.json
2025-12-17 03:56:19.542 [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:35135/resources/index.json.
2025-12-17 03:56:19.542 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35135/resources/index.json
2025-12-17 03:56:19.544 [eventLoopGroupProxy-4-1 @call-handler#22] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2025-12-17 03:56:19.546 [eventLoopGroupProxy-4-1 @call-handler#22] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 2ms
2025-12-17 03:56:19.546 [DefaultDispatcher-worker-3 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35135/resources/index.json
2025-12-17 03:56:19.547 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35135/resources/index.json
2025-12-17 03:56:19.547 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35135/resources/index.json
2025-12-17 03:56:21.557 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 03:56:21.558 [Test worker] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2025-12-17 03:56:21.561 [DefaultDispatcher-worker-1 @coroutine#26] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:34501
2025-12-17 03:56:21.610 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34501/resources/index.json
2025-12-17 03:56:21.610 [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:34501/resources/index.json.
2025-12-17 03:56:21.610 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34501/resources/index.json
2025-12-17 03:56:21.612 [eventLoopGroupProxy-7-1 @call-handler#35] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2025-12-17 03:56:21.613 [DefaultDispatcher-worker-3 @call-handler#35] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 1ms
2025-12-17 03:56:21.614 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34501/resources/index.json
2025-12-17 03:56:21.614 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34501/resources/index.json
2025-12-17 03:56:21.614 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34501/resources/index.json
2025-12-17 03:56:21.614 [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:34501/resources/index.json.
2025-12-17 03:56:21.618 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34501/resources/index.json
2025-12-17 03:56:21.618 [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:34501/resources/index.json.
2025-12-17 03:56:21.618 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34501/resources/index.json
2025-12-17 03:56:21.619 [eventLoopGroupProxy-7-1 @call-handler#45] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2025-12-17 03:56:21.620 [eventLoopGroupProxy-7-1 @call-handler#45] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms
2025-12-17 03:56:21.620 [DefaultDispatcher-worker-2 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34501/resources/index.json
2025-12-17 03:56:21.620 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34501/resources/index.json
2025-12-17 03:56:21.620 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34501/resources/index.json
2025-12-17 03:56:23.626 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 03:56:23.627 [Test worker] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2025-12-17 03:56:23.628 [DefaultDispatcher-worker-2 @coroutine#49] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:46643
2025-12-17 03:56:23.631 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46643/resources/lesson001.json
2025-12-17 03:56:23.631 [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:46643/resources/lesson001.json.
2025-12-17 03:56:23.631 [Test worker @coroutine#52] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46643/resources/lesson001.json
2025-12-17 03:56:23.634 [eventLoopGroupProxy-10-1 @call-handler#56] TRACE io.ktor.server.routing.Routing - Trace for [resources, lesson001.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[lesson001.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[lesson001.json]] @ /(staticContent)/resources/{...}/(method:GET)
2025-12-17 03:56:23.635 [eventLoopGroupProxy-10-1 @call-handler#56] INFO  io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 1ms
2025-12-17 03:56:23.635 [DefaultDispatcher-worker-5 @coroutine#52] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46643/resources/lesson001.json
2025-12-17 03:56:23.636 [DefaultDispatcher-worker-5 @coroutine#52] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46643/resources/lesson001.json
2025-12-17 03:56:23.636 [DefaultDispatcher-worker-5 @coroutine#52] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46643/resources/lesson001.json
2025-12-17 03:56:23.656 [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:46643/resources/lesson001.json.
2025-12-17 03:56:26.121 [Test worker @coroutine#61] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 03:56:26.129 [Test worker @coroutine#61] INFO  io.ktor.server.Application - Application started in 0.448 seconds.
2025-12-17 03:56:26.132 [DefaultDispatcher-worker-5 @coroutine#67] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:39893
2025-12-17 03:56:26.215 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39893/api/school/respect/person?includeRelated=false
2025-12-17 03:56:26.215 [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:39893/api/school/respect/person?includeRelated=false.
2025-12-17 03:56:26.215 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39893/api/school/respect/person?includeRelated=false
2025-12-17 03:56:26.221 [eventLoopGroupProxy-13-1 @call-handler#72] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 03:56:26.252 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39893/api/school/respect/person?includeRelated=false
2025-12-17 03:56:26.253 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39893/api/school/respect/person?includeRelated=false
2025-12-17 03:56:26.253 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39893/api/school/respect/person?includeRelated=false
2025-12-17 03:56:26.255 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:39893/api/school/respect/person?includeRelated=false.
2025-12-17 03:56:26.290 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39893/api/school/respect/person?includeRelated=false
2025-12-17 03:56:26.290 [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:39893/api/school/respect/person?includeRelated=false.
2025-12-17 03:56:26.290 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39893/api/school/respect/person?includeRelated=false
2025-12-17 03:56:26.292 [eventLoopGroupProxy-13-1 @call-handler#78] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 03:56:26.294 [DefaultDispatcher-worker-2 @call-handler#78] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the GET /api/school/respect/person?includeRelated=false request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2025-12-17 03:56:26.295 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39893/api/school/respect/person?includeRelated=false
2025-12-17 03:56:26.295 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39893/api/school/respect/person?includeRelated=false
2025-12-17 03:56:26.295 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39893/api/school/respect/person?includeRelated=false
2025-12-17 03:56:28.358 [Test worker @coroutine#82] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 03:56:28.358 [Test worker @coroutine#82] INFO  io.ktor.server.Application - Application started in 0.054 seconds.
2025-12-17 03:56:28.360 [DefaultDispatcher-worker-2 @coroutine#88] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:42207
2025-12-17 03:56:28.427 [DefaultDispatcher-worker-3 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42207/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-17 03:56:28.428 [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:42207/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2025-12-17 03:56:28.428 [DefaultDispatcher-worker-3 @coroutine#91] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42207/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-17 03:56:28.431 [eventLoopGroupProxy-16-1 @call-handler#97] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 03:56:28.433 [DefaultDispatcher-worker-3 @coroutine#91] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42207/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-17 03:56:28.433 [DefaultDispatcher-worker-3 @coroutine#91] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42207/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-17 03:56:28.433 [DefaultDispatcher-worker-3 @coroutine#91] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42207/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-17 03:56:28.434 [DefaultDispatcher-worker-3 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:42207/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2025-12-17 03:56:30.496 [Test worker @coroutine#102] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 03:56:30.497 [Test worker @coroutine#102] INFO  io.ktor.server.Application - Application started in 0.049 seconds.
2025-12-17 03:56:30.498 [DefaultDispatcher-worker-1 @coroutine#108] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:45251
2025-12-17 03:56:30.528 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45251/api/school/respect/person?includeRelated=false
2025-12-17 03:56:30.528 [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:45251/api/school/respect/person?includeRelated=false.
2025-12-17 03:56:30.528 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45251/api/school/respect/person?includeRelated=false
2025-12-17 03:56:30.531 [eventLoopGroupProxy-19-1 @call-handler#113] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 03:56:30.533 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45251/api/school/respect/person?includeRelated=false
2025-12-17 03:56:30.533 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45251/api/school/respect/person?includeRelated=false
2025-12-17 03:56:30.534 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45251/api/school/respect/person?includeRelated=false
2025-12-17 03:56:30.534 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:45251/api/school/respect/person?includeRelated=false.
2025-12-17 03:56:30.572 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45251/api/school/respect/person?since=2025-12-17T02%3A56%3A30.531Z&includeRelated=false
2025-12-17 03:56:30.572 [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:45251/api/school/respect/person?since=2025-12-17T02%3A56%3A30.531Z&includeRelated=false.
2025-12-17 03:56:30.572 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45251/api/school/respect/person?since=2025-12-17T02%3A56%3A30.531Z&includeRelated=false
2025-12-17 03:56:30.574 [eventLoopGroupProxy-19-1 @call-handler#119] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 03:56:30.576 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45251/api/school/respect/person?since=2025-12-17T02%3A56%3A30.531Z&includeRelated=false
2025-12-17 03:56:30.577 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45251/api/school/respect/person?since=2025-12-17T02%3A56%3A30.531Z&includeRelated=false
2025-12-17 03:56:30.577 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45251/api/school/respect/person?since=2025-12-17T02%3A56%3A30.531Z&includeRelated=false
2025-12-17 03:56:30.577 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:45251/api/school/respect/person?since=2025-12-17T02%3A56%3A30.531Z&includeRelated=false.
2025-12-17 03:56:32.644 [Test worker @coroutine#124] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 03:56:32.645 [Test worker @coroutine#124] INFO  io.ktor.server.Application - Application started in 0.059 seconds.
2025-12-17 03:56:32.646 [DefaultDispatcher-worker-5 @coroutine#130] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:35415
2025-12-17 03:56:32.685 [DefaultDispatcher-worker-3 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35415/api/school/respect/person
2025-12-17 03:56:32.686 [DefaultDispatcher-worker-3 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@116b34a0 for http://localhost:35415/api/school/respect/person
2025-12-17 03:56:32.686 [DefaultDispatcher-worker-3 @coroutine#128] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35415/api/school/respect/person
2025-12-17 03:56:32.686 [DefaultDispatcher-worker-3 @coroutine#128] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:35415/api/school/respect/person from class io.ktor.http.content.TextContent
2025-12-17 03:56:32.690 [eventLoopGroupProxy-22-1 @call-handler#138] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> SUCCESS @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:POST)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:POST)
2025-12-17 03:56:32.696 [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-12-17 03:56:32.723 [DefaultDispatcher-worker-3 @call-handler#138] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the POST /api/school/respect/person request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2025-12-17 03:56:32.724 [DefaultDispatcher-worker-3 @coroutine#128] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35415/api/school/respect/person
2025-12-17 03:56:32.724 [DefaultDispatcher-worker-3 @coroutine#128] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35415/api/school/respect/person
2025-12-17 03:56:32.724 [DefaultDispatcher-worker-3 @coroutine#128] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35415/api/school/respect/person
2025-12-17 03:56:34.759 [Test worker @coroutine#143] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 03:56:34.760 [Test worker @coroutine#143] INFO  io.ktor.server.Application - Application started in 0.029 seconds.
2025-12-17 03:56:34.761 [DefaultDispatcher-worker-3 @coroutine#149] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:34579
2025-12-17 03:56:34.790 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34579/api/school/respect/person?includeRelated=false
2025-12-17 03:56:34.790 [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:34579/api/school/respect/person?includeRelated=false.
2025-12-17 03:56:34.790 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34579/api/school/respect/person?includeRelated=false
2025-12-17 03:56:34.793 [eventLoopGroupProxy-25-1 @call-handler#154] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 03:56:34.795 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34579/api/school/respect/person?includeRelated=false
2025-12-17 03:56:34.796 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34579/api/school/respect/person?includeRelated=false
2025-12-17 03:56:34.796 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34579/api/school/respect/person?includeRelated=false
2025-12-17 03:56:34.796 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34579/api/school/respect/person?includeRelated=false.
2025-12-17 03:56:36.828 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34579/api/school/respect/person?includeRelated=false
2025-12-17 03:56:36.828 [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:34579/api/school/respect/person?includeRelated=false.
2025-12-17 03:56:36.828 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34579/api/school/respect/person?includeRelated=false
2025-12-17 03:56:36.830 [eventLoopGroupProxy-25-1 @call-handler#161] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 03:56:36.832 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34579/api/school/respect/person?includeRelated=false
2025-12-17 03:56:36.832 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34579/api/school/respect/person?includeRelated=false
2025-12-17 03:56:36.832 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34579/api/school/respect/person?includeRelated=false
2025-12-17 03:56:36.833 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34579/api/school/respect/person?includeRelated=false.
2025-12-17 03:56:38.899 [Test worker @coroutine#167] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 03:56:38.899 [Test worker @coroutine#167] INFO  io.ktor.server.Application - Application started in 0.057 seconds.
2025-12-17 03:56:38.900 [DefaultDispatcher-worker-3 @coroutine#173] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:42795
2025-12-17 03:56:38.930 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42795/api/school/respect/person?includeRelated=false
2025-12-17 03:56:38.930 [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:42795/api/school/respect/person?includeRelated=false.
2025-12-17 03:56:38.930 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42795/api/school/respect/person?includeRelated=false
2025-12-17 03:56:38.932 [eventLoopGroupProxy-28-1 @call-handler#178] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 03:56:38.935 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42795/api/school/respect/person?includeRelated=false
2025-12-17 03:56:38.935 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42795/api/school/respect/person?includeRelated=false
2025-12-17 03:56:38.935 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42795/api/school/respect/person?includeRelated=false
2025-12-17 03:56:38.935 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:42795/api/school/respect/person?includeRelated=false.
2025-12-17 03:56:38.973 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42795/api/school/respect/person?since=2025-12-17T02%3A56%3A38.932Z&includeRelated=false
2025-12-17 03:56:38.973 [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:42795/api/school/respect/person?since=2025-12-17T02%3A56%3A38.932Z&includeRelated=false.
2025-12-17 03:56:38.973 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42795/api/school/respect/person?since=2025-12-17T02%3A56%3A38.932Z&includeRelated=false
2025-12-17 03:56:38.974 [eventLoopGroupProxy-28-1 @call-handler#185] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 03:56:38.976 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42795/api/school/respect/person?since=2025-12-17T02%3A56%3A38.932Z&includeRelated=false
2025-12-17 03:56:38.977 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42795/api/school/respect/person?since=2025-12-17T02%3A56%3A38.932Z&includeRelated=false
2025-12-17 03:56:38.977 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42795/api/school/respect/person?since=2025-12-17T02%3A56%3A38.932Z&includeRelated=false
2025-12-17 03:56:38.977 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:42795/api/school/respect/person?since=2025-12-17T02%3A56%3A38.932Z&includeRelated=false.
2025-12-17 08:52:30.255 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 08:52:30.416 [Test worker] INFO  io.ktor.server.Application - Application started in 0.381 seconds.
2025-12-17 08:52:30.562 [DefaultDispatcher-worker-1 @coroutine#2] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:42101
2025-12-17 08:52:30.871 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42101/resources/index.json
2025-12-17 08:52:30.872 [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:42101/resources/index.json.
2025-12-17 08:52:30.872 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42101/resources/index.json
2025-12-17 08:52:31.055 [eventLoopGroupProxy-4-1 @call-handler#12] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2025-12-17 08:52:31.108 [DefaultDispatcher-worker-1 @call-handler#12] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 59ms
2025-12-17 08:52:31.114 [DefaultDispatcher-worker-1 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42101/resources/index.json
2025-12-17 08:52:31.116 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42101/resources/index.json
2025-12-17 08:52:31.116 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42101/resources/index.json
2025-12-17 08:52:31.140 [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:42101/resources/index.json.
2025-12-17 08:52:31.215 [Test worker @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42101/resources/index.json
2025-12-17 08:52:31.215 [Test worker @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:42101/resources/index.json.
2025-12-17 08:52:31.215 [Test worker @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42101/resources/index.json
2025-12-17 08:52:31.220 [eventLoopGroupProxy-4-1 @call-handler#22] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2025-12-17 08:52:31.226 [eventLoopGroupProxy-4-1 @call-handler#22] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 6ms
2025-12-17 08:52:31.229 [DefaultDispatcher-worker-1 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42101/resources/index.json
2025-12-17 08:52:31.234 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42101/resources/index.json
2025-12-17 08:52:31.234 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42101/resources/index.json
2025-12-17 08:52:33.273 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 08:52:33.277 [Test worker] INFO  io.ktor.server.Application - Application started in 0.004 seconds.
2025-12-17 08:52:33.284 [DefaultDispatcher-worker-1 @coroutine#26] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:45089
2025-12-17 08:52:33.336 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45089/resources/index.json
2025-12-17 08:52:33.336 [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:45089/resources/index.json.
2025-12-17 08:52:33.336 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45089/resources/index.json
2025-12-17 08:52:33.340 [eventLoopGroupProxy-7-1 @call-handler#35] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2025-12-17 08:52:33.341 [DefaultDispatcher-worker-3 @call-handler#35] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 1ms
2025-12-17 08:52:33.343 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45089/resources/index.json
2025-12-17 08:52:33.343 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45089/resources/index.json
2025-12-17 08:52:33.343 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45089/resources/index.json
2025-12-17 08:52:33.344 [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:45089/resources/index.json.
2025-12-17 08:52:33.350 [DefaultDispatcher-worker-5 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45089/resources/index.json
2025-12-17 08:52:33.350 [DefaultDispatcher-worker-5 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45089/resources/index.json.
2025-12-17 08:52:33.351 [DefaultDispatcher-worker-5 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45089/resources/index.json
2025-12-17 08:52:33.353 [eventLoopGroupProxy-7-1 @call-handler#45] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2025-12-17 08:52:33.354 [eventLoopGroupProxy-7-1 @call-handler#45] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 2ms
2025-12-17 08:52:33.354 [DefaultDispatcher-worker-6 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45089/resources/index.json
2025-12-17 08:52:33.355 [DefaultDispatcher-worker-5 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45089/resources/index.json
2025-12-17 08:52:33.355 [DefaultDispatcher-worker-5 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45089/resources/index.json
2025-12-17 08:52:35.365 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 08:52:35.365 [Test worker] INFO  io.ktor.server.Application - Application started in 0.0 seconds.
2025-12-17 08:52:35.366 [DefaultDispatcher-worker-5 @coroutine#49] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:37387
2025-12-17 08:52:35.370 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37387/resources/lesson001.json
2025-12-17 08:52:35.370 [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:37387/resources/lesson001.json.
2025-12-17 08:52:35.370 [Test worker @coroutine#52] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37387/resources/lesson001.json
2025-12-17 08:52:35.372 [eventLoopGroupProxy-10-1 @call-handler#56] TRACE io.ktor.server.routing.Routing - Trace for [resources, lesson001.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[lesson001.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[lesson001.json]] @ /(staticContent)/resources/{...}/(method:GET)
2025-12-17 08:52:35.373 [DefaultDispatcher-worker-6 @call-handler#56] INFO  io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 1ms
2025-12-17 08:52:35.374 [DefaultDispatcher-worker-1 @coroutine#52] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37387/resources/lesson001.json
2025-12-17 08:52:35.374 [DefaultDispatcher-worker-1 @coroutine#52] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37387/resources/lesson001.json
2025-12-17 08:52:35.374 [DefaultDispatcher-worker-1 @coroutine#52] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37387/resources/lesson001.json
2025-12-17 08:52:35.393 [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:37387/resources/lesson001.json.
2025-12-17 08:52:38.336 [Test worker @coroutine#61] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 08:52:38.372 [Test worker @coroutine#61] INFO  io.ktor.server.Application - Application started in 0.909 seconds.
2025-12-17 08:52:38.381 [DefaultDispatcher-worker-6 @coroutine#67] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:43047
2025-12-17 08:52:38.525 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43047/api/school/respect/person?includeRelated=false
2025-12-17 08:52:38.525 [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:43047/api/school/respect/person?includeRelated=false.
2025-12-17 08:52:38.525 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43047/api/school/respect/person?includeRelated=false
2025-12-17 08:52:38.532 [eventLoopGroupProxy-13-1 @call-handler#72] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 08:52:38.576 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43047/api/school/respect/person?includeRelated=false
2025-12-17 08:52:38.576 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43047/api/school/respect/person?includeRelated=false
2025-12-17 08:52:38.576 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43047/api/school/respect/person?includeRelated=false
2025-12-17 08:52:38.585 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:43047/api/school/respect/person?includeRelated=false.
2025-12-17 08:52:38.651 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43047/api/school/respect/person?includeRelated=false
2025-12-17 08:52:38.651 [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:43047/api/school/respect/person?includeRelated=false.
2025-12-17 08:52:38.651 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43047/api/school/respect/person?includeRelated=false
2025-12-17 08:52:38.656 [eventLoopGroupProxy-13-1 @call-handler#78] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 08:52:38.659 [DefaultDispatcher-worker-1 @call-handler#78] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the GET /api/school/respect/person?includeRelated=false request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2025-12-17 08:52:38.661 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43047/api/school/respect/person?includeRelated=false
2025-12-17 08:52:38.661 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43047/api/school/respect/person?includeRelated=false
2025-12-17 08:52:38.661 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43047/api/school/respect/person?includeRelated=false
2025-12-17 08:52:40.747 [Test worker @coroutine#82] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 08:52:40.748 [Test worker @coroutine#82] INFO  io.ktor.server.Application - Application started in 0.058 seconds.
2025-12-17 08:52:40.751 [DefaultDispatcher-worker-6 @coroutine#88] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:40199
2025-12-17 08:52:40.820 [DefaultDispatcher-worker-4 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40199/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-17 08:52:40.821 [DefaultDispatcher-worker-4 @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:40199/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2025-12-17 08:52:40.821 [DefaultDispatcher-worker-4 @coroutine#91] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40199/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-17 08:52:40.823 [eventLoopGroupProxy-16-1 @call-handler#97] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 08:52:40.826 [DefaultDispatcher-worker-6 @coroutine#91] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40199/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-17 08:52:40.827 [DefaultDispatcher-worker-6 @coroutine#91] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40199/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-17 08:52:40.827 [DefaultDispatcher-worker-6 @coroutine#91] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40199/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-17 08:52:40.827 [DefaultDispatcher-worker-6 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:40199/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2025-12-17 08:52:42.920 [Test worker @coroutine#102] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 08:52:42.921 [Test worker @coroutine#102] INFO  io.ktor.server.Application - Application started in 0.059 seconds.
2025-12-17 08:52:42.926 [DefaultDispatcher-worker-1 @coroutine#108] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:40193
2025-12-17 08:52:42.978 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40193/api/school/respect/person?includeRelated=false
2025-12-17 08:52:42.978 [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:40193/api/school/respect/person?includeRelated=false.
2025-12-17 08:52:42.979 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40193/api/school/respect/person?includeRelated=false
2025-12-17 08:52:42.996 [eventLoopGroupProxy-19-1 @call-handler#113] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 08:52:43.006 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40193/api/school/respect/person?includeRelated=false
2025-12-17 08:52:43.007 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40193/api/school/respect/person?includeRelated=false
2025-12-17 08:52:43.007 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40193/api/school/respect/person?includeRelated=false
2025-12-17 08:52:43.007 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:40193/api/school/respect/person?includeRelated=false.
2025-12-17 08:52:43.098 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40193/api/school/respect/person?since=2025-12-17T07%3A52%3A42.997Z&includeRelated=false
2025-12-17 08:52:43.098 [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:40193/api/school/respect/person?since=2025-12-17T07%3A52%3A42.997Z&includeRelated=false.
2025-12-17 08:52:43.098 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40193/api/school/respect/person?since=2025-12-17T07%3A52%3A42.997Z&includeRelated=false
2025-12-17 08:52:43.108 [eventLoopGroupProxy-19-1 @call-handler#119] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 08:52:43.117 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40193/api/school/respect/person?since=2025-12-17T07%3A52%3A42.997Z&includeRelated=false
2025-12-17 08:52:43.117 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40193/api/school/respect/person?since=2025-12-17T07%3A52%3A42.997Z&includeRelated=false
2025-12-17 08:52:43.117 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40193/api/school/respect/person?since=2025-12-17T07%3A52%3A42.997Z&includeRelated=false
2025-12-17 08:52:43.118 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:40193/api/school/respect/person?since=2025-12-17T07%3A52%3A42.997Z&includeRelated=false.
2025-12-17 08:52:45.239 [Test worker @coroutine#124] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 08:52:45.243 [Test worker @coroutine#124] INFO  io.ktor.server.Application - Application started in 0.075 seconds.
2025-12-17 08:52:45.247 [DefaultDispatcher-worker-4 @coroutine#130] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:33891
2025-12-17 08:52:45.310 [DefaultDispatcher-worker-1 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33891/api/school/respect/person
2025-12-17 08:52:45.310 [DefaultDispatcher-worker-1 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@2eeffe66 for http://localhost:33891/api/school/respect/person
2025-12-17 08:52:45.311 [DefaultDispatcher-worker-1 @coroutine#128] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33891/api/school/respect/person
2025-12-17 08:52:45.311 [DefaultDispatcher-worker-1 @coroutine#128] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:33891/api/school/respect/person from class io.ktor.http.content.TextContent
2025-12-17 08:52:45.331 [eventLoopGroupProxy-22-1 @call-handler#138] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> SUCCESS @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:POST)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:POST)
2025-12-17 08:52:45.341 [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-12-17 08:52:45.354 [DefaultDispatcher-worker-3 @call-handler#138] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the POST /api/school/respect/person request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2025-12-17 08:52:45.356 [DefaultDispatcher-worker-1 @coroutine#128] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33891/api/school/respect/person
2025-12-17 08:52:45.357 [DefaultDispatcher-worker-1 @coroutine#128] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33891/api/school/respect/person
2025-12-17 08:52:45.357 [DefaultDispatcher-worker-1 @coroutine#128] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33891/api/school/respect/person
2025-12-17 08:52:47.468 [Test worker @coroutine#143] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 08:52:47.469 [Test worker @coroutine#143] INFO  io.ktor.server.Application - Application started in 0.058 seconds.
2025-12-17 08:52:47.471 [DefaultDispatcher-worker-3 @coroutine#149] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:33119
2025-12-17 08:52:47.517 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33119/api/school/respect/person?includeRelated=false
2025-12-17 08:52:47.517 [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:33119/api/school/respect/person?includeRelated=false.
2025-12-17 08:52:47.517 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33119/api/school/respect/person?includeRelated=false
2025-12-17 08:52:47.521 [eventLoopGroupProxy-25-1 @call-handler#154] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 08:52:47.526 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33119/api/school/respect/person?includeRelated=false
2025-12-17 08:52:47.527 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33119/api/school/respect/person?includeRelated=false
2025-12-17 08:52:47.527 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33119/api/school/respect/person?includeRelated=false
2025-12-17 08:52:47.527 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:33119/api/school/respect/person?includeRelated=false.
2025-12-17 08:52:49.585 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33119/api/school/respect/person?includeRelated=false
2025-12-17 08:52:49.585 [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:33119/api/school/respect/person?includeRelated=false.
2025-12-17 08:52:49.585 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33119/api/school/respect/person?includeRelated=false
2025-12-17 08:52:49.592 [eventLoopGroupProxy-25-1 @call-handler#161] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 08:52:49.597 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33119/api/school/respect/person?includeRelated=false
2025-12-17 08:52:49.597 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33119/api/school/respect/person?includeRelated=false
2025-12-17 08:52:49.597 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33119/api/school/respect/person?includeRelated=false
2025-12-17 08:52:49.598 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:33119/api/school/respect/person?includeRelated=false.
2025-12-17 08:52:51.695 [Test worker @coroutine#167] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 08:52:51.699 [Test worker @coroutine#167] INFO  io.ktor.server.Application - Application started in 0.084 seconds.
2025-12-17 08:52:51.706 [DefaultDispatcher-worker-2 @coroutine#173] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:34353
2025-12-17 08:52:51.763 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34353/api/school/respect/person?includeRelated=false
2025-12-17 08:52:51.763 [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:34353/api/school/respect/person?includeRelated=false.
2025-12-17 08:52:51.763 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34353/api/school/respect/person?includeRelated=false
2025-12-17 08:52:51.766 [eventLoopGroupProxy-28-1 @call-handler#178] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 08:52:51.769 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34353/api/school/respect/person?includeRelated=false
2025-12-17 08:52:51.769 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34353/api/school/respect/person?includeRelated=false
2025-12-17 08:52:51.769 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34353/api/school/respect/person?includeRelated=false
2025-12-17 08:52:51.770 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34353/api/school/respect/person?includeRelated=false.
2025-12-17 08:52:51.812 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34353/api/school/respect/person?since=2025-12-17T07%3A52%3A51.766Z&includeRelated=false
2025-12-17 08:52:51.812 [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:34353/api/school/respect/person?since=2025-12-17T07%3A52%3A51.766Z&includeRelated=false.
2025-12-17 08:52:51.812 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34353/api/school/respect/person?since=2025-12-17T07%3A52%3A51.766Z&includeRelated=false
2025-12-17 08:52:51.813 [eventLoopGroupProxy-28-1 @call-handler#185] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 08:52:51.816 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34353/api/school/respect/person?since=2025-12-17T07%3A52%3A51.766Z&includeRelated=false
2025-12-17 08:52:51.816 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34353/api/school/respect/person?since=2025-12-17T07%3A52%3A51.766Z&includeRelated=false
2025-12-17 08:52:51.816 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34353/api/school/respect/person?since=2025-12-17T07%3A52%3A51.766Z&includeRelated=false
2025-12-17 08:52:51.817 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34353/api/school/respect/person?since=2025-12-17T07%3A52%3A51.766Z&includeRelated=false.
2025-12-17 11:21:04.757 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 11:21:04.872 [Test worker] INFO  io.ktor.server.Application - Application started in 0.29 seconds.
2025-12-17 11:21:04.973 [DefaultDispatcher-worker-1 @coroutine#2] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:43205
2025-12-17 11:21:05.305 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43205/resources/index.json
2025-12-17 11:21:05.306 [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:43205/resources/index.json.
2025-12-17 11:21:05.306 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43205/resources/index.json
2025-12-17 11:21:05.506 [eventLoopGroupProxy-4-1 @call-handler#12] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2025-12-17 11:21:05.559 [DefaultDispatcher-worker-1 @call-handler#12] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 59ms
2025-12-17 11:21:05.566 [DefaultDispatcher-worker-2 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43205/resources/index.json
2025-12-17 11:21:05.568 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43205/resources/index.json
2025-12-17 11:21:05.568 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43205/resources/index.json
2025-12-17 11:21:05.589 [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:43205/resources/index.json.
2025-12-17 11:21:05.629 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43205/resources/index.json
2025-12-17 11:21:05.630 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:43205/resources/index.json.
2025-12-17 11:21:05.630 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43205/resources/index.json
2025-12-17 11:21:05.633 [eventLoopGroupProxy-4-1 @call-handler#22] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2025-12-17 11:21:05.635 [eventLoopGroupProxy-4-1 @call-handler#22] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 2ms
2025-12-17 11:21:05.638 [DefaultDispatcher-worker-5 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43205/resources/index.json
2025-12-17 11:21:05.639 [DefaultDispatcher-worker-5 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43205/resources/index.json
2025-12-17 11:21:05.639 [DefaultDispatcher-worker-5 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43205/resources/index.json
2025-12-17 11:21:07.667 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 11:21:07.668 [Test worker] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2025-12-17 11:21:07.674 [DefaultDispatcher-worker-4 @coroutine#26] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:43529
2025-12-17 11:21:07.726 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43529/resources/index.json
2025-12-17 11:21:07.726 [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:43529/resources/index.json.
2025-12-17 11:21:07.726 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43529/resources/index.json
2025-12-17 11:21:07.732 [eventLoopGroupProxy-7-1 @call-handler#35] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2025-12-17 11:21:07.734 [eventLoopGroupProxy-7-1 @call-handler#35] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 2ms
2025-12-17 11:21:07.737 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43529/resources/index.json
2025-12-17 11:21:07.737 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43529/resources/index.json
2025-12-17 11:21:07.737 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43529/resources/index.json
2025-12-17 11:21:07.738 [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:43529/resources/index.json.
2025-12-17 11:21:07.744 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43529/resources/index.json
2025-12-17 11:21:07.744 [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:43529/resources/index.json.
2025-12-17 11:21:07.744 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43529/resources/index.json
2025-12-17 11:21:07.746 [eventLoopGroupProxy-7-1 @call-handler#45] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2025-12-17 11:21:07.747 [eventLoopGroupProxy-7-1 @call-handler#45] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms
2025-12-17 11:21:07.748 [DefaultDispatcher-worker-1 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43529/resources/index.json
2025-12-17 11:21:07.748 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43529/resources/index.json
2025-12-17 11:21:07.748 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43529/resources/index.json
2025-12-17 11:21:09.754 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 11:21:09.755 [Test worker] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2025-12-17 11:21:09.756 [DefaultDispatcher-worker-1 @coroutine#49] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:35621
2025-12-17 11:21:09.759 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35621/resources/lesson001.json
2025-12-17 11:21:09.760 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:35621/resources/lesson001.json.
2025-12-17 11:21:09.760 [Test worker @coroutine#52] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35621/resources/lesson001.json
2025-12-17 11:21:09.762 [eventLoopGroupProxy-10-1 @call-handler#56] TRACE io.ktor.server.routing.Routing - Trace for [resources, lesson001.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[lesson001.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[lesson001.json]] @ /(staticContent)/resources/{...}/(method:GET)
2025-12-17 11:21:09.763 [eventLoopGroupProxy-10-1 @call-handler#56] INFO  io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 1ms
2025-12-17 11:21:09.764 [DefaultDispatcher-worker-1 @coroutine#52] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35621/resources/lesson001.json
2025-12-17 11:21:09.764 [DefaultDispatcher-worker-1 @coroutine#52] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35621/resources/lesson001.json
2025-12-17 11:21:09.764 [DefaultDispatcher-worker-1 @coroutine#52] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35621/resources/lesson001.json
2025-12-17 11:21:09.790 [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:35621/resources/lesson001.json.
2025-12-17 11:21:12.611 [Test worker @coroutine#61] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 11:21:12.623 [Test worker @coroutine#61] INFO  io.ktor.server.Application - Application started in 0.743 seconds.
2025-12-17 11:21:12.626 [DefaultDispatcher-worker-1 @coroutine#67] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:35609
2025-12-17 11:21:12.732 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35609/api/school/respect/person?includeRelated=false
2025-12-17 11:21:12.733 [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:35609/api/school/respect/person?includeRelated=false.
2025-12-17 11:21:12.733 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35609/api/school/respect/person?includeRelated=false
2025-12-17 11:21:12.741 [eventLoopGroupProxy-13-1 @call-handler#72] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 11:21:12.783 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35609/api/school/respect/person?includeRelated=false
2025-12-17 11:21:12.783 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35609/api/school/respect/person?includeRelated=false
2025-12-17 11:21:12.783 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35609/api/school/respect/person?includeRelated=false
2025-12-17 11:21:12.786 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:35609/api/school/respect/person?includeRelated=false.
2025-12-17 11:21:12.853 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35609/api/school/respect/person?includeRelated=false
2025-12-17 11:21:12.854 [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:35609/api/school/respect/person?includeRelated=false.
2025-12-17 11:21:12.854 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35609/api/school/respect/person?includeRelated=false
2025-12-17 11:21:12.856 [eventLoopGroupProxy-13-1 @call-handler#78] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 11:21:12.858 [DefaultDispatcher-worker-1 @call-handler#78] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the GET /api/school/respect/person?includeRelated=false request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2025-12-17 11:21:12.864 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35609/api/school/respect/person?includeRelated=false
2025-12-17 11:21:12.864 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35609/api/school/respect/person?includeRelated=false
2025-12-17 11:21:12.864 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35609/api/school/respect/person?includeRelated=false
2025-12-17 11:21:14.942 [Test worker @coroutine#82] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 11:21:14.942 [Test worker @coroutine#82] INFO  io.ktor.server.Application - Application started in 0.05 seconds.
2025-12-17 11:21:14.944 [DefaultDispatcher-worker-5 @coroutine#88] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:33485
2025-12-17 11:21:15.004 [DefaultDispatcher-worker-5 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33485/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-17 11:21:15.004 [DefaultDispatcher-worker-5 @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:33485/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2025-12-17 11:21:15.004 [DefaultDispatcher-worker-5 @coroutine#91] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33485/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-17 11:21:15.007 [eventLoopGroupProxy-16-1 @call-handler#97] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 11:21:15.009 [DefaultDispatcher-worker-3 @coroutine#91] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33485/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-17 11:21:15.010 [DefaultDispatcher-worker-3 @coroutine#91] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33485/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-17 11:21:15.010 [DefaultDispatcher-worker-3 @coroutine#91] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33485/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-17 11:21:15.010 [DefaultDispatcher-worker-3 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:33485/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2025-12-17 11:21:17.112 [Test worker @coroutine#102] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 11:21:17.115 [Test worker @coroutine#102] INFO  io.ktor.server.Application - Application started in 0.065 seconds.
2025-12-17 11:21:17.119 [DefaultDispatcher-worker-5 @coroutine#108] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:39373
2025-12-17 11:21:17.186 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39373/api/school/respect/person?includeRelated=false
2025-12-17 11:21:17.188 [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:39373/api/school/respect/person?includeRelated=false.
2025-12-17 11:21:17.188 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39373/api/school/respect/person?includeRelated=false
2025-12-17 11:21:17.204 [eventLoopGroupProxy-19-1 @call-handler#113] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 11:21:17.222 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39373/api/school/respect/person?includeRelated=false
2025-12-17 11:21:17.222 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39373/api/school/respect/person?includeRelated=false
2025-12-17 11:21:17.223 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39373/api/school/respect/person?includeRelated=false
2025-12-17 11:21:17.224 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:39373/api/school/respect/person?includeRelated=false.
2025-12-17 11:21:17.275 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39373/api/school/respect/person?since=2025-12-17T10%3A21%3A17.204Z&includeRelated=false
2025-12-17 11:21:17.275 [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:39373/api/school/respect/person?since=2025-12-17T10%3A21%3A17.204Z&includeRelated=false.
2025-12-17 11:21:17.275 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39373/api/school/respect/person?since=2025-12-17T10%3A21%3A17.204Z&includeRelated=false
2025-12-17 11:21:17.278 [eventLoopGroupProxy-19-1 @call-handler#119] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 11:21:17.282 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39373/api/school/respect/person?since=2025-12-17T10%3A21%3A17.204Z&includeRelated=false
2025-12-17 11:21:17.282 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39373/api/school/respect/person?since=2025-12-17T10%3A21%3A17.204Z&includeRelated=false
2025-12-17 11:21:17.282 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39373/api/school/respect/person?since=2025-12-17T10%3A21%3A17.204Z&includeRelated=false
2025-12-17 11:21:17.283 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:39373/api/school/respect/person?since=2025-12-17T10%3A21%3A17.204Z&includeRelated=false.
2025-12-17 11:21:19.422 [Test worker @coroutine#124] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 11:21:19.423 [Test worker @coroutine#124] INFO  io.ktor.server.Application - Application started in 0.063 seconds.
2025-12-17 11:21:19.424 [DefaultDispatcher-worker-3 @coroutine#130] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:38865
2025-12-17 11:21:19.491 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38865/api/school/respect/person
2025-12-17 11:21:19.494 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@50cde3a5 for http://localhost:38865/api/school/respect/person
2025-12-17 11:21:19.494 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38865/api/school/respect/person
2025-12-17 11:21:19.494 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:38865/api/school/respect/person from class io.ktor.http.content.TextContent
2025-12-17 11:21:19.511 [eventLoopGroupProxy-22-1 @call-handler#138] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> SUCCESS @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:POST)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:POST)
2025-12-17 11:21:19.521 [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-12-17 11:21:19.535 [DefaultDispatcher-worker-5 @call-handler#138] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the POST /api/school/respect/person request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2025-12-17 11:21:19.537 [DefaultDispatcher-worker-3 @coroutine#128] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38865/api/school/respect/person
2025-12-17 11:21:19.538 [DefaultDispatcher-worker-3 @coroutine#128] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38865/api/school/respect/person
2025-12-17 11:21:19.538 [DefaultDispatcher-worker-3 @coroutine#128] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38865/api/school/respect/person
2025-12-17 11:21:21.644 [Test worker @coroutine#143] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 11:21:21.645 [Test worker @coroutine#143] INFO  io.ktor.server.Application - Application started in 0.066 seconds.
2025-12-17 11:21:21.647 [DefaultDispatcher-worker-6 @coroutine#149] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:33919
2025-12-17 11:21:21.688 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33919/api/school/respect/person?includeRelated=false
2025-12-17 11:21:21.689 [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:33919/api/school/respect/person?includeRelated=false.
2025-12-17 11:21:21.689 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33919/api/school/respect/person?includeRelated=false
2025-12-17 11:21:21.692 [eventLoopGroupProxy-25-1 @call-handler#154] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 11:21:21.700 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33919/api/school/respect/person?includeRelated=false
2025-12-17 11:21:21.700 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33919/api/school/respect/person?includeRelated=false
2025-12-17 11:21:21.701 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33919/api/school/respect/person?includeRelated=false
2025-12-17 11:21:21.705 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:33919/api/school/respect/person?includeRelated=false.
2025-12-17 11:21:23.750 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33919/api/school/respect/person?includeRelated=false
2025-12-17 11:21:23.750 [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:33919/api/school/respect/person?includeRelated=false.
2025-12-17 11:21:23.750 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33919/api/school/respect/person?includeRelated=false
2025-12-17 11:21:23.752 [eventLoopGroupProxy-25-1 @call-handler#161] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 11:21:23.758 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33919/api/school/respect/person?includeRelated=false
2025-12-17 11:21:23.758 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33919/api/school/respect/person?includeRelated=false
2025-12-17 11:21:23.758 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33919/api/school/respect/person?includeRelated=false
2025-12-17 11:21:23.760 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:33919/api/school/respect/person?includeRelated=false.
2025-12-17 11:21:25.838 [Test worker @coroutine#167] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 11:21:25.839 [Test worker @coroutine#167] INFO  io.ktor.server.Application - Application started in 0.033 seconds.
2025-12-17 11:21:25.840 [DefaultDispatcher-worker-6 @coroutine#173] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:34745
2025-12-17 11:21:25.869 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34745/api/school/respect/person?includeRelated=false
2025-12-17 11:21:25.870 [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:34745/api/school/respect/person?includeRelated=false.
2025-12-17 11:21:25.870 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34745/api/school/respect/person?includeRelated=false
2025-12-17 11:21:25.872 [eventLoopGroupProxy-28-1 @call-handler#178] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 11:21:25.875 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34745/api/school/respect/person?includeRelated=false
2025-12-17 11:21:25.875 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34745/api/school/respect/person?includeRelated=false
2025-12-17 11:21:25.875 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34745/api/school/respect/person?includeRelated=false
2025-12-17 11:21:25.875 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34745/api/school/respect/person?includeRelated=false.
2025-12-17 11:21:25.907 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34745/api/school/respect/person?since=2025-12-17T10%3A21%3A25.872Z&includeRelated=false
2025-12-17 11:21:25.907 [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:34745/api/school/respect/person?since=2025-12-17T10%3A21%3A25.872Z&includeRelated=false.
2025-12-17 11:21:25.907 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34745/api/school/respect/person?since=2025-12-17T10%3A21%3A25.872Z&includeRelated=false
2025-12-17 11:21:25.908 [eventLoopGroupProxy-28-1 @call-handler#185] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 11:21:25.911 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34745/api/school/respect/person?since=2025-12-17T10%3A21%3A25.872Z&includeRelated=false
2025-12-17 11:21:25.911 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34745/api/school/respect/person?since=2025-12-17T10%3A21%3A25.872Z&includeRelated=false
2025-12-17 11:21:25.911 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34745/api/school/respect/person?since=2025-12-17T10%3A21%3A25.872Z&includeRelated=false
2025-12-17 11:21:25.911 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34745/api/school/respect/person?since=2025-12-17T10%3A21%3A25.872Z&includeRelated=false.
2025-12-17 12:49:25.969 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 12:49:26.053 [Test worker] INFO  io.ktor.server.Application - Application started in 0.221 seconds.
2025-12-17 12:49:26.152 [DefaultDispatcher-worker-1 @coroutine#2] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:38815
2025-12-17 12:49:26.434 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38815/resources/index.json
2025-12-17 12:49:26.435 [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:38815/resources/index.json.
2025-12-17 12:49:26.436 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38815/resources/index.json
2025-12-17 12:49:26.590 [eventLoopGroupProxy-4-1 @call-handler#12] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2025-12-17 12:49:26.635 [DefaultDispatcher-worker-1 @call-handler#12] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 53ms
2025-12-17 12:49:26.641 [DefaultDispatcher-worker-1 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38815/resources/index.json
2025-12-17 12:49:26.643 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38815/resources/index.json
2025-12-17 12:49:26.643 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38815/resources/index.json
2025-12-17 12:49:26.660 [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:38815/resources/index.json.
2025-12-17 12:49:26.692 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38815/resources/index.json
2025-12-17 12:49:26.692 [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:38815/resources/index.json.
2025-12-17 12:49:26.692 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38815/resources/index.json
2025-12-17 12:49:26.695 [eventLoopGroupProxy-4-1 @call-handler#22] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2025-12-17 12:49:26.697 [eventLoopGroupProxy-4-1 @call-handler#22] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 2ms
2025-12-17 12:49:26.698 [DefaultDispatcher-worker-3 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38815/resources/index.json
2025-12-17 12:49:26.698 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38815/resources/index.json
2025-12-17 12:49:26.698 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38815/resources/index.json
2025-12-17 12:49:28.710 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 12:49:28.711 [Test worker] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2025-12-17 12:49:28.714 [DefaultDispatcher-worker-3 @coroutine#26] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:38635
2025-12-17 12:49:28.751 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38635/resources/index.json
2025-12-17 12:49:28.751 [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:38635/resources/index.json.
2025-12-17 12:49:28.751 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38635/resources/index.json
2025-12-17 12:49:28.754 [eventLoopGroupProxy-7-1 @call-handler#35] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2025-12-17 12:49:28.755 [DefaultDispatcher-worker-3 @call-handler#35] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 1ms
2025-12-17 12:49:28.756 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38635/resources/index.json
2025-12-17 12:49:28.756 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38635/resources/index.json
2025-12-17 12:49:28.756 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38635/resources/index.json
2025-12-17 12:49:28.757 [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:38635/resources/index.json.
2025-12-17 12:49:28.761 [DefaultDispatcher-worker-4 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38635/resources/index.json
2025-12-17 12:49:28.761 [DefaultDispatcher-worker-4 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:38635/resources/index.json.
2025-12-17 12:49:28.761 [DefaultDispatcher-worker-4 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38635/resources/index.json
2025-12-17 12:49:28.762 [eventLoopGroupProxy-7-1 @call-handler#45] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2025-12-17 12:49:28.763 [eventLoopGroupProxy-7-1 @call-handler#45] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms
2025-12-17 12:49:28.763 [DefaultDispatcher-worker-4 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38635/resources/index.json
2025-12-17 12:49:28.763 [DefaultDispatcher-worker-4 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38635/resources/index.json
2025-12-17 12:49:28.763 [DefaultDispatcher-worker-4 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38635/resources/index.json
2025-12-17 12:49:30.771 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 12:49:30.772 [Test worker] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2025-12-17 12:49:30.773 [DefaultDispatcher-worker-4 @coroutine#49] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:37129
2025-12-17 12:49:30.776 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37129/resources/lesson001.json
2025-12-17 12:49:30.776 [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:37129/resources/lesson001.json.
2025-12-17 12:49:30.776 [Test worker @coroutine#52] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37129/resources/lesson001.json
2025-12-17 12:49:30.779 [eventLoopGroupProxy-10-1 @call-handler#56] TRACE io.ktor.server.routing.Routing - Trace for [resources, lesson001.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[lesson001.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[lesson001.json]] @ /(staticContent)/resources/{...}/(method:GET)
2025-12-17 12:49:30.780 [DefaultDispatcher-worker-3 @call-handler#56] INFO  io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 1ms
2025-12-17 12:49:30.780 [DefaultDispatcher-worker-3 @coroutine#52] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37129/resources/lesson001.json
2025-12-17 12:49:30.780 [DefaultDispatcher-worker-3 @coroutine#52] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37129/resources/lesson001.json
2025-12-17 12:49:30.780 [DefaultDispatcher-worker-3 @coroutine#52] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37129/resources/lesson001.json
2025-12-17 12:49:30.798 [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:37129/resources/lesson001.json.
2025-12-17 12:49:33.307 [Test worker @coroutine#61] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 12:49:33.315 [Test worker @coroutine#61] INFO  io.ktor.server.Application - Application started in 0.493 seconds.
2025-12-17 12:49:33.318 [DefaultDispatcher-worker-3 @coroutine#67] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:44517
2025-12-17 12:49:33.384 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44517/api/school/respect/person?includeRelated=false
2025-12-17 12:49:33.385 [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:44517/api/school/respect/person?includeRelated=false.
2025-12-17 12:49:33.385 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44517/api/school/respect/person?includeRelated=false
2025-12-17 12:49:33.391 [eventLoopGroupProxy-13-1 @call-handler#72] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 12:49:33.422 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44517/api/school/respect/person?includeRelated=false
2025-12-17 12:49:33.422 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44517/api/school/respect/person?includeRelated=false
2025-12-17 12:49:33.422 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44517/api/school/respect/person?includeRelated=false
2025-12-17 12:49:33.424 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44517/api/school/respect/person?includeRelated=false.
2025-12-17 12:49:33.464 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44517/api/school/respect/person?includeRelated=false
2025-12-17 12:49:33.464 [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:44517/api/school/respect/person?includeRelated=false.
2025-12-17 12:49:33.464 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44517/api/school/respect/person?includeRelated=false
2025-12-17 12:49:33.466 [eventLoopGroupProxy-13-1 @call-handler#78] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 12:49:33.467 [DefaultDispatcher-worker-2 @call-handler#78] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the GET /api/school/respect/person?includeRelated=false request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2025-12-17 12:49:33.468 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44517/api/school/respect/person?includeRelated=false
2025-12-17 12:49:33.468 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44517/api/school/respect/person?includeRelated=false
2025-12-17 12:49:33.468 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44517/api/school/respect/person?includeRelated=false
2025-12-17 12:49:35.531 [Test worker @coroutine#82] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 12:49:35.532 [Test worker @coroutine#82] INFO  io.ktor.server.Application - Application started in 0.054 seconds.
2025-12-17 12:49:35.533 [DefaultDispatcher-worker-2 @coroutine#88] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:45651
2025-12-17 12:49:35.606 [DefaultDispatcher-worker-2 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45651/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-17 12:49:35.607 [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:45651/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2025-12-17 12:49:35.607 [DefaultDispatcher-worker-2 @coroutine#91] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45651/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-17 12:49:35.610 [eventLoopGroupProxy-16-1 @call-handler#97] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 12:49:35.613 [DefaultDispatcher-worker-3 @coroutine#91] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45651/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-17 12:49:35.613 [DefaultDispatcher-worker-3 @coroutine#91] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45651/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-17 12:49:35.613 [DefaultDispatcher-worker-3 @coroutine#91] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45651/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-17 12:49:35.614 [DefaultDispatcher-worker-3 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:45651/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2025-12-17 12:49:37.667 [Test worker @coroutine#102] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 12:49:37.668 [Test worker @coroutine#102] INFO  io.ktor.server.Application - Application started in 0.039 seconds.
2025-12-17 12:49:37.669 [DefaultDispatcher-worker-2 @coroutine#108] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:45299
2025-12-17 12:49:37.698 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45299/api/school/respect/person?includeRelated=false
2025-12-17 12:49:37.699 [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:45299/api/school/respect/person?includeRelated=false.
2025-12-17 12:49:37.699 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45299/api/school/respect/person?includeRelated=false
2025-12-17 12:49:37.701 [eventLoopGroupProxy-19-1 @call-handler#113] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 12:49:37.704 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45299/api/school/respect/person?includeRelated=false
2025-12-17 12:49:37.704 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45299/api/school/respect/person?includeRelated=false
2025-12-17 12:49:37.704 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45299/api/school/respect/person?includeRelated=false
2025-12-17 12:49:37.705 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:45299/api/school/respect/person?includeRelated=false.
2025-12-17 12:49:37.757 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45299/api/school/respect/person?since=2025-12-17T11%3A49%3A37.702Z&includeRelated=false
2025-12-17 12:49:37.757 [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:45299/api/school/respect/person?since=2025-12-17T11%3A49%3A37.702Z&includeRelated=false.
2025-12-17 12:49:37.757 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45299/api/school/respect/person?since=2025-12-17T11%3A49%3A37.702Z&includeRelated=false
2025-12-17 12:49:37.759 [eventLoopGroupProxy-19-1 @call-handler#119] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 12:49:37.762 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45299/api/school/respect/person?since=2025-12-17T11%3A49%3A37.702Z&includeRelated=false
2025-12-17 12:49:37.762 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45299/api/school/respect/person?since=2025-12-17T11%3A49%3A37.702Z&includeRelated=false
2025-12-17 12:49:37.762 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45299/api/school/respect/person?since=2025-12-17T11%3A49%3A37.702Z&includeRelated=false
2025-12-17 12:49:37.762 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:45299/api/school/respect/person?since=2025-12-17T11%3A49%3A37.702Z&includeRelated=false.
2025-12-17 12:49:39.829 [Test worker @coroutine#124] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 12:49:39.830 [Test worker @coroutine#124] INFO  io.ktor.server.Application - Application started in 0.057 seconds.
2025-12-17 12:49:39.831 [DefaultDispatcher-worker-2 @coroutine#130] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:41601
2025-12-17 12:49:39.865 [DefaultDispatcher-worker-1 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41601/api/school/respect/person
2025-12-17 12:49:39.865 [DefaultDispatcher-worker-1 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@2ef228d0 for http://localhost:41601/api/school/respect/person
2025-12-17 12:49:39.865 [DefaultDispatcher-worker-1 @coroutine#128] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41601/api/school/respect/person
2025-12-17 12:49:39.865 [DefaultDispatcher-worker-1 @coroutine#128] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:41601/api/school/respect/person from class io.ktor.http.content.TextContent
2025-12-17 12:49:39.869 [eventLoopGroupProxy-22-1 @call-handler#138] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> SUCCESS @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:POST)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:POST)
2025-12-17 12:49:39.875 [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-12-17 12:49:39.897 [DefaultDispatcher-worker-2 @call-handler#138] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the POST /api/school/respect/person request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2025-12-17 12:49:39.898 [DefaultDispatcher-worker-9 @coroutine#128] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41601/api/school/respect/person
2025-12-17 12:49:39.899 [DefaultDispatcher-worker-9 @coroutine#128] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41601/api/school/respect/person
2025-12-17 12:49:39.899 [DefaultDispatcher-worker-9 @coroutine#128] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41601/api/school/respect/person
2025-12-17 12:49:41.960 [Test worker @coroutine#143] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 12:49:41.961 [Test worker @coroutine#143] INFO  io.ktor.server.Application - Application started in 0.054 seconds.
2025-12-17 12:49:41.962 [DefaultDispatcher-worker-12 @coroutine#149] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:40587
2025-12-17 12:49:41.991 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40587/api/school/respect/person?includeRelated=false
2025-12-17 12:49:41.992 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:40587/api/school/respect/person?includeRelated=false.
2025-12-17 12:49:41.992 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40587/api/school/respect/person?includeRelated=false
2025-12-17 12:49:41.994 [eventLoopGroupProxy-25-1 @call-handler#154] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 12:49:41.997 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40587/api/school/respect/person?includeRelated=false
2025-12-17 12:49:41.997 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40587/api/school/respect/person?includeRelated=false
2025-12-17 12:49:41.997 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40587/api/school/respect/person?includeRelated=false
2025-12-17 12:49:41.997 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:40587/api/school/respect/person?includeRelated=false.
2025-12-17 12:49:44.035 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40587/api/school/respect/person?includeRelated=false
2025-12-17 12:49:44.035 [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:40587/api/school/respect/person?includeRelated=false.
2025-12-17 12:49:44.035 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40587/api/school/respect/person?includeRelated=false
2025-12-17 12:49:44.037 [eventLoopGroupProxy-25-1 @call-handler#161] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 12:49:44.039 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40587/api/school/respect/person?includeRelated=false
2025-12-17 12:49:44.039 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40587/api/school/respect/person?includeRelated=false
2025-12-17 12:49:44.039 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40587/api/school/respect/person?includeRelated=false
2025-12-17 12:49:44.040 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:40587/api/school/respect/person?includeRelated=false.
2025-12-17 12:49:46.097 [Test worker @coroutine#167] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 12:49:46.097 [Test worker @coroutine#167] INFO  io.ktor.server.Application - Application started in 0.049 seconds.
2025-12-17 12:49:46.098 [DefaultDispatcher-worker-6 @coroutine#173] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:44379
2025-12-17 12:49:46.127 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44379/api/school/respect/person?includeRelated=false
2025-12-17 12:49:46.127 [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:44379/api/school/respect/person?includeRelated=false.
2025-12-17 12:49:46.127 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44379/api/school/respect/person?includeRelated=false
2025-12-17 12:49:46.129 [eventLoopGroupProxy-28-1 @call-handler#178] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 12:49:46.132 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44379/api/school/respect/person?includeRelated=false
2025-12-17 12:49:46.132 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44379/api/school/respect/person?includeRelated=false
2025-12-17 12:49:46.132 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44379/api/school/respect/person?includeRelated=false
2025-12-17 12:49:46.132 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44379/api/school/respect/person?includeRelated=false.
2025-12-17 12:49:46.162 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44379/api/school/respect/person?since=2025-12-17T11%3A49%3A46.129Z&includeRelated=false
2025-12-17 12:49:46.163 [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:44379/api/school/respect/person?since=2025-12-17T11%3A49%3A46.129Z&includeRelated=false.
2025-12-17 12:49:46.163 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44379/api/school/respect/person?since=2025-12-17T11%3A49%3A46.129Z&includeRelated=false
2025-12-17 12:49:46.164 [eventLoopGroupProxy-28-1 @call-handler#185] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 12:49:46.166 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44379/api/school/respect/person?since=2025-12-17T11%3A49%3A46.129Z&includeRelated=false
2025-12-17 12:49:46.166 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44379/api/school/respect/person?since=2025-12-17T11%3A49%3A46.129Z&includeRelated=false
2025-12-17 12:49:46.166 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44379/api/school/respect/person?since=2025-12-17T11%3A49%3A46.129Z&includeRelated=false
2025-12-17 12:49:46.166 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44379/api/school/respect/person?since=2025-12-17T11%3A49%3A46.129Z&includeRelated=false.
2025-12-17 13:24:55.303 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 13:24:55.452 [Test worker] INFO  io.ktor.server.Application - Application started in 0.364 seconds.
2025-12-17 13:24:55.607 [DefaultDispatcher-worker-2 @coroutine#2] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:40713
2025-12-17 13:24:55.941 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40713/resources/index.json
2025-12-17 13:24:55.942 [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:40713/resources/index.json.
2025-12-17 13:24:55.942 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40713/resources/index.json
2025-12-17 13:24:56.135 [eventLoopGroupProxy-4-1 @call-handler#12] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2025-12-17 13:24:56.190 [DefaultDispatcher-worker-2 @call-handler#12] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 63ms
2025-12-17 13:24:56.196 [DefaultDispatcher-worker-5 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40713/resources/index.json
2025-12-17 13:24:56.197 [DefaultDispatcher-worker-5 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40713/resources/index.json
2025-12-17 13:24:56.198 [DefaultDispatcher-worker-5 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40713/resources/index.json
2025-12-17 13:24:56.218 [DefaultDispatcher-worker-5 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsFeed for http://localhost:40713/resources/index.json.
2025-12-17 13:24:56.249 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40713/resources/index.json
2025-12-17 13:24:56.249 [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:40713/resources/index.json.
2025-12-17 13:24:56.249 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40713/resources/index.json
2025-12-17 13:24:56.251 [eventLoopGroupProxy-4-1 @call-handler#22] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2025-12-17 13:24:56.253 [eventLoopGroupProxy-4-1 @call-handler#22] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 2ms
2025-12-17 13:24:56.254 [DefaultDispatcher-worker-1 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40713/resources/index.json
2025-12-17 13:24:56.254 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40713/resources/index.json
2025-12-17 13:24:56.254 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40713/resources/index.json
2025-12-17 13:24:58.301 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 13:24:58.302 [Test worker] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2025-12-17 13:24:58.310 [DefaultDispatcher-worker-1 @coroutine#26] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:36163
2025-12-17 13:24:58.382 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36163/resources/index.json
2025-12-17 13:24:58.382 [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:36163/resources/index.json.
2025-12-17 13:24:58.382 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36163/resources/index.json
2025-12-17 13:24:58.386 [eventLoopGroupProxy-7-1 @call-handler#35] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2025-12-17 13:24:58.387 [eventLoopGroupProxy-7-1 @call-handler#35] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 1ms
2025-12-17 13:24:58.389 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36163/resources/index.json
2025-12-17 13:24:58.389 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36163/resources/index.json
2025-12-17 13:24:58.389 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36163/resources/index.json
2025-12-17 13:24:58.389 [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:36163/resources/index.json.
2025-12-17 13:24:58.395 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36163/resources/index.json
2025-12-17 13:24:58.395 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:36163/resources/index.json.
2025-12-17 13:24:58.395 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36163/resources/index.json
2025-12-17 13:24:58.398 [eventLoopGroupProxy-7-1 @call-handler#45] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2025-12-17 13:24:58.398 [eventLoopGroupProxy-7-1 @call-handler#45] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms
2025-12-17 13:24:58.399 [DefaultDispatcher-worker-2 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36163/resources/index.json
2025-12-17 13:24:58.400 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36163/resources/index.json
2025-12-17 13:24:58.400 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36163/resources/index.json
2025-12-17 13:25:00.411 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 13:25:00.412 [Test worker] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2025-12-17 13:25:00.413 [DefaultDispatcher-worker-2 @coroutine#49] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:41519
2025-12-17 13:25:00.418 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41519/resources/lesson001.json
2025-12-17 13:25:00.418 [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:41519/resources/lesson001.json.
2025-12-17 13:25:00.418 [Test worker @coroutine#52] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41519/resources/lesson001.json
2025-12-17 13:25:00.421 [eventLoopGroupProxy-10-1 @call-handler#56] TRACE io.ktor.server.routing.Routing - Trace for [resources, lesson001.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[lesson001.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[lesson001.json]] @ /(staticContent)/resources/{...}/(method:GET)
2025-12-17 13:25:00.422 [DefaultDispatcher-worker-3 @call-handler#56] INFO  io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 1ms
2025-12-17 13:25:00.423 [DefaultDispatcher-worker-2 @coroutine#52] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41519/resources/lesson001.json
2025-12-17 13:25:00.423 [DefaultDispatcher-worker-3 @coroutine#52] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41519/resources/lesson001.json
2025-12-17 13:25:00.423 [DefaultDispatcher-worker-3 @coroutine#52] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41519/resources/lesson001.json
2025-12-17 13:25:00.445 [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:41519/resources/lesson001.json.
2025-12-17 13:25:03.415 [Test worker @coroutine#61] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 13:25:03.446 [Test worker @coroutine#61] INFO  io.ktor.server.Application - Application started in 0.931 seconds.
2025-12-17 13:25:03.488 [DefaultDispatcher-worker-2 @coroutine#67] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:34523
2025-12-17 13:25:03.757 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34523/api/school/respect/person?includeRelated=false
2025-12-17 13:25:03.758 [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:34523/api/school/respect/person?includeRelated=false.
2025-12-17 13:25:03.759 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34523/api/school/respect/person?includeRelated=false
2025-12-17 13:25:03.774 [eventLoopGroupProxy-13-1 @call-handler#72] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 13:25:03.830 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34523/api/school/respect/person?includeRelated=false
2025-12-17 13:25:03.830 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34523/api/school/respect/person?includeRelated=false
2025-12-17 13:25:03.830 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34523/api/school/respect/person?includeRelated=false
2025-12-17 13:25:03.833 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34523/api/school/respect/person?includeRelated=false.
2025-12-17 13:25:03.894 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34523/api/school/respect/person?includeRelated=false
2025-12-17 13:25:03.895 [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:34523/api/school/respect/person?includeRelated=false.
2025-12-17 13:25:03.896 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34523/api/school/respect/person?includeRelated=false
2025-12-17 13:25:03.902 [eventLoopGroupProxy-13-1 @call-handler#78] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 13:25:03.905 [DefaultDispatcher-worker-2 @call-handler#78] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the GET /api/school/respect/person?includeRelated=false request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2025-12-17 13:25:03.907 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34523/api/school/respect/person?includeRelated=false
2025-12-17 13:25:03.908 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34523/api/school/respect/person?includeRelated=false
2025-12-17 13:25:03.908 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34523/api/school/respect/person?includeRelated=false
2025-12-17 13:25:05.960 [Test worker @coroutine#82] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 13:25:05.961 [Test worker @coroutine#82] INFO  io.ktor.server.Application - Application started in 0.03 seconds.
2025-12-17 13:25:05.962 [DefaultDispatcher-worker-2 @coroutine#88] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:33327
2025-12-17 13:25:06.030 [DefaultDispatcher-worker-5 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33327/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-17 13:25:06.030 [DefaultDispatcher-worker-5 @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:33327/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2025-12-17 13:25:06.030 [DefaultDispatcher-worker-5 @coroutine#91] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33327/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-17 13:25:06.033 [eventLoopGroupProxy-16-1 @call-handler#97] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 13:25:06.036 [DefaultDispatcher-worker-3 @coroutine#91] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33327/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-17 13:25:06.036 [DefaultDispatcher-worker-3 @coroutine#91] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33327/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-17 13:25:06.036 [DefaultDispatcher-worker-3 @coroutine#91] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33327/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-17 13:25:06.036 [DefaultDispatcher-worker-3 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:33327/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2025-12-17 13:25:08.178 [Test worker @coroutine#102] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 13:25:08.180 [Test worker @coroutine#102] INFO  io.ktor.server.Application - Application started in 0.08 seconds.
2025-12-17 13:25:08.191 [DefaultDispatcher-worker-2 @coroutine#108] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:36813
2025-12-17 13:25:08.243 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36813/api/school/respect/person?includeRelated=false
2025-12-17 13:25:08.244 [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:36813/api/school/respect/person?includeRelated=false.
2025-12-17 13:25:08.244 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36813/api/school/respect/person?includeRelated=false
2025-12-17 13:25:08.260 [eventLoopGroupProxy-19-1 @call-handler#113] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 13:25:08.277 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36813/api/school/respect/person?includeRelated=false
2025-12-17 13:25:08.277 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36813/api/school/respect/person?includeRelated=false
2025-12-17 13:25:08.277 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36813/api/school/respect/person?includeRelated=false
2025-12-17 13:25:08.278 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:36813/api/school/respect/person?includeRelated=false.
2025-12-17 13:25:08.337 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36813/api/school/respect/person?since=2025-12-17T12%3A25%3A08.261Z&includeRelated=false
2025-12-17 13:25:08.338 [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:36813/api/school/respect/person?since=2025-12-17T12%3A25%3A08.261Z&includeRelated=false.
2025-12-17 13:25:08.338 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36813/api/school/respect/person?since=2025-12-17T12%3A25%3A08.261Z&includeRelated=false
2025-12-17 13:25:08.346 [eventLoopGroupProxy-19-1 @call-handler#119] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 13:25:08.350 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36813/api/school/respect/person?since=2025-12-17T12%3A25%3A08.261Z&includeRelated=false
2025-12-17 13:25:08.350 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36813/api/school/respect/person?since=2025-12-17T12%3A25%3A08.261Z&includeRelated=false
2025-12-17 13:25:08.350 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36813/api/school/respect/person?since=2025-12-17T12%3A25%3A08.261Z&includeRelated=false
2025-12-17 13:25:08.350 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:36813/api/school/respect/person?since=2025-12-17T12%3A25%3A08.261Z&includeRelated=false.
2025-12-17 13:25:10.477 [Test worker @coroutine#124] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 13:25:10.485 [Test worker @coroutine#124] INFO  io.ktor.server.Application - Application started in 0.076 seconds.
2025-12-17 13:25:10.491 [DefaultDispatcher-worker-1 @coroutine#130] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:35171
2025-12-17 13:25:10.533 [DefaultDispatcher-worker-4 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35171/api/school/respect/person
2025-12-17 13:25:10.533 [DefaultDispatcher-worker-4 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@3fdcd98f for http://localhost:35171/api/school/respect/person
2025-12-17 13:25:10.534 [DefaultDispatcher-worker-4 @coroutine#128] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35171/api/school/respect/person
2025-12-17 13:25:10.535 [DefaultDispatcher-worker-4 @coroutine#128] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:35171/api/school/respect/person from class io.ktor.http.content.TextContent
2025-12-17 13:25:10.541 [eventLoopGroupProxy-22-1 @call-handler#138] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> SUCCESS @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:POST)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:POST)
2025-12-17 13:25:10.549 [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-12-17 13:25:10.567 [DefaultDispatcher-worker-5 @call-handler#138] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the POST /api/school/respect/person request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2025-12-17 13:25:10.568 [DefaultDispatcher-worker-5 @coroutine#128] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35171/api/school/respect/person
2025-12-17 13:25:10.569 [DefaultDispatcher-worker-8 @coroutine#128] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35171/api/school/respect/person
2025-12-17 13:25:10.570 [DefaultDispatcher-worker-8 @coroutine#128] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35171/api/school/respect/person
2025-12-17 13:25:12.674 [Test worker @coroutine#143] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 13:25:12.675 [Test worker @coroutine#143] INFO  io.ktor.server.Application - Application started in 0.066 seconds.
2025-12-17 13:25:12.677 [DefaultDispatcher-worker-2 @coroutine#149] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:32877
2025-12-17 13:25:12.730 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:32877/api/school/respect/person?includeRelated=false
2025-12-17 13:25:12.730 [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:32877/api/school/respect/person?includeRelated=false.
2025-12-17 13:25:12.730 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:32877/api/school/respect/person?includeRelated=false
2025-12-17 13:25:12.733 [eventLoopGroupProxy-25-1 @call-handler#154] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 13:25:12.738 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:32877/api/school/respect/person?includeRelated=false
2025-12-17 13:25:12.739 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:32877/api/school/respect/person?includeRelated=false
2025-12-17 13:25:12.739 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:32877/api/school/respect/person?includeRelated=false
2025-12-17 13:25:12.739 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:32877/api/school/respect/person?includeRelated=false.
2025-12-17 13:25:14.790 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:32877/api/school/respect/person?includeRelated=false
2025-12-17 13:25:14.790 [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:32877/api/school/respect/person?includeRelated=false.
2025-12-17 13:25:14.790 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:32877/api/school/respect/person?includeRelated=false
2025-12-17 13:25:14.792 [eventLoopGroupProxy-25-1 @call-handler#161] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 13:25:14.794 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:32877/api/school/respect/person?includeRelated=false
2025-12-17 13:25:14.794 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:32877/api/school/respect/person?includeRelated=false
2025-12-17 13:25:14.794 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:32877/api/school/respect/person?includeRelated=false
2025-12-17 13:25:14.795 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:32877/api/school/respect/person?includeRelated=false.
2025-12-17 13:25:16.863 [Test worker @coroutine#167] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-17 13:25:16.864 [Test worker @coroutine#167] INFO  io.ktor.server.Application - Application started in 0.049 seconds.
2025-12-17 13:25:16.865 [DefaultDispatcher-worker-5 @coroutine#173] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:39909
2025-12-17 13:25:16.894 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39909/api/school/respect/person?includeRelated=false
2025-12-17 13:25:16.894 [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:39909/api/school/respect/person?includeRelated=false.
2025-12-17 13:25:16.895 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39909/api/school/respect/person?includeRelated=false
2025-12-17 13:25:16.897 [eventLoopGroupProxy-28-1 @call-handler#178] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 13:25:16.900 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39909/api/school/respect/person?includeRelated=false
2025-12-17 13:25:16.900 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39909/api/school/respect/person?includeRelated=false
2025-12-17 13:25:16.900 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39909/api/school/respect/person?includeRelated=false
2025-12-17 13:25:16.900 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:39909/api/school/respect/person?includeRelated=false.
2025-12-17 13:25:16.932 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39909/api/school/respect/person?since=2025-12-17T12%3A25%3A16.897Z&includeRelated=false
2025-12-17 13:25:16.932 [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:39909/api/school/respect/person?since=2025-12-17T12%3A25%3A16.897Z&includeRelated=false.
2025-12-17 13:25:16.932 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39909/api/school/respect/person?since=2025-12-17T12%3A25%3A16.897Z&includeRelated=false
2025-12-17 13:25:16.934 [eventLoopGroupProxy-28-1 @call-handler#185] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2025-12-17 13:25:16.936 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39909/api/school/respect/person?since=2025-12-17T12%3A25%3A16.897Z&includeRelated=false
2025-12-17 13:25:16.936 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39909/api/school/respect/person?since=2025-12-17T12%3A25%3A16.897Z&includeRelated=false
2025-12-17 13:25:16.936 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39909/api/school/respect/person?since=2025-12-17T12%3A25%3A16.897Z&includeRelated=false
2025-12-17 13:25:16.937 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:39909/api/school/respect/person?since=2025-12-17T12%3A25%3A16.897Z&includeRelated=false.