search

andresoviedo / google-drive-ftp-adapter

Google Drive FTP Adapter to connect to google drive through the FTP protocol
GNU Lesser General Public License v3.0
393 stars 93 forks source link

Lots of duplicated folders and failed uploads #8

Closed phrack closed 6 years ago

phrack commented 8 years ago

Hello, I currently have your software setup to backup snapshots and videos to Google Drive from security cameras that only support FTP. I am having two problems:

  1. Roughly half of the uploads fail.
  2. Nearly every upload attempt causes a new folder to be created on my Drive. From what I can piece together, successful upload = use existing folder, failed upload = new empty folder. This results in hundreds of empty folders being created per day.

Can you provide advice for debugging this? Would the log help?

One thing I see in the logs is that I get this message for every eventual empty folder:

2016-09-29 19:36:34,705 [pool-4-thread-1196] [GFtpServerFactory$FtpFileSystemView] [WARN ] File doesn't exist or is not a directory: 'FtpFileWrapper [absolutePath=/motion/20160929]'...

This is the adapter trying to open the day's folder and failing even though it does exist. Again, this failure seems to lead to the folder being created as an empty duplicate.

I get no error messages, just that warn message, and thousands of info messages that seem reasonable.

andresoviedo commented 8 years ago

Hi @phrack Is it possible for you to attach the chunk of the log file where you have detected the issue starts and ends so we can take a look at it? Thanks

phrack commented 8 years ago

Here is a large chunk of the log (nothing looks off to me aside from the warns and massive amount of duped folders):

2016-10-13 00:26:46,676 [pool-4-thread-3143] [LoggingFilter       ] [INFO ] SENT: 250 Directory changed to /motion/20161013

2016-10-13 00:26:46,678 [pool-4-thread-3141] [FtpLoggingFilter    ] [INFO ] RECEIVED: CWD 00
2016-10-13 00:26:46,679 [pool-4-thread-3143] [LoggingFilter       ] [INFO ] SENT: 250 Directory changed to /motion/20161013/00

2016-10-13 00:26:46,681 [pool-4-thread-3141] [FtpLoggingFilter    ] [INFO ] RECEIVED: EPSV
2016-10-13 00:26:46,682 [pool-4-thread-3143] [LoggingFilter       ] [INFO ] SENT: 229 Entering Passive Mode (|||44459|)

2016-10-13 00:26:46,692 [pool-4-thread-3141] [FtpLoggingFilter    ] [INFO ] RECEIVED: TYPE I
2016-10-13 00:26:46,692 [pool-4-thread-3143] [LoggingFilter       ] [INFO ] SENT: 200 Command TYPE okay.

2016-10-13 00:26:46,695 [pool-4-thread-3141] [FtpLoggingFilter    ] [INFO ] RECEIVED: STOR snapshot_20161013_002659D.jpg
2016-10-13 00:26:46,711 [pool-4-thread-3141] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-6873736639205413024.upload.snapshot_20161013_002659D.jpg'...
2016-10-13 00:26:47,408 [pool-4-thread-3141] [GoogleDrive         ] [INFO ] File created snapshot_20161013_002659D.jpg (0BxCrx_DTxpZcbFREY3lBS2U1czg)
2016-10-13 00:26:47,408 [pool-4-thread-3141] [FtpGdriveSynchService] [INFO ] Synching 0BxCrx_DTxpZcbFREY3lBS2U1czg...
2016-10-13 00:26:47,565 [pool-4-thread-3141] [STOR                ] [INFO ] File uploaded /motion/20161013/00/snapshot_20161013_002659D.jpg
2016-10-13 00:26:47,565 [pool-4-thread-3141] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-6873736639205413024.upload.snapshot_20161013_002659D.jpg'...
2016-10-13 00:26:47,644 [pool-4-thread-3142] [GoogleDrive         ] [INFO ] File created video_20161013_002655D.avi (0BxCrx_DTxpZcWHJfckJtd2VSZ0U)
2016-10-13 00:26:47,644 [pool-4-thread-3142] [FtpGdriveSynchService] [INFO ] Synching 0BxCrx_DTxpZcWHJfckJtd2VSZ0U...
2016-10-13 00:26:47,791 [pool-4-thread-3142] [STOR                ] [INFO ] File uploaded /motion/20161013/00/video_20161013_002655D.avi
2016-10-13 00:26:47,791 [pool-4-thread-3142] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-2096032721614404921.upload.video_20161013_002655D.avi'...
2016-10-13 00:26:48,683 [pool-4-thread-3141] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-6873736639205413024.upload.snapshot_20161013_002659D.jpg'...
2016-10-13 00:26:49,534 [pool-4-thread-3142] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-2096032721614404921.upload.video_20161013_002655D.avi'...
2016-10-13 00:26:49,797 [pool-4-thread-3141] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-6873736639205413024.upload.snapshot_20161013_002659D.jpg'...
2016-10-13 00:26:49,943 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Detected 2 changes
2016-10-13 00:26:49,943 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476332806920'
2016-10-13 00:26:49,972 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476332807108'
2016-10-13 00:26:50,002 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Largest changeId found in local database 108817
2016-10-13 00:26:50,613 [pool-4-thread-3142] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-2096032721614404921.upload.video_20161013_002655D.avi'...
2016-10-13 00:26:50,954 [pool-4-thread-3141] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-6873736639205413024.upload.snapshot_20161013_002659D.jpg'...
2016-10-13 00:26:51,093 [pool-4-thread-3141] [PassivePorts        ] [WARN ] Releasing unreserved passive port: 44459
2016-10-13 00:26:51,094 [pool-4-thread-3141] [LoggingFilter       ] [INFO ] SENT: 150 File status okay; about to open data connection.

2016-10-13 00:26:51,094 [pool-4-thread-3141] [LoggingFilter       ] [INFO ] SENT: 226 Transfer complete.

2016-10-13 00:26:51,097 [pool-4-thread-3143] [FtpLoggingFilter    ] [INFO ] RECEIVED: EPSV
2016-10-13 00:26:51,098 [pool-4-thread-3141] [LoggingFilter       ] [INFO ] SENT: 229 Entering Passive Mode (|||40359|)

2016-10-13 00:26:51,105 [pool-4-thread-3143] [FtpLoggingFilter    ] [INFO ] RECEIVED: STOR snapshot_20161013_002700D.jpg
2016-10-13 00:26:51,131 [pool-4-thread-3143] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-60892956336348460.upload.snapshot_20161013_002700D.jpg'...
2016-10-13 00:26:51,707 [pool-4-thread-3142] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-2096032721614404921.upload.video_20161013_002655D.avi'...
2016-10-13 00:26:51,817 [pool-4-thread-3142] [PassivePorts        ] [WARN ] Releasing unreserved passive port: 42223
2016-10-13 00:26:51,818 [pool-4-thread-3142] [LoggingFilter       ] [INFO ] SENT: 150 File status okay; about to open data connection.

2016-10-13 00:26:51,818 [pool-4-thread-3142] [LoggingFilter       ] [INFO ] SENT: 226 Transfer complete.

2016-10-13 00:26:51,890 [pool-4-thread-3143] [GoogleDrive         ] [INFO ] File created snapshot_20161013_002700D.jpg (0BxCrx_DTxpZcQmFpN3BNTWU1dkU)
2016-10-13 00:26:51,890 [pool-4-thread-3143] [FtpGdriveSynchService] [INFO ] Synching 0BxCrx_DTxpZcQmFpN3BNTWU1dkU...
2016-10-13 00:26:52,144 [pool-4-thread-3143] [STOR                ] [INFO ] File uploaded /motion/20161013/00/snapshot_20161013_002700D.jpg
2016-10-13 00:26:52,144 [pool-4-thread-3143] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-60892956336348460.upload.snapshot_20161013_002700D.jpg'...
2016-10-13 00:26:53,322 [pool-4-thread-3143] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-60892956336348460.upload.snapshot_20161013_002700D.jpg'...
2016-10-13 00:26:54,551 [pool-4-thread-3143] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-60892956336348460.upload.snapshot_20161013_002700D.jpg'...
2016-10-13 00:26:55,780 [pool-4-thread-3143] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-60892956336348460.upload.snapshot_20161013_002700D.jpg'...
2016-10-13 00:26:56,418 [pool-4-thread-3143] [PassivePorts        ] [WARN ] Releasing unreserved passive port: 40359
2016-10-13 00:26:56,418 [pool-4-thread-3143] [LoggingFilter       ] [INFO ] SENT: 150 File status okay; about to open data connection.

2016-10-13 00:26:56,418 [pool-4-thread-3143] [LoggingFilter       ] [INFO ] SENT: 226 Transfer complete.

2016-10-13 00:26:56,422 [pool-4-thread-3141] [FtpLoggingFilter    ] [INFO ] RECEIVED: EPSV
2016-10-13 00:26:56,422 [pool-4-thread-3142] [LoggingFilter       ] [INFO ] SENT: 229 Entering Passive Mode (|||33637|)

2016-10-13 00:26:56,429 [pool-4-thread-3143] [FtpLoggingFilter    ] [INFO ] RECEIVED: STOR snapshot_20161013_002701D.jpg
2016-10-13 00:26:56,451 [pool-4-thread-3143] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-1618840518381124373.upload.snapshot_20161013_002701D.jpg'...
2016-10-13 00:26:57,956 [pool-4-thread-3143] [GoogleDrive         ] [INFO ] File created snapshot_20161013_002701D.jpg (0BxCrx_DTxpZcSW9Dc1NZRmpMNXc)
2016-10-13 00:26:57,956 [pool-4-thread-3143] [FtpGdriveSynchService] [INFO ] Synching 0BxCrx_DTxpZcSW9Dc1NZRmpMNXc...
2016-10-13 00:26:58,099 [pool-4-thread-3143] [STOR                ] [INFO ] File uploaded /motion/20161013/00/snapshot_20161013_002701D.jpg
2016-10-13 00:26:58,099 [pool-4-thread-3143] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-1618840518381124373.upload.snapshot_20161013_002701D.jpg'...
2016-10-13 00:26:59,261 [pool-4-thread-3143] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-1618840518381124373.upload.snapshot_20161013_002701D.jpg'...
2016-10-13 00:27:00,030 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Detected 2 changes
2016-10-13 00:27:00,030 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476332811447'
2016-10-13 00:27:00,053 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476332816725'
2016-10-13 00:27:00,084 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Largest changeId found in local database 108822
2016-10-13 00:27:00,412 [pool-4-thread-3143] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-1618840518381124373.upload.snapshot_20161013_002701D.jpg'...
2016-10-13 00:27:01,644 [pool-4-thread-3143] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-1618840518381124373.upload.snapshot_20161013_002701D.jpg'...
2016-10-13 00:27:01,737 [pool-4-thread-3143] [PassivePorts        ] [WARN ] Releasing unreserved passive port: 33637
2016-10-13 00:27:01,737 [pool-4-thread-3143] [LoggingFilter       ] [INFO ] SENT: 150 File status okay; about to open data connection.

2016-10-13 00:27:01,737 [pool-4-thread-3143] [LoggingFilter       ] [INFO ] SENT: 226 Transfer complete.

2016-10-13 00:27:01,743 [pool-4-thread-3141] [FtpLoggingFilter    ] [INFO ] RECEIVED: EPSV
2016-10-13 00:27:01,744 [pool-4-thread-3142] [LoggingFilter       ] [INFO ] SENT: 229 Entering Passive Mode (|||36499|)

2016-10-13 00:27:01,750 [pool-4-thread-3143] [FtpLoggingFilter    ] [INFO ] RECEIVED: STOR snapshot_20161013_002702D.jpg
2016-10-13 00:27:01,889 [pool-4-thread-3143] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-8435849399824126150.upload.snapshot_20161013_002702D.jpg'...
2016-10-13 00:27:02,665 [pool-4-thread-3143] [GoogleDrive         ] [INFO ] File created snapshot_20161013_002702D.jpg (0BxCrx_DTxpZcQV8xSzNkdXNzMFU)
2016-10-13 00:27:02,665 [pool-4-thread-3143] [FtpGdriveSynchService] [INFO ] Synching 0BxCrx_DTxpZcQV8xSzNkdXNzMFU...
2016-10-13 00:27:02,808 [pool-4-thread-3143] [STOR                ] [INFO ] File uploaded /motion/20161013/00/snapshot_20161013_002702D.jpg
2016-10-13 00:27:02,808 [pool-4-thread-3143] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-8435849399824126150.upload.snapshot_20161013_002702D.jpg'...
2016-10-13 00:27:03,896 [pool-4-thread-3143] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-8435849399824126150.upload.snapshot_20161013_002702D.jpg'...
2016-10-13 00:27:05,201 [pool-4-thread-3143] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-8435849399824126150.upload.snapshot_20161013_002702D.jpg'...
2016-10-13 00:27:06,315 [pool-4-thread-3143] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-8435849399824126150.upload.snapshot_20161013_002702D.jpg'...
2016-10-13 00:27:06,555 [pool-4-thread-3143] [PassivePorts        ] [WARN ] Releasing unreserved passive port: 36499
2016-10-13 00:27:06,555 [pool-4-thread-3143] [LoggingFilter       ] [INFO ] SENT: 150 File status okay; about to open data connection.

2016-10-13 00:27:06,556 [pool-4-thread-3143] [LoggingFilter       ] [INFO ] SENT: 226 Transfer complete.

2016-10-13 00:27:06,559 [pool-4-thread-3141] [FtpLoggingFilter    ] [INFO ] RECEIVED: EPSV
2016-10-13 00:27:06,559 [pool-4-thread-3142] [LoggingFilter       ] [INFO ] SENT: 229 Entering Passive Mode (|||42003|)

2016-10-13 00:27:06,566 [pool-4-thread-3143] [FtpLoggingFilter    ] [INFO ] RECEIVED: STOR snapshot_20161013_002703D.jpg
2016-10-13 00:27:06,585 [pool-4-thread-3143] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-1176875304445630221.upload.snapshot_20161013_002703D.jpg'...
2016-10-13 00:27:07,273 [pool-4-thread-3143] [GoogleDrive         ] [INFO ] File created snapshot_20161013_002703D.jpg (0BxCrx_DTxpZcVGRiV1dtdWU2ZkU)
2016-10-13 00:27:07,274 [pool-4-thread-3143] [FtpGdriveSynchService] [INFO ] Synching 0BxCrx_DTxpZcVGRiV1dtdWU2ZkU...
2016-10-13 00:27:07,504 [pool-4-thread-3143] [STOR                ] [INFO ] File uploaded /motion/20161013/00/snapshot_20161013_002703D.jpg
2016-10-13 00:27:07,504 [pool-4-thread-3143] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-1176875304445630221.upload.snapshot_20161013_002703D.jpg'...
2016-10-13 00:27:09,194 [pool-4-thread-3143] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-1176875304445630221.upload.snapshot_20161013_002703D.jpg'...
2016-10-13 00:27:10,039 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Detected 3 changes
2016-10-13 00:27:10,039 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476332822149'
2016-10-13 00:27:10,061 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476332826851'
2016-10-13 00:27:10,087 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476332446096'
2016-10-13 00:27:10,115 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Largest changeId found in local database 108830
2016-10-13 00:27:10,302 [pool-4-thread-3143] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-1176875304445630221.upload.snapshot_20161013_002703D.jpg'...
2016-10-13 00:27:11,447 [pool-4-thread-3143] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-1176875304445630221.upload.snapshot_20161013_002703D.jpg'...
2016-10-13 00:27:11,454 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-5199505274428315082.upload.snapshot_20161013_002403D.jpg'...
2016-10-13 00:27:11,573 [pool-4-thread-3143] [PassivePorts        ] [WARN ] Releasing unreserved passive port: 42003
2016-10-13 00:27:11,574 [pool-4-thread-3143] [LoggingFilter       ] [INFO ] SENT: 150 File status okay; about to open data connection.

2016-10-13 00:27:11,574 [pool-4-thread-3143] [LoggingFilter       ] [INFO ] SENT: 226 Transfer complete.

2016-10-13 00:27:11,577 [pool-4-thread-3141] [FtpLoggingFilter    ] [INFO ] RECEIVED: EPSV
2016-10-13 00:27:11,577 [pool-4-thread-3142] [LoggingFilter       ] [INFO ] SENT: 229 Entering Passive Mode (|||42159|)

2016-10-13 00:27:11,586 [pool-4-thread-3143] [FtpLoggingFilter    ] [INFO ] RECEIVED: STOR snapshot_20161013_002704D.jpg
2016-10-13 00:27:11,605 [pool-4-thread-3143] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-9215906315923323188.upload.snapshot_20161013_002704D.jpg'...
2016-10-13 00:27:12,394 [pool-4-thread-3143] [GoogleDrive         ] [INFO ] File created snapshot_20161013_002704D.jpg (0BxCrx_DTxpZcN1Q0OXhST0tZWGM)
2016-10-13 00:27:12,394 [pool-4-thread-3143] [FtpGdriveSynchService] [INFO ] Synching 0BxCrx_DTxpZcN1Q0OXhST0tZWGM...
2016-10-13 00:27:12,621 [pool-4-thread-3143] [STOR                ] [INFO ] File uploaded /motion/20161013/00/snapshot_20161013_002704D.jpg
2016-10-13 00:27:12,621 [pool-4-thread-3143] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-9215906315923323188.upload.snapshot_20161013_002704D.jpg'...
2016-10-13 00:27:12,649 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-5199505274428315082.upload.snapshot_20161013_002403D.jpg'...
2016-10-13 00:27:13,702 [pool-4-thread-3143] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-9215906315923323188.upload.snapshot_20161013_002704D.jpg'...
2016-10-13 00:27:13,766 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-5199505274428315082.upload.snapshot_20161013_002403D.jpg'...
2016-10-13 00:27:14,826 [pool-4-thread-3143] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-9215906315923323188.upload.snapshot_20161013_002704D.jpg'...
2016-10-13 00:27:14,859 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-5199505274428315082.upload.snapshot_20161013_002403D.jpg'...
2016-10-13 00:27:14,959 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-8388608617054480399.upload.snapshot_20161013_002404D.jpg'...
2016-10-13 00:27:15,928 [pool-4-thread-3143] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-9215906315923323188.upload.snapshot_20161013_002704D.jpg'...
2016-10-13 00:27:16,079 [pool-4-thread-3143] [PassivePorts        ] [WARN ] Releasing unreserved passive port: 42159
2016-10-13 00:27:16,079 [pool-4-thread-3143] [LoggingFilter       ] [INFO ] SENT: 150 File status okay; about to open data connection.

2016-10-13 00:27:16,079 [pool-4-thread-3143] [LoggingFilter       ] [INFO ] SENT: 226 Transfer complete.

2016-10-13 00:27:16,083 [pool-4-thread-3141] [FtpLoggingFilter    ] [INFO ] RECEIVED: QUIT
2016-10-13 00:27:16,083 [pool-4-thread-3141] [LoggingFilter       ] [INFO ] SENT: 221 Goodbye.

2016-10-13 00:27:16,083 [pool-4-thread-3141] [LoggingFilter       ] [INFO ] CLOSED
2016-10-13 00:27:16,158 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-8388608617054480399.upload.snapshot_20161013_002404D.jpg'...
2016-10-13 00:27:17,244 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-8388608617054480399.upload.snapshot_20161013_002404D.jpg'...
2016-10-13 00:27:18,316 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-8388608617054480399.upload.snapshot_20161013_002404D.jpg'...
2016-10-13 00:27:18,537 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-6873736639205413024.upload.snapshot_20161013_002659D.jpg'...
2016-10-13 00:27:19,741 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-6873736639205413024.upload.snapshot_20161013_002659D.jpg'...
2016-10-13 00:27:19,946 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Detected 2 changes
2016-10-13 00:27:19,947 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476332831866'
2016-10-13 00:27:19,972 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476332025208'
2016-10-13 00:27:20,000 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Largest changeId found in local database 108838
2016-10-13 00:27:20,853 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-6873736639205413024.upload.snapshot_20161013_002659D.jpg'...
2016-10-13 00:27:21,934 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-6873736639205413024.upload.snapshot_20161013_002659D.jpg'...
2016-10-13 00:27:22,037 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-2096032721614404921.upload.video_20161013_002655D.avi'...
2016-10-13 00:27:23,132 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-2096032721614404921.upload.video_20161013_002655D.avi'...
2016-10-13 00:27:24,350 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-2096032721614404921.upload.video_20161013_002655D.avi'...
2016-10-13 00:27:25,452 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-2096032721614404921.upload.video_20161013_002655D.avi'...
2016-10-13 00:27:26,114 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-3242200277195375446.upload.snapshot_20161013_002400D.jpg'...
2016-10-13 00:27:27,319 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-3242200277195375446.upload.snapshot_20161013_002400D.jpg'...
2016-10-13 00:27:28,436 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-3242200277195375446.upload.snapshot_20161013_002400D.jpg'...
2016-10-13 00:27:29,553 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-3242200277195375446.upload.snapshot_20161013_002400D.jpg'...
2016-10-13 00:27:29,700 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-5776114295604028142.upload.snapshot_20161013_002401D.jpg'...
2016-10-13 00:27:30,007 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Detected 1 changes
2016-10-13 00:27:30,007 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476332025208'
2016-10-13 00:27:30,040 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Largest changeId found in local database 108839
2016-10-13 00:27:30,811 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-5776114295604028142.upload.snapshot_20161013_002401D.jpg'...
2016-10-13 00:27:31,930 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-5776114295604028142.upload.snapshot_20161013_002401D.jpg'...
2016-10-13 00:27:33,031 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-5776114295604028142.upload.snapshot_20161013_002401D.jpg'...
2016-10-13 00:27:33,180 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-5724392967549514996.upload.snapshot_20161013_002402D.jpg'...
2016-10-13 00:27:34,286 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-5724392967549514996.upload.snapshot_20161013_002402D.jpg'...
2016-10-13 00:27:35,511 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-5724392967549514996.upload.snapshot_20161013_002402D.jpg'...
2016-10-13 00:27:36,624 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-5724392967549514996.upload.snapshot_20161013_002402D.jpg'...
2016-10-13 00:27:36,764 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-8435849399824126150.upload.snapshot_20161013_002702D.jpg'...
2016-10-13 00:27:37,880 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-8435849399824126150.upload.snapshot_20161013_002702D.jpg'...
2016-10-13 00:27:39,095 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-8435849399824126150.upload.snapshot_20161013_002702D.jpg'...
2016-10-13 00:27:40,796 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-8435849399824126150.upload.snapshot_20161013_002702D.jpg'...
2016-10-13 00:27:40,888 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-1618840518381124373.upload.snapshot_20161013_002701D.jpg'...
2016-10-13 00:27:41,983 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-1618840518381124373.upload.snapshot_20161013_002701D.jpg'...
2016-10-13 00:27:43,191 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-1618840518381124373.upload.snapshot_20161013_002701D.jpg'...
2016-10-13 00:27:44,311 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-1618840518381124373.upload.snapshot_20161013_002701D.jpg'...
2016-10-13 00:27:44,408 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-60892956336348460.upload.snapshot_20161013_002700D.jpg'...
2016-10-13 00:27:45,649 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-60892956336348460.upload.snapshot_20161013_002700D.jpg'...
2016-10-13 00:27:46,746 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-60892956336348460.upload.snapshot_20161013_002700D.jpg'...
2016-10-13 00:27:47,902 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-60892956336348460.upload.snapshot_20161013_002700D.jpg'...
2016-10-13 00:27:50,078 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Detected 1 changes
2016-10-13 00:27:50,079 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476332807108'
2016-10-13 00:27:50,112 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Largest changeId found in local database 108840
2016-10-13 00:27:59,992 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Detected 1 changes
2016-10-13 00:27:59,993 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476332807108'
2016-10-13 00:28:00,021 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Largest changeId found in local database 108841
2016-10-13 00:28:10,045 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Detected 1 changes
2016-10-13 00:28:10,045 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476332807108'
2016-10-13 00:28:10,075 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Largest changeId found in local database 108842
2016-10-13 00:28:47,014 [NioProcessor-4 ] [LoggingFilter       ] [INFO ] CREATED
2016-10-13 00:28:47,015 [pool-4-thread-3144] [LoggingFilter       ] [INFO ] OPENED
2016-10-13 00:28:47,015 [pool-4-thread-3144] [LoggingFilter       ] [INFO ] SENT: 220 Service ready for new user.

2016-10-13 00:28:47,020 [pool-4-thread-3144] [FtpLoggingFilter    ] [INFO ] RECEIVED: USER phrack
2016-10-13 00:28:47,020 [pool-4-thread-3144] [LoggingFilter       ] [INFO ] SENT: 331 User name okay, need password for phrack.

2016-10-13 00:28:47,025 [pool-4-thread-3144] [FtpLoggingFilter    ] [INFO ] RECEIVED: PASS *****
2016-10-13 00:28:47,025 [pool-4-thread-3144] [GFtpServerFactory$FtpFileSystemView] [INFO ] Creating ftp view for user 'phrack'...
2016-10-13 00:28:47,025 [pool-4-thread-3144] [PASS                ] [INFO ] Login success - phrack
2016-10-13 00:28:47,025 [pool-4-thread-3144] [LoggingFilter       ] [INFO ] SENT: 230 User logged in, proceed.

2016-10-13 00:28:47,029 [pool-4-thread-3145] [FtpLoggingFilter    ] [INFO ] RECEIVED: PWD
2016-10-13 00:28:47,029 [pool-4-thread-3145] [GFtpServerFactory$FtpFileSystemView] [INFO ] Initializing ftp view...
2016-10-13 00:28:47,030 [pool-4-thread-3144] [LoggingFilter       ] [INFO ] SENT: 257 "/" is current directory.

2016-10-13 00:28:47,034 [pool-4-thread-3145] [FtpLoggingFilter    ] [INFO ] RECEIVED: CWD /
2016-10-13 00:28:47,034 [pool-4-thread-3144] [LoggingFilter       ] [INFO ] SENT: 250 Directory changed to /

2016-10-13 00:28:47,038 [pool-4-thread-3145] [FtpLoggingFilter    ] [INFO ] RECEIVED: CWD motion
2016-10-13 00:28:47,038 [pool-4-thread-3144] [LoggingFilter       ] [INFO ] SENT: 250 Directory changed to /motion

2016-10-13 00:28:47,043 [pool-4-thread-3145] [FtpLoggingFilter    ] [INFO ] RECEIVED: CWD 20161013
2016-10-13 00:28:47,043 [pool-4-thread-3144] [LoggingFilter       ] [INFO ] SENT: 250 Directory changed to /motion/20161013

2016-10-13 00:28:47,048 [pool-4-thread-3145] [FtpLoggingFilter    ] [INFO ] RECEIVED: CWD 00
2016-10-13 00:28:47,049 [pool-4-thread-3144] [LoggingFilter       ] [INFO ] SENT: 250 Directory changed to /motion/20161013/00

2016-10-13 00:28:47,053 [pool-4-thread-3145] [FtpLoggingFilter    ] [INFO ] RECEIVED: EPSV
2016-10-13 00:28:47,053 [pool-4-thread-3144] [LoggingFilter       ] [INFO ] SENT: 229 Entering Passive Mode (|||33475|)

2016-10-13 00:28:47,062 [pool-4-thread-3145] [FtpLoggingFilter    ] [INFO ] RECEIVED: TYPE I
2016-10-13 00:28:47,062 [pool-4-thread-3144] [LoggingFilter       ] [INFO ] SENT: 200 Command TYPE okay.

2016-10-13 00:28:47,065 [pool-4-thread-3145] [FtpLoggingFilter    ] [INFO ] RECEIVED: STOR snapshot_20161013_002900D.jpg
2016-10-13 00:28:47,089 [pool-4-thread-3145] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-4937536467559069700.upload.snapshot_20161013_002900D.jpg'...
2016-10-13 00:28:47,523 [pool-4-thread-3144] [FtpLoggingFilter    ] [INFO ] RECEIVED: EPSV
2016-10-13 00:28:47,523 [pool-4-thread-3144] [LoggingFilter       ] [INFO ] SENT: 229 Entering Passive Mode (|||46727|)

2016-10-13 00:28:47,530 [pool-4-thread-3144] [FtpLoggingFilter    ] [INFO ] RECEIVED: STOR video_20161013_002856D.avi
2016-10-13 00:28:47,748 [pool-4-thread-3145] [GoogleDrive         ] [INFO ] File created snapshot_20161013_002900D.jpg (0BxCrx_DTxpZcT2ltekJzeUQ3ZzQ)
2016-10-13 00:28:47,748 [pool-4-thread-3145] [FtpGdriveSynchService] [INFO ] Synching 0BxCrx_DTxpZcT2ltekJzeUQ3ZzQ...
2016-10-13 00:28:47,846 [pool-4-thread-3144] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-1947387884254323295.upload.video_20161013_002856D.avi'...
2016-10-13 00:28:47,873 [pool-4-thread-3145] [STOR                ] [INFO ] File uploaded /motion/20161013/00/snapshot_20161013_002900D.jpg
2016-10-13 00:28:47,873 [pool-4-thread-3145] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-4937536467559069700.upload.snapshot_20161013_002900D.jpg'...
2016-10-13 00:28:48,650 [pool-4-thread-3144] [GoogleDrive         ] [INFO ] File created video_20161013_002856D.avi (0BxCrx_DTxpZcQ2FCTzBHSUxvY00)
2016-10-13 00:28:48,650 [pool-4-thread-3144] [FtpGdriveSynchService] [INFO ] Synching 0BxCrx_DTxpZcQ2FCTzBHSUxvY00...
2016-10-13 00:28:48,878 [pool-4-thread-3144] [STOR                ] [INFO ] File uploaded /motion/20161013/00/video_20161013_002856D.avi
2016-10-13 00:28:48,878 [pool-4-thread-3144] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-1947387884254323295.upload.video_20161013_002856D.avi'...
2016-10-13 00:28:48,988 [pool-4-thread-3145] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-4937536467559069700.upload.snapshot_20161013_002900D.jpg'...
2016-10-13 00:28:49,982 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Detected 3 changes
2016-10-13 00:28:49,982 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476332807108'
2016-10-13 00:28:49,992 [pool-4-thread-3144] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-1947387884254323295.upload.video_20161013_002856D.avi'...
2016-10-13 00:28:50,020 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476332927315'
2016-10-13 00:28:50,045 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476332928207'
2016-10-13 00:28:50,075 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Largest changeId found in local database 108850
2016-10-13 00:28:50,673 [pool-4-thread-3145] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-4937536467559069700.upload.snapshot_20161013_002900D.jpg'...
2016-10-13 00:28:51,083 [pool-4-thread-3144] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-1947387884254323295.upload.video_20161013_002856D.avi'...
2016-10-13 00:28:51,902 [pool-4-thread-3145] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-4937536467559069700.upload.snapshot_20161013_002900D.jpg'...
2016-10-13 00:28:52,017 [pool-4-thread-3145] [PassivePorts        ] [WARN ] Releasing unreserved passive port: 33475
2016-10-13 00:28:52,017 [pool-4-thread-3145] [LoggingFilter       ] [INFO ] SENT: 150 File status okay; about to open data connection.

2016-10-13 00:28:52,018 [pool-4-thread-3145] [LoggingFilter       ] [INFO ] SENT: 226 Transfer complete.

2016-10-13 00:28:52,021 [pool-4-thread-3146] [FtpLoggingFilter    ] [INFO ] RECEIVED: EPSV
2016-10-13 00:28:52,022 [pool-4-thread-3145] [LoggingFilter       ] [INFO ] SENT: 229 Entering Passive Mode (|||36247|)

2016-10-13 00:28:52,032 [pool-4-thread-3146] [FtpLoggingFilter    ] [INFO ] RECEIVED: STOR snapshot_20161013_002901D.jpg
2016-10-13 00:28:52,049 [pool-4-thread-3146] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-1492694505203733714.upload.snapshot_20161013_002901D.jpg'...
2016-10-13 00:28:52,312 [pool-4-thread-3144] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-1947387884254323295.upload.video_20161013_002856D.avi'...
2016-10-13 00:28:52,389 [pool-4-thread-3144] [PassivePorts        ] [WARN ] Releasing unreserved passive port: 46727
2016-10-13 00:28:52,389 [pool-4-thread-3144] [LoggingFilter       ] [INFO ] SENT: 150 File status okay; about to open data connection.

2016-10-13 00:28:52,389 [pool-4-thread-3144] [LoggingFilter       ] [INFO ] SENT: 226 Transfer complete.

2016-10-13 00:28:52,746 [pool-4-thread-3146] [GoogleDrive         ] [INFO ] File created snapshot_20161013_002901D.jpg (0BxCrx_DTxpZcZ1BPNlJvcjAyWnc)
2016-10-13 00:28:52,746 [pool-4-thread-3146] [FtpGdriveSynchService] [INFO ] Synching 0BxCrx_DTxpZcZ1BPNlJvcjAyWnc...
2016-10-13 00:28:52,888 [pool-4-thread-3146] [STOR                ] [INFO ] File uploaded /motion/20161013/00/snapshot_20161013_002901D.jpg
2016-10-13 00:28:52,888 [pool-4-thread-3146] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-1492694505203733714.upload.snapshot_20161013_002901D.jpg'...
2016-10-13 00:28:54,053 [pool-4-thread-3146] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-1492694505203733714.upload.snapshot_20161013_002901D.jpg'...
2016-10-13 00:28:55,147 [pool-4-thread-3146] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-1492694505203733714.upload.snapshot_20161013_002901D.jpg'...
2016-10-13 00:28:56,305 [pool-4-thread-3146] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-1492694505203733714.upload.snapshot_20161013_002901D.jpg'...
2016-10-13 00:28:56,387 [pool-4-thread-3146] [PassivePorts        ] [WARN ] Releasing unreserved passive port: 36247
2016-10-13 00:28:56,388 [pool-4-thread-3146] [LoggingFilter       ] [INFO ] SENT: 150 File status okay; about to open data connection.

2016-10-13 00:28:56,388 [pool-4-thread-3146] [LoggingFilter       ] [INFO ] SENT: 226 Transfer complete.

2016-10-13 00:28:56,391 [pool-4-thread-3145] [FtpLoggingFilter    ] [INFO ] RECEIVED: EPSV
2016-10-13 00:28:56,392 [pool-4-thread-3144] [LoggingFilter       ] [INFO ] SENT: 229 Entering Passive Mode (|||36597|)

2016-10-13 00:28:56,398 [pool-4-thread-3146] [FtpLoggingFilter    ] [INFO ] RECEIVED: STOR snapshot_20161013_002902D.jpg
2016-10-13 00:28:56,419 [pool-4-thread-3146] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-8899707206963115239.upload.snapshot_20161013_002902D.jpg'...
2016-10-13 00:28:57,149 [pool-4-thread-3146] [GoogleDrive         ] [INFO ] File created snapshot_20161013_002902D.jpg (0BxCrx_DTxpZcOXRTZWJEMWJodG8)
2016-10-13 00:28:57,150 [pool-4-thread-3146] [FtpGdriveSynchService] [INFO ] Synching 0BxCrx_DTxpZcOXRTZWJEMWJodG8...
2016-10-13 00:28:57,288 [pool-4-thread-3146] [STOR                ] [INFO ] File uploaded /motion/20161013/00/snapshot_20161013_002902D.jpg
2016-10-13 00:28:57,288 [pool-4-thread-3146] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-8899707206963115239.upload.snapshot_20161013_002902D.jpg'...
2016-10-13 00:28:58,968 [pool-4-thread-3146] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-8899707206963115239.upload.snapshot_20161013_002902D.jpg'...
2016-10-13 00:29:00,130 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Detected 2 changes
2016-10-13 00:29:00,131 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476332932250'
2016-10-13 00:29:00,155 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476332936607'
2016-10-13 00:29:00,186 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Largest changeId found in local database 108855
2016-10-13 00:29:00,264 [pool-4-thread-3146] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-8899707206963115239.upload.snapshot_20161013_002902D.jpg'...
2016-10-13 00:29:01,451 [pool-4-thread-3146] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-8899707206963115239.upload.snapshot_20161013_002902D.jpg'...
2016-10-13 00:29:01,596 [pool-4-thread-3146] [PassivePorts        ] [WARN ] Releasing unreserved passive port: 36597
2016-10-13 00:29:01,596 [pool-4-thread-3146] [LoggingFilter       ] [INFO ] SENT: 150 File status okay; about to open data connection.

2016-10-13 00:29:01,596 [pool-4-thread-3146] [LoggingFilter       ] [INFO ] SENT: 226 Transfer complete.

2016-10-13 00:29:01,605 [pool-4-thread-3145] [FtpLoggingFilter    ] [INFO ] RECEIVED: EPSV
2016-10-13 00:29:01,605 [pool-4-thread-3144] [LoggingFilter       ] [INFO ] SENT: 229 Entering Passive Mode (|||36111|)

2016-10-13 00:29:01,729 [pool-4-thread-3146] [FtpLoggingFilter    ] [INFO ] RECEIVED: STOR snapshot_20161013_002903D.jpg
2016-10-13 00:29:01,746 [pool-4-thread-3146] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-6039296623011012294.upload.snapshot_20161013_002903D.jpg'...
2016-10-13 00:29:02,781 [pool-4-thread-3146] [GoogleDrive         ] [INFO ] File created snapshot_20161013_002903D.jpg (0BxCrx_DTxpZcOGZxLWlBQXpRNjg)
2016-10-13 00:29:02,782 [pool-4-thread-3146] [FtpGdriveSynchService] [INFO ] Synching 0BxCrx_DTxpZcOGZxLWlBQXpRNjg...
2016-10-13 00:29:02,921 [pool-4-thread-3146] [STOR                ] [INFO ] File uploaded /motion/20161013/00/snapshot_20161013_002903D.jpg
2016-10-13 00:29:02,921 [pool-4-thread-3146] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-6039296623011012294.upload.snapshot_20161013_002903D.jpg'...
2016-10-13 00:29:04,191 [pool-4-thread-3146] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-6039296623011012294.upload.snapshot_20161013_002903D.jpg'...
2016-10-13 00:29:05,316 [pool-4-thread-3146] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-6039296623011012294.upload.snapshot_20161013_002903D.jpg'...
2016-10-13 00:29:06,420 [pool-4-thread-3146] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-6039296623011012294.upload.snapshot_20161013_002903D.jpg'...
2016-10-13 00:29:06,515 [pool-4-thread-3146] [PassivePorts        ] [WARN ] Releasing unreserved passive port: 36111
2016-10-13 00:29:06,516 [pool-4-thread-3146] [LoggingFilter       ] [INFO ] SENT: 150 File status okay; about to open data connection.

2016-10-13 00:29:06,516 [pool-4-thread-3146] [LoggingFilter       ] [INFO ] SENT: 226 Transfer complete.

2016-10-13 00:29:06,519 [pool-4-thread-3145] [FtpLoggingFilter    ] [INFO ] RECEIVED: EPSV
2016-10-13 00:29:06,520 [pool-4-thread-3144] [LoggingFilter       ] [INFO ] SENT: 229 Entering Passive Mode (|||37093|)

2016-10-13 00:29:06,526 [pool-4-thread-3146] [FtpLoggingFilter    ] [INFO ] RECEIVED: STOR snapshot_20161013_002904D.jpg
2016-10-13 00:29:06,543 [pool-4-thread-3146] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-3095298595232104774.upload.snapshot_20161013_002904D.jpg'...
2016-10-13 00:29:07,254 [pool-4-thread-3146] [GoogleDrive         ] [INFO ] File created snapshot_20161013_002904D.jpg (0BxCrx_DTxpZcYzdDWmJ3RHotU1k)
2016-10-13 00:29:07,255 [pool-4-thread-3146] [FtpGdriveSynchService] [INFO ] Synching 0BxCrx_DTxpZcYzdDWmJ3RHotU1k...
2016-10-13 00:29:07,444 [pool-4-thread-3146] [STOR                ] [INFO ] File uploaded /motion/20161013/00/snapshot_20161013_002904D.jpg
2016-10-13 00:29:07,444 [pool-4-thread-3146] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-3095298595232104774.upload.snapshot_20161013_002904D.jpg'...
2016-10-13 00:29:08,696 [pool-4-thread-3146] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-3095298595232104774.upload.snapshot_20161013_002904D.jpg'...
2016-10-13 00:29:09,785 [pool-4-thread-3146] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-3095298595232104774.upload.snapshot_20161013_002904D.jpg'...
2016-10-13 00:29:09,953 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Detected 2 changes
2016-10-13 00:29:09,953 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476332942084'
2016-10-13 00:29:09,977 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476332946799'
2016-10-13 00:29:10,008 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Largest changeId found in local database 108861
2016-10-13 00:29:10,949 [pool-4-thread-3146] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-3095298595232104774.upload.snapshot_20161013_002904D.jpg'...
2016-10-13 00:29:11,047 [pool-4-thread-3146] [PassivePorts        ] [WARN ] Releasing unreserved passive port: 37093
2016-10-13 00:29:11,048 [pool-4-thread-3146] [LoggingFilter       ] [INFO ] SENT: 150 File status okay; about to open data connection.

2016-10-13 00:29:11,048 [pool-4-thread-3146] [LoggingFilter       ] [INFO ] SENT: 226 Transfer complete.

2016-10-13 00:29:11,052 [pool-4-thread-3145] [FtpLoggingFilter    ] [INFO ] RECEIVED: EPSV
2016-10-13 00:29:11,053 [pool-4-thread-3144] [LoggingFilter       ] [INFO ] SENT: 229 Entering Passive Mode (|||37741|)

2016-10-13 00:29:11,059 [pool-4-thread-3146] [FtpLoggingFilter    ] [INFO ] RECEIVED: STOR snapshot_20161013_002905D.jpg
2016-10-13 00:29:11,081 [pool-4-thread-3146] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-2066005573444300351.upload.snapshot_20161013_002905D.jpg'...
2016-10-13 00:29:11,895 [pool-4-thread-3146] [GoogleDrive         ] [INFO ] File created snapshot_20161013_002905D.jpg (0BxCrx_DTxpZcSF9ITVQtaG9VWVE)
2016-10-13 00:29:11,895 [pool-4-thread-3146] [FtpGdriveSynchService] [INFO ] Synching 0BxCrx_DTxpZcSF9ITVQtaG9VWVE...
2016-10-13 00:29:12,124 [pool-4-thread-3146] [STOR                ] [INFO ] File uploaded /motion/20161013/00/snapshot_20161013_002905D.jpg
2016-10-13 00:29:12,124 [pool-4-thread-3146] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-2066005573444300351.upload.snapshot_20161013_002905D.jpg'...
2016-10-13 00:29:13,224 [pool-4-thread-3146] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-2066005573444300351.upload.snapshot_20161013_002905D.jpg'...
2016-10-13 00:29:14,331 [pool-4-thread-3146] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-2066005573444300351.upload.snapshot_20161013_002905D.jpg'...
2016-10-13 00:29:15,560 [pool-4-thread-3146] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-2066005573444300351.upload.snapshot_20161013_002905D.jpg'...
2016-10-13 00:29:15,787 [pool-4-thread-3146] [PassivePorts        ] [WARN ] Releasing unreserved passive port: 37741
2016-10-13 00:29:15,787 [pool-4-thread-3146] [LoggingFilter       ] [INFO ] SENT: 150 File status okay; about to open data connection.

2016-10-13 00:29:15,788 [pool-4-thread-3146] [LoggingFilter       ] [INFO ] SENT: 226 Transfer complete.

2016-10-13 00:29:15,790 [pool-4-thread-3145] [FtpLoggingFilter    ] [INFO ] RECEIVED: QUIT
2016-10-13 00:29:15,791 [pool-4-thread-3145] [LoggingFilter       ] [INFO ] SENT: 221 Goodbye.

2016-10-13 00:29:15,791 [pool-4-thread-3145] [LoggingFilter       ] [INFO ] CLOSED
2016-10-13 00:29:20,087 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Detected 1 changes
2016-10-13 00:29:20,088 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476332951403'
2016-10-13 00:29:20,122 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Largest changeId found in local database 108864
2016-10-13 00:29:40,056 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Detected 1 changes
2016-10-13 00:29:40,056 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476332627117'
2016-10-13 00:29:40,088 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Largest changeId found in local database 108866
2016-10-13 00:29:49,989 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Detected 2 changes
2016-10-13 00:29:49,990 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476332627117'
2016-10-13 00:29:50,020 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476332928207'
2016-10-13 00:29:50,048 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Largest changeId found in local database 108868
2016-10-13 00:30:00,023 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Detected 2 changes
2016-10-13 00:30:00,024 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476332627117'
2016-10-13 00:30:00,048 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476332928207'
2016-10-13 00:30:00,079 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Largest changeId found in local database 108872
2016-10-13 00:30:09,995 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Detected 1 changes
2016-10-13 00:30:09,995 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476332627117'
2016-10-13 00:30:10,024 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Largest changeId found in local database 108875
2016-10-13 00:30:20,094 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Detected 1 changes
2016-10-13 00:30:20,094 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476332807108'
2016-10-13 00:30:20,125 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Largest changeId found in local database 108876
2016-10-13 00:30:30,027 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Detected 1 changes
2016-10-13 00:30:30,027 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476332807108'
2016-10-13 00:30:30,056 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Largest changeId found in local database 108879
2016-10-13 00:30:40,062 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Detected 1 changes
2016-10-13 00:30:40,063 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476332807108'
2016-10-13 00:30:40,092 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Largest changeId found in local database 108881
2016-10-13 00:30:47,230 [pool-4-thread-3147] [FtpLoggingFilter    ] [INFO ] RECEIVED: EPSV
2016-10-13 00:30:47,230 [pool-4-thread-3147] [LoggingFilter       ] [INFO ] SENT: 229 Entering Passive Mode (|||36047|)

2016-10-13 00:30:47,239 [pool-4-thread-3147] [FtpLoggingFilter    ] [INFO ] RECEIVED: STOR video_20161013_003056D.avi
2016-10-13 00:30:47,345 [NioProcessor-1 ] [LoggingFilter       ] [INFO ] CREATED
2016-10-13 00:30:47,346 [pool-4-thread-3148] [LoggingFilter       ] [INFO ] OPENED
2016-10-13 00:30:47,346 [pool-4-thread-3148] [LoggingFilter       ] [INFO ] SENT: 220 Service ready for new user.

2016-10-13 00:30:47,359 [pool-4-thread-3148] [FtpLoggingFilter    ] [INFO ] RECEIVED: USER phrack
2016-10-13 00:30:47,360 [pool-4-thread-3148] [LoggingFilter       ] [INFO ] SENT: 331 User name okay, need password for phrack.

2016-10-13 00:30:47,391 [pool-4-thread-3148] [FtpLoggingFilter    ] [INFO ] RECEIVED: PASS *****
2016-10-13 00:30:47,391 [pool-4-thread-3148] [GFtpServerFactory$FtpFileSystemView] [INFO ] Creating ftp view for user 'phrack'...
2016-10-13 00:30:47,391 [pool-4-thread-3148] [PASS                ] [INFO ] Login success - phrack
2016-10-13 00:30:47,391 [pool-4-thread-3148] [LoggingFilter       ] [INFO ] SENT: 230 User logged in, proceed.

2016-10-13 00:30:47,411 [pool-4-thread-3148] [FtpLoggingFilter    ] [INFO ] RECEIVED: PWD
2016-10-13 00:30:47,411 [pool-4-thread-3148] [GFtpServerFactory$FtpFileSystemView] [INFO ] Initializing ftp view...
2016-10-13 00:30:47,412 [pool-4-thread-3149] [LoggingFilter       ] [INFO ] SENT: 257 "/" is current directory.

2016-10-13 00:30:47,438 [pool-4-thread-3148] [FtpLoggingFilter    ] [INFO ] RECEIVED: CWD /
2016-10-13 00:30:47,439 [pool-4-thread-3149] [LoggingFilter       ] [INFO ] SENT: 250 Directory changed to /

2016-10-13 00:30:47,458 [pool-4-thread-3148] [FtpLoggingFilter    ] [INFO ] RECEIVED: CWD motion
2016-10-13 00:30:47,458 [pool-4-thread-3149] [LoggingFilter       ] [INFO ] SENT: 250 Directory changed to /motion

2016-10-13 00:30:47,477 [pool-4-thread-3148] [FtpLoggingFilter    ] [INFO ] RECEIVED: CWD 20161013
2016-10-13 00:30:47,478 [pool-4-thread-3149] [LoggingFilter       ] [INFO ] SENT: 250 Directory changed to /motion/20161013

2016-10-13 00:30:47,503 [pool-4-thread-3148] [FtpLoggingFilter    ] [INFO ] RECEIVED: CWD 00
2016-10-13 00:30:47,504 [pool-4-thread-3149] [LoggingFilter       ] [INFO ] SENT: 250 Directory changed to /motion/20161013/00

2016-10-13 00:30:47,509 [pool-4-thread-3148] [FtpLoggingFilter    ] [INFO ] RECEIVED: EPSV
2016-10-13 00:30:47,510 [pool-4-thread-3149] [LoggingFilter       ] [INFO ] SENT: 229 Entering Passive Mode (|||45071|)

2016-10-13 00:30:47,553 [pool-4-thread-3148] [FtpLoggingFilter    ] [INFO ] RECEIVED: TYPE I
2016-10-13 00:30:47,553 [pool-4-thread-3149] [LoggingFilter       ] [INFO ] SENT: 200 Command TYPE okay.

2016-10-13 00:30:47,571 [pool-4-thread-3148] [FtpLoggingFilter    ] [INFO ] RECEIVED: STOR snapshot_20161013_003100D.jpg
2016-10-13 00:30:47,571 [pool-4-thread-3147] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-4491975191382048469.upload.video_20161013_003056D.avi'...
2016-10-13 00:30:47,596 [pool-4-thread-3148] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-7375254386767941621.upload.snapshot_20161013_003100D.jpg'...
2016-10-13 00:30:47,849 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-9215906315923323188.upload.snapshot_20161013_002704D.jpg'...
2016-10-13 00:30:48,444 [pool-4-thread-3147] [GoogleDrive         ] [INFO ] File created video_20161013_003056D.avi (0BxCrx_DTxpZcLWFrTERuU1llSlU)
2016-10-13 00:30:48,445 [pool-4-thread-3147] [FtpGdriveSynchService] [INFO ] Synching 0BxCrx_DTxpZcLWFrTERuU1llSlU...
2016-10-13 00:30:48,694 [pool-4-thread-3147] [STOR                ] [INFO ] File uploaded /motion/20161013/00/video_20161013_003056D.avi
2016-10-13 00:30:48,694 [pool-4-thread-3147] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-4491975191382048469.upload.video_20161013_003056D.avi'...
2016-10-13 00:30:48,971 [pool-4-thread-3148] [GoogleDrive         ] [INFO ] File created snapshot_20161013_003100D.jpg (0BxCrx_DTxpZcOUhvNzBocXlmNTA)
2016-10-13 00:30:48,971 [pool-4-thread-3148] [FtpGdriveSynchService] [INFO ] Synching 0BxCrx_DTxpZcOUhvNzBocXlmNTA...
2016-10-13 00:30:49,009 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-9215906315923323188.upload.snapshot_20161013_002704D.jpg'...
2016-10-13 00:30:49,123 [pool-4-thread-3148] [STOR                ] [INFO ] File uploaded /motion/20161013/00/snapshot_20161013_003100D.jpg
2016-10-13 00:30:49,123 [pool-4-thread-3148] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-7375254386767941621.upload.snapshot_20161013_003100D.jpg'...
2016-10-13 00:30:49,804 [pool-4-thread-3147] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-4491975191382048469.upload.video_20161013_003056D.avi'...
2016-10-13 00:30:49,916 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Detected 2 changes
2016-10-13 00:30:49,916 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476333048070'
2016-10-13 00:30:49,941 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476333048561'
2016-10-13 00:30:49,971 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Largest changeId found in local database 108887
2016-10-13 00:30:50,121 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-9215906315923323188.upload.snapshot_20161013_002704D.jpg'...
2016-10-13 00:30:50,790 [pool-4-thread-3148] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-7375254386767941621.upload.snapshot_20161013_003100D.jpg'...
2016-10-13 00:30:51,219 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-9215906315923323188.upload.snapshot_20161013_002704D.jpg'...
2016-10-13 00:30:51,332 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-1492694505203733714.upload.snapshot_20161013_002901D.jpg'...
2016-10-13 00:30:51,506 [pool-4-thread-3147] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-4491975191382048469.upload.video_20161013_003056D.avi'...
2016-10-13 00:30:52,018 [pool-4-thread-3148] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-7375254386767941621.upload.snapshot_20161013_003100D.jpg'...
2016-10-13 00:30:52,440 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-1492694505203733714.upload.snapshot_20161013_002901D.jpg'...
2016-10-13 00:30:52,617 [pool-4-thread-3147] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-4491975191382048469.upload.video_20161013_003056D.avi'...
2016-10-13 00:30:52,721 [pool-4-thread-3147] [PassivePorts        ] [WARN ] Releasing unreserved passive port: 36047
2016-10-13 00:30:52,721 [pool-4-thread-3147] [LoggingFilter       ] [INFO ] SENT: 150 File status okay; about to open data connection.

2016-10-13 00:30:52,721 [pool-4-thread-3147] [LoggingFilter       ] [INFO ] SENT: 226 Transfer complete.

2016-10-13 00:30:53,128 [pool-4-thread-3148] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-7375254386767941621.upload.snapshot_20161013_003100D.jpg'...
2016-10-13 00:30:53,239 [pool-4-thread-3148] [PassivePorts        ] [WARN ] Releasing unreserved passive port: 45071
2016-10-13 00:30:53,239 [pool-4-thread-3148] [LoggingFilter       ] [INFO ] SENT: 150 File status okay; about to open data connection.

2016-10-13 00:30:53,239 [pool-4-thread-3148] [LoggingFilter       ] [INFO ] SENT: 226 Transfer complete.

2016-10-13 00:30:53,242 [pool-4-thread-3149] [FtpLoggingFilter    ] [INFO ] RECEIVED: EPSV
2016-10-13 00:30:53,243 [pool-4-thread-3147] [LoggingFilter       ] [INFO ] SENT: 229 Entering Passive Mode (|||34325|)

2016-10-13 00:30:53,250 [pool-4-thread-3148] [FtpLoggingFilter    ] [INFO ] RECEIVED: STOR snapshot_20161013_003101D.jpg
2016-10-13 00:30:53,278 [pool-4-thread-3148] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-3704557260229225940.upload.snapshot_20161013_003101D.jpg'...
2016-10-13 00:30:53,620 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-1492694505203733714.upload.snapshot_20161013_002901D.jpg'...
2016-10-13 00:30:54,196 [pool-4-thread-3148] [GoogleDrive         ] [INFO ] File created snapshot_20161013_003101D.jpg (0BxCrx_DTxpZcZ2NSTmJ6aEhobDQ)
2016-10-13 00:30:54,196 [pool-4-thread-3148] [FtpGdriveSynchService] [INFO ] Synching 0BxCrx_DTxpZcZ2NSTmJ6aEhobDQ...
2016-10-13 00:30:54,336 [pool-4-thread-3148] [STOR                ] [INFO ] File uploaded /motion/20161013/00/snapshot_20161013_003101D.jpg
2016-10-13 00:30:54,336 [pool-4-thread-3148] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-3704557260229225940.upload.snapshot_20161013_003101D.jpg'...
2016-10-13 00:30:54,720 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-1492694505203733714.upload.snapshot_20161013_002901D.jpg'...
2016-10-13 00:30:54,801 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-1947387884254323295.upload.video_20161013_002856D.avi'...
2016-10-13 00:30:55,500 [pool-4-thread-3148] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-3704557260229225940.upload.snapshot_20161013_003101D.jpg'...
2016-10-13 00:30:55,881 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-1947387884254323295.upload.video_20161013_002856D.avi'...
2016-10-13 00:30:56,729 [pool-4-thread-3148] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-3704557260229225940.upload.snapshot_20161013_003101D.jpg'...
2016-10-13 00:30:56,963 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-1947387884254323295.upload.video_20161013_002856D.avi'...
2016-10-13 00:30:57,836 [pool-4-thread-3148] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-3704557260229225940.upload.snapshot_20161013_003101D.jpg'...
2016-10-13 00:30:58,265 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-1947387884254323295.upload.video_20161013_002856D.avi'...
2016-10-13 00:30:58,420 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-4937536467559069700.upload.snapshot_20161013_002900D.jpg'...
2016-10-13 00:30:58,570 [pool-4-thread-3148] [PassivePorts        ] [WARN ] Releasing unreserved passive port: 34325
2016-10-13 00:30:58,570 [pool-4-thread-3148] [LoggingFilter       ] [INFO ] SENT: 150 File status okay; about to open data connection.

2016-10-13 00:30:58,570 [pool-4-thread-3148] [LoggingFilter       ] [INFO ] SENT: 226 Transfer complete.

2016-10-13 00:30:58,575 [pool-4-thread-3149] [FtpLoggingFilter    ] [INFO ] RECEIVED: EPSV
2016-10-13 00:30:58,575 [pool-4-thread-3147] [LoggingFilter       ] [INFO ] SENT: 229 Entering Passive Mode (|||40695|)

2016-10-13 00:30:58,582 [pool-4-thread-3148] [FtpLoggingFilter    ] [INFO ] RECEIVED: STOR snapshot_20161013_003102D.jpg
2016-10-13 00:30:58,635 [pool-4-thread-3148] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-7616913076642285852.upload.snapshot_20161013_003102D.jpg'...
2016-10-13 00:30:59,570 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-4937536467559069700.upload.snapshot_20161013_002900D.jpg'...
2016-10-13 00:30:59,632 [pool-4-thread-3148] [GoogleDrive         ] [INFO ] File created snapshot_20161013_003102D.jpg (0BxCrx_DTxpZcczYwanl0WWtBRWM)
2016-10-13 00:30:59,632 [pool-4-thread-3148] [FtpGdriveSynchService] [INFO ] Synching 0BxCrx_DTxpZcczYwanl0WWtBRWM...
2016-10-13 00:30:59,801 [pool-4-thread-3148] [STOR                ] [INFO ] File uploaded /motion/20161013/00/snapshot_20161013_003102D.jpg
2016-10-13 00:30:59,801 [pool-4-thread-3148] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-7616913076642285852.upload.snapshot_20161013_003102D.jpg'...
2016-10-13 00:30:59,953 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Detected 3 changes
2016-10-13 00:30:59,953 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476333053590'
2016-10-13 00:30:59,977 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476332627117'
2016-10-13 00:31:00,003 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476333058919'
2016-10-13 00:31:00,032 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Largest changeId found in local database 108894
2016-10-13 00:31:00,774 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-4937536467559069700.upload.snapshot_20161013_002900D.jpg'...
2016-10-13 00:31:00,951 [pool-4-thread-3148] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-7616913076642285852.upload.snapshot_20161013_003102D.jpg'...
2016-10-13 00:31:02,004 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-4937536467559069700.upload.snapshot_20161013_002900D.jpg'...
2016-10-13 00:31:02,182 [pool-4-thread-3148] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-7616913076642285852.upload.snapshot_20161013_003102D.jpg'...
2016-10-13 00:31:02,234 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-2066005573444300351.upload.snapshot_20161013_002905D.jpg'...
2016-10-13 00:31:03,408 [pool-4-thread-3148] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-7616913076642285852.upload.snapshot_20161013_003102D.jpg'...
2016-10-13 00:31:03,408 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-2066005573444300351.upload.snapshot_20161013_002905D.jpg'...
2016-10-13 00:31:03,531 [pool-4-thread-3148] [PassivePorts        ] [WARN ] Releasing unreserved passive port: 40695
2016-10-13 00:31:03,531 [pool-4-thread-3148] [LoggingFilter       ] [INFO ] SENT: 150 File status okay; about to open data connection.

2016-10-13 00:31:03,531 [pool-4-thread-3148] [LoggingFilter       ] [INFO ] SENT: 226 Transfer complete.

2016-10-13 00:31:03,536 [pool-4-thread-3149] [FtpLoggingFilter    ] [INFO ] RECEIVED: EPSV
2016-10-13 00:31:03,537 [pool-4-thread-3147] [LoggingFilter       ] [INFO ] SENT: 229 Entering Passive Mode (|||45065|)

2016-10-13 00:31:03,543 [pool-4-thread-3148] [FtpLoggingFilter    ] [INFO ] RECEIVED: STOR snapshot_20161013_003103D.jpg
2016-10-13 00:31:03,584 [pool-4-thread-3148] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-5525538120414971542.upload.snapshot_20161013_003103D.jpg'...
2016-10-13 00:31:04,331 [pool-4-thread-3148] [GoogleDrive         ] [INFO ] File created snapshot_20161013_003103D.jpg (0BxCrx_DTxpZcZ0l3ZXdrVjkxdDA)
2016-10-13 00:31:04,331 [pool-4-thread-3148] [FtpGdriveSynchService] [INFO ] Synching 0BxCrx_DTxpZcZ0l3ZXdrVjkxdDA...
2016-10-13 00:31:04,495 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-2066005573444300351.upload.snapshot_20161013_002905D.jpg'...
2016-10-13 00:31:04,523 [pool-4-thread-3148] [STOR                ] [INFO ] File uploaded /motion/20161013/00/snapshot_20161013_003103D.jpg
2016-10-13 00:31:04,523 [pool-4-thread-3148] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-5525538120414971542.upload.snapshot_20161013_003103D.jpg'...
2016-10-13 00:31:05,740 [pool-4-thread-3148] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-5525538120414971542.upload.snapshot_20161013_003103D.jpg'...
2016-10-13 00:31:05,741 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-2066005573444300351.upload.snapshot_20161013_002905D.jpg'...
2016-10-13 00:31:05,820 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-3095298595232104774.upload.snapshot_20161013_002904D.jpg'...
2016-10-13 00:31:06,825 [pool-4-thread-3148] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-5525538120414971542.upload.snapshot_20161013_003103D.jpg'...
2016-10-13 00:31:06,969 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-3095298595232104774.upload.snapshot_20161013_002904D.jpg'...
2016-10-13 00:31:07,906 [pool-4-thread-3148] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-5525538120414971542.upload.snapshot_20161013_003103D.jpg'...
2016-10-13 00:31:08,082 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-3095298595232104774.upload.snapshot_20161013_002904D.jpg'...
2016-10-13 00:31:08,085 [pool-4-thread-3148] [PassivePorts        ] [WARN ] Releasing unreserved passive port: 45065
2016-10-13 00:31:08,085 [pool-4-thread-3148] [LoggingFilter       ] [INFO ] SENT: 150 File status okay; about to open data connection.

2016-10-13 00:31:08,086 [pool-4-thread-3148] [LoggingFilter       ] [INFO ] SENT: 226 Transfer complete.

2016-10-13 00:31:08,089 [pool-4-thread-3149] [FtpLoggingFilter    ] [INFO ] RECEIVED: EPSV
2016-10-13 00:31:08,089 [pool-4-thread-3147] [LoggingFilter       ] [INFO ] SENT: 229 Entering Passive Mode (|||44941|)

2016-10-13 00:31:08,098 [pool-4-thread-3148] [FtpLoggingFilter    ] [INFO ] RECEIVED: STOR snapshot_20161013_003104D.jpg
2016-10-13 00:31:08,116 [pool-4-thread-3148] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-7203356464345757309.upload.snapshot_20161013_003104D.jpg'...
2016-10-13 00:31:08,837 [pool-4-thread-3148] [GoogleDrive         ] [INFO ] File created snapshot_20161013_003104D.jpg (0BxCrx_DTxpZcX2ZwYVZJbGlxeEE)
2016-10-13 00:31:08,837 [pool-4-thread-3148] [FtpGdriveSynchService] [INFO ] Synching 0BxCrx_DTxpZcX2ZwYVZJbGlxeEE...
2016-10-13 00:31:08,977 [pool-4-thread-3148] [STOR                ] [INFO ] File uploaded /motion/20161013/00/snapshot_20161013_003104D.jpg
2016-10-13 00:31:08,978 [pool-4-thread-3148] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-7203356464345757309.upload.snapshot_20161013_003104D.jpg'...
2016-10-13 00:31:09,163 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-3095298595232104774.upload.snapshot_20161013_002904D.jpg'...
2016-10-13 00:31:09,451 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-6039296623011012294.upload.snapshot_20161013_002903D.jpg'...
2016-10-13 00:31:09,963 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Detected 2 changes
2016-10-13 00:31:09,964 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476333063880'
2016-10-13 00:31:09,990 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Updating file Diffs: lastViewedByMeDate '1476333068352'
2016-10-13 00:31:10,019 [Timer-0        ] [FtpGdriveSynchService$1] [INFO ] Largest changeId found in local database 108900
2016-10-13 00:31:10,092 [pool-4-thread-3148] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-7203356464345757309.upload.snapshot_20161013_003104D.jpg'...
2016-10-13 00:31:10,529 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-6039296623011012294.upload.snapshot_20161013_002903D.jpg'...
2016-10-13 00:31:11,269 [pool-4-thread-3148] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-7203356464345757309.upload.snapshot_20161013_003104D.jpg'...
2016-10-13 00:31:12,192 [Finalizer      ] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-6039296623011012294.upload.snapshot_20161013_002903D.jpg'...
2016-10-13 00:31:12,383 [pool-4-thread-3148] [GoogleDrive         ] [INFO ] Uploading file '/tmp/gdrive-synch-7203356464345757309.upload.snapshot_20161013_003104D.jpg'...
2016-10-13 00:31:12,522 [pool-4-thread-3148] [PassivePorts        ] [WARN ] Releasing unreserved passive port: 44941
2016-10-13 00:31:12,522 [pool-4-thread-3148] [LoggingFilter       ] [INFO ] SENT: 150 File status okay; about to open data connection.

2016-10-13 00:31:12,523 [pool-4-thread-3148] [LoggingFilter       ] [INFO ] SENT: 226 Transfer complete.

2016-10-13 00:31:12,526 [pool-4-thread-3149] [FtpLoggingFilter    ] [INFO ] RECEIVED: EPSV
2016-10-13 00:31:12,526 [pool-4-thread-3147] [LoggingFilter       ] [INFO ] SENT: 229 Entering Passive Mode (|||45221|)

2016-10-13 00:31:12,533 [pool-4-thread-3148] [FtpLoggingFilter
johnjjsmith commented 8 years ago

Same issue here. Started when Google Drive began its revision system; new files with the same name are uploaded as separate instances of the same name instead of being overwritten.

isVoid commented 6 years ago

Same issue here. When viewed with Filezilla, I see multiple instances of the same file exist. On drive web console, they show as duplicate files.

andresoviedo commented 6 years ago

No more duplicated files. It should be fixed in v.1.6.0.