amplify-android
amplify-android copied to clipboard
Published
20 hours ago •
aws-amplify
aws-amplify
Initial Sync Takestime Long Time
Before opening, please confirm:
- [X] I have searched for duplicate or closed issues and discussions.
Language and Async Model
Kotlin
Amplify Categories
DataStore
Gradle script dependencies
// Put output below this line
implementation "com.amplifyframework:core:$amplify_version"
implementation "com.amplifyframework:aws-auth-cognito:$amplify_version"
implementation "com.amplifyframework:aws-datastore:$amplify_version"
implementation "com.amplifyframework:aws-api:$amplify_version"
implementation "com.amplifyframework:aws-storage-s3:$amplify_version"
amplify_version = '1.35.7'
Environment information
# Put output below this line
https\://services.gradle.org/distributions/gradle-7.3.3-bin.zip
Please include any relevant guides or documentation you're referencing
No response
Describe the bug
After start sync if we save any data using datastore.save method it shows below warning and data is not synced with dynamoDB.
It shows Success but sometimes createdAt and updatedAt null and data not synced to dynamoDB
amplify:aws-datastore: Successfully enqueued PendingMutation{mutatedItem=SerializedModel{id=
Reproduction steps (if applicable)
No response
Code Snippet
// Put your code below this line.
fun saveDataProfile(argTag: String, item: Model) {
debugs(argTag, TAG, "Values:saveData", item.modelName, item.toJSON())
Amplify.DataStore.save(item,
{
debugs(argTag, TAG, "Save DataStore Profile Success", item.modelName, it.toString())
}, {
errors(argTag, TAG, "Save DataStore Profile Error", item.modelName, it)
}
)
}
Log output
// Put your logs below this line
2022-06-22 17:45:59.392 27323-28169/com.xxx.xxx I/amplify:aws-datastore: Mutation outbox has pending mutation for e4fa6b1d-ce76-53ea-b402-ce74202364c2. Saving the metadata, but not model itself.
2022-06-22 17:45:59.878 27323-28172/com.xxx.xxx I/amplify:aws-datastore: Successfully sync'd down model state from cloud.
2022-06-22 17:46:00.340 27323-28175/com.xxx.xxx I/amplify:aws-datastore: Successfully sync'd down model state from cloud.
2022-06-22 17:46:00.814 27323-28178/com.xxx.xxx I/amplify:aws-datastore: Successfully sync'd down model state from cloud.
2022-06-22 17:46:03.289 27323-28187/com.xxx.xxx I/amplify:aws-datastore: Successfully sync'd down model state from cloud.
2022-06-22 17:46:05.554 27323-28194/com.xxx.xxx I/amplify:aws-datastore: Successfully sync'd down model state from cloud.
2022-06-22 17:46:06.030 27323-28197/com.xxx.xxx I/amplify:aws-datastore: Successfully sync'd down model state from cloud.
2022-06-22 17:46:10.680 27323-28208/com.xxx.xxx I/amplify:aws-datastore: Successfully sync'd down model state from cloud.
2022-06-22 17:46:16.489 27323-28225/com.xxx.xxx I/amplify:aws-datastore: Successfully sync'd down model state from cloud.
2022-06-22 17:46:16.881 27323-28228/com.xxx.xxx I/amplify:aws-datastore: Successfully sync'd down model state from cloud.
2022-06-22 17:46:16.884 27323-27550/com.xxx.xxx I/amplify:aws-datastore: Started processing the mutation outbox. Pending mutations will be published to the cloud.
2022-06-22 17:46:16.886 27323-27449/com.xxx.xxx I/amplify:aws-datastore: Starting processing subscription data buffer.
2022-06-22 17:46:16.886 27323-27449/com.xxx.xxx I/amplify:aws-datastore: Started the orchestrator in API sync mode.
2022-06-22 17:46:17.249 27323-28230/com.xxx.xxx I/amplify:aws-datastore: Successfully removed from mutations outboxPendingMutation{mutatedItem=SerializedModel{id='', serializedData={eventAdditionalInfo=
2022-06-22 17:46:17.612 27323-28237/com.xxx.xxx I/amplify:aws-datastore: Successfully removed from mutations outboxPendingMutation{mutatedItem=SerializedModel{id='', serializedData={eventAdditionalInfo=
2022-06-22 17:46:18.119 27323-28243/com.xxx.xxx I/amplify:aws-datastore: Successfully removed from mutations outboxPendingMutation{mutatedItem=SerializedModel{id='', serializedData={createdAt=null, id=
2022-06-22 17:46:18.519 27323-28245/com.xxx.xxx I/amplify:aws-datastore: Successfully removed from mutations outboxPendingMutation{mutatedItem=SerializedModel{id='', serializedData={eventAdditionalInfo=
amplifyconfiguration.json
{ "UserAgent": "aws-amplify-cli/2.0", "Version": "1.0", "api": { "plugins": { "awsAPIPlugin": { "amplifysyncdata": { "endpointType": "GraphQL", "endpoint": "https://", "region": "us-west-2", "authorizationType": "AMAZON_COGNITO_USER_POOLS" } } } }, "auth": { "plugins": { "awsCognitoAuthPlugin": { "UserAgent": "aws-amplify-cli/0.1.0", "Version": "0.1.0", "IdentityManager": { "Default": {} }, "CognitoUserPool": { "Default": { "PoolId": "", "AppClientId": "", "Region": "us-west-2" } }, "Auth": { "Default": { "authenticationFlowType": "CUSTOM_AUTH", "socialProviders": [], "usernameAttributes": [ "PHONE_NUMBER" ], "signupAttributes": [ "PHONE_NUMBER" ], "passwordProtectionSettings": { "passwordPolicyMinLength": 8, "passwordPolicyCharacters": [] }, "mfaConfiguration": "OFF", "mfaTypes": [], "verificationMechanisms": [] } }, "AppSync": { "Default": { "ApiUrl": "", "Region": "us-west-2", "AuthMode": "AMAZON_COGNITO_USER_POOLS", "ClientDatabasePrefix": "amplifysyncdata_AMAZON_COGNITO_USER_POOLS" } } } } } }
GraphQL Schema
// Put your schema below this line
enum EType {
task
goal
meal
exercise
sleep
learning
geolocation
search
profile
}
enum IM {
manual
system
camera
voice
activtyTracker
photoLibrary
audio
video
}
enum Act {
add
update
delete
lookup
signup
}
type TestJ @model @auth(rules: [{ allow: owner }]) {
id: ID!
username: String!
version: Int!
type: String!
source: InputMethod!
action: String!
logData: String!
time: AWSDateTime!
deviceInfo: String!
expirationTime:Int
eventAdditionalInfo: String!
}
type GStatus @model @auth(rules: [{ allow: owner }]) {
id: ID!
username: String!
version: Int!
goalReference: String!
goalText: String
taskReferences: [String]!
startDate: AWSDateTime!
dueDate: AWSDateTime!
recordedDate: AWSDateTime
complete: Boolean!
selected: Boolean!
assigedByCoach: Boolean!
goalAdditionalInfo:String
}
type AStatus @model @auth(rules: [{ allow: owner }]) {
id: ID!
username: String!
version: Int!
goalReference: String!
goalText: String
taskReferences: [String]!
startDate: AWSDateTime!
dueDate: AWSDateTime!
recordedDate: AWSDateTime
complete: Boolean!
selected: Boolean!
deleted: Boolean!
goalAdditionalInfo:String
}
type TStatus @model @auth(rules: [{ allow: owner }]) {
id: ID!
username: String!
version: Int!
goalReference: String!
goalId:String!
goalCompleted: Boolean!
taskReference: String!
taskText: String
startDate: AWSDateTime!
dueDate: AWSDateTime!
expectedOccurrence: String
expectedParameter: String
loggedOccurence: String
loggedParameter: String
recordedDate: AWSDateTime
complete: Boolean!
taskAdditionalInfo: String
}
type SP @model @auth(rules: [{ allow: owner }]) {
id: ID!
username: String!
profile: String!
}
type UP @model @auth(rules: [{ allow: owner }]) {
id: ID!
username: String!
name: String!
value: String
}
type RItems @model @auth(rules: [{ allow: owner }]) {
id: ID!
username: String!
restaurantID: String!
restaurantName: String!
restaurantImage: String!
streetName: String!
city: String!
state: String!
recommended: Boolean!
favorite: Boolean!
favMarkedDate: AWSDateTime!
isItem: Boolean!
itemId: String
itemName: String
itemImage: String
itemNutritionScore: String
isRemoved: Boolean
additionalInfo: String
restLatitude: Float
restLongitude: Float
}
type UStatus @model @auth(rules: [{ allow: owner }]) {
id: ID!
username: String!
isDeleted: Boolean!
}
type RE @model @auth(rules: [{ allow: owner }]) {
id: ID!
username: String!
recommended: Boolean!
favorite: Boolean!
favMarkedDate: AWSDateTime!
isExercise: Boolean!
exerciseId: String
exerciseName: String
exerciseImage: String
exerciseTag: String
exerciseRating: Int
exerciseNutritionScore: Int
isRemoved: Boolean
additionalInfo: String
}
type Filter @model @auth(rules: [{ allow: owner }]) {
id: ID!
username: String!
deviceInfo: String!
filterAdditionalInfo: String!
}
type FRF @model @auth(rules: [{ allow: owner }]) {
id: ID!
username: String!
deviceInfo: String!
filterAdditionalInfo: String!
}
type HMs @model @auth(rules: [{ allow: owner }]) {
id: ID!
username: String!
itemId: String!
itemName: String!
imageName: String!
recommended: Boolean!
favorite: Boolean!
favMarkedDate: AWSDateTime!
isItem: Boolean!
nutritionScore: String
isRemoved: Boolean
additionalInfo: String
}
type GD @model @auth(rules: [{ allow: owner }]) {
id: ID!
username: String!
modelId: Int
modelDate: Int
additionalInfo: String
}
Additional information and screenshots
No response
@banji180 @chrisbonifacio any update on this it looks like app is broken now and user can't use it. It is critical
Mutation outbox has pending mutation for xx-xxx-xxxx-xxxxx. Saving the metadata, but not model itself.
@banji180 @chrisbonifacio I have implemented below method for verify all table sync completed or not. If all table sync completed after few mints and after that I will save data than it will not shows pending mutation error.
But now the issue is it takes time to sync all tables in local in 3 , 5 , 7 minutes when user first time login which is more than expectation. Sync should be finish in seconds like 10 to 15 maximum for all records.
You can check with same schema which I added in description.
How can i fix this or Is it required changes in amplify library confirm.
fun syncCompleted(argTag: String) {
Amplify.Hub.subscribe(HubChannel.DATASTORE,
{
it.name.equals(DataStoreChannelEventName.MODEL_SYNCED.toString()) },
{
val networkStatus = it.data as ModelSyncedEvent
debugs(argTag, "FullSync", networkStatus.toJSON())
}
)
}
New User Registered FirsTime: Taken 3 minute when no records in any table
-----------------------
2022-06-28 15:39:03.496 2582-2653/com.x--> {"added":0,"deleted":0,"isDeltaSync":false,"isFullSync":true,"model":"xx","updated":0}
2022-06-28 15:39:04.468 2582-2676/com.x--> {"added":0,"deleted":0,"isDeltaSync":false,"isFullSync":true,"model":"xx","updated":0}
2022-06-28 15:39:06.420 2582-2653/com.x--> {"added":0,"deleted":0,"isDeltaSync":false,"isFullSync":true,"model":"xx","updated":0}
2022-06-28 15:39:07.344 2582-2676/com.x--> {"added":0,"deleted":0,"isDeltaSync":false,"isFullSync":true,"model":"xx","updated":0}
2022-06-28 15:39:08.265 2582-2653/com.x--> {"added":0,"deleted":0,"isDeltaSync":false,"isFullSync":true,"model":"xx","updated":0}
2022-06-28 15:39:13.077 2582-2676/com.x--> {"added":0,"deleted":0,"isDeltaSync":false,"isFullSync":true,"model":"xx","updated":0}
2022-06-28 15:39:14.279 2582-2653/com.x--> {"added":0,"deleted":0,"isDeltaSync":false,"isFullSync":true,"model":"xx","updated":0}
2022-06-28 15:39:16.985 2582-2676/com.x--> {"added":0,"deleted":0,"isDeltaSync":false,"isFullSync":true,"model":"xx","updated":0}
2022-06-28 15:39:18.065 2582-2653/com.x--> {"added":0,"deleted":0,"isDeltaSync":false,"isFullSync":true,"model":"xx","updated":0}
2022-06-28 15:39:37.777 2582-2676/com.x--> {"added":0,"deleted":0,"isDeltaSync":false,"isFullSync":true,"model":"xx","updated":0}
2022-06-28 15:39:38.244 2582-2653/com.x--> {"added":0,"deleted":0,"isDeltaSync":false,"isFullSync":true,"model":"xx","updated":0}
2022-06-28 15:39:39.932 2582-2676/com.x--> {"added":0,"deleted":0,"isDeltaSync":false,"isFullSync":true,"model":"xx","updated":0}
2022-06-28 15:39:45.780 2582-2653/com.x--> {"added":0,"deleted":0,"isDeltaSync":false,"isFullSync":true,"model":"xx","updated":0}
2022-06-28 15:39:52.828 2582-2676/com.x--> {"added":0,"deleted":0,"isDeltaSync":false,"isFullSync":true,"model":"xx","updated":0}
2022-06-28 15:41:48.764 2582-3402/com.x--> {"added":0,"deleted":0,"isDeltaSync":false,"isFullSync":true,"model":"xx","updated":0}
Already Registered User Taken 5 minute if we have records in some table
------------------------
2022-06-28 16:00:47.188 5193-5576/com.x--> {"added":1,"deleted":0,"isDeltaSync":false,"isFullSync":true,"model":"xx","updated":0}
2022-06-28 16:00:48.221 5193-5261/com.x--> {"added":0,"deleted":0,"isDeltaSync":false,"isFullSync":true,"model":"xx","updated":0}
2022-06-28 16:00:49.140 5193-5576/com.x--> {"added":0,"deleted":0,"isDeltaSync":false,"isFullSync":true,"model":"xx","updated":0}
2022-06-28 16:00:50.217 5193-5261/com.x--> {"added":0,"deleted":0,"isDeltaSync":false,"isFullSync":true,"model":"xx","updated":0}
2022-06-28 16:00:55.425 5193-5576/com.x--> {"added":9,"deleted":0,"isDeltaSync":false,"isFullSync":true,"model":"xx","updated":0}
2022-06-28 16:00:56.672 5193-5261/com.x--> {"added":3,"deleted":0,"isDeltaSync":false,"isFullSync":true,"model":"xx","updated":0}
2022-06-28 16:04:05.947 5193-6021/com.x--> {"added":317,"deleted":0,"isDeltaSync":false,"isFullSync":true,"model":"xx","updated":0}
2022-06-28 16:04:24.840 5193-5261/com.x--> {"added":0,"deleted":0,"isDeltaSync":false,"isFullSync":true,"model":"xx","updated":0}
2022-06-28 16:04:32.492 5193-6021/com.x--> {"added":21,"deleted":0,"isDeltaSync":false,"isFullSync":true,"model":"xx","updated":0}
2022-06-28 16:04:33.683 5193-5261/com.x--> {"added":1,"deleted":0,"isDeltaSync":false,"isFullSync":true,"model":"xx","updated":0}
2022-06-28 16:04:34.260 5193-6021/com.x--> {"added":0,"deleted":0,"isDeltaSync":false,"isFullSync":true,"model":"xx","updated":0}
2022-06-28 16:04:34.666 5193-5261/com.x--> {"added":0,"deleted":0,"isDeltaSync":false,"isFullSync":true,"model":"xx","updated":0}
2022-06-28 16:04:36.742 5193-6021/com.x--> {"added":11,"deleted":0,"isDeltaSync":false,"isFullSync":true,"model":"xx","updated":0}
2022-06-28 16:04:39.668 5193-5261/com.x--> {"added":21,"deleted":0,"isDeltaSync":false,"isFullSync":true,"model":"xx","updated":0}
2022-06-28 16:04:45.802 5193-6021/com.x--> {"added":8,"deleted":0,"isDeltaSync":false,"isFullSync":true,"model":"xx","updated":0}
@kevinold Can you give sample code how to apply indexing from schema? Also i want to apply indexing on owner which is not part of schema how can I ?
@kevinold @banji180 @chrisbonifacio
iOS takes only 7 seconds for get all table isFullSync=true Android takes more 65 seconds for get all table isFullSync=true
It is big difference between this.
I added indexing on schema level now ios sync after fresh login in only 7 seconds but android took more than 1 minute. Also I am seeing this logs after start sync and after first model isFullSync=true success
2022-07-04 21:40:08.893 23387-23568/com. W/AWSMobileClient: Failed to federate tokens during sign-in
java.lang.Exception: Federation is not enabled, please check if you have CognitoIdentity configured.
at com.amazonaws.mobile.client.AWSMobileClient$11.run(AWSMobileClient.java:1882)
at com.amazonaws.mobile.client.internal.InternalCallback.await(InternalCallback.java:115)
at com.amazonaws.mobile.client.AWSMobileClient.federatedSignInWithoutAssigningState(AWSMobileClient.java:1835)
at com.amazonaws.mobile.client.AWSMobileClient$6$1.onSuccess(AWSMobileClient.java:1269)
at com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUser$6.onSuccess(CognitoUser.java:1102)
at com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUser$27.run(CognitoUser.java:3135)
at com.amazonaws.mobileconnectors.cognitoidentityprovider.continuations.ChallengeContinuation.continueTask(ChallengeContinuation.java:202)
at com.amazonaws.mobile.client.AWSMobileClient$7.run(AWSMobileClient.java:1467)
at com.amazonaws.mobile.client.internal.InternalCallback$1.run(InternalCallback.java:101)
at java.lang.Thread.run(Thread.java:920)
2022-07-04 21:40:08.917 23387-23572/com. D/MyLogsKt: Fragment --> AmplifyViewModel :-- confirmSignIn Success :: {"isSignInComplete":true,"nextStep":{"additionalInfo":{},"codeDeliveryDetails":null,"signInStep":"DONE"}}
2022-07-04 21:40:08.924 23387-23387/com. I/amplify:aws-datastore: Orchestrator lock acquired.
2022-07-04 21:40:08.937 23387-23574/com. I/amplify:aws-datastore: Orchestrator transitioning from STOPPED to SYNC_VIA_API
2022-07-04 21:40:08.942 23387-23574/com. I/amplify:aws-datastore: Starting to observe local storage changes.
2022-07-04 21:40:08.960 23387-23576/com. I/amplify:aws-datastore: Now observing local storage. Local changes will be enqueued to mutation outbox.
2022-07-04 21:40:08.961 23387-23576/com. I/amplify:aws-datastore: Setting currentState to LOCAL_ONLY
2022-07-04 21:40:08.965 23387-23574/com. I/amplify:aws-datastore: Setting currentState to SYNC_VIA_API
2022-07-04 21:40:08.967 23387-23500/com. I/amplify:aws-datastore: Starting API synchronization mode.
2022-07-04 21:40:08.969 23387-23574/com. D/MyLogsKt: Fragment --> syncCompleted :-- Called
2022-07-04 21:40:08.971 23387-23574/com. D/MyLogsKt: Fragment --> ModelSynced Status :-- Sync Start Success
2022-07-04 21:40:08.973 23387-23574/com. I/amplify:aws-datastore: Orchestrator lock released.
2022-07-04 21:40:09.002 23387-23500/com. I/amplify:aws-datastore: Starting processing subscription events.
2022-07-04 21:40:09.098 23387-23492/com. D/EGL_emulation: app_time_stats: avg=16.34ms min=5.26ms max=26.34ms count=62
2022-07-04 21:40:09.480 23387-23401/com. W/System: A resource failed to call close.
2022-07-04 21:40:09.661 23387-23658/com. W/com.: Long monitor contention with owner pool-21-thread-9 (23666) at com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUserSession com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUser.getCachedSession()(CognitoUser.java:1297) waiters=26 in com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUserSession com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUser.getCachedSession() for 414ms
2022-07-04 21:40:09.682 23387-23652/com. W/com.: Long monitor contention with owner pool-21-thread-9 (23666) at com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUserSession com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUser.getCachedSession()(CognitoUser.java:1297) waiters=27 in com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUserSession com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUser.getCachedSession() for 433ms
2022-07-04 21:40:09.700 23387-23654/com. W/com.: Long monitor contention with owner pool-21-thread-9 (23666) at com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUserSession com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUser.getCachedSession()(CognitoUser.java:1297) waiters=28 in com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUserSession com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUser.getCachedSession() for 452ms
2022-07-04 21:40:09.717 23387-23657/com. W/com.: Long monitor contention with owner pool-21-thread-9 (23666) at com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUserSession com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUser.getCachedSession()(CognitoUser.java:1297) waiters=29 in com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUserSession com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUser.getCachedSession() for 470ms
2022-07-04 21:40:09.733 23387-23655/com. W/com.: Long monitor contention with owner pool-21-thread-9 (23666) at com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUserSession com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUser.getCachedSession()(CognitoUser.java:1297) waiters=30 in com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUserSession com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUser.getCachedSession() for 485ms
2022-07-04 21:40:09.752 23387-23662/com. W/com.: Long monitor contention with owner pool-21-thread-9 (23666) at com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUserSession com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUser.getCachedSession()(CognitoUser.java:1297) waiters=31 in com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUserSession com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUser.getCachedSession() for 504ms
2022-07-04 21:40:09.783 23387-23660/com. W/com.: Long monitor contention with owner pool-21-thread-9 (23666) at com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUserSession com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUser.getCachedSession()(CognitoUser.java:1297) waiters=32 in com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUserSession com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUser.getCachedSession() for 536ms
2022-07-04 21:40:10.111 23387-23492/com. D/EGL_emulation: app_time_stats: avg=4.58ms min=2.54ms max=19.56ms count=60
2022-07-04 21:40:11.126 23387-23492/com. D/EGL_emulation: app_time_stats: avg=3.25ms min=2.43ms max=7.02ms count=61
2022-07-04 21:40:12.128 23387-23492/com. D/EGL_emulation: app_time_stats: avg=2.92ms min=2.18ms max=5.60ms count=60
2022-07-04 21:40:12.219 23387-23639/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=0 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 2.988s
2022-07-04 21:40:12.618 23387-23650/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=1 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 3.387s
2022-07-04 21:40:12.993 23387-23661/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=2 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 3.761s
2022-07-04 21:40:13.143 23387-23492/com. D/EGL_emulation: app_time_stats: avg=2.77ms min=1.98ms max=5.72ms count=61
2022-07-04 21:40:13.382 23387-23659/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=3 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 4.136s
2022-07-04 21:40:13.781 23387-23663/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=4 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 4.531s
2022-07-04 21:40:14.143 23387-23492/com. D/EGL_emulation: app_time_stats: avg=2.73ms min=1.98ms max=4.70ms count=60
2022-07-04 21:40:14.195 23387-23664/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=5 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 4.929s
2022-07-04 21:40:14.607 23387-23665/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=6 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 5.327s
2022-07-04 21:40:15.159 23387-23492/com. D/EGL_emulation: app_time_stats: avg=3.07ms min=2.09ms max=7.67ms count=61
2022-07-04 21:40:15.162 23387-23666/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=7 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 5.865s
2022-07-04 21:40:15.575 23387-23667/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=8 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 6.264s
2022-07-04 21:40:15.952 23387-23668/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=9 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 6.623s
2022-07-04 21:40:16.160 23387-23492/com. D/EGL_emulation: app_time_stats: avg=3.29ms min=1.98ms max=14.65ms count=60
2022-07-04 21:40:16.349 23387-23669/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=10 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 7.012s
2022-07-04 21:40:16.744 23387-23670/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=11 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 7.396s
2022-07-04 21:40:17.132 23387-23671/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=12 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 7.777s
2022-07-04 21:40:17.177 23387-23492/com. D/EGL_emulation: app_time_stats: avg=2.94ms min=2.41ms max=6.96ms count=61
2022-07-04 21:40:17.512 23387-23672/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=13 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 8.141s
2022-07-04 21:40:17.901 23387-23673/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=14 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 8.516s
2022-07-04 21:40:18.178 23387-23492/com. D/EGL_emulation: app_time_stats: avg=3.08ms min=2.23ms max=5.51ms count=60
2022-07-04 21:40:18.283 23387-23674/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=15 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 8.882s
2022-07-04 21:40:18.691 23387-23675/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=16 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 9.267s
2022-07-04 21:40:19.102 23387-23676/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=17 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 9.660s
2022-07-04 21:40:19.194 23387-23492/com. D/EGL_emulation: app_time_stats: avg=2.90ms min=2.20ms max=10.56ms count=61
2022-07-04 21:40:19.629 23387-23677/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=18 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 10.174s
2022-07-04 21:40:20.038 23387-23678/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=19 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 10.557s
2022-07-04 21:40:20.210 23387-23492/com. D/EGL_emulation: app_time_stats: avg=3.08ms min=2.08ms max=7.39ms count=61
2022-07-04 21:40:20.427 23387-23679/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=20 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 10.927s
2022-07-04 21:40:20.793 23387-23680/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=21 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 11.278s
2022-07-04 21:40:21.210 23387-23681/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=22 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 11.671s
2022-07-04 21:40:21.212 23387-23492/com. D/EGL_emulation: app_time_stats: avg=3.24ms min=2.16ms max=12.51ms count=60
2022-07-04 21:40:21.593 23387-23683/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=23 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 12.035s
2022-07-04 21:40:21.979 23387-23684/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=24 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 12.410s
2022-07-04 21:40:22.228 23387-23492/com. D/EGL_emulation: app_time_stats: avg=3.36ms min=2.51ms max=8.65ms count=61
2022-07-04 21:40:22.387 23387-23685/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=25 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 12.809s
2022-07-04 21:40:22.785 23387-23686/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=26 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 13.192s
2022-07-04 21:40:23.163 23387-23687/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=27 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 13.554s
2022-07-04 21:40:23.245 23387-23492/com. D/EGL_emulation: app_time_stats: avg=3.66ms min=2.09ms max=21.99ms count=60
2022-07-04 21:40:23.543 23387-23688/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=28 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 13.920s
2022-07-04 21:40:23.974 23387-23689/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=29 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 14.337s
2022-07-04 21:40:24.245 23387-23492/com. D/EGL_emulation: app_time_stats: avg=3.24ms min=2.49ms max=5.48ms count=60
2022-07-04 21:40:24.360 23387-23690/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=30 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 14.712s
2022-07-04 21:40:24.764 23387-23691/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=31 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 15.100s
2022-07-04 21:40:25.142 23387-23692/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=32 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 15.459s
2022-07-04 21:40:25.263 23387-23492/com. D/EGL_emulation: app_time_stats: avg=3.34ms min=2.49ms max=8.62ms count=59
2022-07-04 21:40:25.539 23387-23693/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=33 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 15.812s
2022-07-04 21:40:25.934 23387-23695/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=34 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 16.197s
2022-07-04 21:40:26.276 23387-23492/com. D/EGL_emulation: app_time_stats: avg=3.14ms min=2.11ms max=13.87ms count=61
2022-07-04 21:40:26.296 23387-23699/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=35 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 16.521s
2022-07-04 21:40:26.667 23387-23700/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=36 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 16.875s
2022-07-04 21:40:27.051 23387-23701/com. W/com.: Long monitor contention with owner pool-21-thread-1 (23635) at void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action)(SubscriptionEndpoint.java:187) waiters=37 in void com.amplifyframework.api.aws.SubscriptionEndpoint.requestSubscription(com.amplifyframework.api.graphql.GraphQLRequest, com.amplifyframework.api.aws.AuthorizationType, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Consumer, com.amplifyframework.core.Action) for 17.237s
2022-07-04 21:40:27.276 23387-23492/com. D/EGL_emulation: app_time_stats: avg=2.89ms min=2.13ms max=5.90ms count=60
2022-07-04 21:40:27.444 23387-23500/com. I/amplify:aws-datastore: Started subscription processor for models: [all tables from schema] of types [ON_CREATE, ON_UPDATE, ON_DELETE].
Started subscription processor for models Takes 19 seconds for start syncing.
2022-07-04 21:40:09.661 23387-23658/com. W/com.: Long monitor contention with owner pool-21-thread-9 (23666) at com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUserSession com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUser.getCachedSession()(CognitoUser.java:1297) waiters=26 in com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUserSession com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUser.getCachedSession() for 414ms 2022-07-04 21:40:09.682 23387-23652/com. W/com.: Long monitor contention with owner pool-21-thread-9 (23666) at com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUserSession com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUser.getCachedSession()(CognitoUser.java:1297) waiters=27 in com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUserSession com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUser.getCachedSession() for 433ms 2022-07-04 21:40:09.700 23387-23654/com. W/com.: Long monitor contention with owner pool-21-thread-9 (23666) at com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUserSession com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUser.getCachedSession()(CognitoUser.java:1297) waiters=28 in com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUserSession com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUser.getCachedSession() for 452ms 2022-07-04 21:40:09.717 23387-23657/com. W/com.: Long monitor contention with owner pool-21-thread-9 (23666) at com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUserSession com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUser.getCachedSession()(CognitoUser.java:1297) waiters=29 in com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUserSession com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUser.getCachedSession() for 470ms 2022-07-04 21:40:09.733 23387-23655/com. W/com.: Long monitor contention with owner pool-21-thread-9 (23666) at com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUserSession com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUser.getCachedSession()(CognitoUser.java:1297) waiters=30 in com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUserSession com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUser.getCachedSession() for 485ms 2022-07-04 21:40:09.752 23387-23662/com. W/com.: Long monitor contention with owner pool-21-thread-9 (23666) at com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUserSession com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUser.getCachedSession()(CognitoUser.java:1297) waiters=31 in com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUserSession com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUser.getCachedSession() for 504ms 2022-07-04 21:40:09.783 23387-23660/com. W/com.: Long monitor contention with owner pool-21-thread-9 (23666) at com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUserSession com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUser.getCachedSession()(CognitoUser.java:1297) waiters=32 in com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUserSession com.amazonaws.mobileconnectors.cognitoidentityprovider.CognitoUser.getCachedSession() for 536ms
@kevinold @banji180 @chrisbonifacio Can you check my last comment and update is this library issue do you guys need to fix this so we can plan accordingly?
Relates to this https://github.com/aws-amplify/amplify-android/issues/1660
@maheshordex could you also provide some information about the underlying table? If possible, sharing your schema (or a redacted version) as well as some information about your dataset (number of records, standard record shape) will help us reproduce this performance discrepancy. Additionally, what sort of device/simulators are you pulling these benchmarks from?
@maheshordex I'm happy to report that Amplify Android 2.14.10, which was just released today, contains major improvements to DataStore sync speeds. If you are able to upgrade, we'd love to hear previous vs new sync speed comparisons.
This issue is now closed. Comments on closed issues are hard for our team to see. If you need more assistance, please open a new issue that references this one.
![github-actions[bot] avatar](https://avatars.githubusercontent.com/in/15368?v=4 "Published by a pub.dev verified publisher"){kind=small}