Gradle Test Run :lib-datalayer-repository:jvmTest[jvm]
givenRequestMade_whenDataChangedAndNextRequestSinceParamSetToPreviousConsistentThroughValue_thenRemoteResultShouldBeUpdated[jvm]
summary
|
100%
successful |
standard output
2026-10-05 04:37:01.461 [Test worker @coroutine#270] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-10-05 04:37:01.466 [Test worker @coroutine#270] INFO io.ktor.server.Application - Application started in 0.058 seconds.
2026-10-05 04:37:01.476 [DefaultDispatcher-worker-3 @coroutine#279] INFO io.ktor.server.Application - Responding at http://0.0.0.0:34319
2026-10-05 04:37:01.486 [Test worker @coroutine#270] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34319/api/school/respect/person?includeRelated=false
2026-10-05 04:37:01.487 [Test worker @coroutine#270] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:34319/api/school/respect/person?includeRelated=false.
2026-10-05 04:37:01.519 [eventLoopGroupProxy-28-1 @call-handler#283] 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-10-05 04:37:01.542 [Test worker @coroutine#270] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34319/api/school/respect/person?includeRelated=false
2026-10-05 04:37:01.542 [Test worker @coroutine#270] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34319/api/school/respect/person?includeRelated=false
2026-10-05 04:37:01.542 [Test worker @coroutine#270] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34319/api/school/respect/person?includeRelated=false
2026-10-05 04:37:01.544 [Test worker @coroutine#270] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34319/api/school/respect/person?includeRelated=false.
DataReadyState(data=[Person(guid=4242, userActive=true, status=ACTIVE, lastModified=2026-10-05T00:37:01.348Z, stored=2026-10-05T00:37:01.600Z, 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=1791160621348, lastStored=1791160621600, etag=null, url=http://localhost:34319/api/school/respect/person?includeRelated=false, consistentThrough=2026-10-05T00:37:01.611045722Z, validationInfoKey=0, varyHeader=null, headers=Headers [], permissionsLastModified=null), localState=DataReadyState(data=[Person(guid=4242, userActive=true, status=ACTIVE, lastModified=2026-10-05T00:37:01.348Z, stored=2026-10-05T00:37:01.600Z, 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=1791160621348, lastStored=1791160621600, etag=null, url=null, consistentThrough=2026-10-05T00:37:01.611045722Z, validationInfoKey=0, varyHeader=null, headers=Headers [], permissionsLastModified=null), localState=null, remoteState=null), remoteState=DataReadyState(data=[Person(guid=4242, userActive=true, status=ACTIVE, lastModified=2026-10-05T00:37:01.348Z, stored=2026-10-05T00:37:01.406Z, 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-10-05T00:37:01.340Z, stored=2026-10-05T00:37:01.477Z, 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=1791160621000, lastStored=-1, etag=null, url=http://localhost:34319/api/school/respect/person?includeRelated=false, consistentThrough=2026-10-05T00:37:01.532099741Z, validationInfoKey=7092960727423664838, varyHeader=Authorization, headers=io.ktor.client.engine.okhttp.OkUtilsKt$fromOkHttp$1@727dcc64, permissionsLastModified=null), localState=null, remoteState=null))
2026-10-05 04:37:01.625 [Test worker @coroutine#270] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34319/api/school/respect/person?since=2026-10-05T00%3A37%3A01.532099741Z&includeRelated=false
2026-10-05 04:37:01.626 [Test worker @coroutine#270] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:34319/api/school/respect/person?since=2026-10-05T00%3A37%3A01.532099741Z&includeRelated=false.
2026-10-05 04:37:01.639 [eventLoopGroupProxy-28-1 @call-handler#290] 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-10-05 04:37:01.658 [Test worker @coroutine#270] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34319/api/school/respect/person?since=2026-10-05T00%3A37%3A01.532099741Z&includeRelated=false
2026-10-05 04:37:01.659 [Test worker @coroutine#270] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34319/api/school/respect/person?since=2026-10-05T00%3A37%3A01.532099741Z&includeRelated=false
2026-10-05 04:37:01.659 [Test worker @coroutine#270] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34319/api/school/respect/person?since=2026-10-05T00%3A37%3A01.532099741Z&includeRelated=false
2026-10-05 04:37:01.669 [Test worker @coroutine#270] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34319/api/school/respect/person?since=2026-10-05T00%3A37%3A01.532099741Z&includeRelated=false.
Run time: 194.377221ms
error output
Oct 05, 2026 4:37:01 AM 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) Oct 05, 2026 4:37:01 AM 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 Oct 05, 2026 4:37:01 AM io.github.aakira.napier.DebugAntilog performLog FINE: [DEBUG] MapPagingSource$load - MapPagingSource(tag=PersonDataSourceDb/listAsPagingSource(params=GetListParams(common=GetListCommonParams(guid=null, searchQuery=null, since=2026-10-05T00:37:01.532099741Z, sinceIfPermissionsNotChangedSince=null, includeDeleted=null), filterByClazzUid=null, filterByEnrolmentRole=null, filterByName=null, filterByPersonStatus=null, filterByPersonRole=null, includeRelated=false, inClassOnDay=null))): load Refresh(key=0, loadSize=1000)