"./sync.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestCopyDeleteBefore|TestCopyEmptyDirectories|TestCopyWithFilesFromAndNoTraverse|TestMoveWithDeleteEmptySrcDirs|TestMoveWithIgnoreExisting|TestMoveWithoutDeleteEmptySrcDirs|TestNothingToTransferWithEmptyDirs|TestNothingToTransferWithoutEmptyDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveLocal|TestServerSideMoveOverlap|TestServerSideMoveWithFilter|TestSyncAfterAddingAFile|TestSyncAfterChangingContentsOnly|TestSyncAfterChangingFilesSizeOnly|TestSyncAfterChangingModtimeOnly|TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime|TestSyncAfterRemovingAFileAndAddingAFile|TestSyncAfterRemovingAFileAndAddingAFileDryRun|TestSyncAfterRemovingAFileAndAddingAFileSubDir|TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncCompareDest|TestSyncConcurrentDelete|TestSyncConcurrentTruncate|TestSyncCopyDest|TestSyncDeleteBefore|TestSyncDeleteDuring|TestSyncDoesntUpdateModtime|TestSyncIgnoreCase|TestSyncIgnoreErrors|TestSyncIgnoreExisting|TestSyncIgnoreSize|TestSyncIgnoreTimes|TestSyncImmutable|TestSyncMultipleCompareDest|TestSyncOverlap|TestSyncReplaceDirModTime|TestSyncReplaceDirModTimeWithEmptyDirs|TestSyncSuffix|TestSyncSuffixKeepExtension|TestSyncUTFNorm|TestSyncWithExclude|TestSyncWithExcludeAndDeleteExcluded|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime|TestSyncWithUpdateOlder)$|^TestMaxTransfer$/^(Cautious|Hard|Soft)$'" - Starting (try 3/5) 2026/06/11 03:47:25 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-jagiguk4mehu" 2026/06/11 03:47:25 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/06/11 03:47:25 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Using cached web token 2026/06/11 03:47:25 DEBUG : Creating backend with remote "/tmp/rclone1752417802" === RUN TestCopyWithFilesFromAndNoTraverse run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 03:47:26 DEBUG : potato2: Need to transfer - File not found at Destination 2026/06/11 03:47:26 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 03:47:26 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 03:47:29 DEBUG : potato2: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:47:30 DEBUG : potato2: size = 11 OK 2026/06/11 03:47:30 INFO : potato2: Copied (new) fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 7s just to make sure --- PASS: TestCopyWithFilesFromAndNoTraverse (17.32s) === RUN TestCopyEmptyDirectories run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 03:47:43 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2026/06/11 03:47:43 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2026/06/11 03:47:43 INFO : sub dir2: Set directory modification time (using DirSetModTime) 2026/06/11 03:47:43 INFO : sub dir: Set directory modification time (using DirSetModTime) 2026/06/11 03:47:43 INFO : sub dir2: Making directory 2026/06/11 03:47:44 INFO : sub dir: Making directory 2026/06/11 03:47:46 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/06/11 03:47:46 INFO : sub dir2/sub sub dir2: Making directory 2026/06/11 03:47:48 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 03:47:48 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 03:47:50 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:47:50 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 03:47:50 DEBUG : sub dir/hello world: size = 11 OK 2026/06/11 03:47:50 INFO : sub dir/hello world: Copied (new) 2026/06/11 03:47:51 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- PASS: TestCopyEmptyDirectories (22.97s) === RUN TestSyncIgnoreSize run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 03:48:06 DEBUG : ignore-size: Need to transfer - File not found at Destination 2026/06/11 03:48:06 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 03:48:06 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 03:48:08 INFO : ignore-size: Copied (new) 2026/06/11 03:48:08 DEBUG : Waiting for deletions to finish 2026/06/11 03:48:08 DEBUG : ignore-size: Sizes identical 2026/06/11 03:48:08 DEBUG : ignore-size: Unchanged skipping 2026/06/11 03:48:08 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 03:48:08 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 03:48:08 DEBUG : Waiting for deletions to finish 2026/06/11 03:48:08 INFO : There was nothing to transfer fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- PASS: TestSyncIgnoreSize (12.06s) === RUN TestSyncIgnoreTimes run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure 2026/06/11 03:48:28 DEBUG : existing: size = 6 OK 2026/06/11 03:48:28 DEBUG : existing: Sizes identical 2026/06/11 03:48:28 DEBUG : existing: Unchanged skipping 2026/06/11 03:48:28 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 03:48:28 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 03:48:28 DEBUG : Waiting for deletions to finish 2026/06/11 03:48:28 INFO : There was nothing to transfer 2026/06/11 03:48:28 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2026/06/11 03:48:28 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 03:48:28 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 03:48:28 DEBUG : existing: Update: removing old file 2026/06/11 03:48:31 DEBUG : existing: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:48:32 DEBUG : existing: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 03:48:32 DEBUG : existing: Trying to read object after upload: try again in 400ms (3/10) 2026/06/11 03:48:33 DEBUG : existing: Trying to read object after upload: try again in 800ms (4/10) 2026/06/11 03:48:34 DEBUG : existing: Trying to read object after upload: try again in 1.6s (5/10) 2026/06/11 03:48:35 DEBUG : existing: Trying to read object after upload: try again in 3.2s (6/10) 2026/06/11 03:48:39 DEBUG : existing: Trying to read object after upload: try again in 6.4s (7/10) 2026/06/11 03:48:45 DEBUG : existing: Trying to read object after upload: try again in 12.8s (8/10) 2026/06/11 03:48:58 DEBUG : existing: Trying to read object after upload: try again in 25.6s (9/10) 2026/06/11 03:49:24 DEBUG : existing: Trying to read object after upload: try again in 51.2s (10/10) 2026/06/11 03:50:15 ERROR : existing: Failed to copy: object not found 2026/06/11 03:50:15 ERROR : Linkbox root 'rclone-test-jagiguk4mehu': not deleting files as there were IO errors 2026/06/11 03:50:15 ERROR : Linkbox root 'rclone-test-jagiguk4mehu': not deleting directories as there were IO errors sync_test.go:905: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:905 Error: Received unexpected error: object not found Test: TestSyncIgnoreTimes --- FAIL: TestSyncIgnoreTimes (119.41s) === RUN TestSyncIgnoreExisting run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 03:50:17 DEBUG : existing: Need to transfer - File not found at Destination 2026/06/11 03:50:17 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 03:50:17 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 03:50:20 DEBUG : existing: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:50:20 DEBUG : existing: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 03:50:20 DEBUG : existing: Trying to read object after upload: try again in 400ms (3/10) 2026/06/11 03:50:21 DEBUG : existing: size = 6 OK 2026/06/11 03:50:21 INFO : existing: Copied (new) 2026/06/11 03:50:21 DEBUG : Waiting for deletions to finish 2026/06/11 03:50:21 DEBUG : existing: Destination exists, skipping 2026/06/11 03:50:21 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 03:50:21 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 03:50:21 DEBUG : Waiting for deletions to finish 2026/06/11 03:50:21 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreExisting (6.06s) === RUN TestSyncIgnoreErrors run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 03:50:27 DEBUG : b/potato: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:50:27 DEBUG : b/potato: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 03:50:28 DEBUG : b/potato: Trying to read object after upload: try again in 400ms (3/10) 2026/06/11 03:50:28 DEBUG : b/potato: Trying to read object after upload: try again in 800ms (4/10) 2026/06/11 03:50:33 DEBUG : c/non empty space: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:50:33 DEBUG : c/non empty space: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 03:50:34 INFO : d: Making directory 2026/06/11 03:50:36 DEBUG : a/potato2: Need to transfer - File not found at Destination 2026/06/11 03:50:37 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 03:50:37 DEBUG : c/non empty space: size = 5 OK 2026/06/11 03:50:37 DEBUG : c/non empty space: Sizes identical 2026/06/11 03:50:37 DEBUG : c/non empty space: Unchanged skipping 2026/06/11 03:50:37 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 03:50:40 DEBUG : a/potato2: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:50:41 DEBUG : a/potato2: size = 60 OK 2026/06/11 03:50:41 INFO : a/potato2: Copied (new) 2026/06/11 03:50:41 DEBUG : Waiting for deletions to finish 2026/06/11 03:50:42 INFO : b/potato: Deleted 2026/06/11 03:50:42 INFO : d: Removing directory 2026/06/11 03:50:43 INFO : b: Removing directory 2026/06/11 03:50:45 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': deleted 2 directories --- PASS: TestSyncIgnoreErrors (28.76s) === RUN TestSyncAfterChangingModtimeOnly run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 03:50:54 DEBUG : empty space: Trying to read object after upload: try again in 100ms (1/10) fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure 2026/06/11 03:51:02 DEBUG : empty space: size = 1 OK 2026/06/11 03:51:02 DEBUG : empty space: Sizes identical 2026/06/11 03:51:02 DEBUG : empty space: Unchanged skipping 2026/06/11 03:51:02 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 03:51:02 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 03:51:02 DEBUG : Waiting for deletions to finish 2026/06/11 03:51:02 INFO : There was nothing to transfer 2026/06/11 03:51:03 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 03:51:03 DEBUG : empty space: size = 1 OK 2026/06/11 03:51:03 DEBUG : empty space: Sizes identical 2026/06/11 03:51:03 DEBUG : empty space: Unchanged skipping 2026/06/11 03:51:03 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 03:51:03 DEBUG : Waiting for deletions to finish 2026/06/11 03:51:03 INFO : There was nothing to transfer fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- PASS: TestSyncAfterChangingModtimeOnly (20.17s) === RUN TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" sync_test.go:1046: Can't check this if no hashes supported --- PASS: TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime (0.40s) === RUN TestSyncDoesntUpdateModtime run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" sync_test.go:1072: Can't run this test on fs which doesn't support mod time --- SKIP: TestSyncDoesntUpdateModtime (0.42s) === RUN TestSyncAfterAddingAFile run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 03:51:15 DEBUG : empty space: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:51:16 DEBUG : potato: Need to transfer - File not found at Destination 2026/06/11 03:51:16 DEBUG : empty space: size = 1 OK 2026/06/11 03:51:16 DEBUG : empty space: Sizes identical 2026/06/11 03:51:16 DEBUG : empty space: Unchanged skipping 2026/06/11 03:51:16 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 03:51:16 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 03:51:18 DEBUG : potato: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:51:18 DEBUG : potato: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 03:51:18 DEBUG : potato: size = 60 OK 2026/06/11 03:51:18 INFO : potato: Copied (new) 2026/06/11 03:51:18 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterAddingAFile (8.82s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 03:51:24 DEBUG : potato: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:51:24 DEBUG : potato: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 03:51:25 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 03:51:25 DEBUG : potato: size = 21 (Local file system at /tmp/rclone1752417802) 2026/06/11 03:51:25 DEBUG : potato: size = 60 (Linkbox root 'rclone-test-jagiguk4mehu') 2026/06/11 03:51:25 DEBUG : potato: Sizes differ 2026/06/11 03:51:25 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 03:51:25 DEBUG : potato: Update: removing old file 2026/06/11 03:51:28 DEBUG : potato: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:51:29 DEBUG : potato: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 03:51:29 DEBUG : potato: Trying to read object after upload: try again in 400ms (3/10) 2026/06/11 03:51:30 DEBUG : potato: Trying to read object after upload: try again in 800ms (4/10) 2026/06/11 03:51:31 DEBUG : potato: Trying to read object after upload: try again in 1.6s (5/10) 2026/06/11 03:51:32 DEBUG : potato: Trying to read object after upload: try again in 3.2s (6/10) 2026/06/11 03:51:36 DEBUG : potato: Trying to read object after upload: try again in 6.4s (7/10) 2026/06/11 03:51:43 DEBUG : potato: Trying to read object after upload: try again in 12.8s (8/10) 2026/06/11 03:51:56 DEBUG : potato: Trying to read object after upload: try again in 25.6s (9/10) 2026/06/11 03:52:21 DEBUG : potato: Trying to read object after upload: try again in 51.2s (10/10) 2026/06/11 03:53:13 ERROR : potato: Failed to copy: object not found 2026/06/11 03:53:13 ERROR : Linkbox root 'rclone-test-jagiguk4mehu': not deleting files as there were IO errors 2026/06/11 03:53:13 ERROR : Linkbox root 'rclone-test-jagiguk4mehu': not deleting directories as there were IO errors sync_test.go:1123: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1123 Error: Received unexpected error: object not found Test: TestSyncAfterChangingFilesSizeOnly fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- FAIL: TestSyncAfterChangingFilesSizeOnly (119.89s) === RUN TestSyncAfterChangingContentsOnly run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" sync_test.go:1136: ModTimeNotSupported so forcing file to be a different size 2026/06/11 03:53:24 DEBUG : potato: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:53:24 DEBUG : potato: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 03:53:25 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 03:53:25 DEBUG : potato: size = 21 (Local file system at /tmp/rclone1752417802) 2026/06/11 03:53:25 DEBUG : potato: size = 36 (Linkbox root 'rclone-test-jagiguk4mehu') 2026/06/11 03:53:25 DEBUG : potato: Sizes differ 2026/06/11 03:53:25 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 03:53:25 DEBUG : potato: Update: removing old file 2026/06/11 03:53:28 DEBUG : potato: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:53:28 DEBUG : potato: size = 21 OK 2026/06/11 03:53:28 INFO : potato: Copied (replaced existing) 2026/06/11 03:53:28 DEBUG : Waiting for deletions to finish fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- PASS: TestSyncAfterChangingContentsOnly (23.81s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 03:53:48 DEBUG : potato: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:53:50 DEBUG : empty space: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:53:50 DEBUG : potato2: Need to transfer - File not found at Destination 2026/06/11 03:53:50 DEBUG : empty space: size = 1 OK 2026/06/11 03:53:50 DEBUG : empty space: Sizes identical 2026/06/11 03:53:50 DEBUG : empty space: Unchanged skipping 2026/06/11 03:53:50 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 03:53:50 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 03:53:50 NOTICE: potato2: Skipped copy as --dry-run is set (size 60) 2026/06/11 03:53:50 DEBUG : Waiting for deletions to finish 2026/06/11 03:53:50 NOTICE: potato: Skipped delete as --dry-run is set (size 21) fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (15.55s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 03:54:03 DEBUG : potato: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:54:03 DEBUG : potato: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 03:54:04 DEBUG : potato: Trying to read object after upload: try again in 400ms (3/10) 2026/06/11 03:54:04 DEBUG : potato: Trying to read object after upload: try again in 800ms (4/10) 2026/06/11 03:54:07 DEBUG : empty space: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:54:08 DEBUG : empty space: size = 1 OK 2026/06/11 03:54:08 DEBUG : empty space: Sizes identical 2026/06/11 03:54:08 DEBUG : potato2: Need to transfer - File not found at Destination 2026/06/11 03:54:08 DEBUG : empty space: Unchanged skipping 2026/06/11 03:54:08 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 03:54:08 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 03:54:10 DEBUG : potato2: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:54:10 DEBUG : potato2: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 03:54:11 DEBUG : potato2: Trying to read object after upload: try again in 400ms (3/10) 2026/06/11 03:54:11 DEBUG : potato2: size = 60 OK 2026/06/11 03:54:11 INFO : potato2: Copied (new) 2026/06/11 03:54:11 DEBUG : Waiting for deletions to finish 2026/06/11 03:54:13 INFO : potato: Deleted --- PASS: TestSyncAfterRemovingAFileAndAddingAFile (14.96s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 03:54:19 DEBUG : b/potato: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:54:20 DEBUG : b/potato: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 03:54:20 DEBUG : b/potato: Trying to read object after upload: try again in 400ms (3/10) 2026/06/11 03:54:24 DEBUG : c/non empty space: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:54:25 DEBUG : c/non empty space: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 03:54:25 INFO : d: Making directory 2026/06/11 03:54:27 INFO : d/e: Making directory fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure 2026/06/11 03:54:37 DEBUG : a/potato2: Need to transfer - File not found at Destination 2026/06/11 03:54:38 DEBUG : c/non empty space: size = 5 OK 2026/06/11 03:54:38 DEBUG : c/non empty space: Sizes identical 2026/06/11 03:54:38 DEBUG : c/non empty space: Unchanged skipping 2026/06/11 03:54:40 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 03:54:40 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 03:54:42 DEBUG : a/potato2: size = 60 OK 2026/06/11 03:54:42 INFO : a/potato2: Copied (new) 2026/06/11 03:54:42 DEBUG : Waiting for deletions to finish 2026/06/11 03:54:43 INFO : b/potato: Deleted 2026/06/11 03:54:43 INFO : d/e: Removing directory 2026/06/11 03:54:45 INFO : d: Removing directory 2026/06/11 03:54:46 INFO : b: Removing directory 2026/06/11 03:54:48 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': deleted 3 directories run.go:186: removing dir "c" failed - try 1/3: sleeping 1s: directory not empty --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (40.16s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 03:55:00 DEBUG : b/potato: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:55:00 DEBUG : b/potato: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 03:55:04 DEBUG : c/non empty space: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:55:04 DEBUG : c/non empty space: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 03:55:05 DEBUG : c/non empty space: Trying to read object after upload: try again in 400ms (3/10) 2026/06/11 03:55:05 INFO : d: Making directory 2026/06/11 03:55:08 DEBUG : a/potato2: Need to transfer - File not found at Destination 2026/06/11 03:55:08 DEBUG : c/non empty space: size = 5 OK 2026/06/11 03:55:08 DEBUG : c/non empty space: Sizes identical 2026/06/11 03:55:08 DEBUG : c/non empty space: Unchanged skipping 2026/06/11 03:55:08 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 03:55:08 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 03:55:12 DEBUG : a/potato2: size = 60 OK 2026/06/11 03:55:12 INFO : a/potato2: Copied (new) 2026/06/11 03:55:12 ERROR : Linkbox root 'rclone-test-jagiguk4mehu': not deleting files as there were IO errors 2026/06/11 03:55:12 ERROR : Linkbox root 'rclone-test-jagiguk4mehu': not deleting directories as there were IO errors --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (28.11s) === RUN TestSyncDeleteDuring run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 03:55:26 DEBUG : potato: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:55:27 DEBUG : potato: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 03:55:27 DEBUG : potato: Trying to read object after upload: try again in 400ms (3/10) 2026/06/11 03:55:28 DEBUG : potato: Trying to read object after upload: try again in 800ms (4/10) 2026/06/11 03:55:31 DEBUG : Waiting for deletions to finish 2026/06/11 03:55:31 DEBUG : potato2: Need to transfer - File not found at Destination 2026/06/11 03:55:31 DEBUG : empty space: size = 1 OK 2026/06/11 03:55:31 DEBUG : empty space: Sizes identical 2026/06/11 03:55:31 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 03:55:31 DEBUG : empty space: Unchanged skipping 2026/06/11 03:55:31 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 03:55:33 INFO : potato: Deleted 2026/06/11 03:55:34 DEBUG : potato2: size = 60 OK 2026/06/11 03:55:34 INFO : potato2: Copied (new) fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- PASS: TestSyncDeleteDuring (27.42s) === RUN TestSyncDeleteBefore run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 03:55:54 DEBUG : potato: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:55:54 DEBUG : potato: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 03:55:54 DEBUG : potato: Trying to read object after upload: try again in 400ms (3/10) fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure 2026/06/11 03:56:05 DEBUG : Waiting for deletions to finish 2026/06/11 03:56:05 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 03:56:05 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 03:56:06 INFO : potato: Deleted 2026/06/11 03:56:06 DEBUG : potato2: Need to transfer - File not found at Destination 2026/06/11 03:56:06 DEBUG : empty space: size = 1 OK 2026/06/11 03:56:06 DEBUG : empty space: Sizes identical 2026/06/11 03:56:06 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 03:56:06 DEBUG : empty space: Unchanged skipping 2026/06/11 03:56:06 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 03:56:08 DEBUG : potato2: size = 60 OK 2026/06/11 03:56:08 INFO : potato2: Copied (new) fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- PASS: TestSyncDeleteBefore (27.41s) === RUN TestCopyDeleteBefore run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 03:56:22 DEBUG : potato2: Need to transfer - File not found at Destination 2026/06/11 03:56:22 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 03:56:22 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 03:56:24 DEBUG : potato2: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:56:24 DEBUG : potato2: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 03:56:24 DEBUG : potato2: size = 19 OK 2026/06/11 03:56:24 INFO : potato2: Copied (new) fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- PASS: TestCopyDeleteBefore (23.38s) === RUN TestSyncWithExclude run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 03:56:45 DEBUG : potato2: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:56:45 DEBUG : potato2: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 03:56:45 DEBUG : potato2: Trying to read object after upload: try again in 400ms (3/10) fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure 2026/06/11 03:56:56 DEBUG : enormous: Excluded (Size Filter) 2026/06/11 03:56:56 DEBUG : enormous: Excluded 2026/06/11 03:56:56 DEBUG : potato2: Excluded (Size Filter) 2026/06/11 03:56:56 DEBUG : potato2: Excluded 2026/06/11 03:56:56 DEBUG : potato2: Excluded (Size Filter) 2026/06/11 03:56:56 DEBUG : potato2: Excluded 2026/06/11 03:56:56 DEBUG : empty space: size = 1 OK 2026/06/11 03:56:56 DEBUG : empty space: Sizes identical 2026/06/11 03:56:56 DEBUG : empty space: Unchanged skipping 2026/06/11 03:56:56 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 03:56:56 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 03:56:56 DEBUG : Waiting for deletions to finish 2026/06/11 03:56:56 INFO : There was nothing to transfer 2026/06/11 03:56:56 DEBUG : enormous: Excluded (Size Filter) 2026/06/11 03:56:56 DEBUG : enormous: Excluded 2026/06/11 03:56:56 DEBUG : potato2: Excluded (Size Filter) 2026/06/11 03:56:56 DEBUG : potato2: Excluded 2026/06/11 03:56:56 DEBUG : potato2: Excluded (Size Filter) 2026/06/11 03:56:56 DEBUG : potato2: Excluded 2026/06/11 03:56:56 DEBUG : Local file system at /tmp/rclone1752417802: Waiting for checks to finish 2026/06/11 03:56:56 DEBUG : empty space: size = 1 OK 2026/06/11 03:56:56 DEBUG : empty space: Sizes identical 2026/06/11 03:56:56 DEBUG : empty space: Unchanged skipping 2026/06/11 03:56:56 DEBUG : Local file system at /tmp/rclone1752417802: Waiting for transfers to finish 2026/06/11 03:56:56 DEBUG : Waiting for deletions to finish 2026/06/11 03:56:56 INFO : There was nothing to transfer fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- PASS: TestSyncWithExclude (24.34s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 03:57:11 DEBUG : empty space: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:57:11 DEBUG : empty space: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 03:57:12 DEBUG : empty space: Trying to read object after upload: try again in 400ms (3/10) fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure 2026/06/11 03:57:22 DEBUG : enormous: Excluded (Size Filter) 2026/06/11 03:57:22 DEBUG : enormous: Excluded 2026/06/11 03:57:22 DEBUG : potato2: Excluded (Size Filter) 2026/06/11 03:57:22 DEBUG : potato2: Excluded 2026/06/11 03:57:22 DEBUG : empty space: size = 1 OK 2026/06/11 03:57:22 DEBUG : empty space: Sizes identical 2026/06/11 03:57:22 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 03:57:22 DEBUG : empty space: Unchanged skipping 2026/06/11 03:57:22 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 03:57:22 DEBUG : Waiting for deletions to finish 2026/06/11 03:57:24 INFO : enormous: Deleted 2026/06/11 03:57:24 INFO : potato2: Deleted 2026/06/11 03:57:24 INFO : There was nothing to transfer fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure 2026/06/11 03:57:32 DEBUG : empty space: size = 1 OK 2026/06/11 03:57:32 DEBUG : empty space: Sizes identical 2026/06/11 03:57:32 DEBUG : empty space: Unchanged skipping 2026/06/11 03:57:32 DEBUG : Local file system at /tmp/rclone1752417802: Waiting for checks to finish 2026/06/11 03:57:32 DEBUG : Local file system at /tmp/rclone1752417802: Waiting for transfers to finish 2026/06/11 03:57:32 DEBUG : Waiting for deletions to finish 2026/06/11 03:57:32 INFO : enormous: Deleted 2026/06/11 03:57:32 INFO : potato2: Deleted 2026/06/11 03:57:32 INFO : There was nothing to transfer fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- PASS: TestSyncWithExcludeAndDeleteExcluded (33.98s) === RUN TestSyncWithUpdateOlder run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" sync_test.go:1454: Can't run this test on fs which doesn't support mod time --- SKIP: TestSyncWithUpdateOlder (0.40s) === RUN TestSyncWithTrackRenames run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" sync_test.go:1569: Can track renames: false 2026/06/11 03:57:41 ERROR : Linkbox root 'rclone-test-jagiguk4mehu': Ignoring --track-renames as the destination does not support server-side move or copy 2026/06/11 03:57:41 ERROR : Linkbox root 'rclone-test-jagiguk4mehu': Ignoring --track-renames as the source and destination do not have a common hash 2026/06/11 03:57:41 DEBUG : potato: Need to transfer - File not found at Destination 2026/06/11 03:57:41 DEBUG : yam: Need to transfer - File not found at Destination 2026/06/11 03:57:41 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 03:57:41 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 03:57:44 DEBUG : potato: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:57:44 DEBUG : yam: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:57:44 DEBUG : potato: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 03:57:44 DEBUG : yam: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 03:57:45 DEBUG : potato: size = 14 OK 2026/06/11 03:57:45 INFO : potato: Copied (new) 2026/06/11 03:57:45 DEBUG : yam: size = 11 OK 2026/06/11 03:57:45 INFO : yam: Copied (new) 2026/06/11 03:57:45 DEBUG : Waiting for deletions to finish 2026/06/11 03:57:45 ERROR : Linkbox root 'rclone-test-jagiguk4mehu': Ignoring --track-renames as the destination does not support server-side move or copy 2026/06/11 03:57:45 ERROR : Linkbox root 'rclone-test-jagiguk4mehu': Ignoring --track-renames as the source and destination do not have a common hash 2026/06/11 03:57:45 DEBUG : yaml: Need to transfer - File not found at Destination 2026/06/11 03:57:45 DEBUG : potato: size = 14 OK 2026/06/11 03:57:45 DEBUG : potato: Sizes identical 2026/06/11 03:57:45 DEBUG : potato: Unchanged skipping 2026/06/11 03:57:45 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 03:57:45 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 03:57:47 DEBUG : yaml: size = 11 OK 2026/06/11 03:57:47 INFO : yaml: Copied (new) 2026/06/11 03:57:47 DEBUG : Waiting for deletions to finish 2026/06/11 03:57:49 INFO : yam: Deleted fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- PASS: TestSyncWithTrackRenames (25.54s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" sync_test.go:1641: Can track renames: false 2026/06/11 03:58:07 ERROR : Linkbox root 'rclone-test-jagiguk4mehu': Ignoring --track-renames as the destination does not support server-side move or copy 2026/06/11 03:58:07 ERROR : Linkbox root 'rclone-test-jagiguk4mehu': Ignoring --track-renames as either the source or destination do not support modtime 2026/06/11 03:58:07 DEBUG : potato: Need to transfer - File not found at Destination 2026/06/11 03:58:07 DEBUG : yam: Need to transfer - File not found at Destination 2026/06/11 03:58:07 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 03:58:07 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 03:58:09 DEBUG : potato: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:58:10 DEBUG : yam: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:58:10 DEBUG : potato: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 03:58:10 DEBUG : yam: size = 11 OK 2026/06/11 03:58:10 INFO : yam: Copied (new) 2026/06/11 03:58:10 DEBUG : potato: size = 14 OK 2026/06/11 03:58:10 INFO : potato: Copied (new) 2026/06/11 03:58:10 DEBUG : Waiting for deletions to finish fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure 2026/06/11 03:58:18 ERROR : Linkbox root 'rclone-test-jagiguk4mehu': Ignoring --track-renames as the destination does not support server-side move or copy 2026/06/11 03:58:18 ERROR : Linkbox root 'rclone-test-jagiguk4mehu': Ignoring --track-renames as either the source or destination do not support modtime 2026/06/11 03:58:18 DEBUG : yaml: Need to transfer - File not found at Destination 2026/06/11 03:58:18 DEBUG : potato: size = 14 OK 2026/06/11 03:58:18 DEBUG : potato: Sizes identical 2026/06/11 03:58:18 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 03:58:18 DEBUG : potato: Unchanged skipping 2026/06/11 03:58:18 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 03:58:20 DEBUG : yaml: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:58:20 DEBUG : yaml: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 03:58:21 DEBUG : yaml: size = 11 OK 2026/06/11 03:58:21 INFO : yaml: Copied (new) 2026/06/11 03:58:21 DEBUG : Waiting for deletions to finish 2026/06/11 03:58:22 INFO : yam: Deleted fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- PASS: TestSyncWithTrackRenamesStrategyModtime (33.60s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" sync_test.go:1680: Can track renames: false 2026/06/11 03:58:40 ERROR : Linkbox root 'rclone-test-jagiguk4mehu': Ignoring --track-renames as the destination does not support server-side move or copy 2026/06/11 03:58:41 DEBUG : potato: Need to transfer - File not found at Destination 2026/06/11 03:58:41 DEBUG : sub/yam: Need to transfer - File not found at Destination 2026/06/11 03:58:41 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 03:58:41 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 03:58:44 DEBUG : potato: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:58:45 DEBUG : potato: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 03:58:45 DEBUG : sub/yam: size = 11 OK 2026/06/11 03:58:45 INFO : sub/yam: Copied (new) 2026/06/11 03:58:45 DEBUG : potato: size = 14 OK 2026/06/11 03:58:45 INFO : potato: Copied (new) 2026/06/11 03:58:45 DEBUG : Waiting for deletions to finish fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure 2026/06/11 03:58:53 ERROR : Linkbox root 'rclone-test-jagiguk4mehu': Ignoring --track-renames as the destination does not support server-side move or copy 2026/06/11 03:58:53 DEBUG : yam: Need to transfer - File not found at Destination 2026/06/11 03:58:53 DEBUG : potato: size = 14 OK 2026/06/11 03:58:53 DEBUG : potato: Sizes identical 2026/06/11 03:58:53 DEBUG : potato: Unchanged skipping 2026/06/11 03:58:53 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 03:58:53 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 03:58:55 DEBUG : yam: size = 11 OK 2026/06/11 03:58:55 INFO : yam: Copied (new) 2026/06/11 03:58:55 DEBUG : Waiting for deletions to finish 2026/06/11 03:58:57 INFO : sub/yam: Deleted fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- PASS: TestSyncWithTrackRenamesStrategyLeaf (29.40s) === RUN TestServerSideMoveLocal run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 03:59:10 DEBUG : Creating backend with remote "/tmp/rclone1752417802/dir1" 2026/06/11 03:59:10 DEBUG : Creating backend with remote "/tmp/rclone1752417802/dir2" 2026/06/11 03:59:10 DEBUG : Local file system at /tmp/rclone1752417802/dir2: Using server-side directory move 2026/06/11 03:59:10 INFO : Local file system at /tmp/rclone1752417802/dir2: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2026/06/11 03:59:10 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/06/11 03:59:10 DEBUG : Local file system at /tmp/rclone1752417802/dir2: Waiting for checks to finish 2026/06/11 03:59:10 DEBUG : Local file system at /tmp/rclone1752417802/dir2: Waiting for transfers to finish 2026/06/11 03:59:10 INFO : file1.txt: Moved (server-side) --- PASS: TestServerSideMoveLocal (0.41s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 03:59:10 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/06/11 03:59:10 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2026/06/11 03:59:10 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 03:59:10 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 03:59:17 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:59:17 DEBUG : sub dir/hello world: size = 11 OK 2026/06/11 03:59:17 INFO : sub dir/hello world: Copied (new) 2026/06/11 03:59:17 INFO : sub dir/hello world: Deleted 2026/06/11 03:59:18 DEBUG : nested/sub dir/file: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:59:19 DEBUG : nested/sub dir/file: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 03:59:19 DEBUG : nested/sub dir/file: size = 6 OK 2026/06/11 03:59:19 INFO : nested/sub dir/file: Copied (new) 2026/06/11 03:59:19 INFO : nested/sub dir/file: Deleted 2026/06/11 03:59:19 INFO : sub dir: Removing directory 2026/06/11 03:59:19 INFO : nested/sub dir: Removing directory 2026/06/11 03:59:19 INFO : nested: Removing directory 2026/06/11 03:59:19 DEBUG : Local file system at /tmp/rclone1752417802: deleted 3 directories --- PASS: TestMoveWithDeleteEmptySrcDirs (17.98s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 03:59:28 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/06/11 03:59:28 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2026/06/11 03:59:28 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 03:59:28 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 03:59:35 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:59:35 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 03:59:36 DEBUG : nested/sub dir/file: size = 6 OK 2026/06/11 03:59:36 INFO : nested/sub dir/file: Copied (new) 2026/06/11 03:59:36 INFO : nested/sub dir/file: Deleted 2026/06/11 03:59:36 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 400ms (3/10) 2026/06/11 03:59:36 DEBUG : sub dir/hello world: size = 11 OK 2026/06/11 03:59:36 INFO : sub dir/hello world: Copied (new) 2026/06/11 03:59:36 INFO : sub dir/hello world: Deleted --- PASS: TestMoveWithoutDeleteEmptySrcDirs (17.28s) === RUN TestMoveWithIgnoreExisting run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 03:59:46 DEBUG : existing-b: Need to transfer - File not found at Destination 2026/06/11 03:59:46 DEBUG : existing: Need to transfer - File not found at Destination 2026/06/11 03:59:46 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 03:59:46 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 03:59:48 DEBUG : existing-b: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:59:48 DEBUG : existing: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 03:59:48 DEBUG : existing-b: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 03:59:49 DEBUG : existing: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 03:59:49 DEBUG : existing-b: Trying to read object after upload: try again in 400ms (3/10) 2026/06/11 03:59:49 DEBUG : existing: Trying to read object after upload: try again in 400ms (3/10) 2026/06/11 03:59:49 DEBUG : existing-b: size = 6 OK 2026/06/11 03:59:49 INFO : existing-b: Copied (new) 2026/06/11 03:59:49 INFO : existing-b: Deleted 2026/06/11 03:59:50 DEBUG : existing: size = 6 OK 2026/06/11 03:59:50 INFO : existing: Copied (new) 2026/06/11 03:59:50 INFO : existing: Deleted 2026/06/11 03:59:50 DEBUG : existing: Destination exists, skipping 2026/06/11 03:59:50 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set 2026/06/11 03:59:50 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 03:59:50 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 03:59:50 INFO : There was nothing to transfer fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- PASS: TestMoveWithIgnoreExisting (15.38s) === RUN TestServerSideMove run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 04:00:01 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-conuhig5wiqe" 2026/06/11 04:00:01 DEBUG : Linkbox root 'rclone-test-conuhig5wiqe': Using cached web token 2026/06/11 04:00:04 DEBUG : potato2: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:00:04 DEBUG : potato2: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:00:06 DEBUG : empty space: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:00:07 DEBUG : empty space: Trying to read object after upload: try again in 200ms (2/10) fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure sync_test.go:1736: Server side move (if possible) Linkbox root 'rclone-test-jagiguk4mehu' -> Linkbox root 'rclone-test-conuhig5wiqe' 2026/06/11 04:00:21 DEBUG : empty space: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:00:21 DEBUG : empty space: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:00:23 DEBUG : potato3: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:00:24 DEBUG : potato3: Trying to read object after upload: try again in 200ms (2/10) fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure 2026/06/11 04:00:32 DEBUG : potato2: Need to transfer - File not found at Destination 2026/06/11 04:00:32 DEBUG : empty space: size = 1 OK 2026/06/11 04:00:32 DEBUG : empty space: Sizes identical 2026/06/11 04:00:32 DEBUG : empty space: Unchanged skipping 2026/06/11 04:00:32 DEBUG : potato3: size = 68 (Linkbox root 'rclone-test-jagiguk4mehu') 2026/06/11 04:00:32 DEBUG : potato3: size = 60 (Linkbox root 'rclone-test-conuhig5wiqe') 2026/06/11 04:00:32 DEBUG : potato3: Sizes differ 2026/06/11 04:00:32 DEBUG : Linkbox root 'rclone-test-conuhig5wiqe': Waiting for checks to finish 2026/06/11 04:00:32 NOTICE: Time may be set wrong - time from "aht.nuplink3.net" is 338h51m43.801815621s different from this computer 2026/06/11 04:00:32 DEBUG : potato3: Update: removing old file 2026/06/11 04:00:33 INFO : empty space: Deleted 2026/06/11 04:00:33 DEBUG : Linkbox root 'rclone-test-conuhig5wiqe': Waiting for transfers to finish 2026/06/11 04:00:34 DEBUG : potato2: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:00:35 DEBUG : potato2: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:00:35 DEBUG : potato2: Trying to read object after upload: try again in 400ms (3/10) 2026/06/11 04:00:36 DEBUG : potato3: size = 68 OK 2026/06/11 04:00:36 INFO : potato3: Copied (replaced existing) 2026/06/11 04:00:36 DEBUG : potato2: size = 60 OK 2026/06/11 04:00:36 INFO : potato2: Copied (new) 2026/06/11 04:00:37 INFO : potato3: Deleted 2026/06/11 04:00:37 INFO : potato2: Deleted fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure 2026/06/11 04:00:45 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-jakeluj9viki" 2026/06/11 04:00:45 DEBUG : Linkbox root 'rclone-test-jakeluj9viki': Using cached web token 2026/06/11 04:00:46 DEBUG : empty space: Need to transfer - File not found at Destination 2026/06/11 04:00:46 DEBUG : potato2: Need to transfer - File not found at Destination 2026/06/11 04:00:46 DEBUG : potato3: Need to transfer - File not found at Destination 2026/06/11 04:00:46 DEBUG : Linkbox root 'rclone-test-jakeluj9viki': Waiting for checks to finish 2026/06/11 04:00:46 DEBUG : Linkbox root 'rclone-test-jakeluj9viki': Waiting for transfers to finish 2026/06/11 04:00:50 DEBUG : potato2: size = 60 OK 2026/06/11 04:00:50 INFO : potato2: Copied (new) 2026/06/11 04:00:50 DEBUG : potato3: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:00:51 DEBUG : empty space: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:00:51 DEBUG : potato3: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:00:51 DEBUG : empty space: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:00:51 DEBUG : potato3: size = 68 OK 2026/06/11 04:00:51 INFO : potato3: Copied (new) 2026/06/11 04:00:52 DEBUG : empty space: size = 1 OK 2026/06/11 04:00:52 INFO : empty space: Copied (new) 2026/06/11 04:00:52 INFO : potato2: Deleted 2026/06/11 04:00:53 INFO : potato3: Deleted 2026/06/11 04:00:53 INFO : empty space: Deleted fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure 2026/06/11 04:01:01 DEBUG : Linkbox root 'rclone-test-jakeluj9viki': Purge remote 2026/06/11 04:01:02 DEBUG : Linkbox root 'rclone-test-conuhig5wiqe': Purge remote --- PASS: TestServerSideMove (63.03s) === RUN TestServerSideMoveWithFilter run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 04:01:04 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-buxedin7bama" 2026/06/11 04:01:04 DEBUG : Linkbox root 'rclone-test-buxedin7bama': Using cached web token 2026/06/11 04:01:07 DEBUG : potato2: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:01:07 DEBUG : potato2: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:01:07 DEBUG : potato2: Trying to read object after upload: try again in 400ms (3/10) 2026/06/11 04:01:10 DEBUG : empty space: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:01:10 DEBUG : empty space: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:01:13 DEBUG : potato3: Trying to read object after upload: try again in 100ms (1/10) sync_test.go:1736: Server side move (if possible) Linkbox root 'rclone-test-jagiguk4mehu' -> Linkbox root 'rclone-test-buxedin7bama' 2026/06/11 04:01:17 DEBUG : empty space: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:01:19 DEBUG : potato3: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:01:20 DEBUG : potato3: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:01:20 DEBUG : potato3: Trying to read object after upload: try again in 400ms (3/10) 2026/06/11 04:01:21 DEBUG : empty space: Excluded (Size Filter) 2026/06/11 04:01:21 DEBUG : empty space: Excluded 2026/06/11 04:01:21 DEBUG : empty space: Excluded (Size Filter) 2026/06/11 04:01:21 DEBUG : empty space: Excluded 2026/06/11 04:01:21 DEBUG : potato2: Need to transfer - File not found at Destination 2026/06/11 04:01:21 DEBUG : potato3: size = 68 (Linkbox root 'rclone-test-jagiguk4mehu') 2026/06/11 04:01:21 DEBUG : potato3: size = 60 (Linkbox root 'rclone-test-buxedin7bama') 2026/06/11 04:01:21 DEBUG : potato3: Sizes differ 2026/06/11 04:01:21 DEBUG : Linkbox root 'rclone-test-buxedin7bama': Waiting for checks to finish 2026/06/11 04:01:21 DEBUG : Linkbox root 'rclone-test-buxedin7bama': Waiting for transfers to finish 2026/06/11 04:01:22 DEBUG : potato3: Update: removing old file 2026/06/11 04:01:23 DEBUG : potato2: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:01:24 DEBUG : potato2: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:01:24 DEBUG : potato2: size = 60 OK 2026/06/11 04:01:24 INFO : potato2: Copied (new) 2026/06/11 04:01:25 DEBUG : potato3: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:01:25 DEBUG : potato3: size = 68 OK 2026/06/11 04:01:25 INFO : potato3: Copied (replaced existing) 2026/06/11 04:01:26 INFO : potato2: Deleted 2026/06/11 04:01:27 INFO : potato3: Deleted fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure 2026/06/11 04:01:35 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-womefow4toxo" 2026/06/11 04:01:35 DEBUG : Linkbox root 'rclone-test-womefow4toxo': Using cached web token 2026/06/11 04:01:35 DEBUG : empty space: Excluded (Size Filter) 2026/06/11 04:01:35 DEBUG : empty space: Excluded 2026/06/11 04:01:35 DEBUG : potato2: Need to transfer - File not found at Destination 2026/06/11 04:01:35 DEBUG : potato3: Need to transfer - File not found at Destination 2026/06/11 04:01:35 DEBUG : Linkbox root 'rclone-test-womefow4toxo': Waiting for checks to finish 2026/06/11 04:01:35 DEBUG : Linkbox root 'rclone-test-womefow4toxo': Waiting for transfers to finish 2026/06/11 04:01:39 DEBUG : potato2: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:01:40 DEBUG : potato3: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:01:40 DEBUG : potato2: size = 60 OK 2026/06/11 04:01:40 INFO : potato2: Copied (new) 2026/06/11 04:01:40 DEBUG : potato3: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:01:40 DEBUG : potato3: size = 68 OK 2026/06/11 04:01:40 INFO : potato3: Copied (new) 2026/06/11 04:01:41 INFO : potato2: Deleted 2026/06/11 04:01:42 INFO : potato3: Deleted fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure 2026/06/11 04:01:50 DEBUG : Linkbox root 'rclone-test-womefow4toxo': Purge remote 2026/06/11 04:01:51 DEBUG : Linkbox root 'rclone-test-buxedin7bama': Purge remote fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- PASS: TestServerSideMoveWithFilter (57.68s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 04:02:02 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-wurugod6waci" 2026/06/11 04:02:02 DEBUG : Linkbox root 'rclone-test-wurugod6waci': Using cached web token 2026/06/11 04:02:04 DEBUG : potato2: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:02:05 DEBUG : potato2: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:02:07 DEBUG : empty space: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:02:07 DEBUG : empty space: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:02:10 DEBUG : potato3: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:02:10 INFO : tomatoDir: Making directory sync_test.go:1736: Server side move (if possible) Linkbox root 'rclone-test-jagiguk4mehu' -> Linkbox root 'rclone-test-wurugod6waci' 2026/06/11 04:02:17 DEBUG : potato3: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:02:18 DEBUG : potato2: Need to transfer - File not found at Destination 2026/06/11 04:02:18 DEBUG : empty space: size = 1 OK 2026/06/11 04:02:18 DEBUG : empty space: Sizes identical 2026/06/11 04:02:18 DEBUG : potato3: size = 68 (Linkbox root 'rclone-test-jagiguk4mehu') 2026/06/11 04:02:18 DEBUG : empty space: Unchanged skipping 2026/06/11 04:02:18 DEBUG : potato3: size = 60 (Linkbox root 'rclone-test-wurugod6waci') 2026/06/11 04:02:18 DEBUG : potato3: Sizes differ 2026/06/11 04:02:18 DEBUG : Linkbox root 'rclone-test-wurugod6waci': Waiting for checks to finish 2026/06/11 04:02:19 DEBUG : potato3: Update: removing old file 2026/06/11 04:02:20 INFO : empty space: Deleted 2026/06/11 04:02:20 DEBUG : Linkbox root 'rclone-test-wurugod6waci': Waiting for transfers to finish 2026/06/11 04:02:21 DEBUG : potato2: size = 60 OK 2026/06/11 04:02:21 INFO : potato2: Copied (new) 2026/06/11 04:02:22 INFO : potato2: Deleted 2026/06/11 04:02:22 DEBUG : potato3: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:02:22 DEBUG : potato3: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:02:23 DEBUG : potato3: Trying to read object after upload: try again in 400ms (3/10) 2026/06/11 04:02:23 DEBUG : potato3: Trying to read object after upload: try again in 800ms (4/10) 2026/06/11 04:02:24 DEBUG : potato3: size = 68 OK 2026/06/11 04:02:24 INFO : potato3: Copied (replaced existing) 2026/06/11 04:02:26 INFO : potato3: Deleted 2026/06/11 04:02:26 INFO : tomatoDir: Removing directory 2026/06/11 04:02:27 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': deleted 1 directories 2026/06/11 04:02:28 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-sadotuv8yime" 2026/06/11 04:02:28 DEBUG : Linkbox root 'rclone-test-sadotuv8yime': Using cached web token 2026/06/11 04:02:29 INFO : tomatoDir: Making directory 2026/06/11 04:02:30 DEBUG : empty space: Need to transfer - File not found at Destination 2026/06/11 04:02:30 DEBUG : potato2: Need to transfer - File not found at Destination 2026/06/11 04:02:30 DEBUG : potato3: Need to transfer - File not found at Destination 2026/06/11 04:02:31 DEBUG : Linkbox root 'rclone-test-sadotuv8yime': Waiting for checks to finish 2026/06/11 04:02:31 DEBUG : Linkbox root 'rclone-test-sadotuv8yime': Waiting for transfers to finish 2026/06/11 04:02:35 DEBUG : empty space: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:02:35 DEBUG : potato2: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:02:36 DEBUG : potato3: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:02:36 DEBUG : empty space: size = 1 OK 2026/06/11 04:02:36 INFO : empty space: Copied (new) 2026/06/11 04:02:36 DEBUG : potato2: size = 60 OK 2026/06/11 04:02:36 INFO : potato2: Copied (new) 2026/06/11 04:02:36 DEBUG : potato3: size = 68 OK 2026/06/11 04:02:36 INFO : potato3: Copied (new) 2026/06/11 04:02:37 INFO : empty space: Deleted 2026/06/11 04:02:37 INFO : potato2: Deleted 2026/06/11 04:02:38 INFO : potato3: Deleted 2026/06/11 04:02:38 INFO : tomatoDir: Removing directory 2026/06/11 04:02:39 DEBUG : Linkbox root 'rclone-test-wurugod6waci': deleted 1 directories 2026/06/11 04:02:40 DEBUG : Linkbox root 'rclone-test-sadotuv8yime': Purge remote 2026/06/11 04:02:41 DEBUG : Linkbox root 'rclone-test-wurugod6waci': Purge remote --- PASS: TestServerSideMoveDeleteEmptySourceDirs (41.19s) === RUN TestServerSideMoveOverlap run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 04:02:43 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-jagiguk4mehu/rclone-move-test" 2026/06/11 04:02:43 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu/rclone-move-test': Using cached web token 2026/06/11 04:02:46 DEBUG : potato2: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:02:46 DEBUG : potato2: Trying to read object after upload: try again in 200ms (2/10) fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- PASS: TestServerSideMoveOverlap (13.24s) === RUN TestSyncOverlap run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 04:02:56 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-jagiguk4mehu/rclone-sync-test" 2026/06/11 04:02:56 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu/rclone-sync-test': Using cached web token --- PASS: TestSyncOverlap (1.46s) === RUN TestSyncCompareDest run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 04:02:57 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-jagiguk4mehu/dst" 2026/06/11 04:02:57 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu/dst': Using cached web token 2026/06/11 04:02:58 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-jagiguk4mehu/CompareDest" 2026/06/11 04:02:58 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu/CompareDest': Using cached web token 2026/06/11 04:03:00 DEBUG : one: Need to transfer - File not found at Destination 2026/06/11 04:03:00 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu/dst': Waiting for checks to finish 2026/06/11 04:03:00 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu/dst': Waiting for transfers to finish 2026/06/11 04:03:03 DEBUG : one: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:03:04 DEBUG : one: size = 3 OK 2026/06/11 04:03:04 INFO : one: Copied (new) 2026/06/11 04:03:04 DEBUG : Waiting for deletions to finish 2026/06/11 04:03:05 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu/dst': Waiting for checks to finish 2026/06/11 04:03:05 DEBUG : one: size = 5 (Local file system at /tmp/rclone1752417802) 2026/06/11 04:03:05 DEBUG : one: size = 3 (Linkbox root 'rclone-test-jagiguk4mehu/dst') 2026/06/11 04:03:05 DEBUG : one: Sizes differ 2026/06/11 04:03:05 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu/dst': Waiting for transfers to finish 2026/06/11 04:03:05 DEBUG : one: Update: removing old file 2026/06/11 04:03:08 DEBUG : one: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:03:09 DEBUG : one: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:03:09 DEBUG : one: Trying to read object after upload: try again in 400ms (3/10) 2026/06/11 04:03:10 DEBUG : one: Trying to read object after upload: try again in 800ms (4/10) 2026/06/11 04:03:11 DEBUG : one: Trying to read object after upload: try again in 1.6s (5/10) 2026/06/11 04:03:12 DEBUG : one: Trying to read object after upload: try again in 3.2s (6/10) 2026/06/11 04:03:16 DEBUG : one: Trying to read object after upload: try again in 6.4s (7/10) 2026/06/11 04:03:22 DEBUG : one: Trying to read object after upload: try again in 12.8s (8/10) 2026/06/11 04:03:35 DEBUG : one: Trying to read object after upload: try again in 25.6s (9/10) 2026/06/11 04:04:01 DEBUG : one: Trying to read object after upload: try again in 51.2s (10/10) 2026/06/11 04:04:52 ERROR : one: Failed to copy: object not found 2026/06/11 04:04:52 ERROR : Linkbox root 'rclone-test-jagiguk4mehu/dst': not deleting files as there were IO errors 2026/06/11 04:04:52 ERROR : Linkbox root 'rclone-test-jagiguk4mehu/dst': not deleting directories as there were IO errors sync_test.go:2132: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2132 Error: Received unexpected error: object not found Test: TestSyncCompareDest run.go:186: removing dir "dst" failed - try 1/3: sleeping 1s: directory not empty --- FAIL: TestSyncCompareDest (119.92s) === RUN TestSyncMultipleCompareDest run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 04:05:03 DEBUG : pre-dest1/1: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:05:04 DEBUG : pre-dest1/1: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:05:04 DEBUG : pre-dest1/1: Trying to read object after upload: try again in 400ms (3/10) 2026/06/11 04:05:11 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-jagiguk4mehu/dest" 2026/06/11 04:05:11 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu/dest': Using cached web token 2026/06/11 04:05:11 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-jagiguk4mehu/pre-dest1" 2026/06/11 04:05:11 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu/pre-dest1': Using cached web token 2026/06/11 04:05:12 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-jagiguk4mehu/pre-dest2" 2026/06/11 04:05:12 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu/pre-dest2': Using cached web token 2026/06/11 04:05:13 DEBUG : 1: size = 1 OK 2026/06/11 04:05:13 DEBUG : 1: Sizes identical 2026/06/11 04:05:13 DEBUG : 1: Destination found in --compare-dest, skipping 2026/06/11 04:05:13 DEBUG : 2: size = 1 OK 2026/06/11 04:05:13 DEBUG : 2: Sizes identical 2026/06/11 04:05:13 DEBUG : 2: Destination found in --compare-dest, skipping 2026/06/11 04:05:14 DEBUG : 3: Need to transfer - File not found at Destination 2026/06/11 04:05:14 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu/dest': Waiting for checks to finish 2026/06/11 04:05:14 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu/dest': Waiting for transfers to finish 2026/06/11 04:05:18 DEBUG : 3: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:05:18 DEBUG : 3: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:05:19 DEBUG : 3: Trying to read object after upload: try again in 400ms (3/10) 2026/06/11 04:05:19 DEBUG : 3: Trying to read object after upload: try again in 800ms (4/10) 2026/06/11 04:05:20 DEBUG : 3: size = 1 OK 2026/06/11 04:05:20 INFO : 3: Copied (new) 2026/06/11 04:05:20 DEBUG : Waiting for deletions to finish --- PASS: TestSyncMultipleCompareDest (33.86s) === RUN TestSyncCopyDest run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" sync_test.go:2266: Skipping test as remote does not support server-side copy --- SKIP: TestSyncCopyDest (0.42s) === RUN TestSyncBackupDir run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" sync_test.go:2379: Skipping test as remote does not support server-side move --- SKIP: TestSyncBackupDir (0.41s) === RUN TestSyncBackupDirWithSuffix run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" sync_test.go:2379: Skipping test as remote does not support server-side move --- SKIP: TestSyncBackupDirWithSuffix (0.42s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" sync_test.go:2379: Skipping test as remote does not support server-side move --- SKIP: TestSyncBackupDirWithSuffixKeepExtension (0.42s) === RUN TestSyncBackupDirSuffixOnly run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" sync_test.go:2379: Skipping test as remote does not support server-side move --- SKIP: TestSyncBackupDirSuffixOnly (0.40s) === RUN TestSyncSuffix run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" sync_test.go:2480: Skipping test as remote does not support server-side move --- SKIP: TestSyncSuffix (0.41s) === RUN TestSyncSuffixKeepExtension run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" sync_test.go:2480: Skipping test as remote does not support server-side move --- SKIP: TestSyncSuffixKeepExtension (0.45s) === RUN TestSyncUTFNorm run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 04:05:36 DEBUG : Testêé: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:05:37 DEBUG : Testêé: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:05:37 DEBUG : Testêé: Trying to read object after upload: try again in 400ms (3/10) 2026/06/11 04:05:38 DEBUG : Testêé: size = 14 (Local file system at /tmp/rclone1752417802) 2026/06/11 04:05:38 DEBUG : Testêé: size = 18 (Linkbox root 'rclone-test-jagiguk4mehu') 2026/06/11 04:05:38 DEBUG : Testêé: Sizes differ 2026/06/11 04:05:38 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 04:05:38 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 04:05:38 DEBUG : Testêé: Update: removing old file 2026/06/11 04:05:41 DEBUG : Testêé: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:05:41 DEBUG : Testêé: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:05:42 DEBUG : Testêé: Trying to read object after upload: try again in 400ms (3/10) 2026/06/11 04:05:42 DEBUG : Testêé: Trying to read object after upload: try again in 800ms (4/10) 2026/06/11 04:05:43 DEBUG : Testêé: Trying to read object after upload: try again in 1.6s (5/10) 2026/06/11 04:05:45 DEBUG : Testêé: Trying to read object after upload: try again in 3.2s (6/10) 2026/06/11 04:05:49 DEBUG : Testêé: Trying to read object after upload: try again in 6.4s (7/10) 2026/06/11 04:05:55 DEBUG : Testêé: Trying to read object after upload: try again in 12.8s (8/10) 2026/06/11 04:06:08 DEBUG : Testêé: Trying to read object after upload: try again in 25.6s (9/10) 2026/06/11 04:06:34 DEBUG : Testêé: Trying to read object after upload: try again in 51.2s (10/10) 2026/06/11 04:07:25 ERROR : Testêé: Failed to copy: object not found 2026/06/11 04:07:25 ERROR : Linkbox root 'rclone-test-jagiguk4mehu': not deleting files as there were IO errors 2026/06/11 04:07:25 ERROR : Linkbox root 'rclone-test-jagiguk4mehu': not deleting directories as there were IO errors sync_test.go:2582: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2582 Error: Received unexpected error: object not found Test: TestSyncUTFNorm fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- FAIL: TestSyncUTFNorm (120.36s) === RUN TestSyncImmutable run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 04:07:35 DEBUG : existing: Need to transfer - File not found at Destination 2026/06/11 04:07:35 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 04:07:35 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 04:07:37 DEBUG : existing: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:07:37 DEBUG : existing: size = 6 OK 2026/06/11 04:07:37 INFO : existing: Copied (new) 2026/06/11 04:07:37 DEBUG : Waiting for deletions to finish 2026/06/11 04:07:38 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 04:07:38 DEBUG : existing: size = 8 (Local file system at /tmp/rclone1752417802) 2026/06/11 04:07:38 DEBUG : existing: size = 6 (Linkbox root 'rclone-test-jagiguk4mehu') 2026/06/11 04:07:38 DEBUG : existing: Sizes differ 2026/06/11 04:07:38 ERROR : existing: Source and destination exist but do not match: immutable file modified 2026/06/11 04:07:38 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 04:07:38 ERROR : Linkbox root 'rclone-test-jagiguk4mehu': not deleting files as there were IO errors 2026/06/11 04:07:38 ERROR : Linkbox root 'rclone-test-jagiguk4mehu': not deleting directories as there were IO errors --- PASS: TestSyncImmutable (5.34s) === RUN TestSyncIgnoreCase run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" sync_test.go:2637: Skipping test as local or remote are case-insensitive --- SKIP: TestSyncIgnoreCase (0.41s) === RUN TestMaxTransfer === RUN TestMaxTransfer/Hard run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" sync_test.go:2705: This test only runs on local === RUN TestMaxTransfer/Soft run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" sync_test.go:2705: This test only runs on local === RUN TestMaxTransfer/Cautious run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" sync_test.go:2705: This test only runs on local --- PASS: TestMaxTransfer (1.24s) --- SKIP: TestMaxTransfer/Hard (0.43s) --- SKIP: TestMaxTransfer/Soft (0.41s) --- SKIP: TestMaxTransfer/Cautious (0.40s) === RUN TestSyncConcurrentDelete run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 04:07:43 DEBUG : both0: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:07:44 DEBUG : both0: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:07:44 DEBUG : both0: Trying to read object after upload: try again in 400ms (3/10) 2026/06/11 04:07:51 DEBUG : only1: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:07:51 DEBUG : only1: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:07:56 DEBUG : only2: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:07:58 DEBUG : both3: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:07:58 DEBUG : both3: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:08:01 DEBUG : only3: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:08:07 DEBUG : both5: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:08:08 DEBUG : both5: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:08:10 DEBUG : only5: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:08:10 DEBUG : only5: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:08:13 DEBUG : both6: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:08:13 DEBUG : both6: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:08:14 DEBUG : both6: Trying to read object after upload: try again in 400ms (3/10) 2026/06/11 04:08:18 DEBUG : both7: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:08:21 DEBUG : only7: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:08:23 DEBUG : both8: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:08:23 DEBUG : both8: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:08:24 DEBUG : both8: Trying to read object after upload: try again in 400ms (3/10) 2026/06/11 04:08:26 DEBUG : only8: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:08:27 DEBUG : only8: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:08:27 DEBUG : only8: Trying to read object after upload: try again in 400ms (3/10) 2026/06/11 04:08:32 DEBUG : only9: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:08:34 DEBUG : both10: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:08:34 DEBUG : both10: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:08:46 DEBUG : only12: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:08:49 DEBUG : both13: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:08:49 DEBUG : both13: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:08:52 DEBUG : only13: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:08:57 DEBUG : only14: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:09:00 DEBUG : both15: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:09:01 DEBUG : both15: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:09:04 DEBUG : only15: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:09:04 DEBUG : only15: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:09:05 DEBUG : only15: Trying to read object after upload: try again in 400ms (3/10) 2026/06/11 04:09:05 DEBUG : only15: Trying to read object after upload: try again in 800ms (4/10) 2026/06/11 04:09:09 DEBUG : both16: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:09:09 DEBUG : both16: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:09:15 DEBUG : both17: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:09:15 DEBUG : both17: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:09:16 DEBUG : both17: Trying to read object after upload: try again in 400ms (3/10) 2026/06/11 04:09:19 DEBUG : only17: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:09:19 DEBUG : only17: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:09:20 DEBUG : only17: Trying to read object after upload: try again in 400ms (3/10) 2026/06/11 04:09:26 DEBUG : only18: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:09:26 DEBUG : only18: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:09:29 DEBUG : both19: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:09:32 DEBUG : only19: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:09:33 DEBUG : both11: size = 6 OK 2026/06/11 04:09:33 DEBUG : both0: size = 6 OK 2026/06/11 04:09:33 DEBUG : both11: Sizes identical 2026/06/11 04:09:33 DEBUG : both0: Sizes identical 2026/06/11 04:09:33 DEBUG : both12: size = 6 OK 2026/06/11 04:09:33 DEBUG : both12: Sizes identical 2026/06/11 04:09:33 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 04:09:33 DEBUG : both11: Unchanged skipping 2026/06/11 04:09:33 DEBUG : both13: size = 6 OK 2026/06/11 04:09:33 DEBUG : both10: size = 6 OK 2026/06/11 04:09:33 DEBUG : both10: Sizes identical 2026/06/11 04:09:33 DEBUG : both13: Sizes identical 2026/06/11 04:09:33 DEBUG : both0: Unchanged skipping 2026/06/11 04:09:33 DEBUG : both14: size = 6 OK 2026/06/11 04:09:33 DEBUG : both14: Sizes identical 2026/06/11 04:09:33 DEBUG : both14: Unchanged skipping 2026/06/11 04:09:33 DEBUG : both15: size = 6 OK 2026/06/11 04:09:33 DEBUG : both15: Sizes identical 2026/06/11 04:09:33 DEBUG : both12: Unchanged skipping 2026/06/11 04:09:33 DEBUG : both16: size = 6 OK 2026/06/11 04:09:33 DEBUG : both16: Sizes identical 2026/06/11 04:09:33 DEBUG : both10: Unchanged skipping 2026/06/11 04:09:33 DEBUG : both17: size = 6 OK 2026/06/11 04:09:33 DEBUG : both17: Sizes identical 2026/06/11 04:09:33 DEBUG : both13: Unchanged skipping 2026/06/11 04:09:33 DEBUG : both18: size = 6 OK 2026/06/11 04:09:33 DEBUG : both18: Sizes identical 2026/06/11 04:09:33 DEBUG : both18: Unchanged skipping 2026/06/11 04:09:33 DEBUG : both19: size = 6 OK 2026/06/11 04:09:33 DEBUG : both19: Sizes identical 2026/06/11 04:09:33 DEBUG : both19: Unchanged skipping 2026/06/11 04:09:33 DEBUG : both1: size = 6 OK 2026/06/11 04:09:33 DEBUG : both1: Sizes identical 2026/06/11 04:09:33 DEBUG : both1: Unchanged skipping 2026/06/11 04:09:33 DEBUG : both2: size = 6 OK 2026/06/11 04:09:33 DEBUG : both2: Sizes identical 2026/06/11 04:09:33 DEBUG : both2: Unchanged skipping 2026/06/11 04:09:33 DEBUG : both3: size = 6 OK 2026/06/11 04:09:33 DEBUG : both3: Sizes identical 2026/06/11 04:09:33 DEBUG : both3: Unchanged skipping 2026/06/11 04:09:33 DEBUG : both4: size = 6 OK 2026/06/11 04:09:33 DEBUG : both4: Sizes identical 2026/06/11 04:09:33 DEBUG : both4: Unchanged skipping 2026/06/11 04:09:33 DEBUG : both5: size = 6 OK 2026/06/11 04:09:33 DEBUG : both5: Sizes identical 2026/06/11 04:09:33 DEBUG : both15: Unchanged skipping 2026/06/11 04:09:33 DEBUG : both6: size = 6 OK 2026/06/11 04:09:33 DEBUG : both6: Sizes identical 2026/06/11 04:09:33 DEBUG : both6: Unchanged skipping 2026/06/11 04:09:33 DEBUG : both7: size = 6 OK 2026/06/11 04:09:33 DEBUG : both7: Sizes identical 2026/06/11 04:09:33 DEBUG : both7: Unchanged skipping 2026/06/11 04:09:33 DEBUG : both8: size = 6 OK 2026/06/11 04:09:33 DEBUG : both8: Sizes identical 2026/06/11 04:09:33 DEBUG : both16: Unchanged skipping 2026/06/11 04:09:33 DEBUG : both9: size = 6 OK 2026/06/11 04:09:33 DEBUG : both9: Sizes identical 2026/06/11 04:09:33 DEBUG : both9: Unchanged skipping 2026/06/11 04:09:33 DEBUG : both17: Unchanged skipping 2026/06/11 04:09:33 DEBUG : both5: Unchanged skipping 2026/06/11 04:09:33 DEBUG : both8: Unchanged skipping 2026/06/11 04:09:33 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 04:09:33 DEBUG : Waiting for deletions to finish 2026/06/11 04:09:34 INFO : only8: Deleted 2026/06/11 04:09:34 INFO : only0: Deleted 2026/06/11 04:09:35 INFO : only11: Deleted 2026/06/11 04:09:35 INFO : only14: Deleted 2026/06/11 04:09:36 INFO : only17: Deleted 2026/06/11 04:09:36 INFO : only5: Deleted 2026/06/11 04:09:36 INFO : only9: Deleted 2026/06/11 04:09:36 INFO : only2: Deleted 2026/06/11 04:09:37 INFO : only10: Deleted 2026/06/11 04:09:37 INFO : only12: Deleted 2026/06/11 04:09:37 INFO : only15: Deleted 2026/06/11 04:09:38 INFO : only18: Deleted 2026/06/11 04:09:38 INFO : only19: Deleted 2026/06/11 04:09:38 INFO : only4: Deleted 2026/06/11 04:09:39 INFO : only6: Deleted 2026/06/11 04:09:39 INFO : only3: Deleted 2026/06/11 04:09:39 INFO : only13: Deleted 2026/06/11 04:09:40 INFO : only16: Deleted 2026/06/11 04:09:40 INFO : only1: Deleted 2026/06/11 04:09:40 INFO : only7: Deleted 2026/06/11 04:09:40 INFO : There was nothing to transfer fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- PASS: TestSyncConcurrentDelete (160.97s) === RUN TestSyncConcurrentTruncate run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 04:10:24 DEBUG : both0: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:10:35 DEBUG : only2: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:10:35 DEBUG : only2: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:10:40 DEBUG : only3: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:10:40 DEBUG : only3: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:10:43 DEBUG : both4: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:10:45 DEBUG : only4: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:10:45 DEBUG : only4: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:10:48 DEBUG : both5: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:10:50 DEBUG : only5: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:10:50 DEBUG : only5: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:10:51 DEBUG : only5: Trying to read object after upload: try again in 400ms (3/10) 2026/06/11 04:10:53 DEBUG : both6: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:10:58 DEBUG : both7: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:11:00 DEBUG : only7: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:11:00 DEBUG : only7: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:11:07 DEBUG : both9: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:11:07 DEBUG : both9: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:11:08 DEBUG : both9: Trying to read object after upload: try again in 400ms (3/10) 2026/06/11 04:11:10 DEBUG : only9: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:11:11 DEBUG : only9: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:11:15 DEBUG : only10: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:11:15 DEBUG : only10: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:11:18 DEBUG : both11: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:11:23 DEBUG : both12: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:11:26 DEBUG : only12: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:11:26 DEBUG : only12: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:11:29 DEBUG : both13: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:11:32 DEBUG : only13: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:11:37 DEBUG : only14: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:11:40 DEBUG : both15: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:11:43 DEBUG : only15: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:11:46 DEBUG : both16: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:11:46 DEBUG : both16: Trying to read object after upload: try again in 200ms (2/10) 2026/06/11 04:11:49 DEBUG : only16: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:11:59 DEBUG : only18: Trying to read object after upload: try again in 100ms (1/10) 2026/06/11 04:12:05 DEBUG : both0: size = 6 OK 2026/06/11 04:12:05 DEBUG : both0: Sizes identical 2026/06/11 04:12:05 DEBUG : both0: Unchanged skipping 2026/06/11 04:12:05 DEBUG : both10: size = 6 OK 2026/06/11 04:12:05 DEBUG : both10: Sizes identical 2026/06/11 04:12:05 DEBUG : both10: Unchanged skipping 2026/06/11 04:12:05 DEBUG : both14: size = 6 OK 2026/06/11 04:12:05 DEBUG : both11: size = 6 OK 2026/06/11 04:12:05 DEBUG : both11: Sizes identical 2026/06/11 04:12:05 DEBUG : both14: Sizes identical 2026/06/11 04:12:05 DEBUG : both11: Unchanged skipping 2026/06/11 04:12:05 DEBUG : both15: size = 6 OK 2026/06/11 04:12:05 DEBUG : both15: Sizes identical 2026/06/11 04:12:05 DEBUG : both13: size = 6 OK 2026/06/11 04:12:05 DEBUG : both13: Sizes identical 2026/06/11 04:12:05 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for checks to finish 2026/06/11 04:12:05 DEBUG : both12: size = 6 OK 2026/06/11 04:12:05 DEBUG : both12: Sizes identical 2026/06/11 04:12:05 DEBUG : both14: Unchanged skipping 2026/06/11 04:12:05 DEBUG : both16: size = 6 OK 2026/06/11 04:12:05 DEBUG : both16: Sizes identical 2026/06/11 04:12:05 DEBUG : both16: Unchanged skipping 2026/06/11 04:12:05 DEBUG : both17: size = 6 OK 2026/06/11 04:12:05 DEBUG : both17: Sizes identical 2026/06/11 04:12:05 DEBUG : both17: Unchanged skipping 2026/06/11 04:12:05 DEBUG : both18: size = 6 OK 2026/06/11 04:12:05 DEBUG : both18: Sizes identical 2026/06/11 04:12:05 DEBUG : both18: Unchanged skipping 2026/06/11 04:12:05 DEBUG : both19: size = 6 OK 2026/06/11 04:12:05 DEBUG : both19: Sizes identical 2026/06/11 04:12:05 DEBUG : both15: Unchanged skipping 2026/06/11 04:12:05 DEBUG : both1: size = 6 OK 2026/06/11 04:12:05 DEBUG : both1: Sizes identical 2026/06/11 04:12:05 DEBUG : both13: Unchanged skipping 2026/06/11 04:12:05 DEBUG : both2: size = 6 OK 2026/06/11 04:12:05 DEBUG : both2: Sizes identical 2026/06/11 04:12:05 DEBUG : both2: Unchanged skipping 2026/06/11 04:12:05 DEBUG : both3: size = 6 OK 2026/06/11 04:12:05 DEBUG : both3: Sizes identical 2026/06/11 04:12:05 DEBUG : both3: Unchanged skipping 2026/06/11 04:12:05 DEBUG : both4: size = 6 OK 2026/06/11 04:12:05 DEBUG : both4: Sizes identical 2026/06/11 04:12:05 DEBUG : both4: Unchanged skipping 2026/06/11 04:12:05 DEBUG : both5: size = 6 OK 2026/06/11 04:12:05 DEBUG : both5: Sizes identical 2026/06/11 04:12:05 DEBUG : both5: Unchanged skipping 2026/06/11 04:12:05 DEBUG : both6: size = 6 OK 2026/06/11 04:12:05 DEBUG : both6: Sizes identical 2026/06/11 04:12:05 DEBUG : both12: Unchanged skipping 2026/06/11 04:12:05 DEBUG : both7: size = 6 OK 2026/06/11 04:12:05 DEBUG : both7: Sizes identical 2026/06/11 04:12:05 DEBUG : both6: Unchanged skipping 2026/06/11 04:12:05 DEBUG : both8: size = 6 OK 2026/06/11 04:12:05 DEBUG : both8: Sizes identical 2026/06/11 04:12:05 DEBUG : both8: Unchanged skipping 2026/06/11 04:12:05 DEBUG : both9: size = 6 OK 2026/06/11 04:12:05 DEBUG : both9: Sizes identical 2026/06/11 04:12:05 DEBUG : both9: Unchanged skipping 2026/06/11 04:12:05 DEBUG : only0: size = 0 (Local file system at /tmp/rclone1752417802) 2026/06/11 04:12:05 DEBUG : only0: size = 6 (Linkbox root 'rclone-test-jagiguk4mehu') 2026/06/11 04:12:05 DEBUG : only0: Sizes differ 2026/06/11 04:12:05 DEBUG : both19: Unchanged skipping 2026/06/11 04:12:05 DEBUG : only10: size = 0 (Local file system at /tmp/rclone1752417802) 2026/06/11 04:12:05 DEBUG : only10: size = 6 (Linkbox root 'rclone-test-jagiguk4mehu') 2026/06/11 04:12:05 DEBUG : only10: Sizes differ 2026/06/11 04:12:05 DEBUG : only11: size = 0 (Local file system at /tmp/rclone1752417802) 2026/06/11 04:12:05 DEBUG : only11: size = 6 (Linkbox root 'rclone-test-jagiguk4mehu') 2026/06/11 04:12:05 DEBUG : only11: Sizes differ 2026/06/11 04:12:05 DEBUG : both1: Unchanged skipping 2026/06/11 04:12:05 DEBUG : both7: Unchanged skipping 2026/06/11 04:12:05 DEBUG : only12: size = 0 (Local file system at /tmp/rclone1752417802) 2026/06/11 04:12:05 DEBUG : only12: size = 6 (Linkbox root 'rclone-test-jagiguk4mehu') 2026/06/11 04:12:05 DEBUG : only12: Sizes differ 2026/06/11 04:12:05 ERROR : only10: Failed to copy: can't upload empty files to this remote 2026/06/11 04:12:05 DEBUG : only13: size = 0 (Local file system at /tmp/rclone1752417802) 2026/06/11 04:12:05 DEBUG : only13: size = 6 (Linkbox root 'rclone-test-jagiguk4mehu') 2026/06/11 04:12:05 DEBUG : only14: size = 0 (Local file system at /tmp/rclone1752417802) 2026/06/11 04:12:05 DEBUG : only14: size = 6 (Linkbox root 'rclone-test-jagiguk4mehu') 2026/06/11 04:12:05 DEBUG : only14: Sizes differ 2026/06/11 04:12:05 ERROR : only12: Failed to copy: can't upload empty files to this remote 2026/06/11 04:12:05 DEBUG : only15: size = 0 (Local file system at /tmp/rclone1752417802) 2026/06/11 04:12:05 DEBUG : only15: size = 6 (Linkbox root 'rclone-test-jagiguk4mehu') 2026/06/11 04:12:05 DEBUG : only15: Sizes differ 2026/06/11 04:12:05 DEBUG : only16: size = 0 (Local file system at /tmp/rclone1752417802) 2026/06/11 04:12:05 DEBUG : only16: size = 6 (Linkbox root 'rclone-test-jagiguk4mehu') 2026/06/11 04:12:05 ERROR : only14: Failed to copy: can't upload empty files to this remote 2026/06/11 04:12:05 DEBUG : only16: Sizes differ 2026/06/11 04:12:05 ERROR : only0: Failed to copy: can't upload empty files to this remote 2026/06/11 04:12:05 DEBUG : only17: size = 0 (Local file system at /tmp/rclone1752417802) 2026/06/11 04:12:05 DEBUG : only17: size = 6 (Linkbox root 'rclone-test-jagiguk4mehu') 2026/06/11 04:12:05 DEBUG : only17: Sizes differ 2026/06/11 04:12:05 ERROR : only16: Failed to copy: can't upload empty files to this remote 2026/06/11 04:12:05 DEBUG : only18: size = 0 (Local file system at /tmp/rclone1752417802) 2026/06/11 04:12:05 DEBUG : only18: size = 6 (Linkbox root 'rclone-test-jagiguk4mehu') 2026/06/11 04:12:05 DEBUG : only18: Sizes differ 2026/06/11 04:12:05 DEBUG : only13: Sizes differ 2026/06/11 04:12:05 ERROR : only17: Failed to copy: can't upload empty files to this remote 2026/06/11 04:12:05 DEBUG : only19: size = 0 (Local file system at /tmp/rclone1752417802) 2026/06/11 04:12:05 DEBUG : only19: size = 6 (Linkbox root 'rclone-test-jagiguk4mehu') 2026/06/11 04:12:05 DEBUG : only19: Sizes differ 2026/06/11 04:12:05 ERROR : only18: Failed to copy: can't upload empty files to this remote 2026/06/11 04:12:05 DEBUG : only1: size = 0 (Local file system at /tmp/rclone1752417802) 2026/06/11 04:12:05 DEBUG : only1: size = 6 (Linkbox root 'rclone-test-jagiguk4mehu') 2026/06/11 04:12:05 DEBUG : only1: Sizes differ 2026/06/11 04:12:05 ERROR : only13: Failed to copy: can't upload empty files to this remote 2026/06/11 04:12:05 DEBUG : only2: size = 0 (Local file system at /tmp/rclone1752417802) 2026/06/11 04:12:05 DEBUG : only2: size = 6 (Linkbox root 'rclone-test-jagiguk4mehu') 2026/06/11 04:12:05 DEBUG : only2: Sizes differ 2026/06/11 04:12:05 ERROR : only11: Failed to copy: can't upload empty files to this remote 2026/06/11 04:12:05 DEBUG : only4: size = 0 (Local file system at /tmp/rclone1752417802) 2026/06/11 04:12:05 DEBUG : only4: size = 6 (Linkbox root 'rclone-test-jagiguk4mehu') 2026/06/11 04:12:05 DEBUG : only4: Sizes differ 2026/06/11 04:12:05 ERROR : only15: Failed to copy: can't upload empty files to this remote 2026/06/11 04:12:05 DEBUG : only3: size = 0 (Local file system at /tmp/rclone1752417802) 2026/06/11 04:12:05 DEBUG : only3: size = 6 (Linkbox root 'rclone-test-jagiguk4mehu') 2026/06/11 04:12:05 DEBUG : only3: Sizes differ 2026/06/11 04:12:05 DEBUG : only5: size = 0 (Local file system at /tmp/rclone1752417802) 2026/06/11 04:12:05 DEBUG : only5: size = 6 (Linkbox root 'rclone-test-jagiguk4mehu') 2026/06/11 04:12:05 DEBUG : only5: Sizes differ 2026/06/11 04:12:05 DEBUG : only6: size = 0 (Local file system at /tmp/rclone1752417802) 2026/06/11 04:12:05 DEBUG : only6: size = 6 (Linkbox root 'rclone-test-jagiguk4mehu') 2026/06/11 04:12:05 DEBUG : only6: Sizes differ 2026/06/11 04:12:05 ERROR : only2: Failed to copy: can't upload empty files to this remote 2026/06/11 04:12:05 ERROR : only4: Failed to copy: can't upload empty files to this remote 2026/06/11 04:12:05 ERROR : only3: Failed to copy: can't upload empty files to this remote 2026/06/11 04:12:05 ERROR : only6: Failed to copy: can't upload empty files to this remote 2026/06/11 04:12:05 DEBUG : only7: size = 0 (Local file system at /tmp/rclone1752417802) 2026/06/11 04:12:05 DEBUG : only7: size = 6 (Linkbox root 'rclone-test-jagiguk4mehu') 2026/06/11 04:12:05 DEBUG : only7: Sizes differ 2026/06/11 04:12:05 DEBUG : only8: size = 0 (Local file system at /tmp/rclone1752417802) 2026/06/11 04:12:05 DEBUG : only8: size = 6 (Linkbox root 'rclone-test-jagiguk4mehu') 2026/06/11 04:12:05 DEBUG : only8: Sizes differ 2026/06/11 04:12:05 DEBUG : only9: size = 0 (Local file system at /tmp/rclone1752417802) 2026/06/11 04:12:05 DEBUG : only9: size = 6 (Linkbox root 'rclone-test-jagiguk4mehu') 2026/06/11 04:12:05 DEBUG : only9: Sizes differ 2026/06/11 04:12:05 ERROR : only1: Failed to copy: can't upload empty files to this remote 2026/06/11 04:12:05 ERROR : only7: Failed to copy: can't upload empty files to this remote 2026/06/11 04:12:05 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Waiting for transfers to finish 2026/06/11 04:12:05 ERROR : only9: Failed to copy: can't upload empty files to this remote 2026/06/11 04:12:05 ERROR : only5: Failed to copy: can't upload empty files to this remote 2026/06/11 04:12:05 ERROR : only8: Failed to copy: can't upload empty files to this remote 2026/06/11 04:12:05 ERROR : only19: Failed to copy: can't upload empty files to this remote 2026/06/11 04:12:05 ERROR : Linkbox root 'rclone-test-jagiguk4mehu': not deleting files as there were IO errors 2026/06/11 04:12:05 ERROR : Linkbox root 'rclone-test-jagiguk4mehu': not deleting directories as there were IO errors sync_test.go:2781: Skip test because remote cannot upload empty files fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- SKIP: TestSyncConcurrentTruncate (163.21s) === RUN TestSyncReplaceDirModTime run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 04:13:06 DEBUG : empty_dir: Making directory with metadata 2026/06/11 04:13:06 INFO : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2026/06/11 04:13:06 DEBUG : empty_on_remote: Making directory with metadata 2026/06/11 04:13:06 INFO : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2026/06/11 04:13:06 INFO : empty_on_remote: Making directory 2026/06/11 04:13:07 INFO : empty_on_remote: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC 2026/06/11 04:13:16 INFO : test_dir1: Set directory modification time (using DirSetModTime) 2026/06/11 04:13:16 INFO : test_dir2: Set directory modification time (using DirSetModTime) 2026/06/11 04:13:16 INFO : test_dir2/sub_dir: Set directory modification time (using DirSetModTime) 2026/06/11 04:13:16 INFO : empty_on_remote: Set directory modification time (using DirSetModTime) run.go:186: removing dir "test_dir2/sub_dir" failed - try 1/3: sleeping 1s: directory not empty --- PASS: TestSyncReplaceDirModTime (25.34s) === RUN TestSyncReplaceDirModTimeWithEmptyDirs run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 04:13:31 DEBUG : empty_dir: Making directory with metadata 2026/06/11 04:13:31 INFO : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2026/06/11 04:13:31 DEBUG : empty_on_remote: Making directory with metadata 2026/06/11 04:13:31 INFO : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2026/06/11 04:13:31 INFO : empty_on_remote: Making directory 2026/06/11 04:13:33 INFO : empty_on_remote: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC 2026/06/11 04:13:42 INFO : test_dir1: Set directory modification time (using DirSetModTime) 2026/06/11 04:13:42 INFO : test_dir2: Set directory modification time (using DirSetModTime) 2026/06/11 04:13:42 INFO : test_dir2/sub_dir: Set directory modification time (using DirSetModTime) 2026/06/11 04:13:42 INFO : empty_on_remote: Set directory modification time (using DirSetModTime) 2026/06/11 04:13:42 INFO : empty_dir: Set directory modification time (using DirSetModTime) --- PASS: TestSyncReplaceDirModTimeWithEmptyDirs (26.89s) === RUN TestNothingToTransferWithEmptyDirs run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 04:13:58 INFO : sub dir: Set directory modification time (using DirSetModTime) 2026/06/11 04:13:58 INFO : sub dir: Making directory 2026/06/11 04:13:59 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC run.go:186: removing dir "sub dir2/very/very/very/very/very/nested/subdir" failed - try 1/3: sleeping 1s: directory not empty run.go:186: removing dir "sub dir2/very/very/very/very/very/nested" failed - try 1/3: sleeping 1s: directory not empty fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- PASS: TestNothingToTransferWithEmptyDirs (52.29s) === RUN TestNothingToTransferWithoutEmptyDirs run.go:198: Remote "Linkbox root 'rclone-test-jagiguk4mehu'", Local "Local file system at /tmp/rclone1752417802", Modify Window "876000h0m0s" 2026/06/11 04:14:50 INFO : sub dir: Set directory modification time (using DirSetModTime) 2026/06/11 04:14:50 INFO : sub dir: Making directory 2026/06/11 04:14:52 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC run.go:186: removing dir "sub dir2/very/very/very/very/very/nested/subdir" failed - try 1/3: sleeping 1s: directory not empty --- PASS: TestNothingToTransferWithoutEmptyDirs (43.32s) FAIL 2026/06/11 04:15:34 DEBUG : Linkbox root 'rclone-test-jagiguk4mehu': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestCopyDeleteBefore|TestCopyEmptyDirectories|TestCopyWithFilesFromAndNoTraverse|TestMoveWithDeleteEmptySrcDirs|TestMoveWithIgnoreExisting|TestMoveWithoutDeleteEmptySrcDirs|TestNothingToTransferWithEmptyDirs|TestNothingToTransferWithoutEmptyDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveLocal|TestServerSideMoveOverlap|TestServerSideMoveWithFilter|TestSyncAfterAddingAFile|TestSyncAfterChangingContentsOnly|TestSyncAfterChangingFilesSizeOnly|TestSyncAfterChangingModtimeOnly|TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime|TestSyncAfterRemovingAFileAndAddingAFile|TestSyncAfterRemovingAFileAndAddingAFileDryRun|TestSyncAfterRemovingAFileAndAddingAFileSubDir|TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncCompareDest|TestSyncConcurrentDelete|TestSyncConcurrentTruncate|TestSyncCopyDest|TestSyncDeleteBefore|TestSyncDeleteDuring|TestSyncDoesntUpdateModtime|TestSyncIgnoreCase|TestSyncIgnoreErrors|TestSyncIgnoreExisting|TestSyncIgnoreSize|TestSyncIgnoreTimes|TestSyncImmutable|TestSyncMultipleCompareDest|TestSyncOverlap|TestSyncReplaceDirModTime|TestSyncReplaceDirModTimeWithEmptyDirs|TestSyncSuffix|TestSyncSuffixKeepExtension|TestSyncUTFNorm|TestSyncWithExclude|TestSyncWithExcludeAndDeleteExcluded|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime|TestSyncWithUpdateOlder)$|^TestMaxTransfer$/^(Cautious|Hard|Soft)$'" - Finished ERROR in 28m10.186269943s (try 3/5): exit status 1: Failed [TestSyncIgnoreTimes TestSyncAfterChangingFilesSizeOnly TestSyncCompareDest TestSyncUTFNorm]