[AG-TECH] Problems uploading files

Christoph Willing c.willing at uq.edu.au
Tue Apr 27 19:08:10 CDT 2010


Sorry, the output of a _successful_ upload which  I sent previously  
was incomplete. Here's the complete transaction:

04/28/10 09:57:58 -1245000816 FTPSServer     ftps_server.py:338 INFO   
Connection from 130.102.78.192:53807
04/28/10 09:57:58 -1245000816 FTPSServer     ftps_server.py:271 INFO   
==> 220 vv3 M2Crypto (Medusa) FTP/TLS server v0.18 ready.
04/28/10 09:57:58 -1245000816 FTPSServer     ftps_server.py:271 INFO   
<== AUTH TLS
04/28/10 09:57:58 -1245000816 FTPSServer     ftps_server.py:271 INFO   
==> 234 AUTH TLS successful
04/28/10 09:57:58 -1245000816 FTPSServer     ftps_server.py:271 INFO   
<== PBSZ 0
04/28/10 09:57:58 -1245000816 FTPSServer     ftps_server.py:271 INFO   
==> 200 PBSZ=0 successful.
04/28/10 09:57:58 -1245000816 FTPSServer     ftps_server.py:271 INFO   
<== PROT P
04/28/10 09:57:58 -1245000816 FTPSServer     ftps_server.py:271 INFO   
==> 200 Protection set to Private
04/28/10 09:57:58 -1245000816 FTPSServer     ftps_server.py:271 INFO   
<== USER 0a0101d80c2020bf185599cb7beea8bb
04/28/10 09:57:58 -1245000816 FTPSServer     ftps_server.py:271 INFO   
==> 331 Password required.
04/28/10 09:57:58 -1245000816 FTPSServer     ftps_server.py:271 INFO   
<== PASS <password>
04/28/10 09:57:58 -1245000816 VenueServer     VenueServer.py:432 INFO   
in authorizeDataTransferCB  
<AccessGrid.FTPS.ftps_server.ftp_tls_channel connected  
130.102.78.192:53807 at 0x907eb8c> 0a0101d80c2020bf18
5599cb7beea8bb 82664eb24cd2202bad54cf1e46bb0501
04/28/10 09:57:58 -1245000816 VenueServer     VenueServer.py:458 INFO   
authorizeDataTransferCB: user in venue, authorized Jaunty64 Test to  
transfer files to venue Test Room
04/28/10 09:57:58 -1245000816 FTPSServer     ftps_server.py:271 INFO   
==> 230 Ok.
04/28/10 09:57:58 -1245000816 FTPSServer     ftps_server.py:275 INFO   
Successful login: Filesystem=<unix-style fs root:Data wd:/>
04/28/10 09:57:58 -1245000816 FTPSServer     ftps_server.py:271 INFO   
<== cwd /0a0101d80c2020bf185599cb7beea8bb
04/28/10 09:57:58 -1245000816 FTPSServer     ftps_server.py:271 INFO   
==> 250 CWD command successful.
04/28/10 09:57:58 -1245000816 FTPSServer     ftps_server.py:271 INFO   
<== TYPE I
04/28/10 09:57:58 -1245000816 FTPSServer     ftps_server.py:271 INFO   
==> 200 Type set to Binary.
04/28/10 09:57:58 -1245000816 FTPSServer     ftps_server.py:271 INFO   
<== PASV
04/28/10 09:57:58 -1245000816 FTPSServer     ftps_server.py:271 INFO   
==> 227 Entering Passive Mode (130,102,78,178,195,93)
04/28/10 09:57:58 -1245000816 FTPSServer     ftps_server.py:271 INFO   
<== stor killall.diff
04/28/10 09:57:58 -1245000816 FTPSServer     ftps_server.py:271 INFO   
==> 150 Opening Binary connection for killall.diff
04/28/10 09:57:58 -1245000816 FTPSServer     ftps_server.py:271 INFO   
==> 226 Transfer complete.
04/28/10 09:57:58 -1245000816 VenueServer     VenueServer.py:468 DEBUG  
dataActivityCB: command = RECV
04/28/10 09:57:58 -1245000816 VenueServer     VenueServer.py:469 INFO   
dataActivityCB: command = RECV
04/28/10 09:57:58 -1245000816 VenueServer     VenueServer.py:470 INFO   
dataActivityCB: line = Data/0a0101d80c2020bf185599cb7beea8bb/ 
killall.diff
04/28/10 09:57:58 -1245000816 VenueServer     VenueServer.py:474 DEBUG  
dataActivityCB: Pathpart is: Data
04/28/10 09:57:58 -1245000816 VenueServer     VenueServer.py:474 DEBUG  
dataActivityCB: Pathpart is: 0a0101d80c2020bf185599cb7beea8bb
04/28/10 09:57:58 -1245000816 VenueServer     VenueServer.py:474 DEBUG  
dataActivityCB: Pathpart is: killall.diff
04/28/10 09:57:58 -1245000816 VenueServer     VenueServer.py:486 DEBUG  
dataActivityCB: VenueID 0a0101d80c2020bf185599cb7beea8bb ; Filename:  
killall.diff
04/28/10 09:57:58 -1245000816 VenueServer     VenueServer.py:489 DEBUG  
dataActivityCB: Venue is: 0a0101d80c2020bf6aaa4d18fcbbdee7
04/28/10 09:57:58 -1245000816 VenueServer     VenueServer.py:489 DEBUG  
dataActivityCB: Venue is: 0a0101d80c0620949d2e08d15558b0bc
04/28/10 09:57:58 -1245000816 VenueServer     VenueServer.py:489 DEBUG  
dataActivityCB: Venue is: 0a0101d80c0a209f1c9d810227f4cc4b

[snip] all venues are inspected but omitted here for brevity ...

04/28/10 09:57:59 -1245000816 VenueServer     VenueServer.py:489 DEBUG  
dataActivityCB: Venue is: 82664ec0087e59823554e75b6a03e049
04/28/10 09:57:59 -1245000816 VenueServer     VenueServer.py:491 DEBUG  
dataActivityCB: Key existing? 1
04/28/10 09:57:59 -1245000816 DataStore     DataStore.py:796 DEBUG  
GetDownLoadDescriptor: Pathname is Data/0a0101d80c2020bf185599cb7beea8bb
04/28/10 09:57:59 -1245000816 DataStore     DataStore.py:797 DEBUG  
GetDownLoadDescriptor: Filename is killall.diff
04/28/10 09:57:59 -1245000816 DataStore     DataStore.py:801 DEBUG  
GetDownLoadDescriptor: Joined Path is Data/ 
0a0101d80c2020bf185599cb7beea8bb/killall.diff
04/28/10 09:57:59 -1245000816 FTPSServer     FTPSServer.py:104 DEBUG  
Entered FTPSServer.GetDownloadDescriptor
04/28/10 09:57:59 -1245000816 FTPSServer     FTPSServer.py:110 DEBUG    
descriptor = ftps://vv3.ap-accessgrid.org:8006/0a0101d80c2020bf185599cb7beea8bb/killall.diff
04/28/10 09:57:59 -1245000816 DataStore     DataStore.py:934 DEBUG  
AddFile: URL to download location is: ftps://vv3.ap-accessgrid.org:8006/0a0101d80c2020bf185599cb7beea8bb/killall.diff
04/28/10 09:57:59 -1245000816 DataStore     DataStore.py:935 DEBUG  
AddFile: Path to FTP location of file is: Data/ 
0a0101d80c2020bf185599cb7beea8bb/killall.diff
04/28/10 09:57:59 -1245000816 DataStore     DataStore.py:951 DEBUG  
AddFile: Determined parentID is: -1
04/28/10 09:57:59 -1245000816 DataStore     DataStore.py:961 DEBUG  
AddFile: URI is ftps://vv3.ap-accessgrid.org:8006/0a0101d80c2020bf185599cb7beea8bb/killall.diff
04/28/10 09:57:59 -1245000816 VenueServer     Venue.py:1859 DEBUG  
DataDescription value: DataDescription: {'status': 'present',  
'description': None, 'checksum': None, 'parentId': '-1', 'uri': 'ftps://vv3.ap
-accessgrid.org:8006/0a0101d80c2020bf185599cb7beea8bb/killall.diff',  
'name': 'killall.diff', 'lastModified': 'Wed, Apr 28, 2010, 09:57:59',  
'owner': '', 'hierarchyLevel': -2, 'objectType': 'File', 'type': N
one, 'id': '82664eb24cd2202bb7f27e7e11f0e457', 'size': 428}
04/28/10 09:57:59 -1245000816 FTPSServer     ftps_server.py:271 INFO   
<== QUIT
04/28/10 09:57:59 -1245000816 FTPSServer     ftps_server.py:271 INFO   
==> 221 Goodbye.



On 28/04/2010, at 7:11 AM, Christoph Willing wrote:

>
> On 28/04/2010, at 6:38 AM, Vine, Derek A wrote:
>
>> At least in my case, I connect to the venue locally from the venue  
>> server, I can upload files like expected.  Connecting from any  
>> other node will not allow upload of files, at least not "live".   
>> Sometimes after you try to upload a file and leave and come back  
>> the file is there.
>
>
> Derek,
>
> That looks like a network problem then, like when I was testing from  
> home and small file uploads were OK but large ones didn't seem to  
> work - it was just that big files took a lot longer to via the  
> relatively slow ADSL upload bandwidth.
>
>
> All,
>
> For comparison with previous log output, here's the server log  
> output of a successful upload:
[snip]

Christoph Willing                       +61 7 3365 8316
QCIF Access Grid Manager
University of Queensland



More information about the ag-tech mailing list