Convergence silently stops syncing changes after an object is overwritten

[earshinov]

Not sure if this issue is related to Froala and DomBinder. Probably not.

Versions

• Convergence version: convergencelabs/convergence-server:1.0.0-rc.7
• OS (server): Running in Docker
• OS (client): Windows 10 x64 Version 1909 (OS Build 18363.1139)
• Browser: Google Chrome | 86.0.4240.75 (Official Build)

Step To Reproduce

Theoretically this issue could be reproduced on the Froala example page, but currently it fails to load, see #188.

1. Open a page with a Froala editor in two tabs in collaborative mode.

2. Change something in the editor on the first tab. Observe changes being reflected on the other.

3. Open your browser's DevTools console and get a reference to the RealTimeElement holding the RealTimeElement attached to DomBinder. I am not sure how things are organized on the Froala example page, so for now let's assume that one has

root: RealTimeElement
data: RealTimeElement = root.get('data') // the element attached to `DomBinder`

4. Overwrite the editor data using DevTools console. After you run the snippet below, both editors should display "Test".

const v = {
  "attributes": {},
  "childNodes": [
    {
      "attributes": {},
      "childNodes": [
        {
          "nodeType": 3,
          "nodeValue": "Test"
        }
      ],
      "nodeType": 1,
      "tagName": "P"
    }
  ],
  "nodeType": 1,
  "tagName": "DIV"
};
root.set('data', v);

5. Now the interesting part. Change something in the editor on the first tab, as on step 2. Observe that changes are no longer synced to the second tab.

Expected Behavior

Changes are synced

Actual Behavior

• Changes are not synced. If you reload either of the tabs after making changes, changes are lost without warning.

• Changes are missing in Convergence Admin, too. The same Convergence model opened in Convergence Admin always displays "Test" from step 4. If you edit the text and reload the Convergence Admin page, changes are gone.

• Changes are missing in the REST API, too. Querying GET /domains/{namespace}/{domain}/models/{model} returns the "Test" value irrespective of changes made in the UI and/or in Convergence Admin:

  {
  "body": {
  ...
  "data": {
    "report": {
      ...
      "content_blocks": [
        {
          "data": {
            "childNodes": [
              {
                "childNodes": [
                  {
                    "nodeValue": "Test",
                    "nodeType": 3.0
                  }
                ],
                "attributes": {},
                "tagName": "P",
                "nodeType": 1.0
              }
            ],
            "attributes": {},
            "tagName": "DIV",
            "nodeType": 1.0
          },
          "type": "text"
        }
      ],
      ...

• RealTimeElement id's in the UI don't look like real OrientDB record ids. First, they often have non-numeric cluster index, which looks strange to me. Second, querying these records ids in OrientDB Studio returns nothing (select * from #{your-rid}).

> root.get('data').get('childNodes').id()
"1t:168"

• There are no errors (neither in the logs of Convergence server, nor on the JavaScript side).

[earshinov]

This issue is also reproducible with a single tab only. The second tab is not actually needed.

[mmacfadden]

Apologies for the delay. We are looking at this now.

[earshinov]

I reproduced the problem locally with some Akka debug logging enabled, but it didn't reveal much.

Configuration

convergence-server.conf:

...

akka {
  loglevel = "DEBUG"
  log-dead-letters = on

  ...

  debug {
    # Debug logging
    # References:
    # - https://doc.akka.io/docs/akka/current/typed/logging.html
    # - https://doc.akka.io/docs/akka/current/general/configuration-reference.html#default-configuration
    # - https://livebook.manning.com/book/akka-in-action/chapter-7/101

    # Log user-level messages processed by actors with DEBUG level.
    # Note that it requires modifying the code to include `Behaviors.logMessages`.
    receive = on

    autoreceive = on
    lifecycle = on
    fsm = on
    event-stream = on
    unhandled = on
  }
}

log4j2.xml:

...
  <Loggers>
    <Root level="debug"><AppenderRef ref="Console"/></Root>
    <Logger name="com.convergencelabs" level="debug" />
    <Logger name="com.orientechnologies" level="warn" />
    <Logger name="akka" level="debug" />
  </Loggers>
...

Obtained logs

Step 2:

18:17:37 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b] received message: IncomingBinaryMessage([B@442ae833)
18:17:37 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b] received message: IncomingBinaryMessage([B@5c88cc0b)
18:17:37 DEBUG ProtocolConnection - RCV: ConvergenceMessage(None,None,OperationSubmission(OperationSubmissionMessage(0,2,24,Some(OperationData(CompoundOperation(CompoundOperationData(Vector(DiscreteOperationData(StringInsertOperation(StringInsertOperationData(6:48,false,8,a,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(StringSetOperation(StringSetOperationData(0:79,false,2020-12-23T15:17:37.980Z,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(ObjectSetOperation(ObjectSetOperationData(0:14,false,HashMap(first_name -> DataValue(StringValue(StringValue(7:10,Evgeny,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), email -> DataValue(StringValue(StringValue(7:13,earshinov@company.com,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), groups -> DataValue(ArrayValue(ArrayValue(7:14,Vector(DataValue(StringValue(StringValue(7:15,FFProdEditor,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), id -> DataValue(DoubleValue(DoubleValue(7:16,1.9280588E7,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), last_name -> DataValue(StringValue(StringValue(7:11,Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), gtl_id -> DataValue(NullValue(NullValue(7:17,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), username -> DataValue(StringValue(StringValue(7:9,earshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), full_name -> DataValue(StringValue(StringValue(7:12,Evgeny Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))
18:17:37 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b] received message: SendServerMessage(OperationAcknowledgementMessage(0,2,24,Some(Timestamp(1608736657,990099600,UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:17:37 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b] received message: SendUnprocessedMessage(ConvergenceMessage(None,None,OperationAck(OperationAcknowledgementMessage(0,2,24,Some(Timestamp(1608736657,990099600,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:17:37 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b/IdentityCacheManager] received message: OutgoingMessage(ConvergenceMessage(None,None,OperationAck(OperationAcknowledgementMessage(0,2,24,Some(Timestamp(1608736657,990099600,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:17:37 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c] received message: SendServerMessage(RemoteOperationMessage(0,9,24,Some(Timestamp(1608736657,990099600,UnknownFieldSet(Map()))),Some(OperationData(CompoundOperation(CompoundOperationData(List(DiscreteOperationData(StringInsertOperation(StringInsertOperationData(6:48,false,8,a,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(StringSetOperation(StringSetOperationData(0:79,false,2020-12-23T15:17:37.980Z,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(ObjectSetOperation(ObjectSetOperationData(0:14,false,HashMap(first_name -> DataValue(StringValue(StringValue(7:10,Evgeny,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), email -> DataValue(StringValue(StringValue(7:13,earshinov@company.com,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), groups -> DataValue(ArrayValue(ArrayValue(7:14,List(DataValue(StringValue(StringValue(7:15,FFProdEditor,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), id -> DataValue(DoubleValue(DoubleValue(7:16,1.9280588E7,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), last_name -> DataValue(StringValue(StringValue(7:11,Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), gtl_id -> DataValue(NullValue(NullValue(7:17,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), username -> DataValue(StringValue(StringValue(7:9,earshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), full_name -> DataValue(StringValue(StringValue(7:12,Evgeny Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:17:37 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b] received message: SendProcessedMessage(ConvergenceMessage(None,None,OperationAck(OperationAcknowledgementMessage(0,2,24,Some(Timestamp(1608736657,990099600,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:17:37 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c] received message: SendUnprocessedMessage(ConvergenceMessage(None,None,RemoteOperation(RemoteOperationMessage(0,9,24,Some(Timestamp(1608736657,990099600,UnknownFieldSet(Map()))),Some(OperationData(CompoundOperation(CompoundOperationData(List(DiscreteOperationData(StringInsertOperation(StringInsertOperationData(6:48,false,8,a,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(StringSetOperation(StringSetOperationData(0:79,false,2020-12-23T15:17:37.980Z,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(ObjectSetOperation(ObjectSetOperationData(0:14,false,HashMap(first_name -> DataValue(StringValue(StringValue(7:10,Evgeny,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), email -> DataValue(StringValue(StringValue(7:13,earshinov@company.com,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), groups -> DataValue(ArrayValue(ArrayValue(7:14,List(DataValue(StringValue(StringValue(7:15,FFProdEditor,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), id -> DataValue(DoubleValue(DoubleValue(7:16,1.9280588E7,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), last_name -> DataValue(StringValue(StringValue(7:11,Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), gtl_id -> DataValue(NullValue(NullValue(7:17,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), username -> DataValue(StringValue(StringValue(7:9,earshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), full_name -> DataValue(StringValue(StringValue(7:12,Evgeny Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:17:37 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c/IdentityCacheManager] received message: OutgoingMessage(ConvergenceMessage(None,None,RemoteOperation(RemoteOperationMessage(0,9,24,Some(Timestamp(1608736657,990099600,UnknownFieldSet(Map()))),Some(OperationData(CompoundOperation(CompoundOperationData(List(DiscreteOperationData(StringInsertOperation(StringInsertOperationData(6:48,false,8,a,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(StringSetOperation(StringSetOperationData(0:79,false,2020-12-23T15:17:37.980Z,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(ObjectSetOperation(ObjectSetOperationData(0:14,false,HashMap(first_name -> DataValue(StringValue(StringValue(7:10,Evgeny,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), email -> DataValue(StringValue(StringValue(7:13,earshinov@company.com,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), groups -> DataValue(ArrayValue(ArrayValue(7:14,List(DataValue(StringValue(StringValue(7:15,FFProdEditor,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), id -> DataValue(DoubleValue(DoubleValue(7:16,1.9280588E7,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), last_name -> DataValue(StringValue(StringValue(7:11,Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), gtl_id -> DataValue(NullValue(NullValue(7:17,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), username -> DataValue(StringValue(StringValue(7:9,earshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), full_name -> DataValue(StringValue(StringValue(7:12,Evgeny Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:17:37 DEBUG ProtocolConnection - SND: ConvergenceMessage(None,None,OperationAck(OperationAcknowledgementMessage(0,2,24,Some(Timestamp(1608736657,990099600,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))
18:17:37 DEBUG IdentityServiceActor - Processing identity resolution: IdentityResolutionRequest(Set(9),Set(),Actor[akka://Convergence/temp/$s#0])
18:17:38 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c] received message: IncomingBinaryMessage([B@598372ef)
18:17:38 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c/IdentityCacheManager] received message: IdentityResolved(MessageRecord(ConvergenceMessage(None,None,RemoteOperation(RemoteOperationMessage(0,9,24,Some(Timestamp(1608736657,990099600,UnknownFieldSet(Map()))),Some(OperationData(CompoundOperation(CompoundOperationData(List(DiscreteOperationData(StringInsertOperation(StringInsertOperationData(6:48,false,8,a,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(StringSetOperation(StringSetOperationData(0:79,false,2020-12-23T15:17:37.980Z,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(ObjectSetOperation(ObjectSetOperationData(0:14,false,HashMap(first_name -> DataValue(StringValue(StringValue(7:10,Evgeny,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), email -> DataValue(StringValue(StringValue(7:13,earshinov@company.com,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), groups -> DataValue(ArrayValue(ArrayValue(7:14,List(DataValue(StringValue(StringValue(7:15,FFProdEditor,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), id -> DataValue(DoubleValue(DoubleValue(7:16,1.9280588E7,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), last_name -> DataValue(StringValue(StringValue(7:11,Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), gtl_id -> DataValue(NullValue(NullValue(7:17,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), username -> DataValue(StringValue(StringValue(7:9,earshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), full_name -> DataValue(StringValue(StringValue(7:12,Evgeny Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())),false),IdentityResolutionResponse(Right(IdentityResolution(Map(9 -> DomainUserId(normal,earshinov)),Set(DomainUser(normal,earshinov,Some(Evgeny),Some(Arshinov),Some(Evgeny Arshinov),Some(earshinov@company.com),Some(2020-12-23T15:15:50.894Z),false,false,None))))))
18:17:38 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c] received message: SendProcessedMessage(ConvergenceMessage(None,None,IdentityCacheUpdate(IdentityCacheUpdateMessage(Map(9 -> DomainUserIdData(Normal,earshinov,UnknownFieldSet(Map()))),List(DomainUserData(Some(DomainUserIdData(Normal,earshinov,UnknownFieldSet(Map()))),Some(Evgeny),Some(Arshinov),Some(Evgeny Arshinov),Some(earshinov@company.com),false,false,None,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:17:38 DEBUG ProtocolConnection - SND: ConvergenceMessage(None,None,IdentityCacheUpdate(IdentityCacheUpdateMessage(Map(9 -> DomainUserIdData(Normal,earshinov,UnknownFieldSet(Map()))),List(DomainUserData(Some(DomainUserIdData(Normal,earshinov,UnknownFieldSet(Map()))),Some(Evgeny),Some(Arshinov),Some(Evgeny Arshinov),Some(earshinov@company.com),false,false,None,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))
18:17:38 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c] received message: SendProcessedMessage(ConvergenceMessage(None,None,RemoteOperation(RemoteOperationMessage(0,9,24,Some(Timestamp(1608736657,990099600,UnknownFieldSet(Map()))),Some(OperationData(CompoundOperation(CompoundOperationData(List(DiscreteOperationData(StringInsertOperation(StringInsertOperationData(6:48,false,8,a,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(StringSetOperation(StringSetOperationData(0:79,false,2020-12-23T15:17:37.980Z,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(ObjectSetOperation(ObjectSetOperationData(0:14,false,HashMap(first_name -> DataValue(StringValue(StringValue(7:10,Evgeny,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), email -> DataValue(StringValue(StringValue(7:13,earshinov@company.com,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), groups -> DataValue(ArrayValue(ArrayValue(7:14,List(DataValue(StringValue(StringValue(7:15,FFProdEditor,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), id -> DataValue(DoubleValue(DoubleValue(7:16,1.9280588E7,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), last_name -> DataValue(StringValue(StringValue(7:11,Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), gtl_id -> DataValue(NullValue(NullValue(7:17,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), username -> DataValue(StringValue(StringValue(7:9,earshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), full_name -> DataValue(StringValue(StringValue(7:12,Evgeny Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:17:38 DEBUG ProtocolConnection - SND: ConvergenceMessage(None,None,RemoteOperation(RemoteOperationMessage(0,9,24,Some(Timestamp(1608736657,990099600,UnknownFieldSet(Map()))),Some(OperationData(CompoundOperation(CompoundOperationData(List(DiscreteOperationData(StringInsertOperation(StringInsertOperationData(6:48,false,8,a,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(StringSetOperation(StringSetOperationData(0:79,false,2020-12-23T15:17:37.980Z,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(ObjectSetOperation(ObjectSetOperationData(0:14,false,HashMap(first_name -> DataValue(StringValue(StringValue(7:10,Evgeny,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), email -> DataValue(StringValue(StringValue(7:13,earshinov@company.com,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), groups -> DataValue(ArrayValue(ArrayValue(7:14,List(DataValue(StringValue(StringValue(7:15,FFProdEditor,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), id -> DataValue(DoubleValue(DoubleValue(7:16,1.9280588E7,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), last_name -> DataValue(StringValue(StringValue(7:11,Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), gtl_id -> DataValue(NullValue(NullValue(7:17,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), username -> DataValue(StringValue(StringValue(7:9,earshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), full_name -> DataValue(StringValue(StringValue(7:12,Evgeny Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))

Step 4:

18:18:23 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b] received message: IncomingBinaryMessage([B@672c31c5)
18:18:25 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b] received message: IncomingBinaryMessage([B@293922e3)
18:18:25 DEBUG ProtocolConnection - RCV: ConvergenceMessage(None,None,OperationSubmission(OperationSubmissionMessage(0,3,25,Some(OperationData(DiscreteOperation(DiscreteOperationData(StringSetOperation(StringSetOperationData(0:79,false,2020-12-23T15:18:25.173Z,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))
18:18:25 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b] received message: IncomingBinaryMessage([B@249aeee9)
18:18:25 DEBUG ProtocolConnection - RCV: ConvergenceMessage(None,None,OperationSubmission(OperationSubmissionMessage(0,4,25,Some(OperationData(DiscreteOperation(DiscreteOperationData(ObjectSetOperation(ObjectSetOperationData(0:14,false,HashMap(first_name -> DataValue(StringValue(StringValue(7:32,Evgeny,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), email -> DataValue(StringValue(StringValue(7:35,earshinov@company.com,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), groups -> DataValue(ArrayValue(ArrayValue(7:36,Vector(DataValue(StringValue(StringValue(7:37,FFProdEditor,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), id -> DataValue(DoubleValue(DoubleValue(7:38,1.9280588E7,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), last_name -> DataValue(StringValue(StringValue(7:33,Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), gtl_id -> DataValue(NullValue(NullValue(7:39,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), username -> DataValue(StringValue(StringValue(7:31,earshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), full_name -> DataValue(StringValue(StringValue(7:34,Evgeny Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))
18:18:25 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b] received message: SendServerMessage(OperationAcknowledgementMessage(0,3,25,Some(Timestamp(1608736705,189856300,UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:25 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b] received message: SendUnprocessedMessage(ConvergenceMessage(None,None,OperationAck(OperationAcknowledgementMessage(0,3,25,Some(Timestamp(1608736705,189856300,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:25 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b/IdentityCacheManager] received message: OutgoingMessage(ConvergenceMessage(None,None,OperationAck(OperationAcknowledgementMessage(0,3,25,Some(Timestamp(1608736705,189856300,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:25 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b] received message: SendProcessedMessage(ConvergenceMessage(None,None,OperationAck(OperationAcknowledgementMessage(0,3,25,Some(Timestamp(1608736705,189856300,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:25 DEBUG ProtocolConnection - SND: ConvergenceMessage(None,None,OperationAck(OperationAcknowledgementMessage(0,3,25,Some(Timestamp(1608736705,189856300,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))
18:18:25 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c] received message: SendServerMessage(RemoteOperationMessage(0,9,25,Some(Timestamp(1608736705,189856300,UnknownFieldSet(Map()))),Some(OperationData(DiscreteOperation(DiscreteOperationData(StringSetOperation(StringSetOperationData(0:79,false,2020-12-23T15:18:25.173Z,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:25 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b] received message: SendServerMessage(OperationAcknowledgementMessage(0,4,26,Some(Timestamp(1608736705,203887300,UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:25 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b] received message: IncomingBinaryMessage([B@3c9e284c)
18:18:25 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c] received message: SendServerMessage(RemoteOperationMessage(0,9,26,Some(Timestamp(1608736705,203887300,UnknownFieldSet(Map()))),Some(OperationData(DiscreteOperation(DiscreteOperationData(ObjectSetOperation(ObjectSetOperationData(0:14,false,HashMap(first_name -> DataValue(StringValue(StringValue(7:32,Evgeny,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), email -> DataValue(StringValue(StringValue(7:35,earshinov@company.com,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), groups -> DataValue(ArrayValue(ArrayValue(7:36,List(DataValue(StringValue(StringValue(7:37,FFProdEditor,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), id -> DataValue(DoubleValue(DoubleValue(7:38,1.9280588E7,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), last_name -> DataValue(StringValue(StringValue(7:33,Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), gtl_id -> DataValue(NullValue(NullValue(7:39,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), username -> DataValue(StringValue(StringValue(7:31,earshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), full_name -> DataValue(StringValue(StringValue(7:34,Evgeny Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:25 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c] received message: SendUnprocessedMessage(ConvergenceMessage(None,None,RemoteOperation(RemoteOperationMessage(0,9,25,Some(Timestamp(1608736705,189856300,UnknownFieldSet(Map()))),Some(OperationData(DiscreteOperation(DiscreteOperationData(StringSetOperation(StringSetOperationData(0:79,false,2020-12-23T15:18:25.173Z,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:25 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c] received message: SendUnprocessedMessage(ConvergenceMessage(None,None,RemoteOperation(RemoteOperationMessage(0,9,26,Some(Timestamp(1608736705,203887300,UnknownFieldSet(Map()))),Some(OperationData(DiscreteOperation(DiscreteOperationData(ObjectSetOperation(ObjectSetOperationData(0:14,false,HashMap(first_name -> DataValue(StringValue(StringValue(7:32,Evgeny,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), email -> DataValue(StringValue(StringValue(7:35,earshinov@company.com,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), groups -> DataValue(ArrayValue(ArrayValue(7:36,List(DataValue(StringValue(StringValue(7:37,FFProdEditor,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), id -> DataValue(DoubleValue(DoubleValue(7:38,1.9280588E7,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), last_name -> DataValue(StringValue(StringValue(7:33,Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), gtl_id -> DataValue(NullValue(NullValue(7:39,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), username -> DataValue(StringValue(StringValue(7:31,earshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), full_name -> DataValue(StringValue(StringValue(7:34,Evgeny Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:25 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c/IdentityCacheManager] received message: OutgoingMessage(ConvergenceMessage(None,None,RemoteOperation(RemoteOperationMessage(0,9,25,Some(Timestamp(1608736705,189856300,UnknownFieldSet(Map()))),Some(OperationData(DiscreteOperation(DiscreteOperationData(StringSetOperation(StringSetOperationData(0:79,false,2020-12-23T15:18:25.173Z,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:25 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c/IdentityCacheManager] received message: OutgoingMessage(ConvergenceMessage(None,None,RemoteOperation(RemoteOperationMessage(0,9,26,Some(Timestamp(1608736705,203887300,UnknownFieldSet(Map()))),Some(OperationData(DiscreteOperation(DiscreteOperationData(ObjectSetOperation(ObjectSetOperationData(0:14,false,HashMap(first_name -> DataValue(StringValue(StringValue(7:32,Evgeny,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), email -> DataValue(StringValue(StringValue(7:35,earshinov@company.com,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), groups -> DataValue(ArrayValue(ArrayValue(7:36,List(DataValue(StringValue(StringValue(7:37,FFProdEditor,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), id -> DataValue(DoubleValue(DoubleValue(7:38,1.9280588E7,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), last_name -> DataValue(StringValue(StringValue(7:33,Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), gtl_id -> DataValue(NullValue(NullValue(7:39,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), username -> DataValue(StringValue(StringValue(7:31,earshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), full_name -> DataValue(StringValue(StringValue(7:34,Evgeny Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:25 DEBUG IdentityServiceActor - Processing identity resolution: IdentityResolutionRequest(Set(9),Set(),Actor[akka://Convergence/temp/$t#0])
18:18:25 DEBUG ProtocolConnection - RCV: ConvergenceMessage(None,None,OperationSubmission(OperationSubmissionMessage(0,5,25,Some(OperationData(DiscreteOperation(DiscreteOperationData(ObjectSetPropertyOperation(ObjectSetPropertyOperationData(0:75,false,data,Some(DataValue(ObjectValue(ObjectValue(7:18,Map(attributes -> DataValue(ObjectValue(ObjectValue(7:19,Map(),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), childNodes -> DataValue(ArrayValue(ArrayValue(7:20,Vector(DataValue(ObjectValue(ObjectValue(7:21,Map(attributes -> DataValue(ObjectValue(ObjectValue(7:22,Map(),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), childNodes -> DataValue(ArrayValue(ArrayValue(7:23,Vector(DataValue(ObjectValue(ObjectValue(7:24,Map(nodeType -> DataValue(DoubleValue(DoubleValue(7:25,3.0,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), nodeValue -> DataValue(StringValue(StringValue(7:26,Test,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), nodeType -> DataValue(DoubleValue(DoubleValue(7:27,1.0,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), tagName -> DataValue(StringValue(StringValue(7:28,P,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), nodeType -> DataValue(DoubleValue(DoubleValue(7:29,1.0,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), tagName -> DataValue(StringValue(StringValue(7:30,DIV,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))
18:18:25 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b] received message: SendUnprocessedMessage(ConvergenceMessage(None,None,OperationAck(OperationAcknowledgementMessage(0,4,26,Some(Timestamp(1608736705,203887300,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:25 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b/IdentityCacheManager] received message: OutgoingMessage(ConvergenceMessage(None,None,OperationAck(OperationAcknowledgementMessage(0,4,26,Some(Timestamp(1608736705,203887300,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:25 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b] received message: SendProcessedMessage(ConvergenceMessage(None,None,OperationAck(OperationAcknowledgementMessage(0,4,26,Some(Timestamp(1608736705,203887300,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:25 DEBUG ProtocolConnection - SND: ConvergenceMessage(None,None,OperationAck(OperationAcknowledgementMessage(0,4,26,Some(Timestamp(1608736705,203887300,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))
18:18:25 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b] received message: SendServerMessage(OperationAcknowledgementMessage(0,5,27,Some(Timestamp(1608736705,220943100,UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:25 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b] received message: SendUnprocessedMessage(ConvergenceMessage(None,None,OperationAck(OperationAcknowledgementMessage(0,5,27,Some(Timestamp(1608736705,220943100,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:25 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b/IdentityCacheManager] received message: OutgoingMessage(ConvergenceMessage(None,None,OperationAck(OperationAcknowledgementMessage(0,5,27,Some(Timestamp(1608736705,220943100,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:25 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b] received message: SendProcessedMessage(ConvergenceMessage(None,None,OperationAck(OperationAcknowledgementMessage(0,5,27,Some(Timestamp(1608736705,220943100,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:25 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c] received message: SendServerMessage(RemoteOperationMessage(0,9,27,Some(Timestamp(1608736705,220943100,UnknownFieldSet(Map()))),Some(OperationData(DiscreteOperation(DiscreteOperationData(ObjectSetPropertyOperation(ObjectSetPropertyOperationData(0:75,false,data,Some(DataValue(ObjectValue(ObjectValue(7:18,Map(attributes -> DataValue(ObjectValue(ObjectValue(7:19,Map(),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), childNodes -> DataValue(ArrayValue(ArrayValue(7:20,List(DataValue(ObjectValue(ObjectValue(7:21,Map(attributes -> DataValue(ObjectValue(ObjectValue(7:22,Map(),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), childNodes -> DataValue(ArrayValue(ArrayValue(7:23,List(DataValue(ObjectValue(ObjectValue(7:24,Map(nodeType -> DataValue(DoubleValue(DoubleValue(7:25,3.0,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), nodeValue -> DataValue(StringValue(StringValue(7:26,Test,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), nodeType -> DataValue(DoubleValue(DoubleValue(7:27,1.0,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), tagName -> DataValue(StringValue(StringValue(7:28,P,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), nodeType -> DataValue(DoubleValue(DoubleValue(7:29,1.0,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), tagName -> DataValue(StringValue(StringValue(7:30,DIV,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:25 DEBUG ProtocolConnection - SND: ConvergenceMessage(None,None,OperationAck(OperationAcknowledgementMessage(0,5,27,Some(Timestamp(1608736705,220943100,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))
18:18:25 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c] received message: SendUnprocessedMessage(ConvergenceMessage(None,None,RemoteOperation(RemoteOperationMessage(0,9,27,Some(Timestamp(1608736705,220943100,UnknownFieldSet(Map()))),Some(OperationData(DiscreteOperation(DiscreteOperationData(ObjectSetPropertyOperation(ObjectSetPropertyOperationData(0:75,false,data,Some(DataValue(ObjectValue(ObjectValue(7:18,Map(attributes -> DataValue(ObjectValue(ObjectValue(7:19,Map(),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), childNodes -> DataValue(ArrayValue(ArrayValue(7:20,List(DataValue(ObjectValue(ObjectValue(7:21,Map(attributes -> DataValue(ObjectValue(ObjectValue(7:22,Map(),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), childNodes -> DataValue(ArrayValue(ArrayValue(7:23,List(DataValue(ObjectValue(ObjectValue(7:24,Map(nodeType -> DataValue(DoubleValue(DoubleValue(7:25,3.0,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), nodeValue -> DataValue(StringValue(StringValue(7:26,Test,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), nodeType -> DataValue(DoubleValue(DoubleValue(7:27,1.0,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), tagName -> DataValue(StringValue(StringValue(7:28,P,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), nodeType -> DataValue(DoubleValue(DoubleValue(7:29,1.0,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), tagName -> DataValue(StringValue(StringValue(7:30,DIV,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:25 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c/IdentityCacheManager] received message: OutgoingMessage(ConvergenceMessage(None,None,RemoteOperation(RemoteOperationMessage(0,9,27,Some(Timestamp(1608736705,220943100,UnknownFieldSet(Map()))),Some(OperationData(DiscreteOperation(DiscreteOperationData(ObjectSetPropertyOperation(ObjectSetPropertyOperationData(0:75,false,data,Some(DataValue(ObjectValue(ObjectValue(7:18,Map(attributes -> DataValue(ObjectValue(ObjectValue(7:19,Map(),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), childNodes -> DataValue(ArrayValue(ArrayValue(7:20,List(DataValue(ObjectValue(ObjectValue(7:21,Map(attributes -> DataValue(ObjectValue(ObjectValue(7:22,Map(),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), childNodes -> DataValue(ArrayValue(ArrayValue(7:23,List(DataValue(ObjectValue(ObjectValue(7:24,Map(nodeType -> DataValue(DoubleValue(DoubleValue(7:25,3.0,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), nodeValue -> DataValue(StringValue(StringValue(7:26,Test,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), nodeType -> DataValue(DoubleValue(DoubleValue(7:27,1.0,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), tagName -> DataValue(StringValue(StringValue(7:28,P,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), nodeType -> DataValue(DoubleValue(DoubleValue(7:29,1.0,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), tagName -> DataValue(StringValue(StringValue(7:30,DIV,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:25 DEBUG IdentityServiceActor - Processing identity resolution: IdentityResolutionRequest(Set(9),Set(),Actor[akka://Convergence/temp/$u#0])
18:18:25 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c/IdentityCacheManager] received message: IdentityResolved(MessageRecord(ConvergenceMessage(None,None,RemoteOperation(RemoteOperationMessage(0,9,25,Some(Timestamp(1608736705,189856300,UnknownFieldSet(Map()))),Some(OperationData(DiscreteOperation(DiscreteOperationData(StringSetOperation(StringSetOperationData(0:79,false,2020-12-23T15:18:25.173Z,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())),false),IdentityResolutionResponse(Right(IdentityResolution(Map(9 -> DomainUserId(normal,earshinov)),Set(DomainUser(normal,earshinov,Some(Evgeny),Some(Arshinov),Some(Evgeny Arshinov),Some(earshinov@company.com),Some(2020-12-23T15:15:50.894Z),false,false,None))))))
18:18:25 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c] received message: SendProcessedMessage(ConvergenceMessage(None,None,IdentityCacheUpdate(IdentityCacheUpdateMessage(Map(9 -> DomainUserIdData(Normal,earshinov,UnknownFieldSet(Map()))),List(DomainUserData(Some(DomainUserIdData(Normal,earshinov,UnknownFieldSet(Map()))),Some(Evgeny),Some(Arshinov),Some(Evgeny Arshinov),Some(earshinov@company.com),false,false,None,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:25 DEBUG ProtocolConnection - SND: ConvergenceMessage(None,None,IdentityCacheUpdate(IdentityCacheUpdateMessage(Map(9 -> DomainUserIdData(Normal,earshinov,UnknownFieldSet(Map()))),List(DomainUserData(Some(DomainUserIdData(Normal,earshinov,UnknownFieldSet(Map()))),Some(Evgeny),Some(Arshinov),Some(Evgeny Arshinov),Some(earshinov@company.com),false,false,None,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))
18:18:25 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c] received message: SendProcessedMessage(ConvergenceMessage(None,None,RemoteOperation(RemoteOperationMessage(0,9,25,Some(Timestamp(1608736705,189856300,UnknownFieldSet(Map()))),Some(OperationData(DiscreteOperation(DiscreteOperationData(StringSetOperation(StringSetOperationData(0:79,false,2020-12-23T15:18:25.173Z,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:25 DEBUG ProtocolConnection - SND: ConvergenceMessage(None,None,RemoteOperation(RemoteOperationMessage(0,9,25,Some(Timestamp(1608736705,189856300,UnknownFieldSet(Map()))),Some(OperationData(DiscreteOperation(DiscreteOperationData(StringSetOperation(StringSetOperationData(0:79,false,2020-12-23T15:18:25.173Z,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))
18:18:25 DEBUG IdentityServiceActor - Processing identity resolution: IdentityResolutionRequest(Set(9),Set(),Actor[akka://Convergence/temp/$v#0])
18:18:25 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c/IdentityCacheManager] received message: IdentityResolved(MessageRecord(ConvergenceMessage(None,None,RemoteOperation(RemoteOperationMessage(0,9,26,Some(Timestamp(1608736705,203887300,UnknownFieldSet(Map()))),Some(OperationData(DiscreteOperation(DiscreteOperationData(ObjectSetOperation(ObjectSetOperationData(0:14,false,HashMap(first_name -> DataValue(StringValue(StringValue(7:32,Evgeny,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), email -> DataValue(StringValue(StringValue(7:35,earshinov@company.com,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), groups -> DataValue(ArrayValue(ArrayValue(7:36,List(DataValue(StringValue(StringValue(7:37,FFProdEditor,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), id -> DataValue(DoubleValue(DoubleValue(7:38,1.9280588E7,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), last_name -> DataValue(StringValue(StringValue(7:33,Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), gtl_id -> DataValue(NullValue(NullValue(7:39,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), username -> DataValue(StringValue(StringValue(7:31,earshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), full_name -> DataValue(StringValue(StringValue(7:34,Evgeny Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())),false),IdentityResolutionResponse(Right(IdentityResolution(Map(9 -> DomainUserId(normal,earshinov)),Set(DomainUser(normal,earshinov,Some(Evgeny),Some(Arshinov),Some(Evgeny Arshinov),Some(earshinov@company.com),Some(2020-12-23T15:15:50.894Z),false,false,None))))))
18:18:25 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c] received message: SendProcessedMessage(ConvergenceMessage(None,None,IdentityCacheUpdate(IdentityCacheUpdateMessage(Map(9 -> DomainUserIdData(Normal,earshinov,UnknownFieldSet(Map()))),List(DomainUserData(Some(DomainUserIdData(Normal,earshinov,UnknownFieldSet(Map()))),Some(Evgeny),Some(Arshinov),Some(Evgeny Arshinov),Some(earshinov@company.com),false,false,None,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:25 DEBUG ProtocolConnection - SND: ConvergenceMessage(None,None,IdentityCacheUpdate(IdentityCacheUpdateMessage(Map(9 -> DomainUserIdData(Normal,earshinov,UnknownFieldSet(Map()))),List(DomainUserData(Some(DomainUserIdData(Normal,earshinov,UnknownFieldSet(Map()))),Some(Evgeny),Some(Arshinov),Some(Evgeny Arshinov),Some(earshinov@company.com),false,false,None,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))
18:18:25 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c] received message: SendProcessedMessage(ConvergenceMessage(None,None,RemoteOperation(RemoteOperationMessage(0,9,26,Some(Timestamp(1608736705,203887300,UnknownFieldSet(Map()))),Some(OperationData(DiscreteOperation(DiscreteOperationData(ObjectSetOperation(ObjectSetOperationData(0:14,false,HashMap(first_name -> DataValue(StringValue(StringValue(7:32,Evgeny,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), email -> DataValue(StringValue(StringValue(7:35,earshinov@company.com,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), groups -> DataValue(ArrayValue(ArrayValue(7:36,List(DataValue(StringValue(StringValue(7:37,FFProdEditor,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), id -> DataValue(DoubleValue(DoubleValue(7:38,1.9280588E7,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), last_name -> DataValue(StringValue(StringValue(7:33,Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), gtl_id -> DataValue(NullValue(NullValue(7:39,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), username -> DataValue(StringValue(StringValue(7:31,earshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), full_name -> DataValue(StringValue(StringValue(7:34,Evgeny Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:25 DEBUG ProtocolConnection - SND: ConvergenceMessage(None,None,RemoteOperation(RemoteOperationMessage(0,9,26,Some(Timestamp(1608736705,203887300,UnknownFieldSet(Map()))),Some(OperationData(DiscreteOperation(DiscreteOperationData(ObjectSetOperation(ObjectSetOperationData(0:14,false,HashMap(first_name -> DataValue(StringValue(StringValue(7:32,Evgeny,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), email -> DataValue(StringValue(StringValue(7:35,earshinov@company.com,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), groups -> DataValue(ArrayValue(ArrayValue(7:36,List(DataValue(StringValue(StringValue(7:37,FFProdEditor,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), id -> DataValue(DoubleValue(DoubleValue(7:38,1.9280588E7,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), last_name -> DataValue(StringValue(StringValue(7:33,Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), gtl_id -> DataValue(NullValue(NullValue(7:39,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), username -> DataValue(StringValue(StringValue(7:31,earshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), full_name -> DataValue(StringValue(StringValue(7:34,Evgeny Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))
18:18:25 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c/IdentityCacheManager] received message: IdentityResolved(MessageRecord(ConvergenceMessage(None,None,RemoteOperation(RemoteOperationMessage(0,9,27,Some(Timestamp(1608736705,220943100,UnknownFieldSet(Map()))),Some(OperationData(DiscreteOperation(DiscreteOperationData(ObjectSetPropertyOperation(ObjectSetPropertyOperationData(0:75,false,data,Some(DataValue(ObjectValue(ObjectValue(7:18,Map(attributes -> DataValue(ObjectValue(ObjectValue(7:19,Map(),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), childNodes -> DataValue(ArrayValue(ArrayValue(7:20,List(DataValue(ObjectValue(ObjectValue(7:21,Map(attributes -> DataValue(ObjectValue(ObjectValue(7:22,Map(),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), childNodes -> DataValue(ArrayValue(ArrayValue(7:23,List(DataValue(ObjectValue(ObjectValue(7:24,Map(nodeType -> DataValue(DoubleValue(DoubleValue(7:25,3.0,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), nodeValue -> DataValue(StringValue(StringValue(7:26,Test,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), nodeType -> DataValue(DoubleValue(DoubleValue(7:27,1.0,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), tagName -> DataValue(StringValue(StringValue(7:28,P,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), nodeType -> DataValue(DoubleValue(DoubleValue(7:29,1.0,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), tagName -> DataValue(StringValue(StringValue(7:30,DIV,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())),false),IdentityResolutionResponse(Right(IdentityResolution(Map(9 -> DomainUserId(normal,earshinov)),Set(DomainUser(normal,earshinov,Some(Evgeny),Some(Arshinov),Some(Evgeny Arshinov),Some(earshinov@company.com),Some(2020-12-23T15:15:50.894Z),false,false,None))))))
18:18:25 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c] received message: SendProcessedMessage(ConvergenceMessage(None,None,IdentityCacheUpdate(IdentityCacheUpdateMessage(Map(9 -> DomainUserIdData(Normal,earshinov,UnknownFieldSet(Map()))),List(DomainUserData(Some(DomainUserIdData(Normal,earshinov,UnknownFieldSet(Map()))),Some(Evgeny),Some(Arshinov),Some(Evgeny Arshinov),Some(earshinov@company.com),false,false,None,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:25 DEBUG ProtocolConnection - SND: ConvergenceMessage(None,None,IdentityCacheUpdate(IdentityCacheUpdateMessage(Map(9 -> DomainUserIdData(Normal,earshinov,UnknownFieldSet(Map()))),List(DomainUserData(Some(DomainUserIdData(Normal,earshinov,UnknownFieldSet(Map()))),Some(Evgeny),Some(Arshinov),Some(Evgeny Arshinov),Some(earshinov@company.com),false,false,None,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))
18:18:25 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c] received message: SendProcessedMessage(ConvergenceMessage(None,None,RemoteOperation(RemoteOperationMessage(0,9,27,Some(Timestamp(1608736705,220943100,UnknownFieldSet(Map()))),Some(OperationData(DiscreteOperation(DiscreteOperationData(ObjectSetPropertyOperation(ObjectSetPropertyOperationData(0:75,false,data,Some(DataValue(ObjectValue(ObjectValue(7:18,Map(attributes -> DataValue(ObjectValue(ObjectValue(7:19,Map(),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), childNodes -> DataValue(ArrayValue(ArrayValue(7:20,List(DataValue(ObjectValue(ObjectValue(7:21,Map(attributes -> DataValue(ObjectValue(ObjectValue(7:22,Map(),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), childNodes -> DataValue(ArrayValue(ArrayValue(7:23,List(DataValue(ObjectValue(ObjectValue(7:24,Map(nodeType -> DataValue(DoubleValue(DoubleValue(7:25,3.0,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), nodeValue -> DataValue(StringValue(StringValue(7:26,Test,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), nodeType -> DataValue(DoubleValue(DoubleValue(7:27,1.0,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), tagName -> DataValue(StringValue(StringValue(7:28,P,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), nodeType -> DataValue(DoubleValue(DoubleValue(7:29,1.0,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), tagName -> DataValue(StringValue(StringValue(7:30,DIV,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:25 DEBUG ProtocolConnection - SND: ConvergenceMessage(None,None,RemoteOperation(RemoteOperationMessage(0,9,27,Some(Timestamp(1608736705,220943100,UnknownFieldSet(Map()))),Some(OperationData(DiscreteOperation(DiscreteOperationData(ObjectSetPropertyOperation(ObjectSetPropertyOperationData(0:75,false,data,Some(DataValue(ObjectValue(ObjectValue(7:18,Map(attributes -> DataValue(ObjectValue(ObjectValue(7:19,Map(),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), childNodes -> DataValue(ArrayValue(ArrayValue(7:20,List(DataValue(ObjectValue(ObjectValue(7:21,Map(attributes -> DataValue(ObjectValue(ObjectValue(7:22,Map(),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), childNodes -> DataValue(ArrayValue(ArrayValue(7:23,List(DataValue(ObjectValue(ObjectValue(7:24,Map(nodeType -> DataValue(DoubleValue(DoubleValue(7:25,3.0,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), nodeValue -> DataValue(StringValue(StringValue(7:26,Test,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), nodeType -> DataValue(DoubleValue(DoubleValue(7:27,1.0,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), tagName -> DataValue(StringValue(StringValue(7:28,P,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), nodeType -> DataValue(DoubleValue(DoubleValue(7:29,1.0,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), tagName -> DataValue(StringValue(StringValue(7:30,DIV,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))

Step 5:

18:18:49 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b] received message: IncomingBinaryMessage([B@43a40c25)
18:18:49 DEBUG ProtocolConnection - RCV: ConvergenceMessage(None,None,OperationSubmission(OperationSubmissionMessage(0,6,28,Some(OperationData(CompoundOperation(CompoundOperationData(Vector(DiscreteOperationData(StringInsertOperation(StringInsertOperationData(7:26,false,4,r,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(StringSetOperation(StringSetOperationData(0:79,false,2020-12-23T15:18:49.243Z,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(ObjectSetOperation(ObjectSetOperationData(0:14,false,HashMap(first_name -> DataValue(StringValue(StringValue(7:41,Evgeny,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), email -> DataValue(StringValue(StringValue(7:44,earshinov@company.com,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), groups -> DataValue(ArrayValue(ArrayValue(7:45,Vector(DataValue(StringValue(StringValue(7:46,FFProdEditor,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), id -> DataValue(DoubleValue(DoubleValue(7:47,1.9280588E7,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), last_name -> DataValue(StringValue(StringValue(7:42,Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), gtl_id -> DataValue(NullValue(NullValue(7:48,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), username -> DataValue(StringValue(StringValue(7:40,earshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), full_name -> DataValue(StringValue(StringValue(7:43,Evgeny Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))
18:18:49 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b] received message: SendServerMessage(OperationAcknowledgementMessage(0,6,28,Some(Timestamp(1608736729,257133900,UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:49 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b] received message: SendUnprocessedMessage(ConvergenceMessage(None,None,OperationAck(OperationAcknowledgementMessage(0,6,28,Some(Timestamp(1608736729,257133900,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:49 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b/IdentityCacheManager] received message: OutgoingMessage(ConvergenceMessage(None,None,OperationAck(OperationAcknowledgementMessage(0,6,28,Some(Timestamp(1608736729,257133900,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:49 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b] received message: SendProcessedMessage(ConvergenceMessage(None,None,OperationAck(OperationAcknowledgementMessage(0,6,28,Some(Timestamp(1608736729,257133900,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:49 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c] received message: SendServerMessage(RemoteOperationMessage(0,9,28,Some(Timestamp(1608736729,257133900,UnknownFieldSet(Map()))),Some(OperationData(CompoundOperation(CompoundOperationData(List(DiscreteOperationData(StringInsertOperation(StringInsertOperationData(7:26,true,4,r,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(StringSetOperation(StringSetOperationData(0:79,false,2020-12-23T15:18:49.243Z,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(ObjectSetOperation(ObjectSetOperationData(0:14,false,HashMap(first_name -> DataValue(StringValue(StringValue(7:41,Evgeny,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), email -> DataValue(StringValue(StringValue(7:44,earshinov@company.com,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), groups -> DataValue(ArrayValue(ArrayValue(7:45,List(DataValue(StringValue(StringValue(7:46,FFProdEditor,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), id -> DataValue(DoubleValue(DoubleValue(7:47,1.9280588E7,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), last_name -> DataValue(StringValue(StringValue(7:42,Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), gtl_id -> DataValue(NullValue(NullValue(7:48,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), username -> DataValue(StringValue(StringValue(7:40,earshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), full_name -> DataValue(StringValue(StringValue(7:43,Evgeny Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:49 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c] received message: SendUnprocessedMessage(ConvergenceMessage(None,None,RemoteOperation(RemoteOperationMessage(0,9,28,Some(Timestamp(1608736729,257133900,UnknownFieldSet(Map()))),Some(OperationData(CompoundOperation(CompoundOperationData(List(DiscreteOperationData(StringInsertOperation(StringInsertOperationData(7:26,true,4,r,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(StringSetOperation(StringSetOperationData(0:79,false,2020-12-23T15:18:49.243Z,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(ObjectSetOperation(ObjectSetOperationData(0:14,false,HashMap(first_name -> DataValue(StringValue(StringValue(7:41,Evgeny,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), email -> DataValue(StringValue(StringValue(7:44,earshinov@company.com,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), groups -> DataValue(ArrayValue(ArrayValue(7:45,List(DataValue(StringValue(StringValue(7:46,FFProdEditor,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), id -> DataValue(DoubleValue(DoubleValue(7:47,1.9280588E7,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), last_name -> DataValue(StringValue(StringValue(7:42,Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), gtl_id -> DataValue(NullValue(NullValue(7:48,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), username -> DataValue(StringValue(StringValue(7:40,earshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), full_name -> DataValue(StringValue(StringValue(7:43,Evgeny Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:49 DEBUG ProtocolConnection - SND: ConvergenceMessage(None,None,OperationAck(OperationAcknowledgementMessage(0,6,28,Some(Timestamp(1608736729,257133900,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))
18:18:49 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c/IdentityCacheManager] received message: OutgoingMessage(ConvergenceMessage(None,None,RemoteOperation(RemoteOperationMessage(0,9,28,Some(Timestamp(1608736729,257133900,UnknownFieldSet(Map()))),Some(OperationData(CompoundOperation(CompoundOperationData(List(DiscreteOperationData(StringInsertOperation(StringInsertOperationData(7:26,true,4,r,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(StringSetOperation(StringSetOperationData(0:79,false,2020-12-23T15:18:49.243Z,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(ObjectSetOperation(ObjectSetOperationData(0:14,false,HashMap(first_name -> DataValue(StringValue(StringValue(7:41,Evgeny,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), email -> DataValue(StringValue(StringValue(7:44,earshinov@company.com,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), groups -> DataValue(ArrayValue(ArrayValue(7:45,List(DataValue(StringValue(StringValue(7:46,FFProdEditor,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), id -> DataValue(DoubleValue(DoubleValue(7:47,1.9280588E7,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), last_name -> DataValue(StringValue(StringValue(7:42,Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), gtl_id -> DataValue(NullValue(NullValue(7:48,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), username -> DataValue(StringValue(StringValue(7:40,earshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), full_name -> DataValue(StringValue(StringValue(7:43,Evgeny Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:49 DEBUG IdentityServiceActor - Processing identity resolution: IdentityResolutionRequest(Set(9),Set(),Actor[akka://Convergence/temp/$w#0])
18:18:49 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c/IdentityCacheManager] received message: IdentityResolved(MessageRecord(ConvergenceMessage(None,None,RemoteOperation(RemoteOperationMessage(0,9,28,Some(Timestamp(1608736729,257133900,UnknownFieldSet(Map()))),Some(OperationData(CompoundOperation(CompoundOperationData(List(DiscreteOperationData(StringInsertOperation(StringInsertOperationData(7:26,true,4,r,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(StringSetOperation(StringSetOperationData(0:79,false,2020-12-23T15:18:49.243Z,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(ObjectSetOperation(ObjectSetOperationData(0:14,false,HashMap(first_name -> DataValue(StringValue(StringValue(7:41,Evgeny,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), email -> DataValue(StringValue(StringValue(7:44,earshinov@company.com,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), groups -> DataValue(ArrayValue(ArrayValue(7:45,List(DataValue(StringValue(StringValue(7:46,FFProdEditor,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), id -> DataValue(DoubleValue(DoubleValue(7:47,1.9280588E7,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), last_name -> DataValue(StringValue(StringValue(7:42,Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), gtl_id -> DataValue(NullValue(NullValue(7:48,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), username -> DataValue(StringValue(StringValue(7:40,earshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), full_name -> DataValue(StringValue(StringValue(7:43,Evgeny Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())),false),IdentityResolutionResponse(Right(IdentityResolution(Map(9 -> DomainUserId(normal,earshinov)),Set(DomainUser(normal,earshinov,Some(Evgeny),Some(Arshinov),Some(Evgeny Arshinov),Some(earshinov@company.com),Some(2020-12-23T15:15:50.894Z),false,false,None))))))
18:18:49 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c] received message: SendProcessedMessage(ConvergenceMessage(None,None,IdentityCacheUpdate(IdentityCacheUpdateMessage(Map(9 -> DomainUserIdData(Normal,earshinov,UnknownFieldSet(Map()))),List(DomainUserData(Some(DomainUserIdData(Normal,earshinov,UnknownFieldSet(Map()))),Some(Evgeny),Some(Arshinov),Some(Evgeny Arshinov),Some(earshinov@company.com),false,false,None,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:49 DEBUG ProtocolConnection - SND: ConvergenceMessage(None,None,IdentityCacheUpdate(IdentityCacheUpdateMessage(Map(9 -> DomainUserIdData(Normal,earshinov,UnknownFieldSet(Map()))),List(DomainUserData(Some(DomainUserIdData(Normal,earshinov,UnknownFieldSet(Map()))),Some(Evgeny),Some(Arshinov),Some(Evgeny Arshinov),Some(earshinov@company.com),false,false,None,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))
18:18:49 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c] received message: SendProcessedMessage(ConvergenceMessage(None,None,RemoteOperation(RemoteOperationMessage(0,9,28,Some(Timestamp(1608736729,257133900,UnknownFieldSet(Map()))),Some(OperationData(CompoundOperation(CompoundOperationData(List(DiscreteOperationData(StringInsertOperation(StringInsertOperationData(7:26,true,4,r,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(StringSetOperation(StringSetOperationData(0:79,false,2020-12-23T15:18:49.243Z,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(ObjectSetOperation(ObjectSetOperationData(0:14,false,HashMap(first_name -> DataValue(StringValue(StringValue(7:41,Evgeny,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), email -> DataValue(StringValue(StringValue(7:44,earshinov@company.com,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), groups -> DataValue(ArrayValue(ArrayValue(7:45,List(DataValue(StringValue(StringValue(7:46,FFProdEditor,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), id -> DataValue(DoubleValue(DoubleValue(7:47,1.9280588E7,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), last_name -> DataValue(StringValue(StringValue(7:42,Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), gtl_id -> DataValue(NullValue(NullValue(7:48,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), username -> DataValue(StringValue(StringValue(7:40,earshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), full_name -> DataValue(StringValue(StringValue(7:43,Evgeny Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))
18:18:49 DEBUG ProtocolConnection - SND: ConvergenceMessage(None,None,RemoteOperation(RemoteOperationMessage(0,9,28,Some(Timestamp(1608736729,257133900,UnknownFieldSet(Map()))),Some(OperationData(CompoundOperation(CompoundOperationData(List(DiscreteOperationData(StringInsertOperation(StringInsertOperationData(7:26,true,4,r,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(StringSetOperation(StringSetOperationData(0:79,false,2020-12-23T15:18:49.243Z,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(ObjectSetOperation(ObjectSetOperationData(0:14,false,HashMap(first_name -> DataValue(StringValue(StringValue(7:41,Evgeny,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), email -> DataValue(StringValue(StringValue(7:44,earshinov@company.com,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), groups -> DataValue(ArrayValue(ArrayValue(7:45,List(DataValue(StringValue(StringValue(7:46,FFProdEditor,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), id -> DataValue(DoubleValue(DoubleValue(7:47,1.9280588E7,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), last_name -> DataValue(StringValue(StringValue(7:42,Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), gtl_id -> DataValue(NullValue(NullValue(7:48,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), username -> DataValue(StringValue(StringValue(7:40,earshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), full_name -> DataValue(StringValue(StringValue(7:43,Evgeny Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))

Observations

I don't see any noteable differences between step 2 and step 5. Some messages are logged in a different order, but it's only to be expected. Also, on step 5 there is no equivalent for this message from step 2:

18:17:38 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c] received message: IncomingBinaryMessage([B@598372ef)

...but I don't think it causes any problems.

For convenience, here are logs from step 2 and step 5 with messages reordered to aid side-by-side comparison:

18:17:37 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b] received message: IncomingBinaryMessage([B@442ae833)

18:17:37 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b] received message: IncomingBinaryMessage([B@5c88cc0b)

18:17:37 DEBUG ProtocolConnection - RCV: ConvergenceMessage(None,None,OperationSubmission(OperationSubmissionMessage(0,2,24,Some(OperationData(CompoundOperation(CompoundOperationData(Vector(DiscreteOperationData(StringInsertOperation(StringInsertOperationData(6:48,false,8,a,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(StringSetOperation(StringSetOperationData(0:79,false,2020-12-23T15:17:37.980Z,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(ObjectSetOperation(ObjectSetOperationData(0:14,false,HashMap(first_name -> DataValue(StringValue(StringValue(7:10,Evgeny,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), email -> DataValue(StringValue(StringValue(7:13,earshinov@company.com,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), groups -> DataValue(ArrayValue(ArrayValue(7:14,Vector(DataValue(StringValue(StringValue(7:15,FFProdEditor,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), id -> DataValue(DoubleValue(DoubleValue(7:16,1.9280588E7,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), last_name -> DataValue(StringValue(StringValue(7:11,Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), gtl_id -> DataValue(NullValue(NullValue(7:17,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), username -> DataValue(StringValue(StringValue(7:9,earshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), full_name -> DataValue(StringValue(StringValue(7:12,Evgeny Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))

18:17:37 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b] received message: SendServerMessage(OperationAcknowledgementMessage(0,2,24,Some(Timestamp(1608736657,990099600,UnknownFieldSet(Map()))),UnknownFieldSet(Map())))

18:17:37 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b] received message: SendUnprocessedMessage(ConvergenceMessage(None,None,OperationAck(OperationAcknowledgementMessage(0,2,24,Some(Timestamp(1608736657,990099600,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))

18:17:37 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b/IdentityCacheManager] received message: OutgoingMessage(ConvergenceMessage(None,None,OperationAck(OperationAcknowledgementMessage(0,2,24,Some(Timestamp(1608736657,990099600,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))

18:17:37 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b] received message: SendProcessedMessage(ConvergenceMessage(None,None,OperationAck(OperationAcknowledgementMessage(0,2,24,Some(Timestamp(1608736657,990099600,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))

18:17:37 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c] received message: SendServerMessage(RemoteOperationMessage(0,9,24,Some(Timestamp(1608736657,990099600,UnknownFieldSet(Map()))),Some(OperationData(CompoundOperation(CompoundOperationData(List(DiscreteOperationData(StringInsertOperation(StringInsertOperationData(6:48,false,8,a,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(StringSetOperation(StringSetOperationData(0:79,false,2020-12-23T15:17:37.980Z,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(ObjectSetOperation(ObjectSetOperationData(0:14,false,HashMap(first_name -> DataValue(StringValue(StringValue(7:10,Evgeny,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), email -> DataValue(StringValue(StringValue(7:13,earshinov@company.com,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), groups -> DataValue(ArrayValue(ArrayValue(7:14,List(DataValue(StringValue(StringValue(7:15,FFProdEditor,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), id -> DataValue(DoubleValue(DoubleValue(7:16,1.9280588E7,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), last_name -> DataValue(StringValue(StringValue(7:11,Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), gtl_id -> DataValue(NullValue(NullValue(7:17,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), username -> DataValue(StringValue(StringValue(7:9,earshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), full_name -> DataValue(StringValue(StringValue(7:12,Evgeny Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))

18:17:37 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c] received message: SendUnprocessedMessage(ConvergenceMessage(None,None,RemoteOperation(RemoteOperationMessage(0,9,24,Some(Timestamp(1608736657,990099600,UnknownFieldSet(Map()))),Some(OperationData(CompoundOperation(CompoundOperationData(List(DiscreteOperationData(StringInsertOperation(StringInsertOperationData(6:48,false,8,a,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(StringSetOperation(StringSetOperationData(0:79,false,2020-12-23T15:17:37.980Z,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(ObjectSetOperation(ObjectSetOperationData(0:14,false,HashMap(first_name -> DataValue(StringValue(StringValue(7:10,Evgeny,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), email -> DataValue(StringValue(StringValue(7:13,earshinov@company.com,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), groups -> DataValue(ArrayValue(ArrayValue(7:14,List(DataValue(StringValue(StringValue(7:15,FFProdEditor,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), id -> DataValue(DoubleValue(DoubleValue(7:16,1.9280588E7,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), last_name -> DataValue(StringValue(StringValue(7:11,Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), gtl_id -> DataValue(NullValue(NullValue(7:17,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), username -> DataValue(StringValue(StringValue(7:9,earshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), full_name -> DataValue(StringValue(StringValue(7:12,Evgeny Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))

18:17:37 DEBUG ProtocolConnection - SND: ConvergenceMessage(None,None,OperationAck(OperationAcknowledgementMessage(0,2,24,Some(Timestamp(1608736657,990099600,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))

18:17:37 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c/IdentityCacheManager] received message: OutgoingMessage(ConvergenceMessage(None,None,RemoteOperation(RemoteOperationMessage(0,9,24,Some(Timestamp(1608736657,990099600,UnknownFieldSet(Map()))),Some(OperationData(CompoundOperation(CompoundOperationData(List(DiscreteOperationData(StringInsertOperation(StringInsertOperationData(6:48,false,8,a,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(StringSetOperation(StringSetOperationData(0:79,false,2020-12-23T15:17:37.980Z,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(ObjectSetOperation(ObjectSetOperationData(0:14,false,HashMap(first_name -> DataValue(StringValue(StringValue(7:10,Evgeny,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), email -> DataValue(StringValue(StringValue(7:13,earshinov@company.com,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), groups -> DataValue(ArrayValue(ArrayValue(7:14,List(DataValue(StringValue(StringValue(7:15,FFProdEditor,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), id -> DataValue(DoubleValue(DoubleValue(7:16,1.9280588E7,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), last_name -> DataValue(StringValue(StringValue(7:11,Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), gtl_id -> DataValue(NullValue(NullValue(7:17,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), username -> DataValue(StringValue(StringValue(7:9,earshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), full_name -> DataValue(StringValue(StringValue(7:12,Evgeny Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))

18:17:37 DEBUG IdentityServiceActor - Processing identity resolution: IdentityResolutionRequest(Set(9),Set(),Actor[akka://Convergence/temp/$s#0])

18:17:38 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c] received message: IncomingBinaryMessage([B@598372ef)

18:17:38 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c/IdentityCacheManager] received message: IdentityResolved(MessageRecord(ConvergenceMessage(None,None,RemoteOperation(RemoteOperationMessage(0,9,24,Some(Timestamp(1608736657,990099600,UnknownFieldSet(Map()))),Some(OperationData(CompoundOperation(CompoundOperationData(List(DiscreteOperationData(StringInsertOperation(StringInsertOperationData(6:48,false,8,a,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(StringSetOperation(StringSetOperationData(0:79,false,2020-12-23T15:17:37.980Z,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(ObjectSetOperation(ObjectSetOperationData(0:14,false,HashMap(first_name -> DataValue(StringValue(StringValue(7:10,Evgeny,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), email -> DataValue(StringValue(StringValue(7:13,earshinov@company.com,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), groups -> DataValue(ArrayValue(ArrayValue(7:14,List(DataValue(StringValue(StringValue(7:15,FFProdEditor,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), id -> DataValue(DoubleValue(DoubleValue(7:16,1.9280588E7,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), last_name -> DataValue(StringValue(StringValue(7:11,Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), gtl_id -> DataValue(NullValue(NullValue(7:17,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), username -> DataValue(StringValue(StringValue(7:9,earshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), full_name -> DataValue(StringValue(StringValue(7:12,Evgeny Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())),false),IdentityResolutionResponse(Right(IdentityResolution(Map(9 -> DomainUserId(normal,earshinov)),Set(DomainUser(normal,earshinov,Some(Evgeny),Some(Arshinov),Some(Evgeny Arshinov),Some(earshinov@company.com),Some(2020-12-23T15:15:50.894Z),false,false,None))))))

18:17:38 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c] received message: SendProcessedMessage(ConvergenceMessage(None,None,IdentityCacheUpdate(IdentityCacheUpdateMessage(Map(9 -> DomainUserIdData(Normal,earshinov,UnknownFieldSet(Map()))),List(DomainUserData(Some(DomainUserIdData(Normal,earshinov,UnknownFieldSet(Map()))),Some(Evgeny),Some(Arshinov),Some(Evgeny Arshinov),Some(earshinov@company.com),false,false,None,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))

18:17:38 DEBUG ProtocolConnection - SND: ConvergenceMessage(None,None,IdentityCacheUpdate(IdentityCacheUpdateMessage(Map(9 -> DomainUserIdData(Normal,earshinov,UnknownFieldSet(Map()))),List(DomainUserData(Some(DomainUserIdData(Normal,earshinov,UnknownFieldSet(Map()))),Some(Evgeny),Some(Arshinov),Some(Evgeny Arshinov),Some(earshinov@company.com),false,false,None,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))

18:17:38 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c] received message: SendProcessedMessage(ConvergenceMessage(None,None,RemoteOperation(RemoteOperationMessage(0,9,24,Some(Timestamp(1608736657,990099600,UnknownFieldSet(Map()))),Some(OperationData(CompoundOperation(CompoundOperationData(List(DiscreteOperationData(StringInsertOperation(StringInsertOperationData(6:48,false,8,a,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(StringSetOperation(StringSetOperationData(0:79,false,2020-12-23T15:17:37.980Z,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(ObjectSetOperation(ObjectSetOperationData(0:14,false,HashMap(first_name -> DataValue(StringValue(StringValue(7:10,Evgeny,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), email -> DataValue(StringValue(StringValue(7:13,earshinov@company.com,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), groups -> DataValue(ArrayValue(ArrayValue(7:14,List(DataValue(StringValue(StringValue(7:15,FFProdEditor,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), id -> DataValue(DoubleValue(DoubleValue(7:16,1.9280588E7,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), last_name -> DataValue(StringValue(StringValue(7:11,Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), gtl_id -> DataValue(NullValue(NullValue(7:17,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), username -> DataValue(StringValue(StringValue(7:9,earshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), full_name -> DataValue(StringValue(StringValue(7:12,Evgeny Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))

18:17:38 DEBUG ProtocolConnection - SND: ConvergenceMessage(None,None,RemoteOperation(RemoteOperationMessage(0,9,24,Some(Timestamp(1608736657,990099600,UnknownFieldSet(Map()))),Some(OperationData(CompoundOperation(CompoundOperationData(List(DiscreteOperationData(StringInsertOperation(StringInsertOperationData(6:48,false,8,a,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(StringSetOperation(StringSetOperationData(0:79,false,2020-12-23T15:17:37.980Z,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(ObjectSetOperation(ObjectSetOperationData(0:14,false,HashMap(first_name -> DataValue(StringValue(StringValue(7:10,Evgeny,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), email -> DataValue(StringValue(StringValue(7:13,earshinov@company.com,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), groups -> DataValue(ArrayValue(ArrayValue(7:14,List(DataValue(StringValue(StringValue(7:15,FFProdEditor,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), id -> DataValue(DoubleValue(DoubleValue(7:16,1.9280588E7,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), last_name -> DataValue(StringValue(StringValue(7:11,Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), gtl_id -> DataValue(NullValue(NullValue(7:17,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), username -> DataValue(StringValue(StringValue(7:9,earshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), full_name -> DataValue(StringValue(StringValue(7:12,Evgeny Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))

18:18:49 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b] received message: IncomingBinaryMessage([B@43a40c25)

### 18:17:37 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b] received message: IncomingBinaryMessage([B@5c88cc0b)

18:18:49 DEBUG ProtocolConnection - RCV: ConvergenceMessage(None,None,OperationSubmission(OperationSubmissionMessage(0,6,28,Some(OperationData(CompoundOperation(CompoundOperationData(Vector(DiscreteOperationData(StringInsertOperation(StringInsertOperationData(7:26,false,4,r,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(StringSetOperation(StringSetOperationData(0:79,false,2020-12-23T15:18:49.243Z,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(ObjectSetOperation(ObjectSetOperationData(0:14,false,HashMap(first_name -> DataValue(StringValue(StringValue(7:41,Evgeny,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), email -> DataValue(StringValue(StringValue(7:44,earshinov@company.com,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), groups -> DataValue(ArrayValue(ArrayValue(7:45,Vector(DataValue(StringValue(StringValue(7:46,FFProdEditor,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), id -> DataValue(DoubleValue(DoubleValue(7:47,1.9280588E7,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), last_name -> DataValue(StringValue(StringValue(7:42,Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), gtl_id -> DataValue(NullValue(NullValue(7:48,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), username -> DataValue(StringValue(StringValue(7:40,earshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), full_name -> DataValue(StringValue(StringValue(7:43,Evgeny Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))

18:18:49 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b] received message: SendServerMessage(OperationAcknowledgementMessage(0,6,28,Some(Timestamp(1608736729,257133900,UnknownFieldSet(Map()))),UnknownFieldSet(Map())))

18:18:49 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b] received message: SendUnprocessedMessage(ConvergenceMessage(None,None,OperationAck(OperationAcknowledgementMessage(0,6,28,Some(Timestamp(1608736729,257133900,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))

18:18:49 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b/IdentityCacheManager] received message: OutgoingMessage(ConvergenceMessage(None,None,OperationAck(OperationAcknowledgementMessage(0,6,28,Some(Timestamp(1608736729,257133900,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))

18:18:49 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$b] received message: SendProcessedMessage(ConvergenceMessage(None,None,OperationAck(OperationAcknowledgementMessage(0,6,28,Some(Timestamp(1608736729,257133900,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))

18:18:49 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c] received message: SendServerMessage(RemoteOperationMessage(0,9,28,Some(Timestamp(1608736729,257133900,UnknownFieldSet(Map()))),Some(OperationData(CompoundOperation(CompoundOperationData(List(DiscreteOperationData(StringInsertOperation(StringInsertOperationData(7:26,true,4,r,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(StringSetOperation(StringSetOperationData(0:79,false,2020-12-23T15:18:49.243Z,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(ObjectSetOperation(ObjectSetOperationData(0:14,false,HashMap(first_name -> DataValue(StringValue(StringValue(7:41,Evgeny,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), email -> DataValue(StringValue(StringValue(7:44,earshinov@company.com,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), groups -> DataValue(ArrayValue(ArrayValue(7:45,List(DataValue(StringValue(StringValue(7:46,FFProdEditor,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), id -> DataValue(DoubleValue(DoubleValue(7:47,1.9280588E7,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), last_name -> DataValue(StringValue(StringValue(7:42,Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), gtl_id -> DataValue(NullValue(NullValue(7:48,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), username -> DataValue(StringValue(StringValue(7:40,earshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), full_name -> DataValue(StringValue(StringValue(7:43,Evgeny Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))

18:18:49 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c] received message: SendUnprocessedMessage(ConvergenceMessage(None,None,RemoteOperation(RemoteOperationMessage(0,9,28,Some(Timestamp(1608736729,257133900,UnknownFieldSet(Map()))),Some(OperationData(CompoundOperation(CompoundOperationData(List(DiscreteOperationData(StringInsertOperation(StringInsertOperationData(7:26,true,4,r,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(StringSetOperation(StringSetOperationData(0:79,false,2020-12-23T15:18:49.243Z,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(ObjectSetOperation(ObjectSetOperationData(0:14,false,HashMap(first_name -> DataValue(StringValue(StringValue(7:41,Evgeny,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), email -> DataValue(StringValue(StringValue(7:44,earshinov@company.com,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), groups -> DataValue(ArrayValue(ArrayValue(7:45,List(DataValue(StringValue(StringValue(7:46,FFProdEditor,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), id -> DataValue(DoubleValue(DoubleValue(7:47,1.9280588E7,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), last_name -> DataValue(StringValue(StringValue(7:42,Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), gtl_id -> DataValue(NullValue(NullValue(7:48,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), username -> DataValue(StringValue(StringValue(7:40,earshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), full_name -> DataValue(StringValue(StringValue(7:43,Evgeny Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))

18:18:49 DEBUG ProtocolConnection - SND: ConvergenceMessage(None,None,OperationAck(OperationAcknowledgementMessage(0,6,28,Some(Timestamp(1608736729,257133900,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))

18:18:49 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c/IdentityCacheManager] received message: OutgoingMessage(ConvergenceMessage(None,None,RemoteOperation(RemoteOperationMessage(0,9,28,Some(Timestamp(1608736729,257133900,UnknownFieldSet(Map()))),Some(OperationData(CompoundOperation(CompoundOperationData(List(DiscreteOperationData(StringInsertOperation(StringInsertOperationData(7:26,true,4,r,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(StringSetOperation(StringSetOperationData(0:79,false,2020-12-23T15:18:49.243Z,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(ObjectSetOperation(ObjectSetOperationData(0:14,false,HashMap(first_name -> DataValue(StringValue(StringValue(7:41,Evgeny,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), email -> DataValue(StringValue(StringValue(7:44,earshinov@company.com,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), groups -> DataValue(ArrayValue(ArrayValue(7:45,List(DataValue(StringValue(StringValue(7:46,FFProdEditor,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), id -> DataValue(DoubleValue(DoubleValue(7:47,1.9280588E7,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), last_name -> DataValue(StringValue(StringValue(7:42,Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), gtl_id -> DataValue(NullValue(NullValue(7:48,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), username -> DataValue(StringValue(StringValue(7:40,earshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), full_name -> DataValue(StringValue(StringValue(7:43,Evgeny Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))

18:18:49 DEBUG IdentityServiceActor - Processing identity resolution: IdentityResolutionRequest(Set(9),Set(),Actor[akka://Convergence/temp/$w#0])

### 18:17:38 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c] received message: IncomingBinaryMessage([B@598372ef)

18:18:49 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c/IdentityCacheManager] received message: IdentityResolved(MessageRecord(ConvergenceMessage(None,None,RemoteOperation(RemoteOperationMessage(0,9,28,Some(Timestamp(1608736729,257133900,UnknownFieldSet(Map()))),Some(OperationData(CompoundOperation(CompoundOperationData(List(DiscreteOperationData(StringInsertOperation(StringInsertOperationData(7:26,true,4,r,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(StringSetOperation(StringSetOperationData(0:79,false,2020-12-23T15:18:49.243Z,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(ObjectSetOperation(ObjectSetOperationData(0:14,false,HashMap(first_name -> DataValue(StringValue(StringValue(7:41,Evgeny,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), email -> DataValue(StringValue(StringValue(7:44,earshinov@company.com,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), groups -> DataValue(ArrayValue(ArrayValue(7:45,List(DataValue(StringValue(StringValue(7:46,FFProdEditor,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), id -> DataValue(DoubleValue(DoubleValue(7:47,1.9280588E7,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), last_name -> DataValue(StringValue(StringValue(7:42,Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), gtl_id -> DataValue(NullValue(NullValue(7:48,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), username -> DataValue(StringValue(StringValue(7:40,earshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), full_name -> DataValue(StringValue(StringValue(7:43,Evgeny Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())),false),IdentityResolutionResponse(Right(IdentityResolution(Map(9 -> DomainUserId(normal,earshinov)),Set(DomainUser(normal,earshinov,Some(Evgeny),Some(Arshinov),Some(Evgeny Arshinov),Some(earshinov@company.com),Some(2020-12-23T15:15:50.894Z),false,false,None))))))

18:18:49 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c] received message: SendProcessedMessage(ConvergenceMessage(None,None,IdentityCacheUpdate(IdentityCacheUpdateMessage(Map(9 -> DomainUserIdData(Normal,earshinov,UnknownFieldSet(Map()))),List(DomainUserData(Some(DomainUserIdData(Normal,earshinov,UnknownFieldSet(Map()))),Some(Evgeny),Some(Arshinov),Some(Evgeny Arshinov),Some(earshinov@company.com),false,false,None,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))

18:18:49 DEBUG ProtocolConnection - SND: ConvergenceMessage(None,None,IdentityCacheUpdate(IdentityCacheUpdateMessage(Map(9 -> DomainUserIdData(Normal,earshinov,UnknownFieldSet(Map()))),List(DomainUserData(Some(DomainUserIdData(Normal,earshinov,UnknownFieldSet(Map()))),Some(Evgeny),Some(Arshinov),Some(Evgeny Arshinov),Some(earshinov@company.com),false,false,None,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))

18:18:49 DEBUG LogMessagesInterceptor - actor [akka://Convergence/user/ClientCreatorActor/$c] received message: SendProcessedMessage(ConvergenceMessage(None,None,RemoteOperation(RemoteOperationMessage(0,9,28,Some(Timestamp(1608736729,257133900,UnknownFieldSet(Map()))),Some(OperationData(CompoundOperation(CompoundOperationData(List(DiscreteOperationData(StringInsertOperation(StringInsertOperationData(7:26,true,4,r,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(StringSetOperation(StringSetOperationData(0:79,false,2020-12-23T15:18:49.243Z,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(ObjectSetOperation(ObjectSetOperationData(0:14,false,HashMap(first_name -> DataValue(StringValue(StringValue(7:41,Evgeny,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), email -> DataValue(StringValue(StringValue(7:44,earshinov@company.com,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), groups -> DataValue(ArrayValue(ArrayValue(7:45,List(DataValue(StringValue(StringValue(7:46,FFProdEditor,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), id -> DataValue(DoubleValue(DoubleValue(7:47,1.9280588E7,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), last_name -> DataValue(StringValue(StringValue(7:42,Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), gtl_id -> DataValue(NullValue(NullValue(7:48,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), username -> DataValue(StringValue(StringValue(7:40,earshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), full_name -> DataValue(StringValue(StringValue(7:43,Evgeny Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())))

18:18:49 DEBUG ProtocolConnection - SND: ConvergenceMessage(None,None,RemoteOperation(RemoteOperationMessage(0,9,28,Some(Timestamp(1608736729,257133900,UnknownFieldSet(Map()))),Some(OperationData(CompoundOperation(CompoundOperationData(List(DiscreteOperationData(StringInsertOperation(StringInsertOperationData(7:26,true,4,r,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(StringSetOperation(StringSetOperationData(0:79,false,2020-12-23T15:18:49.243Z,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), DiscreteOperationData(ObjectSetOperation(ObjectSetOperationData(0:14,false,HashMap(first_name -> DataValue(StringValue(StringValue(7:41,Evgeny,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), email -> DataValue(StringValue(StringValue(7:44,earshinov@company.com,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), groups -> DataValue(ArrayValue(ArrayValue(7:45,List(DataValue(StringValue(StringValue(7:46,FFProdEditor,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map())), id -> DataValue(DoubleValue(DoubleValue(7:47,1.9280588E7,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), last_name -> DataValue(StringValue(StringValue(7:42,Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), gtl_id -> DataValue(NullValue(NullValue(7:48,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), username -> DataValue(StringValue(StringValue(7:40,earshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map())), full_name -> DataValue(StringValue(StringValue(7:43,Evgeny Arshinov,UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))),UnknownFieldSet(Map()))

[earshinov]

@mmacfadden , Hi! Did you have a chance to look into it? Our beta testers claim to sometimes lose changes they make, and we can't really enable collaborative editing for a wider audience until this issue is fixed :-(

[earshinov]

@mmacfadden , hey! We upgraded Convergence from 1.0.0-rc.7 to 1.0.0-rc.12 and this problem seems to be gone, although I don't see any relevant changes in the CHANGELOG.

[earshinov]

For the record, here is the dirty code we were using to circumvent this problem. Thankfully, we don't seem to need it any longer.

// Hack around https://github.com/convergencelabs/convergence-project/issues/189
// by replacing .value(value) call with modification of individual keys or indices

export function safeSetValue(el: TypedModel.BaseElement<unknown>, value: unknown) {
  if (el.type() === 'object' && isObject(value) && !Array.isArray(value))
    safeSetObjectValue(el as TypedModel.Object<Record<string, unknown>>, value);
  else if (el.type() === 'array' && Array.isArray(value))
    safeSetArrayValue(el as TypedModel.Array<unknown[]>, value);
  else {
    // Avoid making no-op `.value(value)` calls for null and undefined nodes.
    // These node types are readonly, and any `.value(value)` call causes an exception
    if (
      el.type() === 'null' && value === null ||
      el.type() === 'undefined' && value === undefined
    ) {
      return;
    }

    el.value(value);
  }
}

function safeSetObjectValue(el: TypedModel.Object<Record<string, unknown>>, value: unknown) {
  for (const key of el.keys())
    if (!Object.hasOwnProperty.call(value, key))
      el.remove(key);
  for (const key of Object.keys(value))
    safeSetKey(el, key, value[key]);
}

function safeSetArrayValue<T extends unknown[]>(el: TypedModel.Array<T>, value: T) {
  let len = Math.min(el.length(), value.length);
  let i = 0;
  for (; i < len; ++i)
    safeSetIndex(el, i, value[i]);
  for (; i < value.length; ++i)
    el.push(value[i]);
  len = el.length();
  for (let j = i; j < len; ++j)
    el.remove(i);
}

export function safeSetKey<T, K extends keyof T & string>(parent: TypedModel.Object<T>, key: K, value: T[K]) {
  if (parent.hasKey(key) && isCompatibleValueType(parent.get(key).type(), value) && isCompatibleValue(parent.get(key), value))
    safeSetValue(parent.get(key), value);
  else
    parent.set(key, value);
}

export function safeSetIndex<T extends unknown[]>(parent: TypedModel.Array<T>, index: number, value: T[number]) {
  if (index < parent.length() && isCompatibleValueType(parent.get(index).type(), value) && isCompatibleValue(parent.get(index), value))
    safeSetValue(parent.get(index), value);
  else
    parent.set(index, value);
}

export function isCompatibleValueType(convergenceType: string, value: unknown): boolean {
  switch (convergenceType) {
    case 'null': return value === null;
    case 'undefined': return value === undefined;
    case 'boolean': return typeof value === 'boolean';
    case 'number': return typeof value === 'number';
    case 'string': return typeof value === 'string';
    case 'array': return Array.isArray(value);
    case 'object': return isObject(value) && !Array.isArray(value);
    default: return false;
  }
}

export function isCompatibleValue(el: TypedModel.BaseElement<unknown>, value: unknown): boolean {
  return el.type() !== 'string';
}

[alalonde]

Thanks for the follow-up. rc8 and rc9 were both major releases, so this is good to hear.