©´–Žport = 36117  ©´é14:12:21,805 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found logback-core version 1.6.1  ©´È14:12:21,806 |-INFO in ch.qos.logback.classic.util.ContextInitializer@54c62d71 - No custom configurators were discovered as a service.  ©´à14:12:21,806 |-INFO in ch.qos.logback.classic.util.ContextInitializer@54c62d71 - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator  ©´î14:12:21,807 |-INFO in ch.qos.logback.classic.util.ContextInitializer@54c62d71 - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator  ©´ó14:12:21,808 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]  ©´ë14:12:21,810 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [file:/home/jenkins/.jenkins/workspace/RESPECT-Primary/respect-datalayer-repository/build/processedResources/jvm/test/logback.xml]  ©´×14:12:21,810 |-WARN in ch.qos.logback.classic.util.DefaultJoranConfigurator@65045a87 - Resource [logback.xml] occurs multiple times on the classpath.  ©´ü14:12:21,810 |-WARN in ch.qos.logback.classic.util.DefaultJoranConfigurator@65045a87 - Resource [logback.xml] occurs at [file:/home/jenkins/.jenkins/workspace/RESPECT-Primary/respect-datalayer-repository/build/processedResources/jvm/test/logback.xml]  ©´ö14:12:21,810 |-WARN in ch.qos.logback.classic.util.DefaultJoranConfigurator@65045a87 - Resource [logback.xml] occurs at [jar:file:/home/jenkins/.jenkins/workspace/RESPECT-Primary/respect-server/build/libs/respect-server-1.0.45.jar!/logback.xml]  ©´Ô14:12:21,860 |-INFO in ch.qos.logback.classic.model.processor.ConfigurationModelHandlerFull - Scan attribute not set or set to unrecognized value.  ©´ö14:12:21,863 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [STDOUT]  ©´ß14:12:21,863 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender]  ©´ö14:12:21,867 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property  ©´Í14:12:21,891 |-INFO in ch.qos.logback.core.ConsoleAppender[STDOUT] - NOTE: Writing to the console can be slow. Try to avoid logging to the  ©´Í14:12:21,891 |-INFO in ch.qos.logback.core.ConsoleAppender[STDOUT] - console in production environments, especially in high volume systems.  ©´ý14:12:21,891 |-INFO in ch.qos.logback.core.ConsoleAppender[STDOUT] - See also https://logback.qos.ch/codes.html#slowConsole  ©´þ14:12:21,892 |-INFO in ch.qos.logback.classic.model.processor.RootLoggerModelHandler - Setting level of ROOT logger to TRACE  ©´ È14:12:21,892 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [STDOUT] to Logger[ROOT]  ©´ ÿ14:12:21,892 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [io.netty] to INFO  ©´ î14:12:21,892 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@47f4e407 - End of configuration.  ©´ Ë14:12:21,893 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@2d1dee39 - Registering current configuration as safe fallback point  ©´ Ú14:12:21,895 |-INFO in ch.qos.logback.classic.util.ContextInitializer@54c62d71 - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 86 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY  ©´ ‚  ©´©Æ2026-09-16 14:12:22.048 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off.  ©´ 7Žport = 33051  ©´ 7Æ2026-09-16 14:12:24.248 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off.  ©´|Žport = 34867  ©´|Æ2026-09-16 14:12:25.341 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off.  ©´7Ô2026-09-16 14:12:26.552 [Test worker @coroutine#62] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off.  ©´>þ2026-09-16 14:12:26.558 [Test worker @coroutine#62] INFO io.ktor.server.Application - Application started in 0.099 seconds.  ©´@Ê2026-09-16 14:12:26.560 [DefaultDispatcher-worker-1 @coroutine#71] INFO io.ktor.server.Application - Responding at http://0.0.0.0:46119  ©´HÄ2026-09-16 14:12:26.569 [Test worker @coroutine#62] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46119/api/school/respect/schoolpermissiongrant  ©´HÂ2026-09-16 14:12:26.569 [Test worker @coroutine#62] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:46119/api/school/respect/schoolpermissiongrant.  ©´Mä2026-09-16 14:12:26.574 [eventLoopGroupProxy-13-1 @call-handler#74] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, schoolpermissiongrant]  ©´M/, segment:0 -> SUCCESS @ /  ©´M¥ /api, segment:1 -> SUCCESS @ /api  ©´Mµ /api/school, segment:2 -> SUCCESS @ /api/school  ©´MÇ /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect  ©´Mï /api/school/respect/person, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/person  ©´Mõ /api/school/respect/schoolpermissiongrant, segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant  ©´MÕ /api/school/respect/schoolpermissiongrant [(method:GET)], segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant [(method:GET)]  ©´M‘Matched routes:  ©´MÕ "" -> "api" -> "school" -> "respect" -> "schoolpermissiongrant" -> "(method:GET)"  ©´M™Routing resolve result:  ©´MÆ SUCCESS @ /api/school/respect/schoolpermissiongrant [(method:GET)]  ©´\í2026-09-16 14:12:26.589 [Test worker @coroutine#62] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46119/api/school/respect/schoolpermissiongrant  ©´\Â2026-09-16 14:12:26.589 [Test worker @coroutine#62] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46119/api/school/respect/schoolpermissiongrant  ©´]È2026-09-16 14:12:26.589 [Test worker @coroutine#62] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46119/api/school/respect/schoolpermissiongrant  ©´_Ø2026-09-16 14:12:26.591 [Test worker @coroutine#62] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:46119/api/school/respect/schoolpermissiongrant.  ©´ Ê2026-09-16 14:12:26.657 [Test worker @coroutine#62] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46119/api/school/respect/person?includeRelated=false  ©´¡È2026-09-16 14:12:26.657 [Test worker @coroutine#62] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:46119/api/school/respect/person?includeRelated=false.  ©´£Õ2026-09-16 14:12:26.659 [eventLoopGroupProxy-13-1 @call-handler#80] 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-09-16 14:12:26.680 [Test worker @coroutine#62] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46119/api/school/respect/person?includeRelated=false  ©´·È2026-09-16 14:12:26.680 [Test worker @coroutine#62] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46119/api/school/respect/person?includeRelated=false  ©´·Î2026-09-16 14:12:26.680 [Test worker @coroutine#62] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46119/api/school/respect/person?includeRelated=false  ©´¹Þ2026-09-16 14:12:26.681 [Test worker @coroutine#62] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:46119/api/school/respect/person?includeRelated=false.  ©´¾Ê2026-09-16 14:12:26.687 [Test worker @coroutine#62] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46119/api/school/respect/person?includeRelated=false  ©´¾È2026-09-16 14:12:26.687 [Test worker @coroutine#62] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:46119/api/school/respect/person?includeRelated=false.  ©´ÀÕ2026-09-16 14:12:26.689 [eventLoopGroupProxy-13-1 @call-handler#86] 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-09-16 14:12:26.690 [eventLoopGroupProxy-13-1 @call-handler#86] 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-09-16 14:12:26.691 [Test worker @coroutine#62] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46119/api/school/respect/person?includeRelated=false  ©´ÃÈ2026-09-16 14:12:26.691 [Test worker @coroutine#62] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46119/api/school/respect/person?includeRelated=false  ©´ÃÎ2026-09-16 14:12:26.691 [Test worker @coroutine#62] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46119/api/school/respect/person?includeRelated=false  ©´Ô2026-09-16 14:12:27.801 [Test worker @coroutine#90] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off.  ©´þ2026-09-16 14:12:27.802 [Test worker @coroutine#90] INFO io.ktor.server.Application - Application started in 0.049 seconds.  ©´Ê2026-09-16 14:12:27.803 [DefaultDispatcher-worker-5 @coroutine#99] INFO io.ktor.server.Application - Responding at http://0.0.0.0:44601  ©´Ä2026-09-16 14:12:27.804 [Test worker @coroutine#90] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44601/api/school/respect/schoolpermissiongrant  ©´Â2026-09-16 14:12:27.804 [Test worker @coroutine#90] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:44601/api/school/respect/schoolpermissiongrant.  ©´å2026-09-16 14:12:27.806 [eventLoopGroupProxy-16-1 @call-handler#102] 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-09-16 14:12:27.808 [Test worker @coroutine#90] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44601/api/school/respect/schoolpermissiongrant  ©´ Â2026-09-16 14:12:27.808 [Test worker @coroutine#90] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44601/api/school/respect/schoolpermissiongrant  ©´ È2026-09-16 14:12:27.808 [Test worker @coroutine#90] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44601/api/school/respect/schoolpermissiongrant  ©´ Ø2026-09-16 14:12:27.809 [Test worker @coroutine#90] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44601/api/school/respect/schoolpermissiongrant.  ©´PÁ2026-09-16 14:12:27.856 [DefaultDispatcher-worker-5 @coroutine#108] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44601/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100  ©´Pÿ2026-09-16 14:12:27.856 [DefaultDispatcher-worker-5 @coroutine#108] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:44601/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.  ©´QÖ2026-09-16 14:12:27.858 [eventLoopGroupProxy-16-1 @call-handler#112] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]  ©´Q/, segment:0 -> SUCCESS @ /  ©´Q¥ /api, segment:1 -> SUCCESS @ /api  ©´Qµ /api/school, segment:2 -> SUCCESS @ /api/school  ©´QÇ /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect  ©´Q× /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person  ©´Q÷ /api/school/respect/person [(method:GET)], segment:4 -> SUCCESS @ /api/school/respect/person [(method:GET)]  ©´QÑ /api/school/respect/person [(method:POST)], segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person [(method:POST)]  ©´QÍ /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant  ©´Q‘Matched routes:  ©´QÆ "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"  ©´Q™Routing resolve result:  ©´Q· SUCCESS @ /api/school/respect/person [(method:GET)]  ©´Tê2026-09-16 14:12:27.861 [DefaultDispatcher-worker-1 @coroutine#108] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44601/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100  ©´Tÿ2026-09-16 14:12:27.861 [DefaultDispatcher-worker-1 @coroutine#108] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44601/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100  ©´TÅ2026-09-16 14:12:27.861 [DefaultDispatcher-worker-1 @coroutine#108] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44601/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100  ©´UÕ2026-09-16 14:12:27.862 [DefaultDispatcher-worker-1 @coroutine#108] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44601/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.  ©´¢Õ2026-09-16 14:12:28.962 [Test worker @coroutine#117] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off.  ©´£ÿ2026-09-16 14:12:28.963 [Test worker @coroutine#117] INFO io.ktor.server.Application - Application started in 0.039 seconds.  ©´¤Ë2026-09-16 14:12:28.964 [DefaultDispatcher-worker-5 @coroutine#126] INFO io.ktor.server.Application - Responding at http://0.0.0.0:33497  ©´§Ë2026-09-16 14:12:28.967 [Test worker @coroutine#117] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33497/api/school/respect/person?includeRelated=false  ©´§É2026-09-16 14:12:28.967 [Test worker @coroutine#117] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:33497/api/school/respect/person?includeRelated=false.  ©´ªÖ2026-09-16 14:12:28.970 [eventLoopGroupProxy-19-1 @call-handler#130] 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-09-16 14:12:28.973 [Test worker @coroutine#117] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33497/api/school/respect/person?includeRelated=false  ©´­É2026-09-16 14:12:28.973 [Test worker @coroutine#117] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33497/api/school/respect/person?includeRelated=false  ©´­Ï2026-09-16 14:12:28.973 [Test worker @coroutine#117] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33497/api/school/respect/person?includeRelated=false  ©´®ß2026-09-16 14:12:28.974 [Test worker @coroutine#117] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:33497/api/school/respect/person?includeRelated=false.  ©´Þà0DataReadyState(data=[Person(guid=4242, userActive=true, status=ACTIVE, lastModified=2026-09-16T10:12:28.873Z, stored=2026-09-16T10:12:29.012Z, metadata=null, userMasterIdentifier=null, username=null, givenName=Admin, familyName=User, middleName=null, gender=UNSPECIFIED, preferredFirstName=null, preferredMiddleName=null, preferredLastName=null, pronouns=null, roles=[PersonRole(isPrimaryRole=true, roleEnum=SYSTEM_ADMINISTRATOR, beginDate=null, endDate=null)], relatedPersonUids=[], dateOfBirth=null, email=null, phoneNumber=null)], metaInfo=DataLoadMetaInfo(lastModified=1789553548873, lastStored=1789553549012, etag=null, url=http://localhost:33497/api/school/respect/person?includeRelated=false, consistentThrough=2026-09-16T10:12:29.013572031Z, validationInfoKey=0, varyHeader=null, headers=null, permissionsLastModified=null), localState=DataReadyState(data=[Person(guid=4242, userActive=true, status=ACTIVE, lastModified=2026-09-16T10:12:28.873Z, stored=2026-09-16T10:12:29.012Z, metadata=null, userMasterIdentifier=null, username=null, givenName=Admin, familyName=User, middleName=null, gender=UNSPECIFIED, preferredFirstName=null, preferredMiddleName=null, preferredLastName=null, pronouns=null, roles=[PersonRole(isPrimaryRole=true, roleEnum=SYSTEM_ADMINISTRATOR, beginDate=null, endDate=null)], relatedPersonUids=[], dateOfBirth=null, email=null, phoneNumber=null)], metaInfo=DataLoadMetaInfo(lastModified=1789553548873, lastStored=1789553549012, etag=null, url=null, consistentThrough=2026-09-16T10:12:29.013572031Z, validationInfoKey=0, varyHeader=null, headers=null, permissionsLastModified=null), localState=null, remoteState=null), remoteState=DataReadyState(data=[Person(guid=4242, userActive=true, status=ACTIVE, lastModified=2026-09-16T10:12:28.873Z, stored=2026-09-16T10:12:28.923Z, metadata=null, userMasterIdentifier=null, username=null, givenName=Admin, familyName=User, middleName=null, gender=UNSPECIFIED, preferredFirstName=null, preferredMiddleName=null, preferredLastName=null, pronouns=null, roles=[PersonRole(isPrimaryRole=true, roleEnum=SYSTEM_ADMINISTRATOR, beginDate=null, endDate=null)], relatedPersonUids=[], dateOfBirth=null, email=null, phoneNumber=null), Person(guid=42, userActive=true, status=ACTIVE, lastModified=2026-09-16T10:12:28.871Z, stored=2026-09-16T10:12:28.965Z, metadata=null, userMasterIdentifier=null, username=test, givenName=test, familyName=test, middleName=null, gender=FEMALE, preferredFirstName=null, preferredMiddleName=null, preferredLastName=null, pronouns=null, roles=[PersonRole(isPrimaryRole=true, roleEnum=SITE_ADMINISTRATOR, beginDate=null, endDate=null)], relatedPersonUids=[], dateOfBirth=null, email=null, phoneNumber=null)], metaInfo=DataLoadMetaInfo(lastModified=1789553548000, lastStored=-1, etag=null, url=http://localhost:33497/api/school/respect/person?includeRelated=false, consistentThrough=2026-09-16T10:12:28.971040086Z, validationInfoKey=7092960727423664838, varyHeader=Authorization, headers=io.ktor.client.engine.okhttp.OkUtilsKt$fromOkHttp$1@48b3b1b8, permissionsLastModified=null), localState=null, remoteState=null))  ©´àô2026-09-16 14:12:29.024 [Test worker @coroutine#117] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33497/api/school/respect/person?since=2026-09-16T10%3A12%3A28.971040086Z&includeRelated=false  ©´àò2026-09-16 14:12:29.024 [Test worker @coroutine#117] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:33497/api/school/respect/person?since=2026-09-16T10%3A12%3A28.971040086Z&includeRelated=false.  ©´áÖ2026-09-16 14:12:29.025 [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-09-16 14:12:29.027 [Test worker @coroutine#117] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33497/api/school/respect/person?since=2026-09-16T10%3A12%3A28.971040086Z&includeRelated=false  ©´ãò2026-09-16 14:12:29.027 [Test worker @coroutine#117] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33497/api/school/respect/person?since=2026-09-16T10%3A12%3A28.971040086Z&includeRelated=false  ©´ãø2026-09-16 14:12:29.027 [Test worker @coroutine#117] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33497/api/school/respect/person?since=2026-09-16T10%3A12%3A28.971040086Z&includeRelated=false  ©´ãÈ2026-09-16 14:12:29.027 [Test worker @coroutine#117] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:33497/api/school/respect/person?since=2026-09-16T10%3A12%3A28.971040086Z&includeRelated=false.  ©´ä—Run time: 63.374138ms  ©´#?Õ2026-09-16 14:12:30.143 [Test worker @coroutine#142] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off.  ©´#@ÿ2026-09-16 14:12:30.144 [Test worker @coroutine#142] INFO io.ktor.server.Application - Application started in 0.039 seconds.  ©´#AË2026-09-16 14:12:30.145 [DefaultDispatcher-worker-5 @coroutine#151] INFO io.ktor.server.Application - Responding at http://0.0.0.0:38979  ©´#mÅ2026-09-16 14:12:30.189 [DefaultDispatcher-worker-1 @coroutine#149] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38979/api/school/respect/person  ©´#mÁ2026-09-16 14:12:30.189 [DefaultDispatcher-worker-1 @coroutine#149] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@56246685 for http://localhost:38979/api/school/respect/person  ©´#mÃ2026-09-16 14:12:30.190 [DefaultDispatcher-worker-1 @coroutine#149] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:38979/api/school/respect/person from class io.ktor.http.content.TextContent  ©´#pÖ2026-09-16 14:12:30.193 [eventLoopGroupProxy-22-1 @call-handler#160] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]  ©´#p/, segment:0 -> SUCCESS @ /  ©´#p¥ /api, segment:1 -> SUCCESS @ /api  ©´#pµ /api/school, segment:2 -> SUCCESS @ /api/school  ©´#pÇ /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect  ©´#p× /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person  ©´#pÏ /api/school/respect/person [(method:GET)], segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person [(method:GET)]  ©´#pù /api/school/respect/person [(method:POST)], segment:4 -> SUCCESS @ /api/school/respect/person [(method:POST)]  ©´#p‘Matched routes:  ©´#pÇ "" -> "api" -> "school" -> "respect" -> "person" -> "(method:POST)"  ©´#p™Routing resolve result:  ©´#p¸ SUCCESS @ /api/school/respect/person [(method:POST)]  ©´#tþ2026-09-16 14:12:30.196 [eventLoopGroupProxy-22-1 @call-handler#160] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(kotlin.collections.List) for call /api/school/respect/person  ©´#uÀ2026-09-16 14:12:30.197 [eventLoopGroupProxy-22-1 @call-handler#160] 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].  ©´#vî2026-09-16 14:12:30.198 [DefaultDispatcher-worker-5 @coroutine#149] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38979/api/school/respect/person  ©´#vÃ2026-09-16 14:12:30.198 [DefaultDispatcher-worker-5 @coroutine#149] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38979/api/school/respect/person  ©´#vÉ2026-09-16 14:12:30.198 [DefaultDispatcher-worker-5 @coroutine#149] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38979/api/school/respect/person  ©´'ÈÕ2026-09-16 14:12:31.304 [Test worker @coroutine#165] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off.  ©´'Éÿ2026-09-16 14:12:31.305 [Test worker @coroutine#165] INFO io.ktor.server.Application - Application started in 0.039 seconds.  ©´'ÊË2026-09-16 14:12:31.307 [DefaultDispatcher-worker-5 @coroutine#174] INFO io.ktor.server.Application - Responding at http://0.0.0.0:43915  ©´'ËÅ2026-09-16 14:12:31.307 [Test worker @coroutine#165] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43915/api/school/respect/schoolpermissiongrant  ©´'ËÃ2026-09-16 14:12:31.307 [Test worker @coroutine#165] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:43915/api/school/respect/schoolpermissiongrant.  ©´'Íå2026-09-16 14:12:31.310 [eventLoopGroupProxy-25-1 @call-handler#177] 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-09-16 14:12:31.312 [Test worker @coroutine#165] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43915/api/school/respect/schoolpermissiongrant  ©´'ÏÃ2026-09-16 14:12:31.312 [Test worker @coroutine#165] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43915/api/school/respect/schoolpermissiongrant  ©´'ÏÉ2026-09-16 14:12:31.312 [Test worker @coroutine#165] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43915/api/school/respect/schoolpermissiongrant  ©´'ÐÙ2026-09-16 14:12:31.312 [Test worker @coroutine#165] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:43915/api/school/respect/schoolpermissiongrant.  ©´'ùË2026-09-16 14:12:31.353 [Test worker @coroutine#165] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43915/api/school/respect/person?includeRelated=false  ©´'ùÉ2026-09-16 14:12:31.353 [Test worker @coroutine#165] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:43915/api/school/respect/person?includeRelated=false.  ©´'úÖ2026-09-16 14:12:31.354 [eventLoopGroupProxy-25-1 @call-handler#183] 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)]  ©´'ýÉSep 16, 2026 2:12:31 PM io.github.aakira.napier.DebugAntilog performLog  ©´'ýÀFINE: [DEBUG] MapPagingSource$load - MapPagingSource(tag=PersonDataSourceDb/listAsPagingSource(params=GetListParams(common=GetListCommonParams(guid=null, searchQuery=null, since=null, sinceIfPermissionsNotChangedSince=null, includeDeleted=null), filterByClazzUid=null, filterByEnrolmentRole=null, filterByName=null, filterByPersonStatus=null, filterByPersonRole=null, includeRelated=false, inClassOnDay=null))): load Refresh(key=0, loadSize=1000)  ©´'ÿô2026-09-16 14:12:31.360 [Test worker @coroutine#165] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43915/api/school/respect/person?includeRelated=false  ©´'ÿÉ2026-09-16 14:12:31.360 [Test worker @coroutine#165] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43915/api/school/respect/person?includeRelated=false  ©´'ÿÏ2026-09-16 14:12:31.360 [Test worker @coroutine#165] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43915/api/school/respect/person?includeRelated=false  ©´(ß2026-09-16 14:12:31.361 [Test worker @coroutine#165] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:43915/api/school/respect/person?includeRelated=false.  ©´/ÔÉSep 16, 2026 2:12:33 PM io.github.aakira.napier.DebugAntilog performLog  ©´/ÔæFINE: [DEBUG] DelegatedInvalidationPagingSource$onSrcInvalidated - RPaging/DelegatedInvalidationPagingSource(extra=PersonDataSourceDb/listAsPagingSource(params=GetListParams(common=GetListCommonParams(guid=null, searchQuery=null, since=null, sinceIfPermissionsNotChangedSince=null, includeDeleted=null), filterByClazzUid=null, filterByEnrolmentRole=null, filterByName=null, filterByPersonStatus=null, filterByPersonRole=null, includeRelated=false, inClassOnDay=null))) src invalidated  ©´/ÕÉSep 16, 2026 2:12:33 PM io.github.aakira.napier.DebugAntilog performLog  ©´/ÕÛFINE: [DEBUG] HttpRequestBuilderExtKt$addCacheValidationHeaders - addCacheValidationHeaders = If-Modified-Since = Wed, 16 Sep 2026 10:12:31 GMT for http://localhost:43915/api/school/respect/person?includeRelated=false  ©´/ÕË2026-09-16 14:12:33.366 [Test worker @coroutine#165] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43915/api/school/respect/person?includeRelated=false  ©´/ÕÉ2026-09-16 14:12:33.366 [Test worker @coroutine#165] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:43915/api/school/respect/person?includeRelated=false.  ©´/×Ö2026-09-16 14:12:33.368 [eventLoopGroupProxy-25-1 @call-handler#190] 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)]  ©´/×ÉSep 16, 2026 2:12:33 PM io.github.aakira.napier.DebugAntilog performLog  ©´/×ÀFINE: [DEBUG] MapPagingSource$load - MapPagingSource(tag=PersonDataSourceDb/listAsPagingSource(params=GetListParams(common=GetListCommonParams(guid=null, searchQuery=null, since=null, sinceIfPermissionsNotChangedSince=null, includeDeleted=null), filterByClazzUid=null, filterByEnrolmentRole=null, filterByName=null, filterByPersonStatus=null, filterByPersonRole=null, includeRelated=false, inClassOnDay=null))): load Refresh(key=0, loadSize=1000)  ©´/Ùô2026-09-16 14:12:33.370 [Test worker @coroutine#165] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43915/api/school/respect/person?includeRelated=false  ©´/ÙÉ2026-09-16 14:12:33.370 [Test worker @coroutine#165] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43915/api/school/respect/person?includeRelated=false  ©´/ÙÏ2026-09-16 14:12:33.370 [Test worker @coroutine#165] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43915/api/school/respect/person?includeRelated=false  ©´/Ùß2026-09-16 14:12:33.370 [Test worker @coroutine#165] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:43915/api/school/respect/person?includeRelated=false.  ©´4+Õ2026-09-16 14:12:34.475 [Test worker @coroutine#196] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off.  ©´4+ÿ2026-09-16 14:12:34.476 [Test worker @coroutine#196] INFO io.ktor.server.Application - Application started in 0.038 seconds.  ©´4,Ë2026-09-16 14:12:34.477 [DefaultDispatcher-worker-4 @coroutine#205] INFO io.ktor.server.Application - Responding at http://0.0.0.0:41877  ©´4/Ë2026-09-16 14:12:34.480 [Test worker @coroutine#196] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41877/api/school/respect/person?includeRelated=false  ©´4/É2026-09-16 14:12:34.480 [Test worker @coroutine#196] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41877/api/school/respect/person?includeRelated=false.  ©´41Ö2026-09-16 14:12:34.482 [eventLoopGroupProxy-28-1 @call-handler#209] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]  ©´41/, segment:0 -> SUCCESS @ /  ©´41¥ /api, segment:1 -> SUCCESS @ /api  ©´41µ /api/school, segment:2 -> SUCCESS @ /api/school  ©´41Ç /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect  ©´41× /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person  ©´41÷ /api/school/respect/person [(method:GET)], segment:4 -> SUCCESS @ /api/school/respect/person [(method:GET)]  ©´41Ñ /api/school/respect/person [(method:POST)], segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person [(method:POST)]  ©´41‘Matched routes:  ©´41Æ "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"  ©´41™Routing resolve result:  ©´41· SUCCESS @ /api/school/respect/person [(method:GET)]  ©´42ÉSep 16, 2026 2:12:34 PM io.github.aakira.napier.DebugAntilog performLog  ©´42ÀFINE: [DEBUG] MapPagingSource$load - MapPagingSource(tag=PersonDataSourceDb/listAsPagingSource(params=GetListParams(common=GetListCommonParams(guid=null, searchQuery=null, since=null, sinceIfPermissionsNotChangedSince=null, includeDeleted=null), filterByClazzUid=null, filterByEnrolmentRole=null, filterByName=null, filterByPersonStatus=null, filterByPersonRole=null, includeRelated=false, inClassOnDay=null))): load Refresh(key=0, loadSize=1000)  ©´45ô2026-09-16 14:12:34.486 [Test worker @coroutine#196] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41877/api/school/respect/person?includeRelated=false  ©´45É2026-09-16 14:12:34.486 [Test worker @coroutine#196] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41877/api/school/respect/person?includeRelated=false  ©´45Ï2026-09-16 14:12:34.486 [Test worker @coroutine#196] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41877/api/school/respect/person?includeRelated=false  ©´46ß2026-09-16 14:12:34.487 [Test worker @coroutine#196] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41877/api/school/respect/person?includeRelated=false.  ©´4]à0DataReadyState(data=[Person(guid=4242, userActive=true, status=ACTIVE, lastModified=2026-09-16T10:12:34.377Z, stored=2026-09-16T10:12:34.524Z, metadata=null, userMasterIdentifier=null, username=null, givenName=Admin, familyName=User, middleName=null, gender=UNSPECIFIED, preferredFirstName=null, preferredMiddleName=null, preferredLastName=null, pronouns=null, roles=[PersonRole(isPrimaryRole=true, roleEnum=SYSTEM_ADMINISTRATOR, beginDate=null, endDate=null)], relatedPersonUids=[], dateOfBirth=null, email=null, phoneNumber=null)], metaInfo=DataLoadMetaInfo(lastModified=1789553554377, lastStored=1789553554524, etag=null, url=http://localhost:41877/api/school/respect/person?includeRelated=false, consistentThrough=2026-09-16T10:12:34.525161146Z, validationInfoKey=0, varyHeader=null, headers=null, permissionsLastModified=null), localState=DataReadyState(data=[Person(guid=4242, userActive=true, status=ACTIVE, lastModified=2026-09-16T10:12:34.377Z, stored=2026-09-16T10:12:34.524Z, metadata=null, userMasterIdentifier=null, username=null, givenName=Admin, familyName=User, middleName=null, gender=UNSPECIFIED, preferredFirstName=null, preferredMiddleName=null, preferredLastName=null, pronouns=null, roles=[PersonRole(isPrimaryRole=true, roleEnum=SYSTEM_ADMINISTRATOR, beginDate=null, endDate=null)], relatedPersonUids=[], dateOfBirth=null, email=null, phoneNumber=null)], metaInfo=DataLoadMetaInfo(lastModified=1789553554377, lastStored=1789553554524, etag=null, url=null, consistentThrough=2026-09-16T10:12:34.525161146Z, validationInfoKey=0, varyHeader=null, headers=null, permissionsLastModified=null), localState=null, remoteState=null), remoteState=DataReadyState(data=[Person(guid=4242, userActive=true, status=ACTIVE, lastModified=2026-09-16T10:12:34.377Z, stored=2026-09-16T10:12:34.437Z, metadata=null, userMasterIdentifier=null, username=null, givenName=Admin, familyName=User, middleName=null, gender=UNSPECIFIED, preferredFirstName=null, preferredMiddleName=null, preferredLastName=null, pronouns=null, roles=[PersonRole(isPrimaryRole=true, roleEnum=SYSTEM_ADMINISTRATOR, beginDate=null, endDate=null)], relatedPersonUids=[], dateOfBirth=null, email=null, phoneNumber=null), Person(guid=42, userActive=true, status=ACTIVE, lastModified=2026-09-16T10:12:34.376Z, stored=2026-09-16T10:12:34.478Z, metadata=null, userMasterIdentifier=null, username=test, givenName=test, familyName=test, middleName=null, gender=FEMALE, preferredFirstName=null, preferredMiddleName=null, preferredLastName=null, pronouns=null, roles=[PersonRole(isPrimaryRole=true, roleEnum=SITE_ADMINISTRATOR, beginDate=null, endDate=null)], relatedPersonUids=[], dateOfBirth=null, email=null, phoneNumber=null)], metaInfo=DataLoadMetaInfo(lastModified=1789553554000, lastStored=-1, etag=null, url=http://localhost:41877/api/school/respect/person?includeRelated=false, consistentThrough=2026-09-16T10:12:34.482960211Z, validationInfoKey=7092960727423664838, varyHeader=Authorization, headers=io.ktor.client.engine.okhttp.OkUtilsKt$fromOkHttp$1@2c2aab92, permissionsLastModified=null), localState=null, remoteState=null))  ©´4^ÉSep 16, 2026 2:12:34 PM io.github.aakira.napier.DebugAntilog performLog  ©´4^æFINE: [DEBUG] DelegatedInvalidationPagingSource$onSrcInvalidated - RPaging/DelegatedInvalidationPagingSource(extra=PersonDataSourceDb/listAsPagingSource(params=GetListParams(common=GetListCommonParams(guid=null, searchQuery=null, since=null, sinceIfPermissionsNotChangedSince=null, includeDeleted=null), filterByClazzUid=null, filterByEnrolmentRole=null, filterByName=null, filterByPersonStatus=null, filterByPersonRole=null, includeRelated=false, inClassOnDay=null))) src invalidated  ©´4_ô2026-09-16 14:12:34.528 [Test worker @coroutine#196] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41877/api/school/respect/person?since=2026-09-16T10%3A12%3A34.482960211Z&includeRelated=false  ©´4`ò2026-09-16 14:12:34.529 [Test worker @coroutine#196] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41877/api/school/respect/person?since=2026-09-16T10%3A12%3A34.482960211Z&includeRelated=false.  ©´4aÖ2026-09-16 14:12:34.530 [eventLoopGroupProxy-28-1 @call-handler#216] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]  ©´4a/, segment:0 -> SUCCESS @ /  ©´4a¥ /api, segment:1 -> SUCCESS @ /api  ©´4aµ /api/school, segment:2 -> SUCCESS @ /api/school  ©´4aÇ /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect  ©´4a× /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person  ©´4a÷ /api/school/respect/person [(method:GET)], segment:4 -> SUCCESS @ /api/school/respect/person [(method:GET)]  ©´4aÑ /api/school/respect/person [(method:POST)], segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person [(method:POST)]  ©´4a‘Matched routes:  ©´4aÆ "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"  ©´4a™Routing resolve result:  ©´4a· SUCCESS @ /api/school/respect/person [(method:GET)]  ©´4aÉSep 16, 2026 2:12:34 PM io.github.aakira.napier.DebugAntilog performLog  ©´4aÚFINE: [DEBUG] MapPagingSource$load - MapPagingSource(tag=PersonDataSourceDb/listAsPagingSource(params=GetListParams(common=GetListCommonParams(guid=null, searchQuery=null, since=2026-09-16T10:12:34.482960211Z, sinceIfPermissionsNotChangedSince=null, includeDeleted=null), filterByClazzUid=null, filterByEnrolmentRole=null, filterByName=null, filterByPersonStatus=null, filterByPersonRole=null, includeRelated=false, inClassOnDay=null))): load Refresh(key=0, loadSize=1000)  ©´4cÝ2026-09-16 14:12:34.531 [Test worker @coroutine#196] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41877/api/school/respect/person?since=2026-09-16T10%3A12%3A34.482960211Z&includeRelated=false  ©´4cò2026-09-16 14:12:34.532 [Test worker @coroutine#196] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41877/api/school/respect/person?since=2026-09-16T10%3A12%3A34.482960211Z&includeRelated=false  ©´4cø2026-09-16 14:12:34.532 [Test worker @coroutine#196] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41877/api/school/respect/person?since=2026-09-16T10%3A12%3A34.482960211Z&includeRelated=false  ©´4cÈ2026-09-16 14:12:34.532 [Test worker @coroutine#196] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41877/api/school/respect/person?since=2026-09-16T10%3A12%3A34.482960211Z&includeRelated=false.  ©´4d—Run time: 55.125389ms  ©´8¶Õ2026-09-16 14:12:35.639 [Test worker @coroutine#222] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off.  ©´8¸ÿ2026-09-16 14:12:35.640 [Test worker @coroutine#222] INFO io.ktor.server.Application - Application started in 0.041 seconds.  ©´8¹Ë2026-09-16 14:12:35.641 [DefaultDispatcher-worker-5 @coroutine#232] INFO io.ktor.server.Application - Responding at http://0.0.0.0:36285  ©´8ºÊ2026-09-16 14:12:35.643 [Test worker @coroutine#222] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36285/playlist/ec5f3d20-1df1-4d77-94a1-a1ca4c2ef837  ©´8ºÈ2026-09-16 14:12:35.643 [Test worker @coroutine#222] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:36285/playlist/ec5f3d20-1df1-4d77-94a1-a1ca4c2ef837.  ©´8½è2026-09-16 14:12:35.646 [eventLoopGroupProxy-31-1 @call-handler#235] TRACE io.ktor.server.routing.Routing - Trace for [playlist, ec5f3d20-1df1-4d77-94a1-a1ca4c2ef837]  ©´8½/, segment:0 -> SUCCESS @ /  ©´8½¯ /playlist, segment:1 -> SUCCESS @ /playlist  ©´8½ù /playlist/{uuid}, segment:2 -> SUCCESS; Parameters [uuid=[ec5f3d20-1df1-4d77-94a1-a1ca4c2ef837]] @ /playlist/{uuid}  ©´8½ß /playlist/{uuid} [(method:GET)], segment:2 -> SUCCESS @ /playlist/{uuid} [(method:GET)]  ©´8½ù /playlist/{uuid} [(method:POST)], segment:2 -> FAILURE "Selector didn't match" @ /playlist/{uuid} [(method:POST)]  ©´8½‘Matched routes:  ©´8½² "" -> "playlist" -> "{uuid}" -> "(method:GET)"  ©´8½™Routing resolve result:  ©´8½ç SUCCESS; Parameters [uuid=[ec5f3d20-1df1-4d77-94a1-a1ca4c2ef837]] @ /playlist/{uuid} [(method:GET)]  ©´8Âó2026-09-16 14:12:35.651 [Test worker @coroutine#222] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36285/playlist/ec5f3d20-1df1-4d77-94a1-a1ca4c2ef837  ©´8ÂÈ2026-09-16 14:12:35.651 [Test worker @coroutine#222] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36285/playlist/ec5f3d20-1df1-4d77-94a1-a1ca4c2ef837  ©´8ÂÎ2026-09-16 14:12:35.651 [Test worker @coroutine#222] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36285/playlist/ec5f3d20-1df1-4d77-94a1-a1ca4c2ef837  ©´8Âð2026-09-16 14:12:35.651 [Test worker @coroutine#222] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsFeed for http://localhost:36285/playlist/ec5f3d20-1df1-4d77-94a1-a1ca4c2ef837.  ©´=7Õ2026-09-16 14:12:36.791 [Test worker @coroutine#239] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off.  ©´=7ÿ2026-09-16 14:12:36.792 [Test worker @coroutine#239] INFO io.ktor.server.Application - Application started in 0.037 seconds.  ©´=8Ë2026-09-16 14:12:36.793 [DefaultDispatcher-worker-3 @coroutine#248] INFO io.ktor.server.Application - Responding at http://0.0.0.0:41707  ©´=`Ù2026-09-16 14:12:36.833 [DefaultDispatcher-worker-2 @coroutine#246] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41707/playlist/1f63ac14-e1eb-47d3-8dde-3969a058bb50  ©´=`Õ2026-09-16 14:12:36.833 [DefaultDispatcher-worker-2 @coroutine#246] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@5676f29b for http://localhost:41707/playlist/1f63ac14-e1eb-47d3-8dde-3969a058bb50  ©´=a×2026-09-16 14:12:36.833 [DefaultDispatcher-worker-2 @coroutine#246] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:41707/playlist/1f63ac14-e1eb-47d3-8dde-3969a058bb50 from class io.ktor.http.content.TextContent  ©´=cè2026-09-16 14:12:36.835 [eventLoopGroupProxy-34-1 @call-handler#255] TRACE io.ktor.server.routing.Routing - Trace for [playlist, 1f63ac14-e1eb-47d3-8dde-3969a058bb50]  ©´=c/, segment:0 -> SUCCESS @ /  ©´=c¯ /playlist, segment:1 -> SUCCESS @ /playlist  ©´=cù /playlist/{uuid}, segment:2 -> SUCCESS; Parameters [uuid=[1f63ac14-e1eb-47d3-8dde-3969a058bb50]] @ /playlist/{uuid}  ©´=c÷ /playlist/{uuid} [(method:GET)], segment:2 -> FAILURE "Selector didn't match" @ /playlist/{uuid} [(method:GET)]  ©´=cá /playlist/{uuid} [(method:POST)], segment:2 -> SUCCESS @ /playlist/{uuid} [(method:POST)]  ©´=c‘Matched routes:  ©´=c³ "" -> "playlist" -> "{uuid}" -> "(method:POST)"  ©´=c™Routing resolve result:  ©´=cè SUCCESS; Parameters [uuid=[1f63ac14-e1eb-47d3-8dde-3969a058bb50]] @ /playlist/{uuid} [(method:POST)]  ©´=có2026-09-16 14:12:36.836 [eventLoopGroupProxy-34-1 @call-handler#255] 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/1f63ac14-e1eb-47d3-8dde-3969a058bb50  ©´=dÔ2026-09-16 14:12:36.837 [eventLoopGroupProxy-34-1 @call-handler#255] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the POST /playlist/1f63ac14-e1eb-47d3-8dde-3969a058bb50 request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].  ©´=eÂ2026-09-16 14:12:36.837 [DefaultDispatcher-worker-5 @coroutine#246] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41707/playlist/1f63ac14-e1eb-47d3-8dde-3969a058bb50  ©´=e×2026-09-16 14:12:36.838 [DefaultDispatcher-worker-5 @coroutine#246] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41707/playlist/1f63ac14-e1eb-47d3-8dde-3969a058bb50  ©´=eÝ2026-09-16 14:12:36.838 [DefaultDispatcher-worker-5 @coroutine#246] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41707/playlist/1f63ac14-e1eb-47d3-8dde-3969a058bb50  ©´A Õ2026-09-16 14:12:37.921 [Test worker @coroutine#260] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off.  ©´A¢ÿ2026-09-16 14:12:37.922 [Test worker @coroutine#260] INFO io.ktor.server.Application - Application started in 0.039 seconds.  ©´A£Ë2026-09-16 14:12:37.924 [DefaultDispatcher-worker-4 @coroutine#269] INFO io.ktor.server.Application - Responding at http://0.0.0.0:36491  ©´AòÆ2026-09-16 14:12:38.003 [DefaultDispatcher-worker-5 @coroutine#267] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36491/api/school/xapi/statements  ©´AôÁ2026-09-16 14:12:38.005 [DefaultDispatcher-worker-5 @coroutine#267] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@56564db for http://localhost:36491/api/school/xapi/statements  ©´AôÄ2026-09-16 14:12:38.005 [DefaultDispatcher-worker-5 @coroutine#267] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:36491/api/school/xapi/statements from class io.ktor.http.content.TextContent  ©´Aö×2026-09-16 14:12:38.007 [eventLoopGroupProxy-37-1 @call-handler#278] TRACE io.ktor.server.routing.Routing - Trace for [api, school, xapi, statements]  ©´Aö/, segment:0 -> SUCCESS @ /  ©´Aö¥ /api, segment:1 -> SUCCESS @ /api  ©´Aöµ /api/school, segment:2 -> SUCCESS @ /api/school  ©´AöÁ /api/school/xapi, segment:3 -> SUCCESS @ /api/school/xapi  ©´AöÙ /api/school/xapi/statements, segment:4 -> SUCCESS @ /api/school/xapi/statements  ©´AöÑ /api/school/xapi/statements [(method:GET)], segment:4 -> FAILURE "Selector didn't match" @ /api/school/xapi/statements [(method:GET)]  ©´Aöû /api/school/xapi/statements [(method:POST)], segment:4 -> SUCCESS @ /api/school/xapi/statements [(method:POST)]  ©´Aö‘Matched routes:  ©´AöÈ "" -> "api" -> "school" -> "xapi" -> "statements" -> "(method:POST)"  ©´Aö™Routing resolve result:  ©´Aö¹ SUCCESS @ /api/school/xapi/statements [(method:POST)]  ©´Aöá2026-09-16 14:12:38.007 [eventLoopGroupProxy-37-1 @call-handler#278] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(kotlinx.serialization.json.JsonElement) for call /api/school/xapi/statements  ©´BÑ2026-09-16 14:12:38.018 [DefaultDispatcher-worker-6 @coroutine#267] TRACE i.k.client.plugins.HttpCallValidator - Processing exception java.io.IOException: unexpected end of stream on http://localhost:36491/... for request http://localhost:36491/api/school/xapi/statements  ©´BÍException in thread "DefaultDispatcher-worker-6 @coroutine#267" java.io.IOException: unexpected end of stream on http://localhost:36491/...  ©´B¶ at _COROUTINE._BOUNDARY._(CoroutineDebugging.kt:42)  ©´B× at io.ktor.client.engine.okhttp.OkHttpEngine.executeHttpRequest(OkHttpEngine.kt:107)  ©´BË at io.ktor.client.engine.okhttp.OkHttpEngine.execute(OkHttpEngine.kt:71)  ©´Bî at io.ktor.client.engine.HttpClientEngine$executeWithinCallContext$2.invokeSuspend(HttpClientEngine.kt:183)  ©´BÞ at io.ktor.client.engine.HttpClientEngine.executeWithinCallContext(HttpClientEngine.kt:184)  ©´BÝ at io.ktor.client.engine.HttpClientEngine$install$1.invokeSuspend(HttpClientEngine.kt:154)  ©´BØ at io.ktor.util.pipeline.DebugPipelineContext.proceedLoop(DebugPipelineContext.kt:79)  ©´BÌ at io.ktor.client.plugins.HttpSend$DefaultSender.execute(HttpSend.kt:141)  ©´Bß at io.ktor.client.plugins.HttpRedirectKt$HttpRedirect$2$1.invokeSuspend(HttpRedirect.kt:110)  ©´BÐ at io.ktor.client.plugins.api.Send$install$1.invokeSuspend(CommonHooks.kt:52)  ©´Bî at io.ktor.client.plugins.HttpCallValidatorKt$HttpCallValidator$2$2.invokeSuspend(HttpCallValidator.kt:143)  ©´BÐ at io.ktor.client.plugins.api.Send$install$1.invokeSuspend(CommonHooks.kt:52)  ©´BÕ at io.ktor.client.plugins.HttpSend$Plugin$install$1.invokeSuspend(HttpSend.kt:107)  ©´BØ at io.ktor.util.pipeline.DebugPipelineContext.proceedLoop(DebugPipelineContext.kt:79)  ©´Bë at io.ktor.client.plugins.DefaultTransformKt$defaultTransformers$1.invokeSuspend(DefaultTransform.kt:64)  ©´BØ at io.ktor.util.pipeline.DebugPipelineContext.proceedLoop(DebugPipelineContext.kt:79)  ©´Bé at io.ktor.client.plugins.api.TransformRequestBodyHook$install$1.invokeSuspend(KtorCallContexts.kt:88)  ©´BØ at io.ktor.util.pipeline.DebugPipelineContext.proceedLoop(DebugPipelineContext.kt:79)  ©´BÛ at io.ktor.client.plugins.RequestError$install$1.invokeSuspend(HttpCallValidator.kt:165)  ©´BØ at io.ktor.util.pipeline.DebugPipelineContext.proceedLoop(DebugPipelineContext.kt:79)  ©´Bö at io.ktor.client.plugins.HttpRequestLifecycleKt$HttpRequestLifecycle$1$1.invokeSuspend(HttpRequestLifecycle.kt:29)  ©´Bä at io.ktor.client.plugins.SetupRequestContext$install$1.invokeSuspend(HttpRequestLifecycle.kt:42)  ©´BØ at io.ktor.util.pipeline.DebugPipelineContext.proceedLoop(DebugPipelineContext.kt:79)  ©´BÌ at io.ktor.client.HttpClient.execute$ktor_client_core(HttpClient.kt:1420)  ©´BÐ at io.ktor.client.statement.HttpStatement.fetchResponse(HttpStatement.kt:207)  ©´Bñ at world.respect.datalayer.http.school.xapi.XapiStatementsResourceHttp.post(XapiStatementsResourceHttp.kt:129)  ©´B at world.respect.datalayer.repository.school.writequeue.DrainRemoteWriteQueueUseCase.invoke(DrainRemoteWriteQueueUseCase.kt:90)  ©´BÌ at world.respect.lib.test.clientservertest.ClientServerDataSourceTestBuilder$clients$1$2.invokeSuspend(ClientServerDatasourceTest.kt:280)  ©´Bñ Suppressed: kotlinx.coroutines.internal.DiagnosticCoroutineContextException: [CoroutineId(267), "coroutine#267":StandaloneCoroutine{Cancelling}@228ce798, Dispatchers.Default]  ©´BØCaused by: java.io.IOException: unexpected end of stream on http://localhost:36491/...  ©´BÞ at okhttp3.internal.http1.Http1ExchangeCodec.readResponseHeaders(Http1ExchangeCodec.kt:252)  ©´BÏ at okhttp3.internal.connection.Exchange.readResponseHeaders(Exchange.kt:116)  ©´BØ at okhttp3.internal.http.CallServerInterceptor.intercept(CallServerInterceptor.kt:97)  ©´BÕ at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.kt:332)  ©´BØ at okhttp3.internal.connection.ConnectInterceptor.intercept(ConnectInterceptor.kt:34)  ©´BÕ at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.kt:332)  ©´BÏ at okhttp3.internal.cache.CacheInterceptor.intercept(CacheInterceptor.kt:98)  ©´BÕ at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.kt:332)  ©´BÐ at okhttp3.internal.http.BridgeInterceptor.intercept(BridgeInterceptor.kt:83)  ©´BÕ at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.kt:332)  ©´Bä at okhttp3.internal.http.RetryAndFollowUpInterceptor.intercept(RetryAndFollowUpInterceptor.kt:72)  ©´BÕ at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.kt:332)  ©´Bâ at okhttp3.internal.connection.RealCall.getResponseWithInterceptorChain$okhttp(RealCall.kt:232)  ©´BÉ at okhttp3.internal.connection.RealCall$AsyncCall.run(RealCall.kt:580)  ©´Bß at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136)  ©´Bß at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)  ©´Bµ at java.base/java.lang.Thread.run(Thread.java:840)  ©´BÂCaused by: java.io.EOFException: \n not found: limit=0 content=…  ©´BË at okio.RealBufferedSource.readUtf8LineStrict(RealBufferedSource.kt:362)  ©´BÈ at okhttp3.internal.http1.HeadersReader.readLine(HeadersReader.kt:32)  ©´BÞ at okhttp3.internal.http1.Http1ExchangeCodec.readResponseHeaders(Http1ExchangeCodec.kt:215)  ©´BŽ ... 16 more  ©´F½Õ2026-09-16 14:12:39.230 [Test worker @coroutine#282] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off.  ©´F¾ÿ2026-09-16 14:12:39.231 [Test worker @coroutine#282] INFO io.ktor.server.Application - Application started in 0.048 seconds.  ©´F¿Ë2026-09-16 14:12:39.232 [DefaultDispatcher-worker-2 @coroutine#291] INFO io.ktor.server.Application - Responding at http://0.0.0.0:41761  ©´FíÅ2026-09-16 14:12:39.278 [Test worker @coroutine#282] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41761/api/school/xapi/statements?statementId=6690e6c9-3ef0-4ed3-8b37-7f3964730bee&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false  ©´FíÃ2026-09-16 14:12:39.278 [Test worker @coroutine#282] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41761/api/school/xapi/statements?statementId=6690e6c9-3ef0-4ed3-8b37-7f3964730bee&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.  ©´Fð×2026-09-16 14:12:39.280 [eventLoopGroupProxy-40-1 @call-handler#298] TRACE io.ktor.server.routing.Routing - Trace for [api, school, xapi, statements]  ©´Fð/, segment:0 -> SUCCESS @ /  ©´Fð¥ /api, segment:1 -> SUCCESS @ /api  ©´Fðµ /api/school, segment:2 -> SUCCESS @ /api/school  ©´FðÁ /api/school/xapi, segment:3 -> SUCCESS @ /api/school/xapi  ©´FðÙ /api/school/xapi/statements, segment:4 -> SUCCESS @ /api/school/xapi/statements  ©´Fðù /api/school/xapi/statements [(method:GET)], segment:4 -> SUCCESS @ /api/school/xapi/statements [(method:GET)]  ©´FðÓ /api/school/xapi/statements [(method:POST)], segment:4 -> FAILURE "Selector didn't match" @ /api/school/xapi/statements [(method:POST)]  ©´Fð‘Matched routes:  ©´FðÇ "" -> "api" -> "school" -> "xapi" -> "statements" -> "(method:GET)"  ©´Fð™Routing resolve result:  ©´Fð¸ SUCCESS @ /api/school/xapi/statements [(method:GET)]  ©´Fóî2026-09-16 14:12:39.284 [Test worker @coroutine#282] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41761/api/school/xapi/statements?statementId=6690e6c9-3ef0-4ed3-8b37-7f3964730bee&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false  ©´FôÃ2026-09-16 14:12:39.284 [Test worker @coroutine#282] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41761/api/school/xapi/statements?statementId=6690e6c9-3ef0-4ed3-8b37-7f3964730bee&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false  ©´FôÉ2026-09-16 14:12:39.284 [Test worker @coroutine#282] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41761/api/school/xapi/statements?statementId=6690e6c9-3ef0-4ed3-8b37-7f3964730bee&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false  ©´Fôö2026-09-16 14:12:39.285 [Test worker @coroutine#282] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:41761/api/school/xapi/statements?statementId=6690e6c9-3ef0-4ed3-8b37-7f3964730bee&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.