2026-05-15 11:17:37.107 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 11:17:37.252 [Test worker] INFO  io.ktor.server.Application - Application started in 0.335 seconds.
2026-05-15 11:17:37.387 [DefaultDispatcher-worker-1 @coroutine#2] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:42891
2026-05-15 11:17:38.770 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42891/resources/index.json
2026-05-15 11:17:38.778 [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:42891/resources/index.json.
2026-05-15 11:17:38.779 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42891/resources/index.json
2026-05-15 11:17:38.997 [eventLoopGroupProxy-4-1 @call-handler#12] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2026-05-15 11:17:39.075 [DefaultDispatcher-worker-1 @call-handler#12] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 85ms
2026-05-15 11:17:39.085 [DefaultDispatcher-worker-4 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42891/resources/index.json
2026-05-15 11:17:39.088 [DefaultDispatcher-worker-4 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42891/resources/index.json
2026-05-15 11:17:39.088 [DefaultDispatcher-worker-4 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42891/resources/index.json
2026-05-15 11:17:39.116 [DefaultDispatcher-worker-4 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsFeed for http://localhost:42891/resources/index.json.
2026-05-15 11:17:39.160 [DefaultDispatcher-worker-4 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42891/resources/index.json
2026-05-15 11:17:39.161 [DefaultDispatcher-worker-4 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:42891/resources/index.json.
2026-05-15 11:17:39.161 [DefaultDispatcher-worker-4 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42891/resources/index.json
2026-05-15 11:17:39.164 [eventLoopGroupProxy-4-1 @call-handler#22] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2026-05-15 11:17:39.167 [eventLoopGroupProxy-4-1 @call-handler#22] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 4ms
2026-05-15 11:17:39.168 [DefaultDispatcher-worker-1 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42891/resources/index.json
2026-05-15 11:17:39.169 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42891/resources/index.json
2026-05-15 11:17:39.169 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42891/resources/index.json
2026-05-15 11:17:41.194 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 11:17:41.194 [Test worker] INFO  io.ktor.server.Application - Application started in 0.0 seconds.
2026-05-15 11:17:41.196 [DefaultDispatcher-worker-1 @coroutine#26] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:46611
2026-05-15 11:17:41.253 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46611/resources/index.json
2026-05-15 11:17:41.253 [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:46611/resources/index.json.
2026-05-15 11:17:41.253 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46611/resources/index.json
2026-05-15 11:17:41.257 [eventLoopGroupProxy-7-1 @call-handler#35] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2026-05-15 11:17:41.258 [DefaultDispatcher-worker-6 @call-handler#35] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 1ms
2026-05-15 11:17:41.259 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46611/resources/index.json
2026-05-15 11:17:41.259 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46611/resources/index.json
2026-05-15 11:17:41.260 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46611/resources/index.json
2026-05-15 11:17:41.260 [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:46611/resources/index.json.
2026-05-15 11:17:41.268 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46611/resources/index.json
2026-05-15 11:17:41.268 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:46611/resources/index.json.
2026-05-15 11:17:41.268 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46611/resources/index.json
2026-05-15 11:17:41.271 [eventLoopGroupProxy-7-1 @call-handler#45] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2026-05-15 11:17:41.272 [eventLoopGroupProxy-7-1 @call-handler#45] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 2ms
2026-05-15 11:17:41.272 [DefaultDispatcher-worker-6 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46611/resources/index.json
2026-05-15 11:17:41.273 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46611/resources/index.json
2026-05-15 11:17:41.273 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46611/resources/index.json
2026-05-15 11:17:43.290 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 11:17:43.291 [Test worker] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2026-05-15 11:17:43.297 [DefaultDispatcher-worker-6 @coroutine#49] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:46285
2026-05-15 11:17:43.308 [Test worker @coroutine#55] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46285/resources/lesson001.json
2026-05-15 11:17:43.308 [Test worker @coroutine#55] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:46285/resources/lesson001.json.
2026-05-15 11:17:43.308 [Test worker @coroutine#55] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46285/resources/lesson001.json
2026-05-15 11:17:43.313 [eventLoopGroupProxy-10-1 @call-handler#59] TRACE io.ktor.server.routing.Routing - Trace for [resources, lesson001.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[lesson001.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[lesson001.json]] @ /(staticContent)/resources/{...}/(method:GET)
2026-05-15 11:17:43.315 [DefaultDispatcher-worker-2 @call-handler#59] INFO  io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 2ms
2026-05-15 11:17:43.320 [DefaultDispatcher-worker-6 @coroutine#55] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46285/resources/lesson001.json
2026-05-15 11:17:43.321 [DefaultDispatcher-worker-6 @coroutine#55] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46285/resources/lesson001.json
2026-05-15 11:17:43.321 [DefaultDispatcher-worker-6 @coroutine#55] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46285/resources/lesson001.json
2026-05-15 11:17:43.326 [DefaultDispatcher-worker-6 @coroutine#55] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class kotlinx.serialization.json.JsonObject for http://localhost:46285/resources/lesson001.json.
2026-05-15 11:17:45.612 [Test worker @coroutine#65] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 11:17:45.620 [Test worker @coroutine#65] INFO  io.ktor.server.Application - Application started in 0.129 seconds.
2026-05-15 11:17:45.623 [DefaultDispatcher-worker-13 @coroutine#74] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:43497
2026-05-15 11:17:45.639 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43497/api/school/respect/schoolpermissiongrant
2026-05-15 11:17:45.639 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:43497/api/school/respect/schoolpermissiongrant.
2026-05-15 11:17:45.639 [Test worker @coroutine#65] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43497/api/school/respect/schoolpermissiongrant
2026-05-15 11:17:45.646 [eventLoopGroupProxy-13-1 @call-handler#78] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, schoolpermissiongrant]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/person
        /api/school/respect/schoolpermissiongrant, segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant
          /api/school/respect/schoolpermissiongrant/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "schoolpermissiongrant" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
2026-05-15 11:17:45.662 [Test worker @coroutine#65] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43497/api/school/respect/schoolpermissiongrant
2026-05-15 11:17:45.662 [Test worker @coroutine#65] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43497/api/school/respect/schoolpermissiongrant
2026-05-15 11:17:45.662 [Test worker @coroutine#65] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43497/api/school/respect/schoolpermissiongrant
2026-05-15 11:17:45.664 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:43497/api/school/respect/schoolpermissiongrant.
2026-05-15 11:17:45.785 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43497/api/school/respect/person?includeRelated=false
2026-05-15 11:17:45.786 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:43497/api/school/respect/person?includeRelated=false.
2026-05-15 11:17:45.786 [Test worker @coroutine#65] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43497/api/school/respect/person?includeRelated=false
2026-05-15 11:17:45.792 [eventLoopGroupProxy-13-1 @call-handler#84] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
        /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 11:17:45.858 [Test worker @coroutine#65] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43497/api/school/respect/person?includeRelated=false
2026-05-15 11:17:45.858 [Test worker @coroutine#65] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43497/api/school/respect/person?includeRelated=false
2026-05-15 11:17:45.858 [Test worker @coroutine#65] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43497/api/school/respect/person?includeRelated=false
2026-05-15 11:17:45.862 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:43497/api/school/respect/person?includeRelated=false.
2026-05-15 11:17:45.876 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43497/api/school/respect/person?includeRelated=false
2026-05-15 11:17:45.877 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:43497/api/school/respect/person?includeRelated=false.
2026-05-15 11:17:45.877 [Test worker @coroutine#65] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43497/api/school/respect/person?includeRelated=false
2026-05-15 11:17:45.882 [eventLoopGroupProxy-13-1 @call-handler#90] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
        /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 11:17:45.888 [DefaultDispatcher-worker-13 @call-handler#90] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the GET /api/school/respect/person?includeRelated=false request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-05-15 11:17:45.893 [Test worker @coroutine#65] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43497/api/school/respect/person?includeRelated=false
2026-05-15 11:17:45.894 [Test worker @coroutine#65] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43497/api/school/respect/person?includeRelated=false
2026-05-15 11:17:45.894 [Test worker @coroutine#65] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43497/api/school/respect/person?includeRelated=false
2026-05-15 11:17:48.099 [Test worker @coroutine#94] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 11:17:48.100 [Test worker @coroutine#94] INFO  io.ktor.server.Application - Application started in 0.06 seconds.
2026-05-15 11:17:48.103 [DefaultDispatcher-worker-1 @coroutine#103] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:46383
2026-05-15 11:17:48.109 [Test worker @coroutine#94] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46383/api/school/respect/schoolpermissiongrant
2026-05-15 11:17:48.109 [Test worker @coroutine#94] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:46383/api/school/respect/schoolpermissiongrant.
2026-05-15 11:17:48.109 [Test worker @coroutine#94] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46383/api/school/respect/schoolpermissiongrant
2026-05-15 11:17:48.123 [eventLoopGroupProxy-16-1 @call-handler#107] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, schoolpermissiongrant]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/person
        /api/school/respect/schoolpermissiongrant, segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant
          /api/school/respect/schoolpermissiongrant/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "schoolpermissiongrant" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
2026-05-15 11:17:48.127 [Test worker @coroutine#94] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46383/api/school/respect/schoolpermissiongrant
2026-05-15 11:17:48.128 [Test worker @coroutine#94] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46383/api/school/respect/schoolpermissiongrant
2026-05-15 11:17:48.128 [Test worker @coroutine#94] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46383/api/school/respect/schoolpermissiongrant
2026-05-15 11:17:48.128 [Test worker @coroutine#94] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:46383/api/school/respect/schoolpermissiongrant.
2026-05-15 11:17:48.191 [DefaultDispatcher-worker-12 @coroutine#113] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46383/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 11:17:48.192 [DefaultDispatcher-worker-12 @coroutine#113] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:46383/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2026-05-15 11:17:48.193 [DefaultDispatcher-worker-12 @coroutine#113] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46383/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 11:17:48.195 [eventLoopGroupProxy-16-1 @call-handler#117] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
        /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 11:17:48.200 [DefaultDispatcher-worker-3 @coroutine#113] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46383/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 11:17:48.200 [DefaultDispatcher-worker-3 @coroutine#113] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46383/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 11:17:48.200 [DefaultDispatcher-worker-3 @coroutine#113] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46383/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 11:17:48.202 [DefaultDispatcher-worker-3 @coroutine#113] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:46383/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2026-05-15 11:17:50.434 [Test worker @coroutine#122] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 11:17:50.435 [Test worker @coroutine#122] INFO  io.ktor.server.Application - Application started in 0.084 seconds.
2026-05-15 11:17:50.436 [DefaultDispatcher-worker-12 @coroutine#131] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:45325
2026-05-15 11:17:50.439 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45325/api/school/respect/person?includeRelated=false
2026-05-15 11:17:50.439 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45325/api/school/respect/person?includeRelated=false.
2026-05-15 11:17:50.439 [Test worker @coroutine#122] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45325/api/school/respect/person?includeRelated=false
2026-05-15 11:17:50.441 [eventLoopGroupProxy-19-1 @call-handler#136] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 11:17:50.445 [Test worker @coroutine#122] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45325/api/school/respect/person?includeRelated=false
2026-05-15 11:17:50.445 [Test worker @coroutine#122] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45325/api/school/respect/person?includeRelated=false
2026-05-15 11:17:50.445 [Test worker @coroutine#122] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45325/api/school/respect/person?includeRelated=false
2026-05-15 11:17:50.446 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:45325/api/school/respect/person?includeRelated=false.
2026-05-15 11:17:50.504 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45325/api/school/respect/person?since=2026-05-15T07%3A17%3A50.442258109Z&includeRelated=false
2026-05-15 11:17:50.505 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45325/api/school/respect/person?since=2026-05-15T07%3A17%3A50.442258109Z&includeRelated=false.
2026-05-15 11:17:50.505 [Test worker @coroutine#122] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45325/api/school/respect/person?since=2026-05-15T07%3A17%3A50.442258109Z&includeRelated=false
2026-05-15 11:17:50.506 [eventLoopGroupProxy-19-1 @call-handler#142] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 11:17:50.509 [Test worker @coroutine#122] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45325/api/school/respect/person?since=2026-05-15T07%3A17%3A50.442258109Z&includeRelated=false
2026-05-15 11:17:50.509 [Test worker @coroutine#122] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45325/api/school/respect/person?since=2026-05-15T07%3A17%3A50.442258109Z&includeRelated=false
2026-05-15 11:17:50.509 [Test worker @coroutine#122] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45325/api/school/respect/person?since=2026-05-15T07%3A17%3A50.442258109Z&includeRelated=false
2026-05-15 11:17:50.510 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:45325/api/school/respect/person?since=2026-05-15T07%3A17%3A50.442258109Z&includeRelated=false.
2026-05-15 11:17:52.709 [Test worker @coroutine#148] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 11:17:52.713 [Test worker @coroutine#148] INFO  io.ktor.server.Application - Application started in 0.048 seconds.
2026-05-15 11:17:52.726 [DefaultDispatcher-worker-12 @coroutine#157] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:41101
2026-05-15 11:17:52.794 [DefaultDispatcher-worker-13 @coroutine#155] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41101/api/school/respect/person
2026-05-15 11:17:52.794 [DefaultDispatcher-worker-13 @coroutine#155] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@a524cd for http://localhost:41101/api/school/respect/person
2026-05-15 11:17:52.794 [DefaultDispatcher-worker-13 @coroutine#155] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41101/api/school/respect/person
2026-05-15 11:17:52.795 [DefaultDispatcher-worker-13 @coroutine#155] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:41101/api/school/respect/person from class io.ktor.http.content.TextContent
2026-05-15 11:17:52.822 [eventLoopGroupProxy-22-1 @call-handler#167] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> SUCCESS @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:POST)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:POST)
2026-05-15 11:17:52.839 [eventLoopGroupProxy-22-1 @call-handler#167] 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
2026-05-15 11:17:52.842 [eventLoopGroupProxy-22-1 @call-handler#167] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the POST /api/school/respect/person request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-05-15 11:17:52.848 [DefaultDispatcher-worker-6 @coroutine#155] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41101/api/school/respect/person
2026-05-15 11:17:52.848 [DefaultDispatcher-worker-6 @coroutine#155] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41101/api/school/respect/person
2026-05-15 11:17:52.848 [DefaultDispatcher-worker-6 @coroutine#155] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41101/api/school/respect/person
2026-05-15 11:17:55.051 [Test worker @coroutine#172] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 11:17:55.062 [Test worker @coroutine#172] INFO  io.ktor.server.Application - Application started in 0.064 seconds.
2026-05-15 11:17:55.070 [DefaultDispatcher-worker-1 @coroutine#181] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:42863
2026-05-15 11:17:55.072 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42863/api/school/respect/schoolpermissiongrant
2026-05-15 11:17:55.073 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:42863/api/school/respect/schoolpermissiongrant.
2026-05-15 11:17:55.073 [Test worker @coroutine#172] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42863/api/school/respect/schoolpermissiongrant
2026-05-15 11:17:55.097 [eventLoopGroupProxy-25-1 @call-handler#185] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, schoolpermissiongrant]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/person
        /api/school/respect/schoolpermissiongrant, segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant
          /api/school/respect/schoolpermissiongrant/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "schoolpermissiongrant" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
2026-05-15 11:17:55.106 [Test worker @coroutine#172] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42863/api/school/respect/schoolpermissiongrant
2026-05-15 11:17:55.106 [Test worker @coroutine#172] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42863/api/school/respect/schoolpermissiongrant
2026-05-15 11:17:55.106 [Test worker @coroutine#172] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42863/api/school/respect/schoolpermissiongrant
2026-05-15 11:17:55.109 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:42863/api/school/respect/schoolpermissiongrant.
2026-05-15 11:17:55.183 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42863/api/school/respect/person?includeRelated=false
2026-05-15 11:17:55.183 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:42863/api/school/respect/person?includeRelated=false.
2026-05-15 11:17:55.183 [Test worker @coroutine#172] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42863/api/school/respect/person?includeRelated=false
2026-05-15 11:17:55.191 [eventLoopGroupProxy-25-1 @call-handler#191] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
        /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 11:17:55.212 [Test worker @coroutine#172] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42863/api/school/respect/person?includeRelated=false
2026-05-15 11:17:55.213 [Test worker @coroutine#172] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42863/api/school/respect/person?includeRelated=false
2026-05-15 11:17:55.213 [Test worker @coroutine#172] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42863/api/school/respect/person?includeRelated=false
2026-05-15 11:17:55.214 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:42863/api/school/respect/person?includeRelated=false.
2026-05-15 11:17:57.228 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42863/api/school/respect/person?includeRelated=false
2026-05-15 11:17:57.229 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:42863/api/school/respect/person?includeRelated=false.
2026-05-15 11:17:57.229 [Test worker @coroutine#172] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42863/api/school/respect/person?includeRelated=false
2026-05-15 11:17:57.232 [eventLoopGroupProxy-25-1 @call-handler#198] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
        /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 11:17:57.238 [Test worker @coroutine#172] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42863/api/school/respect/person?includeRelated=false
2026-05-15 11:17:57.239 [Test worker @coroutine#172] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42863/api/school/respect/person?includeRelated=false
2026-05-15 11:17:57.239 [Test worker @coroutine#172] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42863/api/school/respect/person?includeRelated=false
2026-05-15 11:17:57.250 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:42863/api/school/respect/person?includeRelated=false.
2026-05-15 11:17:59.403 [Test worker @coroutine#204] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 11:17:59.403 [Test worker @coroutine#204] INFO  io.ktor.server.Application - Application started in 0.05 seconds.
2026-05-15 11:17:59.405 [DefaultDispatcher-worker-11 @coroutine#213] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:42775
2026-05-15 11:17:59.407 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42775/api/school/respect/person?includeRelated=false
2026-05-15 11:17:59.407 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:42775/api/school/respect/person?includeRelated=false.
2026-05-15 11:17:59.407 [Test worker @coroutine#204] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42775/api/school/respect/person?includeRelated=false
2026-05-15 11:17:59.410 [eventLoopGroupProxy-28-1 @call-handler#218] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 11:17:59.413 [Test worker @coroutine#204] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42775/api/school/respect/person?includeRelated=false
2026-05-15 11:17:59.413 [Test worker @coroutine#204] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42775/api/school/respect/person?includeRelated=false
2026-05-15 11:17:59.413 [Test worker @coroutine#204] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42775/api/school/respect/person?includeRelated=false
2026-05-15 11:17:59.414 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:42775/api/school/respect/person?includeRelated=false.
2026-05-15 11:17:59.460 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42775/api/school/respect/person?since=2026-05-15T07%3A17%3A59.410450390Z&includeRelated=false
2026-05-15 11:17:59.460 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:42775/api/school/respect/person?since=2026-05-15T07%3A17%3A59.410450390Z&includeRelated=false.
2026-05-15 11:17:59.460 [Test worker @coroutine#204] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42775/api/school/respect/person?since=2026-05-15T07%3A17%3A59.410450390Z&includeRelated=false
2026-05-15 11:17:59.461 [eventLoopGroupProxy-28-1 @call-handler#225] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 11:17:59.464 [Test worker @coroutine#204] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42775/api/school/respect/person?since=2026-05-15T07%3A17%3A59.410450390Z&includeRelated=false
2026-05-15 11:17:59.464 [Test worker @coroutine#204] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42775/api/school/respect/person?since=2026-05-15T07%3A17%3A59.410450390Z&includeRelated=false
2026-05-15 11:17:59.464 [Test worker @coroutine#204] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42775/api/school/respect/person?since=2026-05-15T07%3A17%3A59.410450390Z&includeRelated=false
2026-05-15 11:17:59.465 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:42775/api/school/respect/person?since=2026-05-15T07%3A17%3A59.410450390Z&includeRelated=false.
2026-05-15 11:18:01.729 [Test worker @coroutine#231] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 11:18:01.730 [Test worker @coroutine#231] INFO  io.ktor.server.Application - Application started in 0.085 seconds.
2026-05-15 11:18:01.731 [DefaultDispatcher-worker-1 @coroutine#241] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:38099
2026-05-15 11:18:01.733 [Test worker @coroutine#231] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38099/playlist/aebf9ccc-e635-4724-9bac-a11d2d68ee9d
2026-05-15 11:18:01.733 [Test worker @coroutine#231] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:38099/playlist/aebf9ccc-e635-4724-9bac-a11d2d68ee9d.
2026-05-15 11:18:01.733 [Test worker @coroutine#231] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38099/playlist/aebf9ccc-e635-4724-9bac-a11d2d68ee9d
2026-05-15 11:18:01.736 [eventLoopGroupProxy-31-1 @call-handler#245] TRACE io.ktor.server.routing.Routing - Trace for [playlist, aebf9ccc-e635-4724-9bac-a11d2d68ee9d]
/, segment:0 -> SUCCESS @ /
  /playlist, segment:1 -> SUCCESS @ /playlist
    /playlist/{uuid}, segment:2 -> SUCCESS; Parameters [uuid=[aebf9ccc-e635-4724-9bac-a11d2d68ee9d]] @ /playlist/{uuid}
      /playlist/{uuid}/(method:GET), segment:2 -> SUCCESS @ /playlist/{uuid}/(method:GET)
      /playlist/{uuid}/(method:POST), segment:2 -> FAILURE "Selector didn't match" @ /playlist/{uuid}/(method:POST)
Matched routes:
  "" -> "playlist" -> "{uuid}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [uuid=[aebf9ccc-e635-4724-9bac-a11d2d68ee9d]] @ /playlist/{uuid}/(method:GET)
2026-05-15 11:18:01.742 [Test worker @coroutine#231] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38099/playlist/aebf9ccc-e635-4724-9bac-a11d2d68ee9d
2026-05-15 11:18:01.742 [Test worker @coroutine#231] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38099/playlist/aebf9ccc-e635-4724-9bac-a11d2d68ee9d
2026-05-15 11:18:01.742 [Test worker @coroutine#231] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38099/playlist/aebf9ccc-e635-4724-9bac-a11d2d68ee9d
2026-05-15 11:18:01.743 [Test worker @coroutine#231] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsFeed for http://localhost:38099/playlist/aebf9ccc-e635-4724-9bac-a11d2d68ee9d.
2026-05-15 11:18:03.897 [Test worker @coroutine#249] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 11:18:03.898 [Test worker @coroutine#249] INFO  io.ktor.server.Application - Application started in 0.049 seconds.
2026-05-15 11:18:03.899 [DefaultDispatcher-worker-1 @coroutine#258] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:41485
2026-05-15 11:18:03.938 [DefaultDispatcher-worker-1 @coroutine#256] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41485/playlist/85b6e0c4-da83-4875-8803-9ee8136585b1
2026-05-15 11:18:03.939 [DefaultDispatcher-worker-1 @coroutine#256] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@2c227105 for http://localhost:41485/playlist/85b6e0c4-da83-4875-8803-9ee8136585b1
2026-05-15 11:18:03.939 [DefaultDispatcher-worker-1 @coroutine#256] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41485/playlist/85b6e0c4-da83-4875-8803-9ee8136585b1
2026-05-15 11:18:03.939 [DefaultDispatcher-worker-1 @coroutine#256] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:41485/playlist/85b6e0c4-da83-4875-8803-9ee8136585b1 from class io.ktor.http.content.TextContent
2026-05-15 11:18:03.941 [eventLoopGroupProxy-34-1 @call-handler#266] TRACE io.ktor.server.routing.Routing - Trace for [playlist, 85b6e0c4-da83-4875-8803-9ee8136585b1]
/, segment:0 -> SUCCESS @ /
  /playlist, segment:1 -> SUCCESS @ /playlist
    /playlist/{uuid}, segment:2 -> SUCCESS; Parameters [uuid=[85b6e0c4-da83-4875-8803-9ee8136585b1]] @ /playlist/{uuid}
      /playlist/{uuid}/(method:GET), segment:2 -> FAILURE "Selector didn't match" @ /playlist/{uuid}/(method:GET)
      /playlist/{uuid}/(method:POST), segment:2 -> SUCCESS @ /playlist/{uuid}/(method:POST)
Matched routes:
  "" -> "playlist" -> "{uuid}" -> "(method:POST)"
Routing resolve result:
  SUCCESS; Parameters [uuid=[85b6e0c4-da83-4875-8803-9ee8136585b1]] @ /playlist/{uuid}/(method:POST)
2026-05-15 11:18:03.941 [eventLoopGroupProxy-34-1 @call-handler#266] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(world.respect.lib.opds.model.OpdsFeed) for call /playlist/85b6e0c4-da83-4875-8803-9ee8136585b1
2026-05-15 11:18:03.942 [DefaultDispatcher-worker-1 @call-handler#266] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the POST /playlist/85b6e0c4-da83-4875-8803-9ee8136585b1 request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-05-15 11:18:03.943 [DefaultDispatcher-worker-13 @coroutine#256] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41485/playlist/85b6e0c4-da83-4875-8803-9ee8136585b1
2026-05-15 11:18:03.943 [DefaultDispatcher-worker-13 @coroutine#256] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41485/playlist/85b6e0c4-da83-4875-8803-9ee8136585b1
2026-05-15 11:18:03.943 [DefaultDispatcher-worker-13 @coroutine#256] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41485/playlist/85b6e0c4-da83-4875-8803-9ee8136585b1
2026-05-15 14:29:31.373 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 14:29:31.472 [Test worker] INFO  io.ktor.server.Application - Application started in 0.246 seconds.
2026-05-15 14:29:31.563 [DefaultDispatcher-worker-1 @coroutine#2] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:38915
2026-05-15 14:29:32.306 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38915/resources/index.json
2026-05-15 14:29:32.306 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:38915/resources/index.json.
2026-05-15 14:29:32.306 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38915/resources/index.json
2026-05-15 14:29:32.445 [eventLoopGroupProxy-4-1 @call-handler#12] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2026-05-15 14:29:32.507 [eventLoopGroupProxy-4-1 @call-handler#12] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 68ms
2026-05-15 14:29:32.515 [DefaultDispatcher-worker-2 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38915/resources/index.json
2026-05-15 14:29:32.518 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38915/resources/index.json
2026-05-15 14:29:32.518 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38915/resources/index.json
2026-05-15 14:29:32.545 [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:38915/resources/index.json.
2026-05-15 14:29:32.579 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38915/resources/index.json
2026-05-15 14:29:32.579 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:38915/resources/index.json.
2026-05-15 14:29:32.579 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38915/resources/index.json
2026-05-15 14:29:32.583 [eventLoopGroupProxy-4-1 @call-handler#22] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2026-05-15 14:29:32.585 [eventLoopGroupProxy-4-1 @call-handler#22] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 2ms
2026-05-15 14:29:32.586 [DefaultDispatcher-worker-4 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38915/resources/index.json
2026-05-15 14:29:32.587 [DefaultDispatcher-worker-4 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38915/resources/index.json
2026-05-15 14:29:32.587 [DefaultDispatcher-worker-4 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38915/resources/index.json
2026-05-15 14:29:34.604 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 14:29:34.604 [Test worker] INFO  io.ktor.server.Application - Application started in 0.0 seconds.
2026-05-15 14:29:34.605 [DefaultDispatcher-worker-4 @coroutine#26] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:38011
2026-05-15 14:29:34.670 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38011/resources/index.json
2026-05-15 14:29:34.670 [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:38011/resources/index.json.
2026-05-15 14:29:34.670 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38011/resources/index.json
2026-05-15 14:29:34.673 [eventLoopGroupProxy-7-1 @call-handler#35] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2026-05-15 14:29:34.674 [DefaultDispatcher-worker-6 @call-handler#35] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 1ms
2026-05-15 14:29:34.675 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38011/resources/index.json
2026-05-15 14:29:34.675 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38011/resources/index.json
2026-05-15 14:29:34.675 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38011/resources/index.json
2026-05-15 14:29:34.675 [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:38011/resources/index.json.
2026-05-15 14:29:34.680 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38011/resources/index.json
2026-05-15 14:29:34.680 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:38011/resources/index.json.
2026-05-15 14:29:34.680 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38011/resources/index.json
2026-05-15 14:29:34.681 [eventLoopGroupProxy-7-1 @call-handler#45] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2026-05-15 14:29:34.682 [eventLoopGroupProxy-7-1 @call-handler#45] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms
2026-05-15 14:29:34.682 [DefaultDispatcher-worker-6 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38011/resources/index.json
2026-05-15 14:29:34.682 [DefaultDispatcher-worker-6 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38011/resources/index.json
2026-05-15 14:29:34.683 [DefaultDispatcher-worker-6 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38011/resources/index.json
2026-05-15 14:29:36.689 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 14:29:36.690 [Test worker] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2026-05-15 14:29:36.691 [DefaultDispatcher-worker-6 @coroutine#49] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:37265
2026-05-15 14:29:36.696 [Test worker @coroutine#55] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37265/resources/lesson001.json
2026-05-15 14:29:36.696 [Test worker @coroutine#55] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:37265/resources/lesson001.json.
2026-05-15 14:29:36.696 [Test worker @coroutine#55] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37265/resources/lesson001.json
2026-05-15 14:29:36.699 [eventLoopGroupProxy-10-1 @call-handler#59] TRACE io.ktor.server.routing.Routing - Trace for [resources, lesson001.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[lesson001.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[lesson001.json]] @ /(staticContent)/resources/{...}/(method:GET)
2026-05-15 14:29:36.700 [eventLoopGroupProxy-10-1 @call-handler#59] INFO  io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 2ms
2026-05-15 14:29:36.701 [DefaultDispatcher-worker-1 @coroutine#55] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37265/resources/lesson001.json
2026-05-15 14:29:36.701 [DefaultDispatcher-worker-4 @coroutine#55] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37265/resources/lesson001.json
2026-05-15 14:29:36.701 [DefaultDispatcher-worker-4 @coroutine#55] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37265/resources/lesson001.json
2026-05-15 14:29:36.703 [DefaultDispatcher-worker-4 @coroutine#55] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class kotlinx.serialization.json.JsonObject for http://localhost:37265/resources/lesson001.json.
2026-05-15 14:29:38.964 [Test worker @coroutine#65] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 14:29:38.971 [Test worker @coroutine#65] INFO  io.ktor.server.Application - Application started in 0.1 seconds.
2026-05-15 14:29:38.973 [DefaultDispatcher-worker-4 @coroutine#74] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:41097
2026-05-15 14:29:38.981 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41097/api/school/respect/schoolpermissiongrant
2026-05-15 14:29:38.981 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41097/api/school/respect/schoolpermissiongrant.
2026-05-15 14:29:38.981 [Test worker @coroutine#65] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41097/api/school/respect/schoolpermissiongrant
2026-05-15 14:29:38.985 [eventLoopGroupProxy-13-1 @call-handler#78] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, schoolpermissiongrant]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/person
        /api/school/respect/schoolpermissiongrant, segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant
          /api/school/respect/schoolpermissiongrant/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "schoolpermissiongrant" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
2026-05-15 14:29:38.998 [Test worker @coroutine#65] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41097/api/school/respect/schoolpermissiongrant
2026-05-15 14:29:38.999 [Test worker @coroutine#65] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41097/api/school/respect/schoolpermissiongrant
2026-05-15 14:29:38.999 [Test worker @coroutine#65] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41097/api/school/respect/schoolpermissiongrant
2026-05-15 14:29:39.000 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41097/api/school/respect/schoolpermissiongrant.
2026-05-15 14:29:39.076 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41097/api/school/respect/person?includeRelated=false
2026-05-15 14:29:39.076 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41097/api/school/respect/person?includeRelated=false.
2026-05-15 14:29:39.076 [Test worker @coroutine#65] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41097/api/school/respect/person?includeRelated=false
2026-05-15 14:29:39.078 [eventLoopGroupProxy-13-1 @call-handler#84] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
        /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 14:29:39.098 [Test worker @coroutine#65] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41097/api/school/respect/person?includeRelated=false
2026-05-15 14:29:39.098 [Test worker @coroutine#65] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41097/api/school/respect/person?includeRelated=false
2026-05-15 14:29:39.098 [Test worker @coroutine#65] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41097/api/school/respect/person?includeRelated=false
2026-05-15 14:29:39.099 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41097/api/school/respect/person?includeRelated=false.
2026-05-15 14:29:39.105 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41097/api/school/respect/person?includeRelated=false
2026-05-15 14:29:39.105 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41097/api/school/respect/person?includeRelated=false.
2026-05-15 14:29:39.105 [Test worker @coroutine#65] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41097/api/school/respect/person?includeRelated=false
2026-05-15 14:29:39.107 [eventLoopGroupProxy-13-1 @call-handler#90] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
        /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 14:29:39.109 [DefaultDispatcher-worker-3 @call-handler#90] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the GET /api/school/respect/person?includeRelated=false request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-05-15 14:29:39.110 [Test worker @coroutine#65] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41097/api/school/respect/person?includeRelated=false
2026-05-15 14:29:39.110 [Test worker @coroutine#65] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41097/api/school/respect/person?includeRelated=false
2026-05-15 14:29:39.110 [Test worker @coroutine#65] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41097/api/school/respect/person?includeRelated=false
2026-05-15 14:29:41.235 [Test worker @coroutine#94] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 14:29:41.236 [Test worker @coroutine#94] INFO  io.ktor.server.Application - Application started in 0.046 seconds.
2026-05-15 14:29:41.237 [DefaultDispatcher-worker-6 @coroutine#103] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:32935
2026-05-15 14:29:41.238 [Test worker @coroutine#94] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:32935/api/school/respect/schoolpermissiongrant
2026-05-15 14:29:41.238 [Test worker @coroutine#94] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:32935/api/school/respect/schoolpermissiongrant.
2026-05-15 14:29:41.238 [Test worker @coroutine#94] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:32935/api/school/respect/schoolpermissiongrant
2026-05-15 14:29:41.240 [eventLoopGroupProxy-16-1 @call-handler#107] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, schoolpermissiongrant]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/person
        /api/school/respect/schoolpermissiongrant, segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant
          /api/school/respect/schoolpermissiongrant/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "schoolpermissiongrant" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
2026-05-15 14:29:41.242 [Test worker @coroutine#94] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:32935/api/school/respect/schoolpermissiongrant
2026-05-15 14:29:41.242 [Test worker @coroutine#94] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:32935/api/school/respect/schoolpermissiongrant
2026-05-15 14:29:41.242 [Test worker @coroutine#94] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:32935/api/school/respect/schoolpermissiongrant
2026-05-15 14:29:41.243 [Test worker @coroutine#94] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:32935/api/school/respect/schoolpermissiongrant.
2026-05-15 14:29:41.298 [DefaultDispatcher-worker-6 @coroutine#113] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:32935/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 14:29:41.298 [DefaultDispatcher-worker-6 @coroutine#113] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:32935/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2026-05-15 14:29:41.298 [DefaultDispatcher-worker-6 @coroutine#113] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:32935/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 14:29:41.300 [eventLoopGroupProxy-16-1 @call-handler#117] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
        /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 14:29:41.303 [DefaultDispatcher-worker-6 @coroutine#113] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:32935/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 14:29:41.303 [DefaultDispatcher-worker-6 @coroutine#113] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:32935/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 14:29:41.303 [DefaultDispatcher-worker-6 @coroutine#113] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:32935/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 14:29:41.304 [DefaultDispatcher-worker-6 @coroutine#113] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:32935/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2026-05-15 14:29:43.404 [Test worker @coroutine#122] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 14:29:43.404 [Test worker @coroutine#122] INFO  io.ktor.server.Application - Application started in 0.039 seconds.
2026-05-15 14:29:43.405 [DefaultDispatcher-worker-4 @coroutine#131] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:38459
2026-05-15 14:29:43.408 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38459/api/school/respect/person?includeRelated=false
2026-05-15 14:29:43.408 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:38459/api/school/respect/person?includeRelated=false.
2026-05-15 14:29:43.408 [Test worker @coroutine#122] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38459/api/school/respect/person?includeRelated=false
2026-05-15 14:29:43.411 [eventLoopGroupProxy-19-1 @call-handler#136] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 14:29:43.414 [Test worker @coroutine#122] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38459/api/school/respect/person?includeRelated=false
2026-05-15 14:29:43.414 [Test worker @coroutine#122] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38459/api/school/respect/person?includeRelated=false
2026-05-15 14:29:43.414 [Test worker @coroutine#122] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38459/api/school/respect/person?includeRelated=false
2026-05-15 14:29:43.415 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:38459/api/school/respect/person?includeRelated=false.
2026-05-15 14:29:43.469 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38459/api/school/respect/person?since=2026-05-15T10%3A29%3A43.411338242Z&includeRelated=false
2026-05-15 14:29:43.469 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:38459/api/school/respect/person?since=2026-05-15T10%3A29%3A43.411338242Z&includeRelated=false.
2026-05-15 14:29:43.469 [Test worker @coroutine#122] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38459/api/school/respect/person?since=2026-05-15T10%3A29%3A43.411338242Z&includeRelated=false
2026-05-15 14:29:43.470 [eventLoopGroupProxy-19-1 @call-handler#142] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 14:29:43.473 [Test worker @coroutine#122] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38459/api/school/respect/person?since=2026-05-15T10%3A29%3A43.411338242Z&includeRelated=false
2026-05-15 14:29:43.473 [Test worker @coroutine#122] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38459/api/school/respect/person?since=2026-05-15T10%3A29%3A43.411338242Z&includeRelated=false
2026-05-15 14:29:43.473 [Test worker @coroutine#122] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38459/api/school/respect/person?since=2026-05-15T10%3A29%3A43.411338242Z&includeRelated=false
2026-05-15 14:29:43.474 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:38459/api/school/respect/person?since=2026-05-15T10%3A29%3A43.411338242Z&includeRelated=false.
2026-05-15 14:29:45.591 [Test worker @coroutine#148] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 14:29:45.592 [Test worker @coroutine#148] INFO  io.ktor.server.Application - Application started in 0.039 seconds.
2026-05-15 14:29:45.593 [DefaultDispatcher-worker-4 @coroutine#157] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:36825
2026-05-15 14:29:45.645 [DefaultDispatcher-worker-3 @coroutine#155] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36825/api/school/respect/person
2026-05-15 14:29:45.645 [DefaultDispatcher-worker-3 @coroutine#155] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@761f03f1 for http://localhost:36825/api/school/respect/person
2026-05-15 14:29:45.645 [DefaultDispatcher-worker-3 @coroutine#155] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36825/api/school/respect/person
2026-05-15 14:29:45.646 [DefaultDispatcher-worker-3 @coroutine#155] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:36825/api/school/respect/person from class io.ktor.http.content.TextContent
2026-05-15 14:29:45.649 [eventLoopGroupProxy-22-1 @call-handler#167] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> SUCCESS @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:POST)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:POST)
2026-05-15 14:29:45.656 [eventLoopGroupProxy-22-1 @call-handler#167] 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
2026-05-15 14:29:45.657 [DefaultDispatcher-worker-6 @call-handler#167] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the POST /api/school/respect/person request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-05-15 14:29:45.658 [DefaultDispatcher-worker-4 @coroutine#155] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36825/api/school/respect/person
2026-05-15 14:29:45.658 [DefaultDispatcher-worker-4 @coroutine#155] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36825/api/school/respect/person
2026-05-15 14:29:45.658 [DefaultDispatcher-worker-4 @coroutine#155] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36825/api/school/respect/person
2026-05-15 14:29:47.777 [Test worker @coroutine#172] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 14:29:47.778 [Test worker @coroutine#172] INFO  io.ktor.server.Application - Application started in 0.045 seconds.
2026-05-15 14:29:47.779 [DefaultDispatcher-worker-1 @coroutine#181] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:45425
2026-05-15 14:29:47.780 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45425/api/school/respect/schoolpermissiongrant
2026-05-15 14:29:47.780 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45425/api/school/respect/schoolpermissiongrant.
2026-05-15 14:29:47.780 [Test worker @coroutine#172] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45425/api/school/respect/schoolpermissiongrant
2026-05-15 14:29:47.782 [eventLoopGroupProxy-25-1 @call-handler#185] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, schoolpermissiongrant]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/person
        /api/school/respect/schoolpermissiongrant, segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant
          /api/school/respect/schoolpermissiongrant/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "schoolpermissiongrant" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
2026-05-15 14:29:47.784 [Test worker @coroutine#172] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45425/api/school/respect/schoolpermissiongrant
2026-05-15 14:29:47.784 [Test worker @coroutine#172] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45425/api/school/respect/schoolpermissiongrant
2026-05-15 14:29:47.784 [Test worker @coroutine#172] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45425/api/school/respect/schoolpermissiongrant
2026-05-15 14:29:47.784 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:45425/api/school/respect/schoolpermissiongrant.
2026-05-15 14:29:47.834 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45425/api/school/respect/person?includeRelated=false
2026-05-15 14:29:47.834 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45425/api/school/respect/person?includeRelated=false.
2026-05-15 14:29:47.834 [Test worker @coroutine#172] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45425/api/school/respect/person?includeRelated=false
2026-05-15 14:29:47.835 [eventLoopGroupProxy-25-1 @call-handler#191] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
        /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 14:29:47.841 [Test worker @coroutine#172] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45425/api/school/respect/person?includeRelated=false
2026-05-15 14:29:47.841 [Test worker @coroutine#172] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45425/api/school/respect/person?includeRelated=false
2026-05-15 14:29:47.841 [Test worker @coroutine#172] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45425/api/school/respect/person?includeRelated=false
2026-05-15 14:29:47.841 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:45425/api/school/respect/person?includeRelated=false.
2026-05-15 14:29:49.846 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45425/api/school/respect/person?includeRelated=false
2026-05-15 14:29:49.847 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45425/api/school/respect/person?includeRelated=false.
2026-05-15 14:29:49.847 [Test worker @coroutine#172] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45425/api/school/respect/person?includeRelated=false
2026-05-15 14:29:49.848 [eventLoopGroupProxy-25-1 @call-handler#198] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
        /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 14:29:49.851 [Test worker @coroutine#172] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45425/api/school/respect/person?includeRelated=false
2026-05-15 14:29:49.851 [Test worker @coroutine#172] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45425/api/school/respect/person?includeRelated=false
2026-05-15 14:29:49.851 [Test worker @coroutine#172] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45425/api/school/respect/person?includeRelated=false
2026-05-15 14:29:49.852 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:45425/api/school/respect/person?includeRelated=false.
2026-05-15 14:29:51.962 [Test worker @coroutine#204] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 14:29:51.963 [Test worker @coroutine#204] INFO  io.ktor.server.Application - Application started in 0.039 seconds.
2026-05-15 14:29:51.964 [DefaultDispatcher-worker-4 @coroutine#213] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:44547
2026-05-15 14:29:51.966 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44547/api/school/respect/person?includeRelated=false
2026-05-15 14:29:51.967 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:44547/api/school/respect/person?includeRelated=false.
2026-05-15 14:29:51.967 [Test worker @coroutine#204] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44547/api/school/respect/person?includeRelated=false
2026-05-15 14:29:51.969 [eventLoopGroupProxy-28-1 @call-handler#218] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 14:29:51.973 [Test worker @coroutine#204] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44547/api/school/respect/person?includeRelated=false
2026-05-15 14:29:51.973 [Test worker @coroutine#204] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44547/api/school/respect/person?includeRelated=false
2026-05-15 14:29:51.973 [Test worker @coroutine#204] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44547/api/school/respect/person?includeRelated=false
2026-05-15 14:29:51.974 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44547/api/school/respect/person?includeRelated=false.
2026-05-15 14:29:52.015 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44547/api/school/respect/person?since=2026-05-15T10%3A29%3A51.969763760Z&includeRelated=false
2026-05-15 14:29:52.015 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:44547/api/school/respect/person?since=2026-05-15T10%3A29%3A51.969763760Z&includeRelated=false.
2026-05-15 14:29:52.015 [Test worker @coroutine#204] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44547/api/school/respect/person?since=2026-05-15T10%3A29%3A51.969763760Z&includeRelated=false
2026-05-15 14:29:52.017 [eventLoopGroupProxy-28-1 @call-handler#225] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 14:29:52.019 [Test worker @coroutine#204] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44547/api/school/respect/person?since=2026-05-15T10%3A29%3A51.969763760Z&includeRelated=false
2026-05-15 14:29:52.019 [Test worker @coroutine#204] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44547/api/school/respect/person?since=2026-05-15T10%3A29%3A51.969763760Z&includeRelated=false
2026-05-15 14:29:52.019 [Test worker @coroutine#204] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44547/api/school/respect/person?since=2026-05-15T10%3A29%3A51.969763760Z&includeRelated=false
2026-05-15 14:29:52.020 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44547/api/school/respect/person?since=2026-05-15T10%3A29%3A51.969763760Z&includeRelated=false.
2026-05-15 14:29:54.140 [Test worker @coroutine#231] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 14:29:54.142 [Test worker @coroutine#231] INFO  io.ktor.server.Application - Application started in 0.044 seconds.
2026-05-15 14:29:54.143 [DefaultDispatcher-worker-3 @coroutine#241] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:33299
2026-05-15 14:29:54.144 [Test worker @coroutine#231] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33299/playlist/160f31d8-91f6-460f-95e0-d34cce68325d
2026-05-15 14:29:54.144 [Test worker @coroutine#231] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:33299/playlist/160f31d8-91f6-460f-95e0-d34cce68325d.
2026-05-15 14:29:54.144 [Test worker @coroutine#231] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33299/playlist/160f31d8-91f6-460f-95e0-d34cce68325d
2026-05-15 14:29:54.147 [eventLoopGroupProxy-31-1 @call-handler#245] TRACE io.ktor.server.routing.Routing - Trace for [playlist, 160f31d8-91f6-460f-95e0-d34cce68325d]
/, segment:0 -> SUCCESS @ /
  /playlist, segment:1 -> SUCCESS @ /playlist
    /playlist/{uuid}, segment:2 -> SUCCESS; Parameters [uuid=[160f31d8-91f6-460f-95e0-d34cce68325d]] @ /playlist/{uuid}
      /playlist/{uuid}/(method:GET), segment:2 -> SUCCESS @ /playlist/{uuid}/(method:GET)
      /playlist/{uuid}/(method:POST), segment:2 -> FAILURE "Selector didn't match" @ /playlist/{uuid}/(method:POST)
Matched routes:
  "" -> "playlist" -> "{uuid}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [uuid=[160f31d8-91f6-460f-95e0-d34cce68325d]] @ /playlist/{uuid}/(method:GET)
2026-05-15 14:29:54.153 [Test worker @coroutine#231] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33299/playlist/160f31d8-91f6-460f-95e0-d34cce68325d
2026-05-15 14:29:54.153 [Test worker @coroutine#231] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33299/playlist/160f31d8-91f6-460f-95e0-d34cce68325d
2026-05-15 14:29:54.153 [Test worker @coroutine#231] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33299/playlist/160f31d8-91f6-460f-95e0-d34cce68325d
2026-05-15 14:29:54.153 [Test worker @coroutine#231] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsFeed for http://localhost:33299/playlist/160f31d8-91f6-460f-95e0-d34cce68325d.
2026-05-15 14:29:56.327 [Test worker @coroutine#249] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 14:29:56.327 [Test worker @coroutine#249] INFO  io.ktor.server.Application - Application started in 0.048 seconds.
2026-05-15 14:29:56.328 [DefaultDispatcher-worker-2 @coroutine#258] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:38311
2026-05-15 14:29:56.378 [DefaultDispatcher-worker-4 @coroutine#256] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38311/playlist/ca65829e-bbbe-43f7-bc2a-5460d8e81a10
2026-05-15 14:29:56.378 [DefaultDispatcher-worker-4 @coroutine#256] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@2f107c1e for http://localhost:38311/playlist/ca65829e-bbbe-43f7-bc2a-5460d8e81a10
2026-05-15 14:29:56.378 [DefaultDispatcher-worker-4 @coroutine#256] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38311/playlist/ca65829e-bbbe-43f7-bc2a-5460d8e81a10
2026-05-15 14:29:56.378 [DefaultDispatcher-worker-4 @coroutine#256] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:38311/playlist/ca65829e-bbbe-43f7-bc2a-5460d8e81a10 from class io.ktor.http.content.TextContent
2026-05-15 14:29:56.380 [eventLoopGroupProxy-34-1 @call-handler#266] TRACE io.ktor.server.routing.Routing - Trace for [playlist, ca65829e-bbbe-43f7-bc2a-5460d8e81a10]
/, segment:0 -> SUCCESS @ /
  /playlist, segment:1 -> SUCCESS @ /playlist
    /playlist/{uuid}, segment:2 -> SUCCESS; Parameters [uuid=[ca65829e-bbbe-43f7-bc2a-5460d8e81a10]] @ /playlist/{uuid}
      /playlist/{uuid}/(method:GET), segment:2 -> FAILURE "Selector didn't match" @ /playlist/{uuid}/(method:GET)
      /playlist/{uuid}/(method:POST), segment:2 -> SUCCESS @ /playlist/{uuid}/(method:POST)
Matched routes:
  "" -> "playlist" -> "{uuid}" -> "(method:POST)"
Routing resolve result:
  SUCCESS; Parameters [uuid=[ca65829e-bbbe-43f7-bc2a-5460d8e81a10]] @ /playlist/{uuid}/(method:POST)
2026-05-15 14:29:56.381 [eventLoopGroupProxy-34-1 @call-handler#266] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(world.respect.lib.opds.model.OpdsFeed) for call /playlist/ca65829e-bbbe-43f7-bc2a-5460d8e81a10
2026-05-15 14:29:56.381 [DefaultDispatcher-worker-4 @call-handler#266] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the POST /playlist/ca65829e-bbbe-43f7-bc2a-5460d8e81a10 request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-05-15 14:29:56.382 [DefaultDispatcher-worker-9 @coroutine#256] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38311/playlist/ca65829e-bbbe-43f7-bc2a-5460d8e81a10
2026-05-15 14:29:56.382 [DefaultDispatcher-worker-9 @coroutine#256] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38311/playlist/ca65829e-bbbe-43f7-bc2a-5460d8e81a10
2026-05-15 14:29:56.382 [DefaultDispatcher-worker-9 @coroutine#256] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38311/playlist/ca65829e-bbbe-43f7-bc2a-5460d8e81a10
2026-05-15 14:54:36.595 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 14:54:36.729 [Test worker] INFO  io.ktor.server.Application - Application started in 0.309 seconds.
2026-05-15 14:54:36.868 [DefaultDispatcher-worker-1 @coroutine#2] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:38111
2026-05-15 14:54:38.144 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38111/resources/index.json
2026-05-15 14:54:38.145 [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:38111/resources/index.json.
2026-05-15 14:54:38.147 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38111/resources/index.json
2026-05-15 14:54:38.354 [eventLoopGroupProxy-4-1 @call-handler#12] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2026-05-15 14:54:38.413 [eventLoopGroupProxy-4-1 @call-handler#12] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 66ms
2026-05-15 14:54:38.417 [DefaultDispatcher-worker-2 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38111/resources/index.json
2026-05-15 14:54:38.419 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38111/resources/index.json
2026-05-15 14:54:38.419 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38111/resources/index.json
2026-05-15 14:54:38.439 [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:38111/resources/index.json.
2026-05-15 14:54:38.483 [DefaultDispatcher-worker-4 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38111/resources/index.json
2026-05-15 14:54:38.483 [DefaultDispatcher-worker-4 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:38111/resources/index.json.
2026-05-15 14:54:38.483 [DefaultDispatcher-worker-4 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38111/resources/index.json
2026-05-15 14:54:38.491 [eventLoopGroupProxy-4-1 @call-handler#22] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2026-05-15 14:54:38.493 [eventLoopGroupProxy-4-1 @call-handler#22] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 3ms
2026-05-15 14:54:38.495 [DefaultDispatcher-worker-2 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38111/resources/index.json
2026-05-15 14:54:38.496 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38111/resources/index.json
2026-05-15 14:54:38.497 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38111/resources/index.json
2026-05-15 14:54:40.530 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 14:54:40.530 [Test worker] INFO  io.ktor.server.Application - Application started in 0.0 seconds.
2026-05-15 14:54:40.532 [DefaultDispatcher-worker-2 @coroutine#26] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:40513
2026-05-15 14:54:40.617 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40513/resources/index.json
2026-05-15 14:54:40.617 [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:40513/resources/index.json.
2026-05-15 14:54:40.617 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40513/resources/index.json
2026-05-15 14:54:40.623 [eventLoopGroupProxy-7-1 @call-handler#35] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2026-05-15 14:54:40.626 [DefaultDispatcher-worker-2 @call-handler#35] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 3ms
2026-05-15 14:54:40.628 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40513/resources/index.json
2026-05-15 14:54:40.628 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40513/resources/index.json
2026-05-15 14:54:40.628 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40513/resources/index.json
2026-05-15 14:54:40.630 [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:40513/resources/index.json.
2026-05-15 14:54:40.638 [DefaultDispatcher-worker-8 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40513/resources/index.json
2026-05-15 14:54:40.638 [DefaultDispatcher-worker-8 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:40513/resources/index.json.
2026-05-15 14:54:40.638 [DefaultDispatcher-worker-8 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40513/resources/index.json
2026-05-15 14:54:40.644 [eventLoopGroupProxy-7-1 @call-handler#45] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2026-05-15 14:54:40.645 [eventLoopGroupProxy-7-1 @call-handler#45] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 2ms
2026-05-15 14:54:40.646 [DefaultDispatcher-worker-5 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40513/resources/index.json
2026-05-15 14:54:40.647 [DefaultDispatcher-worker-5 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40513/resources/index.json
2026-05-15 14:54:40.647 [DefaultDispatcher-worker-5 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40513/resources/index.json
2026-05-15 14:54:42.658 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 14:54:42.659 [Test worker] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2026-05-15 14:54:42.661 [DefaultDispatcher-worker-5 @coroutine#49] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:37169
2026-05-15 14:54:42.671 [Test worker @coroutine#55] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37169/resources/lesson001.json
2026-05-15 14:54:42.671 [Test worker @coroutine#55] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:37169/resources/lesson001.json.
2026-05-15 14:54:42.671 [Test worker @coroutine#55] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37169/resources/lesson001.json
2026-05-15 14:54:42.676 [eventLoopGroupProxy-10-1 @call-handler#59] TRACE io.ktor.server.routing.Routing - Trace for [resources, lesson001.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[lesson001.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[lesson001.json]] @ /(staticContent)/resources/{...}/(method:GET)
2026-05-15 14:54:42.678 [eventLoopGroupProxy-10-1 @call-handler#59] INFO  io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 3ms
2026-05-15 14:54:42.679 [DefaultDispatcher-worker-11 @coroutine#55] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37169/resources/lesson001.json
2026-05-15 14:54:42.680 [DefaultDispatcher-worker-11 @coroutine#55] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37169/resources/lesson001.json
2026-05-15 14:54:42.680 [DefaultDispatcher-worker-11 @coroutine#55] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37169/resources/lesson001.json
2026-05-15 14:54:42.683 [DefaultDispatcher-worker-11 @coroutine#55] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class kotlinx.serialization.json.JsonObject for http://localhost:37169/resources/lesson001.json.
2026-05-15 14:54:45.020 [Test worker @coroutine#65] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 14:54:45.029 [Test worker @coroutine#65] INFO  io.ktor.server.Application - Application started in 0.157 seconds.
2026-05-15 14:54:45.035 [DefaultDispatcher-worker-10 @coroutine#74] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:43713
2026-05-15 14:54:45.044 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43713/api/school/respect/schoolpermissiongrant
2026-05-15 14:54:45.044 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:43713/api/school/respect/schoolpermissiongrant.
2026-05-15 14:54:45.044 [Test worker @coroutine#65] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43713/api/school/respect/schoolpermissiongrant
2026-05-15 14:54:45.052 [eventLoopGroupProxy-13-1 @call-handler#78] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, schoolpermissiongrant]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/person
        /api/school/respect/schoolpermissiongrant, segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant
          /api/school/respect/schoolpermissiongrant/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "schoolpermissiongrant" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
2026-05-15 14:54:45.078 [Test worker @coroutine#65] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43713/api/school/respect/schoolpermissiongrant
2026-05-15 14:54:45.078 [Test worker @coroutine#65] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43713/api/school/respect/schoolpermissiongrant
2026-05-15 14:54:45.078 [Test worker @coroutine#65] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43713/api/school/respect/schoolpermissiongrant
2026-05-15 14:54:45.080 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:43713/api/school/respect/schoolpermissiongrant.
2026-05-15 14:54:45.197 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43713/api/school/respect/person?includeRelated=false
2026-05-15 14:54:45.197 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:43713/api/school/respect/person?includeRelated=false.
2026-05-15 14:54:45.197 [Test worker @coroutine#65] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43713/api/school/respect/person?includeRelated=false
2026-05-15 14:54:45.201 [eventLoopGroupProxy-13-1 @call-handler#84] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
        /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 14:54:45.231 [Test worker @coroutine#65] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43713/api/school/respect/person?includeRelated=false
2026-05-15 14:54:45.231 [Test worker @coroutine#65] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43713/api/school/respect/person?includeRelated=false
2026-05-15 14:54:45.231 [Test worker @coroutine#65] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43713/api/school/respect/person?includeRelated=false
2026-05-15 14:54:45.233 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:43713/api/school/respect/person?includeRelated=false.
2026-05-15 14:54:45.240 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43713/api/school/respect/person?includeRelated=false
2026-05-15 14:54:45.240 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:43713/api/school/respect/person?includeRelated=false.
2026-05-15 14:54:45.241 [Test worker @coroutine#65] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43713/api/school/respect/person?includeRelated=false
2026-05-15 14:54:45.242 [eventLoopGroupProxy-13-1 @call-handler#90] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
        /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 14:54:45.245 [DefaultDispatcher-worker-8 @call-handler#90] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the GET /api/school/respect/person?includeRelated=false request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-05-15 14:54:45.246 [Test worker @coroutine#65] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43713/api/school/respect/person?includeRelated=false
2026-05-15 14:54:45.246 [Test worker @coroutine#65] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43713/api/school/respect/person?includeRelated=false
2026-05-15 14:54:45.246 [Test worker @coroutine#65] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43713/api/school/respect/person?includeRelated=false
2026-05-15 14:54:47.401 [Test worker @coroutine#94] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 14:54:47.402 [Test worker @coroutine#94] INFO  io.ktor.server.Application - Application started in 0.041 seconds.
2026-05-15 14:54:47.403 [DefaultDispatcher-worker-5 @coroutine#103] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:36529
2026-05-15 14:54:47.404 [Test worker @coroutine#94] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36529/api/school/respect/schoolpermissiongrant
2026-05-15 14:54:47.405 [Test worker @coroutine#94] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:36529/api/school/respect/schoolpermissiongrant.
2026-05-15 14:54:47.405 [Test worker @coroutine#94] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36529/api/school/respect/schoolpermissiongrant
2026-05-15 14:54:47.407 [eventLoopGroupProxy-16-1 @call-handler#107] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, schoolpermissiongrant]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/person
        /api/school/respect/schoolpermissiongrant, segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant
          /api/school/respect/schoolpermissiongrant/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "schoolpermissiongrant" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
2026-05-15 14:54:47.410 [Test worker @coroutine#94] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36529/api/school/respect/schoolpermissiongrant
2026-05-15 14:54:47.410 [Test worker @coroutine#94] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36529/api/school/respect/schoolpermissiongrant
2026-05-15 14:54:47.410 [Test worker @coroutine#94] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36529/api/school/respect/schoolpermissiongrant
2026-05-15 14:54:47.411 [Test worker @coroutine#94] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:36529/api/school/respect/schoolpermissiongrant.
2026-05-15 14:54:47.481 [DefaultDispatcher-worker-10 @coroutine#113] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36529/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 14:54:47.481 [DefaultDispatcher-worker-10 @coroutine#113] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:36529/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2026-05-15 14:54:47.481 [DefaultDispatcher-worker-10 @coroutine#113] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36529/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 14:54:47.485 [eventLoopGroupProxy-16-1 @call-handler#117] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
        /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 14:54:47.490 [DefaultDispatcher-worker-10 @coroutine#113] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36529/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 14:54:47.490 [DefaultDispatcher-worker-10 @coroutine#113] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36529/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 14:54:47.490 [DefaultDispatcher-worker-10 @coroutine#113] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36529/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 14:54:47.492 [DefaultDispatcher-worker-10 @coroutine#113] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:36529/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2026-05-15 14:54:49.624 [Test worker @coroutine#122] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 14:54:49.625 [Test worker @coroutine#122] INFO  io.ktor.server.Application - Application started in 0.04 seconds.
2026-05-15 14:54:49.626 [DefaultDispatcher-worker-5 @coroutine#131] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:38601
2026-05-15 14:54:49.629 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38601/api/school/respect/person?includeRelated=false
2026-05-15 14:54:49.629 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:38601/api/school/respect/person?includeRelated=false.
2026-05-15 14:54:49.629 [Test worker @coroutine#122] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38601/api/school/respect/person?includeRelated=false
2026-05-15 14:54:49.632 [eventLoopGroupProxy-19-1 @call-handler#136] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 14:54:49.636 [Test worker @coroutine#122] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38601/api/school/respect/person?includeRelated=false
2026-05-15 14:54:49.636 [Test worker @coroutine#122] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38601/api/school/respect/person?includeRelated=false
2026-05-15 14:54:49.636 [Test worker @coroutine#122] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38601/api/school/respect/person?includeRelated=false
2026-05-15 14:54:49.637 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:38601/api/school/respect/person?includeRelated=false.
2026-05-15 14:54:49.689 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38601/api/school/respect/person?since=2026-05-15T10%3A54%3A49.632826754Z&includeRelated=false
2026-05-15 14:54:49.689 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:38601/api/school/respect/person?since=2026-05-15T10%3A54%3A49.632826754Z&includeRelated=false.
2026-05-15 14:54:49.689 [Test worker @coroutine#122] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38601/api/school/respect/person?since=2026-05-15T10%3A54%3A49.632826754Z&includeRelated=false
2026-05-15 14:54:49.691 [eventLoopGroupProxy-19-1 @call-handler#142] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 14:54:49.694 [Test worker @coroutine#122] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38601/api/school/respect/person?since=2026-05-15T10%3A54%3A49.632826754Z&includeRelated=false
2026-05-15 14:54:49.695 [Test worker @coroutine#122] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38601/api/school/respect/person?since=2026-05-15T10%3A54%3A49.632826754Z&includeRelated=false
2026-05-15 14:54:49.695 [Test worker @coroutine#122] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38601/api/school/respect/person?since=2026-05-15T10%3A54%3A49.632826754Z&includeRelated=false
2026-05-15 14:54:49.695 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:38601/api/school/respect/person?since=2026-05-15T10%3A54%3A49.632826754Z&includeRelated=false.
2026-05-15 14:54:51.867 [Test worker @coroutine#148] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 14:54:51.868 [Test worker @coroutine#148] INFO  io.ktor.server.Application - Application started in 0.042 seconds.
2026-05-15 14:54:51.870 [DefaultDispatcher-worker-5 @coroutine#157] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:43321
2026-05-15 14:54:51.925 [DefaultDispatcher-worker-5 @coroutine#155] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43321/api/school/respect/person
2026-05-15 14:54:51.926 [DefaultDispatcher-worker-5 @coroutine#155] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@cf46113 for http://localhost:43321/api/school/respect/person
2026-05-15 14:54:51.926 [DefaultDispatcher-worker-5 @coroutine#155] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43321/api/school/respect/person
2026-05-15 14:54:51.926 [DefaultDispatcher-worker-5 @coroutine#155] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:43321/api/school/respect/person from class io.ktor.http.content.TextContent
2026-05-15 14:54:51.932 [eventLoopGroupProxy-22-1 @call-handler#167] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> SUCCESS @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:POST)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:POST)
2026-05-15 14:54:51.941 [eventLoopGroupProxy-22-1 @call-handler#167] 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
2026-05-15 14:54:51.944 [DefaultDispatcher-worker-5 @call-handler#167] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the POST /api/school/respect/person request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-05-15 14:54:51.946 [DefaultDispatcher-worker-5 @coroutine#155] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43321/api/school/respect/person
2026-05-15 14:54:51.946 [DefaultDispatcher-worker-11 @coroutine#155] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43321/api/school/respect/person
2026-05-15 14:54:51.946 [DefaultDispatcher-worker-11 @coroutine#155] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43321/api/school/respect/person
2026-05-15 14:54:54.125 [Test worker @coroutine#172] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 14:54:54.126 [Test worker @coroutine#172] INFO  io.ktor.server.Application - Application started in 0.073 seconds.
2026-05-15 14:54:54.150 [DefaultDispatcher-worker-9 @coroutine#181] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:36745
2026-05-15 14:54:54.151 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36745/api/school/respect/schoolpermissiongrant
2026-05-15 14:54:54.151 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:36745/api/school/respect/schoolpermissiongrant.
2026-05-15 14:54:54.151 [Test worker @coroutine#172] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36745/api/school/respect/schoolpermissiongrant
2026-05-15 14:54:54.179 [eventLoopGroupProxy-25-1 @call-handler#185] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, schoolpermissiongrant]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/person
        /api/school/respect/schoolpermissiongrant, segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant
          /api/school/respect/schoolpermissiongrant/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "schoolpermissiongrant" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
2026-05-15 14:54:54.182 [Test worker @coroutine#172] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36745/api/school/respect/schoolpermissiongrant
2026-05-15 14:54:54.182 [Test worker @coroutine#172] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36745/api/school/respect/schoolpermissiongrant
2026-05-15 14:54:54.182 [Test worker @coroutine#172] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36745/api/school/respect/schoolpermissiongrant
2026-05-15 14:54:54.183 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:36745/api/school/respect/schoolpermissiongrant.
2026-05-15 14:54:54.268 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36745/api/school/respect/person?includeRelated=false
2026-05-15 14:54:54.269 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:36745/api/school/respect/person?includeRelated=false.
2026-05-15 14:54:54.269 [Test worker @coroutine#172] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36745/api/school/respect/person?includeRelated=false
2026-05-15 14:54:54.275 [eventLoopGroupProxy-25-1 @call-handler#191] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
        /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 14:54:54.298 [Test worker @coroutine#172] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36745/api/school/respect/person?includeRelated=false
2026-05-15 14:54:54.299 [Test worker @coroutine#172] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36745/api/school/respect/person?includeRelated=false
2026-05-15 14:54:54.299 [Test worker @coroutine#172] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36745/api/school/respect/person?includeRelated=false
2026-05-15 14:54:54.303 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:36745/api/school/respect/person?includeRelated=false.
2026-05-15 14:54:56.321 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36745/api/school/respect/person?includeRelated=false
2026-05-15 14:54:56.321 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:36745/api/school/respect/person?includeRelated=false.
2026-05-15 14:54:56.321 [Test worker @coroutine#172] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36745/api/school/respect/person?includeRelated=false
2026-05-15 14:54:56.324 [eventLoopGroupProxy-25-1 @call-handler#198] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
        /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 14:54:56.335 [Test worker @coroutine#172] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36745/api/school/respect/person?includeRelated=false
2026-05-15 14:54:56.335 [Test worker @coroutine#172] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36745/api/school/respect/person?includeRelated=false
2026-05-15 14:54:56.335 [Test worker @coroutine#172] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36745/api/school/respect/person?includeRelated=false
2026-05-15 14:54:56.337 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:36745/api/school/respect/person?includeRelated=false.
2026-05-15 14:54:58.535 [Test worker @coroutine#204] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 14:54:58.535 [Test worker @coroutine#204] INFO  io.ktor.server.Application - Application started in 0.057 seconds.
2026-05-15 14:54:58.536 [DefaultDispatcher-worker-10 @coroutine#213] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:44511
2026-05-15 14:54:58.538 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44511/api/school/respect/person?includeRelated=false
2026-05-15 14:54:58.539 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:44511/api/school/respect/person?includeRelated=false.
2026-05-15 14:54:58.539 [Test worker @coroutine#204] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44511/api/school/respect/person?includeRelated=false
2026-05-15 14:54:58.541 [eventLoopGroupProxy-28-1 @call-handler#218] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 14:54:58.544 [Test worker @coroutine#204] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44511/api/school/respect/person?includeRelated=false
2026-05-15 14:54:58.544 [Test worker @coroutine#204] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44511/api/school/respect/person?includeRelated=false
2026-05-15 14:54:58.544 [Test worker @coroutine#204] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44511/api/school/respect/person?includeRelated=false
2026-05-15 14:54:58.545 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44511/api/school/respect/person?includeRelated=false.
2026-05-15 14:54:58.594 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44511/api/school/respect/person?since=2026-05-15T10%3A54%3A58.541375017Z&includeRelated=false
2026-05-15 14:54:58.594 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:44511/api/school/respect/person?since=2026-05-15T10%3A54%3A58.541375017Z&includeRelated=false.
2026-05-15 14:54:58.594 [Test worker @coroutine#204] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44511/api/school/respect/person?since=2026-05-15T10%3A54%3A58.541375017Z&includeRelated=false
2026-05-15 14:54:58.595 [eventLoopGroupProxy-28-1 @call-handler#225] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 14:54:58.598 [Test worker @coroutine#204] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44511/api/school/respect/person?since=2026-05-15T10%3A54%3A58.541375017Z&includeRelated=false
2026-05-15 14:54:58.598 [Test worker @coroutine#204] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44511/api/school/respect/person?since=2026-05-15T10%3A54%3A58.541375017Z&includeRelated=false
2026-05-15 14:54:58.598 [Test worker @coroutine#204] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44511/api/school/respect/person?since=2026-05-15T10%3A54%3A58.541375017Z&includeRelated=false
2026-05-15 14:54:58.599 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44511/api/school/respect/person?since=2026-05-15T10%3A54%3A58.541375017Z&includeRelated=false.
2026-05-15 14:55:00.811 [Test worker @coroutine#231] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 14:55:00.813 [Test worker @coroutine#231] INFO  io.ktor.server.Application - Application started in 0.092 seconds.
2026-05-15 14:55:00.814 [DefaultDispatcher-worker-11 @coroutine#241] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:42309
2026-05-15 14:55:00.817 [Test worker @coroutine#231] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42309/playlist/86541e26-4685-476b-a6a0-c4a2429cd950
2026-05-15 14:55:00.817 [Test worker @coroutine#231] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:42309/playlist/86541e26-4685-476b-a6a0-c4a2429cd950.
2026-05-15 14:55:00.817 [Test worker @coroutine#231] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42309/playlist/86541e26-4685-476b-a6a0-c4a2429cd950
2026-05-15 14:55:00.820 [eventLoopGroupProxy-31-1 @call-handler#245] TRACE io.ktor.server.routing.Routing - Trace for [playlist, 86541e26-4685-476b-a6a0-c4a2429cd950]
/, segment:0 -> SUCCESS @ /
  /playlist, segment:1 -> SUCCESS @ /playlist
    /playlist/{uuid}, segment:2 -> SUCCESS; Parameters [uuid=[86541e26-4685-476b-a6a0-c4a2429cd950]] @ /playlist/{uuid}
      /playlist/{uuid}/(method:GET), segment:2 -> SUCCESS @ /playlist/{uuid}/(method:GET)
      /playlist/{uuid}/(method:POST), segment:2 -> FAILURE "Selector didn't match" @ /playlist/{uuid}/(method:POST)
Matched routes:
  "" -> "playlist" -> "{uuid}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [uuid=[86541e26-4685-476b-a6a0-c4a2429cd950]] @ /playlist/{uuid}/(method:GET)
2026-05-15 14:55:00.827 [Test worker @coroutine#231] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42309/playlist/86541e26-4685-476b-a6a0-c4a2429cd950
2026-05-15 14:55:00.827 [Test worker @coroutine#231] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42309/playlist/86541e26-4685-476b-a6a0-c4a2429cd950
2026-05-15 14:55:00.827 [Test worker @coroutine#231] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42309/playlist/86541e26-4685-476b-a6a0-c4a2429cd950
2026-05-15 14:55:00.827 [Test worker @coroutine#231] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsFeed for http://localhost:42309/playlist/86541e26-4685-476b-a6a0-c4a2429cd950.
2026-05-15 14:55:02.995 [Test worker @coroutine#249] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 14:55:02.996 [Test worker @coroutine#249] INFO  io.ktor.server.Application - Application started in 0.039 seconds.
2026-05-15 14:55:02.997 [DefaultDispatcher-worker-8 @coroutine#258] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:43571
2026-05-15 14:55:03.046 [DefaultDispatcher-worker-11 @coroutine#256] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43571/playlist/d9c34458-21c6-46c3-b580-dfd1d4a9b99e
2026-05-15 14:55:03.046 [DefaultDispatcher-worker-11 @coroutine#256] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@3ceab76 for http://localhost:43571/playlist/d9c34458-21c6-46c3-b580-dfd1d4a9b99e
2026-05-15 14:55:03.046 [DefaultDispatcher-worker-11 @coroutine#256] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43571/playlist/d9c34458-21c6-46c3-b580-dfd1d4a9b99e
2026-05-15 14:55:03.046 [DefaultDispatcher-worker-11 @coroutine#256] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:43571/playlist/d9c34458-21c6-46c3-b580-dfd1d4a9b99e from class io.ktor.http.content.TextContent
2026-05-15 14:55:03.048 [eventLoopGroupProxy-34-1 @call-handler#266] TRACE io.ktor.server.routing.Routing - Trace for [playlist, d9c34458-21c6-46c3-b580-dfd1d4a9b99e]
/, segment:0 -> SUCCESS @ /
  /playlist, segment:1 -> SUCCESS @ /playlist
    /playlist/{uuid}, segment:2 -> SUCCESS; Parameters [uuid=[d9c34458-21c6-46c3-b580-dfd1d4a9b99e]] @ /playlist/{uuid}
      /playlist/{uuid}/(method:GET), segment:2 -> FAILURE "Selector didn't match" @ /playlist/{uuid}/(method:GET)
      /playlist/{uuid}/(method:POST), segment:2 -> SUCCESS @ /playlist/{uuid}/(method:POST)
Matched routes:
  "" -> "playlist" -> "{uuid}" -> "(method:POST)"
Routing resolve result:
  SUCCESS; Parameters [uuid=[d9c34458-21c6-46c3-b580-dfd1d4a9b99e]] @ /playlist/{uuid}/(method:POST)
2026-05-15 14:55:03.049 [eventLoopGroupProxy-34-1 @call-handler#266] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(world.respect.lib.opds.model.OpdsFeed) for call /playlist/d9c34458-21c6-46c3-b580-dfd1d4a9b99e
2026-05-15 14:55:03.050 [DefaultDispatcher-worker-11 @call-handler#266] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the POST /playlist/d9c34458-21c6-46c3-b580-dfd1d4a9b99e request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-05-15 14:55:03.051 [DefaultDispatcher-worker-11 @coroutine#256] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43571/playlist/d9c34458-21c6-46c3-b580-dfd1d4a9b99e
2026-05-15 14:55:03.051 [DefaultDispatcher-worker-11 @coroutine#256] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43571/playlist/d9c34458-21c6-46c3-b580-dfd1d4a9b99e
2026-05-15 14:55:03.051 [DefaultDispatcher-worker-11 @coroutine#256] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43571/playlist/d9c34458-21c6-46c3-b580-dfd1d4a9b99e
2026-05-15 15:57:26.880 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 15:57:26.995 [Test worker] INFO  io.ktor.server.Application - Application started in 0.274 seconds.
2026-05-15 15:57:27.094 [DefaultDispatcher-worker-1 @coroutine#2] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:35899
2026-05-15 15:57:27.917 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35899/resources/index.json
2026-05-15 15:57:27.917 [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:35899/resources/index.json.
2026-05-15 15:57:27.917 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35899/resources/index.json
2026-05-15 15:57:28.068 [eventLoopGroupProxy-4-1 @call-handler#12] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2026-05-15 15:57:28.125 [eventLoopGroupProxy-4-1 @call-handler#12] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 63ms
2026-05-15 15:57:28.132 [DefaultDispatcher-worker-2 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35899/resources/index.json
2026-05-15 15:57:28.134 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35899/resources/index.json
2026-05-15 15:57:28.135 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35899/resources/index.json
2026-05-15 15:57:28.158 [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:35899/resources/index.json.
2026-05-15 15:57:28.195 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35899/resources/index.json
2026-05-15 15:57:28.195 [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:35899/resources/index.json.
2026-05-15 15:57:28.195 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35899/resources/index.json
2026-05-15 15:57:28.199 [eventLoopGroupProxy-4-1 @call-handler#22] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2026-05-15 15:57:28.200 [eventLoopGroupProxy-4-1 @call-handler#22] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 2ms
2026-05-15 15:57:28.202 [DefaultDispatcher-worker-3 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35899/resources/index.json
2026-05-15 15:57:28.202 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35899/resources/index.json
2026-05-15 15:57:28.202 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35899/resources/index.json
2026-05-15 15:57:29.211 [eventLoopGroupProxy-3-1] WARN  i.n.u.c.AbstractEventExecutor - A task raised an exception. Task: io.netty.channel.AbstractChannel$AbstractUnsafe$8@5743b2a7
java.util.concurrent.RejectedExecutionException: event executor terminated
	at io.netty.util.concurrent.SingleThreadEventExecutor.reject(SingleThreadEventExecutor.java:1005)
	at io.netty.util.concurrent.SingleThreadEventExecutor.offerTask(SingleThreadEventExecutor.java:388)
	at io.netty.util.concurrent.SingleThreadEventExecutor.addTask(SingleThreadEventExecutor.java:381)
	at io.netty.util.concurrent.SingleThreadEventExecutor.execute(SingleThreadEventExecutor.java:907)
	at io.netty.util.concurrent.SingleThreadEventExecutor.execute0(SingleThreadEventExecutor.java:873)
	at io.netty.util.concurrent.SingleThreadEventExecutor.execute(SingleThreadEventExecutor.java:863)
	at io.netty.channel.DefaultChannelPipeline.destroyUp(DefaultChannelPipeline.java:816)
	at io.netty.channel.DefaultChannelPipeline.destroy(DefaultChannelPipeline.java:801)
	at io.netty.channel.DefaultChannelPipeline.access$700(DefaultChannelPipeline.java:45)
	at io.netty.channel.DefaultChannelPipeline$HeadContext.channelUnregistered(DefaultChannelPipeline.java:1411)
	at io.netty.channel.DefaultChannelPipeline.fireChannelUnregistered(DefaultChannelPipeline.java:780)
	at io.netty.channel.AbstractChannel$AbstractUnsafe$8.run(AbstractChannel.java:692)
	at io.netty.util.concurrent.AbstractEventExecutor.runTask(AbstractEventExecutor.java:148)
	at io.netty.util.concurrent.AbstractEventExecutor.safeExecute(AbstractEventExecutor.java:141)
	at io.netty.util.concurrent.SingleThreadEventExecutor.runAllTasks(SingleThreadEventExecutor.java:507)
	at io.netty.channel.SingleThreadIoEventLoop.run(SingleThreadIoEventLoop.java:183)
	at io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:1073)
	at io.netty.util.internal.ThreadExecutorMap$2.run(ThreadExecutorMap.java:74)
	at io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30)
	at java.base/java.lang.Thread.run(Thread.java:1583)
2026-05-15 15:57:30.218 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 15:57:30.218 [Test worker] INFO  io.ktor.server.Application - Application started in 0.0 seconds.
2026-05-15 15:57:30.219 [DefaultDispatcher-worker-3 @coroutine#26] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:39667
2026-05-15 15:57:30.290 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39667/resources/index.json
2026-05-15 15:57:30.290 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:39667/resources/index.json.
2026-05-15 15:57:30.290 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39667/resources/index.json
2026-05-15 15:57:30.293 [eventLoopGroupProxy-7-1 @call-handler#35] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2026-05-15 15:57:30.294 [DefaultDispatcher-worker-2 @call-handler#35] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 1ms
2026-05-15 15:57:30.295 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39667/resources/index.json
2026-05-15 15:57:30.295 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39667/resources/index.json
2026-05-15 15:57:30.295 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39667/resources/index.json
2026-05-15 15:57:30.296 [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:39667/resources/index.json.
2026-05-15 15:57:30.300 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39667/resources/index.json
2026-05-15 15:57:30.300 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:39667/resources/index.json.
2026-05-15 15:57:30.300 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39667/resources/index.json
2026-05-15 15:57:30.301 [eventLoopGroupProxy-7-1 @call-handler#45] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2026-05-15 15:57:30.301 [eventLoopGroupProxy-7-1 @call-handler#45] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 0ms
2026-05-15 15:57:30.302 [DefaultDispatcher-worker-2 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39667/resources/index.json
2026-05-15 15:57:30.302 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39667/resources/index.json
2026-05-15 15:57:30.302 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39667/resources/index.json
2026-05-15 15:57:32.309 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 15:57:32.309 [Test worker] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2026-05-15 15:57:32.310 [DefaultDispatcher-worker-3 @coroutine#49] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:34987
2026-05-15 15:57:32.315 [Test worker @coroutine#55] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34987/resources/lesson001.json
2026-05-15 15:57:32.315 [Test worker @coroutine#55] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:34987/resources/lesson001.json.
2026-05-15 15:57:32.315 [Test worker @coroutine#55] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34987/resources/lesson001.json
2026-05-15 15:57:32.317 [eventLoopGroupProxy-10-1 @call-handler#59] TRACE io.ktor.server.routing.Routing - Trace for [resources, lesson001.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[lesson001.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[lesson001.json]] @ /(staticContent)/resources/{...}/(method:GET)
2026-05-15 15:57:32.318 [eventLoopGroupProxy-10-1 @call-handler#59] INFO  io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 1ms
2026-05-15 15:57:32.319 [DefaultDispatcher-worker-2 @coroutine#55] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34987/resources/lesson001.json
2026-05-15 15:57:32.319 [DefaultDispatcher-worker-4 @coroutine#55] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34987/resources/lesson001.json
2026-05-15 15:57:32.319 [DefaultDispatcher-worker-4 @coroutine#55] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34987/resources/lesson001.json
2026-05-15 15:57:32.322 [DefaultDispatcher-worker-4 @coroutine#55] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class kotlinx.serialization.json.JsonObject for http://localhost:34987/resources/lesson001.json.
2026-05-15 15:57:34.568 [Test worker @coroutine#65] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 15:57:34.575 [Test worker @coroutine#65] INFO  io.ktor.server.Application - Application started in 0.113 seconds.
2026-05-15 15:57:34.577 [DefaultDispatcher-worker-1 @coroutine#74] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:38419
2026-05-15 15:57:34.585 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38419/api/school/respect/schoolpermissiongrant
2026-05-15 15:57:34.585 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:38419/api/school/respect/schoolpermissiongrant.
2026-05-15 15:57:34.585 [Test worker @coroutine#65] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38419/api/school/respect/schoolpermissiongrant
2026-05-15 15:57:34.589 [eventLoopGroupProxy-13-1 @call-handler#78] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, schoolpermissiongrant]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/person
        /api/school/respect/schoolpermissiongrant, segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant
          /api/school/respect/schoolpermissiongrant/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "schoolpermissiongrant" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
2026-05-15 15:57:34.601 [Test worker @coroutine#65] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38419/api/school/respect/schoolpermissiongrant
2026-05-15 15:57:34.602 [Test worker @coroutine#65] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38419/api/school/respect/schoolpermissiongrant
2026-05-15 15:57:34.602 [Test worker @coroutine#65] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38419/api/school/respect/schoolpermissiongrant
2026-05-15 15:57:34.603 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:38419/api/school/respect/schoolpermissiongrant.
2026-05-15 15:57:34.669 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38419/api/school/respect/person?includeRelated=false
2026-05-15 15:57:34.669 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:38419/api/school/respect/person?includeRelated=false.
2026-05-15 15:57:34.669 [Test worker @coroutine#65] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38419/api/school/respect/person?includeRelated=false
2026-05-15 15:57:34.671 [eventLoopGroupProxy-13-1 @call-handler#84] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
        /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 15:57:34.689 [Test worker @coroutine#65] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38419/api/school/respect/person?includeRelated=false
2026-05-15 15:57:34.689 [Test worker @coroutine#65] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38419/api/school/respect/person?includeRelated=false
2026-05-15 15:57:34.689 [Test worker @coroutine#65] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38419/api/school/respect/person?includeRelated=false
2026-05-15 15:57:34.691 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:38419/api/school/respect/person?includeRelated=false.
2026-05-15 15:57:34.697 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38419/api/school/respect/person?includeRelated=false
2026-05-15 15:57:34.698 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:38419/api/school/respect/person?includeRelated=false.
2026-05-15 15:57:34.698 [Test worker @coroutine#65] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38419/api/school/respect/person?includeRelated=false
2026-05-15 15:57:34.700 [eventLoopGroupProxy-13-1 @call-handler#90] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
        /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 15:57:34.702 [DefaultDispatcher-worker-2 @call-handler#90] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the GET /api/school/respect/person?includeRelated=false request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-05-15 15:57:34.703 [Test worker @coroutine#65] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38419/api/school/respect/person?includeRelated=false
2026-05-15 15:57:34.704 [Test worker @coroutine#65] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38419/api/school/respect/person?includeRelated=false
2026-05-15 15:57:34.704 [Test worker @coroutine#65] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38419/api/school/respect/person?includeRelated=false
2026-05-15 15:57:36.833 [Test worker @coroutine#94] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 15:57:36.834 [Test worker @coroutine#94] INFO  io.ktor.server.Application - Application started in 0.045 seconds.
2026-05-15 15:57:36.835 [DefaultDispatcher-worker-3 @coroutine#103] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:39801
2026-05-15 15:57:36.836 [Test worker @coroutine#94] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39801/api/school/respect/schoolpermissiongrant
2026-05-15 15:57:36.836 [Test worker @coroutine#94] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:39801/api/school/respect/schoolpermissiongrant.
2026-05-15 15:57:36.836 [Test worker @coroutine#94] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39801/api/school/respect/schoolpermissiongrant
2026-05-15 15:57:36.839 [eventLoopGroupProxy-16-1 @call-handler#107] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, schoolpermissiongrant]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/person
        /api/school/respect/schoolpermissiongrant, segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant
          /api/school/respect/schoolpermissiongrant/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "schoolpermissiongrant" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
2026-05-15 15:57:36.841 [Test worker @coroutine#94] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39801/api/school/respect/schoolpermissiongrant
2026-05-15 15:57:36.841 [Test worker @coroutine#94] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39801/api/school/respect/schoolpermissiongrant
2026-05-15 15:57:36.841 [Test worker @coroutine#94] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39801/api/school/respect/schoolpermissiongrant
2026-05-15 15:57:36.841 [Test worker @coroutine#94] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:39801/api/school/respect/schoolpermissiongrant.
2026-05-15 15:57:36.902 [DefaultDispatcher-worker-2 @coroutine#113] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39801/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 15:57:36.902 [DefaultDispatcher-worker-2 @coroutine#113] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:39801/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2026-05-15 15:57:36.902 [DefaultDispatcher-worker-2 @coroutine#113] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39801/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 15:57:36.904 [eventLoopGroupProxy-16-1 @call-handler#117] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
        /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 15:57:36.906 [DefaultDispatcher-worker-1 @coroutine#113] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39801/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 15:57:36.907 [DefaultDispatcher-worker-1 @coroutine#113] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39801/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 15:57:36.907 [DefaultDispatcher-worker-1 @coroutine#113] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39801/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 15:57:36.907 [DefaultDispatcher-worker-1 @coroutine#113] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:39801/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2026-05-15 15:57:39.020 [Test worker @coroutine#122] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 15:57:39.020 [Test worker @coroutine#122] INFO  io.ktor.server.Application - Application started in 0.039 seconds.
2026-05-15 15:57:39.021 [DefaultDispatcher-worker-4 @coroutine#131] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:41935
2026-05-15 15:57:39.024 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41935/api/school/respect/person?includeRelated=false
2026-05-15 15:57:39.024 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41935/api/school/respect/person?includeRelated=false.
2026-05-15 15:57:39.024 [Test worker @coroutine#122] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41935/api/school/respect/person?includeRelated=false
2026-05-15 15:57:39.026 [eventLoopGroupProxy-19-1 @call-handler#136] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 15:57:39.030 [Test worker @coroutine#122] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41935/api/school/respect/person?includeRelated=false
2026-05-15 15:57:39.030 [Test worker @coroutine#122] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41935/api/school/respect/person?includeRelated=false
2026-05-15 15:57:39.030 [Test worker @coroutine#122] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41935/api/school/respect/person?includeRelated=false
2026-05-15 15:57:39.031 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41935/api/school/respect/person?includeRelated=false.
2026-05-15 15:57:39.091 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41935/api/school/respect/person?since=2026-05-15T11%3A57%3A39.027245927Z&includeRelated=false
2026-05-15 15:57:39.091 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41935/api/school/respect/person?since=2026-05-15T11%3A57%3A39.027245927Z&includeRelated=false.
2026-05-15 15:57:39.092 [Test worker @coroutine#122] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41935/api/school/respect/person?since=2026-05-15T11%3A57%3A39.027245927Z&includeRelated=false
2026-05-15 15:57:39.093 [eventLoopGroupProxy-19-1 @call-handler#142] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 15:57:39.096 [Test worker @coroutine#122] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41935/api/school/respect/person?since=2026-05-15T11%3A57%3A39.027245927Z&includeRelated=false
2026-05-15 15:57:39.096 [Test worker @coroutine#122] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41935/api/school/respect/person?since=2026-05-15T11%3A57%3A39.027245927Z&includeRelated=false
2026-05-15 15:57:39.096 [Test worker @coroutine#122] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41935/api/school/respect/person?since=2026-05-15T11%3A57%3A39.027245927Z&includeRelated=false
2026-05-15 15:57:39.097 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41935/api/school/respect/person?since=2026-05-15T11%3A57%3A39.027245927Z&includeRelated=false.
2026-05-15 15:57:41.197 [Test worker @coroutine#148] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 15:57:41.198 [Test worker @coroutine#148] INFO  io.ktor.server.Application - Application started in 0.04 seconds.
2026-05-15 15:57:41.199 [DefaultDispatcher-worker-3 @coroutine#157] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:34283
2026-05-15 15:57:41.261 [DefaultDispatcher-worker-2 @coroutine#155] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34283/api/school/respect/person
2026-05-15 15:57:41.262 [DefaultDispatcher-worker-2 @coroutine#155] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@1c36d0fe for http://localhost:34283/api/school/respect/person
2026-05-15 15:57:41.262 [DefaultDispatcher-worker-2 @coroutine#155] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34283/api/school/respect/person
2026-05-15 15:57:41.262 [DefaultDispatcher-worker-2 @coroutine#155] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:34283/api/school/respect/person from class io.ktor.http.content.TextContent
2026-05-15 15:57:41.265 [eventLoopGroupProxy-22-1 @call-handler#167] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> SUCCESS @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:POST)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:POST)
2026-05-15 15:57:41.270 [eventLoopGroupProxy-22-1 @call-handler#167] 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
2026-05-15 15:57:41.272 [DefaultDispatcher-worker-2 @call-handler#167] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the POST /api/school/respect/person request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-05-15 15:57:41.273 [DefaultDispatcher-worker-10 @coroutine#155] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34283/api/school/respect/person
2026-05-15 15:57:41.273 [DefaultDispatcher-worker-10 @coroutine#155] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34283/api/school/respect/person
2026-05-15 15:57:41.273 [DefaultDispatcher-worker-10 @coroutine#155] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34283/api/school/respect/person
2026-05-15 15:57:43.395 [Test worker @coroutine#172] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 15:57:43.396 [Test worker @coroutine#172] INFO  io.ktor.server.Application - Application started in 0.054 seconds.
2026-05-15 15:57:43.397 [DefaultDispatcher-worker-5 @coroutine#181] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:44293
2026-05-15 15:57:43.397 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44293/api/school/respect/schoolpermissiongrant
2026-05-15 15:57:43.398 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:44293/api/school/respect/schoolpermissiongrant.
2026-05-15 15:57:43.398 [Test worker @coroutine#172] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44293/api/school/respect/schoolpermissiongrant
2026-05-15 15:57:43.400 [eventLoopGroupProxy-25-1 @call-handler#185] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, schoolpermissiongrant]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/person
        /api/school/respect/schoolpermissiongrant, segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant
          /api/school/respect/schoolpermissiongrant/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "schoolpermissiongrant" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
2026-05-15 15:57:43.402 [Test worker @coroutine#172] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44293/api/school/respect/schoolpermissiongrant
2026-05-15 15:57:43.402 [Test worker @coroutine#172] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44293/api/school/respect/schoolpermissiongrant
2026-05-15 15:57:43.402 [Test worker @coroutine#172] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44293/api/school/respect/schoolpermissiongrant
2026-05-15 15:57:43.402 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44293/api/school/respect/schoolpermissiongrant.
2026-05-15 15:57:43.451 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44293/api/school/respect/person?includeRelated=false
2026-05-15 15:57:43.451 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:44293/api/school/respect/person?includeRelated=false.
2026-05-15 15:57:43.451 [Test worker @coroutine#172] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44293/api/school/respect/person?includeRelated=false
2026-05-15 15:57:43.453 [eventLoopGroupProxy-25-1 @call-handler#191] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
        /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 15:57:43.458 [Test worker @coroutine#172] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44293/api/school/respect/person?includeRelated=false
2026-05-15 15:57:43.458 [Test worker @coroutine#172] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44293/api/school/respect/person?includeRelated=false
2026-05-15 15:57:43.458 [Test worker @coroutine#172] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44293/api/school/respect/person?includeRelated=false
2026-05-15 15:57:43.459 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44293/api/school/respect/person?includeRelated=false.
2026-05-15 15:57:45.464 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44293/api/school/respect/person?includeRelated=false
2026-05-15 15:57:45.464 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:44293/api/school/respect/person?includeRelated=false.
2026-05-15 15:57:45.464 [Test worker @coroutine#172] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44293/api/school/respect/person?includeRelated=false
2026-05-15 15:57:45.466 [eventLoopGroupProxy-25-1 @call-handler#198] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
        /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 15:57:45.469 [Test worker @coroutine#172] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44293/api/school/respect/person?includeRelated=false
2026-05-15 15:57:45.469 [Test worker @coroutine#172] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44293/api/school/respect/person?includeRelated=false
2026-05-15 15:57:45.469 [Test worker @coroutine#172] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44293/api/school/respect/person?includeRelated=false
2026-05-15 15:57:45.469 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44293/api/school/respect/person?includeRelated=false.
2026-05-15 15:57:47.581 [Test worker @coroutine#204] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 15:57:47.581 [Test worker @coroutine#204] INFO  io.ktor.server.Application - Application started in 0.039 seconds.
2026-05-15 15:57:47.582 [DefaultDispatcher-worker-10 @coroutine#213] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:44843
2026-05-15 15:57:47.585 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44843/api/school/respect/person?includeRelated=false
2026-05-15 15:57:47.585 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:44843/api/school/respect/person?includeRelated=false.
2026-05-15 15:57:47.585 [Test worker @coroutine#204] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44843/api/school/respect/person?includeRelated=false
2026-05-15 15:57:47.587 [eventLoopGroupProxy-28-1 @call-handler#218] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 15:57:47.592 [Test worker @coroutine#204] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44843/api/school/respect/person?includeRelated=false
2026-05-15 15:57:47.592 [Test worker @coroutine#204] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44843/api/school/respect/person?includeRelated=false
2026-05-15 15:57:47.592 [Test worker @coroutine#204] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44843/api/school/respect/person?includeRelated=false
2026-05-15 15:57:47.592 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44843/api/school/respect/person?includeRelated=false.
2026-05-15 15:57:47.644 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44843/api/school/respect/person?since=2026-05-15T11%3A57%3A47.588156357Z&includeRelated=false
2026-05-15 15:57:47.644 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:44843/api/school/respect/person?since=2026-05-15T11%3A57%3A47.588156357Z&includeRelated=false.
2026-05-15 15:57:47.644 [Test worker @coroutine#204] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44843/api/school/respect/person?since=2026-05-15T11%3A57%3A47.588156357Z&includeRelated=false
2026-05-15 15:57:47.646 [eventLoopGroupProxy-28-1 @call-handler#225] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-15 15:57:47.648 [Test worker @coroutine#204] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44843/api/school/respect/person?since=2026-05-15T11%3A57%3A47.588156357Z&includeRelated=false
2026-05-15 15:57:47.649 [Test worker @coroutine#204] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44843/api/school/respect/person?since=2026-05-15T11%3A57%3A47.588156357Z&includeRelated=false
2026-05-15 15:57:47.649 [Test worker @coroutine#204] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44843/api/school/respect/person?since=2026-05-15T11%3A57%3A47.588156357Z&includeRelated=false
2026-05-15 15:57:47.649 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44843/api/school/respect/person?since=2026-05-15T11%3A57%3A47.588156357Z&includeRelated=false.
2026-05-15 15:57:49.896 [Test worker @coroutine#231] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 15:57:49.897 [Test worker @coroutine#231] INFO  io.ktor.server.Application - Application started in 0.13 seconds.
2026-05-15 15:57:49.898 [DefaultDispatcher-worker-2 @coroutine#241] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:36821
2026-05-15 15:57:49.900 [Test worker @coroutine#231] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36821/playlist/a55fdab9-2b4d-428c-98f8-3be802cc5264
2026-05-15 15:57:49.900 [Test worker @coroutine#231] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:36821/playlist/a55fdab9-2b4d-428c-98f8-3be802cc5264.
2026-05-15 15:57:49.900 [Test worker @coroutine#231] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36821/playlist/a55fdab9-2b4d-428c-98f8-3be802cc5264
2026-05-15 15:57:49.903 [eventLoopGroupProxy-31-1 @call-handler#245] TRACE io.ktor.server.routing.Routing - Trace for [playlist, a55fdab9-2b4d-428c-98f8-3be802cc5264]
/, segment:0 -> SUCCESS @ /
  /playlist, segment:1 -> SUCCESS @ /playlist
    /playlist/{uuid}, segment:2 -> SUCCESS; Parameters [uuid=[a55fdab9-2b4d-428c-98f8-3be802cc5264]] @ /playlist/{uuid}
      /playlist/{uuid}/(method:GET), segment:2 -> SUCCESS @ /playlist/{uuid}/(method:GET)
      /playlist/{uuid}/(method:POST), segment:2 -> FAILURE "Selector didn't match" @ /playlist/{uuid}/(method:POST)
Matched routes:
  "" -> "playlist" -> "{uuid}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [uuid=[a55fdab9-2b4d-428c-98f8-3be802cc5264]] @ /playlist/{uuid}/(method:GET)
2026-05-15 15:57:49.908 [Test worker @coroutine#231] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36821/playlist/a55fdab9-2b4d-428c-98f8-3be802cc5264
2026-05-15 15:57:49.908 [Test worker @coroutine#231] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36821/playlist/a55fdab9-2b4d-428c-98f8-3be802cc5264
2026-05-15 15:57:49.908 [Test worker @coroutine#231] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36821/playlist/a55fdab9-2b4d-428c-98f8-3be802cc5264
2026-05-15 15:57:49.909 [Test worker @coroutine#231] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsFeed for http://localhost:36821/playlist/a55fdab9-2b4d-428c-98f8-3be802cc5264.
2026-05-15 15:57:52.152 [Test worker @coroutine#249] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 15:57:52.153 [Test worker @coroutine#249] INFO  io.ktor.server.Application - Application started in 0.038 seconds.
2026-05-15 15:57:52.154 [DefaultDispatcher-worker-2 @coroutine#258] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:42813
2026-05-15 15:57:52.193 [DefaultDispatcher-worker-10 @coroutine#256] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42813/playlist/0f830bc8-f8e1-4be3-9465-cebde53909ec
2026-05-15 15:57:52.193 [DefaultDispatcher-worker-10 @coroutine#256] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@1e5be300 for http://localhost:42813/playlist/0f830bc8-f8e1-4be3-9465-cebde53909ec
2026-05-15 15:57:52.193 [DefaultDispatcher-worker-10 @coroutine#256] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42813/playlist/0f830bc8-f8e1-4be3-9465-cebde53909ec
2026-05-15 15:57:52.193 [DefaultDispatcher-worker-10 @coroutine#256] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:42813/playlist/0f830bc8-f8e1-4be3-9465-cebde53909ec from class io.ktor.http.content.TextContent
2026-05-15 15:57:52.196 [eventLoopGroupProxy-34-1 @call-handler#266] TRACE io.ktor.server.routing.Routing - Trace for [playlist, 0f830bc8-f8e1-4be3-9465-cebde53909ec]
/, segment:0 -> SUCCESS @ /
  /playlist, segment:1 -> SUCCESS @ /playlist
    /playlist/{uuid}, segment:2 -> SUCCESS; Parameters [uuid=[0f830bc8-f8e1-4be3-9465-cebde53909ec]] @ /playlist/{uuid}
      /playlist/{uuid}/(method:GET), segment:2 -> FAILURE "Selector didn't match" @ /playlist/{uuid}/(method:GET)
      /playlist/{uuid}/(method:POST), segment:2 -> SUCCESS @ /playlist/{uuid}/(method:POST)
Matched routes:
  "" -> "playlist" -> "{uuid}" -> "(method:POST)"
Routing resolve result:
  SUCCESS; Parameters [uuid=[0f830bc8-f8e1-4be3-9465-cebde53909ec]] @ /playlist/{uuid}/(method:POST)
2026-05-15 15:57:52.196 [eventLoopGroupProxy-34-1 @call-handler#266] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(world.respect.lib.opds.model.OpdsFeed) for call /playlist/0f830bc8-f8e1-4be3-9465-cebde53909ec
2026-05-15 15:57:52.197 [DefaultDispatcher-worker-10 @call-handler#266] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the POST /playlist/0f830bc8-f8e1-4be3-9465-cebde53909ec request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-05-15 15:57:52.198 [DefaultDispatcher-worker-14 @coroutine#256] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42813/playlist/0f830bc8-f8e1-4be3-9465-cebde53909ec
2026-05-15 15:57:52.198 [DefaultDispatcher-worker-14 @coroutine#256] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42813/playlist/0f830bc8-f8e1-4be3-9465-cebde53909ec
2026-05-15 15:57:52.198 [DefaultDispatcher-worker-14 @coroutine#256] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42813/playlist/0f830bc8-f8e1-4be3-9465-cebde53909ec