error.txt

Projects ChangesAgents6Build Queue0
Andreas Öhlund  Administration
Run...
Actions 
Edit Configuration Settings  
NServiceBusNServiceBus.Gateway3.1 Test (.NET Framework on Windows)
#3.0.1-PullRequest0099.30 (28 Sep 18 11:20)
Overview

Changes

Tests

Build Log

Parameters

Dependencies

Artifacts

«  #3.0.1-PullRequest0099.30	 	All history	 	
Last recorded build

Result:	 Tests failed: 1, passed: 46	Agent:	agent-1 (Default pool)
Time:	28 Sep 18 11:20 - 11:22 (1m:31s)	Triggered by:	you on 28 Sep 18 11:20
Branch:	99
 1 test failed (no new)

NServiceBus.Gateway.AcceptanceTests.dll: NServiceBus.Gateway.AcceptanceTests (1)
When_doing_request_reply.Callback_should_be_fired 	
 	Current failure:	99	#3.0.1-PullRequest0099.30 	No changes 	28 Sep 18 11:20
	First failure: 	99	#3.0.1-PullRequest0099.30 	Changes (6) 	28 Sep 18 11:11
System.TimeoutException : Executing given and whens took longer than 60 seconds.
   at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw()
   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
   at NServiceBus.AcceptanceTesting.Support.ScenarioRunner.<PerformScenarios>d__2.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
   at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw()
   at NServiceBus.AcceptanceTesting.Support.ScenarioRunner.<PerformScenarios>d__2.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
   at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw()
   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
   at NServiceBus.AcceptanceTesting.Support.ScenarioRunner.<PerformTestRun>d__1.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
   at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw()
   at NServiceBus.AcceptanceTesting.ScenarioWithContext`1.<Run>d__2.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
   at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw()
   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
   at NServiceBus.Gateway.AcceptanceTests.When_doing_request_reply.<Callback_should_be_fired>d__0.MoveNext() in C:\BuildAgent\work\d85172e1f8c3a958\src\NServiceBus.Gateway.AcceptanceTests\When_doing_request_reply.cs:line 12
--- End of stack trace from previous location where exception was thrown ---
   at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw()
   at NUnit.Framework.Internal.AsyncInvocationRegion.AsyncTaskInvocationRegion.WaitForPendingOperationsToComplete(Object invocationResult)
   at NUnit.Framework.Internal.Commands.TestMethodCommand.RunAsyncTestMethod(TestExecutionContext context)
------- Stdout: -------
current context: NServiceBus.Gateway.AcceptanceTests.When_doing_request_reply+Context
Started test @ 09/28/2018 11:20:58
Stopping endpoint: DoingRequestReply.SiteA
Stopping endpoint: DoingRequestReply.SiteB
Endpoint: DoingRequestReply.SiteA stopped (00:00:00.0502539s)
Endpoint: DoingRequestReply.SiteB stopped (00:00:00.0503168s)
Finished test @ 09/28/2018 11:21:59
------------------------------------------------------
Test summary:


Using settings:


Endpoints:
     - DoingRequestReply.SiteA
     - DoingRequestReply.SiteB
Test failed: System.TimeoutException: Executing given and whens took longer than 60 seconds.
   at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw()
   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
   at NServiceBus.AcceptanceTesting.Support.ScenarioRunner.<PerformScenarios>d__2.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
   at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw()
   at NServiceBus.AcceptanceTesting.Support.ScenarioRunner.<PerformScenarios>d__2.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
   at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw()
   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
   at NServiceBus.AcceptanceTesting.Support.ScenarioRunner.<PerformTestRun>d__1.MoveNext()

Context:
GotCallback = False
Response = 0
TestRunId = 24320493-306f-4ad9-ae56-1ec895ea3954
EndpointsStarted = True
HasNativePubSubSupport = True
LogLevel = Debug
Total time for testrun: 00:01:00.7822326
Log entries (log level: Debug):
------------------------------------------------------
11:20:58 AM Debug DoingRequestReply.SiteA: Activating persistence 'InMemoryPersistence' to provide storage for 'NServiceBus.StorageType+GatewayDeduplication' storage.
11:20:58 AM Debug DoingRequestReply.SiteA: Initializing type: NServiceBus.Gateway.AcceptanceTests.When_doing_request_reply+MyRequest, NServiceBus.Gateway.AcceptanceTests, Version=3.0.0.0, Culture=neutral, PublicKeyToken=null
11:20:58 AM Debug DoingRequestReply.SiteA: Initializing type: NServiceBus.ScheduledTask, NServiceBus.Core, Version=7.0.0.0, Culture=neutral, PublicKeyToken=9fc386479f8a226c
11:20:58 AM Debug DoingRequestReply.SiteA: Number of messages found: 2
11:20:58 AM Debug DoingRequestReply.SiteA: Message definitions: 
NServiceBus.Gateway.AcceptanceTests.When_doing_request_reply+MyRequest
NServiceBus.ScheduledTask
11:20:58 AM Debug DoingRequestReply.SiteA: Looking for license in the following locations:
License not found in C:\BuildAgent\work\cd60bb7d67310454\a\src\NServiceBus.Gateway.AcceptanceTests\bin\Release\net452\license.xml
License not found in C:\Users\buildagent\AppData\Local\ParticularSoftware\license.xml
License not found in C:\ProgramData\ParticularSoftware\license.xml
License not found in HKEY_CURRENT_USER\SOFTWARE\ParticularSoftware
License not found in HKEY_LOCAL_MACHINE\SOFTWARE\ParticularSoftware
License not found in app config 'NServiceBus/License' setting
License file not found in path supplied by app config 'NServiceBus/LicensePath' setting. Value was ''
No valid license could be found. Falling back to trial license with start date '2016-10-05'.

11:20:58 AM Warn DoingRequestReply.SiteA: Trial for the Particular Service Platform has expired.
11:20:58 AM Warn DoingRequestReply.SiteA: To extend your trial license, visit: https://particular.net/license/nservicebus?v=7.1.1&t=0&p=windows
11:20:58 AM Debug DoingRequestReply.SiteA: Associated 'NServiceBus.ScheduledTask' message with 'NServiceBus.ScheduledTaskMessageHandler' handler.
11:20:59 AM Warn DoingRequestReply.SiteA: Failed to grant user 'EC2AMAZ-0UD17OD\buildagent' HttpListener permissions. Processing will continue.
Try running the following command from an admin console:
netsh http add urlacl url=http://localhost:25699/SiteA/ user="EC2AMAZ-0UD17OD\buildagent"

The error message from running the above command is:
Url reservation add failed, Error: 183
Cannot create a file when that file already exists.
11:20:59 AM Debug DoingRequestReply.SiteB: Activating persistence 'InMemoryPersistence' to provide storage for 'NServiceBus.StorageType+GatewayDeduplication' storage.
11:20:59 AM Debug DoingRequestReply.SiteB: Initializing type: NServiceBus.Gateway.AcceptanceTests.When_doing_request_reply+MyRequest, NServiceBus.Gateway.AcceptanceTests, Version=3.0.0.0, Culture=neutral, PublicKeyToken=null
11:20:59 AM Debug DoingRequestReply.SiteB: Initializing type: NServiceBus.ScheduledTask, NServiceBus.Core, Version=7.0.0.0, Culture=neutral, PublicKeyToken=9fc386479f8a226c
11:20:59 AM Debug DoingRequestReply.SiteB: Number of messages found: 2
11:20:59 AM Debug DoingRequestReply.SiteB: Message definitions: 
NServiceBus.Gateway.AcceptanceTests.When_doing_request_reply+MyRequest
NServiceBus.ScheduledTask
11:20:59 AM Debug DoingRequestReply.SiteB: Looking for license in the following locations:
License not found in C:\BuildAgent\work\cd60bb7d67310454\a\src\NServiceBus.Gateway.AcceptanceTests\bin\Release\net452\license.xml
License not found in C:\Users\buildagent\AppData\Local\ParticularSoftware\license.xml
License not found in C:\ProgramData\ParticularSoftware\license.xml
License not found in HKEY_CURRENT_USER\SOFTWARE\ParticularSoftware
License not found in HKEY_LOCAL_MACHINE\SOFTWARE\ParticularSoftware
License not found in app config 'NServiceBus/License' setting
License file not found in path supplied by app config 'NServiceBus/LicensePath' setting. Value was ''
No valid license could be found. Falling back to trial license with start date '2016-10-05'.

11:20:59 AM Warn DoingRequestReply.SiteB: Trial for the Particular Service Platform has expired.
11:20:59 AM Warn DoingRequestReply.SiteB: To extend your trial license, visit: https://particular.net/license/nservicebus?v=7.1.1&t=0&p=windows
11:20:59 AM Debug DoingRequestReply.SiteB: Associated 'NServiceBus.ScheduledTask' message with 'NServiceBus.ScheduledTaskMessageHandler' handler.
11:20:59 AM Debug DoingRequestReply.SiteB: Associated 'NServiceBus.Gateway.AcceptanceTests.When_doing_request_reply+MyRequest' message with 'NServiceBus.Gateway.AcceptanceTests.When_doing_request_reply+SiteB+MyRequestHandler' handler.
11:20:59 AM Warn DoingRequestReply.SiteB: Failed to grant user 'EC2AMAZ-0UD17OD\buildagent' HttpListener permissions. Processing will continue.
Try running the following command from an admin console:
netsh http add urlacl url=http://localhost:25699/SiteB/ user="EC2AMAZ-0UD17OD\buildagent"

The error message from running the above command is:
Url reservation add failed, Error: 183
Cannot create a file when that file already exists.
11:20:59 AM Info DoingRequestReply.SiteA: Receive channel started: http,http://localhost:25699/SiteA/MaxConcurrency=1Default=False
11:20:59 AM Debug DoingRequestReply.SiteA: Receiver Main is starting, listening to queue DoingRequestReply.SiteA.
11:20:59 AM Debug DoingRequestReply.SiteA: Receiver Main is starting, listening to queue DoingRequestReply.SiteA-1.
11:20:59 AM Debug DoingRequestReply.SiteA: Receiver Gateway is starting, listening to queue DoingRequestReply.SiteA-gateway.
11:20:59 AM Debug DoingRequestReply.SiteA: Started polling for new messages in c:\temp\callback-acpttests\1-1003\DoingRequestReply.SiteA
11:20:59 AM Debug DoingRequestReply.SiteA: Started polling for new messages in c:\temp\callback-acpttests\1-1003\DoingRequestReply.SiteA-1
11:20:59 AM Debug DoingRequestReply.SiteA: Started polling for new messages in c:\temp\callback-acpttests\1-1003\DoingRequestReply.SiteA-gateway
11:20:59 AM Info DoingRequestReply.SiteB: Receive channel started: http,http://localhost:25699/SiteB/MaxConcurrency=1Default=False
11:20:59 AM Debug DoingRequestReply.SiteB: Receiver Main is starting, listening to queue DoingRequestReply.SiteB.
11:20:59 AM Debug DoingRequestReply.SiteB: Receiver Gateway is starting, listening to queue DoingRequestReply.SiteB-gateway.
11:20:59 AM Debug DoingRequestReply.SiteB: Started polling for new messages in c:\temp\callback-acpttests\1-1003\DoingRequestReply.SiteB
11:20:59 AM Debug DoingRequestReply.SiteB: Started polling for new messages in c:\temp\callback-acpttests\1-1003\DoingRequestReply.SiteB-gateway
11:20:59 AM Debug DoingRequestReply.SiteA: Serializing message 'NServiceBus.Gateway.AcceptanceTests.When_doing_request_reply+MyRequest, NServiceBus.Gateway.AcceptanceTests, Version=3.0.0.0, Culture=neutral, PublicKeyToken=null' with id '8fd2f4fe-6f30-493d-9e59-a96900bb0a24', ToString() of the message yields: NServiceBus.Gateway.AcceptanceTests.When_doing_request_reply+MyRequest
11:20:59 AM Debug DoingRequestReply.SiteA: Destination: DoingRequestReply.SiteA-gateway
Message headers:
NServiceBus.DestinationSites : SiteB
NServiceBus.MessageId : 8fd2f4fe-6f30-493d-9e59-a96900bb0a24
NServiceBus.MessageIntent : Send
NServiceBus.ConversationId : c583e55d-f5f0-4028-ba3d-a96900bb0a27
NServiceBus.CorrelationId : 8fd2f4fe-6f30-493d-9e59-a96900bb0a24
NServiceBus.OriginatingMachine : EC2AMAZ-0UD17OD
NServiceBus.OriginatingEndpoint : DoingRequestReply.SiteA
$.diagnostics.originating.hostid : 24d38c8c55cc610dbe1bf1259416c22b
NServiceBus.ReplyToAddress : DoingRequestReply.SiteA-1
NServiceBus.ContentType : text/xml
NServiceBus.EnclosedMessageTypes : NServiceBus.Gateway.AcceptanceTests.When_doing_request_reply+MyRequest, NServiceBus.Gateway.AcceptanceTests, Version=3.0.0.0, Culture=neutral, PublicKeyToken=null
NServiceBus.Version : 7.1.1
NServiceBus.TimeSent : 2018-09-28 11:20:59:522468 Z

11:20:59 AM Debug DoingRequestReply.SiteA: Sending message - SingleCallSubmit to: http://localhost:25699/SiteB/
11:21:00 AM Warn DoingRequestReply.SiteA: Delayed Retry will reschedule message '8fd2f4fe-6f30-493d-9e59-a96900bb0a24' after a delay of 00:01:00 because of an exception: System.Net.WebException: The remote server returned an error: (503) Server Unavailable.
   at System.Net.HttpWebRequest.EndGetResponse(IAsyncResult asyncResult)
   at System.Threading.Tasks.TaskFactory`1.FromAsyncCoreLogic(IAsyncResult iar, Func`2 endFunction, Action`1 endAction, Task`1 promise, Boolean requiresSynchronization)
--- End of stack trace from previous location where exception was thrown ---
   at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw()
   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
   at NServiceBus.Gateway.Channels.Http.HttpChannelSender.<Send>d__0.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
   at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw()
   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
   at NServiceBus.Gateway.Sending.SingleCallChannelForwarder.<Transmit>d__3.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
   at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw()
   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
   at NServiceBus.Gateway.Sending.SingleCallChannelForwarder.<Forward>d__1.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
   at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw()
   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
   at NServiceBus.Gateway.Sending.GatewayMessageSender.<SendToSite>d__5.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
   at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw()
   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
   at NServiceBus.Gateway.Sending.GatewayMessageSender.<SendToDestination>d__1.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
   at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw()
   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
   at NServiceBus.LearningTransportMessagePump.<ProcessFile>d__9.MoveNext()
11:21:00 AM Debug DoingRequestReply.SiteA: Completing processing for c:\temp\callback-acpttests\1-1003\DoingRequestReply.SiteA-gateway\a0adc267-6a91-4d6a-abfd-5216f3118508.metadata.txt(c:\temp\callback-acpttests\1-1003\DoingRequestReply.SiteA-gateway\.pending\4fa097d2-7a96-423f-b150-76fdaff0e9fa\a0adc267-6a91-4d6a-abfd-5216f3118508.metadata.txt), exception (if any): 
11:21:59 AM Info DoingRequestReply.SiteA: Initiating shutdown.
11:21:59 AM Info DoingRequestReply.SiteB: Initiating shutdown.
11:21:59 AM Debug DoingRequestReply.SiteA: Stopping Main receiver
11:21:59 AM Debug DoingRequestReply.SiteB: Stopping Main receiver
11:21:59 AM Debug DoingRequestReply.SiteB: Stopped Main receiver
11:21:59 AM Debug DoingRequestReply.SiteB: Stopping Gateway receiver
11:21:59 AM Debug DoingRequestReply.SiteA: Stopped Main receiver
11:21:59 AM Debug DoingRequestReply.SiteA: Stopping Main receiver
11:21:59 AM Debug DoingRequestReply.SiteA: Stopped Main receiver
11:21:59 AM Debug DoingRequestReply.SiteA: Stopping Gateway receiver
11:21:59 AM Debug DoingRequestReply.SiteB: Stopped Gateway receiver
11:21:59 AM Debug DoingRequestReply.SiteA: Stopped Gateway receiver
11:21:59 AM Info DoingRequestReply.SiteB: Receiver is shutting down
11:21:59 AM Info DoingRequestReply.SiteA: Receiver is shutting down
11:21:59 AM Info DoingRequestReply.SiteA: Stopping channel - NServiceBus.Gateway.Channels.Http.HttpChannelReceiver
11:21:59 AM Info DoingRequestReply.SiteB: Stopping channel - NServiceBus.Gateway.Channels.Http.HttpChannelReceiver
11:21:59 AM Info DoingRequestReply.SiteA: Receiver shutdown complete
11:21:59 AM Info DoingRequestReply.SiteB: Receiver shutdown complete
11:21:59 AM Info DoingRequestReply.SiteA: Shutdown complete.
11:21:59 AM Info DoingRequestReply.SiteB: Shutdown complete.
« Hide stacktrace Copy to clipboard
 46 tests passed (all tests)

Snapshot dependencies (1 finished)
 Show projects hierarchy
… 1. Compile 	99	#3.0.1-PullRequest0099.30	 Success 	Artifacts 	Changes (6) 	28 Sep 18 11:10	33s
 Help  Feedback
TeamCity Enterprise 2017.2.4 (build 51228)
 New version is available!
License agreement