<2016-06-30 01:53:50,083> <ConfigurationLoader:DEBUG> Loading configuration file :/com/agile/webfs/configuration/WebSecurity.properties
<2016-06-30 01:53:50,100> <ConfigurationLoader:DEBUG> Loading configuration file :/com/agile/webfs/configuration/XSS-MetaParameters.properties
<2016-06-30 01:53:50,117> <ECFSOpRequests:DEBUG> ECFSOpRequests.existFSOpReq(): false for token: {AES}EE40C83298B0979D884FA308CB7B32A28A886C47BE68ABE4F20C58C58F3982C0AA9E54838907E6EAE598E52CC10B03163F6E6E6F3C31BD4FC6ADB78B0FBA744777A69E50D5042A689A172855E062D03F6B2BB8F3B20B4BB615F5B855364986F9AEC45CA02DF85B3107FC5D8A68F5941DBAAE1907D9F63D9311476F59694D9C1D4E4AD56813F7B9
<2016-06-30 01:53:50,328> <AuthToken:DEBUG> excluded cookie name in webfs:
<2016-06-30 01:53:50,328> <AuthToken:DEBUG> included cookie name in webfs:
<2016-06-30 01:53:50,351> <BasicAuthStrategy:DEBUG> Authenticating User:cad1
<2016-06-30 01:53:50,353> <BasicAuthStrategy:DEBUG> http://agileserver.fr.oracle.com:8001/Agile/SSOAuthServlet
<2016-06-30 01:53:50,828> <HttpAuth:DEBUG> Got Form Authentication from Agile
<2016-06-30 01:53:50,830> <HttpAuth:DEBUG> Submit Form Authentication to Agile with username: cad1
<2016-06-30 01:53:50,843> <HttpAuth:DEBUG> Form authentication redirect to: http://agileserver.fr.oracle.com:8001/Agile/SSOAuthServlet
<2016-06-30 01:53:50,850> <HttpAuth:DEBUG> Redirect Connection succeeded
<2016-06-30 01:53:50,850> <BasicAuthStrategy:DEBUG> login successfully for user: cad1
<2016-06-30 01:53:50,851> <TimerUtil:DEBUG> Action:SecurityManager::isValid Time Taken:521 millis
<2016-06-30 01:53:50,852> <ECFSOpRequests:DEBUG> Create ECFSOpRequests for token: {AES}EE40C83298B0979D884FA308CB7B32A28A886C47BE68ABE4F20C58C58F3982C0AA9E54838907E6EAE598E52CC10B03163F6E6E6F3C31BD4FC6ADB78B0FBA744777A69E50D5042A689A172855E062D03F6B2BB8F3B20B4BB615F5B855364986F9AEC45CA02DF85B3107FC5D8A68F5941DBAAE1907D9F63D9311476F59694D9C1D4E4AD56813F7B9
Attempting to load ESAPI.properties via file I/O.
Attempting to load ESAPI.properties as resource file via file I/O.
Not found in 'org.owasp.esapi.resources' directory or file not readable: /app/agile/agilePLM/agile935/FileManager/bin/ESAPI.properties
Not found in SystemResource Directory/resourceDirectory: .esapi/ESAPI.properties
Not found in 'user.home' (/home/oracle) directory: /home/oracle/esapi/ESAPI.properties
Loading ESAPI.properties via file I/O failed. Exception was: java.io.FileNotFoundException
Attempting to load ESAPI.properties via the classpath.
SUCCESSFULLY LOADED ESAPI.properties via the CLASSPATH from 'esapi/' using current thread context class loader!
Attempting to load validation.properties via file I/O.
Attempting to load validation.properties as resource file via file I/O.
Not found in 'org.owasp.esapi.resources' directory or file not readable: /app/agile/agilePLM/agile935/FileManager/bin/validation.properties
Not found in SystemResource Directory/resourceDirectory: .esapi/validation.properties
Not found in 'user.home' (/home/oracle) directory: /home/oracle/esapi/validation.properties
Loading validation.properties via file I/O failed.
Attempting to load validation.properties via the classpath.
SUCCESSFULLY LOADED validation.properties via the CLASSPATH from 'esapi/' using current thread context class loader!
<2016-06-30 01:53:50,927> <CheckInServlet:DEBUG> Entering doPost => Vault: File Name:agileserver.fr.oracle.com_solidworks_preferences.xml File ID:null Redlined File ID:null Redline File Version :null Opcode=createFile
<2016-06-30 01:53:50,930> <CheckInServlet:DEBUG> Create New File Action
<2016-06-30 01:53:50,935> <FileServerDispatcher:DEBUG> Entering createNewFile =>Token:BASIC_AUTHENTICATION2:cad1 Vault:
<2016-06-30 01:53:50,937> <FMInformationStore:DEBUG> FileID satck is empty. Making remote call to get a stack of fileIDs
<2016-06-30 01:53:51,029> <WebServiceWrapper:DEBUG> Entering getFileIDs()
<2016-06-30 01:53:51,060> <WebServiceWrapper:DEBUG> Return an array of unique fileIDs of size :20
<2016-06-30 01:53:51,060> <FMInformationStore:INFO> Returning fileID :6937421
<2016-06-30 01:53:51,060> <IFSStructureManager:DEBUG> getPath => File ID:6937421.xml
<2016-06-30 01:53:51,061> <IFSStructureManager:DEBUG> Creating path:/data/agilevault/agileEC/93Files/000/069/374
<2016-06-30 01:53:51,061> <Vault:DEBUG> Leaving createNewFile
<2016-06-30 01:53:51,061> <TimerUtil:DEBUG> Action:Vault::createNewFile Time Taken:124 millis
<2016-06-30 01:53:51,061> <VaultManager:DEBUG> Leaving createNewFile => fileID :6937421
<2016-06-30 01:53:51,062> <FileServerDispatcher:INFO> Leaving createNewFile => File ID:6937421
<2016-06-30 01:53:51,062> <TimerUtil:DEBUG> Action:FileServerDispatcher::createNewFile Time Taken:127 millis
<2016-06-30 01:53:51,062> <CheckInServlet:INFO> New File ID:6937421
<2016-06-30 01:53:51,062> <CheckInServlet:DEBUG> Checkin Action Completed Successfully
<2016-06-30 01:53:51,081> <ECFSOpRequests:DEBUG> ECFSOpRequests.existFSOpReq(): true for token: {AES}EE40C83298B0979D884FA308CB7B32A28A886C47BE68ABE4F20C58C58F3982C0AA9E54838907E6EAE598E52CC10B03163F6E6E6F3C31BD4FC6ADB78B0FBA744777A69E50D5042A689A172855E062D03F6B2BB8F3B20B4BB615F5B855364986F9AEC45CA02DF85B3107FC5D8A68F5941DBAAE1907D9F63D9311476F59694D9C1D4E4AD56813F7B9
<2016-06-30 01:53:51,083> <CheckInServlet:DEBUG> Entering doPost => Vault: File Name:agileserver.fr.oracle.com_solidworks_preferences.xml File ID:6937421 Redlined File ID:null Redline File Version :null Opcode=chunkedCheckin
<2016-06-30 01:53:51,085> <CheckInServlet:DEBUG> chunkedCheckIn Action
<2016-06-30 01:53:51,085> <ECFSOpRequests:DEBUG> ECFSOpRequests.existFSOpReq(): true for token: {AES}EE40C83298B0979D884FA308CB7B32A28A886C47BE68ABE4F20C58C58F3982C0AA9E54838907E6EAE598E52CC10B03163F6E6E6F3C31BD4FC6ADB78B0FBA744777A69E50D5042A689A172855E062D03F6B2BB8F3B20B4BB615F5B855364986F9AEC45CA02DF85B3107FC5D8A68F5941DBAAE1907D9F63D9311476F59694D9C1D4E4AD56813F7B9
<2016-06-30 01:53:51,085> <FileServerDispatcher:INFO> Entering Checkin => Token: BASIC_AUTHENTICATION2:cad1 Vault: File Name: agileserver.fr.oracle.com_solidworks_preferences.xmlFileID :6937421
<2016-06-30 01:53:51,086> <VaultManager:INFO> Entering Chunked StreamIn => File Name:agileserver.fr.oracle.com_solidworks_preferences.xml Vault:File ID:6937421
<2016-06-30 01:53:51,086> <Vault:INFO> Entering chunkedStreamIn => filename :agileserver.fr.oracle.com_solidworks_preferences.xml Vault Type :Standard Vault : Primary Vault InputStream :is Not Null.
<2016-06-30 01:53:51,087> <Vault:INFO> Entering getFileObjForFileID => File ID:6937421 Vault Type :Standard Vault : Primary Vault
<2016-06-30 01:53:51,087> <Vault:INFO> Entering isChecksumValid => File ID:6937421 Vault Type :Standard Vault : Primary Vault
<2016-06-30 01:53:51,087> <FMInformationStore:INFO> Information not present on the cache, getting it from Agile system
<2016-06-30 01:53:51,220> <WebServiceWrapper:DEBUG> Entering lookup => File ID :6937421
<2016-06-30 01:53:51,248> <IFSStructureManager:DEBUG> getPath => File ID:6937421
<2016-06-30 01:53:51,250> <FMInformationStore:INFO> Adding file information fileID :6937421 EIFS filepath :null IFS filepath :000/069/374/agileec6937421.SLDPRT HFS filepath :null Locations :http://agileserver.fr.oracle.com:8080/Filemgr/services/FileServer File type :t/agileEC/93Files/000/069/374/agileec6937421.SLDPRTPersistence Level :1
<2016-06-30 01:53:51,251> <Vault:INFO> Checksum Enabled:false
<2016-06-30 01:53:51,251> <Vault:INFO> Leaving isChecksumValid : status :true
<2016-06-30 01:53:51,251> <TimerUtil:DEBUG> Action:Vault:: isChecksumValid Time Taken:164 millis
<2016-06-30 01:53:51,264> <Vault:INFO> Obtained handle to the exisiting file :/data/agilevault/agileEC/93Files/000/069/374/agileec6937421.SLDPRT
<2016-06-30 01:53:51,271> <Vault:INFO> Bytes transferred:61981
<2016-06-30 01:53:51,278> <EventDispatcher:DEBUG> Inside postCheckIn =>ServerContext:com.agile.webfs.components.security.ServerContext@4a1e5e4a File ID :6937421Checksum value :0 EIFS filepath :null IFS filepath :000/069/374/agileec6937421.SLDPRT HFS filepath :null Locations :http://agileserver.fr.oracle.com:8080/Filemgr/services/FileServer File type :xml
<2016-06-30 01:53:51,278> <Checksum:INFO> Checksum Enabled:false
<2016-06-30 01:53:51,282> <MetafileCacheInterceptor:INFO> Cannot generate thumbnail/streaming file for following reasons: - File Type is not in configured thumbnail/viewer file type: xml OR Thumbnail Pregeneration is disabled in System Preferences OR Vue Server details are missing in File Manager configuration.
<2016-06-30 01:53:51,282> <FMInformationStore:INFO> Adding file information fileID :6937421 EIFS filepath :null IFS filepath :000/069/374/agileec6937421.SLDPRT HFS filepath :null Locations :http://agileserver.fr.oracle.com:8080/Filemgr/services/FileServer File type :xmlPersistence Level :1
<2016-06-30 01:53:51,282> <TimerUtil:DEBUG> Action:Vault::chunkedStreamIn Time Taken:195 millis
<2016-06-30 01:53:51,282> <VaultManager:DEBUG> Leaving Chunked StreamIn
<2016-06-30 01:53:51,282> <FileServerDispatcher:INFO> Leaving Checkin
<2016-06-30 01:53:51,282> <TimerUtil:DEBUG> Action:FileServerDispatcher::checkIn Time Taken:197 millis
<2016-06-30 01:53:51,282> <CheckInServlet:DEBUG> Checkin Action Completed Successfully
<2016-06-30 01:53:53,716> <BasicAuthStrategy:DEBUG> Authenticating User:ifsuser
<2016-06-30 01:53:53,716> <BasicAuthStrategy:DEBUG> http://agileserver.fr.oracle.com:8001/Agile/SSOAuthServlet
<2016-06-30 01:53:53,742> <HttpAuth:DEBUG> Got Form Authentication from Agile
<2016-06-30 01:53:53,745> <HttpAuth:DEBUG> Submit Form Authentication to Agile with username: ifsuser
<2016-06-30 01:53:53,760> <HttpAuth:DEBUG> Form authentication redirect to: http://agileserver.fr.oracle.com:8001/Agile/SSOAuthServlet
<2016-06-30 01:53:53,767> <HttpAuth:DEBUG> Redirect Connection succeeded
<2016-06-30 01:53:53,767> <BasicAuthStrategy:DEBUG> login successfully for user: ifsuser
<2016-06-30 01:53:53,767> <TimerUtil:DEBUG> Action:SecurityManager::isValid Time Taken:53 millis
<2016-06-30 01:53:53,769> <CheckOutServlet:DEBUG> Compressing de-activated
<2016-06-30 01:53:53,769> <FileServerDispatcher:INFO> Entering Checkout => Token: BASIC_AUTHENTICATION:ifsuser Vault: File ID: 6871803
<2016-06-30 01:53:53,769> <FileServerDispatcher:DEBUG> Entering vaultLocator => Vault: File ID:6871803
<2016-06-30 01:53:53,769> <VaultManager:DEBUG> Entering valtLocator => Vault: File ID:6871803
<2016-06-30 01:53:53,769> <Vault:INFO> Entering fileExists => File ID:6871803 Vault Type :Standard Vault : Primary Vault
<2016-06-30 01:53:53,769> <FMInformationStore:INFO> Information not present on the cache, getting it from Agile system
<2016-06-30 01:53:53,884> <WebServiceWrapper:DEBUG> Entering lookup => File ID :6871803
<2016-06-30 01:53:53,913> <FMInformationStore:INFO> Persisting the information into the cache
<2016-06-30 01:53:53,913> <FMInformationStore:INFO> Adding file information fileID :6871803 EIFS filepath :null IFS filepath :000/068/718/agile6871803.xml HFS filepath :null Locations :http://agileserver.fr.oracle.com:8080/Filemgr/services/FileServer, File type :xmlPersistence Level :0
<2016-06-30 01:53:53,913> <Vault:INFO> File :/data/agilevault/agileEC/93Files/000/068/718/agile6871803.xml found on vault: Primary Vault
<2016-06-30 01:53:53,913> <TimerUtil:DEBUG> Action:Vault::fileExists Time Taken:144 millis
<2016-06-30 01:53:53,913> <TimerUtil:DEBUG> Action:VaultManager::vaultLocator Time Taken:144 millis
<2016-06-30 01:53:53,913> <FileServerDispatcher:DEBUG> Leaving vaultLocator => File found on:Primary Vault
<2016-06-30 01:53:53,914> <TimerUtil:DEBUG> Action:FileServerDispatcher::vaultLocator Time Taken:145 millis
<2016-06-30 01:53:53,914> <VaultManager:DEBUG> Entering streamOut => Vault: File ID:6871803
<2016-06-30 01:53:53,914> <Vault:INFO> Entering streamOut =>FileID:6871803 Vault Type :Standard Vault : Primary Vault
<2016-06-30 01:53:53,915> <Vault:DEBUG> Invoke pre checkout event
<2016-06-30 01:53:53,915> <EventDispatcher:DEBUG> Inside preCheckOut =>ServerContext:com.agile.webfs.components.security.ServerContext@86fba2aFile :/data/agilevault/agileEC/93Files/000/068/718/agile6871803.xml
<2016-06-30 01:53:53,916> <Checksum:INFO> Inside preCheckOut => File :/data/agilevault/agileEC/93Files/000/068/718/agile6871803.xml
<2016-06-30 01:53:53,916> <Checksum:INFO> Checksum Enabled:false
<2016-06-30 01:53:53,916> <Vault:INFO> Transmitting file :/data/agilevault/agileEC/93Files/000/068/718/agile6871803.xml
<2016-06-30 01:53:53,932> <Vault:INFO> Streamed 26254 bytes of date to client
<2016-06-30 01:53:53,932> <Vault:INFO> Notify event manager => postCheckOut()
<2016-06-30 01:53:53,932> <VaultManager:DEBUG> streamOut complete
<2016-06-30 01:53:53,932> <FileServerDispatcher:DEBUG> checkOut complete
<2016-06-30 01:53:53,932> <TimerUtil:DEBUG> Action:FileServerDispatcher::checkOut Time Taken:163 millis
<2016-06-30 01:54:47,066> <SSOToken:DEBUG> added cookie: Grids, Value: ATTACHTABLE_HISTORY#+aCfEIAAEda5C0aWf5C1bbwC2cFd5C3dUd5C4eOkwC5fFgwC6gFb7_ConstWidth]h+
<2016-06-30 01:54:47,066> <SSOToken:DEBUG> added cookie: CognosCookie, Value: e0FFU31DN0UxMkYzQUE5MkNBMTdGRkRDMzkyQzJBRTJGNUY0NzFBMUNDQTNDQ0RGNDEzMTgyQTFGOTNDMTBE
<2016-06-30 01:54:47,066> <SSOToken:DEBUG> added cookie: JSESSIONID, Value: ZAKgg_w0hdoXqWkXaCz4DbX6-h4ISc4UwRm6fSGfdA6XaQYIktfB!-516961402
<2016-06-30 01:54:47,066> <SSOToken:DEBUG> added cookie: 7topCreatePopupSize, Value: 570
<2016-06-30 01:54:47,066> <SSOToken:DEBUG> added cookie: 500, Value:
<2016-06-30 01:54:47,066> <SSOToken:DEBUG> added cookie: 26topCreatePopupSize, Value: 570
<2016-06-30 01:54:47,066> <SSOToken:DEBUG> added cookie: 500, Value:
<2016-06-30 01:54:47,066> <SSOToken:DEBUG> added cookie: s_nr, Value: 1466041745169
<2016-06-30 01:54:47,066> <SSOToken:DEBUG> added cookie: jsDebug, Value: 0
<2016-06-30 01:54:47,066> <SSOToken:DEBUG> added cookie: search_Type, Value: advancedSearch
<2016-06-30 01:54:47,066> <SSOToken:DEBUG> added cookie: invalidate_session, Value: false
<2016-06-30 01:54:47,066> <SSOToken:DEBUG> added cookie: j_username, Value: e0FFU31DN0UxMkYzQUE5MkNBMTdGRkRDMzkyQzJBRTJGNUY0NzFBMUNDQTNDQ0RGNDEzMTgyQTFGOTNDMTBE
<2016-06-30 01:54:47,066> <SSOToken:DEBUG> added cookie: j_password, Value: JSUle0FFU305Njg5NUU1NTg5NjA3Qjg2RDY5RjM2NTA0QTJCMjBEQjgzQTM1MkQ1RDg0QUY4OTIzMjQ4NEI4MEUzRUNFNDI4MDIyQURBOUY0NjVCMTdENkZDMTVGMjc5MzAwRjE3RDU3NUFERUUyMDI2Mjc5NkNFNEUwN0ZGQjU4QTM1ODNEQTM1MTNBM0Y5MTcxQzZEMzE2OTE1RkEwQzI1M0QJSUl
<2016-06-30 01:54:47,066> <SSOToken:DEBUG> added cookie: START_UPLOAD_IMMED, Value: 0
<2016-06-30 01:54:47,066> <SSOToken:DEBUG> added cookie: INCORP_UPLOAD_OBJECT, Value: 0
<2016-06-30 01:54:47,067> <SSOAuthStrategy:INFO> Authentication Servlet URL:http://agileserver.fr.oracle.com:8001/Agile/SSOAuthServlet
<2016-06-30 01:54:47,067> <SSOAuthStrategy:INFO> Inside SSO Authentication => Cookies:Grids=ATTACHTABLE_HISTORY#+aCfEIAAEda5C0aWf5C1bbwC2cFd5C3dUd5C4eOkwC5fFgwC6gFb7_ConstWidth]h+;CognosCookie=e0FFU31DN0UxMkYzQUE5MkNBMTdGRkRDMzkyQzJBRTJGNUY0NzFBMUNDQTNDQ0RGNDEzMTgyQTFGOTNDMTBE;JSESSIONID=ZAKgg_w0hdoXqWkXaCz4DbX6-h4ISc4UwRm6fSGfdA6XaQYIktfB!-516961402;7topCreatePopupSize=570;500=;26topCreatePopupSize=570;500=;s_nr=1466041745169;jsDebug=0;search_Type=advancedSearch;invalidate_session=false;j_username=e0FFU31DN0UxMkYzQUE5MkNBMTdGRkRDMzkyQzJBRTJGNUY0NzFBMUNDQTNDQ0RGNDEzMTgyQTFGOTNDMTBE;j_password=JSUle0FFU305Njg5NUU1NTg5NjA3Qjg2RDY5RjM2NTA0QTJCMjBEQjgzQTM1MkQ1RDg0QUY4OTIzMjQ4NEI4MEUzRUNFNDI4MDIyQURBOUY0NjVCMTdENkZDMTVGMjc5MzAwRjE3RDU3NUFERUUyMDI2Mjc5NkNFNEUwN0ZGQjU4QTM1ODNEQTM1MTNBM0Y5MTcxQzZEMzE2OTE1RkEwQzI1M0QJSUl;START_UPLOAD_IMMED=0;INCORP_UPLOAD_OBJECT=0
<2016-06-30 01:54:47,071> <AttachmentServlet:DEBUG> Request to the Attachment servlet
<2016-06-30 01:54:47,073> <AttachmentServlet:DEBUG> Downloading file
<2016-06-30 01:54:47,073> <AttachmentServlet:DEBUG> Request content is : com.agile.webfs.components.controller.AgileFSServletRequestWrapper@9698a84
<2016-06-30 01:54:47,081> <FileDownloadHandler:DEBUG> request for download if from file folder object
<2016-06-30 01:54:47,081> <FileDownloadHandler:DEBUG> request for the download of single file from the file folder context
<2016-06-30 01:54:47,081> <FileServerDispatcher:INFO> Entering FileExists => Vault: File ID:6937421
<2016-06-30 01:54:47,081> <FileServerDispatcher:DEBUG> Entering vaultLocator => Vault: File ID:6937421
<2016-06-30 01:54:47,081> <VaultManager:DEBUG> Entering valtLocator => Vault: File ID:6937421
<2016-06-30 01:54:47,081> <Vault:INFO> Entering fileExists => File ID:6937421 Vault Type :Standard Vault : Primary Vault
<2016-06-30 01:54:47,081> <Vault:INFO> File :/data/agilevault/agileEC/93Files/000/069/374/agileec6937421.SLDPRT found on vault: Primary Vault
<2016-06-30 01:54:47,081> <FileServerDispatcher:DEBUG> Leaving vaultLocator => File found on:Primary Vault
<2016-06-30 01:54:47,081> <FileServerDispatcher:DEBUG> Leaving fileExists => status:true
<2016-06-30 01:54:47,081> <FileDownloadHandler:INFO> isFileLocallyPresent: true
<2016-06-30 01:54:47,081> <FileDownloadHandler:INFO> creating request id
<2016-06-30 01:54:47,081> <FileDownloadHandler:INFO> CHECKING active downloads....!!!!!!!!!!!!!!!!!!!!!!!!!!!
<2016-06-30 01:54:47,081> <FMInformationStore:DEBUG> user active downloads is 0
<2016-06-30 01:54:47,082> <FSUtils:DEBUG> File operation UID satck is empty. Making remote call to get a stack of file op UIDs
<2016-06-30 01:54:47,155> <WebServiceWrapper:DEBUG> Entering getFileOpUIDs()()
<2016-06-30 01:54:47,238> <WebServiceWrapper:DEBUG> Return an array of unique fileoperation IDs of size :20
<2016-06-30 01:54:47,238> <FSUtils:INFO> Returning fileID :34497
<2016-06-30 01:54:47,242> <FMInformationStore:INFO> setting up map : 34497 6937421 0 cad1
<2016-06-30 01:54:47,242> <FileDownloadHandler:INFO> request id: 34497 user : cad1
<2016-06-30 01:54:47,242> <FileDownloadHandler:INFO> Entering preCheckOut =>FileID:6937421
<2016-06-30 01:54:47,243> <FileServerDispatcher:INFO> Entering getFileForFileID => Token: com.agile.webfs.components.security.client.SSOToken@22b8f0ed Vault: FileID: 6937421
<2016-06-30 01:54:47,243> <VaultManager:DEBUG> Entering getFileDescriptorForFileID => Vault:
<2016-06-30 01:54:47,243> <Vault:INFO> Entering fileExists => File ID:6937421 Vault Type :Standard Vault : Primary Vault
<2016-06-30 01:54:47,243> <Vault:INFO> File :/data/agilevault/agileEC/93Files/000/069/374/agileec6937421.SLDPRT found on vault: Primary Vault
<2016-06-30 01:54:47,243> <VaultManager:INFO> File located on Read-Write vault. Return the file object to that file
<2016-06-30 01:54:47,243> <Vault:INFO> Entering getFileForFileID => File ID:6937421 Vault Type :Standard Vault : Primary Vault
<2016-06-30 01:54:47,243> <Vault:INFO> Leaving getFileForFileID
<2016-06-30 01:54:47,243> <VaultManager:INFO> Leaving getFileDescriptorForFileID => fileID :agileec6937421.SLDPRT
<2016-06-30 01:54:47,243> <FileServerDispatcher:INFO> Leaving getFileForFileID => File ID: agileec6937421.SLDPRT
<2016-06-30 01:54:47,243> <FileDownloadHandler:INFO> Invoke pre checkout event
<2016-06-30 01:54:47,243> <EventDispatcher:DEBUG> Inside preCheckOut =>ServerContext:com.agile.webfs.components.security.ServerContext@6cccd7adFile :/data/agilevault/agileEC/93Files/000/069/374/agileec6937421.SLDPRT
<2016-06-30 01:54:47,243> <Checksum:INFO> Inside preCheckOut => File :/data/agilevault/agileEC/93Files/000/069/374/agileec6937421.SLDPRT
<2016-06-30 01:54:47,243> <Checksum:INFO> Checksum Enabled:false
redirecting to : http://agileserver.fr.oracle.com:8080/Filemgr/LFDownloadServlet?FSbdg=%7BAES%7DC8B46E943CEAB71B45FB0F66B01AB0746D534AA4A42004BE9DBF1C92380AC4C57E7DE053FAEFB3DF393FB3820477AF3F794E01691C71D1F8552EEE1ADBDDB6A508107FB3492306&requestId=34497
<2016-06-30 01:54:47,357> <FileDownloadHandler:INFO> redirecting to : http://agileserver.fr.oracle.com:8080/Filemgr/LFDownloadServlet?FSbdg=%7BAES%7DC8B46E943CEAB71B45FB0F66B01AB0746D534AA4A42004BE9DBF1C92380AC4C57E7DE053FAEFB3DF393FB3820477AF3F794E01691C71D1F8552EEE1ADBDDB6A508107FB3492306&requestId=34497
<2016-06-30 01:54:47,466> <SessionTicket:INFO> Inside validate => Ticket:agile9.22016-07-01 08 54 47
<2016-06-30 01:54:47,467> <SessionTicket:INFO> Decoded date:2016-07-01 08 54 47
<2016-06-30 01:54:47,470> <DownloadRangeServlet:INFO> Begin Download Request
<2016-06-30 01:54:47,470> <DownloadRangeServlet:INFO> validating Request id:34497--
<2016-06-30 01:54:47,471> <FMInformationStore:INFO> request found.. returning..
<2016-06-30 01:54:47,471> <DownloadRangeServlet:INFO> obtained download request obj:FileDownloadRequest : reqId:34497 req.file:preferences.xml req.fileId:6937421 req.downloadAttempts:10 req.user:cad1 req.st:0 req.isExpired:false
<2016-06-30 01:54:47,471> <DownloadRangeServlet:INFO> obtained file service
<2016-06-30 01:54:47,471> <FileServerDispatcher:INFO> Entering FileExists => Vault: File ID:6937421
<2016-06-30 01:54:47,471> <FileServerDispatcher:DEBUG> Entering vaultLocator => Vault: File ID:6937421
<2016-06-30 01:54:47,472> <VaultManager:DEBUG> Entering valtLocator => Vault: File ID:6937421
<2016-06-30 01:54:47,472> <Vault:INFO> Entering fileExists => File ID:6937421 Vault Type :Standard Vault : Primary Vault
<2016-06-30 01:54:47,472> <Vault:INFO> File :/data/agilevault/agileEC/93Files/000/069/374/agileec6937421.SLDPRT found on vault: Primary Vault
<2016-06-30 01:54:47,472> <FileServerDispatcher:DEBUG> Leaving vaultLocator => File found on:Primary Vault
<2016-06-30 01:54:47,472> <FileServerDispatcher:DEBUG> Leaving fileExists => status:true
<2016-06-30 01:54:47,472> <FileDownloadHandler:INFO> isFileLocallyPresent: true
<2016-06-30 01:54:47,473> <DownloadRangeServlet:INFO> getting file descriptor
<2016-06-30 01:54:47,473> <FileServerDispatcher:INFO> Entering getFileForFileID => Token: com.agile.webfs.components.security.client.ExpiringSessionToken@97621e5 Vault: FileID: 6937421
<2016-06-30 01:54:47,473> <VaultManager:DEBUG> Entering getFileDescriptorForFileID => Vault:
<2016-06-30 01:54:47,473> <Vault:INFO> Entering fileExists => File ID:6937421 Vault Type :Standard Vault : Primary Vault
<2016-06-30 01:54:47,473> <Vault:INFO> File :/data/agilevault/agileEC/93Files/000/069/374/agileec6937421.SLDPRT found on vault: Primary Vault
<2016-06-30 01:54:47,473> <VaultManager:INFO> File located on Read-Write vault. Return the file object to that file
<2016-06-30 01:54:47,473> <Vault:INFO> Entering getFileForFileID => File ID:6937421 Vault Type :Standard Vault : Primary Vault
<2016-06-30 01:54:47,473> <Vault:INFO> Leaving getFileForFileID
<2016-06-30 01:54:47,473> <VaultManager:INFO> Leaving getFileDescriptorForFileID => fileID :agileec6937421.SLDPRT
<2016-06-30 01:54:47,473> <FileServerDispatcher:INFO> Leaving getFileForFileID => File ID: agileec6937421.SLDPRT
<2016-06-30 01:54:47,473> <DownloadRangeServlet:INFO> range header : null
<2016-06-30 01:54:47,473> <DownloadRangeServlet:INFO> full file : true
<2016-06-30 01:54:47,474> <ConfigurationLoader:DEBUG> Loading configuration file :/com/agile/webfs/configuration/MIMETypes.properties
<2016-06-30 01:54:47,508> <DownloadRangeServlet:INFO> using etag : "34497"
<2016-06-30 01:54:47,510> <FMInformationStore:DEBUG> INCREMENTED active download count for user : cad1 is : 1
<2016-06-30 01:54:47,510> <DownloadRangeServlet:INFO> writing full file..
<2016-06-30 01:54:47,510> <DownloadRangeServlet:INFO> output stream : class org.apache.catalina.connector.CoyoteOutputStream
buffer file write time : 16
<2016-06-30 01:54:47,526> <DownloadRangeServlet:DEBUG> wrote end of file for full file request : 34497
<2016-06-30 01:54:47,526> <FMInformationStore:DEBUG> DECREMENTED active download count for user : cad1 is : 0