[
https://issues.apache.org/jira/browse/IGNITE-28345?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel
]
Pavel Tupitsyn updated IGNITE-28345:
------------------------------------
Fix Version/s: 3.2
> .NET: Unexpected notification ID received from the server
> ---------------------------------------------------------
>
> Key: IGNITE-28345
> URL: https://issues.apache.org/jira/browse/IGNITE-28345
> Project: Ignite
> Issue Type: Bug
> Components: platforms ai3, thin clients ai3
> Reporter: Pavel Tupitsyn
> Assignee: Pavel Tupitsyn
> Priority: Major
> Labels: MakeTeamcityGreenAgain, ignite-3
> Fix For: 3.2
>
> Time Spent: 10m
> Remaining Estimate: 0h
>
> https://ci.ignite.apache.org/buildConfiguration/ApacheIgnite3x_Test_PlatformTests_PlatformDotnetTestsWindows/10261039
> {code}
> Apache.Ignite.IgniteClientConnectionException : Unexpected notification ID
> (173) received from the server [remoteAddress=127.0.0.1:10943], closing the
> socket.
> at Apache.Ignite.Internal.ClientSocket.HandleNotification(Int64 requestId,
> Exception exception, PooledBuffer response) in
> C:\w\69bdbe372c424384\ignite-3\modules\platforms\dotnet\Apache.Ignite\Internal\ClientSocket.cs:line
> 985
> at Apache.Ignite.Internal.ClientSocket.HandleResponseInner(PooledBuffer
> response) in
> C:\w\69bdbe372c424384\ignite-3\modules\platforms\dotnet\Apache.Ignite\Internal\ClientSocket.cs:line
> 938
> at Apache.Ignite.Internal.ClientSocket.HandleResponse(PooledBuffer
> response) in
> C:\w\69bdbe372c424384\ignite-3\modules\platforms\dotnet\Apache.Ignite\Internal\ClientSocket.cs:line
> 878
> --- End of stack trace from previous location ---
> at Apache.Ignite.Internal.ClientSocket.DoOutInOpAsyncInternal(ClientOp
> clientOp, PooledArrayBuffer request, Boolean expectNotifications,
> CancellationToken cancellationToken) in
> C:\w\69bdbe372c424384\ignite-3\modules\platforms\dotnet\Apache.Ignite\Internal\ClientSocket.cs:line
> 710
> at Apache.Ignite.Internal.ClientSocket.DoOutInOpAsyncInternal(ClientOp
> clientOp, PooledArrayBuffer request, Boolean expectNotifications,
> CancellationToken cancellationToken) in
> C:\w\69bdbe372c424384\ignite-3\modules\platforms\dotnet\Apache.Ignite\Internal\ClientSocket.cs:line
> 713
> at
> Apache.Ignite.Internal.ClientFailoverSocket.<>c__32`1.<<DoOutInOpAndGetSocketAsync>b__32_1>d.MoveNext()
> in
> C:\w\69bdbe372c424384\ignite-3\modules\platforms\dotnet\Apache.Ignite\Internal\ClientFailoverSocket.cs:line
> 270
> --- End of stack trace from previous location ---
> at
> Apache.Ignite.Internal.ClientFailoverSocket.DoWithRetryAsync[T,TArg](TArg
> arg, Func`3 opFunc, Func`3 func, PreferredNode preferredNode, IRetryPolicy
> retryPolicyOverride) in
> C:\w\69bdbe372c424384\ignite-3\modules\platforms\dotnet\Apache.Ignite\Internal\ClientFailoverSocket.cs:line
> 312
> at
> Apache.Ignite.Internal.ClientFailoverSocket.DoOutInOpAndGetSocketAsync[TArg](ClientOp
> clientOp, Transaction tx, TArg arg, Func`3 requestWriter, PreferredNode
> preferredNode, IRetryPolicy retryPolicyOverride, Boolean expectNotifications,
> CancellationToken cancellationToken) in
> C:\w\69bdbe372c424384\ignite-3\modules\platforms\dotnet\Apache.Ignite\Internal\ClientFailoverSocket.cs:line
> 265
> at
> Apache.Ignite.Internal.ClientFailoverSocket.DoOutInOpAndGetSocketAsync(ClientOp
> clientOp, Transaction tx, PooledArrayBuffer request, PreferredNode
> preferredNode, IRetryPolicy retryPolicyOverride, Boolean expectNotifications,
> CancellationToken cancellationToken) in
> C:\w\69bdbe372c424384\ignite-3\modules\platforms\dotnet\Apache.Ignite\Internal\ClientFailoverSocket.cs:line
> 219
> at Apache.Ignite.Internal.ClientFailoverSocket.DoOutInOpAsync(ClientOp
> clientOp, PooledArrayBuffer request, PreferredNode preferredNode, Boolean
> expectNotifications, CancellationToken cancellationToken) in
> C:\w\69bdbe372c424384\ignite-3\modules\platforms\dotnet\Apache.Ignite\Internal\ClientFailoverSocket.cs:line
> 187
> at Apache.Ignite.Internal.IgniteClientInternal.GetClusterNodesAsync() in
> C:\w\69bdbe372c424384\ignite-3\modules\platforms\dotnet\Apache.Ignite\Internal\IgniteClientInternal.cs:line
> 86
> at Apache.Ignite.Tests.Compute.ComputeTests.GetNodeAsync(Int32 index) in
> C:\w\69bdbe372c424384\ignite-3\modules\platforms\dotnet\Apache.Ignite.Tests\Compute\ComputeTests.cs:line
> 1126
> at
> Apache.Ignite.Tests.Compute.ComputeTests.TestExecuteResultTypeMismatchThrowsInvalidCastException()
> in
> C:\w\69bdbe372c424384\ignite-3\modules\platforms\dotnet\Apache.Ignite.Tests\Compute\ComputeTests.cs:line
> 98
> at
> NUnit.Framework.Internal.TaskAwaitAdapter.GenericAdapter`1.BlockUntilCompleted()
> at
> NUnit.Framework.Internal.MessagePumpStrategy.NoMessagePumpStrategy.WaitForCompletion(AwaitAdapter
> awaiter)
> at NUnit.Framework.Internal.AsyncToSyncAdapter.Await(Func`1 invoke)
> at
> NUnit.Framework.Internal.Commands.TestMethodCommand.RunTestMethod(TestExecutionContext
> context)
> at
> NUnit.Framework.Internal.Commands.TestMethodCommand.Execute(TestExecutionContext
> context)
> at
> NUnit.Framework.Internal.Commands.BeforeAndAfterTestCommand.<>c__DisplayClass1_0.<Execute>b__0()
> at
> NUnit.Framework.Internal.Commands.DelegatingTestCommand.RunTestMethodInThreadAbortSafeZone(TestExecutionContext
> context, Action action)
> --- End of stack trace from previous location ---
> at
> Apache.Ignite.Internal.Compute.Compute.<>c__DisplayClass22_0`1.<<GetJobExecution>g__GetResult|1>d.MoveNext()
> in
> C:\w\69bdbe372c424384\ignite-3\modules\platforms\dotnet\Apache.Ignite\Internal\Compute\Compute.cs:line
> 371
> --- End of stack trace from previous location ---
> at
> Apache.Ignite.Internal.Compute.Compute.<>c__DisplayClass22_0`1.<<GetJobExecution>g__GetResult|1>d.MoveNext()
> in
> C:\w\69bdbe372c424384\ignite-3\modules\platforms\dotnet\Apache.Ignite\Internal\Compute\Compute.cs:line
> 382
> --- End of stack trace from previous location ---
> at Apache.Ignite.Internal.Compute.JobExecution`1.CacheStatusOnCompletion()
> in
> C:\w\69bdbe372c424384\ignite-3\modules\platforms\dotnet\Apache.Ignite\Internal\Compute\JobExecution.cs:line
> 94
> ------- Stdout: -------
> SetUp: TestExecuteResultTypeMismatchThrowsInvalidCastException
> [10:21:02] [trce] [Apache.Ignite.Internal.ClientSocket-154] Sending request
> [requestId=174, op=ClusterGetNodes, remoteAddress=127.0.0.1:10943]
> [10:21:02] [fail] [Apache.Ignite.Internal.ClientSocket-154] Unexpected
> notification ID (173) received from the server
> [remoteAddress=127.0.0.1:10943], closing the socket.
> [10:21:02] [warn] [Apache.Ignite.Internal.ClientSocket-154] Connection closed
> with error [remoteAddress=127.0.0.1:10943]: Unexpected notification ID (173)
> received from the server [remoteAddress=127.0.0.1:10943], closing the socket.
> (exception: Apache.Ignite.IgniteClientConnectionException: Unexpected
> notification ID (173) received from the server
> [remoteAddress=127.0.0.1:10943], closing the socket.
> at Apache.Ignite.Internal.ClientSocket.HandleNotification(Int64 requestId,
> Exception exception, PooledBuffer response) in
> C:\w\69bdbe372c424384\ignite-3\modules\platforms\dotnet\Apache.Ignite\Internal\ClientSocket.cs:line
> 985
> at Apache.Ignite.Internal.ClientSocket.HandleResponseInner(PooledBuffer
> response) in
> C:\w\69bdbe372c424384\ignite-3\modules\platforms\dotnet\Apache.Ignite\Internal\ClientSocket.cs:line
> 938
> at Apache.Ignite.Internal.ClientSocket.HandleResponse(PooledBuffer
> response) in
> C:\w\69bdbe372c424384\ignite-3\modules\platforms\dotnet\Apache.Ignite\Internal\ClientSocket.cs:line
> 878)
> [10:21:02] [dbug] [Apache.Ignite.Internal.ClientFailoverSocket] Not retrying
> operation [opCode=48, opType=ClusterGetNodes, attempt=0, lastError=Unexpected
> notification ID (173) received from the server
> [remoteAddress=127.0.0.1:10943], closing the socket.]
> TearDown start: TestExecuteResultTypeMismatchThrowsInvalidCastException
> TearDown end: TestExecuteResultTypeMismatchThrowsInvalidCastException
> {code}
> Another example, more clear, and the build did not fail:
> https://ci.ignite.apache.org/buildConfiguration/ApacheIgnite3x_Test_PlatformTests_PlatformDotnetTestsWindows/10293224?buildTab=log&focusLine=1666&logView=flowAware&linesState=795.801.1361.1665
> {code}
> SetUp: TestExecuteOnUnknownUnitWithLatestVersionThrows
> [01:13:30] [trce] [Apache.Ignite.Internal.ClientSocket-150] Sending
> request [requestId=157, op=ClusterGetNodes, remoteAddress=127.0.0.1:10942]
> [01:13:30] [trce] [Apache.Ignite.Internal.ClientSocket-150] Received
> response [requestId=157, op=ClusterGetNodes, flags=0,
> remoteAddress=127.0.0.1:10942, duration=00:00:00.0014856, observableTs=0]
> [01:13:30] [trce] [Apache.Ignite.Internal.ClientSocket-149] Sending
> request [requestId=172, op=ComputeExecute, remoteAddress=127.0.0.1:10943]
> [01:13:30] [trce] [Apache.Ignite.Internal.ClientFailoverSocket]
> ObservableTs updated [prev=116321131577933824, current=116321131579047936]
> [01:13:30] [trce] [Apache.Ignite.Internal.ClientSocket-149] Received
> response [requestId=172, op=ComputeExecute, flags=Error,
> remoteAddress=127.0.0.1:10943, duration=00:00:00.0167866,
> observableTs=116321131579047936]
> [01:13:30] [trce] [Apache.Ignite.Internal.ClientSocket-149] Received
> response [requestId=172, op=None, flags=Notification, Error,
> remoteAddress=127.0.0.1:10943, duration=(null),
> observableTs=116321131578982400]
> [01:13:30] [dbug] [Apache.Ignite.Internal.ClientFailoverSocket] Not
> retrying operation [opCode=47, opType=ComputeExecute, attempt=0,
> lastError=Job execution failed: java.lang.ClassNotFoundException:
> org.apache.ignite.internal.runner.app.Jobs$NodeNameJob. Deployment unit
> unit-latest:latest doesn't exist]
> TearDown start: TestExecuteOnUnknownUnitWithLatestVersionThrows
> [01:13:30] [fail] [Apache.Ignite.Internal.ClientSocket-149]
> Unexpected notification ID (172) received from the server
> [remoteAddress=127.0.0.1:10943], closing the socket.
> [01:13:30] [warn] [Apache.Ignite.Internal.ClientSocket-149]
> Connection closed with error [remoteAddress=127.0.0.1:10943]: Unexpected
> notification ID (172) received from the server
> [remoteAddress=127.0.0.1:10943], closing the socket. (exception:
> Apache.Ignite.IgniteClientConnectionException: Unexpected notification ID
> (172) received from the server [remoteAddress=127.0.0.1:10943], closing the
> socket.
> at Apache.Ignite.Internal.ClientSocket.HandleNotification(Int64
> requestId, Exception exception, PooledBuffer response) in
> C:\w\69bdbe372c424384\ignite-3\modules\platforms\dotnet\Apache.Ignite\Internal\ClientSocket.cs:line
> 1020
> at
> Apache.Ignite.Internal.ClientSocket.HandleResponseInner(PooledBuffer
> response) in
> C:\w\69bdbe372c424384\ignite-3\modules\platforms\dotnet\Apache.Ignite\Internal\ClientSocket.cs:line
> 973
> at Apache.Ignite.Internal.ClientSocket.HandleResponse(PooledBuffer
> response) in
> C:\w\69bdbe372c424384\ignite-3\modules\platforms\dotnet\Apache.Ignite\Internal\ClientSocket.cs:line
> 913)
> TearDown end: TestExecuteOnUnknownUnitWithLatestVersionThrows
> {code}
> * We've got an error both from the response and as a notification.
> * The notification arrived after the response, and the notification handler
> was removed?
> * *TestExecuteOnUnknownUnitWithLatestVersionThrows* shows that we always get
> both response and notification, but in undefined order?
--
This message was sent by Atlassian Jira
(v8.20.10#820010)
