"./sync.test -test.v -test.timeout 1h0m0s -remote TestChunkerOverCrypt: -verbose -fast-list -size-limit 6144" - Starting (try 1/5) 2021/03/04 06:12:57 DEBUG : Creating backend with remote "TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0" 2021/03/04 06:12:57 DEBUG : Creating backend with remote "__TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0" 2021/03/04 06:12:57 DEBUG : Creating backend with remote "/tmp/test_chunker_over_crypt/6ljl5nt4bm5fjkpo68k4sp9kvqpi88n6liu075orrmrr0j4piocvhri86l7f9gh0j3kltfmnih420" 2021/03/04 06:12:57 DEBUG : Reset feature "ListR" 2021/03/04 06:12:57 DEBUG : Creating backend with remote "/tmp/rclone487708856" === RUN TestPipe --- PASS: TestPipe (0.00s) === RUN TestPipeConcurrent --- PASS: TestPipeConcurrent (0.11s) === RUN TestPipeOrderBy === RUN TestPipeOrderBy/#00 === RUN TestPipeOrderBy/size === RUN TestPipeOrderBy/name === RUN TestPipeOrderBy/modtime === RUN TestPipeOrderBy/size,ascending === RUN TestPipeOrderBy/name,asc === RUN TestPipeOrderBy/modtime,ascending === RUN TestPipeOrderBy/size,descending === RUN TestPipeOrderBy/name,desc === RUN TestPipeOrderBy/modtime,descending === RUN TestPipeOrderBy/size,mixed,50 === RUN TestPipeOrderBy/size,mixed,51 --- PASS: TestPipeOrderBy (0.00s) --- PASS: TestPipeOrderBy/#00 (0.00s) --- PASS: TestPipeOrderBy/size (0.00s) --- PASS: TestPipeOrderBy/name (0.00s) --- PASS: TestPipeOrderBy/modtime (0.00s) --- PASS: TestPipeOrderBy/size,ascending (0.00s) --- PASS: TestPipeOrderBy/name,asc (0.00s) --- PASS: TestPipeOrderBy/modtime,ascending (0.00s) --- PASS: TestPipeOrderBy/size,descending (0.00s) --- PASS: TestPipeOrderBy/name,desc (0.00s) --- PASS: TestPipeOrderBy/modtime,descending (0.00s) --- PASS: TestPipeOrderBy/size,mixed,50 (0.00s) --- PASS: TestPipeOrderBy/size,mixed,51 (0.00s) === RUN TestNewLess === RUN TestNewLess/blankOK === RUN TestNewLess/tooManyParts === RUN TestNewLess/tooManyParts2 === RUN TestNewLess/badMixed === RUN TestNewLess/unknownComparison === RUN TestNewLess/unknownSortDirection === RUN TestNewLess/size === RUN TestNewLess/name === RUN TestNewLess/modtime === RUN TestNewLess/size,ascending === RUN TestNewLess/name,asc === RUN TestNewLess/modtime,ascending === RUN TestNewLess/size,descending === RUN TestNewLess/name,desc === RUN TestNewLess/modtime,descending === RUN TestNewLess/modtime,mixed === RUN TestNewLess/modtime,mixed,30 --- PASS: TestNewLess (0.00s) --- PASS: TestNewLess/blankOK (0.00s) --- PASS: TestNewLess/tooManyParts (0.00s) --- PASS: TestNewLess/tooManyParts2 (0.00s) --- PASS: TestNewLess/badMixed (0.00s) --- PASS: TestNewLess/unknownComparison (0.00s) --- PASS: TestNewLess/unknownSortDirection (0.00s) --- PASS: TestNewLess/size (0.00s) --- PASS: TestNewLess/name (0.00s) --- PASS: TestNewLess/modtime (0.00s) --- PASS: TestNewLess/size,ascending (0.00s) --- PASS: TestNewLess/name,asc (0.00s) --- PASS: TestNewLess/modtime,ascending (0.00s) --- PASS: TestNewLess/size,descending (0.00s) --- PASS: TestNewLess/name,desc (0.00s) --- PASS: TestNewLess/modtime,descending (0.00s) --- PASS: TestNewLess/modtime,mixed (0.00s) --- PASS: TestNewLess/modtime,mixed,30 (0.00s) === RUN TestRcCopy rc_test.go:16: Skipping test on non local remote --- SKIP: TestRcCopy (0.00s) === RUN TestRcMove rc_test.go:16: Skipping test on non local remote --- SKIP: TestRcMove (0.00s) === RUN TestRcSync rc_test.go:16: Skipping test on non local remote --- SKIP: TestRcSync (0.00s) === RUN TestCopyWithDryRun run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:57 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11) --- PASS: TestCopyWithDryRun (0.02s) === RUN TestCopy run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:57 DEBUG : sub dir/hello world: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.001_fqgg4h: Moved (server-side) to: sub dir/hello world.rcc.001 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.002_fqgg4h: Moved (server-side) to: sub dir/hello world.rcc.002 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.003_fqgg4h: Moved (server-side) to: sub dir/hello world.rcc.003 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.004_fqgg4h: Moved (server-side) to: sub dir/hello world.rcc.004 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:57 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopy (0.01s) === RUN TestCopyMissingDirectory run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:57 DEBUG : Creating backend with remote "/non-existing" 2021/03/04 06:12:57 ERROR : : error reading source directory: directory not found 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish --- PASS: TestCopyMissingDirectory (0.00s) === RUN TestCopyNoTraverse run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:57 DEBUG : sub dir/hello world: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.001_fqggea: Moved (server-side) to: sub dir/hello world.rcc.001 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.002_fqggea: Moved (server-side) to: sub dir/hello world.rcc.002 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.003_fqggea: Moved (server-side) to: sub dir/hello world.rcc.003 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.004_fqggea: Moved (server-side) to: sub dir/hello world.rcc.004 2021/03/04 06:12:57 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyNoTraverse (0.01s) === RUN TestCopyCheckFirst run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:57 INFO : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Running all checks before starting transfers 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:57 INFO : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Checks finished, now starting transfers 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:57 DEBUG : sub dir/hello world: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.001_fqggdx: Moved (server-side) to: sub dir/hello world.rcc.001 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.002_fqggdx: Moved (server-side) to: sub dir/hello world.rcc.002 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.003_fqggdx: Moved (server-side) to: sub dir/hello world.rcc.003 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.004_fqggdx: Moved (server-side) to: sub dir/hello world.rcc.004 2021/03/04 06:12:57 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyCheckFirst (0.02s) === RUN TestSyncNoTraverse run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:57 ERROR : Ignoring --no-traverse with sync 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:57 DEBUG : sub dir/hello world: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.001_fqggxj: Moved (server-side) to: sub dir/hello world.rcc.001 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.002_fqggxj: Moved (server-side) to: sub dir/hello world.rcc.002 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.003_fqggxj: Moved (server-side) to: sub dir/hello world.rcc.003 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.004_fqggxj: Moved (server-side) to: sub dir/hello world.rcc.004 2021/03/04 06:12:57 INFO : sub dir/hello world: Copied (new) 2021/03/04 06:12:57 DEBUG : Waiting for deletions to finish --- PASS: TestSyncNoTraverse (0.01s) === RUN TestCopyWithDepth run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:57 DEBUG : hello world2: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:57 INFO : hello world2.rcc.001_fqgghq: Moved (server-side) to: hello world2.rcc.001 2021/03/04 06:12:57 INFO : hello world2.rcc.002_fqgghq: Moved (server-side) to: hello world2.rcc.002 2021/03/04 06:12:57 INFO : hello world2.rcc.003_fqgghq: Moved (server-side) to: hello world2.rcc.003 2021/03/04 06:12:57 INFO : hello world2.rcc.004_fqgghq: Moved (server-side) to: hello world2.rcc.004 2021/03/04 06:12:57 INFO : hello world2: Copied (new) --- PASS: TestCopyWithDepth (0.01s) === RUN TestCopyWithFilesFrom run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:57 DEBUG : hello world2: Excluded 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:57 DEBUG : potato2: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:57 INFO : potato2.rcc.001_fqggo0: Moved (server-side) to: potato2.rcc.001 2021/03/04 06:12:57 INFO : potato2.rcc.002_fqggo0: Moved (server-side) to: potato2.rcc.002 2021/03/04 06:12:57 INFO : potato2.rcc.003_fqggo0: Moved (server-side) to: potato2.rcc.003 2021/03/04 06:12:57 INFO : potato2.rcc.004_fqggo0: Moved (server-side) to: potato2.rcc.004 2021/03/04 06:12:57 INFO : potato2: Copied (new) --- PASS: TestCopyWithFilesFrom (0.01s) === RUN TestCopyWithFilesFromAndNoTraverse run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:57 DEBUG : potato2: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:57 INFO : potato2.rcc.001_fqggkb: Moved (server-side) to: potato2.rcc.001 2021/03/04 06:12:57 INFO : potato2.rcc.002_fqggkb: Moved (server-side) to: potato2.rcc.002 2021/03/04 06:12:57 INFO : potato2.rcc.003_fqggkb: Moved (server-side) to: potato2.rcc.003 2021/03/04 06:12:57 INFO : potato2.rcc.004_fqggkb: Moved (server-side) to: potato2.rcc.004 2021/03/04 06:12:57 INFO : potato2: Copied (new) --- PASS: TestCopyWithFilesFromAndNoTraverse (0.01s) === RUN TestCopyEmptyDirectories run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:57 DEBUG : sub dir2: Making directory 2021/03/04 06:12:57 DEBUG : sub dir/hello world: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.001_fqggve: Moved (server-side) to: sub dir/hello world.rcc.001 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.002_fqggve: Moved (server-side) to: sub dir/hello world.rcc.002 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.003_fqggve: Moved (server-side) to: sub dir/hello world.rcc.003 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.004_fqggve: Moved (server-side) to: sub dir/hello world.rcc.004 2021/03/04 06:12:57 INFO : sub dir/hello world: Copied (new) 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:57 DEBUG : sub dir2: Making directory 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': copied 1 directories --- PASS: TestCopyEmptyDirectories (0.01s) === RUN TestMoveEmptyDirectories run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:57 DEBUG : sub dir2: Making directory 2021/03/04 06:12:57 DEBUG : sub dir/hello world: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.001_fqgg9c: Moved (server-side) to: sub dir/hello world.rcc.001 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.002_fqgg9c: Moved (server-side) to: sub dir/hello world.rcc.002 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.003_fqgg9c: Moved (server-side) to: sub dir/hello world.rcc.003 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.004_fqgg9c: Moved (server-side) to: sub dir/hello world.rcc.004 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:57 INFO : sub dir/hello world: Copied (new) 2021/03/04 06:12:57 INFO : sub dir/hello world: Deleted 2021/03/04 06:12:57 DEBUG : sub dir: Making directory 2021/03/04 06:12:57 DEBUG : sub dir2: Making directory 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': copied 2 directories --- PASS: TestMoveEmptyDirectories (0.02s) === RUN TestSyncEmptyDirectories run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:57 DEBUG : sub dir2: Making directory 2021/03/04 06:12:57 DEBUG : sub dir/hello world: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.001_fqgg8u: Moved (server-side) to: sub dir/hello world.rcc.001 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.002_fqgg8u: Moved (server-side) to: sub dir/hello world.rcc.002 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.003_fqgg8u: Moved (server-side) to: sub dir/hello world.rcc.003 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.004_fqgg8u: Moved (server-side) to: sub dir/hello world.rcc.004 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:57 INFO : sub dir/hello world: Copied (new) 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:57 DEBUG : sub dir2: Making directory 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': copied 1 directories 2021/03/04 06:12:57 DEBUG : Waiting for deletions to finish --- PASS: TestSyncEmptyDirectories (0.01s) === RUN TestServerSideCopy run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.001_fqgg7u: Moved (server-side) to: sub dir/hello world.rcc.001 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.002_fqgg7u: Moved (server-side) to: sub dir/hello world.rcc.002 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.003_fqgg7u: Moved (server-side) to: sub dir/hello world.rcc.003 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.004_fqgg7u: Moved (server-side) to: sub dir/hello world.rcc.004 2021/03/04 06:12:57 DEBUG : Creating backend with remote "TestChunkerOverCrypt:rclone-test-bediyeg6nozevap6micetip6" 2021/03/04 06:12:57 DEBUG : Creating backend with remote "__TestChunkerOverCrypt:rclone-test-bediyeg6nozevap6micetip6" 2021/03/04 06:12:57 DEBUG : Creating backend with remote "/tmp/test_chunker_over_crypt/j8drthu8v0slurt2ee8lvejsmc2h55rtoj88pofm8ji2e3nnmihblu8voarkpu00ktthn1dhgfiio" 2021/03/04 06:12:57 DEBUG : Reset feature "ListR" sync_test.go:292: Server side copy (if possible) Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0' -> Chunked 'TestChunkerOverCrypt:rclone-test-bediyeg6nozevap6micetip6' 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-bediyeg6nozevap6micetip6': Waiting for checks to finish 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-bediyeg6nozevap6micetip6': Waiting for transfers to finish 2021/03/04 06:12:57 DEBUG : sub dir/hello world: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.001_fqggkd: Moved (server-side) to: sub dir/hello world.rcc.001 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.002_fqggkd: Moved (server-side) to: sub dir/hello world.rcc.002 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.003_fqggkd: Moved (server-side) to: sub dir/hello world.rcc.003 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.004_fqggkd: Moved (server-side) to: sub dir/hello world.rcc.004 2021/03/04 06:12:57 INFO : sub dir/hello world: Copied (new) 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-bediyeg6nozevap6micetip6': Purge remote --- PASS: TestServerSideCopy (0.12s) === RUN TestCopyAfterDelete run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.001_fqggke: Moved (server-side) to: sub dir/hello world.rcc.001 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.002_fqggke: Moved (server-side) to: sub dir/hello world.rcc.002 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.003_fqggke: Moved (server-side) to: sub dir/hello world.rcc.003 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.004_fqggke: Moved (server-side) to: sub dir/hello world.rcc.004 2021/03/04 06:12:57 ERROR : : error listing: directory not found 2021/03/04 06:12:57 DEBUG : Local file system at /tmp/rclone487708856: Making directory 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish --- PASS: TestCopyAfterDelete (0.01s) === RUN TestCopyRedownload run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.001_fqggzz: Moved (server-side) to: sub dir/hello world.rcc.001 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.002_fqggzz: Moved (server-side) to: sub dir/hello world.rcc.002 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.003_fqggzz: Moved (server-side) to: sub dir/hello world.rcc.003 2021/03/04 06:12:57 INFO : sub dir/hello world.rcc.004_fqggzz: Moved (server-side) to: sub dir/hello world.rcc.004 2021/03/04 06:12:57 INFO : sub dir/hello world: Copied (new) 2021/03/04 06:12:57 DEBUG : Local file system at /tmp/rclone487708856: Waiting for checks to finish 2021/03/04 06:12:57 DEBUG : Local file system at /tmp/rclone487708856: Waiting for transfers to finish --- PASS: TestCopyRedownload (0.01s) === RUN TestSyncBasedOnCheckSum run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:57 DEBUG : check sum: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:57 INFO : check sum.rcc.001_fqggm0: Moved (server-side) to: check sum 2021/03/04 06:12:57 INFO : check sum: Copied (new) 2021/03/04 06:12:57 DEBUG : Waiting for deletions to finish 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:57 NOTICE: Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': --checksum is in use but the source and destination have no hashes in common; falling back to --size-only 2021/03/04 06:12:57 DEBUG : check sum: Size of src and dst objects identical 2021/03/04 06:12:57 DEBUG : check sum: Unchanged skipping 2021/03/04 06:12:57 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:57 DEBUG : Waiting for deletions to finish 2021/03/04 06:12:57 INFO : There was nothing to transfer --- PASS: TestSyncBasedOnCheckSum (0.02s) === RUN TestSyncSizeOnly run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:58 DEBUG : sizeonly: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:58 INFO : sizeonly.rcc.001_fqght6: Moved (server-side) to: sizeonly.rcc.001 2021/03/04 06:12:58 INFO : sizeonly.rcc.002_fqght6: Moved (server-side) to: sizeonly.rcc.002 2021/03/04 06:12:58 INFO : sizeonly: Copied (new) 2021/03/04 06:12:58 DEBUG : Waiting for deletions to finish 2021/03/04 06:12:58 DEBUG : sizeonly: Sizes identical 2021/03/04 06:12:58 DEBUG : sizeonly: Unchanged skipping 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:58 DEBUG : Waiting for deletions to finish 2021/03/04 06:12:58 INFO : There was nothing to transfer --- PASS: TestSyncSizeOnly (0.38s) === RUN TestSyncIgnoreSize run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:58 DEBUG : ignore-size: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:58 INFO : ignore-size.rcc.001_fqghrc: Moved (server-side) to: ignore-size.rcc.001 2021/03/04 06:12:58 INFO : ignore-size.rcc.002_fqghrc: Moved (server-side) to: ignore-size.rcc.002 2021/03/04 06:12:58 INFO : ignore-size.rcc.003_fqghrc: Moved (server-side) to: ignore-size.rcc.003 2021/03/04 06:12:58 INFO : ignore-size: Copied (new) 2021/03/04 06:12:58 DEBUG : Waiting for deletions to finish 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:58 DEBUG : ignore-size: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:12:58 DEBUG : ignore-size: Unchanged skipping 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:58 DEBUG : Waiting for deletions to finish 2021/03/04 06:12:58 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreSize (0.12s) === RUN TestSyncIgnoreTimes run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:58 INFO : existing.rcc.001_fqgh5n: Moved (server-side) to: existing.rcc.001 2021/03/04 06:12:58 INFO : existing.rcc.002_fqgh5n: Moved (server-side) to: existing.rcc.002 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:58 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:12:58 DEBUG : existing: Unchanged skipping 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:58 DEBUG : Waiting for deletions to finish 2021/03/04 06:12:58 INFO : There was nothing to transfer 2021/03/04 06:12:58 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:58 DEBUG : existing: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:58 INFO : existing.rcc.001_fqghvo: Moved (server-side) to: existing.rcc.001 2021/03/04 06:12:58 INFO : existing.rcc.002_fqghvo: Moved (server-side) to: existing.rcc.002 2021/03/04 06:12:58 INFO : existing: Copied (replaced existing) 2021/03/04 06:12:58 DEBUG : Waiting for deletions to finish --- PASS: TestSyncIgnoreTimes (0.02s) === RUN TestSyncIgnoreExisting run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:58 DEBUG : existing: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:58 INFO : existing.rcc.001_fqghm8: Moved (server-side) to: existing.rcc.001 2021/03/04 06:12:58 INFO : existing.rcc.002_fqghm8: Moved (server-side) to: existing.rcc.002 2021/03/04 06:12:58 INFO : existing: Copied (new) 2021/03/04 06:12:58 DEBUG : Waiting for deletions to finish 2021/03/04 06:12:58 DEBUG : existing: Destination exists, skipping 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:58 DEBUG : Waiting for deletions to finish 2021/03/04 06:12:58 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreExisting (0.01s) === RUN TestSyncIgnoreErrors run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:58 INFO : b/potato.rcc.001_fqghav: Moved (server-side) to: b/potato.rcc.001 2021/03/04 06:12:58 INFO : b/potato.rcc.002_fqghav: Moved (server-side) to: b/potato.rcc.002 2021/03/04 06:12:58 INFO : b/potato.rcc.003_fqghav: Moved (server-side) to: b/potato.rcc.003 2021/03/04 06:12:58 INFO : b/potato.rcc.004_fqghav: Moved (server-side) to: b/potato.rcc.004 2021/03/04 06:12:58 INFO : b/potato.rcc.005_fqghav: Moved (server-side) to: b/potato.rcc.005 2021/03/04 06:12:58 INFO : b/potato.rcc.006_fqghav: Moved (server-side) to: b/potato.rcc.006 2021/03/04 06:12:58 INFO : b/potato.rcc.007_fqghav: Moved (server-side) to: b/potato.rcc.007 2021/03/04 06:12:58 INFO : c/non empty space.rcc.001_fqghai: Moved (server-side) to: c/non empty space.rcc.001 2021/03/04 06:12:58 INFO : c/non empty space.rcc.002_fqghai: Moved (server-side) to: c/non empty space.rcc.002 2021/03/04 06:12:58 DEBUG : d: Making directory 2021/03/04 06:12:58 DEBUG : a/potato2: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:58 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:12:58 DEBUG : c/non empty space: Unchanged skipping 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:58 INFO : a/potato2.rcc.001_fqghgx: Moved (server-side) to: a/potato2.rcc.001 2021/03/04 06:12:58 INFO : a/potato2.rcc.002_fqghgx: Moved (server-side) to: a/potato2.rcc.002 2021/03/04 06:12:58 INFO : a/potato2.rcc.003_fqghgx: Moved (server-side) to: a/potato2.rcc.003 2021/03/04 06:12:58 INFO : a/potato2.rcc.004_fqghgx: Moved (server-side) to: a/potato2.rcc.004 2021/03/04 06:12:58 INFO : a/potato2.rcc.005_fqghgx: Moved (server-side) to: a/potato2.rcc.005 2021/03/04 06:12:58 INFO : a/potato2.rcc.006_fqghgx: Moved (server-side) to: a/potato2.rcc.006 2021/03/04 06:12:58 INFO : a/potato2.rcc.007_fqghgx: Moved (server-side) to: a/potato2.rcc.007 2021/03/04 06:12:58 INFO : a/potato2.rcc.008_fqghgx: Moved (server-side) to: a/potato2.rcc.008 2021/03/04 06:12:58 INFO : a/potato2.rcc.009_fqghgx: Moved (server-side) to: a/potato2.rcc.009 2021/03/04 06:12:58 INFO : a/potato2.rcc.010_fqghgx: Moved (server-side) to: a/potato2.rcc.010 2021/03/04 06:12:58 INFO : a/potato2.rcc.011_fqghgx: Moved (server-side) to: a/potato2.rcc.011 2021/03/04 06:12:58 INFO : a/potato2.rcc.012_fqghgx: Moved (server-side) to: a/potato2.rcc.012 2021/03/04 06:12:58 INFO : a/potato2.rcc.013_fqghgx: Moved (server-side) to: a/potato2.rcc.013 2021/03/04 06:12:58 INFO : a/potato2.rcc.014_fqghgx: Moved (server-side) to: a/potato2.rcc.014 2021/03/04 06:12:58 INFO : a/potato2.rcc.015_fqghgx: Moved (server-side) to: a/potato2.rcc.015 2021/03/04 06:12:58 INFO : a/potato2.rcc.016_fqghgx: Moved (server-side) to: a/potato2.rcc.016 2021/03/04 06:12:58 INFO : a/potato2.rcc.017_fqghgx: Moved (server-side) to: a/potato2.rcc.017 2021/03/04 06:12:58 INFO : a/potato2.rcc.018_fqghgx: Moved (server-side) to: a/potato2.rcc.018 2021/03/04 06:12:58 INFO : a/potato2.rcc.019_fqghgx: Moved (server-side) to: a/potato2.rcc.019 2021/03/04 06:12:58 INFO : a/potato2.rcc.020_fqghgx: Moved (server-side) to: a/potato2.rcc.020 2021/03/04 06:12:58 INFO : a/potato2: Copied (new) 2021/03/04 06:12:58 DEBUG : Waiting for deletions to finish 2021/03/04 06:12:58 INFO : b/potato: Deleted 2021/03/04 06:12:58 DEBUG : d: Removing directory 2021/03/04 06:12:58 DEBUG : b: Removing directory 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': deleted 2 directories --- PASS: TestSyncIgnoreErrors (0.04s) === RUN TestSyncAfterChangingModtimeOnly run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:58 INFO : empty space.rcc.001_fqghin: Moved (server-side) to: empty space 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:58 DEBUG : empty space: Modification times differ by -95456h54m52.62345679s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499999999 +0000 UTC 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:58 NOTICE: empty space: Skipped copy as --dry-run is set (size 1) 2021/03/04 06:12:58 DEBUG : Waiting for deletions to finish 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:58 DEBUG : empty space: Modification times differ by -95456h54m52.62345679s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499999999 +0000 UTC 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:58 DEBUG : empty space: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:58 INFO : empty space: Deleted 2021/03/04 06:12:58 INFO : empty space.rcc.001_fqghgz: Moved (server-side) to: empty space 2021/03/04 06:12:58 INFO : empty space: Copied (replaced existing) 2021/03/04 06:12:58 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingModtimeOnly (0.02s) === RUN TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" sync_test.go:611: Can't check this if no hashes supported --- PASS: TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime (0.00s) === RUN TestSyncDoesntUpdateModtime run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:58 INFO : foo.rcc.001_fqghvu: Moved (server-side) to: foo 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:58 DEBUG : foo: Modification times differ by -95456h54m52.62345679s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499999999 +0000 UTC 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:58 DEBUG : foo: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:58 INFO : foo: Deleted 2021/03/04 06:12:58 INFO : foo.rcc.001_fqghms: Moved (server-side) to: foo 2021/03/04 06:12:58 INFO : foo: Copied (replaced existing) 2021/03/04 06:12:58 DEBUG : Waiting for deletions to finish --- PASS: TestSyncDoesntUpdateModtime (0.01s) === RUN TestSyncAfterAddingAFile run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:58 INFO : empty space.rcc.001_fqgh78: Moved (server-side) to: empty space 2021/03/04 06:12:58 DEBUG : potato: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:58 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:12:58 DEBUG : empty space: Unchanged skipping 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:58 INFO : potato.rcc.001_fqghxm: Moved (server-side) to: potato.rcc.001 2021/03/04 06:12:58 INFO : potato.rcc.002_fqghxm: Moved (server-side) to: potato.rcc.002 2021/03/04 06:12:58 INFO : potato.rcc.003_fqghxm: Moved (server-side) to: potato.rcc.003 2021/03/04 06:12:58 INFO : potato.rcc.004_fqghxm: Moved (server-side) to: potato.rcc.004 2021/03/04 06:12:58 INFO : potato.rcc.005_fqghxm: Moved (server-side) to: potato.rcc.005 2021/03/04 06:12:58 INFO : potato.rcc.006_fqghxm: Moved (server-side) to: potato.rcc.006 2021/03/04 06:12:58 INFO : potato.rcc.007_fqghxm: Moved (server-side) to: potato.rcc.007 2021/03/04 06:12:58 INFO : potato.rcc.008_fqghxm: Moved (server-side) to: potato.rcc.008 2021/03/04 06:12:58 INFO : potato.rcc.009_fqghxm: Moved (server-side) to: potato.rcc.009 2021/03/04 06:12:58 INFO : potato.rcc.010_fqghxm: Moved (server-side) to: potato.rcc.010 2021/03/04 06:12:58 INFO : potato.rcc.011_fqghxm: Moved (server-side) to: potato.rcc.011 2021/03/04 06:12:58 INFO : potato.rcc.012_fqghxm: Moved (server-side) to: potato.rcc.012 2021/03/04 06:12:58 INFO : potato.rcc.013_fqghxm: Moved (server-side) to: potato.rcc.013 2021/03/04 06:12:58 INFO : potato.rcc.014_fqghxm: Moved (server-side) to: potato.rcc.014 2021/03/04 06:12:58 INFO : potato.rcc.015_fqghxm: Moved (server-side) to: potato.rcc.015 2021/03/04 06:12:58 INFO : potato.rcc.016_fqghxm: Moved (server-side) to: potato.rcc.016 2021/03/04 06:12:58 INFO : potato.rcc.017_fqghxm: Moved (server-side) to: potato.rcc.017 2021/03/04 06:12:58 INFO : potato.rcc.018_fqghxm: Moved (server-side) to: potato.rcc.018 2021/03/04 06:12:58 INFO : potato.rcc.019_fqghxm: Moved (server-side) to: potato.rcc.019 2021/03/04 06:12:58 INFO : potato.rcc.020_fqghxm: Moved (server-side) to: potato.rcc.020 2021/03/04 06:12:58 INFO : potato: Copied (new) 2021/03/04 06:12:58 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterAddingAFile (0.04s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:58 INFO : potato.rcc.001_fqghu8: Moved (server-side) to: potato.rcc.001 2021/03/04 06:12:58 INFO : potato.rcc.002_fqghu8: Moved (server-side) to: potato.rcc.002 2021/03/04 06:12:58 INFO : potato.rcc.003_fqghu8: Moved (server-side) to: potato.rcc.003 2021/03/04 06:12:58 INFO : potato.rcc.004_fqghu8: Moved (server-side) to: potato.rcc.004 2021/03/04 06:12:58 INFO : potato.rcc.005_fqghu8: Moved (server-side) to: potato.rcc.005 2021/03/04 06:12:58 INFO : potato.rcc.006_fqghu8: Moved (server-side) to: potato.rcc.006 2021/03/04 06:12:58 INFO : potato.rcc.007_fqghu8: Moved (server-side) to: potato.rcc.007 2021/03/04 06:12:58 INFO : potato.rcc.008_fqghu8: Moved (server-side) to: potato.rcc.008 2021/03/04 06:12:58 INFO : potato.rcc.009_fqghu8: Moved (server-side) to: potato.rcc.009 2021/03/04 06:12:58 INFO : potato.rcc.010_fqghu8: Moved (server-side) to: potato.rcc.010 2021/03/04 06:12:58 INFO : potato.rcc.011_fqghu8: Moved (server-side) to: potato.rcc.011 2021/03/04 06:12:58 INFO : potato.rcc.012_fqghu8: Moved (server-side) to: potato.rcc.012 2021/03/04 06:12:58 INFO : potato.rcc.013_fqghu8: Moved (server-side) to: potato.rcc.013 2021/03/04 06:12:58 INFO : potato.rcc.014_fqghu8: Moved (server-side) to: potato.rcc.014 2021/03/04 06:12:58 INFO : potato.rcc.015_fqghu8: Moved (server-side) to: potato.rcc.015 2021/03/04 06:12:58 INFO : potato.rcc.016_fqghu8: Moved (server-side) to: potato.rcc.016 2021/03/04 06:12:58 INFO : potato.rcc.017_fqghu8: Moved (server-side) to: potato.rcc.017 2021/03/04 06:12:58 INFO : potato.rcc.018_fqghu8: Moved (server-side) to: potato.rcc.018 2021/03/04 06:12:58 INFO : potato.rcc.019_fqghu8: Moved (server-side) to: potato.rcc.019 2021/03/04 06:12:58 INFO : potato.rcc.020_fqghu8: Moved (server-side) to: potato.rcc.020 2021/03/04 06:12:58 DEBUG : potato: Sizes differ (src 21 vs dst 60) 2021/03/04 06:12:58 DEBUG : potato: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:58 INFO : potato.rcc.001_fqgh7b: Moved (server-side) to: potato.rcc.001 2021/03/04 06:12:58 INFO : potato.rcc.002_fqgh7b: Moved (server-side) to: potato.rcc.002 2021/03/04 06:12:58 INFO : potato.rcc.003_fqgh7b: Moved (server-side) to: potato.rcc.003 2021/03/04 06:12:58 INFO : potato.rcc.004_fqgh7b: Moved (server-side) to: potato.rcc.004 2021/03/04 06:12:58 INFO : potato.rcc.005_fqgh7b: Moved (server-side) to: potato.rcc.005 2021/03/04 06:12:58 INFO : potato.rcc.006_fqgh7b: Moved (server-side) to: potato.rcc.006 2021/03/04 06:12:58 INFO : potato.rcc.007_fqgh7b: Moved (server-side) to: potato.rcc.007 2021/03/04 06:12:58 INFO : potato: Copied (replaced existing) 2021/03/04 06:12:58 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingFilesSizeOnly (0.04s) === RUN TestSyncAfterChangingContentsOnly run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:58 INFO : potato.rcc.001_fqghp4: Moved (server-side) to: potato.rcc.001 2021/03/04 06:12:58 INFO : potato.rcc.002_fqghp4: Moved (server-side) to: potato.rcc.002 2021/03/04 06:12:58 INFO : potato.rcc.003_fqghp4: Moved (server-side) to: potato.rcc.003 2021/03/04 06:12:58 INFO : potato.rcc.004_fqghp4: Moved (server-side) to: potato.rcc.004 2021/03/04 06:12:58 INFO : potato.rcc.005_fqghp4: Moved (server-side) to: potato.rcc.005 2021/03/04 06:12:58 INFO : potato.rcc.006_fqghp4: Moved (server-side) to: potato.rcc.006 2021/03/04 06:12:58 INFO : potato.rcc.007_fqghp4: Moved (server-side) to: potato.rcc.007 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:58 DEBUG : potato: Modification times differ by 119h59m59.876543211s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2011-12-30 12:59:59 +0000 UTC 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:58 DEBUG : potato: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:58 INFO : potato.rcc.001_fqghca: Moved (server-side) to: potato.rcc.001 2021/03/04 06:12:58 INFO : potato.rcc.002_fqghca: Moved (server-side) to: potato.rcc.002 2021/03/04 06:12:58 INFO : potato.rcc.003_fqghca: Moved (server-side) to: potato.rcc.003 2021/03/04 06:12:58 INFO : potato.rcc.004_fqghca: Moved (server-side) to: potato.rcc.004 2021/03/04 06:12:58 INFO : potato.rcc.005_fqghca: Moved (server-side) to: potato.rcc.005 2021/03/04 06:12:58 INFO : potato.rcc.006_fqghca: Moved (server-side) to: potato.rcc.006 2021/03/04 06:12:58 INFO : potato.rcc.007_fqghca: Moved (server-side) to: potato.rcc.007 2021/03/04 06:12:58 INFO : potato: Copied (replaced existing) 2021/03/04 06:12:58 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingContentsOnly (0.02s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:58 INFO : potato.rcc.001_fqghwz: Moved (server-side) to: potato.rcc.001 2021/03/04 06:12:58 INFO : potato.rcc.002_fqghwz: Moved (server-side) to: potato.rcc.002 2021/03/04 06:12:58 INFO : potato.rcc.003_fqghwz: Moved (server-side) to: potato.rcc.003 2021/03/04 06:12:58 INFO : potato.rcc.004_fqghwz: Moved (server-side) to: potato.rcc.004 2021/03/04 06:12:58 INFO : potato.rcc.005_fqghwz: Moved (server-side) to: potato.rcc.005 2021/03/04 06:12:58 INFO : potato.rcc.006_fqghwz: Moved (server-side) to: potato.rcc.006 2021/03/04 06:12:58 INFO : potato.rcc.007_fqghwz: Moved (server-side) to: potato.rcc.007 2021/03/04 06:12:58 INFO : empty space.rcc.001_fqghi1: Moved (server-side) to: empty space 2021/03/04 06:12:58 NOTICE: potato2: Skipped copy as --dry-run is set (size 60) 2021/03/04 06:12:58 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:12:58 DEBUG : empty space: Unchanged skipping 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:58 DEBUG : Waiting for deletions to finish 2021/03/04 06:12:58 NOTICE: potato: Skipped delete as --dry-run is set (size 21) --- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (0.02s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:58 INFO : potato.rcc.001_fqghwv: Moved (server-side) to: potato.rcc.001 2021/03/04 06:12:58 INFO : potato.rcc.002_fqghwv: Moved (server-side) to: potato.rcc.002 2021/03/04 06:12:58 INFO : potato.rcc.003_fqghwv: Moved (server-side) to: potato.rcc.003 2021/03/04 06:12:58 INFO : potato.rcc.004_fqghwv: Moved (server-side) to: potato.rcc.004 2021/03/04 06:12:58 INFO : potato.rcc.005_fqghwv: Moved (server-side) to: potato.rcc.005 2021/03/04 06:12:58 INFO : potato.rcc.006_fqghwv: Moved (server-side) to: potato.rcc.006 2021/03/04 06:12:58 INFO : potato.rcc.007_fqghwv: Moved (server-side) to: potato.rcc.007 2021/03/04 06:12:58 INFO : empty space.rcc.001_fqghma: Moved (server-side) to: empty space 2021/03/04 06:12:58 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:12:58 DEBUG : empty space: Unchanged skipping 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:58 DEBUG : potato2: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:58 INFO : potato2.rcc.001_fqgh68: Moved (server-side) to: potato2.rcc.001 2021/03/04 06:12:58 INFO : potato2.rcc.002_fqgh68: Moved (server-side) to: potato2.rcc.002 2021/03/04 06:12:58 INFO : potato2.rcc.003_fqgh68: Moved (server-side) to: potato2.rcc.003 2021/03/04 06:12:58 INFO : potato2.rcc.004_fqgh68: Moved (server-side) to: potato2.rcc.004 2021/03/04 06:12:58 INFO : potato2.rcc.005_fqgh68: Moved (server-side) to: potato2.rcc.005 2021/03/04 06:12:58 INFO : potato2.rcc.006_fqgh68: Moved (server-side) to: potato2.rcc.006 2021/03/04 06:12:58 INFO : potato2.rcc.007_fqgh68: Moved (server-side) to: potato2.rcc.007 2021/03/04 06:12:58 INFO : potato2.rcc.008_fqgh68: Moved (server-side) to: potato2.rcc.008 2021/03/04 06:12:58 INFO : potato2.rcc.009_fqgh68: Moved (server-side) to: potato2.rcc.009 2021/03/04 06:12:58 INFO : potato2.rcc.010_fqgh68: Moved (server-side) to: potato2.rcc.010 2021/03/04 06:12:58 INFO : potato2.rcc.011_fqgh68: Moved (server-side) to: potato2.rcc.011 2021/03/04 06:12:58 INFO : potato2.rcc.012_fqgh68: Moved (server-side) to: potato2.rcc.012 2021/03/04 06:12:58 INFO : potato2.rcc.013_fqgh68: Moved (server-side) to: potato2.rcc.013 2021/03/04 06:12:58 INFO : potato2.rcc.014_fqgh68: Moved (server-side) to: potato2.rcc.014 2021/03/04 06:12:58 INFO : potato2.rcc.015_fqgh68: Moved (server-side) to: potato2.rcc.015 2021/03/04 06:12:58 INFO : potato2.rcc.016_fqgh68: Moved (server-side) to: potato2.rcc.016 2021/03/04 06:12:58 INFO : potato2.rcc.017_fqgh68: Moved (server-side) to: potato2.rcc.017 2021/03/04 06:12:58 INFO : potato2.rcc.018_fqgh68: Moved (server-side) to: potato2.rcc.018 2021/03/04 06:12:58 INFO : potato2.rcc.019_fqgh68: Moved (server-side) to: potato2.rcc.019 2021/03/04 06:12:58 INFO : potato2.rcc.020_fqgh68: Moved (server-side) to: potato2.rcc.020 2021/03/04 06:12:58 INFO : potato2: Copied (new) 2021/03/04 06:12:58 INFO : potato: Deleted 2021/03/04 06:12:58 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterRemovingAFileAndAddingAFile (0.04s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:58 INFO : b/potato.rcc.001_fqghk5: Moved (server-side) to: b/potato.rcc.001 2021/03/04 06:12:58 INFO : b/potato.rcc.002_fqghk5: Moved (server-side) to: b/potato.rcc.002 2021/03/04 06:12:58 INFO : b/potato.rcc.003_fqghk5: Moved (server-side) to: b/potato.rcc.003 2021/03/04 06:12:58 INFO : b/potato.rcc.004_fqghk5: Moved (server-side) to: b/potato.rcc.004 2021/03/04 06:12:58 INFO : b/potato.rcc.005_fqghk5: Moved (server-side) to: b/potato.rcc.005 2021/03/04 06:12:58 INFO : b/potato.rcc.006_fqghk5: Moved (server-side) to: b/potato.rcc.006 2021/03/04 06:12:58 INFO : b/potato.rcc.007_fqghk5: Moved (server-side) to: b/potato.rcc.007 2021/03/04 06:12:58 INFO : c/non empty space.rcc.001_fqghh9: Moved (server-side) to: c/non empty space.rcc.001 2021/03/04 06:12:58 INFO : c/non empty space.rcc.002_fqghh9: Moved (server-side) to: c/non empty space.rcc.002 2021/03/04 06:12:58 DEBUG : d: Making directory 2021/03/04 06:12:58 DEBUG : d/e: Making directory 2021/03/04 06:12:58 DEBUG : a/potato2: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:58 INFO : a/potato2.rcc.001_fqghab: Moved (server-side) to: a/potato2.rcc.001 2021/03/04 06:12:58 INFO : a/potato2.rcc.002_fqghab: Moved (server-side) to: a/potato2.rcc.002 2021/03/04 06:12:58 INFO : a/potato2.rcc.003_fqghab: Moved (server-side) to: a/potato2.rcc.003 2021/03/04 06:12:58 INFO : a/potato2.rcc.004_fqghab: Moved (server-side) to: a/potato2.rcc.004 2021/03/04 06:12:58 INFO : a/potato2.rcc.005_fqghab: Moved (server-side) to: a/potato2.rcc.005 2021/03/04 06:12:58 INFO : a/potato2.rcc.006_fqghab: Moved (server-side) to: a/potato2.rcc.006 2021/03/04 06:12:58 INFO : a/potato2.rcc.007_fqghab: Moved (server-side) to: a/potato2.rcc.007 2021/03/04 06:12:58 INFO : a/potato2.rcc.008_fqghab: Moved (server-side) to: a/potato2.rcc.008 2021/03/04 06:12:58 INFO : a/potato2.rcc.009_fqghab: Moved (server-side) to: a/potato2.rcc.009 2021/03/04 06:12:58 INFO : a/potato2.rcc.010_fqghab: Moved (server-side) to: a/potato2.rcc.010 2021/03/04 06:12:58 INFO : a/potato2.rcc.011_fqghab: Moved (server-side) to: a/potato2.rcc.011 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:58 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:12:58 DEBUG : c/non empty space: Unchanged skipping 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:58 INFO : a/potato2.rcc.012_fqghab: Moved (server-side) to: a/potato2.rcc.012 2021/03/04 06:12:58 INFO : a/potato2.rcc.013_fqghab: Moved (server-side) to: a/potato2.rcc.013 2021/03/04 06:12:58 INFO : a/potato2.rcc.014_fqghab: Moved (server-side) to: a/potato2.rcc.014 2021/03/04 06:12:58 INFO : a/potato2.rcc.015_fqghab: Moved (server-side) to: a/potato2.rcc.015 2021/03/04 06:12:58 INFO : a/potato2.rcc.016_fqghab: Moved (server-side) to: a/potato2.rcc.016 2021/03/04 06:12:58 INFO : a/potato2.rcc.017_fqghab: Moved (server-side) to: a/potato2.rcc.017 2021/03/04 06:12:58 INFO : a/potato2.rcc.018_fqghab: Moved (server-side) to: a/potato2.rcc.018 2021/03/04 06:12:58 INFO : a/potato2.rcc.019_fqghab: Moved (server-side) to: a/potato2.rcc.019 2021/03/04 06:12:58 INFO : a/potato2.rcc.020_fqghab: Moved (server-side) to: a/potato2.rcc.020 2021/03/04 06:12:58 INFO : a/potato2: Copied (new) 2021/03/04 06:12:58 DEBUG : Waiting for deletions to finish 2021/03/04 06:12:58 INFO : b/potato: Deleted 2021/03/04 06:12:58 DEBUG : d/e: Removing directory 2021/03/04 06:12:58 DEBUG : d: Removing directory 2021/03/04 06:12:58 DEBUG : b: Removing directory 2021/03/04 06:12:58 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': deleted 3 directories --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (0.51s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:59 INFO : b/potato.rcc.001_fqgiy5: Moved (server-side) to: b/potato.rcc.001 2021/03/04 06:12:59 INFO : b/potato.rcc.002_fqgiy5: Moved (server-side) to: b/potato.rcc.002 2021/03/04 06:12:59 INFO : b/potato.rcc.003_fqgiy5: Moved (server-side) to: b/potato.rcc.003 2021/03/04 06:12:59 INFO : b/potato.rcc.004_fqgiy5: Moved (server-side) to: b/potato.rcc.004 2021/03/04 06:12:59 INFO : b/potato.rcc.005_fqgiy5: Moved (server-side) to: b/potato.rcc.005 2021/03/04 06:12:59 INFO : b/potato.rcc.006_fqgiy5: Moved (server-side) to: b/potato.rcc.006 2021/03/04 06:12:59 INFO : b/potato.rcc.007_fqgiy5: Moved (server-side) to: b/potato.rcc.007 2021/03/04 06:12:59 INFO : c/non empty space.rcc.001_fqgic0: Moved (server-side) to: c/non empty space.rcc.001 2021/03/04 06:12:59 INFO : c/non empty space.rcc.002_fqgic0: Moved (server-side) to: c/non empty space.rcc.002 2021/03/04 06:12:59 DEBUG : d: Making directory 2021/03/04 06:12:59 DEBUG : a/potato2: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:59 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:12:59 DEBUG : c/non empty space: Unchanged skipping 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:59 INFO : a/potato2.rcc.001_fqgisj: Moved (server-side) to: a/potato2.rcc.001 2021/03/04 06:12:59 INFO : a/potato2.rcc.002_fqgisj: Moved (server-side) to: a/potato2.rcc.002 2021/03/04 06:12:59 INFO : a/potato2.rcc.003_fqgisj: Moved (server-side) to: a/potato2.rcc.003 2021/03/04 06:12:59 INFO : a/potato2.rcc.004_fqgisj: Moved (server-side) to: a/potato2.rcc.004 2021/03/04 06:12:59 INFO : a/potato2.rcc.005_fqgisj: Moved (server-side) to: a/potato2.rcc.005 2021/03/04 06:12:59 INFO : a/potato2.rcc.006_fqgisj: Moved (server-side) to: a/potato2.rcc.006 2021/03/04 06:12:59 INFO : a/potato2.rcc.007_fqgisj: Moved (server-side) to: a/potato2.rcc.007 2021/03/04 06:12:59 INFO : a/potato2.rcc.008_fqgisj: Moved (server-side) to: a/potato2.rcc.008 2021/03/04 06:12:59 INFO : a/potato2.rcc.009_fqgisj: Moved (server-side) to: a/potato2.rcc.009 2021/03/04 06:12:59 INFO : a/potato2.rcc.010_fqgisj: Moved (server-side) to: a/potato2.rcc.010 2021/03/04 06:12:59 INFO : a/potato2.rcc.011_fqgisj: Moved (server-side) to: a/potato2.rcc.011 2021/03/04 06:12:59 INFO : a/potato2.rcc.012_fqgisj: Moved (server-side) to: a/potato2.rcc.012 2021/03/04 06:12:59 INFO : a/potato2.rcc.013_fqgisj: Moved (server-side) to: a/potato2.rcc.013 2021/03/04 06:12:59 INFO : a/potato2.rcc.014_fqgisj: Moved (server-side) to: a/potato2.rcc.014 2021/03/04 06:12:59 INFO : a/potato2.rcc.015_fqgisj: Moved (server-side) to: a/potato2.rcc.015 2021/03/04 06:12:59 INFO : a/potato2.rcc.016_fqgisj: Moved (server-side) to: a/potato2.rcc.016 2021/03/04 06:12:59 INFO : a/potato2.rcc.017_fqgisj: Moved (server-side) to: a/potato2.rcc.017 2021/03/04 06:12:59 INFO : a/potato2.rcc.018_fqgisj: Moved (server-side) to: a/potato2.rcc.018 2021/03/04 06:12:59 INFO : a/potato2.rcc.019_fqgisj: Moved (server-side) to: a/potato2.rcc.019 2021/03/04 06:12:59 INFO : a/potato2.rcc.020_fqgisj: Moved (server-side) to: a/potato2.rcc.020 2021/03/04 06:12:59 INFO : a/potato2: Copied (new) 2021/03/04 06:12:59 ERROR : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': not deleting files as there were IO errors 2021/03/04 06:12:59 ERROR : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': not deleting directories as there were IO errors --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (0.07s) === RUN TestSyncDeleteAfter --- PASS: TestSyncDeleteAfter (0.00s) === RUN TestSyncDeleteDuring run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:59 INFO : potato.rcc.001_fqginp: Moved (server-side) to: potato.rcc.001 2021/03/04 06:12:59 INFO : potato.rcc.002_fqginp: Moved (server-side) to: potato.rcc.002 2021/03/04 06:12:59 INFO : potato.rcc.003_fqginp: Moved (server-side) to: potato.rcc.003 2021/03/04 06:12:59 INFO : potato.rcc.004_fqginp: Moved (server-side) to: potato.rcc.004 2021/03/04 06:12:59 INFO : potato.rcc.005_fqginp: Moved (server-side) to: potato.rcc.005 2021/03/04 06:12:59 INFO : potato.rcc.006_fqginp: Moved (server-side) to: potato.rcc.006 2021/03/04 06:12:59 INFO : potato.rcc.007_fqginp: Moved (server-side) to: potato.rcc.007 2021/03/04 06:12:59 INFO : empty space.rcc.001_fqgi99: Moved (server-side) to: empty space 2021/03/04 06:12:59 DEBUG : potato2: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:59 DEBUG : Waiting for deletions to finish 2021/03/04 06:12:59 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:12:59 DEBUG : empty space: Unchanged skipping 2021/03/04 06:12:59 INFO : potato: Deleted 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:59 INFO : potato2.rcc.001_fqgigp: Moved (server-side) to: potato2.rcc.001 2021/03/04 06:12:59 INFO : potato2.rcc.002_fqgigp: Moved (server-side) to: potato2.rcc.002 2021/03/04 06:12:59 INFO : potato2.rcc.003_fqgigp: Moved (server-side) to: potato2.rcc.003 2021/03/04 06:12:59 INFO : potato2.rcc.004_fqgigp: Moved (server-side) to: potato2.rcc.004 2021/03/04 06:12:59 INFO : potato2.rcc.005_fqgigp: Moved (server-side) to: potato2.rcc.005 2021/03/04 06:12:59 INFO : potato2.rcc.006_fqgigp: Moved (server-side) to: potato2.rcc.006 2021/03/04 06:12:59 INFO : potato2.rcc.007_fqgigp: Moved (server-side) to: potato2.rcc.007 2021/03/04 06:12:59 INFO : potato2.rcc.008_fqgigp: Moved (server-side) to: potato2.rcc.008 2021/03/04 06:12:59 INFO : potato2.rcc.009_fqgigp: Moved (server-side) to: potato2.rcc.009 2021/03/04 06:12:59 INFO : potato2.rcc.010_fqgigp: Moved (server-side) to: potato2.rcc.010 2021/03/04 06:12:59 INFO : potato2.rcc.011_fqgigp: Moved (server-side) to: potato2.rcc.011 2021/03/04 06:12:59 INFO : potato2.rcc.012_fqgigp: Moved (server-side) to: potato2.rcc.012 2021/03/04 06:12:59 INFO : potato2.rcc.013_fqgigp: Moved (server-side) to: potato2.rcc.013 2021/03/04 06:12:59 INFO : potato2.rcc.014_fqgigp: Moved (server-side) to: potato2.rcc.014 2021/03/04 06:12:59 INFO : potato2.rcc.015_fqgigp: Moved (server-side) to: potato2.rcc.015 2021/03/04 06:12:59 INFO : potato2.rcc.016_fqgigp: Moved (server-side) to: potato2.rcc.016 2021/03/04 06:12:59 INFO : potato2.rcc.017_fqgigp: Moved (server-side) to: potato2.rcc.017 2021/03/04 06:12:59 INFO : potato2.rcc.018_fqgigp: Moved (server-side) to: potato2.rcc.018 2021/03/04 06:12:59 INFO : potato2.rcc.019_fqgigp: Moved (server-side) to: potato2.rcc.019 2021/03/04 06:12:59 INFO : potato2.rcc.020_fqgigp: Moved (server-side) to: potato2.rcc.020 2021/03/04 06:12:59 INFO : potato2: Copied (new) --- PASS: TestSyncDeleteDuring (0.04s) === RUN TestSyncDeleteBefore run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:59 INFO : potato.rcc.001_fqgih6: Moved (server-side) to: potato.rcc.001 2021/03/04 06:12:59 INFO : potato.rcc.002_fqgih6: Moved (server-side) to: potato.rcc.002 2021/03/04 06:12:59 INFO : potato.rcc.003_fqgih6: Moved (server-side) to: potato.rcc.003 2021/03/04 06:12:59 INFO : potato.rcc.004_fqgih6: Moved (server-side) to: potato.rcc.004 2021/03/04 06:12:59 INFO : potato.rcc.005_fqgih6: Moved (server-side) to: potato.rcc.005 2021/03/04 06:12:59 INFO : potato.rcc.006_fqgih6: Moved (server-side) to: potato.rcc.006 2021/03/04 06:12:59 INFO : potato.rcc.007_fqgih6: Moved (server-side) to: potato.rcc.007 2021/03/04 06:12:59 INFO : empty space.rcc.001_fqgi84: Moved (server-side) to: empty space 2021/03/04 06:12:59 DEBUG : Waiting for deletions to finish 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:59 INFO : potato: Deleted 2021/03/04 06:12:59 DEBUG : potato2: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:59 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:12:59 DEBUG : empty space: Unchanged skipping 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:59 INFO : potato2.rcc.001_fqgifp: Moved (server-side) to: potato2.rcc.001 2021/03/04 06:12:59 INFO : potato2.rcc.002_fqgifp: Moved (server-side) to: potato2.rcc.002 2021/03/04 06:12:59 INFO : potato2.rcc.003_fqgifp: Moved (server-side) to: potato2.rcc.003 2021/03/04 06:12:59 INFO : potato2.rcc.004_fqgifp: Moved (server-side) to: potato2.rcc.004 2021/03/04 06:12:59 INFO : potato2.rcc.005_fqgifp: Moved (server-side) to: potato2.rcc.005 2021/03/04 06:12:59 INFO : potato2.rcc.006_fqgifp: Moved (server-side) to: potato2.rcc.006 2021/03/04 06:12:59 INFO : potato2.rcc.007_fqgifp: Moved (server-side) to: potato2.rcc.007 2021/03/04 06:12:59 INFO : potato2.rcc.008_fqgifp: Moved (server-side) to: potato2.rcc.008 2021/03/04 06:12:59 INFO : potato2.rcc.009_fqgifp: Moved (server-side) to: potato2.rcc.009 2021/03/04 06:12:59 INFO : potato2.rcc.010_fqgifp: Moved (server-side) to: potato2.rcc.010 2021/03/04 06:12:59 INFO : potato2.rcc.011_fqgifp: Moved (server-side) to: potato2.rcc.011 2021/03/04 06:12:59 INFO : potato2.rcc.012_fqgifp: Moved (server-side) to: potato2.rcc.012 2021/03/04 06:12:59 INFO : potato2.rcc.013_fqgifp: Moved (server-side) to: potato2.rcc.013 2021/03/04 06:12:59 INFO : potato2.rcc.014_fqgifp: Moved (server-side) to: potato2.rcc.014 2021/03/04 06:12:59 INFO : potato2.rcc.015_fqgifp: Moved (server-side) to: potato2.rcc.015 2021/03/04 06:12:59 INFO : potato2.rcc.016_fqgifp: Moved (server-side) to: potato2.rcc.016 2021/03/04 06:12:59 INFO : potato2.rcc.017_fqgifp: Moved (server-side) to: potato2.rcc.017 2021/03/04 06:12:59 INFO : potato2.rcc.018_fqgifp: Moved (server-side) to: potato2.rcc.018 2021/03/04 06:12:59 INFO : potato2.rcc.019_fqgifp: Moved (server-side) to: potato2.rcc.019 2021/03/04 06:12:59 INFO : potato2.rcc.020_fqgifp: Moved (server-side) to: potato2.rcc.020 2021/03/04 06:12:59 INFO : potato2: Copied (new) --- PASS: TestSyncDeleteBefore (0.04s) === RUN TestCopyDeleteBefore run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:59 INFO : potato.rcc.001_fqgi10: Moved (server-side) to: potato.rcc.001 2021/03/04 06:12:59 INFO : potato.rcc.002_fqgi10: Moved (server-side) to: potato.rcc.002 2021/03/04 06:12:59 INFO : potato.rcc.003_fqgi10: Moved (server-side) to: potato.rcc.003 2021/03/04 06:12:59 INFO : potato.rcc.004_fqgi10: Moved (server-side) to: potato.rcc.004 2021/03/04 06:12:59 INFO : potato.rcc.005_fqgi10: Moved (server-side) to: potato.rcc.005 2021/03/04 06:12:59 INFO : potato.rcc.006_fqgi10: Moved (server-side) to: potato.rcc.006 2021/03/04 06:12:59 INFO : potato.rcc.007_fqgi10: Moved (server-side) to: potato.rcc.007 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:59 DEBUG : potato2: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:59 INFO : potato2.rcc.001_fqgivs: Moved (server-side) to: potato2.rcc.001 2021/03/04 06:12:59 INFO : potato2.rcc.002_fqgivs: Moved (server-side) to: potato2.rcc.002 2021/03/04 06:12:59 INFO : potato2.rcc.003_fqgivs: Moved (server-side) to: potato2.rcc.003 2021/03/04 06:12:59 INFO : potato2.rcc.004_fqgivs: Moved (server-side) to: potato2.rcc.004 2021/03/04 06:12:59 INFO : potato2.rcc.005_fqgivs: Moved (server-side) to: potato2.rcc.005 2021/03/04 06:12:59 INFO : potato2.rcc.006_fqgivs: Moved (server-side) to: potato2.rcc.006 2021/03/04 06:12:59 INFO : potato2.rcc.007_fqgivs: Moved (server-side) to: potato2.rcc.007 2021/03/04 06:12:59 INFO : potato2: Copied (new) --- PASS: TestCopyDeleteBefore (0.03s) === RUN TestSyncWithExclude run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:59 INFO : potato2.rcc.001_fqgiwf: Moved (server-side) to: potato2.rcc.001 2021/03/04 06:12:59 INFO : potato2.rcc.002_fqgiwf: Moved (server-side) to: potato2.rcc.002 2021/03/04 06:12:59 INFO : potato2.rcc.003_fqgiwf: Moved (server-side) to: potato2.rcc.003 2021/03/04 06:12:59 INFO : potato2.rcc.004_fqgiwf: Moved (server-side) to: potato2.rcc.004 2021/03/04 06:12:59 INFO : potato2.rcc.005_fqgiwf: Moved (server-side) to: potato2.rcc.005 2021/03/04 06:12:59 INFO : potato2.rcc.006_fqgiwf: Moved (server-side) to: potato2.rcc.006 2021/03/04 06:12:59 INFO : potato2.rcc.007_fqgiwf: Moved (server-side) to: potato2.rcc.007 2021/03/04 06:12:59 INFO : potato2.rcc.008_fqgiwf: Moved (server-side) to: potato2.rcc.008 2021/03/04 06:12:59 INFO : potato2.rcc.009_fqgiwf: Moved (server-side) to: potato2.rcc.009 2021/03/04 06:12:59 INFO : potato2.rcc.010_fqgiwf: Moved (server-side) to: potato2.rcc.010 2021/03/04 06:12:59 INFO : potato2.rcc.011_fqgiwf: Moved (server-side) to: potato2.rcc.011 2021/03/04 06:12:59 INFO : potato2.rcc.012_fqgiwf: Moved (server-side) to: potato2.rcc.012 2021/03/04 06:12:59 INFO : potato2.rcc.013_fqgiwf: Moved (server-side) to: potato2.rcc.013 2021/03/04 06:12:59 INFO : potato2.rcc.014_fqgiwf: Moved (server-side) to: potato2.rcc.014 2021/03/04 06:12:59 INFO : potato2.rcc.015_fqgiwf: Moved (server-side) to: potato2.rcc.015 2021/03/04 06:12:59 INFO : potato2.rcc.016_fqgiwf: Moved (server-side) to: potato2.rcc.016 2021/03/04 06:12:59 INFO : potato2.rcc.017_fqgiwf: Moved (server-side) to: potato2.rcc.017 2021/03/04 06:12:59 INFO : potato2.rcc.018_fqgiwf: Moved (server-side) to: potato2.rcc.018 2021/03/04 06:12:59 INFO : potato2.rcc.019_fqgiwf: Moved (server-side) to: potato2.rcc.019 2021/03/04 06:12:59 INFO : potato2.rcc.020_fqgiwf: Moved (server-side) to: potato2.rcc.020 2021/03/04 06:12:59 INFO : empty space.rcc.001_fqgi7q: Moved (server-side) to: empty space 2021/03/04 06:12:59 DEBUG : enormous: Excluded 2021/03/04 06:12:59 DEBUG : potato2: Excluded 2021/03/04 06:12:59 DEBUG : potato2: Excluded 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:59 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:12:59 DEBUG : empty space: Unchanged skipping 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:59 DEBUG : Waiting for deletions to finish 2021/03/04 06:12:59 INFO : There was nothing to transfer 2021/03/04 06:12:59 DEBUG : enormous: Excluded 2021/03/04 06:12:59 DEBUG : potato2: Excluded 2021/03/04 06:12:59 DEBUG : potato2: Excluded 2021/03/04 06:12:59 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:12:59 DEBUG : empty space: Unchanged skipping 2021/03/04 06:12:59 DEBUG : Local file system at /tmp/rclone487708856: Waiting for checks to finish 2021/03/04 06:12:59 DEBUG : Local file system at /tmp/rclone487708856: Waiting for transfers to finish 2021/03/04 06:12:59 DEBUG : Waiting for deletions to finish 2021/03/04 06:12:59 INFO : There was nothing to transfer --- PASS: TestSyncWithExclude (0.05s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:59 INFO : potato2.rcc.001_fqgim6: Moved (server-side) to: potato2.rcc.001 2021/03/04 06:12:59 INFO : potato2.rcc.002_fqgim6: Moved (server-side) to: potato2.rcc.002 2021/03/04 06:12:59 INFO : potato2.rcc.003_fqgim6: Moved (server-side) to: potato2.rcc.003 2021/03/04 06:12:59 INFO : potato2.rcc.004_fqgim6: Moved (server-side) to: potato2.rcc.004 2021/03/04 06:12:59 INFO : potato2.rcc.005_fqgim6: Moved (server-side) to: potato2.rcc.005 2021/03/04 06:12:59 INFO : potato2.rcc.006_fqgim6: Moved (server-side) to: potato2.rcc.006 2021/03/04 06:12:59 INFO : potato2.rcc.007_fqgim6: Moved (server-side) to: potato2.rcc.007 2021/03/04 06:12:59 INFO : potato2.rcc.008_fqgim6: Moved (server-side) to: potato2.rcc.008 2021/03/04 06:12:59 INFO : potato2.rcc.009_fqgim6: Moved (server-side) to: potato2.rcc.009 2021/03/04 06:12:59 INFO : potato2.rcc.010_fqgim6: Moved (server-side) to: potato2.rcc.010 2021/03/04 06:12:59 INFO : potato2.rcc.011_fqgim6: Moved (server-side) to: potato2.rcc.011 2021/03/04 06:12:59 INFO : potato2.rcc.012_fqgim6: Moved (server-side) to: potato2.rcc.012 2021/03/04 06:12:59 INFO : potato2.rcc.013_fqgim6: Moved (server-side) to: potato2.rcc.013 2021/03/04 06:12:59 INFO : potato2.rcc.014_fqgim6: Moved (server-side) to: potato2.rcc.014 2021/03/04 06:12:59 INFO : potato2.rcc.015_fqgim6: Moved (server-side) to: potato2.rcc.015 2021/03/04 06:12:59 INFO : potato2.rcc.016_fqgim6: Moved (server-side) to: potato2.rcc.016 2021/03/04 06:12:59 INFO : potato2.rcc.017_fqgim6: Moved (server-side) to: potato2.rcc.017 2021/03/04 06:12:59 INFO : potato2.rcc.018_fqgim6: Moved (server-side) to: potato2.rcc.018 2021/03/04 06:12:59 INFO : potato2.rcc.019_fqgim6: Moved (server-side) to: potato2.rcc.019 2021/03/04 06:12:59 INFO : potato2.rcc.020_fqgim6: Moved (server-side) to: potato2.rcc.020 2021/03/04 06:12:59 INFO : empty space.rcc.001_fqgip0: Moved (server-side) to: empty space 2021/03/04 06:12:59 INFO : enormous.rcc.001_fqgia9: Moved (server-side) to: enormous.rcc.001 2021/03/04 06:12:59 INFO : enormous.rcc.002_fqgia9: Moved (server-side) to: enormous.rcc.002 2021/03/04 06:12:59 INFO : enormous.rcc.003_fqgia9: Moved (server-side) to: enormous.rcc.003 2021/03/04 06:12:59 INFO : enormous.rcc.004_fqgia9: Moved (server-side) to: enormous.rcc.004 2021/03/04 06:12:59 INFO : enormous.rcc.005_fqgia9: Moved (server-side) to: enormous.rcc.005 2021/03/04 06:12:59 INFO : enormous.rcc.006_fqgia9: Moved (server-side) to: enormous.rcc.006 2021/03/04 06:12:59 INFO : enormous.rcc.007_fqgia9: Moved (server-side) to: enormous.rcc.007 2021/03/04 06:12:59 INFO : enormous.rcc.008_fqgia9: Moved (server-side) to: enormous.rcc.008 2021/03/04 06:12:59 INFO : enormous.rcc.009_fqgia9: Moved (server-side) to: enormous.rcc.009 2021/03/04 06:12:59 INFO : enormous.rcc.010_fqgia9: Moved (server-side) to: enormous.rcc.010 2021/03/04 06:12:59 INFO : enormous.rcc.011_fqgia9: Moved (server-side) to: enormous.rcc.011 2021/03/04 06:12:59 INFO : enormous.rcc.012_fqgia9: Moved (server-side) to: enormous.rcc.012 2021/03/04 06:12:59 INFO : enormous.rcc.013_fqgia9: Moved (server-side) to: enormous.rcc.013 2021/03/04 06:12:59 INFO : enormous.rcc.014_fqgia9: Moved (server-side) to: enormous.rcc.014 2021/03/04 06:12:59 INFO : enormous.rcc.015_fqgia9: Moved (server-side) to: enormous.rcc.015 2021/03/04 06:12:59 INFO : enormous.rcc.016_fqgia9: Moved (server-side) to: enormous.rcc.016 2021/03/04 06:12:59 INFO : enormous.rcc.017_fqgia9: Moved (server-side) to: enormous.rcc.017 2021/03/04 06:12:59 INFO : enormous.rcc.018_fqgia9: Moved (server-side) to: enormous.rcc.018 2021/03/04 06:12:59 INFO : enormous.rcc.019_fqgia9: Moved (server-side) to: enormous.rcc.019 2021/03/04 06:12:59 INFO : enormous.rcc.020_fqgia9: Moved (server-side) to: enormous.rcc.020 2021/03/04 06:12:59 INFO : enormous.rcc.021_fqgia9: Moved (server-side) to: enormous.rcc.021 2021/03/04 06:12:59 INFO : enormous.rcc.022_fqgia9: Moved (server-side) to: enormous.rcc.022 2021/03/04 06:12:59 INFO : enormous.rcc.023_fqgia9: Moved (server-side) to: enormous.rcc.023 2021/03/04 06:12:59 INFO : enormous.rcc.024_fqgia9: Moved (server-side) to: enormous.rcc.024 2021/03/04 06:12:59 INFO : enormous.rcc.025_fqgia9: Moved (server-side) to: enormous.rcc.025 2021/03/04 06:12:59 INFO : enormous.rcc.026_fqgia9: Moved (server-side) to: enormous.rcc.026 2021/03/04 06:12:59 INFO : enormous.rcc.027_fqgia9: Moved (server-side) to: enormous.rcc.027 2021/03/04 06:12:59 INFO : enormous.rcc.028_fqgia9: Moved (server-side) to: enormous.rcc.028 2021/03/04 06:12:59 INFO : enormous.rcc.029_fqgia9: Moved (server-side) to: enormous.rcc.029 2021/03/04 06:12:59 INFO : enormous.rcc.030_fqgia9: Moved (server-side) to: enormous.rcc.030 2021/03/04 06:12:59 INFO : enormous.rcc.031_fqgia9: Moved (server-side) to: enormous.rcc.031 2021/03/04 06:12:59 INFO : enormous.rcc.032_fqgia9: Moved (server-side) to: enormous.rcc.032 2021/03/04 06:12:59 INFO : enormous.rcc.033_fqgia9: Moved (server-side) to: enormous.rcc.033 2021/03/04 06:12:59 INFO : enormous.rcc.034_fqgia9: Moved (server-side) to: enormous.rcc.034 2021/03/04 06:12:59 DEBUG : enormous: Excluded 2021/03/04 06:12:59 DEBUG : potato2: Excluded 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:59 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:12:59 DEBUG : empty space: Unchanged skipping 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:59 DEBUG : Waiting for deletions to finish 2021/03/04 06:12:59 INFO : potato2: Deleted 2021/03/04 06:12:59 INFO : enormous: Deleted 2021/03/04 06:12:59 INFO : There was nothing to transfer 2021/03/04 06:12:59 DEBUG : Local file system at /tmp/rclone487708856: Waiting for checks to finish 2021/03/04 06:12:59 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:12:59 DEBUG : empty space: Unchanged skipping 2021/03/04 06:12:59 DEBUG : Local file system at /tmp/rclone487708856: Waiting for transfers to finish 2021/03/04 06:12:59 DEBUG : Waiting for deletions to finish 2021/03/04 06:12:59 INFO : enormous: Deleted 2021/03/04 06:12:59 INFO : potato2: Deleted 2021/03/04 06:12:59 INFO : There was nothing to transfer --- PASS: TestSyncWithExcludeAndDeleteExcluded (0.09s) === RUN TestSyncWithUpdateOlder run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:59 INFO : one.rcc.001_fqgix0: Moved (server-side) to: one 2021/03/04 06:12:59 INFO : two.rcc.001_fqgir6: Moved (server-side) to: two 2021/03/04 06:12:59 INFO : three.rcc.001_fqgib9: Moved (server-side) to: three.rcc.001 2021/03/04 06:12:59 INFO : three.rcc.002_fqgib9: Moved (server-side) to: three.rcc.002 2021/03/04 06:12:59 INFO : four.rcc.001_fqgi1g: Moved (server-side) to: four.rcc.001 2021/03/04 06:12:59 INFO : four.rcc.002_fqgi1g: Moved (server-side) to: four.rcc.002 2021/03/04 06:12:59 INFO : four.rcc.003_fqgi1g: Moved (server-side) to: four.rcc.003 2021/03/04 06:12:59 DEBUG : four: Sizes differ (src 4 vs dst 8) 2021/03/04 06:12:59 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2021/03/04 06:12:59 DEBUG : four: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:59 INFO : four.rcc.001_fqgij6: Moved (server-side) to: four.rcc.001 2021/03/04 06:12:59 INFO : four.rcc.002_fqgij6: Moved (server-side) to: four.rcc.002 2021/03/04 06:12:59 DEBUG : one: Destination is newer than source, skipping 2021/03/04 06:12:59 DEBUG : three: Sizes identical 2021/03/04 06:12:59 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2021/03/04 06:12:59 DEBUG : two: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:59 DEBUG : five: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:59 INFO : two: Deleted 2021/03/04 06:12:59 INFO : two.rcc.001_fqgi7q: Moved (server-side) to: two 2021/03/04 06:12:59 INFO : four: Copied (replaced existing) 2021/03/04 06:12:59 INFO : two: Copied (replaced existing) 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:59 INFO : five.rcc.001_fqgijg: Moved (server-side) to: five.rcc.001 2021/03/04 06:12:59 INFO : five.rcc.002_fqgijg: Moved (server-side) to: five.rcc.002 2021/03/04 06:12:59 INFO : five: Copied (new) 2021/03/04 06:12:59 DEBUG : Waiting for deletions to finish sync_test.go:1056: Skip test with --checksum as no hashes supported --- PASS: TestSyncWithUpdateOlder (0.03s) === RUN TestSyncWithMaxDuration sync_test.go:1074: Skipping test on non local remote --- SKIP: TestSyncWithMaxDuration (0.00s) === RUN TestSyncWithTrackRenames run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" sync_test.go:1128: Can track renames: false 2021/03/04 06:12:59 ERROR : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Ignoring --track-renames as the source and destination do not have a common hash 2021/03/04 06:12:59 DEBUG : potato: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:59 INFO : potato.rcc.001_fqgi5r: Moved (server-side) to: potato.rcc.001 2021/03/04 06:12:59 INFO : potato.rcc.002_fqgi5r: Moved (server-side) to: potato.rcc.002 2021/03/04 06:12:59 INFO : potato.rcc.003_fqgi5r: Moved (server-side) to: potato.rcc.003 2021/03/04 06:12:59 INFO : potato.rcc.004_fqgi5r: Moved (server-side) to: potato.rcc.004 2021/03/04 06:12:59 INFO : potato.rcc.005_fqgi5r: Moved (server-side) to: potato.rcc.005 2021/03/04 06:12:59 DEBUG : yam: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:59 INFO : potato: Copied (new) 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:59 INFO : yam.rcc.001_fqgief: Moved (server-side) to: yam.rcc.001 2021/03/04 06:12:59 INFO : yam.rcc.002_fqgief: Moved (server-side) to: yam.rcc.002 2021/03/04 06:12:59 INFO : yam.rcc.003_fqgief: Moved (server-side) to: yam.rcc.003 2021/03/04 06:12:59 INFO : yam.rcc.004_fqgief: Moved (server-side) to: yam.rcc.004 2021/03/04 06:12:59 INFO : yam: Copied (new) 2021/03/04 06:12:59 DEBUG : Waiting for deletions to finish 2021/03/04 06:12:59 ERROR : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Ignoring --track-renames as the source and destination do not have a common hash 2021/03/04 06:12:59 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:12:59 DEBUG : potato: Unchanged skipping 2021/03/04 06:12:59 DEBUG : yaml: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:59 INFO : yaml.rcc.001_fqgikl: Moved (server-side) to: yaml.rcc.001 2021/03/04 06:12:59 INFO : yaml.rcc.002_fqgikl: Moved (server-side) to: yaml.rcc.002 2021/03/04 06:12:59 INFO : yaml.rcc.003_fqgikl: Moved (server-side) to: yaml.rcc.003 2021/03/04 06:12:59 INFO : yaml.rcc.004_fqgikl: Moved (server-side) to: yaml.rcc.004 2021/03/04 06:12:59 INFO : yaml: Copied (new) 2021/03/04 06:12:59 DEBUG : Waiting for deletions to finish 2021/03/04 06:12:59 INFO : yam: Deleted --- PASS: TestSyncWithTrackRenames (0.05s) === RUN TestParseRenamesStrategyModtime --- PASS: TestParseRenamesStrategyModtime (0.00s) === RUN TestRenamesStrategyModtime --- PASS: TestRenamesStrategyModtime (0.00s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" sync_test.go:1201: Can track renames: true 2021/03/04 06:12:59 INFO : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Making map for --track-renames 2021/03/04 06:12:59 INFO : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Finished making map for --track-renames 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:59 DEBUG : potato: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:59 DEBUG : yam: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:59 INFO : yam.rcc.001_fqgit7: Moved (server-side) to: yam.rcc.001 2021/03/04 06:12:59 INFO : yam.rcc.002_fqgit7: Moved (server-side) to: yam.rcc.002 2021/03/04 06:12:59 INFO : yam.rcc.003_fqgit7: Moved (server-side) to: yam.rcc.003 2021/03/04 06:12:59 INFO : yam.rcc.004_fqgit7: Moved (server-side) to: yam.rcc.004 2021/03/04 06:12:59 INFO : potato.rcc.001_fqgi12: Moved (server-side) to: potato.rcc.001 2021/03/04 06:12:59 INFO : yam: Copied (new) 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for renames to finish 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:59 INFO : potato.rcc.002_fqgi12: Moved (server-side) to: potato.rcc.002 2021/03/04 06:12:59 INFO : potato.rcc.003_fqgi12: Moved (server-side) to: potato.rcc.003 2021/03/04 06:12:59 INFO : potato.rcc.004_fqgi12: Moved (server-side) to: potato.rcc.004 2021/03/04 06:12:59 INFO : potato.rcc.005_fqgi12: Moved (server-side) to: potato.rcc.005 2021/03/04 06:12:59 INFO : potato: Copied (new) 2021/03/04 06:12:59 DEBUG : Waiting for deletions to finish 2021/03/04 06:12:59 INFO : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Making map for --track-renames 2021/03/04 06:12:59 INFO : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Finished making map for --track-renames 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:59 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:12:59 DEBUG : potato: Unchanged skipping 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for renames to finish 2021/03/04 06:12:59 DEBUG : yam: move 4 data chunks... 2021/03/04 06:12:59 INFO : yam.rcc.001: Moved (server-side) to: yaml.rcc.001 2021/03/04 06:12:59 INFO : yam.rcc.002: Moved (server-side) to: yaml.rcc.002 2021/03/04 06:12:59 INFO : yam.rcc.003: Moved (server-side) to: yaml.rcc.003 2021/03/04 06:12:59 INFO : yam.rcc.004: Moved (server-side) to: yaml.rcc.004 2021/03/04 06:12:59 INFO : yam: Moved (server-side) to: yaml 2021/03/04 06:12:59 INFO : yam: Moved (server-side) to: yaml 2021/03/04 06:12:59 INFO : yaml: Renamed from "yam" 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:59 DEBUG : Waiting for deletions to finish 2021/03/04 06:12:59 INFO : There was nothing to transfer --- PASS: TestSyncWithTrackRenamesStrategyModtime (0.02s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" sync_test.go:1241: Can track renames: true 2021/03/04 06:12:59 INFO : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Making map for --track-renames 2021/03/04 06:12:59 INFO : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Finished making map for --track-renames 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:59 DEBUG : potato: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:59 DEBUG : sub/yam: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:59 INFO : potato.rcc.001_fqgibf: Moved (server-side) to: potato.rcc.001 2021/03/04 06:12:59 INFO : potato.rcc.002_fqgibf: Moved (server-side) to: potato.rcc.002 2021/03/04 06:12:59 INFO : potato.rcc.003_fqgibf: Moved (server-side) to: potato.rcc.003 2021/03/04 06:12:59 INFO : potato.rcc.004_fqgibf: Moved (server-side) to: potato.rcc.004 2021/03/04 06:12:59 INFO : potato.rcc.005_fqgibf: Moved (server-side) to: potato.rcc.005 2021/03/04 06:12:59 INFO : potato: Copied (new) 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for renames to finish 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:59 INFO : sub/yam.rcc.001_fqgibw: Moved (server-side) to: sub/yam.rcc.001 2021/03/04 06:12:59 INFO : sub/yam.rcc.002_fqgibw: Moved (server-side) to: sub/yam.rcc.002 2021/03/04 06:12:59 INFO : sub/yam.rcc.003_fqgibw: Moved (server-side) to: sub/yam.rcc.003 2021/03/04 06:12:59 INFO : sub/yam.rcc.004_fqgibw: Moved (server-side) to: sub/yam.rcc.004 2021/03/04 06:12:59 INFO : sub/yam: Copied (new) 2021/03/04 06:12:59 DEBUG : Waiting for deletions to finish 2021/03/04 06:12:59 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:12:59 DEBUG : potato: Unchanged skipping 2021/03/04 06:12:59 INFO : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Making map for --track-renames 2021/03/04 06:12:59 INFO : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Finished making map for --track-renames 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for renames to finish 2021/03/04 06:12:59 DEBUG : sub/yam: move 4 data chunks... 2021/03/04 06:12:59 INFO : sub/yam.rcc.001: Moved (server-side) to: yam.rcc.001 2021/03/04 06:12:59 INFO : sub/yam.rcc.002: Moved (server-side) to: yam.rcc.002 2021/03/04 06:12:59 INFO : sub/yam.rcc.003: Moved (server-side) to: yam.rcc.003 2021/03/04 06:12:59 INFO : sub/yam.rcc.004: Moved (server-side) to: yam.rcc.004 2021/03/04 06:12:59 INFO : sub/yam: Moved (server-side) to: yam 2021/03/04 06:12:59 INFO : sub/yam: Moved (server-side) to: yam 2021/03/04 06:12:59 INFO : yam: Renamed from "sub/yam" 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:59 DEBUG : Waiting for deletions to finish 2021/03/04 06:12:59 INFO : There was nothing to transfer --- PASS: TestSyncWithTrackRenamesStrategyLeaf (0.02s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:59 DEBUG : sub dir/hello world: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:59 DEBUG : nested/sub dir/file: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:59 INFO : nested/sub dir/file.rcc.001_fqgiis: Moved (server-side) to: nested/sub dir/file.rcc.001 2021/03/04 06:12:59 INFO : nested/sub dir/file.rcc.002_fqgiis: Moved (server-side) to: nested/sub dir/file.rcc.002 2021/03/04 06:12:59 INFO : sub dir/hello world.rcc.001_fqgizn: Moved (server-side) to: sub dir/hello world.rcc.001 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:59 INFO : nested/sub dir/file: Copied (new) 2021/03/04 06:12:59 INFO : sub dir/hello world.rcc.002_fqgizn: Moved (server-side) to: sub dir/hello world.rcc.002 2021/03/04 06:12:59 INFO : sub dir/hello world.rcc.003_fqgizn: Moved (server-side) to: sub dir/hello world.rcc.003 2021/03/04 06:12:59 INFO : sub dir/hello world.rcc.004_fqgizn: Moved (server-side) to: sub dir/hello world.rcc.004 2021/03/04 06:12:59 INFO : nested/sub dir/file: Deleted 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:59 INFO : sub dir/hello world: Copied (new) 2021/03/04 06:12:59 INFO : sub dir/hello world: Deleted 2021/03/04 06:12:59 DEBUG : sub dir: Removing directory 2021/03/04 06:12:59 DEBUG : nested/sub dir: Removing directory 2021/03/04 06:12:59 DEBUG : nested: Removing directory 2021/03/04 06:12:59 DEBUG : Local file system at /tmp/rclone487708856: deleted 3 directories --- PASS: TestMoveWithDeleteEmptySrcDirs (0.01s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:59 DEBUG : sub dir/hello world: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:59 DEBUG : nested/sub dir/file: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:12:59 INFO : nested/sub dir/file.rcc.001_fqgi7u: Moved (server-side) to: nested/sub dir/file.rcc.001 2021/03/04 06:12:59 INFO : nested/sub dir/file.rcc.002_fqgi7u: Moved (server-side) to: nested/sub dir/file.rcc.002 2021/03/04 06:12:59 INFO : sub dir/hello world.rcc.001_fqgi45: Moved (server-side) to: sub dir/hello world.rcc.001 2021/03/04 06:12:59 INFO : sub dir/hello world.rcc.002_fqgi45: Moved (server-side) to: sub dir/hello world.rcc.002 2021/03/04 06:12:59 INFO : sub dir/hello world.rcc.003_fqgi45: Moved (server-side) to: sub dir/hello world.rcc.003 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:12:59 INFO : sub dir/hello world.rcc.004_fqgi45: Moved (server-side) to: sub dir/hello world.rcc.004 2021/03/04 06:12:59 INFO : nested/sub dir/file: Copied (new) 2021/03/04 06:12:59 INFO : nested/sub dir/file: Deleted 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:12:59 INFO : sub dir/hello world: Copied (new) 2021/03/04 06:12:59 INFO : sub dir/hello world: Deleted --- PASS: TestMoveWithoutDeleteEmptySrcDirs (0.01s) === RUN TestServerSideMove run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:12:59 DEBUG : Creating backend with remote "TestChunkerOverCrypt:rclone-test-tunebuc5jitawuh7sapidag4" 2021/03/04 06:12:59 DEBUG : Creating backend with remote "__TestChunkerOverCrypt:rclone-test-tunebuc5jitawuh7sapidag4" 2021/03/04 06:12:59 DEBUG : Creating backend with remote "/tmp/test_chunker_over_crypt/jiipo0pnrbjssi5lorqeb18sd9jb394q8k2s2a7m4glup4k23c1irr8026vs267uc6kmkqoff2356" 2021/03/04 06:12:59 DEBUG : Reset feature "ListR" 2021/03/04 06:12:59 INFO : potato2.rcc.001_fqgih0: Moved (server-side) to: potato2.rcc.001 2021/03/04 06:12:59 INFO : potato2.rcc.002_fqgih0: Moved (server-side) to: potato2.rcc.002 2021/03/04 06:12:59 INFO : potato2.rcc.003_fqgih0: Moved (server-side) to: potato2.rcc.003 2021/03/04 06:12:59 INFO : potato2.rcc.004_fqgih0: Moved (server-side) to: potato2.rcc.004 2021/03/04 06:12:59 INFO : potato2.rcc.005_fqgih0: Moved (server-side) to: potato2.rcc.005 2021/03/04 06:12:59 INFO : potato2.rcc.006_fqgih0: Moved (server-side) to: potato2.rcc.006 2021/03/04 06:12:59 INFO : potato2.rcc.007_fqgih0: Moved (server-side) to: potato2.rcc.007 2021/03/04 06:12:59 INFO : potato2.rcc.008_fqgih0: Moved (server-side) to: potato2.rcc.008 2021/03/04 06:12:59 INFO : potato2.rcc.009_fqgih0: Moved (server-side) to: potato2.rcc.009 2021/03/04 06:12:59 INFO : potato2.rcc.010_fqgih0: Moved (server-side) to: potato2.rcc.010 2021/03/04 06:12:59 INFO : potato2.rcc.011_fqgih0: Moved (server-side) to: potato2.rcc.011 2021/03/04 06:12:59 INFO : potato2.rcc.012_fqgih0: Moved (server-side) to: potato2.rcc.012 2021/03/04 06:12:59 INFO : potato2.rcc.013_fqgih0: Moved (server-side) to: potato2.rcc.013 2021/03/04 06:12:59 INFO : potato2.rcc.014_fqgih0: Moved (server-side) to: potato2.rcc.014 2021/03/04 06:12:59 INFO : potato2.rcc.015_fqgih0: Moved (server-side) to: potato2.rcc.015 2021/03/04 06:12:59 INFO : potato2.rcc.016_fqgih0: Moved (server-side) to: potato2.rcc.016 2021/03/04 06:12:59 INFO : potato2.rcc.017_fqgih0: Moved (server-side) to: potato2.rcc.017 2021/03/04 06:12:59 INFO : potato2.rcc.018_fqgih0: Moved (server-side) to: potato2.rcc.018 2021/03/04 06:12:59 INFO : potato2.rcc.019_fqgih0: Moved (server-side) to: potato2.rcc.019 2021/03/04 06:12:59 INFO : potato2.rcc.020_fqgih0: Moved (server-side) to: potato2.rcc.020 2021/03/04 06:12:59 INFO : empty space.rcc.001_fqgiei: Moved (server-side) to: empty space 2021/03/04 06:12:59 INFO : potato3.rcc.001_fqgijx: Moved (server-side) to: potato3.rcc.001 2021/03/04 06:12:59 INFO : potato3.rcc.002_fqgijx: Moved (server-side) to: potato3.rcc.002 2021/03/04 06:12:59 INFO : potato3.rcc.003_fqgijx: Moved (server-side) to: potato3.rcc.003 2021/03/04 06:12:59 INFO : potato3.rcc.004_fqgijx: Moved (server-side) to: potato3.rcc.004 2021/03/04 06:12:59 INFO : potato3.rcc.005_fqgijx: Moved (server-side) to: potato3.rcc.005 2021/03/04 06:12:59 INFO : potato3.rcc.006_fqgijx: Moved (server-side) to: potato3.rcc.006 2021/03/04 06:12:59 INFO : potato3.rcc.007_fqgijx: Moved (server-side) to: potato3.rcc.007 2021/03/04 06:12:59 INFO : potato3.rcc.008_fqgijx: Moved (server-side) to: potato3.rcc.008 2021/03/04 06:12:59 INFO : potato3.rcc.009_fqgijx: Moved (server-side) to: potato3.rcc.009 2021/03/04 06:12:59 INFO : potato3.rcc.010_fqgijx: Moved (server-side) to: potato3.rcc.010 2021/03/04 06:12:59 INFO : potato3.rcc.011_fqgijx: Moved (server-side) to: potato3.rcc.011 2021/03/04 06:12:59 INFO : potato3.rcc.012_fqgijx: Moved (server-side) to: potato3.rcc.012 2021/03/04 06:12:59 INFO : potato3.rcc.013_fqgijx: Moved (server-side) to: potato3.rcc.013 2021/03/04 06:12:59 INFO : potato3.rcc.014_fqgijx: Moved (server-side) to: potato3.rcc.014 2021/03/04 06:12:59 INFO : potato3.rcc.015_fqgijx: Moved (server-side) to: potato3.rcc.015 2021/03/04 06:12:59 INFO : potato3.rcc.016_fqgijx: Moved (server-side) to: potato3.rcc.016 2021/03/04 06:12:59 INFO : potato3.rcc.017_fqgijx: Moved (server-side) to: potato3.rcc.017 2021/03/04 06:12:59 INFO : potato3.rcc.018_fqgijx: Moved (server-side) to: potato3.rcc.018 2021/03/04 06:12:59 INFO : potato3.rcc.019_fqgijx: Moved (server-side) to: potato3.rcc.019 2021/03/04 06:12:59 INFO : potato3.rcc.020_fqgijx: Moved (server-side) to: potato3.rcc.020 2021/03/04 06:12:59 INFO : potato3.rcc.021_fqgijx: Moved (server-side) to: potato3.rcc.021 2021/03/04 06:12:59 INFO : potato3.rcc.022_fqgijx: Moved (server-side) to: potato3.rcc.022 2021/03/04 06:12:59 INFO : potato3.rcc.023_fqgijx: Moved (server-side) to: potato3.rcc.023 sync_test.go:1294: Server side move (if possible) Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0' -> Chunked 'TestChunkerOverCrypt:rclone-test-tunebuc5jitawuh7sapidag4' 2021/03/04 06:12:59 INFO : empty space.rcc.001_fqgia8: Moved (server-side) to: empty space 2021/03/04 06:12:59 INFO : potato3.rcc.001_fqgi16: Moved (server-side) to: potato3.rcc.001 2021/03/04 06:12:59 INFO : potato3.rcc.002_fqgi16: Moved (server-side) to: potato3.rcc.002 2021/03/04 06:12:59 INFO : potato3.rcc.003_fqgi16: Moved (server-side) to: potato3.rcc.003 2021/03/04 06:12:59 INFO : potato3.rcc.004_fqgi16: Moved (server-side) to: potato3.rcc.004 2021/03/04 06:12:59 INFO : potato3.rcc.005_fqgi16: Moved (server-side) to: potato3.rcc.005 2021/03/04 06:12:59 INFO : potato3.rcc.006_fqgi16: Moved (server-side) to: potato3.rcc.006 2021/03/04 06:12:59 INFO : potato3.rcc.007_fqgi16: Moved (server-side) to: potato3.rcc.007 2021/03/04 06:12:59 INFO : potato3.rcc.008_fqgi16: Moved (server-side) to: potato3.rcc.008 2021/03/04 06:12:59 INFO : potato3.rcc.009_fqgi16: Moved (server-side) to: potato3.rcc.009 2021/03/04 06:12:59 INFO : potato3.rcc.010_fqgi16: Moved (server-side) to: potato3.rcc.010 2021/03/04 06:12:59 INFO : potato3.rcc.011_fqgi16: Moved (server-side) to: potato3.rcc.011 2021/03/04 06:12:59 INFO : potato3.rcc.012_fqgi16: Moved (server-side) to: potato3.rcc.012 2021/03/04 06:12:59 INFO : potato3.rcc.013_fqgi16: Moved (server-side) to: potato3.rcc.013 2021/03/04 06:12:59 INFO : potato3.rcc.014_fqgi16: Moved (server-side) to: potato3.rcc.014 2021/03/04 06:12:59 INFO : potato3.rcc.015_fqgi16: Moved (server-side) to: potato3.rcc.015 2021/03/04 06:12:59 INFO : potato3.rcc.016_fqgi16: Moved (server-side) to: potato3.rcc.016 2021/03/04 06:12:59 INFO : potato3.rcc.017_fqgi16: Moved (server-side) to: potato3.rcc.017 2021/03/04 06:12:59 INFO : potato3.rcc.018_fqgi16: Moved (server-side) to: potato3.rcc.018 2021/03/04 06:12:59 INFO : potato3.rcc.019_fqgi16: Moved (server-side) to: potato3.rcc.019 2021/03/04 06:12:59 INFO : potato3.rcc.020_fqgi16: Moved (server-side) to: potato3.rcc.020 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-tunebuc5jitawuh7sapidag4': Using server-side directory move 2021/03/04 06:12:59 INFO : Chunked 'TestChunkerOverCrypt:rclone-test-tunebuc5jitawuh7sapidag4': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2021/03/04 06:12:59 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:12:59 DEBUG : empty space: Unchanged skipping 2021/03/04 06:12:59 DEBUG : potato2: move 20 data chunks... 2021/03/04 06:12:59 INFO : potato2.rcc.001: Moved (server-side) 2021/03/04 06:12:59 INFO : potato2.rcc.002: Moved (server-side) 2021/03/04 06:12:59 INFO : potato2.rcc.003: Moved (server-side) 2021/03/04 06:12:59 INFO : potato2.rcc.004: Moved (server-side) 2021/03/04 06:12:59 INFO : potato2.rcc.005: Moved (server-side) 2021/03/04 06:12:59 INFO : potato2.rcc.006: Moved (server-side) 2021/03/04 06:12:59 INFO : potato2.rcc.007: Moved (server-side) 2021/03/04 06:12:59 INFO : potato2.rcc.008: Moved (server-side) 2021/03/04 06:12:59 INFO : potato2.rcc.009: Moved (server-side) 2021/03/04 06:12:59 INFO : potato2.rcc.010: Moved (server-side) 2021/03/04 06:12:59 INFO : potato2.rcc.011: Moved (server-side) 2021/03/04 06:12:59 INFO : potato2.rcc.012: Moved (server-side) 2021/03/04 06:12:59 INFO : potato2.rcc.013: Moved (server-side) 2021/03/04 06:12:59 INFO : potato2.rcc.014: Moved (server-side) 2021/03/04 06:12:59 INFO : potato2.rcc.015: Moved (server-side) 2021/03/04 06:12:59 INFO : potato2.rcc.016: Moved (server-side) 2021/03/04 06:12:59 INFO : potato2.rcc.017: Moved (server-side) 2021/03/04 06:12:59 INFO : potato2.rcc.018: Moved (server-side) 2021/03/04 06:12:59 INFO : potato2.rcc.019: Moved (server-side) 2021/03/04 06:12:59 INFO : potato2.rcc.020: Moved (server-side) 2021/03/04 06:12:59 INFO : potato2: Moved (server-side) 2021/03/04 06:12:59 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2021/03/04 06:12:59 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-tunebuc5jitawuh7sapidag4': Waiting for checks to finish 2021/03/04 06:13:00 INFO : empty space: Deleted 2021/03/04 06:13:00 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-tunebuc5jitawuh7sapidag4': Waiting for transfers to finish 2021/03/04 06:13:00 INFO : potato3: Deleted 2021/03/04 06:13:00 DEBUG : potato3: move 23 data chunks... 2021/03/04 06:13:00 INFO : potato3.rcc.001: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.002: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.003: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.004: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.005: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.006: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.007: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.008: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.009: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.010: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.011: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.012: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.013: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.014: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.015: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.016: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.017: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.018: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.019: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.020: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.021: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.022: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.023: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3: Moved (server-side) 2021/03/04 06:13:00 INFO : potato2: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3: Moved (server-side) 2021/03/04 06:13:00 INFO : There was nothing to transfer 2021/03/04 06:13:00 DEBUG : Creating backend with remote "TestChunkerOverCrypt:rclone-test-zohawuw0bocifoz8lajopek9" 2021/03/04 06:13:00 DEBUG : Creating backend with remote "__TestChunkerOverCrypt:rclone-test-zohawuw0bocifoz8lajopek9" 2021/03/04 06:13:00 DEBUG : Creating backend with remote "/tmp/test_chunker_over_crypt/l33v2a20lf4bq9kmgphblc61cmtsvl1puilibml5i552i80lsd3kmig6j5vn9oa1t9v378m5nnfks" 2021/03/04 06:13:00 DEBUG : Reset feature "ListR" 2021/03/04 06:13:00 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-zohawuw0bocifoz8lajopek9': Using server-side directory move 2021/03/04 06:13:00 INFO : Chunked 'TestChunkerOverCrypt:rclone-test-zohawuw0bocifoz8lajopek9': Server side directory move succeeded 2021/03/04 06:13:00 ERROR : : error listing: directory not found 2021/03/04 06:13:00 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-zohawuw0bocifoz8lajopek9': Purge remote 2021/03/04 06:13:00 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-tunebuc5jitawuh7sapidag4': Purge remote 2021/03/04 06:13:00 purge failed: directory not found --- PASS: TestServerSideMove (0.76s) === RUN TestServerSideMoveWithFilter run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:13:00 DEBUG : Creating backend with remote "TestChunkerOverCrypt:rclone-test-sufilad4velukak7pefetuq7" 2021/03/04 06:13:00 DEBUG : Creating backend with remote "__TestChunkerOverCrypt:rclone-test-sufilad4velukak7pefetuq7" 2021/03/04 06:13:00 DEBUG : Creating backend with remote "/tmp/test_chunker_over_crypt/3v2cr7uvq8j8m1fm26o9dbj6ak4iv3fg2qct7qfmo2lc2ladavi30k6po0pjnj2l1r7gevbtust1o" 2021/03/04 06:13:00 DEBUG : Reset feature "ListR" 2021/03/04 06:13:00 INFO : potato2.rcc.001_fqgj7j: Moved (server-side) to: potato2.rcc.001 2021/03/04 06:13:00 INFO : potato2.rcc.002_fqgj7j: Moved (server-side) to: potato2.rcc.002 2021/03/04 06:13:00 INFO : potato2.rcc.003_fqgj7j: Moved (server-side) to: potato2.rcc.003 2021/03/04 06:13:00 INFO : potato2.rcc.004_fqgj7j: Moved (server-side) to: potato2.rcc.004 2021/03/04 06:13:00 INFO : potato2.rcc.005_fqgj7j: Moved (server-side) to: potato2.rcc.005 2021/03/04 06:13:00 INFO : potato2.rcc.006_fqgj7j: Moved (server-side) to: potato2.rcc.006 2021/03/04 06:13:00 INFO : potato2.rcc.007_fqgj7j: Moved (server-side) to: potato2.rcc.007 2021/03/04 06:13:00 INFO : potato2.rcc.008_fqgj7j: Moved (server-side) to: potato2.rcc.008 2021/03/04 06:13:00 INFO : potato2.rcc.009_fqgj7j: Moved (server-side) to: potato2.rcc.009 2021/03/04 06:13:00 INFO : potato2.rcc.010_fqgj7j: Moved (server-side) to: potato2.rcc.010 2021/03/04 06:13:00 INFO : potato2.rcc.011_fqgj7j: Moved (server-side) to: potato2.rcc.011 2021/03/04 06:13:00 INFO : potato2.rcc.012_fqgj7j: Moved (server-side) to: potato2.rcc.012 2021/03/04 06:13:00 INFO : potato2.rcc.013_fqgj7j: Moved (server-side) to: potato2.rcc.013 2021/03/04 06:13:00 INFO : potato2.rcc.014_fqgj7j: Moved (server-side) to: potato2.rcc.014 2021/03/04 06:13:00 INFO : potato2.rcc.015_fqgj7j: Moved (server-side) to: potato2.rcc.015 2021/03/04 06:13:00 INFO : potato2.rcc.016_fqgj7j: Moved (server-side) to: potato2.rcc.016 2021/03/04 06:13:00 INFO : potato2.rcc.017_fqgj7j: Moved (server-side) to: potato2.rcc.017 2021/03/04 06:13:00 INFO : potato2.rcc.018_fqgj7j: Moved (server-side) to: potato2.rcc.018 2021/03/04 06:13:00 INFO : potato2.rcc.019_fqgj7j: Moved (server-side) to: potato2.rcc.019 2021/03/04 06:13:00 INFO : potato2.rcc.020_fqgj7j: Moved (server-side) to: potato2.rcc.020 2021/03/04 06:13:00 INFO : empty space.rcc.001_fqgjnu: Moved (server-side) to: empty space 2021/03/04 06:13:00 INFO : potato3.rcc.001_fqgjot: Moved (server-side) to: potato3.rcc.001 2021/03/04 06:13:00 INFO : potato3.rcc.002_fqgjot: Moved (server-side) to: potato3.rcc.002 2021/03/04 06:13:00 INFO : potato3.rcc.003_fqgjot: Moved (server-side) to: potato3.rcc.003 2021/03/04 06:13:00 INFO : potato3.rcc.004_fqgjot: Moved (server-side) to: potato3.rcc.004 2021/03/04 06:13:00 INFO : potato3.rcc.005_fqgjot: Moved (server-side) to: potato3.rcc.005 2021/03/04 06:13:00 INFO : potato3.rcc.006_fqgjot: Moved (server-side) to: potato3.rcc.006 2021/03/04 06:13:00 INFO : potato3.rcc.007_fqgjot: Moved (server-side) to: potato3.rcc.007 2021/03/04 06:13:00 INFO : potato3.rcc.008_fqgjot: Moved (server-side) to: potato3.rcc.008 2021/03/04 06:13:00 INFO : potato3.rcc.009_fqgjot: Moved (server-side) to: potato3.rcc.009 2021/03/04 06:13:00 INFO : potato3.rcc.010_fqgjot: Moved (server-side) to: potato3.rcc.010 2021/03/04 06:13:00 INFO : potato3.rcc.011_fqgjot: Moved (server-side) to: potato3.rcc.011 2021/03/04 06:13:00 INFO : potato3.rcc.012_fqgjot: Moved (server-side) to: potato3.rcc.012 2021/03/04 06:13:00 INFO : potato3.rcc.013_fqgjot: Moved (server-side) to: potato3.rcc.013 2021/03/04 06:13:00 INFO : potato3.rcc.014_fqgjot: Moved (server-side) to: potato3.rcc.014 2021/03/04 06:13:00 INFO : potato3.rcc.015_fqgjot: Moved (server-side) to: potato3.rcc.015 2021/03/04 06:13:00 INFO : potato3.rcc.016_fqgjot: Moved (server-side) to: potato3.rcc.016 2021/03/04 06:13:00 INFO : potato3.rcc.017_fqgjot: Moved (server-side) to: potato3.rcc.017 2021/03/04 06:13:00 INFO : potato3.rcc.018_fqgjot: Moved (server-side) to: potato3.rcc.018 2021/03/04 06:13:00 INFO : potato3.rcc.019_fqgjot: Moved (server-side) to: potato3.rcc.019 2021/03/04 06:13:00 INFO : potato3.rcc.020_fqgjot: Moved (server-side) to: potato3.rcc.020 2021/03/04 06:13:00 INFO : potato3.rcc.021_fqgjot: Moved (server-side) to: potato3.rcc.021 2021/03/04 06:13:00 INFO : potato3.rcc.022_fqgjot: Moved (server-side) to: potato3.rcc.022 2021/03/04 06:13:00 INFO : potato3.rcc.023_fqgjot: Moved (server-side) to: potato3.rcc.023 sync_test.go:1294: Server side move (if possible) Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0' -> Chunked 'TestChunkerOverCrypt:rclone-test-sufilad4velukak7pefetuq7' 2021/03/04 06:13:00 INFO : empty space.rcc.001_fqgj1a: Moved (server-side) to: empty space 2021/03/04 06:13:00 INFO : potato3.rcc.001_fqgjk3: Moved (server-side) to: potato3.rcc.001 2021/03/04 06:13:00 INFO : potato3.rcc.002_fqgjk3: Moved (server-side) to: potato3.rcc.002 2021/03/04 06:13:00 INFO : potato3.rcc.003_fqgjk3: Moved (server-side) to: potato3.rcc.003 2021/03/04 06:13:00 INFO : potato3.rcc.004_fqgjk3: Moved (server-side) to: potato3.rcc.004 2021/03/04 06:13:00 INFO : potato3.rcc.005_fqgjk3: Moved (server-side) to: potato3.rcc.005 2021/03/04 06:13:00 INFO : potato3.rcc.006_fqgjk3: Moved (server-side) to: potato3.rcc.006 2021/03/04 06:13:00 INFO : potato3.rcc.007_fqgjk3: Moved (server-side) to: potato3.rcc.007 2021/03/04 06:13:00 INFO : potato3.rcc.008_fqgjk3: Moved (server-side) to: potato3.rcc.008 2021/03/04 06:13:00 INFO : potato3.rcc.009_fqgjk3: Moved (server-side) to: potato3.rcc.009 2021/03/04 06:13:00 INFO : potato3.rcc.010_fqgjk3: Moved (server-side) to: potato3.rcc.010 2021/03/04 06:13:00 INFO : potato3.rcc.011_fqgjk3: Moved (server-side) to: potato3.rcc.011 2021/03/04 06:13:00 INFO : potato3.rcc.012_fqgjk3: Moved (server-side) to: potato3.rcc.012 2021/03/04 06:13:00 INFO : potato3.rcc.013_fqgjk3: Moved (server-side) to: potato3.rcc.013 2021/03/04 06:13:00 INFO : potato3.rcc.014_fqgjk3: Moved (server-side) to: potato3.rcc.014 2021/03/04 06:13:00 INFO : potato3.rcc.015_fqgjk3: Moved (server-side) to: potato3.rcc.015 2021/03/04 06:13:00 INFO : potato3.rcc.016_fqgjk3: Moved (server-side) to: potato3.rcc.016 2021/03/04 06:13:00 INFO : potato3.rcc.017_fqgjk3: Moved (server-side) to: potato3.rcc.017 2021/03/04 06:13:00 INFO : potato3.rcc.018_fqgjk3: Moved (server-side) to: potato3.rcc.018 2021/03/04 06:13:00 INFO : potato3.rcc.019_fqgjk3: Moved (server-side) to: potato3.rcc.019 2021/03/04 06:13:00 INFO : potato3.rcc.020_fqgjk3: Moved (server-side) to: potato3.rcc.020 2021/03/04 06:13:00 DEBUG : empty space: Excluded 2021/03/04 06:13:00 DEBUG : empty space: Excluded 2021/03/04 06:13:00 DEBUG : potato2: move 20 data chunks... 2021/03/04 06:13:00 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2021/03/04 06:13:00 INFO : potato2.rcc.001: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3: Deleted 2021/03/04 06:13:00 DEBUG : potato3: move 23 data chunks... 2021/03/04 06:13:00 INFO : potato3.rcc.001: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.002: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.003: Moved (server-side) 2021/03/04 06:13:00 INFO : potato2.rcc.002: Moved (server-side) 2021/03/04 06:13:00 INFO : potato2.rcc.003: Moved (server-side) 2021/03/04 06:13:00 INFO : potato2.rcc.004: Moved (server-side) 2021/03/04 06:13:00 INFO : potato2.rcc.005: Moved (server-side) 2021/03/04 06:13:00 INFO : potato2.rcc.006: Moved (server-side) 2021/03/04 06:13:00 INFO : potato2.rcc.007: Moved (server-side) 2021/03/04 06:13:00 INFO : potato2.rcc.008: Moved (server-side) 2021/03/04 06:13:00 INFO : potato2.rcc.009: Moved (server-side) 2021/03/04 06:13:00 INFO : potato2.rcc.010: Moved (server-side) 2021/03/04 06:13:00 INFO : potato2.rcc.011: Moved (server-side) 2021/03/04 06:13:00 INFO : potato2.rcc.012: Moved (server-side) 2021/03/04 06:13:00 INFO : potato2.rcc.013: Moved (server-side) 2021/03/04 06:13:00 INFO : potato2.rcc.014: Moved (server-side) 2021/03/04 06:13:00 INFO : potato2.rcc.015: Moved (server-side) 2021/03/04 06:13:00 INFO : potato2.rcc.016: Moved (server-side) 2021/03/04 06:13:00 INFO : potato2.rcc.017: Moved (server-side) 2021/03/04 06:13:00 INFO : potato2.rcc.018: Moved (server-side) 2021/03/04 06:13:00 INFO : potato2.rcc.019: Moved (server-side) 2021/03/04 06:13:00 INFO : potato2.rcc.020: Moved (server-side) 2021/03/04 06:13:00 INFO : potato2: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.004: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.005: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.006: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.007: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.008: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.009: Moved (server-side) 2021/03/04 06:13:00 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-sufilad4velukak7pefetuq7': Waiting for checks to finish 2021/03/04 06:13:00 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-sufilad4velukak7pefetuq7': Waiting for transfers to finish 2021/03/04 06:13:00 INFO : potato3.rcc.010: Moved (server-side) 2021/03/04 06:13:00 INFO : potato2: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.011: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.012: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.013: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.014: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.015: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.016: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.017: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.018: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.019: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.020: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.021: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.022: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.023: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3: Moved (server-side) 2021/03/04 06:13:00 INFO : There was nothing to transfer 2021/03/04 06:13:00 DEBUG : Creating backend with remote "TestChunkerOverCrypt:rclone-test-helupod4jedejum3qanacot9" 2021/03/04 06:13:00 DEBUG : Creating backend with remote "__TestChunkerOverCrypt:rclone-test-helupod4jedejum3qanacot9" 2021/03/04 06:13:00 DEBUG : Creating backend with remote "/tmp/test_chunker_over_crypt/fnd54bm60kr99pnt95f1jl6rr9r0dmuce6cekp7aluimaeg2uk44v885j1hnchrujn8sn92p9gv2c" 2021/03/04 06:13:00 DEBUG : Reset feature "ListR" 2021/03/04 06:13:00 DEBUG : empty space: Excluded 2021/03/04 06:13:00 DEBUG : potato3: move 23 data chunks... 2021/03/04 06:13:00 INFO : potato3.rcc.001: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.002: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.003: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.004: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.005: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.006: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.007: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.008: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.009: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.010: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.011: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.012: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.013: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.014: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.015: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.016: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.017: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.018: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.019: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.020: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.021: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.022: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3.rcc.023: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3: Moved (server-side) 2021/03/04 06:13:00 INFO : potato3: Moved (server-side) 2021/03/04 06:13:00 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-helupod4jedejum3qanacot9': Waiting for checks to finish 2021/03/04 06:13:00 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-helupod4jedejum3qanacot9': Waiting for transfers to finish 2021/03/04 06:13:01 DEBUG : potato2: move 20 data chunks... 2021/03/04 06:13:01 INFO : potato2.rcc.001: Moved (server-side) 2021/03/04 06:13:01 INFO : potato2.rcc.002: Moved (server-side) 2021/03/04 06:13:01 INFO : potato2.rcc.003: Moved (server-side) 2021/03/04 06:13:01 INFO : potato2.rcc.004: Moved (server-side) 2021/03/04 06:13:01 INFO : potato2.rcc.005: Moved (server-side) 2021/03/04 06:13:01 INFO : potato2.rcc.006: Moved (server-side) 2021/03/04 06:13:01 INFO : potato2.rcc.007: Moved (server-side) 2021/03/04 06:13:01 INFO : potato2.rcc.008: Moved (server-side) 2021/03/04 06:13:01 INFO : potato2.rcc.009: Moved (server-side) 2021/03/04 06:13:01 INFO : potato2.rcc.010: Moved (server-side) 2021/03/04 06:13:01 INFO : potato2.rcc.011: Moved (server-side) 2021/03/04 06:13:01 INFO : potato2.rcc.012: Moved (server-side) 2021/03/04 06:13:01 INFO : potato2.rcc.013: Moved (server-side) 2021/03/04 06:13:01 INFO : potato2.rcc.014: Moved (server-side) 2021/03/04 06:13:01 INFO : potato2.rcc.015: Moved (server-side) 2021/03/04 06:13:01 INFO : potato2.rcc.016: Moved (server-side) 2021/03/04 06:13:01 INFO : potato2.rcc.017: Moved (server-side) 2021/03/04 06:13:01 INFO : potato2.rcc.018: Moved (server-side) 2021/03/04 06:13:01 INFO : potato2.rcc.019: Moved (server-side) 2021/03/04 06:13:01 INFO : potato2.rcc.020: Moved (server-side) 2021/03/04 06:13:01 INFO : potato2: Moved (server-side) 2021/03/04 06:13:01 INFO : potato2: Moved (server-side) 2021/03/04 06:13:01 INFO : There was nothing to transfer 2021/03/04 06:13:01 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-helupod4jedejum3qanacot9': Purge remote 2021/03/04 06:13:01 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-sufilad4velukak7pefetuq7': Purge remote --- PASS: TestServerSideMoveWithFilter (0.99s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:13:01 DEBUG : Creating backend with remote "TestChunkerOverCrypt:rclone-test-tijeron5gafefuz6tamuduw0" 2021/03/04 06:13:01 DEBUG : Creating backend with remote "__TestChunkerOverCrypt:rclone-test-tijeron5gafefuz6tamuduw0" 2021/03/04 06:13:01 DEBUG : Creating backend with remote "/tmp/test_chunker_over_crypt/osh7a692bbo86pi0f5m302f0fvt6eup8r7toc90stit9s4ccersb70j252a39br4ukrttskr467fc" 2021/03/04 06:13:01 DEBUG : Reset feature "ListR" 2021/03/04 06:13:01 INFO : potato2.rcc.001_fqgkci: Moved (server-side) to: potato2.rcc.001 2021/03/04 06:13:01 INFO : potato2.rcc.002_fqgkci: Moved (server-side) to: potato2.rcc.002 2021/03/04 06:13:01 INFO : potato2.rcc.003_fqgkci: Moved (server-side) to: potato2.rcc.003 2021/03/04 06:13:01 INFO : potato2.rcc.004_fqgkci: Moved (server-side) to: potato2.rcc.004 2021/03/04 06:13:01 INFO : potato2.rcc.005_fqgkci: Moved (server-side) to: potato2.rcc.005 2021/03/04 06:13:01 INFO : potato2.rcc.006_fqgkci: Moved (server-side) to: potato2.rcc.006 2021/03/04 06:13:01 INFO : potato2.rcc.007_fqgkci: Moved (server-side) to: potato2.rcc.007 2021/03/04 06:13:01 INFO : potato2.rcc.008_fqgkci: Moved (server-side) to: potato2.rcc.008 2021/03/04 06:13:01 INFO : potato2.rcc.009_fqgkci: Moved (server-side) to: potato2.rcc.009 2021/03/04 06:13:01 INFO : potato2.rcc.010_fqgkci: Moved (server-side) to: potato2.rcc.010 2021/03/04 06:13:01 INFO : potato2.rcc.011_fqgkci: Moved (server-side) to: potato2.rcc.011 2021/03/04 06:13:01 INFO : potato2.rcc.012_fqgkci: Moved (server-side) to: potato2.rcc.012 2021/03/04 06:13:01 INFO : potato2.rcc.013_fqgkci: Moved (server-side) to: potato2.rcc.013 2021/03/04 06:13:01 INFO : potato2.rcc.014_fqgkci: Moved (server-side) to: potato2.rcc.014 2021/03/04 06:13:01 INFO : potato2.rcc.015_fqgkci: Moved (server-side) to: potato2.rcc.015 2021/03/04 06:13:01 INFO : potato2.rcc.016_fqgkci: Moved (server-side) to: potato2.rcc.016 2021/03/04 06:13:01 INFO : potato2.rcc.017_fqgkci: Moved (server-side) to: potato2.rcc.017 2021/03/04 06:13:01 INFO : potato2.rcc.018_fqgkci: Moved (server-side) to: potato2.rcc.018 2021/03/04 06:13:01 INFO : potato2.rcc.019_fqgkci: Moved (server-side) to: potato2.rcc.019 2021/03/04 06:13:01 INFO : potato2.rcc.020_fqgkci: Moved (server-side) to: potato2.rcc.020 2021/03/04 06:13:01 INFO : empty space.rcc.001_fqgkac: Moved (server-side) to: empty space 2021/03/04 06:13:01 INFO : potato3.rcc.001_fqgk2b: Moved (server-side) to: potato3.rcc.001 2021/03/04 06:13:01 INFO : potato3.rcc.002_fqgk2b: Moved (server-side) to: potato3.rcc.002 2021/03/04 06:13:01 INFO : potato3.rcc.003_fqgk2b: Moved (server-side) to: potato3.rcc.003 2021/03/04 06:13:01 INFO : potato3.rcc.004_fqgk2b: Moved (server-side) to: potato3.rcc.004 2021/03/04 06:13:01 INFO : potato3.rcc.005_fqgk2b: Moved (server-side) to: potato3.rcc.005 2021/03/04 06:13:01 INFO : potato3.rcc.006_fqgk2b: Moved (server-side) to: potato3.rcc.006 2021/03/04 06:13:01 INFO : potato3.rcc.007_fqgk2b: Moved (server-side) to: potato3.rcc.007 2021/03/04 06:13:01 INFO : potato3.rcc.008_fqgk2b: Moved (server-side) to: potato3.rcc.008 2021/03/04 06:13:01 INFO : potato3.rcc.009_fqgk2b: Moved (server-side) to: potato3.rcc.009 2021/03/04 06:13:01 INFO : potato3.rcc.010_fqgk2b: Moved (server-side) to: potato3.rcc.010 2021/03/04 06:13:01 INFO : potato3.rcc.011_fqgk2b: Moved (server-side) to: potato3.rcc.011 2021/03/04 06:13:01 INFO : potato3.rcc.012_fqgk2b: Moved (server-side) to: potato3.rcc.012 2021/03/04 06:13:01 INFO : potato3.rcc.013_fqgk2b: Moved (server-side) to: potato3.rcc.013 2021/03/04 06:13:01 INFO : potato3.rcc.014_fqgk2b: Moved (server-side) to: potato3.rcc.014 2021/03/04 06:13:01 INFO : potato3.rcc.015_fqgk2b: Moved (server-side) to: potato3.rcc.015 2021/03/04 06:13:01 INFO : potato3.rcc.016_fqgk2b: Moved (server-side) to: potato3.rcc.016 2021/03/04 06:13:01 INFO : potato3.rcc.017_fqgk2b: Moved (server-side) to: potato3.rcc.017 2021/03/04 06:13:01 INFO : potato3.rcc.018_fqgk2b: Moved (server-side) to: potato3.rcc.018 2021/03/04 06:13:01 INFO : potato3.rcc.019_fqgk2b: Moved (server-side) to: potato3.rcc.019 2021/03/04 06:13:01 INFO : potato3.rcc.020_fqgk2b: Moved (server-side) to: potato3.rcc.020 2021/03/04 06:13:01 INFO : potato3.rcc.021_fqgk2b: Moved (server-side) to: potato3.rcc.021 2021/03/04 06:13:01 INFO : potato3.rcc.022_fqgk2b: Moved (server-side) to: potato3.rcc.022 2021/03/04 06:13:01 INFO : potato3.rcc.023_fqgk2b: Moved (server-side) to: potato3.rcc.023 2021/03/04 06:13:01 DEBUG : tomatoDir: Making directory sync_test.go:1294: Server side move (if possible) Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0' -> Chunked 'TestChunkerOverCrypt:rclone-test-tijeron5gafefuz6tamuduw0' 2021/03/04 06:13:02 INFO : empty space.rcc.001_fqgkwo: Moved (server-side) to: empty space 2021/03/04 06:13:02 INFO : potato3.rcc.001_fqglmm: Moved (server-side) to: potato3.rcc.001 2021/03/04 06:13:02 INFO : potato3.rcc.002_fqglmm: Moved (server-side) to: potato3.rcc.002 2021/03/04 06:13:02 INFO : potato3.rcc.003_fqglmm: Moved (server-side) to: potato3.rcc.003 2021/03/04 06:13:02 INFO : potato3.rcc.004_fqglmm: Moved (server-side) to: potato3.rcc.004 2021/03/04 06:13:02 INFO : potato3.rcc.005_fqglmm: Moved (server-side) to: potato3.rcc.005 2021/03/04 06:13:02 INFO : potato3.rcc.006_fqglmm: Moved (server-side) to: potato3.rcc.006 2021/03/04 06:13:02 INFO : potato3.rcc.007_fqglmm: Moved (server-side) to: potato3.rcc.007 2021/03/04 06:13:02 INFO : potato3.rcc.008_fqglmm: Moved (server-side) to: potato3.rcc.008 2021/03/04 06:13:02 INFO : potato3.rcc.009_fqglmm: Moved (server-side) to: potato3.rcc.009 2021/03/04 06:13:02 INFO : potato3.rcc.010_fqglmm: Moved (server-side) to: potato3.rcc.010 2021/03/04 06:13:02 INFO : potato3.rcc.011_fqglmm: Moved (server-side) to: potato3.rcc.011 2021/03/04 06:13:02 INFO : potato3.rcc.012_fqglmm: Moved (server-side) to: potato3.rcc.012 2021/03/04 06:13:02 INFO : potato3.rcc.013_fqglmm: Moved (server-side) to: potato3.rcc.013 2021/03/04 06:13:02 INFO : potato3.rcc.014_fqglmm: Moved (server-side) to: potato3.rcc.014 2021/03/04 06:13:02 INFO : potato3.rcc.015_fqglmm: Moved (server-side) to: potato3.rcc.015 2021/03/04 06:13:02 INFO : potato3.rcc.016_fqglmm: Moved (server-side) to: potato3.rcc.016 2021/03/04 06:13:02 INFO : potato3.rcc.017_fqglmm: Moved (server-side) to: potato3.rcc.017 2021/03/04 06:13:02 INFO : potato3.rcc.018_fqglmm: Moved (server-side) to: potato3.rcc.018 2021/03/04 06:13:02 INFO : potato3.rcc.019_fqglmm: Moved (server-side) to: potato3.rcc.019 2021/03/04 06:13:02 INFO : potato3.rcc.020_fqglmm: Moved (server-side) to: potato3.rcc.020 2021/03/04 06:13:02 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-tijeron5gafefuz6tamuduw0': Using server-side directory move 2021/03/04 06:13:02 INFO : Chunked 'TestChunkerOverCrypt:rclone-test-tijeron5gafefuz6tamuduw0': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2021/03/04 06:13:02 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:13:02 DEBUG : empty space: Unchanged skipping 2021/03/04 06:13:02 INFO : empty space: Deleted 2021/03/04 06:13:02 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2021/03/04 06:13:02 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-tijeron5gafefuz6tamuduw0': Waiting for checks to finish 2021/03/04 06:13:02 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-tijeron5gafefuz6tamuduw0': Waiting for transfers to finish 2021/03/04 06:13:02 INFO : potato3: Deleted 2021/03/04 06:13:02 DEBUG : potato2: move 20 data chunks... 2021/03/04 06:13:02 INFO : potato2.rcc.001: Moved (server-side) 2021/03/04 06:13:02 INFO : potato2.rcc.002: Moved (server-side) 2021/03/04 06:13:02 INFO : potato2.rcc.003: Moved (server-side) 2021/03/04 06:13:02 INFO : potato2.rcc.004: Moved (server-side) 2021/03/04 06:13:02 INFO : potato2.rcc.005: Moved (server-side) 2021/03/04 06:13:02 INFO : potato2.rcc.006: Moved (server-side) 2021/03/04 06:13:02 INFO : potato2.rcc.007: Moved (server-side) 2021/03/04 06:13:02 INFO : potato2.rcc.008: Moved (server-side) 2021/03/04 06:13:02 INFO : potato2.rcc.009: Moved (server-side) 2021/03/04 06:13:02 INFO : potato2.rcc.010: Moved (server-side) 2021/03/04 06:13:02 INFO : potato2.rcc.011: Moved (server-side) 2021/03/04 06:13:02 INFO : potato2.rcc.012: Moved (server-side) 2021/03/04 06:13:02 INFO : potato2.rcc.013: Moved (server-side) 2021/03/04 06:13:02 INFO : potato2.rcc.014: Moved (server-side) 2021/03/04 06:13:02 INFO : potato2.rcc.015: Moved (server-side) 2021/03/04 06:13:02 INFO : potato2.rcc.016: Moved (server-side) 2021/03/04 06:13:02 INFO : potato2.rcc.017: Moved (server-side) 2021/03/04 06:13:02 INFO : potato2.rcc.018: Moved (server-side) 2021/03/04 06:13:02 INFO : potato2.rcc.019: Moved (server-side) 2021/03/04 06:13:02 INFO : potato2.rcc.020: Moved (server-side) 2021/03/04 06:13:02 INFO : potato2: Moved (server-side) 2021/03/04 06:13:02 DEBUG : potato3: move 23 data chunks... 2021/03/04 06:13:02 INFO : potato3.rcc.001: Moved (server-side) 2021/03/04 06:13:02 INFO : potato3.rcc.002: Moved (server-side) 2021/03/04 06:13:02 INFO : potato3.rcc.003: Moved (server-side) 2021/03/04 06:13:02 INFO : potato3.rcc.004: Moved (server-side) 2021/03/04 06:13:02 INFO : potato3.rcc.005: Moved (server-side) 2021/03/04 06:13:02 INFO : potato3.rcc.006: Moved (server-side) 2021/03/04 06:13:02 INFO : potato3.rcc.007: Moved (server-side) 2021/03/04 06:13:02 INFO : potato3.rcc.008: Moved (server-side) 2021/03/04 06:13:02 INFO : potato3.rcc.009: Moved (server-side) 2021/03/04 06:13:02 INFO : potato3.rcc.010: Moved (server-side) 2021/03/04 06:13:02 INFO : potato3.rcc.011: Moved (server-side) 2021/03/04 06:13:02 INFO : potato3.rcc.012: Moved (server-side) 2021/03/04 06:13:02 INFO : potato3.rcc.013: Moved (server-side) 2021/03/04 06:13:02 INFO : potato3.rcc.014: Moved (server-side) 2021/03/04 06:13:02 INFO : potato3.rcc.015: Moved (server-side) 2021/03/04 06:13:02 INFO : potato3.rcc.016: Moved (server-side) 2021/03/04 06:13:02 INFO : potato3.rcc.017: Moved (server-side) 2021/03/04 06:13:02 INFO : potato3.rcc.018: Moved (server-side) 2021/03/04 06:13:02 INFO : potato3.rcc.019: Moved (server-side) 2021/03/04 06:13:02 INFO : potato3.rcc.020: Moved (server-side) 2021/03/04 06:13:02 INFO : potato3.rcc.021: Moved (server-side) 2021/03/04 06:13:02 INFO : potato3.rcc.022: Moved (server-side) 2021/03/04 06:13:02 INFO : potato3.rcc.023: Moved (server-side) 2021/03/04 06:13:02 INFO : potato3: Moved (server-side) 2021/03/04 06:13:02 INFO : potato3: Moved (server-side) 2021/03/04 06:13:02 INFO : potato2: Moved (server-side) 2021/03/04 06:13:02 DEBUG : tomatoDir: Removing directory 2021/03/04 06:13:02 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': deleted 1 directories 2021/03/04 06:13:02 INFO : There was nothing to transfer 2021/03/04 06:13:02 DEBUG : Creating backend with remote "TestChunkerOverCrypt:rclone-test-yeduzis0gagopuv1honirok1" 2021/03/04 06:13:02 DEBUG : Creating backend with remote "__TestChunkerOverCrypt:rclone-test-yeduzis0gagopuv1honirok1" 2021/03/04 06:13:02 DEBUG : Creating backend with remote "/tmp/test_chunker_over_crypt/lb50enfmrbovpionon7d7k5eqtlcq76e0t44h01dahmj1u98ocr0ba2tcpisuviio1lvu8m0tk356" 2021/03/04 06:13:02 DEBUG : Reset feature "ListR" 2021/03/04 06:13:02 DEBUG : tomatoDir: Making directory 2021/03/04 06:13:02 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-yeduzis0gagopuv1honirok1': Using server-side directory move 2021/03/04 06:13:02 INFO : Chunked 'TestChunkerOverCrypt:rclone-test-yeduzis0gagopuv1honirok1': Server side directory move succeeded 2021/03/04 06:13:02 ERROR : : error listing: directory not found 2021/03/04 06:13:02 ERROR : : error listing: directory not found 2021/03/04 06:13:02 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-yeduzis0gagopuv1honirok1': Purge remote 2021/03/04 06:13:02 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-tijeron5gafefuz6tamuduw0': Purge remote 2021/03/04 06:13:02 purge failed: directory not found --- PASS: TestServerSideMoveDeleteEmptySourceDirs (1.10s) === RUN TestServerSideMoveOverlap run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" sync_test.go:1430: Skipping test as remote supports DirMove --- SKIP: TestServerSideMoveOverlap (0.00s) === RUN TestSyncOverlap run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:13:02 DEBUG : Creating backend with remote "TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/rclone-sync-test" 2021/03/04 06:13:02 DEBUG : Creating backend with remote "__TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/rclone-sync-test" 2021/03/04 06:13:02 DEBUG : Creating backend with remote "/tmp/test_chunker_over_crypt/6ljl5nt4bm5fjkpo68k4sp9kvqpi88n6liu075orrmrr0j4piocvhri86l7f9gh0j3kltfmnih420/0kji1l44g89hp20dijrue5bugvdmdnsgj3kfrnt75fkt5gqolp9g" 2021/03/04 06:13:02 DEBUG : Reset feature "ListR" --- PASS: TestSyncOverlap (0.14s) === RUN TestSyncCompareDest run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:13:02 DEBUG : Creating backend with remote "TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst" 2021/03/04 06:13:02 DEBUG : Creating backend with remote "__TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst" 2021/03/04 06:13:02 DEBUG : Creating backend with remote "/tmp/test_chunker_over_crypt/6ljl5nt4bm5fjkpo68k4sp9kvqpi88n6liu075orrmrr0j4piocvhri86l7f9gh0j3kltfmnih420/mo3p16vesn7ioqbi95iir4gt5g" 2021/03/04 06:13:02 DEBUG : Reset feature "ListR" 2021/03/04 06:13:02 DEBUG : Creating backend with remote "TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/CompareDest" 2021/03/04 06:13:02 DEBUG : Creating backend with remote "__TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/CompareDest" 2021/03/04 06:13:03 DEBUG : Creating backend with remote "/tmp/test_chunker_over_crypt/6ljl5nt4bm5fjkpo68k4sp9kvqpi88n6liu075orrmrr0j4piocvhri86l7f9gh0j3kltfmnih420/fcu437f1ephh64b8cv237u29t4" 2021/03/04 06:13:03 DEBUG : Reset feature "ListR" 2021/03/04 06:13:03 DEBUG : one: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:13:03 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst': Waiting for checks to finish 2021/03/04 06:13:03 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst': Waiting for transfers to finish 2021/03/04 06:13:03 INFO : one.rcc.001_fqgm10: Moved (server-side) to: one 2021/03/04 06:13:03 INFO : one: Copied (new) 2021/03/04 06:13:03 DEBUG : Waiting for deletions to finish 2021/03/04 06:13:03 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst': Waiting for checks to finish 2021/03/04 06:13:03 DEBUG : one: Sizes differ (src 5 vs dst 3) 2021/03/04 06:13:03 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst': Waiting for transfers to finish 2021/03/04 06:13:03 DEBUG : one: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:13:03 INFO : one.rcc.001_fqgm78: Moved (server-side) to: one.rcc.001 2021/03/04 06:13:03 INFO : one.rcc.002_fqgm78: Moved (server-side) to: one.rcc.002 2021/03/04 06:13:03 INFO : one: Copied (replaced existing) 2021/03/04 06:13:03 DEBUG : Waiting for deletions to finish 2021/03/04 06:13:03 INFO : dst/one: Deleted 2021/03/04 06:13:03 INFO : dst/one.rcc.001_fqgmye: Moved (server-side) to: dst/one 2021/03/04 06:13:03 INFO : CompareDest/one.rcc.001_fqgmry: Moved (server-side) to: CompareDest/one.rcc.001 2021/03/04 06:13:03 INFO : CompareDest/one.rcc.002_fqgmry: Moved (server-side) to: CompareDest/one.rcc.002 2021/03/04 06:13:03 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:13:03 DEBUG : one: Destination found in --compare-dest, skipping 2021/03/04 06:13:03 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst': Waiting for checks to finish 2021/03/04 06:13:03 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst': Waiting for transfers to finish 2021/03/04 06:13:03 DEBUG : Waiting for deletions to finish 2021/03/04 06:13:03 INFO : There was nothing to transfer 2021/03/04 06:13:03 INFO : CompareDest/two.rcc.001_fqgm5c: Moved (server-side) to: CompareDest/two 2021/03/04 06:13:03 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:13:03 DEBUG : two: Destination found in --compare-dest, skipping 2021/03/04 06:13:03 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:13:03 DEBUG : one: Destination found in --compare-dest, skipping 2021/03/04 06:13:03 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst': Waiting for checks to finish 2021/03/04 06:13:03 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst': Waiting for transfers to finish 2021/03/04 06:13:03 DEBUG : Waiting for deletions to finish 2021/03/04 06:13:03 INFO : There was nothing to transfer 2021/03/04 06:13:03 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:13:03 DEBUG : two: Destination found in --compare-dest, skipping 2021/03/04 06:13:03 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst': Waiting for checks to finish 2021/03/04 06:13:03 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:13:03 DEBUG : one: Destination found in --compare-dest, skipping 2021/03/04 06:13:03 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst': Waiting for transfers to finish 2021/03/04 06:13:03 DEBUG : Waiting for deletions to finish 2021/03/04 06:13:03 INFO : There was nothing to transfer 2021/03/04 06:13:03 DEBUG : two: Sizes differ (src 5 vs dst 3) 2021/03/04 06:13:03 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:13:03 DEBUG : one: Destination found in --compare-dest, skipping 2021/03/04 06:13:03 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst': Waiting for checks to finish 2021/03/04 06:13:03 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst': Waiting for transfers to finish 2021/03/04 06:13:03 DEBUG : two: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:13:03 INFO : two.rcc.001_fqgmfh: Moved (server-side) to: two.rcc.001 2021/03/04 06:13:03 INFO : two.rcc.002_fqgmfh: Moved (server-side) to: two.rcc.002 2021/03/04 06:13:03 INFO : two: Copied (new) 2021/03/04 06:13:03 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCompareDest (0.41s) === RUN TestSyncMultipleCompareDest run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:13:03 INFO : pre-dest1/1.rcc.001_fqgmwx: Moved (server-side) to: pre-dest1/1 2021/03/04 06:13:03 INFO : pre-dest2/2.rcc.001_fqgmec: Moved (server-side) to: pre-dest2/2 2021/03/04 06:13:03 DEBUG : Creating backend with remote "TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dest" 2021/03/04 06:13:03 DEBUG : Creating backend with remote "__TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dest" 2021/03/04 06:13:03 DEBUG : Creating backend with remote "/tmp/test_chunker_over_crypt/6ljl5nt4bm5fjkpo68k4sp9kvqpi88n6liu075orrmrr0j4piocvhri86l7f9gh0j3kltfmnih420/0na9j9v8qd02gospsl4qad4d2c" 2021/03/04 06:13:03 DEBUG : Reset feature "ListR" 2021/03/04 06:13:03 DEBUG : Creating backend with remote "TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/pre-dest1" 2021/03/04 06:13:03 DEBUG : Creating backend with remote "__TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/pre-dest1" 2021/03/04 06:13:03 DEBUG : Creating backend with remote "/tmp/test_chunker_over_crypt/6ljl5nt4bm5fjkpo68k4sp9kvqpi88n6liu075orrmrr0j4piocvhri86l7f9gh0j3kltfmnih420/puq6ljvda69ueq7v3a16pqbqgo" 2021/03/04 06:13:03 DEBUG : Reset feature "ListR" 2021/03/04 06:13:03 DEBUG : Creating backend with remote "TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/pre-dest2" 2021/03/04 06:13:03 DEBUG : Creating backend with remote "__TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/pre-dest2" 2021/03/04 06:13:03 DEBUG : Creating backend with remote "/tmp/test_chunker_over_crypt/6ljl5nt4bm5fjkpo68k4sp9kvqpi88n6liu075orrmrr0j4piocvhri86l7f9gh0j3kltfmnih420/0v83beu90ap6a4em88hf7dufv0" 2021/03/04 06:13:03 DEBUG : Reset feature "ListR" 2021/03/04 06:13:03 DEBUG : 1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:13:03 DEBUG : 1: Destination found in --compare-dest, skipping 2021/03/04 06:13:03 DEBUG : 2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:13:03 DEBUG : 2: Destination found in --compare-dest, skipping 2021/03/04 06:13:03 DEBUG : 3: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:13:03 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dest': Waiting for checks to finish 2021/03/04 06:13:03 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dest': Waiting for transfers to finish 2021/03/04 06:13:03 INFO : 3.rcc.001_fqgmbc: Moved (server-side) to: 3 2021/03/04 06:13:03 INFO : 3: Copied (new) 2021/03/04 06:13:03 DEBUG : Waiting for deletions to finish --- PASS: TestSyncMultipleCompareDest (0.52s) === RUN TestSyncCopyDest run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" sync_test.go:1607: Skipping test as remote does not support server-side copy --- SKIP: TestSyncCopyDest (0.00s) === RUN TestSyncBackupDir run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:13:03 INFO : dst/one.rcc.001_fqgm6q: Moved (server-side) to: dst/one 2021/03/04 06:13:03 INFO : dst/two.rcc.001_fqgmeh: Moved (server-side) to: dst/two 2021/03/04 06:13:03 INFO : dst/three.txt.rcc.001_fqgmkv: Moved (server-side) to: dst/three.txt.rcc.001 2021/03/04 06:13:03 INFO : dst/three.txt.rcc.002_fqgmkv: Moved (server-side) to: dst/three.txt.rcc.002 2021/03/04 06:13:03 DEBUG : Creating backend with remote "TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst" 2021/03/04 06:13:03 DEBUG : Creating backend with remote "__TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst" 2021/03/04 06:13:03 DEBUG : Creating backend with remote "/tmp/test_chunker_over_crypt/6ljl5nt4bm5fjkpo68k4sp9kvqpi88n6liu075orrmrr0j4piocvhri86l7f9gh0j3kltfmnih420/mo3p16vesn7ioqbi95iir4gt5g" 2021/03/04 06:13:03 DEBUG : Reset feature "ListR" 2021/03/04 06:13:03 DEBUG : Creating backend with remote "TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/backup" 2021/03/04 06:13:03 DEBUG : Creating backend with remote "__TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/backup" 2021/03/04 06:13:03 DEBUG : Creating backend with remote "/tmp/test_chunker_over_crypt/6ljl5nt4bm5fjkpo68k4sp9kvqpi88n6liu075orrmrr0j4piocvhri86l7f9gh0j3kltfmnih420/nb8t2lplr4nd5op5pmtnoafv18" 2021/03/04 06:13:03 DEBUG : Reset feature "ListR" 2021/03/04 06:13:03 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:13:03 DEBUG : two: Unchanged skipping 2021/03/04 06:13:03 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst': Waiting for checks to finish 2021/03/04 06:13:03 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/03/04 06:13:03 DEBUG : one: move non-chunked object... 2021/03/04 06:13:03 INFO : one: Moved (server-side) 2021/03/04 06:13:03 INFO : one: Moved (server-side) 2021/03/04 06:13:03 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst': Waiting for transfers to finish 2021/03/04 06:13:03 DEBUG : one: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:13:03 INFO : one.rcc.001_fqgmwx: Moved (server-side) to: one.rcc.001 2021/03/04 06:13:03 INFO : one.rcc.002_fqgmwx: Moved (server-side) to: one.rcc.002 2021/03/04 06:13:03 INFO : one: Copied (new) 2021/03/04 06:13:03 DEBUG : Waiting for deletions to finish 2021/03/04 06:13:03 DEBUG : three.txt: move 2 data chunks... 2021/03/04 06:13:03 INFO : three.txt.rcc.001: Moved (server-side) 2021/03/04 06:13:03 INFO : three.txt.rcc.002: Moved (server-side) 2021/03/04 06:13:03 INFO : three.txt: Moved (server-side) 2021/03/04 06:13:03 INFO : three.txt: Moved (server-side) 2021/03/04 06:13:03 INFO : three.txt: Moved into backup dir 2021/03/04 06:13:03 INFO : dst/three.txt.rcc.001_fqgml4: Moved (server-side) to: dst/three.txt.rcc.001 2021/03/04 06:13:03 INFO : dst/three.txt.rcc.002_fqgml4: Moved (server-side) to: dst/three.txt.rcc.002 2021/03/04 06:13:03 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst': Waiting for checks to finish 2021/03/04 06:13:03 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/03/04 06:13:03 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:13:03 DEBUG : two: Unchanged skipping 2021/03/04 06:13:03 INFO : one: Deleted 2021/03/04 06:13:03 DEBUG : one: move 2 data chunks... 2021/03/04 06:13:03 INFO : one.rcc.001: Moved (server-side) 2021/03/04 06:13:03 INFO : one.rcc.002: Moved (server-side) 2021/03/04 06:13:03 INFO : one: Moved (server-side) 2021/03/04 06:13:03 INFO : one: Moved (server-side) 2021/03/04 06:13:03 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst': Waiting for transfers to finish 2021/03/04 06:13:03 DEBUG : one: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:13:03 INFO : one.rcc.001_fqgmfl: Moved (server-side) to: one.rcc.001 2021/03/04 06:13:03 INFO : one.rcc.002_fqgmfl: Moved (server-side) to: one.rcc.002 2021/03/04 06:13:03 INFO : one: Copied (new) 2021/03/04 06:13:03 DEBUG : Waiting for deletions to finish 2021/03/04 06:13:03 INFO : three.txt: Deleted 2021/03/04 06:13:03 DEBUG : three.txt: move 2 data chunks... 2021/03/04 06:13:03 INFO : three.txt.rcc.001: Moved (server-side) 2021/03/04 06:13:03 INFO : three.txt.rcc.002: Moved (server-side) 2021/03/04 06:13:03 INFO : three.txt: Moved (server-side) 2021/03/04 06:13:04 INFO : three.txt: Moved (server-side) 2021/03/04 06:13:04 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDir (0.70s) === RUN TestSyncBackupDirWithSuffix run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:13:04 INFO : dst/one.rcc.001_fqgnb7: Moved (server-side) to: dst/one 2021/03/04 06:13:04 INFO : dst/two.rcc.001_fqgnn7: Moved (server-side) to: dst/two 2021/03/04 06:13:04 INFO : dst/three.txt.rcc.001_fqgnoi: Moved (server-side) to: dst/three.txt.rcc.001 2021/03/04 06:13:04 INFO : dst/three.txt.rcc.002_fqgnoi: Moved (server-side) to: dst/three.txt.rcc.002 2021/03/04 06:13:04 DEBUG : Creating backend with remote "TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst" 2021/03/04 06:13:04 DEBUG : Creating backend with remote "__TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst" 2021/03/04 06:13:04 DEBUG : Creating backend with remote "/tmp/test_chunker_over_crypt/6ljl5nt4bm5fjkpo68k4sp9kvqpi88n6liu075orrmrr0j4piocvhri86l7f9gh0j3kltfmnih420/mo3p16vesn7ioqbi95iir4gt5g" 2021/03/04 06:13:04 DEBUG : Reset feature "ListR" 2021/03/04 06:13:04 DEBUG : Creating backend with remote "TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/backup" 2021/03/04 06:13:04 DEBUG : Creating backend with remote "__TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/backup" 2021/03/04 06:13:04 DEBUG : Creating backend with remote "/tmp/test_chunker_over_crypt/6ljl5nt4bm5fjkpo68k4sp9kvqpi88n6liu075orrmrr0j4piocvhri86l7f9gh0j3kltfmnih420/nb8t2lplr4nd5op5pmtnoafv18" 2021/03/04 06:13:04 DEBUG : Reset feature "ListR" 2021/03/04 06:13:04 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/03/04 06:13:04 DEBUG : one: move non-chunked object... 2021/03/04 06:13:04 INFO : one: Moved (server-side) to: one.bak 2021/03/04 06:13:04 INFO : one: Moved (server-side) to: one.bak 2021/03/04 06:13:04 DEBUG : one: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:13:04 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:13:04 DEBUG : two: Unchanged skipping 2021/03/04 06:13:04 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst': Waiting for checks to finish 2021/03/04 06:13:04 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst': Waiting for transfers to finish 2021/03/04 06:13:04 INFO : one.rcc.001_fqgnuj: Moved (server-side) to: one.rcc.001 2021/03/04 06:13:04 INFO : one.rcc.002_fqgnuj: Moved (server-side) to: one.rcc.002 2021/03/04 06:13:04 INFO : one: Copied (new) 2021/03/04 06:13:04 DEBUG : Waiting for deletions to finish 2021/03/04 06:13:04 DEBUG : three.txt: move 2 data chunks... 2021/03/04 06:13:04 INFO : three.txt.rcc.001: Moved (server-side) to: three.txt.bak.rcc.001 2021/03/04 06:13:04 INFO : three.txt.rcc.002: Moved (server-side) to: three.txt.bak.rcc.002 2021/03/04 06:13:04 INFO : three.txt: Moved (server-side) to: three.txt.bak 2021/03/04 06:13:04 INFO : three.txt: Moved (server-side) to: three.txt.bak 2021/03/04 06:13:04 INFO : three.txt: Moved into backup dir 2021/03/04 06:13:04 INFO : dst/three.txt.rcc.001_fqgnpq: Moved (server-side) to: dst/three.txt.rcc.001 2021/03/04 06:13:04 INFO : dst/three.txt.rcc.002_fqgnpq: Moved (server-side) to: dst/three.txt.rcc.002 2021/03/04 06:13:04 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/03/04 06:13:04 INFO : one.bak: Deleted 2021/03/04 06:13:04 DEBUG : one: move 2 data chunks... 2021/03/04 06:13:04 INFO : one.rcc.001: Moved (server-side) to: one.bak.rcc.001 2021/03/04 06:13:04 INFO : one.rcc.002: Moved (server-side) to: one.bak.rcc.002 2021/03/04 06:13:04 INFO : one: Moved (server-side) to: one.bak 2021/03/04 06:13:04 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:13:04 DEBUG : two: Unchanged skipping 2021/03/04 06:13:04 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst': Waiting for checks to finish 2021/03/04 06:13:04 INFO : one: Moved (server-side) to: one.bak 2021/03/04 06:13:04 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst': Waiting for transfers to finish 2021/03/04 06:13:04 DEBUG : one: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:13:04 INFO : one.rcc.001_fqgnd3: Moved (server-side) to: one.rcc.001 2021/03/04 06:13:04 INFO : one.rcc.002_fqgnd3: Moved (server-side) to: one.rcc.002 2021/03/04 06:13:04 INFO : one: Copied (new) 2021/03/04 06:13:04 DEBUG : Waiting for deletions to finish 2021/03/04 06:13:04 INFO : three.txt.bak: Deleted 2021/03/04 06:13:04 DEBUG : three.txt: move 2 data chunks... 2021/03/04 06:13:04 INFO : three.txt.rcc.001: Moved (server-side) to: three.txt.bak.rcc.001 2021/03/04 06:13:04 INFO : three.txt.rcc.002: Moved (server-side) to: three.txt.bak.rcc.002 2021/03/04 06:13:04 INFO : three.txt: Moved (server-side) to: three.txt.bak 2021/03/04 06:13:04 INFO : three.txt: Moved (server-side) to: three.txt.bak 2021/03/04 06:13:04 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffix (0.34s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:13:04 INFO : dst/one.rcc.001_fqgnt0: Moved (server-side) to: dst/one 2021/03/04 06:13:04 INFO : dst/two.rcc.001_fqgn92: Moved (server-side) to: dst/two 2021/03/04 06:13:04 INFO : dst/three.txt.rcc.001_fqgn1o: Moved (server-side) to: dst/three.txt.rcc.001 2021/03/04 06:13:04 INFO : dst/three.txt.rcc.002_fqgn1o: Moved (server-side) to: dst/three.txt.rcc.002 2021/03/04 06:13:04 DEBUG : Creating backend with remote "TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst" 2021/03/04 06:13:04 DEBUG : Creating backend with remote "__TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst" 2021/03/04 06:13:04 DEBUG : Creating backend with remote "/tmp/test_chunker_over_crypt/6ljl5nt4bm5fjkpo68k4sp9kvqpi88n6liu075orrmrr0j4piocvhri86l7f9gh0j3kltfmnih420/mo3p16vesn7ioqbi95iir4gt5g" 2021/03/04 06:13:04 DEBUG : Reset feature "ListR" 2021/03/04 06:13:04 DEBUG : Creating backend with remote "TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/backup" 2021/03/04 06:13:04 DEBUG : Creating backend with remote "__TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/backup" 2021/03/04 06:13:04 DEBUG : Creating backend with remote "/tmp/test_chunker_over_crypt/6ljl5nt4bm5fjkpo68k4sp9kvqpi88n6liu075orrmrr0j4piocvhri86l7f9gh0j3kltfmnih420/nb8t2lplr4nd5op5pmtnoafv18" 2021/03/04 06:13:04 DEBUG : Reset feature "ListR" 2021/03/04 06:13:04 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/03/04 06:13:04 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst': Waiting for checks to finish 2021/03/04 06:13:04 DEBUG : one: move non-chunked object... 2021/03/04 06:13:04 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:13:04 DEBUG : two: Unchanged skipping 2021/03/04 06:13:04 INFO : one: Moved (server-side) to: one-2019-01-01 2021/03/04 06:13:04 INFO : one: Moved (server-side) to: one-2019-01-01 2021/03/04 06:13:04 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst': Waiting for transfers to finish 2021/03/04 06:13:04 DEBUG : one: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:13:04 INFO : one.rcc.001_fqgnuq: Moved (server-side) to: one.rcc.001 2021/03/04 06:13:04 INFO : one.rcc.002_fqgnuq: Moved (server-side) to: one.rcc.002 2021/03/04 06:13:04 INFO : one: Copied (new) 2021/03/04 06:13:04 DEBUG : Waiting for deletions to finish 2021/03/04 06:13:04 DEBUG : three.txt: move 2 data chunks... 2021/03/04 06:13:04 INFO : three.txt.rcc.001: Moved (server-side) to: three-2019-01-01.txt.rcc.001 2021/03/04 06:13:04 INFO : three.txt.rcc.002: Moved (server-side) to: three-2019-01-01.txt.rcc.002 2021/03/04 06:13:04 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2021/03/04 06:13:04 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2021/03/04 06:13:04 INFO : three.txt: Moved into backup dir 2021/03/04 06:13:04 INFO : dst/three.txt.rcc.001_fqgngp: Moved (server-side) to: dst/three.txt.rcc.001 2021/03/04 06:13:04 INFO : dst/three.txt.rcc.002_fqgngp: Moved (server-side) to: dst/three.txt.rcc.002 2021/03/04 06:13:04 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/03/04 06:13:04 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:13:04 DEBUG : two: Unchanged skipping 2021/03/04 06:13:04 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst': Waiting for checks to finish 2021/03/04 06:13:04 INFO : one-2019-01-01: Deleted 2021/03/04 06:13:04 DEBUG : one: move 2 data chunks... 2021/03/04 06:13:04 INFO : one.rcc.001: Moved (server-side) to: one-2019-01-01.rcc.001 2021/03/04 06:13:04 INFO : one.rcc.002: Moved (server-side) to: one-2019-01-01.rcc.002 2021/03/04 06:13:04 INFO : one: Moved (server-side) to: one-2019-01-01 2021/03/04 06:13:05 INFO : one: Moved (server-side) to: one-2019-01-01 2021/03/04 06:13:05 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst': Waiting for transfers to finish 2021/03/04 06:13:05 DEBUG : one: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:13:05 INFO : one.rcc.001_fqgo3f: Moved (server-side) to: one.rcc.001 2021/03/04 06:13:05 INFO : one.rcc.002_fqgo3f: Moved (server-side) to: one.rcc.002 2021/03/04 06:13:05 INFO : one: Copied (new) 2021/03/04 06:13:05 DEBUG : Waiting for deletions to finish 2021/03/04 06:13:05 INFO : three-2019-01-01.txt: Deleted 2021/03/04 06:13:05 DEBUG : three.txt: move 2 data chunks... 2021/03/04 06:13:05 INFO : three.txt.rcc.001: Moved (server-side) to: three-2019-01-01.txt.rcc.001 2021/03/04 06:13:05 INFO : three.txt.rcc.002: Moved (server-side) to: three-2019-01-01.txt.rcc.002 2021/03/04 06:13:05 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2021/03/04 06:13:05 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2021/03/04 06:13:05 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffixKeepExtension (1.65s) === RUN TestSyncBackupDirSuffixOnly run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:13:06 INFO : dst/one.rcc.001_fqgpwb: Moved (server-side) to: dst/one 2021/03/04 06:13:06 INFO : dst/two.rcc.001_fqgprl: Moved (server-side) to: dst/two 2021/03/04 06:13:06 INFO : dst/three.txt.rcc.001_fqgpxm: Moved (server-side) to: dst/three.txt.rcc.001 2021/03/04 06:13:06 INFO : dst/three.txt.rcc.002_fqgpxm: Moved (server-side) to: dst/three.txt.rcc.002 2021/03/04 06:13:06 DEBUG : Creating backend with remote "TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst" 2021/03/04 06:13:06 DEBUG : Creating backend with remote "__TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst" 2021/03/04 06:13:06 DEBUG : Creating backend with remote "/tmp/test_chunker_over_crypt/6ljl5nt4bm5fjkpo68k4sp9kvqpi88n6liu075orrmrr0j4piocvhri86l7f9gh0j3kltfmnih420/mo3p16vesn7ioqbi95iir4gt5g" 2021/03/04 06:13:06 DEBUG : Reset feature "ListR" 2021/03/04 06:13:06 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/03/04 06:13:06 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:13:06 DEBUG : two: Unchanged skipping 2021/03/04 06:13:06 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst': Waiting for checks to finish 2021/03/04 06:13:06 DEBUG : one: move non-chunked object... 2021/03/04 06:13:06 INFO : one: Moved (server-side) to: one.bak 2021/03/04 06:13:06 INFO : one: Moved (server-side) to: one.bak 2021/03/04 06:13:06 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst': Waiting for transfers to finish 2021/03/04 06:13:06 DEBUG : one: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:13:06 INFO : one.rcc.001_fqgpdz: Moved (server-side) to: one.rcc.001 2021/03/04 06:13:06 INFO : one.rcc.002_fqgpdz: Moved (server-side) to: one.rcc.002 2021/03/04 06:13:06 INFO : one: Copied (new) 2021/03/04 06:13:06 DEBUG : Waiting for deletions to finish 2021/03/04 06:13:06 DEBUG : three.txt: move 2 data chunks... 2021/03/04 06:13:06 INFO : three.txt.rcc.001: Moved (server-side) to: three.txt.bak.rcc.001 2021/03/04 06:13:06 INFO : three.txt.rcc.002: Moved (server-side) to: three.txt.bak.rcc.002 2021/03/04 06:13:06 INFO : three.txt: Moved (server-side) to: three.txt.bak 2021/03/04 06:13:06 INFO : three.txt: Moved (server-side) to: three.txt.bak 2021/03/04 06:13:06 INFO : three.txt: Moved into backup dir 2021/03/04 06:13:06 INFO : dst/three.txt.rcc.001_fqgp81: Moved (server-side) to: dst/three.txt.rcc.001 2021/03/04 06:13:06 INFO : dst/three.txt.rcc.002_fqgp81: Moved (server-side) to: dst/three.txt.rcc.002 2021/03/04 06:13:06 DEBUG : one.bak: Excluded 2021/03/04 06:13:06 DEBUG : three.txt.bak: Excluded 2021/03/04 06:13:06 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/03/04 06:13:06 INFO : one.bak: Deleted 2021/03/04 06:13:06 DEBUG : one: move 2 data chunks... 2021/03/04 06:13:06 INFO : one.rcc.001: Moved (server-side) to: one.bak.rcc.001 2021/03/04 06:13:06 INFO : one.rcc.002: Moved (server-side) to: one.bak.rcc.002 2021/03/04 06:13:06 INFO : one: Moved (server-side) to: one.bak 2021/03/04 06:13:06 INFO : one: Moved (server-side) to: one.bak 2021/03/04 06:13:06 DEBUG : one: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:13:06 INFO : one.rcc.001_fqgp1f: Moved (server-side) to: one.rcc.001 2021/03/04 06:13:06 INFO : one.rcc.002_fqgp1f: Moved (server-side) to: one.rcc.002 2021/03/04 06:13:06 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:13:06 DEBUG : two: Unchanged skipping 2021/03/04 06:13:06 INFO : one: Copied (new) 2021/03/04 06:13:06 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst': Waiting for checks to finish 2021/03/04 06:13:06 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst': Waiting for transfers to finish 2021/03/04 06:13:06 DEBUG : Waiting for deletions to finish 2021/03/04 06:13:06 INFO : three.txt.bak: Deleted 2021/03/04 06:13:06 DEBUG : three.txt: move 2 data chunks... 2021/03/04 06:13:06 INFO : three.txt.rcc.001: Moved (server-side) to: three.txt.bak.rcc.001 2021/03/04 06:13:06 INFO : three.txt.rcc.002: Moved (server-side) to: three.txt.bak.rcc.002 2021/03/04 06:13:06 INFO : three.txt: Moved (server-side) to: three.txt.bak 2021/03/04 06:13:07 INFO : three.txt: Moved (server-side) to: three.txt.bak 2021/03/04 06:13:07 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirSuffixOnly (0.94s) === RUN TestSyncSuffix run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:13:07 INFO : dst/one.rcc.001_fqgqwp: Moved (server-side) to: dst/one 2021/03/04 06:13:07 INFO : dst/two.rcc.001_fqgquw: Moved (server-side) to: dst/two 2021/03/04 06:13:07 INFO : dst/three.txt.rcc.001_fqgqn9: Moved (server-side) to: dst/three.txt.rcc.001 2021/03/04 06:13:07 INFO : dst/three.txt.rcc.002_fqgqn9: Moved (server-side) to: dst/three.txt.rcc.002 2021/03/04 06:13:07 DEBUG : Creating backend with remote "TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst" 2021/03/04 06:13:07 DEBUG : Creating backend with remote "__TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst" 2021/03/04 06:13:07 DEBUG : Creating backend with remote "/tmp/test_chunker_over_crypt/6ljl5nt4bm5fjkpo68k4sp9kvqpi88n6liu075orrmrr0j4piocvhri86l7f9gh0j3kltfmnih420/mo3p16vesn7ioqbi95iir4gt5g" 2021/03/04 06:13:07 DEBUG : Reset feature "ListR" 2021/03/04 06:13:07 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/03/04 06:13:07 DEBUG : one: move non-chunked object... 2021/03/04 06:13:07 INFO : one: Moved (server-side) to: one.bak 2021/03/04 06:13:07 INFO : one: Moved (server-side) to: one.bak 2021/03/04 06:13:07 DEBUG : one: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:13:07 INFO : one.rcc.001_fqgq1u: Moved (server-side) to: one.rcc.001 2021/03/04 06:13:07 INFO : one.rcc.002_fqgq1u: Moved (server-side) to: one.rcc.002 2021/03/04 06:13:07 INFO : one: Copied (new) 2021/03/04 06:13:07 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:13:07 DEBUG : two: Unchanged skipping 2021/03/04 06:13:07 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2021/03/04 06:13:07 DEBUG : three.txt: move 2 data chunks... 2021/03/04 06:13:07 INFO : three.txt.rcc.001: Moved (server-side) to: three.txt.bak.rcc.001 2021/03/04 06:13:07 INFO : three.txt.rcc.002: Moved (server-side) to: three.txt.bak.rcc.002 2021/03/04 06:13:07 INFO : three.txt: Moved (server-side) to: three.txt.bak 2021/03/04 06:13:07 INFO : three.txt: Moved (server-side) to: three.txt.bak 2021/03/04 06:13:07 DEBUG : three.txt: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:13:07 INFO : three.txt.rcc.001_fqgq1c: Moved (server-side) to: three.txt.rcc.001 2021/03/04 06:13:07 INFO : three.txt.rcc.002_fqgq1c: Moved (server-side) to: three.txt.rcc.002 2021/03/04 06:13:07 INFO : three.txt: Copied (new) 2021/03/04 06:13:07 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/03/04 06:13:07 INFO : one.bak: Deleted 2021/03/04 06:13:07 DEBUG : one: move 2 data chunks... 2021/03/04 06:13:07 INFO : one.rcc.001: Moved (server-side) to: one.bak.rcc.001 2021/03/04 06:13:07 INFO : one.rcc.002: Moved (server-side) to: one.bak.rcc.002 2021/03/04 06:13:07 INFO : one: Moved (server-side) to: one.bak 2021/03/04 06:13:07 INFO : one: Moved (server-side) to: one.bak 2021/03/04 06:13:07 DEBUG : one: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:13:07 INFO : one.rcc.001_fqgq63: Moved (server-side) to: one.rcc.001 2021/03/04 06:13:07 INFO : one.rcc.002_fqgq63: Moved (server-side) to: one.rcc.002 2021/03/04 06:13:07 INFO : one: Copied (new) 2021/03/04 06:13:07 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:13:07 DEBUG : two: Unchanged skipping 2021/03/04 06:13:07 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2021/03/04 06:13:07 INFO : three.txt.bak: Deleted 2021/03/04 06:13:07 DEBUG : three.txt: move 2 data chunks... 2021/03/04 06:13:07 INFO : three.txt.rcc.001: Moved (server-side) to: three.txt.bak.rcc.001 2021/03/04 06:13:07 INFO : three.txt.rcc.002: Moved (server-side) to: three.txt.bak.rcc.002 2021/03/04 06:13:07 INFO : three.txt: Moved (server-side) to: three.txt.bak 2021/03/04 06:13:07 INFO : three.txt: Moved (server-side) to: three.txt.bak 2021/03/04 06:13:07 DEBUG : three.txt: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:13:07 INFO : three.txt.rcc.001_fqgqxo: Moved (server-side) to: three.txt.rcc.001 2021/03/04 06:13:07 INFO : three.txt.rcc.002_fqgqxo: Moved (server-side) to: three.txt.rcc.002 2021/03/04 06:13:07 INFO : three.txt.rcc.003_fqgqxo: Moved (server-side) to: three.txt.rcc.003 2021/03/04 06:13:07 INFO : three.txt.rcc.004_fqgqxo: Moved (server-side) to: three.txt.rcc.004 2021/03/04 06:13:07 INFO : three.txt.rcc.005_fqgqxo: Moved (server-side) to: three.txt.rcc.005 2021/03/04 06:13:07 INFO : three.txt.rcc.006_fqgqxo: Moved (server-side) to: three.txt.rcc.006 2021/03/04 06:13:07 INFO : three.txt.rcc.007_fqgqxo: Moved (server-side) to: three.txt.rcc.007 2021/03/04 06:13:07 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (0.16s) === RUN TestSyncSuffixKeepExtension run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:13:07 INFO : dst/one.rcc.001_fqgqtl: Moved (server-side) to: dst/one 2021/03/04 06:13:07 INFO : dst/two.rcc.001_fqgqm0: Moved (server-side) to: dst/two 2021/03/04 06:13:07 INFO : dst/three.txt.rcc.001_fqgqid: Moved (server-side) to: dst/three.txt.rcc.001 2021/03/04 06:13:07 INFO : dst/three.txt.rcc.002_fqgqid: Moved (server-side) to: dst/three.txt.rcc.002 2021/03/04 06:13:07 DEBUG : Creating backend with remote "TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst" 2021/03/04 06:13:07 DEBUG : Creating backend with remote "__TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0/dst" 2021/03/04 06:13:07 DEBUG : Creating backend with remote "/tmp/test_chunker_over_crypt/6ljl5nt4bm5fjkpo68k4sp9kvqpi88n6liu075orrmrr0j4piocvhri86l7f9gh0j3kltfmnih420/mo3p16vesn7ioqbi95iir4gt5g" 2021/03/04 06:13:07 DEBUG : Reset feature "ListR" 2021/03/04 06:13:07 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/03/04 06:13:07 DEBUG : one: move non-chunked object... 2021/03/04 06:13:07 INFO : one: Moved (server-side) to: one-2019-01-01 2021/03/04 06:13:07 INFO : one: Moved (server-side) to: one-2019-01-01 2021/03/04 06:13:07 DEBUG : one: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:13:07 INFO : one.rcc.001_fqgqrc: Moved (server-side) to: one.rcc.001 2021/03/04 06:13:07 INFO : one.rcc.002_fqgqrc: Moved (server-side) to: one.rcc.002 2021/03/04 06:13:07 INFO : one: Copied (new) 2021/03/04 06:13:07 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:13:07 DEBUG : two: Unchanged skipping 2021/03/04 06:13:07 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2021/03/04 06:13:07 DEBUG : three.txt: move 2 data chunks... 2021/03/04 06:13:07 INFO : three.txt.rcc.001: Moved (server-side) to: three-2019-01-01.txt.rcc.001 2021/03/04 06:13:07 INFO : three.txt.rcc.002: Moved (server-side) to: three-2019-01-01.txt.rcc.002 2021/03/04 06:13:07 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2021/03/04 06:13:07 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2021/03/04 06:13:07 DEBUG : three.txt: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:13:07 INFO : three.txt.rcc.001_fqgqig: Moved (server-side) to: three.txt.rcc.001 2021/03/04 06:13:07 INFO : three.txt.rcc.002_fqgqig: Moved (server-side) to: three.txt.rcc.002 2021/03/04 06:13:07 INFO : three.txt: Copied (new) 2021/03/04 06:13:07 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/03/04 06:13:07 INFO : one-2019-01-01: Deleted 2021/03/04 06:13:07 DEBUG : one: move 2 data chunks... 2021/03/04 06:13:07 INFO : one.rcc.001: Moved (server-side) to: one-2019-01-01.rcc.001 2021/03/04 06:13:07 INFO : one.rcc.002: Moved (server-side) to: one-2019-01-01.rcc.002 2021/03/04 06:13:07 INFO : one: Moved (server-side) to: one-2019-01-01 2021/03/04 06:13:07 INFO : one: Moved (server-side) to: one-2019-01-01 2021/03/04 06:13:07 DEBUG : one: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:13:07 INFO : one.rcc.001_fqgq50: Moved (server-side) to: one.rcc.001 2021/03/04 06:13:07 INFO : one.rcc.002_fqgq50: Moved (server-side) to: one.rcc.002 2021/03/04 06:13:07 INFO : one: Copied (new) 2021/03/04 06:13:07 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:13:07 DEBUG : two: Unchanged skipping 2021/03/04 06:13:07 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2021/03/04 06:13:07 INFO : three-2019-01-01.txt: Deleted 2021/03/04 06:13:07 DEBUG : three.txt: move 2 data chunks... 2021/03/04 06:13:07 INFO : three.txt.rcc.001: Moved (server-side) to: three-2019-01-01.txt.rcc.001 2021/03/04 06:13:07 INFO : three.txt.rcc.002: Moved (server-side) to: three-2019-01-01.txt.rcc.002 2021/03/04 06:13:07 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2021/03/04 06:13:07 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2021/03/04 06:13:07 DEBUG : three.txt: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:13:07 INFO : three.txt.rcc.001_fqgqb7: Moved (server-side) to: three.txt.rcc.001 2021/03/04 06:13:07 INFO : three.txt.rcc.002_fqgqb7: Moved (server-side) to: three.txt.rcc.002 2021/03/04 06:13:07 INFO : three.txt.rcc.003_fqgqb7: Moved (server-side) to: three.txt.rcc.003 2021/03/04 06:13:07 INFO : three.txt.rcc.004_fqgqb7: Moved (server-side) to: three.txt.rcc.004 2021/03/04 06:13:07 INFO : three.txt.rcc.005_fqgqb7: Moved (server-side) to: three.txt.rcc.005 2021/03/04 06:13:07 INFO : three.txt.rcc.006_fqgqb7: Moved (server-side) to: three.txt.rcc.006 2021/03/04 06:13:07 INFO : three.txt.rcc.007_fqgqb7: Moved (server-side) to: three.txt.rcc.007 2021/03/04 06:13:07 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffixKeepExtension (0.15s) === RUN TestSyncUTFNorm run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:13:07 INFO : Testêé.rcc.001_fqgqwu: Moved (server-side) to: Testêé.rcc.001 2021/03/04 06:13:07 INFO : Testêé.rcc.002_fqgqwu: Moved (server-side) to: Testêé.rcc.002 2021/03/04 06:13:07 INFO : Testêé.rcc.003_fqgqwu: Moved (server-side) to: Testêé.rcc.003 2021/03/04 06:13:07 INFO : Testêé.rcc.004_fqgqwu: Moved (server-side) to: Testêé.rcc.004 2021/03/04 06:13:07 INFO : Testêé.rcc.005_fqgqwu: Moved (server-side) to: Testêé.rcc.005 2021/03/04 06:13:07 INFO : Testêé.rcc.006_fqgqwu: Moved (server-side) to: Testêé.rcc.006 2021/03/04 06:13:07 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:13:07 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2021/03/04 06:13:07 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:13:07 DEBUG : Testêé: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:13:07 INFO : Testêé.rcc.001_fqgqos: Moved (server-side) to: Testêé.rcc.001 2021/03/04 06:13:07 INFO : Testêé.rcc.002_fqgqos: Moved (server-side) to: Testêé.rcc.002 2021/03/04 06:13:07 INFO : Testêé.rcc.003_fqgqos: Moved (server-side) to: Testêé.rcc.003 2021/03/04 06:13:07 INFO : Testêé.rcc.004_fqgqos: Moved (server-side) to: Testêé.rcc.004 2021/03/04 06:13:07 INFO : Testêé.rcc.005_fqgqos: Moved (server-side) to: Testêé.rcc.005 2021/03/04 06:13:07 INFO : Testêé: Copied (replaced existing) to: Testêé 2021/03/04 06:13:07 DEBUG : Waiting for deletions to finish --- PASS: TestSyncUTFNorm (0.03s) === RUN TestSyncImmutable run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:13:07 DEBUG : existing: skip slow SHA1 on source file, hashing in-transit 2021/03/04 06:13:07 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:13:07 INFO : existing.rcc.001_fqgqjx: Moved (server-side) to: existing.rcc.001 2021/03/04 06:13:07 INFO : existing.rcc.002_fqgqjx: Moved (server-side) to: existing.rcc.002 2021/03/04 06:13:07 INFO : existing: Copied (new) 2021/03/04 06:13:07 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:13:07 DEBUG : Waiting for deletions to finish 2021/03/04 06:13:07 DEBUG : existing: Sizes differ (src 8 vs dst 6) 2021/03/04 06:13:07 ERROR : existing: Source and destination exist but do not match: immutable file modified 2021/03/04 06:13:07 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:13:07 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:13:07 ERROR : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': not deleting files as there were IO errors 2021/03/04 06:13:07 ERROR : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': not deleting directories as there were IO errors --- PASS: TestSyncImmutable (0.02s) === RUN TestSyncIgnoreCase run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" 2021/03/04 06:13:07 INFO : EXISTING.rcc.001_fqgqoc: Moved (server-side) to: EXISTING.rcc.001 2021/03/04 06:13:07 INFO : EXISTING.rcc.002_fqgqoc: Moved (server-side) to: EXISTING.rcc.002 2021/03/04 06:13:07 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for checks to finish 2021/03/04 06:13:07 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/03/04 06:13:07 DEBUG : existing: Unchanged skipping 2021/03/04 06:13:07 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Waiting for transfers to finish 2021/03/04 06:13:07 DEBUG : Waiting for deletions to finish 2021/03/04 06:13:07 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreCase (0.01s) === RUN TestMaxTransfer === RUN TestMaxTransfer/Hard run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" sync_test.go:2020: This test only runs on local === RUN TestMaxTransfer/Soft run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" sync_test.go:2020: This test only runs on local === RUN TestMaxTransfer/Cautious run.go:176: Remote "Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0'", Local "Local file system at /tmp/rclone487708856", Modify Window "1ns" sync_test.go:2020: This test only runs on local --- PASS: TestMaxTransfer (0.00s) --- SKIP: TestMaxTransfer/Hard (0.00s) --- SKIP: TestMaxTransfer/Soft (0.00s) --- SKIP: TestMaxTransfer/Cautious (0.00s) PASS 2021/03/04 06:13:07 DEBUG : Chunked 'TestChunkerOverCrypt:rclone-test-fevipif0besefor5susicep0': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestChunkerOverCrypt: -verbose -fast-list -size-limit 6144" - Finished OK in 11.327502766s (try 1/5)