Hello All,
Hope you are doing great!.
I have tried Ignite's REST API via postman. It is not throwing any errors,
but the response json's value part has nothing in it.
Here I am pasting cache config (piece of xml file), bean class and main
class where I am saving the sparkRDD to cache. Also, the attached document
has REST requests and responses along with respective logs.
As the Spark RDD/ DF I am using has more columns, i have created scala bean
class so that I can save it on to IgniteCache as Key, Value.
Ignite server and clients are able to talk to each other. Cache is created
and loaded successfully.
So far so good, trouble started when I am trying to trigger from REST API
(the attached notepad has REST APIs i tried to test and their response).
1) Though the Bean class I created has 8 columns - the cache created has
only 7 columns, what happened to final one? [even "*cache -c=<> -scan*"
command from "*visor*" results has 7 columns.]
2) The REST API responses says it is success but the response json's value
part is empty.
Not sure what went wrong. Happy to provide more details if required.
Many Thanks,
Anji.
*ignite-config.xml*
<property name="cacheConfiguration">
<list>
<!-- College Cache -->
<bean class="org.apache.ignite.configuration.CacheConfiguration">
<property name="name" value="CollegeCache"/>
<property name="backups" value="1"/>
<property name="atomicityMode" value="ATOMIC"/>
<property name="cacheMode" value="PARTITIONED"/>
<property name="queryEntities">
<list>
<bean class="org.apache.ignite.cache.QueryEntity">
<!-- Key Type -->
<property name="keyType" value="java.lang.String"/>
<!-- Value Type -->
<property name="valueType" value="org.anjaneya.prasad.loadbean.College"/>
<!-- value="java.lang.String"/> -->
<!-- Fields to be used from SQL -->
<property name="fields">
<map>
<!--<entry key="values" value="java.lang.String"/> -->
<entry key="register_number" value="java.lang.String"/>
<entry key="current_city" value="java.lang.String"/>
<entry key="date2" value="java.lang.String"/>
<entry key="date_of_birth" value="java.lang.String"/>
<entry key="student_code" value="java.lang.String"/>
<entry key="native_city" value="java.lang.String"/>
<entry key="college_end_date_1" value="java.lang.String"/>
<entry key="college_start_date_1" value="java.lang.String"/>
</map>
</property>
<!-- Assign an unique name for the key to access it from SQL easily. -->
<!-- <property name="keyFieldName" value="register_number"/> -->
<property name="tableName" value="CollegeTab"/>
<!-- Defining indexed fields.-->
<property name="indexes">
<list>
<!-- Single field (aka. column) index -->
<bean class="org.apache.ignite.cache.QueryIndex">
<constructor-arg value="register_number"/>
</bean>
<!-- Single field (aka. column) index
<bean class="org.apache.ignite.cache.QueryIndex">
<constructor-arg value="native_city"/>
</bean>
<bean class="org.apache.ignite.cache.QueryIndex">
<constructor-arg value="current_city"/>
</bean>
-->
</list>
</property>
</bean>
</list>
</property>
</bean>
</list>
</property>
=====================================================
*College.scala*
package org.anjaneya.prasad.loadbean
import scala.beans.BeanProperty
class College(@BeanProperty register_number :String,
@BeanProperty current_city: String,
@BeanProperty date2: String,
@BeanProperty date_of_birth: String,
@BeanProperty student_code: String,
@BeanProperty native_city: String,
@BeanProperty college_end_date_1: String,
@BeanProperty college_start_date_1: String
) extends Serializable{
override def toString: String = s"College: $register_number,
$current_city, $date2, $date_of_birth, $student_code, $native_city,
$college_end_date_1, college_start_date_1"
//return format("%s, %s, %s, %s, %s, %s, %s, %s", register_number ,
native_city , current_city , student_code, college_end_date_1,
date_of_birth, date2)
}
========================================================
*MainProcess.scala*
val ic = new IgniteContext(sc,
"/home/ops/College/src/main/resources/ignite-config.xml",
true)
var sharedRDDCollege: IgniteRDD[String, College] =
ic.fromCache("CollegeCache")
//sharedRDDCollege.collect().foreach(print)
var CollegeCache = test2.rdd.map(x => (x.getString(0),
new College(x.getString(0) , x.getString(1) , x.getString(2) ,
x.getString(3) , x.getString(4) , x.getString(5) , x.getString(6) ,
x.getString(7))))
//CollegeCache.collect.foreach(print)
sharedRDDCollege.savePairs(CollegeCache)
>
====================================================================================================
///////***************************** Log when cache is created
*****************************\\\\\\\\
====================================================================================================
[2017-09-16 14:42:23,494][DEBUG][main][GridCacheEventManager] <CollegeCache>
Cache manager started: CollegeCache
[2017-09-16 14:42:23,494][DEBUG][main][CacheOsStoreManager] <CollegeCache>
Cache manager started: CollegeCache
[2017-09-16 14:42:23,494][DEBUG][main][CacheOffheapEvictionManager]
<CollegeCache> Cache manager started: CollegeCache
[2017-09-16 14:42:23,494][DEBUG][main][GridCacheDistributedQueryManager]
<CollegeCache> Cache manager started: CollegeCache
[2017-09-16 14:42:23,494][DEBUG][main][CacheContinuousQueryManager]
<CollegeCache> Cache manager started: CollegeCache
[2017-09-16 14:42:23,494][DEBUG][main][CacheDataStructuresManager]
<CollegeCache> Cache manager started: CollegeCache
[2017-09-16 14:42:23,494][DEBUG][main][GridCacheTtlManager] <CollegeCache>
Cache manager started: CollegeCache
[2017-09-16
14:42:23,502][DEBUG][ttl-cleanup-worker-#27%null%][GridCacheSharedTtlCleanupManager]
Grid runnable started: ttl-cleanup-worker
[2017-09-16 14:42:23,505][DEBUG][main][IgniteCacheOffheapManagerImpl]
<CollegeCache> Cache manager started: CollegeCache
[2017-09-16 14:42:23,505][DEBUG][main][CachePluginManager] <CollegeCache> Cache
manager started: CollegeCache
[2017-09-16 14:42:23,505][DEBUG][main][GridCacheAffinityManager] <CollegeCache>
Cache manager started: CollegeCache
[2017-09-16 14:42:23,505][DEBUG][main][GridDhtPreloader] <CollegeCache>
Starting DHT rebalancer...
[2017-09-16 14:42:23,510][DEBUG][main][GridResourceProcessor] Injecting
resources:
org.apache.ignite.internal.processors.cache.CacheDefaultBinaryAffinityKeyMapper@4f3bbf68
[2017-09-16 14:42:23,511][DEBUG][main][GridResourceProcessor] Injecting
resources:
org.apache.ignite.internal.processors.cache.CacheDefaultBinaryAffinityKeyMapper@3e1162e7
[2017-09-16 14:42:23,516][DEBUG][main][IgniteH2Indexing] Created H2 schema for
index database: "CollegeCache"
[2017-09-16 14:42:23,517][DEBUG][main][IgniteH2Indexing] Set schema:
"CollegeCache"
[2017-09-16 14:42:23,518][DEBUG][main][IgniteH2Indexing] Creating DB table with
SQL: CREATE TABLE "CollegeCache".CollegeTab (_key VARCHAR INVISIBLE NOT
NULL,_val OTHER INVISIBLE,_ver OTHER INVISIBLE,register_number
VARCHAR,current_city VARCHAR,date2 VARCHAR,date_of_birth VARCHAR,student_code
VARCHAR,native_city VARCHAR,college_end_date_1 VARCHAR,college_start_date_1
VARCHAR)
[2017-09-16 14:42:23,530][DEBUG][main][IgniteH2Indexing] Creating cache index
[cacheId=139226600, idxName=_key_PK]
[2017-09-16 14:42:23,535][DEBUG][main][IgniteH2Indexing] Creating cache index
[cacheId=139226600, idxName=CollegeTab_register_number_ASC_IDX]
[2017-09-16 14:42:23,535][INFO ][main][GridCacheProcessor] Started cache
[name=CollegeCache, memoryPolicyName=null, mode=PARTITIONED]
[2017-09-16 14:42:23,535][DEBUG][main][GridCacheMvccManager] Cache manager
received onKernalStart() callback.
[2017-09-16 14:42:23,535][DEBUG][main][GridCacheVersionManager] Cache manager
received onKernalStart() callback.
[2017-09-16 14:42:23,535][DEBUG][main][IgniteTxManager] Cache manager received
onKernalStart() callback.
[2017-09-16 14:42:23,535][DEBUG][main][CacheNoopJtaManager] Cache manager
received onKernalStart() callback.
[2017-09-16 14:42:23,535][DEBUG][main][GridCacheDeploymentManager] Cache
manager received onKernalStart() callback.
[2017-09-16 14:42:23,540][DEBUG][main][GridDhtPartitionsExchangeFuture]
Creating exchange future [localNode=e8e02510-88dc-4ea2-9f4d-116f56c7cdd4,
fut=GridDhtPartitionsExchangeFuture [dummy=false, forcePreload=false,
reassign=false, discoEvt=null, crd=null, exchId=GridDhtPartitionExchangeId
[topVer=AffinityTopologyVersion [topVer=1, minorTopVer=0], nodeId=e8e02510,
evt=NODE_JOINED], added=false, initFut=GridFutureAdapter
[ignoreInterrupts=false, state=INIT, res=null, hash=1657842786], init=false,
lastVer=null, partReleaseFut=null, affChangeMsg=null, skipPreload=false,
clientOnlyExchange=false, initTs=0, centralizedAff=false,
changeGlobalStateE=null, exchangeOnChangeGlobalState=false, forcedRebFut=null,
evtLatch=1, remaining=[], srvNodes=null, super=GridFutureAdapter
[ignoreInterrupts=false, state=INIT, res=null, hash=1671811074]]]
[2017-09-16 14:42:23,542][DEBUG][main][GridCachePartitionExchangeManager]
Beginning to wait on local exchange future: GridDhtPartitionsExchangeFuture
[dummy=false, forcePreload=false, reassign=false, discoEvt=DiscoveryEvent
[evtNode=TcpDiscoveryNode [id=e8e02510-88dc-4ea2-9f4d-116f56c7cdd4,
addrs=[0:0:0:0:0:0:0:1%lo, 10.0.2.4, 127.0.0.1], sockAddrs=[/10.0.2.4:47500,
/0:0:0:0:0:0:0:1%lo:47500, /127.0.0.1:47500], discPort=47500, order=1,
intOrder=1, lastExchangeTime=1505572943239, loc=true,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], topVer=1, nodeId8=e8e02510,
msg=null, type=NODE_JOINED, tstamp=1505572943300], crd=null,
exchId=GridDhtPartitionExchangeId [topVer=AffinityTopologyVersion [topVer=1,
minorTopVer=0], nodeId=e8e02510, evt=NODE_JOINED], added=false,
initFut=GridFutureAdapter [ignoreInterrupts=false, state=INIT, res=null,
hash=1657842786], init=false, lastVer=null, partReleaseFut=null,
affChangeMsg=null, skipPreload=false, clientOnlyExchange=false, initTs=0,
centralizedAff=false, changeGlobalStateE=null,
exchangeOnChangeGlobalState=false, forcedRebFut=null, evtLatch=0, remaining=[],
srvNodes=null, super=GridFutureAdapter [ignoreInterrupts=false, state=INIT,
res=null, hash=1671811074]]
[2017-09-16
14:42:23,542][DEBUG][exchange-worker-#28%null%][GridCachePartitionExchangeManager]
Grid runnable started: partition-exchanger
[2017-09-16
14:42:23,543][DEBUG][exchange-worker-#28%null%][GridCachePartitionExchangeManager]
Before waiting for exchange futures [futs[GridDhtPartitionsExchangeFuture
[dummy=false, forcePreload=false, reassign=false, discoEvt=DiscoveryEvent
[evtNode=TcpDiscoveryNode [id=e8e02510-88dc-4ea2-9f4d-116f56c7cdd4,
addrs=[0:0:0:0:0:0:0:1%lo, 10.0.2.4, 127.0.0.1], sockAddrs=[/10.0.2.4:47500,
/0:0:0:0:0:0:0:1%lo:47500, /127.0.0.1:47500], discPort=47500, order=1,
intOrder=1, lastExchangeTime=1505572943239, loc=true,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], topVer=1, nodeId8=e8e02510,
msg=null, type=NODE_JOINED, tstamp=1505572943300], crd=null,
exchId=GridDhtPartitionExchangeId [topVer=AffinityTopologyVersion [topVer=1,
minorTopVer=0], nodeId=e8e02510, evt=NODE_JOINED], added=false,
initFut=GridFutureAdapter [ignoreInterrupts=false, state=INIT, res=null,
hash=1657842786], init=false, lastVer=null, partReleaseFut=null,
affChangeMsg=null, skipPreload=false, clientOnlyExchange=false, initTs=0,
centralizedAff=false, changeGlobalStateE=null,
exchangeOnChangeGlobalState=false, forcedRebFut=null, evtLatch=0, remaining=[],
srvNodes=null, super=GridFutureAdapter [ignoreInterrupts=false, state=INIT,
res=null, hash=1671811074]]], worker=GridWorker [name=partition-exchanger,
igniteInstanceName=null, finished=false, hashCode=337772022, interrupted=false,
runner=exchange-worker-#28%null%]]
[2017-09-16
14:42:23,544][DEBUG][exchange-worker-#28%null%][GridAffinityAssignmentCache]
Calculating affinity [topVer=AffinityTopologyVersion [topVer=1, minorTopVer=0],
locNodeId=e8e02510-88dc-4ea2-9f4d-116f56c7cdd4, discoEvt=DiscoveryEvent
[evtNode=TcpDiscoveryNode [id=e8e02510-88dc-4ea2-9f4d-116f56c7cdd4,
addrs=[0:0:0:0:0:0:0:1%lo, 10.0.2.4, 127.0.0.1], sockAddrs=[/10.0.2.4:47500,
/0:0:0:0:0:0:0:1%lo:47500, /127.0.0.1:47500], discPort=47500, order=1,
intOrder=1, lastExchangeTime=1505572943239, loc=true,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], topVer=1, nodeId8=e8e02510,
msg=null, type=NODE_JOINED, tstamp=1505572943300]]
[2017-09-16
14:42:23,545][DEBUG][exchange-worker-#28%null%][GridAffinityAssignmentCache]
Calculating affinity [topVer=AffinityTopologyVersion [topVer=1, minorTopVer=0],
locNodeId=e8e02510-88dc-4ea2-9f4d-116f56c7cdd4, discoEvt=DiscoveryEvent
[evtNode=TcpDiscoveryNode [id=e8e02510-88dc-4ea2-9f4d-116f56c7cdd4,
addrs=[0:0:0:0:0:0:0:1%lo, 10.0.2.4, 127.0.0.1], sockAddrs=[/10.0.2.4:47500,
/0:0:0:0:0:0:0:1%lo:47500, /127.0.0.1:47500], discPort=47500, order=1,
intOrder=1, lastExchangeTime=1505572943239, loc=true,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], topVer=1, nodeId8=e8e02510,
msg=null, type=NODE_JOINED, tstamp=1505572943300]]
[2017-09-16
14:42:23,546][DEBUG][exchange-worker-#28%null%][GridAffinityAssignmentCache]
Calculating affinity [topVer=AffinityTopologyVersion [topVer=1, minorTopVer=0],
locNodeId=e8e02510-88dc-4ea2-9f4d-116f56c7cdd4, discoEvt=DiscoveryEvent
[evtNode=TcpDiscoveryNode [id=e8e02510-88dc-4ea2-9f4d-116f56c7cdd4,
addrs=[0:0:0:0:0:0:0:1%lo, 10.0.2.4, 127.0.0.1], sockAddrs=[/10.0.2.4:47500,
/0:0:0:0:0:0:0:1%lo:47500, /127.0.0.1:47500], discPort=47500, order=1,
intOrder=1, lastExchangeTime=1505572943239, loc=true,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], topVer=1, nodeId8=e8e02510,
msg=null, type=NODE_JOINED, tstamp=1505572943300]]
=========================================================================================================
///////***************************** Log while saving to igniteRDD
*****************************\\\\\\\\
=========================================================================================================
[2017-09-16 14:43:06,217][DEBUG][data-streamer-#46%null%][DataStreamProcessor]
Processing data load request: DataStreamerRequest [reqId=1,
cacheName=CollegeCache, ignoreDepOwnership=true, skipStore=false,
keepBinary=false, depMode=null, sampleClsName=null, userVer=null,
ldrParticipants=null, clsLdrId=null, forceLocDep=true,
topVer=AffinityTopologyVersion [topVer=2, minorTopVer=0]]
[2017-09-16
14:43:06,223][DEBUG][data-streamer-#46%null%][GridResourceProcessor] Injecting
resources:
org.apache.ignite.internal.processors.datastreamer.DataStreamerImpl$IsolatedUpdater@6edf18d4
[2017-09-16 14:43:06,223][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,224][DEBUG][data-streamer-#46%null%][DataStreamProcessor]
Running put job [nodeId=e8e02510-88dc-4ea2-9f4d-116f56c7cdd4, size=30]
[2017-09-16 14:43:06,241][DEBUG][data-streamer-#46%null%][GridQueryProcessor]
Store [space=CollegeCache, key=KeyCacheObjectImpl [part=720, val=Student-1,
hasValBytes=true], val=org.anjaneya.prasad.loadbean.College [idHash=440433364,
hash=617790956, native_city=Bakersfield, current_city=ac, date2=2017-06-26,
date_of_birth=--, register_number=Student-1, student_code=Abilene,
college_end_date_1=--]]
[2017-09-16 14:43:06,241][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,241][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,242][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,242][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,244][DEBUG][data-streamer-#46%null%][GridDhtAtomicCache]
<CollegeCache> Remove will not be done for key (entry got replaced or removed):
KeyCacheObjectImpl [part=720, val=Student-1, hasValBytes=true]
[2017-09-16 14:43:06,246][DEBUG][data-streamer-#46%null%][GridQueryProcessor]
Store [space=CollegeCache, key=KeyCacheObjectImpl [part=721, val=Student-2,
hasValBytes=true], val=org.anjaneya.prasad.loadbean.College [idHash=1501020102,
hash=558154337, native_city=Baltimore, current_city=dd, date2=2017-06-25,
date_of_birth=--, register_number=Student-2, student_code=Alexandria,
college_end_date_1=--]]
[2017-09-16 14:43:06,246][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,246][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,246][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,246][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,246][DEBUG][data-streamer-#46%null%][GridDhtAtomicCache]
<CollegeCache> Remove will not be done for key (entry got replaced or removed):
KeyCacheObjectImpl [part=721, val=Student-2, hasValBytes=true]
[2017-09-16 14:43:06,250][DEBUG][data-streamer-#46%null%][GridQueryProcessor]
Store [space=CollegeCache, key=KeyCacheObjectImpl [part=726, val=Student-3,
hasValBytes=true], val=org.anjaneya.prasad.loadbean.College [idHash=98315285,
hash=-1993451924, native_city=Baton Rouge, current_city=dt, date2=2017-06-27,
date_of_birth=--, register_number=Student-3, student_code=Austin,
college_end_date_1=--]]
[2017-09-16 14:43:06,250][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,250][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,250][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,250][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,250][DEBUG][data-streamer-#46%null%][GridDhtAtomicCache]
<CollegeCache> Remove will not be done for key (entry got replaced or removed):
KeyCacheObjectImpl [part=726, val=Student-3, hasValBytes=true]
[2017-09-16 14:43:06,251][DEBUG][data-streamer-#46%null%][GridQueryProcessor]
Store [space=CollegeCache, key=KeyCacheObjectImpl [part=727, val=Student-4,
hasValBytes=true], val=org.anjaneya.prasad.loadbean.College [idHash=241916128,
hash=-654559620, native_city=Beaumont, current_city=lb, date2=2017-06-27,
date_of_birth=--, register_number=Student-4, student_code=Bakersfield,
college_end_date_1=--]]
[2017-09-16 14:43:06,251][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,251][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,251][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,251][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,251][DEBUG][data-streamer-#46%null%][GridDhtAtomicCache]
<CollegeCache> Remove will not be done for key (entry got replaced or removed):
KeyCacheObjectImpl [part=727, val=Student-4, hasValBytes=true]
[2017-09-16 14:43:06,251][DEBUG][data-streamer-#46%null%][GridQueryProcessor]
Store [space=CollegeCache, key=KeyCacheObjectImpl [part=724, val=Student-5,
hasValBytes=true], val=org.anjaneya.prasad.loadbean.College [idHash=731640876,
hash=1649080541, native_city=Bellevue, current_city=v, date2=2017-06-26,
date_of_birth=--, register_number=Student-5, student_code=Baltimore,
college_end_date_1=--]]
[2017-09-16 14:43:06,251][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,251][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,251][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,251][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,251][DEBUG][data-streamer-#46%null%][GridDhtAtomicCache]
<CollegeCache> Remove will not be done for key (entry got replaced or removed):
KeyCacheObjectImpl [part=724, val=Student-5, hasValBytes=true]
[2017-09-16 14:43:06,252][DEBUG][data-streamer-#46%null%][GridQueryProcessor]
Store [space=CollegeCache, key=KeyCacheObjectImpl [part=725, val=Student-6,
hasValBytes=true], val=org.anjaneya.prasad.loadbean.College [idHash=1341581078,
hash=1544502237, native_city=Berkeley, current_city=r, date2=2017-06-25,
date_of_birth=--, register_number=Student-6, student_code=Baton Rouge,
college_end_date_1=--]]
[2017-09-16 14:43:06,252][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,252][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,252][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,252][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,252][DEBUG][data-streamer-#46%null%][GridDhtAtomicCache]
<CollegeCache> Remove will not be done for key (entry got replaced or removed):
KeyCacheObjectImpl [part=725, val=Student-6, hasValBytes=true]
[2017-09-16 14:43:06,252][DEBUG][data-streamer-#46%null%][GridQueryProcessor]
Store [space=CollegeCache, key=KeyCacheObjectImpl [part=714, val=Student-7,
hasValBytes=true], val=org.anjaneya.prasad.loadbean.College [idHash=724489849,
hash=1503616549, native_city=Billings, current_city=v, date2=2017-06-23,
date_of_birth=--, register_number=Student-7, student_code=Beaumont,
college_end_date_1=--]]
[2017-09-16 14:43:06,252][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,252][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,252][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,252][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,252][DEBUG][data-streamer-#46%null%][GridDhtAtomicCache]
<CollegeCache> Remove will not be done for key (entry got replaced or removed):
KeyCacheObjectImpl [part=714, val=Student-7, hasValBytes=true]
[2017-09-16 14:43:06,253][DEBUG][data-streamer-#46%null%][GridQueryProcessor]
Store [space=CollegeCache, key=KeyCacheObjectImpl [part=715, val=Student-8,
hasValBytes=true], val=org.anjaneya.prasad.loadbean.College [idHash=2144741284,
hash=-795035461, native_city=Birmingham, current_city=dd, date2=2017-06-22,
date_of_birth=--, register_number=Student-8, student_code=Bellevue,
college_end_date_1=--]]
[2017-09-16 14:43:06,253][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,253][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,253][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,253][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,253][DEBUG][data-streamer-#46%null%][GridDhtAtomicCache]
<CollegeCache> Remove will not be done for key (entry got replaced or removed):
KeyCacheObjectImpl [part=715, val=Student-8, hasValBytes=true]
[2017-09-16 14:43:06,253][DEBUG][data-streamer-#46%null%][GridQueryProcessor]
Store [space=CollegeCache, key=KeyCacheObjectImpl [part=712, val=Student-9,
hasValBytes=true], val=org.anjaneya.prasad.loadbean.College [idHash=194545382,
hash=97562502, native_city=Boise, current_city=ac, date2=2017-06-20,
date_of_birth=--, register_number=Student-9, student_code=Berkeley,
college_end_date_1=--]]
[2017-09-16 14:43:06,253][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,253][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,253][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,253][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,253][DEBUG][data-streamer-#46%null%][GridDhtAtomicCache]
<CollegeCache> Remove will not be done for key (entry got replaced or removed):
KeyCacheObjectImpl [part=712, val=Student-9, hasValBytes=true]
[2017-09-16 14:43:06,254][DEBUG][data-streamer-#46%null%][GridQueryProcessor]
Store [space=CollegeCache, key=KeyCacheObjectImpl [part=782, val=Student-10,
hasValBytes=true], val=org.anjaneya.prasad.loadbean.College [idHash=1940790996,
hash=902121586, native_city=Boston, current_city=lb, date2=2017-06-26,
date_of_birth=--, register_number=Student-10, student_code=Billings,
college_end_date_1=--]]
[2017-09-16 14:43:06,254][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,254][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,254][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,254][DEBUG][data-streamer-#46%null%][GridCacheProcessor]
Getting internal cache adapter: CollegeCache
[2017-09-16 14:43:06,254][DEBUG][data-streamer-#46%null%][GridDhtAtomicCache]
<CollegeCache> Remove will not be done for key (entry got replaced or removed):
KeyCacheObjectImpl [part=782, val=Student-10, hasValBytes=true]
[2017-09-16 14:43:06,254][DEBUG][data-streamer-#46%null%][GridDhtAtomicCache]
<CollegeCache> Remove will not be done for key (entry got replaced or removed):
KeyCacheObjectImpl [part=720, val=Student-1, hasValBytes=true]
[2017-09-16 14:43:06,254][DEBUG][data-streamer-#46%null%][GridDhtAtomicCache]
<CollegeCache> Remove will not be done for key (entry got replaced or removed):
KeyCacheObjectImpl [part=721, val=Student-2, hasValBytes=true]
[2017-09-16 14:43:06,255][DEBUG][data-streamer-#46%null%][GridDhtAtomicCache]
<CollegeCache> Remove will not be done for key (entry got replaced or removed):
KeyCacheObjectImpl [part=726, val=Student-3, hasValBytes=true]
====================================================================================================
///////***************************** qryscan, response and log
*****************************\\\\\\\\
====================================================================================================
Only key values are populated, but not the values.
1) Why value is emoty?
http://xx.xx.xx.xx:8080/ignite?cmd=qryscanexe&pageSize=20&cacheName=CollegeCache
{
"successStatus": 0,
"error": null,
"sessionToken": null,
"response": {
"items": [
{
"key": "Student-9",
"value": {}
},
{
"key": "Student-7",
"value": {}
},
{
"key": "Student-8",
"value": {}
},
{
"key": "Student-1",
"value": {}
},
{
"key": "Student-2",
"value": {}
},
{
"key": "Student-5",
"value": {}
},
{
"key": "Student-6",
"value": {}
},
{
"key": "Student-3",
"value": {}
},
{
"key": "Student-4",
"value": {}
},
{
"key": "Student-12",
"value": {}
},
{
"key": "Student-13",
"value": {}
},
{
"key": "Student-14",
"value": {}
},
{
"key": "Student-15",
"value": {}
},
{
"key": "Student-16",
"value": {}
},
{
"key": "Student-17",
"value": {}
},
{
"key": "Student-18",
"value": {}
},
{
"key": "Student-19",
"value": {}
},
{
"key": "Student-10",
"value": {}
},
{
"key": "Student-11",
"value": {}
},
{
"key": "Student-20",
"value": {}
}
],
"last": true,
"fieldsMetadata": [
{
"schemaName": null,
"typeName": null,
"fieldName": "key",
"fieldTypeName": null
},
{
"schemaName": null,
"typeName": null,
"fieldName": "value",
"fieldTypeName": null
}
],
"queryId": 25
}
}
[2017-09-16 15:37:05,677][DEBUG][rest-#461%null%][GridRestProcessor] Grid
runnable finished normally: rest-proc-worker
[2017-09-16 15:37:05,678][DEBUG][pub-#462%null%][GridClosureProcessor] Grid
runnable started: closure-proc-worker
[2017-09-16 15:37:05,678][DEBUG][pub-#462%null%][GridCacheProcessor] Getting
public cache for name: CollegeCache
[2017-09-16 15:37:05,678][DEBUG][pub-#462%null%][GridCacheQueryAdapter]
<CollegeCache> Executing query [query=GridCacheQueryAdapter [type=SCAN,
clsName=null, clause=null, filter=null, transform=null, part=null,
incMeta=false, metrics=GridCacheQueryMetricsAdapter
[minTime=9223372036854775807, maxTime=0, sumTime=0, avgTime=0.0, execs=0,
completed=0, fails=0], pageSize=1024, timeout=0, keepAll=true,
incBackups=false, dedup=false, prj=null, keepBinary=false, subjId=null,
taskHash=0], nodes=[TcpDiscoveryNode [id=e8e02510-88dc-4ea2-9f4d-116f56c7cdd4,
addrs=[0:0:0:0:0:0:0:1%lo, 10.0.2.4, 127.0.0.1], sockAddrs=[/10.0.2.4:47500,
/0:0:0:0:0:0:0:1%lo:47500, /127.0.0.1:47500], discPort=47500, order=1,
intOrder=1, lastExchangeTime=1505572956427, loc=true,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false]]]
[2017-09-16
15:37:05,678][DEBUG][pub-#462%null%][GridCacheDistributedQueryManager]
<CollegeCache> Running local SCAN query: GridCacheQueryAdapter [type=SCAN,
clsName=null, clause=null, filter=null, transform=null, part=null,
incMeta=false, metrics=GridCacheQueryMetricsAdapter
[minTime=9223372036854775807, maxTime=0, sumTime=0, avgTime=0.0, execs=0,
completed=0, fails=0], pageSize=1024, timeout=0, keepAll=true,
incBackups=false, dedup=false, prj=null, keepBinary=false,
subjId=e8e02510-88dc-4ea2-9f4d-116f56c7cdd4, taskHash=0]
[2017-09-16 15:37:05,682][DEBUG][pub-#462%null%][GridClosureProcessor] Grid
runnable finished normally: closure-proc-worker
[2017-09-16 15:37:05,682][DEBUG][qtp848097505-57][GridJettyRestProtocol] Parsed
command response into JSON object:
{"successStatus":0,"error":null,"sessionToken":null,"response":{"items":[{"key":"Student-9","value":{}},{"key":"Student-7","value":{}},{"key":"Student-8","value":{}},{"key":"Student-1","value":{}},{"key":"Student-2","value":{}},{"key":"Student-5","value":{}},{"key":"Student-6","value":{}},{"key":"Student-3","value":{}},{"key":"Student-4","value":{}},{"key":"Student-12","value":{}},{"key":"Student-13","value":{}},{"key":"Student-14","value":{}},{"key":"Student-15","value":{}},{"key":"Student-16","value":{}},{"key":"Student-17","value":{}},{"key":"Student-18","value":{}},{"key":"Student-19","value":{}},{"key":"Student-10","value":{}},{"key":"Student-11","value":{}},{"key":"Student-20","value":{}}],"last":true,"fieldsMetadata":[{"schemaName":null,"typeName":null,"fieldName":"key","fieldTypeName":null},{"schemaName":null,"typeName":null,"fieldName":"value","fieldTypeName":null}],"queryId":25}}
[2017-09-16 15:37:05,683][DEBUG][qtp848097505-57][GridJettyRestProtocol]
Processed HTTP request [action=/ignite, jsonRes=GridRestResponse
[successStatus=0, sesTokStr=null, err=null, obj=CacheQueryResult [qryId=25,
last=true]], req=(GET
/ignite?cmd=qryscanexe&pageSize=20&cacheName=CollegeCache)@640698269
org.eclipse.jetty.server.Request@2630479d]
[2017-09-16
15:37:05,727][DEBUG][grid-timeout-worker-#15%null%][GridTimeoutProcessor]
Timeout has occurred: CancelableTask
[id=570f32b8e51-9cefaec4-c955-4dfc-9a06-c38dcf766ffd, endTime=1505576225718,
period=3000, cancel=false,
task=org.apache.ignite.internal.processors.query.GridQueryProcessor$2@19dc4a89]
[2017-09-16
15:37:05,727][DEBUG][grid-timeout-worker-#15%null%][GridTimeoutProcessor]
Timeout has occurred: CancelableTask
[id=770f32b8e51-9cefaec4-c955-4dfc-9a06-c38dcf766ffd, endTime=1505576225718,
period=3000, cancel=false, task=MetricsUpdater [prevGcTime=99,
prevCpuTime=20320,
super=org.apache.ignite.internal.managers.discovery.GridDiscoveryManager$MetricsUpdater@7a395b30]]
[2017-09-16
15:37:06,955][DEBUG][tcp-disco-msg-worker-#2%null%][TcpDiscoverySpi] No next
node in topology.
[2017-09-16
15:37:06,955][DEBUG][tcp-disco-msg-worker-#2%null%][TcpDiscoverySpi] No next
node in topology.
[2017-09-16
15:37:07,038][DEBUG][grid-timeout-worker-#15%null%][GridTimeoutProcessor]
Timeout has occurred: CancelableTask
[id=d70f32b8e51-9cefaec4-c955-4dfc-9a06-c38dcf766ffd, endTime=1505576227031,
period=5000, cancel=false,
task=org.apache.ignite.internal.processors.cache.query.continuous.CacheContinuousQueryManager$BackupCleaner@190473ff]
[2017-09-16
15:37:07,038][DEBUG][grid-timeout-worker-#15%null%][GridTimeoutProcessor]
Timeout has occurred: CancelableTask
[id=e70f32b8e51-9cefaec4-c955-4dfc-9a06-c38dcf766ffd, endTime=1505576227031,
period=5000, cancel=false,
task=org.apache.ignite.internal.processors.cache.query.continuous.CacheContinuousQueryManager$BackupCleaner@7dbda89c]
[2017-09-16
15:37:07,038][DEBUG][grid-timeout-worker-#15%null%][GridTimeoutProcessor]
Timeout has occurred: CancelableTask
[id=f70f32b8e51-9cefaec4-c955-4dfc-9a06-c38dcf766ffd, endTime=1505576227031,
period=5000, cancel=false,
task=org.apache.ignite.internal.processors.cache.query.continuous.CacheContinuousQueryManager$BackupCleaner@28c38521]
[2017-09-16
15:37:08,730][DEBUG][grid-timeout-worker-#15%null%][GridTimeoutProcessor]
Timeout has occurred: CancelableTask
[id=570f32b8e51-9cefaec4-c955-4dfc-9a06-c38dcf766ffd, endTime=1505576228720,
period=3000, cancel=false,
task=org.apache.ignite.internal.processors.query.GridQueryProcessor$2@19dc4a89]
[2017-09-16
15:37:08,730][DEBUG][grid-timeout-worker-#15%null%][GridTimeoutProcessor]
Timeout has occurred: CancelableTask
[id=770f32b8e51-9cefaec4-c955-4dfc-9a06-c38dcf766ffd, endTime=1505576228720,
period=3000, cancel=false, task=MetricsUpdater [prevGcTime=99,
prevCpuTime=20340,
super=org.apache.ignite.internal.managers.discovery.GridDiscoveryManager$MetricsUpdater@7a395b30]]
[2017-09-16
15:37:08,959][DEBUG][tcp-disco-msg-worker-#2%null%][TcpDiscoverySpi] No next
node in topology.
[2017-09-16
15:37:08,960][DEBUG][tcp-disco-msg-worker-#2%null%][TcpDiscoverySpi] No next
node in topology.
[2017-09-16
15:37:09,488][DEBUG][exchange-worker-#28%null%][GridCachePartitionExchangeManager]
Before waiting for exchange futures [futs[], worker=GridWorker
[name=partition-exchanger, igniteInstanceName=null, finished=false,
hashCode=337772022, interrupted=false, runner=exchange-worker-#28%null%]]
[2017-09-16
15:37:10,965][DEBUG][tcp-disco-msg-worker-#2%null%][TcpDiscoverySpi] No next
node in topology.
[2017-09-16
15:37:10,965][DEBUG][tcp-disco-msg-worker-#2%null%][TcpDiscoverySpi] No next
node in topology.
[2017-09-16 15:37:11,038][DEBUG][nio-acceptor-#16%null%][TcpCommunicationSpi]
Balancing data [min0=0, minIdx=0, max0=-1, maxIdx=-1]
[2017-09-16 15:37:11,203][DEBUG][nio-acceptor-#22%null%][GridTcpRestProtocol]
Balancing data [min0=0, minIdx=0, max0=-1, maxIdx=-1]
[2017-09-16
15:37:11,733][DEBUG][grid-timeout-worker-#15%null%][GridTimeoutProcessor]
Timeout has occurred: CancelableTask
[id=570f32b8e51-9cefaec4-c955-4dfc-9a06-c38dcf766ffd, endTime=1505576231724,
period=3000, cancel=false,
task=org.apache.ignite.internal.processors.query.GridQueryProcessor$2@19dc4a89]
[2017-09-16
15:37:11,733][DEBUG][grid-timeout-worker-#15%null%][GridTimeoutProcessor]
Timeout has occurred: CancelableTask
[id=770f32b8e51-9cefaec4-c955-4dfc-9a06-c38dcf766ffd, endTime=1505576231724,
period=3000, cancel=false, task=MetricsUpdater [prevGcTime=99,
prevCpuTime=20350,
super=org.apache.ignite.internal.managers.discovery.GridDiscoveryManager$MetricsUpdater@7a395b30]]
====================================================================================================
///////***************************** qryexe, response and logs
*****************************\\\\\\\\
====================================================================================================
http://xx.xx.xx.xx:8080/ignite?cmd=qryexe&pageSize=10&cacheName=CollegeCache&type=College&arg1=Student-17&qry=register_number+%3D+%3F
{
"successStatus": 0,
"error": null,
"sessionToken": null,
"response": {
"items": [
{
"key": "Student-17",
"value": {}
}
],
"last": true,
"fieldsMetadata": [],
"queryId": 26
}
}
[2017-09-16
15:37:45,021][DEBUG][tcp-disco-msg-worker-#2%null%][TcpDiscoverySpi] No next
node in topology.
[2017-09-16 15:37:45,286][DEBUG][qtp848097505-58][GridJettyRestProtocol]
Handling request [target=/ignite, req=(GET
/ignite?cmd=qryexe&pageSize=10&cacheName=CollegeCache&type=College&arg1=Student-17&qry=register_number+%3D+%3F)@581065253
org.eclipse.jetty.server.Request@22a25a25, srvReq=(GET
/ignite?cmd=qryexe&pageSize=10&cacheName=CollegeCache&type=College&arg1=Student-17&qry=register_number+%3D+%3F)@581065253
org.eclipse.jetty.server.Request@22a25a25]
[2017-09-16 15:37:45,286][DEBUG][qtp848097505-58][GridJettyRestProtocol]
Initialized command request: GridRestRequest [destId=null, clientId=null,
addr=/106.200.218.80:19593, cmd=EXECUTE_SQL_QUERY]
[2017-09-16 15:37:45,287][DEBUG][rest-#466%null%][GridRestProcessor] Grid
runnable started: rest-proc-worker
[2017-09-16 15:37:45,287][DEBUG][rest-#466%null%][GridRestProcessor] Received
request from client: GridRestRequest [destId=null, clientId=null,
addr=/106.200.218.80:19593, cmd=EXECUTE_SQL_QUERY]
[2017-09-16 15:37:45,287][DEBUG][rest-#466%null%][GridResourceProcessor]
Injecting resources:
org.apache.ignite.internal.processors.rest.handlers.query.QueryCommandHandler$ExecuteQueryCallable@2aabc5c
[2017-09-16 15:37:45,287][DEBUG][rest-#466%null%][GridRestProcessor] Grid
runnable finished normally: rest-proc-worker
[2017-09-16 15:37:45,287][DEBUG][pub-#467%null%][GridClosureProcessor] Grid
runnable started: closure-proc-worker
[2017-09-16 15:37:45,287][DEBUG][pub-#467%null%][GridCacheProcessor] Getting
public cache for name: CollegeCache
[2017-09-16 15:37:45,287][DEBUG][pub-#467%null%][IgniteH2Indexing] Set schema:
"CollegeCache"
[2017-09-16 15:37:45,288][DEBUG][pub-#467%null%][IgniteH2Indexing] Parsed
query: `SELECT "CollegeCache".CollegeTab._key, "CollegeCache".CollegeTab._val
FROM "CollegeCache".CollegeTab WHERE register_number = ?` into two step query:
GridCacheTwoStepQuery [mapQrys=[GridCacheSqlQuery [qry=SELECT
"CollegeCache".__Z0._KEY __C0_0,
"CollegeCache".__Z0._VAL __C0_1
FROM "CollegeCache".CollegeTab __Z0
WHERE __Z0.register_number = ?1, paramIdxs=[0], cols={__C0_0=GridSqlType
[type=13, scale=0, precision=2147483647, displaySize=2147483647, sql=VARCHAR],
__C0_1=GridSqlType [type=19, scale=0, precision=2147483647,
displaySize=2147483647, sql=OTHER]}, alias=null, sort=[], partitioned=true,
node=null]], rdc=GridCacheSqlQuery [qry=SELECT
__C0_0 _KEY,
__C0_1 _VAL
FROM PUBLIC.__T0, paramIdxs=[], cols=null, alias=null, sort=null,
partitioned=false, node=null], pageSize=1024, explain=false, originalSql=SELECT
"CollegeCache".CollegeTab._KEY,
"CollegeCache".CollegeTab._VAL
FROM "CollegeCache".CollegeTab
WHERE register_number = ?1, distributedJoins=false, skipMergeTbl=true,
local=false]
[2017-09-16 15:37:45,288][DEBUG][pub-#467%null%][GridReduceQueryExecutor]
Sending: [msg=GridH2QueryRequest [reqId=19, caches=[139226600],
topVer=AffinityTopologyVersion [topVer=2, minorTopVer=0], parts=null,
qryParts=null, pageSize=1024, qrys=[GridCacheSqlQuery [qry=SELECT
"CollegeCache".__Z0._KEY __C0_0,
"CollegeCache".__Z0._VAL __C0_1
FROM "CollegeCache".CollegeTab __Z0
WHERE __Z0.register_number = ?1, paramIdxs=[0], cols={__C0_0=GridSqlType
[type=13, scale=0, precision=2147483647, displaySize=2147483647, sql=VARCHAR],
__C0_1=GridSqlType [type=19, scale=0, precision=2147483647,
displaySize=2147483647, sql=OTHER]}, alias=null, sort=[], partitioned=true,
node=null]], flags=2, tbls=null, timeout=0, params=[Student-17]],
nodes=[TcpDiscoveryNode [id=e8e02510-88dc-4ea2-9f4d-116f56c7cdd4,
addrs=[0:0:0:0:0:0:0:1%lo, 10.0.2.4, 127.0.0.1], sockAddrs=[/10.0.2.4:47500,
/0:0:0:0:0:0:0:1%lo:47500, /127.0.0.1:47500], discPort=47500, order=1,
intOrder=1, lastExchangeTime=1505572956427, loc=true,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false]], specialize=null]
[2017-09-16 15:37:45,289][DEBUG][pub-#467%null%][GridCacheProcessor] Getting
internal cache adapter: CollegeCache
[2017-09-16 15:37:45,289][DEBUG][pub-#467%null%][GridCacheProcessor] Getting
internal cache adapter: CollegeCache
[2017-09-16 15:37:45,289][DEBUG][pub-#467%null%][GridCacheProcessor] Getting
internal cache adapter: CollegeCache
[2017-09-16 15:37:45,289][DEBUG][pub-#467%null%][GridCacheProcessor] Getting
internal cache adapter: CollegeCache
[2017-09-16 15:37:45,289][DEBUG][pub-#467%null%][GridReduceQueryExecutor]
Processed response:
e8e02510-88dc-4ea2-9f4d-116f56c7cdd4->e8e02510-88dc-4ea2-9f4d-116f56c7cdd4
GridQueryNextPageResponse [qryReqId=19, segmentId=0, qry=0, page=0, allRows=1,
cols=2, retry=null, valsSize=0, rowsSize=1]
[2017-09-16 15:37:45,289][DEBUG][pub-#467%null%][GridMapQueryExecutor]
Processed request:
e8e02510-88dc-4ea2-9f4d-116f56c7cdd4->e8e02510-88dc-4ea2-9f4d-116f56c7cdd4
GridH2QueryRequest [reqId=19, caches=[139226600],
topVer=AffinityTopologyVersion [topVer=2, minorTopVer=0], parts=null,
qryParts=null, pageSize=1024, qrys=[GridCacheSqlQuery [qry=SELECT
"CollegeCache".__Z0._KEY __C0_0,
"CollegeCache".__Z0._VAL __C0_1
FROM "CollegeCache".CollegeTab __Z0
WHERE __Z0.register_number = ?1, paramIdxs=[0], cols={__C0_0=GridSqlType
[type=13, scale=0, precision=2147483647, displaySize=2147483647, sql=VARCHAR],
__C0_1=GridSqlType [type=19, scale=0, precision=2147483647,
displaySize=2147483647, sql=OTHER]}, alias=null, sort=[], partitioned=true,
node=null]], flags=2, tbls=null, timeout=0, params=[Student-17]]
[2017-09-16 15:37:45,289][DEBUG][qtp848097505-58][GridJettyRestProtocol] Parsed
command response into JSON object:
{"successStatus":0,"error":null,"sessionToken":null,"response":{"items":[{"key":"Student-17","value":{}}],"last":true,"fieldsMetadata":[],"queryId":26}}
[2017-09-16 15:37:45,289][DEBUG][qtp848097505-58][GridJettyRestProtocol]
Processed HTTP request [action=/ignite, jsonRes=GridRestResponse
[successStatus=0, sesTokStr=null, err=null, obj=CacheQueryResult [qryId=26,
last=true]], req=(GET
/ignite?cmd=qryexe&pageSize=10&cacheName=CollegeCache&type=College&arg1=Student-17&qry=register_number+%3D+%3F)@581065253
org.eclipse.jetty.server.Request@22a25a25]
[2017-09-16 15:37:45,290][DEBUG][pub-#467%null%][GridClosureProcessor] Grid
runnable finished normally: closure-proc-worker
[2017-09-16
15:37:45,334][DEBUG][grid-timeout-worker-#15%null%][GridTimeoutProcessor]
Timeout has occurred:
org.apache.ignite.internal.processors.cache.GridCacheProcessor$RemovedItemsCleanupTask@2f317187
[2017-09-16
15:37:45,334][DEBUG][grid-timeout-worker-#15%null%][GridResourceProcessor]
Injecting resources:
org.apache.ignite.internal.processors.cache.GridCacheProcessor$RemovedItemsCleanupTask$1@7d99f682
[2017-09-16 15:37:45,334][DEBUG][sys-#468%null%][GridClosureProcessor] Grid
runnable started: closure-proc-worker
[2017-09-16 15:37:45,334][DEBUG][sys-#468%null%][GridClosureProcessor] Grid
runnable finished normally: closure-proc-worker
[2017-09-16
15:37:47,025][DEBUG][tcp-disco-msg-worker-#2%null%][TcpDiscoverySpi] No next
node in topology.
[2017-09-16
15:37:47,025][DEBUG][tcp-disco-msg-worker-#2%null%][TcpDiscoverySpi] No next
node in topology.
[2017-09-16 15:37:47,075][DEBUG][nio-acceptor-#16%null%][TcpCommunicationSpi]
Balancing data [min0=0, minIdx=0, max0=-1, maxIdx=-1]
[2017-09-16
15:37:47,093][DEBUG][grid-timeout-worker-#15%null%][GridTimeoutProcessor]
Timeout has occurred: CancelableTask
[id=d70f32b8e51-9cefaec4-c955-4dfc-9a06-c38dcf766ffd, endTime=1505576267085,
period=5000, cancel=false,
task=org.apache.ignite.internal.processors.cache.query.continuous.CacheContinuousQueryManager$BackupCleaner@190473ff]
[2017-09-16
15:37:47,093][DEBUG][grid-timeout-worker-#15%null%][GridTimeoutProcessor]
Timeout has occurred: CancelableTask
[id=e70f32b8e51-9cefaec4-c955-4dfc-9a06-c38dcf766ffd, endTime=1505576267085,
period=5000, cancel=false,
task=org.apache.ignite.internal.processors.cache.query.continuous.CacheContinuousQueryManager$BackupCleaner@7dbda89c]
====================================================================================================
///////***************************** qryexe, response and logs
*****************************\\\\\\\\
====================================================================================================
http://xx.xx.xx.xx:8080/ignite?cmd=qryexe&type=College&pageSize=10&cacheName=CollegeCache&arg1=Student-3&arg2=Austin&qry=register_number+%3D+%3F+and+college_start_date_1+%3D+%3F
{
"successStatus": 0,
"error": null,
"sessionToken": null,
"response": {
"items": [],
"last": true,
"fieldsMetadata": [],
"queryId": 27
}
}
[2017-09-16
15:38:02,799][DEBUG][grid-timeout-worker-#15%null%][GridTimeoutProcessor]
Timeout has occurred: CancelableTask
[id=570f32b8e51-9cefaec4-c955-4dfc-9a06-c38dcf766ffd, endTime=1505576282797,
period=3000, cancel=false,
task=org.apache.ignite.internal.processors.query.GridQueryProcessor$2@19dc4a89]
[2017-09-16
15:38:02,799][DEBUG][grid-timeout-worker-#15%null%][GridTimeoutProcessor]
Timeout has occurred: CancelableTask
[id=770f32b8e51-9cefaec4-c955-4dfc-9a06-c38dcf766ffd, endTime=1505576282797,
period=3000, cancel=false, task=MetricsUpdater [prevGcTime=99,
prevCpuTime=20500,
super=org.apache.ignite.internal.managers.discovery.GridDiscoveryManager$MetricsUpdater@7a395b30]]
[2017-09-16 15:38:02,977][DEBUG][qtp848097505-59][GridJettyRestProtocol]
Handling request [target=/ignite, req=(GET
/ignite?cmd=qryexe&type=College&pageSize=10&cacheName=CollegeCache&arg1=Student-3&arg2=Austin&qry=register_number+%3D+%3F+and+college_start_date_1+%3D+%3F)@581065253
org.eclipse.jetty.server.Request@22a25a25, srvReq=(GET
/ignite?cmd=qryexe&type=College&pageSize=10&cacheName=CollegeCache&arg1=Student-3&arg2=Austin&qry=register_number+%3D+%3F+and+college_start_date_1+%3D+%3F)@581065253
org.eclipse.jetty.server.Request@22a25a25]
[2017-09-16 15:38:02,978][DEBUG][qtp848097505-59][GridJettyRestProtocol]
Initialized command request: GridRestRequest [destId=null, clientId=null,
addr=/106.200.218.80:19593, cmd=EXECUTE_SQL_QUERY]
[2017-09-16 15:38:02,978][DEBUG][rest-#470%null%][GridRestProcessor] Grid
runnable started: rest-proc-worker
[2017-09-16 15:38:02,978][DEBUG][rest-#470%null%][GridRestProcessor] Received
request from client: GridRestRequest [destId=null, clientId=null,
addr=/106.200.218.80:19593, cmd=EXECUTE_SQL_QUERY]
[2017-09-16 15:38:02,978][DEBUG][rest-#470%null%][GridResourceProcessor]
Injecting resources:
org.apache.ignite.internal.processors.rest.handlers.query.QueryCommandHandler$ExecuteQueryCallable@2cf8a7e0
[2017-09-16 15:38:02,978][DEBUG][rest-#470%null%][GridRestProcessor] Grid
runnable finished normally: rest-proc-worker
[2017-09-16 15:38:02,978][DEBUG][pub-#471%null%][GridClosureProcessor] Grid
runnable started: closure-proc-worker
[2017-09-16 15:38:02,978][DEBUG][pub-#471%null%][GridCacheProcessor] Getting
public cache for name: CollegeCache
[2017-09-16 15:38:02,979][DEBUG][pub-#471%null%][IgniteH2Indexing] Set schema:
"CollegeCache"
[2017-09-16 15:38:02,979][DEBUG][pub-#471%null%][IgniteH2Indexing] Parsed
query: `SELECT "CollegeCache".CollegeTab._key, "CollegeCache".CollegeTab._val
FROM "CollegeCache".CollegeTab WHERE register_number = ? and
college_start_date_1 = ?` into two step query: GridCacheTwoStepQuery
[mapQrys=[GridCacheSqlQuery [qry=SELECT
"CollegeCache".__Z0._KEY __C0_0,
"CollegeCache".__Z0._VAL __C0_1
FROM "CollegeCache".CollegeTab __Z0
WHERE (__Z0.register_number = ?1) AND (__Z0.college_start_date_1 = ?2),
paramIdxs=[0, 1], cols={__C0_0=GridSqlType [type=13, scale=0,
precision=2147483647, displaySize=2147483647, sql=VARCHAR], __C0_1=GridSqlType
[type=19, scale=0, precision=2147483647, displaySize=2147483647, sql=OTHER]},
alias=null, sort=[], partitioned=true, node=null]], rdc=GridCacheSqlQuery
[qry=SELECT
__C0_0 _KEY,
__C0_1 _VAL
FROM PUBLIC.__T0, paramIdxs=[], cols=null, alias=null, sort=null,
partitioned=false, node=null], pageSize=1024, explain=false, originalSql=SELECT
"CollegeCache".CollegeTab._KEY,
"CollegeCache".CollegeTab._VAL
FROM "CollegeCache".CollegeTab
WHERE (register_number = ?1) AND (college_start_date_1 = ?2),
distributedJoins=false, skipMergeTbl=true, local=false]
[2017-09-16 15:38:02,980][DEBUG][pub-#471%null%][GridReduceQueryExecutor]
Sending: [msg=GridH2QueryRequest [reqId=20, caches=[139226600],
topVer=AffinityTopologyVersion [topVer=2, minorTopVer=0], parts=null,
qryParts=null, pageSize=1024, qrys=[GridCacheSqlQuery [qry=SELECT
"CollegeCache".__Z0._KEY __C0_0,
"CollegeCache".__Z0._VAL __C0_1
FROM "CollegeCache".CollegeTab __Z0
WHERE (__Z0.register_number = ?1) AND (__Z0.college_start_date_1 = ?2),
paramIdxs=[0, 1], cols={__C0_0=GridSqlType [type=13, scale=0,
precision=2147483647, displaySize=2147483647, sql=VARCHAR], __C0_1=GridSqlType
[type=19, scale=0, precision=2147483647, displaySize=2147483647, sql=OTHER]},
alias=null, sort=[], partitioned=true, node=null]], flags=2, tbls=null,
timeout=0, params=[Student-3, Austin]], nodes=[TcpDiscoveryNode
[id=e8e02510-88dc-4ea2-9f4d-116f56c7cdd4, addrs=[0:0:0:0:0:0:0:1%lo, 10.0.2.4,
127.0.0.1], sockAddrs=[/10.0.2.4:47500, /0:0:0:0:0:0:0:1%lo:47500,
/127.0.0.1:47500], discPort=47500, order=1, intOrder=1,
lastExchangeTime=1505572956427, loc=true, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false]], specialize=null]
[2017-09-16 15:38:02,980][DEBUG][pub-#471%null%][GridCacheProcessor] Getting
internal cache adapter: CollegeCache
[2017-09-16 15:38:02,980][DEBUG][pub-#471%null%][GridCacheProcessor] Getting
internal cache adapter: CollegeCache
[2017-09-16 15:38:02,980][DEBUG][pub-#471%null%][GridCacheProcessor] Getting
internal cache adapter: CollegeCache
[2017-09-16 15:38:02,980][DEBUG][pub-#471%null%][GridCacheProcessor] Getting
internal cache adapter: CollegeCache
[2017-09-16 15:38:02,980][DEBUG][pub-#471%null%][GridReduceQueryExecutor]
Processed response:
e8e02510-88dc-4ea2-9f4d-116f56c7cdd4->e8e02510-88dc-4ea2-9f4d-116f56c7cdd4
GridQueryNextPageResponse [qryReqId=20, segmentId=0, qry=0, page=0, allRows=0,
cols=2, retry=null, valsSize=0, rowsSize=0]
[2017-09-16 15:38:02,981][DEBUG][pub-#471%null%][GridMapQueryExecutor]
Processed request:
e8e02510-88dc-4ea2-9f4d-116f56c7cdd4->e8e02510-88dc-4ea2-9f4d-116f56c7cdd4
GridH2QueryRequest [reqId=20, caches=[139226600],
topVer=AffinityTopologyVersion [topVer=2, minorTopVer=0], parts=null,
qryParts=null, pageSize=1024, qrys=[GridCacheSqlQuery [qry=SELECT
"CollegeCache".__Z0._KEY __C0_0,
"CollegeCache".__Z0._VAL __C0_1
FROM "CollegeCache".CollegeTab __Z0
WHERE (__Z0.register_number = ?1) AND (__Z0.college_start_date_1 = ?2),
paramIdxs=[0, 1], cols={__C0_0=GridSqlType [type=13, scale=0,
precision=2147483647, displaySize=2147483647, sql=VARCHAR], __C0_1=GridSqlType
[type=19, scale=0, precision=2147483647, displaySize=2147483647, sql=OTHER]},
alias=null, sort=[], partitioned=true, node=null]], flags=2, tbls=null,
timeout=0, params=[Student-3, Austin]]
[2017-09-16 15:38:02,981][DEBUG][qtp848097505-59][GridJettyRestProtocol] Parsed
command response into JSON object:
{"successStatus":0,"error":null,"sessionToken":null,"response":{"items":[],"last":true,"fieldsMetadata":[],"queryId":27}}
[2017-09-16 15:38:02,981][DEBUG][pub-#471%null%][GridClosureProcessor] Grid
runnable finished normally: closure-proc-worker
[2017-09-16 15:38:02,982][DEBUG][qtp848097505-59][GridJettyRestProtocol]
Processed HTTP request [action=/ignite, jsonRes=GridRestResponse
[successStatus=0, sesTokStr=null, err=null, obj=CacheQueryResult [qryId=27,
last=true]], req=(GET
/ignite?cmd=qryexe&type=College&pageSize=10&cacheName=CollegeCache&arg1=Student-3&arg2=Austin&qry=register_number+%3D+%3F+and+college_start_date_1+%3D+%3F)@581065253
org.eclipse.jetty.server.Request@22a25a25]
[2017-09-16
15:38:03,044][DEBUG][tcp-disco-msg-worker-#2%null%][TcpDiscoverySpi] No next
node in topology.
[2017-09-16
15:38:03,044][DEBUG][tcp-disco-msg-worker-#2%null%][TcpDiscoverySpi] No next
node in topology.
[2017-09-16
15:38:04,363][DEBUG][grid-timeout-worker-#15%null%][GridTimeoutProcessor]
Timeout has occurred: CancelableTask
[id=470f32b8e51-9cefaec4-c955-4dfc-9a06-c38dcf766ffd, endTime=1505576284361,
period=10000, cancel=false,
task=org.apache.ignite.internal.processors.query.h2.IgniteH2Indexing$11@4c279fcc]
[2017-09-16
15:38:04,518][DEBUG][exchange-worker-#28%null%][GridCachePartitionExchangeManager]
Before waiting for exchange futures [futs[], worker=GridWorker
[name=partition-exchanger, igniteInstanceName=null, finished=false,
hashCode=337772022, interrupted=false, runner=exchange-worker-#28%null%]]
[2017-09-16
15:38:05,047][DEBUG][tcp-disco-msg-worker-#2%null%][TcpDiscoverySpi] No next
node in topology.
[2017-09-16
15:38:05,048][DEBUG][tcp-disco-msg-worker-#2%null%][TcpDiscoverySpi] No next
node in topology.
[2017-09-16 15:38:05,095][DEBUG][nio-acceptor-#16%null%][TcpCommunicationSpi]
Balancing data [min0=0, minIdx=0, max0=-1, maxIdx=-1]
[2017-09-16 15:38:05,280][DEBUG][nio-acceptor-#22%null%][GridTcpRestProtocol]
Balancing data [min0=0, minIdx=0, max0=-1, maxIdx=-1]
[2017-09-16
15:38:05,337][DEBUG][grid-timeout-worker-#15%null%][GridTimeoutProcessor]
Timeout has occurred:
org.apache.ignite.internal.processors.cache.GridCacheProcessor$RemovedItemsCleanupTask@135e90be
[2017-09-16
15:38:05,337][DEBUG][grid-timeout-worker-#15%null%][GridResourceProcessor]
Injecting resources:
org.apache.ignite.internal.processors.cache.GridCacheProcessor$RemovedItemsCleanupTask$1@558bd03
[2017-09-16 15:38:05,338][DEBUG][sys-#472%null%][GridClosureProcessor] Grid
runnable started: closure-proc-worker
[2017-09-16 15:38:05,338][DEBUG][sys-#472%null%][GridClosureProcessor] Grid
runnable finished normally: closure-proc-worker
[2017-09-16
15:38:05,805][DEBUG][grid-timeout-worker-#15%null%][GridTimeoutProcessor]
Timeout has occurred: CancelableTask
[id=570f32b8e51-9cefaec4-c955-4dfc-9a06-c38dcf766ffd, endTime=1505576285797,
period=3000, cancel=false,
task=org.apache.ignite.internal.processors.query.GridQueryProcessor$2@19dc4a89]
[2017-09-16
15:38:05,805][DEBUG][grid-timeout-worker-#15%null%][GridTimeoutProcessor]
Timeout has occurred: CancelableTask
[id=770f32b8e51-9cefaec4-c955-4dfc-9a06-c38dcf766ffd, endTime=1505576285797,
period=3000, cancel=false, task=MetricsUpdater [prevGcTime=99,
prevCpuTime=20510,
super=org.apache.ignite.internal.managers.discovery.GridDiscoveryManager$MetricsUpdater@7a395b30]]
[2017-09-16
15:38:07,050][DEBUG][tcp-disco-msg-worker-#2%null%][TcpDiscoverySpi] No next
node in topology.
[2017-09-16
15:38:07,050][DEBUG][tcp-disco-msg-worker-#2%null%][TcpDiscoverySpi] No next
node in topology.
[2017-09-16
15:38:07,109][DEBUG][grid-timeout-worker-#15%null%][GridTimeoutProcessor]
Timeout has occurred: CancelableTask
[id=d70f32b8e51-9cefaec4-c955-4dfc-9a06-c38dcf766ffd, endTime=1505576287100,
period=5000, cancel=false,
task=org.apache.ignite.internal.processors.cache.query.continuous.CacheContinuousQueryManager$BackupCleaner@190473ff]
