server1.log

2014-02-24 13:54:38:035 INFO URL=plocal:/Users/luca/work/dev/orientechnologies/orientdb/misc/servers/1/databases/platform [OrientDBCluster]

2014-02-24 13:54:38:037 INFO Starting EXECUTE test against database plocal:/Users/luca/work/dev/orientechnologies/orientdb/misc/servers/1/databases/platform count = 10000 [OrientDBCluster]Current directory: /Users/luca/work/dev/orientechnologies/orientdb/misc/.

2014-02-24 13:54:39:335 INFO Loading configuration from input stream [OServerConfigurationLoaderXml]
2014-02-24 13:54:39:539 INFO OrientDB Server v1.7-rc2-SNAPSHOT is starting up... [OServer]
2014-02-24 13:54:39:549 INFO Databases directory: /Users/luca/work/dev/orientechnologies/orientdb/misc/servers/1/databases [OServer]
2014-02-24 13:54:39:582 INFO Port 0.0.0.0:2424 busy, trying the next available... [OServerNetworkListener]
2014-02-24 13:54:39:583 INFO Listening binary connections on 0.0.0.0:2425 (protocol v.20) [OServerNetworkListener]
2014-02-24 13:54:39:583 INFO Port 0.0.0.0:2480 busy, trying the next available... [OServerNetworkListener]
2014-02-24 13:54:39:584 INFO Listening http connections on 0.0.0.0:2481 (protocol v.10) [OServerNetworkListener]
2014-02-24 13:54:39:615 INFO Starting distributed server 'europe1'... [OHazelcastPlugin]
2014-02-24 13:54:39:631 INFO Configuring Hazelcast from '/Users/luca/work/dev/orientechnologies/orientdb/misc/src/test/resources/hazelcast-1.xml'. [FileSystemXmlConfig]
2014-02-24 13:54:39:860 INFO Interfaces is disabled, trying to pick one address from TCP-IP config addresses: [127.0.0.1] [DefaultAddressPicker]
2014-02-24 13:54:39:874 INFO Picked Address[127.0.0.1]:2435, using socket ServerSocket[addr=/0:0:0:0:0:0:0:0,localport=2435], bind any local is true [DefaultAddressPicker]
2014-02-24 13:54:40:004 INFO [127.0.0.1]:2435 [orientdb] Hazelcast Community Edition 3.1 (20131011) starting at Address[127.0.0.1]:2435 [system]
2014-02-24 13:54:40:004 INFO [127.0.0.1]:2435 [orientdb] Copyright (C) 2008-2013 Hazelcast.com [system]
2014-02-24 13:54:40:007 INFO [127.0.0.1]:2435 [orientdb] Creating TcpIpJoiner [Node]
2014-02-24 13:54:40:008 INFO [127.0.0.1]:2435 [orientdb] Address[127.0.0.1]:2435 is STARTING [LifecycleService]
2014-02-24 13:54:40:078 INFO [127.0.0.1]:2435 [orientdb] Connecting to possible member: Address[127.0.0.1]:2436 [TcpIpJoiner]
2014-02-24 13:54:40:081 INFO [127.0.0.1]:2435 [orientdb] Connecting to possible member: Address[127.0.0.1]:2437 [TcpIpJoiner]
2014-02-24 13:54:40:081 INFO [127.0.0.1]:2435 [orientdb] Connecting to possible member: Address[127.0.0.1]:2434 [TcpIpJoiner]
2014-02-24 13:54:40:083 INFO [127.0.0.1]:2435 [orientdb] Connecting to /127.0.0.1:2434, timeout: 0, bind-any: true [SocketConnector]
2014-02-24 13:54:40:083 INFO [127.0.0.1]:2435 [orientdb] Connecting to /127.0.0.1:2436, timeout: 0, bind-any: true [SocketConnector]
2014-02-24 13:54:40:083 INFO [127.0.0.1]:2435 [orientdb] Connecting to /127.0.0.1:2437, timeout: 0, bind-any: true [SocketConnector]
2014-02-24 13:54:40:085 INFO [127.0.0.1]:2435 [orientdb] Could not connect to: /127.0.0.1:2437. Reason: SocketException[Connection refused to address /127.0.0.1:2437] [SocketConnector]
2014-02-24 13:54:40:085 INFO [127.0.0.1]:2435 [orientdb] Could not connect to: /127.0.0.1:2436. Reason: SocketException[Connection refused to address /127.0.0.1:2436] [SocketConnector]
2014-02-24 13:54:40:092 INFO [127.0.0.1]:2435 [orientdb] 51679 accepted socket connection from /127.0.0.1:2434 [TcpIpConnectionManager]
2014-02-24 13:54:46:103 INFO [127.0.0.1]:2435 [orientdb] 

Members [2] {
	Member [127.0.0.1]:2434
	Member [127.0.0.1]:2435 this
}
 [ClusterService]
2014-02-24 13:54:48:112 INFO [127.0.0.1]:2435 [orientdb] Hazelcast JMX agent enabled. [ManagementService]
2014-02-24 13:54:48:198 INFO [127.0.0.1]:2435 [orientdb] Address[127.0.0.1]:2435 is STARTED [LifecycleService]
2014-02-24 13:54:48:290 INFO [europe1] loaded database configuration from active cluster [OHazelcastPlugin]
2014-02-24 13:54:48:299 INFO updated distributed configuration for database: platform:
----------
{
  "version":1,
  "replication":true,
  "autoDeploy":true,
  "hotAlignment":false,
  "resyncEvery":0,"clusters":{
    "internal":{
  "replication":false
},
    "index":{
  "replication":false
},
    "*":{
  "replication":true,
  "readQuorum":1,
  "writeQuorum":2,
  "failureAvailableNodesLessQuorum":false,
  "readYourWrites":true,"partitioning":{
    "strategy":"round-robin",
    "default":0,
    "partitions":[["<NEW_NODE>","europe0"]]
    }
}
    }
}
---------- [OHazelcastPlugin]
2014-02-24 13:54:48:302 INFO [europe1] received added status europe1.platform=OFFLINE [OHazelcastPlugin]
2014-02-24 13:54:48:302 INFO [europe1] adding node 'europe1' in partition: db=platform [*.0] [OHazelcastDistributedDatabase]
2014-02-24 13:54:48:304 INFO updated distributed configuration for database: platform:
----------
{
  "version":2,
  "replication":true,
  "autoDeploy":true,
  "hotAlignment":false,
  "resyncEvery":0,"clusters":{
    "internal":{
  "replication":false
},
    "index":{
  "replication":false
},
    "*":{
  "replication":true,
  "readQuorum":1,
  "writeQuorum":2,
  "failureAvailableNodesLessQuorum":false,
  "readYourWrites":true,"partitioning":{
    "strategy":"round-robin",
    "default":0,
    "partitions":[["<NEW_NODE>","europe0","europe1"]]
    }
}
    }
}
---------- [OHazelcastPlugin]
2014-02-24 13:54:48:304 INFO Saving distributed configuration file for database 'platform' to: /Users/luca/work/dev/orientechnologies/orientdb/misc/servers/1/databases/platform/distributed-config.json [OHazelcastPlugin]
2014-02-24 13:54:51:123 INFO [europe1]<-[europe0] received updated status europe0.platform=SYNCHRONIZING [OHazelcastPlugin]
2014-02-24 13:54:51:551 INFO [europe1]<-[europe0] received updated status europe0.platform=ONLINE [OHazelcastPlugin]
2014-02-24 13:54:51:569 INFO [europe1]<-[europe0] copying remote database 'platform' to: /var/folders/zc/y34429014c3bt_x1587qblth0000gn/T//orientdb/install_platform.zip [OHazelcastPlugin]
2014-02-24 13:54:51:569 WARN [europe1] - writing chunk #1 offset=0 size=1024,00Kb [OHazelcastPlugin]
2014-02-24 13:54:51:584 WARN [europe1] - writing chunk #2 offset=1048576 size=95,31Kb [OHazelcastPlugin]
2014-02-24 13:54:51:584 INFO [europe1] database copied correctly, size=1,09Mb [OHazelcastPlugin]
2014-02-24 13:54:51:584 WARN [europe1]<-[europe0] installing database 'platform' to: /Users/luca/work/dev/orientechnologies/orientdb/misc/servers/1/databases/platform... [OHazelcastPlugin]
2014-02-24 13:54:51:659 INFO - Uncompressing file database.ocf... [OHazelcastPlugin]
2014-02-24 13:54:51:660 INFO - Uncompressing file default.cpm... [OHazelcastPlugin]
2014-02-24 13:54:51:660 INFO - Uncompressing file default.pcl... [OHazelcastPlugin]
2014-02-24 13:54:51:661 INFO - Uncompressing file dictionary.sbt... [OHazelcastPlugin]
2014-02-24 13:54:51:661 INFO - Uncompressing file distributed-config.json... [OHazelcastPlugin]
2014-02-24 13:54:51:662 INFO - Uncompressing file id_pk.sbt... [OHazelcastPlugin]
2014-02-24 13:54:51:689 INFO - Uncompressing file index.cpm... [OHazelcastPlugin]
2014-02-24 13:54:51:689 INFO - Uncompressing file index.pcl... [OHazelcastPlugin]
2014-02-24 13:54:51:690 INFO - Uncompressing file internal.cpm... [OHazelcastPlugin]
2014-02-24 13:54:51:691 INFO - Uncompressing file internal.pcl... [OHazelcastPlugin]
2014-02-24 13:54:51:691 INFO - Uncompressing file manindex.cpm... [OHazelcastPlugin]
2014-02-24 13:54:51:692 INFO - Uncompressing file manindex.pcl... [OHazelcastPlugin]
2014-02-24 13:54:51:693 INFO - Uncompressing file name_id_map.cm... [OHazelcastPlugin]
2014-02-24 13:54:51:693 INFO - Uncompressing file Name_Index.irs... [OHazelcastPlugin]
2014-02-24 13:54:51:693 INFO - Uncompressing file Name_Index.sbt... [OHazelcastPlugin]
2014-02-24 13:54:51:697 INFO - Uncompressing file ofunction.cpm... [OHazelcastPlugin]
2014-02-24 13:54:51:697 INFO - Uncompressing file ofunction.pcl... [OHazelcastPlugin]
2014-02-24 13:54:51:698 INFO - Uncompressing file orids.cpm... [OHazelcastPlugin]
2014-02-24 13:54:51:698 INFO - Uncompressing file orids.pcl... [OHazelcastPlugin]
2014-02-24 13:54:51:698 INFO - Uncompressing file orole.cpm... [OHazelcastPlugin]
2014-02-24 13:54:51:699 INFO - Uncompressing file ORole.name.sbt... [OHazelcastPlugin]
2014-02-24 13:54:51:699 INFO - Uncompressing file orole.pcl... [OHazelcastPlugin]
2014-02-24 13:54:51:700 INFO - Uncompressing file oschedule.cpm... [OHazelcastPlugin]
2014-02-24 13:54:51:700 INFO - Uncompressing file oschedule.pcl... [OHazelcastPlugin]
2014-02-24 13:54:51:701 INFO - Uncompressing file ouser.cpm... [OHazelcastPlugin]
2014-02-24 13:54:51:702 INFO - Uncompressing file OUser.name.sbt... [OHazelcastPlugin]
2014-02-24 13:54:51:702 INFO - Uncompressing file ouser.pcl... [OHazelcastPlugin]
2014-02-24 13:54:51:703 INFO - Uncompressing file person.cpm... [OHazelcastPlugin]
2014-02-24 13:54:51:704 INFO - Uncompressing file person.pcl... [OHazelcastPlugin]
2014-02-24 13:54:51:730 INFO - Uncompressing file platform.wmr... [OHazelcastPlugin]
2014-02-24 13:54:51:730 INFO [europe1] installed database 'platform' [OHazelcastPlugin]
2014-02-24 13:54:51:760 WARN Can not restore 1 WAL master record for storage platform [OWriteAheadLog]
2014-02-24 13:54:51:806 WARN Current implementation of storage does not support sbtree collections [ODatabaseRecordAbstract$1]
2014-02-24 13:54:52:043 WARN Current implementation of storage does not support sbtree collections [ODatabaseRecordAbstract$1]
2014-02-24 13:54:52:049 INFO [europe1] Publishing online status for database europe1.platform... [OHazelcastDistributedDatabase]
2014-02-24 13:54:52:050 INFO [europe1] received updated status europe1.platform=ONLINE [OHazelcastPlugin]
2014-02-24 13:54:52:050 INFO [europe1] Database europe1.platform is online, waking up listeners on local node... [OHazelcastDistributedDatabase]
2014-02-24 13:54:52:051 WARN [europe1] database 'platform' is online [OHazelcastPlugin]
2014-02-24 13:54:52:051 WARN [europe1] updated node status to 'ONLINE' [OHazelcastPlugin]
2014-02-24 13:54:52:054 INFO OrientDB Server v1.7-rc2-SNAPSHOT is active. [OServer]
2014-02-24 13:54:52:057 WARN Current implementation of storage does not support sbtree collections [ODatabaseRecordAbstract$1]
2014-02-24 13:54:52:109 INFO  [OrientDBCluster]
2014-02-24 13:54:52:109 INFO  [OrientDBCluster]
2014-02-24 13:54:52:109 INFO Hit return to start test [OrientDBCluster]
2014-02-24 13:54:52:109 INFO  [OrientDBCluster]
2014-02-24 13:54:52:112 INFO Starting Writer... [OrientDBCluster]
2014-02-24 13:54:52:112 INFO Starting Writer... [OrientDBCluster]
2014-02-24 13:54:52:112 INFO Starting Writer... [OrientDBCluster]
2014-02-24 13:54:52:113 INFO Starting Reader... [OrientDBCluster]
2014-02-24 13:54:52:113 INFO Starting Writer... [OrientDBCluster]
2014-02-24 13:54:52:113 INFO Starting Writer... [OrientDBCluster]
2014-02-24 13:54:52:114 WARN Current implementation of storage does not support sbtree collections [ODatabaseRecordAbstract$1]
2014-02-24 13:54:52:118 WARN Current implementation of storage does not support sbtree collections [ODatabaseRecordAbstract$1]
2014-02-24 13:54:52:124 WARN Current implementation of storage does not support sbtree collections [ODatabaseRecordAbstract$1]
2014-02-24 13:54:52:128 WARN Current implementation of storage does not support sbtree collections [ODatabaseRecordAbstract$1]
2014-02-24 13:54:52:165 INFO Count(/Users/luca/work/dev/orientechnologies/orientdb/misc): {count:12953} counting class: 12954 counting cluster: 12954 [OrientDBCluster]
2014-02-24 13:54:52:167 WARN Current implementation of storage does not support sbtree collections [ODatabaseRecordAbstract$1]
2014-02-24 13:54:53:166 INFO Count(/Users/luca/work/dev/orientechnologies/orientdb/misc): {count:13035} counting class: 13035 counting cluster: 13035 [OrientDBCluster]
2014-02-24 13:54:54:168 INFO Count(/Users/luca/work/dev/orientechnologies/orientdb/misc): {count:13125} counting class: 13125 counting cluster: 13125 [OrientDBCluster]
2014-02-24 13:54:55:169 INFO Count(/Users/luca/work/dev/orientechnologies/orientdb/misc): {count:13245} counting class: 13245 counting cluster: 13245 [OrientDBCluster]
2014-02-24 13:54:56:170 INFO Count(/Users/luca/work/dev/orientechnologies/orientdb/misc): {count:13405} counting class: 13405 counting cluster: 13405 [OrientDBCluster]
2014-02-24 13:54:57:172 INFO Count(/Users/luca/work/dev/orientechnologies/orientdb/misc): {count:13595} counting class: 13595 counting cluster: 13595 [OrientDBCluster]
2014-02-24 13:54:58:173 INFO Count(/Users/luca/work/dev/orientechnologies/orientdb/misc): {count:13815} counting class: 13815 counting cluster: 13815 [OrientDBCluster]
2014-02-24 13:54:59:175 INFO Count(/Users/luca/work/dev/orientechnologies/orientdb/misc): {count:14070} counting class: 14070 counting cluster: 14070 [OrientDBCluster]
2014-02-24 13:55:00:176 INFO Count(/Users/luca/work/dev/orientechnologies/orientdb/misc): {count:14318} counting class: 14318 counting cluster: 14318 [OrientDBCluster]
2014-02-24 13:55:01:178 INFO Count(/Users/luca/work/dev/orientechnologies/orientdb/misc): {count:14596} counting class: 14596 counting cluster: 14596 [OrientDBCluster]
2014-02-24 13:55:02:179 INFO Count(/Users/luca/work/dev/orientechnologies/orientdb/misc): {count:14856} counting class: 14856 counting cluster: 14856 [OrientDBCluster]