Skip to content

Instantly share code, notes, and snippets.

@dsarfati
Created April 25, 2016 23:02
Show Gist options
  • Save dsarfati/5bf0d92669f1d7eb0fc698fe579935b3 to your computer and use it in GitHub Desktop.
Save dsarfati/5bf0d92669f1d7eb0fc698fe579935b3 to your computer and use it in GitHub Desktop.
Orleans SQL Membership Table Errors
[2016-04-25 22:57:45.387 GMT 1 INFO 100404 Silo 169.254.22.7:0] Silo starting with GC settings: ServerGC=False GCLatencyMode=Interactive
[2016-04-25 22:57:45.391 GMT 1 WARNING 100405 Silo 169.254.22.7:0] Note: Silo not running with ServerGC turned on or with GCLatencyMode.Batch enabled - recommend checking app config : <configuration>-<runtime>-<gcServer enabled="true"> and <configuration>-<runtime>-<gcConcurrent enabled="false"/>
[2016-04-25 22:57:45.391 GMT 1 WARNING 100405 Silo 169.254.22.7:0] Note: ServerGC only kicks in on multi-core systems (settings enabling ServerGC have no effect on single-core machines).
[2016-04-25 22:57:45.392 GMT 1 INFO 100403 Silo 169.254.22.7:0] -------------- Initializing Secondary silo on host DRACOCLUSTER-1 MachineName DRACOCLUSTER-1 at 169.254.22.7:0, gen 199321065 --------------
[2016-04-25 22:57:45.425 GMT 1 INFO 100415 Silo 169.254.22.7:0] Starting silo DRACOCLUSTER-1 with runtime Version='1.2.0.0 (Release).' .NET version='4.0.30319.42000' Is .NET 4.5=True OS version='Microsoft Windows NT 6.2.9200.0' Config=
Config File Name: C:\Users\amc-admin\Desktop\Debug\OrleansConfiguration.xml
Host: DRACOCLUSTER-1
Start time: 2016-04-25 22:57:45.394 GMT
Primary node: null
Platform version info:
.NET version: 4.0.30319.42000
Is .NET 4.5=True
OS version: Microsoft Windows NT 6.2.9200.0
GC Type=Client GCLatencyMode=Interactive
Global configuration:
System Ids:
ServiceId: 00000000-0000-0000-0000-000000000000
DeploymentId: DracoSilo
Subnet:
Seed nodes:
Messaging:
Response timeout: 00:00:30
Maximum resend count: 0
Resend On Timeout: False
Maximum Socket Age: 10675199.02:48:05.4775807
Drop Expired Messages: True
Silo Sender queues: 1
Gateway Sender queues: 1
Client Drop Timeout: 00:01:00
Use standard (.NET) serializer: False
Use fallback json serializer: False
Buffer Pool Buffer Size: 4096
Buffer Pool Max Size: 10000
Buffer Pool Preallocation Size: 250
Use Message Batching: False
Max Message Batching Size: 10
Maximum forward count: 2
Liveness:
LivenessEnabled: True
LivenessType: SqlServer
ProbeTimeout: 00:00:10
TableRefreshTimeout: 00:01:00
DeathVoteExpirationTimeout: 00:02:00
NumMissedProbesLimit: 3
NumProbedSilos: 3
NumVotesForDeathDeclaration: 2
UseLivenessGossip: True
IAmAliveTablePublishTimeout: 00:05:00
NumMissedTableIAmAliveLimit: 2
MaxJoinAttemptTime: 00:05:00
ExpectedClusterSize: 20
SystemStore:
SystemStore ConnectionString: Data Source=DRACODB;Initial Catalog=Draco;Integrated Security=True;Pooling=False;Max Pool Size=200;Asynchronous Processing=True;MultipleActiveResultSets=True
Reminders ConnectionString: Data Source=DRACODB;Initial Catalog=Draco;Integrated Security=True;Pooling=False;Max Pool Size=200;Asynchronous Processing=True;MultipleActiveResultSets=True
Application:
Defaults:
Deactivate if idle for: 02:00:00
PlacementStrategy:
Default Placement Strategy: RandomPlacement
Deployment Load Publisher Refresh Time: 00:00:01
Activation CountBased Placement Choose Out Of: 2
Grain directory cache:
Maximum size: 1000000 grains
Initial TTL: 00:00:30
Maximum TTL: 00:04:00
TTL extension factor: 2.00
Directory Caching Strategy: Adaptive
Grain directory:
Lazy deregistration delay: 00:01:00
Client registration refresh: 00:05:00
Reminder Service:
ReminderServiceType: SqlServer
Consistent Ring:
Use Virtual Buckets Consistent Ring: True
Num Virtual Buckets Consistent Ring: 30
Providers:
StorageProviders:
Name=PubSubStore, Type=Orleans.Storage.MemoryStorage, Properties=[NumStorageGrains]
Name=Default, Type=Orleans.Storage.MemoryStorage, Properties=[]
StreamProviders:
Name=Default, Type=Orleans.Providers.Streams.SimpleMessageStream.SimpleMessageStreamProvider, Properties=[FireAndForgetDelivery]
Silo configuration:
Silo Name: DRACOCLUSTER-1
Generation: 199321065
Host Name or IP Address:
DNS Host Name: DRACOCLUSTER-1
Port: 0
Subnet:
Preferred Address Family: InterNetwork
IsGatewayNode: False
IsPrimaryNode: False
Scheduler:
Max Active Threads: 4
Processor Count: 1
Delay Warning Threshold: 00:00:10
Activation Scheduling Quantum: 00:00:00.1000000
Turn Warning Length Threshold: 00:00:00.2000000
Inject More Worker Threads: False
MinDotNetThreadPoolSize: 200
.NET thread pool sizes - Min: Worker Threads=1 Completion Port Threads=1
.NET thread pool sizes - Max: Worker Threads=32767 Completion Port Threads=1000
.NET ServicePointManager - DefaultConnectionLimit=200 Expect100Continue=False UseNagleAlgorithm=False
Load Shedding Enabled: False
Load Shedding Limit: 95
SiloShutdownEventName:
Debug:
Tracing:
Default Trace Level: Info
TraceLevelOverrides: None
Trace to Console: True
Trace File Name: C:\Users\amc-admin\Desktop\Debug\DRACOCLUSTER-1-2016-04-25-22.57.44.774Z.log
LargeMessageWarningThreshold: 85000
PropagateActivityId: False
BulkMessageLimit: 1000
Statistics:
MetricsTableWriteInterval: 00:00:30
PerfCounterWriteInterval: 00:00:30
LogWriteInterval: 00:05:00
WriteLogStatisticsToTable: True
StatisticsCollectionLevel: Info
[2016-04-25 22:57:45.501 GMT 1 INFO 100445 Silo 169.254.22.7:0] Successfully loaded Orleans.Runtime.Startup.ConfigureStartupBuilder from OrleansDependencyInjection.dll
[2016-04-25 22:57:45.541 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] Searching for assemblies in C:\Users\amc-admin\Desktop\Debug...
[2016-04-25 22:57:45.573 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\DracoInterfaces.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:57:45.576 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\DracoModels.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:57:45.579 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\DracoUtils.dll
* Grain type Draco.Utility.DracoGrain is abstract and cannot be instantiated.
* Grain type Draco.Utility.DracoGrain`1 is abstract and cannot be instantiated.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:57:45.601 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\Microsoft.Azure.SqlDatabase.ElasticScale.Client.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:57:45.838 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\Microsoft.CodeAnalysis.CSharp.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:57:45.951 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\Microsoft.CodeAnalysis.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:57:45.958 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\Microsoft.Extensions.DependencyInjection.Abstractions.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:57:45.962 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\Microsoft.Extensions.DependencyInjection.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:57:45.966 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\Microsoft.Practices.EnterpriseLibrary.TransientFaultHandling.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:57:45.997 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\MongoDB.Bson.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:57:46.039 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\MongoDB.Driver.Core.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:57:46.094 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\MongoDB.Driver.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:57:46.115 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\Newtonsoft.Json.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:57:46.117 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\Orleans.dll
* Assembly filename is excluded.
[2016-04-25 22:57:46.120 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\OrleansCodeGenerator.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:57:46.123 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\OrleansDependencyInjection.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:57:46.128 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\OrleansRuntime.dll
* Assembly filename is excluded.
[2016-04-25 22:57:46.150 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\System.Collections.Immutable.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:57:46.160 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\System.Reactive.Core.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:57:46.163 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\System.Reactive.Interfaces.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:57:46.269 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\System.Reactive.Linq.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:57:46.289 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\System.Reflection.Metadata.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:57:46.300 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\System.Threading.Tasks.Dataflow.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:57:46.305 GMT 1 WARNING 101705 AssemblyLoader.Silo 169.254.22.7:0] Unable to find directory C:\Users\amc-admin\Desktop\Debug\Applications; skipping.
[2016-04-25 22:57:46.306 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] Loading assembly C:\Users\amc-admin\Desktop\Debug\DracoFoundation.dll...
[2016-04-25 22:57:47.248 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] Loading assembly C:\Users\amc-admin\Desktop\Debug\OrleansProviders.dll...
[2016-04-25 22:57:47.278 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] Loading assembly C:\Users\amc-admin\Desktop\Debug\OrleansSQLUtils.dll...
[2016-04-25 22:57:47.315 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] Loading assembly C:\Users\amc-admin\Desktop\Debug\TestDriver.dll...
[2016-04-25 22:57:47.388 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] Loading assembly C:\Users\amc-admin\Desktop\Debug\VSMConnection.dll...
[2016-04-25 22:57:47.393 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] 5 assemblies loaded.
[2016-04-25 22:57:47.574 GMT 1 INFO 100000 Scheduler.OrleansTaskScheduler 169.254.22.7:0] Starting OrleansTaskScheduler with 4 Max Active application Threads and 1 system thread.
[2016-04-25 22:57:47.586 GMT 1 INFO 101010 Runtime.Messaging.IncomingMessageAcceptor 169.254.22.7:0] Opened a listening socket at address 169.254.22.7:51998
[2016-04-25 22:57:47.624 GMT 1 INFO 100000 VirtualBucketsRingProvider 169.254.22.7:0] Starting VirtualBucketsRingProvider on silo S169.254.22.7:51998:199321065/x499BF77F.
[2016-04-25 22:57:47.669 GMT 1 INFO 103003 VirtualBucketsRingProvider 169.254.22.7:0] Added Server S169.254.22.7:51998:199321065/x499BF77F. Current view: [S169.254.22.7:51998:199321065 -> <MultiRange: Size=x100000000, %Ring=100.000%>]
[2016-04-25 22:57:47.673 GMT 1 INFO 103005 VirtualBucketsRingProvider 169.254.22.7:0] -NotifyLocalRangeSubscribers about old <(0 0], Size=x100000000, %Ring=100.000%> new <MultiRange: Size=x100000000, %Ring=100.000%> increased? True
[2016-04-25 22:57:47.714 GMT 1 INFO 100294 SystemStatus 169.254.22.7:0] SystemStatus=Created
[2016-04-25 22:57:47.716 GMT 1 INFO 100422 Silo 169.254.22.7:0] -------------- Started silo S169.254.22.7:51998:199321065, ConsistentHashCode 499BF77F --------------
[2016-04-25 22:57:47.719 GMT 1 INFO 100441 OrleansSiloHost 169.254.22.7:0] Silo shutdown event name: DRACOCLUSTER-1-Shutdown
[2016-04-25 22:57:47.720 GMT 1 INFO 100442 OrleansSiloHost 169.254.22.7:0] Created and set shutdown event DRACOCLUSTER-1-Shutdown
[2016-04-25 22:57:47.731 GMT 1 INFO 100294 SystemStatus 169.254.22.7:0] SystemStatus=Starting
[2016-04-25 22:57:47.732 GMT 1 INFO 100401 Silo 169.254.22.7:0] Silo Start()
[2016-04-25 22:57:47.734 GMT 1 INFO 100430 Silo 169.254.22.7:0] Configured ThreadPool.SetMinThreads() to values: 200,200. Previous values are: 1,1.
[2016-04-25 22:57:47.736 GMT 1 INFO 100436 Silo 169.254.22.7:0] Configured .NET ServicePointManager to Expect100Continue=False, DefaultConnectionLimit=200, UseNagleAlgorithm=False to improve Azure storage performance.
[2016-04-25 22:57:47.789 GMT 1 INFO 101711 AssemblyLoader.Silo 169.254.22.7:0] Loaded grain type summary for 11 types:
Grain class Draco.Foundation.Draco.Foundation.VehicleGrain [-882752399 (0xCB624471)] from DracoFoundation.dll implementing interfaces: Draco.Interfaces.Draco.Interfaces.IVehicleGrain [-186200810 (0xF4E6CD16)]
Grain class Draco.Foundation.Draco.Foundation.VehicleManager [892960422 (0x35397EA6)] from DracoFoundation.dll implementing interfaces: Draco.Interfaces.Draco.Interfaces.IVehicleManager [9765603 (0x9502E3)], Draco.Utility.Draco.Utility.IGrainWithSingletonKey [-854559413 (0xCD10754B)]
Grain class Draco.Foundation.Draco.Foundation.VehicleTypeManager [-1451282848 (0xA97F2E60)] from DracoFoundation.dll implementing interfaces: Draco.Interfaces.Draco.Interfaces.IVehicleTypeManager [868096219 (0x33BE18DB)], Draco.Utility.Draco.Utility.IGrainWithSingletonKey [-854559413 (0xCD10754B)]
Grain class Draco.VSMConnection.Draco.VSMConnection.VSMDiscovery [-349437437 (0xEB2C0203)] from VSMConnection.dll implementing interfaces: Draco.VSMConnection.Draco.VSMConnection.IVSMDiscovery [-1019522468 (0xC33B525C)], Draco.Utility.Draco.Utility.IGrainWithSingletonKey [-854559413 (0xCD10754B)], Orleans.Orleans.IRemindable [-831689659 (0xCE6D6C45)]
Grain class Draco.VSMConnection.Draco.VSMConnection.VSMManager [-1479894192 (0xA7CA9B50)] from VSMConnection.dll implementing interfaces: Draco.Interfaces.Draco.Interfaces.IVSMManager [196364016 (0xBB446F0)]
Grain class Orleans.Runtime.Management.Orleans.Runtime.Management.ManagementGrain [1954798034 (0x7483D9D2)] from OrleansRuntime.dll implementing interfaces: Orleans.Runtime.Orleans.Runtime.IManagementGrain [-1734666656 (0x989B1660)]
Grain class Orleans.Runtime.MembershipService.Orleans.Runtime.MembershipService.GrainBasedMembershipTable [-2103923544 (0x8298ACA8)] from OrleansRuntime.dll implementing interfaces: Orleans.Orleans.IMembershipTableGrain [-1256503757 (0xB51B4633)]
Grain class Orleans.Runtime.ReminderService.Orleans.Runtime.ReminderService.GrainBasedReminderTable [-55315191 (0xFCB3F509)] from OrleansRuntime.dll implementing interfaces: Orleans.Orleans.IReminderTableGrain [-1135060418 (0xBC585A3E)]
Grain class Orleans.Storage.Orleans.Storage.MemoryStorageGrain [819348208 (0x30D642F0)] from OrleansRuntime.dll implementing interfaces: Orleans.Storage.Orleans.Storage.IMemoryStorageGrain [577125491 (0x22663C73)]
Grain class Orleans.Streams.Orleans.Streams.PubSubRendezvousGrain [1903070868 (0x716E8E94)] from OrleansRuntime.dll implementing interfaces: Orleans.Streams.Orleans.Streams.IPubSubRendezvousGrain [1746702088 (0x681C8F08)]
Grain class TestDriver.TestDriver.LoadTestGrain [456827097 (0x1B3AA0D9)] from TestDriver.dll implementing interfaces: TestDriver.TestDriver.ILoadTestGrain [-1097320062 (0xBE983982)], Draco.Utility.Draco.Utility.IGrainWithSingletonKey [-854559413 (0xCD10754B)]
[2016-04-25 22:57:47.829 GMT 10 INFO 100000 Runtime.Scheduler.WorkerPoolThread/System.5 169.254.22.7:0] Starting AsyncAgent Runtime.Scheduler.WorkerPoolThread/System.5 on managed thread 10
[2016-04-25 22:57:47.835 GMT 6 INFO 100000 Runtime.Scheduler.WorkerPoolThread/0 169.254.22.7:0] Starting AsyncAgent Runtime.Scheduler.WorkerPoolThread/0 on managed thread 6
[2016-04-25 22:57:47.835 GMT 7 INFO 100000 Runtime.Scheduler.WorkerPoolThread/1 169.254.22.7:0] Starting AsyncAgent Runtime.Scheduler.WorkerPoolThread/1 on managed thread 7
[2016-04-25 22:57:47.839 GMT 8 INFO 100000 Runtime.Scheduler.WorkerPoolThread/2 169.254.22.7:0] Starting AsyncAgent Runtime.Scheduler.WorkerPoolThread/2 on managed thread 8
[2016-04-25 22:57:47.842 GMT 9 INFO 100000 Runtime.Scheduler.WorkerPoolThread/3 169.254.22.7:0] Starting AsyncAgent Runtime.Scheduler.WorkerPoolThread/3 on managed thread 9
[2016-04-25 22:57:47.842 GMT 11 INFO 100000 Runtime.Messaging.IncomingMessageAcceptor 169.254.22.7:0] Starting AsyncAgent Runtime.Messaging.IncomingMessageAcceptor on managed thread 11
[2016-04-25 22:57:47.843 GMT 12 INFO 100000 Runtime.Messaging.SiloMessageSender/PingSender 169.254.22.7:0] Starting AsyncAgent Runtime.Messaging.SiloMessageSender/PingSender on managed thread 12
[2016-04-25 22:57:47.843 GMT 13 INFO 100000 Runtime.Messaging.SiloMessageSender/SystemSender 169.254.22.7:0] Starting AsyncAgent Runtime.Messaging.SiloMessageSender/SystemSender on managed thread 13
[2016-04-25 22:57:47.844 GMT 16 INFO 100000 Runtime.Messaging.IncomingMessageAgent/Ping 169.254.22.7:0] Starting AsyncAgent Runtime.Messaging.IncomingMessageAgent/Ping on managed thread 16
[2016-04-25 22:57:47.844 GMT 15 INFO 100000 Runtime.Messaging.IncomingMessageAgent/System 169.254.22.7:0] Starting AsyncAgent Runtime.Messaging.IncomingMessageAgent/System on managed thread 15
[2016-04-25 22:57:47.844 GMT 17 INFO 100000 Runtime.Messaging.IncomingMessageAgent/Application 169.254.22.7:0] Starting AsyncAgent Runtime.Messaging.IncomingMessageAgent/Application on managed thread 17
[2016-04-25 22:57:47.845 GMT 14 INFO 100000 Runtime.GrainDirectory.AdaptiveDirectoryCacheMaintainer`1 169.254.22.7:0] Starting AsyncAgent Runtime.GrainDirectory.AdaptiveDirectoryCacheMaintainer`1 on managed thread 14
[2016-04-25 22:57:47.860 GMT 1 INFO 100000 MembershipFactory 169.254.22.7:0] Creating membership oracle for type=SqlServer
[2016-04-25 22:57:47.882 GMT 11 INFO 100328 Runtime.Messaging.IncomingMessageAcceptor 169.254.22.7:0] Stopping AsyncAgent Runtime.Messaging.IncomingMessageAcceptor that runs on managed thread 11
[2016-04-25 22:57:47.901 GMT 1 INFO 100000 ReminderFactory 169.254.22.7:0] Creating reminder system target for type=SqlServer
[2016-04-25 22:57:47.950 GMT 10 INFO 100507 Catalog 169.254.22.7:0] Before collection#1: memory=17MB, #activations=0, collector=<#Activations=0, #Buckets=0, buckets=[]>.
[2016-04-25 22:57:47.963 GMT 9 INFO 103102 ProviderLoader/IStorageProvider 169.254.22.7:0] Loaded provider of type Orleans.Storage.MemoryStorage Name=PubSubStore
[2016-04-25 22:57:47.964 GMT 9 INFO 103102 ProviderLoader/IStorageProvider 169.254.22.7:0] Loaded provider of type Orleans.Storage.MemoryStorage Name=Default
[2016-04-25 22:57:47.976 GMT 9 INFO 0 Storage.MemoryStorage.1 169.254.22.7:0] Init: Name=PubSubStore NumStorageGrains=1
[2016-04-25 22:57:47.979 GMT 9 INFO 0 Storage.MemoryStorage.2 169.254.22.7:0] Init: Name=Default NumStorageGrains=10
[2016-04-25 22:57:47.984 GMT 9 INFO 103102 ProviderLoader/IStreamProviderImpl 169.254.22.7:0] Loaded provider of type Orleans.Providers.Streams.SimpleMessageStream.SimpleMessageStreamProvider Name=Default
[2016-04-25 22:57:47.991 GMT 9 INFO 0 SimpleMessageStreamProvider 169.254.22.7:0] Initialized SimpleMessageStreamProvider with name Default and with property FireAndForgetDelivery: False, OptimizeForImmutableData: True and PubSubType: ExplicitGrainBasedAndImplicit
[2016-04-25 22:57:48.051 GMT 10 INFO 100508 Catalog 169.254.22.7:0] After collection#1: memory=19MB, #activations=0, collected 0 activations, collector=<#Activations=0, #Buckets=0, buckets=[]>, collection time=00:00:00.1067990.
[2016-04-25 22:57:48.172 GMT 10 INFO 100603 MembershipOracle 169.254.22.7:0] MembershipOracle starting on host = DRACOCLUSTER-1 address = S169.254.22.7:51998:199321065 at 2016-04-25 22:57:47.888 GMT, backOffMax = 00:00:20
[2016-04-25 22:57:56.415 GMT 10 INFO 100652 MembershipOracle 169.254.22.7:0] -CleanupTable called on silo startup. Membership table 1 silos, 0 are Active, 1 are Dead, Version=<69, 69>. All silos: [SiloAddress=S169.254.22.7:51954:199320984 InstanceName= Status=Dead]
[2016-04-25 22:57:56.530 GMT 10 INFO 100660 MembershipOracle 169.254.22.7:0] Starting IAmAliveUpdateTimer.
[2016-04-25 22:57:56.561 GMT 10 WARNING 101215 Scheduler.MembershipOracle.WorkItemGroup 169.254.22.7:0] Task [Id=302, Status=RanToCompletion] in WorkGroup [SystemTarget: S169.254.22.7:51998:199321065MembershipOracle@S0000000f] took elapsed time 0:00:00.237973 for execution, which is longer than 00:00:00.2000000. Running on thread <Runtime.Scheduler.WorkerPoolThread/System.5, ManagedThreadId=10, Executing Task Id=302 Status=RanToCompletion for 00:00:00.2425265 on WorkItem=System*WorkItemGroup:Name=MembershipOracle,WorkGroupStatus=Running Executing for 00:00:00.2425265. .>
[2016-04-25 22:57:56.599 GMT 10 INFO 100604 MembershipOracle 169.254.22.7:0] -BecomeActive
[2016-04-25 22:57:56.615 GMT 10 INFO 100614 MembershipOracle 169.254.22.7:0] About to send pings to 0 nodes in order to validate communication in the Joining state. Pinged nodes = []
[2016-04-25 22:57:56.677 GMT 10 INFO 100634 MembershipOracle 169.254.22.7:0] -ReadAll (called from BecomeActive) Membership table 2 silos, 1 are Active, 1 are Dead, Version=<71, 71>. All silos: [SiloAddress=S169.254.22.7:51998:199321065 InstanceName= Status=Active, SiloAddress=S169.254.22.7:51954:199320984 InstanceName= Status=Dead]
[2016-04-25 22:57:56.677 GMT 10 INFO 100605 MembershipOracle 169.254.22.7:0] -Finished BecomeActive.
[2016-04-25 22:57:56.677 GMT 1 INFO 100702 WindowsPerfCountersStatistics 169.254.22.7:0] Starting Windows perf counter stats collection with frequency=00:00:30
[2016-04-25 22:57:56.696 GMT 1 WARNING 100701 WindowsPerfCountersStatistics 169.254.22.7:0] Windows perf counters not found -- defaulting to in-memory counters. Run OrleansCounterControl.exe as Administrator to create perf counters for Orleans.
[2016-04-25 22:57:56.699 GMT 1 INFO 100714 SiloPerformanceMetrics 169.254.22.7:0] Starting Silo Table metrics reporter with reportFrequency=00:00:30
[2016-04-25 22:57:56.715 GMT 10 INFO 100000 DeploymentLoadPublisher 169.254.22.7:0] Starting DeploymentLoadPublisher.
[2016-04-25 22:57:56.861 GMT 6 INFO 100000 DeploymentLoadPublisher 169.254.22.7:0] Started DeploymentLoadPublisher.
[2016-04-25 22:57:56.864 GMT 1 INFO 100000 Watchdog 169.254.22.7:0] Starting Silo Watchdog.
[2016-04-25 22:57:56.867 GMT 31 INFO 100000 Runtime.Watchdog 169.254.22.7:0] Starting AsyncAgent Runtime.Watchdog on managed thread 31
[2016-04-25 22:57:56.870 GMT 10 INFO 102925 ReminderService 169.254.22.7:0] Starting reminder system target on: S169.254.22.7:51998:199321065 x499BF77F, with range <MultiRange: Size=x100000000, %Ring=100.000%>
[2016-04-25 22:57:57.498 GMT 10 INFO 102926 ReminderService 169.254.22.7:0] Reminder system target started OK on: S169.254.22.7:51998:199321065 x499BF77F, with range <MultiRange: Size=x100000000, %Ring=100.000%>
[2016-04-25 22:57:57.498 GMT 10 WARNING 101215 Scheduler.ReminderService.WorkItemGroup 169.254.22.7:0] Task [Id=904, Status=RanToCompletion] in WorkGroup [SystemTarget: S169.254.22.7:51998:199321065ReminderService@S00000010] took elapsed time 0:00:00.643133 for execution, which is longer than 00:00:00.2000000. Running on thread <Runtime.Scheduler.WorkerPoolThread/System.5, ManagedThreadId=10, Executing Task Id=904 Status=RanToCompletion for 00:00:00.6311588 on WorkItem=System*WorkItemGroup:Name=ReminderService,WorkGroupStatus=Running Executing for 00:00:00.6311588. .>
[2016-04-25 22:57:57.520 GMT 1 INFO 100294 SystemStatus 169.254.22.7:0] SystemStatus=Running
[2016-04-25 22:57:57.520 GMT 1 INFO 100424 OrleansSiloHost 169.254.22.7:0] Silo startup event name: DRACOCLUSTER-1
[2016-04-25 22:56:24.739 GMT 1 INFO 100404 Silo 169.254.22.7:0] Silo starting with GC settings: ServerGC=False GCLatencyMode=Interactive
[2016-04-25 22:56:24.745 GMT 1 WARNING 100405 Silo 169.254.22.7:0] Note: Silo not running with ServerGC turned on or with GCLatencyMode.Batch enabled - recommend checking app config : <configuration>-<runtime>-<gcServer enabled="true"> and <configuration>-<runtime>-<gcConcurrent enabled="false"/>
[2016-04-25 22:56:24.747 GMT 1 WARNING 100405 Silo 169.254.22.7:0] Note: ServerGC only kicks in on multi-core systems (settings enabling ServerGC have no effect on single-core machines).
[2016-04-25 22:56:24.749 GMT 1 INFO 100403 Silo 169.254.22.7:0] -------------- Initializing Secondary silo on host DRACOCLUSTER-1 MachineName DRACOCLUSTER-1 at 169.254.22.7:0, gen 199320984 --------------
[2016-04-25 22:56:24.782 GMT 1 INFO 100415 Silo 169.254.22.7:0] Starting silo DRACOCLUSTER-1 with runtime Version='1.2.0.0 (Release).' .NET version='4.0.30319.42000' Is .NET 4.5=True OS version='Microsoft Windows NT 6.2.9200.0' Config=
Config File Name: C:\Users\amc-admin\Desktop\Debug\OrleansConfiguration.xml
Host: DRACOCLUSTER-1
Start time: 2016-04-25 22:56:24.752 GMT
Primary node: null
Platform version info:
.NET version: 4.0.30319.42000
Is .NET 4.5=True
OS version: Microsoft Windows NT 6.2.9200.0
GC Type=Client GCLatencyMode=Interactive
Global configuration:
System Ids:
ServiceId: 00000000-0000-0000-0000-000000000000
DeploymentId: DracoSilo
Subnet:
Seed nodes:
Messaging:
Response timeout: 00:00:30
Maximum resend count: 0
Resend On Timeout: False
Maximum Socket Age: 10675199.02:48:05.4775807
Drop Expired Messages: True
Silo Sender queues: 1
Gateway Sender queues: 1
Client Drop Timeout: 00:01:00
Use standard (.NET) serializer: False
Use fallback json serializer: False
Buffer Pool Buffer Size: 4096
Buffer Pool Max Size: 10000
Buffer Pool Preallocation Size: 250
Use Message Batching: False
Max Message Batching Size: 10
Maximum forward count: 2
Liveness:
LivenessEnabled: True
LivenessType: SqlServer
ProbeTimeout: 00:00:10
TableRefreshTimeout: 00:01:00
DeathVoteExpirationTimeout: 00:02:00
NumMissedProbesLimit: 3
NumProbedSilos: 3
NumVotesForDeathDeclaration: 2
UseLivenessGossip: True
IAmAliveTablePublishTimeout: 00:05:00
NumMissedTableIAmAliveLimit: 2
MaxJoinAttemptTime: 00:05:00
ExpectedClusterSize: 20
SystemStore:
SystemStore ConnectionString: Data Source=DRACODB;Initial Catalog=Draco;Integrated Security=True;Pooling=False;Max Pool Size=200;Asynchronous Processing=True;MultipleActiveResultSets=True
Reminders ConnectionString: Data Source=DRACODB;Initial Catalog=Draco;Integrated Security=True;Pooling=False;Max Pool Size=200;Asynchronous Processing=True;MultipleActiveResultSets=True
Application:
Defaults:
Deactivate if idle for: 02:00:00
PlacementStrategy:
Default Placement Strategy: RandomPlacement
Deployment Load Publisher Refresh Time: 00:00:01
Activation CountBased Placement Choose Out Of: 2
Grain directory cache:
Maximum size: 1000000 grains
Initial TTL: 00:00:30
Maximum TTL: 00:04:00
TTL extension factor: 2.00
Directory Caching Strategy: Adaptive
Grain directory:
Lazy deregistration delay: 00:01:00
Client registration refresh: 00:05:00
Reminder Service:
ReminderServiceType: SqlServer
Consistent Ring:
Use Virtual Buckets Consistent Ring: True
Num Virtual Buckets Consistent Ring: 30
Providers:
StorageProviders:
Name=PubSubStore, Type=Orleans.Storage.MemoryStorage, Properties=[NumStorageGrains]
Name=Default, Type=Orleans.Storage.MemoryStorage, Properties=[]
StreamProviders:
Name=Default, Type=Orleans.Providers.Streams.SimpleMessageStream.SimpleMessageStreamProvider, Properties=[FireAndForgetDelivery]
Silo configuration:
Silo Name: DRACOCLUSTER-1
Generation: 199320984
Host Name or IP Address:
DNS Host Name: DRACOCLUSTER-1
Port: 0
Subnet:
Preferred Address Family: InterNetwork
IsGatewayNode: False
IsPrimaryNode: False
Scheduler:
Max Active Threads: 4
Processor Count: 1
Delay Warning Threshold: 00:00:10
Activation Scheduling Quantum: 00:00:00.1000000
Turn Warning Length Threshold: 00:00:00.2000000
Inject More Worker Threads: False
MinDotNetThreadPoolSize: 200
.NET thread pool sizes - Min: Worker Threads=1 Completion Port Threads=1
.NET thread pool sizes - Max: Worker Threads=32767 Completion Port Threads=1000
.NET ServicePointManager - DefaultConnectionLimit=200 Expect100Continue=False UseNagleAlgorithm=False
Load Shedding Enabled: False
Load Shedding Limit: 95
SiloShutdownEventName:
Debug:
Tracing:
Default Trace Level: Info
TraceLevelOverrides: None
Trace to Console: True
Trace File Name: C:\Users\amc-admin\Desktop\Debug\DRACOCLUSTER-1-2016-04-25-22.56.24.104Z.log
LargeMessageWarningThreshold: 85000
PropagateActivityId: False
BulkMessageLimit: 1000
Statistics:
MetricsTableWriteInterval: 00:00:30
PerfCounterWriteInterval: 00:00:30
LogWriteInterval: 00:05:00
WriteLogStatisticsToTable: True
StatisticsCollectionLevel: Info
[2016-04-25 22:56:24.858 GMT 1 INFO 100445 Silo 169.254.22.7:0] Successfully loaded Orleans.Runtime.Startup.ConfigureStartupBuilder from OrleansDependencyInjection.dll
[2016-04-25 22:56:24.897 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] Searching for assemblies in C:\Users\amc-admin\Desktop\Debug...
[2016-04-25 22:56:24.930 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\DracoInterfaces.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:56:24.933 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\DracoModels.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:56:24.936 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\DracoUtils.dll
* Grain type Draco.Utility.DracoGrain is abstract and cannot be instantiated.
* Grain type Draco.Utility.DracoGrain`1 is abstract and cannot be instantiated.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:56:24.957 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\Microsoft.Azure.SqlDatabase.ElasticScale.Client.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:56:25.210 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\Microsoft.CodeAnalysis.CSharp.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:56:25.324 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\Microsoft.CodeAnalysis.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:56:25.331 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\Microsoft.Extensions.DependencyInjection.Abstractions.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:56:25.335 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\Microsoft.Extensions.DependencyInjection.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:56:25.338 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\Microsoft.Practices.EnterpriseLibrary.TransientFaultHandling.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:56:25.369 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\MongoDB.Bson.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:56:25.406 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\MongoDB.Driver.Core.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:56:25.457 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\MongoDB.Driver.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:56:25.486 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\Newtonsoft.Json.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:56:25.488 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\Orleans.dll
* Assembly filename is excluded.
[2016-04-25 22:56:25.491 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\OrleansCodeGenerator.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:56:25.493 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\OrleansDependencyInjection.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:56:25.499 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\OrleansRuntime.dll
* Assembly filename is excluded.
[2016-04-25 22:56:25.521 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\System.Collections.Immutable.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:56:25.531 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\System.Reactive.Core.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:56:25.533 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\System.Reactive.Interfaces.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:56:25.631 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\System.Reactive.Linq.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:56:25.650 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\System.Reflection.Metadata.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:56:25.662 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\System.Threading.Tasks.Dataflow.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:56:25.665 GMT 1 WARNING 101705 AssemblyLoader.Silo 169.254.22.7:0] Unable to find directory C:\Users\amc-admin\Desktop\Debug\Applications; skipping.
[2016-04-25 22:56:25.667 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] Loading assembly C:\Users\amc-admin\Desktop\Debug\DracoFoundation.dll...
[2016-04-25 22:56:26.585 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] Loading assembly C:\Users\amc-admin\Desktop\Debug\OrleansProviders.dll...
[2016-04-25 22:56:26.614 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] Loading assembly C:\Users\amc-admin\Desktop\Debug\OrleansSQLUtils.dll...
[2016-04-25 22:56:26.652 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] Loading assembly C:\Users\amc-admin\Desktop\Debug\TestDriver.dll...
[2016-04-25 22:56:26.728 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] Loading assembly C:\Users\amc-admin\Desktop\Debug\VSMConnection.dll...
[2016-04-25 22:56:26.733 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] 5 assemblies loaded.
[2016-04-25 22:56:26.908 GMT 1 INFO 100000 Scheduler.OrleansTaskScheduler 169.254.22.7:0] Starting OrleansTaskScheduler with 4 Max Active application Threads and 1 system thread.
[2016-04-25 22:56:26.920 GMT 1 INFO 101010 Runtime.Messaging.IncomingMessageAcceptor 169.254.22.7:0] Opened a listening socket at address 169.254.22.7:51954
[2016-04-25 22:56:26.954 GMT 1 INFO 100000 VirtualBucketsRingProvider 169.254.22.7:0] Starting VirtualBucketsRingProvider on silo S169.254.22.7:51954:199320984/x469F7FC3.
[2016-04-25 22:56:26.998 GMT 1 INFO 103003 VirtualBucketsRingProvider 169.254.22.7:0] Added Server S169.254.22.7:51954:199320984/x469F7FC3. Current view: [S169.254.22.7:51954:199320984 -> <MultiRange: Size=x100000000, %Ring=100.000%>]
[2016-04-25 22:56:27.002 GMT 1 INFO 103005 VirtualBucketsRingProvider 169.254.22.7:0] -NotifyLocalRangeSubscribers about old <(0 0], Size=x100000000, %Ring=100.000%> new <MultiRange: Size=x100000000, %Ring=100.000%> increased? True
[2016-04-25 22:56:27.042 GMT 1 INFO 100294 SystemStatus 169.254.22.7:0] SystemStatus=Created
[2016-04-25 22:56:27.044 GMT 1 INFO 100422 Silo 169.254.22.7:0] -------------- Started silo S169.254.22.7:51954:199320984, ConsistentHashCode 469F7FC3 --------------
[2016-04-25 22:56:27.047 GMT 1 INFO 100441 OrleansSiloHost 169.254.22.7:0] Silo shutdown event name: DRACOCLUSTER-1-Shutdown
[2016-04-25 22:56:27.048 GMT 1 INFO 100442 OrleansSiloHost 169.254.22.7:0] Created and set shutdown event DRACOCLUSTER-1-Shutdown
[2016-04-25 22:56:27.059 GMT 1 INFO 100294 SystemStatus 169.254.22.7:0] SystemStatus=Starting
[2016-04-25 22:56:27.060 GMT 1 INFO 100401 Silo 169.254.22.7:0] Silo Start()
[2016-04-25 22:56:27.069 GMT 1 INFO 100430 Silo 169.254.22.7:0] Configured ThreadPool.SetMinThreads() to values: 200,200. Previous values are: 1,1.
[2016-04-25 22:56:27.071 GMT 1 INFO 100436 Silo 169.254.22.7:0] Configured .NET ServicePointManager to Expect100Continue=False, DefaultConnectionLimit=200, UseNagleAlgorithm=False to improve Azure storage performance.
[2016-04-25 22:56:27.117 GMT 1 INFO 101711 AssemblyLoader.Silo 169.254.22.7:0] Loaded grain type summary for 11 types:
Grain class Draco.Foundation.Draco.Foundation.VehicleGrain [-882752399 (0xCB624471)] from DracoFoundation.dll implementing interfaces: Draco.Interfaces.Draco.Interfaces.IVehicleGrain [-186200810 (0xF4E6CD16)]
Grain class Draco.Foundation.Draco.Foundation.VehicleManager [892960422 (0x35397EA6)] from DracoFoundation.dll implementing interfaces: Draco.Interfaces.Draco.Interfaces.IVehicleManager [9765603 (0x9502E3)], Draco.Utility.Draco.Utility.IGrainWithSingletonKey [-854559413 (0xCD10754B)]
Grain class Draco.Foundation.Draco.Foundation.VehicleTypeManager [-1451282848 (0xA97F2E60)] from DracoFoundation.dll implementing interfaces: Draco.Interfaces.Draco.Interfaces.IVehicleTypeManager [868096219 (0x33BE18DB)], Draco.Utility.Draco.Utility.IGrainWithSingletonKey [-854559413 (0xCD10754B)]
Grain class Draco.VSMConnection.Draco.VSMConnection.VSMDiscovery [-349437437 (0xEB2C0203)] from VSMConnection.dll implementing interfaces: Draco.VSMConnection.Draco.VSMConnection.IVSMDiscovery [-1019522468 (0xC33B525C)], Draco.Utility.Draco.Utility.IGrainWithSingletonKey [-854559413 (0xCD10754B)], Orleans.Orleans.IRemindable [-831689659 (0xCE6D6C45)]
Grain class Draco.VSMConnection.Draco.VSMConnection.VSMManager [-1479894192 (0xA7CA9B50)] from VSMConnection.dll implementing interfaces: Draco.Interfaces.Draco.Interfaces.IVSMManager [196364016 (0xBB446F0)]
Grain class Orleans.Runtime.Management.Orleans.Runtime.Management.ManagementGrain [1954798034 (0x7483D9D2)] from OrleansRuntime.dll implementing interfaces: Orleans.Runtime.Orleans.Runtime.IManagementGrain [-1734666656 (0x989B1660)]
Grain class Orleans.Runtime.MembershipService.Orleans.Runtime.MembershipService.GrainBasedMembershipTable [-2103923544 (0x8298ACA8)] from OrleansRuntime.dll implementing interfaces: Orleans.Orleans.IMembershipTableGrain [-1256503757 (0xB51B4633)]
Grain class Orleans.Runtime.ReminderService.Orleans.Runtime.ReminderService.GrainBasedReminderTable [-55315191 (0xFCB3F509)] from OrleansRuntime.dll implementing interfaces: Orleans.Orleans.IReminderTableGrain [-1135060418 (0xBC585A3E)]
Grain class Orleans.Storage.Orleans.Storage.MemoryStorageGrain [819348208 (0x30D642F0)] from OrleansRuntime.dll implementing interfaces: Orleans.Storage.Orleans.Storage.IMemoryStorageGrain [577125491 (0x22663C73)]
Grain class Orleans.Streams.Orleans.Streams.PubSubRendezvousGrain [1903070868 (0x716E8E94)] from OrleansRuntime.dll implementing interfaces: Orleans.Streams.Orleans.Streams.IPubSubRendezvousGrain [1746702088 (0x681C8F08)]
Grain class TestDriver.TestDriver.LoadTestGrain [456827097 (0x1B3AA0D9)] from TestDriver.dll implementing interfaces: TestDriver.TestDriver.ILoadTestGrain [-1097320062 (0xBE983982)], Draco.Utility.Draco.Utility.IGrainWithSingletonKey [-854559413 (0xCD10754B)]
[2016-04-25 22:56:27.160 GMT 10 INFO 100000 Runtime.Scheduler.WorkerPoolThread/System.5 169.254.22.7:0] Starting AsyncAgent Runtime.Scheduler.WorkerPoolThread/System.5 on managed thread 10
[2016-04-25 22:56:27.166 GMT 6 INFO 100000 Runtime.Scheduler.WorkerPoolThread/0 169.254.22.7:0] Starting AsyncAgent Runtime.Scheduler.WorkerPoolThread/0 on managed thread 6
[2016-04-25 22:56:27.170 GMT 7 INFO 100000 Runtime.Scheduler.WorkerPoolThread/1 169.254.22.7:0] Starting AsyncAgent Runtime.Scheduler.WorkerPoolThread/1 on managed thread 7
[2016-04-25 22:56:27.171 GMT 8 INFO 100000 Runtime.Scheduler.WorkerPoolThread/2 169.254.22.7:0] Starting AsyncAgent Runtime.Scheduler.WorkerPoolThread/2 on managed thread 8
[2016-04-25 22:56:27.172 GMT 9 INFO 100000 Runtime.Scheduler.WorkerPoolThread/3 169.254.22.7:0] Starting AsyncAgent Runtime.Scheduler.WorkerPoolThread/3 on managed thread 9
[2016-04-25 22:56:27.173 GMT 11 INFO 100000 Runtime.Messaging.IncomingMessageAcceptor 169.254.22.7:0] Starting AsyncAgent Runtime.Messaging.IncomingMessageAcceptor on managed thread 11
[2016-04-25 22:56:27.175 GMT 11 INFO 100328 Runtime.Messaging.IncomingMessageAcceptor 169.254.22.7:0] Stopping AsyncAgent Runtime.Messaging.IncomingMessageAcceptor that runs on managed thread 11
[2016-04-25 22:56:27.179 GMT 12 INFO 100000 Runtime.Messaging.SiloMessageSender/PingSender 169.254.22.7:0] Starting AsyncAgent Runtime.Messaging.SiloMessageSender/PingSender on managed thread 12
[2016-04-25 22:56:27.179 GMT 13 INFO 100000 Runtime.Messaging.SiloMessageSender/SystemSender 169.254.22.7:0] Starting AsyncAgent Runtime.Messaging.SiloMessageSender/SystemSender on managed thread 13
[2016-04-25 22:56:27.180 GMT 16 INFO 100000 Runtime.Messaging.IncomingMessageAgent/Ping 169.254.22.7:0] Starting AsyncAgent Runtime.Messaging.IncomingMessageAgent/Ping on managed thread 16
[2016-04-25 22:56:27.180 GMT 15 INFO 100000 Runtime.Messaging.IncomingMessageAgent/System 169.254.22.7:0] Starting AsyncAgent Runtime.Messaging.IncomingMessageAgent/System on managed thread 15
[2016-04-25 22:56:27.180 GMT 17 INFO 100000 Runtime.Messaging.IncomingMessageAgent/Application 169.254.22.7:0] Starting AsyncAgent Runtime.Messaging.IncomingMessageAgent/Application on managed thread 17
[2016-04-25 22:56:27.181 GMT 14 INFO 100000 Runtime.GrainDirectory.AdaptiveDirectoryCacheMaintainer`1 169.254.22.7:0] Starting AsyncAgent Runtime.GrainDirectory.AdaptiveDirectoryCacheMaintainer`1 on managed thread 14
[2016-04-25 22:56:27.196 GMT 1 INFO 100000 MembershipFactory 169.254.22.7:0] Creating membership oracle for type=SqlServer
[2016-04-25 22:56:27.230 GMT 1 INFO 100000 ReminderFactory 169.254.22.7:0] Creating reminder system target for type=SqlServer
[2016-04-25 22:56:27.278 GMT 10 INFO 100507 Catalog 169.254.22.7:0] Before collection#1: memory=17MB, #activations=0, collector=<#Activations=0, #Buckets=0, buckets=[]>.
[2016-04-25 22:56:27.291 GMT 8 INFO 103102 ProviderLoader/IStorageProvider 169.254.22.7:0] Loaded provider of type Orleans.Storage.MemoryStorage Name=PubSubStore
[2016-04-25 22:56:27.292 GMT 8 INFO 103102 ProviderLoader/IStorageProvider 169.254.22.7:0] Loaded provider of type Orleans.Storage.MemoryStorage Name=Default
[2016-04-25 22:56:27.305 GMT 8 INFO 0 Storage.MemoryStorage.1 169.254.22.7:0] Init: Name=PubSubStore NumStorageGrains=1
[2016-04-25 22:56:27.306 GMT 8 INFO 0 Storage.MemoryStorage.2 169.254.22.7:0] Init: Name=Default NumStorageGrains=10
[2016-04-25 22:56:27.311 GMT 8 INFO 103102 ProviderLoader/IStreamProviderImpl 169.254.22.7:0] Loaded provider of type Orleans.Providers.Streams.SimpleMessageStream.SimpleMessageStreamProvider Name=Default
[2016-04-25 22:56:27.319 GMT 8 INFO 0 SimpleMessageStreamProvider 169.254.22.7:0] Initialized SimpleMessageStreamProvider with name Default and with property FireAndForgetDelivery: False, OptimizeForImmutableData: True and PubSubType: ExplicitGrainBasedAndImplicit
[2016-04-25 22:56:27.375 GMT 10 INFO 100508 Catalog 169.254.22.7:0] After collection#1: memory=19MB, #activations=0, collected 0 activations, collector=<#Activations=0, #Buckets=0, buckets=[]>, collection time=00:00:00.1022482.
[2016-04-25 22:56:27.486 GMT 10 INFO 100603 MembershipOracle 169.254.22.7:0] MembershipOracle starting on host = DRACOCLUSTER-1 address = S169.254.22.7:51954:199320984 at 2016-04-25 22:56:27.218 GMT, backOffMax = 00:00:20
[2016-04-25 22:56:35.193 GMT 10 INFO 100652 MembershipOracle 169.254.22.7:0] -CleanupTable called on silo startup. Membership table 0 silos, 0 are Active, 0 are Dead, Version=<66, 66>. All silos: []
[2016-04-25 22:56:35.293 GMT 10 INFO 100660 MembershipOracle 169.254.22.7:0] Starting IAmAliveUpdateTimer.
[2016-04-25 22:56:35.339 GMT 10 WARNING 101215 Scheduler.MembershipOracle.WorkItemGroup 169.254.22.7:0] Task [Id=301, Status=RanToCompletion] in WorkGroup [SystemTarget: S169.254.22.7:51954:199320984MembershipOracle@S0000000f] took elapsed time 0:00:00.2550655 for execution, which is longer than 00:00:00.2000000. Running on thread <Runtime.Scheduler.WorkerPoolThread/System.5, ManagedThreadId=10, Executing Task Id=301 Status=RanToCompletion for 00:00:00.2466158 on WorkItem=System*WorkItemGroup:Name=MembershipOracle,WorkGroupStatus=Running Executing for 00:00:00.2466158. .>
[2016-04-25 22:56:35.377 GMT 10 INFO 100604 MembershipOracle 169.254.22.7:0] -BecomeActive
[2016-04-25 22:56:35.393 GMT 10 INFO 100614 MembershipOracle 169.254.22.7:0] About to send pings to 0 nodes in order to validate communication in the Joining state. Pinged nodes = []
[2016-04-25 22:56:35.456 GMT 10 INFO 100634 MembershipOracle 169.254.22.7:0] -ReadAll (called from BecomeActive) Membership table 1 silos, 1 are Active, 0 are Dead, Version=<68, 68>. All silos: [SiloAddress=S169.254.22.7:51954:199320984 InstanceName= Status=Active]
[2016-04-25 22:56:35.456 GMT 10 INFO 100605 MembershipOracle 169.254.22.7:0] -Finished BecomeActive.
[2016-04-25 22:56:35.456 GMT 1 INFO 100702 WindowsPerfCountersStatistics 169.254.22.7:0] Starting Windows perf counter stats collection with frequency=00:00:30
[2016-04-25 22:56:35.456 GMT 1 WARNING 100701 WindowsPerfCountersStatistics 169.254.22.7:0] Windows perf counters not found -- defaulting to in-memory counters. Run OrleansCounterControl.exe as Administrator to create perf counters for Orleans.
[2016-04-25 22:56:35.477 GMT 1 INFO 100714 SiloPerformanceMetrics 169.254.22.7:0] Starting Silo Table metrics reporter with reportFrequency=00:00:30
[2016-04-25 22:56:35.477 GMT 10 INFO 100000 DeploymentLoadPublisher 169.254.22.7:0] Starting DeploymentLoadPublisher.
[2016-04-25 22:56:35.602 GMT 9 INFO 100000 DeploymentLoadPublisher 169.254.22.7:0] Started DeploymentLoadPublisher.
[2016-04-25 22:56:35.604 GMT 1 INFO 100000 Watchdog 169.254.22.7:0] Starting Silo Watchdog.
[2016-04-25 22:56:35.606 GMT 30 INFO 100000 Runtime.Watchdog 169.254.22.7:0] Starting AsyncAgent Runtime.Watchdog on managed thread 30
[2016-04-25 22:56:35.613 GMT 10 INFO 102925 ReminderService 169.254.22.7:0] Starting reminder system target on: S169.254.22.7:51954:199320984 x469F7FC3, with range <MultiRange: Size=x100000000, %Ring=100.000%>
[2016-04-25 22:56:36.126 GMT 10 INFO 102926 ReminderService 169.254.22.7:0] Reminder system target started OK on: S169.254.22.7:51954:199320984 x469F7FC3, with range <MultiRange: Size=x100000000, %Ring=100.000%>
[2016-04-25 22:56:36.126 GMT 10 WARNING 101215 Scheduler.ReminderService.WorkItemGroup 169.254.22.7:0] Task [Id=920, Status=RanToCompletion] in WorkGroup [SystemTarget: S169.254.22.7:51954:199320984ReminderService@S00000010] took elapsed time 0:00:00.5233037 for execution, which is longer than 00:00:00.2000000. Running on thread <Runtime.Scheduler.WorkerPoolThread/System.5, ManagedThreadId=10, Executing Task Id=920 Status=RanToCompletion for 00:00:00.5152696 on WorkItem=System*WorkItemGroup:Name=ReminderService,WorkGroupStatus=Running Executing for 00:00:00.5152696. .>
[2016-04-25 22:56:36.148 GMT 1 INFO 100294 SystemStatus 169.254.22.7:0] SystemStatus=Running
[2016-04-25 22:56:36.195 GMT 1 INFO 100424 OrleansSiloHost 169.254.22.7:0] Silo startup event name: DRACOCLUSTER-1
[2016-04-25 22:56:36.211 GMT 1 INFO 100425 OrleansSiloHost 169.254.22.7:0] Created and set startup event DRACOCLUSTER-1
[2016-04-25 22:56:36.211 GMT 1 INFO 100402 OrleansSiloHost 169.254.22.7:0] Silo DRACOCLUSTER-1 started successfully
[2016-04-25 22:57:12.739 GMT 4 WARNING 100220 Silo 169.254.22.7:0] Process is exiting
[2016-04-25 22:57:12.739 GMT 4 INFO 100294 SystemStatus 169.254.22.7:0] SystemStatus=Stopping
[2016-04-25 22:57:12.739 GMT 4 INFO 100414 Silo 169.254.22.7:0] Silo.HandleProcessExit() - starting to FastKill()
[2016-04-25 22:57:12.775 GMT 10 INFO 100609 MembershipOracle 169.254.22.7:0] -KillMyself
[2016-04-25 22:57:12.859 GMT 4 INFO 101203 Scheduler.OrleansTaskScheduler 169.254.22.7:0] OrleansTaskScheduler.PrintStatistics(): RunQueue=0, WorkItems=10, Directory:
[--System*WorkItemGroup:Name=Catalog,WorkGroupStatus=Waiting. Currently QueuedWorkItems=0; Total EnQueued=3; Total processed=3; Quantum expirations=0; TaskRunner=ActivationTaskScheduler-9:Queued=0; Detailed SchedulingContext=<[SystemTarget: S169.254.22.7:51954:199320984Catalog@S0000000e] CurrentlyExecuting=null>
--System*WorkItemGroup:Name=ClientObserverRegistrar,WorkGroupStatus=Waiting. Currently QueuedWorkItems=0; Total EnQueued=1; Total processed=1; Quantum expirations=0; TaskRunner=ActivationTaskScheduler-5:Queued=0; Detailed SchedulingContext=<[SystemTarget: S169.254.22.7:51954:199320984ClientObserverRegistrar@S0000000d] CurrentlyExecuting=null>
--System*WorkItemGroup:Name=DeploymentLoadPublisherSystemTarget,WorkGroupStatus=Waiting. Currently QueuedWorkItems=0; Total EnQueued=155; Total processed=155; Quantum expirations=0; TaskRunner=ActivationTaskScheduler-2:Queued=0; Detailed SchedulingContext=<[SystemTarget: S169.254.22.7:51954:199320984DeploymentLoadPublisherSystemTarget@S00000016] CurrentlyExecuting=Response S169.254.22.7:51954:199320984DeploymentLoadPublisherSystemTarget@S00000016->S169.254.22.7:51954:199320984DeploymentLoadPublisherSystemTarget@S00000016 #40: global::Orleans.Runtime.IDeploymentLoadPublisher:UpdateRuntimeStatistics()>
--System*WorkItemGroup:Name=DirectoryCacheValidator,WorkGroupStatus=Waiting. Currently QueuedWorkItems=0; Total EnQueued=1; Total processed=1; Quantum expirations=0; TaskRunner=ActivationTaskScheduler-4:Queued=0; Detailed SchedulingContext=<[SystemTarget: S169.254.22.7:51954:199320984DirectoryCacheValidator@S0000000b] CurrentlyExecuting=null>
--System*WorkItemGroup:Name=DirectoryService,WorkGroupStatus=Waiting. Currently QueuedWorkItems=0; Total EnQueued=0; Total processed=0; Quantum expirations=0; TaskRunner=ActivationTaskScheduler-3:Queued=0; Detailed SchedulingContext=<[SystemTarget: S169.254.22.7:51954:199320984DirectoryService@S0000000a] CurrentlyExecuting=null>
--System*WorkItemGroup:Name=MembershipOracle,WorkGroupStatus=Waiting. Currently QueuedWorkItems=0; Total EnQueued=11; Total processed=11; Quantum expirations=0; TaskRunner=ActivationTaskScheduler-7:Queued=0; Detailed SchedulingContext=<[SystemTarget: S169.254.22.7:51954:199320984MembershipOracle@S0000000f] CurrentlyExecuting=null>
--System*WorkItemGroup:Name=ProviderManagerSystemTarget,WorkGroupStatus=Waiting. Currently QueuedWorkItems=0; Total EnQueued=4; Total processed=4; Quantum expirations=0; TaskRunner=ActivationTaskScheduler-10:Queued=0; Detailed SchedulingContext=<[SystemTarget: S169.254.22.7:51954:199320984ProviderManagerSystemTarget@S00000013] CurrentlyExecuting=null>
--System*WorkItemGroup:Name=ReminderService,WorkGroupStatus=Waiting. Currently QueuedWorkItems=0; Total EnQueued=1; Total processed=1; Quantum expirations=0; TaskRunner=ActivationTaskScheduler-8:Queued=0; Detailed SchedulingContext=<[SystemTarget: S169.254.22.7:51954:199320984ReminderService@S00000010] CurrentlyExecuting=null>
--System*WorkItemGroup:Name=SiloControl,WorkGroupStatus=Waiting. Currently QueuedWorkItems=0; Total EnQueued=1; Total processed=1; Quantum expirations=0; TaskRunner=ActivationTaskScheduler-1:Queued=0; Detailed SchedulingContext=<[SystemTarget: S169.254.22.7:51954:199320984SiloControl@S0000000c] CurrentlyExecuting=Request S169.254.22.7:51954:199320984DeploymentLoadPublisherSystemTarget@S00000016->S169.254.22.7:51954:199320984SiloControl@S0000000c #2: global::Orleans.ISiloControl:GetRuntimeStatistics()>
--System*WorkItemGroup:Name=TypeManagerId,WorkGroupStatus=Waiting. Currently QueuedWorkItems=0; Total EnQueued=0; Total processed=0; Quantum expirations=0; TaskRunner=ActivationTaskScheduler-6:Queued=0; Detailed SchedulingContext=<[SystemTarget: S169.254.22.7:51954:199320984TypeManagerId@S00000011] CurrentlyExecuting=null>]
[2016-04-25 22:57:12.859 GMT 6 INFO 100328 Runtime.Scheduler.WorkerPoolThread/0 169.254.22.7:0] Stopping AsyncAgent Runtime.Scheduler.WorkerPoolThread/0 that runs on managed thread 6
[2016-04-25 22:57:12.859 GMT 7 INFO 100328 Runtime.Scheduler.WorkerPoolThread/1 169.254.22.7:0] Stopping AsyncAgent Runtime.Scheduler.WorkerPoolThread/1 that runs on managed thread 7
[2016-04-25 22:57:12.859 GMT 9 INFO 100328 Runtime.Scheduler.WorkerPoolThread/3 169.254.22.7:0] Stopping AsyncAgent Runtime.Scheduler.WorkerPoolThread/3 that runs on managed thread 9
[2016-04-25 22:57:12.859 GMT 8 INFO 100328 Runtime.Scheduler.WorkerPoolThread/2 169.254.22.7:0] Stopping AsyncAgent Runtime.Scheduler.WorkerPoolThread/2 that runs on managed thread 8
[2016-04-25 22:57:12.859 GMT 10 INFO 100328 Runtime.Scheduler.WorkerPoolThread/System.5 169.254.22.7:0] Stopping AsyncAgent Runtime.Scheduler.WorkerPoolThread/System.5 that runs on managed thread 10
[2016-04-25 22:57:12.875 GMT 4 INFO 100528 ActivationDirectory 169.254.22.7:0] ActivationDirectory.PrintActivationDirectory(): Size = 0, Directory:
[]
[2016-04-25 22:57:12.891 GMT 4 INFO 100703 WindowsPerfCountersStatistics 169.254.22.7:0] Stopping Windows perf counter stats collection
[2016-04-25 22:57:12.891 GMT 13 INFO 100312 Runtime.Messaging.SiloMessageSender/SystemSender 169.254.22.7:0] Stop request processed
[2016-04-25 22:57:12.891 GMT 12 INFO 100312 Runtime.Messaging.SiloMessageSender/PingSender 169.254.22.7:0] Stop request processed
[2016-04-25 22:57:12.938 GMT 4 INFO 100704 SiloLogStatistics 169.254.22.7:0] Statistics: ^^^
App.Requests.Latency.Average.Millis=1.000
App.Requests.LatencyHistogram.Millis=[0.0512:0.1023]=1, [0.1024:0.2047]=3, [0.2048:0.4095]=31, [0.4096:0.8191]=1, [1.6384:3.2767]=2, [26.2144:52.4287]=1,
App.Requests.TimedOut.Current=0
App.Requests.Total.Requests.Current=39
Catalog.Activation.Collection.NumberOfCollections.Current=1
Catalog.Activation.Created.Current=0
Catalog.Activation.CurrentCount=0
Catalog.Activation.Destroyed.Current=0
Catalog.Activation.FailedToActivate.Current=0
ConsistentRing.AverageRangePercentage=100.000
ConsistentRing.MyRange.RingDistance=x100000000
ConsistentRing.MyRange.RingPercentage=100.000
ConsistentRing.Ring=[S169.254.22.7:51954:199320984 -> <MultiRange: Size=x100000000, %Ring=100.000%>]
ConsistentRing.RingSize=1
Directory.CacheSize=0
Directory.Lookups.Cache.HitRatio=0, Delta=0
Directory.Lookups.Cache.Issued.Current=0
Directory.Lookups.Cache.Successes.Current=0
Directory.Lookups.Full.Issued.Current=0
Directory.Lookups.Local.Issued.Current=0
Directory.Lookups.Local.Successes.Current=0
Directory.Lookups.LocalDirectory.Issued.Current=0
Directory.Lookups.LocalDirectory.Successes.Current=0
Directory.Lookups.Remote.Received.Current=0
Directory.Lookups.Remote.Sent.Current=0
Directory.PartitionSize=0
Directory.Registrations.Issued.Current=0
Directory.Registrations.Local.Current=0
Directory.Registrations.Remote.Received.Current=0
Directory.Registrations.Remote.Sent.Current=0
Directory.Registrations.SingleAct.Issued.Current=0
Directory.Registrations.SingleAct.Local.Current=0
Directory.Registrations.SingleAct.Remote.Received.Current=0
Directory.Registrations.SingleAct.Remote.Sent.Current=0
Directory.Ring=[S169.254.22.7:51954:199320984/469F7FC3]
Directory.Ring.MyPortion.AverageRingPercentage=100.000
Directory.Ring.MyPortion.RingDistance=0
Directory.Ring.MyPortion.RingPercentage=0.000
Directory.Ring.MyPredecessors=[]
Directory.Ring.MySuccessors=[]
Directory.Ring.RingSize=1
Directory.UnRegistrations.Issued.Current=0
Directory.UnRegistrations.Local.Current=0
Directory.UnRegistrations.Remote.Received.Current=0
Directory.UnRegistrations.Remote.Sent.Current=0
Directory.UnRegistrationsMany.Issued.Current=0
Directory.UnRegistrationsMany.Remote.Received.Current=0
Directory.UnRegistrationsMany.Remote.Sent.Current=0
Directory.Validations.Cache.Received.Current=0
Directory.Validations.Cache.Sent.Current=0
Gateway.ConnectedClients.Current=0
Membership.ActiveCluster=[]
Membership.ActiveClusterSize=0
MessageCenter.ReceiveQueueLength=0
MessageCenter.SendQueueLength=0
Messaging.Expired.AtDispatch.Current=0
Messaging.Expired.AtInvoke.Current=0
Messaging.Expired.AtReceive.Current=0
Messaging.Expired.AtRespond.Current=0
Messaging.Expired.AtSend.Current=0
Messaging.Processing.ActivationData.All=0
Messaging.Processing.Dispatcher.Processed.Errors.Direction.OneWay.Current=0
Messaging.Processing.Dispatcher.Processed.Errors.Direction.Request.Current=0
Messaging.Processing.Dispatcher.Processed.Errors.Direction.Response.Current=0
Messaging.Processing.Dispatcher.Processed.Ok.Direction.OneWay.Current=0
Messaging.Processing.Dispatcher.Processed.Ok.Direction.Request.Current=0
Messaging.Processing.Dispatcher.Processed.Ok.Direction.Response.Current=0
Messaging.Processing.Dispatcher.Processed.ReRoute.Direction.OneWay.Current=0
Messaging.Processing.Dispatcher.Processed.ReRoute.Direction.Request.Current=0
Messaging.Processing.Dispatcher.Processed.ReRoute.Direction.Response.Current=0
Messaging.Processing.Dispatcher.Processed.Total.Current=0
Messaging.Processing.Dispatcher.Received.Direction.OneWay.Current=0
Messaging.Processing.Dispatcher.Received.Direction.Request.Current=0
Messaging.Processing.Dispatcher.Received.Direction.Response.Current=0
Messaging.Processing.Dispatcher.Received.OnActivationContext.Current=0
Messaging.Processing.Dispatcher.Received.OnNullContext.Current=0
Messaging.Processing.Dispatcher.Received.Total.Current=0
Messaging.Processing.IGC.Forwarded.Current=0
Messaging.Processing.IGC.ReRoute.Current=0
Messaging.Processing.IGC.Resent.Current=0
Messaging.Processing.IMA.Enqueued.ToActivationContex.Current=0
Messaging.Processing.IMA.Enqueued.ToNullContex.Current=0
Messaging.Processing.IMA.Enqueued.ToSystemTargetContex.Current=78
Messaging.Processing.IMA.Received.Current=78
Messaging.Received.BatchSize.PerSocketDirection.GatewayToClient=0.000
Messaging.Received.BatchSize.PerSocketDirection.SiloToSilo=0.000
Messaging.Received.BatchSizeBytesHistogram.Bytes.PerSocketDirection.GatewayToClient=
Messaging.Received.BatchSizeBytesHistogram.Bytes.PerSocketDirection.SiloToSilo=
Messaging.Received.Bytes.Header.Current=0
Messaging.Received.Bytes.Total.Current=0
Messaging.Received.Direction.OneWay.Current=0
Messaging.Received.Direction.Request.Current=0
Messaging.Received.Direction.Response.Current=0
Messaging.Received.Messages.Total.Current=0
Messaging.Received.MessageSizeHistogram.Bytes=
Messaging.Rerouted.OneWay.Current=0
Messaging.Rerouted.Request.Current=0
Messaging.Rerouted.Response.Current=0
Messaging.Sent.BatchSize.PerSocketDirection.GatewayToClient=0.000
Messaging.Sent.BatchSize.PerSocketDirection.SiloToSilo=0.000
Messaging.Sent.BatchSizeBytesHistogram.Bytes.PerSocketDirection.GatewayToClient=
Messaging.Sent.BatchSizeBytesHistogram.Bytes.PerSocketDirection.SiloToSilo=
Messaging.Sent.Bytes.Header.Current=0
Messaging.Sent.Bytes.Total.Current=0
Messaging.Sent.Direction.OneWay.Current=0
Messaging.Sent.Direction.Request.Current=0
Messaging.Sent.Direction.Response.Current=0
Messaging.Sent.LocalMessages.Current=78
Messaging.Sent.Messages.Total.Current=0
Messaging.Sent.MessageSizeHistogram.Bytes=
Networking.Sockets.GatewayToClient.Duplex.Closed.Current=0
Networking.Sockets.GatewayToClient.Duplex.Opened.Current=0
Networking.Sockets.Silo.Receiving.Closed.Current=0
Networking.Sockets.Silo.Receiving.Opened.Current=0
Networking.Sockets.Silo.Sending.Closed.Current=0
Networking.Sockets.Silo.Sending.Opened.Current=0
Queues.QueueSize.Instantaneous.Scheduler.LevelOne=0
Reminders.AverageTardiness.Seconds=0 Secs
Reminders.NumberOfActiveReminders=0
Reminders.TicksDelivered.Current=0
Runtime.CpuUsage=1.061
Runtime.DOT.NET.ThreadPool.InUse.CompletionPortThreads=0
Runtime.DOT.NET.ThreadPool.InUse.WorkerThreads=2
Runtime.GC.AllocatedBytesInKbPerSec=0.000
Runtime.GC.GenCollectonCount=gen0=13, gen1=5, gen2=3
Runtime.GC.GenSizesKb=gen0=23040.00, gen1=0.02, gen2=6355.20
Runtime.GC.LargeObjectHeapSizeKb=806.488
Runtime.GC.NumberOfInducedGCs=2.000
Runtime.GC.PercentOfTimeInGC=51.338
Runtime.GC.PromotedFinalizationMemoryFromGen0Kb=0.000
Runtime.GC.PromotedMemoryFromGen1Kb=61.125
Runtime.GC.TotalMemoryKb=35481
Runtime.IsOverloaded=False
Runtime.Memory.AvailableMemoryMb=884
Runtime.Memory.TotalPhysicalMemoryMb=2048
Runtime.Threads.AsynchAgent.Runtime.GrainDirectory.AdaptiveDirectoryCacheMaintainer`1.Current=1
Runtime.Threads.AsynchAgent.Runtime.Messaging.IncomingMessageAcceptor.Current=0
Runtime.Threads.AsynchAgent.Runtime.Messaging.IncomingMessageAgent.Current=3
Runtime.Threads.AsynchAgent.Runtime.Messaging.SiloMessageSender.Current=2
Runtime.Threads.AsynchAgent.Runtime.Scheduler.WorkerPoolThread.Current=0
Runtime.Threads.AsynchAgent.Runtime.Watchdog.Current=1
Runtime.Threads.AsynchAgent.TotalThreadsCreated.Current=13
Scheduler.NumLongQueueWaitTimes.Current=0
Scheduler.NumLongRunningTurns.Current=2
Scheduler.WorkItemGroupCount=10
Serialization.BufferPool.AllocatedBuffers.Current=250
Serialization.BufferPool.BuffersInPool=220
Serialization.BufferPool.CheckedInBuffers.Current=250
Serialization.BufferPool.CheckedOutBuffers.Current=280
Serialization.BufferPool.DroppedBuffers.Current=0
Serialization.BufferPool.DroppedTooLargeBuffers.Current=0
Serialization.BufferPool.InUse.AllocatedAndNotInPool_Buffers=30
Serialization.BufferPool.InUse.CheckedOutAndNotCheckedIn_Buffers=30
Silo.StartTime=2016-04-25 22:56:24.191 GMT
Storage.Activate.Errors.Current=0
Storage.Activate.Total.Current=0
Storage.Clear.Errors.Current=0
Storage.Clear.Latency=0 Secs
Storage.Clear.Total.Current=0
Storage.Read.Errors.Current=0
Storage.Read.Latency=0 Secs
Storage.Read.Total.Current=0
Storage.Write.Errors.Current=0
Storage.Write.Latency=0 Secs
Storage.Write.Total.Current=0
Watchdog.NumHealthChecks.Current=0
[2016-04-25 22:57:12.959 GMT 12 INFO 100328 Runtime.Messaging.SiloMessageSender/PingSender 169.254.22.7:0] Stopping AsyncAgent Runtime.Messaging.SiloMessageSender/PingSender that runs on managed thread 12
[2016-04-25 22:57:13.017 GMT 4 INFO 100294 SystemStatus 169.254.22.7:0] SystemStatus=Terminated
[2016-04-25 22:58:39.242 GMT 1 INFO 100404 Silo 169.254.22.7:0] Silo starting with GC settings: ServerGC=False GCLatencyMode=Interactive
[2016-04-25 22:58:39.246 GMT 1 WARNING 100405 Silo 169.254.22.7:0] Note: Silo not running with ServerGC turned on or with GCLatencyMode.Batch enabled - recommend checking app config : <configuration>-<runtime>-<gcServer enabled="true"> and <configuration>-<runtime>-<gcConcurrent enabled="false"/>
[2016-04-25 22:58:39.246 GMT 1 WARNING 100405 Silo 169.254.22.7:0] Note: ServerGC only kicks in on multi-core systems (settings enabling ServerGC have no effect on single-core machines).
[2016-04-25 22:58:39.247 GMT 1 INFO 100403 Silo 169.254.22.7:0] -------------- Initializing Secondary silo on host DRACOCLUSTER-1 MachineName DRACOCLUSTER-1 at 169.254.22.7:0, gen 199321119 --------------
[2016-04-25 22:58:39.279 GMT 1 INFO 100415 Silo 169.254.22.7:0] Starting silo DRACOCLUSTER-1 with runtime Version='1.2.0.0 (Release).' .NET version='4.0.30319.42000' Is .NET 4.5=True OS version='Microsoft Windows NT 6.2.9200.0' Config=
Config File Name: C:\Users\amc-admin\Desktop\Debug\OrleansConfiguration.xml
Host: DRACOCLUSTER-1
Start time: 2016-04-25 22:58:39.249 GMT
Primary node: null
Platform version info:
.NET version: 4.0.30319.42000
Is .NET 4.5=True
OS version: Microsoft Windows NT 6.2.9200.0
GC Type=Client GCLatencyMode=Interactive
Global configuration:
System Ids:
ServiceId: 00000000-0000-0000-0000-000000000000
DeploymentId: DracoSilo
Subnet:
Seed nodes:
Messaging:
Response timeout: 00:00:30
Maximum resend count: 0
Resend On Timeout: False
Maximum Socket Age: 10675199.02:48:05.4775807
Drop Expired Messages: True
Silo Sender queues: 1
Gateway Sender queues: 1
Client Drop Timeout: 00:01:00
Use standard (.NET) serializer: False
Use fallback json serializer: False
Buffer Pool Buffer Size: 4096
Buffer Pool Max Size: 10000
Buffer Pool Preallocation Size: 250
Use Message Batching: False
Max Message Batching Size: 10
Maximum forward count: 2
Liveness:
LivenessEnabled: True
LivenessType: SqlServer
ProbeTimeout: 00:00:10
TableRefreshTimeout: 00:01:00
DeathVoteExpirationTimeout: 00:02:00
NumMissedProbesLimit: 3
NumProbedSilos: 3
NumVotesForDeathDeclaration: 2
UseLivenessGossip: True
IAmAliveTablePublishTimeout: 00:05:00
NumMissedTableIAmAliveLimit: 2
MaxJoinAttemptTime: 00:05:00
ExpectedClusterSize: 20
SystemStore:
SystemStore ConnectionString: Data Source=DRACODB;Initial Catalog=Draco;Integrated Security=True;Pooling=False;Max Pool Size=200;Asynchronous Processing=True;MultipleActiveResultSets=True
Reminders ConnectionString: Data Source=DRACODB;Initial Catalog=Draco;Integrated Security=True;Pooling=False;Max Pool Size=200;Asynchronous Processing=True;MultipleActiveResultSets=True
Application:
Defaults:
Deactivate if idle for: 02:00:00
PlacementStrategy:
Default Placement Strategy: RandomPlacement
Deployment Load Publisher Refresh Time: 00:00:01
Activation CountBased Placement Choose Out Of: 2
Grain directory cache:
Maximum size: 1000000 grains
Initial TTL: 00:00:30
Maximum TTL: 00:04:00
TTL extension factor: 2.00
Directory Caching Strategy: Adaptive
Grain directory:
Lazy deregistration delay: 00:01:00
Client registration refresh: 00:05:00
Reminder Service:
ReminderServiceType: SqlServer
Consistent Ring:
Use Virtual Buckets Consistent Ring: True
Num Virtual Buckets Consistent Ring: 30
Providers:
StorageProviders:
Name=PubSubStore, Type=Orleans.Storage.MemoryStorage, Properties=[NumStorageGrains]
Name=Default, Type=Orleans.Storage.MemoryStorage, Properties=[]
StreamProviders:
Name=Default, Type=Orleans.Providers.Streams.SimpleMessageStream.SimpleMessageStreamProvider, Properties=[FireAndForgetDelivery]
Silo configuration:
Silo Name: DRACOCLUSTER-1
Generation: 199321119
Host Name or IP Address:
DNS Host Name: DRACOCLUSTER-1
Port: 0
Subnet:
Preferred Address Family: InterNetwork
IsGatewayNode: False
IsPrimaryNode: False
Scheduler:
Max Active Threads: 4
Processor Count: 1
Delay Warning Threshold: 00:00:10
Activation Scheduling Quantum: 00:00:00.1000000
Turn Warning Length Threshold: 00:00:00.2000000
Inject More Worker Threads: False
MinDotNetThreadPoolSize: 200
.NET thread pool sizes - Min: Worker Threads=1 Completion Port Threads=1
.NET thread pool sizes - Max: Worker Threads=32767 Completion Port Threads=1000
.NET ServicePointManager - DefaultConnectionLimit=200 Expect100Continue=False UseNagleAlgorithm=False
Load Shedding Enabled: False
Load Shedding Limit: 95
SiloShutdownEventName:
Debug:
Tracing:
Default Trace Level: Info
TraceLevelOverrides: None
Trace to Console: True
Trace File Name: C:\Users\amc-admin\Desktop\Debug\DRACOCLUSTER-1-2016-04-25-22.58.38.609Z.log
LargeMessageWarningThreshold: 85000
PropagateActivityId: False
BulkMessageLimit: 1000
Statistics:
MetricsTableWriteInterval: 00:00:30
PerfCounterWriteInterval: 00:00:30
LogWriteInterval: 00:05:00
WriteLogStatisticsToTable: True
StatisticsCollectionLevel: Info
[2016-04-25 22:58:39.355 GMT 1 INFO 100445 Silo 169.254.22.7:0] Successfully loaded Orleans.Runtime.Startup.ConfigureStartupBuilder from OrleansDependencyInjection.dll
[2016-04-25 22:58:39.392 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] Searching for assemblies in C:\Users\amc-admin\Desktop\Debug...
[2016-04-25 22:58:39.425 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\DracoInterfaces.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:58:39.428 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\DracoModels.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:58:39.432 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\DracoUtils.dll
* Grain type Draco.Utility.DracoGrain is abstract and cannot be instantiated.
* Grain type Draco.Utility.DracoGrain`1 is abstract and cannot be instantiated.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:58:39.454 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\Microsoft.Azure.SqlDatabase.ElasticScale.Client.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:58:39.685 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\Microsoft.CodeAnalysis.CSharp.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:58:39.789 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\Microsoft.CodeAnalysis.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:58:39.792 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\Microsoft.Extensions.DependencyInjection.Abstractions.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:58:39.796 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\Microsoft.Extensions.DependencyInjection.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:58:39.806 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\Microsoft.Practices.EnterpriseLibrary.TransientFaultHandling.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:58:39.840 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\MongoDB.Bson.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:58:39.883 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\MongoDB.Driver.Core.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:58:39.915 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\MongoDB.Driver.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:58:39.936 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\Newtonsoft.Json.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:58:39.939 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\Orleans.dll
* Assembly filename is excluded.
[2016-04-25 22:58:39.941 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\OrleansCodeGenerator.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:58:39.944 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\OrleansDependencyInjection.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:58:39.949 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\OrleansRuntime.dll
* Assembly filename is excluded.
[2016-04-25 22:58:39.975 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\System.Collections.Immutable.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:58:40.014 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\System.Reactive.Core.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:58:40.016 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\System.Reactive.Interfaces.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:58:40.093 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\System.Reactive.Linq.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:58:40.115 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\System.Reflection.Metadata.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:58:40.155 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] User assembly ignored: C:\Users\amc-admin\Desktop\Debug\System.Threading.Tasks.Dataflow.dll
* Assembly does not contain any acceptable grain types.
* Assembly contains no types assignable from Orleans.Providers.IProvider.
[2016-04-25 22:58:40.159 GMT 1 WARNING 101705 AssemblyLoader.Silo 169.254.22.7:0] Unable to find directory C:\Users\amc-admin\Desktop\Debug\Applications; skipping.
[2016-04-25 22:58:40.160 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] Loading assembly C:\Users\amc-admin\Desktop\Debug\DracoFoundation.dll...
[2016-04-25 22:58:41.117 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] Loading assembly C:\Users\amc-admin\Desktop\Debug\OrleansProviders.dll...
[2016-04-25 22:58:41.130 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] Loading assembly C:\Users\amc-admin\Desktop\Debug\OrleansSQLUtils.dll...
[2016-04-25 22:58:41.167 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] Loading assembly C:\Users\amc-admin\Desktop\Debug\TestDriver.dll...
[2016-04-25 22:58:41.243 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] Loading assembly C:\Users\amc-admin\Desktop\Debug\VSMConnection.dll...
[2016-04-25 22:58:41.249 GMT 1 INFO 100000 AssemblyLoader.Silo 169.254.22.7:0] 5 assemblies loaded.
[2016-04-25 22:58:41.430 GMT 1 INFO 100000 Scheduler.OrleansTaskScheduler 169.254.22.7:0] Starting OrleansTaskScheduler with 4 Max Active application Threads and 1 system thread.
[2016-04-25 22:58:41.441 GMT 1 INFO 101010 Runtime.Messaging.IncomingMessageAcceptor 169.254.22.7:0] Opened a listening socket at address 169.254.22.7:52040
[2016-04-25 22:58:41.478 GMT 1 INFO 100000 VirtualBucketsRingProvider 169.254.22.7:0] Starting VirtualBucketsRingProvider on silo S169.254.22.7:52040:199321119/xDF3F438F.
[2016-04-25 22:58:41.524 GMT 1 INFO 103003 VirtualBucketsRingProvider 169.254.22.7:0] Added Server S169.254.22.7:52040:199321119/xDF3F438F. Current view: [S169.254.22.7:52040:199321119 -> <MultiRange: Size=x100000000, %Ring=100.000%>]
[2016-04-25 22:58:41.529 GMT 1 INFO 103005 VirtualBucketsRingProvider 169.254.22.7:0] -NotifyLocalRangeSubscribers about old <(0 0], Size=x100000000, %Ring=100.000%> new <MultiRange: Size=x100000000, %Ring=100.000%> increased? True
[2016-04-25 22:58:41.575 GMT 1 INFO 100294 SystemStatus 169.254.22.7:0] SystemStatus=Created
[2016-04-25 22:58:41.577 GMT 1 INFO 100422 Silo 169.254.22.7:0] -------------- Started silo S169.254.22.7:52040:199321119, ConsistentHashCode DF3F438F --------------
[2016-04-25 22:58:41.580 GMT 1 INFO 100441 OrleansSiloHost 169.254.22.7:0] Silo shutdown event name: DRACOCLUSTER-1-Shutdown
[2016-04-25 22:58:41.582 GMT 1 INFO 100442 OrleansSiloHost 169.254.22.7:0] Created and set shutdown event DRACOCLUSTER-1-Shutdown
[2016-04-25 22:58:41.593 GMT 1 INFO 100294 SystemStatus 169.254.22.7:0] SystemStatus=Starting
[2016-04-25 22:58:41.594 GMT 1 INFO 100401 Silo 169.254.22.7:0] Silo Start()
[2016-04-25 22:58:41.597 GMT 1 INFO 100430 Silo 169.254.22.7:0] Configured ThreadPool.SetMinThreads() to values: 200,200. Previous values are: 1,1.
[2016-04-25 22:58:41.598 GMT 1 INFO 100436 Silo 169.254.22.7:0] Configured .NET ServicePointManager to Expect100Continue=False, DefaultConnectionLimit=200, UseNagleAlgorithm=False to improve Azure storage performance.
[2016-04-25 22:58:41.647 GMT 1 INFO 101711 AssemblyLoader.Silo 169.254.22.7:0] Loaded grain type summary for 11 types:
Grain class Draco.Foundation.Draco.Foundation.VehicleGrain [-882752399 (0xCB624471)] from DracoFoundation.dll implementing interfaces: Draco.Interfaces.Draco.Interfaces.IVehicleGrain [-186200810 (0xF4E6CD16)]
Grain class Draco.Foundation.Draco.Foundation.VehicleManager [892960422 (0x35397EA6)] from DracoFoundation.dll implementing interfaces: Draco.Interfaces.Draco.Interfaces.IVehicleManager [9765603 (0x9502E3)], Draco.Utility.Draco.Utility.IGrainWithSingletonKey [-854559413 (0xCD10754B)]
Grain class Draco.Foundation.Draco.Foundation.VehicleTypeManager [-1451282848 (0xA97F2E60)] from DracoFoundation.dll implementing interfaces: Draco.Interfaces.Draco.Interfaces.IVehicleTypeManager [868096219 (0x33BE18DB)], Draco.Utility.Draco.Utility.IGrainWithSingletonKey [-854559413 (0xCD10754B)]
Grain class Draco.VSMConnection.Draco.VSMConnection.VSMDiscovery [-349437437 (0xEB2C0203)] from VSMConnection.dll implementing interfaces: Draco.VSMConnection.Draco.VSMConnection.IVSMDiscovery [-1019522468 (0xC33B525C)], Draco.Utility.Draco.Utility.IGrainWithSingletonKey [-854559413 (0xCD10754B)], Orleans.Orleans.IRemindable [-831689659 (0xCE6D6C45)]
Grain class Draco.VSMConnection.Draco.VSMConnection.VSMManager [-1479894192 (0xA7CA9B50)] from VSMConnection.dll implementing interfaces: Draco.Interfaces.Draco.Interfaces.IVSMManager [196364016 (0xBB446F0)]
Grain class Orleans.Runtime.Management.Orleans.Runtime.Management.ManagementGrain [1954798034 (0x7483D9D2)] from OrleansRuntime.dll implementing interfaces: Orleans.Runtime.Orleans.Runtime.IManagementGrain [-1734666656 (0x989B1660)]
Grain class Orleans.Runtime.MembershipService.Orleans.Runtime.MembershipService.GrainBasedMembershipTable [-2103923544 (0x8298ACA8)] from OrleansRuntime.dll implementing interfaces: Orleans.Orleans.IMembershipTableGrain [-1256503757 (0xB51B4633)]
Grain class Orleans.Runtime.ReminderService.Orleans.Runtime.ReminderService.GrainBasedReminderTable [-55315191 (0xFCB3F509)] from OrleansRuntime.dll implementing interfaces: Orleans.Orleans.IReminderTableGrain [-1135060418 (0xBC585A3E)]
Grain class Orleans.Storage.Orleans.Storage.MemoryStorageGrain [819348208 (0x30D642F0)] from OrleansRuntime.dll implementing interfaces: Orleans.Storage.Orleans.Storage.IMemoryStorageGrain [577125491 (0x22663C73)]
Grain class Orleans.Streams.Orleans.Streams.PubSubRendezvousGrain [1903070868 (0x716E8E94)] from OrleansRuntime.dll implementing interfaces: Orleans.Streams.Orleans.Streams.IPubSubRendezvousGrain [1746702088 (0x681C8F08)]
Grain class TestDriver.TestDriver.LoadTestGrain [456827097 (0x1B3AA0D9)] from TestDriver.dll implementing interfaces: TestDriver.TestDriver.ILoadTestGrain [-1097320062 (0xBE983982)], Draco.Utility.Draco.Utility.IGrainWithSingletonKey [-854559413 (0xCD10754B)]
[2016-04-25 22:58:41.693 GMT 10 INFO 100000 Runtime.Scheduler.WorkerPoolThread/System.5 169.254.22.7:0] Starting AsyncAgent Runtime.Scheduler.WorkerPoolThread/System.5 on managed thread 10
[2016-04-25 22:58:41.693 GMT 6 INFO 100000 Runtime.Scheduler.WorkerPoolThread/0 169.254.22.7:0] Starting AsyncAgent Runtime.Scheduler.WorkerPoolThread/0 on managed thread 6
[2016-04-25 22:58:41.701 GMT 7 INFO 100000 Runtime.Scheduler.WorkerPoolThread/1 169.254.22.7:0] Starting AsyncAgent Runtime.Scheduler.WorkerPoolThread/1 on managed thread 7
[2016-04-25 22:58:41.704 GMT 8 INFO 100000 Runtime.Scheduler.WorkerPoolThread/2 169.254.22.7:0] Starting AsyncAgent Runtime.Scheduler.WorkerPoolThread/2 on managed thread 8
[2016-04-25 22:58:41.704 GMT 9 INFO 100000 Runtime.Scheduler.WorkerPoolThread/3 169.254.22.7:0] Starting AsyncAgent Runtime.Scheduler.WorkerPoolThread/3 on managed thread 9
[2016-04-25 22:58:41.705 GMT 11 INFO 100000 Runtime.Messaging.IncomingMessageAcceptor 169.254.22.7:0] Starting AsyncAgent Runtime.Messaging.IncomingMessageAcceptor on managed thread 11
[2016-04-25 22:58:41.705 GMT 12 INFO 100000 Runtime.Messaging.SiloMessageSender/PingSender 169.254.22.7:0] Starting AsyncAgent Runtime.Messaging.SiloMessageSender/PingSender on managed thread 12
[2016-04-25 22:58:41.705 GMT 13 INFO 100000 Runtime.Messaging.SiloMessageSender/SystemSender 169.254.22.7:0] Starting AsyncAgent Runtime.Messaging.SiloMessageSender/SystemSender on managed thread 13
[2016-04-25 22:58:41.706 GMT 16 INFO 100000 Runtime.Messaging.IncomingMessageAgent/Ping 169.254.22.7:0] Starting AsyncAgent Runtime.Messaging.IncomingMessageAgent/Ping on managed thread 16
[2016-04-25 22:58:41.706 GMT 15 INFO 100000 Runtime.Messaging.IncomingMessageAgent/System 169.254.22.7:0] Starting AsyncAgent Runtime.Messaging.IncomingMessageAgent/System on managed thread 15
[2016-04-25 22:58:41.708 GMT 17 INFO 100000 Runtime.Messaging.IncomingMessageAgent/Application 169.254.22.7:0] Starting AsyncAgent Runtime.Messaging.IncomingMessageAgent/Application on managed thread 17
[2016-04-25 22:58:41.708 GMT 14 INFO 100000 Runtime.GrainDirectory.AdaptiveDirectoryCacheMaintainer`1 169.254.22.7:0] Starting AsyncAgent Runtime.GrainDirectory.AdaptiveDirectoryCacheMaintainer`1 on managed thread 14
[2016-04-25 22:58:41.723 GMT 1 INFO 100000 MembershipFactory 169.254.22.7:0] Creating membership oracle for type=SqlServer
[2016-04-25 22:58:41.746 GMT 11 INFO 100328 Runtime.Messaging.IncomingMessageAcceptor 169.254.22.7:0] Stopping AsyncAgent Runtime.Messaging.IncomingMessageAcceptor that runs on managed thread 11
[2016-04-25 22:58:41.766 GMT 1 INFO 100000 ReminderFactory 169.254.22.7:0] Creating reminder system target for type=SqlServer
[2016-04-25 22:58:41.817 GMT 10 INFO 100507 Catalog 169.254.22.7:0] Before collection#1: memory=17MB, #activations=0, collector=<#Activations=0, #Buckets=0, buckets=[]>.
[2016-04-25 22:58:41.831 GMT 6 INFO 103102 ProviderLoader/IStorageProvider 169.254.22.7:0] Loaded provider of type Orleans.Storage.MemoryStorage Name=PubSubStore
[2016-04-25 22:58:41.832 GMT 6 INFO 103102 ProviderLoader/IStorageProvider 169.254.22.7:0] Loaded provider of type Orleans.Storage.MemoryStorage Name=Default
[2016-04-25 22:58:41.845 GMT 6 INFO 0 Storage.MemoryStorage.1 169.254.22.7:0] Init: Name=PubSubStore NumStorageGrains=1
[2016-04-25 22:58:41.848 GMT 6 INFO 0 Storage.MemoryStorage.2 169.254.22.7:0] Init: Name=Default NumStorageGrains=10
[2016-04-25 22:58:41.853 GMT 6 INFO 103102 ProviderLoader/IStreamProviderImpl 169.254.22.7:0] Loaded provider of type Orleans.Providers.Streams.SimpleMessageStream.SimpleMessageStreamProvider Name=Default
[2016-04-25 22:58:41.860 GMT 6 INFO 0 SimpleMessageStreamProvider 169.254.22.7:0] Initialized SimpleMessageStreamProvider with name Default and with property FireAndForgetDelivery: False, OptimizeForImmutableData: True and PubSubType: ExplicitGrainBasedAndImplicit
[2016-04-25 22:58:41.931 GMT 10 INFO 100508 Catalog 169.254.22.7:0] After collection#1: memory=19MB, #activations=0, collected 0 activations, collector=<#Activations=0, #Buckets=0, buckets=[]>, collection time=00:00:00.1192953.
[2016-04-25 22:58:42.078 GMT 6 WARNING 101215 Scheduler.MembershipOracle.WorkItemGroup 169.254.22.7:0] Task [Id=225, Status=RanToCompletion] in WorkGroup [SystemTarget: S169.254.22.7:52040:199321119MembershipOracle@S0000000f] took elapsed time 0:00:00.2070367 for execution, which is longer than 00:00:00.2000000. Running on thread <Runtime.Scheduler.WorkerPoolThread/0, ManagedThreadId=6, Executing Task Id=225 Status=RanToCompletion for 00:00:00.2107931 on WorkItem=System*WorkItemGroup:Name=MembershipOracle,WorkGroupStatus=Running Executing for 00:00:00.2117953. .>
[2016-04-25 22:58:42.087 GMT 6 INFO 100603 MembershipOracle 169.254.22.7:0] MembershipOracle starting on host = DRACOCLUSTER-1 address = S169.254.22.7:52040:199321119 at 2016-04-25 22:58:41.753 GMT, backOffMax = 00:00:20
[2016-04-25 22:58:51.305 GMT 10 INFO 100652 MembershipOracle 169.254.22.7:0] -CleanupTable called on silo startup. Membership table 2 silos, 1 are Active, 1 are Dead, Version=<71, 71>. All silos: [SiloAddress=S169.254.22.7:51998:199321065 InstanceName= Status=Active, SiloAddress=S169.254.22.7:51954:199320984 InstanceName= Status=Dead]
[2016-04-25 22:58:51.389 GMT 10 INFO 100660 MembershipOracle 169.254.22.7:0] Starting IAmAliveUpdateTimer.
[2016-04-25 22:58:51.405 GMT 10 WARNING 101215 Scheduler.MembershipOracle.WorkItemGroup 169.254.22.7:0] Task [Id=307, Status=RanToCompletion] in WorkGroup [SystemTarget: S169.254.22.7:52040:199321119MembershipOracle@S0000000f] took elapsed time 0:00:00.2058428 for execution, which is longer than 00:00:00.2000000. Running on thread <Runtime.Scheduler.WorkerPoolThread/System.5, ManagedThreadId=10, Executing Task Id=307 Status=RanToCompletion for 00:00:00.1943722 on WorkItem=System*WorkItemGroup:Name=MembershipOracle,WorkGroupStatus=Running Executing for 00:00:00.1943722. .>
[2016-04-25 22:58:51.452 GMT 10 INFO 100604 MembershipOracle 169.254.22.7:0] -BecomeActive
[2016-04-25 22:58:51.467 GMT 10 INFO 100614 MembershipOracle 169.254.22.7:0] About to send pings to 1 nodes in order to validate communication in the Joining state. Pinged nodes = [[SiloAddress=S169.254.22.7:51998:199321065 InstanceName= Status=Active HostName=DRACOCLUSTER-1 ProxyPort=0 RoleName= UpdateZone=0 FaultZone=0 StartTime = 2016-04-25 22:57:47.890 GMT IAmAliveTime = 2016-04-25 22:57:56.617 GMT ]]
[2016-04-25 22:58:52.568 GMT 12 WARNING 101021 Runtime.Messaging.SiloMessageSender/PingSender 169.254.22.7:0] Exception getting a sending socket to endpoint S169.254.22.7:51998:199321065
Exc level 0: System.Net.Sockets.SocketException: No connection could be made because the target machine actively refused it 169.254.22.7:51998
at System.Net.Sockets.Socket.DoConnect(EndPoint endPointSnapshot, SocketAddress socketAddress)
at System.Net.Sockets.Socket.Connect(EndPoint remoteEP)
at Orleans.Runtime.SocketManager.SendingSocketCreator(IPEndPoint target)
at Orleans.Runtime.LRU`2.Get(TKey key)
at Orleans.Runtime.Messaging.SiloMessageSender.GetSendingSocket(Message msg, Socket& socket, SiloAddress& targetSilo, String& error)
[2016-04-25 22:58:52.615 GMT 10 WARNING 100613 MembershipOracle 169.254.22.7:0] -Did not get ping response for ping #0 from S169.254.22.7:51998:199321065. Reason = Original Exc Type: Orleans.Runtime.OrleansException Message:Silo S169.254.22.7:52040:199321119 is rejecting message: Request S169.254.22.7:52040:199321119MembershipOracle@S0000000f->S169.254.22.7:51998:199321065MembershipOracle@S0000000f #2: global::Orleans.Runtime.IMembershipService:Ping(). Reason = Exception getting a sending socket to endpoint S169.254.22.7:51998:199321065
[2016-04-25 22:58:54.414 GMT 10 INFO 100614 MembershipOracle 169.254.22.7:0] About to send pings to 1 nodes in order to validate communication in the Joining state. Pinged nodes = [[SiloAddress=S169.254.22.7:51998:199321065 InstanceName= Status=Active HostName=DRACOCLUSTER-1 ProxyPort=0 RoleName= UpdateZone=0 FaultZone=0 StartTime = 2016-04-25 22:57:47.890 GMT IAmAliveTime = 2016-04-25 22:57:56.617 GMT ]]
[2016-04-25 22:58:55.453 GMT 12 WARNING 101021 Runtime.Messaging.SiloMessageSender/PingSender 169.254.22.7:0] Exception getting a sending socket to endpoint S169.254.22.7:51998:199321065
Exc level 0: System.Net.Sockets.SocketException: No connection could be made because the target machine actively refused it 169.254.22.7:51998
at System.Net.Sockets.Socket.DoConnect(EndPoint endPointSnapshot, SocketAddress socketAddress)
at System.Net.Sockets.Socket.Connect(EndPoint remoteEP)
at Orleans.Runtime.SocketManager.SendingSocketCreator(IPEndPoint target)
at Orleans.Runtime.LRU`2.Get(TKey key)
at Orleans.Runtime.Messaging.SiloMessageSender.GetSendingSocket(Message msg, Socket& socket, SiloAddress& targetSilo, String& error)
[2016-04-25 22:58:55.453 GMT 10 WARNING 100613 MembershipOracle 169.254.22.7:0] -Did not get ping response for ping #1 from S169.254.22.7:51998:199321065. Reason = Original Exc Type: Orleans.Runtime.OrleansException Message:Silo S169.254.22.7:52040:199321119 is rejecting message: Request S169.254.22.7:52040:199321119MembershipOracle@S0000000f->S169.254.22.7:51998:199321065MembershipOracle@S0000000f #3: global::Orleans.Runtime.IMembershipService:Ping(). Reason = Exception getting a sending socket to endpoint S169.254.22.7:51998:199321065
[2016-04-25 22:58:56.976 GMT 10 INFO 100614 MembershipOracle 169.254.22.7:0] About to send pings to 1 nodes in order to validate communication in the Joining state. Pinged nodes = [[SiloAddress=S169.254.22.7:51998:199321065 InstanceName= Status=Active HostName=DRACOCLUSTER-1 ProxyPort=0 RoleName= UpdateZone=0 FaultZone=0 StartTime = 2016-04-25 22:57:47.890 GMT IAmAliveTime = 2016-04-25 22:57:56.617 GMT ]]
[2016-04-25 22:58:58.005 GMT 12 WARNING 101021 Runtime.Messaging.SiloMessageSender/PingSender 169.254.22.7:0] Exception getting a sending socket to endpoint S169.254.22.7:51998:199321065
Exc level 0: System.Net.Sockets.SocketException: No connection could be made because the target machine actively refused it 169.254.22.7:51998
at System.Net.Sockets.Socket.DoConnect(EndPoint endPointSnapshot, SocketAddress socketAddress)
at System.Net.Sockets.Socket.Connect(EndPoint remoteEP)
at Orleans.Runtime.SocketManager.SendingSocketCreator(IPEndPoint target)
at Orleans.Runtime.LRU`2.Get(TKey key)
at Orleans.Runtime.Messaging.SiloMessageSender.GetSendingSocket(Message msg, Socket& socket, SiloAddress& targetSilo, String& error)
[2016-04-25 22:58:58.020 GMT 10 WARNING 100613 MembershipOracle 169.254.22.7:0] -Did not get ping response for ping #2 from S169.254.22.7:51998:199321065. Reason = Original Exc Type: Orleans.Runtime.OrleansException Message:Silo S169.254.22.7:52040:199321119 is rejecting message: Request S169.254.22.7:52040:199321119MembershipOracle@S0000000f->S169.254.22.7:51998:199321065MembershipOracle@S0000000f #4: global::Orleans.Runtime.IMembershipService:Ping(). Reason = Exception getting a sending socket to endpoint S169.254.22.7:51998:199321065
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment