[main] INFO zookeeper.ZooKeeper - Client environment:zookeeper.version=3.3.2-1031432, built on 11/05/2010 05:32 GMT [main] INFO zookeeper.ZooKeeper - Client environment:host.name=cnode3.iplantcollaborative.org [main] INFO zookeeper.ZooKeeper - Client environment:java.version=1.6.0_27 [main] INFO zookeeper.ZooKeeper - Client environment:java.vendor=Sun Microsystems Inc. [main] INFO zookeeper.ZooKeeper - Client environment:java.home=/usr/java/jdk1.6.0_27/jre [main] INFO zookeeper.ZooKeeper - Client environment:java.class.path=/usr/local/lib/porklock/porklock-1.2.1-SNAPSHOT-standalone.jar [main] INFO zookeeper.ZooKeeper - Client environment:java.library.path=/usr/java/jdk1.6.0_27/jre/lib/amd64/server:/usr/java/jdk1.6.0_27/jre/lib/amd64:/usr/java/jdk1.6.0_27/jre/../lib/amd64:/usr/java/packages/lib/amd64:/usr/lib64:/lib64:/lib:/usr/lib [main] INFO zookeeper.ZooKeeper - Client environment:java.io.tmpdir=/tmp [main] INFO zookeeper.ZooKeeper - Client environment:java.compiler= [main] INFO zookeeper.ZooKeeper - Client environment:os.name=Linux [main] INFO zookeeper.ZooKeeper - Client environment:os.arch=amd64 [main] INFO zookeeper.ZooKeeper - Client environment:os.version=2.6.18-348.18.1.el5 [main] INFO zookeeper.ZooKeeper - Client environment:user.name=condor [main] INFO zookeeper.ZooKeeper - Client environment:user.home=/var/lib/condor [main] INFO zookeeper.ZooKeeper - Client environment:user.dir=/var/lib/condor/iplant-de-jobs/sr320/FEB5DF32-85EF-45F1-B8F7-E6CFFEEFAE2C [porklock] [arguments] (get --user sr320 --source /iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq --config /condor01/scratch/sr320/RNAseq2bedgraph_G3-2014-03-06-16-26-41.026/logs/irods-config -m ipc-execution-id,FEB5DF32-85EF-45F1-B8F7-E6CFFEEFAE2C,UUID -m ipc-analysis-id,F7626782-7D3E-4AF0-BAEE-33C0EB8D84FA,UUID) [porklock] [options] {:user sr320, :source /iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq, :destination ., :config /condor01/scratch/sr320/RNAseq2bedgraph_G3-2014-03-06-16-26-41.026/logs/irods-config, :meta [(ipc-execution-id FEB5DF32-85EF-45F1-B8F7-E6CFFEEFAE2C UUID) (ipc-analysis-id F7626782-7D3E-4AF0-BAEE-33C0EB8D84FA UUID)], :help false} [porklock] [remnants] [] [main] WARN clojure-commons.config - CONFIG: porklock.irods-home = /iplant/home [main] WARN clojure-commons.config - CONFIG: porklock.irods-host = data.iplantcollaborative.org [main] WARN clojure-commons.config - CONFIG: porklock.irods-pass = ******** [main] WARN clojure-commons.config - CONFIG: porklock.irods-port = 1247 [main] WARN clojure-commons.config - CONFIG: porklock.irods-resc = [main] WARN clojure-commons.config - CONFIG: porklock.irods-user = ******** [main] WARN clojure-commons.config - CONFIG: porklock.irods-zone = iplant ================================================================================ env: {"irodsAuthFileName" "./.irods/.irodsA", "irodsEnvFile" "./.irods/.irodsEnv"} command: /usr/local2/icommands/iinit stdout: Enter your current iRODS password: [main] INFO connection.IRODSSimpleProtocolManager - creating simple protocol manager [main] INFO connection.IRODSSession - IRODS Session creation, loading default properties, these may be overridden... [main] INFO pub.IRODSFileSystem - IRODSfileSystem is initialized [main] INFO connection.AuthenticationFactoryImpl - instanceAuthMechanism() [main] INFO connection.AuthenticationFactoryImpl - authScheme:STANDARD [main] INFO connection.AuthenticationFactoryImpl - using standard auth [main] INFO connection.IRODSConnection - pipeline configuration:PipelineConfiguration irodsSocketTimeout:0 irodsParallelSocketTimeout:120 internalInputStreamBufferSize:0 internalOutputStreamBufferSize:-1 internalCacheBufferSize:65535 localFileOutputStreamBufferSize:0 localFileInputStreamBufferSize:0 defaultEncoding:UTF-8 inputToOutputCopyBufferByteSize:8192 instrument:false reconnect:false reconnect time in millis:600000 [main] INFO connection.IRODSConnection - using internal cache buffer of size:65535 [main] INFO connection.IRODSConnection - opening irods socket [main] INFO connection.IRODSConnection - connect() [main] INFO connection.IRODSConnection - connecting socket to agent [main] INFO connection.IRODSConnection - normal iRODS connection [main] INFO connection.IRODSConnection - connection to socket made... [main] INFO connection.IRODSConnection - default buffer on input stream [main] INFO connection.IRODSConnection - no buffer on output stream [main] INFO connection.IRODSConnection - socket opened successfully [main] INFO connection.IRODSCommands - reading message from irods [main] INFO connection.AuthMechanism - startup response:StartupResponseData: status:0 relVersion:rods3.3 apiVersion:d reconnPort:0 reconnAddr: cookie:0 [main] INFO connection.StandardIRODSAuth - authenticate [main] INFO connection.StandardIRODSAuth - sending standard irods password [main] INFO connection.IRODSCommands - reading message from irods [main] INFO connection.IRODSCommands - calling irods function with byte array [main] INFO connection.IRODSCommands - reading message from irods [main] INFO connection.StandardIRODSAuth - auth was successful [main] INFO connection.StandardIRODSAuth - auth response was:org.irods.jargon.core.connection.auth.AuthResponse@16ad339b [main] INFO connection.EnvironmentalInfoAccessor - getting irods server properties [main] INFO connection.DiscoveredServerPropertiesCache - now retriving server properties from cache with zone:iplant [main] INFO connection.IRODSCommands - calling irods function with byte array [main] INFO connection.IRODSCommands - reading message from irods [main] INFO connection.EnvironmentalInfoAccessor - server response obtained [main] INFO connection.IRODSCommands - IRODS server properties icat enabled?:ICAT_ENABLED Server boot time:1391616767 Rel version:rods3.3 API version:d zone:iplant [main] INFO io.IRODSFileImpl - setting file name, given path = /iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq [main] INFO io.IRODSFileImpl - detected local separator = / [main] INFO io.IRODSFileImpl - file name was set as: G3_2.fq [main] INFO io.IRODSFileImpl - isDirectory() for path:/iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq [main] INFO io.IRODSFileImpl - looking up objStat, not cached in file [main] INFO pub.IRODSFileSystemAOImpl - getObjStat(final String irodsAbsolutePath) [main] INFO connection.IRODSCommands - calling irods function with byte array [main] INFO connection.IRODSCommands - reading message from irods [main] INFO pub.CollectionAndDataObjectListAndSearchAOImpl - objStat: absolutePath:/iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq dataId:103183006 specColType:NORMAL objectType:DATA_OBJECT collectionPath: objectPath: checksum:9883f5a6833a6e14f88fb76e2eff1571 ownerName:sr320 ownerZone:iplant objSize:6043172545 cacheDir: cacheDirty:false createdAt:replNumber:0Thu Mar 06 15:24:23 MST 2014 modifiedAt:Thu Mar 06 15:24:23 MST 2014 [main] INFO io.IRODSFileImpl - setting file name, given path = /iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq [main] INFO io.IRODSFileImpl - detected local separator = / [main] INFO io.IRODSFileImpl - file name was set as: G3_2.fq [main] INFO io.IRODSFileImpl - isFile() for path:/iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq [main] INFO io.IRODSFileImpl - looking up objStat, not cached in file [main] INFO pub.IRODSFileSystemAOImpl - getObjStat(final String irodsAbsolutePath) [main] INFO connection.IRODSCommands - calling irods function with byte array [main] INFO connection.IRODSCommands - reading message from irods [main] INFO pub.CollectionAndDataObjectListAndSearchAOImpl - objStat: absolutePath:/iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq dataId:103183006 specColType:NORMAL objectType:DATA_OBJECT collectionPath: objectPath: checksum:9883f5a6833a6e14f88fb76e2eff1571 ownerName:sr320 ownerZone:iplant objSize:6043172545 cacheDir: cacheDirty:false createdAt:replNumber:0Thu Mar 06 15:24:23 MST 2014 modifiedAt:Thu Mar 06 15:24:23 MST 2014 [main] INFO pub.UserGroupAOImpl - find user group with user name: sr320 [main] INFO pub.UserGroupAOImpl - query string: SELECT USER_GROUP_NAME,USER_GROUP_ID WHERE USER_NAME = 'sr320' [main] INFO pub.IRODSGenQueryExecutorImpl - executeIRODSQueryAndCloseResult() [main] INFO pub.IRODSGenQueryExecutorImpl - executeIRODSQueryAndCloseResultInZone() [main] INFO pub.IRODSGenQueryExecutorImpl - query: IRODSQuery: queryString:SELECT USER_GROUP_NAME,USER_GROUP_ID WHERE USER_NAME = 'sr320' numberOfResultsDesired:500 [main] INFO connection.IRODSCommands - calling irods function with byte array [main] INFO connection.IRODSCommands - reading message from irods [main] INFO query.GenQueryProcessor - continuation value: 0 [main] INFO query.GenQueryProcessor - total records:0 [main] INFO query.QueryResultProcessingUtils - rows returned from iRODS query: 2 [main] INFO query.GenQueryProcessor - auto closing result set [main] INFO query.GenQueryProcessor - getting more results for query [main] INFO query.GenQueryProcessor - no results to close, ignore [main] INFO pub.IRODSGenQueryExecutorImpl - executeIRODSQueryAndCloseResult() [main] INFO pub.IRODSGenQueryExecutorImpl - executeIRODSQueryAndCloseResultInZone() [main] INFO pub.IRODSGenQueryExecutorImpl - query: IRODSQuery: queryString:select USER_ID where USER_NAME = 'public' numberOfResultsDesired:50000 [main] INFO connection.IRODSCommands - calling irods function with byte array [main] INFO connection.IRODSCommands - reading message from irods [main] INFO query.GenQueryProcessor - continuation value: 0 [main] INFO query.GenQueryProcessor - total records:0 [main] INFO query.QueryResultProcessingUtils - rows returned from iRODS query: 1 [main] INFO query.GenQueryProcessor - auto closing result set [main] INFO query.GenQueryProcessor - getting more results for query [main] INFO query.GenQueryProcessor - no results to close, ignore [main] INFO pub.IRODSGenQueryExecutorImpl - executeIRODSQueryAndCloseResult() [main] INFO pub.IRODSGenQueryExecutorImpl - executeIRODSQueryAndCloseResultInZone() [main] INFO pub.IRODSGenQueryExecutorImpl - query: IRODSQuery: queryString:select DATA_ACCESS_TYPE where COLL_NAME = '/iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783' and DATA_NAME = 'G3_2.fq' and DATA_ACCESS_USER_ID = '10004' numberOfResultsDesired:50000 [main] INFO connection.IRODSCommands - calling irods function with byte array [main] INFO connection.IRODSCommands - reading message from irods [main] INFO query.GenQueryProcessor - response from IRODS call indicates no rows found [main] INFO query.GenQueryProcessor - auto closing result set [main] INFO query.GenQueryProcessor - getting more results for query [main] INFO query.GenQueryProcessor - no results to close, ignore [main] INFO pub.IRODSGenQueryExecutorImpl - executeIRODSQueryAndCloseResult() [main] INFO pub.IRODSGenQueryExecutorImpl - executeIRODSQueryAndCloseResultInZone() [main] INFO pub.IRODSGenQueryExecutorImpl - query: IRODSQuery: queryString:select USER_ID where USER_NAME = 'sr320' numberOfResultsDesired:50000 [main] INFO connection.IRODSCommands - calling irods function with byte array [main] INFO connection.IRODSCommands - reading message from irods [main] INFO query.GenQueryProcessor - continuation value: 0 [main] INFO query.GenQueryProcessor - total records:0 [main] INFO query.QueryResultProcessingUtils - rows returned from iRODS query: 1 [main] INFO query.GenQueryProcessor - auto closing result set [main] INFO query.GenQueryProcessor - getting more results for query [main] INFO query.GenQueryProcessor - no results to close, ignore [main] INFO pub.IRODSGenQueryExecutorImpl - executeIRODSQueryAndCloseResult() [main] INFO pub.IRODSGenQueryExecutorImpl - executeIRODSQueryAndCloseResultInZone() [main] INFO pub.IRODSGenQueryExecutorImpl - query: IRODSQuery: queryString:select DATA_ACCESS_TYPE where COLL_NAME = '/iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783' and DATA_NAME = 'G3_2.fq' and DATA_ACCESS_USER_ID = '73068066' numberOfResultsDesired:50000 [main] INFO connection.IRODSCommands - calling irods function with byte array [main] INFO connection.IRODSCommands - reading message from irods [main] INFO query.GenQueryProcessor - continuation value: 0 [main] INFO query.GenQueryProcessor - total records:0 [main] INFO query.QueryResultProcessingUtils - rows returned from iRODS query: 1 [main] INFO query.GenQueryProcessor - auto closing result set [main] INFO query.GenQueryProcessor - getting more results for query [main] INFO query.GenQueryProcessor - no results to close, ignore [main] INFO io.IRODSFileImpl - setting file name, given path = /iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq [main] INFO io.IRODSFileImpl - detected local separator = / [main] INFO io.IRODSFileImpl - file name was set as: G3_2.fq [main] INFO io.IRODSFileImpl - isDirectory() for path:/iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq [main] INFO io.IRODSFileImpl - looking up objStat, not cached in file [main] INFO pub.IRODSFileSystemAOImpl - getObjStat(final String irodsAbsolutePath) [main] INFO connection.IRODSCommands - calling irods function with byte array [main] INFO connection.IRODSCommands - reading message from irods [main] INFO pub.CollectionAndDataObjectListAndSearchAOImpl - objStat: absolutePath:/iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq dataId:103183006 specColType:NORMAL objectType:DATA_OBJECT collectionPath: objectPath: checksum:9883f5a6833a6e14f88fb76e2eff1571 ownerName:sr320 ownerZone:iplant objSize:6043172545 cacheDir: cacheDirty:false createdAt:replNumber:0Thu Mar 06 15:24:23 MST 2014 modifiedAt:Thu Mar 06 15:24:23 MST 2014 [porklock] Metadata tuples for /iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq are ((ipc-execution-id FEB5DF32-85EF-45F1-B8F7-E6CFFEEFAE2C UUID) (ipc-analysis-id F7626782-7D3E-4AF0-BAEE-33C0EB8D84FA UUID)) [porklock] Size of tuple (ipc-execution-id FEB5DF32-85EF-45F1-B8F7-E6CFFEEFAE2C UUID) is 3 [porklock] Might be adding metadata to /iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq (ipc-execution-id FEB5DF32-85EF-45F1-B8F7-E6CFFEEFAE2C UUID) [main] INFO io.IRODSFileImpl - setting file name, given path = /iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq [main] INFO io.IRODSFileImpl - detected local separator = / [main] INFO io.IRODSFileImpl - file name was set as: G3_2.fq [main] INFO io.IRODSFileImpl - isDirectory() for path:/iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq [main] INFO io.IRODSFileImpl - looking up objStat, not cached in file [main] INFO pub.IRODSFileSystemAOImpl - getObjStat(final String irodsAbsolutePath) [main] INFO connection.IRODSCommands - calling irods function with byte array [main] INFO connection.IRODSCommands - reading message from irods [main] INFO pub.CollectionAndDataObjectListAndSearchAOImpl - objStat: absolutePath:/iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq dataId:103183006 specColType:NORMAL objectType:DATA_OBJECT collectionPath: objectPath: checksum:9883f5a6833a6e14f88fb76e2eff1571 ownerName:sr320 ownerZone:iplant objSize:6043172545 cacheDir: cacheDirty:false createdAt:replNumber:0Thu Mar 06 15:24:23 MST 2014 modifiedAt:Thu Mar 06 15:24:23 MST 2014 [main] INFO pub.DataObjectAOImpl - findMetadataValuesForDataObject: /iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq [main] INFO io.IRODSFileImpl - setting file name, given path = G3_2.fq [main] INFO io.IRODSFileImpl - detected local separator = / [main] INFO io.IRODSFileImpl - file name was set as: G3_2.fq [main] INFO pub.FileCatalogObjectAOImpl - retrieveObjStat() [main] INFO pub.FileCatalogObjectAOImpl - irodsAbsolutePath:/iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq [main] INFO connection.IRODSCommands - calling irods function with byte array [main] INFO connection.IRODSCommands - reading message from irods [main] INFO pub.CollectionAndDataObjectListAndSearchAOImpl - objStat: absolutePath:/iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq dataId:103183006 specColType:NORMAL objectType:DATA_OBJECT collectionPath: objectPath: checksum:9883f5a6833a6e14f88fb76e2eff1571 ownerName:sr320 ownerZone:iplant objSize:6043172545 cacheDir: cacheDirty:false createdAt:replNumber:0Thu Mar 06 15:24:23 MST 2014 modifiedAt:Thu Mar 06 15:24:23 MST 2014 [main] INFO io.IRODSFileImpl - setting file name, given path = /iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq [main] INFO io.IRODSFileImpl - detected local separator = / [main] INFO io.IRODSFileImpl - file name was set as: G3_2.fq [main] INFO pub.IRODSGenQueryExecutorImpl - executeIRODSQueryAndCloseResultInZone() [main] INFO pub.IRODSGenQueryExecutorImpl - query: org.irods.jargon.core.query.IRODSGenQueryFromBuilder@21453d72 [main] INFO connection.IRODSCommands - calling irods function with byte array [main] INFO connection.IRODSCommands - reading message from irods [main] INFO query.GenQueryProcessor - continuation value: 0 [main] INFO query.GenQueryProcessor - total records:0 [main] INFO query.QueryResultProcessingUtils - rows returned from iRODS query: 3 [main] INFO query.GenQueryProcessor - auto closing result set [main] INFO query.GenQueryProcessor - getting more results for query [main] INFO query.GenQueryProcessor - no results to close, ignore [porklock] AVU? /iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq () [main] INFO io.IRODSFileImpl - setting file name, given path = /iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq [main] INFO io.IRODSFileImpl - detected local separator = / [main] INFO io.IRODSFileImpl - file name was set as: G3_2.fq [main] INFO io.IRODSFileImpl - isDirectory() for path:/iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq [main] INFO io.IRODSFileImpl - looking up objStat, not cached in file [main] INFO pub.IRODSFileSystemAOImpl - getObjStat(final String irodsAbsolutePath) [main] INFO connection.IRODSCommands - calling irods function with byte array [main] INFO connection.IRODSCommands - reading message from irods [main] INFO pub.CollectionAndDataObjectListAndSearchAOImpl - objStat: absolutePath:/iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq dataId:103183006 specColType:NORMAL objectType:DATA_OBJECT collectionPath: objectPath: checksum:9883f5a6833a6e14f88fb76e2eff1571 ownerName:sr320 ownerZone:iplant objSize:6043172545 cacheDir: cacheDirty:false createdAt:replNumber:0Thu Mar 06 15:24:23 MST 2014 modifiedAt:Thu Mar 06 15:24:23 MST 2014 [main] INFO pub.DataObjectAOImpl - findMetadataValuesForDataObject: /iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq [main] INFO io.IRODSFileImpl - setting file name, given path = G3_2.fq [main] INFO io.IRODSFileImpl - detected local separator = / [main] INFO io.IRODSFileImpl - file name was set as: G3_2.fq [main] INFO pub.FileCatalogObjectAOImpl - retrieveObjStat() [main] INFO pub.FileCatalogObjectAOImpl - irodsAbsolutePath:/iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq [main] INFO connection.IRODSCommands - calling irods function with byte array [main] INFO connection.IRODSCommands - reading message from irods [main] INFO pub.CollectionAndDataObjectListAndSearchAOImpl - objStat: absolutePath:/iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq dataId:103183006 specColType:NORMAL objectType:DATA_OBJECT collectionPath: objectPath: checksum:9883f5a6833a6e14f88fb76e2eff1571 ownerName:sr320 ownerZone:iplant objSize:6043172545 cacheDir: cacheDirty:false createdAt:replNumber:0Thu Mar 06 15:24:23 MST 2014 modifiedAt:Thu Mar 06 15:24:23 MST 2014 [main] INFO io.IRODSFileImpl - setting file name, given path = /iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq [main] INFO io.IRODSFileImpl - detected local separator = / [main] INFO io.IRODSFileImpl - file name was set as: G3_2.fq [main] INFO pub.IRODSGenQueryExecutorImpl - executeIRODSQueryAndCloseResultInZone() [main] INFO pub.IRODSGenQueryExecutorImpl - query: org.irods.jargon.core.query.IRODSGenQueryFromBuilder@5b4bc4e6 [main] INFO connection.IRODSCommands - calling irods function with byte array [main] INFO connection.IRODSCommands - reading message from irods [main] INFO query.GenQueryProcessor - continuation value: 0 [main] INFO query.GenQueryProcessor - total records:0 [main] INFO query.QueryResultProcessingUtils - rows returned from iRODS query: 3 [main] INFO query.GenQueryProcessor - auto closing result set [main] INFO query.GenQueryProcessor - getting more results for query [main] INFO query.GenQueryProcessor - no results to close, ignore [porklock] Adding metadata ipc-execution-id FEB5DF32-85EF-45F1-B8F7-E6CFFEEFAE2C /iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq [main] INFO io.IRODSFileImpl - setting file name, given path = /iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq [main] INFO io.IRODSFileImpl - detected local separator = / [main] INFO io.IRODSFileImpl - file name was set as: G3_2.fq [main] INFO io.IRODSFileImpl - isDirectory() for path:/iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq [main] INFO io.IRODSFileImpl - looking up objStat, not cached in file [main] INFO pub.IRODSFileSystemAOImpl - getObjStat(final String irodsAbsolutePath) [main] INFO connection.IRODSCommands - calling irods function with byte array [main] INFO connection.IRODSCommands - reading message from irods [main] INFO pub.CollectionAndDataObjectListAndSearchAOImpl - objStat: absolutePath:/iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq dataId:103183006 specColType:NORMAL objectType:DATA_OBJECT collectionPath: objectPath: checksum:9883f5a6833a6e14f88fb76e2eff1571 ownerName:sr320 ownerZone:iplant objSize:6043172545 cacheDir: cacheDirty:false createdAt:replNumber:0Thu Mar 06 15:24:23 MST 2014 modifiedAt:Thu Mar 06 15:24:23 MST 2014 [main] INFO pub.DataObjectAOImpl - adding avu metadata to data object: avu data: attrib:ipc-execution-id value:FEB5DF32-85EF-45F1-B8F7-E6CFFEEFAE2C units:UUID [main] INFO pub.DataObjectAOImpl - absolute path: /iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq [main] INFO pub.FileCatalogObjectAOImpl - resoveAbsolutePathViaObjStat() [main] INFO pub.FileCatalogObjectAOImpl - retrieveObjStat() [main] INFO pub.FileCatalogObjectAOImpl - irodsAbsolutePath:/iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783 [main] INFO connection.IRODSCommands - calling irods function with byte array [main] INFO connection.IRODSCommands - reading message from irods [main] INFO pub.CollectionAndDataObjectListAndSearchAOImpl - objStat: absolutePath:/iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783 dataId:103182993 specColType:NORMAL objectType:COLLECTION collectionPath: objectPath: checksum: ownerName:de-irods ownerZone:iplant objSize:0 cacheDir: cacheDirty:false createdAt:replNumber:0Thu Mar 06 15:23:02 MST 2014 modifiedAt:Thu Mar 06 15:23:02 MST 2014 [main] INFO connection.IRODSCommands - calling irods function with byte array [main] INFO connection.IRODSCommands - reading message from irods [porklock] Size of tuple (ipc-analysis-id F7626782-7D3E-4AF0-BAEE-33C0EB8D84FA UUID) is 3 [porklock] Might be adding metadata to /iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq (ipc-analysis-id F7626782-7D3E-4AF0-BAEE-33C0EB8D84FA UUID) [main] INFO io.IRODSFileImpl - setting file name, given path = /iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq [main] INFO io.IRODSFileImpl - detected local separator = / [main] INFO io.IRODSFileImpl - file name was set as: G3_2.fq [main] INFO io.IRODSFileImpl - isDirectory() for path:/iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq [main] INFO io.IRODSFileImpl - looking up objStat, not cached in file [main] INFO pub.IRODSFileSystemAOImpl - getObjStat(final String irodsAbsolutePath) [main] INFO connection.IRODSCommands - calling irods function with byte array [main] INFO connection.IRODSCommands - reading message from irods [main] INFO pub.CollectionAndDataObjectListAndSearchAOImpl - objStat: absolutePath:/iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq dataId:103183006 specColType:NORMAL objectType:DATA_OBJECT collectionPath: objectPath: checksum:9883f5a6833a6e14f88fb76e2eff1571 ownerName:sr320 ownerZone:iplant objSize:6043172545 cacheDir: cacheDirty:false createdAt:replNumber:0Thu Mar 06 15:24:23 MST 2014 modifiedAt:Thu Mar 06 15:24:23 MST 2014 [main] INFO pub.DataObjectAOImpl - findMetadataValuesForDataObject: /iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq [main] INFO io.IRODSFileImpl - setting file name, given path = G3_2.fq [main] INFO io.IRODSFileImpl - detected local separator = / [main] INFO io.IRODSFileImpl - file name was set as: G3_2.fq [main] INFO pub.FileCatalogObjectAOImpl - retrieveObjStat() [main] INFO pub.FileCatalogObjectAOImpl - irodsAbsolutePath:/iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq [main] INFO connection.IRODSCommands - calling irods function with byte array [main] INFO connection.IRODSCommands - reading message from irods [main] INFO pub.CollectionAndDataObjectListAndSearchAOImpl - objStat: absolutePath:/iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq dataId:103183006 specColType:NORMAL objectType:DATA_OBJECT collectionPath: objectPath: checksum:9883f5a6833a6e14f88fb76e2eff1571 ownerName:sr320 ownerZone:iplant objSize:6043172545 cacheDir: cacheDirty:false createdAt:replNumber:0Thu Mar 06 15:24:23 MST 2014 modifiedAt:Thu Mar 06 15:24:23 MST 2014 [main] INFO io.IRODSFileImpl - setting file name, given path = /iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq [main] INFO io.IRODSFileImpl - detected local separator = / [main] INFO io.IRODSFileImpl - file name was set as: G3_2.fq [main] INFO pub.IRODSGenQueryExecutorImpl - executeIRODSQueryAndCloseResultInZone() [main] INFO pub.IRODSGenQueryExecutorImpl - query: org.irods.jargon.core.query.IRODSGenQueryFromBuilder@4fef3a22 [main] INFO connection.IRODSCommands - calling irods function with byte array [main] INFO connection.IRODSCommands - reading message from irods [main] INFO query.GenQueryProcessor - continuation value: 0 [main] INFO query.GenQueryProcessor - total records:0 [main] INFO query.QueryResultProcessingUtils - rows returned from iRODS query: 4 [main] INFO query.GenQueryProcessor - auto closing result set [main] INFO query.GenQueryProcessor - getting more results for query [main] INFO query.GenQueryProcessor - no results to close, ignore [porklock] AVU? /iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq () [main] INFO io.IRODSFileImpl - setting file name, given path = /iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq [main] INFO io.IRODSFileImpl - detected local separator = / [main] INFO io.IRODSFileImpl - file name was set as: G3_2.fq [main] INFO io.IRODSFileImpl - isDirectory() for path:/iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq [main] INFO io.IRODSFileImpl - looking up objStat, not cached in file [main] INFO pub.IRODSFileSystemAOImpl - getObjStat(final String irodsAbsolutePath) [main] INFO connection.IRODSCommands - calling irods function with byte array [main] INFO connection.IRODSCommands - reading message from irods [main] INFO pub.CollectionAndDataObjectListAndSearchAOImpl - objStat: absolutePath:/iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq dataId:103183006 specColType:NORMAL objectType:DATA_OBJECT collectionPath: objectPath: checksum:9883f5a6833a6e14f88fb76e2eff1571 ownerName:sr320 ownerZone:iplant objSize:6043172545 cacheDir: cacheDirty:false createdAt:replNumber:0Thu Mar 06 15:24:23 MST 2014 modifiedAt:Thu Mar 06 15:24:23 MST 2014 [main] INFO pub.DataObjectAOImpl - findMetadataValuesForDataObject: /iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq [main] INFO io.IRODSFileImpl - setting file name, given path = G3_2.fq [main] INFO io.IRODSFileImpl - detected local separator = / [main] INFO io.IRODSFileImpl - file name was set as: G3_2.fq [main] INFO pub.FileCatalogObjectAOImpl - retrieveObjStat() [main] INFO pub.FileCatalogObjectAOImpl - irodsAbsolutePath:/iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq [main] INFO connection.IRODSCommands - calling irods function with byte array [main] INFO connection.IRODSCommands - reading message from irods [main] INFO pub.CollectionAndDataObjectListAndSearchAOImpl - objStat: absolutePath:/iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq dataId:103183006 specColType:NORMAL objectType:DATA_OBJECT collectionPath: objectPath: checksum:9883f5a6833a6e14f88fb76e2eff1571 ownerName:sr320 ownerZone:iplant objSize:6043172545 cacheDir: cacheDirty:false createdAt:replNumber:0Thu Mar 06 15:24:23 MST 2014 modifiedAt:Thu Mar 06 15:24:23 MST 2014 [main] INFO io.IRODSFileImpl - setting file name, given path = /iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq [main] INFO io.IRODSFileImpl - detected local separator = / [main] INFO io.IRODSFileImpl - file name was set as: G3_2.fq [main] INFO pub.IRODSGenQueryExecutorImpl - executeIRODSQueryAndCloseResultInZone() [main] INFO pub.IRODSGenQueryExecutorImpl - query: org.irods.jargon.core.query.IRODSGenQueryFromBuilder@36511e0a [main] INFO connection.IRODSCommands - calling irods function with byte array [main] INFO connection.IRODSCommands - reading message from irods [main] INFO query.GenQueryProcessor - continuation value: 0 [main] INFO query.GenQueryProcessor - total records:0 [main] INFO query.QueryResultProcessingUtils - rows returned from iRODS query: 4 [main] INFO query.GenQueryProcessor - auto closing result set [main] INFO query.GenQueryProcessor - getting more results for query [main] INFO query.GenQueryProcessor - no results to close, ignore [porklock] Adding metadata ipc-analysis-id F7626782-7D3E-4AF0-BAEE-33C0EB8D84FA /iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq [main] INFO io.IRODSFileImpl - setting file name, given path = /iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq [main] INFO io.IRODSFileImpl - detected local separator = / [main] INFO io.IRODSFileImpl - file name was set as: G3_2.fq [main] INFO io.IRODSFileImpl - isDirectory() for path:/iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq [main] INFO io.IRODSFileImpl - looking up objStat, not cached in file [main] INFO pub.IRODSFileSystemAOImpl - getObjStat(final String irodsAbsolutePath) [main] INFO connection.IRODSCommands - calling irods function with byte array [main] INFO connection.IRODSCommands - reading message from irods [main] INFO pub.CollectionAndDataObjectListAndSearchAOImpl - objStat: absolutePath:/iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq dataId:103183006 specColType:NORMAL objectType:DATA_OBJECT collectionPath: objectPath: checksum:9883f5a6833a6e14f88fb76e2eff1571 ownerName:sr320 ownerZone:iplant objSize:6043172545 cacheDir: cacheDirty:false createdAt:replNumber:0Thu Mar 06 15:24:23 MST 2014 modifiedAt:Thu Mar 06 15:24:23 MST 2014 [main] INFO pub.DataObjectAOImpl - adding avu metadata to data object: avu data: attrib:ipc-analysis-id value:F7626782-7D3E-4AF0-BAEE-33C0EB8D84FA units:UUID [main] INFO pub.DataObjectAOImpl - absolute path: /iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq [main] INFO pub.FileCatalogObjectAOImpl - resoveAbsolutePathViaObjStat() [main] INFO pub.FileCatalogObjectAOImpl - retrieveObjStat() [main] INFO pub.FileCatalogObjectAOImpl - irodsAbsolutePath:/iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783 [main] INFO connection.IRODSCommands - calling irods function with byte array [main] INFO connection.IRODSCommands - reading message from irods [main] INFO pub.CollectionAndDataObjectListAndSearchAOImpl - objStat: absolutePath:/iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783 dataId:103182993 specColType:NORMAL objectType:COLLECTION collectionPath: objectPath: checksum: ownerName:de-irods ownerZone:iplant objSize:0 cacheDir: cacheDirty:false createdAt:replNumber:0Thu Mar 06 15:23:02 MST 2014 modifiedAt:Thu Mar 06 15:23:02 MST 2014 [main] INFO connection.IRODSCommands - calling irods function with byte array [main] INFO connection.IRODSCommands - reading message from irods ================================================================================ env: {"clientUserName" "sr320", "irodsAuthFileName" "./.irods/.irodsA", "irodsEnvFile" "./.irods/.irodsEnv"} command: /usr/local2/icommands/iget -f -P /iplant/home/sr320/Cgigas_v9/Zhang/fastq/G3-2014-03-06-15-19-01.783/G3_2.fq ./ stdout: 0/1 - 0.00% of files done 0.000/5763.086 MB - 0.00% of file sizes done Processing G3_2.fq - 5763.086 MB 2014-03-06.16:28:49 G3_2.fq - 39.999/5763.086 MB - 0.69% done 2014-03-06.16:28:52 G3_2.fq - 639.985/5763.086 MB - 11.10% done 2014-03-06.16:29:07 G3_2.fq - 1279.971/5763.086 MB - 22.21% done 2014-03-06.16:29:21 G3_2.fq - 1959.955/5763.086 MB - 34.01% done 2014-03-06.16:29:34 G3_2.fq - 2599.940/5763.086 MB - 45.11% done 2014-03-06.16:29:45 G3_2.fq - 3279.925/5763.086 MB - 56.91% done 2014-03-06.16:30:04 G3_2.fq - 3879.911/5763.086 MB - 67.32% done 2014-03-06.16:30:18 G3_2.fq - 4639.894/5763.086 MB - 80.51% done 2014-03-06.16:30:31 G3_2.fq - 5240.484/5763.086 MB - 90.93% done 2014-03-06.16:30:42 G3_2.fq - 5240.685/5763.086 MB - 90.94% done 2014-03-06.16:30:42 G3_2.fq - 5763.086/5763.086 MB - 100.00% done 2014-03-06.16:30:53 [main] INFO connection.IRODSSession - closing all irods sessions [main] INFO connection.IRODSCommands - closing connection [main] INFO connection.IRODSCommands - shutdown()...check if executor service is running for reconnect [main] INFO connection.IRODSCommands - shutting down, need to send disconnect to irods [main] INFO connection.IRODSCommands - sending disconnect message [main] INFO connection.IRODSConnection - shutting down connection: true [main] INFO connection.IRODSConnection - is connected for : irodsSimpleConnection/main/1394148528746 [main] INFO connection.IRODSConnection - now disconnected