"./sync.test -test.v -test.timeout 2h0m0s -remote TestPutio: -verbose -test.run '^(TestCopyDeleteBefore|TestMoveWithDeleteEmptySrcDirs|TestMoveWithIgnoreExisting|TestMoveWithoutDeleteEmptySrcDirs|TestServerSideCopy|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveWithFilter|TestSyncAfterAddingAFile|TestSyncAfterChangingContentsOnly|TestSyncAfterChangingFilesSizeOnly|TestSyncAfterRemovingAFileAndAddingAFile|TestSyncAfterRemovingAFileAndAddingAFileDryRun|TestSyncAfterRemovingAFileAndAddingAFileSubDir|TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncCompareDest|TestSyncConcurrentDelete|TestSyncConcurrentTruncate|TestSyncCopyDest|TestSyncDeleteBefore|TestSyncDeleteDuring|TestSyncIgnoreCase|TestSyncImmutable|TestSyncMultipleCompareDest|TestSyncSuffix|TestSyncSuffixKeepExtension|TestSyncUTFNorm|TestSyncWithExclude|TestSyncWithExcludeAndDeleteExcluded|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime|TestSyncWithUpdateOlder)$'" - Starting (try 2/5) 2022/03/02 06:05:15 DEBUG : Creating backend with remote "TestPutio:rclone-test-yizofus4kinogoh8lufaxad6" 2022/03/02 06:05:15 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2022/03/02 06:05:15 DEBUG : Creating backend with remote "/tmp/rclone3526237606" === RUN TestServerSideCopy run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" run.go:287: Failed to put "sub dir/hello world" to "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'": unexpected status code from upload create: 429 --- FAIL: TestServerSideCopy (0.95s) === RUN TestSyncAfterAddingAFile run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" run.go:287: Failed to put "empty space" to "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'": unexpected status code from upload create: 429 --- FAIL: TestSyncAfterAddingAFile (0.38s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" run.go:287: Failed to put "potato" to "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'": unexpected status code from upload create: 429 --- FAIL: TestSyncAfterChangingFilesSizeOnly (0.41s) === RUN TestSyncAfterChangingContentsOnly run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" run.go:287: Failed to put "potato" to "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'": unexpected status code from upload create: 429 --- FAIL: TestSyncAfterChangingContentsOnly (0.38s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" run.go:287: Failed to put "potato" to "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'": unexpected status code from upload create: 429 --- FAIL: TestSyncAfterRemovingAFileAndAddingAFileDryRun (0.38s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" run.go:287: Failed to put "potato" to "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'": unexpected status code from upload create: 429 --- FAIL: TestSyncAfterRemovingAFileAndAddingAFile (0.39s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" run.go:287: Failed to put "b/potato" to "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'": unexpected status code from upload create: 429 --- FAIL: TestSyncAfterRemovingAFileAndAddingAFileSubDir (0.80s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" run.go:287: Failed to put "b/potato" to "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'": unexpected status code from upload create: 429 --- FAIL: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (0.83s) === RUN TestSyncDeleteDuring run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" run.go:287: Failed to put "potato" to "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'": unexpected status code from upload create: 429 --- FAIL: TestSyncDeleteDuring (0.38s) === RUN TestSyncDeleteBefore run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" run.go:287: Failed to put "potato" to "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'": unexpected status code from upload create: 429 --- FAIL: TestSyncDeleteBefore (0.39s) === RUN TestCopyDeleteBefore run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" run.go:287: Failed to put "potato" to "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'": unexpected status code from upload create: 429 --- FAIL: TestCopyDeleteBefore (0.37s) === RUN TestSyncWithExclude run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" run.go:287: Failed to put "potato2" to "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'": unexpected status code from upload create: 429 --- FAIL: TestSyncWithExclude (0.39s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" run.go:287: Failed to put "potato2" to "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'": unexpected status code from upload create: 429 --- FAIL: TestSyncWithExcludeAndDeleteExcluded (0.40s) === RUN TestSyncWithUpdateOlder run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" run.go:287: Failed to put "one" to "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'": unexpected status code from upload create: 429 --- FAIL: TestSyncWithUpdateOlder (0.39s) === RUN TestSyncWithTrackRenames run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" sync_test.go:1058: Can track renames: true 2022/03/02 06:05:22 INFO : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Making map for --track-renames 2022/03/02 06:05:22 INFO : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Finished making map for --track-renames 2022/03/02 06:05:22 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Waiting for checks to finish 2022/03/02 06:05:22 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Waiting for renames to finish 2022/03/02 06:05:22 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Waiting for transfers to finish 2022/03/02 06:05:23 ERROR : potato: Failed to copy: unexpected status code from upload create: 429 2022/03/02 06:05:23 ERROR : yam: Failed to copy: unexpected status code from upload create: 429 2022/03/02 06:05:23 ERROR : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': not deleting files as there were IO errors 2022/03/02 06:05:23 ERROR : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': not deleting directories as there were IO errors sync_test.go:1064: Error Trace: sync_test.go:1064 Error: Received unexpected error: unexpected status code from upload create: 429 Test: TestSyncWithTrackRenames --- FAIL: TestSyncWithTrackRenames (0.46s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" sync_test.go:1127: Can track renames: true 2022/03/02 06:05:23 INFO : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Making map for --track-renames 2022/03/02 06:05:23 INFO : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Finished making map for --track-renames 2022/03/02 06:05:23 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Waiting for checks to finish 2022/03/02 06:05:23 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Waiting for renames to finish 2022/03/02 06:05:23 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Waiting for transfers to finish 2022/03/02 06:05:23 ERROR : yam: Failed to copy: unexpected status code from upload create: 429 2022/03/02 06:05:23 ERROR : potato: Failed to copy: unexpected status code from upload create: 429 2022/03/02 06:05:23 ERROR : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': not deleting files as there were IO errors 2022/03/02 06:05:23 ERROR : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': not deleting directories as there were IO errors sync_test.go:1133: Error Trace: sync_test.go:1133 Error: Received unexpected error: unexpected status code from upload create: 429 Test: TestSyncWithTrackRenamesStrategyModtime --- FAIL: TestSyncWithTrackRenamesStrategyModtime (0.45s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" sync_test.go:1163: Can track renames: true 2022/03/02 06:05:23 INFO : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Making map for --track-renames 2022/03/02 06:05:23 INFO : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Finished making map for --track-renames 2022/03/02 06:05:23 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Waiting for checks to finish 2022/03/02 06:05:23 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Waiting for renames to finish 2022/03/02 06:05:23 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Waiting for transfers to finish 2022/03/02 06:05:24 ERROR : potato: Failed to copy: unexpected status code from upload create: 429 2022/03/02 06:05:24 ERROR : sub/yam: Failed to copy: unexpected status code from upload create: 429 2022/03/02 06:05:24 ERROR : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': not deleting files as there were IO errors 2022/03/02 06:05:24 ERROR : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': not deleting directories as there were IO errors sync_test.go:1169: Error Trace: sync_test.go:1169 Error: Received unexpected error: unexpected status code from upload create: 429 Test: TestSyncWithTrackRenamesStrategyLeaf --- FAIL: TestSyncWithTrackRenamesStrategyLeaf (0.91s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" 2022/03/02 06:05:24 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Waiting for checks to finish 2022/03/02 06:05:24 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Waiting for transfers to finish 2022/03/02 06:05:25 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': chunkStart: 0, reqSize: 11 2022/03/02 06:05:25 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Sending chunk. transferOffset: 0 length: 11 2022/03/02 06:05:25 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': chunkStart: 0, reqSize: 6 2022/03/02 06:05:25 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Sending chunk. transferOffset: 0 length: 6 2022/03/02 06:05:26 DEBUG : sub dir/hello world: crc32 = 0d4a1185 OK 2022/03/02 06:05:26 INFO : sub dir/hello world: Copied (new) 2022/03/02 06:05:26 INFO : sub dir/hello world: Deleted 2022/03/02 06:05:26 DEBUG : nested/sub dir/file: crc32 = aac9c2e9 OK 2022/03/02 06:05:26 INFO : nested/sub dir/file: Copied (new) 2022/03/02 06:05:26 INFO : nested/sub dir/file: Deleted 2022/03/02 06:05:26 ERROR : Local file system at /tmp/rclone3526237606: not deleting directories as there were IO errors sync_test.go:1278: Error Trace: sync_test.go:1278 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestMoveWithDeleteEmptySrcDirs --- FAIL: TestMoveWithDeleteEmptySrcDirs (3.00s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" 2022/03/02 06:05:27 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Waiting for checks to finish 2022/03/02 06:05:27 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Waiting for transfers to finish 2022/03/02 06:05:28 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': chunkStart: 0, reqSize: 11 2022/03/02 06:05:28 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Sending chunk. transferOffset: 0 length: 11 2022/03/02 06:05:28 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': chunkStart: 0, reqSize: 6 2022/03/02 06:05:28 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Sending chunk. transferOffset: 0 length: 6 2022/03/02 06:05:29 DEBUG : nested/sub dir/file: crc32 = aac9c2e9 OK 2022/03/02 06:05:29 INFO : nested/sub dir/file: Copied (new) 2022/03/02 06:05:29 INFO : nested/sub dir/file: Deleted 2022/03/02 06:05:30 DEBUG : sub dir/hello world: crc32 = 0d4a1185 OK 2022/03/02 06:05:30 INFO : sub dir/hello world: Copied (new) 2022/03/02 06:05:30 INFO : sub dir/hello world: Deleted --- PASS: TestMoveWithoutDeleteEmptySrcDirs (4.00s) === RUN TestMoveWithIgnoreExisting run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" 2022/03/02 06:05:31 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Waiting for checks to finish 2022/03/02 06:05:31 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Waiting for transfers to finish 2022/03/02 06:05:32 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': chunkStart: 0, reqSize: 6 2022/03/02 06:05:32 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Sending chunk. transferOffset: 0 length: 6 2022/03/02 06:05:32 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': chunkStart: 0, reqSize: 6 2022/03/02 06:05:32 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Sending chunk. transferOffset: 0 length: 6 2022/03/02 06:05:32 DEBUG : existing: crc32 = 9a941a19 OK 2022/03/02 06:05:32 INFO : existing: Copied (new) 2022/03/02 06:05:32 INFO : existing: Deleted 2022/03/02 06:05:35 DEBUG : existing-b: crc32 = 2c14401a OK 2022/03/02 06:05:35 INFO : existing-b: Copied (new) 2022/03/02 06:05:35 INFO : existing-b: Deleted 2022/03/02 06:05:35 DEBUG : existing: Destination exists, skipping 2022/03/02 06:05:35 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set 2022/03/02 06:05:35 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Waiting for checks to finish 2022/03/02 06:05:35 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Waiting for transfers to finish 2022/03/02 06:05:35 INFO : There was nothing to transfer --- PASS: TestMoveWithIgnoreExisting (4.28s) === RUN TestServerSideMove run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" 2022/03/02 06:05:35 DEBUG : Creating backend with remote "TestPutio:rclone-test-hodayeb5cutocin5yedusej5" 2022/03/02 06:05:36 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': chunkStart: 0, reqSize: 60 2022/03/02 06:05:36 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Sending chunk. transferOffset: 0 length: 60 2022/03/02 06:05:37 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': chunkStart: 0, reqSize: 1 2022/03/02 06:05:37 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Sending chunk. transferOffset: 0 length: 1 2022/03/02 06:05:38 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': chunkStart: 0, reqSize: 68 2022/03/02 06:05:38 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Sending chunk. transferOffset: 0 length: 68 sync_test.go:1215: Server side move (if possible) Putio root 'rclone-test-yizofus4kinogoh8lufaxad6' -> Putio root 'rclone-test-hodayeb5cutocin5yedusej5' 2022/03/02 06:05:39 DEBUG : Putio root 'rclone-test-hodayeb5cutocin5yedusej5': chunkStart: 0, reqSize: 1 2022/03/02 06:05:39 DEBUG : Putio root 'rclone-test-hodayeb5cutocin5yedusej5': Sending chunk. transferOffset: 0 length: 1 2022/03/02 06:05:40 DEBUG : Putio root 'rclone-test-hodayeb5cutocin5yedusej5': chunkStart: 0, reqSize: 60 2022/03/02 06:05:40 DEBUG : Putio root 'rclone-test-hodayeb5cutocin5yedusej5': Sending chunk. transferOffset: 0 length: 60 2022/03/02 06:05:41 DEBUG : Putio root 'rclone-test-hodayeb5cutocin5yedusej5': Using server-side directory move 2022/03/02 06:05:41 INFO : Putio root 'rclone-test-hodayeb5cutocin5yedusej5': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2022/03/02 06:05:41 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2022/03/02 06:05:41 DEBUG : empty space: Unchanged skipping 2022/03/02 06:05:41 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2022/03/02 06:05:41 DEBUG : Putio root 'rclone-test-hodayeb5cutocin5yedusej5': Waiting for checks to finish 2022/03/02 06:05:41 INFO : empty space: Deleted 2022/03/02 06:05:41 DEBUG : Putio root 'rclone-test-hodayeb5cutocin5yedusej5': Waiting for transfers to finish 2022/03/02 06:05:41 INFO : potato2: Moved (server-side) 2022/03/02 06:05:42 INFO : potato3: Deleted 2022/03/02 06:05:42 INFO : potato3: Moved (server-side) 2022/03/02 06:05:42 INFO : There was nothing to transfer 2022/03/02 06:05:42 DEBUG : Creating backend with remote "TestPutio:rclone-test-wofemum2vufabiq5xohetol7" 2022/03/02 06:05:43 DEBUG : Putio root 'rclone-test-wofemum2vufabiq5xohetol7': Using server-side directory move 2022/03/02 06:05:43 INFO : Putio root 'rclone-test-wofemum2vufabiq5xohetol7': Server side directory move succeeded 2022/03/02 06:05:43 ERROR : : error listing: directory not found 2022/03/02 06:05:43 DEBUG : Putio root 'rclone-test-wofemum2vufabiq5xohetol7': Purge remote 2022/03/02 06:05:43 DEBUG : Putio root 'rclone-test-hodayeb5cutocin5yedusej5': Purge remote 2022/03/02 06:05:43 purge failed: Rmdir: directory not found --- PASS: TestServerSideMove (7.79s) === RUN TestServerSideMoveWithFilter run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" 2022/03/02 06:05:43 DEBUG : Creating backend with remote "TestPutio:rclone-test-feyekih1bepuben1hasozid7" 2022/03/02 06:05:44 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': chunkStart: 0, reqSize: 60 2022/03/02 06:05:44 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Sending chunk. transferOffset: 0 length: 60 2022/03/02 06:05:45 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': chunkStart: 0, reqSize: 1 2022/03/02 06:05:45 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Sending chunk. transferOffset: 0 length: 1 2022/03/02 06:05:46 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': chunkStart: 0, reqSize: 68 2022/03/02 06:05:46 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Sending chunk. transferOffset: 0 length: 68 sync_test.go:1215: Server side move (if possible) Putio root 'rclone-test-yizofus4kinogoh8lufaxad6' -> Putio root 'rclone-test-feyekih1bepuben1hasozid7' 2022/03/02 06:05:47 DEBUG : Putio root 'rclone-test-feyekih1bepuben1hasozid7': chunkStart: 0, reqSize: 1 2022/03/02 06:05:47 DEBUG : Putio root 'rclone-test-feyekih1bepuben1hasozid7': Sending chunk. transferOffset: 0 length: 1 2022/03/02 06:05:48 DEBUG : Putio root 'rclone-test-feyekih1bepuben1hasozid7': chunkStart: 0, reqSize: 60 2022/03/02 06:05:48 DEBUG : Putio root 'rclone-test-feyekih1bepuben1hasozid7': Sending chunk. transferOffset: 0 length: 60 2022/03/02 06:05:49 DEBUG : empty space: Excluded 2022/03/02 06:05:49 DEBUG : empty space: Excluded 2022/03/02 06:05:49 DEBUG : Putio root 'rclone-test-feyekih1bepuben1hasozid7': Waiting for checks to finish 2022/03/02 06:05:49 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2022/03/02 06:05:49 DEBUG : Putio root 'rclone-test-feyekih1bepuben1hasozid7': Waiting for transfers to finish 2022/03/02 06:05:49 INFO : potato3: Deleted 2022/03/02 06:05:49 INFO : potato2: Moved (server-side) 2022/03/02 06:05:49 INFO : potato3: Moved (server-side) 2022/03/02 06:05:49 INFO : There was nothing to transfer 2022/03/02 06:05:49 DEBUG : Creating backend with remote "TestPutio:rclone-test-qajoqek8runepiw5xuwajek6" 2022/03/02 06:05:49 DEBUG : empty space: Excluded 2022/03/02 06:05:49 DEBUG : Putio root 'rclone-test-qajoqek8runepiw5xuwajek6': Waiting for checks to finish 2022/03/02 06:05:49 DEBUG : Putio root 'rclone-test-qajoqek8runepiw5xuwajek6': Waiting for transfers to finish 2022/03/02 06:05:50 INFO : potato2: Moved (server-side) 2022/03/02 06:05:50 INFO : potato3: Moved (server-side) 2022/03/02 06:05:50 INFO : There was nothing to transfer 2022/03/02 06:05:50 DEBUG : Putio root 'rclone-test-qajoqek8runepiw5xuwajek6': Purge remote 2022/03/02 06:05:50 DEBUG : Putio root 'rclone-test-feyekih1bepuben1hasozid7': Purge remote --- PASS: TestServerSideMoveWithFilter (7.20s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" 2022/03/02 06:05:50 DEBUG : Creating backend with remote "TestPutio:rclone-test-wurerus0qitigot3jerosuw2" 2022/03/02 06:05:51 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': chunkStart: 0, reqSize: 60 2022/03/02 06:05:51 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Sending chunk. transferOffset: 0 length: 60 2022/03/02 06:05:52 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': chunkStart: 0, reqSize: 1 2022/03/02 06:05:52 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Sending chunk. transferOffset: 0 length: 1 2022/03/02 06:05:53 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': chunkStart: 0, reqSize: 68 2022/03/02 06:05:53 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Sending chunk. transferOffset: 0 length: 68 2022/03/02 06:05:53 DEBUG : tomatoDir: Making directory sync_test.go:1215: Server side move (if possible) Putio root 'rclone-test-yizofus4kinogoh8lufaxad6' -> Putio root 'rclone-test-wurerus0qitigot3jerosuw2' 2022/03/02 06:05:54 DEBUG : Putio root 'rclone-test-wurerus0qitigot3jerosuw2': chunkStart: 0, reqSize: 1 2022/03/02 06:05:54 DEBUG : Putio root 'rclone-test-wurerus0qitigot3jerosuw2': Sending chunk. transferOffset: 0 length: 1 2022/03/02 06:05:56 DEBUG : Putio root 'rclone-test-wurerus0qitigot3jerosuw2': chunkStart: 0, reqSize: 60 2022/03/02 06:05:56 DEBUG : Putio root 'rclone-test-wurerus0qitigot3jerosuw2': Sending chunk. transferOffset: 0 length: 60 2022/03/02 06:05:56 DEBUG : Putio root 'rclone-test-wurerus0qitigot3jerosuw2': Using server-side directory move 2022/03/02 06:05:56 INFO : Putio root 'rclone-test-wurerus0qitigot3jerosuw2': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2022/03/02 06:05:57 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2022/03/02 06:05:57 DEBUG : empty space: Unchanged skipping 2022/03/02 06:05:57 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2022/03/02 06:05:57 DEBUG : Putio root 'rclone-test-wurerus0qitigot3jerosuw2': Waiting for checks to finish 2022/03/02 06:05:57 INFO : empty space: Deleted 2022/03/02 06:05:57 DEBUG : Putio root 'rclone-test-wurerus0qitigot3jerosuw2': Waiting for transfers to finish 2022/03/02 06:05:57 INFO : potato2: Moved (server-side) 2022/03/02 06:05:58 INFO : potato3: Deleted 2022/03/02 06:05:58 INFO : potato3: Moved (server-side) 2022/03/02 06:05:58 INFO : tomatoDir: Removing directory 2022/03/02 06:05:58 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': deleted 1 directories 2022/03/02 06:05:58 INFO : There was nothing to transfer 2022/03/02 06:05:58 DEBUG : Creating backend with remote "TestPutio:rclone-test-hicelif3kefucid8rocejop1" 2022/03/02 06:05:59 DEBUG : tomatoDir: Making directory 2022/03/02 06:05:59 DEBUG : Putio root 'rclone-test-hicelif3kefucid8rocejop1': Using server-side directory move 2022/03/02 06:05:59 INFO : Putio root 'rclone-test-hicelif3kefucid8rocejop1': Server side directory move succeeded 2022/03/02 06:05:59 ERROR : : error listing: directory not found 2022/03/02 06:05:59 ERROR : : error listing: directory not found 2022/03/02 06:05:59 DEBUG : Putio root 'rclone-test-hicelif3kefucid8rocejop1': Purge remote 2022/03/02 06:05:59 DEBUG : Putio root 'rclone-test-wurerus0qitigot3jerosuw2': Purge remote 2022/03/02 06:05:59 purge failed: Rmdir: directory not found --- PASS: TestServerSideMoveDeleteEmptySourceDirs (9.20s) === RUN TestSyncCompareDest run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" 2022/03/02 06:06:00 DEBUG : Creating backend with remote "TestPutio:rclone-test-yizofus4kinogoh8lufaxad6/dst" 2022/03/02 06:06:00 DEBUG : Creating backend with remote "TestPutio:rclone-test-yizofus4kinogoh8lufaxad6/CompareDest" 2022/03/02 06:06:01 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6/dst': Waiting for checks to finish 2022/03/02 06:06:01 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6/dst': Waiting for transfers to finish 2022/03/02 06:06:01 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6/dst': chunkStart: 0, reqSize: 3 2022/03/02 06:06:01 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6/dst': Sending chunk. transferOffset: 0 length: 3 2022/03/02 06:06:02 DEBUG : one: crc32 = 7a6c86f1 OK 2022/03/02 06:06:02 INFO : one: Copied (new) 2022/03/02 06:06:02 DEBUG : Waiting for deletions to finish 2022/03/02 06:06:02 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6/dst': Waiting for checks to finish 2022/03/02 06:06:03 DEBUG : one: Sizes differ (src 5 vs dst 3) 2022/03/02 06:06:03 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6/dst': Waiting for transfers to finish 2022/03/02 06:06:03 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6/dst': chunkStart: 0, reqSize: 5 2022/03/02 06:06:03 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6/dst': Sending chunk. transferOffset: 0 length: 5 2022/03/02 06:06:04 DEBUG : one: crc32 = cb217308 OK 2022/03/02 06:06:04 INFO : one: Copied (replaced existing) 2022/03/02 06:06:04 DEBUG : Waiting for deletions to finish 2022/03/02 06:06:05 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': chunkStart: 0, reqSize: 3 2022/03/02 06:06:05 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Sending chunk. transferOffset: 0 length: 3 2022/03/02 06:06:06 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': chunkStart: 0, reqSize: 5 2022/03/02 06:06:06 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Sending chunk. transferOffset: 0 length: 5 2022/03/02 06:06:07 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6/dst': Waiting for checks to finish 2022/03/02 06:06:07 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2022/03/02 06:06:07 DEBUG : one: Destination found in --compare-dest, skipping 2022/03/02 06:06:07 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6/dst': Waiting for transfers to finish 2022/03/02 06:06:07 DEBUG : Waiting for deletions to finish 2022/03/02 06:06:07 INFO : There was nothing to transfer 2022/03/02 06:06:08 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': chunkStart: 0, reqSize: 3 2022/03/02 06:06:08 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Sending chunk. transferOffset: 0 length: 3 2022/03/02 06:06:09 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2022/03/02 06:06:09 DEBUG : two: Destination found in --compare-dest, skipping 2022/03/02 06:06:09 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6/dst': Waiting for checks to finish 2022/03/02 06:06:09 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2022/03/02 06:06:09 DEBUG : one: Destination found in --compare-dest, skipping 2022/03/02 06:06:09 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6/dst': Waiting for transfers to finish 2022/03/02 06:06:09 DEBUG : Waiting for deletions to finish 2022/03/02 06:06:09 INFO : There was nothing to transfer 2022/03/02 06:06:09 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2022/03/02 06:06:09 DEBUG : two: Destination found in --compare-dest, skipping 2022/03/02 06:06:09 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6/dst': Waiting for checks to finish 2022/03/02 06:06:09 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2022/03/02 06:06:09 DEBUG : one: Destination found in --compare-dest, skipping 2022/03/02 06:06:09 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6/dst': Waiting for transfers to finish 2022/03/02 06:06:09 DEBUG : Waiting for deletions to finish 2022/03/02 06:06:09 INFO : There was nothing to transfer 2022/03/02 06:06:09 DEBUG : two: Modification times differ by -120h0m0s: 2011-12-30 12:59:59 +0000 UTC, 2011-12-25 12:59:59 +0000 UTC 2022/03/02 06:06:09 DEBUG : two: crc32 = 11ca8a66 OK 2022/03/02 06:06:09 DEBUG : two: Destination found in --compare-dest, skipping 2022/03/02 06:06:09 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6/dst': Waiting for checks to finish 2022/03/02 06:06:10 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2022/03/02 06:06:10 DEBUG : one: Destination found in --compare-dest, skipping 2022/03/02 06:06:10 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6/dst': Waiting for transfers to finish 2022/03/02 06:06:10 DEBUG : Waiting for deletions to finish 2022/03/02 06:06:10 INFO : There was nothing to transfer 2022/03/02 06:06:10 DEBUG : two: Sizes differ (src 5 vs dst 3) 2022/03/02 06:06:10 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6/dst': Waiting for checks to finish 2022/03/02 06:06:10 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2022/03/02 06:06:10 DEBUG : one: Destination found in --compare-dest, skipping 2022/03/02 06:06:10 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6/dst': Waiting for transfers to finish 2022/03/02 06:06:11 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6/dst': chunkStart: 0, reqSize: 5 2022/03/02 06:06:11 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6/dst': Sending chunk. transferOffset: 0 length: 5 2022/03/02 06:06:11 DEBUG : two: crc32 = 8b9078ce OK 2022/03/02 06:06:11 INFO : two: Copied (new) 2022/03/02 06:06:11 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCompareDest (12.83s) === RUN TestSyncMultipleCompareDest run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" 2022/03/02 06:06:13 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': chunkStart: 0, reqSize: 1 2022/03/02 06:06:13 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Sending chunk. transferOffset: 0 length: 1 2022/03/02 06:06:14 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': chunkStart: 0, reqSize: 1 2022/03/02 06:06:14 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Sending chunk. transferOffset: 0 length: 1 2022/03/02 06:06:15 DEBUG : Creating backend with remote "TestPutio:rclone-test-yizofus4kinogoh8lufaxad6/dest" 2022/03/02 06:06:15 DEBUG : Config file has changed externaly - reloading 2022/03/02 06:06:15 DEBUG : Creating backend with remote "TestPutio:rclone-test-yizofus4kinogoh8lufaxad6/pre-dest1" 2022/03/02 06:06:15 DEBUG : Creating backend with remote "TestPutio:rclone-test-yizofus4kinogoh8lufaxad6/pre-dest2" 2022/03/02 06:06:16 DEBUG : 1: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2022/03/02 06:06:16 DEBUG : 1: Destination found in --compare-dest, skipping 2022/03/02 06:06:16 DEBUG : 2: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2022/03/02 06:06:16 DEBUG : 2: Destination found in --compare-dest, skipping 2022/03/02 06:06:16 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6/dest': Waiting for checks to finish 2022/03/02 06:06:16 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6/dest': Waiting for transfers to finish 2022/03/02 06:06:17 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6/dest': chunkStart: 0, reqSize: 1 2022/03/02 06:06:17 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6/dest': Sending chunk. transferOffset: 0 length: 1 2022/03/02 06:06:17 DEBUG : 3: crc32 = 6dd28e9b OK 2022/03/02 06:06:17 INFO : 3: Copied (new) 2022/03/02 06:06:17 DEBUG : Waiting for deletions to finish --- PASS: TestSyncMultipleCompareDest (7.33s) === RUN TestSyncCopyDest run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" 2022/03/02 06:06:20 DEBUG : Creating backend with remote "TestPutio:rclone-test-yizofus4kinogoh8lufaxad6/dst" 2022/03/02 06:06:20 DEBUG : Creating backend with remote "TestPutio:rclone-test-yizofus4kinogoh8lufaxad6/CopyDest" 2022/03/02 06:06:21 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6/dst': Waiting for checks to finish 2022/03/02 06:06:21 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6/dst': Waiting for transfers to finish 2022/03/02 06:06:21 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6/dst': chunkStart: 0, reqSize: 3 2022/03/02 06:06:21 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6/dst': Sending chunk. transferOffset: 0 length: 3 2022/03/02 06:06:23 DEBUG : one: crc32 = 7a6c86f1 OK 2022/03/02 06:06:23 INFO : one: Copied (new) 2022/03/02 06:06:23 DEBUG : Waiting for deletions to finish 2022/03/02 06:06:23 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6/dst': Waiting for checks to finish 2022/03/02 06:06:24 DEBUG : one: Sizes differ (src 5 vs dst 3) 2022/03/02 06:06:24 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6/dst': Waiting for transfers to finish 2022/03/02 06:06:24 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6/dst': chunkStart: 0, reqSize: 5 2022/03/02 06:06:24 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6/dst': Sending chunk. transferOffset: 0 length: 5 2022/03/02 06:06:25 DEBUG : one: crc32 = cb217308 OK 2022/03/02 06:06:25 INFO : one: Copied (replaced existing) 2022/03/02 06:06:25 DEBUG : Waiting for deletions to finish run.go:287: Failed to put "dst/one" to "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'": unexpected status code from upload create: 429 --- FAIL: TestSyncCopyDest (5.76s) === RUN TestSyncBackupDir run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" run.go:287: Failed to put "dst/one" to "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'": unexpected status code from upload create: 429 --- FAIL: TestSyncBackupDir (0.85s) === RUN TestSyncBackupDirWithSuffix run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" run.go:287: Failed to put "dst/one" to "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'": unexpected status code from upload create: 429 --- FAIL: TestSyncBackupDirWithSuffix (0.87s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" run.go:287: Failed to put "dst/one" to "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'": unexpected status code from upload create: 429 --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (0.77s) === RUN TestSyncBackupDirSuffixOnly run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" run.go:287: Failed to put "dst/one" to "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'": unexpected status code from upload create: 429 --- FAIL: TestSyncBackupDirSuffixOnly (0.82s) === RUN TestSyncSuffix run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" run.go:287: Failed to put "dst/one" to "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'": unexpected status code from upload create: 429 --- FAIL: TestSyncSuffix (0.80s) === RUN TestSyncSuffixKeepExtension run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" run.go:287: Failed to put "dst/one" to "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'": unexpected status code from upload create: 429 --- FAIL: TestSyncSuffixKeepExtension (0.83s) === RUN TestSyncUTFNorm run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" run.go:287: Failed to put "Testêé" to "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'": unexpected status code from upload create: 429 --- FAIL: TestSyncUTFNorm (0.61s) === RUN TestSyncImmutable run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" 2022/03/02 06:06:31 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Waiting for checks to finish 2022/03/02 06:06:31 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Waiting for transfers to finish 2022/03/02 06:06:31 ERROR : existing: Failed to copy: unexpected status code from upload create: 429 2022/03/02 06:06:31 ERROR : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': not deleting files as there were IO errors 2022/03/02 06:06:31 ERROR : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': not deleting directories as there were IO errors sync_test.go:1929: Error Trace: sync_test.go:1929 Error: Received unexpected error: unexpected status code from upload create: 429 Test: TestSyncImmutable --- FAIL: TestSyncImmutable (0.53s) === RUN TestSyncIgnoreCase run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" run.go:287: Failed to put "EXISTING" to "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'": unexpected status code from upload create: 429 --- FAIL: TestSyncIgnoreCase (0.37s) === RUN TestSyncConcurrentDelete run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" run.go:287: Failed to put "both0" to "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'": unexpected status code from upload create: 429 --- FAIL: TestSyncConcurrentDelete (0.37s) === RUN TestSyncConcurrentTruncate run.go:181: Remote "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'", Local "Local file system at /tmp/rclone3526237606", Modify Window "1s" run.go:287: Failed to put "both0" to "Putio root 'rclone-test-yizofus4kinogoh8lufaxad6'": unexpected status code from upload create: 429 --- FAIL: TestSyncConcurrentTruncate (0.38s) FAIL 2022/03/02 06:06:33 DEBUG : Putio root 'rclone-test-yizofus4kinogoh8lufaxad6': Purge remote "./sync.test -test.v -test.timeout 2h0m0s -remote TestPutio: -verbose -test.run '^(TestCopyDeleteBefore|TestMoveWithDeleteEmptySrcDirs|TestMoveWithIgnoreExisting|TestMoveWithoutDeleteEmptySrcDirs|TestServerSideCopy|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveWithFilter|TestSyncAfterAddingAFile|TestSyncAfterChangingContentsOnly|TestSyncAfterChangingFilesSizeOnly|TestSyncAfterRemovingAFileAndAddingAFile|TestSyncAfterRemovingAFileAndAddingAFileDryRun|TestSyncAfterRemovingAFileAndAddingAFileSubDir|TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncCompareDest|TestSyncConcurrentDelete|TestSyncConcurrentTruncate|TestSyncCopyDest|TestSyncDeleteBefore|TestSyncDeleteDuring|TestSyncIgnoreCase|TestSyncImmutable|TestSyncMultipleCompareDest|TestSyncSuffix|TestSyncSuffixKeepExtension|TestSyncUTFNorm|TestSyncWithExclude|TestSyncWithExcludeAndDeleteExcluded|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime|TestSyncWithUpdateOlder)$'" - Finished ERROR in 1m17.718868278s (try 2/5): exit status 1: Failed [TestServerSideCopy TestSyncAfterAddingAFile TestSyncAfterChangingFilesSizeOnly TestSyncAfterChangingContentsOnly TestSyncAfterRemovingAFileAndAddingAFileDryRun TestSyncAfterRemovingAFileAndAddingAFile TestSyncAfterRemovingAFileAndAddingAFileSubDir TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors TestSyncDeleteDuring TestSyncDeleteBefore TestCopyDeleteBefore TestSyncWithExclude TestSyncWithExcludeAndDeleteExcluded TestSyncWithUpdateOlder TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestSyncCopyDest TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly TestSyncSuffix TestSyncSuffixKeepExtension TestSyncUTFNorm TestSyncImmutable TestSyncIgnoreCase TestSyncConcurrentDelete TestSyncConcurrentTruncate]