"./sync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose" - Starting (try 1/5) 2021/02/08 06:12:37 DEBUG : Creating backend with remote "TestB2:rclone-test-mahaxot7xanuduj5pinariy5" 2021/02/08 06:12:38 DEBUG : Creating backend with remote "/tmp/rclone536930939" === RUN TestPipe --- PASS: TestPipe (0.00s) === RUN TestPipeConcurrent --- PASS: TestPipeConcurrent (0.10s) === 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 "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:12:39 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:12:39 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:12:39 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11) --- PASS: TestCopyWithDryRun (1.33s) === RUN TestCopy run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:12:40 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:12:40 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:12:41 DEBUG : sub dir/hello world: SHA-1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/02/08 06:12:41 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopy (1.84s) === RUN TestCopyMissingDirectory run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:12:41 DEBUG : Creating backend with remote "/non-existing" 2021/02/08 06:12:41 ERROR : : error reading source directory: directory not found 2021/02/08 06:12:41 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:12:41 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish --- PASS: TestCopyMissingDirectory (0.42s) === RUN TestCopyNoTraverse run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:12:42 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:12:42 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:12:42 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:12:43 DEBUG : sub dir/hello world: SHA-1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/02/08 06:12:43 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyNoTraverse (2.06s) === RUN TestCopyCheckFirst run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:12:44 INFO : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Running all checks before starting transfers 2021/02/08 06:12:44 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:12:44 INFO : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Checks finished, now starting transfers 2021/02/08 06:12:44 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:12:45 DEBUG : sub dir/hello world: SHA-1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/02/08 06:12:45 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyCheckFirst (1.53s) === RUN TestSyncNoTraverse run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:12:45 ERROR : Ignoring --no-traverse with sync 2021/02/08 06:12:45 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:12:45 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:12:46 DEBUG : sub dir/hello world: SHA-1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/02/08 06:12:46 INFO : sub dir/hello world: Copied (new) 2021/02/08 06:12:46 DEBUG : Waiting for deletions to finish --- PASS: TestSyncNoTraverse (2.02s) === RUN TestCopyWithDepth run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:12:47 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:12:47 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:12:48 DEBUG : hello world2: SHA-1 = c0bf117f9c93d02c894fe8ffd6e5cecf3545c209 OK 2021/02/08 06:12:48 INFO : hello world2: Copied (new) --- PASS: TestCopyWithDepth (1.92s) === RUN TestCopyWithFilesFrom run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:12:49 DEBUG : hello world2: Excluded 2021/02/08 06:12:49 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:12:49 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:12:50 DEBUG : potato2: SHA-1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/02/08 06:12:50 INFO : potato2: Copied (new) --- PASS: TestCopyWithFilesFrom (1.94s) === RUN TestCopyWithFilesFromAndNoTraverse run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:12:52 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:12:52 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:12:52 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:12:52 DEBUG : potato2: SHA-1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/02/08 06:12:52 INFO : potato2: Copied (new) --- PASS: TestCopyWithFilesFromAndNoTraverse (1.99s) === RUN TestCopyEmptyDirectories run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:12:53 DEBUG : sub dir2: Making directory 2021/02/08 06:12:53 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:12:53 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:12:54 DEBUG : sub dir/hello world: SHA-1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/02/08 06:12:54 INFO : sub dir/hello world: Copied (new) 2021/02/08 06:12:54 DEBUG : sub dir2: Making directory 2021/02/08 06:12:54 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: copied 1 directories fstest.go:249: Filtering empty directory "sub dir2" --- PASS: TestCopyEmptyDirectories (1.03s) === RUN TestMoveEmptyDirectories run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:12:54 DEBUG : sub dir2: Making directory 2021/02/08 06:12:54 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:12:54 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:12:55 DEBUG : sub dir/hello world: SHA-1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/02/08 06:12:55 INFO : sub dir/hello world: Copied (new) 2021/02/08 06:12:55 INFO : sub dir/hello world: Deleted 2021/02/08 06:12:55 DEBUG : sub dir2: Making directory 2021/02/08 06:12:55 DEBUG : sub dir: Making directory 2021/02/08 06:12:55 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: copied 2 directories fstest.go:249: Filtering empty directory "sub dir2" --- PASS: TestMoveEmptyDirectories (1.48s) === RUN TestSyncEmptyDirectories run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:12:56 DEBUG : sub dir2: Making directory 2021/02/08 06:12:56 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:12:56 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:12:56 DEBUG : sub dir/hello world: SHA-1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/02/08 06:12:56 INFO : sub dir/hello world: Copied (new) 2021/02/08 06:12:56 DEBUG : sub dir2: Making directory 2021/02/08 06:12:56 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: copied 1 directories 2021/02/08 06:12:56 DEBUG : Waiting for deletions to finish fstest.go:249: Filtering empty directory "sub dir2" --- PASS: TestSyncEmptyDirectories (1.50s) === RUN TestServerSideCopy run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:12:58 DEBUG : Creating backend with remote "TestB2:rclone-test-noruxap5lasaceg6lipaloq2" sync_test.go:292: Server side copy (if possible) B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 -> B2 bucket rclone-test-noruxap5lasaceg6lipaloq2 2021/02/08 06:12:59 DEBUG : B2 bucket rclone-test-noruxap5lasaceg6lipaloq2: Waiting for checks to finish 2021/02/08 06:12:59 DEBUG : B2 bucket rclone-test-noruxap5lasaceg6lipaloq2: Waiting for transfers to finish 2021/02/08 06:13:00 DEBUG : sub dir/hello world: SHA-1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/02/08 06:13:00 INFO : sub dir/hello world: Copied (server-side copy) 2021/02/08 06:13:00 DEBUG : B2 bucket rclone-test-noruxap5lasaceg6lipaloq2: Purge remote 2021/02/08 06:13:00 DEBUG : sub dir/hello world: Deleting (id "4_z0f129d43405d8b0b7f780e1b_f109160627371d010_d20210208_m061259_c001_v0001150_t0054") --- PASS: TestServerSideCopy (10.25s) === RUN TestCopyAfterDelete run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:13:08 ERROR : : error listing: directory not found 2021/02/08 06:13:08 DEBUG : Local file system at /tmp/rclone536930939: Making directory 2021/02/08 06:13:09 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:13:09 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish --- PASS: TestCopyAfterDelete (2.05s) === RUN TestCopyRedownload run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:13:11 DEBUG : Local file system at /tmp/rclone536930939: Waiting for checks to finish 2021/02/08 06:13:11 DEBUG : Local file system at /tmp/rclone536930939: Waiting for transfers to finish 2021/02/08 06:13:11 DEBUG : sub dir/hello world: SHA-1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/02/08 06:13:11 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyRedownload (2.76s) === RUN TestSyncBasedOnCheckSum run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:13:12 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:13:12 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:13:13 DEBUG : check sum: SHA-1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2021/02/08 06:13:13 INFO : check sum: Copied (new) 2021/02/08 06:13:13 DEBUG : Waiting for deletions to finish 2021/02/08 06:13:13 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:13:13 DEBUG : check sum: SHA-1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2021/02/08 06:13:13 DEBUG : check sum: Size and SHA-1 of src and dst objects identical 2021/02/08 06:13:13 DEBUG : check sum: Unchanged skipping 2021/02/08 06:13:13 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:13:13 DEBUG : Waiting for deletions to finish 2021/02/08 06:13:13 INFO : There was nothing to transfer --- PASS: TestSyncBasedOnCheckSum (2.03s) === RUN TestSyncSizeOnly run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:13:14 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:13:14 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:13:15 DEBUG : sizeonly: SHA-1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2021/02/08 06:13:15 INFO : sizeonly: Copied (new) 2021/02/08 06:13:15 DEBUG : Waiting for deletions to finish 2021/02/08 06:13:15 DEBUG : sizeonly: Sizes identical 2021/02/08 06:13:15 DEBUG : sizeonly: Unchanged skipping 2021/02/08 06:13:15 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:13:15 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:13:15 DEBUG : Waiting for deletions to finish 2021/02/08 06:13:15 INFO : There was nothing to transfer --- PASS: TestSyncSizeOnly (2.51s) === RUN TestSyncIgnoreSize run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:13:17 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:13:17 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:13:17 DEBUG : ignore-size: SHA-1 = 4a756ca07e9487f482465a99e8286abc86ba4dc7 OK 2021/02/08 06:13:17 INFO : ignore-size: Copied (new) 2021/02/08 06:13:17 DEBUG : Waiting for deletions to finish 2021/02/08 06:13:18 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:13:18 DEBUG : ignore-size: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/02/08 06:13:18 DEBUG : ignore-size: Unchanged skipping 2021/02/08 06:13:18 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:13:18 DEBUG : Waiting for deletions to finish 2021/02/08 06:13:18 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreSize (1.55s) === RUN TestSyncIgnoreTimes run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:13:19 DEBUG : existing: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/02/08 06:13:19 DEBUG : existing: Unchanged skipping 2021/02/08 06:13:19 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:13:19 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:13:19 DEBUG : Waiting for deletions to finish 2021/02/08 06:13:19 INFO : There was nothing to transfer 2021/02/08 06:13:19 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2021/02/08 06:13:19 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:13:19 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:13:20 DEBUG : existing: SHA-1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2021/02/08 06:13:20 INFO : existing: Copied (replaced existing) 2021/02/08 06:13:20 DEBUG : Waiting for deletions to finish --- PASS: TestSyncIgnoreTimes (2.38s) === RUN TestSyncIgnoreExisting run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:13:21 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:13:21 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:13:21 DEBUG : existing: SHA-1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2021/02/08 06:13:21 INFO : existing: Copied (new) 2021/02/08 06:13:21 DEBUG : Waiting for deletions to finish 2021/02/08 06:13:22 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:13:22 DEBUG : existing: Destination exists, skipping 2021/02/08 06:13:22 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:13:22 DEBUG : Waiting for deletions to finish 2021/02/08 06:13:22 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreExisting (3.38s) === RUN TestSyncIgnoreErrors run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:13:25 DEBUG : d: Making directory fstest.go:249: Filtering empty directory "d" 2021/02/08 06:13:26 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/02/08 06:13:26 DEBUG : c/non empty space: Unchanged skipping 2021/02/08 06:13:26 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:13:26 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:13:28 DEBUG : a/potato2: SHA-1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/02/08 06:13:28 INFO : a/potato2: Copied (new) 2021/02/08 06:13:28 DEBUG : Waiting for deletions to finish 2021/02/08 06:13:29 INFO : b/potato: Deleted --- PASS: TestSyncIgnoreErrors (6.46s) === RUN TestSyncAfterChangingModtimeOnly run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:13:31 DEBUG : empty space: Modification times differ by -95456h54m52.624456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499 +0000 UTC 2021/02/08 06:13:31 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:13:31 DEBUG : empty space: SHA-1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2021/02/08 06:13:31 NOTICE: empty space: Skipped update modification time as --dry-run is set (size 1) 2021/02/08 06:13:31 DEBUG : empty space: Unchanged skipping 2021/02/08 06:13:31 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:13:31 DEBUG : Waiting for deletions to finish 2021/02/08 06:13:31 INFO : There was nothing to transfer 2021/02/08 06:13:32 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:13:32 DEBUG : empty space: Modification times differ by -95456h54m52.624456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499 +0000 UTC 2021/02/08 06:13:32 DEBUG : empty space: SHA-1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2021/02/08 06:13:35 INFO : empty space: Updated modification time in destination 2021/02/08 06:13:35 DEBUG : empty space: Unchanged skipping 2021/02/08 06:13:35 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:13:35 DEBUG : Waiting for deletions to finish 2021/02/08 06:13:35 INFO : There was nothing to transfer --- PASS: TestSyncAfterChangingModtimeOnly (5.05s) === RUN TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:13:37 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:13:37 DEBUG : empty space: Modification times differ by -95456h54m52.624456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499 +0000 UTC 2021/02/08 06:13:37 DEBUG : empty space: SHA-1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2021/02/08 06:13:37 DEBUG : empty space: Unchanged skipping 2021/02/08 06:13:37 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:13:37 DEBUG : Waiting for deletions to finish 2021/02/08 06:13:37 INFO : There was nothing to transfer --- PASS: TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime (1.78s) === RUN TestSyncDoesntUpdateModtime run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:13:39 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:13:39 DEBUG : foo: Modification times differ by -95456h54m52.624456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499 +0000 UTC 2021/02/08 06:13:39 DEBUG : foo: SHA-1 = 0beec7b5ea3f0fdbc95d0dd47f3c5bc275da8a33 (Local file system at /tmp/rclone536930939) 2021/02/08 06:13:39 DEBUG : foo: SHA-1 = 62cdb7020ff920e5aa642c3d4066950dd1f01f4d (B2 bucket rclone-test-mahaxot7xanuduj5pinariy5) 2021/02/08 06:13:39 DEBUG : foo: SHA-1 differ 2021/02/08 06:13:39 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:13:39 DEBUG : foo: SHA-1 = 0beec7b5ea3f0fdbc95d0dd47f3c5bc275da8a33 OK 2021/02/08 06:13:39 INFO : foo: Copied (replaced existing) 2021/02/08 06:13:39 DEBUG : Waiting for deletions to finish --- PASS: TestSyncDoesntUpdateModtime (2.75s) === RUN TestSyncAfterAddingAFile run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:13:41 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/02/08 06:13:41 DEBUG : empty space: Unchanged skipping 2021/02/08 06:13:41 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:13:41 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:13:42 DEBUG : potato: SHA-1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/02/08 06:13:42 INFO : potato: Copied (new) 2021/02/08 06:13:42 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterAddingAFile (3.85s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:13:45 DEBUG : potato: Sizes differ (src 21 vs dst 60) 2021/02/08 06:13:45 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:13:45 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:13:46 DEBUG : potato: SHA-1 = 0fd321a1023ac4e1e1054fcc0236b9d0755f722f OK 2021/02/08 06:13:46 INFO : potato: Copied (replaced existing) 2021/02/08 06:13:46 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingFilesSizeOnly (3.31s) === RUN TestSyncAfterChangingContentsOnly run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:13:48 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/02/08 06:13:48 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:13:48 DEBUG : potato: SHA-1 = 1ca5094b3b73f587249eabe179c40a3eec839b1f (Local file system at /tmp/rclone536930939) 2021/02/08 06:13:48 DEBUG : potato: SHA-1 = 0fd321a1023ac4e1e1054fcc0236b9d0755f722f (B2 bucket rclone-test-mahaxot7xanuduj5pinariy5) 2021/02/08 06:13:48 DEBUG : potato: SHA-1 differ 2021/02/08 06:13:48 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:13:49 DEBUG : potato: SHA-1 = 1ca5094b3b73f587249eabe179c40a3eec839b1f OK 2021/02/08 06:13:49 INFO : potato: Copied (replaced existing) 2021/02/08 06:13:49 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingContentsOnly (2.33s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:13:51 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:13:51 NOTICE: potato2: Skipped copy as --dry-run is set (size 60) 2021/02/08 06:13:51 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/02/08 06:13:51 DEBUG : empty space: Unchanged skipping 2021/02/08 06:13:51 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:13:51 DEBUG : Waiting for deletions to finish 2021/02/08 06:13:51 NOTICE: potato: Skipped delete as --dry-run is set (size 21) --- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (2.45s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:13:54 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/02/08 06:13:54 DEBUG : empty space: Unchanged skipping 2021/02/08 06:13:54 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:13:54 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:13:54 DEBUG : potato2: SHA-1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/02/08 06:13:54 INFO : potato2: Copied (new) 2021/02/08 06:13:54 DEBUG : Waiting for deletions to finish 2021/02/08 06:13:55 INFO : potato: Deleted --- PASS: TestSyncAfterRemovingAFileAndAddingAFile (4.41s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:13:58 DEBUG : d: Making directory 2021/02/08 06:13:58 DEBUG : d/e: Making directory fstest.go:249: Filtering empty directory "d" fstest.go:249: Filtering empty directory "d/e" 2021/02/08 06:13:58 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/02/08 06:13:58 DEBUG : c/non empty space: Unchanged skipping 2021/02/08 06:13:58 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:13:58 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:13:58 DEBUG : a/potato2: SHA-1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/02/08 06:13:58 INFO : a/potato2: Copied (new) 2021/02/08 06:13:58 DEBUG : Waiting for deletions to finish 2021/02/08 06:13:59 INFO : b/potato: Deleted --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (3.85s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:14:01 DEBUG : d: Making directory fstest.go:249: Filtering empty directory "d" 2021/02/08 06:14:02 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/02/08 06:14:02 DEBUG : c/non empty space: Unchanged skipping 2021/02/08 06:14:02 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:14:02 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:14:02 DEBUG : a/potato2: SHA-1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/02/08 06:14:02 INFO : a/potato2: Copied (new) 2021/02/08 06:14:02 ERROR : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: not deleting files as there were IO errors 2021/02/08 06:14:02 ERROR : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: not deleting directories as there were IO errors fstest.go:249: Filtering empty directory "d" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (33.43s) === RUN TestSyncDeleteAfter --- PASS: TestSyncDeleteAfter (0.00s) === RUN TestSyncDeleteDuring run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:14:35 DEBUG : Waiting for deletions to finish 2021/02/08 06:14:36 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/02/08 06:14:36 DEBUG : empty space: Unchanged skipping 2021/02/08 06:14:36 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:14:36 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:14:36 DEBUG : potato2: SHA-1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/02/08 06:14:36 INFO : potato2: Copied (new) 2021/02/08 06:15:06 INFO : potato: Deleted --- PASS: TestSyncDeleteDuring (33.42s) === RUN TestSyncDeleteBefore run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:15:10 DEBUG : Waiting for deletions to finish 2021/02/08 06:15:10 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:15:10 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:15:14 INFO : potato: Deleted 2021/02/08 06:15:14 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/02/08 06:15:14 DEBUG : empty space: Unchanged skipping 2021/02/08 06:15:14 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:15:14 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:15:15 DEBUG : potato2: SHA-1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/02/08 06:15:15 INFO : potato2: Copied (new) --- PASS: TestSyncDeleteBefore (8.82s) === RUN TestCopyDeleteBefore run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:15:17 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:15:17 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:15:17 DEBUG : potato2: SHA-1 = 810274f0df19dab60a894a562b7a8ff04c072623 OK 2021/02/08 06:15:17 INFO : potato2: Copied (new) --- PASS: TestCopyDeleteBefore (2.69s) === RUN TestSyncWithExclude run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:15:20 DEBUG : enormous: Excluded 2021/02/08 06:15:20 DEBUG : potato2: Excluded 2021/02/08 06:15:20 DEBUG : potato2: Excluded 2021/02/08 06:15:20 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/02/08 06:15:20 DEBUG : empty space: Unchanged skipping 2021/02/08 06:15:20 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:15:20 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:15:20 DEBUG : Waiting for deletions to finish 2021/02/08 06:15:20 INFO : There was nothing to transfer 2021/02/08 06:15:20 DEBUG : enormous: Excluded 2021/02/08 06:15:20 DEBUG : potato2: Excluded 2021/02/08 06:15:20 DEBUG : potato2: Excluded 2021/02/08 06:15:20 DEBUG : empty space: Size and modification time the same (differ by 456.789µs, within tolerance 1ms) 2021/02/08 06:15:20 DEBUG : empty space: Unchanged skipping 2021/02/08 06:15:20 DEBUG : Local file system at /tmp/rclone536930939: Waiting for checks to finish 2021/02/08 06:15:20 DEBUG : Local file system at /tmp/rclone536930939: Waiting for transfers to finish 2021/02/08 06:15:20 DEBUG : Waiting for deletions to finish 2021/02/08 06:15:20 INFO : There was nothing to transfer --- PASS: TestSyncWithExclude (2.79s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:15:23 DEBUG : enormous: Excluded 2021/02/08 06:15:23 DEBUG : potato2: Excluded 2021/02/08 06:15:23 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/02/08 06:15:23 DEBUG : empty space: Unchanged skipping 2021/02/08 06:15:23 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:15:23 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:15:23 DEBUG : Waiting for deletions to finish 2021/02/08 06:15:24 INFO : enormous: Deleted 2021/02/08 06:15:31 INFO : potato2: Deleted 2021/02/08 06:15:31 INFO : There was nothing to transfer 2021/02/08 06:15:31 DEBUG : empty space: Size and modification time the same (differ by 456.789µs, within tolerance 1ms) 2021/02/08 06:15:31 DEBUG : empty space: Unchanged skipping 2021/02/08 06:15:31 DEBUG : Local file system at /tmp/rclone536930939: Waiting for checks to finish 2021/02/08 06:15:31 DEBUG : Local file system at /tmp/rclone536930939: Waiting for transfers to finish 2021/02/08 06:15:31 DEBUG : Waiting for deletions to finish 2021/02/08 06:15:31 INFO : potato2: Deleted 2021/02/08 06:15:31 INFO : enormous: Deleted 2021/02/08 06:15:31 INFO : There was nothing to transfer --- PASS: TestSyncWithExcludeAndDeleteExcluded (10.45s) === RUN TestSyncWithUpdateOlder run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:15:34 DEBUG : four: Sizes differ (src 4 vs dst 8) 2021/02/08 06:15:34 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2021/02/08 06:15:34 DEBUG : one: Destination is newer than source, skipping 2021/02/08 06:15:34 DEBUG : three: Sizes identical 2021/02/08 06:15:34 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2021/02/08 06:15:34 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:15:34 DEBUG : two: SHA-1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b (Local file system at /tmp/rclone536930939) 2021/02/08 06:15:34 DEBUG : two: SHA-1 = b10e0da85e90399abfec36c7376b20aa4596461b (B2 bucket rclone-test-mahaxot7xanuduj5pinariy5) 2021/02/08 06:15:34 DEBUG : two: SHA-1 differ 2021/02/08 06:15:34 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:15:35 DEBUG : four: SHA-1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2021/02/08 06:15:35 INFO : four: Copied (replaced existing) 2021/02/08 06:15:36 DEBUG : two: SHA-1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2021/02/08 06:15:36 INFO : two: Copied (replaced existing) 2021/02/08 06:15:36 DEBUG : five: SHA-1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2021/02/08 06:15:36 INFO : five: Copied (new) 2021/02/08 06:15:36 DEBUG : Waiting for deletions to finish 2021/02/08 06:15:37 DEBUG : one: Destination is newer than source, skipping 2021/02/08 06:15:37 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:15:37 DEBUG : four: SHA-1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2021/02/08 06:15:37 DEBUG : four: Size and SHA-1 of src and dst objects identical 2021/02/08 06:15:37 DEBUG : four: Destination mod time is within 1s of source and files identical, skipping 2021/02/08 06:15:37 DEBUG : five: SHA-1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2021/02/08 06:15:37 DEBUG : five: Size and SHA-1 of src and dst objects identical 2021/02/08 06:15:37 DEBUG : five: Destination mod time is within 1s of source and files identical, skipping 2021/02/08 06:15:37 DEBUG : two: SHA-1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2021/02/08 06:15:37 DEBUG : two: Size and SHA-1 of src and dst objects identical 2021/02/08 06:15:37 DEBUG : two: Destination mod time is within 1s of source and files identical, skipping 2021/02/08 06:15:37 DEBUG : three: SHA-1 = b802f384302cb24fbab0a44997e820bf2e8507bb (Local file system at /tmp/rclone536930939) 2021/02/08 06:15:37 DEBUG : three: SHA-1 = 03731cad13f4cf7b59703c77529381cdec1632e5 (B2 bucket rclone-test-mahaxot7xanuduj5pinariy5) 2021/02/08 06:15:37 DEBUG : three: SHA-1 differ 2021/02/08 06:15:37 DEBUG : three: Destination mod time is within 1s of source but files differ, transferring 2021/02/08 06:15:37 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:15:38 DEBUG : three: SHA-1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2021/02/08 06:15:38 INFO : three: Copied (replaced existing) 2021/02/08 06:15:38 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithUpdateOlder (8.70s) === RUN TestSyncWithMaxDuration sync_test.go:1074: Skipping test on non local remote --- SKIP: TestSyncWithMaxDuration (0.00s) === RUN TestSyncWithTrackRenames run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" sync_test.go:1128: Can track renames: true 2021/02/08 06:15:41 INFO : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Making map for --track-renames 2021/02/08 06:15:41 INFO : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Finished making map for --track-renames 2021/02/08 06:15:41 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:15:41 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for renames to finish 2021/02/08 06:15:41 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:15:41 DEBUG : potato: SHA-1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2021/02/08 06:15:41 INFO : potato: Copied (new) 2021/02/08 06:15:42 DEBUG : yam: SHA-1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2021/02/08 06:15:42 INFO : yam: Copied (new) 2021/02/08 06:15:42 DEBUG : Waiting for deletions to finish 2021/02/08 06:15:42 INFO : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Making map for --track-renames 2021/02/08 06:15:42 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/02/08 06:15:42 DEBUG : potato: Unchanged skipping 2021/02/08 06:15:42 INFO : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Finished making map for --track-renames 2021/02/08 06:15:42 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:15:42 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for renames to finish 2021/02/08 06:15:43 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:15:53 DEBUG : yam: SHA-1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2021/02/08 06:15:53 INFO : yam: Copied (server-side copy) to: yaml 2021/02/08 06:15:53 INFO : yam: Deleted 2021/02/08 06:15:53 INFO : yaml: Renamed from "yam" 2021/02/08 06:15:53 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:15:53 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenames (14.12s) === RUN TestParseRenamesStrategyModtime --- PASS: TestParseRenamesStrategyModtime (0.00s) === RUN TestRenamesStrategyModtime --- PASS: TestRenamesStrategyModtime (0.00s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" sync_test.go:1201: Can track renames: true 2021/02/08 06:15:55 INFO : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Making map for --track-renames 2021/02/08 06:15:55 INFO : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Finished making map for --track-renames 2021/02/08 06:15:55 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:15:55 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for renames to finish 2021/02/08 06:15:55 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:15:56 DEBUG : yam: SHA-1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2021/02/08 06:15:56 INFO : yam: Copied (new) 2021/02/08 06:15:56 DEBUG : potato: SHA-1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2021/02/08 06:15:56 INFO : potato: Copied (new) 2021/02/08 06:15:56 DEBUG : Waiting for deletions to finish 2021/02/08 06:15:56 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/02/08 06:15:56 DEBUG : potato: Unchanged skipping 2021/02/08 06:15:56 INFO : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Making map for --track-renames 2021/02/08 06:15:56 INFO : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Finished making map for --track-renames 2021/02/08 06:15:56 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:15:56 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for renames to finish 2021/02/08 06:15:57 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:15:57 DEBUG : yam: SHA-1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2021/02/08 06:15:57 INFO : yam: Copied (server-side copy) to: yaml 2021/02/08 06:15:58 INFO : yam: Deleted 2021/02/08 06:15:58 INFO : yaml: Renamed from "yam" 2021/02/08 06:15:58 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:15:58 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenamesStrategyModtime (6.10s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" sync_test.go:1241: Can track renames: true 2021/02/08 06:16:01 INFO : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Making map for --track-renames 2021/02/08 06:16:01 INFO : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Finished making map for --track-renames 2021/02/08 06:16:01 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:16:01 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for renames to finish 2021/02/08 06:16:01 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:16:02 DEBUG : potato: SHA-1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2021/02/08 06:16:02 INFO : potato: Copied (new) 2021/02/08 06:16:02 DEBUG : sub/yam: SHA-1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2021/02/08 06:16:02 INFO : sub/yam: Copied (new) 2021/02/08 06:16:02 DEBUG : Waiting for deletions to finish 2021/02/08 06:16:02 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/02/08 06:16:02 DEBUG : potato: Unchanged skipping 2021/02/08 06:16:03 INFO : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Making map for --track-renames 2021/02/08 06:16:03 INFO : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Finished making map for --track-renames 2021/02/08 06:16:03 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:16:03 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for renames to finish 2021/02/08 06:16:03 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:16:04 DEBUG : sub/yam: SHA-1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2021/02/08 06:16:04 INFO : sub/yam: Copied (server-side copy) to: yam 2021/02/08 06:16:04 INFO : sub/yam: Deleted 2021/02/08 06:16:04 INFO : yam: Renamed from "sub/yam" 2021/02/08 06:16:04 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:16:04 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenamesStrategyLeaf (17.92s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:16:19 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:16:19 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:16:20 DEBUG : nested/sub dir/file: SHA-1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2021/02/08 06:16:20 INFO : nested/sub dir/file: Copied (new) 2021/02/08 06:16:20 INFO : nested/sub dir/file: Deleted 2021/02/08 06:16:20 DEBUG : sub dir/hello world: SHA-1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/02/08 06:16:20 INFO : sub dir/hello world: Copied (new) 2021/02/08 06:16:20 INFO : sub dir/hello world: Deleted 2021/02/08 06:16:20 DEBUG : sub dir: Removing directory 2021/02/08 06:16:20 DEBUG : nested/sub dir: Removing directory 2021/02/08 06:16:20 DEBUG : nested: Removing directory 2021/02/08 06:16:20 DEBUG : Local file system at /tmp/rclone536930939: deleted 3 directories --- PASS: TestMoveWithDeleteEmptySrcDirs (2.53s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:16:21 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:16:21 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:16:22 DEBUG : sub dir/hello world: SHA-1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/02/08 06:16:22 INFO : sub dir/hello world: Copied (new) 2021/02/08 06:16:22 INFO : sub dir/hello world: Deleted 2021/02/08 06:16:24 DEBUG : nested/sub dir/file: SHA-1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2021/02/08 06:16:24 INFO : nested/sub dir/file: Copied (new) 2021/02/08 06:16:24 INFO : nested/sub dir/file: Deleted --- PASS: TestMoveWithoutDeleteEmptySrcDirs (4.00s) === RUN TestServerSideMove run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:16:25 DEBUG : Creating backend with remote "TestB2:rclone-test-yiqivop4wuvipol0dudarow5" sync_test.go:1294: Server side move (if possible) B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 -> B2 bucket rclone-test-yiqivop4wuvipol0dudarow5 2021/02/08 06:16:33 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ms) 2021/02/08 06:16:33 DEBUG : empty space: Unchanged skipping 2021/02/08 06:16:33 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2021/02/08 06:16:33 DEBUG : B2 bucket rclone-test-yiqivop4wuvipol0dudarow5: Waiting for checks to finish 2021/02/08 06:16:34 DEBUG : potato2: SHA-1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/02/08 06:16:34 INFO : potato2: Copied (server-side copy) 2021/02/08 06:16:34 DEBUG : potato3: SHA-1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2021/02/08 06:16:34 INFO : potato3: Copied (server-side copy) 2021/02/08 06:16:34 INFO : potato2: Deleted 2021/02/08 06:16:34 INFO : empty space: Deleted 2021/02/08 06:16:34 DEBUG : B2 bucket rclone-test-yiqivop4wuvipol0dudarow5: Waiting for transfers to finish 2021/02/08 06:16:36 INFO : potato3: Deleted 2021/02/08 06:16:36 DEBUG : Creating backend with remote "TestB2:rclone-test-sedages3lafijim7qifejeb0" 2021/02/08 06:16:37 DEBUG : B2 bucket rclone-test-sedages3lafijim7qifejeb0: Waiting for checks to finish 2021/02/08 06:16:37 DEBUG : B2 bucket rclone-test-sedages3lafijim7qifejeb0: Waiting for transfers to finish 2021/02/08 06:16:38 DEBUG : potato3: SHA-1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2021/02/08 06:16:38 INFO : potato3: Copied (server-side copy) 2021/02/08 06:16:38 DEBUG : empty space: SHA-1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2021/02/08 06:16:38 INFO : empty space: Copied (server-side copy) 2021/02/08 06:16:38 INFO : potato3: Deleted 2021/02/08 06:16:38 INFO : empty space: Deleted 2021/02/08 06:16:38 DEBUG : potato2: SHA-1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/02/08 06:16:38 INFO : potato2: Copied (server-side copy) 2021/02/08 06:16:39 INFO : potato2: Deleted 2021/02/08 06:16:39 DEBUG : B2 bucket rclone-test-sedages3lafijim7qifejeb0: Purge remote 2021/02/08 06:16:39 DEBUG : empty space: Deleting (id "4_z0fc2ed83408d8b0b7f780e1b_f119ce5b0036fbd4d_d20210208_m061638_c001_v0001030_t0004") 2021/02/08 06:16:39 DEBUG : potato2: Deleting (id "4_z0fc2ed83408d8b0b7f780e1b_f107e8f9e0f08fd94_d20210208_m061638_c001_v0001150_t0023") 2021/02/08 06:16:39 DEBUG : potato3: Deleting (id "4_z0fc2ed83408d8b0b7f780e1b_f1002e25b4a374486_d20210208_m061638_c001_v0001154_t0017") 2021/02/08 06:16:40 DEBUG : B2 bucket rclone-test-yiqivop4wuvipol0dudarow5: Purge remote 2021/02/08 06:16:40 DEBUG : empty space: Deleting (id "4_zbfe2dd13408d8b0b7f780e1b_f113c02ccdb937180_d20210208_m061638_c001_v0001022_t0003") 2021/02/08 06:16:40 DEBUG : empty space: Deleting (id "4_zbfe2dd13408d8b0b7f780e1b_f1189952e5bebcc53_d20210208_m061633_c001_v0001136_t0014") 2021/02/08 06:16:40 DEBUG : potato2: Deleting (id "4_zbfe2dd13408d8b0b7f780e1b_f118bbcb23c662da4_d20210208_m061638_c001_v0001154_t0010") 2021/02/08 06:16:40 DEBUG : potato2: Deleting (id "4_zbfe2dd13408d8b0b7f780e1b_f1041e6a7b5703ff3_d20210208_m061634_c001_v0001145_t0041") 2021/02/08 06:16:40 DEBUG : potato3: Deleting (id "4_zbfe2dd13408d8b0b7f780e1b_f1097783647511b40_d20210208_m061638_c001_v0001040_t0012") 2021/02/08 06:16:40 DEBUG : potato3: Deleting (id "4_zbfe2dd13408d8b0b7f780e1b_f111d7860177939a4_d20210208_m061634_c001_v0001146_t0048") 2021/02/08 06:16:40 DEBUG : potato3: Deleting (id "4_zbfe2dd13408d8b0b7f780e1b_f1189952e5bebcc55_d20210208_m061633_c001_v0001136_t0014") --- PASS: TestServerSideMove (15.39s) === RUN TestServerSideMoveWithFilter run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:16:41 DEBUG : Creating backend with remote "TestB2:rclone-test-putujes8nekeheg3taminez3" sync_test.go:1294: Server side move (if possible) B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 -> B2 bucket rclone-test-putujes8nekeheg3taminez3 2021/02/08 06:16:48 DEBUG : empty space: Excluded 2021/02/08 06:16:48 DEBUG : empty space: Excluded 2021/02/08 06:16:48 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2021/02/08 06:16:48 DEBUG : B2 bucket rclone-test-putujes8nekeheg3taminez3: Waiting for checks to finish 2021/02/08 06:16:48 DEBUG : B2 bucket rclone-test-putujes8nekeheg3taminez3: Waiting for transfers to finish 2021/02/08 06:16:48 DEBUG : potato2: SHA-1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/02/08 06:16:48 INFO : potato2: Copied (server-side copy) 2021/02/08 06:16:49 DEBUG : potato3: SHA-1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2021/02/08 06:16:49 INFO : potato3: Copied (server-side copy) 2021/02/08 06:16:49 INFO : potato3: Deleted 2021/02/08 06:16:51 INFO : potato2: Deleted 2021/02/08 06:16:51 DEBUG : Creating backend with remote "TestB2:rclone-test-migorix5koripub2zihejiz6" 2021/02/08 06:16:52 DEBUG : empty space: Excluded 2021/02/08 06:16:52 DEBUG : B2 bucket rclone-test-migorix5koripub2zihejiz6: Waiting for checks to finish 2021/02/08 06:16:52 DEBUG : B2 bucket rclone-test-migorix5koripub2zihejiz6: Waiting for transfers to finish 2021/02/08 06:16:53 DEBUG : potato3: SHA-1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2021/02/08 06:16:53 INFO : potato3: Copied (server-side copy) 2021/02/08 06:16:55 DEBUG : potato2: SHA-1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/02/08 06:16:55 INFO : potato2: Copied (server-side copy) 2021/02/08 06:16:55 INFO : potato2: Deleted 2021/02/08 06:17:01 INFO : potato3: Deleted 2021/02/08 06:17:01 DEBUG : B2 bucket rclone-test-migorix5koripub2zihejiz6: Purge remote 2021/02/08 06:17:01 DEBUG : potato2: Deleting (id "4_zbf422d13409d8b0b7f780e1b_f11769414e4f865a0_d20210208_m061652_c001_v0001150_t0008") 2021/02/08 06:17:01 DEBUG : potato3: Deleting (id "4_zbf422d13409d8b0b7f780e1b_f111d786017793a50_d20210208_m061652_c001_v0001146_t0055") 2021/02/08 06:17:02 DEBUG : B2 bucket rclone-test-putujes8nekeheg3taminez3: Purge remote 2021/02/08 06:17:02 DEBUG : empty space: Deleting (id "4_zaf120d83409d8b0b7f780e1b_f106316c4b1bbb51a_d20210208_m061646_c001_v0001137_t0027") 2021/02/08 06:17:02 DEBUG : potato2: Deleting (id "4_zaf120d83409d8b0b7f780e1b_f1154214a47d58643_d20210208_m061655_c001_v0001130_t0012") 2021/02/08 06:17:02 DEBUG : potato2: Deleting (id "4_zaf120d83409d8b0b7f780e1b_f10070ec3f39f0a43_d20210208_m061648_c001_v0001146_t0005") 2021/02/08 06:17:02 DEBUG : potato3: Deleting (id "4_zaf120d83409d8b0b7f780e1b_f11456bc927e5d2a1_d20210208_m061653_c001_v0001146_t0030") 2021/02/08 06:17:02 DEBUG : potato3: Deleting (id "4_zaf120d83409d8b0b7f780e1b_f11403dd8d4b86218_d20210208_m061648_c001_v0001154_t0024") 2021/02/08 06:17:02 DEBUG : potato3: Deleting (id "4_zaf120d83409d8b0b7f780e1b_f106316c4b1bbb51c_d20210208_m061647_c001_v0001137_t0027") --- PASS: TestServerSideMoveWithFilter (26.34s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:17:07 DEBUG : Creating backend with remote "TestB2:rclone-test-jabafus4xudaziq6qupokey7" 2021/02/08 06:17:14 DEBUG : tomatoDir: Making directory sync_test.go:1294: Server side move (if possible) B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 -> B2 bucket rclone-test-jabafus4xudaziq6qupokey7 2021/02/08 06:17:16 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ms) 2021/02/08 06:17:16 DEBUG : empty space: Unchanged skipping 2021/02/08 06:17:16 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2021/02/08 06:17:16 DEBUG : B2 bucket rclone-test-jabafus4xudaziq6qupokey7: Waiting for checks to finish 2021/02/08 06:17:16 DEBUG : potato2: SHA-1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/02/08 06:17:16 INFO : potato2: Copied (server-side copy) 2021/02/08 06:17:16 DEBUG : potato3: SHA-1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2021/02/08 06:17:16 INFO : potato3: Copied (server-side copy) 2021/02/08 06:17:17 INFO : empty space: Deleted 2021/02/08 06:17:17 DEBUG : B2 bucket rclone-test-jabafus4xudaziq6qupokey7: Waiting for transfers to finish 2021/02/08 06:17:17 INFO : potato2: Deleted 2021/02/08 06:17:17 INFO : potato3: Deleted 2021/02/08 06:17:17 DEBUG : Creating backend with remote "TestB2:rclone-test-zokecal1gucamur2fotujuq2" 2021/02/08 06:17:18 DEBUG : tomatoDir: Making directory 2021/02/08 06:17:18 DEBUG : B2 bucket rclone-test-zokecal1gucamur2fotujuq2: Waiting for checks to finish 2021/02/08 06:17:18 DEBUG : B2 bucket rclone-test-zokecal1gucamur2fotujuq2: Waiting for transfers to finish 2021/02/08 06:17:19 DEBUG : potato2: SHA-1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/02/08 06:17:19 INFO : potato2: Copied (server-side copy) 2021/02/08 06:17:19 DEBUG : empty space: SHA-1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2021/02/08 06:17:19 INFO : empty space: Copied (server-side copy) 2021/02/08 06:17:19 DEBUG : potato3: SHA-1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2021/02/08 06:17:19 INFO : potato3: Copied (server-side copy) 2021/02/08 06:17:19 INFO : potato2: Deleted 2021/02/08 06:17:19 INFO : empty space: Deleted 2021/02/08 06:17:22 INFO : potato3: Deleted 2021/02/08 06:17:22 DEBUG : B2 bucket rclone-test-zokecal1gucamur2fotujuq2: Purge remote 2021/02/08 06:17:22 DEBUG : empty space: Deleting (id "4_z2fc28d83409d8b0b7f780e1b_f1175efb503e925b1_d20210208_m061719_c001_v0001022_t0025") 2021/02/08 06:17:22 DEBUG : potato2: Deleting (id "4_z2fc28d83409d8b0b7f780e1b_f1021bc6a0ed3e22d_d20210208_m061719_c001_v0001153_t0006") 2021/02/08 06:17:22 DEBUG : potato3: Deleting (id "4_z2fc28d83409d8b0b7f780e1b_f1192779f420c9ea8_d20210208_m061719_c001_v0001025_t0001") 2021/02/08 06:17:23 DEBUG : B2 bucket rclone-test-jabafus4xudaziq6qupokey7: Purge remote 2021/02/08 06:17:23 DEBUG : empty space: Deleting (id "4_zbf027d73409d8b0b7f780e1b_f10512edd353beb7d_d20210208_m061719_c001_v0001153_t0019") 2021/02/08 06:17:23 DEBUG : empty space: Deleting (id "4_zbf027d73409d8b0b7f780e1b_f101204e86af45ba2_d20210208_m061715_c001_v0001026_t0007") 2021/02/08 06:17:23 DEBUG : potato2: Deleting (id "4_zbf027d73409d8b0b7f780e1b_f10756664d9ec746f_d20210208_m061719_c001_v0001137_t0059") 2021/02/08 06:17:23 DEBUG : potato2: Deleting (id "4_zbf027d73409d8b0b7f780e1b_f119b93a7b93b86f8_d20210208_m061716_c001_v0001154_t0022") 2021/02/08 06:17:23 DEBUG : potato3: Deleting (id "4_zbf027d73409d8b0b7f780e1b_f10048fbb95ec55a2_d20210208_m061719_c001_v0001032_t0042") 2021/02/08 06:17:23 DEBUG : potato3: Deleting (id "4_zbf027d73409d8b0b7f780e1b_f11326cf0a969254c_d20210208_m061716_c001_v0001043_t0021") 2021/02/08 06:17:23 DEBUG : potato3: Deleting (id "4_zbf027d73409d8b0b7f780e1b_f101204e86af45ba6_d20210208_m061715_c001_v0001026_t0007") --- PASS: TestServerSideMoveDeleteEmptySourceDirs (16.88s) === RUN TestServerSideMoveOverlap run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:17:24 DEBUG : Creating backend with remote "TestB2:rclone-test-mahaxot7xanuduj5pinariy5/rclone-move-test" 2021/02/08 06:17:25 DEBUG : Couldn't decode error response: EOF --- PASS: TestServerSideMoveOverlap (3.62s) === RUN TestSyncOverlap run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:17:28 DEBUG : Creating backend with remote "TestB2:rclone-test-mahaxot7xanuduj5pinariy5/rclone-sync-test" 2021/02/08 06:17:28 DEBUG : Couldn't decode error response: EOF --- PASS: TestSyncOverlap (0.65s) === RUN TestSyncCompareDest run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:17:28 DEBUG : Creating backend with remote "TestB2:rclone-test-mahaxot7xanuduj5pinariy5/dst" 2021/02/08 06:17:29 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:17:29 DEBUG : Creating backend with remote "TestB2:rclone-test-mahaxot7xanuduj5pinariy5/CompareDest" 2021/02/08 06:17:29 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:17:29 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:17:29 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for checks to finish 2021/02/08 06:17:29 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for transfers to finish 2021/02/08 06:17:30 DEBUG : one: SHA-1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/02/08 06:17:30 INFO : one: Copied (new) 2021/02/08 06:17:30 DEBUG : Waiting for deletions to finish 2021/02/08 06:17:31 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for checks to finish 2021/02/08 06:17:31 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:17:31 DEBUG : one: Sizes differ (src 5 vs dst 3) 2021/02/08 06:17:31 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for transfers to finish 2021/02/08 06:17:31 DEBUG : one: SHA-1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2021/02/08 06:17:31 INFO : one: Copied (replaced existing) 2021/02/08 06:17:31 DEBUG : Waiting for deletions to finish 2021/02/08 06:17:35 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for checks to finish 2021/02/08 06:17:35 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/02/08 06:17:35 DEBUG : one: Destination found in --compare-dest, skipping 2021/02/08 06:17:35 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for transfers to finish 2021/02/08 06:17:35 DEBUG : Waiting for deletions to finish 2021/02/08 06:17:35 INFO : There was nothing to transfer 2021/02/08 06:17:37 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/02/08 06:17:37 DEBUG : two: Destination found in --compare-dest, skipping 2021/02/08 06:17:37 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for checks to finish 2021/02/08 06:17:37 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/02/08 06:17:37 DEBUG : one: Destination found in --compare-dest, skipping 2021/02/08 06:17:37 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for transfers to finish 2021/02/08 06:17:37 DEBUG : Waiting for deletions to finish 2021/02/08 06:17:37 INFO : There was nothing to transfer 2021/02/08 06:17:38 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/02/08 06:17:38 DEBUG : two: Destination found in --compare-dest, skipping 2021/02/08 06:17:38 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for checks to finish 2021/02/08 06:17:38 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/02/08 06:17:38 DEBUG : one: Destination found in --compare-dest, skipping 2021/02/08 06:17:38 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for transfers to finish 2021/02/08 06:17:38 DEBUG : Waiting for deletions to finish 2021/02/08 06:17:38 INFO : There was nothing to transfer 2021/02/08 06:17:38 DEBUG : two: Sizes differ (src 5 vs dst 3) 2021/02/08 06:17:38 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for checks to finish 2021/02/08 06:17:38 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/02/08 06:17:38 DEBUG : one: Destination found in --compare-dest, skipping 2021/02/08 06:17:38 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for transfers to finish 2021/02/08 06:17:39 DEBUG : two: SHA-1 = a4be8877ad88f3109a6411985a1f359e10e2d930 OK 2021/02/08 06:17:39 INFO : two: Copied (new) 2021/02/08 06:17:39 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCompareDest (13.99s) === RUN TestSyncCopyDest run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:17:42 DEBUG : Creating backend with remote "TestB2:rclone-test-mahaxot7xanuduj5pinariy5/dst" 2021/02/08 06:17:43 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:17:43 DEBUG : Creating backend with remote "TestB2:rclone-test-mahaxot7xanuduj5pinariy5/CopyDest" 2021/02/08 06:17:43 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:17:44 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:17:44 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for checks to finish 2021/02/08 06:17:44 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for transfers to finish 2021/02/08 06:17:45 DEBUG : one: SHA-1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/02/08 06:17:45 INFO : one: Copied (new) 2021/02/08 06:17:45 DEBUG : Waiting for deletions to finish 2021/02/08 06:17:45 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for checks to finish 2021/02/08 06:17:45 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:17:45 DEBUG : one: Sizes differ (src 5 vs dst 3) 2021/02/08 06:17:45 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for transfers to finish 2021/02/08 06:17:46 DEBUG : one: SHA-1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2021/02/08 06:17:46 INFO : one: Copied (replaced existing) 2021/02/08 06:17:46 DEBUG : Waiting for deletions to finish 2021/02/08 06:17:47 DEBUG : Creating backend with remote "TestB2:rclone-test-mahaxot7xanuduj5pinariy5/BackupDir" 2021/02/08 06:17:48 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:17:48 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for checks to finish 2021/02/08 06:17:48 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/02/08 06:17:48 DEBUG : one: Sizes differ (src 5 vs dst 3) 2021/02/08 06:17:48 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:17:49 DEBUG : one: SHA-1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/02/08 06:17:49 INFO : one: Copied (server-side copy) 2021/02/08 06:17:52 INFO : one: Deleted 2021/02/08 06:17:52 DEBUG : one: SHA-1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2021/02/08 06:17:52 INFO : one: Copied (server-side copy) 2021/02/08 06:17:52 DEBUG : one: Destination found in --copy-dest, using server-side copy 2021/02/08 06:17:52 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for transfers to finish 2021/02/08 06:17:52 DEBUG : Waiting for deletions to finish 2021/02/08 06:17:55 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/02/08 06:17:55 DEBUG : two: SHA-1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2021/02/08 06:17:55 INFO : two: Copied (server-side copy) 2021/02/08 06:17:55 DEBUG : two: Destination found in --copy-dest, using server-side copy 2021/02/08 06:17:55 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for checks to finish 2021/02/08 06:17:55 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/02/08 06:17:55 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/02/08 06:17:55 DEBUG : one: Unchanged skipping 2021/02/08 06:17:55 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for transfers to finish 2021/02/08 06:17:55 DEBUG : Waiting for deletions to finish 2021/02/08 06:17:56 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for checks to finish 2021/02/08 06:17:56 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/02/08 06:17:56 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/02/08 06:17:56 DEBUG : one: Unchanged skipping 2021/02/08 06:17:56 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/02/08 06:17:56 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/02/08 06:17:56 DEBUG : two: Unchanged skipping 2021/02/08 06:17:56 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for transfers to finish 2021/02/08 06:17:56 DEBUG : Waiting for deletions to finish 2021/02/08 06:17:56 INFO : There was nothing to transfer 2021/02/08 06:17:57 DEBUG : three: Sizes differ (src 7 vs dst 5) 2021/02/08 06:17:57 DEBUG : three: Destination not found in --copy-dest 2021/02/08 06:17:57 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for checks to finish 2021/02/08 06:17:57 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/02/08 06:17:57 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/02/08 06:17:57 DEBUG : one: Unchanged skipping 2021/02/08 06:17:57 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/02/08 06:17:57 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/02/08 06:17:57 DEBUG : two: Unchanged skipping 2021/02/08 06:17:57 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for transfers to finish 2021/02/08 06:17:58 DEBUG : three: SHA-1 = 370e613335f3cf2f19b2a2d35a86402f55c659f8 OK 2021/02/08 06:17:58 INFO : three: Copied (new) 2021/02/08 06:17:58 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCopyDest (23.64s) === RUN TestSyncBackupDir run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:18:09 DEBUG : Creating backend with remote "TestB2:rclone-test-mahaxot7xanuduj5pinariy5/dst" 2021/02/08 06:18:11 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:18:11 DEBUG : Creating backend with remote "TestB2:rclone-test-mahaxot7xanuduj5pinariy5/backup" 2021/02/08 06:18:11 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:18:11 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/02/08 06:18:11 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for checks to finish 2021/02/08 06:18:11 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/02/08 06:18:11 DEBUG : two: Unchanged skipping 2021/02/08 06:18:11 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:18:13 DEBUG : one: SHA-1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/02/08 06:18:13 INFO : one: Copied (server-side copy) 2021/02/08 06:18:14 INFO : one: Deleted 2021/02/08 06:18:14 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for transfers to finish 2021/02/08 06:18:15 DEBUG : one: SHA-1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/02/08 06:18:15 INFO : one: Copied (new) 2021/02/08 06:18:15 DEBUG : Waiting for deletions to finish 2021/02/08 06:18:15 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:18:16 DEBUG : three.txt: SHA-1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2021/02/08 06:18:16 INFO : three.txt: Copied (server-side copy) 2021/02/08 06:18:16 INFO : three.txt: Deleted 2021/02/08 06:18:16 INFO : three.txt: Moved into backup dir 2021/02/08 06:18:18 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/02/08 06:18:18 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for checks to finish 2021/02/08 06:18:18 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/02/08 06:18:18 DEBUG : two: Unchanged skipping 2021/02/08 06:18:19 DEBUG : one: SHA-1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/02/08 06:18:19 INFO : one: Copied (server-side copy) 2021/02/08 06:18:32 INFO : one: Deleted 2021/02/08 06:18:32 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for transfers to finish 2021/02/08 06:18:33 DEBUG : one: SHA-1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2021/02/08 06:18:33 INFO : one: Copied (new) 2021/02/08 06:18:33 DEBUG : Waiting for deletions to finish 2021/02/08 06:18:35 DEBUG : three.txt: SHA-1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2021/02/08 06:18:35 INFO : three.txt: Copied (server-side copy) 2021/02/08 06:18:35 INFO : three.txt: Deleted 2021/02/08 06:18:35 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDir (31.33s) === RUN TestSyncBackupDirWithSuffix run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:18:40 DEBUG : Creating backend with remote "TestB2:rclone-test-mahaxot7xanuduj5pinariy5/dst" 2021/02/08 06:18:41 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:18:41 DEBUG : Creating backend with remote "TestB2:rclone-test-mahaxot7xanuduj5pinariy5/backup" 2021/02/08 06:18:41 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:18:42 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/02/08 06:18:42 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/02/08 06:18:42 DEBUG : two: Unchanged skipping 2021/02/08 06:18:42 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for checks to finish 2021/02/08 06:18:42 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:18:45 DEBUG : one: SHA-1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/02/08 06:18:45 INFO : one: Copied (server-side copy) to: one.bak 2021/02/08 06:18:45 INFO : one: Deleted 2021/02/08 06:18:45 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for transfers to finish 2021/02/08 06:18:46 DEBUG : one: SHA-1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/02/08 06:18:46 INFO : one: Copied (new) 2021/02/08 06:18:46 DEBUG : Waiting for deletions to finish 2021/02/08 06:18:46 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:18:47 DEBUG : three.txt: SHA-1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2021/02/08 06:18:47 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2021/02/08 06:18:48 INFO : three.txt: Deleted 2021/02/08 06:18:48 INFO : three.txt: Moved into backup dir 2021/02/08 06:18:49 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/02/08 06:18:49 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for checks to finish 2021/02/08 06:18:49 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/02/08 06:18:49 DEBUG : two: Unchanged skipping 2021/02/08 06:18:50 DEBUG : one: SHA-1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/02/08 06:18:50 INFO : one: Copied (server-side copy) to: one.bak 2021/02/08 06:18:50 INFO : one: Deleted 2021/02/08 06:18:50 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for transfers to finish 2021/02/08 06:18:51 DEBUG : one: SHA-1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2021/02/08 06:18:51 INFO : one: Copied (new) 2021/02/08 06:18:51 DEBUG : Waiting for deletions to finish 2021/02/08 06:18:51 DEBUG : three.txt: SHA-1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2021/02/08 06:18:51 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2021/02/08 06:18:52 INFO : three.txt: Deleted 2021/02/08 06:18:52 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffix (16.31s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:18:57 DEBUG : Creating backend with remote "TestB2:rclone-test-mahaxot7xanuduj5pinariy5/dst" 2021/02/08 06:18:58 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:18:58 DEBUG : Creating backend with remote "TestB2:rclone-test-mahaxot7xanuduj5pinariy5/backup" 2021/02/08 06:18:59 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:18:59 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/02/08 06:18:59 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/02/08 06:18:59 DEBUG : two: Unchanged skipping 2021/02/08 06:18:59 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for checks to finish 2021/02/08 06:18:59 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:19:01 DEBUG : one: SHA-1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/02/08 06:19:01 INFO : one: Copied (server-side copy) to: one-2019-01-01 2021/02/08 06:19:02 INFO : one: Deleted 2021/02/08 06:19:02 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for transfers to finish 2021/02/08 06:19:08 DEBUG : one: SHA-1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/02/08 06:19:08 INFO : one: Copied (new) 2021/02/08 06:19:08 DEBUG : Waiting for deletions to finish 2021/02/08 06:19:09 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:19:11 DEBUG : three.txt: SHA-1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2021/02/08 06:19:11 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2021/02/08 06:19:13 INFO : three.txt: Deleted 2021/02/08 06:19:13 INFO : three.txt: Moved into backup dir 2021/02/08 06:19:14 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/02/08 06:19:14 DEBUG : two: Unchanged skipping 2021/02/08 06:19:14 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/02/08 06:19:14 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for checks to finish 2021/02/08 06:19:15 DEBUG : one: SHA-1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/02/08 06:19:15 INFO : one: Copied (server-side copy) to: one-2019-01-01 2021/02/08 06:19:16 INFO : one: Deleted 2021/02/08 06:19:16 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for transfers to finish 2021/02/08 06:19:17 DEBUG : one: SHA-1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2021/02/08 06:19:17 INFO : one: Copied (new) 2021/02/08 06:19:17 DEBUG : Waiting for deletions to finish 2021/02/08 06:19:18 DEBUG : three.txt: SHA-1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2021/02/08 06:19:18 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2021/02/08 06:19:18 INFO : three.txt: Deleted 2021/02/08 06:19:18 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffixKeepExtension (28.42s) === RUN TestSyncBackupDirSuffixOnly run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:19:26 DEBUG : Creating backend with remote "TestB2:rclone-test-mahaxot7xanuduj5pinariy5/dst" 2021/02/08 06:19:27 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:19:27 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/02/08 06:19:27 DEBUG : two: Unchanged skipping 2021/02/08 06:19:27 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/02/08 06:19:27 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for checks to finish 2021/02/08 06:19:27 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:19:28 DEBUG : one: SHA-1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/02/08 06:19:28 INFO : one: Copied (server-side copy) to: one.bak 2021/02/08 06:19:29 INFO : one: Deleted 2021/02/08 06:19:29 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for transfers to finish 2021/02/08 06:19:30 DEBUG : one: SHA-1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/02/08 06:19:30 INFO : one: Copied (new) 2021/02/08 06:19:30 DEBUG : Waiting for deletions to finish 2021/02/08 06:19:30 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:19:30 DEBUG : three.txt: SHA-1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2021/02/08 06:19:30 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2021/02/08 06:19:31 INFO : three.txt: Deleted 2021/02/08 06:19:31 INFO : three.txt: Moved into backup dir 2021/02/08 06:19:33 DEBUG : one.bak: Excluded 2021/02/08 06:19:33 DEBUG : three.txt.bak: Excluded 2021/02/08 06:19:33 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/02/08 06:19:33 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for checks to finish 2021/02/08 06:19:33 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/02/08 06:19:33 DEBUG : two: Unchanged skipping 2021/02/08 06:19:34 DEBUG : one: SHA-1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/02/08 06:19:34 INFO : one: Copied (server-side copy) to: one.bak 2021/02/08 06:19:37 INFO : one: Deleted 2021/02/08 06:19:37 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5 path dst: Waiting for transfers to finish 2021/02/08 06:19:37 DEBUG : one: SHA-1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2021/02/08 06:19:37 INFO : one: Copied (new) 2021/02/08 06:19:37 DEBUG : Waiting for deletions to finish 2021/02/08 06:19:38 DEBUG : three.txt: SHA-1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2021/02/08 06:19:38 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2021/02/08 06:19:39 INFO : three.txt: Deleted 2021/02/08 06:19:39 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirSuffixOnly (19.27s) === RUN TestSyncSuffix run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:19:44 DEBUG : Creating backend with remote "TestB2:rclone-test-mahaxot7xanuduj5pinariy5/dst" 2021/02/08 06:19:45 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:19:46 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/02/08 06:19:46 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:19:47 DEBUG : one: SHA-1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/02/08 06:19:47 INFO : one: Copied (server-side copy) to: one.bak 2021/02/08 06:19:47 INFO : one: Deleted 2021/02/08 06:19:48 DEBUG : one: SHA-1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/02/08 06:19:48 INFO : one: Copied (new) 2021/02/08 06:19:49 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/02/08 06:19:49 DEBUG : two: Unchanged skipping 2021/02/08 06:19:49 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2021/02/08 06:19:49 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:19:49 DEBUG : three.txt: SHA-1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2021/02/08 06:19:49 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2021/02/08 06:19:50 INFO : three.txt: Deleted 2021/02/08 06:19:50 DEBUG : three.txt: SHA-1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2021/02/08 06:19:50 INFO : three.txt: Copied (new) 2021/02/08 06:19:50 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/02/08 06:19:51 DEBUG : one: SHA-1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/02/08 06:19:51 INFO : one: Copied (server-side copy) to: one.bak 2021/02/08 06:19:51 INFO : one: Deleted 2021/02/08 06:19:52 DEBUG : one: SHA-1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2021/02/08 06:19:52 INFO : one: Copied (new) 2021/02/08 06:19:53 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/02/08 06:19:53 DEBUG : two: Unchanged skipping 2021/02/08 06:19:53 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2021/02/08 06:19:54 DEBUG : three.txt: SHA-1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2021/02/08 06:19:54 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2021/02/08 06:19:54 INFO : three.txt: Deleted 2021/02/08 06:19:55 DEBUG : three.txt: SHA-1 = 476e1707cbd7f0497a7dc4d44f0b07b8566ffc30 OK 2021/02/08 06:19:55 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (17.69s) === RUN TestSyncSuffixKeepExtension run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:20:02 DEBUG : Creating backend with remote "TestB2:rclone-test-mahaxot7xanuduj5pinariy5/dst" 2021/02/08 06:20:04 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:20:04 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/02/08 06:20:04 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:20:05 DEBUG : one: SHA-1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/02/08 06:20:05 INFO : one: Copied (server-side copy) to: one-2019-01-01 2021/02/08 06:20:08 INFO : one: Deleted 2021/02/08 06:20:08 DEBUG : one: SHA-1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/02/08 06:20:08 INFO : one: Copied (new) 2021/02/08 06:20:09 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/02/08 06:20:09 DEBUG : two: Unchanged skipping 2021/02/08 06:20:09 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2021/02/08 06:20:09 DEBUG : Couldn't decode error response: EOF 2021/02/08 06:20:09 DEBUG : three.txt: SHA-1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2021/02/08 06:20:09 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2021/02/08 06:20:13 INFO : three.txt: Deleted 2021/02/08 06:20:15 DEBUG : three.txt: SHA-1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2021/02/08 06:20:15 INFO : three.txt: Copied (new) 2021/02/08 06:20:16 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/02/08 06:20:24 DEBUG : one: SHA-1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/02/08 06:20:24 INFO : one: Copied (server-side copy) to: one-2019-01-01 2021/02/08 06:20:24 INFO : one: Deleted 2021/02/08 06:20:25 DEBUG : one: SHA-1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2021/02/08 06:20:25 INFO : one: Copied (new) 2021/02/08 06:20:26 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/02/08 06:20:26 DEBUG : two: Unchanged skipping 2021/02/08 06:20:26 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2021/02/08 06:20:26 DEBUG : three.txt: SHA-1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2021/02/08 06:20:26 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2021/02/08 06:20:28 INFO : three.txt: Deleted 2021/02/08 06:20:28 DEBUG : three.txt: SHA-1 = 476e1707cbd7f0497a7dc4d44f0b07b8566ffc30 OK 2021/02/08 06:20:28 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffixKeepExtension (32.15s) === RUN TestSyncUTFNorm run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:20:32 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:20:32 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2021/02/08 06:20:32 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:20:33 DEBUG : Testêé: SHA-1 = a54d88e06612d820bc3be72877c74f257b561b19 OK 2021/02/08 06:20:33 INFO : Testêé: Copied (replaced existing) to: Testêé 2021/02/08 06:20:33 DEBUG : Waiting for deletions to finish --- PASS: TestSyncUTFNorm (3.05s) === RUN TestSyncImmutable run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:20:34 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:20:34 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:20:35 DEBUG : existing: SHA-1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2021/02/08 06:20:35 INFO : existing: Copied (new) 2021/02/08 06:20:35 DEBUG : Waiting for deletions to finish 2021/02/08 06:20:36 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:20:36 DEBUG : existing: Sizes differ (src 8 vs dst 6) 2021/02/08 06:20:36 ERROR : existing: Source and destination exist but do not match: immutable file modified 2021/02/08 06:20:36 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:20:36 ERROR : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: not deleting files as there were IO errors 2021/02/08 06:20:36 ERROR : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: not deleting directories as there were IO errors --- PASS: TestSyncImmutable (2.37s) === RUN TestSyncIgnoreCase run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" 2021/02/08 06:20:37 DEBUG : existing: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/02/08 06:20:37 DEBUG : existing: Unchanged skipping 2021/02/08 06:20:37 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for checks to finish 2021/02/08 06:20:37 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Waiting for transfers to finish 2021/02/08 06:20:37 DEBUG : Waiting for deletions to finish 2021/02/08 06:20:37 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreCase (1.62s) === RUN TestMaxTransfer === RUN TestMaxTransfer/Hard run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" sync_test.go:1986: This test only runs on local === RUN TestMaxTransfer/Soft run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" sync_test.go:1986: This test only runs on local === RUN TestMaxTransfer/Cautious run.go:176: Remote "B2 bucket rclone-test-mahaxot7xanuduj5pinariy5", Local "Local file system at /tmp/rclone536930939", Modify Window "1ms" sync_test.go:1986: This test only runs on local --- PASS: TestMaxTransfer (0.91s) --- SKIP: TestMaxTransfer/Hard (0.30s) --- SKIP: TestMaxTransfer/Soft (0.30s) --- SKIP: TestMaxTransfer/Cautious (0.31s) PASS 2021/02/08 06:20:39 DEBUG : B2 bucket rclone-test-mahaxot7xanuduj5pinariy5: Purge remote 2021/02/08 06:20:39 DEBUG : BackupDir/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1129c0da7d8aee03_d20210208_m061758_c001_v0001154_t0000") 2021/02/08 06:20:39 DEBUG : BackupDir/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f109480e1a22ac084_d20210208_m061749_c001_v0001153_t0004") 2021/02/08 06:20:39 DEBUG : CompareDest/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f10294f2169a24710_d20210208_m061739_c001_v0001145_t0026") 2021/02/08 06:20:39 DEBUG : CompareDest/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f108cc4bbf6627c1b_d20210208_m061734_c001_v0001154_t0013") 2021/02/08 06:20:39 DEBUG : CompareDest/two: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1132dcd5326146d7_d20210208_m061740_c001_v0001144_t0014") 2021/02/08 06:20:39 DEBUG : CompareDest/two: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc2841dc_d20210208_m061736_c001_v0001145_t0038") 2021/02/08 06:20:39 DEBUG : CopyDest/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f119b93a7b93b896e_d20210208_m061759_c001_v0001154_t0010") 2021/02/08 06:20:39 DEBUG : CopyDest/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f108cc4bbf6627cb6_d20210208_m061747_c001_v0001154_t0013") 2021/02/08 06:20:39 DEBUG : CopyDest/three: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1151e98191d034c4_d20210208_m061759_c001_v0001154_t0013") 2021/02/08 06:20:40 DEBUG : CopyDest/three: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f11833c3f1c76e1ec_d20210208_m061757_c001_v0001091_t0032") 2021/02/08 06:20:40 DEBUG : CopyDest/two: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1041e6a7b5704165_d20210208_m061800_c001_v0001145_t0005") 2021/02/08 06:20:40 DEBUG : CopyDest/two: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc28424a_d20210208_m061753_c001_v0001145_t0038") 2021/02/08 06:20:40 DEBUG : EXISTING: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f116f96b4c4ad31c0_d20210208_m062038_c001_v0001137_t0057") 2021/02/08 06:20:40 DEBUG : EXISTING: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc2847ba_d20210208_m062036_c001_v0001145_t0038") 2021/02/08 06:20:40 DEBUG : Testêé: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1174deb7d5df284b_d20210208_m062034_c001_v0001130_t0003") 2021/02/08 06:20:40 DEBUG : Testêé: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f11833c3f1c76e30b_d20210208_m062033_c001_v0001091_t0032") 2021/02/08 06:20:41 DEBUG : Testêé: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc284798_d20210208_m062031_c001_v0001145_t0038") 2021/02/08 06:20:41 DEBUG : a/potato2: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1103cf2df08a2eb7_d20210208_m061403_c001_v0001113_t0006") 2021/02/08 06:20:41 DEBUG : a/potato2: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283c84_d20210208_m061402_c001_v0001145_t0038") 2021/02/08 06:20:41 DEBUG : a/potato2: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f106040eb6a38c75b_d20210208_m061359_c001_v0001029_t0033") 2021/02/08 06:20:41 DEBUG : a/potato2: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283c6e_d20210208_m061358_c001_v0001145_t0038") 2021/02/08 06:20:41 DEBUG : a/potato2: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f113b258d0476c591_d20210208_m061329_c001_v0001040_t0031") 2021/02/08 06:20:41 DEBUG : a/potato2: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283b81_d20210208_m061327_c001_v0001145_t0038") 2021/02/08 06:20:41 DEBUG : b/potato: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f10512edd353be467_d20210208_m061433_c001_v0001153_t0022") 2021/02/08 06:20:41 DEBUG : b/potato: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283c7c_d20210208_m061400_c001_v0001145_t0038") 2021/02/08 06:20:41 DEBUG : b/potato: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f100eefba1baa1960_d20210208_m061358_c001_v0001150_t0015") 2021/02/08 06:20:41 DEBUG : b/potato: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283c62_d20210208_m061357_c001_v0001145_t0038") 2021/02/08 06:20:41 DEBUG : b/potato: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f108859b27a116cec_d20210208_m061328_c001_v0001012_t0040") 2021/02/08 06:20:42 DEBUG : b/potato: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283b72_d20210208_m061324_c001_v0001145_t0038") 2021/02/08 06:20:42 DEBUG : backup/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1097950de32920e2_d20210208_m061836_c001_v0001131_t0024") 2021/02/08 06:20:42 DEBUG : backup/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f118bbcb23c6633af_d20210208_m061818_c001_v0001154_t0018") 2021/02/08 06:20:42 DEBUG : backup/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1010736f8a654e75_d20210208_m061813_c001_v0001145_t0048") 2021/02/08 06:20:42 DEBUG : backup/one-2019-01-01: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f11330097780926b9_d20210208_m061918_c001_v0001120_t0022") 2021/02/08 06:20:42 DEBUG : backup/one-2019-01-01: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f11403dd8d4b869bf_d20210208_m061915_c001_v0001154_t0012") 2021/02/08 06:20:42 DEBUG : backup/one-2019-01-01: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f102e543e99c96569_d20210208_m061900_c001_v0001091_t0015") 2021/02/08 06:20:42 DEBUG : backup/one.bak: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f118944a3facf9608_d20210208_m061852_c001_v0001131_t0017") 2021/02/08 06:20:42 DEBUG : backup/one.bak: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1076cdd50cddc79b_d20210208_m061850_c001_v0001154_t0008") 2021/02/08 06:20:42 DEBUG : backup/one.bak: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1195e4b763d68c71_d20210208_m061843_c001_v0001113_t0045") 2021/02/08 06:20:42 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1109c9e40e39fb07_d20210208_m061920_c001_v0001145_t0016") 2021/02/08 06:20:42 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f100e4da535c9e25d_d20210208_m061918_c001_v0001153_t0000") 2021/02/08 06:20:42 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1021bc6a0ed3e64b_d20210208_m061910_c001_v0001153_t0025") 2021/02/08 06:20:42 DEBUG : backup/three.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1155388b1c5ffe55_d20210208_m061836_c001_v0001039_t0042") 2021/02/08 06:20:42 DEBUG : backup/three.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1137cdde7dd0dfde_d20210208_m061834_c001_v0001154_t0023") 2021/02/08 06:20:42 DEBUG : backup/three.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f102eb93b1a60b554_d20210208_m061815_c001_v0001146_t0043") 2021/02/08 06:20:42 DEBUG : backup/three.txt.bak: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1151e98191d03713_d20210208_m061852_c001_v0001154_t0012") 2021/02/08 06:20:42 DEBUG : backup/three.txt.bak: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f10229c145a14383d_d20210208_m061851_c001_v0001130_t0035") 2021/02/08 06:20:42 DEBUG : backup/three.txt.bak: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f116cf6875ae67209_d20210208_m061846_c001_v0001130_t0009") 2021/02/08 06:20:42 DEBUG : c/non empty space: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1041e6a7b5703e1b_d20210208_m061433_c001_v0001145_t0056") 2021/02/08 06:20:42 DEBUG : c/non empty space: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283c80_d20210208_m061401_c001_v0001145_t0038") 2021/02/08 06:20:42 DEBUG : c/non empty space: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f111abbb94aad9b20_d20210208_m061400_c001_v0001153_t0021") 2021/02/08 06:20:42 DEBUG : c/non empty space: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283c69_d20210208_m061357_c001_v0001145_t0038") 2021/02/08 06:20:42 DEBUG : c/non empty space: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f104b3bb18b43aa11_d20210208_m061330_c001_v0001038_t0030") 2021/02/08 06:20:42 DEBUG : c/non empty space: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283b76_d20210208_m061325_c001_v0001145_t0038") 2021/02/08 06:20:43 DEBUG : check sum: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f10757f2386924950_d20210208_m061313_c001_v0001153_t0014") 2021/02/08 06:20:43 DEBUG : check sum: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283b0a_d20210208_m061312_c001_v0001145_t0038") 2021/02/08 06:20:43 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1030e4f2510e8d73_d20210208_m062028_c001_v0001134_t0005") 2021/02/08 06:20:43 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f118866950a1229eb_d20210208_m062025_c001_v0001150_t0009") 2021/02/08 06:20:43 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1137cdde7dd0e543_d20210208_m062024_c001_v0001154_t0004") 2021/02/08 06:20:43 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f118866950a12296a_d20210208_m062008_c001_v0001150_t0009") 2021/02/08 06:20:43 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1132af33f8c9d27e_d20210208_m062005_c001_v0001146_t0043") 2021/02/08 06:20:43 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc28463e_d20210208_m061959_c001_v0001145_t0038") 2021/02/08 06:20:43 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f106aabceeba2a260_d20210208_m061955_c001_v0001153_t0021") 2021/02/08 06:20:43 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1154e67c0ff39d87_d20210208_m061952_c001_v0001150_t0005") 2021/02/08 06:20:43 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f105def96408c5f49_d20210208_m061951_c001_v0001019_t0035") 2021/02/08 06:20:43 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1154e67c0ff39d68_d20210208_m061948_c001_v0001150_t0005") 2021/02/08 06:20:43 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1195958b32ede101_d20210208_m061947_c001_v0001037_t0045") 2021/02/08 06:20:43 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc284587_d20210208_m061942_c001_v0001145_t0038") 2021/02/08 06:20:43 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f119021ab6b81a1f2_d20210208_m061939_c001_v0001015_t0013") 2021/02/08 06:20:43 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1029d6d4a195f154_d20210208_m061937_c001_v0001041_t0047") 2021/02/08 06:20:43 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1075528600e2bd1e_d20210208_m061934_c001_v0001036_t0016") 2021/02/08 06:20:43 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1029d6d4a195f144_d20210208_m061929_c001_v0001041_t0047") 2021/02/08 06:20:43 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f11110dbc85395873_d20210208_m061928_c001_v0001154_t0021") 2021/02/08 06:20:43 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f108cc4bbf66280c4_d20210208_m061922_c001_v0001154_t0013") 2021/02/08 06:20:43 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1002e25b4a374d96_d20210208_m061920_c001_v0001154_t0023") 2021/02/08 06:20:43 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f10228c0d31a38dca_d20210208_m061917_c001_v0001008_t0011") 2021/02/08 06:20:43 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1087447b15db548e_d20210208_m061915_c001_v0001092_t0007") 2021/02/08 06:20:43 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f10228c0d31a38dc6_d20210208_m061903_c001_v0001008_t0011") 2021/02/08 06:20:43 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1027e4c02f75d730_d20210208_m061901_c001_v0001144_t0008") 2021/02/08 06:20:44 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f11833c3f1c76e25b_d20210208_m061854_c001_v0001091_t0032") 2021/02/08 06:20:44 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f117cc3e55b354651_d20210208_m061853_c001_v0001146_t0045") 2021/02/08 06:20:44 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1091fc2121854132_d20210208_m061851_c001_v0001154_t0010") 2021/02/08 06:20:44 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1021bc6a0ed3e58e_d20210208_m061850_c001_v0001153_t0015") 2021/02/08 06:20:44 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1091fc212185410b_d20210208_m061846_c001_v0001154_t0010") 2021/02/08 06:20:44 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1041a6a351536cf1_d20210208_m061845_c001_v0001144_t0018") 2021/02/08 06:20:44 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc284347_d20210208_m061838_c001_v0001145_t0038") 2021/02/08 06:20:44 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f109a882e13946ae5_d20210208_m061836_c001_v0001137_t0045") 2021/02/08 06:20:44 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f11503ad4fb2cbb78_d20210208_m061833_c001_v0001144_t0000") 2021/02/08 06:20:44 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1129446c94beaea5_d20210208_m061819_c001_v0001012_t0007") 2021/02/08 06:20:44 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f11503ad4fb2cbac8_d20210208_m061814_c001_v0001144_t0000") 2021/02/08 06:20:44 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f106bbd582eb926af_d20210208_m061813_c001_v0001144_t0003") 2021/02/08 06:20:44 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f108cc4bbf6627d96_d20210208_m061806_c001_v0001154_t0013") 2021/02/08 06:20:44 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1139c051ec254e8c_d20210208_m061801_c001_v0001113_t0038") 2021/02/08 06:20:44 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f10978fb187994035_d20210208_m061752_c001_v0001146_t0045") 2021/02/08 06:20:44 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f112bee49dc8f3ebf_d20210208_m061749_c001_v0001040_t0031") 2021/02/08 06:20:44 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f11833c3f1c76e1d4_d20210208_m061746_c001_v0001091_t0032") 2021/02/08 06:20:44 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f10978fb187994001_d20210208_m061745_c001_v0001146_t0004") 2021/02/08 06:20:44 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f10978fb187993ff9_d20210208_m061744_c001_v0001146_t0004") 2021/02/08 06:20:44 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1177dbb564987768_d20210208_m061741_c001_v0001154_t0021") 2021/02/08 06:20:44 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f11833c3f1c76e1af_d20210208_m061732_c001_v0001091_t0032") 2021/02/08 06:20:44 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1177aeef50c2a64c_d20210208_m061731_c001_v0001037_t0031") 2021/02/08 06:20:44 DEBUG : dst/one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1177aeef50c2a64a_d20210208_m061730_c001_v0001037_t0031") 2021/02/08 06:20:44 DEBUG : dst/one-2019-01-01: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f100e7ec4cdbfd7fe_d20210208_m062029_c001_v0001091_t0034") 2021/02/08 06:20:45 DEBUG : dst/one-2019-01-01: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1080aed48dd65191_d20210208_m062016_c001_v0001041_t0041") 2021/02/08 06:20:45 DEBUG : dst/one-2019-01-01: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f108d41d060cc4628_d20210208_m062005_c001_v0001150_t0016") 2021/02/08 06:20:45 DEBUG : dst/one.bak: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1041a6a351536f7c_d20210208_m061955_c001_v0001144_t0002") 2021/02/08 06:20:45 DEBUG : dst/one.bak: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1060834983f0cf19_d20210208_m061951_c001_v0001154_t0014") 2021/02/08 06:20:45 DEBUG : dst/one.bak: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f112a1fe1640bdc70_d20210208_m061947_c001_v0001134_t0056") 2021/02/08 06:20:45 DEBUG : dst/one.bak: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f10200882b8e763d3_d20210208_m061940_c001_v0001137_t0016") 2021/02/08 06:20:45 DEBUG : dst/one.bak: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1096095a02eb44e7_d20210208_m061933_c001_v0001130_t0003") 2021/02/08 06:20:45 DEBUG : dst/one.bak: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1032bd492f8a597e_d20210208_m061927_c001_v0001113_t0032") 2021/02/08 06:20:45 DEBUG : dst/three: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1041a6a351536b4e_d20210208_m061804_c001_v0001144_t0006") 2021/02/08 06:20:45 DEBUG : dst/three: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f10978fb187994060_d20210208_m061758_c001_v0001146_t0004") 2021/02/08 06:20:45 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1061ed6be8be24df_d20210208_m062030_c001_v0001150_t0024") 2021/02/08 06:20:45 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f103e56008737745a_d20210208_m062026_c001_v0001154_t0008") 2021/02/08 06:20:45 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f107599f442bd60b2_d20210208_m062009_c001_v0001134_t0002") 2021/02/08 06:20:45 DEBUG : dst/three.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f119302d13e0d10f8_d20210208_m062030_c001_v0001033_t0038") 2021/02/08 06:20:45 DEBUG : dst/three.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f118866950a122a00_d20210208_m062028_c001_v0001150_t0009") 2021/02/08 06:20:45 DEBUG : dst/three.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1146ced7979f8425_d20210208_m062026_c001_v0001144_t0020") 2021/02/08 06:20:45 DEBUG : dst/three.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f118866950a122995_d20210208_m062014_c001_v0001150_t0009") 2021/02/08 06:20:45 DEBUG : dst/three.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f119ebcfa9c61cdfe_d20210208_m062009_c001_v0001032_t0056") 2021/02/08 06:20:45 DEBUG : dst/three.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f108cc4bbf6628294_d20210208_m062002_c001_v0001154_t0013") 2021/02/08 06:20:46 DEBUG : dst/three.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1052e4ddd9053299_d20210208_m061956_c001_v0001146_t0016") 2021/02/08 06:20:46 DEBUG : dst/three.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1154e67c0ff39da5_d20210208_m061955_c001_v0001150_t0005") 2021/02/08 06:20:46 DEBUG : dst/three.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f106f4b7085da2eaa_d20210208_m061954_c001_v0001146_t0049") 2021/02/08 06:20:46 DEBUG : dst/three.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1154e67c0ff39d78_d20210208_m061950_c001_v0001150_t0005") 2021/02/08 06:20:46 DEBUG : dst/three.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1137cdde7dd0e3c8_d20210208_m061949_c001_v0001154_t0020") 2021/02/08 06:20:46 DEBUG : dst/three.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f108cc4bbf66281be_d20210208_m061944_c001_v0001154_t0013") 2021/02/08 06:20:46 DEBUG : dst/three.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f118b064df0985619_d20210208_m061939_c001_v0001042_t0052") 2021/02/08 06:20:46 DEBUG : dst/three.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f108cc4bbf662812e_d20210208_m061932_c001_v0001154_t0013") 2021/02/08 06:20:46 DEBUG : dst/three.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1076cdd50cddc98c_d20210208_m061930_c001_v0001154_t0014") 2021/02/08 06:20:46 DEBUG : dst/three.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f11833c3f1c76e294_d20210208_m061925_c001_v0001091_t0032") 2021/02/08 06:20:47 DEBUG : dst/three.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1000c3eacae0cc0e_d20210208_m061918_c001_v0001033_t0003") 2021/02/08 06:20:47 DEBUG : dst/three.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f11833c3f1c76e27e_d20210208_m061914_c001_v0001091_t0032") 2021/02/08 06:20:47 DEBUG : dst/three.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1075b2a36f8a2025_d20210208_m061911_c001_v0001030_t0024") 2021/02/08 06:20:47 DEBUG : dst/three.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc2843d0_d20210208_m061856_c001_v0001145_t0038") 2021/02/08 06:20:47 DEBUG : dst/three.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115a2bd8f62657f0_d20210208_m061851_c001_v0001137_t0036") 2021/02/08 06:20:47 DEBUG : dst/three.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc284394_d20210208_m061849_c001_v0001145_t0038") 2021/02/08 06:20:47 DEBUG : dst/three.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1151e98191d036cf_d20210208_m061847_c001_v0001154_t0013") 2021/02/08 06:20:47 DEBUG : dst/three.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f108cc4bbf6627f13_d20210208_m061839_c001_v0001154_t0013") 2021/02/08 06:20:47 DEBUG : dst/three.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1155388b1c5ffe54_d20210208_m061835_c001_v0001039_t0016") 2021/02/08 06:20:47 DEBUG : dst/three.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f108cc4bbf6627df4_d20210208_m061817_c001_v0001154_t0013") 2021/02/08 06:20:47 DEBUG : dst/three.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f114bda888308b243_d20210208_m061816_c001_v0001150_t0032") 2021/02/08 06:20:47 DEBUG : dst/three.txt: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f11833c3f1c76e1fa_d20210208_m061809_c001_v0001091_t0032") 2021/02/08 06:20:47 DEBUG : dst/three.txt.bak: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1022add70c8059d1_d20210208_m061958_c001_v0001131_t0053") 2021/02/08 06:20:47 DEBUG : dst/three.txt.bak: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1004e564f70c74e7_d20210208_m061953_c001_v0001144_t0039") 2021/02/08 06:20:47 DEBUG : dst/three.txt.bak: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f101a2db343c7c866_d20210208_m061949_c001_v0001033_t0009") 2021/02/08 06:20:47 DEBUG : dst/three.txt.bak: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f10756664d9ec772f_d20210208_m061940_c001_v0001137_t0043") 2021/02/08 06:20:47 DEBUG : dst/three.txt.bak: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1119e502f964809d_d20210208_m061938_c001_v0001144_t0039") 2021/02/08 06:20:48 DEBUG : dst/three.txt.bak: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f10553785c6dca1b6_d20210208_m061930_c001_v0001130_t0033") 2021/02/08 06:20:48 DEBUG : dst/two: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f101d95575c247bcc_d20210208_m062031_c001_v0001150_t0054") 2021/02/08 06:20:48 DEBUG : dst/two: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f11833c3f1c76e2d7_d20210208_m062001_c001_v0001091_t0032") 2021/02/08 06:20:48 DEBUG : dst/two: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1132dcd532614a91_d20210208_m061958_c001_v0001144_t0021") 2021/02/08 06:20:48 DEBUG : dst/two: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f11833c3f1c76e2b4_d20210208_m061943_c001_v0001091_t0032") 2021/02/08 06:20:48 DEBUG : dst/two: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f11554790ff357953_d20210208_m061941_c001_v0001146_t0059") 2021/02/08 06:20:48 DEBUG : dst/two: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc2844d7_d20210208_m061924_c001_v0001145_t0038") 2021/02/08 06:20:48 DEBUG : dst/two: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1188dbd6d2d791af_d20210208_m061921_c001_v0001144_t0025") 2021/02/08 06:20:48 DEBUG : dst/two: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f108cc4bbf6627fc0_d20210208_m061855_c001_v0001154_t0013") 2021/02/08 06:20:48 DEBUG : dst/two: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1016bdc2de04a1a9_d20210208_m061853_c001_v0001131_t0014") 2021/02/08 06:20:48 DEBUG : dst/two: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f11833c3f1c76e22c_d20210208_m061838_c001_v0001091_t0032") 2021/02/08 06:20:48 DEBUG : dst/two: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f103e4392edbb88f6_d20210208_m061837_c001_v0001150_t0038") 2021/02/08 06:20:48 DEBUG : dst/two: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc2842b6_d20210208_m061808_c001_v0001145_t0038") 2021/02/08 06:20:48 DEBUG : dst/two: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1039751fb7d613ef_d20210208_m061805_c001_v0001029_t0025") 2021/02/08 06:20:48 DEBUG : dst/two: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1132af33f8c9cf97_d20210208_m061755_c001_v0001146_t0047") 2021/02/08 06:20:48 DEBUG : dst/two: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f103d94609de406cd_d20210208_m061741_c001_v0001136_t0014") 2021/02/08 06:20:48 DEBUG : dst/two: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1177aeef50c2a652_d20210208_m061739_c001_v0001037_t0031") 2021/02/08 06:20:48 DEBUG : empty space: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f11111ce8511883e7_d20210208_m061716_c001_v0001033_t0057") 2021/02/08 06:20:48 DEBUG : empty space: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f11833c3f1c76e193_d20210208_m061710_c001_v0001091_t0032") 2021/02/08 06:20:48 DEBUG : empty space: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1100b8736e5b9314_d20210208_m061703_c001_v0001039_t0039") 2021/02/08 06:20:48 DEBUG : empty space: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f11833c3f1c76e161_d20210208_m061642_c001_v0001091_t0032") 2021/02/08 06:20:48 DEBUG : empty space: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1118079a4d4d8d2e_d20210208_m061634_c001_v0001120_t0030") 2021/02/08 06:20:48 DEBUG : empty space: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f11833c3f1c76e14c_d20210208_m061628_c001_v0001091_t0032") 2021/02/08 06:20:48 DEBUG : empty space: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1089e18a59ee9fbe_d20210208_m061532_c001_v0001137_t0037") 2021/02/08 06:20:48 DEBUG : empty space: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283e35_d20210208_m061522_c001_v0001145_t0038") 2021/02/08 06:20:49 DEBUG : empty space: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f11769414e4f86312_d20210208_m061520_c001_v0001150_t0027") 2021/02/08 06:20:49 DEBUG : empty space: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283e1b_d20210208_m061519_c001_v0001145_t0038") 2021/02/08 06:20:49 DEBUG : empty space: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f114bdbd546f7918e_d20210208_m061515_c001_v0001137_t0044") 2021/02/08 06:20:49 DEBUG : empty space: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283dd0_d20210208_m061509_c001_v0001145_t0038") 2021/02/08 06:20:49 DEBUG : empty space: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f10336ffb4d10b5c8_d20210208_m061506_c001_v0001153_t0020") 2021/02/08 06:20:49 DEBUG : empty space: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283d2c_d20210208_m061435_c001_v0001145_t0038") 2021/02/08 06:20:49 DEBUG : empty space: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1061ed6be8be1700_d20210208_m061355_c001_v0001150_t0047") 2021/02/08 06:20:49 DEBUG : empty space: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283c30_d20210208_m061353_c001_v0001145_t0038") 2021/02/08 06:20:49 DEBUG : empty space: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f102219b9c8b3eb3a_d20210208_m061351_c001_v0001040_t0022") 2021/02/08 06:20:49 DEBUG : empty space: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283c1c_d20210208_m061350_c001_v0001145_t0038") 2021/02/08 06:20:49 DEBUG : empty space: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1129c0da7d8ae44d_d20210208_m061343_c001_v0001154_t0019") 2021/02/08 06:20:49 DEBUG : empty space: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283bd0_d20210208_m061340_c001_v0001145_t0038") 2021/02/08 06:20:49 DEBUG : empty space: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115f005397f499d8_d20210208_m061337_c001_v0001153_t0023") 2021/02/08 06:20:49 DEBUG : empty space: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283bb3_d20210208_m061336_c001_v0001145_t0038") 2021/02/08 06:20:49 DEBUG : empty space: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f10200882b8e75f89_d20210208_m061335_c001_v0001137_t0053") 2021/02/08 06:20:49 DEBUG : empty space: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f108d41d060cc3a77_d20210208_m061334_c001_v0001150_t0034") 2021/02/08 06:20:49 DEBUG : empty space: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283b95_d20210208_m061331_c001_v0001145_t0038") 2021/02/08 06:20:49 DEBUG : enormous: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f106aabceeba2930d_d20210208_m061524_c001_v0001153_t0009") 2021/02/08 06:20:49 DEBUG : enormous: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283e3d_d20210208_m061523_c001_v0001145_t0038") 2021/02/08 06:20:49 DEBUG : existing: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f103238d2337a7b40_d20210208_m062036_c001_v0001130_t0013") 2021/02/08 06:20:49 DEBUG : existing: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f108cc4bbf66283f4_d20210208_m062035_c001_v0001154_t0013") 2021/02/08 06:20:49 DEBUG : existing: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1192f2d73ec742d1_d20210208_m061323_c001_v0001144_t0059") 2021/02/08 06:20:49 DEBUG : existing: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283b4e_d20210208_m061321_c001_v0001145_t0038") 2021/02/08 06:20:49 DEBUG : existing: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f111abbb94aad9926_d20210208_m061320_c001_v0001153_t0022") 2021/02/08 06:20:49 DEBUG : existing: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283b3f_d20210208_m061319_c001_v0001145_t0038") 2021/02/08 06:20:50 DEBUG : existing: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283b33_d20210208_m061318_c001_v0001145_t0038") 2021/02/08 06:20:50 DEBUG : five: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115167b18a3e6a98_d20210208_m061538_c001_v0001033_t0044") 2021/02/08 06:20:50 DEBUG : five: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f11833c3f1c76e0e7_d20210208_m061535_c001_v0001091_t0032") 2021/02/08 06:20:50 DEBUG : foo: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f108d41d060cc3ab4_d20210208_m061340_c001_v0001150_t0046") 2021/02/08 06:20:50 DEBUG : foo: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283bca_d20210208_m061339_c001_v0001145_t0038") 2021/02/08 06:20:50 DEBUG : foo: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283bbf_d20210208_m061337_c001_v0001145_t0038") 2021/02/08 06:20:50 DEBUG : four: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1019d30a4501b68e_d20210208_m061538_c001_v0001154_t0013") 2021/02/08 06:20:50 DEBUG : four: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283e8c_d20210208_m061535_c001_v0001145_t0038") 2021/02/08 06:20:50 DEBUG : four: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283e81_d20210208_m061534_c001_v0001145_t0038") 2021/02/08 06:20:50 DEBUG : hello world2: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f118e2197a4c0009a_d20210208_m061249_c001_v0001022_t0053") 2021/02/08 06:20:50 DEBUG : hello world2: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283a58_d20210208_m061248_c001_v0001145_t0038") 2021/02/08 06:20:50 DEBUG : ignore-size: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f10400b111a61aed7_d20210208_m061318_c001_v0001154_t0023") 2021/02/08 06:20:50 DEBUG : ignore-size: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283b28_d20210208_m061317_c001_v0001145_t0038") 2021/02/08 06:20:50 DEBUG : nested/sub dir/file: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1108bd8026748f2f_d20210208_m061624_c001_v0001144_t0056") 2021/02/08 06:20:50 DEBUG : nested/sub dir/file: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f108cc4bbf66278e2_d20210208_m061622_c001_v0001154_t0013") 2021/02/08 06:20:50 DEBUG : nested/sub dir/file: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f118250222ad60164_d20210208_m061620_c001_v0001137_t0000") 2021/02/08 06:20:50 DEBUG : nested/sub dir/file: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f108cc4bbf66278bc_d20210208_m061619_c001_v0001154_t0013") 2021/02/08 06:20:50 DEBUG : one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f10438c0fc70c2698_d20210208_m061539_c001_v0001150_t0058") 2021/02/08 06:20:50 DEBUG : one: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283e72_d20210208_m061532_c001_v0001145_t0038") 2021/02/08 06:20:50 DEBUG : potato: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1188dbd6d2d78bd0_d20210208_m061604_c001_v0001144_t0048") 2021/02/08 06:20:50 DEBUG : potato: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f108cc4bbf6627795_d20210208_m061601_c001_v0001154_t0013") 2021/02/08 06:20:50 DEBUG : potato: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f10003c8d3ed4cd7e_d20210208_m061558_c001_v0001090_t0026") 2021/02/08 06:20:50 DEBUG : potato: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283f1e_d20210208_m061555_c001_v0001145_t0038") 2021/02/08 06:20:50 DEBUG : potato: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f114bda888308ae97_d20210208_m061554_c001_v0001150_t0041") 2021/02/08 06:20:50 DEBUG : potato: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f11833c3f1c76e0f2_d20210208_m061541_c001_v0001091_t0032") 2021/02/08 06:20:50 DEBUG : potato: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f107e8f9e0f08fa4f_d20210208_m061517_c001_v0001150_t0044") 2021/02/08 06:20:51 DEBUG : potato: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283dfd_d20210208_m061516_c001_v0001145_t0038") 2021/02/08 06:20:51 DEBUG : potato: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1127e2478db699d3_d20210208_m061510_c001_v0001039_t0026") 2021/02/08 06:20:51 DEBUG : potato: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283dc8_d20210208_m061508_c001_v0001145_t0038") 2021/02/08 06:20:51 DEBUG : potato: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f107e8f9e0f08f9f5_d20210208_m061506_c001_v0001150_t0019") 2021/02/08 06:20:51 DEBUG : potato: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283d26_d20210208_m061434_c001_v0001145_t0038") 2021/02/08 06:20:51 DEBUG : potato: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1119e502f96473a5_d20210208_m061354_c001_v0001144_t0041") 2021/02/08 06:20:51 DEBUG : potato: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283c2e_d20210208_m061353_c001_v0001145_t0038") 2021/02/08 06:20:51 DEBUG : potato: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f11369f17f180b83a_d20210208_m061352_c001_v0001145_t0047") 2021/02/08 06:20:51 DEBUG : potato: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283c17_d20210208_m061350_c001_v0001145_t0038") 2021/02/08 06:20:51 DEBUG : potato: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f118bbcb23c662395_d20210208_m061349_c001_v0001154_t0001") 2021/02/08 06:20:51 DEBUG : potato: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283c0e_d20210208_m061348_c001_v0001145_t0038") 2021/02/08 06:20:51 DEBUG : potato: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283c00_d20210208_m061347_c001_v0001145_t0038") 2021/02/08 06:20:51 DEBUG : potato: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115f005397f49a42_d20210208_m061346_c001_v0001153_t0008") 2021/02/08 06:20:51 DEBUG : potato: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283bf3_d20210208_m061345_c001_v0001145_t0038") 2021/02/08 06:20:51 DEBUG : potato: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283bef_d20210208_m061344_c001_v0001145_t0038") 2021/02/08 06:20:51 DEBUG : potato: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1086a80f15f254c3_d20210208_m061343_c001_v0001145_t0013") 2021/02/08 06:20:51 DEBUG : potato: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283bd7_d20210208_m061341_c001_v0001145_t0038") 2021/02/08 06:20:51 DEBUG : potato2: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1041a6a3515369e6_d20210208_m061727_c001_v0001144_t0001") 2021/02/08 06:20:51 DEBUG : potato2: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc284179_d20210208_m061726_c001_v0001145_t0038") 2021/02/08 06:20:51 DEBUG : potato2: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f103ba8dd533fcdfe_d20210208_m061716_c001_v0001044_t0007") 2021/02/08 06:20:51 DEBUG : potato2: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc28410a_d20210208_m061708_c001_v0001145_t0038") 2021/02/08 06:20:51 DEBUG : potato2: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f114b99097f6fb375_d20210208_m061649_c001_v0001037_t0058") 2021/02/08 06:20:51 DEBUG : potato2: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc28406c_d20210208_m061641_c001_v0001145_t0038") 2021/02/08 06:20:51 DEBUG : potato2: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f102eb93b1a60b36a_d20210208_m061634_c001_v0001146_t0027") 2021/02/08 06:20:52 DEBUG : potato2: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc28400e_d20210208_m061626_c001_v0001145_t0038") 2021/02/08 06:20:52 DEBUG : potato2: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115b7506cc168475_d20210208_m061524_c001_v0001019_t0006") 2021/02/08 06:20:52 DEBUG : potato2: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283e31_d20210208_m061522_c001_v0001145_t0038") 2021/02/08 06:20:52 DEBUG : potato2: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1046da6dc480e73d_d20210208_m061521_c001_v0001042_t0008") 2021/02/08 06:20:52 DEBUG : potato2: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283e15_d20210208_m061519_c001_v0001145_t0038") 2021/02/08 06:20:52 DEBUG : potato2: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f106f4a727e651ac1_d20210208_m061518_c001_v0001036_t0024") 2021/02/08 06:20:52 DEBUG : potato2: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283e06_d20210208_m061517_c001_v0001145_t0038") 2021/02/08 06:20:52 DEBUG : potato2: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f11442eb7bc18c5d2_d20210208_m061515_c001_v0001120_t0053") 2021/02/08 06:20:52 DEBUG : potato2: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283dea_d20210208_m061514_c001_v0001145_t0038") 2021/02/08 06:20:52 DEBUG : potato2: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1021bc6a0ed3dae0_d20210208_m061507_c001_v0001153_t0017") 2021/02/08 06:20:52 DEBUG : potato2: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283d32_d20210208_m061436_c001_v0001145_t0038") 2021/02/08 06:20:52 DEBUG : potato2: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1083b8e0bb4b73b1_d20210208_m061356_c001_v0001144_t0003") 2021/02/08 06:20:52 DEBUG : potato2: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283c3e_d20210208_m061354_c001_v0001145_t0038") 2021/02/08 06:20:52 DEBUG : potato2: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1119854fa9738e88_d20210208_m061253_c001_v0001093_t0025") 2021/02/08 06:20:52 DEBUG : potato2: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283a71_d20210208_m061252_c001_v0001145_t0038") 2021/02/08 06:20:52 DEBUG : potato2: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f112a1fe1640bd69d_d20210208_m061251_c001_v0001134_t0054") 2021/02/08 06:20:52 DEBUG : potato2: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283a62_d20210208_m061250_c001_v0001145_t0038") 2021/02/08 06:20:52 DEBUG : potato3: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f10924d168b0c48da_d20210208_m061716_c001_v0001038_t0009") 2021/02/08 06:20:52 DEBUG : potato3: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f108cc4bbf6627b1d_d20210208_m061712_c001_v0001154_t0013") 2021/02/08 06:20:52 DEBUG : potato3: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f116f96b4c4ad2eb4_d20210208_m061649_c001_v0001137_t0052") 2021/02/08 06:20:52 DEBUG : potato3: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f108cc4bbf6627a0e_d20210208_m061645_c001_v0001154_t0013") 2021/02/08 06:20:52 DEBUG : potato3: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1019d30a4501b8fc_d20210208_m061634_c001_v0001154_t0016") 2021/02/08 06:20:52 DEBUG : potato3: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f108cc4bbf6627943_d20210208_m061629_c001_v0001154_t0013") 2021/02/08 06:20:52 DEBUG : sizeonly: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f109b84f53b1e05e6_d20210208_m061316_c001_v0001090_t0027") 2021/02/08 06:20:52 DEBUG : sizeonly: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283b1a_d20210208_m061314_c001_v0001145_t0038") 2021/02/08 06:20:52 DEBUG : sub dir/hello world: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f11025f23454769bb_d20210208_m061625_c001_v0001120_t0053") 2021/02/08 06:20:53 DEBUG : sub dir/hello world: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f11833c3f1c76e13f_d20210208_m061622_c001_v0001091_t0032") 2021/02/08 06:20:53 DEBUG : sub dir/hello world: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f119400f907c48303_d20210208_m061621_c001_v0001044_t0010") 2021/02/08 06:20:53 DEBUG : sub dir/hello world: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283fe3_d20210208_m061619_c001_v0001145_t0038") 2021/02/08 06:20:53 DEBUG : sub dir/hello world: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f10947c374a54dc1f_d20210208_m061311_c001_v0001144_t0002") 2021/02/08 06:20:53 DEBUG : sub dir/hello world: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283afa_d20210208_m061310_c001_v0001145_t0038") 2021/02/08 06:20:53 DEBUG : sub dir/hello world: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f111f17ee7bb6d62f_d20210208_m061309_c001_v0001150_t0006") 2021/02/08 06:20:53 DEBUG : sub dir/hello world: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283af2_d20210208_m061308_c001_v0001145_t0038") 2021/02/08 06:20:53 DEBUG : sub dir/hello world: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1155388b1c5ffd5c_d20210208_m061301_c001_v0001039_t0029") 2021/02/08 06:20:53 DEBUG : sub dir/hello world: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283aa7_d20210208_m061259_c001_v0001145_t0038") 2021/02/08 06:20:53 DEBUG : sub dir/hello world: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1083b8e0bb4b716b_d20210208_m061258_c001_v0001144_t0033") 2021/02/08 06:20:53 DEBUG : sub dir/hello world: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283a94_d20210208_m061257_c001_v0001145_t0038") 2021/02/08 06:20:53 DEBUG : sub dir/hello world: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f11110dbc85394348_d20210208_m061256_c001_v0001154_t0009") 2021/02/08 06:20:53 DEBUG : sub dir/hello world: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283a86_d20210208_m061255_c001_v0001145_t0038") 2021/02/08 06:20:53 DEBUG : sub dir/hello world: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f110aca3c0385ca3f_d20210208_m061254_c001_v0001093_t0036") 2021/02/08 06:20:53 DEBUG : sub dir/hello world: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283a7e_d20210208_m061253_c001_v0001145_t0038") 2021/02/08 06:20:53 DEBUG : sub dir/hello world: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f11653b5db97f8c0a_d20210208_m061247_c001_v0001144_t0015") 2021/02/08 06:20:53 DEBUG : sub dir/hello world: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283a4e_d20210208_m061246_c001_v0001145_t0038") 2021/02/08 06:20:53 DEBUG : sub dir/hello world: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f117f70968e1ef7d1_d20210208_m061245_c001_v0001090_t0057") 2021/02/08 06:20:53 DEBUG : sub dir/hello world: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283a42_d20210208_m061244_c001_v0001145_t0038") 2021/02/08 06:20:53 DEBUG : sub dir/hello world: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1171cb33c1a302c3_d20210208_m061243_c001_v0001137_t0020") 2021/02/08 06:20:53 DEBUG : sub dir/hello world: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283a3c_d20210208_m061242_c001_v0001145_t0038") 2021/02/08 06:20:53 DEBUG : sub dir/hello world: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f116b934b068249e7_d20210208_m061241_c001_v0001131_t0017") 2021/02/08 06:20:53 DEBUG : sub dir/hello world: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283a32_d20210208_m061240_c001_v0001145_t0038") 2021/02/08 06:20:53 DEBUG : sub/yam: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1019d30a4501b7cc_d20210208_m061604_c001_v0001154_t0002") 2021/02/08 06:20:54 DEBUG : sub/yam: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f11833c3f1c76e119_d20210208_m061601_c001_v0001091_t0032") 2021/02/08 06:20:54 DEBUG : three: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f108ec42680d5f4b6_d20210208_m061540_c001_v0001043_t0008") 2021/02/08 06:20:54 DEBUG : three: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283e9f_d20210208_m061537_c001_v0001145_t0038") 2021/02/08 06:20:54 DEBUG : three: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283e7c_d20210208_m061533_c001_v0001145_t0038") 2021/02/08 06:20:54 DEBUG : two: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1188dbd6d2d78b1a_d20210208_m061540_c001_v0001144_t0002") 2021/02/08 06:20:54 DEBUG : two: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f108cc4bbf6627635_d20210208_m061535_c001_v0001154_t0013") 2021/02/08 06:20:54 DEBUG : two: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f115ae9bcdc283e76_d20210208_m061533_c001_v0001145_t0038") 2021/02/08 06:20:54 DEBUG : yam: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f10994d8b19c27b9c_d20210208_m061605_c001_v0001113_t0042") 2021/02/08 06:20:54 DEBUG : yam: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1151e98191d02fc9_d20210208_m061603_c001_v0001154_t0003") 2021/02/08 06:20:54 DEBUG : yam: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f10336ffb4d10b878_d20210208_m061557_c001_v0001153_t0020") 2021/02/08 06:20:54 DEBUG : yam: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f11833c3f1c76e10c_d20210208_m061555_c001_v0001091_t0032") 2021/02/08 06:20:54 DEBUG : yam: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f10947c374a54e2c3_d20210208_m061553_c001_v0001144_t0009") 2021/02/08 06:20:54 DEBUG : yam: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f108cc4bbf6627687_d20210208_m061541_c001_v0001154_t0013") 2021/02/08 06:20:54 DEBUG : yaml: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f117e8b247ddd88c4_d20210208_m061559_c001_v0001029_t0043") 2021/02/08 06:20:54 DEBUG : yaml: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f118f188f9c4cc35d_d20210208_m061557_c001_v0001145_t0015") 2021/02/08 06:20:54 DEBUG : yaml: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f10757f2386924e51_d20210208_m061554_c001_v0001153_t0019") 2021/02/08 06:20:54 DEBUG : yaml: Deleting (id "4_z3fb24d43405d8b0b7f780e1b_f1061679f53d61a41_d20210208_m061543_c001_v0001006_t0022") "./sync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose" - Finished OK in 8m17.683833255s (try 1/5)