Skip to content

Instantly share code, notes, and snippets.

@arunapiravi

arunapiravi/gist:8e0ae6edd63de5356dfc

Created March 8, 2016 21:54
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save arunapiravi/8e0ae6edd63de5356dfc to your computer and use it in GitHub Desktop.
Save arunapiravi/8e0ae6edd63de5356dfc to your computer and use it in GitHub Desktop.
Download ZIP
Raw
gistfile1.txt
./testrunner -i INI_FILE.ini -t fts.stable_topology_fts.StableTopFTS.test_query_type,items=1000000,num_queries=100,query_types=match,match_phrase,dataset=wiki,cluster=D+F,F,index_retry=20,get-cbcollect-info=True,query_max_matches=10000
Test Input params:
{'num_queries': '100', 'logs_folder': '/root/workspace/perf-fts-indexing/logs/testrunner-16-Mar-08_12-52-34/test_1', 'query_types': 'match,match_phrase', 'items': '1000000', 'dataset': 'wiki', 'cluster_name': 'INI_FILE', 'cluster': 'D+F,F', 'query_max_matches': '10000', 'ini': 'INI_FILE.ini', 'case_number': 1, 'get-cbcollect-info': 'True', 'index_retry': '20', 'num_nodes': 2}
Run before suite setup for fts.stable_topology_fts.StableTopFTS.test_query_type
2016-03-08 12:52:34 | WARNING | MainProcess | MainThread | [data_helper.<module>] Can not import concurrent module. Data for each server will be loaded/retrieved sequentially
test_query_type (fts.stable_topology_fts.StableTopFTS) ... 2016-03-08 12:52:34 | INFO | MainProcess | test_thread | [fts_base.setUp] ==== FTSbasetests setup is started for test #1 test_query_type ====
2016-03-08 12:52:34 | INFO | MainProcess | test_thread | [fts_base.cleanup_cluster] removing nodes from cluster ...
2016-03-08 12:52:34 | INFO | MainProcess | test_thread | [fts_base.cleanup_cluster] cleanup [ip:172.23.123.38 port:8091 ssh_username:root]
2016-03-08 12:52:34 | INFO | MainProcess | test_thread | [bucket_helper.delete_all_buckets_or_assert] deleting existing buckets [] on 172.23.123.38
2016-03-08 12:52:34 | INFO | MainProcess | test_thread | [cluster_helper.wait_for_ns_servers_or_assert] waiting for ns_server @ 172.23.123.38:8091
2016-03-08 12:52:34 | INFO | MainProcess | test_thread | [cluster_helper.wait_for_ns_servers_or_assert] ns_server @ 172.23.123.38:8091 is running
2016-03-08 12:52:34 | INFO | MainProcess | test_thread | [fts_base.init_cluster] Initializing Cluster ...
2016-03-08 12:52:35 | INFO | MainProcess | Cluster_Thread | [rest_client.init_cluster] settings/web params on 172.23.123.38:8091:username=Administrator&password=password&port=8091
2016-03-08 12:52:35 | INFO | MainProcess | Cluster_Thread | [rest_client.init_cluster_memoryQuota] pools/default params : memoryQuota=68825
2016-03-08 12:52:35 | INFO | MainProcess | Cluster_Thread | [rest_client.set_indexer_storage_mode] settings/indexes params : storageMode=forestdb
2016-03-08 12:52:35 | INFO | MainProcess | test_thread | [fts_base.init_cluster] 172.23.123.40 will be configured with services fts
2016-03-08 12:52:36 | INFO | MainProcess | Cluster_Thread | [task.add_nodes] adding node 172.23.123.40:8091 to cluster
2016-03-08 12:52:36 | INFO | MainProcess | Cluster_Thread | [rest_client.add_node] adding remote node @172.23.123.40:8091 to this cluster @172.23.123.38:8091
2016-03-08 12:52:40 | INFO | MainProcess | Cluster_Thread | [rest_client.rebalance] rebalance params : password=password&ejectedNodes=&user=Administrator&knownNodes=ns_1%40172.23.123.40%2Cns_1%40172.23.123.38
2016-03-08 12:52:40 | INFO | MainProcess | Cluster_Thread | [rest_client.rebalance] rebalance operation started
2016-03-08 12:52:40 | INFO | MainProcess | Cluster_Thread | [rest_client._rebalance_progress] rebalance percentage : 0.00 %
2016-03-08 12:52:50 | INFO | MainProcess | Cluster_Thread | [task.check] rebalancing was completed with progress: 100% in 10.0233058929 sec
2016-03-08 12:52:51 | INFO | MainProcess | Cluster_Thread | [rest_client.create_bucket] http://172.23.123.38:8091/pools/default/buckets with param: bucketType=membase&evictionPolicy=valueOnly&threadsNumber=3&ramQuotaMB=68325&proxyPort=11211&authType=sasl&name=default&flushEnabled=1&replicaNumber=1&replicaIndex=1&saslPassword=None
2016-03-08 12:52:51 | INFO | MainProcess | Cluster_Thread | [rest_client.create_bucket] 0.01 seconds to create bucket default
2016-03-08 12:52:51 | INFO | MainProcess | Cluster_Thread | [bucket_helper.wait_for_memcached] waiting for memcached bucket : default in 172.23.123.38 to accept set ops
2016-03-08 12:52:52 | INFO | MainProcess | Cluster_Thread | [data_helper.direct_client] creating direct client 172.23.123.38:11210 default
2016-03-08 12:52:52 | INFO | MainProcess | Cluster_Thread | [data_helper.direct_client] creating direct client 172.23.123.38:11210 default
2016-03-08 12:52:53 | INFO | MainProcess | Cluster_Thread | [task.check] bucket 'default' was created with per node RAM quota: 68325
2016-03-08 12:52:53 | INFO | MainProcess | test_thread | [remote_util.__init__] connecting to 172.23.123.38 with username : root password : couchbase ssh_key:
2016-03-08 12:52:53 | INFO | MainProcess | test_thread | [remote_util.__init__] Connected to 172.23.123.38
2016-03-08 12:52:53 | INFO | MainProcess | test_thread | [rest_client.diag_eval] /diag/eval status on 172.23.123.38:8091: True content: "/opt/couchbase/var/lib/couchbase/logs" command: filename:absname(element(2, application:get_env(ns_server,error_logger_mf_dir))).
2016-03-08 12:52:54 | INFO | MainProcess | test_thread | [remote_util.execute_command_raw] running command.raw on 172.23.123.38: zgrep "panic:" "/opt/couchbase/var/lib/couchbase/logs"/fts.log* | wc -l
2016-03-08 12:52:54 | INFO | MainProcess | test_thread | [remote_util.execute_command_raw] command executed successfully
2016-03-08 12:52:54 | INFO | MainProcess | test_thread | [fts_base.check_fts_log] 0
2016-03-08 12:52:54 | INFO | MainProcess | test_thread | [remote_util.__init__] connecting to 172.23.123.40 with username : root password : couchbase ssh_key:
2016-03-08 12:52:55 | INFO | MainProcess | test_thread | [remote_util.__init__] Connected to 172.23.123.40
2016-03-08 12:52:55 | INFO | MainProcess | test_thread | [rest_client.diag_eval] /diag/eval status on 172.23.123.40:8091: True content: "/opt/couchbase/var/lib/couchbase/logs" command: filename:absname(element(2, application:get_env(ns_server,error_logger_mf_dir))).
2016-03-08 12:52:55 | INFO | MainProcess | test_thread | [remote_util.execute_command_raw] running command.raw on 172.23.123.40: zgrep "panic:" "/opt/couchbase/var/lib/couchbase/logs"/fts.log* | wc -l
2016-03-08 12:52:55 | INFO | MainProcess | test_thread | [remote_util.execute_command_raw] command executed successfully
2016-03-08 12:52:55 | INFO | MainProcess | test_thread | [fts_base.check_fts_log] 0
2016-03-08 12:52:55 | INFO | MainProcess | test_thread | [fts_base.__initialize_error_count_dict] {'172.23.123.40': {'panic:': 0}, '172.23.123.38': {'panic:': 0}}
2016-03-08 12:52:55 | INFO | MainProcess | test_thread | [fts_base.setUp] ==== FTSbasetests setup is finished for test #1 test_query_type ====
2016-03-08 12:53:55 | INFO | MainProcess | test_thread | [data_helper.direct_client] creating direct client 172.23.123.38:11210 default
2016-03-08 13:22:10 | INFO | MainProcess | test_thread | [fts_base.load_data] Loading phase complete!
2016-03-08 13:22:10 | INFO | MainProcess | test_thread | [fts_base.create] Checking if index already exists ...
2016-03-08 13:22:10 | ERROR | MainProcess | test_thread | [rest_client._http_request] http://172.23.123.38:8094/api/index/default_index error 403 reason: status: 403, content: rest_auth: preparePerm, err: index not found
rest_auth: preparePerm, err: index not found
2016-03-08 13:22:10 | ERROR | MainProcess | test_thread | [rest_client._http_request] http://172.23.123.38:8094/api/index/default_index error 403 reason: status: 403, content: rest_auth: preparePerm, err: index not found
rest_auth: preparePerm, err: index not found
2016-03-08 13:22:10 | INFO | MainProcess | test_thread | [fts_base.create] Creating fulltext-index default_index on 172.23.123.38
2016-03-08 13:22:10 | INFO | MainProcess | test_thread | [rest_client.create_fts_index] {"params": {"mapping": {"default_field": "_all", "default_analyzer": "simple", "analysis": {}, "default_datetime_parser": "dateTimeOptional", "default_mapping": {"default_analyzer": "", "dynamic": true, "enabled": true}, "type_field": "type", "byte_array_converter": "json", "default_type": "_default"}, "store": {"kvStoreName": "forestdb"}}, "name": "default_index", "planParams": {"hierarchyRules": null, "nodePlanParams": null, "numReplicas": 0, "planFrozen": false, "maxPartitionsPerPIndex": 32}, "sourceName": "default", "sourceUUID": "", "sourceType": "couchbase", "type": "fulltext-index", "sourceParams": {"authUser": "default", "dataManagerSleepMaxMS": 20000, "authSaslUser": "", "clusterManagerSleepMaxMS": 20000, "authSaslPassword": "", "clusterManagerSleepInitMS": 0, "dataManagerBackoffFactor": 0, "authPassword": "", "dataManagerSleepInitMS": 0, "feedBufferAckThreshold": 0, "feedBufferSizeBytes": 0, "clusterManagerBackoffFactor": 0}, "uuid": ""}
2016-03-08 13:22:10 | INFO | MainProcess | test_thread | [rest_client.create_fts_index] Index default_index created
2016-03-08 13:22:10 | INFO | MainProcess | test_thread | [fts_base.sleep] sleep for 5 secs. No pindexes found, waiting for index to get created ...
2016-03-08 13:22:16 | INFO | MainProcess | test_thread | [fts_base.is_index_partitioned_balanced] Validated: Number of PIndexes = 32
2016-03-08 13:22:16 | INFO | MainProcess | test_thread | [fts_base.is_index_partitioned_balanced] Validated: Every pIndex serves 32 partitions or lesser
2016-03-08 13:22:16 | INFO | MainProcess | test_thread | [fts_base.is_index_partitioned_balanced] Validated: pIndexes are distributed across [u'468bb12777fefa891df7a2188d138ebf', u'4852af1e95f6c69d49a6c9cd2b85f3c4']
2016-03-08 13:22:16 | INFO | MainProcess | test_thread | [fts_base.is_index_partitioned_balanced] Expecting num of partitions in each node in range 480-544
2016-03-08 13:22:16 | INFO | MainProcess | test_thread | [fts_base.is_index_partitioned_balanced] Validated: Node 468bb12777fefa891df7a2188d138ebf houses 16 pindexes which serve 512 partitions
2016-03-08 13:22:16 | INFO | MainProcess | test_thread | [fts_base.is_index_partitioned_balanced] Validated: Node 4852af1e95f6c69d49a6c9cd2b85f3c4 houses 16 pindexes which serve 512 partitions
2016-03-08 13:22:16 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 1944
2016-03-08 13:22:26 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 10702
2016-03-08 13:22:36 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 20481
2016-03-08 13:22:47 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 30224
2016-03-08 13:22:57 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 38989
2016-03-08 13:23:07 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 47767
2016-03-08 13:23:17 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 56526
2016-03-08 13:23:27 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 67232
2016-03-08 13:23:38 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 76045
2016-03-08 13:23:48 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 83856
2016-03-08 13:23:58 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 94563
2016-03-08 13:24:08 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 103335
2016-03-08 13:24:19 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 114084
2016-03-08 13:24:29 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 122866
2016-03-08 13:24:39 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 132646
2016-03-08 13:24:49 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 141428
2016-03-08 13:24:59 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 150209
2016-03-08 13:25:10 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 159968
2016-03-08 13:25:20 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 169763
2016-03-08 13:25:30 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 177614
2016-03-08 13:25:40 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 187416
2016-03-08 13:25:51 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 196201
2016-03-08 13:26:01 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 204999
2016-03-08 13:26:11 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 214740
2016-03-08 13:26:21 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 224527
2016-03-08 13:26:31 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 234283
2016-03-08 13:26:42 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 243073
2016-03-08 13:26:52 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 252848
2016-03-08 13:27:02 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 262610
2016-03-08 13:27:12 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 271397
2016-03-08 13:27:23 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 280199
2016-03-08 13:27:33 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 289995
2016-03-08 13:27:43 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 298760
2016-03-08 13:27:53 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 308488
2016-03-08 13:28:03 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 317260
2016-03-08 13:28:14 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 326053
2016-03-08 13:28:24 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 335839
2016-03-08 13:28:34 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 344636
2016-03-08 13:28:44 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 354409
2016-03-08 13:28:54 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 363168
2016-03-08 13:29:05 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 371926
2016-03-08 13:29:15 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 382691
2016-03-08 13:29:25 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 390551
2016-03-08 13:29:35 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 398358
2016-03-08 13:29:45 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 408098
2016-03-08 13:29:56 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 416903
2016-03-08 13:30:06 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 425692
2016-03-08 13:30:16 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 433519
2016-03-08 13:30:26 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 442288
2016-03-08 13:30:37 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 451106
2016-03-08 13:30:47 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 457953
2016-03-08 13:30:57 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 465739
2016-03-08 13:31:07 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 473560
2016-03-08 13:31:17 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 480413
2016-03-08 13:31:28 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 489216
2016-03-08 13:31:38 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 497031
2016-03-08 13:31:48 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 504830
2016-03-08 13:31:58 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 513617
2016-03-08 13:32:09 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 520475
2016-03-08 13:32:19 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 528315
2016-03-08 13:32:29 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 536117
2016-03-08 13:32:40 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 542953
2016-03-08 13:32:50 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 550696
2016-03-08 13:33:00 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 554595
2016-03-08 13:33:10 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 559483
2016-03-08 13:33:21 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 562420
2016-03-08 13:33:31 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 567318
2016-03-08 13:33:41 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 571229
2016-03-08 13:33:51 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 576095
2016-03-08 13:34:01 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 579977
2016-03-08 13:34:12 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 584855
2016-03-08 13:34:22 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 588758
2016-03-08 13:34:32 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 591694
2016-03-08 13:34:42 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 596579
2016-03-08 13:34:52 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 600489
2016-03-08 13:35:03 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 604405
2016-03-08 13:35:13 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 609287
2016-03-08 13:35:23 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 613195
2016-03-08 13:35:34 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 617127
2016-03-08 13:35:44 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 621016
2016-03-08 13:35:54 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 624902
2016-03-08 13:36:04 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 628831
2016-03-08 13:36:14 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 633714
2016-03-08 13:36:25 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 637601
2016-03-08 13:36:35 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 641521
2016-03-08 13:36:45 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 645406
2016-03-08 13:36:55 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 649296
2016-03-08 13:37:06 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 653230
2016-03-08 13:37:16 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 657170
2016-03-08 13:37:26 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 662051
2016-03-08 13:37:36 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 665962
2016-03-08 13:37:46 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 669871
2016-03-08 13:37:57 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 673787
2016-03-08 13:38:07 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 677700
2016-03-08 13:38:17 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 681590
2016-03-08 13:38:27 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 685515
2016-03-08 13:38:37 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 689425
2016-03-08 13:38:48 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 694271
2016-03-08 13:38:58 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 698170
2016-03-08 13:39:08 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 702116
2016-03-08 13:39:18 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 706966
2016-03-08 13:39:28 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 710863
2016-03-08 13:39:39 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 714768
2016-03-08 13:39:49 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 717692
2016-03-08 13:39:59 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 721607
2016-03-08 13:40:10 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 725516
2016-03-08 13:40:20 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 730429
2016-03-08 13:40:30 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 734322
2016-03-08 13:40:40 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 738241
2016-03-08 13:40:50 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 741181
2016-03-08 13:41:01 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 744123
2016-03-08 13:41:11 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 749010
2016-03-08 13:41:21 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 752903
2016-03-08 13:41:31 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 756780
2016-03-08 13:41:42 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 759698
2016-03-08 13:41:52 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 763594
2016-03-08 13:42:02 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 767510
2016-03-08 13:42:12 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 771392
2016-03-08 13:42:22 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 775301
2016-03-08 13:42:33 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 779223
2016-03-08 13:42:43 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 782151
2016-03-08 13:42:53 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 787025
2016-03-08 13:43:03 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 789970
2016-03-08 13:43:14 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 793866
2016-03-08 13:43:24 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 798736
2016-03-08 13:43:34 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 802662
2016-03-08 13:43:44 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 805576
2016-03-08 13:43:55 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 805576
2016-03-08 13:44:05 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 805576
2016-03-08 13:44:15 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 805576
2016-03-08 13:44:25 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 805576
2016-03-08 13:44:35 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 805576
2016-03-08 13:44:46 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 805576
2016-03-08 13:44:56 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 805576
2016-03-08 13:45:06 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 805576
2016-03-08 13:45:16 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 805576
2016-03-08 13:45:26 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 805576
2016-03-08 13:45:36 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 805576
2016-03-08 13:45:47 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 805576
2016-03-08 13:45:57 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 805576
2016-03-08 13:46:07 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 805576
2016-03-08 13:46:17 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 805576
2016-03-08 13:46:27 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 805576
2016-03-08 13:46:38 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 805576
2016-03-08 13:46:48 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 805576
2016-03-08 13:46:58 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 805576
2016-03-08 13:47:08 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] Docs in bucket = 1000000, docs in FTS index 'default_index': 805576
2016-03-08 13:47:18 | INFO | MainProcess | test_thread | [fts_base.wait_for_indexing_complete] FTS indexed 805576 docs in 25.05 mins
2016-03-08 13:47:19 | INFO | MainProcess | Cluster_Thread | [task.execute] ------------------------------------------------------------------ Query # 1 -----------------------------------------------------------------
2016-03-08 13:47:19 | INFO | MainProcess | Cluster_Thread | [fts_base.run_fts_query] Running query {"from": 0, "indexName": "default_index", "fields": [], "explain": false, "ctl": {"timeout": 0, "consistency": {"vectors": {}, "level": ""}}, "query": {"field": "revision.text.#text", "match_phrase": "Bielefeld"}, "size": 10000} on node: 172.23.123.40
2016-03-08 13:48:19 | ERROR | MainProcess | Cluster_Thread | [rest_client._http_request] socket error while connecting to http://172.23.123.40:8094/api/index/default_index/query error timed out
2016-03-08 13:48:19 | ERROR | MainProcess | Cluster_Thread | [task.execute] ERROR: FTS Query timed out (timeout=30s)!
2016-03-08 13:48:19 | INFO | MainProcess | Cluster_Thread | [task.execute] ------------------------------------------------------------------ Query # 2 -----------------------------------------------------------------
2016-03-08 13:48:19 | INFO | MainProcess | Cluster_Thread | [fts_base.run_fts_query] Running query {"from": 0, "indexName": "default_index", "fields": [], "explain": false, "ctl": {"timeout": 0, "consistency": {"vectors": {}, "level": ""}}, "query": {"field": "type", "match": "emp"}, "size": 10000} on node: 172.23.123.38
2016-03-08 13:49:19 | ERROR | MainProcess | Cluster_Thread | [rest_client._http_request] socket error while connecting to http://172.23.123.38:8094/api/index/default_index/query error timed out
2016-03-08 13:49:19 | ERROR | MainProcess | Cluster_Thread | [task.execute] ERROR: FTS Query timed out (timeout=30s)!
2016-03-08 13:49:19 | INFO | MainProcess | Cluster_Thread | [task.execute] ------------------------------------------------------------------ Query # 3 -----------------------------------------------------------------
2016-03-08 13:49:19 | INFO | MainProcess | Cluster_Thread | [fts_base.run_fts_query] Running query {"from": 0, "indexName": "default_index", "fields": [], "explain": false, "ctl": {"timeout": 0, "consistency": {"vectors": {}, "level": ""}}, "query": {"field": "type", "match": "emp"}, "size": 10000} on node: 172.23.123.38
2016-03-08 13:50:19 | ERROR | MainProcess | Cluster_Thread | [rest_client._http_request] socket error while connecting to http://172.23.123.38:8094/api/index/default_index/query error timed out
2016-03-08 13:50:19 | ERROR | MainProcess | Cluster_Thread | [task.execute] ERROR: FTS Query timed out (timeout=30s)!
2016-03-08 13:50:19 | INFO | MainProcess | Cluster_Thread | [task.execute] ------------------------------------------------------------------ Query # 4 -----------------------------------------------------------------
2016-03-08 13:50:19 | INFO | MainProcess | Cluster_Thread | [fts_base.run_fts_query] Running query {"from": 0, "indexName": "default_index", "fields": [], "explain": false, "ctl": {"timeout": 0, "consistency": {"vectors": {}, "level": ""}}, "query": {"field": "title", "match_phrase": "Charcoal"}, "size": 10000} on node: 172.23.123.40
2016-03-08 13:51:19 | ERROR | MainProcess | Cluster_Thread | [rest_client._http_request] socket error while connecting to http://172.23.123.40:8094/api/index/default_index/query error timed out
2016-03-08 13:51:19 | ERROR | MainProcess | Cluster_Thread | [task.execute] ERROR: FTS Query timed out (timeout=30s)!
2016-03-08 13:51:19 | INFO | MainProcess | Cluster_Thread | [task.execute] ------------------------------------------------------------------ Query # 5 -----------------------------------------------------------------
2016-03-08 13:51:19 | INFO | MainProcess | Cluster_Thread | [fts_base.run_fts_query] Running query {"from": 0, "indexName": "default_index", "fields": [], "explain": false, "ctl": {"timeout": 0, "consistency": {"vectors": {}, "level": ""}}, "query": {"field": "title", "match_phrase": "Poppy"}, "size": 10000} on node: 172.23.123.38
2016-03-08 13:52:20 | ERROR | MainProcess | Cluster_Thread | [rest_client._http_request] socket error while connecting to http://172.23.123.38:8094/api/index/default_index/query error timed out
2016-03-08 13:52:20 | ERROR | MainProcess | Cluster_Thread | [task.execute] ERROR: FTS Query timed out (timeout=30s)!
2016-03-08 13:52:20 | INFO | MainProcess | Cluster_Thread | [task.execute] ------------------------------------------------------------------ Query # 6 -----------------------------------------------------------------
2016-03-08 13:52:20 | INFO | MainProcess | Cluster_Thread | [fts_base.run_fts_query] Running query {"from": 0, "indexName": "default_index", "fields": [], "explain": false, "ctl": {"timeout": 0, "consistency": {"vectors": {}, "level": ""}}, "query": {"field": "revision.text.#text", "match_phrase": "Template:Country data Hong Kong"}, "size": 10000} on node: 172.23.123.40
Build was aborted
Aborted by Aruna Piravi
Finished: ABORTED
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment