Start a new topic

550 HTTP Aborted error

av_tiuk @ Tue Jul 29 07:31:27 EEST 2014
Yesterday a user tried to upload a file (approx 266MB) to our FTP using the web interface. They tried twice, 10 or 11 minutes apart. Below I have pasted the log entries from the first attempt (with user names and IPs edited out). All we received on the server was a 240KB zip file with the correct name, but it was corrupt and couldn't be opened. Any thoughts on why this would occur? Currently running version 7.0.2_138. Thanks for any insight.

[code]07/28/2014 01:21:03 PM|[HTTP:5760::] WROTE: *150 Opening BINARY mode data connection. Ready to write file . "/INCOMING/Full Body Data.zip") S T O R*
07/28/2014 01:21:04 PM|[HTTP:5761:lookup:8080] Accepting connection from: :64346
07/28/2014 01:21:04 PM|[HTTP:5761::] READ: *POST /WebInterface/function/ HTTP/1.0*
07/28/2014 01:21:04 PM|[HTTP:5761::] READ: *X-Requested-With: XMLHttpRequest*
07/28/2014 01:21:04 PM|[HTTP:5761::] READ: *Referer: http://:8080/#/INCOMING/*
07/28/2014 01:21:04 PM|[HTTP:5761::] READ: *Host: :8080*
07/28/2014 01:21:04 PM|[HTTP:5761::] READ: *Via: 1.0 iprism_33866 (squid/3.0.STABLE19)*
07/28/2014 01:21:04 PM|[HTTP:5761::] READ: *X-Forwarded-For: *
07/28/2014 01:21:04 PM|[HTTP:5761::] READ: *command:getUploadStatus*
07/28/2014 01:21:04 PM|[HTTP:5761::] READ: *itemName:file_8HN7_SINGLE_FILE_POST*
07/28/2014 01:21:04 PM|[HTTP:5761::] READ: *c2f:MlDJ*
07/28/2014 01:21:04 PM|[HTTP:5761::] WROTE: *HTTP/1.1 200 OK*
07/28/2014 01:21:06 PM|[HTTP:5762:lookup:8080] Accepting connection from: :55080
07/28/2014 01:21:06 PM|[HTTP:5762::] READ: *POST /WebInterface/function/ HTTP/1.0*
07/28/2014 01:21:06 PM|[HTTP:5762::] READ: *X-Requested-With: XMLHttpRequest*
07/28/2014 01:21:06 PM|[HTTP:5762::] READ: *Referer: http://:8080/#/INCOMING/*
07/28/2014 01:21:06 PM|[HTTP:5762::] READ: *Host: :8080*
07/28/2014 01:21:06 PM|[HTTP:5762::] READ: *Via: 1.0 iprism_33866 (squid/3.0.STABLE19)*
07/28/2014 01:21:06 PM|[HTTP:5762::] READ: *X-Forwarded-For: *
07/28/2014 01:21:06 PM|[HTTP:5762::] READ: *command:getUploadStatus*
07/28/2014 01:21:06 PM|[HTTP:5762::] READ: *itemName:file_8HN7_SINGLE_FILE_POST*
07/28/2014 01:21:06 PM|[HTTP:5762::] READ: *c2f:MlDJ*
07/28/2014 01:21:06 PM|[HTTP:5762::] WROTE: *HTTP/1.1 200 OK*
07/28/2014 01:21:07 PM|[HTTP:5763:lookup:8080] Accepting connection from: :22319
07/28/2014 01:21:07 PM|[HTTP:5763::] READ: *POST /WebInterface/function/ HTTP/1.0*
07/28/2014 01:21:07 PM|[HTTP:5763::] READ: *X-Requested-With: XMLHttpRequest*
07/28/2014 01:21:07 PM|[HTTP:5763::] READ: *Referer: http://:8080/#/INCOMING/*
07/28/2014 01:21:07 PM|[HTTP:5763::] READ: *Host: :8080*
07/28/2014 01:21:07 PM|[HTTP:5763::] READ: *Via: 1.0 iprism_33866 (squid/3.0.STABLE19)*
07/28/2014 01:21:07 PM|[HTTP:5763::] READ: *X-Forwarded-For: *
07/28/2014 01:21:07 PM|[HTTP:5763::] READ: *command:getUploadStatus*
07/28/2014 01:21:07 PM|[HTTP:5763::] READ: *itemName:file_8HN7_SINGLE_FILE_POST*
07/28/2014 01:21:07 PM|[HTTP:5763::] READ: *c2f:MlDJ*
07/28/2014 01:21:07 PM|[HTTP:5763::] WROTE: *HTTP/1.1 200 OK*
07/28/2014 01:21:09 PM|[HTTP:5764:lookup:8080] Accepting connection from: :17685
07/28/2014 01:21:09 PM|[HTTP:5764::] READ: *POST /WebInterface/function/ HTTP/1.0*
07/28/2014 01:21:09 PM|[HTTP:5764::] READ: *X-Requested-With: XMLHttpRequest*
07/28/2014 01:21:09 PM|[HTTP:5764::] READ: *Referer: http://:8080/#/INCOMING/*
07/28/2014 01:21:09 PM|[HTTP:5764::] READ: *Host: :8080*
07/28/2014 01:21:09 PM|[HTTP:5764::] READ: *Via: 1.0 iprism_33866 (squid/3.0.STABLE19)*
07/28/2014 01:21:09 PM|[HTTP:5764::] READ: *X-Forwarded-For: *
07/28/2014 01:21:10 PM|[HTTP:5764::] READ: *command:getUploadStatus*
07/28/2014 01:21:10 PM|[HTTP:5764::] READ: *itemName:file_8HN7_SINGLE_FILE_POST*
07/28/2014 01:21:10 PM|[HTTP:5764::] READ: *c2f:MlDJ*
07/28/2014 01:21:10 PM|[HTTP:5764::] WROTE: *HTTP/1.1 200 OK*
07/28/2014 01:21:12 PM|[HTTP:5765:lookup:8080] Accepting connection from: :31250
07/28/2014 01:21:12 PM|[HTTP:5765::] READ: *POST /WebInterface/function/ HTTP/1.0*
07/28/2014 01:21:12 PM|[HTTP:5765::] READ: *X-Requested-With: XMLHttpRequest*
07/28/2014 01:21:12 PM|[HTTP:5765::] READ: *Referer: http://:8080/#/INCOMING/*
07/28/2014 01:21:12 PM|[HTTP:5765::] READ: *Host: :8080*
07/28/2014 01:21:12 PM|[HTTP:5765::] READ: *Via: 1.0 iprism_33866 (squid/3.0.STABLE19)*
07/28/2014 01:21:12 PM|[HTTP:5765::] READ: *X-Forwarded-For: *
07/28/2014 01:21:12 PM|[HTTP:5765::] READ: *command:getUploadStatus*
07/28/2014 01:21:12 PM|[HTTP:5765::] READ: *itemName:file_8HN7_SINGLE_FILE_POST*
07/28/2014 01:21:12 PM|[HTTP:5765::] READ: *c2f:MlDJ*
07/28/2014 01:21:12 PM|[HTTP:5765::] WROTE: *HTTP/1.1 200 OK*
07/28/2014 01:21:21 PM|[HTTP:5766:lookup:8080] Accepting connection from: :49962
07/28/2014 01:21:24 PM|[5760::] WROTE: Error with files (path):/INCOMING/
07/28/2014 01:21:24 PM|[5760::] WROTE: Error with files (name):Full Body Data.zip
07/28/2014 01:21:24 PM|[HTTP:5760::] WROTE: *550 HTTP Aborted ("/INCOMING/Full Body Data.zip") STOR*
07/28/2014 01:21:24 PM|[5760::] WROTE: Error:java.lang.Exception: HTTP Aborted
07/28/2014 01:21:24 PM|[HTTP:5760::] WROTE: *HTTP/1.1 200 OK*
07/28/2014 01:21:24 PM|[HTTP:5760::] WROTE: *Success*[/code]

spinkb @ Tue Jul 29 07:47:56 EEST 2014
It looks like they started a second upload overwriting the file, probably realized their mistake and closed the browser window or cancelled it quick hoping nothing had been overwritten...

Thanks,
Ben
av_tiuk @ Tue Jul 29 07:55:01 EEST 2014
That sounds possible. Would you mind taking a look at the second attempt? I could see it happening once, but I would think on the second try they wouldn't have made the same mistake.

[code]07/28/2014 01:32:09 PM|[HTTP:6016::] WROTE: *150 Opening BINARY mode data connection. Ready to write file . "/INCOMING/Full Body Data.zip") S T O R*
07/28/2014 01:32:10 PM|[HTTP:6017:lookup:8080] Accepting connection from: :45462
07/28/2014 01:32:10 PM|[HTTP:6017::] READ: *POST /WebInterface/function/ HTTP/1.0*
07/28/2014 01:32:10 PM|[HTTP:6017::] READ: *X-Requested-With: XMLHttpRequest*
07/28/2014 01:32:10 PM|[HTTP:6017::] READ: *Referer: http://:8080/#/INCOMING/*
07/28/2014 01:32:10 PM|[HTTP:6017::] READ: *Host: :8080*
07/28/2014 01:32:10 PM|[HTTP:6017::] READ: *Via: 1.0 iprism_33866 (squid/3.0.STABLE19)*
07/28/2014 01:32:10 PM|[HTTP:6017::] READ: *X-Forwarded-For: *
07/28/2014 01:32:10 PM|[HTTP:6017::] READ: *command:getUploadStatus*
07/28/2014 01:32:10 PM|[HTTP:6017::] READ: *itemName:file_j66x_SINGLE_FILE_POST*
07/28/2014 01:32:10 PM|[HTTP:6017::] READ: *c2f:MlDJ*
07/28/2014 01:32:10 PM|[HTTP:6017::] WROTE: *HTTP/1.1 200 OK*
07/28/2014 01:32:12 PM|[HTTP:6018:lookup:8080] Accepting connection from: :42812
07/28/2014 01:32:12 PM|[HTTP:6018::] READ: *POST /WebInterface/function/ HTTP/1.0*
07/28/2014 01:32:12 PM|[HTTP:6018::] READ: *X-Requested-With: XMLHttpRequest*
07/28/2014 01:32:12 PM|[HTTP:6018::] READ: *Referer: http://:8080/#/INCOMING/*
07/28/2014 01:32:12 PM|[HTTP:6018::] READ: *Host: :8080*
07/28/2014 01:32:12 PM|[HTTP:6018::] READ: *Via: 1.0 iprism_33866 (squid/3.0.STABLE19)*
07/28/2014 01:32:12 PM|[HTTP:6018::] READ: *X-Forwarded-For: *
07/28/2014 01:32:12 PM|[HTTP:6018::] READ: *command:getUploadStatus*
07/28/2014 01:32:12 PM|[HTTP:6018::] READ: *itemName:file_j66x_SINGLE_FILE_POST*
07/28/2014 01:32:12 PM|[HTTP:6018::] READ: *c2f:MlDJ*
07/28/2014 01:32:12 PM|[HTTP:6018::] WROTE: *HTTP/1.1 200 OK*
07/28/2014 01:32:14 PM|[HTTP:6019:lookup:8080] Accepting connection from: :41049
07/28/2014 01:32:14 PM|[HTTP:6019::] READ: *POST /WebInterface/function/ HTTP/1.0*
07/28/2014 01:32:14 PM|[HTTP:6019::] READ: *X-Requested-With: XMLHttpRequest*
07/28/2014 01:32:14 PM|[HTTP:6019::] READ: *Referer: http://:8080/#/INCOMING/*
07/28/2014 01:32:14 PM|[HTTP:6019::] READ: *Host: :8080*
07/28/2014 01:32:14 PM|[HTTP:6019::] READ: *Via: 1.0 iprism_33866 (squid/3.0.STABLE19)*
07/28/2014 01:32:14 PM|[HTTP:6019::] READ: *X-Forwarded-For: *
07/28/2014 01:32:14 PM|[HTTP:6019::] READ: *command:getUploadStatus*
07/28/2014 01:32:14 PM|[HTTP:6019::] READ: *itemName:file_j66x_SINGLE_FILE_POST*
07/28/2014 01:32:14 PM|[HTTP:6019::] READ: *c2f:MlDJ*
07/28/2014 01:32:14 PM|[HTTP:6019::] WROTE: *HTTP/1.1 200 OK*
07/28/2014 01:32:15 PM|[HTTP:6020:lookup:8080] Accepting connection from: :50450
07/28/2014 01:32:15 PM|[HTTP:6020::] READ: *POST /WebInterface/function/ HTTP/1.0*
07/28/2014 01:32:15 PM|[HTTP:6020::] READ: *X-Requested-With: XMLHttpRequest*
07/28/2014 01:32:15 PM|[HTTP:6020::] READ: *Referer: http://:8080/#/INCOMING/*
07/28/2014 01:32:15 PM|[HTTP:6020::] READ: *Host: :8080*
07/28/2014 01:32:15 PM|[HTTP:6020::] READ: *Via: 1.0 iprism_33866 (squid/3.0.STABLE19)*
07/28/2014 01:32:15 PM|[HTTP:6020::] READ: *X-Forwarded-For: *
07/28/2014 01:32:15 PM|[HTTP:6020::] READ: *command:getUploadStatus*
07/28/2014 01:32:15 PM|[HTTP:6020::] READ: *itemName:file_j66x_SINGLE_FILE_POST*
07/28/2014 01:32:15 PM|[HTTP:6020::] READ: *c2f:MlDJ*
07/28/2014 01:32:15 PM|[HTTP:6020::] WROTE: *HTTP/1.1 200 OK*
07/28/2014 01:32:17 PM|[HTTP:6021:lookup:8080] Accepting connection from: :30583
07/28/2014 01:32:17 PM|[HTTP:6021::] READ: *POST /WebInterface/function/ HTTP/1.0*
07/28/2014 01:32:17 PM|[HTTP:6021::] READ: *X-Requested-With: XMLHttpRequest*
07/28/2014 01:32:17 PM|[HTTP:6021::] READ: *Referer: http://:8080/#/INCOMING/*
07/28/2014 01:32:17 PM|[HTTP:6021::] READ: *Host: :8080*
07/28/2014 01:32:17 PM|[HTTP:6021::] READ: *Via: 1.0 iprism_33866 (squid/3.0.STABLE19)*
07/28/2014 01:32:17 PM|[HTTP:6021::] READ: *X-Forwarded-For: *
07/28/2014 01:32:17 PM|[HTTP:6021::] READ: *command:getUploadStatus*
07/28/2014 01:32:17 PM|[HTTP:6021::] READ: *itemName:file_j66x_SINGLE_FILE_POST*
07/28/2014 01:32:17 PM|[HTTP:6021::] READ: *c2f:MlDJ*
07/28/2014 01:32:17 PM|[HTTP:6021::] WROTE: *HTTP/1.1 200 OK*
07/28/2014 01:32:18 PM|[HTTP:6022:lookup:8080] Accepting connection from: :22265
07/28/2014 01:32:18 PM|[HTTP:6022::] READ: *POST /WebInterface/function/ HTTP/1.0*
07/28/2014 01:32:18 PM|[HTTP:6022::] READ: *X-Requested-With: XMLHttpRequest*
07/28/2014 01:32:18 PM|[HTTP:6022::] READ: *Referer: http://:8080/#/INCOMING/*
07/28/2014 01:32:18 PM|[HTTP:6022::] READ: *Host: :8080*
07/28/2014 01:32:18 PM|[HTTP:6022::] READ: *Via: 1.0 iprism_33866 (squid/3.0.STABLE19)*
07/28/2014 01:32:18 PM|[HTTP:6022::] READ: *X-Forwarded-For: *
07/28/2014 01:32:18 PM|[HTTP:6022::] READ: *command:getUploadStatus*
07/28/2014 01:32:18 PM|[HTTP:6022::] READ: *itemName:file_j66x_SINGLE_FILE_POST*
07/28/2014 01:32:18 PM|[HTTP:6022::] READ: *c2f:MlDJ*
07/28/2014 01:32:18 PM|[HTTP:6022::] WROTE: *HTTP/1.1 200 OK*
07/28/2014 01:32:20 PM|[HTTP:6023:lookup:8080] Accepting connection from: :11506
07/28/2014 01:32:20 PM|[HTTP:6023::] READ: *POST /WebInterface/function/ HTTP/1.0*
07/28/2014 01:32:20 PM|[HTTP:6023::] READ: *X-Requested-With: XMLHttpRequest*
07/28/2014 01:32:20 PM|[HTTP:6023::] READ: *Referer: http://:8080/#/INCOMING/*
07/28/2014 01:32:20 PM|[HTTP:6023::] READ: *Host: :8080*
07/28/2014 01:32:20 PM|[HTTP:6023::] READ: *Via: 1.0 iprism_33866 (squid/3.0.STABLE19)*
07/28/2014 01:32:20 PM|[HTTP:6023::] READ: *X-Forwarded-For: *
07/28/2014 01:32:20 PM|[HTTP:6023::] READ: *command:getUploadStatus*
07/28/2014 01:32:20 PM|[HTTP:6023::] READ: *itemName:file_j66x_SINGLE_FILE_POST*
07/28/2014 01:32:20 PM|[HTTP:6023::] READ: *c2f:MlDJ*
07/28/2014 01:32:20 PM|[HTTP:6023::] WROTE: *HTTP/1.1 200 OK*
07/28/2014 01:32:29 PM|[6016::] WROTE: Error with files (path):/INCOMING/
07/28/2014 01:32:29 PM|[6016::] WROTE: Error with files (name):Full Body Data.zip
07/28/2014 01:32:29 PM|[HTTP:6016::] WROTE: *550 HTTP Aborted ("/INCOMING/Full Body Data.zip") STOR*
07/28/2014 01:32:29 PM|[6016::] WROTE: Error:java.lang.Exception: HTTP Aborted
07/28/2014 01:32:29 PM|[HTTP:6016::] WROTE: *HTTP/1.1 200 OK*
07/28/2014 01:32:29 PM|[HTTP:6016::] WROTE: *Success*[/code]
spinkb @ Tue Jul 29 08:00:07 EEST 2014
This one was there longer, but I think they still cancelled it by closing the browser, reloading, clicking cancel, etc.
av_tiuk @ Tue Jul 29 08:01:47 EEST 2014
Fair enough. Perhaps they got frustrated by our slow connection (5Mbps).

Thanks for your help.
Login to post a comment