Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

Potential federation error 4.1 iRODS query across zones getting objStat #126

Closed
michael-conway opened this issue Jun 2, 2015 · 1 comment
Closed

Potential federation error 4.1 iRODS query across zones getting objStat #126

michael-conway opened this issue Jun 2, 2015 · 1 comment
Assignees
@michael-conway
Milestone
4.0.2.3 with iROD...

Comments

@michael-conway
Copy link
Collaborator

see FederatedCollectionAndDataObjectListAndSearchAOImplTest

/**
     * For a collection, add a federated user, and then query the collections
     * with permissions to make sure the cross zone user is found, with the
     * appropriate zone. In this case the query is made from a user logged in to
     * zone 2. The query should look at the data on zone1
     * 
     * @throws Exception
     */
    @Test
    public void testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2()
            throws Exception {

        if (!testingPropertiesHelper.isTestFederatedZone(testingProperties)) {
            return;
        }

        String testCollectionName = "testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2";
        String subCollName = "testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl";

        String targetIrodsCollection = testingPropertiesHelper
                .buildIRODSCollectionAbsolutePathFromTestProperties(
                        testingProperties, IRODS_TEST_SUBDIR_PATH + "/"
                                + testCollectionName);

        IRODSAccount irodsAccount = testingPropertiesHelper
                .buildIRODSAccountFromTestProperties(testingProperties);
        CollectionAO collectionAO = irodsFileSystem
                .getIRODSAccessObjectFactory().getCollectionAO(irodsAccount);
        IRODSFile irodsFile = irodsFileSystem.getIRODSFileFactory(irodsAccount)
                .instanceIRODSFile(targetIrodsCollection, subCollName);
        irodsFile.deleteWithForceOption();
        irodsFile.mkdirs();

        collectionAO
                .setAccessPermissionRead(
                        "",
                        irodsFile.getAbsolutePath(),
                        testingProperties
                                .getProperty(TestingPropertiesHelper.IRODS_SECONDARY_USER_KEY),
                        true);

        collectionAO
                .setAccessPermissionRead(
                        testingProperties
                                .getProperty(TestingPropertiesHelper.IRODS_FEDERATED_ZONE_KEY),
                        irodsFile.getAbsolutePath(),
                        testingProperties
                                .getProperty(TestingPropertiesHelper.IRODS_FEDERATED_USER_KEY),
                        true);

        IRODSAccount zone2Account = testingPropertiesHelper
                .buildIRODSAccountForFederatedZoneFromTestProperties(testingProperties);
        CollectionAndDataObjectListAndSearchAO collectionAndDataObjectListAndSearchAO = irodsFileSystem
                .getIRODSAccessObjectFactory()
                .getCollectionAndDataObjectListAndSearchAO(zone2Account);

        List<CollectionAndDataObjectListingEntry> collections = collectionAndDataObjectListAndSearchAO
                .listCollectionsUnderPathWithPermissions(targetIrodsCollection,
                        0);

        Assert.assertEquals("should have 1 collection", 1, collections.size());

        boolean foundCrossZone = false;

        List<UserFilePermission> userFilePermissions = collections.get(0)
                .getUserFilePermission();
        Assert.assertNotNull("got a null userFilePermissions",
                userFilePermissions);
        Assert.assertFalse("did not find the permissions",
                userFilePermissions.isEmpty());
        Assert.assertTrue("did not find the three permissions",
                userFilePermissions.size() >= 3);

        for (UserFilePermission userFilePermission : userFilePermissions) {
            if (userFilePermission
                    .getUserZone()
                    .equals(testingProperties
                            .getProperty(TestingPropertiesHelper.IRODS_FEDERATED_ZONE_KEY))
                    && userFilePermission
                            .getUserName()
                            .equals(testingProperties
                                    .getProperty(TestingPropertiesHelper.IRODS_FEDERATED_USER_KEY))) {
                foundCrossZone = true;
            }

        }

        Assert.assertTrue("did not find cross zone user with zone info",
                foundCrossZone);
    }

appears to fail getting an objStat on a zone1 path from zone2, which is a regression from previous iRODS versions. This needs to be looked at to make sure no config errors exist, but am federated, can see other zone, etc.

Stack trace and jargon log from test...

log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@59906517, irodsAccount=irods://[email protected]:1247]
5300 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
5300 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
5300 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
5300 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126534, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@614ddd49, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@1f554b06, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20126
   reconnAddr:fedzone1-410
   cookie:486858398, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@59906517, irodsAccount=irods://[email protected]:1247]
5301 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
5301 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
5301 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
5301 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126534, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@614ddd49, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@1f554b06, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20126
   reconnAddr:fedzone1-410
   cookie:486858398, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@59906517, irodsAccount=irods://[email protected]:1247]
5301 [main] INFO  org.irods.jargon.core.pub.io.IRODSFileImpl  - setting file name, given path = /fedZone1/home/test1/jargon-scratch/jargon-scratch
5301 [main] INFO  org.irods.jargon.core.pub.io.IRODSFileImpl  - detected local separator = \
5301 [main] INFO  org.irods.jargon.core.pub.io.IRODSFileImpl  - file name was set as: jargon-scratch
5301 [main] INFO  org.irods.jargon.core.pub.IRODSFileSystemAOImpl  - mkdir(final IRODSFile irodsFile, final boolean recursiveOpr)
5301 [main] INFO  org.irods.jargon.core.pub.IRODSFileSystemAOImpl  - making dir for:/fedZone1/home/test1/jargon-scratch/jargon-scratch
5301 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126534, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@614ddd49, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@1f554b06, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20126
   reconnAddr:fedzone1-410
   cookie:486858398, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@59906517, irodsAccount=irods://[email protected]:1247]
5301 [main] DEBUG org.irods.jargon.core.packinstr.CollInp  - kvp tag: <KeyValPair_PI><ssLen>1</ssLen>
<keyWord>recursiveOpr</keyWord>
<svalue></svalue>
</KeyValPair_PI>

5301 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with byte array
5301 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with:<CollInpNew_PI><collName>/fedZone1/home/test1/jargon-scratch/jargon-scratch</collName>
<flags>0</flags>
<oprType>0</oprType>
<KeyValPair_PI><ssLen>1</ssLen>
<keyWord>recursiveOpr</keyWord>
<svalue></svalue>
</KeyValPair_PI>
</CollInpNew_PI>

5301 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - api number is:681
5301 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 681
5301 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_API_REQ</type><msgLen>241</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>681</intInfo></MsgHeader_PI>
5301 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
5301 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
5301 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
5301 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
5308 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  139
5308 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
5308 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 139
5309 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:0
5309 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
5309 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
5309 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:0
5309 [main] DEBUG org.irods.jargon.core.pub.IRODSFileSystemAOImpl  - mkdir succesful
5309 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - closing all irods sessions
5309 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - found and am closing connection to : irods://[email protected]:1247
5309 [main] DEBUG org.irods.jargon.core.connection.IRODSSimpleProtocolManager  - irodsMidLevelProtocol returned:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126534, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@614ddd49, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@1f554b06, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20126
   reconnAddr:fedzone1-410
   cookie:486858398, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@59906517, irodsAccount=irods://[email protected]:1247]
5309 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - shutting down, need to send disconnect to irods
5309 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - sending disconnect message
5309 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 0
5309 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_DISCONNECT</type><msgLen>0</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>0</intInfo></MsgHeader_PI>
5309 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - finally, shutdown is being called on the given connection
5309 [main] DEBUG org.irods.jargon.core.connection.IRODSBasicTCPConnection  - shutting down connection: true
5309 [main] DEBUG org.irods.jargon.core.connection.IRODSBasicTCPConnection  - is connected for : irods://[email protected]:1247/fedZone1/home/test1/main/1433261126534
5309 [main] DEBUG org.irods.jargon.core.connection.IRODSBasicTCPConnection  - now disconnected
5309 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - all sessions closed for this Thread
5309 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
5309 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
5309 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - no connections are cached, so create a new cache map
5309 [main] DEBUG org.irods.jargon.core.connection.IRODSSimpleProtocolManager  - creating an IRODSSimpleConnection for account:irods://[email protected]:1247
5309 [main] DEBUG org.irods.jargon.core.connection.IRODSProtocolManager  - creating a fresh AbstractIRODSMidLevelProtocol for account:irods://[email protected]:1247
5309 [main] INFO  org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocolFactory  - instance() method...calling connection life cycle
5309 [main] INFO  org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocolFactory  - create connection....
5309 [main] INFO  org.irods.jargon.core.connection.IRODSTCPConnectionFactoryImpl  - instance()
5309 [main] INFO  org.irods.jargon.core.connection.AbstractConnection  - AbstractConnection()
5309 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - initializing connection with account:irods://[email protected]:1247
5309 [main] INFO  org.irods.jargon.core.connection.AbstractConnection  - opening irods socket
5309 [main] DEBUG org.irods.jargon.core.connection.IRODSBasicTCPConnection  - connect()
5309 [main] DEBUG org.irods.jargon.core.connection.IRODSBasicTCPConnection  - connecting socket to agent
5309 [main] DEBUG org.irods.jargon.core.connection.IRODSBasicTCPConnection  - normal iRODS connection
5311 [main] DEBUG org.irods.jargon.core.connection.IRODSBasicTCPConnection  - connection to socket made...
5311 [main] DEBUG org.irods.jargon.core.connection.IRODSBasicTCPConnection  - default buffer on input stream
5311 [main] DEBUG org.irods.jargon.core.connection.IRODSBasicTCPConnection  - default buffer on input stream
5311 [main] DEBUG org.irods.jargon.core.connection.IRODSBasicTCPConnection  - socket opened successfully
5311 [main] INFO  org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocolFactory  - ...have connection, now authenticate given the auth scheme in the iRODS account...
5311 [main] INFO  org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocolFactory  - authenticate()
5311 [main] INFO  org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocolFactory  - get auth mechanism
5311 [main] INFO  org.irods.jargon.core.connection.AuthenticationFactoryImpl  - instanceAuthMechanism()
5311 [main] INFO  org.irods.jargon.core.connection.AuthenticationFactoryImpl  - authScheme:STANDARD
5311 [main] INFO  org.irods.jargon.core.connection.AuthenticationFactoryImpl  - using standard auth
5311 [main] INFO  org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocolFactory  - authenticate...
5311 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 0
5311 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_CONNECT</type><msgLen>340</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>0</intInfo></MsgHeader_PI>
5311 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
5311 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
5311 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
5311 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
5338 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  139
5338 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
5338 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 139
5338 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:205
5338 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
5338 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
5338 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:0
5338 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length greater than zero
5338 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  205
5338 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
5338 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 205
5338 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message from IRODS read back:<Version_PI><status>0</status>
<relVersion>rods4.1.0</relVersion>
<apiVersion>d</apiVersion>
<reconnPort>20036</reconnPort>
<reconnAddr>fedzone1-410</reconnAddr>
<cookie>1084217353</cookie>
</Version_PI>

5338 [main] INFO  org.irods.jargon.core.connection.AuthMechanism  - startup response:StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20036
   reconnAddr:fedzone1-410
   cookie:1084217353
5339 [main] INFO  org.irods.jargon.core.connection.StandardIRODSAuth  - authenticate
5339 [main] INFO  org.irods.jargon.core.connection.StandardIRODSAuth  - sending standard irods password
5339 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 703
5339 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_API_REQ</type><msgLen>0</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>703</intInfo></MsgHeader_PI>
5339 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
5339 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
5339 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
5339 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
5339 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  141
5339 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
5339 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 141
5339 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:153
5339 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
5339 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
5339 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:0
5339 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length greater than zero
5339 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  153
5339 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
5339 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 153
5339 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message from IRODS read back:<authRequestOut_PI><challenge>DxAzSvtFlt/V6dAg6L9DHJrF9NFhc4m3HIi+m5C+KLemCXPFGeeKBHVDC3EPJijlJ4gWW1gCHw3SR2oKoiXXiA==</challenge>
</authRequestOut_PI>

5339 [main] DEBUG org.irods.jargon.core.connection.AuthMechanism  - cached challenge response:DxAzSvtFlt/V6dAg6L9DHJrF9NFhc4m3HIi+m5C+KLemCXPFGeeKBHVDC3EPJijlJ4gWW1gCHw3SR2oKoiXXiA==
5339 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with byte array
5339 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with:<authResponseInp_PI><response>BZ0Z7IZrmZGhFu4SHZfxGA==</response>
<username>test1</username>
</authResponseInp_PI>

5339 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - api number is:704
5339 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 704
5339 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_API_REQ</type><msgLen>115</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>704</intInfo></MsgHeader_PI>
5339 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
5340 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
5340 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
5340 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
5342 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  139
5342 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
5342 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 139
5342 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:0
5342 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
5342 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
5342 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:0
5342 [main] INFO  org.irods.jargon.core.connection.StandardIRODSAuth  - auth was successful
5343 [main] INFO  org.irods.jargon.core.connection.StandardIRODSAuth  - auth response was:org.irods.jargon.core.connection.auth.AuthResponse@5bfbf16f
5343 [main] INFO  org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocolFactory  - ..authenticated...now decorate and return...
5343 [main] INFO  org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocolFactory  - decorate()
5343 [main] INFO  org.irods.jargon.core.connection.EnvironmentalInfoAccessor  - getting irods server properties
5343 [main] DEBUG org.irods.jargon.core.connection.EnvironmentalInfoAccessor  - checking for cached properties...
5343 [main] INFO  org.irods.jargon.core.connection.DiscoveredServerPropertiesCache  - now retriving server properties from cache with zone:fedZone1
5343 [main] INFO  org.irods.jargon.core.connection.EnvironmentalInfoAccessor  - returning cached props:IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true

5343 [main] INFO  org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocolFactory  - IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true

5343 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - put a reference to a new connection for account: irods://[email protected]:1247
5343 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - returned new connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126578, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@614ddd49, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@1f554b06, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20036
   reconnAddr:fedzone1-410
   cookie:1084217353, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@5bfbf16f, irodsAccount=irods://[email protected]:1247]
5343 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - put a reference to a new connection for account: irods://[email protected]:1247
5343 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
5343 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
5343 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126578, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@614ddd49, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@1f554b06, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20036
   reconnAddr:fedzone1-410
   cookie:1084217353, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@5bfbf16f, irodsAccount=irods://[email protected]:1247]
5343 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
5343 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
5343 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
5343 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126578, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@614ddd49, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@1f554b06, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20036
   reconnAddr:fedzone1-410
   cookie:1084217353, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@5bfbf16f, irodsAccount=irods://[email protected]:1247]
5343 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
5343 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
5343 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
5343 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126578, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@614ddd49, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@1f554b06, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20036
   reconnAddr:fedzone1-410
   cookie:1084217353, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@5bfbf16f, irodsAccount=irods://[email protected]:1247]
5343 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
5343 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
5343 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
5343 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126578, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@614ddd49, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@1f554b06, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20036
   reconnAddr:fedzone1-410
   cookie:1084217353, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@5bfbf16f, irodsAccount=irods://[email protected]:1247]
5343 [main] INFO  org.irods.jargon.core.pub.io.IRODSFileImpl  - setting file name, given path = /fedZone1/home/test1/jargon-scratch//FederatedCollectionAndDataObjectListAndSearchAOImplTest
5343 [main] INFO  org.irods.jargon.core.pub.io.IRODSFileImpl  - detected local separator = \
5343 [main] INFO  org.irods.jargon.core.pub.io.IRODSFileImpl  - file name was set as: FederatedCollectionAndDataObjectListAndSearchAOImplTest
5343 [main] INFO  org.irods.jargon.core.pub.IRODSFileSystemAOImpl  - mkdir(final IRODSFile irodsFile, final boolean recursiveOpr)
5343 [main] INFO  org.irods.jargon.core.pub.IRODSFileSystemAOImpl  - making dir for:/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest
5343 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126578, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@614ddd49, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@1f554b06, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20036
   reconnAddr:fedzone1-410
   cookie:1084217353, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@5bfbf16f, irodsAccount=irods://[email protected]:1247]
5343 [main] DEBUG org.irods.jargon.core.packinstr.CollInp  - kvp tag: <KeyValPair_PI><ssLen>1</ssLen>
<keyWord>recursiveOpr</keyWord>
<svalue></svalue>
</KeyValPair_PI>

5343 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with byte array
5343 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with:<CollInpNew_PI><collName>/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest</collName>
<flags>0</flags>
<oprType>0</oprType>
<KeyValPair_PI><ssLen>1</ssLen>
<keyWord>recursiveOpr</keyWord>
<svalue></svalue>
</KeyValPair_PI>
</CollInpNew_PI>

5343 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - api number is:681
5343 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 681
5343 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_API_REQ</type><msgLen>282</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>681</intInfo></MsgHeader_PI>
5343 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
5343 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
5343 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
5343 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
5347 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  139
5347 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
5347 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 139
5347 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:0
5347 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
5347 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
5347 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:0
5347 [main] DEBUG org.irods.jargon.core.pub.IRODSFileSystemAOImpl  - mkdir succesful
5347 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - closing all irods sessions
5347 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - found and am closing connection to : irods://[email protected]:1247
5347 [main] DEBUG org.irods.jargon.core.connection.IRODSSimpleProtocolManager  - irodsMidLevelProtocol returned:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126578, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@614ddd49, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@1f554b06, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20036
   reconnAddr:fedzone1-410
   cookie:1084217353, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@5bfbf16f, irodsAccount=irods://[email protected]:1247]
5347 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - shutting down, need to send disconnect to irods
5347 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - sending disconnect message
5347 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 0
5347 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_DISCONNECT</type><msgLen>0</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>0</intInfo></MsgHeader_PI>
5347 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - finally, shutdown is being called on the given connection
5347 [main] DEBUG org.irods.jargon.core.connection.IRODSBasicTCPConnection  - shutting down connection: true
5347 [main] DEBUG org.irods.jargon.core.connection.IRODSBasicTCPConnection  - is connected for : irods://[email protected]:1247/fedZone1/home/test1/main/1433261126578
5347 [main] DEBUG org.irods.jargon.core.connection.IRODSBasicTCPConnection  - now disconnected
5347 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - all sessions closed for this Thread
5347 [main] INFO  org.irods.jargon.core.connection.IRODSSimpleProtocolManager  - creating simple protocol manager
5347 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - IRODS Session creation, loading default properties, these may be overridden...
5348 [main] INFO  org.irods.jargon.core.pub.IRODSFileSystem  - IRODSfileSystem is initialized
5351 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
5353 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
5353 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
5354 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - no connections are cached, so create a new cache map
5354 [main] DEBUG org.irods.jargon.core.connection.IRODSSimpleProtocolManager  - creating an IRODSSimpleConnection for account:irods://[email protected]:1247
5354 [main] DEBUG org.irods.jargon.core.connection.IRODSProtocolManager  - creating a fresh AbstractIRODSMidLevelProtocol for account:irods://[email protected]:1247
5354 [main] INFO  org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocolFactory  - instance() method...calling connection life cycle
5354 [main] INFO  org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocolFactory  - create connection....
5354 [main] INFO  org.irods.jargon.core.connection.IRODSTCPConnectionFactoryImpl  - instance()
5354 [main] INFO  org.irods.jargon.core.connection.AbstractConnection  - AbstractConnection()
5354 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - initializing connection with account:irods://[email protected]:1247
5354 [main] INFO  org.irods.jargon.core.connection.AbstractConnection  - opening irods socket
5354 [main] DEBUG org.irods.jargon.core.connection.IRODSBasicTCPConnection  - connect()
5354 [main] DEBUG org.irods.jargon.core.connection.IRODSBasicTCPConnection  - connecting socket to agent
5354 [main] DEBUG org.irods.jargon.core.connection.IRODSBasicTCPConnection  - normal iRODS connection
5354 [main] DEBUG org.irods.jargon.core.connection.IRODSBasicTCPConnection  - connection to socket made...
5354 [main] DEBUG org.irods.jargon.core.connection.IRODSBasicTCPConnection  - default buffer on input stream
5354 [main] DEBUG org.irods.jargon.core.connection.IRODSBasicTCPConnection  - default buffer on input stream
5354 [main] DEBUG org.irods.jargon.core.connection.IRODSBasicTCPConnection  - socket opened successfully
5354 [main] INFO  org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocolFactory  - ...have connection, now authenticate given the auth scheme in the iRODS account...
5354 [main] INFO  org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocolFactory  - authenticate()
5354 [main] INFO  org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocolFactory  - get auth mechanism
5354 [main] INFO  org.irods.jargon.core.connection.AuthenticationFactoryImpl  - instanceAuthMechanism()
5354 [main] INFO  org.irods.jargon.core.connection.AuthenticationFactoryImpl  - authScheme:STANDARD
5354 [main] INFO  org.irods.jargon.core.connection.AuthenticationFactoryImpl  - using standard auth
5354 [main] INFO  org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocolFactory  - authenticate...
5354 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 0
5354 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_CONNECT</type><msgLen>340</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>0</intInfo></MsgHeader_PI>
5355 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
5355 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
5355 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
5355 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
5383 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  139
5384 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
5384 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 139
5384 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:204
5384 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
5384 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
5384 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:0
5384 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length greater than zero
5384 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  204
5384 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
5384 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 204
5384 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message from IRODS read back:<Version_PI><status>0</status>
<relVersion>rods4.1.0</relVersion>
<apiVersion>d</apiVersion>
<reconnPort>20045</reconnPort>
<reconnAddr>fedzone1-410</reconnAddr>
<cookie>981961296</cookie>
</Version_PI>

5384 [main] INFO  org.irods.jargon.core.connection.AuthMechanism  - startup response:StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296
5384 [main] INFO  org.irods.jargon.core.connection.StandardIRODSAuth  - authenticate
5384 [main] INFO  org.irods.jargon.core.connection.StandardIRODSAuth  - sending standard irods password
5384 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 703
5384 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_API_REQ</type><msgLen>0</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>703</intInfo></MsgHeader_PI>
5384 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
5384 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
5384 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
5384 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
5384 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  141
5384 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
5384 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 141
5384 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:153
5384 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
5384 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
5384 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:0
5384 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length greater than zero
5384 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  153
5384 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
5384 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 153
5385 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message from IRODS read back:<authRequestOut_PI><challenge>SBOy4nG/nYTZn4uWnk8w7vK5TuWx64IoVd63WVlGx9rq+3oNEPgFdSG5FahdXYfF2D3I4h59Fgj2hh8kVnPV9A==</challenge>
</authRequestOut_PI>

5385 [main] DEBUG org.irods.jargon.core.connection.AuthMechanism  - cached challenge response:SBOy4nG/nYTZn4uWnk8w7vK5TuWx64IoVd63WVlGx9rq+3oNEPgFdSG5FahdXYfF2D3I4h59Fgj2hh8kVnPV9A==
5385 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with byte array
5385 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with:<authResponseInp_PI><response>UpT8IoCPajEZJirS606p9A==</response>
<username>test1</username>
</authResponseInp_PI>

5385 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - api number is:704
5385 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 704
5385 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_API_REQ</type><msgLen>115</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>704</intInfo></MsgHeader_PI>
5385 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
5385 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
5385 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
5385 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
5390 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  139
5390 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
5390 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 139
5390 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:0
5390 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
5390 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
5390 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:0
5390 [main] INFO  org.irods.jargon.core.connection.StandardIRODSAuth  - auth was successful
5390 [main] INFO  org.irods.jargon.core.connection.StandardIRODSAuth  - auth response was:org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9
5390 [main] INFO  org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocolFactory  - ..authenticated...now decorate and return...
5390 [main] INFO  org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocolFactory  - decorate()
5390 [main] INFO  org.irods.jargon.core.connection.EnvironmentalInfoAccessor  - getting irods server properties
5390 [main] DEBUG org.irods.jargon.core.connection.EnvironmentalInfoAccessor  - checking for cached properties...
5390 [main] INFO  org.irods.jargon.core.connection.DiscoveredServerPropertiesCache  - now retriving server properties from cache with zone:fedZone1
5390 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with byte array
5390 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with:
5390 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - api number is:700
5390 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 700
5390 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_API_REQ</type><msgLen>0</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>700</intInfo></MsgHeader_PI>
5390 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
5390 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
5390 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
5390 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
5390 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  141
5390 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
5390 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 141
5390 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:198
5390 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
5390 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
5390 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:0
5390 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length greater than zero
5390 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  198
5391 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
5391 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 198
5391 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message from IRODS read back:<MiscSvrInfo_PI><serverType>1</serverType>
<serverBootTime>1433259442</serverBootTime>
<relVersion>rods4.1.0</relVersion>
<apiVersion>d</apiVersion>
<rodsZone>fedZone1</rodsZone>
</MiscSvrInfo_PI>

5391 [main] INFO  org.irods.jargon.core.connection.EnvironmentalInfoAccessor  - server response obtained
5391 [main] DEBUG org.irods.jargon.core.connection.EnvironmentalInfoAccessor  - cached the props for host and zone:IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true

5391 [main] INFO  org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocolFactory  - IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true

5391 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - put a reference to a new connection for account: irods://[email protected]:1247
5391 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - returned new connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
5391 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - put a reference to a new connection for account: irods://[email protected]:1247
5391 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
5391 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
5391 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
5391 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
5391 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
5391 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
5391 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
5391 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
5391 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
5391 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
5391 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
5391 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
5391 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
5391 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
5391 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
5391 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
5391 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
5391 [main] INFO  org.irods.jargon.core.pub.io.IRODSFileFactoryImpl  - instanceIRODSFile()
5391 [main] INFO  org.irods.jargon.core.pub.io.IRODSFileFactoryImpl  - parent:/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2
5391 [main] INFO  org.irods.jargon.core.pub.io.IRODSFileFactoryImpl  - child:testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl
5391 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
5391 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
5391 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
5391 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
5391 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
5391 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
5391 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
5391 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
5391 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
5391 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
5391 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
5391 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
5391 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
5391 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
5391 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
5391 [main] INFO  org.irods.jargon.core.pub.io.IRODSFileImpl  - setting file name, given path = testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl
5391 [main] INFO  org.irods.jargon.core.pub.io.IRODSFileImpl  - detected local separator = \
5391 [main] INFO  org.irods.jargon.core.pub.io.IRODSFileImpl  - file name was set as: testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl
8299 [main] INFO  org.irods.jargon.core.pub.io.IRODSFileImpl  - isFile() for path:/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl
8299 [main] INFO  org.irods.jargon.core.pub.IRODSFileSystemAOImpl  - getObjStat(final String irodsAbsolutePath)
9683 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
9684 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with byte array
9684 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with:<DataObjInp_PI><objPath>/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl</objPath>
<createMode>0</createMode>
<openFlags>0</openFlags>
<offset>0</offset>
<dataSize>0</dataSize>
<numThreads>0</numThreads>
<oprType>0</oprType>
<KeyValPair_PI><ssLen>0</ssLen>
</KeyValPair_PI>
</DataObjInp_PI>

9685 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - api number is:633
9685 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 633
9685 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_API_REQ</type><msgLen>503</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>633</intInfo></MsgHeader_PI>
9686 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
9686 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
9686 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
9686 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
9690 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  145
9690 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
9690 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 145
9691 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:0
9691 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
9691 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
9691 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:-310000
9691 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info is < 0
9691 [main] DEBUG org.irods.jargon.core.connection.IRODSErrorScanner  - inspectAndThrowIfNeeded:-310000
9691 [main] DEBUG org.irods.jargon.core.connection.IRODSErrorScanner  - scanning for info value...
9692 [main] DEBUG org.irods.jargon.core.connection.IRODSErrorScanner  - errorEnum val:USER_FILE_DOES_NOT_EXIST
11371 [main] INFO  org.irods.jargon.core.pub.io.IRODSFileImpl  - file not found
13554 [main] INFO  org.irods.jargon.core.pub.io.IRODSFileImpl  - isDirectory() for path:/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl
13555 [main] INFO  org.irods.jargon.core.pub.IRODSFileSystemAOImpl  - getObjStat(final String irodsAbsolutePath)
14714 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
14716 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with byte array
14716 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with:<DataObjInp_PI><objPath>/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl</objPath>
<createMode>0</createMode>
<openFlags>0</openFlags>
<offset>0</offset>
<dataSize>0</dataSize>
<numThreads>0</numThreads>
<oprType>0</oprType>
<KeyValPair_PI><ssLen>0</ssLen>
</KeyValPair_PI>
</DataObjInp_PI>

14716 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - api number is:633
14716 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 633
14716 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_API_REQ</type><msgLen>503</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>633</intInfo></MsgHeader_PI>
14717 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
14717 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
14717 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
14717 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
14718 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  145
14718 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
14718 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 145
14719 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:0
14719 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
14719 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
14719 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:-310000
14719 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info is < 0
14719 [main] DEBUG org.irods.jargon.core.connection.IRODSErrorScanner  - inspectAndThrowIfNeeded:-310000
14719 [main] DEBUG org.irods.jargon.core.connection.IRODSErrorScanner  - scanning for info value...
14720 [main] DEBUG org.irods.jargon.core.connection.IRODSErrorScanner  - errorEnum val:USER_FILE_DOES_NOT_EXIST
15458 [main] INFO  org.irods.jargon.core.pub.io.IRODSFileImpl  - file not found
39146 [main] INFO  org.irods.jargon.core.pub.IRODSFileSystemAOImpl  - mkdir(final IRODSFile irodsFile, final boolean recursiveOpr)
39146 [main] INFO  org.irods.jargon.core.pub.IRODSFileSystemAOImpl  - making dir for:/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl
39147 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
39147 [main] DEBUG org.irods.jargon.core.packinstr.CollInp  - kvp tag: <KeyValPair_PI><ssLen>1</ssLen>
<keyWord>recursiveOpr</keyWord>
<svalue></svalue>
</KeyValPair_PI>

39148 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with byte array
39148 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with:<CollInpNew_PI><collName>/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl</collName>
<flags>0</flags>
<oprType>0</oprType>
<KeyValPair_PI><ssLen>1</ssLen>
<keyWord>recursiveOpr</keyWord>
<svalue></svalue>
</KeyValPair_PI>
</CollInpNew_PI>

39148 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - api number is:681
39148 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 681
39149 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_API_REQ</type><msgLen>451</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>681</intInfo></MsgHeader_PI>
39149 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
39149 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
39149 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
39149 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
39157 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  139
39157 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
39157 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 139
39158 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:0
39158 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
39158 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
39158 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:0
39158 [main] DEBUG org.irods.jargon.core.pub.IRODSFileSystemAOImpl  - mkdir succesful
43794 [main] INFO  org.irods.jargon.core.pub.CollectionAOImpl  - setAccessPermissionRead on absPath:/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl
43795 [main] INFO  org.irods.jargon.core.pub.FileCatalogObjectAOImpl  - resoveAbsolutePathViaObjStat()
43795 [main] INFO  org.irods.jargon.core.pub.FileCatalogObjectAOImpl  - retrieveObjStat()
43795 [main] INFO  org.irods.jargon.core.pub.FileCatalogObjectAOImpl  - irodsAbsolutePath:/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl
44043 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
44044 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with byte array
44044 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with:<DataObjInp_PI><objPath>/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl</objPath>
<createMode>0</createMode>
<openFlags>0</openFlags>
<offset>0</offset>
<dataSize>0</dataSize>
<numThreads>0</numThreads>
<oprType>0</oprType>
<KeyValPair_PI><ssLen>0</ssLen>
</KeyValPair_PI>
</DataObjInp_PI>

44044 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - api number is:633
44044 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 633
44045 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_API_REQ</type><msgLen>503</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>633</intInfo></MsgHeader_PI>
44045 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
44045 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
44045 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
44045 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
44048 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  141
44048 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
44048 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 141
44048 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:276
44048 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
44048 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
44048 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:2
44048 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length greater than zero
44048 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  276
44048 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
44048 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 276
44049 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message from IRODS read back:<RodsObjStat_PI><objSize>0</objSize>
<objType>2</objType>
<dataMode>0</dataMode>
<dataId>23618</dataId>
<chksum></chksum>
<ownerName>test1</ownerName>
<ownerZone>fedZone1</ownerZone>
<createTime>01433261159</createTime>
<modifyTime>01433261159</modifyTime>
</RodsObjStat_PI>

44049 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytes length is not zero
45907 [main] DEBUG org.irods.jargon.core.pub.CollectionAndDataObjectListAndSearchAOImpl  - response from objStat: <RodsObjStat_PI><objSize>0</objSize>
<objType>2</objType>
<dataMode>0</dataMode>
<dataId>23618</dataId>
<chksum></chksum>
<ownerName>test1</ownerName>
<ownerZone>fedZone1</ownerZone>
<createTime>01433261159</createTime>
<modifyTime>01433261159</modifyTime>
<MsgHeader_PI><type>RODS_API_REPLY</type>
<msgLen>276</msgLen>
<errorLen>0</errorLen>
<bsLen>0</bsLen>
<intInfo>2</intInfo>
</MsgHeader_PI>
</RodsObjStat_PI>

55211 [main] INFO  org.irods.jargon.core.pub.CollectionAndDataObjectListAndSearchAOImpl  - objStat:
  absolutePath:/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl
   dataId:23618
   specColType:NORMAL
   objectType:COLLECTION
   collectionPath:
   objectPath:
   checksum:
   ownerName:test1
   ownerZone:fedZone1
  objSize:0
   cacheDir:
   cacheDirty:false
   createdAt:replNumber:0Tue Jun 02 12:05:59 EDT 2015
   modifiedAt:Tue Jun 02 12:05:59 EDT 2015
171418 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
171418 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
171418 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
171419 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
171419 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
171419 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
171420 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
171420 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
171420 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
171420 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
171420 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
171421 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
171421 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
171421 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
171421 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
171422 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
171422 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
171422 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
171422 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
171423 [main] INFO  org.irods.jargon.core.pub.io.IRODSFileImpl  - setting file name, given path = /fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl
171423 [main] INFO  org.irods.jargon.core.pub.io.IRODSFileImpl  - detected local separator = \
171423 [main] INFO  org.irods.jargon.core.pub.io.IRODSFileImpl  - file name was set as: testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl
171423 [main] INFO  org.irods.jargon.core.pub.IRODSFileSystemAOImpl  - isFileExists()
171424 [main] INFO  org.irods.jargon.core.pub.IRODSFileSystemAOImpl  - checking existence of: /fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl
171424 [main] INFO  org.irods.jargon.core.pub.IRODSFileSystemAOImpl  - getObjStat(final String irodsAbsolutePath)
172361 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
172363 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with byte array
172363 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with:<DataObjInp_PI><objPath>/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl</objPath>
<createMode>0</createMode>
<openFlags>0</openFlags>
<offset>0</offset>
<dataSize>0</dataSize>
<numThreads>0</numThreads>
<oprType>0</oprType>
<KeyValPair_PI><ssLen>0</ssLen>
</KeyValPair_PI>
</DataObjInp_PI>

172363 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - api number is:633
172363 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 633
172364 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_API_REQ</type><msgLen>503</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>633</intInfo></MsgHeader_PI>
172364 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
172364 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
172364 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
172364 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
172368 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  141
172368 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
172369 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 141
172369 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:276
172369 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
172370 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
172370 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:2
172370 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length greater than zero
172370 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  276
172370 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
172371 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 276
172372 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message from IRODS read back:<RodsObjStat_PI><objSize>0</objSize>
<objType>2</objType>
<dataMode>0</dataMode>
<dataId>23618</dataId>
<chksum></chksum>
<ownerName>test1</ownerName>
<ownerZone>fedZone1</ownerZone>
<createTime>01433261159</createTime>
<modifyTime>01433261159</modifyTime>
</RodsObjStat_PI>

172372 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytes length is not zero
173395 [main] DEBUG org.irods.jargon.core.pub.CollectionAndDataObjectListAndSearchAOImpl  - response from objStat: <RodsObjStat_PI><objSize>0</objSize>
<objType>2</objType>
<dataMode>0</dataMode>
<dataId>23618</dataId>
<chksum></chksum>
<ownerName>test1</ownerName>
<ownerZone>fedZone1</ownerZone>
<createTime>01433261159</createTime>
<modifyTime>01433261159</modifyTime>
<MsgHeader_PI><type>RODS_API_REPLY</type>
<msgLen>276</msgLen>
<errorLen>0</errorLen>
<bsLen>0</bsLen>
<intInfo>2</intInfo>
</MsgHeader_PI>
</RodsObjStat_PI>

180634 [main] INFO  org.irods.jargon.core.pub.CollectionAndDataObjectListAndSearchAOImpl  - objStat:
  absolutePath:/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl
   dataId:23618
   specColType:NORMAL
   objectType:COLLECTION
   collectionPath:
   objectPath:
   checksum:
   ownerName:test1
   ownerZone:fedZone1
  objSize:0
   cacheDir:
   cacheDirty:false
   createdAt:replNumber:0Tue Jun 02 12:05:59 EDT 2015
   modifiedAt:Tue Jun 02 12:05:59 EDT 2015
199769 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
200737 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
200737 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
200738 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
200738 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
200738 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
200738 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
200739 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
204426 [main] INFO  org.irods.jargon.core.pub.CollectionAndDataObjectListAndSearchAOImpl  - countDataObjectsAndCollectionsUnder: /fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl
205585 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
205586 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with byte array
205587 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with:<DataObjInp_PI><objPath>/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl</objPath>
<createMode>0</createMode>
<openFlags>0</openFlags>
<offset>0</offset>
<dataSize>0</dataSize>
<numThreads>0</numThreads>
<oprType>0</oprType>
<KeyValPair_PI><ssLen>0</ssLen>
</KeyValPair_PI>
</DataObjInp_PI>

205587 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - api number is:633
205587 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 633
205587 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_API_REQ</type><msgLen>503</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>633</intInfo></MsgHeader_PI>
205587 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
205588 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
205588 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
205588 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
205591 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  141
205591 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
205591 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 141
205591 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:276
205591 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
205592 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
205592 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:2
205592 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length greater than zero
205592 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  276
205592 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
205592 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 276
205593 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message from IRODS read back:<RodsObjStat_PI><objSize>0</objSize>
<objType>2</objType>
<dataMode>0</dataMode>
<dataId>23618</dataId>
<chksum></chksum>
<ownerName>test1</ownerName>
<ownerZone>fedZone1</ownerZone>
<createTime>01433261159</createTime>
<modifyTime>01433261159</modifyTime>
</RodsObjStat_PI>

205593 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytes length is not zero
206594 [main] DEBUG org.irods.jargon.core.pub.CollectionAndDataObjectListAndSearchAOImpl  - response from objStat: <RodsObjStat_PI><objSize>0</objSize>
<objType>2</objType>
<dataMode>0</dataMode>
<dataId>23618</dataId>
<chksum></chksum>
<ownerName>test1</ownerName>
<ownerZone>fedZone1</ownerZone>
<createTime>01433261159</createTime>
<modifyTime>01433261159</modifyTime>
<MsgHeader_PI><type>RODS_API_REPLY</type>
<msgLen>276</msgLen>
<errorLen>0</errorLen>
<bsLen>0</bsLen>
<intInfo>2</intInfo>
</MsgHeader_PI>
</RodsObjStat_PI>

213274 [main] INFO  org.irods.jargon.core.pub.CollectionAndDataObjectListAndSearchAOImpl  - objStat:
  absolutePath:/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl
   dataId:23618
   specColType:NORMAL
   objectType:COLLECTION
   collectionPath:
   objectPath:
   checksum:
   ownerName:test1
   ownerZone:fedZone1
  objSize:0
   cacheDir:
   cacheDirty:false
   createdAt:replNumber:0Tue Jun 02 12:05:59 EDT 2015
   modifiedAt:Tue Jun 02 12:05:59 EDT 2015
222497 [main] INFO  org.irods.jargon.core.pub.CollectionAndDataObjectListAndSearchAOImpl  - determined effectiveAbsolutePathToBe:/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl
224889 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
224890 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
224890 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
224901 [main] INFO  org.irods.jargon.core.pub.IRODSGenQueryExecutorImpl  - executeIRODSQueryAndCloseResultInZone()
224901 [main] INFO  org.irods.jargon.core.pub.IRODSGenQueryExecutorImpl  - query: org.irods.jargon.core.query.IRODSGenQueryFromBuilder@e720b71
224903 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
224908 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with byte array
224908 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with:<GenQueryInp_PI><maxRows>1</maxRows>
<continueInx>0</continueInx>
<partialStartIndex>0</partialStartIndex>
<options>0</options>
<KeyValPair_PI><ssLen>1</ssLen>
<keyWord>zone</keyWord>
<svalue>fedZone1</svalue>
</KeyValPair_PI>
<InxIvalPair_PI><iiLen>2</iiLen>
<inx>501</inx>
<inx>403</inx>
<ivalue>6</ivalue>
<ivalue>6</ivalue>
</InxIvalPair_PI>
<InxValPair_PI><isLen>2</isLen>
<inx>501</inx>
<inx>404</inx>
<svalue> = '/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl' </svalue>
<svalue> = '0' </svalue>
</InxValPair_PI>
</GenQueryInp_PI>

224908 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - api number is:702
224908 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 702
224909 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_API_REQ</type><msgLen>752</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>702</intInfo></MsgHeader_PI>
224909 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
224909 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
224909 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
224909 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
224910 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  142
224910 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
224911 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 142
224911 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:3829
224911 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
224911 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
224911 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:0
224912 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length greater than zero
224912 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  3829
224912 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
224912 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 3829
224922 [main] INFO  org.irods.jargon.core.query.GenQueryProcessor  - continuation value: 1
224922 [main] INFO  org.irods.jargon.core.query.GenQueryProcessor  - total records:0
224922 [main] INFO  org.irods.jargon.core.query.QueryResultProcessingUtils  - rows returned from iRODS query: 1
224922 [main] DEBUG org.irods.jargon.core.query.QueryResultProcessingUtils  - is this the last record? false
224924 [main] INFO  org.irods.jargon.core.query.GenQueryProcessor  - auto closing result set
224924 [main] INFO  org.irods.jargon.core.query.GenQueryProcessor  - getting more results for query
224925 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with byte array
224925 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with:<GenQueryInp_PI><maxRows>-1</maxRows>
<continueInx>1</continueInx>
<partialStartIndex>0</partialStartIndex>
<options>0</options>
<KeyValPair_PI><ssLen>0</ssLen>
</KeyValPair_PI>
<InxIvalPair_PI><iiLen>2</iiLen>
<inx>501</inx>
<inx>403</inx>
<ivalue>6</ivalue>
<ivalue>6</ivalue>
</InxIvalPair_PI>
<InxValPair_PI><isLen>2</isLen>
<inx>501</inx>
<inx>404</inx>
<svalue> = '/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl' </svalue>
<svalue> = '0' </svalue>
</InxValPair_PI>
</GenQueryInp_PI>

224925 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - api number is:702
224925 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 702
224925 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_API_REQ</type><msgLen>703</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>702</intInfo></MsgHeader_PI>
224926 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
224926 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
224926 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
224926 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
224926 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  142
224926 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
224927 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 142
224927 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:3789
224927 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
224927 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
224927 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:0
224927 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length greater than zero
224928 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  3789
224928 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
224928 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 3789
224936 [main] INFO  org.irods.jargon.core.query.GenQueryProcessor  - auto closing result set
224936 [main] INFO  org.irods.jargon.core.query.GenQueryProcessor  - getting more results for query
224937 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with byte array
224937 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with:<GenQueryInp_PI><maxRows>-1</maxRows>
<continueInx>1</continueInx>
<partialStartIndex>0</partialStartIndex>
<options>0</options>
<KeyValPair_PI><ssLen>0</ssLen>
</KeyValPair_PI>
<InxIvalPair_PI><iiLen>2</iiLen>
<inx>501</inx>
<inx>403</inx>
<ivalue>6</ivalue>
<ivalue>6</ivalue>
</InxIvalPair_PI>
<InxValPair_PI><isLen>2</isLen>
<inx>501</inx>
<inx>404</inx>
<svalue> = '/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl' </svalue>
<svalue> = '0' </svalue>
</InxValPair_PI>
</GenQueryInp_PI>

224938 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - api number is:702
224938 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 702
224938 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_API_REQ</type><msgLen>703</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>702</intInfo></MsgHeader_PI>
224938 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
224938 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
224939 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
224939 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
224939 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  142
224939 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
224939 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 142
224940 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:3789
224940 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
224940 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
224940 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:0
224940 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length greater than zero
224940 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  3789
224940 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
224940 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 3789
225226 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
225226 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
225226 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
225227 [main] INFO  org.irods.jargon.core.pub.IRODSGenQueryExecutorImpl  - executeIRODSQueryAndCloseResultInZone()
225227 [main] INFO  org.irods.jargon.core.pub.IRODSGenQueryExecutorImpl  - query: org.irods.jargon.core.query.IRODSGenQueryFromBuilder@37374a5e
225227 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
225228 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with byte array
225228 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with:<GenQueryInp_PI><maxRows>1</maxRows>
<continueInx>0</continueInx>
<partialStartIndex>0</partialStartIndex>
<options>0</options>
<KeyValPair_PI><ssLen>1</ssLen>
<keyWord>zone</keyWord>
<svalue>fedZone1</svalue>
</KeyValPair_PI>
<InxIvalPair_PI><iiLen>2</iiLen>
<inx>510</inx>
<inx>501</inx>
<ivalue>6</ivalue>
<ivalue>6</ivalue>
</InxIvalPair_PI>
<InxValPair_PI><isLen>1</isLen>
<inx>502</inx>
<svalue> = '/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl' </svalue>
</InxValPair_PI>
</GenQueryInp_PI>

225229 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - api number is:702
225229 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 702
225229 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_API_REQ</type><msgLen>712</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>702</intInfo></MsgHeader_PI>
225229 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
225229 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
225229 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
225230 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
225230 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  142
225230 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
225231 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 142
225231 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:3829
225231 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
225231 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
225231 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:0
225232 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length greater than zero
225232 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  3829
225232 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
225232 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 3829
225241 [main] INFO  org.irods.jargon.core.query.GenQueryProcessor  - continuation value: 1
225241 [main] INFO  org.irods.jargon.core.query.GenQueryProcessor  - total records:0
225241 [main] INFO  org.irods.jargon.core.query.QueryResultProcessingUtils  - rows returned from iRODS query: 1
225241 [main] DEBUG org.irods.jargon.core.query.QueryResultProcessingUtils  - is this the last record? false
225241 [main] INFO  org.irods.jargon.core.query.GenQueryProcessor  - auto closing result set
225241 [main] INFO  org.irods.jargon.core.query.GenQueryProcessor  - getting more results for query
225242 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with byte array
225242 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with:<GenQueryInp_PI><maxRows>-1</maxRows>
<continueInx>1</continueInx>
<partialStartIndex>0</partialStartIndex>
<options>0</options>
<KeyValPair_PI><ssLen>0</ssLen>
</KeyValPair_PI>
<InxIvalPair_PI><iiLen>2</iiLen>
<inx>510</inx>
<inx>501</inx>
<ivalue>6</ivalue>
<ivalue>6</ivalue>
</InxIvalPair_PI>
<InxValPair_PI><isLen>1</isLen>
<inx>502</inx>
<svalue> = '/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl' </svalue>
</InxValPair_PI>
</GenQueryInp_PI>

225243 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - api number is:702
225243 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 702
225243 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_API_REQ</type><msgLen>663</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>702</intInfo></MsgHeader_PI>
225243 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
225244 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
225244 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
225244 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
225244 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  142
225244 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
225244 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 142
225245 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:3789
225245 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
225245 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
225245 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:0
225245 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length greater than zero
225245 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  3789
225246 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
225246 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 3789
225254 [main] INFO  org.irods.jargon.core.query.GenQueryProcessor  - auto closing result set
225255 [main] INFO  org.irods.jargon.core.query.GenQueryProcessor  - getting more results for query
225255 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with byte array
225256 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with:<GenQueryInp_PI><maxRows>-1</maxRows>
<continueInx>1</continueInx>
<partialStartIndex>0</partialStartIndex>
<options>0</options>
<KeyValPair_PI><ssLen>0</ssLen>
</KeyValPair_PI>
<InxIvalPair_PI><iiLen>2</iiLen>
<inx>510</inx>
<inx>501</inx>
<ivalue>6</ivalue>
<ivalue>6</ivalue>
</InxIvalPair_PI>
<InxValPair_PI><isLen>1</isLen>
<inx>502</inx>
<svalue> = '/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl' </svalue>
</InxValPair_PI>
</GenQueryInp_PI>

225256 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - api number is:702
225256 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 702
225256 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_API_REQ</type><msgLen>663</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>702</intInfo></MsgHeader_PI>
225256 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
225256 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
225257 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
225257 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
225257 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  142
225257 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
225257 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 142
225258 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:3789
225258 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
225258 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
225258 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:0
225258 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length greater than zero
225259 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  3789
225259 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
225259 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 3789
228721 [main] INFO  org.irods.jargon.core.pub.CollectionAOImpl  - overridding recursive flag, file has no children
251122 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
251123 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with byte array
251123 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with:<modAccessControlInp_PI><recursiveFlag>0</recursiveFlag>
<accessLevel>read</accessLevel>
<userName>test2</userName>
<zone></zone>
<path>/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl</path>
</modAccessControlInp_PI>

251123 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - api number is:707
251123 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 707
251123 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_API_REQ</type><msgLen>430</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>707</intInfo></MsgHeader_PI>
251124 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
251124 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
251124 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
251124 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
251126 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  139
251127 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
251127 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 139
251127 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:0
251127 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
251128 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
251128 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:0
258833 [main] INFO  org.irods.jargon.core.pub.CollectionAOImpl  - setAccessPermissionRead on absPath:/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl
258833 [main] INFO  org.irods.jargon.core.pub.FileCatalogObjectAOImpl  - resoveAbsolutePathViaObjStat()
258833 [main] INFO  org.irods.jargon.core.pub.FileCatalogObjectAOImpl  - retrieveObjStat()
258833 [main] INFO  org.irods.jargon.core.pub.FileCatalogObjectAOImpl  - irodsAbsolutePath:/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl
260161 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
260163 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with byte array
260163 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with:<DataObjInp_PI><objPath>/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl</objPath>
<createMode>0</createMode>
<openFlags>0</openFlags>
<offset>0</offset>
<dataSize>0</dataSize>
<numThreads>0</numThreads>
<oprType>0</oprType>
<KeyValPair_PI><ssLen>0</ssLen>
</KeyValPair_PI>
</DataObjInp_PI>

260163 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - api number is:633
260163 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 633
260163 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_API_REQ</type><msgLen>503</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>633</intInfo></MsgHeader_PI>
260163 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
260164 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
260164 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
260164 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
260166 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  141
260167 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
260167 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 141
260167 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:276
260167 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
260168 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
260168 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:2
260168 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length greater than zero
260168 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  276
260168 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
260168 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 276
260169 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message from IRODS read back:<RodsObjStat_PI><objSize>0</objSize>
<objType>2</objType>
<dataMode>0</dataMode>
<dataId>23618</dataId>
<chksum></chksum>
<ownerName>test1</ownerName>
<ownerZone>fedZone1</ownerZone>
<createTime>01433261159</createTime>
<modifyTime>01433261159</modifyTime>
</RodsObjStat_PI>

260169 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytes length is not zero
261418 [main] DEBUG org.irods.jargon.core.pub.CollectionAndDataObjectListAndSearchAOImpl  - response from objStat: <RodsObjStat_PI><objSize>0</objSize>
<objType>2</objType>
<dataMode>0</dataMode>
<dataId>23618</dataId>
<chksum></chksum>
<ownerName>test1</ownerName>
<ownerZone>fedZone1</ownerZone>
<createTime>01433261159</createTime>
<modifyTime>01433261159</modifyTime>
<MsgHeader_PI><type>RODS_API_REPLY</type>
<msgLen>276</msgLen>
<errorLen>0</errorLen>
<bsLen>0</bsLen>
<intInfo>2</intInfo>
</MsgHeader_PI>
</RodsObjStat_PI>

282018 [main] INFO  org.irods.jargon.core.pub.CollectionAndDataObjectListAndSearchAOImpl  - objStat:
  absolutePath:/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl
   dataId:23618
   specColType:NORMAL
   objectType:COLLECTION
   collectionPath:
   objectPath:
   checksum:
   ownerName:test1
   ownerZone:fedZone1
  objSize:0
   cacheDir:
   cacheDirty:false
   createdAt:replNumber:0Tue Jun 02 12:05:59 EDT 2015
   modifiedAt:Tue Jun 02 12:05:59 EDT 2015
321832 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
321833 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
321833 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
321833 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
321833 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
321833 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
321834 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
321834 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
321834 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
321834 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
321835 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
321835 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
321835 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
321835 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
321835 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
321836 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
321836 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
321836 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
321836 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
321837 [main] INFO  org.irods.jargon.core.pub.io.IRODSFileImpl  - setting file name, given path = /fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl
321837 [main] INFO  org.irods.jargon.core.pub.io.IRODSFileImpl  - detected local separator = \
321837 [main] INFO  org.irods.jargon.core.pub.io.IRODSFileImpl  - file name was set as: testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl
321837 [main] INFO  org.irods.jargon.core.pub.IRODSFileSystemAOImpl  - isFileExists()
321837 [main] INFO  org.irods.jargon.core.pub.IRODSFileSystemAOImpl  - checking existence of: /fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl
321838 [main] INFO  org.irods.jargon.core.pub.IRODSFileSystemAOImpl  - getObjStat(final String irodsAbsolutePath)
322737 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
322739 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with byte array
322739 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with:<DataObjInp_PI><objPath>/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl</objPath>
<createMode>0</createMode>
<openFlags>0</openFlags>
<offset>0</offset>
<dataSize>0</dataSize>
<numThreads>0</numThreads>
<oprType>0</oprType>
<KeyValPair_PI><ssLen>0</ssLen>
</KeyValPair_PI>
</DataObjInp_PI>

322739 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - api number is:633
322739 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 633
322739 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_API_REQ</type><msgLen>503</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>633</intInfo></MsgHeader_PI>
322740 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
322740 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
322740 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
322740 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
322742 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  141
322743 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
322743 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 141
322743 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:276
322743 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
322744 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
322744 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:2
322744 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length greater than zero
322744 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  276
322744 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
322744 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 276
322744 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message from IRODS read back:<RodsObjStat_PI><objSize>0</objSize>
<objType>2</objType>
<dataMode>0</dataMode>
<dataId>23618</dataId>
<chksum></chksum>
<ownerName>test1</ownerName>
<ownerZone>fedZone1</ownerZone>
<createTime>01433261159</createTime>
<modifyTime>01433261159</modifyTime>
</RodsObjStat_PI>

322744 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytes length is not zero
324362 [main] DEBUG org.irods.jargon.core.pub.CollectionAndDataObjectListAndSearchAOImpl  - response from objStat: <RodsObjStat_PI><objSize>0</objSize>
<objType>2</objType>
<dataMode>0</dataMode>
<dataId>23618</dataId>
<chksum></chksum>
<ownerName>test1</ownerName>
<ownerZone>fedZone1</ownerZone>
<createTime>01433261159</createTime>
<modifyTime>01433261159</modifyTime>
<MsgHeader_PI><type>RODS_API_REPLY</type>
<msgLen>276</msgLen>
<errorLen>0</errorLen>
<bsLen>0</bsLen>
<intInfo>2</intInfo>
</MsgHeader_PI>
</RodsObjStat_PI>

367993 [main] INFO  org.irods.jargon.core.pub.CollectionAndDataObjectListAndSearchAOImpl  - objStat:
  absolutePath:/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl
   dataId:23618
   specColType:NORMAL
   objectType:COLLECTION
   collectionPath:
   objectPath:
   checksum:
   ownerName:test1
   ownerZone:fedZone1
  objSize:0
   cacheDir:
   cacheDirty:false
   createdAt:replNumber:0Tue Jun 02 12:05:59 EDT 2015
   modifiedAt:Tue Jun 02 12:05:59 EDT 2015
375648 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
375912 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
375913 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
375913 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
375913 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
375913 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
375913 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
375914 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
376601 [main] INFO  org.irods.jargon.core.pub.CollectionAndDataObjectListAndSearchAOImpl  - countDataObjectsAndCollectionsUnder: /fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl
376800 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
376802 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with byte array
376802 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with:<DataObjInp_PI><objPath>/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl</objPath>
<createMode>0</createMode>
<openFlags>0</openFlags>
<offset>0</offset>
<dataSize>0</dataSize>
<numThreads>0</numThreads>
<oprType>0</oprType>
<KeyValPair_PI><ssLen>0</ssLen>
</KeyValPair_PI>
</DataObjInp_PI>

376802 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - api number is:633
376802 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 633
376802 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_API_REQ</type><msgLen>503</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>633</intInfo></MsgHeader_PI>
376802 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
376803 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
376803 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
376803 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
376805 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  141
376806 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
376806 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 141
376806 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:276
376806 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
376806 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
376807 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:2
376807 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length greater than zero
376807 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  276
376807 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
376807 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 276
376808 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message from IRODS read back:<RodsObjStat_PI><objSize>0</objSize>
<objType>2</objType>
<dataMode>0</dataMode>
<dataId>23618</dataId>
<chksum></chksum>
<ownerName>test1</ownerName>
<ownerZone>fedZone1</ownerZone>
<createTime>01433261159</createTime>
<modifyTime>01433261159</modifyTime>
</RodsObjStat_PI>

376808 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytes length is not zero
377186 [main] DEBUG org.irods.jargon.core.pub.CollectionAndDataObjectListAndSearchAOImpl  - response from objStat: <RodsObjStat_PI><objSize>0</objSize>
<objType>2</objType>
<dataMode>0</dataMode>
<dataId>23618</dataId>
<chksum></chksum>
<ownerName>test1</ownerName>
<ownerZone>fedZone1</ownerZone>
<createTime>01433261159</createTime>
<modifyTime>01433261159</modifyTime>
<MsgHeader_PI><type>RODS_API_REPLY</type>
<msgLen>276</msgLen>
<errorLen>0</errorLen>
<bsLen>0</bsLen>
<intInfo>2</intInfo>
</MsgHeader_PI>
</RodsObjStat_PI>

383817 [main] INFO  org.irods.jargon.core.pub.CollectionAndDataObjectListAndSearchAOImpl  - objStat:
  absolutePath:/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl
   dataId:23618
   specColType:NORMAL
   objectType:COLLECTION
   collectionPath:
   objectPath:
   checksum:
   ownerName:test1
   ownerZone:fedZone1
  objSize:0
   cacheDir:
   cacheDirty:false
   createdAt:replNumber:0Tue Jun 02 12:05:59 EDT 2015
   modifiedAt:Tue Jun 02 12:05:59 EDT 2015
387905 [main] INFO  org.irods.jargon.core.pub.CollectionAndDataObjectListAndSearchAOImpl  - determined effectiveAbsolutePathToBe:/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl
389793 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
389793 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
389793 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
389794 [main] INFO  org.irods.jargon.core.pub.IRODSGenQueryExecutorImpl  - executeIRODSQueryAndCloseResultInZone()
389794 [main] INFO  org.irods.jargon.core.pub.IRODSGenQueryExecutorImpl  - query: org.irods.jargon.core.query.IRODSGenQueryFromBuilder@2db7a79b
389794 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
389795 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with byte array
389795 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with:<GenQueryInp_PI><maxRows>1</maxRows>
<continueInx>0</continueInx>
<partialStartIndex>0</partialStartIndex>
<options>0</options>
<KeyValPair_PI><ssLen>1</ssLen>
<keyWord>zone</keyWord>
<svalue>fedZone1</svalue>
</KeyValPair_PI>
<InxIvalPair_PI><iiLen>2</iiLen>
<inx>501</inx>
<inx>403</inx>
<ivalue>6</ivalue>
<ivalue>6</ivalue>
</InxIvalPair_PI>
<InxValPair_PI><isLen>2</isLen>
<inx>501</inx>
<inx>404</inx>
<svalue> = '/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl' </svalue>
<svalue> = '0' </svalue>
</InxValPair_PI>
</GenQueryInp_PI>

389795 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - api number is:702
389795 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 702
389795 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_API_REQ</type><msgLen>752</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>702</intInfo></MsgHeader_PI>
389796 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
389796 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
389796 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
389796 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
389797 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  142
389797 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
389797 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 142
389798 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:3829
389798 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
389798 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
389798 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:0
389798 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length greater than zero
389798 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  3829
389798 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
389799 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 3829
389808 [main] INFO  org.irods.jargon.core.query.GenQueryProcessor  - continuation value: 1
389808 [main] INFO  org.irods.jargon.core.query.GenQueryProcessor  - total records:0
389808 [main] INFO  org.irods.jargon.core.query.QueryResultProcessingUtils  - rows returned from iRODS query: 1
389808 [main] DEBUG org.irods.jargon.core.query.QueryResultProcessingUtils  - is this the last record? false
389808 [main] INFO  org.irods.jargon.core.query.GenQueryProcessor  - auto closing result set
389808 [main] INFO  org.irods.jargon.core.query.GenQueryProcessor  - getting more results for query
389809 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with byte array
389809 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with:<GenQueryInp_PI><maxRows>-1</maxRows>
<continueInx>1</continueInx>
<partialStartIndex>0</partialStartIndex>
<options>0</options>
<KeyValPair_PI><ssLen>0</ssLen>
</KeyValPair_PI>
<InxIvalPair_PI><iiLen>2</iiLen>
<inx>501</inx>
<inx>403</inx>
<ivalue>6</ivalue>
<ivalue>6</ivalue>
</InxIvalPair_PI>
<InxValPair_PI><isLen>2</isLen>
<inx>501</inx>
<inx>404</inx>
<svalue> = '/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl' </svalue>
<svalue> = '0' </svalue>
</InxValPair_PI>
</GenQueryInp_PI>

389810 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - api number is:702
389810 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 702
389810 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_API_REQ</type><msgLen>703</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>702</intInfo></MsgHeader_PI>
389810 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
389810 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
389811 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
389811 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
389811 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  142
389811 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
389811 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 142
389812 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:3789
389812 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
389812 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
389812 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:0
389812 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length greater than zero
389812 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  3789
389812 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
389812 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 3789
389821 [main] INFO  org.irods.jargon.core.query.GenQueryProcessor  - auto closing result set
389821 [main] INFO  org.irods.jargon.core.query.GenQueryProcessor  - getting more results for query
389822 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with byte array
389822 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with:<GenQueryInp_PI><maxRows>-1</maxRows>
<continueInx>1</continueInx>
<partialStartIndex>0</partialStartIndex>
<options>0</options>
<KeyValPair_PI><ssLen>0</ssLen>
</KeyValPair_PI>
<InxIvalPair_PI><iiLen>2</iiLen>
<inx>501</inx>
<inx>403</inx>
<ivalue>6</ivalue>
<ivalue>6</ivalue>
</InxIvalPair_PI>
<InxValPair_PI><isLen>2</isLen>
<inx>501</inx>
<inx>404</inx>
<svalue> = '/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl' </svalue>
<svalue> = '0' </svalue>
</InxValPair_PI>
</GenQueryInp_PI>

389822 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - api number is:702
389823 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 702
389823 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_API_REQ</type><msgLen>703</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>702</intInfo></MsgHeader_PI>
389823 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
389823 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
389823 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
389823 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
389823 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  142
389824 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
389824 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 142
389824 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:3789
389824 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
389824 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
389825 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:0
389825 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length greater than zero
389825 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  3789
389825 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
389825 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 3789
389984 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
389984 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
389986 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
389986 [main] INFO  org.irods.jargon.core.pub.IRODSGenQueryExecutorImpl  - executeIRODSQueryAndCloseResultInZone()
389986 [main] INFO  org.irods.jargon.core.pub.IRODSGenQueryExecutorImpl  - query: org.irods.jargon.core.query.IRODSGenQueryFromBuilder@6950e31
389986 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
389987 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with byte array
389987 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with:<GenQueryInp_PI><maxRows>1</maxRows>
<continueInx>0</continueInx>
<partialStartIndex>0</partialStartIndex>
<options>0</options>
<KeyValPair_PI><ssLen>1</ssLen>
<keyWord>zone</keyWord>
<svalue>fedZone1</svalue>
</KeyValPair_PI>
<InxIvalPair_PI><iiLen>2</iiLen>
<inx>510</inx>
<inx>501</inx>
<ivalue>6</ivalue>
<ivalue>6</ivalue>
</InxIvalPair_PI>
<InxValPair_PI><isLen>1</isLen>
<inx>502</inx>
<svalue> = '/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl' </svalue>
</InxValPair_PI>
</GenQueryInp_PI>

389987 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - api number is:702
389987 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 702
389987 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_API_REQ</type><msgLen>712</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>702</intInfo></MsgHeader_PI>
389988 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
389988 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
389988 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
389988 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
389989 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  142
389989 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
389989 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 142
389989 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:3829
389990 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
389990 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
389990 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:0
389990 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length greater than zero
389990 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  3829
389990 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
389990 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 3829
389999 [main] INFO  org.irods.jargon.core.query.GenQueryProcessor  - continuation value: 1
389999 [main] INFO  org.irods.jargon.core.query.GenQueryProcessor  - total records:0
389999 [main] INFO  org.irods.jargon.core.query.QueryResultProcessingUtils  - rows returned from iRODS query: 1
389999 [main] DEBUG org.irods.jargon.core.query.QueryResultProcessingUtils  - is this the last record? false
390000 [main] INFO  org.irods.jargon.core.query.GenQueryProcessor  - auto closing result set
390000 [main] INFO  org.irods.jargon.core.query.GenQueryProcessor  - getting more results for query
390001 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with byte array
390001 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with:<GenQueryInp_PI><maxRows>-1</maxRows>
<continueInx>1</continueInx>
<partialStartIndex>0</partialStartIndex>
<options>0</options>
<KeyValPair_PI><ssLen>0</ssLen>
</KeyValPair_PI>
<InxIvalPair_PI><iiLen>2</iiLen>
<inx>510</inx>
<inx>501</inx>
<ivalue>6</ivalue>
<ivalue>6</ivalue>
</InxIvalPair_PI>
<InxValPair_PI><isLen>1</isLen>
<inx>502</inx>
<svalue> = '/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl' </svalue>
</InxValPair_PI>
</GenQueryInp_PI>

390001 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - api number is:702
390001 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 702
390001 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_API_REQ</type><msgLen>663</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>702</intInfo></MsgHeader_PI>
390002 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
390002 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
390002 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
390002 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
390002 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  142
390002 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
390003 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 142
390003 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:3789
390003 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
390003 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
390003 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:0
390004 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length greater than zero
390004 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  3789
390004 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
390004 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 3789
390013 [main] INFO  org.irods.jargon.core.query.GenQueryProcessor  - auto closing result set
390013 [main] INFO  org.irods.jargon.core.query.GenQueryProcessor  - getting more results for query
390014 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with byte array
390014 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with:<GenQueryInp_PI><maxRows>-1</maxRows>
<continueInx>1</continueInx>
<partialStartIndex>0</partialStartIndex>
<options>0</options>
<KeyValPair_PI><ssLen>0</ssLen>
</KeyValPair_PI>
<InxIvalPair_PI><iiLen>2</iiLen>
<inx>510</inx>
<inx>501</inx>
<ivalue>6</ivalue>
<ivalue>6</ivalue>
</InxIvalPair_PI>
<InxValPair_PI><isLen>1</isLen>
<inx>502</inx>
<svalue> = '/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl' </svalue>
</InxValPair_PI>
</GenQueryInp_PI>

390014 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - api number is:702
390014 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 702
390015 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_API_REQ</type><msgLen>663</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>702</intInfo></MsgHeader_PI>
390015 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
390015 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
390015 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
390015 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
390015 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  142
390016 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
390016 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 142
390016 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:3789
390016 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
390016 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
390016 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:0
390016 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length greater than zero
390017 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  3789
390017 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
390017 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 3789
392608 [main] INFO  org.irods.jargon.core.pub.CollectionAOImpl  - overridding recursive flag, file has no children
404584 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
404586 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with byte array
404586 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with:<modAccessControlInp_PI><recursiveFlag>0</recursiveFlag>
<accessLevel>read</accessLevel>
<userName>test1</userName>
<zone>fedZone2</zone>
<path>/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2SubColl</path>
</modAccessControlInp_PI>

404586 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - api number is:707
404586 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 707
404586 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_API_REQ</type><msgLen>438</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>707</intInfo></MsgHeader_PI>
404586 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
404587 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
404587 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
404587 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
404589 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  139
404589 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
404589 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 139
404590 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:0
404590 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
404590 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
404590 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:0
407529 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
407529 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
407529 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - null connection in thread local, using IRODSConnectionManager to create a new connection
407529 [main] DEBUG org.irods.jargon.core.connection.IRODSSimpleProtocolManager  - creating an IRODSSimpleConnection for account:irods://[email protected]:1247
407529 [main] DEBUG org.irods.jargon.core.connection.IRODSProtocolManager  - creating a fresh AbstractIRODSMidLevelProtocol for account:irods://[email protected]:1247
407530 [main] INFO  org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocolFactory  - instance() method...calling connection life cycle
407530 [main] INFO  org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocolFactory  - create connection....
407530 [main] INFO  org.irods.jargon.core.connection.IRODSTCPConnectionFactoryImpl  - instance()
407530 [main] INFO  org.irods.jargon.core.connection.AbstractConnection  - AbstractConnection()
407530 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - initializing connection with account:irods://[email protected]:1247
407530 [main] INFO  org.irods.jargon.core.connection.AbstractConnection  - opening irods socket
407530 [main] DEBUG org.irods.jargon.core.connection.IRODSBasicTCPConnection  - connect()
407530 [main] DEBUG org.irods.jargon.core.connection.IRODSBasicTCPConnection  - connecting socket to agent
407530 [main] DEBUG org.irods.jargon.core.connection.IRODSBasicTCPConnection  - normal iRODS connection
407531 [main] DEBUG org.irods.jargon.core.connection.IRODSBasicTCPConnection  - connection to socket made...
407531 [main] DEBUG org.irods.jargon.core.connection.IRODSBasicTCPConnection  - default buffer on input stream
407531 [main] DEBUG org.irods.jargon.core.connection.IRODSBasicTCPConnection  - default buffer on input stream
407531 [main] DEBUG org.irods.jargon.core.connection.IRODSBasicTCPConnection  - socket opened successfully
407532 [main] INFO  org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocolFactory  - ...have connection, now authenticate given the auth scheme in the iRODS account...
407532 [main] INFO  org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocolFactory  - authenticate()
407532 [main] INFO  org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocolFactory  - get auth mechanism
407532 [main] INFO  org.irods.jargon.core.connection.AuthenticationFactoryImpl  - instanceAuthMechanism()
407532 [main] INFO  org.irods.jargon.core.connection.AuthenticationFactoryImpl  - authScheme:STANDARD
407533 [main] INFO  org.irods.jargon.core.connection.AuthenticationFactoryImpl  - using standard auth
407533 [main] INFO  org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocolFactory  - authenticate...
407533 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 0
407533 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_CONNECT</type><msgLen>340</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>0</intInfo></MsgHeader_PI>
407533 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
407533 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
407534 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
407534 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
407556 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  139
407556 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
407556 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 139
407557 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:204
407557 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
407557 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
407557 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:0
407557 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length greater than zero
407557 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  204
407557 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
407558 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 204
407558 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message from IRODS read back:<Version_PI><status>0</status>
<relVersion>rods4.1.0</relVersion>
<apiVersion>d</apiVersion>
<reconnPort>20002</reconnPort>
<reconnAddr>fedzone2-410</reconnAddr>
<cookie>264999191</cookie>
</Version_PI>

407559 [main] INFO  org.irods.jargon.core.connection.AuthMechanism  - startup response:StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20002
   reconnAddr:fedzone2-410
   cookie:264999191
407559 [main] INFO  org.irods.jargon.core.connection.StandardIRODSAuth  - authenticate
407559 [main] INFO  org.irods.jargon.core.connection.StandardIRODSAuth  - sending standard irods password
407559 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 703
407559 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_API_REQ</type><msgLen>0</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>703</intInfo></MsgHeader_PI>
407559 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
407560 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
407560 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
407560 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
407560 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  141
407560 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
407560 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 141
407561 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:153
407561 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
407561 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
407561 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:0
407561 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length greater than zero
407561 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  153
407561 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
407561 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 153
407562 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message from IRODS read back:<authRequestOut_PI><challenge>6bbuekfOYw8bbhgRbQt9FkPOkU9q6Umd2LO3gzYd6CPD9FXN+I9KJ/8em8X6tCw5z7XOEOjFIe4BJXhJ/S/Otw==</challenge>
</authRequestOut_PI>

407562 [main] DEBUG org.irods.jargon.core.connection.AuthMechanism  - cached challenge response:6bbuekfOYw8bbhgRbQt9FkPOkU9q6Umd2LO3gzYd6CPD9FXN+I9KJ/8em8X6tCw5z7XOEOjFIe4BJXhJ/S/Otw==
407563 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with byte array
407563 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with:<authResponseInp_PI><response>8f5IOe1BkQfe6EUzH5xt4w==</response>
<username>test1</username>
</authResponseInp_PI>

407563 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - api number is:704
407563 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 704
407563 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_API_REQ</type><msgLen>115</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>704</intInfo></MsgHeader_PI>
407564 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
407564 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
407564 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
407564 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
407566 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  139
407567 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
407567 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 139
407567 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:0
407567 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
407567 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
407568 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:0
407568 [main] INFO  org.irods.jargon.core.connection.StandardIRODSAuth  - auth was successful
407568 [main] INFO  org.irods.jargon.core.connection.StandardIRODSAuth  - auth response was:org.irods.jargon.core.connection.auth.AuthResponse@b7dd107
407568 [main] INFO  org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocolFactory  - ..authenticated...now decorate and return...
407568 [main] INFO  org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocolFactory  - decorate()
407568 [main] INFO  org.irods.jargon.core.connection.EnvironmentalInfoAccessor  - getting irods server properties
407568 [main] DEBUG org.irods.jargon.core.connection.EnvironmentalInfoAccessor  - checking for cached properties...
407568 [main] INFO  org.irods.jargon.core.connection.DiscoveredServerPropertiesCache  - now retriving server properties from cache with zone:fedZone2
407569 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with byte array
407569 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with:
407569 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - api number is:700
407569 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 700
407569 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_API_REQ</type><msgLen>0</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>700</intInfo></MsgHeader_PI>
407569 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
407569 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
407570 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
407570 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
407570 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  141
407570 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
407570 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 141
407571 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:198
407571 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
407571 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
407571 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:0
407571 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length greater than zero
407571 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  198
407571 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
407571 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 198
407572 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message from IRODS read back:<MiscSvrInfo_PI><serverType>1</serverType>
<serverBootTime>1433259502</serverBootTime>
<relVersion>rods4.1.0</relVersion>
<apiVersion>d</apiVersion>
<rodsZone>fedZone2</rodsZone>
</MiscSvrInfo_PI>

407572 [main] INFO  org.irods.jargon.core.connection.EnvironmentalInfoAccessor  - server response obtained
407572 [main] DEBUG org.irods.jargon.core.connection.EnvironmentalInfoAccessor  - cached the props for host and zone:IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259502
    Rel version:rods4.1.0
    API version:d
    zone:fedZone2
    eirods:true

407572 [main] INFO  org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocolFactory  - IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259502
    Rel version:rods4.1.0
    API version:d
    zone:fedZone2
    eirods:true

407573 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - put a reference to a new connection for account: irods://[email protected]:1247
407573 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - returned new connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone2/home/test1/main/1433261528799, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259502
    Rel version:rods4.1.0
    API version:d
    zone:fedZone2
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20002
   reconnAddr:fedzone2-410
   cookie:264999191, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@b7dd107, irodsAccount=irods://[email protected]:1247]
407573 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
407573 [main] DEBUG org.irods.jargon.core.pub.IRODSAccessObjectFactoryImpl  - creating access object factory
407573 [main] DEBUG org.irods.jargon.core.pub.IRODSGenericAO  - establishing connection
407573 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone2/home/test1/main/1433261528799, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259502
    Rel version:rods4.1.0
    API version:d
    zone:fedZone2
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20002
   reconnAddr:fedzone2-410
   cookie:264999191, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@b7dd107, irodsAccount=irods://[email protected]:1247]
421393 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - session using previously established connection:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone2/home/test1/main/1433261528799, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259502
    Rel version:rods4.1.0
    API version:d
    zone:fedZone2
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20002
   reconnAddr:fedzone2-410
   cookie:264999191, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@b7dd107, irodsAccount=irods://[email protected]:1247]
421394 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with byte array
421394 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - calling irods function with:<DataObjInp_PI><objPath>/fedZone1/home/test1/jargon-scratch/FederatedCollectionAndDataObjectListAndSearchAOImplTest/testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2</objPath>
<createMode>0</createMode>
<openFlags>0</openFlags>
<offset>0</offset>
<dataSize>0</dataSize>
<numThreads>0</numThreads>
<oprType>0</oprType>
<KeyValPair_PI><ssLen>0</ssLen>
</KeyValPair_PI>
</DataObjInp_PI>

421395 [main] DEBUG org.irods.jargon.core.connection.IRODSMidLevelProtocol  - api number is:633
421395 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 633
421395 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_API_REQ</type><msgLen>415</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>633</intInfo></MsgHeader_PI>
421395 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - reading message from irods
421395 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  4
421395 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
421396 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 4
421498 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - IRODSConnection.read, byte array size =  145
421499 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - offset = 0
421499 [main] DEBUG org.irods.jargon.core.connection.AbstractConnection  - length = 145
421499 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - message length:0
421499 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - error length:0
421499 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - bytesLength:0
421499 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info value:-310000
421500 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - info is < 0
421500 [main] DEBUG org.irods.jargon.core.connection.IRODSErrorScanner  - inspectAndThrowIfNeeded:-310000
421500 [main] DEBUG org.irods.jargon.core.connection.IRODSErrorScanner  - scanning for info value...
421500 [main] DEBUG org.irods.jargon.core.connection.IRODSErrorScanner  - errorEnum val:USER_FILE_DOES_NOT_EXIST
472836 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - closing all irods sessions
472836 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - found and am closing connection to : irods://[email protected]:1247
472836 [main] DEBUG org.irods.jargon.core.connection.IRODSSimpleProtocolManager  - irodsMidLevelProtocol returned:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259442
    Rel version:rods4.1.0
    API version:d
    zone:fedZone1
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20045
   reconnAddr:fedzone1-410
   cookie:981961296, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@77ec78b9, irodsAccount=irods://[email protected]:1247]
472836 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - shutting down, need to send disconnect to irods
472836 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - sending disconnect message
472836 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 0
472836 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_DISCONNECT</type><msgLen>0</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>0</intInfo></MsgHeader_PI>
472836 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - finally, shutdown is being called on the given connection
472836 [main] DEBUG org.irods.jargon.core.connection.IRODSBasicTCPConnection  - shutting down connection: true
472836 [main] DEBUG org.irods.jargon.core.connection.IRODSBasicTCPConnection  - is connected for : irods://[email protected]:1247/fedZone1/home/test1/main/1433261126621
472836 [main] DEBUG org.irods.jargon.core.connection.IRODSBasicTCPConnection  - now disconnected
472836 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - found and am closing connection to : irods://[email protected]:1247
472836 [main] DEBUG org.irods.jargon.core.connection.IRODSSimpleProtocolManager  - irodsMidLevelProtocol returned:AbstractIRODSMidLevelProtocol [irodsConnection=irods://[email protected]:1247/fedZone2/home/test1/main/1433261528799, irodsProtocolManager=org.irods.jargon.core.connection.IRODSSimpleProtocolManager@1a3869f4, irodsServerProperties=IRODS server properties
    icat enabled?:ICAT_ENABLED
    Server boot time:1433259502
    Rel version:rods4.1.0
    API version:d
    zone:fedZone2
    eirods:true
, irodsSession=org.irods.jargon.core.connection.IRODSSession@a38d7a3, startupResponseData=StartupResponseData:
   status:0
   relVersion:rods4.1.0
   apiVersion:d
   reconnPort:20002
   reconnAddr:fedzone2-410
   cookie:264999191, forceSslFlush=false, log=org.slf4j.impl.Log4jLoggerAdapter(org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol), authResponse=org.irods.jargon.core.connection.auth.AuthResponse@b7dd107, irodsAccount=irods://[email protected]:1247]
472836 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - shutting down, need to send disconnect to irods
472836 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - sending disconnect message
472836 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - functionID: 0
472836 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - header:<MsgHeader_PI><type>RODS_DISCONNECT</type><msgLen>0</msgLen><errorLen>0</errorLen><bsLen>0</bsLen><intInfo>0</intInfo></MsgHeader_PI>
472836 [main] DEBUG org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol  - finally, shutdown is being called on the given connection
472838 [main] DEBUG org.irods.jargon.core.connection.IRODSBasicTCPConnection  - shutting down connection: true
472838 [main] DEBUG org.irods.jargon.core.connection.IRODSBasicTCPConnection  - is connected for : irods://[email protected]:1247/fedZone2/home/test1/main/1433261528799
472838 [main] DEBUG org.irods.jargon.core.connection.IRODSBasicTCPConnection  - now disconnected
472838 [main] DEBUG org.irods.jargon.core.connection.IRODSSession  - all sessions closed for this Thread
@michael-conway michael-conway added this to the 4.0.2.3 with iRODS 4.1 milestone Jun 2, 2015
@michael-conway michael-conway self-assigned this Jun 2, 2015
@michael-conway
Copy link
Collaborator Author

Junit stack trace from test

org.irods.jargon.core.exception.FileNotFoundException: File not found
    at org.irods.jargon.core.connection.IRODSErrorScanner.checkSpecificCodesAndThrowIfExceptionLocated(IRODSErrorScanner.java:174)
    at org.irods.jargon.core.connection.IRODSErrorScanner.inspectAndThrowIfNeeded(IRODSErrorScanner.java:123)
    at org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol.processMessageInfoLessThanZero(AbstractIRODSMidLevelProtocol.java:1172)
    at org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol.readMessage(AbstractIRODSMidLevelProtocol.java:663)
    at org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol.readMessage(AbstractIRODSMidLevelProtocol.java:629)
    at org.irods.jargon.core.connection.IRODSMidLevelProtocol.irodsFunction(IRODSMidLevelProtocol.java:231)
    at org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol.irodsFunction(AbstractIRODSMidLevelProtocol.java:174)
    at org.irods.jargon.core.connection.AbstractIRODSMidLevelProtocol.irodsFunction(AbstractIRODSMidLevelProtocol.java:571)
    at org.irods.jargon.core.pub.CollectionAndDataObjectListAndSearchAOImpl.retrieveObjectStatForPath(CollectionAndDataObjectListAndSearchAOImpl.java:1580)
    at org.irods.jargon.core.pub.CollectionAndDataObjectListAndSearchAOImpl.listCollectionsUnderPathWithPermissions(CollectionAndDataObjectListAndSearchAOImpl.java:769)
    at org.irods.jargon.core.pub.FederatedCollectionAndDataObjectListAndSearchAOImplTest.testListCollectionsUnderPathWithPermissionsIncludingACrossZoneUserQueryFromZone2(FederatedCollectionAndDataObjectListAndSearchAOImplTest.java:404)
    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
    at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
    at java.lang.reflect.Method.invoke(Unknown Source)
    at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
    at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
    at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
    at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
    at org.junit.runners.BlockJUnit4ClassRunner.runNotIgnored(BlockJUnit4ClassRunner.java:79)
    at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:71)
    at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:49)
    at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
    at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
    at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
    at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
    at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
    at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
    at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:31)
    at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
    at org.eclipse.jdt.internal.junit4.runner.JUnit4TestReference.run(JUnit4TestReference.java:50)
    at org.eclipse.jdt.internal.junit.runner.TestExecution.run(TestExecution.java:38)
    at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:459)
    at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:675)
    at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.run(RemoteTestRunner.java:382)
    at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.main(RemoteTestRunner.java:192)

michael-conway added a commit that referenced this issue Jun 3, 2015
@michael-conway
#126 fixes for stand-ins when getting objStat
2270f5f
michael-conway added a commit that referenced this issue Jun 3, 2015
@michael-conway
#126 file exists method now works with stand-in directories for root,…
8f4e89e 
… zone, home to account for strict acls
@michael-conway michael-conway reopened this Jun 3, 2015
michael-conway added a commit that referenced this issue Jun 3, 2015
@michael-conway
#126 browsing cross zones now works in webdav
6dbbe21
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees

@michael-conway michael-conway

Labels
None yet
Projects
None yet
Milestone
4.0.2.3 with iRODS 4.1
Development

No branches or pull requests
1 participant
@michael-conway