Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

Persistent subscription doesn't handle events fast enough #5

Closed
jvdlaar opened this issue Aug 2, 2018 · 4 comments
Closed

Persistent subscription doesn't handle events fast enough #5

jvdlaar opened this issue Aug 2, 2018 · 4 comments

Comments

@jvdlaar
Copy link

jvdlaar commented Aug 2, 2018

I have the situation where I have a persistent subscription which receives events. I have 5 events created in my stream so they arrive immediately (buffer size of 5) when I connect. The first event enters my code and gets dumped. The other events never arrive and are retried later.

When I change the buffer size to 1 then all works well.

This is my code:

    public function consume(int $timeout = 0, int $maxItems = 0): void
    {
        $this->connection->connectAsync();

        $this->connection->connectToPersistentSubscriptionAsync(
            $this->stream,
            $this->subscriptionName,
            function (
                EventStorePersistentSubscription $subscription,
                ResolvedEvent $event,
                int $retry
            ) use ($timeout, $maxItems): Promise {
                dump((string) $event->event()->eventId());
                return new Success();
            },
            null,
            5,
            true,
            $this->credentials
        );
    }

        $builder = new ConnectionSettingsBuilder();
        $builder->enableVerboseLogging();
        $builder->useConsoleLogger();

        $this->connection = EventStoreConnectionBuilder::createAsyncFromIpEndPoint(
            new IpEndPoint(getenv('EVENT_STORE_HOST'), (int) getenv('EVENT_STORE_TCP_PORT')),
            $builder->build()
        );

This is the console output (heartbeat events removed):

[2018-08-02 08:37:04] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': enqueing message StartConnectionMessage
[2018-08-02 08:37:04] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': startConnection
[2018-08-02 08:37:04] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': discoverEndPoint
[2018-08-02 08:37:04] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': enqueing message EstablishTcpConnectionMessage
[2018-08-02 08:37:04] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': EstablishTcpConnection to [component-event-store:1113]
[2018-08-02 08:37:04] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': enqueing message StartPersistentSubscriptionMessage
[2018-08-02 08:37:04] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': StartSubscription enqueue ConnectToPersistentSubscription, StreamId: stream5b62c2b0043946.75821726, ResolveLinkTos: no, GroupName: subscription5b62c2b0043a12.27977132, BufferSize: 5, SubscriptionId: , MaxRetries: 10, Timeout: 7000
[2018-08-02 08:37:04] event-store-client.debug: TcpPackageConnection: connected to [component-event-store:1113, a40e31f36c8e43879a9da81b4672e0bb]
[2018-08-02 08:37:04] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': enqueing message TcpConnectionEstablishedMessage
[2018-08-02 08:37:04] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': TCP connection to [component-event-store:1113, a40e31f36c8e43879a9da81b4672e0bb] established
[2018-08-02 08:37:04] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': enqueing message HandleTcpPackageMessage
[2018-08-02 08:37:04] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': HandleTcpPackage connId a40e31f36c8e43879a9da81b4672e0bb, package ClientIdentified, cdcd448024ca43df9b6aaf0f4625601d
[2018-08-02 08:37:04] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': StartSubscription SUBSCRIBING Subscription ConnectToPersistentSubscription (e5ec638d650547fd99cc654a1179a185): StreamId: stream5b62c2b0043946.75821726, ResolveLinkTos: no, GroupName: subscription5b62c2b0043a12.27977132, BufferSize: 5, SubscriptionId: , is subscribed: no, retry count: 0, created: 2018-08-02T08:37:04.055498Z, last updated: 2018-08-02T08:37:04.131925Z
[2018-08-02 08:37:04] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': enqueing message HandleTcpPackageMessage
[2018-08-02 08:37:04] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': HandleTcpPackage connId a40e31f36c8e43879a9da81b4672e0bb, package PersistentSubscriptionConfirmation, e5ec638d650547fd99cc654a1179a185
[2018-08-02 08:37:04] event-store-client.debug: Subscription e5ec638d650547fd99cc654a1179a185 to stream5b62c2b0043946.75821726: subscribed at CommitPosition: 3422620, EventNumber: 4
[2018-08-02 08:37:04] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': HandleTcpPackage e5ec638d650547fd99cc654a1179a185 SUBSCRIPTION DECISION Subscribed (SubscriptionConfirmation), 
[2018-08-02 08:37:04] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': enqueing message HandleTcpPackageMessage
[2018-08-02 08:37:04] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': HandleTcpPackage connId a40e31f36c8e43879a9da81b4672e0bb, package PersistentSubscriptionStreamEventAppeared, e5ec638d650547fd99cc654a1179a185
[2018-08-02 08:37:04] event-store-client.debug: Subscription e5ec638d650547fd99cc654a1179a185 to stream5b62c2b0043946.75821726: event appeared (stream5b62c2b0043946.75821726, 0, Tests\Mock\TestDomainEvent @ <null>)
[2018-08-02 08:37:04] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': HandleTcpPackage e5ec638d650547fd99cc654a1179a185 SUBSCRIPTION DECISION DoNothing (StreamEventAppeared), 
[2018-08-02 08:37:04] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': enqueing message HandleTcpPackageMessage
[2018-08-02 08:37:04] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': HandleTcpPackage connId a40e31f36c8e43879a9da81b4672e0bb, package PersistentSubscriptionStreamEventAppeared, e5ec638d650547fd99cc654a1179a185
[2018-08-02 08:37:04] event-store-client.debug: Subscription e5ec638d650547fd99cc654a1179a185 to stream5b62c2b0043946.75821726: event appeared (stream5b62c2b0043946.75821726, 1, Tests\Mock\TestDomainEvent @ <null>)
[2018-08-02 08:37:04] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': HandleTcpPackage e5ec638d650547fd99cc654a1179a185 SUBSCRIPTION DECISION DoNothing (StreamEventAppeared), 
[2018-08-02 08:37:04] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': enqueing message HandleTcpPackageMessage
[2018-08-02 08:37:04] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': HandleTcpPackage connId a40e31f36c8e43879a9da81b4672e0bb, package PersistentSubscriptionStreamEventAppeared, e5ec638d650547fd99cc654a1179a185
[2018-08-02 08:37:04] event-store-client.debug: Subscription e5ec638d650547fd99cc654a1179a185 to stream5b62c2b0043946.75821726: event appeared (stream5b62c2b0043946.75821726, 2, Tests\Mock\TestDomainEvent @ <null>)
[2018-08-02 08:37:04] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': HandleTcpPackage e5ec638d650547fd99cc654a1179a185 SUBSCRIPTION DECISION DoNothing (StreamEventAppeared), 
[2018-08-02 08:37:04] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': enqueing message HandleTcpPackageMessage
[2018-08-02 08:37:04] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': HandleTcpPackage connId a40e31f36c8e43879a9da81b4672e0bb, package PersistentSubscriptionStreamEventAppeared, e5ec638d650547fd99cc654a1179a185
[2018-08-02 08:37:04] event-store-client.debug: Subscription e5ec638d650547fd99cc654a1179a185 to stream5b62c2b0043946.75821726: event appeared (stream5b62c2b0043946.75821726, 3, Tests\Mock\TestDomainEvent @ <null>)
[2018-08-02 08:37:04] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': HandleTcpPackage e5ec638d650547fd99cc654a1179a185 SUBSCRIPTION DECISION DoNothing (StreamEventAppeared), 
[2018-08-02 08:37:04] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': enqueing message HandleTcpPackageMessage
[2018-08-02 08:37:04] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': HandleTcpPackage connId a40e31f36c8e43879a9da81b4672e0bb, package PersistentSubscriptionStreamEventAppeared, e5ec638d650547fd99cc654a1179a185
[2018-08-02 08:37:04] event-store-client.debug: Subscription e5ec638d650547fd99cc654a1179a185 to stream5b62c2b0043946.75821726: event appeared (stream5b62c2b0043946.75821726, 4, Tests\Mock\TestDomainEvent @ <null>)
[2018-08-02 08:37:04] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': HandleTcpPackage e5ec638d650547fd99cc654a1179a185 SUBSCRIPTION DECISION DoNothing (StreamEventAppeared), 
"d9929fe3-228d-a645-9ffd-2fecad6321f4"
[2018-08-02 08:37:04] event-store-client.debug: Persistent Subscription to stream5b62c2b0043946.75821726: processed event (stream5b62c2b0043946.75821726, 0, Tests\Mock\TestDomainEvent @ 0)




[2018-08-02 08:37:35] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': enqueing message HandleTcpPackageMessage
[2018-08-02 08:37:35] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': HandleTcpPackage connId a40e31f36c8e43879a9da81b4672e0bb, package PersistentSubscriptionStreamEventAppeared, e5ec638d650547fd99cc654a1179a185
[2018-08-02 08:37:35] event-store-client.debug: Subscription e5ec638d650547fd99cc654a1179a185 to stream5b62c2b0043946.75821726: event appeared (stream5b62c2b0043946.75821726, 1, Tests\Mock\TestDomainEvent @ <null>)
[2018-08-02 08:37:35] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': HandleTcpPackage e5ec638d650547fd99cc654a1179a185 SUBSCRIPTION DECISION DoNothing (StreamEventAppeared), 
[2018-08-02 08:37:35] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': enqueing message HandleTcpPackageMessage
[2018-08-02 08:37:35] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': HandleTcpPackage connId a40e31f36c8e43879a9da81b4672e0bb, package PersistentSubscriptionStreamEventAppeared, e5ec638d650547fd99cc654a1179a185
[2018-08-02 08:37:35] event-store-client.debug: Subscription e5ec638d650547fd99cc654a1179a185 to stream5b62c2b0043946.75821726: event appeared (stream5b62c2b0043946.75821726, 2, Tests\Mock\TestDomainEvent @ <null>)
[2018-08-02 08:37:35] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': HandleTcpPackage e5ec638d650547fd99cc654a1179a185 SUBSCRIPTION DECISION DoNothing (StreamEventAppeared), 
[2018-08-02 08:37:35] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': enqueing message HandleTcpPackageMessage
[2018-08-02 08:37:35] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': HandleTcpPackage connId a40e31f36c8e43879a9da81b4672e0bb, package PersistentSubscriptionStreamEventAppeared, e5ec638d650547fd99cc654a1179a185
[2018-08-02 08:37:35] event-store-client.debug: Subscription e5ec638d650547fd99cc654a1179a185 to stream5b62c2b0043946.75821726: event appeared (stream5b62c2b0043946.75821726, 3, Tests\Mock\TestDomainEvent @ <null>)
[2018-08-02 08:37:35] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': HandleTcpPackage e5ec638d650547fd99cc654a1179a185 SUBSCRIPTION DECISION DoNothing (StreamEventAppeared), 
[2018-08-02 08:37:35] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': enqueing message HandleTcpPackageMessage
[2018-08-02 08:37:35] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': HandleTcpPackage connId a40e31f36c8e43879a9da81b4672e0bb, package PersistentSubscriptionStreamEventAppeared, e5ec638d650547fd99cc654a1179a185
[2018-08-02 08:37:35] event-store-client.debug: Subscription e5ec638d650547fd99cc654a1179a185 to stream5b62c2b0043946.75821726: event appeared (stream5b62c2b0043946.75821726, 4, Tests\Mock\TestDomainEvent @ <null>)
[2018-08-02 08:37:35] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': HandleTcpPackage e5ec638d650547fd99cc654a1179a185 SUBSCRIPTION DECISION DoNothing (StreamEventAppeared), 
"ce0d29fd-9c71-6944-91b6-b7230bcdf965"
[2018-08-02 08:37:35] event-store-client.debug: Persistent Subscription to stream5b62c2b0043946.75821726: processed event (stream5b62c2b0043946.75821726, 1, Tests\Mock\TestDomainEvent @ 1)
"ba48670b-54eb-da4d-a0f8-4ac6e16b6bb4"
[2018-08-02 08:37:35] event-store-client.debug: Persistent Subscription to stream5b62c2b0043946.75821726: processed event (stream5b62c2b0043946.75821726, 2, Tests\Mock\TestDomainEvent @ 2)




[2018-08-02 08:38:05] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': enqueing message HandleTcpPackageMessage
[2018-08-02 08:38:05] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': HandleTcpPackage connId a40e31f36c8e43879a9da81b4672e0bb, package PersistentSubscriptionStreamEventAppeared, e5ec638d650547fd99cc654a1179a185
[2018-08-02 08:38:05] event-store-client.debug: Subscription e5ec638d650547fd99cc654a1179a185 to stream5b62c2b0043946.75821726: event appeared (stream5b62c2b0043946.75821726, 3, Tests\Mock\TestDomainEvent @ <null>)
[2018-08-02 08:38:05] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': HandleTcpPackage e5ec638d650547fd99cc654a1179a185 SUBSCRIPTION DECISION DoNothing (StreamEventAppeared), 
[2018-08-02 08:38:05] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': enqueing message HandleTcpPackageMessage
[2018-08-02 08:38:05] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': HandleTcpPackage connId a40e31f36c8e43879a9da81b4672e0bb, package PersistentSubscriptionStreamEventAppeared, e5ec638d650547fd99cc654a1179a185
[2018-08-02 08:38:05] event-store-client.debug: Subscription e5ec638d650547fd99cc654a1179a185 to stream5b62c2b0043946.75821726: event appeared (stream5b62c2b0043946.75821726, 4, Tests\Mock\TestDomainEvent @ <null>)
[2018-08-02 08:38:05] event-store-client.debug: EventStoreNodeConnection '62c98317776b4b4f81b9a19102ff55e9': HandleTcpPackage e5ec638d650547fd99cc654a1179a185 SUBSCRIPTION DECISION DoNothing (StreamEventAppeared), 
"3c463f4d-9f2e-0c48-92bd-df08e935bdd4"
[2018-08-02 08:38:05] event-store-client.debug: Persistent Subscription to stream5b62c2b0043946.75821726: processed event (stream5b62c2b0043946.75821726, 3, Tests\Mock\TestDomainEvent @ 3)
"d8b3d541-c800-1a4b-b82d-775b57614540"
[2018-08-02 08:38:05] event-store-client.debug: Persistent Subscription to stream5b62c2b0043946.75821726: processed event (stream5b62c2b0043946.75821726, 4, Tests\Mock\TestDomainEvent @ 4)

Subscription settings:
screenshot from 2018-08-02 10-46-31
@prolic
Copy link
Member

prolic commented Aug 4, 2018

I cannot reproduce this. I used this test-case: https://github.com/prooph/event-store-client/blob/master/tests/happy_case_writing_and_subscribing_to_normal_events_auto_ack.php and enabled console logger as well as verbose logging. All events come in only once. See my output below.

PHPUnit 7.2.7 by Sebastian Bergmann and contributors.

[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message StartConnectionMessage
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': startConnection
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': discoverEndPoint
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message EstablishTcpConnectionMessage
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': EstablishTcpConnection to [localhost:1113]
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message StartOperationMessage
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': StartOperation enqueue CreatePersistentSubscription, 10, 7000
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': EnqueueOperation WAITING for Operation CreatePersistentSubscription (b894be0f664f41f58659775cc5b31b82): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, Group Name: 24217997b4cb44a0a9e7980a695939aa, retry count: 0, created: 2018-08-04T15:59:55.725162Z, last updated: 2018-08-04T15:59:55.725162Z
[2018-08-04 15:59:55] event-store-client.DEBUG: TcpPackageConnection: connected to [localhost:1113, 9ed1a9ac39ab458ea1a69b1ed1f7cafe]
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message TcpConnectionEstablishedMessage
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': TCP connection to [localhost:1113, 9ed1a9ac39ab458ea1a69b1ed1f7cafe] established
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package Authenticated, e750f4bad0324027a06516a09dba5345
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package ClientIdentified, 68805ab544ba44f693363b0ade44993b
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': ExecuteOperation package CreatePersistentSubscription, b894be0f664f41f58659775cc5b31b82, Operation CreatePersistentSubscription (b894be0f664f41f58659775cc5b31b82): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, Group Name: 24217997b4cb44a0a9e7980a695939aa, retry count: 0, created: 2018-08-04T15:59:55.725162Z, last updated: 2018-08-04T15:59:55.777784Z
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package CreatePersistentSubscriptionCompleted, b894be0f664f41f58659775cc5b31b82
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message StartPersistentSubscriptionMessage
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': StartSubscription fire ConnectToPersistentSubscription, StreamId: 4dcced610f404b31b3f3c8c2f9b4916d, ResolveLinkTos: no, GroupName: 24217997b4cb44a0a9e7980a695939aa, BufferSize: 10, SubscriptionId: , MaxRetries: 10, Timeout: 7000
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': StartSubscription SUBSCRIBING Subscription ConnectToPersistentSubscription (538147f266f3437e993c68492fedaae4): StreamId: 4dcced610f404b31b3f3c8c2f9b4916d, ResolveLinkTos: no, GroupName: 24217997b4cb44a0a9e7980a695939aa, BufferSize: 10, SubscriptionId: , is subscribed: no, retry count: 0, created: 2018-08-04T15:59:55.799867Z, last updated: 2018-08-04T15:59:55.799902Z
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message StartOperationMessage
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': StartOperation schedule AppendToStream, Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, 10, 7000
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': ExecuteOperation package WriteEvents, dc887321fbda44e7bc9d8bd75345b7bf, Operation AppendToStream (dc887321fbda44e7bc9d8bd75345b7bf): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:55.800577Z, last updated: 2018-08-04T15:59:55.800594Z
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage OPERATION DECISION EndOperation (Success), Operation CreatePersistentSubscription (b894be0f664f41f58659775cc5b31b82): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, Group Name: 24217997b4cb44a0a9e7980a695939aa, retry count: 0, created: 2018-08-04T15:59:55.725162Z, last updated: 2018-08-04T15:59:55.777784Z
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': RemoveOperation SUCCEEDED for Operation CreatePersistentSubscription (b894be0f664f41f58659775cc5b31b82): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, Group Name: 24217997b4cb44a0a9e7980a695939aa, retry count: 0, created: 2018-08-04T15:59:55.725162Z, last updated: 2018-08-04T15:59:55.777784Z
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package PersistentSubscriptionConfirmation, 538147f266f3437e993c68492fedaae4
[2018-08-04 15:59:55] event-store-client.DEBUG: Subscription 538147f266f3437e993c68492fedaae4 to 4dcced610f404b31b3f3c8c2f9b4916d: subscribed at CommitPosition: 26284815, EventNumber: -1
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage 538147f266f3437e993c68492fedaae4 SUBSCRIPTION DECISION Subscribed (SubscriptionConfirmation), 
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package PersistentSubscriptionStreamEventAppeared, 538147f266f3437e993c68492fedaae4
[2018-08-04 15:59:55] event-store-client.DEBUG: Subscription 538147f266f3437e993c68492fedaae4 to 4dcced610f404b31b3f3c8c2f9b4916d: event appeared (4dcced610f404b31b3f3c8c2f9b4916d, 0, SomeEvent @ <null>)
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage 538147f266f3437e993c68492fedaae4 SUBSCRIPTION DECISION DoNothing (StreamEventAppeared), 
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package WriteEventsCompleted, dc887321fbda44e7bc9d8bd75345b7bf
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message StartOperationMessage
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': StartOperation schedule AppendToStream, Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, 10, 7000
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': ExecuteOperation package WriteEvents, f8efa0df4b054811976e39090c004979, Operation AppendToStream (f8efa0df4b054811976e39090c004979): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:55.824061Z, last updated: 2018-08-04T15:59:55.824076Z
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage OPERATION DECISION EndOperation (Success), Operation AppendToStream (dc887321fbda44e7bc9d8bd75345b7bf): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:55.800577Z, last updated: 2018-08-04T15:59:55.800594Z
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': RemoveOperation SUCCEEDED for Operation AppendToStream (dc887321fbda44e7bc9d8bd75345b7bf): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:55.800577Z, last updated: 2018-08-04T15:59:55.800594Z
[2018-08-04 15:59:55] event-store-client.DEBUG: Persistent Subscription to 4dcced610f404b31b3f3c8c2f9b4916d: processed event (4dcced610f404b31b3f3c8c2f9b4916d, 0, SomeEvent @ 0)
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package PersistentSubscriptionStreamEventAppeared, 538147f266f3437e993c68492fedaae4
[2018-08-04 15:59:55] event-store-client.DEBUG: Subscription 538147f266f3437e993c68492fedaae4 to 4dcced610f404b31b3f3c8c2f9b4916d: event appeared (4dcced610f404b31b3f3c8c2f9b4916d, 1, SomeEvent @ <null>)
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage 538147f266f3437e993c68492fedaae4 SUBSCRIPTION DECISION DoNothing (StreamEventAppeared), 
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package WriteEventsCompleted, f8efa0df4b054811976e39090c004979
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message StartOperationMessage
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': StartOperation schedule AppendToStream, Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, 10, 7000
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': ExecuteOperation package WriteEvents, 30659fa29330401690b48da2fc771477, Operation AppendToStream (30659fa29330401690b48da2fc771477): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:55.847771Z, last updated: 2018-08-04T15:59:55.847794Z
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage OPERATION DECISION EndOperation (Success), Operation AppendToStream (f8efa0df4b054811976e39090c004979): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:55.824061Z, last updated: 2018-08-04T15:59:55.824076Z
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': RemoveOperation SUCCEEDED for Operation AppendToStream (f8efa0df4b054811976e39090c004979): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:55.824061Z, last updated: 2018-08-04T15:59:55.824076Z
[2018-08-04 15:59:55] event-store-client.DEBUG: Persistent Subscription to 4dcced610f404b31b3f3c8c2f9b4916d: processed event (4dcced610f404b31b3f3c8c2f9b4916d, 1, SomeEvent @ 1)
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package PersistentSubscriptionStreamEventAppeared, 538147f266f3437e993c68492fedaae4
[2018-08-04 15:59:55] event-store-client.DEBUG: Subscription 538147f266f3437e993c68492fedaae4 to 4dcced610f404b31b3f3c8c2f9b4916d: event appeared (4dcced610f404b31b3f3c8c2f9b4916d, 2, SomeEvent @ <null>)
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage 538147f266f3437e993c68492fedaae4 SUBSCRIPTION DECISION DoNothing (StreamEventAppeared), 
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package WriteEventsCompleted, 30659fa29330401690b48da2fc771477
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message StartOperationMessage
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': StartOperation schedule AppendToStream, Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, 10, 7000
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': ExecuteOperation package WriteEvents, 190ecbcbc33e4b37ba7a2794b519dc74, Operation AppendToStream (190ecbcbc33e4b37ba7a2794b519dc74): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:55.872219Z, last updated: 2018-08-04T15:59:55.872242Z
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage OPERATION DECISION EndOperation (Success), Operation AppendToStream (30659fa29330401690b48da2fc771477): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:55.847771Z, last updated: 2018-08-04T15:59:55.847794Z
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': RemoveOperation SUCCEEDED for Operation AppendToStream (30659fa29330401690b48da2fc771477): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:55.847771Z, last updated: 2018-08-04T15:59:55.847794Z
[2018-08-04 15:59:55] event-store-client.DEBUG: Persistent Subscription to 4dcced610f404b31b3f3c8c2f9b4916d: processed event (4dcced610f404b31b3f3c8c2f9b4916d, 2, SomeEvent @ 2)
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package PersistentSubscriptionStreamEventAppeared, 538147f266f3437e993c68492fedaae4
[2018-08-04 15:59:55] event-store-client.DEBUG: Subscription 538147f266f3437e993c68492fedaae4 to 4dcced610f404b31b3f3c8c2f9b4916d: event appeared (4dcced610f404b31b3f3c8c2f9b4916d, 3, SomeEvent @ <null>)
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage 538147f266f3437e993c68492fedaae4 SUBSCRIPTION DECISION DoNothing (StreamEventAppeared), 
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package WriteEventsCompleted, 190ecbcbc33e4b37ba7a2794b519dc74
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message StartOperationMessage
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': StartOperation schedule AppendToStream, Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, 10, 7000
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': ExecuteOperation package WriteEvents, f921427f4c1747f8911dbbd46e7b838b, Operation AppendToStream (f921427f4c1747f8911dbbd46e7b838b): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:55.896950Z, last updated: 2018-08-04T15:59:55.896972Z
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage OPERATION DECISION EndOperation (Success), Operation AppendToStream (190ecbcbc33e4b37ba7a2794b519dc74): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:55.872219Z, last updated: 2018-08-04T15:59:55.872242Z
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': RemoveOperation SUCCEEDED for Operation AppendToStream (190ecbcbc33e4b37ba7a2794b519dc74): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:55.872219Z, last updated: 2018-08-04T15:59:55.872242Z
[2018-08-04 15:59:55] event-store-client.DEBUG: Persistent Subscription to 4dcced610f404b31b3f3c8c2f9b4916d: processed event (4dcced610f404b31b3f3c8c2f9b4916d, 3, SomeEvent @ 3)
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package PersistentSubscriptionStreamEventAppeared, 538147f266f3437e993c68492fedaae4
[2018-08-04 15:59:55] event-store-client.DEBUG: Subscription 538147f266f3437e993c68492fedaae4 to 4dcced610f404b31b3f3c8c2f9b4916d: event appeared (4dcced610f404b31b3f3c8c2f9b4916d, 4, SomeEvent @ <null>)
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage 538147f266f3437e993c68492fedaae4 SUBSCRIPTION DECISION DoNothing (StreamEventAppeared), 
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package WriteEventsCompleted, f921427f4c1747f8911dbbd46e7b838b
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message StartOperationMessage
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': StartOperation schedule AppendToStream, Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, 10, 7000
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': ExecuteOperation package WriteEvents, a953efb2cf734b2aa5054cadf56729bc, Operation AppendToStream (a953efb2cf734b2aa5054cadf56729bc): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:55.921736Z, last updated: 2018-08-04T15:59:55.921764Z
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage OPERATION DECISION EndOperation (Success), Operation AppendToStream (f921427f4c1747f8911dbbd46e7b838b): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:55.896950Z, last updated: 2018-08-04T15:59:55.896972Z
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': RemoveOperation SUCCEEDED for Operation AppendToStream (f921427f4c1747f8911dbbd46e7b838b): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:55.896950Z, last updated: 2018-08-04T15:59:55.896972Z
[2018-08-04 15:59:55] event-store-client.DEBUG: Persistent Subscription to 4dcced610f404b31b3f3c8c2f9b4916d: processed event (4dcced610f404b31b3f3c8c2f9b4916d, 4, SomeEvent @ 4)
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package PersistentSubscriptionStreamEventAppeared, 538147f266f3437e993c68492fedaae4
[2018-08-04 15:59:55] event-store-client.DEBUG: Subscription 538147f266f3437e993c68492fedaae4 to 4dcced610f404b31b3f3c8c2f9b4916d: event appeared (4dcced610f404b31b3f3c8c2f9b4916d, 5, SomeEvent @ <null>)
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage 538147f266f3437e993c68492fedaae4 SUBSCRIPTION DECISION DoNothing (StreamEventAppeared), 
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package WriteEventsCompleted, a953efb2cf734b2aa5054cadf56729bc
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message StartOperationMessage
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': StartOperation schedule AppendToStream, Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, 10, 7000
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': ExecuteOperation package WriteEvents, 746031eb66834aeb9873efa7eb814397, Operation AppendToStream (746031eb66834aeb9873efa7eb814397): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:55.946079Z, last updated: 2018-08-04T15:59:55.946099Z
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage OPERATION DECISION EndOperation (Success), Operation AppendToStream (a953efb2cf734b2aa5054cadf56729bc): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:55.921736Z, last updated: 2018-08-04T15:59:55.921764Z
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': RemoveOperation SUCCEEDED for Operation AppendToStream (a953efb2cf734b2aa5054cadf56729bc): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:55.921736Z, last updated: 2018-08-04T15:59:55.921764Z
[2018-08-04 15:59:55] event-store-client.DEBUG: Persistent Subscription to 4dcced610f404b31b3f3c8c2f9b4916d: processed event (4dcced610f404b31b3f3c8c2f9b4916d, 5, SomeEvent @ 5)
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package PersistentSubscriptionStreamEventAppeared, 538147f266f3437e993c68492fedaae4
[2018-08-04 15:59:55] event-store-client.DEBUG: Subscription 538147f266f3437e993c68492fedaae4 to 4dcced610f404b31b3f3c8c2f9b4916d: event appeared (4dcced610f404b31b3f3c8c2f9b4916d, 6, SomeEvent @ <null>)
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage 538147f266f3437e993c68492fedaae4 SUBSCRIPTION DECISION DoNothing (StreamEventAppeared), 
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package WriteEventsCompleted, 746031eb66834aeb9873efa7eb814397
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message StartOperationMessage
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': StartOperation schedule AppendToStream, Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, 10, 7000
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': ExecuteOperation package WriteEvents, c7d9f7d595ec4a66b293e69f3f346621, Operation AppendToStream (c7d9f7d595ec4a66b293e69f3f346621): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:55.969650Z, last updated: 2018-08-04T15:59:55.969669Z
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage OPERATION DECISION EndOperation (Success), Operation AppendToStream (746031eb66834aeb9873efa7eb814397): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:55.946079Z, last updated: 2018-08-04T15:59:55.946099Z
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': RemoveOperation SUCCEEDED for Operation AppendToStream (746031eb66834aeb9873efa7eb814397): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:55.946079Z, last updated: 2018-08-04T15:59:55.946099Z
[2018-08-04 15:59:55] event-store-client.DEBUG: Persistent Subscription to 4dcced610f404b31b3f3c8c2f9b4916d: processed event (4dcced610f404b31b3f3c8c2f9b4916d, 6, SomeEvent @ 6)
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package WriteEventsCompleted, c7d9f7d595ec4a66b293e69f3f346621
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message StartOperationMessage
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': StartOperation schedule AppendToStream, Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, 10, 7000
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': ExecuteOperation package WriteEvents, 5367322029e145109cc4cee0cc1acaf2, Operation AppendToStream (5367322029e145109cc4cee0cc1acaf2): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:55.993933Z, last updated: 2018-08-04T15:59:55.993955Z
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage OPERATION DECISION EndOperation (Success), Operation AppendToStream (c7d9f7d595ec4a66b293e69f3f346621): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:55.969650Z, last updated: 2018-08-04T15:59:55.969669Z
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': RemoveOperation SUCCEEDED for Operation AppendToStream (c7d9f7d595ec4a66b293e69f3f346621): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:55.969650Z, last updated: 2018-08-04T15:59:55.969669Z
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package PersistentSubscriptionStreamEventAppeared, 538147f266f3437e993c68492fedaae4
[2018-08-04 15:59:55] event-store-client.DEBUG: Subscription 538147f266f3437e993c68492fedaae4 to 4dcced610f404b31b3f3c8c2f9b4916d: event appeared (4dcced610f404b31b3f3c8c2f9b4916d, 7, SomeEvent @ <null>)
[2018-08-04 15:59:55] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage 538147f266f3437e993c68492fedaae4 SUBSCRIPTION DECISION DoNothing (StreamEventAppeared), 
[2018-08-04 15:59:55] event-store-client.DEBUG: Persistent Subscription to 4dcced610f404b31b3f3c8c2f9b4916d: processed event (4dcced610f404b31b3f3c8c2f9b4916d, 7, SomeEvent @ 7)
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package PersistentSubscriptionStreamEventAppeared, 538147f266f3437e993c68492fedaae4
[2018-08-04 15:59:56] event-store-client.DEBUG: Subscription 538147f266f3437e993c68492fedaae4 to 4dcced610f404b31b3f3c8c2f9b4916d: event appeared (4dcced610f404b31b3f3c8c2f9b4916d, 8, SomeEvent @ <null>)
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage 538147f266f3437e993c68492fedaae4 SUBSCRIPTION DECISION DoNothing (StreamEventAppeared), 
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package WriteEventsCompleted, 5367322029e145109cc4cee0cc1acaf2
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message StartOperationMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': StartOperation schedule AppendToStream, Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, 10, 7000
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': ExecuteOperation package WriteEvents, 17dc790f69d64972bfb63be1b3a61936, Operation AppendToStream (17dc790f69d64972bfb63be1b3a61936): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:56.015565Z, last updated: 2018-08-04T15:59:56.015583Z
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage OPERATION DECISION EndOperation (Success), Operation AppendToStream (5367322029e145109cc4cee0cc1acaf2): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:55.993933Z, last updated: 2018-08-04T15:59:55.993955Z
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': RemoveOperation SUCCEEDED for Operation AppendToStream (5367322029e145109cc4cee0cc1acaf2): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:55.993933Z, last updated: 2018-08-04T15:59:55.993955Z
[2018-08-04 15:59:56] event-store-client.DEBUG: Persistent Subscription to 4dcced610f404b31b3f3c8c2f9b4916d: processed event (4dcced610f404b31b3f3c8c2f9b4916d, 8, SomeEvent @ 8)
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package PersistentSubscriptionStreamEventAppeared, 538147f266f3437e993c68492fedaae4
[2018-08-04 15:59:56] event-store-client.DEBUG: Subscription 538147f266f3437e993c68492fedaae4 to 4dcced610f404b31b3f3c8c2f9b4916d: event appeared (4dcced610f404b31b3f3c8c2f9b4916d, 9, SomeEvent @ <null>)
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage 538147f266f3437e993c68492fedaae4 SUBSCRIPTION DECISION DoNothing (StreamEventAppeared), 
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package WriteEventsCompleted, 17dc790f69d64972bfb63be1b3a61936
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message StartOperationMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': StartOperation schedule AppendToStream, Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, 10, 7000
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': ExecuteOperation package WriteEvents, a231da45650d4e6caf5bfbdb3f199d4e, Operation AppendToStream (a231da45650d4e6caf5bfbdb3f199d4e): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:56.035044Z, last updated: 2018-08-04T15:59:56.035062Z
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage OPERATION DECISION EndOperation (Success), Operation AppendToStream (17dc790f69d64972bfb63be1b3a61936): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:56.015565Z, last updated: 2018-08-04T15:59:56.015583Z
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': RemoveOperation SUCCEEDED for Operation AppendToStream (17dc790f69d64972bfb63be1b3a61936): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:56.015565Z, last updated: 2018-08-04T15:59:56.015583Z
[2018-08-04 15:59:56] event-store-client.DEBUG: Persistent Subscription to 4dcced610f404b31b3f3c8c2f9b4916d: processed event (4dcced610f404b31b3f3c8c2f9b4916d, 9, SomeEvent @ 9)
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package PersistentSubscriptionStreamEventAppeared, 538147f266f3437e993c68492fedaae4
[2018-08-04 15:59:56] event-store-client.DEBUG: Subscription 538147f266f3437e993c68492fedaae4 to 4dcced610f404b31b3f3c8c2f9b4916d: event appeared (4dcced610f404b31b3f3c8c2f9b4916d, 10, SomeEvent @ <null>)
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage 538147f266f3437e993c68492fedaae4 SUBSCRIPTION DECISION DoNothing (StreamEventAppeared), 
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package WriteEventsCompleted, a231da45650d4e6caf5bfbdb3f199d4e
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message StartOperationMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': StartOperation schedule AppendToStream, Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, 10, 7000
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': ExecuteOperation package WriteEvents, e974c39351a04de9ba86b0e2460b4042, Operation AppendToStream (e974c39351a04de9ba86b0e2460b4042): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:56.059975Z, last updated: 2018-08-04T15:59:56.059995Z
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage OPERATION DECISION EndOperation (Success), Operation AppendToStream (a231da45650d4e6caf5bfbdb3f199d4e): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:56.035044Z, last updated: 2018-08-04T15:59:56.035062Z
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': RemoveOperation SUCCEEDED for Operation AppendToStream (a231da45650d4e6caf5bfbdb3f199d4e): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:56.035044Z, last updated: 2018-08-04T15:59:56.035062Z
[2018-08-04 15:59:56] event-store-client.DEBUG: Persistent Subscription to 4dcced610f404b31b3f3c8c2f9b4916d: processed event (4dcced610f404b31b3f3c8c2f9b4916d, 10, SomeEvent @ 10)
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package PersistentSubscriptionStreamEventAppeared, 538147f266f3437e993c68492fedaae4
[2018-08-04 15:59:56] event-store-client.DEBUG: Subscription 538147f266f3437e993c68492fedaae4 to 4dcced610f404b31b3f3c8c2f9b4916d: event appeared (4dcced610f404b31b3f3c8c2f9b4916d, 11, SomeEvent @ <null>)
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage 538147f266f3437e993c68492fedaae4 SUBSCRIPTION DECISION DoNothing (StreamEventAppeared), 
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package WriteEventsCompleted, e974c39351a04de9ba86b0e2460b4042
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message StartOperationMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': StartOperation schedule AppendToStream, Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, 10, 7000
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': ExecuteOperation package WriteEvents, c83868d59260436f8f31b2e5f7b55f41, Operation AppendToStream (c83868d59260436f8f31b2e5f7b55f41): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:56.083715Z, last updated: 2018-08-04T15:59:56.083734Z
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage OPERATION DECISION EndOperation (Success), Operation AppendToStream (e974c39351a04de9ba86b0e2460b4042): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:56.059975Z, last updated: 2018-08-04T15:59:56.059995Z
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': RemoveOperation SUCCEEDED for Operation AppendToStream (e974c39351a04de9ba86b0e2460b4042): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:56.059975Z, last updated: 2018-08-04T15:59:56.059995Z
[2018-08-04 15:59:56] event-store-client.DEBUG: Persistent Subscription to 4dcced610f404b31b3f3c8c2f9b4916d: processed event (4dcced610f404b31b3f3c8c2f9b4916d, 11, SomeEvent @ 11)
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package WriteEventsCompleted, c83868d59260436f8f31b2e5f7b55f41
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message StartOperationMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': StartOperation schedule AppendToStream, Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, 10, 7000
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': ExecuteOperation package WriteEvents, 6ddafe093259462792ef3cb92e08e9a9, Operation AppendToStream (6ddafe093259462792ef3cb92e08e9a9): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:56.108043Z, last updated: 2018-08-04T15:59:56.108065Z
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage OPERATION DECISION EndOperation (Success), Operation AppendToStream (c83868d59260436f8f31b2e5f7b55f41): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:56.083715Z, last updated: 2018-08-04T15:59:56.083734Z
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': RemoveOperation SUCCEEDED for Operation AppendToStream (c83868d59260436f8f31b2e5f7b55f41): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:56.083715Z, last updated: 2018-08-04T15:59:56.083734Z
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package PersistentSubscriptionStreamEventAppeared, 538147f266f3437e993c68492fedaae4
[2018-08-04 15:59:56] event-store-client.DEBUG: Subscription 538147f266f3437e993c68492fedaae4 to 4dcced610f404b31b3f3c8c2f9b4916d: event appeared (4dcced610f404b31b3f3c8c2f9b4916d, 12, SomeEvent @ <null>)
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage 538147f266f3437e993c68492fedaae4 SUBSCRIPTION DECISION DoNothing (StreamEventAppeared), 
[2018-08-04 15:59:56] event-store-client.DEBUG: Persistent Subscription to 4dcced610f404b31b3f3c8c2f9b4916d: processed event (4dcced610f404b31b3f3c8c2f9b4916d, 12, SomeEvent @ 12)
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package PersistentSubscriptionStreamEventAppeared, 538147f266f3437e993c68492fedaae4
[2018-08-04 15:59:56] event-store-client.DEBUG: Subscription 538147f266f3437e993c68492fedaae4 to 4dcced610f404b31b3f3c8c2f9b4916d: event appeared (4dcced610f404b31b3f3c8c2f9b4916d, 13, SomeEvent @ <null>)
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage 538147f266f3437e993c68492fedaae4 SUBSCRIPTION DECISION DoNothing (StreamEventAppeared), 
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package WriteEventsCompleted, 6ddafe093259462792ef3cb92e08e9a9
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message StartOperationMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': StartOperation schedule AppendToStream, Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, 10, 7000
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': ExecuteOperation package WriteEvents, 3c2ca775e51b4b318aef106a12969216, Operation AppendToStream (3c2ca775e51b4b318aef106a12969216): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:56.168991Z, last updated: 2018-08-04T15:59:56.169016Z
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage OPERATION DECISION EndOperation (Success), Operation AppendToStream (6ddafe093259462792ef3cb92e08e9a9): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:56.108043Z, last updated: 2018-08-04T15:59:56.108065Z
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': RemoveOperation SUCCEEDED for Operation AppendToStream (6ddafe093259462792ef3cb92e08e9a9): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:56.108043Z, last updated: 2018-08-04T15:59:56.108065Z
[2018-08-04 15:59:56] event-store-client.DEBUG: Persistent Subscription to 4dcced610f404b31b3f3c8c2f9b4916d: processed event (4dcced610f404b31b3f3c8c2f9b4916d, 13, SomeEvent @ 13)
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package PersistentSubscriptionStreamEventAppeared, 538147f266f3437e993c68492fedaae4
[2018-08-04 15:59:56] event-store-client.DEBUG: Subscription 538147f266f3437e993c68492fedaae4 to 4dcced610f404b31b3f3c8c2f9b4916d: event appeared (4dcced610f404b31b3f3c8c2f9b4916d, 14, SomeEvent @ <null>)
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage 538147f266f3437e993c68492fedaae4 SUBSCRIPTION DECISION DoNothing (StreamEventAppeared), 
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package WriteEventsCompleted, 3c2ca775e51b4b318aef106a12969216
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message StartOperationMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': StartOperation schedule AppendToStream, Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, 10, 7000
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': ExecuteOperation package WriteEvents, 04dd7723f7e8446b989b8b3957bc601a, Operation AppendToStream (04dd7723f7e8446b989b8b3957bc601a): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:56.202029Z, last updated: 2018-08-04T15:59:56.202050Z
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage OPERATION DECISION EndOperation (Success), Operation AppendToStream (3c2ca775e51b4b318aef106a12969216): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:56.168991Z, last updated: 2018-08-04T15:59:56.169016Z
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': RemoveOperation SUCCEEDED for Operation AppendToStream (3c2ca775e51b4b318aef106a12969216): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:56.168991Z, last updated: 2018-08-04T15:59:56.169016Z
[2018-08-04 15:59:56] event-store-client.DEBUG: Persistent Subscription to 4dcced610f404b31b3f3c8c2f9b4916d: processed event (4dcced610f404b31b3f3c8c2f9b4916d, 14, SomeEvent @ 14)
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package PersistentSubscriptionStreamEventAppeared, 538147f266f3437e993c68492fedaae4
[2018-08-04 15:59:56] event-store-client.DEBUG: Subscription 538147f266f3437e993c68492fedaae4 to 4dcced610f404b31b3f3c8c2f9b4916d: event appeared (4dcced610f404b31b3f3c8c2f9b4916d, 15, SomeEvent @ <null>)
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage 538147f266f3437e993c68492fedaae4 SUBSCRIPTION DECISION DoNothing (StreamEventAppeared), 
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package WriteEventsCompleted, 04dd7723f7e8446b989b8b3957bc601a
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message StartOperationMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': StartOperation schedule AppendToStream, Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, 10, 7000
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': ExecuteOperation package WriteEvents, 03d681639b394856b9d5f87f530b2329, Operation AppendToStream (03d681639b394856b9d5f87f530b2329): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:56.227479Z, last updated: 2018-08-04T15:59:56.227500Z
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage OPERATION DECISION EndOperation (Success), Operation AppendToStream (04dd7723f7e8446b989b8b3957bc601a): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:56.202029Z, last updated: 2018-08-04T15:59:56.202050Z
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': RemoveOperation SUCCEEDED for Operation AppendToStream (04dd7723f7e8446b989b8b3957bc601a): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:56.202029Z, last updated: 2018-08-04T15:59:56.202050Z
[2018-08-04 15:59:56] event-store-client.DEBUG: Persistent Subscription to 4dcced610f404b31b3f3c8c2f9b4916d: processed event (4dcced610f404b31b3f3c8c2f9b4916d, 15, SomeEvent @ 15)
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package PersistentSubscriptionStreamEventAppeared, 538147f266f3437e993c68492fedaae4
[2018-08-04 15:59:56] event-store-client.DEBUG: Subscription 538147f266f3437e993c68492fedaae4 to 4dcced610f404b31b3f3c8c2f9b4916d: event appeared (4dcced610f404b31b3f3c8c2f9b4916d, 16, SomeEvent @ <null>)
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage 538147f266f3437e993c68492fedaae4 SUBSCRIPTION DECISION DoNothing (StreamEventAppeared), 
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package WriteEventsCompleted, 03d681639b394856b9d5f87f530b2329
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message StartOperationMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': StartOperation schedule AppendToStream, Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, 10, 7000
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': ExecuteOperation package WriteEvents, f7af05e258a24f92804ca66436620955, Operation AppendToStream (f7af05e258a24f92804ca66436620955): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:56.249646Z, last updated: 2018-08-04T15:59:56.249661Z
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage OPERATION DECISION EndOperation (Success), Operation AppendToStream (03d681639b394856b9d5f87f530b2329): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:56.227479Z, last updated: 2018-08-04T15:59:56.227500Z
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': RemoveOperation SUCCEEDED for Operation AppendToStream (03d681639b394856b9d5f87f530b2329): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:56.227479Z, last updated: 2018-08-04T15:59:56.227500Z
[2018-08-04 15:59:56] event-store-client.DEBUG: Persistent Subscription to 4dcced610f404b31b3f3c8c2f9b4916d: processed event (4dcced610f404b31b3f3c8c2f9b4916d, 16, SomeEvent @ 16)
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package PersistentSubscriptionStreamEventAppeared, 538147f266f3437e993c68492fedaae4
[2018-08-04 15:59:56] event-store-client.DEBUG: Subscription 538147f266f3437e993c68492fedaae4 to 4dcced610f404b31b3f3c8c2f9b4916d: event appeared (4dcced610f404b31b3f3c8c2f9b4916d, 17, SomeEvent @ <null>)
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage 538147f266f3437e993c68492fedaae4 SUBSCRIPTION DECISION DoNothing (StreamEventAppeared), 
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package WriteEventsCompleted, f7af05e258a24f92804ca66436620955
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message StartOperationMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': StartOperation schedule AppendToStream, Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, 10, 7000
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': ExecuteOperation package WriteEvents, 74902f7153854548bcc57e0a865873a7, Operation AppendToStream (74902f7153854548bcc57e0a865873a7): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:56.268324Z, last updated: 2018-08-04T15:59:56.268349Z
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage OPERATION DECISION EndOperation (Success), Operation AppendToStream (f7af05e258a24f92804ca66436620955): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:56.249646Z, last updated: 2018-08-04T15:59:56.249661Z
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': RemoveOperation SUCCEEDED for Operation AppendToStream (f7af05e258a24f92804ca66436620955): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:56.249646Z, last updated: 2018-08-04T15:59:56.249661Z
[2018-08-04 15:59:56] event-store-client.DEBUG: Persistent Subscription to 4dcced610f404b31b3f3c8c2f9b4916d: processed event (4dcced610f404b31b3f3c8c2f9b4916d, 17, SomeEvent @ 17)
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package PersistentSubscriptionStreamEventAppeared, 538147f266f3437e993c68492fedaae4
[2018-08-04 15:59:56] event-store-client.DEBUG: Subscription 538147f266f3437e993c68492fedaae4 to 4dcced610f404b31b3f3c8c2f9b4916d: event appeared (4dcced610f404b31b3f3c8c2f9b4916d, 18, SomeEvent @ <null>)
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage 538147f266f3437e993c68492fedaae4 SUBSCRIPTION DECISION DoNothing (StreamEventAppeared), 
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package WriteEventsCompleted, 74902f7153854548bcc57e0a865873a7
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message StartOperationMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': StartOperation schedule AppendToStream, Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, 10, 7000
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': ExecuteOperation package WriteEvents, 662499468f4444a0a2c233082cf6fb4c, Operation AppendToStream (662499468f4444a0a2c233082cf6fb4c): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:56.291632Z, last updated: 2018-08-04T15:59:56.291651Z
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage OPERATION DECISION EndOperation (Success), Operation AppendToStream (74902f7153854548bcc57e0a865873a7): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:56.268324Z, last updated: 2018-08-04T15:59:56.268349Z
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': RemoveOperation SUCCEEDED for Operation AppendToStream (74902f7153854548bcc57e0a865873a7): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:56.268324Z, last updated: 2018-08-04T15:59:56.268349Z
[2018-08-04 15:59:56] event-store-client.DEBUG: Persistent Subscription to 4dcced610f404b31b3f3c8c2f9b4916d: processed event (4dcced610f404b31b3f3c8c2f9b4916d, 18, SomeEvent @ 18)
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package PersistentSubscriptionStreamEventAppeared, 538147f266f3437e993c68492fedaae4
[2018-08-04 15:59:56] event-store-client.DEBUG: Subscription 538147f266f3437e993c68492fedaae4 to 4dcced610f404b31b3f3c8c2f9b4916d: event appeared (4dcced610f404b31b3f3c8c2f9b4916d, 19, SomeEvent @ <null>)
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage 538147f266f3437e993c68492fedaae4 SUBSCRIPTION DECISION DoNothing (StreamEventAppeared), 
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message HandleTcpPackageMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage connId 9ed1a9ac39ab458ea1a69b1ed1f7cafe, package WriteEventsCompleted, 662499468f4444a0a2c233082cf6fb4c
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': HandleTcpPackage OPERATION DECISION EndOperation (Success), Operation AppendToStream (662499468f4444a0a2c233082cf6fb4c): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:56.291632Z, last updated: 2018-08-04T15:59:56.291651Z
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': RemoveOperation SUCCEEDED for Operation AppendToStream (662499468f4444a0a2c233082cf6fb4c): Stream: 4dcced610f404b31b3f3c8c2f9b4916d, ExpectedVersion: -2, RequireMaster: yes, retry count: 0, created: 2018-08-04T15:59:56.291632Z, last updated: 2018-08-04T15:59:56.291651Z
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': enqueing message CloseConnectionMessage
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': CloseConnection, reason Connection close requested by client, exception <none>
[2018-08-04 15:59:56] event-store-client.DEBUG: Subscription 538147f266f3437e993c68492fedaae4 to 4dcced610f404b31b3f3c8c2f9b4916d: closing subscription, reason: ConnectionClosed, exception: Connection '894f667874174912bc1f24fb821a74e6' was closed...
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': CloseTcpConnection
[2018-08-04 15:59:56] event-store-client.DEBUG: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': IGNORED (state: Closed, internal conn.ID: {1:B}, conn.ID: 9ed1a9ac39ab458ea1a69b1ed1f7cafe): TCP connection to [9ed1a9ac39ab458ea1a69b1ed1f7cafe] closed
[2018-08-04 15:59:56] event-store-client.INFO: EventStoreNodeConnection '894f667874174912bc1f24fb821a74e6': Closed. Reason: Connection close requested by client
.                                                                   1 / 1 (100%)

Time: 676 ms, Memory: 10.00MB

OK (1 test, 1 assertion)

@jvdlaar
Copy link
Author

jvdlaar commented Aug 14, 2018

I've been testing for a week with buffersize 1 so haven't seen the error anymore. I'll try this again on our staging server to see if the same problem happens there as well.

@jvdlaar
Copy link
Author

jvdlaar commented Aug 15, 2018

Issue doesn't happen anymore on my side either... can't explain what solved it tho.

@jvdlaar jvdlaar closed this as completed Aug 15, 2018
@prolic
Copy link
Member

prolic commented Aug 15, 2018

Good to know :)

@prolic prolic mentioned this issue Nov 15, 2018
Closed
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
None yet
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
2 participants
@prolic @jvdlaar