2026-05-15 10:43:33.113 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 10:43:33.258 [Test worker] INFO  io.ktor.server.Application - Application started in 0.297 seconds.
2026-05-15 10:43:33.357 [DefaultDispatcher-worker-1 @coroutine#2] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:35117
2026-05-15 10:43:34.336 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35117/resources/index.json
2026-05-15 10:43:34.337 [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:35117/resources/index.json.
2026-05-15 10:43:34.337 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35117/resources/index.json
2026-05-15 10:43:34.488 [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 10:43:34.542 [DefaultDispatcher-worker-2 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35117/resources/index.json
2026-05-15 10:43:34.545 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35117/resources/index.json
2026-05-15 10:43:34.545 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35117/resources/index.json
2026-05-15 10:43:34.546 [eventLoopGroupProxy-4-1 @call-handler#12] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 63ms
2026-05-15 10:43:34.573 [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:35117/resources/index.json.
2026-05-15 10:43:34.616 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35117/resources/index.json
2026-05-15 10:43:34.616 [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:35117/resources/index.json.
2026-05-15 10:43:34.616 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35117/resources/index.json
2026-05-15 10:43:34.621 [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 10:43:34.625 [eventLoopGroupProxy-4-1 @call-handler#22] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 5ms
2026-05-15 10:43:34.626 [DefaultDispatcher-worker-4 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35117/resources/index.json
2026-05-15 10:43:34.626 [DefaultDispatcher-worker-4 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35117/resources/index.json
2026-05-15 10:43:34.626 [DefaultDispatcher-worker-4 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35117/resources/index.json
2026-05-15 10:43:36.655 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 10:43:36.656 [Test worker] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2026-05-15 10:43:36.658 [DefaultDispatcher-worker-4 @coroutine#26] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:34517
2026-05-15 10:43:36.781 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34517/resources/index.json
2026-05-15 10:43:36.781 [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:34517/resources/index.json.
2026-05-15 10:43:36.782 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34517/resources/index.json
2026-05-15 10:43:36.785 [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 10:43:36.788 [DefaultDispatcher-worker-2 @call-handler#35] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 3ms
2026-05-15 10:43:36.789 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34517/resources/index.json
2026-05-15 10:43:36.789 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34517/resources/index.json
2026-05-15 10:43:36.789 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34517/resources/index.json
2026-05-15 10:43:36.791 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsFeed for http://localhost:34517/resources/index.json.
2026-05-15 10:43:36.798 [DefaultDispatcher-worker-10 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34517/resources/index.json
2026-05-15 10:43:36.799 [DefaultDispatcher-worker-10 @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:34517/resources/index.json.
2026-05-15 10:43:36.799 [DefaultDispatcher-worker-10 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34517/resources/index.json
2026-05-15 10:43:36.801 [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 10:43:36.802 [eventLoopGroupProxy-7-1 @call-handler#45] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 2ms
2026-05-15 10:43:36.803 [DefaultDispatcher-worker-10 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34517/resources/index.json
2026-05-15 10:43:36.803 [DefaultDispatcher-worker-10 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34517/resources/index.json
2026-05-15 10:43:36.803 [DefaultDispatcher-worker-10 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34517/resources/index.json
2026-05-15 10:43:38.815 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 10:43:38.816 [Test worker] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2026-05-15 10:43:38.817 [DefaultDispatcher-worker-10 @coroutine#49] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:32967
2026-05-15 10:43:38.824 [Test worker @coroutine#55] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:32967/resources/lesson001.json
2026-05-15 10:43:38.824 [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:32967/resources/lesson001.json.
2026-05-15 10:43:38.825 [Test worker @coroutine#55] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:32967/resources/lesson001.json
2026-05-15 10:43:38.828 [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 10:43:38.830 [DefaultDispatcher-worker-5 @call-handler#59] INFO  io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 2ms
2026-05-15 10:43:38.830 [DefaultDispatcher-worker-3 @coroutine#55] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:32967/resources/lesson001.json
2026-05-15 10:43:38.831 [DefaultDispatcher-worker-4 @coroutine#55] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:32967/resources/lesson001.json
2026-05-15 10:43:38.831 [DefaultDispatcher-worker-4 @coroutine#55] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:32967/resources/lesson001.json
2026-05-15 10:43:38.834 [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:32967/resources/lesson001.json.
2026-05-15 10:43:41.249 [Test worker @coroutine#65] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 10:43:41.292 [Test worker @coroutine#65] INFO  io.ktor.server.Application - Application started in 0.2 seconds.
2026-05-15 10:43:41.295 [DefaultDispatcher-worker-4 @coroutine#74] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:42101
2026-05-15 10:43:41.308 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42101/api/school/respect/schoolpermissiongrant
2026-05-15 10:43:41.310 [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:42101/api/school/respect/schoolpermissiongrant.
2026-05-15 10:43:41.311 [Test worker @coroutine#65] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42101/api/school/respect/schoolpermissiongrant
2026-05-15 10:43:41.322 [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 10:43:41.343 [Test worker @coroutine#65] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42101/api/school/respect/schoolpermissiongrant
2026-05-15 10:43:41.344 [Test worker @coroutine#65] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42101/api/school/respect/schoolpermissiongrant
2026-05-15 10:43:41.344 [Test worker @coroutine#65] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42101/api/school/respect/schoolpermissiongrant
2026-05-15 10:43:41.346 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:42101/api/school/respect/schoolpermissiongrant.
2026-05-15 10:43:41.454 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42101/api/school/respect/person?includeRelated=false
2026-05-15 10:43:41.454 [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:42101/api/school/respect/person?includeRelated=false.
2026-05-15 10:43:41.455 [Test worker @coroutine#65] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42101/api/school/respect/person?includeRelated=false
2026-05-15 10:43:41.457 [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 10:43:41.504 [Test worker @coroutine#65] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42101/api/school/respect/person?includeRelated=false
2026-05-15 10:43:41.505 [Test worker @coroutine#65] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42101/api/school/respect/person?includeRelated=false
2026-05-15 10:43:41.505 [Test worker @coroutine#65] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42101/api/school/respect/person?includeRelated=false
2026-05-15 10:43:41.507 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:42101/api/school/respect/person?includeRelated=false.
2026-05-15 10:43:41.526 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42101/api/school/respect/person?includeRelated=false
2026-05-15 10:43:41.526 [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:42101/api/school/respect/person?includeRelated=false.
2026-05-15 10:43:41.527 [Test worker @coroutine#65] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42101/api/school/respect/person?includeRelated=false
2026-05-15 10:43:41.530 [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 10:43:41.536 [DefaultDispatcher-worker-4 @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 10:43:41.537 [Test worker @coroutine#65] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42101/api/school/respect/person?includeRelated=false
2026-05-15 10:43:41.538 [Test worker @coroutine#65] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42101/api/school/respect/person?includeRelated=false
2026-05-15 10:43:41.539 [Test worker @coroutine#65] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42101/api/school/respect/person?includeRelated=false
2026-05-15 10:43:43.665 [Test worker @coroutine#94] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 10:43:43.666 [Test worker @coroutine#94] INFO  io.ktor.server.Application - Application started in 0.04 seconds.
2026-05-15 10:43:43.667 [DefaultDispatcher-worker-4 @coroutine#103] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:42969
2026-05-15 10:43:43.668 [Test worker @coroutine#94] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42969/api/school/respect/schoolpermissiongrant
2026-05-15 10:43:43.668 [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:42969/api/school/respect/schoolpermissiongrant.
2026-05-15 10:43:43.668 [Test worker @coroutine#94] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42969/api/school/respect/schoolpermissiongrant
2026-05-15 10:43:43.670 [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 10:43:43.672 [Test worker @coroutine#94] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42969/api/school/respect/schoolpermissiongrant
2026-05-15 10:43:43.673 [Test worker @coroutine#94] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42969/api/school/respect/schoolpermissiongrant
2026-05-15 10:43:43.673 [Test worker @coroutine#94] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42969/api/school/respect/schoolpermissiongrant
2026-05-15 10:43:43.673 [Test worker @coroutine#94] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:42969/api/school/respect/schoolpermissiongrant.
2026-05-15 10:43:43.719 [DefaultDispatcher-worker-3 @coroutine#113] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42969/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 10:43:43.719 [DefaultDispatcher-worker-3 @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:42969/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2026-05-15 10:43:43.720 [DefaultDispatcher-worker-3 @coroutine#113] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42969/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 10:43:43.721 [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 10:43:43.724 [DefaultDispatcher-worker-4 @coroutine#113] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42969/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 10:43:43.724 [DefaultDispatcher-worker-4 @coroutine#113] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42969/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 10:43:43.724 [DefaultDispatcher-worker-4 @coroutine#113] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42969/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 10:43:43.725 [DefaultDispatcher-worker-4 @coroutine#113] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:42969/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2026-05-15 10:43:45.908 [Test worker @coroutine#122] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 10:43:45.911 [Test worker @coroutine#122] INFO  io.ktor.server.Application - Application started in 0.062 seconds.
2026-05-15 10:43:45.914 [DefaultDispatcher-worker-4 @coroutine#131] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:35501
2026-05-15 10:43:45.918 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35501/api/school/respect/person?includeRelated=false
2026-05-15 10:43:45.918 [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:35501/api/school/respect/person?includeRelated=false.
2026-05-15 10:43:45.918 [Test worker @coroutine#122] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35501/api/school/respect/person?includeRelated=false
2026-05-15 10:43:45.931 [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 10:43:45.943 [Test worker @coroutine#122] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35501/api/school/respect/person?includeRelated=false
2026-05-15 10:43:45.943 [Test worker @coroutine#122] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35501/api/school/respect/person?includeRelated=false
2026-05-15 10:43:45.944 [Test worker @coroutine#122] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35501/api/school/respect/person?includeRelated=false
2026-05-15 10:43:45.949 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:35501/api/school/respect/person?includeRelated=false.
2026-05-15 10:43:46.090 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35501/api/school/respect/person?since=2026-05-15T06%3A43%3A45.932187195Z&includeRelated=false
2026-05-15 10:43:46.090 [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:35501/api/school/respect/person?since=2026-05-15T06%3A43%3A45.932187195Z&includeRelated=false.
2026-05-15 10:43:46.090 [Test worker @coroutine#122] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35501/api/school/respect/person?since=2026-05-15T06%3A43%3A45.932187195Z&includeRelated=false
2026-05-15 10:43:46.102 [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 10:43:46.109 [Test worker @coroutine#122] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35501/api/school/respect/person?since=2026-05-15T06%3A43%3A45.932187195Z&includeRelated=false
2026-05-15 10:43:46.110 [Test worker @coroutine#122] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35501/api/school/respect/person?since=2026-05-15T06%3A43%3A45.932187195Z&includeRelated=false
2026-05-15 10:43:46.113 [Test worker @coroutine#122] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35501/api/school/respect/person?since=2026-05-15T06%3A43%3A45.932187195Z&includeRelated=false
2026-05-15 10:43:46.115 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:35501/api/school/respect/person?since=2026-05-15T06%3A43%3A45.932187195Z&includeRelated=false.
2026-05-15 10:43:48.360 [Test worker @coroutine#148] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 10:43:48.368 [Test worker @coroutine#148] INFO  io.ktor.server.Application - Application started in 0.068 seconds.
2026-05-15 10:43:48.376 [DefaultDispatcher-worker-8 @coroutine#157] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:46597
2026-05-15 10:43:48.444 [DefaultDispatcher-worker-5 @coroutine#155] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46597/api/school/respect/person
2026-05-15 10:43:48.445 [DefaultDispatcher-worker-5 @coroutine#155] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@658be5a8 for http://localhost:46597/api/school/respect/person
2026-05-15 10:43:48.445 [DefaultDispatcher-worker-5 @coroutine#155] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46597/api/school/respect/person
2026-05-15 10:43:48.445 [DefaultDispatcher-worker-5 @coroutine#155] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:46597/api/school/respect/person from class io.ktor.http.content.TextContent
2026-05-15 10:43:48.451 [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 10:43:48.459 [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 10:43:48.464 [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 10:43:48.468 [DefaultDispatcher-worker-4 @coroutine#155] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46597/api/school/respect/person
2026-05-15 10:43:48.468 [DefaultDispatcher-worker-4 @coroutine#155] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46597/api/school/respect/person
2026-05-15 10:43:48.468 [DefaultDispatcher-worker-4 @coroutine#155] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46597/api/school/respect/person
2026-05-15 10:43:50.665 [Test worker @coroutine#172] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 10:43:50.666 [Test worker @coroutine#172] INFO  io.ktor.server.Application - Application started in 0.044 seconds.
2026-05-15 10:43:50.668 [DefaultDispatcher-worker-7 @coroutine#181] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:34451
2026-05-15 10:43:50.669 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34451/api/school/respect/schoolpermissiongrant
2026-05-15 10:43:50.670 [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:34451/api/school/respect/schoolpermissiongrant.
2026-05-15 10:43:50.670 [Test worker @coroutine#172] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34451/api/school/respect/schoolpermissiongrant
2026-05-15 10:43:50.673 [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 10:43:50.675 [Test worker @coroutine#172] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34451/api/school/respect/schoolpermissiongrant
2026-05-15 10:43:50.675 [Test worker @coroutine#172] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34451/api/school/respect/schoolpermissiongrant
2026-05-15 10:43:50.676 [Test worker @coroutine#172] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34451/api/school/respect/schoolpermissiongrant
2026-05-15 10:43:50.676 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34451/api/school/respect/schoolpermissiongrant.
2026-05-15 10:43:50.746 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34451/api/school/respect/person?includeRelated=false
2026-05-15 10:43:50.746 [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:34451/api/school/respect/person?includeRelated=false.
2026-05-15 10:43:50.750 [Test worker @coroutine#172] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34451/api/school/respect/person?includeRelated=false
2026-05-15 10:43:50.753 [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 10:43:50.771 [Test worker @coroutine#172] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34451/api/school/respect/person?includeRelated=false
2026-05-15 10:43:50.771 [Test worker @coroutine#172] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34451/api/school/respect/person?includeRelated=false
2026-05-15 10:43:50.771 [Test worker @coroutine#172] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34451/api/school/respect/person?includeRelated=false
2026-05-15 10:43:50.773 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34451/api/school/respect/person?includeRelated=false.
2026-05-15 10:43:52.785 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34451/api/school/respect/person?includeRelated=false
2026-05-15 10:43:52.785 [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:34451/api/school/respect/person?includeRelated=false.
2026-05-15 10:43:52.785 [Test worker @coroutine#172] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34451/api/school/respect/person?includeRelated=false
2026-05-15 10:43:52.787 [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 10:43:52.790 [Test worker @coroutine#172] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34451/api/school/respect/person?includeRelated=false
2026-05-15 10:43:52.790 [Test worker @coroutine#172] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34451/api/school/respect/person?includeRelated=false
2026-05-15 10:43:52.790 [Test worker @coroutine#172] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34451/api/school/respect/person?includeRelated=false
2026-05-15 10:43:52.791 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34451/api/school/respect/person?includeRelated=false.
2026-05-15 10:43:54.956 [Test worker @coroutine#204] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 10:43:54.957 [Test worker @coroutine#204] INFO  io.ktor.server.Application - Application started in 0.057 seconds.
2026-05-15 10:43:54.958 [DefaultDispatcher-worker-4 @coroutine#213] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:36251
2026-05-15 10:43:54.960 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36251/api/school/respect/person?includeRelated=false
2026-05-15 10:43:54.960 [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:36251/api/school/respect/person?includeRelated=false.
2026-05-15 10:43:54.960 [Test worker @coroutine#204] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36251/api/school/respect/person?includeRelated=false
2026-05-15 10:43:54.962 [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 10:43:54.966 [Test worker @coroutine#204] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36251/api/school/respect/person?includeRelated=false
2026-05-15 10:43:54.966 [Test worker @coroutine#204] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36251/api/school/respect/person?includeRelated=false
2026-05-15 10:43:54.966 [Test worker @coroutine#204] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36251/api/school/respect/person?includeRelated=false
2026-05-15 10:43:54.967 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:36251/api/school/respect/person?includeRelated=false.
2026-05-15 10:43:55.028 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36251/api/school/respect/person?since=2026-05-15T06%3A43%3A54.963022853Z&includeRelated=false
2026-05-15 10:43:55.028 [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:36251/api/school/respect/person?since=2026-05-15T06%3A43%3A54.963022853Z&includeRelated=false.
2026-05-15 10:43:55.028 [Test worker @coroutine#204] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36251/api/school/respect/person?since=2026-05-15T06%3A43%3A54.963022853Z&includeRelated=false
2026-05-15 10:43:55.029 [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 10:43:55.032 [Test worker @coroutine#204] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36251/api/school/respect/person?since=2026-05-15T06%3A43%3A54.963022853Z&includeRelated=false
2026-05-15 10:43:55.033 [Test worker @coroutine#204] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36251/api/school/respect/person?since=2026-05-15T06%3A43%3A54.963022853Z&includeRelated=false
2026-05-15 10:43:55.033 [Test worker @coroutine#204] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36251/api/school/respect/person?since=2026-05-15T06%3A43%3A54.963022853Z&includeRelated=false
2026-05-15 10:43:55.034 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:36251/api/school/respect/person?since=2026-05-15T06%3A43%3A54.963022853Z&includeRelated=false.
2026-05-15 10:43:57.146 [Test worker @coroutine#231] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 10:43:57.147 [Test worker @coroutine#231] INFO  io.ktor.server.Application - Application started in 0.044 seconds.
2026-05-15 10:43:57.148 [DefaultDispatcher-worker-8 @coroutine#241] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:34597
2026-05-15 10:43:57.151 [Test worker @coroutine#231] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34597/playlist/378401ea-91f2-403c-b81d-fbdd694a4ba6
2026-05-15 10:43:57.151 [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:34597/playlist/378401ea-91f2-403c-b81d-fbdd694a4ba6.
2026-05-15 10:43:57.151 [Test worker @coroutine#231] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34597/playlist/378401ea-91f2-403c-b81d-fbdd694a4ba6
2026-05-15 10:43:57.162 [eventLoopGroupProxy-31-1 @call-handler#245] TRACE io.ktor.server.routing.Routing - Trace for [playlist, 378401ea-91f2-403c-b81d-fbdd694a4ba6]
/, segment:0 -> SUCCESS @ /
  /playlist, segment:1 -> SUCCESS @ /playlist
    /playlist/{uuid}, segment:2 -> SUCCESS; Parameters [uuid=[378401ea-91f2-403c-b81d-fbdd694a4ba6]] @ /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=[378401ea-91f2-403c-b81d-fbdd694a4ba6]] @ /playlist/{uuid}/(method:GET)
2026-05-15 10:43:57.179 [Test worker @coroutine#231] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34597/playlist/378401ea-91f2-403c-b81d-fbdd694a4ba6
2026-05-15 10:43:57.180 [Test worker @coroutine#231] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34597/playlist/378401ea-91f2-403c-b81d-fbdd694a4ba6
2026-05-15 10:43:57.180 [Test worker @coroutine#231] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34597/playlist/378401ea-91f2-403c-b81d-fbdd694a4ba6
2026-05-15 10:43:57.182 [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:34597/playlist/378401ea-91f2-403c-b81d-fbdd694a4ba6.
2026-05-15 10:43:59.332 [Test worker @coroutine#249] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 10:43:59.333 [Test worker @coroutine#249] INFO  io.ktor.server.Application - Application started in 0.04 seconds.
2026-05-15 10:43:59.334 [DefaultDispatcher-worker-3 @coroutine#258] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:45247
2026-05-15 10:43:59.374 [DefaultDispatcher-worker-3 @coroutine#256] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45247/playlist/cfe67b5d-0ea3-4865-8bc9-79734d4ebc6d
2026-05-15 10:43:59.374 [DefaultDispatcher-worker-3 @coroutine#256] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@11f74f89 for http://localhost:45247/playlist/cfe67b5d-0ea3-4865-8bc9-79734d4ebc6d
2026-05-15 10:43:59.374 [DefaultDispatcher-worker-3 @coroutine#256] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45247/playlist/cfe67b5d-0ea3-4865-8bc9-79734d4ebc6d
2026-05-15 10:43:59.374 [DefaultDispatcher-worker-3 @coroutine#256] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:45247/playlist/cfe67b5d-0ea3-4865-8bc9-79734d4ebc6d from class io.ktor.http.content.TextContent
2026-05-15 10:43:59.377 [eventLoopGroupProxy-34-1 @call-handler#266] TRACE io.ktor.server.routing.Routing - Trace for [playlist, cfe67b5d-0ea3-4865-8bc9-79734d4ebc6d]
/, segment:0 -> SUCCESS @ /
  /playlist, segment:1 -> SUCCESS @ /playlist
    /playlist/{uuid}, segment:2 -> SUCCESS; Parameters [uuid=[cfe67b5d-0ea3-4865-8bc9-79734d4ebc6d]] @ /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=[cfe67b5d-0ea3-4865-8bc9-79734d4ebc6d]] @ /playlist/{uuid}/(method:POST)
2026-05-15 10:43:59.377 [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/cfe67b5d-0ea3-4865-8bc9-79734d4ebc6d
2026-05-15 10:43:59.378 [DefaultDispatcher-worker-3 @call-handler#266] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the POST /playlist/cfe67b5d-0ea3-4865-8bc9-79734d4ebc6d request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-05-15 10:43:59.379 [DefaultDispatcher-worker-6 @coroutine#256] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45247/playlist/cfe67b5d-0ea3-4865-8bc9-79734d4ebc6d
2026-05-15 10:43:59.379 [DefaultDispatcher-worker-6 @coroutine#256] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45247/playlist/cfe67b5d-0ea3-4865-8bc9-79734d4ebc6d
2026-05-15 10:43:59.379 [DefaultDispatcher-worker-6 @coroutine#256] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45247/playlist/cfe67b5d-0ea3-4865-8bc9-79734d4ebc6d
2026-05-15 11:14:41.109 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 11:14:41.287 [Test worker] INFO  io.ktor.server.Application - Application started in 0.369 seconds.
2026-05-15 11:14:41.417 [DefaultDispatcher-worker-1 @coroutine#2] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:42525
2026-05-15 11:14:42.510 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42525/resources/index.json
2026-05-15 11:14:42.511 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:42525/resources/index.json.
2026-05-15 11:14:42.511 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42525/resources/index.json
2026-05-15 11:14:42.681 [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:14:42.757 [DefaultDispatcher-worker-3 @call-handler#12] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 82ms
2026-05-15 11:14:42.763 [DefaultDispatcher-worker-2 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42525/resources/index.json
2026-05-15 11:14:42.765 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42525/resources/index.json
2026-05-15 11:14:42.766 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42525/resources/index.json
2026-05-15 11:14:42.798 [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:42525/resources/index.json.
2026-05-15 11:14:42.843 [DefaultDispatcher-worker-8 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42525/resources/index.json
2026-05-15 11:14:42.843 [DefaultDispatcher-worker-8 @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:42525/resources/index.json.
2026-05-15 11:14:42.843 [DefaultDispatcher-worker-8 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42525/resources/index.json
2026-05-15 11:14:42.847 [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:14:42.849 [eventLoopGroupProxy-4-1 @call-handler#22] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 3ms
2026-05-15 11:14:42.852 [DefaultDispatcher-worker-9 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42525/resources/index.json
2026-05-15 11:14:42.853 [DefaultDispatcher-worker-9 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42525/resources/index.json
2026-05-15 11:14:42.853 [DefaultDispatcher-worker-9 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42525/resources/index.json
2026-05-15 11:14:44.889 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 11:14:44.890 [Test worker] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2026-05-15 11:14:44.891 [DefaultDispatcher-worker-9 @coroutine#26] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:46063
2026-05-15 11:14:44.951 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46063/resources/index.json
2026-05-15 11:14:44.951 [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:46063/resources/index.json.
2026-05-15 11:14:44.951 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46063/resources/index.json
2026-05-15 11:14:44.954 [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:14:44.955 [DefaultDispatcher-worker-10 @call-handler#35] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 1ms
2026-05-15 11:14:44.956 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46063/resources/index.json
2026-05-15 11:14:44.956 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46063/resources/index.json
2026-05-15 11:14:44.956 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46063/resources/index.json
2026-05-15 11:14:44.957 [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:46063/resources/index.json.
2026-05-15 11:14:44.961 [DefaultDispatcher-worker-8 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46063/resources/index.json
2026-05-15 11:14:44.961 [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:46063/resources/index.json.
2026-05-15 11:14:44.961 [DefaultDispatcher-worker-8 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46063/resources/index.json
2026-05-15 11:14:44.977 [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:14:44.981 [eventLoopGroupProxy-7-1 @call-handler#45] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 5ms
2026-05-15 11:14:44.982 [DefaultDispatcher-worker-8 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46063/resources/index.json
2026-05-15 11:14:44.983 [DefaultDispatcher-worker-8 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46063/resources/index.json
2026-05-15 11:14:44.983 [DefaultDispatcher-worker-8 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46063/resources/index.json
2026-05-15 11:14:47.007 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 11:14:47.008 [Test worker] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2026-05-15 11:14:47.018 [DefaultDispatcher-worker-8 @coroutine#49] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:44401
2026-05-15 11:14:47.031 [Test worker @coroutine#55] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44401/resources/lesson001.json
2026-05-15 11:14:47.031 [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:44401/resources/lesson001.json.
2026-05-15 11:14:47.031 [Test worker @coroutine#55] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44401/resources/lesson001.json
2026-05-15 11:14:47.035 [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:14:47.036 [DefaultDispatcher-worker-10 @call-handler#59] INFO  io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 1ms
2026-05-15 11:14:47.037 [DefaultDispatcher-worker-10 @coroutine#55] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44401/resources/lesson001.json
2026-05-15 11:14:47.037 [DefaultDispatcher-worker-10 @coroutine#55] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44401/resources/lesson001.json
2026-05-15 11:14:47.037 [DefaultDispatcher-worker-10 @coroutine#55] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44401/resources/lesson001.json
2026-05-15 11:14:47.041 [DefaultDispatcher-worker-10 @coroutine#55] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class kotlinx.serialization.json.JsonObject for http://localhost:44401/resources/lesson001.json.
2026-05-15 11:14:49.260 [Test worker @coroutine#65] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 11:14:49.269 [Test worker @coroutine#65] INFO  io.ktor.server.Application - Application started in 0.106 seconds.
2026-05-15 11:14:49.271 [DefaultDispatcher-worker-2 @coroutine#74] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:44349
2026-05-15 11:14:49.279 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44349/api/school/respect/schoolpermissiongrant
2026-05-15 11:14:49.280 [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:44349/api/school/respect/schoolpermissiongrant.
2026-05-15 11:14:49.280 [Test worker @coroutine#65] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44349/api/school/respect/schoolpermissiongrant
2026-05-15 11:14:49.285 [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:14:49.297 [Test worker @coroutine#65] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44349/api/school/respect/schoolpermissiongrant
2026-05-15 11:14:49.297 [Test worker @coroutine#65] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44349/api/school/respect/schoolpermissiongrant
2026-05-15 11:14:49.297 [Test worker @coroutine#65] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44349/api/school/respect/schoolpermissiongrant
2026-05-15 11:14:49.299 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44349/api/school/respect/schoolpermissiongrant.
2026-05-15 11:14:49.371 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44349/api/school/respect/person?includeRelated=false
2026-05-15 11:14:49.371 [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:44349/api/school/respect/person?includeRelated=false.
2026-05-15 11:14:49.371 [Test worker @coroutine#65] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44349/api/school/respect/person?includeRelated=false
2026-05-15 11:14:49.373 [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:14:49.389 [Test worker @coroutine#65] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44349/api/school/respect/person?includeRelated=false
2026-05-15 11:14:49.390 [Test worker @coroutine#65] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44349/api/school/respect/person?includeRelated=false
2026-05-15 11:14:49.390 [Test worker @coroutine#65] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44349/api/school/respect/person?includeRelated=false
2026-05-15 11:14:49.391 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44349/api/school/respect/person?includeRelated=false.
2026-05-15 11:14:49.396 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44349/api/school/respect/person?includeRelated=false
2026-05-15 11:14:49.397 [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:44349/api/school/respect/person?includeRelated=false.
2026-05-15 11:14:49.397 [Test worker @coroutine#65] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44349/api/school/respect/person?includeRelated=false
2026-05-15 11:14:49.398 [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:14:49.401 [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 11:14:49.401 [Test worker @coroutine#65] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44349/api/school/respect/person?includeRelated=false
2026-05-15 11:14:49.402 [Test worker @coroutine#65] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44349/api/school/respect/person?includeRelated=false
2026-05-15 11:14:49.402 [Test worker @coroutine#65] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44349/api/school/respect/person?includeRelated=false
2026-05-15 11:14:51.560 [Test worker @coroutine#94] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 11:14:51.561 [Test worker @coroutine#94] INFO  io.ktor.server.Application - Application started in 0.058 seconds.
2026-05-15 11:14:51.563 [DefaultDispatcher-worker-2 @coroutine#103] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:41495
2026-05-15 11:14:51.564 [Test worker @coroutine#94] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41495/api/school/respect/schoolpermissiongrant
2026-05-15 11:14:51.564 [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:41495/api/school/respect/schoolpermissiongrant.
2026-05-15 11:14:51.564 [Test worker @coroutine#94] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41495/api/school/respect/schoolpermissiongrant
2026-05-15 11:14:51.568 [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:14:51.570 [Test worker @coroutine#94] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41495/api/school/respect/schoolpermissiongrant
2026-05-15 11:14:51.571 [Test worker @coroutine#94] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41495/api/school/respect/schoolpermissiongrant
2026-05-15 11:14:51.571 [Test worker @coroutine#94] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41495/api/school/respect/schoolpermissiongrant
2026-05-15 11:14:51.571 [Test worker @coroutine#94] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41495/api/school/respect/schoolpermissiongrant.
2026-05-15 11:14:51.618 [DefaultDispatcher-worker-8 @coroutine#113] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41495/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 11:14:51.618 [DefaultDispatcher-worker-8 @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:41495/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2026-05-15 11:14:51.618 [DefaultDispatcher-worker-8 @coroutine#113] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41495/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 11:14:51.620 [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:14:51.623 [DefaultDispatcher-worker-10 @coroutine#113] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41495/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 11:14:51.623 [DefaultDispatcher-worker-10 @coroutine#113] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41495/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 11:14:51.623 [DefaultDispatcher-worker-10 @coroutine#113] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41495/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 11:14:51.624 [DefaultDispatcher-worker-10 @coroutine#113] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41495/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2026-05-15 11:14:53.755 [Test worker @coroutine#122] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 11:14:53.756 [Test worker @coroutine#122] INFO  io.ktor.server.Application - Application started in 0.041 seconds.
2026-05-15 11:14:53.757 [DefaultDispatcher-worker-9 @coroutine#131] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:43867
2026-05-15 11:14:53.759 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43867/api/school/respect/person?includeRelated=false
2026-05-15 11:14:53.759 [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:43867/api/school/respect/person?includeRelated=false.
2026-05-15 11:14:53.759 [Test worker @coroutine#122] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43867/api/school/respect/person?includeRelated=false
2026-05-15 11:14:53.762 [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:14:53.765 [Test worker @coroutine#122] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43867/api/school/respect/person?includeRelated=false
2026-05-15 11:14:53.765 [Test worker @coroutine#122] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43867/api/school/respect/person?includeRelated=false
2026-05-15 11:14:53.765 [Test worker @coroutine#122] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43867/api/school/respect/person?includeRelated=false
2026-05-15 11:14:53.766 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:43867/api/school/respect/person?includeRelated=false.
2026-05-15 11:14:53.825 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43867/api/school/respect/person?since=2026-05-15T07%3A14%3A53.762715117Z&includeRelated=false
2026-05-15 11:14:53.825 [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:43867/api/school/respect/person?since=2026-05-15T07%3A14%3A53.762715117Z&includeRelated=false.
2026-05-15 11:14:53.825 [Test worker @coroutine#122] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43867/api/school/respect/person?since=2026-05-15T07%3A14%3A53.762715117Z&includeRelated=false
2026-05-15 11:14:53.827 [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:14:53.829 [Test worker @coroutine#122] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43867/api/school/respect/person?since=2026-05-15T07%3A14%3A53.762715117Z&includeRelated=false
2026-05-15 11:14:53.829 [Test worker @coroutine#122] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43867/api/school/respect/person?since=2026-05-15T07%3A14%3A53.762715117Z&includeRelated=false
2026-05-15 11:14:53.829 [Test worker @coroutine#122] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43867/api/school/respect/person?since=2026-05-15T07%3A14%3A53.762715117Z&includeRelated=false
2026-05-15 11:14:53.830 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:43867/api/school/respect/person?since=2026-05-15T07%3A14%3A53.762715117Z&includeRelated=false.
2026-05-15 11:14:55.955 [Test worker @coroutine#148] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 11:14:55.956 [Test worker @coroutine#148] INFO  io.ktor.server.Application - Application started in 0.04 seconds.
2026-05-15 11:14:55.957 [DefaultDispatcher-worker-9 @coroutine#157] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:43659
2026-05-15 11:14:56.000 [DefaultDispatcher-worker-2 @coroutine#155] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43659/api/school/respect/person
2026-05-15 11:14:56.000 [DefaultDispatcher-worker-2 @coroutine#155] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@470c5b11 for http://localhost:43659/api/school/respect/person
2026-05-15 11:14:56.000 [DefaultDispatcher-worker-2 @coroutine#155] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43659/api/school/respect/person
2026-05-15 11:14:56.001 [DefaultDispatcher-worker-2 @coroutine#155] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:43659/api/school/respect/person from class io.ktor.http.content.TextContent
2026-05-15 11:14:56.004 [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:14:56.009 [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:14:56.011 [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 11:14:56.012 [DefaultDispatcher-worker-2 @coroutine#155] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43659/api/school/respect/person
2026-05-15 11:14:56.012 [DefaultDispatcher-worker-2 @coroutine#155] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43659/api/school/respect/person
2026-05-15 11:14:56.012 [DefaultDispatcher-worker-2 @coroutine#155] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43659/api/school/respect/person
2026-05-15 11:14:58.131 [Test worker @coroutine#172] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 11:14:58.132 [Test worker @coroutine#172] INFO  io.ktor.server.Application - Application started in 0.045 seconds.
2026-05-15 11:14:58.133 [DefaultDispatcher-worker-10 @coroutine#181] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:35145
2026-05-15 11:14:58.134 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35145/api/school/respect/schoolpermissiongrant
2026-05-15 11:14:58.134 [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:35145/api/school/respect/schoolpermissiongrant.
2026-05-15 11:14:58.134 [Test worker @coroutine#172] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35145/api/school/respect/schoolpermissiongrant
2026-05-15 11:14:58.137 [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:14:58.139 [Test worker @coroutine#172] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35145/api/school/respect/schoolpermissiongrant
2026-05-15 11:14:58.139 [Test worker @coroutine#172] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35145/api/school/respect/schoolpermissiongrant
2026-05-15 11:14:58.139 [Test worker @coroutine#172] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35145/api/school/respect/schoolpermissiongrant
2026-05-15 11:14:58.139 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:35145/api/school/respect/schoolpermissiongrant.
2026-05-15 11:14:58.190 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35145/api/school/respect/person?includeRelated=false
2026-05-15 11:14:58.190 [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:35145/api/school/respect/person?includeRelated=false.
2026-05-15 11:14:58.190 [Test worker @coroutine#172] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35145/api/school/respect/person?includeRelated=false
2026-05-15 11:14:58.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:14:58.198 [Test worker @coroutine#172] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35145/api/school/respect/person?includeRelated=false
2026-05-15 11:14:58.198 [Test worker @coroutine#172] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35145/api/school/respect/person?includeRelated=false
2026-05-15 11:14:58.198 [Test worker @coroutine#172] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35145/api/school/respect/person?includeRelated=false
2026-05-15 11:14:58.199 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:35145/api/school/respect/person?includeRelated=false.
2026-05-15 11:15:00.204 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35145/api/school/respect/person?includeRelated=false
2026-05-15 11:15:00.204 [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:35145/api/school/respect/person?includeRelated=false.
2026-05-15 11:15:00.204 [Test worker @coroutine#172] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35145/api/school/respect/person?includeRelated=false
2026-05-15 11:15:00.205 [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:15:00.208 [Test worker @coroutine#172] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35145/api/school/respect/person?includeRelated=false
2026-05-15 11:15:00.208 [Test worker @coroutine#172] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35145/api/school/respect/person?includeRelated=false
2026-05-15 11:15:00.208 [Test worker @coroutine#172] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35145/api/school/respect/person?includeRelated=false
2026-05-15 11:15:00.209 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:35145/api/school/respect/person?includeRelated=false.
2026-05-15 11:15:02.365 [Test worker @coroutine#204] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 11:15:02.366 [Test worker @coroutine#204] INFO  io.ktor.server.Application - Application started in 0.081 seconds.
2026-05-15 11:15:02.369 [DefaultDispatcher-worker-9 @coroutine#213] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:44689
2026-05-15 11:15:02.376 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44689/api/school/respect/person?includeRelated=false
2026-05-15 11:15:02.377 [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:44689/api/school/respect/person?includeRelated=false.
2026-05-15 11:15:02.377 [Test worker @coroutine#204] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44689/api/school/respect/person?includeRelated=false
2026-05-15 11:15:02.381 [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:15:02.391 [Test worker @coroutine#204] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44689/api/school/respect/person?includeRelated=false
2026-05-15 11:15:02.391 [Test worker @coroutine#204] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44689/api/school/respect/person?includeRelated=false
2026-05-15 11:15:02.391 [Test worker @coroutine#204] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44689/api/school/respect/person?includeRelated=false
2026-05-15 11:15:02.395 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44689/api/school/respect/person?includeRelated=false.
2026-05-15 11:15:02.451 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44689/api/school/respect/person?since=2026-05-15T07%3A15%3A02.382688063Z&includeRelated=false
2026-05-15 11:15:02.451 [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:44689/api/school/respect/person?since=2026-05-15T07%3A15%3A02.382688063Z&includeRelated=false.
2026-05-15 11:15:02.451 [Test worker @coroutine#204] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44689/api/school/respect/person?since=2026-05-15T07%3A15%3A02.382688063Z&includeRelated=false
2026-05-15 11:15:02.453 [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:15:02.457 [Test worker @coroutine#204] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44689/api/school/respect/person?since=2026-05-15T07%3A15%3A02.382688063Z&includeRelated=false
2026-05-15 11:15:02.457 [Test worker @coroutine#204] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44689/api/school/respect/person?since=2026-05-15T07%3A15%3A02.382688063Z&includeRelated=false
2026-05-15 11:15:02.457 [Test worker @coroutine#204] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44689/api/school/respect/person?since=2026-05-15T07%3A15%3A02.382688063Z&includeRelated=false
2026-05-15 11:15:02.458 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44689/api/school/respect/person?since=2026-05-15T07%3A15%3A02.382688063Z&includeRelated=false.
2026-05-15 11:15:04.693 [Test worker @coroutine#231] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 11:15:04.696 [Test worker @coroutine#231] INFO  io.ktor.server.Application - Application started in 0.077 seconds.
2026-05-15 11:15:04.700 [DefaultDispatcher-worker-10 @coroutine#241] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:39749
2026-05-15 11:15:04.704 [Test worker @coroutine#231] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39749/playlist/51589783-7a16-4555-9620-5fcf35b54cb3
2026-05-15 11:15:04.704 [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:39749/playlist/51589783-7a16-4555-9620-5fcf35b54cb3.
2026-05-15 11:15:04.704 [Test worker @coroutine#231] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39749/playlist/51589783-7a16-4555-9620-5fcf35b54cb3
2026-05-15 11:15:04.715 [eventLoopGroupProxy-31-1 @call-handler#245] TRACE io.ktor.server.routing.Routing - Trace for [playlist, 51589783-7a16-4555-9620-5fcf35b54cb3]
/, segment:0 -> SUCCESS @ /
  /playlist, segment:1 -> SUCCESS @ /playlist
    /playlist/{uuid}, segment:2 -> SUCCESS; Parameters [uuid=[51589783-7a16-4555-9620-5fcf35b54cb3]] @ /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=[51589783-7a16-4555-9620-5fcf35b54cb3]] @ /playlist/{uuid}/(method:GET)
2026-05-15 11:15:04.736 [Test worker @coroutine#231] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39749/playlist/51589783-7a16-4555-9620-5fcf35b54cb3
2026-05-15 11:15:04.736 [Test worker @coroutine#231] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39749/playlist/51589783-7a16-4555-9620-5fcf35b54cb3
2026-05-15 11:15:04.736 [Test worker @coroutine#231] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39749/playlist/51589783-7a16-4555-9620-5fcf35b54cb3
2026-05-15 11:15:04.737 [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:39749/playlist/51589783-7a16-4555-9620-5fcf35b54cb3.
2026-05-15 11:15:07.083 [Test worker @coroutine#249] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 11:15:07.084 [Test worker @coroutine#249] INFO  io.ktor.server.Application - Application started in 0.185 seconds.
2026-05-15 11:15:07.085 [DefaultDispatcher-worker-2 @coroutine#258] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:41431
2026-05-15 11:15:07.204 [DefaultDispatcher-worker-2 @coroutine#256] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41431/playlist/6f9b3335-79d0-4afa-af33-90c3c784537b
2026-05-15 11:15:07.205 [DefaultDispatcher-worker-2 @coroutine#256] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@258cd15f for http://localhost:41431/playlist/6f9b3335-79d0-4afa-af33-90c3c784537b
2026-05-15 11:15:07.205 [DefaultDispatcher-worker-2 @coroutine#256] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41431/playlist/6f9b3335-79d0-4afa-af33-90c3c784537b
2026-05-15 11:15:07.205 [DefaultDispatcher-worker-2 @coroutine#256] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:41431/playlist/6f9b3335-79d0-4afa-af33-90c3c784537b from class io.ktor.http.content.TextContent
2026-05-15 11:15:07.207 [eventLoopGroupProxy-34-1 @call-handler#266] TRACE io.ktor.server.routing.Routing - Trace for [playlist, 6f9b3335-79d0-4afa-af33-90c3c784537b]
/, segment:0 -> SUCCESS @ /
  /playlist, segment:1 -> SUCCESS @ /playlist
    /playlist/{uuid}, segment:2 -> SUCCESS; Parameters [uuid=[6f9b3335-79d0-4afa-af33-90c3c784537b]] @ /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=[6f9b3335-79d0-4afa-af33-90c3c784537b]] @ /playlist/{uuid}/(method:POST)
2026-05-15 11:15:07.208 [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/6f9b3335-79d0-4afa-af33-90c3c784537b
2026-05-15 11:15:07.209 [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/6f9b3335-79d0-4afa-af33-90c3c784537b request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-05-15 11:15:07.210 [DefaultDispatcher-worker-1 @coroutine#256] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41431/playlist/6f9b3335-79d0-4afa-af33-90c3c784537b
2026-05-15 11:15:07.210 [DefaultDispatcher-worker-1 @coroutine#256] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41431/playlist/6f9b3335-79d0-4afa-af33-90c3c784537b
2026-05-15 11:15:07.210 [DefaultDispatcher-worker-1 @coroutine#256] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41431/playlist/6f9b3335-79d0-4afa-af33-90c3c784537b
2026-05-15 14:24:09.800 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 14:24:09.934 [Test worker] INFO  io.ktor.server.Application - Application started in 0.316 seconds.
2026-05-15 14:24:10.019 [DefaultDispatcher-worker-1 @coroutine#2] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:44293
2026-05-15 14:24:10.885 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44293/resources/index.json
2026-05-15 14:24:10.886 [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:44293/resources/index.json.
2026-05-15 14:24:10.886 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44293/resources/index.json
2026-05-15 14:24:11.051 [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:24:11.128 [DefaultDispatcher-worker-1 @call-handler#12] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 84ms
2026-05-15 14:24:11.135 [DefaultDispatcher-worker-4 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44293/resources/index.json
2026-05-15 14:24:11.138 [DefaultDispatcher-worker-4 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44293/resources/index.json
2026-05-15 14:24:11.138 [DefaultDispatcher-worker-4 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44293/resources/index.json
2026-05-15 14:24:11.162 [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:44293/resources/index.json.
2026-05-15 14:24:11.198 [DefaultDispatcher-worker-4 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44293/resources/index.json
2026-05-15 14:24:11.198 [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:44293/resources/index.json.
2026-05-15 14:24:11.199 [DefaultDispatcher-worker-4 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44293/resources/index.json
2026-05-15 14:24:11.202 [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:24:11.204 [eventLoopGroupProxy-4-1 @call-handler#22] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 2ms
2026-05-15 14:24:11.205 [DefaultDispatcher-worker-4 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44293/resources/index.json
2026-05-15 14:24:11.205 [DefaultDispatcher-worker-4 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44293/resources/index.json
2026-05-15 14:24:11.205 [DefaultDispatcher-worker-4 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44293/resources/index.json
2026-05-15 14:24:12.216 [eventLoopGroupProxy-3-1] WARN  i.n.u.c.AbstractEventExecutor - A task raised an exception. Task: io.netty.channel.AbstractChannel$AbstractUnsafe$8@51cdac86
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 14:24:13.226 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 14:24:13.227 [Test worker] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2026-05-15 14:24:13.230 [DefaultDispatcher-worker-4 @coroutine#26] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:37967
2026-05-15 14:24:13.294 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37967/resources/index.json
2026-05-15 14:24:13.295 [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:37967/resources/index.json.
2026-05-15 14:24:13.295 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37967/resources/index.json
2026-05-15 14:24:13.299 [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:24:13.301 [DefaultDispatcher-worker-7 @call-handler#35] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 3ms
2026-05-15 14:24:13.302 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37967/resources/index.json
2026-05-15 14:24:13.303 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37967/resources/index.json
2026-05-15 14:24:13.304 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37967/resources/index.json
2026-05-15 14:24:13.305 [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:37967/resources/index.json.
2026-05-15 14:24:13.313 [DefaultDispatcher-worker-7 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37967/resources/index.json
2026-05-15 14:24:13.314 [DefaultDispatcher-worker-7 @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:37967/resources/index.json.
2026-05-15 14:24:13.314 [DefaultDispatcher-worker-7 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37967/resources/index.json
2026-05-15 14:24:13.317 [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:24:13.318 [eventLoopGroupProxy-7-1 @call-handler#45] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms
2026-05-15 14:24:13.319 [DefaultDispatcher-worker-8 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37967/resources/index.json
2026-05-15 14:24:13.319 [DefaultDispatcher-worker-8 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37967/resources/index.json
2026-05-15 14:24:13.319 [DefaultDispatcher-worker-8 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37967/resources/index.json
2026-05-15 14:24:15.346 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 14:24:15.347 [Test worker] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2026-05-15 14:24:15.350 [DefaultDispatcher-worker-7 @coroutine#49] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:38425
2026-05-15 14:24:15.356 [Test worker @coroutine#55] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38425/resources/lesson001.json
2026-05-15 14:24:15.357 [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:38425/resources/lesson001.json.
2026-05-15 14:24:15.357 [Test worker @coroutine#55] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38425/resources/lesson001.json
2026-05-15 14:24:15.361 [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:24:15.363 [DefaultDispatcher-worker-7 @call-handler#59] INFO  io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 2ms
2026-05-15 14:24:15.364 [DefaultDispatcher-worker-2 @coroutine#55] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38425/resources/lesson001.json
2026-05-15 14:24:15.365 [DefaultDispatcher-worker-2 @coroutine#55] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38425/resources/lesson001.json
2026-05-15 14:24:15.365 [DefaultDispatcher-worker-2 @coroutine#55] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38425/resources/lesson001.json
2026-05-15 14:24:15.368 [DefaultDispatcher-worker-2 @coroutine#55] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class kotlinx.serialization.json.JsonObject for http://localhost:38425/resources/lesson001.json.
2026-05-15 14:24:18.022 [Test worker @coroutine#65] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 14:24:18.040 [Test worker @coroutine#65] INFO  io.ktor.server.Application - Application started in 0.386 seconds.
2026-05-15 14:24:18.046 [DefaultDispatcher-worker-2 @coroutine#74] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:39267
2026-05-15 14:24:18.088 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39267/api/school/respect/schoolpermissiongrant
2026-05-15 14:24:18.088 [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:39267/api/school/respect/schoolpermissiongrant.
2026-05-15 14:24:18.089 [Test worker @coroutine#65] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39267/api/school/respect/schoolpermissiongrant
2026-05-15 14:24:18.124 [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:24:18.178 [Test worker @coroutine#65] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39267/api/school/respect/schoolpermissiongrant
2026-05-15 14:24:18.179 [Test worker @coroutine#65] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39267/api/school/respect/schoolpermissiongrant
2026-05-15 14:24:18.179 [Test worker @coroutine#65] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39267/api/school/respect/schoolpermissiongrant
2026-05-15 14:24:18.185 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:39267/api/school/respect/schoolpermissiongrant.
2026-05-15 14:24:18.369 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39267/api/school/respect/person?includeRelated=false
2026-05-15 14:24:18.370 [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:39267/api/school/respect/person?includeRelated=false.
2026-05-15 14:24:18.370 [Test worker @coroutine#65] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39267/api/school/respect/person?includeRelated=false
2026-05-15 14:24:18.377 [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:24:18.438 [Test worker @coroutine#65] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39267/api/school/respect/person?includeRelated=false
2026-05-15 14:24:18.439 [Test worker @coroutine#65] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39267/api/school/respect/person?includeRelated=false
2026-05-15 14:24:18.439 [Test worker @coroutine#65] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39267/api/school/respect/person?includeRelated=false
2026-05-15 14:24:18.441 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:39267/api/school/respect/person?includeRelated=false.
2026-05-15 14:24:18.480 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39267/api/school/respect/person?includeRelated=false
2026-05-15 14:24:18.481 [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:39267/api/school/respect/person?includeRelated=false.
2026-05-15 14:24:18.481 [Test worker @coroutine#65] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39267/api/school/respect/person?includeRelated=false
2026-05-15 14:24:18.484 [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:24:18.487 [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:24:18.492 [Test worker @coroutine#65] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39267/api/school/respect/person?includeRelated=false
2026-05-15 14:24:18.492 [Test worker @coroutine#65] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39267/api/school/respect/person?includeRelated=false
2026-05-15 14:24:18.492 [Test worker @coroutine#65] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39267/api/school/respect/person?includeRelated=false
2026-05-15 14:24:20.641 [Test worker @coroutine#94] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 14:24:20.642 [Test worker @coroutine#94] INFO  io.ktor.server.Application - Application started in 0.058 seconds.
2026-05-15 14:24:20.650 [DefaultDispatcher-worker-1 @coroutine#103] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:33789
2026-05-15 14:24:20.653 [Test worker @coroutine#94] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33789/api/school/respect/schoolpermissiongrant
2026-05-15 14:24:20.653 [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:33789/api/school/respect/schoolpermissiongrant.
2026-05-15 14:24:20.653 [Test worker @coroutine#94] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33789/api/school/respect/schoolpermissiongrant
2026-05-15 14:24:20.663 [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:24:20.668 [Test worker @coroutine#94] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33789/api/school/respect/schoolpermissiongrant
2026-05-15 14:24:20.668 [Test worker @coroutine#94] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33789/api/school/respect/schoolpermissiongrant
2026-05-15 14:24:20.668 [Test worker @coroutine#94] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33789/api/school/respect/schoolpermissiongrant
2026-05-15 14:24:20.669 [Test worker @coroutine#94] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:33789/api/school/respect/schoolpermissiongrant.
2026-05-15 14:24:20.725 [DefaultDispatcher-worker-1 @coroutine#113] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33789/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 14:24:20.726 [DefaultDispatcher-worker-1 @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:33789/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2026-05-15 14:24:20.726 [DefaultDispatcher-worker-1 @coroutine#113] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33789/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 14:24:20.728 [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:24:20.732 [DefaultDispatcher-worker-8 @coroutine#113] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33789/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 14:24:20.732 [DefaultDispatcher-worker-8 @coroutine#113] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33789/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 14:24:20.732 [DefaultDispatcher-worker-8 @coroutine#113] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33789/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 14:24:20.733 [DefaultDispatcher-worker-8 @coroutine#113] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:33789/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2026-05-15 14:24:22.862 [Test worker @coroutine#122] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 14:24:22.864 [Test worker @coroutine#122] INFO  io.ktor.server.Application - Application started in 0.042 seconds.
2026-05-15 14:24:22.866 [DefaultDispatcher-worker-7 @coroutine#131] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:41509
2026-05-15 14:24:22.873 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41509/api/school/respect/person?includeRelated=false
2026-05-15 14:24:22.874 [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:41509/api/school/respect/person?includeRelated=false.
2026-05-15 14:24:22.874 [Test worker @coroutine#122] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41509/api/school/respect/person?includeRelated=false
2026-05-15 14:24:22.880 [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:24:22.887 [Test worker @coroutine#122] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41509/api/school/respect/person?includeRelated=false
2026-05-15 14:24:22.889 [Test worker @coroutine#122] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41509/api/school/respect/person?includeRelated=false
2026-05-15 14:24:22.889 [Test worker @coroutine#122] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41509/api/school/respect/person?includeRelated=false
2026-05-15 14:24:22.891 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41509/api/school/respect/person?includeRelated=false.
2026-05-15 14:24:22.976 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41509/api/school/respect/person?since=2026-05-15T10%3A24%3A22.880699139Z&includeRelated=false
2026-05-15 14:24:22.976 [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:41509/api/school/respect/person?since=2026-05-15T10%3A24%3A22.880699139Z&includeRelated=false.
2026-05-15 14:24:22.976 [Test worker @coroutine#122] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41509/api/school/respect/person?since=2026-05-15T10%3A24%3A22.880699139Z&includeRelated=false
2026-05-15 14:24:22.978 [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:24:22.981 [Test worker @coroutine#122] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41509/api/school/respect/person?since=2026-05-15T10%3A24%3A22.880699139Z&includeRelated=false
2026-05-15 14:24:22.981 [Test worker @coroutine#122] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41509/api/school/respect/person?since=2026-05-15T10%3A24%3A22.880699139Z&includeRelated=false
2026-05-15 14:24:22.981 [Test worker @coroutine#122] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41509/api/school/respect/person?since=2026-05-15T10%3A24%3A22.880699139Z&includeRelated=false
2026-05-15 14:24:22.982 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41509/api/school/respect/person?since=2026-05-15T10%3A24%3A22.880699139Z&includeRelated=false.
2026-05-15 14:24:25.154 [Test worker @coroutine#148] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 14:24:25.155 [Test worker @coroutine#148] INFO  io.ktor.server.Application - Application started in 0.041 seconds.
2026-05-15 14:24:25.157 [DefaultDispatcher-worker-8 @coroutine#157] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:41685
2026-05-15 14:24:25.210 [DefaultDispatcher-worker-8 @coroutine#155] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41685/api/school/respect/person
2026-05-15 14:24:25.211 [DefaultDispatcher-worker-8 @coroutine#155] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@5fbe8b40 for http://localhost:41685/api/school/respect/person
2026-05-15 14:24:25.211 [DefaultDispatcher-worker-8 @coroutine#155] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41685/api/school/respect/person
2026-05-15 14:24:25.211 [DefaultDispatcher-worker-8 @coroutine#155] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:41685/api/school/respect/person from class io.ktor.http.content.TextContent
2026-05-15 14:24:25.218 [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:24:25.226 [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:24:25.228 [DefaultDispatcher-worker-8 @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:24:25.229 [DefaultDispatcher-worker-2 @coroutine#155] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41685/api/school/respect/person
2026-05-15 14:24:25.230 [DefaultDispatcher-worker-2 @coroutine#155] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41685/api/school/respect/person
2026-05-15 14:24:25.230 [DefaultDispatcher-worker-2 @coroutine#155] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41685/api/school/respect/person
2026-05-15 14:24:27.435 [Test worker @coroutine#172] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 14:24:27.436 [Test worker @coroutine#172] INFO  io.ktor.server.Application - Application started in 0.053 seconds.
2026-05-15 14:24:27.447 [DefaultDispatcher-worker-3 @coroutine#181] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:32995
2026-05-15 14:24:27.448 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:32995/api/school/respect/schoolpermissiongrant
2026-05-15 14:24:27.448 [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:32995/api/school/respect/schoolpermissiongrant.
2026-05-15 14:24:27.448 [Test worker @coroutine#172] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:32995/api/school/respect/schoolpermissiongrant
2026-05-15 14:24:27.474 [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:24:27.477 [Test worker @coroutine#172] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:32995/api/school/respect/schoolpermissiongrant
2026-05-15 14:24:27.477 [Test worker @coroutine#172] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:32995/api/school/respect/schoolpermissiongrant
2026-05-15 14:24:27.477 [Test worker @coroutine#172] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:32995/api/school/respect/schoolpermissiongrant
2026-05-15 14:24:27.482 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:32995/api/school/respect/schoolpermissiongrant.
2026-05-15 14:24:27.526 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:32995/api/school/respect/person?includeRelated=false
2026-05-15 14:24:27.526 [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:32995/api/school/respect/person?includeRelated=false.
2026-05-15 14:24:27.527 [Test worker @coroutine#172] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:32995/api/school/respect/person?includeRelated=false
2026-05-15 14:24:27.528 [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:24:27.537 [Test worker @coroutine#172] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:32995/api/school/respect/person?includeRelated=false
2026-05-15 14:24:27.537 [Test worker @coroutine#172] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:32995/api/school/respect/person?includeRelated=false
2026-05-15 14:24:27.537 [Test worker @coroutine#172] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:32995/api/school/respect/person?includeRelated=false
2026-05-15 14:24:27.538 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:32995/api/school/respect/person?includeRelated=false.
2026-05-15 14:24:29.560 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:32995/api/school/respect/person?includeRelated=false
2026-05-15 14:24:29.560 [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:32995/api/school/respect/person?includeRelated=false.
2026-05-15 14:24:29.560 [Test worker @coroutine#172] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:32995/api/school/respect/person?includeRelated=false
2026-05-15 14:24:29.565 [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:24:29.576 [Test worker @coroutine#172] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:32995/api/school/respect/person?includeRelated=false
2026-05-15 14:24:29.576 [Test worker @coroutine#172] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:32995/api/school/respect/person?includeRelated=false
2026-05-15 14:24:29.576 [Test worker @coroutine#172] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:32995/api/school/respect/person?includeRelated=false
2026-05-15 14:24:29.578 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:32995/api/school/respect/person?includeRelated=false.
2026-05-15 14:24:31.730 [Test worker @coroutine#204] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 14:24:31.731 [Test worker @coroutine#204] INFO  io.ktor.server.Application - Application started in 0.043 seconds.
2026-05-15 14:24:31.733 [DefaultDispatcher-worker-2 @coroutine#213] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:37835
2026-05-15 14:24:31.735 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37835/api/school/respect/person?includeRelated=false
2026-05-15 14:24:31.735 [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:37835/api/school/respect/person?includeRelated=false.
2026-05-15 14:24:31.735 [Test worker @coroutine#204] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37835/api/school/respect/person?includeRelated=false
2026-05-15 14:24:31.738 [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:24:31.742 [Test worker @coroutine#204] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37835/api/school/respect/person?includeRelated=false
2026-05-15 14:24:31.742 [Test worker @coroutine#204] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37835/api/school/respect/person?includeRelated=false
2026-05-15 14:24:31.742 [Test worker @coroutine#204] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37835/api/school/respect/person?includeRelated=false
2026-05-15 14:24:31.743 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:37835/api/school/respect/person?includeRelated=false.
2026-05-15 14:24:31.808 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37835/api/school/respect/person?since=2026-05-15T10%3A24%3A31.738437369Z&includeRelated=false
2026-05-15 14:24:31.808 [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:37835/api/school/respect/person?since=2026-05-15T10%3A24%3A31.738437369Z&includeRelated=false.
2026-05-15 14:24:31.808 [Test worker @coroutine#204] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37835/api/school/respect/person?since=2026-05-15T10%3A24%3A31.738437369Z&includeRelated=false
2026-05-15 14:24:31.809 [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:24:31.813 [Test worker @coroutine#204] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37835/api/school/respect/person?since=2026-05-15T10%3A24%3A31.738437369Z&includeRelated=false
2026-05-15 14:24:31.813 [Test worker @coroutine#204] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37835/api/school/respect/person?since=2026-05-15T10%3A24%3A31.738437369Z&includeRelated=false
2026-05-15 14:24:31.813 [Test worker @coroutine#204] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37835/api/school/respect/person?since=2026-05-15T10%3A24%3A31.738437369Z&includeRelated=false
2026-05-15 14:24:31.814 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:37835/api/school/respect/person?since=2026-05-15T10%3A24%3A31.738437369Z&includeRelated=false.
2026-05-15 14:24:33.989 [Test worker @coroutine#231] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 14:24:33.991 [Test worker @coroutine#231] INFO  io.ktor.server.Application - Application started in 0.06 seconds.
2026-05-15 14:24:33.992 [DefaultDispatcher-worker-3 @coroutine#241] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:40641
2026-05-15 14:24:33.994 [Test worker @coroutine#231] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40641/playlist/ae136dca-7597-40b0-a793-adc9bee2a1d3
2026-05-15 14:24:33.994 [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:40641/playlist/ae136dca-7597-40b0-a793-adc9bee2a1d3.
2026-05-15 14:24:33.994 [Test worker @coroutine#231] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40641/playlist/ae136dca-7597-40b0-a793-adc9bee2a1d3
2026-05-15 14:24:33.997 [eventLoopGroupProxy-31-1 @call-handler#245] TRACE io.ktor.server.routing.Routing - Trace for [playlist, ae136dca-7597-40b0-a793-adc9bee2a1d3]
/, segment:0 -> SUCCESS @ /
  /playlist, segment:1 -> SUCCESS @ /playlist
    /playlist/{uuid}, segment:2 -> SUCCESS; Parameters [uuid=[ae136dca-7597-40b0-a793-adc9bee2a1d3]] @ /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=[ae136dca-7597-40b0-a793-adc9bee2a1d3]] @ /playlist/{uuid}/(method:GET)
2026-05-15 14:24:34.003 [Test worker @coroutine#231] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40641/playlist/ae136dca-7597-40b0-a793-adc9bee2a1d3
2026-05-15 14:24:34.003 [Test worker @coroutine#231] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40641/playlist/ae136dca-7597-40b0-a793-adc9bee2a1d3
2026-05-15 14:24:34.003 [Test worker @coroutine#231] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40641/playlist/ae136dca-7597-40b0-a793-adc9bee2a1d3
2026-05-15 14:24:34.004 [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:40641/playlist/ae136dca-7597-40b0-a793-adc9bee2a1d3.
2026-05-15 14:24:36.208 [Test worker @coroutine#249] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 14:24:36.209 [Test worker @coroutine#249] INFO  io.ktor.server.Application - Application started in 0.072 seconds.
2026-05-15 14:24:36.210 [DefaultDispatcher-worker-2 @coroutine#258] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:35123
2026-05-15 14:24:36.251 [DefaultDispatcher-worker-3 @coroutine#256] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35123/playlist/770dca0e-2236-4e2f-8355-d2e41551aa4b
2026-05-15 14:24:36.251 [DefaultDispatcher-worker-3 @coroutine#256] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@693ff93c for http://localhost:35123/playlist/770dca0e-2236-4e2f-8355-d2e41551aa4b
2026-05-15 14:24:36.251 [DefaultDispatcher-worker-3 @coroutine#256] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35123/playlist/770dca0e-2236-4e2f-8355-d2e41551aa4b
2026-05-15 14:24:36.251 [DefaultDispatcher-worker-3 @coroutine#256] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:35123/playlist/770dca0e-2236-4e2f-8355-d2e41551aa4b from class io.ktor.http.content.TextContent
2026-05-15 14:24:36.254 [eventLoopGroupProxy-34-1 @call-handler#266] TRACE io.ktor.server.routing.Routing - Trace for [playlist, 770dca0e-2236-4e2f-8355-d2e41551aa4b]
/, segment:0 -> SUCCESS @ /
  /playlist, segment:1 -> SUCCESS @ /playlist
    /playlist/{uuid}, segment:2 -> SUCCESS; Parameters [uuid=[770dca0e-2236-4e2f-8355-d2e41551aa4b]] @ /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=[770dca0e-2236-4e2f-8355-d2e41551aa4b]] @ /playlist/{uuid}/(method:POST)
2026-05-15 14:24:36.254 [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/770dca0e-2236-4e2f-8355-d2e41551aa4b
2026-05-15 14:24:36.256 [DefaultDispatcher-worker-3 @call-handler#266] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the POST /playlist/770dca0e-2236-4e2f-8355-d2e41551aa4b request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-05-15 14:24:36.257 [DefaultDispatcher-worker-4 @coroutine#256] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35123/playlist/770dca0e-2236-4e2f-8355-d2e41551aa4b
2026-05-15 14:24:36.257 [DefaultDispatcher-worker-4 @coroutine#256] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35123/playlist/770dca0e-2236-4e2f-8355-d2e41551aa4b
2026-05-15 14:24:36.257 [DefaultDispatcher-worker-4 @coroutine#256] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35123/playlist/770dca0e-2236-4e2f-8355-d2e41551aa4b
2026-05-15 15:53:34.685 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 15:53:34.822 [Test worker] INFO  io.ktor.server.Application - Application started in 0.337 seconds.
2026-05-15 15:53:34.953 [DefaultDispatcher-worker-2 @coroutine#2] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:33645
2026-05-15 15:53:35.911 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33645/resources/index.json
2026-05-15 15:53:35.912 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:33645/resources/index.json.
2026-05-15 15:53:35.913 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33645/resources/index.json
2026-05-15 15:53:36.274 [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:53:36.449 [DefaultDispatcher-worker-1 @call-handler#12] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 187ms
2026-05-15 15:53:36.457 [DefaultDispatcher-worker-4 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33645/resources/index.json
2026-05-15 15:53:36.460 [DefaultDispatcher-worker-4 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33645/resources/index.json
2026-05-15 15:53:36.461 [DefaultDispatcher-worker-4 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33645/resources/index.json
2026-05-15 15:53:36.515 [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:33645/resources/index.json.
2026-05-15 15:53:36.570 [Test worker @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33645/resources/index.json
2026-05-15 15:53:36.570 [Test worker @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:33645/resources/index.json.
2026-05-15 15:53:36.570 [Test worker @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33645/resources/index.json
2026-05-15 15:53:36.581 [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:53:36.584 [eventLoopGroupProxy-4-1 @call-handler#22] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 3ms
2026-05-15 15:53:36.588 [DefaultDispatcher-worker-3 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33645/resources/index.json
2026-05-15 15:53:36.588 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33645/resources/index.json
2026-05-15 15:53:36.588 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33645/resources/index.json
2026-05-15 15:53:37.610 [eventLoopGroupProxy-3-1] WARN  i.n.u.c.AbstractEventExecutor - A task raised an exception. Task: io.netty.channel.AbstractChannel$AbstractUnsafe$8@24880b8f
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:53:38.619 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 15:53:38.619 [Test worker] INFO  io.ktor.server.Application - Application started in 0.0 seconds.
2026-05-15 15:53:38.621 [DefaultDispatcher-worker-3 @coroutine#26] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:35957
2026-05-15 15:53:38.740 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35957/resources/index.json
2026-05-15 15:53:38.741 [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:35957/resources/index.json.
2026-05-15 15:53:38.741 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35957/resources/index.json
2026-05-15 15:53:38.745 [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:53:38.746 [DefaultDispatcher-worker-3 @call-handler#35] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 2ms
2026-05-15 15:53:38.747 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35957/resources/index.json
2026-05-15 15:53:38.747 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35957/resources/index.json
2026-05-15 15:53:38.747 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35957/resources/index.json
2026-05-15 15:53:38.748 [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:35957/resources/index.json.
2026-05-15 15:53:38.755 [DefaultDispatcher-worker-11 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35957/resources/index.json
2026-05-15 15:53:38.755 [DefaultDispatcher-worker-11 @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:35957/resources/index.json.
2026-05-15 15:53:38.755 [DefaultDispatcher-worker-11 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35957/resources/index.json
2026-05-15 15:53:38.758 [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:53:38.760 [eventLoopGroupProxy-7-1 @call-handler#45] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 2ms
2026-05-15 15:53:38.762 [DefaultDispatcher-worker-10 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35957/resources/index.json
2026-05-15 15:53:38.763 [DefaultDispatcher-worker-10 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35957/resources/index.json
2026-05-15 15:53:38.763 [DefaultDispatcher-worker-10 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35957/resources/index.json
2026-05-15 15:53:40.774 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 15:53:40.774 [Test worker] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2026-05-15 15:53:40.775 [DefaultDispatcher-worker-11 @coroutine#49] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:45301
2026-05-15 15:53:40.782 [Test worker @coroutine#55] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45301/resources/lesson001.json
2026-05-15 15:53:40.782 [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:45301/resources/lesson001.json.
2026-05-15 15:53:40.782 [Test worker @coroutine#55] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45301/resources/lesson001.json
2026-05-15 15:53:40.786 [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:53:40.788 [DefaultDispatcher-worker-2 @call-handler#59] INFO  io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 2ms
2026-05-15 15:53:40.789 [DefaultDispatcher-worker-10 @coroutine#55] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45301/resources/lesson001.json
2026-05-15 15:53:40.789 [DefaultDispatcher-worker-10 @coroutine#55] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45301/resources/lesson001.json
2026-05-15 15:53:40.789 [DefaultDispatcher-worker-10 @coroutine#55] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45301/resources/lesson001.json
2026-05-15 15:53:40.792 [DefaultDispatcher-worker-10 @coroutine#55] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class kotlinx.serialization.json.JsonObject for http://localhost:45301/resources/lesson001.json.
2026-05-15 15:53:43.085 [Test worker @coroutine#65] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 15:53:43.092 [Test worker @coroutine#65] INFO  io.ktor.server.Application - Application started in 0.109 seconds.
2026-05-15 15:53:43.095 [DefaultDispatcher-worker-2 @coroutine#74] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:46367
2026-05-15 15:53:43.104 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46367/api/school/respect/schoolpermissiongrant
2026-05-15 15:53:43.104 [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:46367/api/school/respect/schoolpermissiongrant.
2026-05-15 15:53:43.104 [Test worker @coroutine#65] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46367/api/school/respect/schoolpermissiongrant
2026-05-15 15:53:43.115 [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:53:43.132 [Test worker @coroutine#65] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46367/api/school/respect/schoolpermissiongrant
2026-05-15 15:53:43.132 [Test worker @coroutine#65] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46367/api/school/respect/schoolpermissiongrant
2026-05-15 15:53:43.132 [Test worker @coroutine#65] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46367/api/school/respect/schoolpermissiongrant
2026-05-15 15:53:43.138 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:46367/api/school/respect/schoolpermissiongrant.
2026-05-15 15:53:43.219 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46367/api/school/respect/person?includeRelated=false
2026-05-15 15:53:43.219 [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:46367/api/school/respect/person?includeRelated=false.
2026-05-15 15:53:43.219 [Test worker @coroutine#65] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46367/api/school/respect/person?includeRelated=false
2026-05-15 15:53:43.222 [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:53:43.246 [Test worker @coroutine#65] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46367/api/school/respect/person?includeRelated=false
2026-05-15 15:53:43.246 [Test worker @coroutine#65] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46367/api/school/respect/person?includeRelated=false
2026-05-15 15:53:43.246 [Test worker @coroutine#65] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46367/api/school/respect/person?includeRelated=false
2026-05-15 15:53:43.248 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:46367/api/school/respect/person?includeRelated=false.
2026-05-15 15:53:43.258 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46367/api/school/respect/person?includeRelated=false
2026-05-15 15:53:43.259 [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:46367/api/school/respect/person?includeRelated=false.
2026-05-15 15:53:43.259 [Test worker @coroutine#65] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46367/api/school/respect/person?includeRelated=false
2026-05-15 15:53:43.261 [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:53:43.264 [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:53:43.265 [Test worker @coroutine#65] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46367/api/school/respect/person?includeRelated=false
2026-05-15 15:53:43.266 [Test worker @coroutine#65] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46367/api/school/respect/person?includeRelated=false
2026-05-15 15:53:43.266 [Test worker @coroutine#65] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46367/api/school/respect/person?includeRelated=false
2026-05-15 15:53:45.415 [Test worker @coroutine#94] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 15:53:45.416 [Test worker @coroutine#94] INFO  io.ktor.server.Application - Application started in 0.049 seconds.
2026-05-15 15:53:45.423 [DefaultDispatcher-worker-2 @coroutine#103] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:34939
2026-05-15 15:53:45.426 [Test worker @coroutine#94] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34939/api/school/respect/schoolpermissiongrant
2026-05-15 15:53:45.427 [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:34939/api/school/respect/schoolpermissiongrant.
2026-05-15 15:53:45.427 [Test worker @coroutine#94] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34939/api/school/respect/schoolpermissiongrant
2026-05-15 15:53:45.436 [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:53:45.446 [Test worker @coroutine#94] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34939/api/school/respect/schoolpermissiongrant
2026-05-15 15:53:45.447 [Test worker @coroutine#94] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34939/api/school/respect/schoolpermissiongrant
2026-05-15 15:53:45.447 [Test worker @coroutine#94] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34939/api/school/respect/schoolpermissiongrant
2026-05-15 15:53:45.448 [Test worker @coroutine#94] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34939/api/school/respect/schoolpermissiongrant.
2026-05-15 15:53:45.538 [DefaultDispatcher-worker-10 @coroutine#113] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34939/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 15:53:45.538 [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:34939/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2026-05-15 15:53:45.539 [DefaultDispatcher-worker-10 @coroutine#113] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34939/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 15:53:45.544 [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:53:45.557 [DefaultDispatcher-worker-8 @coroutine#113] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34939/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 15:53:45.558 [DefaultDispatcher-worker-2 @coroutine#113] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34939/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 15:53:45.558 [DefaultDispatcher-worker-2 @coroutine#113] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34939/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-15 15:53:45.560 [DefaultDispatcher-worker-4 @coroutine#113] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34939/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2026-05-15 15:53:47.725 [Test worker @coroutine#122] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 15:53:47.726 [Test worker @coroutine#122] INFO  io.ktor.server.Application - Application started in 0.041 seconds.
2026-05-15 15:53:47.727 [DefaultDispatcher-worker-4 @coroutine#131] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:39701
2026-05-15 15:53:47.730 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39701/api/school/respect/person?includeRelated=false
2026-05-15 15:53:47.730 [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:39701/api/school/respect/person?includeRelated=false.
2026-05-15 15:53:47.730 [Test worker @coroutine#122] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39701/api/school/respect/person?includeRelated=false
2026-05-15 15:53:47.733 [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:53:47.737 [Test worker @coroutine#122] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39701/api/school/respect/person?includeRelated=false
2026-05-15 15:53:47.737 [Test worker @coroutine#122] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39701/api/school/respect/person?includeRelated=false
2026-05-15 15:53:47.737 [Test worker @coroutine#122] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39701/api/school/respect/person?includeRelated=false
2026-05-15 15:53:47.738 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:39701/api/school/respect/person?includeRelated=false.
2026-05-15 15:53:47.793 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39701/api/school/respect/person?since=2026-05-15T11%3A53%3A47.733860050Z&includeRelated=false
2026-05-15 15:53:47.793 [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:39701/api/school/respect/person?since=2026-05-15T11%3A53%3A47.733860050Z&includeRelated=false.
2026-05-15 15:53:47.793 [Test worker @coroutine#122] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39701/api/school/respect/person?since=2026-05-15T11%3A53%3A47.733860050Z&includeRelated=false
2026-05-15 15:53:47.795 [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:53:47.798 [Test worker @coroutine#122] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39701/api/school/respect/person?since=2026-05-15T11%3A53%3A47.733860050Z&includeRelated=false
2026-05-15 15:53:47.798 [Test worker @coroutine#122] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39701/api/school/respect/person?since=2026-05-15T11%3A53%3A47.733860050Z&includeRelated=false
2026-05-15 15:53:47.798 [Test worker @coroutine#122] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39701/api/school/respect/person?since=2026-05-15T11%3A53%3A47.733860050Z&includeRelated=false
2026-05-15 15:53:47.799 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:39701/api/school/respect/person?since=2026-05-15T11%3A53%3A47.733860050Z&includeRelated=false.
2026-05-15 15:53:50.047 [Test worker @coroutine#148] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 15:53:50.048 [Test worker @coroutine#148] INFO  io.ktor.server.Application - Application started in 0.093 seconds.
2026-05-15 15:53:50.049 [DefaultDispatcher-worker-2 @coroutine#157] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:36673
2026-05-15 15:53:50.114 [DefaultDispatcher-worker-2 @coroutine#155] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36673/api/school/respect/person
2026-05-15 15:53:50.115 [DefaultDispatcher-worker-2 @coroutine#155] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@1b709fb1 for http://localhost:36673/api/school/respect/person
2026-05-15 15:53:50.115 [DefaultDispatcher-worker-2 @coroutine#155] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36673/api/school/respect/person
2026-05-15 15:53:50.115 [DefaultDispatcher-worker-2 @coroutine#155] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:36673/api/school/respect/person from class io.ktor.http.content.TextContent
2026-05-15 15:53:50.118 [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:53:50.123 [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:53:50.124 [DefaultDispatcher-worker-4 @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:53:50.125 [DefaultDispatcher-worker-2 @coroutine#155] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36673/api/school/respect/person
2026-05-15 15:53:50.125 [DefaultDispatcher-worker-2 @coroutine#155] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36673/api/school/respect/person
2026-05-15 15:53:50.125 [DefaultDispatcher-worker-2 @coroutine#155] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36673/api/school/respect/person
2026-05-15 15:53:52.269 [Test worker @coroutine#172] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 15:53:52.270 [Test worker @coroutine#172] INFO  io.ktor.server.Application - Application started in 0.04 seconds.
2026-05-15 15:53:52.272 [DefaultDispatcher-worker-4 @coroutine#181] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:34591
2026-05-15 15:53:52.273 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34591/api/school/respect/schoolpermissiongrant
2026-05-15 15:53:52.273 [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:34591/api/school/respect/schoolpermissiongrant.
2026-05-15 15:53:52.273 [Test worker @coroutine#172] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34591/api/school/respect/schoolpermissiongrant
2026-05-15 15:53:52.278 [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:53:52.280 [Test worker @coroutine#172] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34591/api/school/respect/schoolpermissiongrant
2026-05-15 15:53:52.281 [Test worker @coroutine#172] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34591/api/school/respect/schoolpermissiongrant
2026-05-15 15:53:52.281 [Test worker @coroutine#172] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34591/api/school/respect/schoolpermissiongrant
2026-05-15 15:53:52.281 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34591/api/school/respect/schoolpermissiongrant.
2026-05-15 15:53:52.347 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34591/api/school/respect/person?includeRelated=false
2026-05-15 15:53:52.347 [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:34591/api/school/respect/person?includeRelated=false.
2026-05-15 15:53:52.347 [Test worker @coroutine#172] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34591/api/school/respect/person?includeRelated=false
2026-05-15 15:53:52.353 [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:53:52.369 [Test worker @coroutine#172] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34591/api/school/respect/person?includeRelated=false
2026-05-15 15:53:52.369 [Test worker @coroutine#172] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34591/api/school/respect/person?includeRelated=false
2026-05-15 15:53:52.369 [Test worker @coroutine#172] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34591/api/school/respect/person?includeRelated=false
2026-05-15 15:53:52.371 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34591/api/school/respect/person?includeRelated=false.
2026-05-15 15:53:54.393 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34591/api/school/respect/person?includeRelated=false
2026-05-15 15:53:54.393 [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:34591/api/school/respect/person?includeRelated=false.
2026-05-15 15:53:54.394 [Test worker @coroutine#172] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34591/api/school/respect/person?includeRelated=false
2026-05-15 15:53:54.396 [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:53:54.415 [Test worker @coroutine#172] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34591/api/school/respect/person?includeRelated=false
2026-05-15 15:53:54.416 [Test worker @coroutine#172] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34591/api/school/respect/person?includeRelated=false
2026-05-15 15:53:54.416 [Test worker @coroutine#172] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34591/api/school/respect/person?includeRelated=false
2026-05-15 15:53:54.419 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34591/api/school/respect/person?includeRelated=false.
2026-05-15 15:53:56.601 [Test worker @coroutine#204] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 15:53:56.604 [Test worker @coroutine#204] INFO  io.ktor.server.Application - Application started in 0.068 seconds.
2026-05-15 15:53:56.605 [DefaultDispatcher-worker-3 @coroutine#213] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:33079
2026-05-15 15:53:56.608 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33079/api/school/respect/person?includeRelated=false
2026-05-15 15:53:56.609 [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:33079/api/school/respect/person?includeRelated=false.
2026-05-15 15:53:56.609 [Test worker @coroutine#204] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33079/api/school/respect/person?includeRelated=false
2026-05-15 15:53:56.612 [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:53:56.618 [Test worker @coroutine#204] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33079/api/school/respect/person?includeRelated=false
2026-05-15 15:53:56.619 [Test worker @coroutine#204] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33079/api/school/respect/person?includeRelated=false
2026-05-15 15:53:56.619 [Test worker @coroutine#204] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33079/api/school/respect/person?includeRelated=false
2026-05-15 15:53:56.620 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:33079/api/school/respect/person?includeRelated=false.
2026-05-15 15:53:56.686 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33079/api/school/respect/person?since=2026-05-15T11%3A53%3A56.612540373Z&includeRelated=false
2026-05-15 15:53:56.690 [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:33079/api/school/respect/person?since=2026-05-15T11%3A53%3A56.612540373Z&includeRelated=false.
2026-05-15 15:53:56.690 [Test worker @coroutine#204] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33079/api/school/respect/person?since=2026-05-15T11%3A53%3A56.612540373Z&includeRelated=false
2026-05-15 15:53:56.696 [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:53:56.702 [Test worker @coroutine#204] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33079/api/school/respect/person?since=2026-05-15T11%3A53%3A56.612540373Z&includeRelated=false
2026-05-15 15:53:56.702 [Test worker @coroutine#204] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33079/api/school/respect/person?since=2026-05-15T11%3A53%3A56.612540373Z&includeRelated=false
2026-05-15 15:53:56.703 [Test worker @coroutine#204] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33079/api/school/respect/person?since=2026-05-15T11%3A53%3A56.612540373Z&includeRelated=false
2026-05-15 15:53:56.706 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:33079/api/school/respect/person?since=2026-05-15T11%3A53%3A56.612540373Z&includeRelated=false.
2026-05-15 15:53:58.864 [Test worker @coroutine#231] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 15:53:58.866 [Test worker @coroutine#231] INFO  io.ktor.server.Application - Application started in 0.047 seconds.
2026-05-15 15:53:58.870 [DefaultDispatcher-worker-9 @coroutine#241] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:45279
2026-05-15 15:53:58.875 [Test worker @coroutine#231] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45279/playlist/c111592a-d338-4772-9265-c43604c9eb06
2026-05-15 15:53:58.876 [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:45279/playlist/c111592a-d338-4772-9265-c43604c9eb06.
2026-05-15 15:53:58.876 [Test worker @coroutine#231] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45279/playlist/c111592a-d338-4772-9265-c43604c9eb06
2026-05-15 15:53:58.889 [eventLoopGroupProxy-31-1 @call-handler#245] TRACE io.ktor.server.routing.Routing - Trace for [playlist, c111592a-d338-4772-9265-c43604c9eb06]
/, segment:0 -> SUCCESS @ /
  /playlist, segment:1 -> SUCCESS @ /playlist
    /playlist/{uuid}, segment:2 -> SUCCESS; Parameters [uuid=[c111592a-d338-4772-9265-c43604c9eb06]] @ /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=[c111592a-d338-4772-9265-c43604c9eb06]] @ /playlist/{uuid}/(method:GET)
2026-05-15 15:53:58.898 [Test worker @coroutine#231] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45279/playlist/c111592a-d338-4772-9265-c43604c9eb06
2026-05-15 15:53:58.898 [Test worker @coroutine#231] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45279/playlist/c111592a-d338-4772-9265-c43604c9eb06
2026-05-15 15:53:58.898 [Test worker @coroutine#231] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45279/playlist/c111592a-d338-4772-9265-c43604c9eb06
2026-05-15 15:53:58.899 [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:45279/playlist/c111592a-d338-4772-9265-c43604c9eb06.
2026-05-15 15:54:01.118 [Test worker @coroutine#249] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-15 15:54:01.119 [Test worker @coroutine#249] INFO  io.ktor.server.Application - Application started in 0.069 seconds.
2026-05-15 15:54:01.120 [DefaultDispatcher-worker-9 @coroutine#258] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:45319
2026-05-15 15:54:01.185 [DefaultDispatcher-worker-4 @coroutine#256] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45319/playlist/0b282a12-b166-447c-81c2-3f9257cc5217
2026-05-15 15:54:01.186 [DefaultDispatcher-worker-4 @coroutine#256] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@18f1e12b for http://localhost:45319/playlist/0b282a12-b166-447c-81c2-3f9257cc5217
2026-05-15 15:54:01.186 [DefaultDispatcher-worker-4 @coroutine#256] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45319/playlist/0b282a12-b166-447c-81c2-3f9257cc5217
2026-05-15 15:54:01.186 [DefaultDispatcher-worker-4 @coroutine#256] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:45319/playlist/0b282a12-b166-447c-81c2-3f9257cc5217 from class io.ktor.http.content.TextContent
2026-05-15 15:54:01.195 [eventLoopGroupProxy-34-1 @call-handler#266] TRACE io.ktor.server.routing.Routing - Trace for [playlist, 0b282a12-b166-447c-81c2-3f9257cc5217]
/, segment:0 -> SUCCESS @ /
  /playlist, segment:1 -> SUCCESS @ /playlist
    /playlist/{uuid}, segment:2 -> SUCCESS; Parameters [uuid=[0b282a12-b166-447c-81c2-3f9257cc5217]] @ /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=[0b282a12-b166-447c-81c2-3f9257cc5217]] @ /playlist/{uuid}/(method:POST)
2026-05-15 15:54:01.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/0b282a12-b166-447c-81c2-3f9257cc5217
2026-05-15 15:54:01.198 [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/0b282a12-b166-447c-81c2-3f9257cc5217 request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-05-15 15:54:01.199 [DefaultDispatcher-worker-3 @coroutine#256] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45319/playlist/0b282a12-b166-447c-81c2-3f9257cc5217
2026-05-15 15:54:01.199 [DefaultDispatcher-worker-3 @coroutine#256] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45319/playlist/0b282a12-b166-447c-81c2-3f9257cc5217
2026-05-15 15:54:01.199 [DefaultDispatcher-worker-3 @coroutine#256] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45319/playlist/0b282a12-b166-447c-81c2-3f9257cc5217