"./sync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -fast-list" - Starting (try 1/5) 2022/01/12 06:00:03 DEBUG : Creating backend with remote "TestB2:rclone-test-kaxosol9pagerad4qasoqib6" 2022/01/12 06:00:03 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2022/01/12 06:00:04 DEBUG : Creating backend with remote "/tmp/rclone4102840195" === RUN TestPipe --- PASS: TestPipe (0.00s) === RUN TestPipeConcurrent --- PASS: TestPipeConcurrent (0.02s) === 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:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:00:06 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11) 2022/01/12 06:00:06 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:00:06 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish --- PASS: TestCopyWithDryRun (1.81s) === RUN TestCopy run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:00:06 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:00:06 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:00:08 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/01/12 06:00:08 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopy (3.21s) === RUN TestCopyMissingDirectory run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:00:09 DEBUG : Creating backend with remote "/non-existing" 2022/01/12 06:00:09 DEBUG : Config file has changed externaly - reloading 2022/01/12 06:00:10 ERROR : Local file system at /non-existing: error reading source root directory: directory not found 2022/01/12 06:00:10 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:00:10 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish --- PASS: TestCopyMissingDirectory (0.61s) === RUN TestCopyNoTraverse run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:00:11 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:00:11 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:00:11 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:00:11 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/01/12 06:00:11 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyNoTraverse (3.90s) === RUN TestCopyCheckFirst run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:00:14 INFO : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Running all checks before starting transfers 2022/01/12 06:00:14 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:00:14 INFO : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Checks finished, now starting transfers 2022/01/12 06:00:14 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:00:16 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/01/12 06:00:16 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyCheckFirst (2.61s) === RUN TestSyncNoTraverse run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:00:17 ERROR : Ignoring --no-traverse with sync 2022/01/12 06:00:17 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:00:17 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:00:17 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/01/12 06:00:17 INFO : sub dir/hello world: Copied (new) 2022/01/12 06:00:17 DEBUG : Waiting for deletions to finish --- PASS: TestSyncNoTraverse (2.15s) === RUN TestCopyWithDepth run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:00:19 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:00:19 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:00:20 DEBUG : hello world2: sha1 = c0bf117f9c93d02c894fe8ffd6e5cecf3545c209 OK 2022/01/12 06:00:20 INFO : hello world2: Copied (new) --- PASS: TestCopyWithDepth (1.84s) === RUN TestCopyWithFilesFrom run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:00:21 DEBUG : hello world2: Excluded 2022/01/12 06:00:21 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:00:21 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:00:24 DEBUG : potato2: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/01/12 06:00:24 INFO : potato2: Copied (new) --- PASS: TestCopyWithFilesFrom (4.09s) === RUN TestCopyWithFilesFromAndNoTraverse run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:00:25 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:00:25 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:00:25 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:00:29 DEBUG : potato2: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/01/12 06:00:29 INFO : potato2: Copied (new) --- PASS: TestCopyWithFilesFromAndNoTraverse (5.22s) === RUN TestCopyEmptyDirectories run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:00:30 DEBUG : sub dir2: Making directory 2022/01/12 06:00:30 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:00:30 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:00:30 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/01/12 06:00:30 INFO : sub dir/hello world: Copied (new) 2022/01/12 06:00:30 DEBUG : sub dir2: Making directory 2022/01/12 06:00:30 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: copied 1 directories fstest.go:251: Filtering empty directory "sub dir2" --- PASS: TestCopyEmptyDirectories (2.60s) === RUN TestMoveEmptyDirectories run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:00:32 DEBUG : sub dir2: Making directory 2022/01/12 06:00:33 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:00:33 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:00:33 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/01/12 06:00:33 INFO : sub dir/hello world: Copied (new) 2022/01/12 06:00:33 INFO : sub dir/hello world: Deleted 2022/01/12 06:00:33 DEBUG : sub dir: Making directory 2022/01/12 06:00:33 DEBUG : sub dir2: Making directory 2022/01/12 06:00:33 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: copied 2 directories fstest.go:251: Filtering empty directory "sub dir2" --- PASS: TestMoveEmptyDirectories (2.74s) === RUN TestSyncEmptyDirectories run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:00:35 DEBUG : sub dir2: Making directory 2022/01/12 06:00:35 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:00:35 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:00:38 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/01/12 06:00:38 INFO : sub dir/hello world: Copied (new) 2022/01/12 06:00:38 DEBUG : sub dir2: Making directory 2022/01/12 06:00:38 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: copied 1 directories 2022/01/12 06:00:38 DEBUG : Waiting for deletions to finish fstest.go:251: Filtering empty directory "sub dir2" --- PASS: TestSyncEmptyDirectories (3.71s) === RUN TestServerSideCopy run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:00:40 DEBUG : Creating backend with remote "TestB2:rclone-test-dixetoh2qihumik9vagumir4" sync_test.go:275: Server side copy (if possible) B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 -> B2 bucket rclone-test-dixetoh2qihumik9vagumir4 2022/01/12 06:00:41 DEBUG : B2 bucket rclone-test-dixetoh2qihumik9vagumir4: Waiting for checks to finish 2022/01/12 06:00:41 DEBUG : B2 bucket rclone-test-dixetoh2qihumik9vagumir4: Waiting for transfers to finish 2022/01/12 06:00:43 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/01/12 06:00:43 INFO : sub dir/hello world: Copied (server-side copy) 2022/01/12 06:00:43 DEBUG : B2 bucket rclone-test-dixetoh2qihumik9vagumir4: Purge remote 2022/01/12 06:00:44 DEBUG : sub dir/hello world: Deleting (id "4_z5f12cdb3d0fd4bcb7fe80e1b_f11090b2f6d844800_d20220112_m060042_c001_v0001109_t0034") --- PASS: TestServerSideCopy (6.53s) === RUN TestCopyAfterDelete run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:00:47 ERROR : : error listing: directory not found 2022/01/12 06:00:47 DEBUG : Local file system at /tmp/rclone4102840195: Making directory 2022/01/12 06:00:47 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:00:47 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish --- PASS: TestCopyAfterDelete (3.24s) === RUN TestCopyRedownload run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:00:52 DEBUG : Local file system at /tmp/rclone4102840195: Waiting for checks to finish 2022/01/12 06:00:52 DEBUG : Local file system at /tmp/rclone4102840195: Waiting for transfers to finish 2022/01/12 06:00:53 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/01/12 06:00:53 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyRedownload (5.58s) === RUN TestSyncBasedOnCheckSum run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:00:54 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:00:54 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:00:55 DEBUG : check sum: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2022/01/12 06:00:55 INFO : check sum: Copied (new) 2022/01/12 06:00:55 DEBUG : Waiting for deletions to finish 2022/01/12 06:00:55 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:00:55 DEBUG : check sum: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2022/01/12 06:00:55 DEBUG : check sum: Size and sha1 of src and dst objects identical 2022/01/12 06:00:55 DEBUG : check sum: Unchanged skipping 2022/01/12 06:00:55 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:00:55 DEBUG : Waiting for deletions to finish 2022/01/12 06:00:55 INFO : There was nothing to transfer --- PASS: TestSyncBasedOnCheckSum (2.39s) === RUN TestSyncSizeOnly run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:00:57 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:00:57 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:00:57 DEBUG : sizeonly: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2022/01/12 06:00:57 INFO : sizeonly: Copied (new) 2022/01/12 06:00:57 DEBUG : Waiting for deletions to finish 2022/01/12 06:00:58 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:00:58 DEBUG : sizeonly: Sizes identical 2022/01/12 06:00:58 DEBUG : sizeonly: Unchanged skipping 2022/01/12 06:00:58 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:00:58 DEBUG : Waiting for deletions to finish 2022/01/12 06:00:58 INFO : There was nothing to transfer --- PASS: TestSyncSizeOnly (4.80s) === RUN TestSyncIgnoreSize run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:01:02 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:01:02 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:01:03 DEBUG : ignore-size: sha1 = 4a756ca07e9487f482465a99e8286abc86ba4dc7 OK 2022/01/12 06:01:03 INFO : ignore-size: Copied (new) 2022/01/12 06:01:03 DEBUG : Waiting for deletions to finish 2022/01/12 06:01:03 DEBUG : ignore-size: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:01:03 DEBUG : ignore-size: Unchanged skipping 2022/01/12 06:01:03 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:01:03 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:01:03 DEBUG : Waiting for deletions to finish 2022/01/12 06:01:03 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreSize (2.64s) === RUN TestSyncIgnoreTimes run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:01:06 DEBUG : existing: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:01:06 DEBUG : existing: Unchanged skipping 2022/01/12 06:01:06 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:01:06 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:01:06 DEBUG : Waiting for deletions to finish 2022/01/12 06:01:06 INFO : There was nothing to transfer 2022/01/12 06:01:06 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:01:06 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2022/01/12 06:01:06 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:01:07 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2022/01/12 06:01:07 INFO : existing: Copied (replaced existing) 2022/01/12 06:01:07 DEBUG : Waiting for deletions to finish --- PASS: TestSyncIgnoreTimes (3.49s) === RUN TestSyncIgnoreExisting run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:01:08 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:01:08 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:01:09 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2022/01/12 06:01:09 INFO : existing: Copied (new) 2022/01/12 06:01:09 DEBUG : Waiting for deletions to finish 2022/01/12 06:01:09 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:01:09 DEBUG : existing: Destination exists, skipping 2022/01/12 06:01:09 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:01:09 DEBUG : Waiting for deletions to finish 2022/01/12 06:01:09 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreExisting (2.36s) === RUN TestSyncIgnoreErrors run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:01:12 DEBUG : d: Making directory fstest.go:251: Filtering empty directory "d" 2022/01/12 06:01:12 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/12 06:01:12 DEBUG : c/non empty space: Unchanged skipping 2022/01/12 06:01:12 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:01:12 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:01:14 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/01/12 06:01:14 INFO : a/potato2: Copied (new) 2022/01/12 06:01:14 DEBUG : Waiting for deletions to finish 2022/01/12 06:01:14 INFO : b/potato: Deleted --- PASS: TestSyncIgnoreErrors (6.16s) === RUN TestSyncAfterChangingModtimeOnly run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:01:18 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:01:18 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 2022/01/12 06:01:18 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2022/01/12 06:01:18 NOTICE: empty space: Skipped update modification time as --dry-run is set (size 1) 2022/01/12 06:01:18 DEBUG : empty space: Unchanged skipping 2022/01/12 06:01:18 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:01:18 DEBUG : Waiting for deletions to finish 2022/01/12 06:01:18 INFO : There was nothing to transfer 2022/01/12 06:01:18 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 2022/01/12 06:01:18 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:01:18 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2022/01/12 06:01:21 INFO : empty space: Updated modification time in destination 2022/01/12 06:01:21 DEBUG : empty space: Unchanged skipping 2022/01/12 06:01:21 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:01:21 DEBUG : Waiting for deletions to finish 2022/01/12 06:01:21 INFO : There was nothing to transfer --- PASS: TestSyncAfterChangingModtimeOnly (6.07s) === RUN TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:01:23 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 2022/01/12 06:01:23 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:01:23 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2022/01/12 06:01:23 DEBUG : empty space: Unchanged skipping 2022/01/12 06:01:23 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:01:23 DEBUG : Waiting for deletions to finish 2022/01/12 06:01:23 INFO : There was nothing to transfer --- PASS: TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime (2.63s) === RUN TestSyncDoesntUpdateModtime run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:01:26 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:01:26 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 2022/01/12 06:01:26 DEBUG : foo: sha1 = 0beec7b5ea3f0fdbc95d0dd47f3c5bc275da8a33 (Local file system at /tmp/rclone4102840195) 2022/01/12 06:01:26 DEBUG : foo: sha1 = 62cdb7020ff920e5aa642c3d4066950dd1f01f4d (B2 bucket rclone-test-kaxosol9pagerad4qasoqib6) 2022/01/12 06:01:26 DEBUG : foo: sha1 differ 2022/01/12 06:01:26 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:01:27 DEBUG : foo: sha1 = 0beec7b5ea3f0fdbc95d0dd47f3c5bc275da8a33 OK 2022/01/12 06:01:27 INFO : foo: Copied (replaced existing) 2022/01/12 06:01:27 DEBUG : Waiting for deletions to finish --- PASS: TestSyncDoesntUpdateModtime (3.06s) === RUN TestSyncAfterAddingAFile run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:01:29 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:01:29 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/12 06:01:29 DEBUG : empty space: Unchanged skipping 2022/01/12 06:01:29 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:01:31 DEBUG : potato: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/01/12 06:01:31 INFO : potato: Copied (new) 2022/01/12 06:01:31 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterAddingAFile (7.01s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:01:36 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:01:36 DEBUG : potato: Sizes differ (src 21 vs dst 60) 2022/01/12 06:01:36 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:01:37 DEBUG : potato: sha1 = 0fd321a1023ac4e1e1054fcc0236b9d0755f722f OK 2022/01/12 06:01:37 INFO : potato: Copied (replaced existing) 2022/01/12 06:01:37 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingFilesSizeOnly (4.36s) === RUN TestSyncAfterChangingContentsOnly run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:01:41 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:01:41 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 2022/01/12 06:01:41 DEBUG : potato: sha1 = 1ca5094b3b73f587249eabe179c40a3eec839b1f (Local file system at /tmp/rclone4102840195) 2022/01/12 06:01:41 DEBUG : potato: sha1 = 0fd321a1023ac4e1e1054fcc0236b9d0755f722f (B2 bucket rclone-test-kaxosol9pagerad4qasoqib6) 2022/01/12 06:01:41 DEBUG : potato: sha1 differ 2022/01/12 06:01:41 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:01:41 DEBUG : potato: sha1 = 1ca5094b3b73f587249eabe179c40a3eec839b1f OK 2022/01/12 06:01:41 INFO : potato: Copied (replaced existing) 2022/01/12 06:01:41 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingContentsOnly (4.61s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:01:46 NOTICE: potato2: Skipped copy as --dry-run is set (size 60) 2022/01/12 06:01:46 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:01:46 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/12 06:01:46 DEBUG : empty space: Unchanged skipping 2022/01/12 06:01:46 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:01:46 DEBUG : Waiting for deletions to finish 2022/01/12 06:01:46 NOTICE: potato: Skipped delete as --dry-run is set (size 21) --- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (5.47s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:01:51 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/12 06:01:51 DEBUG : empty space: Unchanged skipping 2022/01/12 06:01:51 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:01:51 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:01:52 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/01/12 06:01:52 INFO : potato2: Copied (new) 2022/01/12 06:01:52 DEBUG : Waiting for deletions to finish 2022/01/12 06:01:52 INFO : potato: Deleted --- PASS: TestSyncAfterRemovingAFileAndAddingAFile (5.16s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:01:56 DEBUG : d: Making directory 2022/01/12 06:01:56 DEBUG : d/e: Making directory fstest.go:251: Filtering empty directory "d" fstest.go:251: Filtering empty directory "d/e" 2022/01/12 06:01:56 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/12 06:01:56 DEBUG : c/non empty space: Unchanged skipping 2022/01/12 06:01:56 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:01:56 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:01:57 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/01/12 06:01:57 INFO : a/potato2: Copied (new) 2022/01/12 06:01:57 DEBUG : Waiting for deletions to finish 2022/01/12 06:01:58 INFO : b/potato: Deleted --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (8.15s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:02:05 DEBUG : d: Making directory fstest.go:251: Filtering empty directory "d" 2022/01/12 06:02:05 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:02:05 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/12 06:02:05 DEBUG : c/non empty space: Unchanged skipping 2022/01/12 06:02:05 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:02:06 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/01/12 06:02:06 INFO : a/potato2: Copied (new) 2022/01/12 06:02:06 ERROR : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: not deleting files as there were IO errors 2022/01/12 06:02:06 ERROR : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: not deleting directories as there were IO errors fstest.go:251: Filtering empty directory "d" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (7.44s) === RUN TestSyncDeleteAfter --- PASS: TestSyncDeleteAfter (0.00s) === RUN TestSyncDeleteDuring run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:02:12 DEBUG : Waiting for deletions to finish 2022/01/12 06:02:12 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:02:12 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/12 06:02:12 DEBUG : empty space: Unchanged skipping 2022/01/12 06:02:12 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:02:13 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/01/12 06:02:13 INFO : potato2: Copied (new) 2022/01/12 06:02:13 INFO : potato: Deleted --- PASS: TestSyncDeleteDuring (12.58s) === RUN TestSyncDeleteBefore run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:02:26 DEBUG : Waiting for deletions to finish 2022/01/12 06:02:26 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:02:26 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:02:26 INFO : potato: Deleted 2022/01/12 06:02:26 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/12 06:02:26 DEBUG : empty space: Unchanged skipping 2022/01/12 06:02:26 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:02:26 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:02:28 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/01/12 06:02:28 INFO : potato2: Copied (new) --- PASS: TestSyncDeleteBefore (8.19s) === RUN TestCopyDeleteBefore run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:02:34 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:02:34 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:02:34 DEBUG : potato2: sha1 = 810274f0df19dab60a894a562b7a8ff04c072623 OK 2022/01/12 06:02:34 INFO : potato2: Copied (new) --- PASS: TestCopyDeleteBefore (9.60s) === RUN TestSyncWithExclude run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:02:43 DEBUG : enormous: Excluded 2022/01/12 06:02:43 DEBUG : potato2: Excluded 2022/01/12 06:02:43 DEBUG : potato2: Excluded from sync (and deletion) 2022/01/12 06:02:43 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/12 06:02:43 DEBUG : empty space: Unchanged skipping 2022/01/12 06:02:43 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:02:43 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:02:43 DEBUG : Waiting for deletions to finish 2022/01/12 06:02:43 INFO : There was nothing to transfer 2022/01/12 06:02:44 DEBUG : enormous: Excluded 2022/01/12 06:02:44 DEBUG : potato2: Excluded 2022/01/12 06:02:44 DEBUG : potato2: Excluded from sync (and deletion) 2022/01/12 06:02:44 DEBUG : empty space: Size and modification time the same (differ by 456.789µs, within tolerance 1ms) 2022/01/12 06:02:44 DEBUG : empty space: Unchanged skipping 2022/01/12 06:02:44 DEBUG : Local file system at /tmp/rclone4102840195: Waiting for checks to finish 2022/01/12 06:02:44 DEBUG : Local file system at /tmp/rclone4102840195: Waiting for transfers to finish 2022/01/12 06:02:44 DEBUG : Waiting for deletions to finish 2022/01/12 06:02:44 INFO : There was nothing to transfer --- PASS: TestSyncWithExclude (6.23s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:02:49 DEBUG : enormous: Excluded 2022/01/12 06:02:49 DEBUG : potato2: Excluded 2022/01/12 06:02:49 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:02:49 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/12 06:02:49 DEBUG : empty space: Unchanged skipping 2022/01/12 06:02:49 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:02:49 DEBUG : Waiting for deletions to finish 2022/01/12 06:02:50 INFO : enormous: Deleted 2022/01/12 06:02:52 INFO : potato2: Deleted 2022/01/12 06:02:52 INFO : There was nothing to transfer 2022/01/12 06:02:52 DEBUG : Local file system at /tmp/rclone4102840195: Waiting for checks to finish 2022/01/12 06:02:52 DEBUG : empty space: Size and modification time the same (differ by 456.789µs, within tolerance 1ms) 2022/01/12 06:02:52 DEBUG : empty space: Unchanged skipping 2022/01/12 06:02:52 DEBUG : Local file system at /tmp/rclone4102840195: Waiting for transfers to finish 2022/01/12 06:02:52 DEBUG : Waiting for deletions to finish 2022/01/12 06:02:52 INFO : enormous: Deleted 2022/01/12 06:02:52 INFO : potato2: Deleted 2022/01/12 06:02:52 INFO : There was nothing to transfer --- PASS: TestSyncWithExcludeAndDeleteExcluded (7.93s) === RUN TestSyncWithUpdateOlder run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:02:59 DEBUG : four: Sizes differ (src 4 vs dst 8) 2022/01/12 06:02:59 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2022/01/12 06:02:59 DEBUG : one: Destination is newer than source, skipping 2022/01/12 06:02:59 DEBUG : three: Sizes identical 2022/01/12 06:02:59 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2022/01/12 06:02:59 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:02:59 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b (Local file system at /tmp/rclone4102840195) 2022/01/12 06:02:59 DEBUG : two: sha1 = b10e0da85e90399abfec36c7376b20aa4596461b (B2 bucket rclone-test-kaxosol9pagerad4qasoqib6) 2022/01/12 06:02:59 DEBUG : two: sha1 differ 2022/01/12 06:02:59 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:03:00 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2022/01/12 06:03:00 INFO : two: Copied (replaced existing) 2022/01/12 06:03:01 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2022/01/12 06:03:01 INFO : five: Copied (new) 2022/01/12 06:03:02 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2022/01/12 06:03:02 INFO : four: Copied (replaced existing) 2022/01/12 06:03:02 DEBUG : Waiting for deletions to finish 2022/01/12 06:03:03 DEBUG : one: Destination is newer than source, skipping 2022/01/12 06:03:03 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:03:03 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2022/01/12 06:03:03 DEBUG : two: Size and sha1 of src and dst objects identical 2022/01/12 06:03:03 DEBUG : two: Destination mod time is within 1s of source and files identical, skipping 2022/01/12 06:03:03 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2022/01/12 06:03:03 DEBUG : five: Size and sha1 of src and dst objects identical 2022/01/12 06:03:03 DEBUG : five: Destination mod time is within 1s of source and files identical, skipping 2022/01/12 06:03:03 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2022/01/12 06:03:03 DEBUG : four: Size and sha1 of src and dst objects identical 2022/01/12 06:03:03 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb (Local file system at /tmp/rclone4102840195) 2022/01/12 06:03:03 DEBUG : four: Destination mod time is within 1s of source and files identical, skipping 2022/01/12 06:03:03 DEBUG : three: sha1 = 03731cad13f4cf7b59703c77529381cdec1632e5 (B2 bucket rclone-test-kaxosol9pagerad4qasoqib6) 2022/01/12 06:03:03 DEBUG : three: sha1 differ 2022/01/12 06:03:03 DEBUG : three: Destination mod time is within 1s of source but files differ, transferring 2022/01/12 06:03:03 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:03:04 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2022/01/12 06:03:04 INFO : three: Copied (replaced existing) 2022/01/12 06:03:04 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithUpdateOlder (13.73s) === RUN TestSyncWithMaxDuration sync_test.go:1009: Skipping test on non local remote --- SKIP: TestSyncWithMaxDuration (0.00s) === RUN TestSyncWithTrackRenames run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" sync_test.go:1058: Can track renames: true 2022/01/12 06:03:09 INFO : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Making map for --track-renames 2022/01/12 06:03:09 INFO : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Finished making map for --track-renames 2022/01/12 06:03:09 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:03:09 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for renames to finish 2022/01/12 06:03:09 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:03:10 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2022/01/12 06:03:10 INFO : yam: Copied (new) 2022/01/12 06:03:11 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2022/01/12 06:03:11 INFO : potato: Copied (new) 2022/01/12 06:03:11 DEBUG : Waiting for deletions to finish 2022/01/12 06:03:11 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:03:11 DEBUG : potato: Unchanged skipping 2022/01/12 06:03:11 INFO : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Making map for --track-renames 2022/01/12 06:03:11 INFO : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Finished making map for --track-renames 2022/01/12 06:03:11 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:03:11 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for renames to finish 2022/01/12 06:03:12 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:03:13 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2022/01/12 06:03:13 INFO : yam: Copied (server-side copy) to: yaml 2022/01/12 06:03:13 INFO : yam: Deleted 2022/01/12 06:03:13 INFO : yaml: Renamed from "yam" 2022/01/12 06:03:13 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:03:13 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenames (6.75s) === RUN TestParseRenamesStrategyModtime --- PASS: TestParseRenamesStrategyModtime (0.00s) === RUN TestRenamesStrategyModtime --- PASS: TestRenamesStrategyModtime (0.00s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" sync_test.go:1127: Can track renames: true 2022/01/12 06:03:15 INFO : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Making map for --track-renames 2022/01/12 06:03:15 INFO : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Finished making map for --track-renames 2022/01/12 06:03:15 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:03:15 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for renames to finish 2022/01/12 06:03:15 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:03:17 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2022/01/12 06:03:17 INFO : potato: Copied (new) 2022/01/12 06:03:18 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2022/01/12 06:03:18 INFO : yam: Copied (new) 2022/01/12 06:03:18 DEBUG : Waiting for deletions to finish 2022/01/12 06:03:18 INFO : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Making map for --track-renames 2022/01/12 06:03:18 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:03:18 DEBUG : potato: Unchanged skipping 2022/01/12 06:03:18 INFO : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Finished making map for --track-renames 2022/01/12 06:03:18 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:03:18 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for renames to finish 2022/01/12 06:03:19 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:03:20 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2022/01/12 06:03:20 INFO : yam: Copied (server-side copy) to: yaml 2022/01/12 06:03:23 INFO : yam: Deleted 2022/01/12 06:03:23 INFO : yaml: Renamed from "yam" 2022/01/12 06:03:23 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:03:23 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenamesStrategyModtime (9.30s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" sync_test.go:1163: Can track renames: true 2022/01/12 06:03:25 INFO : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Making map for --track-renames 2022/01/12 06:03:25 INFO : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Finished making map for --track-renames 2022/01/12 06:03:25 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:03:25 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for renames to finish 2022/01/12 06:03:25 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:03:26 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2022/01/12 06:03:26 INFO : sub/yam: Copied (new) 2022/01/12 06:03:27 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2022/01/12 06:03:27 INFO : potato: Copied (new) 2022/01/12 06:03:27 DEBUG : Waiting for deletions to finish 2022/01/12 06:03:27 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:03:27 DEBUG : potato: Unchanged skipping 2022/01/12 06:03:27 INFO : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Making map for --track-renames 2022/01/12 06:03:27 INFO : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Finished making map for --track-renames 2022/01/12 06:03:27 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:03:27 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for renames to finish 2022/01/12 06:03:28 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:03:29 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2022/01/12 06:03:29 INFO : sub/yam: Copied (server-side copy) to: yam 2022/01/12 06:03:29 INFO : sub/yam: Deleted 2022/01/12 06:03:29 INFO : yam: Renamed from "sub/yam" 2022/01/12 06:03:29 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:03:29 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenamesStrategyLeaf (6.60s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:03:31 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:03:31 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:03:32 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2022/01/12 06:03:32 INFO : nested/sub dir/file: Copied (new) 2022/01/12 06:03:32 INFO : nested/sub dir/file: Deleted 2022/01/12 06:03:33 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/01/12 06:03:33 INFO : sub dir/hello world: Copied (new) 2022/01/12 06:03:33 INFO : sub dir/hello world: Deleted 2022/01/12 06:03:33 INFO : sub dir: Removing directory 2022/01/12 06:03:33 INFO : nested/sub dir: Removing directory 2022/01/12 06:03:33 INFO : nested: Removing directory 2022/01/12 06:03:33 DEBUG : Local file system at /tmp/rclone4102840195: deleted 3 directories --- PASS: TestMoveWithDeleteEmptySrcDirs (4.88s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:03:36 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:03:36 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:03:36 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2022/01/12 06:03:36 INFO : nested/sub dir/file: Copied (new) 2022/01/12 06:03:36 INFO : nested/sub dir/file: Deleted 2022/01/12 06:03:37 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/01/12 06:03:37 INFO : sub dir/hello world: Copied (new) 2022/01/12 06:03:37 INFO : sub dir/hello world: Deleted --- PASS: TestMoveWithoutDeleteEmptySrcDirs (4.49s) === RUN TestMoveWithIgnoreExisting run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:03:41 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:03:41 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:03:41 DEBUG : existing-b: sha1 = 321f6b7e8bf7f29aab89c5e41a555b1b0baa41a9 OK 2022/01/12 06:03:41 INFO : existing-b: Copied (new) 2022/01/12 06:03:41 INFO : existing-b: Deleted 2022/01/12 06:03:43 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2022/01/12 06:03:43 INFO : existing: Copied (new) 2022/01/12 06:03:43 INFO : existing: Deleted 2022/01/12 06:03:43 DEBUG : existing: Destination exists, skipping 2022/01/12 06:03:43 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:03:43 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set 2022/01/12 06:03:43 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:03:43 INFO : There was nothing to transfer --- PASS: TestMoveWithIgnoreExisting (5.07s) === RUN TestServerSideMove run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:03:45 DEBUG : Creating backend with remote "TestB2:rclone-test-novopoz0yabilad4gozacik3" 2022/01/12 06:03:45 DEBUG : Config file has changed externaly - reloading sync_test.go:1215: Server side move (if possible) B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 -> B2 bucket rclone-test-novopoz0yabilad4gozacik3 2022/01/12 06:03:53 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ms) 2022/01/12 06:03:53 DEBUG : empty space: Unchanged skipping 2022/01/12 06:03:53 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2022/01/12 06:03:53 DEBUG : B2 bucket rclone-test-novopoz0yabilad4gozacik3: Waiting for checks to finish 2022/01/12 06:03:53 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/01/12 06:03:53 INFO : potato2: Copied (server-side copy) 2022/01/12 06:03:54 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2022/01/12 06:03:54 INFO : potato3: Copied (server-side copy) 2022/01/12 06:03:54 INFO : potato2: Deleted 2022/01/12 06:03:55 INFO : empty space: Deleted 2022/01/12 06:03:55 DEBUG : B2 bucket rclone-test-novopoz0yabilad4gozacik3: Waiting for transfers to finish 2022/01/12 06:03:58 INFO : potato3: Deleted 2022/01/12 06:03:58 DEBUG : Creating backend with remote "TestB2:rclone-test-tequdah1cubuxab9hazevoc6" 2022/01/12 06:04:00 DEBUG : B2 bucket rclone-test-tequdah1cubuxab9hazevoc6: Waiting for checks to finish 2022/01/12 06:04:00 DEBUG : B2 bucket rclone-test-tequdah1cubuxab9hazevoc6: Waiting for transfers to finish 2022/01/12 06:04:02 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2022/01/12 06:04:02 INFO : empty space: Copied (server-side copy) 2022/01/12 06:04:03 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2022/01/12 06:04:03 INFO : potato3: Copied (server-side copy) 2022/01/12 06:04:03 INFO : empty space: Deleted 2022/01/12 06:04:04 INFO : potato3: Deleted 2022/01/12 06:04:07 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/01/12 06:04:07 INFO : potato2: Copied (server-side copy) 2022/01/12 06:04:08 INFO : potato2: Deleted 2022/01/12 06:04:08 DEBUG : B2 bucket rclone-test-tequdah1cubuxab9hazevoc6: Purge remote 2022/01/12 06:04:08 DEBUG : empty space: Deleting (id "4_z4fb2dd43e02d4bcb7fe80e1b_f115a1b2a80199db9_d20220112_m060401_c001_v0001109_t0025") 2022/01/12 06:04:08 DEBUG : potato2: Deleting (id "4_z4fb2dd43e02d4bcb7fe80e1b_f106ce8c74b77fca4_d20220112_m060406_c001_v0001134_t0022") 2022/01/12 06:04:08 DEBUG : potato3: Deleting (id "4_z4fb2dd43e02d4bcb7fe80e1b_f119671ce1367f62e_d20220112_m060401_c001_v0001033_t0022") 2022/01/12 06:04:09 DEBUG : B2 bucket rclone-test-novopoz0yabilad4gozacik3: Purge remote 2022/01/12 06:04:09 DEBUG : empty space: Deleting (id "4_z8f82adb3e02d4bcb7fe80e1b_f102cd2c11737505a_d20220112_m060402_c001_v0001033_t0016") 2022/01/12 06:04:09 DEBUG : empty space: Deleting (id "4_z8f82adb3e02d4bcb7fe80e1b_f112086eb240a91ef_d20220112_m060351_c001_v0001113_t0016") 2022/01/12 06:04:09 DEBUG : potato2: Deleting (id "4_z8f82adb3e02d4bcb7fe80e1b_f110b227f5ade49ea_d20220112_m060407_c001_v0001120_t0042") 2022/01/12 06:04:09 DEBUG : potato2: Deleting (id "4_z8f82adb3e02d4bcb7fe80e1b_f1026c860e795ccd6_d20220112_m060353_c001_v0001153_t0020") 2022/01/12 06:04:09 DEBUG : potato3: Deleting (id "4_z8f82adb3e02d4bcb7fe80e1b_f114ee64f3c4c9fd6_d20220112_m060403_c001_v0001105_t0013") 2022/01/12 06:04:09 DEBUG : potato3: Deleting (id "4_z8f82adb3e02d4bcb7fe80e1b_f102b9adbdb9ce8dd_d20220112_m060354_c001_v0001043_t0036") 2022/01/12 06:04:09 DEBUG : potato3: Deleting (id "4_z8f82adb3e02d4bcb7fe80e1b_f112086eb240a91f4_d20220112_m060352_c001_v0001113_t0048") --- PASS: TestServerSideMove (25.33s) === RUN TestServerSideMoveWithFilter run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:04:11 DEBUG : Creating backend with remote "TestB2:rclone-test-hoyeriq2cidoqez6pecovak3" sync_test.go:1215: Server side move (if possible) B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 -> B2 bucket rclone-test-hoyeriq2cidoqez6pecovak3 2022/01/12 06:04:20 DEBUG : empty space: Excluded from sync (and deletion) 2022/01/12 06:04:20 DEBUG : empty space: Excluded from sync (and deletion) 2022/01/12 06:04:20 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2022/01/12 06:04:20 DEBUG : B2 bucket rclone-test-hoyeriq2cidoqez6pecovak3: Waiting for checks to finish 2022/01/12 06:04:20 DEBUG : B2 bucket rclone-test-hoyeriq2cidoqez6pecovak3: Waiting for transfers to finish 2022/01/12 06:04:21 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2022/01/12 06:04:21 INFO : potato3: Copied (server-side copy) 2022/01/12 06:04:21 INFO : potato3: Deleted 2022/01/12 06:04:22 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/01/12 06:04:22 INFO : potato2: Copied (server-side copy) 2022/01/12 06:04:23 INFO : potato2: Deleted 2022/01/12 06:04:24 DEBUG : Creating backend with remote "TestB2:rclone-test-tuhuser0migenuf4kumifot6" 2022/01/12 06:04:24 DEBUG : Config file has changed externaly - reloading 2022/01/12 06:04:25 DEBUG : empty space: Excluded from sync (and deletion) 2022/01/12 06:04:25 DEBUG : B2 bucket rclone-test-tuhuser0migenuf4kumifot6: Waiting for checks to finish 2022/01/12 06:04:25 DEBUG : B2 bucket rclone-test-tuhuser0migenuf4kumifot6: Waiting for transfers to finish 2022/01/12 06:04:26 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2022/01/12 06:04:26 INFO : potato3: Copied (server-side copy) 2022/01/12 06:04:27 INFO : potato3: Deleted 2022/01/12 06:04:28 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/01/12 06:04:28 INFO : potato2: Copied (server-side copy) 2022/01/12 06:04:28 INFO : potato2: Deleted 2022/01/12 06:04:29 DEBUG : B2 bucket rclone-test-tuhuser0migenuf4kumifot6: Purge remote 2022/01/12 06:04:29 DEBUG : potato2: Deleting (id "4_z7fc23d53e03d4bcb7fe80e1b_f119fcea85695fb2e_d20220112_m060426_c001_v0001131_t0020") 2022/01/12 06:04:29 DEBUG : potato3: Deleting (id "4_z7fc23d53e03d4bcb7fe80e1b_f10369698e2e92303_d20220112_m060426_c001_v0001146_t0020") 2022/01/12 06:04:30 DEBUG : B2 bucket rclone-test-hoyeriq2cidoqez6pecovak3: Purge remote 2022/01/12 06:04:30 DEBUG : empty space: Deleting (id "4_z7f421d03e03d4bcb7fe80e1b_f118a3c373b0d95e9_d20220112_m060417_c001_v0001157_t0052") 2022/01/12 06:04:30 DEBUG : potato2: Deleting (id "4_z7f421d03e03d4bcb7fe80e1b_f1067fb5d234472a4_d20220112_m060428_c001_v0001105_t0050") 2022/01/12 06:04:30 DEBUG : potato2: Deleting (id "4_z7f421d03e03d4bcb7fe80e1b_f104e0a22740d7080_d20220112_m060421_c001_v0001105_t0019") 2022/01/12 06:04:30 DEBUG : potato3: Deleting (id "4_z7f421d03e03d4bcb7fe80e1b_f1098f5e74ff763a4_d20220112_m060426_c001_v0001117_t0052") 2022/01/12 06:04:30 DEBUG : potato3: Deleting (id "4_z7f421d03e03d4bcb7fe80e1b_f108aef6b4a7c224b_d20220112_m060421_c001_v0001098_t0051") 2022/01/12 06:04:30 DEBUG : potato3: Deleting (id "4_z7f421d03e03d4bcb7fe80e1b_f118a3c373b0d95fa_d20220112_m060420_c001_v0001157_t0042") 2022/01/12 06:04:30 DEBUG : pacer: low level retry 1/10 (error Post "https://api001.backblazeb2.com/b2api/v1/b2_delete_file_version": EOF) 2022/01/12 06:04:30 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2022/01/12 06:04:30 DEBUG : pacer: low level retry 1/10 (error Post "https://api001.backblazeb2.com/b2api/v1/b2_delete_file_version": EOF) 2022/01/12 06:04:30 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2022/01/12 06:04:30 DEBUG : pacer: Reducing sleep to 20ms 2022/01/12 06:04:30 DEBUG : pacer: Reducing sleep to 10ms --- PASS: TestServerSideMoveWithFilter (20.91s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:04:32 DEBUG : Creating backend with remote "TestB2:rclone-test-tasecal0rejesuz7lifuvih5" 2022/01/12 06:04:36 DEBUG : tomatoDir: Making directory sync_test.go:1215: Server side move (if possible) B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 -> B2 bucket rclone-test-tasecal0rejesuz7lifuvih5 2022/01/12 06:04:40 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ms) 2022/01/12 06:04:40 DEBUG : empty space: Unchanged skipping 2022/01/12 06:04:40 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2022/01/12 06:04:40 DEBUG : B2 bucket rclone-test-tasecal0rejesuz7lifuvih5: Waiting for checks to finish 2022/01/12 06:04:41 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2022/01/12 06:04:41 INFO : potato3: Copied (server-side copy) 2022/01/12 06:04:41 INFO : empty space: Deleted 2022/01/12 06:04:41 DEBUG : B2 bucket rclone-test-tasecal0rejesuz7lifuvih5: Waiting for transfers to finish 2022/01/12 06:04:43 INFO : potato3: Deleted 2022/01/12 06:04:44 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/01/12 06:04:44 INFO : potato2: Copied (server-side copy) 2022/01/12 06:04:46 INFO : potato2: Deleted 2022/01/12 06:04:48 DEBUG : Creating backend with remote "TestB2:rclone-test-kepidev1pavoner2wurenez2" 2022/01/12 06:04:49 DEBUG : tomatoDir: Making directory 2022/01/12 06:04:50 DEBUG : B2 bucket rclone-test-kepidev1pavoner2wurenez2: Waiting for checks to finish 2022/01/12 06:04:50 DEBUG : B2 bucket rclone-test-kepidev1pavoner2wurenez2: Waiting for transfers to finish 2022/01/12 06:04:52 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2022/01/12 06:04:52 INFO : potato3: Copied (server-side copy) 2022/01/12 06:04:52 INFO : potato3: Deleted 2022/01/12 06:04:52 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2022/01/12 06:04:52 INFO : empty space: Copied (server-side copy) 2022/01/12 06:04:52 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/01/12 06:04:52 INFO : potato2: Copied (server-side copy) 2022/01/12 06:04:52 INFO : potato2: Deleted 2022/01/12 06:04:53 INFO : empty space: Deleted 2022/01/12 06:04:53 DEBUG : B2 bucket rclone-test-kepidev1pavoner2wurenez2: Purge remote 2022/01/12 06:04:54 DEBUG : empty space: Deleting (id "4_zafb29d53e03d4bcb7fe80e1b_f1151c5bef83011a4_d20220112_m060451_c001_v0001131_t0013") 2022/01/12 06:04:54 DEBUG : potato2: Deleting (id "4_zafb29d53e03d4bcb7fe80e1b_f1067fb5d23447686_d20220112_m060451_c001_v0001105_t0040") 2022/01/12 06:04:54 DEBUG : potato3: Deleting (id "4_zafb29d53e03d4bcb7fe80e1b_f107a2c7ae4aa9535_d20220112_m060451_c001_v0001117_t0013") 2022/01/12 06:04:55 DEBUG : B2 bucket rclone-test-tasecal0rejesuz7lifuvih5: Purge remote 2022/01/12 06:04:55 DEBUG : empty space: Deleting (id "4_zdf326d13e03d4bcb7fe80e1b_f104e0a22740d757b_d20220112_m060452_c001_v0001105_t0047") 2022/01/12 06:04:55 DEBUG : empty space: Deleting (id "4_zdf326d13e03d4bcb7fe80e1b_f1031e1d8e08aa7b3_d20220112_m060438_c001_v0001117_t0053") 2022/01/12 06:04:55 DEBUG : potato2: Deleting (id "4_zdf326d13e03d4bcb7fe80e1b_f1158e7a8cb83074b_d20220112_m060452_c001_v0001165_t0039") 2022/01/12 06:04:55 DEBUG : potato2: Deleting (id "4_zdf326d13e03d4bcb7fe80e1b_f1154ed5aac3ee135_d20220112_m060442_c001_v0001018_t0027") 2022/01/12 06:04:55 DEBUG : potato3: Deleting (id "4_zdf326d13e03d4bcb7fe80e1b_f11495f058f7ad5ef_d20220112_m060452_c001_v0001092_t0040") 2022/01/12 06:04:55 DEBUG : potato3: Deleting (id "4_zdf326d13e03d4bcb7fe80e1b_f110ef4122bb864fb_d20220112_m060440_c001_v0001117_t0040") 2022/01/12 06:04:55 DEBUG : potato3: Deleting (id "4_zdf326d13e03d4bcb7fe80e1b_f1031e1d8e08aa7bd_d20220112_m060439_c001_v0001117_t0057") --- PASS: TestServerSideMoveDeleteEmptySourceDirs (25.08s) === RUN TestServerSideMoveOverlap run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:04:57 DEBUG : Creating backend with remote "TestB2:rclone-test-kaxosol9pagerad4qasoqib6/rclone-move-test" 2022/01/12 06:04:58 DEBUG : Couldn't decode error response: EOF --- PASS: TestServerSideMoveOverlap (8.48s) === RUN TestSyncOverlap run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:05:05 DEBUG : Creating backend with remote "TestB2:rclone-test-kaxosol9pagerad4qasoqib6/rclone-sync-test" 2022/01/12 06:05:07 DEBUG : Couldn't decode error response: EOF --- PASS: TestSyncOverlap (4.64s) === RUN TestSyncCompareDest run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:05:10 DEBUG : Creating backend with remote "TestB2:rclone-test-kaxosol9pagerad4qasoqib6/dst" 2022/01/12 06:05:10 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:05:10 DEBUG : Creating backend with remote "TestB2:rclone-test-kaxosol9pagerad4qasoqib6/CompareDest" 2022/01/12 06:05:11 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:05:12 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:05:12 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for checks to finish 2022/01/12 06:05:12 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for transfers to finish 2022/01/12 06:05:17 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/01/12 06:05:17 INFO : one: Copied (new) 2022/01/12 06:05:17 DEBUG : Waiting for deletions to finish 2022/01/12 06:05:20 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for checks to finish 2022/01/12 06:05:21 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:05:21 DEBUG : one: Sizes differ (src 5 vs dst 3) 2022/01/12 06:05:21 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for transfers to finish 2022/01/12 06:05:21 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2022/01/12 06:05:21 INFO : one: Copied (replaced existing) 2022/01/12 06:05:21 DEBUG : Waiting for deletions to finish 2022/01/12 06:05:27 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for checks to finish 2022/01/12 06:05:31 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/12 06:05:31 DEBUG : one: Destination found in --compare-dest, skipping 2022/01/12 06:05:31 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for transfers to finish 2022/01/12 06:05:31 DEBUG : Waiting for deletions to finish 2022/01/12 06:05:31 INFO : There was nothing to transfer 2022/01/12 06:05:35 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/12 06:05:35 DEBUG : two: Destination found in --compare-dest, skipping 2022/01/12 06:05:35 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for checks to finish 2022/01/12 06:05:35 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/12 06:05:35 DEBUG : one: Destination found in --compare-dest, skipping 2022/01/12 06:05:35 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for transfers to finish 2022/01/12 06:05:35 DEBUG : Waiting for deletions to finish 2022/01/12 06:05:35 INFO : There was nothing to transfer 2022/01/12 06:05:38 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/12 06:05:38 DEBUG : two: Destination found in --compare-dest, skipping 2022/01/12 06:05:38 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for checks to finish 2022/01/12 06:05:40 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/12 06:05:40 DEBUG : one: Destination found in --compare-dest, skipping 2022/01/12 06:05:40 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for transfers to finish 2022/01/12 06:05:40 DEBUG : Waiting for deletions to finish 2022/01/12 06:05:40 INFO : There was nothing to transfer 2022/01/12 06:05:47 DEBUG : two: Modification times differ by -119h59m59.877s: 2011-12-30 12:59:59 +0000 UTC, 2011-12-25 12:59:59.123 +0000 UTC 2022/01/12 06:05:47 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2022/01/12 06:05:47 DEBUG : two: Destination found in --compare-dest, skipping 2022/01/12 06:05:47 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for checks to finish 2022/01/12 06:05:48 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/12 06:05:48 DEBUG : one: Destination found in --compare-dest, skipping 2022/01/12 06:05:48 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for transfers to finish 2022/01/12 06:05:48 DEBUG : Waiting for deletions to finish 2022/01/12 06:05:48 INFO : There was nothing to transfer 2022/01/12 06:05:52 DEBUG : two: Sizes differ (src 5 vs dst 3) 2022/01/12 06:05:52 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for checks to finish 2022/01/12 06:05:53 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/12 06:05:53 DEBUG : one: Destination found in --compare-dest, skipping 2022/01/12 06:05:53 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for transfers to finish 2022/01/12 06:05:55 DEBUG : two: sha1 = a4be8877ad88f3109a6411985a1f359e10e2d930 OK 2022/01/12 06:05:55 INFO : two: Copied (new) 2022/01/12 06:05:55 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCompareDest (60.59s) === RUN TestSyncMultipleCompareDest run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:06:13 DEBUG : Creating backend with remote "TestB2:rclone-test-kaxosol9pagerad4qasoqib6/dest" 2022/01/12 06:06:15 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:06:15 DEBUG : Creating backend with remote "TestB2:rclone-test-kaxosol9pagerad4qasoqib6/pre-dest1" 2022/01/12 06:06:15 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:06:15 DEBUG : Creating backend with remote "TestB2:rclone-test-kaxosol9pagerad4qasoqib6/pre-dest2" 2022/01/12 06:06:16 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:06:17 DEBUG : 1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:06:17 DEBUG : 1: Destination found in --compare-dest, skipping 2022/01/12 06:06:18 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:06:18 DEBUG : 2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:06:18 DEBUG : 2: Destination found in --compare-dest, skipping 2022/01/12 06:06:18 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:06:18 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:06:18 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dest: Waiting for checks to finish 2022/01/12 06:06:18 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dest: Waiting for transfers to finish 2022/01/12 06:06:20 DEBUG : 3: sha1 = 77de68daecd823babbb58edb1c8e14d7106e83bb OK 2022/01/12 06:06:20 INFO : 3: Copied (new) 2022/01/12 06:06:20 DEBUG : Waiting for deletions to finish --- PASS: TestSyncMultipleCompareDest (14.76s) === RUN TestSyncCopyDest run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:06:25 DEBUG : Creating backend with remote "TestB2:rclone-test-kaxosol9pagerad4qasoqib6/dst" 2022/01/12 06:06:28 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:06:28 DEBUG : Creating backend with remote "TestB2:rclone-test-kaxosol9pagerad4qasoqib6/CopyDest" 2022/01/12 06:06:29 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:06:30 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:06:30 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for checks to finish 2022/01/12 06:06:30 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for transfers to finish 2022/01/12 06:06:33 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/01/12 06:06:33 INFO : one: Copied (new) 2022/01/12 06:06:33 DEBUG : Waiting for deletions to finish 2022/01/12 06:06:33 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for checks to finish 2022/01/12 06:06:34 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:06:34 DEBUG : one: Sizes differ (src 5 vs dst 3) 2022/01/12 06:06:34 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for transfers to finish 2022/01/12 06:06:36 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2022/01/12 06:06:36 INFO : one: Copied (replaced existing) 2022/01/12 06:06:36 DEBUG : Waiting for deletions to finish 2022/01/12 06:06:38 DEBUG : Creating backend with remote "TestB2:rclone-test-kaxosol9pagerad4qasoqib6/BackupDir" 2022/01/12 06:06:40 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:06:41 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for checks to finish 2022/01/12 06:06:41 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/12 06:06:41 DEBUG : one: Sizes differ (src 5 vs dst 3) 2022/01/12 06:06:42 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:06:43 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/01/12 06:06:43 INFO : one: Copied (server-side copy) 2022/01/12 06:06:44 INFO : one: Deleted 2022/01/12 06:06:45 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2022/01/12 06:06:45 INFO : one: Copied (server-side copy) 2022/01/12 06:06:45 DEBUG : one: Destination found in --copy-dest, using server-side copy 2022/01/12 06:06:45 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for transfers to finish 2022/01/12 06:06:45 DEBUG : Waiting for deletions to finish 2022/01/12 06:06:48 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/12 06:06:49 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2022/01/12 06:06:49 INFO : two: Copied (server-side copy) 2022/01/12 06:06:49 DEBUG : two: Destination found in --copy-dest, using server-side copy 2022/01/12 06:06:49 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for checks to finish 2022/01/12 06:06:50 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/12 06:06:50 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/12 06:06:50 DEBUG : one: Unchanged skipping 2022/01/12 06:06:50 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for transfers to finish 2022/01/12 06:06:50 DEBUG : Waiting for deletions to finish 2022/01/12 06:06:50 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for checks to finish 2022/01/12 06:06:50 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/12 06:06:50 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/12 06:06:50 DEBUG : one: Unchanged skipping 2022/01/12 06:06:50 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/12 06:06:50 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/12 06:06:50 DEBUG : two: Unchanged skipping 2022/01/12 06:06:50 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for transfers to finish 2022/01/12 06:06:50 DEBUG : Waiting for deletions to finish 2022/01/12 06:06:50 INFO : There was nothing to transfer 2022/01/12 06:06:52 DEBUG : three: Sizes differ (src 7 vs dst 5) 2022/01/12 06:06:52 DEBUG : three: Destination not found in --copy-dest 2022/01/12 06:06:52 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for checks to finish 2022/01/12 06:06:52 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/12 06:06:52 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/12 06:06:52 DEBUG : two: Unchanged skipping 2022/01/12 06:06:52 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/12 06:06:52 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/12 06:06:52 DEBUG : one: Unchanged skipping 2022/01/12 06:06:52 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for transfers to finish 2022/01/12 06:06:54 DEBUG : three: sha1 = 370e613335f3cf2f19b2a2d35a86402f55c659f8 OK 2022/01/12 06:06:54 INFO : three: Copied (new) 2022/01/12 06:06:54 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCopyDest (33.64s) === RUN TestSyncBackupDir run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:07:14 DEBUG : Creating backend with remote "TestB2:rclone-test-kaxosol9pagerad4qasoqib6/dst" 2022/01/12 06:07:15 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:07:15 DEBUG : Creating backend with remote "TestB2:rclone-test-kaxosol9pagerad4qasoqib6/backup" 2022/01/12 06:07:16 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:07:17 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/01/12 06:07:17 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:07:17 DEBUG : two: Unchanged skipping 2022/01/12 06:07:17 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for checks to finish 2022/01/12 06:07:17 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:07:20 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/01/12 06:07:20 INFO : one: Copied (server-side copy) 2022/01/12 06:07:20 INFO : one: Deleted 2022/01/12 06:07:20 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for transfers to finish 2022/01/12 06:07:22 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/01/12 06:07:22 INFO : one: Copied (new) 2022/01/12 06:07:22 DEBUG : Waiting for deletions to finish 2022/01/12 06:07:22 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:07:23 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2022/01/12 06:07:23 INFO : three.txt: Copied (server-side copy) 2022/01/12 06:07:24 INFO : three.txt: Deleted 2022/01/12 06:07:24 INFO : three.txt: Moved into backup dir 2022/01/12 06:07:26 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/01/12 06:07:26 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:07:26 DEBUG : two: Unchanged skipping 2022/01/12 06:07:26 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for checks to finish 2022/01/12 06:07:28 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/01/12 06:07:28 INFO : one: Copied (server-side copy) 2022/01/12 06:07:30 INFO : one: Deleted 2022/01/12 06:07:30 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for transfers to finish 2022/01/12 06:07:31 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2022/01/12 06:07:31 INFO : one: Copied (new) 2022/01/12 06:07:31 DEBUG : Waiting for deletions to finish 2022/01/12 06:07:34 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/01/12 06:07:34 INFO : three.txt: Copied (server-side copy) 2022/01/12 06:07:34 INFO : three.txt: Deleted 2022/01/12 06:07:34 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDir (40.86s) === RUN TestSyncBackupDirWithSuffix run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:07:46 DEBUG : Creating backend with remote "TestB2:rclone-test-kaxosol9pagerad4qasoqib6/dst" 2022/01/12 06:07:48 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:07:48 DEBUG : Creating backend with remote "TestB2:rclone-test-kaxosol9pagerad4qasoqib6/backup" 2022/01/12 06:07:48 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:07:48 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/01/12 06:07:48 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:07:48 DEBUG : two: Unchanged skipping 2022/01/12 06:07:48 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for checks to finish 2022/01/12 06:07:49 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:07:51 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/01/12 06:07:51 INFO : one: Copied (server-side copy) to: one.bak 2022/01/12 06:07:52 INFO : one: Deleted 2022/01/12 06:07:52 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for transfers to finish 2022/01/12 06:07:54 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/01/12 06:07:54 INFO : one: Copied (new) 2022/01/12 06:07:54 DEBUG : Waiting for deletions to finish 2022/01/12 06:07:55 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:07:55 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2022/01/12 06:07:55 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/01/12 06:07:56 INFO : three.txt: Deleted 2022/01/12 06:07:56 INFO : three.txt: Moved into backup dir 2022/01/12 06:07:58 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/01/12 06:07:58 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:07:58 DEBUG : two: Unchanged skipping 2022/01/12 06:07:58 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for checks to finish 2022/01/12 06:07:58 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/01/12 06:07:58 INFO : one: Copied (server-side copy) to: one.bak 2022/01/12 06:07:59 INFO : one: Deleted 2022/01/12 06:07:59 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for transfers to finish 2022/01/12 06:07:59 DEBUG : one: Clearing upload URL because of error: Post "https://pod-000-1145-01.backblaze.com/b2api/v1/b2_upload_file/ff723dc3d0fd4bcb7fe80e1b/c001_v0001145_t0032": EOF 2022/01/12 06:07:59 DEBUG : pacer: low level retry 1/1 (error Post "https://pod-000-1145-01.backblaze.com/b2api/v1/b2_upload_file/ff723dc3d0fd4bcb7fe80e1b/c001_v0001145_t0032": EOF) 2022/01/12 06:07:59 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2022/01/12 06:07:59 DEBUG : one: Received error: Post "https://pod-000-1145-01.backblaze.com/b2api/v1/b2_upload_file/ff723dc3d0fd4bcb7fe80e1b/c001_v0001145_t0032": EOF - low level retry 1/10 2022/01/12 06:07:59 DEBUG : pacer: Reducing sleep to 10ms 2022/01/12 06:08:00 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2022/01/12 06:08:00 INFO : one: Copied (new) 2022/01/12 06:08:00 DEBUG : Waiting for deletions to finish 2022/01/12 06:08:02 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/01/12 06:08:02 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/01/12 06:08:04 INFO : three.txt: Deleted 2022/01/12 06:08:04 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffix (27.78s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:08:11 DEBUG : Creating backend with remote "TestB2:rclone-test-kaxosol9pagerad4qasoqib6/dst" 2022/01/12 06:08:13 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:08:13 DEBUG : Creating backend with remote "TestB2:rclone-test-kaxosol9pagerad4qasoqib6/backup" 2022/01/12 06:08:13 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:08:13 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/01/12 06:08:13 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:08:13 DEBUG : two: Unchanged skipping 2022/01/12 06:08:13 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for checks to finish 2022/01/12 06:08:13 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:08:15 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/01/12 06:08:15 INFO : one: Copied (server-side copy) to: one-2019-01-01 2022/01/12 06:08:16 INFO : one: Deleted 2022/01/12 06:08:16 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for transfers to finish 2022/01/12 06:08:17 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/01/12 06:08:17 INFO : one: Copied (new) 2022/01/12 06:08:17 DEBUG : Waiting for deletions to finish 2022/01/12 06:08:17 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:08:19 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2022/01/12 06:08:19 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2022/01/12 06:08:19 INFO : three.txt: Deleted 2022/01/12 06:08:19 INFO : three.txt: Moved into backup dir 2022/01/12 06:08:24 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/01/12 06:08:24 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:08:24 DEBUG : two: Unchanged skipping 2022/01/12 06:08:24 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for checks to finish 2022/01/12 06:08:26 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/01/12 06:08:26 INFO : one: Copied (server-side copy) to: one-2019-01-01 2022/01/12 06:08:26 INFO : one: Deleted 2022/01/12 06:08:26 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for transfers to finish 2022/01/12 06:08:27 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2022/01/12 06:08:27 INFO : one: Copied (new) 2022/01/12 06:08:27 DEBUG : Waiting for deletions to finish 2022/01/12 06:08:28 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/01/12 06:08:28 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2022/01/12 06:08:29 INFO : three.txt: Deleted 2022/01/12 06:08:29 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffixKeepExtension (35.02s) === RUN TestSyncBackupDirSuffixOnly run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:08:47 DEBUG : Creating backend with remote "TestB2:rclone-test-kaxosol9pagerad4qasoqib6/dst" 2022/01/12 06:08:48 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:08:49 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/01/12 06:08:49 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:08:49 DEBUG : two: Unchanged skipping 2022/01/12 06:08:49 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for checks to finish 2022/01/12 06:08:49 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:08:51 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/01/12 06:08:51 INFO : one: Copied (server-side copy) to: one.bak 2022/01/12 06:08:52 INFO : one: Deleted 2022/01/12 06:08:52 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for transfers to finish 2022/01/12 06:08:53 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/01/12 06:08:53 INFO : one: Copied (new) 2022/01/12 06:08:53 DEBUG : Waiting for deletions to finish 2022/01/12 06:08:53 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:08:54 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2022/01/12 06:08:54 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/01/12 06:08:54 INFO : three.txt: Deleted 2022/01/12 06:08:54 INFO : three.txt: Moved into backup dir 2022/01/12 06:08:56 DEBUG : one.bak: Excluded from sync (and deletion) 2022/01/12 06:08:56 DEBUG : three.txt.bak: Excluded from sync (and deletion) 2022/01/12 06:08:56 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/01/12 06:08:56 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:08:56 DEBUG : two: Unchanged skipping 2022/01/12 06:08:56 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for checks to finish 2022/01/12 06:08:57 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/01/12 06:08:57 INFO : one: Copied (server-side copy) to: one.bak 2022/01/12 06:08:57 INFO : one: Deleted 2022/01/12 06:08:57 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6 path dst: Waiting for transfers to finish 2022/01/12 06:08:58 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2022/01/12 06:08:58 INFO : one: Copied (new) 2022/01/12 06:08:58 DEBUG : Waiting for deletions to finish 2022/01/12 06:08:59 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/01/12 06:08:59 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/01/12 06:09:02 INFO : three.txt: Deleted 2022/01/12 06:09:02 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirSuffixOnly (22.74s) === RUN TestSyncSuffix run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:09:10 DEBUG : Creating backend with remote "TestB2:rclone-test-kaxosol9pagerad4qasoqib6/dst" 2022/01/12 06:09:12 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:09:12 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/01/12 06:09:12 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:09:14 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/01/12 06:09:14 INFO : one: Copied (server-side copy) to: one.bak 2022/01/12 06:09:14 INFO : one: Deleted 2022/01/12 06:09:15 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/01/12 06:09:15 INFO : one: Copied (new) 2022/01/12 06:09:15 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:09:15 DEBUG : two: Unchanged skipping 2022/01/12 06:09:15 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2022/01/12 06:09:16 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:09:16 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2022/01/12 06:09:16 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/01/12 06:09:19 INFO : three.txt: Deleted 2022/01/12 06:09:19 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/01/12 06:09:19 INFO : three.txt: Copied (new) 2022/01/12 06:09:20 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/01/12 06:09:21 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/01/12 06:09:21 INFO : one: Copied (server-side copy) to: one.bak 2022/01/12 06:09:21 INFO : one: Deleted 2022/01/12 06:09:22 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2022/01/12 06:09:22 INFO : one: Copied (new) 2022/01/12 06:09:22 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:09:22 DEBUG : two: Unchanged skipping 2022/01/12 06:09:22 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2022/01/12 06:09:23 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/01/12 06:09:23 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/01/12 06:09:24 INFO : three.txt: Deleted 2022/01/12 06:09:24 DEBUG : three.txt: sha1 = 476e1707cbd7f0497a7dc4d44f0b07b8566ffc30 OK 2022/01/12 06:09:24 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (42.58s) === RUN TestSyncSuffixKeepExtension run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:09:52 DEBUG : Creating backend with remote "TestB2:rclone-test-kaxosol9pagerad4qasoqib6/dst" 2022/01/12 06:09:54 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:09:54 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/01/12 06:09:54 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:09:56 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/01/12 06:09:56 INFO : one: Copied (server-side copy) to: one-2019-01-01 2022/01/12 06:09:56 INFO : one: Deleted 2022/01/12 06:09:58 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/01/12 06:09:58 INFO : one: Copied (new) 2022/01/12 06:09:58 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:09:58 DEBUG : two: Unchanged skipping 2022/01/12 06:09:58 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2022/01/12 06:09:59 DEBUG : Couldn't decode error response: EOF 2022/01/12 06:09:59 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2022/01/12 06:09:59 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2022/01/12 06:10:00 INFO : three.txt: Deleted 2022/01/12 06:10:01 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/01/12 06:10:01 INFO : three.txt: Copied (new) 2022/01/12 06:10:02 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/01/12 06:10:02 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/01/12 06:10:02 INFO : one: Copied (server-side copy) to: one-2019-01-01 2022/01/12 06:10:03 INFO : one: Deleted 2022/01/12 06:10:03 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2022/01/12 06:10:03 INFO : one: Copied (new) 2022/01/12 06:10:04 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:10:04 DEBUG : two: Unchanged skipping 2022/01/12 06:10:04 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2022/01/12 06:10:04 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/01/12 06:10:04 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2022/01/12 06:10:06 INFO : three.txt: Deleted 2022/01/12 06:10:06 DEBUG : three.txt: sha1 = 476e1707cbd7f0497a7dc4d44f0b07b8566ffc30 OK 2022/01/12 06:10:06 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffixKeepExtension (22.06s) === RUN TestSyncUTFNorm run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:10:12 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:10:12 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2022/01/12 06:10:12 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:10:13 DEBUG : Testêé: sha1 = a54d88e06612d820bc3be72877c74f257b561b19 OK 2022/01/12 06:10:13 INFO : Testêé: Copied (replaced existing) to: Testêé 2022/01/12 06:10:13 DEBUG : Waiting for deletions to finish --- PASS: TestSyncUTFNorm (4.94s) === RUN TestSyncImmutable run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:10:15 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:10:15 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:10:17 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2022/01/12 06:10:17 INFO : existing: Copied (new) 2022/01/12 06:10:17 DEBUG : Waiting for deletions to finish 2022/01/12 06:10:18 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:10:18 DEBUG : existing: Sizes differ (src 8 vs dst 6) 2022/01/12 06:10:18 ERROR : existing: Source and destination exist but do not match: immutable file modified 2022/01/12 06:10:18 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:10:18 ERROR : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: not deleting files as there were IO errors 2022/01/12 06:10:18 ERROR : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: not deleting directories as there were IO errors --- PASS: TestSyncImmutable (3.66s) === RUN TestSyncIgnoreCase run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:10:20 DEBUG : existing: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:10:20 DEBUG : existing: Unchanged skipping 2022/01/12 06:10:20 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:10:20 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:10:20 DEBUG : Waiting for deletions to finish 2022/01/12 06:10:20 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreCase (2.90s) === RUN TestMaxTransfer === RUN TestMaxTransfer/Hard run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" sync_test.go:1989: This test only runs on local === RUN TestMaxTransfer/Soft run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" sync_test.go:1989: This test only runs on local === RUN TestMaxTransfer/Cautious run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" sync_test.go:1989: This test only runs on local --- PASS: TestMaxTransfer (1.26s) --- SKIP: TestMaxTransfer/Hard (0.50s) --- SKIP: TestMaxTransfer/Soft (0.38s) --- SKIP: TestMaxTransfer/Cautious (0.38s) === RUN TestSyncConcurrentDelete run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:10:53 DEBUG : both0: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:10:53 DEBUG : both0: Unchanged skipping 2022/01/12 06:10:53 DEBUG : both1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:10:53 DEBUG : both1: Unchanged skipping 2022/01/12 06:10:53 DEBUG : both10: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:10:53 DEBUG : both10: Unchanged skipping 2022/01/12 06:10:53 DEBUG : both11: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:10:53 DEBUG : both11: Unchanged skipping 2022/01/12 06:10:53 DEBUG : both12: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:10:53 DEBUG : both12: Unchanged skipping 2022/01/12 06:10:53 DEBUG : both13: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:10:53 DEBUG : both13: Unchanged skipping 2022/01/12 06:10:53 DEBUG : both14: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:10:53 DEBUG : both14: Unchanged skipping 2022/01/12 06:10:53 DEBUG : both15: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:10:53 DEBUG : both15: Unchanged skipping 2022/01/12 06:10:53 DEBUG : both16: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:10:53 DEBUG : both16: Unchanged skipping 2022/01/12 06:10:53 DEBUG : both17: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:10:53 DEBUG : both17: Unchanged skipping 2022/01/12 06:10:53 DEBUG : both18: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:10:53 DEBUG : both18: Unchanged skipping 2022/01/12 06:10:53 DEBUG : both19: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:10:53 DEBUG : both19: Unchanged skipping 2022/01/12 06:10:53 DEBUG : both2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:10:53 DEBUG : both2: Unchanged skipping 2022/01/12 06:10:53 DEBUG : both3: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:10:53 DEBUG : both3: Unchanged skipping 2022/01/12 06:10:53 DEBUG : both4: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:10:53 DEBUG : both4: Unchanged skipping 2022/01/12 06:10:53 DEBUG : both5: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:10:53 DEBUG : both5: Unchanged skipping 2022/01/12 06:10:53 DEBUG : both6: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:10:53 DEBUG : both6: Unchanged skipping 2022/01/12 06:10:53 DEBUG : both7: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:10:53 DEBUG : both7: Unchanged skipping 2022/01/12 06:10:53 DEBUG : both8: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:10:53 DEBUG : both8: Unchanged skipping 2022/01/12 06:10:53 DEBUG : both9: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:10:53 DEBUG : both9: Unchanged skipping 2022/01/12 06:10:53 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:10:53 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:10:53 DEBUG : Waiting for deletions to finish 2022/01/12 06:10:53 INFO : only1: Deleted 2022/01/12 06:10:54 INFO : only19: Deleted 2022/01/12 06:10:54 INFO : only13: Deleted 2022/01/12 06:10:54 INFO : only3: Deleted 2022/01/12 06:10:55 INFO : only18: Deleted 2022/01/12 06:10:55 INFO : only0: Deleted 2022/01/12 06:10:55 INFO : only16: Deleted 2022/01/12 06:10:55 INFO : only2: Deleted 2022/01/12 06:10:56 INFO : only9: Deleted 2022/01/12 06:10:56 INFO : only10: Deleted 2022/01/12 06:10:56 INFO : only11: Deleted 2022/01/12 06:10:56 INFO : only14: Deleted 2022/01/12 06:10:57 INFO : only6: Deleted 2022/01/12 06:10:57 INFO : only8: Deleted 2022/01/12 06:10:57 INFO : only7: Deleted 2022/01/12 06:10:58 INFO : only15: Deleted 2022/01/12 06:10:58 INFO : only17: Deleted 2022/01/12 06:10:58 INFO : only12: Deleted 2022/01/12 06:10:58 INFO : only4: Deleted 2022/01/12 06:10:58 INFO : only5: Deleted 2022/01/12 06:10:58 INFO : There was nothing to transfer --- PASS: TestSyncConcurrentDelete (59.59s) === RUN TestSyncConcurrentTruncate run.go:181: Remote "B2 bucket rclone-test-kaxosol9pagerad4qasoqib6", Local "Local file system at /tmp/rclone4102840195", Modify Window "1ms" 2022/01/12 06:12:03 DEBUG : both1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:12:03 DEBUG : both1: Unchanged skipping 2022/01/12 06:12:03 DEBUG : both10: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:12:03 DEBUG : both10: Unchanged skipping 2022/01/12 06:12:03 DEBUG : both11: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:12:03 DEBUG : both11: Unchanged skipping 2022/01/12 06:12:03 DEBUG : both12: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:12:03 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for checks to finish 2022/01/12 06:12:03 DEBUG : both12: Unchanged skipping 2022/01/12 06:12:03 DEBUG : both13: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:12:03 DEBUG : both14: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:12:03 DEBUG : both14: Unchanged skipping 2022/01/12 06:12:03 DEBUG : both16: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:12:03 DEBUG : both16: Unchanged skipping 2022/01/12 06:12:03 DEBUG : both15: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:12:03 DEBUG : both17: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:12:03 DEBUG : both15: Unchanged skipping 2022/01/12 06:12:03 DEBUG : both0: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:12:03 DEBUG : both0: Unchanged skipping 2022/01/12 06:12:03 DEBUG : both18: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:12:03 DEBUG : both18: Unchanged skipping 2022/01/12 06:12:03 DEBUG : both19: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:12:03 DEBUG : both19: Unchanged skipping 2022/01/12 06:12:03 DEBUG : both17: Unchanged skipping 2022/01/12 06:12:03 DEBUG : both4: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:12:03 DEBUG : both2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:12:03 DEBUG : both2: Unchanged skipping 2022/01/12 06:12:03 DEBUG : both5: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:12:03 DEBUG : both5: Unchanged skipping 2022/01/12 06:12:03 DEBUG : both6: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:12:03 DEBUG : both6: Unchanged skipping 2022/01/12 06:12:03 DEBUG : both7: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:12:03 DEBUG : both7: Unchanged skipping 2022/01/12 06:12:03 DEBUG : both8: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:12:03 DEBUG : both8: Unchanged skipping 2022/01/12 06:12:03 DEBUG : both9: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:12:03 DEBUG : both9: Unchanged skipping 2022/01/12 06:12:03 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2022/01/12 06:12:03 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2022/01/12 06:12:03 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2022/01/12 06:12:03 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2022/01/12 06:12:03 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2022/01/12 06:12:03 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2022/01/12 06:12:03 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2022/01/12 06:12:03 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2022/01/12 06:12:03 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2022/01/12 06:12:03 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2022/01/12 06:12:03 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2022/01/12 06:12:03 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2022/01/12 06:12:03 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2022/01/12 06:12:03 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2022/01/12 06:12:03 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2022/01/12 06:12:03 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2022/01/12 06:12:03 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2022/01/12 06:12:03 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2022/01/12 06:12:03 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2022/01/12 06:12:03 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2022/01/12 06:12:03 DEBUG : both13: Unchanged skipping 2022/01/12 06:12:03 DEBUG : both3: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/12 06:12:03 DEBUG : both3: Unchanged skipping 2022/01/12 06:12:03 DEBUG : both4: Unchanged skipping 2022/01/12 06:12:03 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Waiting for transfers to finish 2022/01/12 06:12:04 DEBUG : only1: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/12 06:12:04 INFO : only1: Copied (replaced existing) 2022/01/12 06:12:04 DEBUG : only10: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/12 06:12:04 INFO : only10: Copied (replaced existing) 2022/01/12 06:12:04 DEBUG : only0: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/12 06:12:04 INFO : only0: Copied (replaced existing) 2022/01/12 06:12:04 DEBUG : only13: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/12 06:12:04 INFO : only13: Copied (replaced existing) 2022/01/12 06:12:05 DEBUG : only11: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/12 06:12:05 INFO : only11: Copied (replaced existing) 2022/01/12 06:12:05 DEBUG : only15: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/12 06:12:05 INFO : only15: Copied (replaced existing) 2022/01/12 06:12:05 DEBUG : only12: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/12 06:12:05 INFO : only12: Copied (replaced existing) 2022/01/12 06:12:05 DEBUG : only17: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/12 06:12:05 INFO : only17: Copied (replaced existing) 2022/01/12 06:12:05 DEBUG : only16: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/12 06:12:05 INFO : only16: Copied (replaced existing) 2022/01/12 06:12:05 DEBUG : only19: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/12 06:12:05 INFO : only19: Copied (replaced existing) 2022/01/12 06:12:06 DEBUG : only14: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/12 06:12:06 INFO : only14: Copied (replaced existing) 2022/01/12 06:12:06 DEBUG : only18: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/12 06:12:06 INFO : only18: Copied (replaced existing) 2022/01/12 06:12:06 DEBUG : only3: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/12 06:12:06 INFO : only3: Copied (replaced existing) 2022/01/12 06:12:06 DEBUG : only2: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/12 06:12:06 INFO : only2: Copied (replaced existing) 2022/01/12 06:12:06 DEBUG : only5: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/12 06:12:06 INFO : only5: Copied (replaced existing) 2022/01/12 06:12:07 DEBUG : only8: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/12 06:12:07 INFO : only8: Copied (replaced existing) 2022/01/12 06:12:07 DEBUG : only6: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/12 06:12:07 INFO : only6: Copied (replaced existing) 2022/01/12 06:12:07 DEBUG : only7: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/12 06:12:07 INFO : only7: Copied (replaced existing) 2022/01/12 06:12:07 DEBUG : only9: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/12 06:12:07 INFO : only9: Copied (replaced existing) 2022/01/12 06:12:08 DEBUG : only4: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/12 06:12:08 INFO : only4: Copied (replaced existing) 2022/01/12 06:12:08 DEBUG : Waiting for deletions to finish 2022/01/12 06:12:08 DEBUG : pacer: low level retry 1/10 (error Post "https://api001.backblazeb2.com/b2api/v1/b2_list_file_names": EOF) 2022/01/12 06:12:08 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2022/01/12 06:12:09 DEBUG : pacer: Reducing sleep to 10ms --- PASS: TestSyncConcurrentTruncate (89.13s) PASS 2022/01/12 06:12:51 DEBUG : B2 bucket rclone-test-kaxosol9pagerad4qasoqib6: Purge remote 2022/01/12 06:12:52 DEBUG : BackupDir/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f111c3681a7635525_d20220112_m060655_c001_v0001154_t0017") 2022/01/12 06:12:52 DEBUG : BackupDir/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110b3b79a2ce8411_d20220112_m060643_c001_v0001030_t0016") 2022/01/12 06:12:52 DEBUG : CompareDest/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f118065f94f54b4fe_d20220112_m060600_c001_v0001093_t0029") 2022/01/12 06:12:52 DEBUG : CompareDest/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c1999388122f9_d20220112_m060525_c001_v0001105_t0035") 2022/01/12 06:12:52 DEBUG : CompareDest/two: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11797d79e133dc8e_d20220112_m060603_c001_v0001105_t0052") 2022/01/12 06:12:52 DEBUG : CompareDest/two: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd55c_d20220112_m060532_c001_v0001029_t0012") 2022/01/12 06:12:52 DEBUG : CopyDest/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f112c6527c79b5ee3_d20220112_m060655_c001_v0001131_t0034") 2022/01/12 06:12:52 DEBUG : CopyDest/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef52714b8_d20220112_m060638_c001_v0001157_t0000") 2022/01/12 06:12:52 DEBUG : CopyDest/three: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1031e1d8e08aae5a_d20220112_m060655_c001_v0001117_t0057") 2022/01/12 06:12:52 DEBUG : CopyDest/three: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd5ce_d20220112_m060651_c001_v0001029_t0029") 2022/01/12 06:12:53 DEBUG : CopyDest/two: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f10057e8082f6b478_d20220112_m060656_c001_v0001098_t0019") 2022/01/12 06:12:53 DEBUG : CopyDest/two: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c199938812e8d_d20220112_m060645_c001_v0001105_t0015") 2022/01/12 06:12:53 DEBUG : EXISTING: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f10871aedacb30824_d20220112_m061021_c001_v0001009_t0032") 2022/01/12 06:12:53 DEBUG : EXISTING: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c199938814dbc_d20220112_m061019_c001_v0001105_t0052") 2022/01/12 06:12:53 DEBUG : Testêé: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f115a769bb2c4024a_d20220112_m061013_c001_v0001117_t0018") 2022/01/12 06:12:53 DEBUG : Testêé: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd6f2_d20220112_m061012_c001_v0001029_t0029") 2022/01/12 06:12:53 DEBUG : Testêé: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c199938814c5d_d20220112_m061011_c001_v0001105_t0050") 2022/01/12 06:12:53 DEBUG : a/potato2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110f6f02f2ca2747_d20220112_m060207_c001_v0001091_t0039") 2022/01/12 06:12:53 DEBUG : a/potato2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd458_d20220112_m060206_c001_v0001029_t0019") 2022/01/12 06:12:53 DEBUG : a/potato2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11797b246fbf64ab_d20220112_m060158_c001_v0001165_t0056") 2022/01/12 06:12:53 DEBUG : a/potato2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd445_d20220112_m060156_c001_v0001029_t0035") 2022/01/12 06:12:53 DEBUG : a/potato2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1174c992b43af6a2_d20220112_m060115_c001_v0001041_t0032") 2022/01/12 06:12:53 DEBUG : a/potato2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd3f8_d20220112_m060112_c001_v0001029_t0043") 2022/01/12 06:12:53 DEBUG : b/potato: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f10081dd545b13242_d20220112_m060208_c001_v0001109_t0053") 2022/01/12 06:12:53 DEBUG : b/potato: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd44f_d20220112_m060203_c001_v0001029_t0011") 2022/01/12 06:12:54 DEBUG : b/potato: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f106c1a18973f961c_d20220112_m060157_c001_v0001093_t0051") 2022/01/12 06:12:54 DEBUG : b/potato: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd43d_d20220112_m060155_c001_v0001029_t0034") 2022/01/12 06:12:54 DEBUG : b/potato: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f106e0c1f996677e3_d20220112_m060114_c001_v0001041_t0056") 2022/01/12 06:12:54 DEBUG : b/potato: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd3f0_d20220112_m060110_c001_v0001029_t0037") 2022/01/12 06:12:54 DEBUG : backup/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1023be88de3d6aba_d20220112_m060735_c001_v0001105_t0027") 2022/01/12 06:12:54 DEBUG : backup/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f115ac477b7612d92_d20220112_m060727_c001_v0001105_t0010") 2022/01/12 06:12:54 DEBUG : backup/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f112381bbb624d479_d20220112_m060719_c001_v0001036_t0032") 2022/01/12 06:12:54 DEBUG : backup/one-2019-01-01: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f114b722e2e54dae1_d20220112_m060830_c001_v0001154_t0016") 2022/01/12 06:12:54 DEBUG : backup/one-2019-01-01: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f115a1b2a8019aded_d20220112_m060825_c001_v0001109_t0027") 2022/01/12 06:12:54 DEBUG : backup/one-2019-01-01: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f105d74121388c770_d20220112_m060815_c001_v0001032_t0048") 2022/01/12 06:12:54 DEBUG : backup/one.bak: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f10762f3618c03431_d20220112_m060804_c001_v0001039_t0039") 2022/01/12 06:12:54 DEBUG : backup/one.bak: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1015be620f93ab89_d20220112_m060758_c001_v0001137_t0047") 2022/01/12 06:12:54 DEBUG : backup/one.bak: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11145f3723f8ff2d_d20220112_m060750_c001_v0001144_t0041") 2022/01/12 06:12:54 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1175ff8a41b30a25_d20220112_m060831_c001_v0001033_t0037") 2022/01/12 06:12:54 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1115121ef471c639_d20220112_m060828_c001_v0001022_t0041") 2022/01/12 06:12:54 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f10299083413cd170_d20220112_m060818_c001_v0001120_t0032") 2022/01/12 06:12:54 DEBUG : backup/three.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f112dcc6191e3a404_d20220112_m060736_c001_v0001130_t0030") 2022/01/12 06:12:54 DEBUG : backup/three.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f111c95d772aa7e58_d20220112_m060733_c001_v0001039_t0028") 2022/01/12 06:12:55 DEBUG : backup/three.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110bbea8a9d65285_d20220112_m060723_c001_v0001097_t0029") 2022/01/12 06:12:55 DEBUG : backup/three.txt.bak: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1017110bee09c284_d20220112_m060804_c001_v0001117_t0027") 2022/01/12 06:12:55 DEBUG : backup/three.txt.bak: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1158eb438e6fd870_d20220112_m060801_c001_v0001013_t0009") 2022/01/12 06:12:55 DEBUG : backup/three.txt.bak: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f106688e57967c0c6_d20220112_m060755_c001_v0001165_t0033") 2022/01/12 06:12:55 DEBUG : both0: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11835a5b25ea5d5a_d20220112_m061210_c001_v0001117_t0049") 2022/01/12 06:12:55 DEBUG : both0: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef527193d_d20220112_m061123_c001_v0001157_t0000") 2022/01/12 06:12:55 DEBUG : both0: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f115ac477b7614e2d_d20220112_m061059_c001_v0001105_t0038") 2022/01/12 06:12:55 DEBUG : both0: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd70a_d20220112_m061023_c001_v0001029_t0021") 2022/01/12 06:12:55 DEBUG : both1: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f10618d30f43e7b97_d20220112_m061211_c001_v0001150_t0014") 2022/01/12 06:12:55 DEBUG : both1: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd791_d20220112_m061126_c001_v0001029_t0043") 2022/01/12 06:12:55 DEBUG : both1: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f114eb92a222d6a33_d20220112_m061100_c001_v0001033_t0027") 2022/01/12 06:12:55 DEBUG : both1: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c199938814eec_d20220112_m061025_c001_v0001105_t0024") 2022/01/12 06:12:55 DEBUG : both10: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f114e181771e74077_d20220112_m061211_c001_v0001146_t0005") 2022/01/12 06:12:55 DEBUG : both10: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd7a8_d20220112_m061140_c001_v0001029_t0011") 2022/01/12 06:12:55 DEBUG : both10: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1144fbc881743b15_d20220112_m061102_c001_v0001150_t0007") 2022/01/12 06:12:55 DEBUG : both10: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c199938815108_d20220112_m061037_c001_v0001105_t0058") 2022/01/12 06:12:56 DEBUG : both11: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1082bb13d3ad0d60_d20220112_m061212_c001_v0001109_t0039") 2022/01/12 06:12:56 DEBUG : both11: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c199938815980_d20220112_m061141_c001_v0001105_t0034") 2022/01/12 06:12:56 DEBUG : both11: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1009dee1ea0d2e25_d20220112_m061103_c001_v0001157_t0040") 2022/01/12 06:12:56 DEBUG : both11: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef527187f_d20220112_m061038_c001_v0001157_t0031") 2022/01/12 06:12:56 DEBUG : both12: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11768623a79ad6b7_d20220112_m061213_c001_v0001109_t0027") 2022/01/12 06:12:56 DEBUG : both12: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef5271983_d20220112_m061142_c001_v0001157_t0059") 2022/01/12 06:12:56 DEBUG : both12: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f119d07f6ecccc862_d20220112_m061104_c001_v0001150_t0048") 2022/01/12 06:12:56 DEBUG : both12: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd744_d20220112_m061039_c001_v0001029_t0043") 2022/01/12 06:12:56 DEBUG : both13: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f104576c6f2dd5fc7_d20220112_m061214_c001_v0001117_t0041") 2022/01/12 06:12:56 DEBUG : both13: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd7af_d20220112_m061144_c001_v0001029_t0030") 2022/01/12 06:12:56 DEBUG : both13: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f104a080fe21d3022_d20220112_m061104_c001_v0001131_t0003") 2022/01/12 06:12:56 DEBUG : both13: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c199938815184_d20220112_m061040_c001_v0001105_t0026") 2022/01/12 06:12:56 DEBUG : both14: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1112c943f83fb2f6_d20220112_m061215_c001_v0001145_t0036") 2022/01/12 06:12:56 DEBUG : both14: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c199938815a38_d20220112_m061145_c001_v0001105_t0002") 2022/01/12 06:12:56 DEBUG : both14: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f113d48f5052b9c34_d20220112_m061107_c001_v0001161_t0013") 2022/01/12 06:12:56 DEBUG : both14: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef527188d_d20220112_m061040_c001_v0001157_t0025") 2022/01/12 06:12:56 DEBUG : both15: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1193ae68f0794fed_d20220112_m061215_c001_v0001044_t0058") 2022/01/12 06:12:56 DEBUG : both15: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef5271999_d20220112_m061148_c001_v0001157_t0023") 2022/01/12 06:12:56 DEBUG : both15: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11797d79e1340406_d20220112_m061108_c001_v0001105_t0059") 2022/01/12 06:12:56 DEBUG : both15: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd74a_d20220112_m061041_c001_v0001029_t0010") 2022/01/12 06:12:57 DEBUG : both16: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1133baf706430acc_d20220112_m061216_c001_v0001157_t0019") 2022/01/12 06:12:57 DEBUG : both16: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd7bf_d20220112_m061150_c001_v0001029_t0015") 2022/01/12 06:12:57 DEBUG : both16: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1115f2f71a55513b_d20220112_m061109_c001_v0001105_t0050") 2022/01/12 06:12:57 DEBUG : both16: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c19993881528b_d20220112_m061046_c001_v0001105_t0059") 2022/01/12 06:12:57 DEBUG : both17: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11076ad981584e48_d20220112_m061217_c001_v0001150_t0038") 2022/01/12 06:12:57 DEBUG : both17: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c199938815b05_d20220112_m061151_c001_v0001105_t0035") 2022/01/12 06:12:57 DEBUG : both17: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f10753486b6f24bc0_d20220112_m061110_c001_v0001131_t0048") 2022/01/12 06:12:57 DEBUG : both17: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef52718b5_d20220112_m061047_c001_v0001157_t0002") 2022/01/12 06:12:57 DEBUG : both18: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f107b819eba91c5b6_d20220112_m061218_c001_v0001098_t0003") 2022/01/12 06:12:57 DEBUG : both18: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef52719b2_d20220112_m061155_c001_v0001157_t0058") 2022/01/12 06:12:57 DEBUG : both18: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f101db73a8bbb78dd_d20220112_m061111_c001_v0001146_t0015") 2022/01/12 06:12:57 DEBUG : both18: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd75a_d20220112_m061049_c001_v0001029_t0015") 2022/01/12 06:12:57 DEBUG : both19: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11385c07e3597159_d20220112_m061219_c001_v0001008_t0026") 2022/01/12 06:12:57 DEBUG : both19: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd7c9_d20220112_m061157_c001_v0001029_t0035") 2022/01/12 06:12:57 DEBUG : both19: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f10140f5efa22a984_d20220112_m061111_c001_v0001161_t0048") 2022/01/12 06:12:57 DEBUG : both19: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c19993881532f_d20220112_m061050_c001_v0001105_t0019") 2022/01/12 06:12:57 DEBUG : both2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f101810ece1837c13_d20220112_m061219_c001_v0001113_t0043") 2022/01/12 06:12:57 DEBUG : both2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c1999388157e5_d20220112_m061127_c001_v0001105_t0020") 2022/01/12 06:12:57 DEBUG : both2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f10108833264efb02_d20220112_m061112_c001_v0001092_t0041") 2022/01/12 06:12:58 DEBUG : both2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef5271846_d20220112_m061027_c001_v0001157_t0040") 2022/01/12 06:12:58 DEBUG : both3: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1172a7ed8af7d5b0_d20220112_m061222_c001_v0001137_t0039") 2022/01/12 06:12:58 DEBUG : both3: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef5271955_d20220112_m061128_c001_v0001157_t0048") 2022/01/12 06:12:58 DEBUG : both3: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f115bb3004b55608b_d20220112_m061113_c001_v0001145_t0020") 2022/01/12 06:12:58 DEBUG : both3: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd71b_d20220112_m061028_c001_v0001029_t0018") 2022/01/12 06:12:58 DEBUG : both4: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f116242fef0e9b407_d20220112_m061224_c001_v0001041_t0053") 2022/01/12 06:12:58 DEBUG : both4: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd797_d20220112_m061129_c001_v0001029_t0029") 2022/01/12 06:12:58 DEBUG : both4: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f100ce1ab607746c4_d20220112_m061115_c001_v0001105_t0005") 2022/01/12 06:12:58 DEBUG : both4: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c199938814f84_d20220112_m061029_c001_v0001105_t0014") 2022/01/12 06:12:58 DEBUG : both5: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f10805e4d605aeb5d_d20220112_m061224_c001_v0001000_t0032") 2022/01/12 06:12:58 DEBUG : both5: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c199938815877_d20220112_m061133_c001_v0001105_t0031") 2022/01/12 06:12:58 DEBUG : both5: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1142e508a76d18a8_d20220112_m061116_c001_v0001120_t0046") 2022/01/12 06:12:58 DEBUG : both5: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef5271857_d20220112_m061030_c001_v0001157_t0037") 2022/01/12 06:12:58 DEBUG : both6: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1031ccfc97904a55_d20220112_m061225_c001_v0001011_t0007") 2022/01/12 06:12:58 DEBUG : both6: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef5271965_d20220112_m061134_c001_v0001157_t0026") 2022/01/12 06:12:58 DEBUG : both6: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f104e0a22740db2cf_d20220112_m061117_c001_v0001105_t0038") 2022/01/12 06:12:58 DEBUG : both6: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd725_d20220112_m061031_c001_v0001029_t0038") 2022/01/12 06:12:58 DEBUG : both7: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1037d616bb1d6934_d20220112_m061227_c001_v0001033_t0040") 2022/01/12 06:12:59 DEBUG : both7: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd7a4_d20220112_m061137_c001_v0001029_t0000") 2022/01/12 06:12:59 DEBUG : both7: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f119ce1a3ea8c57c7_d20220112_m061119_c001_v0001105_t0021") 2022/01/12 06:12:59 DEBUG : both7: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c199938815034_d20220112_m061033_c001_v0001105_t0059") 2022/01/12 06:12:59 DEBUG : both8: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f105fb9db88a21eb9_d20220112_m061230_c001_v0001130_t0056") 2022/01/12 06:12:59 DEBUG : both8: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c199938815921_d20220112_m061138_c001_v0001105_t0042") 2022/01/12 06:12:59 DEBUG : both8: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f109ae94d155498f8_d20220112_m061120_c001_v0001105_t0022") 2022/01/12 06:12:59 DEBUG : both8: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef5271868_d20220112_m061034_c001_v0001157_t0043") 2022/01/12 06:12:59 DEBUG : both9: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1067fb5d2344bfbc_d20220112_m061231_c001_v0001105_t0018") 2022/01/12 06:12:59 DEBUG : both9: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef5271977_d20220112_m061139_c001_v0001157_t0014") 2022/01/12 06:12:59 DEBUG : both9: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f119ce1a3ea8c582c_d20220112_m061121_c001_v0001105_t0006") 2022/01/12 06:12:59 DEBUG : both9: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd739_d20220112_m061035_c001_v0001029_t0016") 2022/01/12 06:12:59 DEBUG : c/non empty space: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f112ac64761a64365_d20220112_m060209_c001_v0001026_t0021") 2022/01/12 06:12:59 DEBUG : c/non empty space: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd453_d20220112_m060204_c001_v0001029_t0041") 2022/01/12 06:12:59 DEBUG : c/non empty space: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f10180acdcc8c37b8_d20220112_m060200_c001_v0001109_t0004") 2022/01/12 06:12:59 DEBUG : c/non empty space: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd440_d20220112_m060155_c001_v0001029_t0012") 2022/01/12 06:12:59 DEBUG : c/non empty space: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1195ce9b5e722616_d20220112_m060115_c001_v0001109_t0045") 2022/01/12 06:12:59 DEBUG : c/non empty space: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd3f4_d20220112_m060111_c001_v0001029_t0027") 2022/01/12 06:12:59 DEBUG : check sum: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f108aef6b4a7c1904_d20220112_m060056_c001_v0001098_t0055") 2022/01/12 06:12:59 DEBUG : check sum: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd3d3_d20220112_m060055_c001_v0001029_t0040") 2022/01/12 06:13:00 DEBUG : dest/3: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f116696faf3794213_d20220112_m060623_c001_v0001109_t0010") 2022/01/12 06:13:00 DEBUG : dest/3: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11733c70870a2767_d20220112_m060620_c001_v0001113_t0030") 2022/01/12 06:13:00 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f113e0384a6546d4f_d20220112_m061007_c001_v0001042_t0018") 2022/01/12 06:13:00 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f104e0a22740da688_d20220112_m061003_c001_v0001105_t0036") 2022/01/12 06:13:00 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f119947a12e9a2098_d20220112_m061002_c001_v0001117_t0008") 2022/01/12 06:13:00 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f104e0a22740da588_d20220112_m060957_c001_v0001105_t0043") 2022/01/12 06:13:00 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1087dce285916fb0_d20220112_m060956_c001_v0001137_t0029") 2022/01/12 06:13:00 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c1999388148de_d20220112_m060948_c001_v0001105_t0013") 2022/01/12 06:13:00 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f112e6ec21688a2ec_d20220112_m060925_c001_v0001022_t0058") 2022/01/12 06:13:00 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1179c3881f27c6d6_d20220112_m060922_c001_v0001136_t0039") 2022/01/12 06:13:00 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f105e6d480eef7721_d20220112_m060921_c001_v0001165_t0001") 2022/01/12 06:13:00 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1179c3881f27c6bb_d20220112_m060915_c001_v0001136_t0053") 2022/01/12 06:13:00 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f113559a7e5ce0fa7_d20220112_m060914_c001_v0001153_t0020") 2022/01/12 06:13:00 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c1999388143d5_d20220112_m060906_c001_v0001105_t0010") 2022/01/12 06:13:00 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f105fb9db88a21cc0_d20220112_m060902_c001_v0001130_t0038") 2022/01/12 06:13:00 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f10747149f04010ad_d20220112_m060858_c001_v0001093_t0054") 2022/01/12 06:13:00 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f117347991c57f377_d20220112_m060857_c001_v0001036_t0019") 2022/01/12 06:13:00 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f10747149f0401097_d20220112_m060853_c001_v0001093_t0013") 2022/01/12 06:13:00 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1128346e3f6661d9_d20220112_m060851_c001_v0001015_t0007") 2022/01/12 06:13:01 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef52716cf_d20220112_m060843_c001_v0001157_t0043") 2022/01/12 06:13:01 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1137019be0635c01_d20220112_m060835_c001_v0001097_t0007") 2022/01/12 06:13:01 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f100d9c36ec5669e1_d20220112_m060827_c001_v0001161_t0009") 2022/01/12 06:13:01 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f119a5ced73ceb026_d20220112_m060826_c001_v0001039_t0040") 2022/01/12 06:13:01 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f100d9c36ec566979_d20220112_m060817_c001_v0001161_t0055") 2022/01/12 06:13:01 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11948d8c53372d13_d20220112_m060816_c001_v0001137_t0015") 2022/01/12 06:13:01 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd62b_d20220112_m060808_c001_v0001029_t0021") 2022/01/12 06:13:01 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1133f8d15b3956c5_d20220112_m060806_c001_v0001105_t0025") 2022/01/12 06:13:01 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f109e240a413c5b88_d20220112_m060800_c001_v0001150_t0000") 2022/01/12 06:13:01 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f10466368c9b165cb_d20220112_m060758_c001_v0001130_t0033") 2022/01/12 06:13:01 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1019eeb41b59c58d_d20220112_m060753_c001_v0001145_t0017") 2022/01/12 06:13:01 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11060f49d25051b1_d20220112_m060751_c001_v0001009_t0043") 2022/01/12 06:13:01 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c199938813758_d20220112_m060740_c001_v0001105_t0030") 2022/01/12 06:13:01 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f114c17c97221162f_d20220112_m060736_c001_v0001165_t0033") 2022/01/12 06:13:01 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f10352f2dbdab3558_d20220112_m060731_c001_v0001113_t0034") 2022/01/12 06:13:01 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1115f2f71a553230_d20220112_m060728_c001_v0001105_t0053") 2022/01/12 06:13:01 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f10352f2dbdab3522_d20220112_m060721_c001_v0001113_t0048") 2022/01/12 06:13:01 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f111cc81d58c6b1f8_d20220112_m060720_c001_v0001031_t0038") 2022/01/12 06:13:01 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef527151e_d20220112_m060659_c001_v0001157_t0045") 2022/01/12 06:13:02 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11252536aa28d9f4_d20220112_m060656_c001_v0001117_t0038") 2022/01/12 06:13:02 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f10299083413ccf67_d20220112_m060644_c001_v0001120_t0009") 2022/01/12 06:13:02 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110e66e64442350b_d20220112_m060643_c001_v0001003_t0027") 2022/01/12 06:13:02 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd5be_d20220112_m060637_c001_v0001029_t0014") 2022/01/12 06:13:02 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1186e43dff6152de_d20220112_m060634_c001_v0001105_t0039") 2022/01/12 06:13:02 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1186e43dff615262_d20220112_m060632_c001_v0001105_t0030") 2022/01/12 06:13:02 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f109ae94d1554660c_d20220112_m060607_c001_v0001105_t0030") 2022/01/12 06:13:02 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef527137a_d20220112_m060524_c001_v0001157_t0037") 2022/01/12 06:13:02 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11791ba4e1f769d6_d20220112_m060521_c001_v0001097_t0026") 2022/01/12 06:13:02 DEBUG : dst/one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11791ba4e1f76993_d20220112_m060516_c001_v0001097_t0017") 2022/01/12 06:13:02 DEBUG : dst/one-2019-01-01: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f106d462dc3694791_d20220112_m061007_c001_v0001040_t0009") 2022/01/12 06:13:02 DEBUG : dst/one-2019-01-01: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f105646ce3327dfa6_d20220112_m061002_c001_v0001037_t0024") 2022/01/12 06:13:02 DEBUG : dst/one-2019-01-01: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11572d8bdc1e1632_d20220112_m060955_c001_v0001097_t0045") 2022/01/12 06:13:02 DEBUG : dst/one.bak: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1130195366a0a658_d20220112_m060925_c001_v0001113_t0043") 2022/01/12 06:13:02 DEBUG : dst/one.bak: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f101db73a8bbb76b3_d20220112_m060921_c001_v0001146_t0007") 2022/01/12 06:13:02 DEBUG : dst/one.bak: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f118fde16652f13a4_d20220112_m060913_c001_v0001092_t0056") 2022/01/12 06:13:02 DEBUG : dst/one.bak: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f100eb6974a0085f6_d20220112_m060903_c001_v0001001_t0012") 2022/01/12 06:13:03 DEBUG : dst/one.bak: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f101fffe94d83f4be_d20220112_m060856_c001_v0001128_t0004") 2022/01/12 06:13:03 DEBUG : dst/one.bak: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f10875e538a9e84ca_d20220112_m060849_c001_v0001105_t0007") 2022/01/12 06:13:03 DEBUG : dst/three: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f106ae7f0624c51b4_d20220112_m060657_c001_v0001161_t0032") 2022/01/12 06:13:03 DEBUG : dst/three: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1186e43dff61564e_d20220112_m060653_c001_v0001105_t0029") 2022/01/12 06:13:03 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1107b80a4bc5d2e5_d20220112_m061008_c001_v0001165_t0020") 2022/01/12 06:13:03 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f116bec5469156717_d20220112_m061004_c001_v0001154_t0006") 2022/01/12 06:13:03 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1129b03e7aa96104_d20220112_m060959_c001_v0001105_t0012") 2022/01/12 06:13:03 DEBUG : dst/three.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f10427f828270e874_d20220112_m061008_c001_v0001041_t0011") 2022/01/12 06:13:03 DEBUG : dst/three.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f104e0a22740da703_d20220112_m061006_c001_v0001105_t0051") 2022/01/12 06:13:03 DEBUG : dst/three.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f112fd596c9ec7a7b_d20220112_m061004_c001_v0001000_t0007") 2022/01/12 06:13:03 DEBUG : dst/three.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f104e0a22740da5f5_d20220112_m061000_c001_v0001105_t0027") 2022/01/12 06:13:03 DEBUG : dst/three.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f100d9c36ec566cae_d20220112_m060959_c001_v0001161_t0012") 2022/01/12 06:13:03 DEBUG : dst/three.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef5271799_d20220112_m060952_c001_v0001157_t0024") 2022/01/12 06:13:03 DEBUG : dst/three.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f106ce8c74b7801bf_d20220112_m060926_c001_v0001134_t0034") 2022/01/12 06:13:03 DEBUG : dst/three.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1179c3881f27c6e5_d20220112_m060924_c001_v0001136_t0035") 2022/01/12 06:13:04 DEBUG : dst/three.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11626095c9b4811a_d20220112_m060923_c001_v0001165_t0032") 2022/01/12 06:13:04 DEBUG : dst/three.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1179c3881f27c6c9_d20220112_m060919_c001_v0001136_t0050") 2022/01/12 06:13:04 DEBUG : dst/three.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f104576c6f2dd5774_d20220112_m060917_c001_v0001117_t0012") 2022/01/12 06:13:04 DEBUG : dst/three.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef5271720_d20220112_m060910_c001_v0001157_t0041") 2022/01/12 06:13:04 DEBUG : dst/three.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f106bf9926709a43b_d20220112_m060859_c001_v0001097_t0019") 2022/01/12 06:13:04 DEBUG : dst/three.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef52716f8_d20220112_m060855_c001_v0001157_t0022") 2022/01/12 06:13:04 DEBUG : dst/three.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f108bb2598608d06d_d20220112_m060854_c001_v0001154_t0022") 2022/01/12 06:13:04 DEBUG : dst/three.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd669_d20220112_m060846_c001_v0001029_t0001") 2022/01/12 06:13:04 DEBUG : dst/three.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110050575ff1d085_d20220112_m060828_c001_v0001161_t0032") 2022/01/12 06:13:04 DEBUG : dst/three.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd63b_d20220112_m060821_c001_v0001029_t0031") 2022/01/12 06:13:04 DEBUG : dst/three.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1115f2f71a553a47_d20220112_m060819_c001_v0001105_t0040") 2022/01/12 06:13:04 DEBUG : dst/three.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c199938813c2a_d20220112_m060810_c001_v0001105_t0008") 2022/01/12 06:13:04 DEBUG : dst/three.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f113472c8b8279b68_d20220112_m060802_c001_v0001117_t0033") 2022/01/12 06:13:04 DEBUG : dst/three.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c1999388139c9_d20220112_m060756_c001_v0001105_t0019") 2022/01/12 06:13:05 DEBUG : dst/three.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f111c63a3cae9d173_d20220112_m060755_c001_v0001161_t0010") 2022/01/12 06:13:05 DEBUG : dst/three.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef52715f1_d20220112_m060745_c001_v0001157_t0059") 2022/01/12 06:13:05 DEBUG : dst/three.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f119947a12e9a1a99_d20220112_m060734_c001_v0001117_t0036") 2022/01/12 06:13:05 DEBUG : dst/three.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef52715a8_d20220112_m060725_c001_v0001157_t0048") 2022/01/12 06:13:05 DEBUG : dst/three.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1103e6f7bef402eb_d20220112_m060723_c001_v0001044_t0016") 2022/01/12 06:13:05 DEBUG : dst/three.txt: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd5d7_d20220112_m060702_c001_v0001029_t0032") 2022/01/12 06:13:05 DEBUG : dst/three.txt.bak: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f102cd52567e134a0_d20220112_m060927_c001_v0001117_t0041") 2022/01/12 06:13:05 DEBUG : dst/three.txt.bak: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1187a902ab4b9415_d20220112_m060923_c001_v0001131_t0002") 2022/01/12 06:13:05 DEBUG : dst/three.txt.bak: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f100ae274919303d6_d20220112_m060916_c001_v0001145_t0011") 2022/01/12 06:13:05 DEBUG : dst/three.txt.bak: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11050d156110a50a_d20220112_m060904_c001_v0001036_t0005") 2022/01/12 06:13:05 DEBUG : dst/three.txt.bak: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110f63a217df6013_d20220112_m060858_c001_v0001131_t0058") 2022/01/12 06:13:05 DEBUG : dst/three.txt.bak: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f119a4acdc140e9a8_d20220112_m060854_c001_v0001146_t0033") 2022/01/12 06:13:05 DEBUG : dst/two: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1129b03e7aa962ac_d20220112_m061009_c001_v0001105_t0000") 2022/01/12 06:13:05 DEBUG : dst/two: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd6c7_d20220112_m060950_c001_v0001029_t0017") 2022/01/12 06:13:05 DEBUG : dst/two: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c202e48ade995_d20220112_m060928_c001_v0001036_t0017") 2022/01/12 06:13:05 DEBUG : dst/two: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd682_d20220112_m060908_c001_v0001029_t0017") 2022/01/12 06:13:05 DEBUG : dst/two: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f101d48d12a192046_d20220112_m060905_c001_v0001105_t0059") 2022/01/12 06:13:05 DEBUG : dst/two: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c1999388140b1_d20220112_m060844_c001_v0001105_t0030") 2022/01/12 06:13:06 DEBUG : dst/two: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f109c38c35e4627f1_d20220112_m060842_c001_v0001098_t0054") 2022/01/12 06:13:06 DEBUG : dst/two: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef5271670_d20220112_m060810_c001_v0001157_t0025") 2022/01/12 06:13:06 DEBUG : dst/two: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1184f07f4747ef87_d20220112_m060807_c001_v0001036_t0047") 2022/01/12 06:13:06 DEBUG : dst/two: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd604_d20220112_m060743_c001_v0001029_t0043") 2022/01/12 06:13:06 DEBUG : dst/two: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11012dfc3c39fd6a_d20220112_m060737_c001_v0001105_t0043") 2022/01/12 06:13:06 DEBUG : dst/two: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c199938813106_d20220112_m060700_c001_v0001105_t0006") 2022/01/12 06:13:06 DEBUG : dst/two: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f100ce1ab60771d3d_d20220112_m060658_c001_v0001105_t0014") 2022/01/12 06:13:06 DEBUG : dst/two: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f114ee64f3c4cb993_d20220112_m060648_c001_v0001105_t0043") 2022/01/12 06:13:06 DEBUG : dst/two: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f114d95aa9390fe97_d20220112_m060610_c001_v0001134_t0015") 2022/01/12 06:13:06 DEBUG : dst/two: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11791ba4e1f76aba_d20220112_m060553_c001_v0001097_t0046") 2022/01/12 06:13:06 DEBUG : empty space: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1186e43dff613f4b_d20220112_m060440_c001_v0001105_t0048") 2022/01/12 06:13:06 DEBUG : empty space: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef527126f_d20220112_m060435_c001_v0001157_t0024") 2022/01/12 06:13:06 DEBUG : empty space: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11797b246fbf6d52_d20220112_m060431_c001_v0001165_t0030") 2022/01/12 06:13:06 DEBUG : empty space: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef5271201_d20220112_m060414_c001_v0001157_t0039") 2022/01/12 06:13:06 DEBUG : empty space: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f100ce1ab6077002d_d20220112_m060353_c001_v0001105_t0051") 2022/01/12 06:13:06 DEBUG : empty space: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef527116c_d20220112_m060348_c001_v0001157_t0005") 2022/01/12 06:13:06 DEBUG : empty space: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f118cc1900b528cab_d20220112_m060253_c001_v0001128_t0038") 2022/01/12 06:13:06 DEBUG : empty space: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd494_d20220112_m060247_c001_v0001029_t0000") 2022/01/12 06:13:06 DEBUG : empty space: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f119ce1a3ea8c0aa0_d20220112_m060245_c001_v0001105_t0025") 2022/01/12 06:13:07 DEBUG : empty space: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd48e_d20220112_m060242_c001_v0001029_t0037") 2022/01/12 06:13:07 DEBUG : empty space: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11789c4dc080d89f_d20220112_m060229_c001_v0001008_t0018") 2022/01/12 06:13:07 DEBUG : empty space: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd477_d20220112_m060225_c001_v0001029_t0022") 2022/01/12 06:13:07 DEBUG : empty space: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f112d76b49f2e5b4e_d20220112_m060213_c001_v0001039_t0007") 2022/01/12 06:13:07 DEBUG : empty space: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd461_d20220112_m060211_c001_v0001029_t0020") 2022/01/12 06:13:07 DEBUG : empty space: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11776354f5f0b39e_d20220112_m060153_c001_v0001128_t0040") 2022/01/12 06:13:07 DEBUG : empty space: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd439_d20220112_m060150_c001_v0001029_t0028") 2022/01/12 06:13:07 DEBUG : empty space: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f101d5933e74afeba_d20220112_m060147_c001_v0001134_t0011") 2022/01/12 06:13:07 DEBUG : empty space: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd42e_d20220112_m060145_c001_v0001029_t0029") 2022/01/12 06:13:07 DEBUG : empty space: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f119696fb1b954d4a_d20220112_m060132_c001_v0001097_t0059") 2022/01/12 06:13:07 DEBUG : empty space: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd40e_d20220112_m060128_c001_v0001029_t0011") 2022/01/12 06:13:07 DEBUG : empty space: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1199af165eb016d1_d20220112_m060124_c001_v0001041_t0032") 2022/01/12 06:13:07 DEBUG : empty space: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd404_d20220112_m060123_c001_v0001029_t0041") 2022/01/12 06:13:07 DEBUG : empty space: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110e4ec7628e7cc1_d20220112_m060122_c001_v0001137_t0047") 2022/01/12 06:13:07 DEBUG : empty space: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f119ce1a3ea8bfd57_d20220112_m060120_c001_v0001105_t0032") 2022/01/12 06:13:07 DEBUG : empty space: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd3fd_d20220112_m060116_c001_v0001029_t0005") 2022/01/12 06:13:08 DEBUG : enormous: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11796a7fa11a58fe_d20220112_m060249_c001_v0001025_t0022") 2022/01/12 06:13:08 DEBUG : enormous: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd497_d20220112_m060248_c001_v0001029_t0010") 2022/01/12 06:13:08 DEBUG : existing: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1149e96758084498_d20220112_m061018_c001_v0001098_t0001") 2022/01/12 06:13:08 DEBUG : existing: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef5271802_d20220112_m061017_c001_v0001157_t0040") 2022/01/12 06:13:08 DEBUG : existing: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1195cc8bc5b9b374_d20220112_m060344_c001_v0001013_t0029") 2022/01/12 06:13:08 DEBUG : existing: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c19993881142b_d20220112_m060341_c001_v0001105_t0017") 2022/01/12 06:13:08 DEBUG : existing: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f109496c3dde92b80_d20220112_m060109_c001_v0001131_t0042") 2022/01/12 06:13:08 DEBUG : existing: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd3ec_d20220112_m060108_c001_v0001029_t0012") 2022/01/12 06:13:08 DEBUG : existing: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110ba2daac9c8a48_d20220112_m060107_c001_v0001136_t0028") 2022/01/12 06:13:08 DEBUG : existing: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd3e5_d20220112_m060106_c001_v0001029_t0002") 2022/01/12 06:13:08 DEBUG : existing: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd3e1_d20220112_m060104_c001_v0001029_t0023") 2022/01/12 06:13:08 DEBUG : existing-b: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1035defc481a5c17_d20220112_m060345_c001_v0001150_t0053") 2022/01/12 06:13:08 DEBUG : existing-b: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef5271142_d20220112_m060341_c001_v0001157_t0016") 2022/01/12 06:13:08 DEBUG : five: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f101d48d12a18eda1_d20220112_m060304_c001_v0001105_t0038") 2022/01/12 06:13:09 DEBUG : five: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd4aa_d20220112_m060259_c001_v0001029_t0016") 2022/01/12 06:13:09 DEBUG : foo: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1054982d15105a7c_d20220112_m060127_c001_v0001117_t0056") 2022/01/12 06:13:09 DEBUG : foo: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd409_d20220112_m060126_c001_v0001029_t0020") 2022/01/12 06:13:09 DEBUG : foo: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd407_d20220112_m060125_c001_v0001029_t0030") 2022/01/12 06:13:09 DEBUG : four: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11373ae39cc4aed4_d20220112_m060306_c001_v0001154_t0023") 2022/01/12 06:13:09 DEBUG : four: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c199938810f28_d20220112_m060302_c001_v0001105_t0038") 2022/01/12 06:13:09 DEBUG : four: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd4a8_d20220112_m060258_c001_v0001029_t0033") 2022/01/12 06:13:09 DEBUG : hello world2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1092860db70b84c8_d20220112_m060020_c001_v0001161_t0028") 2022/01/12 06:13:09 DEBUG : hello world2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd393_d20220112_m060019_c001_v0001029_t0004") 2022/01/12 06:13:09 DEBUG : ignore-size: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1009dee1ea0d0c82_d20220112_m060104_c001_v0001157_t0027") 2022/01/12 06:13:09 DEBUG : ignore-size: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd3dc_d20220112_m060102_c001_v0001029_t0021") 2022/01/12 06:13:09 DEBUG : nested/sub dir/file: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f10875e538a9e5757_d20220112_m060337_c001_v0001105_t0021") 2022/01/12 06:13:09 DEBUG : nested/sub dir/file: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef5271129_d20220112_m060336_c001_v0001157_t0013") 2022/01/12 06:13:09 DEBUG : nested/sub dir/file: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1088ce4b30f7b7ee_d20220112_m060335_c001_v0001097_t0000") 2022/01/12 06:13:09 DEBUG : nested/sub dir/file: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef5271115_d20220112_m060332_c001_v0001157_t0047") 2022/01/12 06:13:09 DEBUG : one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1149e967580832ba_d20220112_m060307_c001_v0001098_t0029") 2022/01/12 06:13:09 DEBUG : one: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd4a0_d20220112_m060255_c001_v0001029_t0015") 2022/01/12 06:13:10 DEBUG : only0: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f10627b2d93cdc6e6_d20220112_m061233_c001_v0001117_t0051") 2022/01/12 06:13:10 DEBUG : only0: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c199938815cc3_d20220112_m061204_c001_v0001105_t0055") 2022/01/12 06:13:10 DEBUG : only0: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c199938815798_d20220112_m061124_c001_v0001105_t0031") 2022/01/12 06:13:10 DEBUG : only0: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f112dd91e813e1b4a_d20220112_m061053_c001_v0001109_t0044") 2022/01/12 06:13:10 DEBUG : only0: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef527183b_d20220112_m061025_c001_v0001157_t0003") 2022/01/12 06:13:10 DEBUG : only1: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f102fd32a0348ce02_d20220112_m061233_c001_v0001134_t0047") 2022/01/12 06:13:10 DEBUG : only1: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd7d0_d20220112_m061203_c001_v0001029_t0008") 2022/01/12 06:13:10 DEBUG : only1: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef527194b_d20220112_m061126_c001_v0001157_t0042") 2022/01/12 06:13:10 DEBUG : only1: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11406b410668a9c0_d20220112_m061053_c001_v0001097_t0009") 2022/01/12 06:13:10 DEBUG : only1: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd711_d20220112_m061026_c001_v0001029_t0041") 2022/01/12 06:13:10 DEBUG : only10: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f10136a2ec0601985_d20220112_m061234_c001_v0001154_t0017") 2022/01/12 06:13:10 DEBUG : only10: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef52719d0_d20220112_m061203_c001_v0001157_t0008") 2022/01/12 06:13:10 DEBUG : only10: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef527197c_d20220112_m061141_c001_v0001157_t0026") 2022/01/12 06:13:10 DEBUG : only10: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f10762f3618c035c9_d20220112_m061055_c001_v0001039_t0029") 2022/01/12 06:13:10 DEBUG : only10: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd740_d20220112_m061037_c001_v0001029_t0029") 2022/01/12 06:13:10 DEBUG : only11: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f111b55150edd0e18_d20220112_m061234_c001_v0001165_t0058") 2022/01/12 06:13:10 DEBUG : only11: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1133f8d15b397801_d20220112_m061204_c001_v0001105_t0000") 2022/01/12 06:13:11 DEBUG : only11: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd7ab_d20220112_m061142_c001_v0001029_t0006") 2022/01/12 06:13:11 DEBUG : only11: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1017e6154039a14a_d20220112_m061055_c001_v0001041_t0043") 2022/01/12 06:13:11 DEBUG : only11: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c19993881513e_d20220112_m061038_c001_v0001105_t0019") 2022/01/12 06:13:11 DEBUG : only12: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11012dfc3c3a3172_d20220112_m061234_c001_v0001105_t0022") 2022/01/12 06:13:11 DEBUG : only12: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd7d2_d20220112_m061204_c001_v0001029_t0033") 2022/01/12 06:13:11 DEBUG : only12: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c1999388159b7_d20220112_m061143_c001_v0001105_t0026") 2022/01/12 06:13:11 DEBUG : only12: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1115f2f71a554f9a_d20220112_m061056_c001_v0001105_t0001") 2022/01/12 06:13:11 DEBUG : only12: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef5271887_d20220112_m061039_c001_v0001157_t0003") 2022/01/12 06:13:11 DEBUG : only13: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f111b55150edd0e3f_d20220112_m061236_c001_v0001165_t0044") 2022/01/12 06:13:11 DEBUG : only13: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef52719d4_d20220112_m061204_c001_v0001157_t0057") 2022/01/12 06:13:11 DEBUG : only13: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef527198a_d20220112_m061145_c001_v0001157_t0027") 2022/01/12 06:13:11 DEBUG : only13: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f102fdc275ca163d1_d20220112_m061054_c001_v0001146_t0052") 2022/01/12 06:13:11 DEBUG : only13: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd746_d20220112_m061040_c001_v0001029_t0044") 2022/01/12 06:13:11 DEBUG : only14: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f101db73a8bbb7a73_d20220112_m061236_c001_v0001146_t0023") 2022/01/12 06:13:11 DEBUG : only14: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c199938815cdb_d20220112_m061204_c001_v0001105_t0003") 2022/01/12 06:13:12 DEBUG : only14: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd7b9_d20220112_m061148_c001_v0001029_t0001") 2022/01/12 06:13:12 DEBUG : only14: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11797d79e1340287_d20220112_m061054_c001_v0001105_t0014") 2022/01/12 06:13:12 DEBUG : only14: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c1999388151ba_d20220112_m061041_c001_v0001105_t0031") 2022/01/12 06:13:12 DEBUG : only15: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f114ee64f3c4cecba_d20220112_m061237_c001_v0001105_t0025") 2022/01/12 06:13:12 DEBUG : only15: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef52719d9_d20220112_m061205_c001_v0001157_t0056") 2022/01/12 06:13:12 DEBUG : only15: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c199938815a90_d20220112_m061149_c001_v0001105_t0015") 2022/01/12 06:13:12 DEBUG : only15: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11587d9d21210394_d20220112_m061057_c001_v0001113_t0004") 2022/01/12 06:13:12 DEBUG : only15: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef52718ab_d20220112_m061046_c001_v0001157_t0025") 2022/01/12 06:13:12 DEBUG : only16: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f101d9a9db4e80843_d20220112_m061241_c001_v0001165_t0024") 2022/01/12 06:13:12 DEBUG : only16: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1133f8d15b39781b_d20220112_m061205_c001_v0001105_t0017") 2022/01/12 06:13:12 DEBUG : only16: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef52719a3_d20220112_m061151_c001_v0001157_t0048") 2022/01/12 06:13:12 DEBUG : only16: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11903cdd71d80cf3_d20220112_m061055_c001_v0001157_t0052") 2022/01/12 06:13:12 DEBUG : only16: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd754_d20220112_m061046_c001_v0001029_t0035") 2022/01/12 06:13:12 DEBUG : only17: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1094763a7364416f_d20220112_m061242_c001_v0001136_t0001") 2022/01/12 06:13:12 DEBUG : only17: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef52719db_d20220112_m061205_c001_v0001157_t0005") 2022/01/12 06:13:12 DEBUG : only17: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd7c4_d20220112_m061153_c001_v0001029_t0017") 2022/01/12 06:13:12 DEBUG : only17: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1006bac54c3a52aa_d20220112_m061057_c001_v0001131_t0059") 2022/01/12 06:13:13 DEBUG : only17: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c1999388152be_d20220112_m061047_c001_v0001105_t0008") 2022/01/12 06:13:13 DEBUG : only18: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11600f323f6b73da_d20220112_m061242_c001_v0001105_t0021") 2022/01/12 06:13:13 DEBUG : only18: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd7d4_d20220112_m061205_c001_v0001029_t0009") 2022/01/12 06:13:13 DEBUG : only18: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c199938815ba3_d20220112_m061156_c001_v0001105_t0006") 2022/01/12 06:13:13 DEBUG : only18: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f10850e0e1dbfbfe7_d20220112_m061053_c001_v0001033_t0058") 2022/01/12 06:13:13 DEBUG : only18: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef52718c1_d20220112_m061050_c001_v0001157_t0047") 2022/01/12 06:13:13 DEBUG : only19: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110e4ec7628e8907_d20220112_m061243_c001_v0001137_t0059") 2022/01/12 06:13:13 DEBUG : only19: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef52719df_d20220112_m061205_c001_v0001157_t0019") 2022/01/12 06:13:13 DEBUG : only19: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef52719cc_d20220112_m061202_c001_v0001157_t0000") 2022/01/12 06:13:13 DEBUG : only19: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11768623a79ad3da_d20220112_m061053_c001_v0001109_t0048") 2022/01/12 06:13:13 DEBUG : only19: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd761_d20220112_m061051_c001_v0001029_t0033") 2022/01/12 06:13:13 DEBUG : only2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f113745cef21871c3_d20220112_m061244_c001_v0001146_t0035") 2022/01/12 06:13:13 DEBUG : only2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1133f8d15b397826_d20220112_m061205_c001_v0001105_t0046") 2022/01/12 06:13:14 DEBUG : only2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd793_d20220112_m061127_c001_v0001029_t0016") 2022/01/12 06:13:14 DEBUG : only2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f109ae94d15549584_d20220112_m061055_c001_v0001105_t0045") 2022/01/12 06:13:14 DEBUG : only2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c199938814f46_d20220112_m061027_c001_v0001105_t0027") 2022/01/12 06:13:14 DEBUG : only3: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f102ad4c18430281e_d20220112_m061245_c001_v0001137_t0029") 2022/01/12 06:13:14 DEBUG : only3: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef52719e1_d20220112_m061205_c001_v0001157_t0053") 2022/01/12 06:13:14 DEBUG : only3: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c19993881582a_d20220112_m061129_c001_v0001105_t0045") 2022/01/12 06:13:14 DEBUG : only3: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f115ac477b7614d98_d20220112_m061053_c001_v0001105_t0033") 2022/01/12 06:13:14 DEBUG : only3: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef527184c_d20220112_m061028_c001_v0001157_t0049") 2022/01/12 06:13:14 DEBUG : only4: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f107fd94232284694_d20220112_m061246_c001_v0001109_t0009") 2022/01/12 06:13:14 DEBUG : only4: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c199938815cff_d20220112_m061206_c001_v0001105_t0038") 2022/01/12 06:13:14 DEBUG : only4: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef527195d_d20220112_m061131_c001_v0001157_t0010") 2022/01/12 06:13:14 DEBUG : only4: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1077c9a2b1484615_d20220112_m061058_c001_v0001153_t0008") 2022/01/12 06:13:14 DEBUG : only4: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd721_d20220112_m061029_c001_v0001029_t0030") 2022/01/12 06:13:14 DEBUG : only5: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f106a4a33a0736094_d20220112_m061247_c001_v0001033_t0004") 2022/01/12 06:13:15 DEBUG : only5: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd7d7_d20220112_m061206_c001_v0001029_t0031") 2022/01/12 06:13:15 DEBUG : only5: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd79f_d20220112_m061133_c001_v0001029_t0027") 2022/01/12 06:13:15 DEBUG : only5: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1137ca40fa342056_d20220112_m061056_c001_v0001044_t0040") 2022/01/12 06:13:15 DEBUG : only5: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c199938814fc0_d20220112_m061030_c001_v0001105_t0002") 2022/01/12 06:13:15 DEBUG : only6: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f100ce1ab607755cb_d20220112_m061248_c001_v0001105_t0048") 2022/01/12 06:13:15 DEBUG : only6: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef52719e4_d20220112_m061206_c001_v0001157_t0024") 2022/01/12 06:13:15 DEBUG : only6: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c1999388158a6_d20220112_m061134_c001_v0001105_t0011") 2022/01/12 06:13:15 DEBUG : only6: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f100631a25c295df2_d20220112_m061056_c001_v0001025_t0025") 2022/01/12 06:13:15 DEBUG : only6: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef5271861_d20220112_m061032_c001_v0001157_t0052") 2022/01/12 06:13:15 DEBUG : only7: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f107a009d39f0ecd2_d20220112_m061250_c001_v0001105_t0026") 2022/01/12 06:13:15 DEBUG : only7: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1133f8d15b397856_d20220112_m061206_c001_v0001105_t0010") 2022/01/12 06:13:15 DEBUG : only7: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef5271972_d20220112_m061138_c001_v0001157_t0011") 2022/01/12 06:13:16 DEBUG : only7: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f115ac477b7614dec_d20220112_m061056_c001_v0001105_t0016") 2022/01/12 06:13:16 DEBUG : only7: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd730_d20220112_m061033_c001_v0001029_t0023") 2022/01/12 06:13:16 DEBUG : only8: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f118896dae4855ffc_d20220112_m061251_c001_v0001145_t0059") 2022/01/12 06:13:16 DEBUG : only8: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd7dc_d20220112_m061206_c001_v0001029_t0008") 2022/01/12 06:13:16 DEBUG : only8: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd7a6_d20220112_m061139_c001_v0001029_t0012") 2022/01/12 06:13:16 DEBUG : only8: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11797b246fbf8920_d20220112_m061057_c001_v0001165_t0053") 2022/01/12 06:13:16 DEBUG : only8: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c199938815081_d20220112_m061034_c001_v0001105_t0020") 2022/01/12 06:13:16 DEBUG : only9: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f108da012fcc76d48_d20220112_m061251_c001_v0001165_t0055") 2022/01/12 06:13:16 DEBUG : only9: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd7e0_d20220112_m061207_c001_v0001029_t0033") 2022/01/12 06:13:16 DEBUG : only9: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c199938815950_d20220112_m061139_c001_v0001105_t0050") 2022/01/12 06:13:16 DEBUG : only9: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1133f8d15b396e4f_d20220112_m061055_c001_v0001105_t0050") 2022/01/12 06:13:16 DEBUG : only9: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef5271876_d20220112_m061036_c001_v0001157_t0028") 2022/01/12 06:13:16 DEBUG : potato: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f10245a49a5e697a7_d20220112_m060330_c001_v0001040_t0057") 2022/01/12 06:13:16 DEBUG : potato: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd4bf_d20220112_m060325_c001_v0001029_t0012") 2022/01/12 06:13:16 DEBUG : potato: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f111024e6689c3098_d20220112_m060323_c001_v0001131_t0022") 2022/01/12 06:13:16 DEBUG : potato: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef52710cf_d20220112_m060317_c001_v0001157_t0046") 2022/01/12 06:13:16 DEBUG : potato: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1002a1f36a6688bb_d20220112_m060313_c001_v0001093_t0013") 2022/01/12 06:13:17 DEBUG : potato: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd4b0_d20220112_m060309_c001_v0001029_t0035") 2022/01/12 06:13:17 DEBUG : potato: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110ef4122bb85f95_d20220112_m060235_c001_v0001117_t0002") 2022/01/12 06:13:17 DEBUG : potato: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd47f_d20220112_m060231_c001_v0001029_t0029") 2022/01/12 06:13:17 DEBUG : potato: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f114d95aa9390f790_d20220112_m060226_c001_v0001134_t0038") 2022/01/12 06:13:17 DEBUG : potato: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd474_d20220112_m060223_c001_v0001029_t0026") 2022/01/12 06:13:17 DEBUG : potato: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1144e6788a6ada0d_d20220112_m060212_c001_v0001161_t0053") 2022/01/12 06:13:17 DEBUG : potato: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd45f_d20220112_m060210_c001_v0001029_t0023") 2022/01/12 06:13:17 DEBUG : potato: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f115a47e7b6db7126_d20220112_m060152_c001_v0001098_t0050") 2022/01/12 06:13:17 DEBUG : potato: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd437_d20220112_m060149_c001_v0001029_t0021") 2022/01/12 06:13:17 DEBUG : potato: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1002d75f744731ee_d20220112_m060148_c001_v0001117_t0043") 2022/01/12 06:13:17 DEBUG : potato: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd42c_d20220112_m060144_c001_v0001029_t0012") 2022/01/12 06:13:17 DEBUG : potato: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f10042f0e058d3007_d20220112_m060142_c001_v0001043_t0031") 2022/01/12 06:13:17 DEBUG : potato: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd423_d20220112_m060141_c001_v0001029_t0041") 2022/01/12 06:13:17 DEBUG : potato: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd41e_d20220112_m060139_c001_v0001029_t0038") 2022/01/12 06:13:17 DEBUG : potato: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11285a7b1754bb5a_d20220112_m060138_c001_v0001161_t0010") 2022/01/12 06:13:17 DEBUG : potato: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd41a_d20220112_m060136_c001_v0001029_t0012") 2022/01/12 06:13:17 DEBUG : potato: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd418_d20220112_m060135_c001_v0001029_t0006") 2022/01/12 06:13:18 DEBUG : potato: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110e725a1bd67dfe_d20220112_m060132_c001_v0001113_t0002") 2022/01/12 06:13:18 DEBUG : potato: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd411_d20220112_m060129_c001_v0001029_t0039") 2022/01/12 06:13:18 DEBUG : potato2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f100ce1ab60770b7c_d20220112_m060503_c001_v0001105_t0009") 2022/01/12 06:13:18 DEBUG : potato2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd533_d20220112_m060459_c001_v0001029_t0018") 2022/01/12 06:13:18 DEBUG : potato2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11768623a79ac6c5_d20220112_m060445_c001_v0001109_t0004") 2022/01/12 06:13:18 DEBUG : potato2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd515_d20220112_m060434_c001_v0001029_t0031") 2022/01/12 06:13:18 DEBUG : potato2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11012dfc3c39db46_d20220112_m060422_c001_v0001105_t0018") 2022/01/12 06:13:18 DEBUG : potato2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd4fe_d20220112_m060412_c001_v0001029_t0011") 2022/01/12 06:13:18 DEBUG : potato2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1017110bee09b62b_d20220112_m060353_c001_v0001117_t0010") 2022/01/12 06:13:18 DEBUG : potato2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd4e0_d20220112_m060347_c001_v0001029_t0014") 2022/01/12 06:13:18 DEBUG : potato2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f113d2200d0bbaae5_d20220112_m060251_c001_v0001030_t0026") 2022/01/12 06:13:18 DEBUG : potato2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd492_d20220112_m060247_c001_v0001029_t0023") 2022/01/12 06:13:18 DEBUG : potato2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11797b246fbf6786_d20220112_m060246_c001_v0001165_t0010") 2022/01/12 06:13:18 DEBUG : potato2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd48a_d20220112_m060241_c001_v0001029_t0025") 2022/01/12 06:13:18 DEBUG : potato2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f106c062fb06045ab_d20220112_m060239_c001_v0001113_t0002") 2022/01/12 06:13:19 DEBUG : potato2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd484_d20220112_m060234_c001_v0001029_t0022") 2022/01/12 06:13:19 DEBUG : potato2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1007ce6cc20b284e_d20220112_m060230_c001_v0001038_t0054") 2022/01/12 06:13:19 DEBUG : potato2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd479_d20220112_m060226_c001_v0001029_t0007") 2022/01/12 06:13:19 DEBUG : potato2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1056c5a5d9e1953b_d20220112_m060217_c001_v0001044_t0017") 2022/01/12 06:13:19 DEBUG : potato2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd463_d20220112_m060212_c001_v0001029_t0008") 2022/01/12 06:13:19 DEBUG : potato2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f10816a53414f64cb_d20220112_m060154_c001_v0001090_t0038") 2022/01/12 06:13:19 DEBUG : potato2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd43b_d20220112_m060151_c001_v0001029_t0013") 2022/01/12 06:13:19 DEBUG : potato2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f101db73a8bbb6c70_d20220112_m060029_c001_v0001146_t0046") 2022/01/12 06:13:19 DEBUG : potato2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd3a3_d20220112_m060025_c001_v0001029_t0017") 2022/01/12 06:13:19 DEBUG : potato2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1087dce2859164d5_d20220112_m060024_c001_v0001137_t0000") 2022/01/12 06:13:19 DEBUG : potato2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd396_d20220112_m060021_c001_v0001029_t0043") 2022/01/12 06:13:19 DEBUG : potato3: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f109c04e99137d892_d20220112_m060441_c001_v0001011_t0029") 2022/01/12 06:13:20 DEBUG : potato3: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c199938811bb6_d20220112_m060436_c001_v0001105_t0006") 2022/01/12 06:13:20 DEBUG : potato3: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f10618d30f43e7290_d20220112_m060421_c001_v0001150_t0004") 2022/01/12 06:13:20 DEBUG : potato3: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c1999388118f1_d20220112_m060415_c001_v0001105_t0027") 2022/01/12 06:13:20 DEBUG : potato3: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1191af522d70e0a0_d20220112_m060354_c001_v0001090_t0019") 2022/01/12 06:13:20 DEBUG : potato3: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c199938811536_d20220112_m060349_c001_v0001105_t0037") 2022/01/12 06:13:20 DEBUG : pre-dest1/1: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1098f5e74ff7692c_d20220112_m060623_c001_v0001117_t0030") 2022/01/12 06:13:20 DEBUG : pre-dest1/1: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef527142d_d20220112_m060611_c001_v0001157_t0044") 2022/01/12 06:13:20 DEBUG : pre-dest2/2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f111f441ca35d0c71_d20220112_m060624_c001_v0001150_t0024") 2022/01/12 06:13:20 DEBUG : pre-dest2/2: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c199938812956_d20220112_m060612_c001_v0001105_t0017") 2022/01/12 06:13:20 DEBUG : sizeonly: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f106ab0fa065455d8_d20220112_m060058_c001_v0001146_t0028") 2022/01/12 06:13:20 DEBUG : sizeonly: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd3d6_d20220112_m060057_c001_v0001029_t0013") 2022/01/12 06:13:20 DEBUG : sub dir/hello world: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f100ce1ab6076fdf2_d20220112_m060339_c001_v0001105_t0008") 2022/01/12 06:13:20 DEBUG : sub dir/hello world: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd4ce_d20220112_m060337_c001_v0001029_t0000") 2022/01/12 06:13:21 DEBUG : sub dir/hello world: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1137a18268ee0ffb_d20220112_m060335_c001_v0001150_t0028") 2022/01/12 06:13:21 DEBUG : sub dir/hello world: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c1999388112e0_d20220112_m060332_c001_v0001105_t0035") 2022/01/12 06:13:21 DEBUG : sub dir/hello world: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f112ce198d132ac9a_d20220112_m060054_c001_v0001146_t0051") 2022/01/12 06:13:21 DEBUG : sub dir/hello world: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd3c5_d20220112_m060049_c001_v0001029_t0022") 2022/01/12 06:13:21 DEBUG : sub dir/hello world: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1166a21dfd8d7d56_d20220112_m060048_c001_v0001113_t0035") 2022/01/12 06:13:21 DEBUG : sub dir/hello world: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd3c1_d20220112_m060046_c001_v0001029_t0009") 2022/01/12 06:13:21 DEBUG : sub dir/hello world: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f119ce1a3ea8bf83e_d20220112_m060045_c001_v0001105_t0027") 2022/01/12 06:13:21 DEBUG : sub dir/hello world: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd3b9_d20220112_m060039_c001_v0001029_t0043") 2022/01/12 06:13:21 DEBUG : sub dir/hello world: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11572d8bdc1e017f_d20220112_m060038_c001_v0001097_t0001") 2022/01/12 06:13:21 DEBUG : sub dir/hello world: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd3b6_d20220112_m060036_c001_v0001029_t0015") 2022/01/12 06:13:21 DEBUG : sub dir/hello world: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1050b710db5f2005_d20220112_m060034_c001_v0001097_t0019") 2022/01/12 06:13:21 DEBUG : sub dir/hello world: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd3b0_d20220112_m060033_c001_v0001029_t0012") 2022/01/12 06:13:21 DEBUG : sub dir/hello world: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f100ce1ab6076e019_d20220112_m060031_c001_v0001105_t0048") 2022/01/12 06:13:21 DEBUG : sub dir/hello world: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd3ac_d20220112_m060030_c001_v0001029_t0008") 2022/01/12 06:13:21 DEBUG : sub dir/hello world: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f105926d51875efb2_d20220112_m060018_c001_v0001120_t0046") 2022/01/12 06:13:21 DEBUG : sub dir/hello world: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd38f_d20220112_m060017_c001_v0001029_t0020") 2022/01/12 06:13:21 DEBUG : sub dir/hello world: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f10790bcbe6c7aa11_d20220112_m060016_c001_v0001150_t0003") 2022/01/12 06:13:21 DEBUG : sub dir/hello world: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd38c_d20220112_m060014_c001_v0001029_t0017") 2022/01/12 06:13:21 DEBUG : sub dir/hello world: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f101d48d12a18d402_d20220112_m060012_c001_v0001105_t0034") 2022/01/12 06:13:22 DEBUG : sub dir/hello world: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd384_d20220112_m060011_c001_v0001029_t0034") 2022/01/12 06:13:22 DEBUG : sub dir/hello world: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f104ced6360d5532c_d20220112_m060009_c001_v0001092_t0005") 2022/01/12 06:13:22 DEBUG : sub dir/hello world: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd37e_d20220112_m060007_c001_v0001029_t0031") 2022/01/12 06:13:22 DEBUG : sub/yam: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f10794d1b1d8a0db7_d20220112_m060329_c001_v0001037_t0030") 2022/01/12 06:13:22 DEBUG : sub/yam: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef52710f2_d20220112_m060325_c001_v0001157_t0028") 2022/01/12 06:13:22 DEBUG : three: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103fce192ea5ce16_d20220112_m060307_c001_v0001098_t0040") 2022/01/12 06:13:22 DEBUG : three: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef52710a9_d20220112_m060303_c001_v0001157_t0056") 2022/01/12 06:13:22 DEBUG : three: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd4a6_d20220112_m060257_c001_v0001029_t0012") 2022/01/12 06:13:22 DEBUG : two: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f117e3c5acdb2019e_d20220112_m060308_c001_v0001018_t0015") 2022/01/12 06:13:22 DEBUG : two: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1034664ef527109e_d20220112_m060300_c001_v0001157_t0044") 2022/01/12 06:13:22 DEBUG : two: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f110882fa3ddfd4a4_d20220112_m060256_c001_v0001029_t0030") 2022/01/12 06:13:22 DEBUG : yam: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f10567ad7584b96a7_d20220112_m060330_c001_v0001105_t0001") 2022/01/12 06:13:22 DEBUG : yam: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1191af522d70e083_d20220112_m060328_c001_v0001090_t0014") 2022/01/12 06:13:22 DEBUG : yam: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11299c923599298f_d20220112_m060322_c001_v0001001_t0019") 2022/01/12 06:13:22 DEBUG : yam: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c1999388110c3_d20220112_m060316_c001_v0001105_t0032") 2022/01/12 06:13:23 DEBUG : yam: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f112ac64761a6438e_d20220112_m060313_c001_v0001026_t0013") 2022/01/12 06:13:23 DEBUG : yam: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f103c199938811002_d20220112_m060309_c001_v0001105_t0030") 2022/01/12 06:13:23 DEBUG : yaml: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f11600f323f6b1a21_d20220112_m060324_c001_v0001105_t0039") 2022/01/12 06:13:23 DEBUG : yaml: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1097f77016775895_d20220112_m060319_c001_v0001029_t0031") 2022/01/12 06:13:23 DEBUG : yaml: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f101d9a9db4e7e380_d20220112_m060315_c001_v0001165_t0044") 2022/01/12 06:13:23 DEBUG : yaml: Deleting (id "4_zff723dc3d0fd4bcb7fe80e1b_f1112977eb6a1ba9e_d20220112_m060312_c001_v0001098_t0042") "./sync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -fast-list" - Finished OK in 13m23.123694775s (try 1/5)