Class org.syncany.tests.integration.operations.SplitSyncUpOperationTest

2

tests

0

failures

0

ignored

1.448s

duration

100%

successful

Tests

Test Duration Result
testUploadLocalDatabase_MultipleTransactions 1.063s passed
testUploadLocalDatabase_SingleTransactionPerFile 0.385s passed

Standard error

29-3-20 17:50:53.803 | org.syncany.plu | Test worker    | FINE : Validating required fields
29-3-20 17:50:53.804 | LocalTransferMa | Test worker    | INFO : testTargetExists: Target exists.
29-3-20 17:50:53.922 | org.syncany.plu | Test worker    | FINE : Validating required fields
29-3-20 17:50:53.928 | TransferManager | Test worker    | INFO : Building LocalTransferManager from config 'syncany-200329175011381-61083-client-syncanyclient' ...
29-3-20 17:50:53.928 | TransferManager | Test worker    | INFO : - With feature ReadAfterWriteConsistent
29-3-20 17:50:53.929 | TransferManager | Test worker    | INFO : - With feature Retriable
29-3-20 17:50:53.929 | TransferManager | Test worker    | FINE : - Checking if selected features supported ...
29-3-20 17:50:53.929 | TransferManager | Test worker    | FINE : - Checking for duplicate features ...
29-3-20 17:50:53.929 | TransferManager | Test worker    | FINE : - Checking required feature TransactionAware in LocalTransferManager ...
29-3-20 17:50:53.929 | TransferManager | Test worker    | FINE : - Checking required feature Retriable in LocalTransferManager ...
29-3-20 17:50:53.930 | TransferManager | Test worker    | INFO : - SKIPPING unsupported optional feature ReadAfterWriteConsistent
29-3-20 17:50:53.930 | TransferManager | Test worker    | FINE : - Wrapping TransferManager LocalTransferManager in RetriableFeatureTransferManager
29-3-20 17:50:53.930 | org.syncany.plu | Test worker    | FINE : Validating required fields
29-3-20 17:50:53.931 | TransferManager | Test worker    | INFO : Building LocalTransferManager from config 'syncany-200329175011381-61083-client-syncanyclient' ...
29-3-20 17:50:53.931 | TransferManager | Test worker    | INFO : - With feature ReadAfterWriteConsistent
29-3-20 17:50:53.932 | TransferManager | Test worker    | INFO : - With feature Retriable
29-3-20 17:50:53.932 | TransferManager | Test worker    | INFO : - With feature PathAware
29-3-20 17:50:53.932 | TransferManager | Test worker    | INFO : - With feature TransactionAware
29-3-20 17:50:53.932 | TransferManager | Test worker    | FINE : - Checking if selected features supported ...
29-3-20 17:50:53.932 | TransferManager | Test worker    | FINE : - Checking for duplicate features ...
29-3-20 17:50:53.932 | TransferManager | Test worker    | FINE : - Checking required feature TransactionAware in LocalTransferManager ...
29-3-20 17:50:53.932 | TransferManager | Test worker    | FINE : - Checking required feature Retriable in LocalTransferManager ...
29-3-20 17:50:53.933 | TransferManager | Test worker    | INFO : - SKIPPING unsupported optional feature ReadAfterWriteConsistent
29-3-20 17:50:53.933 | TransferManager | Test worker    | FINE : - Wrapping TransferManager LocalTransferManager in RetriableFeatureTransferManager
29-3-20 17:50:53.933 | TransferManager | Test worker    | INFO : - SKIPPING unsupported optional feature PathAware
29-3-20 17:50:53.933 | TransferManager | Test worker    | FINE : - Wrapping TransferManager RetriableFeatureTransferManager in TransactionAwareFeatureTransferManager
29-3-20 17:50:53.993 | hsqldb.db.HSQLD | Test worker    | INFO : Checkpoint start
29-3-20 17:50:53.994 | hsqldb.db.HSQLD | Test worker    | INFO : checkpointClose start
29-3-20 17:50:54.001 | hsqldb.db.HSQLD | Test worker    | FINE : log close size: 0
29-3-20 17:50:54.009 | hsqldb.db.HSQLD | Test worker    | INFO : checkpointClose end
29-3-20 17:50:54.009 | hsqldb.db.HSQLD | Test worker    | INFO : Checkpoint end - txts: 1
29-3-20 17:50:54.015 | DatabaseConnect | Test worker    | INFO : Found 0 tables.
29-3-20 17:50:54.015 | DatabaseConnect | Test worker    | INFO : Database has no tables. Creating tables from script.create.all.sql
29-3-20 17:50:54.015 | SqlRunner       | Test worker    | INFO : SQL (comment): -- Tables
29-3-20 17:50:54.016 | SqlRunner       | Test worker    | INFO : SQL:  CREATE CACHED TABLE IF NOT EXISTS databaseversion ( id int NOT NULL IDENTITY, status varchar(45) NOT NULL, localtime datetime NOT NULL, client varchar(45) NOT NULL, vectorclock_serialized varchar(1024) NOT NULL, UNIQUE (vectorclock_serialized) ); 
29-3-20 17:50:54.018 | SqlRunner       | Test worker    | INFO : SQL:  CREATE CACHED TABLE IF NOT EXISTS  chunk ( checksum varchar(40) NOT NULL, databaseversion_id int NOT NULL, size bigint NOT NULL, PRIMARY KEY (checksum), FOREIGN KEY (databaseversion_id) REFERENCES databaseversion (id) ON DELETE NO ACTION ON UPDATE NO ACTION ); 
29-3-20 17:50:54.023 | SqlRunner       | Test worker    | INFO : SQL:  CREATE CACHED TABLE IF NOT EXISTS  databaseversion_vectorclock ( databaseversion_id int NOT NULL, client varchar(45) NOT NULL, logicaltime int NOT NULL, PRIMARY KEY (databaseversion_id, client), FOREIGN KEY (databaseversion_id) REFERENCES databaseversion (id) ON DELETE NO ACTION ON UPDATE NO ACTION ); 
29-3-20 17:50:54.029 | SqlRunner       | Test worker    | INFO : SQL:  CREATE CACHED TABLE IF NOT EXISTS  filecontent ( checksum varchar(40) NOT NULL, databaseversion_id int NOT NULL, size bigint NOT NULL, PRIMARY KEY (checksum), FOREIGN KEY (databaseversion_id) REFERENCES databaseversion (id) ON DELETE NO ACTION ON UPDATE NO ACTION ); 
29-3-20 17:50:54.031 | SqlRunner       | Test worker    | INFO : SQL:  CREATE CACHED TABLE IF NOT EXISTS  filecontent_chunk ( filecontent_checksum varchar(40) NOT NULL, chunk_checksum varchar(40) NOT NULL, num int NOT NULL, PRIMARY KEY (filecontent_checksum, chunk_checksum, num), FOREIGN KEY (filecontent_checksum) REFERENCES filecontent (checksum) ON DELETE NO ACTION ON UPDATE NO ACTION, FOREIGN KEY (chunk_checksum) REFERENCES chunk (checksum) ON DELETE NO ACTION ON UPDATE NO ACTION ); 
29-3-20 17:50:54.033 | SqlRunner       | Test worker    | INFO : SQL:  CREATE CACHED TABLE IF NOT EXISTS  filehistory ( id varchar(40) NOT NULL, databaseversion_id int NOT NULL, PRIMARY KEY (id, databaseversion_id), FOREIGN KEY (databaseversion_id) REFERENCES databaseversion (id) ON DELETE NO ACTION ON UPDATE NO ACTION ); 
29-3-20 17:50:54.035 | SqlRunner       | Test worker    | INFO : SQL:  CREATE CACHED TABLE IF NOT EXISTS  fileversion ( filehistory_id varchar(40) NOT NULL, version int NOT NULL, databaseversion_id int NOT NULL, path varchar(1024) NOT NULL, type varchar(45) NOT NULL, status varchar(45) NOT NULL, size bigint NOT NULL, lastmodified datetime NOT NULL, linktarget varchar(1024), filecontent_checksum varchar(40) DEFAULT NULL, updated datetime NOT NULL, posixperms varchar(45) DEFAULT NULL, dosattrs varchar(45) DEFAULT NULL, PRIMARY KEY (filehistory_id, version, databaseversion_id), FOREIGN KEY (filehistory_id, databaseversion_id) REFERENCES filehistory (id, databaseversion_id) ON DELETE NO ACTION ON UPDATE NO ACTION, FOREIGN KEY (filecontent_checksum) REFERENCES filecontent (checksum) ON DELETE NO ACTION ON UPDATE NO ACTION ); 
29-3-20 17:50:54.037 | SqlRunner       | Test worker    | INFO : SQL:  CREATE CACHED TABLE IF NOT EXISTS  multichunk ( id varchar(40) NOT NULL, databaseversion_id int NOT NULL, size bigint NOT NULL, PRIMARY KEY (id), FOREIGN KEY (databaseversion_id) REFERENCES databaseversion (id) ON DELETE NO ACTION ON UPDATE NO ACTION ); 
29-3-20 17:50:54.040 | SqlRunner       | Test worker    | INFO : SQL:  CREATE CACHED TABLE IF NOT EXISTS  multichunk_chunk ( multichunk_id varchar(40) NOT NULL, chunk_checksum varchar(40) NOT NULL, PRIMARY KEY (multichunk_id, chunk_checksum), FOREIGN KEY (multichunk_id) REFERENCES multichunk (id) ON DELETE NO ACTION ON UPDATE NO ACTION, FOREIGN KEY (chunk_checksum) REFERENCES chunk (checksum) ON DELETE NO ACTION ON UPDATE NO ACTION ); 
29-3-20 17:50:54.045 | SqlRunner       | Test worker    | INFO : SQL:  CREATE CACHED TABLE IF NOT EXISTS  multichunk_muddy ( id varchar(40) NOT NULL, machine_name varchar(255) NOT NULL, machine_version int NOT NULL, PRIMARY KEY (id) ); 
29-3-20 17:50:54.047 | SqlRunner       | Test worker    | INFO : SQL:  CREATE CACHED TABLE IF NOT EXISTS  known_databases ( id int NOT NULL IDENTITY, client varchar(45) NOT NULL, filenumber int NOT NULL, UNIQUE (client, filenumber) ); 
29-3-20 17:50:54.049 | SqlRunner       | Test worker    | INFO : SQL:  CREATE CACHED TABLE IF NOT EXISTS  general_settings ( key varchar(255) NOT NULL, value varchar(255) NOT NULL, PRIMARY KEY (key) ); 
29-3-20 17:50:54.050 | SqlRunner       | Test worker    | INFO : SQL (comment): -- Non-primary indices
29-3-20 17:50:54.050 | SqlRunner       | Test worker    | INFO : SQL:   CREATE INDEX idx_databaseversion_status ON databaseversion (status); 
29-3-20 17:50:54.051 | hsqldb.db.HSQLD | Test worker    | INFO : dataFileCache open start
29-3-20 17:50:54.053 | hsqldb.db.HSQLD | Test worker    | INFO : dataFileCache open end
29-3-20 17:50:54.055 | SqlRunner       | Test worker    | INFO : SQL: CREATE INDEX idx_databaseversion_vectorclock_serialized ON databaseversion (vectorclock_serialized); 
29-3-20 17:50:54.056 | SqlRunner       | Test worker    | INFO : SQL: CREATE INDEX idx_fileversion_path ON fileversion (path); 
29-3-20 17:50:54.058 | SqlRunner       | Test worker    | INFO : SQL: CREATE INDEX idx_fileversion_status ON fileversion (status); 
29-3-20 17:50:54.059 | SqlRunner       | Test worker    | INFO : SQL: CREATE INDEX idx_fileversion_filecontent_checksum ON fileversion (filecontent_checksum); 
29-3-20 17:50:54.061 | SqlRunner       | Test worker    | INFO : SQL (comment): -- Views
29-3-20 17:50:54.061 | SqlRunner       | Test worker    | INFO : SQL:    CREATE VIEW databaseversion_master AS SELECT dbv.*, vc.logicaltime as client_version FROM databaseversion dbv JOIN databaseversion_vectorclock vc on dbv.id=vc.databaseversion_id and dbv.client=vc.client WHERE dbv.status='MASTER'; 
29-3-20 17:50:54.063 | SqlRunner       | Test worker    | INFO : SQL:  CREATE VIEW fileversion_master AS SELECT fv0.* FROM fileversion fv0 JOIN databaseversion dbv ON fv0.databaseversion_id=dbv.id AND dbv.status='MASTER'; 
29-3-20 17:50:54.065 | SqlRunner       | Test worker    | INFO : SQL:  CREATE VIEW fileversion_master_maxversion AS SELECT DISTINCT filehistory_id, MAX(version) version FROM fileversion_master GROUP BY filehistory_id; 
29-3-20 17:50:54.067 | SqlRunner       | Test worker    | INFO : SQL:  CREATE VIEW fileversion_master_last AS SELECT fv.* FROM fileversion_master_maxversion fvmax JOIN fileversion_master fv ON fvmax.filehistory_id=fv.filehistory_id AND fvmax.version=fv.version WHERE fv.status<>'DELETED'; 
29-3-20 17:50:54.073 | SqlRunner       | Test worker    | INFO : SQL (comment): -- Full Views
29-3-20 17:50:54.073 | SqlRunner       | Test worker    | INFO : SQL:    create view filehistory_full as select dbv.status as databaseversion_status, dbv.localtime as databaseversion_localtime, dbv.client as databaseversion_client, dbv.vectorclock_serialized as databaseversion_vectorclock_serialized, fh.* from databaseversion dbv join filehistory fh on dbv.id=fh.databaseversion_id; 
29-3-20 17:50:54.076 | SqlRunner       | Test worker    | INFO : SQL:  create view fileversion_full as select fhf.databaseversion_status, fhf.databaseversion_localtime, fhf.databaseversion_client, fhf.databaseversion_vectorclock_serialized, fv.* from filehistory_full fhf join fileversion fv on fhf.id=fv.filehistory_id and fhf.databaseversion_id=fv.databaseversion_id; 
29-3-20 17:50:54.078 | SqlRunner       | Test worker    | INFO : SQL (comment): -- Functions
29-3-20 17:50:54.078 | SqlRunner       | Test worker    | INFO : SQL (new delimiter): end;
29-3-20 17:50:54.078 | SqlRunner       | Test worker    | INFO : SQL:     create function substr_count(haystack varchar(255), needle varchar(255)) returns integer begin atomic declare strCount integer; declare lastIndex integer;  set strCount = 0; set lastIndex = 1;  while lastIndex <> 0 do set lastIndex = locate(needle, haystack, lastIndex);  if lastIndex <> 0 then set strCount = strCount + 1; set lastIndex = lastIndex + length(needle); end if; end while;  return strCount; end; 
29-3-20 17:50:54.081 | UpOperation     | Test worker    | INFO : 
29-3-20 17:50:54.081 | UpOperation     | Test worker    | INFO : Running 'Sync up' at client syncanyclienttTXhJiZuuLqHpSmfKTUu ...
29-3-20 17:50:54.081 | UpOperation     | Test worker    | INFO : --------------------------------------------
29-3-20 17:50:54.082 | InternalEventBu | Test worker    | INFO : Event bus 'LocalEventBus': Posting event UpStartSyncExternalEvent (org.syncany.operations.daemon.messages.UpStartSyncExternalEvent@75c6485e) ...
29-3-20 17:50:54.083 | DatabaseConnect | Test worker    | INFO : Found 12 tables.
29-3-20 17:50:54.083 | StatusOperation | Test worker    | INFO : 
29-3-20 17:50:54.084 | StatusOperation | Test worker    | INFO : Running 'Status' at client syncanyclienttTXhJiZuuLqHpSmfKTUu ...
29-3-20 17:50:54.088 | StatusOperation | Test worker    | INFO : --------------------------------------------
29-3-20 17:50:54.088 | StatusOperation | Test worker    | INFO : Querying current file tree from database ...
29-3-20 17:50:54.088 | InternalEventBu | Test worker    | INFO : Event bus 'LocalEventBus': Posting event StatusStartSyncExternalEvent (org.syncany.operations.daemon.messages.StatusStartSyncExternalEvent@39a05558) ...
29-3-20 17:50:54.093 | StatusOperation | Test worker    | INFO : Analyzing local folder /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient ...
29-3-20 17:50:54.093 | StatusOperation | Test worker    | FINE : - New file: rndFile-1585504253911-49373787.dat
29-3-20 17:50:54.094 | StatusOperation | Test worker    | FINE : - New file: rndFile-1585504253856-2126030180.dat
29-3-20 17:50:54.094 | StatusOperation | Test worker    | FINE : - New file: rndFile-1585504253877-2048064196.dat
29-3-20 17:50:54.094 | StatusOperation | Test worker    | FINE : - New file: rndFile-1585504253849-1169255758.dat
29-3-20 17:50:54.095 | StatusOperation | Test worker    | FINE : - New file: rndFile-1585504253822-1716481931.dat
29-3-20 17:50:54.097 | StatusOperation | Test worker    | FINE : - Ignoring file (syncany app-related): .syncany
29-3-20 17:50:54.099 | StatusOperation | Test worker    | FINE : - New file: rndFile-1585504253894-1233081534.dat
29-3-20 17:50:54.099 | InternalEventBu | Test worker    | INFO : Event bus 'LocalEventBus': Posting event StatusEndSyncExternalEvent (org.syncany.operations.daemon.messages.StatusEndSyncExternalEvent@1feb4b80) ...
29-3-20 17:50:54.102 | AbstractTransfe | Test worker    | INFO : Looking for other running remote operations ...
29-3-20 17:50:54.104 | DatabaseConnect | Test worker    | INFO : Found 12 tables.
29-3-20 17:50:54.105 | LsRemoteOperati | Test worker    | INFO : 
29-3-20 17:50:54.105 | LsRemoteOperati | Test worker    | INFO : Running 'Remote Status' at client syncanyclienttTXhJiZuuLqHpSmfKTUu ...
29-3-20 17:50:54.105 | LsRemoteOperati | Test worker    | INFO : --------------------------------------------
29-3-20 17:50:54.105 | InternalEventBu | Test worker    | INFO : Event bus 'LocalEventBus': Posting event LsRemoteStartSyncExternalEvent (org.syncany.operations.daemon.messages.LsRemoteStartSyncExternalEvent@5bce2851) ...
29-3-20 17:50:54.105 | LsRemoteOperati | Test worker    | INFO : Retrieving remote database list.
29-3-20 17:50:54.107 | InternalEventBu | Test worker    | INFO : Event bus 'LocalEventBus': Posting event LsRemoteEndSyncExternalEvent (org.syncany.operations.daemon.messages.LsRemoteEndSyncExternalEvent@63a85b28) ...
29-3-20 17:50:54.107 | UpOperation     | Test worker    | INFO : No remote changes, ready to upload.
29-3-20 17:50:54.108 | ActionFileHandl | Test worker    | INFO : Starting action for RemoteFile[name=action-up-syncanyclienttTXhJiZuuLqHpSmfKTUu-1585504253933] ...
29-3-20 17:50:54.108 | ActionFileHandl | Test worker    | INFO : Uploading action file: RemoteFile[name=action-up-syncanyclienttTXhJiZuuLqHpSmfKTUu-1585504253933]
29-3-20 17:50:54.108 | ActionFileHandl | Test worker    | INFO : Scheduling action renewal task for every 2 minutes, for RemoteFile[name=action-up-syncanyclienttTXhJiZuuLqHpSmfKTUu-1585504253933] ...
29-3-20 17:50:54.113 | DatabaseConnect | Test worker    | INFO : Found 12 tables.
29-3-20 17:50:54.120 | TransactionAwar | Test worker    | INFO : Done rolling back previous transactions.
29-3-20 17:50:54.121 | AsyncIndexer    | AsyncI/syncany | INFO : Starting Indexing.
29-3-20 17:50:54.122 | InternalEventBu | AsyncI/syncany | INFO : Event bus 'LocalEventBus': Posting event UpIndexStartSyncExternalEvent (org.syncany.operations.daemon.messages.UpIndexStartSyncExternalEvent@460791fa) ...
29-3-20 17:50:54.122 | Indexer         | AsyncI/syncany | FINE : - Looking for deleted files ...
29-3-20 17:50:54.122 | Indexer         | AsyncI/syncany | FINE : - +File /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/rndFile-1585504253822-1716481931.dat
29-3-20 17:50:54.122 | Indexer         | AsyncI/syncany | FINE : - +FileContent: /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/rndFile-1585504253822-1716481931.dat
29-3-20 17:50:54.139 | Indexer         | AsyncI/syncany | FINE : - Chunk new: 88a1b0899c2a4935135173043c6596561063290f
29-3-20 17:50:54.139 | Indexer         | AsyncI/syncany | FINE : - +MultiChunk 76681332265e26601299102b759da463f2f622f1
29-3-20 17:50:54.153 | Indexer         | AsyncI/syncany | FINE : - Chunk > MultiChunk: 88a1b0899c2a4935135173043c6596561063290f > 76681332265e26601299102b759da463f2f622f1
29-3-20 17:50:54.153 | Indexer         | AsyncI/syncany | FINE : - Chunk > FileContent: 88a1b0899c2a4935135173043c6596561063290f > /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/rndFile-1585504253822-1716481931.dat
29-3-20 17:50:54.164 | Indexer         | AsyncI/syncany | FINE : - Chunk new: c08898413146538d36ba7a1522e6e30762309559
29-3-20 17:50:54.176 | Indexer         | AsyncI/syncany | FINE : - Chunk > MultiChunk: c08898413146538d36ba7a1522e6e30762309559 > 76681332265e26601299102b759da463f2f622f1
29-3-20 17:50:54.177 | Indexer         | AsyncI/syncany | FINE : - Chunk > FileContent: c08898413146538d36ba7a1522e6e30762309559 > /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/rndFile-1585504253822-1716481931.dat
29-3-20 17:50:54.189 | Indexer         | AsyncI/syncany | FINE : - Chunk new: fa0787c03b7a142d44ab59f2f70ee8c080d86943
29-3-20 17:50:54.202 | Indexer         | AsyncI/syncany | FINE : - Chunk > MultiChunk: fa0787c03b7a142d44ab59f2f70ee8c080d86943 > 76681332265e26601299102b759da463f2f622f1
29-3-20 17:50:54.203 | Indexer         | AsyncI/syncany | FINE : - Chunk > FileContent: fa0787c03b7a142d44ab59f2f70ee8c080d86943 > /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/rndFile-1585504253822-1716481931.dat
29-3-20 17:50:54.203 | Indexer         | AsyncI/syncany | FINE : - /File: rndFile-1585504253822-1716481931.dat (checksum 734d3e01e2cbc64062ae098c049ef408fd8219e9)
29-3-20 17:50:54.216 | Indexer         | AsyncI/syncany | FINE :    * No old file history found, starting new history (path: rndFile-1585504253822-1716481931.dat, checksum: 734d3e01e2cbc64062ae098c049ef408fd8219e9)
29-3-20 17:50:54.217 | FileVersionComp | AsyncI/syncany | INFO :      - [DELETED]: Local file DIFFERS from file version, actual file is NULL, for file rndFile-1585504253822-1716481931.dat
29-3-20 17:50:54.217 | Indexer         | AsyncI/syncany | INFO :    * Added file version:    FileVersion [version=1, path=rndFile-1585504253822-1716481931.dat, type=FILE, status=NEW, size=1259520, lastModified=Sun Mar 29 17:50:53 UTC 2020, linkTarget=null, checksum=734d3e01e2cbc64062ae098c049ef408fd8219e9, updated=Sun Mar 29 17:50:54 UTC 2020, posixPermissions=rw-rw-r--, dosAttributes=--a-]
29-3-20 17:50:54.217 | Indexer         | AsyncI/syncany | INFO :      based on file version: null
29-3-20 17:50:54.218 | InternalEventBu | AsyncI/syncany | INFO : Event bus 'LocalEventBus': Posting event UpIndexChangesDetectedSyncExternalEvent (org.syncany.operations.daemon.messages.UpIndexChangesDetectedSyncExternalEvent@1fd138d8) ...
29-3-20 17:50:54.224 | Indexer         | AsyncI/syncany | FINE : - +File /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/rndFile-1585504253849-1169255758.dat
29-3-20 17:50:54.225 | Indexer         | AsyncI/syncany | FINE : - +FileContent: /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/rndFile-1585504253849-1169255758.dat
29-3-20 17:50:54.231 | Indexer         | AsyncI/syncany | FINE : - Chunk new: dfccd31be5903e87d71204e862e9eab699282fcd
29-3-20 17:50:54.249 | Indexer         | AsyncI/syncany | FINE : - Chunk > MultiChunk: dfccd31be5903e87d71204e862e9eab699282fcd > 76681332265e26601299102b759da463f2f622f1
29-3-20 17:50:54.255 | Indexer         | AsyncI/syncany | FINE : - Chunk > FileContent: dfccd31be5903e87d71204e862e9eab699282fcd > /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/rndFile-1585504253849-1169255758.dat
29-3-20 17:50:54.261 | Indexer         | AsyncI/syncany | FINE : - Chunk new: 49715a8a3a663f665d2347d4f9afb526604a994c
29-3-20 17:50:54.274 | Indexer         | AsyncI/syncany | FINE : - Chunk > MultiChunk: 49715a8a3a663f665d2347d4f9afb526604a994c > 76681332265e26601299102b759da463f2f622f1
29-3-20 17:50:54.274 | Indexer         | AsyncI/syncany | FINE : - Chunk > FileContent: 49715a8a3a663f665d2347d4f9afb526604a994c > /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/rndFile-1585504253849-1169255758.dat
29-3-20 17:50:54.282 | Indexer         | AsyncI/syncany | FINE : - Chunk new: b0852575d7bfb27f62e647479b56ab9b3bdd1ba3
29-3-20 17:50:54.285 | Indexer         | AsyncI/syncany | FINE : - Chunk > MultiChunk: b0852575d7bfb27f62e647479b56ab9b3bdd1ba3 > 76681332265e26601299102b759da463f2f622f1
29-3-20 17:50:54.285 | Indexer         | AsyncI/syncany | FINE : - Chunk > FileContent: b0852575d7bfb27f62e647479b56ab9b3bdd1ba3 > /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/rndFile-1585504253849-1169255758.dat
29-3-20 17:50:54.287 | Indexer         | AsyncI/syncany | FINE : - /File: rndFile-1585504253849-1169255758.dat (checksum d46c53caa532a8fa1277e9bf4a9dcfad7a7ff149)
29-3-20 17:50:54.289 | Indexer         | AsyncI/syncany | FINE :    * No old file history found, starting new history (path: rndFile-1585504253849-1169255758.dat, checksum: d46c53caa532a8fa1277e9bf4a9dcfad7a7ff149)
29-3-20 17:50:54.292 | FileVersionComp | AsyncI/syncany | INFO :      - [DELETED]: Local file DIFFERS from file version, actual file is NULL, for file rndFile-1585504253849-1169255758.dat
29-3-20 17:50:54.292 | Indexer         | AsyncI/syncany | INFO :    * Added file version:    FileVersion [version=1, path=rndFile-1585504253849-1169255758.dat, type=FILE, status=NEW, size=1259520, lastModified=Sun Mar 29 17:50:53 UTC 2020, linkTarget=null, checksum=d46c53caa532a8fa1277e9bf4a9dcfad7a7ff149, updated=Sun Mar 29 17:50:54 UTC 2020, posixPermissions=rw-rw-r--, dosAttributes=--a-]
29-3-20 17:50:54.292 | Indexer         | AsyncI/syncany | INFO :      based on file version: null
29-3-20 17:50:54.293 | Indexer         | AsyncI/syncany | FINE : - /MultiChunk 76681332265e26601299102b759da463f2f622f1
29-3-20 17:50:54.293 | Indexer         | AsyncI/syncany | FINE : Processed new database version: DatabaseVersion [header=UnknownMachine/()/T=1585504254121, chunks=6, multiChunks=1, fileContents=2, fileHistories=2]
29-3-20 17:50:54.294 | UpOperation     | Test worker    | INFO : No DIRTY data found in database (no dirty databases); Nothing to do here.
29-3-20 17:50:54.294 | UpOperation     | Test worker    | INFO : Last vector clock was: ()
29-3-20 17:50:54.295 | UpOperation     | Test worker    | INFO : Uploading new multichunks ...
29-3-20 17:50:54.295 | UpOperation     | Test worker    | INFO : - Uploading multichunk 76681332265e26601299102b759da463f2f622f1 from /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/.syncany/cache/multichunk-76681332265e26601299102b759da463f2f622f1 to RemoteFile[name=multichunk-76681332265e26601299102b759da463f2f622f1] ...
29-3-20 17:50:54.295 | RemoteTransacti | Test worker    | INFO : - Adding file to TX for UPLOAD: /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/.syncany/cache/multichunk-76681332265e26601299102b759da463f2f622f1 -> Temp. remote file: RemoteFile[name=temp-dFNzT-multichunk-76681332265e26601299102b759da463f2f622f1], final location: RemoteFile[name=multichunk-76681332265e26601299102b759da463f2f622f1]
29-3-20 17:50:54.295 | UpOperation     | Test worker    | INFO : Uploading database: DatabaseVersion [header=syncanyclienttTXhJiZuuLqHpSmfKTUu/(syncanyclienttTXhJiZuuLqHpSmfKTUu1)/T=1585504254295, chunks=6, multiChunks=1, fileContents=2, fileHistories=2]
29-3-20 17:50:54.296 | UpOperation     | Test worker    | INFO : Saving local delta database, version syncanyclienttTXhJiZuuLqHpSmfKTUu/(syncanyclienttTXhJiZuuLqHpSmfKTUu1)/T=1585504254295 to file /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/.syncany/cache/database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000001 ... 
29-3-20 17:50:54.296 | UpOperation     | Test worker    | INFO : - Saving database to /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/.syncany/cache/database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000001 ...
29-3-20 17:50:54.297 | UpOperation     | Test worker    | INFO : - Uploading local delta database file ...
29-3-20 17:50:54.298 | UpOperation     | Test worker    | INFO : - Uploading /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/.syncany/cache/database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000001 to RemoteFile[name=database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000001] ...
29-3-20 17:50:54.298 | RemoteTransacti | Test worker    | INFO : - Adding file to TX for UPLOAD: /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/.syncany/cache/database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000001 -> Temp. remote file: RemoteFile[name=temp-Dmmch-database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000001], final location: RemoteFile[name=database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000001]
29-3-20 17:50:54.298 | InternalEventBu | AsyncI/syncany | INFO : Event bus 'LocalEventBus': Posting event UpIndexMidSyncExternalEvent (org.syncany.operations.daemon.messages.UpIndexMidSyncExternalEvent@504b93cf) ...
29-3-20 17:50:54.299 | Indexer         | AsyncI/syncany | FINE : - +File /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/rndFile-1585504253856-2126030180.dat
29-3-20 17:50:54.299 | UpOperation     | Test worker    | INFO : Adding shutdown hook (to allow resuming the upload) ...
29-3-20 17:50:54.299 | RemoteTransacti | Test worker    | INFO : Starting TX.commit() ...
29-3-20 17:50:54.303 | Indexer         | AsyncI/syncany | FINE : - +FileContent: /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/rndFile-1585504253856-2126030180.dat
29-3-20 17:50:54.309 | RemoteTransacti | Test worker    | INFO : Wrote transaction manifest to temporary file: /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/.syncany/cache/temp-transaction-5017478329146974214.tmp
29-3-20 17:50:54.309 | InternalEventBu | Test worker    | INFO : Event bus 'LocalEventBus': Posting event UpUploadFileSyncExternalEvent (org.syncany.operations.daemon.messages.UpUploadFileSyncExternalEvent@1b2e6ec4) ...
29-3-20 17:50:54.310 | RemoteTransacti | Test worker    | INFO : - Uploading remote transaction file RemoteFile[name=transaction-40b75603] ...
29-3-20 17:50:54.311 | RemoteTransacti | Test worker    | INFO : - Starting to upload data in commit.
29-3-20 17:50:54.312 | InternalEventBu | Test worker    | INFO : Event bus 'LocalEventBus': Posting event UpUploadFileInTransactionSyncExternalEvent (org.syncany.operations.daemon.messages.UpUploadFileInTransactionSyncExternalEvent@3499540b) ...
29-3-20 17:50:54.312 | RemoteTransacti | Test worker    | INFO : - Uploading /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/.syncany/cache/multichunk-76681332265e26601299102b759da463f2f622f1 to temp. file RemoteFile[name=temp-dFNzT-multichunk-76681332265e26601299102b759da463f2f622f1] ...
29-3-20 17:50:54.322 | InternalEventBu | Test worker    | INFO : Event bus 'LocalEventBus': Posting event UpUploadFileInTransactionSyncExternalEvent (org.syncany.operations.daemon.messages.UpUploadFileInTransactionSyncExternalEvent@4bbb08cc) ...
29-3-20 17:50:54.322 | RemoteTransacti | Test worker    | INFO : - Uploading /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/.syncany/cache/database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000001 to temp. file RemoteFile[name=temp-Dmmch-database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000001] ...
29-3-20 17:50:54.324 | RemoteTransacti | Test worker    | INFO : - Moving temp. file RemoteFile[name=temp-dFNzT-multichunk-76681332265e26601299102b759da463f2f622f1] to final location RemoteFile[name=multichunk-76681332265e26601299102b759da463f2f622f1] ...
29-3-20 17:50:54.325 | RemoteTransacti | Test worker    | INFO : - Moving temp. file RemoteFile[name=temp-Dmmch-database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000001] to final location RemoteFile[name=database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000001] ...
29-3-20 17:50:54.325 | RemoteTransacti | Test worker    | INFO : - Deleting remote transaction file RemoteFile[name=transaction-40b75603] ...
29-3-20 17:50:54.325 | RemoteTransacti | Test worker    | INFO : END of TX.commmit(): Succesfully committed transaction.
29-3-20 17:50:54.325 | RemoteTransacti | Test worker    | INFO : END of TX.delTemp(): Sucessfully deleted final files.
29-3-20 17:50:54.325 | UpOperation     | Test worker    | INFO : Persisting local SQL database (new database version syncanyclienttTXhJiZuuLqHpSmfKTUu/(syncanyclienttTXhJiZuuLqHpSmfKTUu1)/T=1585504254295) ...
29-3-20 17:50:54.327 | Indexer         | AsyncI/syncany | FINE : - Chunk new: 17c2afffa7672b1d5065797b2c44c11ecf3bec30
29-3-20 17:50:54.327 | Indexer         | AsyncI/syncany | FINE : - +MultiChunk 20cca4a0ea94ad5d14fe3ef068b2d33010525e33
29-3-20 17:50:54.341 | Indexer         | AsyncI/syncany | FINE : - Chunk > MultiChunk: 17c2afffa7672b1d5065797b2c44c11ecf3bec30 > 20cca4a0ea94ad5d14fe3ef068b2d33010525e33
29-3-20 17:50:54.341 | Indexer         | AsyncI/syncany | FINE : - Chunk > FileContent: 17c2afffa7672b1d5065797b2c44c11ecf3bec30 > /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/rndFile-1585504253856-2126030180.dat
29-3-20 17:50:54.345 | UpOperation     | Test worker    | INFO : Removing DIRTY database versions from database ...
29-3-20 17:50:54.360 | Indexer         | AsyncI/syncany | FINE : - Chunk new: 6faa36a98734580c628196f77bff4ac87e7ec97f
29-3-20 17:50:54.361 | UpOperation     | Test worker    | INFO : Adding database version to result changes:DatabaseVersion [header=syncanyclienttTXhJiZuuLqHpSmfKTUu/(syncanyclienttTXhJiZuuLqHpSmfKTUu1)/T=1585504254295, chunks=6, multiChunks=1, fileContents=2, fileHistories=2]
29-3-20 17:50:54.362 | UpOperation     | Test worker    | INFO : Committing local database.
29-3-20 17:50:54.362 | UpOperation     | Test worker    | FINE : Waiting for new database version.
29-3-20 17:50:54.374 | Indexer         | AsyncI/syncany | FINE : - Chunk > MultiChunk: 6faa36a98734580c628196f77bff4ac87e7ec97f > 20cca4a0ea94ad5d14fe3ef068b2d33010525e33
29-3-20 17:50:54.374 | Indexer         | AsyncI/syncany | FINE : - Chunk > FileContent: 6faa36a98734580c628196f77bff4ac87e7ec97f > /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/rndFile-1585504253856-2126030180.dat
29-3-20 17:50:54.379 | Indexer         | AsyncI/syncany | FINE : - Chunk new: cffb8cd8eed0bdc7a9859aa5117cb53acd44c0b2
29-3-20 17:50:54.385 | Indexer         | AsyncI/syncany | FINE : - Chunk > MultiChunk: cffb8cd8eed0bdc7a9859aa5117cb53acd44c0b2 > 20cca4a0ea94ad5d14fe3ef068b2d33010525e33
29-3-20 17:50:54.385 | Indexer         | AsyncI/syncany | FINE : - Chunk > FileContent: cffb8cd8eed0bdc7a9859aa5117cb53acd44c0b2 > /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/rndFile-1585504253856-2126030180.dat
29-3-20 17:50:54.386 | Indexer         | AsyncI/syncany | FINE : - /File: rndFile-1585504253856-2126030180.dat (checksum 1c33b87b5d1cdbfc57445e3932c247df2ae9a05e)
29-3-20 17:50:54.399 | Indexer         | AsyncI/syncany | FINE :    * No old file history found, starting new history (path: rndFile-1585504253856-2126030180.dat, checksum: 1c33b87b5d1cdbfc57445e3932c247df2ae9a05e)
29-3-20 17:50:54.399 | FileVersionComp | AsyncI/syncany | INFO :      - [DELETED]: Local file DIFFERS from file version, actual file is NULL, for file rndFile-1585504253856-2126030180.dat
29-3-20 17:50:54.399 | Indexer         | AsyncI/syncany | INFO :    * Added file version:    FileVersion [version=1, path=rndFile-1585504253856-2126030180.dat, type=FILE, status=NEW, size=1259520, lastModified=Sun Mar 29 17:50:53 UTC 2020, linkTarget=null, checksum=1c33b87b5d1cdbfc57445e3932c247df2ae9a05e, updated=Sun Mar 29 17:50:54 UTC 2020, posixPermissions=rw-rw-r--, dosAttributes=--a-]
29-3-20 17:50:54.399 | Indexer         | AsyncI/syncany | INFO :      based on file version: null
29-3-20 17:50:54.399 | InternalEventBu | AsyncI/syncany | INFO : Event bus 'LocalEventBus': Posting event UpIndexChangesDetectedSyncExternalEvent (org.syncany.operations.daemon.messages.UpIndexChangesDetectedSyncExternalEvent@2b3ea39b) ...
29-3-20 17:50:54.401 | Indexer         | AsyncI/syncany | FINE : - +File /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/rndFile-1585504253877-2048064196.dat
29-3-20 17:50:54.401 | Indexer         | AsyncI/syncany | FINE : - +FileContent: /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/rndFile-1585504253877-2048064196.dat
29-3-20 17:50:54.415 | Indexer         | AsyncI/syncany | FINE : - Chunk new: c8d76a5121d13028f2d046b585fb5ceec1b1307e
29-3-20 17:50:54.433 | Indexer         | AsyncI/syncany | FINE : - Chunk > MultiChunk: c8d76a5121d13028f2d046b585fb5ceec1b1307e > 20cca4a0ea94ad5d14fe3ef068b2d33010525e33
29-3-20 17:50:54.437 | Indexer         | AsyncI/syncany | FINE : - Chunk > FileContent: c8d76a5121d13028f2d046b585fb5ceec1b1307e > /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/rndFile-1585504253877-2048064196.dat
29-3-20 17:50:54.468 | Indexer         | AsyncI/syncany | FINE : - Chunk new: 2c6262002a89e16d7064f9d5608380111621d67f
29-3-20 17:50:54.486 | Indexer         | AsyncI/syncany | FINE : - Chunk > MultiChunk: 2c6262002a89e16d7064f9d5608380111621d67f > 20cca4a0ea94ad5d14fe3ef068b2d33010525e33
29-3-20 17:50:54.492 | Indexer         | AsyncI/syncany | FINE : - Chunk > FileContent: 2c6262002a89e16d7064f9d5608380111621d67f > /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/rndFile-1585504253877-2048064196.dat
29-3-20 17:50:54.505 | Indexer         | AsyncI/syncany | FINE : - Chunk new: 431b85d94d94bc310773a0e35510440077063e9e
29-3-20 17:50:54.507 | Indexer         | AsyncI/syncany | FINE : - Chunk > MultiChunk: 431b85d94d94bc310773a0e35510440077063e9e > 20cca4a0ea94ad5d14fe3ef068b2d33010525e33
29-3-20 17:50:54.507 | Indexer         | AsyncI/syncany | FINE : - Chunk > FileContent: 431b85d94d94bc310773a0e35510440077063e9e > /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/rndFile-1585504253877-2048064196.dat
29-3-20 17:50:54.508 | Indexer         | AsyncI/syncany | FINE : - /File: rndFile-1585504253877-2048064196.dat (checksum 9bb40cce7f5543bc86273330be6e0555f98a27b2)
29-3-20 17:50:54.511 | Indexer         | AsyncI/syncany | FINE :    * No old file history found, starting new history (path: rndFile-1585504253877-2048064196.dat, checksum: 9bb40cce7f5543bc86273330be6e0555f98a27b2)
29-3-20 17:50:54.515 | FileVersionComp | AsyncI/syncany | INFO :      - [DELETED]: Local file DIFFERS from file version, actual file is NULL, for file rndFile-1585504253877-2048064196.dat
29-3-20 17:50:54.518 | Indexer         | AsyncI/syncany | INFO :    * Added file version:    FileVersion [version=1, path=rndFile-1585504253877-2048064196.dat, type=FILE, status=NEW, size=1259520, lastModified=Sun Mar 29 17:50:53 UTC 2020, linkTarget=null, checksum=9bb40cce7f5543bc86273330be6e0555f98a27b2, updated=Sun Mar 29 17:50:54 UTC 2020, posixPermissions=rw-rw-r--, dosAttributes=--a-]
29-3-20 17:50:54.518 | Indexer         | AsyncI/syncany | INFO :      based on file version: null
29-3-20 17:50:54.518 | Indexer         | AsyncI/syncany | FINE : - /MultiChunk 20cca4a0ea94ad5d14fe3ef068b2d33010525e33
29-3-20 17:50:54.519 | Indexer         | AsyncI/syncany | FINE : Processed new database version: DatabaseVersion [header=UnknownMachine/()/T=1585504254299, chunks=6, multiChunks=1, fileContents=2, fileHistories=2]
29-3-20 17:50:54.519 | InternalEventBu | AsyncI/syncany | INFO : Event bus 'LocalEventBus': Posting event UpIndexMidSyncExternalEvent (org.syncany.operations.daemon.messages.UpIndexMidSyncExternalEvent@39209b42) ...
29-3-20 17:50:54.522 | Indexer         | AsyncI/syncany | FINE : - +File /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/rndFile-1585504253894-1233081534.dat
29-3-20 17:50:54.522 | UpOperation     | Test worker    | FINE : Took new database version: DatabaseVersion [header=UnknownMachine/()/T=1585504254299, chunks=6, multiChunks=1, fileContents=2, fileHistories=2]
29-3-20 17:50:54.523 | Indexer         | AsyncI/syncany | FINE : - +FileContent: /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/rndFile-1585504253894-1233081534.dat
29-3-20 17:50:54.523 | UpOperation     | Test worker    | INFO : Last vector clock was: (syncanyclienttTXhJiZuuLqHpSmfKTUu1)
29-3-20 17:50:54.523 | UpOperation     | Test worker    | INFO : Uploading new multichunks ...
29-3-20 17:50:54.524 | UpOperation     | Test worker    | INFO : - Uploading multichunk 20cca4a0ea94ad5d14fe3ef068b2d33010525e33 from /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/.syncany/cache/multichunk-20cca4a0ea94ad5d14fe3ef068b2d33010525e33 to RemoteFile[name=multichunk-20cca4a0ea94ad5d14fe3ef068b2d33010525e33] ...
29-3-20 17:50:54.524 | RemoteTransacti | Test worker    | INFO : - Adding file to TX for UPLOAD: /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/.syncany/cache/multichunk-20cca4a0ea94ad5d14fe3ef068b2d33010525e33 -> Temp. remote file: RemoteFile[name=temp-rRBWX-multichunk-20cca4a0ea94ad5d14fe3ef068b2d33010525e33], final location: RemoteFile[name=multichunk-20cca4a0ea94ad5d14fe3ef068b2d33010525e33]
29-3-20 17:50:54.524 | UpOperation     | Test worker    | INFO : Uploading database: DatabaseVersion [header=syncanyclienttTXhJiZuuLqHpSmfKTUu/(syncanyclienttTXhJiZuuLqHpSmfKTUu2)/T=1585504254523, chunks=6, multiChunks=1, fileContents=2, fileHistories=2]
29-3-20 17:50:54.524 | UpOperation     | Test worker    | INFO : Saving local delta database, version syncanyclienttTXhJiZuuLqHpSmfKTUu/(syncanyclienttTXhJiZuuLqHpSmfKTUu2)/T=1585504254523 to file /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/.syncany/cache/database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000002 ... 
29-3-20 17:50:54.525 | UpOperation     | Test worker    | INFO : - Saving database to /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/.syncany/cache/database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000002 ...
29-3-20 17:50:54.526 | UpOperation     | Test worker    | INFO : - Uploading local delta database file ...
29-3-20 17:50:54.526 | UpOperation     | Test worker    | INFO : - Uploading /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/.syncany/cache/database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000002 to RemoteFile[name=database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000002] ...
29-3-20 17:50:54.526 | RemoteTransacti | Test worker    | INFO : - Adding file to TX for UPLOAD: /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/.syncany/cache/database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000002 -> Temp. remote file: RemoteFile[name=temp-rbWvd-database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000002], final location: RemoteFile[name=database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000002]
29-3-20 17:50:54.527 | UpOperation     | Test worker    | INFO : Adding shutdown hook (to allow resuming the upload) ...
29-3-20 17:50:54.527 | RemoteTransacti | Test worker    | INFO : Starting TX.commit() ...
29-3-20 17:50:54.536 | RemoteTransacti | Test worker    | INFO : Wrote transaction manifest to temporary file: /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/.syncany/cache/temp-transaction-15959805576145700614.tmp
29-3-20 17:50:54.536 | InternalEventBu | Test worker    | INFO : Event bus 'LocalEventBus': Posting event UpUploadFileSyncExternalEvent (org.syncany.operations.daemon.messages.UpUploadFileSyncExternalEvent@6f23b04a) ...
29-3-20 17:50:54.539 | RemoteTransacti | Test worker    | INFO : - Uploading remote transaction file RemoteFile[name=transaction-67e8422f] ...
29-3-20 17:50:54.544 | RemoteTransacti | Test worker    | INFO : - Starting to upload data in commit.
29-3-20 17:50:54.545 | InternalEventBu | Test worker    | INFO : Event bus 'LocalEventBus': Posting event UpUploadFileInTransactionSyncExternalEvent (org.syncany.operations.daemon.messages.UpUploadFileInTransactionSyncExternalEvent@4bdf16c5) ...
29-3-20 17:50:54.545 | RemoteTransacti | Test worker    | INFO : - Uploading /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/.syncany/cache/multichunk-20cca4a0ea94ad5d14fe3ef068b2d33010525e33 to temp. file RemoteFile[name=temp-rRBWX-multichunk-20cca4a0ea94ad5d14fe3ef068b2d33010525e33] ...
29-3-20 17:50:54.550 | InternalEventBu | Test worker    | INFO : Event bus 'LocalEventBus': Posting event UpUploadFileInTransactionSyncExternalEvent (org.syncany.operations.daemon.messages.UpUploadFileInTransactionSyncExternalEvent@6eaa17bf) ...
29-3-20 17:50:54.550 | RemoteTransacti | Test worker    | INFO : - Uploading /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/.syncany/cache/database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000002 to temp. file RemoteFile[name=temp-rbWvd-database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000002] ...
29-3-20 17:50:54.551 | Indexer         | AsyncI/syncany | FINE : - Chunk new: 2654857705c563219babad27d8f25b44573e903d
29-3-20 17:50:54.551 | RemoteTransacti | Test worker    | INFO : - Moving temp. file RemoteFile[name=temp-rRBWX-multichunk-20cca4a0ea94ad5d14fe3ef068b2d33010525e33] to final location RemoteFile[name=multichunk-20cca4a0ea94ad5d14fe3ef068b2d33010525e33] ...
29-3-20 17:50:54.552 | RemoteTransacti | Test worker    | INFO : - Moving temp. file RemoteFile[name=temp-rbWvd-database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000002] to final location RemoteFile[name=database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000002] ...
29-3-20 17:50:54.552 | Indexer         | AsyncI/syncany | FINE : - +MultiChunk 5ceaa45913a3efd01a310e6cfe3f61f9d27ec292
29-3-20 17:50:54.556 | RemoteTransacti | Test worker    | INFO : - Deleting remote transaction file RemoteFile[name=transaction-67e8422f] ...
29-3-20 17:50:54.556 | RemoteTransacti | Test worker    | INFO : END of TX.commmit(): Succesfully committed transaction.
29-3-20 17:50:54.556 | RemoteTransacti | Test worker    | INFO : END of TX.delTemp(): Sucessfully deleted final files.
29-3-20 17:50:54.556 | UpOperation     | Test worker    | INFO : Persisting local SQL database (new database version syncanyclienttTXhJiZuuLqHpSmfKTUu/(syncanyclienttTXhJiZuuLqHpSmfKTUu2)/T=1585504254523) ...
29-3-20 17:50:54.568 | Indexer         | AsyncI/syncany | FINE : - Chunk > MultiChunk: 2654857705c563219babad27d8f25b44573e903d > 5ceaa45913a3efd01a310e6cfe3f61f9d27ec292
29-3-20 17:50:54.568 | Indexer         | AsyncI/syncany | FINE : - Chunk > FileContent: 2654857705c563219babad27d8f25b44573e903d > /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/rndFile-1585504253894-1233081534.dat
29-3-20 17:50:54.584 | UpOperation     | Test worker    | INFO : Removing DIRTY database versions from database ...
29-3-20 17:50:54.597 | Indexer         | AsyncI/syncany | FINE : - Chunk new: 4f7f38b7628f382d9ab551d9ec559df4859f2d88
29-3-20 17:50:54.614 | UpOperation     | Test worker    | INFO : Adding database version to result changes:DatabaseVersion [header=syncanyclienttTXhJiZuuLqHpSmfKTUu/(syncanyclienttTXhJiZuuLqHpSmfKTUu2)/T=1585504254523, chunks=6, multiChunks=1, fileContents=2, fileHistories=2]
29-3-20 17:50:54.614 | UpOperation     | Test worker    | INFO : Committing local database.
29-3-20 17:50:54.615 | UpOperation     | Test worker    | FINE : Waiting for new database version.
29-3-20 17:50:54.618 | Indexer         | AsyncI/syncany | FINE : - Chunk > MultiChunk: 4f7f38b7628f382d9ab551d9ec559df4859f2d88 > 5ceaa45913a3efd01a310e6cfe3f61f9d27ec292
29-3-20 17:50:54.618 | Indexer         | AsyncI/syncany | FINE : - Chunk > FileContent: 4f7f38b7628f382d9ab551d9ec559df4859f2d88 > /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/rndFile-1585504253894-1233081534.dat
29-3-20 17:50:54.623 | Indexer         | AsyncI/syncany | FINE : - Chunk new: 1b4f43f3f4292cf7ce5b372bd8f47dce47d58ddb
29-3-20 17:50:54.627 | Indexer         | AsyncI/syncany | FINE : - Chunk > MultiChunk: 1b4f43f3f4292cf7ce5b372bd8f47dce47d58ddb > 5ceaa45913a3efd01a310e6cfe3f61f9d27ec292
29-3-20 17:50:54.628 | Indexer         | AsyncI/syncany | FINE : - Chunk > FileContent: 1b4f43f3f4292cf7ce5b372bd8f47dce47d58ddb > /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/rndFile-1585504253894-1233081534.dat
29-3-20 17:50:54.630 | Indexer         | AsyncI/syncany | FINE : - /File: rndFile-1585504253894-1233081534.dat (checksum bad981f63f4051571c253d98962f4de9dc236c15)
29-3-20 17:50:54.633 | Indexer         | AsyncI/syncany | FINE :    * No old file history found, starting new history (path: rndFile-1585504253894-1233081534.dat, checksum: bad981f63f4051571c253d98962f4de9dc236c15)
29-3-20 17:50:54.633 | FileVersionComp | AsyncI/syncany | INFO :      - [DELETED]: Local file DIFFERS from file version, actual file is NULL, for file rndFile-1585504253894-1233081534.dat
29-3-20 17:50:54.633 | Indexer         | AsyncI/syncany | INFO :    * Added file version:    FileVersion [version=1, path=rndFile-1585504253894-1233081534.dat, type=FILE, status=NEW, size=1259520, lastModified=Sun Mar 29 17:50:53 UTC 2020, linkTarget=null, checksum=bad981f63f4051571c253d98962f4de9dc236c15, updated=Sun Mar 29 17:50:54 UTC 2020, posixPermissions=rw-rw-r--, dosAttributes=--a-]
29-3-20 17:50:54.633 | Indexer         | AsyncI/syncany | INFO :      based on file version: null
29-3-20 17:50:54.633 | InternalEventBu | AsyncI/syncany | INFO : Event bus 'LocalEventBus': Posting event UpIndexChangesDetectedSyncExternalEvent (org.syncany.operations.daemon.messages.UpIndexChangesDetectedSyncExternalEvent@a1fd807) ...
29-3-20 17:50:54.635 | Indexer         | AsyncI/syncany | FINE : - +File /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/rndFile-1585504253911-49373787.dat
29-3-20 17:50:54.635 | Indexer         | AsyncI/syncany | FINE : - +FileContent: /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/rndFile-1585504253911-49373787.dat
29-3-20 17:50:54.655 | Indexer         | AsyncI/syncany | FINE : - Chunk new: b1255049d7a288d9b4c5109b59b2012b39e6facd
29-3-20 17:50:54.673 | Indexer         | AsyncI/syncany | FINE : - Chunk > MultiChunk: b1255049d7a288d9b4c5109b59b2012b39e6facd > 5ceaa45913a3efd01a310e6cfe3f61f9d27ec292
29-3-20 17:50:54.673 | Indexer         | AsyncI/syncany | FINE : - Chunk > FileContent: b1255049d7a288d9b4c5109b59b2012b39e6facd > /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/rndFile-1585504253911-49373787.dat
29-3-20 17:50:54.685 | Indexer         | AsyncI/syncany | FINE : - Chunk new: 9fafec237362050fe83b852b3e4428f2c339ad1a
29-3-20 17:50:54.699 | Indexer         | AsyncI/syncany | FINE : - Chunk > MultiChunk: 9fafec237362050fe83b852b3e4428f2c339ad1a > 5ceaa45913a3efd01a310e6cfe3f61f9d27ec292
29-3-20 17:50:54.700 | Indexer         | AsyncI/syncany | FINE : - Chunk > FileContent: 9fafec237362050fe83b852b3e4428f2c339ad1a > /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/rndFile-1585504253911-49373787.dat
29-3-20 17:50:54.704 | Indexer         | AsyncI/syncany | FINE : - Chunk new: 9a105326c9769a0b941d3dd0795a82da789ecb89
29-3-20 17:50:54.713 | Indexer         | AsyncI/syncany | FINE : - Chunk > MultiChunk: 9a105326c9769a0b941d3dd0795a82da789ecb89 > 5ceaa45913a3efd01a310e6cfe3f61f9d27ec292
29-3-20 17:50:54.715 | Indexer         | AsyncI/syncany | FINE : - Chunk > FileContent: 9a105326c9769a0b941d3dd0795a82da789ecb89 > /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/rndFile-1585504253911-49373787.dat
29-3-20 17:50:54.716 | Indexer         | AsyncI/syncany | FINE : - /File: rndFile-1585504253911-49373787.dat (checksum a3700a80f1d0a4faaf397db673be5ddca643df65)
29-3-20 17:50:54.719 | Indexer         | AsyncI/syncany | FINE :    * No old file history found, starting new history (path: rndFile-1585504253911-49373787.dat, checksum: a3700a80f1d0a4faaf397db673be5ddca643df65)
29-3-20 17:50:54.721 | FileVersionComp | AsyncI/syncany | INFO :      - [DELETED]: Local file DIFFERS from file version, actual file is NULL, for file rndFile-1585504253911-49373787.dat
29-3-20 17:50:54.721 | Indexer         | AsyncI/syncany | INFO :    * Added file version:    FileVersion [version=1, path=rndFile-1585504253911-49373787.dat, type=FILE, status=NEW, size=1259520, lastModified=Sun Mar 29 17:50:53 UTC 2020, linkTarget=null, checksum=a3700a80f1d0a4faaf397db673be5ddca643df65, updated=Sun Mar 29 17:50:54 UTC 2020, posixPermissions=rw-rw-r--, dosAttributes=--a-]
29-3-20 17:50:54.721 | Indexer         | AsyncI/syncany | INFO :      based on file version: null
29-3-20 17:50:54.725 | Indexer         | AsyncI/syncany | FINE : - /MultiChunk 5ceaa45913a3efd01a310e6cfe3f61f9d27ec292
29-3-20 17:50:54.725 | Indexer         | AsyncI/syncany | FINE : Processed new database version: DatabaseVersion [header=UnknownMachine/()/T=1585504254519, chunks=6, multiChunks=1, fileContents=2, fileHistories=2]
29-3-20 17:50:54.725 | InternalEventBu | AsyncI/syncany | INFO : Event bus 'LocalEventBus': Posting event UpIndexMidSyncExternalEvent (org.syncany.operations.daemon.messages.UpIndexMidSyncExternalEvent@45665a74) ...
29-3-20 17:50:54.725 | UpOperation     | Test worker    | FINE : Took new database version: DatabaseVersion [header=UnknownMachine/()/T=1585504254519, chunks=6, multiChunks=1, fileContents=2, fileHistories=2]
29-3-20 17:50:54.726 | UpOperation     | Test worker    | INFO : Last vector clock was: (syncanyclienttTXhJiZuuLqHpSmfKTUu2)
29-3-20 17:50:54.727 | UpOperation     | Test worker    | INFO : Uploading new multichunks ...
29-3-20 17:50:54.727 | UpOperation     | Test worker    | INFO : - Uploading multichunk 5ceaa45913a3efd01a310e6cfe3f61f9d27ec292 from /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/.syncany/cache/multichunk-5ceaa45913a3efd01a310e6cfe3f61f9d27ec292 to RemoteFile[name=multichunk-5ceaa45913a3efd01a310e6cfe3f61f9d27ec292] ...
29-3-20 17:50:54.727 | RemoteTransacti | Test worker    | INFO : - Adding file to TX for UPLOAD: /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/.syncany/cache/multichunk-5ceaa45913a3efd01a310e6cfe3f61f9d27ec292 -> Temp. remote file: RemoteFile[name=temp-rQlsu-multichunk-5ceaa45913a3efd01a310e6cfe3f61f9d27ec292], final location: RemoteFile[name=multichunk-5ceaa45913a3efd01a310e6cfe3f61f9d27ec292]
29-3-20 17:50:54.727 | UpOperation     | Test worker    | INFO : Uploading database: DatabaseVersion [header=syncanyclienttTXhJiZuuLqHpSmfKTUu/(syncanyclienttTXhJiZuuLqHpSmfKTUu3)/T=1585504254727, chunks=6, multiChunks=1, fileContents=2, fileHistories=2]
29-3-20 17:50:54.730 | UpOperation     | Test worker    | INFO : Saving local delta database, version syncanyclienttTXhJiZuuLqHpSmfKTUu/(syncanyclienttTXhJiZuuLqHpSmfKTUu3)/T=1585504254727 to file /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/.syncany/cache/database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000003 ... 
29-3-20 17:50:54.730 | UpOperation     | Test worker    | INFO : - Saving database to /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/.syncany/cache/database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000003 ...
29-3-20 17:50:54.732 | UpOperation     | Test worker    | INFO : - Uploading local delta database file ...
29-3-20 17:50:54.732 | UpOperation     | Test worker    | INFO : - Uploading /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/.syncany/cache/database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000003 to RemoteFile[name=database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000003] ...
29-3-20 17:50:54.736 | RemoteTransacti | Test worker    | INFO : - Adding file to TX for UPLOAD: /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/.syncany/cache/database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000003 -> Temp. remote file: RemoteFile[name=temp-Neiuc-database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000003], final location: RemoteFile[name=database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000003]
29-3-20 17:50:54.736 | UpOperation     | Test worker    | INFO : Adding shutdown hook (to allow resuming the upload) ...
29-3-20 17:50:54.736 | RemoteTransacti | Test worker    | INFO : Starting TX.commit() ...
29-3-20 17:50:54.740 | AsyncIndexer    | AsyncI/syncany | INFO : Stopping indexing. Signal end of stream with empty databaseversion
29-3-20 17:50:54.751 | RemoteTransacti | Test worker    | INFO : Wrote transaction manifest to temporary file: /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/.syncany/cache/temp-transaction-1762844335200221757.tmp
29-3-20 17:50:54.751 | InternalEventBu | Test worker    | INFO : Event bus 'LocalEventBus': Posting event UpUploadFileSyncExternalEvent (org.syncany.operations.daemon.messages.UpUploadFileSyncExternalEvent@4e38095e) ...
29-3-20 17:50:54.756 | RemoteTransacti | Test worker    | INFO : - Uploading remote transaction file RemoteFile[name=transaction-af21320] ...
29-3-20 17:50:54.756 | RemoteTransacti | Test worker    | INFO : - Starting to upload data in commit.
29-3-20 17:50:54.759 | InternalEventBu | Test worker    | INFO : Event bus 'LocalEventBus': Posting event UpUploadFileInTransactionSyncExternalEvent (org.syncany.operations.daemon.messages.UpUploadFileInTransactionSyncExternalEvent@5bb8185) ...
29-3-20 17:50:54.759 | RemoteTransacti | Test worker    | INFO : - Uploading /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/.syncany/cache/multichunk-5ceaa45913a3efd01a310e6cfe3f61f9d27ec292 to temp. file RemoteFile[name=temp-rQlsu-multichunk-5ceaa45913a3efd01a310e6cfe3f61f9d27ec292] ...
29-3-20 17:50:54.770 | InternalEventBu | Test worker    | INFO : Event bus 'LocalEventBus': Posting event UpUploadFileInTransactionSyncExternalEvent (org.syncany.operations.daemon.messages.UpUploadFileInTransactionSyncExternalEvent@6e2002c5) ...
29-3-20 17:50:54.772 | RemoteTransacti | Test worker    | INFO : - Uploading /tmp/syncanytest/syncany-200329175011381-61083-client-syncanyclient/.syncany/cache/database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000003 to temp. file RemoteFile[name=temp-Neiuc-database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000003] ...
29-3-20 17:50:54.774 | RemoteTransacti | Test worker    | INFO : - Moving temp. file RemoteFile[name=temp-rQlsu-multichunk-5ceaa45913a3efd01a310e6cfe3f61f9d27ec292] to final location RemoteFile[name=multichunk-5ceaa45913a3efd01a310e6cfe3f61f9d27ec292] ...
29-3-20 17:50:54.778 | RemoteTransacti | Test worker    | INFO : - Moving temp. file RemoteFile[name=temp-Neiuc-database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000003] to final location RemoteFile[name=database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000003] ...
29-3-20 17:50:54.779 | RemoteTransacti | Test worker    | INFO : - Deleting remote transaction file RemoteFile[name=transaction-af21320] ...
29-3-20 17:50:54.779 | RemoteTransacti | Test worker    | INFO : END of TX.commmit(): Succesfully committed transaction.
29-3-20 17:50:54.779 | RemoteTransacti | Test worker    | INFO : END of TX.delTemp(): Sucessfully deleted final files.
29-3-20 17:50:54.779 | UpOperation     | Test worker    | INFO : Persisting local SQL database (new database version syncanyclienttTXhJiZuuLqHpSmfKTUu/(syncanyclienttTXhJiZuuLqHpSmfKTUu3)/T=1585504254727) ...
29-3-20 17:50:54.795 | UpOperation     | Test worker    | INFO : Removing DIRTY database versions from database ...
29-3-20 17:50:54.809 | UpOperation     | Test worker    | INFO : Adding database version to result changes:DatabaseVersion [header=syncanyclienttTXhJiZuuLqHpSmfKTUu/(syncanyclienttTXhJiZuuLqHpSmfKTUu3)/T=1585504254727, chunks=6, multiChunks=1, fileContents=2, fileHistories=2]
29-3-20 17:50:54.809 | UpOperation     | Test worker    | INFO : Committing local database.
29-3-20 17:50:54.809 | UpOperation     | Test worker    | FINE : Waiting for new database version.
29-3-20 17:50:54.809 | UpOperation     | Test worker    | FINE : Took new database version: DatabaseVersion [header=UnknownMachine/()/T=1585504254740, chunks=0, multiChunks=0, fileContents=0, fileHistories=0]
29-3-20 17:50:54.809 | UpOperation     | Test worker    | INFO : Sync up done.
29-3-20 17:50:54.811 | ActionFileHandl | Test worker    | INFO : Finishing action for RemoteFile[name=action-up-syncanyclienttTXhJiZuuLqHpSmfKTUu-1585504253933] ...
29-3-20 17:50:54.818 | ActionFileHandl | Test worker    | INFO : Deleting action file: RemoteFile[name=action-up-syncanyclienttTXhJiZuuLqHpSmfKTUu-1585504253933]
29-3-20 17:50:54.818 | AbstractTransfe | Test worker    | INFO : Cleaning own old action files ...
29-3-20 17:50:54.819 | Cache           | Test worker    | INFO : Cache size okay (7392 KB), no need to clean (keep size is 500 MB)
29-3-20 17:50:54.819 | InternalEventBu | Test worker    | INFO : Event bus 'LocalEventBus': Posting event UpEndSyncExternalEvent (org.syncany.operations.daemon.messages.UpEndSyncExternalEvent@37f3c02) ...
29-3-20 17:50:54.819 | DatabaseXmlSeri | Test worker    | INFO : - Loading database (FULL) from file /tmp/syncanytest/syncany-200329175011381-61083-repo/databases/database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000001 ...
29-3-20 17:50:54.823 | DatabaseXmlPars | Test worker    | INFO :    + Added database version syncanyclienttTXhJiZuuLqHpSmfKTUu/(syncanyclienttTXhJiZuuLqHpSmfKTUu1)/T=1585504254295
29-3-20 17:50:54.823 | DatabaseXmlSeri | Test worker    | INFO : - Loading database (FULL) from file /tmp/syncanytest/syncany-200329175011381-61083-repo/databases/database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000002 ...
29-3-20 17:50:54.826 | DatabaseXmlPars | Test worker    | INFO :    + Added database version syncanyclienttTXhJiZuuLqHpSmfKTUu/(syncanyclienttTXhJiZuuLqHpSmfKTUu2)/T=1585504254523
29-3-20 17:50:54.826 | DatabaseXmlSeri | Test worker    | INFO : - Loading database (FULL) from file /tmp/syncanytest/syncany-200329175011381-61083-repo/databases/database-syncanyclienttTXhJiZuuLqHpSmfKTUu-0000000003 ...
29-3-20 17:50:54.830 | DatabaseXmlPars | Test worker    | INFO :    + Added database version syncanyclienttTXhJiZuuLqHpSmfKTUu/(syncanyclienttTXhJiZuuLqHpSmfKTUu3)/T=1585504254727
29-3-20 17:50:54.845 | NotificationLis | NotifyThread   | INFO : Connecting socket to notify.syncany.org:8080 ...
29-3-20 17:50:54.846 | NotificationLis | NotifyThread   | INFO : Connecting socket to notify.syncany.org:8080 ...
29-3-20 17:50:54.848 | DatabaseConnect | Test worker    | INFO : Found 12 tables.
29-3-20 17:50:54.863 | org.syncany.plu | Test worker    | FINE : Validating required fields
29-3-20 17:50:54.868 | LocalTransferMa | Test worker    | INFO : testTargetExists: Target exists.
29-3-20 17:50:54.907 | org.syncany.plu | Test worker    | FINE : Validating required fields
29-3-20 17:50:54.908 | TransferManager | Test worker    | INFO : Building LocalTransferManager from config 'syncany-200329175011381-10309-client-syncanyclient' ...
29-3-20 17:50:54.908 | TransferManager | Test worker    | INFO : - With feature ReadAfterWriteConsistent
29-3-20 17:50:54.908 | TransferManager | Test worker    | INFO : - With feature Retriable
29-3-20 17:50:54.908 | TransferManager | Test worker    | FINE : - Checking if selected features supported ...
29-3-20 17:50:54.908 | TransferManager | Test worker    | FINE : - Checking for duplicate features ...
29-3-20 17:50:54.909 | TransferManager | Test worker    | FINE : - Checking required feature TransactionAware in LocalTransferManager ...
29-3-20 17:50:54.909 | TransferManager | Test worker    | FINE : - Checking required feature Retriable in LocalTransferManager ...
29-3-20 17:50:54.909 | TransferManager | Test worker    | INFO : - SKIPPING unsupported optional feature ReadAfterWriteConsistent
29-3-20 17:50:54.909 | TransferManager | Test worker    | FINE : - Wrapping TransferManager LocalTransferManager in RetriableFeatureTransferManager
29-3-20 17:50:54.909 | org.syncany.plu | Test worker    | FINE : Validating required fields
29-3-20 17:50:54.910 | TransferManager | Test worker    | INFO : Building LocalTransferManager from config 'syncany-200329175011381-10309-client-syncanyclient' ...
29-3-20 17:50:54.910 | TransferManager | Test worker    | INFO : - With feature ReadAfterWriteConsistent
29-3-20 17:50:54.910 | TransferManager | Test worker    | INFO : - With feature Retriable
29-3-20 17:50:54.910 | TransferManager | Test worker    | INFO : - With feature PathAware
29-3-20 17:50:54.910 | TransferManager | Test worker    | INFO : - With feature TransactionAware
29-3-20 17:50:54.910 | TransferManager | Test worker    | FINE : - Checking if selected features supported ...
29-3-20 17:50:54.910 | TransferManager | Test worker    | FINE : - Checking for duplicate features ...
29-3-20 17:50:54.910 | TransferManager | Test worker    | FINE : - Checking required feature TransactionAware in LocalTransferManager ...
29-3-20 17:50:54.910 | TransferManager | Test worker    | FINE : - Checking required feature Retriable in LocalTransferManager ...
29-3-20 17:50:54.911 | TransferManager | Test worker    | INFO : - SKIPPING unsupported optional feature ReadAfterWriteConsistent
29-3-20 17:50:54.911 | TransferManager | Test worker    | FINE : - Wrapping TransferManager LocalTransferManager in RetriableFeatureTransferManager
29-3-20 17:50:54.911 | TransferManager | Test worker    | INFO : - SKIPPING unsupported optional feature PathAware
29-3-20 17:50:54.911 | TransferManager | Test worker    | FINE : - Wrapping TransferManager RetriableFeatureTransferManager in TransactionAwareFeatureTransferManager
29-3-20 17:50:54.931 | hsqldb.db.HSQLD | Test worker    | INFO : Checkpoint start
29-3-20 17:50:54.932 | hsqldb.db.HSQLD | Test worker    | INFO : checkpointClose start
29-3-20 17:50:54.944 | hsqldb.db.HSQLD | Test worker    | FINE : log close size: 0
29-3-20 17:50:54.946 | hsqldb.db.HSQLD | Test worker    | INFO : checkpointClose end
29-3-20 17:50:54.947 | hsqldb.db.HSQLD | Test worker    | INFO : Checkpoint end - txts: 1
29-3-20 17:50:54.948 | NotificationLis | NotifyThread   | FINE : Could not connect the socket
java.net.ConnectException: Connection refused (Connection refused)
	at java.base/java.net.PlainSocketImpl.socketConnect(Native Method)
	at java.base/java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:399)
	at java.base/java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:242)
	at java.base/java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:224)
	at java.base/java.net.SocksSocketImpl.connect(SocksSocketImpl.java:403)
	at java.base/java.net.Socket.connect(Socket.java:591)
	at java.base/java.net.Socket.connect(Socket.java:540)
	at java.base/java.net.Socket.<init>(Socket.java:436)
	at java.base/java.net.Socket.<init>(Socket.java:213)
	at org.syncany.operations.watch.NotificationListener.connect(NotificationListener.java:176)
	at org.syncany.operations.watch.NotificationListener.access$100(NotificationListener.java:61)
	at org.syncany.operations.watch.NotificationListener$SocketThread.run(NotificationListener.java:256)
29-3-20 17:50:54.949 | NotificationLis | NotifyThread   | INFO : Disconnecting socket ...
29-3-20 17:50:54.949 | NotificationLis | NotifyThread   | INFO : Re-subscribing to channels after broken connection ...
29-3-20 17:50:54.949 | NotificationLis | NotifyThread   | INFO : Subscribing to channel org.syncany.tests.integration.operations.NotificationListenerTest-845887340...
29-3-20 17:50:54.949 | NotificationLis | NotifyThread   | INFO : Sending failed and message already in queue: subscribe org.syncany.tests.integration.operations.NotificationListenerTest-845887340
29-3-20 17:50:54.950 | NotificationLis | NotifyThread   | INFO : Notification connection down: Socket closed, sleeping 5000ms, then trying a re-connect ...
29-3-20 17:50:54.949 | NotificationLis | NotifyThread   | FINE : Could not connect the socket
java.net.ConnectException: Connection refused (Connection refused)
	at java.base/java.net.PlainSocketImpl.socketConnect(Native Method)
	at java.base/java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:399)
	at java.base/java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:242)
	at java.base/java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:224)
	at java.base/java.net.SocksSocketImpl.connect(SocksSocketImpl.java:403)
	at java.base/java.net.Socket.connect(Socket.java:591)
	at java.base/java.net.Socket.connect(Socket.java:540)
	at java.base/java.net.Socket.<init>(Socket.java:436)
	at java.base/java.net.Socket.<init>(Socket.java:213)
	at org.syncany.operations.watch.NotificationListener.connect(NotificationListener.java:176)
	at org.syncany.operations.watch.NotificationListener.access$100(NotificationListener.java:61)
	at org.syncany.operations.watch.NotificationListener$SocketThread.run(NotificationListener.java:256)
29-3-20 17:50:54.950 | NotificationLis | NotifyThread   | INFO : Disconnecting socket ...
29-3-20 17:50:54.950 | NotificationLis | NotifyThread   | INFO : Re-subscribing to channels after broken connection ...
29-3-20 17:50:54.950 | NotificationLis | NotifyThread   | INFO : Subscribing to channel org.syncany.tests.integration.operations.NotificationListenerTest-845887340...
29-3-20 17:50:54.950 | NotificationLis | NotifyThread   | INFO : Sending failed and message already in queue: subscribe org.syncany.tests.integration.operations.NotificationListenerTest-845887340
29-3-20 17:50:54.950 | NotificationLis | NotifyThread   | INFO : Notification connection down: Socket closed, sleeping 5000ms, then trying a re-connect ...
29-3-20 17:50:54.953 | DatabaseConnect | Test worker    | INFO : Found 0 tables.
29-3-20 17:50:54.953 | DatabaseConnect | Test worker    | INFO : Database has no tables. Creating tables from script.create.all.sql
29-3-20 17:50:54.954 | SqlRunner       | Test worker    | INFO : SQL (comment): -- Tables
29-3-20 17:50:54.954 | SqlRunner       | Test worker    | INFO : SQL:  CREATE CACHED TABLE IF NOT EXISTS databaseversion ( id int NOT NULL IDENTITY, status varchar(45) NOT NULL, localtime datetime NOT NULL, client varchar(45) NOT NULL, vectorclock_serialized varchar(1024) NOT NULL, UNIQUE (vectorclock_serialized) ); 
29-3-20 17:50:54.961 | SqlRunner       | Test worker    | INFO : SQL:  CREATE CACHED TABLE IF NOT EXISTS  chunk ( checksum varchar(40) NOT NULL, databaseversion_id int NOT NULL, size bigint NOT NULL, PRIMARY KEY (checksum), FOREIGN KEY (databaseversion_id) REFERENCES databaseversion (id) ON DELETE NO ACTION ON UPDATE NO ACTION ); 
29-3-20 17:50:54.963 | SqlRunner       | Test worker    | INFO : SQL:  CREATE CACHED TABLE IF NOT EXISTS  databaseversion_vectorclock ( databaseversion_id int NOT NULL, client varchar(45) NOT NULL, logicaltime int NOT NULL, PRIMARY KEY (databaseversion_id, client), FOREIGN KEY (databaseversion_id) REFERENCES databaseversion (id) ON DELETE NO ACTION ON UPDATE NO ACTION ); 
29-3-20 17:50:54.964 | SqlRunner       | Test worker    | INFO : SQL:  CREATE CACHED TABLE IF NOT EXISTS  filecontent ( checksum varchar(40) NOT NULL, databaseversion_id int NOT NULL, size bigint NOT NULL, PRIMARY KEY (checksum), FOREIGN KEY (databaseversion_id) REFERENCES databaseversion (id) ON DELETE NO ACTION ON UPDATE NO ACTION ); 
29-3-20 17:50:54.966 | SqlRunner       | Test worker    | INFO : SQL:  CREATE CACHED TABLE IF NOT EXISTS  filecontent_chunk ( filecontent_checksum varchar(40) NOT NULL, chunk_checksum varchar(40) NOT NULL, num int NOT NULL, PRIMARY KEY (filecontent_checksum, chunk_checksum, num), FOREIGN KEY (filecontent_checksum) REFERENCES filecontent (checksum) ON DELETE NO ACTION ON UPDATE NO ACTION, FOREIGN KEY (chunk_checksum) REFERENCES chunk (checksum) ON DELETE NO ACTION ON UPDATE NO ACTION ); 
29-3-20 17:50:54.968 | SqlRunner       | Test worker    | INFO : SQL:  CREATE CACHED TABLE IF NOT EXISTS  filehistory ( id varchar(40) NOT NULL, databaseversion_id int NOT NULL, PRIMARY KEY (id, databaseversion_id), FOREIGN KEY (databaseversion_id) REFERENCES databaseversion (id) ON DELETE NO ACTION ON UPDATE NO ACTION ); 
29-3-20 17:50:54.970 | SqlRunner       | Test worker    | INFO : SQL:  CREATE CACHED TABLE IF NOT EXISTS  fileversion ( filehistory_id varchar(40) NOT NULL, version int NOT NULL, databaseversion_id int NOT NULL, path varchar(1024) NOT NULL, type varchar(45) NOT NULL, status varchar(45) NOT NULL, size bigint NOT NULL, lastmodified datetime NOT NULL, linktarget varchar(1024), filecontent_checksum varchar(40) DEFAULT NULL, updated datetime NOT NULL, posixperms varchar(45) DEFAULT NULL, dosattrs varchar(45) DEFAULT NULL, PRIMARY KEY (filehistory_id, version, databaseversion_id), FOREIGN KEY (filehistory_id, databaseversion_id) REFERENCES filehistory (id, databaseversion_id) ON DELETE NO ACTION ON UPDATE NO ACTION, FOREIGN KEY (filecontent_checksum) REFERENCES filecontent (checksum) ON DELETE NO ACTION ON UPDATE NO ACTION ); 
29-3-20 17:50:54.972 | SqlRunner       | Test worker    | INFO : SQL:  CREATE CACHED TABLE IF NOT EXISTS  multichunk ( id varchar(40) NOT NULL, databaseversion_id int NOT NULL, size bigint NOT NULL, PRIMARY KEY (id), FOREIGN KEY (databaseversion_id) REFERENCES databaseversion (id) ON DELETE NO ACTION ON UPDATE NO ACTION ); 
29-3-20 17:50:54.974 | SqlRunner       | Test worker    | INFO : SQL:  CREATE CACHED TABLE IF NOT EXISTS  multichunk_chunk ( multichunk_id varchar(40) NOT NULL, chunk_checksum varchar(40) NOT NULL, PRIMARY KEY (multichunk_id, chunk_checksum), FOREIGN KEY (multichunk_id) REFERENCES multichunk (id) ON DELETE NO ACTION ON UPDATE NO ACTION, FOREIGN KEY (chunk_checksum) REFERENCES chunk (checksum) ON DELETE NO ACTION ON UPDATE NO ACTION ); 
29-3-20 17:50:54.976 | SqlRunner       | Test worker    | INFO : SQL:  CREATE CACHED TABLE IF NOT EXISTS  multichunk_muddy ( id varchar(40) NOT NULL, machine_name varchar(255) NOT NULL, machine_version int NOT NULL, PRIMARY KEY (id) ); 
29-3-20 17:50:54.978 | SqlRunner       | Test worker    | INFO : SQL:  CREATE CACHED TABLE IF NOT EXISTS  known_databases ( id int NOT NULL IDENTITY, client varchar(45) NOT NULL, filenumber int NOT NULL, UNIQUE (client, filenumber) ); 
29-3-20 17:50:54.980 | SqlRunner       | Test worker    | INFO : SQL:  CREATE CACHED TABLE IF NOT EXISTS  general_settings ( key varchar(255) NOT NULL, value varchar(255) NOT NULL, PRIMARY KEY (key) ); 
29-3-20 17:50:54.981 | SqlRunner       | Test worker    | INFO : SQL (comment): -- Non-primary indices
29-3-20 17:50:54.981 | SqlRunner       | Test worker    | INFO : SQL:   CREATE INDEX idx_databaseversion_status ON databaseversion (status); 
29-3-20 17:50:54.982 | hsqldb.db.HSQLD | Test worker    | INFO : dataFileCache open start
29-3-20 17:50:54.984 | hsqldb.db.HSQLD | Test worker    | INFO : dataFileCache open end
29-3-20 17:50:54.985 | SqlRunner       | Test worker    | INFO : SQL: CREATE INDEX idx_databaseversion_vectorclock_serialized ON databaseversion (vectorclock_serialized); 
29-3-20 17:50:54.987 | SqlRunner       | Test worker    | INFO : SQL: CREATE INDEX idx_fileversion_path ON fileversion (path); 
29-3-20 17:50:54.988 | SqlRunner       | Test worker    | INFO : SQL: CREATE INDEX idx_fileversion_status ON fileversion (status); 
29-3-20 17:50:54.989 | SqlRunner       | Test worker    | INFO : SQL: CREATE INDEX idx_fileversion_filecontent_checksum ON fileversion (filecontent_checksum); 
29-3-20 17:50:54.991 | SqlRunner       | Test worker    | INFO : SQL (comment): -- Views
29-3-20 17:50:54.991 | SqlRunner       | Test worker    | INFO : SQL:    CREATE VIEW databaseversion_master AS SELECT dbv.*, vc.logicaltime as client_version FROM databaseversion dbv JOIN databaseversion_vectorclock vc on dbv.id=vc.databaseversion_id and dbv.client=vc.client WHERE dbv.status='MASTER'; 
29-3-20 17:50:54.993 | SqlRunner       | Test worker    | INFO : SQL:  CREATE VIEW fileversion_master AS SELECT fv0.* FROM fileversion fv0 JOIN databaseversion dbv ON fv0.databaseversion_id=dbv.id AND dbv.status='MASTER'; 
29-3-20 17:50:54.995 | SqlRunner       | Test worker    | INFO : SQL:  CREATE VIEW fileversion_master_maxversion AS SELECT DISTINCT filehistory_id, MAX(version) version FROM fileversion_master GROUP BY filehistory_id; 
29-3-20 17:50:54.997 | SqlRunner       | Test worker    | INFO : SQL:  CREATE VIEW fileversion_master_last AS SELECT fv.* FROM fileversion_master_maxversion fvmax JOIN fileversion_master fv ON fvmax.filehistory_id=fv.filehistory_id AND fvmax.version=fv.version WHERE fv.status<>'DELETED'; 
29-3-20 17:50:55.000 | SqlRunner       | Test worker    | INFO : SQL (comment): -- Full Views
29-3-20 17:50:55.000 | SqlRunner       | Test worker    | INFO : SQL:    create view filehistory_full as select dbv.status as databaseversion_status, dbv.localtime as databaseversion_localtime, dbv.client as databaseversion_client, dbv.vectorclock_serialized as databaseversion_vectorclock_serialized, fh.* from databaseversion dbv join filehistory fh on dbv.id=fh.databaseversion_id; 
29-3-20 17:50:55.002 | SqlRunner       | Test worker    | INFO : SQL:  create view fileversion_full as select fhf.databaseversion_status, fhf.databaseversion_localtime, fhf.databaseversion_client, fhf.databaseversion_vectorclock_serialized, fv.* from filehistory_full fhf join fileversion fv on fhf.id=fv.filehistory_id and fhf.databaseversion_id=fv.databaseversion_id; 
29-3-20 17:50:55.004 | SqlRunner       | Test worker    | INFO : SQL (comment): -- Functions
29-3-20 17:50:55.004 | SqlRunner       | Test worker    | INFO : SQL (new delimiter): end;
29-3-20 17:50:55.004 | SqlRunner       | Test worker    | INFO : SQL:     create function substr_count(haystack varchar(255), needle varchar(255)) returns integer begin atomic declare strCount integer; declare lastIndex integer;  set strCount = 0; set lastIndex = 1;  while lastIndex <> 0 do set lastIndex = locate(needle, haystack, lastIndex);  if lastIndex <> 0 then set strCount = strCount + 1; set lastIndex = lastIndex + length(needle); end if; end while;  return strCount; end; 
29-3-20 17:50:55.007 | UpOperation     | Test worker    | INFO : 
29-3-20 17:50:55.007 | UpOperation     | Test worker    | INFO : Running 'Sync up' at client syncanyclientUWTtvoJlQUepTTwSVMOO ...
29-3-20 17:50:55.007 | UpOperation     | Test worker    | INFO : --------------------------------------------
29-3-20 17:50:55.007 | InternalEventBu | Test worker    | INFO : Event bus 'LocalEventBus': Posting event UpStartSyncExternalEvent (org.syncany.operations.daemon.messages.UpStartSyncExternalEvent@6edbe20e) ...
29-3-20 17:50:55.008 | DatabaseConnect | Test worker    | INFO : Found 12 tables.
29-3-20 17:50:55.008 | StatusOperation | Test worker    | INFO : 
29-3-20 17:50:55.008 | StatusOperation | Test worker    | INFO : Running 'Status' at client syncanyclientUWTtvoJlQUepTTwSVMOO ...
29-3-20 17:50:55.009 | StatusOperation | Test worker    | INFO : --------------------------------------------
29-3-20 17:50:55.009 | StatusOperation | Test worker    | INFO : Querying current file tree from database ...
29-3-20 17:50:55.009 | InternalEventBu | Test worker    | INFO : Event bus 'LocalEventBus': Posting event StatusStartSyncExternalEvent (org.syncany.operations.daemon.messages.StatusStartSyncExternalEvent@4e17b4cb) ...
29-3-20 17:50:55.010 | StatusOperation | Test worker    | INFO : Analyzing local folder /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient ...
29-3-20 17:50:55.010 | StatusOperation | Test worker    | FINE : - New file: rndFile-1585504254893-1923764931.dat
29-3-20 17:50:55.011 | StatusOperation | Test worker    | FINE : - New file: rndFile-1585504254900-438542125.dat
29-3-20 17:50:55.011 | StatusOperation | Test worker    | FINE : - Ignoring file (syncany app-related): .syncany
29-3-20 17:50:55.011 | StatusOperation | Test worker    | FINE : - New file: rndFile-1585504254886-1106190920.dat
29-3-20 17:50:55.012 | InternalEventBu | Test worker    | INFO : Event bus 'LocalEventBus': Posting event StatusEndSyncExternalEvent (org.syncany.operations.daemon.messages.StatusEndSyncExternalEvent@31b081a8) ...
29-3-20 17:50:55.012 | AbstractTransfe | Test worker    | INFO : Looking for other running remote operations ...
29-3-20 17:50:55.015 | DatabaseConnect | Test worker    | INFO : Found 12 tables.
29-3-20 17:50:55.015 | LsRemoteOperati | Test worker    | INFO : 
29-3-20 17:50:55.015 | LsRemoteOperati | Test worker    | INFO : Running 'Remote Status' at client syncanyclientUWTtvoJlQUepTTwSVMOO ...
29-3-20 17:50:55.016 | LsRemoteOperati | Test worker    | INFO : --------------------------------------------
29-3-20 17:50:55.016 | InternalEventBu | Test worker    | INFO : Event bus 'LocalEventBus': Posting event LsRemoteStartSyncExternalEvent (org.syncany.operations.daemon.messages.LsRemoteStartSyncExternalEvent@3c3fb668) ...
29-3-20 17:50:55.016 | LsRemoteOperati | Test worker    | INFO : Retrieving remote database list.
29-3-20 17:50:55.016 | InternalEventBu | Test worker    | INFO : Event bus 'LocalEventBus': Posting event LsRemoteEndSyncExternalEvent (org.syncany.operations.daemon.messages.LsRemoteEndSyncExternalEvent@65260800) ...
29-3-20 17:50:55.017 | UpOperation     | Test worker    | INFO : No remote changes, ready to upload.
29-3-20 17:50:55.017 | ActionFileHandl | Test worker    | INFO : Starting action for RemoteFile[name=action-up-syncanyclientUWTtvoJlQUepTTwSVMOO-1585504254911] ...
29-3-20 17:50:55.017 | ActionFileHandl | Test worker    | INFO : Uploading action file: RemoteFile[name=action-up-syncanyclientUWTtvoJlQUepTTwSVMOO-1585504254911]
29-3-20 17:50:55.017 | ActionFileHandl | Test worker    | INFO : Scheduling action renewal task for every 2 minutes, for RemoteFile[name=action-up-syncanyclientUWTtvoJlQUepTTwSVMOO-1585504254911] ...
29-3-20 17:50:55.020 | DatabaseConnect | Test worker    | INFO : Found 12 tables.
29-3-20 17:50:55.028 | TransactionAwar | Test worker    | INFO : Done rolling back previous transactions.
29-3-20 17:50:55.028 | AsyncIndexer    | AsyncI/syncany | INFO : Starting Indexing.
29-3-20 17:50:55.028 | InternalEventBu | AsyncI/syncany | INFO : Event bus 'LocalEventBus': Posting event UpIndexStartSyncExternalEvent (org.syncany.operations.daemon.messages.UpIndexStartSyncExternalEvent@708a936) ...
29-3-20 17:50:55.029 | Indexer         | AsyncI/syncany | FINE : - Looking for deleted files ...
29-3-20 17:50:55.029 | Indexer         | AsyncI/syncany | FINE : - +File /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/rndFile-1585504254886-1106190920.dat
29-3-20 17:50:55.029 | Indexer         | AsyncI/syncany | FINE : - +FileContent: /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/rndFile-1585504254886-1106190920.dat
29-3-20 17:50:55.037 | Indexer         | AsyncI/syncany | FINE : - Chunk new: cca3455ce060f3664a6fd02953f7e98135749988
29-3-20 17:50:55.037 | Indexer         | AsyncI/syncany | FINE : - +MultiChunk f15bd0927410670eb543495d6477df2665302ed1
29-3-20 17:50:55.044 | Indexer         | AsyncI/syncany | FINE : - Chunk > MultiChunk: cca3455ce060f3664a6fd02953f7e98135749988 > f15bd0927410670eb543495d6477df2665302ed1
29-3-20 17:50:55.044 | Indexer         | AsyncI/syncany | FINE : - Chunk > FileContent: cca3455ce060f3664a6fd02953f7e98135749988 > /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/rndFile-1585504254886-1106190920.dat
29-3-20 17:50:55.050 | Indexer         | AsyncI/syncany | FINE : - Chunk new: 6200fed30184ead51998be84870c7ff649809ef2
29-3-20 17:50:55.054 | Indexer         | AsyncI/syncany | FINE : - Chunk > MultiChunk: 6200fed30184ead51998be84870c7ff649809ef2 > f15bd0927410670eb543495d6477df2665302ed1
29-3-20 17:50:55.054 | Indexer         | AsyncI/syncany | FINE : - Chunk > FileContent: 6200fed30184ead51998be84870c7ff649809ef2 > /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/rndFile-1585504254886-1106190920.dat
29-3-20 17:50:55.056 | Indexer         | AsyncI/syncany | FINE : - Chunk new: 5483478596d5f34d3f680996640f2f4a08780e21
29-3-20 17:50:55.057 | Indexer         | AsyncI/syncany | FINE : - Chunk > MultiChunk: 5483478596d5f34d3f680996640f2f4a08780e21 > f15bd0927410670eb543495d6477df2665302ed1
29-3-20 17:50:55.057 | Indexer         | AsyncI/syncany | FINE : - Chunk > FileContent: 5483478596d5f34d3f680996640f2f4a08780e21 > /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/rndFile-1585504254886-1106190920.dat
29-3-20 17:50:55.057 | Indexer         | AsyncI/syncany | FINE : - /File: rndFile-1585504254886-1106190920.dat (checksum ef7e429cbdcdc2f8200e8309231d5047116ecdf7)
29-3-20 17:50:55.059 | Indexer         | AsyncI/syncany | FINE :    * No old file history found, starting new history (path: rndFile-1585504254886-1106190920.dat, checksum: ef7e429cbdcdc2f8200e8309231d5047116ecdf7)
29-3-20 17:50:55.059 | FileVersionComp | AsyncI/syncany | INFO :      - [DELETED]: Local file DIFFERS from file version, actual file is NULL, for file rndFile-1585504254886-1106190920.dat
29-3-20 17:50:55.059 | Indexer         | AsyncI/syncany | INFO :    * Added file version:    FileVersion [version=1, path=rndFile-1585504254886-1106190920.dat, type=FILE, status=NEW, size=1259520, lastModified=Sun Mar 29 17:50:54 UTC 2020, linkTarget=null, checksum=ef7e429cbdcdc2f8200e8309231d5047116ecdf7, updated=Sun Mar 29 17:50:55 UTC 2020, posixPermissions=rw-rw-r--, dosAttributes=--a-]
29-3-20 17:50:55.059 | Indexer         | AsyncI/syncany | INFO :      based on file version: null
29-3-20 17:50:55.059 | InternalEventBu | AsyncI/syncany | INFO : Event bus 'LocalEventBus': Posting event UpIndexChangesDetectedSyncExternalEvent (org.syncany.operations.daemon.messages.UpIndexChangesDetectedSyncExternalEvent@269ca53e) ...
29-3-20 17:50:55.060 | Indexer         | AsyncI/syncany | FINE : - /MultiChunk f15bd0927410670eb543495d6477df2665302ed1
29-3-20 17:50:55.061 | Indexer         | AsyncI/syncany | FINE : Processed new database version: DatabaseVersion [header=UnknownMachine/()/T=1585504255028, chunks=3, multiChunks=1, fileContents=1, fileHistories=1]
29-3-20 17:50:55.061 | UpOperation     | Test worker    | INFO : No DIRTY data found in database (no dirty databases); Nothing to do here.
29-3-20 17:50:55.061 | UpOperation     | Test worker    | INFO : Last vector clock was: ()
29-3-20 17:50:55.062 | UpOperation     | Test worker    | INFO : Uploading new multichunks ...
29-3-20 17:50:55.062 | UpOperation     | Test worker    | INFO : - Uploading multichunk f15bd0927410670eb543495d6477df2665302ed1 from /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/.syncany/cache/multichunk-f15bd0927410670eb543495d6477df2665302ed1 to RemoteFile[name=multichunk-f15bd0927410670eb543495d6477df2665302ed1] ...
29-3-20 17:50:55.062 | RemoteTransacti | Test worker    | INFO : - Adding file to TX for UPLOAD: /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/.syncany/cache/multichunk-f15bd0927410670eb543495d6477df2665302ed1 -> Temp. remote file: RemoteFile[name=temp-OBYto-multichunk-f15bd0927410670eb543495d6477df2665302ed1], final location: RemoteFile[name=multichunk-f15bd0927410670eb543495d6477df2665302ed1]
29-3-20 17:50:55.062 | UpOperation     | Test worker    | INFO : Uploading database: DatabaseVersion [header=syncanyclientUWTtvoJlQUepTTwSVMOO/(syncanyclientUWTtvoJlQUepTTwSVMOO1)/T=1585504255062, chunks=3, multiChunks=1, fileContents=1, fileHistories=1]
29-3-20 17:50:55.063 | UpOperation     | Test worker    | INFO : Saving local delta database, version syncanyclientUWTtvoJlQUepTTwSVMOO/(syncanyclientUWTtvoJlQUepTTwSVMOO1)/T=1585504255062 to file /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/.syncany/cache/database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000001 ... 
29-3-20 17:50:55.063 | UpOperation     | Test worker    | INFO : - Saving database to /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/.syncany/cache/database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000001 ...
29-3-20 17:50:55.064 | UpOperation     | Test worker    | INFO : - Uploading local delta database file ...
29-3-20 17:50:55.064 | UpOperation     | Test worker    | INFO : - Uploading /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/.syncany/cache/database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000001 to RemoteFile[name=database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000001] ...
29-3-20 17:50:55.064 | RemoteTransacti | Test worker    | INFO : - Adding file to TX for UPLOAD: /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/.syncany/cache/database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000001 -> Temp. remote file: RemoteFile[name=temp-XUzQZ-database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000001], final location: RemoteFile[name=database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000001]
29-3-20 17:50:55.064 | UpOperation     | Test worker    | INFO : Adding shutdown hook (to allow resuming the upload) ...
29-3-20 17:50:55.064 | RemoteTransacti | Test worker    | INFO : Starting TX.commit() ...
29-3-20 17:50:55.067 | RemoteTransacti | Test worker    | INFO : Wrote transaction manifest to temporary file: /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/.syncany/cache/temp-transaction-490083789611663596.tmp
29-3-20 17:50:55.067 | InternalEventBu | Test worker    | INFO : Event bus 'LocalEventBus': Posting event UpUploadFileSyncExternalEvent (org.syncany.operations.daemon.messages.UpUploadFileSyncExternalEvent@22e692df) ...
29-3-20 17:50:55.067 | RemoteTransacti | Test worker    | INFO : - Uploading remote transaction file RemoteFile[name=transaction-1128cb2e] ...
29-3-20 17:50:55.067 | RemoteTransacti | Test worker    | INFO : - Starting to upload data in commit.
29-3-20 17:50:55.068 | InternalEventBu | Test worker    | INFO : Event bus 'LocalEventBus': Posting event UpUploadFileInTransactionSyncExternalEvent (org.syncany.operations.daemon.messages.UpUploadFileInTransactionSyncExternalEvent@7884581d) ...
29-3-20 17:50:55.068 | RemoteTransacti | Test worker    | INFO : - Uploading /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/.syncany/cache/multichunk-f15bd0927410670eb543495d6477df2665302ed1 to temp. file RemoteFile[name=temp-OBYto-multichunk-f15bd0927410670eb543495d6477df2665302ed1] ...
29-3-20 17:50:55.071 | InternalEventBu | AsyncI/syncany | INFO : Event bus 'LocalEventBus': Posting event UpIndexMidSyncExternalEvent (org.syncany.operations.daemon.messages.UpIndexMidSyncExternalEvent@7b27ba08) ...
29-3-20 17:50:55.071 | Indexer         | AsyncI/syncany | FINE : - +File /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/rndFile-1585504254893-1923764931.dat
29-3-20 17:50:55.071 | Indexer         | AsyncI/syncany | FINE : - +FileContent: /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/rndFile-1585504254893-1923764931.dat
29-3-20 17:50:55.078 | InternalEventBu | Test worker    | INFO : Event bus 'LocalEventBus': Posting event UpUploadFileInTransactionSyncExternalEvent (org.syncany.operations.daemon.messages.UpUploadFileInTransactionSyncExternalEvent@67882767) ...
29-3-20 17:50:55.078 | RemoteTransacti | Test worker    | INFO : - Uploading /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/.syncany/cache/database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000001 to temp. file RemoteFile[name=temp-XUzQZ-database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000001] ...
29-3-20 17:50:55.080 | RemoteTransacti | Test worker    | INFO : - Moving temp. file RemoteFile[name=temp-OBYto-multichunk-f15bd0927410670eb543495d6477df2665302ed1] to final location RemoteFile[name=multichunk-f15bd0927410670eb543495d6477df2665302ed1] ...
29-3-20 17:50:55.080 | RemoteTransacti | Test worker    | INFO : - Moving temp. file RemoteFile[name=temp-XUzQZ-database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000001] to final location RemoteFile[name=database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000001] ...
29-3-20 17:50:55.081 | RemoteTransacti | Test worker    | INFO : - Deleting remote transaction file RemoteFile[name=transaction-1128cb2e] ...
29-3-20 17:50:55.081 | RemoteTransacti | Test worker    | INFO : END of TX.commmit(): Succesfully committed transaction.
29-3-20 17:50:55.081 | RemoteTransacti | Test worker    | INFO : END of TX.delTemp(): Sucessfully deleted final files.
29-3-20 17:50:55.081 | Indexer         | AsyncI/syncany | FINE : - Chunk new: 94c9ee0dbe6534b410a931241c8ae1ba3b8551c4
29-3-20 17:50:55.081 | UpOperation     | Test worker    | INFO : Persisting local SQL database (new database version syncanyclientUWTtvoJlQUepTTwSVMOO/(syncanyclientUWTtvoJlQUepTTwSVMOO1)/T=1585504255062) ...
29-3-20 17:50:55.082 | Indexer         | AsyncI/syncany | FINE : - +MultiChunk 33e2948f7b9f79162921f0c6c37c7880e0dde8a4
29-3-20 17:50:55.088 | Indexer         | AsyncI/syncany | FINE : - Chunk > MultiChunk: 94c9ee0dbe6534b410a931241c8ae1ba3b8551c4 > 33e2948f7b9f79162921f0c6c37c7880e0dde8a4
29-3-20 17:50:55.088 | Indexer         | AsyncI/syncany | FINE : - Chunk > FileContent: 94c9ee0dbe6534b410a931241c8ae1ba3b8551c4 > /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/rndFile-1585504254893-1923764931.dat
29-3-20 17:50:55.090 | UpOperation     | Test worker    | INFO : Removing DIRTY database versions from database ...
29-3-20 17:50:55.100 | UpOperation     | Test worker    | INFO : Adding database version to result changes:DatabaseVersion [header=syncanyclientUWTtvoJlQUepTTwSVMOO/(syncanyclientUWTtvoJlQUepTTwSVMOO1)/T=1585504255062, chunks=3, multiChunks=1, fileContents=1, fileHistories=1]
29-3-20 17:50:55.100 | UpOperation     | Test worker    | INFO : Committing local database.
29-3-20 17:50:55.100 | UpOperation     | Test worker    | FINE : Waiting for new database version.
29-3-20 17:50:55.102 | Indexer         | AsyncI/syncany | FINE : - Chunk new: e58418f25c55c9b0f1e4f82a019c63cb2b2942b8
29-3-20 17:50:55.106 | Indexer         | AsyncI/syncany | FINE : - Chunk > MultiChunk: e58418f25c55c9b0f1e4f82a019c63cb2b2942b8 > 33e2948f7b9f79162921f0c6c37c7880e0dde8a4
29-3-20 17:50:55.106 | Indexer         | AsyncI/syncany | FINE : - Chunk > FileContent: e58418f25c55c9b0f1e4f82a019c63cb2b2942b8 > /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/rndFile-1585504254893-1923764931.dat
29-3-20 17:50:55.108 | Indexer         | AsyncI/syncany | FINE : - Chunk new: a971097b64bd7a70ec0a092c8ea28639cf5838e5
29-3-20 17:50:55.110 | Indexer         | AsyncI/syncany | FINE : - Chunk > MultiChunk: a971097b64bd7a70ec0a092c8ea28639cf5838e5 > 33e2948f7b9f79162921f0c6c37c7880e0dde8a4
29-3-20 17:50:55.110 | Indexer         | AsyncI/syncany | FINE : - Chunk > FileContent: a971097b64bd7a70ec0a092c8ea28639cf5838e5 > /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/rndFile-1585504254893-1923764931.dat
29-3-20 17:50:55.110 | Indexer         | AsyncI/syncany | FINE : - /File: rndFile-1585504254893-1923764931.dat (checksum da4cc94e69e0e700f55ba2782c5bd7204290ece9)
29-3-20 17:50:55.111 | Indexer         | AsyncI/syncany | FINE :    * No old file history found, starting new history (path: rndFile-1585504254893-1923764931.dat, checksum: da4cc94e69e0e700f55ba2782c5bd7204290ece9)
29-3-20 17:50:55.111 | FileVersionComp | AsyncI/syncany | INFO :      - [DELETED]: Local file DIFFERS from file version, actual file is NULL, for file rndFile-1585504254893-1923764931.dat
29-3-20 17:50:55.111 | Indexer         | AsyncI/syncany | INFO :    * Added file version:    FileVersion [version=1, path=rndFile-1585504254893-1923764931.dat, type=FILE, status=NEW, size=1259520, lastModified=Sun Mar 29 17:50:54 UTC 2020, linkTarget=null, checksum=da4cc94e69e0e700f55ba2782c5bd7204290ece9, updated=Sun Mar 29 17:50:55 UTC 2020, posixPermissions=rw-rw-r--, dosAttributes=--a-]
29-3-20 17:50:55.111 | Indexer         | AsyncI/syncany | INFO :      based on file version: null
29-3-20 17:50:55.111 | InternalEventBu | AsyncI/syncany | INFO : Event bus 'LocalEventBus': Posting event UpIndexChangesDetectedSyncExternalEvent (org.syncany.operations.daemon.messages.UpIndexChangesDetectedSyncExternalEvent@69fc7b0f) ...
29-3-20 17:50:55.112 | Indexer         | AsyncI/syncany | FINE : - /MultiChunk 33e2948f7b9f79162921f0c6c37c7880e0dde8a4
29-3-20 17:50:55.112 | Indexer         | AsyncI/syncany | FINE : Processed new database version: DatabaseVersion [header=UnknownMachine/()/T=1585504255071, chunks=3, multiChunks=1, fileContents=1, fileHistories=1]
29-3-20 17:50:55.112 | InternalEventBu | AsyncI/syncany | INFO : Event bus 'LocalEventBus': Posting event UpIndexMidSyncExternalEvent (org.syncany.operations.daemon.messages.UpIndexMidSyncExternalEvent@33c58bcc) ...
29-3-20 17:50:55.116 | UpOperation     | Test worker    | FINE : Took new database version: DatabaseVersion [header=UnknownMachine/()/T=1585504255071, chunks=3, multiChunks=1, fileContents=1, fileHistories=1]
29-3-20 17:50:55.118 | Indexer         | AsyncI/syncany | FINE : - +File /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/rndFile-1585504254900-438542125.dat
29-3-20 17:50:55.119 | Indexer         | AsyncI/syncany | FINE : - +FileContent: /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/rndFile-1585504254900-438542125.dat
29-3-20 17:50:55.119 | UpOperation     | Test worker    | INFO : Last vector clock was: (syncanyclientUWTtvoJlQUepTTwSVMOO1)
29-3-20 17:50:55.120 | UpOperation     | Test worker    | INFO : Uploading new multichunks ...
29-3-20 17:50:55.120 | UpOperation     | Test worker    | INFO : - Uploading multichunk 33e2948f7b9f79162921f0c6c37c7880e0dde8a4 from /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/.syncany/cache/multichunk-33e2948f7b9f79162921f0c6c37c7880e0dde8a4 to RemoteFile[name=multichunk-33e2948f7b9f79162921f0c6c37c7880e0dde8a4] ...
29-3-20 17:50:55.120 | RemoteTransacti | Test worker    | INFO : - Adding file to TX for UPLOAD: /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/.syncany/cache/multichunk-33e2948f7b9f79162921f0c6c37c7880e0dde8a4 -> Temp. remote file: RemoteFile[name=temp-IesGs-multichunk-33e2948f7b9f79162921f0c6c37c7880e0dde8a4], final location: RemoteFile[name=multichunk-33e2948f7b9f79162921f0c6c37c7880e0dde8a4]
29-3-20 17:50:55.121 | UpOperation     | Test worker    | INFO : Uploading database: DatabaseVersion [header=syncanyclientUWTtvoJlQUepTTwSVMOO/(syncanyclientUWTtvoJlQUepTTwSVMOO2)/T=1585504255120, chunks=3, multiChunks=1, fileContents=1, fileHistories=1]
29-3-20 17:50:55.121 | UpOperation     | Test worker    | INFO : Saving local delta database, version syncanyclientUWTtvoJlQUepTTwSVMOO/(syncanyclientUWTtvoJlQUepTTwSVMOO2)/T=1585504255120 to file /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/.syncany/cache/database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000002 ... 
29-3-20 17:50:55.121 | UpOperation     | Test worker    | INFO : - Saving database to /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/.syncany/cache/database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000002 ...
29-3-20 17:50:55.123 | UpOperation     | Test worker    | INFO : - Uploading local delta database file ...
29-3-20 17:50:55.123 | UpOperation     | Test worker    | INFO : - Uploading /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/.syncany/cache/database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000002 to RemoteFile[name=database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000002] ...
29-3-20 17:50:55.124 | RemoteTransacti | Test worker    | INFO : - Adding file to TX for UPLOAD: /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/.syncany/cache/database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000002 -> Temp. remote file: RemoteFile[name=temp-vuvFz-database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000002], final location: RemoteFile[name=database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000002]
29-3-20 17:50:55.124 | UpOperation     | Test worker    | INFO : Adding shutdown hook (to allow resuming the upload) ...
29-3-20 17:50:55.126 | RemoteTransacti | Test worker    | INFO : Starting TX.commit() ...
29-3-20 17:50:55.127 | Indexer         | AsyncI/syncany | FINE : - Chunk new: 6ee931331670ef1382f712015ad1068fdfe5638f
29-3-20 17:50:55.128 | Indexer         | AsyncI/syncany | FINE : - +MultiChunk 8d6682887b15713c1178971bb75e877e6e4e9d46
29-3-20 17:50:55.129 | RemoteTransacti | Test worker    | INFO : Wrote transaction manifest to temporary file: /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/.syncany/cache/temp-transaction-2020817532401814611.tmp
29-3-20 17:50:55.130 | InternalEventBu | Test worker    | INFO : Event bus 'LocalEventBus': Posting event UpUploadFileSyncExternalEvent (org.syncany.operations.daemon.messages.UpUploadFileSyncExternalEvent@4d0ac904) ...
29-3-20 17:50:55.130 | RemoteTransacti | Test worker    | INFO : - Uploading remote transaction file RemoteFile[name=transaction-760c1fd2] ...
29-3-20 17:50:55.132 | RemoteTransacti | Test worker    | INFO : - Starting to upload data in commit.
29-3-20 17:50:55.132 | InternalEventBu | Test worker    | INFO : Event bus 'LocalEventBus': Posting event UpUploadFileInTransactionSyncExternalEvent (org.syncany.operations.daemon.messages.UpUploadFileInTransactionSyncExternalEvent@5becf655) ...
29-3-20 17:50:55.132 | RemoteTransacti | Test worker    | INFO : - Uploading /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/.syncany/cache/multichunk-33e2948f7b9f79162921f0c6c37c7880e0dde8a4 to temp. file RemoteFile[name=temp-IesGs-multichunk-33e2948f7b9f79162921f0c6c37c7880e0dde8a4] ...
29-3-20 17:50:55.134 | InternalEventBu | Test worker    | INFO : Event bus 'LocalEventBus': Posting event UpUploadFileInTransactionSyncExternalEvent (org.syncany.operations.daemon.messages.UpUploadFileInTransactionSyncExternalEvent@7ab56e08) ...
29-3-20 17:50:55.135 | RemoteTransacti | Test worker    | INFO : - Uploading /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/.syncany/cache/database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000002 to temp. file RemoteFile[name=temp-vuvFz-database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000002] ...
29-3-20 17:50:55.136 | RemoteTransacti | Test worker    | INFO : - Moving temp. file RemoteFile[name=temp-IesGs-multichunk-33e2948f7b9f79162921f0c6c37c7880e0dde8a4] to final location RemoteFile[name=multichunk-33e2948f7b9f79162921f0c6c37c7880e0dde8a4] ...
29-3-20 17:50:55.136 | RemoteTransacti | Test worker    | INFO : - Moving temp. file RemoteFile[name=temp-vuvFz-database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000002] to final location RemoteFile[name=database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000002] ...
29-3-20 17:50:55.137 | RemoteTransacti | Test worker    | INFO : - Deleting remote transaction file RemoteFile[name=transaction-760c1fd2] ...
29-3-20 17:50:55.137 | RemoteTransacti | Test worker    | INFO : END of TX.commmit(): Succesfully committed transaction.
29-3-20 17:50:55.137 | RemoteTransacti | Test worker    | INFO : END of TX.delTemp(): Sucessfully deleted final files.
29-3-20 17:50:55.138 | UpOperation     | Test worker    | INFO : Persisting local SQL database (new database version syncanyclientUWTtvoJlQUepTTwSVMOO/(syncanyclientUWTtvoJlQUepTTwSVMOO2)/T=1585504255120) ...
29-3-20 17:50:55.139 | Indexer         | AsyncI/syncany | FINE : - Chunk > MultiChunk: 6ee931331670ef1382f712015ad1068fdfe5638f > 8d6682887b15713c1178971bb75e877e6e4e9d46
29-3-20 17:50:55.139 | Indexer         | AsyncI/syncany | FINE : - Chunk > FileContent: 6ee931331670ef1382f712015ad1068fdfe5638f > /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/rndFile-1585504254900-438542125.dat
29-3-20 17:50:55.147 | UpOperation     | Test worker    | INFO : Removing DIRTY database versions from database ...
29-3-20 17:50:55.154 | Indexer         | AsyncI/syncany | FINE : - Chunk new: 31fa616029ab9e222d8078d3496597d4a0e30495
29-3-20 17:50:55.155 | UpOperation     | Test worker    | INFO : Adding database version to result changes:DatabaseVersion [header=syncanyclientUWTtvoJlQUepTTwSVMOO/(syncanyclientUWTtvoJlQUepTTwSVMOO2)/T=1585504255120, chunks=3, multiChunks=1, fileContents=1, fileHistories=1]
29-3-20 17:50:55.156 | UpOperation     | Test worker    | INFO : Committing local database.
29-3-20 17:50:55.156 | UpOperation     | Test worker    | FINE : Waiting for new database version.
29-3-20 17:50:55.166 | Indexer         | AsyncI/syncany | FINE : - Chunk > MultiChunk: 31fa616029ab9e222d8078d3496597d4a0e30495 > 8d6682887b15713c1178971bb75e877e6e4e9d46
29-3-20 17:50:55.166 | Indexer         | AsyncI/syncany | FINE : - Chunk > FileContent: 31fa616029ab9e222d8078d3496597d4a0e30495 > /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/rndFile-1585504254900-438542125.dat
29-3-20 17:50:55.168 | Indexer         | AsyncI/syncany | FINE : - Chunk new: 0131656c4f929734d313c962b139387779608a53
29-3-20 17:50:55.170 | Indexer         | AsyncI/syncany | FINE : - Chunk > MultiChunk: 0131656c4f929734d313c962b139387779608a53 > 8d6682887b15713c1178971bb75e877e6e4e9d46
29-3-20 17:50:55.170 | Indexer         | AsyncI/syncany | FINE : - Chunk > FileContent: 0131656c4f929734d313c962b139387779608a53 > /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/rndFile-1585504254900-438542125.dat
29-3-20 17:50:55.171 | Indexer         | AsyncI/syncany | FINE : - /File: rndFile-1585504254900-438542125.dat (checksum 23227510b19516fe0ea5b6a6f9461ed339915e98)
29-3-20 17:50:55.172 | Indexer         | AsyncI/syncany | FINE :    * No old file history found, starting new history (path: rndFile-1585504254900-438542125.dat, checksum: 23227510b19516fe0ea5b6a6f9461ed339915e98)
29-3-20 17:50:55.173 | FileVersionComp | AsyncI/syncany | INFO :      - [DELETED]: Local file DIFFERS from file version, actual file is NULL, for file rndFile-1585504254900-438542125.dat
29-3-20 17:50:55.173 | Indexer         | AsyncI/syncany | INFO :    * Added file version:    FileVersion [version=1, path=rndFile-1585504254900-438542125.dat, type=FILE, status=NEW, size=1259520, lastModified=Sun Mar 29 17:50:54 UTC 2020, linkTarget=null, checksum=23227510b19516fe0ea5b6a6f9461ed339915e98, updated=Sun Mar 29 17:50:55 UTC 2020, posixPermissions=rw-rw-r--, dosAttributes=--a-]
29-3-20 17:50:55.173 | Indexer         | AsyncI/syncany | INFO :      based on file version: null
29-3-20 17:50:55.173 | InternalEventBu | AsyncI/syncany | INFO : Event bus 'LocalEventBus': Posting event UpIndexChangesDetectedSyncExternalEvent (org.syncany.operations.daemon.messages.UpIndexChangesDetectedSyncExternalEvent@712a272c) ...
29-3-20 17:50:55.174 | Indexer         | AsyncI/syncany | FINE : - /MultiChunk 8d6682887b15713c1178971bb75e877e6e4e9d46
29-3-20 17:50:55.174 | Indexer         | AsyncI/syncany | FINE : Processed new database version: DatabaseVersion [header=UnknownMachine/()/T=1585504255118, chunks=3, multiChunks=1, fileContents=1, fileHistories=1]
29-3-20 17:50:55.174 | InternalEventBu | AsyncI/syncany | INFO : Event bus 'LocalEventBus': Posting event UpIndexMidSyncExternalEvent (org.syncany.operations.daemon.messages.UpIndexMidSyncExternalEvent@e19b879) ...
29-3-20 17:50:55.174 | UpOperation     | Test worker    | FINE : Took new database version: DatabaseVersion [header=UnknownMachine/()/T=1585504255118, chunks=3, multiChunks=1, fileContents=1, fileHistories=1]
29-3-20 17:50:55.175 | UpOperation     | Test worker    | INFO : Last vector clock was: (syncanyclientUWTtvoJlQUepTTwSVMOO2)
29-3-20 17:50:55.175 | UpOperation     | Test worker    | INFO : Uploading new multichunks ...
29-3-20 17:50:55.176 | UpOperation     | Test worker    | INFO : - Uploading multichunk 8d6682887b15713c1178971bb75e877e6e4e9d46 from /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/.syncany/cache/multichunk-8d6682887b15713c1178971bb75e877e6e4e9d46 to RemoteFile[name=multichunk-8d6682887b15713c1178971bb75e877e6e4e9d46] ...
29-3-20 17:50:55.176 | RemoteTransacti | Test worker    | INFO : - Adding file to TX for UPLOAD: /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/.syncany/cache/multichunk-8d6682887b15713c1178971bb75e877e6e4e9d46 -> Temp. remote file: RemoteFile[name=temp-ySifk-multichunk-8d6682887b15713c1178971bb75e877e6e4e9d46], final location: RemoteFile[name=multichunk-8d6682887b15713c1178971bb75e877e6e4e9d46]
29-3-20 17:50:55.176 | UpOperation     | Test worker    | INFO : Uploading database: DatabaseVersion [header=syncanyclientUWTtvoJlQUepTTwSVMOO/(syncanyclientUWTtvoJlQUepTTwSVMOO3)/T=1585504255175, chunks=3, multiChunks=1, fileContents=1, fileHistories=1]
29-3-20 17:50:55.177 | UpOperation     | Test worker    | INFO : Saving local delta database, version syncanyclientUWTtvoJlQUepTTwSVMOO/(syncanyclientUWTtvoJlQUepTTwSVMOO3)/T=1585504255175 to file /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/.syncany/cache/database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000003 ... 
29-3-20 17:50:55.177 | UpOperation     | Test worker    | INFO : - Saving database to /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/.syncany/cache/database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000003 ...
29-3-20 17:50:55.178 | UpOperation     | Test worker    | INFO : - Uploading local delta database file ...
29-3-20 17:50:55.178 | UpOperation     | Test worker    | INFO : - Uploading /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/.syncany/cache/database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000003 to RemoteFile[name=database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000003] ...
29-3-20 17:50:55.178 | RemoteTransacti | Test worker    | INFO : - Adding file to TX for UPLOAD: /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/.syncany/cache/database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000003 -> Temp. remote file: RemoteFile[name=temp-EdOqe-database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000003], final location: RemoteFile[name=database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000003]
29-3-20 17:50:55.178 | UpOperation     | Test worker    | INFO : Adding shutdown hook (to allow resuming the upload) ...
29-3-20 17:50:55.178 | RemoteTransacti | Test worker    | INFO : Starting TX.commit() ...
29-3-20 17:50:55.188 | RemoteTransacti | Test worker    | INFO : Wrote transaction manifest to temporary file: /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/.syncany/cache/temp-transaction-15675362817679004943.tmp
29-3-20 17:50:55.188 | InternalEventBu | Test worker    | INFO : Event bus 'LocalEventBus': Posting event UpUploadFileSyncExternalEvent (org.syncany.operations.daemon.messages.UpUploadFileSyncExternalEvent@6c5d791) ...
29-3-20 17:50:55.190 | RemoteTransacti | Test worker    | INFO : - Uploading remote transaction file RemoteFile[name=transaction-7800e018] ...
29-3-20 17:50:55.191 | RemoteTransacti | Test worker    | INFO : - Starting to upload data in commit.
29-3-20 17:50:55.191 | InternalEventBu | Test worker    | INFO : Event bus 'LocalEventBus': Posting event UpUploadFileInTransactionSyncExternalEvent (org.syncany.operations.daemon.messages.UpUploadFileInTransactionSyncExternalEvent@58a6beb8) ...
29-3-20 17:50:55.191 | RemoteTransacti | Test worker    | INFO : - Uploading /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/.syncany/cache/multichunk-8d6682887b15713c1178971bb75e877e6e4e9d46 to temp. file RemoteFile[name=temp-ySifk-multichunk-8d6682887b15713c1178971bb75e877e6e4e9d46] ...
29-3-20 17:50:55.193 | InternalEventBu | Test worker    | INFO : Event bus 'LocalEventBus': Posting event UpUploadFileInTransactionSyncExternalEvent (org.syncany.operations.daemon.messages.UpUploadFileInTransactionSyncExternalEvent@3fb6ccc7) ...
29-3-20 17:50:55.193 | RemoteTransacti | Test worker    | INFO : - Uploading /tmp/syncanytest/syncany-200329175011381-10309-client-syncanyclient/.syncany/cache/database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000003 to temp. file RemoteFile[name=temp-EdOqe-database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000003] ...
29-3-20 17:50:55.193 | AsyncIndexer    | AsyncI/syncany | INFO : Stopping indexing. Signal end of stream with empty databaseversion
29-3-20 17:50:55.194 | RemoteTransacti | Test worker    | INFO : - Moving temp. file RemoteFile[name=temp-ySifk-multichunk-8d6682887b15713c1178971bb75e877e6e4e9d46] to final location RemoteFile[name=multichunk-8d6682887b15713c1178971bb75e877e6e4e9d46] ...
29-3-20 17:50:55.195 | RemoteTransacti | Test worker    | INFO : - Moving temp. file RemoteFile[name=temp-EdOqe-database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000003] to final location RemoteFile[name=database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000003] ...
29-3-20 17:50:55.196 | RemoteTransacti | Test worker    | INFO : - Deleting remote transaction file RemoteFile[name=transaction-7800e018] ...
29-3-20 17:50:55.196 | RemoteTransacti | Test worker    | INFO : END of TX.commmit(): Succesfully committed transaction.
29-3-20 17:50:55.196 | RemoteTransacti | Test worker    | INFO : END of TX.delTemp(): Sucessfully deleted final files.
29-3-20 17:50:55.196 | UpOperation     | Test worker    | INFO : Persisting local SQL database (new database version syncanyclientUWTtvoJlQUepTTwSVMOO/(syncanyclientUWTtvoJlQUepTTwSVMOO3)/T=1585504255175) ...
29-3-20 17:50:55.200 | UpOperation     | Test worker    | INFO : Removing DIRTY database versions from database ...
29-3-20 17:50:55.208 | UpOperation     | Test worker    | INFO : Adding database version to result changes:DatabaseVersion [header=syncanyclientUWTtvoJlQUepTTwSVMOO/(syncanyclientUWTtvoJlQUepTTwSVMOO3)/T=1585504255175, chunks=3, multiChunks=1, fileContents=1, fileHistories=1]
29-3-20 17:50:55.208 | UpOperation     | Test worker    | INFO : Committing local database.
29-3-20 17:50:55.208 | UpOperation     | Test worker    | FINE : Waiting for new database version.
29-3-20 17:50:55.208 | UpOperation     | Test worker    | FINE : Took new database version: DatabaseVersion [header=UnknownMachine/()/T=1585504255193, chunks=0, multiChunks=0, fileContents=0, fileHistories=0]
29-3-20 17:50:55.208 | UpOperation     | Test worker    | INFO : Sync up done.
29-3-20 17:50:55.210 | ActionFileHandl | Test worker    | INFO : Finishing action for RemoteFile[name=action-up-syncanyclientUWTtvoJlQUepTTwSVMOO-1585504254911] ...
29-3-20 17:50:55.212 | ActionFileHandl | Test worker    | INFO : Deleting action file: RemoteFile[name=action-up-syncanyclientUWTtvoJlQUepTTwSVMOO-1585504254911]
29-3-20 17:50:55.212 | AbstractTransfe | Test worker    | INFO : Cleaning own old action files ...
29-3-20 17:50:55.213 | Cache           | Test worker    | INFO : Cache size okay (3697 KB), no need to clean (keep size is 500 MB)
29-3-20 17:50:55.213 | InternalEventBu | Test worker    | INFO : Event bus 'LocalEventBus': Posting event UpEndSyncExternalEvent (org.syncany.operations.daemon.messages.UpEndSyncExternalEvent@1fcba616) ...
29-3-20 17:50:55.214 | DatabaseXmlSeri | Test worker    | INFO : - Loading database (FULL) from file /tmp/syncanytest/syncany-200329175011381-10309-repo/databases/database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000001 ...
29-3-20 17:50:55.223 | DatabaseXmlPars | Test worker    | INFO :    + Added database version syncanyclientUWTtvoJlQUepTTwSVMOO/(syncanyclientUWTtvoJlQUepTTwSVMOO1)/T=1585504255062
29-3-20 17:50:55.225 | DatabaseXmlSeri | Test worker    | INFO : - Loading database (FULL) from file /tmp/syncanytest/syncany-200329175011381-10309-repo/databases/database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000002 ...
29-3-20 17:50:55.228 | DatabaseXmlPars | Test worker    | INFO :    + Added database version syncanyclientUWTtvoJlQUepTTwSVMOO/(syncanyclientUWTtvoJlQUepTTwSVMOO2)/T=1585504255120
29-3-20 17:50:55.229 | DatabaseXmlSeri | Test worker    | INFO : - Loading database (FULL) from file /tmp/syncanytest/syncany-200329175011381-10309-repo/databases/database-syncanyclientUWTtvoJlQUepTTwSVMOO-0000000003 ...
29-3-20 17:50:55.232 | DatabaseXmlPars | Test worker    | INFO :    + Added database version syncanyclientUWTtvoJlQUepTTwSVMOO/(syncanyclientUWTtvoJlQUepTTwSVMOO3)/T=1585504255175
29-3-20 17:50:55.237 | DatabaseConnect | Test worker    | INFO : Found 12 tables.