search

thinkaurelius / titan

Distributed Graph Database
http://titandb.io
Apache License 2.0
5.25k stars 1.01k forks source link

Not an instance of the expected data type: expected byte, found java.lang.Byte #222

Closed zachkinstner closed 11 years ago

zachkinstner commented 11 years ago

Using RexPro, I am trying to create a typed Byte index. Due to MsgPack data limitations, my Byte parameter is converted to a Long (see https://github.com/tinkerpop/rexster/issues/295). I have to re-cast that parameter to a Byte within the Gremlin script.

This seems related to Marko's issue posted a few hours ago: https://github.com/thinkaurelius/titan/issues/220. I posted it as a separate issue because I could not reproduce these issues via the DogHouse Gremlin console. The problem occurs when I use the RexsterClient/RexPro.

Builds

Rexster 2.3.0 Titan 0.3.0

Steps to Reproduce

Using the following Java code:

public static void main(String args[]) {
    Map<String, Object> params = new HashMap<String, Object>();
    params.put("A", (byte)99);

    runTest("g", null);
    runTest("g.makeType().dataType(Byte.class).name('ByteVal').unique(OUT).indexed(Vertex.class).makePropertyKey()", null);
    runTest("g.addVertex([ByteVal:A.byteValue()])", params);
    runTest("g.addVertex([ByteVal:(byte)A])", params);
    runTest("g.addVertex([ByteVal:(byte)A.byteValue()])", params);
}

public static void runTest(String script, Map<String,Object> paramMap) throws Exception {
    System.out.println("\ngremlin> "+script);

    try {
        RexsterClient client = RexsterClientFactory.open(MyRexConfig);
        List<Object> list = client.execute(script, paramMap);
        System.out.println("==> "+list);
    }
    catch ( Exception e ) {
        System.err.println("==> "+e);
    }
}

Produces is output/errors (some exception output removed with "[...]"):

gremlin> g
==> [titangraph[local:data/FabricTest]]

gremlin> g.makeType().dataType(Byte.class).name('ByteVal').unique(OUT).indexed(Vertex.class).makePropertyKey()
==> [{_id=36028797018964802, _type=vertex}]

gremlin> g.addVertex([ByteVal:A.byteValue()])
==> [...] java.lang.IllegalArgumentException: Value [99] is not an instance of the expected data type for property key [ByteVal]. Expected: byte, found: class java.lang.Byte

gremlin> g.addVertex([ByteVal:(byte)A])
==> [...] java.lang.IllegalArgumentException: Value [99] is not an instance of the expected data type for property key [ByteVal]. Expected: byte, found: class java.lang.Byte

gremlin> g.addVertex([ByteVal:(byte)A.byteValue()])
==> [...] java.lang.IllegalArgumentException: Value [99] is not an instance of the expected data type for property key [ByteVal]. Expected: byte, found: class java.lang.Byte
zachkinstner commented 11 years ago

Without parameters:

gremlin> g.addVertex([ByteVal:(byte)88])
==> [...] java.lang.IllegalArgumentException: Value [88] is not an instance of the expected data type for property key [ByteVal]. Expected: byte, found: class java.lang.Byte

Without creating an index:

gremlin> g.makeType().dataType(Byte.class).name('ByteNonIndex').unique(OUT).makePropertyKey()
==> [{_id=36028797018964826, _type=vertex}]

gremlin> g.addVertex([ByteNonIndex:A.byteValue()])
==> [...] java.lang.IllegalArgumentException: Value [99] is not an instance of the expected data type for property key [ByteNonIndex]. Expected: byte, found: class java.lang.Byte

gremlin> g.addVertex([ByteNonIndex:(byte)A])
==> [...] java.lang.IllegalArgumentException: Value [99] is not an instance of the expected data type for property key [ByteNonIndex]. Expected: byte, found: class java.lang.Byte

Also occurs for the Short data type:

gremlin> g.makeType().dataType(Short.class).name('ShortVal').unique(OUT).indexed(Vertex.class).makePropertyKey()
==> [{_id=36028797018964810, _type=vertex}]

gremlin> g.addVertex([ShortVal:A.shortValue()])
==> [...] java.lang.IllegalArgumentException: Value [99] is not an instance of the expected data type for property key [ShortVal]. Expected: short, found: class java.lang.Short

gremlin> g.addVertex([ShortVal:(short)A])
==> [...] java.lang.IllegalArgumentException: Value [99] is not an instance of the expected data type for property key [ShortVal]. Expected: short, found: class java.lang.Short

Integer works as expected:

gremlin> g.makeType().dataType(Integer.class).name('IntVal').unique(OUT).indexed(Vertex.class).makePropertyKey()
==> [{_id=36028797018964818, _type=vertex}]

gremlin> g.addVertex([IntVal:A.toInteger()])
==> [{_properties={IntVal=99}, _id=768196, _type=vertex}]
zachkinstner commented 11 years ago

Using my new RexConnect project, in "console" mode:

RexConn script> g.makeType().dataType(Byte.class).name('ByteVal').unique(OUT).indexed(Vertex.class).makePropertyKey()
        params>

... [{"_id":"36028797018964842","_type":"vertex"}]
... 1248ms

RexConn script> g.addVertex([ByteVal:A.byteValue()])
        params> {"A":99}

... ERROR: [...] java.lang.IllegalArgumentException: Value [99] is not an instance of the expected data type for property key [ByteVal]. Expected: byte, found: class java.lang.Byte
... 1591ms

The relevant Rexster Server debug output, with "TRACE" output level and running with the "-d" debug flag:

[DEBUG] JuliToLog4jHandler - KEY IS REGISTERED: sun.nio.ch.SelectionKeyImpl@59ec59df
[TRACE] JuliToLog4jHandler - executing connection (TCPNIOConnection{localSocketAddress=/192.168.1.105:8184, peerSocketAddress=/192.168.1.106:63863}). IOEvent=ACCEPTED processor=org.glassfish.grizzly.filterchain.DefaultFilterChain@1f183871
[...]
[TRACE] VertexCentricQueryOptimizer - Splitting query [[v[-2]](OUT,null,[com.thinkaurelius.titan.graphdb.types.system.SystemKey@16fdf48d])-():true:PROPERTY] on type w/o group
[DEBUG] QueryProcessor - Optimized query [[v[-2]](OUT,null,[com.thinkaurelius.titan.graphdb.types.system.SystemKey@16fdf48d])-():true:PROPERTY] into 1 subqueries
[TRACE] StandardIDPool - [2] Returned id: 1400005
[TRACE] StandardIDPool - [1] Returned id: 140002
[DEBUG] TitanGraphQueryBuilder - Best index for query [[(com.thinkaurelius.titan.graphdb.types.system.SystemKey@7f371a59=ByteVal)]:VERTEX]: standard
[DEBUG] QueryProcessor - Optimized query [[(com.thinkaurelius.titan.graphdb.types.system.SystemKey@7f371a59=ByteVal)]:VERTEX] into 1 subqueries
[DEBUG] StandardTitanTx$6 - Answering query [[(com.thinkaurelius.titan.graphdb.types.system.SystemKey@7f371a59=ByteVal)]:VERTEX] with index standard
[DEBUG] CachedKeyColumnValueStore - Cache Retrieval on vertexindex. Attempts: 2 | Misses: 2
[TRACE] StandardTitanGraph - Checking node existence for 36028797018964842
[TRACE] BerkeleyJEKeyValueStore - Get slice query
[TRACE] BerkeleyJEKeyValueStore - Retrieved: 0
[TRACE] VertexCentricQueryOptimizer - Splitting query [[v[36028797018964842]](OUT,null,[com.thinkaurelius.titan.graphdb.types.system.SystemKey@46205df9])-():true:PROPERTY] on type w/o group
[DEBUG] QueryProcessor - Optimized query [[v[36028797018964842]](OUT,null,[com.thinkaurelius.titan.graphdb.types.system.SystemKey@46205df9])-():true:PROPERTY] into 1 subqueries
[DEBUG] CachedKeyColumnValueStore - Cache Retrieval on edgestore. Attempts: 1 | Misses: 1
[TRACE] VertexCentricQueryOptimizer - Splitting query [[v[560008]](OUT,null,[v[36028797018964842]])-():false:PROPERTY] on type w/o group
[DEBUG] QueryProcessor - Optimized query [[v[560008]](OUT,null,[v[36028797018964842]])-():false:PROPERTY] into 1 subqueries
[WARN] ScriptFilter - Could not process script [g.addVertex([ByteVal:A.byteValue()])] for language [groovy] on session [null] and request [[B@4d677979]
zachkinstner commented 11 years ago

The exception comes from AttributeUtil. The issue is the class comparison within line 48:

datatype.equals(attribute.getClass())

I'm not a Java developer, so I may be missing something obvious. After some tests and Google searches, however, it seems there exists no trivial way to compare between primitives and object types (like "byte" and "java.lang.Byte"). I wrote some testing code to try some comparisons; the commented-out lines threw exceptions:

private static final void Bug222() {
        Class<?> typeA = Byte.class;
        Class<?> typeB = byte.class;
        Byte valA = new Byte((byte)123);
        byte valB = (byte)123;

        System.out.println("A: "+typeA+" / "+valA);
        System.out.println("B: "+typeB+" / "+valB);

        System.out.println("TypeA Equals TypeB: "+typeA.equals(typeB));
        System.out.println("ValA Equals ValB: "+valA.equals(valB));

        //System.out.println("TypeA AsSub TypeB: "+typeA.asSubclass(typeB));
        //System.out.println("TypeB AsSub TypeA: "+typeB.asSubclass(typeA));

        //System.out.println("TypeA Cast TypeB: "+typeA.cast(typeB));
        //System.out.println("TypeB Cast TypeA: "+typeB.cast(typeA));
        System.out.println("TypeA Cast TypeA: "+typeA.cast(valA));
       // System.out.println("TypeA Cast TypeA: "+typeB.cast(valA));
        System.out.println("TypeA Cast TypeB: "+typeA.cast(valB));
        //System.out.println("TypeA Cast TypeB: "+typeB.cast(valB));

        System.out.println("TypeA Assign TypeB: "+typeA.isAssignableFrom(typeB));
        System.out.println("TypeB Assign TypeA: "+typeB.isAssignableFrom(typeA));

        System.out.println("TypeA Inst TypeB: "+typeA.isInstance(typeB));
        System.out.println("TypeB Inst TypeB: "+typeB.isInstance(typeA));
        System.out.println("TypeA Inst ValA: "+typeA.isInstance(typeA));
        System.out.println("TypeA Inst ValB: "+typeA.isInstance(typeB));
        System.out.println("TypeB Inst ValA: "+typeB.isInstance(typeA));
        System.out.println("TypeB Inst ValB: "+typeB.isInstance(typeB));

        System.out.println("ValA Equals ValB: "+valA.equals(valB));
        System.out.println("TypeA Classses: "+typeA.getClasses().length);
        System.out.println("TypeB Classses: "+typeB.getClasses().length);
    }

Which produces the output:

A: class java.lang.Byte / 123
B: byte / 123
TypeA Equals TypeB: false
ValA Equals ValB: true
TypeA Cast TypeA: 123
TypeA Cast TypeB: 123
TypeA Assign TypeB: false
TypeB Assign TypeA: false
TypeA Inst TypeB: false
TypeB Inst TypeB: false
TypeA Inst ValA: false
TypeA Inst ValB: false
TypeB Inst ValA: false
TypeB Inst ValB: false
ValA Equals ValB: true
TypeA Classses: 0
TypeB Classses: 0
zachkinstner commented 11 years ago

When I create the Byte property within the Dog House console, I don't receive these errors. Once that property has been added, I can successfully create a vertex with a "ByteVal" property from that same console, using Rexster REST, and using RexConnect via the RexPro client.

The exception occurs only when I create the Byte property using the REST API (see below), or via RexPro.

http://rexster:8182/graphs/FabricTest/tp/gremlin?script=g.makeType%28%29.dataType%28Byte.class%29.name%28%27ByteVal4%27%29.unique%28OUT%29.indexed%28Vertex.class%29.makePropertyKey%28%29

...

{
    "results": [
        {
            "_id": 36028797018964870,
            "_type": "vertex"
        }
    ],
    "success": true,
    "version": "2.3.0",
    "queryTime": 144.012032
}
http://rexster:8182/graphs/FabricTest/tp/gremlin?script=g.addVertex%28[ByteVal4:%28byte%2999]%29

...

{
    "error": "javax.script.ScriptException: java.lang.IllegalArgumentException: Value [99] is not an instance of the expected data type for property key [ByteVal4]. Expected: byte, found: class java.lang.Byte",
    [...]
}

For these Byte properties defined via REST/RexPro, attempting to add a vertex via DogHouse console generates the same error:

gremlin> g.addVertex([ByteVal:99.byteValue()])
==> javax.script.ScriptException: java.lang.IllegalArgumentException: Value [99] is not an instance of the expected data type for property key [ByteVal4]. Expected: byte, found: class java.lang.Byte
zachkinstner commented 11 years ago

I captured Rexster's debug output while performing the index creation via Gremlin Console and then RexConnect Console. There's a lot of output, so this is going to be a long comment. Is there a way to attach text files instead?

Index creation code:

g.makeType().dataType(Byte.class).name('ByteVal').unique(OUT).indexed(Vertex.class).makePropertyKey()

Performed using the DogHouse Gremlin Console:

[DEBUG] JuliToLog4jHandler - KEY IS REGISTERED: sun.nio.ch.SelectionKeyImpl@46ad89ec
[TRACE] JuliToLog4jHandler - executing connection (TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}). IOEvent=ACCEPTED processor=org.glassfish.grizzly.filterchain.DefaultFilterChain@cd73c3c
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.filterchain.TransportFilter@6b38dba context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=ACCEPT, message=null, address=null]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=org.glassfish.grizzly.filterchain.TransportFilter@6b38dba context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=ACCEPT, message=null, address=null] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.utils.IdleTimeoutFilter@761db1c5 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=ACCEPT, message=null, address=null]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=org.glassfish.grizzly.utils.IdleTimeoutFilter@761db1c5 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=ACCEPT, message=null, address=null] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.http.HttpServerFilter@667262b6 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=ACCEPT, message=null, address=null]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=org.glassfish.grizzly.http.HttpServerFilter@667262b6 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=ACCEPT, message=null, address=null] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.http.server.FileCacheFilter@5faecf45 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=ACCEPT, message=null, address=null]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=org.glassfish.grizzly.http.server.FileCacheFilter@5faecf45 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=ACCEPT, message=null, address=null] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.http.server.HttpServerFilter@4da9ec16 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=ACCEPT, message=null, address=null]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=org.glassfish.grizzly.http.server.HttpServerFilter@4da9ec16 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=ACCEPT, message=null, address=null] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[TRACE] JuliToLog4jHandler - executing connection (TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}). IOEvent=READ processor=org.glassfish.grizzly.filterchain.DefaultFilterChain@cd73c3c
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.filterchain.TransportFilter@6b38dba context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=READ, message=null, address=null]
[DEBUG] JuliToLog4jHandler - TCPNIOConnection (TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}) (allocated) read 593 bytes
[DEBUG] JuliToLog4jHandler - after execute filter. filter=org.glassfish.grizzly.filterchain.TransportFilter@6b38dba context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=READ, message=HeapBuffer (63506285) [pos=0 lim=593 cap=593], address=/127.0.0.1:53183] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.utils.IdleTimeoutFilter@761db1c5 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=READ, message=HeapBuffer (63506285) [pos=0 lim=593 cap=593], address=/127.0.0.1:53183]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=org.glassfish.grizzly.utils.IdleTimeoutFilter@761db1c5 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=READ, message=HeapBuffer (63506285) [pos=0 lim=593 cap=593], address=/127.0.0.1:53183] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.http.HttpServerFilter@667262b6 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=READ, message=HeapBuffer (63506285) [pos=0 lim=593 cap=593], address=/127.0.0.1:53183]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=org.glassfish.grizzly.http.HttpServerFilter@667262b6 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=READ, message=org.glassfish.grizzly.http.HttpContent@306870c, address=/127.0.0.1:53183] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@57364b53
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.http.server.FileCacheFilter@5faecf45 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=READ, message=org.glassfish.grizzly.http.HttpContent@306870c, address=/127.0.0.1:53183]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=org.glassfish.grizzly.http.server.FileCacheFilter@5faecf45 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=READ, message=org.glassfish.grizzly.http.HttpContent@306870c, address=/127.0.0.1:53183] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.http.server.HttpServerFilter@4da9ec16 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=READ, message=org.glassfish.grizzly.http.HttpContent@306870c, address=/127.0.0.1:53183]
[INFO] JuliToLog4jHandler - [doghouse] [POST /exec?code=g.makeType().dataType(Byte.class).name('ByteVal6').unique(OUT).indexed(Vertex.class).makePropertyKey()] 200 OK
[TRACE] VertexCentricQueryOptimizer - Splitting query [[v[-2]](OUT,null,[com.thinkaurelius.titan.graphdb.types.system.SystemKey@4f14e777])-():true:PROPERTY] on type w/o group
[DEBUG] QueryProcessor - Optimized query [[v[-2]](OUT,null,[com.thinkaurelius.titan.graphdb.types.system.SystemKey@4f14e777])-():true:PROPERTY] into 1 subqueries
[DEBUG] TitanGraphQueryBuilder - Best index for query [[(com.thinkaurelius.titan.graphdb.types.system.SystemKey@4f14e777=ByteVal6)]:VERTEX]: standard
[DEBUG] QueryProcessor - Optimized query [[(com.thinkaurelius.titan.graphdb.types.system.SystemKey@4f14e777=ByteVal6)]:VERTEX] into 1 subqueries
[DEBUG] StandardTitanTx$6 - Answering query [[(com.thinkaurelius.titan.graphdb.types.system.SystemKey@4f14e777=ByteVal6)]:VERTEX] with index standard
[DEBUG] CachedKeyColumnValueStore - Cache Retrieval on vertexindex. Attempts: 1 | Misses: 1
[TRACE] BerkeleyJEKeyValueStore - Get slice query
[TRACE] BerkeleyJEKeyValueStore - Retrieved: 0
[TRACE] StandardIDPool - [2] Returned id: 1500004
[TRACE] VertexCentricQueryOptimizer - Splitting query [[v[-2]](OUT,null,[com.thinkaurelius.titan.graphdb.types.system.SystemKey@140de648])-():true:PROPERTY] on type w/o group
[DEBUG] QueryProcessor - Optimized query [[v[-2]](OUT,null,[com.thinkaurelius.titan.graphdb.types.system.SystemKey@140de648])-():true:PROPERTY] into 1 subqueries
[TRACE] StandardIDPool - [2] Returned id: 1500005
[TRACE] VertexCentricQueryOptimizer - Splitting query [[v[-2]](OUT,null,[com.thinkaurelius.titan.graphdb.types.system.SystemKey@1c898b41])-():true:PROPERTY] on type w/o group
[DEBUG] QueryProcessor - Optimized query [[v[-2]](OUT,null,[com.thinkaurelius.titan.graphdb.types.system.SystemKey@1c898b41])-():true:PROPERTY] into 1 subqueries
[TRACE] StandardIDPool - [2] Returned id: 1500006
[TRACE] StandardIDPool - [3] Returned id: 134
[TRACE] VertexCentricQueryOptimizer - Splitting query [[v[-2]](OUT,null,[com.thinkaurelius.titan.graphdb.types.system.SystemKey@140de648])-():true:PROPERTY] on type w/o group
[DEBUG] QueryProcessor - Optimized query [[v[-2]](OUT,null,[com.thinkaurelius.titan.graphdb.types.system.SystemKey@140de648])-():true:PROPERTY] into 1 subqueries
[TRACE] JuliToLog4jHandler - executing connection (TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}). IOEvent=NONE processor=org.glassfish.grizzly.filterchain.DefaultFilterChain@cd73c3c
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.http.server.FileCacheFilter@5faecf45 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=WRITE, message=org.glassfish.grizzly.http.HttpContent@306870c, address=null]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=org.glassfish.grizzly.http.server.FileCacheFilter@5faecf45 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=WRITE, message=org.glassfish.grizzly.http.HttpContent@306870c, address=null] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.http.HttpServerFilter@667262b6 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=WRITE, message=org.glassfish.grizzly.http.HttpContent@306870c, address=null]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=org.glassfish.grizzly.http.HttpServerFilter@667262b6 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=WRITE, message=BuffersBuffer (2016131963) [pos=0 lim=216 cap=216 bufferSize=2 buffers=[HeapBuffer (419871992) [pos=0 lim=192 cap=192], HeapBuffer (157305502) [pos=0 lim=24 cap=24], null, null]], address=null] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.utils.IdleTimeoutFilter@761db1c5 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=WRITE, message=BuffersBuffer (2016131963) [pos=0 lim=216 cap=216 bufferSize=2 buffers=[HeapBuffer (419871992) [pos=0 lim=192 cap=192], HeapBuffer (157305502) [pos=0 lim=24 cap=24], null, null]], address=null]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=org.glassfish.grizzly.utils.IdleTimeoutFilter@761db1c5 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=WRITE, message=BuffersBuffer (2016131963) [pos=0 lim=216 cap=216 bufferSize=2 buffers=[HeapBuffer (419871992) [pos=0 lim=192 cap=192], HeapBuffer (157305502) [pos=0 lim=24 cap=24], null, null]], address=null] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.filterchain.TransportFilter@6b38dba context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=WRITE, message=BuffersBuffer (2016131963) [pos=0 lim=216 cap=216 bufferSize=2 buffers=[HeapBuffer (419871992) [pos=0 lim=192 cap=192], HeapBuffer (157305502) [pos=0 lim=24 cap=24], null, null]], address=null]
[DEBUG] JuliToLog4jHandler - TCPNIOConnection (TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}) (composite) write 216 bytes
[DEBUG] JuliToLog4jHandler - after execute filter. filter=org.glassfish.grizzly.filterchain.TransportFilter@6b38dba context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=WRITE, message=null, address=null] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[TRACE] JuliToLog4jHandler - executing connection (TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}). IOEvent=NONE processor=org.glassfish.grizzly.filterchain.DefaultFilterChain@cd73c3c
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.http.server.FileCacheFilter@5faecf45 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=EVENT, message=null, address=/127.0.0.1:53183]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=org.glassfish.grizzly.http.server.FileCacheFilter@5faecf45 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=EVENT, message=null, address=/127.0.0.1:53183] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.http.HttpServerFilter@667262b6 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=EVENT, message=null, address=/127.0.0.1:53183]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=org.glassfish.grizzly.http.HttpServerFilter@667262b6 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=EVENT, message=null, address=/127.0.0.1:53183] nextAction=org.glassfish.grizzly.filterchain.StopAction@7cb64078
[DEBUG] JuliToLog4jHandler - after execute filter. filter=org.glassfish.grizzly.http.server.HttpServerFilter@4da9ec16 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=READ, message=org.glassfish.grizzly.http.server.Response@17cb0a16, address=/127.0.0.1:53183] nextAction=org.glassfish.grizzly.filterchain.StopAction@7cb64078
[TRACE] JuliToLog4jHandler - executing connection (TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}). IOEvent=READ processor=org.glassfish.grizzly.filterchain.DefaultFilterChain@cd73c3c
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.filterchain.TransportFilter@6b38dba context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=READ, message=null, address=null]
[DEBUG] JuliToLog4jHandler - TCPNIOConnection (TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}) (allocated) read 392 bytes
[DEBUG] JuliToLog4jHandler - after execute filter. filter=org.glassfish.grizzly.filterchain.TransportFilter@6b38dba context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=READ, message=HeapBuffer (63506285) [pos=0 lim=392 cap=392], address=/127.0.0.1:53183] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.utils.IdleTimeoutFilter@761db1c5 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=READ, message=HeapBuffer (63506285) [pos=0 lim=392 cap=392], address=/127.0.0.1:53183]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=org.glassfish.grizzly.utils.IdleTimeoutFilter@761db1c5 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=READ, message=HeapBuffer (63506285) [pos=0 lim=392 cap=392], address=/127.0.0.1:53183] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.http.HttpServerFilter@667262b6 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=READ, message=HeapBuffer (63506285) [pos=0 lim=392 cap=392], address=/127.0.0.1:53183]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=org.glassfish.grizzly.http.HttpServerFilter@667262b6 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=READ, message=org.glassfish.grizzly.http.HttpContent@306870c, address=/127.0.0.1:53183] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.http.server.FileCacheFilter@5faecf45 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=READ, message=org.glassfish.grizzly.http.HttpContent@306870c, address=/127.0.0.1:53183]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=org.glassfish.grizzly.http.server.FileCacheFilter@5faecf45 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=READ, message=org.glassfish.grizzly.http.HttpContent@306870c, address=/127.0.0.1:53183] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.http.server.HttpServerFilter@4da9ec16 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=READ, message=org.glassfish.grizzly.http.HttpContent@306870c, address=/127.0.0.1:53183]
[DEBUG] JuliToLog4jHandler - Cookies: Parsing b[]: JSESSIONID=1277850429080098989
[TRACE] JuliToLog4jHandler - executing connection (TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}). IOEvent=NONE processor=org.glassfish.grizzly.filterchain.DefaultFilterChain@cd73c3c
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.http.server.FileCacheFilter@5faecf45 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=WRITE, message=org.glassfish.grizzly.http.HttpContent@306870c, address=null]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=org.glassfish.grizzly.http.server.FileCacheFilter@5faecf45 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=WRITE, message=org.glassfish.grizzly.http.HttpContent@306870c, address=null] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.http.HttpServerFilter@667262b6 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=WRITE, message=org.glassfish.grizzly.http.HttpContent@306870c, address=null]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=org.glassfish.grizzly.http.HttpServerFilter@667262b6 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=WRITE, message=BuffersBuffer (2016131963) [pos=0 lim=13530 cap=13530 bufferSize=3 buffers=[HeapBuffer (419871992) [pos=0 lim=147 cap=147], HeapBuffer (1680568263) [pos=0 lim=8192 cap=8192], HeapBuffer (157305502) [pos=0 lim=5191 cap=5191], null]], address=null] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.utils.IdleTimeoutFilter@761db1c5 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=WRITE, message=BuffersBuffer (2016131963) [pos=0 lim=13530 cap=13530 bufferSize=3 buffers=[HeapBuffer (419871992) [pos=0 lim=147 cap=147], HeapBuffer (1680568263) [pos=0 lim=8192 cap=8192], HeapBuffer (157305502) [pos=0 lim=5191 cap=5191], null]], address=null]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=org.glassfish.grizzly.utils.IdleTimeoutFilter@761db1c5 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=WRITE, message=BuffersBuffer (2016131963) [pos=0 lim=13530 cap=13530 bufferSize=3 buffers=[HeapBuffer (419871992) [pos=0 lim=147 cap=147], HeapBuffer (1680568263) [pos=0 lim=8192 cap=8192], HeapBuffer (157305502) [pos=0 lim=5191 cap=5191], null]], address=null] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.filterchain.TransportFilter@6b38dba context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=WRITE, message=BuffersBuffer (2016131963) [pos=0 lim=13530 cap=13530 bufferSize=3 buffers=[HeapBuffer (419871992) [pos=0 lim=147 cap=147], HeapBuffer (1680568263) [pos=0 lim=8192 cap=8192], HeapBuffer (157305502) [pos=0 lim=5191 cap=5191], null]], address=null]
[DEBUG] JuliToLog4jHandler - TCPNIOConnection (TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}) (composite) write 13,530 bytes
[DEBUG] JuliToLog4jHandler - after execute filter. filter=org.glassfish.grizzly.filterchain.TransportFilter@6b38dba context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=WRITE, message=null, address=null] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[TRACE] JuliToLog4jHandler - executing connection (TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}). IOEvent=NONE processor=org.glassfish.grizzly.filterchain.DefaultFilterChain@cd73c3c
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.http.server.FileCacheFilter@5faecf45 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=EVENT, message=null, address=/127.0.0.1:53183]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=org.glassfish.grizzly.http.server.FileCacheFilter@5faecf45 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=EVENT, message=null, address=/127.0.0.1:53183] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.http.HttpServerFilter@667262b6 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=EVENT, message=null, address=/127.0.0.1:53183]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=org.glassfish.grizzly.http.HttpServerFilter@667262b6 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=EVENT, message=null, address=/127.0.0.1:53183] nextAction=org.glassfish.grizzly.filterchain.StopAction@7cb64078
[DEBUG] JuliToLog4jHandler - after execute filter. filter=org.glassfish.grizzly.http.server.HttpServerFilter@4da9ec16 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8182, peerSocketAddress=/127.0.0.1:53183}, operation=READ, message=org.glassfish.grizzly.http.server.Response@17cb0a16, address=/127.0.0.1:53183] nextAction=org.glassfish.grizzly.filterchain.StopAction@7cb64078

Performed using RexConnect Console:

DEBUG] JuliToLog4jHandler - KEY IS REGISTERED: sun.nio.ch.SelectionKeyImpl@1f4e8ac9
[TRACE] JuliToLog4jHandler - executing connection (TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}). IOEvent=ACCEPTED processor=org.glassfish.grizzly.filterchain.DefaultFilterChain@132d9844
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.filterchain.TransportFilter@76749ebc context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=ACCEPT, message=null, address=null]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=org.glassfish.grizzly.filterchain.TransportFilter@76749ebc context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=ACCEPT, message=null, address=null] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.utils.IdleTimeoutFilter@15664f1a context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=ACCEPT, message=null, address=null]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=org.glassfish.grizzly.utils.IdleTimeoutFilter@15664f1a context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=ACCEPT, message=null, address=null] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[DEBUG] JuliToLog4jHandler - Execute filter. filter=com.tinkerpop.rexster.protocol.filter.RexProMessageFilter@3c9ff588 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=ACCEPT, message=null, address=null]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=com.tinkerpop.rexster.protocol.filter.RexProMessageFilter@3c9ff588 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=ACCEPT, message=null, address=null] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[DEBUG] JuliToLog4jHandler - Execute filter. filter=com.tinkerpop.rexster.protocol.filter.SessionFilter@29b0d2d0 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=ACCEPT, message=null, address=null]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=com.tinkerpop.rexster.protocol.filter.SessionFilter@29b0d2d0 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=ACCEPT, message=null, address=null] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[DEBUG] JuliToLog4jHandler - Execute filter. filter=com.tinkerpop.rexster.protocol.filter.ScriptFilter@17e06b12 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=ACCEPT, message=null, address=null]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=com.tinkerpop.rexster.protocol.filter.ScriptFilter@17e06b12 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=ACCEPT, message=null, address=null] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[TRACE] JuliToLog4jHandler - executing connection (TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}). IOEvent=READ processor=org.glassfish.grizzly.filterchain.DefaultFilterChain@132d9844
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.filterchain.TransportFilter@76749ebc context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=READ, message=null, address=null]
[DEBUG] JuliToLog4jHandler - TCPNIOConnection (TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}) (allocated) read 217 bytes
[DEBUG] JuliToLog4jHandler - after execute filter. filter=org.glassfish.grizzly.filterchain.TransportFilter@76749ebc context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=READ, message=HeapBuffer (2083095816) [pos=0 lim=217 cap=217], address=/127.0.0.1:53208] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.utils.IdleTimeoutFilter@15664f1a context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=READ, message=HeapBuffer (2083095816) [pos=0 lim=217 cap=217], address=/127.0.0.1:53208]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=org.glassfish.grizzly.utils.IdleTimeoutFilter@15664f1a context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=READ, message=HeapBuffer (2083095816) [pos=0 lim=217 cap=217], address=/127.0.0.1:53208] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[DEBUG] JuliToLog4jHandler - Execute filter. filter=com.tinkerpop.rexster.protocol.filter.RexProMessageFilter@3c9ff588 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=READ, message=HeapBuffer (2083095816) [pos=0 lim=217 cap=217], address=/127.0.0.1:53208]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=com.tinkerpop.rexster.protocol.filter.RexProMessageFilter@3c9ff588 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=READ, message=com.tinkerpop.rexster.protocol.msg.ScriptRequestMessage@9dd0fe7, address=/127.0.0.1:53208] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@57398044
[DEBUG] JuliToLog4jHandler - Execute filter. filter=com.tinkerpop.rexster.protocol.filter.SessionFilter@29b0d2d0 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=READ, message=com.tinkerpop.rexster.protocol.msg.ScriptRequestMessage@9dd0fe7, address=/127.0.0.1:53208]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=com.tinkerpop.rexster.protocol.filter.SessionFilter@29b0d2d0 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=READ, message=com.tinkerpop.rexster.protocol.msg.ScriptRequestMessage@9dd0fe7, address=/127.0.0.1:53208] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[DEBUG] JuliToLog4jHandler - Execute filter. filter=com.tinkerpop.rexster.protocol.filter.ScriptFilter@17e06b12 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=READ, message=com.tinkerpop.rexster.protocol.msg.ScriptRequestMessage@9dd0fe7, address=/127.0.0.1:53208]
[TRACE] VertexCentricQueryOptimizer - Splitting query [[v[-2]](OUT,null,[com.thinkaurelius.titan.graphdb.types.system.SystemKey@4f14e777])-():true:PROPERTY] on type w/o group
[DEBUG] QueryProcessor - Optimized query [[v[-2]](OUT,null,[com.thinkaurelius.titan.graphdb.types.system.SystemKey@4f14e777])-():true:PROPERTY] into 1 subqueries
[DEBUG] TitanGraphQueryBuilder - Best index for query [[(com.thinkaurelius.titan.graphdb.types.system.SystemKey@4f14e777=ByteVal7)]:VERTEX]: standard
[DEBUG] QueryProcessor - Optimized query [[(com.thinkaurelius.titan.graphdb.types.system.SystemKey@4f14e777=ByteVal7)]:VERTEX] into 1 subqueries
[DEBUG] StandardTitanTx$6 - Answering query [[(com.thinkaurelius.titan.graphdb.types.system.SystemKey@4f14e777=ByteVal7)]:VERTEX] with index standard
[DEBUG] CachedKeyColumnValueStore - Cache Retrieval on vertexindex. Attempts: 2 | Misses: 2
[TRACE] BerkeleyJEKeyValueStore - Get slice query
[TRACE] BerkeleyJEKeyValueStore - Retrieved: 0
[TRACE] StandardIDPool - [2] Returned id: 1500007
[TRACE] VertexCentricQueryOptimizer - Splitting query [[v[-2]](OUT,null,[com.thinkaurelius.titan.graphdb.types.system.SystemKey@140de648])-():true:PROPERTY] on type w/o group
[DEBUG] QueryProcessor - Optimized query [[v[-2]](OUT,null,[com.thinkaurelius.titan.graphdb.types.system.SystemKey@140de648])-():true:PROPERTY] into 1 subqueries
[TRACE] StandardIDPool - [2] Returned id: 1500008
[TRACE] VertexCentricQueryOptimizer - Splitting query [[v[-2]](OUT,null,[com.thinkaurelius.titan.graphdb.types.system.SystemKey@1c898b41])-():true:PROPERTY] on type w/o group
[DEBUG] QueryProcessor - Optimized query [[v[-2]](OUT,null,[com.thinkaurelius.titan.graphdb.types.system.SystemKey@1c898b41])-():true:PROPERTY] into 1 subqueries
[TRACE] StandardIDPool - [2] Returned id: 1500009
[TRACE] StandardIDPool - [3] Returned id: 135
[TRACE] VertexCentricQueryOptimizer - Splitting query [[v[-2]](OUT,null,[com.thinkaurelius.titan.graphdb.types.system.SystemKey@140de648])-():true:PROPERTY] on type w/o group
[DEBUG] QueryProcessor - Optimized query [[v[-2]](OUT,null,[com.thinkaurelius.titan.graphdb.types.system.SystemKey@140de648])-():true:PROPERTY] into 1 subqueries
[DEBUG] QueryProcessor - Optimized query [[v[36028797018965050]](OUT,null,[])-():false:PROPERTY] into 1 subqueries
[DEBUG] StandardTitanGraph - Saving transaction. Added 3, removed 0
[TRACE] BerkeleyJEKeyValueStore - Acquiring lock.
[TRACE] JuliToLog4jHandler - executing connection (TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}). IOEvent=NONE processor=org.glassfish.grizzly.filterchain.DefaultFilterChain@132d9844
[DEBUG] JuliToLog4jHandler - Execute filter. filter=com.tinkerpop.rexster.protocol.filter.SessionFilter@29b0d2d0 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=WRITE, message=[B@7f787395, address=null]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=com.tinkerpop.rexster.protocol.filter.SessionFilter@29b0d2d0 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=WRITE, message=[B@7f787395, address=null] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[DEBUG] JuliToLog4jHandler - Execute filter. filter=com.tinkerpop.rexster.protocol.filter.RexProMessageFilter@3c9ff588 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=WRITE, message=[B@7f787395, address=null]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=com.tinkerpop.rexster.protocol.filter.RexProMessageFilter@3c9ff588 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=WRITE, message=HeapBuffer (2083095816) [pos=0 lim=79 cap=79], address=null] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.utils.IdleTimeoutFilter@15664f1a context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=WRITE, message=HeapBuffer (2083095816) [pos=0 lim=79 cap=79], address=null]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=org.glassfish.grizzly.utils.IdleTimeoutFilter@15664f1a context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=WRITE, message=HeapBuffer (2083095816) [pos=0 lim=79 cap=79], address=null] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.filterchain.TransportFilter@76749ebc context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=WRITE, message=HeapBuffer (2083095816) [pos=0 lim=79 cap=79], address=null]
[TRACE] JuliToLog4jHandler - AsyncQueueWriter.write connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208} record=org.glassfish.grizzly.asyncqueue.AsyncWriteQueueRecord@46fb3d6 directWrite=true
[DEBUG] JuliToLog4jHandler - after execute filter. filter=org.glassfish.grizzly.filterchain.TransportFilter@76749ebc context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=WRITE, message=null, address=null] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[DEBUG] JuliToLog4jHandler - after execute filter. filter=com.tinkerpop.rexster.protocol.filter.ScriptFilter@17e06b12 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=READ, message=com.tinkerpop.rexster.protocol.msg.ScriptRequestMessage@9dd0fe7, address=/127.0.0.1:53208] nextAction=org.glassfish.grizzly.filterchain.StopAction@7cb64078
[TRACE] JuliToLog4jHandler - executing connection (TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}). IOEvent=READ processor=org.glassfish.grizzly.filterchain.DefaultFilterChain@132d9844
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.filterchain.TransportFilter@76749ebc context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=READ, message=null, address=null]
[DEBUG] JuliToLog4jHandler - TCPNIOConnection (TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}) (allocated) read -1 bytes
[TRACE] JuliToLog4jHandler - executing connection (TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}). IOEvent=CLOSED processor=org.glassfish.grizzly.filterchain.DefaultFilterChain@132d9844
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.filterchain.TransportFilter@76749ebc context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=CLOSE, message=null, address=null]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=org.glassfish.grizzly.filterchain.TransportFilter@76749ebc context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=CLOSE, message=null, address=null] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[DEBUG] JuliToLog4jHandler - Execute filter. filter=org.glassfish.grizzly.utils.IdleTimeoutFilter@15664f1a context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=CLOSE, message=null, address=null]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=org.glassfish.grizzly.utils.IdleTimeoutFilter@15664f1a context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=CLOSE, message=null, address=null] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[DEBUG] JuliToLog4jHandler - Execute filter. filter=com.tinkerpop.rexster.protocol.filter.RexProMessageFilter@3c9ff588 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=CLOSE, message=null, address=null]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=com.tinkerpop.rexster.protocol.filter.RexProMessageFilter@3c9ff588 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=CLOSE, message=null, address=null] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[DEBUG] JuliToLog4jHandler - Execute filter. filter=com.tinkerpop.rexster.protocol.filter.SessionFilter@29b0d2d0 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=CLOSE, message=null, address=null]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=com.tinkerpop.rexster.protocol.filter.SessionFilter@29b0d2d0 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=CLOSE, message=null, address=null] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[DEBUG] JuliToLog4jHandler - Execute filter. filter=com.tinkerpop.rexster.protocol.filter.ScriptFilter@17e06b12 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=CLOSE, message=null, address=null]
[DEBUG] JuliToLog4jHandler - after execute filter. filter=com.tinkerpop.rexster.protocol.filter.ScriptFilter@17e06b12 context=FilterChainContext [connection=TCPNIOConnection{localSocketAddress=/127.0.0.1:8184, peerSocketAddress=/127.0.0.1:53208}, operation=CLOSE, message=null, address=null] nextAction=org.glassfish.grizzly.filterchain.InvokeAction@62618565
[DEBUG] JuliToLog4jHandler - Exception during FilterChain execution
java.io.EOFException
    at org.glassfish.grizzly.nio.transport.TCPNIOTransport.read(TCPNIOTransport.java:919)
    at org.glassfish.grizzly.nio.transport.TCPNIOTransportFilter.handleRead(TCPNIOTransportFilter.java:74)
    at org.glassfish.grizzly.filterchain.TransportFilter.handleRead(TransportFilter.java:173)
    at org.glassfish.grizzly.filterchain.ExecutorResolver$9.execute(ExecutorResolver.java:119)
    at org.glassfish.grizzly.filterchain.DefaultFilterChain.executeFilter(DefaultFilterChain.java:265)
    at org.glassfish.grizzly.filterchain.DefaultFilterChain.executeChainPart(DefaultFilterChain.java:200)
    at org.glassfish.grizzly.filterchain.DefaultFilterChain.execute(DefaultFilterChain.java:134)
    at org.glassfish.grizzly.filterchain.DefaultFilterChain.process(DefaultFilterChain.java:112)
    at org.glassfish.grizzly.ProcessorExecutor.execute(ProcessorExecutor.java:78)
    at org.glassfish.grizzly.nio.transport.TCPNIOTransport.fireIOEvent(TCPNIOTransport.java:815)
    at org.glassfish.grizzly.strategies.AbstractIOStrategy.fireIOEvent(AbstractIOStrategy.java:112)
    at org.glassfish.grizzly.strategies.LeaderFollowerNIOStrategy.executeIoEvent(LeaderFollowerNIOStrategy.java:102)
    at org.glassfish.grizzly.strategies.AbstractIOStrategy.executeIoEvent(AbstractIOStrategy.java:88)
    at org.glassfish.grizzly.nio.SelectorRunner.iterateKeyEvents(SelectorRunner.java:398)
    at org.glassfish.grizzly.nio.SelectorRunner.iterateKeys(SelectorRunner.java:368)
    at org.glassfish.grizzly.nio.SelectorRunner.doSelect(SelectorRunner.java:334)
    at org.glassfish.grizzly.nio.SelectorRunner.run(SelectorRunner.java:264)
    at org.glassfish.grizzly.threadpool.AbstractThreadPool$Worker.doWork(AbstractThreadPool.java:567)
    at org.glassfish.grizzly.threadpool.AbstractThreadPool$Worker.run(AbstractThreadPool.java:547)
    at java.lang.Thread.run(Thread.java:680)

Compared to the Gremlin output, the RexConnect output...

[DEBUG] QueryProcessor - Optimized query [[v[36028797018965050]](OUT,null,[])-():false:PROPERTY] into 1 subqueries
[DEBUG] StandardTitanGraph - Saving transaction. Added 3, removed 0
[TRACE] BerkeleyJEKeyValueStore - Acquiring lock.
zachkinstner commented 11 years ago

Confirmed -- I can now use the Byte type as described above.