2025-12-22 07:25:27.861 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 07:25:28.001 [Test worker] INFO  io.ktor.server.Application - Application started in 0.332 seconds.
2025-12-22 07:25:28.129 [DefaultDispatcher-worker-1 @coroutine#2] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:44405
2025-12-22 07:25:28.502 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44405/resources/index.json
2025-12-22 07:25:28.504 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:44405/resources/index.json.
2025-12-22 07:25:28.505 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44405/resources/index.json
2025-12-22 07:25:28.677 [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-22 07:25:28.725 [eventLoopGroupProxy-4-1 @call-handler#12] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 55ms
2025-12-22 07:25:28.729 [DefaultDispatcher-worker-2 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44405/resources/index.json
2025-12-22 07:25:28.732 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44405/resources/index.json
2025-12-22 07:25:28.732 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44405/resources/index.json
2025-12-22 07:25:28.757 [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:44405/resources/index.json.
2025-12-22 07:25:28.794 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44405/resources/index.json
2025-12-22 07:25:28.795 [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:44405/resources/index.json.
2025-12-22 07:25:28.796 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44405/resources/index.json
2025-12-22 07:25:28.798 [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-22 07:25:28.800 [eventLoopGroupProxy-4-1 @call-handler#22] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 2ms
2025-12-22 07:25:28.801 [DefaultDispatcher-worker-3 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44405/resources/index.json
2025-12-22 07:25:28.801 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44405/resources/index.json
2025-12-22 07:25:28.801 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44405/resources/index.json
2025-12-22 07:25:30.830 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 07:25:30.830 [Test worker] INFO  io.ktor.server.Application - Application started in 0.0 seconds.
2025-12-22 07:25:30.832 [DefaultDispatcher-worker-3 @coroutine#26] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:45429
2025-12-22 07:25:30.897 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45429/resources/index.json
2025-12-22 07:25:30.898 [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:45429/resources/index.json.
2025-12-22 07:25:30.898 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45429/resources/index.json
2025-12-22 07:25:30.912 [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-22 07:25:30.915 [DefaultDispatcher-worker-2 @call-handler#35] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 3ms
2025-12-22 07:25:30.921 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45429/resources/index.json
2025-12-22 07:25:30.921 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45429/resources/index.json
2025-12-22 07:25:30.921 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45429/resources/index.json
2025-12-22 07:25:30.922 [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:45429/resources/index.json.
2025-12-22 07:25:30.930 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45429/resources/index.json
2025-12-22 07:25:30.930 [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:45429/resources/index.json.
2025-12-22 07:25:30.930 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45429/resources/index.json
2025-12-22 07:25:30.932 [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-22 07:25:30.933 [eventLoopGroupProxy-7-1 @call-handler#45] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms
2025-12-22 07:25:30.934 [DefaultDispatcher-worker-6 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45429/resources/index.json
2025-12-22 07:25:30.934 [DefaultDispatcher-worker-6 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45429/resources/index.json
2025-12-22 07:25:30.934 [DefaultDispatcher-worker-6 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45429/resources/index.json
2025-12-22 07:25:32.942 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 07:25:32.942 [Test worker] INFO  io.ktor.server.Application - Application started in 0.0 seconds.
2025-12-22 07:25:32.944 [DefaultDispatcher-worker-6 @coroutine#49] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:44951
2025-12-22 07:25:32.948 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44951/resources/lesson001.json
2025-12-22 07:25:32.948 [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:44951/resources/lesson001.json.
2025-12-22 07:25:32.948 [Test worker @coroutine#52] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44951/resources/lesson001.json
2025-12-22 07:25:32.951 [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-22 07:25:32.952 [DefaultDispatcher-worker-5 @call-handler#56] INFO  io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 1ms
2025-12-22 07:25:32.953 [DefaultDispatcher-worker-6 @coroutine#52] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44951/resources/lesson001.json
2025-12-22 07:25:32.953 [DefaultDispatcher-worker-5 @coroutine#52] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44951/resources/lesson001.json
2025-12-22 07:25:32.953 [DefaultDispatcher-worker-5 @coroutine#52] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44951/resources/lesson001.json
2025-12-22 07:25:32.978 [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:44951/resources/lesson001.json.
2025-12-22 07:25:35.925 [Test worker @coroutine#61] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 07:25:35.943 [Test worker @coroutine#61] INFO  io.ktor.server.Application - Application started in 0.86 seconds.
2025-12-22 07:25:35.950 [DefaultDispatcher-worker-6 @coroutine#67] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:41759
2025-12-22 07:25:36.075 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41759/api/school/respect/person?includeRelated=false
2025-12-22 07:25:36.076 [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:41759/api/school/respect/person?includeRelated=false.
2025-12-22 07:25:36.076 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41759/api/school/respect/person?includeRelated=false
2025-12-22 07:25:36.086 [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-22 07:25:36.128 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41759/api/school/respect/person?includeRelated=false
2025-12-22 07:25:36.128 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41759/api/school/respect/person?includeRelated=false
2025-12-22 07:25:36.128 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41759/api/school/respect/person?includeRelated=false
2025-12-22 07:25:36.131 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41759/api/school/respect/person?includeRelated=false.
2025-12-22 07:25:36.167 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41759/api/school/respect/person?includeRelated=false
2025-12-22 07:25:36.167 [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:41759/api/school/respect/person?includeRelated=false.
2025-12-22 07:25:36.167 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41759/api/school/respect/person?includeRelated=false
2025-12-22 07:25:36.169 [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-22 07:25:36.171 [DefaultDispatcher-worker-5 @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-22 07:25:36.172 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41759/api/school/respect/person?includeRelated=false
2025-12-22 07:25:36.172 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41759/api/school/respect/person?includeRelated=false
2025-12-22 07:25:36.172 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41759/api/school/respect/person?includeRelated=false
2025-12-22 07:25:38.252 [Test worker @coroutine#82] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 07:25:38.253 [Test worker @coroutine#82] INFO  io.ktor.server.Application - Application started in 0.056 seconds.
2025-12-22 07:25:38.254 [DefaultDispatcher-worker-5 @coroutine#88] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:44375
2025-12-22 07:25:38.325 [DefaultDispatcher-worker-6 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44375/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-22 07:25:38.325 [DefaultDispatcher-worker-6 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:44375/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2025-12-22 07:25:38.325 [DefaultDispatcher-worker-6 @coroutine#91] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44375/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-22 07:25:38.328 [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-22 07:25:38.331 [DefaultDispatcher-worker-2 @coroutine#91] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44375/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-22 07:25:38.331 [DefaultDispatcher-worker-2 @coroutine#91] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44375/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-22 07:25:38.331 [DefaultDispatcher-worker-2 @coroutine#91] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44375/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-22 07:25:38.332 [DefaultDispatcher-worker-2 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44375/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2025-12-22 07:25:40.445 [Test worker @coroutine#102] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 07:25:40.446 [Test worker @coroutine#102] INFO  io.ktor.server.Application - Application started in 0.067 seconds.
2025-12-22 07:25:40.454 [DefaultDispatcher-worker-6 @coroutine#108] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:35645
2025-12-22 07:25:40.501 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35645/api/school/respect/person?includeRelated=false
2025-12-22 07:25:40.502 [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:35645/api/school/respect/person?includeRelated=false.
2025-12-22 07:25:40.502 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35645/api/school/respect/person?includeRelated=false
2025-12-22 07:25:40.505 [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-22 07:25:40.508 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35645/api/school/respect/person?includeRelated=false
2025-12-22 07:25:40.508 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35645/api/school/respect/person?includeRelated=false
2025-12-22 07:25:40.508 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35645/api/school/respect/person?includeRelated=false
2025-12-22 07:25:40.509 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:35645/api/school/respect/person?includeRelated=false.
2025-12-22 07:25:40.590 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35645/api/school/respect/person?since=2025-12-22T06%3A25%3A40.505Z&includeRelated=false
2025-12-22 07:25:40.590 [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:35645/api/school/respect/person?since=2025-12-22T06%3A25%3A40.505Z&includeRelated=false.
2025-12-22 07:25:40.590 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35645/api/school/respect/person?since=2025-12-22T06%3A25%3A40.505Z&includeRelated=false
2025-12-22 07:25:40.603 [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-22 07:25:40.616 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35645/api/school/respect/person?since=2025-12-22T06%3A25%3A40.505Z&includeRelated=false
2025-12-22 07:25:40.617 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35645/api/school/respect/person?since=2025-12-22T06%3A25%3A40.505Z&includeRelated=false
2025-12-22 07:25:40.617 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35645/api/school/respect/person?since=2025-12-22T06%3A25%3A40.505Z&includeRelated=false
2025-12-22 07:25:40.617 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:35645/api/school/respect/person?since=2025-12-22T06%3A25%3A40.505Z&includeRelated=false.
2025-12-22 07:25:42.795 [Test worker @coroutine#124] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 07:25:42.805 [Test worker @coroutine#124] INFO  io.ktor.server.Application - Application started in 0.084 seconds.
2025-12-22 07:25:42.813 [DefaultDispatcher-worker-5 @coroutine#130] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:40173
2025-12-22 07:25:42.863 [DefaultDispatcher-worker-4 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40173/api/school/respect/person
2025-12-22 07:25:42.863 [DefaultDispatcher-worker-4 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@39cd7d16 for http://localhost:40173/api/school/respect/person
2025-12-22 07:25:42.863 [DefaultDispatcher-worker-4 @coroutine#128] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40173/api/school/respect/person
2025-12-22 07:25:42.864 [DefaultDispatcher-worker-4 @coroutine#128] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:40173/api/school/respect/person from class io.ktor.http.content.TextContent
2025-12-22 07:25:42.868 [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-22 07:25:42.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-22 07:25:42.917 [DefaultDispatcher-worker-6 @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-22 07:25:42.921 [DefaultDispatcher-worker-1 @coroutine#128] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40173/api/school/respect/person
2025-12-22 07:25:42.922 [DefaultDispatcher-worker-1 @coroutine#128] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40173/api/school/respect/person
2025-12-22 07:25:42.923 [DefaultDispatcher-worker-1 @coroutine#128] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40173/api/school/respect/person
2025-12-22 07:25:45.036 [Test worker @coroutine#143] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 07:25:45.037 [Test worker @coroutine#143] INFO  io.ktor.server.Application - Application started in 0.072 seconds.
2025-12-22 07:25:45.038 [DefaultDispatcher-worker-5 @coroutine#149] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:41603
2025-12-22 07:25:45.082 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41603/api/school/respect/person?includeRelated=false
2025-12-22 07:25:45.082 [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:41603/api/school/respect/person?includeRelated=false.
2025-12-22 07:25:45.082 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41603/api/school/respect/person?includeRelated=false
2025-12-22 07:25:45.085 [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-22 07:25:45.088 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41603/api/school/respect/person?includeRelated=false
2025-12-22 07:25:45.089 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41603/api/school/respect/person?includeRelated=false
2025-12-22 07:25:45.089 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41603/api/school/respect/person?includeRelated=false
2025-12-22 07:25:45.089 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41603/api/school/respect/person?includeRelated=false.
2025-12-22 07:25:47.141 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41603/api/school/respect/person?includeRelated=false
2025-12-22 07:25:47.141 [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:41603/api/school/respect/person?includeRelated=false.
2025-12-22 07:25:47.141 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41603/api/school/respect/person?includeRelated=false
2025-12-22 07:25:47.143 [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-22 07:25:47.146 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41603/api/school/respect/person?includeRelated=false
2025-12-22 07:25:47.146 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41603/api/school/respect/person?includeRelated=false
2025-12-22 07:25:47.146 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41603/api/school/respect/person?includeRelated=false
2025-12-22 07:25:47.147 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41603/api/school/respect/person?includeRelated=false.
2025-12-22 07:25:49.210 [Test worker @coroutine#167] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 07:25:49.211 [Test worker @coroutine#167] INFO  io.ktor.server.Application - Application started in 0.049 seconds.
2025-12-22 07:25:49.212 [DefaultDispatcher-worker-1 @coroutine#173] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:37455
2025-12-22 07:25:49.258 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37455/api/school/respect/person?includeRelated=false
2025-12-22 07:25:49.258 [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:37455/api/school/respect/person?includeRelated=false.
2025-12-22 07:25:49.258 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37455/api/school/respect/person?includeRelated=false
2025-12-22 07:25:49.278 [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-22 07:25:49.293 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37455/api/school/respect/person?includeRelated=false
2025-12-22 07:25:49.293 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37455/api/school/respect/person?includeRelated=false
2025-12-22 07:25:49.294 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37455/api/school/respect/person?includeRelated=false
2025-12-22 07:25:49.294 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:37455/api/school/respect/person?includeRelated=false.
2025-12-22 07:25:49.358 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37455/api/school/respect/person?since=2025-12-22T06%3A25%3A49.279Z&includeRelated=false
2025-12-22 07:25:49.359 [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:37455/api/school/respect/person?since=2025-12-22T06%3A25%3A49.279Z&includeRelated=false.
2025-12-22 07:25:49.359 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37455/api/school/respect/person?since=2025-12-22T06%3A25%3A49.279Z&includeRelated=false
2025-12-22 07:25:49.368 [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-22 07:25:49.378 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37455/api/school/respect/person?since=2025-12-22T06%3A25%3A49.279Z&includeRelated=false
2025-12-22 07:25:49.378 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37455/api/school/respect/person?since=2025-12-22T06%3A25%3A49.279Z&includeRelated=false
2025-12-22 07:25:49.378 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37455/api/school/respect/person?since=2025-12-22T06%3A25%3A49.279Z&includeRelated=false
2025-12-22 07:25:49.379 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:37455/api/school/respect/person?since=2025-12-22T06%3A25%3A49.279Z&includeRelated=false.
2025-12-22 08:30:06.037 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 08:30:06.199 [Test worker] INFO  io.ktor.server.Application - Application started in 0.336 seconds.
2025-12-22 08:30:06.328 [DefaultDispatcher-worker-1 @coroutine#2] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:43825
2025-12-22 08:30:06.723 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43825/resources/index.json
2025-12-22 08:30:06.723 [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:43825/resources/index.json.
2025-12-22 08:30:06.723 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43825/resources/index.json
2025-12-22 08:30:06.911 [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-22 08:30:06.972 [DefaultDispatcher-worker-2 @call-handler#12] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 68ms
2025-12-22 08:30:06.977 [DefaultDispatcher-worker-2 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43825/resources/index.json
2025-12-22 08:30:06.979 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43825/resources/index.json
2025-12-22 08:30:06.980 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43825/resources/index.json
2025-12-22 08:30:07.002 [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:43825/resources/index.json.
2025-12-22 08:30:07.037 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43825/resources/index.json
2025-12-22 08:30:07.037 [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:43825/resources/index.json.
2025-12-22 08:30:07.037 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43825/resources/index.json
2025-12-22 08:30:07.048 [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-22 08:30:07.052 [eventLoopGroupProxy-4-1 @call-handler#22] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 4ms
2025-12-22 08:30:07.054 [DefaultDispatcher-worker-1 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43825/resources/index.json
2025-12-22 08:30:07.054 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43825/resources/index.json
2025-12-22 08:30:07.054 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43825/resources/index.json
2025-12-22 08:30:09.092 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 08:30:09.093 [Test worker] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2025-12-22 08:30:09.098 [DefaultDispatcher-worker-1 @coroutine#26] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:37261
2025-12-22 08:30:09.150 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37261/resources/index.json
2025-12-22 08:30:09.150 [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:37261/resources/index.json.
2025-12-22 08:30:09.150 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37261/resources/index.json
2025-12-22 08:30:09.155 [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-22 08:30:09.156 [DefaultDispatcher-worker-8 @call-handler#35] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 2ms
2025-12-22 08:30:09.157 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37261/resources/index.json
2025-12-22 08:30:09.157 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37261/resources/index.json
2025-12-22 08:30:09.157 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37261/resources/index.json
2025-12-22 08:30:09.158 [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:37261/resources/index.json.
2025-12-22 08:30:09.165 [DefaultDispatcher-worker-5 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37261/resources/index.json
2025-12-22 08:30:09.165 [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:37261/resources/index.json.
2025-12-22 08:30:09.165 [DefaultDispatcher-worker-5 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37261/resources/index.json
2025-12-22 08:30:09.168 [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-22 08:30:09.169 [eventLoopGroupProxy-7-1 @call-handler#45] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms
2025-12-22 08:30:09.171 [DefaultDispatcher-worker-7 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37261/resources/index.json
2025-12-22 08:30:09.171 [DefaultDispatcher-worker-7 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37261/resources/index.json
2025-12-22 08:30:09.171 [DefaultDispatcher-worker-7 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37261/resources/index.json
2025-12-22 08:30:11.183 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 08:30:11.184 [Test worker] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2025-12-22 08:30:11.185 [DefaultDispatcher-worker-7 @coroutine#49] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:42531
2025-12-22 08:30:11.189 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42531/resources/lesson001.json
2025-12-22 08:30:11.189 [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:42531/resources/lesson001.json.
2025-12-22 08:30:11.189 [Test worker @coroutine#52] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42531/resources/lesson001.json
2025-12-22 08:30:11.192 [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-22 08:30:11.193 [DefaultDispatcher-worker-6 @call-handler#56] INFO  io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 1ms
2025-12-22 08:30:11.194 [DefaultDispatcher-worker-7 @coroutine#52] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42531/resources/lesson001.json
2025-12-22 08:30:11.194 [DefaultDispatcher-worker-8 @coroutine#52] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42531/resources/lesson001.json
2025-12-22 08:30:11.194 [DefaultDispatcher-worker-8 @coroutine#52] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42531/resources/lesson001.json
2025-12-22 08:30:11.212 [DefaultDispatcher-worker-8 @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsPublication for http://localhost:42531/resources/lesson001.json.
2025-12-22 08:30:14.474 [Test worker @coroutine#61] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 08:30:14.525 [Test worker @coroutine#61] INFO  io.ktor.server.Application - Application started in 1.258 seconds.
2025-12-22 08:30:14.537 [DefaultDispatcher-worker-7 @coroutine#67] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:42829
2025-12-22 08:30:14.680 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42829/api/school/respect/person?includeRelated=false
2025-12-22 08:30:14.680 [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:42829/api/school/respect/person?includeRelated=false.
2025-12-22 08:30:14.681 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42829/api/school/respect/person?includeRelated=false
2025-12-22 08:30:14.690 [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-22 08:30:14.741 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42829/api/school/respect/person?includeRelated=false
2025-12-22 08:30:14.742 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42829/api/school/respect/person?includeRelated=false
2025-12-22 08:30:14.742 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42829/api/school/respect/person?includeRelated=false
2025-12-22 08:30:14.757 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:42829/api/school/respect/person?includeRelated=false.
2025-12-22 08:30:14.846 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42829/api/school/respect/person?includeRelated=false
2025-12-22 08:30:14.846 [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:42829/api/school/respect/person?includeRelated=false.
2025-12-22 08:30:14.846 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42829/api/school/respect/person?includeRelated=false
2025-12-22 08:30:14.853 [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-22 08:30:14.859 [DefaultDispatcher-worker-6 @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-22 08:30:14.866 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42829/api/school/respect/person?includeRelated=false
2025-12-22 08:30:14.867 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42829/api/school/respect/person?includeRelated=false
2025-12-22 08:30:14.867 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42829/api/school/respect/person?includeRelated=false
2025-12-22 08:30:16.957 [Test worker @coroutine#82] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 08:30:16.958 [Test worker @coroutine#82] INFO  io.ktor.server.Application - Application started in 0.056 seconds.
2025-12-22 08:30:16.960 [DefaultDispatcher-worker-6 @coroutine#88] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:43921
2025-12-22 08:30:17.035 [DefaultDispatcher-worker-7 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43921/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-22 08:30:17.035 [DefaultDispatcher-worker-7 @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:43921/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2025-12-22 08:30:17.035 [DefaultDispatcher-worker-7 @coroutine#91] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43921/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-22 08:30:17.038 [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-22 08:30:17.041 [DefaultDispatcher-worker-8 @coroutine#91] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43921/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-22 08:30:17.041 [DefaultDispatcher-worker-8 @coroutine#91] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43921/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-22 08:30:17.041 [DefaultDispatcher-worker-8 @coroutine#91] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43921/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-22 08:30:17.042 [DefaultDispatcher-worker-8 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:43921/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2025-12-22 08:30:19.154 [Test worker @coroutine#102] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 08:30:19.155 [Test worker @coroutine#102] INFO  io.ktor.server.Application - Application started in 0.06 seconds.
2025-12-22 08:30:19.159 [DefaultDispatcher-worker-7 @coroutine#108] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:41615
2025-12-22 08:30:19.194 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41615/api/school/respect/person?includeRelated=false
2025-12-22 08:30:19.194 [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:41615/api/school/respect/person?includeRelated=false.
2025-12-22 08:30:19.194 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41615/api/school/respect/person?includeRelated=false
2025-12-22 08:30:19.197 [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-22 08:30:19.203 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41615/api/school/respect/person?includeRelated=false
2025-12-22 08:30:19.203 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41615/api/school/respect/person?includeRelated=false
2025-12-22 08:30:19.203 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41615/api/school/respect/person?includeRelated=false
2025-12-22 08:30:19.204 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41615/api/school/respect/person?includeRelated=false.
2025-12-22 08:30:19.265 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41615/api/school/respect/person?since=2025-12-22T07%3A30%3A19.198Z&includeRelated=false
2025-12-22 08:30:19.266 [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:41615/api/school/respect/person?since=2025-12-22T07%3A30%3A19.198Z&includeRelated=false.
2025-12-22 08:30:19.266 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41615/api/school/respect/person?since=2025-12-22T07%3A30%3A19.198Z&includeRelated=false
2025-12-22 08:30:19.269 [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-22 08:30:19.275 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41615/api/school/respect/person?since=2025-12-22T07%3A30%3A19.198Z&includeRelated=false
2025-12-22 08:30:19.275 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41615/api/school/respect/person?since=2025-12-22T07%3A30%3A19.198Z&includeRelated=false
2025-12-22 08:30:19.276 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41615/api/school/respect/person?since=2025-12-22T07%3A30%3A19.198Z&includeRelated=false
2025-12-22 08:30:19.277 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41615/api/school/respect/person?since=2025-12-22T07%3A30%3A19.198Z&includeRelated=false.
2025-12-22 08:30:21.428 [Test worker @coroutine#124] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 08:30:21.429 [Test worker @coroutine#124] INFO  io.ktor.server.Application - Application started in 0.063 seconds.
2025-12-22 08:30:21.433 [DefaultDispatcher-worker-5 @coroutine#130] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:36191
2025-12-22 08:30:21.502 [DefaultDispatcher-worker-7 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36191/api/school/respect/person
2025-12-22 08:30:21.503 [DefaultDispatcher-worker-7 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@25418292 for http://localhost:36191/api/school/respect/person
2025-12-22 08:30:21.503 [DefaultDispatcher-worker-7 @coroutine#128] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36191/api/school/respect/person
2025-12-22 08:30:21.503 [DefaultDispatcher-worker-7 @coroutine#128] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:36191/api/school/respect/person from class io.ktor.http.content.TextContent
2025-12-22 08:30:21.527 [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-22 08:30:21.558 [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-22 08:30:21.567 [DefaultDispatcher-worker-6 @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-22 08:30:21.574 [DefaultDispatcher-worker-8 @coroutine#128] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36191/api/school/respect/person
2025-12-22 08:30:21.574 [DefaultDispatcher-worker-8 @coroutine#128] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36191/api/school/respect/person
2025-12-22 08:30:21.574 [DefaultDispatcher-worker-8 @coroutine#128] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36191/api/school/respect/person
2025-12-22 08:30:23.716 [Test worker @coroutine#143] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 08:30:23.717 [Test worker @coroutine#143] INFO  io.ktor.server.Application - Application started in 0.067 seconds.
2025-12-22 08:30:23.719 [DefaultDispatcher-worker-7 @coroutine#149] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:41757
2025-12-22 08:30:23.773 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41757/api/school/respect/person?includeRelated=false
2025-12-22 08:30:23.774 [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:41757/api/school/respect/person?includeRelated=false.
2025-12-22 08:30:23.774 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41757/api/school/respect/person?includeRelated=false
2025-12-22 08:30:23.779 [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-22 08:30:23.784 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41757/api/school/respect/person?includeRelated=false
2025-12-22 08:30:23.785 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41757/api/school/respect/person?includeRelated=false
2025-12-22 08:30:23.785 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41757/api/school/respect/person?includeRelated=false
2025-12-22 08:30:23.785 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41757/api/school/respect/person?includeRelated=false.
2025-12-22 08:30:25.825 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41757/api/school/respect/person?includeRelated=false
2025-12-22 08:30:25.825 [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:41757/api/school/respect/person?includeRelated=false.
2025-12-22 08:30:25.825 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41757/api/school/respect/person?includeRelated=false
2025-12-22 08:30:25.827 [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-22 08:30:25.830 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41757/api/school/respect/person?includeRelated=false
2025-12-22 08:30:25.830 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41757/api/school/respect/person?includeRelated=false
2025-12-22 08:30:25.830 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41757/api/school/respect/person?includeRelated=false
2025-12-22 08:30:25.831 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41757/api/school/respect/person?includeRelated=false.
2025-12-22 08:30:27.901 [Test worker @coroutine#167] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 08:30:27.902 [Test worker @coroutine#167] INFO  io.ktor.server.Application - Application started in 0.047 seconds.
2025-12-22 08:30:27.903 [DefaultDispatcher-worker-7 @coroutine#173] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:40829
2025-12-22 08:30:27.933 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40829/api/school/respect/person?includeRelated=false
2025-12-22 08:30:27.934 [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:40829/api/school/respect/person?includeRelated=false.
2025-12-22 08:30:27.934 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40829/api/school/respect/person?includeRelated=false
2025-12-22 08:30:27.936 [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-22 08:30:27.939 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40829/api/school/respect/person?includeRelated=false
2025-12-22 08:30:27.939 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40829/api/school/respect/person?includeRelated=false
2025-12-22 08:30:27.939 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40829/api/school/respect/person?includeRelated=false
2025-12-22 08:30:27.939 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:40829/api/school/respect/person?includeRelated=false.
2025-12-22 08:30:27.978 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40829/api/school/respect/person?since=2025-12-22T07%3A30%3A27.936Z&includeRelated=false
2025-12-22 08:30:27.978 [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:40829/api/school/respect/person?since=2025-12-22T07%3A30%3A27.936Z&includeRelated=false.
2025-12-22 08:30:27.978 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40829/api/school/respect/person?since=2025-12-22T07%3A30%3A27.936Z&includeRelated=false
2025-12-22 08:30:27.980 [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-22 08:30:27.982 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40829/api/school/respect/person?since=2025-12-22T07%3A30%3A27.936Z&includeRelated=false
2025-12-22 08:30:27.982 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40829/api/school/respect/person?since=2025-12-22T07%3A30%3A27.936Z&includeRelated=false
2025-12-22 08:30:27.982 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40829/api/school/respect/person?since=2025-12-22T07%3A30%3A27.936Z&includeRelated=false
2025-12-22 08:30:27.982 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:40829/api/school/respect/person?since=2025-12-22T07%3A30%3A27.936Z&includeRelated=false.
2025-12-22 08:55:26.287 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 08:55:26.428 [Test worker] INFO  io.ktor.server.Application - Application started in 0.326 seconds.
2025-12-22 08:55:26.559 [DefaultDispatcher-worker-1 @coroutine#2] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:40033
2025-12-22 08:55:26.918 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40033/resources/index.json
2025-12-22 08:55:26.919 [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:40033/resources/index.json.
2025-12-22 08:55:26.920 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40033/resources/index.json
2025-12-22 08:55:27.093 [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-22 08:55:27.140 [DefaultDispatcher-worker-1 @call-handler#12] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 51ms
2025-12-22 08:55:27.147 [DefaultDispatcher-worker-3 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40033/resources/index.json
2025-12-22 08:55:27.149 [DefaultDispatcher-worker-3 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40033/resources/index.json
2025-12-22 08:55:27.150 [DefaultDispatcher-worker-3 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40033/resources/index.json
2025-12-22 08:55:27.179 [DefaultDispatcher-worker-3 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsFeed for http://localhost:40033/resources/index.json.
2025-12-22 08:55:27.256 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40033/resources/index.json
2025-12-22 08:55:27.256 [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:40033/resources/index.json.
2025-12-22 08:55:27.256 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40033/resources/index.json
2025-12-22 08:55:27.269 [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-22 08:55:27.271 [eventLoopGroupProxy-4-1 @call-handler#22] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 2ms
2025-12-22 08:55:27.276 [DefaultDispatcher-worker-2 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40033/resources/index.json
2025-12-22 08:55:27.276 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40033/resources/index.json
2025-12-22 08:55:27.276 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40033/resources/index.json
2025-12-22 08:55:29.323 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 08:55:29.324 [Test worker] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2025-12-22 08:55:29.325 [DefaultDispatcher-worker-2 @coroutine#26] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:35595
2025-12-22 08:55:29.385 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35595/resources/index.json
2025-12-22 08:55:29.385 [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:35595/resources/index.json.
2025-12-22 08:55:29.385 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35595/resources/index.json
2025-12-22 08:55:29.391 [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-22 08:55:29.393 [eventLoopGroupProxy-7-1 @call-handler#35] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 2ms
2025-12-22 08:55:29.394 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35595/resources/index.json
2025-12-22 08:55:29.395 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35595/resources/index.json
2025-12-22 08:55:29.395 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35595/resources/index.json
2025-12-22 08:55:29.395 [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:35595/resources/index.json.
2025-12-22 08:55:29.405 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35595/resources/index.json
2025-12-22 08:55:29.405 [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:35595/resources/index.json.
2025-12-22 08:55:29.405 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35595/resources/index.json
2025-12-22 08:55:29.413 [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-22 08:55:29.414 [eventLoopGroupProxy-7-1 @call-handler#45] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms
2025-12-22 08:55:29.416 [DefaultDispatcher-worker-3 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35595/resources/index.json
2025-12-22 08:55:29.416 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35595/resources/index.json
2025-12-22 08:55:29.417 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35595/resources/index.json
2025-12-22 08:55:31.426 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 08:55:31.426 [Test worker] INFO  io.ktor.server.Application - Application started in 0.0 seconds.
2025-12-22 08:55:31.428 [DefaultDispatcher-worker-3 @coroutine#49] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:40731
2025-12-22 08:55:31.431 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40731/resources/lesson001.json
2025-12-22 08:55:31.432 [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:40731/resources/lesson001.json.
2025-12-22 08:55:31.432 [Test worker @coroutine#52] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40731/resources/lesson001.json
2025-12-22 08:55:31.434 [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-22 08:55:31.436 [DefaultDispatcher-worker-3 @call-handler#56] INFO  io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 2ms
2025-12-22 08:55:31.437 [DefaultDispatcher-worker-3 @coroutine#52] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40731/resources/lesson001.json
2025-12-22 08:55:31.439 [DefaultDispatcher-worker-5 @coroutine#52] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40731/resources/lesson001.json
2025-12-22 08:55:31.439 [DefaultDispatcher-worker-5 @coroutine#52] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40731/resources/lesson001.json
2025-12-22 08:55:31.467 [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:40731/resources/lesson001.json.
2025-12-22 08:55:34.516 [Test worker @coroutine#61] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 08:55:34.557 [Test worker @coroutine#61] INFO  io.ktor.server.Application - Application started in 1.018 seconds.
2025-12-22 08:55:34.568 [DefaultDispatcher-worker-5 @coroutine#67] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:45839
2025-12-22 08:55:34.790 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45839/api/school/respect/person?includeRelated=false
2025-12-22 08:55:34.791 [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:45839/api/school/respect/person?includeRelated=false.
2025-12-22 08:55:34.792 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45839/api/school/respect/person?includeRelated=false
2025-12-22 08:55:34.808 [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-22 08:55:34.876 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45839/api/school/respect/person?includeRelated=false
2025-12-22 08:55:34.876 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45839/api/school/respect/person?includeRelated=false
2025-12-22 08:55:34.877 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45839/api/school/respect/person?includeRelated=false
2025-12-22 08:55:34.882 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:45839/api/school/respect/person?includeRelated=false.
2025-12-22 08:55:34.954 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45839/api/school/respect/person?includeRelated=false
2025-12-22 08:55:34.954 [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:45839/api/school/respect/person?includeRelated=false.
2025-12-22 08:55:34.955 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45839/api/school/respect/person?includeRelated=false
2025-12-22 08:55:34.961 [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-22 08:55:34.966 [DefaultDispatcher-worker-3 @call-handler#78] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the GET /api/school/respect/person?includeRelated=false request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2025-12-22 08:55:34.968 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45839/api/school/respect/person?includeRelated=false
2025-12-22 08:55:34.969 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45839/api/school/respect/person?includeRelated=false
2025-12-22 08:55:34.969 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45839/api/school/respect/person?includeRelated=false
2025-12-22 08:55:37.050 [Test worker @coroutine#82] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 08:55:37.050 [Test worker @coroutine#82] INFO  io.ktor.server.Application - Application started in 0.053 seconds.
2025-12-22 08:55:37.052 [DefaultDispatcher-worker-3 @coroutine#88] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:43397
2025-12-22 08:55:37.115 [DefaultDispatcher-worker-6 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43397/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-22 08:55:37.115 [DefaultDispatcher-worker-6 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:43397/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2025-12-22 08:55:37.115 [DefaultDispatcher-worker-6 @coroutine#91] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43397/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-22 08:55:37.119 [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-22 08:55:37.123 [DefaultDispatcher-worker-4 @coroutine#91] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43397/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-22 08:55:37.123 [DefaultDispatcher-worker-4 @coroutine#91] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43397/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-22 08:55:37.123 [DefaultDispatcher-worker-4 @coroutine#91] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43397/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-22 08:55:37.123 [DefaultDispatcher-worker-4 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:43397/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2025-12-22 08:55:39.265 [Test worker @coroutine#102] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 08:55:39.266 [Test worker @coroutine#102] INFO  io.ktor.server.Application - Application started in 0.066 seconds.
2025-12-22 08:55:39.267 [DefaultDispatcher-worker-4 @coroutine#108] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:41777
2025-12-22 08:55:39.328 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41777/api/school/respect/person?includeRelated=false
2025-12-22 08:55:39.329 [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:41777/api/school/respect/person?includeRelated=false.
2025-12-22 08:55:39.329 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41777/api/school/respect/person?includeRelated=false
2025-12-22 08:55:39.349 [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-22 08:55:39.359 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41777/api/school/respect/person?includeRelated=false
2025-12-22 08:55:39.360 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41777/api/school/respect/person?includeRelated=false
2025-12-22 08:55:39.360 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41777/api/school/respect/person?includeRelated=false
2025-12-22 08:55:39.363 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41777/api/school/respect/person?includeRelated=false.
2025-12-22 08:55:39.448 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41777/api/school/respect/person?since=2025-12-22T07%3A55%3A39.350Z&includeRelated=false
2025-12-22 08:55:39.449 [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:41777/api/school/respect/person?since=2025-12-22T07%3A55%3A39.350Z&includeRelated=false.
2025-12-22 08:55:39.450 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41777/api/school/respect/person?since=2025-12-22T07%3A55%3A39.350Z&includeRelated=false
2025-12-22 08:55:39.464 [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-22 08:55:39.470 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41777/api/school/respect/person?since=2025-12-22T07%3A55%3A39.350Z&includeRelated=false
2025-12-22 08:55:39.470 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41777/api/school/respect/person?since=2025-12-22T07%3A55%3A39.350Z&includeRelated=false
2025-12-22 08:55:39.470 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41777/api/school/respect/person?since=2025-12-22T07%3A55%3A39.350Z&includeRelated=false
2025-12-22 08:55:39.471 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41777/api/school/respect/person?since=2025-12-22T07%3A55%3A39.350Z&includeRelated=false.
2025-12-22 08:55:41.657 [Test worker @coroutine#124] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 08:55:41.661 [Test worker @coroutine#124] INFO  io.ktor.server.Application - Application started in 0.13 seconds.
2025-12-22 08:55:41.663 [DefaultDispatcher-worker-4 @coroutine#130] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:45403
2025-12-22 08:55:41.714 [DefaultDispatcher-worker-6 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45403/api/school/respect/person
2025-12-22 08:55:41.718 [DefaultDispatcher-worker-6 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@4e8d9589 for http://localhost:45403/api/school/respect/person
2025-12-22 08:55:41.718 [DefaultDispatcher-worker-6 @coroutine#128] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45403/api/school/respect/person
2025-12-22 08:55:41.718 [DefaultDispatcher-worker-6 @coroutine#128] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:45403/api/school/respect/person from class io.ktor.http.content.TextContent
2025-12-22 08:55:41.727 [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-22 08:55:41.737 [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-22 08:55:41.769 [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-22 08:55:41.777 [DefaultDispatcher-worker-8 @coroutine#128] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45403/api/school/respect/person
2025-12-22 08:55:41.779 [DefaultDispatcher-worker-8 @coroutine#128] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45403/api/school/respect/person
2025-12-22 08:55:41.779 [DefaultDispatcher-worker-8 @coroutine#128] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45403/api/school/respect/person
2025-12-22 08:55:43.878 [Test worker @coroutine#143] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 08:55:43.879 [Test worker @coroutine#143] INFO  io.ktor.server.Application - Application started in 0.064 seconds.
2025-12-22 08:55:43.880 [DefaultDispatcher-worker-8 @coroutine#149] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:43759
2025-12-22 08:55:43.928 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43759/api/school/respect/person?includeRelated=false
2025-12-22 08:55:43.929 [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:43759/api/school/respect/person?includeRelated=false.
2025-12-22 08:55:43.929 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43759/api/school/respect/person?includeRelated=false
2025-12-22 08:55:43.932 [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-22 08:55:43.937 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43759/api/school/respect/person?includeRelated=false
2025-12-22 08:55:43.937 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43759/api/school/respect/person?includeRelated=false
2025-12-22 08:55:43.937 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43759/api/school/respect/person?includeRelated=false
2025-12-22 08:55:43.937 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:43759/api/school/respect/person?includeRelated=false.
2025-12-22 08:55:45.988 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43759/api/school/respect/person?includeRelated=false
2025-12-22 08:55:45.989 [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:43759/api/school/respect/person?includeRelated=false.
2025-12-22 08:55:45.989 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43759/api/school/respect/person?includeRelated=false
2025-12-22 08:55:45.990 [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-22 08:55:45.993 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43759/api/school/respect/person?includeRelated=false
2025-12-22 08:55:45.993 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43759/api/school/respect/person?includeRelated=false
2025-12-22 08:55:45.993 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43759/api/school/respect/person?includeRelated=false
2025-12-22 08:55:45.993 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:43759/api/school/respect/person?includeRelated=false.
2025-12-22 08:55:48.109 [Test worker @coroutine#167] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 08:55:48.113 [Test worker @coroutine#167] INFO  io.ktor.server.Application - Application started in 0.076 seconds.
2025-12-22 08:55:48.119 [DefaultDispatcher-worker-7 @coroutine#173] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:37495
2025-12-22 08:55:48.156 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37495/api/school/respect/person?includeRelated=false
2025-12-22 08:55:48.156 [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:37495/api/school/respect/person?includeRelated=false.
2025-12-22 08:55:48.156 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37495/api/school/respect/person?includeRelated=false
2025-12-22 08:55:48.159 [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-22 08:55:48.162 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37495/api/school/respect/person?includeRelated=false
2025-12-22 08:55:48.163 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37495/api/school/respect/person?includeRelated=false
2025-12-22 08:55:48.163 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37495/api/school/respect/person?includeRelated=false
2025-12-22 08:55:48.163 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:37495/api/school/respect/person?includeRelated=false.
2025-12-22 08:55:48.195 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37495/api/school/respect/person?since=2025-12-22T07%3A55%3A48.159Z&includeRelated=false
2025-12-22 08:55:48.195 [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:37495/api/school/respect/person?since=2025-12-22T07%3A55%3A48.159Z&includeRelated=false.
2025-12-22 08:55:48.195 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37495/api/school/respect/person?since=2025-12-22T07%3A55%3A48.159Z&includeRelated=false
2025-12-22 08:55:48.197 [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-22 08:55:48.203 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37495/api/school/respect/person?since=2025-12-22T07%3A55%3A48.159Z&includeRelated=false
2025-12-22 08:55:48.203 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37495/api/school/respect/person?since=2025-12-22T07%3A55%3A48.159Z&includeRelated=false
2025-12-22 08:55:48.203 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37495/api/school/respect/person?since=2025-12-22T07%3A55%3A48.159Z&includeRelated=false
2025-12-22 08:55:48.205 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:37495/api/school/respect/person?since=2025-12-22T07%3A55%3A48.159Z&includeRelated=false.
2025-12-22 09:49:23.917 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 09:49:24.026 [Test worker] INFO  io.ktor.server.Application - Application started in 0.253 seconds.
2025-12-22 09:49:24.123 [DefaultDispatcher-worker-1 @coroutine#2] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:34089
2025-12-22 09:49:24.417 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34089/resources/index.json
2025-12-22 09:49:24.417 [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:34089/resources/index.json.
2025-12-22 09:49:24.417 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34089/resources/index.json
2025-12-22 09:49:24.584 [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-22 09:49:24.636 [eventLoopGroupProxy-4-1 @call-handler#12] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 59ms
2025-12-22 09:49:24.640 [DefaultDispatcher-worker-2 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34089/resources/index.json
2025-12-22 09:49:24.642 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34089/resources/index.json
2025-12-22 09:49:24.642 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34089/resources/index.json
2025-12-22 09:49:24.663 [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:34089/resources/index.json.
2025-12-22 09:49:24.701 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34089/resources/index.json
2025-12-22 09:49:24.701 [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:34089/resources/index.json.
2025-12-22 09:49:24.701 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34089/resources/index.json
2025-12-22 09:49:24.705 [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-22 09:49:24.706 [eventLoopGroupProxy-4-1 @call-handler#22] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 2ms
2025-12-22 09:49:24.707 [DefaultDispatcher-worker-2 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34089/resources/index.json
2025-12-22 09:49:24.708 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34089/resources/index.json
2025-12-22 09:49:24.708 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34089/resources/index.json
2025-12-22 09:49:26.729 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 09:49:26.729 [Test worker] INFO  io.ktor.server.Application - Application started in 0.0 seconds.
2025-12-22 09:49:26.731 [DefaultDispatcher-worker-2 @coroutine#26] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:44701
2025-12-22 09:49:26.785 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44701/resources/index.json
2025-12-22 09:49:26.786 [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:44701/resources/index.json.
2025-12-22 09:49:26.786 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44701/resources/index.json
2025-12-22 09:49:26.789 [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-22 09:49:26.790 [DefaultDispatcher-worker-1 @call-handler#35] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 1ms
2025-12-22 09:49:26.791 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44701/resources/index.json
2025-12-22 09:49:26.791 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44701/resources/index.json
2025-12-22 09:49:26.791 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44701/resources/index.json
2025-12-22 09:49:26.791 [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:44701/resources/index.json.
2025-12-22 09:49:26.796 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44701/resources/index.json
2025-12-22 09:49:26.796 [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:44701/resources/index.json.
2025-12-22 09:49:26.796 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44701/resources/index.json
2025-12-22 09:49:26.797 [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-22 09:49:26.798 [eventLoopGroupProxy-7-1 @call-handler#45] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms
2025-12-22 09:49:26.798 [DefaultDispatcher-worker-1 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44701/resources/index.json
2025-12-22 09:49:26.798 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44701/resources/index.json
2025-12-22 09:49:26.798 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44701/resources/index.json
2025-12-22 09:49:28.819 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 09:49:28.820 [Test worker] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2025-12-22 09:49:28.832 [DefaultDispatcher-worker-2 @coroutine#49] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:44301
2025-12-22 09:49:28.843 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44301/resources/lesson001.json
2025-12-22 09:49:28.843 [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:44301/resources/lesson001.json.
2025-12-22 09:49:28.844 [Test worker @coroutine#52] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44301/resources/lesson001.json
2025-12-22 09:49:28.858 [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-22 09:49:28.862 [DefaultDispatcher-worker-5 @call-handler#56] INFO  io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 5ms
2025-12-22 09:49:28.867 [DefaultDispatcher-worker-3 @coroutine#52] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44301/resources/lesson001.json
2025-12-22 09:49:28.867 [DefaultDispatcher-worker-3 @coroutine#52] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44301/resources/lesson001.json
2025-12-22 09:49:28.867 [DefaultDispatcher-worker-3 @coroutine#52] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44301/resources/lesson001.json
2025-12-22 09:49:28.913 [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:44301/resources/lesson001.json.
2025-12-22 09:49:31.773 [Test worker @coroutine#61] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 09:49:31.782 [Test worker @coroutine#61] INFO  io.ktor.server.Application - Application started in 0.752 seconds.
2025-12-22 09:49:31.785 [DefaultDispatcher-worker-4 @coroutine#67] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:44427
2025-12-22 09:49:31.863 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44427/api/school/respect/person?includeRelated=false
2025-12-22 09:49:31.864 [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:44427/api/school/respect/person?includeRelated=false.
2025-12-22 09:49:31.864 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44427/api/school/respect/person?includeRelated=false
2025-12-22 09:49:31.869 [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-22 09:49:31.898 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44427/api/school/respect/person?includeRelated=false
2025-12-22 09:49:31.898 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44427/api/school/respect/person?includeRelated=false
2025-12-22 09:49:31.898 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44427/api/school/respect/person?includeRelated=false
2025-12-22 09:49:31.900 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44427/api/school/respect/person?includeRelated=false.
2025-12-22 09:49:31.935 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44427/api/school/respect/person?includeRelated=false
2025-12-22 09:49:31.935 [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:44427/api/school/respect/person?includeRelated=false.
2025-12-22 09:49:31.935 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44427/api/school/respect/person?includeRelated=false
2025-12-22 09:49:31.937 [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-22 09:49:31.938 [DefaultDispatcher-worker-4 @call-handler#78] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the GET /api/school/respect/person?includeRelated=false request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2025-12-22 09:49:31.940 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44427/api/school/respect/person?includeRelated=false
2025-12-22 09:49:31.940 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44427/api/school/respect/person?includeRelated=false
2025-12-22 09:49:31.941 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44427/api/school/respect/person?includeRelated=false
2025-12-22 09:49:34.006 [Test worker @coroutine#82] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 09:49:34.008 [Test worker @coroutine#82] INFO  io.ktor.server.Application - Application started in 0.038 seconds.
2025-12-22 09:49:34.009 [DefaultDispatcher-worker-4 @coroutine#88] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:37501
2025-12-22 09:49:34.114 [DefaultDispatcher-worker-4 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37501/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-22 09:49:34.114 [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:37501/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2025-12-22 09:49:34.115 [DefaultDispatcher-worker-4 @coroutine#91] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37501/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-22 09:49:34.134 [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-22 09:49:34.148 [DefaultDispatcher-worker-1 @coroutine#91] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37501/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-22 09:49:34.149 [DefaultDispatcher-worker-6 @coroutine#91] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37501/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-22 09:49:34.149 [DefaultDispatcher-worker-6 @coroutine#91] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37501/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-22 09:49:34.150 [DefaultDispatcher-worker-6 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:37501/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2025-12-22 09:49:36.307 [Test worker @coroutine#102] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 09:49:36.313 [Test worker @coroutine#102] INFO  io.ktor.server.Application - Application started in 0.069 seconds.
2025-12-22 09:49:36.337 [DefaultDispatcher-worker-7 @coroutine#108] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:34639
2025-12-22 09:49:36.391 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34639/api/school/respect/person?includeRelated=false
2025-12-22 09:49:36.391 [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:34639/api/school/respect/person?includeRelated=false.
2025-12-22 09:49:36.392 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34639/api/school/respect/person?includeRelated=false
2025-12-22 09:49:36.412 [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-22 09:49:36.430 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34639/api/school/respect/person?includeRelated=false
2025-12-22 09:49:36.431 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34639/api/school/respect/person?includeRelated=false
2025-12-22 09:49:36.431 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34639/api/school/respect/person?includeRelated=false
2025-12-22 09:49:36.432 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34639/api/school/respect/person?includeRelated=false.
2025-12-22 09:49:36.530 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34639/api/school/respect/person?since=2025-12-22T08%3A49%3A36.413Z&includeRelated=false
2025-12-22 09:49:36.530 [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:34639/api/school/respect/person?since=2025-12-22T08%3A49%3A36.413Z&includeRelated=false.
2025-12-22 09:49:36.530 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34639/api/school/respect/person?since=2025-12-22T08%3A49%3A36.413Z&includeRelated=false
2025-12-22 09:49:36.539 [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-22 09:49:36.550 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34639/api/school/respect/person?since=2025-12-22T08%3A49%3A36.413Z&includeRelated=false
2025-12-22 09:49:36.550 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34639/api/school/respect/person?since=2025-12-22T08%3A49%3A36.413Z&includeRelated=false
2025-12-22 09:49:36.550 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34639/api/school/respect/person?since=2025-12-22T08%3A49%3A36.413Z&includeRelated=false
2025-12-22 09:49:36.551 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34639/api/school/respect/person?since=2025-12-22T08%3A49%3A36.413Z&includeRelated=false.
2025-12-22 09:49:38.700 [Test worker @coroutine#124] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 09:49:38.702 [Test worker @coroutine#124] INFO  io.ktor.server.Application - Application started in 0.071 seconds.
2025-12-22 09:49:38.703 [DefaultDispatcher-worker-7 @coroutine#130] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:44417
2025-12-22 09:49:38.765 [DefaultDispatcher-worker-2 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44417/api/school/respect/person
2025-12-22 09:49:38.766 [DefaultDispatcher-worker-2 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@13b19077 for http://localhost:44417/api/school/respect/person
2025-12-22 09:49:38.766 [DefaultDispatcher-worker-2 @coroutine#128] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44417/api/school/respect/person
2025-12-22 09:49:38.766 [DefaultDispatcher-worker-2 @coroutine#128] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:44417/api/school/respect/person from class io.ktor.http.content.TextContent
2025-12-22 09:49:38.770 [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-22 09:49:38.777 [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-22 09:49:38.826 [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-22 09:49:38.831 [DefaultDispatcher-worker-5 @coroutine#128] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44417/api/school/respect/person
2025-12-22 09:49:38.831 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44417/api/school/respect/person
2025-12-22 09:49:38.831 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44417/api/school/respect/person
2025-12-22 09:49:40.917 [Test worker @coroutine#143] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 09:49:40.918 [Test worker @coroutine#143] INFO  io.ktor.server.Application - Application started in 0.048 seconds.
2025-12-22 09:49:40.919 [DefaultDispatcher-worker-5 @coroutine#149] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:37193
2025-12-22 09:49:40.962 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37193/api/school/respect/person?includeRelated=false
2025-12-22 09:49:40.962 [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:37193/api/school/respect/person?includeRelated=false.
2025-12-22 09:49:40.962 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37193/api/school/respect/person?includeRelated=false
2025-12-22 09:49:40.965 [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-22 09:49:40.972 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37193/api/school/respect/person?includeRelated=false
2025-12-22 09:49:40.973 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37193/api/school/respect/person?includeRelated=false
2025-12-22 09:49:40.979 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37193/api/school/respect/person?includeRelated=false
2025-12-22 09:49:40.979 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:37193/api/school/respect/person?includeRelated=false.
2025-12-22 09:49:43.019 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37193/api/school/respect/person?includeRelated=false
2025-12-22 09:49:43.019 [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:37193/api/school/respect/person?includeRelated=false.
2025-12-22 09:49:43.019 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37193/api/school/respect/person?includeRelated=false
2025-12-22 09:49:43.021 [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-22 09:49:43.023 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37193/api/school/respect/person?includeRelated=false
2025-12-22 09:49:43.023 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37193/api/school/respect/person?includeRelated=false
2025-12-22 09:49:43.023 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37193/api/school/respect/person?includeRelated=false
2025-12-22 09:49:43.024 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:37193/api/school/respect/person?includeRelated=false.
2025-12-22 09:49:45.094 [Test worker @coroutine#167] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 09:49:45.095 [Test worker @coroutine#167] INFO  io.ktor.server.Application - Application started in 0.057 seconds.
2025-12-22 09:49:45.096 [DefaultDispatcher-worker-5 @coroutine#173] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:38537
2025-12-22 09:49:45.126 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38537/api/school/respect/person?includeRelated=false
2025-12-22 09:49:45.126 [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:38537/api/school/respect/person?includeRelated=false.
2025-12-22 09:49:45.126 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38537/api/school/respect/person?includeRelated=false
2025-12-22 09:49:45.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-22 09:49:45.132 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38537/api/school/respect/person?includeRelated=false
2025-12-22 09:49:45.132 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38537/api/school/respect/person?includeRelated=false
2025-12-22 09:49:45.132 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38537/api/school/respect/person?includeRelated=false
2025-12-22 09:49:45.132 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:38537/api/school/respect/person?includeRelated=false.
2025-12-22 09:49:45.170 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38537/api/school/respect/person?since=2025-12-22T08%3A49%3A45.129Z&includeRelated=false
2025-12-22 09:49:45.171 [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:38537/api/school/respect/person?since=2025-12-22T08%3A49%3A45.129Z&includeRelated=false.
2025-12-22 09:49:45.171 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38537/api/school/respect/person?since=2025-12-22T08%3A49%3A45.129Z&includeRelated=false
2025-12-22 09:49:45.172 [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-22 09:49:45.175 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38537/api/school/respect/person?since=2025-12-22T08%3A49%3A45.129Z&includeRelated=false
2025-12-22 09:49:45.175 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38537/api/school/respect/person?since=2025-12-22T08%3A49%3A45.129Z&includeRelated=false
2025-12-22 09:49:45.175 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38537/api/school/respect/person?since=2025-12-22T08%3A49%3A45.129Z&includeRelated=false
2025-12-22 09:49:45.175 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:38537/api/school/respect/person?since=2025-12-22T08%3A49%3A45.129Z&includeRelated=false.
2025-12-22 20:10:22.093 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 20:10:22.177 [Test worker] INFO  io.ktor.server.Application - Application started in 0.196 seconds.
2025-12-22 20:10:22.256 [DefaultDispatcher-worker-1 @coroutine#2] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:39991
2025-12-22 20:10:22.566 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39991/resources/index.json
2025-12-22 20:10:22.567 [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:39991/resources/index.json.
2025-12-22 20:10:22.567 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39991/resources/index.json
2025-12-22 20:10:22.712 [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-22 20:10:22.759 [eventLoopGroupProxy-4-1 @call-handler#12] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 52ms
2025-12-22 20:10:22.765 [DefaultDispatcher-worker-2 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39991/resources/index.json
2025-12-22 20:10:22.768 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39991/resources/index.json
2025-12-22 20:10:22.769 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39991/resources/index.json
2025-12-22 20:10:22.794 [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:39991/resources/index.json.
2025-12-22 20:10:22.832 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39991/resources/index.json
2025-12-22 20:10:22.832 [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:39991/resources/index.json.
2025-12-22 20:10:22.832 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39991/resources/index.json
2025-12-22 20:10:22.835 [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-22 20:10:22.836 [eventLoopGroupProxy-4-1 @call-handler#22] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms
2025-12-22 20:10:22.837 [DefaultDispatcher-worker-2 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39991/resources/index.json
2025-12-22 20:10:22.838 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39991/resources/index.json
2025-12-22 20:10:22.838 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39991/resources/index.json
2025-12-22 20:10:24.852 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 20:10:24.852 [Test worker] INFO  io.ktor.server.Application - Application started in 0.0 seconds.
2025-12-22 20:10:24.855 [DefaultDispatcher-worker-1 @coroutine#26] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:38911
2025-12-22 20:10:24.918 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38911/resources/index.json
2025-12-22 20:10:24.918 [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:38911/resources/index.json.
2025-12-22 20:10:24.918 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38911/resources/index.json
2025-12-22 20:10:24.921 [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-22 20:10:24.922 [eventLoopGroupProxy-7-1 @call-handler#35] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 1ms
2025-12-22 20:10:24.923 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38911/resources/index.json
2025-12-22 20:10:24.923 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38911/resources/index.json
2025-12-22 20:10:24.923 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38911/resources/index.json
2025-12-22 20:10:24.924 [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:38911/resources/index.json.
2025-12-22 20:10:24.928 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38911/resources/index.json
2025-12-22 20:10:24.928 [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:38911/resources/index.json.
2025-12-22 20:10:24.928 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38911/resources/index.json
2025-12-22 20:10:24.929 [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-22 20:10:24.930 [eventLoopGroupProxy-7-1 @call-handler#45] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms
2025-12-22 20:10:24.930 [DefaultDispatcher-worker-4 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38911/resources/index.json
2025-12-22 20:10:24.930 [DefaultDispatcher-worker-4 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38911/resources/index.json
2025-12-22 20:10:24.930 [DefaultDispatcher-worker-4 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38911/resources/index.json
2025-12-22 20:10:26.936 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 20:10:26.936 [Test worker] INFO  io.ktor.server.Application - Application started in 0.0 seconds.
2025-12-22 20:10:26.937 [DefaultDispatcher-worker-4 @coroutine#49] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:36275
2025-12-22 20:10:26.940 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36275/resources/lesson001.json
2025-12-22 20:10:26.941 [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:36275/resources/lesson001.json.
2025-12-22 20:10:26.941 [Test worker @coroutine#52] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36275/resources/lesson001.json
2025-12-22 20:10:26.943 [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-22 20:10:26.944 [eventLoopGroupProxy-10-1 @call-handler#56] INFO  io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 1ms
2025-12-22 20:10:26.945 [DefaultDispatcher-worker-4 @coroutine#52] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36275/resources/lesson001.json
2025-12-22 20:10:26.945 [DefaultDispatcher-worker-4 @coroutine#52] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36275/resources/lesson001.json
2025-12-22 20:10:26.945 [DefaultDispatcher-worker-4 @coroutine#52] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36275/resources/lesson001.json
2025-12-22 20:10:26.961 [DefaultDispatcher-worker-4 @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsPublication for http://localhost:36275/resources/lesson001.json.
2025-12-22 20:10:29.436 [Test worker @coroutine#61] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 20:10:29.444 [Test worker @coroutine#61] INFO  io.ktor.server.Application - Application started in 0.459 seconds.
2025-12-22 20:10:29.447 [DefaultDispatcher-worker-4 @coroutine#67] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:34825
2025-12-22 20:10:29.543 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34825/api/school/respect/person?includeRelated=false
2025-12-22 20:10:29.543 [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:34825/api/school/respect/person?includeRelated=false.
2025-12-22 20:10:29.543 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34825/api/school/respect/person?includeRelated=false
2025-12-22 20:10:29.549 [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-22 20:10:29.579 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34825/api/school/respect/person?includeRelated=false
2025-12-22 20:10:29.580 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34825/api/school/respect/person?includeRelated=false
2025-12-22 20:10:29.580 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34825/api/school/respect/person?includeRelated=false
2025-12-22 20:10:29.582 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34825/api/school/respect/person?includeRelated=false.
2025-12-22 20:10:29.641 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34825/api/school/respect/person?includeRelated=false
2025-12-22 20:10:29.642 [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:34825/api/school/respect/person?includeRelated=false.
2025-12-22 20:10:29.642 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34825/api/school/respect/person?includeRelated=false
2025-12-22 20:10:29.644 [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-22 20:10:29.645 [DefaultDispatcher-worker-4 @call-handler#78] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the GET /api/school/respect/person?includeRelated=false request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2025-12-22 20:10:29.646 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34825/api/school/respect/person?includeRelated=false
2025-12-22 20:10:29.646 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34825/api/school/respect/person?includeRelated=false
2025-12-22 20:10:29.646 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34825/api/school/respect/person?includeRelated=false
2025-12-22 20:10:31.718 [Test worker @coroutine#82] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 20:10:31.719 [Test worker @coroutine#82] INFO  io.ktor.server.Application - Application started in 0.062 seconds.
2025-12-22 20:10:31.721 [DefaultDispatcher-worker-4 @coroutine#88] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:43751
2025-12-22 20:10:31.812 [DefaultDispatcher-worker-5 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43751/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-22 20:10:31.812 [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:43751/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2025-12-22 20:10:31.812 [DefaultDispatcher-worker-5 @coroutine#91] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43751/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-22 20:10:31.815 [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-22 20:10:31.818 [DefaultDispatcher-worker-2 @coroutine#91] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43751/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-22 20:10:31.818 [DefaultDispatcher-worker-2 @coroutine#91] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43751/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-22 20:10:31.818 [DefaultDispatcher-worker-2 @coroutine#91] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43751/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2025-12-22 20:10:31.819 [DefaultDispatcher-worker-2 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:43751/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2025-12-22 20:10:33.901 [Test worker @coroutine#102] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 20:10:33.902 [Test worker @coroutine#102] INFO  io.ktor.server.Application - Application started in 0.069 seconds.
2025-12-22 20:10:33.903 [DefaultDispatcher-worker-4 @coroutine#108] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:38827
2025-12-22 20:10:33.943 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38827/api/school/respect/person?includeRelated=false
2025-12-22 20:10:33.943 [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:38827/api/school/respect/person?includeRelated=false.
2025-12-22 20:10:33.943 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38827/api/school/respect/person?includeRelated=false
2025-12-22 20:10:33.946 [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-22 20:10:33.948 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38827/api/school/respect/person?includeRelated=false
2025-12-22 20:10:33.948 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38827/api/school/respect/person?includeRelated=false
2025-12-22 20:10:33.948 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38827/api/school/respect/person?includeRelated=false
2025-12-22 20:10:33.949 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:38827/api/school/respect/person?includeRelated=false.
2025-12-22 20:10:34.001 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38827/api/school/respect/person?since=2025-12-22T19%3A10%3A33.946Z&includeRelated=false
2025-12-22 20:10:34.001 [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:38827/api/school/respect/person?since=2025-12-22T19%3A10%3A33.946Z&includeRelated=false.
2025-12-22 20:10:34.001 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38827/api/school/respect/person?since=2025-12-22T19%3A10%3A33.946Z&includeRelated=false
2025-12-22 20:10:34.003 [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-22 20:10:34.005 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38827/api/school/respect/person?since=2025-12-22T19%3A10%3A33.946Z&includeRelated=false
2025-12-22 20:10:34.005 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38827/api/school/respect/person?since=2025-12-22T19%3A10%3A33.946Z&includeRelated=false
2025-12-22 20:10:34.005 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38827/api/school/respect/person?since=2025-12-22T19%3A10%3A33.946Z&includeRelated=false
2025-12-22 20:10:34.006 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:38827/api/school/respect/person?since=2025-12-22T19%3A10%3A33.946Z&includeRelated=false.
2025-12-22 20:10:36.089 [Test worker @coroutine#124] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 20:10:36.090 [Test worker @coroutine#124] INFO  io.ktor.server.Application - Application started in 0.074 seconds.
2025-12-22 20:10:36.091 [DefaultDispatcher-worker-5 @coroutine#130] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:39719
2025-12-22 20:10:36.135 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39719/api/school/respect/person
2025-12-22 20:10:36.136 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@5b65eb82 for http://localhost:39719/api/school/respect/person
2025-12-22 20:10:36.136 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39719/api/school/respect/person
2025-12-22 20:10:36.136 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:39719/api/school/respect/person from class io.ktor.http.content.TextContent
2025-12-22 20:10:36.139 [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-22 20:10:36.145 [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-22 20:10:36.193 [DefaultDispatcher-worker-4 @call-handler#138] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the POST /api/school/respect/person request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2025-12-22 20:10:36.194 [DefaultDispatcher-worker-5 @coroutine#128] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39719/api/school/respect/person
2025-12-22 20:10:36.194 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39719/api/school/respect/person
2025-12-22 20:10:36.194 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39719/api/school/respect/person
2025-12-22 20:10:38.263 [Test worker @coroutine#143] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 20:10:38.264 [Test worker @coroutine#143] INFO  io.ktor.server.Application - Application started in 0.061 seconds.
2025-12-22 20:10:38.265 [DefaultDispatcher-worker-2 @coroutine#149] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:32995
2025-12-22 20:10:38.316 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:32995/api/school/respect/person?includeRelated=false
2025-12-22 20:10:38.316 [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:32995/api/school/respect/person?includeRelated=false.
2025-12-22 20:10:38.316 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:32995/api/school/respect/person?includeRelated=false
2025-12-22 20:10:38.319 [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-22 20:10:38.322 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:32995/api/school/respect/person?includeRelated=false
2025-12-22 20:10:38.322 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:32995/api/school/respect/person?includeRelated=false
2025-12-22 20:10:38.322 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:32995/api/school/respect/person?includeRelated=false
2025-12-22 20:10:38.322 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:32995/api/school/respect/person?includeRelated=false.
2025-12-22 20:10:40.366 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:32995/api/school/respect/person?includeRelated=false
2025-12-22 20:10:40.366 [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:32995/api/school/respect/person?includeRelated=false.
2025-12-22 20:10:40.366 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:32995/api/school/respect/person?includeRelated=false
2025-12-22 20:10:40.368 [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-22 20:10:40.370 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:32995/api/school/respect/person?includeRelated=false
2025-12-22 20:10:40.370 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:32995/api/school/respect/person?includeRelated=false
2025-12-22 20:10:40.370 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:32995/api/school/respect/person?includeRelated=false
2025-12-22 20:10:40.371 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:32995/api/school/respect/person?includeRelated=false.
2025-12-22 20:10:42.443 [Test worker @coroutine#167] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2025-12-22 20:10:42.443 [Test worker @coroutine#167] INFO  io.ktor.server.Application - Application started in 0.06 seconds.
2025-12-22 20:10:42.444 [DefaultDispatcher-worker-5 @coroutine#173] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:34637
2025-12-22 20:10:42.484 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34637/api/school/respect/person?includeRelated=false
2025-12-22 20:10:42.485 [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:34637/api/school/respect/person?includeRelated=false.
2025-12-22 20:10:42.485 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34637/api/school/respect/person?includeRelated=false
2025-12-22 20:10:42.487 [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-22 20:10:42.490 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34637/api/school/respect/person?includeRelated=false
2025-12-22 20:10:42.490 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34637/api/school/respect/person?includeRelated=false
2025-12-22 20:10:42.490 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34637/api/school/respect/person?includeRelated=false
2025-12-22 20:10:42.490 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34637/api/school/respect/person?includeRelated=false.
2025-12-22 20:10:42.541 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34637/api/school/respect/person?since=2025-12-22T19%3A10%3A42.487Z&includeRelated=false
2025-12-22 20:10:42.541 [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:34637/api/school/respect/person?since=2025-12-22T19%3A10%3A42.487Z&includeRelated=false.
2025-12-22 20:10:42.541 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34637/api/school/respect/person?since=2025-12-22T19%3A10%3A42.487Z&includeRelated=false
2025-12-22 20:10:42.542 [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-22 20:10:42.545 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34637/api/school/respect/person?since=2025-12-22T19%3A10%3A42.487Z&includeRelated=false
2025-12-22 20:10:42.545 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34637/api/school/respect/person?since=2025-12-22T19%3A10%3A42.487Z&includeRelated=false
2025-12-22 20:10:42.545 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34637/api/school/respect/person?since=2025-12-22T19%3A10%3A42.487Z&includeRelated=false
2025-12-22 20:10:42.546 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34637/api/school/respect/person?since=2025-12-22T19%3A10%3A42.487Z&includeRelated=false.